+ exec cinder-volume --config-file /etc/cinder/cinder.conf --config-file /etc/cinder/conf/backends.conf --config-file /tmp/pod-shared/internal_tenant.conf
simplejson unavailable, fall-back to standard python json
2026-07-10 15:12:57.513 1 INFO cinder.rpc [None req-e8756e7e-a9cc-49c6-b9b2-4262745900bc - - - - - -] Automatically selected cinder-scheduler objects version 1.39 as minimum service version.
2026-07-10 15:12:57.517 1 INFO cinder.rpc [None req-e8756e7e-a9cc-49c6-b9b2-4262745900bc - - - - - -] Automatically selected cinder-scheduler RPC version 3.12 as minimum service version.
2026-07-10 15:12:57.655 1 INFO cinder.volume.manager [None req-e8756e7e-a9cc-49c6-b9b2-4262745900bc - - - - - -] Determined volume DB was empty at startup.
2026-07-10 15:12:57.660 1 INFO cinder.volume.manager [None req-e8756e7e-a9cc-49c6-b9b2-4262745900bc - - - - - -] Service not found for updating active_backend_id, assuming default for driver init.
2026-07-10 15:12:57.717 1 INFO cinder.rpc [None req-e8756e7e-a9cc-49c6-b9b2-4262745900bc - - - - - -] Automatically selected cinder-volume objects version 1.39 as minimum service version.
2026-07-10 15:12:57.721 1 INFO cinder.rpc [None req-e8756e7e-a9cc-49c6-b9b2-4262745900bc - - - - - -] Automatically selected cinder-volume RPC version 3.20 as minimum service version.
2026-07-10 15:12:57.723 1 INFO cinder.volume.manager [None req-e8756e7e-a9cc-49c6-b9b2-4262745900bc - - - - - -] Image-volume cache enabled for host cinder-volume-worker@rbd1.
2026-07-10 15:12:57.767 1 INFO oslo_service.backend._eventlet.service [None req-e8756e7e-a9cc-49c6-b9b2-4262745900bc - - - - - -] Starting 1 workers
2026-07-10 15:12:57.776 8 INFO cinder.service [-] Starting cinder-volume node (version 27.1.0)
2026-07-10 15:12:57.779 1 WARNING oslo_config.cfg [None req-e8756e7e-a9cc-49c6-b9b2-4262745900bc - - - - - -] Deprecated: Option "auth_uri" from group "keystone_authtoken" is deprecated for removal (The auth_uri option is deprecated in favor of www_authenticate_uri and will be removed in the S  release.).  Its value may be silently ignored in the future.
2026-07-10 15:12:57.780 1 WARNING oslo_config.cfg [None req-e8756e7e-a9cc-49c6-b9b2-4262745900bc - - - - - -] Deprecated: Option "auth_uri" from group "keystone_authtoken" is deprecated. Use option "www_authenticate_uri" from group "keystone_authtoken".
2026-07-10 15:12:57.811 8 INFO cinder.volume.manager [None req-d0f6d9e9-b8e5-4cce-a662-ec1093a277b9 - - - - - -] Starting volume driver RBDDriver (1.3.0)
2026-07-10 15:12:57.905 8 INFO cinder.volume.driver [None req-d0f6d9e9-b8e5-4cce-a662-ec1093a277b9 - - - - - -] Driver hasn't implemented _init_vendor_properties()
2026-07-10 15:12:57.967 8 INFO cinder.keymgr.migration [None req-566f07a2-88fd-4a86-b423-1819f1ce2b85 - - - - - -] Not migrating encryption keys because the ConfKeyManager's fixed_key is not in use.
2026-07-10 15:12:58.060 8 INFO cinder.volume.manager [None req-d0f6d9e9-b8e5-4cce-a662-ec1093a277b9 - - - - - -] Driver initialization completed successfully.
2026-07-10 15:12:58.060 8 INFO cinder.manager [None req-d0f6d9e9-b8e5-4cce-a662-ec1093a277b9 - - - - - -] Initiating service 3 cleanup
2026-07-10 15:12:58.071 8 INFO cinder.manager [None req-d0f6d9e9-b8e5-4cce-a662-ec1093a277b9 - - - - - -] Service 3 cleanup completed.
2026-07-10 15:12:58.113 8 INFO cinder.volume.manager [None req-d0f6d9e9-b8e5-4cce-a662-ec1093a277b9 - - - - - -] Initializing RPC dependent components of volume driver RBDDriver (1.3.0)
2026-07-10 15:12:58.205 8 INFO cinder.volume.manager [None req-d0f6d9e9-b8e5-4cce-a662-ec1093a277b9 - - - - - -] Driver post RPC initialization completed successfully.
2026-07-10 15:27:20.145 8 WARNING oslo.service.backend._common.loopingcall [None req-53c8baa8-e7b7-4ef3-96c3-a297521d2c56 - - - - - -] Function 'cinder.service.Service.report_state' run outlasted interval by 1.83 sec
2026-07-10 15:35:06.426 8 WARNING oslo.service.backend._common.loopingcall [None req-53c8baa8-e7b7-4ef3-96c3-a297521d2c56 - - - - - -] Function 'cinder.service.Service.report_state' run outlasted interval by 6.19 sec
2026-07-10 15:46:07.014 8 WARNING oslo.service.backend._common.loopingcall [None req-53c8baa8-e7b7-4ef3-96c3-a297521d2c56 - - - - - -] Function 'cinder.service.Service.report_state' run outlasted interval by 0.37 sec
2026-07-10 15:46:24.805 8 WARNING oslo.service.backend._common.loopingcall [None req-53c8baa8-e7b7-4ef3-96c3-a297521d2c56 - - - - - -] Function 'cinder.service.Service.report_state' run outlasted interval by 7.79 sec
2026-07-10 15:46:45.311 8 WARNING oslo.service.backend._common.loopingcall [None req-53c8baa8-e7b7-4ef3-96c3-a297521d2c56 - - - - - -] Function 'cinder.service.Service.report_state' run outlasted interval by 0.51 sec
2026-07-10 16:17:37.813 8 INFO cinder.volume.flows.manager.create_volume [None req-a8c68b55-31d9-4679-b627-abac7fa8095b d34a3a76228d465eb6e67b6835781278 193d31ce0f9b49c784f8db0aad2fdfd4 - - - -] Volume 2591c32f-9a80-4f37-9a43-c41e81bf43cb: being created as image with specification: {'status': 'creating', 'volume_name': 'volume-2591c32f-9a80-4f37-9a43-c41e81bf43cb', 'volume_size': 1, 'image_id': 'e00298fe-a194-427a-bdef-655d7fa63056', 'image_location': (None, [{'url': 'rbd://4837cbf8-4f90-4300-b3f6-726c9b9f89b4/glance.images/e00298fe-a194-427a-bdef-655d7fa63056/snap', 'metadata': {}}]), 'image_meta': {'name': 'cirros', 'disk_format': 'raw', 'container_format': 'bare', 'visibility': 'public', 'size': 117440512, 'virtual_size': 117440512, 'status': 'active', 'checksum': '4245576e3df99ea1211871b8b9514d3b', 'protected': False, 'min_ram': 0, 'min_disk': 1, 'owner': 'a21c670e1e9049cf90b620b09a50420a', 'os_hidden': False, 'os_hash_algo': 'sha512', 'os_hash_value': 'dbb480bdc4f13ead7e00b62766df2815ddc8d4775af8a82ec40f8afd433d4cb95a109a58fbe7e0a661be86e0a06321c00362bc881f58c61c40bd2d1486954594', 'id': 'e00298fe-a194-427a-bdef-655d7fa63056', 'created_at': datetime.datetime(2026, 7, 10, 14, 59, 53, tzinfo=datetime.timezone.utc), 'updated_at': datetime.datetime(2026, 7, 10, 15, 0, 14, tzinfo=datetime.timezone.utc), 'locations': [{'url': 'rbd://4837cbf8-4f90-4300-b3f6-726c9b9f89b4/glance.images/e00298fe-a194-427a-bdef-655d7fa63056/snap', 'metadata': {}}], 'direct_url': 'rbd://4837cbf8-4f90-4300-b3f6-726c9b9f89b4/glance.images/e00298fe-a194-427a-bdef-655d7fa63056/snap', 'tags': [], 'file': '/v2/images/e00298fe-a194-427a-bdef-655d7fa63056/file', 'properties': {'atmosphere:image:etag': '0x8DB6132337274B7', 'atmosphere:image:url': 'http://download.cirros-cloud.net/0.6.2/cirros-0.6.2-x86_64-disk.img', 'owner_specified.openstack.md5': '', 'owner_specified.openstack.object': 'images/cirros', 'owner_specified.openstack.sha256': ''}}, 'image_service': <cinder.image.glance.GlanceImageService object at 0x7f0e9028a2d0>}
2026-07-10 16:17:39.836 8 INFO cinder.volume.flows.manager.create_volume [None req-a8c68b55-31d9-4679-b627-abac7fa8095b d34a3a76228d465eb6e67b6835781278 193d31ce0f9b49c784f8db0aad2fdfd4 - - - -] Volume volume-2591c32f-9a80-4f37-9a43-c41e81bf43cb (2591c32f-9a80-4f37-9a43-c41e81bf43cb): created successfully
2026-07-10 16:17:39.853 8 INFO cinder.volume.manager [None req-a8c68b55-31d9-4679-b627-abac7fa8095b d34a3a76228d465eb6e67b6835781278 193d31ce0f9b49c784f8db0aad2fdfd4 - - - -] Created volume successfully.
2026-07-10 16:17:50.945 8 INFO cinder.volume.manager [req-a4d56ae4-b948-4b55-922c-158d86631b02 req-82a4fd0b-f766-41cd-b439-64bd8fe358a4 d34a3a76228d465eb6e67b6835781278 193d31ce0f9b49c784f8db0aad2fdfd4 - - - -] attachment_update completed successfully.
2026-07-10 16:18:04.913 8 INFO cinder.volume.manager [req-32cded19-f68e-4fe2-b1aa-77f6a444a7d1 req-328b013b-df06-4736-b779-da13bc626634 d34a3a76228d465eb6e67b6835781278 193d31ce0f9b49c784f8db0aad2fdfd4 - - - -] Terminate volume connection completed successfully.
2026-07-10 16:18:06.020 8 WARNING cinder.quota [req-32cded19-f68e-4fe2-b1aa-77f6a444a7d1 req-48691a9c-6f33-4ad6-bf66-a8dcfd68eff9 d34a3a76228d465eb6e67b6835781278 193d31ce0f9b49c784f8db0aad2fdfd4 - - - -] Deprecated: Default quota for resource: volumes_rbd1 is set by the default quota flag: quota_volumes_rbd1, it is now deprecated. Please use the default quota class for default quota.
2026-07-10 16:18:06.021 8 WARNING cinder.quota [req-32cded19-f68e-4fe2-b1aa-77f6a444a7d1 req-48691a9c-6f33-4ad6-bf66-a8dcfd68eff9 d34a3a76228d465eb6e67b6835781278 193d31ce0f9b49c784f8db0aad2fdfd4 - - - -] Deprecated: Default quota for resource: gigabytes_rbd1 is set by the default quota flag: quota_gigabytes_rbd1, it is now deprecated. Please use the default quota class for default quota.
2026-07-10 16:18:06.205 8 INFO cinder.volume.manager [req-32cded19-f68e-4fe2-b1aa-77f6a444a7d1 req-48691a9c-6f33-4ad6-bf66-a8dcfd68eff9 d34a3a76228d465eb6e67b6835781278 193d31ce0f9b49c784f8db0aad2fdfd4 - - - -] Deleted volume successfully.
2026-07-10 16:18:46.851 8 INFO cinder.volume.flows.manager.create_volume [None req-9370e5d9-63a3-466e-ab2a-304b0228d9dd 207999b820734406a176cc65d61f8dc8 6ac1ed04dfb9476fa0770d967e15015d - - - -] Volume 99b587d0-fc50-45e9-bb0f-63747fb78fa2: being created as raw with specification: {'status': 'creating', 'volume_name': 'volume-99b587d0-fc50-45e9-bb0f-63747fb78fa2', 'volume_size': 1}
2026-07-10 16:18:46.985 8 INFO cinder.volume.flows.manager.create_volume [None req-9370e5d9-63a3-466e-ab2a-304b0228d9dd 207999b820734406a176cc65d61f8dc8 6ac1ed04dfb9476fa0770d967e15015d - - - -] Volume volume-99b587d0-fc50-45e9-bb0f-63747fb78fa2 (99b587d0-fc50-45e9-bb0f-63747fb78fa2): created successfully
2026-07-10 16:18:47.030 8 INFO cinder.volume.manager [None req-9370e5d9-63a3-466e-ab2a-304b0228d9dd 207999b820734406a176cc65d61f8dc8 6ac1ed04dfb9476fa0770d967e15015d - - - -] Created volume successfully.
2026-07-10 16:19:03.521 8 INFO cinder.volume.manager [None req-dde3607f-927c-48bf-8ef9-0c339d356e98 207999b820734406a176cc65d61f8dc8 6ac1ed04dfb9476fa0770d967e15015d - - - -] Attaching volume 99b587d0-fc50-45e9-bb0f-63747fb78fa2 to instance b551c330-5162-4f8b-b5b9-31c3906e8196 at mountpoint /dev/vdb on host None.
2026-07-10 16:19:03.541 8 INFO cinder.volume.manager [None req-dde3607f-927c-48bf-8ef9-0c339d356e98 207999b820734406a176cc65d61f8dc8 6ac1ed04dfb9476fa0770d967e15015d - - - -] Attach volume completed successfully.
2026-07-10 16:19:04.070 8 INFO cinder.volume.manager [None req-d2a0e55d-f957-4498-b34a-baf009a57fa5 207999b820734406a176cc65d61f8dc8 6ac1ed04dfb9476fa0770d967e15015d - - - -] Detaching volume 99b587d0-fc50-45e9-bb0f-63747fb78fa2 from instance b551c330-5162-4f8b-b5b9-31c3906e8196.
2026-07-10 16:19:04.113 8 INFO cinder.volume.manager [None req-d2a0e55d-f957-4498-b34a-baf009a57fa5 207999b820734406a176cc65d61f8dc8 6ac1ed04dfb9476fa0770d967e15015d - - - -] Detach volume completed successfully.
2026-07-10 16:19:12.820 8 INFO cinder.volume.manager [None req-b0799d35-38a2-4005-81af-33e762c656a3 207999b820734406a176cc65d61f8dc8 6ac1ed04dfb9476fa0770d967e15015d - - - -] Deleted volume successfully.