Attachment 918453 Details for Bug 1120275 – compute log

compute log

compute.log (text/x-log), 232.10 KB, created by Ido Ovadia on 2014-07-16 15:30:09 UTC

(hide)

Description:

Filename:

MIME Type:

Creator: Ido Ovadia

Created: 2014-07-16 15:30:09 UTC

Size: 232.10 KB

patch

obsolete

>2014-07-15 15:08:30.367 18350 DEBUG nova.servicegroup.api [-] ServiceGroup driver defined as an instance of db __new__ /usr/lib/python2.6/site-packages/nova/servicegroup/api.py:65
>2014-07-15 15:08:30.497 18350 INFO nova.openstack.common.periodic_task [-] Skipping periodic task _periodic_update_dns because its interval is negative
>2014-07-15 15:08:30.607 18350 DEBUG stevedore.extension [-] found extension EntryPoint.parse('file = nova.image.download.file') _load_plugins /usr/lib/python2.6/site-packages/stevedore/extension.py:156
>2014-07-15 15:08:30.623 18350 DEBUG stevedore.extension [-] found extension EntryPoint.parse('file = nova.image.download.file') _load_plugins /usr/lib/python2.6/site-packages/stevedore/extension.py:156
>2014-07-15 15:08:30.626 18350 INFO nova.virt.driver [-] Loading compute driver 'nova.virt.libvirt.LibvirtDriver'
>2014-07-15 15:08:31.671 18350 INFO oslo.messaging._drivers.impl_rabbit [-] Connected to AMQP server on 10.35.64.150:5672
>2014-07-15 15:08:31.686 18350 INFO oslo.messaging._drivers.impl_rabbit [-] Connected to AMQP server on 10.35.64.150:5672
>2014-07-15 15:08:31.696 18350 DEBUG nova.openstack.common.service [-] Full set of CONF: _wait_for_exit_or_signal /usr/lib/python2.6/site-packages/nova/openstack/common/service.py:167
>2014-07-15 15:08:31.696 18350 DEBUG nova.openstack.common.service [-] ******************************************************************************** log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1932
>2014-07-15 15:08:31.696 18350 DEBUG nova.openstack.common.service [-] Configuration options gathered from: log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1933
>2014-07-15 15:08:31.697 18350 DEBUG nova.openstack.common.service [-] command line args: ['--logfile', '/var/log/nova/compute.log'] log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1934
>2014-07-15 15:08:31.697 18350 DEBUG nova.openstack.common.service [-] config files: ['/usr/share/nova/nova-dist.conf', '/etc/nova/nova.conf'] log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1935
>2014-07-15 15:08:31.697 18350 DEBUG nova.openstack.common.service [-] ================================================================================ log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1936
>2014-07-15 15:08:31.697 18350 DEBUG nova.openstack.common.service [-] allow_instance_snapshots       = True log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.698 18350 DEBUG nova.openstack.common.service [-] allow_migrate_to_same_host     = False log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.698 18350 DEBUG nova.openstack.common.service [-] allow_resize_to_same_host      = False log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.698 18350 DEBUG nova.openstack.common.service [-] allow_same_net_traffic         = True log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.698 18350 DEBUG nova.openstack.common.service [-] allowed_direct_url_schemes     = [] log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.698 18350 DEBUG nova.openstack.common.service [-] amqp_auto_delete               = False log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.699 18350 DEBUG nova.openstack.common.service [-] amqp_durable_queues            = False log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.699 18350 DEBUG nova.openstack.common.service [-] api_paste_config               = api-paste.ini log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.699 18350 DEBUG nova.openstack.common.service [-] api_rate_limit                 = False log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.699 18350 DEBUG nova.openstack.common.service [-] auth_strategy                  = keystone log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.700 18350 DEBUG nova.openstack.common.service [-] auto_assign_floating_ip        = False log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.700 18350 DEBUG nova.openstack.common.service [-] backdoor_port                  = None log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.700 18350 DEBUG nova.openstack.common.service [-] bandwidth_poll_interval        = 600 log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.700 18350 DEBUG nova.openstack.common.service [-] bindir                         = /usr/local/bin log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.701 18350 DEBUG nova.openstack.common.service [-] boot_script_template           = /usr/lib/python2.6/site-packages/nova/cloudpipe/bootscript.template log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.701 18350 DEBUG nova.openstack.common.service [-] ca_file                        = cacert.pem log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.701 18350 DEBUG nova.openstack.common.service [-] ca_path                        = /var/lib/nova/CA log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.701 18350 DEBUG nova.openstack.common.service [-] cert_manager                   = nova.cert.manager.CertManager log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.702 18350 DEBUG nova.openstack.common.service [-] cinder_api_insecure            = False log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.702 18350 DEBUG nova.openstack.common.service [-] cinder_ca_certificates_file    = None log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.702 18350 DEBUG nova.openstack.common.service [-] cinder_catalog_info            = volume:cinder:publicURL log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.702 18350 DEBUG nova.openstack.common.service [-] cinder_cross_az_attach         = True log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.702 18350 DEBUG nova.openstack.common.service [-] cinder_endpoint_template       = None log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.703 18350 DEBUG nova.openstack.common.service [-] cinder_http_retries            = 3 log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.703 18350 DEBUG nova.openstack.common.service [-] cnt_vpn_clients                = 0 log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.703 18350 DEBUG nova.openstack.common.service [-] compute_available_monitors     = ['nova.compute.monitors.all_monitors'] log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.703 18350 DEBUG nova.openstack.common.service [-] compute_driver                 = nova.virt.libvirt.LibvirtDriver log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.704 18350 DEBUG nova.openstack.common.service [-] compute_manager                = nova.compute.manager.ComputeManager log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.704 18350 DEBUG nova.openstack.common.service [-] compute_monitors               = [] log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.704 18350 DEBUG nova.openstack.common.service [-] compute_stats_class            = nova.compute.stats.Stats log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.704 18350 DEBUG nova.openstack.common.service [-] compute_topic                  = compute log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.704 18350 DEBUG nova.openstack.common.service [-] config_dir                     = None log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.705 18350 DEBUG nova.openstack.common.service [-] config_drive_format            = iso9660 log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.705 18350 DEBUG nova.openstack.common.service [-] config_drive_skip_versions     = 1.0 2007-01-19 2007-03-01 2007-08-29 2007-10-10 2007-12-15 2008-02-01 2008-09-01 log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.705 18350 DEBUG nova.openstack.common.service [-] config_drive_tempdir           = None log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.705 18350 DEBUG nova.openstack.common.service [-] config_file                    = ['/usr/share/nova/nova-dist.conf', '/etc/nova/nova.conf'] log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.706 18350 DEBUG nova.openstack.common.service [-] console_host                   = cougar11.scl.lab.tlv.redhat.com log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.706 18350 DEBUG nova.openstack.common.service [-] console_manager                = nova.console.manager.ConsoleProxyManager log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.706 18350 DEBUG nova.openstack.common.service [-] console_topic                  = console log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.706 18350 DEBUG nova.openstack.common.service [-] consoleauth_manager            = nova.consoleauth.manager.ConsoleAuthManager log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.707 18350 DEBUG nova.openstack.common.service [-] consoleauth_topic              = consoleauth log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.707 18350 DEBUG nova.openstack.common.service [-] control_exchange               = nova log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.707 18350 DEBUG nova.openstack.common.service [-] create_unique_mac_address_attempts = 5 log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.707 18350 DEBUG nova.openstack.common.service [-] crl_file                       = crl.pem log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.707 18350 DEBUG nova.openstack.common.service [-] db_driver                      = nova.db log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.708 18350 DEBUG nova.openstack.common.service [-] debug                          = True log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.708 18350 DEBUG nova.openstack.common.service [-] default_access_ip_network_name = None log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.708 18350 DEBUG nova.openstack.common.service [-] default_availability_zone      = nova log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.708 18350 DEBUG nova.openstack.common.service [-] default_ephemeral_format       = None log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.709 18350 DEBUG nova.openstack.common.service [-] default_flavor                 = m1.small log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.709 18350 DEBUG nova.openstack.common.service [-] default_floating_pool          = nova log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.709 18350 DEBUG nova.openstack.common.service [-] default_log_levels             = ['amqp=WARN', 'amqplib=WARN', 'boto=WARN', 'qpid=WARN', 'sqlalchemy=WARN', 'suds=INFO', 'oslo.messaging=INFO', 'iso8601=WARN'] log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.709 18350 DEBUG nova.openstack.common.service [-] default_notification_level     = INFO log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.710 18350 DEBUG nova.openstack.common.service [-] default_publisher_id           = None log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.710 18350 DEBUG nova.openstack.common.service [-] default_schedule_zone          = None log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.710 18350 DEBUG nova.openstack.common.service [-] defer_iptables_apply           = False log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.710 18350 DEBUG nova.openstack.common.service [-] dhcp_domain                    = novalocal log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.710 18350 DEBUG nova.openstack.common.service [-] dhcp_lease_time                = 120 log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.711 18350 DEBUG nova.openstack.common.service [-] dhcpbridge                     = /usr/bin/nova-dhcpbridge log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.711 18350 DEBUG nova.openstack.common.service [-] dhcpbridge_flagfile            = ['/usr/share/nova/nova-dist.conf', '/etc/nova/nova.conf'] log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.711 18350 DEBUG nova.openstack.common.service [-] disable_process_locking        = False log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.711 18350 DEBUG nova.openstack.common.service [-] dmz_cidr                       = [] log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.712 18350 DEBUG nova.openstack.common.service [-] dmz_mask                       = 255.255.255.0 log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.712 18350 DEBUG nova.openstack.common.service [-] dmz_net                        = 10.0.0.0 log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.712 18350 DEBUG nova.openstack.common.service [-] dns_server                     = [] log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.712 18350 DEBUG nova.openstack.common.service [-] dns_update_periodic_interval   = -1 log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.712 18350 DEBUG nova.openstack.common.service [-] dnsmasq_config_file            =  log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.713 18350 DEBUG nova.openstack.common.service [-] ec2_listen                     = 0.0.0.0 log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.713 18350 DEBUG nova.openstack.common.service [-] ec2_listen_port                = 8773 log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.713 18350 DEBUG nova.openstack.common.service [-] ec2_private_dns_show_ip        = False log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.713 18350 DEBUG nova.openstack.common.service [-] ec2_strict_validation          = True log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.714 18350 DEBUG nova.openstack.common.service [-] ec2_timestamp_expiry           = 300 log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.714 18350 DEBUG nova.openstack.common.service [-] ec2_workers                    = None log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.714 18350 DEBUG nova.openstack.common.service [-] enable_instance_password       = True log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.714 18350 DEBUG nova.openstack.common.service [-] enable_new_services            = True log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.715 18350 DEBUG nova.openstack.common.service [-] enabled_apis                   = ['ec2', 'osapi_compute', 'metadata'] log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.715 18350 DEBUG nova.openstack.common.service [-] enabled_ssl_apis               = [] log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.715 18350 DEBUG nova.openstack.common.service [-] fake_call                      = False log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.715 18350 DEBUG nova.openstack.common.service [-] fake_network                   = False log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.715 18350 DEBUG nova.openstack.common.service [-] fake_rabbit                    = False log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.716 18350 DEBUG nova.openstack.common.service [-] fatal_deprecations             = False log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.716 18350 DEBUG nova.openstack.common.service [-] fatal_exception_format_errors  = False log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.716 18350 DEBUG nova.openstack.common.service [-] firewall_driver                = nova.virt.firewall.NoopFirewallDriver log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.716 18350 DEBUG nova.openstack.common.service [-] fixed_ip_disassociate_timeout  = 600 log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.717 18350 DEBUG nova.openstack.common.service [-] fixed_range_v6                 = fd00::/48 log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.717 18350 DEBUG nova.openstack.common.service [-] flat_injected                  = False log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.717 18350 DEBUG nova.openstack.common.service [-] flat_interface                 = None log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.717 18350 DEBUG nova.openstack.common.service [-] flat_network_bridge            = None log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.717 18350 DEBUG nova.openstack.common.service [-] flat_network_dns               = 8.8.4.4 log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.718 18350 DEBUG nova.openstack.common.service [-] floating_ip_dns_manager        = nova.network.noop_dns_driver.NoopDNSDriver log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.718 18350 DEBUG nova.openstack.common.service [-] force_config_drive             = None log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.718 18350 DEBUG nova.openstack.common.service [-] force_dhcp_release             = True log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.718 18350 DEBUG nova.openstack.common.service [-] force_raw_images               = True log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.719 18350 DEBUG nova.openstack.common.service [-] force_snat_range               = [] log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.719 18350 DEBUG nova.openstack.common.service [-] forward_bridge_interface       = ['all'] log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.719 18350 DEBUG nova.openstack.common.service [-] gateway                        = None log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.719 18350 DEBUG nova.openstack.common.service [-] gateway_v6                     = None log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.719 18350 DEBUG nova.openstack.common.service [-] glance_api_insecure            = False log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.720 18350 DEBUG nova.openstack.common.service [-] glance_api_servers             = ['10.35.64.150:9292'] log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.720 18350 DEBUG nova.openstack.common.service [-] glance_host                    = 10.35.160.111 log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.720 18350 DEBUG nova.openstack.common.service [-] glance_num_retries             = 0 log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.720 18350 DEBUG nova.openstack.common.service [-] glance_port                    = 9292 log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.721 18350 DEBUG nova.openstack.common.service [-] glance_protocol                = http log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.721 18350 DEBUG nova.openstack.common.service [-] heal_instance_info_cache_interval = 60 log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.721 18350 DEBUG nova.openstack.common.service [-] host                           = cougar11.scl.lab.tlv.redhat.com log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.721 18350 DEBUG nova.openstack.common.service [-] image_cache_manager_interval   = 2400 log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.722 18350 DEBUG nova.openstack.common.service [-] image_cache_subdirectory_name  = _base log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.722 18350 DEBUG nova.openstack.common.service [-] injected_network_template      = /usr/share/nova/interfaces.template log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.722 18350 DEBUG nova.openstack.common.service [-] instance_build_timeout         = 0 log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.722 18350 DEBUG nova.openstack.common.service [-] instance_delete_interval       = 300 log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.722 18350 DEBUG nova.openstack.common.service [-] instance_dns_domain            =  log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.723 18350 DEBUG nova.openstack.common.service [-] instance_dns_manager           = nova.network.noop_dns_driver.NoopDNSDriver log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.723 18350 DEBUG nova.openstack.common.service [-] instance_format                = [instance: %(uuid)s]  log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.723 18350 DEBUG nova.openstack.common.service [-] instance_name_template         = instance-%08x log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.723 18350 DEBUG nova.openstack.common.service [-] instance_usage_audit           = False log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.724 18350 DEBUG nova.openstack.common.service [-] instance_usage_audit_period    = month log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.724 18350 DEBUG nova.openstack.common.service [-] instance_uuid_format           = [instance: %(uuid)s]  log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.724 18350 DEBUG nova.openstack.common.service [-] instances_path                 = /var/lib/nova/instances log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.724 18350 DEBUG nova.openstack.common.service [-] internal_service_availability_zone = internal log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.725 18350 DEBUG nova.openstack.common.service [-] iptables_bottom_regex          =  log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.725 18350 DEBUG nova.openstack.common.service [-] iptables_drop_action           = DROP log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.725 18350 DEBUG nova.openstack.common.service [-] iptables_top_regex             =  log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.725 18350 DEBUG nova.openstack.common.service [-] ipv6_backend                   = rfc2462 log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.725 18350 DEBUG nova.openstack.common.service [-] key_file                       = private/cakey.pem log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.726 18350 DEBUG nova.openstack.common.service [-] keys_path                      = /var/lib/nova/keys log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.726 18350 DEBUG nova.openstack.common.service [-] keystone_ec2_url               = http://localhost:5000/v2.0/ec2tokens log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.726 18350 DEBUG nova.openstack.common.service [-] kombu_reconnect_delay          = 1.0 log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.726 18350 DEBUG nova.openstack.common.service [-] kombu_ssl_ca_certs             =  log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.727 18350 DEBUG nova.openstack.common.service [-] kombu_ssl_certfile             =  log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.727 18350 DEBUG nova.openstack.common.service [-] kombu_ssl_keyfile              =  log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.727 18350 DEBUG nova.openstack.common.service [-] kombu_ssl_version              =  log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.727 18350 DEBUG nova.openstack.common.service [-] l3_lib                         = nova.network.l3.LinuxNetL3 log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.727 18350 DEBUG nova.openstack.common.service [-] linuxnet_interface_driver      = nova.network.linux_net.LinuxBridgeInterfaceDriver log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.728 18350 DEBUG nova.openstack.common.service [-] linuxnet_ovs_integration_bridge = br-int log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.728 18350 DEBUG nova.openstack.common.service [-] live_migration_retry_count     = 30 log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.728 18350 DEBUG nova.openstack.common.service [-] lock_path                      = /var/lib/nova/tmp log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.728 18350 DEBUG nova.openstack.common.service [-] lockout_attempts               = 5 log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.728 18350 DEBUG nova.openstack.common.service [-] lockout_minutes                = 15 log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.729 18350 DEBUG nova.openstack.common.service [-] lockout_window                 = 15 log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.729 18350 DEBUG nova.openstack.common.service [-] log_config_append              = None log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.729 18350 DEBUG nova.openstack.common.service [-] log_date_format                = %Y-%m-%d %H:%M:%S log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.729 18350 DEBUG nova.openstack.common.service [-] log_dir                        = /var/log/nova log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.730 18350 DEBUG nova.openstack.common.service [-] log_file                       = /var/log/nova/compute.log log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.730 18350 DEBUG nova.openstack.common.service [-] log_format                     = None log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.730 18350 DEBUG nova.openstack.common.service [-] logging_context_format_string  = %(asctime)s.%(msecs)03d %(process)d %(levelname)s %(name)s [%(request_id)s %(user)s %(tenant)s] %(instance)s%(message)s log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.730 18350 DEBUG nova.openstack.common.service [-] logging_debug_format_suffix    = %(funcName)s %(pathname)s:%(lineno)d log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.730 18350 DEBUG nova.openstack.common.service [-] logging_default_format_string  = %(asctime)s.%(msecs)03d %(process)d %(levelname)s %(name)s [-] %(instance)s%(message)s log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.731 18350 DEBUG nova.openstack.common.service [-] logging_exception_prefix       = %(asctime)s.%(msecs)03d %(process)d TRACE %(name)s %(instance)s log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.731 18350 DEBUG nova.openstack.common.service [-] max_age                        = 0 log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.731 18350 DEBUG nova.openstack.common.service [-] max_header_line                = 16384 log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.731 18350 DEBUG nova.openstack.common.service [-] max_local_block_devices        = 3 log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.732 18350 DEBUG nova.openstack.common.service [-] maximum_instance_delete_attempts = 5 log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.732 18350 DEBUG nova.openstack.common.service [-] memcached_servers              = None log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.732 18350 DEBUG nova.openstack.common.service [-] metadata_host                  = 10.35.64.150 log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.732 18350 DEBUG nova.openstack.common.service [-] metadata_listen                = 0.0.0.0 log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.732 18350 DEBUG nova.openstack.common.service [-] metadata_listen_port           = 8775 log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.733 18350 DEBUG nova.openstack.common.service [-] metadata_manager               = nova.api.manager.MetadataManager log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.733 18350 DEBUG nova.openstack.common.service [-] metadata_port                  = 8775 log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.733 18350 DEBUG nova.openstack.common.service [-] metadata_workers               = None log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.733 18350 DEBUG nova.openstack.common.service [-] migrate_max_retries            = -1 log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.734 18350 DEBUG nova.openstack.common.service [-] mkisofs_cmd                    = genisoimage log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.734 18350 DEBUG nova.openstack.common.service [-] monkey_patch                   = False log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.734 18350 DEBUG nova.openstack.common.service [-] monkey_patch_modules           = ['nova.api.ec2.cloud:nova.notifications.notify_decorator', 'nova.compute.api:nova.notifications.notify_decorator'] log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.734 18350 DEBUG nova.openstack.common.service [-] multi_host                     = False log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.735 18350 DEBUG nova.openstack.common.service [-] multi_instance_display_name_template = %(name)s-%(uuid)s log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.735 18350 DEBUG nova.openstack.common.service [-] my_ip                          = 10.35.160.111 log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.735 18350 DEBUG nova.openstack.common.service [-] network_allocate_retries       = 0 log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.735 18350 DEBUG nova.openstack.common.service [-] network_api_class              = nova.network.neutronv2.api.API log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.735 18350 DEBUG nova.openstack.common.service [-] network_device_mtu             = None log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.736 18350 DEBUG nova.openstack.common.service [-] network_driver                 = nova.network.linux_net log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.736 18350 DEBUG nova.openstack.common.service [-] network_manager                = nova.network.manager.FlatDHCPManager log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.736 18350 DEBUG nova.openstack.common.service [-] network_size                   = 256 log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.736 18350 DEBUG nova.openstack.common.service [-] network_topic                  = network log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.737 18350 DEBUG nova.openstack.common.service [-] networks_path                  = /var/lib/nova/networks log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.737 18350 DEBUG nova.openstack.common.service [-] neutron_admin_auth_url         = http://10.35.64.150:35357/v2.0 log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.737 18350 DEBUG nova.openstack.common.service [-] neutron_admin_password         = **************** log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.737 18350 DEBUG nova.openstack.common.service [-] neutron_admin_tenant_id        = None log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.738 18350 DEBUG nova.openstack.common.service [-] neutron_admin_tenant_name      = services log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.738 18350 DEBUG nova.openstack.common.service [-] neutron_admin_username         = neutron log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.738 18350 DEBUG nova.openstack.common.service [-] neutron_api_insecure           = False log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.738 18350 DEBUG nova.openstack.common.service [-] neutron_auth_strategy          = keystone log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.738 18350 DEBUG nova.openstack.common.service [-] neutron_ca_certificates_file   = None log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.739 18350 DEBUG nova.openstack.common.service [-] neutron_extension_sync_interval = 600 log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.739 18350 DEBUG nova.openstack.common.service [-] neutron_ovs_bridge             = br-int log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.739 18350 DEBUG nova.openstack.common.service [-] neutron_region_name            = RegionOne log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.739 18350 DEBUG nova.openstack.common.service [-] neutron_url                    = http://10.35.64.150:9696 log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.740 18350 DEBUG nova.openstack.common.service [-] neutron_url_timeout            = 30 log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.740 18350 DEBUG nova.openstack.common.service [-] non_inheritable_image_properties = ['cache_in_nova', 'bittorrent'] log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.740 18350 DEBUG nova.openstack.common.service [-] notification_driver            = ['ceilometer.compute.nova_notifier', 'nova.openstack.common.notifier.rpc_notifier', ''] log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.740 18350 DEBUG nova.openstack.common.service [-] notification_topics            = ['notifications'] log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.741 18350 DEBUG nova.openstack.common.service [-] notify_api_faults              = False log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.741 18350 DEBUG nova.openstack.common.service [-] notify_on_state_change         = None log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.741 18350 DEBUG nova.openstack.common.service [-] novncproxy_base_url            = http://10.35.64.150:6080/vnc_auto.html log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.741 18350 DEBUG nova.openstack.common.service [-] null_kernel                    = nokernel log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.741 18350 DEBUG nova.openstack.common.service [-] num_networks                   = 1 log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.742 18350 DEBUG nova.openstack.common.service [-] os_region_name                 = None log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.742 18350 DEBUG nova.openstack.common.service [-] osapi_compute_ext_list         = [] log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.742 18350 DEBUG nova.openstack.common.service [-] osapi_compute_extension        = ['nova.api.openstack.compute.contrib.standard_extensions'] log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.742 18350 DEBUG nova.openstack.common.service [-] osapi_compute_link_prefix      = None log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.743 18350 DEBUG nova.openstack.common.service [-] osapi_compute_listen           = 0.0.0.0 log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.743 18350 DEBUG nova.openstack.common.service [-] osapi_compute_listen_port      = 8774 log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.743 18350 DEBUG nova.openstack.common.service [-] osapi_compute_workers          = None log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.743 18350 DEBUG nova.openstack.common.service [-] osapi_glance_link_prefix       = None log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.743 18350 DEBUG nova.openstack.common.service [-] osapi_max_limit                = 1000 log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.744 18350 DEBUG nova.openstack.common.service [-] ovs_vsctl_timeout              = 120 log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.744 18350 DEBUG nova.openstack.common.service [-] password_length                = 12 log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.744 18350 DEBUG nova.openstack.common.service [-] pci_alias                      = [] log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.744 18350 DEBUG nova.openstack.common.service [-] pci_passthrough_whitelist      = [] log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.745 18350 DEBUG nova.openstack.common.service [-] periodic_enable                = True log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.745 18350 DEBUG nova.openstack.common.service [-] periodic_fuzzy_delay           = 60 log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.745 18350 DEBUG nova.openstack.common.service [-] policy_default_rule            = default log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.745 18350 DEBUG nova.openstack.common.service [-] policy_file                    = policy.json log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.745 18350 DEBUG nova.openstack.common.service [-] preallocate_images             = none log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.746 18350 DEBUG nova.openstack.common.service [-] project_cert_subject           = /C=US/ST=California/O=OpenStack/OU=NovaDev/CN=project-ca-%.16s-%s log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.746 18350 DEBUG nova.openstack.common.service [-] public_interface               = eth0 log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.746 18350 DEBUG nova.openstack.common.service [-] publish_errors                 = False log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.746 18350 DEBUG nova.openstack.common.service [-] pybasedir                      = /usr/lib/python2.6/site-packages log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.747 18350 DEBUG nova.openstack.common.service [-] quota_cores                    = 20 log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.747 18350 DEBUG nova.openstack.common.service [-] quota_driver                   = nova.quota.DbQuotaDriver log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.747 18350 DEBUG nova.openstack.common.service [-] quota_fixed_ips                = -1 log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.747 18350 DEBUG nova.openstack.common.service [-] quota_floating_ips             = 10 log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.747 18350 DEBUG nova.openstack.common.service [-] quota_injected_file_content_bytes = 10240 log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.748 18350 DEBUG nova.openstack.common.service [-] quota_injected_file_path_bytes = 255 log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.748 18350 DEBUG nova.openstack.common.service [-] quota_injected_files           = 5 log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.748 18350 DEBUG nova.openstack.common.service [-] quota_instances                = 10 log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.748 18350 DEBUG nova.openstack.common.service [-] quota_key_pairs                = 100 log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.749 18350 DEBUG nova.openstack.common.service [-] quota_metadata_items           = 128 log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.749 18350 DEBUG nova.openstack.common.service [-] quota_ram                      = 51200 log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.749 18350 DEBUG nova.openstack.common.service [-] quota_security_group_rules     = 20 log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.749 18350 DEBUG nova.openstack.common.service [-] quota_security_groups          = 10 log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.749 18350 DEBUG nova.openstack.common.service [-] rabbit_ha_queues               = False log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.750 18350 DEBUG nova.openstack.common.service [-] rabbit_host                    = 10.35.64.150 log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.750 18350 DEBUG nova.openstack.common.service [-] rabbit_hosts                   = ['10.35.64.150:5672'] log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.750 18350 DEBUG nova.openstack.common.service [-] rabbit_login_method            = AMQPLAIN log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.750 18350 DEBUG nova.openstack.common.service [-] rabbit_max_retries             = 0 log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.750 18350 DEBUG nova.openstack.common.service [-] rabbit_password                = ***** log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.751 18350 DEBUG nova.openstack.common.service [-] rabbit_port                    = 5672 log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.751 18350 DEBUG nova.openstack.common.service [-] rabbit_retry_backoff           = 2 log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.751 18350 DEBUG nova.openstack.common.service [-] rabbit_retry_interval          = 1 log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.751 18350 DEBUG nova.openstack.common.service [-] rabbit_use_ssl                 = False log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.751 18350 DEBUG nova.openstack.common.service [-] rabbit_userid                  = guest log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.751 18350 DEBUG nova.openstack.common.service [-] rabbit_virtual_host            = / log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.752 18350 DEBUG nova.openstack.common.service [-] reboot_timeout                 = 0 log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.752 18350 DEBUG nova.openstack.common.service [-] reclaim_instance_interval      = 0 log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.752 18350 DEBUG nova.openstack.common.service [-] remove_unused_base_images      = True log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.752 18350 DEBUG nova.openstack.common.service [-] remove_unused_original_minimum_age_seconds = 86400 log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.753 18350 DEBUG nova.openstack.common.service [-] report_interval                = 10 log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.753 18350 DEBUG nova.openstack.common.service [-] rescue_timeout                 = 0 log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.753 18350 DEBUG nova.openstack.common.service [-] reservation_expire             = 86400 log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.753 18350 DEBUG nova.openstack.common.service [-] reserved_host_disk_mb          = 0 log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.753 18350 DEBUG nova.openstack.common.service [-] reserved_host_memory_mb        = 512 log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.754 18350 DEBUG nova.openstack.common.service [-] resize_confirm_window          = 0 log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.754 18350 DEBUG nova.openstack.common.service [-] resize_fs_using_block_device   = False log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.754 18350 DEBUG nova.openstack.common.service [-] resume_guests_state_on_host_boot = False log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.754 18350 DEBUG nova.openstack.common.service [-] rootwrap_config                = /etc/nova/rootwrap.conf log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.755 18350 DEBUG nova.openstack.common.service [-] routing_source_ip              = 10.35.160.111 log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.755 18350 DEBUG nova.openstack.common.service [-] rpc_backend                    = nova.openstack.common.rpc.impl_kombu log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.755 18350 DEBUG nova.openstack.common.service [-] rpc_conn_pool_size             = 30 log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.755 18350 DEBUG nova.openstack.common.service [-] rpc_response_timeout           = 60 log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.756 18350 DEBUG nova.openstack.common.service [-] run_external_periodic_tasks    = True log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.756 18350 DEBUG nova.openstack.common.service [-] running_deleted_instance_action = reap log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.756 18350 DEBUG nova.openstack.common.service [-] running_deleted_instance_poll_interval = 1800 log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.756 18350 DEBUG nova.openstack.common.service [-] running_deleted_instance_timeout = 0 log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.756 18350 DEBUG nova.openstack.common.service [-] scheduler_manager              = nova.scheduler.manager.SchedulerManager log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.757 18350 DEBUG nova.openstack.common.service [-] scheduler_topic                = scheduler log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.757 18350 DEBUG nova.openstack.common.service [-] security_group_api             = neutron log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.757 18350 DEBUG nova.openstack.common.service [-] send_arp_for_ha                = False log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.757 18350 DEBUG nova.openstack.common.service [-] send_arp_for_ha_count          = 3 log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.758 18350 DEBUG nova.openstack.common.service [-] service_down_time              = 60 log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.758 18350 DEBUG nova.openstack.common.service [-] servicegroup_driver            = db log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.758 18350 DEBUG nova.openstack.common.service [-] share_dhcp_address             = False log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.758 18350 DEBUG nova.openstack.common.service [-] shelved_offload_time           = 0 log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.758 18350 DEBUG nova.openstack.common.service [-] shelved_poll_interval          = 3600 log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.759 18350 DEBUG nova.openstack.common.service [-] snapshot_name_template         = snapshot-%s log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.759 18350 DEBUG nova.openstack.common.service [-] ssl_ca_file                    = None log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.759 18350 DEBUG nova.openstack.common.service [-] ssl_cert_file                  = None log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.759 18350 DEBUG nova.openstack.common.service [-] ssl_key_file                   = None log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.760 18350 DEBUG nova.openstack.common.service [-] state_path                     = /var/lib/nova log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.760 18350 DEBUG nova.openstack.common.service [-] sync_power_state_interval      = 600 log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.760 18350 DEBUG nova.openstack.common.service [-] syslog_log_facility            = LOG_USER log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.760 18350 DEBUG nova.openstack.common.service [-] tcp_keepidle                   = 600 log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.760 18350 DEBUG nova.openstack.common.service [-] teardown_unused_network_gateway = False log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.761 18350 DEBUG nova.openstack.common.service [-] tempdir                        = None log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.761 18350 DEBUG nova.openstack.common.service [-] transport_url                  = None log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.761 18350 DEBUG nova.openstack.common.service [-] until_refresh                  = 0 log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.761 18350 DEBUG nova.openstack.common.service [-] update_dns_entries             = False log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.762 18350 DEBUG nova.openstack.common.service [-] use_cow_images                 = True log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.762 18350 DEBUG nova.openstack.common.service [-] use_forwarded_for              = False log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.762 18350 DEBUG nova.openstack.common.service [-] use_ipv6                       = False log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.762 18350 DEBUG nova.openstack.common.service [-] use_network_dns_servers        = False log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.762 18350 DEBUG nova.openstack.common.service [-] use_project_ca                 = False log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.763 18350 DEBUG nova.openstack.common.service [-] use_single_default_gateway     = False log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.763 18350 DEBUG nova.openstack.common.service [-] use_stderr                     = False log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.763 18350 DEBUG nova.openstack.common.service [-] use_syslog                     = False log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.763 18350 DEBUG nova.openstack.common.service [-] use_syslog_rfc_format          = False log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.764 18350 DEBUG nova.openstack.common.service [-] user_cert_subject              = /C=US/ST=California/O=OpenStack/OU=NovaDev/CN=%.16s-%.16s-%s log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.764 18350 DEBUG nova.openstack.common.service [-] vcpu_pin_set                   = None log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.764 18350 DEBUG nova.openstack.common.service [-] vendordata_driver              = nova.api.metadata.vendordata_json.JsonFileVendorData log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.764 18350 DEBUG nova.openstack.common.service [-] verbose                        = True log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.764 18350 DEBUG nova.openstack.common.service [-] vif_plugging_is_fatal          = True log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.765 18350 DEBUG nova.openstack.common.service [-] vif_plugging_timeout           = 300 log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.765 18350 DEBUG nova.openstack.common.service [-] virt_mkfs                      = [] log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.765 18350 DEBUG nova.openstack.common.service [-] vlan_interface                 = None log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.765 18350 DEBUG nova.openstack.common.service [-] vlan_start                     = 100 log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.765 18350 DEBUG nova.openstack.common.service [-] vnc_enabled                    = True log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.766 18350 DEBUG nova.openstack.common.service [-] vnc_keymap                     = en-us log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.766 18350 DEBUG nova.openstack.common.service [-] vncserver_listen               = 0.0.0.0 log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.766 18350 DEBUG nova.openstack.common.service [-] vncserver_proxyclient_address  = 10.35.160.111 log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.766 18350 DEBUG nova.openstack.common.service [-] volume_api_class               = nova.volume.cinder.API log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.767 18350 DEBUG nova.openstack.common.service [-] volume_usage_poll_interval     = 0 log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.767 18350 DEBUG nova.openstack.common.service [-] vpn_flavor                     = m1.tiny log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.767 18350 DEBUG nova.openstack.common.service [-] vpn_image_id                   = 0 log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.767 18350 DEBUG nova.openstack.common.service [-] vpn_ip                         = 10.35.160.111 log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.768 18350 DEBUG nova.openstack.common.service [-] vpn_key_suffix                 = -vpn log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.768 18350 DEBUG nova.openstack.common.service [-] vpn_start                      = 1000 log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.768 18350 DEBUG nova.openstack.common.service [-] wsgi_default_pool_size         = 1000 log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.768 18350 DEBUG nova.openstack.common.service [-] wsgi_log_format                = %(client_ip)s "%(request_line)s" status: %(status_code)s len: %(body_length)s time: %(wall_seconds).7f log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.769 18350 DEBUG nova.openstack.common.service [-] xvpvncproxy_base_url           = http://127.0.0.1:6081/console log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1945
>2014-07-15 15:08:31.769 18350 DEBUG nova.openstack.common.service [-] osapi_v3.enabled               = False log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1953
>2014-07-15 15:08:31.769 18350 DEBUG nova.openstack.common.service [-] osapi_v3.extensions_blacklist  = [] log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1953
>2014-07-15 15:08:31.769 18350 DEBUG nova.openstack.common.service [-] osapi_v3.extensions_whitelist  = [] log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1953
>2014-07-15 15:08:31.769 18350 DEBUG nova.openstack.common.service [-] rdp.enabled                    = False log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1953
>2014-07-15 15:08:31.770 18350 DEBUG nova.openstack.common.service [-] rdp.html5_proxy_base_url       = http://127.0.0.1:6083/ log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1953
>2014-07-15 15:08:31.770 18350 DEBUG nova.openstack.common.service [-] conductor.manager              = nova.conductor.manager.ConductorManager log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1953
>2014-07-15 15:08:31.770 18350 DEBUG nova.openstack.common.service [-] conductor.topic                = conductor log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1953
>2014-07-15 15:08:31.770 18350 DEBUG nova.openstack.common.service [-] conductor.use_local            = False log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1953
>2014-07-15 15:08:31.771 18350 DEBUG nova.openstack.common.service [-] conductor.workers              = None log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1953
>2014-07-15 15:08:31.771 18350 DEBUG nova.openstack.common.service [-] keymgr.api_class               = nova.keymgr.conf_key_mgr.ConfKeyManager log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1953
>2014-07-15 15:08:31.771 18350 DEBUG nova.openstack.common.service [-] cells.bandwidth_update_interval = 600 log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1953
>2014-07-15 15:08:31.771 18350 DEBUG nova.openstack.common.service [-] cells.call_timeout             = 60 log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1953
>2014-07-15 15:08:31.772 18350 DEBUG nova.openstack.common.service [-] cells.capabilities             = ['hypervisor=xenserver;kvm', 'os=linux;windows'] log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1953
>2014-07-15 15:08:31.772 18350 DEBUG nova.openstack.common.service [-] cells.cell_type                = compute log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1953
>2014-07-15 15:08:31.772 18350 DEBUG nova.openstack.common.service [-] cells.enable                   = False log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1953
>2014-07-15 15:08:31.772 18350 DEBUG nova.openstack.common.service [-] cells.manager                  = nova.cells.manager.CellsManager log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1953
>2014-07-15 15:08:31.773 18350 DEBUG nova.openstack.common.service [-] cells.mute_child_interval      = 300 log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1953
>2014-07-15 15:08:31.773 18350 DEBUG nova.openstack.common.service [-] cells.name                     = nova log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1953
>2014-07-15 15:08:31.773 18350 DEBUG nova.openstack.common.service [-] cells.reserve_percent          = 10.0 log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1953
>2014-07-15 15:08:31.773 18350 DEBUG nova.openstack.common.service [-] cells.topic                    = cells log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1953
>2014-07-15 15:08:31.774 18350 DEBUG nova.openstack.common.service [-] database.backend               = sqlalchemy log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1953
>2014-07-15 15:08:31.774 18350 DEBUG nova.openstack.common.service [-] database.connection            = ****************************** log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1953
>2014-07-15 15:08:31.774 18350 DEBUG nova.openstack.common.service [-] database.connection_debug      = 0 log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1953
>2014-07-15 15:08:31.774 18350 DEBUG nova.openstack.common.service [-] database.connection_trace      = False log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1953
>2014-07-15 15:08:31.774 18350 DEBUG nova.openstack.common.service [-] database.db_inc_retry_interval = True log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1953
>2014-07-15 15:08:31.775 18350 DEBUG nova.openstack.common.service [-] database.db_max_retries        = 20 log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1953
>2014-07-15 15:08:31.775 18350 DEBUG nova.openstack.common.service [-] database.db_max_retry_interval = 10 log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1953
>2014-07-15 15:08:31.775 18350 DEBUG nova.openstack.common.service [-] database.db_retry_interval     = 1 log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1953
>2014-07-15 15:08:31.775 18350 DEBUG nova.openstack.common.service [-] database.idle_timeout          = 3600 log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1953
>2014-07-15 15:08:31.776 18350 DEBUG nova.openstack.common.service [-] database.max_overflow          = None log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1953
>2014-07-15 15:08:31.776 18350 DEBUG nova.openstack.common.service [-] database.max_pool_size         = None log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1953
>2014-07-15 15:08:31.776 18350 DEBUG nova.openstack.common.service [-] database.max_retries           = -1 log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1953
>2014-07-15 15:08:31.776 18350 DEBUG nova.openstack.common.service [-] database.min_pool_size         = 1 log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1953
>2014-07-15 15:08:31.777 18350 DEBUG nova.openstack.common.service [-] database.mysql_sql_mode        = None log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1953
>2014-07-15 15:08:31.777 18350 DEBUG nova.openstack.common.service [-] database.pool_timeout          = None log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1953
>2014-07-15 15:08:31.777 18350 DEBUG nova.openstack.common.service [-] database.retry_interval        = 10 log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1953
>2014-07-15 15:08:31.777 18350 DEBUG nova.openstack.common.service [-] database.sqlite_db             = nova.sqlite log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1953
>2014-07-15 15:08:31.778 18350 DEBUG nova.openstack.common.service [-] database.sqlite_synchronous    = True log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1953
>2014-07-15 15:08:31.778 18350 DEBUG nova.openstack.common.service [-] database.use_db_reconnect      = False log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1953
>2014-07-15 15:08:31.778 18350 DEBUG nova.openstack.common.service [-] image_file_url.filesystems     = [] log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1953
>2014-07-15 15:08:31.778 18350 DEBUG nova.openstack.common.service [-] libvirt.block_migration_flag   = VIR_MIGRATE_UNDEFINE_SOURCE, VIR_MIGRATE_PEER2PEER, VIR_MIGRATE_NON_SHARED_INC log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1953
>2014-07-15 15:08:31.779 18350 DEBUG nova.openstack.common.service [-] libvirt.checksum_base_images   = False log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1953
>2014-07-15 15:08:31.779 18350 DEBUG nova.openstack.common.service [-] libvirt.checksum_interval_seconds = 3600 log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1953
>2014-07-15 15:08:31.779 18350 DEBUG nova.openstack.common.service [-] libvirt.connection_uri         =  log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1953
>2014-07-15 15:08:31.779 18350 DEBUG nova.openstack.common.service [-] libvirt.cpu_mode               = host-model log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1953
>2014-07-15 15:08:31.779 18350 DEBUG nova.openstack.common.service [-] libvirt.cpu_model              = None log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1953
>2014-07-15 15:08:31.780 18350 DEBUG nova.openstack.common.service [-] libvirt.disk_cachemodes        = [] log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1953
>2014-07-15 15:08:31.780 18350 DEBUG nova.openstack.common.service [-] libvirt.disk_prefix            = None log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1953
>2014-07-15 15:08:31.780 18350 DEBUG nova.openstack.common.service [-] libvirt.glusterfs_mount_point_base = /var/lib/nova/mnt log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1953
>2014-07-15 15:08:31.780 18350 DEBUG nova.openstack.common.service [-] libvirt.image_info_filename_pattern = /var/lib/nova/instances/_base/%(image)s.info log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1953
>2014-07-15 15:08:31.781 18350 DEBUG nova.openstack.common.service [-] libvirt.images_rbd_ceph_conf   =  log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1953
>2014-07-15 15:08:31.781 18350 DEBUG nova.openstack.common.service [-] libvirt.images_rbd_pool        = rbd log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1953
>2014-07-15 15:08:31.781 18350 DEBUG nova.openstack.common.service [-] libvirt.images_type            = default log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1953
>2014-07-15 15:08:31.781 18350 DEBUG nova.openstack.common.service [-] libvirt.images_volume_group    = None log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1953
>2014-07-15 15:08:31.782 18350 DEBUG nova.openstack.common.service [-] libvirt.inject_key             = False log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1953
>2014-07-15 15:08:31.782 18350 DEBUG nova.openstack.common.service [-] libvirt.inject_partition       = -1 log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1953
>2014-07-15 15:08:31.782 18350 DEBUG nova.openstack.common.service [-] libvirt.inject_password        = False log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1953
>2014-07-15 15:08:31.782 18350 DEBUG nova.openstack.common.service [-] libvirt.iscsi_use_multipath    = False log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1953
>2014-07-15 15:08:31.783 18350 DEBUG nova.openstack.common.service [-] libvirt.iser_use_multipath     = False log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1953
>2014-07-15 15:08:31.783 18350 DEBUG nova.openstack.common.service [-] libvirt.live_migration_bandwidth = 0 log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1953
>2014-07-15 15:08:31.783 18350 DEBUG nova.openstack.common.service [-] libvirt.live_migration_flag    = VIR_MIGRATE_UNDEFINE_SOURCE, VIR_MIGRATE_PEER2PEER log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1953
>2014-07-15 15:08:31.783 18350 DEBUG nova.openstack.common.service [-] libvirt.live_migration_uri     = qemu+ssh://nova@%s/system?no_verify=1&keyfile=/etc/nova/ssh/nova_migration_key log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1953
>2014-07-15 15:08:31.784 18350 DEBUG nova.openstack.common.service [-] libvirt.nfs_mount_options      = None log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1953
>2014-07-15 15:08:31.784 18350 DEBUG nova.openstack.common.service [-] libvirt.nfs_mount_point_base   = /var/lib/nova/mnt log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1953
>2014-07-15 15:08:31.784 18350 DEBUG nova.openstack.common.service [-] libvirt.num_aoe_discover_tries = 3 log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1953
>2014-07-15 15:08:31.784 18350 DEBUG nova.openstack.common.service [-] libvirt.num_iscsi_scan_tries   = 5 log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1953
>2014-07-15 15:08:31.785 18350 DEBUG nova.openstack.common.service [-] libvirt.num_iser_scan_tries    = 5 log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1953
>2014-07-15 15:08:31.785 18350 DEBUG nova.openstack.common.service [-] libvirt.qemu_allowed_storage_drivers = [] log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1953
>2014-07-15 15:08:31.785 18350 DEBUG nova.openstack.common.service [-] libvirt.rbd_secret_uuid        = None log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1953
>2014-07-15 15:08:31.785 18350 DEBUG nova.openstack.common.service [-] libvirt.rbd_user               = None log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1953
>2014-07-15 15:08:31.785 18350 DEBUG nova.openstack.common.service [-] libvirt.remove_unused_kernels  = False log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1953
>2014-07-15 15:08:31.786 18350 DEBUG nova.openstack.common.service [-] libvirt.remove_unused_resized_minimum_age_seconds = 3600 log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1953
>2014-07-15 15:08:31.786 18350 DEBUG nova.openstack.common.service [-] libvirt.rescue_image_id        = None log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1953
>2014-07-15 15:08:31.786 18350 DEBUG nova.openstack.common.service [-] libvirt.rescue_kernel_id       = None log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1953
>2014-07-15 15:08:31.786 18350 DEBUG nova.openstack.common.service [-] libvirt.rescue_ramdisk_id      = None log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1953
>2014-07-15 15:08:31.787 18350 DEBUG nova.openstack.common.service [-] libvirt.rng_dev_path           = None log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1953
>2014-07-15 15:08:31.787 18350 DEBUG nova.openstack.common.service [-] libvirt.scality_sofs_config    = None log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1953
>2014-07-15 15:08:31.787 18350 DEBUG nova.openstack.common.service [-] libvirt.scality_sofs_mount_point = /var/lib/nova/scality log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1953
>2014-07-15 15:08:31.787 18350 DEBUG nova.openstack.common.service [-] libvirt.snapshot_compression   = False log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1953
>2014-07-15 15:08:31.788 18350 DEBUG nova.openstack.common.service [-] libvirt.snapshot_image_format  = None log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1953
>2014-07-15 15:08:31.788 18350 DEBUG nova.openstack.common.service [-] libvirt.snapshots_directory    = /var/lib/nova/instances/snapshots log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1953
>2014-07-15 15:08:31.788 18350 DEBUG nova.openstack.common.service [-] libvirt.sparse_logical_volumes = False log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1953
>2014-07-15 15:08:31.788 18350 DEBUG nova.openstack.common.service [-] libvirt.use_usb_tablet         = True log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1953
>2014-07-15 15:08:31.789 18350 DEBUG nova.openstack.common.service [-] libvirt.use_virtio_for_bridges = True log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1953
>2014-07-15 15:08:31.789 18350 DEBUG nova.openstack.common.service [-] libvirt.vif_driver             = nova.virt.libvirt.vif.LibvirtGenericVIFDriver log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1953
>2014-07-15 15:08:31.789 18350 DEBUG nova.openstack.common.service [-] libvirt.virt_type              = kvm log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1953
>2014-07-15 15:08:31.789 18350 DEBUG nova.openstack.common.service [-] libvirt.volume_clear           = zero log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1953
>2014-07-15 15:08:31.790 18350 DEBUG nova.openstack.common.service [-] libvirt.volume_clear_size      = 0 log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1953
>2014-07-15 15:08:31.790 18350 DEBUG nova.openstack.common.service [-] libvirt.volume_drivers         = ['iscsi=nova.virt.libvirt.volume.LibvirtISCSIVolumeDriver', 'iser=nova.virt.libvirt.volume.LibvirtISERVolumeDriver', 'local=nova.virt.libvirt.volume.LibvirtVolumeDriver', 'fake=nova.virt.libvirt.volume.LibvirtFakeVolumeDriver', 'rbd=nova.virt.libvirt.volume.LibvirtNetVolumeDriver', 'sheepdog=nova.virt.libvirt.volume.LibvirtNetVolumeDriver', 'nfs=nova.virt.libvirt.volume.LibvirtNFSVolumeDriver', 'aoe=nova.virt.libvirt.volume.LibvirtAOEVolumeDriver', 'glusterfs=nova.virt.libvirt.volume.LibvirtGlusterfsVolumeDriver', 'fibre_channel=nova.virt.libvirt.volume.LibvirtFibreChannelVolumeDriver', 'scality=nova.virt.libvirt.volume.LibvirtScalityVolumeDriver'] log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1953
>2014-07-15 15:08:31.790 18350 DEBUG nova.openstack.common.service [-] libvirt.wait_soft_reboot_seconds = 120 log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1953
>2014-07-15 15:08:31.790 18350 DEBUG nova.openstack.common.service [-] libvirt.xen_hvmloader_path     = /usr/lib/xen/boot/hvmloader log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1953
>2014-07-15 15:08:31.791 18350 DEBUG nova.openstack.common.service [-] remote_debug.host              = None log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1953
>2014-07-15 15:08:31.791 18350 DEBUG nova.openstack.common.service [-] remote_debug.port              = None log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1953
>2014-07-15 15:08:31.791 18350 DEBUG nova.openstack.common.service [-] upgrade_levels.baseapi         = None log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1953
>2014-07-15 15:08:31.791 18350 DEBUG nova.openstack.common.service [-] upgrade_levels.cells           = None log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1953
>2014-07-15 15:08:31.792 18350 DEBUG nova.openstack.common.service [-] upgrade_levels.compute         = None log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1953
>2014-07-15 15:08:31.792 18350 DEBUG nova.openstack.common.service [-] upgrade_levels.conductor       = None log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1953
>2014-07-15 15:08:31.792 18350 DEBUG nova.openstack.common.service [-] upgrade_levels.console         = None log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1953
>2014-07-15 15:08:31.792 18350 DEBUG nova.openstack.common.service [-] upgrade_levels.consoleauth     = None log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1953
>2014-07-15 15:08:31.792 18350 DEBUG nova.openstack.common.service [-] upgrade_levels.network         = None log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1953
>2014-07-15 15:08:31.793 18350 DEBUG nova.openstack.common.service [-] upgrade_levels.scheduler       = None log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1953
>2014-07-15 15:08:31.793 18350 DEBUG nova.openstack.common.service [-] spice.agent_enabled            = True log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1953
>2014-07-15 15:08:31.793 18350 DEBUG nova.openstack.common.service [-] spice.enabled                  = False log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1953
>2014-07-15 15:08:31.793 18350 DEBUG nova.openstack.common.service [-] spice.html5proxy_base_url      = http://127.0.0.1:6082/spice_auto.html log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1953
>2014-07-15 15:08:31.794 18350 DEBUG nova.openstack.common.service [-] spice.keymap                   = en-us log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1953
>2014-07-15 15:08:31.794 18350 DEBUG nova.openstack.common.service [-] spice.server_listen            = 127.0.0.1 log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1953
>2014-07-15 15:08:31.794 18350 DEBUG nova.openstack.common.service [-] spice.server_proxyclient_address = 127.0.0.1 log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1953
>2014-07-15 15:08:31.794 18350 DEBUG nova.openstack.common.service [-] ******************************************************************************** log_opt_values /usr/lib/python2.6/site-packages/oslo/config/cfg.py:1955
>2014-07-15 15:08:31.795 18350 AUDIT nova.service [-] Starting compute node (version 2014.1.1-1.el6ost)
>2014-07-15 15:08:31.797 18350 DEBUG nova.virt.libvirt.driver [-] Connecting to libvirt: qemu:///system _get_new_connection /usr/lib/python2.6/site-packages/nova/virt/libvirt/driver.py:671
>2014-07-15 15:08:32.042 18350 WARNING nova.virt.libvirt.driver [req-31a2751e-b087-4351-ad28-3a4e6885bde9 None None] Cannot update service status on host: cougar11.scl.lab.tlv.redhat.com,since it is not registered.
>2014-07-15 15:08:32.042 18350 DEBUG nova.virt.libvirt.driver [-] Registering for lifecycle events <nova.virt.libvirt.driver.LibvirtDriver object at 0x258dbd0> _get_new_connection /usr/lib/python2.6/site-packages/nova/virt/libvirt/driver.py:687
>2014-07-15 15:08:32.043 18350 DEBUG nova.virt.libvirt.driver [-] Registering for connection events: <nova.virt.libvirt.driver.LibvirtDriver object at 0x258dbd0> _get_new_connection /usr/lib/python2.6/site-packages/nova/virt/libvirt/driver.py:699
>2014-07-15 15:08:32.044 18350 DEBUG nova.virt.libvirt.driver [-] The version of python-libvirt does not support registerCloseCallback or is too old: registerCloseCallback() takes exactly 4 arguments (3 given) _get_new_connection /usr/lib/python2.6/site-packages/nova/virt/libvirt/driver.py:709
>2014-07-15 15:08:32.055 18350 DEBUG nova.virt.libvirt.driver [-] Starting native event thread _init_events /usr/lib/python2.6/site-packages/nova/virt/libvirt/driver.py:624
>2014-07-15 15:08:32.056 18350 DEBUG nova.virt.libvirt.driver [-] Starting green dispatch thread _init_events /usr/lib/python2.6/site-packages/nova/virt/libvirt/driver.py:629
>2014-07-15 15:08:32.169 18350 DEBUG nova.virt.libvirt.driver [-] Updating host stats update_status /usr/lib/python2.6/site-packages/nova/virt/libvirt/driver.py:5311
>2014-07-15 15:08:32.255 18350 DEBUG nova.openstack.common.lockutils [-] Got semaphore "compute_resources" lock /usr/lib/python2.6/site-packages/nova/openstack/common/lockutils.py:168
>2014-07-15 15:08:32.255 18350 DEBUG nova.openstack.common.lockutils [-] Got semaphore / lock "update_available_resource" inner /usr/lib/python2.6/site-packages/nova/openstack/common/lockutils.py:248
>2014-07-15 15:08:32.255 18350 AUDIT nova.compute.resource_tracker [-] Auditing locally available compute resources
>2014-07-15 15:08:32.255 18350 DEBUG nova.virt.libvirt.driver [-] Updating host stats update_status /usr/lib/python2.6/site-packages/nova/virt/libvirt/driver.py:5311
>2014-07-15 15:08:32.336 18350 DEBUG nova.compute.resource_tracker [-] Hypervisor: free ram (MB): 15503 _report_hypervisor_resource_view /usr/lib/python2.6/site-packages/nova/compute/resource_tracker.py:409
>2014-07-15 15:08:32.336 18350 DEBUG nova.compute.resource_tracker [-] Hypervisor: free disk (GB): 449 _report_hypervisor_resource_view /usr/lib/python2.6/site-packages/nova/compute/resource_tracker.py:410
>2014-07-15 15:08:32.336 18350 DEBUG nova.compute.resource_tracker [-] Hypervisor: free VCPUs: 6 _report_hypervisor_resource_view /usr/lib/python2.6/site-packages/nova/compute/resource_tracker.py:415
>2014-07-15 15:08:32.337 18350 DEBUG nova.compute.resource_tracker [-] Hypervisor: assignable PCI devices: [] _report_hypervisor_resource_view /usr/lib/python2.6/site-packages/nova/compute/resource_tracker.py:422
>2014-07-15 15:08:32.373 18350 AUDIT nova.compute.resource_tracker [-] Free ram (MB): 15429
>2014-07-15 15:08:32.374 18350 AUDIT nova.compute.resource_tracker [-] Free disk (GB): 450
>2014-07-15 15:08:32.374 18350 AUDIT nova.compute.resource_tracker [-] Free VCPUS: 6
>2014-07-15 15:08:32.478 18350 INFO nova.compute.resource_tracker [-] Compute_service record created for cougar11.scl.lab.tlv.redhat.com:cougar11.scl.lab.tlv.redhat.com
>2014-07-15 15:08:32.479 18350 DEBUG nova.openstack.common.lockutils [-] Semaphore / lock released "update_available_resource" inner /usr/lib/python2.6/site-packages/nova/openstack/common/lockutils.py:252
>2014-07-15 15:08:32.496 18350 DEBUG nova.service [-] Creating RPC server for service compute start /usr/lib/python2.6/site-packages/nova/service.py:184
>2014-07-15 15:08:32.496 18350 DEBUG stevedore.extension [-] found extension EntryPoint.parse('blocking = oslo.messaging._executors.impl_blocking:BlockingExecutor') _load_plugins /usr/lib/python2.6/site-packages/stevedore/extension.py:156
>2014-07-15 15:08:32.496 18350 DEBUG stevedore.extension [-] found extension EntryPoint.parse('eventlet = oslo.messaging._executors.impl_eventlet:EventletExecutor') _load_plugins /usr/lib/python2.6/site-packages/stevedore/extension.py:156
>2014-07-15 15:08:32.508 18350 INFO oslo.messaging._drivers.impl_rabbit [-] Connected to AMQP server on 10.35.64.150:5672
>2014-07-15 15:08:32.514 18350 DEBUG nova.service [-] Join ServiceGroup membership for this service compute start /usr/lib/python2.6/site-packages/nova/service.py:202
>2014-07-15 15:08:32.514 18350 DEBUG nova.servicegroup.api [-] Join new ServiceGroup member cougar11.scl.lab.tlv.redhat.com to the compute group, service = <nova.service.Service object at 0x1f8f250> join /usr/lib/python2.6/site-packages/nova/servicegroup/api.py:109
>2014-07-15 15:08:32.515 18350 DEBUG nova.servicegroup.drivers.db [-] DB_Driver: join new ServiceGroup member cougar11.scl.lab.tlv.redhat.com to the compute group, service = <nova.service.Service object at 0x1f8f250> join /usr/lib/python2.6/site-packages/nova/servicegroup/drivers/db.py:45
>2014-07-15 15:09:19.517 18350 DEBUG nova.openstack.common.periodic_task [req-4fc38004-aa70-48c3-b10d-6e78ff6c9a34 None None] Running periodic task ComputeManager._poll_volume_usage run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:09:19.519 18350 DEBUG nova.openstack.common.periodic_task [req-4fc38004-aa70-48c3-b10d-6e78ff6c9a34 None None] Running periodic task ComputeManager._instance_usage_audit run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:09:19.520 18350 DEBUG nova.openstack.common.periodic_task [req-4fc38004-aa70-48c3-b10d-6e78ff6c9a34 None None] Running periodic task ComputeManager.update_available_resource run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:09:19.520 18350 DEBUG nova.openstack.common.lockutils [req-4fc38004-aa70-48c3-b10d-6e78ff6c9a34 None None] Got semaphore "compute_resources" lock /usr/lib/python2.6/site-packages/nova/openstack/common/lockutils.py:168
>2014-07-15 15:09:19.520 18350 DEBUG nova.openstack.common.lockutils [req-4fc38004-aa70-48c3-b10d-6e78ff6c9a34 None None] Got semaphore / lock "update_available_resource" inner /usr/lib/python2.6/site-packages/nova/openstack/common/lockutils.py:248
>2014-07-15 15:09:19.520 18350 AUDIT nova.compute.resource_tracker [req-4fc38004-aa70-48c3-b10d-6e78ff6c9a34 None None] Auditing locally available compute resources
>2014-07-15 15:09:19.521 18350 DEBUG nova.virt.libvirt.driver [req-4fc38004-aa70-48c3-b10d-6e78ff6c9a34 None None] Updating host stats update_status /usr/lib/python2.6/site-packages/nova/virt/libvirt/driver.py:5311
>2014-07-15 15:09:19.612 18350 DEBUG nova.compute.resource_tracker [req-4fc38004-aa70-48c3-b10d-6e78ff6c9a34 None None] Hypervisor: free ram (MB): 15421 _report_hypervisor_resource_view /usr/lib/python2.6/site-packages/nova/compute/resource_tracker.py:409
>2014-07-15 15:09:19.612 18350 DEBUG nova.compute.resource_tracker [req-4fc38004-aa70-48c3-b10d-6e78ff6c9a34 None None] Hypervisor: free disk (GB): 449 _report_hypervisor_resource_view /usr/lib/python2.6/site-packages/nova/compute/resource_tracker.py:410
>2014-07-15 15:09:19.613 18350 DEBUG nova.compute.resource_tracker [req-4fc38004-aa70-48c3-b10d-6e78ff6c9a34 None None] Hypervisor: free VCPUs: 6 _report_hypervisor_resource_view /usr/lib/python2.6/site-packages/nova/compute/resource_tracker.py:415
>2014-07-15 15:09:19.613 18350 DEBUG nova.compute.resource_tracker [req-4fc38004-aa70-48c3-b10d-6e78ff6c9a34 None None] Hypervisor: assignable PCI devices: [] _report_hypervisor_resource_view /usr/lib/python2.6/site-packages/nova/compute/resource_tracker.py:422
>2014-07-15 15:09:19.664 18350 AUDIT nova.compute.resource_tracker [req-4fc38004-aa70-48c3-b10d-6e78ff6c9a34 None None] Free ram (MB): 15429
>2014-07-15 15:09:19.664 18350 AUDIT nova.compute.resource_tracker [req-4fc38004-aa70-48c3-b10d-6e78ff6c9a34 None None] Free disk (GB): 450
>2014-07-15 15:09:19.664 18350 AUDIT nova.compute.resource_tracker [req-4fc38004-aa70-48c3-b10d-6e78ff6c9a34 None None] Free VCPUS: 6
>2014-07-15 15:09:19.697 18350 INFO nova.compute.resource_tracker [req-4fc38004-aa70-48c3-b10d-6e78ff6c9a34 None None] Compute_service record updated for cougar11.scl.lab.tlv.redhat.com:cougar11.scl.lab.tlv.redhat.com
>2014-07-15 15:09:19.697 18350 DEBUG nova.openstack.common.lockutils [req-4fc38004-aa70-48c3-b10d-6e78ff6c9a34 None None] Semaphore / lock released "update_available_resource" inner /usr/lib/python2.6/site-packages/nova/openstack/common/lockutils.py:252
>2014-07-15 15:09:19.727 18350 DEBUG nova.openstack.common.periodic_task [req-4fc38004-aa70-48c3-b10d-6e78ff6c9a34 None None] Running periodic task ComputeManager._poll_rebooting_instances run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:09:19.728 18350 DEBUG nova.openstack.common.periodic_task [req-4fc38004-aa70-48c3-b10d-6e78ff6c9a34 None None] Running periodic task ComputeManager._reclaim_queued_deletes run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:09:19.728 18350 DEBUG nova.compute.manager [req-4fc38004-aa70-48c3-b10d-6e78ff6c9a34 None None] CONF.reclaim_instance_interval <= 0, skipping... _reclaim_queued_deletes /usr/lib/python2.6/site-packages/nova/compute/manager.py:5392
>2014-07-15 15:09:19.728 18350 DEBUG nova.openstack.common.periodic_task [req-4fc38004-aa70-48c3-b10d-6e78ff6c9a34 None None] Running periodic task ComputeManager._poll_unconfirmed_resizes run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:09:19.729 18350 DEBUG nova.openstack.common.periodic_task [req-4fc38004-aa70-48c3-b10d-6e78ff6c9a34 None None] Running periodic task ComputeManager._sync_power_states run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:09:19.751 18350 DEBUG nova.openstack.common.periodic_task [req-4fc38004-aa70-48c3-b10d-6e78ff6c9a34 None None] Running periodic task ComputeManager._poll_rescued_instances run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:09:19.752 18350 DEBUG nova.openstack.common.periodic_task [req-4fc38004-aa70-48c3-b10d-6e78ff6c9a34 None None] Running periodic task ComputeManager._check_instance_build_time run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:09:19.752 18350 DEBUG nova.openstack.common.loopingcall [-] Dynamic looping call sleeping for 10.63 seconds _inner /usr/lib/python2.6/site-packages/nova/openstack/common/loopingcall.py:132
>2014-07-15 15:09:30.390 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager._poll_volume_usage run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:09:30.392 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager._instance_usage_audit run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:09:30.392 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager.update_available_resource run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:09:30.392 18350 DEBUG nova.openstack.common.lockutils [-] Got semaphore "compute_resources" lock /usr/lib/python2.6/site-packages/nova/openstack/common/lockutils.py:168
>2014-07-15 15:09:30.392 18350 DEBUG nova.openstack.common.lockutils [-] Got semaphore / lock "update_available_resource" inner /usr/lib/python2.6/site-packages/nova/openstack/common/lockutils.py:248
>2014-07-15 15:09:30.393 18350 AUDIT nova.compute.resource_tracker [-] Auditing locally available compute resources
>2014-07-15 15:09:30.393 18350 DEBUG nova.virt.libvirt.driver [-] Updating host stats update_status /usr/lib/python2.6/site-packages/nova/virt/libvirt/driver.py:5311
>2014-07-15 15:09:30.479 18350 DEBUG nova.compute.resource_tracker [-] Hypervisor: free ram (MB): 15415 _report_hypervisor_resource_view /usr/lib/python2.6/site-packages/nova/compute/resource_tracker.py:409
>2014-07-15 15:09:30.480 18350 DEBUG nova.compute.resource_tracker [-] Hypervisor: free disk (GB): 449 _report_hypervisor_resource_view /usr/lib/python2.6/site-packages/nova/compute/resource_tracker.py:410
>2014-07-15 15:09:30.480 18350 DEBUG nova.compute.resource_tracker [-] Hypervisor: free VCPUs: 6 _report_hypervisor_resource_view /usr/lib/python2.6/site-packages/nova/compute/resource_tracker.py:415
>2014-07-15 15:09:30.480 18350 DEBUG nova.compute.resource_tracker [-] Hypervisor: assignable PCI devices: [] _report_hypervisor_resource_view /usr/lib/python2.6/site-packages/nova/compute/resource_tracker.py:422
>2014-07-15 15:09:30.525 18350 AUDIT nova.compute.resource_tracker [-] Free ram (MB): 15429
>2014-07-15 15:09:30.525 18350 AUDIT nova.compute.resource_tracker [-] Free disk (GB): 450
>2014-07-15 15:09:30.525 18350 AUDIT nova.compute.resource_tracker [-] Free VCPUS: 6
>2014-07-15 15:09:30.577 18350 INFO nova.compute.resource_tracker [-] Compute_service record updated for cougar11.scl.lab.tlv.redhat.com:cougar11.scl.lab.tlv.redhat.com
>2014-07-15 15:09:30.577 18350 DEBUG nova.openstack.common.lockutils [-] Semaphore / lock released "update_available_resource" inner /usr/lib/python2.6/site-packages/nova/openstack/common/lockutils.py:252
>2014-07-15 15:09:30.601 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager._poll_rebooting_instances run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:09:30.602 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager._reclaim_queued_deletes run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:09:30.602 18350 DEBUG nova.compute.manager [-] CONF.reclaim_instance_interval <= 0, skipping... _reclaim_queued_deletes /usr/lib/python2.6/site-packages/nova/compute/manager.py:5392
>2014-07-15 15:09:30.602 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager._poll_unconfirmed_resizes run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:09:30.603 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager._poll_rescued_instances run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:09:30.603 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager._check_instance_build_time run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:09:30.603 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager._heal_instance_info_cache run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:09:30.603 18350 DEBUG nova.compute.manager [-] Starting heal instance info cache _heal_instance_info_cache /usr/lib/python2.6/site-packages/nova/compute/manager.py:4817
>2014-07-15 15:09:30.604 18350 DEBUG nova.compute.manager [-] Rebuilding the list of instances to heal _heal_instance_info_cache /usr/lib/python2.6/site-packages/nova/compute/manager.py:4821
>2014-07-15 15:09:30.628 18350 DEBUG nova.compute.manager [-] Didn't find any instances for network info cache update. _heal_instance_info_cache /usr/lib/python2.6/site-packages/nova/compute/manager.py:4883
>2014-07-15 15:09:30.628 18350 DEBUG nova.openstack.common.loopingcall [-] Dynamic looping call sleeping for 60.00 seconds _inner /usr/lib/python2.6/site-packages/nova/openstack/common/loopingcall.py:132
>2014-07-15 15:10:30.629 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager._poll_volume_usage run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:10:30.629 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager._instance_usage_audit run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:10:30.630 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager.update_available_resource run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:10:30.630 18350 DEBUG nova.openstack.common.lockutils [-] Got semaphore "compute_resources" lock /usr/lib/python2.6/site-packages/nova/openstack/common/lockutils.py:168
>2014-07-15 15:10:30.630 18350 DEBUG nova.openstack.common.lockutils [-] Got semaphore / lock "update_available_resource" inner /usr/lib/python2.6/site-packages/nova/openstack/common/lockutils.py:248
>2014-07-15 15:10:30.630 18350 AUDIT nova.compute.resource_tracker [-] Auditing locally available compute resources
>2014-07-15 15:10:30.631 18350 DEBUG nova.virt.libvirt.driver [-] Updating host stats update_status /usr/lib/python2.6/site-packages/nova/virt/libvirt/driver.py:5311
>2014-07-15 15:10:30.709 18350 DEBUG nova.compute.resource_tracker [-] Hypervisor: free ram (MB): 15402 _report_hypervisor_resource_view /usr/lib/python2.6/site-packages/nova/compute/resource_tracker.py:409
>2014-07-15 15:10:30.709 18350 DEBUG nova.compute.resource_tracker [-] Hypervisor: free disk (GB): 449 _report_hypervisor_resource_view /usr/lib/python2.6/site-packages/nova/compute/resource_tracker.py:410
>2014-07-15 15:10:30.709 18350 DEBUG nova.compute.resource_tracker [-] Hypervisor: free VCPUs: 6 _report_hypervisor_resource_view /usr/lib/python2.6/site-packages/nova/compute/resource_tracker.py:415
>2014-07-15 15:10:30.709 18350 DEBUG nova.compute.resource_tracker [-] Hypervisor: assignable PCI devices: [] _report_hypervisor_resource_view /usr/lib/python2.6/site-packages/nova/compute/resource_tracker.py:422
>2014-07-15 15:10:30.756 18350 AUDIT nova.compute.resource_tracker [-] Free ram (MB): 15429
>2014-07-15 15:10:30.756 18350 AUDIT nova.compute.resource_tracker [-] Free disk (GB): 450
>2014-07-15 15:10:30.756 18350 AUDIT nova.compute.resource_tracker [-] Free VCPUS: 6
>2014-07-15 15:10:30.795 18350 INFO nova.compute.resource_tracker [-] Compute_service record updated for cougar11.scl.lab.tlv.redhat.com:cougar11.scl.lab.tlv.redhat.com
>2014-07-15 15:10:30.795 18350 DEBUG nova.openstack.common.lockutils [-] Semaphore / lock released "update_available_resource" inner /usr/lib/python2.6/site-packages/nova/openstack/common/lockutils.py:252
>2014-07-15 15:10:30.822 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager._poll_rebooting_instances run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:10:30.822 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager._reclaim_queued_deletes run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:10:30.822 18350 DEBUG nova.compute.manager [-] CONF.reclaim_instance_interval <= 0, skipping... _reclaim_queued_deletes /usr/lib/python2.6/site-packages/nova/compute/manager.py:5392
>2014-07-15 15:10:30.823 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager._poll_unconfirmed_resizes run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:10:30.823 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager._poll_rescued_instances run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:10:30.823 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager._check_instance_build_time run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:10:30.824 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager._heal_instance_info_cache run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:10:30.824 18350 DEBUG nova.compute.manager [-] Starting heal instance info cache _heal_instance_info_cache /usr/lib/python2.6/site-packages/nova/compute/manager.py:4817
>2014-07-15 15:10:30.824 18350 DEBUG nova.compute.manager [-] Rebuilding the list of instances to heal _heal_instance_info_cache /usr/lib/python2.6/site-packages/nova/compute/manager.py:4821
>2014-07-15 15:10:30.849 18350 DEBUG nova.compute.manager [-] Didn't find any instances for network info cache update. _heal_instance_info_cache /usr/lib/python2.6/site-packages/nova/compute/manager.py:4883
>2014-07-15 15:10:30.849 18350 DEBUG nova.openstack.common.loopingcall [-] Dynamic looping call sleeping for 60.00 seconds _inner /usr/lib/python2.6/site-packages/nova/openstack/common/loopingcall.py:132
>2014-07-15 15:11:30.849 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager._poll_volume_usage run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:11:30.850 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager._instance_usage_audit run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:11:30.850 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager.update_available_resource run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:11:30.850 18350 DEBUG nova.openstack.common.lockutils [-] Got semaphore "compute_resources" lock /usr/lib/python2.6/site-packages/nova/openstack/common/lockutils.py:168
>2014-07-15 15:11:30.851 18350 DEBUG nova.openstack.common.lockutils [-] Got semaphore / lock "update_available_resource" inner /usr/lib/python2.6/site-packages/nova/openstack/common/lockutils.py:248
>2014-07-15 15:11:30.851 18350 AUDIT nova.compute.resource_tracker [-] Auditing locally available compute resources
>2014-07-15 15:11:30.851 18350 DEBUG nova.virt.libvirt.driver [-] Updating host stats update_status /usr/lib/python2.6/site-packages/nova/virt/libvirt/driver.py:5311
>2014-07-15 15:11:30.929 18350 DEBUG nova.compute.resource_tracker [-] Hypervisor: free ram (MB): 15403 _report_hypervisor_resource_view /usr/lib/python2.6/site-packages/nova/compute/resource_tracker.py:409
>2014-07-15 15:11:30.929 18350 DEBUG nova.compute.resource_tracker [-] Hypervisor: free disk (GB): 449 _report_hypervisor_resource_view /usr/lib/python2.6/site-packages/nova/compute/resource_tracker.py:410
>2014-07-15 15:11:30.930 18350 DEBUG nova.compute.resource_tracker [-] Hypervisor: free VCPUs: 6 _report_hypervisor_resource_view /usr/lib/python2.6/site-packages/nova/compute/resource_tracker.py:415
>2014-07-15 15:11:30.930 18350 DEBUG nova.compute.resource_tracker [-] Hypervisor: assignable PCI devices: [] _report_hypervisor_resource_view /usr/lib/python2.6/site-packages/nova/compute/resource_tracker.py:422
>2014-07-15 15:11:30.979 18350 AUDIT nova.compute.resource_tracker [-] Free ram (MB): 15429
>2014-07-15 15:11:30.980 18350 AUDIT nova.compute.resource_tracker [-] Free disk (GB): 450
>2014-07-15 15:11:30.980 18350 AUDIT nova.compute.resource_tracker [-] Free VCPUS: 6
>2014-07-15 15:11:31.011 18350 INFO nova.compute.resource_tracker [-] Compute_service record updated for cougar11.scl.lab.tlv.redhat.com:cougar11.scl.lab.tlv.redhat.com
>2014-07-15 15:11:31.012 18350 DEBUG nova.openstack.common.lockutils [-] Semaphore / lock released "update_available_resource" inner /usr/lib/python2.6/site-packages/nova/openstack/common/lockutils.py:252
>2014-07-15 15:11:31.034 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager._poll_rebooting_instances run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:11:31.034 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager._reclaim_queued_deletes run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:11:31.034 18350 DEBUG nova.compute.manager [-] CONF.reclaim_instance_interval <= 0, skipping... _reclaim_queued_deletes /usr/lib/python2.6/site-packages/nova/compute/manager.py:5392
>2014-07-15 15:11:31.034 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager._poll_unconfirmed_resizes run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:11:31.035 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager._poll_rescued_instances run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:11:31.035 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager._check_instance_build_time run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:11:31.035 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager._heal_instance_info_cache run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:11:31.035 18350 DEBUG nova.compute.manager [-] Starting heal instance info cache _heal_instance_info_cache /usr/lib/python2.6/site-packages/nova/compute/manager.py:4817
>2014-07-15 15:11:31.036 18350 DEBUG nova.compute.manager [-] Rebuilding the list of instances to heal _heal_instance_info_cache /usr/lib/python2.6/site-packages/nova/compute/manager.py:4821
>2014-07-15 15:11:31.053 18350 DEBUG nova.compute.manager [-] Didn't find any instances for network info cache update. _heal_instance_info_cache /usr/lib/python2.6/site-packages/nova/compute/manager.py:4883
>2014-07-15 15:11:31.053 18350 DEBUG nova.openstack.common.loopingcall [-] Dynamic looping call sleeping for 60.00 seconds _inner /usr/lib/python2.6/site-packages/nova/openstack/common/loopingcall.py:132
>2014-07-15 15:12:31.054 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager._poll_volume_usage run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:12:31.054 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager._instance_usage_audit run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:12:31.054 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager.update_available_resource run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:12:31.055 18350 DEBUG nova.openstack.common.lockutils [-] Got semaphore "compute_resources" lock /usr/lib/python2.6/site-packages/nova/openstack/common/lockutils.py:168
>2014-07-15 15:12:31.055 18350 DEBUG nova.openstack.common.lockutils [-] Got semaphore / lock "update_available_resource" inner /usr/lib/python2.6/site-packages/nova/openstack/common/lockutils.py:248
>2014-07-15 15:12:31.055 18350 AUDIT nova.compute.resource_tracker [-] Auditing locally available compute resources
>2014-07-15 15:12:31.055 18350 DEBUG nova.virt.libvirt.driver [-] Updating host stats update_status /usr/lib/python2.6/site-packages/nova/virt/libvirt/driver.py:5311
>2014-07-15 15:12:31.134 18350 DEBUG nova.compute.resource_tracker [-] Hypervisor: free ram (MB): 15407 _report_hypervisor_resource_view /usr/lib/python2.6/site-packages/nova/compute/resource_tracker.py:409
>2014-07-15 15:12:31.134 18350 DEBUG nova.compute.resource_tracker [-] Hypervisor: free disk (GB): 449 _report_hypervisor_resource_view /usr/lib/python2.6/site-packages/nova/compute/resource_tracker.py:410
>2014-07-15 15:12:31.134 18350 DEBUG nova.compute.resource_tracker [-] Hypervisor: free VCPUs: 6 _report_hypervisor_resource_view /usr/lib/python2.6/site-packages/nova/compute/resource_tracker.py:415
>2014-07-15 15:12:31.135 18350 DEBUG nova.compute.resource_tracker [-] Hypervisor: assignable PCI devices: [] _report_hypervisor_resource_view /usr/lib/python2.6/site-packages/nova/compute/resource_tracker.py:422
>2014-07-15 15:12:31.162 18350 AUDIT nova.compute.resource_tracker [-] Free ram (MB): 15429
>2014-07-15 15:12:31.163 18350 AUDIT nova.compute.resource_tracker [-] Free disk (GB): 450
>2014-07-15 15:12:31.163 18350 AUDIT nova.compute.resource_tracker [-] Free VCPUS: 6
>2014-07-15 15:12:31.188 18350 INFO nova.compute.resource_tracker [-] Compute_service record updated for cougar11.scl.lab.tlv.redhat.com:cougar11.scl.lab.tlv.redhat.com
>2014-07-15 15:12:31.188 18350 DEBUG nova.openstack.common.lockutils [-] Semaphore / lock released "update_available_resource" inner /usr/lib/python2.6/site-packages/nova/openstack/common/lockutils.py:252
>2014-07-15 15:12:31.212 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager._poll_rebooting_instances run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:12:31.213 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager._reclaim_queued_deletes run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:12:31.213 18350 DEBUG nova.compute.manager [-] CONF.reclaim_instance_interval <= 0, skipping... _reclaim_queued_deletes /usr/lib/python2.6/site-packages/nova/compute/manager.py:5392
>2014-07-15 15:12:31.213 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager._poll_unconfirmed_resizes run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:12:31.213 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager._poll_rescued_instances run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:12:31.214 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager._check_instance_build_time run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:12:31.214 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager._heal_instance_info_cache run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:12:31.214 18350 DEBUG nova.compute.manager [-] Starting heal instance info cache _heal_instance_info_cache /usr/lib/python2.6/site-packages/nova/compute/manager.py:4817
>2014-07-15 15:12:31.214 18350 DEBUG nova.compute.manager [-] Rebuilding the list of instances to heal _heal_instance_info_cache /usr/lib/python2.6/site-packages/nova/compute/manager.py:4821
>2014-07-15 15:12:31.227 18350 DEBUG nova.compute.manager [-] Didn't find any instances for network info cache update. _heal_instance_info_cache /usr/lib/python2.6/site-packages/nova/compute/manager.py:4883
>2014-07-15 15:12:31.227 18350 DEBUG nova.openstack.common.loopingcall [-] Dynamic looping call sleeping for 59.17 seconds _inner /usr/lib/python2.6/site-packages/nova/openstack/common/loopingcall.py:132
>2014-07-15 15:13:30.404 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager._poll_volume_usage run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:13:30.404 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager._instance_usage_audit run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:13:30.404 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager.update_available_resource run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:13:30.405 18350 DEBUG nova.openstack.common.lockutils [-] Got semaphore "compute_resources" lock /usr/lib/python2.6/site-packages/nova/openstack/common/lockutils.py:168
>2014-07-15 15:13:30.405 18350 DEBUG nova.openstack.common.lockutils [-] Got semaphore / lock "update_available_resource" inner /usr/lib/python2.6/site-packages/nova/openstack/common/lockutils.py:248
>2014-07-15 15:13:30.405 18350 AUDIT nova.compute.resource_tracker [-] Auditing locally available compute resources
>2014-07-15 15:13:30.405 18350 DEBUG nova.virt.libvirt.driver [-] Updating host stats update_status /usr/lib/python2.6/site-packages/nova/virt/libvirt/driver.py:5311
>2014-07-15 15:13:30.484 18350 DEBUG nova.compute.resource_tracker [-] Hypervisor: free ram (MB): 15413 _report_hypervisor_resource_view /usr/lib/python2.6/site-packages/nova/compute/resource_tracker.py:409
>2014-07-15 15:13:30.484 18350 DEBUG nova.compute.resource_tracker [-] Hypervisor: free disk (GB): 449 _report_hypervisor_resource_view /usr/lib/python2.6/site-packages/nova/compute/resource_tracker.py:410
>2014-07-15 15:13:30.484 18350 DEBUG nova.compute.resource_tracker [-] Hypervisor: free VCPUs: 6 _report_hypervisor_resource_view /usr/lib/python2.6/site-packages/nova/compute/resource_tracker.py:415
>2014-07-15 15:13:30.485 18350 DEBUG nova.compute.resource_tracker [-] Hypervisor: assignable PCI devices: [] _report_hypervisor_resource_view /usr/lib/python2.6/site-packages/nova/compute/resource_tracker.py:422
>2014-07-15 15:13:30.527 18350 AUDIT nova.compute.resource_tracker [-] Free ram (MB): 15429
>2014-07-15 15:13:30.527 18350 AUDIT nova.compute.resource_tracker [-] Free disk (GB): 450
>2014-07-15 15:13:30.527 18350 AUDIT nova.compute.resource_tracker [-] Free VCPUS: 6
>2014-07-15 15:13:30.558 18350 INFO nova.compute.resource_tracker [-] Compute_service record updated for cougar11.scl.lab.tlv.redhat.com:cougar11.scl.lab.tlv.redhat.com
>2014-07-15 15:13:30.559 18350 DEBUG nova.openstack.common.lockutils [-] Semaphore / lock released "update_available_resource" inner /usr/lib/python2.6/site-packages/nova/openstack/common/lockutils.py:252
>2014-07-15 15:13:30.580 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager._poll_rebooting_instances run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:13:30.580 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager._reclaim_queued_deletes run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:13:30.581 18350 DEBUG nova.compute.manager [-] CONF.reclaim_instance_interval <= 0, skipping... _reclaim_queued_deletes /usr/lib/python2.6/site-packages/nova/compute/manager.py:5392
>2014-07-15 15:13:30.581 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager._poll_unconfirmed_resizes run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:13:30.581 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager._poll_rescued_instances run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:13:30.581 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager._run_pending_deletes run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:13:30.582 18350 DEBUG nova.compute.manager [-] Cleaning up deleted instances _run_pending_deletes /usr/lib/python2.6/site-packages/nova/compute/manager.py:5670
>2014-07-15 15:13:30.596 18350 DEBUG nova.compute.manager [-] There are 0 instances to clean _run_pending_deletes /usr/lib/python2.6/site-packages/nova/compute/manager.py:5679
>2014-07-15 15:13:30.596 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager._check_instance_build_time run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:13:30.596 18350 DEBUG nova.openstack.common.loopingcall [-] Dynamic looping call sleeping for 0.62 seconds _inner /usr/lib/python2.6/site-packages/nova/openstack/common/loopingcall.py:132
>2014-07-15 15:13:31.214 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager._poll_volume_usage run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:13:31.215 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager._instance_usage_audit run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:13:31.215 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager.update_available_resource run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:13:31.215 18350 DEBUG nova.openstack.common.lockutils [-] Got semaphore "compute_resources" lock /usr/lib/python2.6/site-packages/nova/openstack/common/lockutils.py:168
>2014-07-15 15:13:31.216 18350 DEBUG nova.openstack.common.lockutils [-] Got semaphore / lock "update_available_resource" inner /usr/lib/python2.6/site-packages/nova/openstack/common/lockutils.py:248
>2014-07-15 15:13:31.216 18350 AUDIT nova.compute.resource_tracker [-] Auditing locally available compute resources
>2014-07-15 15:13:31.216 18350 DEBUG nova.virt.libvirt.driver [-] Updating host stats update_status /usr/lib/python2.6/site-packages/nova/virt/libvirt/driver.py:5311
>2014-07-15 15:13:31.294 18350 DEBUG nova.compute.resource_tracker [-] Hypervisor: free ram (MB): 15413 _report_hypervisor_resource_view /usr/lib/python2.6/site-packages/nova/compute/resource_tracker.py:409
>2014-07-15 15:13:31.294 18350 DEBUG nova.compute.resource_tracker [-] Hypervisor: free disk (GB): 449 _report_hypervisor_resource_view /usr/lib/python2.6/site-packages/nova/compute/resource_tracker.py:410
>2014-07-15 15:13:31.294 18350 DEBUG nova.compute.resource_tracker [-] Hypervisor: free VCPUs: 6 _report_hypervisor_resource_view /usr/lib/python2.6/site-packages/nova/compute/resource_tracker.py:415
>2014-07-15 15:13:31.295 18350 DEBUG nova.compute.resource_tracker [-] Hypervisor: assignable PCI devices: [] _report_hypervisor_resource_view /usr/lib/python2.6/site-packages/nova/compute/resource_tracker.py:422
>2014-07-15 15:13:31.323 18350 AUDIT nova.compute.resource_tracker [-] Free ram (MB): 15429
>2014-07-15 15:13:31.323 18350 AUDIT nova.compute.resource_tracker [-] Free disk (GB): 450
>2014-07-15 15:13:31.324 18350 AUDIT nova.compute.resource_tracker [-] Free VCPUS: 6
>2014-07-15 15:13:31.350 18350 INFO nova.compute.resource_tracker [-] Compute_service record updated for cougar11.scl.lab.tlv.redhat.com:cougar11.scl.lab.tlv.redhat.com
>2014-07-15 15:13:31.350 18350 DEBUG nova.openstack.common.lockutils [-] Semaphore / lock released "update_available_resource" inner /usr/lib/python2.6/site-packages/nova/openstack/common/lockutils.py:252
>2014-07-15 15:13:31.378 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager._poll_rebooting_instances run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:13:31.378 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager._reclaim_queued_deletes run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:13:31.378 18350 DEBUG nova.compute.manager [-] CONF.reclaim_instance_interval <= 0, skipping... _reclaim_queued_deletes /usr/lib/python2.6/site-packages/nova/compute/manager.py:5392
>2014-07-15 15:13:31.379 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager._poll_unconfirmed_resizes run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:13:31.379 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager._poll_rescued_instances run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:13:31.379 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager._check_instance_build_time run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:13:31.380 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager._heal_instance_info_cache run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:13:31.380 18350 DEBUG nova.compute.manager [-] Starting heal instance info cache _heal_instance_info_cache /usr/lib/python2.6/site-packages/nova/compute/manager.py:4817
>2014-07-15 15:13:31.380 18350 DEBUG nova.compute.manager [-] Rebuilding the list of instances to heal _heal_instance_info_cache /usr/lib/python2.6/site-packages/nova/compute/manager.py:4821
>2014-07-15 15:13:31.399 18350 DEBUG nova.compute.manager [-] Didn't find any instances for network info cache update. _heal_instance_info_cache /usr/lib/python2.6/site-packages/nova/compute/manager.py:4883
>2014-07-15 15:13:31.399 18350 DEBUG nova.openstack.common.loopingcall [-] Dynamic looping call sleeping for 60.00 seconds _inner /usr/lib/python2.6/site-packages/nova/openstack/common/loopingcall.py:132
>2014-07-15 15:14:31.400 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager._poll_volume_usage run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:14:31.400 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager._instance_usage_audit run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:14:31.400 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager.update_available_resource run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:14:31.401 18350 DEBUG nova.openstack.common.lockutils [-] Got semaphore "compute_resources" lock /usr/lib/python2.6/site-packages/nova/openstack/common/lockutils.py:168
>2014-07-15 15:14:31.401 18350 DEBUG nova.openstack.common.lockutils [-] Got semaphore / lock "update_available_resource" inner /usr/lib/python2.6/site-packages/nova/openstack/common/lockutils.py:248
>2014-07-15 15:14:31.401 18350 AUDIT nova.compute.resource_tracker [-] Auditing locally available compute resources
>2014-07-15 15:14:31.401 18350 DEBUG nova.virt.libvirt.driver [-] Updating host stats update_status /usr/lib/python2.6/site-packages/nova/virt/libvirt/driver.py:5311
>2014-07-15 15:14:31.480 18350 DEBUG nova.compute.resource_tracker [-] Hypervisor: free ram (MB): 15413 _report_hypervisor_resource_view /usr/lib/python2.6/site-packages/nova/compute/resource_tracker.py:409
>2014-07-15 15:14:31.480 18350 DEBUG nova.compute.resource_tracker [-] Hypervisor: free disk (GB): 449 _report_hypervisor_resource_view /usr/lib/python2.6/site-packages/nova/compute/resource_tracker.py:410
>2014-07-15 15:14:31.480 18350 DEBUG nova.compute.resource_tracker [-] Hypervisor: free VCPUs: 6 _report_hypervisor_resource_view /usr/lib/python2.6/site-packages/nova/compute/resource_tracker.py:415
>2014-07-15 15:14:31.480 18350 DEBUG nova.compute.resource_tracker [-] Hypervisor: assignable PCI devices: [] _report_hypervisor_resource_view /usr/lib/python2.6/site-packages/nova/compute/resource_tracker.py:422
>2014-07-15 15:14:31.517 18350 AUDIT nova.compute.resource_tracker [-] Free ram (MB): 15429
>2014-07-15 15:14:31.517 18350 AUDIT nova.compute.resource_tracker [-] Free disk (GB): 450
>2014-07-15 15:14:31.518 18350 AUDIT nova.compute.resource_tracker [-] Free VCPUS: 6
>2014-07-15 15:14:31.548 18350 INFO nova.compute.resource_tracker [-] Compute_service record updated for cougar11.scl.lab.tlv.redhat.com:cougar11.scl.lab.tlv.redhat.com
>2014-07-15 15:14:31.548 18350 DEBUG nova.openstack.common.lockutils [-] Semaphore / lock released "update_available_resource" inner /usr/lib/python2.6/site-packages/nova/openstack/common/lockutils.py:252
>2014-07-15 15:14:31.567 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager._poll_rebooting_instances run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:14:31.568 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager._reclaim_queued_deletes run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:14:31.568 18350 DEBUG nova.compute.manager [-] CONF.reclaim_instance_interval <= 0, skipping... _reclaim_queued_deletes /usr/lib/python2.6/site-packages/nova/compute/manager.py:5392
>2014-07-15 15:14:31.568 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager._poll_unconfirmed_resizes run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:14:31.569 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager._poll_rescued_instances run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:14:31.569 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager._check_instance_build_time run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:14:31.569 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager._heal_instance_info_cache run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:14:31.569 18350 DEBUG nova.compute.manager [-] Starting heal instance info cache _heal_instance_info_cache /usr/lib/python2.6/site-packages/nova/compute/manager.py:4817
>2014-07-15 15:14:31.570 18350 DEBUG nova.compute.manager [-] Rebuilding the list of instances to heal _heal_instance_info_cache /usr/lib/python2.6/site-packages/nova/compute/manager.py:4821
>2014-07-15 15:14:31.592 18350 DEBUG nova.compute.manager [-] Didn't find any instances for network info cache update. _heal_instance_info_cache /usr/lib/python2.6/site-packages/nova/compute/manager.py:4883
>2014-07-15 15:14:31.592 18350 DEBUG nova.openstack.common.loopingcall [-] Dynamic looping call sleeping for 60.00 seconds _inner /usr/lib/python2.6/site-packages/nova/openstack/common/loopingcall.py:132
>2014-07-15 15:15:31.592 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager._poll_volume_usage run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:15:31.594 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager._instance_usage_audit run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:15:31.595 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager.update_available_resource run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:15:31.595 18350 DEBUG nova.openstack.common.lockutils [-] Got semaphore "compute_resources" lock /usr/lib/python2.6/site-packages/nova/openstack/common/lockutils.py:168
>2014-07-15 15:15:31.595 18350 DEBUG nova.openstack.common.lockutils [-] Got semaphore / lock "update_available_resource" inner /usr/lib/python2.6/site-packages/nova/openstack/common/lockutils.py:248
>2014-07-15 15:15:31.595 18350 AUDIT nova.compute.resource_tracker [-] Auditing locally available compute resources
>2014-07-15 15:15:31.596 18350 DEBUG nova.virt.libvirt.driver [-] Updating host stats update_status /usr/lib/python2.6/site-packages/nova/virt/libvirt/driver.py:5311
>2014-07-15 15:15:31.692 18350 DEBUG nova.compute.resource_tracker [-] Hypervisor: free ram (MB): 15366 _report_hypervisor_resource_view /usr/lib/python2.6/site-packages/nova/compute/resource_tracker.py:409
>2014-07-15 15:15:31.692 18350 DEBUG nova.compute.resource_tracker [-] Hypervisor: free disk (GB): 449 _report_hypervisor_resource_view /usr/lib/python2.6/site-packages/nova/compute/resource_tracker.py:410
>2014-07-15 15:15:31.692 18350 DEBUG nova.compute.resource_tracker [-] Hypervisor: free VCPUs: 6 _report_hypervisor_resource_view /usr/lib/python2.6/site-packages/nova/compute/resource_tracker.py:415
>2014-07-15 15:15:31.692 18350 DEBUG nova.compute.resource_tracker [-] Hypervisor: assignable PCI devices: [] _report_hypervisor_resource_view /usr/lib/python2.6/site-packages/nova/compute/resource_tracker.py:422
>2014-07-15 15:15:31.728 18350 AUDIT nova.compute.resource_tracker [-] Free ram (MB): 15429
>2014-07-15 15:15:31.728 18350 AUDIT nova.compute.resource_tracker [-] Free disk (GB): 450
>2014-07-15 15:15:31.728 18350 AUDIT nova.compute.resource_tracker [-] Free VCPUS: 6
>2014-07-15 15:15:31.747 18350 INFO nova.compute.resource_tracker [-] Compute_service record updated for cougar11.scl.lab.tlv.redhat.com:cougar11.scl.lab.tlv.redhat.com
>2014-07-15 15:15:31.748 18350 DEBUG nova.openstack.common.lockutils [-] Semaphore / lock released "update_available_resource" inner /usr/lib/python2.6/site-packages/nova/openstack/common/lockutils.py:252
>2014-07-15 15:15:31.764 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager._poll_rebooting_instances run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:15:31.764 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager._reclaim_queued_deletes run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:15:31.764 18350 DEBUG nova.compute.manager [-] CONF.reclaim_instance_interval <= 0, skipping... _reclaim_queued_deletes /usr/lib/python2.6/site-packages/nova/compute/manager.py:5392
>2014-07-15 15:15:31.765 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager._poll_unconfirmed_resizes run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:15:31.765 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager._poll_rescued_instances run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:15:31.765 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager._check_instance_build_time run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:15:31.766 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager._heal_instance_info_cache run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:15:31.766 18350 DEBUG nova.compute.manager [-] Starting heal instance info cache _heal_instance_info_cache /usr/lib/python2.6/site-packages/nova/compute/manager.py:4817
>2014-07-15 15:15:31.766 18350 DEBUG nova.compute.manager [-] Rebuilding the list of instances to heal _heal_instance_info_cache /usr/lib/python2.6/site-packages/nova/compute/manager.py:4821
>2014-07-15 15:15:31.779 18350 DEBUG nova.compute.manager [-] Didn't find any instances for network info cache update. _heal_instance_info_cache /usr/lib/python2.6/site-packages/nova/compute/manager.py:4883
>2014-07-15 15:15:31.779 18350 DEBUG nova.openstack.common.loopingcall [-] Dynamic looping call sleeping for 60.00 seconds _inner /usr/lib/python2.6/site-packages/nova/openstack/common/loopingcall.py:132
>2014-07-15 15:16:31.779 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager._poll_volume_usage run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:16:31.781 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager._instance_usage_audit run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:16:31.781 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager.update_available_resource run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:16:31.782 18350 DEBUG nova.openstack.common.lockutils [-] Got semaphore "compute_resources" lock /usr/lib/python2.6/site-packages/nova/openstack/common/lockutils.py:168
>2014-07-15 15:16:31.782 18350 DEBUG nova.openstack.common.lockutils [-] Got semaphore / lock "update_available_resource" inner /usr/lib/python2.6/site-packages/nova/openstack/common/lockutils.py:248
>2014-07-15 15:16:31.782 18350 AUDIT nova.compute.resource_tracker [-] Auditing locally available compute resources
>2014-07-15 15:16:31.782 18350 DEBUG nova.virt.libvirt.driver [-] Updating host stats update_status /usr/lib/python2.6/site-packages/nova/virt/libvirt/driver.py:5311
>2014-07-15 15:16:31.868 18350 DEBUG nova.compute.resource_tracker [-] Hypervisor: free ram (MB): 15400 _report_hypervisor_resource_view /usr/lib/python2.6/site-packages/nova/compute/resource_tracker.py:409
>2014-07-15 15:16:31.868 18350 DEBUG nova.compute.resource_tracker [-] Hypervisor: free disk (GB): 449 _report_hypervisor_resource_view /usr/lib/python2.6/site-packages/nova/compute/resource_tracker.py:410
>2014-07-15 15:16:31.869 18350 DEBUG nova.compute.resource_tracker [-] Hypervisor: free VCPUs: 6 _report_hypervisor_resource_view /usr/lib/python2.6/site-packages/nova/compute/resource_tracker.py:415
>2014-07-15 15:16:31.869 18350 DEBUG nova.compute.resource_tracker [-] Hypervisor: assignable PCI devices: [] _report_hypervisor_resource_view /usr/lib/python2.6/site-packages/nova/compute/resource_tracker.py:422
>2014-07-15 15:16:31.903 18350 AUDIT nova.compute.resource_tracker [-] Free ram (MB): 15429
>2014-07-15 15:16:31.903 18350 AUDIT nova.compute.resource_tracker [-] Free disk (GB): 450
>2014-07-15 15:16:31.903 18350 AUDIT nova.compute.resource_tracker [-] Free VCPUS: 6
>2014-07-15 15:16:31.933 18350 INFO nova.compute.resource_tracker [-] Compute_service record updated for cougar11.scl.lab.tlv.redhat.com:cougar11.scl.lab.tlv.redhat.com
>2014-07-15 15:16:31.934 18350 DEBUG nova.openstack.common.lockutils [-] Semaphore / lock released "update_available_resource" inner /usr/lib/python2.6/site-packages/nova/openstack/common/lockutils.py:252
>2014-07-15 15:16:31.957 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager._poll_rebooting_instances run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:16:31.957 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager._reclaim_queued_deletes run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:16:31.957 18350 DEBUG nova.compute.manager [-] CONF.reclaim_instance_interval <= 0, skipping... _reclaim_queued_deletes /usr/lib/python2.6/site-packages/nova/compute/manager.py:5392
>2014-07-15 15:16:31.957 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager._poll_unconfirmed_resizes run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:16:31.958 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager._poll_rescued_instances run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:16:31.958 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager._check_instance_build_time run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:16:31.958 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager._heal_instance_info_cache run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:16:31.958 18350 DEBUG nova.compute.manager [-] Starting heal instance info cache _heal_instance_info_cache /usr/lib/python2.6/site-packages/nova/compute/manager.py:4817
>2014-07-15 15:16:31.959 18350 DEBUG nova.compute.manager [-] Rebuilding the list of instances to heal _heal_instance_info_cache /usr/lib/python2.6/site-packages/nova/compute/manager.py:4821
>2014-07-15 15:16:31.980 18350 DEBUG nova.compute.manager [-] Didn't find any instances for network info cache update. _heal_instance_info_cache /usr/lib/python2.6/site-packages/nova/compute/manager.py:4883
>2014-07-15 15:16:31.980 18350 DEBUG nova.openstack.common.loopingcall [-] Dynamic looping call sleeping for 60.00 seconds _inner /usr/lib/python2.6/site-packages/nova/openstack/common/loopingcall.py:132
>2014-07-15 15:17:31.980 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager._poll_volume_usage run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:17:31.982 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager._instance_usage_audit run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:17:31.982 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager.update_available_resource run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:17:31.983 18350 DEBUG nova.openstack.common.lockutils [-] Got semaphore "compute_resources" lock /usr/lib/python2.6/site-packages/nova/openstack/common/lockutils.py:168
>2014-07-15 15:17:31.983 18350 DEBUG nova.openstack.common.lockutils [-] Got semaphore / lock "update_available_resource" inner /usr/lib/python2.6/site-packages/nova/openstack/common/lockutils.py:248
>2014-07-15 15:17:31.983 18350 AUDIT nova.compute.resource_tracker [-] Auditing locally available compute resources
>2014-07-15 15:17:31.983 18350 DEBUG nova.virt.libvirt.driver [-] Updating host stats update_status /usr/lib/python2.6/site-packages/nova/virt/libvirt/driver.py:5311
>2014-07-15 15:17:32.069 18350 DEBUG nova.compute.resource_tracker [-] Hypervisor: free ram (MB): 15400 _report_hypervisor_resource_view /usr/lib/python2.6/site-packages/nova/compute/resource_tracker.py:409
>2014-07-15 15:17:32.069 18350 DEBUG nova.compute.resource_tracker [-] Hypervisor: free disk (GB): 449 _report_hypervisor_resource_view /usr/lib/python2.6/site-packages/nova/compute/resource_tracker.py:410
>2014-07-15 15:17:32.070 18350 DEBUG nova.compute.resource_tracker [-] Hypervisor: free VCPUs: 6 _report_hypervisor_resource_view /usr/lib/python2.6/site-packages/nova/compute/resource_tracker.py:415
>2014-07-15 15:17:32.070 18350 DEBUG nova.compute.resource_tracker [-] Hypervisor: assignable PCI devices: [] _report_hypervisor_resource_view /usr/lib/python2.6/site-packages/nova/compute/resource_tracker.py:422
>2014-07-15 15:17:32.115 18350 AUDIT nova.compute.resource_tracker [-] Free ram (MB): 15429
>2014-07-15 15:17:32.115 18350 AUDIT nova.compute.resource_tracker [-] Free disk (GB): 450
>2014-07-15 15:17:32.116 18350 AUDIT nova.compute.resource_tracker [-] Free VCPUS: 6
>2014-07-15 15:17:32.191 18350 INFO nova.compute.resource_tracker [-] Compute_service record updated for cougar11.scl.lab.tlv.redhat.com:cougar11.scl.lab.tlv.redhat.com
>2014-07-15 15:17:32.191 18350 DEBUG nova.openstack.common.lockutils [-] Semaphore / lock released "update_available_resource" inner /usr/lib/python2.6/site-packages/nova/openstack/common/lockutils.py:252
>2014-07-15 15:17:32.220 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager._poll_rebooting_instances run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:17:32.220 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager._reclaim_queued_deletes run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:17:32.220 18350 DEBUG nova.compute.manager [-] CONF.reclaim_instance_interval <= 0, skipping... _reclaim_queued_deletes /usr/lib/python2.6/site-packages/nova/compute/manager.py:5392
>2014-07-15 15:17:32.220 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager._poll_unconfirmed_resizes run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:17:32.221 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager._poll_rescued_instances run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:17:32.221 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager._check_instance_build_time run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:17:32.221 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager._heal_instance_info_cache run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:17:32.221 18350 DEBUG nova.compute.manager [-] Starting heal instance info cache _heal_instance_info_cache /usr/lib/python2.6/site-packages/nova/compute/manager.py:4817
>2014-07-15 15:17:32.222 18350 DEBUG nova.compute.manager [-] Rebuilding the list of instances to heal _heal_instance_info_cache /usr/lib/python2.6/site-packages/nova/compute/manager.py:4821
>2014-07-15 15:17:32.241 18350 DEBUG nova.compute.manager [-] Didn't find any instances for network info cache update. _heal_instance_info_cache /usr/lib/python2.6/site-packages/nova/compute/manager.py:4883
>2014-07-15 15:17:32.241 18350 DEBUG nova.openstack.common.loopingcall [-] Dynamic looping call sleeping for 58.17 seconds _inner /usr/lib/python2.6/site-packages/nova/openstack/common/loopingcall.py:132
>2014-07-15 15:18:30.410 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager._poll_volume_usage run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:18:30.410 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager._instance_usage_audit run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:18:30.410 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager.update_available_resource run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:18:30.410 18350 DEBUG nova.openstack.common.lockutils [-] Got semaphore "compute_resources" lock /usr/lib/python2.6/site-packages/nova/openstack/common/lockutils.py:168
>2014-07-15 15:18:30.411 18350 DEBUG nova.openstack.common.lockutils [-] Got semaphore / lock "update_available_resource" inner /usr/lib/python2.6/site-packages/nova/openstack/common/lockutils.py:248
>2014-07-15 15:18:30.411 18350 AUDIT nova.compute.resource_tracker [-] Auditing locally available compute resources
>2014-07-15 15:18:30.411 18350 DEBUG nova.virt.libvirt.driver [-] Updating host stats update_status /usr/lib/python2.6/site-packages/nova/virt/libvirt/driver.py:5311
>2014-07-15 15:18:30.490 18350 DEBUG nova.compute.resource_tracker [-] Hypervisor: free ram (MB): 15414 _report_hypervisor_resource_view /usr/lib/python2.6/site-packages/nova/compute/resource_tracker.py:409
>2014-07-15 15:18:30.490 18350 DEBUG nova.compute.resource_tracker [-] Hypervisor: free disk (GB): 449 _report_hypervisor_resource_view /usr/lib/python2.6/site-packages/nova/compute/resource_tracker.py:410
>2014-07-15 15:18:30.490 18350 DEBUG nova.compute.resource_tracker [-] Hypervisor: free VCPUs: 6 _report_hypervisor_resource_view /usr/lib/python2.6/site-packages/nova/compute/resource_tracker.py:415
>2014-07-15 15:18:30.490 18350 DEBUG nova.compute.resource_tracker [-] Hypervisor: assignable PCI devices: [] _report_hypervisor_resource_view /usr/lib/python2.6/site-packages/nova/compute/resource_tracker.py:422
>2014-07-15 15:18:30.535 18350 AUDIT nova.compute.resource_tracker [-] Free ram (MB): 15429
>2014-07-15 15:18:30.535 18350 AUDIT nova.compute.resource_tracker [-] Free disk (GB): 450
>2014-07-15 15:18:30.536 18350 AUDIT nova.compute.resource_tracker [-] Free VCPUS: 6
>2014-07-15 15:18:30.563 18350 INFO nova.compute.resource_tracker [-] Compute_service record updated for cougar11.scl.lab.tlv.redhat.com:cougar11.scl.lab.tlv.redhat.com
>2014-07-15 15:18:30.563 18350 DEBUG nova.openstack.common.lockutils [-] Semaphore / lock released "update_available_resource" inner /usr/lib/python2.6/site-packages/nova/openstack/common/lockutils.py:252
>2014-07-15 15:18:30.593 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager._poll_rebooting_instances run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:18:30.593 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager._reclaim_queued_deletes run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:18:30.593 18350 DEBUG nova.compute.manager [-] CONF.reclaim_instance_interval <= 0, skipping... _reclaim_queued_deletes /usr/lib/python2.6/site-packages/nova/compute/manager.py:5392
>2014-07-15 15:18:30.594 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager._poll_unconfirmed_resizes run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:18:30.594 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager._poll_rescued_instances run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:18:30.594 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager._poll_bandwidth_usage run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:18:30.595 18350 INFO nova.compute.manager [-] Updating bandwidth usage cache
>2014-07-15 15:18:30.619 18350 WARNING nova.compute.manager [-] Bandwidth usage not supported by hypervisor.
>2014-07-15 15:18:30.619 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager._run_pending_deletes run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:18:30.619 18350 DEBUG nova.compute.manager [-] Cleaning up deleted instances _run_pending_deletes /usr/lib/python2.6/site-packages/nova/compute/manager.py:5670
>2014-07-15 15:18:30.641 18350 DEBUG nova.compute.manager [-] There are 0 instances to clean _run_pending_deletes /usr/lib/python2.6/site-packages/nova/compute/manager.py:5679
>2014-07-15 15:18:30.641 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager._check_instance_build_time run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:18:30.642 18350 DEBUG nova.openstack.common.loopingcall [-] Dynamic looping call sleeping for 1.58 seconds _inner /usr/lib/python2.6/site-packages/nova/openstack/common/loopingcall.py:132
>2014-07-15 15:18:32.222 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager._poll_volume_usage run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:18:32.222 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager._instance_usage_audit run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:18:32.222 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager.update_available_resource run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:18:32.223 18350 DEBUG nova.openstack.common.lockutils [-] Got semaphore "compute_resources" lock /usr/lib/python2.6/site-packages/nova/openstack/common/lockutils.py:168
>2014-07-15 15:18:32.223 18350 DEBUG nova.openstack.common.lockutils [-] Got semaphore / lock "update_available_resource" inner /usr/lib/python2.6/site-packages/nova/openstack/common/lockutils.py:248
>2014-07-15 15:18:32.223 18350 AUDIT nova.compute.resource_tracker [-] Auditing locally available compute resources
>2014-07-15 15:18:32.223 18350 DEBUG nova.virt.libvirt.driver [-] Updating host stats update_status /usr/lib/python2.6/site-packages/nova/virt/libvirt/driver.py:5311
>2014-07-15 15:18:32.302 18350 DEBUG nova.compute.resource_tracker [-] Hypervisor: free ram (MB): 15414 _report_hypervisor_resource_view /usr/lib/python2.6/site-packages/nova/compute/resource_tracker.py:409
>2014-07-15 15:18:32.302 18350 DEBUG nova.compute.resource_tracker [-] Hypervisor: free disk (GB): 449 _report_hypervisor_resource_view /usr/lib/python2.6/site-packages/nova/compute/resource_tracker.py:410
>2014-07-15 15:18:32.303 18350 DEBUG nova.compute.resource_tracker [-] Hypervisor: free VCPUs: 6 _report_hypervisor_resource_view /usr/lib/python2.6/site-packages/nova/compute/resource_tracker.py:415
>2014-07-15 15:18:32.303 18350 DEBUG nova.compute.resource_tracker [-] Hypervisor: assignable PCI devices: [] _report_hypervisor_resource_view /usr/lib/python2.6/site-packages/nova/compute/resource_tracker.py:422
>2014-07-15 15:18:32.349 18350 AUDIT nova.compute.resource_tracker [-] Free ram (MB): 15429
>2014-07-15 15:18:32.349 18350 AUDIT nova.compute.resource_tracker [-] Free disk (GB): 450
>2014-07-15 15:18:32.349 18350 AUDIT nova.compute.resource_tracker [-] Free VCPUS: 6
>2014-07-15 15:18:32.377 18350 INFO nova.compute.resource_tracker [-] Compute_service record updated for cougar11.scl.lab.tlv.redhat.com:cougar11.scl.lab.tlv.redhat.com
>2014-07-15 15:18:32.378 18350 DEBUG nova.openstack.common.lockutils [-] Semaphore / lock released "update_available_resource" inner /usr/lib/python2.6/site-packages/nova/openstack/common/lockutils.py:252
>2014-07-15 15:18:32.402 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager._poll_rebooting_instances run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:18:32.402 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager._reclaim_queued_deletes run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:18:32.402 18350 DEBUG nova.compute.manager [-] CONF.reclaim_instance_interval <= 0, skipping... _reclaim_queued_deletes /usr/lib/python2.6/site-packages/nova/compute/manager.py:5392
>2014-07-15 15:18:32.402 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager._poll_unconfirmed_resizes run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:18:32.403 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager._poll_rescued_instances run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:18:32.403 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager._check_instance_build_time run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:18:32.403 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager._heal_instance_info_cache run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:18:32.403 18350 DEBUG nova.compute.manager [-] Starting heal instance info cache _heal_instance_info_cache /usr/lib/python2.6/site-packages/nova/compute/manager.py:4817
>2014-07-15 15:18:32.404 18350 DEBUG nova.compute.manager [-] Rebuilding the list of instances to heal _heal_instance_info_cache /usr/lib/python2.6/site-packages/nova/compute/manager.py:4821
>2014-07-15 15:18:32.423 18350 DEBUG nova.compute.manager [-] Didn't find any instances for network info cache update. _heal_instance_info_cache /usr/lib/python2.6/site-packages/nova/compute/manager.py:4883
>2014-07-15 15:18:32.423 18350 DEBUG nova.openstack.common.loopingcall [-] Dynamic looping call sleeping for 47.33 seconds _inner /usr/lib/python2.6/site-packages/nova/openstack/common/loopingcall.py:132
>2014-07-15 15:19:19.752 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager._poll_volume_usage run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:19:19.753 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager._instance_usage_audit run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:19:19.753 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager.update_available_resource run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:19:19.753 18350 DEBUG nova.openstack.common.lockutils [-] Got semaphore "compute_resources" lock /usr/lib/python2.6/site-packages/nova/openstack/common/lockutils.py:168
>2014-07-15 15:19:19.754 18350 DEBUG nova.openstack.common.lockutils [-] Got semaphore / lock "update_available_resource" inner /usr/lib/python2.6/site-packages/nova/openstack/common/lockutils.py:248
>2014-07-15 15:19:19.754 18350 AUDIT nova.compute.resource_tracker [-] Auditing locally available compute resources
>2014-07-15 15:19:19.754 18350 DEBUG nova.virt.libvirt.driver [-] Updating host stats update_status /usr/lib/python2.6/site-packages/nova/virt/libvirt/driver.py:5311
>2014-07-15 15:19:19.837 18350 DEBUG nova.compute.resource_tracker [-] Hypervisor: free ram (MB): 15414 _report_hypervisor_resource_view /usr/lib/python2.6/site-packages/nova/compute/resource_tracker.py:409
>2014-07-15 15:19:19.837 18350 DEBUG nova.compute.resource_tracker [-] Hypervisor: free disk (GB): 449 _report_hypervisor_resource_view /usr/lib/python2.6/site-packages/nova/compute/resource_tracker.py:410
>2014-07-15 15:19:19.837 18350 DEBUG nova.compute.resource_tracker [-] Hypervisor: free VCPUs: 6 _report_hypervisor_resource_view /usr/lib/python2.6/site-packages/nova/compute/resource_tracker.py:415
>2014-07-15 15:19:19.837 18350 DEBUG nova.compute.resource_tracker [-] Hypervisor: assignable PCI devices: [] _report_hypervisor_resource_view /usr/lib/python2.6/site-packages/nova/compute/resource_tracker.py:422
>2014-07-15 15:19:19.884 18350 AUDIT nova.compute.resource_tracker [-] Free ram (MB): 15429
>2014-07-15 15:19:19.884 18350 AUDIT nova.compute.resource_tracker [-] Free disk (GB): 450
>2014-07-15 15:19:19.884 18350 AUDIT nova.compute.resource_tracker [-] Free VCPUS: 6
>2014-07-15 15:19:19.917 18350 INFO nova.compute.resource_tracker [-] Compute_service record updated for cougar11.scl.lab.tlv.redhat.com:cougar11.scl.lab.tlv.redhat.com
>2014-07-15 15:19:19.917 18350 DEBUG nova.openstack.common.lockutils [-] Semaphore / lock released "update_available_resource" inner /usr/lib/python2.6/site-packages/nova/openstack/common/lockutils.py:252
>2014-07-15 15:19:19.942 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager._poll_rebooting_instances run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:19:19.942 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager._reclaim_queued_deletes run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:19:19.942 18350 DEBUG nova.compute.manager [-] CONF.reclaim_instance_interval <= 0, skipping... _reclaim_queued_deletes /usr/lib/python2.6/site-packages/nova/compute/manager.py:5392
>2014-07-15 15:19:19.942 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager._poll_unconfirmed_resizes run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:19:19.943 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager._sync_power_states run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:19:19.959 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager._poll_rescued_instances run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:19:19.960 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager._check_instance_build_time run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:19:19.960 18350 DEBUG nova.openstack.common.loopingcall [-] Dynamic looping call sleeping for 12.44 seconds _inner /usr/lib/python2.6/site-packages/nova/openstack/common/loopingcall.py:132
>2014-07-15 15:19:32.404 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager._poll_volume_usage run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:19:32.404 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager._instance_usage_audit run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:19:32.404 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager.update_available_resource run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:19:32.405 18350 DEBUG nova.openstack.common.lockutils [-] Got semaphore "compute_resources" lock /usr/lib/python2.6/site-packages/nova/openstack/common/lockutils.py:168
>2014-07-15 15:19:32.405 18350 DEBUG nova.openstack.common.lockutils [-] Got semaphore / lock "update_available_resource" inner /usr/lib/python2.6/site-packages/nova/openstack/common/lockutils.py:248
>2014-07-15 15:19:32.405 18350 AUDIT nova.compute.resource_tracker [-] Auditing locally available compute resources
>2014-07-15 15:19:32.405 18350 DEBUG nova.virt.libvirt.driver [-] Updating host stats update_status /usr/lib/python2.6/site-packages/nova/virt/libvirt/driver.py:5311
>2014-07-15 15:19:32.484 18350 DEBUG nova.compute.resource_tracker [-] Hypervisor: free ram (MB): 15415 _report_hypervisor_resource_view /usr/lib/python2.6/site-packages/nova/compute/resource_tracker.py:409
>2014-07-15 15:19:32.484 18350 DEBUG nova.compute.resource_tracker [-] Hypervisor: free disk (GB): 449 _report_hypervisor_resource_view /usr/lib/python2.6/site-packages/nova/compute/resource_tracker.py:410
>2014-07-15 15:19:32.484 18350 DEBUG nova.compute.resource_tracker [-] Hypervisor: free VCPUs: 6 _report_hypervisor_resource_view /usr/lib/python2.6/site-packages/nova/compute/resource_tracker.py:415
>2014-07-15 15:19:32.485 18350 DEBUG nova.compute.resource_tracker [-] Hypervisor: assignable PCI devices: [] _report_hypervisor_resource_view /usr/lib/python2.6/site-packages/nova/compute/resource_tracker.py:422
>2014-07-15 15:19:32.521 18350 AUDIT nova.compute.resource_tracker [-] Free ram (MB): 15429
>2014-07-15 15:19:32.521 18350 AUDIT nova.compute.resource_tracker [-] Free disk (GB): 450
>2014-07-15 15:19:32.521 18350 AUDIT nova.compute.resource_tracker [-] Free VCPUS: 6
>2014-07-15 15:19:32.571 18350 INFO nova.compute.resource_tracker [-] Compute_service record updated for cougar11.scl.lab.tlv.redhat.com:cougar11.scl.lab.tlv.redhat.com
>2014-07-15 15:19:32.571 18350 DEBUG nova.openstack.common.lockutils [-] Semaphore / lock released "update_available_resource" inner /usr/lib/python2.6/site-packages/nova/openstack/common/lockutils.py:252
>2014-07-15 15:19:32.593 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager._poll_rebooting_instances run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:19:32.593 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager._reclaim_queued_deletes run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:19:32.593 18350 DEBUG nova.compute.manager [-] CONF.reclaim_instance_interval <= 0, skipping... _reclaim_queued_deletes /usr/lib/python2.6/site-packages/nova/compute/manager.py:5392
>2014-07-15 15:19:32.593 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager._poll_unconfirmed_resizes run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:19:32.594 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager._poll_rescued_instances run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:19:32.594 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager._check_instance_build_time run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:19:32.594 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager._heal_instance_info_cache run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:19:32.595 18350 DEBUG nova.compute.manager [-] Starting heal instance info cache _heal_instance_info_cache /usr/lib/python2.6/site-packages/nova/compute/manager.py:4817
>2014-07-15 15:19:32.595 18350 DEBUG nova.compute.manager [-] Rebuilding the list of instances to heal _heal_instance_info_cache /usr/lib/python2.6/site-packages/nova/compute/manager.py:4821
>2014-07-15 15:19:32.610 18350 DEBUG nova.compute.manager [-] Didn't find any instances for network info cache update. _heal_instance_info_cache /usr/lib/python2.6/site-packages/nova/compute/manager.py:4883
>2014-07-15 15:19:32.610 18350 DEBUG nova.openstack.common.loopingcall [-] Dynamic looping call sleeping for 60.00 seconds _inner /usr/lib/python2.6/site-packages/nova/openstack/common/loopingcall.py:132
>2014-07-15 15:20:32.610 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager._poll_volume_usage run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:20:32.611 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager._instance_usage_audit run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:20:32.611 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager.update_available_resource run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:20:32.612 18350 DEBUG nova.openstack.common.lockutils [-] Got semaphore "compute_resources" lock /usr/lib/python2.6/site-packages/nova/openstack/common/lockutils.py:168
>2014-07-15 15:20:32.612 18350 DEBUG nova.openstack.common.lockutils [-] Got semaphore / lock "update_available_resource" inner /usr/lib/python2.6/site-packages/nova/openstack/common/lockutils.py:248
>2014-07-15 15:20:32.612 18350 AUDIT nova.compute.resource_tracker [-] Auditing locally available compute resources
>2014-07-15 15:20:32.612 18350 DEBUG nova.virt.libvirt.driver [-] Updating host stats update_status /usr/lib/python2.6/site-packages/nova/virt/libvirt/driver.py:5311
>2014-07-15 15:20:32.692 18350 DEBUG nova.compute.resource_tracker [-] Hypervisor: free ram (MB): 15407 _report_hypervisor_resource_view /usr/lib/python2.6/site-packages/nova/compute/resource_tracker.py:409
>2014-07-15 15:20:32.693 18350 DEBUG nova.compute.resource_tracker [-] Hypervisor: free disk (GB): 449 _report_hypervisor_resource_view /usr/lib/python2.6/site-packages/nova/compute/resource_tracker.py:410
>2014-07-15 15:20:32.693 18350 DEBUG nova.compute.resource_tracker [-] Hypervisor: free VCPUs: 6 _report_hypervisor_resource_view /usr/lib/python2.6/site-packages/nova/compute/resource_tracker.py:415
>2014-07-15 15:20:32.693 18350 DEBUG nova.compute.resource_tracker [-] Hypervisor: assignable PCI devices: [] _report_hypervisor_resource_view /usr/lib/python2.6/site-packages/nova/compute/resource_tracker.py:422
>2014-07-15 15:20:32.731 18350 AUDIT nova.compute.resource_tracker [-] Free ram (MB): 15429
>2014-07-15 15:20:32.731 18350 AUDIT nova.compute.resource_tracker [-] Free disk (GB): 450
>2014-07-15 15:20:32.731 18350 AUDIT nova.compute.resource_tracker [-] Free VCPUS: 6
>2014-07-15 15:20:32.772 18350 INFO nova.compute.resource_tracker [-] Compute_service record updated for cougar11.scl.lab.tlv.redhat.com:cougar11.scl.lab.tlv.redhat.com
>2014-07-15 15:20:32.773 18350 DEBUG nova.openstack.common.lockutils [-] Semaphore / lock released "update_available_resource" inner /usr/lib/python2.6/site-packages/nova/openstack/common/lockutils.py:252
>2014-07-15 15:20:32.802 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager._poll_rebooting_instances run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:20:32.802 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager._reclaim_queued_deletes run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:20:32.802 18350 DEBUG nova.compute.manager [-] CONF.reclaim_instance_interval <= 0, skipping... _reclaim_queued_deletes /usr/lib/python2.6/site-packages/nova/compute/manager.py:5392
>2014-07-15 15:20:32.802 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager._poll_unconfirmed_resizes run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:20:32.803 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager._poll_rescued_instances run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:20:32.803 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager._check_instance_build_time run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:20:32.803 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager._heal_instance_info_cache run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:20:32.804 18350 DEBUG nova.compute.manager [-] Starting heal instance info cache _heal_instance_info_cache /usr/lib/python2.6/site-packages/nova/compute/manager.py:4817
>2014-07-15 15:20:32.804 18350 DEBUG nova.compute.manager [-] Rebuilding the list of instances to heal _heal_instance_info_cache /usr/lib/python2.6/site-packages/nova/compute/manager.py:4821
>2014-07-15 15:20:32.822 18350 DEBUG nova.compute.manager [-] Didn't find any instances for network info cache update. _heal_instance_info_cache /usr/lib/python2.6/site-packages/nova/compute/manager.py:4883
>2014-07-15 15:20:32.822 18350 DEBUG nova.openstack.common.loopingcall [-] Dynamic looping call sleeping for 60.00 seconds _inner /usr/lib/python2.6/site-packages/nova/openstack/common/loopingcall.py:132
>2014-07-15 15:21:32.822 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager._poll_volume_usage run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:21:32.823 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager._instance_usage_audit run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:21:32.823 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager.update_available_resource run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:21:32.823 18350 DEBUG nova.openstack.common.lockutils [-] Got semaphore "compute_resources" lock /usr/lib/python2.6/site-packages/nova/openstack/common/lockutils.py:168
>2014-07-15 15:21:32.823 18350 DEBUG nova.openstack.common.lockutils [-] Got semaphore / lock "update_available_resource" inner /usr/lib/python2.6/site-packages/nova/openstack/common/lockutils.py:248
>2014-07-15 15:21:32.824 18350 AUDIT nova.compute.resource_tracker [-] Auditing locally available compute resources
>2014-07-15 15:21:32.824 18350 DEBUG nova.virt.libvirt.driver [-] Updating host stats update_status /usr/lib/python2.6/site-packages/nova/virt/libvirt/driver.py:5311
>2014-07-15 15:21:32.902 18350 DEBUG nova.compute.resource_tracker [-] Hypervisor: free ram (MB): 15403 _report_hypervisor_resource_view /usr/lib/python2.6/site-packages/nova/compute/resource_tracker.py:409
>2014-07-15 15:21:32.903 18350 DEBUG nova.compute.resource_tracker [-] Hypervisor: free disk (GB): 449 _report_hypervisor_resource_view /usr/lib/python2.6/site-packages/nova/compute/resource_tracker.py:410
>2014-07-15 15:21:32.903 18350 DEBUG nova.compute.resource_tracker [-] Hypervisor: free VCPUs: 6 _report_hypervisor_resource_view /usr/lib/python2.6/site-packages/nova/compute/resource_tracker.py:415
>2014-07-15 15:21:32.903 18350 DEBUG nova.compute.resource_tracker [-] Hypervisor: assignable PCI devices: [] _report_hypervisor_resource_view /usr/lib/python2.6/site-packages/nova/compute/resource_tracker.py:422
>2014-07-15 15:21:32.939 18350 AUDIT nova.compute.resource_tracker [-] Free ram (MB): 15429
>2014-07-15 15:21:32.940 18350 AUDIT nova.compute.resource_tracker [-] Free disk (GB): 450
>2014-07-15 15:21:32.940 18350 AUDIT nova.compute.resource_tracker [-] Free VCPUS: 6
>2014-07-15 15:21:32.995 18350 INFO nova.compute.resource_tracker [-] Compute_service record updated for cougar11.scl.lab.tlv.redhat.com:cougar11.scl.lab.tlv.redhat.com
>2014-07-15 15:21:32.995 18350 DEBUG nova.openstack.common.lockutils [-] Semaphore / lock released "update_available_resource" inner /usr/lib/python2.6/site-packages/nova/openstack/common/lockutils.py:252
>2014-07-15 15:21:33.015 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager._poll_rebooting_instances run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:21:33.015 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager._reclaim_queued_deletes run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:21:33.015 18350 DEBUG nova.compute.manager [-] CONF.reclaim_instance_interval <= 0, skipping... _reclaim_queued_deletes /usr/lib/python2.6/site-packages/nova/compute/manager.py:5392
>2014-07-15 15:21:33.015 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager._poll_unconfirmed_resizes run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:21:33.016 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager._poll_rescued_instances run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:21:33.016 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager._check_instance_build_time run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:21:33.016 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager._heal_instance_info_cache run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:21:33.016 18350 DEBUG nova.compute.manager [-] Starting heal instance info cache _heal_instance_info_cache /usr/lib/python2.6/site-packages/nova/compute/manager.py:4817
>2014-07-15 15:21:33.017 18350 DEBUG nova.compute.manager [-] Rebuilding the list of instances to heal _heal_instance_info_cache /usr/lib/python2.6/site-packages/nova/compute/manager.py:4821
>2014-07-15 15:21:33.038 18350 DEBUG nova.compute.manager [-] Didn't find any instances for network info cache update. _heal_instance_info_cache /usr/lib/python2.6/site-packages/nova/compute/manager.py:4883
>2014-07-15 15:21:33.038 18350 DEBUG nova.openstack.common.loopingcall [-] Dynamic looping call sleeping for 60.00 seconds _inner /usr/lib/python2.6/site-packages/nova/openstack/common/loopingcall.py:132
>2014-07-15 15:22:33.038 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager._poll_volume_usage run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:22:33.039 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager._instance_usage_audit run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:22:33.039 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager.update_available_resource run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:22:33.039 18350 DEBUG nova.openstack.common.lockutils [-] Got semaphore "compute_resources" lock /usr/lib/python2.6/site-packages/nova/openstack/common/lockutils.py:168
>2014-07-15 15:22:33.040 18350 DEBUG nova.openstack.common.lockutils [-] Got semaphore / lock "update_available_resource" inner /usr/lib/python2.6/site-packages/nova/openstack/common/lockutils.py:248
>2014-07-15 15:22:33.040 18350 AUDIT nova.compute.resource_tracker [-] Auditing locally available compute resources
>2014-07-15 15:22:33.040 18350 DEBUG nova.virt.libvirt.driver [-] Updating host stats update_status /usr/lib/python2.6/site-packages/nova/virt/libvirt/driver.py:5311
>2014-07-15 15:22:33.118 18350 DEBUG nova.compute.resource_tracker [-] Hypervisor: free ram (MB): 15401 _report_hypervisor_resource_view /usr/lib/python2.6/site-packages/nova/compute/resource_tracker.py:409
>2014-07-15 15:22:33.119 18350 DEBUG nova.compute.resource_tracker [-] Hypervisor: free disk (GB): 449 _report_hypervisor_resource_view /usr/lib/python2.6/site-packages/nova/compute/resource_tracker.py:410
>2014-07-15 15:22:33.119 18350 DEBUG nova.compute.resource_tracker [-] Hypervisor: free VCPUs: 6 _report_hypervisor_resource_view /usr/lib/python2.6/site-packages/nova/compute/resource_tracker.py:415
>2014-07-15 15:22:33.119 18350 DEBUG nova.compute.resource_tracker [-] Hypervisor: assignable PCI devices: [] _report_hypervisor_resource_view /usr/lib/python2.6/site-packages/nova/compute/resource_tracker.py:422
>2014-07-15 15:22:33.158 18350 AUDIT nova.compute.resource_tracker [-] Free ram (MB): 15429
>2014-07-15 15:22:33.158 18350 AUDIT nova.compute.resource_tracker [-] Free disk (GB): 450
>2014-07-15 15:22:33.158 18350 AUDIT nova.compute.resource_tracker [-] Free VCPUS: 6
>2014-07-15 15:22:33.191 18350 INFO nova.compute.resource_tracker [-] Compute_service record updated for cougar11.scl.lab.tlv.redhat.com:cougar11.scl.lab.tlv.redhat.com
>2014-07-15 15:22:33.191 18350 DEBUG nova.openstack.common.lockutils [-] Semaphore / lock released "update_available_resource" inner /usr/lib/python2.6/site-packages/nova/openstack/common/lockutils.py:252
>2014-07-15 15:22:33.213 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager._poll_rebooting_instances run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:22:33.213 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager._reclaim_queued_deletes run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:22:33.214 18350 DEBUG nova.compute.manager [-] CONF.reclaim_instance_interval <= 0, skipping... _reclaim_queued_deletes /usr/lib/python2.6/site-packages/nova/compute/manager.py:5392
>2014-07-15 15:22:33.214 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager._poll_unconfirmed_resizes run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:22:33.214 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager._poll_rescued_instances run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:22:33.214 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager._check_instance_build_time run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:22:33.215 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager._heal_instance_info_cache run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:22:33.215 18350 DEBUG nova.compute.manager [-] Starting heal instance info cache _heal_instance_info_cache /usr/lib/python2.6/site-packages/nova/compute/manager.py:4817
>2014-07-15 15:22:33.215 18350 DEBUG nova.compute.manager [-] Rebuilding the list of instances to heal _heal_instance_info_cache /usr/lib/python2.6/site-packages/nova/compute/manager.py:4821
>2014-07-15 15:22:33.238 18350 DEBUG nova.compute.manager [-] Didn't find any instances for network info cache update. _heal_instance_info_cache /usr/lib/python2.6/site-packages/nova/compute/manager.py:4883
>2014-07-15 15:22:33.238 18350 DEBUG nova.openstack.common.loopingcall [-] Dynamic looping call sleeping for 57.40 seconds _inner /usr/lib/python2.6/site-packages/nova/openstack/common/loopingcall.py:132
>2014-07-15 15:23:30.646 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager._poll_volume_usage run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:23:30.646 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager._instance_usage_audit run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:23:30.647 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager.update_available_resource run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:23:30.647 18350 DEBUG nova.openstack.common.lockutils [-] Got semaphore "compute_resources" lock /usr/lib/python2.6/site-packages/nova/openstack/common/lockutils.py:168
>2014-07-15 15:23:30.648 18350 DEBUG nova.openstack.common.lockutils [-] Got semaphore / lock "update_available_resource" inner /usr/lib/python2.6/site-packages/nova/openstack/common/lockutils.py:248
>2014-07-15 15:23:30.648 18350 AUDIT nova.compute.resource_tracker [-] Auditing locally available compute resources
>2014-07-15 15:23:30.648 18350 DEBUG nova.virt.libvirt.driver [-] Updating host stats update_status /usr/lib/python2.6/site-packages/nova/virt/libvirt/driver.py:5311
>2014-07-15 15:23:30.727 18350 DEBUG nova.compute.resource_tracker [-] Hypervisor: free ram (MB): 15415 _report_hypervisor_resource_view /usr/lib/python2.6/site-packages/nova/compute/resource_tracker.py:409
>2014-07-15 15:23:30.727 18350 DEBUG nova.compute.resource_tracker [-] Hypervisor: free disk (GB): 449 _report_hypervisor_resource_view /usr/lib/python2.6/site-packages/nova/compute/resource_tracker.py:410
>2014-07-15 15:23:30.727 18350 DEBUG nova.compute.resource_tracker [-] Hypervisor: free VCPUs: 6 _report_hypervisor_resource_view /usr/lib/python2.6/site-packages/nova/compute/resource_tracker.py:415
>2014-07-15 15:23:30.727 18350 DEBUG nova.compute.resource_tracker [-] Hypervisor: assignable PCI devices: [] _report_hypervisor_resource_view /usr/lib/python2.6/site-packages/nova/compute/resource_tracker.py:422
>2014-07-15 15:23:30.769 18350 AUDIT nova.compute.resource_tracker [-] Free ram (MB): 15429
>2014-07-15 15:23:30.769 18350 AUDIT nova.compute.resource_tracker [-] Free disk (GB): 450
>2014-07-15 15:23:30.770 18350 AUDIT nova.compute.resource_tracker [-] Free VCPUS: 6
>2014-07-15 15:23:30.846 18350 INFO nova.compute.resource_tracker [-] Compute_service record updated for cougar11.scl.lab.tlv.redhat.com:cougar11.scl.lab.tlv.redhat.com
>2014-07-15 15:23:30.846 18350 DEBUG nova.openstack.common.lockutils [-] Semaphore / lock released "update_available_resource" inner /usr/lib/python2.6/site-packages/nova/openstack/common/lockutils.py:252
>2014-07-15 15:23:30.871 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager._poll_rebooting_instances run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:23:30.872 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager._reclaim_queued_deletes run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:23:30.872 18350 DEBUG nova.compute.manager [-] CONF.reclaim_instance_interval <= 0, skipping... _reclaim_queued_deletes /usr/lib/python2.6/site-packages/nova/compute/manager.py:5392
>2014-07-15 15:23:30.872 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager._poll_unconfirmed_resizes run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:23:30.872 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager._poll_rescued_instances run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:23:30.873 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager._run_pending_deletes run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:23:30.873 18350 DEBUG nova.compute.manager [-] Cleaning up deleted instances _run_pending_deletes /usr/lib/python2.6/site-packages/nova/compute/manager.py:5670
>2014-07-15 15:23:30.899 18350 DEBUG nova.compute.manager [-] There are 0 instances to clean _run_pending_deletes /usr/lib/python2.6/site-packages/nova/compute/manager.py:5679
>2014-07-15 15:23:30.899 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager._check_instance_build_time run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:23:30.899 18350 DEBUG nova.openstack.common.loopingcall [-] Dynamic looping call sleeping for 2.32 seconds _inner /usr/lib/python2.6/site-packages/nova/openstack/common/loopingcall.py:132
>2014-07-15 15:23:33.215 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager._poll_volume_usage run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:23:33.216 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager._instance_usage_audit run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:23:33.216 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager.update_available_resource run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:23:33.216 18350 DEBUG nova.openstack.common.lockutils [-] Got semaphore "compute_resources" lock /usr/lib/python2.6/site-packages/nova/openstack/common/lockutils.py:168
>2014-07-15 15:23:33.217 18350 DEBUG nova.openstack.common.lockutils [-] Got semaphore / lock "update_available_resource" inner /usr/lib/python2.6/site-packages/nova/openstack/common/lockutils.py:248
>2014-07-15 15:23:33.217 18350 AUDIT nova.compute.resource_tracker [-] Auditing locally available compute resources
>2014-07-15 15:23:33.217 18350 DEBUG nova.virt.libvirt.driver [-] Updating host stats update_status /usr/lib/python2.6/site-packages/nova/virt/libvirt/driver.py:5311
>2014-07-15 15:23:33.294 18350 DEBUG nova.compute.resource_tracker [-] Hypervisor: free ram (MB): 15415 _report_hypervisor_resource_view /usr/lib/python2.6/site-packages/nova/compute/resource_tracker.py:409
>2014-07-15 15:23:33.295 18350 DEBUG nova.compute.resource_tracker [-] Hypervisor: free disk (GB): 449 _report_hypervisor_resource_view /usr/lib/python2.6/site-packages/nova/compute/resource_tracker.py:410
>2014-07-15 15:23:33.295 18350 DEBUG nova.compute.resource_tracker [-] Hypervisor: free VCPUs: 6 _report_hypervisor_resource_view /usr/lib/python2.6/site-packages/nova/compute/resource_tracker.py:415
>2014-07-15 15:23:33.295 18350 DEBUG nova.compute.resource_tracker [-] Hypervisor: assignable PCI devices: [] _report_hypervisor_resource_view /usr/lib/python2.6/site-packages/nova/compute/resource_tracker.py:422
>2014-07-15 15:23:33.336 18350 AUDIT nova.compute.resource_tracker [-] Free ram (MB): 15429
>2014-07-15 15:23:33.336 18350 AUDIT nova.compute.resource_tracker [-] Free disk (GB): 450
>2014-07-15 15:23:33.336 18350 AUDIT nova.compute.resource_tracker [-] Free VCPUS: 6
>2014-07-15 15:23:33.389 18350 INFO nova.compute.resource_tracker [-] Compute_service record updated for cougar11.scl.lab.tlv.redhat.com:cougar11.scl.lab.tlv.redhat.com
>2014-07-15 15:23:33.390 18350 DEBUG nova.openstack.common.lockutils [-] Semaphore / lock released "update_available_resource" inner /usr/lib/python2.6/site-packages/nova/openstack/common/lockutils.py:252
>2014-07-15 15:23:33.412 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager._poll_rebooting_instances run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:23:33.412 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager._reclaim_queued_deletes run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:23:33.413 18350 DEBUG nova.compute.manager [-] CONF.reclaim_instance_interval <= 0, skipping... _reclaim_queued_deletes /usr/lib/python2.6/site-packages/nova/compute/manager.py:5392
>2014-07-15 15:23:33.413 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager._poll_unconfirmed_resizes run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:23:33.413 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager._poll_rescued_instances run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:23:33.414 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager._check_instance_build_time run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:23:33.414 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager._heal_instance_info_cache run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:23:33.414 18350 DEBUG nova.compute.manager [-] Starting heal instance info cache _heal_instance_info_cache /usr/lib/python2.6/site-packages/nova/compute/manager.py:4817
>2014-07-15 15:23:33.414 18350 DEBUG nova.compute.manager [-] Rebuilding the list of instances to heal _heal_instance_info_cache /usr/lib/python2.6/site-packages/nova/compute/manager.py:4821
>2014-07-15 15:23:33.439 18350 DEBUG nova.compute.manager [-] Didn't find any instances for network info cache update. _heal_instance_info_cache /usr/lib/python2.6/site-packages/nova/compute/manager.py:4883
>2014-07-15 15:23:33.439 18350 DEBUG nova.openstack.common.loopingcall [-] Dynamic looping call sleeping for 60.00 seconds _inner /usr/lib/python2.6/site-packages/nova/openstack/common/loopingcall.py:132
>2014-07-15 15:24:33.440 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager._poll_volume_usage run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:24:33.440 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager._instance_usage_audit run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:24:33.440 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager.update_available_resource run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:24:33.441 18350 DEBUG nova.openstack.common.lockutils [-] Got semaphore "compute_resources" lock /usr/lib/python2.6/site-packages/nova/openstack/common/lockutils.py:168
>2014-07-15 15:24:33.441 18350 DEBUG nova.openstack.common.lockutils [-] Got semaphore / lock "update_available_resource" inner /usr/lib/python2.6/site-packages/nova/openstack/common/lockutils.py:248
>2014-07-15 15:24:33.441 18350 AUDIT nova.compute.resource_tracker [-] Auditing locally available compute resources
>2014-07-15 15:24:33.441 18350 DEBUG nova.virt.libvirt.driver [-] Updating host stats update_status /usr/lib/python2.6/site-packages/nova/virt/libvirt/driver.py:5311
>2014-07-15 15:24:33.518 18350 DEBUG nova.compute.resource_tracker [-] Hypervisor: free ram (MB): 15414 _report_hypervisor_resource_view /usr/lib/python2.6/site-packages/nova/compute/resource_tracker.py:409
>2014-07-15 15:24:33.519 18350 DEBUG nova.compute.resource_tracker [-] Hypervisor: free disk (GB): 449 _report_hypervisor_resource_view /usr/lib/python2.6/site-packages/nova/compute/resource_tracker.py:410
>2014-07-15 15:24:33.519 18350 DEBUG nova.compute.resource_tracker [-] Hypervisor: free VCPUs: 6 _report_hypervisor_resource_view /usr/lib/python2.6/site-packages/nova/compute/resource_tracker.py:415
>2014-07-15 15:24:33.519 18350 DEBUG nova.compute.resource_tracker [-] Hypervisor: assignable PCI devices: [] _report_hypervisor_resource_view /usr/lib/python2.6/site-packages/nova/compute/resource_tracker.py:422
>2014-07-15 15:24:33.556 18350 AUDIT nova.compute.resource_tracker [-] Free ram (MB): 15429
>2014-07-15 15:24:33.556 18350 AUDIT nova.compute.resource_tracker [-] Free disk (GB): 450
>2014-07-15 15:24:33.556 18350 AUDIT nova.compute.resource_tracker [-] Free VCPUS: 6
>2014-07-15 15:24:33.586 18350 INFO nova.compute.resource_tracker [-] Compute_service record updated for cougar11.scl.lab.tlv.redhat.com:cougar11.scl.lab.tlv.redhat.com
>2014-07-15 15:24:33.587 18350 DEBUG nova.openstack.common.lockutils [-] Semaphore / lock released "update_available_resource" inner /usr/lib/python2.6/site-packages/nova/openstack/common/lockutils.py:252
>2014-07-15 15:24:33.612 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager._poll_rebooting_instances run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:24:33.612 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager._reclaim_queued_deletes run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:24:33.612 18350 DEBUG nova.compute.manager [-] CONF.reclaim_instance_interval <= 0, skipping... _reclaim_queued_deletes /usr/lib/python2.6/site-packages/nova/compute/manager.py:5392
>2014-07-15 15:24:33.613 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager._poll_unconfirmed_resizes run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:24:33.613 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager._poll_rescued_instances run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:24:33.613 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager._check_instance_build_time run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:24:33.613 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager._heal_instance_info_cache run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:24:33.614 18350 DEBUG nova.compute.manager [-] Starting heal instance info cache _heal_instance_info_cache /usr/lib/python2.6/site-packages/nova/compute/manager.py:4817
>2014-07-15 15:24:33.614 18350 DEBUG nova.compute.manager [-] Rebuilding the list of instances to heal _heal_instance_info_cache /usr/lib/python2.6/site-packages/nova/compute/manager.py:4821
>2014-07-15 15:24:33.638 18350 DEBUG nova.compute.manager [-] Didn't find any instances for network info cache update. _heal_instance_info_cache /usr/lib/python2.6/site-packages/nova/compute/manager.py:4883
>2014-07-15 15:24:33.638 18350 DEBUG nova.openstack.common.loopingcall [-] Dynamic looping call sleeping for 60.00 seconds _inner /usr/lib/python2.6/site-packages/nova/openstack/common/loopingcall.py:132
>2014-07-15 15:25:33.639 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager._poll_volume_usage run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:25:33.639 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager._instance_usage_audit run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:25:33.639 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager.update_available_resource run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:25:33.640 18350 DEBUG nova.openstack.common.lockutils [-] Got semaphore "compute_resources" lock /usr/lib/python2.6/site-packages/nova/openstack/common/lockutils.py:168
>2014-07-15 15:25:33.640 18350 DEBUG nova.openstack.common.lockutils [-] Got semaphore / lock "update_available_resource" inner /usr/lib/python2.6/site-packages/nova/openstack/common/lockutils.py:248
>2014-07-15 15:25:33.640 18350 AUDIT nova.compute.resource_tracker [-] Auditing locally available compute resources
>2014-07-15 15:25:33.640 18350 DEBUG nova.virt.libvirt.driver [-] Updating host stats update_status /usr/lib/python2.6/site-packages/nova/virt/libvirt/driver.py:5311
>2014-07-15 15:25:33.718 18350 DEBUG nova.compute.resource_tracker [-] Hypervisor: free ram (MB): 15401 _report_hypervisor_resource_view /usr/lib/python2.6/site-packages/nova/compute/resource_tracker.py:409
>2014-07-15 15:25:33.718 18350 DEBUG nova.compute.resource_tracker [-] Hypervisor: free disk (GB): 449 _report_hypervisor_resource_view /usr/lib/python2.6/site-packages/nova/compute/resource_tracker.py:410
>2014-07-15 15:25:33.719 18350 DEBUG nova.compute.resource_tracker [-] Hypervisor: free VCPUs: 6 _report_hypervisor_resource_view /usr/lib/python2.6/site-packages/nova/compute/resource_tracker.py:415
>2014-07-15 15:25:33.719 18350 DEBUG nova.compute.resource_tracker [-] Hypervisor: assignable PCI devices: [] _report_hypervisor_resource_view /usr/lib/python2.6/site-packages/nova/compute/resource_tracker.py:422
>2014-07-15 15:25:33.756 18350 AUDIT nova.compute.resource_tracker [-] Free ram (MB): 15429
>2014-07-15 15:25:33.756 18350 AUDIT nova.compute.resource_tracker [-] Free disk (GB): 450
>2014-07-15 15:25:33.757 18350 AUDIT nova.compute.resource_tracker [-] Free VCPUS: 6
>2014-07-15 15:25:33.797 18350 INFO nova.compute.resource_tracker [-] Compute_service record updated for cougar11.scl.lab.tlv.redhat.com:cougar11.scl.lab.tlv.redhat.com
>2014-07-15 15:25:33.797 18350 DEBUG nova.openstack.common.lockutils [-] Semaphore / lock released "update_available_resource" inner /usr/lib/python2.6/site-packages/nova/openstack/common/lockutils.py:252
>2014-07-15 15:25:33.821 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager._poll_rebooting_instances run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:25:33.822 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager._reclaim_queued_deletes run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:25:33.822 18350 DEBUG nova.compute.manager [-] CONF.reclaim_instance_interval <= 0, skipping... _reclaim_queued_deletes /usr/lib/python2.6/site-packages/nova/compute/manager.py:5392
>2014-07-15 15:25:33.822 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager._poll_unconfirmed_resizes run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:25:33.822 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager._poll_rescued_instances run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:25:33.823 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager._check_instance_build_time run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:25:33.823 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager._heal_instance_info_cache run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:25:33.823 18350 DEBUG nova.compute.manager [-] Starting heal instance info cache _heal_instance_info_cache /usr/lib/python2.6/site-packages/nova/compute/manager.py:4817
>2014-07-15 15:25:33.823 18350 DEBUG nova.compute.manager [-] Rebuilding the list of instances to heal _heal_instance_info_cache /usr/lib/python2.6/site-packages/nova/compute/manager.py:4821
>2014-07-15 15:25:33.847 18350 DEBUG nova.compute.manager [-] Didn't find any instances for network info cache update. _heal_instance_info_cache /usr/lib/python2.6/site-packages/nova/compute/manager.py:4883
>2014-07-15 15:25:33.847 18350 DEBUG nova.openstack.common.loopingcall [-] Dynamic looping call sleeping for 60.00 seconds _inner /usr/lib/python2.6/site-packages/nova/openstack/common/loopingcall.py:132
>2014-07-15 15:26:33.847 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager._poll_volume_usage run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:26:33.848 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager._instance_usage_audit run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:26:33.849 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager.update_available_resource run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:26:33.849 18350 DEBUG nova.openstack.common.lockutils [-] Got semaphore "compute_resources" lock /usr/lib/python2.6/site-packages/nova/openstack/common/lockutils.py:168
>2014-07-15 15:26:33.849 18350 DEBUG nova.openstack.common.lockutils [-] Got semaphore / lock "update_available_resource" inner /usr/lib/python2.6/site-packages/nova/openstack/common/lockutils.py:248
>2014-07-15 15:26:33.849 18350 AUDIT nova.compute.resource_tracker [-] Auditing locally available compute resources
>2014-07-15 15:26:33.850 18350 DEBUG nova.virt.libvirt.driver [-] Updating host stats update_status /usr/lib/python2.6/site-packages/nova/virt/libvirt/driver.py:5311
>2014-07-15 15:26:33.933 18350 DEBUG nova.compute.resource_tracker [-] Hypervisor: free ram (MB): 15398 _report_hypervisor_resource_view /usr/lib/python2.6/site-packages/nova/compute/resource_tracker.py:409
>2014-07-15 15:26:33.933 18350 DEBUG nova.compute.resource_tracker [-] Hypervisor: free disk (GB): 449 _report_hypervisor_resource_view /usr/lib/python2.6/site-packages/nova/compute/resource_tracker.py:410
>2014-07-15 15:26:33.934 18350 DEBUG nova.compute.resource_tracker [-] Hypervisor: free VCPUs: 6 _report_hypervisor_resource_view /usr/lib/python2.6/site-packages/nova/compute/resource_tracker.py:415
>2014-07-15 15:26:33.934 18350 DEBUG nova.compute.resource_tracker [-] Hypervisor: assignable PCI devices: [] _report_hypervisor_resource_view /usr/lib/python2.6/site-packages/nova/compute/resource_tracker.py:422
>2014-07-15 15:26:33.971 18350 AUDIT nova.compute.resource_tracker [-] Free ram (MB): 15429
>2014-07-15 15:26:33.971 18350 AUDIT nova.compute.resource_tracker [-] Free disk (GB): 450
>2014-07-15 15:26:33.971 18350 AUDIT nova.compute.resource_tracker [-] Free VCPUS: 6
>2014-07-15 15:26:33.999 18350 INFO nova.compute.resource_tracker [-] Compute_service record updated for cougar11.scl.lab.tlv.redhat.com:cougar11.scl.lab.tlv.redhat.com
>2014-07-15 15:26:34.000 18350 DEBUG nova.openstack.common.lockutils [-] Semaphore / lock released "update_available_resource" inner /usr/lib/python2.6/site-packages/nova/openstack/common/lockutils.py:252
>2014-07-15 15:26:34.030 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager._poll_rebooting_instances run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:26:34.030 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager._reclaim_queued_deletes run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:26:34.030 18350 DEBUG nova.compute.manager [-] CONF.reclaim_instance_interval <= 0, skipping... _reclaim_queued_deletes /usr/lib/python2.6/site-packages/nova/compute/manager.py:5392
>2014-07-15 15:26:34.031 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager._poll_unconfirmed_resizes run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:26:34.031 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager._poll_rescued_instances run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:26:34.031 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager._check_instance_build_time run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:26:34.031 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager._heal_instance_info_cache run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:26:34.032 18350 DEBUG nova.compute.manager [-] Starting heal instance info cache _heal_instance_info_cache /usr/lib/python2.6/site-packages/nova/compute/manager.py:4817
>2014-07-15 15:26:34.032 18350 DEBUG nova.compute.manager [-] Rebuilding the list of instances to heal _heal_instance_info_cache /usr/lib/python2.6/site-packages/nova/compute/manager.py:4821
>2014-07-15 15:26:34.057 18350 DEBUG nova.compute.manager [-] Didn't find any instances for network info cache update. _heal_instance_info_cache /usr/lib/python2.6/site-packages/nova/compute/manager.py:4883
>2014-07-15 15:26:34.058 18350 DEBUG nova.openstack.common.loopingcall [-] Dynamic looping call sleeping for 60.00 seconds _inner /usr/lib/python2.6/site-packages/nova/openstack/common/loopingcall.py:132
>2014-07-15 15:26:37.294 18350 ERROR oslo.messaging._drivers.impl_rabbit [-] Failed to consume message from queue: [Errno 104] Connection reset by peer
>2014-07-15 15:26:37.294 18350 TRACE oslo.messaging._drivers.impl_rabbit Traceback (most recent call last):
>2014-07-15 15:26:37.294 18350 TRACE oslo.messaging._drivers.impl_rabbit   File "/usr/lib/python2.6/site-packages/oslo/messaging/_drivers/impl_rabbit.py", line 622, in ensure
>2014-07-15 15:26:37.294 18350 TRACE oslo.messaging._drivers.impl_rabbit     return method(*args, **kwargs)
>2014-07-15 15:26:37.294 18350 TRACE oslo.messaging._drivers.impl_rabbit   File "/usr/lib/python2.6/site-packages/oslo/messaging/_drivers/impl_rabbit.py", line 702, in _consume
>2014-07-15 15:26:37.294 18350 TRACE oslo.messaging._drivers.impl_rabbit     return self.connection.drain_events(timeout=timeout)
>2014-07-15 15:26:37.294 18350 TRACE oslo.messaging._drivers.impl_rabbit   File "/usr/lib/python2.6/site-packages/kombu/connection.py", line 281, in drain_events
>2014-07-15 15:26:37.294 18350 TRACE oslo.messaging._drivers.impl_rabbit     return self.transport.drain_events(self.connection, **kwargs)
>2014-07-15 15:26:37.294 18350 TRACE oslo.messaging._drivers.impl_rabbit   File "/usr/lib/python2.6/site-packages/kombu/transport/pyamqp.py", line 94, in drain_events
>2014-07-15 15:26:37.294 18350 TRACE oslo.messaging._drivers.impl_rabbit     return connection.drain_events(**kwargs)
>2014-07-15 15:26:37.294 18350 TRACE oslo.messaging._drivers.impl_rabbit   File "/usr/lib/python2.6/site-packages/amqp/connection.py", line 286, in drain_events
>2014-07-15 15:26:37.294 18350 TRACE oslo.messaging._drivers.impl_rabbit     return amqp_method(channel, args)
>2014-07-15 15:26:37.294 18350 TRACE oslo.messaging._drivers.impl_rabbit   File "/usr/lib/python2.6/site-packages/amqp/connection.py", line 489, in _close
>2014-07-15 15:26:37.294 18350 TRACE oslo.messaging._drivers.impl_rabbit     self._x_close_ok()
>2014-07-15 15:26:37.294 18350 TRACE oslo.messaging._drivers.impl_rabbit   File "/usr/lib/python2.6/site-packages/amqp/connection.py", line 506, in _x_close_ok
>2014-07-15 15:26:37.294 18350 TRACE oslo.messaging._drivers.impl_rabbit     self._send_method((10, 51))
>2014-07-15 15:26:37.294 18350 TRACE oslo.messaging._drivers.impl_rabbit   File "/usr/lib/python2.6/site-packages/amqp/abstract_channel.py", line 58, in _send_method
>2014-07-15 15:26:37.294 18350 TRACE oslo.messaging._drivers.impl_rabbit     self.channel_id, method_sig, args, content,
>2014-07-15 15:26:37.294 18350 TRACE oslo.messaging._drivers.impl_rabbit   File "/usr/lib/python2.6/site-packages/amqp/method_framing.py", line 224, in write_method
>2014-07-15 15:26:37.294 18350 TRACE oslo.messaging._drivers.impl_rabbit     write_frame(1, channel, payload)
>2014-07-15 15:26:37.294 18350 TRACE oslo.messaging._drivers.impl_rabbit   File "/usr/lib/python2.6/site-packages/amqp/transport.py", line 160, in write_frame
>2014-07-15 15:26:37.294 18350 TRACE oslo.messaging._drivers.impl_rabbit     pack('>BHI%dsB' % size, frame_type, channel, size, payload, 0xce),
>2014-07-15 15:26:37.294 18350 TRACE oslo.messaging._drivers.impl_rabbit   File "/usr/lib/python2.6/site-packages/eventlet/greenio.py", line 309, in sendall
>2014-07-15 15:26:37.294 18350 TRACE oslo.messaging._drivers.impl_rabbit     tail = self.send(data, flags)
>2014-07-15 15:26:37.294 18350 TRACE oslo.messaging._drivers.impl_rabbit   File "/usr/lib/python2.6/site-packages/eventlet/greenio.py", line 295, in send
>2014-07-15 15:26:37.294 18350 TRACE oslo.messaging._drivers.impl_rabbit     total_sent += fd.send(data[total_sent:], flags)
>2014-07-15 15:26:37.294 18350 TRACE oslo.messaging._drivers.impl_rabbit error: [Errno 104] Connection reset by peer
>2014-07-15 15:26:37.294 18350 TRACE oslo.messaging._drivers.impl_rabbit 
>2014-07-15 15:26:37.297 18350 INFO oslo.messaging._drivers.impl_rabbit [-] Reconnecting to AMQP server on 10.35.64.150:5672
>2014-07-15 15:26:37.297 18350 INFO oslo.messaging._drivers.impl_rabbit [-] Delaying reconnect for 1.0 seconds...
>2014-07-15 15:26:37.831 18350 ERROR oslo.messaging._drivers.impl_rabbit [-] Failed to publish message to topic 'conductor': [Errno 104] Connection reset by peer
>2014-07-15 15:26:37.831 18350 TRACE oslo.messaging._drivers.impl_rabbit Traceback (most recent call last):
>2014-07-15 15:26:37.831 18350 TRACE oslo.messaging._drivers.impl_rabbit   File "/usr/lib/python2.6/site-packages/oslo/messaging/_drivers/impl_rabbit.py", line 622, in ensure
>2014-07-15 15:26:37.831 18350 TRACE oslo.messaging._drivers.impl_rabbit     return method(*args, **kwargs)
>2014-07-15 15:26:37.831 18350 TRACE oslo.messaging._drivers.impl_rabbit   File "/usr/lib/python2.6/site-packages/oslo/messaging/_drivers/impl_rabbit.py", line 718, in _publish
>2014-07-15 15:26:37.831 18350 TRACE oslo.messaging._drivers.impl_rabbit     publisher = cls(self.conf, self.channel, topic, **kwargs)
>2014-07-15 15:26:37.831 18350 TRACE oslo.messaging._drivers.impl_rabbit   File "/usr/lib/python2.6/site-packages/oslo/messaging/_drivers/impl_rabbit.py", line 379, in __init__
>2014-07-15 15:26:37.831 18350 TRACE oslo.messaging._drivers.impl_rabbit     **options)
>2014-07-15 15:26:37.831 18350 TRACE oslo.messaging._drivers.impl_rabbit   File "/usr/lib/python2.6/site-packages/oslo/messaging/_drivers/impl_rabbit.py", line 326, in __init__
>2014-07-15 15:26:37.831 18350 TRACE oslo.messaging._drivers.impl_rabbit     self.reconnect(channel)
>2014-07-15 15:26:37.831 18350 TRACE oslo.messaging._drivers.impl_rabbit   File "/usr/lib/python2.6/site-packages/oslo/messaging/_drivers/impl_rabbit.py", line 334, in reconnect
>2014-07-15 15:26:37.831 18350 TRACE oslo.messaging._drivers.impl_rabbit     routing_key=self.routing_key)
>2014-07-15 15:26:37.831 18350 TRACE oslo.messaging._drivers.impl_rabbit   File "/usr/lib/python2.6/site-packages/kombu/messaging.py", line 83, in __init__
>2014-07-15 15:26:37.831 18350 TRACE oslo.messaging._drivers.impl_rabbit     self.revive(self._channel)
>2014-07-15 15:26:37.831 18350 TRACE oslo.messaging._drivers.impl_rabbit   File "/usr/lib/python2.6/site-packages/kombu/messaging.py", line 214, in revive
>2014-07-15 15:26:37.831 18350 TRACE oslo.messaging._drivers.impl_rabbit     self.declare()
>2014-07-15 15:26:37.831 18350 TRACE oslo.messaging._drivers.impl_rabbit   File "/usr/lib/python2.6/site-packages/kombu/messaging.py", line 100, in declare
>2014-07-15 15:26:37.831 18350 TRACE oslo.messaging._drivers.impl_rabbit     self.exchange.declare()
>2014-07-15 15:26:37.831 18350 TRACE oslo.messaging._drivers.impl_rabbit   File "/usr/lib/python2.6/site-packages/kombu/entity.py", line 163, in declare
>2014-07-15 15:26:37.831 18350 TRACE oslo.messaging._drivers.impl_rabbit     nowait=nowait, passive=passive,
>2014-07-15 15:26:37.831 18350 TRACE oslo.messaging._drivers.impl_rabbit   File "/usr/lib/python2.6/site-packages/amqp/channel.py", line 595, in exchange_declare
>2014-07-15 15:26:37.831 18350 TRACE oslo.messaging._drivers.impl_rabbit     self._send_method((40, 10), args)
>2014-07-15 15:26:37.831 18350 TRACE oslo.messaging._drivers.impl_rabbit   File "/usr/lib/python2.6/site-packages/amqp/abstract_channel.py", line 58, in _send_method
>2014-07-15 15:26:37.831 18350 TRACE oslo.messaging._drivers.impl_rabbit     self.channel_id, method_sig, args, content,
>2014-07-15 15:26:37.831 18350 TRACE oslo.messaging._drivers.impl_rabbit   File "/usr/lib/python2.6/site-packages/amqp/method_framing.py", line 224, in write_method
>2014-07-15 15:26:37.831 18350 TRACE oslo.messaging._drivers.impl_rabbit     write_frame(1, channel, payload)
>2014-07-15 15:26:37.831 18350 TRACE oslo.messaging._drivers.impl_rabbit   File "/usr/lib/python2.6/site-packages/amqp/transport.py", line 160, in write_frame
>2014-07-15 15:26:37.831 18350 TRACE oslo.messaging._drivers.impl_rabbit     pack('>BHI%dsB' % size, frame_type, channel, size, payload, 0xce),
>2014-07-15 15:26:37.831 18350 TRACE oslo.messaging._drivers.impl_rabbit   File "/usr/lib/python2.6/site-packages/eventlet/greenio.py", line 309, in sendall
>2014-07-15 15:26:37.831 18350 TRACE oslo.messaging._drivers.impl_rabbit     tail = self.send(data, flags)
>2014-07-15 15:26:37.831 18350 TRACE oslo.messaging._drivers.impl_rabbit   File "/usr/lib/python2.6/site-packages/eventlet/greenio.py", line 295, in send
>2014-07-15 15:26:37.831 18350 TRACE oslo.messaging._drivers.impl_rabbit     total_sent += fd.send(data[total_sent:], flags)
>2014-07-15 15:26:37.831 18350 TRACE oslo.messaging._drivers.impl_rabbit error: [Errno 104] Connection reset by peer
>2014-07-15 15:26:37.831 18350 TRACE oslo.messaging._drivers.impl_rabbit 
>2014-07-15 15:26:37.833 18350 INFO oslo.messaging._drivers.impl_rabbit [-] Reconnecting to AMQP server on 10.35.64.150:5672
>2014-07-15 15:26:37.833 18350 INFO oslo.messaging._drivers.impl_rabbit [-] Delaying reconnect for 1.0 seconds...
>2014-07-15 15:26:38.312 18350 ERROR oslo.messaging._drivers.impl_rabbit [-] AMQP server on 10.35.64.150:5672 is unreachable: [Errno 111] ECONNREFUSED. Trying again in 1 seconds.
>2014-07-15 15:26:38.842 18350 ERROR oslo.messaging._drivers.impl_rabbit [-] AMQP server on 10.35.64.150:5672 is unreachable: [Errno 111] ECONNREFUSED. Trying again in 1 seconds.
>2014-07-15 15:26:39.312 18350 INFO oslo.messaging._drivers.impl_rabbit [-] Reconnecting to AMQP server on 10.35.64.150:5672
>2014-07-15 15:26:39.313 18350 INFO oslo.messaging._drivers.impl_rabbit [-] Delaying reconnect for 1.0 seconds...
>2014-07-15 15:26:39.842 18350 INFO oslo.messaging._drivers.impl_rabbit [-] Reconnecting to AMQP server on 10.35.64.150:5672
>2014-07-15 15:26:39.843 18350 INFO oslo.messaging._drivers.impl_rabbit [-] Delaying reconnect for 1.0 seconds...
>2014-07-15 15:26:40.321 18350 ERROR oslo.messaging._drivers.impl_rabbit [-] AMQP server on 10.35.64.150:5672 is unreachable: [Errno 111] ECONNREFUSED. Trying again in 3 seconds.
>2014-07-15 15:26:40.852 18350 ERROR oslo.messaging._drivers.impl_rabbit [-] AMQP server on 10.35.64.150:5672 is unreachable: [Errno 111] ECONNREFUSED. Trying again in 3 seconds.
>2014-07-15 15:26:43.321 18350 INFO oslo.messaging._drivers.impl_rabbit [-] Reconnecting to AMQP server on 10.35.64.150:5672
>2014-07-15 15:26:43.322 18350 INFO oslo.messaging._drivers.impl_rabbit [-] Delaying reconnect for 1.0 seconds...
>2014-07-15 15:26:43.852 18350 INFO oslo.messaging._drivers.impl_rabbit [-] Reconnecting to AMQP server on 10.35.64.150:5672
>2014-07-15 15:26:43.853 18350 INFO oslo.messaging._drivers.impl_rabbit [-] Delaying reconnect for 1.0 seconds...
>2014-07-15 15:26:44.335 18350 ERROR oslo.messaging._drivers.impl_rabbit [-] AMQP server on 10.35.64.150:5672 is unreachable: [Errno 111] ECONNREFUSED. Trying again in 5 seconds.
>2014-07-15 15:26:44.861 18350 ERROR oslo.messaging._drivers.impl_rabbit [-] AMQP server on 10.35.64.150:5672 is unreachable: [Errno 111] ECONNREFUSED. Trying again in 5 seconds.
>2014-07-15 15:26:49.336 18350 INFO oslo.messaging._drivers.impl_rabbit [-] Reconnecting to AMQP server on 10.35.64.150:5672
>2014-07-15 15:26:49.336 18350 INFO oslo.messaging._drivers.impl_rabbit [-] Delaying reconnect for 1.0 seconds...
>2014-07-15 15:26:49.861 18350 INFO oslo.messaging._drivers.impl_rabbit [-] Reconnecting to AMQP server on 10.35.64.150:5672
>2014-07-15 15:26:49.861 18350 INFO oslo.messaging._drivers.impl_rabbit [-] Delaying reconnect for 1.0 seconds...
>2014-07-15 15:26:55.348 18350 ERROR oslo.messaging._drivers.impl_rabbit [-] AMQP server on 10.35.64.150:5672 is unreachable: timed out. Trying again in 7 seconds.
>2014-07-15 15:26:55.869 18350 ERROR oslo.messaging._drivers.impl_rabbit [-] AMQP server on 10.35.64.150:5672 is unreachable: timed out. Trying again in 7 seconds.
>2014-07-15 15:27:02.352 18350 INFO oslo.messaging._drivers.impl_rabbit [-] Reconnecting to AMQP server on 10.35.64.150:5672
>2014-07-15 15:27:02.353 18350 INFO oslo.messaging._drivers.impl_rabbit [-] Delaying reconnect for 1.0 seconds...
>2014-07-15 15:27:02.870 18350 INFO oslo.messaging._drivers.impl_rabbit [-] Reconnecting to AMQP server on 10.35.64.150:5672
>2014-07-15 15:27:02.870 18350 INFO oslo.messaging._drivers.impl_rabbit [-] Delaying reconnect for 1.0 seconds...
>2014-07-15 15:27:08.360 18350 ERROR oslo.messaging._drivers.impl_rabbit [-] AMQP server on 10.35.64.150:5672 is unreachable: timed out. Trying again in 9 seconds.
>2014-07-15 15:27:08.877 18350 ERROR oslo.messaging._drivers.impl_rabbit [-] AMQP server on 10.35.64.150:5672 is unreachable: timed out. Trying again in 9 seconds.
>2014-07-15 15:27:17.368 18350 INFO oslo.messaging._drivers.impl_rabbit [-] Reconnecting to AMQP server on 10.35.64.150:5672
>2014-07-15 15:27:17.369 18350 INFO oslo.messaging._drivers.impl_rabbit [-] Delaying reconnect for 1.0 seconds...
>2014-07-15 15:27:17.878 18350 INFO oslo.messaging._drivers.impl_rabbit [-] Reconnecting to AMQP server on 10.35.64.150:5672
>2014-07-15 15:27:17.878 18350 INFO oslo.messaging._drivers.impl_rabbit [-] Delaying reconnect for 1.0 seconds...
>2014-07-15 15:27:23.380 18350 ERROR oslo.messaging._drivers.impl_rabbit [-] AMQP server on 10.35.64.150:5672 is unreachable: timed out. Trying again in 11 seconds.
>2014-07-15 15:27:23.885 18350 ERROR oslo.messaging._drivers.impl_rabbit [-] AMQP server on 10.35.64.150:5672 is unreachable: timed out. Trying again in 11 seconds.
>2014-07-15 15:27:34.058 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager._poll_volume_usage run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:27:34.058 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager._instance_usage_audit run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:27:34.059 18350 DEBUG nova.openstack.common.periodic_task [-] Running periodic task ComputeManager.update_available_resource run_periodic_tasks /usr/lib/python2.6/site-packages/nova/openstack/common/periodic_task.py:178
>2014-07-15 15:27:34.059 18350 DEBUG nova.openstack.common.lockutils [-] Got semaphore "compute_resources" lock /usr/lib/python2.6/site-packages/nova/openstack/common/lockutils.py:168
>2014-07-15 15:27:34.059 18350 DEBUG nova.openstack.common.lockutils [-] Got semaphore / lock "update_available_resource" inner /usr/lib/python2.6/site-packages/nova/openstack/common/lockutils.py:248
>2014-07-15 15:27:34.059 18350 AUDIT nova.compute.resource_tracker [-] Auditing locally available compute resources
>2014-07-15 15:27:34.060 18350 DEBUG nova.virt.libvirt.driver [-] Updating host stats update_status /usr/lib/python2.6/site-packages/nova/virt/libvirt/driver.py:5311
>2014-07-15 15:27:34.143 18350 DEBUG nova.compute.resource_tracker [-] Hypervisor: free ram (MB): 15382 _report_hypervisor_resource_view /usr/lib/python2.6/site-packages/nova/compute/resource_tracker.py:409
>2014-07-15 15:27:34.144 18350 DEBUG nova.compute.resource_tracker [-] Hypervisor: free disk (GB): 449 _report_hypervisor_resource_view /usr/lib/python2.6/site-packages/nova/compute/resource_tracker.py:410
>2014-07-15 15:27:34.144 18350 DEBUG nova.compute.resource_tracker [-] Hypervisor: free VCPUs: 6 _report_hypervisor_resource_view /usr/lib/python2.6/site-packages/nova/compute/resource_tracker.py:415
>2014-07-15 15:27:34.144 18350 DEBUG nova.compute.resource_tracker [-] Hypervisor: assignable PCI devices: [] _report_hypervisor_resource_view /usr/lib/python2.6/site-packages/nova/compute/resource_tracker.py:422
>2014-07-15 15:27:34.380 18350 INFO oslo.messaging._drivers.impl_rabbit [-] Reconnecting to AMQP server on 10.35.64.150:5672
>2014-07-15 15:27:34.381 18350 INFO oslo.messaging._drivers.impl_rabbit [-] Delaying reconnect for 1.0 seconds...
>2014-07-15 15:27:34.886 18350 INFO oslo.messaging._drivers.impl_rabbit [-] Reconnecting to AMQP server on 10.35.64.150:5672
>2014-07-15 15:27:34.886 18350 INFO oslo.messaging._drivers.impl_rabbit [-] Delaying reconnect for 1.0 seconds...
>2014-07-15 15:27:39.157 18350 ERROR oslo.messaging._drivers.impl_rabbit [-] AMQP server on 10.35.64.150:5672 is unreachable: timed out. Trying again in 1 seconds.
>2014-07-15 15:27:40.157 18350 INFO oslo.messaging._drivers.impl_rabbit [-] Reconnecting to AMQP server on 10.35.64.150:5672
>2014-07-15 15:27:40.157 18350 INFO oslo.messaging._drivers.impl_rabbit [-] Delaying reconnect for 1.0 seconds...
>2014-07-15 15:27:40.388 18350 ERROR oslo.messaging._drivers.impl_rabbit [-] AMQP server on 10.35.64.150:5672 is unreachable: timed out. Trying again in 13 seconds.
>2014-07-15 15:27:40.893 18350 ERROR oslo.messaging._drivers.impl_rabbit [-] AMQP server on 10.35.64.150:5672 is unreachable: timed out. Trying again in 13 seconds.
>2014-07-15 15:27:46.169 18350 ERROR oslo.messaging._drivers.impl_rabbit [-] AMQP server on 10.35.64.150:5672 is unreachable: timed out. Trying again in 3 seconds.
>2014-07-15 15:27:49.172 18350 INFO oslo.messaging._drivers.impl_rabbit [-] Reconnecting to AMQP server on 10.35.64.150:5672
>2014-07-15 15:27:49.172 18350 INFO oslo.messaging._drivers.impl_rabbit [-] Delaying reconnect for 1.0 seconds...
>2014-07-15 15:27:53.391 18350 INFO oslo.messaging._drivers.impl_rabbit [-] Reconnecting to AMQP server on 10.35.64.150:5672
>2014-07-15 15:27:53.391 18350 INFO oslo.messaging._drivers.impl_rabbit [-] Delaying reconnect for 1.0 seconds...
>2014-07-15 15:27:53.893 18350 INFO oslo.messaging._drivers.impl_rabbit [-] Reconnecting to AMQP server on 10.35.64.150:5672
>2014-07-15 15:27:53.894 18350 INFO oslo.messaging._drivers.impl_rabbit [-] Delaying reconnect for 1.0 seconds...
>2014-07-15 15:27:55.180 18350 ERROR oslo.messaging._drivers.impl_rabbit [-] AMQP server on 10.35.64.150:5672 is unreachable: timed out. Trying again in 5 seconds.
>2014-07-15 15:27:59.403 18350 ERROR oslo.messaging._drivers.impl_rabbit [-] AMQP server on 10.35.64.150:5672 is unreachable: timed out. Trying again in 15 seconds.
>2014-07-15 15:27:59.902 18350 ERROR oslo.messaging._drivers.impl_rabbit [-] AMQP server on 10.35.64.150:5672 is unreachable: timed out. Trying again in 15 seconds.
>2014-07-15 15:28:00.180 18350 INFO oslo.messaging._drivers.impl_rabbit [-] Reconnecting to AMQP server on 10.35.64.150:5672
>2014-07-15 15:28:00.181 18350 INFO oslo.messaging._drivers.impl_rabbit [-] Delaying reconnect for 1.0 seconds...
>2014-07-15 15:28:06.193 18350 ERROR oslo.messaging._drivers.impl_rabbit [-] AMQP server on 10.35.64.150:5672 is unreachable: timed out. Trying again in 7 seconds.
>2014-07-15 15:28:13.199 18350 INFO oslo.messaging._drivers.impl_rabbit [-] Reconnecting to AMQP server on 10.35.64.150:5672
>2014-07-15 15:28:13.200 18350 INFO oslo.messaging._drivers.impl_rabbit [-] Delaying reconnect for 1.0 seconds...
>2014-07-15 15:28:14.403 18350 INFO oslo.messaging._drivers.impl_rabbit [-] Reconnecting to AMQP server on 10.35.64.150:5672
>2014-07-15 15:28:14.403 18350 INFO oslo.messaging._drivers.impl_rabbit [-] Delaying reconnect for 1.0 seconds...
>2014-07-15 15:28:14.902 18350 INFO oslo.messaging._drivers.impl_rabbit [-] Reconnecting to AMQP server on 10.35.64.150:5672
>2014-07-15 15:28:14.902 18350 INFO oslo.messaging._drivers.impl_rabbit [-] Delaying reconnect for 1.0 seconds...
>2014-07-15 15:28:19.210 18350 ERROR oslo.messaging._drivers.impl_rabbit [-] AMQP server on 10.35.64.150:5672 is unreachable: timed out. Trying again in 9 seconds.
>2014-07-15 15:28:20.412 18350 ERROR oslo.messaging._drivers.impl_rabbit [-] AMQP server on 10.35.64.150:5672 is unreachable: timed out. Trying again in 17 seconds.
>2014-07-15 15:28:20.910 18350 ERROR oslo.messaging._drivers.impl_rabbit [-] AMQP server on 10.35.64.150:5672 is unreachable: timed out. Trying again in 17 seconds.
>2014-07-15 15:28:28.218 18350 INFO oslo.messaging._drivers.impl_rabbit [-] Reconnecting to AMQP server on 10.35.64.150:5672
>2014-07-15 15:28:28.218 18350 INFO oslo.messaging._drivers.impl_rabbit [-] Delaying reconnect for 1.0 seconds...
>2014-07-15 15:28:34.230 18350 ERROR oslo.messaging._drivers.impl_rabbit [-] AMQP server on 10.35.64.150:5672 is unreachable: timed out. Trying again in 11 seconds.
>2014-07-15 15:28:37.416 18350 INFO oslo.messaging._drivers.impl_rabbit [-] Reconnecting to AMQP server on 10.35.64.150:5672
>2014-07-15 15:28:37.416 18350 INFO oslo.messaging._drivers.impl_rabbit [-] Delaying reconnect for 1.0 seconds...
>2014-07-15 15:28:37.911 18350 INFO oslo.messaging._drivers.impl_rabbit [-] Reconnecting to AMQP server on 10.35.64.150:5672
>2014-07-15 15:28:37.911 18350 INFO oslo.messaging._drivers.impl_rabbit [-] Delaying reconnect for 1.0 seconds...
>2014-07-15 15:28:43.428 18350 ERROR oslo.messaging._drivers.impl_rabbit [-] AMQP server on 10.35.64.150:5672 is unreachable: timed out. Trying again in 19 seconds.
>2014-07-15 15:28:43.919 18350 ERROR oslo.messaging._drivers.impl_rabbit [-] AMQP server on 10.35.64.150:5672 is unreachable: timed out. Trying again in 19 seconds.
>2014-07-15 15:28:45.231 18350 INFO oslo.messaging._drivers.impl_rabbit [-] Reconnecting to AMQP server on 10.35.64.150:5672
>2014-07-15 15:28:45.232 18350 INFO oslo.messaging._drivers.impl_rabbit [-] Delaying reconnect for 1.0 seconds...
>2014-07-15 15:28:46.240 18350 ERROR oslo.messaging._drivers.impl_rabbit [-] AMQP server on 10.35.64.150:5672 is unreachable: [Errno 111] ECONNREFUSED. Trying again in 13 seconds.
>2014-07-15 15:28:59.247 18350 INFO oslo.messaging._drivers.impl_rabbit [-] Reconnecting to AMQP server on 10.35.64.150:5672
>2014-07-15 15:28:59.248 18350 INFO oslo.messaging._drivers.impl_rabbit [-] Delaying reconnect for 1.0 seconds...
>2014-07-15 15:29:00.256 18350 ERROR oslo.messaging._drivers.impl_rabbit [-] AMQP server on 10.35.64.150:5672 is unreachable: [Errno 111] ECONNREFUSED. Trying again in 15 seconds.
>2014-07-15 15:29:02.431 18350 INFO oslo.messaging._drivers.impl_rabbit [-] Reconnecting to AMQP server on 10.35.64.150:5672
>2014-07-15 15:29:02.431 18350 INFO oslo.messaging._drivers.impl_rabbit [-] Delaying reconnect for 1.0 seconds...
>2014-07-15 15:29:02.919 18350 INFO oslo.messaging._drivers.impl_rabbit [-] Reconnecting to AMQP server on 10.35.64.150:5672
>2014-07-15 15:29:02.919 18350 INFO oslo.messaging._drivers.impl_rabbit [-] Delaying reconnect for 1.0 seconds...
>2014-07-15 15:29:03.439 18350 ERROR oslo.messaging._drivers.impl_rabbit [-] AMQP server on 10.35.64.150:5672 is unreachable: [Errno 111] ECONNREFUSED. Trying again in 21 seconds.
>2014-07-15 15:29:03.931 18350 INFO oslo.messaging._drivers.impl_rabbit [-] Connected to AMQP server on 10.35.64.150:5672
>2014-07-15 15:29:03.934 18350 ERROR oslo.messaging._drivers.impl_rabbit [-] Failed to consume message from queue: [Errno 104] Connection reset by peer
>2014-07-15 15:29:03.934 18350 TRACE oslo.messaging._drivers.impl_rabbit Traceback (most recent call last):
>2014-07-15 15:29:03.934 18350 TRACE oslo.messaging._drivers.impl_rabbit   File "/usr/lib/python2.6/site-packages/oslo/messaging/_drivers/impl_rabbit.py", line 622, in ensure
>2014-07-15 15:29:03.934 18350 TRACE oslo.messaging._drivers.impl_rabbit     return method(*args, **kwargs)
>2014-07-15 15:29:03.934 18350 TRACE oslo.messaging._drivers.impl_rabbit   File "/usr/lib/python2.6/site-packages/oslo/messaging/_drivers/impl_rabbit.py", line 702, in _consume
>2014-07-15 15:29:03.934 18350 TRACE oslo.messaging._drivers.impl_rabbit     return self.connection.drain_events(timeout=timeout)
>2014-07-15 15:29:03.934 18350 TRACE oslo.messaging._drivers.impl_rabbit   File "/usr/lib/python2.6/site-packages/kombu/connection.py", line 281, in drain_events
>2014-07-15 15:29:03.934 18350 TRACE oslo.messaging._drivers.impl_rabbit     return self.transport.drain_events(self.connection, **kwargs)
>2014-07-15 15:29:03.934 18350 TRACE oslo.messaging._drivers.impl_rabbit   File "/usr/lib/python2.6/site-packages/kombu/transport/pyamqp.py", line 94, in drain_events
>2014-07-15 15:29:03.934 18350 TRACE oslo.messaging._drivers.impl_rabbit     return connection.drain_events(**kwargs)
>2014-07-15 15:29:03.934 18350 TRACE oslo.messaging._drivers.impl_rabbit   File "/usr/lib/python2.6/site-packages/amqp/connection.py", line 286, in drain_events
>2014-07-15 15:29:03.934 18350 TRACE oslo.messaging._drivers.impl_rabbit     return amqp_method(channel, args)
>2014-07-15 15:29:03.934 18350 TRACE oslo.messaging._drivers.impl_rabbit   File "/usr/lib/python2.6/site-packages/amqp/connection.py", line 489, in _close
>2014-07-15 15:29:03.934 18350 TRACE oslo.messaging._drivers.impl_rabbit     self._x_close_ok()
>2014-07-15 15:29:03.934 18350 TRACE oslo.messaging._drivers.impl_rabbit   File "/usr/lib/python2.6/site-packages/amqp/connection.py", line 506, in _x_close_ok
>2014-07-15 15:29:03.934 18350 TRACE oslo.messaging._drivers.impl_rabbit     self._send_method((10, 51))
>2014-07-15 15:29:03.934 18350 TRACE oslo.messaging._drivers.impl_rabbit   File "/usr/lib/python2.6/site-packages/amqp/abstract_channel.py", line 58, in _send_method
>2014-07-15 15:29:03.934 18350 TRACE oslo.messaging._drivers.impl_rabbit     self.channel_id, method_sig, args, content,
>2014-07-15 15:29:03.934 18350 TRACE oslo.messaging._drivers.impl_rabbit   File "/usr/lib/python2.6/site-packages/amqp/method_framing.py", line 224, in write_method
>2014-07-15 15:29:03.934 18350 TRACE oslo.messaging._drivers.impl_rabbit     write_frame(1, channel, payload)
>2014-07-15 15:29:03.934 18350 TRACE oslo.messaging._drivers.impl_rabbit   File "/usr/lib/python2.6/site-packages/amqp/transport.py", line 160, in write_frame
>2014-07-15 15:29:03.934 18350 TRACE oslo.messaging._drivers.impl_rabbit     pack('>BHI%dsB' % size, frame_type, channel, size, payload, 0xce),
>2014-07-15 15:29:03.934 18350 TRACE oslo.messaging._drivers.impl_rabbit   File "/usr/lib/python2.6/site-packages/eventlet/greenio.py", line 309, in sendall
>2014-07-15 15:29:03.934 18350 TRACE oslo.messaging._drivers.impl_rabbit     tail = self.send(data, flags)
>2014-07-15 15:29:03.934 18350 TRACE oslo.messaging._drivers.impl_rabbit   File "/usr/lib/python2.6/site-packages/eventlet/greenio.py", line 295, in send
>2014-07-15 15:29:03.934 18350 TRACE oslo.messaging._drivers.impl_rabbit     total_sent += fd.send(data[total_sent:], flags)
>2014-07-15 15:29:03.934 18350 TRACE oslo.messaging._drivers.impl_rabbit error: [Errno 104] Connection reset by peer
>2014-07-15 15:29:03.934 18350 TRACE oslo.messaging._drivers.impl_rabbit 
>2014-07-15 15:29:03.935 18350 INFO oslo.messaging._drivers.impl_rabbit [-] Reconnecting to AMQP server on 10.35.64.150:5672
>2014-07-15 15:29:03.935 18350 INFO oslo.messaging._drivers.impl_rabbit [-] Delaying reconnect for 1.0 seconds...
>2014-07-15 15:29:04.953 18350 INFO oslo.messaging._drivers.impl_rabbit [-] Connected to AMQP server on 10.35.64.150:5672
>2014-07-15 15:29:15.261 18350 INFO oslo.messaging._drivers.impl_rabbit [-] Reconnecting to AMQP server on 10.35.64.150:5672
>2014-07-15 15:29:15.262 18350 INFO oslo.messaging._drivers.impl_rabbit [-] Delaying reconnect for 1.0 seconds...
>2014-07-15 15:29:16.272 18350 INFO oslo.messaging._drivers.impl_rabbit [-] Connected to AMQP server on 10.35.64.150:5672
>2014-07-15 15:29:24.442 18350 INFO oslo.messaging._drivers.impl_rabbit [-] Reconnecting to AMQP server on 10.35.64.150:5672
>2014-07-15 15:29:24.442 18350 INFO oslo.messaging._drivers.impl_rabbit [-] Delaying reconnect for 1.0 seconds...
>2014-07-15 15:29:25.462 18350 INFO oslo.messaging._drivers.impl_rabbit [-] Connected to AMQP server on 10.35.64.150:5672
>2014-07-15 15:30:04.988 18350 ERROR nova.servicegroup.drivers.db [-] model server went away
>2014-07-15 15:30:04.988 18350 TRACE nova.servicegroup.drivers.db Traceback (most recent call last):
>2014-07-15 15:30:04.988 18350 TRACE nova.servicegroup.drivers.db   File "/usr/lib/python2.6/site-packages/nova/servicegroup/drivers/db.py", line 95, in _report_state
>2014-07-15 15:30:04.988 18350 TRACE nova.servicegroup.drivers.db     service.service_ref, state_catalog)
>2014-07-15 15:30:04.988 18350 TRACE nova.servicegroup.drivers.db   File "/usr/lib/python2.6/site-packages/nova/conductor/api.py", line 218, in service_update
>2014-07-15 15:30:04.988 18350 TRACE nova.servicegroup.drivers.db     return self._manager.service_update(context, service, values)
>2014-07-15 15:30:04.988 18350 TRACE nova.servicegroup.drivers.db   File "/usr/lib/python2.6/site-packages/nova/conductor/rpcapi.py", line 330, in service_update
>2014-07-15 15:30:04.988 18350 TRACE nova.servicegroup.drivers.db     service=service_p, values=values)
>2014-07-15 15:30:04.988 18350 TRACE nova.servicegroup.drivers.db   File "/usr/lib/python2.6/site-packages/oslo/messaging/rpc/client.py", line 150, in call
>2014-07-15 15:30:04.988 18350 TRACE nova.servicegroup.drivers.db     wait_for_reply=True, timeout=timeout)
>2014-07-15 15:30:04.988 18350 TRACE nova.servicegroup.drivers.db   File "/usr/lib/python2.6/site-packages/oslo/messaging/transport.py", line 90, in _send
>2014-07-15 15:30:04.988 18350 TRACE nova.servicegroup.drivers.db     timeout=timeout)
>2014-07-15 15:30:04.988 18350 TRACE nova.servicegroup.drivers.db   File "/usr/lib/python2.6/site-packages/oslo/messaging/_drivers/amqpdriver.py", line 412, in send
>2014-07-15 15:30:04.988 18350 TRACE nova.servicegroup.drivers.db     return self._send(target, ctxt, message, wait_for_reply, timeout)
>2014-07-15 15:30:04.988 18350 TRACE nova.servicegroup.drivers.db   File "/usr/lib/python2.6/site-packages/oslo/messaging/_drivers/amqpdriver.py", line 403, in _send
>2014-07-15 15:30:04.988 18350 TRACE nova.servicegroup.drivers.db     result = self._waiter.wait(msg_id, timeout)
>2014-07-15 15:30:04.988 18350 TRACE nova.servicegroup.drivers.db   File "/usr/lib/python2.6/site-packages/oslo/messaging/_drivers/amqpdriver.py", line 267, in wait
>2014-07-15 15:30:04.988 18350 TRACE nova.servicegroup.drivers.db     reply, ending = self._poll_connection(msg_id, timeout)
>2014-07-15 15:30:04.988 18350 TRACE nova.servicegroup.drivers.db   File "/usr/lib/python2.6/site-packages/oslo/messaging/_drivers/amqpdriver.py", line 217, in _poll_connection
>2014-07-15 15:30:04.988 18350 TRACE nova.servicegroup.drivers.db     % msg_id)
>2014-07-15 15:30:04.988 18350 TRACE nova.servicegroup.drivers.db MessagingTimeout: Timed out waiting for a reply to message ID deadb334a85743d081c17679c4eec5cd
>2014-07-15 15:30:04.988 18350 TRACE nova.servicegroup.drivers.db 
>2014-07-15 15:30:04.990 18350 WARNING nova.openstack.common.loopingcall [-] task run outlasted interval by 197.159587 sec
>2014-07-15 15:30:05.026 18350 ERROR nova.servicegroup.drivers.db [-] Recovered model server connection!

Actions: View

Attachments on bug 1120275: 918452 | 918453 | 918675