Closed ericclemmons closed 11 years ago
Eric@eric-mbp:~/Sites/ericclemmons/wordpress-skeleton [master>]$ vagrant up [default] VM already created. Booting if it's not already running... [default] Clearing any previously set forwarded ports... [default] Fixed port collision for 22 => 2222. Now on port 2200. [default] Forwarding ports... [default] -- 22 => 2200 (adapter 1) [default] Exporting NFS shared folders... [vagrant] Preparing to edit /etc/exports. Administrator privileges will be required... [default] Creating shared folders metadata... [default] Clearing any previously set network interfaces... [default] Preparing network interfaces based on configuration... [default] Booting VM... [default] Waiting for VM to boot. This can take a few minutes. [default] VM booted and ready for use! [default] Configuring and enabling network interfaces... [default] Setting host name... [default] Mounting shared folders... [default] -- v-csc-1: /tmp/vagrant-chef-1/chef-solo-1/cookbooks [default] -- v-csc-2: /tmp/vagrant-chef-1/chef-solo-2/cookbooks [default] Mounting NFS shared folders... [vagrant] Updating host entry for default VM. Administrator privileges will be required... [default] Running provisioner: Vagrant::Provisioners::ChefSolo... [default] Generating chef JSON and uploading... [default] Running chef-solo... stdin: is not a tty [Tue, 18 Sep 2012 16:06:22 +0200] INFO: *** Chef 0.10.10 *** [Tue, 18 Sep 2012 16:06:23 +0200] INFO: Setting the run_list to ["recipe[wordpress-skeleton]"] from JSON [Tue, 18 Sep 2012 16:06:23 +0200] INFO: Run List is [recipe[wordpress-skeleton]] [Tue, 18 Sep 2012 16:06:23 +0200] INFO: Run List expands to [wordpress-skeleton] [Tue, 18 Sep 2012 16:06:23 +0200] INFO: Starting Chef Run for develop.wordpress-skeleton.com [Tue, 18 Sep 2012 16:06:23 +0200] INFO: Running start handlers [Tue, 18 Sep 2012 16:06:23 +0200] INFO: Start handlers complete. [Tue, 18 Sep 2012 16:06:23 +0200] INFO: Could not find previously defined grants.sql resource [Tue, 18 Sep 2012 16:06:23 +0200] INFO: Processing execute[apt-get-update] action run (apt::default line 22) [Tue, 18 Sep 2012 16:06:23 +0200] INFO: Processing execute[apt-get update] action nothing (apt::default line 29) [Tue, 18 Sep 2012 16:06:23 +0200] INFO: Processing package[update-notifier-common] action install (apt::default line 36) [Tue, 18 Sep 2012 16:06:23 +0200] INFO: Processing execute[apt-get-update-periodic] action run (apt::default line 40) [Tue, 18 Sep 2012 16:06:29 +0200] INFO: execute[apt-get-update-periodic] ran successfully [Tue, 18 Sep 2012 16:06:29 +0200] INFO: Processing directory[/var/cache/local] action create (apt::default line 50) [Tue, 18 Sep 2012 16:06:29 +0200] INFO: Processing directory[/var/cache/local/preseeding] action create (apt::default line 50) [Tue, 18 Sep 2012 16:06:29 +0200] INFO: directory[/var/cache/local/preseeding] mode changed to 644 [Tue, 18 Sep 2012 16:06:29 +0200] INFO: Processing package[apache2] action install (apache2::default line 20) [Tue, 18 Sep 2012 16:06:29 +0200] INFO: Processing service[apache2] action enable (apache2::default line 25) [Tue, 18 Sep 2012 16:06:29 +0200] INFO: Processing directory[/etc/apache2/ssl] action create (apache2::default line 138) [Tue, 18 Sep 2012 16:06:29 +0200] INFO: Processing directory[/etc/apache2/conf.d] action create (apache2::default line 145) [Tue, 18 Sep 2012 16:06:29 +0200] INFO: Processing directory[/var/cache/apache2] action create (apache2::default line 152) [Tue, 18 Sep 2012 16:06:29 +0200] INFO: Processing template[apache2.conf] action create (apache2::default line 159) [Tue, 18 Sep 2012 16:06:30 +0200] INFO: Processing template[security] action create (apache2::default line 175) [Tue, 18 Sep 2012 16:06:30 +0200] INFO: Processing template[charset] action create (apache2::default line 185) [Tue, 18 Sep 2012 16:06:30 +0200] INFO: Processing template[/etc/apache2/ports.conf] action create (apache2::default line 195) [Tue, 18 Sep 2012 16:06:30 +0200] INFO: Processing template[/etc/apache2/sites-available/default] action create (apache2::default line 204) [Tue, 18 Sep 2012 16:06:30 +0200] INFO: Processing template[/etc/apache2/mods-available/status.conf] action create (apache2::mod_status line 21) [Tue, 18 Sep 2012 16:06:30 +0200] INFO: Processing execute[a2enmod status] action run (apache2::mod_status line 38) [Tue, 18 Sep 2012 16:06:30 +0200] INFO: Processing template[/etc/apache2/mods-available/alias.conf] action create (apache2::mod_alias line 21) [Tue, 18 Sep 2012 16:06:30 +0200] INFO: Processing execute[a2enmod alias] action run (apache2::mod_alias line 38) [Tue, 18 Sep 2012 16:06:30 +0200] INFO: Processing execute[a2enmod auth_basic] action run (apache2::mod_auth_basic line 38) [Tue, 18 Sep 2012 16:06:30 +0200] INFO: Processing execute[a2enmod authn_file] action run (apache2::mod_authn_file line 38) [Tue, 18 Sep 2012 16:06:30 +0200] INFO: Processing execute[a2enmod authz_default] action run (apache2::mod_authz_default line 38) [Tue, 18 Sep 2012 16:06:30 +0200] INFO: Processing execute[a2enmod authz_groupfile] action run (apache2::mod_authz_groupfile line 38) [Tue, 18 Sep 2012 16:06:30 +0200] INFO: Processing execute[a2enmod authz_host] action run (apache2::mod_authz_host line 38) [Tue, 18 Sep 2012 16:06:30 +0200] INFO: Processing execute[a2enmod authz_user] action run (apache2::mod_authz_user line 38) [Tue, 18 Sep 2012 16:06:30 +0200] INFO: Processing template[/etc/apache2/mods-available/autoindex.conf] action create (apache2::mod_autoindex line 21) [Tue, 18 Sep 2012 16:06:30 +0200] INFO: Processing execute[a2enmod autoindex] action run (apache2::mod_autoindex line 38) [Tue, 18 Sep 2012 16:06:30 +0200] INFO: Processing template[/etc/apache2/mods-available/dir.conf] action create (apache2::mod_dir line 21) [Tue, 18 Sep 2012 16:06:30 +0200] INFO: Processing execute[a2enmod dir] action run (apache2::mod_dir line 38) [Tue, 18 Sep 2012 16:06:30 +0200] INFO: Processing execute[a2enmod env] action run (apache2::mod_env line 38) [Tue, 18 Sep 2012 16:06:30 +0200] INFO: Processing template[/etc/apache2/mods-available/mime.conf] action create (apache2::mod_mime line 21) [Tue, 18 Sep 2012 16:06:30 +0200] INFO: Processing execute[a2enmod mime] action run (apache2::mod_mime line 38) [Tue, 18 Sep 2012 16:06:30 +0200] INFO: Processing template[/etc/apache2/mods-available/negotiation.conf] action create (apache2::mod_negotiation line 21) [Tue, 18 Sep 2012 16:06:30 +0200] INFO: Processing execute[a2enmod negotiation] action run (apache2::mod_negotiation line 38) [Tue, 18 Sep 2012 16:06:30 +0200] INFO: Processing template[/etc/apache2/mods-available/setenvif.conf] action create (apache2::mod_setenvif line 21) [Tue, 18 Sep 2012 16:06:30 +0200] INFO: Processing execute[a2enmod setenvif] action run (apache2::mod_setenvif line 38) [Tue, 18 Sep 2012 16:06:30 +0200] INFO: Processing service[apache2] action start (apache2::default line 219) [Tue, 18 Sep 2012 16:06:30 +0200] INFO: Processing package[mysql-client] action install (mysql::client line 46) [Tue, 18 Sep 2012 16:06:30 +0200] INFO: Processing package[libmysqlclient-dev] action install (mysql::client line 46) [Tue, 18 Sep 2012 16:06:30 +0200] INFO: Processing directory[/var/cache/local/preseeding] action create (mysql::server line 31) [Tue, 18 Sep 2012 16:06:30 +0200] INFO: directory[/var/cache/local/preseeding] mode changed to 755 [Tue, 18 Sep 2012 16:06:30 +0200] INFO: Processing execute[preseed mysql-server] action nothing (mysql::server line 38) [Tue, 18 Sep 2012 16:06:30 +0200] INFO: Processing template[/var/cache/local/preseeding/mysql-server.seed] action create (mysql::server line 43) [Tue, 18 Sep 2012 16:06:30 +0200] INFO: Processing template[/etc/mysql/debian.cnf] action create (mysql::server line 51) [Tue, 18 Sep 2012 16:06:30 +0200] INFO: template[/etc/mysql/debian.cnf] backed up to /var/chef/backup/etc/mysql/debian.cnf.chef-20120918160630 [Tue, 18 Sep 2012 16:06:30 +0200] INFO: template[/etc/mysql/debian.cnf] updated content [Tue, 18 Sep 2012 16:06:30 +0200] INFO: Processing package[mysql-server] action install (mysql::server line 78) [Tue, 18 Sep 2012 16:06:30 +0200] INFO: Processing directory[/etc/mysql/conf.d] action create (mysql::server line 85) [Tue, 18 Sep 2012 16:06:30 +0200] INFO: Processing service[mysql] action nothing (mysql::server line 105) [Tue, 18 Sep 2012 16:06:30 +0200] INFO: Processing template[/etc/mysql/my.cnf] action create (mysql::server line 125) [Tue, 18 Sep 2012 16:06:30 +0200] INFO: Processing template[/etc/mysql/grants.sql] action create (mysql::server line 179) [Tue, 18 Sep 2012 16:06:30 +0200] INFO: template[/etc/mysql/grants.sql] backed up to /var/chef/backup/etc/mysql/grants.sql.chef-20120918160630 [Tue, 18 Sep 2012 16:06:30 +0200] INFO: template[/etc/mysql/grants.sql] updated content [Tue, 18 Sep 2012 16:06:30 +0200] INFO: template[/etc/mysql/grants.sql] sending run action to execute[mysql-install-privileges] (immediate) [Tue, 18 Sep 2012 16:06:30 +0200] INFO: Processing execute[mysql-install-privileges] action run (mysql::server line 195) [Tue, 18 Sep 2012 16:06:30 +0200] ERROR: execute[mysql-install-privileges] (mysql::server line 195) has had an error [Tue, 18 Sep 2012 16:06:30 +0200] ERROR: template[/etc/mysql/grants.sql] (/tmp/vagrant-chef-1/chef-solo-2/cookbooks/mysql/recipes/server.rb:179:in `from_file') had an error: execute[mysql-install-privileges] (mysql::server line 195) had an error: Mixlib::ShellOut::ShellCommandFailed: Expected process to exit with [0], but received '1' ---- Begin output of "/usr/bin/mysql" -u root -p"vagrant" < "/etc/mysql/grants.sql" ---- STDOUT: STDERR: ERROR 2002 (HY000): Can't connect to local MySQL server through socket '/var/run/mysqld/mysqld.sock' (2) ---- End output of "/usr/bin/mysql" -u root -p"vagrant" < "/etc/mysql/grants.sql" ---- Ran "/usr/bin/mysql" -u root -p"vagrant" < "/etc/mysql/grants.sql" returned 1 /opt/vagrant_ruby/lib/ruby/gems/1.8/gems/mixlib-shellout-1.0.0.rc.1/lib/mixlib/shellout.rb:242:in `invalid!' /opt/vagrant_ruby/lib/ruby/gems/1.8/gems/mixlib-shellout-1.0.0.rc.1/lib/mixlib/shellout.rb:228:in `error!' /opt/vagrant_ruby/lib/ruby/gems/1.8/gems/chef-0.10.10/bin/../lib/chef/mixin/shell_out.rb:36:in `shell_out!' /opt/vagrant_ruby/lib/ruby/gems/1.8/gems/chef-0.10.10/bin/../lib/chef/provider/execute.rb:58:in `action_run' /opt/vagrant_ruby/lib/ruby/gems/1.8/gems/chef-0.10.10/bin/../lib/chef/resource.rb:454:in `send' /opt/vagrant_ruby/lib/ruby/gems/1.8/gems/chef-0.10.10/bin/../lib/chef/resource.rb:454:in `run_action' /opt/vagrant_ruby/lib/ruby/gems/1.8/gems/chef-0.10.10/bin/../lib/chef/runner.rb:49:in `run_action' /opt/vagrant_ruby/lib/ruby/gems/1.8/gems/chef-0.10.10/bin/../lib/chef/runner.rb:57:in `run_action' /opt/vagrant_ruby/lib/ruby/gems/1.8/gems/chef-0.10.10/bin/../lib/chef/runner.rb:55:in `each' /opt/vagrant_ruby/lib/ruby/gems/1.8/gems/chef-0.10.10/bin/../lib/chef/runner.rb:55:in `run_action' /opt/vagrant_ruby/lib/ruby/gems/1.8/gems/chef-0.10.10/bin/../lib/chef/runner.rb:85:in `converge' /opt/vagrant_ruby/lib/ruby/gems/1.8/gems/chef-0.10.10/bin/../lib/chef/runner.rb:85:in `each' /opt/vagrant_ruby/lib/ruby/gems/1.8/gems/chef-0.10.10/bin/../lib/chef/runner.rb:85:in `converge' /opt/vagrant_ruby/lib/ruby/gems/1.8/gems/chef-0.10.10/bin/../lib/chef/resource_collection.rb:94:in `execute_each_resource' /opt/vagrant_ruby/lib/ruby/gems/1.8/gems/chef-0.10.10/bin/../lib/chef/resource_collection/stepable_iterator.rb:116:in `call' /opt/vagrant_ruby/lib/ruby/gems/1.8/gems/chef-0.10.10/bin/../lib/chef/resource_collection/stepable_iterator.rb:116:in `call_iterator_block' /opt/vagrant_ruby/lib/ruby/gems/1.8/gems/chef-0.10.10/bin/../lib/chef/resource_collection/stepable_iterator.rb:85:in `step' /opt/vagrant_ruby/lib/ruby/gems/1.8/gems/chef-0.10.10/bin/../lib/chef/resource_collection/stepable_iterator.rb:104:in `iterate' /opt/vagrant_ruby/lib/ruby/gems/1.8/gems/chef-0.10.10/bin/../lib/chef/resource_collection/stepable_iterator.rb:55:in `each_with_index' /opt/vagrant_ruby/lib/ruby/gems/1.8/gems/chef-0.10.10/bin/../lib/chef/resource_collection.rb:92:in `execute_each_resource' /opt/vagrant_ruby/lib/ruby/gems/1.8/gems/chef-0.10.10/bin/../lib/chef/runner.rb:80:in `converge' /opt/vagrant_ruby/lib/ruby/gems/1.8/gems/chef-0.10.10/bin/../lib/chef/client.rb:330:in `converge' /opt/vagrant_ruby/lib/ruby/gems/1.8/gems/chef-0.10.10/bin/../lib/chef/client.rb:163:in `run' /opt/vagrant_ruby/lib/ruby/gems/1.8/gems/chef-0.10.10/bin/../lib/chef/application/solo.rb:207:in `run_application' /opt/vagrant_ruby/lib/ruby/gems/1.8/gems/chef-0.10.10/bin/../lib/chef/application/solo.rb:195:in `loop' /opt/vagrant_ruby/lib/ruby/gems/1.8/gems/chef-0.10.10/bin/../lib/chef/application/solo.rb:195:in `run_application' /opt/vagrant_ruby/lib/ruby/gems/1.8/gems/chef-0.10.10/bin/../lib/chef/application.rb:70:in `run' /opt/vagrant_ruby/lib/ruby/gems/1.8/gems/chef-0.10.10/bin/chef-solo:25 /opt/vagrant_ruby/bin/chef-solo:19:in `load' /opt/vagrant_ruby/bin/chef-solo:19 [Tue, 18 Sep 2012 16:06:30 +0200] ERROR: Running exception handlers [Tue, 18 Sep 2012 16:06:30 +0200] ERROR: Exception handlers complete [Tue, 18 Sep 2012 16:06:30 +0200] FATAL: Stacktrace dumped to /tmp/vagrant-chef-1/chef-stacktrace.out [Tue, 18 Sep 2012 16:06:30 +0200] FATAL: Mixlib::ShellOut::ShellCommandFailed: execute[mysql-install-privileges] (mysql::server line 195) had an error: Mixlib::ShellOut::ShellCommandFailed: Expected process to exit with [0], but received '1' ---- Begin output of "/usr/bin/mysql" -u root -p"vagrant" < "/etc/mysql/grants.sql" ---- STDOUT: STDERR: ERROR 2002 (HY000): Can't connect to local MySQL server through socket '/var/run/mysqld/mysqld.sock' (2) ---- End output of "/usr/bin/mysql" -u root -p"vagrant" < "/etc/mysql/grants.sql" ---- Ran "/usr/bin/mysql" -u root -p"vagrant" < "/etc/mysql/grants.sql" returned 1 Chef never successfully completed! Any errors should be visible in the output above. Please fix your recipes so that they properly complete.