<html>
<head>
<meta http-equiv="Content-Type" content="text/html; charset=us-ascii">
<meta name="Generator" content="Microsoft Exchange Server">
<!-- converted from rtf -->
<style><!-- .EmailQuote { margin-left: 1pt; padding-left: 4pt; border-left: #800000 2px solid; } --></style>
</head>
<body>
<font face="Calibri" size="2"><span style="font-size:11pt;">
<div>Hi,</div>
<div> </div>
<div>My icehouse installation fails to start VMs. I have done the installation according to installation guide but the nova-compute.log shows errors listed below. The result is the same for ubuntu 12.04 and ubuntu 14.04. I use neutron and ML2 plugin with ovs.
There is no difference whether virt_type=kvm or qemu. Havana installation worked fine in the same servers. (I did clean installation for icehouse.) Do you have ideas how to fix this?</div>
<div> </div>
<div>Regards,</div>
<div>Johanna</div>
<div> </div>
<div> </div>
<div>2014-02-03 03:02:53.135 5561 AUDIT nova.compute.manager [req-a18ba4ce-048d-4e64-b3ba-1ae7a02bf25c 222d961af18b46c1a27e254e5717bb5d 4d6cf4028cbc448f8827a43f97233389] [instance: 45048c4b-d3fd-46d8-8259-a3bcf93db783] Starting instance...</div>
<div>2014-02-03 03:02:53.256 5561 AUDIT nova.compute.claims [req-a18ba4ce-048d-4e64-b3ba-1ae7a02bf25c 222d961af18b46c1a27e254e5717bb5d 4d6cf4028cbc448f8827a43f97233389] [instance: 45048c4b-d3fd-46d8-8259-a3bcf93db783] Attempting claim: memory 2048 MB, disk
20 GB, VCPUs 1</div>
<div>2014-02-03 03:02:53.256 5561 AUDIT nova.compute.claims [req-a18ba4ce-048d-4e64-b3ba-1ae7a02bf25c 222d961af18b46c1a27e254e5717bb5d 4d6cf4028cbc448f8827a43f97233389] [instance: 45048c4b-d3fd-46d8-8259-a3bcf93db783] Total memory: 128905 MB, used: 8704.00
MB</div>
<div>2014-02-03 03:02:53.257 5561 AUDIT nova.compute.claims [req-a18ba4ce-048d-4e64-b3ba-1ae7a02bf25c 222d961af18b46c1a27e254e5717bb5d 4d6cf4028cbc448f8827a43f97233389] [instance: 45048c4b-d3fd-46d8-8259-a3bcf93db783] memory limit: 193357.50 MB, free: 184653.50
MB</div>
<div>2014-02-03 03:02:53.257 5561 AUDIT nova.compute.claims [req-a18ba4ce-048d-4e64-b3ba-1ae7a02bf25c 222d961af18b46c1a27e254e5717bb5d 4d6cf4028cbc448f8827a43f97233389] [instance: 45048c4b-d3fd-46d8-8259-a3bcf93db783] Total disk: 802 GB, used: 80.00 GB</div>
<div>2014-02-03 03:02:53.258 5561 AUDIT nova.compute.claims [req-a18ba4ce-048d-4e64-b3ba-1ae7a02bf25c 222d961af18b46c1a27e254e5717bb5d 4d6cf4028cbc448f8827a43f97233389] [instance: 45048c4b-d3fd-46d8-8259-a3bcf93db783] disk limit not specified, defaulting to
unlimited</div>
<div>2014-02-03 03:02:53.258 5561 AUDIT nova.compute.claims [req-a18ba4ce-048d-4e64-b3ba-1ae7a02bf25c 222d961af18b46c1a27e254e5717bb5d 4d6cf4028cbc448f8827a43f97233389] [instance: 45048c4b-d3fd-46d8-8259-a3bcf93db783] Total CPUs: 32 VCPUs, used: 4.00 VCPUs</div>
<div>2014-02-03 03:02:53.259 5561 AUDIT nova.compute.claims [req-a18ba4ce-048d-4e64-b3ba-1ae7a02bf25c 222d961af18b46c1a27e254e5717bb5d 4d6cf4028cbc448f8827a43f97233389] [instance: 45048c4b-d3fd-46d8-8259-a3bcf93db783] CPUs limit not specified, defaulting to
unlimited</div>
<div>2014-02-03 03:02:53.259 5561 AUDIT nova.compute.claims [req-a18ba4ce-048d-4e64-b3ba-1ae7a02bf25c 222d961af18b46c1a27e254e5717bb5d 4d6cf4028cbc448f8827a43f97233389] [instance: 45048c4b-d3fd-46d8-8259-a3bcf93db783] Claim successful</div>
<div>2014-02-03 03:02:54.314 5561 INFO nova.virt.libvirt.driver [req-a18ba4ce-048d-4e64-b3ba-1ae7a02bf25c 222d961af18b46c1a27e254e5717bb5d 4d6cf4028cbc448f8827a43f97233389] [instance: 45048c4b-d3fd-46d8-8259-a3bcf93db783] Creating image</div>
<div>2014-02-03 03:03:07.285 5561 WARNING nova.virt.disk.vfs.guestfs [req-a18ba4ce-048d-4e64-b3ba-1ae7a02bf25c 222d961af18b46c1a27e254e5717bb5d 4d6cf4028cbc448f8827a43f97233389] Failed to close augeas aug_close: do_aug_close: you must call 'aug-init' first
to initialize Augeas</div>
<div>2014-02-03 03:03:25.235 5561 AUDIT nova.compute.resource_tracker [-] Auditing locally available compute resources</div>
<div>2014-02-03 03:03:25.923 5561 AUDIT nova.compute.resource_tracker [-] Free ram (MB): 118153</div>
<div>2014-02-03 03:03:25.924 5561 AUDIT nova.compute.resource_tracker [-] Free disk (GB): 702</div>
<div>2014-02-03 03:03:25.924 5561 AUDIT nova.compute.resource_tracker [-] Free VCPUS: 27</div>
<div>2014-02-03 03:03:25.985 5561 INFO nova.compute.resource_tracker [-] Compute_service record updated for icehouse229:icehouse229</div>
<div>2014-02-03 03:03:26.051 5561 WARNING nova.compute.manager [-] Found 5 in the database and 0 on the hypervisor.</div>
<div>2014-02-03 03:03:26.051 5561 INFO nova.compute.manager [-] [instance: edff8020-2002-4ef0-9370-e1b197b7ed73] During sync_power_state the instance has a pending task. Skip.</div>
<div>2014-02-03 03:03:26.051 5561 INFO nova.compute.manager [-] [instance: 45d96b86-c8cc-43c9-bcda-53fb20ede176] During sync_power_state the instance has a pending task. Skip.</div>
<div>2014-02-03 03:03:26.148 5561 INFO nova.compute.manager [-] [instance: 45048c4b-d3fd-46d8-8259-a3bcf93db783] During sync_power_state the instance has a pending task. Skip.</div>
<div>2014-02-03 03:03:53.782 5561 ERROR nova.compute.manager [-] Instance failed network setup after 1 attempt(s)</div>
<div>2014-02-03 03:03:53.782 5561 TRACE nova.compute.manager Traceback (most recent call last):</div>
<div>2014-02-03 03:03:53.782 5561 TRACE nova.compute.manager File "/usr/lib/python2.7/dist-packages/nova/compute/manager.py", line 1510, in _allocate_network_async</div>
<div>2014-02-03 03:03:53.782 5561 TRACE nova.compute.manager dhcp_options=dhcp_options)</div>
<div>2014-02-03 03:03:53.782 5561 TRACE nova.compute.manager File "/usr/lib/python2.7/dist-packages/nova/network/api.py", line 94, in wrapped</div>
<div>2014-02-03 03:03:53.782 5561 TRACE nova.compute.manager return func(self, context, *args, **kwargs)</div>
<div>2014-02-03 03:03:53.782 5561 TRACE nova.compute.manager File "/usr/lib/python2.7/dist-packages/nova/network/api.py", line 48, in wrapper</div>
<div>2014-02-03 03:03:53.782 5561 TRACE nova.compute.manager res = f(self, context, *args, **kwargs)</div>
<div>2014-02-03 03:03:53.782 5561 TRACE nova.compute.manager File "/usr/lib/python2.7/dist-packages/nova/network/api.py", line 302, in allocate_for_instance</div>
<div>2014-02-03 03:03:53.782 5561 TRACE nova.compute.manager nw_info = self.network_rpcapi.allocate_for_instance(context, **args)</div>
<div>2014-02-03 03:03:53.782 5561 TRACE nova.compute.manager File "/usr/lib/python2.7/dist-packages/nova/network/rpcapi.py", line 170, in allocate_for_instance</div>
<div>2014-02-03 03:03:53.782 5561 TRACE nova.compute.manager macs=jsonutils.to_primitive(macs))</div>
<div>2014-02-03 03:03:53.782 5561 TRACE nova.compute.manager File "/usr/lib/python2.7/dist-packages/oslo/messaging/rpc/client.py", line 150, in call</div>
<div>2014-02-03 03:03:53.782 5561 TRACE nova.compute.manager wait_for_reply=True, timeout=timeout)</div>
<div>2014-02-03 03:03:53.782 5561 TRACE nova.compute.manager File "/usr/lib/python2.7/dist-packages/oslo/messaging/transport.py", line 90, in _send</div>
<div>2014-02-03 03:03:53.782 5561 TRACE nova.compute.manager timeout=timeout)</div>
<div>2014-02-03 03:03:53.782 5561 TRACE nova.compute.manager File "/usr/lib/python2.7/dist-packages/oslo/messaging/_drivers/amqpdriver.py", line 412, in send</div>
<div>2014-02-03 03:03:53.782 5561 TRACE nova.compute.manager return self._send(target, ctxt, message, wait_for_reply, timeout)</div>
<div>2014-02-03 03:03:53.782 5561 TRACE nova.compute.manager File "/usr/lib/python2.7/dist-packages/oslo/messaging/_drivers/amqpdriver.py", line 403, in _send</div>
<div>2014-02-03 03:03:53.782 5561 TRACE nova.compute.manager result = self._waiter.wait(msg_id, timeout)</div>
<div>2014-02-03 03:03:53.782 5561 TRACE nova.compute.manager File "/usr/lib/python2.7/dist-packages/oslo/messaging/_drivers/amqpdriver.py", line 280, in wait</div>
<div>2014-02-03 03:03:53.782 5561 TRACE nova.compute.manager reply, ending, trylock = self._poll_queue(msg_id, timeout)</div>
<div>2014-02-03 03:03:53.782 5561 TRACE nova.compute.manager File "/usr/lib/python2.7/dist-packages/oslo/messaging/_drivers/amqpdriver.py", line 220, in _poll_queue</div>
<div>2014-02-03 03:03:53.782 5561 TRACE nova.compute.manager message = self.waiters.get(msg_id, timeout)</div>
<div>2014-02-03 03:03:53.782 5561 TRACE nova.compute.manager File "/usr/lib/python2.7/dist-packages/oslo/messaging/_drivers/amqpdriver.py", line 126, in get</div>
<div>2014-02-03 03:03:53.782 5561 TRACE nova.compute.manager 'to message ID %s' % msg_id)</div>
<div>2014-02-03 03:03:53.782 5561 TRACE nova.compute.manager MessagingTimeout: Timed out waiting for a reply to message ID 0f47e260dccb4dfd945eb6442108c769</div>
<div>2014-02-03 03:03:53.782 5561 TRACE nova.compute.manager</div>
<div>2014-02-03 03:03:53.786 5561 ERROR nova.compute.manager [req-a18ba4ce-048d-4e64-b3ba-1ae7a02bf25c 222d961af18b46c1a27e254e5717bb5d 4d6cf4028cbc448f8827a43f97233389] [instance: 45048c4b-d3fd-46d8-8259-a3bcf93db783] Instance failed to spawn</div>
<div>2014-02-03 03:03:53.786 5561 TRACE nova.compute.manager [instance: 45048c4b-d3fd-46d8-8259-a3bcf93db783] Traceback (most recent call last):</div>
<div>2014-02-03 03:03:53.786 5561 TRACE nova.compute.manager [instance: 45048c4b-d3fd-46d8-8259-a3bcf93db783] File "/usr/lib/python2.7/dist-packages/nova/compute/manager.py", line 1720, in _spawn</div>
<div>2014-02-03 03:03:53.786 5561 TRACE nova.compute.manager [instance: 45048c4b-d3fd-46d8-8259-a3bcf93db783] block_device_info)</div>
<div>2014-02-03 03:03:53.786 5561 TRACE nova.compute.manager [instance: 45048c4b-d3fd-46d8-8259-a3bcf93db783] File "/usr/lib/python2.7/dist-packages/nova/virt/libvirt/driver.py", line 2250, in spawn</div>
<div>2014-02-03 03:03:53.786 5561 TRACE nova.compute.manager [instance: 45048c4b-d3fd-46d8-8259-a3bcf93db783] write_to_disk=True)</div>
<div>2014-02-03 03:03:53.786 5561 TRACE nova.compute.manager [instance: 45048c4b-d3fd-46d8-8259-a3bcf93db783] File "/usr/lib/python2.7/dist-packages/nova/virt/libvirt/driver.py", line 3420, in to_xml</div>
<div>2014-02-03 03:03:53.786 5561 TRACE nova.compute.manager [instance: 45048c4b-d3fd-46d8-8259-a3bcf93db783] network_info_str = str(network_info)</div>
<div>2014-02-03 03:03:53.786 5561 TRACE nova.compute.manager [instance: 45048c4b-d3fd-46d8-8259-a3bcf93db783] File "/usr/lib/python2.7/dist-packages/nova/network/model.py", line 424, in __str__</div>
<div>2014-02-03 03:03:53.786 5561 TRACE nova.compute.manager [instance: 45048c4b-d3fd-46d8-8259-a3bcf93db783] return self._sync_wrapper(fn, *args, **kwargs)</div>
<div>2014-02-03 03:03:53.786 5561 TRACE nova.compute.manager [instance: 45048c4b-d3fd-46d8-8259-a3bcf93db783] File "/usr/lib/python2.7/dist-packages/nova/network/model.py", line 407, in _sync_wrapper</div>
<div>2014-02-03 03:03:53.786 5561 TRACE nova.compute.manager [instance: 45048c4b-d3fd-46d8-8259-a3bcf93db783] self.wait()</div>
<div>2014-02-03 03:03:53.786 5561 TRACE nova.compute.manager [instance: 45048c4b-d3fd-46d8-8259-a3bcf93db783] File "/usr/lib/python2.7/dist-packages/nova/network/model.py", line 439, in wait</div>
<div>2014-02-03 03:03:53.786 5561 TRACE nova.compute.manager [instance: 45048c4b-d3fd-46d8-8259-a3bcf93db783] self[:] = self._gt.wait()</div>
<div>2014-02-03 03:03:53.786 5561 TRACE nova.compute.manager [instance: 45048c4b-d3fd-46d8-8259-a3bcf93db783] File "/usr/lib/python2.7/dist-packages/eventlet/greenthread.py", line 168, in wait</div>
<div>2014-02-03 03:03:53.786 5561 TRACE nova.compute.manager [instance: 45048c4b-d3fd-46d8-8259-a3bcf93db783] return self._exit_event.wait()</div>
<div>2014-02-03 03:03:53.786 5561 TRACE nova.compute.manager [instance: 45048c4b-d3fd-46d8-8259-a3bcf93db783] File "/usr/lib/python2.7/dist-packages/eventlet/event.py", line 116, in wait</div>
<div>2014-02-03 03:03:53.786 5561 TRACE nova.compute.manager [instance: 45048c4b-d3fd-46d8-8259-a3bcf93db783] return hubs.get_hub().switch()</div>
<div>2014-02-03 03:03:53.786 5561 TRACE nova.compute.manager [instance: 45048c4b-d3fd-46d8-8259-a3bcf93db783] File "/usr/lib/python2.7/dist-packages/eventlet/hubs/hub.py", line 187, in switch</div>
<div>2014-02-03 03:03:53.786 5561 TRACE nova.compute.manager [instance: 45048c4b-d3fd-46d8-8259-a3bcf93db783] return self.greenlet.switch()</div>
<div>2014-02-03 03:03:53.786 5561 TRACE nova.compute.manager [instance: 45048c4b-d3fd-46d8-8259-a3bcf93db783] File "/usr/lib/python2.7/dist-packages/eventlet/greenthread.py", line 194, in main</div>
<div>2014-02-03 03:03:53.786 5561 TRACE nova.compute.manager [instance: 45048c4b-d3fd-46d8-8259-a3bcf93db783] result = function(*args, **kwargs)</div>
<div>2014-02-03 03:03:53.786 5561 TRACE nova.compute.manager [instance: 45048c4b-d3fd-46d8-8259-a3bcf93db783] File "/usr/lib/python2.7/dist-packages/nova/compute/manager.py", line 1510, in _allocate_network_async</div>
<div>2014-02-03 03:03:53.786 5561 TRACE nova.compute.manager [instance: 45048c4b-d3fd-46d8-8259-a3bcf93db783] dhcp_options=dhcp_options)</div>
<div>2014-02-03 03:03:53.786 5561 TRACE nova.compute.manager [instance: 45048c4b-d3fd-46d8-8259-a3bcf93db783] File "/usr/lib/python2.7/dist-packages/nova/network/api.py", line 94, in wrapped</div>
<div>2014-02-03 03:03:53.786 5561 TRACE nova.compute.manager [instance: 45048c4b-d3fd-46d8-8259-a3bcf93db783] return func(self, context, *args, **kwargs)</div>
<div>2014-02-03 03:03:53.786 5561 TRACE nova.compute.manager [instance: 45048c4b-d3fd-46d8-8259-a3bcf93db783] File "/usr/lib/python2.7/dist-packages/nova/network/api.py", line 48, in wrapper</div>
<div>2014-02-03 03:03:53.786 5561 TRACE nova.compute.manager [instance: 45048c4b-d3fd-46d8-8259-a3bcf93db783] res = f(self, context, *args, **kwargs)</div>
<div>2014-02-03 03:03:53.786 5561 TRACE nova.compute.manager [instance: 45048c4b-d3fd-46d8-8259-a3bcf93db783] File "/usr/lib/python2.7/dist-packages/nova/network/api.py", line 302, in allocate_for_instance</div>
<div>2014-02-03 03:03:53.786 5561 TRACE nova.compute.manager [instance: 45048c4b-d3fd-46d8-8259-a3bcf93db783] nw_info = self.network_rpcapi.allocate_for_instance(context, **args)</div>
<div>2014-02-03 03:03:53.786 5561 TRACE nova.compute.manager [instance: 45048c4b-d3fd-46d8-8259-a3bcf93db783] File "/usr/lib/python2.7/dist-packages/nova/network/rpcapi.py", line 170, in allocate_for_instance</div>
<div>2014-02-03 03:03:53.786 5561 TRACE nova.compute.manager [instance: 45048c4b-d3fd-46d8-8259-a3bcf93db783] macs=jsonutils.to_primitive(macs))</div>
<div>2014-02-03 03:03:53.786 5561 TRACE nova.compute.manager [instance: 45048c4b-d3fd-46d8-8259-a3bcf93db783] File "/usr/lib/python2.7/dist-packages/oslo/messaging/rpc/client.py", line 150, in call</div>
<div>2014-02-03 03:03:53.786 5561 TRACE nova.compute.manager [instance: 45048c4b-d3fd-46d8-8259-a3bcf93db783] wait_for_reply=True, timeout=timeout)</div>
<div>2014-02-03 03:03:53.786 5561 TRACE nova.compute.manager [instance: 45048c4b-d3fd-46d8-8259-a3bcf93db783] File "/usr/lib/python2.7/dist-packages/oslo/messaging/transport.py", line 90, in _send</div>
<div>2014-02-03 03:03:53.786 5561 TRACE nova.compute.manager [instance: 45048c4b-d3fd-46d8-8259-a3bcf93db783] timeout=timeout)</div>
<div>2014-02-03 03:03:53.786 5561 TRACE nova.compute.manager [instance: 45048c4b-d3fd-46d8-8259-a3bcf93db783] File "/usr/lib/python2.7/dist-packages/oslo/messaging/_drivers/amqpdriver.py", line 412, in send</div>
<div>2014-02-03 03:03:53.786 5561 TRACE nova.compute.manager [instance: 45048c4b-d3fd-46d8-8259-a3bcf93db783] return self._send(target, ctxt, message, wait_for_reply, timeout)</div>
<div>2014-02-03 03:03:53.786 5561 TRACE nova.compute.manager [instance: 45048c4b-d3fd-46d8-8259-a3bcf93db783] File "/usr/lib/python2.7/dist-packages/oslo/messaging/_drivers/amqpdriver.py", line 403, in _send</div>
<div>2014-02-03 03:03:53.786 5561 TRACE nova.compute.manager [instance: 45048c4b-d3fd-46d8-8259-a3bcf93db783] result = self._waiter.wait(msg_id, timeout)</div>
<div>2014-02-03 03:03:53.786 5561 TRACE nova.compute.manager [instance: 45048c4b-d3fd-46d8-8259-a3bcf93db783] File "/usr/lib/python2.7/dist-packages/oslo/messaging/_drivers/amqpdriver.py", line 280, in wait</div>
<div>2014-02-03 03:03:53.786 5561 TRACE nova.compute.manager [instance: 45048c4b-d3fd-46d8-8259-a3bcf93db783] reply, ending, trylock = self._poll_queue(msg_id, timeout)</div>
<div>2014-02-03 03:03:53.786 5561 TRACE nova.compute.manager [instance: 45048c4b-d3fd-46d8-8259-a3bcf93db783] File "/usr/lib/python2.7/dist-packages/oslo/messaging/_drivers/amqpdriver.py", line 220, in _poll_queue</div>
<div>2014-02-03 03:03:53.786 5561 TRACE nova.compute.manager [instance: 45048c4b-d3fd-46d8-8259-a3bcf93db783] message = self.waiters.get(msg_id, timeout)</div>
<div>2014-02-03 03:03:53.786 5561 TRACE nova.compute.manager [instance: 45048c4b-d3fd-46d8-8259-a3bcf93db783] File "/usr/lib/python2.7/dist-packages/oslo/messaging/_drivers/amqpdriver.py", line 126, in get</div>
<div>2014-02-03 03:03:53.786 5561 TRACE nova.compute.manager [instance: 45048c4b-d3fd-46d8-8259-a3bcf93db783] 'to message ID %s' % msg_id)</div>
<div>2014-02-03 03:03:53.786 5561 TRACE nova.compute.manager [instance: 45048c4b-d3fd-46d8-8259-a3bcf93db783] MessagingTimeout: Timed out waiting for a reply to message ID 0f47e260dccb4dfd945eb6442108c769</div>
<div>2014-02-03 03:03:53.786 5561 TRACE nova.compute.manager [instance: 45048c4b-d3fd-46d8-8259-a3bcf93db783]</div>
<div>2014-02-03 03:03:53.909 5561 AUDIT nova.compute.manager [req-a18ba4ce-048d-4e64-b3ba-1ae7a02bf25c 222d961af18b46c1a27e254e5717bb5d 4d6cf4028cbc448f8827a43f97233389] [instance: 45048c4b-d3fd-46d8-8259-a3bcf93db783] Terminating instance</div>
<div> </div>
</span></font>
</body>
</html>