Skip to content

Instantly share code, notes, and snippets.

@lypanov
Created March 7, 2011 22:21
Show Gist options
  • Save lypanov/859396 to your computer and use it in GitHub Desktop.
Save lypanov/859396 to your computer and use it in GitHub Desktop.
[Mon, 07 Mar 2011 14:13:38 -0800] DEBUG: Loading cookbook mysql's library file: /var/chef/cache/cookbooks/mysql/libraries/database.rb
[Mon, 07 Mar 2011 14:13:38 -0800] WARN: Missing gem 'mysql'
[Mon, 07 Mar 2011 14:13:38 -0800] DEBUG: Loading cookbook openssl's library file: /var/chef/cache/cookbooks/openssl/libraries/secure_password.rb
[Mon, 07 Mar 2011 14:13:38 -0800] DEBUG: Loading cookbook packages's library file: /var/chef/cache/cookbooks/packages/libraries/packages.rb
[Mon, 07 Mar 2011 14:13:38 -0800] DEBUG: Loading cookbook aws's library file: /var/chef/cache/cookbooks/aws/libraries/ec2.rb
[Mon, 07 Mar 2011 14:13:38 -0800] WARN: Missing gem 'right_aws'
[Mon, 07 Mar 2011 14:13:38 -0800] DEBUG: Loading cookbook radiant's library file: /var/chef/cache/cookbooks/radiant/libraries/radiant.rb
[Mon, 07 Mar 2011 14:13:38 -0800] DEBUG: Loading cookbook mysql's providers from /var/chef/cache/cookbooks/mysql/providers/database.rb
[Mon, 07 Mar 2011 14:13:38 -0800] DEBUG: Loaded contents of /var/chef/cache/cookbooks/mysql/providers/database.rb into a provider named mysql_database defined in Chef::Provider::MysqlDatabase
[Mon, 07 Mar 2011 14:13:38 -0800] DEBUG: Loading cookbook aws's providers from /var/chef/cache/cookbooks/aws/providers/elastic_ip.rb
[Mon, 07 Mar 2011 14:13:38 -0800] DEBUG: Loaded contents of /var/chef/cache/cookbooks/aws/providers/elastic_ip.rb into a provider named aws_elastic_ip defined in Chef::Provider::AwsElasticIp
[Mon, 07 Mar 2011 14:13:38 -0800] DEBUG: Loading cookbook aws's providers from /var/chef/cache/cookbooks/aws/providers/ebs_volume.rb
[Mon, 07 Mar 2011 14:13:38 -0800] DEBUG: Loaded contents of /var/chef/cache/cookbooks/aws/providers/ebs_volume.rb into a provider named aws_ebs_volume defined in Chef::Provider::AwsEbsVolume
[Mon, 07 Mar 2011 14:13:38 -0800] DEBUG: Loading cookbook mysql's resources from /var/chef/cache/cookbooks/mysql/resources/database.rb
[Mon, 07 Mar 2011 14:13:38 -0800] DEBUG: Loaded contents of /var/chef/cache/cookbooks/mysql/resources/database.rb into a resource named mysql_database defined in Chef::Resource::MysqlDatabase
[Mon, 07 Mar 2011 14:13:38 -0800] DEBUG: Loading cookbook aws's resources from /var/chef/cache/cookbooks/aws/resources/elastic_ip.rb
[Mon, 07 Mar 2011 14:13:38 -0800] DEBUG: Loaded contents of /var/chef/cache/cookbooks/aws/resources/elastic_ip.rb into a resource named aws_elastic_ip defined in Chef::Resource::AwsElasticIp
[Mon, 07 Mar 2011 14:13:38 -0800] DEBUG: Loading cookbook aws's resources from /var/chef/cache/cookbooks/aws/resources/ebs_volume.rb
[Mon, 07 Mar 2011 14:13:38 -0800] DEBUG: Loaded contents of /var/chef/cache/cookbooks/aws/resources/ebs_volume.rb into a resource named aws_ebs_volume defined in Chef::Resource::AwsEbsVolume
[Mon, 07 Mar 2011 14:13:38 -0800] DEBUG: node vagrantup.com loading cookbook rails's attribute file /var/chef/cache/cookbooks/rails/attributes/default.rb
[Mon, 07 Mar 2011 14:13:38 -0800] DEBUG: node vagrantup.com loading cookbook runit's attribute file /var/chef/cache/cookbooks/runit/attributes/default.rb
[Mon, 07 Mar 2011 14:13:38 -0800] DEBUG: node vagrantup.com loading cookbook mysql's attribute file /var/chef/cache/cookbooks/mysql/attributes/server.rb
[Mon, 07 Mar 2011 14:13:38 -0800] DEBUG: Not setting mysql/server_debian_password to "R9DcyjbVuhnIG16C7Kxv" because it has a normal value already
[Mon, 07 Mar 2011 14:13:38 -0800] DEBUG: Not setting mysql/server_root_password to "OyMvf3CH1UmQhYMiuC1r" because it has a normal value already
[Mon, 07 Mar 2011 14:13:38 -0800] DEBUG: Not setting mysql/server_repl_password to "1x5byGeBNDia_H4v0JDT" because it has a normal value already
[Mon, 07 Mar 2011 14:13:38 -0800] DEBUG: node vagrantup.com loading cookbook passenger_apache2's attribute file /var/chef/cache/cookbooks/passenger_apache2/attributes/default.rb
[Mon, 07 Mar 2011 14:13:38 -0800] DEBUG: node vagrantup.com loading cookbook packages's attribute file /var/chef/cache/cookbooks/packages/attributes/default.rb
[Mon, 07 Mar 2011 14:13:38 -0800] DEBUG: node vagrantup.com loading cookbook nginx's attribute file /var/chef/cache/cookbooks/nginx/attributes/default.rb
[Mon, 07 Mar 2011 14:13:38 -0800] DEBUG: node vagrantup.com loading cookbook passenger_enterprise's attribute file /var/chef/cache/cookbooks/passenger_enterprise/attributes/default.rb
[Mon, 07 Mar 2011 14:13:38 -0800] DEBUG: node vagrantup.com loading cookbook apache2's attribute file /var/chef/cache/cookbooks/apache2/attributes/default.rb
[Mon, 07 Mar 2011 14:13:38 -0800] DEBUG: node vagrantup.com loading cookbook ruby_enterprise's attribute file /var/chef/cache/cookbooks/ruby_enterprise/attributes/default.rb
[Mon, 07 Mar 2011 14:13:38 -0800] DEBUG: node vagrantup.com loading cookbook radiant's attribute file /var/chef/cache/cookbooks/radiant/attributes/default.rb
[Mon, 07 Mar 2011 14:13:38 -0800] DEBUG: Loading cookbook runit's definitions from /var/chef/cache/cookbooks/runit/definitions/runit_service.rb
[Mon, 07 Mar 2011 14:13:38 -0800] DEBUG: Loading cookbook unicorn's definitions from /var/chef/cache/cookbooks/unicorn/definitions/unicorn_config.rb
[Mon, 07 Mar 2011 14:13:38 -0800] DEBUG: Loading cookbook nginx's definitions from /var/chef/cache/cookbooks/nginx/definitions/nginx_site.rb
[Mon, 07 Mar 2011 14:13:38 -0800] DEBUG: Loading cookbook ruby's definitions from /var/chef/cache/cookbooks/ruby/definitions/ruby_packages.rb
[Mon, 07 Mar 2011 14:13:38 -0800] DEBUG: Loading cookbook ruby's definitions from /var/chef/cache/cookbooks/ruby/definitions/ruby_symlinks.rb
[Mon, 07 Mar 2011 14:13:38 -0800] DEBUG: Loading cookbook apache2's definitions from /var/chef/cache/cookbooks/apache2/definitions/apache_conf.rb
[Mon, 07 Mar 2011 14:13:38 -0800] DEBUG: Loading cookbook apache2's definitions from /var/chef/cache/cookbooks/apache2/definitions/apache_module.rb
[Mon, 07 Mar 2011 14:13:38 -0800] DEBUG: Loading cookbook apache2's definitions from /var/chef/cache/cookbooks/apache2/definitions/web_app.rb
[Mon, 07 Mar 2011 14:13:38 -0800] DEBUG: Loading cookbook apache2's definitions from /var/chef/cache/cookbooks/apache2/definitions/apache_site.rb
[Mon, 07 Mar 2011 14:13:38 -0800] DEBUG: Loading cookbook ruby_enterprise's definitions from /var/chef/cache/cookbooks/ruby_enterprise/definitions/ree_gem.rb
[Mon, 07 Mar 2011 14:13:38 -0800] DEBUG: Signing the request as vagrantup.com
[Mon, 07 Mar 2011 14:13:38 -0800] DEBUG: String to sign: 'Method:GET
Hashed Path:cABi3l8695q3PnRkSSKaNOZ+HYQ=
X-Ops-Content-Hash:2jmj7l5rSw0yVb/vlWAYkK/YBwk=
X-Ops-Timestamp:2011-03-07T22:13:38Z
X-Ops-UserId:vagrantup.com'
Header hash: {"X-Ops-Content-Hash"=>"2jmj7l5rSw0yVb/vlWAYkK/YBwk=", "X-Ops-Authorization-1"=>"AvnLJhBe/hICAaFYcK2MdtzTF6MzxRiViA2HWYvk3EWmwyIGYhN5rcFSsSbB", "X-Ops-Userid"=>"vagrantup.com", "X-Ops-Sign"=>"version=1.0", "X-Ops-Authorization-2"=>"8D2fpYigmmxv6WCjWc4AEKvzkO4AJkZ8ziMk4xqpN5y2LmHUYOwhZY06/SA8", "X-Ops-Authorization-3"=>"LA/glNGRw57lhIEywmbTJxAsPZDbLsj/3qDEjr0DwKHZ5XEEkYvxGqQI0Crl", "X-Ops-Authorization-4"=>"pUfOUMLdJSGRb94iXHClyn+auGP8fYuIYIL2efoa8ZdDA+GjQwlUPB9MGDXO", "X-Ops-Authorization-5"=>"wURay3LEtVUNxNLfk2caLIstl/4fdrwACFEFWlQYWXoMlj0qG9tN2A144lom", "X-Ops-Authorization-6"=>"SfSAfZ7meO0m+LIgElEydX+qNY7+5XZm+cNw+pFclg==", "X-Ops-Timestamp"=>"2011-03-07T22:13:38Z"}
[Mon, 07 Mar 2011 14:13:38 -0800] DEBUG: Sending HTTP Request via GET to api.opscode.com:443/organizations/libersy/roles/vagrant
[Mon, 07 Mar 2011 14:13:39 -0800] DEBUG: Signing the request as vagrantup.com
[Mon, 07 Mar 2011 14:13:39 -0800] DEBUG: String to sign: 'Method:GET
Hashed Path:m8cEmGVthB6PfW2D1YPyf3av8/c=
X-Ops-Content-Hash:2jmj7l5rSw0yVb/vlWAYkK/YBwk=
X-Ops-Timestamp:2011-03-07T22:13:39Z
X-Ops-UserId:vagrantup.com'
Header hash: {"X-Ops-Content-Hash"=>"2jmj7l5rSw0yVb/vlWAYkK/YBwk=", "X-Ops-Authorization-1"=>"jsiXeiGdk+EJoki0mnMLC6bDgoKKC14BJMo8BkGhnJ29FGwVQ1tKzm/7acuv", "X-Ops-Userid"=>"vagrantup.com", "X-Ops-Sign"=>"version=1.0", "X-Ops-Authorization-2"=>"cr80dFreGas7WzmZOcRq+NvXU4zo9GCm32Bv9pZNaETkY+O+6L6FM5F2OYrP", "X-Ops-Authorization-3"=>"QZGASZHgcifh10ByV/6iLKf8KnBm5pKfp6Kn9SLuvdtWEXsNKZASSgRkgoka", "X-Ops-Authorization-4"=>"VLdI3EP/fIQD/aWQc25l/ga4FqpEgU6D+tGR5Uxo0yH56fNtF2g471JoUol/", "X-Ops-Authorization-5"=>"4qnVCkt3ts+ceRSZGcRwuOkRn6GUWMFK0YLGGaz3uT8OgswD5RNCWOfLSFJ6", "X-Ops-Authorization-6"=>"g56Jp+eGG1s2zAhFVgbVh5GWsf4wSSrS1eyAP1kgNw==", "X-Ops-Timestamp"=>"2011-03-07T22:13:39Z"}
[Mon, 07 Mar 2011 14:13:39 -0800] DEBUG: Sending HTTP Request via GET to api.opscode.com:443/organizations/libersy/roles/production
[Mon, 07 Mar 2011 14:13:40 -0800] DEBUG: Signing the request as vagrantup.com
[Mon, 07 Mar 2011 14:13:40 -0800] DEBUG: String to sign: 'Method:GET
Hashed Path:bhFJrgEcsdJxZQeSlA3vNjKJroQ=
X-Ops-Content-Hash:2jmj7l5rSw0yVb/vlWAYkK/YBwk=
X-Ops-Timestamp:2011-03-07T22:13:40Z
X-Ops-UserId:vagrantup.com'
Header hash: {"X-Ops-Content-Hash"=>"2jmj7l5rSw0yVb/vlWAYkK/YBwk=", "X-Ops-Authorization-1"=>"A8y0xOVeafuStvFZv7pSkuuF9NAU4gWmeRZY2ENYvNgChFq2qMOsWeHijtwE", "X-Ops-Userid"=>"vagrantup.com", "X-Ops-Sign"=>"version=1.0", "X-Ops-Authorization-2"=>"WPi1IqEdTVHjyj18KmQnf8W8g9G9+Tndt5q07AFj6VNQeZAO8dyvvl/pH917", "X-Ops-Authorization-3"=>"a8dvuoIYpkXXSO56GkpSn6GJWJ8b85+oJdaQfu7AnfnCAgHSLtDhSVPT4vqN", "X-Ops-Authorization-4"=>"NDQe0DruJC/4pdsl6TiYXhXV1dYlxIqsphlSYlxCMYh4CnDLHVDWsnaybjBG", "X-Ops-Authorization-5"=>"MahPL2jyjtUBR0XsBb48/Ee1aW7bbnx1kAMEQgkbLP6q2Ulz41frVG8EWhNp", "X-Ops-Authorization-6"=>"nMY9XCBMlfz/dABFDn2DZ2Mm3KED0lsSpd/wa5PcOw==", "X-Ops-Timestamp"=>"2011-03-07T22:13:40Z"}
[Mon, 07 Mar 2011 14:13:40 -0800] DEBUG: Sending HTTP Request via GET to api.opscode.com:443/organizations/libersy/roles/base
[Mon, 07 Mar 2011 14:13:40 -0800] DEBUG: Signing the request as vagrantup.com
[Mon, 07 Mar 2011 14:13:40 -0800] DEBUG: String to sign: 'Method:GET
Hashed Path:tmUM0XgVC6IuDjMOaNg2A5NHjjw=
X-Ops-Content-Hash:2jmj7l5rSw0yVb/vlWAYkK/YBwk=
X-Ops-Timestamp:2011-03-07T22:13:40Z
X-Ops-UserId:vagrantup.com'
Header hash: {"X-Ops-Content-Hash"=>"2jmj7l5rSw0yVb/vlWAYkK/YBwk=", "X-Ops-Authorization-1"=>"h/97jggIRVnkNRXI/5JKL0vqzyXJ9gaOgpWYCFUGT7TwhiXDPaRDDL5lTBPC", "X-Ops-Userid"=>"vagrantup.com", "X-Ops-Sign"=>"version=1.0", "X-Ops-Authorization-2"=>"J7y+pk6Tv3TOcnXMY3wE82lS7gwB1Gdy7XckIkwOVzepYe24EMnzhrQI8gj0", "X-Ops-Authorization-3"=>"Jg1x+WIhhgwsVco0Cl5SkpnjqUMQT9nDQABdOzGsaBnmpMsa1ecN4hAlkFsW", "X-Ops-Authorization-4"=>"xkDTtA7rRjuXfNDEb0FjhbUFo1eewhJEWQOlljnsC9QzCqlQgHymlcRHf9CP", "X-Ops-Authorization-5"=>"h3/5nu3akbKr7wn8AwSRzJcAl+Fg1Fcrdc7mCmOkaVf5mFfUtDqDIW+7zX6R", "X-Ops-Authorization-6"=>"qxtVkayDhoVSawRya9loUtuD3OblqQ9yG/rjS/1hAw==", "X-Ops-Timestamp"=>"2011-03-07T22:13:40Z"}
[Mon, 07 Mar 2011 14:13:41 -0800] DEBUG: Sending HTTP Request via GET to api.opscode.com:443/organizations/libersy/roles/radiant_database_master
[Mon, 07 Mar 2011 14:13:41 -0800] DEBUG: Signing the request as vagrantup.com
[Mon, 07 Mar 2011 14:13:41 -0800] DEBUG: String to sign: 'Method:GET
Hashed Path:UEyGktu4LnpEmNm1pDKwaruGxCc=
X-Ops-Content-Hash:2jmj7l5rSw0yVb/vlWAYkK/YBwk=
X-Ops-Timestamp:2011-03-07T22:13:41Z
X-Ops-UserId:vagrantup.com'
Header hash: {"X-Ops-Content-Hash"=>"2jmj7l5rSw0yVb/vlWAYkK/YBwk=", "X-Ops-Authorization-1"=>"UrKT3r5Zzbpt8FcZhPhZehRFd+XWzUZzTOJPODkdnSy1rbbVWcFpjEGkFDGk", "X-Ops-Userid"=>"vagrantup.com", "X-Ops-Sign"=>"version=1.0", "X-Ops-Authorization-2"=>"fW7TbWB0e7DQnS/wYI9MWsGE3/qSBZjRcwULCemK6i0UVOg4ZSfQcCRapkO6", "X-Ops-Authorization-3"=>"BPkmDLumcLaQbsHkmsEDUWTs3um8t2mB87aWZ78dM20l6OAaBSb0UUlG9/uM", "X-Ops-Authorization-4"=>"iLtEwDjeID4uB9KE1GxT+xm0ysGc7DWz4/IrnDlOVuhfcIXt/M2vWml+Hbji", "X-Ops-Authorization-5"=>"kGweN2MuyB0gPXMUpp+8/TPcb/MYcGjenbG4qWZ+10Jc6lT0vkw8YxrTiKgA", "X-Ops-Authorization-6"=>"ES9rPs4TvFNMu8byA7WKKIv0AYU9/g8f0MIMzPal3g==", "X-Ops-Timestamp"=>"2011-03-07T22:13:41Z"}
[Mon, 07 Mar 2011 14:13:41 -0800] DEBUG: Sending HTTP Request via GET to api.opscode.com:443/organizations/libersy/roles/radiant
[Mon, 07 Mar 2011 14:13:42 -0800] DEBUG: Signing the request as vagrantup.com
[Mon, 07 Mar 2011 14:13:42 -0800] DEBUG: String to sign: 'Method:GET
Hashed Path:iMTGyv0N9qggfVxxLvklAzbk930=
X-Ops-Content-Hash:2jmj7l5rSw0yVb/vlWAYkK/YBwk=
X-Ops-Timestamp:2011-03-07T22:13:42Z
X-Ops-UserId:vagrantup.com'
Header hash: {"X-Ops-Content-Hash"=>"2jmj7l5rSw0yVb/vlWAYkK/YBwk=", "X-Ops-Authorization-1"=>"pWO/wK6zdCBZm+1YdlQSIGog9ZKQ6ki9m99LkmlWENrveH5lfnLgJdgE1VyM", "X-Ops-Userid"=>"vagrantup.com", "X-Ops-Sign"=>"version=1.0", "X-Ops-Authorization-2"=>"L/WZmOm6YubdlzgYeWjQecDUJX4Pu0wQdTFrILkMC5FWPymABdcUFzqiDoXK", "X-Ops-Authorization-3"=>"ey2PDR71GWgjwD+AJwZzCl8LZ6s/KlF+APOlwu4Uz6hUg+9cc5tlAYVBCuRO", "X-Ops-Authorization-4"=>"gX63nyRWu0H+VL1XV3DKgCnET2nS5qeDnkOG0IN7klBmL0+W6yc/J9FtCND0", "X-Ops-Authorization-5"=>"jKTGcyx1UxkcwOulrXlxJSr3LfZdJFc3mwIFQhnL6ybrD1+vqDrNcDS9v60L", "X-Ops-Authorization-6"=>"MnZHE4bL4+uhn3FRT9PsrYVHuDUrYsXIOQLzxMAhCA==", "X-Ops-Timestamp"=>"2011-03-07T22:13:42Z"}
[Mon, 07 Mar 2011 14:13:42 -0800] DEBUG: Sending HTTP Request via GET to api.opscode.com:443/organizations/libersy/roles/radiant_run_migrations
[Mon, 07 Mar 2011 14:13:43 -0800] DEBUG: Loading Recipe apt via include_recipe
[Mon, 07 Mar 2011 14:13:43 -0800] DEBUG: Found recipe default in cookbook apt
[Mon, 07 Mar 2011 14:13:43 -0800] DEBUG: Executing apt-get update
[Mon, 07 Mar 2011 14:13:49 -0800] DEBUG: ---- Begin output of apt-get update ----
[Mon, 07 Mar 2011 14:13:49 -0800] DEBUG: STDOUT: Get:1 http://security.ubuntu.com lucid-security Release.gpg [198B]
Hit http://us.archive.ubuntu.com lucid Release.gpg
Get:2 http://us.archive.ubuntu.com lucid-updates Release.gpg [198B]
Get:3 http://security.ubuntu.com lucid-security Release [44.7kB]
Hit http://us.archive.ubuntu.com lucid Release
Get:4 http://us.archive.ubuntu.com lucid-updates Release [44.7kB]
Hit http://us.archive.ubuntu.com lucid/main Packages
Get:5 http://security.ubuntu.com lucid-security/main Packages [152kB]
Hit http://us.archive.ubuntu.com lucid/restricted Packages
Hit http://us.archive.ubuntu.com lucid/main Sources
Hit http://us.archive.ubuntu.com lucid/restricted Sources
Hit http://us.archive.ubuntu.com lucid/universe Packages
Hit http://us.archive.ubuntu.com lucid/universe Sources
Hit http://us.archive.ubuntu.com lucid/multiverse Packages
Hit http://us.archive.ubuntu.com lucid/multiverse Sources
Get:6 http://us.archive.ubuntu.com lucid-updates/main Packages [454kB]
Get:7 http://security.ubuntu.com lucid-security/restricted Packages [14B]
Get:8 http://security.ubuntu.com lucid-security/main Sources [47.4kB]
Get:9 http://security.ubuntu.com lucid-security/restricted Sources [14B]
Get:10 http://security.ubuntu.com lucid-security/universe Packages [62.9kB]
Get:11 http://security.ubuntu.com lucid-security/universe Sources [19.4kB]
Get:12 http://us.archive.ubuntu.com lucid-updates/restricted Packages [3240B]
Get:13 http://us.archive.ubuntu.com lucid-updates/main Sources [182kB]
Get:14 http://security.ubuntu.com lucid-security/multiverse Packages [1995B]
Get:15 http://security.ubuntu.com lucid-security/multiverse Sources [651B]
Get:16 http://us.archive.ubuntu.com lucid-updates/restricted Sources [1443B]
Get:17 http://us.archive.ubuntu.com lucid-updates/universe Packages [192kB]
Get:18 http://us.archive.ubuntu.com lucid-updates/universe Sources [69.7kB]
Get:19 http://us.archive.ubuntu.com lucid-updates/multiverse Packages [8427B]
Get:20 http://us.archive.ubuntu.com lucid-updates/multiverse Sources [4369B]
Fetched 1288kB in 2s (542kB/s)
Reading package lists...
[Mon, 07 Mar 2011 14:13:49 -0800] DEBUG: STDERR:
[Mon, 07 Mar 2011 14:13:49 -0800] DEBUG: ---- End output of apt-get update ----
[Mon, 07 Mar 2011 14:13:49 -0800] DEBUG: Ran apt-get update returned 0
[Mon, 07 Mar 2011 14:13:49 -0800] INFO: Ran execute[apt-get update] successfully
[Mon, 07 Mar 2011 14:13:49 -0800] DEBUG: Loading Recipe git via include_recipe
[Mon, 07 Mar 2011 14:13:49 -0800] DEBUG: Found recipe default in cookbook git
[Mon, 07 Mar 2011 14:13:49 -0800] DEBUG: Loading Recipe build-essential via include_recipe
[Mon, 07 Mar 2011 14:13:49 -0800] DEBUG: Found recipe default in cookbook build-essential
[Mon, 07 Mar 2011 14:13:49 -0800] DEBUG: Loading Recipe ruby via include_recipe
[Mon, 07 Mar 2011 14:13:49 -0800] DEBUG: Found recipe default in cookbook ruby
[Mon, 07 Mar 2011 14:13:49 -0800] DEBUG: Loading Recipe database::master via include_recipe
[Mon, 07 Mar 2011 14:13:49 -0800] DEBUG: Found recipe master in cookbook database
[Mon, 07 Mar 2011 14:13:49 -0800] DEBUG: Signing the request as vagrantup.com
[Mon, 07 Mar 2011 14:13:49 -0800] DEBUG: String to sign: 'Method:GET
Hashed Path:CVX+H4TwVTvanDZ8Dn9hV1369zs=
X-Ops-Content-Hash:2jmj7l5rSw0yVb/vlWAYkK/YBwk=
X-Ops-Timestamp:2011-03-07T22:13:49Z
X-Ops-UserId:vagrantup.com'
Header hash: {"X-Ops-Content-Hash"=>"2jmj7l5rSw0yVb/vlWAYkK/YBwk=", "X-Ops-Authorization-1"=>"t545PY2Rzl1CI6zudlfhROc0Q8E6RyMhTQGbTOcGuq95tF2+YtyOOaELW3M9", "X-Ops-Userid"=>"vagrantup.com", "X-Ops-Sign"=>"version=1.0", "X-Ops-Authorization-2"=>"Vqc2BZHbuqHa2MoamqYIN8OIUzlLbzaIjg2prwmyhHaBk6loIqrrc/vYboaL", "X-Ops-Authorization-3"=>"o+9jpA/3UpkeV45eNpnTR2y+CpnkdRfmOCl6P706WD3DIP28PPNBiE+SnK63", "X-Ops-Authorization-4"=>"fwqSWKKrx0lqOucYdgL9kZKCjf7Y+rXyeKXUKZTMO7fOS632DZNAyKhEmSyO", "X-Ops-Authorization-5"=>"2ChoQpZ2NXZnZykWvKYg2B53F6IFVj1ruTgT/oiYQoIBXnBeVUAyp4eVRUVx", "X-Ops-Authorization-6"=>"0Tp9MrCfNhnyLitOBK22/WZ2xkx7MWLJe7EAF4N8Hg==", "X-Ops-Timestamp"=>"2011-03-07T22:13:49Z"}
[Mon, 07 Mar 2011 14:13:49 -0800] DEBUG: Sending HTTP Request via GET to api.opscode.com:443/organizations/libersy/search/apps
[Mon, 07 Mar 2011 14:13:50 -0800] DEBUG: Loading Recipe mysql::server via include_recipe
[Mon, 07 Mar 2011 14:13:50 -0800] DEBUG: Found recipe server in cookbook mysql
[Mon, 07 Mar 2011 14:13:50 -0800] DEBUG: Loading Recipe mysql::client via include_recipe
[Mon, 07 Mar 2011 14:13:50 -0800] DEBUG: Found recipe client in cookbook mysql
[Mon, 07 Mar 2011 14:13:50 -0800] DEBUG: Checking apt-cache policy for libmysqlclient-dev
[Mon, 07 Mar 2011 14:13:50 -0800] DEBUG: Current version is nil
[Mon, 07 Mar 2011 14:13:50 -0800] DEBUG: Candidate version is 5.1.41-3ubuntu12.10
[Mon, 07 Mar 2011 14:13:50 -0800] INFO: Installing package[mysql-devel] version 5.1.41-3ubuntu12.10
[Mon, 07 Mar 2011 14:13:50 -0800] DEBUG: Executing apt-get -q -y install libmysqlclient-dev=5.1.41-3ubuntu12.10
[Mon, 07 Mar 2011 14:14:18 -0800] DEBUG: ---- Begin output of apt-get -q -y install libmysqlclient-dev=5.1.41-3ubuntu12.10 ----
[Mon, 07 Mar 2011 14:14:18 -0800] DEBUG: STDOUT: Reading package lists...
Building dependency tree...
Reading state information...
The following extra packages will be installed:
libmysqlclient-dev libmysqlclient16 mysql-common zlib1g-dev
The following NEW packages will be installed:
libmysqlclient-dev libmysqlclient16 mysql-common zlib1g-dev
0 upgraded, 4 newly installed, 0 to remove and 48 not upgraded.
Need to get 5,315kB of archives.
After this operation, 13.1MB of additional disk space will be used.
Get:1 http://us.archive.ubuntu.com/ubuntu/ lucid-updates/main mysql-common 5.1.41-3ubuntu12.10 [98.9kB]
Get:2 http://us.archive.ubuntu.com/ubuntu/ lucid-updates/main libmysqlclient16 5.1.41-3ubuntu12.10 [1,933kB]
Get:3 http://us.archive.ubuntu.com/ubuntu/ lucid/main zlib1g-dev 1:1.2.3.3.dfsg-15ubuntu1 [162kB]
Get:4 http://us.archive.ubuntu.com/ubuntu/ lucid-updates/main libmysqlclient-dev 5.1.41-3ubuntu12.10 [3,121kB]
Fetched 5,315kB in 6s (825kB/s)
Selecting previously deselected package mysql-common.
(Reading database ... 58988 files and directories currently installed.)
Unpacking mysql-common (from .../mysql-common_5.1.41-3ubuntu12.10_all.deb) ...
Selecting previously deselected package libmysqlclient16.
Unpacking libmysqlclient16 (from .../libmysqlclient16_5.1.41-3ubuntu12.10_i386.deb) ...
Selecting previously deselected package zlib1g-dev.
Unpacking zlib1g-dev (from .../zlib1g-dev_1%3a1.2.3.3.dfsg-15ubuntu1_i386.deb) ...
Selecting previously deselected package libmysqlclient-dev.
Unpacking libmysqlclient-dev (from .../libmysqlclient-dev_5.1.41-3ubuntu12.10_i386.deb) ...
Processing triggers for man-db ...
Setting up mysql-common (5.1.41-3ubuntu12.10) ...
Setting up libmysqlclient16 (5.1.41-3ubuntu12.10) ...
Setting up zlib1g-dev (1:1.2.3.3.dfsg-15ubuntu1) ...
Setting up libmysqlclient-dev (5.1.41-3ubuntu12.10) ...
Processing triggers for libc-bin ...
ldconfig deferred processing now taking place
[Mon, 07 Mar 2011 14:14:18 -0800] DEBUG: STDERR:
[Mon, 07 Mar 2011 14:14:18 -0800] DEBUG: ---- End output of apt-get -q -y install libmysqlclient-dev=5.1.41-3ubuntu12.10 ----
[Mon, 07 Mar 2011 14:14:18 -0800] DEBUG: Ran apt-get -q -y install libmysqlclient-dev=5.1.41-3ubuntu12.10 returned 0
[Mon, 07 Mar 2011 14:14:18 -0800] DEBUG: Checking apt-cache policy for mysql-client
[Mon, 07 Mar 2011 14:14:19 -0800] DEBUG: Current version is nil
[Mon, 07 Mar 2011 14:14:19 -0800] DEBUG: Candidate version is 5.1.41-3ubuntu12.10
[Mon, 07 Mar 2011 14:14:19 -0800] INFO: Installing package[mysql-client] version 5.1.41-3ubuntu12.10
[Mon, 07 Mar 2011 14:14:19 -0800] DEBUG: Executing apt-get -q -y install mysql-client=5.1.41-3ubuntu12.10
[Mon, 07 Mar 2011 14:15:04 -0800] DEBUG: ---- Begin output of apt-get -q -y install mysql-client=5.1.41-3ubuntu12.10 ----
[Mon, 07 Mar 2011 14:15:04 -0800] DEBUG: STDOUT: Reading package lists...
Building dependency tree...
Reading state information...
The following extra packages will be installed:
libdbd-mysql-perl libdbi-perl libnet-daemon-perl libplrpc-perl mysql-client
mysql-client-5.1 mysql-client-core-5.1
Suggested packages:
dbishell
The following NEW packages will be installed:
libdbd-mysql-perl libdbi-perl libnet-daemon-perl libplrpc-perl mysql-client
mysql-client-5.1 mysql-client-core-5.1
0 upgraded, 7 newly installed, 0 to remove and 48 not upgraded.
Need to get 9,430kB of archives.
After this operation, 23.2MB of additional disk space will be used.
Get:1 http://us.archive.ubuntu.com/ubuntu/ lucid/main libnet-daemon-perl 0.43-1 [46.9kB]
Get:2 http://us.archive.ubuntu.com/ubuntu/ lucid/main libplrpc-perl 0.2020-2 [36.0kB]
Get:3 http://us.archive.ubuntu.com/ubuntu/ lucid/main libdbi-perl 1.609-1build1 [798kB]
Get:4 http://us.archive.ubuntu.com/ubuntu/ lucid/main libdbd-mysql-perl 4.012-1ubuntu1 [135kB]
Get:5 http://us.archive.ubuntu.com/ubuntu/ lucid-updates/main mysql-client-core-5.1 5.1.41-3ubuntu12.10 [178kB]
Get:6 http://us.archive.ubuntu.com/ubuntu/ lucid-updates/main mysql-client-5.1 5.1.41-3ubuntu12.10 [8,141kB]
Get:7 http://us.archive.ubuntu.com/ubuntu/ lucid-updates/main mysql-client 5.1.41-3ubuntu12.10 [94.7kB]
Fetched 9,430kB in 20s (455kB/s)
Selecting previously deselected package libnet-daemon-perl.
(Reading database ... 59094 files and directories currently installed.)
Unpacking libnet-daemon-perl (from .../libnet-daemon-perl_0.43-1_all.deb) ...
Selecting previously deselected package libplrpc-perl.
Unpacking libplrpc-perl (from .../libplrpc-perl_0.2020-2_all.deb) ...
Selecting previously deselected package libdbi-perl.
Unpacking libdbi-perl (from .../libdbi-perl_1.609-1build1_i386.deb) ...
Selecting previously deselected package libdbd-mysql-perl.
Unpacking libdbd-mysql-perl (from .../libdbd-mysql-perl_4.012-1ubuntu1_i386.deb) ...
Selecting previously deselected package mysql-client-core-5.1.
Unpacking mysql-client-core-5.1 (from .../mysql-client-core-5.1_5.1.41-3ubuntu12.10_i386.deb) ...
Selecting previously deselected package mysql-client-5.1.
Unpacking mysql-client-5.1 (from .../mysql-client-5.1_5.1.41-3ubuntu12.10_i386.deb) ...
Selecting previously deselected package mysql-client.
Unpacking mysql-client (from .../mysql-client_5.1.41-3ubuntu12.10_all.deb) ...
Processing triggers for man-db ...
Setting up libnet-daemon-perl (0.43-1) ...
Setting up libplrpc-perl (0.2020-2) ...
Setting up libdbi-perl (1.609-1build1) ...
Setting up libdbd-mysql-perl (4.012-1ubuntu1) ...
Setting up mysql-client-core-5.1 (5.1.41-3ubuntu12.10) ...
Setting up mysql-client-5.1 (5.1.41-3ubuntu12.10) ...
Setting up mysql-client (5.1.41-3ubuntu12.10) ...
[Mon, 07 Mar 2011 14:15:04 -0800] DEBUG: STDERR:
[Mon, 07 Mar 2011 14:15:04 -0800] DEBUG: ---- End output of apt-get -q -y install mysql-client=5.1.41-3ubuntu12.10 ----
[Mon, 07 Mar 2011 14:15:04 -0800] DEBUG: Ran apt-get -q -y install mysql-client=5.1.41-3ubuntu12.10 returned 0
[Mon, 07 Mar 2011 14:15:04 -0800] DEBUG: No installed version found for mysql (>= 0, runtime)
[Mon, 07 Mar 2011 14:15:08 -0800] DEBUG: Found gem mysql version 2.8.1 for platform ruby from http://rubygems.org/
[Mon, 07 Mar 2011 14:15:08 -0800] INFO: Installing gem_package[mysql] version 2.8.1
Fetching: mysql-2.8.1.gem (100%)
Building native extensions. This could take a while...
[Mon, 07 Mar 2011 14:15:15 -0800] DEBUG: Setting directory[/var/cache/local/preseeding] to the state of the prior directory[/var/cache/local/preseeding]
[Mon, 07 Mar 2011 14:15:15 -0800] WARN: Could not find previously defined grants.sql resource
[Mon, 07 Mar 2011 14:15:15 -0800] DEBUG: Signing the request as vagrantup.com
[Mon, 07 Mar 2011 14:15:15 -0800] DEBUG: String to sign: 'Method:GET
Hashed Path:CVX+H4TwVTvanDZ8Dn9hV1369zs=
X-Ops-Content-Hash:2jmj7l5rSw0yVb/vlWAYkK/YBwk=
X-Ops-Timestamp:2011-03-07T22:15:15Z
X-Ops-UserId:vagrantup.com'
Header hash: {"X-Ops-Content-Hash"=>"2jmj7l5rSw0yVb/vlWAYkK/YBwk=", "X-Ops-Authorization-1"=>"xMicRkiz77nP/nF2kMbGMeAp+6tWSvkg5RIa57gtTZy8TP0jdXGRdLuxPPC8", "X-Ops-Userid"=>"vagrantup.com", "X-Ops-Sign"=>"version=1.0", "X-Ops-Authorization-2"=>"kukRC43xNdNPELvDV7tLEFIz2OU6hpshqdpAVThcz/CnVQPFf4/fZcstjnzP", "X-Ops-Authorization-3"=>"qDaHXX35OrLvB7g94nM9BLFQ0iVNTpXqfR707FhN5FQQLj5g+Hb2wBdvo1JW", "X-Ops-Authorization-4"=>"A8I/FmIEtOTjD65eNqPCYc/faLhIlyBWzlRYG+qC3uc0hKRmKnovr1a9UYuP", "X-Ops-Authorization-5"=>"95GKkhlhc60AuUuAQzQWtZO0nyT41ouLcd4xL1zYWtauE5QOvJD5FKAn4tOv", "X-Ops-Authorization-6"=>"m8VaACtQ9vvNB6WPU27Omdfw/XrO64vHSYEy+oUDQg==", "X-Ops-Timestamp"=>"2011-03-07T22:15:15Z"}
[Mon, 07 Mar 2011 14:15:15 -0800] DEBUG: Sending HTTP Request via GET to api.opscode.com:443/organizations/libersy/search/apps
[Mon, 07 Mar 2011 14:15:16 -0800] DEBUG: I am not loading mysql::client, because I have already seen it.
[Mon, 07 Mar 2011 14:15:16 -0800] DEBUG: Loading Recipe application via include_recipe
[Mon, 07 Mar 2011 14:15:16 -0800] DEBUG: Found recipe default in cookbook application
[Mon, 07 Mar 2011 14:15:16 -0800] DEBUG: Signing the request as vagrantup.com
[Mon, 07 Mar 2011 14:15:16 -0800] DEBUG: String to sign: 'Method:GET
Hashed Path:CVX+H4TwVTvanDZ8Dn9hV1369zs=
X-Ops-Content-Hash:2jmj7l5rSw0yVb/vlWAYkK/YBwk=
X-Ops-Timestamp:2011-03-07T22:15:16Z
X-Ops-UserId:vagrantup.com'
Header hash: {"X-Ops-Content-Hash"=>"2jmj7l5rSw0yVb/vlWAYkK/YBwk=", "X-Ops-Authorization-1"=>"GGlIQfMk/rN98iux1iv7k1mANIPtQObfwLf4oU12CFI/g24mqPRCiWEpN/jQ", "X-Ops-Userid"=>"vagrantup.com", "X-Ops-Sign"=>"version=1.0", "X-Ops-Authorization-2"=>"jhIaSeYr6shW7/wDTplrNjRGSzTzbANbaieIQCVAn1H04ua9ovaX/irwHjPT", "X-Ops-Authorization-3"=>"fgIi2Kg6KzaItfgJ4SmdqElXe63sRBDbNtItudkJbdfvZ+Vw+G9VXS6p2t2n", "X-Ops-Authorization-4"=>"84K4S9MLZDvys4Ghcx1U6dn45pq8DHLBF9p3JEjgwKwgUQ6pJpULBK8VWcIE", "X-Ops-Authorization-5"=>"xfTFq7aQ11vh2O5o9EJoAEnUIJ6JLCyjKqdFY+mD+tzupeTCcNi23J5T5DMU", "X-Ops-Authorization-6"=>"4QrQ4AFWZRf9UCcZLbHRVdAbMvG17/zB0NLV8wTuBg==", "X-Ops-Timestamp"=>"2011-03-07T22:15:16Z"}
[Mon, 07 Mar 2011 14:15:16 -0800] DEBUG: Sending HTTP Request via GET to api.opscode.com:443/organizations/libersy/search/apps
[Mon, 07 Mar 2011 14:15:18 -0800] DEBUG: Loading Recipe radiant::db_bootstrap via include_recipe
[Mon, 07 Mar 2011 14:15:18 -0800] DEBUG: Found recipe db_bootstrap in cookbook radiant
[Mon, 07 Mar 2011 14:15:18 -0800] DEBUG: Signing the request as vagrantup.com
[Mon, 07 Mar 2011 14:15:18 -0800] DEBUG: String to sign: 'Method:GET
Hashed Path:PmDdxkG/mb/VYV14t3a1E8VgKWI=
X-Ops-Content-Hash:2jmj7l5rSw0yVb/vlWAYkK/YBwk=
X-Ops-Timestamp:2011-03-07T22:15:18Z
X-Ops-UserId:vagrantup.com'
Header hash: {"X-Ops-Content-Hash"=>"2jmj7l5rSw0yVb/vlWAYkK/YBwk=", "X-Ops-Authorization-1"=>"FbZF+h8e2vXBQX4hfAwsQ8C3qnSEvD7Vn1D8WZeQvxzuLmg0a/JRjeXSHjtr", "X-Ops-Userid"=>"vagrantup.com", "X-Ops-Sign"=>"version=1.0", "X-Ops-Authorization-2"=>"8Vtm+FteHaQhBVIWhu3AfXxI5fUeGI9Eobwxw9SY0VccUdSYj9bIJB7olH8V", "X-Ops-Authorization-3"=>"1MT3N8Jae73TaY9Pz5kagi9o6fbYHL7oCQnwUSJRpkS907MnT18yAnraZXV+", "X-Ops-Authorization-4"=>"V6O2m6iY/5D3dXETtXqujFKKkADUBBSMCJQOJm0ZPlUbwrI13uK5vUFfZGkz", "X-Ops-Authorization-5"=>"dxlVih/qiouWYV/7G9ni/pty8QJPGDwIfQLPaWk4pYQcztsztVEgOCqxTutS", "X-Ops-Authorization-6"=>"L6xUfdrbr+MXMv1bakfXw0k1JRzVGNhoD0HUk6ZVMA==", "X-Ops-Timestamp"=>"2011-03-07T22:15:18Z"}
[Mon, 07 Mar 2011 14:15:18 -0800] DEBUG: Sending HTTP Request via GET to api.opscode.com:443/organizations/libersy/data/apps/radiant
[Mon, 07 Mar 2011 14:15:19 -0800] DEBUG: Converging node vagrantup.com
[Mon, 07 Mar 2011 14:15:19 -0800] DEBUG: Processing execute[apt-get update] on vagrantup.com
[Mon, 07 Mar 2011 14:15:19 -0800] DEBUG: Doing nothing for execute[apt-get update]
[Mon, 07 Mar 2011 14:15:19 -0800] DEBUG: Processing directory[/var/cache/local] on vagrantup.com
[Mon, 07 Mar 2011 14:15:19 -0800] INFO: Creating directory[/var/cache/local] at /var/cache/local
[Mon, 07 Mar 2011 14:15:19 -0800] INFO: Setting owner to 0 for directory[/var/cache/local]
[Mon, 07 Mar 2011 14:15:19 -0800] INFO: Setting group to 0 for directory[/var/cache/local]
[Mon, 07 Mar 2011 14:15:19 -0800] INFO: Setting mode to 755 for directory[/var/cache/local]
[Mon, 07 Mar 2011 14:15:19 -0800] DEBUG: Processing directory[/var/cache/local/preseeding] on vagrantup.com
[Mon, 07 Mar 2011 14:15:19 -0800] INFO: Creating directory[/var/cache/local/preseeding] at /var/cache/local/preseeding
[Mon, 07 Mar 2011 14:15:19 -0800] INFO: Setting owner to 0 for directory[/var/cache/local/preseeding]
[Mon, 07 Mar 2011 14:15:19 -0800] INFO: Setting group to 0 for directory[/var/cache/local/preseeding]
[Mon, 07 Mar 2011 14:15:19 -0800] INFO: Setting mode to 755 for directory[/var/cache/local/preseeding]
[Mon, 07 Mar 2011 14:15:19 -0800] DEBUG: Processing package[git-core] on vagrantup.com
[Mon, 07 Mar 2011 14:15:19 -0800] DEBUG: Checking apt-cache policy for git-core
[Mon, 07 Mar 2011 14:15:20 -0800] DEBUG: Current version is nil
[Mon, 07 Mar 2011 14:15:20 -0800] DEBUG: Candidate version is 1:1.7.0.4-1ubuntu0.2
[Mon, 07 Mar 2011 14:15:20 -0800] INFO: Installing package[git-core] version 1:1.7.0.4-1ubuntu0.2
[Mon, 07 Mar 2011 14:15:20 -0800] DEBUG: Executing apt-get -q -y install git-core=1:1.7.0.4-1ubuntu0.2
[Mon, 07 Mar 2011 14:15:46 -0800] DEBUG: ---- Begin output of apt-get -q -y install git-core=1:1.7.0.4-1ubuntu0.2 ----
[Mon, 07 Mar 2011 14:15:46 -0800] DEBUG: STDOUT: Reading package lists...
Building dependency tree...
Reading state information...
The following extra packages will be installed:
git-core libdigest-sha1-perl liberror-perl
Suggested packages:
git-doc git-arch git-cvs git-svn git-email git-daemon-run git-gui gitk
gitweb
The following NEW packages will be installed:
git-core libdigest-sha1-perl liberror-perl
0 upgraded, 3 newly installed, 0 to remove and 48 not upgraded.
Need to get 5,688kB of archives.
After this operation, 11.9MB of additional disk space will be used.
Get:1 http://us.archive.ubuntu.com/ubuntu/ lucid/main liberror-perl 0.17-1 [23.8kB]
Get:2 http://us.archive.ubuntu.com/ubuntu/ lucid/main libdigest-sha1-perl 2.12-1build1 [26.2kB]
Get:3 http://us.archive.ubuntu.com/ubuntu/ lucid-updates/main git-core 1:1.7.0.4-1ubuntu0.2 [5,638kB]
Fetched 5,688kB in 8s (640kB/s)
Selecting previously deselected package liberror-perl.
(Reading database ... 59353 files and directories currently installed.)
Unpacking liberror-perl (from .../liberror-perl_0.17-1_all.deb) ...
Selecting previously deselected package libdigest-sha1-perl.
Unpacking libdigest-sha1-perl (from .../libdigest-sha1-perl_2.12-1build1_i386.deb) ...
Selecting previously deselected package git-core.
Unpacking git-core (from .../git-core_1%3a1.7.0.4-1ubuntu0.2_i386.deb) ...
Processing triggers for man-db ...
Setting up liberror-perl (0.17-1) ...
Setting up libdigest-sha1-perl (2.12-1build1) ...
Setting up git-core (1:1.7.0.4-1ubuntu0.2) ...
[Mon, 07 Mar 2011 14:15:46 -0800] DEBUG: STDERR:
[Mon, 07 Mar 2011 14:15:46 -0800] DEBUG: ---- End output of apt-get -q -y install git-core=1:1.7.0.4-1ubuntu0.2 ----
[Mon, 07 Mar 2011 14:15:46 -0800] DEBUG: Ran apt-get -q -y install git-core=1:1.7.0.4-1ubuntu0.2 returned 0
[Mon, 07 Mar 2011 14:15:46 -0800] DEBUG: Processing package[build-essential] on vagrantup.com
[Mon, 07 Mar 2011 14:15:46 -0800] DEBUG: Checking apt-cache policy for build-essential
[Mon, 07 Mar 2011 14:15:48 -0800] DEBUG: Current version is 11.4build1
[Mon, 07 Mar 2011 14:15:48 -0800] DEBUG: Candidate version is 11.4build1
[Mon, 07 Mar 2011 14:15:48 -0800] DEBUG: Processing package[binutils-doc] on vagrantup.com
[Mon, 07 Mar 2011 14:15:48 -0800] DEBUG: Checking apt-cache policy for binutils-doc
[Mon, 07 Mar 2011 14:15:48 -0800] DEBUG: Current version is nil
[Mon, 07 Mar 2011 14:15:48 -0800] DEBUG: Candidate version is 2.20.1-3ubuntu7
[Mon, 07 Mar 2011 14:15:48 -0800] INFO: Installing package[binutils-doc] version 2.20.1-3ubuntu7
[Mon, 07 Mar 2011 14:15:48 -0800] DEBUG: Executing apt-get -q -y install binutils-doc=2.20.1-3ubuntu7
[Mon, 07 Mar 2011 14:15:57 -0800] DEBUG: ---- Begin output of apt-get -q -y install binutils-doc=2.20.1-3ubuntu7 ----
[Mon, 07 Mar 2011 14:15:57 -0800] DEBUG: STDOUT: Reading package lists...
Building dependency tree...
Reading state information...
The following NEW packages will be installed:
binutils-doc
0 upgraded, 1 newly installed, 0 to remove and 48 not upgraded.
Need to get 553kB of archives.
After this operation, 610kB of additional disk space will be used.
Get:1 http://us.archive.ubuntu.com/ubuntu/ lucid-updates/main binutils-doc 2.20.1-3ubuntu7 [553kB]
Fetched 553kB in 1s (328kB/s)
Selecting previously deselected package binutils-doc.
(Reading database ... 59879 files and directories currently installed.)
Unpacking binutils-doc (from .../binutils-doc_2.20.1-3ubuntu7_all.deb) ...
Processing triggers for install-info ...
Setting up binutils-doc (2.20.1-3ubuntu7) ...
[Mon, 07 Mar 2011 14:15:57 -0800] DEBUG: STDERR:
[Mon, 07 Mar 2011 14:15:57 -0800] DEBUG: ---- End output of apt-get -q -y install binutils-doc=2.20.1-3ubuntu7 ----
[Mon, 07 Mar 2011 14:15:57 -0800] DEBUG: Ran apt-get -q -y install binutils-doc=2.20.1-3ubuntu7 returned 0
[Mon, 07 Mar 2011 14:15:57 -0800] DEBUG: Processing package[autoconf] on vagrantup.com
[Mon, 07 Mar 2011 14:15:57 -0800] DEBUG: Checking apt-cache policy for autoconf
[Mon, 07 Mar 2011 14:15:58 -0800] DEBUG: Current version is nil
[Mon, 07 Mar 2011 14:15:58 -0800] DEBUG: Candidate version is 2.65-3ubuntu1
[Mon, 07 Mar 2011 14:15:58 -0800] INFO: Installing package[autoconf] version 2.65-3ubuntu1
[Mon, 07 Mar 2011 14:15:58 -0800] DEBUG: Executing apt-get -q -y install autoconf=2.65-3ubuntu1
[Mon, 07 Mar 2011 14:16:18 -0800] DEBUG: ---- Begin output of apt-get -q -y install autoconf=2.65-3ubuntu1 ----
[Mon, 07 Mar 2011 14:16:18 -0800] DEBUG: STDOUT: Reading package lists...
Building dependency tree...
Reading state information...
The following extra packages will be installed:
autoconf automake autotools-dev m4
Suggested packages:
autoconf2.13 autoconf-archive gnu-standards autoconf-doc libtool gettext
The following NEW packages will be installed:
autoconf automake autotools-dev m4
0 upgraded, 4 newly installed, 0 to remove and 48 not upgraded.
Need to get 1,685kB of archives.
After this operation, 4,915kB of additional disk space will be used.
Get:1 http://us.archive.ubuntu.com/ubuntu/ lucid/main m4 1.4.13-3 [241kB]
Get:2 http://us.archive.ubuntu.com/ubuntu/ lucid/main autoconf 2.65-3ubuntu1 [772kB]
Get:3 http://us.archive.ubuntu.com/ubuntu/ lucid/main autotools-dev 20090611.1 [64.1kB]
Get:4 http://us.archive.ubuntu.com/ubuntu/ lucid/main automake 1:1.11.1-1 [608kB]
Fetched 1,685kB in 3s (461kB/s)
Selecting previously deselected package m4.
(Reading database ... 59891 files and directories currently installed.)
Unpacking m4 (from .../archives/m4_1.4.13-3_i386.deb) ...
Selecting previously deselected package autoconf.
Unpacking autoconf (from .../autoconf_2.65-3ubuntu1_all.deb) ...
Selecting previously deselected package autotools-dev.
Unpacking autotools-dev (from .../autotools-dev_20090611.1_all.deb) ...
Selecting previously deselected package automake.
Unpacking automake (from .../automake_1%3a1.11.1-1_all.deb) ...
Processing triggers for install-info ...
Processing triggers for man-db ...
Setting up m4 (1.4.13-3) ...
Setting up autoconf (2.65-3ubuntu1) ...
Setting up autotools-dev (20090611.1) ...
Setting up automake (1:1.11.1-1) ...
update-alternatives: using /usr/bin/automake-1.11 to provide /usr/bin/automake (automake) in auto mode.
[Mon, 07 Mar 2011 14:16:18 -0800] DEBUG: STDERR:
[Mon, 07 Mar 2011 14:16:18 -0800] DEBUG: ---- End output of apt-get -q -y install autoconf=2.65-3ubuntu1 ----
[Mon, 07 Mar 2011 14:16:18 -0800] DEBUG: Ran apt-get -q -y install autoconf=2.65-3ubuntu1 returned 0
[Mon, 07 Mar 2011 14:16:18 -0800] DEBUG: Processing package[flex] on vagrantup.com
[Mon, 07 Mar 2011 14:16:18 -0800] DEBUG: Checking apt-cache policy for flex
[Mon, 07 Mar 2011 14:16:19 -0800] DEBUG: Current version is nil
[Mon, 07 Mar 2011 14:16:19 -0800] DEBUG: Candidate version is 2.5.35-9
[Mon, 07 Mar 2011 14:16:19 -0800] INFO: Installing package[flex] version 2.5.35-9
[Mon, 07 Mar 2011 14:16:19 -0800] DEBUG: Executing apt-get -q -y install flex=2.5.35-9
[Mon, 07 Mar 2011 14:16:27 -0800] DEBUG: ---- Begin output of apt-get -q -y install flex=2.5.35-9 ----
[Mon, 07 Mar 2011 14:16:27 -0800] DEBUG: STDOUT: Reading package lists...
Building dependency tree...
Reading state information...
Suggested packages:
bison
The following NEW packages will be installed:
flex
0 upgraded, 1 newly installed, 0 to remove and 48 not upgraded.
Need to get 244kB of archives.
After this operation, 999kB of additional disk space will be used.
Get:1 http://us.archive.ubuntu.com/ubuntu/ lucid/main flex 2.5.35-9 [244kB]
Fetched 244kB in 0s (249kB/s)
Selecting previously deselected package flex.
(Reading database ... 60178 files and directories currently installed.)
Unpacking flex (from .../flex_2.5.35-9_i386.deb) ...
Processing triggers for install-info ...
Processing triggers for man-db ...
Setting up flex (2.5.35-9) ...
[Mon, 07 Mar 2011 14:16:27 -0800] DEBUG: STDERR:
[Mon, 07 Mar 2011 14:16:27 -0800] DEBUG: ---- End output of apt-get -q -y install flex=2.5.35-9 ----
[Mon, 07 Mar 2011 14:16:27 -0800] DEBUG: Ran apt-get -q -y install flex=2.5.35-9 returned 0
[Mon, 07 Mar 2011 14:16:27 -0800] DEBUG: Processing package[bison] on vagrantup.com
[Mon, 07 Mar 2011 14:16:27 -0800] DEBUG: Checking apt-cache policy for bison
[Mon, 07 Mar 2011 14:16:27 -0800] DEBUG: Current version is nil
[Mon, 07 Mar 2011 14:16:27 -0800] DEBUG: Candidate version is 1:2.4.1.dfsg-3
[Mon, 07 Mar 2011 14:16:27 -0800] INFO: Installing package[bison] version 1:2.4.1.dfsg-3
[Mon, 07 Mar 2011 14:16:27 -0800] DEBUG: Executing apt-get -q -y install bison=1:2.4.1.dfsg-3
[Mon, 07 Mar 2011 14:16:35 -0800] DEBUG: ---- Begin output of apt-get -q -y install bison=1:2.4.1.dfsg-3 ----
[Mon, 07 Mar 2011 14:16:35 -0800] DEBUG: STDOUT: Reading package lists...
Building dependency tree...
Reading state information...
Suggested packages:
bison-doc
The following NEW packages will be installed:
bison
0 upgraded, 1 newly installed, 0 to remove and 48 not upgraded.
Need to get 468kB of archives.
After this operation, 1,810kB of additional disk space will be used.
Get:1 http://us.archive.ubuntu.com/ubuntu/ lucid/main bison 1:2.4.1.dfsg-3 [468kB]
Fetched 468kB in 1s (294kB/s)
Selecting previously deselected package bison.
(Reading database ... 60201 files and directories currently installed.)
Unpacking bison (from .../bison_1%3a2.4.1.dfsg-3_i386.deb) ...
Processing triggers for man-db ...
Setting up bison (1:2.4.1.dfsg-3) ...
update-alternatives: using /usr/bin/bison.yacc to provide /usr/bin/yacc (yacc) in auto mode.
[Mon, 07 Mar 2011 14:16:35 -0800] DEBUG: STDERR:
[Mon, 07 Mar 2011 14:16:35 -0800] DEBUG: ---- End output of apt-get -q -y install bison=1:2.4.1.dfsg-3 ----
[Mon, 07 Mar 2011 14:16:35 -0800] DEBUG: Ran apt-get -q -y install bison=1:2.4.1.dfsg-3 returned 0
[Mon, 07 Mar 2011 14:16:35 -0800] DEBUG: Processing package[ruby1.8] on vagrantup.com
[Mon, 07 Mar 2011 14:16:35 -0800] DEBUG: Checking apt-cache policy for ruby1.8
[Mon, 07 Mar 2011 14:16:36 -0800] DEBUG: Current version is 1.8.7.249-2
[Mon, 07 Mar 2011 14:16:36 -0800] DEBUG: Candidate version is 1.8.7.249-2
[Mon, 07 Mar 2011 14:16:36 -0800] DEBUG: Processing package[ruby1.8-dev] on vagrantup.com
[Mon, 07 Mar 2011 14:16:36 -0800] DEBUG: Checking apt-cache policy for ruby1.8-dev
[Mon, 07 Mar 2011 14:16:36 -0800] DEBUG: Current version is 1.8.7.249-2
[Mon, 07 Mar 2011 14:16:36 -0800] DEBUG: Candidate version is 1.8.7.249-2
[Mon, 07 Mar 2011 14:16:36 -0800] DEBUG: Processing package[rdoc1.8] on vagrantup.com
[Mon, 07 Mar 2011 14:16:36 -0800] DEBUG: Checking apt-cache policy for rdoc1.8
[Mon, 07 Mar 2011 14:16:36 -0800] DEBUG: Current version is 1.8.7.249-2
[Mon, 07 Mar 2011 14:16:36 -0800] DEBUG: Candidate version is 1.8.7.249-2
[Mon, 07 Mar 2011 14:16:36 -0800] DEBUG: Processing package[ri1.8] on vagrantup.com
[Mon, 07 Mar 2011 14:16:36 -0800] DEBUG: Checking apt-cache policy for ri1.8
[Mon, 07 Mar 2011 14:16:36 -0800] DEBUG: Current version is 1.8.7.249-2
[Mon, 07 Mar 2011 14:16:36 -0800] DEBUG: Candidate version is 1.8.7.249-2
[Mon, 07 Mar 2011 14:16:36 -0800] DEBUG: Processing package[irb1.8] on vagrantup.com
[Mon, 07 Mar 2011 14:16:36 -0800] DEBUG: Checking apt-cache policy for irb1.8
[Mon, 07 Mar 2011 14:16:36 -0800] DEBUG: Current version is 1.8.7.249-2
[Mon, 07 Mar 2011 14:16:36 -0800] DEBUG: Candidate version is 1.8.7.249-2
[Mon, 07 Mar 2011 14:16:36 -0800] DEBUG: Processing package[libopenssl-ruby1.8] on vagrantup.com
[Mon, 07 Mar 2011 14:16:36 -0800] DEBUG: Checking apt-cache policy for libopenssl-ruby1.8
[Mon, 07 Mar 2011 14:16:36 -0800] DEBUG: Current version is 1.8.7.249-2
[Mon, 07 Mar 2011 14:16:36 -0800] DEBUG: Candidate version is 1.8.7.249-2
[Mon, 07 Mar 2011 14:16:36 -0800] DEBUG: Processing package[libshadow-ruby1.8] on vagrantup.com
[Mon, 07 Mar 2011 14:16:36 -0800] DEBUG: Checking apt-cache policy for libshadow-ruby1.8
[Mon, 07 Mar 2011 14:16:36 -0800] DEBUG: Current version is nil
[Mon, 07 Mar 2011 14:16:36 -0800] DEBUG: Candidate version is 1.4.1-8build1
[Mon, 07 Mar 2011 14:16:36 -0800] INFO: Installing package[libshadow-ruby1.8] version 1.4.1-8build1
[Mon, 07 Mar 2011 14:16:36 -0800] DEBUG: Executing apt-get -q -y install libshadow-ruby1.8=1.4.1-8build1
[Mon, 07 Mar 2011 14:16:43 -0800] DEBUG: ---- Begin output of apt-get -q -y install libshadow-ruby1.8=1.4.1-8build1 ----
[Mon, 07 Mar 2011 14:16:43 -0800] DEBUG: STDOUT: Reading package lists...
Building dependency tree...
Reading state information...
The following NEW packages will be installed:
libshadow-ruby1.8
0 upgraded, 1 newly installed, 0 to remove and 48 not upgraded.
Need to get 8,828B of archives.
After this operation, 73.7kB of additional disk space will be used.
Get:1 http://us.archive.ubuntu.com/ubuntu/ lucid/main libshadow-ruby1.8 1.4.1-8build1 [8,828B]
Fetched 8,828B in 0s (29.4kB/s)
Selecting previously deselected package libshadow-ruby1.8.
(Reading database ... 60239 files and directories currently installed.)
Unpacking libshadow-ruby1.8 (from .../libshadow-ruby1.8_1.4.1-8build1_i386.deb) ...
Setting up libshadow-ruby1.8 (1.4.1-8build1) ...
[Mon, 07 Mar 2011 14:16:43 -0800] DEBUG: STDERR:
[Mon, 07 Mar 2011 14:16:43 -0800] DEBUG: ---- End output of apt-get -q -y install libshadow-ruby1.8=1.4.1-8build1 ----
[Mon, 07 Mar 2011 14:16:43 -0800] DEBUG: Ran apt-get -q -y install libshadow-ruby1.8=1.4.1-8build1 returned 0
[Mon, 07 Mar 2011 14:16:43 -0800] DEBUG: Processing package[mysql-devel] on vagrantup.com
[Mon, 07 Mar 2011 14:16:43 -0800] DEBUG: Checking apt-cache policy for libmysqlclient-dev
[Mon, 07 Mar 2011 14:16:43 -0800] DEBUG: Current version is 5.1.41-3ubuntu12.10
[Mon, 07 Mar 2011 14:16:43 -0800] DEBUG: Candidate version is 5.1.41-3ubuntu12.10
[Mon, 07 Mar 2011 14:16:43 -0800] DEBUG: Doing nothing for package[mysql-devel]
[Mon, 07 Mar 2011 14:16:43 -0800] DEBUG: Processing package[mysql-client] on vagrantup.com
[Mon, 07 Mar 2011 14:16:43 -0800] DEBUG: Checking apt-cache policy for mysql-client
[Mon, 07 Mar 2011 14:16:44 -0800] DEBUG: Current version is 5.1.41-3ubuntu12.10
[Mon, 07 Mar 2011 14:16:44 -0800] DEBUG: Candidate version is 5.1.41-3ubuntu12.10
[Mon, 07 Mar 2011 14:16:44 -0800] DEBUG: Doing nothing for package[mysql-client]
[Mon, 07 Mar 2011 14:16:44 -0800] DEBUG: Processing gem_package[mysql] on vagrantup.com
[Mon, 07 Mar 2011 14:16:44 -0800] DEBUG: Found installed gem mysql version 2.8.1 matching mysql (>= 0, runtime)
[Mon, 07 Mar 2011 14:16:44 -0800] DEBUG: Doing nothing for gem_package[mysql]
[Mon, 07 Mar 2011 14:16:44 -0800] DEBUG: Processing directory[/var/cache/local/preseeding] on vagrantup.com
[Mon, 07 Mar 2011 14:16:44 -0800] DEBUG: Processing execute[preseed mysql-server] on vagrantup.com
[Mon, 07 Mar 2011 14:16:44 -0800] DEBUG: Doing nothing for execute[preseed mysql-server]
[Mon, 07 Mar 2011 14:16:44 -0800] DEBUG: Processing template[/var/cache/local/preseeding/mysql-server.seed] on vagrantup.com
[Mon, 07 Mar 2011 14:16:44 -0800] DEBUG: looking for template mysql-server.seed.erb in cookbook "mysql"
[Mon, 07 Mar 2011 14:16:44 -0800] DEBUG: Signing the request as vagrantup.com
[Mon, 07 Mar 2011 14:16:44 -0800] DEBUG: String to sign: 'Method:GET
Hashed Path:Ipbo4wXGCChOGfJLA6MRh88j6wE=
X-Ops-Content-Hash:2jmj7l5rSw0yVb/vlWAYkK/YBwk=
X-Ops-Timestamp:2011-03-07T22:16:44Z
X-Ops-UserId:vagrantup.com'
Header hash: {"X-Ops-Content-Hash"=>"2jmj7l5rSw0yVb/vlWAYkK/YBwk=", "X-Ops-Authorization-1"=>"MFpRZ+vBpCAMT49musP0TbSUv7OKkfp0SzH5YV7NXG3FzYjqWqJemW+aEK5U", "X-Ops-Userid"=>"vagrantup.com", "X-Ops-Sign"=>"version=1.0", "X-Ops-Authorization-2"=>"doFvV5pVTrPaEst/Kkq8e0i+iNeH160ugV4l0ox3zBwVQJNjdkU1oUhGXiCH", "X-Ops-Authorization-3"=>"QBqdB1HYg9j/pU5XSh+6flC0gLTaovo7WCyjl5m2880PsNbQHnbQcxMJaKND", "X-Ops-Authorization-4"=>"cg2y1+WKIjCIvcDCml+fTIJv5yzsDa/kBEfGGmqAepNjVVY6MqkdUw9SF0VO", "X-Ops-Authorization-5"=>"gPFJuxOhFLNnc9hLJKspjTZL8t9HaxYB7ot4AHdphlVsjolBG7Nq+isWiRdN", "X-Ops-Authorization-6"=>"4ZuFAdIWXQsAwpKPJN2JZMqGE0gg7fvQCpgpherZkQ==", "X-Ops-Timestamp"=>"2011-03-07T22:16:44Z"}
[Mon, 07 Mar 2011 14:16:44 -0800] DEBUG: Sending HTTP Request via GET to s3.amazonaws.com:443/opscode-platform-production-data/organization-912f0dce8213412f81eafe6692f41594/checksum-096fe3dcc11747fd9e4f6786c595ba2d
[Mon, 07 Mar 2011 14:16:44 -0800] DEBUG: Streaming download from https://s3.amazonaws.com/opscode-platform-production-data/organization-912f0dce8213412f81eafe6692f41594/checksum-096fe3dcc11747fd9e4f6786c595ba2d?AWSAccessKeyId=AKIAJOZTD2N26S7W6APA&Expires=1299539502&Signature=FVpEiSF5gW9lXvwGXzHezYK9mog%3D to tempfile /tmp/chef-rest20110307-1731-1saulvw-0
[Mon, 07 Mar 2011 14:16:44 -0800] INFO: Storing updated cookbooks/mysql/templates/default/mysql-server.seed.erb in the cache.
[Mon, 07 Mar 2011 14:16:44 -0800] DEBUG: Creating directory /var/chef/cache/cookbooks/mysql/templates
[Mon, 07 Mar 2011 14:16:44 -0800] DEBUG: Creating directory /var/chef/cache/cookbooks/mysql/templates/default
[Mon, 07 Mar 2011 14:16:44 -0800] DEBUG: Current content's checksum:
[Mon, 07 Mar 2011 14:16:44 -0800] DEBUG: Rendered content's checksum: 0079a439421374368f0d0fcda31c183ad8568845812ac76e58630637131b24bc
[Mon, 07 Mar 2011 14:16:44 -0800] INFO: Writing updated content for template[/var/cache/local/preseeding/mysql-server.seed] to /var/cache/local/preseeding/mysql-server.seed
[Mon, 07 Mar 2011 14:16:44 -0800] INFO: template[/var/cache/local/preseeding/mysql-server.seed] sending run action to execute[preseed mysql-server] (immediate)
[Mon, 07 Mar 2011 14:16:44 -0800] DEBUG: Executing debconf-set-selections /var/cache/local/preseeding/mysql-server.seed
[Mon, 07 Mar 2011 14:16:44 -0800] DEBUG: ---- Begin output of debconf-set-selections /var/cache/local/preseeding/mysql-server.seed ----
[Mon, 07 Mar 2011 14:16:44 -0800] DEBUG: STDOUT:
[Mon, 07 Mar 2011 14:16:44 -0800] DEBUG: STDERR:
[Mon, 07 Mar 2011 14:16:44 -0800] DEBUG: ---- End output of debconf-set-selections /var/cache/local/preseeding/mysql-server.seed ----
[Mon, 07 Mar 2011 14:16:44 -0800] DEBUG: Ran debconf-set-selections /var/cache/local/preseeding/mysql-server.seed returned 0
[Mon, 07 Mar 2011 14:16:44 -0800] INFO: Ran execute[preseed mysql-server] successfully
[Mon, 07 Mar 2011 14:16:44 -0800] DEBUG: Processing template[/etc/mysql/debian.cnf] on vagrantup.com
[Mon, 07 Mar 2011 14:16:44 -0800] DEBUG: looking for template debian.cnf.erb in cookbook "mysql"
[Mon, 07 Mar 2011 14:16:44 -0800] DEBUG: Signing the request as vagrantup.com
[Mon, 07 Mar 2011 14:16:44 -0800] DEBUG: String to sign: 'Method:GET
Hashed Path:f5btePIzUdu5bF6uQMoYJeqhRsw=
X-Ops-Content-Hash:2jmj7l5rSw0yVb/vlWAYkK/YBwk=
X-Ops-Timestamp:2011-03-07T22:16:44Z
X-Ops-UserId:vagrantup.com'
Header hash: {"X-Ops-Content-Hash"=>"2jmj7l5rSw0yVb/vlWAYkK/YBwk=", "X-Ops-Authorization-1"=>"J+qLGr1NU4iP3doDaHeKfUnXypKPvEKMhubwaMzIQPiCAhQSCBsHOECDEd1g", "X-Ops-Userid"=>"vagrantup.com", "X-Ops-Sign"=>"version=1.0", "X-Ops-Authorization-2"=>"Z7ZVDucBIhfU9tJWOmYtZnzfp6N0/Gbr+5leoPhYg+uYInhjYBNZcDsLtjC+", "X-Ops-Authorization-3"=>"XUw8bbuzj6XW15OGzl+aLJWtIamRfySYf2WJm4FCqRBZS5urMZLnbb/a14WC", "X-Ops-Authorization-4"=>"3oXAS3x3C/o7uPV10F48zZr9xNIBmJ79lAyt0yQ/R/nfkoFhNN/Qx8LGqYiT", "X-Ops-Authorization-5"=>"cyMcAiSGxilyyg6aWMyPYYxc+ij4d/UtT4PKvQSQtoSSgM7MkEjjIXhj2HmB", "X-Ops-Authorization-6"=>"VYGONL8R8xBzXXTSqr5RodX4X6fAsV/5izZeBQzyQg==", "X-Ops-Timestamp"=>"2011-03-07T22:16:44Z"}
[Mon, 07 Mar 2011 14:16:44 -0800] DEBUG: Sending HTTP Request via GET to s3.amazonaws.com:443/opscode-platform-production-data/organization-912f0dce8213412f81eafe6692f41594/checksum-28bd6fe21c4c37a09f34532c3128e79c
[Mon, 07 Mar 2011 14:16:45 -0800] DEBUG: Streaming download from https://s3.amazonaws.com/opscode-platform-production-data/organization-912f0dce8213412f81eafe6692f41594/checksum-28bd6fe21c4c37a09f34532c3128e79c?AWSAccessKeyId=AKIAJOZTD2N26S7W6APA&Expires=1299539502&Signature=3oquFOWlHTb%2BZK%2FXqauJwLm1XJI%3D to tempfile /tmp/chef-rest20110307-1731-7k20xv-0
[Mon, 07 Mar 2011 14:16:45 -0800] INFO: Storing updated cookbooks/mysql/templates/default/debian.cnf.erb in the cache.
[Mon, 07 Mar 2011 14:16:45 -0800] DEBUG: Current content's checksum:
[Mon, 07 Mar 2011 14:16:45 -0800] DEBUG: Rendered content's checksum: 4f4e1c492774ba2b7a5724165e56fa48cd9ceea43bb17c88013fa1492056298a
[Mon, 07 Mar 2011 14:16:45 -0800] INFO: Writing updated content for template[/etc/mysql/debian.cnf] to /etc/mysql/debian.cnf
[Mon, 07 Mar 2011 14:16:45 -0800] DEBUG: Processing package[mysql-server] on vagrantup.com
[Mon, 07 Mar 2011 14:16:45 -0800] DEBUG: Checking apt-cache policy for mysql-server
[Mon, 07 Mar 2011 14:16:45 -0800] DEBUG: Current version is nil
[Mon, 07 Mar 2011 14:16:45 -0800] DEBUG: Candidate version is 5.1.41-3ubuntu12.10
[Mon, 07 Mar 2011 14:16:45 -0800] INFO: Installing package[mysql-server] version 5.1.41-3ubuntu12.10
[Mon, 07 Mar 2011 14:16:45 -0800] DEBUG: Executing apt-get -q -y install mysql-server=5.1.41-3ubuntu12.10
[Mon, 07 Mar 2011 14:18:00 -0800] DEBUG: ---- Begin output of apt-get -q -y install mysql-server=5.1.41-3ubuntu12.10 ----
[Mon, 07 Mar 2011 14:18:00 -0800] DEBUG: STDOUT: Reading package lists...
Building dependency tree...
Reading state information...
The following extra packages will be installed:
libhtml-template-perl mysql-server mysql-server-5.1 mysql-server-core-5.1
Suggested packages:
libipc-sharedcache-perl tinyca mailx
The following NEW packages will be installed:
libhtml-template-perl mysql-server mysql-server-5.1 mysql-server-core-5.1
0 upgraded, 4 newly installed, 0 to remove and 48 not upgraded.
Need to get 11.9MB of archives.
After this operation, 27.3MB of additional disk space will be used.
Get:1 http://us.archive.ubuntu.com/ubuntu/ lucid-updates/main mysql-server-core-5.1 5.1.41-3ubuntu12.10 [4,714kB]
Get:2 http://us.archive.ubuntu.com/ubuntu/ lucid-updates/main mysql-server-5.1 5.1.41-3ubuntu12.10 [7,009kB]
Get:3 http://us.archive.ubuntu.com/ubuntu/ lucid/main libhtml-template-perl 2.9-1 [65.8kB]
Get:4 http://us.archive.ubuntu.com/ubuntu/ lucid-updates/main mysql-server 5.1.41-3ubuntu12.10 [94.8kB]
Preconfiguring packages ...
Fetched 11.9MB in 18s (643kB/s)
Selecting previously deselected package mysql-server-core-5.1.
(Reading database ... 60246 files and directories currently installed.)
Unpacking mysql-server-core-5.1 (from .../mysql-server-core-5.1_5.1.41-3ubuntu12.10_i386.deb) ...
Selecting previously deselected package mysql-server-5.1.
Unpacking mysql-server-5.1 (from .../mysql-server-5.1_5.1.41-3ubuntu12.10_i386.deb) ...
Selecting previously deselected package libhtml-template-perl.
Unpacking libhtml-template-perl (from .../libhtml-template-perl_2.9-1_all.deb) ...
Selecting previously deselected package mysql-server.
Unpacking mysql-server (from .../mysql-server_5.1.41-3ubuntu12.10_all.deb) ...
Processing triggers for man-db ...
Processing triggers for ureadahead ...
ureadahead will be reprofiled on next reboot
Setting up mysql-server-core-5.1 (5.1.41-3ubuntu12.10) ...
Setting up mysql-server-5.1 (5.1.41-3ubuntu12.10) ...
Setting up libhtml-template-perl (2.9-1) ...
Setting up mysql-server (5.1.41-3ubuntu12.10) ...
Processing triggers for libc-bin ...
ldconfig deferred processing now taking place
[Mon, 07 Mar 2011 14:18:00 -0800] DEBUG: STDERR: mysql start/running, process 4404
[Mon, 07 Mar 2011 14:18:00 -0800] DEBUG: ---- End output of apt-get -q -y install mysql-server=5.1.41-3ubuntu12.10 ----
[Mon, 07 Mar 2011 14:18:00 -0800] DEBUG: Ran apt-get -q -y install mysql-server=5.1.41-3ubuntu12.10 returned 0
[Mon, 07 Mar 2011 14:18:00 -0800] DEBUG: Processing service[mysql] on vagrantup.com
[Mon, 07 Mar 2011 14:18:00 -0800] DEBUG: service[mysql] supports status, running
[Mon, 07 Mar 2011 14:18:00 -0800] DEBUG: Executing /etc/init.d/mysql status
[Mon, 07 Mar 2011 14:18:00 -0800] DEBUG: ---- Begin output of /etc/init.d/mysql status ----
[Mon, 07 Mar 2011 14:18:00 -0800] DEBUG: STDOUT: Rather than invoking init scripts through /etc/init.d, use the service(8)
utility, e.g. service mysql status
Since the script you are attempting to invoke has been converted to an
Upstart job, you may also use the status(8) utility, e.g. status mysql
mysql start/running, process 4404
[Mon, 07 Mar 2011 14:18:00 -0800] DEBUG: STDERR:
[Mon, 07 Mar 2011 14:18:00 -0800] DEBUG: ---- End output of /etc/init.d/mysql status ----
[Mon, 07 Mar 2011 14:18:00 -0800] DEBUG: Ran /etc/init.d/mysql status returned 0
[Mon, 07 Mar 2011 14:18:00 -0800] DEBUG: Doing nothing for service[mysql]
[Mon, 07 Mar 2011 14:18:00 -0800] DEBUG: Processing template[/etc/mysql/my.cnf] on vagrantup.com
[Mon, 07 Mar 2011 14:18:00 -0800] DEBUG: looking for template my.cnf.erb in cookbook "mysql"
[Mon, 07 Mar 2011 14:18:00 -0800] DEBUG: Signing the request as vagrantup.com
[Mon, 07 Mar 2011 14:18:00 -0800] DEBUG: String to sign: 'Method:GET
Hashed Path:D7Sn2DHDb4mynu2Wd1hJfq3kuWM=
X-Ops-Content-Hash:2jmj7l5rSw0yVb/vlWAYkK/YBwk=
X-Ops-Timestamp:2011-03-07T22:18:00Z
X-Ops-UserId:vagrantup.com'
Header hash: {"X-Ops-Content-Hash"=>"2jmj7l5rSw0yVb/vlWAYkK/YBwk=", "X-Ops-Authorization-1"=>"rKhW5i6nfX+jJgTtLpnJguNgIgeHPSct1k6aK4vCJHnhJhDiyZBwmgTCtOlG", "X-Ops-Userid"=>"vagrantup.com", "X-Ops-Sign"=>"version=1.0", "X-Ops-Authorization-2"=>"2TJs3RmlCYW4nMUG9FBk+nyjWLno4uzhib1sOlkHBHyfrgD2kQr3UNxJDkKl", "X-Ops-Authorization-3"=>"u8sGG6ffaiUoTzVqNSniKyaAQlV/5dKq0krnNu8MiS0iI0E598pVKmoLPc5U", "X-Ops-Authorization-4"=>"fj0JGIdyCo/LN52OKOm+48TMxOsAdBYhtRKOaYtNK2Umr7ze+kAgOxzj4+Ek", "X-Ops-Authorization-5"=>"qOK+S1j9EhhhP6leVqdC6L93auOsuFgZDN+oL+VqDcC4FDYnPh2sLNhc1NU0", "X-Ops-Authorization-6"=>"R5HmGyYAJtzTlkhR0fZkRVeJgPuRY5QI4W3WBw8J7g==", "X-Ops-Timestamp"=>"2011-03-07T22:18:00Z"}
[Mon, 07 Mar 2011 14:18:00 -0800] DEBUG: Sending HTTP Request via GET to s3.amazonaws.com:443/opscode-platform-production-data/organization-912f0dce8213412f81eafe6692f41594/checksum-b8eb33900bc343b4ad717e55dbb3587c
[Mon, 07 Mar 2011 14:18:01 -0800] DEBUG: Streaming download from https://s3.amazonaws.com/opscode-platform-production-data/organization-912f0dce8213412f81eafe6692f41594/checksum-b8eb33900bc343b4ad717e55dbb3587c?AWSAccessKeyId=AKIAJOZTD2N26S7W6APA&Expires=1299539502&Signature=B6ecmElbpVoKf%2Bn6D73SQpD92VI%3D to tempfile /tmp/chef-rest20110307-1731-10k64y1-0
[Mon, 07 Mar 2011 14:18:01 -0800] INFO: Storing updated cookbooks/mysql/templates/ubuntu-10.04/my.cnf.erb in the cache.
[Mon, 07 Mar 2011 14:18:01 -0800] DEBUG: Creating directory /var/chef/cache/cookbooks/mysql/templates/ubuntu-10.04
[Mon, 07 Mar 2011 14:18:01 -0800] DEBUG: Current content's checksum: 194dd242533b0847d10627302056f8cf646aabdbb077cf6f7e0d758e01a7f3cc
[Mon, 07 Mar 2011 14:18:01 -0800] DEBUG: Rendered content's checksum: fd4a83e2c36c0176c003d00320190423921e2403925a2dbd3bb77adfa64e395b
[Mon, 07 Mar 2011 14:18:01 -0800] INFO: Writing updated content for template[/etc/mysql/my.cnf] to /etc/mysql/my.cnf
[Mon, 07 Mar 2011 14:18:01 -0800] INFO: Backing up template[/etc/mysql/my.cnf] to /var/chef/backup/etc/mysql/my.cnf.chef-20110307141801
[Mon, 07 Mar 2011 14:18:01 -0800] DEBUG: setting mode on /tmp/chef-rendered-template20110307-1731-14hp05f-0 to 644
[Mon, 07 Mar 2011 14:18:01 -0800] INFO: template[/etc/mysql/my.cnf] sending restart action to service[mysql] (immediate)
[Mon, 07 Mar 2011 14:18:01 -0800] DEBUG: service[mysql] supports status, running
[Mon, 07 Mar 2011 14:18:01 -0800] DEBUG: Executing /etc/init.d/mysql status
[Mon, 07 Mar 2011 14:18:01 -0800] DEBUG: ---- Begin output of /etc/init.d/mysql status ----
[Mon, 07 Mar 2011 14:18:01 -0800] DEBUG: STDOUT: Rather than invoking init scripts through /etc/init.d, use the service(8)
utility, e.g. service mysql status
Since the script you are attempting to invoke has been converted to an
Upstart job, you may also use the status(8) utility, e.g. status mysql
mysql start/running, process 4404
[Mon, 07 Mar 2011 14:18:01 -0800] DEBUG: STDERR:
[Mon, 07 Mar 2011 14:18:01 -0800] DEBUG: ---- End output of /etc/init.d/mysql status ----
[Mon, 07 Mar 2011 14:18:01 -0800] DEBUG: Ran /etc/init.d/mysql status returned 0
[Mon, 07 Mar 2011 14:18:01 -0800] DEBUG: service[mysql]: attempting to restart
[Mon, 07 Mar 2011 14:18:01 -0800] DEBUG: Executing restart mysql
[Mon, 07 Mar 2011 14:18:05 -0800] DEBUG: ---- Begin output of restart mysql ----
[Mon, 07 Mar 2011 14:18:05 -0800] DEBUG: STDOUT: mysql start/running, process 4506
[Mon, 07 Mar 2011 14:18:05 -0800] DEBUG: STDERR:
[Mon, 07 Mar 2011 14:18:05 -0800] DEBUG: ---- End output of restart mysql ----
[Mon, 07 Mar 2011 14:18:05 -0800] DEBUG: Ran restart mysql returned 0
[Mon, 07 Mar 2011 14:18:05 -0800] INFO: service[mysql]: restarted successfully
[Mon, 07 Mar 2011 14:18:05 -0800] DEBUG: Processing ruby_block[save node data] on vagrantup.com
[Mon, 07 Mar 2011 14:18:05 -0800] DEBUG: Signing the request as vagrantup.com
[Mon, 07 Mar 2011 14:18:05 -0800] DEBUG: String to sign: 'Method:PUT
Hashed Path:7vwWjDr6Ei9P8y26OFDI5jURG84=
X-Ops-Content-Hash:Ykx3nvO32qrMUAFiiUJWfClWcj8=
X-Ops-Timestamp:2011-03-07T22:18:05Z
X-Ops-UserId:vagrantup.com'
Header hash: {"X-Ops-Content-Hash"=>"Ykx3nvO32qrMUAFiiUJWfClWcj8=", "X-Ops-Authorization-1"=>"lIm1iezYF6ls45nls63EDL817/5BOcS48BJfJJboIzu+Ogp5OXgPhBWUsZFc", "X-Ops-Userid"=>"vagrantup.com", "X-Ops-Sign"=>"version=1.0", "X-Ops-Authorization-2"=>"5xonlRl5cuuapOOCEnFNNIIpFPWoQvUvz81x9H1oOYKZPlm090puhkX4U2rD", "X-Ops-Authorization-3"=>"2KzB+QFQrEzzEA9g7D/2tVPRAcshZDcR0WJfwiIKWIMXT+sohGQQAUrBiB0o", "X-Ops-Authorization-4"=>"NAuTeKfH6Eg9yeHZ7nhPr5T6BKElLeZzzd2XOM8kTHJmerLQfZx1/q8kXOPJ", "X-Ops-Authorization-5"=>"mJbpK4tN0bnImMZCMnUlKJRtx176cUvbTi6As4MuNM0OCGYWNutMvBeOmOlh", "X-Ops-Authorization-6"=>"AwYINkJPdyqS6LZZ+uWUjSLeL8FefDoRQUXWjYtQYQ==", "X-Ops-Timestamp"=>"2011-03-07T22:18:05Z"}
[Mon, 07 Mar 2011 14:18:05 -0800] DEBUG: Sending HTTP Request via PUT to api.opscode.com:443/organizations/libersy/nodes/vagrantup.com
[Mon, 07 Mar 2011 14:18:07 -0800] DEBUG: Processing template[/etc/mysql/grants.sql] on vagrantup.com
[Mon, 07 Mar 2011 14:18:07 -0800] DEBUG: looking for template grants.sql.erb in cookbook "mysql"
[Mon, 07 Mar 2011 14:18:07 -0800] DEBUG: Signing the request as vagrantup.com
[Mon, 07 Mar 2011 14:18:08 -0800] DEBUG: String to sign: 'Method:GET
Hashed Path:eZZeiDBfN2Hi0m4FEthlricOAZc=
X-Ops-Content-Hash:2jmj7l5rSw0yVb/vlWAYkK/YBwk=
X-Ops-Timestamp:2011-03-07T22:18:08Z
X-Ops-UserId:vagrantup.com'
Header hash: {"X-Ops-Content-Hash"=>"2jmj7l5rSw0yVb/vlWAYkK/YBwk=", "X-Ops-Authorization-1"=>"Gsf5KsXp9xQ+/G5gmMKGt1XMgSDoVNp5sJmtQz4AXweun8ihVCK5pUfGgiI+", "X-Ops-Userid"=>"vagrantup.com", "X-Ops-Sign"=>"version=1.0", "X-Ops-Authorization-2"=>"kMJG/GrW2MWRBhguZxqynJ0nTa1OIJTKWOCsJzwocZcQ6ygkiA4Ws8EOOM3X", "X-Ops-Authorization-3"=>"SDsDONiD6/wN6NmB0k+QgsRjhllbrR7OlOiUIYPwIieva1xuiLqfNyO4LLcn", "X-Ops-Authorization-4"=>"kRCyDUlM6j0FINpPDyfoE4u3nwJsNGWDLOXGkewIOP/gbff6hSiRV6SfguF9", "X-Ops-Authorization-5"=>"P/VtxFJjgLGYp1jgg15xPl5MrQzy80R+eFXuCaAA/eTJR/yn5Y2UdLGgi3G6", "X-Ops-Authorization-6"=>"AKK/UvEgPhaE5aqnCyH0WZFIWdTyGwW8CNyW30mPsw==", "X-Ops-Timestamp"=>"2011-03-07T22:18:08Z"}
[Mon, 07 Mar 2011 14:18:08 -0800] DEBUG: Sending HTTP Request via GET to s3.amazonaws.com:443/opscode-platform-production-data/organization-912f0dce8213412f81eafe6692f41594/checksum-4f635779e426d91a0b481f5eedc62e83
[Mon, 07 Mar 2011 14:18:08 -0800] DEBUG: Streaming download from https://s3.amazonaws.com/opscode-platform-production-data/organization-912f0dce8213412f81eafe6692f41594/checksum-4f635779e426d91a0b481f5eedc62e83?AWSAccessKeyId=AKIAJOZTD2N26S7W6APA&Expires=1299539502&Signature=9lJw5n99AREoYJbkXPv6Ndyx8Is%3D to tempfile /tmp/chef-rest20110307-1731-1gb9ej5-0
[Mon, 07 Mar 2011 14:18:08 -0800] INFO: Storing updated cookbooks/mysql/templates/default/grants.sql.erb in the cache.
[Mon, 07 Mar 2011 14:18:08 -0800] DEBUG: Current content's checksum:
[Mon, 07 Mar 2011 14:18:08 -0800] DEBUG: Rendered content's checksum: 18f66a8c8baec6917619b4f8e94fe91ea366bb316a8104e4d64a2013b7c9af21
[Mon, 07 Mar 2011 14:18:08 -0800] INFO: Writing updated content for template[/etc/mysql/grants.sql] to /etc/mysql/grants.sql
[Mon, 07 Mar 2011 14:18:08 -0800] INFO: template[/etc/mysql/grants.sql] sending run action to execute[mysql-install-privileges] (immediate)
[Mon, 07 Mar 2011 14:18:08 -0800] DEBUG: Executing /usr/bin/mysql -u root -pmysql_root < /etc/mysql/grants.sql
[Mon, 07 Mar 2011 14:18:08 -0800] DEBUG: ---- Begin output of /usr/bin/mysql -u root -pmysql_root < /etc/mysql/grants.sql ----
[Mon, 07 Mar 2011 14:18:08 -0800] DEBUG: STDOUT:
[Mon, 07 Mar 2011 14:18:08 -0800] DEBUG: STDERR:
[Mon, 07 Mar 2011 14:18:08 -0800] DEBUG: ---- End output of /usr/bin/mysql -u root -pmysql_root < /etc/mysql/grants.sql ----
[Mon, 07 Mar 2011 14:18:08 -0800] DEBUG: Ran /usr/bin/mysql -u root -pmysql_root < /etc/mysql/grants.sql returned 0
[Mon, 07 Mar 2011 14:18:08 -0800] INFO: Ran execute[mysql-install-privileges] successfully
[Mon, 07 Mar 2011 14:18:08 -0800] DEBUG: Processing execute[mysql-install-privileges] on vagrantup.com
[Mon, 07 Mar 2011 14:18:08 -0800] DEBUG: Doing nothing for execute[mysql-install-privileges]
[Mon, 07 Mar 2011 14:18:08 -0800] DEBUG: Processing template[/etc/mysql/app_grants.sql] on vagrantup.com
[Mon, 07 Mar 2011 14:18:08 -0800] DEBUG: looking for template app_grants.sql.erb in cookbook "database"
[Mon, 07 Mar 2011 14:18:08 -0800] DEBUG: Signing the request as vagrantup.com
[Mon, 07 Mar 2011 14:18:08 -0800] DEBUG: String to sign: 'Method:GET
Hashed Path:W8tsCl/vehnv2w629yvpSMi1ZUA=
X-Ops-Content-Hash:2jmj7l5rSw0yVb/vlWAYkK/YBwk=
X-Ops-Timestamp:2011-03-07T22:18:08Z
X-Ops-UserId:vagrantup.com'
Header hash: {"X-Ops-Content-Hash"=>"2jmj7l5rSw0yVb/vlWAYkK/YBwk=", "X-Ops-Authorization-1"=>"RphrWYfmWOfLrWxGedUvJ68EmQMW33iobudS19jeMN5FNCTS9ZoPy+vXQgtq", "X-Ops-Userid"=>"vagrantup.com", "X-Ops-Sign"=>"version=1.0", "X-Ops-Authorization-2"=>"kJTTsa2+IFcz+85ARFAOebK0p0UKhkwDd4Od+j4HcTtEGFZtim/CC4Pelpff", "X-Ops-Authorization-3"=>"FWMzlHGL/C2gHOl2LAoeMvcHVC6J+qKdjCPsXSiqJTPr+wkv/6UehXz2AmxY", "X-Ops-Authorization-4"=>"Pi4LBWDVoYirkPCIwLTNQLQlS1RspPdSsF85dN0IlF6Kl+AzZDz3a9yKohlG", "X-Ops-Authorization-5"=>"5Qs4UdWarNIsta9HrDVwFJadAwKaXt+90S8ZO0lY0s+RRfbRkMSKmnAoXKTM", "X-Ops-Authorization-6"=>"yNlHg/IwE4LHO/PLsBOoxFWJ2w2R5DaONXgFTIW6Vg==", "X-Ops-Timestamp"=>"2011-03-07T22:18:08Z"}
[Mon, 07 Mar 2011 14:18:08 -0800] DEBUG: Sending HTTP Request via GET to s3.amazonaws.com:443/opscode-platform-production-data/organization-912f0dce8213412f81eafe6692f41594/checksum-6ffb08a0c0742c421ddb99e62862ef06
[Mon, 07 Mar 2011 14:18:09 -0800] DEBUG: Streaming download from https://s3.amazonaws.com/opscode-platform-production-data/organization-912f0dce8213412f81eafe6692f41594/checksum-6ffb08a0c0742c421ddb99e62862ef06?AWSAccessKeyId=AKIAJOZTD2N26S7W6APA&Expires=1299539502&Signature=V90WcZF33ku6JUStkgCOFfb5adY%3D to tempfile /tmp/chef-rest20110307-1731-1ys7jhs-0
[Mon, 07 Mar 2011 14:18:09 -0800] INFO: Storing updated cookbooks/database/templates/default/app_grants.sql.erb in the cache.
[Mon, 07 Mar 2011 14:18:09 -0800] DEBUG: Creating directory /var/chef/cache/cookbooks/database/templates
[Mon, 07 Mar 2011 14:18:09 -0800] DEBUG: Creating directory /var/chef/cache/cookbooks/database/templates/default
[Mon, 07 Mar 2011 14:18:09 -0800] DEBUG: Current content's checksum:
[Mon, 07 Mar 2011 14:18:09 -0800] DEBUG: Rendered content's checksum: ba5b1dc79902a6af14f7cbfb9ddd0cd914e2613b101db434b474b5e95bd79f77
[Mon, 07 Mar 2011 14:18:09 -0800] INFO: Writing updated content for template[/etc/mysql/app_grants.sql] to /etc/mysql/app_grants.sql
[Mon, 07 Mar 2011 14:18:09 -0800] INFO: template[/etc/mysql/app_grants.sql] sending run action to execute[mysql-install-application-privileges] (immediate)
[Mon, 07 Mar 2011 14:18:09 -0800] DEBUG: Executing /usr/bin/mysql -u root -pmysql_root < /etc/mysql/app_grants.sql
[Mon, 07 Mar 2011 14:18:09 -0800] DEBUG: ---- Begin output of /usr/bin/mysql -u root -pmysql_root < /etc/mysql/app_grants.sql ----
[Mon, 07 Mar 2011 14:18:09 -0800] DEBUG: STDOUT:
[Mon, 07 Mar 2011 14:18:09 -0800] DEBUG: STDERR:
[Mon, 07 Mar 2011 14:18:09 -0800] DEBUG: ---- End output of /usr/bin/mysql -u root -pmysql_root < /etc/mysql/app_grants.sql ----
[Mon, 07 Mar 2011 14:18:09 -0800] DEBUG: Ran /usr/bin/mysql -u root -pmysql_root < /etc/mysql/app_grants.sql returned 0
[Mon, 07 Mar 2011 14:18:09 -0800] INFO: Ran execute[mysql-install-application-privileges] successfully
[Mon, 07 Mar 2011 14:18:09 -0800] DEBUG: Processing execute[mysql-install-application-privileges] on vagrantup.com
[Mon, 07 Mar 2011 14:18:09 -0800] DEBUG: Doing nothing for execute[mysql-install-application-privileges]
[Mon, 07 Mar 2011 14:18:09 -0800] DEBUG: Processing execute[db_bootstrap] on vagrantup.com
[Mon, 07 Mar 2011 14:18:09 -0800] DEBUG: Executing yes | rake production db:bootstrap ADMIN_NAME=Administrator ADMIN_USERNAME=admin ADMIN_PASSWORD=radiant DATABASE_TEMPLATE=empty.yml
[Mon, 07 Mar 2011 14:18:09 -0800] ERROR: execute[db_bootstrap] (/var/chef/cache/cookbooks/radiant/recipes/db_bootstrap.rb:44:in `from_file') had an error:
/srv/radiant/current does not exist or is not a directory
/usr/lib/ruby/gems/1.8/gems/chef-0.9.14/bin/../lib/chef/mixin/command.rb:146:in `output_of_command'
/usr/lib/ruby/gems/1.8/gems/chef-0.9.14/bin/../lib/chef/mixin/command.rb:128:in `run_command'
/usr/lib/ruby/gems/1.8/gems/chef-0.9.14/bin/../lib/chef/provider/execute.rb:49:in `action_run'
/usr/lib/ruby/gems/1.8/gems/chef-0.9.14/bin/../lib/chef/resource.rb:395:in `send'
/usr/lib/ruby/gems/1.8/gems/chef-0.9.14/bin/../lib/chef/resource.rb:395:in `run_action'
/usr/lib/ruby/gems/1.8/gems/chef-0.9.14/bin/../lib/chef/runner.rb:53:in `run_action'
/usr/lib/ruby/gems/1.8/gems/chef-0.9.14/bin/../lib/chef/runner.rb:89:in `converge'
/usr/lib/ruby/gems/1.8/gems/chef-0.9.14/bin/../lib/chef/runner.rb:89:in `each'
/usr/lib/ruby/gems/1.8/gems/chef-0.9.14/bin/../lib/chef/runner.rb:89:in `converge'
/usr/lib/ruby/gems/1.8/gems/chef-0.9.14/bin/../lib/chef/resource_collection.rb:94
/usr/lib/ruby/gems/1.8/gems/chef-0.9.14/bin/../lib/chef/resource_collection/stepable_iterator.rb:116:in `call'
/usr/lib/ruby/gems/1.8/gems/chef-0.9.14/bin/../lib/chef/resource_collection/stepable_iterator.rb:116:in `call_iterator_block'
/usr/lib/ruby/gems/1.8/gems/chef-0.9.14/bin/../lib/chef/resource_collection/stepable_iterator.rb:85:in `step'
/usr/lib/ruby/gems/1.8/gems/chef-0.9.14/bin/../lib/chef/resource_collection/stepable_iterator.rb:104:in `iterate'
/usr/lib/ruby/gems/1.8/gems/chef-0.9.14/bin/../lib/chef/resource_collection/stepable_iterator.rb:55:in `each_with_index'
/usr/lib/ruby/gems/1.8/gems/chef-0.9.14/bin/../lib/chef/resource_collection.rb:92:in `execute_each_resource'
/usr/lib/ruby/gems/1.8/gems/chef-0.9.14/bin/../lib/chef/runner.rb:84:in `converge'
/usr/lib/ruby/gems/1.8/gems/chef-0.9.14/bin/../lib/chef/client.rb:268:in `converge'
/usr/lib/ruby/gems/1.8/gems/chef-0.9.14/bin/../lib/chef/client.rb:171:in `run'
/usr/lib/ruby/gems/1.8/gems/chef-0.9.14/bin/../lib/chef/application/client.rb:222:in `run_application'
/usr/lib/ruby/gems/1.8/gems/chef-0.9.14/bin/../lib/chef/application/client.rb:212:in `loop'
/usr/lib/ruby/gems/1.8/gems/chef-0.9.14/bin/../lib/chef/application/client.rb:212:in `run_application'
/usr/lib/ruby/gems/1.8/gems/chef-0.9.14/bin/../lib/chef/application.rb:62:in `run'
/usr/lib/ruby/gems/1.8/gems/chef-0.9.14/bin/chef-client:26
/usr/bin/chef-client:19:in `load'
/usr/bin/chef-client:19
[Mon, 07 Mar 2011 14:18:09 -0800] DEBUG: Processing file[/srv/radiant/current/tmp/radiant_config_cache.txt] on vagrantup.com
[Mon, 07 Mar 2011 14:18:09 -0800] INFO: Creating file[/srv/radiant/current/tmp/radiant_config_cache.txt] at /srv/radiant/current/tmp/radiant_config_cache.txt
[Mon, 07 Mar 2011 14:18:09 -0800] ERROR: file[/srv/radiant/current/tmp/radiant_config_cache.txt] (/var/chef/cache/cookbooks/radiant/recipes/db_bootstrap.rb:52:in `from_file') had an error:
No such file or directory - /srv/radiant/current/tmp/radiant_config_cache.txt
/usr/lib/ruby/gems/1.8/gems/chef-0.9.14/bin/../lib/chef/provider/file.rb:142:in `initialize'
/usr/lib/ruby/gems/1.8/gems/chef-0.9.14/bin/../lib/chef/provider/file.rb:142:in `open'
/usr/lib/ruby/gems/1.8/gems/chef-0.9.14/bin/../lib/chef/provider/file.rb:142:in `action_create'
/usr/lib/ruby/gems/1.8/gems/chef-0.9.14/bin/../lib/chef/resource.rb:395:in `send'
/usr/lib/ruby/gems/1.8/gems/chef-0.9.14/bin/../lib/chef/resource.rb:395:in `run_action'
/usr/lib/ruby/gems/1.8/gems/chef-0.9.14/bin/../lib/chef/runner.rb:53:in `run_action'
/usr/lib/ruby/gems/1.8/gems/chef-0.9.14/bin/../lib/chef/runner.rb:89:in `converge'
/usr/lib/ruby/gems/1.8/gems/chef-0.9.14/bin/../lib/chef/runner.rb:89:in `each'
/usr/lib/ruby/gems/1.8/gems/chef-0.9.14/bin/../lib/chef/runner.rb:89:in `converge'
/usr/lib/ruby/gems/1.8/gems/chef-0.9.14/bin/../lib/chef/resource_collection.rb:94
/usr/lib/ruby/gems/1.8/gems/chef-0.9.14/bin/../lib/chef/resource_collection/stepable_iterator.rb:116:in `call'
/usr/lib/ruby/gems/1.8/gems/chef-0.9.14/bin/../lib/chef/resource_collection/stepable_iterator.rb:116:in `call_iterator_block'
/usr/lib/ruby/gems/1.8/gems/chef-0.9.14/bin/../lib/chef/resource_collection/stepable_iterator.rb:85:in `step'
/usr/lib/ruby/gems/1.8/gems/chef-0.9.14/bin/../lib/chef/resource_collection/stepable_iterator.rb:104:in `iterate'
/usr/lib/ruby/gems/1.8/gems/chef-0.9.14/bin/../lib/chef/resource_collection/stepable_iterator.rb:55:in `each_with_index'
/usr/lib/ruby/gems/1.8/gems/chef-0.9.14/bin/../lib/chef/resource_collection.rb:92:in `execute_each_resource'
/usr/lib/ruby/gems/1.8/gems/chef-0.9.14/bin/../lib/chef/runner.rb:84:in `converge'
/usr/lib/ruby/gems/1.8/gems/chef-0.9.14/bin/../lib/chef/client.rb:268:in `converge'
/usr/lib/ruby/gems/1.8/gems/chef-0.9.14/bin/../lib/chef/client.rb:171:in `run'
/usr/lib/ruby/gems/1.8/gems/chef-0.9.14/bin/../lib/chef/application/client.rb:222:in `run_application'
/usr/lib/ruby/gems/1.8/gems/chef-0.9.14/bin/../lib/chef/application/client.rb:212:in `loop'
/usr/lib/ruby/gems/1.8/gems/chef-0.9.14/bin/../lib/chef/application/client.rb:212:in `run_application'
/usr/lib/ruby/gems/1.8/gems/chef-0.9.14/bin/../lib/chef/application.rb:62:in `run'
/usr/lib/ruby/gems/1.8/gems/chef-0.9.14/bin/chef-client:26
/usr/bin/chef-client:19:in `load'
/usr/bin/chef-client:19
[Mon, 07 Mar 2011 14:18:09 -0800] ERROR: Running exception handlers
[Mon, 07 Mar 2011 14:18:09 -0800] ERROR: Exception handlers complete
[Mon, 07 Mar 2011 14:18:09 -0800] DEBUG: Re-raising exception: Errno::ENOENT - No such file or directory - /srv/radiant/current/tmp/radiant_config_cache.txt
/usr/lib/ruby/gems/1.8/gems/chef-0.9.14/bin/../lib/chef/provider/file.rb:142:in `initialize'
/usr/lib/ruby/gems/1.8/gems/chef-0.9.14/bin/../lib/chef/provider/file.rb:142:in `open'
/usr/lib/ruby/gems/1.8/gems/chef-0.9.14/bin/../lib/chef/provider/file.rb:142:in `action_create'
/usr/lib/ruby/gems/1.8/gems/chef-0.9.14/bin/../lib/chef/resource.rb:395:in `send'
/usr/lib/ruby/gems/1.8/gems/chef-0.9.14/bin/../lib/chef/resource.rb:395:in `run_action'
/usr/lib/ruby/gems/1.8/gems/chef-0.9.14/bin/../lib/chef/runner.rb:53:in `run_action'
/usr/lib/ruby/gems/1.8/gems/chef-0.9.14/bin/../lib/chef/runner.rb:89:in `converge'
/usr/lib/ruby/gems/1.8/gems/chef-0.9.14/bin/../lib/chef/runner.rb:89:in `each'
/usr/lib/ruby/gems/1.8/gems/chef-0.9.14/bin/../lib/chef/runner.rb:89:in `converge'
/usr/lib/ruby/gems/1.8/gems/chef-0.9.14/bin/../lib/chef/resource_collection.rb:94
/usr/lib/ruby/gems/1.8/gems/chef-0.9.14/bin/../lib/chef/resource_collection/stepable_iterator.rb:116:in `call'
/usr/lib/ruby/gems/1.8/gems/chef-0.9.14/bin/../lib/chef/resource_collection/stepable_iterator.rb:116:in `call_iterator_block'
/usr/lib/ruby/gems/1.8/gems/chef-0.9.14/bin/../lib/chef/resource_collection/stepable_iterator.rb:85:in `step'
/usr/lib/ruby/gems/1.8/gems/chef-0.9.14/bin/../lib/chef/resource_collection/stepable_iterator.rb:104:in `iterate'
/usr/lib/ruby/gems/1.8/gems/chef-0.9.14/bin/../lib/chef/resource_collection/stepable_iterator.rb:55:in `each_with_index'
/usr/lib/ruby/gems/1.8/gems/chef-0.9.14/bin/../lib/chef/resource_collection.rb:92:in `execute_each_resource'
/usr/lib/ruby/gems/1.8/gems/chef-0.9.14/bin/../lib/chef/runner.rb:84:in `converge'
/usr/lib/ruby/gems/1.8/gems/chef-0.9.14/bin/../lib/chef/client.rb:268:in `converge'
/usr/lib/ruby/gems/1.8/gems/chef-0.9.14/bin/../lib/chef/client.rb:171:in `run'
/usr/lib/ruby/gems/1.8/gems/chef-0.9.14/bin/../lib/chef/application/client.rb:222:in `run_application'
/usr/lib/ruby/gems/1.8/gems/chef-0.9.14/bin/../lib/chef/application/client.rb:212:in `loop'
/usr/lib/ruby/gems/1.8/gems/chef-0.9.14/bin/../lib/chef/application/client.rb:212:in `run_application'
/usr/lib/ruby/gems/1.8/gems/chef-0.9.14/bin/../lib/chef/application.rb:62:in `run'
/usr/lib/ruby/gems/1.8/gems/chef-0.9.14/bin/chef-client:26
/usr/bin/chef-client:19:in `load'
/usr/bin/chef-client:19
/usr/lib/ruby/gems/1.8/gems/chef-0.9.14/bin/../lib/chef/provider/file.rb:142:in `initialize': No such file or directory - /srv/radiant/current/tmp/radiant_config_cache.txt (Errno::ENOENT)
from /usr/lib/ruby/gems/1.8/gems/chef-0.9.14/bin/../lib/chef/provider/file.rb:142:in `open'
from /usr/lib/ruby/gems/1.8/gems/chef-0.9.14/bin/../lib/chef/provider/file.rb:142:in `action_create'
from /usr/lib/ruby/gems/1.8/gems/chef-0.9.14/bin/../lib/chef/resource.rb:395:in `send'
from /usr/lib/ruby/gems/1.8/gems/chef-0.9.14/bin/../lib/chef/resource.rb:395:in `run_action'
from /usr/lib/ruby/gems/1.8/gems/chef-0.9.14/bin/../lib/chef/runner.rb:53:in `run_action'
from /usr/lib/ruby/gems/1.8/gems/chef-0.9.14/bin/../lib/chef/runner.rb:89:in `converge'
from /usr/lib/ruby/gems/1.8/gems/chef-0.9.14/bin/../lib/chef/runner.rb:89:in `each'
from /usr/lib/ruby/gems/1.8/gems/chef-0.9.14/bin/../lib/chef/runner.rb:89:in `converge'
from /usr/lib/ruby/gems/1.8/gems/chef-0.9.14/bin/../lib/chef/resource_collection.rb:94
from /usr/lib/ruby/gems/1.8/gems/chef-0.9.14/bin/../lib/chef/resource_collection/stepable_iterator.rb:116:in `call'
from /usr/lib/ruby/gems/1.8/gems/chef-0.9.14/bin/../lib/chef/resource_collection/stepable_iterator.rb:116:in `call_iterator_block'
from /usr/lib/ruby/gems/1.8/gems/chef-0.9.14/bin/../lib/chef/resource_collection/stepable_iterator.rb:85:in `step'
from /usr/lib/ruby/gems/1.8/gems/chef-0.9.14/bin/../lib/chef/resource_collection/stepable_iterator.rb:104:in `iterate'
from /usr/lib/ruby/gems/1.8/gems/chef-0.9.14/bin/../lib/chef/resource_collection/stepable_iterator.rb:55:in `each_with_index'
from /usr/lib/ruby/gems/1.8/gems/chef-0.9.14/bin/../lib/chef/resource_collection.rb:92:in `execute_each_resource'
from /usr/lib/ruby/gems/1.8/gems/chef-0.9.14/bin/../lib/chef/runner.rb:84:in `converge'
from /usr/lib/ruby/gems/1.8/gems/chef-0.9.14/bin/../lib/chef/client.rb:268:in `converge'
from /usr/lib/ruby/gems/1.8/gems/chef-0.9.14/bin/../lib/chef/client.rb:171:in `run'
from /usr/lib/ruby/gems/1.8/gems/chef-0.9.14/bin/../lib/chef/application/client.rb:222:in `run_application'
from /usr/lib/ruby/gems/1.8/gems/chef-0.9.14/bin/../lib/chef/application/client.rb:212:in `loop'
from /usr/lib/ruby/gems/1.8/gems/chef-0.9.14/bin/../lib/chef/application/client.rb:212:in `run_application'
from /usr/lib/ruby/gems/1.8/gems/chef-0.9.14/bin/../lib/chef/application.rb:62:in `run'
from /usr/lib/ruby/gems/1.8/gems/chef-0.9.14/bin/chef-client:26
from /usr/bin/chef-client:19:in `load'
from /usr/bin/chef-client:19
vagrant@vagrantup:~$
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment