Attachment 666667 Details for Bug 889199 – nova logs

nova logs

nova_logs.txt (text/plain), 57.26 KB, created by Nir Magnezi on 2012-12-20 13:46:06 UTC

(hide)

Description:

Filename:

MIME Type:

Creator: Nir Magnezi

Created: 2012-12-20 13:46:06 UTC

Size: 57.26 KB

patch

obsolete

>
>
>
>
>==> /var/log/nova/network.log <==
>2012-12-20 12:10:24 22074 DEBUG nova.manager [-] Running periodic task FlatDHCPManager._publish_service_capabilities periodic_tasks /usr/lib/python2.6/site-packages/nova/manager.py:172
>2012-12-20 12:10:24 22074 DEBUG nova.manager [-] Running periodic task FlatDHCPManager._disassociate_stale_fixed_ips periodic_tasks /usr/lib/python2.6/site-packages/nova/manager.py:172
>
>==> /var/log/nova/compute.log <==
>2012-12-20 12:10:46 22119 DEBUG nova.manager [-] Running periodic task ComputeManager._publish_service_capabilities periodic_tasks /usr/lib/python2.6/site-packages/nova/manager.py:172
>2012-12-20 12:10:46 22119 DEBUG nova.manager [-] Notifying Schedulers of capabilities ... _publish_service_capabilities /usr/lib/python2.6/site-packages/nova/manager.py:231
>2012-12-20 12:10:46 22119 DEBUG nova.openstack.common.rpc.amqp [-] Making asynchronous fanout cast... fanout_cast /usr/lib/python2.6/site-packages/nova/openstack/common/rpc/amqp.py:385
>2012-12-20 12:10:46 22119 DEBUG nova.manager [-] Running periodic task ComputeManager._poll_rescued_instances periodic_tasks /usr/lib/python2.6/site-packages/nova/manager.py:172
>2012-12-20 12:10:46 22119 DEBUG nova.manager [-] Skipping ComputeManager._sync_power_states, 6 ticks left until next run periodic_tasks /usr/lib/python2.6/site-packages/nova/manager.py:167
>2012-12-20 12:10:46 22119 DEBUG nova.manager [-] Running periodic task ComputeManager._poll_bandwidth_usage periodic_tasks /usr/lib/python2.6/site-packages/nova/manager.py:172
>2012-12-20 12:10:46 22119 DEBUG nova.manager [-] Running periodic task ComputeManager._instance_usage_audit periodic_tasks /usr/lib/python2.6/site-packages/nova/manager.py:172
>2012-12-20 12:10:46 22119 DEBUG nova.manager [-] Running periodic task ComputeManager.update_available_resource periodic_tasks /usr/lib/python2.6/site-packages/nova/manager.py:172
>2012-12-20 12:10:46 22119 DEBUG nova.utils [-] Got semaphore "compute_resources" for method "update_available_resource"... inner /usr/lib/python2.6/site-packages/nova/utils.py:721
>2012-12-20 12:10:46 22119 DEBUG nova.compute.resource_tracker [-] Hypervisor: free ram (MB): 13491 _report_hypervisor_resource_view /usr/lib/python2.6/site-packages/nova/compute/resource_tracker.py:470
>2012-12-20 12:10:46 22119 DEBUG nova.compute.resource_tracker [-] Hypervisor: free disk (GB): 15 _report_hypervisor_resource_view /usr/lib/python2.6/site-packages/nova/compute/resource_tracker.py:471
>2012-12-20 12:10:46 22119 DEBUG nova.compute.resource_tracker [-] Hypervisor: free VCPUs: 8 _report_hypervisor_resource_view /usr/lib/python2.6/site-packages/nova/compute/resource_tracker.py:476
>2012-12-20 12:10:46 22119 AUDIT nova.compute.resource_tracker [-] Free ram (MB): 13481
>2012-12-20 12:10:46 22119 AUDIT nova.compute.resource_tracker [-] Free disk (GB): 19
>2012-12-20 12:10:46 22119 AUDIT nova.compute.resource_tracker [-] Free VCPUS: 8
>2012-12-20 12:10:46 22119 INFO nova.compute.resource_tracker [-] Compute_service record updated for blond-vdsf.qa.lab.tlv.redhat.com 
>2012-12-20 12:10:46 22119 DEBUG nova.manager [-] Running periodic task ComputeManager._poll_rebooting_instances periodic_tasks /usr/lib/python2.6/site-packages/nova/manager.py:172
>2012-12-20 12:10:46 22119 DEBUG nova.manager [-] Skipping ComputeManager._cleanup_running_deleted_instances, 15 ticks left until next run periodic_tasks /usr/lib/python2.6/site-packages/nova/manager.py:167
>2012-12-20 12:10:46 22119 DEBUG nova.manager [-] Running periodic task ComputeManager._check_instance_build_time periodic_tasks /usr/lib/python2.6/site-packages/nova/manager.py:172
>2012-12-20 12:10:46 22119 DEBUG nova.manager [-] Running periodic task ComputeManager._heal_instance_info_cache periodic_tasks /usr/lib/python2.6/site-packages/nova/manager.py:172
>2012-12-20 12:10:46 22119 DEBUG nova.manager [-] Running periodic task ComputeManager._run_image_cache_manager_pass periodic_tasks /usr/lib/python2.6/site-packages/nova/manager.py:172
>2012-12-20 12:10:46 22119 DEBUG nova.manager [-] Running periodic task ComputeManager._reclaim_queued_deletes periodic_tasks /usr/lib/python2.6/site-packages/nova/manager.py:172
>2012-12-20 12:10:46 22119 DEBUG nova.compute.manager [-] FLAGS.reclaim_instance_interval <= 0, skipping... _reclaim_queued_deletes /usr/lib/python2.6/site-packages/nova/compute/manager.py:2790
>2012-12-20 12:10:46 22119 DEBUG nova.manager [-] Running periodic task ComputeManager._report_driver_status periodic_tasks /usr/lib/python2.6/site-packages/nova/manager.py:172
>2012-12-20 12:10:46 22119 DEBUG nova.manager [-] Running periodic task ComputeManager._poll_unconfirmed_resizes periodic_tasks /usr/lib/python2.6/site-packages/nova/manager.py:172
>
>==> /var/log/nova/network.log <==
>2012-12-20 12:10:51 22074 DEBUG nova.openstack.common.rpc.amqp [-] received {u'_context_roles': [u'admin'], u'_msg_id': u'3a7b19cc9c704d34ac6f3d19e27c53eb', u'_context_quota_class': None, u'_context_request_id': u'req-0a6c73ac-e51e-490e-ac60-297717ef990a', u'_context_service_catalog': [{u'endpoints': [{u'adminURL': u'http://10.35.171.174:8776/v1/537b496443f54f25acc33fc3fa0be5c2', u'region': u'RegionOne', u'internalURL': u'http://10.35.171.174:8776/v1/537b496443f54f25acc33fc3fa0be5c2', u'id': u'ae8b294e48994c63bbbe39493d2a5ed1', u'publicURL': u'http://10.35.171.174:8776/v1/537b496443f54f25acc33fc3fa0be5c2'}], u'endpoints_links': [], u'type': u'volume', u'name': u'cinder'}, {u'endpoints': [{u'adminURL': u'http://10.35.169.164:9292/v1', u'region': u'RegionOne', u'internalURL': u'http://10.35.169.164:9292/v1', u'id': u'7e5aade9d8ec47fc873d105503dee5ca', u'publicURL': u'http://10.35.169.164:9292/v1'}], u'endpoints_links': [], u'type': u'image', u'name': u'glance'}, {u'endpoints': [{u'adminURL': u'http://10.35.171.194:8774/v2/537b496443f54f25acc33fc3fa0be5c2', u'region': u'RegionOne', u'internalURL': u'http://10.35.171.194:8774/v2/537b496443f54f25acc33fc3fa0be5c2', u'id': u'7689bd13ea254d76ac3279ff50206af9', u'publicURL': u'http://10.35.171.194:8774/v2/537b496443f54f25acc33fc3fa0be5c2'}], u'endpoints_links': [], u'type': u'compute', u'name': u'nova'}, {u'endpoints': [{u'adminURL': u'http://10.35.171.194:8773/services/Admin', u'region': u'RegionOne', u'internalURL': u'http://10.35.171.194:8773/services/Cloud', u'id': u'74b7c14ddb1d49d2bad6523544e57064', u'publicURL': u'http://10.35.171.194:8773/services/Cloud'}], u'endpoints_links': [], u'type': u'ec2', u'name': u'nova_ec2'}, {u'endpoints': [{u'adminURL': u'http://10.35.169.162:35357/v2.0', u'region': u'RegionOne', u'internalURL': u'http://10.35.169.162:5000/v2.0', u'id': u'654f1dd16021471ebffb0607cc186199', u'publicURL': u'http://10.35.169.162:5000/v2.0'}], u'endpoints_links': [], u'type': u'identity', u'name': u'keystone'}], u'_context_user_name': u'admin', u'_context_auth_token': '<SANITIZED>', u'_context_instance_lock_checked': False, u'_context_project_name': u'admin', u'_context_is_admin': True, u'_context_project_id': u'537b496443f54f25acc33fc3fa0be5c2', u'_context_timestamp': u'2012-12-20T12:11:57.059224', u'_context_read_deleted': u'no', u'_context_user_id': u'6ae6423f10d54cf7a6b22d6eedfc307b', u'method': u'get_floating_ips_by_project', u'_context_remote_address': u'10.35.169.165'} _safe_log /usr/lib/python2.6/site-packages/nova/openstack/common/rpc/common.py:195
>2012-12-20 12:10:51 22074 DEBUG nova.openstack.common.rpc.amqp [-] unpacked context: {'project_name': u'admin', 'user_id': u'6ae6423f10d54cf7a6b22d6eedfc307b', 'roles': [u'admin'], 'timestamp': u'2012-12-20T12:11:57.059224', 'auth_token': '<SANITIZED>', 'remote_address': u'10.35.169.165', 'quota_class': None, 'is_admin': True, 'service_catalog': [{u'endpoints_links': [], u'endpoints': [{u'adminURL': u'http://10.35.171.174:8776/v1/537b496443f54f25acc33fc3fa0be5c2', u'region': u'RegionOne', u'publicURL': u'http://10.35.171.174:8776/v1/537b496443f54f25acc33fc3fa0be5c2', u'internalURL': u'http://10.35.171.174:8776/v1/537b496443f54f25acc33fc3fa0be5c2', u'id': u'ae8b294e48994c63bbbe39493d2a5ed1'}], u'type': u'volume', u'name': u'cinder'}, {u'endpoints_links': [], u'endpoints': [{u'adminURL': u'http://10.35.169.164:9292/v1', u'region': u'RegionOne', u'publicURL': u'http://10.35.169.164:9292/v1', u'internalURL': u'http://10.35.169.164:9292/v1', u'id': u'7e5aade9d8ec47fc873d105503dee5ca'}], u'type': u'image', u'name': u'glance'}, {u'endpoints_links': [], u'endpoints': [{u'adminURL': u'http://10.35.171.194:8774/v2/537b496443f54f25acc33fc3fa0be5c2', u'region': u'RegionOne', u'publicURL': u'http://10.35.171.194:8774/v2/537b496443f54f25acc33fc3fa0be5c2', u'internalURL': u'http://10.35.171.194:8774/v2/537b496443f54f25acc33fc3fa0be5c2', u'id': u'7689bd13ea254d76ac3279ff50206af9'}], u'type': u'compute', u'name': u'nova'}, {u'endpoints_links': [], u'endpoints': [{u'adminURL': u'http://10.35.171.194:8773/services/Admin', u'region': u'RegionOne', u'publicURL': u'http://10.35.171.194:8773/services/Cloud', u'internalURL': u'http://10.35.171.194:8773/services/Cloud', u'id': u'74b7c14ddb1d49d2bad6523544e57064'}], u'type': u'ec2', u'name': u'nova_ec2'}, {u'endpoints_links': [], u'endpoints': [{u'adminURL': u'http://10.35.169.162:35357/v2.0', u'region': u'RegionOne', u'publicURL': u'http://10.35.169.162:5000/v2.0', u'internalURL': u'http://10.35.169.162:5000/v2.0', u'id': u'654f1dd16021471ebffb0607cc186199'}], u'type': u'identity', u'name': u'keystone'}], 'request_id': u'req-0a6c73ac-e51e-490e-ac60-297717ef990a', 'instance_lock_checked': False, 'project_id': u'537b496443f54f25acc33fc3fa0be5c2', 'user_name': u'admin', 'read_deleted': u'no'} _safe_log /usr/lib/python2.6/site-packages/nova/openstack/common/rpc/common.py:195
>2012-12-20 12:10:51 DEBUG nova.utils [req-0a6c73ac-e51e-490e-ac60-297717ef990a 6ae6423f10d54cf7a6b22d6eedfc307b 537b496443f54f25acc33fc3fa0be5c2] Reloading cached file /etc/nova/policy.json read_cached_file /usr/lib/python2.6/site-packages/nova/utils.py:1137
>2012-12-20 12:10:51 22074 DEBUG nova.openstack.common.rpc.amqp [-] Pool creating new connection create /usr/lib/python2.6/site-packages/nova/openstack/common/rpc/amqp.py:58
>2012-12-20 12:10:51 22074 INFO nova.openstack.common.rpc.impl_qpid [-] Connected to AMQP server on 10.35.171.163:5672
>2012-12-20 12:11:13 22074 DEBUG nova.openstack.common.rpc.amqp [-] received {u'_context_roles': [u'admin'], u'_msg_id': u'4805a8f84c6c4444a4079e41a864e2d3', u'_context_quota_class': None, u'_context_request_id': u'req-7a89bb6d-7959-484d-a2f4-6d540f27a063', u'_context_service_catalog': [{u'endpoints': [{u'adminURL': u'http://10.35.171.174:8776/v1/537b496443f54f25acc33fc3fa0be5c2', u'region': u'RegionOne', u'internalURL': u'http://10.35.171.174:8776/v1/537b496443f54f25acc33fc3fa0be5c2', u'id': u'ae8b294e48994c63bbbe39493d2a5ed1', u'publicURL': u'http://10.35.171.174:8776/v1/537b496443f54f25acc33fc3fa0be5c2'}], u'endpoints_links': [], u'type': u'volume', u'name': u'cinder'}, {u'endpoints': [{u'adminURL': u'http://10.35.169.164:9292/v1', u'region': u'RegionOne', u'internalURL': u'http://10.35.169.164:9292/v1', u'id': u'7e5aade9d8ec47fc873d105503dee5ca', u'publicURL': u'http://10.35.169.164:9292/v1'}], u'endpoints_links': [], u'type': u'image', u'name': u'glance'}, {u'endpoints': [{u'adminURL': u'http://10.35.171.194:8774/v2/537b496443f54f25acc33fc3fa0be5c2', u'region': u'RegionOne', u'internalURL': u'http://10.35.171.194:8774/v2/537b496443f54f25acc33fc3fa0be5c2', u'id': u'7689bd13ea254d76ac3279ff50206af9', u'publicURL': u'http://10.35.171.194:8774/v2/537b496443f54f25acc33fc3fa0be5c2'}], u'endpoints_links': [], u'type': u'compute', u'name': u'nova'}, {u'endpoints': [{u'adminURL': u'http://10.35.171.194:8773/services/Admin', u'region': u'RegionOne', u'internalURL': u'http://10.35.171.194:8773/services/Cloud', u'id': u'74b7c14ddb1d49d2bad6523544e57064', u'publicURL': u'http://10.35.171.194:8773/services/Cloud'}], u'endpoints_links': [], u'type': u'ec2', u'name': u'nova_ec2'}, {u'endpoints': [{u'adminURL': u'http://10.35.169.162:35357/v2.0', u'region': u'RegionOne', u'internalURL': u'http://10.35.169.162:5000/v2.0', u'id': u'654f1dd16021471ebffb0607cc186199', u'publicURL': u'http://10.35.169.162:5000/v2.0'}], u'endpoints_links': [], u'type': u'identity', u'name': u'keystone'}], u'_context_user_name': u'admin', u'_context_auth_token': '<SANITIZED>', u'_context_instance_lock_checked': False, u'_context_project_name': u'admin', u'_context_is_admin': True, u'_context_project_id': u'537b496443f54f25acc33fc3fa0be5c2', u'_context_timestamp': u'2012-12-20T12:12:19.769157', u'_context_read_deleted': u'no', u'_context_user_id': u'6ae6423f10d54cf7a6b22d6eedfc307b', u'method': u'get_floating_ips_by_project', u'_context_remote_address': u'10.35.169.165'} _safe_log /usr/lib/python2.6/site-packages/nova/openstack/common/rpc/common.py:195
>2012-12-20 12:11:13 22074 DEBUG nova.openstack.common.rpc.amqp [-] unpacked context: {'project_name': u'admin', 'user_id': u'6ae6423f10d54cf7a6b22d6eedfc307b', 'roles': [u'admin'], 'timestamp': u'2012-12-20T12:12:19.769157', 'auth_token': '<SANITIZED>', 'remote_address': u'10.35.169.165', 'quota_class': None, 'is_admin': True, 'service_catalog': [{u'endpoints_links': [], u'endpoints': [{u'adminURL': u'http://10.35.171.174:8776/v1/537b496443f54f25acc33fc3fa0be5c2', u'region': u'RegionOne', u'publicURL': u'http://10.35.171.174:8776/v1/537b496443f54f25acc33fc3fa0be5c2', u'internalURL': u'http://10.35.171.174:8776/v1/537b496443f54f25acc33fc3fa0be5c2', u'id': u'ae8b294e48994c63bbbe39493d2a5ed1'}], u'type': u'volume', u'name': u'cinder'}, {u'endpoints_links': [], u'endpoints': [{u'adminURL': u'http://10.35.169.164:9292/v1', u'region': u'RegionOne', u'publicURL': u'http://10.35.169.164:9292/v1', u'internalURL': u'http://10.35.169.164:9292/v1', u'id': u'7e5aade9d8ec47fc873d105503dee5ca'}], u'type': u'image', u'name': u'glance'}, {u'endpoints_links': [], u'endpoints': [{u'adminURL': u'http://10.35.171.194:8774/v2/537b496443f54f25acc33fc3fa0be5c2', u'region': u'RegionOne', u'publicURL': u'http://10.35.171.194:8774/v2/537b496443f54f25acc33fc3fa0be5c2', u'internalURL': u'http://10.35.171.194:8774/v2/537b496443f54f25acc33fc3fa0be5c2', u'id': u'7689bd13ea254d76ac3279ff50206af9'}], u'type': u'compute', u'name': u'nova'}, {u'endpoints_links': [], u'endpoints': [{u'adminURL': u'http://10.35.171.194:8773/services/Admin', u'region': u'RegionOne', u'publicURL': u'http://10.35.171.194:8773/services/Cloud', u'internalURL': u'http://10.35.171.194:8773/services/Cloud', u'id': u'74b7c14ddb1d49d2bad6523544e57064'}], u'type': u'ec2', u'name': u'nova_ec2'}, {u'endpoints_links': [], u'endpoints': [{u'adminURL': u'http://10.35.169.162:35357/v2.0', u'region': u'RegionOne', u'publicURL': u'http://10.35.169.162:5000/v2.0', u'internalURL': u'http://10.35.169.162:5000/v2.0', u'id': u'654f1dd16021471ebffb0607cc186199'}], u'type': u'identity', u'name': u'keystone'}], 'request_id': u'req-7a89bb6d-7959-484d-a2f4-6d540f27a063', 'instance_lock_checked': False, 'project_id': u'537b496443f54f25acc33fc3fa0be5c2', 'user_name': u'admin', 'read_deleted': u'no'} _safe_log /usr/lib/python2.6/site-packages/nova/openstack/common/rpc/common.py:195
>2012-12-20 12:11:24 22074 DEBUG nova.manager [-] Running periodic task FlatDHCPManager._publish_service_capabilities periodic_tasks /usr/lib/python2.6/site-packages/nova/manager.py:172
>2012-12-20 12:11:24 22074 DEBUG nova.manager [-] Running periodic task FlatDHCPManager._disassociate_stale_fixed_ips periodic_tasks /usr/lib/python2.6/site-packages/nova/manager.py:172
>
>==> /var/log/nova/compute.log <==
>2012-12-20 12:11:46 22119 DEBUG nova.manager [-] Running periodic task ComputeManager._publish_service_capabilities periodic_tasks /usr/lib/python2.6/site-packages/nova/manager.py:172
>2012-12-20 12:11:46 22119 DEBUG nova.manager [-] Notifying Schedulers of capabilities ... _publish_service_capabilities /usr/lib/python2.6/site-packages/nova/manager.py:231
>2012-12-20 12:11:46 22119 DEBUG nova.openstack.common.rpc.amqp [-] Making asynchronous fanout cast... fanout_cast /usr/lib/python2.6/site-packages/nova/openstack/common/rpc/amqp.py:385
>2012-12-20 12:11:46 22119 DEBUG nova.manager [-] Running periodic task ComputeManager._poll_rescued_instances periodic_tasks /usr/lib/python2.6/site-packages/nova/manager.py:172
>2012-12-20 12:11:46 22119 DEBUG nova.manager [-] Skipping ComputeManager._sync_power_states, 5 ticks left until next run periodic_tasks /usr/lib/python2.6/site-packages/nova/manager.py:167
>2012-12-20 12:11:46 22119 DEBUG nova.manager [-] Running periodic task ComputeManager._poll_bandwidth_usage periodic_tasks /usr/lib/python2.6/site-packages/nova/manager.py:172
>2012-12-20 12:11:46 22119 DEBUG nova.manager [-] Running periodic task ComputeManager._instance_usage_audit periodic_tasks /usr/lib/python2.6/site-packages/nova/manager.py:172
>2012-12-20 12:11:46 22119 DEBUG nova.manager [-] Running periodic task ComputeManager.update_available_resource periodic_tasks /usr/lib/python2.6/site-packages/nova/manager.py:172
>2012-12-20 12:11:46 22119 DEBUG nova.utils [-] Got semaphore "compute_resources" for method "update_available_resource"... inner /usr/lib/python2.6/site-packages/nova/utils.py:721
>2012-12-20 12:11:47 22119 DEBUG nova.compute.resource_tracker [-] Hypervisor: free ram (MB): 13491 _report_hypervisor_resource_view /usr/lib/python2.6/site-packages/nova/compute/resource_tracker.py:470
>2012-12-20 12:11:47 22119 DEBUG nova.compute.resource_tracker [-] Hypervisor: free disk (GB): 15 _report_hypervisor_resource_view /usr/lib/python2.6/site-packages/nova/compute/resource_tracker.py:471
>2012-12-20 12:11:47 22119 DEBUG nova.compute.resource_tracker [-] Hypervisor: free VCPUs: 8 _report_hypervisor_resource_view /usr/lib/python2.6/site-packages/nova/compute/resource_tracker.py:476
>2012-12-20 12:11:47 22119 AUDIT nova.compute.resource_tracker [-] Free ram (MB): 13481
>2012-12-20 12:11:47 22119 AUDIT nova.compute.resource_tracker [-] Free disk (GB): 19
>2012-12-20 12:11:47 22119 AUDIT nova.compute.resource_tracker [-] Free VCPUS: 8
>2012-12-20 12:11:47 22119 INFO nova.compute.resource_tracker [-] Compute_service record updated for blond-vdsf.qa.lab.tlv.redhat.com 
>2012-12-20 12:11:47 22119 DEBUG nova.manager [-] Running periodic task ComputeManager._poll_rebooting_instances periodic_tasks /usr/lib/python2.6/site-packages/nova/manager.py:172
>2012-12-20 12:11:47 22119 DEBUG nova.manager [-] Skipping ComputeManager._cleanup_running_deleted_instances, 14 ticks left until next run periodic_tasks /usr/lib/python2.6/site-packages/nova/manager.py:167
>2012-12-20 12:11:47 22119 DEBUG nova.manager [-] Running periodic task ComputeManager._check_instance_build_time periodic_tasks /usr/lib/python2.6/site-packages/nova/manager.py:172
>2012-12-20 12:11:47 22119 DEBUG nova.manager [-] Running periodic task ComputeManager._heal_instance_info_cache periodic_tasks /usr/lib/python2.6/site-packages/nova/manager.py:172
>2012-12-20 12:11:47 22119 DEBUG nova.manager [-] Running periodic task ComputeManager._run_image_cache_manager_pass periodic_tasks /usr/lib/python2.6/site-packages/nova/manager.py:172
>2012-12-20 12:11:47 22119 DEBUG nova.manager [-] Running periodic task ComputeManager._reclaim_queued_deletes periodic_tasks /usr/lib/python2.6/site-packages/nova/manager.py:172
>2012-12-20 12:11:47 22119 DEBUG nova.compute.manager [-] FLAGS.reclaim_instance_interval <= 0, skipping... _reclaim_queued_deletes /usr/lib/python2.6/site-packages/nova/compute/manager.py:2790
>2012-12-20 12:11:47 22119 DEBUG nova.manager [-] Running periodic task ComputeManager._report_driver_status periodic_tasks /usr/lib/python2.6/site-packages/nova/manager.py:172
>2012-12-20 12:11:47 22119 INFO nova.compute.manager [-] Updating host status
>2012-12-20 12:11:47 22119 DEBUG nova.virt.libvirt.driver [-] Updating host stats update_status /usr/lib/python2.6/site-packages/nova/virt/libvirt/driver.py:3063
>2012-12-20 12:11:47 22119 DEBUG nova.manager [-] Running periodic task ComputeManager._poll_unconfirmed_resizes periodic_tasks /usr/lib/python2.6/site-packages/nova/manager.py:172
>
>==> /var/log/nova/network.log <==
>2012-12-20 12:12:24 22074 DEBUG nova.manager [-] Running periodic task FlatDHCPManager._publish_service_capabilities periodic_tasks /usr/lib/python2.6/site-packages/nova/manager.py:172
>2012-12-20 12:12:24 22074 DEBUG nova.manager [-] Running periodic task FlatDHCPManager._disassociate_stale_fixed_ips periodic_tasks /usr/lib/python2.6/site-packages/nova/manager.py:172
>
>==> /var/log/nova/compute.log <==
>2012-12-20 12:12:47 22119 DEBUG nova.manager [-] Running periodic task ComputeManager._publish_service_capabilities periodic_tasks /usr/lib/python2.6/site-packages/nova/manager.py:172
>2012-12-20 12:12:47 22119 DEBUG nova.manager [-] Notifying Schedulers of capabilities ... _publish_service_capabilities /usr/lib/python2.6/site-packages/nova/manager.py:231
>2012-12-20 12:12:47 22119 DEBUG nova.openstack.common.rpc.amqp [-] Making asynchronous fanout cast... fanout_cast /usr/lib/python2.6/site-packages/nova/openstack/common/rpc/amqp.py:385
>2012-12-20 12:12:47 22119 DEBUG nova.manager [-] Running periodic task ComputeManager._poll_rescued_instances periodic_tasks /usr/lib/python2.6/site-packages/nova/manager.py:172
>2012-12-20 12:12:47 22119 DEBUG nova.manager [-] Skipping ComputeManager._sync_power_states, 4 ticks left until next run periodic_tasks /usr/lib/python2.6/site-packages/nova/manager.py:167
>2012-12-20 12:12:47 22119 DEBUG nova.manager [-] Running periodic task ComputeManager._poll_bandwidth_usage periodic_tasks /usr/lib/python2.6/site-packages/nova/manager.py:172
>2012-12-20 12:12:47 22119 DEBUG nova.manager [-] Running periodic task ComputeManager._instance_usage_audit periodic_tasks /usr/lib/python2.6/site-packages/nova/manager.py:172
>2012-12-20 12:12:47 22119 DEBUG nova.manager [-] Running periodic task ComputeManager.update_available_resource periodic_tasks /usr/lib/python2.6/site-packages/nova/manager.py:172
>2012-12-20 12:12:47 22119 DEBUG nova.utils [-] Got semaphore "compute_resources" for method "update_available_resource"... inner /usr/lib/python2.6/site-packages/nova/utils.py:721
>2012-12-20 12:12:47 22119 DEBUG nova.compute.resource_tracker [-] Hypervisor: free ram (MB): 13491 _report_hypervisor_resource_view /usr/lib/python2.6/site-packages/nova/compute/resource_tracker.py:470
>2012-12-20 12:12:47 22119 DEBUG nova.compute.resource_tracker [-] Hypervisor: free disk (GB): 15 _report_hypervisor_resource_view /usr/lib/python2.6/site-packages/nova/compute/resource_tracker.py:471
>2012-12-20 12:12:47 22119 DEBUG nova.compute.resource_tracker [-] Hypervisor: free VCPUs: 8 _report_hypervisor_resource_view /usr/lib/python2.6/site-packages/nova/compute/resource_tracker.py:476
>2012-12-20 12:12:47 22119 AUDIT nova.compute.resource_tracker [-] Free ram (MB): 13481
>2012-12-20 12:12:47 22119 AUDIT nova.compute.resource_tracker [-] Free disk (GB): 19
>2012-12-20 12:12:47 22119 AUDIT nova.compute.resource_tracker [-] Free VCPUS: 8
>2012-12-20 12:12:47 22119 INFO nova.compute.resource_tracker [-] Compute_service record updated for blond-vdsf.qa.lab.tlv.redhat.com 
>2012-12-20 12:12:47 22119 DEBUG nova.manager [-] Running periodic task ComputeManager._poll_rebooting_instances periodic_tasks /usr/lib/python2.6/site-packages/nova/manager.py:172
>2012-12-20 12:12:47 22119 DEBUG nova.manager [-] Skipping ComputeManager._cleanup_running_deleted_instances, 13 ticks left until next run periodic_tasks /usr/lib/python2.6/site-packages/nova/manager.py:167
>2012-12-20 12:12:47 22119 DEBUG nova.manager [-] Running periodic task ComputeManager._check_instance_build_time periodic_tasks /usr/lib/python2.6/site-packages/nova/manager.py:172
>2012-12-20 12:12:47 22119 DEBUG nova.manager [-] Running periodic task ComputeManager._heal_instance_info_cache periodic_tasks /usr/lib/python2.6/site-packages/nova/manager.py:172
>2012-12-20 12:12:47 22119 DEBUG nova.manager [-] Running periodic task ComputeManager._run_image_cache_manager_pass periodic_tasks /usr/lib/python2.6/site-packages/nova/manager.py:172
>2012-12-20 12:12:47 22119 DEBUG nova.manager [-] Running periodic task ComputeManager._reclaim_queued_deletes periodic_tasks /usr/lib/python2.6/site-packages/nova/manager.py:172
>2012-12-20 12:12:47 22119 DEBUG nova.compute.manager [-] FLAGS.reclaim_instance_interval <= 0, skipping... _reclaim_queued_deletes /usr/lib/python2.6/site-packages/nova/compute/manager.py:2790
>2012-12-20 12:12:47 22119 DEBUG nova.manager [-] Running periodic task ComputeManager._report_driver_status periodic_tasks /usr/lib/python2.6/site-packages/nova/manager.py:172
>2012-12-20 12:12:47 22119 DEBUG nova.manager [-] Running periodic task ComputeManager._poll_unconfirmed_resizes periodic_tasks /usr/lib/python2.6/site-packages/nova/manager.py:172
>
>==> /var/log/nova/network.log <==
>2012-12-20 12:13:24 22074 DEBUG nova.manager [-] Running periodic task FlatDHCPManager._publish_service_capabilities periodic_tasks /usr/lib/python2.6/site-packages/nova/manager.py:172
>2012-12-20 12:13:24 22074 DEBUG nova.manager [-] Running periodic task FlatDHCPManager._disassociate_stale_fixed_ips periodic_tasks /usr/lib/python2.6/site-packages/nova/manager.py:172
>
>==> /var/log/nova/compute.log <==
>2012-12-20 12:13:47 22119 DEBUG nova.manager [-] Running periodic task ComputeManager._publish_service_capabilities periodic_tasks /usr/lib/python2.6/site-packages/nova/manager.py:172
>2012-12-20 12:13:47 22119 DEBUG nova.manager [-] Notifying Schedulers of capabilities ... _publish_service_capabilities /usr/lib/python2.6/site-packages/nova/manager.py:231
>2012-12-20 12:13:47 22119 DEBUG nova.openstack.common.rpc.amqp [-] Making asynchronous fanout cast... fanout_cast /usr/lib/python2.6/site-packages/nova/openstack/common/rpc/amqp.py:385
>2012-12-20 12:13:47 22119 DEBUG nova.manager [-] Running periodic task ComputeManager._poll_rescued_instances periodic_tasks /usr/lib/python2.6/site-packages/nova/manager.py:172
>2012-12-20 12:13:47 22119 DEBUG nova.manager [-] Skipping ComputeManager._sync_power_states, 3 ticks left until next run periodic_tasks /usr/lib/python2.6/site-packages/nova/manager.py:167
>2012-12-20 12:13:47 22119 DEBUG nova.manager [-] Running periodic task ComputeManager._poll_bandwidth_usage periodic_tasks /usr/lib/python2.6/site-packages/nova/manager.py:172
>2012-12-20 12:13:47 22119 DEBUG nova.manager [-] Running periodic task ComputeManager._instance_usage_audit periodic_tasks /usr/lib/python2.6/site-packages/nova/manager.py:172
>2012-12-20 12:13:47 22119 DEBUG nova.manager [-] Running periodic task ComputeManager.update_available_resource periodic_tasks /usr/lib/python2.6/site-packages/nova/manager.py:172
>2012-12-20 12:13:47 22119 DEBUG nova.utils [-] Got semaphore "compute_resources" for method "update_available_resource"... inner /usr/lib/python2.6/site-packages/nova/utils.py:721
>2012-12-20 12:13:47 22119 DEBUG nova.compute.resource_tracker [-] Hypervisor: free ram (MB): 13490 _report_hypervisor_resource_view /usr/lib/python2.6/site-packages/nova/compute/resource_tracker.py:470
>2012-12-20 12:13:47 22119 DEBUG nova.compute.resource_tracker [-] Hypervisor: free disk (GB): 15 _report_hypervisor_resource_view /usr/lib/python2.6/site-packages/nova/compute/resource_tracker.py:471
>2012-12-20 12:13:47 22119 DEBUG nova.compute.resource_tracker [-] Hypervisor: free VCPUs: 8 _report_hypervisor_resource_view /usr/lib/python2.6/site-packages/nova/compute/resource_tracker.py:476
>2012-12-20 12:13:47 22119 AUDIT nova.compute.resource_tracker [-] Free ram (MB): 13481
>2012-12-20 12:13:47 22119 AUDIT nova.compute.resource_tracker [-] Free disk (GB): 19
>2012-12-20 12:13:47 22119 AUDIT nova.compute.resource_tracker [-] Free VCPUS: 8
>2012-12-20 12:13:48 22119 INFO nova.compute.resource_tracker [-] Compute_service record updated for blond-vdsf.qa.lab.tlv.redhat.com 
>2012-12-20 12:13:48 22119 DEBUG nova.manager [-] Running periodic task ComputeManager._poll_rebooting_instances periodic_tasks /usr/lib/python2.6/site-packages/nova/manager.py:172
>2012-12-20 12:13:48 22119 DEBUG nova.manager [-] Skipping ComputeManager._cleanup_running_deleted_instances, 12 ticks left until next run periodic_tasks /usr/lib/python2.6/site-packages/nova/manager.py:167
>2012-12-20 12:13:48 22119 DEBUG nova.manager [-] Running periodic task ComputeManager._check_instance_build_time periodic_tasks /usr/lib/python2.6/site-packages/nova/manager.py:172
>2012-12-20 12:13:48 22119 DEBUG nova.manager [-] Running periodic task ComputeManager._heal_instance_info_cache periodic_tasks /usr/lib/python2.6/site-packages/nova/manager.py:172
>2012-12-20 12:13:48 22119 DEBUG nova.manager [-] Running periodic task ComputeManager._run_image_cache_manager_pass periodic_tasks /usr/lib/python2.6/site-packages/nova/manager.py:172
>2012-12-20 12:13:48 22119 DEBUG nova.manager [-] Running periodic task ComputeManager._reclaim_queued_deletes periodic_tasks /usr/lib/python2.6/site-packages/nova/manager.py:172
>2012-12-20 12:13:48 22119 DEBUG nova.compute.manager [-] FLAGS.reclaim_instance_interval <= 0, skipping... _reclaim_queued_deletes /usr/lib/python2.6/site-packages/nova/compute/manager.py:2790
>2012-12-20 12:13:48 22119 DEBUG nova.manager [-] Running periodic task ComputeManager._report_driver_status periodic_tasks /usr/lib/python2.6/site-packages/nova/manager.py:172
>2012-12-20 12:13:48 22119 INFO nova.compute.manager [-] Updating host status
>2012-12-20 12:13:48 22119 DEBUG nova.virt.libvirt.driver [-] Updating host stats update_status /usr/lib/python2.6/site-packages/nova/virt/libvirt/driver.py:3063
>2012-12-20 12:13:48 22119 DEBUG nova.manager [-] Running periodic task ComputeManager._poll_unconfirmed_resizes periodic_tasks /usr/lib/python2.6/site-packages/nova/manager.py:172
>
>==> /var/log/nova/network.log <==
>2012-12-20 12:14:24 22074 DEBUG nova.manager [-] Running periodic task FlatDHCPManager._publish_service_capabilities periodic_tasks /usr/lib/python2.6/site-packages/nova/manager.py:172
>2012-12-20 12:14:24 22074 DEBUG nova.manager [-] Running periodic task FlatDHCPManager._disassociate_stale_fixed_ips periodic_tasks /usr/lib/python2.6/site-packages/nova/manager.py:172
>
>==> /var/log/nova/compute.log <==
>2012-12-20 12:14:48 22119 DEBUG nova.manager [-] Running periodic task ComputeManager._publish_service_capabilities periodic_tasks /usr/lib/python2.6/site-packages/nova/manager.py:172
>2012-12-20 12:14:48 22119 DEBUG nova.manager [-] Notifying Schedulers of capabilities ... _publish_service_capabilities /usr/lib/python2.6/site-packages/nova/manager.py:231
>2012-12-20 12:14:48 22119 DEBUG nova.openstack.common.rpc.amqp [-] Making asynchronous fanout cast... fanout_cast /usr/lib/python2.6/site-packages/nova/openstack/common/rpc/amqp.py:385
>2012-12-20 12:14:48 22119 DEBUG nova.manager [-] Running periodic task ComputeManager._poll_rescued_instances periodic_tasks /usr/lib/python2.6/site-packages/nova/manager.py:172
>2012-12-20 12:14:48 22119 DEBUG nova.manager [-] Skipping ComputeManager._sync_power_states, 2 ticks left until next run periodic_tasks /usr/lib/python2.6/site-packages/nova/manager.py:167
>2012-12-20 12:14:48 22119 DEBUG nova.manager [-] Running periodic task ComputeManager._poll_bandwidth_usage periodic_tasks /usr/lib/python2.6/site-packages/nova/manager.py:172
>2012-12-20 12:14:48 22119 DEBUG nova.manager [-] Running periodic task ComputeManager._instance_usage_audit periodic_tasks /usr/lib/python2.6/site-packages/nova/manager.py:172
>2012-12-20 12:14:48 22119 DEBUG nova.manager [-] Running periodic task ComputeManager.update_available_resource periodic_tasks /usr/lib/python2.6/site-packages/nova/manager.py:172
>2012-12-20 12:14:48 22119 DEBUG nova.utils [-] Got semaphore "compute_resources" for method "update_available_resource"... inner /usr/lib/python2.6/site-packages/nova/utils.py:721
>2012-12-20 12:14:48 22119 DEBUG nova.compute.resource_tracker [-] Hypervisor: free ram (MB): 13491 _report_hypervisor_resource_view /usr/lib/python2.6/site-packages/nova/compute/resource_tracker.py:470
>2012-12-20 12:14:48 22119 DEBUG nova.compute.resource_tracker [-] Hypervisor: free disk (GB): 15 _report_hypervisor_resource_view /usr/lib/python2.6/site-packages/nova/compute/resource_tracker.py:471
>2012-12-20 12:14:48 22119 DEBUG nova.compute.resource_tracker [-] Hypervisor: free VCPUs: 8 _report_hypervisor_resource_view /usr/lib/python2.6/site-packages/nova/compute/resource_tracker.py:476
>2012-12-20 12:14:48 22119 AUDIT nova.compute.resource_tracker [-] Free ram (MB): 13481
>2012-12-20 12:14:48 22119 AUDIT nova.compute.resource_tracker [-] Free disk (GB): 19
>2012-12-20 12:14:48 22119 AUDIT nova.compute.resource_tracker [-] Free VCPUS: 8
>2012-12-20 12:14:48 22119 INFO nova.compute.resource_tracker [-] Compute_service record updated for blond-vdsf.qa.lab.tlv.redhat.com 
>2012-12-20 12:14:48 22119 DEBUG nova.manager [-] Running periodic task ComputeManager._poll_rebooting_instances periodic_tasks /usr/lib/python2.6/site-packages/nova/manager.py:172
>2012-12-20 12:14:48 22119 DEBUG nova.manager [-] Skipping ComputeManager._cleanup_running_deleted_instances, 11 ticks left until next run periodic_tasks /usr/lib/python2.6/site-packages/nova/manager.py:167
>2012-12-20 12:14:48 22119 DEBUG nova.manager [-] Running periodic task ComputeManager._check_instance_build_time periodic_tasks /usr/lib/python2.6/site-packages/nova/manager.py:172
>2012-12-20 12:14:48 22119 DEBUG nova.manager [-] Running periodic task ComputeManager._heal_instance_info_cache periodic_tasks /usr/lib/python2.6/site-packages/nova/manager.py:172
>2012-12-20 12:14:48 22119 DEBUG nova.manager [-] Running periodic task ComputeManager._run_image_cache_manager_pass periodic_tasks /usr/lib/python2.6/site-packages/nova/manager.py:172
>2012-12-20 12:14:48 22119 DEBUG nova.manager [-] Running periodic task ComputeManager._reclaim_queued_deletes periodic_tasks /usr/lib/python2.6/site-packages/nova/manager.py:172
>2012-12-20 12:14:48 22119 DEBUG nova.compute.manager [-] FLAGS.reclaim_instance_interval <= 0, skipping... _reclaim_queued_deletes /usr/lib/python2.6/site-packages/nova/compute/manager.py:2790
>2012-12-20 12:14:48 22119 DEBUG nova.manager [-] Running periodic task ComputeManager._report_driver_status periodic_tasks /usr/lib/python2.6/site-packages/nova/manager.py:172
>2012-12-20 12:14:48 22119 DEBUG nova.manager [-] Running periodic task ComputeManager._poll_unconfirmed_resizes periodic_tasks /usr/lib/python2.6/site-packages/nova/manager.py:172
>
>==> /var/log/nova/network.log <==
>2012-12-20 12:15:25 22074 DEBUG nova.manager [-] Running periodic task FlatDHCPManager._publish_service_capabilities periodic_tasks /usr/lib/python2.6/site-packages/nova/manager.py:172
>2012-12-20 12:15:25 22074 DEBUG nova.manager [-] Running periodic task FlatDHCPManager._disassociate_stale_fixed_ips periodic_tasks /usr/lib/python2.6/site-packages/nova/manager.py:172
>
>==> /var/log/nova/compute.log <==
>2012-12-20 12:15:48 22119 DEBUG nova.manager [-] Running periodic task ComputeManager._publish_service_capabilities periodic_tasks /usr/lib/python2.6/site-packages/nova/manager.py:172
>2012-12-20 12:15:48 22119 DEBUG nova.manager [-] Notifying Schedulers of capabilities ... _publish_service_capabilities /usr/lib/python2.6/site-packages/nova/manager.py:231
>2012-12-20 12:15:48 22119 DEBUG nova.openstack.common.rpc.amqp [-] Making asynchronous fanout cast... fanout_cast /usr/lib/python2.6/site-packages/nova/openstack/common/rpc/amqp.py:385
>2012-12-20 12:15:48 22119 DEBUG nova.manager [-] Running periodic task ComputeManager._poll_rescued_instances periodic_tasks /usr/lib/python2.6/site-packages/nova/manager.py:172
>2012-12-20 12:15:48 22119 DEBUG nova.manager [-] Skipping ComputeManager._sync_power_states, 1 ticks left until next run periodic_tasks /usr/lib/python2.6/site-packages/nova/manager.py:167
>2012-12-20 12:15:48 22119 DEBUG nova.manager [-] Running periodic task ComputeManager._poll_bandwidth_usage periodic_tasks /usr/lib/python2.6/site-packages/nova/manager.py:172
>2012-12-20 12:15:48 22119 INFO nova.compute.manager [-] Updating bandwidth usage cache
>2012-12-20 12:15:48 22119 DEBUG nova.manager [-] Running periodic task ComputeManager._instance_usage_audit periodic_tasks /usr/lib/python2.6/site-packages/nova/manager.py:172
>2012-12-20 12:15:48 22119 DEBUG nova.manager [-] Running periodic task ComputeManager.update_available_resource periodic_tasks /usr/lib/python2.6/site-packages/nova/manager.py:172
>2012-12-20 12:15:48 22119 DEBUG nova.utils [-] Got semaphore "compute_resources" for method "update_available_resource"... inner /usr/lib/python2.6/site-packages/nova/utils.py:721
>2012-12-20 12:15:48 22119 DEBUG nova.compute.resource_tracker [-] Hypervisor: free ram (MB): 13491 _report_hypervisor_resource_view /usr/lib/python2.6/site-packages/nova/compute/resource_tracker.py:470
>2012-12-20 12:15:48 22119 DEBUG nova.compute.resource_tracker [-] Hypervisor: free disk (GB): 15 _report_hypervisor_resource_view /usr/lib/python2.6/site-packages/nova/compute/resource_tracker.py:471
>2012-12-20 12:15:48 22119 DEBUG nova.compute.resource_tracker [-] Hypervisor: free VCPUs: 8 _report_hypervisor_resource_view /usr/lib/python2.6/site-packages/nova/compute/resource_tracker.py:476
>2012-12-20 12:15:48 22119 AUDIT nova.compute.resource_tracker [-] Free ram (MB): 13481
>2012-12-20 12:15:48 22119 AUDIT nova.compute.resource_tracker [-] Free disk (GB): 19
>2012-12-20 12:15:48 22119 AUDIT nova.compute.resource_tracker [-] Free VCPUS: 8
>2012-12-20 12:15:48 22119 INFO nova.compute.resource_tracker [-] Compute_service record updated for blond-vdsf.qa.lab.tlv.redhat.com 
>2012-12-20 12:15:48 22119 DEBUG nova.manager [-] Running periodic task ComputeManager._poll_rebooting_instances periodic_tasks /usr/lib/python2.6/site-packages/nova/manager.py:172
>2012-12-20 12:15:48 22119 DEBUG nova.manager [-] Skipping ComputeManager._cleanup_running_deleted_instances, 10 ticks left until next run periodic_tasks /usr/lib/python2.6/site-packages/nova/manager.py:167
>2012-12-20 12:15:48 22119 DEBUG nova.manager [-] Running periodic task ComputeManager._check_instance_build_time periodic_tasks /usr/lib/python2.6/site-packages/nova/manager.py:172
>2012-12-20 12:15:48 22119 DEBUG nova.manager [-] Running periodic task ComputeManager._heal_instance_info_cache periodic_tasks /usr/lib/python2.6/site-packages/nova/manager.py:172
>2012-12-20 12:15:48 22119 DEBUG nova.manager [-] Running periodic task ComputeManager._run_image_cache_manager_pass periodic_tasks /usr/lib/python2.6/site-packages/nova/manager.py:172
>2012-12-20 12:15:48 22119 DEBUG nova.manager [-] Running periodic task ComputeManager._reclaim_queued_deletes periodic_tasks /usr/lib/python2.6/site-packages/nova/manager.py:172
>2012-12-20 12:15:48 22119 DEBUG nova.compute.manager [-] FLAGS.reclaim_instance_interval <= 0, skipping... _reclaim_queued_deletes /usr/lib/python2.6/site-packages/nova/compute/manager.py:2790
>2012-12-20 12:15:48 22119 DEBUG nova.manager [-] Running periodic task ComputeManager._report_driver_status periodic_tasks /usr/lib/python2.6/site-packages/nova/manager.py:172
>2012-12-20 12:15:48 22119 INFO nova.compute.manager [-] Updating host status
>2012-12-20 12:15:48 22119 DEBUG nova.virt.libvirt.driver [-] Updating host stats update_status /usr/lib/python2.6/site-packages/nova/virt/libvirt/driver.py:3063
>2012-12-20 12:15:49 22119 DEBUG nova.manager [-] Running periodic task ComputeManager._poll_unconfirmed_resizes periodic_tasks /usr/lib/python2.6/site-packages/nova/manager.py:172
>
>==> /var/log/nova/network.log <==
>2012-12-20 12:16:25 22074 DEBUG nova.manager [-] Running periodic task FlatDHCPManager._publish_service_capabilities periodic_tasks /usr/lib/python2.6/site-packages/nova/manager.py:172
>2012-12-20 12:16:25 22074 DEBUG nova.manager [-] Running periodic task FlatDHCPManager._disassociate_stale_fixed_ips periodic_tasks /usr/lib/python2.6/site-packages/nova/manager.py:172
>
>==> /var/log/nova/compute.log <==
>2012-12-20 12:16:49 22119 DEBUG nova.manager [-] Running periodic task ComputeManager._publish_service_capabilities periodic_tasks /usr/lib/python2.6/site-packages/nova/manager.py:172
>2012-12-20 12:16:49 22119 DEBUG nova.manager [-] Notifying Schedulers of capabilities ... _publish_service_capabilities /usr/lib/python2.6/site-packages/nova/manager.py:231
>2012-12-20 12:16:49 22119 DEBUG nova.openstack.common.rpc.amqp [-] Making asynchronous fanout cast... fanout_cast /usr/lib/python2.6/site-packages/nova/openstack/common/rpc/amqp.py:385
>2012-12-20 12:16:49 22119 DEBUG nova.manager [-] Running periodic task ComputeManager._poll_rescued_instances periodic_tasks /usr/lib/python2.6/site-packages/nova/manager.py:172
>2012-12-20 12:16:49 22119 DEBUG nova.manager [-] Running periodic task ComputeManager._sync_power_states periodic_tasks /usr/lib/python2.6/site-packages/nova/manager.py:172
>2012-12-20 12:16:49 22119 DEBUG nova.manager [-] Running periodic task ComputeManager._poll_bandwidth_usage periodic_tasks /usr/lib/python2.6/site-packages/nova/manager.py:172
>2012-12-20 12:16:49 22119 DEBUG nova.manager [-] Running periodic task ComputeManager._instance_usage_audit periodic_tasks /usr/lib/python2.6/site-packages/nova/manager.py:172
>2012-12-20 12:16:49 22119 DEBUG nova.manager [-] Running periodic task ComputeManager.update_available_resource periodic_tasks /usr/lib/python2.6/site-packages/nova/manager.py:172
>2012-12-20 12:16:49 22119 DEBUG nova.utils [-] Got semaphore "compute_resources" for method "update_available_resource"... inner /usr/lib/python2.6/site-packages/nova/utils.py:721
>2012-12-20 12:16:49 22119 DEBUG nova.compute.resource_tracker [-] Hypervisor: free ram (MB): 13491 _report_hypervisor_resource_view /usr/lib/python2.6/site-packages/nova/compute/resource_tracker.py:470
>2012-12-20 12:16:49 22119 DEBUG nova.compute.resource_tracker [-] Hypervisor: free disk (GB): 15 _report_hypervisor_resource_view /usr/lib/python2.6/site-packages/nova/compute/resource_tracker.py:471
>2012-12-20 12:16:49 22119 DEBUG nova.compute.resource_tracker [-] Hypervisor: free VCPUs: 8 _report_hypervisor_resource_view /usr/lib/python2.6/site-packages/nova/compute/resource_tracker.py:476
>2012-12-20 12:16:49 22119 AUDIT nova.compute.resource_tracker [-] Free ram (MB): 13481
>2012-12-20 12:16:49 22119 AUDIT nova.compute.resource_tracker [-] Free disk (GB): 19
>2012-12-20 12:16:49 22119 AUDIT nova.compute.resource_tracker [-] Free VCPUS: 8
>2012-12-20 12:16:49 22119 INFO nova.compute.resource_tracker [-] Compute_service record updated for blond-vdsf.qa.lab.tlv.redhat.com 
>2012-12-20 12:16:49 22119 DEBUG nova.manager [-] Running periodic task ComputeManager._poll_rebooting_instances periodic_tasks /usr/lib/python2.6/site-packages/nova/manager.py:172
>2012-12-20 12:16:49 22119 DEBUG nova.manager [-] Skipping ComputeManager._cleanup_running_deleted_instances, 9 ticks left until next run periodic_tasks /usr/lib/python2.6/site-packages/nova/manager.py:167
>2012-12-20 12:16:49 22119 DEBUG nova.manager [-] Running periodic task ComputeManager._check_instance_build_time periodic_tasks /usr/lib/python2.6/site-packages/nova/manager.py:172
>2012-12-20 12:16:49 22119 DEBUG nova.manager [-] Running periodic task ComputeManager._heal_instance_info_cache periodic_tasks /usr/lib/python2.6/site-packages/nova/manager.py:172
>2012-12-20 12:16:49 22119 DEBUG nova.manager [-] Running periodic task ComputeManager._run_image_cache_manager_pass periodic_tasks /usr/lib/python2.6/site-packages/nova/manager.py:172
>2012-12-20 12:16:49 22119 DEBUG nova.manager [-] Running periodic task ComputeManager._reclaim_queued_deletes periodic_tasks /usr/lib/python2.6/site-packages/nova/manager.py:172
>2012-12-20 12:16:49 22119 DEBUG nova.compute.manager [-] FLAGS.reclaim_instance_interval <= 0, skipping... _reclaim_queued_deletes /usr/lib/python2.6/site-packages/nova/compute/manager.py:2790
>2012-12-20 12:16:49 22119 DEBUG nova.manager [-] Running periodic task ComputeManager._report_driver_status periodic_tasks /usr/lib/python2.6/site-packages/nova/manager.py:172
>2012-12-20 12:16:49 22119 DEBUG nova.manager [-] Running periodic task ComputeManager._poll_unconfirmed_resizes periodic_tasks /usr/lib/python2.6/site-packages/nova/manager.py:172
>
>==> /var/log/nova/network.log <==
>2012-12-20 12:17:25 22074 DEBUG nova.manager [-] Running periodic task FlatDHCPManager._publish_service_capabilities periodic_tasks /usr/lib/python2.6/site-packages/nova/manager.py:172
>2012-12-20 12:17:25 22074 DEBUG nova.manager [-] Running periodic task FlatDHCPManager._disassociate_stale_fixed_ips periodic_tasks /usr/lib/python2.6/site-packages/nova/manager.py:172
>
>==> /var/log/nova/compute.log <==
>2012-12-20 12:17:49 22119 DEBUG nova.manager [-] Running periodic task ComputeManager._publish_service_capabilities periodic_tasks /usr/lib/python2.6/site-packages/nova/manager.py:172
>2012-12-20 12:17:49 22119 DEBUG nova.manager [-] Notifying Schedulers of capabilities ... _publish_service_capabilities /usr/lib/python2.6/site-packages/nova/manager.py:231
>2012-12-20 12:17:49 22119 DEBUG nova.openstack.common.rpc.amqp [-] Making asynchronous fanout cast... fanout_cast /usr/lib/python2.6/site-packages/nova/openstack/common/rpc/amqp.py:385
>2012-12-20 12:17:49 22119 DEBUG nova.manager [-] Running periodic task ComputeManager._poll_rescued_instances periodic_tasks /usr/lib/python2.6/site-packages/nova/manager.py:172
>2012-12-20 12:17:49 22119 DEBUG nova.manager [-] Skipping ComputeManager._sync_power_states, 10 ticks left until next run periodic_tasks /usr/lib/python2.6/site-packages/nova/manager.py:167
>2012-12-20 12:17:49 22119 DEBUG nova.manager [-] Running periodic task ComputeManager._poll_bandwidth_usage periodic_tasks /usr/lib/python2.6/site-packages/nova/manager.py:172
>2012-12-20 12:17:49 22119 DEBUG nova.manager [-] Running periodic task ComputeManager._instance_usage_audit periodic_tasks /usr/lib/python2.6/site-packages/nova/manager.py:172
>2012-12-20 12:17:49 22119 DEBUG nova.manager [-] Running periodic task ComputeManager.update_available_resource periodic_tasks /usr/lib/python2.6/site-packages/nova/manager.py:172
>2012-12-20 12:17:49 22119 DEBUG nova.utils [-] Got semaphore "compute_resources" for method "update_available_resource"... inner /usr/lib/python2.6/site-packages/nova/utils.py:721
>2012-12-20 12:17:49 22119 DEBUG nova.compute.resource_tracker [-] Hypervisor: free ram (MB): 13491 _report_hypervisor_resource_view /usr/lib/python2.6/site-packages/nova/compute/resource_tracker.py:470
>2012-12-20 12:17:49 22119 DEBUG nova.compute.resource_tracker [-] Hypervisor: free disk (GB): 15 _report_hypervisor_resource_view /usr/lib/python2.6/site-packages/nova/compute/resource_tracker.py:471
>2012-12-20 12:17:49 22119 DEBUG nova.compute.resource_tracker [-] Hypervisor: free VCPUs: 8 _report_hypervisor_resource_view /usr/lib/python2.6/site-packages/nova/compute/resource_tracker.py:476
>2012-12-20 12:17:49 22119 AUDIT nova.compute.resource_tracker [-] Free ram (MB): 13481
>2012-12-20 12:17:49 22119 AUDIT nova.compute.resource_tracker [-] Free disk (GB): 19
>2012-12-20 12:17:49 22119 AUDIT nova.compute.resource_tracker [-] Free VCPUS: 8
>2012-12-20 12:17:49 22119 INFO nova.compute.resource_tracker [-] Compute_service record updated for blond-vdsf.qa.lab.tlv.redhat.com 
>2012-12-20 12:17:49 22119 DEBUG nova.manager [-] Running periodic task ComputeManager._poll_rebooting_instances periodic_tasks /usr/lib/python2.6/site-packages/nova/manager.py:172
>2012-12-20 12:17:49 22119 DEBUG nova.manager [-] Skipping ComputeManager._cleanup_running_deleted_instances, 8 ticks left until next run periodic_tasks /usr/lib/python2.6/site-packages/nova/manager.py:167
>2012-12-20 12:17:49 22119 DEBUG nova.manager [-] Running periodic task ComputeManager._check_instance_build_time periodic_tasks /usr/lib/python2.6/site-packages/nova/manager.py:172
>2012-12-20 12:17:49 22119 DEBUG nova.manager [-] Running periodic task ComputeManager._heal_instance_info_cache periodic_tasks /usr/lib/python2.6/site-packages/nova/manager.py:172
>2012-12-20 12:17:49 22119 DEBUG nova.manager [-] Running periodic task ComputeManager._run_image_cache_manager_pass periodic_tasks /usr/lib/python2.6/site-packages/nova/manager.py:172
>2012-12-20 12:17:49 22119 DEBUG nova.manager [-] Running periodic task ComputeManager._reclaim_queued_deletes periodic_tasks /usr/lib/python2.6/site-packages/nova/manager.py:172
>2012-12-20 12:17:49 22119 DEBUG nova.compute.manager [-] FLAGS.reclaim_instance_interval <= 0, skipping... _reclaim_queued_deletes /usr/lib/python2.6/site-packages/nova/compute/manager.py:2790
>2012-12-20 12:17:49 22119 DEBUG nova.manager [-] Running periodic task ComputeManager._report_driver_status periodic_tasks /usr/lib/python2.6/site-packages/nova/manager.py:172
>2012-12-20 12:17:49 22119 INFO nova.compute.manager [-] Updating host status
>2012-12-20 12:17:49 22119 DEBUG nova.virt.libvirt.driver [-] Updating host stats update_status /usr/lib/python2.6/site-packages/nova/virt/libvirt/driver.py:3063
>2012-12-20 12:17:49 22119 DEBUG nova.manager [-] Running periodic task ComputeManager._poll_unconfirmed_resizes periodic_tasks /usr/lib/python2.6/site-packages/nova/manager.py:172
>
>==> /var/log/nova/network.log <==
>2012-12-20 12:18:25 22074 DEBUG nova.manager [-] Running periodic task FlatDHCPManager._publish_service_capabilities periodic_tasks /usr/lib/python2.6/site-packages/nova/manager.py:172
>2012-12-20 12:18:25 22074 DEBUG nova.manager [-] Running periodic task FlatDHCPManager._disassociate_stale_fixed_ips periodic_tasks /usr/lib/python2.6/site-packages/nova/manager.py:172
>
>==> /var/log/nova/compute.log <==
>2012-12-20 12:18:49 22119 DEBUG nova.manager [-] Running periodic task ComputeManager._publish_service_capabilities periodic_tasks /usr/lib/python2.6/site-packages/nova/manager.py:172
>2012-12-20 12:18:49 22119 DEBUG nova.manager [-] Notifying Schedulers of capabilities ... _publish_service_capabilities /usr/lib/python2.6/site-packages/nova/manager.py:231
>2012-12-20 12:18:49 22119 DEBUG nova.openstack.common.rpc.amqp [-] Making asynchronous fanout cast... fanout_cast /usr/lib/python2.6/site-packages/nova/openstack/common/rpc/amqp.py:385
>2012-12-20 12:18:49 22119 DEBUG nova.manager [-] Running periodic task ComputeManager._poll_rescued_instances periodic_tasks /usr/lib/python2.6/site-packages/nova/manager.py:172
>2012-12-20 12:18:49 22119 DEBUG nova.manager [-] Skipping ComputeManager._sync_power_states, 9 ticks left until next run periodic_tasks /usr/lib/python2.6/site-packages/nova/manager.py:167
>2012-12-20 12:18:49 22119 DEBUG nova.manager [-] Running periodic task ComputeManager._poll_bandwidth_usage periodic_tasks /usr/lib/python2.6/site-packages/nova/manager.py:172
>2012-12-20 12:18:49 22119 DEBUG nova.manager [-] Running periodic task ComputeManager._instance_usage_audit periodic_tasks /usr/lib/python2.6/site-packages/nova/manager.py:172
>2012-12-20 12:18:49 22119 DEBUG nova.manager [-] Running periodic task ComputeManager.update_available_resource periodic_tasks /usr/lib/python2.6/site-packages/nova/manager.py:172
>2012-12-20 12:18:49 22119 DEBUG nova.utils [-] Got semaphore "compute_resources" for method "update_available_resource"... inner /usr/lib/python2.6/site-packages/nova/utils.py:721
>2012-12-20 12:18:50 22119 DEBUG nova.compute.resource_tracker [-] Hypervisor: free ram (MB): 13490 _report_hypervisor_resource_view /usr/lib/python2.6/site-packages/nova/compute/resource_tracker.py:470
>2012-12-20 12:18:50 22119 DEBUG nova.compute.resource_tracker [-] Hypervisor: free disk (GB): 15 _report_hypervisor_resource_view /usr/lib/python2.6/site-packages/nova/compute/resource_tracker.py:471
>2012-12-20 12:18:50 22119 DEBUG nova.compute.resource_tracker [-] Hypervisor: free VCPUs: 8 _report_hypervisor_resource_view /usr/lib/python2.6/site-packages/nova/compute/resource_tracker.py:476
>2012-12-20 12:18:50 22119 AUDIT nova.compute.resource_tracker [-] Free ram (MB): 13481
>2012-12-20 12:18:50 22119 AUDIT nova.compute.resource_tracker [-] Free disk (GB): 19
>2012-12-20 12:18:50 22119 AUDIT nova.compute.resource_tracker [-] Free VCPUS: 8
>2012-12-20 12:18:50 22119 INFO nova.compute.resource_tracker [-] Compute_service record updated for blond-vdsf.qa.lab.tlv.redhat.com 
>2012-12-20 12:18:50 22119 DEBUG nova.manager [-] Running periodic task ComputeManager._poll_rebooting_instances periodic_tasks /usr/lib/python2.6/site-packages/nova/manager.py:172
>2012-12-20 12:18:50 22119 DEBUG nova.manager [-] Skipping ComputeManager._cleanup_running_deleted_instances, 7 ticks left until next run periodic_tasks /usr/lib/python2.6/site-packages/nova/manager.py:167
>2012-12-20 12:18:50 22119 DEBUG nova.manager [-] Running periodic task ComputeManager._check_instance_build_time periodic_tasks /usr/lib/python2.6/site-packages/nova/manager.py:172
>2012-12-20 12:18:50 22119 DEBUG nova.manager [-] Running periodic task ComputeManager._heal_instance_info_cache periodic_tasks /usr/lib/python2.6/site-packages/nova/manager.py:172
>2012-12-20 12:18:50 22119 DEBUG nova.manager [-] Running periodic task ComputeManager._run_image_cache_manager_pass periodic_tasks /usr/lib/python2.6/site-packages/nova/manager.py:172
>2012-12-20 12:18:50 22119 DEBUG nova.manager [-] Running periodic task ComputeManager._reclaim_queued_deletes periodic_tasks /usr/lib/python2.6/site-packages/nova/manager.py:172
>2012-12-20 12:18:50 22119 DEBUG nova.compute.manager [-] FLAGS.reclaim_instance_interval <= 0, skipping... _reclaim_queued_deletes /usr/lib/python2.6/site-packages/nova/compute/manager.py:2790
>2012-12-20 12:18:50 22119 DEBUG nova.manager [-] Running periodic task ComputeManager._report_driver_status periodic_tasks /usr/lib/python2.6/site-packages/nova/manager.py:172
>2012-12-20 12:18:50 22119 DEBUG nova.manager [-] Running periodic task ComputeManager._poll_unconfirmed_resizes periodic_tasks /usr/lib/python2.6/site-packages/nova/manager.py:172
>
>==> /var/log/nova/network.log <==
>2012-12-20 12:19:25 22074 DEBUG nova.manager [-] Running periodic task FlatDHCPManager._publish_service_capabilities periodic_tasks /usr/lib/python2.6/site-packages/nova/manager.py:172
>2012-12-20 12:19:25 22074 DEBUG nova.manager [-] Running periodic task FlatDHCPManager._disassociate_stale_fixed_ips periodic_tasks /usr/lib/python2.6/site-packages/nova/manager.py:172
>
>==> /var/log/nova/compute.log <==
>2012-12-20 12:19:50 22119 DEBUG nova.manager [-] Running periodic task ComputeManager._publish_service_capabilities periodic_tasks /usr/lib/python2.6/site-packages/nova/manager.py:172
>2012-12-20 12:19:50 22119 DEBUG nova.manager [-] Notifying Schedulers of capabilities ... _publish_service_capabilities /usr/lib/python2.6/site-packages/nova/manager.py:231
>2012-12-20 12:19:50 22119 DEBUG nova.openstack.common.rpc.amqp [-] Making asynchronous fanout cast... fanout_cast /usr/lib/python2.6/site-packages/nova/openstack/common/rpc/amqp.py:385
>2012-12-20 12:19:50 22119 DEBUG nova.manager [-] Running periodic task ComputeManager._poll_rescued_instances periodic_tasks /usr/lib/python2.6/site-packages/nova/manager.py:172
>2012-12-20 12:19:50 22119 DEBUG nova.manager [-] Skipping ComputeManager._sync_power_states, 8 ticks left until next run periodic_tasks /usr/lib/python2.6/site-packages/nova/manager.py:167
>2012-12-20 12:19:50 22119 DEBUG nova.manager [-] Running periodic task ComputeManager._poll_bandwidth_usage periodic_tasks /usr/lib/python2.6/site-packages/nova/manager.py:172
>2012-12-20 12:19:50 22119 DEBUG nova.manager [-] Running periodic task ComputeManager._instance_usage_audit periodic_tasks /usr/lib/python2.6/site-packages/nova/manager.py:172
>2012-12-20 12:19:50 22119 DEBUG nova.manager [-] Running periodic task ComputeManager.update_available_resource periodic_tasks /usr/lib/python2.6/site-packages/nova/manager.py:172
>2012-12-20 12:19:50 22119 DEBUG nova.utils [-] Got semaphore "compute_resources" for method "update_available_resource"... inner /usr/lib/python2.6/site-packages/nova/utils.py:721
>2012-12-20 12:19:50 22119 DEBUG nova.compute.resource_tracker [-] Hypervisor: free ram (MB): 13490 _report_hypervisor_resource_view /usr/lib/python2.6/site-packages/nova/compute/resource_tracker.py:470
>2012-12-20 12:19:50 22119 DEBUG nova.compute.resource_tracker [-] Hypervisor: free disk (GB): 15 _report_hypervisor_resource_view /usr/lib/python2.6/site-packages/nova/compute/resource_tracker.py:471
>2012-12-20 12:19:50 22119 DEBUG nova.compute.resource_tracker [-] Hypervisor: free VCPUs: 8 _report_hypervisor_resource_view /usr/lib/python2.6/site-packages/nova/compute/resource_tracker.py:476
>2012-12-20 12:19:50 22119 AUDIT nova.compute.resource_tracker [-] Free ram (MB): 13481
>2012-12-20 12:19:50 22119 AUDIT nova.compute.resource_tracker [-] Free disk (GB): 19
>2012-12-20 12:19:50 22119 AUDIT nova.compute.resource_tracker [-] Free VCPUS: 8
>2012-12-20 12:19:50 22119 INFO nova.compute.resource_tracker [-] Compute_service record updated for blond-vdsf.qa.lab.tlv.redhat.com 
>2012-12-20 12:19:50 22119 DEBUG nova.manager [-] Running periodic task ComputeManager._poll_rebooting_instances periodic_tasks /usr/lib/python2.6/site-packages/nova/manager.py:172
>2012-12-20 12:19:50 22119 DEBUG nova.manager [-] Skipping ComputeManager._cleanup_running_deleted_instances, 6 ticks left until next run periodic_tasks /usr/lib/python2.6/site-packages/nova/manager.py:167
>2012-12-20 12:19:50 22119 DEBUG nova.manager [-] Running periodic task ComputeManager._check_instance_build_time periodic_tasks /usr/lib/python2.6/site-packages/nova/manager.py:172
>2012-12-20 12:19:50 22119 DEBUG nova.manager [-] Running periodic task ComputeManager._heal_instance_info_cache periodic_tasks /usr/lib/python2.6/site-packages/nova/manager.py:172
>2012-12-20 12:19:50 22119 DEBUG nova.manager [-] Running periodic task ComputeManager._run_image_cache_manager_pass periodic_tasks /usr/lib/python2.6/site-packages/nova/manager.py:172
>2012-12-20 12:19:50 22119 DEBUG nova.manager [-] Running periodic task ComputeManager._reclaim_queued_deletes periodic_tasks /usr/lib/python2.6/site-packages/nova/manager.py:172
>2012-12-20 12:19:50 22119 DEBUG nova.compute.manager [-] FLAGS.reclaim_instance_interval <= 0, skipping... _reclaim_queued_deletes /usr/lib/python2.6/site-packages/nova/compute/manager.py:2790
>2012-12-20 12:19:50 22119 DEBUG nova.manager [-] Running periodic task ComputeManager._report_driver_status periodic_tasks /usr/lib/python2.6/site-packages/nova/manager.py:172
>2012-12-20 12:19:50 22119 INFO nova.compute.manager [-] Updating host status
>2012-12-20 12:19:50 22119 DEBUG nova.virt.libvirt.driver [-] Updating host stats update_status /usr/lib/python2.6/site-packages/nova/virt/libvirt/driver.py:3063
>2012-12-20 12:19:50 22119 DEBUG nova.manager [-] Running periodic task ComputeManager._poll_unconfirmed_resizes periodic_tasks /usr/lib/python2.6/site-packages/nova/manager.py:172
>
>

Actions: View

Attachments on bug 889199: 666667