Openstack 2023.2 - Cinder - Creating an encrypted volume from a non encrypted glance image fails

Bug #2054604 reported by Noel Ashford
6
This bug affects 1 person
Affects Status Importance Assigned to Milestone
Cinder
New
Undecided
Unassigned

Bug Description

Hello, I think there is a reversion from another older bug as this never used to happen until i went to 2023.2. I can not take an image and convert to a LUKS volume any longer, it fails complaining the ISO isn't encrypted .... ?

==> /var/log/kolla/cinder/cinder-api-error.log <==
2024-02-21 15:14:26.694173 /var/lib/kolla/venv/lib/python3.10/site-packages/oslo_context/context.py:100: DeprecationWarning: Policy enforcement is depending on the value of is_admin. This key is deprecated. Please update your policy file to use the standard policy values.
2024-02-21 15:14:26.694219 warnings.warn('Policy enforcement is depending on the value of '

==> /var/log/kolla/cinder/cinder-api.log <==
2024-02-21 15:14:26.703 733 INFO cinder.api.openstack.wsgi [None req-572fb234-e072-43db-acf4-29f1493ea915 0f28f91c6e9a422dac08846921757bea e5b9296fbd9e4d9ea5e925780c64690f - - default default] https://int.noel.openstack.tunninet.com:8776/v3/e5b9296fbd9e4d9ea5e925780c64690f/volumes/detail?all_tenants=true returned with HTTP 200

==> /var/log/kolla/cinder/cinder-api-access.log <==
192.168.5.99 - - [21/Feb/2024:15:14:26 -0500] "GET /v3/e5b9296fbd9e4d9ea5e925780c64690f/volumes/detail?all_tenants=true HTTP/1.1" 200 16264 31475 "-" "gophercloud/2.0.0"

==> /var/log/kolla/cinder/cinder-backup.log <==
2024-02-21 15:14:30.544 7 ERROR cinder.service [-] Manager for service cinder-backup tunninet-server-noel is reporting problems, not sending heartbeat. Service will appear "down".

==> /var/log/kolla/cinder/cinder-volume.log <==
2024-02-21 15:14:32.944 747 INFO cinder.volume.targets.tgt [None req-ab9576d4-8b2d-45f1-b7c8-c7e68604e729 0f28f91c6e9a422dac08846921757bea e5b9296fbd9e4d9ea5e925780c64690f - - - -] Removing iscsi_target for Volume ID: cfa8a200-67c1-47cd-a9c1-61f6be5674e1
2024-02-21 15:14:33.040 747 ERROR cinder.volume.volume_utils [None req-ab9576d4-8b2d-45f1-b7c8-c7e68604e729 0f28f91c6e9a422dac08846921757bea e5b9296fbd9e4d9ea5e925780c64690f - - - -] Failed to copy image ba1cc6a7-06e3-48f1-882c-3fb8d24418bb to volume: cfa8a200-67c1-47cd-a9c1-61f6be5674e1: oslo_concurrency.processutils.ProcessExecutionError: Unexpected error while running command.
Command: cryptsetup --batch-mode luksFormat --type luks1 --key-file=- --cipher aes-xts-plain64 --key-size 256 /dev/sdi
Exit code: 5
Stdout: ''
Stderr: 'Cannot use device /dev/sdi which is in use (already mapped or mounted).\n'
2024-02-21 15:14:33.040 747 ERROR cinder.volume.volume_utils Traceback (most recent call last):
2024-02-21 15:14:33.040 747 ERROR cinder.volume.volume_utils File "/var/lib/kolla/venv/lib/python3.10/site-packages/os_brick/encryptors/luks.py", line 130, in attach_volume
2024-02-21 15:14:33.040 747 ERROR cinder.volume.volume_utils self._open_volume(passphrase, **kwargs)
2024-02-21 15:14:33.040 747 ERROR cinder.volume.volume_utils File "/var/lib/kolla/venv/lib/python3.10/site-packages/os_brick/encryptors/luks.py", line 112, in _open_volume
2024-02-21 15:14:33.040 747 ERROR cinder.volume.volume_utils self._execute('cryptsetup', 'luksOpen', '--key-file=-',
2024-02-21 15:14:33.040 747 ERROR cinder.volume.volume_utils File "/var/lib/kolla/venv/lib/python3.10/site-packages/os_brick/executor.py", line 55, in _execute
2024-02-21 15:14:33.040 747 ERROR cinder.volume.volume_utils result = self.__execute(*args, **kwargs)
2024-02-21 15:14:33.040 747 ERROR cinder.volume.volume_utils File "/var/lib/kolla/venv/lib/python3.10/site-packages/os_brick/privileged/rootwrap.py", line 172, in execute
2024-02-21 15:14:33.040 747 ERROR cinder.volume.volume_utils return execute_root(*cmd, **kwargs)
2024-02-21 15:14:33.040 747 ERROR cinder.volume.volume_utils File "/var/lib/kolla/venv/lib/python3.10/site-packages/oslo_privsep/priv_context.py", line 271, in _wrap
2024-02-21 15:14:33.040 747 ERROR cinder.volume.volume_utils return self.channel.remote_call(name, args, kwargs,
2024-02-21 15:14:33.040 747 ERROR cinder.volume.volume_utils File "/var/lib/kolla/venv/lib/python3.10/site-packages/oslo_privsep/daemon.py", line 215, in remote_call
2024-02-21 15:14:33.040 747 ERROR cinder.volume.volume_utils raise exc_type(*result[2])
2024-02-21 15:14:33.040 747 ERROR cinder.volume.volume_utils oslo_concurrency.processutils.ProcessExecutionError: Unexpected error while running command.
2024-02-21 15:14:33.040 747 ERROR cinder.volume.volume_utils Command: cryptsetup luksOpen --key-file=- /dev/sdi crypt-os-brick+dev+sdi
2024-02-21 15:14:33.040 747 ERROR cinder.volume.volume_utils Exit code: 1
2024-02-21 15:14:33.040 747 ERROR cinder.volume.volume_utils Stdout: ''
2024-02-21 15:14:33.040 747 ERROR cinder.volume.volume_utils Stderr: 'Device /dev/sdi is not a valid LUKS device.\n'
2024-02-21 15:14:33.040 747 ERROR cinder.volume.volume_utils
2024-02-21 15:14:33.040 747 ERROR cinder.volume.volume_utils During handling of the above exception, another exception occurred:
2024-02-21 15:14:33.040 747 ERROR cinder.volume.volume_utils
2024-02-21 15:14:33.040 747 ERROR cinder.volume.volume_utils Traceback (most recent call last):
2024-02-21 15:14:33.040 747 ERROR cinder.volume.volume_utils File "/var/lib/kolla/venv/lib/python3.10/site-packages/cinder/volume/volume_utils.py", line 1206, in copy_image_to_volume
2024-02-21 15:14:33.040 747 ERROR cinder.volume.volume_utils driver.copy_image_to_encrypted_volume(
2024-02-21 15:14:33.040 747 ERROR cinder.volume.volume_utils File "/var/lib/kolla/venv/lib/python3.10/site-packages/cinder/volume/driver.py", line 884, in copy_image_to_encrypted_volume
2024-02-21 15:14:33.040 747 ERROR cinder.volume.volume_utils self._copy_image_data_to_volume(
2024-02-21 15:14:33.040 747 ERROR cinder.volume.volume_utils File "/var/lib/kolla/venv/lib/python3.10/site-packages/cinder/volume/driver.py", line 902, in _copy_image_data_to_volume
2024-02-21 15:14:33.040 747 ERROR cinder.volume.volume_utils volume_utils.brick_attach_volume_encryptor(context,
2024-02-21 15:14:33.040 747 ERROR cinder.volume.volume_utils File "/var/lib/kolla/venv/lib/python3.10/site-packages/cinder/volume/volume_utils.py", line 1436, in brick_attach_volume_encryptor
2024-02-21 15:14:33.040 747 ERROR cinder.volume.volume_utils encryptor.attach_volume(context, **encryption)
2024-02-21 15:14:33.040 747 ERROR cinder.volume.volume_utils File "/var/lib/kolla/venv/lib/python3.10/site-packages/os_brick/encryptors/luks.py", line 139, in attach_volume
2024-02-21 15:14:33.040 747 ERROR cinder.volume.volume_utils self._format_volume(passphrase, **kwargs)
2024-02-21 15:14:33.040 747 ERROR cinder.volume.volume_utils File "/var/lib/kolla/venv/lib/python3.10/site-packages/os_brick/encryptors/luks.py", line 70, in _format_volume
2024-02-21 15:14:33.040 747 ERROR cinder.volume.volume_utils self._format_luks_volume(passphrase, 'luks1', **kwargs)
2024-02-21 15:14:33.040 747 ERROR cinder.volume.volume_utils File "/var/lib/kolla/venv/lib/python3.10/site-packages/os_brick/encryptors/luks.py", line 101, in _format_luks_volume
2024-02-21 15:14:33.040 747 ERROR cinder.volume.volume_utils self._execute(*cmd, process_input=passphrase,
2024-02-21 15:14:33.040 747 ERROR cinder.volume.volume_utils File "/var/lib/kolla/venv/lib/python3.10/site-packages/os_brick/executor.py", line 55, in _execute
2024-02-21 15:14:33.040 747 ERROR cinder.volume.volume_utils result = self.__execute(*args, **kwargs)
2024-02-21 15:14:33.040 747 ERROR cinder.volume.volume_utils File "/var/lib/kolla/venv/lib/python3.10/site-packages/os_brick/privileged/rootwrap.py", line 172, in execute
2024-02-21 15:14:33.040 747 ERROR cinder.volume.volume_utils return execute_root(*cmd, **kwargs)
2024-02-21 15:14:33.040 747 ERROR cinder.volume.volume_utils File "/var/lib/kolla/venv/lib/python3.10/site-packages/oslo_privsep/priv_context.py", line 271, in _wrap
2024-02-21 15:14:33.040 747 ERROR cinder.volume.volume_utils return self.channel.remote_call(name, args, kwargs,
2024-02-21 15:14:33.040 747 ERROR cinder.volume.volume_utils File "/var/lib/kolla/venv/lib/python3.10/site-packages/oslo_privsep/daemon.py", line 215, in remote_call
2024-02-21 15:14:33.040 747 ERROR cinder.volume.volume_utils raise exc_type(*result[2])
2024-02-21 15:14:33.040 747 ERROR cinder.volume.volume_utils oslo_concurrency.processutils.ProcessExecutionError: Unexpected error while running command.
2024-02-21 15:14:33.040 747 ERROR cinder.volume.volume_utils Command: cryptsetup --batch-mode luksFormat --type luks1 --key-file=- --cipher aes-xts-plain64 --key-size 256 /dev/sdi
2024-02-21 15:14:33.040 747 ERROR cinder.volume.volume_utils Exit code: 5
2024-02-21 15:14:33.040 747 ERROR cinder.volume.volume_utils Stdout: ''
2024-02-21 15:14:33.040 747 ERROR cinder.volume.volume_utils Stderr: 'Cannot use device /dev/sdi which is in use (already mapped or mounted).\n'
2024-02-21 15:14:33.040 747 ERROR cinder.volume.volume_utils
2024-02-21 15:14:33.205 747 WARNING cinder.volume.manager [None req-ab9576d4-8b2d-45f1-b7c8-c7e68604e729 0f28f91c6e9a422dac08846921757bea e5b9296fbd9e4d9ea5e925780c64690f - - - -] Task 'cinder.volume.flows.manager.create_volume.CreateVolumeFromSpecTask;volume:create' (7a48c581-7204-4eb8-8ca2-6d31d00d02d1) transitioned into state 'FAILURE' from state 'RUNNING'
5 predecessors (most recent first):
  Atom 'cinder.volume.flows.manager.create_volume.NotifyVolumeActionTask;volume:create, create.start' {'intention': 'EXECUTE', 'state': 'SUCCESS', 'requires': {'context': <cinder.context.RequestContext object at 0x7f3748c2ec80>, 'volume': Volume(_name_id=None,admin_metadata={},attach_status='detached',availability_zone='5Net',bootable=False,cluster=<?>,cluster_name=None,consistencygroup=<?>,consistencygroup_id=None,created_at=2024-02-21T20:11:40Z,deleted=False,deleted_at=None,display_description='',display_name='TEST',ec2_id=None,encryption_key_id=654c2a03-b193-4efd-b16d-736ce31a595e,glance_metadata=<?>,group=<?>,group_id=None,host='tunninet-server-noel@lvm-1#lvm-1',id=cfa8a200-67c1-47cd-a9c1-61f6be5674e1,launched_at=None,metadata={},migration_status=None,multiattach=False,previous_status=None,project_id='e5b9296fbd9e4d9ea5e925780c64690f',provider_auth='CHAP M2y42j8V2KjkwuSybfWp g7u3BTFs6nCNJTyT',provider_geometry=None,provider_id=None,provider_location='192.168.5.1:3260,1 iqn.2010-10.org.openstack:volume-cfa8a200-67c1-47cd-a9c1-61f6be5674e1 1',replication_driver_data=None,replication_extended_status=None,replication_status=None,scheduled_at=2024-02-21T20:11:40Z,service_uuid=None,shared_targets=True,size=10,snapshot_id=None,snapshots=<?>,source_volid=None,status='downloading',terminated_at=None,updated_at=2024-02-21T20:11:40Z,use_quota=True,user_id='0f28f91c6e9a422dac08846921757bea',volume_attachment=VolumeAttachmentList,volume_type=VolumeType(f549d715-0e3d-4994-a04c-4d10ce65d454),volume_type_id=f549d715-0e3d-4994-a04c-4d10ce65d454)}, 'provides': None}
  |__Atom 'cinder.volume.flows.manager.create_volume.ExtractVolumeSpecTask;volume:create' {'intention': 'EXECUTE', 'state': 'SUCCESS', 'requires': {'context': <cinder.context.RequestContext object at 0x7f3748c2ec80>, 'volume': Volume(_name_id=None,admin_metadata={},attach_status='detached',availability_zone='5Net',bootable=False,cluster=<?>,cluster_name=None,consistencygroup=<?>,consistencygroup_id=None,created_at=2024-02-21T20:11:40Z,deleted=False,deleted_at=None,display_description='',display_name='TEST',ec2_id=None,encryption_key_id=654c2a03-b193-4efd-b16d-736ce31a595e,glance_metadata=<?>,group=<?>,group_id=None,host='tunninet-server-noel@lvm-1#lvm-1',id=cfa8a200-67c1-47cd-a9c1-61f6be5674e1,launched_at=None,metadata={},migration_status=None,multiattach=False,previous_status=None,project_id='e5b9296fbd9e4d9ea5e925780c64690f',provider_auth='CHAP M2y42j8V2KjkwuSybfWp g7u3BTFs6nCNJTyT',provider_geometry=None,provider_id=None,provider_location='192.168.5.1:3260,1 iqn.2010-10.org.openstack:volume-cfa8a200-67c1-47cd-a9c1-61f6be5674e1 1',replication_driver_data=None,replication_extended_status=None,replication_status=None,scheduled_at=2024-02-21T20:11:40Z,service_uuid=None,shared_targets=True,size=10,snapshot_id=None,snapshots=<?>,source_volid=None,status='downloading',terminated_at=None,updated_at=2024-02-21T20:11:40Z,use_quota=True,user_id='0f28f91c6e9a422dac08846921757bea',volume_attachment=VolumeAttachmentList,volume_type=VolumeType(f549d715-0e3d-4994-a04c-4d10ce65d454),volume_type_id=f549d715-0e3d-4994-a04c-4d10ce65d454), 'request_spec': RequestSpec(CG_backend=<?>,availability_zones=['5Net'],backup_id=None,cgsnapshot_id=None,consistencygroup_id=None,group_backend=<?>,group_id=None,image_id=ba1cc6a7-06e3-48f1-882c-3fb8d24418bb,operation=<?>,resource_backend=<?>,snapshot_id=None,source_replicaid=<?>,source_volid=None,volume=Volume(cfa8a200-67c1-47cd-a9c1-61f6be5674e1),volume_id=cfa8a200-67c1-47cd-a9c1-61f6be5674e1,volume_properties=VolumeProperties,volume_type=VolumeType(f549d715-0e3d-4994-a04c-4d10ce65d454))}, 'provides': {'status': 'creating', 'type': 'image', 'volume_id': 'cfa8a200-67c1-47cd-a9c1-61f6be5674e1', 'volume_name': 'volume-cfa8a200-67c1-47cd-a9c1-61f6be5674e1', 'volume_size': 10, 'image_id': 'ba1cc6a7-06e3-48f1-882c-3fb8d24418bb', 'image_location': (None, None), 'image_meta': {'name': 'jammy-server-cloudimg-amd64', 'disk_format': 'qcow2', 'container_format': 'bare', 'visibility': 'shared', 'size': 677117952, 'virtual_size': 2361393152, 'status': 'active', 'checksum': 'd9a4498d18990fe901263b7b326756d4', 'protected': False, 'min_ram': 0, 'min_disk': 0, 'owner': 'e5b9296fbd9e4d9ea5e925780c64690f', 'os_hidden': False, 'os_hash_algo': 'sha512', 'os_hash_value': '80056511281dced13f2ad75108d18444c1f409a369da7294cd0c6756bb357039ccac00927a71eadb0901785acbebe4ad51be5f7a07090c0f3b6dc9a5114d2b17', 'id': 'ba1cc6a7-06e3-48f1-882c-3fb8d24418bb', 'created_at': datetime.datetime(2024, 2, 20, 9, 15, 22, tzinfo=datetime.timezone.utc), 'updated_at': datetime.datetime(2024, 2, 20, 9, 16, tzinfo=datetime.timezone.utc), 'tags': [], 'file': '/v2/images/ba1cc6a7-06e3-48f1-882c-3fb8d24418bb/file', 'stores': 'swift', 'properties': {'owner_specified.openstack.md5': '', 'owner_specified.openstack.sha256': '', 'owner_specified.openstack.object': 'images/jammy-server-cloudimg-amd64'}}, 'image_service': <cinder.image.glance.GlanceImageService object at 0x7f3748c7a4d0>}}
     |__Atom 'cinder.volume.flows.manager.create_volume.OnFailureRescheduleTask;volume:create' {'intention': 'EXECUTE', 'state': 'SUCCESS', 'requires': {'filter_properties': {'retry': {'num_attempts': 1, 'backends': ['tunninet-server-noel@lvm-1#lvm-1'], 'hosts': ['tunninet-server-noel@lvm-1#lvm-1']}, 'request_spec': {'consistencygroup_id': None, 'group_id': None, 'cgsnapshot_id': None, 'image_id': 'ba1cc6a7-06e3-48f1-882c-3fb8d24418bb', 'snapshot_id': None, 'source_volid': None, 'volume_id': 'cfa8a200-67c1-47cd-a9c1-61f6be5674e1', 'volume': {'id': 'cfa8a200-67c1-47cd-a9c1-61f6be5674e1', '_name_id': None, 'ec2_id': None, 'user_id': '0f28f91c6e9a422dac08846921757bea', 'project_id': 'e5b9296fbd9e4d9ea5e925780c64690f', 'use_quota': True, 'snapshot_id': None, 'cluster_name': None, 'host': None, 'size': 10, 'availability_zone': '5Net', 'status': 'creating', 'attach_status': 'detached', 'migration_status': None, 'scheduled_at': None, 'launched_at': None, 'terminated_at': None, 'display_name': 'TEST', 'display_description': '', 'provider_id': None, 'provider_location': None, 'provider_auth': None, 'provider_geometry': None, 'volume_type_id': 'f549d715-0e3d-4994-a04c-4d10ce65d454', 'source_volid': None, 'encryption_key_id': '654c2a03-b193-4efd-b16d-736ce31a595e', 'consistencygroup_id': None, 'group_id': None, 'deleted': False, 'bootable': False, 'multiattach': False, 'replication_status': None, 'replication_extended_status': None, 'replication_driver_data': None, 'previous_status': None, 'metadata': {}, 'admin_metadata': {}, 'volume_type': {'id': 'f549d715-0e3d-4994-a04c-4d10ce65d454', 'name': 'LUKS', 'description': None, 'is_public': True, 'extra_specs': {}, 'qos_specs_id': None, 'created_at': '2023-07-26T12:43:26.000000', 'updated_at': None, 'deleted_at': None, 'deleted': False}, 'volume_attachment': [], 'service_uuid': None, 'shared_targets': True, 'created_at': '2024-02-21T20:11:40.000000', 'updated_at': None, 'deleted_at': None, 'name': 'volume-cfa8a200-67c1-47cd-a9c1-61f6be5674e1', 'name_id': 'cfa8a200-67c1-47cd-a9c1-61f6be5674e1', 'volume_metadata': [], 'volume_admin_metadata': [], 'volume_glance_metadata': []}, 'volume_type': {'id': 'f549d715-0e3d-4994-a04c-4d10ce65d454', 'name': 'LUKS', 'description': None, 'is_public': True, 'projects': [], 'extra_specs': {}, 'qos_specs_id': None, 'created_at': '2023-07-26T12:43:26.000000', 'updated_at': None, 'deleted_at': None, 'deleted': False}, 'volume_properties': {'attach_status': 'detached', 'availability_zone': '5Net', 'cgsnapshot_id': None, 'consistencygroup_id': None, 'group_id': None, 'display_description': '', 'display_name': 'TEST', 'encryption_key_id': '654c2a03-b193-4efd-b16d-736ce31a595e', 'metadata': {}, 'multiattach': False, 'project_id': 'e5b9296fbd9e4d9ea5e925780c64690f', 'qos_specs': None, 'reservations': ['92723234-5299-4954-afd4-c1b7a2ef7d32', '54a03803-9eed-4bfe-b04c-293bc6f45127', '400aa13a-21f9-4262-b9cc-e7fb085472e8', '1d5ef1fa-d84c-4c8f-9326-75dce7376826'], 'size': 10, 'snapshot_id': None, 'source_volid': None, 'status': 'creating', 'user_id': '0f28f91c6e9a422dac08846921757bea', 'volume_type_id': 'f549d715-0e3d-4994-a04c-4d10ce65d454'}, 'backup_id': None, 'availability_zones': ['5Net'], 'resource_properties': {'attach_status': 'detached', 'availability_zone': '5Net', 'cgsnapshot_id': None, 'consistencygroup_id': None, 'group_id': None, 'display_description': '', 'display_name': 'TEST', 'encryption_key_id': '654c2a03-b193-4efd-b16d-736ce31a595e', 'metadata': {}, 'multiattach': False, 'project_id': 'e5b9296fbd9e4d9ea5e925780c64690f', 'qos_specs': None, 'reservations': ['92723234-5299-4954-afd4-c1b7a2ef7d32', '54a03803-9eed-4bfe-b04c-293bc6f45127', '400aa13a-21f9-4262-b9cc-e7fb085472e8', '1d5ef1fa-d84c-4c8f-9326-75dce7376826'], 'size': 10, 'snapshot_id': None, 'source_volid': None, 'status': 'creating', 'user_id': '0f28f91c6e9a422dac08846921757bea', 'volume_type_id': 'f549d715-0e3d-4994-a04c-4d10ce65d454'}}, 'config_options': {}, 'volume_type': VolumeType(created_at=2023-07-26T12:43:26Z,deleted=False,deleted_at=None,description=None,extra_specs={},id=f549d715-0e3d-4994-a04c-4d10ce65d454,is_public=True,name='LUKS',projects=[],qos_specs=<?>,qos_specs_id=None,updated_at=None), 'resource_type': VolumeType(created_at=2023-07-26T12:43:26Z,deleted=False,deleted_at=None,description=None,extra_specs={},id=f549d715-0e3d-4994-a04c-4d10ce65d454,is_public=True,name='LUKS',projects=[],qos_specs=<?>,qos_specs_id=None,updated_at=None), 'size': 10, 'availability_zone': '5Net', 'user_id': '0f28f91c6e9a422dac08846921757bea', 'metadata': {}, 'qos_specs': None}, 'request_spec': RequestSpec(CG_backend=<?>,availability_zones=['5Net'],backup_id=None,cgsnapshot_id=None,consistencygroup_id=None,group_backend=<?>,group_id=None,image_id=ba1cc6a7-06e3-48f1-882c-3fb8d24418bb,operation=<?>,resource_backend=<?>,snapshot_id=None,source_replicaid=<?>,source_volid=None,volume=Volume(cfa8a200-67c1-47cd-a9c1-61f6be5674e1),volume_id=cfa8a200-67c1-47cd-a9c1-61f6be5674e1,volume_properties=VolumeProperties,volume_type=VolumeType(f549d715-0e3d-4994-a04c-4d10ce65d454)), 'volume': Volume(_name_id=None,admin_metadata={},attach_status='detached',availability_zone='5Net',bootable=False,cluster=<?>,cluster_name=None,consistencygroup=<?>,consistencygroup_id=None,created_at=2024-02-21T20:11:40Z,deleted=False,deleted_at=None,display_description='',display_name='TEST',ec2_id=None,encryption_key_id=654c2a03-b193-4efd-b16d-736ce31a595e,glance_metadata=<?>,group=<?>,group_id=None,host='tunninet-server-noel@lvm-1#lvm-1',id=cfa8a200-67c1-47cd-a9c1-61f6be5674e1,launched_at=None,metadata={},migration_status=None,multiattach=False,previous_status=None,project_id='e5b9296fbd9e4d9ea5e925780c64690f',provider_auth='CHAP M2y42j8V2KjkwuSybfWp g7u3BTFs6nCNJTyT',provider_geometry=None,provider_id=None,provider_location='192.168.5.1:3260,1 iqn.2010-10.org.openstack:volume-cfa8a200-67c1-47cd-a9c1-61f6be5674e1 1',replication_driver_data=None,replication_extended_status=None,replication_status=None,scheduled_at=2024-02-21T20:11:40Z,service_uuid=None,shared_targets=True,size=10,snapshot_id=None,snapshots=<?>,source_volid=None,status='downloading',terminated_at=None,updated_at=2024-02-21T20:11:40Z,use_quota=True,user_id='0f28f91c6e9a422dac08846921757bea',volume_attachment=VolumeAttachmentList,volume_type=VolumeType(f549d715-0e3d-4994-a04c-4d10ce65d454),volume_type_id=f549d715-0e3d-4994-a04c-4d10ce65d454), 'context': <cinder.context.RequestContext object at 0x7f3748c2ec80>}, 'provides': None}
        |__Atom 'cinder.volume.flows.manager.create_volume.ExtractVolumeRefTask;volume:create' {'intention': 'EXECUTE', 'state': 'SUCCESS', 'requires': {'context': <cinder.context.RequestContext object at 0x7f3748c2ec80>, 'volume': Volume(_name_id=None,admin_metadata={},attach_status='detached',availability_zone='5Net',bootable=False,cluster=<?>,cluster_name=None,consistencygroup=<?>,consistencygroup_id=None,created_at=2024-02-21T20:11:40Z,deleted=False,deleted_at=None,display_description='',display_name='TEST',ec2_id=None,encryption_key_id=654c2a03-b193-4efd-b16d-736ce31a595e,glance_metadata=<?>,group=<?>,group_id=None,host='tunninet-server-noel@lvm-1#lvm-1',id=cfa8a200-67c1-47cd-a9c1-61f6be5674e1,launched_at=None,metadata={},migration_status=None,multiattach=False,previous_status=None,project_id='e5b9296fbd9e4d9ea5e925780c64690f',provider_auth='CHAP M2y42j8V2KjkwuSybfWp g7u3BTFs6nCNJTyT',provider_geometry=None,provider_id=None,provider_location='192.168.5.1:3260,1 iqn.2010-10.org.openstack:volume-cfa8a200-67c1-47cd-a9c1-61f6be5674e1 1',replication_driver_data=None,replication_extended_status=None,replication_status=None,scheduled_at=2024-02-21T20:11:40Z,service_uuid=None,shared_targets=True,size=10,snapshot_id=None,snapshots=<?>,source_volid=None,status='downloading',terminated_at=None,updated_at=2024-02-21T20:11:40Z,use_quota=True,user_id='0f28f91c6e9a422dac08846921757bea',volume_attachment=VolumeAttachmentList,volume_type=VolumeType(f549d715-0e3d-4994-a04c-4d10ce65d454),volume_type_id=f549d715-0e3d-4994-a04c-4d10ce65d454)}, 'provides': Volume(_name_id=None,admin_metadata={},attach_status='detached',availability_zone='5Net',bootable=False,cluster=<?>,cluster_name=None,consistencygroup=<?>,consistencygroup_id=None,created_at=2024-02-21T20:11:40Z,deleted=False,deleted_at=None,display_description='',display_name='TEST',ec2_id=None,encryption_key_id=654c2a03-b193-4efd-b16d-736ce31a595e,glance_metadata=<?>,group=<?>,group_id=None,host='tunninet-server-noel@lvm-1#lvm-1',id=cfa8a200-67c1-47cd-a9c1-61f6be5674e1,launched_at=None,metadata={},migration_status=None,multiattach=False,previous_status=None,project_id='e5b9296fbd9e4d9ea5e925780c64690f',provider_auth='CHAP M2y42j8V2KjkwuSybfWp g7u3BTFs6nCNJTyT',provider_geometry=None,provider_id=None,provider_location='192.168.5.1:3260,1 iqn.2010-10.org.openstack:volume-cfa8a200-67c1-47cd-a9c1-61f6be5674e1 1',replication_driver_data=None,replication_extended_status=None,replication_status=None,scheduled_at=2024-02-21T20:11:40Z,service_uuid=None,shared_targets=True,size=10,snapshot_id=None,snapshots=<?>,source_volid=None,status='downloading',terminated_at=None,updated_at=2024-02-21T20:11:40Z,use_quota=True,user_id='0f28f91c6e9a422dac08846921757bea',volume_attachment=VolumeAttachmentList,volume_type=VolumeType(f549d715-0e3d-4994-a04c-4d10ce65d454),volume_type_id=f549d715-0e3d-4994-a04c-4d10ce65d454)}
           |__Flow 'volume_create_manager': cinder.exception.ImageCopyFailure: Failed to copy image to volume: Cannot use device /dev/sdi which is in use (already mapped or mounted).
2024-02-21 15:14:33.205 747 ERROR cinder.volume.manager Traceback (most recent call last):
2024-02-21 15:14:33.205 747 ERROR cinder.volume.manager File "/var/lib/kolla/venv/lib/python3.10/site-packages/os_brick/encryptors/luks.py", line 130, in attach_volume
2024-02-21 15:14:33.205 747 ERROR cinder.volume.manager self._open_volume(passphrase, **kwargs)
2024-02-21 15:14:33.205 747 ERROR cinder.volume.manager File "/var/lib/kolla/venv/lib/python3.10/site-packages/os_brick/encryptors/luks.py", line 112, in _open_volume
2024-02-21 15:14:33.205 747 ERROR cinder.volume.manager self._execute('cryptsetup', 'luksOpen', '--key-file=-',
2024-02-21 15:14:33.205 747 ERROR cinder.volume.manager File "/var/lib/kolla/venv/lib/python3.10/site-packages/os_brick/executor.py", line 55, in _execute
2024-02-21 15:14:33.205 747 ERROR cinder.volume.manager result = self.__execute(*args, **kwargs)
2024-02-21 15:14:33.205 747 ERROR cinder.volume.manager File "/var/lib/kolla/venv/lib/python3.10/site-packages/os_brick/privileged/rootwrap.py", line 172, in execute
2024-02-21 15:14:33.205 747 ERROR cinder.volume.manager return execute_root(*cmd, **kwargs)
2024-02-21 15:14:33.205 747 ERROR cinder.volume.manager File "/var/lib/kolla/venv/lib/python3.10/site-packages/oslo_privsep/priv_context.py", line 271, in _wrap
2024-02-21 15:14:33.205 747 ERROR cinder.volume.manager return self.channel.remote_call(name, args, kwargs,
2024-02-21 15:14:33.205 747 ERROR cinder.volume.manager File "/var/lib/kolla/venv/lib/python3.10/site-packages/oslo_privsep/daemon.py", line 215, in remote_call
2024-02-21 15:14:33.205 747 ERROR cinder.volume.manager raise exc_type(*result[2])
2024-02-21 15:14:33.205 747 ERROR cinder.volume.manager oslo_concurrency.processutils.ProcessExecutionError: Unexpected error while running command.
2024-02-21 15:14:33.205 747 ERROR cinder.volume.manager Command: cryptsetup luksOpen --key-file=- /dev/sdi crypt-os-brick+dev+sdi
2024-02-21 15:14:33.205 747 ERROR cinder.volume.manager Exit code: 1
2024-02-21 15:14:33.205 747 ERROR cinder.volume.manager Stdout: ''
2024-02-21 15:14:33.205 747 ERROR cinder.volume.manager Stderr: 'Device /dev/sdi is not a valid LUKS device.\n'
2024-02-21 15:14:33.205 747 ERROR cinder.volume.manager
2024-02-21 15:14:33.205 747 ERROR cinder.volume.manager During handling of the above exception, another exception occurred:
2024-02-21 15:14:33.205 747 ERROR cinder.volume.manager
2024-02-21 15:14:33.205 747 ERROR cinder.volume.manager Traceback (most recent call last):
2024-02-21 15:14:33.205 747 ERROR cinder.volume.manager File "/var/lib/kolla/venv/lib/python3.10/site-packages/cinder/volume/volume_utils.py", line 1206, in copy_image_to_volume
2024-02-21 15:14:33.205 747 ERROR cinder.volume.manager driver.copy_image_to_encrypted_volume(
2024-02-21 15:14:33.205 747 ERROR cinder.volume.manager File "/var/lib/kolla/venv/lib/python3.10/site-packages/cinder/volume/driver.py", line 884, in copy_image_to_encrypted_volume
2024-02-21 15:14:33.205 747 ERROR cinder.volume.manager self._copy_image_data_to_volume(
2024-02-21 15:14:33.205 747 ERROR cinder.volume.manager File "/var/lib/kolla/venv/lib/python3.10/site-packages/cinder/volume/driver.py", line 902, in _copy_image_data_to_volume
2024-02-21 15:14:33.205 747 ERROR cinder.volume.manager volume_utils.brick_attach_volume_encryptor(context,
2024-02-21 15:14:33.205 747 ERROR cinder.volume.manager File "/var/lib/kolla/venv/lib/python3.10/site-packages/cinder/volume/volume_utils.py", line 1436, in brick_attach_volume_encryptor
2024-02-21 15:14:33.205 747 ERROR cinder.volume.manager encryptor.attach_volume(context, **encryption)
2024-02-21 15:14:33.205 747 ERROR cinder.volume.manager File "/var/lib/kolla/venv/lib/python3.10/site-packages/os_brick/encryptors/luks.py", line 139, in attach_volume
2024-02-21 15:14:33.205 747 ERROR cinder.volume.manager self._format_volume(passphrase, **kwargs)
2024-02-21 15:14:33.205 747 ERROR cinder.volume.manager File "/var/lib/kolla/venv/lib/python3.10/site-packages/os_brick/encryptors/luks.py", line 70, in _format_volume
2024-02-21 15:14:33.205 747 ERROR cinder.volume.manager self._format_luks_volume(passphrase, 'luks1', **kwargs)
2024-02-21 15:14:33.205 747 ERROR cinder.volume.manager File "/var/lib/kolla/venv/lib/python3.10/site-packages/os_brick/encryptors/luks.py", line 101, in _format_luks_volume
2024-02-21 15:14:33.205 747 ERROR cinder.volume.manager self._execute(*cmd, process_input=passphrase,
2024-02-21 15:14:33.205 747 ERROR cinder.volume.manager File "/var/lib/kolla/venv/lib/python3.10/site-packages/os_brick/executor.py", line 55, in _execute
2024-02-21 15:14:33.205 747 ERROR cinder.volume.manager result = self.__execute(*args, **kwargs)
2024-02-21 15:14:33.205 747 ERROR cinder.volume.manager File "/var/lib/kolla/venv/lib/python3.10/site-packages/os_brick/privileged/rootwrap.py", line 172, in execute
2024-02-21 15:14:33.205 747 ERROR cinder.volume.manager return execute_root(*cmd, **kwargs)
2024-02-21 15:14:33.205 747 ERROR cinder.volume.manager File "/var/lib/kolla/venv/lib/python3.10/site-packages/oslo_privsep/priv_context.py", line 271, in _wrap
2024-02-21 15:14:33.205 747 ERROR cinder.volume.manager return self.channel.remote_call(name, args, kwargs,
2024-02-21 15:14:33.205 747 ERROR cinder.volume.manager File "/var/lib/kolla/venv/lib/python3.10/site-packages/oslo_privsep/daemon.py", line 215, in remote_call
2024-02-21 15:14:33.205 747 ERROR cinder.volume.manager raise exc_type(*result[2])
2024-02-21 15:14:33.205 747 ERROR cinder.volume.manager oslo_concurrency.processutils.ProcessExecutionError: Unexpected error while running command.
2024-02-21 15:14:33.205 747 ERROR cinder.volume.manager Command: cryptsetup --batch-mode luksFormat --type luks1 --key-file=- --cipher aes-xts-plain64 --key-size 256 /dev/sdi
2024-02-21 15:14:33.205 747 ERROR cinder.volume.manager Exit code: 5
2024-02-21 15:14:33.205 747 ERROR cinder.volume.manager Stdout: ''
2024-02-21 15:14:33.205 747 ERROR cinder.volume.manager Stderr: 'Cannot use device /dev/sdi which is in use (already mapped or mounted).\n'
2024-02-21 15:14:33.205 747 ERROR cinder.volume.manager
2024-02-21 15:14:33.205 747 ERROR cinder.volume.manager During handling of the above exception, another exception occurred:
2024-02-21 15:14:33.205 747 ERROR cinder.volume.manager
2024-02-21 15:14:33.205 747 ERROR cinder.volume.manager Traceback (most recent call last):
2024-02-21 15:14:33.205 747 ERROR cinder.volume.manager File "/var/lib/kolla/venv/lib/python3.10/site-packages/taskflow/engines/action_engine/executor.py", line 52, in _execute_task
2024-02-21 15:14:33.205 747 ERROR cinder.volume.manager result = task.execute(**arguments)
2024-02-21 15:14:33.205 747 ERROR cinder.volume.manager File "/var/lib/kolla/venv/lib/python3.10/site-packages/cinder/volume/flows/manager/create_volume.py", line 1237, in execute
2024-02-21 15:14:33.205 747 ERROR cinder.volume.manager model_update = self._create_from_image(context,
2024-02-21 15:14:33.205 747 ERROR cinder.volume.manager File "/var/lib/kolla/venv/lib/python3.10/site-packages/cinder/utils.py", line 669, in _wrapper
2024-02-21 15:14:33.205 747 ERROR cinder.volume.manager return r(f, *args, **kwargs)
2024-02-21 15:14:33.205 747 ERROR cinder.volume.manager File "/var/lib/kolla/venv/lib/python3.10/site-packages/tenacity/__init__.py", line 423, in __call__
2024-02-21 15:14:33.205 747 ERROR cinder.volume.manager do = self.iter(retry_state=retry_state)
2024-02-21 15:14:33.205 747 ERROR cinder.volume.manager File "/var/lib/kolla/venv/lib/python3.10/site-packages/tenacity/__init__.py", line 360, in iter
2024-02-21 15:14:33.205 747 ERROR cinder.volume.manager return fut.result()
2024-02-21 15:14:33.205 747 ERROR cinder.volume.manager File "/usr/lib/python3.10/concurrent/futures/_base.py", line 451, in result
2024-02-21 15:14:33.205 747 ERROR cinder.volume.manager return self.__get_result()
2024-02-21 15:14:33.205 747 ERROR cinder.volume.manager File "/usr/lib/python3.10/concurrent/futures/_base.py", line 403, in __get_result
2024-02-21 15:14:33.205 747 ERROR cinder.volume.manager raise self._exception
2024-02-21 15:14:33.205 747 ERROR cinder.volume.manager File "/var/lib/kolla/venv/lib/python3.10/site-packages/tenacity/__init__.py", line 426, in __call__
2024-02-21 15:14:33.205 747 ERROR cinder.volume.manager result = fn(*args, **kwargs)
2024-02-21 15:14:33.205 747 ERROR cinder.volume.manager File "/var/lib/kolla/venv/lib/python3.10/site-packages/cinder/volume/flows/manager/create_volume.py", line 1125, in _create_from_image
2024-02-21 15:14:33.205 747 ERROR cinder.volume.manager model_update = self._create_from_image_cache_or_download(
2024-02-21 15:14:33.205 747 ERROR cinder.volume.manager File "/var/lib/kolla/venv/lib/python3.10/site-packages/cinder/volume/flows/manager/create_volume.py", line 1004, in _create_from_image_cache_or_download
2024-02-21 15:14:33.205 747 ERROR cinder.volume.manager model_update = self._create_from_image_download(
2024-02-21 15:14:33.205 747 ERROR cinder.volume.manager File "/var/lib/kolla/venv/lib/python3.10/site-packages/cinder/volume/flows/manager/create_volume.py", line 803, in _create_from_image_download
2024-02-21 15:14:33.205 747 ERROR cinder.volume.manager volume_utils.copy_image_to_volume(self.driver, context, volume,
2024-02-21 15:14:33.205 747 ERROR cinder.volume.manager File "/var/lib/kolla/venv/lib/python3.10/site-packages/cinder/volume/volume_utils.py", line 1215, in copy_image_to_volume
2024-02-21 15:14:33.205 747 ERROR cinder.volume.manager raise exception.ImageCopyFailure(reason=ex.stderr)
2024-02-21 15:14:33.205 747 ERROR cinder.volume.manager cinder.exception.ImageCopyFailure: Failed to copy image to volume: Cannot use device /dev/sdi which is in use (already mapped or mounted).
2024-02-21 15:14:33.205 747 ERROR cinder.volume.manager
2024-02-21 15:14:33.205 747 ERROR cinder.volume.manager
2024-02-21 15:14:33.213 747 WARNING cinder.volume.manager [None req-ab9576d4-8b2d-45f1-b7c8-c7e68604e729 0f28f91c6e9a422dac08846921757bea e5b9296fbd9e4d9ea5e925780c64690f - - - -] Task 'cinder.volume.flows.manager.create_volume.CreateVolumeFromSpecTask;volume:create' (7a48c581-7204-4eb8-8ca2-6d31d00d02d1) transitioned into state 'REVERTED' from state 'REVERTING'

Revision history for this message
Noel Ashford (nashford77) wrote :

 Is there any update here ?

           |__Flow 'volume_create_manager': cinder.exception.ImageCopyFailure: Failed to copy image to volume: Cannot use device /dev/sdl which is in use (already mapped or mounted).
2024-04-14 19:30:34.134 737 ERROR cinder.volume.manager Traceback (most recent call last):
2024-04-14 19:30:34.134 737 ERROR cinder.volume.manager File "/var/lib/kolla/venv/lib/python3.10/site-packages/os_brick/encryptors/luks.py", line 130, in attach_volume
2024-04-14 19:30:34.134 737 ERROR cinder.volume.manager self._open_volume(passphrase, **kwargs)
2024-04-14 19:30:34.134 737 ERROR cinder.volume.manager File "/var/lib/kolla/venv/lib/python3.10/site-packages/os_brick/encryptors/luks.py", line 112, in _open_volume
2024-04-14 19:30:34.134 737 ERROR cinder.volume.manager self._execute('cryptsetup', 'luksOpen', '--key-file=-',
2024-04-14 19:30:34.134 737 ERROR cinder.volume.manager File "/var/lib/kolla/venv/lib/python3.10/site-packages/os_brick/executor.py", line 55, in _execute
2024-04-14 19:30:34.134 737 ERROR cinder.volume.manager result = self.__execute(*args, **kwargs)
2024-04-14 19:30:34.134 737 ERROR cinder.volume.manager File "/var/lib/kolla/venv/lib/python3.10/site-packages/os_brick/privileged/rootwrap.py", line 172, in execute
2024-04-14 19:30:34.134 737 ERROR cinder.volume.manager return execute_root(*cmd, **kwargs)
2024-04-14 19:30:34.134 737 ERROR cinder.volume.manager File "/var/lib/kolla/venv/lib/python3.10/site-packages/oslo_privsep/priv_context.py", line 271, in _wrap
2024-04-14 19:30:34.134 737 ERROR cinder.volume.manager return self.channel.remote_call(name, args, kwargs,
2024-04-14 19:30:34.134 737 ERROR cinder.volume.manager File "/var/lib/kolla/venv/lib/python3.10/site-packages/oslo_privsep/daemon.py", line 215, in remote_call
2024-04-14 19:30:34.134 737 ERROR cinder.volume.manager raise exc_type(*result[2])
2024-04-14 19:30:34.134 737 ERROR cinder.volume.manager oslo_concurrency.processutils.ProcessExecutionError: Unexpected error while running command.
2024-04-14 19:30:34.134 737 ERROR cinder.volume.manager Command: cryptsetup luksOpen --key-file=- /dev/sdl crypt-os-brick+dev+sdl
2024-04-14 19:30:34.134 737 ERROR cinder.volume.manager Exit code: 1
2024-04-14 19:30:34.134 737 ERROR cinder.volume.manager Stdout: ''
2024-04-14 19:30:34.134 737 ERROR cinder.volume.manager Stderr: 'Device /dev/sdl is not a valid LUKS device.\n'

To post a comment you must log in.
This report contains Public information  
Everyone can see this information.

Other bug subscribers

Remote bug watches

Bug watches keep track of this bug in other bug trackers.