Oct 29 12:07:36 localhost nova-conductor[27853]: #033[00;32mDEBUG oslo_concurrency.lockutils [#033[01;36mNone req-f3675427-8ac5-47d7-a839-dc161bc9946e #033[00;36madmin admin#033[00;32m] #033[01;35m#033[00;32mLock "7426fc95-1ef3-4920-8725-03ea9c64929e" acquired by "nova.context.get_or_set_cached_cell_and_set_connections" :: waited 0.000s#033[00m #033[00;33m{{(pid=29542) inner /usr/local/lib/python2.7/dist-packages/oslo_concurrency/lockutils.py:273}}#033[00m Oct 29 12:07:36 localhost nova-conductor[27853]: #033[00;32mDEBUG oslo_concurrency.lockutils [#033[01;36mNone req-f3675427-8ac5-47d7-a839-dc161bc9946e #033[00;36madmin admin#033[00;32m] #033[01;35m#033[00;32mLock "7426fc95-1ef3-4920-8725-03ea9c64929e" released by "nova.context.get_or_set_cached_cell_and_set_connections" :: held 0.000s#033[00m #033[00;33m{{(pid=29542) inner /usr/local/lib/python2.7/dist-packages/oslo_concurrency/lockutils.py:285}}#033[00m Oct 29 12:07:36 localhost nova-conductor[27853]: #033[01;31mERROR oslo_messaging.rpc.server [#033[01;36mNone req-f3675427-8ac5-47d7-a839-dc161bc9946e #033[00;36madmin admin#033[01;31m] #033[01;35m#033[01;31mException during message handling#033[00m: DBDataError: (pymysql.err.DataError) (1264, u"Out of range value for column 'instance_type_id' at row 1") [SQL: u'INSERT INTO instances (created_at, updated_at, deleted_at, deleted, user_id, project_id, image_ref, kernel_id, ramdisk_id, hostname, launch_index, key_name, key_data, power_state, vm_state, task_state, memory_mb, vcpus, root_gb, ephemeral_gb, ephemeral_key_uuid, host, node, instance_type_id, user_data, reservation_id, launched_at, terminated_at, availability_zone, display_name, display_description, launched_on, locked, locked_by, os_type, architecture, vm_mode, uuid, root_device_name, default_ephemeral_device, default_swap_device, config_drive, access_ip_v4, access_ip_v6, auto_disk_config, progress, shutdown_terminate, disable_terminate, cell_name, cleaned) VALUES (%(created_at)s, %(updated_at)s, %(deleted_at)s, %(deleted)s, %(user_id)s, %(project_id)s, %(image_ref)s, %(kernel_id)s, %(ramdisk_id)s, %(hostname)s, %(launch_index)s, %(key_name)s, %(key_data)s, %(power_state)s, %(vm_state)s, %(task_state)s, %(memory_mb)s, %(vcpus)s, %(root_gb)s, %(ephemeral_gb)s, %(ephemeral_key_uuid)s, %(host)s, %(node)s, %(instance_type_id)s, %(user_data)s, %(reservation_id)s, %(launched_at)s, %(terminated_at)s, %(availability_zone)s, %(display_name)s, %(display_description)s, %(launched_on)s, %(locked)s, %(locked_by)s, %(os_type)s, %(architecture)s, %(vm_mode)s, %(uuid)s, %(root_device_name)s, %(default_ephemeral_device)s, %(default_swap_device)s, %(config_drive)s, %(access_ip_v4)s, %(access_ip_v6)s, %(auto_disk_config)s, %(progress)s, %(shutdown_terminate)s, %(disable_terminate)s, %(cell_name)s, %(cleaned)s)'] [parameters: {'vm_state': u'building', 'availability_zone': u'nova', 'terminated_at': None, 'ephemeral_gb': 0, 'instance_type_id': 10000000000000000000000L, 'user_data': None, 'cleaned': 0, 'vm_mode': None, 'deleted_at': None, 'reserva Oct 29 12:07:36 localhost nova-conductor[27853]: tion_id': u'r-nc6s5n1k', 'disable_terminate': 0, 'display_name': u'Michele Aguirre', 'uuid': u'ecdf226c-4a0f-4580-90b3-b3c245624892', 'default_swap_device': None, 'hostname': u'michele-aguirre', 'launched_on': None, 'display_description': u'Michele Aguirre', 'key_data': None, 'kernel_id': u'', 'power_state': 0, 'default_ephemeral_device': None, 'progress': 0, 'project_id': u'e2e7a7f1899d4149a702a0f6ffa5a364', 'launched_at': None, 'root_device_name': None, 'node': None, 'ramdisk_id': u'', 'access_ip_v6': None, 'access_ip_v4': None, 'deleted': 0, 'key_name': None, 'updated_at': None, 'host': None, 'root_gb': 0, 'user_id': u'840f812ec07b46e3825d2c9639cea2d1', 'task_state': u'scheduling', 'shutdown_terminate': 0, 'cell_name': None, 'ephemeral_key_uuid': None, 'locked': 0, 'created_at': datetime.datetime(2018, 10, 29, 15, 7, 36), 'locked_by': None, 'launch_index': 0, 'memory_mb': 64, 'vcpus': 1, 'image_ref': u'e05a934f-2a44-4ad9-99fe-396369c180b8', 'architecture': None, 'auto_disk_config': 0, 'os_type': None, 'config_drive': u''}] (Background on this error at: http://sqlalche.me/e/9h9h) Oct 29 12:07:36 localhost nova-conductor[27853]: ERROR oslo_messaging.rpc.server #033[01;35m#033[00mTraceback (most recent call last): Oct 29 12:07:36 localhost nova-conductor[27853]: ERROR oslo_messaging.rpc.server #033[01;35m#033[00m File "/usr/local/lib/python2.7/dist-packages/oslo_messaging/rpc/server.py", line 163, in _process_incoming Oct 29 12:07:36 localhost nova-conductor[27853]: ERROR oslo_messaging.rpc.server #033[01;35m#033[00m res = self.dispatcher.dispatch(message) Oct 29 12:07:36 localhost nova-conductor[27853]: ERROR oslo_messaging.rpc.server #033[01;35m#033[00m File "/usr/local/lib/python2.7/dist-packages/oslo_messaging/rpc/dispatcher.py", line 220, in dispatch Oct 29 12:07:36 localhost nova-conductor[27853]: ERROR oslo_messaging.rpc.server #033[01;35m#033[00m return self._do_dispatch(endpoint, method, ctxt, args) Oct 29 12:07:36 localhost nova-conductor[27853]: ERROR oslo_messaging.rpc.server #033[01;35m#033[00m File "/usr/local/lib/python2.7/dist-packages/oslo_messaging/rpc/dispatcher.py", line 190, in _do_dispatch Oct 29 12:07:36 localhost nova-conductor[27853]: ERROR oslo_messaging.rpc.server #033[01;35m#033[00m result = func(ctxt, **new_args) Oct 29 12:07:36 localhost nova-conductor[27853]: ERROR oslo_messaging.rpc.server #033[01;35m#033[00m File "/opt/stack/queens/dest/nova/nova/conductor/manager.py", line 1180, in schedule_and_build_instances Oct 29 12:07:36 localhost nova-conductor[27853]: ERROR oslo_messaging.rpc.server #033[01;35m#033[00m instance.create() Oct 29 12:07:36 localhost nova-conductor[27853]: ERROR oslo_messaging.rpc.server #033[01;35m#033[00m File "/usr/local/lib/python2.7/dist-packages/oslo_versionedobjects/base.py", line 226, in wrapper Oct 29 12:07:36 localhost nova-conductor[27853]: ERROR oslo_messaging.rpc.server #033[01;35m#033[00m return fn(self, *args, **kwargs) Oct 29 12:07:36 localhost nova-conductor[27853]: ERROR oslo_messaging.rpc.server #033[01;35m#033[00m File "/opt/stack/queens/dest/nova/nova/objects/instance.py", line 579, in create Oct 29 12:07:36 localhost nova-conductor[27853]: ERROR oslo_messaging.rpc.server #033[01;35m#033[00m db_inst = db.instance_create(self._context, updates) Oct 29 12:07:36 localhost nova-conductor[27853]: ERROR oslo_messaging.rpc.server #033[01;35m#033[00m File "/opt/stack/queens/dest/nova/nova/db/api.py", line 754, in instance_create Oct 29 12:07:36 localhost nova-conductor[27853]: ERROR oslo_messaging.rpc.server #033[01;35m#033[00m return IMPL.instance_create(context, values) Oct 29 12:07:36 localhost nova-conductor[27853]: ERROR oslo_messaging.rpc.server #033[01;35m#033[00m File "/opt/stack/queens/dest/nova/nova/db/sqlalchemy/api.py", line 169, in wrapper Oct 29 12:07:36 localhost nova-conductor[27853]: ERROR oslo_messaging.rpc.server #033[01;35m#033[00m return f(*args, **kwargs) Oct 29 12:07:36 localhost nova-conductor[27853]: ERROR oslo_messaging.rpc.server #033[01;35m#033[00m File "/usr/local/lib/python2.7/dist-packages/oslo_db/api.py", line 147, in wrapper Oct 29 12:07:36 localhost nova-conductor[27853]: ERROR oslo_messaging.rpc.server #033[01;35m#033[00m ectxt.value = e.inner_exc Oct 29 12:07:36 localhost nova-conductor[27853]: ERROR oslo_messaging.rpc.server #033[01;35m#033[00m File "/usr/local/lib/python2.7/dist-packages/oslo_utils/excutils.py", line 220, in __exit__ Oct 29 12:07:36 localhost nova-conductor[27853]: ERROR oslo_messaging.rpc.server #033[01;35m#033[00m self.force_reraise() Oct 29 12:07:36 localhost nova-conductor[27853]: ERROR oslo_messaging.rpc.server #033[01;35m#033[00m File "/usr/local/lib/python2.7/dist-packages/oslo_utils/excutils.py", line 196, in force_reraise Oct 29 12:07:36 localhost nova-conductor[27853]: ERROR oslo_messaging.rpc.server #033[01;35m#033[00m six.reraise(self.type_, self.value, self.tb) Oct 29 12:07:36 localhost nova-conductor[27853]: ERROR oslo_messaging.rpc.server #033[01;35m#033[00m File "/usr/local/lib/python2.7/dist-packages/oslo_db/api.py", line 135, in wrapper Oct 29 12:07:36 localhost nova-conductor[27853]: ERROR oslo_messaging.rpc.server #033[01;35m#033[00m return f(*args, **kwargs) Oct 29 12:07:36 localhost nova-conductor[27853]: ERROR oslo_messaging.rpc.server #033[01;35m#033[00m File "/opt/stack/queens/dest/nova/nova/db/sqlalchemy/api.py", line 240, in wrapped Oct 29 12:07:36 localhost nova-conductor[27853]: ERROR oslo_messaging.rpc.server #033[01;35m#033[00m return f(context, *args, **kwargs) Oct 29 12:07:36 localhost nova-conductor[27853]: ERROR oslo_messaging.rpc.server #033[01;35m#033[00m File "/opt/stack/queens/dest/nova/nova/db/sqlalchemy/api.py", line 1786, in instance_create Oct 29 12:07:36 localhost nova-conductor[27853]: ERROR oslo_messaging.rpc.server #033[01;35m#033[00m ec2_instance_create(context, instance_ref['uuid']) Oct 29 12:07:36 localhost nova-conductor[27853]: ERROR oslo_messaging.rpc.server #033[01;35m#033[00m File "/opt/stack/queens/dest/nova/nova/db/sqlalchemy/api.py", line 169, in wrapper Oct 29 12:07:36 localhost nova-conductor[27853]: ERROR oslo_messaging.rpc.server #033[01;35m#033[00m return f(*args, **kwargs) Oct 29 12:07:36 localhost nova-conductor[27853]: ERROR oslo_messaging.rpc.server #033[01;35m#033[00m File "/opt/stack/queens/dest/nova/nova/db/sqlalchemy/api.py", line 240, in wrapped Oct 29 12:07:36 localhost nova-conductor[27853]: ERROR oslo_messaging.rpc.server #033[01;35m#033[00m return f(context, *args, **kwargs) Oct 29 12:07:36 localhost nova-conductor[27853]: ERROR oslo_messaging.rpc.server #033[01;35m#033[00m File "/opt/stack/queens/dest/nova/nova/db/sqlalchemy/api.py", line 5934, in ec2_instance_create Oct 29 12:07:36 localhost nova-conductor[27853]: ERROR oslo_messaging.rpc.server #033[01;35m#033[00m ec2_instance_ref.save(context.session) Oct 29 12:07:36 localhost nova-conductor[27853]: ERROR oslo_messaging.rpc.server #033[01;35m#033[00m File "/usr/local/lib/python2.7/dist-packages/oslo_db/sqlalchemy/models.py", line 50, in save Oct 29 12:07:36 localhost nova-conductor[27853]: ERROR oslo_messaging.rpc.server #033[01;35m#033[00m session.flush() Oct 29 12:07:36 localhost nova-conductor[27853]: ERROR oslo_messaging.rpc.server #033[01;35m#033[00m File "/usr/local/lib/python2.7/dist-packages/sqlalchemy/orm/session.py", line 2243, in flush Oct 29 12:07:36 localhost nova-conductor[27853]: ERROR oslo_messaging.rpc.server #033[01;35m#033[00m self._flush(objects) Oct 29 12:07:36 localhost nova-conductor[27853]: ERROR oslo_messaging.rpc.server #033[01;35m#033[00m File "/usr/local/lib/python2.7/dist-packages/sqlalchemy/orm/session.py", line 2369, in _flush Oct 29 12:07:36 localhost nova-conductor[27853]: ERROR oslo_messaging.rpc.server #033[01;35m#033[00m transaction.rollback(_capture_exception=True) Oct 29 12:07:36 localhost nova-conductor[27853]: ERROR oslo_messaging.rpc.server #033[01;35m#033[00m File "/usr/local/lib/python2.7/dist-packages/sqlalchemy/util/langhelpers.py", line 66, in __exit__ Oct 29 12:07:36 localhost nova-conductor[27853]: ERROR oslo_messaging.rpc.server #033[01;35m#033[00m compat.reraise(exc_type, exc_value, exc_tb) Oct 29 12:07:36 localhost neutron-server[15247]: #033[00;36mINFO neutron.wsgi [#033[01;36mNone req-2699cefa-13e0-4bb8-8cc5-98d125000adc #033[00;36madmin admin#033[00;36m] #033[01;35m#033[00;36m192.168.0.22 "GET /v2.0/ports?device_id=e75f815b-1fe0-4029-a580-2bb22f632083 HTTP/1.1" status: 200 len: 1204 time: 0.0529811#033[00m Oct 29 12:07:36 localhost nova-conductor[27853]: ERROR oslo_messaging.rpc.server #033[01;35m#033[00m File "/usr/local/lib/python2.7/dist-packages/sqlalchemy/orm/session.py", line 2333, in _flush Oct 29 12:07:36 localhost nova-conductor[27853]: ERROR oslo_messaging.rpc.server #033[01;35m#033[00m flush_context.execute() Oct 29 12:07:36 localhost nova-conductor[27853]: ERROR oslo_messaging.rpc.server #033[01;35m#033[00m File "/usr/local/lib/python2.7/dist-packages/sqlalchemy/orm/unitofwork.py", line 391, in execute Oct 29 12:07:36 localhost nova-conductor[27853]: ERROR oslo_messaging.rpc.server #033[01;35m#033[00m rec.execute(self) Oct 29 12:07:36 localhost nova-conductor[27853]: ERROR oslo_messaging.rpc.server #033[01;35m#033[00m File "/usr/local/lib/python2.7/dist-packages/sqlalchemy/orm/unitofwork.py", line 556, in execute Oct 29 12:07:36 localhost nova-conductor[27853]: ERROR oslo_messaging.rpc.server #033[01;35m#033[00m uow Oct 29 12:07:36 localhost nova-conductor[27853]: ERROR oslo_messaging.rpc.server #033[01;35m#033[00m File "/usr/local/lib/python2.7/dist-packages/sqlalchemy/orm/persistence.py", line 181, in save_obj Oct 29 12:07:36 localhost nova-conductor[27853]: ERROR oslo_messaging.rpc.server #033[01;35m#033[00m mapper, table, insert) Oct 29 12:07:36 localhost nova-conductor[27853]: ERROR oslo_messaging.rpc.server #033[01;35m#033[00m File "/usr/local/lib/python2.7/dist-packages/sqlalchemy/orm/persistence.py", line 866, in _emit_insert_statements Oct 29 12:07:36 localhost nova-conductor[27853]: ERROR oslo_messaging.rpc.server #033[01;35m#033[00m execute(statement, params) Oct 29 12:07:36 localhost nova-conductor[27853]: ERROR oslo_messaging.rpc.server #033[01;35m#033[00m File "/usr/local/lib/python2.7/dist-packages/sqlalchemy/engine/base.py", line 948, in execute Oct 29 12:07:36 localhost nova-conductor[27853]: ERROR oslo_messaging.rpc.server #033[01;35m#033[00m return meth(self, multiparams, params) Oct 29 12:07:36 localhost nova-conductor[27853]: ERROR oslo_messaging.rpc.server #033[01;35m#033[00m File "/usr/local/lib/python2.7/dist-packages/sqlalchemy/sql/elements.py", line 269, in _execute_on_connection Oct 29 12:07:36 localhost nova-conductor[27853]: ERROR oslo_messaging.rpc.server #033[01;35m#033[00m return connection._execute_clauseelement(self, multiparams, params) Oct 29 12:07:36 localhost nova-conductor[27853]: ERROR oslo_messaging.rpc.server #033[01;35m#033[00m File "/usr/local/lib/python2.7/dist-packages/sqlalchemy/engine/base.py", line 1060, in _execute_clauseelement Oct 29 12:07:36 localhost nova-conductor[27853]: ERROR oslo_messaging.rpc.server #033[01;35m#033[00m compiled_sql, distilled_params Oct 29 12:07:36 localhost nova-conductor[27853]: ERROR oslo_messaging.rpc.server #033[01;35m#033[00m File "/usr/local/lib/python2.7/dist-packages/sqlalchemy/engine/base.py", line 1200, in _execute_context Oct 29 12:07:36 localhost nova-conductor[27853]: ERROR oslo_messaging.rpc.server #033[01;35m#033[00m context) Oct 29 12:07:36 localhost nova-conductor[27853]: ERROR oslo_messaging.rpc.server #033[01;35m#033[00m File "/usr/local/lib/python2.7/dist-packages/sqlalchemy/engine/base.py", line 1409, in _handle_dbapi_exception Oct 29 12:07:36 localhost nova-conductor[27853]: ERROR oslo_messaging.rpc.server #033[01;35m#033[00m util.raise_from_cause(newraise, exc_info) Oct 29 12:07:36 localhost nova-conductor[27853]: ERROR oslo_messaging.rpc.server #033[01;35m#033[00m File "/usr/local/lib/python2.7/dist-packages/sqlalchemy/util/compat.py", line 203, in raise_from_cause Oct 29 12:07:36 localhost nova-conductor[27853]: ERROR oslo_messaging.rpc.server #033[01;35m#033[00m reraise(type(exception), exception, tb=exc_tb, cause=cause) Oct 29 12:07:36 localhost nova-conductor[27853]: ERROR oslo_messaging.rpc.server #033[01;35m#033[00m File "/usr/local/lib/python2.7/dist-packages/sqlalchemy/engine/base.py", line 1193, in _execute_context Oct 29 12:07:36 localhost nova-conductor[27853]: ERROR oslo_messaging.rpc.server #033[01;35m#033[00m context) Oct 29 12:07:36 localhost nova-conductor[27853]: ERROR oslo_messaging.rpc.server #033[01;35m#033[00m File "/usr/local/lib/python2.7/dist-packages/sqlalchemy/engine/default.py", line 507, in do_execute Oct 29 12:07:36 localhost nova-conductor[27853]: ERROR oslo_messaging.rpc.server #033[01;35m#033[00m cursor.execute(statement, parameters) Oct 29 12:07:36 localhost nova-conductor[27853]: ERROR oslo_messaging.rpc.server #033[01;35m#033[00m File "/usr/local/lib/python2.7/dist-packages/pymysql/cursors.py", line 165, in execute Oct 29 12:07:36 localhost nova-conductor[27853]: ERROR oslo_messaging.rpc.server #033[01;35m#033[00m result = self._query(query) Oct 29 12:07:36 localhost nova-conductor[27853]: ERROR oslo_messaging.rpc.server #033[01;35m#033[00m File "/usr/local/lib/python2.7/dist-packages/pymysql/cursors.py", line 321, in _query Oct 29 12:07:36 localhost nova-conductor[27853]: ERROR oslo_messaging.rpc.server #033[01;35m#033[00m conn.query(q) Oct 29 12:07:36 localhost nova-conductor[27853]: ERROR oslo_messaging.rpc.server #033[01;35m#033[00m File "/usr/local/lib/python2.7/dist-packages/pymysql/connections.py", line 860, in query Oct 29 12:07:36 localhost nova-conductor[27853]: ERROR oslo_messaging.rpc.server #033[01;35m#033[00m self._affected_rows = self._read_query_result(unbuffered=unbuffered) Oct 29 12:07:36 localhost nova-conductor[27853]: ERROR oslo_messaging.rpc.server #033[01;35m#033[00m File "/usr/local/lib/python2.7/dist-packages/pymysql/connections.py", line 1061, in _read_query_result Oct 29 12:07:36 localhost nova-conductor[27853]: ERROR oslo_messaging.rpc.server #033[01;35m#033[00m result.read() Oct 29 12:07:36 localhost nova-conductor[27853]: ERROR oslo_messaging.rpc.server #033[01;35m#033[00m File "/usr/local/lib/python2.7/dist-packages/pymysql/connections.py", line 1349, in read Oct 29 12:07:36 localhost nova-conductor[27853]: ERROR oslo_messaging.rpc.server #033[01;35m#033[00m first_packet = self.connection._read_packet() Oct 29 12:07:36 localhost nova-conductor[27853]: ERROR oslo_messaging.rpc.server #033[01;35m#033[00m File "/usr/local/lib/python2.7/dist-packages/pymysql/connections.py", line 1018, in _read_packet Oct 29 12:07:36 localhost nova-conductor[27853]: ERROR oslo_messaging.rpc.server #033[01;35m#033[00m packet.check_error() Oct 29 12:07:36 localhost nova-conductor[27853]: ERROR oslo_messaging.rpc.server #033[01;35m#033[00m File "/usr/local/lib/python2.7/dist-packages/pymysql/connections.py", line 384, in check_error Oct 29 12:07:36 localhost nova-conductor[27853]: ERROR oslo_messaging.rpc.server #033[01;35m#033[00m err.raise_mysql_exception(self._data) Oct 29 12:07:36 localhost nova-conductor[27853]: ERROR oslo_messaging.rpc.server #033[01;35m#033[00m File "/usr/local/lib/python2.7/dist-packages/pymysql/err.py", line 107, in raise_mysql_exception Oct 29 12:07:36 localhost nova-conductor[27853]: ERROR oslo_messaging.rpc.server #033[01;35m#033[00m raise errorclass(errno, errval) Oct 29 12:07:36 localhost nova-conductor[27853]: ERROR oslo_messaging.rpc.server #033[01;35m#033[00mDBDataError: (pymysql.err.DataError) (1264, u"Out of range value for column 'instance_type_id' at row 1") [SQL: u'INSERT INTO instances (created_at, updated_at, deleted_at, deleted, user_id, project_id, image_ref, kernel_id, ramdisk_id, hostname, launch_index, key_name, key_data, power_state, vm_state, task_state, memory_mb, vcpus, root_gb, ephemeral_gb, ephemeral_key_uuid, host, node, instance_type_id, user_data, reservation_id, launched_at, terminated_at, availability_zone, display_name, display_description, launched_on, locked, locked_by, os_type, architecture, vm_mode, uuid, root_device_name, default_ephemeral_device, default_swap_device, config_drive, access_ip_v4, access_ip_v6, auto_disk_config, progress, shutdown_terminate, disable_terminate, cell_name, cleaned) VALUES (%(created_at)s, %(updated_at)s, %(deleted_at)s, %(deleted)s, %(user_id)s, %(project_id)s, %(image_ref)s, %(kernel_id)s, %(ramdisk_id)s, %(hostname)s, %(launch_index)s, %(key_name)s, %(key_data)s, %(power_state)s, %(vm_state)s, %(task_state)s, %(memory_mb)s, %(vcpus)s, %(root_gb)s, %(ephemeral_gb)s, %(ephemeral_key_uuid)s, %(host)s, %(node)s, %(instance_type_id)s, %(user_data)s, %(reservation_id)s, %(launched_at)s, %(terminated_at)s, %(availability_zone)s, %(display_name)s, %(display_description)s, %(launched_on)s, %(locked)s, %(locked_by)s, %(os_type)s, %(architecture)s, %(vm_mode)s, %(uuid)s, %(root_device_name)s, %(default_ephemeral_device)s, %(default_swap_device)s, %(config_drive)s, %(access_ip_v4)s, %(access_ip_v6)s, %(auto_disk_config)s, %(progress)s, %(shutdown_terminate)s, %(disable_terminate)s, %(cell_name)s, %(cleaned)s)'] [parameters: {'vm_state': u'building', 'availability_zone': u'nova', 'terminated_at': None, 'ephemeral_gb': 0, 'instance_type_id': 10000000000000000000000L, 'user_data': None, 'cleaned': 0, 'vm_mode': None, 'deleted_at': None, 'reservation_id': u'r-nc6s5n1k', 'disable_terminate': 0, 'display_name': u'Michele Aguirre', 'uuid': u'ecdf226c-4a0f-4580-90b3-b3c245624892', ' Oct 29 12:07:36 localhost nova-conductor[27853]: default_swap_device': None, 'hostname': u'michele-aguirre', 'launched_on': None, 'display_description': u'Michele Aguirre', 'key_data': None, 'kernel_id': u'', 'power_state': 0, 'default_ephemeral_device': None, 'progress': 0, 'project_id': u'e2e7a7f1899d4149a702a0f6ffa5a364', 'launched_at': None, 'root_device_name': None, 'node': None, 'ramdisk_id': u'', 'access_ip_v6': None, 'access_ip_v4': None, 'deleted': 0, 'key_name': None, 'updated_at': None, 'host': None, 'root_gb': 0, 'user_id': u'840f812ec07b46e3825d2c9639cea2d1', 'task_state': u'scheduling', 'shutdown_terminate': 0, 'cell_name': None, 'ephemeral_key_uuid': None, 'locked': 0, 'created_at': datetime.datetime(2018, 10, 29, 15, 7, 36), 'locked_by': None, 'launch_index': 0, 'memory_mb': 64, 'vcpus': 1, 'image_ref': u'e05a934f-2a44-4ad9-99fe-396369c180b8', 'architecture': None, 'auto_disk_config': 0, 'os_type': None, 'config_drive': u''}] (Background on this error at: http://sqlalche.me/e/9h9h) Oct 29 12:07:36 localhost nova-conductor[27853]: ERROR oslo_messaging.rpc.server #033[01;35m#033[00m Oct 29 12:07:37 localhost nova-compute[29419]: #033[01;33mWARNING nova.compute.manager [#033[01;36mNone req-c952fca9-2b68-4b3c-80f2-5818eb14b02e #033[00;36mservice nova#033[01;33m] #033[01;35m[instance: e75f815b-1fe0-4029-a580-2bb22f632083] #033[01;33mDetach interface failed, port_id=93829574-c9a8-443d-8278-b69edbd94986, reason: Instance e75f815b-1fe0-4029-a580-2bb22f632083 could not be found.#033[00m: InstanceNotFound: Instance e75f815b-1fe0-4029-a580-2bb22f632083 could not be found. Oct 29 12:07:37 localhost devstack@n-api.service[14263]: #033[00;32mDEBUG nova.policy [#033[01;36mNone req-1b4afeb4-54a2-47b5-a1a5-b081b1661b02 #033[00;36madmin admin#033[00;32m] #033[01;35m#033[00;32mPolicy check for os_compute_api:os-hide-server-addresses failed with credentials {'service_roles': [], 'user_id': u'840f812ec07b46e3825d2c9639cea2d1', 'roles': [u'admin'], 'user_domain_id': u'default', 'service_project_id': None, 'service_user_id': None, 'service_user_domain_id': None, 'service_project_domain_id': None, 'is_admin_project': True, 'is_admin': True, 'project_id': u'e2e7a7f1899d4149a702a0f6ffa5a364', 'project_domain_id': u'default'}#033[00m #033[00;33m{{(pid=14265) authorize /opt/stack/queens/dest/nova/nova/policy.py:168}}#033[00m Oct 29 12:07:37 localhost neutron-server[15247]: #033[00;36mINFO neutron.wsgi [#033[01;36mNone req-968a5c54-868a-4fbf-932a-084780b63870 #033[00;36madmin admin#033[00;36m] #033[01;35m#033[00;36m192.168.0.22 "GET /v2.0/ports?device_id=ecdf226c-4a0f-4580-90b3-b3c245624892 HTTP/1.1" status: 200 len: 210 time: 0.0424249#033[00m Oct 29 12:07:37 localhost devstack@n-api.service[14263]: #033[00;36mINFO nova.api.openstack.requestlog [#033[01;36mNone req-1b4afeb4-54a2-47b5-a1a5-b081b1661b02 #033[00;36madmin admin#033[00;36m] #033[01;35m#033[00;36m192.168.0.22 "GET /compute/v2.1/servers/ecdf226c-4a0f-4580-90b3-b3c245624892" status: 200 len: 1365 microversion: 2.1 time: 0.097321#033[00m Oct 29 12:07:37 localhost devstack@n-api.service[14263]: [pid: 14265|app: 0|req: 643/1285] 192.168.0.22 () {60 vars in 1311 bytes} [Mon Oct 29 12:07:37 2018] GET /compute/v2.1/servers/ecdf226c-4a0f-4580-90b3-b3c245624892 => generated 1365 bytes in 98 msecs (HTTP/1.1 200) 9 headers in 358 bytes (2 switches on core 0) 2018-10-29 12:09:06,757 DEBUG [urllib3.connectionpool] http://localhost:8081 "GET /cote/compute/v2.1/servers/ecdf226c-4a0f-4580-90b3-b3c245624892 HTTP/1.1" 200 1365 2018-10-29 12:09:06,758 DEBUG [novaclient.v2.client] RESP BODY: {"server": {"OS-EXT-STS:task_state": "scheduling", "addresses": {}, "links": [{"href": "http://192.168.0.22/compute/v2.1/servers/ecdf226c-4a0f-4580-90b3-b3c245624892", "rel": "self"}, {"href": "http://192.168.0.22/compute/servers/ecdf226c-4a0f-4580-90b3-b3c245624892", "rel": "bookmark"}], "image": {"id": "e05a934f-2a44-4ad9-99fe-396369c180b8", "links": [{"href": "http://192.168.0.22/compute/images/e05a934f-2a44-4ad9-99fe-396369c180b8", "rel": "bookmark"}]}, "OS-EXT-STS:vm_state": "building", "OS-EXT-SRV-ATTR:instance_name": "", "OS-SRV-USG:launched_at": null, "flavor": {"id": "c0d2fa36-5dd5-4252-9fd1-bee0d3d2c3db", "links": [{"href": "http://192.168.0.22/compute/flavors/c0d2fa36-5dd5-4252-9fd1-bee0d3d2c3db", "rel": "bookmark"}]}, "id": "ecdf226c-4a0f-4580-90b3-b3c245624892", "user_id": "840f812ec07b46e3825d2c9639cea2d1", "OS-DCF:diskConfig": "MANUAL", "accessIPv4": "", "accessIPv6": "", "progress": 0, "OS-EXT-STS:power_state": 0, "OS-EXT-AZ:availability_zone": "", "config_drive": "", "status": "BUILD", "updated": "2018-10-29T15:09:06Z", "hostId": "", "OS-EXT-SRV-ATTR:host": null, "OS-SRV-USG:terminated_at": null, "key_name": null, "OS-EXT-SRV-ATTR:hypervisor_hostname": null, "name": "Michele Aguirre", "created": "2018-10-29T15:07:36Z", "tenant_id": "e2e7a7f1899d4149a702a0f6ffa5a364", "os-extended-volumes:volumes_attached": [], "metadata": {}}}