Ask Your Question

Revision history [back]

click to hide/show revision 1
initial version

nova instance failed to start.

Hi,

First of all pls, forgive me, I'm new and may be missing something simple. Some messages in the nova-compute.log seem curious.

ie. "libvirtError: internal error no supported architecture for os type 'hvm' " I also see an entries for qemu and kvm. I think I should be using kvm according to my nova.conf.

Any pointers very welcome.

Begin Verbose DUMP -----

Env:

Installed Ubuntu 11.04 and the nova package that comes with it. Also installed Glance and swift. kvm is also installed. Ubuntu is running as a VM om my Mac via VMWARE fusion. All services are running off this one server for now.

nova.conf:

--dhcpbridge=/usr/bin/nova-dhcpbridge --lock_path=/var/lock/nova --cc_host=172.16.20.111 --use_ipv6=false --ca_path=/var/lib/nova/CA --keys_path=/var/lib/nova/keys --networks_path=/var/lib/nova/networks --instances_path=/var/lib/nova/instances --images_path=/var/lib/nova/images --buckets_path=/var/lib/nova/buckets --libvirt_type=kvm --volume_group=nova-volumes --glance_host=172.16.20.111 --glance_port=9292 --image_service=nova.image.glance.GlanceImageService --vnc_console_proxy_url=http://172.16.20.111:6080 --vnc_enabled=True --vncproxy_host=172.16.20.111 --daemonize=1 --my_ip=172.16.20.111 --network_manager=nova.network.manager.FlatManager --fixed_range=172.16.20.0/25 --num_networks=1 --public_interface=eth0 --flat_injected=true --rabbit_host=172.16.20.111 --s3_host=172.16.20.111 --cc_host=172.16.20.111 --ec2_url=http://172.16.20.111:8773/services/Cloud --logdir=/var/log/nova --state_path=/var/lib/nova --verbose

glance.conf [DEFAULT] verbose = True debug = False [app:glance-api] paste.app_factory = glance.server:app_factory default_store = file bind_host = 0.0.0.0 bind_port = 9292 registry_host = 0.0.0.0 registry_port = 9191 filesystem_store_datadir=/var/lib/glance/images/ swift_store_auth_address = 127.0.0.1:8080/v1.0/ swift_store_user = chris swift_store_key = a86850deb2742ec3cb41518e26aa2d89 swift_store_container = glance swift_store_create_container_on_put = True [app:glance-registry] paste.app_factory = glance.registry.server:app_factory bind_host = 0.0.0.0 bind_port = 9191 sql_connection = sqlite:////var/lib/glance/glance.sqlite sql_idle_timeout = 3600

nova-manage service list nova-manage service list ubuntuServer nova-compute enabled :-) 2011-05-09 03:22:25.182752 ubuntuServer nova-scheduler enabled :-) 2011-05-09 03:22:25.498640 ubuntuServer nova-network enabled :-) 2011-05-09 03:22:25.287896 ubuntuServer nova-volume enabled :-) 2011-05-09 03:22:25.004466

sudo nova-manage vm list instance node type state launched image kernel ramdisk project user zone index i-00000001 ubuntuServer <nova.db.sqlalchemy.models.instancetypes object="" at="" 0x3183350=""> shutdown None 2 1 dev chris None 0
i-00000002 ubuntuServer <nova.db.sqlalchemy.models.instancetypes object="" at="" 0x3183350=""> shutdown None 2 1 dev chris None 0
i-00000003 ubuntuServer <nova.db.sqlalchemy.models.instancetypes object="" at="" 0x3183350=""> shutdown None 2 1 dev chris None 0
i-00000004 ubuntuServer <nova.db.sqlalchemy.models.instancetypes object="" at="" 0x3183350=""> shutdown None 2 1 dev chris None 0
i-00000005 ubuntuServer <nova.db.sqlalchemy.models.instancetypes object="" at="" 0x3183350=""> shutdown None 2 1 dev chris None 0
i-00000006 ubuntuServer <nova.db.sqlalchemy.models.instancetypes object="" at="" 0x3183350=""> shutdown None 2 1 dev chris None 0
i-00000007 ubuntuServer <nova.db.sqlalchemy.models.instancetypes object="" at="" 0x3183350=""> shutdown None 2 1 dev chris nova 0
i-00000008 ubuntuServer <nova.db.sqlalchemy.models.instancetypes object="" at="" 0x3183350=""> shutdown None 2 1 dev chris nova 0
i-00000009 ubuntuServer <nova.db.sqlalchemy.models.instancetypes object="" at="" 0x3183350=""> shutdown None 2 1 dev chris nova 0
i-0000000a ubuntuServer <nova.db.sqlalchemy.models.instancetypes object="" at="" 0x3183350=""> shutdown None 2 1 dev chris nova 0

euca-describe-availability-zones AVAILABILITYZONE nova available chris@ubuntuServer:/etc/glance$ euca-describe-instances RESERVATION r-z5yjs0su dev default INSTANCE i-0000000a ami-00000002 172.16.20.9 172.16.20.9 shutdown chris_key 0 m1.tiny 2011-05-09T02:17:32Z nova
RESERVATION r-hf40eqhy dev default INSTANCE i-00000005 ami-00000002 172.16.20.4 172.16.20.4 shutdown chris_key 0 m1.tiny 2011-05-09T01:16:52Z nova
RESERVATION r-0lw2wp00 dev default INSTANCE i-00000001 ami-00000002 shutdown chris_key 0 m1.tiny 2011-05-06T04:00:54Z nova
RESERVATION r-zz9ifpye dev default INSTANCE i-00000009 ami-00000002 172.16.20.8 172.16.20.8 shutdown chris_key 0 m1.tiny 2011-05-09T02:10:35Z nova
RESERVATION r-01s4hid8 dev default INSTANCE i-00000008 ami-00000002 172.16.20.7 172.16.20.7 shutdown chris_key 0 m1.tiny 2011-05-09T02:03:59Z nova
RESERVATION r-n5tabmta dev default INSTANCE i-00000002 ami-00000002 shutdown chris_key 0 m1.tiny 2011-05-09T00:28:32Z nova
RESERVATION r-iqwdec9z dev default INSTANCE i-00000006 ami-00000002 172.16.20.5 172.16.20.5 shutdown chris_key 0 m1.tiny 2011-05-09T01:41:42Z nova
RESERVATION r-1j1y8kxt dev default INSTANCE i-00000007 ami-00000002 172.16.20.6 172.16.20.6 shutdown chris_key 0 m1.tiny 2011-05-09T02:02:23Z nova
RESERVATION r-0wqp6194 dev default INSTANCE i-00000004 ami-00000002 172.16.20.3 172.16.20.3 shutdown chris_key 0 m1.tiny 2011-05-09T01:16:46Z nova
RESERVATION r-gxz10sha dev default INSTANCE i-00000003 ami-00000002 172.16.20.2 172.16.20.2 shutdown chris_key 0 m1.tiny 2011-05-09T00:35:51Z nova

sudo nova-manage network list network netmask start address DNS
172.16.20.0/25 255.255.255.128 172.16.20.2 8.8.4.4

Zones euca-describe-availability-zones AVAILABILITYZONE nova available

Image I gave used is: export image="/home/chris/ubuntu1010-UEC-localuser-image.tar.gz" uec-publish-tarball $image dub-bucket x86_64

I then run the instance: euca-run-instances ami-00000002 -k chris_key -t m1.tiny -z nova

When I try to run an instance it fails and eventually results in the following:

chris@ubuntuServer:/var/log/nova$ euca-describe-instances RESERVATION r-z5yjs0su dev default INSTANCE i-0000000a ami-00000002 172.16.20.9 172.16.20.9 shutdown chris_key 0 m1.tiny 2011-05-09T02:17:32Z nova
RESERVATION r-hf40eqhy dev default INSTANCE i-00000005 ami-00000002 172.16.20.4 172.16.20.4 shutdown chris_key 0 m1.tiny 2011-05-09T01:16:52Z nova
RESERVATION r-0lw2wp00 dev default INSTANCE i-00000001 ami-00000002 shutdown chris_key 0 m1.tiny 2011-05-06T04:00:54Z nova
RESERVATION r-zz9ifpye dev default INSTANCE i-00000009 ami-00000002 172.16.20.8 172.16.20.8 shutdown chris_key 0 m1.tiny 2011-05-09T02:10:35Z nova
RESERVATION r-01s4hid8 dev default INSTANCE i-00000008 ami-00000002 172.16.20.7 172.16.20.7 shutdown chris_key 0 m1.tiny 2011-05-09T02:03:59Z nova
RESERVATION r-n5tabmta dev default INSTANCE i-00000002 ami-00000002 shutdown chris_key 0 m1.tiny 2011-05-09T00:28:32Z nova
RESERVATION r-iqwdec9z dev default INSTANCE i-00000006 ami-00000002 172.16.20.5 172.16.20.5 shutdown chris_key 0 m1.tiny 2011-05-09T01:41:42Z nova
RESERVATION r-1j1y8kxt dev default INSTANCE i-00000007 ami-00000002 172.16.20.6 172.16.20.6 shutdown chris_key 0 m1.tiny 2011-05-09T02:02:23Z nova
RESERVATION r-0wqp6194 dev default INSTANCE i-00000004 ami-00000002 172.16.20.3 172.16.20.3 shutdown chris_key 0 m1.tiny 2011-05-09T01:16:46Z nova
RESERVATION r-gxz10sha dev default INSTANCE i-00000003 ami-00000002 172.16.20.2 172.16.20.2 shutdown chris_key 0 m1.tiny 2011-05-09T00:35:51Z nova

Here is a section of the nova-compute.log

VM. State=5, so setting state to shutoff. 2011-05-09 12:16:58,490 DEBUG nova [-] Serving nova-compute from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:283 2011-05-09 12:16:58,491 DEBUG nova [-] Full set of FLAGS: from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:284 2011-05-09 12:16:58,500 DEBUG nova [-] storage_availability_zone : nova from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:16:58,551 DEBUG nova [-] ca_file : cacert.pem from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:16:58,551 DEBUG nova [-] ec2_dmz_host : 172.16.20.111 from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:16:58,560 DEBUG nova [-] fixed_range : 172.16.20.0/25 from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:16:58,581 DEBUG nova [-] compute_topic : compute from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:16:58,582 DEBUG nova [-] glance_port : 9292 from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:16:58,602 DEBUG nova [-] live_migration_retry_count : 30 from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:16:58,602 DEBUG nova [-] rabbit_password : guest from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:16:58,633 DEBUG nova [-] user_cert_subject : /C=US/ST=California/L=MountainView/O=AnsoLabs/OU=NovaDev/CN=%s-%s-%s from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:16:58,633 DEBUG nova [-] s3_dmz : 172.16.20.111 from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:16:58,663 DEBUG nova [-] vmwareapi_task_poll_interval : 5.0 from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:16:58,671 DEBUG nova [-] public_interface : eth0 from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:16:58,714 DEBUG nova [-] vlan_interface : eth0 from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:16:58,714 DEBUG nova [-] aws_access_key_id : admin from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:16:58,738 DEBUG nova [-] vncserver_host : 0.0.0.0 from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:16:58,757 DEBUG nova [-] network_size : 256 from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:16:58,777 DEBUG nova [-] xenapi_remap_vbd_dev : False from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:16:58,777 DEBUG nova [-] enable_new_services : True from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:16:58,777 DEBUG nova [-] my_ip : 172.16.20.111 from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:16:58,797 DEBUG nova [-] live_migration_bandwidth : 0 from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:16:58,813 DEBUG nova [-] help : None from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:16:58,841 DEBUG nova [-] password_length : 12 from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:16:58,850 DEBUG nova [-] quota_max_injected_files : 5 from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:16:58,869 DEBUG nova [-] iqn_prefix : iqn.2010-10.org.openstack from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:16:58,870 DEBUG nova [-] zone_capabilities : ['hypervisor=xenserver;kvm', 'os=linux;windows'] from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:16:58,870 DEBUG nova [-] logdir : /var/log/nova from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:16:58,870 DEBUG nova [-] sqlite_db : nova.sqlite from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:16:58,885 DEBUG nova [-] iscsi_target_prefix : iqn.2010-10.org.openstack: from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:16:58,904 DEBUG nova [-] num_networks : 1 from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:16:58,929 DEBUG nova [-] live_migration_flag : VIR_MIGRATE_UNDEFINE_SOURCE, VIR_MIGRATE_PEER2PEER from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:16:58,943 DEBUG nova [-] blades_per_shelf : 16 from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:16:58,943 DEBUG nova [-] osapi_max_limit : 1000 from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:16:58,963 DEBUG nova [-] aoe_eth_dev : eth0 from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:16:58,996 DEBUG nova [-] fixed_range_v6 : fd00::/48 from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:16:58,996 DEBUG nova [-] rabbit_port : 5672 from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:16:59,014 DEBUG nova [-] vmwareapi_host_password : None from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:16:59,016 DEBUG nova [-] rabbit_max_retries : 12 from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:17:00,073 DEBUG nova [-] dhcp_lease_time : 120 from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:17:00,073 DEBUG nova [-] ec2_listen : 0.0.0.0 from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:17:00,073 DEBUG nova [-] logfile : None from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:17:00,073 DEBUG nova [-] ajax_console_proxy_url : http://127.0.0.1:8000 from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:17:00,097 DEBUG nova [-] xenapi_remap_vbd_dev_prefix : sd from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:17:00,118 DEBUG nova [-] injected_network_template : /usr/lib/pymodules/python2.7/nova/virt/interfaces.template from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:17:00,139 DEBUG nova [-] network_host : ubuntuServer from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:17:00,153 DEBUG nova [-] vncproxy_url : http://127.0.0.1:6080 from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:17:00,153 DEBUG nova [-] ajax_console_proxy_topic : ajax_proxy from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:17:00,198 DEBUG nova [-] vmwareapi_host_username : None from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:17:00,242 DEBUG nova [-] minimum_root_size : 10737418240 from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:17:00,270 DEBUG nova [-] xenapi_connection_username : root from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:17:00,285 DEBUG nova [-] quota_cores : 20 from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:17:00,312 DEBUG nova [-] use_project_ca : False from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:17:00,332 DEBUG nova [-] routing_source_ip : 172.16.20.111 from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:17:00,332 DEBUG nova [-] rabbit_userid : guest from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:17:00,332 DEBUG nova [-] volume_topic : volume from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:17:00,341 DEBUG nova [-] num_shell_tries : 3 from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:17:00,368 DEBUG nova [-] vmwareapi_wsdl_loc : None from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:17:00,368 DEBUG nova [-] volume_name_template : volume-%08x from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:17:00,368 DEBUG nova [-] lock_path : /var/lock/nova from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:17:00,388 DEBUG nova [-] live_migration_uri : qemu+tcp://%s/system from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:17:00,412 DEBUG nova [-] iscsi_num_targets : 100 from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:17:00,429 DEBUG nova [-] xenapi_agent_path : usr/sbin/xe-update-networking from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:17:00,454 DEBUG nova [-] flat_network_dns : 8.8.4.4 from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:17:00,454 DEBUG nova [-] osapi_listen_port : 8774 from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:17:00,454 DEBUG nova [-] connection_type : libvirt from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:17:00,477 DEBUG nova [-] update_dhcp_on_disassociate : False from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:17:00,477 DEBUG nova [-] default_project : openstack from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:17:00,477 DEBUG nova [-] s3_port : 3333 from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:17:00,477 DEBUG nova [-] logging_context_format_string : %(asctime)s %(levelname)s %(name)s [%(request_id)s %(user)s %(project)s] %(message)s from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:17:00,497 DEBUG nova [-] vpn_ip : 172.16.20.111 from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:17:00,497 DEBUG nova [-] instance_name_template : instance-%08x from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:17:00,497 DEBUG nova [-] ec2_host : 172.16.20.111 from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:17:00,514 DEBUG nova [-] credential_key_file : pk.pem from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:17:00,540 DEBUG nova [-] quota_metadata_items : 128 from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:17:00,540 DEBUG nova [-] logging_debug_format_suffix : from (pid=%(process)d) %(funcName)s %(pathname)s:%(lineno)d from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:17:00,573 DEBUG nova [-] stub_network : False from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:17:00,574 DEBUG nova [-] console_manager : nova.console.manager.ConsoleProxyManager from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:17:00,574 DEBUG nova [-] ? : None from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:17:00,574 DEBUG nova [-] default_log_levels : ['amqplib=WARN', 'sqlalchemy=WARN', 'boto=WARN', 'eventlet.wsgi.server=WARN'] from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:17:00,574 DEBUG nova [-] osapi_scheme : http from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:17:00,593 DEBUG nova [-] credential_rc_file : %src from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:17:00,615 DEBUG nova [-] dhcp_domain : novalocal from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:17:00,615 DEBUG nova [-] sql_connection : sqlite:////var/lib/nova/nova.sqlite from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:17:00,615 DEBUG nova [-] console_topic : console from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:17:00,624 DEBUG nova [-] instances_path : /var/lib/nova/instances from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:17:00,644 DEBUG nova [-] flat_injected : True from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:17:00,663 DEBUG nova [-] use_local_volumes : True from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:17:00,663 DEBUG nova [-] host : ubuntuServer from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:17:00,690 DEBUG nova [-] target_port : 3260 from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:17:00,706 DEBUG nova [-] flat_network_dhcp_start : 10.0.0.2 from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:17:00,724 DEBUG nova [-] fixed_ip_disassociate_timeout : 600 from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:17:00,745 DEBUG nova [-] console_host : ubuntuServer from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:17:00,769 DEBUG nova [-] rescue_ramdisk_id : ari-rescue from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:17:00,787 DEBUG nova [-] quota_max_injected_file_content_bytes : 10240 from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:17:00,800 DEBUG nova [-] floating_range : 4.4.4.0/24 from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:17:00,800 DEBUG nova [-] db_backend : sqlalchemy from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:17:00,816 DEBUG nova [-] credentials_template : /usr/lib/pymodules/python2.7/nova/auth/novarc.template from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:17:00,842 DEBUG nova [-] vpn_cert_subject : /C=US/ST=California/L=MountainView/O=AnsoLabs/OU=NovaDev/CN=project-vpn-%s-%s from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:17:00,842 DEBUG nova [-] sql_retry_interval : 10 from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:17:00,861 DEBUG nova [-] vpn_start : 1000 from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:17:00,881 DEBUG nova [-] volume_driver : nova.volume.driver.ISCSIDriver from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:17:00,900 DEBUG nova [-] networks_path : /var/lib/nova/networks from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:17:00,914 DEBUG nova [-] crl_file : crl.pem from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:17:00,914 DEBUG nova [-] s3_host : 172.16.20.111 from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:17:00,936 DEBUG nova [-] qemu_img : qemu-img from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:17:00,955 DEBUG nova [-] input_chain : INPUT from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:17:00,981 DEBUG nova [-] max_nbd_devices : 16 from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:17:00,990 DEBUG nova [-] xenapi_connection_url : None from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:17:00,990 DEBUG nova [-] scheduler_topic : scheduler from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:17:00,990 DEBUG nova [-] verbose : True from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:17:01,022 DEBUG nova [-] flat_network_bridge : br100 from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:17:01,022 DEBUG nova [-] sql_max_retries : 12 from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:17:01,041 DEBUG nova [-] num_iscsi_scan_tries : 3 from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:17:01,041 DEBUG nova [-] default_instance_type : m1.small from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:17:01,050 DEBUG nova [-] firewall_driver : nova.virt.libvirt_conn.IptablesFirewallDriver from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:17:01,082 DEBUG nova [-] libvirt_type : kvm from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:17:01,090 DEBUG nova [-] periodic_interval : 60 from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:17:01,099 DEBUG nova [-] num_shelves : 100 from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:17:01,099 DEBUG nova [-] vpn_key_suffix : -vpn from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:17:01,123 DEBUG nova [-] use_cow_images : True from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:17:01,143 DEBUG nova [-] block_size : 268435456 from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:17:01,144 DEBUG nova [-] null_kernel : nokernel from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:17:01,162 DEBUG nova [-] target_host : None from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:17:01,191 DEBUG nova [-] flat_interface : None from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:17:01,244 DEBUG nova [-] libvirt_xml_template : /usr/lib/pymodules/python2.7/nova/virt/libvirt.xml.template from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:17:01,282 DEBUG nova [-] vpn_client_template : /usr/lib/pymodules/python2.7/nova/cloudpipe/client.ovpn.template from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:17:01,318 DEBUG nova [-] vmwareapi_host_ip : None from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:17:01,345 DEBUG nova [-] xenapi_image_service : glance from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:17:01,387 DEBUG nova [-] helpshort : None from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:17:01,408 DEBUG nova [-] credential_vpn_file : nova-vpn.conf from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:17:01,453 DEBUG nova [-] volume_group : nova-volumes from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:17:01,474 DEBUG nova [-] cpuinfo_xml_template : /usr/lib/pymodules/python2.7/nova/virt/cpuinfo.xml.template from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:17:01,499 DEBUG nova [-] credential_cert_file : cert.pem from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:17:01,532 DEBUG nova [-] allowed_roles : ['cloudadmin', 'itsec', 'sysadmin', 'netadmin', 'developer'] from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:17:01,533 DEBUG nova [-] logging_exception_prefix : (%(name)s): TRACE: from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:17:01,544 DEBUG nova [-] xenapi_vhd_coalesce_max_attempts : 5 from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:17:01,565 DEBUG nova [-] vmwareapi_vlan_interface : vmnic0 from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:17:01,565 DEBUG nova [-] report_interval : 10 from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:17:01,565 DEBUG nova [-] scheduler_manager : nova.scheduler.manager.SchedulerManager from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:17:01,565 DEBUG nova [-] ec2_port : 8773 from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:17:01,588 DEBUG nova [-] rescue_kernel_id : aki-rescue from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:17:01,600 DEBUG nova [-] osapi_port : 8774 from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:17:01,600 DEBUG nova [-] auth_token_ttl : 3600 from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:17:01,620 DEBUG nova [-] quota_volumes : 10 from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:17:01,629 DEBUG nova [-] libvirt_uri : from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:17:01,638 DEBUG nova [-] ec2_listen_port : 8773 from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:17:01,638 DEBUG nova [-] ec2_scheme : http from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:17:01,648 DEBUG nova [-] keys_path : /var/lib/nova/keys from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:17:01,648 DEBUG nova [-] vpn_image_id : ami-cloudpipe from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:17:01,667 DEBUG nova [-] dns_server : None from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:17:01,699 DEBUG nova [-] quota_floating_ips : 10 from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:17:01,725 DEBUG nova [-] fake_call : False from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:17:01,725 DEBUG nova [-] state_path : /var/lib/nova from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:17:01,725 DEBUG nova [-] sql_idle_timeout : 3600 from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:17:01,725 DEBUG nova [-] glance_host : 172.16.20.111 from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:17:01,725 DEBUG nova [-] default_image : ami-11111 from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:17:01,726 DEBUG nova [-] aws_secret_access_key : admin from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:17:01,748 DEBUG nova [-] use_ipv6 : False from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:17:01,748 DEBUG nova [-] osapi_listen : 0.0.0.0 from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:17:01,776 DEBUG nova [-] key_file : private/cakey.pem from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:17:01,800 DEBUG nova [-] helpxml : None from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:17:01,800 DEBUG nova [-] fake_network : False from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:17:01,800 DEBUG nova [-] osapi_extensions_path : /var/lib/nova/extensions from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:17:01,821 DEBUG nova [-] quota_gigabytes : 1000 from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:17:01,822 DEBUG nova [-] region_list : [] from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:17:01,842 DEBUG nova [-] xenapi_vhd_coalesce_poll_interval : 5.0 from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:17:01,861 DEBUG nova [-] dhcpbridge : /usr/bin/nova-dhcpbridge from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:17:01,884 DEBUG nova [-] auth_driver : nova.auth.dbdriver.DbDriver from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:17:01,884 DEBUG nova [-] network_manager : nova.network.manager.FlatManager from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:17:01,914 DEBUG nova [-] enable_zone_routing : False from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:17:01,934 DEBUG nova [-] xenapi_inject_image : True from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:17:01,934 DEBUG nova [-] osapi_host : 172.16.20.111 from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:17:01,960 DEBUG nova [-] rescue_image_id : ami-rescue from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:17:01,961 DEBUG nova [-] zone_name : nova from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:17:01,961 DEBUG nova [-] logging_default_format_string : %(asctime)s %(levelname)s %(name)s [-] %(message)s from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:17:01,985 DEBUG nova [-] timeout_nbd : 10 from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:17:02,025 DEBUG nova [-] compute_driver : nova.virt.connection.get_connection from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:17:02,085 DEBUG nova [-] dhcpbridge_flagfile : /etc/nova/nova.conf from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:17:02,115 DEBUG nova [-] quota_max_injected_file_path_bytes : 255 from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:17:02,149 DEBUG nova [-] default_os_type : linux from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:17:02,149 DEBUG nova [-] fake_rabbit : False from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:17:02,180 DEBUG nova [-] block_device_creation_timeout : 10 from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:17:02,180 DEBUG nova [-] rabbit_host : 172.16.20.111 from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:17:02,205 DEBUG nova [-] rescue_timeout : 0 from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:17:02,225 DEBUG nova [-] dmz_cidr : 10.128.0.0/24 from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:17:02,255 DEBUG nova [-] xenapi_login_timeout : 10 from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:17:02,291 DEBUG nova [-] xenapi_sr_base_path : /var/run/sr-mount from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:17:02,291 DEBUG nova [-] use_syslog : False from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:17:02,318 DEBUG nova [-] superuser_roles : ['cloudadmin'] from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:17:02,319 DEBUG nova [-] osapi_path : /v1.0/ from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:17:02,319 DEBUG nova [-] ec2_path : /services/Cloud from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:17:02,349 DEBUG nova [-] rbd_pool : rbd from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:17:02,368 DEBUG nova [-] allow_project_net_traffic : True from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:17:02,395 DEBUG nova [-] vmwareapi_api_retry_count : 10.0 from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:17:02,419 DEBUG nova [-] ca_path : /var/lib/nova/CA from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:17:02,429 DEBUG nova [-] rabbit_retry_interval : 10 from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:17:02,430 DEBUG nova [-] node_availability_zone : nova from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:17:02,462 DEBUG nova [-] xenapi_task_poll_interval : 0.5 from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:17:02,485 DEBUG nova [-] db_driver : nova.db.api from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:17:02,508 DEBUG nova [-] iscsi_ip_prefix : 172.16.20.111 from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:17:02,535 DEBUG nova [-] ajaxterm_portrange : 10000-12000 from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:17:02,535 DEBUG nova [-] volume_manager : nova.volume.manager.VolumeManager from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:17:02,567 DEBUG nova [-] start_guests_on_host_boot : False from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:17:02,603 DEBUG nova [-] vlan_start : 100 from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:17:02,603 DEBUG nova [-] rpc_thread_pool_size : 1024 from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:17:02,634 DEBUG nova [-] vnc_enabled : True from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:17:02,635 DEBUG nova [-] api_paste_config : api-paste.ini from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:17:02,663 DEBUG nova [-] global_roles : ['cloudadmin', 'itsec'] from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:17:02,681 DEBUG nova [-] xenapi_connection_password : None from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:17:02,681 DEBUG nova [-] rabbit_virtual_host : / from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:17:02,698 DEBUG nova [-] network_driver : nova.network.linux_net from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:17:02,730 DEBUG nova [-] quota_instances : 10 from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:17:02,747 DEBUG nova [-] project_cert_subject : /C=US/ST=California/L=MountainView/O=AnsoLabs/OU=NovaDev/CN=project-ca-%s-%s from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:17:02,748 DEBUG nova [-] image_service : nova.image.glance.GlanceImageService from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:17:02,748 DEBUG nova [-] control_exchange : nova from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:17:02,765 DEBUG nova [-] cnt_vpn_clients : 0 from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:17:02,766 DEBUG nova [-] ajax_console_proxy_port : 8000 from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:17:02,786 DEBUG nova [-] vncproxy_topic : vncproxy from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:17:02,786 DEBUG nova [-] compute_manager : nova.compute.manager.ComputeManager from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:17:02,786 DEBUG nova [-] network_topic : network from (pid=17201) serve /usr/lib/pymodules/python2.7/nova/service.py:287 2011-05-09 12:17:02,786 AUDIT nova [-] Starting compute node (version 2011.2-workspace:tarmac-20110415024701-a9bdb77vaatk99lh) 2011-05-09 12:17:03,087 DEBUG nova.utils [-] backend <module 'nova.db.sqlalchemy.api'="" from="" '="" usr="" lib="" pymodules="" python2.7="" nova="" db="" sqlalchemy="" api.pyc'=""> from (pid=17201) __get_backend /usr/lib/pymodules/python2.7/nova/utils.py:427 2011-05-09 12:17:03,305 DEBUG nova.virt.libvirt_conn [-] Checking state of instance-00000001 from (pid=17201) init_host /usr/lib/pymodules/python2.7/nova/virt/libvirt_conn.py:227 2011-05-09 12:17:03,306 DEBUG nova.virt.libvirt_conn [-] Connecting to libvirt: qemu:///system from (pid=17201) _get_connection /usr/lib/pymodules/python2.7/nova/virt/libvirt_conn.py:246 2011-05-09 12:17:03,324 DEBUG nova.virt.libvirt_conn [-] Current state of instance-00000001 was 5. from (pid=17201) init_host /usr/lib/pymodules/python2.7/nova/virt/libvirt_conn.py:233 2011-05-09 12:17:03,423 DEBUG nova.virt.libvirt_conn [-] Checking state of instance-00000002 from (pid=17201) init_host /usr/lib/pymodules/python2.7/nova/virt/libvirt_conn.py:227 2011-05-09 12:17:03,427 DEBUG nova.virt.libvirt_conn [-] Current state of instance-00000002 was 5. from (pid=17201) init_host /usr/lib/pymodules/python2.7/nova/virt/libvirt_conn.py:233 2011-05-09 12:17:03,522 DEBUG nova.virt.libvirt_conn [-] Checking state of instance-00000003 from (pid=17201) init_host /usr/lib/pymodules/python2.7/nova/virt/libvirt_conn.py:227 2011-05-09 12:17:03,524 DEBUG nova.virt.libvirt_conn [-] Current state of instance-00000003 was 5. from (pid=17201) init_host /usr/lib/pymodules/python2.7/nova/virt/libvirt_conn.py:233 2011-05-09 12:17:03,611 DEBUG nova.virt.libvirt_conn [-] Checking state of instance-00000004 from (pid=17201) init_host /usr/lib/pymodules/python2.7/nova/virt/libvirt_conn.py:227 2011-05-09 12:17:03,613 DEBUG nova.virt.libvirt_conn [-] Current state of instance-00000004 was 5. from (pid=17201) init_host /usr/lib/pymodules/python2.7/nova/virt/libvirt_conn.py:233 2011-05-09 12:17:03,685 DEBUG nova.virt.libvirt_conn [-] Checking state of instance-00000005 from (pid=17201) init_host /usr/lib/pymodules/python2.7/nova/virt/libvirt_conn.py:227 2011-05-09 12:17:03,700 DEBUG nova.virt.libvirt_conn [-] Current state of instance-00000005 was 5. from (pid=17201) init_host /usr/lib/pymodules/python2.7/nova/virt/libvirt_conn.py:233 2011-05-09 12:17:03,783 DEBUG nova.virt.libvirt_conn [-] Checking state of instance-00000006 from (pid=17201) init_host /usr/lib/pymodules/python2.7/nova/virt/libvirt_conn.py:227 2011-05-09 12:17:03,785 DEBUG nova.virt.libvirt_conn [-] Current state of instance-00000006 was 5. from (pid=17201) init_host /usr/lib/pymodules/python2.7/nova/virt/libvirt_conn.py:233 2011-05-09 12:17:03,866 DEBUG nova.virt.libvirt_conn [-] Checking state of instance-00000007 from (pid=17201) init_host /usr/lib/pymodules/python2.7/nova/virt/libvirt_conn.py:227 2011-05-09 12:17:03,867 DEBUG nova.virt.libvirt_conn [-] Current state of instance-00000007 was 5. from (pid=17201) init_host /usr/lib/pymodules/python2.7/nova/virt/libvirt_conn.py:233 2011-05-09 12:17:03,982 DEBUG nova.virt.libvirt_conn [-] Checking state of instance-00000008 from (pid=17201) init_host /usr/lib/pymodules/python2.7/nova/virt/libvirt_conn.py:227 2011-05-09 12:17:03,986 DEBUG nova.virt.libvirt_conn [-] Current state of instance-00000008 was 5. from (pid=17201) init_host /usr/lib/pymodules/python2.7/nova/virt/libvirt_conn.py:233 2011-05-09 12:17:04,087 DEBUG nova.virt.libvirt_conn [-] Checking state of instance-00000009 from (pid=17201) init_host /usr/lib/pymodules/python2.7/nova/virt/libvirt_conn.py:227 2011-05-09 12:17:04,092 DEBUG nova.virt.libvirt_conn [-] Current state of instance-00000009 was 5. from (pid=17201) init_host /usr/lib/pymodules/python2.7/nova/virt/libvirt_conn.py:233 2011-05-09 12:17:04,491 INFO nova.virt.libvirt_conn [-] Compute_service record updated for ubuntuServer 2011-05-09 12:17:04,506 DEBUG nova.rpc [-] Initing the Adapter Consumer for compute from (pid=17201) __init__ /usr/lib/pymodules/python2.7/nova/rpc.py:148 2011-05-09 12:17:04,552 DEBUG nova.rpc [-] Initing the Adapter Consumer for compute.ubuntuServer from (pid=17201) __init__ /usr/lib/pymodules/python2.7/nova/rpc.py:148 2011-05-09 12:17:04,591 INFO nova.rpc [-] Created 'compute_fanout' fanout exchange with 'compute' routing key 2011-05-09 12:17:04,592 DEBUG nova.rpc [-] Initing the Adapter Consumer for compute from (pid=17201) __init__ /usr/lib/pymodules/python2.7/nova/rpc.py:148 2011-05-09 12:17:33,448 DEBUG nova.rpc [-] received {u'_context_request_id': u'-B4P0JZZC-5UPN68GYFJ', u'_context_read_deleted': False, u'args': {u'instance_id': 10, u'injected_files': None, u'availability_zone': u'nova'}, u'_context_is_admin': None, u'_context_timestamp': u'2011-05-09T02:17:31Z', u'_context_user': u'chris', u'method': u'run_instance', u'_context_project': u'dev', u'_context_remote_address': u'172.16.72.136'} from (pid=17201) _receive /usr/lib/pymodules/python2.7/nova/rpc.py:167 2011-05-09 12:17:33,448 DEBUG nova.rpc [-] unpacked context: {'timestamp': u'2011-05-09T02:17:31Z', 'remote_address': u'172.16.72.136', 'project': u'dev', 'is_admin': None, 'user': u'chris', 'request_id': u'-B4P0JZZC-5UPN68GYFJ', 'read_deleted': False} from (pid=17201) _unpack_context /usr/lib/pymodules/python2.7/nova/rpc.py:331 2011-05-09 12:17:33,691 AUDIT nova.compute.manager [-B4P0JZZC-5UPN68GYFJ chris dev] instance 10: starting... 2011-05-09 12:17:34,806 DEBUG nova.rpc [-] Making asynchronous call on network.ubuntuServer ... from (pid=17201) call /usr/lib/pymodules/python2.7/nova/rpc.py:350 2011-05-09 12:17:34,807 DEBUG nova.rpc [-] MSG_ID is baf75eef84d74ce1b3da8c7e40c4b806 from (pid=17201) call /usr/lib/pymodules/python2.7/nova/rpc.py:353 2011-05-09 12:17:35,523 DEBUG nova.virt.libvirt_conn [-] instance instance-0000000a: starting toXML method from (pid=17201) to_xml /usr/lib/pymodules/python2.7/nova/virt/libvirt_conn.py:996 2011-05-09 12:17:35,862 DEBUG nova.virt.libvirt_conn [-] instance instance-0000000a: finished toXML method from (pid=17201) to_xml /usr/lib/pymodules/python2.7/nova/virt/libvirt_conn.py:1041 2011-05-09 12:17:36,015 INFO nova [-] called setup_basic_filtering in nwfilter 2011-05-09 12:17:36,015 INFO nova [-] ensuring static filters 2011-05-09 12:17:36,231 INFO nova [-] <nova.db.sqlalchemy.models.securitygroupingressrule object="" at="" 0x46ad810=""> 2011-05-09 12:17:36,231 INFO nova [-] <nova.db.sqlalchemy.models.securitygroupingressrule object="" at="" 0x46ad450=""> 2011-05-09 12:17:36,241 DEBUG nova.utils [-] Attempting to grab semaphore "iptables" for method "apply"... from (pid=17201) inner /usr/lib/pymodules/python2.7/nova/utils.py:594 2011-05-09 12:17:36,241 DEBUG nova.utils [-] Attempting to grab file lock "iptables" for method "apply"... from (pid=17201) inner /usr/lib/pymodules/python2.7/nova/utils.py:599 2011-05-09 12:17:36,276 DEBUG nova.utils [-] Running cmd (subprocess): sudo iptables-save -t filter from (pid=17201) execute /usr/lib/pymodules/python2.7/nova/utils.py:150 2011-05-09 12:17:36,523 DEBUG nova.utils [-] Running cmd (subprocess): sudo iptables-restore from (pid=17201) execute /usr/lib/pymodules/python2.7/nova/utils.py:150 2011-05-09 12:17:36,743 DEBUG nova.utils [-] Running cmd (subprocess): sudo iptables-save -t nat from (pid=17201) execute /usr/lib/pymodules/python2.7/nova/utils.py:150 2011-05-09 12:17:36,886 DEBUG nova.utils [-] Running cmd (subprocess): sudo iptables-restore from (pid=17201) execute /usr/lib/pymodules/python2.7/nova/utils.py:150 2011-05-09 12:17:37,156 DEBUG nova.utils [-] Running cmd (subprocess): mkdir -p /var/lib/nova/instances/instance-0000000a/ from (pid=17201) execute /usr/lib/pymodules/python2.7/nova/utils.py:150 2011-05-09 12:17:37,277 INFO nova.virt.libvirt_conn [-] instance instance-0000000a: Creating image 2011-05-09 12:17:37,620 DEBUG nova.utils [-] Attempting to grab semaphore "00000001" for method "call_if_not_exists"... from (pid=17201) inner /usr/lib/pymodules/python2.7/nova/utils.py:594 2011-05-09 12:17:37,632 DEBUG nova.utils [-] Running cmd (subprocess): cp /var/lib/nova/instances/_base/00000001 /var/lib/nova/instances/instance-0000000a/kernel from (pid=17201) execute /usr/lib/pymodules/python2.7/nova/utils.py:150 2011-05-09 12:17:37,913 DEBUG nova.utils [-] Attempting to grab semaphore "00000002_sm" for method "call_if_not_exists"... from (pid=17201) inner /usr/lib/pymodules/python2.7/nova/utils.py:594 2011-05-09 12:17:37,913 DEBUG nova.utils [-] Running cmd (subprocess): qemu-img create -f qcow2 -o cluster_size=2M,backing_file=/var/lib/nova/instances/_base/00000002_sm /var/lib/nova/instances/instance-0000000a/disk from (pid=17201) execute /usr/lib/pymodules/python2.7/nova/utils.py:150 2011-05-09 12:17:38,251 INFO nova.virt.libvirt_conn [-] instance instance-0000000a: injecting key into image 2 2011-05-09 12:17:38,252 INFO nova.virt.libvirt_conn [-] instance instance-0000000a: injecting net into image 2 2011-05-09 12:17:38,294 DEBUG nova.utils [-] Running cmd (subprocess): sudo qemu-nbd -c /dev/nbd15 /var/lib/nova/instances/instance-0000000a/disk from (pid=17201) execute /usr/lib/pymodules/python2.7/nova/utils.py:150 2011-05-09 12:17:39,615 DEBUG nova.utils [-] Running cmd (subprocess): sudo tune2fs -c 0 -i 0 /dev/nbd15 from (pid=17201) execute /usr/lib/pymodules/python2.7/nova/utils.py:150 2011-05-09 12:17:40,194 DEBUG nova.utils [-] Running cmd (subprocess): sudo mount /dev/nbd15 /tmp/tmp4MfRlw from (pid=17201) execute /usr/lib/pymodules/python2.7/nova/utils.py:150 2011-05-09 12:17:40,425 DEBUG nova.utils [-] Running cmd (subprocess): sudo mkdir -p /tmp/tmp4MfRlw/root/.ssh from (pid=17201) execute /usr/lib/pymodules/python2.7/nova/utils.py:150 2011-05-09 12:17:40,583 DEBUG nova.utils [-] Running cmd (subprocess): sudo chown root /tmp/tmp4MfRlw/root/.ssh from (pid=17201) execute /usr/lib/pymodules/python2.7/nova/utils.py:150 2011-05-09 12:17:40,682 DEBUG nova.utils [-] Running cmd (subprocess): sudo chmod 700 /tmp/tmp4MfRlw/root/.ssh from (pid=17201) execute /usr/lib/pymodules/python2.7/nova/utils.py:150 2011-05-09 12:17:40,791 DEBUG nova.utils [-] Running cmd (subprocess): sudo tee -a /tmp/tmp4MfRlw/root/.ssh/authorized_keys from (pid=17201) execute /usr/lib/pymodules/python2.7/nova/utils.py:150 2011-05-09 12:17:40,907 DEBUG nova.utils [-] Running cmd (subprocess): sudo mkdir -p /tmp/tmp4MfRlw/etc/network from (pid=17201) execute /usr/lib/pymodules/python2.7/nova/utils.py:150 2011-05-09 12:17:41,033 DEBUG nova.utils [-] Running cmd (subprocess): sudo chown root:root /tmp/tmp4MfRlw/etc/network from (pid=17201) execute /usr/lib/pymodules/python2.7/nova/utils.py:150 2011-05-09 12:17:41,144 DEBUG nova.utils [-] Running cmd (subprocess): sudo chmod 755 /tmp/tmp4MfRlw/etc/network from (pid=17201) execute /usr/lib/pymodules/python2.7/nova/utils.py:150 2011-05-09 12:17:41,248 DEBUG nova.utils [-] Running cmd (subprocess): sudo tee /tmp/tmp4MfRlw/etc/network/interfaces from (pid=17201) execute /usr/lib/pymodules/python2.7/nova/utils.py:150 2011-05-09 12:17:41,351 DEBUG nova.utils [-] Running cmd (subprocess): sudo umount /dev/nbd15 from (pid=17201) execute /usr/lib/pymodules/python2.7/nova/utils.py:150 2011-05-09 12:17:42,442 DEBUG nova.utils [-] Running cmd (subprocess): rmdir /tmp/tmp4MfRlw from (pid=17201) execute /usr/lib/pymodules/python2.7/nova/utils.py:150 2011-05-09 12:17:42,624 DEBUG nova.utils [-] Running cmd (subprocess): sudo qemu-nbd -d /dev/nbd15 from (pid=17201) execute /usr/lib/pymodules/python2.7/nova/utils.py:150 2011-05-09 12:17:42,971 ERROR nova.exception [-] Uncaught exception (nova.exception): TRACE: Traceback (most recent call last): (nova.exception): TRACE: File "/usr/lib/pymodules/python2.7/nova/exception.py", line 120, in _wrap (nova.exception): TRACE: return f(args, *kw) (nova.exception): TRACE: File "/usr/lib/pymodules/python2.7/nova/virt/libvirt_conn.py", line 617, in spawn (nova.exception): TRACE: domain = self._create_new_domain(xml) (nova.exception): TRACE: File "/usr/lib/pymodules/python2.7/nova/virt/libvirt_conn.py", line 1077, in _create_new_domain (nova.exception): TRACE: domain = self._conn.defineXML(xml) (nova.exception): TRACE: File "/usr/lib/python2.7/dist-packages/libvirt.py", line 1368, in defineXML (nova.exception): TRACE: if ret is None:raise libvirtError('virDomainDefineXML() failed', conn=self) (nova.exception): TRACE: libvirtError: internal error no supported architecture for os type 'hvm' (nova.exception): TRACE: 2011-05-09 12:17:42,994 ERROR nova.compute.manager [-B4P0JZZC-5UPN68GYFJ chris dev] Instance '10' failed to spawn. Is virtualization enabled in the BIOS? (nova.compute.manager): TRACE: Traceback (most recent call last): (nova.compute.manager): TRACE: File "/usr/lib/pymodules/python2.7/nova/compute/manager.py", line 234, in run_instance (nova.compute.manager): TRACE: self.driver.spawn(instance_ref) (nova.compute.manager): TRACE: File "/usr/lib/pymodules/python2.7/nova/exception.py", line 126, in _wrap (nova.compute.manager): TRACE: raise Error(str(e)) (nova.compute.manager): TRACE: Error: internal error no supported architecture for os type 'hvm' (nova.compute.manager): TRACE: 2011-05-09 12:18:04,708 INFO nova.compute.manager [-] Found instance 'instance-00000001' in DB but no VM. State=5, so setting state to shutoff. 2011-05-09 12:18:04,709 INFO nova.compute.manager [-] Found instance 'instance-00000002' in DB but no VM. State=5, so setting state to shutoff. 2011-05-09 12:18:04,709 INFO nova.compute.manager [-] Found instance 'instance-00000003' in DB but no VM. State=5, so setting state to shutoff. 2011-05-09 12:18:04,709 INFO nova.compute.manager [-] Found instance 'instance-00000004' in DB but no VM. State=5, so setting state to shutoff. 2011-05-09 12:18:04,709 INFO nova.compute.manager [-] Found instance 'instance-00000005' in DB but no VM. State=5, so setting state to shutoff. 2011-05-09 12:18:04,709 INFO nova.compute.manager [-] Found instance 'instance-00000006' in DB but no VM. State=5, so setting state to shutoff. 2011-05-09 12:18:04,709 INFO nova.compute.manager [-] Found instance 'instance-00000007' in DB but no VM. State=5, so setting state to shutoff. 2011-05-09 12:18:04,709 INFO nova.compute.manager [-] Found instance 'instance-00000008' in DB but no VM. State=5, so setting state to shutoff. 2011-05-09 12:18:04,710 INFO nova.compute.manager [-] Found instance 'instance-00000009' in DB but no VM. State=5, so setting state to shutoff. 2011-05-09 12:18:04,710 INFO nova.compute.manager [-] Found instance 'instance-0000000a' in DB but no VM. State=8, so setting state to shutoff. 2011-05-09 12:18:04,710 INFO nova.compute.manager [-] DB/VM state mismatch. Changing state from '8' to '5' 2011-05-09 12:19:04,896 INFO nova.compute.manager [-] Found instance 'instance-00000001' in DB but no VM. State=5, so setting state to shutoff.

Thanks Chris