[Openstack-operators] nova-compute and xen SR - error trace

Leandro Reox leandro.reox at gmail.com
Thu May 12 14:28:45 UTC 2011


I manage to get everything working, but it seems that nova is not locating
the xen SR, when i start an instance it keeps on SHUTDOWN state, trace below
:

2011-05-12 09:53:52,814 DEBUG nova.rpc [-] received {u'_context_request_id':
u'ZCACXBRLE67UDK7ZOC4R', u'_context_read_deleted': False, u'args':
{u'instance_id': 12, u'injected_files': None, u'availability_zone': None},
u'_context_is_admin': True, u'_context_timestamp': u'2011-05-12T13:53:43Z',
u'_context_user': u'admin', u'method': u'run_instance', u'_context_project':
u'melicloud', u'_context_remote_address': u'172.16.133.241'} from (pid=4250)
_receive /usr/lib/pymodules/python2.6/nova/rpc.py:177
2011-05-12 09:53:52,814 DEBUG nova.rpc [-] unpacked context: {'timestamp':
u'2011-05-12T13:53:43Z', 'remote_address': u'172.16.133.241', 'project':
u'melicloud', 'is_admin': True, 'user': u'admin', 'request_id':
u'ZCACXBRLE67UDK7ZOC4R', 'read_deleted': False} from (pid=4250)
_unpack_context /usr/lib/pymodules/python2.6/nova/rpc.py:350
2011-05-12 09:53:55,530 AUDIT nova.compute.manager [ZCACXBRLE67UDK7ZOC4R
admin melicloud] instance 12: starting...
2011-05-12 09:53:55,660 DEBUG nova.rpc [-] Making asynchronous call on
network.novacontroller ... from (pid=4250) call
/usr/lib/pymodules/python2.6/nova/rpc.py:370
2011-05-12 09:53:55,661 DEBUG nova.rpc [-] MSG_ID is
c03c04ff49f04d8d9d80b9f5e55d161c from (pid=4250) call
/usr/lib/pymodules/python2.6/nova/rpc.py:373
2011-05-12 09:53:56,191 DEBUG nova.virt.xenapi.vm_utils [-] Detected
DISK_RAW format for image 4, instance 12 from (pid=4250) log_disk_format
/usr/lib/pymodules/python2.6/nova/virt/xenapi/vm_utils.py:494
2011-05-12 09:53:56,804 ERROR nova.compute.manager [ZCACXBRLE67UDK7ZOC4R
admin melicloud] Instance '12' failed to spawn. Is virtualization enabled in
the BIOS?
(nova.compute.manager): TRACE: Traceback (most recent call last):
(nova.compute.manager): TRACE:   File
"/usr/lib/pymodules/python2.6/nova/compute/manager.py", line 240, in
run_instance
(nova.compute.manager): TRACE:     self.driver.spawn(instance_ref)
(nova.compute.manager): TRACE:   File
"/usr/lib/pymodules/python2.6/nova/virt/xenapi_conn.py", line 188, in spawn
(nova.compute.manager): TRACE:     self._vmops.spawn(instance)
(nova.compute.manager): TRACE:   File
"/usr/lib/pymodules/python2.6/nova/virt/xenapi/vmops.py", line 117, in spawn
(nova.compute.manager): TRACE:     vdi_uuid = self._create_disk(instance)
(nova.compute.manager): TRACE:   File
"/usr/lib/pymodules/python2.6/nova/virt/xenapi/vmops.py", line 113, in
_create_disk
(nova.compute.manager): TRACE:     instance.image_id, user, project,
disk_image_type)
(nova.compute.manager): TRACE:   File
"/usr/lib/pymodules/python2.6/nova/virt/xenapi/vm_utils.py", line 382, in
fetch_image
(nova.compute.manager): TRACE:     access, image_type)
(nova.compute.manager): TRACE:   File
"/usr/lib/pymodules/python2.6/nova/virt/xenapi/vm_utils.py", line 535, in
_fetch_image_glance
(nova.compute.manager): TRACE:     session, instance_id, image, access,
image_type)
(nova.compute.manager): TRACE:   File
"/usr/lib/pymodules/python2.6/nova/virt/xenapi/vm_utils.py", line 436, in
_fetch_image_glance_disk
(nova.compute.manager): TRACE:     sr_ref = safe_find_sr(session)
(nova.compute.manager): TRACE:   File
"/usr/lib/pymodules/python2.6/nova/virt/xenapi/vm_utils.py", line 853, in
safe_find_sr
(nova.compute.manager): TRACE:     raise
exception.StorageRepositoryNotFound()
(nova.compute.manager): TRACE: StorageRepositoryNotFound: Cannot find SR to
read/write VDI.
(nova.compute.manager): TRACE:
2011-05-12 09:53:57,076 ERROR nova.exception [-] Uncaught exception
(nova.exception): TRACE: Traceback (most recent call last):
(nova.exception): TRACE:   File
"/usr/lib/pymodules/python2.6/nova/exception.py", line 79, in _wrap
(nova.exception): TRACE:     return f(*args, **kw)
(nova.exception): TRACE:   File
"/usr/lib/pymodules/python2.6/nova/compute/manager.py", line 265, in
run_instance
(nova.exception): TRACE:     self._update_state(context, instance_id)
(nova.exception): TRACE:   File
"/usr/lib/pymodules/python2.6/nova/compute/manager.py", line 145, in
_update_state
(nova.exception): TRACE:     info =
self.driver.get_info(instance_ref['name'])
(nova.exception): TRACE:   File
"/usr/lib/pymodules/python2.6/nova/virt/xenapi_conn.py", line 263, in
get_info
(nova.exception): TRACE:     return self._vmops.get_info(instance_id)
(nova.exception): TRACE:   File
"/usr/lib/pymodules/python2.6/nova/virt/xenapi/vmops.py", line 771, in
get_info
(nova.exception): TRACE:     vm_ref = self._get_vm_opaque_ref(instance)
(nova.exception): TRACE:   File
"/usr/lib/pymodules/python2.6/nova/virt/xenapi/vmops.py", line 262, in
_get_vm_opaque_ref
(nova.exception): TRACE:     raise exception.InstanceNotFound(instance_id=
instance_obj.id)
(nova.exception): TRACE: UnboundLocalError: local variable 'instance_obj'
referenced before assignment
(nova.exception): TRACE:
2011-05-12 09:53:57,111 ERROR nova [-] Exception during message handling
(nova): TRACE: Traceback (most recent call last):
(nova): TRACE:   File "/usr/lib/pymodules/python2.6/nova/rpc.py", line 198,
in _receive
(nova): TRACE:     rval = node_func(context=ctxt, **node_args)
(nova): TRACE:   File "/usr/lib/pymodules/python2.6/nova/exception.py", line
85, in _wrap
(nova): TRACE:     raise Error(str(e))
(nova): TRACE: Error: local variable 'instance_obj' referenced before
assignment
(nova): TRACE:
2011-05-12 09:54:50,664 INFO nova.virt.xenapi.vm_utils [-] (VM_UTILS)
xenserver vm state -> |Running|
2011-05-12 09:54:50,665 INFO nova.virt.xenapi.vm_utils [-] (VM_UTILS) xenapi
power_state -> |1|
2011-05-12 09:54:51,060 INFO nova.compute.manager [-] Found instance
'instance-0000000c' in DB but no VM. State=4, so setting state to shutoff.
2011-05-12 09:54:51,060 INFO nova.compute.manager [-] DB/VM state mismatch.
Changing state from '4' to '5'
2011-05-12 09:55:53,429 INFO nova.virt.xenapi.vm_utils [-] (VM_UTILS)
xenserver vm state -> |Running|
2011-05-12 09:55:53,429 INFO nova.virt.xenapi.vm_utils [-] (VM_UTILS) xenapi
power_state -> |1|
2011-05-12 09:55:53,802 INFO nova.compute.manager [-] Found instance
'instance-0000000c' in DB but no VM. State=5, so setting state to shutoff.
2011-05-12 09:56:56,132 INFO nova.virt.xenapi.vm_utils [-] (VM_UTILS)
xenserver vm state -> |Running|
2011-05-12 09:56:56,132 INFO nova.virt.xenapi.vm_utils [-] (VM_UTILS) xenapi
power_state -> |1|
2011-05-12 09:56:56,503 INFO nova.compute.manager [-] Found instance
'instance-0000000c' in DB but no VM. State=5, so setting state to shutoff.
2011-05-12 09:57:58,846 INFO nova.virt.xenapi.vm_utils [-] (VM_UTILS)
xenserver vm state -> |Running|
2011-05-12 09:57:58,846 INFO nova.virt.xenapi.vm_utils [-] (VM_UTILS) xenapi
power_state -> |1|
2011-05-12 09:57:59,216 INFO nova.compute.manager [-] Found instance
'instance-0000000c' in DB but no VM. State=5, so setting state to shutoff.
2011-05-12 09:59:01,539 INFO nova.virt.xenapi.vm_utils [-] (VM_UTILS)
xenserver vm state -> |Running|
2011-05-12 09:59:01,539 INFO nova.virt.xenapi.vm_utils [-] (VM_UTILS) xenapi
power_state -> |1|
2011-05-12 09:59:01,911 INFO nova.compute.manager [-] Found instance
'instance-0000000c' in DB but no VM. State=5, so setting state to shutoff.
2011-05-12 10:00:04,233 INFO nova.virt.xenapi.vm_utils [-] (VM_UTILS)
xenserver vm state -> |Running|
2011-05-12 10:00:04,233 INFO nova.virt.xenapi.vm_utils [-] (VM_UTILS) xenapi
power_state -> |1|
2011-05-12 10:00:04,605 INFO nova.compute.manager [-] Found instance
'instance-0000000c' in DB but no VM. State=5, so setting state to shutoff.
2011-05-12 10:01:06,936 INFO nova.virt.xenapi.vm_utils [-] (VM_UTILS)
xenserver vm state -> |Running|
2011-05-12 10:01:06,936 INFO nova.virt.xenapi.vm_utils [-] (VM_UTILS) xenapi
power_state -> |1|
2011-05-12 10:01:07,308 INFO nova.compute.manager [-] Found instance
'instance-0000000c' in DB but no VM. State=5, so setting state to shutoff.
2011-05-12 10:02:09,650 INFO nova.virt.xenapi.vm_utils [-] (VM_UTILS)
xenserver vm state -> |Running|
2011-05-12 10:02:09,651 INFO nova.virt.xenapi.vm_utils [-] (VM_UTILS) xenapi
power_state -> |1|
2011-05-12 10:02:10,022 INFO nova.compute.manager [-] Found instance
'instance-0000000c' in DB but no VM. State=5, so setting state to shutoff.
2011-05-12 10:03:12,344 INFO nova.virt.xenapi.vm_utils [-] (VM_UTILS)
xenserver vm state -> |Running|
2011-05-12 10:03:12,344 INFO nova.virt.xenapi.vm_utils [-] (VM_UTILS) xenapi
power_state -> |1|
2011-05-12 10:03:12,715 INFO nova.compute.manager [-] Found instance
'instance-0000000c' in DB but no VM. State=5, so setting state to shutoff.
2011-05-12 10:04:15,031 INFO nova.virt.xenapi.vm_utils [-] (VM_UTILS)
xenserver vm state -> |Running|
2011-05-12 10:04:15,031 INFO nova.virt.xenapi.vm_utils [-] (VM_UTILS) xenapi
power_state -> |1|
2011-05-12 10:04:15,410 INFO nova.compute.manager [-] Found instance
'instance-0000000c' in DB but no VM. State=5, so setting state to shutoff.
2011-05-12 10:05:17,731 INFO nova.virt.xenapi.vm_utils [-] (VM_UTILS)
xenserver vm state -> |Running|
2011-05-12 10:05:17,731 INFO nova.virt.xenapi.vm_utils [-] (VM_UTILS) xenapi
power_state -> |1|
2011-05-12 10:05:18,138 INFO nova.compute.manager [-] Found instance
'instance-0000000c' in DB but no VM. State=5, so setting state to shutoff.
-------------- next part --------------
An HTML attachment was scrubbed...
URL: <http://lists.openstack.org/pipermail/openstack-operators/attachments/20110512/3419f84f/attachment-0002.html>


More information about the Openstack-operators mailing list