Attachment 890538 Details for Bug 1092079 – compute.log

compute.log

file_1092079.txt (text/plain), 15.06 KB, created by Jaroslav Henner on 2014-04-28 17:36:37 UTC

(hide)

Description:

Filename:

MIME Type:

Creator: Jaroslav Henner

Created: 2014-04-28 17:36:37 UTC

Size: 15.06 KB

patch

obsolete

>2014-04-28 13:27:10.483 8869 AUDIT nova.compute.resource_tracker [-] Free ram (MB): 7391
>2014-04-28 13:27:10.483 8869 AUDIT nova.compute.resource_tracker [-] Free disk (GB): 223
>2014-04-28 13:27:10.484 8869 AUDIT nova.compute.resource_tracker [-] Free VCPUS: 2
>2014-04-28 13:27:10.560 8869 INFO nova.compute.resource_tracker [-] Compute_service record updated for cloudimg:domain-c7(foo)
>2014-04-28 13:28:11.171 8869 AUDIT nova.compute.resource_tracker [-] Auditing locally available compute resources
>2014-04-28 13:28:11.571 8869 AUDIT nova.compute.resource_tracker [-] Free ram (MB): 7391
>2014-04-28 13:28:11.571 8869 AUDIT nova.compute.resource_tracker [-] Free disk (GB): 223
>2014-04-28 13:28:11.572 8869 AUDIT nova.compute.resource_tracker [-] Free VCPUS: 2
>2014-04-28 13:28:11.638 8869 INFO nova.compute.resource_tracker [-] Compute_service record updated for cloudimg:domain-c7(foo)
>2014-04-28 13:28:13.019 8869 AUDIT nova.compute.resource_tracker [-] Auditing locally available compute resources
>2014-04-28 13:28:13.467 8869 AUDIT nova.compute.resource_tracker [-] Free ram (MB): 7391
>2014-04-28 13:28:13.483 8869 AUDIT nova.compute.resource_tracker [-] Free disk (GB): 223
>2014-04-28 13:28:13.484 8869 AUDIT nova.compute.resource_tracker [-] Free VCPUS: 2
>2014-04-28 13:28:13.590 8869 INFO nova.compute.resource_tracker [-] Compute_service record updated for cloudimg:domain-c7(foo)
>2014-04-28 13:29:06.484 8869 AUDIT nova.compute.resource_tracker [-] Auditing locally available compute resources
>2014-04-28 13:29:06.898 8869 AUDIT nova.compute.resource_tracker [-] Free ram (MB): 7391
>2014-04-28 13:29:06.899 8869 AUDIT nova.compute.resource_tracker [-] Free disk (GB): 223
>2014-04-28 13:29:06.899 8869 AUDIT nova.compute.resource_tracker [-] Free VCPUS: 2
>2014-04-28 13:29:06.954 8869 INFO nova.compute.resource_tracker [-] Compute_service record updated for cloudimg:domain-c7(foo)
>2014-04-28 13:29:16.794 8869 AUDIT nova.compute.resource_tracker [-] Auditing locally available compute resources
>2014-04-28 13:29:17.196 8869 AUDIT nova.compute.resource_tracker [-] Free ram (MB): 7391
>2014-04-28 13:29:17.197 8869 AUDIT nova.compute.resource_tracker [-] Free disk (GB): 223
>2014-04-28 13:29:17.197 8869 AUDIT nova.compute.resource_tracker [-] Free VCPUS: 2
>2014-04-28 13:29:17.281 8869 INFO nova.compute.resource_tracker [-] Compute_service record updated for cloudimg:domain-c7(foo)
>2014-04-28 13:29:17.463 8869 WARNING nova.compute.manager [-] Found 2 in the database and 7 on the hypervisor.
>2014-04-28 13:30:18.350 8869 AUDIT nova.compute.resource_tracker [-] Auditing locally available compute resources
>2014-04-28 13:30:18.775 8869 AUDIT nova.compute.resource_tracker [-] Free ram (MB): 7391
>2014-04-28 13:30:18.776 8869 AUDIT nova.compute.resource_tracker [-] Free disk (GB): 223
>2014-04-28 13:30:18.776 8869 AUDIT nova.compute.resource_tracker [-] Free VCPUS: 2
>2014-04-28 13:30:18.852 8869 INFO nova.compute.resource_tracker [-] Compute_service record updated for cloudimg:domain-c7(foo)
>2014-04-28 13:31:19.335 8869 AUDIT nova.compute.resource_tracker [-] Auditing locally available compute resources
>2014-04-28 13:31:19.734 8869 AUDIT nova.compute.resource_tracker [-] Free ram (MB): 7391
>2014-04-28 13:31:19.735 8869 AUDIT nova.compute.resource_tracker [-] Free disk (GB): 223
>2014-04-28 13:31:19.735 8869 AUDIT nova.compute.resource_tracker [-] Free VCPUS: 2
>2014-04-28 13:31:19.792 8869 INFO nova.compute.resource_tracker [-] Compute_service record updated for cloudimg:domain-c7(foo)
>2014-04-28 13:32:20.467 8869 AUDIT nova.compute.resource_tracker [-] Auditing locally available compute resources
>2014-04-28 13:32:20.895 8869 AUDIT nova.compute.resource_tracker [-] Free ram (MB): 7391
>2014-04-28 13:32:20.895 8869 AUDIT nova.compute.resource_tracker [-] Free disk (GB): 223
>2014-04-28 13:32:20.896 8869 AUDIT nova.compute.resource_tracker [-] Free VCPUS: 2
>2014-04-28 13:32:20.949 8869 INFO nova.compute.resource_tracker [-] Compute_service record updated for cloudimg:domain-c7(foo)
>2014-04-28 13:33:01.176 8869 AUDIT nova.compute.manager [req-3d6c9585-25a7-43bb-98ce-e26899f65ff0 639678fbaf8147bbb2f38043b4305bd8 365c31d728ef4bf2a43dcb9dde5e538f] [instance: c5822237-b054-4e26-81a9-629817f9f2e4] Detach volume 5f1c4596-e3f0-4829-b82a-aa3fba621b40 from mountpoint /dev/sdb
>2014-04-28 13:33:01.267 8869 WARNING nova.compute.manager [req-3d6c9585-25a7-43bb-98ce-e26899f65ff0 639678fbaf8147bbb2f38043b4305bd8 365c31d728ef4bf2a43dcb9dde5e538f] [instance: c5822237-b054-4e26-81a9-629817f9f2e4] Detaching volume from unknown instance
>2014-04-28 13:33:09.546 8869 INFO nova.virt.vmwareapi.volumeops [req-3d6c9585-25a7-43bb-98ce-e26899f65ff0 639678fbaf8147bbb2f38043b4305bd8 365c31d728ef4bf2a43dcb9dde5e538f] Mountpoint /dev/sdb detached from instance instance-00000005
>2014-04-28 13:33:10.251 8869 INFO urllib3.connectionpool [-] Starting new HTTP connection (1): 10.34.69.103
>2014-04-28 13:33:10.429 8869 INFO urllib3.connectionpool [-] Starting new HTTP connection (1): 10.34.69.103
>2014-04-28 13:33:21.404 8869 AUDIT nova.compute.resource_tracker [-] Auditing locally available compute resources
>2014-04-28 13:33:21.822 8869 AUDIT nova.compute.resource_tracker [-] Free ram (MB): 7391
>2014-04-28 13:33:21.822 8869 AUDIT nova.compute.resource_tracker [-] Free disk (GB): 223
>2014-04-28 13:33:21.822 8869 AUDIT nova.compute.resource_tracker [-] Free VCPUS: 2
>2014-04-28 13:33:21.887 8869 INFO nova.compute.resource_tracker [-] Compute_service record updated for cloudimg:domain-c7(foo)
>2014-04-28 13:33:28.796 8869 AUDIT nova.compute.manager [req-7f602213-4429-42f6-ab0f-201e03d5d9c3 639678fbaf8147bbb2f38043b4305bd8 365c31d728ef4bf2a43dcb9dde5e538f] [instance: c5822237-b054-4e26-81a9-629817f9f2e4] Attaching volume cfc0327a-3b57-45ab-adea-71aa96b3c226 to /dev/sdc
>2014-04-28 13:33:29.504 8869 INFO urllib3.connectionpool [-] Starting new HTTP connection (1): 10.34.69.103
>2014-04-28 13:33:37.889 8869 WARNING nova.virt.vmwareapi.driver [-] Task [ReconfigVM_Task] (returnval){
>   value = "task-2450"
>   _type = "Task"
> } status: error A specified parameter was not correct. 
>
>2014-04-28 13:33:37.890 8869 ERROR nova.compute.manager [req-7f602213-4429-42f6-ab0f-201e03d5d9c3 639678fbaf8147bbb2f38043b4305bd8 365c31d728ef4bf2a43dcb9dde5e538f] [instance: c5822237-b054-4e26-81a9-629817f9f2e4] Failed to attach volume cfc0327a-3b57-45ab-adea-71aa96b3c226 at /dev/sdc
>2014-04-28 13:33:37.890 8869 TRACE nova.compute.manager [instance: c5822237-b054-4e26-81a9-629817f9f2e4] Traceback (most recent call last):
>2014-04-28 13:33:37.890 8869 TRACE nova.compute.manager [instance: c5822237-b054-4e26-81a9-629817f9f2e4]   File "/usr/lib/python2.6/site-packages/nova/compute/manager.py", line 3689, in _attach_volume
>2014-04-28 13:33:37.890 8869 TRACE nova.compute.manager [instance: c5822237-b054-4e26-81a9-629817f9f2e4]     encryption=encryption)
>2014-04-28 13:33:37.890 8869 TRACE nova.compute.manager [instance: c5822237-b054-4e26-81a9-629817f9f2e4]   File "/usr/lib/python2.6/site-packages/nova/virt/vmwareapi/driver.py", line 641, in attach_volume
>2014-04-28 13:33:37.890 8869 TRACE nova.compute.manager [instance: c5822237-b054-4e26-81a9-629817f9f2e4]     mountpoint)
>2014-04-28 13:33:37.890 8869 TRACE nova.compute.manager [instance: c5822237-b054-4e26-81a9-629817f9f2e4]   File "/usr/lib/python2.6/site-packages/nova/virt/vmwareapi/volumeops.py", line 281, in attach_volume
>2014-04-28 13:33:37.890 8869 TRACE nova.compute.manager [instance: c5822237-b054-4e26-81a9-629817f9f2e4]     self._attach_volume_iscsi(connection_info, instance, mountpoint)
>2014-04-28 13:33:37.890 8869 TRACE nova.compute.manager [instance: c5822237-b054-4e26-81a9-629817f9f2e4]   File "/usr/lib/python2.6/site-packages/nova/virt/vmwareapi/volumeops.py", line 268, in _attach_volume_iscsi
>2014-04-28 13:33:37.890 8869 TRACE nova.compute.manager [instance: c5822237-b054-4e26-81a9-629817f9f2e4]     device_name=device_name)
>2014-04-28 13:33:37.890 8869 TRACE nova.compute.manager [instance: c5822237-b054-4e26-81a9-629817f9f2e4]   File "/usr/lib/python2.6/site-packages/nova/virt/vmwareapi/volumeops.py", line 71, in attach_disk_to_vm
>2014-04-28 13:33:37.890 8869 TRACE nova.compute.manager [instance: c5822237-b054-4e26-81a9-629817f9f2e4]     self._session._wait_for_task(instance_uuid, reconfig_task)
>2014-04-28 13:33:37.890 8869 TRACE nova.compute.manager [instance: c5822237-b054-4e26-81a9-629817f9f2e4]   File "/usr/lib/python2.6/site-packages/nova/virt/vmwareapi/driver.py", line 919, in _wait_for_task
>2014-04-28 13:33:37.890 8869 TRACE nova.compute.manager [instance: c5822237-b054-4e26-81a9-629817f9f2e4]     ret_val = done.wait()
>2014-04-28 13:33:37.890 8869 TRACE nova.compute.manager [instance: c5822237-b054-4e26-81a9-629817f9f2e4]   File "/usr/lib/python2.6/site-packages/eventlet/event.py", line 116, in wait
>2014-04-28 13:33:37.890 8869 TRACE nova.compute.manager [instance: c5822237-b054-4e26-81a9-629817f9f2e4]     return hubs.get_hub().switch()
>2014-04-28 13:33:37.890 8869 TRACE nova.compute.manager [instance: c5822237-b054-4e26-81a9-629817f9f2e4]   File "/usr/lib/python2.6/site-packages/eventlet/hubs/hub.py", line 187, in switch
>2014-04-28 13:33:37.890 8869 TRACE nova.compute.manager [instance: c5822237-b054-4e26-81a9-629817f9f2e4]     return self.greenlet.switch()
>2014-04-28 13:33:37.890 8869 TRACE nova.compute.manager [instance: c5822237-b054-4e26-81a9-629817f9f2e4] NovaException: A specified parameter was not correct. 
>2014-04-28 13:33:37.890 8869 TRACE nova.compute.manager [instance: c5822237-b054-4e26-81a9-629817f9f2e4] 
>2014-04-28 13:33:37.890 8869 TRACE nova.compute.manager [instance: c5822237-b054-4e26-81a9-629817f9f2e4] 
>2014-04-28 13:33:37.893 8869 INFO urllib3.connectionpool [-] Starting new HTTP connection (1): 10.34.69.103
>2014-04-28 13:33:38.463 8869 ERROR nova.openstack.common.rpc.amqp [req-7f602213-4429-42f6-ab0f-201e03d5d9c3 639678fbaf8147bbb2f38043b4305bd8 365c31d728ef4bf2a43dcb9dde5e538f] Exception during message handling
>2014-04-28 13:33:38.463 8869 TRACE nova.openstack.common.rpc.amqp Traceback (most recent call last):
>2014-04-28 13:33:38.463 8869 TRACE nova.openstack.common.rpc.amqp   File "/usr/lib/python2.6/site-packages/nova/openstack/common/rpc/amqp.py", line 461, in _process_data
>2014-04-28 13:33:38.463 8869 TRACE nova.openstack.common.rpc.amqp     **args)
>2014-04-28 13:33:38.463 8869 TRACE nova.openstack.common.rpc.amqp   File "/usr/lib/python2.6/site-packages/nova/openstack/common/rpc/dispatcher.py", line 172, in dispatch
>2014-04-28 13:33:38.463 8869 TRACE nova.openstack.common.rpc.amqp     result = getattr(proxyobj, method)(ctxt, **kwargs)
>2014-04-28 13:33:38.463 8869 TRACE nova.openstack.common.rpc.amqp   File "/usr/lib/python2.6/site-packages/nova/exception.py", line 90, in wrapped
>2014-04-28 13:33:38.463 8869 TRACE nova.openstack.common.rpc.amqp     payload)
>2014-04-28 13:33:38.463 8869 TRACE nova.openstack.common.rpc.amqp   File "/usr/lib/python2.6/site-packages/nova/exception.py", line 73, in wrapped
>2014-04-28 13:33:38.463 8869 TRACE nova.openstack.common.rpc.amqp     return f(self, context, *args, **kw)
>2014-04-28 13:33:38.463 8869 TRACE nova.openstack.common.rpc.amqp   File "/usr/lib/python2.6/site-packages/nova/compute/manager.py", line 244, in decorated_function
>2014-04-28 13:33:38.463 8869 TRACE nova.openstack.common.rpc.amqp     pass
>2014-04-28 13:33:38.463 8869 TRACE nova.openstack.common.rpc.amqp   File "/usr/lib/python2.6/site-packages/nova/compute/manager.py", line 230, in decorated_function
>2014-04-28 13:33:38.463 8869 TRACE nova.openstack.common.rpc.amqp     return function(self, context, *args, **kwargs)
>2014-04-28 13:33:38.463 8869 TRACE nova.openstack.common.rpc.amqp   File "/usr/lib/python2.6/site-packages/nova/compute/manager.py", line 272, in decorated_function
>2014-04-28 13:33:38.463 8869 TRACE nova.openstack.common.rpc.amqp     e, sys.exc_info())
>2014-04-28 13:33:38.463 8869 TRACE nova.openstack.common.rpc.amqp   File "/usr/lib/python2.6/site-packages/nova/compute/manager.py", line 259, in decorated_function
>2014-04-28 13:33:38.463 8869 TRACE nova.openstack.common.rpc.amqp     return function(self, context, *args, **kwargs)
>2014-04-28 13:33:38.463 8869 TRACE nova.openstack.common.rpc.amqp   File "/usr/lib/python2.6/site-packages/nova/compute/manager.py", line 3657, in attach_volume
>2014-04-28 13:33:38.463 8869 TRACE nova.openstack.common.rpc.amqp     context, instance, mountpoint)
>2014-04-28 13:33:38.463 8869 TRACE nova.openstack.common.rpc.amqp   File "/usr/lib/python2.6/site-packages/nova/compute/manager.py", line 3652, in attach_volume
>2014-04-28 13:33:38.463 8869 TRACE nova.openstack.common.rpc.amqp     mountpoint, instance)
>2014-04-28 13:33:38.463 8869 TRACE nova.openstack.common.rpc.amqp   File "/usr/lib/python2.6/site-packages/nova/compute/manager.py", line 3699, in _attach_volume
>2014-04-28 13:33:38.463 8869 TRACE nova.openstack.common.rpc.amqp     connector)
>2014-04-28 13:33:38.463 8869 TRACE nova.openstack.common.rpc.amqp   File "/usr/lib/python2.6/site-packages/nova/compute/manager.py", line 3689, in _attach_volume
>2014-04-28 13:33:38.463 8869 TRACE nova.openstack.common.rpc.amqp     encryption=encryption)
>2014-04-28 13:33:38.463 8869 TRACE nova.openstack.common.rpc.amqp   File "/usr/lib/python2.6/site-packages/nova/virt/vmwareapi/driver.py", line 641, in attach_volume
>2014-04-28 13:33:38.463 8869 TRACE nova.openstack.common.rpc.amqp     mountpoint)
>2014-04-28 13:33:38.463 8869 TRACE nova.openstack.common.rpc.amqp   File "/usr/lib/python2.6/site-packages/nova/virt/vmwareapi/volumeops.py", line 281, in attach_volume
>2014-04-28 13:33:38.463 8869 TRACE nova.openstack.common.rpc.amqp     self._attach_volume_iscsi(connection_info, instance, mountpoint)
>2014-04-28 13:33:38.463 8869 TRACE nova.openstack.common.rpc.amqp   File "/usr/lib/python2.6/site-packages/nova/virt/vmwareapi/volumeops.py", line 268, in _attach_volume_iscsi
>2014-04-28 13:33:38.463 8869 TRACE nova.openstack.common.rpc.amqp     device_name=device_name)
>2014-04-28 13:33:38.463 8869 TRACE nova.openstack.common.rpc.amqp   File "/usr/lib/python2.6/site-packages/nova/virt/vmwareapi/volumeops.py", line 71, in attach_disk_to_vm
>2014-04-28 13:33:38.463 8869 TRACE nova.openstack.common.rpc.amqp     self._session._wait_for_task(instance_uuid, reconfig_task)
>2014-04-28 13:33:38.463 8869 TRACE nova.openstack.common.rpc.amqp   File "/usr/lib/python2.6/site-packages/nova/virt/vmwareapi/driver.py", line 919, in _wait_for_task
>2014-04-28 13:33:38.463 8869 TRACE nova.openstack.common.rpc.amqp     ret_val = done.wait()
>2014-04-28 13:33:38.463 8869 TRACE nova.openstack.common.rpc.amqp   File "/usr/lib/python2.6/site-packages/eventlet/event.py", line 116, in wait
>2014-04-28 13:33:38.463 8869 TRACE nova.openstack.common.rpc.amqp     return hubs.get_hub().switch()
>2014-04-28 13:33:38.463 8869 TRACE nova.openstack.common.rpc.amqp   File "/usr/lib/python2.6/site-packages/eventlet/hubs/hub.py", line 187, in switch
>2014-04-28 13:33:38.463 8869 TRACE nova.openstack.common.rpc.amqp     return self.greenlet.switch()
>2014-04-28 13:33:38.463 8869 TRACE nova.openstack.common.rpc.amqp NovaException: A specified parameter was not correct. 
>2014-04-28 13:33:38.463 8869 TRACE nova.openstack.common.rpc.amqp 
>2014-04-28 13:33:38.463 8869 TRACE nova.openstack.common.rpc.amqp

Actions: View

Attachments on bug 1092079: 890538