2012-08-10 09:57:34,985 DEBUG nova [-] Full set of FLAGS: from (pid=18708) wait /usr/lib/python2.7/dist-packages/nova/service.py:352 2012-08-10 09:57:34,985 DEBUG nova [-] storage_availability_zone : nova from (pid=18708) wait /usr/lib/python2.7/dist-packages/nova/service.py:355 2012-08-10 09:57:34,986 DEBUG nova [-] vc_image_name : vc_image from (pid=18708) wait /usr/lib/python2.7/dist-packages/nova/service.py:355 2012-08-10 09:57:34,986 DEBUG nova [-] ec2_dmz_host : 10.230.5.4 from (pid=18708) wait /usr/lib/python2.7/dist-packages/nova/service.py:355 2012-08-10 09:57:34,986 DEBUG nova [-] fixed_range : 192.168.3.0/24 from (pid=18708) wait /usr/lib/python2.7/dist-packages/nova/service.py:355 2012-08-10 09:57:34,986 DEBUG nova [-] compute_topic : compute from (pid=18708) wait /usr/lib/python2.7/dist-packages/nova/service.py:355 2012-08-10 09:57:34,986 DEBUG nova [-] vsa_topic : vsa from (pid=18708) wait /usr/lib/python2.7/dist-packages/nova/service.py:355 2012-08-10 09:57:34,986 DEBUG nova [-] fixed_range_v6 : fd00::/48 from (pid=18708) wait /usr/lib/python2.7/dist-packages/nova/service.py:355 2012-08-10 09:57:34,986 DEBUG nova [-] glance_api_servers : ['10.230.5.3:9292'] from (pid=18708) wait /usr/lib/python2.7/dist-packages/nova/service.py:355 2012-08-10 09:57:34,986 DEBUG nova [-] rabbit_password : guest from (pid=18708) wait /usr/lib/python2.7/dist-packages/nova/service.py:355 2012-08-10 09:57:34,987 DEBUG nova [-] s3_dmz : 10.230.5.4 from (pid=18708) wait /usr/lib/python2.7/dist-packages/nova/service.py:355 2012-08-10 09:57:34,987 DEBUG nova [-] dhcp_lease_time : 120 from (pid=18708) wait /usr/lib/python2.7/dist-packages/nova/service.py:355 2012-08-10 09:57:34,987 DEBUG nova [-] quota_ram : 51200 from (pid=18708) wait /usr/lib/python2.7/dist-packages/nova/service.py:355 2012-08-10 09:57:34,987 DEBUG nova [-] find_host_timeout : 30 from (pid=18708) wait /usr/lib/python2.7/dist-packages/nova/service.py:355 2012-08-10 09:57:34,987 DEBUG nova [-] aws_access_key_id : admin from (pid=18708) wait /usr/lib/python2.7/dist-packages/nova/service.py:355 2012-08-10 09:57:34,987 DEBUG nova [-] vncserver_host : 0.0.0.0 from (pid=18708) wait /usr/lib/python2.7/dist-packages/nova/service.py:355 2012-08-10 09:57:34,987 DEBUG nova [-] network_size : 8 from (pid=18708) wait /usr/lib/python2.7/dist-packages/nova/service.py:355 2012-08-10 09:57:34,987 DEBUG nova [-] enable_new_services : True from (pid=18708) wait /usr/lib/python2.7/dist-packages/nova/service.py:355 2012-08-10 09:57:34,987 DEBUG nova [-] my_ip : 10.230.5.4 from (pid=18708) wait /usr/lib/python2.7/dist-packages/nova/service.py:355 2012-08-10 09:57:34,988 DEBUG nova [-] quota_security_groups : 10 from (pid=18708) wait /usr/lib/python2.7/dist-packages/nova/service.py:355 2012-08-10 09:57:34,988 DEBUG nova [-] help : None from (pid=18708) wait /usr/lib/python2.7/dist-packages/nova/service.py:355 2012-08-10 09:57:34,988 DEBUG nova [-] quota_max_injected_files : 5 from (pid=18708) wait /usr/lib/python2.7/dist-packages/nova/service.py:355 2012-08-10 09:57:34,988 DEBUG nova [-] public_interface : eth0 from (pid=18708) wait /usr/lib/python2.7/dist-packages/nova/service.py:355 2012-08-10 09:57:34,988 DEBUG nova [-] zone_capabilities : ['hypervisor=xenserver;kvm', 'os=linux;windows'] from (pid=18708) wait /usr/lib/python2.7/dist-packages/nova/service.py:355 2012-08-10 09:57:34,988 DEBUG nova [-] logdir : /var/log/nova from (pid=18708) wait /usr/lib/python2.7/dist-packages/nova/service.py:355 2012-08-10 09:57:34,988 DEBUG nova [-] sqlite_db : nova.sqlite from (pid=18708) wait /usr/lib/python2.7/dist-packages/nova/service.py:355 2012-08-10 09:57:34,988 DEBUG nova [-] helpxml : None from (pid=18708) wait /usr/lib/python2.7/dist-packages/nova/service.py:355 2012-08-10 09:57:34,989 DEBUG nova [-] num_networks : 1 from (pid=18708) wait /usr/lib/python2.7/dist-packages/nova/service.py:355 2012-08-10 09:57:34,989 DEBUG nova [-] vsa_manager : nova.vsa.manager.VsaManager from (pid=18708) wait /usr/lib/python2.7/dist-packages/nova/service.py:355 2012-08-10 09:57:34,989 DEBUG nova [-] notification_driver : nova.notifier.no_op_notifier from (pid=18708) wait /usr/lib/python2.7/dist-packages/nova/service.py:355 2012-08-10 09:57:34,989 DEBUG nova [-] osapi_max_limit : 1000 from (pid=18708) wait /usr/lib/python2.7/dist-packages/nova/service.py:355 2012-08-10 09:57:34,989 DEBUG nova [-] rabbit_port : 5672 from (pid=18708) wait /usr/lib/python2.7/dist-packages/nova/service.py:355 2012-08-10 09:57:34,989 DEBUG nova [-] dns_server : None from (pid=18708) wait /usr/lib/python2.7/dist-packages/nova/service.py:355 2012-08-10 09:57:34,989 DEBUG nova [-] rabbit_max_retries : 0 from (pid=18708) wait /usr/lib/python2.7/dist-packages/nova/service.py:355 2012-08-10 09:57:34,989 DEBUG nova [-] resume_guests_state_on_host_boot : False from (pid=18708) wait /usr/lib/python2.7/dist-packages/nova/service.py:355 2012-08-10 09:57:34,990 DEBUG nova [-] sql_max_pool_size : 10 from (pid=18708) wait /usr/lib/python2.7/dist-packages/nova/service.py:355 2012-08-10 09:57:34,990 DEBUG nova [-] ec2_listen : 0.0.0.0 from (pid=18708) wait /usr/lib/python2.7/dist-packages/nova/service.py:355 2012-08-10 09:57:34,990 DEBUG nova [-] logfile : None from (pid=18708) wait /usr/lib/python2.7/dist-packages/nova/service.py:355 2012-08-10 09:57:34,990 DEBUG nova [-] ajax_console_proxy_url : http://127.0.0.1:8000 from (pid=18708) wait /usr/lib/python2.7/dist-packages/nova/service.py:355 2012-08-10 09:57:34,990 DEBUG nova [-] send_arp_for_ha : False from (pid=18708) wait /usr/lib/python2.7/dist-packages/nova/service.py:355 2012-08-10 09:57:34,990 DEBUG nova [-] snapshot_name_template : snapshot-%08x from (pid=18708) wait /usr/lib/python2.7/dist-packages/nova/service.py:355 2012-08-10 09:57:34,990 DEBUG nova [-] vncproxy_url : http://127.0.0.1:6080 from (pid=18708) wait /usr/lib/python2.7/dist-packages/nova/service.py:355 2012-08-10 09:57:34,990 DEBUG nova [-] osapi_port : 8774 from (pid=18708) wait /usr/lib/python2.7/dist-packages/nova/service.py:355 2012-08-10 09:57:34,991 DEBUG nova [-] ajax_console_proxy_topic : ajax_proxy from (pid=18708) wait /usr/lib/python2.7/dist-packages/nova/service.py:355 2012-08-10 09:57:34,991 DEBUG nova [-] quota_cores : 20 from (pid=18708) wait /usr/lib/python2.7/dist-packages/nova/service.py:355 2012-08-10 09:57:34,991 DEBUG nova [-] routing_source_ip : 192.168.3.1 from (pid=18708) wait /usr/lib/python2.7/dist-packages/nova/service.py:355 2012-08-10 09:57:34,991 DEBUG nova [-] vsa_name_template : vsa-%08x from (pid=18708) wait /usr/lib/python2.7/dist-packages/nova/service.py:355 2012-08-10 09:57:34,991 DEBUG nova [-] default_log_levels : ['amqplib=WARN', 'sqlalchemy=WARN', 'boto=WARN', 'eventlet.wsgi.server=WARN'] from (pid=18708) wait /usr/lib/python2.7/dist-packages/nova/service.py:355 2012-08-10 09:57:34,991 DEBUG nova [-] volume_topic : volume from (pid=18708) wait /usr/lib/python2.7/dist-packages/nova/service.py:355 2012-08-10 09:57:34,991 DEBUG nova [-] dnsmasq_config_file : from (pid=18708) wait /usr/lib/python2.7/dist-packages/nova/service.py:355 2012-08-10 09:57:34,991 DEBUG nova [-] volume_name_template : volume-%08x from (pid=18708) wait /usr/lib/python2.7/dist-packages/nova/service.py:355 2012-08-10 09:57:34,992 DEBUG nova [-] lock_path : /var/lock/nova from (pid=18708) wait /usr/lib/python2.7/dist-packages/nova/service.py:355 2012-08-10 09:57:34,992 DEBUG nova [-] flat_network_dns : 8.8.4.4 from (pid=18708) wait /usr/lib/python2.7/dist-packages/nova/service.py:355 2012-08-10 09:57:34,992 DEBUG nova [-] default_vsa_instance_type : m1.small from (pid=18708) wait /usr/lib/python2.7/dist-packages/nova/service.py:355 2012-08-10 09:57:34,992 DEBUG nova [-] osapi_listen_port : 8774 from (pid=18708) wait /usr/lib/python2.7/dist-packages/nova/service.py:355 2012-08-10 09:57:34,992 DEBUG nova [-] connection_type : libvirt from (pid=18708) wait /usr/lib/python2.7/dist-packages/nova/service.py:355 2012-08-10 09:57:34,992 DEBUG nova [-] update_dhcp_on_disassociate : False from (pid=18708) wait /usr/lib/python2.7/dist-packages/nova/service.py:355 2012-08-10 09:57:34,992 DEBUG nova [-] default_project : openstack from (pid=18708) wait /usr/lib/python2.7/dist-packages/nova/service.py:355 2012-08-10 09:57:34,992 DEBUG nova [-] s3_port : 3333 from (pid=18708) wait /usr/lib/python2.7/dist-packages/nova/service.py:355 2012-08-10 09:57:34,993 DEBUG nova [-] logfile_mode : 420 from (pid=18708) wait /usr/lib/python2.7/dist-packages/nova/service.py:355 2012-08-10 09:57:34,993 DEBUG nova [-] logging_context_format_string : %(asctime)s %(levelname)s %(name)s [%(request_id)s %(user_id)s %(project_id)s] %(message)s from (pid=18708) wait /usr/lib/python2.7/dist-packages/nova/service.py:355 2012-08-10 09:57:34,993 DEBUG nova [-] instance_name_template : instance-%08x from (pid=18708) wait /usr/lib/python2.7/dist-packages/nova/service.py:355 2012-08-10 09:57:34,993 DEBUG nova [-] ec2_host : 10.230.5.3 from (pid=18708) wait /usr/lib/python2.7/dist-packages/nova/service.py:355 2012-08-10 09:57:34,993 DEBUG nova [-] rabbit_durable_queues : False from (pid=18708) wait /usr/lib/python2.7/dist-packages/nova/service.py:355 2012-08-10 09:57:34,993 DEBUG nova [-] quota_metadata_items : 128 from (pid=18708) wait /usr/lib/python2.7/dist-packages/nova/service.py:355 2012-08-10 09:57:34,993 DEBUG nova [-] logging_debug_format_suffix : from (pid=%(process)d) %(funcName)s %(pathname)s:%(lineno)d from (pid=18708) wait /usr/lib/python2.7/dist-packages/nova/service.py:355 2012-08-10 09:57:34,993 DEBUG nova [-] network_host : ch01b04 from (pid=18708) wait /usr/lib/python2.7/dist-packages/nova/service.py:355 2012-08-10 09:57:34,994 DEBUG nova [-] console_manager : nova.console.manager.ConsoleProxyManager from (pid=18708) wait /usr/lib/python2.7/dist-packages/nova/service.py:355 2012-08-10 09:57:34,994 DEBUG nova [-] ? : None from (pid=18708) wait /usr/lib/python2.7/dist-packages/nova/service.py:355 2012-08-10 09:57:34,994 DEBUG nova [-] rpc_backend : nova.rpc.impl_kombu from (pid=18708) wait /usr/lib/python2.7/dist-packages/nova/service.py:355 2012-08-10 09:57:34,994 DEBUG nova [-] rabbit_userid : guest from (pid=18708) wait /usr/lib/python2.7/dist-packages/nova/service.py:355 2012-08-10 09:57:34,994 DEBUG nova [-] build_plan_encryption_key : None from (pid=18708) wait /usr/lib/python2.7/dist-packages/nova/service.py:355 2012-08-10 09:57:34,994 DEBUG nova [-] osapi_scheme : http from (pid=18708) wait /usr/lib/python2.7/dist-packages/nova/service.py:355 2012-08-10 09:57:34,994 DEBUG nova [-] dhcp_domain : novalocal from (pid=18708) wait /usr/lib/python2.7/dist-packages/nova/service.py:355 2012-08-10 09:57:34,994 DEBUG nova [-] sql_connection : mysql://root:ubuntu@10.230.5.3/nova from (pid=18708) wait /usr/lib/python2.7/dist-packages/nova/service.py:355 2012-08-10 09:57:34,995 DEBUG nova [-] console_topic : console from (pid=18708) wait /usr/lib/python2.7/dist-packages/nova/service.py:355 2012-08-10 09:57:34,995 DEBUG nova [-] flat_injected : False from (pid=18708) wait /usr/lib/python2.7/dist-packages/nova/service.py:355 2012-08-10 09:57:34,995 DEBUG nova [-] use_local_volumes : True from (pid=18708) wait /usr/lib/python2.7/dist-packages/nova/service.py:355 2012-08-10 09:57:34,995 DEBUG nova [-] host : ch01b04 from (pid=18708) wait /usr/lib/python2.7/dist-packages/nova/service.py:355 2012-08-10 09:57:34,995 DEBUG nova [-] fixed_ip_disassociate_timeout : 600 from (pid=18708) wait /usr/lib/python2.7/dist-packages/nova/service.py:355 2012-08-10 09:57:34,995 DEBUG nova [-] flat_interface : eth1 from (pid=18708) wait /usr/lib/python2.7/dist-packages/nova/service.py:355 2012-08-10 09:57:34,996 DEBUG nova [-] quota_instances : 10 from (pid=18708) wait /usr/lib/python2.7/dist-packages/nova/service.py:355 2012-08-10 09:57:34,996 DEBUG nova [-] quota_max_injected_file_content_bytes : 10240 from (pid=18708) wait /usr/lib/python2.7/dist-packages/nova/service.py:355 2012-08-10 09:57:34,996 DEBUG nova [-] floating_range : 4.4.4.0/24 from (pid=18708) wait /usr/lib/python2.7/dist-packages/nova/service.py:355 2012-08-10 09:57:34,996 DEBUG nova [-] multi_host : False from (pid=18708) wait /usr/lib/python2.7/dist-packages/nova/service.py:355 2012-08-10 09:57:34,996 DEBUG nova [-] db_backend : sqlalchemy from (pid=18708) wait /usr/lib/python2.7/dist-packages/nova/service.py:355 2012-08-10 09:57:34,996 DEBUG nova [-] sql_retry_interval : 10 from (pid=18708) wait /usr/lib/python2.7/dist-packages/nova/service.py:355 2012-08-10 09:57:34,996 DEBUG nova [-] vpn_start : 1000 from (pid=18708) wait /usr/lib/python2.7/dist-packages/nova/service.py:355 2012-08-10 09:57:34,996 DEBUG nova [-] volume_driver : nova.volume.driver.ISCSIDriver from (pid=18708) wait /usr/lib/python2.7/dist-packages/nova/service.py:355 2012-08-10 09:57:34,996 DEBUG nova [-] networks_path : /var/lib/nova/networks from (pid=18708) wait /usr/lib/python2.7/dist-packages/nova/service.py:355 2012-08-10 09:57:34,997 DEBUG nova [-] dmz_cidr : 10.128.0.0/24 from (pid=18708) wait /usr/lib/python2.7/dist-packages/nova/service.py:355 2012-08-10 09:57:34,997 DEBUG nova [-] sql_min_pool_size : 10 from (pid=18708) wait /usr/lib/python2.7/dist-packages/nova/service.py:355 2012-08-10 09:57:34,997 DEBUG nova [-] monkey_patch : False from (pid=18708) wait /usr/lib/python2.7/dist-packages/nova/service.py:355 2012-08-10 09:57:34,997 DEBUG nova [-] rpc_conn_pool_size : 30 from (pid=18708) wait /usr/lib/python2.7/dist-packages/nova/service.py:355 2012-08-10 09:57:34,997 DEBUG nova [-] s3_host : 10.230.5.3 from (pid=18708) wait /usr/lib/python2.7/dist-packages/nova/service.py:355 2012-08-10 09:57:34,997 DEBUG nova [-] input_chain : INPUT from (pid=18708) wait /usr/lib/python2.7/dist-packages/nova/service.py:355 2012-08-10 09:57:34,997 DEBUG nova [-] vlan_interface : None from (pid=18708) wait /usr/lib/python2.7/dist-packages/nova/service.py:355 2012-08-10 09:57:34,997 DEBUG nova [-] linuxnet_ovs_integration_bridge : br-int from (pid=18708) wait /usr/lib/python2.7/dist-packages/nova/service.py:355 2012-08-10 09:57:34,998 DEBUG nova [-] volume_force_update_capabilities : False from (pid=18708) wait /usr/lib/python2.7/dist-packages/nova/service.py:355 2012-08-10 09:57:34,998 DEBUG nova [-] scheduler_topic : scheduler from (pid=18708) wait /usr/lib/python2.7/dist-packages/nova/service.py:355 2012-08-10 09:57:34,998 DEBUG nova [-] verbose : True from (pid=18708) wait /usr/lib/python2.7/dist-packages/nova/service.py:355 2012-08-10 09:57:34,998 DEBUG nova [-] flat_network_bridge : br100 from (pid=18708) wait /usr/lib/python2.7/dist-packages/nova/service.py:355 2012-08-10 09:57:34,998 DEBUG nova [-] sql_max_retries : 12 from (pid=18708) wait /usr/lib/python2.7/dist-packages/nova/service.py:355 2012-08-10 09:57:34,998 DEBUG nova [-] default_instance_type : m1.small from (pid=18708) wait /usr/lib/python2.7/dist-packages/nova/service.py:355 2012-08-10 09:57:34,998 DEBUG nova [-] dhcpbridge_flagfile : /etc/nova/nova.conf from (pid=18708) wait /usr/lib/python2.7/dist-packages/nova/service.py:355 2012-08-10 09:57:34,998 DEBUG nova [-] periodic_interval : 60 from (pid=18708) wait /usr/lib/python2.7/dist-packages/nova/service.py:355 2012-08-10 09:57:34,999 DEBUG nova [-] vpn_key_suffix : -vpn from (pid=18708) wait /usr/lib/python2.7/dist-packages/nova/service.py:355 2012-08-10 09:57:34,999 DEBUG nova [-] null_kernel : nokernel from (pid=18708) wait /usr/lib/python2.7/dist-packages/nova/service.py:355 2012-08-10 09:57:34,999 DEBUG nova [-] helpshort : None from (pid=18708) wait /usr/lib/python2.7/dist-packages/nova/service.py:355 2012-08-10 09:57:34,999 DEBUG nova [-] sql_pool_timeout : 30 from (pid=18708) wait /usr/lib/python2.7/dist-packages/nova/service.py:355 2012-08-10 09:57:34,999 DEBUG nova [-] publish_errors : False from (pid=18708) wait /usr/lib/python2.7/dist-packages/nova/service.py:355 2012-08-10 09:57:34,999 DEBUG nova [-] logging_exception_prefix : (%(name)s): TRACE: from (pid=18708) wait /usr/lib/python2.7/dist-packages/nova/service.py:355 2012-08-10 09:57:34,999 DEBUG nova [-] enabled_apis : ['ec2', 'osapi'] from (pid=18708) wait /usr/lib/python2.7/dist-packages/nova/service.py:355 2012-08-10 09:57:34,999 DEBUG nova [-] report_interval : 10 from (pid=18708) wait /usr/lib/python2.7/dist-packages/nova/service.py:355 2012-08-10 09:57:35,000 DEBUG nova [-] scheduler_manager : nova.scheduler.manager.SchedulerManager from (pid=18708) wait /usr/lib/python2.7/dist-packages/nova/service.py:355 2012-08-10 09:57:35,000 DEBUG nova [-] ec2_port : 8773 from (pid=18708) wait /usr/lib/python2.7/dist-packages/nova/service.py:355 2012-08-10 09:57:35,000 DEBUG nova [-] monkey_patch_modules : ['nova.api.ec2.cloud:nova.notifier.api.notify_decorator', 'nova.compute.api:nova.notifier.api.notify_decorator'] from (pid=18708) wait /usr/lib/python2.7/dist-packages/nova/service.py:355 2012-08-10 09:57:35,000 DEBUG nova [-] rabbit_retry_backoff : 2 from (pid=18708) wait /usr/lib/python2.7/dist-packages/nova/service.py:355 2012-08-10 09:57:35,000 DEBUG nova [-] auth_token_ttl : 3600 from (pid=18708) wait /usr/lib/python2.7/dist-packages/nova/service.py:355 2012-08-10 09:57:35,000 DEBUG nova [-] quota_volumes : 10 from (pid=18708) wait /usr/lib/python2.7/dist-packages/nova/service.py:355 2012-08-10 09:57:35,000 DEBUG nova [-] ec2_listen_port : 8773 from (pid=18708) wait /usr/lib/python2.7/dist-packages/nova/service.py:355 2012-08-10 09:57:35,000 DEBUG nova [-] ec2_scheme : http from (pid=18708) wait /usr/lib/python2.7/dist-packages/nova/service.py:355 2012-08-10 09:57:35,000 DEBUG nova [-] vpn_image_id : 0 from (pid=18708) wait /usr/lib/python2.7/dist-packages/nova/service.py:355 2012-08-10 09:57:35,001 DEBUG nova [-] auto_assign_floating_ip : False from (pid=18708) wait /usr/lib/python2.7/dist-packages/nova/service.py:355 2012-08-10 09:57:35,001 DEBUG nova [-] quota_floating_ips : 10 from (pid=18708) wait /usr/lib/python2.7/dist-packages/nova/service.py:355 2012-08-10 09:57:35,001 DEBUG nova [-] max_vcs_in_vsa : 32 from (pid=18708) wait /usr/lib/python2.7/dist-packages/nova/service.py:355 2012-08-10 09:57:35,001 DEBUG nova [-] fake_call : False from (pid=18708) wait /usr/lib/python2.7/dist-packages/nova/service.py:355 2012-08-10 09:57:35,001 DEBUG nova [-] state_path : /var/lib/nova from (pid=18708) wait /usr/lib/python2.7/dist-packages/nova/service.py:355 2012-08-10 09:57:35,001 DEBUG nova [-] sql_idle_timeout : 3600 from (pid=18708) wait /usr/lib/python2.7/dist-packages/nova/service.py:355 2012-08-10 09:57:35,001 DEBUG nova [-] vpn_ip : 10.230.5.4 from (pid=18708) wait /usr/lib/python2.7/dist-packages/nova/service.py:355 2012-08-10 09:57:35,001 DEBUG nova [-] default_image : ami-11111 from (pid=18708) wait /usr/lib/python2.7/dist-packages/nova/service.py:355 2012-08-10 09:57:35,002 DEBUG nova [-] aws_secret_access_key : admin from (pid=18708) wait /usr/lib/python2.7/dist-packages/nova/service.py:355 2012-08-10 09:57:35,002 DEBUG nova [-] use_ipv6 : False from (pid=18708) wait /usr/lib/python2.7/dist-packages/nova/service.py:355 2012-08-10 09:57:35,002 DEBUG nova [-] osapi_listen : 0.0.0.0 from (pid=18708) wait /usr/lib/python2.7/dist-packages/nova/service.py:355 2012-08-10 09:57:35,002 DEBUG nova [-] fake_network : False from (pid=18708) wait /usr/lib/python2.7/dist-packages/nova/service.py:355 2012-08-10 09:57:35,002 DEBUG nova [-] force_dhcp_release : False from (pid=18708) wait /usr/lib/python2.7/dist-packages/nova/service.py:355 2012-08-10 09:57:35,002 DEBUG nova [-] osapi_extensions_path : /var/lib/nova/extensions from (pid=18708) wait /usr/lib/python2.7/dist-packages/nova/service.py:355 2012-08-10 09:57:35,002 DEBUG nova [-] quota_gigabytes : 1000 from (pid=18708) wait /usr/lib/python2.7/dist-packages/nova/service.py:355 2012-08-10 09:57:35,002 DEBUG nova [-] region_list : [] from (pid=18708) wait /usr/lib/python2.7/dist-packages/nova/service.py:355 2012-08-10 09:57:35,003 DEBUG nova [-] dhcpbridge : /usr/bin/nova-dhcpbridge from (pid=18708) wait /usr/lib/python2.7/dist-packages/nova/service.py:355 2012-08-10 09:57:35,003 DEBUG nova [-] network_manager : nova.network.manager.FlatDHCPManager from (pid=18708) wait /usr/lib/python2.7/dist-packages/nova/service.py:355 2012-08-10 09:57:35,003 DEBUG nova [-] enable_zone_routing : False from (pid=18708) wait /usr/lib/python2.7/dist-packages/nova/service.py:355 2012-08-10 09:57:35,003 DEBUG nova [-] root_helper : sudo from (pid=18708) wait /usr/lib/python2.7/dist-packages/nova/service.py:355 2012-08-10 09:57:35,003 DEBUG nova [-] osapi_host : 10.230.5.4 from (pid=18708) wait /usr/lib/python2.7/dist-packages/nova/service.py:355 2012-08-10 09:57:35,003 DEBUG nova [-] zone_name : nova from (pid=18708) wait /usr/lib/python2.7/dist-packages/nova/service.py:355 2012-08-10 09:57:35,003 DEBUG nova [-] memcached_servers : None from (pid=18708) wait /usr/lib/python2.7/dist-packages/nova/service.py:355 2012-08-10 09:57:35,003 DEBUG nova [-] logging_default_format_string : %(asctime)s %(levelname)s %(name)s [-] %(message)s from (pid=18708) wait /usr/lib/python2.7/dist-packages/nova/service.py:355 2012-08-10 09:57:35,004 DEBUG nova [-] quota_max_injected_file_path_bytes : 255 from (pid=18708) wait /usr/lib/python2.7/dist-packages/nova/service.py:355 2012-08-10 09:57:35,004 DEBUG nova [-] fake_rabbit : False from (pid=18708) wait /usr/lib/python2.7/dist-packages/nova/service.py:355 2012-08-10 09:57:35,004 DEBUG nova [-] rabbit_host : 10.230.5.3 from (pid=18708) wait /usr/lib/python2.7/dist-packages/nova/service.py:355 2012-08-10 09:57:35,004 DEBUG nova [-] use_syslog : False from (pid=18708) wait /usr/lib/python2.7/dist-packages/nova/service.py:355 2012-08-10 09:57:35,004 DEBUG nova [-] gateway_v6 : None from (pid=18708) wait /usr/lib/python2.7/dist-packages/nova/service.py:355 2012-08-10 09:57:35,004 DEBUG nova [-] osapi_path : /v1.1/ from (pid=18708) wait /usr/lib/python2.7/dist-packages/nova/service.py:355 2012-08-10 09:57:35,004 DEBUG nova [-] ec2_path : /services/Cloud from (pid=18708) wait /usr/lib/python2.7/dist-packages/nova/service.py:355 2012-08-10 09:57:35,004 DEBUG nova [-] linuxnet_interface_driver : nova.network.linux_net.LinuxBridgeInterfaceDriver from (pid=18708) wait /usr/lib/python2.7/dist-packages/nova/service.py:355 2012-08-10 09:57:35,005 DEBUG nova [-] rabbit_use_ssl : False from (pid=18708) wait /usr/lib/python2.7/dist-packages/nova/service.py:355 2012-08-10 09:57:35,005 DEBUG nova [-] rabbit_retry_interval : 1 from (pid=18708) wait /usr/lib/python2.7/dist-packages/nova/service.py:355 2012-08-10 09:57:35,005 DEBUG nova [-] quota_security_group_rules : 20 from (pid=18708) wait /usr/lib/python2.7/dist-packages/nova/service.py:355 2012-08-10 09:57:35,005 DEBUG nova [-] node_availability_zone : nova from (pid=18708) wait /usr/lib/python2.7/dist-packages/nova/service.py:355 2012-08-10 09:57:35,005 DEBUG nova [-] db_driver : nova.db.api from (pid=18708) wait /usr/lib/python2.7/dist-packages/nova/service.py:355 2012-08-10 09:57:35,005 DEBUG nova [-] create_unique_mac_address_attempts : 5 from (pid=18708) wait /usr/lib/python2.7/dist-packages/nova/service.py:355 2012-08-10 09:57:35,005 DEBUG nova [-] volume_manager : nova.volume.manager.VolumeManager from (pid=18708) wait /usr/lib/python2.7/dist-packages/nova/service.py:355 2012-08-10 09:57:35,005 DEBUG nova [-] start_guests_on_host_boot : False from (pid=18708) wait /usr/lib/python2.7/dist-packages/nova/service.py:355 2012-08-10 09:57:35,005 DEBUG nova [-] vlan_start : 100 from (pid=18708) wait /usr/lib/python2.7/dist-packages/nova/service.py:355 2012-08-10 09:57:35,006 DEBUG nova [-] rpc_thread_pool_size : 1024 from (pid=18708) wait /usr/lib/python2.7/dist-packages/nova/service.py:355 2012-08-10 09:57:35,006 DEBUG nova [-] ipv6_backend : rfc2462 from (pid=18708) wait /usr/lib/python2.7/dist-packages/nova/service.py:355 2012-08-10 09:57:35,006 DEBUG nova [-] vnc_enabled : True from (pid=18708) wait /usr/lib/python2.7/dist-packages/nova/service.py:355 2012-08-10 09:57:35,006 DEBUG nova [-] api_paste_config : api-paste.ini from (pid=18708) wait /usr/lib/python2.7/dist-packages/nova/service.py:355 2012-08-10 09:57:35,006 DEBUG nova [-] rabbit_virtual_host : / from (pid=18708) wait /usr/lib/python2.7/dist-packages/nova/service.py:355 2012-08-10 09:57:35,006 DEBUG nova [-] network_driver : nova.network.linux_net from (pid=18708) wait /usr/lib/python2.7/dist-packages/nova/service.py:355 2012-08-10 09:57:35,006 DEBUG nova [-] ajax_console_proxy_port : 8000 from (pid=18708) wait /usr/lib/python2.7/dist-packages/nova/service.py:355 2012-08-10 09:57:35,006 DEBUG nova [-] vnc_keymap : en-us from (pid=18708) wait /usr/lib/python2.7/dist-packages/nova/service.py:355 2012-08-10 09:57:35,007 DEBUG nova [-] image_service : nova.image.glance.GlanceImageService from (pid=18708) wait /usr/lib/python2.7/dist-packages/nova/service.py:355 2012-08-10 09:57:35,007 DEBUG nova [-] use_single_default_gateway : False from (pid=18708) wait /usr/lib/python2.7/dist-packages/nova/service.py:355 2012-08-10 09:57:35,007 DEBUG nova [-] control_exchange : nova from (pid=18708) wait /usr/lib/python2.7/dist-packages/nova/service.py:355 2012-08-10 09:57:35,007 DEBUG nova [-] cnt_vpn_clients : 0 from (pid=18708) wait /usr/lib/python2.7/dist-packages/nova/service.py:355 2012-08-10 09:57:35,007 DEBUG nova [-] vsa_part_size_gb : 100 from (pid=18708) wait /usr/lib/python2.7/dist-packages/nova/service.py:355 2012-08-10 09:57:35,007 DEBUG nova [-] vncproxy_topic : vncproxy from (pid=18708) wait /usr/lib/python2.7/dist-packages/nova/service.py:355 2012-08-10 09:57:35,007 DEBUG nova [-] compute_manager : nova.compute.manager.ComputeManager from (pid=18708) wait /usr/lib/python2.7/dist-packages/nova/service.py:355 2012-08-10 09:57:35,007 DEBUG nova [-] network_topic : network from (pid=18708) wait /usr/lib/python2.7/dist-packages/nova/service.py:355 2012-08-10 09:57:35,008 AUDIT nova [-] Starting network node (version 2011.3-nova-milestone-tarball:tarmac-20110922115702-k9nkvxqzhj130av2) 2012-08-10 09:57:35,008 DEBUG nova.utils [-] Attempting to grab semaphore "iptables" for method "apply"... from (pid=18708) inner /usr/lib/python2.7/dist-packages/nova/utils.py:675 2012-08-10 09:57:35,008 DEBUG nova.utils [-] Attempting to grab file lock "iptables" for method "apply"... from (pid=18708) inner /usr/lib/python2.7/dist-packages/nova/utils.py:680 2012-08-10 09:57:35,008 DEBUG nova.utils [-] Running cmd (subprocess): sudo iptables-save -t filter from (pid=18708) execute /usr/lib/python2.7/dist-packages/nova/utils.py:168 2012-08-10 09:57:35,022 DEBUG nova.utils [-] Running cmd (subprocess): sudo iptables-restore from (pid=18708) execute /usr/lib/python2.7/dist-packages/nova/utils.py:168 2012-08-10 09:57:35,046 DEBUG nova.utils [-] Running cmd (subprocess): sudo iptables-save -t nat from (pid=18708) execute /usr/lib/python2.7/dist-packages/nova/utils.py:168 2012-08-10 09:57:35,070 DEBUG nova.utils [-] Running cmd (subprocess): sudo iptables-restore from (pid=18708) execute /usr/lib/python2.7/dist-packages/nova/utils.py:168 2012-08-10 09:57:35,096 DEBUG nova.utils [-] Running cmd (subprocess): sudo ip addr add 169.254.169.254/32 scope link dev lo from (pid=18708) execute /usr/lib/python2.7/dist-packages/nova/utils.py:168 2012-08-10 09:57:35,118 DEBUG nova.utils [-] Result was 254 from (pid=18708) execute /usr/lib/python2.7/dist-packages/nova/utils.py:183 2012-08-10 09:57:35,218 DEBUG nova.utils [-] backend from (pid=18708) __get_backend /usr/lib/python2.7/dist-packages/nova/utils.py:450 2012-08-10 09:57:35,219 INFO nova.db.sqlalchemy [-] Using mysql/eventlet db_pool. 2012-08-10 09:57:35,326 DEBUG nova.utils [-] Attempting to grab semaphore "get_dhcp" for method "_get_dhcp_ip"... from (pid=18708) inner /usr/lib/python2.7/dist-packages/nova/utils.py:675 2012-08-10 09:57:35,326 DEBUG nova.utils [-] Attempting to grab semaphore "ensure_bridge" for method "ensure_bridge"... from (pid=18708) inner /usr/lib/python2.7/dist-packages/nova/utils.py:675 2012-08-10 09:57:35,326 DEBUG nova.utils [-] Attempting to grab file lock "ensure_bridge" for method "ensure_bridge"... from (pid=18708) inner /usr/lib/python2.7/dist-packages/nova/utils.py:680 2012-08-10 09:57:35,327 DEBUG nova.utils [-] Running cmd (subprocess): ip link show dev br100 from (pid=18708) execute /usr/lib/python2.7/dist-packages/nova/utils.py:168 2012-08-10 09:57:35,332 DEBUG nova.utils [-] Running cmd (subprocess): sudo brctl addif br100 eth1 from (pid=18708) execute /usr/lib/python2.7/dist-packages/nova/utils.py:168 2012-08-10 09:57:35,341 DEBUG nova.utils [-] Result was 1 from (pid=18708) execute /usr/lib/python2.7/dist-packages/nova/utils.py:183 2012-08-10 09:57:35,341 DEBUG nova.utils [-] Running cmd (subprocess): sudo route -n from (pid=18708) execute /usr/lib/python2.7/dist-packages/nova/utils.py:168 2012-08-10 09:57:35,351 DEBUG nova.utils [-] Running cmd (subprocess): sudo ip addr show dev eth1 scope global from (pid=18708) execute /usr/lib/python2.7/dist-packages/nova/utils.py:168 2012-08-10 09:57:35,361 DEBUG nova.utils [-] Running cmd (subprocess): sudo ip addr show dev br100 scope global from (pid=18708) execute /usr/lib/python2.7/dist-packages/nova/utils.py:168 2012-08-10 09:57:35,370 DEBUG nova.utils [-] Attempting to grab semaphore "dnsmasq_start" for method "update_dhcp"... from (pid=18708) inner /usr/lib/python2.7/dist-packages/nova/utils.py:675 2012-08-10 09:57:35,389 DEBUG nova.utils [-] Running cmd (subprocess): cat /proc/1447/cmdline from (pid=18708) execute /usr/lib/python2.7/dist-packages/nova/utils.py:168 2012-08-10 09:57:35,395 DEBUG nova.utils [-] Running cmd (subprocess): sudo kill -HUP 1447 from (pid=18708) execute /usr/lib/python2.7/dist-packages/nova/utils.py:168 2012-08-10 09:57:35,473 DEBUG nova.utils [-] Attempting to grab semaphore "iptables" for method "apply"... from (pid=18708) inner /usr/lib/python2.7/dist-packages/nova/utils.py:675 2012-08-10 09:57:35,473 DEBUG nova.utils [-] Attempting to grab file lock "iptables" for method "apply"... from (pid=18708) inner /usr/lib/python2.7/dist-packages/nova/utils.py:680 2012-08-10 09:57:35,474 DEBUG nova.utils [-] Running cmd (subprocess): sudo iptables-save -t filter from (pid=18708) execute /usr/lib/python2.7/dist-packages/nova/utils.py:168 2012-08-10 09:57:35,487 DEBUG nova.utils [-] Running cmd (subprocess): sudo iptables-restore from (pid=18708) execute /usr/lib/python2.7/dist-packages/nova/utils.py:168 2012-08-10 09:57:35,502 DEBUG nova.utils [-] Running cmd (subprocess): sudo iptables-save -t nat from (pid=18708) execute /usr/lib/python2.7/dist-packages/nova/utils.py:168 2012-08-10 09:57:35,517 DEBUG nova.utils [-] Running cmd (subprocess): sudo iptables-restore from (pid=18708) execute /usr/lib/python2.7/dist-packages/nova/utils.py:168 2012-08-10 09:57:35,584 INFO nova.rpc [-] Connected to AMQP server on 10.230.5.3:5672 2012-08-10 09:57:35,585 DEBUG nova [-] Creating Consumer connection for Service network from (pid=18708) start /usr/lib/python2.7/dist-packages/nova/service.py:153 2012-08-10 10:00:18,590 DEBUG nova.rpc [-] received {u'_context_roles': [u'projectmanager'], u'_msg_id': u'f92bb5cfb3cf4020bb89f38ac6f561ce', u'_context_read_deleted': False, u'_context_request_id': u'6dc1ac71-e949-474d-a7fc-a876de1d1f25', u'args': {u'instance_id': 40, u'network_id': 5, u'vpn': False, u'address': None}, u'_context_auth_token': None, u'_context_strategy': u'noauth', u'_context_is_admin': True, u'_context_project_id': u'proj', u'_context_timestamp': u'2012-08-10T09:00:18.281696', u'_context_user_id': u'novaadmin', u'method': u'_rpc_allocate_fixed_ip', u'_context_remote_address': u'10.230.5.4'} from (pid=18708) __call__ /usr/lib/python2.7/dist-packages/nova/rpc/impl_kombu.py:600 2012-08-10 10:00:18,590 DEBUG nova.rpc [-] unpacked context: {'user_id': u'novaadmin', 'roles': [u'projectmanager'], 'timestamp': u'2012-08-10T09:00:18.281696', 'auth_token': None, 'msg_id': u'f92bb5cfb3cf4020bb89f38ac6f561ce', 'remote_address': u'10.230.5.4', 'strategy': u'noauth', 'is_admin': True, 'request_id': u'6dc1ac71-e949-474d-a7fc-a876de1d1f25', 'project_id': u'proj', 'read_deleted': False} from (pid=18708) _unpack_context /usr/lib/python2.7/dist-packages/nova/rpc/impl_kombu.py:646 2012-08-10 10:00:18,841 DEBUG nova.utils [-] Attempting to grab semaphore "get_dhcp" for method "_get_dhcp_ip"... from (pid=18708) inner /usr/lib/python2.7/dist-packages/nova/utils.py:675 2012-08-10 10:00:18,842 DEBUG nova.utils [-] Attempting to grab semaphore "ensure_bridge" for method "ensure_bridge"... from (pid=18708) inner /usr/lib/python2.7/dist-packages/nova/utils.py:675 2012-08-10 10:00:18,842 DEBUG nova.utils [-] Attempting to grab file lock "ensure_bridge" for method "ensure_bridge"... from (pid=18708) inner /usr/lib/python2.7/dist-packages/nova/utils.py:680 2012-08-10 10:00:18,842 DEBUG nova.utils [-] Running cmd (subprocess): ip link show dev br100 from (pid=18708) execute /usr/lib/python2.7/dist-packages/nova/utils.py:168 2012-08-10 10:00:18,851 DEBUG nova.utils [-] Running cmd (subprocess): sudo brctl addif br100 eth1 from (pid=18708) execute /usr/lib/python2.7/dist-packages/nova/utils.py:168 2012-08-10 10:00:18,866 DEBUG nova.utils [-] Result was 1 from (pid=18708) execute /usr/lib/python2.7/dist-packages/nova/utils.py:183 2012-08-10 10:00:18,867 DEBUG nova.utils [-] Running cmd (subprocess): sudo route -n from (pid=18708) execute /usr/lib/python2.7/dist-packages/nova/utils.py:168 2012-08-10 10:00:18,883 DEBUG nova.utils [-] Running cmd (subprocess): sudo ip addr show dev eth1 scope global from (pid=18708) execute /usr/lib/python2.7/dist-packages/nova/utils.py:168 2012-08-10 10:00:18,898 DEBUG nova.utils [-] Running cmd (subprocess): sudo ip addr show dev br100 scope global from (pid=18708) execute /usr/lib/python2.7/dist-packages/nova/utils.py:168 2012-08-10 10:00:18,914 DEBUG nova.utils [-] Attempting to grab semaphore "dnsmasq_start" for method "update_dhcp"... from (pid=18708) inner /usr/lib/python2.7/dist-packages/nova/utils.py:675 2012-08-10 10:00:18,938 DEBUG nova.utils [-] Running cmd (subprocess): cat /proc/1447/cmdline from (pid=18708) execute /usr/lib/python2.7/dist-packages/nova/utils.py:168 2012-08-10 10:00:18,946 DEBUG nova.utils [-] Running cmd (subprocess): sudo kill -HUP 1447 from (pid=18708) execute /usr/lib/python2.7/dist-packages/nova/utils.py:168 2012-08-10 10:00:18,962 DEBUG nova.rpc [-] Pool creating new connection from (pid=18708) create /usr/lib/python2.7/dist-packages/nova/rpc/impl_kombu.py:504 2012-08-10 10:00:18,965 INFO nova.rpc [-] Connected to AMQP server on 10.230.5.3:5672 2012-08-10 10:00:46,877 DEBUG nova.rpc [-] received {u'_context_roles': [], u'_context_request_id': u'aa6ef96c-f16f-4f1a-b708-2daf7a545f8f', u'_context_read_deleted': False, u'args': {u'address': u'10.0.0.5'}, u'_context_auth_token': None, u'_context_strategy': u'noauth', u'_context_is_admin': True, u'_context_project_id': None, u'_context_timestamp': u'2012-08-10T09:00:46.839325', u'_context_user_id': None, u'method': u'lease_fixed_ip', u'_context_remote_address': None} from (pid=18708) __call__ /usr/lib/python2.7/dist-packages/nova/rpc/impl_kombu.py:600 2012-08-10 10:00:46,877 DEBUG nova.rpc [-] unpacked context: {'user_id': None, 'roles': [], 'timestamp': u'2012-08-10T09:00:46.839325', 'auth_token': None, 'msg_id': None, 'remote_address': None, 'strategy': u'noauth', 'is_admin': True, 'request_id': u'aa6ef96c-f16f-4f1a-b708-2daf7a545f8f', 'project_id': None, 'read_deleted': False} from (pid=18708) _unpack_context /usr/lib/python2.7/dist-packages/nova/rpc/impl_kombu.py:646 2012-08-10 10:00:46,878 DEBUG nova.network.manager [aa6ef96c-f16f-4f1a-b708-2daf7a545f8f None None] Leased IP |10.0.0.5| from (pid=18708) lease_fixed_ip /usr/lib/python2.7/dist-packages/nova/network/manager.py:645 2012-08-10 10:01:40,545 DEBUG nova.rpc [-] received {u'_context_roles': [], u'_context_request_id': u'60c7b8aa-657a-4f33-a7e1-53336b408610', u'_context_read_deleted': False, u'args': {u'address': u'10.0.0.5'}, u'_context_auth_token': None, u'_context_strategy': u'noauth', u'_context_is_admin': True, u'_context_project_id': None, u'_context_timestamp': u'2012-08-10T09:01:40.508036', u'_context_user_id': None, u'method': u'lease_fixed_ip', u'_context_remote_address': None} from (pid=18708) __call__ /usr/lib/python2.7/dist-packages/nova/rpc/impl_kombu.py:600 2012-08-10 10:01:40,545 DEBUG nova.rpc [-] unpacked context: {'user_id': None, 'roles': [], 'timestamp': u'2012-08-10T09:01:40.508036', 'auth_token': None, 'msg_id': None, 'remote_address': None, 'strategy': u'noauth', 'is_admin': True, 'request_id': u'60c7b8aa-657a-4f33-a7e1-53336b408610', 'project_id': None, 'read_deleted': False} from (pid=18708) _unpack_context /usr/lib/python2.7/dist-packages/nova/rpc/impl_kombu.py:646 2012-08-10 10:01:40,546 DEBUG nova.network.manager [60c7b8aa-657a-4f33-a7e1-53336b408610 None None] Leased IP |10.0.0.5| from (pid=18708) lease_fixed_ip /usr/lib/python2.7/dist-packages/nova/network/manager.py:645 2012-08-10 10:02:29,971 DEBUG nova.rpc [-] received {u'_context_roles': [], u'_context_request_id': u'd2bf58f1-b73f-4039-b76d-093ccf4d3e14', u'_context_read_deleted': False, u'args': {u'address': u'10.0.0.5'}, u'_context_auth_token': None, u'_context_strategy': u'noauth', u'_context_is_admin': True, u'_context_project_id': None, u'_context_timestamp': u'2012-08-10T09:02:29.933430', u'_context_user_id': None, u'method': u'lease_fixed_ip', u'_context_remote_address': None} from (pid=18708) __call__ /usr/lib/python2.7/dist-packages/nova/rpc/impl_kombu.py:600 2012-08-10 10:02:29,971 DEBUG nova.rpc [-] unpacked context: {'user_id': None, 'roles': [], 'timestamp': u'2012-08-10T09:02:29.933430', 'auth_token': None, 'msg_id': None, 'remote_address': None, 'strategy': u'noauth', 'is_admin': True, 'request_id': u'd2bf58f1-b73f-4039-b76d-093ccf4d3e14', 'project_id': None, 'read_deleted': False} from (pid=18708) _unpack_context /usr/lib/python2.7/dist-packages/nova/rpc/impl_kombu.py:646 2012-08-10 10:02:29,972 DEBUG nova.network.manager [d2bf58f1-b73f-4039-b76d-093ccf4d3e14 None None] Leased IP |10.0.0.5| from (pid=18708) lease_fixed_ip /usr/lib/python2.7/dist-packages/nova/network/manager.py:645 ### start of test ### 2012-08-10 10:03:22,974 DEBUG nova.rpc [-] received {u'_context_roles': [], u'_context_request_id': u'c096b5be-7921-49c8-83da-eb8da4a48319', u'_context_read_deleted': False, u'args': {u'address': u'10.0.0.5'}, u'_context_auth_token': None, u'_context_strategy': u'noauth', u'_context_is_admin': True, u'_context_project_id': None, u'_context_timestamp': u'2012-08-10T09:03:22.937217', u'_context_user_id': None, u'method': u'lease_fixed_ip', u'_context_remote_address': None} from (pid=18708) __call__ /usr/lib/python2.7/dist-packages/nova/rpc/impl_kombu.py:600 2012-08-10 10:03:22,974 DEBUG nova.rpc [-] unpacked context: {'user_id': None, 'roles': [], 'timestamp': u'2012-08-10T09:03:22.937217', 'auth_token': None, 'msg_id': None, 'remote_address': None, 'strategy': u'noauth', 'is_admin': True, 'request_id': u'c096b5be-7921-49c8-83da-eb8da4a48319', 'project_id': None, 'read_deleted': False} from (pid=18708) _unpack_context /usr/lib/python2.7/dist-packages/nova/rpc/impl_kombu.py:646 2012-08-10 10:03:22,975 DEBUG nova.network.manager [c096b5be-7921-49c8-83da-eb8da4a48319 None None] Leased IP |10.0.0.5| from (pid=18708) lease_fixed_ip /usr/lib/python2.7/dist-packages/nova/network/manager.py:645 2012-08-10 10:03:31,259 DEBUG nova.rpc [-] received {u'_context_roles': [], u'_context_request_id': u'c1075972-42d3-4a0e-b37e-b615b8d06b4a', u'_context_read_deleted': False, u'args': {u'address': u'10.0.0.5'}, u'_context_auth_token': None, u'_context_strategy': u'noauth', u'_context_is_admin': True, u'_context_project_id': None, u'_context_timestamp': u'2012-08-10T09:03:31.213892', u'_context_user_id': None, u'method': u'release_fixed_ip', u'_context_remote_address': None} from (pid=18708) __call__ /usr/lib/python2.7/dist-packages/nova/rpc/impl_kombu.py:600 2012-08-10 10:03:31,260 DEBUG nova.rpc [-] unpacked context: {'user_id': None, 'roles': [], 'timestamp': u'2012-08-10T09:03:31.213892', 'auth_token': None, 'msg_id': None, 'remote_address': None, 'strategy': u'noauth', 'is_admin': True, 'request_id': u'c1075972-42d3-4a0e-b37e-b615b8d06b4a', 'project_id': None, 'read_deleted': False} from (pid=18708) _unpack_context /usr/lib/python2.7/dist-packages/nova/rpc/impl_kombu.py:646 2012-08-10 10:03:31,260 DEBUG nova.network.manager [c1075972-42d3-4a0e-b37e-b615b8d06b4a None None] Released IP |10.0.0.5| from (pid=18708) release_fixed_ip /usr/lib/python2.7/dist-packages/nova/network/manager.py:662 2012-08-10 10:03:41,483 DEBUG nova.rpc [-] received {u'_context_roles': [], u'_context_request_id': u'db6c5489-a893-4326-b4e9-e116bd681c84', u'_context_read_deleted': False, u'args': {u'address': u'10.0.0.5'}, u'_context_auth_token': None, u'_context_strategy': u'noauth', u'_context_is_admin': True, u'_context_project_id': None, u'_context_timestamp': u'2012-08-10T09:03:41.445913', u'_context_user_id': None, u'method': u'lease_fixed_ip', u'_context_remote_address': None} from (pid=18708) __call__ /usr/lib/python2.7/dist-packages/nova/rpc/impl_kombu.py:600 2012-08-10 10:03:41,483 DEBUG nova.rpc [-] unpacked context: {'user_id': None, 'roles': [], 'timestamp': u'2012-08-10T09:03:41.445913', 'auth_token': None, 'msg_id': None, 'remote_address': None, 'strategy': u'noauth', 'is_admin': True, 'request_id': u'db6c5489-a893-4326-b4e9-e116bd681c84', 'project_id': None, 'read_deleted': False} from (pid=18708) _unpack_context /usr/lib/python2.7/dist-packages/nova/rpc/impl_kombu.py:646 2012-08-10 10:03:41,484 DEBUG nova.network.manager [db6c5489-a893-4326-b4e9-e116bd681c84 None None] Leased IP |10.0.0.5| from (pid=18708) lease_fixed_ip /usr/lib/python2.7/dist-packages/nova/network/manager.py:645 2012-08-10 10:03:44,133 DEBUG nova.rpc [-] received {u'_context_roles': [u'projectmanager'], u'_msg_id': u'7ebede1addb448168ab97a5979fc0667', u'_context_read_deleted': False, u'_context_request_id': u'2b44889d-b941-43d9-bddb-de0492e34c75', u'args': {u'instance_id': 40, u'host': u'ch01b04', u'instance_type_id': 2}, u'_context_auth_token': None, u'_context_strategy': u'noauth', u'_context_is_admin': True, u'_context_project_id': u'proj', u'_context_timestamp': u'2012-08-10T09:03:44.191568', u'_context_user_id': u'novaadmin', u'method': u'get_instance_nw_info', u'_context_remote_address': u'10.230.5.4'} from (pid=18708) __call__ /usr/lib/python2.7/dist-packages/nova/rpc/impl_kombu.py:600 2012-08-10 10:03:44,134 DEBUG nova.rpc [-] unpacked context: {'user_id': u'novaadmin', 'roles': [u'projectmanager'], 'timestamp': u'2012-08-10T09:03:44.191568', 'auth_token': None, 'msg_id': u'7ebede1addb448168ab97a5979fc0667', 'remote_address': u'10.230.5.4', 'strategy': u'noauth', 'is_admin': True, 'request_id': u'2b44889d-b941-43d9-bddb-de0492e34c75', 'project_id': u'proj', 'read_deleted': False} from (pid=18708) _unpack_context /usr/lib/python2.7/dist-packages/nova/rpc/impl_kombu.py:646 2012-08-10 10:03:44,215 DEBUG nova.utils [-] Attempting to grab semaphore "get_dhcp" for method "_get_dhcp_ip"... from (pid=18708) inner /usr/lib/python2.7/dist-packages/nova/utils.py:675 2012-08-10 10:05:51,480 DEBUG nova.rpc [-] received {u'_context_roles': [], u'_context_request_id': u'67a75b71-4470-4ee9-b7d3-e4ec8f762eef', u'_context_read_deleted': False, u'args': {u'address': u'10.0.0.5'}, u'_context_auth_token': None, u'_context_strategy': u'noauth', u'_context_is_admin': True, u'_context_project_id': None, u'_context_timestamp': u'2012-08-10T09:05:51.443521', u'_context_user_id': None, u'method': u'release_fixed_ip', u'_context_remote_address': None} from (pid=18708) __call__ /usr/lib/python2.7/dist-packages/nova/rpc/impl_kombu.py:600 2012-08-10 10:05:51,481 DEBUG nova.rpc [-] unpacked context: {'user_id': None, 'roles': [], 'timestamp': u'2012-08-10T09:05:51.443521', 'auth_token': None, 'msg_id': None, 'remote_address': None, 'strategy': u'noauth', 'is_admin': True, 'request_id': u'67a75b71-4470-4ee9-b7d3-e4ec8f762eef', 'project_id': None, 'read_deleted': False} from (pid=18708) _unpack_context /usr/lib/python2.7/dist-packages/nova/rpc/impl_kombu.py:646 2012-08-10 10:05:51,481 DEBUG nova.network.manager [67a75b71-4470-4ee9-b7d3-e4ec8f762eef None None] Released IP |10.0.0.5| from (pid=18708) release_fixed_ip /usr/lib/python2.7/dist-packages/nova/network/manager.py:662