Errors associated with nova starting.

Asked by Havent on 2012-04-28

/var/log/syslog:
Apr 28 15:29:23 cc202 kernel: [107254.975874] init: nova-compute main process (27423) terminated with status 1
Apr 28 15:29:25 cc202 kernel: [107257.682464] init: nova-compute main process (27436) terminated with status 1
Apr 28 15:29:26 cc202 kernel: [107258.342480] init: nova-compute main process (27449) terminated with status 1
Apr 28 15:29:26 cc202 kernel: [107258.809095] init: nova-compute main process (27462) terminated with status 1
Apr 28 15:34:09 cc202 kernel: [107541.662575] init: keystone main process (5208) terminated with status 143
Apr 28 15:36:10 cc202 kernel: [107662.601144] init: keystone main process (27565) terminated with status 143
Apr 28 15:44:29 cc202 kernel: [108161.299635] init: nova-api main process (30123) terminated with status 1
Apr 28 15:44:30 cc202 kernel: [108162.401465] init: nova-api main process (30135) terminated with status 1
Apr 28 15:44:31 cc202 kernel: [108163.086635] init: nova-api main process (30147) terminated with status 1
Apr 28 15:44:31 cc202 kernel: [108163.577797] init: nova-api main process (30159) terminated with status 1

my nova.conf files as below:
[DEFAULT]

# LOGS/STATE
--verbose=True

# AUTHENTICATION
--auth_strategy=keystone

# SCHEDULER
--compute_scheduler_driver=nova.scheduler.filter_scheduler.FilterScheduler

# VOLUMES
--volume_group=nova-volumes
--volume_name_template=volume-%08x
--iscsi_helper=tgtadm

# DATABASE
--sql_connection=mysql://nova:passwd@localhost/nova

# COMPUTE
--libvirt_type=qemu
--connection_type=libvirt
--instance_name_template=instance-%08x
--api_paste_config=/etc/nova/api-paste.ini
--allow_resize_to_same_host=True

# APIS
--osapi_compute_extension=nova.api.openstack.compute.contrib.standard_extensions
--ec2_dmz_host=localhost
--s3_host=localhost

# RABBITMQ
--rabbit_host=localhost
#--rabbit_password=passwd

# GLANCE
--image_service=nova.image.glance.GlanceImageService
--glance_api_servers=localhost:9292

# NETWORK
--network_manager=nova.network.manager.FlatDHCPManager
--force_dhcp_release=True
--dhcpbridge_flagfile=/etc/nova/nova.conf
--firewall_driver=nova.virt.libvirt.firewall.IptablesFirewallDriver
--my_ip=localhost
--public_interface=br100
--vlan_interface=eth0
--flat_network_bridge=br100
--flat_interface=eth0
--fixed_range=192.168.200.0/24
--flat_network_dhcp_start=192.168.200.2
--public_interface=eth0
--flat_interface=eth0
--flat_network_bridge=br100

# NOVNC CONSOLE
--novncproxy_base_url=http://localhost:6080/vnc_auto.html
--vncserver_proxyclient_address=localhost
--vncserver_listen=localhost

so, what problem made it not work?
Thanks!

Question information

Language:
English Edit question
Status:
Expired
For:
OpenStack Compute (nova) Edit question
Assignee:
No assignee Edit question
Last query:
2012-05-06
Last reply:
2012-05-21
yong sheng gong (gongysh) said : #1

please add
log-dir=/var/log/nova
debug=true
into nova.conf and see what's in the log files

and also enable the log for keystone.

Or we can start the nova binaries by console to see the output on console.

koolhead17 (koolhead17) said : #2

chown -R nova:nova /etc/nova

restart all services and it will work.

Havent (guestly) said : #3

to koolhead17: It still doesn't work.
to yong sheng gong: It doesn't print any log.

Havent (guestly) said : #4

I checked the /var/log/nova/nova-network.log, it said:

2012-04-28 17:11:09 TRACE nova.manager Traceback (most recent call last):
2012-04-28 17:11:09 TRACE nova.manager File "/usr/lib/python2.7/dist-packages/nova/manager.py", line 155, in periodic_tasks
2012-04-28 17:11:09 TRACE nova.manager task(self, context)
2012-04-28 17:11:09 TRACE nova.manager File "/usr/lib/python2.7/dist-packages/nova/network/manager.py", line 776, in _disassociate_stale_fixed_ips
2012-04-28 17:11:09 TRACE nova.manager time)
2012-04-28 17:11:09 TRACE nova.manager File "/usr/lib/python2.7/dist-packages/nova/db/api.py", line 422, in fixed_ip_disassociate_all_by_timeout
2012-04-28 17:11:09 TRACE nova.manager return IMPL.fixed_ip_disassociate_all_by_timeout(context, host, time)
2012-04-28 17:11:09 TRACE nova.manager File "/usr/lib/python2.7/dist-packages/nova/db/sqlalchemy/api.py", line 102, in wrapper
2012-04-28 17:11:09 TRACE nova.manager return f(*args, **kwargs)
2012-04-28 17:11:09 TRACE nova.manager File "/usr/lib/python2.7/dist-packages/nova/db/sqlalchemy/api.py", line 1004, in fixed_ip_disassociate_all_by_timeout
2012-04-28 17:11:09 TRACE nova.manager filter(host_filter).\
2012-04-28 17:11:09 TRACE nova.manager File "/usr/lib/python2.7/dist-packages/sqlalchemy/orm/query.py", line 1947, in all
2012-04-28 17:11:09 TRACE nova.manager return list(self)
2012-04-28 17:11:09 TRACE nova.manager File "/usr/lib/python2.7/dist-packages/sqlalchemy/orm/query.py", line 2057, in __iter__
2012-04-28 17:11:09 TRACE nova.manager return self._execute_and_instances(context)
2012-04-28 17:11:09 TRACE nova.manager File "/usr/lib/python2.7/dist-packages/sqlalchemy/orm/query.py", line 2072, in _execute_and_instances
2012-04-28 17:11:09 TRACE nova.manager result = conn.execute(querycontext.statement, self._params)
2012-04-28 17:11:09 TRACE nova.manager File "/usr/lib/python2.7/dist-packages/sqlalchemy/engine/base.py", line 1405, in execute
2012-04-28 17:11:09 TRACE nova.manager params)
2012-04-28 17:11:09 TRACE nova.manager File "/usr/lib/python2.7/dist-packages/sqlalchemy/engine/base.py", line 1538, in _execute_clauseelement
2012-04-28 17:11:09 TRACE nova.manager compiled_sql, distilled_params
2012-04-28 17:11:09 TRACE nova.manager File "/usr/lib/python2.7/dist-packages/sqlalchemy/engine/base.py", line 1646, in _execute_context
2012-04-28 17:11:09 TRACE nova.manager context)
2012-04-28 17:11:09 TRACE nova.manager File "/usr/lib/python2.7/dist-packages/sqlalchemy/engine/base.py", line 1639, in _execute_context
2012-04-28 17:11:09 TRACE nova.manager context)
2012-04-28 17:11:09 TRACE nova.manager File "/usr/lib/python2.7/dist-packages/sqlalchemy/engine/default.py", line 330, in do_execute
2012-04-28 17:11:09 TRACE nova.manager cursor.execute(statement, parameters)
2012-04-28 17:11:09 TRACE nova.manager OperationalError: (OperationalError) no such table: fixed_ips u'SELECT fixed_ips.id AS fixed_ips_id \nFROM fixed_ips JOIN networks ON networks.id = fixed_ips.network_id JOIN instances ON instances.id = fixed_ips.instance_id \nWHERE fixed_ips.deleted = ? AND fixed_ips.allocated = ? AND fixed_ips.updated_at < ? AND (instances.host = ? AND networks.multi_host = ? OR networks.host = ?)' (0, 0, '2012-04-28 09:01:09.873187', 'cc202', 1, 'cc202')
2012-04-28 17:11:09 TRACE nova.manager

Havent (guestly) said : #5

I start:
nova-api
nova-compute
nova-network
nova-scheduler
nova-vncproxy
nova-volume

and copy the /var/log/upstart dir log as below:

nova-api:
2012-05-06 16:03:50 TRACE nova File "/usr/bin/nova-api", line 51, in <module>
2012-05-06 16:03:50 TRACE nova servers.append(service.WSGIService(api))
2012-05-06 16:03:50 TRACE nova File "/usr/lib/python2.7/dist-packages/nova/service.py", line 326, in __init__
2012-05-06 16:03:50 TRACE nova self.app = self.loader.load_app(name)
2012-05-06 16:03:50 TRACE nova File "/usr/lib/python2.7/dist-packages/nova/wsgi.py", line 388, in load_app
2012-05-06 16:03:50 TRACE nova return deploy.loadapp("config:%s" % self.config_path, name=name)
2012-05-06 16:03:50 TRACE nova File "/usr/lib/python2.7/dist-packages/paste/deploy/loadwsgi.py", line 247, in loadapp
2012-05-06 16:03:50 TRACE nova return loadobj(APP, uri, name=name, **kw)
2012-05-06 16:03:50 TRACE nova File "/usr/lib/python2.7/dist-packages/paste/deploy/loadwsgi.py", line 272, in loadobj
2012-05-06 16:03:50 TRACE nova return context.create()
2012-05-06 16:03:50 TRACE nova File "/usr/lib/python2.7/dist-packages/paste/deploy/loadwsgi.py", line 710, in create
2012-05-06 16:03:50 TRACE nova return self.object_type.invoke(self)
2012-05-06 16:03:50 TRACE nova File "/usr/lib/python2.7/dist-packages/paste/deploy/loadwsgi.py", line 144, in invoke
2012-05-06 16:03:50 TRACE nova **context.local_conf)
2012-05-06 16:03:50 TRACE nova File "/usr/lib/python2.7/dist-packages/paste/deploy/util.py", line 56, in fix_call
2012-05-06 16:03:50 TRACE nova val = callable(*args, **kw)
2012-05-06 16:03:50 TRACE nova File "/usr/lib/python2.7/dist-packages/paste/urlmap.py", line 25, in urlmap_factory
2012-05-06 16:03:50 TRACE nova app = loader.get_app(app_name, global_conf=global_conf)
2012-05-06 16:03:50 TRACE nova File "/usr/lib/python2.7/dist-packages/paste/deploy/loadwsgi.py", line 350, in get_app
2012-05-06 16:03:50 TRACE nova name=name, global_conf=global_conf).create()
2012-05-06 16:03:50 TRACE nova File "/usr/lib/python2.7/dist-packages/paste/deploy/loadwsgi.py", line 362, in app_context
2012-05-06 16:03:50 TRACE nova APP, name=name, global_conf=global_conf)
2012-05-06 16:03:50 TRACE nova File "/usr/lib/python2.7/dist-packages/paste/deploy/loadwsgi.py", line 450, in get_context
2012-05-06 16:03:50 TRACE nova global_additions=global_additions)
2012-05-06 16:03:50 TRACE nova File "/usr/lib/python2.7/dist-packages/paste/deploy/loadwsgi.py", line 559, in _pipeline_app_context
2012-05-06 16:03:50 TRACE nova APP, pipeline[-1], global_conf)
2012-05-06 16:03:50 TRACE nova File "/usr/lib/python2.7/dist-packages/paste/deploy/loadwsgi.py", line 458, in get_context
2012-05-06 16:03:50 TRACE nova section)
2012-05-06 16:03:50 TRACE nova File "/usr/lib/python2.7/dist-packages/paste/deploy/loadwsgi.py", line 517, in _context_from_explicit
2012-05-06 16:03:50 TRACE nova value = import_string(found_expr)
2012-05-06 16:03:50 TRACE nova File "/usr/lib/python2.7/dist-packages/paste/deploy/loadwsgi.py", line 22, in import_string
2012-05-06 16:03:50 TRACE nova return pkg_resources.EntryPoint.parse("x=" + s).load(False)
2012-05-06 16:03:50 TRACE nova File "/usr/lib/python2.7/dist-packages/pkg_resources.py", line 1989, in load
2012-05-06 16:03:50 TRACE nova entry = __import__(self.module_name, globals(),globals(), ['__name__'])
2012-05-06 16:03:50 TRACE nova ImportError: No module named metadatarequesthandler
2012-05-06 16:03:50 TRACE nova
Exception KeyError: KeyError(140482343790608,) in <module 'threading' from '/usr/lib/python2.7/threading.pyc'> ignored

nova-compute:
2012-05-06 16:08:35 TRACE nova.rpc.common
2012-05-06 16:08:37 INFO nova.rpc.common [-] Reconnecting to AMQP server on localhost:5672
2012-05-06 16:08:40 ERROR nova.rpc.common [-] AMQP server on localhost:5672 is unreachable: Socket closed. Trying again in 3 seconds.
2012-05-06 16:08:40 TRACE nova.rpc.common Traceback (most recent call last):
2012-05-06 16:08:40 TRACE nova.rpc.common File "/usr/lib/python2.7/dist-packages/nova/rpc/impl_kombu.py", line 446, in reconnect
2012-05-06 16:08:40 TRACE nova.rpc.common self._connect()
2012-05-06 16:08:40 TRACE nova.rpc.common File "/usr/lib/python2.7/dist-packages/nova/rpc/impl_kombu.py", line 423, in _connect
2012-05-06 16:08:40 TRACE nova.rpc.common self.connection.connect()
2012-05-06 16:08:40 TRACE nova.rpc.common File "/usr/lib/python2.7/dist-packages/kombu/connection.py", line 154, in connect
2012-05-06 16:08:40 TRACE nova.rpc.common return self.connection
2012-05-06 16:08:40 TRACE nova.rpc.common File "/usr/lib/python2.7/dist-packages/kombu/connection.py", line 560, in connection
2012-05-06 16:08:40 TRACE nova.rpc.common self._connection = self._establish_connection()
2012-05-06 16:08:40 TRACE nova.rpc.common File "/usr/lib/python2.7/dist-packages/kombu/connection.py", line 521, in _establish_connection
2012-05-06 16:08:40 TRACE nova.rpc.common conn = self.transport.establish_connection()
2012-05-06 16:08:40 TRACE nova.rpc.common File "/usr/lib/python2.7/dist-packages/kombu/transport/pyamqplib.py", line 255, in establish_connection
2012-05-06 16:08:40 TRACE nova.rpc.common connect_timeout=conninfo.connect_timeout)
2012-05-06 16:08:40 TRACE nova.rpc.common File "/usr/lib/python2.7/dist-packages/kombu/transport/pyamqplib.py", line 52, in __init__
2012-05-06 16:08:40 TRACE nova.rpc.common super(Connection, self).__init__(*args, **kwargs)
2012-05-06 16:08:40 TRACE nova.rpc.common File "/usr/lib/python2.7/dist-packages/amqplib/client_0_8/connection.py", line 144, in __init__
2012-05-06 16:08:40 TRACE nova.rpc.common (10, 30), # tune
2012-05-06 16:08:40 TRACE nova.rpc.common File "/usr/lib/python2.7/dist-packages/amqplib/client_0_8/abstract_channel.py", line 95, in wait
2012-05-06 16:08:40 TRACE nova.rpc.common self.channel_id, allowed_methods)
2012-05-06 16:08:40 TRACE nova.rpc.common File "/usr/lib/python2.7/dist-packages/amqplib/client_0_8/connection.py", line 202, in _wait_method
2012-05-06 16:08:40 TRACE nova.rpc.common self.method_reader.read_method()
2012-05-06 16:08:40 TRACE nova.rpc.common File "/usr/lib/python2.7/dist-packages/amqplib/client_0_8/method_framing.py", line 221, in read_method
2012-05-06 16:08:40 TRACE nova.rpc.common raise m
2012-05-06 16:08:40 TRACE nova.rpc.common IOError: Socket closed
2012-05-06 16:08:40 TRACE nova.rpc.common
2012-05-06 16:08:43 INFO nova.rpc.common [-] Reconnecting to AMQP server on localhost:5672

nova-network:
2012-05-06 16:09:32 TRACE nova File "/usr/bin/nova-network", line 49, in <module>
2012-05-06 16:09:32 TRACE nova service.wait()
2012-05-06 16:09:32 TRACE nova File "/usr/lib/python2.7/dist-packages/nova/service.py", line 413, in wait
2012-05-06 16:09:32 TRACE nova _launcher.wait()
2012-05-06 16:09:32 TRACE nova File "/usr/lib/python2.7/dist-packages/nova/service.py", line 131, in wait
2012-05-06 16:09:32 TRACE nova service.wait()
2012-05-06 16:09:32 TRACE nova File "/usr/lib/python2.7/dist-packages/eventlet/greenthread.py", line 166, in wait
2012-05-06 16:09:32 TRACE nova return self._exit_event.wait()
2012-05-06 16:09:32 TRACE nova File "/usr/lib/python2.7/dist-packages/eventlet/event.py", line 116, in wait
2012-05-06 16:09:32 TRACE nova return hubs.get_hub().switch()
2012-05-06 16:09:32 TRACE nova File "/usr/lib/python2.7/dist-packages/eventlet/hubs/hub.py", line 177, in switch
2012-05-06 16:09:32 TRACE nova return self.greenlet.switch()
2012-05-06 16:09:32 TRACE nova File "/usr/lib/python2.7/dist-packages/eventlet/greenthread.py", line 192, in main
2012-05-06 16:09:32 TRACE nova result = function(*args, **kwargs)
2012-05-06 16:09:32 TRACE nova File "/usr/lib/python2.7/dist-packages/nova/service.py", line 101, in run_server
2012-05-06 16:09:32 TRACE nova server.start()
2012-05-06 16:09:32 TRACE nova File "/usr/lib/python2.7/dist-packages/nova/service.py", line 162, in start
2012-05-06 16:09:32 TRACE nova self.manager.init_host()
2012-05-06 16:09:32 TRACE nova File "/usr/lib/python2.7/dist-packages/nova/network/manager.py", line 1706, in init_host
2012-05-06 16:09:32 TRACE nova self.l3driver.initialize()
2012-05-06 16:09:32 TRACE nova File "/usr/lib/python2.7/dist-packages/nova/network/l3.py", line 84, in initialize
2012-05-06 16:09:32 TRACE nova linux_net.init_host()
2012-05-06 16:09:32 TRACE nova File "/usr/lib/python2.7/dist-packages/nova/network/linux_net.py", line 442, in init_host
2012-05-06 16:09:32 TRACE nova add_snat_rule(ip_range)
2012-05-06 16:09:32 TRACE nova File "/usr/lib/python2.7/dist-packages/nova/network/linux_net.py", line 432, in add_snat_rule
2012-05-06 16:09:32 TRACE nova iptables_manager.apply()
2012-05-06 16:09:32 TRACE nova File "/usr/lib/python2.7/dist-packages/nova/utils.py", line 939, in inner
2012-05-06 16:09:32 TRACE nova with lock:
2012-05-06 16:09:32 TRACE nova File "/usr/lib/python2.7/dist-packages/lockfile.py", line 223, in __enter__
2012-05-06 16:09:32 TRACE nova self.acquire()
2012-05-06 16:09:32 TRACE nova File "/usr/lib/python2.7/dist-packages/lockfile.py", line 239, in acquire
2012-05-06 16:09:32 TRACE nova raise LockFailed("failed to create %s" % self.unique_name)
2012-05-06 16:09:32 TRACE nova LockFailed: failed to create /usr/lib/python2.7/dist-packages/cc202-32b50d-32b4160.2819
2012-05-06 16:09:32 TRACE nova
Exception KeyError: KeyError(139891220817840,) in <module 'threading' from '/usr/lib/python2.7/threading.pyc'> ignored

nova-scheduler:
2012-05-06 16:10:38 TRACE nova.rpc.common Traceback (most recent call last):
2012-05-06 16:10:38 TRACE nova.rpc.common File "/usr/lib/python2.7/dist-packages/nova/rpc/impl_kombu.py", line 446, in reconnect
2012-05-06 16:10:38 TRACE nova.rpc.common self._connect()
2012-05-06 16:10:38 TRACE nova.rpc.common File "/usr/lib/python2.7/dist-packages/nova/rpc/impl_kombu.py", line 423, in _connect
2012-05-06 16:10:38 TRACE nova.rpc.common self.connection.connect()
2012-05-06 16:10:38 TRACE nova.rpc.common File "/usr/lib/python2.7/dist-packages/kombu/connection.py", line 154, in connect
2012-05-06 16:10:38 TRACE nova.rpc.common return self.connection
2012-05-06 16:10:38 TRACE nova.rpc.common File "/usr/lib/python2.7/dist-packages/kombu/connection.py", line 560, in connection
2012-05-06 16:10:38 TRACE nova.rpc.common self._connection = self._establish_connection()
2012-05-06 16:10:38 TRACE nova.rpc.common File "/usr/lib/python2.7/dist-packages/kombu/connection.py", line 521, in _establish_connection
2012-05-06 16:10:38 TRACE nova.rpc.common conn = self.transport.establish_connection()
2012-05-06 16:10:38 TRACE nova.rpc.common File "/usr/lib/python2.7/dist-packages/kombu/transport/pyamqplib.py", line 255, in establish_connection
2012-05-06 16:10:38 TRACE nova.rpc.common connect_timeout=conninfo.connect_timeout)
2012-05-06 16:10:38 TRACE nova.rpc.common File "/usr/lib/python2.7/dist-packages/kombu/transport/pyamqplib.py", line 52, in __init__
2012-05-06 16:10:38 TRACE nova.rpc.common super(Connection, self).__init__(*args, **kwargs)
2012-05-06 16:10:38 TRACE nova.rpc.common File "/usr/lib/python2.7/dist-packages/amqplib/client_0_8/connection.py", line 144, in __init__
2012-05-06 16:10:38 TRACE nova.rpc.common (10, 30), # tune
2012-05-06 16:10:38 TRACE nova.rpc.common File "/usr/lib/python2.7/dist-packages/amqplib/client_0_8/abstract_channel.py", line 95, in wait
2012-05-06 16:10:38 TRACE nova.rpc.common self.channel_id, allowed_methods)
2012-05-06 16:10:38 TRACE nova.rpc.common File "/usr/lib/python2.7/dist-packages/amqplib/client_0_8/connection.py", line 202, in _wait_method
2012-05-06 16:10:38 TRACE nova.rpc.common self.method_reader.read_method()
2012-05-06 16:10:38 TRACE nova.rpc.common File "/usr/lib/python2.7/dist-packages/amqplib/client_0_8/method_framing.py", line 221, in read_method
2012-05-06 16:10:38 TRACE nova.rpc.common raise m
2012-05-06 16:10:38 TRACE nova.rpc.common IOError: Socket closed
2012-05-06 16:10:38 TRACE nova.rpc.common

nova-vncproxy:(only this process can be start with no error)
2012-05-06 16:01:15 DEBUG nova.service [-] api_paste_config : /etc/nova/api-paste.ini from (pid=2548) wait /usr/lib/python2.7/dist-packages/nova/service.py:411
2012-05-06 16:01:15 DEBUG nova.service [-] rabbit_virtual_host : / from (pid=2548) wait /usr/lib/python2.7/dist-packages/nova/service.py:411
2012-05-06 16:01:15 DEBUG nova.service [-] network_driver : nova.network.linux_net from (pid=2548) wait /usr/lib/python2.7/dist-packages/nova/service.py:411
2012-05-06 16:01:15 DEBUG nova.service [-] vnc_keymap : FLAG SET from (pid=2548) wait /usr/lib/python2.7/dist-packages/nova/service.py:409
2012-05-06 16:01:15 DEBUG nova.service [-] image_service : nova.image.glance.GlanceImageService from (pid=2548) wait /usr/lib/python2.7/dist-packages/nova/service.py:411
2012-05-06 16:01:15 DEBUG nova.service [-] control_exchange : nova from (pid=2548) wait /usr/lib/python2.7/dist-packages/nova/service.py:411
2012-05-06 16:01:15 DEBUG nova.service [-] log_file : None from (pid=2548) wait /usr/lib/python2.7/dist-packages/nova/service.py:411
2012-05-06 16:01:15 DEBUG nova.service [-] compute_manager : nova.compute.manager.ComputeManager from (pid=2548) wait /usr/lib/python2.7/dist-packages/nova/service.py:411
2012-05-06 16:01:15 DEBUG nova.service [-] network_topic : network from (pid=2548) wait /usr/lib/python2.7/dist-packages/nova/service.py:411
2012-05-06 16:01:15 INFO nova.wsgi [-] Started XCP VNC Proxy on 0.0.0.0:6081

nova-volume:
2012-05-06 16:12:35 TRACE nova Traceback (most recent call last):
2012-05-06 16:12:35 TRACE nova File "/usr/bin/nova-volume", line 49, in <module>
2012-05-06 16:12:35 TRACE nova service.wait()
2012-05-06 16:12:35 TRACE nova File "/usr/lib/python2.7/dist-packages/nova/service.py", line 413, in wait
2012-05-06 16:12:35 TRACE nova _launcher.wait()
2012-05-06 16:12:35 TRACE nova File "/usr/lib/python2.7/dist-packages/nova/service.py", line 131, in wait
2012-05-06 16:12:35 TRACE nova service.wait()
2012-05-06 16:12:35 TRACE nova File "/usr/lib/python2.7/dist-packages/eventlet/greenthread.py", line 166, in wait
2012-05-06 16:12:35 TRACE nova return self._exit_event.wait()
2012-05-06 16:12:35 TRACE nova File "/usr/lib/python2.7/dist-packages/eventlet/event.py", line 116, in wait
2012-05-06 16:12:35 TRACE nova return hubs.get_hub().switch()
2012-05-06 16:12:35 TRACE nova File "/usr/lib/python2.7/dist-packages/eventlet/hubs/hub.py", line 177, in switch
2012-05-06 16:12:35 TRACE nova return self.greenlet.switch()
2012-05-06 16:12:35 TRACE nova File "/usr/lib/python2.7/dist-packages/eventlet/greenthread.py", line 192, in main
2012-05-06 16:12:35 TRACE nova result = function(*args, **kwargs)
2012-05-06 16:12:35 TRACE nova File "/usr/lib/python2.7/dist-packages/nova/service.py", line 101, in run_server
2012-05-06 16:12:35 TRACE nova server.start()
2012-05-06 16:12:35 TRACE nova File "/usr/lib/python2.7/dist-packages/nova/service.py", line 162, in start
2012-05-06 16:12:35 TRACE nova self.manager.init_host()
2012-05-06 16:12:35 TRACE nova File "/usr/lib/python2.7/dist-packages/nova/volume/manager.py", line 93, in init_host
2012-05-06 16:12:35 TRACE nova self.driver.check_for_setup_error()
2012-05-06 16:12:35 TRACE nova File "/usr/lib/python2.7/dist-packages/nova/volume/driver.py", line 103, in check_for_setup_error
2012-05-06 16:12:35 TRACE nova run_as_root=True)
2012-05-06 16:12:35 TRACE nova File "/usr/lib/python2.7/dist-packages/nova/utils.py", line 242, in execute
2012-05-06 16:12:35 TRACE nova cmd=' '.join(cmd))
2012-05-06 16:12:35 TRACE nova ProcessExecutionError: Unexpected error while running command.
2012-05-06 16:12:35 TRACE nova Command: sudo vgs --noheadings -o name
2012-05-06 16:12:35 TRACE nova Exit code: 1
2012-05-06 16:12:35 TRACE nova Stdout: ''
2012-05-06 16:12:35 TRACE nova Stderr: 'sudo: no tty present and no askpass program specified\nSorry, try again.\nsudo: no tty present and no askpass program specified\nSorry, try again.\nsudo: no tty present and no askpass program specified\nSorry, try again.\nsudo: 3 incorrect password attempts\n'
2012-05-06 16:12:35 TRACE nova
Exception KeyError: KeyError(140145708697520,) in <module 'threading' from '/usr/lib/python2.7/threading.pyc'> ignored

Launchpad Janitor (janitor) said : #6

This question was expired because it remained in the 'Open' state without activity for the last 15 days.

Lorin Hochstein (lorinh) said : #7

This error messages suggests that nova doesn't have sudo privileges. If you installed from packages on ubuntu, then add the following line to nova.conf:

root_helper=sudo nova-rootwrap

Aimon Bustardo (aimonb) said : #8

Correct solution is to remove the Defaults requiretty from /etc/sudoers.