[Bug 1429739] Re: neutron-server does not start: OperationalError: (OperationalError) no such table: ml2_vlan_allocations

Mon Mar 9 07:58:07 UTC 2015

In fact this happens also under upstart, so it's not init specific.

** Tags removed: systemd-boot

** Also affects: neutron (Ubuntu Vivid)
   Importance: High
       Status: New

** Changed in: neutron (Ubuntu Vivid)
     Assignee: (unassigned) => James Page (james-page)

** Description changed:

- Installing neutron-server under systemd leads to several failed startup
- attemps and eventual failure. journalctl -u neutron-server shows:
+ Installing neutron-server (under systemd or upstart) leads to several
+ failed startup attemps and eventual failure. journalctl -u neutron-
+ server shows:

  Mar 09 08:53:33 autopkgtest neutron-server[2776]: 2015-03-09 08:53:33.948 2776 TRACE neutron Traceback (most recent call last):
  Mar 09 08:53:33 autopkgtest neutron-server[2776]: 2015-03-09 08:53:33.948 2776 TRACE neutron   File "/usr/bin/neutron-server", line 10, in <module>
  Mar 09 08:53:33 autopkgtest neutron-server[2776]: 2015-03-09 08:53:33.948 2776 TRACE neutron     sys.exit(main())
  Mar 09 08:53:33 autopkgtest neutron-server[2776]: 2015-03-09 08:53:33.948 2776 TRACE neutron   File "/usr/lib/python2.7/dist-packages/neutron/server/__init__.py", line 46, in main
  Mar 09 08:53:33 autopkgtest neutron-server[2776]: 2015-03-09 08:53:33.948 2776 TRACE neutron     neutron_api = service.serve_wsgi(service.NeutronApiService)
  Mar 09 08:53:33 autopkgtest neutron-server[2776]: 2015-03-09 08:53:33.948 2776 TRACE neutron   File "/usr/lib/python2.7/dist-packages/neutron/service.py", line 106, in serve_wsgi
  Mar 09 08:53:33 autopkgtest neutron-server[2776]: 2015-03-09 08:53:33.948 2776 TRACE neutron     LOG.exception(_LE('Unrecoverable error: please check log '
  Mar 09 08:53:33 autopkgtest neutron-server[2776]: 2015-03-09 08:53:33.948 2776 TRACE neutron   File "/usr/lib/python2.7/dist-packages/oslo_utils/excutils.py", line 82, in __exit__
  Mar 09 08:53:33 autopkgtest neutron-server[2776]: 2015-03-09 08:53:33.948 2776 TRACE neutron     six.reraise(self.type_, self.value, self.tb)
  Mar 09 08:53:33 autopkgtest neutron-server[2776]: 2015-03-09 08:53:33.948 2776 TRACE neutron   File "/usr/lib/python2.7/dist-packages/neutron/service.py", line 103, in serve_wsgi
  Mar 09 08:53:33 autopkgtest neutron-server[2776]: 2015-03-09 08:53:33.948 2776 TRACE neutron     service.start()
  Mar 09 08:53:33 autopkgtest neutron-server[2776]: 2015-03-09 08:53:33.948 2776 TRACE neutron   File "/usr/lib/python2.7/dist-packages/neutron/service.py", line 74, in start
  Mar 09 08:53:33 autopkgtest neutron-server[2776]: 2015-03-09 08:53:33.948 2776 TRACE neutron     self.wsgi_app = _run_wsgi(self.app_name)
  Mar 09 08:53:33 autopkgtest neutron-server[2776]: 2015-03-09 08:53:33.948 2776 TRACE neutron   File "/usr/lib/python2.7/dist-packages/neutron/service.py", line 169, in _run_wsgi
  Mar 09 08:53:33 autopkgtest neutron-server[2776]: 2015-03-09 08:53:33.948 2776 TRACE neutron     app = config.load_paste_app(app_name)
  Mar 09 08:53:33 autopkgtest neutron-server[2776]: 2015-03-09 08:53:33.948 2776 TRACE neutron   File "/usr/lib/python2.7/dist-packages/neutron/common/config.py", line 192, in load_paste_app
  Mar 09 08:53:33 autopkgtest neutron-server[2776]: 2015-03-09 08:53:33.948 2776 TRACE neutron     app = deploy.loadapp("config:%s" % config_path, name=app_name)
  Mar 09 08:53:33 autopkgtest neutron-server[2776]: 2015-03-09 08:53:33.948 2776 TRACE neutron   File "/usr/lib/python2.7/dist-packages/paste/deploy/loadwsgi.py", line 247, in loadapp
  Mar 09 08:53:33 autopkgtest neutron-server[2776]: 2015-03-09 08:53:33.948 2776 TRACE neutron     return loadobj(APP, uri, name=name, **kw)
  Mar 09 08:53:33 autopkgtest neutron-server[2776]: 2015-03-09 08:53:33.948 2776 TRACE neutron   File "/usr/lib/python2.7/dist-packages/paste/deploy/loadwsgi.py", line 272, in loadobj
  Mar 09 08:53:33 autopkgtest neutron-server[2776]: 2015-03-09 08:53:33.948 2776 TRACE neutron     return context.create()
  Mar 09 08:53:33 autopkgtest neutron-server[2776]: 2015-03-09 08:53:33.948 2776 TRACE neutron   File "/usr/lib/python2.7/dist-packages/paste/deploy/loadwsgi.py", line 710, in create
  Mar 09 08:53:33 autopkgtest neutron-server[2776]: 2015-03-09 08:53:33.948 2776 TRACE neutron     return self.object_type.invoke(self)
  Mar 09 08:53:33 autopkgtest neutron-server[2776]: 2015-03-09 08:53:33.948 2776 TRACE neutron   File "/usr/lib/python2.7/dist-packages/paste/deploy/loadwsgi.py", line 144, in invoke
  Mar 09 08:53:33 autopkgtest neutron-server[2776]: 2015-03-09 08:53:33.948 2776 TRACE neutron     **context.local_conf)
  Mar 09 08:53:33 autopkgtest neutron-server[2776]: 2015-03-09 08:53:33.948 2776 TRACE neutron   File "/usr/lib/python2.7/dist-packages/paste/deploy/util.py", line 55, in fix_call
  Mar 09 08:53:33 autopkgtest neutron-server[2776]: 2015-03-09 08:53:33.948 2776 TRACE neutron     val = callable(*args, **kw)
  Mar 09 08:53:33 autopkgtest neutron-server[2776]: 2015-03-09 08:53:33.948 2776 TRACE neutron   File "/usr/lib/python2.7/dist-packages/paste/urlmap.py", line 28, in urlmap_factory
  Mar 09 08:53:33 autopkgtest neutron-server[2776]: 2015-03-09 08:53:33.948 2776 TRACE neutron     app = loader.get_app(app_name, global_conf=global_conf)
  Mar 09 08:53:33 autopkgtest neutron-server[2776]: 2015-03-09 08:53:33.948 2776 TRACE neutron   File "/usr/lib/python2.7/dist-packages/paste/deploy/loadwsgi.py", line 350, in get_app
  Mar 09 08:53:33 autopkgtest neutron-server[2776]: 2015-03-09 08:53:33.948 2776 TRACE neutron     name=name, global_conf=global_conf).create()
  Mar 09 08:53:33 autopkgtest neutron-server[2776]: 2015-03-09 08:53:33.948 2776 TRACE neutron   File "/usr/lib/python2.7/dist-packages/paste/deploy/loadwsgi.py", line 710, in create
  Mar 09 08:53:33 autopkgtest neutron-server[2776]: 2015-03-09 08:53:33.948 2776 TRACE neutron     return self.object_type.invoke(self)
  Mar 09 08:53:33 autopkgtest neutron-server[2776]: 2015-03-09 08:53:33.948 2776 TRACE neutron   File "/usr/lib/python2.7/dist-packages/paste/deploy/loadwsgi.py", line 144, in invoke
  Mar 09 08:53:33 autopkgtest neutron-server[2776]: 2015-03-09 08:53:33.948 2776 TRACE neutron     **context.local_conf)
  Mar 09 08:53:33 autopkgtest neutron-server[2776]: 2015-03-09 08:53:33.948 2776 TRACE neutron   File "/usr/lib/python2.7/dist-packages/paste/deploy/util.py", line 55, in fix_call
  Mar 09 08:53:33 autopkgtest neutron-server[2776]: 2015-03-09 08:53:33.948 2776 TRACE neutron     val = callable(*args, **kw)
  Mar 09 08:53:33 autopkgtest neutron-server[2776]: 2015-03-09 08:53:33.948 2776 TRACE neutron   File "/usr/lib/python2.7/dist-packages/neutron/auth.py", line 71, in pipeline_factory
  Mar 09 08:53:33 autopkgtest neutron-server[2776]: 2015-03-09 08:53:33.948 2776 TRACE neutron     app = loader.get_app(pipeline[-1])
  Mar 09 08:53:33 autopkgtest neutron-server[2776]: 2015-03-09 08:53:33.948 2776 TRACE neutron   File "/usr/lib/python2.7/dist-packages/paste/deploy/loadwsgi.py", line 350, in get_app
  Mar 09 08:53:33 autopkgtest neutron-server[2776]: 2015-03-09 08:53:33.948 2776 TRACE neutron     name=name, global_conf=global_conf).create()
  Mar 09 08:53:33 autopkgtest neutron-server[2776]: 2015-03-09 08:53:33.948 2776 TRACE neutron   File "/usr/lib/python2.7/dist-packages/paste/deploy/loadwsgi.py", line 710, in create
  Mar 09 08:53:33 autopkgtest neutron-server[2776]: 2015-03-09 08:53:33.948 2776 TRACE neutron     return self.object_type.invoke(self)
  Mar 09 08:53:33 autopkgtest neutron-server[2776]: 2015-03-09 08:53:33.948 2776 TRACE neutron   File "/usr/lib/python2.7/dist-packages/paste/deploy/loadwsgi.py", line 146, in invoke
  Mar 09 08:53:33 autopkgtest neutron-server[2776]: 2015-03-09 08:53:33.948 2776 TRACE neutron     return fix_call(context.object, context.global_conf, **context.local_conf)
  Mar 09 08:53:33 autopkgtest neutron-server[2776]: 2015-03-09 08:53:33.948 2776 TRACE neutron   File "/usr/lib/python2.7/dist-packages/paste/deploy/util.py", line 55, in fix_call
  Mar 09 08:53:33 autopkgtest neutron-server[2776]: 2015-03-09 08:53:33.948 2776 TRACE neutron     val = callable(*args, **kw)
  Mar 09 08:53:33 autopkgtest neutron-server[2776]: 2015-03-09 08:53:33.948 2776 TRACE neutron   File "/usr/lib/python2.7/dist-packages/neutron/api/v2/router.py", line 70, in factory
  Mar 09 08:53:33 autopkgtest neutron-server[2776]: 2015-03-09 08:53:33.948 2776 TRACE neutron     return cls(**local_config)
  Mar 09 08:53:33 autopkgtest neutron-server[2776]: 2015-03-09 08:53:33.948 2776 TRACE neutron   File "/usr/lib/python2.7/dist-packages/neutron/api/v2/router.py", line 74, in __init__
  Mar 09 08:53:33 autopkgtest neutron-server[2776]: 2015-03-09 08:53:33.948 2776 TRACE neutron     plugin = manager.NeutronManager.get_plugin()
  Mar 09 08:53:33 autopkgtest neutron-server[2776]: 2015-03-09 08:53:33.948 2776 TRACE neutron   File "/usr/lib/python2.7/dist-packages/neutron/manager.py", line 222, in get_plugin
  Mar 09 08:53:33 autopkgtest neutron-server[2776]: 2015-03-09 08:53:33.948 2776 TRACE neutron     return weakref.proxy(cls.get_instance().plugin)
  Mar 09 08:53:33 autopkgtest neutron-server[2776]: 2015-03-09 08:53:33.948 2776 TRACE neutron   File "/usr/lib/python2.7/dist-packages/neutron/manager.py", line 216, in get_instance
  Mar 09 08:53:33 autopkgtest neutron-server[2776]: 2015-03-09 08:53:33.948 2776 TRACE neutron     cls._create_instance()
  Mar 09 08:53:33 autopkgtest neutron-server[2776]: 2015-03-09 08:53:33.948 2776 TRACE neutron   File "/usr/lib/python2.7/dist-packages/oslo_concurrency/lockutils.py", line 431, in inner
  Mar 09 08:53:33 autopkgtest neutron-server[2776]: 2015-03-09 08:53:33.948 2776 TRACE neutron     return f(*args, **kwargs)
  Mar 09 08:53:33 autopkgtest neutron-server[2776]: 2015-03-09 08:53:33.948 2776 TRACE neutron   File "/usr/lib/python2.7/dist-packages/neutron/manager.py", line 202, in _create_instance
  Mar 09 08:53:33 autopkgtest neutron-server[2776]: 2015-03-09 08:53:33.948 2776 TRACE neutron     cls._instance = cls()
  Mar 09 08:53:33 autopkgtest neutron-server[2776]: 2015-03-09 08:53:33.948 2776 TRACE neutron   File "/usr/lib/python2.7/dist-packages/neutron/manager.py", line 117, in __init__
  Mar 09 08:53:33 autopkgtest neutron-server[2776]: 2015-03-09 08:53:33.948 2776 TRACE neutron     plugin_provider)
  Mar 09 08:53:33 autopkgtest neutron-server[2776]: 2015-03-09 08:53:33.948 2776 TRACE neutron   File "/usr/lib/python2.7/dist-packages/neutron/manager.py", line 143, in _get_plugin_instance
  Mar 09 08:53:33 autopkgtest neutron-server[2776]: 2015-03-09 08:53:33.948 2776 TRACE neutron     return plugin_class()
  Mar 09 08:53:33 autopkgtest neutron-server[2776]: 2015-03-09 08:53:33.948 2776 TRACE neutron   File "/usr/lib/python2.7/dist-packages/neutron/plugins/ml2/plugin.py", line 126, in __init__
  Mar 09 08:53:33 autopkgtest neutron-server[2776]: 2015-03-09 08:53:33.948 2776 TRACE neutron     self.type_manager.initialize()
  Mar 09 08:53:33 autopkgtest neutron-server[2776]: 2015-03-09 08:53:33.948 2776 TRACE neutron   File "/usr/lib/python2.7/dist-packages/neutron/plugins/ml2/managers.py", line 139, in initialize
  Mar 09 08:53:33 autopkgtest neutron-server[2776]: 2015-03-09 08:53:33.948 2776 TRACE neutron     driver.obj.initialize()
  Mar 09 08:53:33 autopkgtest neutron-server[2776]: 2015-03-09 08:53:33.948 2776 TRACE neutron   File "/usr/lib/python2.7/dist-packages/neutron/plugins/ml2/drivers/type_vlan.py", line 165, in initialize
  Mar 09 08:53:33 autopkgtest neutron-server[2776]: 2015-03-09 08:53:33.948 2776 TRACE neutron     self._sync_vlan_allocations()
  Mar 09 08:53:33 autopkgtest neutron-server[2776]: 2015-03-09 08:53:33.948 2776 TRACE neutron   File "/usr/lib/python2.7/dist-packages/neutron/plugins/ml2/drivers/type_vlan.py", line 108, in _sync_vlan_allocations
  Mar 09 08:53:33 autopkgtest neutron-server[2776]: 2015-03-09 08:53:33.948 2776 TRACE neutron     for alloc in allocs:
  Mar 09 08:53:33 autopkgtest neutron-server[2776]: 2015-03-09 08:53:33.948 2776 TRACE neutron   File "/usr/lib/python2.7/dist-packages/sqlalchemy/orm/query.py", line 2438, in __iter__
  Mar 09 08:53:33 autopkgtest neutron-server[2776]: 2015-03-09 08:53:33.948 2776 TRACE neutron     return self._execute_and_instances(context)
  Mar 09 08:53:33 autopkgtest neutron-server[2776]: 2015-03-09 08:53:33.948 2776 TRACE neutron   File "/usr/lib/python2.7/dist-packages/sqlalchemy/orm/query.py", line 2453, in _execute_and_instances
  Mar 09 08:53:33 autopkgtest neutron-server[2776]: 2015-03-09 08:53:33.948 2776 TRACE neutron     result = conn.execute(querycontext.statement, self._params)
  Mar 09 08:53:33 autopkgtest neutron-server[2776]: 2015-03-09 08:53:33.948 2776 TRACE neutron   File "/usr/lib/python2.7/dist-packages/sqlalchemy/engine/base.py", line 729, in execute
  Mar 09 08:53:33 autopkgtest neutron-server[2776]: 2015-03-09 08:53:33.948 2776 TRACE neutron     return meth(self, multiparams, params)
  Mar 09 08:53:33 autopkgtest neutron-server[2776]: 2015-03-09 08:53:33.948 2776 TRACE neutron   File "/usr/lib/python2.7/dist-packages/sqlalchemy/sql/elements.py", line 322, in _execute_on_connection
  Mar 09 08:53:33 autopkgtest neutron-server[2776]: 2015-03-09 08:53:33.948 2776 TRACE neutron     return connection._execute_clauseelement(self, multiparams, params)
  Mar 09 08:53:33 autopkgtest neutron-server[2776]: 2015-03-09 08:53:33.948 2776 TRACE neutron   File "/usr/lib/python2.7/dist-packages/sqlalchemy/engine/base.py", line 826, in _execute_clauseelement
  Mar 09 08:53:33 autopkgtest neutron-server[2776]: 2015-03-09 08:53:33.948 2776 TRACE neutron     compiled_sql, distilled_params
  Mar 09 08:53:33 autopkgtest neutron-server[2776]: 2015-03-09 08:53:33.948 2776 TRACE neutron   File "/usr/lib/python2.7/dist-packages/sqlalchemy/engine/base.py", line 958, in _execute_context
  Mar 09 08:53:33 autopkgtest neutron-server[2776]: 2015-03-09 08:53:33.948 2776 TRACE neutron     context)
  Mar 09 08:53:33 autopkgtest neutron-server[2776]: 2015-03-09 08:53:33.948 2776 TRACE neutron   File "/usr/lib/python2.7/dist-packages/sqlalchemy/engine/base.py", line 1155, in _handle_dbapi_exception
  Mar 09 08:53:33 autopkgtest neutron-server[2776]: 2015-03-09 08:53:33.948 2776 TRACE neutron     util.raise_from_cause(newraise, exc_info)
  Mar 09 08:53:33 autopkgtest neutron-server[2776]: 2015-03-09 08:53:33.948 2776 TRACE neutron   File "/usr/lib/python2.7/dist-packages/sqlalchemy/util/compat.py", line 199, in raise_from_cause
  Mar 09 08:53:33 autopkgtest neutron-server[2776]: 2015-03-09 08:53:33.948 2776 TRACE neutron     reraise(type(exception), exception, tb=exc_tb)
  Mar 09 08:53:33 autopkgtest neutron-server[2776]: 2015-03-09 08:53:33.948 2776 TRACE neutron   File "/usr/lib/python2.7/dist-packages/sqlalchemy/engine/base.py", line 951, in _execute_context
  Mar 09 08:53:33 autopkgtest neutron-server[2776]: 2015-03-09 08:53:33.948 2776 TRACE neutron     context)
  Mar 09 08:53:33 autopkgtest neutron-server[2776]: 2015-03-09 08:53:33.948 2776 TRACE neutron   File "/usr/lib/python2.7/dist-packages/sqlalchemy/engine/default.py", line 436, in do_execute
  Mar 09 08:53:33 autopkgtest neutron-server[2776]: 2015-03-09 08:53:33.948 2776 TRACE neutron     cursor.execute(statement, parameters)
  Mar 09 08:53:33 autopkgtest neutron-server[2776]: 2015-03-09 08:53:33.948 2776 TRACE neutron OperationalError: (OperationalError) no such table: ml2_vlan_allocations u'SELECT ml2_vlan_allocations.physical_network AS ml2_vlan_allocations_physical_network, ml2_vlan_allocations.vlan_id AS ml2_vlan_allocations_vlan_id, ml2_vlan_allocations.allocated AS ml2_vlan_allocations_allocated \nFROM ml2_vlan_allocations' ()
  Mar 09 08:53:33 autopkgtest neutron-server[2776]: 2015-03-09 08:53:33.948 2776 TRACE neutron
  Mar 09 08:53:34 autopkgtest systemd[1]: neutron-server.service: main process exited, code=exited, status=1/FAILURE

-- 
You received this bug notification because you are a member of Ubuntu
Server Team, which is subscribed to neutron in Ubuntu.
https://bugs.launchpad.net/bugs/1429739

Title:
  neutron-server does not start: OperationalError: (OperationalError) no
  such table: ml2_vlan_allocations

To manage notifications about this bug go to:
https://bugs.launchpad.net/ubuntu/+source/neutron/+bug/1429739/+subscriptions