OpenStack Compute (nova)

Vagrant/chef virtual setup fails

Asked by Lorin Hochstein on 2011-03-11

Tried to run OpenStack on my OSX machine using Vagrant and Chef, following instructions from: http://ansolabs.com/articles/single-node-nova-installation-using-vagrant-and-chef.

I'm getting errors that seem to be related to the openstack-dashboard not being installed properly.

Here's a fragment of the output after doing "vagrant up"

Using /usr/lib/python2.6/dist-packages
Finished processing dependencies for django-nova==0.1
[Fri, 11 Mar 2011 12:30:26 +0000] DEBUG: STDERR:
[Fri, 11 Mar 2011 12:30:26 +0000] DEBUG: ---- End output of python setup.py develop ----
[Fri, 11 Mar 2011 12:30:26 +0000] DEBUG: Ran python setup.py develop returned 0
[Fri, 11 Mar 2011 12:30:26 +0000] INFO: Ran execute[python setup.py develop] successfully
[Fri, 11 Mar 2011 12:30:26 +0000] DEBUG: Processing execute[pip install -r /srv/openstack-dashboard/tools/pip-requires] on maverick.hsd1.ca.comcast.net.
[Fri, 11 Mar 2011 12:30:26 +0000] DEBUG: Executing pip install -r /srv/openstack-dashboard/tools/pip-requires
: stdout
[0K[default] [Fri, 11 Mar 2011 12:30:27 +0000] DEBUG: ---- Begin output of pip install -r /srv/openstack-dashboard/tools/pip-requires ----
[Fri, 11 Mar 2011 12:30:27 +0000] DEBUG: STDOUT: Exception:
Traceback (most recent call last):
  File "/usr/lib/pymodules/python2.6/pip/basecommand.py", line 120, in main
    self.run(options, args)
  File "/usr/lib/pymodules/python2.6/pip/commands/install.py", line 158, in run
    for req in parse_requirements(filename, finder=finder, options=options):
  File "/usr/lib/pymodules/python2.6/pip/req.py", line 1344, in parse_requirements
    filename, content = get_file_content(filename, comes_from=comes_from)
  File "/usr/lib/pymodules/python2.6/pip/util.py", line 305, in get_file_content
    f = open(url)
IOError: [Errno 2] No such file or directory: '/srv/openstack-dashboard/tools/pip-requires'

Storing complete log in /home/vagrant/.pip/pip.log

This seems to break the installation process. I can "vagrant ssh" successfully to get into the VirtualBox VM, but from there the /vagrant/novarc file is not there, and trying to launch an instance fails.

Here's the version of openstack-cookbooks I'm using:

[lorin@macbook openstack-cookbooks]$ git show
commit 0ee0cfc4e2ffae3c70ff4e844f61fde45cf57237
Author: termie <email address hidden>
Date: Tue Mar 8 15:32:40 2011 -0800

remove branching of django-nova from dashboard

Here's the full output from doing "vagrant up":

[lorin@macbook ~]$ cd chef
[lorin@macbook chef]$ vagrant up

[0K[default] Provisioning enabled with chef_solo...

[0K[default] Importing base box 'base'...

[0KProgress: 0%
[0KProgress: 14%
[0KProgress: 28%
[0KProgress: 30%
[0KProgress: 34%
[0KProgress: 35%
[0KProgress: 39%
[0KProgress: 44%
[0KProgress: 45%
[0KProgress: 49%
[0KProgress: 50%
[0KProgress: 54%
[0KProgress: 55%
[0KProgress: 65%
[0KProgress: 70%
[0KProgress: 75%
[0KProgress: 99%
[0K[default] Matching MAC address for NAT networking...
[33m
[0K[default] The guest additions on this VM do not match the install version of
VirtualBox! This may cause things such as forwarded ports, shared
folders, and more to not work properly. If any of those things fail on
this machine, please update the guest additions and repackage the
box.

Guest Additions Version: 4.0.2
VirtualBox Version: 4.0.4[0m

[0K[default] Running any VM customizations...

[0K[default] Clearing any previously set forwarded ports...

[0K[default] Forwarding ports...

[0K[default] -- ssh: 22 => 2222 (adapter 1)

[0K[default] Creating shared folders metadata...

[0K[default] Preparing host only network...

[0K[default] Creating new host only network for environment...

[0K[default] Booting VM...

[0K[default] Waiting for VM to boot. This can take a few minutes.

[0K[default] VM booted and ready for use!

[0K[default] Enabling host only network...

[0K[default] Mounting shared folders...

[0K[default] -- v-csc-0: /tmp/vagrant-chef/cookbooks-0

[0K[default] -- v-root: /vagrant

[0K[default] -- v-csr-0: /tmp/vagrant-chef/roles-0

[0K[default] -- v-apt: /var/cache/apt

[0K[default] Running provisioner: Vagrant::Provisioners::ChefSolo...

[0K[default] Generating chef JSON and uploading...

[0K[default] Running chef-solo...

[0K[default] [Fri, 11 Mar 2011 12:21:04 +0000] DEBUG: Building node object for
[Fri, 11 Mar 2011 12:21:04 +0000] DEBUG: Extracting run list from JSON attributes provided on command line
[Fri, 11 Mar 2011 12:21:04 +0000] INFO: Setting the run_list to ["recipe[nova::hostname]", "recipe[anso::devpackages]", "recipe[nova::filevg]", "recipe[nova]", "recipe[nova::creds]"] from JSON
[Fri, 11 Mar 2011 12:21:04 +0000] DEBUG: Applying attributes from json file
[Fri, 11 Mar 2011 12:21:04 +0000] DEBUG: Platform is ubuntu version 10.10
[Fri, 11 Mar 2011 12:21:04 +0000] INFO: Starting Chef Run (Version 0.9.12)
[Fri, 11 Mar 2011 12:21:04 +0000] DEBUG: Loading cookbook mysql's library file: /tmp/vagrant-chef/cookbooks-0/mysql/libraries/database.rb
[Fri, 11 Mar 2011 12:21:04 +0000] WARN: Missing gem 'mysql'
[Fri, 11 Mar 2011 12:21:04 +0000] DEBUG: Loading cookbook openssl's library file: /tmp/vagrant-chef/cookbooks-0/openssl/libraries/secure_password.rb
[Fri, 11 Mar 2011 12:21:04 +0000] DEBUG: Loading cookbook mysql's providers from /tmp/vagrant-chef/cookbooks-0/mysql/providers/database.rb
[Fri, 11 Mar 2011 12:21:04 +0000] DEBUG: Loaded contents of /tmp/vagrant-chef/cookbooks-0/mysql/providers/database.rb into a provider named mysql_database defined in Chef::Provider::MysqlDatabase
[Fri, 11 Mar 2011 12:21:04 +0000] DEBUG: Loading cookbook daemontools's providers from /tmp/vagrant-chef/cookbooks-0/daemontools/providers/service.rb
[Fri, 11 Mar 2011 12:21:04 +0000] DEBUG: Loaded contents of /tmp/vagrant-chef/cookbooks-0/daemontools/providers/service.rb into a provider named daemontools_service defined in Chef::Provider::DaemontoolsService
[Fri, 11 Mar 2011 12:21:04 +0000] DEBUG: Loading cookbook apt's providers from /tmp/vagrant-chef/cookbooks-0/apt/providers/repository.rb
[Fri, 11 Mar 2011 12:21:04 +0000] DEBUG: Loaded contents of /tmp/vagrant-chef/cookbooks-0/apt/providers/repository.rb into a provider named apt_repository defined in Chef::Provider::AptRepository
[Fri, 11 Mar 2011 12:21:04 +0000] DEBUG: Loading cookbook bluepill's providers from /tmp/vagrant-chef/cookbooks-0/bluepill/providers/service.rb
[Fri, 11 Mar 2011 12:21:04 +0000] DEBUG: Loaded contents of /tmp/vagrant-chef/cookbooks-0/bluepill/providers/service.rb into a provider named bluepill_service defined in Chef::Provider::BluepillService
[Fri, 11 Mar 2011 12:21:04 +0000] DEBUG: Loading cookbook mysql's resources from /tmp/vagrant-chef/cookbooks-0/mysql/resources/database.rb
[Fri, 11 Mar 2011 12:21:04 +0000] DEBUG: Loaded contents of /tmp/vagrant-chef/cookbooks-0/mysql/resources/database.rb into a resource named mysql_database defined in Chef::Resource::MysqlDatabase
[Fri, 11 Mar 2011 12:21:04 +0000] DEBUG: Loading cookbook daemontools's resources from /tmp/vagrant-chef/cookbooks-0/daemontools/resources/service.rb
[Fri, 11 Mar 2011 12:21:04 +0000] DEBUG: Loaded contents of /tmp/vagrant-chef/cookbooks-0/daemontools/resources/service.rb into a resource named daemontools_service defined in Chef::Resource::DaemontoolsService
[Fri, 11 Mar 2011 12:21:04 +0000] DEBUG: Loading cookbook apt's resources from /tmp/vagrant-chef/cookbooks-0/apt/resources/repository.rb
[Fri, 11 Mar 2011 12:21:04 +0000] DEBUG: Loaded contents of /tmp/vagrant-chef/cookbooks-0/apt/resources/repository.rb into a resource named apt_repository defined in Chef::Resource::AptRepository
[Fri, 11 Mar 2011 12:21:04 +0000] DEBUG: Loading cookbook bluepill's resources from /tmp/vagrant-chef/cookbooks-0/bluepill/resources/service.rb
[Fri, 11 Mar 2011 12:21:04 +0000] DEBUG: Loaded contents of /tmp/vagrant-chef/cookbooks-0/bluepill/resources/service.rb into a resource named bluepill_service defined in Chef::Resource::BluepillService
[Fri, 11 Mar 2011 12:21:04 +0000] DEBUG: node maverick.hsd1.ca.comcast.net. loading cookbook glance's attribute file /tmp/vagrant-chef/cookbooks-0/glance/attributes/default.rb
[Fri, 11 Mar 2011 12:21:04 +0000] DEBUG: node maverick.hsd1.ca.comcast.net. loading cookbook nova's attribute file /tmp/vagrant-chef/cookbooks-0/nova/attributes/dashboard.rb
[Fri, 11 Mar 2011 12:21:04 +0000] DEBUG: node maverick.hs: stdout
[0K[default] d1.ca.comcast.net. loading cookbook nova's attribute file /tmp/vagrant-chef/cookbooks-0/nova/attributes/source.rb
[Fri, 11 Mar 2011 12:21:04 +0000] DEBUG: node maverick.hsd1.ca.comcast.net. loading cookbook nova's attribute file /tmp/vagrant-chef/cookbooks-0/nova/attributes/rabbit.rb
[Fri, 11 Mar 2011 12:21:04 +0000] DEBUG: node maverick.hsd1.ca.comcast.net. loading cookbook nova's attribute file /tmp/vagrant-chef/cookbooks-0/nova/attributes/mysql.rb
[Fri, 11 Mar 2011 12:21:04 +0000] DEBUG: node maverick.hsd1.ca.comcast.net. loading cookbook nova's attribute file /tmp/vagrant-chef/cookbooks-0/nova/attributes/default.rb
[Fri, 11 Mar 2011 12:21:04 +0000] DEBUG: node maverick.hsd1.ca.comcast.net. loading cookbook runit's attribute file /tmp/vagrant-chef/cookbooks-0/runit/attributes/default.rb
[Fri, 11 Mar 2011 12:21:04 +0000] DEBUG: node maverick.hsd1.ca.comcast.net. loading cookbook mysql's attribute file /tmp/vagrant-chef/cookbooks-0/mysql/attributes/server.rb
[Fri, 11 Mar 2011 12:21:04 +0000] DEBUG: node maverick.hsd1.ca.comcast.net. loading cookbook anso's attribute file /tmp/vagrant-chef/cookbooks-0/anso/attributes/default.rb
[Fri, 11 Mar 2011 12:21:04 +0000] DEBUG: node maverick.hsd1.ca.comcast.net. loading cookbook anso's attribute file /tmp/vagrant-chef/cookbooks-0/anso/attributes/cookbooks.rb
[Fri, 11 Mar 2011 12:21:04 +0000] DEBUG: node maverick.hsd1.ca.comcast.net. loading cookbook ohai's attribute file /tmp/vagrant-chef/cookbooks-0/ohai/attributes/default.rb
[Fri, 11 Mar 2011 12:21:04 +0000] DEBUG: node maverick.hsd1.ca.comcast.net. loading cookbook daemontools's attribute file /tmp/vagrant-chef/cookbooks-0/daemontools/attributes/default.rb
[Fri, 11 Mar 2011 12:21:04 +0000] DEBUG: node maverick.hsd1.ca.comcast.net. loading cookbook couchdb's attribute file /tmp/vagrant-chef/cookbooks-0/couchdb/attributes/default.rb
[Fri, 11 Mar 2011 12:21:04 +0000] DEBUG: node maverick.hsd1.ca.comcast.net. loading cookbook nginx's attribute file /tmp/vagrant-chef/cookbooks-0/nginx/attributes/default.rb
[Fri, 11 Mar 2011 12:21:05 +0000] DEBUG: node maverick.hsd1.ca.comcast.net. loading cookbook java's attribute file /tmp/vagrant-chef/cookbooks-0/java/attributes/default.rb
[Fri, 11 Mar 2011 12:21:05 +0000] DEBUG: node maverick.hsd1.ca.comcast.net. loading cookbook openldap's attribute file /tmp/vagrant-chef/cookbooks-0/openldap/attributes/default.rb
[Fri, 11 Mar 2011 12:21:05 +0000] DEBUG: node maverick.hsd1.ca.comcast.net. loading cookbook chef's attribute file /tmp/vagrant-chef/cookbooks-0/chef/attributes/server_proxy.rb
[Fri, 11 Mar 2011 12:21:05 +0000] DEBUG: Loading Attribute apache2
[Fri, 11 Mar 2011 12:21:05 +0000] DEBUG: Loading Attribute chef
[Fri, 11 Mar 2011 12:21:05 +0000] DEBUG: node maverick.hsd1.ca.comcast.net. loading cookbook chef's attribute file /tmp/vagrant-chef/cookbooks-0/chef/attributes/default.rb
[Fri, 11 Mar 2011 12:21:05 +0000] DEBUG: node maverick.hsd1.ca.comcast.net. loading cookbook apache2's attribute file /tmp/vagrant-chef/cookbooks-0/apache2/attributes/default.rb
[Fri, 11 Mar 2011 12:21:05 +0000] DEBUG: node maverick.hsd1.ca.comcast.net. loading cookbook ucspi-tcp's attribute file /tmp/vagrant-chef/cookbooks-0/ucspi-tcp/attributes/default.rb
[Fri, 11 Mar 2011 12:21:05 +0000] DEBUG: node maverick.hsd1.ca.comcast.net. loading cookbook erlang's attribute file /tmp/vagrant-chef/cookbooks-0/erlang/attributes/default.rb
[Fri, 11 Mar 2011 12:21:05 +0000] DEBUG: node maverick.hsd1.ca.comcast.net. loading cookbook swift's attribute file /tmp/vagrant-chef/cookbooks-0/swift/attributes/default.rb
[Fri, 11 Mar 2011 12:21:05 +0000] DEBUG: node maverick.hsd1.ca.comcast.net. loading cookbook rabbitmq's attribute file /tmp/vagrant-chef/cookbooks-0/rabbitmq/attributes/rabbitmq.rb
[Fri, 11 Mar 2011 12:21:05 +0000] DEBUG: node maverick.hsd1.ca.comcast.net. loading cookbook bluepill's attribute file /tmp/vagrant-chef/cookbooks-0/bluepill/attributes/default.rb
[Fri, 11 Mar 2011 12:21:05 +0000] DEBUG: Loading cookbook glance's definitions from /tmp/vagrant-chef/cookbooks-0/glance/definitions/glance_service.rb
[Fri, 11 Mar: stdout

[0K[default] 2011 12:21:05 +0000] DEBUG: Loading cookbook nova's definitions from /tmp/vagrant-chef/cookbooks-0/nova/definitions/nova_package.rb
[Fri, 11 Mar 2011 12:21:05 +0000] DEBUG: Loading cookbook runit's definitions from /tmp/vagrant-chef/cookbooks-0/runit/definitions/runit_service.rb
[Fri, 11 Mar 2011 12:21:05 +0000] DEBUG: Loading cookbook nginx's definitions from /tmp/vagrant-chef/cookbooks-0/nginx/definitions/nginx_site.rb
[Fri, 11 Mar 2011 12:21:05 +0000] DEBUG: Loading cookbook apache2's definitions from /tmp/vagrant-chef/cookbooks-0/apache2/definitions/apache_conf.rb
[Fri, 11 Mar 2011 12:21:05 +0000] DEBUG: Loading cookbook apache2's definitions from /tmp/vagrant-chef/cookbooks-0/apache2/definitions/apache_module.rb
[Fri, 11 Mar 2011 12:21:05 +0000] DEBUG: Loading cookbook apache2's definitions from /tmp/vagrant-chef/cookbooks-0/apache2/definitions/web_app.rb
[Fri, 11 Mar 2011 12:21:05 +0000] DEBUG: Loading cookbook apache2's definitions from /tmp/vagrant-chef/cookbooks-0/apache2/definitions/apache_site.rb
[Fri, 11 Mar 2011 12:21:05 +0000] DEBUG: Loading Recipe nova::hostname via include_recipe
[Fri, 11 Mar 2011 12:21:05 +0000] DEBUG: Found recipe hostname in cookbook nova
[Fri, 11 Mar 2011 12:21:05 +0000] DEBUG: Loading Recipe anso::devpackages via include_recipe
[Fri, 11 Mar 2011 12:21:05 +0000] DEBUG: Found recipe devpackages in cookbook anso
[Fri, 11 Mar 2011 12:21:05 +0000] DEBUG: Loading Recipe apt via include_recipe
[Fri, 11 Mar 2011 12:21:05 +0000] DEBUG: Found recipe default in cookbook apt
[Fri, 11 Mar 2011 12:21:05 +0000] DEBUG: Executing apt-get update
: stdout

[0K[default] [Fri, 11 Mar 2011 12:21:09 +0000] DEBUG: ---- Begin output of apt-get update ----
[Fri, 11 Mar 2011 12:21:09 +0000] DEBUG: STDOUT: Get:1 http://security.ubuntu.com maverick-security Release.gpg [198B]
Ign http://security.ubuntu.com/ubuntu/ maverick-security/main Translation-en
Ign http://security.ubuntu.com/ubuntu/ maverick-security/multiverse Translation-en
Hit http://us.archive.ubuntu.com maverick Release.gpg
Ign http://us.archive.ubuntu.com/ubuntu/ maverick/main Translation-en
Ign http://us.archive.ubuntu.com/ubuntu/ maverick/multiverse Translation-en
Ign http://security.ubuntu.com/ubuntu/ maverick-security/restricted Translation-en
Ign http://security.ubuntu.com/ubuntu/ maverick-security/universe Translation-en
Get:2 http://security.ubuntu.com maverick-security Release [31.4kB]
Ign http://us.archive.ubuntu.com/ubuntu/ maverick/restricted Translation-en
Ign http://us.archive.ubuntu.com/ubuntu/ maverick/universe Translation-en
Get:3 http://us.archive.ubuntu.com maverick-updates Release.gpg [198B]
Ign http://us.archive.ubuntu.com/ubuntu/ maverick-updates/main Translation-en
Ign http://us.archive.ubuntu.com/ubuntu/ maverick-updates/multiverse Translation-en
Ign http://us.archive.ubuntu.com/ubuntu/ maverick-updates/restricted Translation-en
Ign http://us.archive.ubuntu.com/ubuntu/ maverick-updates/universe Translation-en
Hit http://us.archive.ubuntu.com maverick Release
Get:4 http://us.archive.ubuntu.com maverick-updates Release [31.4kB]
Get:5 http://security.ubuntu.com maverick-security/main Sources [31.1kB]
Get:6 http://security.ubuntu.com maverick-security/restricted Sources [14B]
Hit http://us.archive.ubuntu.com maverick/main Sources
Hit http://us.archive.ubuntu.com maverick/restricted Sources
Hit http://us.archive.ubuntu.com maverick/universe Sources
Hit http://us.archive.ubuntu.com maverick/multiverse Sources
Hit http://us.archive.ubuntu.com maverick/main amd64 Packages
Get:7 http://security.ubuntu.com maverick-security/universe Sources [12.1kB]
Get:8 http://security.ubuntu.com maverick-security/multiverse Sources [643B]
Get:9 http://security.ubuntu.com maverick-security/main amd64 Packages [107kB]
Hit http://us.archive.ubuntu.com maverick/restricted amd64 Packages
Hit http://us.archive.ubuntu.com maverick/universe amd64 Packages
Hit http://us.archive.ubuntu.com maverick/multiverse amd64 Packages
Get:10 http://us.archive.ubuntu.com maverick-updates/main Sources [90.8kB]
Get:11 http://security.ubuntu.com maverick-security/restricted amd64 Packages [14B]
Get:12 http://security.ubuntu.com maverick-security/universe amd64 Packages [49.5kB]
Get:13 http://security.ubuntu.com maverick-security/multiverse amd64 Packages [1512B]
Get:14 http://us.archive.ubuntu.com maverick-updates/restricted Sources [778B]
Get:15 http://us.archive.ubuntu.com maverick-updates/universe Sources [36.2kB]
Get:16 http://us.archive.ubuntu.com maverick-updates/multiverse Sources [1498B]
Get:17 http://us.archive.ubuntu.com maverick-updates/main amd64 Packages [249kB]
Get:18 http://us.archive.ubuntu.com maverick-updates/restricted amd64 Packages [1802B]
Get:19 http://us.archive.ubuntu.com maverick-updates/universe amd64 Packages [107kB]
Get:20 http://us.archive.ubuntu.com maverick-updates/multiverse amd64 Packages [2703B]
Fetched 754kB in 1s (398kB/s)
Reading package lists...
[Fri, 11 Mar 2011 12:21:09 +0000] DEBUG: STDERR:
[Fri, 11 Mar 2011 12:21:09 +0000] DEBUG: ---- End output of apt-get update ----
[Fri, 11 Mar 2011 12:21:09 +0000] DEBUG: Ran apt-get update returned 0
[Fri, 11 Mar 2011 12:21:09 +0000] INFO: Ran execute[apt-get update] successfully
[Fri, 11 Mar 2011 12:21:09 +0000] DEBUG: Loading Recipe nova::filevg via include_recipe
[Fri, 11 Mar 2011 12:21:09 +0000] DEBUG: Found recipe filevg in cookbook nova
[Fri, 11 Mar 2011 12:21:09 +0000] DEBUG: I am not loading apt, because I have already seen it.
[Fri, 11 Mar 2011 12:21:09 +0000] DEBUG: Loading Recipe nova via include_recipe
[Fri, 11 Mar 2011 12:21:09 +0000] DEBUG: Found recipe default in cookbook nova
[Fri, 11 Mar 2011 12:21:09 +0000] DEBUG: Loading Recipe nova::all via include_recipe
[Fr: stdout
[0K[default] i, 11 Mar 2011 12:21:09 +0000] DEBUG: Found recipe all in cookbook nova
[Fri, 11 Mar 2011 12:21:09 +0000] DEBUG: Loading Recipe nova::mysql via include_recipe
[Fri, 11 Mar 2011 12:21:09 +0000] DEBUG: Found recipe mysql in cookbook nova
[Fri, 11 Mar 2011 12:21:09 +0000] INFO: Mysql recipe included
[Fri, 11 Mar 2011 12:21:09 +0000] DEBUG: Loading Recipe mysql::server via include_recipe
[Fri, 11 Mar 2011 12:21:09 +0000] DEBUG: Found recipe server in cookbook mysql
[Fri, 11 Mar 2011 12:21:09 +0000] DEBUG: Loading Recipe mysql::client via include_recipe
[Fri, 11 Mar 2011 12:21:09 +0000] DEBUG: Found recipe client in cookbook mysql
[Fri, 11 Mar 2011 12:21:09 +0000] DEBUG: Checking apt-cache policy for libmysqlclient-dev
: stdout

[0K[default] [Fri, 11 Mar 2011 12:21:09 +0000] DEBUG: Current version is nil
[Fri, 11 Mar 2011 12:21:09 +0000] DEBUG: Current version is 5.1.49-1ubuntu8.1
[Fri, 11 Mar 2011 12:21:09 +0000] INFO: Installing package[mysql-devel] version 5.1.49-1ubuntu8.1
[Fri, 11 Mar 2011 12:21:09 +0000] DEBUG: Executing apt-get -q -y install libmysqlclient-dev=5.1.49-1ubuntu8.1
: stdout

[0K[default] [Fri, 11 Mar 2011 12:21:15 +0000] DEBUG: ---- Begin output of apt-get -q -y install libmysqlclient-dev=5.1.49-1ubuntu8.1 ----
[Fri, 11 Mar 2011 12:21:15 +0000] 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 71 not upgraded.
Need to get 0B/5,413kB of archives.
After this operation, 14.9MB of additional disk space will be used.
Selecting previously deselected package mysql-common.
(Reading database ... 46333 files and directories currently installed.)
Unpacking mysql-common (from .../mysql-common_5.1.49-1ubuntu8.1_all.deb) ...
Selecting previously deselected package libmysqlclient16.
Unpacking libmysqlclient16 (from .../libmysqlclient16_5.1.49-1ubuntu8.1_amd64.deb) ...
Selecting previously deselected package zlib1g-dev.
Unpacking zlib1g-dev (from .../zlib1g-dev_1%3a1.2.3.4.dfsg-3ubuntu1_amd64.deb) ...
Selecting previously deselected package libmysqlclient-dev.
Unpacking libmysqlclient-dev (from .../libmysqlclient-dev_5.1.49-1ubuntu8.1_amd64.deb) ...
Processing triggers for man-db ...
Setting up mysql-common (5.1.49-1ubuntu8.1) ...
Setting up libmysqlclient16 (5.1.49-1ubuntu8.1) ...
Setting up zlib1g-dev (1:1.2.3.4.dfsg-3ubuntu1) ...
Setting up libmysqlclient-dev (5.1.49-1ubuntu8.1) ...
Processing triggers for libc-bin ...
ldconfig deferred processing now taking place
[Fri, 11 Mar 2011 12:21:15 +0000] DEBUG: STDERR:
[Fri, 11 Mar 2011 12:21:15 +0000] DEBUG: ---- End output of apt-get -q -y install libmysqlclient-dev=5.1.49-1ubuntu8.1 ----
[Fri, 11 Mar 2011 12:21:15 +0000] DEBUG: Ran apt-get -q -y install libmysqlclient-dev=5.1.49-1ubuntu8.1 returned 0
[Fri, 11 Mar 2011 12:21:15 +0000] DEBUG: Checking apt-cache policy for mysql-client
: stdout
[0K[default] [Fri, 11 Mar 2011 12:21:16 +0000] DEBUG: Current version is nil
[Fri, 11 Mar 2011 12:21:16 +0000] DEBUG: Current version is 5.1.49-1ubuntu8.1
[Fri, 11 Mar 2011 12:21:16 +0000] INFO: Installing package[mysql-client] version 5.1.49-1ubuntu8.1
[Fri, 11 Mar 2011 12:21:16 +0000] DEBUG: Executing apt-get -q -y install mysql-client=5.1.49-1ubuntu8.1
: stdout

[0K[default] [Fri, 11 Mar 2011 12:21:29 +0000] DEBUG: ---- Begin output of apt-get -q -y install mysql-client=5.1.49-1ubuntu8.1 ----
[Fri, 11 Mar 2011 12:21:29 +0000] 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
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 71 not upgraded.
Need to get 0B/9,936kB of archives.
After this operation, 26.6MB of additional disk space will be used.
Selecting previously deselected package libnet-daemon-perl.
(Reading database ... 46439 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.611-1_amd64.deb) ...
Selecting previously deselected package libdbd-mysql-perl.
Unpacking libdbd-mysql-perl (from .../libdbd-mysql-perl_4.016-1_amd64.deb) ...
Selecting previously deselected package mysql-client-core-5.1.
Unpacking mysql-client-core-5.1 (from .../mysql-client-core-5.1_5.1.49-1ubuntu8.1_amd64.deb) ...
Selecting previously deselected package mysql-client-5.1.
Unpacking mysql-client-5.1 (from .../mysql-client-5.1_5.1.49-1ubuntu8.1_amd64.deb) ...
Selecting previously deselected package mysql-client.
Unpacking mysql-client (from .../mysql-client_5.1.49-1ubuntu8.1_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.611-1) ...
Setting up libdbd-mysql-perl (4.016-1) ...
Setting up mysql-client-core-5.1 (5.1.49-1ubuntu8.1) ...
Setting up mysql-client-5.1 (5.1.49-1ubuntu8.1) ...
Setting up mysql-client (5.1.49-1ubuntu8.1) ...
[Fri, 11 Mar 2011 12:21:29 +0000] DEBUG: STDERR:
[Fri, 11 Mar 2011 12:21:29 +0000] DEBUG: ---- End output of apt-get -q -y install mysql-client=5.1.49-1ubuntu8.1 ----
[Fri, 11 Mar 2011 12:21:29 +0000] DEBUG: Ran apt-get -q -y install mysql-client=5.1.49-1ubuntu8.1 returned 0
[Fri, 11 Mar 2011 12:21:29 +0000] DEBUG: No installed version found for mysql (>= 0, runtime)
[Fri, 11 Mar 2011 12:21:31 +0000] DEBUG: Found gem mysql version 2.8.1 for platform ruby from http://rubygems.org/
[Fri, 11 Mar 2011 12:21:31 +0000] INFO: Installing gem_package[mysql] version 2.8.1
Building native extensions. This could take a while...
[Fri, 11 Mar 2011 12:21:37 +0000] DEBUG: Found installed gem mysql version 2.8.1 matching mysql (>= 0, runtime)
[Fri, 11 Mar 2011 12:21:37 +0000] DEBUG: Setting directory[/var/cache/local/preseeding] to the state of the prior directory[/var/cache/local/preseeding]
[Fri, 11 Mar 2011 12:21:37 +0000] WARN: Could not find previously defined grants.sql resource
[Fri, 11 Mar 2011 12:21:38 +0000] DEBUG: Loading Recipe nova::rabbit via include_recipe
[Fri, 11 Mar 2011 12:21:38 +0000] DEBUG: Found recipe rabbit in cookbook nova
[Fri, 11 Mar 2011 12:21:38 +0000] DEBUG: Loading Recipe rabbitmq via include_recipe
[Fri, 11 Mar 2011 12:21:38 +0000] DEBUG: Found recipe default in cookbook rabbitmq
[Fri, 11 Mar 2011 12:21:38 +0000] DEBUG: Loading Recipe nova::common via include_recipe
[Fri, 11 Mar 2011 12:21:38 +0000] DEBUG: Found recipe common in cookbook nova
[Fri, 11 Mar 2011 12:21:38 +0000] DEBUG: I am not loading apt, because I have already seen it.
[Fri, 11 Mar 2011 12:21:38 +0000] INFO: Using mysql
[Fri, 11 Mar 2011 12:21:38 +0000] INFO: Using local mysql at 192.168.86.100
[Fri, 11 Mar 2011 12:21:38 +0000] INFO: Using local rabbit at 192.168.86.100
[Fri, 11 Mar 2011 12:21:38 +0000] INFO: Objectstore server found at 192.168.86.100
[Fri, 11 Mar 2011 12:21:38 +0000] INFO: Network server found at 192.168.86.100
[Fri, 11 Mar 2: stdout
[0K[default] 011 12:21:38 +0000] DEBUG: Loading Recipe nova::api via include_recipe
[Fri, 11 Mar 2011 12:21:38 +0000] DEBUG: Found recipe api in cookbook nova
[Fri, 11 Mar 2011 12:21:38 +0000] DEBUG: I am not loading nova::common, because I have already seen it.
[Fri, 11 Mar 2011 12:21:38 +0000] DEBUG: Loading Recipe nova::scheduler via include_recipe
[Fri, 11 Mar 2011 12:21:38 +0000] DEBUG: Found recipe scheduler in cookbook nova
[Fri, 11 Mar 2011 12:21:38 +0000] DEBUG: I am not loading nova::common, because I have already seen it.
[Fri, 11 Mar 2011 12:21:38 +0000] DEBUG: Loading Recipe nova::network via include_recipe
[Fri, 11 Mar 2011 12:21:38 +0000] DEBUG: Found recipe network in cookbook nova
[Fri, 11 Mar 2011 12:21:38 +0000] DEBUG: I am not loading nova::common, because I have already seen it.
[Fri, 11 Mar 2011 12:21:38 +0000] DEBUG: Loading Recipe nova::objectstore via include_recipe
[Fri, 11 Mar 2011 12:21:38 +0000] DEBUG: Found recipe objectstore in cookbook nova
[Fri, 11 Mar 2011 12:21:38 +0000] DEBUG: I am not loading nova::common, because I have already seen it.
[Fri, 11 Mar 2011 12:21:38 +0000] DEBUG: Loading Recipe nova::compute via include_recipe
[Fri, 11 Mar 2011 12:21:38 +0000] DEBUG: Found recipe compute in cookbook nova
[Fri, 11 Mar 2011 12:21:38 +0000] DEBUG: I am not loading nova::common, because I have already seen it.
[Fri, 11 Mar 2011 12:21:38 +0000] DEBUG: Loading Recipe nova::volume via include_recipe
[Fri, 11 Mar 2011 12:21:38 +0000] DEBUG: Found recipe volume in cookbook nova
[Fri, 11 Mar 2011 12:21:38 +0000] DEBUG: I am not loading nova::common, because I have already seen it.
[Fri, 11 Mar 2011 12:21:38 +0000] DEBUG: Loading Recipe nova::setup via include_recipe
[Fri, 11 Mar 2011 12:21:38 +0000] DEBUG: Found recipe setup in cookbook nova
[Fri, 11 Mar 2011 12:21:38 +0000] DEBUG: I am not loading apt, because I have already seen it.
[Fri, 11 Mar 2011 12:21:38 +0000] DEBUG: Loading Recipe nova::dashboard via include_recipe
[Fri, 11 Mar 2011 12:21:38 +0000] DEBUG: Found recipe dashboard in cookbook nova
[Fri, 11 Mar 2011 12:21:38 +0000] DEBUG: Setting directory[/srv] to the state of the prior directory[/srv]
[Fri, 11 Mar 2011 12:21:38 +0000] DEBUG: Loading Recipe nova::creds via include_recipe
[Fri, 11 Mar 2011 12:21:38 +0000] DEBUG: Found recipe creds in cookbook nova
[Fri, 11 Mar 2011 12:21:38 +0000] DEBUG: loading from cookbook_path: /tmp/vagrant-chef/cookbooks-0
[Fri, 11 Mar 2011 12:21:38 +0000] DEBUG: Converging node maverick.hsd1.ca.comcast.net.
[Fri, 11 Mar 2011 12:21:38 +0000] DEBUG: Processing execute[/root/hostname.sh] on maverick.hsd1.ca.comcast.net.
[Fri, 11 Mar 2011 12:21:38 +0000] DEBUG: Doing nothing for execute[/root/hostname.sh]
[Fri, 11 Mar 2011 12:21:38 +0000] DEBUG: Processing template[/root/hostname.sh] on maverick.hsd1.ca.comcast.net.
[Fri, 11 Mar 2011 12:21:38 +0000] DEBUG: looking for template hostname.erb in cookbook :nova
[Fri, 11 Mar 2011 12:21:38 +0000] DEBUG: Current content's checksum:
[Fri, 11 Mar 2011 12:21:38 +0000] DEBUG: Rendered content's checksum: 5caed8c4d3dd4b40acd15210e0a2c0d9ed268cb1f177280540addb984e5245b1
[Fri, 11 Mar 2011 12:21:38 +0000] INFO: Writing updated content for template[/root/hostname.sh] to /root/hostname.sh
[Fri, 11 Mar 2011 12:21:38 +0000] DEBUG: setting mode on /tmp/chef-rendered-template20110311-1016-g333rl-0 to 755
[Fri, 11 Mar 2011 12:21:38 +0000] INFO: template[/root/hostname.sh] sending run action to execute[/root/hostname.sh] (immediate)
[Fri, 11 Mar 2011 12:21:38 +0000] DEBUG: Executing /root/hostname.sh
: stdout
[0K[default] [Fri, 11 Mar 2011 12:21:38 +0000] DEBUG: ---- Begin output of /root/hostname.sh ----
[Fri, 11 Mar 2011 12:21:38 +0000] DEBUG: STDOUT:
[Fri, 11 Mar 2011 12:21:38 +0000] DEBUG: STDERR:
[Fri, 11 Mar 2011 12:21:38 +0000] DEBUG: ---- End output of /root/hostname.sh ----
[Fri, 11 Mar 2011 12:21:38 +0000] DEBUG: Ran /root/hostname.sh returned 0
[Fri, 11 Mar 2011 12:21:38 +0000] INFO: Ran execute[/root/hostname.sh] successfully
[Fri, 11 Mar 2011 12:21:38 +0000] DEBUG: Processing execute[apt-get update] on maverick.hsd1.ca.comcast.net.
[Fri, 11 Mar 2011 12:21:38 +0000] DEBUG: Doing nothing for execute[apt-get update]
[Fri, 11 Mar 2011 12:21:38 +0000] DEBUG: Processing directory[/var/cache/local] on maverick.hsd1.ca.comcast.net.
[Fri, 11 Mar 2011 12:21:38 +0000] INFO: Creating directory[/var/cache/local] at /var/cache/local
[Fri, 11 Mar 2011 12:21:38 +0000] INFO: Setting owner to 0 for directory[/var/cache/local]
[Fri, 11 Mar 2011 12:21:38 +0000] INFO: Setting group to 0 for directory[/var/cache/local]
[Fri, 11 Mar 2011 12:21:38 +0000] INFO: Setting mode to 755 for directory[/var/cache/local]
[Fri, 11 Mar 2011 12:21:38 +0000] DEBUG: Processing directory[/var/cache/local/preseeding] on maverick.hsd1.ca.comcast.net.
[Fri, 11 Mar 2011 12:21:38 +0000] INFO: Creating directory[/var/cache/local/preseeding] at /var/cache/local/preseeding
[Fri, 11 Mar 2011 12:21:38 +0000] INFO: Setting owner to 0 for directory[/var/cache/local/preseeding]
[Fri, 11 Mar 2011 12:21:38 +0000] INFO: Setting group to 0 for directory[/var/cache/local/preseeding]
[Fri, 11 Mar 2011 12:21:38 +0000] INFO: Setting mode to 755 for directory[/var/cache/local/preseeding]
[Fri, 11 Mar 2011 12:21:38 +0000] DEBUG: Processing apt_repository[anso] on maverick.hsd1.ca.comcast.net.
[Fri, 11 Mar 2011 12:21:38 +0000] INFO: Adding anso repository to /etc/apt/sources.list.d/anso-source.list
[Fri, 11 Mar 2011 12:21:38 +0000] DEBUG: Executing apt-key adv --keyserver keyserver.ubuntu.com --recv 460DF9BE
: stdout
[0K[default] [Fri, 11 Mar 2011 12:21:39 +0000] DEBUG: ---- Begin output of apt-key adv --keyserver keyserver.ubuntu.com --recv 460DF9BE ----
[Fri, 11 Mar 2011 12:21:39 +0000] DEBUG: STDOUT: Executing: gpg --ignore-time-conflict --no-options --no-default-keyring --secret-keyring /etc/apt/secring.gpg --trustdb-name /etc/apt/trustdb.gpg --keyring /etc/apt/trusted.gpg --primary-keyring /etc/apt/trusted.gpg --keyserver keyserver.ubuntu.com --recv 460DF9BE
[Fri, 11 Mar 2011 12:21:39 +0000] DEBUG: STDERR: gpg: requesting key 460DF9BE from hkp server keyserver.ubuntu.com
gpg: key 460DF9BE: public key "Anso Labs <email address hidden>" imported
gpg: Total number processed: 1
gpg: imported: 1 (RSA: 1)
[Fri, 11 Mar 2011 12:21:39 +0000] DEBUG: ---- End output of apt-key adv --keyserver keyserver.ubuntu.com --recv 460DF9BE ----
[Fri, 11 Mar 2011 12:21:39 +0000] DEBUG: Ran apt-key adv --keyserver keyserver.ubuntu.com --recv 460DF9BE returned 0
[Fri, 11 Mar 2011 12:21:39 +0000] INFO: Ran execute[install-key 460DF9BE] successfully
[Fri, 11 Mar 2011 12:21:39 +0000] DEBUG: Executing apt-get update
: stdout

[0K[default] [Fri, 11 Mar 2011 12:21:41 +0000] DEBUG: ---- Begin output of apt-get update ----
[Fri, 11 Mar 2011 12:21:41 +0000] DEBUG: STDOUT: Hit http://security.ubuntu.com maverick-security Release.gpg
Ign http://security.ubuntu.com/ubuntu/ maverick-security/main Translation-en
Ign http://security.ubuntu.com/ubuntu/ maverick-security/multiverse Translation-en
Hit http://us.archive.ubuntu.com maverick Release.gpg
Ign http://us.archive.ubuntu.com/ubuntu/ maverick/main Translation-en
Ign http://us.archive.ubuntu.com/ubuntu/ maverick/multiverse Translation-en
Ign http://security.ubuntu.com/ubuntu/ maverick-security/restricted Translation-en
Ign http://security.ubuntu.com/ubuntu/ maverick-security/universe Translation-en
Hit http://security.ubuntu.com maverick-security Release
Ign http://us.archive.ubuntu.com/ubuntu/ maverick/restricted Translation-en
Ign http://us.archive.ubuntu.com/ubuntu/ maverick/universe Translation-en
Hit http://us.archive.ubuntu.com maverick-updates Release.gpg
Ign http://us.archive.ubuntu.com/ubuntu/ maverick-updates/main Translation-en
Ign http://us.archive.ubuntu.com/ubuntu/ maverick-updates/multiverse Translation-en
Ign http://us.archive.ubuntu.com/ubuntu/ maverick-updates/restricted Translation-en
Ign http://us.archive.ubuntu.com/ubuntu/ maverick-updates/universe Translation-en
Hit http://us.archive.ubuntu.com maverick Release
Hit http://security.ubuntu.com maverick-security/main Sources
Hit http://us.archive.ubuntu.com maverick-updates Release
Hit http://security.ubuntu.com maverick-security/restricted Sources
Hit http://security.ubuntu.com maverick-security/universe Sources
Hit http://security.ubuntu.com maverick-security/multiverse Sources
Hit http://security.ubuntu.com maverick-security/main amd64 Packages
Hit http://security.ubuntu.com maverick-security/restricted amd64 Packages
Hit http://us.archive.ubuntu.com maverick/main Sources
Hit http://us.archive.ubuntu.com maverick/restricted Sources
Hit http://us.archive.ubuntu.com maverick/universe Sources
Hit http://us.archive.ubuntu.com maverick/multiverse Sources
Hit http://us.archive.ubuntu.com maverick/main amd64 Packages
Hit http://security.ubuntu.com maverick-security/universe amd64 Packages
Hit http://security.ubuntu.com maverick-security/multiverse amd64 Packages
Hit http://us.archive.ubuntu.com maverick/restricted amd64 Packages
Hit http://us.archive.ubuntu.com maverick/universe amd64 Packages
Hit http://us.archive.ubuntu.com maverick/multiverse amd64 Packages
Hit http://us.archive.ubuntu.com maverick-updates/main Sources
Hit http://us.archive.ubuntu.com maverick-updates/restricted Sources
Hit http://us.archive.ubuntu.com maverick-updates/universe Sources
Hit http://us.archive.ubuntu.com maverick-updates/multiverse Sources
Hit http://us.archive.ubuntu.com maverick-updates/main amd64 Packages
Hit http://us.archive.ubuntu.com maverick-updates/restricted amd64 Packages
Hit http://us.archive.ubuntu.com maverick-updates/universe amd64 Packages
Hit http://us.archive.ubuntu.com maverick-updates/multiverse amd64 Packages
Reading package lists...
[Fri, 11 Mar 2011 12:21:41 +0000] DEBUG: STDERR:
[Fri, 11 Mar 2011 12:21:41 +0000] DEBUG: ---- End output of apt-get update ----
[Fri, 11 Mar 2011 12:21:41 +0000] DEBUG: Ran apt-get update returned 0
[Fri, 11 Mar 2011 12:21:41 +0000] INFO: Ran execute[update package index] successfully
[Fri, 11 Mar 2011 12:21:41 +0000] DEBUG: Processing execute[install-key 460DF9BE] on maverick.hsd1.ca.comcast.net.
[Fri, 11 Mar 2011 12:21:41 +0000] DEBUG: Executing apt-key adv --keyserver keyserver.ubuntu.com --recv 460DF9BE
: stdout
[0K[default] [Fri, 11 Mar 2011 12:21:42 +0000] DEBUG: ---- Begin output of apt-key adv --keyserver keyserver.ubuntu.com --recv 460DF9BE ----
[Fri, 11 Mar 2011 12:21:42 +0000] DEBUG: STDOUT: Executing: gpg --ignore-time-conflict --no-options --no-default-keyring --secret-keyring /etc/apt/secring.gpg --trustdb-name /etc/apt/trustdb.gpg --keyring /etc/apt/trusted.gpg --primary-keyring /etc/apt/trusted.gpg --keyserver keyserver.ubuntu.com --recv 460DF9BE
[Fri, 11 Mar 2011 12:21:42 +0000] DEBUG: STDERR: gpg: requesting key 460DF9BE from hkp server keyserver.ubuntu.com
gpg: key 460DF9BE: "Anso Labs <email address hidden>" not changed
gpg: Total number processed: 1
gpg: unchanged: 1
[Fri, 11 Mar 2011 12:21:42 +0000] DEBUG: ---- End output of apt-key adv --keyserver keyserver.ubuntu.com --recv 460DF9BE ----
[Fri, 11 Mar 2011 12:21:42 +0000] DEBUG: Ran apt-key adv --keyserver keyserver.ubuntu.com --recv 460DF9BE returned 0
[Fri, 11 Mar 2011 12:21:42 +0000] INFO: Ran execute[install-key 460DF9BE] successfully
[Fri, 11 Mar 2011 12:21:42 +0000] DEBUG: Processing file[/etc/apt/sources.list.d/anso-source.list] on maverick.hsd1.ca.comcast.net.
[Fri, 11 Mar 2011 12:21:42 +0000] INFO: Creating file[/etc/apt/sources.list.d/anso-source.list] at /etc/apt/sources.list.d/anso-source.list
[Fri, 11 Mar 2011 12:21:42 +0000] INFO: Setting owner to 0 for file[/etc/apt/sources.list.d/anso-source.list]
[Fri, 11 Mar 2011 12:21:42 +0000] INFO: Setting group to 0 for file[/etc/apt/sources.list.d/anso-source.list]
[Fri, 11 Mar 2011 12:21:42 +0000] INFO: Setting mode to 644 for file[/etc/apt/sources.list.d/anso-source.list]
[Fri, 11 Mar 2011 12:21:42 +0000] DEBUG: Processing execute[update package index] on maverick.hsd1.ca.comcast.net.
[Fri, 11 Mar 2011 12:21:42 +0000] DEBUG: Executing apt-get update
: stdout

[0K[default] [Fri, 11 Mar 2011 12:21:45 +0000] DEBUG: ---- Begin output of apt-get update ----
[Fri, 11 Mar 2011 12:21:45 +0000] DEBUG: STDOUT: Get:1 http://devpackages.ansolabs.com maverick Release.gpg [490B]
Ign http://devpackages.ansolabs.com/ maverick/main Translation-en
Get:2 http://devpackages.ansolabs.com maverick Release [11.0kB]
Hit http://security.ubuntu.com maverick-security Release.gpg
Ign http://security.ubuntu.com/ubuntu/ maverick-security/main Translation-en
Ign http://security.ubuntu.com/ubuntu/ maverick-security/multiverse Translation-en
Hit http://us.archive.ubuntu.com maverick Release.gpg
Ign http://us.archive.ubuntu.com/ubuntu/ maverick/main Translation-en
Ign http://us.archive.ubuntu.com/ubuntu/ maverick/multiverse Translation-en
Ign http://security.ubuntu.com/ubuntu/ maverick-security/restricted Translation-en
Ign http://security.ubuntu.com/ubuntu/ maverick-security/universe Translation-en
Ign http://devpackages.ansolabs.com maverick/main amd64 Packages
Get:3 http://devpackages.ansolabs.com maverick/main amd64 Packages [3536B]
Hit http://security.ubuntu.com maverick-security Release
Ign http://us.archive.ubuntu.com/ubuntu/ maverick/restricted Translation-en
Ign http://us.archive.ubuntu.com/ubuntu/ maverick/universe Translation-en
Hit http://us.archive.ubuntu.com maverick-updates Release.gpg
Ign http://us.archive.ubuntu.com/ubuntu/ maverick-updates/main Translation-en
Ign http://us.archive.ubuntu.com/ubuntu/ maverick-updates/multiverse Translation-en
Ign http://us.archive.ubuntu.com/ubuntu/ maverick-updates/restricted Translation-en
Ign http://us.archive.ubuntu.com/ubuntu/ maverick-updates/universe Translation-en
Hit http://us.archive.ubuntu.com maverick Release
Hit http://security.ubuntu.com maverick-security/main Sources
Hit http://us.archive.ubuntu.com maverick-updates Release
Hit http://security.ubuntu.com maverick-security/restricted Sources
Hit http://security.ubuntu.com maverick-security/universe Sources
Hit http://security.ubuntu.com maverick-security/multiverse Sources
Hit http://security.ubuntu.com maverick-security/main amd64 Packages
Hit http://security.ubuntu.com maverick-security/restricted amd64 Packages
Hit http://us.archive.ubuntu.com maverick/main Sources
Hit http://us.archive.ubuntu.com maverick/restricted Sources
Hit http://us.archive.ubuntu.com maverick/universe Sources
Hit http://us.archive.ubuntu.com maverick/multiverse Sources
Hit http://us.archive.ubuntu.com maverick/main amd64 Packages
Hit http://security.ubuntu.com maverick-security/universe amd64 Packages
Hit http://security.ubuntu.com maverick-security/multiverse amd64 Packages
Hit http://us.archive.ubuntu.com maverick/restricted amd64 Packages
Hit http://us.archive.ubuntu.com maverick/universe amd64 Packages
Hit http://us.archive.ubuntu.com maverick/multiverse amd64 Packages
Hit http://us.archive.ubuntu.com maverick-updates/main Sources
Hit http://us.archive.ubuntu.com maverick-updates/restricted Sources
Hit http://us.archive.ubuntu.com maverick-updates/universe Sources
Hit http://us.archive.ubuntu.com maverick-updates/multiverse Sources
Hit http://us.archive.ubuntu.com maverick-updates/main amd64 Packages
Hit http://us.archive.ubuntu.com maverick-updates/restricted amd64 Packages
Hit http://us.archive.ubuntu.com maverick-updates/universe amd64 Packages
Hit http://us.archive.ubuntu.com maverick-updates/multiverse amd64 Packages
Fetched 15.0kB in 0s (16.4kB/s)
Reading package lists...
[Fri, 11 Mar 2011 12:21:45 +0000] DEBUG: STDERR:
[Fri, 11 Mar 2011 12:21:45 +0000] DEBUG: ---- End output of apt-get update ----
[Fri, 11 Mar 2011 12:21:45 +0000] DEBUG: Ran apt-get update returned 0
[Fri, 11 Mar 2011 12:21:45 +0000] INFO: Ran execute[update package index] successfully
[Fri, 11 Mar 2011 12:21:45 +0000] DEBUG: Processing package[lvm2] on maverick.hsd1.ca.comcast.net.
[Fri, 11 Mar 2011 12:21:45 +0000] DEBUG: Checking apt-cache policy for lvm2
: stdout
[0K[default] [Fri, 11 Mar 2011 12:21:45 +0000] DEBUG: Current version is nil
[Fri, 11 Mar 2011 12:21:45 +0000] DEBUG: Current version is 2.02.54-1ubuntu6
[Fri, 11 Mar 2011 12:21:45 +0000] INFO: Installing package[lvm2] version 2.02.54-1ubuntu6
[Fri, 11 Mar 2011 12:21:45 +0000] DEBUG: Executing apt-get -q -y --force-yes install lvm2=2.02.54-1ubuntu6
: stdout

[0K[default] [Fri, 11 Mar 2011 12:22:27 +0000] DEBUG: ---- Begin output of apt-get -q -y --force-yes install lvm2=2.02.54-1ubuntu6 ----
[Fri, 11 Mar 2011 12:22:27 +0000] DEBUG: STDOUT: Reading package lists...
Building dependency tree...
Reading state information...
The following extra packages will be installed:
  libdevmapper-event1.02.1 lvm2 watershed
The following NEW packages will be installed:
  libdevmapper-event1.02.1 lvm2 watershed
0 upgraded, 3 newly installed, 0 to remove and 71 not upgraded.
Need to get 0B/463kB of archives.
After this operation, 1,262kB of additional disk space will be used.
Selecting previously deselected package libdevmapper-event1.02.1.
(Reading database ... 46700 files and directories currently installed.)
Unpacking libdevmapper-event1.02.1 (from .../libdevmapper-event1.02.1_2%3a1.02.39-1ubuntu6_amd64.deb) ...
Selecting previously deselected package watershed.
Unpacking watershed (from .../archives/watershed_5_amd64.deb) ...
Selecting previously deselected package lvm2.
Unpacking lvm2 (from .../lvm2_2.02.54-1ubuntu6_amd64.deb) ...
Processing triggers for man-db ...
Setting up libdevmapper-event1.02.1 (2:1.02.39-1ubuntu6) ...
Setting up watershed (5) ...
update-initramfs: deferring update (trigger activated)
Setting up lvm2 (2.02.54-1ubuntu6) ...
update-initramfs: deferring update (trigger activated)
Processing triggers for libc-bin ...
ldconfig deferred processing now taking place
Processing triggers for initramfs-tools ...
update-initramfs: Generating /boot/initrd.img-2.6.35-22-server
[Fri, 11 Mar 2011 12:22:27 +0000] DEBUG: STDERR:
[Fri, 11 Mar 2011 12:22:27 +0000] DEBUG: ---- End output of apt-get -q -y --force-yes install lvm2=2.02.54-1ubuntu6 ----
[Fri, 11 Mar 2011 12:22:27 +0000] DEBUG: Ran apt-get -q -y --force-yes install lvm2=2.02.54-1ubuntu6 returned 0
[Fri, 11 Mar 2011 12:22:27 +0000] DEBUG: Processing execute[truncate -s 10G /root/nova-volumes] on maverick.hsd1.ca.comcast.net.
[Fri, 11 Mar 2011 12:22:27 +0000] DEBUG: Executing truncate -s 10G /root/nova-volumes
: stdout
[0K[default] [Fri, 11 Mar 2011 12:22:27 +0000] DEBUG: ---- Begin output of truncate -s 10G /root/nova-volumes ----
[Fri, 11 Mar 2011 12:22:27 +0000] DEBUG: STDOUT:
[Fri, 11 Mar 2011 12:22:27 +0000] DEBUG: STDERR:
[Fri, 11 Mar 2011 12:22:27 +0000] DEBUG: ---- End output of truncate -s 10G /root/nova-volumes ----
[Fri, 11 Mar 2011 12:22:27 +0000] DEBUG: Ran truncate -s 10G /root/nova-volumes returned 0
[Fri, 11 Mar 2011 12:22:27 +0000] INFO: Ran execute[truncate -s 10G /root/nova-volumes] successfully
[Fri, 11 Mar 2011 12:22:27 +0000] DEBUG: Processing execute[losetup /dev/loop0 /root/nova-volumes] on maverick.hsd1.ca.comcast.net.
[Fri, 11 Mar 2011 12:22:27 +0000] DEBUG: Executing losetup -a | grep /dev/loop0 || vgs --noheadings -o name | grep nova-volumes
: stdout
[0K[default] [Fri, 11 Mar 2011 12:22:27 +0000] DEBUG: ---- Begin output of losetup -a | grep /dev/loop0 || vgs --noheadings -o name | grep nova-volumes ----
[Fri, 11 Mar 2011 12:22:27 +0000] DEBUG: STDOUT:
[Fri, 11 Mar 2011 12:22:27 +0000] DEBUG: STDERR: File descriptor 3 (socket:[9766]) leaked on vgs invocation. Parent PID 6911: sh
File descriptor 8 (socket:[9757]) leaked on vgs invocation. Parent PID 6911: sh
File descriptor 9 (socket:[9761]) leaked on vgs invocation. Parent PID 6911: sh
File descriptor 14 (pipe:[14280]) leaked on vgs invocation. Parent PID 6911: sh
[Fri, 11 Mar 2011 12:22:27 +0000] DEBUG: ---- End output of losetup -a | grep /dev/loop0 || vgs --noheadings -o name | grep nova-volumes ----
[Fri, 11 Mar 2011 12:22:27 +0000] DEBUG: Ran losetup -a | grep /dev/loop0 || vgs --noheadings -o name | grep nova-volumes returned 1
[Fri, 11 Mar 2011 12:22:27 +0000] DEBUG: Executing losetup /dev/loop0 /root/nova-volumes
: stdout
[0K[default] [Fri, 11 Mar 2011 12:22:27 +0000] DEBUG: ---- Begin output of losetup /dev/loop0 /root/nova-volumes ----
[Fri, 11 Mar 2011 12:22:27 +0000] DEBUG: STDOUT:
[Fri, 11 Mar 2011 12:22:27 +0000] DEBUG: STDERR:
[Fri, 11 Mar 2011 12:22:27 +0000] DEBUG: ---- End output of losetup /dev/loop0 /root/nova-volumes ----
[Fri, 11 Mar 2011 12:22:27 +0000] DEBUG: Ran losetup /dev/loop0 /root/nova-volumes returned 0
[Fri, 11 Mar 2011 12:22:27 +0000] INFO: Ran execute[losetup /dev/loop0 /root/nova-volumes] successfully
[Fri, 11 Mar 2011 12:22:27 +0000] DEBUG: Processing execute[vgcreate nova-volumes /dev/loop0] on maverick.hsd1.ca.comcast.net.
[Fri, 11 Mar 2011 12:22:27 +0000] DEBUG: Executing vgs --noheadings -o name | grep nova-volumes
: stdout
[0K[default] [Fri, 11 Mar 2011 12:22:27 +0000] DEBUG: ---- Begin output of vgs --noheadings -o name | grep nova-volumes ----
[Fri, 11 Mar 2011 12:22:27 +0000] DEBUG: STDOUT:
[Fri, 11 Mar 2011 12:22:27 +0000] DEBUG: STDERR: File descriptor 3 (socket:[9766]) leaked on vgs invocation. Parent PID 6920: sh
File descriptor 8 (socket:[9757]) leaked on vgs invocation. Parent PID 6920: sh
File descriptor 9 (socket:[9761]) leaked on vgs invocation. Parent PID 6920: sh
File descriptor 14 (pipe:[14305]) leaked on vgs invocation. Parent PID 6920: sh
[Fri, 11 Mar 2011 12:22:27 +0000] DEBUG: ---- End output of vgs --noheadings -o name | grep nova-volumes ----
[Fri, 11 Mar 2011 12:22:27 +0000] DEBUG: Ran vgs --noheadings -o name | grep nova-volumes returned 1
[Fri, 11 Mar 2011 12:22:27 +0000] DEBUG: Executing vgcreate nova-volumes /dev/loop0
: stdout
[0K[default] [Fri, 11 Mar 2011 12:22:27 +0000] DEBUG: ---- Begin output of vgcreate nova-volumes /dev/loop0 ----
[Fri, 11 Mar 2011 12:22:27 +0000] DEBUG: STDOUT: Physical volume "/dev/loop0" successfully created
  Volume group "nova-volumes" successfully created
[Fri, 11 Mar 2011 12:22:27 +0000] DEBUG: STDERR: File descriptor 3 (socket:[9766]) leaked on vgcreate invocation. Parent PID 1016: /usr/bin/ruby1.8
File descriptor 8 (socket:[9757]) leaked on vgcreate invocation. Parent PID 1016: /usr/bin/ruby1.8
File descriptor 9 (socket:[9761]) leaked on vgcreate invocation. Parent PID 1016: /usr/bin/ruby1.8
File descriptor 14 (pipe:[14320]) leaked on vgcreate invocation. Parent PID 1016: /usr/bin/ruby1.8
  No physical volume label read from /dev/loop0
[Fri, 11 Mar 2011 12:22:27 +0000] DEBUG: ---- End output of vgcreate nova-volumes /dev/loop0 ----
[Fri, 11 Mar 2011 12:22:27 +0000] DEBUG: Ran vgcreate nova-volumes /dev/loop0 returned 0
[Fri, 11 Mar 2011 12:22:27 +0000] INFO: Ran execute[vgcreate nova-volumes /dev/loop0] successfully
[Fri, 11 Mar 2011 12:22:27 +0000] DEBUG: Processing execute[mysql-install-nova-privileges] on maverick.hsd1.ca.comcast.net.
[Fri, 11 Mar 2011 12:22:27 +0000] DEBUG: Doing nothing for execute[mysql-install-nova-privileges]
[Fri, 11 Mar 2011 12:22:27 +0000] DEBUG: Processing package[mysql-devel] on maverick.hsd1.ca.comcast.net.
[Fri, 11 Mar 2011 12:22:27 +0000] DEBUG: Checking apt-cache policy for libmysqlclient-dev
: stdout

[0K[default] [Fri, 11 Mar 2011 12:22:29 +0000] DEBUG: Current version is 5.1.49-1ubuntu8.1
[Fri, 11 Mar 2011 12:22:29 +0000] DEBUG: Current version is 5.1.49-1ubuntu8.1
[Fri, 11 Mar 2011 12:22:29 +0000] DEBUG: Doing nothing for package[mysql-client]
[Fri, 11 Mar 2011 12:22:29 +0000] DEBUG: Processing gem_package[mysql] on maverick.hsd1.ca.comcast.net.
[Fri, 11 Mar 2011 12:22:29 +0000] DEBUG: Found installed gem mysql version 2.8.1 matching mysql (>= 0, runtime)
[Fri, 11 Mar 2011 12:22:29 +0000] DEBUG: Doing nothing for gem_package[mysql]
[Fri, 11 Mar 2011 12:22:29 +0000] DEBUG: Processing directory[/var/cache/local/preseeding] on maverick.hsd1.ca.comcast.net.
[Fri, 11 Mar 2011 12:22:29 +0000] DEBUG: Processing execute[preseed mysql-server] on maverick.hsd1.ca.comcast.net.
[Fri, 11 Mar 2011 12:22:29 +0000] DEBUG: Doing nothing for execute[preseed mysql-server]
[Fri, 11 Mar 2011 12:22:29 +0000] DEBUG: Processing template[/var/cache/local/preseeding/mysql-server.seed] on maverick.hsd1.ca.comcast.net.

[Fri, 11 Mar 2011 12:22:29 +0000] DEBUG: looking for template mysql-server.seed.erb in cookbook :mysql
[Fri, 11 Mar 2011 12:22:29 +0000] DEBUG: Current content's checksum:
[Fri, 11 Mar 2011 12:22:29 +0000] DEBUG: Rendered content's checksum: e4a75f5202ec9178248a21a994a29b2e5181100e72c5de3f067277d7ceb7fd48
[Fri, 11 Mar 2011 12:22:29 +0000] INFO: Writing updated content for template[/var/cache/local/preseeding/mysql-server.seed] to /var/cache/local/preseeding/mysql-server.seed
[Fri, 11 Mar 2011 12:22:29 +0000] INFO: template[/var/cache/local/preseeding/mysql-server.seed] sending run action to execute[preseed mysql-server] (immediate)
[Fri, 11 Mar 2011 12:22:29 +0000] DEBUG: Executing debconf-set-selections /var/cache/local/preseeding/mysql-server.seed
: stdout
[0K[default] [Fri, 11 Mar 2011 12:22:29 +0000] DEBUG: ---- Begin output of debconf-set-selections /var/cache/local/preseeding/mysql-server.seed ----
[Fri, 11 Mar 2011 12:22:29 +0000] DEBUG: STDOUT:
[Fri, 11 Mar 2011 12:22:29 +0000] DEBUG: STDERR:
[Fri, 11 Mar 2011 12:22:29 +0000] DEBUG: ---- End output of debconf-set-selections /var/cache/local/preseeding/mysql-server.seed ----
[Fri, 11 Mar 2011 12:22:29 +0000] DEBUG: Ran debconf-set-selections /var/cache/local/preseeding/mysql-server.seed returned 0
[Fri, 11 Mar 2011 12:22:29 +0000] INFO: Ran execute[preseed mysql-server] successfully
[Fri, 11 Mar 2011 12:22:29 +0000] DEBUG: Processing template[/etc/mysql/debian.cnf] on maverick.hsd1.ca.comcast.net.
[Fri, 11 Mar 2011 12:22:29 +0000] DEBUG: looking for template debian.cnf.erb in cookbook :mysql
[Fri, 11 Mar 2011 12:22:29 +0000] DEBUG: Current content's checksum:
[Fri, 11 Mar 2011 12:22:29 +0000] DEBUG: Rendered content's checksum: 6c420714eb0cc2c636b1337f1a18fb370205127a9e9614edb6cc5058970fa8af
[Fri, 11 Mar 2011 12:22:29 +0000] INFO: Writing updated content for template[/etc/mysql/debian.cnf] to /etc/mysql/debian.cnf
[Fri, 11 Mar 2011 12:22:29 +0000] DEBUG: Processing package[mysql-server] on maverick.hsd1.ca.comcast.net.
[Fri, 11 Mar 2011 12:22:29 +0000] DEBUG: Checking apt-cache policy for mysql-server
: stdout
[0K[default] [Fri, 11 Mar 2011 12:22:29 +0000] DEBUG: Current version is nil
[Fri, 11 Mar 2011 12:22:29 +0000] DEBUG: Current version is 5.1.49-1ubuntu8.1
[Fri, 11 Mar 2011 12:22:29 +0000] INFO: Installing package[mysql-server] version 5.1.49-1ubuntu8.1
[Fri, 11 Mar 2011 12:22:29 +0000] DEBUG: Executing apt-get -q -y install mysql-server=5.1.49-1ubuntu8.1
: stdout

[0K[default] [Fri, 11 Mar 2011 12:23:12 +0000] DEBUG: ---- Begin output of apt-get -q -y install mysql-server=5.1.49-1ubuntu8.1 ----
[Fri, 11 Mar 2011 12:23:12 +0000] 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
Preconfiguring packages ...
0 upgraded, 4 newly installed, 0 to remove and 71 not upgraded.
Need to get 0B/12.2MB of archives.
After this operation, 29.5MB of additional disk space will be used.
Selecting previously deselected package mysql-server-core-5.1.
(Reading database ... 46818 files and directories currently installed.)
Unpacking mysql-server-core-5.1 (from .../mysql-server-core-5.1_5.1.49-1ubuntu8.1_amd64.deb) ...
Selecting previously deselected package mysql-server-5.1.
Unpacking mysql-server-5.1 (from .../mysql-server-5.1_5.1.49-1ubuntu8.1_amd64.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.49-1ubuntu8.1_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.49-1ubuntu8.1) ...
Setting up mysql-server-5.1 (5.1.49-1ubuntu8.1) ...
Setting up libhtml-template-perl (2.9-1) ...
Setting up mysql-server (5.1.49-1ubuntu8.1) ...
[Fri, 11 Mar 2011 12:23:12 +0000] DEBUG: STDERR: mysql start/running, process 7305
[Fri, 11 Mar 2011 12:23:12 +0000] DEBUG: ---- End output of apt-get -q -y install mysql-server=5.1.49-1ubuntu8.1 ----
[Fri, 11 Mar 2011 12:23:12 +0000] DEBUG: Ran apt-get -q -y install mysql-server=5.1.49-1ubuntu8.1 returned 0
[Fri, 11 Mar 2011 12:23:12 +0000] DEBUG: Processing service[mysql] on maverick.hsd1.ca.comcast.net.
[Fri, 11 Mar 2011 12:23:12 +0000] DEBUG: service[mysql] supports status, running
[Fri, 11 Mar 2011 12:23:12 +0000] DEBUG: Executing /etc/init.d/mysql status
: stdout

[0K[default] [Fri, 11 Mar 2011 12:23:12 +0000] DEBUG: ---- Begin output of /etc/init.d/mysql status ----
[Fri, 11 Mar 2011 12:23:12 +0000] 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 7305
[Fri, 11 Mar 2011 12:23:12 +0000] DEBUG: STDERR:
[Fri, 11 Mar 2011 12:23:12 +0000] DEBUG: ---- End output of /etc/init.d/mysql status ----
[Fri, 11 Mar 2011 12:23:12 +0000] DEBUG: Ran /etc/init.d/mysql status returned 0
: stdout
[0K[default] [Fri, 11 Mar 2011 12:23:12 +0000] DEBUG: Doing nothing for service[mysql]
[Fri, 11 Mar 2011 12:23:12 +0000] DEBUG: Processing template[/etc/mysql/my.cnf] on maverick.hsd1.ca.comcast.net.
[Fri, 11 Mar 2011 12:23:12 +0000] DEBUG: looking for template my.cnf.erb in cookbook :mysql
[Fri, 11 Mar 2011 12:23:12 +0000] DEBUG: Current content's checksum: 194dd242533b0847d10627302056f8cf646aabdbb077cf6f7e0d758e01a7f3cc
[Fri, 11 Mar 2011 12:23:12 +0000] DEBUG: Rendered content's checksum: 7a48e40437729e14aa244df8c818c41ced7ba20fd1ebfd5add0dfffb59c3ef17
[Fri, 11 Mar 2011 12:23:12 +0000] INFO: Writing updated content for template[/etc/mysql/my.cnf] to /etc/mysql/my.cnf
[Fri, 11 Mar 2011 12:23:12 +0000] INFO: Backing up template[/etc/mysql/my.cnf] to /var/chef/backup/etc/mysql/my.cnf.chef-20110311122312
[Fri, 11 Mar 2011 12:23:12 +0000] DEBUG: setting mode on /tmp/chef-rendered-template20110311-1016-1ru0ocf-0 to 644
[Fri, 11 Mar 2011 12:23:12 +0000] INFO: template[/etc/mysql/my.cnf] sending restart action to service[mysql] (immediate)
[Fri, 11 Mar 2011 12:23:12 +0000] DEBUG: service[mysql] supports status, running
[Fri, 11 Mar 2011 12:23:12 +0000] DEBUG: Executing /etc/init.d/mysql status
: stdout

[0K[default] [Fri, 11 Mar 2011 12:23:17 +0000] DEBUG: ---- Begin output of restart mysql ----
[Fri, 11 Mar 2011 12:23:17 +0000] DEBUG: STDOUT: mysql start/running, process 7361
[Fri, 11 Mar 2011 12:23:17 +0000] DEBUG: STDERR:
[Fri, 11 Mar 2011 12:23:17 +0000] DEBUG: ---- End output of restart mysql ----
[Fri, 11 Mar 2011 12:23:17 +0000] DEBUG: Ran restart mysql returned 0
[Fri, 11 Mar 2011 12:23:17 +0000] INFO: service[mysql]: restarted successfully
[Fri, 11 Mar 2011 12:23:17 +0000] DEBUG: Processing template[/etc/mysql/grants.sql] on maverick.hsd1.ca.comcast.net.
[Fri, 11 Mar 2011 12:23:17 +0000] DEBUG: looking for template grants.sql.erb in cookbook :mysql
[Fri, 11 Mar 2011 12:23:17 +0000] DEBUG: Current content's checksum:
[Fri, 11 Mar 2011 12:23:17 +0000] DEBUG: Rendered content's checksum: 66b51f41993f4edd536c2ba6b911ee8ae7f6f58379f3e6de975dabdbe93ec41e
[Fri, 11 Mar 2011 12:23:17 +0000] INFO: Writing updated content for template[/etc/mysql/grants.sql] to /etc/mysql/grants.sql
[Fri, 11 Mar 2011 12:23:17 +0000] INFO: template[/etc/mysql/grants.sql] sending run action to execute[mysql-install-privileges] (immediate)
[Fri, 11 Mar 2011 12:23:17 +0000] DEBUG: Executing /usr/bin/mysql -u root -pUJZQgs6Ebn5QnJ9xucj8 < /etc/mysql/grants.sql
: stdout
[0K[default] [Fri, 11 Mar 2011 12:23:17 +0000] DEBUG: ---- Begin output of /usr/bin/mysql -u root -pUJZQgs6Ebn5QnJ9xucj8 < /etc/mysql/grants.sql ----
[Fri, 11 Mar 2011 12:23:17 +0000] DEBUG: STDOUT:
[Fri, 11 Mar 2011 12:23:17 +0000] DEBUG: STDERR:
[Fri, 11 Mar 2011 12:23:17 +0000] DEBUG: ---- End output of /usr/bin/mysql -u root -pUJZQgs6Ebn5QnJ9xucj8 < /etc/mysql/grants.sql ----
[Fri, 11 Mar 2011 12:23:17 +0000] DEBUG: Ran /usr/bin/mysql -u root -pUJZQgs6Ebn5QnJ9xucj8 < /etc/mysql/grants.sql returned 0
[Fri, 11 Mar 2011 12:23:17 +0000] INFO: Ran execute[mysql-install-privileges] successfully
[Fri, 11 Mar 2011 12:23:17 +0000] DEBUG: Processing execute[mysql-install-privileges] on maverick.hsd1.ca.comcast.net.
[Fri, 11 Mar 2011 12:23:17 +0000] DEBUG: Doing nothing for execute[mysql-install-privileges]
[Fri, 11 Mar 2011 12:23:17 +0000] DEBUG: Processing template[/etc/mysql/nova-grants.sql] on maverick.hsd1.ca.comcast.net.
[Fri, 11 Mar 2011 12:23:17 +0000] DEBUG: looking for template grants.sql.erb in cookbook :nova
[Fri, 11 Mar 2011 12:23:17 +0000] DEBUG: Current content's checksum:
[Fri, 11 Mar 2011 12:23:17 +0000] DEBUG: Rendered content's checksum: 4cc9b3fc498912bf65291c7921e3611925ddd3ee0f13bfcc93fd0b59f4987a69
[Fri, 11 Mar 2011 12:23:17 +0000] INFO: Writing updated content for template[/etc/mysql/nova-grants.sql] to /etc/mysql/nova-grants.sql
[Fri, 11 Mar 2011 12:23:17 +0000] INFO: template[/etc/mysql/nova-grants.sql] sending run action to execute[mysql-install-nova-privileges] (immediate)
[Fri, 11 Mar 2011 12:23:17 +0000] DEBUG: Executing /usr/bin/mysql -u root -pUJZQgs6Ebn5QnJ9xucj8 < /etc/mysql/nova-grants.sql
: stdout
[0K[default] [Fri, 11 Mar 2011 12:23:17 +0000] DEBUG: ---- Begin output of /usr/bin/mysql -u root -pUJZQgs6Ebn5QnJ9xucj8 < /etc/mysql/nova-grants.sql ----
[Fri, 11 Mar 2011 12:23:17 +0000] DEBUG: STDOUT:
[Fri, 11 Mar 2011 12:23:17 +0000] DEBUG: STDERR:
[Fri, 11 Mar 2011 12:23:17 +0000] DEBUG: ---- End output of /usr/bin/mysql -u root -pUJZQgs6Ebn5QnJ9xucj8 < /etc/mysql/nova-grants.sql ----
[Fri, 11 Mar 2011 12:23:17 +0000] DEBUG: Ran /usr/bin/mysql -u root -pUJZQgs6Ebn5QnJ9xucj8 < /etc/mysql/nova-grants.sql returned 0
[Fri, 11 Mar 2011 12:23:17 +0000] INFO: Ran execute[mysql-install-nova-privileges] successfully
[Fri, 11 Mar 2011 12:23:17 +0000] DEBUG: Processing execute[create nova database] on maverick.hsd1.ca.comcast.net.
[Fri, 11 Mar 2011 12:23:17 +0000] DEBUG: Executing /usr/bin/mysqladmin -u root -pUJZQgs6Ebn5QnJ9xucj8 create nova
: stdout
[0K[default] [Fri, 11 Mar 2011 12:23:17 +0000] DEBUG: ---- Begin output of /usr/bin/mysqladmin -u root -pUJZQgs6Ebn5QnJ9xucj8 create nova ----
[Fri, 11 Mar 2011 12:23:17 +0000] DEBUG: STDOUT:
[Fri, 11 Mar 2011 12:23:17 +0000] DEBUG: STDERR:
[Fri, 11 Mar 2011 12:23:17 +0000] DEBUG: ---- End output of /usr/bin/mysqladmin -u root -pUJZQgs6Ebn5QnJ9xucj8 create nova ----
[Fri, 11 Mar 2011 12:23:17 +0000] DEBUG: Ran /usr/bin/mysqladmin -u root -pUJZQgs6Ebn5QnJ9xucj8 create nova returned 0
[Fri, 11 Mar 2011 12:23:17 +0000] INFO: Ran execute[create nova database] successfully
[Fri, 11 Mar 2011 12:23:17 +0000] DEBUG: Processing package[rabbitmq-server] on maverick.hsd1.ca.comcast.net.
[Fri, 11 Mar 2011 12:23:17 +0000] DEBUG: Checking apt-cache policy for rabbitmq-server
: stdout
[0K[default] [Fri, 11 Mar 2011 12:23:19 +0000] DEBUG: Current version is nil
[Fri, 11 Mar 2011 12:23:19 +0000] DEBUG: Current version is 1.8.0-1ubuntu2
[Fri, 11 Mar 2011 12:23:19 +0000] INFO: Installing package[rabbitmq-server] version 1.8.0-1ubuntu2
[Fri, 11 Mar 2011 12:23:19 +0000] DEBUG: Executing apt-get -q -y install rabbitmq-server=1.8.0-1ubuntu2
: stdout

[0K[default] [Fri, 11 Mar 2011 12:23:30 +0000] DEBUG: ---- Begin output of apt-get -q -y install rabbitmq-server=1.8.0-1ubuntu2 ----
[Fri, 11 Mar 2011 12:23:30 +0000] DEBUG: STDOUT: Reading package lists...
Building dependency tree...
Reading state information...
The following extra packages will be installed:
  erlang-base erlang-crypto erlang-mnesia erlang-os-mon erlang-public-key
  erlang-runtime-tools erlang-snmp erlang-ssl erlang-syntax-tools libsctp1
  lksctp-tools rabbitmq-server
Suggested packages:
  erlang-tools erlang erlang-manpages erlang-doc-html
The following NEW packages will be installed:
  erlang-base erlang-crypto erlang-mnesia erlang-os-mon erlang-public-key
  erlang-runtime-tools erlang-snmp erlang-ssl erlang-syntax-tools libsctp1
  lksctp-tools rabbitmq-server
Preconfiguring packages ...
0 upgraded, 12 newly installed, 0 to remove and 71 not upgraded.
Need to get 0B/6,703kB of archives.
After this operation, 13.3MB of additional disk space will be used.
Selecting previously deselected package erlang-base.
(Reading database ... 46997 files and directories currently installed.)
Unpacking erlang-base (from .../erlang-base_1%3a13.b.3-dfsg-2ubuntu3_amd64.deb) ...
Selecting previously deselected package erlang-crypto.
Unpacking erlang-crypto (from .../erlang-crypto_1%3a13.b.3-dfsg-2ubuntu3_amd64.deb) ...
Selecting previously deselected package erlang-mnesia.
Unpacking erlang-mnesia (from .../erlang-mnesia_1%3a13.b.3-dfsg-2ubuntu3_amd64.deb) ...
Selecting previously deselected package erlang-runtime-tools.
Unpacking erlang-runtime-tools (from .../erlang-runtime-tools_1%3a13.b.3-dfsg-2ubuntu3_amd64.deb) ...
Selecting previously deselected package erlang-snmp.
Unpacking erlang-snmp (from .../erlang-snmp_1%3a13.b.3-dfsg-2ubuntu3_amd64.deb) ...
Selecting previously deselected package erlang-os-mon.
Unpacking erlang-os-mon (from .../erlang-os-mon_1%3a13.b.3-dfsg-2ubuntu3_amd64.deb) ...
Selecting previously deselected package erlang-public-key.
Unpacking erlang-public-key (from .../erlang-public-key_1%3a13.b.3-dfsg-2ubuntu3_amd64.deb) ...
Selecting previously deselected package erlang-ssl.
Unpacking erlang-ssl (from .../erlang-ssl_1%3a13.b.3-dfsg-2ubuntu3_amd64.deb) ...
Selecting previously deselected package erlang-syntax-tools.
Unpacking erlang-syntax-tools (from .../erlang-syntax-tools_1%3a13.b.3-dfsg-2ubuntu3_amd64.deb) ...
Selecting previously deselected package libsctp1.
Unpacking libsctp1 (from .../libsctp1_1.0.11+dfsg-1_amd64.deb) ...
Selecting previously deselected package lksctp-tools.
Unpacking lksctp-tools (from .../lksctp-tools_1.0.11+dfsg-1_amd64.deb) ...
Selecting previously deselected package rabbitmq-server.
Unpacking rabbitmq-server (from .../rabbitmq-server_1.8.0-1ubuntu2_all.deb) ...
Processing triggers for man-db ...
Processing triggers for ureadahead ...
Setting up erlang-base (1:13.b.3-dfsg-2ubuntu3) ...
Searching for services which depend on erlang and should be started...none found.
Setting up erlang-crypto (1:13.b.3-dfsg-2ubuntu3) ...

Setting up erlang-mnesia (1:13.b.3-dfsg-2ubuntu3) ...
Setting up erlang-runtime-tools (1:13.b.3-dfsg-2ubuntu3) ...
Setting up erlang-snmp (1:13.b.3-dfsg-2ubuntu3) ...
Setting up erlang-os-mon (1:13.b.3-dfsg-2ubuntu3) ...
Setting up erlang-public-key (1:13.b.3-dfsg-2ubuntu3) ...
Setting up erlang-ssl (1:13.b.3-dfsg-2ubuntu3) ...
Setting up erlang-syntax-tools (1:13.b.3-dfsg-2ubuntu3) ...
Setting up libsctp1 (1.0.11+dfsg-1) ...
Setting up lksctp-tools (1.0.11+dfsg-1) ...
Setting up rabbitmq-server (1.8.0-1ubuntu2) ...
Adding group `rabbitmq' (GID 111) ...
Done.
Adding system user `rabbitmq' (UID 104) ...
Adding new user `rabbitmq' (UID 104) with group `rabbitmq' ...
Not creating home directory `/var/lib/rabbitmq'.
Starting rabbitmq-server: SUCCESS
rabbitmq-server.
Processing triggers for libc-bin ...
ldconfig deferred processing now taking place
[Fri, 11 Mar 2011 12:23:30 +0000] DEBUG: STDERR:
[Fri, 11 Mar 2011 12:23:30 +0000] DEBUG: ---- End output of apt-get -q -y install rabbitmq-server=1.8.0-1ubuntu2 ----
[Fri, 11 Mar 2011 12:23:30 +0000] DEBUG: Ran apt-get -q -y ins: stdout
[0K[default] tall rabbitmq-server=1.8.0-1ubuntu2 returned 0
[Fri, 11 Mar 2011 12:23:30 +0000] DEBUG: Processing service[rabbitmq-server] on maverick.hsd1.ca.comcast.net.
[Fri, 11 Mar 2011 12:23:30 +0000] DEBUG: service[rabbitmq-server] supports status, running
[Fri, 11 Mar 2011 12:23:30 +0000] DEBUG: Executing /etc/init.d/rabbitmq-server status
: stdout

[0K[default] [Fri, 11 Mar 2011 12:23:31 +0000] DEBUG: ---- Begin output of /etc/init.d/rabbitmq-server status ----
[Fri, 11 Mar 2011 12:23:31 +0000] DEBUG: STDOUT: Status of all running nodes...
Node 'rabbit@nova' with Pid 7755: running
done.
[Fri, 11 Mar 2011 12:23:31 +0000] DEBUG: STDERR:
[Fri, 11 Mar 2011 12:23:31 +0000] DEBUG: ---- End output of /etc/init.d/rabbitmq-server status ----
[Fri, 11 Mar 2011 12:23:31 +0000] DEBUG: Ran /etc/init.d/rabbitmq-server status returned 0
: stdout
[0K[default] [Fri, 11 Mar 2011 12:23:31 +0000] DEBUG: service[rabbitmq-server]: not starting, already running
[Fri, 11 Mar 2011 12:23:31 +0000] DEBUG: Processing template[/etc/rabbitmq/rabbitmq.conf] on maverick.hsd1.ca.comcast.net.
[Fri, 11 Mar 2011 12:23:31 +0000] DEBUG: looking for template rabbitmq.config.erb in cookbook :rabbitmq
[Fri, 11 Mar 2011 12:23:31 +0000] DEBUG: Current content's checksum:
[Fri, 11 Mar 2011 12:23:31 +0000] DEBUG: Rendered content's checksum: 885a9fd8ab6f53849f4565261ce9317bdb95adb48a674f56e5ba41d205b673c6
[Fri, 11 Mar 2011 12:23:31 +0000] INFO: Writing updated content for template[/etc/rabbitmq/rabbitmq.conf] to /etc/rabbitmq/rabbitmq.conf
[Fri, 11 Mar 2011 12:23:31 +0000] DEBUG: setting mode on /tmp/chef-rendered-template20110311-1016-6qicwm-0 to 644
[Fri, 11 Mar 2011 12:23:31 +0000] DEBUG: Processing execute[rabbitmqctl add_vhost /nova] on maverick.hsd1.ca.comcast.net.
[Fri, 11 Mar 2011 12:23:31 +0000] DEBUG: Executing rabbitmqctl list_vhosts | grep /nova
: stdout
[0K[default] [Fri, 11 Mar 2011 12:23:32 +0000] DEBUG: ---- Begin output of rabbitmqctl list_vhosts | grep /nova ----
[Fri, 11 Mar 2011 12:23:32 +0000] DEBUG: STDOUT:
[Fri, 11 Mar 2011 12:23:32 +0000] DEBUG: STDERR:
[Fri, 11 Mar 2011 12:23:32 +0000] DEBUG: ---- End output of rabbitmqctl list_vhosts | grep /nova ----
[Fri, 11 Mar 2011 12:23:32 +0000] DEBUG: Ran rabbitmqctl list_vhosts | grep /nova returned 1
[Fri, 11 Mar 2011 12:23:32 +0000] DEBUG: Doing nothing for execute[rabbitmqctl add_vhost /nova]
[Fri, 11 Mar 2011 12:23:32 +0000] DEBUG: Processing execute[rabbitmqctl add_user nova IoahNdNz8RVj0Irf8_ie] on maverick.hsd1.ca.comcast.net.
[Fri, 11 Mar 2011 12:23:32 +0000] DEBUG: Executing rabbitmqctl list_users | grep nova
: stdout
[0K[default] [Fri, 11 Mar 2011 12:23:32 +0000] DEBUG: ---- Begin output of rabbitmqctl list_users | grep nova ----
[Fri, 11 Mar 2011 12:23:32 +0000] DEBUG: STDOUT:
[Fri, 11 Mar 2011 12:23:32 +0000] DEBUG: STDERR:
[Fri, 11 Mar 2011 12:23:32 +0000] DEBUG: ---- End output of rabbitmqctl list_users | grep nova ----
[Fri, 11 Mar 2011 12:23:32 +0000] DEBUG: Ran rabbitmqctl list_users | grep nova returned 1
[Fri, 11 Mar 2011 12:23:32 +0000] DEBUG: Doing nothing for execute[rabbitmqctl add_user nova IoahNdNz8RVj0Irf8_ie]
[Fri, 11 Mar 2011 12:23:32 +0000] DEBUG: Processing execute[rabbitmqctl set_permissions -p /nova nova ".*" ".*" ".*"] on maverick.hsd1.ca.comcast.net.
[Fri, 11 Mar 2011 12:23:32 +0000] DEBUG: Executing rabbitmqctl list_user_permissions nova | grep /nova
: stdout
[0K[default] [Fri, 11 Mar 2011 12:23:32 +0000] DEBUG: ---- Begin output of rabbitmqctl list_user_permissions nova | grep /nova ----
[Fri, 11 Mar 2011 12:23:32 +0000] DEBUG: STDOUT:
[Fri, 11 Mar 2011 12:23:32 +0000] DEBUG: STDERR: Error: {no_such_user,<<"nova">>}
[Fri, 11 Mar 2011 12:23:32 +0000] DEBUG: ---- End output of rabbitmqctl list_user_permissions nova | grep /nova ----
[Fri, 11 Mar 2011 12:23:32 +0000] DEBUG: Ran rabbitmqctl list_user_permissions nova | grep /nova returned 1
[Fri, 11 Mar 2011 12:23:32 +0000] DEBUG: Doing nothing for execute[rabbitmqctl set_permissions -p /nova nova ".*" ".*" ".*"]
[Fri, 11 Mar 2011 12:23:32 +0000] DEBUG: Processing package[nova-common] on maverick.hsd1.ca.comcast.net.
[Fri, 11 Mar 2011 12:23:32 +0000] DEBUG: Checking apt-cache policy for nova-common
: stdout
[0K[default] [Fri, 11 Mar 2011 12:23:33 +0000] DEBUG: Current version is nil
[Fri, 11 Mar 2011 12:23:33 +0000] DEBUG: Current version is 2011.1-anso~dev~bzr635-maverick
[Fri, 11 Mar 2011 12:23:33 +0000] INFO: Installing package[nova-common] version 2011.1-anso~dev~bzr635-maverick
[Fri, 11 Mar 2011 12:23:33 +0000] DEBUG: Executing apt-get -q -y --force-yes -o Dpkg::Options::="--force-confdef" install nova-common=2011.1-anso~dev~bzr635-maverick
: stdout

[0K[default] [Fri, 11 Mar 2011 12:24:12 +0000] DEBUG: ---- Begin output of apt-get -q -y --force-yes -o Dpkg::Options::="--force-confdef" install nova-common=2011.1-anso~dev~bzr635-maverick ----
[Fri, 11 Mar 2011 12:24:12 +0000] DEBUG: STDOUT: Reading package lists...
Building dependency tree...
Reading state information...
The following extra packages will be installed:
  libjs-jquery nova-common python-amqplib python-anyjson python-boto
  python-carrot python-cheetah python-cjson python-daemon python-decorator
  python-dingus python-eventlet python-formencode python-gflags python-glance
  python-greenlet python-ipy python-ldap python-libxml2 python-lockfile
  python-m2crypto python-migrate python-netaddr python-nose python-nova
  python-openid python-openssl python-pam python-paste python-pastedeploy
  python-pastescript python-pkg-resources python-py python-pycurl
  python-routes python-scgi python-serial python-setuptools python-sqlalchemy
  python-sqlalchemy-ext python-stompy python-tempita python-twisted-bin
  python-twisted-core python-twisted-web python-webob python-zope.interface
Suggested packages:
  javascript-common python-cjson-dbg python-egenix-mxdatetime python-dns
  python-greenlet-doc python-greenlet-dev python-greenlet-dbg python-ldap-doc
  ipython python-coverage python-openssl-doc python-openssl-dbg python-pam-dbg
  python-pastewebkit libapache2-mod-wsgi libapache2-mod-python
  libapache2-mod-scgi python-pgsql libjs-mochikit python-cherrypy3
  python-cherrypy python-flup python-distribute python-distribute-doc
  subversion python-pytest-xdist libcurl4-gnutls-dev python-pycurl-dbg
  python-wxgtk2.8 python-wxgtk2.6 python-wxgtk python-sqlalchemy-doc
  python-psycopg2 python-mysqldb python-kinterbasdb python-pymssql
  python-twisted-bin-dbg python-tk python-gtk2 python-glade2 python-qt3
  python-profiler python-z3c.recipe.sphinxdoc
The following NEW packages will be installed:
  libjs-jquery nova-common python-amqplib python-anyjson python-boto
  python-carrot python-cheetah python-cjson python-daemon python-decorator
  python-dingus python-eventlet python-formencode python-gflags python-glance
  python-greenlet python-ipy python-ldap python-libxml2 python-lockfile
  python-m2crypto python-migrate python-netaddr python-nose python-nova
  python-openid python-openssl python-pam python-paste python-pastedeploy
  python-pastescript python-pkg-resources python-py python-pycurl
  python-routes python-scgi python-serial python-setuptools python-sqlalchemy
  python-sqlalchemy-ext python-stompy python-tempita python-twisted-bin
  python-twisted-core python-twisted-web python-webob python-zope.interface
0 upgraded, 47 newly installed, 0 to remove and 71 not upgraded.
Need to get 0B/7,562kB of archives.
After this operation, 46.8MB of additional disk space will be used.
Selecting previously deselected package libjs-jquery.
(Reading database ... 47998 files and directories currently installed.)
Unpacking libjs-jquery (from .../libjs-jquery_1.4.2-2ubuntu1_all.deb) ...
Selecting previously deselected package python-amqplib.
Unpacking python-amqplib (from .../python-amqplib_0.6.1-1_all.deb) ...
Selecting previously deselected package python-cjson.
Unpacking python-cjson (from .../python-cjson_1.0.5-4_amd64.deb) ...
Selecting previously deselected package python-anyjson.
Unpacking python-anyjson (from .../python-anyjson_0.2.3-1_all.deb) ...
Selecting previously deselected package python-boto.
Unpacking python-boto (from .../python-boto_1.9b-1ubuntu3_all.deb) ...
Selecting previously deselected package python-carrot.
Unpacking python-carrot (from .../python-carrot_0.10.3-1_all.deb) ...
Selecting previously deselected package python-cheetah.
Unpacking python-cheetah (from .../python-cheetah_2.0.1-2ubuntu7_amd64.deb) ...
Selecting previously deselected package python-lockfile.
Unpacking python-lockfile (from .../python-lockfile_1%3a0.8-2_all.deb) ...
Selecting previously deselected package python-daemon.
Unpacking python-daemon (from .../python-daemon_1.5.5-1_all.deb) ...
Selecting previously deselected package python-decorator.
Unpacking python-decorator (from .../python-decorator_3.2.0-1_all.deb) ...
Selecting previously deselected package python-dingus.
Unpacking python-dingus (from .../python-dingus_0.1-2_all.deb) ...
Selecting previously deselected package python-greenlet.
Unpacking python-greenlet (from .../python-greenlet_0.3.1-1ubuntu1_amd64.deb) ...
Selecting previously deselected package python-eventlet.
Unpacking python-eventlet (from .../python-eventlet_0.9.14-0ubuntu2~maverick1_amd64.deb) ...
Selecting previously deselected package python-pkg-resources.
Unpacking python-pkg-resources (from .../python-pkg-resources_0.6.14-3ubuntu1_all.deb) ...
Selecting previously deselected package python-formencode.
Unpacking python-formencode (from .../python-formencode_1.2.2-1ubuntu5_all.deb) ...
Selecting previously deselected package python-gflags.
Unpacking python-gflags (from .../python-gflags_1.3-1_all.deb) ...
Selecting previously deselected package python-ipy.
Unpacking python-ipy (from .../python-ipy_1%3a0.70-1_all.deb) ...
Selecting previously deselected package python-ldap.
Unpacking python-ldap (from .../python-ldap_2.3.11-1ubuntu1_amd64.deb) ...
Selecting previously deselected package python-libxml2.
Unpacking python-libxml2 (from .../python-libxml2_2.7.7.dfsg-4ubuntu0.1_amd64.deb) ...
Selecting previously deselected package python-m2crypto.
Unpacking python-m2crypto (from .../python-m2crypto_0.20.1-1ubuntu4_amd64.deb) ...
Selecting previously deselected package python-sqlalchemy.
Unpacking python-sqlalchemy (from .../python-sqlalchemy_0.6.3-2_all.deb) ...
Selecting previously deselected package python-py.
Unpacking python-py (from .../python-py_1.2.1-4_all.deb) ...
Selecting previously deselected package python-migrate.
Unpacking python-migrate (from .../python-migrate_0.6-2_all.deb) ...
Selecting previously deselected package python-netaddr.
Unpacking python-netaddr (from .../python-netaddr_0.7.4-1_all.deb) ...
Selecting previously deselected package python-nose.
Unpacking python-nose (from .../python-nose_0.11.1-1_all.deb) ...
Selecting previously deselected package python-openid.
Unpacking python-openid (from .../python-openid_2.2.4-1build1_all.deb) ...
Selecting previously deselected package python-openssl.
Unpacking python-openssl (from .../python-openssl_0.10-1_amd64.deb) ...
Selecting previously deselected package python-pam.
Unpacking python-pam (from .../python-pam_0.4.2-12.1ubuntu1_amd64.deb) ...
Selecting previously deselected package python-paste.
Unpacking python-paste (from .../python-paste_1.7.4-1_all.deb) ...
Selecting previously deselected package python-pastedeploy.
Unpacking python-pastedeploy (from .../python-pastedeploy_1.3.3-3ubuntu2_all.deb) ...
Selecting previously deselected package python-setuptools.
Unpacking python-setuptools (from .../python-setuptools_0.6.14-3ubuntu1_all.deb) ...
Selecting previously deselected package python-pastescript.
Unpacking python-pastescript (from .../python-pastescript_1.7.3-6_all.deb) ...
Selecting previously deselected package python-routes.
Unpacking python-routes (from .../python-routes_1.12.3-1_all.deb) ...
Selecting previously deselected package python-scgi.
Unpacking python-scgi (from .../python-scgi_1.13-1_amd64.deb) ...
Selecting previously deselected package python-serial.
Unpacking python-serial (from .../python-serial_2.3-1_all.deb) ...
Selecting previously deselected package python-sqlalchemy-ext.
Unpacking python-sqlalchemy-ext (from .../python-sqlalchemy-ext_0.6.3-2_amd64.deb) ...
Selecting previously deselected package python-stompy.
Unpacking python-stompy (from .../python-stompy_0.2.5-1_all.deb) ...
Selecting previously deselected package python-twisted-bin.
Unpacking python-twisted-bin (from .../python-twisted-bin_10.1.0-2_amd64.deb) ...
Selecting previously deselected package python-zope.interface.
Unpacking python-zope.interface (from .../python-zope.interface_3.6.1-0ubuntu1_amd64.deb) ...
Selecting previously deselected package python-twisted-core.
Unpacking python-twisted-core (from .../python-twisted-core_10.1.0-2_all.deb) ...
Selecting previously deselected package python-twisted-web.
Unpacking python-twisted-web (from .../python-twisted-web_10.1.0-1_all.deb) ...
Selecting previously deselected package python-pycurl.
Unpacking python-pycurl (from .../python-pycurl_7.19.0-3_amd64.deb) ...
Selecting previously deselected package python-webob.
Unpacking python-webob (from .../python-webob_0.9.8-1_all.deb) ...
Selecting previously deselected package python-tempita.
Unpacking python-tempita (from .../python-tempita_0.4-1_all.deb) ...
Selecting previously deselected package python-glance.
Unpacking python-glance (from .../python-glance_0.1.3pre~bzr40-0ubuntu0ppa1~maverick1_all.deb) ...
Selecting previously deselected package python-nova.
Unpacking python-nova (from .../python-nova_2011.1-anso~dev~bzr635-maverick_all.deb) ...
Selecting previously deselected package nova-common.
Unpacking nova-common (from .../nova-common_2011.1-anso~dev~bzr635-maverick_all.deb) ...
Processing triggers for man-db ...
Setting up libjs-jquery (1.4.2-2ubuntu1) ...
Setting up python-amqplib (0.6.1-1) ...
Setting up python-cjson (1.0.5-4) ...
Setting up python-anyjson (0.2.3-1) ...
Setting up python-boto (1.9b-1ubuntu3) ...
Setting up python-carrot (0.10.3-1) ...
Setting up python-cheetah (2.0.1-2ubuntu7) ...
Setting up python-lockfile (1:0.8-2) ...
Setting up python-daemon (1.5.5-1) ...
Setting up python-decorator (3.2.0-1) ...
Setting up python-dingus (0.1-2) ...
Setting up python-greenlet (0.3.1-1ubuntu1) ...
Setting up python-eventlet (0.9.14-0ubuntu2~maverick1) ...
Setting up python-pkg-resources (0.6.14-3ubuntu1) ...
Setting up python-formencode (1.2.2-1ubuntu5) ...
Setting up python-gflags (1.3-1) ...
Setting up python-ipy (1:0.70-1) ...
Setting up python-ldap (2.3.11-1ubuntu1) ...
Setting up python-libxml2 (2.7.7.dfsg-4ubuntu0.1) ...
Setting up python-m2crypto (0.20.1-1ubuntu4) ...
Setting up python-sqlalchemy (0.6.3-2) ...
Setting up python-py (1.2.1-4) ...
Setting up python-migrate (0.6-2) ...
Setting up python-netaddr (0.7.4-1) ...
Setting up python-nose (0.11.1-1) ...
Setting up python-openid (2.2.4-1build1) ...
Setting up python-openssl (0.10-1) ...
Setting up python-pam (0.4.2-12.1ubuntu1) ...
Setting up python-paste (1.7.4-1) ...
Setting up python-pastedeploy (1.3.3-3ubuntu2) ...
Setting up python-setuptools (0.6.14-3ubuntu1) ...
Setting up python-pastescript (1.7.3-6) ...
Setting up python-routes (1.12.3-1) ...
Setting up python-scgi (1.13-1) ...
Setting up python-serial (2.3-1) ...
Setting up python-sqlalchemy-ext (0.6.3-2) ...
Setting up python-stompy (0.2.5-1) ...
Setting up python-twisted-bin (10.1.0-2) ...
Setting up python-zope.interface (3.6.1-0ubuntu1) ...
Setting up python-pycurl (7.19.0-3) ...
Setting up python-webob (0.9.8-1) ...
Setting up python-tempita (0.4-1) ...
Processing triggers for python-central ...
Setting up python-twisted-core (10.1.0-2) ...
Setting up python-twisted-web (10.1.0-1) ...
Setting up python-glance (0.1.3pre~bzr40-0ubuntu0ppa1~maverick1) ...
Setting up python-nova (2011.1-anso~dev~bzr635-maverick) ...
Setting up nova-common (2011.1-anso~dev~bzr635-maverick) ...
Adding system user `nova' (UID 105) ...
Adding new user `nova' (UID 105) with group `nogroup' ...
Not creating home directory `/var/lib/nova'.
Processing triggers for python-support ...
[Fri, 11 Mar 2011 12:24:12 +0000] DEBUG: STDERR:
Extracting templates from packages: 63%
Extracting templates from packages: 100%
[Fri, 11 Mar 2011 12:24:12 +0000] DEBUG: ---- End output of apt-get -q -y --force-yes -o Dpkg::Options::="--force-confdef" install nova-common=2011.1-anso~dev~bzr635-maverick ----
[Fri, 11 Mar 2011 12:24:12 +0000] DEBUG: Ran apt-get -q -y --force-yes -o Dpkg::Options::="--force-confdef" install nova-common=2011.1-anso~dev~bzr635-maverick returned 0
[Fri, 11 Mar 2011 12:24:12 +0000] DEBUG: Processing directory[/etc/nova] on maverick.hsd1.ca.comcast.net.
[Fri, 11 Mar 2011 12:24:12 +0000] DEBUG: Processing package[python-mysqldb] on maverick.hsd1.ca.comcast.net.
[Fri, 11 Mar 2011 12:24:12 +0000] DEBUG: Checking apt-cache policy for python-mysqldb
: stdout

[0K[default] [Fri, 11 Mar 2011 12:24:13 +0000] DEBUG: Current version is nil
[Fri, 11 Mar 2011 12:24:13 +0000] DEBUG: Current version is 1.2.2-10build1
[Fri, 11 Mar 2011 12:24:13 +0000] INFO: Installing package[python-mysqldb] version 1.2.2-10build1
[Fri, 11 Mar 2011 12:24:13 +0000] DEBUG: Executing apt-get -q -y install python-mysqldb=1.2.2-10build1
: stdout

[0K[default] [Fri, 11 Mar 2011 12:24:18 +0000] DEBUG: ---- Begin output of apt-get -q -y install python-mysqldb=1.2.2-10build1 ----
[Fri, 11 Mar 2011 12:24:18 +0000] DEBUG: STDOUT: Reading package lists...
Building dependency tree...
Reading state information...
Suggested packages:
python-egenix-mxdatetime python-mysqldb-dbg
The following NEW packages will be installed:
python-mysqldb
0 upgraded, 1 newly installed, 0 to remove and 71 not upgraded.
Need to get 0B/79.6kB of archives.
After this operation, 299kB of additional disk space will be used.
Selecting previously deselected package python-mysqldb.
(Reading database ... 52620 files and directories currently installed.)
Unpacking python-mysqldb (from .../python-mysqldb_1.2.2-10build1_amd64.deb) ...
Setting up python-mysqldb (1.2.2-10build1) ...
Processing triggers for python-support ...
[Fri, 11 Mar 2011 12:24:18 +0000] DEBUG: STDERR:
[Fri, 11 Mar 2011 12:24:18 +0000] DEBUG: ---- End output of apt-get -q -y install python-mysqldb=1.2.2-10build1 ----
[Fri, 11 Mar 2011 12:24:18 +0000] DEBUG: Ran apt-get -q -y install python-mysqldb=1.2.2-10build1 returned 0
[Fri, 11 Mar 2011 12:24:18 +0000] DEBUG: Processing execute[nova-manage db sync] on maverick.hsd1.ca.comcast.net.
[Fri, 11 Mar 2011 12:24:18 +0000] DEBUG: Doing nothing for execute[nova-manage db sync]
[Fri, 11 Mar 2011 12:24:18 +0000] DEBUG: Processing file[/etc/default/nova-common] on maverick.hsd1.ca.comcast.net.
[Fri, 11 Mar 2011 12:24:18 +0000] DEBUG: Doing nothing for file[/etc/default/nova-common]
[Fri, 11 Mar 2011 12:24:18 +0000] DEBUG: Processing template[/etc/nova/nova.conf] on maverick.hsd1.ca.comcast.net.
[Fri, 11 Mar 2011 12:24:18 +0000] DEBUG: looking for template nova.conf.erb in cookbook :nova
[Fri, 11 Mar 2011 12:24:18 +0000] DEBUG: Current content's checksum: a17f00603e4b753d9761ca5f4464c5fefc3f89f501af884c2120d17f8d6780b4
[Fri, 11 Mar 2011 12:24:18 +0000] DEBUG: Rendered content's checksum: d7b8c218d5d9f09c6edcdae237170c8cbd01e1f3adbe3e8b2083ba0d9b5c597c
[Fri, 11 Mar 2011 12:24:18 +0000] INFO: Writing updated content for template[/etc/nova/nova.conf] to /etc/nova/nova.conf
[Fri, 11 Mar 2011 12:24:18 +0000] INFO: Backing up template[/etc/nova/nova.conf] to /var/chef/backup/etc/nova/nova.conf.chef-20110311122418
[Fri, 11 Mar 2011 12:24:18 +0000] DEBUG: setting mode on /tmp/chef-rendered-template20110311-1016-u4ll3e-0 to 644
[Fri, 11 Mar 2011 12:24:18 +0000] INFO: template[/etc/nova/nova.conf] sending run action to execute[nova-manage db sync] (immediate)
[Fri, 11 Mar 2011 12:24:18 +0000] DEBUG: Executing nova-manage db sync
: stdout
[0K[default] [Fri, 11 Mar 2011 12:24:20 +0000] DEBUG: ---- Begin output of nova-manage db sync ----
[Fri, 11 Mar 2011 12:24:20 +0000] DEBUG: STDOUT:
[Fri, 11 Mar 2011 12:24:20 +0000] DEBUG: STDERR:
[Fri, 11 Mar 2011 12:24:20 +0000] DEBUG: ---- End output of nova-manage db sync ----
[Fri, 11 Mar 2011 12:24:20 +0000] DEBUG: Ran nova-manage db sync returned 0
[Fri, 11 Mar 2011 12:24:20 +0000] INFO: Ran execute[nova-manage db sync] successfully
[Fri, 11 Mar 2011 12:24:20 +0000] INFO: template[/etc/nova/nova.conf] sending touch action to file[/etc/default/nova-common] (immediate)
[Fri, 11 Mar 2011 12:24:20 +0000] INFO: Setting content for file[/etc/default/nova-common]
[Fri, 11 Mar 2011 12:24:20 +0000] INFO: Backing up file[/etc/default/nova-common] to /var/chef/backup/etc/default/nova-common.chef-20110311122420
[Fri, 11 Mar 2011 12:24:20 +0000] INFO: Updating file[/etc/default/nova-common] with new atime/mtime of Fri Mar 11 12:24:20 +0000 2011
[Fri, 11 Mar 2011 12:24:20 +0000] DEBUG: Processing package[nova-api] on maverick.hsd1.ca.comcast.net.
[Fri, 11 Mar 2011 12:24:20 +0000] DEBUG: Checking apt-cache policy for nova-api
: stdout
[0K[default] [Fri, 11 Mar 2011 12:24:21 +0000] DEBUG: Current version is nil
[Fri, 11 Mar 2011 12:24:21 +0000] DEBUG: Current version is 2011.1-anso~dev~bzr635-maverick
[Fri, 11 Mar 2011 12:24:21 +0000] INFO: Installing package[nova-api] version 2011.1-anso~dev~bzr635-maverick
[Fri, 11 Mar 2011 12:24:21 +0000] DEBUG: Executing apt-get -q -y --force-yes install nova-api=2011.1-anso~dev~bzr635-maverick
: stdout

[0K[default] [Fri, 11 Mar 2011 12:24:23 +0000] DEBUG: ---- Begin output of apt-get -q -y --force-yes install nova-api=2011.1-anso~dev~bzr635-maverick ----
[Fri, 11 Mar 2011 12:24:23 +0000] DEBUG: STDOUT: Reading package lists...
Building dependency tree...
Reading state information...
The following NEW packages will be installed:
nova-api
0 upgraded, 1 newly installed, 0 to remove and 71 not upgraded.
Need to get 0B/7,624B of archives.
After this operation, 98.3kB of additional disk space will be used.
Selecting previously deselected package nova-api.
(Reading database ... 52651 files and directories currently installed.)
Unpacking nova-api (from .../nova-api_2011.1-anso~dev~bzr635-maverick_all.deb) ...
Processing triggers for ureadahead ...
Setting up nova-api (2011.1-anso~dev~bzr635-maverick) ...
[Fri, 11 Mar 2011 12:24:23 +0000] DEBUG: STDERR:
[Fri, 11 Mar 2011 12:24:23 +0000] DEBUG: ---- End output of apt-get -q -y --force-yes install nova-api=2011.1-anso~dev~bzr635-maverick ----
[Fri, 11 Mar 2011 12:24:23 +0000] DEBUG: Ran apt-get -q -y --force-yes install nova-api=2011.1-anso~dev~bzr635-maverick returned 0
[Fri, 11 Mar 2011 12:24:23 +0000] DEBUG: Processing service[nova-api] on maverick.hsd1.ca.comcast.net.
[Fri, 11 Mar 2011 12:24:23 +0000] DEBUG: service[nova-api] you have specified a status command, running..
[Fri, 11 Mar 2011 12:24:23 +0000] DEBUG: Executing status nova-api | cut -d' ' -f2 | cut -d'/' -f1 | grep start
: stdout
[0K[default] [Fri, 11 Mar 2011 12:24:23 +0000] DEBUG: ---- Begin output of status nova-api | cut -d' ' -f2 | cut -d'/' -f1 | grep start ----
[Fri, 11 Mar 2011 12:24:23 +0000] DEBUG: STDOUT:
[Fri, 11 Mar 2011 12:24:23 +0000] DEBUG: STDERR:
[Fri, 11 Mar 2011 12:24:23 +0000] DEBUG: ---- End output of status nova-api | cut -d' ' -f2 | cut -d'/' -f1 | grep start ----
[Fri, 11 Mar 2011 12:24:23 +0000] DEBUG: Ran status nova-api | cut -d' ' -f2 | cut -d'/' -f1 | grep start returned 1
: stdout
[0K[default] [Fri, 11 Mar 2011 12:24:23 +0000] DEBUG: service[nova-api]: attempting to start
[Fri, 11 Mar 2011 12:24:23 +0000] DEBUG: Executing start nova-api
: stdout

[0K[default] [Fri, 11 Mar 2011 12:24:23 +0000] DEBUG: ---- Begin output of start nova-api ----
[Fri, 11 Mar 2011 12:24:23 +0000] DEBUG: STDOUT: nova-api start/running, process 8821
[Fri, 11 Mar 2011 12:24:23 +0000] DEBUG: STDERR:
[Fri, 11 Mar 2011 12:24:23 +0000] DEBUG: ---- End output of start nova-api ----
[Fri, 11 Mar 2011 12:24:23 +0000] DEBUG: Ran start nova-api returned 0
[Fri, 11 Mar 2011 12:24:23 +0000] INFO: Started service service[nova-api] successfully
[Fri, 11 Mar 2011 12:24:23 +0000] DEBUG: Processing package[nova-scheduler] on maverick.hsd1.ca.comcast.net.
[Fri, 11 Mar 2011 12:24:23 +0000] DEBUG: Checking apt-cache policy for nova-scheduler
: stdout
[0K[default] [Fri, 11 Mar 2011 12:24:25 +0000] DEBUG: Current version is nil
[Fri, 11 Mar 2011 12:24:25 +0000] DEBUG: Current version is 2011.1-anso~dev~bzr635-maverick
[Fri, 11 Mar 2011 12:24:25 +0000] INFO: Installing package[nova-scheduler] version 2011.1-anso~dev~bzr635-maverick
[Fri, 11 Mar 2011 12:24:25 +0000] DEBUG: Executing apt-get -q -y --force-yes install nova-scheduler=2011.1-anso~dev~bzr635-maverick
: stdout

[0K[default] [Fri, 11 Mar 2011 12:24:27 +0000] DEBUG: ---- Begin output of apt-get -q -y --force-yes install nova-scheduler=2011.1-anso~dev~bzr635-maverick ----
[Fri, 11 Mar 2011 12:24:27 +0000] DEBUG: STDOUT: Reading package lists...
Building dependency tree...
Reading state information...
The following NEW packages will be installed:
nova-scheduler
0 upgraded, 1 newly installed, 0 to remove and 71 not upgraded.
Need to get 0B/6,140B of archives.
After this operation, 77.8kB of additional disk space will be used.
Selecting previously deselected package nova-scheduler.
(Reading database ... 52660 files and directories currently installed.)
Unpacking nova-scheduler (from .../nova-scheduler_2011.1-anso~dev~bzr635-maverick_all.deb) ...
Processing triggers for ureadahead ...
Setting up nova-scheduler (2011.1-anso~dev~bzr635-maverick) ...
[Fri, 11 Mar 2011 12:24:27 +0000] DEBUG: STDERR:
[Fri, 11 Mar 2011 12:24:27 +0000] DEBUG: ---- End output of apt-get -q -y --force-yes install nova-scheduler=2011.1-anso~dev~bzr635-maverick ----
[Fri, 11 Mar 2011 12:24:27 +0000] DEBUG: Ran apt-get -q -y --force-yes install nova-scheduler=2011.1-anso~dev~bzr635-maverick returned 0
[Fri, 11 Mar 2011 12:24:27 +0000] DEBUG: Processing service[nova-scheduler] on maverick.hsd1.ca.comcast.net.
[Fri, 11 Mar 2011 12:24:27 +0000] DEBUG: service[nova-scheduler] you have specified a status command, running..
[Fri, 11 Mar 2011 12:24:27 +0000] DEBUG: Executing status nova-scheduler | cut -d' ' -f2 | cut -d'/' -f1 | grep start
: stdout
[0K[default] [Fri, 11 Mar 2011 12:24:27 +0000] DEBUG: ---- Begin output of status nova-scheduler | cut -d' ' -f2 | cut -d'/' -f1 | grep start ----
[Fri, 11 Mar 2011 12:24:27 +0000] DEBUG: STDOUT:
[Fri, 11 Mar 2011 12:24:27 +0000] DEBUG: STDERR:
[Fri, 11 Mar 2011 12:24:27 +0000] DEBUG: ---- End output of status nova-scheduler | cut -d' ' -f2 | cut -d'/' -f1 | grep start ----
[Fri, 11 Mar 2011 12:24:27 +0000] DEBUG: Ran status nova-scheduler | cut -d' ' -f2 | cut -d'/' -f1 | grep start returned 1
: stdout
[0K[default] [Fri, 11 Mar 2011 12:24:27 +0000] DEBUG: service[nova-scheduler]: attempting to start
[Fri, 11 Mar 2011 12:24:27 +0000] DEBUG: Executing start nova-scheduler
: stdout

[0K[default] [Fri, 11 Mar 2011 12:24:27 +0000] DEBUG: ---- Begin output of start nova-scheduler ----
[Fri, 11 Mar 2011 12:24:27 +0000] DEBUG: STDOUT: nova-scheduler start/running, process 8872
[Fri, 11 Mar 2011 12:24:27 +0000] DEBUG: STDERR:
[Fri, 11 Mar 2011 12:24:27 +0000] DEBUG: ---- End output of start nova-scheduler ----
[Fri, 11 Mar 2011 12:24:27 +0000] DEBUG: Ran start nova-scheduler returned 0
[Fri, 11 Mar 2011 12:24:27 +0000] INFO: Started service service[nova-scheduler] successfully
[Fri, 11 Mar 2011 12:24:27 +0000] DEBUG: Processing package[nova-network] on maverick.hsd1.ca.comcast.net.
[Fri, 11 Mar 2011 12:24:27 +0000] DEBUG: Checking apt-cache policy for nova-network
: stdout
[0K[default] [Fri, 11 Mar 2011 12:24:29 +0000] DEBUG: Current version is nil
[Fri, 11 Mar 2011 12:24:29 +0000] DEBUG: Current version is 2011.1-anso~dev~bzr635-maverick
[Fri, 11 Mar 2011 12:24:29 +0000] INFO: Installing package[nova-network] version 2011.1-anso~dev~bzr635-maverick
[Fri, 11 Mar 2011 12:24:29 +0000] DEBUG: Executing apt-get -q -y --force-yes install nova-network=2011.1-anso~dev~bzr635-maverick
: stdout

[0K[default] [Fri, 11 Mar 2011 12:24:34 +0000] DEBUG: ---- Begin output of apt-get -q -y --force-yes install nova-network=2011.1-anso~dev~bzr635-maverick ----
[Fri, 11 Mar 2011 12:24:34 +0000] DEBUG: STDOUT: Reading package lists...
Building dependency tree...
Reading state information...
The following extra packages will be installed:
bridge-utils dnsmasq-base nova-network vlan
The following NEW packages will be installed:
bridge-utils dnsmasq-base nova-network vlan
0 upgraded, 4 newly installed, 0 to remove and 71 not upgraded.
Need to get 0B/342kB of archives.
After this operation, 1,241kB of additional disk space will be used.
Selecting previously deselected package bridge-utils.
(Reading database ... 52667 files and directories currently installed.)
Unpacking bridge-utils (from .../bridge-utils_1.4-5ubuntu2_amd64.deb) ...
Selecting previously deselected package dnsmasq-base.
Unpacking dnsmasq-base (from .../dnsmasq-base_2.55-1_amd64.deb) ...
Selecting previously deselected package vlan.
Unpacking vlan (from .../vlan_1.9-3ubuntu3_amd64.deb) ...
Selecting previously deselected package nova-network.
Unpacking nova-network (from .../nova-network_2011.1-anso~dev~bzr635-maverick_all.deb) ...
Processing triggers for ureadahead ...
Processing triggers for man-db ...
Setting up bridge-utils (1.4-5ubuntu2) ...
Setting up dnsmasq-base (2.55-1) ...
Setting up vlan (1.9-3ubuntu3) ...
Setting up nova-network (2011.1-anso~dev~bzr635-maverick) ...
[Fri, 11 Mar 2011 12:24:34 +0000] DEBUG: STDERR:
[Fri, 11 Mar 2011 12:24:34 +0000] DEBUG: ---- End output of apt-get -q -y --force-yes install nova-network=2011.1-anso~dev~bzr635-maverick ----
[Fri, 11 Mar 2011 12:24:34 +0000] DEBUG: Ran apt-get -q -y --force-yes install nova-network=2011.1-anso~dev~bzr635-maverick returned 0
[Fri, 11 Mar 2011 12:24:34 +0000] DEBUG: Processing service[nova-network] on maverick.hsd1.ca.comcast.net.
[Fri, 11 Mar 2011 12:24:34 +0000] DEBUG: service[nova-network] you have specified a status command, running..
[Fri, 11 Mar 2011 12:24:34 +0000] DEBUG: Executing status nova-network | cut -d' ' -f2 | cut -d'/' -f1 | grep start
: stdout
[0K[default] [Fri, 11 Mar 2011 12:24:34 +0000] DEBUG: ---- Begin output of status nova-network | cut -d' ' -f2 | cut -d'/' -f1 | grep start ----
[Fri, 11 Mar 2011 12:24:34 +0000] DEBUG: STDOUT:
[Fri, 11 Mar 2011 12:24:34 +0000] DEBUG: STDERR:
[Fri, 11 Mar 2011 12:24:34 +0000] DEBUG: ---- End output of status nova-network | cut -d' ' -f2 | cut -d'/' -f1 | grep start ----
[Fri, 11 Mar 2011 12:24:34 +0000] DEBUG: Ran status nova-network | cut -d' ' -f2 | cut -d'/' -f1 | grep start returned 1
: stdout
[0K[default] [Fri, 11 Mar 2011 12:24:34 +0000] DEBUG: service[nova-network]: attempting to start
[Fri, 11 Mar 2011 12:24:34 +0000] DEBUG: Executing start nova-network
: stdout

[0K[default] [Fri, 11 Mar 2011 12:24:34 +0000] DEBUG: ---- Begin output of start nova-network ----
[Fri, 11 Mar 2011 12:24:34 +0000] DEBUG: STDOUT: nova-network start/running, process 8983
[Fri, 11 Mar 2011 12:24:34 +0000] DEBUG: STDERR:
[Fri, 11 Mar 2011 12:24:34 +0000] DEBUG: ---- End output of start nova-network ----
[Fri, 11 Mar 2011 12:24:34 +0000] DEBUG: Ran start nova-network returned 0
[Fri, 11 Mar 2011 12:24:34 +0000] INFO: Started service service[nova-network] successfully
[Fri, 11 Mar 2011 12:24:34 +0000] DEBUG: Processing execute[sysctl -p] on maverick.hsd1.ca.comcast.net.
[Fri, 11 Mar 2011 12:24:34 +0000] DEBUG: Doing nothing for execute[sysctl -p]
[Fri, 11 Mar 2011 12:24:34 +0000] DEBUG: Processing template[/etc/sysctl.conf] on maverick.hsd1.ca.comcast.net.
[Fri, 11 Mar 2011 12:24:34 +0000] DEBUG: looking for template sysctl.conf.erb in cookbook :nova
[Fri, 11 Mar 2011 12:24:34 +0000] DEBUG: Current content's checksum: c29dd9cb5823e7c46dfbe974873091d006e3b2d8e74ddef6197f9e6105c68aed
[Fri, 11 Mar 2011 12:24:34 +0000] DEBUG: Rendered content's checksum: 57b90f71813606b4be92e904a5d207b5e65dbf2436d09069dc0333d8a266f017
[Fri, 11 Mar 2011 12:24:34 +0000] INFO: Writing updated content for template[/etc/sysctl.conf] to /etc/sysctl.conf
[Fri, 11 Mar 2011 12:24:34 +0000] INFO: Backing up template[/etc/sysctl.conf] to /var/chef/backup/etc/sysctl.conf.chef-20110311122434
[Fri, 11 Mar 2011 12:24:34 +0000] DEBUG: setting mode on /tmp/chef-rendered-template20110311-1016-14csm6y-0 to 644
[Fri, 11 Mar 2011 12:24:34 +0000] INFO: template[/etc/sysctl.conf] sending run action to execute[sysctl -p] (immediate)
[Fri, 11 Mar 2011 12:24:34 +0000] DEBUG: Executing sysctl -p
: stdout
[0K[default] [Fri, 11 Mar 2011 12:24:34 +0000] DEBUG: ---- Begin output of sysctl -p ----
[Fri, 11 Mar 2011 12:24:34 +0000] DEBUG: STDOUT: net.ipv4.ip_forward = 1
[Fri, 11 Mar 2011 12:24:34 +0000] DEBUG: STDERR:
[Fri, 11 Mar 2011 12:24:34 +0000] DEBUG: ---- End output of sysctl -p ----
[Fri, 11 Mar 2011 12:24:34 +0000] DEBUG: Ran sysctl -p returned 0
[Fri, 11 Mar 2011 12:24:34 +0000] INFO: Ran execute[sysctl -p] successfully
[Fri, 11 Mar 2011 12:24:34 +0000] DEBUG: Processing package[nova-objectstore] on maverick.hsd1.ca.comcast.net.
[Fri, 11 Mar 2011 12:24:34 +0000] DEBUG: Checking apt-cache policy for nova-objectstore
: stdout
[0K[default] [Fri, 11 Mar 2011 12:24:37 +0000] DEBUG: Current version is nil
[Fri, 11 Mar 2011 12:24:37 +0000] DEBUG: Current version is 2011.1-anso~dev~bzr635-maverick
[Fri, 11 Mar 2011 12:24:37 +0000] INFO: Installing package[nova-objectstore] version 2011.1-anso~dev~bzr635-maverick
[Fri, 11 Mar 2011 12:24:37 +0000] DEBUG: Executing apt-get -q -y --force-yes install nova-objectstore=2011.1-anso~dev~bzr635-maverick
: stdout

[0K[default] [Fri, 11 Mar 2011 12:24:43 +0000] DEBUG: ---- Begin output of apt-get -q -y --force-yes install nova-objectstore=2011.1-anso~dev~bzr635-maverick ----
[Fri, 11 Mar 2011 12:24:43 +0000] DEBUG: STDOUT: Reading package lists...
Building dependency tree...
Reading state information...
The following NEW packages will be installed:
nova-objectstore
0 upgraded, 1 newly installed, 0 to remove and 71 not upgraded.
Need to get 0B/6,388B of archives.
After this operation, 90.1kB of additional disk space will be used.
Selecting previously deselected package nova-objectstore.
(Reading database ... 52733 files and directories currently installed.)
Unpacking nova-objectstore (from .../nova-objectstore_2011.1-anso~dev~bzr635-maverick_all.deb) ...
Processing triggers for ureadahead ...
Setting up nova-objectstore (2011.1-anso~dev~bzr635-maverick) ...
[Fri, 11 Mar 2011 12:24:43 +0000] DEBUG: STDERR:
[Fri, 11 Mar 2011 12:24:43 +0000] DEBUG: ---- End output of apt-get -q -y --force-yes install nova-objectstore=2011.1-anso~dev~bzr635-maverick ----
[Fri, 11 Mar 2011 12:24:43 +0000] DEBUG: Ran apt-get -q -y --force-yes install nova-objectstore=2011.1-anso~dev~bzr635-maverick returned 0
[Fri, 11 Mar 2011 12:24:43 +0000] DEBUG: Processing service[nova-objectstore] on maverick.hsd1.ca.comcast.net.
[Fri, 11 Mar 2011 12:24:43 +0000] DEBUG: service[nova-objectstore] you have specified a status command, running..
[Fri, 11 Mar 2011 12:24:43 +0000] DEBUG: Executing status nova-objectstore | cut -d' ' -f2 | cut -d'/' -f1 | grep start
: stdout
[0K[default] [Fri, 11 Mar 2011 12:24:43 +0000] DEBUG: ---- Begin output of status nova-objectstore | cut -d' ' -f2 | cut -d'/' -f1 | grep start ----
[Fri, 11 Mar 2011 12:24:43 +0000] DEBUG: STDOUT:
[Fri, 11 Mar 2011 12:24:43 +0000] DEBUG: STDERR:
[Fri, 11 Mar 2011 12:24:43 +0000] DEBUG: ---- End output of status nova-objectstore | cut -d' ' -f2 | cut -d'/' -f1 | grep start ----
[Fri, 11 Mar 2011 12:24:43 +0000] DEBUG: Ran status nova-objectstore | cut -d' ' -f2 | cut -d'/' -f1 | grep start returned 1
: stdout
[0K[default] [Fri, 11 Mar 2011 12:24:43 +0000] DEBUG: service[nova-objectstore]: attempting to start
[Fri, 11 Mar 2011 12:24:43 +0000] DEBUG: Executing start nova-objectstore
: stdout

[0K[default] [Fri, 11 Mar 2011 12:24:43 +0000] DEBUG: ---- Begin output of start nova-objectstore ----
[Fri, 11 Mar 2011 12:24:43 +0000] DEBUG: STDOUT: nova-objectstore start/running, process 9102
[Fri, 11 Mar 2011 12:24:43 +0000] DEBUG: STDERR:
[Fri, 11 Mar 2011 12:24:43 +0000] DEBUG: ---- End output of start nova-objectstore ----
[Fri, 11 Mar 2011 12:24:43 +0000] DEBUG: Ran start nova-objectstore returned 0
[Fri, 11 Mar 2011 12:24:43 +0000] INFO: Started service service[nova-objectstore] successfully
[Fri, 11 Mar 2011 12:24:43 +0000] DEBUG: Processing package[nova-compute] on maverick.hsd1.ca.comcast.net.
[Fri, 11 Mar 2011 12:24:43 +0000] DEBUG: Checking apt-cache policy for nova-compute
: stdout
[0K[default] [Fri, 11 Mar 2011 12:24:45 +0000] DEBUG: Current version is nil
[Fri, 11 Mar 2011 12:24:45 +0000] DEBUG: Current version is 2011.1-anso~dev~bzr635-maverick
[Fri, 11 Mar 2011 12:24:45 +0000] INFO: Installing package[nova-compute] version 2011.1-anso~dev~bzr635-maverick
[Fri, 11 Mar 2011 12:24:45 +0000] DEBUG: Executing apt-get -q -y --force-yes install nova-compute=2011.1-anso~dev~bzr635-maverick
: stdout

[0K[default] [Fri, 11 Mar 2011 12:26:42 +0000] DEBUG: ---- Begin output of apt-get -q -y --force-yes install nova-compute=2011.1-anso~dev~bzr635-maverick ----
[Fri, 11 Mar 2011 12:26:42 +0000] DEBUG: STDOUT: Reading package lists...
Building dependency tree...
Reading state information...
The following extra packages will be installed:
  cpu-checker ebtables gawk kpartx kvm libaio1 libasound2 libavahi-client3
  libavahi-common-data libavahi-common3 libflac8 libice6 libnl1 libogg0
  libpciaccess0 libpulse0 libpython2.6 libsdl1.2debian libsdl1.2debian-alsa
  libsm6 libsndfile1 libvirt-bin libvirt0 libvorbis0a libvorbisenc2
  libx11-xcb1 libxcb-atom1 libxen3 libxi6 libxml2-utils libxtst6 nova-compute
  open-iscsi open-iscsi-utils python-libvirt qemu-common qemu-kvm seabios
  vgabios x11-common
Suggested packages:
  libasound2-plugins pulseaudio policykit-1 mol-drivers-macosx openbios-sparc
  kvm-pxe ubuntu-vm-builder uml-utilities
The following NEW packages will be installed:
  cpu-checker ebtables gawk kpartx kvm libaio1 libasound2 libavahi-client3
  libavahi-common-data libavahi-common3 libflac8 libice6 libnl1 libogg0
  libpciaccess0 libpulse0 libpython2.6 libsdl1.2debian libsdl1.2debian-alsa
  libsm6 libsndfile1 libvirt-bin libvirt0 libvorbis0a libvorbisenc2
  libx11-xcb1 libxcb-atom1 libxen3 libxi6 libxml2-utils libxtst6 nova-compute
  open-iscsi open-iscsi-utils python-libvirt qemu-common qemu-kvm seabios
  vgabios x11-common
Preconfiguring packages ...
0 upgraded, 40 newly installed, 0 to remove and 71 not upgraded.
Need to get 0B/9,741kB of archives.
After this operation, 30.2MB of additional disk space will be used.
Selecting previously deselected package gawk.
(Reading database ... 52741 files and directories currently installed.)
Unpacking gawk (from .../gawk_1%3a3.1.7.dfsg-5_amd64.deb) ...
Selecting previously deselected package x11-common.
Unpacking x11-common (from .../x11-common_1%3a7.5+6ubuntu3_all.deb) ...
Selecting previously deselected package cpu-checker.
Unpacking cpu-checker (from .../cpu-checker_0.1-0ubuntu2_all.deb) ...
Selecting previously deselected package ebtables.
Unpacking ebtables (from .../ebtables_2.0.9.2-2_amd64.deb) ...
Selecting previously deselected package libaio1.
Unpacking libaio1 (from .../libaio1_0.3.107-7ubuntu1_amd64.deb) ...
Selecting previously deselected package libpython2.6.
Unpacking libpython2.6 (from .../libpython2.6_2.6.6-5ubuntu1_amd64.deb) ...
Selecting previously deselected package libasound2.
Unpacking libasound2 (from .../libasound2_1.0.23-1ubuntu2.1_amd64.deb) ...
Selecting previously deselected package libice6.
Unpacking libice6 (from .../libice6_2%3a1.0.6-1_amd64.deb) ...
Selecting previously deselected package libsm6.
Unpacking libsm6 (from .../libsm6_2%3a1.1.1-1_amd64.deb) ...
Selecting previously deselected package libogg0.
Unpacking libogg0 (from .../libogg0_1.2.0~dfsg-1_amd64.deb) ...
Selecting previously deselected package libflac8.
Unpacking libflac8 (from .../libflac8_1.2.1-3_amd64.deb) ...
Selecting previously deselected package libvorbis0a.
Unpacking libvorbis0a (from .../libvorbis0a_1.3.1-1_amd64.deb) ...
Selecting previously deselected package libvorbisenc2.
Unpacking libvorbisenc2 (from .../libvorbisenc2_1.3.1-1_amd64.deb) ...
Selecting previously deselected package libsndfile1.
Unpacking libsndfile1 (from .../libsndfile1_1.0.21-2_amd64.deb) ...
Selecting previously deselected package libx11-xcb1.
Unpacking libx11-xcb1 (from .../libx11-xcb1_2%3a1.3.3-3ubuntu1_amd64.deb) ...
Selecting previously deselected package libxcb-atom1.
Unpacking libxcb-atom1 (from .../libxcb-atom1_0.3.6-1build1_amd64.deb) ...
Selecting previously deselected package libxi6.
Unpacking libxi6 (from .../libxi6_2%3a1.3-4_amd64.deb) ...
Selecting previously deselected package libxtst6.
Unpacking libxtst6 (from .../libxtst6_2%3a1.1.0-3_amd64.deb) ...
Selecting previously deselected package libpulse0.
Unpacking libpulse0 (from .../libpulse0_1%3a0.9.22~0.9.21+stable-queue-32-g8478-0ubuntu21.1_amd64.deb) ...
Selecting previously deselected package libsdl1.2debian-alsa.
Unpacking libsdl1.2debian-alsa (: stdout

[0K[default] from .../libsdl1.2debian-alsa_1.2.14-6ubuntu3_amd64.deb) ...
Selecting previously deselected package libsdl1.2debian.
Unpacking libsdl1.2debian (from .../libsdl1.2debian_1.2.14-6ubuntu3_amd64.deb) ...
Selecting previously deselected package seabios.
Unpacking seabios (from .../seabios_0.6.0-0ubuntu1_all.deb) ...
Selecting previously deselected package vgabios.
Unpacking vgabios (from .../vgabios_0.6c-2ubuntu1_all.deb) ...
Selecting previously deselected package qemu-common.
Unpacking qemu-common (from .../qemu-common_0.12.5+noroms-0ubuntu7.2_all.deb) ...
Selecting previously deselected package qemu-kvm.
Unpacking qemu-kvm (from .../qemu-kvm_0.12.5+noroms-0ubuntu7.2_amd64.deb) ...
Selecting previously deselected package kvm.
Unpacking kvm (from .../kvm_1%3a84+dfsg-0ubuntu16+0.12.5+noroms+0ubuntu7.2_amd64.deb) ...
Selecting previously deselected package libavahi-common-data.
Unpacking libavahi-common-data (from .../libavahi-common-data_0.6.27-2ubuntu3.1_amd64.deb) ...
Selecting previously deselected package libavahi-common3.
Unpacking libavahi-common3 (from .../libavahi-common3_0.6.27-2ubuntu3.1_amd64.deb) ...
Selecting previously deselected package libavahi-client3.
Unpacking libavahi-client3 (from .../libavahi-client3_0.6.27-2ubuntu3.1_amd64.deb) ...
Selecting previously deselected package libnl1.
Unpacking libnl1 (from .../libnl1_1.1-5build1_amd64.deb) ...
Selecting previously deselected package libpciaccess0.
Unpacking libpciaccess0 (from .../libpciaccess0_0.12.0-1_amd64.deb) ...
Selecting previously deselected package libxen3.
Unpacking libxen3 (from .../libxen3_3.3.0-1ubuntu12_amd64.deb) ...
Selecting previously deselected package libvirt0.
Unpacking libvirt0 (from .../libvirt0_0.8.3-1ubuntu14_amd64.deb) ...
Selecting previously deselected package libvirt-bin.
Unpacking libvirt-bin (from .../libvirt-bin_0.8.3-1ubuntu14_amd64.deb) ...
Selecting previously deselected package libxml2-utils.
Unpacking libxml2-utils (from .../libxml2-utils_2.7.7.dfsg-4ubuntu0.1_amd64.deb) ...
Selecting previously deselected package open-iscsi-utils.
Unpacking open-iscsi-utils (from .../open-iscsi-utils_2.0.871-0ubuntu5_amd64.deb) ...
Selecting previously deselected package open-iscsi.
Unpacking open-iscsi (from .../open-iscsi_2.0.871-0ubuntu5_amd64.deb) ...
Selecting previously deselected package python-libvirt.
Unpacking python-libvirt (from .../python-libvirt_0.8.3-1ubuntu14_amd64.deb) ...
Selecting previously deselected package kpartx.
Unpacking kpartx (from .../kpartx_0.4.8-14ubuntu4_amd64.deb) ...
Selecting previously deselected package nova-compute.
Unpacking nova-compute (from .../nova-compute_2011.1-anso~dev~bzr635-maverick_all.deb) ...
Processing triggers for man-db ...
Processing triggers for ureadahead ...
Setting up gawk (1:3.1.7.dfsg-5) ...
Setting up x11-common (1:7.5+6ubuntu3) ...
Setting up cpu-checker (0.1-0ubuntu2) ...
Setting up ebtables (2.0.9.2-2) ...
Setting up libaio1 (0.3.107-7ubuntu1) ...
Setting up libpython2.6 (2.6.6-5ubuntu1) ...
Setting up libasound2 (1.0.23-1ubuntu2.1) ...
Setting up libice6 (2:1.0.6-1) ...
Setting up libsm6 (2:1.1.1-1) ...
Setting up libogg0 (1.2.0~dfsg-1) ...
Setting up libflac8 (1.2.1-3) ...
Setting up libvorbis0a (1.3.1-1) ...
Setting up libvorbisenc2 (1.3.1-1) ...
Setting up libsndfile1 (1.0.21-2) ...
Setting up libx11-xcb1 (2:1.3.3-3ubuntu1) ...
Setting up libxcb-atom1 (0.3.6-1build1) ...
Setting up libxi6 (2:1.3-4) ...
Setting up libxtst6 (2:1.1.0-3) ...
Setting up libpulse0 (1:0.9.22~0.9.21+stable-queue-32-g8478-0ubuntu21.1) ...
Setting up libsdl1.2debian-alsa (1.2.14-6ubuntu3) ...
Setting up libsdl1.2debian (1.2.14-6ubuntu3) ...
Setting up seabios (0.6.0-0ubuntu1) ...
Setting up vgabios (0.6c-2ubuntu1) ...
Setting up qemu-common (0.12.5+noroms-0ubuntu7.2) ...
Setting up qemu-kvm (0.12.5+noroms-0ubuntu7.2) ...
qemu-kvm start/running
Setting up kvm (1:84+dfsg-0ubuntu16+0.12.5+noroms+0ubuntu7.2) ...
Setting up libavahi-common-data (0.6.27-2ubuntu3.1) ...
Setting up libavahi-common3 (0.6.27-2ubuntu3.1) ...
Setting up libavahi-client3 (0.6.27-2ubuntu3.1) ...
Setting up libnl1 (1.1-5build1: stdout

[0K[default] ) ...
Setting up libpciaccess0 (0.12.0-1) ...
Setting up libxen3 (3.3.0-1ubuntu12) ...
Setting up libvirt0 (0.8.3-1ubuntu14) ...
Setting up libvirt-bin (0.8.3-1ubuntu14) ...
Adding group `libvirtd' (GID 113) ...
Done.
libvirt-bin start/running, process 11517
Setting up libxml2-utils (2.7.7.dfsg-4ubuntu0.1) ...
Setting up open-iscsi-utils (2.0.871-0ubuntu5) ...
Setting up open-iscsi (2.0.871-0ubuntu5) ...
* Starting iSCSI initiator service iscsid
...done.
* Setting up iSCSI targets
...done.
Setting up python-libvirt (0.8.3-1ubuntu14) ...
Setting up kpartx (0.4.8-14ubuntu4) ...
Processing triggers for python-central ...
Setting up nova-compute (2011.1-anso~dev~bzr635-maverick) ...
Adding user `nova' to group `libvirtd' ...
Adding user nova to group libvirtd
Done.
Processing triggers for libc-bin ...
ldconfig deferred processing now taking place
[Fri, 11 Mar 2011 12:26:42 +0000] DEBUG: STDERR:
Extracting templates from packages: 75%
Extracting templates from packages: 100%
update-rc.d: warning: open-iscsi stop runlevel arguments (0 1 6) do not match LSB Default-Stop values (0 6)
[Fri, 11 Mar 2011 12:26:42 +0000] DEBUG: ---- End output of apt-get -q -y --force-yes install nova-compute=2011.1-anso~dev~bzr635-maverick ----
[Fri, 11 Mar 2011 12:26:42 +0000] DEBUG: Ran apt-get -q -y --force-yes install nova-compute=2011.1-anso~dev~bzr635-maverick returned 0
[Fri, 11 Mar 2011 12:26:42 +0000] DEBUG: Processing service[nova-compute] on maverick.hsd1.ca.comcast.net.
[Fri, 11 Mar 2011 12:26:42 +0000] DEBUG: service[nova-compute] you have specified a status command, running..
[Fri, 11 Mar 2011 12:26:42 +0000] DEBUG: Executing status nova-compute | cut -d' ' -f2 | cut -d'/' -f1 | grep start
: stdout

[0K[default] [Fri, 11 Mar 2011 12:26:43 +0000] DEBUG: ---- Begin output of status nova-compute | cut -d' ' -f2 | cut -d'/' -f1 | grep start ----
[Fri, 11 Mar 2011 12:26:43 +0000] DEBUG: STDOUT:
[Fri, 11 Mar 2011 12:26:43 +0000] DEBUG: STDERR:
[Fri, 11 Mar 2011 12:26:43 +0000] DEBUG: ---- End output of status nova-compute | cut -d' ' -f2 | cut -d'/' -f1 | grep start ----
[Fri, 11 Mar 2011 12:26:43 +0000] DEBUG: Ran status nova-compute | cut -d' ' -f2 | cut -d'/' -f1 | grep start returned 1
: stdout
[0K[default] [Fri, 11 Mar 2011 12:26:43 +0000] DEBUG: service[nova-compute]: attempting to start
[Fri, 11 Mar 2011 12:26:43 +0000] DEBUG: Executing start nova-compute
: stdout

[0K[default] [Fri, 11 Mar 2011 12:26:43 +0000] DEBUG: ---- Begin output of start nova-compute ----
[Fri, 11 Mar 2011 12:26:43 +0000] DEBUG: STDOUT: nova-compute start/running, process 11870
[Fri, 11 Mar 2011 12:26:43 +0000] DEBUG: STDERR:
[Fri, 11 Mar 2011 12:26:43 +0000] DEBUG: ---- End output of start nova-compute ----
[Fri, 11 Mar 2011 12:26:43 +0000] DEBUG: Ran start nova-compute returned 0
[Fri, 11 Mar 2011 12:26:43 +0000] INFO: Started service service[nova-compute] successfully
[Fri, 11 Mar 2011 12:26:43 +0000] DEBUG: Processing execute[modprobe nbd] on maverick.hsd1.ca.comcast.net.
[Fri, 11 Mar 2011 12:26:43 +0000] DEBUG: Executing modprobe nbd
: stdout
[0K[default] [Fri, 11 Mar 2011 12:26:43 +0000] DEBUG: ---- Begin output of modprobe nbd ----
[Fri, 11 Mar 2011 12:26:43 +0000] DEBUG: STDOUT:
[Fri, 11 Mar 2011 12:26:43 +0000] DEBUG: STDERR:
[Fri, 11 Mar 2011 12:26:43 +0000] DEBUG: ---- End output of modprobe nbd ----
[Fri, 11 Mar 2011 12:26:43 +0000] DEBUG: Ran modprobe nbd returned 0
[Fri, 11 Mar 2011 12:26:43 +0000] INFO: Ran execute[modprobe nbd] successfully
[Fri, 11 Mar 2011 12:26:43 +0000] DEBUG: Processing package[nova-volume] on maverick.hsd1.ca.comcast.net.
[Fri, 11 Mar 2011 12:26:43 +0000] DEBUG: Checking apt-cache policy for nova-volume
: stdout
[0K[default] [Fri, 11 Mar 2011 12:26:45 +0000] DEBUG: Current version is nil
[Fri, 11 Mar 2011 12:26:45 +0000] DEBUG: Current version is 2011.1-anso~dev~bzr635-maverick
[Fri, 11 Mar 2011 12:26:45 +0000] INFO: Installing package[nova-volume] version 2011.1-anso~dev~bzr635-maverick
[Fri, 11 Mar 2011 12:26:45 +0000] DEBUG: Executing apt-get -q -y --force-yes install nova-volume=2011.1-anso~dev~bzr635-maverick
: stdout

[0K[default] [Fri, 11 Mar 2011 12:27:11 +0000] DEBUG: ---- Begin output of apt-get -q -y --force-yes install nova-volume=2011.1-anso~dev~bzr635-maverick ----
[Fri, 11 Mar 2011 12:27:11 +0000] DEBUG: STDOUT: Reading package lists...
Building dependency tree...
Reading state information...
The following extra packages will be installed:
  aoetools fgetty iscsitarget nova-volume runit vblade vblade-persist
Suggested packages:
  iscsitarget-source iscsitarget-dkms runit-run socklog-run
Recommended packages:
  iscsitarget-module
The following NEW packages will be installed:
  aoetools fgetty iscsitarget nova-volume runit vblade vblade-persist
Preconfiguring packages ...
0 upgraded, 7 newly installed, 0 to remove and 71 not upgraded.
Need to get 0B/297kB of archives.
After this operation, 1,536kB of additional disk space will be used.
Selecting previously deselected package aoetools.
(Reading database ... 53508 files and directories currently installed.)
Unpacking aoetools (from .../aoetools_30-3ubuntu1_amd64.deb) ...
Selecting previously deselected package fgetty.
Unpacking fgetty (from .../fgetty_0.6-5build1_amd64.deb) ...
Selecting previously deselected package iscsitarget.
Unpacking iscsitarget (from .../iscsitarget_1.4.20.2-1ubuntu1_amd64.deb) ...
Selecting previously deselected package runit.
Unpacking runit (from .../runit_2.1.1-4ubuntu1_amd64.deb) ...
Selecting previously deselected package vblade.
Unpacking vblade (from .../vblade_20-1ubuntu1_amd64.deb) ...
Selecting previously deselected package vblade-persist.
Unpacking vblade-persist (from .../vblade-persist_0.6-2_all.deb) ...
Selecting previously deselected package nova-volume.
Unpacking nova-volume (from .../nova-volume_2011.1-anso~dev~bzr635-maverick_all.deb) ...
Processing triggers for man-db ...
Processing triggers for ureadahead ...
Setting up aoetools (30-3ubuntu1) ...
* Starting AoE devices discovery and mounting AoE filesystems
* not started.
Setting up fgetty (0.6-5build1) ...
Setting up iscsitarget (1.4.20.2-1ubuntu1) ...
* iscsitarget not enabled in "/etc/default/iscsitarget", not starting...
Setting up runit (2.1.1-4ubuntu1) ...
runsvdir start/running, process 12484
Setting up vblade (20-1ubuntu1) ...
* Starting vblade deaemons vblade
Setting up vblade-persist (0.6-2) ...
Setting up nova-volume (2011.1-anso~dev~bzr635-maverick) ...
[Fri, 11 Mar 2011 12:27:11 +0000] DEBUG: STDERR: grep: /etc/inittab: No such file or directory
[Fri, 11 Mar 2011 12:27:11 +0000] DEBUG: ---- End output of apt-get -q -y --force-yes install nova-volume=2011.1-anso~dev~bzr635-maverick ----
[Fri, 11 Mar 2011 12:27:11 +0000] DEBUG: Ran apt-get -q -y --force-yes install nova-volume=2011.1-anso~dev~bzr635-maverick returned 0
[Fri, 11 Mar 2011 12:27:11 +0000] DEBUG: Processing service[nova-volume] on maverick.hsd1.ca.comcast.net.
[Fri, 11 Mar 2011 12:27:11 +0000] DEBUG: service[nova-volume] you have specified a status command, running..
[Fri, 11 Mar 2011 12:27:11 +0000] DEBUG: Executing status nova-volume | cut -d' ' -f2 | cut -d'/' -f1 | grep start
: stdout

[0K[default] [Fri, 11 Mar 2011 12:27:11 +0000] DEBUG: ---- Begin output of status nova-volume | cut -d' ' -f2 | cut -d'/' -f1 | grep start ----
[Fri, 11 Mar 2011 12:27:11 +0000] DEBUG: STDOUT:
[Fri, 11 Mar 2011 12:27:11 +0000] DEBUG: STDERR:
[Fri, 11 Mar 2011 12:27:11 +0000] DEBUG: ---- End output of status nova-volume | cut -d' ' -f2 | cut -d'/' -f1 | grep start ----
[Fri, 11 Mar 2011 12:27:11 +0000] DEBUG: Ran status nova-volume | cut -d' ' -f2 | cut -d'/' -f1 | grep start returned 1
: stdout
[0K[default] [Fri, 11 Mar 2011 12:27:11 +0000] DEBUG: service[nova-volume]: attempting to start
[Fri, 11 Mar 2011 12:27:11 +0000] DEBUG: Executing start nova-volume
: stdout

[0K[default] [Fri, 11 Mar 2011 12:27:11 +0000] DEBUG: ---- Begin output of start nova-volume ----
[Fri, 11 Mar 2011 12:27:11 +0000] DEBUG: STDOUT: nova-volume start/running, process 12562
[Fri, 11 Mar 2011 12:27:11 +0000] DEBUG: STDERR:
[Fri, 11 Mar 2011 12:27:11 +0000] DEBUG: ---- End output of start nova-volume ----
[Fri, 11 Mar 2011 12:27:11 +0000] DEBUG: Ran start nova-volume returned 0
[Fri, 11 Mar 2011 12:27:11 +0000] INFO: Started service service[nova-volume] successfully
[Fri, 11 Mar 2011 12:27:11 +0000] DEBUG: Processing service[iscsitarget] on maverick.hsd1.ca.comcast.net.
[Fri, 11 Mar 2011 12:27:11 +0000] DEBUG: service[iscsitarget] supports status, running
[Fri, 11 Mar 2011 12:27:11 +0000] DEBUG: Executing /etc/init.d/iscsitarget status
: stdout
[0K[default] [Fri, 11 Mar 2011 12:27:11 +0000] DEBUG: ---- Begin output of /etc/init.d/iscsitarget status ----
[Fri, 11 Mar 2011 12:27:11 +0000] DEBUG: STDOUT: * could not access PID file for iSCSI enterprise target
[Fri, 11 Mar 2011 12:27:11 +0000] DEBUG: STDERR:
[Fri, 11 Mar 2011 12:27:11 +0000] DEBUG: ---- End output of /etc/init.d/iscsitarget status ----
[Fri, 11 Mar 2011 12:27:11 +0000] DEBUG: Ran /etc/init.d/iscsitarget status returned 4
: stdout
[0K[default] [Fri, 11 Mar 2011 12:27:12 +0000] DEBUG: Doing nothing for service[iscsitarget]
[Fri, 11 Mar 2011 12:27:12 +0000] DEBUG: Processing file[/etc/default/iscsitarget] on maverick.hsd1.ca.comcast.net.
[Fri, 11 Mar 2011 12:27:12 +0000] INFO: Setting content for file[/etc/default/iscsitarget]
[Fri, 11 Mar 2011 12:27:12 +0000] INFO: Backing up file[/etc/default/iscsitarget] to /var/chef/backup/etc/default/iscsitarget.chef-20110311122712
[Fri, 11 Mar 2011 12:27:12 +0000] INFO: file[/etc/default/iscsitarget] sending restart action to service[iscsitarget] (immediate)
[Fri, 11 Mar 2011 12:27:12 +0000] DEBUG: service[iscsitarget] supports status, running
[Fri, 11 Mar 2011 12:27:12 +0000] DEBUG: Executing /etc/init.d/iscsitarget status
: stdout

[0K[default] [Fri, 11 Mar 2011 12:27:12 +0000] DEBUG: ---- Begin output of /etc/init.d/iscsitarget status ----
[Fri, 11 Mar 2011 12:27:12 +0000] DEBUG: STDOUT: * could not access PID file for iSCSI enterprise target
[Fri, 11 Mar 2011 12:27:12 +0000] DEBUG: STDERR:
[Fri, 11 Mar 2011 12:27:12 +0000] DEBUG: ---- End output of /etc/init.d/iscsitarget status ----
[Fri, 11 Mar 2011 12:27:12 +0000] DEBUG: Ran /etc/init.d/iscsitarget status returned 4
: stdout
[0K[default] [Fri, 11 Mar 2011 12:27:12 +0000] DEBUG: service[iscsitarget]: attempting to restart
[Fri, 11 Mar 2011 12:27:12 +0000] DEBUG: Executing /etc/init.d/iscsitarget restart
: stdout

[0K[default] [Fri, 11 Mar 2011 12:27:13 +0000] DEBUG: ---- Begin output of /etc/init.d/iscsitarget restart ----
[Fri, 11 Mar 2011 12:27:13 +0000] DEBUG: STDOUT: * Removing iSCSI enterprise target devices:
   ...done.
* Starting iSCSI enterprise target service
   ...done.
   ...done.
[Fri, 11 Mar 2011 12:27:13 +0000] DEBUG: STDERR:
[Fri, 11 Mar 2011 12:27:13 +0000] DEBUG: ---- End output of /etc/init.d/iscsitarget restart ----
[Fri, 11 Mar 2011 12:27:13 +0000] DEBUG: Ran /etc/init.d/iscsitarget restart returned 0
[Fri, 11 Mar 2011 12:27:13 +0000] INFO: service[iscsitarget]: restarted successfully
[Fri, 11 Mar 2011 12:27:13 +0000] DEBUG: Processing package[euca2ools] on maverick.hsd1.ca.comcast.net.
[Fri, 11 Mar 2011 12:27:13 +0000] DEBUG: Checking apt-cache policy for euca2ools
: stdout
[0K[default] [Fri, 11 Mar 2011 12:27:15 +0000] DEBUG: Current version is nil
[Fri, 11 Mar 2011 12:27:15 +0000] DEBUG: Current version is 1.2-0ubuntu11.1
[Fri, 11 Mar 2011 12:27:15 +0000] INFO: Installing package[euca2ools] version 1.2-0ubuntu11.1
[Fri, 11 Mar 2011 12:27:15 +0000] DEBUG: Executing apt-get -q -y install euca2ools=1.2-0ubuntu11.1
: stdout

[0K[default] [Fri, 11 Mar 2011 12:27:48 +0000] DEBUG: ---- Begin output of apt-get -q -y install euca2ools=1.2-0ubuntu11.1 ----
[Fri, 11 Mar 2011 12:27:48 +0000] DEBUG: STDOUT: Reading package lists...
Building dependency tree...
Reading state information...
The following extra packages will be installed:
  cloud-utils euca2ools libyaml-0-2 python-crypto python-paramiko python-yaml
Suggested packages:
  python-crypto-dbg
The following NEW packages will be installed:
  cloud-utils euca2ools libyaml-0-2 python-crypto python-paramiko python-yaml
0 upgraded, 6 newly installed, 0 to remove and 71 not upgraded.
Need to get 0B/1,285kB of archives.
After this operation, 10.1MB of additional disk space will be used.
Selecting previously deselected package euca2ools.
(Reading database ... 53675 files and directories currently installed.)
Unpacking euca2ools (from .../euca2ools_1.2-0ubuntu11.1_all.deb) ...
Selecting previously deselected package libyaml-0-2.
Unpacking libyaml-0-2 (from .../libyaml-0-2_0.1.3-1_amd64.deb) ...
Selecting previously deselected package python-crypto.
Unpacking python-crypto (from .../python-crypto_2.0.1+dfsg1-4ubuntu2_amd64.deb) ...
Selecting previously deselected package python-paramiko.
Unpacking python-paramiko (from .../python-paramiko_1.7.6-2_all.deb) ...
Selecting previously deselected package python-yaml.
Unpacking python-yaml (from .../python-yaml_3.09-4build1_amd64.deb) ...
Selecting previously deselected package cloud-utils.
Unpacking cloud-utils (from .../cloud-utils_0.16ubuntu1_all.deb) ...
Processing triggers for man-db ...
Setting up euca2ools (1.2-0ubuntu11.1) ...
Setting up libyaml-0-2 (0.1.3-1) ...
Setting up python-crypto (2.0.1+dfsg1-4ubuntu2) ...
Setting up python-yaml (3.09-4build1) ...
Processing triggers for python-central ...
Setting up python-paramiko (1.7.6-2) ...
Setting up cloud-utils (0.16ubuntu1) ...
Processing triggers for libc-bin ...
ldconfig deferred processing now taking place
Processing triggers for python-support ...
[Fri, 11 Mar 2011 12:27:48 +0000] DEBUG: STDERR:
[Fri, 11 Mar 2011 12:27:48 +0000] DEBUG: ---- End output of apt-get -q -y install euca2ools=1.2-0ubuntu11.1 ----
[Fri, 11 Mar 2011 12:27:48 +0000] DEBUG: Ran apt-get -q -y install euca2ools=1.2-0ubuntu11.1 returned 0
[Fri, 11 Mar 2011 12:27:48 +0000] DEBUG: Processing package[curl] on maverick.hsd1.ca.comcast.net.
[Fri, 11 Mar 2011 12:27:48 +0000] DEBUG: Checking apt-cache policy for curl
: stdout
[0K[default] [Fri, 11 Mar 2011 12:27:49 +0000] DEBUG: Current version is 7.21.0-1ubuntu1
[Fri, 11 Mar 2011 12:27:49 +0000] DEBUG: Current version is 7.21.0-1ubuntu1
[Fri, 11 Mar 2011 12:27:49 +0000] DEBUG: Processing execute[nova-manage user admin admin UgyOFutNXtjzFqzouhGP pomcb4K9ekxERDsqjI4D] on maverick.hsd1.ca.comcast.net.
[Fri, 11 Mar 2011 12:27:49 +0000] DEBUG: Executing nova-manage user list | grep admin
: stdout

[0K[default] [Fri, 11 Mar 2011 12:27:52 +0000] DEBUG: ---- Begin output of nova-manage user list | grep admin ----
[Fri, 11 Mar 2011 12:27:52 +0000] DEBUG: STDOUT:
[Fri, 11 Mar 2011 12:27:52 +0000] DEBUG: STDERR:
[Fri, 11 Mar 2011 12:27:52 +0000] DEBUG: ---- End output of nova-manage user list | grep admin ----
[Fri, 11 Mar 2011 12:27:52 +0000] DEBUG: Ran nova-manage user list | grep admin returned 1
[Fri, 11 Mar 2011 12:27:52 +0000] DEBUG: Executing nova-manage user admin admin UgyOFutNXtjzFqzouhGP pomcb4K9ekxERDsqjI4D
: stdout
[0K[default] [Fri, 11 Mar 2011 12:27:54 +0000] DEBUG: ---- Begin output of nova-manage user admin admin UgyOFutNXtjzFqzouhGP pomcb4K9ekxERDsqjI4D ----
[Fri, 11 Mar 2011 12:27:54 +0000] DEBUG: STDOUT: export EC2_ACCESS_KEY=UgyOFutNXtjzFqzouhGP
export EC2_SECRET_KEY=pomcb4K9ekxERDsqjI4D
[Fri, 11 Mar 2011 12:27:54 +0000] DEBUG: STDERR:
[Fri, 11 Mar 2011 12:27:54 +0000] DEBUG: ---- End output of nova-manage user admin admin UgyOFutNXtjzFqzouhGP pomcb4K9ekxERDsqjI4D ----
[Fri, 11 Mar 2011 12:27:54 +0000] DEBUG: Ran nova-manage user admin admin UgyOFutNXtjzFqzouhGP pomcb4K9ekxERDsqjI4D returned 0
[Fri, 11 Mar 2011 12:27:54 +0000] INFO: Ran execute[nova-manage user admin admin UgyOFutNXtjzFqzouhGP pomcb4K9ekxERDsqjI4D] successfully
[Fri, 11 Mar 2011 12:27:54 +0000] DEBUG: Processing execute[nova-manage project create admin admin] on maverick.hsd1.ca.comcast.net.
[Fri, 11 Mar 2011 12:27:54 +0000] DEBUG: Executing nova-manage project list | grep admin
: stdout
[0K[default] [Fri, 11 Mar 2011 12:27:56 +0000] DEBUG: ---- Begin output of nova-manage project list | grep admin ----
[Fri, 11 Mar 2011 12:27:56 +0000] DEBUG: STDOUT:
[Fri, 11 Mar 2011 12:27:56 +0000] DEBUG: STDERR:
[Fri, 11 Mar 2011 12:27:56 +0000] DEBUG: ---- End output of nova-manage project list | grep admin ----
[Fri, 11 Mar 2011 12:27:56 +0000] DEBUG: Ran nova-manage project list | grep admin returned 1
[Fri, 11 Mar 2011 12:27:56 +0000] DEBUG: Executing nova-manage project create admin admin
: stdout
[0K[default] [Fri, 11 Mar 2011 12:27:58 +0000] DEBUG: ---- Begin output of nova-manage project create admin admin ----
[Fri, 11 Mar 2011 12:27:58 +0000] DEBUG: STDOUT:
[Fri, 11 Mar 2011 12:27:58 +0000] DEBUG: STDERR:
[Fri, 11 Mar 2011 12:27:58 +0000] DEBUG: ---- End output of nova-manage project create admin admin ----
[Fri, 11 Mar 2011 12:27:58 +0000] DEBUG: Ran nova-manage project create admin admin returned 0
[Fri, 11 Mar 2011 12:27:58 +0000] INFO: Ran execute[nova-manage project create admin admin] successfully
[Fri, 11 Mar 2011 12:27:58 +0000] DEBUG: Processing execute[nova-manage network create 10.0.86.0/24 8 32] on maverick.hsd1.ca.comcast.net.
[Fri, 11 Mar 2011 12:27:58 +0000] DEBUG: Executing nova-manage network create 10.0.86.0/24 8 32
: stdout
[0K[default] [Fri, 11 Mar 2011 12:28:01 +0000] DEBUG: ---- Begin output of nova-manage network create 10.0.86.0/24 8 32 ----
[Fri, 11 Mar 2011 12:28:01 +0000] DEBUG: STDOUT:
[Fri, 11 Mar 2011 12:28:01 +0000] DEBUG: STDERR:
[Fri, 11 Mar 2011 12:28:01 +0000] DEBUG: ---- End output of nova-manage network create 10.0.86.0/24 8 32 ----
[Fri, 11 Mar 2011 12:28:01 +0000] DEBUG: Ran nova-manage network create 10.0.86.0/24 8 32 returned 0
[Fri, 11 Mar 2011 12:28:01 +0000] INFO: Ran execute[nova-manage network create 10.0.86.0/24 8 32] successfully
[Fri, 11 Mar 2011 12:28:01 +0000] DEBUG: Processing execute[nova-manage floating create nova 192.168.86.128/28] on maverick.hsd1.ca.comcast.net.
[Fri, 11 Mar 2011 12:28:01 +0000] DEBUG: Executing nova-manage floating create nova 192.168.86.128/28
: stdout
[0K[default] [Fri, 11 Mar 2011 12:28:03 +0000] DEBUG: ---- Begin output of nova-manage floating create nova 192.168.86.128/28 ----
[Fri, 11 Mar 2011 12:28:03 +0000] DEBUG: STDOUT:
[Fri, 11 Mar 2011 12:28:03 +0000] DEBUG: STDERR:
[Fri, 11 Mar 2011 12:28:03 +0000] DEBUG: ---- End output of nova-manage floating create nova 192.168.86.128/28 ----
[Fri, 11 Mar 2011 12:28:03 +0000] DEBUG: Ran nova-manage floating create nova 192.168.86.128/28 returned 0
[Fri, 11 Mar 2011 12:28:03 +0000] INFO: Ran execute[nova-manage floating create nova 192.168.86.128/28] successfully
[Fri, 11 Mar 2011 12:28:03 +0000] DEBUG: Processing execute[curl http://images.ansolabs.com/tty.tgz | tar xvz -C /var/lib/nova/images] on maverick.hsd1.ca.comcast.net.
[Fri, 11 Mar 2011 12:28:03 +0000] DEBUG: Executing curl http://images.ansolabs.com/tty.tgz | tar xvz -C /var/lib/nova/images
: stdout
[0K[default] [Fri, 11 Mar 2011 12:28:17 +0000] DEBUG: ---- Begin output of curl http://images.ansolabs.com/tty.tgz | tar xvz -C /var/lib/nova/images ----
[Fri, 11 Mar 2011 12:28:17 +0000] DEBUG: STDOUT: aki-tty/
aki-tty/image
aki-tty/info.json
ami-tty/
ami-tty/image
ami-tty/info.json
ari-tty/
ari-tty/image
ari-tty/info.json
[Fri, 11 Mar 2011 12:28:17 +0000] DEBUG: STDERR: % Total % Received % Xferd Average Speed Time Time Time Current
Dload Upload Total Spent Left Speed

0 0 0 0 22.6M 3 22.6M 7 22.6M 11 22.6M 11 2678k 0 16 22.6M 16 3867k 0 23 22.6M 23 5456k 0 33 22.6M 33 7648k 0 42 22.6M 42 9955k 0 52 22.6M 52 11.8M 0 62 22.6M 62 14.1M 0 73 22.6M 73 16.5M 0 83 22.6M 83 18.8M 0 92 22.6M 92 20.8M 0 100 22.6M 100 22.6M 0 [Fri, 11 Mar 2011 [Fri, 11 Mar 2011 [Fri, 11 Mar 2011 [Fri, 11 Mar 2011 [Fri, 11 Mar 2011 : stdout 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0
0 82536 0 0 132k 0 0:02:54 --:--:-- 0:02:54 328k
3 779k 0 0 483k 0 0:00:47 0:00:01 0:00:46 624k
7 1638k 0 0 628k 0 0:00:36 0:00:02 0:00:34 730k
0 742k 0 0:00:31 0:00:03 0:00:28 825k
0 838k 0 0:00:27 0:00:04 0:00:23 910k
0 973k 0 0:00:23 0:00:05 0:00:18 1075k
0 1157k 0 0:00:20 0:00:06 0:00:14 1374k
0 1308k 0 0:00:17 0:00:07 0:00:10 1662k
0 1415k 0 0:00:16 0:00:08 0:00:08 1901k
0 1506k 0 0:00:15 0:00:09 0:00:06 2122k
0 1598k 0 0:00:14 0:00:10 0:00:04 2299k
0 1661k 0 0:00:13 0:00:11 0:00:02 2327k
0 1683k 0 0:00:13 0:00:12 0:00:01 2245k
0 1740k 0 0:00:13 0:00:13 --:--:-- 2336k
12:28:17 +0000] DEBUG: ---- End output of curl http://images.ansolabs.com/tty.tgz | tar xvz -C /var/lib/nova/images ----
12:28:17 +0000] DEBUG: Ran curl http://images.ansolabs.com/tty.tgz | tar xvz -C /var/lib/nova/images returned 0
12:28:17 +0000] INFO: Ran execute[curl http://images.ansolabs.com/tty.tgz | tar xvz -C /var/lib/nova/images] successfully
12:28:17 +0000] DEBUG: Processing execute[touch /var/lib/nova/setup] on maverick.hsd1.ca.comcast.net.
12:28:17 +0000] DEBUG: Executing touch /var/lib/nova/setup

[0K[default] [Fri, 11 Mar 2011 12:28:17 +0000] DEBUG: ---- Begin output of touch /var/lib/nova/setup ----
[Fri, 11 Mar 2011 12:28:17 +0000] DEBUG: STDOUT:
[Fri, 11 Mar 2011 12:28:17 +0000] DEBUG: STDERR:
[Fri, 11 Mar 2011 12:28:17 +0000] DEBUG: ---- End output of touch /var/lib/nova/setup ----
[Fri, 11 Mar 2011 12:28:17 +0000] DEBUG: Ran touch /var/lib/nova/setup returned 0
[Fri, 11 Mar 2011 12:28:17 +0000] INFO: Ran execute[touch /var/lib/nova/setup] successfully
[Fri, 11 Mar 2011 12:28:17 +0000] DEBUG: Processing package[python-pip] on maverick.hsd1.ca.comcast.net.
[Fri, 11 Mar 2011 12:28:17 +0000] DEBUG: Checking apt-cache policy for python-pip
: stdout
[0K[default] [Fri, 11 Mar 2011 12:28:17 +0000] DEBUG: Current version is nil
[Fri, 11 Mar 2011 12:28:17 +0000] DEBUG: Current version is 0.7.2-1
[Fri, 11 Mar 2011 12:28:17 +0000] INFO: Installing package[python-pip] version 0.7.2-1
[Fri, 11 Mar 2011 12:28:17 +0000] DEBUG: Executing apt-get -q -y install python-pip=0.7.2-1
: stdout

[0K[default] [Fri, 11 Mar 2011 12:28:25 +0000] DEBUG: ---- Begin output of apt-get -q -y install python-pip=0.7.2-1 ----
[Fri, 11 Mar 2011 12:28:25 +0000] DEBUG: STDOUT: Reading package lists...
Building dependency tree...
Reading state information...
The following NEW packages will be installed:
python-pip
0 upgraded, 1 newly installed, 0 to remove and 71 not upgraded.
Need to get 0B/68.7kB of archives.
After this operation, 385kB of additional disk space will be used.
Selecting previously deselected package python-pip.
(Reading database ... 54138 files and directories currently installed.)
Unpacking python-pip (from .../python-pip_0.7.2-1_all.deb) ...
Processing triggers for man-db ...
Setting up python-pip (0.7.2-1) ...
Processing triggers for python-support ...
[Fri, 11 Mar 2011 12:28:25 +0000] DEBUG: STDERR:
[Fri, 11 Mar 2011 12:28:25 +0000] DEBUG: ---- End output of apt-get -q -y install python-pip=0.7.2-1 ----
[Fri, 11 Mar 2011 12:28:25 +0000] DEBUG: Ran apt-get -q -y install python-pip=0.7.2-1 returned 0
[Fri, 11 Mar 2011 12:28:25 +0000] DEBUG: Processing package[python-virtualenv] on maverick.hsd1.ca.comcast.net.
[Fri, 11 Mar 2011 12:28:25 +0000] DEBUG: Checking apt-cache policy for python-virtualenv
: stdout
[0K[default] [Fri, 11 Mar 2011 12:28:27 +0000] DEBUG: Current version is nil
[Fri, 11 Mar 2011 12:28:27 +0000] DEBUG: Current version is 1.4.9-3
[Fri, 11 Mar 2011 12:28:27 +0000] INFO: Installing package[python-virtualenv] version 1.4.9-3
[Fri, 11 Mar 2011 12:28:27 +0000] DEBUG: Executing apt-get -q -y install python-virtualenv=1.4.9-3
: stdout

[0K[default] [Fri, 11 Mar 2011 12:28:35 +0000] DEBUG: ---- Begin output of apt-get -q -y install python-virtualenv=1.4.9-3 ----
[Fri, 11 Mar 2011 12:28:35 +0000] DEBUG: STDOUT: Reading package lists...
Building dependency tree...
Reading state information...
The following NEW packages will be installed:
python-virtualenv
0 upgraded, 1 newly installed, 0 to remove and 71 not upgraded.
Need to get 0B/1,507kB of archives.
After this operation, 1,737kB of additional disk space will be used.
Selecting previously deselected package python-virtualenv.
(Reading database ... 54177 files and directories currently installed.)
Unpacking python-virtualenv (from .../python-virtualenv_1.4.9-3_all.deb) ...
Processing triggers for man-db ...
Setting up python-virtualenv (1.4.9-3) ...
Processing triggers for python-support ...
[Fri, 11 Mar 2011 12:28:35 +0000] DEBUG: STDERR:
[Fri, 11 Mar 2011 12:28:35 +0000] DEBUG: ---- End output of apt-get -q -y install python-virtualenv=1.4.9-3 ----
[Fri, 11 Mar 2011 12:28:35 +0000] DEBUG: Ran apt-get -q -y install python-virtualenv=1.4.9-3 returned 0
[Fri, 11 Mar 2011 12:28:35 +0000] DEBUG: Processing package[bzr] on maverick.hsd1.ca.comcast.net.
[Fri, 11 Mar 2011 12:28:35 +0000] DEBUG: Checking apt-cache policy for bzr
: stdout
[0K[default] [Fri, 11 Mar 2011 12:28:36 +0000] DEBUG: Current version is nil
[Fri, 11 Mar 2011 12:28:36 +0000] DEBUG: Current version is 2.2.1-0ubuntu1
[Fri, 11 Mar 2011 12:28:36 +0000] INFO: Installing package[bzr] version 2.2.1-0ubuntu1
[Fri, 11 Mar 2011 12:28:36 +0000] DEBUG: Executing apt-get -q -y install bzr=2.2.1-0ubuntu1
: stdout

[0K[default] [Fri, 11 Mar 2011 12:28:58 +0000] DEBUG: ---- Begin output of apt-get -q -y install bzr=2.2.1-0ubuntu1 ----
[Fri, 11 Mar 2011 12:28:58 +0000] DEBUG: STDOUT: Reading package lists...
Building dependency tree...
Reading state information...
The following extra packages will be installed:
  bzr bzrtools python-configobj
Suggested packages:
  bzr-gtk bzr-svn xdg-utils python-kerberos bzr-doc librsvg2-bin graphviz
The following NEW packages will be installed:
  bzr bzrtools python-configobj
0 upgraded, 3 newly installed, 0 to remove and 71 not upgraded.
Need to get 0B/3,350kB of archives.
After this operation, 18.0MB of additional disk space will be used.
Selecting previously deselected package python-configobj.
(Reading database ... 54201 files and directories currently installed.)
Unpacking python-configobj (from .../python-configobj_4.7.2+ds-1_all.deb) ...
Selecting previously deselected package bzr.
Unpacking bzr (from .../bzr_2.2.1-0ubuntu1_amd64.deb) ...
Selecting previously deselected package bzrtools.
Unpacking bzrtools (from .../bzrtools_2.2.0-2_all.deb) ...
Processing triggers for man-db ...
Setting up python-configobj (4.7.2+ds-1) ...
Setting up bzr (2.2.1-0ubuntu1) ...
Processing triggers for python-central ...
Setting up bzrtools (2.2.0-2) ...
Processing triggers for python-support ...
Processing triggers for python-central ...
[Fri, 11 Mar 2011 12:28:58 +0000] DEBUG: STDERR:
[Fri, 11 Mar 2011 12:28:58 +0000] DEBUG: ---- End output of apt-get -q -y install bzr=2.2.1-0ubuntu1 ----
[Fri, 11 Mar 2011 12:28:58 +0000] DEBUG: Ran apt-get -q -y install bzr=2.2.1-0ubuntu1 returned 0
[Fri, 11 Mar 2011 12:28:58 +0000] DEBUG: Processing package[apache2] on maverick.hsd1.ca.comcast.net.
[Fri, 11 Mar 2011 12:28:58 +0000] DEBUG: Checking apt-cache policy for apache2
: stdout
[0K[default] [Fri, 11 Mar 2011 12:28:59 +0000] DEBUG: Current version is nil
[Fri, 11 Mar 2011 12:28:59 +0000] DEBUG: Current version is 2.2.16-1ubuntu3.1
[Fri, 11 Mar 2011 12:28:59 +0000] INFO: Installing package[apache2] version 2.2.16-1ubuntu3.1
[Fri, 11 Mar 2011 12:28:59 +0000] DEBUG: Executing apt-get -q -y install apache2=2.2.16-1ubuntu3.1
: stdout

[0K[default] [Fri, 11 Mar 2011 12:29:47 +0000] DEBUG: ---- Begin output of apt-get -q -y install apache2=2.2.16-1ubuntu3.1 ----
[Fri, 11 Mar 2011 12:29:47 +0000] DEBUG: STDOUT: Reading package lists...
Building dependency tree...
Reading state information...
The following extra packages will be installed:
  apache2 apache2-mpm-worker apache2-utils apache2.2-bin apache2.2-common
  libapr1 libaprutil1 libaprutil1-dbd-sqlite3 libaprutil1-ldap ssl-cert
Suggested packages:
  apache2-doc apache2-suexec apache2-suexec-custom openssl-blacklist
The following NEW packages will be installed:
  apache2 apache2-mpm-worker apache2-utils apache2.2-bin apache2.2-common
  libapr1 libaprutil1 libaprutil1-dbd-sqlite3 libaprutil1-ldap ssl-cert
Preconfiguring packages ...
0 upgraded, 10 newly installed, 0 to remove and 71 not upgraded.
Need to get 0B/3,428kB of archives.
After this operation, 11.4MB of additional disk space will be used.
Selecting previously deselected package libapr1.
(Reading database ... 55155 files and directories currently installed.)
Unpacking libapr1 (from .../libapr1_1.4.2-3ubuntu1_amd64.deb) ...
Selecting previously deselected package libaprutil1.
Unpacking libaprutil1 (from .../libaprutil1_1.3.9+dfsg-3ubuntu0.10.10.1_amd64.deb) ...
Selecting previously deselected package libaprutil1-dbd-sqlite3.
Unpacking libaprutil1-dbd-sqlite3 (from .../libaprutil1-dbd-sqlite3_1.3.9+dfsg-3ubuntu0.10.10.1_amd64.deb) ...
Selecting previously deselected package libaprutil1-ldap.
Unpacking libaprutil1-ldap (from .../libaprutil1-ldap_1.3.9+dfsg-3ubuntu0.10.10.1_amd64.deb) ...
Selecting previously deselected package apache2.2-bin.
Unpacking apache2.2-bin (from .../apache2.2-bin_2.2.16-1ubuntu3.1_amd64.deb) ...
Selecting previously deselected package apache2-utils.
Unpacking apache2-utils (from .../apache2-utils_2.2.16-1ubuntu3.1_amd64.deb) ...
Selecting previously deselected package apache2.2-common.
Unpacking apache2.2-common (from .../apache2.2-common_2.2.16-1ubuntu3.1_amd64.deb) ...
Selecting previously deselected package apache2-mpm-worker.
Unpacking apache2-mpm-worker (from .../apache2-mpm-worker_2.2.16-1ubuntu3.1_amd64.deb) ...
Selecting previously deselected package apache2.
Unpacking apache2 (from .../apache2_2.2.16-1ubuntu3.1_amd64.deb) ...
Selecting previously deselected package ssl-cert.
Unpacking ssl-cert (from .../ssl-cert_1.0.26_all.deb) ...
Processing triggers for man-db ...
Processing triggers for ufw ...
Processing triggers for ureadahead ...
Setting up libapr1 (1.4.2-3ubuntu1) ...
Setting up libaprutil1 (1.3.9+dfsg-3ubuntu0.10.10.1) ...
Setting up libaprutil1-dbd-sqlite3 (1.3.9+dfsg-3ubuntu0.10.10.1) ...
Setting up libaprutil1-ldap (1.3.9+dfsg-3ubuntu0.10.10.1) ...
Setting up apache2.2-bin (2.2.16-1ubuntu3.1) ...
Setting up apache2-utils (2.2.16-1ubuntu3.1) ...
Setting up apache2.2-common (2.2.16-1ubuntu3.1) ...
Enabling site default.
Enabling module alias.
Enabling module autoindex.
Enabling module dir.
Enabling module env.
Enabling module mime.
Enabling module negotiation.
Enabling module setenvif.
Enabling module status.
Enabling module auth_basic.
Enabling module deflate.
Enabling module authz_default.
Enabling module authz_user.
Enabling module authz_groupfile.
Enabling module authn_file.
Enabling module authz_host.
Enabling module reqtimeout.
Setting up apache2-mpm-worker (2.2.16-1ubuntu3.1) ...
* Starting web server apache2
   ...done.
Setting up apache2 (2.2.16-1ubuntu3.1) ...
Setting up ssl-cert (1.0.26) ...
Processing triggers for libc-bin ...
ldconfig deferred processing now taking place
[Fri, 11 Mar 2011 12:29:47 +0000] DEBUG: STDERR:
[Fri, 11 Mar 2011 12:29:47 +0000] DEBUG: ---- End output of apt-get -q -y install apache2=2.2.16-1ubuntu3.1 ----
[Fri, 11 Mar 2011 12:29:47 +0000] DEBUG: Ran apt-get -q -y install apache2=2.2.16-1ubuntu3.1 returned 0
[Fri, 11 Mar 2011 12:29:47 +0000] DEBUG: Processing package[libapache2-mod-wsgi] on maverick.hsd1.ca.comcast.net.
[Fri, 11 Mar 2011 12:29:47 +0000] DEBUG: Checking apt-cache policy for libapache2-mod-wsgi
: stdout
[0K[default] [Fri, 11 Mar 2011 12:29:49 +0000] DEBUG: Current version is nil
[Fri, 11 Mar 2011 12:29:49 +0000] DEBUG: Current version is 3.2-2
[Fri, 11 Mar 2011 12:29:49 +0000] INFO: Installing package[libapache2-mod-wsgi] version 3.2-2
[Fri, 11 Mar 2011 12:29:49 +0000] DEBUG: Executing apt-get -q -y install libapache2-mod-wsgi=3.2-2
: stdout

[0K[default] [Fri, 11 Mar 2011 12:30:11 +0000] DEBUG: ---- Begin output of apt-get -q -y install libapache2-mod-wsgi=3.2-2 ----
[Fri, 11 Mar 2011 12:30:11 +0000] DEBUG: STDOUT: Reading package lists...
Building dependency tree...
Reading state information...
The following extra packages will be installed:
  libapache2-mod-wsgi libpython3.1 python3.1 python3.1-minimal
Suggested packages:
  python3.1-doc python3.1-profiler binfmt-support
The following NEW packages will be installed:
  libapache2-mod-wsgi libpython3.1 python3.1 python3.1-minimal
0 upgraded, 4 newly installed, 0 to remove and 71 not upgraded.
Need to get 0B/6,763kB of archives.
After this operation, 23.6MB of additional disk space will be used.
Selecting previously deselected package python3.1-minimal.
(Reading database ... 55748 files and directories currently installed.)
Unpacking python3.1-minimal (from .../python3.1-minimal_3.1.2+20100915-0ubuntu4_amd64.deb) ...
Selecting previously deselected package python3.1.
Unpacking python3.1 (from .../python3.1_3.1.2+20100915-0ubuntu4_amd64.deb) ...
Selecting previously deselected package libpython3.1.
Unpacking libpython3.1 (from .../libpython3.1_3.1.2+20100915-0ubuntu4_amd64.deb) ...
Selecting previously deselected package libapache2-mod-wsgi.
Unpacking libapache2-mod-wsgi (from .../libapache2-mod-wsgi_3.2-2_amd64.deb) ...
Processing triggers for man-db ...
Setting up python3.1-minimal (3.1.2+20100915-0ubuntu4) ...
Setting up python3.1 (3.1.2+20100915-0ubuntu4) ...
Setting up libpython3.1 (3.1.2+20100915-0ubuntu4) ...
Setting up libapache2-mod-wsgi (3.2-2) ...
* Restarting web server apache2
   ...done.
Processing triggers for libc-bin ...
ldconfig deferred processing now taking place
[Fri, 11 Mar 2011 12:30:11 +0000] DEBUG: STDERR:
[Fri, 11 Mar 2011 12:30:11 +0000] DEBUG: ---- End output of apt-get -q -y install libapache2-mod-wsgi=3.2-2 ----
[Fri, 11 Mar 2011 12:30:11 +0000] DEBUG: Ran apt-get -q -y install libapache2-mod-wsgi=3.2-2 returned 0
[Fri, 11 Mar 2011 12:30:11 +0000] DEBUG: Processing directory[/srv] on maverick.hsd1.ca.comcast.net.
[Fri, 11 Mar 2011 12:30:11 +0000] DEBUG: Processing directory[/srv] on maverick.hsd1.ca.comcast.net.
[Fri, 11 Mar 2011 12:30:11 +0000] DEBUG: Processing execute[bzr branch lp:openstack-dashboard /srv/openstack-dashboard] on maverick.hsd1.ca.comcast.net.
[Fri, 11 Mar 2011 12:30:11 +0000] DEBUG: Executing bzr branch lp:openstack-dashboard /srv/openstack-dashboard
: stdout
[0K[default] [Fri, 11 Mar 2011 12:30:24 +0000] DEBUG: ---- Begin output of bzr branch lp:openstack-dashboard /srv/openstack-dashboard ----
[Fri, 11 Mar 2011 12:30:24 +0000] DEBUG: STDOUT:
[Fri, 11 Mar 2011 12:30:24 +0000] DEBUG: STDERR: You have not informed bzr of your Launchpad ID, and you must do this to
write to Launchpad or access private data. See "bzr help launchpad-login".
Branched 22 revision(s).
[Fri, 11 Mar 2011 12:30:24 +0000] DEBUG: ---- End output of bzr branch lp:openstack-dashboard /srv/openstack-dashboard ----
[Fri, 11 Mar 2011 12:30:24 +0000] DEBUG: Ran bzr branch lp:openstack-dashboard /srv/openstack-dashboard returned 0
[Fri, 11 Mar 2011 12:30:24 +0000] INFO: Ran execute[bzr branch lp:openstack-dashboard /srv/openstack-dashboard] successfully
[Fri, 11 Mar 2011 12:30:24 +0000] DEBUG: Processing file[/usr/lib/python2.6/dist-packages/dashboard.pth] on maverick.hsd1.ca.comcast.net.
[Fri, 11 Mar 2011 12:30:24 +0000] INFO: Creating file[/usr/lib/python2.6/dist-packages/dashboard.pth] at /usr/lib/python2.6/dist-packages/dashboard.pth
[Fri, 11 Mar 2011 12:30:24 +0000] DEBUG: Processing execute[python setup.py develop] on maverick.hsd1.ca.comcast.net.
[Fri, 11 Mar 2011 12:30:24 +0000] DEBUG: Executing python setup.py develop
: stdout
[0K[default] [Fri, 11 Mar 2011 12:30:26 +0000] DEBUG: ---- Begin output of python setup.py develop ----
[Fri, 11 Mar 2011 12:30:26 +0000] DEBUG: STDOUT: running develop
install_dir /usr/local/lib/python2.6/dist-packages/
Checking .pth file support in /usr/local/lib/python2.6/dist-packages/
/usr/bin/python -E -c pass
TEST PASSED: /usr/local/lib/python2.6/dist-packages/ appears to support .pth files
running egg_info
creating src/django_nova.egg-info
writing requirements to src/django_nova.egg-info/requires.txt
writing src/django_nova.egg-info/PKG-INFO
writing top-level names to src/django_nova.egg-info/top_level.txt
writing dependency_links to src/django_nova.egg-info/dependency_links.txt
writing manifest file 'src/django_nova.egg-info/SOURCES.txt'
reading manifest file 'src/django_nova.egg-info/SOURCES.txt'
writing manifest file 'src/django_nova.egg-info/SOURCES.txt'
running build_ext
Creating /usr/local/lib/python2.6/dist-packages/django-nova.egg-link (link to src)
Adding django-nova 0.1 to easy-install.pth file

Installed /srv/openstack-dashboard/django-nova/src
Processing dependencies for django-nova==0.1
Searching for mox>=0.5.0
Reading http://pypi.python.org/simple/mox/
Reading http://code.google.com/p/pymox/
Best match: mox 0.5.3
Downloading http://pypi.python.org/packages/source/m/mox/mox-0.5.3.tar.gz#md5=6de7371e7e8bd9e2dad3fef2646f4a43
Processing mox-0.5.3.tar.gz
Running mox-0.5.3/setup.py -q bdist_egg --dist-dir /tmp/easy_install-MEG4SM/mox-0.5.3/egg-dist-tmp-SQzfhD
zip_safe flag not set; analyzing archive contents...
Adding mox 0.5.3 to easy-install.pth file

Installed /usr/local/lib/python2.6/dist-packages/mox-0.5.3-py2.6.egg
Searching for boto==1.9b
Best match: boto 1.9b
Adding boto 1.9b to easy-install.pth file

Using /usr/lib/pymodules/python2.6
Searching for distribute==0.6.14
Best match: distribute 0.6.14
Adding distribute 0.6.14 to easy-install.pth file
Installing easy_install script to /usr/local/bin
Installing easy_install-2.7 script to /usr/local/bin

Installing easy_install-2.6 script to /usr/local/bin

Storing complete log in /home/vagrant/.pip/pip.log
[Fri, 11 Mar 2011 12:30:27 +0000] DEBUG: STDERR:
[Fri, 11 Mar 2011 12:30:27 +0000] DEBUG: ---- End output of pip install -r /srv/openstack-dashboard/tools/pip-requires ----
[Fri, 11 Mar 2011 12:30:27 +0000] DEBUG: Ran pip install -r /srv/openstack-dashboard/tools/pip-requires returned 2
[Fri, 11 Mar 2011 12:30:27 +0000] ERROR: execute[pip install -r /srv/openstack-dashboard/tools/pip-requires] (/tmp/vagrant-chef/cookbooks-0/nova/recipes/dashboard.rb:33:in `from_file') had an error:
pip install -r /srv/openstack-dashboard/tools/pip-requires returned 2, expected 0
---- Begin output of pip install -r /srv/openstack-dashboard/tools/pip-requires ----
STDOUT: Exception:
Traceback (most recent call last):
  File "/usr/lib/pymodules/python2.6/pip/basecommand.py", line 120, in main
    self.run(options, args)
  File "/usr/lib/pymodules/python2.6/pip/commands/install.py", line 158, in run
    for req in parse_requirements(filename, finder=finder, options=options):
  File "/usr/lib/pymodules/python2.6/pip/req.py", line 1344, in parse_requirements
    filename, content = get_file_content(filename, comes_from=comes_from)
  File "/usr/lib/pymodules/python2.6/pip/util.py", line 305, in get_file_content
    f = open(url)
IOError: [Errno 2] No such file or directory: '/srv/openstack-dashboard/tools/pip-requires'

Storing complete log in /home/vagrant/.pip/pip.logSTDERR:
---- End output of pip install -r /srv/openstack-dashboard/tools/pip-requires ----

/var/lib/gems/1.8/gems/chef-0.9.12/bin/../lib/chef/mixin/command.rb:184:in `handle_command_failures'
/var/lib/gems/1.8/gems/chef-0.9.12/bin/../lib/chef/mixin/command.rb:131:in `run_command'
/var/lib/gems/1.8/gems/chef-0.9.12/bin/../lib/chef/provider/execute.rb:49:in `action_run'
/var/lib/gems/1.8/gems/chef-0.9.12/bin/../lib/chef/resource.rb:395:in `send'
/var/lib/gems/1.8/gems/chef-0.9.12/bin/../lib/chef/resource.rb:395:in `run_action'
/var/lib/gems/1.8/gems/chef-0.9.12/bin/../lib/chef/runner.rb:53:in `run_action'
/var/lib/gems/1.8/gems/chef-0.9.12/bin/../lib/chef/runner.rb:89:in `converge'
/var/lib/gems/1.8/gems/chef-0.9.12/bin/../lib/chef/runner.rb:89:in `each'
/var/lib/gems/1.8/gems/chef-0.9.12/bin/../lib/chef/runner.rb:89:in `converge'
/var/lib/gems/1.8/gems/chef-0.9.12/bin/../lib/chef/resource_collection.rb:94:in `execute_each_resource'
/var/lib/gems/1.8/gems/chef-0.9.12/bin/../lib/chef/resource_collection/stepable_iterator.rb:116:in `call'
/var/lib/gems/1.8/gems/chef-0.9.12/bin/../lib/chef/resource_collection/stepable_iterator.rb:116:in `call_iterator_block'
/var/lib/gems/1.8/gems/chef-0.9.12/bin/../lib/chef/resource_collection/stepable_iterator.rb:85:in `step'
/var/lib/gems/1.8/gems/chef-0.9.12/bin/../lib/chef/resource_collection/stepable_iterator.rb:104:in `iterate'
/var/lib/gems/1.8/gems/chef-0.9.12/bin/../lib/chef/resource_collection/stepable_iterator.rb:55:in `each_with_index'
/var/lib/gems/1.8/gems/chef-0.9.12/bin/../lib/chef/resource_collection.rb:92:in `execute_each_resource'
/var/lib/gems/1.8/gems/chef-0.9.12/bin/../lib/chef/runner.rb:84:in `converge'
/var/lib/gems/1.8/gems/chef-0.9.12/bin/../lib/chef/client.rb:268:in `converge'
/var/lib/gems/1.8/gems/chef-0.9.12/bin/../lib/chef/client.rb:158:in `run'
/var/l: stdout
[0K[default] /var/lib/gems/1.8/gems/chef-0.9.12/bin/../lib/chef/mixin/command.rb:184:in `handle_command_failures': stderr

[0K[default] : : stderr

[0K[default] pip install -r /srv/openstack-dashboard/tools/pip-requires returned 2, expected 0: stderr

[0K[default] (: stderr

[0K[default] Chef::Exceptions::Exec: stderr

[0K[default] )
: stderr

[0K[default] ---- Begin output of pip install -r /srv/openstack-dashboard/tools/pip-requires ----
STDOUT: Exception:
Traceback (most recent call last):
  File "/usr/lib/pymodules/python2.6/pip/basecommand.py", line 120, in main
    self.run(options, args)
  File "/usr/lib/pymodules/python2.6/pip/commands/install.py", line 158, in run
    for req in parse_requirements(filename, finder=finder, options=options):
  File "/usr/lib/pymodules/python2.6/pip/req.py", line 1344, in parse_requirements
    filename, content = get_file_content(filename, comes_from=comes_from)
  File "/usr/lib/pymodules/python2.6/pip/util.py", line 305, in get_file_content
    f = open(url)
IOError: [Errno 2] No such file or directory: '/srv/openstack-dashboard/tools/pip-requires'

Storing complete log in /home/vagrant/.pip/pip.logSTDERR:
---- End output of pip install -r /srv/openstack-dashboard/tools/pip-requires ----
: stderr
[0K[default] from /var/lib/gems/1.8/gems/chef-0.9.12/bin/../lib/chef/mixin/command.rb:131:in `run_command'
: stderr

[0K[default] from /var/lib/gems/1.8/gems/chef-0.9.12/bin/../lib/chef/provider/execute.rb:49:in `action_run'
: stderr

[0K[default] from /var/lib/gems/1.8/gems/chef-0.9.12/bin/../lib/chef/resource.rb:395:in `send'
: stderr

[0K[default] from /var/lib/gems/1.8/gems/chef-0.9.12/bin/../lib/chef/resource.rb:395:in `run_action'
from /var/lib/gems/1.8/gems/chef-0.9.12/bin/../lib/chef/runner.rb:53:in `run_action'
from /var/lib/gems/1.8/gems/chef-0.9.12/bin/../lib/chef/runner.rb:89:in `converge'
from /var/lib/gems/1.8/gems/chef-0.9.12/bin/../lib/chef/runner.rb:89:in `each'
from /var/lib/gems/1.8/gems/chef-0.9.12/bin/../lib/chef/runner.rb:89:in `converge'
from /var/lib/gems/1.8/gems/chef-0.9.12/bin/../lib/chef/resource_collection.rb:94:in `execute_each_resource'
from /var/lib/gems/1.8/gems/chef-0.9.12/bin/../lib/chef/resource_collection/stepable_iterator.rb:116:in `call'
from /var/lib/gems/1.8/gems/chef-0.9.12/bin/../lib/chef/resource_collection/stepable_iterator.rb:116:in `call_iterator_block'
from /var/lib/gems/1.8/gems/chef-0.9.12/bin/../lib/chef/resource_collection/stepable_iterator.rb:85:in `step'
from /var/lib/gems/1.8/gems/chef-0.9.12/bin/../lib/chef/resource_collection/stepable_iterator.rb:104:in `iterate'
from /var/lib/gems/1.8/gems/chef-0.9.12/bin/../lib/chef/resource_collection/stepable_iterator.rb:55:in `each_with_index'
from /var/lib/gems/1.8/gems/chef-0.9.12/bin/../lib/chef/resource_collection.rb:92:in `execute_each_resource'
from /var/lib/gems/1.8/gems/chef-0.9.12/bin/../lib/chef/runner.rb:84:in `converge'
from /var/lib/gems/1.8/gems/chef-0.9.12/bin/../lib/chef/client.rb:268:in `converge'
from /var/lib/gems/1.8/gems/chef-0.9.12/bin/../lib/chef/client.rb:158:in `run'
from /var/lib/gems/1.8/gems/chef-0.9.12/bin/../lib/chef/application/solo.rb:190:in `run_application'
from /var/lib/gems/1.8/gems/chef-0.9.12/bin/../lib/chef/application/solo.rb:181:in `loop'
from /var/lib/gems/1.8/gems/chef-0.9.12/bin/../lib/chef/application/solo.rb:181:in `run_application'
from /var/lib/gems/1.8/gems/chef-0.9.12/bin/../lib/chef/application.rb:62:in `run'
from /var/lib/gems/1.8/gems/chef-0.9.12/bin/chef-solo:25
from /var/lib/gems/1.8/bin/chef-solo:19:in `load'
from /var/lib/gems/1.8/bin/chef-solo:19
: stderr

[0K[default] ib/gems/1.8/gems/chef-0.9.12/bin/../lib/chef/application/solo.rb:190:in `run_application'
/var/lib/gems/1.8/gems/chef-0.9.12/bin/../lib/chef/application/solo.rb:181:in `loop'
/var/lib/gems/1.8/gems/chef-0.9.12/bin/../lib/chef/application/solo.rb:181:in `run_application'
/var/lib/gems/1.8/gems/chef-0.9.12/bin/../lib/chef/application.rb:62:in `run'
/var/lib/gems/1.8/gems/chef-0.9.12/bin/chef-solo:25
/var/lib/gems/1.8/bin/chef-solo:19:in `load'
/var/lib/gems/1.8/bin/chef-solo:19
[Fri, 11 Mar 2011 12:30:27 +0000] ERROR: Running exception handlers
[Fri, 11 Mar 2011 12:30:27 +0000] ERROR: Exception handlers complete
[Fri, 11 Mar 2011 12:30:27 +0000] DEBUG: Re-raising exception: Chef::Exceptions::Exec - pip install -r /srv/openstack-dashboard/tools/pip-requires returned 2, expected 0
---- Begin output of pip install -r /srv/openstack-dashboard/tools/pip-requires ----
STDOUT: Exception:
Traceback (most recent call last):
  File "/usr/lib/pymodules/python2.6/pip/basecommand.py", line 120, in main
    self.run(options, args)
  File "/usr/lib/pymodules/python2.6/pip/commands/install.py", line 158, in run
    for req in parse_requirements(filename, finder=finder, options=options):
  File "/usr/lib/pymodules/python2.6/pip/req.py", line 1344, in parse_requirements
    filename, content = get_file_content(filename, comes_from=comes_from)
  File "/usr/lib/pymodules/python2.6/pip/util.py", line 305, in get_file_content
    f = open(url)
IOError: [Errno 2] No such file or directory: '/srv/openstack-dashboard/tools/pip-requires'

Storing complete log in /home/vagrant/.pip/pip.logSTDERR:
---- End output of pip install -r /srv/openstack-dashboard/tools/pip-requires ----

/var/lib/gems/1.8/gems/chef-0.9.12/bin/../lib/chef/mixin/command.rb:184:in `handle_command_failures'
  /var/lib/gems/1.8/gems/chef-0.9.12/bin/../lib/chef/mixin/command.rb:131:in `run_command'
  /var/lib/gems/1.8/gems/chef-0.9.12/bin/../lib/chef/provider/execute.rb:49:in `action_run'
  /var/lib/gems/1.8/gems/chef-0.9.12/bin/../lib/chef/resource.rb:395:in `send'
  /var/lib/gems/1.8/gems/chef-0.9.12/bin/../lib/chef/resource.rb:395:in `run_action'
  /var/lib/gems/1.8/gems/chef-0.9.12/bin/../lib/chef/runner.rb:53:in `run_action'
  /var/lib/gems/1.8/gems/chef-0.9.12/bin/../lib/chef/runner.rb:89:in `converge'
  /var/lib/gems/1.8/gems/chef-0.9.12/bin/../lib/chef/runner.rb:89:in `each'
  /var/lib/gems/1.8/gems/chef-0.9.12/bin/../lib/chef/runner.rb:89:in `converge'
  /var/lib/gems/1.8/gems/chef-0.9.12/bin/../lib/chef/resource_collection.rb:94:in `execute_each_resource'
  /var/lib/gems/1.8/gems/chef-0.9.12/bin/../lib/chef/resource_collection/stepable_iterator.rb:116:in `call'
  /var/lib/gems/1.8/gems/chef-0.9.12/bin/../lib/chef/resource_collection/stepable_iterator.rb:116:in `call_iterator_block'
  /var/lib/gems/1.8/gems/chef-0.9.12/bin/../lib/chef/resource_collection/stepable_iterator.rb:85:in `step'
  /var/lib/gems/1.8/gems/chef-0.9.12/bin/../lib/chef/resource_collection/stepable_iterator.rb:104:in `iterate'
  /var/lib/gems/1.8/gems/chef-0.9.12/bin/../lib/chef/resource_collection/stepable_iterator.rb:55:in `each_with_index'
  /var/lib/gems/1.8/gems/chef-0.9.12/bin/../lib/chef/resource_collection.rb:92:in `execute_each_resource'
  /var/lib/gems/1.8/gems/chef-0.9.12/bin/../lib/chef/runner.rb:84:in `converge'
  /var/lib/gems/1.8/gems/chef-0.9.12/bin/../lib/chef/client.rb:268:in `converge'
  /var/lib/gems/1.8/gems/chef-0.9.12/bin/../lib/chef/client.rb:158:in `run'
  /var/lib/gems/1.8/gems/chef-0.9.12/bin/../lib/chef/application/solo.rb:190:in `run_application'
  /var/lib/gems/1.8/gems/chef-0.9.12/bin/../lib/chef/application/solo.rb:181:in `loop'
  /var/lib/gems/1.8/gems/chef-0.9.12/bin/../lib/chef/application/solo.rb:181:in `run_application'
  /var/lib/gems/1.8/gems/chef-0.9.12/bin/../lib/chef/application.rb:62:in `run'
  /var/lib/gems/1.8/gems/chef-0.9.12/bin/chef-solo:25
  /var/lib/gems/1.8/bin/chef-solo:19:in `load'
  /var/lib/gems/1.8/bin/chef-solo:19
: stdout[31m
[0KThe following SSH command responded with a non-zero exit status.
Vagrant assumes that this means the command failed!

cd /tmp/vagrant-chef
chef-solo -c solo.rb -j dna.json

The output of the command prior to failing is outputted below:

[no output][0m
[lorin@macbook chef]$

Question information

Language:: English Edit question

Status:: Solved

For:: OpenStack Compute (nova) Edit question

Assignee:: No assignee Edit question

Solved by:: Vish Ishaya

Solved:: 2011-03-14

Last query:: 2011-03-14

Last reply:: 2011-03-11

Link existing bug

Revision history for this message

Lorin Hochstein (lorinh) said on 2011-03-11:

Here's my nova version info (from the ~/aptcache/archives directory):

[lorin@macbook archives]$ ls *nova*.deb
nova-api_2011.1-anso~dev~bzr634-maverick_all.deb
nova-api_2011.1-anso~dev~bzr635-maverick_all.deb
nova-common_2011.1-anso~dev~bzr634-maverick_all.deb
nova-common_2011.1-anso~dev~bzr635-maverick_all.deb
nova-compute_2011.1-anso~dev~bzr634-maverick_all.deb
nova-compute_2011.1-anso~dev~bzr635-maverick_all.deb
nova-network_2011.1-anso~dev~bzr634-maverick_all.deb
nova-network_2011.1-anso~dev~bzr635-maverick_all.deb
nova-objectstore_2011.1-anso~dev~bzr634-maverick_all.deb
nova-objectstore_2011.1-anso~dev~bzr635-maverick_all.deb
nova-scheduler_2011.1-anso~dev~bzr634-maverick_all.deb
nova-scheduler_2011.1-anso~dev~bzr635-maverick_all.deb
nova-volume_2011.1-anso~dev~bzr634-maverick_all.deb
nova-volume_2011.1-anso~dev~bzr635-maverick_all.deb
python-nova_2011.1-anso~dev~bzr634-maverick_all.deb
python-nova_2011.1-anso~dev~bzr635-maverick_all.deb

Revision history for this message

Vish Ishaya (vishvananda) said on 2011-03-11:

Hey,

I fixed the code yesterday Vagrantfile to pull the proper branch and uploaded packages. This should work now.
You might want to re-grab the Vagrantfile (that is re-run the curl command that dowloads it) and make sure do a git pull in openstack-cookbooks.

Vish

On Mar 11, 2011, at 5:46 AM, Lorin Hochstein wrote:

> Question #148698 on OpenStack Compute (nova) changed:
> https://answers.launchpad.net/nova/+question/148698
>
> Lorin Hochstein gave more information on the question:
> Here's my nova version info (from the ~/aptcache/archives directory):
>
> [lorin@macbook archives]$ ls *nova*.deb
> nova-api_2011.1-anso~dev~bzr634-maverick_all.deb
> nova-api_2011.1-anso~dev~bzr635-maverick_all.deb
> nova-common_2011.1-anso~dev~bzr634-maverick_all.deb
> nova-common_2011.1-anso~dev~bzr635-maverick_all.deb
> nova-compute_2011.1-anso~dev~bzr634-maverick_all.deb
> nova-compute_2011.1-anso~dev~bzr635-maverick_all.deb
> nova-network_2011.1-anso~dev~bzr634-maverick_all.deb
> nova-network_2011.1-anso~dev~bzr635-maverick_all.deb
> nova-objectstore_2011.1-anso~dev~bzr634-maverick_all.deb
> nova-objectstore_2011.1-anso~dev~bzr635-maverick_all.deb
> nova-scheduler_2011.1-anso~dev~bzr634-maverick_all.deb
> nova-scheduler_2011.1-anso~dev~bzr635-maverick_all.deb
> nova-volume_2011.1-anso~dev~bzr634-maverick_all.deb
> nova-volume_2011.1-anso~dev~bzr635-maverick_all.deb
> python-nova_2011.1-anso~dev~bzr634-maverick_all.deb
> python-nova_2011.1-anso~dev~bzr635-maverick_all.deb
>
> --
> You received this question notification because you are a member of Nova
> Core, which is an answer contact for OpenStack Compute (nova).

Revision history for this message

Lorin Hochstein (lorinh) said on 2011-03-11:

Vish,

I see that you edited server.rb to use anso::packages instead anso::devpackages, but solo.rb still uses anso::devpackages. I'm using solo.rb since I'm running single node. Should solo.rb be changed as well?

(I'm still getting the same error, but I'll do a proper wipe of aptcache and try again a little later...)

Revision history for this message

Vish Ishaya (vishvananda) said on 2011-03-11:

It should be using packages, I will change it. Let me know if it works for you.

Vish

On Mar 11, 2011, at 7:13 AM, Lorin Hochstein wrote:

> Question #148698 on OpenStack Compute (nova) changed:
> https://answers.launchpad.net/nova/+question/148698
>
> Status: Answered => Open
>
> Lorin Hochstein is still having a problem:
> Vish,
>
> I see that you edited server.rb to use anso::packages instead
> anso::devpackages, but solo.rb still uses anso::devpackages. I'm using
> solo.rb since I'm running single node. Should solo.rb be changed as
> well?
>
> (I'm still getting the same error, but I'll do a proper wipe of aptcache
> and try again a little later...)
>
> --
> You received this question notification because you are a member of Nova
> Core, which is an answer contact for OpenStack Compute (nova).

Revision history for this message

Christoph Streit (cstreit2000) said on 2011-03-11:

Hi!

I have the same problem. I edited the vagrantfile and changed

anso::devpackages
to
anso::packages

Now the installation seems to go through but halts on installing the dashboard.

---- Begin output of pip install -r /srv/openstack-dashboard/tools/pip-requires ----
STDOUT: Exception:
Traceback (most recent call last):
  File "/usr/lib/pymodules/python2.6/pip/basecommand.py", line 120, in main
    self.run(options, args)
  File "/usr/lib/pymodules/python2.6/pip/commands/install.py", line 158, in run
    for req in parse_requirements(filename, finder=finder, options=options):
  File "/usr/lib/pymodules/python2.6/pip/req.py", line 1344, in parse_requirements
    filename, content = get_file_content(filename, comes_from=comes_from)
  File "/usr/lib/pymodules/python2.6/pip/util.py", line 305, in get_file_content
    f = open(url)
IOError: [Errno 2] No such file or directory: '/srv/openstack-dashboard/tools/pip-requires'

Storing complete log in /home/vagrant/.pip/pip.logSTDERR:
---- End output of pip install -r /srv/openstack-dashboard/tools/pip-requires ----

Please advise.

Thanks

Christoph

Revision history for this message

Vish Ishaya (vishvananda) said on 2011-03-11:

Thanks for the heads up guys. There were actually two issues due to recent code changes

1) openstack-django moved inside the openstack-dashobard repo

2) lock_path is required in nova.conf

Both of these issues have been resolved and you should be able to use the instructions now.

Vish

On Mar 11, 2011, at 7:55 AM, christoph12 wrote:

> Question #148698 on OpenStack Compute (nova) changed:
> https://answers.launchpad.net/nova/+question/148698
>
> christoph12 posted a new comment:
> Hi!
>
> I have the same problem. I edited the vagrantfile and changed
>
> anso::devpackages
> to
> anso::packages
>
> Now the installation seems to go through but halts on installing the
> dashboard.
>
>
> ---- Begin output of pip install -r /srv/openstack-dashboard/tools/pip-requires ----
> STDOUT: Exception:
> Traceback (most recent call last):
> File "/usr/lib/pymodules/python2.6/pip/basecommand.py", line 120, in main
> self.run(options, args)
> File "/usr/lib/pymodules/python2.6/pip/commands/install.py", line 158, in run
> for req in parse_requirements(filename, finder=finder, options=options):
> File "/usr/lib/pymodules/python2.6/pip/req.py", line 1344, in parse_requirements
> filename, content = get_file_content(filename, comes_from=comes_from)
> File "/usr/lib/pymodules/python2.6/pip/util.py", line 305, in get_file_content
> f = open(url)
> IOError: [Errno 2] No such file or directory: '/srv/openstack-dashboard/tools/pip-requires'
>
> Storing complete log in /home/vagrant/.pip/pip.logSTDERR:
> ---- End output of pip install -r /srv/openstack-dashboard/tools/pip-requires ----
>
>
> Please advise.
>
> Thanks
>
> Christoph
>
> You received this question notification because you are a member of Nova
> Core, which is an answer contact for OpenStack Compute (nova).

Revision history for this message

Christoph Streit (cstreit2000) said on 2011-03-11:

Vish,

thanks. It now worked. I have installed it in Virtualbox on my Mac. However, when starting a test instance, the instance remains in the state "networking". Do you lnow what this could be related to? I followed the exact instructions at http://ansolabs.com/articles/single-node-nova-installation-using-vagrant-and-chef.html.

Thanks

Christoph

Revision history for this message

Vish Ishaya (vishvananda) said on 2011-03-11:

I'm not running into that error, so you might want to just try a
vagrant destroy / vagrant up

If you are still seeing the error, check /var/log/nova/nova-compute.log for errors. Either there should be a traceback or somehow the message isn't making it to nova-network (i.e. it is not running or some such)

Vish

On Mar 11, 2011, at 9:26 AM, christoph12 wrote:

> Question #148698 on OpenStack Compute (nova) changed:
> https://answers.launchpad.net/nova/+question/148698
>
> christoph12 requested for more information:
> Vish,
>
> thanks. It now worked. I have installed it in Virtualbox on my Mac.
> However, when starting a test instance, the instance remains in the
> state "networking". Do you lnow what this could be related to? I
> followed the exact instructions at http://ansolabs.com/articles/single-
> node-nova-installation-using-vagrant-and-chef.html.
>
> Thanks
>
> Christoph
>
> --
> You received this question notification because you are a member of Nova
> Core, which is an answer contact for OpenStack Compute (nova).

Revision history for this message

Lorin Hochstein (lorinh) said on 2011-03-12:

This works for me now, thanks.

Revision history for this message

Lorin Hochstein (lorinh) said on 2011-03-14:

#10

Thanks Vish Ishaya, that solved my question.

To post a message you must log in.

Ask a question

Edit question

OpenStack Compute (nova)

Vagrant/chef virtual setup fails

Question information

Related bugs

Related FAQ:

Subscribers