FAIL: $ stkr start -fv test

gistfile1.sh

$ stkr start -fv test                                                                   master ‹ruby-1.9.3›
Initializing the environment.
Cloning repositories
Cloning into /Users/grimen/StackRocket/apps/test...

Verifying VM
Importing VM: 99%
Fowarding ssh port 22 -> 2000
Fowarding web port 80 -> 8000
Starting VM
Mapping project folder /Users/grimen/StackRocket/apps/test -> /koi/apps/test
Mapping config folder /Users/grimen/StackRocket/configs/test -> /koi/configs/test
Provisioning server.  This may take some time.
[Sun, 16 Oct 2011 04:41:36 -0400] INFO: *** Chef 0.10.0 ***

[Sun, 16 Oct 2011 04:41:36 -0400] INFO: Setting the run_list to ["main::misc", "main::apt", "main::postgres", "main::rails", "main::nginx", "main::supervisor"] from JSON

[Sun, 16 Oct 2011 04:41:36 -0400] INFO: Run List is [recipe[main::misc], recipe[main::apt], recipe[main::postgres], recipe[main::rails], recipe[main::nginx], recipe[main::supervisor]]

[Sun, 16 Oct 2011 04:41:36 -0400] INFO: Run List expands to [main::misc, main::apt, main::postgres, main::rails, main::nginx, main::supervisor]
[Sun, 16 Oct 2011 04:41:36 -0400] INFO: Starting Chef Run for koibase.phub.net.cable.rogers.com

[Sun, 16 Oct 2011 04:41:36 -0400] INFO: Processing cookbook_file[/tmp/1e1326c7c3b0483ee747081916e48cdce0c53312.tar] action create (main::misc line 1)

[Sun, 16 Oct 2011 04:41:36 -0400] INFO: cookbook_file[/tmp/1e1326c7c3b0483ee747081916e48cdce0c53312.tar] mode changed to 644

[Sun, 16 Oct 2011 04:41:36 -0400] INFO: cookbook_file[/tmp/1e1326c7c3b0483ee747081916e48cdce0c53312.tar] created file /tmp/1e1326c7c3b0483ee747081916e48cdce0c53312.tar

[Sun, 16 Oct 2011 04:41:36 -0400] INFO: Processing execute[tar xf /tmp/1e1326c7c3b0483ee747081916e48cdce0c53312.tar] action run (main::misc line 8)

[Sun, 16 Oct 2011 04:41:36 -0400] INFO: execute[tar xf /tmp/1e1326c7c3b0483ee747081916e48cdce0c53312.tar] sh(tar xf /tmp/1e1326c7c3b0483ee747081916e48cdce0c53312.tar)

[Sun, 16 Oct 2011 04:41:36 -0400] INFO: execute[tar xf /tmp/1e1326c7c3b0483ee747081916e48cdce0c53312.tar] ran successfully

[Sun, 16 Oct 2011 04:41:36 -0400] INFO: Processing template[/etc/hosts] action create (main::misc line 9)

[Sun, 16 Oct 2011 04:41:36 -0400] INFO: template[/etc/hosts] mode changed to 644

[Sun, 16 Oct 2011 04:41:36 -0400] INFO: template[/etc/hosts] updated content

[Sun, 16 Oct 2011 04:41:36 -0400] INFO: Processing execute[hostname test] action run (main::misc line 16)

[Sun, 16 Oct 2011 04:41:36 -0400] INFO: execute[hostname test] sh(hostname test)

[Sun, 16 Oct 2011 04:41:36 -0400] INFO: execute[hostname test] ran successfully

[Sun, 16 Oct 2011 04:41:36 -0400] INFO: Processing execute[echo 'test' > /etc/hostname] action run (main::misc line 17)

[Sun, 16 Oct 2011 04:41:36 -0400] INFO: execute[echo 'test' > /etc/hostname] sh(echo 'test' > /etc/hostname)

[Sun, 16 Oct 2011 04:41:36 -0400] INFO: execute[echo 'test' > /etc/hostname] ran successfully

[Sun, 16 Oct 2011 04:41:36 -0400] INFO: Processing execute[sysctl kernel.hostname=test] action run (main::misc line 18)

[Sun, 16 Oct 2011 04:41:36 -0400] INFO: execute[sysctl kernel.hostname=test] sh(sysctl kernel.hostname=test)

[Sun, 16 Oct 2011 04:41:36 -0400] INFO: execute[sysctl kernel.hostname=test] ran successfully

[Sun, 16 Oct 2011 04:41:36 -0400] INFO: Processing execute[make-ssl-cert generate-default-snakeoil --force-overwrite] action run (main::misc line 19)

[Sun, 16 Oct 2011 04:41:36 -0400] INFO: execute[make-ssl-cert generate-default-snakeoil --force-overwrite] sh(make-ssl-cert generate-default-snakeoil --force-overwrite)

[Sun, 16 Oct 2011 04:41:37 -0400] INFO: execute[make-ssl-cert generate-default-snakeoil --force-overwrite] ran successfully

[Sun, 16 Oct 2011 04:41:37 -0400] INFO: Processing execute[/bin/rm /etc/ssh/ssh_host_*] action run (main::misc line 20)

[Sun, 16 Oct 2011 04:41:37 -0400] INFO: execute[/bin/rm /etc/ssh/ssh_host_*] sh(/bin/rm /etc/ssh/ssh_host_*)

[Sun, 16 Oct 2011 04:41:37 -0400] INFO: execute[/bin/rm /etc/ssh/ssh_host_*] ran successfully
[Sun, 16 Oct 2011 04:41:37 -0400] INFO: Processing execute[dpkg-reconfigure openssh-server] action run (main::misc line 21)
[Sun, 16 Oct 2011 04:41:37 -0400] INFO: execute[dpkg-reconfigure openssh-server] sh(dpkg-reconfigure openssh-server)

[Sun, 16 Oct 2011 04:41:38 -0400] INFO: execute[dpkg-reconfigure openssh-server] ran successfully

[Sun, 16 Oct 2011 04:41:38 -0400] INFO: Processing directory[/etc/apt] action create (main::apt line 1)

[Sun, 16 Oct 2011 04:41:38 -0400] INFO: Processing execute[add-apt-repository ppa:nginx/stable] action run (main::apt line 7)

[Sun, 16 Oct 2011 04:41:38 -0400] INFO: execute[add-apt-repository ppa:nginx/stable] sh(add-apt-repository ppa:nginx/stable)

[Sun, 16 Oct 2011 04:41:39 -0400] INFO: execute[add-apt-repository ppa:nginx/stable] ran successfully

[Sun, 16 Oct 2011 04:41:39 -0400] INFO: Processing execute[add-apt-repository ppa:pitti/postgresql] action run (main::apt line 8)

[Sun, 16 Oct 2011 04:41:39 -0400] INFO: execute[add-apt-repository ppa:pitti/postgresql] sh(add-apt-repository ppa:pitti/postgresql)

[Sun, 16 Oct 2011 04:41:41 -0400] INFO: execute[add-apt-repository ppa:pitti/postgresql] ran successfully

[Sun, 16 Oct 2011 04:41:41 -0400] INFO: Processing cookbook_file[/etc/apt/sources.list] action create (main::apt line 10)

[Sun, 16 Oct 2011 04:41:41 -0400] INFO: cookbook_file[/etc/apt/sources.list] mode changed to 755

[Sun, 16 Oct 2011 04:41:41 -0400] INFO: Processing execute[apt-get -q update] action run (main::apt line 17)

[Sun, 16 Oct 2011 04:41:41 -0400] INFO: execute[apt-get -q update] sh(apt-get -q update)

[Sun, 16 Oct 2011 04:41:45 -0400] INFO: execute[apt-get -q update] ran successfully

[Sun, 16 Oct 2011 04:41:45 -0400] INFO: Processing package[postgresql-9.1] action install (main::postgres line 1)

[Sun, 16 Oct 2011 04:42:13 -0400] INFO: package[postgresql-9.1] installed version 9.1.1-1~lucid
[Sun, 16 Oct 2011 04:42:13 -0400] INFO: Processing package[libpq-dev] action install (main::postgres line 2)

[Sun, 16 Oct 2011 04:42:24 -0400] INFO: package[libpq-dev] installed version 9.1.1-1~lucid
[Sun, 16 Oct 2011 04:42:24 -0400] INFO: Processing cookbook_file[/etc/postgresql/9.1/main/pg_hba.conf] action create (main::postgres line 4)

[Sun, 16 Oct 2011 04:42:24 -0400] INFO: cookbook_file[/etc/postgresql/9.1/main/pg_hba.conf] owner changed to 104

[Sun, 16 Oct 2011 04:42:24 -0400] INFO: cookbook_file[/etc/postgresql/9.1/main/pg_hba.conf] owner changed to 113

[Sun, 16 Oct 2011 04:42:24 -0400] INFO: cookbook_file[/etc/postgresql/9.1/main/pg_hba.conf] mode changed to 640

[Sun, 16 Oct 2011 04:42:24 -0400] INFO: cookbook_file[/etc/postgresql/9.1/main/pg_hba.conf] created file /etc/postgresql/9.1/main/pg_hba.conf

[Sun, 16 Oct 2011 04:42:24 -0400] INFO: Processing template[/etc/postgresql/9.1/main/postgresql.conf] action create (main::postgres line 11)

[Sun, 16 Oct 2011 04:42:24 -0400] INFO: template[/etc/postgresql/9.1/main/postgresql.conf] owner changed to 104

[Sun, 16 Oct 2011 04:42:24 -0400] INFO: template[/etc/postgresql/9.1/main/postgresql.conf] owner changed to 113

[Sun, 16 Oct 2011 04:42:24 -0400] INFO: template[/etc/postgresql/9.1/main/postgresql.conf] mode changed to 644
[Sun, 16 Oct 2011 04:42:24 -0400] INFO: template[/etc/postgresql/9.1/main/postgresql.conf] updated content

[Sun, 16 Oct 2011 04:42:24 -0400] INFO: Processing template[/tmp/db_init.sql] action create (main::postgres line 21)

[Sun, 16 Oct 2011 04:42:24 -0400] INFO: template[/tmp/db_init.sql] owner changed to 104

[Sun, 16 Oct 2011 04:42:24 -0400] INFO: template[/tmp/db_init.sql] owner changed to 113

[Sun, 16 Oct 2011 04:42:24 -0400] INFO: template[/tmp/db_init.sql] mode changed to 640

[Sun, 16 Oct 2011 04:42:24 -0400] INFO: template[/tmp/db_init.sql] updated content
[Sun, 16 Oct 2011 04:42:24 -0400] INFO: Processing execute[initialized db] action run (main::postgres line 28)

[Sun, 16 Oct 2011 04:42:24 -0400] INFO: execute[initialized db] sh(sudo -u postgres psql -f /tmp/db_init.sql)

[Sun, 16 Oct 2011 04:42:24 -0400] INFO: execute[initialized db] ran successfully
[Sun, 16 Oct 2011 04:42:24 -0400] INFO: Processing service[postgresql] action restart (main::postgres line 33)

[Sun, 16 Oct 2011 04:42:28 -0400] INFO: service[postgresql] restarted
[Sun, 16 Oct 2011 04:42:28 -0400] INFO: Processing package[libssl-dev] action install (main::rails line 1)

[Sun, 16 Oct 2011 04:42:28 -0400] INFO: Processing package[libreadline-dev] action install (main::rails line 2)

[Sun, 16 Oct 2011 04:42:34 -0400] INFO: package[libreadline-dev] installed version 6.1-1
[Sun, 16 Oct 2011 04:42:34 -0400] INFO: Processing execute[install rvm] action run (main::rails line 3)
[Sun, 16 Oct 2011 04:42:34 -0400] INFO: execute[install rvm] sh(curl -s https://rvm.beginrescueend.com/install/rvm -o rvm-installer ; chmod +x rvm-installer ; ./rvm-installer --version latest)

[Sun, 16 Oct 2011 04:42:47 -0400] INFO: execute[install rvm] ran successfully
[Sun, 16 Oct 2011 04:42:47 -0400] INFO: Processing cookbook_file[/home/koi/.bash_profile] action create (main::rails line 9)

[Sun, 16 Oct 2011 04:42:47 -0400] INFO: cookbook_file[/home/koi/.bash_profile] owner changed to 1000

[Sun, 16 Oct 2011 04:42:47 -0400] INFO: cookbook_file[/home/koi/.bash_profile] owner changed to 1000

[Sun, 16 Oct 2011 04:42:47 -0400] INFO: cookbook_file[/home/koi/.bash_profile] mode changed to 644

[Sun, 16 Oct 2011 04:42:47 -0400] INFO: cookbook_file[/home/koi/.bash_profile] created file /home/koi/.bash_profile

[Sun, 16 Oct 2011 04:42:47 -0400] INFO: Processing bash[install ruby-1.9.2-p290 and rubygems 1.8.10] action run (main::rails line 17)

[Sun, 16 Oct 2011 04:42:47 -0400] INFO: bash[install ruby-1.9.2-p290 and rubygems 1.8.10] sh("bash"  "/tmp/chef-script20111016-891-h2z41b-0")

[Sun, 16 Oct 2011 04:47:55 -0400] INFO: bash[install ruby-1.9.2-p290 and rubygems 1.8.10] ran successfully

[Sun, 16 Oct 2011 04:47:55 -0400] INFO: Processing bash[create rails project] action run (main::rails line 35)

[Sun, 16 Oct 2011 04:47:55 -0400] INFO: bash[create rails project] sh("bash"  "/tmp/chef-script20111016-891-1g48fmw-0")

[Sun, 16 Oct 2011 04:47:55 -0400] ERROR: bash[create rails project] (main::rails line 35) has had an error
[Sun, 16 Oct 2011 04:47:55 -0400] ERROR: Running exception handlers
[Sun, 16 Oct 2011 04:47:55 -0400] ERROR: Exception handlers complete

[Sun, 16 Oct 2011 04:47:55 -0400] FATAL: Stacktrace dumped to /var/chef/cache/chef-stacktrace.out

[Sun, 16 Oct 2011 04:47:55 -0400] FATAL: Chef::Exceptions::ShellCommandFailed: bash[create rails project] (main::rails line 35) had an error: Expected process to exit 0, but it exited with 1
---- Begin output of "bash"  "/tmp/chef-script20111016-891-1g48fmw-0" ----
STDOUT: 
STDERR: Invalid application name test. Please give a name which does not match one of the reserved rails words.
---- End output of "bash"  "/tmp/chef-script20111016-891-1g48fmw-0" ----
Ran "bash"  "/tmp/chef-script20111016-891-1g48fmw-0" returned 1

Copying ssh public key


!!!!! ERROR !!!!!


Error initializing environment.

	stkr start -fv test			To retry in verbose mode.

	stkr ssh test			To login to the environment via SSH to troubleshoot.

	stkr stop test			To stop the environment.

	stkr destroy -f test			To stop and delete the environment.

Here are some tips to help you:

	1. Check the error output inside the VM at /var/chef/cache/chef-stacktrace.out by logging in via SSH and fix configuration problems.

	2. Contact help@stackrocket.com for support.