Jul 04 17:13:52.403618 np0000004511 systemd[1]: Started devstack@c-vol.service - Devstack devstack@c-vol.service. Jul 04 17:13:52.537029 np0000004511 cinder-volume[98636]: /opt/stack/cinder/cinder/__init__.py:21: EventletDeprecationWarning: Jul 04 17:13:52.537029 np0000004511 cinder-volume[98636]: Eventlet is deprecated. It is currently being maintained in bugfix mode, and Jul 04 17:13:52.537029 np0000004511 cinder-volume[98636]: we strongly recommend against using it for new projects. Jul 04 17:13:52.537029 np0000004511 cinder-volume[98636]: If you are already using Eventlet, we recommend migrating to a different Jul 04 17:13:52.537029 np0000004511 cinder-volume[98636]: framework. For more detail see Jul 04 17:13:52.537029 np0000004511 cinder-volume[98636]: https://eventlet.readthedocs.io/en/latest/asyncio/migration.html Jul 04 17:13:52.537029 np0000004511 cinder-volume[98636]: import eventlet # noqa Jul 04 17:13:53.537793 np0000004511 cinder-volume[98636]: DEBUG oslo_concurrency.lockutils [-] Acquiring lock "singleton_lock" {{(pid=98636) lock /opt/stack/data/venv/lib/python3.12/site-packages/oslo_concurrency/lockutils.py:395}} Jul 04 17:13:53.538322 np0000004511 cinder-volume[98636]: DEBUG oslo_concurrency.lockutils [-] Acquired lock "singleton_lock" {{(pid=98636) lock /opt/stack/data/venv/lib/python3.12/site-packages/oslo_concurrency/lockutils.py:398}} Jul 04 17:13:53.538322 np0000004511 cinder-volume[98636]: DEBUG oslo_concurrency.lockutils [-] Releasing lock "singleton_lock" {{(pid=98636) lock /opt/stack/data/venv/lib/python3.12/site-packages/oslo_concurrency/lockutils.py:418}} Jul 04 17:13:53.977118 np0000004511 cinder-volume[98636]: INFO dbcounter [None req-8b5170f8-f5b4-4ccc-ad76-ee4052af7e18 None None] Registered counter for database cinder Jul 04 17:13:54.056468 np0000004511 cinder-volume[98636]: ======================================================================== Jul 04 17:13:54.056468 np0000004511 cinder-volume[98636]: ==== Guru Meditation ==== Jul 04 17:13:54.056468 np0000004511 cinder-volume[98636]: ======================================================================== Jul 04 17:13:54.056468 np0000004511 cinder-volume[98636]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 04 17:13:54.056468 np0000004511 cinder-volume[98636]: ======================================================================== Jul 04 17:13:54.056468 np0000004511 cinder-volume[98636]: ==== Package ==== Jul 04 17:13:54.056468 np0000004511 cinder-volume[98636]: ======================================================================== Jul 04 17:13:54.056468 np0000004511 cinder-volume[98636]: product = None Jul 04 17:13:54.056468 np0000004511 cinder-volume[98636]: vendor = None Jul 04 17:13:54.056468 np0000004511 cinder-volume[98636]: version = None Jul 04 17:13:54.056468 np0000004511 cinder-volume[98636]: ======================================================================== Jul 04 17:13:54.056468 np0000004511 cinder-volume[98636]: ==== Threads ==== Jul 04 17:13:54.056468 np0000004511 cinder-volume[98636]: ======================================================================== Jul 04 17:13:54.056468 np0000004511 cinder-volume[98636]: ------ Thread #135919541108480 ------ Jul 04 17:13:54.056468 np0000004511 cinder-volume[98636]: /opt/stack/data/venv/bin/cinder-volume:6 in Jul 04 17:13:54.056468 np0000004511 cinder-volume[98636]: `sys.exit(main())` Jul 04 17:13:54.056468 np0000004511 cinder-volume[98636]: /opt/stack/cinder/cinder/cmd/volume.py:145 in main Jul 04 17:13:54.056468 np0000004511 cinder-volume[98636]: `_launch_services()` Jul 04 17:13:54.056468 np0000004511 cinder-volume[98636]: /opt/stack/cinder/cinder/cmd/volume.py:119 in _launch_services Jul 04 17:13:54.056468 np0000004511 cinder-volume[98636]: `_launch_service(launcher, backend)` Jul 04 17:13:54.056468 np0000004511 cinder-volume[98636]: /opt/stack/cinder/cinder/cmd/volume.py:85 in _launch_service Jul 04 17:13:54.056468 np0000004511 cinder-volume[98636]: `server = service.Service.create(host=host,` Jul 04 17:13:54.056468 np0000004511 cinder-volume[98636]: /opt/stack/cinder/cinder/service.py:413 in create Jul 04 17:13:54.056468 np0000004511 cinder-volume[98636]: `service_obj = cls(host, binary, topic, manager,` Jul 04 17:13:54.056468 np0000004511 cinder-volume[98636]: /opt/stack/cinder/cinder/service.py:151 in __init__ Jul 04 17:13:54.056468 np0000004511 cinder-volume[98636]: `self.manager = manager_class(host=self.host,` Jul 04 17:13:54.056468 np0000004511 cinder-volume[98636]: /opt/stack/cinder/cinder/volume/manager.py:262 in __init__ Jul 04 17:13:54.056468 np0000004511 cinder-volume[98636]: `super(VolumeManager, self).__init__(` Jul 04 17:13:54.056468 np0000004511 cinder-volume[98636]: /opt/stack/cinder/cinder/manager.py:251 in __init__ Jul 04 17:13:54.056468 np0000004511 cinder-volume[98636]: `super(SizedThreadPoolManager, self).__init__(*args, **kwargs)` Jul 04 17:13:54.056468 np0000004511 cinder-volume[98636]: /opt/stack/cinder/cinder/manager.py:209 in __init__ Jul 04 17:13:54.056468 np0000004511 cinder-volume[98636]: `self.scheduler_rpcapi = scheduler_rpcapi.SchedulerAPI()` Jul 04 17:13:54.056468 np0000004511 cinder-volume[98636]: /opt/stack/cinder/cinder/rpc.py:219 in __init__ Jul 04 17:13:54.056468 np0000004511 cinder-volume[98636]: `obj_version_cap = self.determine_obj_version_cap()` Jul 04 17:13:54.056468 np0000004511 cinder-volume[98636]: /opt/stack/cinder/cinder/rpc.py:273 in determine_obj_version_cap Jul 04 17:13:54.056468 np0000004511 cinder-volume[98636]: `version_cap = objects.Service.get_minimum_obj_version(` Jul 04 17:13:54.058376 np0000004511 cinder-volume[98636]: /opt/stack/cinder/cinder/objects/service.py:207 in get_minimum_obj_version Jul 04 17:13:54.058376 np0000004511 cinder-volume[98636]: `return cls._get_minimum_version('object_current_version', context,` Jul 04 17:13:54.058376 np0000004511 cinder-volume[98636]: /opt/stack/cinder/cinder/objects/service.py:178 in _get_minimum_version Jul 04 17:13:54.058376 np0000004511 cinder-volume[98636]: `services = ServiceList.get_all_by_binary(context, binary)` Jul 04 17:13:54.058376 np0000004511 cinder-volume[98636]: /opt/stack/cinder/cinder/objects/service.py:241 in get_all_by_binary Jul 04 17:13:54.058376 np0000004511 cinder-volume[98636]: `services = db.service_get_all(context, binary=binary,` Jul 04 17:13:54.058376 np0000004511 cinder-volume[98636]: /opt/stack/cinder/cinder/db/api.py:208 in wrapper Jul 04 17:13:54.058376 np0000004511 cinder-volume[98636]: `return f(*args, **kwargs)` Jul 04 17:13:54.058376 np0000004511 cinder-volume[98636]: /opt/stack/data/venv/lib/python3.12/site-packages/oslo_db/sqlalchemy/enginefacade.py:1158 in wrapper Jul 04 17:13:54.058376 np0000004511 cinder-volume[98636]: `with self._transaction_scope(context):` Jul 04 17:13:54.058376 np0000004511 cinder-volume[98636]: /usr/lib/python3.12/contextlib.py:137 in __enter__ Jul 04 17:13:54.058376 np0000004511 cinder-volume[98636]: `return next(self.gen)` Jul 04 17:13:54.058376 np0000004511 cinder-volume[98636]: /opt/stack/data/venv/lib/python3.12/site-packages/oslo_db/sqlalchemy/enginefacade.py:1175 in _transaction_scope Jul 04 17:13:54.058376 np0000004511 cinder-volume[98636]: `with current._produce_block(` Jul 04 17:13:54.058376 np0000004511 cinder-volume[98636]: /usr/lib/python3.12/contextlib.py:137 in __enter__ Jul 04 17:13:54.058376 np0000004511 cinder-volume[98636]: `return next(self.gen)` Jul 04 17:13:54.058376 np0000004511 cinder-volume[98636]: /opt/stack/data/venv/lib/python3.12/site-packages/oslo_db/sqlalchemy/enginefacade.py:828 in _session Jul 04 17:13:54.058376 np0000004511 cinder-volume[98636]: `self.session = self.factory._create_session(` Jul 04 17:13:54.058376 np0000004511 cinder-volume[98636]: /opt/stack/data/venv/lib/python3.12/site-packages/oslo_db/sqlalchemy/enginefacade.py:458 in _create_session Jul 04 17:13:54.058376 np0000004511 cinder-volume[98636]: `self._start()` Jul 04 17:13:54.058376 np0000004511 cinder-volume[98636]: /opt/stack/data/venv/lib/python3.12/site-packages/oslo_db/sqlalchemy/enginefacade.py:532 in _start Jul 04 17:13:54.058376 np0000004511 cinder-volume[98636]: `self._setup_for_connection(` Jul 04 17:13:54.058376 np0000004511 cinder-volume[98636]: /opt/stack/data/venv/lib/python3.12/site-packages/oslo_db/sqlalchemy/enginefacade.py:635 in _setup_for_connection Jul 04 17:13:54.058376 np0000004511 cinder-volume[98636]: `engine = engines.create_engine(` Jul 04 17:13:54.058376 np0000004511 cinder-volume[98636]: /opt/stack/data/venv/lib/python3.12/site-packages/debtcollector/renames.py:64 in decorator Jul 04 17:13:54.058376 np0000004511 cinder-volume[98636]: `return wrapped(*args, **kwargs)` Jul 04 17:13:54.058376 np0000004511 cinder-volume[98636]: /opt/stack/data/venv/lib/python3.12/site-packages/oslo_db/sqlalchemy/engines.py:180 in create_engine Jul 04 17:13:54.058376 np0000004511 cinder-volume[98636]: `engine, engine_event_target = _engine_target(url, **engine_args)` Jul 04 17:13:54.058376 np0000004511 cinder-volume[98636]: /opt/stack/data/venv/lib/python3.12/site-packages/oslo_db/sqlalchemy/engines.py:91 in _create_engine Jul 04 17:13:54.058376 np0000004511 cinder-volume[98636]: `engine = sqlalchemy.create_engine(url, **engine_args)` Jul 04 17:13:54.058376 np0000004511 cinder-volume[98636]: :2 in create_engine Jul 04 17:13:54.058376 np0000004511 cinder-volume[98636]: `` Jul 04 17:13:54.059030 np0000004511 cinder-volume[98636]: /opt/stack/data/venv/lib/python3.12/site-packages/sqlalchemy/util/deprecations.py:281 in warned Jul 04 17:13:54.059030 np0000004511 cinder-volume[98636]: `return fn(*args, **kwargs) # type: ignore[no-any-return]` Jul 04 17:13:54.059030 np0000004511 cinder-volume[98636]: /opt/stack/data/venv/lib/python3.12/site-packages/sqlalchemy/engine/create.py:566 in create_engine Jul 04 17:13:54.059030 np0000004511 cinder-volume[98636]: `u, plugins, kwargs = u._instantiate_plugins(kwargs)` Jul 04 17:13:54.059030 np0000004511 cinder-volume[98636]: /opt/stack/data/venv/lib/python3.12/site-packages/sqlalchemy/engine/url.py:746 in _instantiate_plugins Jul 04 17:13:54.059030 np0000004511 cinder-volume[98636]: `plugins.load(plugin_name)(self, kwargs)` Jul 04 17:13:54.059030 np0000004511 cinder-volume[98636]: /opt/stack/data/venv/lib/python3.12/site-packages/dbcounter.py:39 in __init__ Jul 04 17:13:54.059030 np0000004511 cinder-volume[98636]: `self.engine = sqlalchemy.create_engine(new_url)` Jul 04 17:13:54.059030 np0000004511 cinder-volume[98636]: :2 in create_engine Jul 04 17:13:54.059030 np0000004511 cinder-volume[98636]: `` Jul 04 17:13:54.059030 np0000004511 cinder-volume[98636]: /opt/stack/data/venv/lib/python3.12/site-packages/sqlalchemy/util/deprecations.py:281 in warned Jul 04 17:13:54.059030 np0000004511 cinder-volume[98636]: `return fn(*args, **kwargs) # type: ignore[no-any-return]` Jul 04 17:13:54.059030 np0000004511 cinder-volume[98636]: /opt/stack/data/venv/lib/python3.12/site-packages/sqlalchemy/engine/create.py:617 in create_engine Jul 04 17:13:54.059030 np0000004511 cinder-volume[98636]: `dbapi = dbapi_meth(**dbapi_args)` Jul 04 17:13:54.059030 np0000004511 cinder-volume[98636]: /opt/stack/data/venv/lib/python3.12/site-packages/sqlalchemy/dialects/mysql/pymysql.py:116 in import_dbapi Jul 04 17:13:54.059030 np0000004511 cinder-volume[98636]: `return __import__("pymysql")` Jul 04 17:13:54.059030 np0000004511 cinder-volume[98636]: :1360 in _find_and_load Jul 04 17:13:54.059030 np0000004511 cinder-volume[98636]: `` Jul 04 17:13:54.059030 np0000004511 cinder-volume[98636]: :1331 in _find_and_load_unlocked Jul 04 17:13:54.059030 np0000004511 cinder-volume[98636]: `` Jul 04 17:13:54.059030 np0000004511 cinder-volume[98636]: :935 in _load_unlocked Jul 04 17:13:54.059030 np0000004511 cinder-volume[98636]: `` Jul 04 17:13:54.059030 np0000004511 cinder-volume[98636]: :995 in exec_module Jul 04 17:13:54.059030 np0000004511 cinder-volume[98636]: `` Jul 04 17:13:54.059030 np0000004511 cinder-volume[98636]: :488 in _call_with_frames_removed Jul 04 17:13:54.059030 np0000004511 cinder-volume[98636]: `` Jul 04 17:13:54.059030 np0000004511 cinder-volume[98636]: /opt/stack/data/venv/lib/python3.12/site-packages/pymysql/__init__.py:41 in Jul 04 17:13:54.059030 np0000004511 cinder-volume[98636]: `from .times import (` Jul 04 17:13:54.059030 np0000004511 cinder-volume[98636]: :1360 in _find_and_load Jul 04 17:13:54.059030 np0000004511 cinder-volume[98636]: `` Jul 04 17:13:54.059030 np0000004511 cinder-volume[98636]: :1321 in _find_and_load_unlocked Jul 04 17:13:54.059030 np0000004511 cinder-volume[98636]: `` Jul 04 17:13:54.059030 np0000004511 cinder-volume[98636]: ------ Thread #135919561564288 ------ Jul 04 17:13:54.059030 np0000004511 cinder-volume[98636]: /opt/stack/data/venv/bin/cinder-volume:6 in Jul 04 17:13:54.059030 np0000004511 cinder-volume[98636]: `sys.exit(main())` Jul 04 17:13:54.059030 np0000004511 cinder-volume[98636]: /opt/stack/cinder/cinder/cmd/volume.py:145 in main Jul 04 17:13:54.059030 np0000004511 cinder-volume[98636]: `_launch_services()` Jul 04 17:13:54.059030 np0000004511 cinder-volume[98636]: /opt/stack/cinder/cinder/cmd/volume.py:119 in _launch_services Jul 04 17:13:54.059030 np0000004511 cinder-volume[98636]: `_launch_service(launcher, backend)` Jul 04 17:13:54.059030 np0000004511 cinder-volume[98636]: /opt/stack/cinder/cinder/cmd/volume.py:85 in _launch_service Jul 04 17:13:54.059678 np0000004511 cinder-volume[98636]: `server = service.Service.create(host=host,` Jul 04 17:13:54.059678 np0000004511 cinder-volume[98636]: /opt/stack/cinder/cinder/service.py:413 in create Jul 04 17:13:54.059678 np0000004511 cinder-volume[98636]: `service_obj = cls(host, binary, topic, manager,` Jul 04 17:13:54.059678 np0000004511 cinder-volume[98636]: /opt/stack/cinder/cinder/service.py:151 in __init__ Jul 04 17:13:54.059678 np0000004511 cinder-volume[98636]: `self.manager = manager_class(host=self.host,` Jul 04 17:13:54.059678 np0000004511 cinder-volume[98636]: /opt/stack/cinder/cinder/volume/manager.py:262 in __init__ Jul 04 17:13:54.059678 np0000004511 cinder-volume[98636]: `super(VolumeManager, self).__init__(` Jul 04 17:13:54.059678 np0000004511 cinder-volume[98636]: /opt/stack/cinder/cinder/manager.py:251 in __init__ Jul 04 17:13:54.059678 np0000004511 cinder-volume[98636]: `super(SizedThreadPoolManager, self).__init__(*args, **kwargs)` Jul 04 17:13:54.059678 np0000004511 cinder-volume[98636]: /opt/stack/cinder/cinder/manager.py:209 in __init__ Jul 04 17:13:54.059678 np0000004511 cinder-volume[98636]: `self.scheduler_rpcapi = scheduler_rpcapi.SchedulerAPI()` Jul 04 17:13:54.059678 np0000004511 cinder-volume[98636]: /opt/stack/cinder/cinder/rpc.py:219 in __init__ Jul 04 17:13:54.059678 np0000004511 cinder-volume[98636]: `obj_version_cap = self.determine_obj_version_cap()` Jul 04 17:13:54.059678 np0000004511 cinder-volume[98636]: /opt/stack/cinder/cinder/rpc.py:273 in determine_obj_version_cap Jul 04 17:13:54.059678 np0000004511 cinder-volume[98636]: `version_cap = objects.Service.get_minimum_obj_version(` Jul 04 17:13:54.059678 np0000004511 cinder-volume[98636]: /opt/stack/cinder/cinder/objects/service.py:207 in get_minimum_obj_version Jul 04 17:13:54.059678 np0000004511 cinder-volume[98636]: `return cls._get_minimum_version('object_current_version', context,` Jul 04 17:13:54.059678 np0000004511 cinder-volume[98636]: /opt/stack/cinder/cinder/objects/service.py:178 in _get_minimum_version Jul 04 17:13:54.059678 np0000004511 cinder-volume[98636]: `services = ServiceList.get_all_by_binary(context, binary)` Jul 04 17:13:54.059678 np0000004511 cinder-volume[98636]: /opt/stack/cinder/cinder/objects/service.py:241 in get_all_by_binary Jul 04 17:13:54.059678 np0000004511 cinder-volume[98636]: `services = db.service_get_all(context, binary=binary,` Jul 04 17:13:54.059678 np0000004511 cinder-volume[98636]: /opt/stack/cinder/cinder/db/api.py:208 in wrapper Jul 04 17:13:54.059678 np0000004511 cinder-volume[98636]: `return f(*args, **kwargs)` Jul 04 17:13:54.059678 np0000004511 cinder-volume[98636]: /opt/stack/data/venv/lib/python3.12/site-packages/oslo_db/sqlalchemy/enginefacade.py:1158 in wrapper Jul 04 17:13:54.059678 np0000004511 cinder-volume[98636]: `with self._transaction_scope(context):` Jul 04 17:13:54.059678 np0000004511 cinder-volume[98636]: /usr/lib/python3.12/contextlib.py:137 in __enter__ Jul 04 17:13:54.059678 np0000004511 cinder-volume[98636]: `return next(self.gen)` Jul 04 17:13:54.059678 np0000004511 cinder-volume[98636]: /opt/stack/data/venv/lib/python3.12/site-packages/oslo_db/sqlalchemy/enginefacade.py:1175 in _transaction_scope Jul 04 17:13:54.059678 np0000004511 cinder-volume[98636]: `with current._produce_block(` Jul 04 17:13:54.059678 np0000004511 cinder-volume[98636]: /usr/lib/python3.12/contextlib.py:137 in __enter__ Jul 04 17:13:54.059678 np0000004511 cinder-volume[98636]: `return next(self.gen)` Jul 04 17:13:54.059678 np0000004511 cinder-volume[98636]: /opt/stack/data/venv/lib/python3.12/site-packages/oslo_db/sqlalchemy/enginefacade.py:828 in _session Jul 04 17:13:54.059678 np0000004511 cinder-volume[98636]: `self.session = self.factory._create_session(` Jul 04 17:13:54.059678 np0000004511 cinder-volume[98636]: /opt/stack/data/venv/lib/python3.12/site-packages/oslo_db/sqlalchemy/enginefacade.py:458 in _create_session Jul 04 17:13:54.060882 np0000004511 cinder-volume[98636]: `self._start()` Jul 04 17:13:54.060882 np0000004511 cinder-volume[98636]: /opt/stack/data/venv/lib/python3.12/site-packages/oslo_db/sqlalchemy/enginefacade.py:532 in _start Jul 04 17:13:54.060882 np0000004511 cinder-volume[98636]: `self._setup_for_connection(` Jul 04 17:13:54.060882 np0000004511 cinder-volume[98636]: /opt/stack/data/venv/lib/python3.12/site-packages/oslo_db/sqlalchemy/enginefacade.py:635 in _setup_for_connection Jul 04 17:13:54.060882 np0000004511 cinder-volume[98636]: `engine = engines.create_engine(` Jul 04 17:13:54.060882 np0000004511 cinder-volume[98636]: /opt/stack/data/venv/lib/python3.12/site-packages/debtcollector/renames.py:64 in decorator Jul 04 17:13:54.060882 np0000004511 cinder-volume[98636]: `return wrapped(*args, **kwargs)` Jul 04 17:13:54.060882 np0000004511 cinder-volume[98636]: /opt/stack/data/venv/lib/python3.12/site-packages/oslo_db/sqlalchemy/engines.py:180 in create_engine Jul 04 17:13:54.060882 np0000004511 cinder-volume[98636]: `engine, engine_event_target = _engine_target(url, **engine_args)` Jul 04 17:13:54.060882 np0000004511 cinder-volume[98636]: /opt/stack/data/venv/lib/python3.12/site-packages/oslo_db/sqlalchemy/engines.py:91 in _create_engine Jul 04 17:13:54.060882 np0000004511 cinder-volume[98636]: `engine = sqlalchemy.create_engine(url, **engine_args)` Jul 04 17:13:54.060882 np0000004511 cinder-volume[98636]: :2 in create_engine Jul 04 17:13:54.060882 np0000004511 cinder-volume[98636]: `` Jul 04 17:13:54.060882 np0000004511 cinder-volume[98636]: /opt/stack/data/venv/lib/python3.12/site-packages/sqlalchemy/util/deprecations.py:281 in warned Jul 04 17:13:54.060882 np0000004511 cinder-volume[98636]: `return fn(*args, **kwargs) # type: ignore[no-any-return]` Jul 04 17:13:54.060882 np0000004511 cinder-volume[98636]: /opt/stack/data/venv/lib/python3.12/site-packages/sqlalchemy/engine/create.py:566 in create_engine Jul 04 17:13:54.060882 np0000004511 cinder-volume[98636]: `u, plugins, kwargs = u._instantiate_plugins(kwargs)` Jul 04 17:13:54.060882 np0000004511 cinder-volume[98636]: /opt/stack/data/venv/lib/python3.12/site-packages/sqlalchemy/engine/url.py:746 in _instantiate_plugins Jul 04 17:13:54.060882 np0000004511 cinder-volume[98636]: `plugins.load(plugin_name)(self, kwargs)` Jul 04 17:13:54.060882 np0000004511 cinder-volume[98636]: /opt/stack/data/venv/lib/python3.12/site-packages/dbcounter.py:39 in __init__ Jul 04 17:13:54.060882 np0000004511 cinder-volume[98636]: `self.engine = sqlalchemy.create_engine(new_url)` Jul 04 17:13:54.060882 np0000004511 cinder-volume[98636]: :2 in create_engine Jul 04 17:13:54.060882 np0000004511 cinder-volume[98636]: `` Jul 04 17:13:54.060882 np0000004511 cinder-volume[98636]: /opt/stack/data/venv/lib/python3.12/site-packages/sqlalchemy/util/deprecations.py:281 in warned Jul 04 17:13:54.060882 np0000004511 cinder-volume[98636]: `return fn(*args, **kwargs) # type: ignore[no-any-return]` Jul 04 17:13:54.060882 np0000004511 cinder-volume[98636]: /opt/stack/data/venv/lib/python3.12/site-packages/sqlalchemy/engine/create.py:617 in create_engine Jul 04 17:13:54.060882 np0000004511 cinder-volume[98636]: `dbapi = dbapi_meth(**dbapi_args)` Jul 04 17:13:54.060882 np0000004511 cinder-volume[98636]: /opt/stack/data/venv/lib/python3.12/site-packages/sqlalchemy/dialects/mysql/pymysql.py:116 in import_dbapi Jul 04 17:13:54.060882 np0000004511 cinder-volume[98636]: `return __import__("pymysql")` Jul 04 17:13:54.060882 np0000004511 cinder-volume[98636]: :1360 in _find_and_load Jul 04 17:13:54.060882 np0000004511 cinder-volume[98636]: `` Jul 04 17:13:54.060882 np0000004511 cinder-volume[98636]: :1331 in _find_and_load_unlocked Jul 04 17:13:54.060882 np0000004511 cinder-volume[98636]: `` Jul 04 17:13:54.062393 np0000004511 cinder-volume[98636]: :935 in _load_unlocked Jul 04 17:13:54.062393 np0000004511 cinder-volume[98636]: `` Jul 04 17:13:54.062393 np0000004511 cinder-volume[98636]: :995 in exec_module Jul 04 17:13:54.062393 np0000004511 cinder-volume[98636]: `` Jul 04 17:13:54.062393 np0000004511 cinder-volume[98636]: :488 in _call_with_frames_removed Jul 04 17:13:54.062393 np0000004511 cinder-volume[98636]: `` Jul 04 17:13:54.062393 np0000004511 cinder-volume[98636]: /opt/stack/data/venv/lib/python3.12/site-packages/pymysql/__init__.py:41 in Jul 04 17:13:54.062393 np0000004511 cinder-volume[98636]: `from .times import (` Jul 04 17:13:54.062393 np0000004511 cinder-volume[98636]: :1360 in _find_and_load Jul 04 17:13:54.062393 np0000004511 cinder-volume[98636]: `` Jul 04 17:13:54.062393 np0000004511 cinder-volume[98636]: :1321 in _find_and_load_unlocked Jul 04 17:13:54.062393 np0000004511 cinder-volume[98636]: `` Jul 04 17:13:54.062393 np0000004511 cinder-volume[98636]: /opt/stack/data/venv/lib/python3.12/site-packages/oslo_reports/guru_meditation_report.py:241 in Jul 04 17:13:54.062393 np0000004511 cinder-volume[98636]: `lambda sn, f: cls.handle_signal(version, service_name, log_dir, f),` Jul 04 17:13:54.062393 np0000004511 cinder-volume[98636]: /opt/stack/data/venv/lib/python3.12/site-packages/oslo_reports/guru_meditation_report.py:270 in handle_signal Jul 04 17:13:54.062393 np0000004511 cinder-volume[98636]: `res = cls(version, frame).run()` Jul 04 17:13:54.062393 np0000004511 cinder-volume[98636]: /opt/stack/data/venv/lib/python3.12/site-packages/oslo_reports/guru_meditation_report.py:320 in run Jul 04 17:13:54.062393 np0000004511 cinder-volume[98636]: `return super().run()` Jul 04 17:13:54.062393 np0000004511 cinder-volume[98636]: /opt/stack/data/venv/lib/python3.12/site-packages/oslo_reports/report.py:91 in run Jul 04 17:13:54.062393 np0000004511 cinder-volume[98636]: `return "\n".join(str(sect) for sect in self.sections)` Jul 04 17:13:54.062393 np0000004511 cinder-volume[98636]: /opt/stack/data/venv/lib/python3.12/site-packages/oslo_reports/report.py:91 in Jul 04 17:13:54.062393 np0000004511 cinder-volume[98636]: `return "\n".join(str(sect) for sect in self.sections)` Jul 04 17:13:54.062393 np0000004511 cinder-volume[98636]: /opt/stack/data/venv/lib/python3.12/site-packages/oslo_reports/report.py:120 in __str__ Jul 04 17:13:54.062393 np0000004511 cinder-volume[98636]: `model = self.generator()` Jul 04 17:13:54.062393 np0000004511 cinder-volume[98636]: /opt/stack/data/venv/lib/python3.12/site-packages/oslo_reports/report.py:159 in newgen Jul 04 17:13:54.062393 np0000004511 cinder-volume[98636]: `res = gen()` Jul 04 17:13:54.062393 np0000004511 cinder-volume[98636]: /opt/stack/data/venv/lib/python3.12/site-packages/oslo_reports/generators/threading.py:70 in __call__ Jul 04 17:13:54.062393 np0000004511 cinder-volume[98636]: `thread_id: tm.ThreadModel(thread_id, stack)` Jul 04 17:13:54.062393 np0000004511 cinder-volume[98636]: ======================================================================== Jul 04 17:13:54.062393 np0000004511 cinder-volume[98636]: ==== Green Threads ==== Jul 04 17:13:54.062393 np0000004511 cinder-volume[98636]: ======================================================================== Jul 04 17:13:54.062393 np0000004511 cinder-volume[98636]: ------ Green Thread ------ Jul 04 17:13:54.062393 np0000004511 cinder-volume[98636]: /opt/stack/data/venv/lib/python3.12/site-packages/eventlet/hubs/hub.py:352 in run Jul 04 17:13:54.062393 np0000004511 cinder-volume[98636]: `self.fire_timers(self.clock())` Jul 04 17:13:54.063328 np0000004511 cinder-volume[98636]: /opt/stack/data/venv/lib/python3.12/site-packages/eventlet/hubs/hub.py:471 in fire_timers Jul 04 17:13:54.063328 np0000004511 cinder-volume[98636]: `timer()` Jul 04 17:13:54.063328 np0000004511 cinder-volume[98636]: /opt/stack/data/venv/lib/python3.12/site-packages/eventlet/hubs/timer.py:59 in __call__ Jul 04 17:13:54.063328 np0000004511 cinder-volume[98636]: `cb(*args, **kw)` Jul 04 17:13:54.063328 np0000004511 cinder-volume[98636]: ------ Green Thread ------ Jul 04 17:13:54.063328 np0000004511 cinder-volume[98636]: No Traceback! Jul 04 17:13:54.063328 np0000004511 cinder-volume[98636]: ======================================================================== Jul 04 17:13:54.063328 np0000004511 cinder-volume[98636]: ==== Processes ==== Jul 04 17:13:54.063328 np0000004511 cinder-volume[98636]: ======================================================================== Jul 04 17:13:54.063328 np0000004511 cinder-volume[98636]: Process 98636 (under 1) [ run by: stack (1002), state: running ] Jul 04 17:13:54.063328 np0000004511 cinder-volume[98636]: ======================================================================== Jul 04 17:13:54.063328 np0000004511 cinder-volume[98636]: ==== Configuration ==== Jul 04 17:13:54.063328 np0000004511 cinder-volume[98636]: ======================================================================== Jul 04 17:13:54.063328 np0000004511 cinder-volume[98636]: backend_defaults: Jul 04 17:13:54.063328 np0000004511 cinder-volume[98636]: backend_availability_zone = None Jul 04 17:13:54.063328 np0000004511 cinder-volume[98636]: backend_native_threads_pool_size = 20 Jul 04 17:13:54.063328 np0000004511 cinder-volume[98636]: chap_password = *** Jul 04 17:13:54.063328 np0000004511 cinder-volume[98636]: chap_username = Jul 04 17:13:54.063328 np0000004511 cinder-volume[98636]: chiscsi_conf = /etc/chelsio-iscsi/chiscsi.conf Jul 04 17:13:54.063328 np0000004511 cinder-volume[98636]: disk_geometry = None Jul 04 17:13:54.063328 np0000004511 cinder-volume[98636]: driver_client_cert = None Jul 04 17:13:54.063328 np0000004511 cinder-volume[98636]: driver_client_cert_key = None Jul 04 17:13:54.063328 np0000004511 cinder-volume[98636]: driver_data_namespace = None Jul 04 17:13:54.063328 np0000004511 cinder-volume[98636]: driver_ssl_cert_path = None Jul 04 17:13:54.063328 np0000004511 cinder-volume[98636]: driver_ssl_cert_verify = False Jul 04 17:13:54.063328 np0000004511 cinder-volume[98636]: driver_use_ssl = False Jul 04 17:13:54.063328 np0000004511 cinder-volume[98636]: enable_unsupported_driver = False Jul 04 17:13:54.063328 np0000004511 cinder-volume[98636]: enforce_multipath_for_image_xfer = False Jul 04 17:13:54.063328 np0000004511 cinder-volume[98636]: extra_capabilities = {} Jul 04 17:13:54.063328 np0000004511 cinder-volume[98636]: filter_function = None Jul 04 17:13:54.063328 np0000004511 cinder-volume[98636]: goodness_function = None Jul 04 17:13:54.063328 np0000004511 cinder-volume[98636]: image_upload_use_cinder_backend = False Jul 04 17:13:54.063328 np0000004511 cinder-volume[98636]: image_upload_use_internal_tenant = False Jul 04 17:13:54.063328 np0000004511 cinder-volume[98636]: image_volume_cache_enabled = False Jul 04 17:13:54.063328 np0000004511 cinder-volume[98636]: image_volume_cache_max_count = 0 Jul 04 17:13:54.063328 np0000004511 cinder-volume[98636]: image_volume_cache_max_size_gb = 0 Jul 04 17:13:54.063328 np0000004511 cinder-volume[98636]: iscsi_target_flags = Jul 04 17:13:54.063328 np0000004511 cinder-volume[98636]: iscsi_write_cache = on Jul 04 17:13:54.063328 np0000004511 cinder-volume[98636]: iser_helper = tgtadm Jul 04 17:13:54.063328 np0000004511 cinder-volume[98636]: iser_ip_address = 10.4.3.236 Jul 04 17:13:54.063328 np0000004511 cinder-volume[98636]: iser_port = 3260 Jul 04 17:13:54.063328 np0000004511 cinder-volume[98636]: iser_target_prefix = iqn.2010-10.org.openstack: Jul 04 17:13:54.063328 np0000004511 cinder-volume[98636]: max_over_subscription_ratio = 20.0 Jul 04 17:13:54.063328 np0000004511 cinder-volume[98636]: num_iser_scan_tries = 3 Jul 04 17:13:54.063328 np0000004511 cinder-volume[98636]: num_shell_tries = 3 Jul 04 17:13:54.063328 np0000004511 cinder-volume[98636]: num_volume_device_scan_tries = 3 Jul 04 17:13:54.063328 np0000004511 cinder-volume[98636]: nvmeof_conn_info_version = 1 Jul 04 17:13:54.063328 np0000004511 cinder-volume[98636]: nvmet_ns_id = 10 Jul 04 17:13:54.063328 np0000004511 cinder-volume[98636]: nvmet_port_id = 1 Jul 04 17:13:54.063328 np0000004511 cinder-volume[98636]: replication_device = *** Jul 04 17:13:54.063328 np0000004511 cinder-volume[98636]: report_discard_supported = False Jul 04 17:13:54.063328 np0000004511 cinder-volume[98636]: reserved_percentage = 0 Jul 04 17:13:54.063328 np0000004511 cinder-volume[98636]: scst_target_driver = iscsi Jul 04 17:13:54.064111 np0000004511 cinder-volume[98636]: scst_target_iqn_name = None Jul 04 17:13:54.064111 np0000004511 cinder-volume[98636]: storage_protocol = iSCSI Jul 04 17:13:54.064111 np0000004511 cinder-volume[98636]: suppress_requests_ssl_warnings = False Jul 04 17:13:54.064111 np0000004511 cinder-volume[98636]: target_helper = tgtadm Jul 04 17:13:54.064111 np0000004511 cinder-volume[98636]: target_ip_address = 10.4.3.236 Jul 04 17:13:54.064111 np0000004511 cinder-volume[98636]: target_port = 3260 Jul 04 17:13:54.064111 np0000004511 cinder-volume[98636]: target_prefix = iqn.2010-10.org.openstack: Jul 04 17:13:54.064111 np0000004511 cinder-volume[98636]: target_protocol = iscsi Jul 04 17:13:54.064111 np0000004511 cinder-volume[98636]: target_secondary_ip_addresses = Jul 04 17:13:54.064111 np0000004511 cinder-volume[98636]: trace_flags = None Jul 04 17:13:54.064111 np0000004511 cinder-volume[98636]: unique_fqdn_network = True Jul 04 17:13:54.064111 np0000004511 cinder-volume[98636]: use_chap_auth = False Jul 04 17:13:54.064111 np0000004511 cinder-volume[98636]: use_multipath_for_image_xfer = False Jul 04 17:13:54.064111 np0000004511 cinder-volume[98636]: volume_backend_name = None Jul 04 17:13:54.064111 np0000004511 cinder-volume[98636]: volume_clear = zero Jul 04 17:13:54.064111 np0000004511 cinder-volume[98636]: volume_clear_ionice = None Jul 04 17:13:54.064111 np0000004511 cinder-volume[98636]: volume_clear_size = 0 Jul 04 17:13:54.064111 np0000004511 cinder-volume[98636]: volume_copy_blkio_cgroup_name = cinder-volume-copy Jul 04 17:13:54.064111 np0000004511 cinder-volume[98636]: volume_copy_bps_limit = 0 Jul 04 17:13:54.064111 np0000004511 cinder-volume[98636]: volume_dd_blocksize = 1M Jul 04 17:13:54.064111 np0000004511 cinder-volume[98636]: volume_driver = cinder.volume.drivers.lvm.LVMVolumeDriver Jul 04 17:13:54.064111 np0000004511 cinder-volume[98636]: volumes_dir = /opt/stack/data/cinder/volumes Jul 04 17:13:54.064111 np0000004511 cinder-volume[98636]: barbican: Jul 04 17:13:54.064111 np0000004511 cinder-volume[98636]: auth_endpoint = http://localhost/identity/v3 Jul 04 17:13:54.064111 np0000004511 cinder-volume[98636]: barbican_api_version = None Jul 04 17:13:54.064111 np0000004511 cinder-volume[98636]: barbican_endpoint = None Jul 04 17:13:54.064111 np0000004511 cinder-volume[98636]: barbican_endpoint_type = public Jul 04 17:13:54.064111 np0000004511 cinder-volume[98636]: barbican_region_name = None Jul 04 17:13:54.064111 np0000004511 cinder-volume[98636]: cafile = None Jul 04 17:13:54.064111 np0000004511 cinder-volume[98636]: certfile = None Jul 04 17:13:54.064111 np0000004511 cinder-volume[98636]: collect-timing = False Jul 04 17:13:54.064111 np0000004511 cinder-volume[98636]: insecure = False Jul 04 17:13:54.064111 np0000004511 cinder-volume[98636]: keyfile = None Jul 04 17:13:54.064111 np0000004511 cinder-volume[98636]: number_of_retries = 60 Jul 04 17:13:54.064111 np0000004511 cinder-volume[98636]: retry_delay = 1 Jul 04 17:13:54.064111 np0000004511 cinder-volume[98636]: send_service_user_token = False Jul 04 17:13:54.064111 np0000004511 cinder-volume[98636]: split-loggers = False Jul 04 17:13:54.064111 np0000004511 cinder-volume[98636]: timeout = None Jul 04 17:13:54.064111 np0000004511 cinder-volume[98636]: verify_ssl = True Jul 04 17:13:54.064111 np0000004511 cinder-volume[98636]: verify_ssl_path = None Jul 04 17:13:54.064111 np0000004511 cinder-volume[98636]: barbican_service_user: Jul 04 17:13:54.064111 np0000004511 cinder-volume[98636]: auth_section = None Jul 04 17:13:54.064111 np0000004511 cinder-volume[98636]: auth_type = None Jul 04 17:13:54.064111 np0000004511 cinder-volume[98636]: cafile = None Jul 04 17:13:54.064111 np0000004511 cinder-volume[98636]: certfile = None Jul 04 17:13:54.064111 np0000004511 cinder-volume[98636]: collect-timing = False Jul 04 17:13:54.064111 np0000004511 cinder-volume[98636]: insecure = False Jul 04 17:13:54.064111 np0000004511 cinder-volume[98636]: keyfile = None Jul 04 17:13:54.064111 np0000004511 cinder-volume[98636]: split-loggers = False Jul 04 17:13:54.064111 np0000004511 cinder-volume[98636]: timeout = None Jul 04 17:13:54.064111 np0000004511 cinder-volume[98636]: cache: Jul 04 17:13:54.064111 np0000004511 cinder-volume[98636]: backend = dogpile.cache.null Jul 04 17:13:54.064111 np0000004511 cinder-volume[98636]: backend_argument = *** Jul 04 17:13:54.064111 np0000004511 cinder-volume[98636]: backend_expiration_time = None Jul 04 17:13:54.064111 np0000004511 cinder-volume[98636]: config_prefix = cache.oslo Jul 04 17:13:54.064111 np0000004511 cinder-volume[98636]: debug_cache_backend = False Jul 04 17:13:54.064111 np0000004511 cinder-volume[98636]: enable_retry_client = False Jul 04 17:13:54.064111 np0000004511 cinder-volume[98636]: enable_socket_keepalive = False Jul 04 17:13:54.064111 np0000004511 cinder-volume[98636]: enabled = False Jul 04 17:13:54.064111 np0000004511 cinder-volume[98636]: expiration_time = 600 Jul 04 17:13:54.064111 np0000004511 cinder-volume[98636]: hashclient_dead_timeout = 60.0 Jul 04 17:13:54.064111 np0000004511 cinder-volume[98636]: hashclient_retry_attempts = 2 Jul 04 17:13:54.064111 np0000004511 cinder-volume[98636]: hashclient_retry_timeout = 1.0 Jul 04 17:13:54.064111 np0000004511 cinder-volume[98636]: memcache_dead_retry = 300 Jul 04 17:13:54.064111 np0000004511 cinder-volume[98636]: memcache_pool_connection_get_timeout = 10 Jul 04 17:13:54.064111 np0000004511 cinder-volume[98636]: memcache_pool_flush_on_reconnect = False Jul 04 17:13:54.064111 np0000004511 cinder-volume[98636]: memcache_pool_maxsize = 10 Jul 04 17:13:54.064111 np0000004511 cinder-volume[98636]: memcache_pool_unused_timeout = 60 Jul 04 17:13:54.064111 np0000004511 cinder-volume[98636]: memcache_sasl_enabled = False Jul 04 17:13:54.064111 np0000004511 cinder-volume[98636]: memcache_servers = Jul 04 17:13:54.064111 np0000004511 cinder-volume[98636]: localhost:11211 Jul 04 17:13:54.064111 np0000004511 cinder-volume[98636]: password = *** Jul 04 17:13:54.064111 np0000004511 cinder-volume[98636]: proxies = Jul 04 17:13:54.064111 np0000004511 cinder-volume[98636]: redis_db = 0 Jul 04 17:13:54.066443 np0000004511 cinder-volume[98636]: redis_sentinel_service_name = mymaster Jul 04 17:13:54.066443 np0000004511 cinder-volume[98636]: redis_sentinels = Jul 04 17:13:54.066443 np0000004511 cinder-volume[98636]: localhost:26379 Jul 04 17:13:54.066443 np0000004511 cinder-volume[98636]: redis_server = localhost:6379 Jul 04 17:13:54.066443 np0000004511 cinder-volume[98636]: retry_attempts = 2 Jul 04 17:13:54.066443 np0000004511 cinder-volume[98636]: retry_delay = 0.0 Jul 04 17:13:54.066443 np0000004511 cinder-volume[98636]: socket_keepalive_count = 1 Jul 04 17:13:54.066443 np0000004511 cinder-volume[98636]: socket_keepalive_idle = 1 Jul 04 17:13:54.066443 np0000004511 cinder-volume[98636]: socket_keepalive_interval = 1 Jul 04 17:13:54.066443 np0000004511 cinder-volume[98636]: socket_timeout = 1.0 Jul 04 17:13:54.066443 np0000004511 cinder-volume[98636]: tls_allowed_ciphers = None Jul 04 17:13:54.066443 np0000004511 cinder-volume[98636]: tls_cafile = None Jul 04 17:13:54.066443 np0000004511 cinder-volume[98636]: tls_certfile = None Jul 04 17:13:54.066443 np0000004511 cinder-volume[98636]: tls_enabled = False Jul 04 17:13:54.066443 np0000004511 cinder-volume[98636]: tls_keyfile = None Jul 04 17:13:54.066443 np0000004511 cinder-volume[98636]: username = None Jul 04 17:13:54.066443 np0000004511 cinder-volume[98636]: cinder_sys_admin: Jul 04 17:13:54.066443 np0000004511 cinder-volume[98636]: capabilities = Jul 04 17:13:54.066443 np0000004511 cinder-volume[98636]: 0 Jul 04 17:13:54.066443 np0000004511 cinder-volume[98636]: 1 Jul 04 17:13:54.066443 np0000004511 cinder-volume[98636]: 12 Jul 04 17:13:54.066443 np0000004511 cinder-volume[98636]: 2 Jul 04 17:13:54.066443 np0000004511 cinder-volume[98636]: 21 Jul 04 17:13:54.066443 np0000004511 cinder-volume[98636]: 3 Jul 04 17:13:54.066443 np0000004511 cinder-volume[98636]: group = None Jul 04 17:13:54.066443 np0000004511 cinder-volume[98636]: helper_command = None Jul 04 17:13:54.066443 np0000004511 cinder-volume[98636]: log_daemon_traceback = False Jul 04 17:13:54.066443 np0000004511 cinder-volume[98636]: logger_name = oslo_privsep.daemon Jul 04 17:13:54.066443 np0000004511 cinder-volume[98636]: thread_pool_size = 16 Jul 04 17:13:54.066443 np0000004511 cinder-volume[98636]: user = None Jul 04 17:13:54.066443 np0000004511 cinder-volume[98636]: coordination: Jul 04 17:13:54.066443 np0000004511 cinder-volume[98636]: backend_url = *** Jul 04 17:13:54.066443 np0000004511 cinder-volume[98636]: database: Jul 04 17:13:54.066443 np0000004511 cinder-volume[98636]: asyncio_connection = *** Jul 04 17:13:54.066443 np0000004511 cinder-volume[98636]: asyncio_slave_connection = *** Jul 04 17:13:54.066443 np0000004511 cinder-volume[98636]: backend = sqlalchemy Jul 04 17:13:54.066443 np0000004511 cinder-volume[98636]: connection = *** Jul 04 17:13:54.066443 np0000004511 cinder-volume[98636]: connection_debug = 0 Jul 04 17:13:54.066443 np0000004511 cinder-volume[98636]: connection_parameters = Jul 04 17:13:54.066443 np0000004511 cinder-volume[98636]: connection_recycle_time = 3600 Jul 04 17:13:54.066443 np0000004511 cinder-volume[98636]: connection_trace = False Jul 04 17:13:54.066443 np0000004511 cinder-volume[98636]: db_inc_retry_interval = True Jul 04 17:13:54.066443 np0000004511 cinder-volume[98636]: db_max_retries = 20 Jul 04 17:13:54.066443 np0000004511 cinder-volume[98636]: db_max_retry_interval = 10 Jul 04 17:13:54.066443 np0000004511 cinder-volume[98636]: db_retry_interval = 1 Jul 04 17:13:54.066443 np0000004511 cinder-volume[98636]: max_overflow = 50 Jul 04 17:13:54.066443 np0000004511 cinder-volume[98636]: max_pool_size = 5 Jul 04 17:13:54.066443 np0000004511 cinder-volume[98636]: max_retries = 10 Jul 04 17:13:54.066443 np0000004511 cinder-volume[98636]: mysql_sql_mode = TRADITIONAL Jul 04 17:13:54.066443 np0000004511 cinder-volume[98636]: mysql_wsrep_sync_wait = None Jul 04 17:13:54.066443 np0000004511 cinder-volume[98636]: pool_timeout = None Jul 04 17:13:54.066443 np0000004511 cinder-volume[98636]: retry_interval = 10 Jul 04 17:13:54.066443 np0000004511 cinder-volume[98636]: slave_connection = *** Jul 04 17:13:54.066443 np0000004511 cinder-volume[98636]: sqlite_synchronous = True Jul 04 17:13:54.066443 np0000004511 cinder-volume[98636]: synchronous_reader = True Jul 04 17:13:54.066443 np0000004511 cinder-volume[98636]: use_db_reconnect = False Jul 04 17:13:54.066443 np0000004511 cinder-volume[98636]: default: Jul 04 17:13:54.066443 np0000004511 cinder-volume[98636]: allow_availability_zone_fallback = False Jul 04 17:13:54.066443 np0000004511 cinder-volume[98636]: allow_compression_on_image_upload = False Jul 04 17:13:54.066443 np0000004511 cinder-volume[98636]: allowed_direct_url_schemes = Jul 04 17:13:54.066443 np0000004511 cinder-volume[98636]: api_rate_limit = True Jul 04 17:13:54.066443 np0000004511 cinder-volume[98636]: auth_strategy = keystone Jul 04 17:13:54.066443 np0000004511 cinder-volume[98636]: backend_availability_zone = None Jul 04 17:13:54.066443 np0000004511 cinder-volume[98636]: backend_host = None Jul 04 17:13:54.066443 np0000004511 cinder-volume[98636]: backend_name = None Jul 04 17:13:54.066443 np0000004511 cinder-volume[98636]: backend_stats_polling_interval = 60 Jul 04 17:13:54.066443 np0000004511 cinder-volume[98636]: backup_api_class = cinder.backup.api.API Jul 04 17:13:54.066443 np0000004511 cinder-volume[98636]: backup_manager = cinder.backup.manager.BackupManager Jul 04 17:13:54.066443 np0000004511 cinder-volume[98636]: backup_name_template = backup-%s Jul 04 17:13:54.066443 np0000004511 cinder-volume[98636]: backup_use_same_host = False Jul 04 17:13:54.066443 np0000004511 cinder-volume[98636]: backup_use_temp_snapshot = False Jul 04 17:13:54.066443 np0000004511 cinder-volume[98636]: chap_password = *** Jul 04 17:13:54.066443 np0000004511 cinder-volume[98636]: chap_username = Jul 04 17:13:54.066443 np0000004511 cinder-volume[98636]: chiscsi_conf = /etc/chelsio-iscsi/chiscsi.conf Jul 04 17:13:54.066443 np0000004511 cinder-volume[98636]: cinder_internal_tenant_project_id = cf0d90654c1940c6b19ad2f3e6bdef97 Jul 04 17:13:54.066443 np0000004511 cinder-volume[98636]: cinder_internal_tenant_user_id = da5693393d4f4665a0694dcc92bfca70 Jul 04 17:13:54.066443 np0000004511 cinder-volume[98636]: cluster = None Jul 04 17:13:54.066443 np0000004511 cinder-volume[98636]: compression_format = gzip Jul 04 17:13:54.069610 np0000004511 cinder-volume[98636]: compute_api_class = cinder.compute.nova.API Jul 04 17:13:54.069610 np0000004511 cinder-volume[98636]: config-dir = Jul 04 17:13:54.069610 np0000004511 cinder-volume[98636]: config-file = Jul 04 17:13:54.069610 np0000004511 cinder-volume[98636]: /etc/cinder/cinder.conf Jul 04 17:13:54.069610 np0000004511 cinder-volume[98636]: config_source = Jul 04 17:13:54.069610 np0000004511 cinder-volume[98636]: consistencygroup_api_class = cinder.consistencygroup.api.API Jul 04 17:13:54.069610 np0000004511 cinder-volume[98636]: control_exchange = openstack Jul 04 17:13:54.069610 np0000004511 cinder-volume[98636]: debug = True Jul 04 17:13:54.069610 np0000004511 cinder-volume[98636]: default_availability_zone = None Jul 04 17:13:54.069610 np0000004511 cinder-volume[98636]: default_group_type = None Jul 04 17:13:54.069610 np0000004511 cinder-volume[98636]: default_log_levels = Jul 04 17:13:54.069610 np0000004511 cinder-volume[98636]: amqp=WARN Jul 04 17:13:54.069610 np0000004511 cinder-volume[98636]: boto=WARN Jul 04 17:13:54.069610 np0000004511 cinder-volume[98636]: dogpile.core.dogpile=INFO Jul 04 17:13:54.069610 np0000004511 cinder-volume[98636]: iso8601=WARN Jul 04 17:13:54.069610 np0000004511 cinder-volume[98636]: keystoneauth=WARN Jul 04 17:13:54.069610 np0000004511 cinder-volume[98636]: keystonemiddleware=WARN Jul 04 17:13:54.069610 np0000004511 cinder-volume[98636]: oslo.cache=INFO Jul 04 17:13:54.069610 np0000004511 cinder-volume[98636]: oslo.messaging=INFO Jul 04 17:13:54.069610 np0000004511 cinder-volume[98636]: oslo_messaging=INFO Jul 04 17:13:54.069610 np0000004511 cinder-volume[98636]: oslo_policy=INFO Jul 04 17:13:54.069610 np0000004511 cinder-volume[98636]: requests.packages.urllib3.connectionpool=WARN Jul 04 17:13:54.069610 np0000004511 cinder-volume[98636]: requests.packages.urllib3.util.retry=WARN Jul 04 17:13:54.069610 np0000004511 cinder-volume[98636]: routes.middleware=WARN Jul 04 17:13:54.069610 np0000004511 cinder-volume[98636]: sqlalchemy=WARN Jul 04 17:13:54.069610 np0000004511 cinder-volume[98636]: stevedore=WARN Jul 04 17:13:54.069610 np0000004511 cinder-volume[98636]: suds=INFO Jul 04 17:13:54.069610 np0000004511 cinder-volume[98636]: taskflow=WARN Jul 04 17:13:54.069610 np0000004511 cinder-volume[98636]: urllib3.connectionpool=WARN Jul 04 17:13:54.069610 np0000004511 cinder-volume[98636]: urllib3.util.retry=WARN Jul 04 17:13:54.069610 np0000004511 cinder-volume[98636]: websocket=WARN Jul 04 17:13:54.069610 np0000004511 cinder-volume[98636]: default_volume_type = storpool Jul 04 17:13:54.069610 np0000004511 cinder-volume[98636]: disk_geometry = None Jul 04 17:13:54.069610 np0000004511 cinder-volume[98636]: driver_client_cert = None Jul 04 17:13:54.069610 np0000004511 cinder-volume[98636]: driver_client_cert_key = None Jul 04 17:13:54.069610 np0000004511 cinder-volume[98636]: driver_data_namespace = None Jul 04 17:13:54.069610 np0000004511 cinder-volume[98636]: driver_ssl_cert_path = None Jul 04 17:13:54.069610 np0000004511 cinder-volume[98636]: driver_ssl_cert_verify = False Jul 04 17:13:54.069610 np0000004511 cinder-volume[98636]: driver_use_ssl = False Jul 04 17:13:54.069610 np0000004511 cinder-volume[98636]: enable_new_services = True Jul 04 17:13:54.069610 np0000004511 cinder-volume[98636]: enable_unsupported_driver = False Jul 04 17:13:54.069610 np0000004511 cinder-volume[98636]: enabled_backends = Jul 04 17:13:54.069610 np0000004511 cinder-volume[98636]: storpool Jul 04 17:13:54.069610 np0000004511 cinder-volume[98636]: enforce_multipath_for_image_xfer = False Jul 04 17:13:54.069610 np0000004511 cinder-volume[98636]: filter_function = None Jul 04 17:13:54.069610 np0000004511 cinder-volume[98636]: glance_api_insecure = False Jul 04 17:13:54.069610 np0000004511 cinder-volume[98636]: glance_api_servers = Jul 04 17:13:54.069610 np0000004511 cinder-volume[98636]: https://10.4.3.236/image Jul 04 17:13:54.069610 np0000004511 cinder-volume[98636]: glance_api_ssl_compression = False Jul 04 17:13:54.069610 np0000004511 cinder-volume[98636]: glance_ca_certificates_file = /opt/stack/data/ca-bundle.pem Jul 04 17:13:54.069610 np0000004511 cinder-volume[98636]: glance_catalog_info = image:glance:publicURL Jul 04 17:13:54.069610 np0000004511 cinder-volume[98636]: glance_certfile = None Jul 04 17:13:54.069610 np0000004511 cinder-volume[98636]: glance_core_properties = Jul 04 17:13:54.069610 np0000004511 cinder-volume[98636]: checksum Jul 04 17:13:54.069610 np0000004511 cinder-volume[98636]: container_format Jul 04 17:13:54.069610 np0000004511 cinder-volume[98636]: disk_format Jul 04 17:13:54.069610 np0000004511 cinder-volume[98636]: image_id Jul 04 17:13:54.069610 np0000004511 cinder-volume[98636]: image_name Jul 04 17:13:54.069610 np0000004511 cinder-volume[98636]: min_disk Jul 04 17:13:54.069610 np0000004511 cinder-volume[98636]: min_ram Jul 04 17:13:54.069610 np0000004511 cinder-volume[98636]: name Jul 04 17:13:54.069610 np0000004511 cinder-volume[98636]: size Jul 04 17:13:54.069610 np0000004511 cinder-volume[98636]: glance_keyfile = None Jul 04 17:13:54.069610 np0000004511 cinder-volume[98636]: glance_num_retries = 3 Jul 04 17:13:54.069610 np0000004511 cinder-volume[98636]: glance_request_timeout = None Jul 04 17:13:54.069610 np0000004511 cinder-volume[98636]: goodness_function = None Jul 04 17:13:54.069610 np0000004511 cinder-volume[98636]: graceful_shutdown_timeout = 5 Jul 04 17:13:54.069610 np0000004511 cinder-volume[98636]: group_api_class = cinder.group.api.API Jul 04 17:13:54.069610 np0000004511 cinder-volume[98636]: host = np0000004511 Jul 04 17:13:54.069610 np0000004511 cinder-volume[98636]: image_compress_on_upload = True Jul 04 17:13:54.069610 np0000004511 cinder-volume[98636]: image_conversion_address_space_limit = 1 Jul 04 17:13:54.069610 np0000004511 cinder-volume[98636]: image_conversion_cpu_limit = 60 Jul 04 17:13:54.069610 np0000004511 cinder-volume[98636]: image_conversion_dir = /opt/stack/data/cinder/conversion Jul 04 17:13:54.069610 np0000004511 cinder-volume[98636]: image_conversion_disable = False Jul 04 17:13:54.070833 np0000004511 cinder-volume[98636]: image_upload_use_cinder_backend = False Jul 04 17:13:54.070833 np0000004511 cinder-volume[98636]: image_upload_use_internal_tenant = False Jul 04 17:13:54.070833 np0000004511 cinder-volume[98636]: image_volume_cache_enabled = False Jul 04 17:13:54.070833 np0000004511 cinder-volume[98636]: image_volume_cache_max_count = 0 Jul 04 17:13:54.070833 np0000004511 cinder-volume[98636]: image_volume_cache_max_size_gb = 0 Jul 04 17:13:54.070833 np0000004511 cinder-volume[98636]: init_host_max_objects_retrieval = 0 Jul 04 17:13:54.070833 np0000004511 cinder-volume[98636]: instance_format = [instance: %(uuid)s] Jul 04 17:13:54.070833 np0000004511 cinder-volume[98636]: instance_uuid_format = [instance: %(uuid)s] Jul 04 17:13:54.070833 np0000004511 cinder-volume[98636]: iscsi_target_flags = Jul 04 17:13:54.070833 np0000004511 cinder-volume[98636]: iscsi_write_cache = on Jul 04 17:13:54.070833 np0000004511 cinder-volume[98636]: iser_helper = tgtadm Jul 04 17:13:54.070833 np0000004511 cinder-volume[98636]: iser_ip_address = 10.4.3.236 Jul 04 17:13:54.070833 np0000004511 cinder-volume[98636]: iser_port = 3260 Jul 04 17:13:54.070833 np0000004511 cinder-volume[98636]: iser_target_prefix = iqn.2010-10.org.openstack: Jul 04 17:13:54.070833 np0000004511 cinder-volume[98636]: log-config-append = None Jul 04 17:13:54.070833 np0000004511 cinder-volume[98636]: log-date-format = %Y-%m-%d %H:%M:%S Jul 04 17:13:54.070833 np0000004511 cinder-volume[98636]: log-dir = None Jul 04 17:13:54.070833 np0000004511 cinder-volume[98636]: log-file = None Jul 04 17:13:54.070833 np0000004511 cinder-volume[98636]: log_color = False Jul 04 17:13:54.070833 np0000004511 cinder-volume[98636]: log_options = True Jul 04 17:13:54.070833 np0000004511 cinder-volume[98636]: log_rotate_interval = 1 Jul 04 17:13:54.070833 np0000004511 cinder-volume[98636]: log_rotate_interval_type = days Jul 04 17:13:54.070833 np0000004511 cinder-volume[98636]: log_rotation_type = none Jul 04 17:13:54.070833 np0000004511 cinder-volume[98636]: logging_context_format_string = %(color)s%(levelname)s %(name)s [%(global_request_id)s %(request_id)s %(project_name)s %(user_name)s%(color)s] %(instance)s%(color)s%(message)s Jul 04 17:13:54.070833 np0000004511 cinder-volume[98636]: logging_debug_format_suffix = {{(pid=%(process)d) %(funcName)s %(pathname)s:%(lineno)d}} Jul 04 17:13:54.070833 np0000004511 cinder-volume[98636]: logging_default_format_string = %(color)s%(levelname)s %(name)s [-%(color)s] %(instance)s%(color)s%(message)s Jul 04 17:13:54.070833 np0000004511 cinder-volume[98636]: logging_exception_prefix = ERROR %(name)s %(instance)s Jul 04 17:13:54.070833 np0000004511 cinder-volume[98636]: logging_user_identity_format = %(user)s %(project)s %(domain)s %(system_scope)s %(user_domain)s %(project_domain)s Jul 04 17:13:54.070833 np0000004511 cinder-volume[98636]: max_age = 0 Jul 04 17:13:54.070833 np0000004511 cinder-volume[98636]: max_logfile_count = 30 Jul 04 17:13:54.070833 np0000004511 cinder-volume[98636]: max_logfile_size_mb = 200 Jul 04 17:13:54.070833 np0000004511 cinder-volume[98636]: max_over_subscription_ratio = 20.0 Jul 04 17:13:54.070833 np0000004511 cinder-volume[98636]: message_reap_interval = 86400 Jul 04 17:13:54.070833 np0000004511 cinder-volume[98636]: message_ttl = 2592000 Jul 04 17:13:54.070833 np0000004511 cinder-volume[98636]: migration_create_volume_timeout_secs = 300 Jul 04 17:13:54.070833 np0000004511 cinder-volume[98636]: monkey_patch = False Jul 04 17:13:54.070833 np0000004511 cinder-volume[98636]: monkey_patch_modules = Jul 04 17:13:54.070833 np0000004511 cinder-volume[98636]: my_ip = 10.4.3.236 Jul 04 17:13:54.070833 np0000004511 cinder-volume[98636]: no_snapshot_gb_quota = False Jul 04 17:13:54.070833 np0000004511 cinder-volume[98636]: num_iser_scan_tries = 3 Jul 04 17:13:54.070833 np0000004511 cinder-volume[98636]: num_shell_tries = 3 Jul 04 17:13:54.070833 np0000004511 cinder-volume[98636]: num_volume_device_scan_tries = 3 Jul 04 17:13:54.070833 np0000004511 cinder-volume[98636]: nvmeof_conn_info_version = 1 Jul 04 17:13:54.070833 np0000004511 cinder-volume[98636]: nvmet_ns_id = 10 Jul 04 17:13:54.070833 np0000004511 cinder-volume[98636]: nvmet_port_id = 1 Jul 04 17:13:54.070833 np0000004511 cinder-volume[98636]: osapi_max_limit = 1000 Jul 04 17:13:54.070833 np0000004511 cinder-volume[98636]: osapi_volume_ext_list = Jul 04 17:13:54.070833 np0000004511 cinder-volume[98636]: osapi_volume_extension = Jul 04 17:13:54.070833 np0000004511 cinder-volume[98636]: cinder.api.contrib.standard_extensions Jul 04 17:13:54.070833 np0000004511 cinder-volume[98636]: osapi_volume_listen = 0.0.0.0 Jul 04 17:13:54.070833 np0000004511 cinder-volume[98636]: osapi_volume_listen_port = 8776 Jul 04 17:13:54.070833 np0000004511 cinder-volume[98636]: osapi_volume_use_ssl = False Jul 04 17:13:54.073171 np0000004511 cinder-volume[98636]: osapi_volume_workers = None Jul 04 17:13:54.073171 np0000004511 cinder-volume[98636]: per_volume_size_limit = -1 Jul 04 17:13:54.073171 np0000004511 cinder-volume[98636]: periodic_fuzzy_delay = 60 Jul 04 17:13:54.073171 np0000004511 cinder-volume[98636]: periodic_interval = 60 Jul 04 17:13:54.073171 np0000004511 cinder-volume[98636]: project_id_regex = [0-9a-f\-]+ Jul 04 17:13:54.073171 np0000004511 cinder-volume[98636]: public_endpoint = None Jul 04 17:13:54.073171 np0000004511 cinder-volume[98636]: publish_errors = False Jul 04 17:13:54.073171 np0000004511 cinder-volume[98636]: quota_backup_gigabytes = 1000 Jul 04 17:13:54.073171 np0000004511 cinder-volume[98636]: quota_backups = 10 Jul 04 17:13:54.073171 np0000004511 cinder-volume[98636]: quota_driver = cinder.quota.DbQuotaDriver Jul 04 17:13:54.073171 np0000004511 cinder-volume[98636]: quota_gigabytes = 1000 Jul 04 17:13:54.073171 np0000004511 cinder-volume[98636]: quota_groups = 10 Jul 04 17:13:54.073171 np0000004511 cinder-volume[98636]: quota_snapshots = 10 Jul 04 17:13:54.073171 np0000004511 cinder-volume[98636]: quota_volumes = 10 Jul 04 17:13:54.073171 np0000004511 cinder-volume[98636]: rate_limit_burst = 0 Jul 04 17:13:54.073171 np0000004511 cinder-volume[98636]: rate_limit_except_level = CRITICAL Jul 04 17:13:54.073171 np0000004511 cinder-volume[98636]: rate_limit_interval = 0 Jul 04 17:13:54.073171 np0000004511 cinder-volume[98636]: reinit_driver_count = 3 Jul 04 17:13:54.073171 np0000004511 cinder-volume[98636]: replication_device = *** Jul 04 17:13:54.073171 np0000004511 cinder-volume[98636]: report_discard_supported = False Jul 04 17:13:54.073171 np0000004511 cinder-volume[98636]: report_interval = 120 Jul 04 17:13:54.073171 np0000004511 cinder-volume[98636]: reservation_clean_interval = 86400 Jul 04 17:13:54.073171 np0000004511 cinder-volume[98636]: reservation_expire = 86400 Jul 04 17:13:54.073171 np0000004511 cinder-volume[98636]: reserved_image_namespaces = Jul 04 17:13:54.073171 np0000004511 cinder-volume[98636]: reserved_percentage = 0 Jul 04 17:13:54.073171 np0000004511 cinder-volume[98636]: resource_query_filters_file = /etc/cinder/resource_filters.json Jul 04 17:13:54.073171 np0000004511 cinder-volume[98636]: rootwrap_config = /etc/cinder/rootwrap.conf Jul 04 17:13:54.073171 np0000004511 cinder-volume[98636]: scheduler_manager = cinder.scheduler.manager.SchedulerManager Jul 04 17:13:54.073171 np0000004511 cinder-volume[98636]: scst_target_driver = iscsi Jul 04 17:13:54.073171 np0000004511 cinder-volume[98636]: scst_target_iqn_name = None Jul 04 17:13:54.073171 np0000004511 cinder-volume[98636]: service_down_time = 720 Jul 04 17:13:54.073171 np0000004511 cinder-volume[98636]: shell_completion = None Jul 04 17:13:54.073171 np0000004511 cinder-volume[98636]: snapshot_name_template = snapshot-%s Jul 04 17:13:54.073171 np0000004511 cinder-volume[98636]: split_loggers = False Jul 04 17:13:54.073171 np0000004511 cinder-volume[98636]: state_path = /opt/stack/data/cinder Jul 04 17:13:54.073171 np0000004511 cinder-volume[98636]: storage_availability_zone = nova Jul 04 17:13:54.073171 np0000004511 cinder-volume[98636]: storage_protocol = iSCSI Jul 04 17:13:54.073171 np0000004511 cinder-volume[98636]: syslog-log-facility = LOG_USER Jul 04 17:13:54.073171 np0000004511 cinder-volume[98636]: target_helper = lioadm Jul 04 17:13:54.073171 np0000004511 cinder-volume[98636]: target_ip_address = 10.4.3.236 Jul 04 17:13:54.073171 np0000004511 cinder-volume[98636]: target_port = 3260 Jul 04 17:13:54.073171 np0000004511 cinder-volume[98636]: target_prefix = iqn.2010-10.org.openstack: Jul 04 17:13:54.073171 np0000004511 cinder-volume[98636]: target_protocol = iscsi Jul 04 17:13:54.073171 np0000004511 cinder-volume[98636]: target_secondary_ip_addresses = Jul 04 17:13:54.073171 np0000004511 cinder-volume[98636]: trace_flags = None Jul 04 17:13:54.073171 np0000004511 cinder-volume[98636]: transfer_api_class = cinder.transfer.api.API Jul 04 17:13:54.073171 np0000004511 cinder-volume[98636]: transport_url = *** Jul 04 17:13:54.073171 np0000004511 cinder-volume[98636]: until_refresh = 0 Jul 04 17:13:54.073171 np0000004511 cinder-volume[98636]: use-journal = False Jul 04 17:13:54.073171 np0000004511 cinder-volume[98636]: use-json = False Jul 04 17:13:54.073171 np0000004511 cinder-volume[98636]: use-syslog = False Jul 04 17:13:54.073171 np0000004511 cinder-volume[98636]: use_chap_auth = False Jul 04 17:13:54.073171 np0000004511 cinder-volume[98636]: use_default_quota_class = True Jul 04 17:13:54.073171 np0000004511 cinder-volume[98636]: use_multipath_for_image_xfer = False Jul 04 17:13:54.073171 np0000004511 cinder-volume[98636]: use_stderr = False Jul 04 17:13:54.073171 np0000004511 cinder-volume[98636]: verify_glance_signatures = enabled Jul 04 17:13:54.073171 np0000004511 cinder-volume[98636]: vmdk_allowed_types = Jul 04 17:13:54.073171 np0000004511 cinder-volume[98636]: monolithicSparse Jul 04 17:13:54.073171 np0000004511 cinder-volume[98636]: streamOptimized Jul 04 17:13:54.073171 np0000004511 cinder-volume[98636]: volume_api_class = cinder.volume.api.API Jul 04 17:13:54.073171 np0000004511 cinder-volume[98636]: volume_backend_name = None Jul 04 17:13:54.073171 np0000004511 cinder-volume[98636]: volume_clear = zero Jul 04 17:13:54.073171 np0000004511 cinder-volume[98636]: volume_clear_ionice = None Jul 04 17:13:54.073171 np0000004511 cinder-volume[98636]: volume_clear_size = 0 Jul 04 17:13:54.073171 np0000004511 cinder-volume[98636]: volume_copy_blkio_cgroup_name = cinder-volume-copy Jul 04 17:13:54.073171 np0000004511 cinder-volume[98636]: volume_copy_bps_limit = 0 Jul 04 17:13:54.073171 np0000004511 cinder-volume[98636]: volume_dd_blocksize = 1M Jul 04 17:13:54.074614 np0000004511 cinder-volume[98636]: volume_manager = cinder.volume.manager.VolumeManager Jul 04 17:13:54.074614 np0000004511 cinder-volume[98636]: volume_name_template = volume-%s Jul 04 17:13:54.074614 np0000004511 cinder-volume[98636]: volume_service_inithost_offload = False Jul 04 17:13:54.074614 np0000004511 cinder-volume[98636]: volume_usage_audit_period = month Jul 04 17:13:54.074614 np0000004511 cinder-volume[98636]: volumes_dir = /opt/stack/data/cinder/volumes Jul 04 17:13:54.074614 np0000004511 cinder-volume[98636]: zoning_mode = None Jul 04 17:13:54.074614 np0000004511 cinder-volume[98636]: glance: Jul 04 17:13:54.074614 np0000004511 cinder-volume[98636]: auth_section = None Jul 04 17:13:54.074614 np0000004511 cinder-volume[98636]: auth_type = password Jul 04 17:13:54.074614 np0000004511 cinder-volume[98636]: cafile = /opt/stack/data/ca-bundle.pem Jul 04 17:13:54.074614 np0000004511 cinder-volume[98636]: certfile = None Jul 04 17:13:54.074614 np0000004511 cinder-volume[98636]: collect-timing = False Jul 04 17:13:54.074614 np0000004511 cinder-volume[98636]: insecure = False Jul 04 17:13:54.074614 np0000004511 cinder-volume[98636]: keyfile = None Jul 04 17:13:54.074614 np0000004511 cinder-volume[98636]: region_name = None Jul 04 17:13:54.074614 np0000004511 cinder-volume[98636]: split-loggers = False Jul 04 17:13:54.074614 np0000004511 cinder-volume[98636]: timeout = None Jul 04 17:13:54.074614 np0000004511 cinder-volume[98636]: key_manager: Jul 04 17:13:54.074614 np0000004511 cinder-volume[98636]: backend = cinder.keymgr.conf_key_mgr.ConfKeyManager Jul 04 17:13:54.074614 np0000004511 cinder-volume[98636]: keystone_authtoken: Jul 04 17:13:54.074614 np0000004511 cinder-volume[98636]: auth_section = None Jul 04 17:13:54.074614 np0000004511 cinder-volume[98636]: auth_type = password Jul 04 17:13:54.074614 np0000004511 cinder-volume[98636]: auth_version = None Jul 04 17:13:54.074614 np0000004511 cinder-volume[98636]: cache = None Jul 04 17:13:54.074614 np0000004511 cinder-volume[98636]: cafile = /opt/stack/data/ca-bundle.pem Jul 04 17:13:54.074614 np0000004511 cinder-volume[98636]: certfile = None Jul 04 17:13:54.074614 np0000004511 cinder-volume[98636]: delay_auth_decision = False Jul 04 17:13:54.074614 np0000004511 cinder-volume[98636]: enforce_token_bind = permissive Jul 04 17:13:54.074614 np0000004511 cinder-volume[98636]: http_connect_timeout = None Jul 04 17:13:54.074614 np0000004511 cinder-volume[98636]: http_request_max_retries = 3 Jul 04 17:13:54.074614 np0000004511 cinder-volume[98636]: include_service_catalog = True Jul 04 17:13:54.074614 np0000004511 cinder-volume[98636]: insecure = False Jul 04 17:13:54.074614 np0000004511 cinder-volume[98636]: interface = public Jul 04 17:13:54.074614 np0000004511 cinder-volume[98636]: keyfile = None Jul 04 17:13:54.074614 np0000004511 cinder-volume[98636]: memcache_password = Jul 04 17:13:54.074614 np0000004511 cinder-volume[98636]: memcache_pool_conn_get_timeout = 10 Jul 04 17:13:54.074614 np0000004511 cinder-volume[98636]: memcache_pool_dead_retry = 300 Jul 04 17:13:54.074614 np0000004511 cinder-volume[98636]: memcache_pool_maxsize = 10 Jul 04 17:13:54.074614 np0000004511 cinder-volume[98636]: memcache_pool_socket_timeout = 3 Jul 04 17:13:54.074614 np0000004511 cinder-volume[98636]: memcache_pool_unused_timeout = 60 Jul 04 17:13:54.074614 np0000004511 cinder-volume[98636]: memcache_sasl_enabled = False Jul 04 17:13:54.074614 np0000004511 cinder-volume[98636]: memcache_secret_key = *** Jul 04 17:13:54.074614 np0000004511 cinder-volume[98636]: memcache_security_strategy = None Jul 04 17:13:54.074614 np0000004511 cinder-volume[98636]: memcache_tls_allowed_ciphers = None Jul 04 17:13:54.074614 np0000004511 cinder-volume[98636]: memcache_tls_cafile = None Jul 04 17:13:54.074614 np0000004511 cinder-volume[98636]: memcache_tls_certfile = None Jul 04 17:13:54.074614 np0000004511 cinder-volume[98636]: memcache_tls_enabled = False Jul 04 17:13:54.074614 np0000004511 cinder-volume[98636]: memcache_tls_keyfile = None Jul 04 17:13:54.074614 np0000004511 cinder-volume[98636]: memcache_use_advanced_pool = True Jul 04 17:13:54.074614 np0000004511 cinder-volume[98636]: memcache_username = Jul 04 17:13:54.074614 np0000004511 cinder-volume[98636]: memcached_servers = Jul 04 17:13:54.074614 np0000004511 cinder-volume[98636]: localhost:11211 Jul 04 17:13:54.074614 np0000004511 cinder-volume[98636]: region_name = None Jul 04 17:13:54.074614 np0000004511 cinder-volume[98636]: service_token_roles = Jul 04 17:13:54.074614 np0000004511 cinder-volume[98636]: service Jul 04 17:13:54.074614 np0000004511 cinder-volume[98636]: service_token_roles_required = True Jul 04 17:13:54.074614 np0000004511 cinder-volume[98636]: service_type = None Jul 04 17:13:54.074614 np0000004511 cinder-volume[98636]: token_cache_time = 300 Jul 04 17:13:54.074614 np0000004511 cinder-volume[98636]: www_authenticate_uri = https://10.4.3.236/identity Jul 04 17:13:54.074614 np0000004511 cinder-volume[98636]: os_brick: Jul 04 17:13:54.074614 np0000004511 cinder-volume[98636]: lightos_discovery_client_address = localhost Jul 04 17:13:54.074614 np0000004511 cinder-volume[98636]: lightos_discovery_client_dir_path = /etc/discovery-client/discovery.d/ Jul 04 17:13:54.074614 np0000004511 cinder-volume[98636]: lightos_discovery_client_port = 6060 Jul 04 17:13:54.074614 np0000004511 cinder-volume[98636]: lock_path = /opt/stack/data/os_brick Jul 04 17:13:54.074614 np0000004511 cinder-volume[98636]: wait_mpath_device_attempts = 4 Jul 04 17:13:54.074614 np0000004511 cinder-volume[98636]: wait_mpath_device_interval = 1 Jul 04 17:13:54.074614 np0000004511 cinder-volume[98636]: oslo_concurrency: Jul 04 17:13:54.074614 np0000004511 cinder-volume[98636]: disable_process_locking = False Jul 04 17:13:54.074614 np0000004511 cinder-volume[98636]: lock_path = /opt/stack/data/cinder Jul 04 17:13:54.075730 np0000004511 cinder-volume[98636]: oslo_messaging_metrics: Jul 04 17:13:54.075730 np0000004511 cinder-volume[98636]: metrics_buffer_size = 1000 Jul 04 17:13:54.075730 np0000004511 cinder-volume[98636]: metrics_enabled = False Jul 04 17:13:54.075730 np0000004511 cinder-volume[98636]: metrics_process_name = Jul 04 17:13:54.075730 np0000004511 cinder-volume[98636]: metrics_socket_file = /var/tmp/metrics_collector.sock Jul 04 17:13:54.075730 np0000004511 cinder-volume[98636]: metrics_thread_stop_timeout = 10 Jul 04 17:13:54.075730 np0000004511 cinder-volume[98636]: oslo_messaging_notifications: Jul 04 17:13:54.075730 np0000004511 cinder-volume[98636]: driver = Jul 04 17:13:54.075730 np0000004511 cinder-volume[98636]: retry = -1 Jul 04 17:13:54.075730 np0000004511 cinder-volume[98636]: topics = Jul 04 17:13:54.075730 np0000004511 cinder-volume[98636]: notifications Jul 04 17:13:54.075730 np0000004511 cinder-volume[98636]: transport_url = *** Jul 04 17:13:54.075730 np0000004511 cinder-volume[98636]: oslo_messaging_rabbit: Jul 04 17:13:54.075730 np0000004511 cinder-volume[98636]: amqp_auto_delete = False Jul 04 17:13:54.075730 np0000004511 cinder-volume[98636]: amqp_durable_queues = False Jul 04 17:13:54.075730 np0000004511 cinder-volume[98636]: conn_pool_min_size = 2 Jul 04 17:13:54.075730 np0000004511 cinder-volume[98636]: conn_pool_ttl = 1200 Jul 04 17:13:54.075730 np0000004511 cinder-volume[98636]: direct_mandatory_flag = True Jul 04 17:13:54.075730 np0000004511 cinder-volume[98636]: enable_cancel_on_failover = False Jul 04 17:13:54.075730 np0000004511 cinder-volume[98636]: heartbeat_rate = 3 Jul 04 17:13:54.075730 np0000004511 cinder-volume[98636]: heartbeat_timeout_threshold = 60 Jul 04 17:13:54.075730 np0000004511 cinder-volume[98636]: hostname = np0000004511 Jul 04 17:13:54.075730 np0000004511 cinder-volume[98636]: kombu_compression = None Jul 04 17:13:54.075730 np0000004511 cinder-volume[98636]: kombu_failover_strategy = round-robin Jul 04 17:13:54.075730 np0000004511 cinder-volume[98636]: kombu_missing_consumer_retry_timeout = 60 Jul 04 17:13:54.075730 np0000004511 cinder-volume[98636]: kombu_reconnect_delay = 1.0 Jul 04 17:13:54.075730 np0000004511 cinder-volume[98636]: kombu_reconnect_splay = 0.0 Jul 04 17:13:54.075730 np0000004511 cinder-volume[98636]: processname = cinder-volume Jul 04 17:13:54.075730 np0000004511 cinder-volume[98636]: rabbit_ha_queues = False Jul 04 17:13:54.075730 np0000004511 cinder-volume[98636]: rabbit_interval_max = 30 Jul 04 17:13:54.075730 np0000004511 cinder-volume[98636]: rabbit_login_method = AMQPLAIN Jul 04 17:13:54.075730 np0000004511 cinder-volume[98636]: rabbit_qos_prefetch_count = 0 Jul 04 17:13:54.075730 np0000004511 cinder-volume[98636]: rabbit_quorum_delivery_limit = 0 Jul 04 17:13:54.075730 np0000004511 cinder-volume[98636]: rabbit_quorum_max_memory_bytes = 0 Jul 04 17:13:54.075730 np0000004511 cinder-volume[98636]: rabbit_quorum_max_memory_length = 0 Jul 04 17:13:54.075730 np0000004511 cinder-volume[98636]: rabbit_quorum_queue = False Jul 04 17:13:54.075730 np0000004511 cinder-volume[98636]: rabbit_retry_backoff = 2 Jul 04 17:13:54.075730 np0000004511 cinder-volume[98636]: rabbit_retry_interval = 1 Jul 04 17:13:54.075730 np0000004511 cinder-volume[98636]: rabbit_stream_fanout = False Jul 04 17:13:54.075730 np0000004511 cinder-volume[98636]: rabbit_transient_queues_ttl = 1800 Jul 04 17:13:54.075730 np0000004511 cinder-volume[98636]: rabbit_transient_quorum_queue = False Jul 04 17:13:54.075730 np0000004511 cinder-volume[98636]: rpc_conn_pool_size = 30 Jul 04 17:13:54.075730 np0000004511 cinder-volume[98636]: ssl = False Jul 04 17:13:54.075730 np0000004511 cinder-volume[98636]: ssl_ca_file = Jul 04 17:13:54.075730 np0000004511 cinder-volume[98636]: ssl_cert_file = Jul 04 17:13:54.075730 np0000004511 cinder-volume[98636]: ssl_enforce_fips_mode = False Jul 04 17:13:54.075730 np0000004511 cinder-volume[98636]: ssl_enforce_hostname_verification = True Jul 04 17:13:54.075730 np0000004511 cinder-volume[98636]: ssl_key_file = Jul 04 17:13:54.075730 np0000004511 cinder-volume[98636]: ssl_version = Jul 04 17:13:54.075730 np0000004511 cinder-volume[98636]: use_queue_manager = False Jul 04 17:13:54.075730 np0000004511 cinder-volume[98636]: oslo_middleware: Jul 04 17:13:54.075730 np0000004511 cinder-volume[98636]: http_basic_auth_user_file = /etc/htpasswd Jul 04 17:13:54.075730 np0000004511 cinder-volume[98636]: oslo_policy: Jul 04 17:13:54.075730 np0000004511 cinder-volume[98636]: enforce_new_defaults = True Jul 04 17:13:54.075730 np0000004511 cinder-volume[98636]: enforce_scope = False Jul 04 17:13:54.075730 np0000004511 cinder-volume[98636]: policy_default_rule = default Jul 04 17:13:54.075730 np0000004511 cinder-volume[98636]: policy_dirs = Jul 04 17:13:54.075730 np0000004511 cinder-volume[98636]: policy.d Jul 04 17:13:54.075730 np0000004511 cinder-volume[98636]: policy_file = policy.yaml Jul 04 17:13:54.075730 np0000004511 cinder-volume[98636]: remote_content_type = application/x-www-form-urlencoded Jul 04 17:13:54.075730 np0000004511 cinder-volume[98636]: remote_ssl_ca_crt_file = None Jul 04 17:13:54.075730 np0000004511 cinder-volume[98636]: remote_ssl_client_crt_file = None Jul 04 17:13:54.075730 np0000004511 cinder-volume[98636]: remote_ssl_client_key_file = None Jul 04 17:13:54.075730 np0000004511 cinder-volume[98636]: remote_ssl_verify_server_crt = False Jul 04 17:13:54.075730 np0000004511 cinder-volume[98636]: remote_timeout = 60.0 Jul 04 17:13:54.075730 np0000004511 cinder-volume[98636]: oslo_reports: Jul 04 17:13:54.075730 np0000004511 cinder-volume[98636]: file_event_handler = None Jul 04 17:13:54.075730 np0000004511 cinder-volume[98636]: file_event_handler_interval = 1 Jul 04 17:13:54.075730 np0000004511 cinder-volume[98636]: log_dir = None Jul 04 17:13:54.075730 np0000004511 cinder-volume[98636]: oslo_versionedobjects: Jul 04 17:13:54.075730 np0000004511 cinder-volume[98636]: fatal_exception_format_errors = False Jul 04 17:13:54.075730 np0000004511 cinder-volume[98636]: privsep_osbrick: Jul 04 17:13:54.079069 np0000004511 cinder-volume[98636]: capabilities = Jul 04 17:13:54.079069 np0000004511 cinder-volume[98636]: 2 Jul 04 17:13:54.079069 np0000004511 cinder-volume[98636]: 21 Jul 04 17:13:54.079069 np0000004511 cinder-volume[98636]: group = None Jul 04 17:13:54.079069 np0000004511 cinder-volume[98636]: helper_command = None Jul 04 17:13:54.079069 np0000004511 cinder-volume[98636]: log_daemon_traceback = False Jul 04 17:13:54.079069 np0000004511 cinder-volume[98636]: logger_name = brick_privsep_hide_output Jul 04 17:13:54.079069 np0000004511 cinder-volume[98636]: thread_pool_size = 16 Jul 04 17:13:54.079069 np0000004511 cinder-volume[98636]: user = None Jul 04 17:13:54.079069 np0000004511 cinder-volume[98636]: profiler: Jul 04 17:13:54.079069 np0000004511 cinder-volume[98636]: connection_string = messaging:// Jul 04 17:13:54.079069 np0000004511 cinder-volume[98636]: enabled = False Jul 04 17:13:54.079069 np0000004511 cinder-volume[98636]: es_doc_type = notification Jul 04 17:13:54.079069 np0000004511 cinder-volume[98636]: es_scroll_size = 10000 Jul 04 17:13:54.079069 np0000004511 cinder-volume[98636]: es_scroll_time = 2m Jul 04 17:13:54.079069 np0000004511 cinder-volume[98636]: filter_error_trace = False Jul 04 17:13:54.079069 np0000004511 cinder-volume[98636]: hmac_keys = *** Jul 04 17:13:54.079069 np0000004511 cinder-volume[98636]: sentinel_service_name = mymaster Jul 04 17:13:54.079069 np0000004511 cinder-volume[98636]: socket_timeout = 0.1 Jul 04 17:13:54.079069 np0000004511 cinder-volume[98636]: trace_requests = False Jul 04 17:13:54.079069 np0000004511 cinder-volume[98636]: trace_sqlalchemy = False Jul 04 17:13:54.079069 np0000004511 cinder-volume[98636]: profiler_jaeger: Jul 04 17:13:54.079069 np0000004511 cinder-volume[98636]: process_tags: Jul 04 17:13:54.079069 np0000004511 cinder-volume[98636]: service_name_prefix = None Jul 04 17:13:54.079069 np0000004511 cinder-volume[98636]: profiler_otlp: Jul 04 17:13:54.079069 np0000004511 cinder-volume[98636]: service_name_prefix = None Jul 04 17:13:54.079069 np0000004511 cinder-volume[98636]: service_user: Jul 04 17:13:54.079069 np0000004511 cinder-volume[98636]: auth_section = None Jul 04 17:13:54.079069 np0000004511 cinder-volume[98636]: auth_type = password Jul 04 17:13:54.079069 np0000004511 cinder-volume[98636]: cafile = None Jul 04 17:13:54.079069 np0000004511 cinder-volume[98636]: certfile = None Jul 04 17:13:54.079069 np0000004511 cinder-volume[98636]: collect-timing = False Jul 04 17:13:54.079069 np0000004511 cinder-volume[98636]: insecure = False Jul 04 17:13:54.079069 np0000004511 cinder-volume[98636]: keyfile = None Jul 04 17:13:54.079069 np0000004511 cinder-volume[98636]: send_service_user_token = True Jul 04 17:13:54.079069 np0000004511 cinder-volume[98636]: split-loggers = False Jul 04 17:13:54.079069 np0000004511 cinder-volume[98636]: timeout = None Jul 04 17:13:54.079069 np0000004511 cinder-volume[98636]: storpool: Jul 04 17:13:54.079069 np0000004511 cinder-volume[98636]: backend_host = None Jul 04 17:13:54.079069 np0000004511 cinder-volume[98636]: vault: Jul 04 17:13:54.079069 np0000004511 cinder-volume[98636]: approle_role_id = *** Jul 04 17:13:54.079069 np0000004511 cinder-volume[98636]: approle_secret_id = *** Jul 04 17:13:54.079069 np0000004511 cinder-volume[98636]: kv_mountpoint = secret Jul 04 17:13:54.079069 np0000004511 cinder-volume[98636]: kv_path = None Jul 04 17:13:54.079069 np0000004511 cinder-volume[98636]: kv_version = 2 Jul 04 17:13:54.079069 np0000004511 cinder-volume[98636]: namespace = None Jul 04 17:13:54.079069 np0000004511 cinder-volume[98636]: root_token_id = *** Jul 04 17:13:54.079069 np0000004511 cinder-volume[98636]: ssl_ca_crt_file = None Jul 04 17:13:54.079069 np0000004511 cinder-volume[98636]: timeout = 60.0 Jul 04 17:13:54.079069 np0000004511 cinder-volume[98636]: use_ssl = False Jul 04 17:13:54.079069 np0000004511 cinder-volume[98636]: vault_url = http://127.0.0.1:8200 Jul 04 17:13:54.091606 np0000004511 cinder-volume[98636]: DEBUG oslo_db.sqlalchemy.engines [None req-8b5170f8-f5b4-4ccc-ad76-ee4052af7e18 None None] MySQL server mode set to STRICT_TRANS_TABLES,STRICT_ALL_TABLES,NO_ZERO_IN_DATE,NO_ZERO_DATE,ERROR_FOR_DIVISION_BY_ZERO,TRADITIONAL,NO_ENGINE_SUBSTITUTION {{(pid=98636) _check_effective_sql_mode /opt/stack/data/venv/lib/python3.12/site-packages/oslo_db/sqlalchemy/engines.py:325}} Jul 04 17:13:54.260270 np0000004511 cinder-volume[98636]: DEBUG dbcounter [-] [98636] Writer thread running {{(pid=98636) stat_writer /opt/stack/data/venv/lib/python3.12/site-packages/dbcounter.py:102}} Jul 04 17:13:54.268850 np0000004511 cinder-volume[98636]: ERROR cinder.cmd.volume [None req-8b5170f8-f5b4-4ccc-ad76-ee4052af7e18 None None] Volume service np0000004511@storpool failed to start.: sqlalchemy.exc.ProgrammingError: (pymysql.err.ProgrammingError) (1146, "Table 'cinder.services' doesn't exist") Jul 04 17:13:54.268850 np0000004511 cinder-volume[98636]: [SQL: SELECT services.id AS services_id, services.uuid AS services_uuid, services.cluster_name AS services_cluster_name, services.host AS services_host, services.`binary` AS services_binary, services.updated_at AS services_updated_at, services.topic AS services_topic, services.report_count AS services_report_count, services.disabled AS services_disabled, services.availability_zone AS services_availability_zone, services.disabled_reason AS services_disabled_reason, services.modified_at AS services_modified_at, services.rpc_current_version AS services_rpc_current_version, services.object_current_version AS services_object_current_version, services.replication_status AS services_replication_status, services.active_backend_id AS services_active_backend_id, services.frozen AS services_frozen, services.deleted_at AS services_deleted_at, services.deleted AS services_deleted, services.created_at AS services_created_at Jul 04 17:13:54.268850 np0000004511 cinder-volume[98636]: FROM services Jul 04 17:13:54.268850 np0000004511 cinder-volume[98636]: WHERE services.deleted = false AND services.`binary` = %(binary_1)s] Jul 04 17:13:54.268850 np0000004511 cinder-volume[98636]: [parameters: {'binary_1': 'cinder-scheduler'}] Jul 04 17:13:54.268850 np0000004511 cinder-volume[98636]: (Background on this error at: https://sqlalche.me/e/20/f405) Jul 04 17:13:54.268850 np0000004511 cinder-volume[98636]: ERROR cinder.cmd.volume Traceback (most recent call last): Jul 04 17:13:54.268850 np0000004511 cinder-volume[98636]: ERROR cinder.cmd.volume File "/opt/stack/data/venv/lib/python3.12/site-packages/sqlalchemy/engine/base.py", line 1969, in _exec_single_context Jul 04 17:13:54.268850 np0000004511 cinder-volume[98636]: ERROR cinder.cmd.volume self.dialect.do_execute( Jul 04 17:13:54.268850 np0000004511 cinder-volume[98636]: ERROR cinder.cmd.volume File "/opt/stack/data/venv/lib/python3.12/site-packages/sqlalchemy/engine/default.py", line 952, in do_execute Jul 04 17:13:54.268850 np0000004511 cinder-volume[98636]: ERROR cinder.cmd.volume cursor.execute(statement, parameters) Jul 04 17:13:54.269208 np0000004511 cinder-volume[98636]: ERROR cinder.cmd.volume File "/opt/stack/data/venv/lib/python3.12/site-packages/pymysql/cursors.py", line 159, in execute Jul 04 17:13:54.269208 np0000004511 cinder-volume[98636]: ERROR cinder.cmd.volume result = self._query(query) Jul 04 17:13:54.269208 np0000004511 cinder-volume[98636]: ERROR cinder.cmd.volume ^^^^^^^^^^^^^^^^^^ Jul 04 17:13:54.269208 np0000004511 cinder-volume[98636]: ERROR cinder.cmd.volume File "/opt/stack/data/venv/lib/python3.12/site-packages/pymysql/cursors.py", line 330, in _query Jul 04 17:13:54.269208 np0000004511 cinder-volume[98636]: ERROR cinder.cmd.volume conn.query(q) Jul 04 17:13:54.269208 np0000004511 cinder-volume[98636]: ERROR cinder.cmd.volume File "/opt/stack/data/venv/lib/python3.12/site-packages/pymysql/connections.py", line 582, in query Jul 04 17:13:54.269208 np0000004511 cinder-volume[98636]: ERROR cinder.cmd.volume self._affected_rows = self._read_query_result(unbuffered=unbuffered) Jul 04 17:13:54.269208 np0000004511 cinder-volume[98636]: ERROR cinder.cmd.volume ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ Jul 04 17:13:54.269208 np0000004511 cinder-volume[98636]: ERROR cinder.cmd.volume File "/opt/stack/data/venv/lib/python3.12/site-packages/pymysql/connections.py", line 847, in _read_query_result Jul 04 17:13:54.269208 np0000004511 cinder-volume[98636]: ERROR cinder.cmd.volume result.read() Jul 04 17:13:54.269208 np0000004511 cinder-volume[98636]: ERROR cinder.cmd.volume File "/opt/stack/data/venv/lib/python3.12/site-packages/pymysql/connections.py", line 1245, in read Jul 04 17:13:54.269208 np0000004511 cinder-volume[98636]: ERROR cinder.cmd.volume first_packet = self.connection._read_packet() Jul 04 17:13:54.269208 np0000004511 cinder-volume[98636]: ERROR cinder.cmd.volume ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ Jul 04 17:13:54.269208 np0000004511 cinder-volume[98636]: ERROR cinder.cmd.volume File "/opt/stack/data/venv/lib/python3.12/site-packages/pymysql/connections.py", line 803, in _read_packet Jul 04 17:13:54.269208 np0000004511 cinder-volume[98636]: ERROR cinder.cmd.volume packet.raise_for_error() Jul 04 17:13:54.269208 np0000004511 cinder-volume[98636]: ERROR cinder.cmd.volume File "/opt/stack/data/venv/lib/python3.12/site-packages/pymysql/protocol.py", line 219, in raise_for_error Jul 04 17:13:54.269208 np0000004511 cinder-volume[98636]: ERROR cinder.cmd.volume err.raise_mysql_exception(self._data) Jul 04 17:13:54.269208 np0000004511 cinder-volume[98636]: ERROR cinder.cmd.volume File "/opt/stack/data/venv/lib/python3.12/site-packages/pymysql/err.py", line 154, in raise_mysql_exception Jul 04 17:13:54.269208 np0000004511 cinder-volume[98636]: ERROR cinder.cmd.volume raise errorclass(errno, errval, sqlstate=sqlstate) Jul 04 17:13:54.269533 np0000004511 cinder-volume[98636]: ERROR cinder.cmd.volume pymysql.err.ProgrammingError: (1146, "Table 'cinder.services' doesn't exist") Jul 04 17:13:54.269533 np0000004511 cinder-volume[98636]: ERROR cinder.cmd.volume Jul 04 17:13:54.269533 np0000004511 cinder-volume[98636]: ERROR cinder.cmd.volume The above exception was the direct cause of the following exception: Jul 04 17:13:54.269533 np0000004511 cinder-volume[98636]: ERROR cinder.cmd.volume Jul 04 17:13:54.269533 np0000004511 cinder-volume[98636]: ERROR cinder.cmd.volume Traceback (most recent call last): Jul 04 17:13:54.269533 np0000004511 cinder-volume[98636]: ERROR cinder.cmd.volume File "/opt/stack/cinder/cinder/cmd/volume.py", line 85, in _launch_service Jul 04 17:13:54.269533 np0000004511 cinder-volume[98636]: ERROR cinder.cmd.volume server = service.Service.create(host=host, Jul 04 17:13:54.269533 np0000004511 cinder-volume[98636]: ERROR cinder.cmd.volume ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ Jul 04 17:13:54.269533 np0000004511 cinder-volume[98636]: ERROR cinder.cmd.volume File "/opt/stack/cinder/cinder/service.py", line 413, in create Jul 04 17:13:54.269533 np0000004511 cinder-volume[98636]: ERROR cinder.cmd.volume service_obj = cls(host, binary, topic, manager, Jul 04 17:13:54.269533 np0000004511 cinder-volume[98636]: ERROR cinder.cmd.volume ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ Jul 04 17:13:54.269533 np0000004511 cinder-volume[98636]: ERROR cinder.cmd.volume File "/opt/stack/cinder/cinder/service.py", line 151, in __init__ Jul 04 17:13:54.269533 np0000004511 cinder-volume[98636]: ERROR cinder.cmd.volume self.manager = manager_class(host=self.host, Jul 04 17:13:54.269533 np0000004511 cinder-volume[98636]: ERROR cinder.cmd.volume ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ Jul 04 17:13:54.269533 np0000004511 cinder-volume[98636]: ERROR cinder.cmd.volume File "/opt/stack/cinder/cinder/volume/manager.py", line 262, in __init__ Jul 04 17:13:54.269533 np0000004511 cinder-volume[98636]: ERROR cinder.cmd.volume super(VolumeManager, self).__init__( Jul 04 17:13:54.269533 np0000004511 cinder-volume[98636]: ERROR cinder.cmd.volume File "/opt/stack/cinder/cinder/manager.py", line 251, in __init__ Jul 04 17:13:54.269533 np0000004511 cinder-volume[98636]: ERROR cinder.cmd.volume super(SizedThreadPoolManager, self).__init__(*args, **kwargs) Jul 04 17:13:54.269533 np0000004511 cinder-volume[98636]: ERROR cinder.cmd.volume File "/opt/stack/cinder/cinder/manager.py", line 209, in __init__ Jul 04 17:13:54.269533 np0000004511 cinder-volume[98636]: ERROR cinder.cmd.volume self.scheduler_rpcapi = scheduler_rpcapi.SchedulerAPI() Jul 04 17:13:54.269533 np0000004511 cinder-volume[98636]: ERROR cinder.cmd.volume ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ Jul 04 17:13:54.269533 np0000004511 cinder-volume[98636]: ERROR cinder.cmd.volume File "/opt/stack/cinder/cinder/rpc.py", line 219, in __init__ Jul 04 17:13:54.269870 np0000004511 cinder-volume[98636]: ERROR cinder.cmd.volume obj_version_cap = self.determine_obj_version_cap() Jul 04 17:13:54.269870 np0000004511 cinder-volume[98636]: ERROR cinder.cmd.volume ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ Jul 04 17:13:54.269870 np0000004511 cinder-volume[98636]: ERROR cinder.cmd.volume File "/opt/stack/cinder/cinder/rpc.py", line 273, in determine_obj_version_cap Jul 04 17:13:54.269870 np0000004511 cinder-volume[98636]: ERROR cinder.cmd.volume version_cap = objects.Service.get_minimum_obj_version( Jul 04 17:13:54.269870 np0000004511 cinder-volume[98636]: ERROR cinder.cmd.volume ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ Jul 04 17:13:54.269870 np0000004511 cinder-volume[98636]: ERROR cinder.cmd.volume File "/opt/stack/cinder/cinder/objects/service.py", line 207, in get_minimum_obj_version Jul 04 17:13:54.269870 np0000004511 cinder-volume[98636]: ERROR cinder.cmd.volume return cls._get_minimum_version('object_current_version', context, Jul 04 17:13:54.269870 np0000004511 cinder-volume[98636]: ERROR cinder.cmd.volume ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ Jul 04 17:13:54.269870 np0000004511 cinder-volume[98636]: ERROR cinder.cmd.volume File "/opt/stack/cinder/cinder/objects/service.py", line 178, in _get_minimum_version Jul 04 17:13:54.269870 np0000004511 cinder-volume[98636]: ERROR cinder.cmd.volume services = ServiceList.get_all_by_binary(context, binary) Jul 04 17:13:54.269870 np0000004511 cinder-volume[98636]: ERROR cinder.cmd.volume ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ Jul 04 17:13:54.269870 np0000004511 cinder-volume[98636]: ERROR cinder.cmd.volume File "/opt/stack/cinder/cinder/objects/service.py", line 241, in get_all_by_binary Jul 04 17:13:54.269870 np0000004511 cinder-volume[98636]: ERROR cinder.cmd.volume services = db.service_get_all(context, binary=binary, Jul 04 17:13:54.269870 np0000004511 cinder-volume[98636]: ERROR cinder.cmd.volume ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ Jul 04 17:13:54.269870 np0000004511 cinder-volume[98636]: ERROR cinder.cmd.volume File "/opt/stack/cinder/cinder/db/api.py", line 208, in wrapper Jul 04 17:13:54.269870 np0000004511 cinder-volume[98636]: ERROR cinder.cmd.volume return f(*args, **kwargs) Jul 04 17:13:54.269870 np0000004511 cinder-volume[98636]: ERROR cinder.cmd.volume ^^^^^^^^^^^^^^^^^^ Jul 04 17:13:54.269870 np0000004511 cinder-volume[98636]: ERROR cinder.cmd.volume File "/opt/stack/data/venv/lib/python3.12/site-packages/oslo_db/sqlalchemy/enginefacade.py", line 1159, in wrapper Jul 04 17:13:54.269870 np0000004511 cinder-volume[98636]: ERROR cinder.cmd.volume return fn(*args, **kwargs) Jul 04 17:13:54.269870 np0000004511 cinder-volume[98636]: ERROR cinder.cmd.volume ^^^^^^^^^^^^^^^^^^^ Jul 04 17:13:54.270204 np0000004511 cinder-volume[98636]: ERROR cinder.cmd.volume File "/opt/stack/cinder/cinder/db/api.py", line 907, in service_get_all Jul 04 17:13:54.270204 np0000004511 cinder-volume[98636]: ERROR cinder.cmd.volume return [] if not query else query.all() Jul 04 17:13:54.270204 np0000004511 cinder-volume[98636]: ERROR cinder.cmd.volume ^^^^^^^^^^^ Jul 04 17:13:54.270204 np0000004511 cinder-volume[98636]: ERROR cinder.cmd.volume File "/opt/stack/data/venv/lib/python3.12/site-packages/sqlalchemy/orm/query.py", line 2711, in all Jul 04 17:13:54.270204 np0000004511 cinder-volume[98636]: ERROR cinder.cmd.volume return self._iter().all() # type: ignore Jul 04 17:13:54.270204 np0000004511 cinder-volume[98636]: ERROR cinder.cmd.volume ^^^^^^^^^^^^ Jul 04 17:13:54.270204 np0000004511 cinder-volume[98636]: ERROR cinder.cmd.volume File "/opt/stack/data/venv/lib/python3.12/site-packages/sqlalchemy/orm/query.py", line 2864, in _iter Jul 04 17:13:54.270204 np0000004511 cinder-volume[98636]: ERROR cinder.cmd.volume result: Union[ScalarResult[_T], Result[_T]] = self.session.execute( Jul 04 17:13:54.270204 np0000004511 cinder-volume[98636]: ERROR cinder.cmd.volume ^^^^^^^^^^^^^^^^^^^^^ Jul 04 17:13:54.270204 np0000004511 cinder-volume[98636]: ERROR cinder.cmd.volume File "/opt/stack/data/venv/lib/python3.12/site-packages/sqlalchemy/orm/session.py", line 2373, in execute Jul 04 17:13:54.270204 np0000004511 cinder-volume[98636]: ERROR cinder.cmd.volume return self._execute_internal( Jul 04 17:13:54.270204 np0000004511 cinder-volume[98636]: ERROR cinder.cmd.volume ^^^^^^^^^^^^^^^^^^^^^^^ Jul 04 17:13:54.270204 np0000004511 cinder-volume[98636]: ERROR cinder.cmd.volume File "/opt/stack/data/venv/lib/python3.12/site-packages/sqlalchemy/orm/session.py", line 2271, in _execute_internal Jul 04 17:13:54.270204 np0000004511 cinder-volume[98636]: ERROR cinder.cmd.volume result: Result[Any] = compile_state_cls.orm_execute_statement( Jul 04 17:13:54.270204 np0000004511 cinder-volume[98636]: ERROR cinder.cmd.volume ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ Jul 04 17:13:54.270204 np0000004511 cinder-volume[98636]: ERROR cinder.cmd.volume File "/opt/stack/data/venv/lib/python3.12/site-packages/sqlalchemy/orm/context.py", line 306, in orm_execute_statement Jul 04 17:13:54.270204 np0000004511 cinder-volume[98636]: ERROR cinder.cmd.volume result = conn.execute( Jul 04 17:13:54.270204 np0000004511 cinder-volume[98636]: ERROR cinder.cmd.volume ^^^^^^^^^^^^^ Jul 04 17:13:54.270204 np0000004511 cinder-volume[98636]: ERROR cinder.cmd.volume File "/opt/stack/data/venv/lib/python3.12/site-packages/sqlalchemy/engine/base.py", line 1421, in execute Jul 04 17:13:54.270204 np0000004511 cinder-volume[98636]: ERROR cinder.cmd.volume return meth( Jul 04 17:13:54.270528 np0000004511 cinder-volume[98636]: ERROR cinder.cmd.volume ^^^^^ Jul 04 17:13:54.270528 np0000004511 cinder-volume[98636]: ERROR cinder.cmd.volume File "/opt/stack/data/venv/lib/python3.12/site-packages/sqlalchemy/sql/elements.py", line 526, in _execute_on_connection Jul 04 17:13:54.270528 np0000004511 cinder-volume[98636]: ERROR cinder.cmd.volume return connection._execute_clauseelement( Jul 04 17:13:54.270528 np0000004511 cinder-volume[98636]: ERROR cinder.cmd.volume ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ Jul 04 17:13:54.270528 np0000004511 cinder-volume[98636]: ERROR cinder.cmd.volume File "/opt/stack/data/venv/lib/python3.12/site-packages/sqlalchemy/engine/base.py", line 1643, in _execute_clauseelement Jul 04 17:13:54.270528 np0000004511 cinder-volume[98636]: ERROR cinder.cmd.volume ret = self._execute_context( Jul 04 17:13:54.270528 np0000004511 cinder-volume[98636]: ERROR cinder.cmd.volume ^^^^^^^^^^^^^^^^^^^^^^ Jul 04 17:13:54.270528 np0000004511 cinder-volume[98636]: ERROR cinder.cmd.volume File "/opt/stack/data/venv/lib/python3.12/site-packages/sqlalchemy/engine/base.py", line 1848, in _execute_context Jul 04 17:13:54.270528 np0000004511 cinder-volume[98636]: ERROR cinder.cmd.volume return self._exec_single_context( Jul 04 17:13:54.270528 np0000004511 cinder-volume[98636]: ERROR cinder.cmd.volume ^^^^^^^^^^^^^^^^^^^^^^^^^^ Jul 04 17:13:54.270528 np0000004511 cinder-volume[98636]: ERROR cinder.cmd.volume File "/opt/stack/data/venv/lib/python3.12/site-packages/sqlalchemy/engine/base.py", line 1988, in _exec_single_context Jul 04 17:13:54.270528 np0000004511 cinder-volume[98636]: ERROR cinder.cmd.volume self._handle_dbapi_exception( Jul 04 17:13:54.270528 np0000004511 cinder-volume[98636]: ERROR cinder.cmd.volume File "/opt/stack/data/venv/lib/python3.12/site-packages/sqlalchemy/engine/base.py", line 2362, in _handle_dbapi_exception Jul 04 17:13:54.270528 np0000004511 cinder-volume[98636]: ERROR cinder.cmd.volume raise newraise.with_traceback(exc_info[2]) from e Jul 04 17:13:54.270528 np0000004511 cinder-volume[98636]: ERROR cinder.cmd.volume File "/opt/stack/data/venv/lib/python3.12/site-packages/sqlalchemy/engine/base.py", line 1969, in _exec_single_context Jul 04 17:13:54.270528 np0000004511 cinder-volume[98636]: ERROR cinder.cmd.volume self.dialect.do_execute( Jul 04 17:13:54.270528 np0000004511 cinder-volume[98636]: ERROR cinder.cmd.volume File "/opt/stack/data/venv/lib/python3.12/site-packages/sqlalchemy/engine/default.py", line 952, in do_execute Jul 04 17:13:54.270528 np0000004511 cinder-volume[98636]: ERROR cinder.cmd.volume cursor.execute(statement, parameters) Jul 04 17:13:54.270528 np0000004511 cinder-volume[98636]: ERROR cinder.cmd.volume File "/opt/stack/data/venv/lib/python3.12/site-packages/pymysql/cursors.py", line 159, in execute Jul 04 17:13:54.270821 np0000004511 cinder-volume[98636]: ERROR cinder.cmd.volume result = self._query(query) Jul 04 17:13:54.270821 np0000004511 cinder-volume[98636]: ERROR cinder.cmd.volume ^^^^^^^^^^^^^^^^^^ Jul 04 17:13:54.270821 np0000004511 cinder-volume[98636]: ERROR cinder.cmd.volume File "/opt/stack/data/venv/lib/python3.12/site-packages/pymysql/cursors.py", line 330, in _query Jul 04 17:13:54.270821 np0000004511 cinder-volume[98636]: ERROR cinder.cmd.volume conn.query(q) Jul 04 17:13:54.270821 np0000004511 cinder-volume[98636]: ERROR cinder.cmd.volume File "/opt/stack/data/venv/lib/python3.12/site-packages/pymysql/connections.py", line 582, in query Jul 04 17:13:54.270821 np0000004511 cinder-volume[98636]: ERROR cinder.cmd.volume self._affected_rows = self._read_query_result(unbuffered=unbuffered) Jul 04 17:13:54.270821 np0000004511 cinder-volume[98636]: ERROR cinder.cmd.volume ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ Jul 04 17:13:54.270821 np0000004511 cinder-volume[98636]: ERROR cinder.cmd.volume File "/opt/stack/data/venv/lib/python3.12/site-packages/pymysql/connections.py", line 847, in _read_query_result Jul 04 17:13:54.270821 np0000004511 cinder-volume[98636]: ERROR cinder.cmd.volume result.read() Jul 04 17:13:54.270821 np0000004511 cinder-volume[98636]: ERROR cinder.cmd.volume File "/opt/stack/data/venv/lib/python3.12/site-packages/pymysql/connections.py", line 1245, in read Jul 04 17:13:54.270821 np0000004511 cinder-volume[98636]: ERROR cinder.cmd.volume first_packet = self.connection._read_packet() Jul 04 17:13:54.270821 np0000004511 cinder-volume[98636]: ERROR cinder.cmd.volume ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ Jul 04 17:13:54.270821 np0000004511 cinder-volume[98636]: ERROR cinder.cmd.volume File "/opt/stack/data/venv/lib/python3.12/site-packages/pymysql/connections.py", line 803, in _read_packet Jul 04 17:13:54.270821 np0000004511 cinder-volume[98636]: ERROR cinder.cmd.volume packet.raise_for_error() Jul 04 17:13:54.270821 np0000004511 cinder-volume[98636]: ERROR cinder.cmd.volume File "/opt/stack/data/venv/lib/python3.12/site-packages/pymysql/protocol.py", line 219, in raise_for_error Jul 04 17:13:54.270821 np0000004511 cinder-volume[98636]: ERROR cinder.cmd.volume err.raise_mysql_exception(self._data) Jul 04 17:13:54.270821 np0000004511 cinder-volume[98636]: ERROR cinder.cmd.volume File "/opt/stack/data/venv/lib/python3.12/site-packages/pymysql/err.py", line 154, in raise_mysql_exception Jul 04 17:13:54.270821 np0000004511 cinder-volume[98636]: ERROR cinder.cmd.volume raise errorclass(errno, errval, sqlstate=sqlstate) Jul 04 17:13:54.270821 np0000004511 cinder-volume[98636]: ERROR cinder.cmd.volume sqlalchemy.exc.ProgrammingError: (pymysql.err.ProgrammingError) (1146, "Table 'cinder.services' doesn't exist") Jul 04 17:13:54.271088 np0000004511 cinder-volume[98636]: ERROR cinder.cmd.volume [SQL: SELECT services.id AS services_id, services.uuid AS services_uuid, services.cluster_name AS services_cluster_name, services.host AS services_host, services.`binary` AS services_binary, services.updated_at AS services_updated_at, services.topic AS services_topic, services.report_count AS services_report_count, services.disabled AS services_disabled, services.availability_zone AS services_availability_zone, services.disabled_reason AS services_disabled_reason, services.modified_at AS services_modified_at, services.rpc_current_version AS services_rpc_current_version, services.object_current_version AS services_object_current_version, services.replication_status AS services_replication_status, services.active_backend_id AS services_active_backend_id, services.frozen AS services_frozen, services.deleted_at AS services_deleted_at, services.deleted AS services_deleted, services.created_at AS services_created_at Jul 04 17:13:54.271088 np0000004511 cinder-volume[98636]: ERROR cinder.cmd.volume FROM services Jul 04 17:13:54.271088 np0000004511 cinder-volume[98636]: ERROR cinder.cmd.volume WHERE services.deleted = false AND services.`binary` = %(binary_1)s] Jul 04 17:13:54.271088 np0000004511 cinder-volume[98636]: ERROR cinder.cmd.volume [parameters: {'binary_1': 'cinder-scheduler'}] Jul 04 17:13:54.271088 np0000004511 cinder-volume[98636]: ERROR cinder.cmd.volume (Background on this error at: https://sqlalche.me/e/20/f405) Jul 04 17:13:54.271088 np0000004511 cinder-volume[98636]: ERROR cinder.cmd.volume Jul 04 17:13:54.271088 np0000004511 cinder-volume[98636]: ERROR cinder.cmd.volume [None req-8b5170f8-f5b4-4ccc-ad76-ee4052af7e18 None None] No volume service(s) started successfully, terminating. Jul 04 17:13:54.456307 np0000004511 cinder-volume[98636]: Exception ignored in: Jul 04 17:13:54.456307 np0000004511 cinder-volume[98636]: Traceback (most recent call last): Jul 04 17:13:54.456307 np0000004511 cinder-volume[98636]: File "/usr/lib/python3.12/logging/__init__.py", line 884, in _removeHandlerRef Jul 04 17:13:54.456471 np0000004511 cinder-volume[98636]: File "/usr/lib/python3.12/logging/__init__.py", line 241, in _acquireLock Jul 04 17:13:54.456471 np0000004511 cinder-volume[98636]: File "/usr/lib/python3.12/threading.py", line 198, in acquire Jul 04 17:13:54.456471 np0000004511 cinder-volume[98636]: File "/opt/stack/data/venv/lib/python3.12/site-packages/eventlet/green/thread.py", line 39, in get_ident Jul 04 17:13:54.456471 np0000004511 cinder-volume[98636]: RuntimeError: greenlet is being finalized Jul 04 17:13:54.647380 np0000004511 systemd[1]: devstack@c-vol.service: Main process exited, code=exited, status=1/FAILURE Jul 04 17:13:54.647585 np0000004511 systemd[1]: devstack@c-vol.service: Failed with result 'exit-code'.