New Question

Revision history [back]

click to hide/show revision 1
initial version

Error: Failed to launch instance "test": Please try again later [Error: No valid host was found. ].

Hi

I have two physical machines, One with Devstack deployment and another with Hyper-v. I have deployed Nova using Cloudbase: http://www.cloudbase.it/openstack/openstack-compute-installer/ When I try to spawn an instance named "test" I am getting the error :

Error: Failed to launch instance "test": Please try again later [Error: No valid host was found. ].

I have followed the following steps to create the instance (I would be better if I could explain it with screenshots, but anyway)

1) First I downloaded a mini ISO image of ubuntu.

2) Uploaded the image in openstack as VHD format. It uploaded successfully.

3) Next I clicked on the "Launch" button and it began to create an instance "test" (Flavor selected "m1.tiny")

4) Next on Instance page the task appeared as "Scheduling" and a success message appeared as "Success: Launched instance named "test" ".

5) Next, the task shifted to "Spawing", and after it ended an error, with the above message flashed, and the Status is set as "Error".

the log file in /var/log/nova/nova-compute.log contained the following error log:

2015-01-13 02:59:58.758 4106 AUDIT nova.compute.resource_tracker [-] Auditing locally available compute resources

2015-01-13 02:59:59.003 4106 AUDIT nova.compute.resource_tracker [-] Total physical ram (MB): 1841, total allocated virtual ram (MB): 512

2015-01-13 02:59:59.003 4106 AUDIT nova.compute.resource_tracker [-] Free disk (GB): 26

2015-01-13 02:59:59.004 4106 AUDIT nova.compute.resource_tracker [-] Total usable vcpus: 1, total allocated vcpus: 0

2015-01-13 02:59:59.004 4106 AUDIT nova.compute.resource_tracker [-] PCI stats: []

2015-01-13 02:59:59.004 4106 INFO nova.compute.resourcetracker [-] Computeservice record updated for localhost.localdomain:localhost.localdomain

2015-01-13 03:00:15.595 4106 AUDIT nova.compute.manager [req-e458f80c-f53b-40b6-88ee-1ecfa8be66c8 None] [instance: 5d2580c2-5f29-4a46-a7b3-d757ffd48de7] Starting instance...

2015-01-13 03:00:15.789 4106 WARNING nova.compute.resource_tracker [-] [instance: 5d2580c2-5f29-4a46-a7b3-d757ffd48de7] Host field should not be set on the instance until resources have been claimed.

2015-01-13 03:00:15.790 4106 WARNING nova.compute.resource_tracker [-] [instance: 5d2580c2-5f29-4a46-a7b3-d757ffd48de7] Node field should not be set on the instance until resources have been claimed.

2015-01-13 03:00:15.799 4106 AUDIT nova.compute.claims [-] [instance: 5d2580c2-5f29-4a46-a7b3-d757ffd48de7] Attempting claim: memory 512 MB, disk 1 GB

2015-01-13 03:00:15.800 4106 AUDIT nova.compute.claims [-] [instance: 5d2580c2-5f29-4a46-a7b3-d757ffd48de7] Total memory: 1841 MB, used: 512.00 MB

2015-01-13 03:00:15.800 4106 AUDIT nova.compute.claims [-] [instance: 5d2580c2-5f29-4a46-a7b3-d757ffd48de7] memory limit: 2761.50 MB, free: 2249.50 MB

2015-01-13 03:00:15.800 4106 AUDIT nova.compute.claims [-] [instance: 5d2580c2-5f29-4a46-a7b3-d757ffd48de7] Total disk: 26 GB, used: 0.00 GB

2015-01-13 03:00:15.800 4106 AUDIT nova.compute.claims [-] [instance: 5d2580c2-5f29-4a46-a7b3-d757ffd48de7] disk limit not specified, defaulting to unlimited

2015-01-13 03:00:15.871 4106 AUDIT nova.compute.claims [-] [instance: 5d2580c2-5f29-4a46-a7b3-d757ffd48de7] Claim successful

2015-01-13 03:00:16.371 4106 INFO nova.scheduler.client.report [-] Compute_service record updated for ('localhost.localdomain', 'localhost.localdomain')

2015-01-13 03:00:17.062 4106 INFO nova.virt.libvirt.driver [-] [instance: 5d2580c2-5f29-4a46-a7b3-d757ffd48de7] Creating image

2015-01-13 03:00:34.203 4106 WARNING nova.compute.manager [-] While synchronizing instance power states, found 1 instances in the database and 0 instances on the hypervisor.

2015-01-13 03:01:12.975 4106 WARNING nova.openstack.common.loopingcall [-] task <bound method="" dbdriver._report_state="" of="" <nova.servicegroup.drivers.db.dbdriver="" object="" at="" 0x2113f10="">> run outlasted interval by 19.30 sec

2015-01-13 03:01:24.971 4106 AUDIT nova.compute.resource_tracker [-] Auditing locally available compute resources

2015-01-13 03:02:29.960 4106 WARNING nova.openstack.common.loopingcall [-] task <bound method="" dbdriver._report_state="" of="" <nova.servicegroup.drivers.db.dbdriver="" object="" at="" 0x2113f10="">> run outlasted interval by 56.31 sec

2015-01-13 03:02:31.147 4106 AUDIT nova.compute.resource_tracker [-] Total physical ram (MB): 1841, total allocated virtual ram (MB): 1024

2015-01-13 03:02:31.147 4106 AUDIT nova.compute.resource_tracker [-] Free disk (GB): 25

2015-01-13 03:02:31.147 4106 AUDIT nova.compute.resource_tracker [-] Total usable vcpus: 1, total allocated vcpus: 0

2015-01-13 03:02:31.147 4106 AUDIT nova.compute.resource_tracker [-] PCI stats: []

2015-01-13 03:02:31.281 4106 INFO nova.scheduler.client.report [-] Compute_service record updated for ('localhost.localdomain', 'localhost.localdomain')

2015-01-13 03:02:31.281 4106 INFO nova.compute.resourcetracker [-] Computeservice record updated for localhost.localdomain:localhost.localdomain

2015-01-13 03:03:09.003 4106 WARNING nova.openstack.common.loopingcall [-] task <bound method="" dbdriver._report_state="" of="" <nova.servicegroup.drivers.db.dbdriver="" object="" at="" 0x2113f10="">> run outlasted interval by 18.95 sec

2015-01-13 03:03:21.919 4106 AUDIT nova.compute.resource_tracker [-] Auditing locally available compute resources

2015-01-13 03:03:24.267 4106 AUDIT nova.compute.resource_tracker [-] Total physical ram (MB): 1841, total allocated virtual ram (MB): 1024

2015-01-13 03:03:24.267 4106 AUDIT nova.compute.resource_tracker [-] Free disk (GB): 25

2015-01-13 03:03:24.268 4106 AUDIT nova.compute.resource_tracker [-] Total usable vcpus: 1, total allocated vcpus: 0

2015-01-13 03:03:24.268 4106 AUDIT nova.compute.resource_tracker [-] PCI stats: []

2015-01-13 03:03:24.268 4106 INFO nova.compute.resourcetracker [-] Computeservice record updated for localhost.localdomain:localhost.localdomain

2015-01-13 03:03:57.267 4106 WARNING nova.openstack.common.loopingcall [-] task <bound method="" dbdriver._report_state="" of="" <nova.servicegroup.drivers.db.dbdriver="" object="" at="" 0x2113f10="">> run outlasted interval by 7.31 sec

2015-01-13 03:04:08.665 4106 AUDIT nova.compute.resource_tracker [-] Auditing locally available compute resources

2015-01-13 03:04:12.953 4106 AUDIT nova.compute.resource_tracker [-] Total physical ram (MB): 1841, total allocated virtual ram (MB): 1024

2015-01-13 03:04:12.953 4106 AUDIT nova.compute.resource_tracker [-] Free disk (GB): 25

2015-01-13 03:04:12.954 4106 AUDIT nova.compute.resource_tracker [-] Total usable vcpus: 1, total allocated vcpus: 0

2015-01-13 03:04:12.954 4106 AUDIT nova.compute.resource_tracker [-] PCI stats: []

2015-01-13 03:04:12.955 4106 INFO nova.compute.resourcetracker [-] Computeservice record updated for localhost.localdomain:localhost.localdomain

2015-01-13 03:05:36.646 4106 ERROR nova.openstack.common.periodictask [-] Error during ComputeManager.runpendingdeletes: Timed out waiting for a reply to message ID 260aa95be9204f0d82838860aadc4add

2015-01-13 03:05:36.646 4106 TRACE nova.openstack.common.periodic_task Traceback (most recent call last):

2015-01-13 03:05:36.646 4106 TRACE nova.openstack.common.periodictask File "/usr/lib/python2.7/site-packages/nova/openstack/common/periodictask.py", line 198, in runperiodictasks

2015-01-13 03:05:36.646 4106 TRACE nova.openstack.common.periodic_task task(self, context)

2015-01-13 03:05:36.646 4106 TRACE nova.openstack.common.periodictask File "/usr/lib/python2.7/site-packages/nova/compute/manager.py", line 6228, in _runpending_deletes

2015-01-13 03:05:36.646 4106 TRACE nova.openstack.common.periodictask context, filters, expectedattrs=attrs, use_slave=True)

2015-01-13 03:05:36.646 4106 TRACE nova.openstack.common.periodic_task File "/usr/lib/python2.7/site-packages/nova/objects/base.py", line 153, in wrapper

2015-01-13 03:05:36.646 4106 TRACE nova.openstack.common.periodic_task args, kwargs)

2015-01-13 03:05:36.646 4106 TRACE nova.openstack.common.periodictask File "/usr/lib/python2.7/site-packages/nova/conductor/rpcapi.py", line 346, in objectclass_action

2015-01-13 03:05:36.646 4106 TRACE nova.openstack.common.periodic_task objver=objver, args=args, kwargs=kwargs)

2015-01-13 03:05:36.646 4106 TRACE nova.openstack.common.periodic_task File "/usr/lib/python2.7/site-packages/oslo/messaging/rpc/client.py", line 152, in call

2015-01-13 03:05:36.646 4106 TRACE nova.openstack.common.periodic_task retry=self.retry)

2015-01-13 03:05:36.646 4106 TRACE nova.openstack.common.periodic_task File "/usr/lib/python2.7/site-packages/oslo/messaging/transport.py", line 90, in _send

2015-01-13 03:05:36.646 4106 TRACE nova.openstack.common.periodic_task timeout=timeout, retry=retry)

2015-01-13 03:05:36.646 4106 TRACE nova.openstack.common.periodictask File "/usr/lib/python2.7/site-packages/oslo/messaging/drivers/amqpdriver.py", line 408, in send

2015-01-13 03:05:36.646 4106 TRACE nova.openstack.common.periodic_task retry=retry)

2015-01-13 03:05:36.646 4106 TRACE nova.openstack.common.periodictask File "/usr/lib/python2.7/site-packages/oslo/messaging/drivers/amqpdriver.py", line 397, in _send

2015-01-13 03:05:36.646 4106 TRACE nova.openstack.common.periodictask result = self.waiter.wait(msg_id, timeout)

2015-01-13 03:05:36.646 4106 TRACE nova.openstack.common.periodictask File "/usr/lib/python2.7/site-packages/oslo/messaging/drivers/amqpdriver.py", line 285, in wait

2015-01-13 03:05:36.646 4106 TRACE nova.openstack.common.periodictask reply, ending = self.pollconnection(msgid, timeout)

2015-01-13 03:05:36.646 4106 TRACE nova.openstack.common.periodictask File "/usr/lib/python2.7/site-packages/oslo/messaging/drivers/amqpdriver.py", line 235, in pollconnection

2015-01-13 03:05:36.646 4106 TRACE nova.openstack.common.periodictask % msgid)

2015-01-13 03:05:36.646 4106 TRACE nova.openstack.common.periodic_task MessagingTimeout: Timed out waiting for a reply to message ID 260aa95be9204f0d82838860aadc4add

2015-01-13 03:05:36.646 4106 TRACE nova.openstack.common.periodic_task

2015-01-13 03:05:49.350 4106 ERROR nova.servicegroup.drivers.db [-] model server went away

2015-01-13 03:05:49.350 4106 TRACE nova.servicegroup.drivers.db Traceback (most recent call last):

2015-01-13 03:05:49.350 4106 TRACE nova.servicegroup.drivers.db File "/usr/lib/python2.7/site-packages/nova/servicegroup/drivers/db.py", line 99, in reportstate

2015-01-13 03:05:49.350 4106 TRACE nova.servicegroup.drivers.db service.serviceref, statecatalog)

2015-01-13 03:05:49.350 4106 TRACE nova.servicegroup.drivers.db File "/usr/lib/python2.7/site-packages/nova/conductor/api.py", line 180, in service_update

2015-01-13 03:05:49.350 4106 TRACE nova.servicegroup.drivers.db return self.manager.serviceupdate(context, service, values)

2015-01-13 03:05:49.350 4106 TRACE nova.servicegroup.drivers.db File "/usr/lib/python2.7/site-packages/nova/conductor/rpcapi.py", line 286, in service_update

2015-01-13 03:05:49.350 4106 TRACE nova.servicegroup.drivers.db service=service_p, values=values)

2015-01-13 03:05:49.350 4106 TRACE nova.servicegroup.drivers.db File "/usr/lib/python2.7/site-packages/oslo/messaging/rpc/client.py", line 152, in call

2015-01-13 03:05:49.350 4106 TRACE nova.servicegroup.drivers.db retry=self.retry)

2015-01-13 03:05:49.350 4106 TRACE nova.servicegroup.drivers.db File "/usr/lib/python2.7/site-packages/oslo/messaging/transport.py", line 90, in _send

2015-01-13 03:05:49.350 4106 TRACE nova.servicegroup.drivers.db timeout=timeout, retry=retry)

2015-01-13 03:05:49.350 4106 TRACE nova.servicegroup.drivers.db File "/usr/lib/python2.7/site-packages/oslo/messaging/_drivers/amqpdriver.py", line 408, in send

2015-01-13 03:05:49.350 4106 TRACE nova.servicegroup.drivers.db retry=retry)

2015-01-13 03:05:49.350 4106 TRACE nova.servicegroup.drivers.db File "/usr/lib/python2.7/site-packages/oslo/messaging/_drivers/amqpdriver.py", line 397, in _send

2015-01-13 03:05:49.350 4106 TRACE nova.servicegroup.drivers.db result = self.waiter.wait(msgid, timeout)

2015-01-13 03:05:49.350 4106 TRACE nova.servicegroup.drivers.db File "/usr/lib/python2.7/site-packages/oslo/messaging/_drivers/amqpdriver.py", line 298, in wait

2015-01-13 03:05:49.350 4106 TRACE nova.servicegroup.drivers.db reply, ending, trylock = self.pollqueue(msg_id, timeout)

2015-01-13 03:05:49.350 4106 TRACE nova.servicegroup.drivers.db File "/usr/lib/python2.7/site-packages/oslo/messaging/drivers/amqpdriver.py", line 238, in _pollqueue

2015-01-13 03:05:49.350 4106 TRACE nova.servicegroup.drivers.db message = self.waiters.get(msg_id, timeout)

2015-01-13 03:05:49.350 4106 TRACE nova.servicegroup.drivers.db File "/usr/lib/python2.7/site-packages/oslo/messaging/_drivers/amqpdriver.py", line 144, in get

2015-01-13 03:05:49.350 4106 TRACE nova.servicegroup.drivers.db 'to message ID %s' % msg_id)

2015-01-13 03:05:49.350 4106 TRACE nova.servicegroup.drivers.db MessagingTimeout: Timed out waiting for a reply to message ID d796b2673b6749aab3e52782f4769295

2015-01-13 03:05:49.350 4106 TRACE nova.servicegroup.drivers.db

2015-01-13 03:05:50.482 4106 WARNING nova.openstack.common.loopingcall [-] task <bound method="" dbdriver._report_state="" of="" <nova.servicegroup.drivers.db.dbdriver="" object="" at="" 0x2113f10="">> run outlasted interval by 72.43 sec

2015-01-13 03:06:20.199 4106 WARNING oslo.messaging.drivers.amqpdriver [-] No calling threads waiting for msgid : 260aa95be9204f0d82838860aadc4add, message : {u'uniqueid': u'f0e4c4ed54f645fda153b6b27f70179d', u'failure': None, u'result': {u'novaobject.version': u'1.9', u'novaobject.name': u'InstanceList', u'novaobject.namespace': u'nova', u'novaobject.data': {u'objects': []}}}

2015-01-13 03:06:20.382 4106 WARNING oslo.messaging._drivers.amqpdriver [-] _queues: {'5110762a4d8649eab0d069ae4f7a5aaa': <queue at="" 0x33e3b50="" maxsize="None">, '80e5bfe3559e47a6af79d2ac32797958': <queue at="" 0x33e4910="" maxsize="None">}

2015-01-13 03:06:20.394 4106 WARNING oslo.messaging.drivers.amqpdriver [-] No calling threads waiting for msgid : 260aa95be9204f0d82838860aadc4add, message : {u'uniqueid': u'3205fd4d91cd43d6a0dea016f836381a', u'failure': None, u'result': None, u'ending': True}

2015-01-13 03:06:20.394 4106 WARNING oslo.messaging._drivers.amqpdriver [-] _queues: {'5110762a4d8649eab0d069ae4f7a5aaa': <queue at="" 0x33e3b50="" maxsize="None">, '80e5bfe3559e47a6af79d2ac32797958': <queue at="" 0x33e4910="" maxsize="None">}

2015-01-13 03:06:20.395 4106 WARNING oslo.messaging.drivers.amqpdriver [-] No calling threads waiting for msgid : d796b2673b6749aab3e52782f4769295, message : {u'uniqueid': u'14c8ea977da14785b187e75d45f89243', u'failure': None, u'result': {u'binary': u'nova-compute', u'deleted': 0, u'createdat': u'2015-01-05T06:48:25.000000', u'updatedat': u'2015-01-13T08:05:46.287451', u'reportcount': 66501, u'topic': u'compute', u'host': u'localhost.localdomain', u'disabled': False, u'deletedat': None, u'disabled_reason': u'None', u'id': 4}}

2015-01-13 03:06:20.395 4106 WARNING oslo.messaging._drivers.amqpdriver [-] _queues: {'5110762a4d8649eab0d069ae4f7a5aaa': <queue at="" 0x33e3b50="" maxsize="None">, '80e5bfe3559e47a6af79d2ac32797958': <queue at="" 0x33e4910="" maxsize="None">}

2015-01-13 03:06:20.395 4106 WARNING oslo.messaging.drivers.amqpdriver [-] No calling threads waiting for msgid : d796b2673b6749aab3e52782f4769295, message : {u'uniqueid': u'8c11fd194e2b4afa83973b688d499ba4', u'failure': None, u'result': None, u'ending': True}

2015-01-13 03:06:20.395 4106 WARNING oslo.messaging._drivers.amqpdriver [-] _queues: {'5110762a4d8649eab0d069ae4f7a5aaa': <queue at="" 0x33e3b50="" maxsize="None">, '80e5bfe3559e47a6af79d2ac32797958': <queue at="" 0x33e4910="" maxsize="None">}

2015-01-13 03:06:22.609 4106 ERROR nova.servicegroup.drivers.db [-] Recovered model server connection!

2015-01-13 03:06:22.609 4106 WARNING nova.openstack.common.loopingcall [-] task <bound method="" dbdriver._report_state="" of="" <nova.servicegroup.drivers.db.dbdriver="" object="" at="" 0x2113f10="">> run outlasted interval by 22.13 sec

2015-01-13 03:06:26.384 4106 AUDIT nova.compute.resource_tracker [-] Auditing locally available compute resources

2015-01-13 03:06:34.756 4106 AUDIT nova.compute.resource_tracker [-] Total physical ram (MB): 1841, total allocated virtual ram (MB): 1024

2015-01-13 03:06:34.758 4106 AUDIT nova.compute.resource_tracker [-] Free disk (GB): 25

2015-01-13 03:06:34.758 4106 AUDIT nova.compute.resource_tracker [-] Total usable vcpus: 1, total allocated vcpus: 0

2015-01-13 03:06:34.758 4106 AUDIT nova.compute.resource_tracker [-] PCI stats: []

2015-01-13 03:06:34.760 4106 INFO nova.compute.resourcetracker [-] Computeservice record updated for localhost.localdomain:localhost.localdomain

2015-01-13 03:06:39.346 4106 ERROR nova.compute.manager [-] [instance: 5d2580c2-5f29-4a46-a7b3-d757ffd48de7] Instance failed to spawn

2015-01-13 03:06:39.346 4106 TRACE nova.compute.manager [instance: 5d2580c2-5f29-4a46-a7b3-d757ffd48de7] Traceback (most recent call last):

2015-01-13 03:06:39.346 4106 TRACE nova.compute.manager [instance: 5d2580c2-5f29-4a46-a7b3-d757ffd48de7] File "/usr/lib/python2.7/site-packages/nova/compute/manager.py", line 2243, in buildresources

2015-01-13 03:06:39.346 4106 TRACE nova.compute.manager [instance: 5d2580c2-5f29-4a46-a7b3-d757ffd48de7] yield resources

2015-01-13 03:06:39.346 4106 TRACE nova.compute.manager [instance: 5d2580c2-5f29-4a46-a7b3-d757ffd48de7] File "/usr/lib/python2.7/site-packages/nova/compute/manager.py", line 2113, in buildandruninstance

2015-01-13 03:06:39.346 4106 TRACE nova.compute.manager [instance: 5d2580c2-5f29-4a46-a7b3-d757ffd48de7] blockdeviceinfo=blockdeviceinfo)

2015-01-13 03:06:39.346 4106 TRACE nova.compute.manager [instance: 5d2580c2-5f29-4a46-a7b3-d757ffd48de7] File "/usr/lib/python2.7/site-packages/nova/virt/libvirt/driver.py", line 2619, in spawn

2015-01-13 03:06:39.346 4106 TRACE nova.compute.manager [instance: 5d2580c2-5f29-4a46-a7b3-d757ffd48de7] writetodisk=True)

2015-01-13 03:06:39.346 4106 TRACE nova.compute.manager [instance: 5d2580c2-5f29-4a46-a7b3-d757ffd48de7] File "/usr/lib/python2.7/site-packages/nova/virt/libvirt/driver.py", line 4150, in getguest_xml

2015-01-13 03:06:39.346 4106 TRACE nova.compute.manager [instance: 5d2580c2-5f29-4a46-a7b3-d757ffd48de7] context)

2015-01-13 03:06:39.346 4106 TRACE nova.compute.manager [instance: 5d2580c2-5f29-4a46-a7b3-d757ffd48de7] File "/usr/lib/python2.7/site-packages/nova/virt/libvirt/driver.py", line 3936, in getguest_config

2015-01-13 03:06:39.346 4106 TRACE nova.compute.manager [instance: 5d2580c2-5f29-4a46-a7b3-d757ffd48de7] flavor, CONF.libvirt.virt_type)

2015-01-13 03:06:39.346 4106 TRACE nova.compute.manager [instance: 5d2580c2-5f29-4a46-a7b3-d757ffd48de7] File "/usr/lib/python2.7/site-packages/nova/virt/libvirt/vif.py", line 352, in get_config

2015-01-13 03:06:39.346 4106 TRACE nova.compute.manager [instance: 5d2580c2-5f29-4a46-a7b3-d757ffd48de7] ("Unexpected viftype=%s") % vif_type)

2015-01-13 03:06:39.346 4106 TRACE nova.compute.manager [instance: 5d2580c2-5f29-4a46-a7b3-d757ffd48de7] NovaException: Unexpected viftype=bindingfailed

2015-01-13 03:06:39.346 4106 TRACE nova.compute.manager [instance: 5d2580c2-5f29-4a46-a7b3-d757ffd48de7]

2015-01-13 03:06:39.675 4106 AUDIT nova.compute.manager [req-e458f80c-f53b-40b6-88ee-1ecfa8be66c8 None] [instance: 5d2580c2-5f29-4a46-a7b3-d757ffd48de7] Terminating instance

2015-01-13 03:06:41.897 4106 WARNING nova.virt.libvirt.driver [-] [instance: 5d2580c2-5f29-4a46-a7b3-d757ffd48de7] During wait destroy, instance disappeared.

2015-01-13 03:06:46.006 4106 INFO nova.virt.libvirt.driver [-] [instance: 5d2580c2-5f29-4a46-a7b3-d757ffd48de7] Deleting instance files /var/lib/nova/instances/5d2580c2-5f29-4a46-a7b3-d757ffd48de7_del

2015-01-13 03:06:46.043 4106 INFO nova.virt.libvirt.driver [-] [instance: 5d2580c2-5f29-4a46-a7b3-d757ffd48de7] Deletion of /var/lib/nova/instances/5d2580c2-5f29-4a46-a7b3-d757ffd48de7_del complete

2015-01-13 03:06:46.925 4106 INFO nova.scheduler.client.report [-] Compute_service record updated for ('localhost.localdomain', 'localhost.localdomain')

2015-01-13 03:06:48.825 4106 INFO nova.compute.manager [-] [instance: 5d2580c2-5f29-4a46-a7b3-d757ffd48de7] During syncpowerstate the instance has a pending task (spawning). Skip.

I am new to this, so if any other record is needed please let me know.

Thanks!!

Error: Failed to launch instance "test": Please try again later [Error: No valid host was found. ].

Hi

I have two physical machines, One with Devstack deployment and another with Hyper-v. I have deployed Nova using Cloudbase: http://www.cloudbase.it/openstack/openstack-compute-installer/ When I try to spawn an instance named "test" I am getting the error :

Error: Failed to launch instance "test": Please try again later [Error: No valid host was found. ].

I have followed the following steps to create the instance (I would be better if I could explain it with screenshots, but anyway)

1) First I downloaded a mini ISO image of ubuntu.

2) Uploaded the image in openstack as VHD format. It uploaded successfully.

3) Next I clicked on the "Launch" button and it began to create an instance "test" (Flavor selected "m1.tiny")

4) Next on Instance page the task appeared as "Scheduling" and a success message appeared as "Success: Launched instance named "test" ".

5) Next, the task shifted to "Spawing", and after that, it ended in an error, with flashing the above message flashed, message, and the Status is set as "Error".

the log file in /var/log/nova/nova-compute.log contained the following error log:

2015-01-13 02:59:58.758 4106 AUDIT nova.compute.resource_tracker [-] Auditing locally available compute resources

2015-01-13 02:59:59.003 4106 AUDIT nova.compute.resource_tracker [-] Total physical ram (MB): 1841, total allocated virtual ram (MB): 512

2015-01-13 02:59:59.003 4106 AUDIT nova.compute.resource_tracker [-] Free disk (GB): 26

2015-01-13 02:59:59.004 4106 AUDIT nova.compute.resource_tracker [-] Total usable vcpus: 1, total allocated vcpus: 0

2015-01-13 02:59:59.004 4106 AUDIT nova.compute.resource_tracker [-] PCI stats: []

2015-01-13 02:59:59.004 4106 INFO nova.compute.resourcetracker [-] Computeservice record updated for localhost.localdomain:localhost.localdomain

2015-01-13 03:00:15.595 4106 AUDIT nova.compute.manager [req-e458f80c-f53b-40b6-88ee-1ecfa8be66c8 None] [instance: 5d2580c2-5f29-4a46-a7b3-d757ffd48de7] Starting instance...

2015-01-13 03:00:15.789 4106 WARNING nova.compute.resource_tracker [-] [instance: 5d2580c2-5f29-4a46-a7b3-d757ffd48de7] Host field should not be set on the instance until resources have been claimed.

2015-01-13 03:00:15.790 4106 WARNING nova.compute.resource_tracker [-] [instance: 5d2580c2-5f29-4a46-a7b3-d757ffd48de7] Node field should not be set on the instance until resources have been claimed.

2015-01-13 03:00:15.799 4106 AUDIT nova.compute.claims [-] [instance: 5d2580c2-5f29-4a46-a7b3-d757ffd48de7] Attempting claim: memory 512 MB, disk 1 GB

2015-01-13 03:00:15.800 4106 AUDIT nova.compute.claims [-] [instance: 5d2580c2-5f29-4a46-a7b3-d757ffd48de7] Total memory: 1841 MB, used: 512.00 MB

2015-01-13 03:00:15.800 4106 AUDIT nova.compute.claims [-] [instance: 5d2580c2-5f29-4a46-a7b3-d757ffd48de7] memory limit: 2761.50 MB, free: 2249.50 MB

2015-01-13 03:00:15.800 4106 AUDIT nova.compute.claims [-] [instance: 5d2580c2-5f29-4a46-a7b3-d757ffd48de7] Total disk: 26 GB, used: 0.00 GB

2015-01-13 03:00:15.800 4106 AUDIT nova.compute.claims [-] [instance: 5d2580c2-5f29-4a46-a7b3-d757ffd48de7] disk limit not specified, defaulting to unlimited

2015-01-13 03:00:15.871 4106 AUDIT nova.compute.claims [-] [instance: 5d2580c2-5f29-4a46-a7b3-d757ffd48de7] Claim successful

2015-01-13 03:00:16.371 4106 INFO nova.scheduler.client.report [-] Compute_service record updated for ('localhost.localdomain', 'localhost.localdomain')

2015-01-13 03:00:17.062 4106 INFO nova.virt.libvirt.driver [-] [instance: 5d2580c2-5f29-4a46-a7b3-d757ffd48de7] Creating image

2015-01-13 03:00:34.203 4106 WARNING nova.compute.manager [-] While synchronizing instance power states, found 1 instances in the database and 0 instances on the hypervisor.

2015-01-13 03:01:12.975 4106 WARNING nova.openstack.common.loopingcall [-] task <bound method="" dbdriver._report_state="" of="" <nova.servicegroup.drivers.db.dbdriver="" object="" at="" 0x2113f10="">> run outlasted interval by 19.30 sec

2015-01-13 03:01:24.971 4106 AUDIT nova.compute.resource_tracker [-] Auditing locally available compute resources

2015-01-13 03:02:29.960 4106 WARNING nova.openstack.common.loopingcall [-] task <bound method="" dbdriver._report_state="" of="" <nova.servicegroup.drivers.db.dbdriver="" object="" at="" 0x2113f10="">> run outlasted interval by 56.31 sec

2015-01-13 03:02:31.147 4106 AUDIT nova.compute.resource_tracker [-] Total physical ram (MB): 1841, total allocated virtual ram (MB): 1024

2015-01-13 03:02:31.147 4106 AUDIT nova.compute.resource_tracker [-] Free disk (GB): 25

2015-01-13 03:02:31.147 4106 AUDIT nova.compute.resource_tracker [-] Total usable vcpus: 1, total allocated vcpus: 0

2015-01-13 03:02:31.147 4106 AUDIT nova.compute.resource_tracker [-] PCI stats: []

2015-01-13 03:02:31.281 4106 INFO nova.scheduler.client.report [-] Compute_service record updated for ('localhost.localdomain', 'localhost.localdomain')

2015-01-13 03:02:31.281 4106 INFO nova.compute.resourcetracker [-] Computeservice record updated for localhost.localdomain:localhost.localdomain

2015-01-13 03:03:09.003 4106 WARNING nova.openstack.common.loopingcall [-] task <bound method="" dbdriver._report_state="" of="" <nova.servicegroup.drivers.db.dbdriver="" object="" at="" 0x2113f10="">> run outlasted interval by 18.95 sec

2015-01-13 03:03:21.919 4106 AUDIT nova.compute.resource_tracker [-] Auditing locally available compute resources

2015-01-13 03:03:24.267 4106 AUDIT nova.compute.resource_tracker [-] Total physical ram (MB): 1841, total allocated virtual ram (MB): 1024

2015-01-13 03:03:24.267 4106 AUDIT nova.compute.resource_tracker [-] Free disk (GB): 25

2015-01-13 03:03:24.268 4106 AUDIT nova.compute.resource_tracker [-] Total usable vcpus: 1, total allocated vcpus: 0

2015-01-13 03:03:24.268 4106 AUDIT nova.compute.resource_tracker [-] PCI stats: []

2015-01-13 03:03:24.268 4106 INFO nova.compute.resourcetracker [-] Computeservice record updated for localhost.localdomain:localhost.localdomain

2015-01-13 03:03:57.267 4106 WARNING nova.openstack.common.loopingcall [-] task <bound method="" dbdriver._report_state="" of="" <nova.servicegroup.drivers.db.dbdriver="" object="" at="" 0x2113f10="">> run outlasted interval by 7.31 sec

2015-01-13 03:04:08.665 4106 AUDIT nova.compute.resource_tracker [-] Auditing locally available compute resources

2015-01-13 03:04:12.953 4106 AUDIT nova.compute.resource_tracker [-] Total physical ram (MB): 1841, total allocated virtual ram (MB): 1024

2015-01-13 03:04:12.953 4106 AUDIT nova.compute.resource_tracker [-] Free disk (GB): 25

2015-01-13 03:04:12.954 4106 AUDIT nova.compute.resource_tracker [-] Total usable vcpus: 1, total allocated vcpus: 0

2015-01-13 03:04:12.954 4106 AUDIT nova.compute.resource_tracker [-] PCI stats: []

2015-01-13 03:04:12.955 4106 INFO nova.compute.resourcetracker [-] Computeservice record updated for localhost.localdomain:localhost.localdomain

2015-01-13 03:05:36.646 4106 ERROR nova.openstack.common.periodictask [-] Error during ComputeManager.runpendingdeletes: Timed out waiting for a reply to message ID 260aa95be9204f0d82838860aadc4add

2015-01-13 03:05:36.646 4106 TRACE nova.openstack.common.periodic_task Traceback (most recent call last):

2015-01-13 03:05:36.646 4106 TRACE nova.openstack.common.periodictask File "/usr/lib/python2.7/site-packages/nova/openstack/common/periodictask.py", line 198, in runperiodictasks

2015-01-13 03:05:36.646 4106 TRACE nova.openstack.common.periodic_task task(self, context)

2015-01-13 03:05:36.646 4106 TRACE nova.openstack.common.periodictask File "/usr/lib/python2.7/site-packages/nova/compute/manager.py", line 6228, in _runpending_deletes

2015-01-13 03:05:36.646 4106 TRACE nova.openstack.common.periodictask context, filters, expectedattrs=attrs, use_slave=True)

2015-01-13 03:05:36.646 4106 TRACE nova.openstack.common.periodic_task File "/usr/lib/python2.7/site-packages/nova/objects/base.py", line 153, in wrapper

2015-01-13 03:05:36.646 4106 TRACE nova.openstack.common.periodic_task args, kwargs)

2015-01-13 03:05:36.646 4106 TRACE nova.openstack.common.periodictask File "/usr/lib/python2.7/site-packages/nova/conductor/rpcapi.py", line 346, in objectclass_action

2015-01-13 03:05:36.646 4106 TRACE nova.openstack.common.periodic_task objver=objver, args=args, kwargs=kwargs)

2015-01-13 03:05:36.646 4106 TRACE nova.openstack.common.periodic_task File "/usr/lib/python2.7/site-packages/oslo/messaging/rpc/client.py", line 152, in call

2015-01-13 03:05:36.646 4106 TRACE nova.openstack.common.periodic_task retry=self.retry)

2015-01-13 03:05:36.646 4106 TRACE nova.openstack.common.periodic_task File "/usr/lib/python2.7/site-packages/oslo/messaging/transport.py", line 90, in _send

2015-01-13 03:05:36.646 4106 TRACE nova.openstack.common.periodic_task timeout=timeout, retry=retry)

2015-01-13 03:05:36.646 4106 TRACE nova.openstack.common.periodictask File "/usr/lib/python2.7/site-packages/oslo/messaging/drivers/amqpdriver.py", line 408, in send

2015-01-13 03:05:36.646 4106 TRACE nova.openstack.common.periodic_task retry=retry)

2015-01-13 03:05:36.646 4106 TRACE nova.openstack.common.periodictask File "/usr/lib/python2.7/site-packages/oslo/messaging/drivers/amqpdriver.py", line 397, in _send

2015-01-13 03:05:36.646 4106 TRACE nova.openstack.common.periodictask result = self.waiter.wait(msg_id, timeout)

2015-01-13 03:05:36.646 4106 TRACE nova.openstack.common.periodictask File "/usr/lib/python2.7/site-packages/oslo/messaging/drivers/amqpdriver.py", line 285, in wait

2015-01-13 03:05:36.646 4106 TRACE nova.openstack.common.periodictask reply, ending = self.pollconnection(msgid, timeout)

2015-01-13 03:05:36.646 4106 TRACE nova.openstack.common.periodictask File "/usr/lib/python2.7/site-packages/oslo/messaging/drivers/amqpdriver.py", line 235, in pollconnection

2015-01-13 03:05:36.646 4106 TRACE nova.openstack.common.periodictask % msgid)

2015-01-13 03:05:36.646 4106 TRACE nova.openstack.common.periodic_task MessagingTimeout: Timed out waiting for a reply to message ID 260aa95be9204f0d82838860aadc4add

2015-01-13 03:05:36.646 4106 TRACE nova.openstack.common.periodic_task

2015-01-13 03:05:49.350 4106 ERROR nova.servicegroup.drivers.db [-] model server went away

2015-01-13 03:05:49.350 4106 TRACE nova.servicegroup.drivers.db Traceback (most recent call last):

2015-01-13 03:05:49.350 4106 TRACE nova.servicegroup.drivers.db File "/usr/lib/python2.7/site-packages/nova/servicegroup/drivers/db.py", line 99, in reportstate

2015-01-13 03:05:49.350 4106 TRACE nova.servicegroup.drivers.db service.serviceref, statecatalog)

2015-01-13 03:05:49.350 4106 TRACE nova.servicegroup.drivers.db File "/usr/lib/python2.7/site-packages/nova/conductor/api.py", line 180, in service_update

2015-01-13 03:05:49.350 4106 TRACE nova.servicegroup.drivers.db return self.manager.serviceupdate(context, service, values)

2015-01-13 03:05:49.350 4106 TRACE nova.servicegroup.drivers.db File "/usr/lib/python2.7/site-packages/nova/conductor/rpcapi.py", line 286, in service_update

2015-01-13 03:05:49.350 4106 TRACE nova.servicegroup.drivers.db service=service_p, values=values)

2015-01-13 03:05:49.350 4106 TRACE nova.servicegroup.drivers.db File "/usr/lib/python2.7/site-packages/oslo/messaging/rpc/client.py", line 152, in call

2015-01-13 03:05:49.350 4106 TRACE nova.servicegroup.drivers.db retry=self.retry)

2015-01-13 03:05:49.350 4106 TRACE nova.servicegroup.drivers.db File "/usr/lib/python2.7/site-packages/oslo/messaging/transport.py", line 90, in _send

2015-01-13 03:05:49.350 4106 TRACE nova.servicegroup.drivers.db timeout=timeout, retry=retry)

2015-01-13 03:05:49.350 4106 TRACE nova.servicegroup.drivers.db File "/usr/lib/python2.7/site-packages/oslo/messaging/_drivers/amqpdriver.py", line 408, in send

2015-01-13 03:05:49.350 4106 TRACE nova.servicegroup.drivers.db retry=retry)

2015-01-13 03:05:49.350 4106 TRACE nova.servicegroup.drivers.db File "/usr/lib/python2.7/site-packages/oslo/messaging/_drivers/amqpdriver.py", line 397, in _send

2015-01-13 03:05:49.350 4106 TRACE nova.servicegroup.drivers.db result = self.waiter.wait(msgid, timeout)

2015-01-13 03:05:49.350 4106 TRACE nova.servicegroup.drivers.db File "/usr/lib/python2.7/site-packages/oslo/messaging/_drivers/amqpdriver.py", line 298, in wait

2015-01-13 03:05:49.350 4106 TRACE nova.servicegroup.drivers.db reply, ending, trylock = self.pollqueue(msg_id, timeout)

2015-01-13 03:05:49.350 4106 TRACE nova.servicegroup.drivers.db File "/usr/lib/python2.7/site-packages/oslo/messaging/drivers/amqpdriver.py", line 238, in _pollqueue

2015-01-13 03:05:49.350 4106 TRACE nova.servicegroup.drivers.db message = self.waiters.get(msg_id, timeout)

2015-01-13 03:05:49.350 4106 TRACE nova.servicegroup.drivers.db File "/usr/lib/python2.7/site-packages/oslo/messaging/_drivers/amqpdriver.py", line 144, in get

2015-01-13 03:05:49.350 4106 TRACE nova.servicegroup.drivers.db 'to message ID %s' % msg_id)

2015-01-13 03:05:49.350 4106 TRACE nova.servicegroup.drivers.db MessagingTimeout: Timed out waiting for a reply to message ID d796b2673b6749aab3e52782f4769295

2015-01-13 03:05:49.350 4106 TRACE nova.servicegroup.drivers.db

2015-01-13 03:05:50.482 4106 WARNING nova.openstack.common.loopingcall [-] task <bound method="" dbdriver._report_state="" of="" <nova.servicegroup.drivers.db.dbdriver="" object="" at="" 0x2113f10="">> run outlasted interval by 72.43 sec

2015-01-13 03:06:20.199 4106 WARNING oslo.messaging.drivers.amqpdriver [-] No calling threads waiting for msgid : 260aa95be9204f0d82838860aadc4add, message : {u'uniqueid': u'f0e4c4ed54f645fda153b6b27f70179d', u'failure': None, u'result': {u'novaobject.version': u'1.9', u'novaobject.name': u'InstanceList', u'novaobject.namespace': u'nova', u'novaobject.data': {u'objects': []}}}

2015-01-13 03:06:20.382 4106 WARNING oslo.messaging._drivers.amqpdriver [-] _queues: {'5110762a4d8649eab0d069ae4f7a5aaa': <queue at="" 0x33e3b50="" maxsize="None">, '80e5bfe3559e47a6af79d2ac32797958': <queue at="" 0x33e4910="" maxsize="None">}

2015-01-13 03:06:20.394 4106 WARNING oslo.messaging.drivers.amqpdriver [-] No calling threads waiting for msgid : 260aa95be9204f0d82838860aadc4add, message : {u'uniqueid': u'3205fd4d91cd43d6a0dea016f836381a', u'failure': None, u'result': None, u'ending': True}

2015-01-13 03:06:20.394 4106 WARNING oslo.messaging._drivers.amqpdriver [-] _queues: {'5110762a4d8649eab0d069ae4f7a5aaa': <queue at="" 0x33e3b50="" maxsize="None">, '80e5bfe3559e47a6af79d2ac32797958': <queue at="" 0x33e4910="" maxsize="None">}

2015-01-13 03:06:20.395 4106 WARNING oslo.messaging.drivers.amqpdriver [-] No calling threads waiting for msgid : d796b2673b6749aab3e52782f4769295, message : {u'uniqueid': u'14c8ea977da14785b187e75d45f89243', u'failure': None, u'result': {u'binary': u'nova-compute', u'deleted': 0, u'createdat': u'2015-01-05T06:48:25.000000', u'updatedat': u'2015-01-13T08:05:46.287451', u'reportcount': 66501, u'topic': u'compute', u'host': u'localhost.localdomain', u'disabled': False, u'deletedat': None, u'disabled_reason': u'None', u'id': 4}}

2015-01-13 03:06:20.395 4106 WARNING oslo.messaging._drivers.amqpdriver [-] _queues: {'5110762a4d8649eab0d069ae4f7a5aaa': <queue at="" 0x33e3b50="" maxsize="None">, '80e5bfe3559e47a6af79d2ac32797958': <queue at="" 0x33e4910="" maxsize="None">}

2015-01-13 03:06:20.395 4106 WARNING oslo.messaging.drivers.amqpdriver [-] No calling threads waiting for msgid : d796b2673b6749aab3e52782f4769295, message : {u'uniqueid': u'8c11fd194e2b4afa83973b688d499ba4', u'failure': None, u'result': None, u'ending': True}

2015-01-13 03:06:20.395 4106 WARNING oslo.messaging._drivers.amqpdriver [-] _queues: {'5110762a4d8649eab0d069ae4f7a5aaa': <queue at="" 0x33e3b50="" maxsize="None">, '80e5bfe3559e47a6af79d2ac32797958': <queue at="" 0x33e4910="" maxsize="None">}

2015-01-13 03:06:22.609 4106 ERROR nova.servicegroup.drivers.db [-] Recovered model server connection!

2015-01-13 03:06:22.609 4106 WARNING nova.openstack.common.loopingcall [-] task <bound method="" dbdriver._report_state="" of="" <nova.servicegroup.drivers.db.dbdriver="" object="" at="" 0x2113f10="">> run outlasted interval by 22.13 sec

2015-01-13 03:06:26.384 4106 AUDIT nova.compute.resource_tracker [-] Auditing locally available compute resources

2015-01-13 03:06:34.756 4106 AUDIT nova.compute.resource_tracker [-] Total physical ram (MB): 1841, total allocated virtual ram (MB): 1024

2015-01-13 03:06:34.758 4106 AUDIT nova.compute.resource_tracker [-] Free disk (GB): 25

2015-01-13 03:06:34.758 4106 AUDIT nova.compute.resource_tracker [-] Total usable vcpus: 1, total allocated vcpus: 0

2015-01-13 03:06:34.758 4106 AUDIT nova.compute.resource_tracker [-] PCI stats: []

2015-01-13 03:06:34.760 4106 INFO nova.compute.resourcetracker [-] Computeservice record updated for localhost.localdomain:localhost.localdomain

2015-01-13 03:06:39.346 4106 ERROR nova.compute.manager [-] [instance: 5d2580c2-5f29-4a46-a7b3-d757ffd48de7] Instance failed to spawn

2015-01-13 03:06:39.346 4106 TRACE nova.compute.manager [instance: 5d2580c2-5f29-4a46-a7b3-d757ffd48de7] Traceback (most recent call last):

2015-01-13 03:06:39.346 4106 TRACE nova.compute.manager [instance: 5d2580c2-5f29-4a46-a7b3-d757ffd48de7] File "/usr/lib/python2.7/site-packages/nova/compute/manager.py", line 2243, in buildresources

2015-01-13 03:06:39.346 4106 TRACE nova.compute.manager [instance: 5d2580c2-5f29-4a46-a7b3-d757ffd48de7] yield resources

2015-01-13 03:06:39.346 4106 TRACE nova.compute.manager [instance: 5d2580c2-5f29-4a46-a7b3-d757ffd48de7] File "/usr/lib/python2.7/site-packages/nova/compute/manager.py", line 2113, in buildandruninstance

2015-01-13 03:06:39.346 4106 TRACE nova.compute.manager [instance: 5d2580c2-5f29-4a46-a7b3-d757ffd48de7] blockdeviceinfo=blockdeviceinfo)

2015-01-13 03:06:39.346 4106 TRACE nova.compute.manager [instance: 5d2580c2-5f29-4a46-a7b3-d757ffd48de7] File "/usr/lib/python2.7/site-packages/nova/virt/libvirt/driver.py", line 2619, in spawn

2015-01-13 03:06:39.346 4106 TRACE nova.compute.manager [instance: 5d2580c2-5f29-4a46-a7b3-d757ffd48de7] writetodisk=True)

2015-01-13 03:06:39.346 4106 TRACE nova.compute.manager [instance: 5d2580c2-5f29-4a46-a7b3-d757ffd48de7] File "/usr/lib/python2.7/site-packages/nova/virt/libvirt/driver.py", line 4150, in getguest_xml

2015-01-13 03:06:39.346 4106 TRACE nova.compute.manager [instance: 5d2580c2-5f29-4a46-a7b3-d757ffd48de7] context)

2015-01-13 03:06:39.346 4106 TRACE nova.compute.manager [instance: 5d2580c2-5f29-4a46-a7b3-d757ffd48de7] File "/usr/lib/python2.7/site-packages/nova/virt/libvirt/driver.py", line 3936, in getguest_config

2015-01-13 03:06:39.346 4106 TRACE nova.compute.manager [instance: 5d2580c2-5f29-4a46-a7b3-d757ffd48de7] flavor, CONF.libvirt.virt_type)

2015-01-13 03:06:39.346 4106 TRACE nova.compute.manager [instance: 5d2580c2-5f29-4a46-a7b3-d757ffd48de7] File "/usr/lib/python2.7/site-packages/nova/virt/libvirt/vif.py", line 352, in get_config

2015-01-13 03:06:39.346 4106 TRACE nova.compute.manager [instance: 5d2580c2-5f29-4a46-a7b3-d757ffd48de7] ("Unexpected viftype=%s") % vif_type)

2015-01-13 03:06:39.346 4106 TRACE nova.compute.manager [instance: 5d2580c2-5f29-4a46-a7b3-d757ffd48de7] NovaException: Unexpected viftype=bindingfailed

2015-01-13 03:06:39.346 4106 TRACE nova.compute.manager [instance: 5d2580c2-5f29-4a46-a7b3-d757ffd48de7]

2015-01-13 03:06:39.675 4106 AUDIT nova.compute.manager [req-e458f80c-f53b-40b6-88ee-1ecfa8be66c8 None] [instance: 5d2580c2-5f29-4a46-a7b3-d757ffd48de7] Terminating instance

2015-01-13 03:06:41.897 4106 WARNING nova.virt.libvirt.driver [-] [instance: 5d2580c2-5f29-4a46-a7b3-d757ffd48de7] During wait destroy, instance disappeared.

2015-01-13 03:06:46.006 4106 INFO nova.virt.libvirt.driver [-] [instance: 5d2580c2-5f29-4a46-a7b3-d757ffd48de7] Deleting instance files /var/lib/nova/instances/5d2580c2-5f29-4a46-a7b3-d757ffd48de7_del

2015-01-13 03:06:46.043 4106 INFO nova.virt.libvirt.driver [-] [instance: 5d2580c2-5f29-4a46-a7b3-d757ffd48de7] Deletion of /var/lib/nova/instances/5d2580c2-5f29-4a46-a7b3-d757ffd48de7_del complete

2015-01-13 03:06:46.925 4106 INFO nova.scheduler.client.report [-] Compute_service record updated for ('localhost.localdomain', 'localhost.localdomain')

2015-01-13 03:06:48.825 4106 INFO nova.compute.manager [-] [instance: 5d2580c2-5f29-4a46-a7b3-d757ffd48de7] During syncpowerstate the instance has a pending task (spawning). Skip.

I am new to this, so if any other record is needed please let me know.

Thanks!!

Error: Failed to launch instance "test": Please try again later [Error: No valid host was found. ].

Hi

I have two physical machines, One with Devstack deployment and another with Hyper-v. I have deployed Nova using Cloudbase: http://www.cloudbase.it/openstack/openstack-compute-installer/ When I try to spawn an instance named "test" I am getting the error :

Error: Failed to launch instance "test": Please try again later [Error: No valid host was found. ].

I have followed the following steps to create the instance (I would be better if I could explain it with screenshots, but anyway)

1) First I downloaded a mini ISO image of ubuntu.

2) Uploaded the image in openstack as VHD format. It uploaded successfully.

3) Next I clicked on the "Launch" button and it began to create an instance "test" (Flavor selected "m1.tiny")

4) Next on Instance page the task appeared as "Scheduling" and a success message appeared as "Success: Launched instance named "test" ".

5) Next, the task shifted to "Spawing", and after that, it ended in an error, flashing the above message, and the Status is set as "Error".

the log file in /var/log/nova/nova-compute.log contained the following error log:

2015-01-13 02:59:58.758 4106 AUDIT nova.compute.resource_tracker [-] Auditing locally available compute resources

2015-01-13 02:59:59.003 4106 AUDIT nova.compute.resource_tracker [-] Total physical ram (MB): 1841, total allocated virtual ram (MB): 512

2015-01-13 02:59:59.003 4106 AUDIT nova.compute.resource_tracker [-] Free disk (GB): 26

2015-01-13 02:59:59.004 4106 AUDIT nova.compute.resource_tracker [-] Total usable vcpus: 1, total allocated vcpus: 0

2015-01-13 02:59:59.004 4106 AUDIT nova.compute.resource_tracker [-] PCI stats: []

2015-01-13 02:59:59.004 4106 INFO nova.compute.resourcetracker [-] Computeservice record updated for localhost.localdomain:localhost.localdomain

2015-01-13 03:00:15.595 4106 AUDIT nova.compute.manager [req-e458f80c-f53b-40b6-88ee-1ecfa8be66c8 None] [instance: 5d2580c2-5f29-4a46-a7b3-d757ffd48de7] Starting instance...

2015-01-13 03:00:15.789 4106 WARNING nova.compute.resource_tracker [-] [instance: 5d2580c2-5f29-4a46-a7b3-d757ffd48de7] Host field should not be set on the instance until resources have been claimed.

2015-01-13 03:00:15.790 4106 WARNING nova.compute.resource_tracker [-] [instance: 5d2580c2-5f29-4a46-a7b3-d757ffd48de7] Node field should not be set on the instance until resources have been claimed.

2015-01-13 03:00:15.799 4106 AUDIT nova.compute.claims [-] [instance: 5d2580c2-5f29-4a46-a7b3-d757ffd48de7] Attempting claim: memory 512 MB, disk 1 GB

2015-01-13 03:00:15.800 4106 AUDIT nova.compute.claims [-] [instance: 5d2580c2-5f29-4a46-a7b3-d757ffd48de7] Total memory: 1841 MB, used: 512.00 MB

2015-01-13 03:00:15.800 4106 AUDIT nova.compute.claims [-] [instance: 5d2580c2-5f29-4a46-a7b3-d757ffd48de7] memory limit: 2761.50 MB, free: 2249.50 MB

2015-01-13 03:00:15.800 4106 AUDIT nova.compute.claims [-] [instance: 5d2580c2-5f29-4a46-a7b3-d757ffd48de7] Total disk: 26 GB, used: 0.00 GB

2015-01-13 03:00:15.800 4106 AUDIT nova.compute.claims [-] [instance: 5d2580c2-5f29-4a46-a7b3-d757ffd48de7] disk limit not specified, defaulting to unlimited

2015-01-13 03:00:15.871 4106 AUDIT nova.compute.claims [-] [instance: 5d2580c2-5f29-4a46-a7b3-d757ffd48de7] Claim successful

2015-01-13 03:00:16.371 4106 INFO nova.scheduler.client.report [-] Compute_service record updated for ('localhost.localdomain', 'localhost.localdomain')

2015-01-13 03:00:17.062 4106 INFO nova.virt.libvirt.driver [-] [instance: 5d2580c2-5f29-4a46-a7b3-d757ffd48de7] Creating image

2015-01-13 03:00:34.203 4106 WARNING nova.compute.manager [-] While synchronizing instance power states, found 1 instances in the database and 0 instances on the hypervisor.

2015-01-13 03:01:12.975 4106 WARNING nova.openstack.common.loopingcall [-] task <bound method="" dbdriver._report_state="" of="" <nova.servicegroup.drivers.db.dbdriver="" object="" at="" 0x2113f10="">> run outlasted interval by 19.30 sec

2015-01-13 03:01:24.971 4106 AUDIT nova.compute.resource_tracker [-] Auditing locally available compute resources

2015-01-13 03:02:29.960 4106 WARNING nova.openstack.common.loopingcall [-] task <bound method="" dbdriver._report_state="" of="" <nova.servicegroup.drivers.db.dbdriver="" object="" at="" 0x2113f10="">> run outlasted interval by 56.31 sec

2015-01-13 03:02:31.147 4106 AUDIT nova.compute.resource_tracker [-] Total physical ram (MB): 1841, total allocated virtual ram (MB): 1024

2015-01-13 03:02:31.147 4106 AUDIT nova.compute.resource_tracker [-] Free disk (GB): 25

2015-01-13 03:02:31.147 4106 AUDIT nova.compute.resource_tracker [-] Total usable vcpus: 1, total allocated vcpus: 0

2015-01-13 03:02:31.147 4106 AUDIT nova.compute.resource_tracker [-] PCI stats: []

2015-01-13 03:02:31.281 4106 INFO nova.scheduler.client.report [-] Compute_service record updated for ('localhost.localdomain', 'localhost.localdomain')

2015-01-13 03:02:31.281 4106 INFO nova.compute.resourcetracker [-] Computeservice record updated for localhost.localdomain:localhost.localdomain

2015-01-13 03:03:09.003 4106 WARNING nova.openstack.common.loopingcall [-] task <bound method="" dbdriver._report_state="" of="" <nova.servicegroup.drivers.db.dbdriver="" object="" at="" 0x2113f10="">> run outlasted interval by 18.95 sec

2015-01-13 03:03:21.919 4106 AUDIT nova.compute.resource_tracker [-] Auditing locally available compute resources

2015-01-13 03:03:24.267 4106 AUDIT nova.compute.resource_tracker [-] Total physical ram (MB): 1841, total allocated virtual ram (MB): 1024

2015-01-13 03:03:24.267 4106 AUDIT nova.compute.resource_tracker [-] Free disk (GB): 25

2015-01-13 03:03:24.268 4106 AUDIT nova.compute.resource_tracker [-] Total usable vcpus: 1, total allocated vcpus: 0

2015-01-13 03:03:24.268 4106 AUDIT nova.compute.resource_tracker [-] PCI stats: []

2015-01-13 03:03:24.268 4106 INFO nova.compute.resourcetracker [-] Computeservice record updated for localhost.localdomain:localhost.localdomain

2015-01-13 03:03:57.267 4106 WARNING nova.openstack.common.loopingcall [-] task <bound method="" dbdriver._report_state="" of="" <nova.servicegroup.drivers.db.dbdriver="" object="" at="" 0x2113f10="">> run outlasted interval by 7.31 sec

2015-01-13 03:04:08.665 4106 AUDIT nova.compute.resource_tracker [-] Auditing locally available compute resources

2015-01-13 03:04:12.953 4106 AUDIT nova.compute.resource_tracker [-] Total physical ram (MB): 1841, total allocated virtual ram (MB): 1024

2015-01-13 03:04:12.953 4106 AUDIT nova.compute.resource_tracker [-] Free disk (GB): 25

2015-01-13 03:04:12.954 4106 AUDIT nova.compute.resource_tracker [-] Total usable vcpus: 1, total allocated vcpus: 0

2015-01-13 03:04:12.954 4106 AUDIT nova.compute.resource_tracker [-] PCI stats: []

2015-01-13 03:04:12.955 4106 INFO nova.compute.resourcetracker [-] Computeservice record updated for localhost.localdomain:localhost.localdomain

2015-01-13 03:05:36.646 4106 ERROR nova.openstack.common.periodictask [-] Error during ComputeManager.runpendingdeletes: Timed out waiting for a reply to message ID 260aa95be9204f0d82838860aadc4add

2015-01-13 03:05:36.646 4106 TRACE nova.openstack.common.periodic_task Traceback (most recent call last):

2015-01-13 03:05:36.646 4106 TRACE nova.openstack.common.periodictask File "/usr/lib/python2.7/site-packages/nova/openstack/common/periodictask.py", line 198, in runperiodictasks

2015-01-13 03:05:36.646 4106 TRACE nova.openstack.common.periodic_task task(self, context)

2015-01-13 03:05:36.646 4106 TRACE nova.openstack.common.periodictask File "/usr/lib/python2.7/site-packages/nova/compute/manager.py", line 6228, in _runpending_deletes

2015-01-13 03:05:36.646 4106 TRACE nova.openstack.common.periodictask context, filters, expectedattrs=attrs, use_slave=True)

2015-01-13 03:05:36.646 4106 TRACE nova.openstack.common.periodic_task File "/usr/lib/python2.7/site-packages/nova/objects/base.py", line 153, in wrapper

2015-01-13 03:05:36.646 4106 TRACE nova.openstack.common.periodic_task args, kwargs)

2015-01-13 03:05:36.646 4106 TRACE nova.openstack.common.periodictask File "/usr/lib/python2.7/site-packages/nova/conductor/rpcapi.py", line 346, in objectclass_action

2015-01-13 03:05:36.646 4106 TRACE nova.openstack.common.periodic_task objver=objver, args=args, kwargs=kwargs)

2015-01-13 03:05:36.646 4106 TRACE nova.openstack.common.periodic_task File "/usr/lib/python2.7/site-packages/oslo/messaging/rpc/client.py", line 152, in call

2015-01-13 03:05:36.646 4106 TRACE nova.openstack.common.periodic_task retry=self.retry)

2015-01-13 03:05:36.646 4106 TRACE nova.openstack.common.periodic_task File "/usr/lib/python2.7/site-packages/oslo/messaging/transport.py", line 90, in _send

2015-01-13 03:05:36.646 4106 TRACE nova.openstack.common.periodic_task timeout=timeout, retry=retry)

2015-01-13 03:05:36.646 4106 TRACE nova.openstack.common.periodictask File "/usr/lib/python2.7/site-packages/oslo/messaging/drivers/amqpdriver.py", line 408, in send

2015-01-13 03:05:36.646 4106 TRACE nova.openstack.common.periodic_task retry=retry)

2015-01-13 03:05:36.646 4106 TRACE nova.openstack.common.periodictask File "/usr/lib/python2.7/site-packages/oslo/messaging/drivers/amqpdriver.py", line 397, in _send

2015-01-13 03:05:36.646 4106 TRACE nova.openstack.common.periodictask result = self.waiter.wait(msg_id, timeout)

2015-01-13 03:05:36.646 4106 TRACE nova.openstack.common.periodictask File "/usr/lib/python2.7/site-packages/oslo/messaging/drivers/amqpdriver.py", line 285, in wait

2015-01-13 03:05:36.646 4106 TRACE nova.openstack.common.periodictask reply, ending = self.pollconnection(msgid, timeout)

2015-01-13 03:05:36.646 4106 TRACE nova.openstack.common.periodictask File "/usr/lib/python2.7/site-packages/oslo/messaging/drivers/amqpdriver.py", line 235, in pollconnection

2015-01-13 03:05:36.646 4106 TRACE nova.openstack.common.periodictask % msgid)

2015-01-13 03:05:36.646 4106 TRACE nova.openstack.common.periodic_task MessagingTimeout: Timed out waiting for a reply to message ID 260aa95be9204f0d82838860aadc4add

2015-01-13 03:05:36.646 4106 TRACE nova.openstack.common.periodic_task

2015-01-13 03:05:49.350 4106 ERROR nova.servicegroup.drivers.db [-] model server went away

2015-01-13 03:05:49.350 4106 TRACE nova.servicegroup.drivers.db Traceback (most recent call last):

2015-01-13 03:05:49.350 4106 TRACE nova.servicegroup.drivers.db File "/usr/lib/python2.7/site-packages/nova/servicegroup/drivers/db.py", line 99, in reportstate

2015-01-13 03:05:49.350 4106 TRACE nova.servicegroup.drivers.db service.serviceref, statecatalog)

2015-01-13 03:05:49.350 4106 TRACE nova.servicegroup.drivers.db File "/usr/lib/python2.7/site-packages/nova/conductor/api.py", line 180, in service_update

2015-01-13 03:05:49.350 4106 TRACE nova.servicegroup.drivers.db return self.manager.serviceupdate(context, service, values)

2015-01-13 03:05:49.350 4106 TRACE nova.servicegroup.drivers.db File "/usr/lib/python2.7/site-packages/nova/conductor/rpcapi.py", line 286, in service_update

2015-01-13 03:05:49.350 4106 TRACE nova.servicegroup.drivers.db service=service_p, values=values)

2015-01-13 03:05:49.350 4106 TRACE nova.servicegroup.drivers.db File "/usr/lib/python2.7/site-packages/oslo/messaging/rpc/client.py", line 152, in call

2015-01-13 03:05:49.350 4106 TRACE nova.servicegroup.drivers.db retry=self.retry)

2015-01-13 03:05:49.350 4106 TRACE nova.servicegroup.drivers.db File "/usr/lib/python2.7/site-packages/oslo/messaging/transport.py", line 90, in _send

2015-01-13 03:05:49.350 4106 TRACE nova.servicegroup.drivers.db timeout=timeout, retry=retry)

2015-01-13 03:05:49.350 4106 TRACE nova.servicegroup.drivers.db File "/usr/lib/python2.7/site-packages/oslo/messaging/_drivers/amqpdriver.py", line 408, in send

2015-01-13 03:05:49.350 4106 TRACE nova.servicegroup.drivers.db retry=retry)

2015-01-13 03:05:49.350 4106 TRACE nova.servicegroup.drivers.db File "/usr/lib/python2.7/site-packages/oslo/messaging/_drivers/amqpdriver.py", line 397, in _send

2015-01-13 03:05:49.350 4106 TRACE nova.servicegroup.drivers.db result = self.waiter.wait(msgid, timeout)

2015-01-13 03:05:49.350 4106 TRACE nova.servicegroup.drivers.db File "/usr/lib/python2.7/site-packages/oslo/messaging/_drivers/amqpdriver.py", line 298, in wait

2015-01-13 03:05:49.350 4106 TRACE nova.servicegroup.drivers.db reply, ending, trylock = self.pollqueue(msg_id, timeout)

2015-01-13 03:05:49.350 4106 TRACE nova.servicegroup.drivers.db File "/usr/lib/python2.7/site-packages/oslo/messaging/drivers/amqpdriver.py", line 238, in _pollqueue

2015-01-13 03:05:49.350 4106 TRACE nova.servicegroup.drivers.db message = self.waiters.get(msg_id, timeout)

2015-01-13 03:05:49.350 4106 TRACE nova.servicegroup.drivers.db File "/usr/lib/python2.7/site-packages/oslo/messaging/_drivers/amqpdriver.py", line 144, in get

2015-01-13 03:05:49.350 4106 TRACE nova.servicegroup.drivers.db 'to message ID %s' % msg_id)

2015-01-13 03:05:49.350 4106 TRACE nova.servicegroup.drivers.db MessagingTimeout: Timed out waiting for a reply to message ID d796b2673b6749aab3e52782f4769295

2015-01-13 03:05:49.350 4106 TRACE nova.servicegroup.drivers.db

2015-01-13 03:05:50.482 4106 WARNING nova.openstack.common.loopingcall [-] task <bound method="" dbdriver._report_state="" of="" <nova.servicegroup.drivers.db.dbdriver="" object="" at="" 0x2113f10="">> run outlasted interval by 72.43 sec

2015-01-13 03:06:20.199 4106 WARNING oslo.messaging.drivers.amqpdriver [-] No calling threads waiting for msgid : 260aa95be9204f0d82838860aadc4add, message : {u'uniqueid': u'f0e4c4ed54f645fda153b6b27f70179d', u'failure': None, u'result': {u'novaobject.version': u'1.9', u'novaobject.name': u'InstanceList', u'novaobject.namespace': u'nova', u'novaobject.data': {u'objects': []}}}

2015-01-13 03:06:20.382 4106 WARNING oslo.messaging._drivers.amqpdriver [-] _queues: {'5110762a4d8649eab0d069ae4f7a5aaa': <queue at="" 0x33e3b50="" maxsize="None">, '80e5bfe3559e47a6af79d2ac32797958': <queue at="" 0x33e4910="" maxsize="None">}

2015-01-13 03:06:20.394 4106 WARNING oslo.messaging.drivers.amqpdriver [-] No calling threads waiting for msgid : 260aa95be9204f0d82838860aadc4add, message : {u'uniqueid': u'3205fd4d91cd43d6a0dea016f836381a', u'failure': None, u'result': None, u'ending': True}

2015-01-13 03:06:20.394 4106 WARNING oslo.messaging._drivers.amqpdriver [-] _queues: {'5110762a4d8649eab0d069ae4f7a5aaa': <queue at="" 0x33e3b50="" maxsize="None">, '80e5bfe3559e47a6af79d2ac32797958': <queue at="" 0x33e4910="" maxsize="None">}

2015-01-13 03:06:20.395 4106 WARNING oslo.messaging.drivers.amqpdriver [-] No calling threads waiting for msgid : d796b2673b6749aab3e52782f4769295, message : {u'uniqueid': u'14c8ea977da14785b187e75d45f89243', u'failure': None, u'result': {u'binary': u'nova-compute', u'deleted': 0, u'createdat': u'2015-01-05T06:48:25.000000', u'updatedat': u'2015-01-13T08:05:46.287451', u'reportcount': 66501, u'topic': u'compute', u'host': u'localhost.localdomain', u'disabled': False, u'deletedat': None, u'disabled_reason': u'None', u'id': 4}}

2015-01-13 03:06:20.395 4106 WARNING oslo.messaging._drivers.amqpdriver [-] _queues: {'5110762a4d8649eab0d069ae4f7a5aaa': <queue at="" 0x33e3b50="" maxsize="None">, '80e5bfe3559e47a6af79d2ac32797958': <queue at="" 0x33e4910="" maxsize="None">}

2015-01-13 03:06:20.395 4106 WARNING oslo.messaging.drivers.amqpdriver [-] No calling threads waiting for msgid : d796b2673b6749aab3e52782f4769295, message : {u'uniqueid': u'8c11fd194e2b4afa83973b688d499ba4', u'failure': None, u'result': None, u'ending': True}

2015-01-13 03:06:20.395 4106 WARNING oslo.messaging._drivers.amqpdriver [-] _queues: {'5110762a4d8649eab0d069ae4f7a5aaa': <queue at="" 0x33e3b50="" maxsize="None">, '80e5bfe3559e47a6af79d2ac32797958': <queue at="" 0x33e4910="" maxsize="None">}

2015-01-13 03:06:22.609 4106 ERROR nova.servicegroup.drivers.db [-] Recovered model server connection!

2015-01-13 03:06:22.609 4106 WARNING nova.openstack.common.loopingcall [-] task <bound method="" dbdriver._report_state="" of="" <nova.servicegroup.drivers.db.dbdriver="" object="" at="" 0x2113f10="">> run outlasted interval by 22.13 sec

2015-01-13 03:06:26.384 4106 AUDIT nova.compute.resource_tracker [-] Auditing locally available compute resources

2015-01-13 03:06:34.756 4106 AUDIT nova.compute.resource_tracker [-] Total physical ram (MB): 1841, total allocated virtual ram (MB): 1024

2015-01-13 03:06:34.758 4106 AUDIT nova.compute.resource_tracker [-] Free disk (GB): 25

2015-01-13 03:06:34.758 4106 AUDIT nova.compute.resource_tracker [-] Total usable vcpus: 1, total allocated vcpus: 0

2015-01-13 03:06:34.758 4106 AUDIT nova.compute.resource_tracker [-] PCI stats: []

2015-01-13 03:06:34.760 4106 INFO nova.compute.resourcetracker [-] Computeservice record updated for localhost.localdomain:localhost.localdomain

2015-01-13 03:06:39.346 4106 ERROR nova.compute.manager [-] [instance: 5d2580c2-5f29-4a46-a7b3-d757ffd48de7] Instance failed to spawn

2015-01-13 03:06:39.346 4106 TRACE nova.compute.manager [instance: 5d2580c2-5f29-4a46-a7b3-d757ffd48de7] Traceback (most recent call last):

2015-01-13 03:06:39.346 4106 TRACE nova.compute.manager [instance: 5d2580c2-5f29-4a46-a7b3-d757ffd48de7] File "/usr/lib/python2.7/site-packages/nova/compute/manager.py", line 2243, in buildresources

2015-01-13 03:06:39.346 4106 TRACE nova.compute.manager [instance: 5d2580c2-5f29-4a46-a7b3-d757ffd48de7] yield resources

2015-01-13 03:06:39.346 4106 TRACE nova.compute.manager [instance: 5d2580c2-5f29-4a46-a7b3-d757ffd48de7] File "/usr/lib/python2.7/site-packages/nova/compute/manager.py", line 2113, in buildandruninstance

2015-01-13 03:06:39.346 4106 TRACE nova.compute.manager [instance: 5d2580c2-5f29-4a46-a7b3-d757ffd48de7] blockdeviceinfo=blockdeviceinfo)

2015-01-13 03:06:39.346 4106 TRACE nova.compute.manager [instance: 5d2580c2-5f29-4a46-a7b3-d757ffd48de7] File "/usr/lib/python2.7/site-packages/nova/virt/libvirt/driver.py", line 2619, in spawn

2015-01-13 03:06:39.346 4106 TRACE nova.compute.manager [instance: 5d2580c2-5f29-4a46-a7b3-d757ffd48de7] writetodisk=True)

2015-01-13 03:06:39.346 4106 TRACE nova.compute.manager [instance: 5d2580c2-5f29-4a46-a7b3-d757ffd48de7] File "/usr/lib/python2.7/site-packages/nova/virt/libvirt/driver.py", line 4150, in getguest_xml

2015-01-13 03:06:39.346 4106 TRACE nova.compute.manager [instance: 5d2580c2-5f29-4a46-a7b3-d757ffd48de7] context)

2015-01-13 03:06:39.346 4106 TRACE nova.compute.manager [instance: 5d2580c2-5f29-4a46-a7b3-d757ffd48de7] File "/usr/lib/python2.7/site-packages/nova/virt/libvirt/driver.py", line 3936, in getguest_config

2015-01-13 03:06:39.346 4106 TRACE nova.compute.manager [instance: 5d2580c2-5f29-4a46-a7b3-d757ffd48de7] flavor, CONF.libvirt.virt_type)

2015-01-13 03:06:39.346 4106 TRACE nova.compute.manager [instance: 5d2580c2-5f29-4a46-a7b3-d757ffd48de7] File "/usr/lib/python2.7/site-packages/nova/virt/libvirt/vif.py", line 352, in get_config

2015-01-13 03:06:39.346 4106 TRACE nova.compute.manager [instance: 5d2580c2-5f29-4a46-a7b3-d757ffd48de7] ("Unexpected viftype=%s") % vif_type)

2015-01-13 03:06:39.346 4106 TRACE nova.compute.manager [instance: 5d2580c2-5f29-4a46-a7b3-d757ffd48de7] NovaException: Unexpected viftype=bindingfailed

2015-01-13 03:06:39.346 4106 TRACE nova.compute.manager [instance: 5d2580c2-5f29-4a46-a7b3-d757ffd48de7]

2015-01-13 03:06:39.675 4106 AUDIT nova.compute.manager [req-e458f80c-f53b-40b6-88ee-1ecfa8be66c8 None] [instance: 5d2580c2-5f29-4a46-a7b3-d757ffd48de7] Terminating instance

2015-01-13 03:06:41.897 4106 WARNING nova.virt.libvirt.driver [-] [instance: 5d2580c2-5f29-4a46-a7b3-d757ffd48de7] During wait destroy, instance disappeared.

2015-01-13 03:06:46.006 4106 INFO nova.virt.libvirt.driver [-] [instance: 5d2580c2-5f29-4a46-a7b3-d757ffd48de7] Deleting instance files /var/lib/nova/instances/5d2580c2-5f29-4a46-a7b3-d757ffd48de7_del

2015-01-13 03:06:46.043 4106 INFO nova.virt.libvirt.driver [-] [instance: 5d2580c2-5f29-4a46-a7b3-d757ffd48de7] Deletion of /var/lib/nova/instances/5d2580c2-5f29-4a46-a7b3-d757ffd48de7_del complete

2015-01-13 03:06:46.925 4106 INFO nova.scheduler.client.report [-] Compute_service record updated for ('localhost.localdomain', 'localhost.localdomain')

2015-01-13 03:06:48.825 4106 INFO nova.compute.manager [-] [instance: 5d2580c2-5f29-4a46-a7b3-d757ffd48de7] During syncpowerstate the instance has a pending task (spawning). Skip.

I am new to this, so if any other record is needed please let me know.

Thanks!!