Login
[x]
Log in using an account from:
Fedora Account System
Red Hat Associate
Red Hat Customer
Or login using a Red Hat Bugzilla account
Forgot Password
Login:
Hide Forgot
Create an Account
Red Hat Bugzilla – Attachment 881912 Details for
Bug 1083675
nova-network and nova-compute dies when there is a network without VlanID specified
[?]
New
Simple Search
Advanced Search
My Links
Browse
Requests
Reports
Current State
Search
Tabular reports
Graphical reports
Duplicates
Other Reports
User Changes
Plotly Reports
Bug Status
Bug Severity
Non-Defaults
|
Product Dashboard
Help
Page Help!
Bug Writing Guidelines
What's new
Browser Support Policy
5.0.4.rh83 Release notes
FAQ
Guides index
User guide
Web Services
Contact
Legal
This site requires JavaScript to be enabled to function correctly, please enable it.
logs
file_1083675.txt (text/plain), 57.84 KB, created by
Jaroslav Henner
on 2014-04-02 17:21:55 UTC
(
hide
)
Description:
logs
Filename:
MIME Type:
Creator:
Jaroslav Henner
Created:
2014-04-02 17:21:55 UTC
Size:
57.84 KB
patch
obsolete
>==> /var/log/nova/scheduler.log <== >2014-04-02 16:59:22.281 32174 INFO nova.scheduler.filter_scheduler [req-c4a2b971-c916-4401-9f2b-805756316ecb admin admin] Attempting to build 1 instance(s) uuids: [u'070e65b0-0b94-4dfe-8359-f46ec1c4172b'] >2014-04-02 16:59:22.288 32174 INFO nova.scheduler.filter_scheduler [req-c4a2b971-c916-4401-9f2b-805756316ecb admin admin] Choosing host WeighedHost [host: jhenner-node-permanent.beerdrop, weight: 3318.0] for instance 070e65b0-0b94-4dfe-8359-f46ec1c4172b > >==> /var/log/nova/api.log <== >2014-04-02 16:59:22.306 32018 INFO nova.osapi_compute.wsgi.server [req-80ef0161-ac1e-4a8c-bb1d-dbd999f90ffc admin admin] 172.16.0.10 "GET /v2/9cbbe7e41508451986a1a401dcaac268/images/3e1056e3-81f2-4e9b-84ed-b78f7dcf5941 HTTP/1.1" status: 200 len: 1007 time: 0.0482600 > > >==> /var/log/nova/compute.log <== >2014-04-02 16:59:22.414 32005 AUDIT nova.compute.manager [req-c4a2b971-c916-4401-9f2b-805756316ecb admin admin] [instance: 070e65b0-0b94-4dfe-8359-f46ec1c4172b] Starting instance... >2014-04-02 16:59:22.639 32005 AUDIT nova.compute.claims [req-c4a2b971-c916-4401-9f2b-805756316ecb admin admin] [instance: 070e65b0-0b94-4dfe-8359-f46ec1c4172b] Attempting claim: memory 512 MB, disk 1 GB, VCPUs 1 >2014-04-02 16:59:22.640 32005 AUDIT nova.compute.claims [req-c4a2b971-c916-4401-9f2b-805756316ecb admin admin] [instance: 070e65b0-0b94-4dfe-8359-f46ec1c4172b] Total Memory: 3830 MB, used: 512.00 MB >2014-04-02 16:59:22.640 32005 AUDIT nova.compute.claims [req-c4a2b971-c916-4401-9f2b-805756316ecb admin admin] [instance: 070e65b0-0b94-4dfe-8359-f46ec1c4172b] Memory limit: 5745.00 MB, free: 5233.00 MB >2014-04-02 16:59:22.640 32005 AUDIT nova.compute.claims [req-c4a2b971-c916-4401-9f2b-805756316ecb admin admin] [instance: 070e65b0-0b94-4dfe-8359-f46ec1c4172b] Total Disk: 39 GB, used: 0.00 GB >2014-04-02 16:59:22.640 32005 AUDIT nova.compute.claims [req-c4a2b971-c916-4401-9f2b-805756316ecb admin admin] [instance: 070e65b0-0b94-4dfe-8359-f46ec1c4172b] Disk limit not specified, defaulting to unlimited >2014-04-02 16:59:22.641 32005 AUDIT nova.compute.claims [req-c4a2b971-c916-4401-9f2b-805756316ecb admin admin] [instance: 070e65b0-0b94-4dfe-8359-f46ec1c4172b] Total CPU: 2 VCPUs, used: 0.00 VCPUs >2014-04-02 16:59:22.641 32005 AUDIT nova.compute.claims [req-c4a2b971-c916-4401-9f2b-805756316ecb admin admin] [instance: 070e65b0-0b94-4dfe-8359-f46ec1c4172b] CPU limit: 32.00 VCPUs, free: 32.00 VCPUs >2014-04-02 16:59:22.641 32005 AUDIT nova.compute.claims [req-c4a2b971-c916-4401-9f2b-805756316ecb admin admin] [instance: 070e65b0-0b94-4dfe-8359-f46ec1c4172b] Claim successful >2014-04-02 16:59:22.846 32005 INFO nova.openstack.common.rpc.impl_qpid [-] Connected to AMQP server on 172.16.0.10:5672 > >==> /var/log/nova/network.log <== >2014-04-02 16:59:22.889 32108 INFO nova.openstack.common.rpc.impl_qpid [req-c4a2b971-c916-4401-9f2b-805756316ecb admin admin] Connected to AMQP server on 172.16.0.10:5672 >2014-04-02 16:59:22.903 32108 INFO nova.openstack.common.rpc.impl_qpid [req-c4a2b971-c916-4401-9f2b-805756316ecb admin admin] Connected to AMQP server on 172.16.0.10:5672 >2014-04-02 16:59:22.921 32108 INFO nova.openstack.common.rpc.impl_qpid [req-c4a2b971-c916-4401-9f2b-805756316ecb admin admin] Connected to AMQP server on 172.16.0.10:5672 > >==> /var/log/nova/compute.log <== >2014-04-02 16:59:23.142 32005 INFO nova.virt.libvirt.driver [req-c4a2b971-c916-4401-9f2b-805756316ecb admin admin] [instance: 070e65b0-0b94-4dfe-8359-f46ec1c4172b] Creating image > >==> /var/log/nova/network.log <== >2014-04-02 16:59:29.529 32108 ERROR nova.openstack.common.rpc.amqp [req-c4a2b971-c916-4401-9f2b-805756316ecb admin admin] Exception during message handling >2014-04-02 16:59:29.529 32108 TRACE nova.openstack.common.rpc.amqp Traceback (most recent call last): >2014-04-02 16:59:29.529 32108 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-02 16:59:29.529 32108 TRACE nova.openstack.common.rpc.amqp **args) >2014-04-02 16:59:29.529 32108 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-02 16:59:29.529 32108 TRACE nova.openstack.common.rpc.amqp result = getattr(proxyobj, method)(ctxt, **kwargs) >2014-04-02 16:59:29.529 32108 TRACE nova.openstack.common.rpc.amqp File "/usr/lib/python2.6/site-packages/nova/network/floating_ips.py", line 118, in allocate_for_instance >2014-04-02 16:59:29.529 32108 TRACE nova.openstack.common.rpc.amqp **kwargs) >2014-04-02 16:59:29.529 32108 TRACE nova.openstack.common.rpc.amqp File "/usr/lib/python2.6/site-packages/nova/network/manager.py", line 510, in allocate_for_instance >2014-04-02 16:59:29.529 32108 TRACE nova.openstack.common.rpc.amqp requested_networks=requested_networks) >2014-04-02 16:59:29.529 32108 TRACE nova.openstack.common.rpc.amqp File "/usr/lib/python2.6/site-packages/nova/network/manager.py", line 213, in _allocate_fixed_ips >2014-04-02 16:59:29.529 32108 TRACE nova.openstack.common.rpc.amqp vpn=vpn, address=address) >2014-04-02 16:59:29.529 32108 TRACE nova.openstack.common.rpc.amqp File "/usr/lib/python2.6/site-packages/nova/network/manager.py", line 1762, in allocate_fixed_ip >2014-04-02 16:59:29.529 32108 TRACE nova.openstack.common.rpc.amqp self._setup_network_on_host(context, network) >2014-04-02 16:59:29.529 32108 TRACE nova.openstack.common.rpc.amqp File "/usr/lib/python2.6/site-packages/nova/openstack/common/lockutils.py", line 246, in inner >2014-04-02 16:59:29.529 32108 TRACE nova.openstack.common.rpc.amqp return f(*args, **kwargs) >2014-04-02 16:59:29.529 32108 TRACE nova.openstack.common.rpc.amqp File "/usr/lib/python2.6/site-packages/nova/network/manager.py", line 1869, in _setup_network_on_host >2014-04-02 16:59:29.529 32108 TRACE nova.openstack.common.rpc.amqp network['vpn_private_address']) >2014-04-02 16:59:29.529 32108 TRACE nova.openstack.common.rpc.amqp File "/usr/lib/python2.6/site-packages/nova/network/l3.py", line 125, in add_vpn >2014-04-02 16:59:29.529 32108 TRACE nova.openstack.common.rpc.amqp linux_net.ensure_vpn_forward(public_ip, port, private_ip) >2014-04-02 16:59:29.529 32108 TRACE nova.openstack.common.rpc.amqp File "/usr/lib/python2.6/site-packages/nova/network/linux_net.py", line 747, in ensure_vpn_forward >2014-04-02 16:59:29.529 32108 TRACE nova.openstack.common.rpc.amqp iptables_manager.apply() >2014-04-02 16:59:29.529 32108 TRACE nova.openstack.common.rpc.amqp File "/usr/lib/python2.6/site-packages/nova/network/linux_net.py", line 421, in apply >2014-04-02 16:59:29.529 32108 TRACE nova.openstack.common.rpc.amqp self._apply() >2014-04-02 16:59:29.529 32108 TRACE nova.openstack.common.rpc.amqp File "/usr/lib/python2.6/site-packages/nova/openstack/common/lockutils.py", line 246, in inner >2014-04-02 16:59:29.529 32108 TRACE nova.openstack.common.rpc.amqp return f(*args, **kwargs) >2014-04-02 16:59:29.529 32108 TRACE nova.openstack.common.rpc.amqp File "/usr/lib/python2.6/site-packages/nova/network/linux_net.py", line 450, in _apply >2014-04-02 16:59:29.529 32108 TRACE nova.openstack.common.rpc.amqp attempts=5) >2014-04-02 16:59:29.529 32108 TRACE nova.openstack.common.rpc.amqp File "/usr/lib/python2.6/site-packages/nova/network/linux_net.py", line 1190, in _execute >2014-04-02 16:59:29.529 32108 TRACE nova.openstack.common.rpc.amqp return utils.execute(*cmd, **kwargs) >2014-04-02 16:59:29.529 32108 TRACE nova.openstack.common.rpc.amqp File "/usr/lib/python2.6/site-packages/nova/utils.py", line 177, in execute >2014-04-02 16:59:29.529 32108 TRACE nova.openstack.common.rpc.amqp return processutils.execute(*cmd, **kwargs) >2014-04-02 16:59:29.529 32108 TRACE nova.openstack.common.rpc.amqp File "/usr/lib/python2.6/site-packages/nova/openstack/common/processutils.py", line 178, in execute >2014-04-02 16:59:29.529 32108 TRACE nova.openstack.common.rpc.amqp cmd=' '.join(cmd)) >2014-04-02 16:59:29.529 32108 TRACE nova.openstack.common.rpc.amqp ProcessExecutionError: Unexpected error while running command. >2014-04-02 16:59:29.529 32108 TRACE nova.openstack.common.rpc.amqp Command: sudo nova-rootwrap /etc/nova/rootwrap.conf iptables-restore -c >2014-04-02 16:59:29.529 32108 TRACE nova.openstack.common.rpc.amqp Exit code: 2 >2014-04-02 16:59:29.529 32108 TRACE nova.openstack.common.rpc.amqp Stdout: '' >2014-04-02 16:59:29.529 32108 TRACE nova.openstack.common.rpc.amqp Stderr: "iptables-restore v1.4.7: invalid port/service `None' specified\nError occurred at line: 40\nTry `iptables-restore -h' or 'iptables-restore --help' for more information.\n" >2014-04-02 16:59:29.529 32108 TRACE nova.openstack.common.rpc.amqp >2014-04-02 16:59:29.534 32108 ERROR nova.openstack.common.rpc.common [req-c4a2b971-c916-4401-9f2b-805756316ecb admin admin] Returning exception Unexpected error while running command. >Command: sudo nova-rootwrap /etc/nova/rootwrap.conf iptables-restore -c >Exit code: 2 >Stdout: '' >Stderr: "iptables-restore v1.4.7: invalid port/service `None' specified\nError occurred at line: 40\nTry `iptables-restore -h' or 'iptables-restore --help' for more information.\n" to caller >2014-04-02 16:59:29.535 32108 ERROR nova.openstack.common.rpc.common [req-c4a2b971-c916-4401-9f2b-805756316ecb admin admin] ['Traceback (most recent call last):\n', ' File "/usr/lib/python2.6/site-packages/nova/openstack/common/rpc/amqp.py", line 461, in _process_data\n **args)\n', ' File "/usr/lib/python2.6/site-packages/nova/openstack/common/rpc/dispatcher.py", line 172, in dispatch\n result = getattr(proxyobj, method)(ctxt, **kwargs)\n', ' File "/usr/lib/python2.6/site-packages/nova/network/floating_ips.py", line 118, in allocate_for_instance\n **kwargs)\n', ' File "/usr/lib/python2.6/site-packages/nova/network/manager.py", line 510, in allocate_for_instance\n requested_networks=requested_networks)\n', ' File "/usr/lib/python2.6/site-packages/nova/network/manager.py", line 213, in _allocate_fixed_ips\n vpn=vpn, address=address)\n', ' File "/usr/lib/python2.6/site-packages/nova/network/manager.py", line 1762, in allocate_fixed_ip\n self._setup_network_on_host(context, network)\n', ' File "/usr/lib/python2.6/site-packages/nova/openstack/common/lockutils.py", line 246, in inner\n return f(*args, **kwargs)\n', ' File "/usr/lib/python2.6/site-packages/nova/network/manager.py", line 1869, in _setup_network_on_host\n network[\'vpn_private_address\'])\n', ' File "/usr/lib/python2.6/site-packages/nova/network/l3.py", line 125, in add_vpn\n linux_net.ensure_vpn_forward(public_ip, port, private_ip)\n', ' File "/usr/lib/python2.6/site-packages/nova/network/linux_net.py", line 747, in ensure_vpn_forward\n iptables_manager.apply()\n', ' File "/usr/lib/python2.6/site-packages/nova/network/linux_net.py", line 421, in apply\n self._apply()\n', ' File "/usr/lib/python2.6/site-packages/nova/openstack/common/lockutils.py", line 246, in inner\n return f(*args, **kwargs)\n', ' File "/usr/lib/python2.6/site-packages/nova/network/linux_net.py", line 450, in _apply\n attempts=5)\n', ' File "/usr/lib/python2.6/site-packages/nova/network/linux_net.py", line 1190, in _execute\n return utils.execute(*cmd, **kwargs)\n', ' File "/usr/lib/python2.6/site-packages/nova/utils.py", line 177, in execute\n return processutils.execute(*cmd, **kwargs)\n', ' File "/usr/lib/python2.6/site-packages/nova/openstack/common/processutils.py", line 178, in execute\n cmd=\' \'.join(cmd))\n', 'ProcessExecutionError: Unexpected error while running command.\nCommand: sudo nova-rootwrap /etc/nova/rootwrap.conf iptables-restore -c\nExit code: 2\nStdout: \'\'\nStderr: "iptables-restore v1.4.7: invalid port/service `None\' specified\\nError occurred at line: 40\\nTry `iptables-restore -h\' or \'iptables-restore --help\' for more information.\\n"\n'] > >==> /var/log/nova/compute.log <== >2014-04-02 16:59:29.548 32005 ERROR nova.compute.manager [-] Instance failed network setup after 1 attempt(s) >2014-04-02 16:59:29.548 32005 TRACE nova.compute.manager Traceback (most recent call last): >2014-04-02 16:59:29.548 32005 TRACE nova.compute.manager File "/usr/lib/python2.6/site-packages/nova/compute/manager.py", line 1244, in _allocate_network_async >2014-04-02 16:59:29.548 32005 TRACE nova.compute.manager dhcp_options=dhcp_options) >2014-04-02 16:59:29.548 32005 TRACE nova.compute.manager File "/usr/lib/python2.6/site-packages/nova/network/api.py", line 94, in wrapped >2014-04-02 16:59:29.548 32005 TRACE nova.compute.manager return func(self, context, *args, **kwargs) >2014-04-02 16:59:29.548 32005 TRACE nova.compute.manager File "/usr/lib/python2.6/site-packages/nova/network/api.py", line 49, in wrapper >2014-04-02 16:59:29.548 32005 TRACE nova.compute.manager res = f(self, context, *args, **kwargs) >2014-04-02 16:59:29.548 32005 TRACE nova.compute.manager File "/usr/lib/python2.6/site-packages/nova/network/api.py", line 301, in allocate_for_instance >2014-04-02 16:59:29.548 32005 TRACE nova.compute.manager nw_info = self.network_rpcapi.allocate_for_instance(context, **args) >2014-04-02 16:59:29.548 32005 TRACE nova.compute.manager File "/usr/lib/python2.6/site-packages/nova/network/rpcapi.py", line 184, in allocate_for_instance >2014-04-02 16:59:29.548 32005 TRACE nova.compute.manager macs=jsonutils.to_primitive(macs)) >2014-04-02 16:59:29.548 32005 TRACE nova.compute.manager File "/usr/lib/python2.6/site-packages/nova/rpcclient.py", line 85, in call >2014-04-02 16:59:29.548 32005 TRACE nova.compute.manager return self._invoke(self.proxy.call, ctxt, method, **kwargs) >2014-04-02 16:59:29.548 32005 TRACE nova.compute.manager File "/usr/lib/python2.6/site-packages/nova/rpcclient.py", line 63, in _invoke >2014-04-02 16:59:29.548 32005 TRACE nova.compute.manager return cast_or_call(ctxt, msg, **self.kwargs) >2014-04-02 16:59:29.548 32005 TRACE nova.compute.manager File "/usr/lib/python2.6/site-packages/nova/openstack/common/rpc/proxy.py", line 126, in call >2014-04-02 16:59:29.548 32005 TRACE nova.compute.manager result = rpc.call(context, real_topic, msg, timeout) >2014-04-02 16:59:29.548 32005 TRACE nova.compute.manager File "/usr/lib/python2.6/site-packages/nova/openstack/common/rpc/__init__.py", line 139, in call >2014-04-02 16:59:29.548 32005 TRACE nova.compute.manager return _get_impl().call(CONF, context, topic, msg, timeout) >2014-04-02 16:59:29.548 32005 TRACE nova.compute.manager File "/usr/lib/python2.6/site-packages/nova/openstack/common/rpc/impl_qpid.py", line 783, in call >2014-04-02 16:59:29.548 32005 TRACE nova.compute.manager rpc_amqp.get_connection_pool(conf, Connection)) >2014-04-02 16:59:29.548 32005 TRACE nova.compute.manager File "/usr/lib/python2.6/site-packages/nova/openstack/common/rpc/amqp.py", line 574, in call >2014-04-02 16:59:29.548 32005 TRACE nova.compute.manager rv = list(rv) >2014-04-02 16:59:29.548 32005 TRACE nova.compute.manager File "/usr/lib/python2.6/site-packages/nova/openstack/common/rpc/amqp.py", line 539, in __iter__ >2014-04-02 16:59:29.548 32005 TRACE nova.compute.manager raise result >2014-04-02 16:59:29.548 32005 TRACE nova.compute.manager RemoteError: Remote error: ProcessExecutionError Unexpected error while running command. >2014-04-02 16:59:29.548 32005 TRACE nova.compute.manager Command: sudo nova-rootwrap /etc/nova/rootwrap.conf iptables-restore -c >2014-04-02 16:59:29.548 32005 TRACE nova.compute.manager Exit code: 2 >2014-04-02 16:59:29.548 32005 TRACE nova.compute.manager Stdout: '' >2014-04-02 16:59:29.548 32005 TRACE nova.compute.manager Stderr: "iptables-restore v1.4.7: invalid port/service `None' specified\nError occurred at line: 40\nTry `iptables-restore -h' or 'iptables-restore --help' for more information.\n" >2014-04-02 16:59:29.548 32005 TRACE nova.compute.manager [u'Traceback (most recent call last):\n', u' File "/usr/lib/python2.6/site-packages/nova/openstack/common/rpc/amqp.py", line 461, in _process_data\n **args)\n', u' File "/usr/lib/python2.6/site-packages/nova/openstack/common/rpc/dispatcher.py", line 172, in dispatch\n result = getattr(proxyobj, method)(ctxt, **kwargs)\n', u' File "/usr/lib/python2.6/site-packages/nova/network/floating_ips.py", line 118, in allocate_for_instance\n **kwargs)\n', u' File "/usr/lib/python2.6/site-packages/nova/network/manager.py", line 510, in allocate_for_instance\n requested_networks=requested_networks)\n', u' File "/usr/lib/python2.6/site-packages/nova/network/manager.py", line 213, in _allocate_fixed_ips\n vpn=vpn, address=address)\n', u' File "/usr/lib/python2.6/site-packages/nova/network/manager.py", line 1762, in allocate_fixed_ip\n self._setup_network_on_host(context, network)\n', u' File "/usr/lib/python2.6/site-packages/nova/openstack/common/lockutils.py", line 246, in inner\n return f(*args, **kwargs)\n', u' File "/usr/lib/python2.6/site-packages/nova/network/manager.py", line 1869, in _setup_network_on_host\n network[\'vpn_private_address\'])\n', u' File "/usr/lib/python2.6/site-packages/nova/network/l3.py", line 125, in add_vpn\n linux_net.ensure_vpn_forward(public_ip, port, private_ip)\n', u' File "/usr/lib/python2.6/site-packages/nova/network/linux_net.py", line 747, in ensure_vpn_forward\n iptables_manager.apply()\n', u' File "/usr/lib/python2.6/site-packages/nova/network/linux_net.py", line 421, in apply\n self._apply()\n', u' File "/usr/lib/python2.6/site-packages/nova/openstack/common/lockutils.py", line 246, in inner\n return f(*args, **kwargs)\n', u' File "/usr/lib/python2.6/site-packages/nova/network/linux_net.py", line 450, in _apply\n attempts=5)\n', u' File "/usr/lib/python2.6/site-packages/nova/network/linux_net.py", line 1190, in _execute\n return utils.execute(*cmd, **kwargs)\n', u' File "/usr/lib/python2.6/site-packages/nova/utils.py", line 177, in execute\n return processutils.execute(*cmd, **kwargs)\n', u' File "/usr/lib/python2.6/site-packages/nova/openstack/common/processutils.py", line 178, in execute\n cmd=\' \'.join(cmd))\n', u'ProcessExecutionError: Unexpected error while running command.\nCommand: sudo nova-rootwrap /etc/nova/rootwrap.conf iptables-restore -c\nExit code: 2\nStdout: \'\'\nStderr: "iptables-restore v1.4.7: invalid port/service `None\' specified\\nError occurred at line: 40\\nTry `iptables-restore -h\' or \'iptables-restore --help\' for more information.\\n"\n']. >2014-04-02 16:59:29.548 32005 TRACE nova.compute.manager >2014-04-02 16:59:46.405 32005 ERROR nova.compute.manager [req-c4a2b971-c916-4401-9f2b-805756316ecb admin admin] [instance: 070e65b0-0b94-4dfe-8359-f46ec1c4172b] Instance failed to spawn >2014-04-02 16:59:46.405 32005 TRACE nova.compute.manager [instance: 070e65b0-0b94-4dfe-8359-f46ec1c4172b] Traceback (most recent call last): >2014-04-02 16:59:46.405 32005 TRACE nova.compute.manager [instance: 070e65b0-0b94-4dfe-8359-f46ec1c4172b] File "/usr/lib/python2.6/site-packages/nova/compute/manager.py", line 1423, in _spawn >2014-04-02 16:59:46.405 32005 TRACE nova.compute.manager [instance: 070e65b0-0b94-4dfe-8359-f46ec1c4172b] block_device_info) >2014-04-02 16:59:46.405 32005 TRACE nova.compute.manager [instance: 070e65b0-0b94-4dfe-8359-f46ec1c4172b] File "/usr/lib/python2.6/site-packages/nova/virt/libvirt/driver.py", line 2084, in spawn >2014-04-02 16:59:46.405 32005 TRACE nova.compute.manager [instance: 070e65b0-0b94-4dfe-8359-f46ec1c4172b] admin_pass=admin_password) >2014-04-02 16:59:46.405 32005 TRACE nova.compute.manager [instance: 070e65b0-0b94-4dfe-8359-f46ec1c4172b] File "/usr/lib/python2.6/site-packages/nova/virt/libvirt/driver.py", line 2481, in _create_image >2014-04-02 16:59:46.405 32005 TRACE nova.compute.manager [instance: 070e65b0-0b94-4dfe-8359-f46ec1c4172b] net = netutils.get_injected_network_template(network_info) >2014-04-02 16:59:46.405 32005 TRACE nova.compute.manager [instance: 070e65b0-0b94-4dfe-8359-f46ec1c4172b] File "/usr/lib/python2.6/site-packages/nova/virt/netutils.py", line 74, in get_injected_network_template >2014-04-02 16:59:46.405 32005 TRACE nova.compute.manager [instance: 070e65b0-0b94-4dfe-8359-f46ec1c4172b] if not (network_info and template): >2014-04-02 16:59:46.405 32005 TRACE nova.compute.manager [instance: 070e65b0-0b94-4dfe-8359-f46ec1c4172b] File "/usr/lib/python2.6/site-packages/nova/network/model.py", line 379, in __len__ >2014-04-02 16:59:46.405 32005 TRACE nova.compute.manager [instance: 070e65b0-0b94-4dfe-8359-f46ec1c4172b] return self._sync_wrapper(fn, *args, **kwargs) >2014-04-02 16:59:46.405 32005 TRACE nova.compute.manager [instance: 070e65b0-0b94-4dfe-8359-f46ec1c4172b] File "/usr/lib/python2.6/site-packages/nova/network/model.py", line 366, in _sync_wrapper >2014-04-02 16:59:46.405 32005 TRACE nova.compute.manager [instance: 070e65b0-0b94-4dfe-8359-f46ec1c4172b] self.wait() >2014-04-02 16:59:46.405 32005 TRACE nova.compute.manager [instance: 070e65b0-0b94-4dfe-8359-f46ec1c4172b] File "/usr/lib/python2.6/site-packages/nova/network/model.py", line 398, in wait >2014-04-02 16:59:46.405 32005 TRACE nova.compute.manager [instance: 070e65b0-0b94-4dfe-8359-f46ec1c4172b] self[:] = self._gt.wait() >2014-04-02 16:59:46.405 32005 TRACE nova.compute.manager [instance: 070e65b0-0b94-4dfe-8359-f46ec1c4172b] File "/usr/lib/python2.6/site-packages/eventlet/greenthread.py", line 168, in wait >2014-04-02 16:59:46.405 32005 TRACE nova.compute.manager [instance: 070e65b0-0b94-4dfe-8359-f46ec1c4172b] return self._exit_event.wait() >2014-04-02 16:59:46.405 32005 TRACE nova.compute.manager [instance: 070e65b0-0b94-4dfe-8359-f46ec1c4172b] File "/usr/lib/python2.6/site-packages/eventlet/event.py", line 120, in wait >2014-04-02 16:59:46.405 32005 TRACE nova.compute.manager [instance: 070e65b0-0b94-4dfe-8359-f46ec1c4172b] current.throw(*self._exc) >2014-04-02 16:59:46.405 32005 TRACE nova.compute.manager [instance: 070e65b0-0b94-4dfe-8359-f46ec1c4172b] File "/usr/lib/python2.6/site-packages/eventlet/greenthread.py", line 194, in main >2014-04-02 16:59:46.405 32005 TRACE nova.compute.manager [instance: 070e65b0-0b94-4dfe-8359-f46ec1c4172b] result = function(*args, **kwargs) >2014-04-02 16:59:46.405 32005 TRACE nova.compute.manager [instance: 070e65b0-0b94-4dfe-8359-f46ec1c4172b] File "/usr/lib/python2.6/site-packages/nova/compute/manager.py", line 1244, in _allocate_network_async >2014-04-02 16:59:46.405 32005 TRACE nova.compute.manager [instance: 070e65b0-0b94-4dfe-8359-f46ec1c4172b] dhcp_options=dhcp_options) >2014-04-02 16:59:46.405 32005 TRACE nova.compute.manager [instance: 070e65b0-0b94-4dfe-8359-f46ec1c4172b] File "/usr/lib/python2.6/site-packages/nova/network/api.py", line 94, in wrapped >2014-04-02 16:59:46.405 32005 TRACE nova.compute.manager [instance: 070e65b0-0b94-4dfe-8359-f46ec1c4172b] return func(self, context, *args, **kwargs) >2014-04-02 16:59:46.405 32005 TRACE nova.compute.manager [instance: 070e65b0-0b94-4dfe-8359-f46ec1c4172b] File "/usr/lib/python2.6/site-packages/nova/network/api.py", line 49, in wrapper >2014-04-02 16:59:46.405 32005 TRACE nova.compute.manager [instance: 070e65b0-0b94-4dfe-8359-f46ec1c4172b] res = f(self, context, *args, **kwargs) >2014-04-02 16:59:46.405 32005 TRACE nova.compute.manager [instance: 070e65b0-0b94-4dfe-8359-f46ec1c4172b] File "/usr/lib/python2.6/site-packages/nova/network/api.py", line 301, in allocate_for_instance >2014-04-02 16:59:46.405 32005 TRACE nova.compute.manager [instance: 070e65b0-0b94-4dfe-8359-f46ec1c4172b] nw_info = self.network_rpcapi.allocate_for_instance(context, **args) >2014-04-02 16:59:46.405 32005 TRACE nova.compute.manager [instance: 070e65b0-0b94-4dfe-8359-f46ec1c4172b] File "/usr/lib/python2.6/site-packages/nova/network/rpcapi.py", line 184, in allocate_for_instance >2014-04-02 16:59:46.405 32005 TRACE nova.compute.manager [instance: 070e65b0-0b94-4dfe-8359-f46ec1c4172b] macs=jsonutils.to_primitive(macs)) >2014-04-02 16:59:46.405 32005 TRACE nova.compute.manager [instance: 070e65b0-0b94-4dfe-8359-f46ec1c4172b] File "/usr/lib/python2.6/site-packages/nova/rpcclient.py", line 85, in call >2014-04-02 16:59:46.405 32005 TRACE nova.compute.manager [instance: 070e65b0-0b94-4dfe-8359-f46ec1c4172b] return self._invoke(self.proxy.call, ctxt, method, **kwargs) >2014-04-02 16:59:46.405 32005 TRACE nova.compute.manager [instance: 070e65b0-0b94-4dfe-8359-f46ec1c4172b] File "/usr/lib/python2.6/site-packages/nova/rpcclient.py", line 63, in _invoke >2014-04-02 16:59:46.405 32005 TRACE nova.compute.manager [instance: 070e65b0-0b94-4dfe-8359-f46ec1c4172b] return cast_or_call(ctxt, msg, **self.kwargs) >2014-04-02 16:59:46.405 32005 TRACE nova.compute.manager [instance: 070e65b0-0b94-4dfe-8359-f46ec1c4172b] File "/usr/lib/python2.6/site-packages/nova/openstack/common/rpc/proxy.py", line 126, in call >2014-04-02 16:59:46.405 32005 TRACE nova.compute.manager [instance: 070e65b0-0b94-4dfe-8359-f46ec1c4172b] result = rpc.call(context, real_topic, msg, timeout) >2014-04-02 16:59:46.405 32005 TRACE nova.compute.manager [instance: 070e65b0-0b94-4dfe-8359-f46ec1c4172b] File "/usr/lib/python2.6/site-packages/nova/openstack/common/rpc/__init__.py", line 139, in call >2014-04-02 16:59:46.405 32005 TRACE nova.compute.manager [instance: 070e65b0-0b94-4dfe-8359-f46ec1c4172b] return _get_impl().call(CONF, context, topic, msg, timeout) >2014-04-02 16:59:46.405 32005 TRACE nova.compute.manager [instance: 070e65b0-0b94-4dfe-8359-f46ec1c4172b] File "/usr/lib/python2.6/site-packages/nova/openstack/common/rpc/impl_qpid.py", line 783, in call >2014-04-02 16:59:46.405 32005 TRACE nova.compute.manager [instance: 070e65b0-0b94-4dfe-8359-f46ec1c4172b] rpc_amqp.get_connection_pool(conf, Connection)) >2014-04-02 16:59:46.405 32005 TRACE nova.compute.manager [instance: 070e65b0-0b94-4dfe-8359-f46ec1c4172b] File "/usr/lib/python2.6/site-packages/nova/openstack/common/rpc/amqp.py", line 574, in call >2014-04-02 16:59:46.405 32005 TRACE nova.compute.manager [instance: 070e65b0-0b94-4dfe-8359-f46ec1c4172b] rv = list(rv) >2014-04-02 16:59:46.405 32005 TRACE nova.compute.manager [instance: 070e65b0-0b94-4dfe-8359-f46ec1c4172b] File "/usr/lib/python2.6/site-packages/nova/openstack/common/rpc/amqp.py", line 539, in __iter__ >2014-04-02 16:59:46.405 32005 TRACE nova.compute.manager [instance: 070e65b0-0b94-4dfe-8359-f46ec1c4172b] raise result >2014-04-02 16:59:46.405 32005 TRACE nova.compute.manager [instance: 070e65b0-0b94-4dfe-8359-f46ec1c4172b] RemoteError: Remote error: ProcessExecutionError Unexpected error while running command. >2014-04-02 16:59:46.405 32005 TRACE nova.compute.manager [instance: 070e65b0-0b94-4dfe-8359-f46ec1c4172b] Command: sudo nova-rootwrap /etc/nova/rootwrap.conf iptables-restore -c >2014-04-02 16:59:46.405 32005 TRACE nova.compute.manager [instance: 070e65b0-0b94-4dfe-8359-f46ec1c4172b] Exit code: 2 >2014-04-02 16:59:46.405 32005 TRACE nova.compute.manager [instance: 070e65b0-0b94-4dfe-8359-f46ec1c4172b] Stdout: '' >2014-04-02 16:59:46.405 32005 TRACE nova.compute.manager [instance: 070e65b0-0b94-4dfe-8359-f46ec1c4172b] Stderr: "iptables-restore v1.4.7: invalid port/service `None' specified\nError occurred at line: 40\nTry `iptables-restore -h' or 'iptables-restore --help' for more information.\n" >2014-04-02 16:59:46.405 32005 TRACE nova.compute.manager [instance: 070e65b0-0b94-4dfe-8359-f46ec1c4172b] [u'Traceback (most recent call last):\n', u' File "/usr/lib/python2.6/site-packages/nova/openstack/common/rpc/amqp.py", line 461, in _process_data\n **args)\n', u' File "/usr/lib/python2.6/site-packages/nova/openstack/common/rpc/dispatcher.py", line 172, in dispatch\n result = getattr(proxyobj, method)(ctxt, **kwargs)\n', u' File "/usr/lib/python2.6/site-packages/nova/network/floating_ips.py", line 118, in allocate_for_instance\n **kwargs)\n', u' File "/usr/lib/python2.6/site-packages/nova/network/manager.py", line 510, in allocate_for_instance\n requested_networks=requested_networks)\n', u' File "/usr/lib/python2.6/site-packages/nova/network/manager.py", line 213, in _allocate_fixed_ips\n vpn=vpn, address=address)\n', u' File "/usr/lib/python2.6/site-packages/nova/network/manager.py", line 1762, in allocate_fixed_ip\n self._setup_network_on_host(context, network)\n', u' File "/usr/lib/python2.6/site-packages/nova/openstack/common/lockutils.py", line 246, in inner\n return f(*args, **kwargs)\n', u' File "/usr/lib/python2.6/site-packages/nova/network/manager.py", line 1869, in _setup_network_on_host\n network[\'vpn_private_address\'])\n', u' File "/usr/lib/python2.6/site-packages/nova/network/l3.py", line 125, in add_vpn\n linux_net.ensure_vpn_forward(public_ip, port, private_ip)\n', u' File "/usr/lib/python2.6/site-packages/nova/network/linux_net.py", line 747, in ensure_vpn_forward\n iptables_manager.apply()\n', u' File "/usr/lib/python2.6/site-packages/nova/network/linux_net.py", line 421, in apply\n self._apply()\n', u' File "/usr/lib/python2.6/site-packages/nova/openstack/common/lockutils.py", line 246, in inner\n return f(*args, **kwargs)\n', u' File "/usr/lib/python2.6/site-packages/nova/network/linux_net.py", line 450, in _apply\n attempts=5)\n', u' File "/usr/lib/python2.6/site-packages/nova/network/linux_net.py", line 1190, in _execute\n return utils.execute(*cmd, **kwargs)\n', u' File "/usr/lib/python2.6/site-packages/nova/utils.py", line 177, in execute\n return processutils.execute(*cmd, **kwargs)\n', u' File "/usr/lib/python2.6/site-packages/nova/openstack/common/processutils.py", line 178, in execute\n cmd=\' \'.join(cmd))\n', u'ProcessExecutionError: Unexpected error while running command.\nCommand: sudo nova-rootwrap /etc/nova/rootwrap.conf iptables-restore -c\nExit code: 2\nStdout: \'\'\nStderr: "iptables-restore v1.4.7: invalid port/service `None\' specified\\nError occurred at line: 40\\nTry `iptables-restore -h\' or \'iptables-restore --help\' for more information.\\n"\n']. >2014-04-02 16:59:46.405 32005 TRACE nova.compute.manager [instance: 070e65b0-0b94-4dfe-8359-f46ec1c4172b] >2014-04-02 16:59:46.460 32005 AUDIT nova.compute.manager [req-c4a2b971-c916-4401-9f2b-805756316ecb admin admin] [instance: 070e65b0-0b94-4dfe-8359-f46ec1c4172b] Terminating instance >2014-04-02 16:59:46.685 32005 ERROR nova.virt.libvirt.driver [-] [instance: 070e65b0-0b94-4dfe-8359-f46ec1c4172b] During wait destroy, instance disappeared. > > > > ># nova show foo_vm > >+--------------------------------------+-------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------+ >| Property | Value | >+--------------------------------------+-------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------+ >| OS-DCF:diskConfig | MANUAL | >| OS-EXT-AZ:availability_zone | nova | >| OS-EXT-SRV-ATTR:host | jhenner-node-permanent.beerdrop | >| OS-EXT-SRV-ATTR:hypervisor_hostname | jhenner-node-permanent.beerdrop | >| OS-EXT-SRV-ATTR:instance_name | instance-00000004 | >| OS-EXT-STS:power_state | 0 | >| OS-EXT-STS:task_state | - | >| OS-EXT-STS:vm_state | error | >| OS-SRV-USG:launched_at | - | >| OS-SRV-USG:terminated_at | - | >| accessIPv4 | | >| accessIPv6 | | >| config_drive | | >| created | 2014-04-02T16:59:22Z | >| fault | {"message": "Remote error: ProcessExecutionError Unexpected error while running command. | >| | Command: sudo nova-rootwrap /etc/nova/rootwrap.conf env CONFIG_FILE=[\"/usr/share/nova/nova-dist.conf\", \"/etc/nova/nova.conf\"] NETWORK_ID=3 dnsmasq --strict-order --bind-interfaces", "code": 500, "details": " File \"/usr/lib/python2.6/site-packages/nova/compute/manager.py\", line 258, in decorated_function | >| | return function(self, context, *args, **kwargs) | >| | File \"/usr/lib/python2.6/site-packages/nova/compute/manager.py\", line 1630, in run_instance | >| | do_run_instance() | >| | File \"/usr/lib/python2.6/site-packages/nova/openstack/common/lockutils.py\", line 246, in inner | >| | return f(*args, **kwargs) | >| | File \"/usr/lib/python2.6/site-packages/nova/compute/manager.py\", line 1629, in do_run_instance | >| | legacy_bdm_in_spec) | >| | File \"/usr/lib/python2.6/site-packages/nova/compute/manager.py\", line 968, in _run_instance | >| | notify(\"error\", msg=unicode(e)) # notify that build failed | >| | File \"/usr/lib/python2.6/site-packages/nova/compute/manager.py\", line 952, in _run_instance | >| | instance, image_meta, legacy_bdm_in_spec) | >| | File \"/usr/lib/python2.6/site-packages/nova/compute/manager.py\", line 1091, in _build_instance | >| | filter_properties, bdms, legacy_bdm_in_spec) | >| | File \"/usr/lib/python2.6/site-packages/nova/compute/manager.py\", line 1135, in _reschedule_or_error | >| | self._log_original_error(exc_info, instance_uuid) | >| | File \"/usr/lib/python2.6/site-packages/nova/compute/manager.py\", line 1130, in _reschedule_or_error | >| | bdms, requested_networks) | >| | File \"/usr/lib/python2.6/site-packages/nova/compute/manager.py\", line 1681, in _shutdown_instance | >| | self._try_deallocate_network(context, instance, requested_networks) | >| | File \"/usr/lib/python2.6/site-packages/nova/compute/manager.py\", line 1641, in _try_deallocate_network | >| | self._set_instance_error_state(context, instance['uuid']) | >| | File \"/usr/lib/python2.6/site-packages/nova/compute/manager.py\", line 1636, in _try_deallocate_network | >| | self._deallocate_network(context, instance, requested_networks) | >| | File \"/usr/lib/python2.6/site-packages/nova/compute/manager.py\", line 1479, in _deallocate_network | >| | context, instance, requested_networks=requested_networks) | >| | File \"/usr/lib/python2.6/site-packages/nova/network/api.py\", line 94, in wrapped | >| | return func(self, context, *args, **kwargs) | >| | File \"/usr/lib/python2.6/site-packages/nova/network/api.py\", line 318, in deallocate_for_instance | >| | self.network_rpcapi.deallocate_for_instance(context, **args) | >| | File \"/usr/lib/python2.6/site-packages/nova/network/rpcapi.py\", line 193, in deallocate_for_instance | >| | host=host, requested_networks=requested_networks) | >| | File \"/usr/lib/python2.6/site-packages/nova/rpcclient.py\", line 85, in call | >| | return self._invoke(self.proxy.call, ctxt, method, **kwargs) | >| | File \"/usr/lib/python2.6/site-packages/nova/rpcclient.py\", line 63, in _invoke | >| | return cast_or_call(ctxt, msg, **self.kwargs) | >| | File \"/usr/lib/python2.6/site-packages/nova/openstack/common/rpc/proxy.py\", line 126, in call | >| | result = rpc.call(context, real_topic, msg, timeout) | >| | File \"/usr/lib/python2.6/site-packages/nova/openstack/common/rpc/__init__.py\", line 139, in call | >| | return _get_impl().call(CONF, context, topic, msg, timeout) | >| | File \"/usr/lib/python2.6/site-packages/nova/openstack/common/rpc/impl_qpid.py\", line 783, in call | >| | rpc_amqp.get_connection_pool(conf, Connection)) | >| | File \"/usr/lib/python2.6/site-packages/nova/openstack/common/rpc/amqp.py\", line 574, in call | >| | rv = list(rv) | >| | File \"/usr/lib/python2.6/site-packages/nova/openstack/common/rpc/amqp.py\", line 539, in __iter__ | >| | raise result | >| | ", "created": "2014-04-02T16:59:54Z"} | >| flavor | m1.tiny (1) | >| hostId | a39c373fc95dfe03b9387eaca448e0410b3c5f060f7ceef59c04aca2 | >| id | 070e65b0-0b94-4dfe-8359-f46ec1c4172b | >| image | cirros-0.3.1-x86_64-uec (3e1056e3-81f2-4e9b-84ed-b78f7dcf5941) | >| key_name | - | >| metadata | {} | >| name | foo_vm | >| novanetwork network | | >| os-extended-volumes:volumes_attached | [] | >| security_groups | default | >| status | ERROR | >| tenant_id | 9cbbe7e41508451986a1a401dcaac268 | >| updated | 2014-04-02T16:59:54Z | >| user_id | 9ec3f851ecb340dca518cbcfae3b143c | >+--------------------------------------+-------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------+
<b>You cannot view the attachment while viewing its details because your browser does not support IFRAMEs. <a href="attachment.cgi?id=881912">View the attachment on a separate page</a>.</b>
View Attachment As Raw
Actions:
View
Attachments on
bug 1083675
: 881912