thebaron / safewater-athens

SafeWater Athens project
0 stars 0 forks source link

unique_together on actions is too aggressive. #2

Open thebaron opened 11 years ago

thebaron commented 11 years ago

Looks like we need more components to the unique together on the action model.

CCR Complete Failure to Report-01-JUL-11 IntegrityError: (1062, "Duplicate entry '14-SII-ENFORCEMENT-EPA' for key 'safewater_action_report_id_11ceaa4ece9fb4aa_uniq'")

LaughterOnWater commented 11 years ago

Not sure if this helps... Below is a running transcript of the vagrant install process. (chef-stacktrace.out below that)

Chris@GIGANTOR /e/github
$ cd safewater-athens/

Chris@GIGANTOR /e/github/safewater-athens (master)
$ git submodule update --init --recursive

Chris@GIGANTOR /e/github/safewater-athens (master)
$ vagrant up
Bringing machine 'default' up with 'virtualbox' provider...
[default] Box 'quantal-server-roderik' was not found. Fetching box from specifie
d URL for the provider 'virtualbox'. Note that if the URL does not have a box fo
r this provider, you should interrupt Vagrant now and add the box yourself. Othe
rwise Vagrant will attempt to download the full box prior to discovering this er
ror.
Downloading or copying the box...
?[0KProgress: 26% (Rate: 1830k/s, Estimated time remaining: 0:02:31)
?[0KProgress: 91% (Rate: 1902k/s, Estimated time remaining: 0:00:17)
?[0KProgress: 99% (Rate: 1958k/s, Estimated time remaining: 0:00:01)
?[0KExtracting box...ate: 1903k/s, Estimated time remaining: --:--:--)
Successfully added box 'quantal-server-roderik' with provider 'virtualbox'!
[default] Importing base box 'quantal-server-roderik'...
?[0K[default] Matching MAC address for NAT networking...
[default] Setting the name of the VM...
[default] Clearing any previously set forwarded ports...
[default] Creating shared folders metadata...
[default] Clearing any previously set network interfaces...
[default] Preparing network interfaces based on configuration...
[default] Forwarding ports...
[default] -- 22 => 2222 (adapter 1)
[default] -- 80 => 8080 (adapter 1)
[default] Running 'pre-boot' VM customizations...
[default] Booting VM...
[default] Waiting for VM to boot. This can take a few minutes.

[default] VM booted and ready for use!
[default] Mounting shared folders...
[default] -- /vagrant
[default] -- /opt/water/app
[default] -- /tmp/vagrant-chef-1/chef-solo-2/roles
[default] -- /tmp/vagrant-chef-1/chef-solo-1/cookbooks
[default] -- /tmp/vagrant-chef-1/chef-solo-3/data_bags
[default] Running provisioner: chef_solo...
Generating chef JSON and uploading...
Running chef-solo...
stdin: is not a tty
[2013-10-22T14:35:18+00:00] INFO: *** Chef 10.12.0 ***
[2013-10-22T14:35:18+00:00] INFO: Setting the run_list to ["role[ubuntu]", "role
[safewater-dev]"] from JSON
[2013-10-22T14:35:18+00:00] INFO: Run List is [role[ubuntu], role[safewater-dev]
]
[2013-10-22T14:35:18+00:00] INFO: Run List expands to [safewater::ubuntu, apt, u
ser::data_bag, build-essential, mysql::client, mysql::server, database::mysql, v
c-python, safewater]
[2013-10-22T14:35:18+00:00] INFO: Starting Chef Run for quantal64
[2013-10-22T14:35:18+00:00] INFO: Running start handlers
[2013-10-22T14:35:18+00:00] INFO: Start handlers complete.
[2013-10-22T14:35:19+00:00] INFO: Application light-weight resource already init
ialized -- overriding!
/usr/lib/ruby/vendor_ruby/chef/resource.rb:598: warning: already initialized con
stant Application
[default] VM booted and ready for use!
[default] Mounting shared folders...
[default] -- /vagrant
[default] -- /opt/water/app
[default] -- /tmp/vagrant-chef-1/chef-solo-2/roles
[default] -- /tmp/vagrant-chef-1/chef-solo-1/cookbooks
[default] -- /tmp/vagrant-chef-1/chef-solo-3/data_bags
[default] Running provisioner: chef_solo...
Generating chef JSON and uploading...
Running chef-solo...
stdin: is not a tty
[2013-10-22T14:35:18+00:00] INFO: *** Chef 10.12.0 ***
[2013-10-22T14:35:18+00:00] INFO: Setting the run_list to ["role[ubuntu]", "role
[safewater-dev]"] from JSON
[2013-10-22T14:35:18+00:00] INFO: Run List is [role[ubuntu], role[safewater-dev]
]
[2013-10-22T14:35:18+00:00] INFO: Run List expands to [safewater::ubuntu, apt, u
ser::data_bag, build-essential, mysql::client, mysql::server, database::mysql, v
c-python, safewater]
[2013-10-22T14:35:18+00:00] INFO: Starting Chef Run for quantal64
[2013-10-22T14:35:18+00:00] INFO: Running start handlers
[2013-10-22T14:35:18+00:00] INFO: Start handlers complete.
[2013-10-22T14:35:19+00:00] INFO: Application light-weight resource already init
ialized -- overriding!
/usr/lib/ruby/vendor_ruby/chef/resource.rb:598: warning: already initialized con
stant Application
[2013-10-22T14:35:25+00:00] INFO: execute[apt-get-update-force] ran successfully

[2013-10-22T14:35:25+00:00] INFO: Could not find previously defined grants.sql r
esource
[2013-10-22T14:35:34+00:00] INFO: package[mysql-client] installed version 5.5.32
-0ubuntu0.12.10.1
[2013-10-22T14:35:37+00:00] INFO: package[libmysqlclient-dev] installed version
5.5.32-0ubuntu0.12.10.1
[2013-10-22T14:35:38+00:00] INFO: package[python-mysqldb] installed version 1.2.
3-1build2
[2013-10-22T14:35:41+00:00] INFO: package[ruby-dev] installed version 4.9
[2013-10-22T14:35:48+00:00] INFO: chef_gem[mysql] installed version 2.9.1
[2013-10-22T14:35:52+00:00] INFO: execute[apt-get-update-force] ran successfully

[2013-10-22T14:36:00+00:00] INFO: execute[apt-get-update] ran successfully
[2013-10-22T14:36:02+00:00] INFO: package[update-notifier-common] installed vers
ion 0.126
[2013-10-22T14:36:02+00:00] INFO: package[update-notifier-common] sending run ac
tion to execute[apt-get-update] (immediate)
[2013-10-22T14:36:10+00:00] INFO: execute[apt-get-update] ran successfully
[2013-10-22T14:36:10+00:00] INFO: directory[/var/cache/local] created directory
/var/cache/local
[2013-10-22T14:36:10+00:00] INFO: directory[/var/cache/local/preseeding] created
 directory /var/cache/local/preseeding
[2013-10-22T14:36:10+00:00] INFO: user[vagrant] altered
[2013-10-22T14:36:10+00:00] INFO: directory[/home/vagrant/.ssh] group changed to
 1000
[2013-10-22T14:36:10+00:00] INFO: directory[/home/vagrant] mode changed to 2755
[2013-10-22T14:36:10+00:00] INFO: template[/home/vagrant/.ssh/authorized_keys] b
acked up to /var/chef/backup/home/vagrant/.ssh/authorized_keys.chef-201310221436
10
[2013-10-22T14:36:10+00:00] INFO: template[/home/vagrant/.ssh/authorized_keys] o
wner changed to 1000
[2013-10-22T14:36:10+00:00] INFO: template[/home/vagrant/.ssh/authorized_keys] g
roup changed to 1000
[2013-10-22T14:36:10+00:00] INFO: template[/home/vagrant/.ssh/authorized_keys] u
pdated content
[2013-10-22T14:36:10+00:00] INFO: execute[create ssh keypair for vagrant] ran su
ccessfully
[2013-10-22T14:36:10+00:00] INFO: group[developers] created
[2013-10-22T14:36:10+00:00] INFO: group[water] created
[2013-10-22T14:36:10+00:00] INFO: user[water] created
[2013-10-22T14:36:10+00:00] INFO: directory[/home/water/.ssh] created directory
/home/water/.ssh
[2013-10-22T14:36:10+00:00] INFO: directory[/home/water/.ssh] owner changed to 1
001
[2013-10-22T14:36:10+00:00] INFO: directory[/home/water/.ssh] group changed to 1
002
[2013-10-22T14:36:10+00:00] INFO: directory[/home/water/.ssh] mode changed to 70
0
[2013-10-22T14:36:10+00:00] INFO: directory[/home/water] mode changed to 2755
[2013-10-22T14:36:10+00:00] INFO: template[/home/water/.ssh/authorized_keys] own
er changed to 1001
[2013-10-22T14:36:10+00:00] INFO: template[/home/water/.ssh/authorized_keys] gro
up changed to 1002
[2013-10-22T14:36:10+00:00] INFO: template[/home/water/.ssh/authorized_keys] upd
ated content
[2013-10-22T14:36:10+00:00] INFO: execute[create ssh keypair for water] ran succ
essfully
[2013-10-22T14:36:11+00:00] INFO: group[water] altered
[2013-10-22T14:36:13+00:00] INFO: package[autoconf] installed version 2.69-1ubun
tu1
[2013-10-22T14:36:15+00:00] INFO: package[binutils-doc] installed version 2.22.9
0.20120924-0ubuntu2
[2013-10-22T14:36:18+00:00] INFO: package[bison] installed version 1:2.5.dfsg-2.
1build1
[2013-10-22T14:36:25+00:00] INFO: package[build-essential] installed version 11.
5ubuntu3
[2013-10-22T14:36:27+00:00] INFO: package[flex] installed version 2.5.35-10.1ubu
ntu1
[2013-10-22T14:36:27+00:00] INFO: template[/var/cache/local/preseeding/mysql-ser
ver.seed] updated content
[2013-10-22T14:36:27+00:00] INFO: template[/var/cache/local/preseeding/mysql-ser
ver.seed] sending run action to execute[preseed mysql-server] (immediate)
[2013-10-22T14:36:27+00:00] INFO: execute[preseed mysql-server] ran successfully

[2013-10-22T14:36:27+00:00] INFO: template[/etc/mysql/debian.cnf] updated conten
t
[2013-10-22T14:36:48+00:00] INFO: package[mysql-server] installed version 5.5.32
-0ubuntu0.12.10.1
[2013-10-22T14:36:48+00:00] INFO: package[mysql-server] sending start action to
service[mysql] (immediate)
[2013-10-22T14:36:48+00:00] INFO: directory[/var/run/mysqld] group changed to 11
2
[2013-10-22T14:36:48+00:00] INFO: directory[/var/log/mysql] group changed to 112

[2013-10-22T14:36:48+00:00] INFO: directory[/etc/mysql] owner changed to 107
[2013-10-22T14:36:48+00:00] INFO: directory[/etc/mysql] group changed to 112
[2013-10-22T14:36:48+00:00] INFO: directory[/etc/mysql/conf.d] owner changed to
107
[2013-10-22T14:36:48+00:00] INFO: directory[/etc/mysql/conf.d] group changed to
112
[2013-10-22T14:36:48+00:00] INFO: template[/etc/mysql/grants.sql] updated conten
t
[2013-10-22T14:36:48+00:00] INFO: template[/etc/mysql/grants.sql] sending run ac
tion to execute[mysql-install-privileges] (immediate)
[2013-10-22T14:36:48+00:00] INFO: execute[mysql-install-privileges] ran successf
ully
[2013-10-22T14:36:48+00:00] INFO: template[/etc/mysql/my.cnf] backed up to /var/
chef/backup/etc/mysql/my.cnf.chef-20131022143648
[2013-10-22T14:36:48+00:00] INFO: template[/etc/mysql/my.cnf] mode changed to 64
4
[2013-10-22T14:36:48+00:00] INFO: template[/etc/mysql/my.cnf] updated content
[2013-10-22T14:36:48+00:00] INFO: template[/etc/mysql/my.cnf] sending restart ac
tion to service[mysql] (immediate)
[2013-10-22T14:36:52+00:00] INFO: service[mysql] restarted
[2013-10-22T14:37:11+00:00] INFO: package[python-dev] installed version 2.7.3-0u
buntu7.1
[2013-10-22T14:37:11+00:00] INFO: remote_file[/var/chef/cache/distribute_setup.p
y] updated
[2013-10-22T14:37:11+00:00] INFO: remote_file[/var/chef/cache/distribute_setup.p
y] mode changed to 644
[2013-10-22T14:37:14+00:00] INFO: bash[install-pip] ran successfully
[2013-10-22T14:37:14+00:00] INFO: Installing vc-python_pip[virtualenv] version l
atest
[2013-10-22T14:37:24+00:00] INFO: package[libapache2-mod-wsgi] installed version
 3.4-0ubuntu1
[2013-10-22T14:37:36+00:00] INFO: package[libapache2-mod-php5] installed version
 5.4.6-1ubuntu1.4
[2013-10-22T14:37:39+00:00] INFO: package[supervisor] installed version 3.0a8-1.
1
[2013-10-22T14:37:42+00:00] INFO: package[redis-server] installed version 2:2.4.
15-1
[2013-10-22T14:37:57+00:00] INFO: package[graphicsmagick-imagemagick-compat] ins
talled version 1.3.16-1.1ubuntu1
[2013-10-22T14:37:57+00:00] INFO: directory[/opt/water] owner changed to 1000
[2013-10-22T14:37:57+00:00] INFO: directory[/opt/water] group changed to 1002
[2013-10-22T14:37:57+00:00] INFO: directory[/opt/water] mode changed to 2775
[2013-10-22T14:37:57+00:00] INFO: directory[/opt/water/var] created directory /o
pt/water/var
[2013-10-22T14:37:57+00:00] INFO: directory[/opt/water/var] owner changed to 100
0
[2013-10-22T14:37:57+00:00] INFO: directory[/opt/water/var] mode changed to 2775

[2013-10-22T14:37:57+00:00] INFO: directory[/opt/water/data] created directory /
opt/water/data
[2013-10-22T14:37:57+00:00] INFO: directory[/opt/water/data] owner changed to 10
00
[2013-10-22T14:37:57+00:00] INFO: directory[/opt/water/data] mode changed to 277
5
[2013-10-22T14:37:57+00:00] INFO: directory[/opt/water/var/tmp] created director
y /opt/water/var/tmp
[2013-10-22T14:37:57+00:00] INFO: directory[/opt/water/var/tmp] owner changed to
 1000
[2013-10-22T14:37:57+00:00] INFO: directory[/opt/water/var/tmp] mode changed to
2775
[2013-10-22T14:37:57+00:00] INFO: directory[/opt/water/var/run] created director
y /opt/water/var/run
[2013-10-22T14:37:57+00:00] INFO: directory[/opt/water/var/run] owner changed to
 1000
[2013-10-22T14:37:57+00:00] INFO: directory[/opt/water/var/run] mode changed to
2775
[2013-10-22T14:37:57+00:00] INFO: directory[/opt/water/var/log] created director
y /opt/water/var/log
[2013-10-22T14:37:57+00:00] INFO: directory[/opt/water/var/log] owner changed to
 1000
[2013-10-22T14:37:57+00:00] INFO: directory[/opt/water/var/log] mode changed to
2775
[2013-10-22T14:37:57+00:00] INFO: bash[remount /opt/water/app] ran successfully
[2013-10-22T14:37:57+00:00] INFO: directory[/etc/apache2/ssl] created directory
/etc/apache2/ssl
[2013-10-22T14:37:57+00:00] INFO: directory[/var/cache/apache2] owner changed to
 0
[2013-10-22T14:37:57+00:00] INFO: directory[/var/cache/apache2] group changed to
 0
[2013-10-22T14:37:57+00:00] INFO: template[apache2.conf] backed up to /var/chef/
backup/etc/apache2/apache2.conf.chef-20131022143757
[2013-10-22T14:37:57+00:00] INFO: template[apache2.conf] mode changed to 644
[2013-10-22T14:37:57+00:00] INFO: template[apache2.conf] updated content
[2013-10-22T14:37:57+00:00] INFO: template[apache2-conf-security] mode changed t
o 644
[2013-10-22T14:37:57+00:00] INFO: template[apache2-conf-security] updated conten
t
[2013-10-22T14:37:57+00:00] INFO: template[apache2-conf-security] not queuing de
layed action restart on service[apache2] (delayed), as it's already been queued
[2013-10-22T14:37:57+00:00] INFO: template[/etc/apache2/ports.conf] backed up to
 /var/chef/backup/etc/apache2/ports.conf.chef-20131022143757
[2013-10-22T14:37:57+00:00] INFO: template[/etc/apache2/ports.conf] mode changed
 to 644
[2013-10-22T14:37:57+00:00] INFO: template[/etc/apache2/ports.conf] updated cont
ent
[2013-10-22T14:37:57+00:00] INFO: template[/etc/apache2/ports.conf] not queuing
delayed action restart on service[apache2] (delayed), as it's already been queue
d
[2013-10-22T14:37:57+00:00] INFO: template[/etc/apache2/sites-available/default]
 backed up to /var/chef/backup/etc/apache2/sites-available/default.chef-20131022
143757
[2013-10-22T14:37:57+00:00] INFO: template[/etc/apache2/sites-available/default]
 mode changed to 644
[2013-10-22T14:37:57+00:00] INFO: template[/etc/apache2/sites-available/default]
 updated content
[2013-10-22T14:37:57+00:00] INFO: template[/etc/apache2/sites-available/default]
 not queuing delayed action restart on service[apache2] (delayed), as it's alrea
dy been queued
[2013-10-22T14:37:57+00:00] INFO: template[/etc/apache2/mods-available/status.co
nf] backed up to /var/chef/backup/etc/apache2/mods-available/status.conf.chef-20
131022143757
[2013-10-22T14:37:57+00:00] INFO: template[/etc/apache2/mods-available/status.co
nf] mode changed to 644
[2013-10-22T14:37:57+00:00] INFO: template[/etc/apache2/mods-available/status.co
nf] updated content
[2013-10-22T14:37:57+00:00] INFO: template[/etc/apache2/mods-available/status.co
nf] not queuing delayed action restart on service[apache2] (delayed), as it's al
ready been queued
[2013-10-22T14:37:57+00:00] INFO: template[/etc/apache2/mods-available/alias.con
f] backed up to /var/chef/backup/etc/apache2/mods-available/alias.conf.chef-2013
1022143757
[2013-10-22T14:37:57+00:00] INFO: template[/etc/apache2/mods-available/alias.con
f] mode changed to 644
[2013-10-22T14:37:57+00:00] INFO: template[/etc/apache2/mods-available/alias.con
f] updated content
[2013-10-22T14:37:57+00:00] INFO: template[/etc/apache2/mods-available/alias.con
f] not queuing delayed action restart on service[apache2] (delayed), as it's alr
eady been queued
[2013-10-22T14:37:57+00:00] INFO: template[/etc/apache2/mods-available/mime.conf
] backed up to /var/chef/backup/etc/apache2/mods-available/mime.conf.chef-201310
22143757
[2013-10-22T14:37:57+00:00] INFO: template[/etc/apache2/mods-available/mime.conf
] mode changed to 644
[2013-10-22T14:37:57+00:00] INFO: template[/etc/apache2/mods-available/mime.conf
] updated content
[2013-10-22T14:37:57+00:00] INFO: template[/etc/apache2/mods-available/mime.conf
] not queuing delayed action restart on service[apache2] (delayed), as it's alre
ady been queued
[2013-10-22T14:37:57+00:00] INFO: template[/etc/apache2/mods-available/setenvif.
conf] backed up to /var/chef/backup/etc/apache2/mods-available/setenvif.conf.che
f-20131022143757
[2013-10-22T14:37:57+00:00] INFO: template[/etc/apache2/mods-available/setenvif.
conf] mode changed to 644
[2013-10-22T14:37:57+00:00] INFO: template[/etc/apache2/mods-available/setenvif.
conf] updated content
[2013-10-22T14:37:57+00:00] INFO: template[/etc/apache2/mods-available/setenvif.
conf] not queuing delayed action restart on service[apache2] (delayed), as it's
already been queued
[2013-10-22T14:37:57+00:00] INFO: execute[a2dissite default] ran successfully
[2013-10-22T14:37:57+00:00] INFO: execute[a2enmod proxy] ran successfully
[2013-10-22T14:37:57+00:00] INFO: execute[a2enmod proxy] not queuing delayed act
ion restart on service[apache2] (delayed), as it's already been queued
[2013-10-22T14:37:57+00:00] INFO: execute[a2enmod proxy_http] ran successfully
[2013-10-22T14:37:57+00:00] INFO: execute[a2enmod proxy_http] not queuing delaye
d action restart on service[apache2] (delayed), as it's already been queued
[2013-10-22T14:37:57+00:00] INFO: execute[a2enmod rewrite] ran successfully
[2013-10-22T14:37:57+00:00] INFO: execute[a2enmod rewrite] not queuing delayed a
ction restart on service[apache2] (delayed), as it's already been queued
[2013-10-22T14:37:57+00:00] INFO: template[/etc/supervisor/conf.d/safewater.conf
] updated content
[2013-10-22T14:37:57+00:00] INFO: template[/etc/apache2/sites-available/safewate
r-athens.conf] updated content
[2013-10-22T14:37:57+00:00] INFO: link[/etc/apache2/sites-enabled/safewater-athe
ns.conf] created
[2013-10-22T14:37:57+00:00] INFO: Creating virtualenv vc-python_virtualenv[/opt/
water/var] at /opt/water/var
[2013-10-22T14:37:58+00:00] INFO: execute[virtualenv --python=python2.7 /opt/wat
er/var] ran successfully
[2013-10-22T14:37:58+00:00] INFO: Upgrading vc-python_pip[distribute] version fr
om uninstalled to latest
[2013-10-22T14:38:01+00:00] INFO: Installing vc-python_pip[-] from /opt/water/ap
p/requirements.txt
[2013-10-22T14:43:23+00:00] INFO: mysql_database_user[safewater]: granting acces
s with statement [GRANT all ON `safewater`.* TO `safewater`@`%` IDENTIFIED BY [F
ILTERED]]
[2013-10-22T14:43:23+00:00] ERROR: bash[syncdb] (safewater::default line 153) ha
s had an error
[2013-10-22T14:43:23+00:00] ERROR: bash[syncdb] (/tmp/vagrant-chef-1/chef-solo-1
/cookbooks/safewater/recipes/default.rb:153:in `from_file') had an error:
bash[syncdb] (safewater::default line 153) had an error: Mixlib::ShellOut::Shell
CommandFailed: Expected process to exit with [0], but received '127'
---- Begin output of "bash"  "/tmp/chef-script20131022-1376-5thcc2" ----
STDOUT:
STDERR: /tmp/chef-script20131022-1376-5thcc2: line 2: bin/activate: Not a direct
ory
: No such file or directory
---- End output of "bash"  "/tmp/chef-script20131022-1376-5thcc2" ----
Ran "bash"  "/tmp/chef-script20131022-1376-5thcc2" returned 127
/usr/lib/ruby/vendor_ruby/mixlib/shellout.rb:242:in `invalid!'
/usr/lib/ruby/vendor_ruby/mixlib/shellout.rb:228:in `error!'
/usr/lib/ruby/vendor_ruby/chef/mixin/shell_out.rb:36:in `shell_out!'
/usr/lib/ruby/vendor_ruby/chef/provider/execute.rb:58:in `action_run'
/usr/lib/ruby/vendor_ruby/chef/provider/script.rb:33:in `action_run'
/usr/lib/ruby/vendor_ruby/chef/resource.rb:454:in `run_action'
/usr/lib/ruby/vendor_ruby/chef/runner.rb:49:in `run_action'
/usr/lib/ruby/vendor_ruby/chef/runner.rb:85:in `block (2 levels) in converge'
/usr/lib/ruby/vendor_ruby/chef/runner.rb:85:in `each'
/usr/lib/ruby/vendor_ruby/chef/runner.rb:85:in `block in converge'
/usr/lib/ruby/vendor_ruby/chef/resource_collection.rb:94:in `block in execute_ea
ch_resource'
/usr/lib/ruby/vendor_ruby/chef/resource_collection/stepable_iterator.rb:116:in `
call'
/usr/lib/ruby/vendor_ruby/chef/resource_collection/stepable_iterator.rb:116:in `
call_iterator_block'
/usr/lib/ruby/vendor_ruby/chef/resource_collection/stepable_iterator.rb:85:in `s
tep'
/usr/lib/ruby/vendor_ruby/chef/resource_collection/stepable_iterator.rb:104:in `
iterate'
/usr/lib/ruby/vendor_ruby/chef/resource_collection/stepable_iterator.rb:55:in `e
ach_with_index'
/usr/lib/ruby/vendor_ruby/chef/resource_collection.rb:92:in `execute_each_resour
ce'
/usr/lib/ruby/vendor_ruby/chef/runner.rb:80:in `converge'
/usr/lib/ruby/vendor_ruby/chef/client.rb:330:in `converge'
/usr/lib/ruby/vendor_ruby/chef/client.rb:163:in `run'
/usr/lib/ruby/vendor_ruby/chef/application/solo.rb:207:in `block in run_applicat
ion'
/usr/lib/ruby/vendor_ruby/chef/application/solo.rb:195:in `loop'
/usr/lib/ruby/vendor_ruby/chef/application/solo.rb:195:in `run_application'
/usr/lib/ruby/vendor_ruby/chef/application.rb:70:in `run'
/usr/bin/chef-solo:24:in `<main>'
[2013-10-22T14:43:23+00:00] ERROR: Running exception handlers
[2013-10-22T14:43:23+00:00] ERROR: Exception handlers complete
[2013-10-22T14:43:23+00:00] FATAL: Stacktrace dumped to /var/chef/cache/chef-sta
cktrace.out
[2013-10-22T14:43:23+00:00] FATAL: Mixlib::ShellOut::ShellCommandFailed: bash[sy
ncdb] (safewater::default line 153) had an error: Mixlib::ShellOut::ShellCommand
Failed: Expected process to exit with [0], but received '127'
---- Begin output of "bash"  "/tmp/chef-script20131022-1376-5thcc2" ----
STDOUT:
STDERR: /tmp/chef-script20131022-1376-5thcc2: line 2: bin/activate: Not a direct
ory
: No such file or directory
---- End output of "bash"  "/tmp/chef-script20131022-1376-5thcc2" ----
Ran "bash"  "/tmp/chef-script20131022-1376-5thcc2" returned 127
Chef never successfully completed! Any errors should be visible in the
output above. Please fix your recipes so that they properly complete.

Chris@GIGANTOR /e/github/safewater-athens (master)

Here's the chef-stacktrace.out file:

vagrant@quantal64:/vagrant$ more chef-stacktrace.out
Generated at 2013-10-22 14:43:23 +0000
Mixlib::ShellOut::ShellCommandFailed: bash[syncdb] (safewater::default line 153)
 had an error: Mixlib::ShellOut::ShellCommandFailed: Expected process to exit wi
th [0], but received '127'
---- Begin output of "bash"  "/tmp/chef-script20131022-1376-5thcc2" ----
STDOUT:
STDERR: /tmp/chef-script20131022-1376-5thcc2: line 2: bin/activate: Not a direct
ory
: No such file or directory
---- End output of "bash"  "/tmp/chef-script20131022-1376-5thcc2" ----
Ran "bash"  "/tmp/chef-script20131022-1376-5thcc2" returned 127
/usr/lib/ruby/vendor_ruby/mixlib/shellout.rb:242:in `invalid!'
/usr/lib/ruby/vendor_ruby/mixlib/shellout.rb:228:in `error!'
/usr/lib/ruby/vendor_ruby/chef/mixin/shell_out.rb:36:in `shell_out!'
/usr/lib/ruby/vendor_ruby/chef/provider/execute.rb:58:in `action_run'
/usr/lib/ruby/vendor_ruby/chef/provider/script.rb:33:in `action_run'
/usr/lib/ruby/vendor_ruby/chef/resource.rb:454:in `run_action'
/usr/lib/ruby/vendor_ruby/chef/runner.rb:49:in `run_action'
/usr/lib/ruby/vendor_ruby/chef/runner.rb:85:in `block (2 levels) in converge'
/usr/lib/ruby/vendor_ruby/chef/runner.rb:85:in `each'
/usr/lib/ruby/vendor_ruby/chef/runner.rb:85:in `block in converge'
/usr/lib/ruby/vendor_ruby/chef/resource_collection.rb:94:in `block in execute_ea
ch_resource'
/usr/lib/ruby/vendor_ruby/chef/resource_collection/stepable_iterator.rb:116:in `
call'
/usr/lib/ruby/vendor_ruby/chef/resource_collection/stepable_iterator.rb:116:in `
call_iterator_block'
/usr/lib/ruby/vendor_ruby/chef/resource_collection/stepable_iterator.rb:85:in `s
tep'
/usr/lib/ruby/vendor_ruby/chef/resource_collection/stepable_iterator.rb:104:in `
iterate'
/usr/lib/ruby/vendor_ruby/chef/resource_collection/stepable_iterator.rb:55:in `e
ach_with_index'
/usr/lib/ruby/vendor_ruby/chef/resource_collection.rb:92:in `execute_each_resour
ce'
/usr/lib/ruby/vendor_ruby/chef/runner.rb:80:in `converge'
/usr/lib/ruby/vendor_ruby/chef/client.rb:330:in `converge'
/usr/lib/ruby/vendor_ruby/chef/client.rb:163:in `run'
/usr/lib/ruby/vendor_ruby/chef/application/solo.rb:207:in `block in run_applicat
ion'
/usr/lib/ruby/vendor_ruby/chef/application/solo.rb:195:in `loop'
/usr/lib/ruby/vendor_ruby/chef/application/solo.rb:195:in `run_application'
/usr/lib/ruby/vendor_ruby/chef/application.rb:70:in `run'
/usr/bin/chef-solo:24:in `<main>'
vagrant@quantal64:/vagrant$
LaughterOnWater commented 11 years ago
[2013-10-23T18:43:57+00:00] INFO: directory[/home/vagrant] mode changed to 2755
[2013-10-23T18:43:57+00:00] INFO: template[/home/vagrant/.ssh/authorized_keys] b
acked up to /var/chef/backup/home/vagrant/.ssh/authorized_keys.chef-201310231843
57
[2013-10-23T18:43:57+00:00] INFO: template[/home/vagrant/.ssh/authorized_keys] o
wner changed to 1000
[2013-10-23T18:43:57+00:00] INFO: template[/home/vagrant/.ssh/authorized_keys] g
roup changed to 1000
[2013-10-23T18:43:57+00:00] INFO: template[/home/vagrant/.ssh/authorized_keys] u
pdated content
[2013-10-23T18:43:57+00:00] INFO: execute[create ssh keypair for vagrant] ran su
ccessfully
[2013-10-23T18:43:57+00:00] INFO: group[developers] created
[2013-10-23T18:43:57+00:00] INFO: group[water] created
[2013-10-23T18:43:57+00:00] INFO: user[water] created
[2013-10-23T18:43:57+00:00] INFO: directory[/home/water/.ssh] created directory
/home/water/.ssh
[2013-10-23T18:43:57+00:00] INFO: directory[/home/water/.ssh] owner changed to 1
001
[2013-10-23T18:43:57+00:00] INFO: directory[/home/water/.ssh] group changed to 1
002
[2013-10-23T18:43:57+00:00] INFO: directory[/home/water/.ssh] mode changed to 70
0
[2013-10-23T18:43:57+00:00] INFO: directory[/home/water] mode changed to 2755
[2013-10-23T18:43:57+00:00] INFO: template[/home/water/.ssh/authorized_keys] own
er changed to 1001
[2013-10-23T18:43:57+00:00] INFO: template[/home/water/.ssh/authorized_keys] gro
up changed to 1002
[2013-10-23T18:43:57+00:00] INFO: template[/home/water/.ssh/authorized_keys] upd
ated content
[2013-10-23T18:43:57+00:00] INFO: execute[create ssh keypair for water] ran succ
essfully
[2013-10-23T18:43:57+00:00] INFO: group[water] altered
[2013-10-23T18:44:01+00:00] INFO: package[autoconf] installed version 2.69-1ubun
tu1
[2013-10-23T18:44:03+00:00] INFO: package[binutils-doc] installed version 2.22.9
0.20120924-0ubuntu2
[2013-10-23T18:44:06+00:00] INFO: package[bison] installed version 1:2.5.dfsg-2.
1build1
[2013-10-23T18:44:10+00:00] INFO: package[build-essential] installed version 11.
5ubuntu3
[2013-10-23T18:44:11+00:00] INFO: package[flex] installed version 2.5.35-10.1ubu
ntu1
[2013-10-23T18:44:12+00:00] INFO: template[/var/cache/local/preseeding/mysql-ser
ver.seed] updated content
[2013-10-23T18:44:12+00:00] INFO: template[/var/cache/local/preseeding/mysql-ser
ver.seed] sending run action to execute[preseed mysql-server] (immediate)
[2013-10-23T18:44:12+00:00] INFO: execute[preseed mysql-server] ran successfully

[2013-10-23T18:44:12+00:00] INFO: template[/etc/mysql/debian.cnf] updated conten
t
[2013-10-23T18:44:33+00:00] INFO: package[mysql-server] installed version 5.5.32
-0ubuntu0.12.10.1
[2013-10-23T18:44:33+00:00] INFO: package[mysql-server] sending start action to
service[mysql] (immediate)
[2013-10-23T18:44:33+00:00] INFO: directory[/var/run/mysqld] group changed to 11
2
[2013-10-23T18:44:33+00:00] INFO: directory[/var/log/mysql] group changed to 112

[2013-10-23T18:44:33+00:00] INFO: directory[/etc/mysql] owner changed to 107
[2013-10-23T18:44:33+00:00] INFO: directory[/etc/mysql] group changed to 112
[2013-10-23T18:44:33+00:00] INFO: directory[/etc/mysql/conf.d] owner changed to
107
[2013-10-23T18:44:33+00:00] INFO: directory[/etc/mysql/conf.d] group changed to
112
[2013-10-23T18:44:33+00:00] INFO: template[/etc/mysql/grants.sql] updated conten
t
[2013-10-23T18:44:33+00:00] INFO: template[/etc/mysql/grants.sql] sending run ac
tion to execute[mysql-install-privileges] (immediate)
[2013-10-23T18:44:33+00:00] INFO: execute[mysql-install-privileges] ran successf
ully
[2013-10-23T18:44:33+00:00] INFO: template[/etc/mysql/my.cnf] backed up to /var/
chef/backup/etc/mysql/my.cnf.chef-20131023184433
[2013-10-23T18:44:33+00:00] INFO: template[/etc/mysql/my.cnf] mode changed to 64
4
[2013-10-23T18:44:33+00:00] INFO: template[/etc/mysql/my.cnf] updated content
[2013-10-23T18:44:33+00:00] INFO: template[/etc/mysql/my.cnf] sending restart ac
tion to service[mysql] (immediate)
[2013-10-23T18:44:36+00:00] INFO: service[mysql] restarted
[2013-10-23T18:44:53+00:00] INFO: package[python-dev] installed version 2.7.3-0u
buntu7.1
[2013-10-23T18:44:54+00:00] INFO: remote_file[/var/chef/cache/distribute_setup.p
y] updated
[2013-10-23T18:44:54+00:00] INFO: remote_file[/var/chef/cache/distribute_setup.p
y] mode changed to 644
[2013-10-23T18:44:56+00:00] INFO: bash[install-pip] ran successfully
[2013-10-23T18:44:56+00:00] INFO: Installing vc-python_pip[virtualenv] version l
atest
[2013-10-23T18:45:06+00:00] INFO: package[libapache2-mod-wsgi] installed version
 3.4-0ubuntu1
[2013-10-23T18:45:16+00:00] INFO: package[libapache2-mod-php5] installed version
 5.4.6-1ubuntu1.4
[2013-10-23T18:45:20+00:00] INFO: package[supervisor] installed version 3.0a8-1.
1
[2013-10-23T18:45:23+00:00] INFO: package[redis-server] installed version 2:2.4.
15-1
[2013-10-23T18:45:39+00:00] INFO: package[graphicsmagick-imagemagick-compat] ins
talled version 1.3.16-1.1ubuntu1
[2013-10-23T18:45:39+00:00] INFO: directory[/opt/water] owner changed to 1000
[2013-10-23T18:45:39+00:00] INFO: directory[/opt/water] group changed to 1002
[2013-10-23T18:45:39+00:00] INFO: directory[/opt/water] mode changed to 2775
[2013-10-23T18:45:39+00:00] INFO: directory[/opt/water/var] created directory /o
pt/water/var
[2013-10-23T18:45:39+00:00] INFO: directory[/opt/water/var] owner changed to 100
0
[2013-10-23T18:45:39+00:00] INFO: directory[/opt/water/var] mode changed to 2775

[2013-10-23T18:45:39+00:00] INFO: directory[/opt/water/data] created directory /
opt/water/data
[2013-10-23T18:45:39+00:00] INFO: directory[/opt/water/data] owner changed to 10
00
[2013-10-23T18:45:39+00:00] INFO: directory[/opt/water/data] mode changed to 277
5
[2013-10-23T18:45:39+00:00] INFO: directory[/opt/water/var/tmp] created director
y /opt/water/var/tmp
[2013-10-23T18:45:39+00:00] INFO: directory[/opt/water/var/tmp] owner changed to
 1000
[2013-10-23T18:45:39+00:00] INFO: directory[/opt/water/var/tmp] mode changed to
2775
[2013-10-23T18:45:39+00:00] INFO: directory[/opt/water/var/run] created director
y /opt/water/var/run
[2013-10-23T18:45:39+00:00] INFO: directory[/opt/water/var/run] owner changed to
 1000
[2013-10-23T18:45:39+00:00] INFO: directory[/opt/water/var/run] mode changed to
2775
[2013-10-23T18:45:39+00:00] INFO: directory[/opt/water/var/log] created director
y /opt/water/var/log
[2013-10-23T18:45:39+00:00] INFO: directory[/opt/water/var/log] owner changed to
 1000
[2013-10-23T18:45:39+00:00] INFO: directory[/opt/water/var/log] mode changed to
2775
[2013-10-23T18:45:39+00:00] INFO: bash[remount /opt/water/app] ran successfully
[2013-10-23T18:45:39+00:00] INFO: directory[/etc/apache2/ssl] created directory
/etc/apache2/ssl
[2013-10-23T18:45:39+00:00] INFO: directory[/var/cache/apache2] owner changed to
 0
[2013-10-23T18:45:39+00:00] INFO: directory[/var/cache/apache2] group changed to
 0
[2013-10-23T18:45:39+00:00] INFO: template[apache2.conf] backed up to /var/chef/
backup/etc/apache2/apache2.conf.chef-20131023184539
[2013-10-23T18:45:39+00:00] INFO: template[apache2.conf] mode changed to 644
[2013-10-23T18:45:39+00:00] INFO: template[apache2.conf] updated content
[2013-10-23T18:45:39+00:00] INFO: template[apache2-conf-security] mode changed t
o 644
[2013-10-23T18:45:39+00:00] INFO: template[apache2-conf-security] updated conten
t
[2013-10-23T18:45:39+00:00] INFO: template[apache2-conf-security] not queuing de
layed action restart on service[apache2] (delayed), as it's already been queued
[2013-10-23T18:45:39+00:00] INFO: template[/etc/apache2/ports.conf] backed up to
 /var/chef/backup/etc/apache2/ports.conf.chef-20131023184539
[2013-10-23T18:45:39+00:00] INFO: template[/etc/apache2/ports.conf] mode changed
 to 644
[2013-10-23T18:45:39+00:00] INFO: template[/etc/apache2/ports.conf] updated cont
ent
[2013-10-23T18:45:39+00:00] INFO: template[/etc/apache2/ports.conf] not queuing
delayed action restart on service[apache2] (delayed), as it's already been queue
d
[2013-10-23T18:45:39+00:00] INFO: template[/etc/apache2/sites-available/default]
 backed up to /var/chef/backup/etc/apache2/sites-available/default.chef-20131023
184539
[2013-10-23T18:45:39+00:00] INFO: template[/etc/apache2/sites-available/default]
 mode changed to 644
[2013-10-23T18:45:39+00:00] INFO: template[/etc/apache2/sites-available/default]
 updated content
[2013-10-23T18:45:39+00:00] INFO: template[/etc/apache2/sites-available/default]
 not queuing delayed action restart on service[apache2] (delayed), as it's alrea
dy been queued
[2013-10-23T18:45:39+00:00] INFO: template[/etc/apache2/mods-available/status.co
nf] backed up to /var/chef/backup/etc/apache2/mods-available/status.conf.chef-20
131023184539
[2013-10-23T18:45:39+00:00] INFO: template[/etc/apache2/mods-available/status.co
nf] mode changed to 644
[2013-10-23T18:45:39+00:00] INFO: template[/etc/apache2/mods-available/status.co
nf] updated content
[2013-10-23T18:45:39+00:00] INFO: template[/etc/apache2/mods-available/status.co
nf] not queuing delayed action restart on service[apache2] (delayed), as it's al
ready been queued
[2013-10-23T18:45:39+00:00] INFO: template[/etc/apache2/mods-available/alias.con
f] backed up to /var/chef/backup/etc/apache2/mods-available/alias.conf.chef-2013
1023184539
[2013-10-23T18:45:39+00:00] INFO: template[/etc/apache2/mods-available/alias.con
f] mode changed to 644
[2013-10-23T18:45:39+00:00] INFO: template[/etc/apache2/mods-available/alias.con
f] updated content
[2013-10-23T18:45:39+00:00] INFO: template[/etc/apache2/mods-available/alias.con
f] not queuing delayed action restart on service[apache2] (delayed), as it's alr
eady been queued
[2013-10-23T18:45:39+00:00] INFO: template[/etc/apache2/mods-available/mime.conf
] backed up to /var/chef/backup/etc/apache2/mods-available/mime.conf.chef-201310
23184539
[2013-10-23T18:45:39+00:00] INFO: template[/etc/apache2/mods-available/mime.conf
] mode changed to 644
[2013-10-23T18:45:39+00:00] INFO: template[/etc/apache2/mods-available/mime.conf
] updated content
[2013-10-23T18:45:39+00:00] INFO: template[/etc/apache2/mods-available/mime.conf
] not queuing delayed action restart on service[apache2] (delayed), as it's alre
ady been queued
[2013-10-23T18:45:39+00:00] INFO: template[/etc/apache2/mods-available/setenvif.
conf] backed up to /var/chef/backup/etc/apache2/mods-available/setenvif.conf.che
f-20131023184539
[2013-10-23T18:45:39+00:00] INFO: template[/etc/apache2/mods-available/setenvif.
conf] mode changed to 644
[2013-10-23T18:45:39+00:00] INFO: template[/etc/apache2/mods-available/setenvif.
conf] updated content
[2013-10-23T18:45:39+00:00] INFO: template[/etc/apache2/mods-available/setenvif.
conf] not queuing delayed action restart on service[apache2] (delayed), as it's
already been queued
[2013-10-23T18:45:39+00:00] INFO: execute[a2dissite default] ran successfully
[2013-10-23T18:45:39+00:00] INFO: execute[a2enmod proxy] ran successfully
[2013-10-23T18:45:39+00:00] INFO: execute[a2enmod proxy] not queuing delayed act
ion restart on service[apache2] (delayed), as it's already been queued
[2013-10-23T18:45:39+00:00] INFO: execute[a2enmod proxy_http] ran successfully
[2013-10-23T18:45:39+00:00] INFO: execute[a2enmod proxy_http] not queuing delaye
d action restart on service[apache2] (delayed), as it's already been queued
[2013-10-23T18:45:39+00:00] INFO: execute[a2enmod rewrite] ran successfully
[2013-10-23T18:45:39+00:00] INFO: execute[a2enmod rewrite] not queuing delayed a
ction restart on service[apache2] (delayed), as it's already been queued
[2013-10-23T18:45:39+00:00] INFO: template[/etc/supervisor/conf.d/safewater.conf
] updated content
[2013-10-23T18:45:39+00:00] INFO: template[/etc/apache2/sites-available/safewate
r-athens.conf] updated content
[2013-10-23T18:45:39+00:00] INFO: link[/etc/apache2/sites-enabled/safewater-athe
ns.conf] created
[2013-10-23T18:45:39+00:00] INFO: Creating virtualenv vc-python_virtualenv[/opt/
water/var] at /opt/water/var
[2013-10-23T18:45:40+00:00] INFO: execute[virtualenv --python=python2.7 /opt/wat
er/var] ran successfully
[2013-10-23T18:45:40+00:00] INFO: Upgrading vc-python_pip[distribute] version fr
om uninstalled to latest
[2013-10-23T18:45:43+00:00] INFO: Installing vc-python_pip[-] from /opt/water/ap
p/requirements.txt
[2013-10-23T18:51:07+00:00] INFO: mysql_database_user[safewater]: granting acces
s with statement [GRANT all ON `safewater`.* TO `safewater`@`%` IDENTIFIED BY [F
ILTERED]]
[2013-10-23T18:51:07+00:00] ERROR: bash[syncdb] (safewater::default line 153) ha
s had an error
[2013-10-23T18:51:07+00:00] ERROR: bash[syncdb] (/tmp/vagrant-chef-1/chef-solo-1
/cookbooks/safewater/recipes/default.rb:153:in `from_file') had an error:
bash[syncdb] (safewater::default line 153) had an error: Mixlib::ShellOut::Shell
CommandFailed: Expected process to exit with [0], but received '127'
---- Begin output of "bash"  "/tmp/chef-script20131023-1391-iory4e" ----
STDOUT:
STDERR: /tmp/chef-script20131023-1391-iory4e: line 2: bin/activate: Not a direct
ory
: No such file or directory
---- End output of "bash"  "/tmp/chef-script20131023-1391-iory4e" ----
Ran "bash"  "/tmp/chef-script20131023-1391-iory4e" returned 127
/usr/lib/ruby/vendor_ruby/mixlib/shellout.rb:242:in `invalid!'
/usr/lib/ruby/vendor_ruby/mixlib/shellout.rb:228:in `error!'
/usr/lib/ruby/vendor_ruby/chef/mixin/shell_out.rb:36:in `shell_out!'
/usr/lib/ruby/vendor_ruby/chef/provider/execute.rb:58:in `action_run'
/usr/lib/ruby/vendor_ruby/chef/provider/script.rb:33:in `action_run'
/usr/lib/ruby/vendor_ruby/chef/resource.rb:454:in `run_action'
/usr/lib/ruby/vendor_ruby/chef/runner.rb:49:in `run_action'
/usr/lib/ruby/vendor_ruby/chef/runner.rb:85:in `block (2 levels) in converge'
/usr/lib/ruby/vendor_ruby/chef/runner.rb:85:in `each'
/usr/lib/ruby/vendor_ruby/chef/runner.rb:85:in `block in converge'
/usr/lib/ruby/vendor_ruby/chef/resource_collection.rb:94:in `block in execute_ea
ch_resource'
/usr/lib/ruby/vendor_ruby/chef/resource_collection/stepable_iterator.rb:116:in `
call'
/usr/lib/ruby/vendor_ruby/chef/resource_collection/stepable_iterator.rb:116:in `
call_iterator_block'
/usr/lib/ruby/vendor_ruby/chef/resource_collection/stepable_iterator.rb:85:in `s
tep'
/usr/lib/ruby/vendor_ruby/chef/resource_collection/stepable_iterator.rb:104:in `
iterate'
/usr/lib/ruby/vendor_ruby/chef/resource_collection/stepable_iterator.rb:55:in `e
ach_with_index'
/usr/lib/ruby/vendor_ruby/chef/resource_collection.rb:92:in `execute_each_resour
ce'
/usr/lib/ruby/vendor_ruby/chef/runner.rb:80:in `converge'
/usr/lib/ruby/vendor_ruby/chef/client.rb:330:in `converge'
/usr/lib/ruby/vendor_ruby/chef/client.rb:163:in `run'
/usr/lib/ruby/vendor_ruby/chef/application/solo.rb:207:in `block in run_applicat
ion'
/usr/lib/ruby/vendor_ruby/chef/application/solo.rb:195:in `loop'
/usr/lib/ruby/vendor_ruby/chef/application/solo.rb:195:in `run_application'
/usr/lib/ruby/vendor_ruby/chef/application.rb:70:in `run'
/usr/bin/chef-solo:24:in `<main>'
[2013-10-23T18:51:07+00:00] ERROR: Running exception handlers
[2013-10-23T18:51:07+00:00] ERROR: Exception handlers complete
[2013-10-23T18:51:07+00:00] FATAL: Stacktrace dumped to /var/chef/cache/chef-sta
cktrace.out
[2013-10-23T18:51:07+00:00] FATAL: Mixlib::ShellOut::ShellCommandFailed: bash[sy
ncdb] (safewater::default line 153) had an error: Mixlib::ShellOut::ShellCommand
Failed: Expected process to exit with [0], but received '127'
---- Begin output of "bash"  "/tmp/chef-script20131023-1391-iory4e" ----
STDOUT:
STDERR: /tmp/chef-script20131023-1391-iory4e: line 2: bin/activate: Not a direct
ory
: No such file or directory
---- End output of "bash"  "/tmp/chef-script20131023-1391-iory4e" ----
Ran "bash"  "/tmp/chef-script20131023-1391-iory4e" returned 127
Chef never successfully completed! Any errors should be visible in the
output above. Please fix your recipes so that they properly complete.

Chris@GIGANTOR /e/github/safewater-athens (master)