← Back to team overview

openstack team mailing list archive

Error when launching instances on the additional compute node

 




Hi friends,
I progressed in my installation, and now when I run 'nova-manage service list' I have all services with a ":-)" status even the additional compute node. But when I launch several instances, the ones hosted on the additional compute node, can't be launched, it gives me an ERROR status, herein the tails of log files (nova-compute.log, nova-network.log and libvirt.log) on the Cloud Controller:
 
nova-compute log file :

2012-06-25 11:56:02 DEBUG nova.manager [-] Running periodic task ComputeManager._poll_unconfirmed_resizes from (pid=1111) periodic_tasks /usr/lib/python2.7/dist-packages/nova/manager.py:152
2012-06-25 11:57:02 DEBUG nova.manager [-] Running periodic task ComputeManager._publish_service_capabilities from (pid=1111) periodic_tasks /usr/lib/python2.7/dist-packages/nova/manager.py:152
2012-06-25 11:57:02 DEBUG nova.manager [-] Notifying Schedulers of capabilities ... from (pid=1111) _publish_service_capabilities /usr/lib/python2.7/dist-packages/nova/manager.py:203
2012-06-25 11:57:02 DEBUG nova.rpc.amqp [-] Making asynchronous fanout cast... from (pid=1111) fanout_cast /usr/lib/python2.7/dist-packages/nova/rpc/amqp.py:354
2012-06-25 11:57:02 DEBUG nova.manager [-] Running periodic task ComputeManager._poll_rescued_instances from (pid=1111) periodic_tasks /usr/lib/python2.7/dist-packages/nova/manager.py:152
2012-06-25 11:57:02 DEBUG nova.manager [-] Running periodic task ComputeManager._sync_power_states from (pid=1111) periodic_tasks /usr/lib/python2.7/dist-packages/nova/manager.py:152
2012-06-25 11:57:03 DEBUG nova.manager [-] Running periodic task ComputeManager._poll_bandwidth_usage from (pid=1111) periodic_tasks /usr/lib/python2.7/dist-packages/nova/manager.py:152
2012-06-25 11:57:03 INFO nova.compute.manager [-] Updating bandwidth usage cache
2012-06-25 11:57:03 DEBUG nova.manager [-] Running periodic task ComputeManager.update_available_resource from (pid=1111) periodic_tasks /usr/lib/python2.7/dist-packages/nova/manager.py:152
2012-06-25 11:57:04 INFO nova.virt.libvirt.connection [-] Compute_service record updated for Server1 
2012-06-25 11:57:04 DEBUG nova.manager [-] Running periodic task ComputeManager._poll_rebooting_instances from (pid=1111) periodic_tasks /usr/lib/python2.7/dist-packages/nova/manager.py:152
2012-06-25 11:57:04 DEBUG nova.manager [-] Skipping ComputeManager._cleanup_running_deleted_instances, 3 ticks left until next run from (pid=1111) periodic_tasks /usr/lib/python2.7/dist-packages/nova/manager.py:147
2012-06-25 11:57:04 DEBUG nova.manager [-] Running periodic task ComputeManager._heal_instance_info_cache from (pid=1111) periodic_tasks /usr/lib/python2.7/dist-packages/nova/manager.py:152
2012-06-25 11:57:04 DEBUG nova.manager [-] Skipping ComputeManager._run_image_cache_manager_pass, 2 ticks left until next run from (pid=1111) periodic_tasks /usr/lib/python2.7/dist-packages/nova/manager.py:147
2012-06-25 11:57:04 DEBUG nova.manager [-] Running periodic task ComputeManager._reclaim_queued_deletes from (pid=1111) periodic_tasks /usr/lib/python2.7/dist-packages/nova/manager.py:152
2012-06-25 11:57:04 DEBUG nova.compute.manager [-] FLAGS.reclaim_instance_interval <= 0, skipping... from (pid=1111) _reclaim_queued_deletes /usr/lib/python2.7/dist-packages/nova/compute/manager.py:2380
2012-06-25 11:57:04 DEBUG nova.manager [-] Running periodic task ComputeManager._report_driver_status from (pid=1111) periodic_tasks /usr/lib/python2.7/dist-packages/nova/manager.py:152
2012-06-25 11:57:04 INFO nova.compute.manager [-] Updating host status
2012-06-25 11:57:04 DEBUG nova.virt.libvirt.connection [-] Updating host stats from (pid=1111) update_status /usr/lib/python2.7/dist-packages/nova/virt/libvirt/connection.py:2467
2012-06-25 11:57:06 DEBUG nova.manager [-] Running periodic task ComputeManager._poll_unconfirmed_resizes from (pid=1111) periodic_tasks /usr/lib/python2.7/dist-packages/nova/manager.py:152
2012-06-25 11:58:06 DEBUG nova.manager [-] Running periodic task ComputeManager._publish_service_capabilities from (pid=1111) periodic_tasks /usr/lib/python2.7/dist-packages/nova/manager.py:152
2012-06-25 11:58:06 DEBUG nova.manager [-] Notifying Schedulers of capabilities ... from (pid=1111) _publish_service_capabilities /usr/lib/python2.7/dist-packages/nova/manager.py:203
2012-06-25 11:58:06 DEBUG nova.rpc.amqp [-] Making asynchronous fanout cast... from (pid=1111) fanout_cast /usr/lib/python2.7/dist-packages/nova/rpc/amqp.py:354
2012-06-25 11:58:06 DEBUG nova.manager [-] Running periodic task ComputeManager._poll_rescued_instances from (pid=1111) periodic_tasks /usr/lib/python2.7/dist-packages/nova/manager.py:152
2012-06-25 11:58:06 DEBUG nova.manager [-] Skipping ComputeManager._sync_power_states, 10 ticks left until next run from (pid=1111) periodic_tasks /usr/lib/python2.7/dist-packages/nova/manager.py:147
2012-06-25 11:58:06 DEBUG nova.manager [-] Running periodic task ComputeManager._poll_bandwidth_usage from (pid=1111) periodic_tasks /usr/lib/python2.7/dist-packages/nova/manager.py:152
2012-06-25 11:58:06 DEBUG nova.manager [-] Running periodic task ComputeManager.update_available_resource from (pid=1111) periodic_tasks /usr/lib/python2.7/dist-packages/nova/manager.py:152
2012-06-25 11:58:07 INFO nova.virt.libvirt.connection [-] Compute_service record updated for Server1 
2012-06-25 11:58:07 DEBUG nova.manager [-] Running periodic task ComputeManager._poll_rebooting_instances from (pid=1111) periodic_tasks /usr/lib/python2.7/dist-packages/nova/manager.py:152
2012-06-25 11:58:07 DEBUG nova.manager [-] Skipping ComputeManager._cleanup_running_deleted_instances, 2 ticks left until next run from (pid=1111) periodic_tasks /usr/lib/python2.7/dist-packages/nova/manager.py:147
2012-06-25 11:58:07 DEBUG nova.manager [-] Running periodic task ComputeManager._heal_instance_info_cache from (pid=1111) periodic_tasks /usr/lib/python2.7/dist-packages/nova/manager.py:152
2012-06-25 11:58:07 DEBUG nova.manager [-] Skipping ComputeManager._run_image_cache_manager_pass, 1 ticks left until next run from (pid=1111) periodic_tasks /usr/lib/python2.7/dist-packages/nova/manager.py:147
2012-06-25 11:58:07 DEBUG nova.manager [-] Running periodic task ComputeManager._reclaim_queued_deletes from (pid=1111) periodic_tasks /usr/lib/python2.7/dist-packages/nova/manager.py:152
2012-06-25 11:58:07 DEBUG nova.compute.manager [-] FLAGS.reclaim_instance_interval <= 0, skipping... from (pid=1111) _reclaim_queued_deletes /usr/lib/python2.7/dist-packages/nova/compute/manager.py:2380
2012-06-25 11:58:07 DEBUG nova.manager [-] Running periodic task ComputeManager._report_driver_status from (pid=1111) periodic_tasks /usr/lib/python2.7/dist-packages/nova/manager.py:152
2012-06-25 11:58:07 DEBUG nova.manager [-] Running periodic task ComputeManager._poll_unconfirmed_resizes from (pid=1111) periodic_tasks /usr/lib/python2.7/dist-packages/nova/manager.py:152

when I run "cat /var/log/nova/nova-compute | grep error" I got:

2012-06-25 09:47:18 DEBUG nova.service [-] publish_errors : False from (pid=1111) wait /usr/lib/python2.7/dist-packages/nova/service.py:411
2012-06-25 09:47:21 TRACE nova.rpc.common     raise socket.error, msg
2012-06-25 09:47:21 TRACE nova.rpc.common error: [Errno 111] ECONNREFUSED
2012-06-25 09:47:22 TRACE nova.rpc.common     raise socket.error, msg
2012-06-25 09:47:22 TRACE nova.rpc.common error: [Errno 111] ECONNREFUSED
2012-06-25 11:21:05 DEBUG nova.utils [req-ec147ba2-5ccf-4828-b0d0-71b0c0beca5a bd096917fac04e4488b9045627d74fdc 7081bd235a6f4070820716b142a3606b] Unexpected error while running command.
2012-06-25 11:21:05 DEBUG nova.virt.disk.api [req-ec147ba2-5ccf-4828-b0d0-71b0c0beca5a bd096917fac04e4488b9045627d74fdc 7081bd235a6f4070820716b142a3606b] Failed to mount filesystem: Unexpected error while running command.
2012-06-25 11:21:06 DEBUG nova.utils [req-ec147ba2-5ccf-4828-b0d0-71b0c0beca5a bd096917fac04e4488b9045627d74fdc 7081bd235a6f4070820716b142a3606b] Unexpected error while running command.
2012-06-25 11:21:06 DEBUG nova.utils [req-ec147ba2-5ccf-4828-b0d0-71b0c0beca5a bd096917fac04e4488b9045627d74fdc 7081bd235a6f4070820716b142a3606b] Unexpected error while running command.
2012-06-25 11:21:06 DEBUG nova.virt.disk.api [req-ec147ba2-5ccf-4828-b0d0-71b0c0beca5a bd096917fac04e4488b9045627d74fdc 7081bd235a6f4070820716b142a3606b] Failed to mount filesystem: Unexpected error while running command.
2012-06-25 11:21:06 WARNING nova.virt.libvirt.connection [req-ec147ba2-5ccf-4828-b0d0-71b0c0beca5a bd096917fac04e4488b9045627d74fdc 7081bd235a6f4070820716b142a3606b] [instance: e2df588a-191d-4a82-ad28-23381870b4b0] Ignoring error injecting data into image d32edebf-4bb6-47d2-b8ea-073c08a5bf75 (
Failed to mount filesystem: Unexpected error while running command.
Failed to mount filesystem: Unexpected error while running command.

nova-network log file:



2012-06-25 11:54:59 DEBUG nova.rpc.amqp [-] received {u'_context_roles': [u'admin'], u'_msg_id': u'05e2384a2b574bbbae036f3cc068dcb4', u'_context_read_deleted': u'no', u'_context_request_id': u'req-e15f9c74-9242-4969-8df3-abcc596f0c72', u'args': {u'instance_id': 97, u'instance_uuid': u'9cdabb6c-02a3-4bdd-b65a-f82f4b6e7405', u'host': u'Server1', u'project_id': u'7081bd235a6f4070820716b142a3606b', u'rxtx_factor': 1.0}, u'_context_auth_token': '<SANITIZED>', u'_context_is_admin': True, u'_context_project_id': None, u'_context_timestamp': u'2012-06-25T09:54:57.021275', u'_context_user_id': None, u'method': u'get_instance_nw_info', u'_context_remote_address': None} from (pid=1132) _safe_log /usr/lib/python2.7/dist-packages/nova/rpc/common.py:160
2012-06-25 11:54:59 DEBUG nova.rpc.amqp [req-e15f9c74-9242-4969-8df3-abcc596f0c72 None None] unpacked context: {'user_id': None, 'roles': [u'admin'], 'timestamp': '2012-06-25T09:54:57.021275', 'auth_token': '<SANITIZED>', 'remote_address': None, 'is_admin': True, 'request_id': u'req-e15f9c74-9242-4969-8df3-abcc596f0c72', 'project_id': None, 'read_deleted': u'no'} from (pid=1132) _safe_log /usr/lib/python2.7/dist-packages/nova/rpc/common.py:160
2012-06-25 11:54:59 DEBUG nova.utils [req-e15f9c74-9242-4969-8df3-abcc596f0c72 None None] Attempting to grab semaphore "get_dhcp" for method "_get_dhcp_ip"... from (pid=1132) inner /usr/lib/python2.7/dist-packages/nova/utils.py:927
2012-06-25 11:54:59 DEBUG nova.utils [req-e15f9c74-9242-4969-8df3-abcc596f0c72 None None] Got semaphore "get_dhcp" for method "_get_dhcp_ip"... from (pid=1132) inner /usr/lib/python2.7/dist-packages/nova/utils.py:931
2012-06-25 11:54:59 DEBUG nova.utils [req-e15f9c74-9242-4969-8df3-abcc596f0c72 None None] Attempting to grab semaphore "get_dhcp" for method "_get_dhcp_ip"... from (pid=1132) inner /usr/lib/python2.7/dist-packages/nova/utils.py:927
2012-06-25 11:54:59 DEBUG nova.utils [req-e15f9c74-9242-4969-8df3-abcc596f0c72 None None] Got semaphore "get_dhcp" for method "_get_dhcp_ip"... from (pid=1132) inner /usr/lib/python2.7/dist-packages/nova/utils.py:931
2012-06-25 11:55:01 DEBUG nova.rpc.amqp [-] received {u'_context_roles': [u'KeystoneServiceAdmin', u'KeystoneAdmin', u'admin'], u'_msg_id': u'54ed7e19373044908644049b6a554708', u'_context_read_deleted': u'no', u'_context_request_id': u'req-4ad2bdf1-8d44-4737-bd90-b9f1276488e5', u'args': {u'instance_id': 98, u'instance_uuid': u'5bbc127f-37bd-4128-ac93-0bdd2d53f437', u'host': u'cloud-OptiPlex-980', u'project_id': u'7081bd235a6f4070820716b142a3606b', u'rxtx_factor': 1.0}, u'_context_auth_token': '<SANITIZED>', u'_context_is_admin': True, u'_context_project_id': u'7081bd235a6f4070820716b142a3606b', u'_context_timestamp': u'2012-06-25T09:55:01.522708', u'_context_user_id': u'bd096917fac04e4488b9045627d74fdc', u'method': u'get_instance_nw_info', u'_context_remote_address': u'127.0.0.1'} from (pid=1132) _safe_log /usr/lib/python2.7/dist-packages/nova/rpc/common.py:160
2012-06-25 11:55:01 DEBUG nova.rpc.amqp [req-4ad2bdf1-8d44-4737-bd90-b9f1276488e5 bd096917fac04e4488b9045627d74fdc 7081bd235a6f4070820716b142a3606b] unpacked context: {'user_id': u'bd096917fac04e4488b9045627d74fdc', 'roles': [u'KeystoneServiceAdmin', u'KeystoneAdmin', u'admin'], 'timestamp': '2012-06-25T09:55:01.522708', 'auth_token': '<SANITIZED>', 'remote_address': u'127.0.0.1', 'is_admin': True, 'request_id': u'req-4ad2bdf1-8d44-4737-bd90-b9f1276488e5', 'project_id': u'7081bd235a6f4070820716b142a3606b', 'read_deleted': u'no'} from (pid=1132) _safe_log /usr/lib/python2.7/dist-packages/nova/rpc/common.py:160
2012-06-25 11:55:01 DEBUG nova.rpc.amqp [-] received {u'_context_roles': [u'KeystoneServiceAdmin', u'KeystoneAdmin', u'admin'], u'_context_request_id': u'req-4ad2bdf1-8d44-4737-bd90-b9f1276488e5', u'_context_read_deleted': u'no', u'args': {u'instance_id': 98, u'host': u'cloud-OptiPlex-980', u'project_id': u'7081bd235a6f4070820716b142a3606b'}, u'_context_auth_token': '<SANITIZED>', u'_context_is_admin': True, u'_context_project_id': u'7081bd235a6f4070820716b142a3606b', u'_context_timestamp': u'2012-06-25T09:55:01.522708', u'_context_user_id': u'bd096917fac04e4488b9045627d74fdc', u'method': u'deallocate_for_instance', u'_context_remote_address': u'127.0.0.1'} from (pid=1132) _safe_log /usr/lib/python2.7/dist-packages/nova/rpc/common.py:160
2012-06-25 11:55:01 DEBUG nova.rpc.amqp [req-4ad2bdf1-8d44-4737-bd90-b9f1276488e5 bd096917fac04e4488b9045627d74fdc 7081bd235a6f4070820716b142a3606b] unpacked context: {'user_id': u'bd096917fac04e4488b9045627d74fdc', 'roles': [u'KeystoneServiceAdmin', u'KeystoneAdmin', u'admin'], 'timestamp': '2012-06-25T09:55:01.522708', 'auth_token': '<SANITIZED>', 'remote_address': u'127.0.0.1', 'is_admin': True, 'request_id': u'req-4ad2bdf1-8d44-4737-bd90-b9f1276488e5', 'project_id': u'7081bd235a6f4070820716b142a3606b', 'read_deleted': u'no'} from (pid=1132) _safe_log /usr/lib/python2.7/dist-packages/nova/rpc/common.py:160
2012-06-25 11:55:01 DEBUG nova.network.manager [req-4ad2bdf1-8d44-4737-bd90-b9f1276488e5 bd096917fac04e4488b9045627d74fdc 7081bd235a6f4070820716b142a3606b] floating IP deallocation for instance |98| from (pid=1132) deallocate_for_instance /usr/lib/python2.7/dist-packages/nova/network/manager.py:354
2012-06-25 11:55:01 DEBUG nova.network.manager [req-4ad2bdf1-8d44-4737-bd90-b9f1276488e5 bd096917fac04e4488b9045627d74fdc 7081bd235a6f4070820716b142a3606b] network deallocation for instance |98| from (pid=1132) deallocate_for_instance /usr/lib/python2.7/dist-packages/nova/network/manager.py:931
2012-06-25 11:55:02 DEBUG nova.utils [req-4ad2bdf1-8d44-4737-bd90-b9f1276488e5 bd096917fac04e4488b9045627d74fdc 7081bd235a6f4070820716b142a3606b] Attempting to grab semaphore "get_dhcp" for method "_get_dhcp_ip"... from (pid=1132) inner /usr/lib/python2.7/dist-packages/nova/utils.py:927
2012-06-25 11:55:02 DEBUG nova.utils [req-4ad2bdf1-8d44-4737-bd90-b9f1276488e5 bd096917fac04e4488b9045627d74fdc 7081bd235a6f4070820716b142a3606b] Got semaphore "get_dhcp" for method "_get_dhcp_ip"... from (pid=1132) inner /usr/lib/python2.7/dist-packages/nova/utils.py:931
2012-06-25 11:55:02 DEBUG nova.utils [req-4ad2bdf1-8d44-4737-bd90-b9f1276488e5 bd096917fac04e4488b9045627d74fdc 7081bd235a6f4070820716b142a3606b] Attempting to grab semaphore "dnsmasq_start" for method "restart_dhcp"... from (pid=1132) inner /usr/lib/python2.7/dist-packages/nova/utils.py:927
2012-06-25 11:55:02 DEBUG nova.utils [req-4ad2bdf1-8d44-4737-bd90-b9f1276488e5 bd096917fac04e4488b9045627d74fdc 7081bd235a6f4070820716b142a3606b] Got semaphore "dnsmasq_start" for method "restart_dhcp"... from (pid=1132) inner /usr/lib/python2.7/dist-packages/nova/utils.py:931
2012-06-25 11:55:02 DEBUG nova.utils [req-4ad2bdf1-8d44-4737-bd90-b9f1276488e5 bd096917fac04e4488b9045627d74fdc 7081bd235a6f4070820716b142a3606b] Running cmd (subprocess): cat /proc/1996/cmdline from (pid=1132) execute /usr/lib/python2.7/dist-packages/nova/utils.py:219
2012-06-25 11:55:02 DEBUG nova.utils [req-4ad2bdf1-8d44-4737-bd90-b9f1276488e5 bd096917fac04e4488b9045627d74fdc 7081bd235a6f4070820716b142a3606b] Running cmd (subprocess): sudo nova-rootwrap kill -HUP 1996 from (pid=1132) execute /usr/lib/python2.7/dist-packages/nova/utils.py:219
2012-06-25 11:55:02 DEBUG nova.rpc.amqp [-] received {u'_context_roles': [u'KeystoneServiceAdmin', u'KeystoneAdmin', u'admin'], u'_msg_id': u'32de038b7a5d47098572c301461b3688', u'_context_read_deleted': u'no', u'_context_request_id': u'req-158697c8-f1d7-42b7-87c3-b8636a4783b4', u'args': {u'instance_id': 97, u'instance_uuid': u'9cdabb6c-02a3-4bdd-b65a-f82f4b6e7405', u'host': u'Server1', u'project_id': u'7081bd235a6f4070820716b142a3606b', u'rxtx_factor': 1.0}, u'_context_auth_token': '<SANITIZED>', u'_context_is_admin': True, u'_context_project_id': u'7081bd235a6f4070820716b142a3606b', u'_context_timestamp': u'2012-06-25T09:55:01.753054', u'_context_user_id': u'bd096917fac04e4488b9045627d74fdc', u'method': u'get_instance_nw_info', u'_context_remote_address': u'127.0.0.1'} from (pid=1132) _safe_log /usr/lib/python2.7/dist-packages/nova/rpc/common.py:160
2012-06-25 11:55:02 DEBUG nova.rpc.amqp [req-158697c8-f1d7-42b7-87c3-b8636a4783b4 bd096917fac04e4488b9045627d74fdc 7081bd235a6f4070820716b142a3606b] unpacked context: {'user_id': u'bd096917fac04e4488b9045627d74fdc', 'roles': [u'KeystoneServiceAdmin', u'KeystoneAdmin', u'admin'], 'timestamp': '2012-06-25T09:55:01.753054', 'auth_token': '<SANITIZED>', 'remote_address': u'127.0.0.1', 'is_admin': True, 'request_id': u'req-158697c8-f1d7-42b7-87c3-b8636a4783b4', 'project_id': u'7081bd235a6f4070820716b142a3606b', 'read_deleted': u'no'} from (pid=1132) _safe_log /usr/lib/python2.7/dist-packages/nova/rpc/common.py:160
2012-06-25 11:55:02 DEBUG nova.utils [req-158697c8-f1d7-42b7-87c3-b8636a4783b4 bd096917fac04e4488b9045627d74fdc 7081bd235a6f4070820716b142a3606b] Attempting to grab semaphore "get_dhcp" for method "_get_dhcp_ip"... from (pid=1132) inner /usr/lib/python2.7/dist-packages/nova/utils.py:927
2012-06-25 11:55:02 DEBUG nova.utils [req-158697c8-f1d7-42b7-87c3-b8636a4783b4 bd096917fac04e4488b9045627d74fdc 7081bd235a6f4070820716b142a3606b] Got semaphore "get_dhcp" for method "_get_dhcp_ip"... from (pid=1132) inner /usr/lib/python2.7/dist-packages/nova/utils.py:931
2012-06-25 11:55:02 DEBUG nova.utils [req-158697c8-f1d7-42b7-87c3-b8636a4783b4 bd096917fac04e4488b9045627d74fdc 7081bd235a6f4070820716b142a3606b] Attempting to grab semaphore "get_dhcp" for method "_get_dhcp_ip"... from (pid=1132) inner /usr/lib/python2.7/dist-packages/nova/utils.py:927
2012-06-25 11:55:02 DEBUG nova.utils [req-158697c8-f1d7-42b7-87c3-b8636a4783b4 bd096917fac04e4488b9045627d74fdc 7081bd235a6f4070820716b142a3606b] Got semaphore "get_dhcp" for method "_get_dhcp_ip"... from (pid=1132) inner /usr/lib/python2.7/dist-packages/nova/utils.py:931
2012-06-25 11:55:02 DEBUG nova.rpc.amqp [-] received {u'_context_roles': [u'KeystoneServiceAdmin', u'KeystoneAdmin', u'admin'], u'_context_request_id': u'req-158697c8-f1d7-42b7-87c3-b8636a4783b4', u'_context_read_deleted': u'no', u'args': {u'instance_id': 97, u'host': u'Server1', u'project_id': u'7081bd235a6f4070820716b142a3606b'}, u'_context_auth_token': '<SANITIZED>', u'_context_is_admin': True, u'_context_project_id': u'7081bd235a6f4070820716b142a3606b', u'_context_timestamp': u'2012-06-25T09:55:01.753054', u'_context_user_id': u'bd096917fac04e4488b9045627d74fdc', u'method': u'deallocate_for_instance', u'_context_remote_address': u'127.0.0.1'} from (pid=1132) _safe_log /usr/lib/python2.7/dist-packages/nova/rpc/common.py:160
2012-06-25 11:55:02 DEBUG nova.rpc.amqp [req-158697c8-f1d7-42b7-87c3-b8636a4783b4 bd096917fac04e4488b9045627d74fdc 7081bd235a6f4070820716b142a3606b] unpacked context: {'user_id': u'bd096917fac04e4488b9045627d74fdc', 'roles': [u'KeystoneServiceAdmin', u'KeystoneAdmin', u'admin'], 'timestamp': '2012-06-25T09:55:01.753054', 'auth_token': '<SANITIZED>', 'remote_address': u'127.0.0.1', 'is_admin': True, 'request_id': u'req-158697c8-f1d7-42b7-87c3-b8636a4783b4', 'project_id': u'7081bd235a6f4070820716b142a3606b', 'read_deleted': u'no'} from (pid=1132) _safe_log /usr/lib/python2.7/dist-packages/nova/rpc/common.py:160
2012-06-25 11:55:02 DEBUG nova.network.manager [req-158697c8-f1d7-42b7-87c3-b8636a4783b4 bd096917fac04e4488b9045627d74fdc 7081bd235a6f4070820716b142a3606b] floating IP deallocation for instance |97| from (pid=1132) deallocate_for_instance /usr/lib/python2.7/dist-packages/nova/network/manager.py:354
2012-06-25 11:55:02 DEBUG nova.network.manager [req-158697c8-f1d7-42b7-87c3-b8636a4783b4 bd096917fac04e4488b9045627d74fdc 7081bd235a6f4070820716b142a3606b] network deallocation for instance |97| from (pid=1132) deallocate_for_instance /usr/lib/python2.7/dist-packages/nova/network/manager.py:931
2012-06-25 11:55:02 DEBUG nova.utils [req-158697c8-f1d7-42b7-87c3-b8636a4783b4 bd096917fac04e4488b9045627d74fdc 7081bd235a6f4070820716b142a3606b] Attempting to grab semaphore "get_dhcp" for method "_get_dhcp_ip"... from (pid=1132) inner /usr/lib/python2.7/dist-packages/nova/utils.py:927
2012-06-25 11:55:02 DEBUG nova.utils [req-158697c8-f1d7-42b7-87c3-b8636a4783b4 bd096917fac04e4488b9045627d74fdc 7081bd235a6f4070820716b142a3606b] Got semaphore "get_dhcp" for method "_get_dhcp_ip"... from (pid=1132) inner /usr/lib/python2.7/dist-packages/nova/utils.py:931
2012-06-25 11:55:02 DEBUG nova.utils [req-158697c8-f1d7-42b7-87c3-b8636a4783b4 bd096917fac04e4488b9045627d74fdc 7081bd235a6f4070820716b142a3606b] Attempting to grab semaphore "dnsmasq_start" for method "restart_dhcp"... from (pid=1132) inner /usr/lib/python2.7/dist-packages/nova/utils.py:927
2012-06-25 11:55:02 ERROR nova.network.manager [req-4ad2bdf1-8d44-4737-bd90-b9f1276488e5 bd096917fac04e4488b9045627d74fdc 7081bd235a6f4070820716b142a3606b] Unable to release 192.168.3.4 because vif doesn't exist.
2012-06-25 11:55:02 DEBUG nova.utils [req-158697c8-f1d7-42b7-87c3-b8636a4783b4 bd096917fac04e4488b9045627d74fdc 7081bd235a6f4070820716b142a3606b] Got semaphore "dnsmasq_start" for method "restart_dhcp"... from (pid=1132) inner /usr/lib/python2.7/dist-packages/nova/utils.py:931
2012-06-25 11:55:02 DEBUG nova.utils [req-158697c8-f1d7-42b7-87c3-b8636a4783b4 bd096917fac04e4488b9045627d74fdc 7081bd235a6f4070820716b142a3606b] Running cmd (subprocess): cat /proc/1996/cmdline from (pid=1132) execute /usr/lib/python2.7/dist-packages/nova/utils.py:219
2012-06-25 11:55:02 DEBUG nova.utils [req-158697c8-f1d7-42b7-87c3-b8636a4783b4 bd096917fac04e4488b9045627d74fdc 7081bd235a6f4070820716b142a3606b] Running cmd (subprocess): sudo nova-rootwrap kill -HUP 1996 from (pid=1132) execute /usr/lib/python2.7/dist-packages/nova/utils.py:219
2012-06-25 11:55:02 DEBUG nova.utils [req-158697c8-f1d7-42b7-87c3-b8636a4783b4 bd096917fac04e4488b9045627d74fdc 7081bd235a6f4070820716b142a3606b] Running cmd (subprocess): sudo nova-rootwrap dhcp_release br100 192.168.3.2 fa:16:3e:27:65:4a from (pid=1132) execute /usr/lib/python2.7/dist-packages/nova/utils.py:219
2012-06-25 11:55:03 DEBUG nova.rpc.amqp [-] received {u'_context_roles': [u'admin'], u'_context_request_id': u'req-8e8f60f6-5a93-41a3-b7f8-33f2ea57645a', u'_context_read_deleted': u'no', u'args': {u'address': u'192.168.3.2'}, u'_context_auth_token': '<SANITIZED>', u'_context_is_admin': True, u'_context_project_id': None, u'_context_timestamp': u'2012-06-25T09:55:03.921228', u'_context_user_id': None, u'method': u'release_fixed_ip', u'_context_remote_address': None} from (pid=1132) _safe_log /usr/lib/python2.7/dist-packages/nova/rpc/common.py:160
2012-06-25 11:55:03 DEBUG nova.rpc.amqp [req-8e8f60f6-5a93-41a3-b7f8-33f2ea57645a None None] unpacked context: {'user_id': None, 'roles': [u'admin'], 'timestamp': '2012-06-25T09:55:03.921228', 'auth_token': '<SANITIZED>', 'remote_address': None, 'is_admin': True, 'request_id': u'req-8e8f60f6-5a93-41a3-b7f8-33f2ea57645a', 'project_id': None, 'read_deleted': u'no'} from (pid=1132) _safe_log /usr/lib/python2.7/dist-packages/nova/rpc/common.py:160
2012-06-25 11:55:03 DEBUG nova.network.manager [req-8e8f60f6-5a93-41a3-b7f8-33f2ea57645a None None] Released IP |192.168.3.2| from (pid=1132) release_fixed_ip /usr/lib/python2.7/dist-packages/nova/network/manager.py:1261
2012-06-25 11:55:25 DEBUG nova.manager [-] Running periodic task FlatDHCPManager._publish_service_capabilities from (pid=1132) periodic_tasks /usr/lib/python2.7/dist-packages/nova/manager.py:152
2012-06-25 11:55:25 DEBUG nova.manager [-] Running periodic task FlatDHCPManager._disassociate_stale_fixed_ips from (pid=1132) periodic_tasks /usr/lib/python2.7/dist-packages/nova/manager.py:152
2012-06-25 11:56:25 DEBUG nova.manager [-] Running periodic task FlatDHCPManager._publish_service_capabilities from (pid=1132) periodic_tasks /usr/lib/python2.7/dist-packages/nova/manager.py:152
2012-06-25 11:56:25 DEBUG nova.manager [-] Running periodic task FlatDHCPManager._disassociate_stale_fixed_ips from (pid=1132) periodic_tasks /usr/lib/python2.7/dist-packages/nova/manager.py:152
2012-06-25 11:57:25 DEBUG nova.manager [-] Running periodic task FlatDHCPManager._publish_service_capabilities from (pid=1132) periodic_tasks /usr/lib/python2.7/dist-packages/nova/manager.py:152
2012-06-25 11:57:25 DEBUG nova.manager [-] Running periodic task FlatDHCPManager._disassociate_stale_fixed_ips from (pid=1132) periodic_tasks /usr/lib/python2.7/dist-packages/nova/manager.py:152
2012-06-25 11:58:25 DEBUG nova.manager [-] Running periodic task FlatDHCPManager._publish_service_capabilities from (pid=1132) periodic_tasks /usr/lib/python2.7/dist-packages/nova/manager.py:152
2012-06-25 11:58:25 DEBUG nova.manager [-] Running periodic task FlatDHCPManager._disassociate_stale_fixed_ips from (pid=1132) periodic_tasks /usr/lib/python2.7/dist-packages/nova/manager.py:152
2012-06-25 11:58:25 DEBUG nova.network.manager [-] Disassociated 2 stale fixed ip(s) from (pid=1132) _disassociate_stale_fixed_ips /usr/lib/python2.7/dist-packages/nova/network/manager.py:778

When I run "cat /var/log/nova/nova-network.log | grep error" I got:

2012-06-25 09:47:17 DEBUG nova.service [-] publish_errors : False from (pid=1132) wait /usr/lib/python2.7/dist-packages/nova/service.py:411


And finally the libvirt/log:

2012-06-25 09:52:53.549+0000: 1338: error : virExecWithHook:328 : Cannot find 'pm-is-supported' in path: No such file or directory
2012-06-25 09:52:53.549+0000: 1338: warning : qemuCapsInit:856 : Failed to get host power management capabilities
2012-06-25 09:52:53.817+0000: 1336: error : virExecWithHook:328 : Cannot find 'pm-is-supported' in path: No such file or directory
2012-06-25 09:52:53.817+0000: 1336: warning : qemuCapsInit:856 : Failed to get host power management capabilities
2012-06-25 09:52:54.077+0000: 1335: error : virExecWithHook:328 : Cannot find 'pm-is-supported' in path: No such file or directory
2012-06-25 09:52:54.077+0000: 1335: warning : qemuCapsInit:856 : Failed to get host power management capabilities
2012-06-25 09:53:11.188+0000: 1334: error : virExecWithHook:328 : Cannot find 'pm-is-supported' in path: No such file or directory
2012-06-25 09:53:11.188+0000: 1334: warning : qemuCapsInit:856 : Failed to get host power management capabilities
2012-06-25 09:53:13.179+0000: 1336: error : virExecWithHook:328 : Cannot find 'pm-is-supported' in path: No such file or directory
2012-06-25 09:53:13.179+0000: 1336: warning : qemuCapsInit:856 : Failed to get host power management capabilities
2012-06-25 09:53:17.225+0000: 1337: error : virExecWithHook:328 : Cannot find 'pm-is-supported' in path: No such file or directory
2012-06-25 09:53:17.225+0000: 1337: warning : qemuCapsInit:856 : Failed to get host power management capabilities
2012-06-25 09:53:18.898+0000: 1336: error : virExecWithHook:328 : Cannot find 'pm-is-supported' in path: No such file or directory
2012-06-25 09:53:18.898+0000: 1336: warning : qemuCapsInit:856 : Failed to get host power management capabilities
2012-06-25 09:53:19.284+0000: 1334: error : virExecWithHook:328 : Cannot find 'pm-is-supported' in path: No such file or directory
2012-06-25 09:53:19.284+0000: 1334: warning : qemuCapsInit:856 : Failed to get host power management capabilities
2012-06-25 09:53:19.751+0000: 1335: error : virExecWithHook:328 : Cannot find 'pm-is-supported' in path: No such file or directory
2012-06-25 09:53:19.751+0000: 1335: warning : qemuCapsInit:856 : Failed to get host power management capabilities
2012-06-25 09:53:54.360+0000: 1338: error : virExecWithHook:328 : Cannot find 'pm-is-supported' in path: No such file or directory
2012-06-25 09:53:54.360+0000: 1338: warning : qemuCapsInit:856 : Failed to get host power management capabilities
2012-06-25 09:53:54.618+0000: 1335: error : virExecWithHook:328 : Cannot find 'pm-is-supported' in path: No such file or directory
2012-06-25 09:53:54.618+0000: 1335: warning : qemuCapsInit:856 : Failed to get host power management capabilities
2012-06-25 09:53:54.862+0000: 1335: error : virExecWithHook:328 : Cannot find 'pm-is-supported' in path: No such file or directory
2012-06-25 09:53:54.862+0000: 1335: warning : qemuCapsInit:856 : Failed to get host power management capabilities
2012-06-25 09:53:55.117+0000: 1337: error : virExecWithHook:328 : Cannot find 'pm-is-supported' in path: No such file or directory
2012-06-25 09:53:55.117+0000: 1337: warning : qemuCapsInit:856 : Failed to get host power management capabilities
2012-06-25 09:53:55.378+0000: 1338: error : virExecWithHook:328 : Cannot find 'pm-is-supported' in path: No such file or directory
2012-06-25 09:53:55.378+0000: 1338: warning : qemuCapsInit:856 : Failed to get host power management capabilities
2012-06-25 09:53:55.634+0000: 1336: error : virExecWithHook:328 : Cannot find 'pm-is-supported' in path: No such file or directory
2012-06-25 09:53:55.634+0000: 1336: warning : qemuCapsInit:856 : Failed to get host power management capabilities
2012-06-25 09:53:55.896+0000: 1335: error : virExecWithHook:328 : Cannot find 'pm-is-supported' in path: No such file or directory
2012-06-25 09:53:55.896+0000: 1335: warning : qemuCapsInit:856 : Failed to get host power management capabilities
2012-06-25 09:53:56.165+0000: 1334: error : virExecWithHook:328 : Cannot find 'pm-is-supported' in path: No such file or directory
2012-06-25 09:53:56.166+0000: 1334: warning : qemuCapsInit:856 : Failed to get host power management capabilities
2012-06-25 09:53:56.398+0000: 1336: error : virExecWithHook:328 : Cannot find 'pm-is-supported' in path: No such file or directory
2012-06-25 09:53:56.398+0000: 1336: warning : qemuCapsInit:856 : Failed to get host power management capabilities
2012-06-25 09:54:57.039+0000: 1334: error : virExecWithHook:328 : Cannot find 'pm-is-supported' in path: No such file or directory
2012-06-25 09:54:57.039+0000: 1334: warning : qemuCapsInit:856 : Failed to get host power management capabilities
2012-06-25 09:54:57.274+0000: 1336: error : virExecWithHook:328 : Cannot find 'pm-is-supported' in path: No such file or directory
2012-06-25 09:54:57.274+0000: 1336: warning : qemuCapsInit:856 : Failed to get host power management capabilities
2012-06-25 09:54:57.526+0000: 1336: error : virExecWithHook:328 : Cannot find 'pm-is-supported' in path: No such file or directory
2012-06-25 09:54:57.526+0000: 1336: warning : qemuCapsInit:856 : Failed to get host power management capabilities
2012-06-25 09:54:57.777+0000: 1335: error : virExecWithHook:328 : Cannot find 'pm-is-supported' in path: No such file or directory
2012-06-25 09:54:57.777+0000: 1335: warning : qemuCapsInit:856 : Failed to get host power management capabilities
2012-06-25 09:54:58.026+0000: 1334: error : virExecWithHook:328 : Cannot find 'pm-is-supported' in path: No such file or directory
2012-06-25 09:54:58.026+0000: 1334: warning : qemuCapsInit:856 : Failed to get host power management capabilities
2012-06-25 09:54:58.281+0000: 1338: error : virExecWithHook:328 : Cannot find 'pm-is-supported' in path: No such file or directory
2012-06-25 09:54:58.281+0000: 1338: warning : qemuCapsInit:856 : Failed to get host power management capabilities
2012-06-25 09:54:58.548+0000: 1336: error : virExecWithHook:328 : Cannot find 'pm-is-supported' in path: No such file or directory
2012-06-25 09:54:58.548+0000: 1336: warning : qemuCapsInit:856 : Failed to get host power management capabilities
2012-06-25 09:54:58.758+0000: 1337: error : virExecWithHook:328 : Cannot find 'pm-is-supported' in path: No such file or directory
2012-06-25 09:54:58.758+0000: 1337: warning : qemuCapsInit:856 : Failed to get host power management capabilities
2012-06-25 09:54:59.022+0000: 1338: error : virExecWithHook:328 : Cannot find 'pm-is-supported' in path: No such file or directory
2012-06-25 09:54:59.022+0000: 1338: warning : qemuCapsInit:856 : Failed to get host power management capabilities
2012-06-25 09:54:59.596+0000: 1337: error : virExecWithHook:328 : Cannot find 'pm-is-supported' in path: No such file or directory
2012-06-25 09:54:59.596+0000: 1337: warning : qemuCapsInit:856 : Failed to get host power management capabilities
2012-06-25 09:54:59.838+0000: 1338: error : virExecWithHook:328 : Cannot find 'pm-is-supported' in path: No such file or directory
2012-06-25 09:54:59.838+0000: 1338: warning : qemuCapsInit:856 : Failed to get host power management capabilities
2012-06-25 09:55:00.082+0000: 1338: error : virExecWithHook:328 : Cannot find 'pm-is-supported' in path: No such file or directory
2012-06-25 09:55:00.082+0000: 1338: warning : qemuCapsInit:856 : Failed to get host power management capabilities
2012-06-25 09:55:00.329+0000: 1336: error : virExecWithHook:328 : Cannot find 'pm-is-supported' in path: No such file or directory
2012-06-25 09:55:00.329+0000: 1336: warning : qemuCapsInit:856 : Failed to get host power management capabilities
2012-06-25 09:55:00.597+0000: 1335: error : virExecWithHook:328 : Cannot find 'pm-is-supported' in path: No such file or directory
2012-06-25 09:55:00.597+0000: 1335: warning : qemuCapsInit:856 : Failed to get host power management capabilities
2012-06-25 09:55:00.849+0000: 1337: error : virExecWithHook:328 : Cannot find 'pm-is-supported' in path: No such file or directory
2012-06-25 09:55:00.849+0000: 1337: warning : qemuCapsInit:856 : Failed to get host power management capabilities
2012-06-25 09:55:02.227+0000: 1338: error : virExecWithHook:328 : Cannot find 'pm-is-supported' in path: No such file or directory
2012-06-25 09:55:02.227+0000: 1338: warning : qemuCapsInit:856 : Failed to get host power management capabilities
2012-06-25 09:55:02.910+0000: 1335: error : virNetDevGetIndex:656 : Unable to get index for interface vnet0: No such device
2012-06-25 09:55:04.079+0000: 1338: error : virExecWithHook:328 : Cannot find 'pm-is-supported' in path: No such file or directory
2012-06-25 09:55:04.079+0000: 1338: warning : qemuCapsInit:856 : Failed to get host power management capabilities
2012-06-25 09:55:04.554+0000: 1335: error : virExecWithHook:328 : Cannot find 'pm-is-supported' in path: No such file or directory
2012-06-25 09:55:04.554+0000: 1335: warning : qemuCapsInit:856 : Failed to get host power management capabilities
2012-06-25 09:56:01.147+0000: 1338: error : virExecWithHook:328 : Cannot find 'pm-is-supported' in path: No such file or directory
2012-06-25 09:56:01.147+0000: 1338: warning : qemuCapsInit:856 : Failed to get host power management capabilities
2012-06-25 09:56:01.390+0000: 1335: error : virExecWithHook:328 : Cannot find 'pm-is-supported' in path: No such file or directory
2012-06-25 09:56:01.390+0000: 1335: warning : qemuCapsInit:856 : Failed to get host power management capabilities
2012-06-25 09:56:01.653+0000: 1337: error : virExecWithHook:328 : Cannot find 'pm-is-supported' in path: No such file or directory
2012-06-25 09:56:01.653+0000: 1337: warning : qemuCapsInit:856 : Failed to get host power management capabilities
2012-06-25 09:56:01.910+0000: 1338: error : virExecWithHook:328 : Cannot find 'pm-is-supported' in path: No such file or directory
2012-06-25 09:56:01.910+0000: 1338: warning : qemuCapsInit:856 : Failed to get host power management capabilities
2012-06-25 09:56:02.161+0000: 1336: error : virExecWithHook:328 : Cannot find 'pm-is-supported' in path: No such file or directory
2012-06-25 09:56:02.161+0000: 1336: warning : qemuCapsInit:856 : Failed to get host power management capabilities
2012-06-25 09:56:02.388+0000: 1335: error : virExecWithHook:328 : Cannot find 'pm-is-supported' in path: No such file or directory
2012-06-25 09:56:02.388+0000: 1335: warning : qemuCapsInit:856 : Failed to get host power management capabilities
2012-06-25 09:57:02.790+0000: 1334: error : virExecWithHook:328 : Cannot find 'pm-is-supported' in path: No such file or directory
2012-06-25 09:57:02.790+0000: 1334: warning : qemuCapsInit:856 : Failed to get host power management capabilities
2012-06-25 09:57:03.068+0000: 1336: error : virExecWithHook:328 : Cannot find 'pm-is-supported' in path: No such file or directory
2012-06-25 09:57:03.068+0000: 1336: warning : qemuCapsInit:856 : Failed to get host power management capabilities
2012-06-25 09:57:03.338+0000: 1337: error : virExecWithHook:328 : Cannot find 'pm-is-supported' in path: No such file or directory
2012-06-25 09:57:03.338+0000: 1337: warning : qemuCapsInit:856 : Failed to get host power management capabilities
2012-06-25 09:57:03.593+0000: 1334: error : virExecWithHook:328 : Cannot find 'pm-is-supported' in path: No such file or directory
2012-06-25 09:57:03.593+0000: 1334: warning : qemuCapsInit:856 : Failed to get host power management capabilities
2012-06-25 09:57:03.850+0000: 1336: error : virExecWithHook:328 : Cannot find 'pm-is-supported' in path: No such file or directory
2012-06-25 09:57:03.850+0000: 1336: warning : qemuCapsInit:856 : Failed to get host power management capabilities
2012-06-25 09:57:04.101+0000: 1335: error : virExecWithHook:328 : Cannot find 'pm-is-supported' in path: No such file or directory
2012-06-25 09:57:04.101+0000: 1335: warning : qemuCapsInit:856 : Failed to get host power management capabilities
2012-06-25 09:57:04.368+0000: 1337: error : virExecWithHook:328 : Cannot find 'pm-is-supported' in path: No such file or directory
2012-06-25 09:57:04.368+0000: 1337: warning : qemuCapsInit:856 : Failed to get host power management capabilities
2012-06-25 09:57:04.785+0000: 1338: error : virExecWithHook:328 : Cannot find 'pm-is-supported' in path: No such file or directory
2012-06-25 09:57:04.785+0000: 1338: warning : qemuCapsInit:856 : Failed to get host power management capabilities
2012-06-25 09:57:05.066+0000: 1335: error : virExecWithHook:328 : Cannot find 'pm-is-supported' in path: No such file or directory
2012-06-25 09:57:05.066+0000: 1335: warning : qemuCapsInit:856 : Failed to get host power management capabilities
2012-06-25 09:57:05.325+0000: 1337: error : virExecWithHook:328 : Cannot find 'pm-is-supported' in path: No such file or directory
2012-06-25 09:57:05.325+0000: 1337: warning : qemuCapsInit:856 : Failed to get host power management capabilities
2012-06-25 09:57:05.596+0000: 1334: error : virExecWithHook:328 : Cannot find 'pm-is-supported' in path: No such file or directory
2012-06-25 09:57:05.597+0000: 1334: warning : qemuCapsInit:856 : Failed to get host power management capabilities
2012-06-25 09:57:05.861+0000: 1338: error : virExecWithHook:328 : Cannot find 'pm-is-supported' in path: No such file or directory
2012-06-25 09:57:05.861+0000: 1338: warning : qemuCapsInit:856 : Failed to get host power management capabilities
2012-06-25 09:58:06.157+0000: 1335: error : virExecWithHook:328 : Cannot find 'pm-is-supported' in path: No such file or directory
2012-06-25 09:58:06.157+0000: 1335: warning : qemuCapsInit:856 : Failed to get host power management capabilities
2012-06-25 09:58:06.398+0000: 1334: error : virExecWithHook:328 : Cannot find 'pm-is-supported' in path: No such file or directory
2012-06-25 09:58:06.398+0000: 1334: warning : qemuCapsInit:856 : Failed to get host power management capabilities
2012-06-25 09:58:06.645+0000: 1338: error : virExecWithHook:328 : Cannot find 'pm-is-supported' in path: No such file or directory
2012-06-25 09:58:06.645+0000: 1338: warning : qemuCapsInit:856 : Failed to get host power management capabilities
2012-06-25 09:58:06.910+0000: 1335: error : virExecWithHook:328 : Cannot find 'pm-is-supported' in path: No such file or directory
2012-06-25 09:58:06.910+0000: 1335: warning : qemuCapsInit:856 : Failed to get host power management capabilities
2012-06-25 09:58:07.165+0000: 1337: error : virExecWithHook:328 : Cannot find 'pm-is-supported' in path: No such file or directory
2012-06-25 09:58:07.165+0000: 1337: warning : qemuCapsInit:856 : Failed to get host power management capabilities
2012-06-25 09:58:07.440+0000: 1334: error : virExecWithHook:328 : Cannot find 'pm-is-supported' in path: No such file or directory
2012-06-25 09:58:07.440+0000: 1334: warning : qemuCapsInit:856 : Failed to get host power management capabilities
2012-06-25 09:59:07.769+0000: 1336: error : virExecWithHook:328 : Cannot find 'pm-is-supported' in path: No such file or directory
2012-06-25 09:59:07.769+0000: 1336: warning : qemuCapsInit:856 : Failed to get host power management capabilities
2012-06-25 09:59:08.018+0000: 1337: error : virExecWithHook:328 : Cannot find 'pm-is-supported' in path: No such file or directory
2012-06-25 09:59:08.018+0000: 1337: warning : qemuCapsInit:856 : Failed to get host power management capabilities
2012-06-25 09:59:08.278+0000: 1334: error : virExecWithHook:328 : Cannot find 'pm-is-supported' in path: No such file or directory
2012-06-25 09:59:08.278+0000: 1334: warning : qemuCapsInit:856 : Failed to get host power management capabilities
2012-06-25 09:59:08.526+0000: 1336: error : virExecWithHook:328 : Cannot find 'pm-is-supported' in path: No such file or directory
2012-06-25 09:59:08.526+0000: 1336: warning : qemuCapsInit:856 : Failed to get host power management capabilities
2012-06-25 09:59:08.817+0000: 1335: error : virExecWithHook:328 : Cannot find 'pm-is-supported' in path: No such file or directory
2012-06-25 09:59:08.817+0000: 1335: warning : qemuCapsInit:856 : Failed to get host power management capabilities
2012-06-25 09:59:09.086+0000: 1337: error : virExecWithHook:328 : Cannot find 'pm-is-supported' in path: No such file or directory
2012-06-25 09:59:09.086+0000: 1337: warning : qemuCapsInit:856 : Failed to get host power management capabilities
2012-06-25 09:59:09.430+0000: 1338: error : virExecWithHook:328 : Cannot find 'pm-is-supported' in path: No such file or directory
2012-06-25 09:59:09.430+0000: 1338: warning : qemuCapsInit:856 : Failed to get host power management capabilities
2012-06-25 09:59:09.690+0000: 1335: error : virExecWithHook:328 : Cannot find 'pm-is-supported' in path: No such file or directory
2012-06-25 09:59:09.690+0000: 1335: warning : qemuCapsInit:856 : Failed to get host power management capabilities
2012-06-25 09:59:09.961+0000: 1337: error : virExecWithHook:328 : Cannot find 'pm-is-supported' in path: No such file or directory
2012-06-25 09:59:09.961+0000: 1337: warning : qemuCapsInit:856 : Failed to get host power management capabilities
2012-06-25 09:59:10.212+0000: 1334: error : virExecWithHook:328 : Cannot find 'pm-is-supported' in path: No such file or directory
2012-06-25 09:59:10.212+0000: 1334: warning : qemuCapsInit:856 : Failed to get host power management capabilities
2012-06-25 09:59:10.489+0000: 1338: error : virExecWithHook:328 : Cannot find 'pm-is-supported' in path: No such file or directory
2012-06-25 09:59:10.489+0000: 1338: warning : qemuCapsInit:856 : Failed to get host power management capabilities

I really hope getting help, 
thank you

sincerely 
Badis