BackUp是将Volume备份到别的地方（备份设备），将来可以通过restore操作恢复。
BackUp VS Snapshot
查看backup功能好像与snapshot很相似，都可以保存volume的当前状态，以备以后恢复。但二者在用途和实现上还是有却别的，具体表现在：
1、Snapshot依赖于源volume，不能独立存在；而backup不依赖与源volume，即使源volume不存在了，也可以restore
2、Snapshot 与源volume 通常放在一起，都由同一个volume provider 管理；而backup存放在独立的备份设备中，有自己的备份方案和实现，与volume provider 没有关系。
3、上面两点决定了backup 具有容灾功能；而snapshot则提供volume provider内便捷的回溯功能
配置cinder-backup
Cinder 的Backup功能是由 cinder-backup 服务提供的，DevStack 默认没有启用该服务，需要手工启动。与cinder-volume类似，cinder-backup也通过driver架构支持多种备份backend，包括POSIX文件系统、NFS、Ceph、GlusterFS、Swift和IBM TSM。支持的driver 源文件放在/opt/stack/cinder/cinder/backup/drivers/目录下
[root@DevStack-Rocky-Compute-22 ~]# ll /opt/stack/cinder/cinder/backup/drivers/
total 132
-rw-r--r--. 1 stack root 53872 Jun 6 23:22 ceph.py
-rw-r--r--. 1 stack root 15322 Jun 6 23:22 gcs.py
-rw-r--r--. 1 stack root 3528 Jun 6 23:22 glusterfs.py
-rw-r--r--. 1 stack root 0 Jun 6 23:22 __init__.py
-rw-r--r--. 1 stack root 3868 Jun 6 23:22 nfs.py
-rw-r--r--. 1 stack root 5865 Jun 6 23:22 posix.py
-rw-r--r--. 1 stack root 18587 Jun 6 23:22 swift.py
-rw-r--r--. 1 stack root 21172 Jun 6 23:22 tsm.py
本节以NFS为backend来研究backup操作。
在实验环境中，存放volume backup 的NFS 远程目录为 10.12.28.8:/home/nfs ，cinder-backup服务节点上 挂载点为 /backup_mount 。需要在/etc/cinder/cinder.conf中进行配置
[DEFAULT]
backup_driver = cinder.backup.drivers.nfs
backup_mount_point_base = /backup_mount
backup_share = 10.12.28.8:/home/nfs
启动cinder-backup，第一次执行会报错，第二次就好了（第二次执行加 & ，这样不会占用终端）
/usr/bin/python /usr/bin/cinder-backup --config-file /etc/cinder/cinder.conf
目前只能在命令行执行backup操作（因为要执行backup的volume当前attach到了Instance上，所以需要添加--force选项，还可以添加 --incremental 选项执行增量备份）
[stack@DevStack-Rocky-Compute-22 ~]$ cinder list
+--------------------------------------+--------+------+------+-------------+----------+--------------------------------------+
| ID | Status | Name | Size | Volume Type | Bootable | Attached to |
+--------------------------------------+--------+------+------+-------------+----------+--------------------------------------+
| 06984f3c-44e1-42a5-b03c-08a0cfa19f73 | in-use | | 1 | lvmdriver-1 | true | 502d7935-e350-4164-8ef4-95cc8b34bd54 |
+--------------------------------------+--------+------+------+-------------+----------+--------------------------------------+
[stack@DevStack-Rocky-Compute-22 ~]$ cinder backup-create 06984f3c-44e1-42a5-b03c-08a0cfa19f73 --force
+-----------+--------------------------------------+
| Property | Value |
+-----------+--------------------------------------+
| id | 2e20eca6-07ed-4231-8576-891446ae5ff7 |
| name | None |
| volume_id | 06984f3c-44e1-42a5-b03c-08a0cfa19f73 |
+-----------+--------------------------------------+
[stack@DevStack-Rocky-Compute-22 ~]$ cinder list
+--------------------------------------+------------+-------------------------------------------------+------+-------------+----------+--------------------------------------+
| ID | Status | Name | Size | Volume Type | Bootable | Attached to |
+--------------------------------------+------------+-------------------------------------------------+------+-------------+----------+--------------------------------------+
| 06984f3c-44e1-42a5-b03c-08a0cfa19f73 | backing-up | | 1 | lvmdriver-1 | true | 502d7935-e350-4164-8ef4-95cc8b34bd54 |
| 964ba140-4b45-4072-ac6a-4a3c0ff50fc8 | available | backup-vol-06984f3c-44e1-42a5-b03c-08a0cfa19f73 | 1 | lvmdriver-1 | false | |
+--------------------------------------+------------+-------------------------------------------------+------+-------------+----------+--------------------------------------+
[stack@DevStack-Rocky-Compute-22 ~]$ cinder list
+--------------------------------------+--------+------+------+-------------+----------+--------------------------------------+
| ID | Status | Name | Size | Volume Type | Bootable | Attached to |
+--------------------------------------+--------+------+------+-------------+----------+--------------------------------------+
| 06984f3c-44e1-42a5-b03c-08a0cfa19f73 | in-use | | 1 | lvmdriver-1 | true | 502d7935-e350-4164-8ef4-95cc8b34bd54 |
+--------------------------------------+--------+------+------+-------------+----------+--------------------------------------+
[stack@DevStack-Rocky-Compute-22 ~]$ cinder backup-list
+--------------------------------------+--------------------------------------+-----------+------+------+--------------+--------------------------------------------+
| ID | Volume ID | Status | Name | Size | Object Count | Container |
+--------------------------------------+--------------------------------------+-----------+------+------+--------------+--------------------------------------------+
| 2e20eca6-07ed-4231-8576-891446ae5ff7 | 06984f3c-44e1-42a5-b03c-08a0cfa19f73 | available | - | 1 | 2 | 2e/20/2e20eca6-07ed-4231-8576-891446ae5ff7 |
+--------------------------------------+--------------------------------------+-----------+------+------+--------------+--------------------------------------------+
cinder-backup执行backup过程分析：
1、启动backup操作，mount NFS
2、创建volume的临时快照，见上面backup过程中 cinder list 内容
3、创建存放backup的container目录
4、对临时快照进行数据压缩，并保存到container目录
5、创建并保存sha256（加密）文件和metadata文件
6、删除临时快照
Jul 2 22:20:26 DevStack-Rocky-Controller-21 devstack@c-api.service: INFO cinder.api.openstack.wsgi [None req-97bdb30a-2461-4d92-8d77-1da241b2f3a5 admin admin] GET http://10.12.30.21/volume/v3/9ed27f1df9814f91b370d1003b066b0a/volumes/06984f3c-44e1-42a5-b03c-08a0cfa19f73
Jul 2 22:20:26 DevStack-Rocky-Controller-21 devstack@c-api.service: DEBUG cinder.api.openstack.wsgi [None req-97bdb30a-2461-4d92-8d77-1da241b2f3a5 admin admin] Empty body provided in request {{(pid=21071) get_body /opt/stack/cinder/cinder/api/openstack/wsgi.py:718}}
Jul 2 22:20:26 DevStack-Rocky-Controller-21 devstack@c-api.service: DEBUG cinder.api.openstack.wsgi [None req-97bdb30a-2461-4d92-8d77-1da241b2f3a5 admin admin] Calling method 'show' {{(pid=21071) _process_stack /opt/stack/cinder/cinder/api/openstack/wsgi.py:872}}
Jul 2 22:20:26 DevStack-Rocky-Controller-21 devstack@c-api.service: INFO cinder.volume.api [None req-97bdb30a-2461-4d92-8d77-1da241b2f3a5 admin admin] Volume info retrieved successfully.
Jul 2 22:20:26 DevStack-Rocky-Controller-21 devstack@c-api.service: INFO cinder.api.openstack.wsgi [None req-97bdb30a-2461-4d92-8d77-1da241b2f3a5 admin admin] http://10.12.30.21/volume/v3/9ed27f1df9814f91b370d1003b066b0a/volumes/06984f3c-44e1-42a5-b03c-08a0cfa19f73 returned with HTTP 200
Jul 2 22:20:26 DevStack-Rocky-Controller-21 devstack@c-api.service: INFO cinder.api.openstack.wsgi [req-97bdb30a-2461-4d92-8d77-1da241b2f3a5 req-8b498153-3faf-4bc2-bda8-6c290b69c6dc admin admin] POST http://10.12.30.21/volume/v3/9ed27f1df9814f91b370d1003b066b0a/backups
Jul 2 22:20:26 DevStack-Rocky-Controller-21 devstack@c-api.service: DEBUG cinder.api.openstack.wsgi [req-97bdb30a-2461-4d92-8d77-1da241b2f3a5 req-8b498153-3faf-4bc2-bda8-6c290b69c6dc admin admin] Action: 'create', calling method: create, body: {"backup": {"force": true, "description": null, "snapshot_id": null, "incremental": false, "volume_id": "06984f3c-44e1-42a5-b03c-08a0cfa19f73", "container": null, "name": null}} {{(pid=21070) _process_stack /opt/stack/cinder/cinder/api/openstack/wsgi.py:869}}
Jul 2 22:20:26 DevStack-Rocky-Controller-21 devstack@c-api.service: DEBUG cinder.api.contrib.backups [req-97bdb30a-2461-4d92-8d77-1da241b2f3a5 req-8b498153-3faf-4bc2-bda8-6c290b69c6dc admin admin] Creating new backup {u'backup': {u'container': None, u'description': None, u'snapshot_id': None, u'incremental': False, u'volume_id': u'06984f3c-44e1-42a5-b03c-08a0cfa19f73', u'force': True, u'name': None}} {{(pid=21070) create /opt/stack/cinder/cinder/api/contrib/backups.py:153}}
Jul 2 22:20:26 DevStack-Rocky-Controller-21 devstack@c-api.service: INFO cinder.api.contrib.backups [req-97bdb30a-2461-4d92-8d77-1da241b2f3a5 req-8b498153-3faf-4bc2-bda8-6c290b69c6dc admin admin] Creating backup of volume 06984f3c-44e1-42a5-b03c-08a0cfa19f73 in container None
Jul 2 22:20:26 DevStack-Rocky-Controller-21 devstack@c-api.service: INFO cinder.volume.api [req-97bdb30a-2461-4d92-8d77-1da241b2f3a5 req-8b498153-3faf-4bc2-bda8-6c290b69c6dc admin admin] Volume info retrieved successfully.
Jul 2 22:20:26 DevStack-Rocky-Controller-21 devstack@c-api.service: DEBUG cinder.quota [req-97bdb30a-2461-4d92-8d77-1da241b2f3a5 req-8b498153-3faf-4bc2-bda8-6c290b69c6dc admin admin] Created reservations ['b33376fa-e857-46ee-a118-5fc01bb4b25b', '0d228dee-b8d3-430b-97ff-47b96565649a'] {{(pid=21070) reserve /opt/stack/cinder/cinder/quota.py:1029}}
Jul 2 22:20:26 DevStack-Rocky-Controller-21 devstack@c-api.service: DEBUG cinder.backup.rpcapi [req-97bdb30a-2461-4d92-8d77-1da241b2f3a5 req-8b498153-3faf-4bc2-bda8-6c290b69c6dc admin admin] create_backup in rpcapi backup_id 2e20eca6-07ed-4231-8576-891446ae5ff7 {{(pid=21070) create_backup /opt/stack/cinder/cinder/backup/rpcapi.py:57}}
Jul 2 22:20:26 DevStack-Rocky-Controller-21 devstack@c-api.service: INFO cinder.api.openstack.wsgi [req-97bdb30a-2461-4d92-8d77-1da241b2f3a5 req-8b498153-3faf-4bc2-bda8-6c290b69c6dc admin admin] http://10.12.30.21/volume/v3/9ed27f1df9814f91b370d1003b066b0a/backups returned with HTTP 202
Jul 2 22:20:28 DevStack-Rocky-Controller-21 cinder-volume: DEBUG cinder.volume.driver [req-97bdb30a-2461-4d92-8d77-1da241b2f3a5 req-8b498153-3faf-4bc2-bda8-6c290b69c6dc admin None] Creating a new backup for volume volume-06984f3c-44e1-42a5-b03c-08a0cfa19f73. {{(pid=22852) _get_backup_volume_temp_volume /opt/stack/cinder/cinder/volume/driver.py:1177}}
Jul 2 22:20:28 DevStack-Rocky-Controller-21 cinder-volume: DEBUG oslo_concurrency.processutils [req-97bdb30a-2461-4d92-8d77-1da241b2f3a5 req-8b498153-3faf-4bc2-bda8-6c290b69c6dc admin None] Running cmd (subprocess): sudo cinder-rootwrap /etc/cinder/rootwrap.conf env LC_ALL=C lvs --noheadings --unit=g -o vg_name,name,size --nosuffix stack-volumes-lvmdriver-1/volume-06984f3c-44e1-42a5-b03c-08a0cfa19f73 {{(pid=22852) execute /usr/lib/python2.7/site-packages/oslo_concurrency/processutils.py:372}}
Jul 2 22:20:28 DevStack-Rocky-Controller-21 cinder-volume: DEBUG oslo_concurrency.processutils [req-97bdb30a-2461-4d92-8d77-1da241b2f3a5 req-8b498153-3faf-4bc2-bda8-6c290b69c6dc admin None] CMD "sudo cinder-rootwrap /etc/cinder/rootwrap.conf env LC_ALL=C lvs --noheadings --unit=g -o vg_name,name,size --nosuffix stack-volumes-lvmdriver-1/volume-06984f3c-44e1-42a5-b03c-08a0cfa19f73" returned: 0 in 0.306s {{(pid=22852) execute /usr/lib/python2.7/site-packages/oslo_concurrency/processutils.py:409}}
Jul 2 22:20:28 DevStack-Rocky-Controller-21 cinder-volume: DEBUG oslo_concurrency.processutils [req-97bdb30a-2461-4d92-8d77-1da241b2f3a5 req-8b498153-3faf-4bc2-bda8-6c290b69c6dc admin None] Running cmd (subprocess): sudo cinder-rootwrap /etc/cinder/rootwrap.conf env LC_ALL=C lvcreate --name volume-964ba140-4b45-4072-ac6a-4a3c0ff50fc8 --snapshot stack-volumes-lvmdriver-1/volume-06984f3c-44e1-42a5-b03c-08a0cfa19f73 {{(pid=22852) execute /usr/lib/python2.7/site-packages/oslo_concurrency/processutils.py:372}}
Jul 2 22:20:28 DevStack-Rocky-Controller-21 cinder-volume: DEBUG oslo_concurrency.processutils [req-97bdb30a-2461-4d92-8d77-1da241b2f3a5 req-8b498153-3faf-4bc2-bda8-6c290b69c6dc admin None] CMD "sudo cinder-rootwrap /etc/cinder/rootwrap.conf env LC_ALL=C lvcreate --name volume-964ba140-4b45-4072-ac6a-4a3c0ff50fc8 --snapshot stack-volumes-lvmdriver-1/volume-06984f3c-44e1-42a5-b03c-08a0cfa19f73" returned: 0 in 0.399s {{(pid=22852) execute /usr/lib/python2.7/site-packages/oslo_concurrency/processutils.py:409}}
Jul 2 22:20:28 DevStack-Rocky-Controller-21 cinder-volume: DEBUG oslo_concurrency.processutils [req-97bdb30a-2461-4d92-8d77-1da241b2f3a5 req-8b498153-3faf-4bc2-bda8-6c290b69c6dc admin None] Running cmd (subprocess): sudo cinder-rootwrap /etc/cinder/rootwrap.conf lvchange -a y --yes -k n stack-volumes-lvmdriver-1/volume-964ba140-4b45-4072-ac6a-4a3c0ff50fc8 {{(pid=22852) execute /usr/lib/python2.7/site-packages/oslo_concurrency/processutils.py:372}}
Jul 2 22:20:29 DevStack-Rocky-Controller-21 cinder-volume: DEBUG oslo_concurrency.processutils [req-97bdb30a-2461-4d92-8d77-1da241b2f3a5 req-8b498153-3faf-4bc2-bda8-6c290b69c6dc admin None] CMD "sudo cinder-rootwrap /etc/cinder/rootwrap.conf lvchange -a y --yes -k n stack-volumes-lvmdriver-1/volume-964ba140-4b45-4072-ac6a-4a3c0ff50fc8" returned: 0 in 0.319s {{(pid=22852) execute /usr/lib/python2.7/site-packages/oslo_concurrency/processutils.py:409}}
Jul 2 22:20:29 DevStack-Rocky-Controller-21 cinder-volume: DEBUG oslo_concurrency.processutils [req-97bdb30a-2461-4d92-8d77-1da241b2f3a5 req-8b498153-3faf-4bc2-bda8-6c290b69c6dc admin None] Running cmd (subprocess): sudo cinder-rootwrap /etc/cinder/rootwrap.conf lvchange -a y --yes -K stack-volumes-lvmdriver-1/volume-964ba140-4b45-4072-ac6a-4a3c0ff50fc8 {{(pid=22852) execute /usr/lib/python2.7/site-packages/oslo_concurrency/processutils.py:372}}
Jul 2 22:20:29 DevStack-Rocky-Controller-21 cinder-volume: DEBUG oslo_concurrency.processutils [req-97bdb30a-2461-4d92-8d77-1da241b2f3a5 req-8b498153-3faf-4bc2-bda8-6c290b69c6dc admin None] CMD "sudo cinder-rootwrap /etc/cinder/rootwrap.conf lvchange -a y --yes -K stack-volumes-lvmdriver-1/volume-964ba140-4b45-4072-ac6a-4a3c0ff50fc8" returned: 0 in 0.273s {{(pid=22852) execute /usr/lib/python2.7/site-packages/oslo_concurrency/processutils.py:409}}
Jul 2 22:20:29 DevStack-Rocky-Controller-21 cinder-volume: INFO cinder.volume.targets.lio [req-97bdb30a-2461-4d92-8d77-1da241b2f3a5 req-8b498153-3faf-4bc2-bda8-6c290b69c6dc admin None] Creating iscsi_target for volume: volume-964ba140-4b45-4072-ac6a-4a3c0ff50fc8
Jul 2 22:20:29 DevStack-Rocky-Controller-21 cinder-volume: DEBUG oslo_concurrency.lockutils [req-97bdb30a-2461-4d92-8d77-1da241b2f3a5 req-8b498153-3faf-4bc2-bda8-6c290b69c6dc admin None] Lock "lioadm" acquired by "cinder.volume.targets.lio._execute" :: waited 0.000s {{(pid=22852) inner /usr/lib/python2.7/site-packages/oslo_concurrency/lockutils.py:273}}
Jul 2 22:20:29 DevStack-Rocky-Controller-21 cinder-volume: DEBUG oslo_concurrency.processutils [req-97bdb30a-2461-4d92-8d77-1da241b2f3a5 req-8b498153-3faf-4bc2-bda8-6c290b69c6dc admin None] Running cmd (subprocess): sudo cinder-rootwrap /etc/cinder/rootwrap.conf cinder-rtstool create /dev/stack-volumes-lvmdriver-1/volume-964ba140-4b45-4072-ac6a-4a3c0ff50fc8 iqn.2010-10.org.openstack:volume-964ba140-4b45-4072-ac6a-4a3c0ff50fc8 kMQqe7C9R67buRENfic3 aRBksd8xc8M23UqP False -p3260 -a10.12.30.21 {{(pid=22852) execute /usr/lib/python2.7/site-packages/oslo_concurrency/processutils.py:372}}
Jul 2 22:20:30 DevStack-Rocky-Controller-21 cinder-volume: DEBUG oslo_concurrency.processutils [req-97bdb30a-2461-4d92-8d77-1da241b2f3a5 req-8b498153-3faf-4bc2-bda8-6c290b69c6dc admin None] CMD "sudo cinder-rootwrap /etc/cinder/rootwrap.conf cinder-rtstool create /dev/stack-volumes-lvmdriver-1/volume-964ba140-4b45-4072-ac6a-4a3c0ff50fc8 iqn.2010-10.org.openstack:volume-964ba140-4b45-4072-ac6a-4a3c0ff50fc8 kMQqe7C9R67buRENfic3 aRBksd8xc8M23UqP False -p3260 -a10.12.30.21" returned: 0 in 0.624s {{(pid=22852) execute /usr/lib/python2.7/site-packages/oslo_concurrency/processutils.py:409}}
Jul 2 22:20:30 DevStack-Rocky-Controller-21 cinder-volume: DEBUG oslo_concurrency.lockutils [req-97bdb30a-2461-4d92-8d77-1da241b2f3a5 req-8b498153-3faf-4bc2-bda8-6c290b69c6dc admin None] Lock "lioadm" released by "cinder.volume.targets.lio._execute" :: held 0.626s {{(pid=22852) inner /usr/lib/python2.7/site-packages/oslo_concurrency/lockutils.py:285}}
Jul 2 22:20:30 DevStack-Rocky-Controller-21 cinder-volume: DEBUG oslo_concurrency.lockutils [req-97bdb30a-2461-4d92-8d77-1da241b2f3a5 req-8b498153-3faf-4bc2-bda8-6c290b69c6dc admin None] Lock "lioadm" acquired by "cinder.volume.targets.lio._execute" :: waited 0.000s {{(pid=22852) inner /usr/lib/python2.7/site-packages/oslo_concurrency/lockutils.py:273}}
Jul 2 22:20:30 DevStack-Rocky-Controller-21 cinder-volume: DEBUG oslo_concurrency.processutils [req-97bdb30a-2461-4d92-8d77-1da241b2f3a5 req-8b498153-3faf-4bc2-bda8-6c290b69c6dc admin None] Running cmd (subprocess): sudo cinder-rootwrap /etc/cinder/rootwrap.conf cinder-rtstool get-targets {{(pid=22852) execute /usr/lib/python2.7/site-packages/oslo_concurrency/processutils.py:372}}
Jul 2 22:20:30 DevStack-Rocky-Controller-21 cinder-volume: DEBUG oslo_concurrency.processutils [req-97bdb30a-2461-4d92-8d77-1da241b2f3a5 req-8b498153-3faf-4bc2-bda8-6c290b69c6dc admin None] CMD "sudo cinder-rootwrap /etc/cinder/rootwrap.conf cinder-rtstool get-targets" returned: 0 in 0.498s {{(pid=22852) execute /usr/lib/python2.7/site-packages/oslo_concurrency/processutils.py:409}}
Jul 2 22:20:30 DevStack-Rocky-Controller-21 cinder-volume: DEBUG oslo_concurrency.lockutils [req-97bdb30a-2461-4d92-8d77-1da241b2f3a5 req-8b498153-3faf-4bc2-bda8-6c290b69c6dc admin None] Lock "lioadm" released by "cinder.volume.targets.lio._execute" :: held 0.500s {{(pid=22852) inner /usr/lib/python2.7/site-packages/oslo_concurrency/lockutils.py:285}}
Jul 2 22:20:30 DevStack-Rocky-Controller-21 cinder-volume: DEBUG oslo_concurrency.lockutils [req-97bdb30a-2461-4d92-8d77-1da241b2f3a5 req-8b498153-3faf-4bc2-bda8-6c290b69c6dc admin None] Lock "lioadm" acquired by "cinder.volume.targets.lio._execute" :: waited 0.000s {{(pid=22852) inner /usr/lib/python2.7/site-packages/oslo_concurrency/lockutils.py:273}}
Jul 2 22:20:30 DevStack-Rocky-Controller-21 cinder-volume: DEBUG oslo_concurrency.processutils [req-97bdb30a-2461-4d92-8d77-1da241b2f3a5 req-8b498153-3faf-4bc2-bda8-6c290b69c6dc admin None] Running cmd (subprocess): sudo cinder-rootwrap /etc/cinder/rootwrap.conf cinder-rtstool save {{(pid=22852) execute /usr/lib/python2.7/site-packages/oslo_concurrency/processutils.py:372}}
Jul 2 22:20:31 DevStack-Rocky-Controller-21 cinder-volume: DEBUG oslo_concurrency.processutils [req-97bdb30a-2461-4d92-8d77-1da241b2f3a5 req-8b498153-3faf-4bc2-bda8-6c290b69c6dc admin None] CMD "sudo cinder-rootwrap /etc/cinder/rootwrap.conf cinder-rtstool save" returned: 0 in 0.577s {{(pid=22852) execute /usr/lib/python2.7/site-packages/oslo_concurrency/processutils.py:409}}
Jul 2 22:20:31 DevStack-Rocky-Controller-21 cinder-volume: DEBUG oslo_concurrency.lockutils [req-97bdb30a-2461-4d92-8d77-1da241b2f3a5 req-8b498153-3faf-4bc2-bda8-6c290b69c6dc admin None] Lock "lioadm" released by "cinder.volume.targets.lio._execute" :: held 0.579s {{(pid=22852) inner /usr/lib/python2.7/site-packages/oslo_concurrency/lockutils.py:285}}
Jul 2 22:20:31 DevStack-Rocky-Controller-21 cinder-volume: DEBUG cinder.volume.targets.iscsi [req-97bdb30a-2461-4d92-8d77-1da241b2f3a5 req-8b498153-3faf-4bc2-bda8-6c290b69c6dc admin None] Set provider_location to: 10.12.30.21:3260,iqn.2010-10.org.openstack:volume-964ba140-4b45-4072-ac6a-4a3c0ff50fc8 iqn.2010-10.org.openstack:volume-964ba140-4b45-4072-ac6a-4a3c0ff50fc8 0 {{(pid=22852) create_export /opt/stack/cinder/cinder/volume/targets/iscsi.py:215}}
Jul 2 22:20:31 DevStack-Rocky-Controller-21 cinder-volume: DEBUG oslo_concurrency.lockutils [req-97bdb30a-2461-4d92-8d77-1da241b2f3a5 req-8b498153-3faf-4bc2-bda8-6c290b69c6dc admin None] Lock "lioadm" acquired by "cinder.volume.targets.lio._execute" :: waited 0.000s {{(pid=22852) inner /usr/lib/python2.7/site-packages/oslo_concurrency/lockutils.py:273}}
Jul 2 22:20:31 DevStack-Rocky-Controller-21 cinder-volume: DEBUG oslo_concurrency.processutils [req-97bdb30a-2461-4d92-8d77-1da241b2f3a5 req-8b498153-3faf-4bc2-bda8-6c290b69c6dc admin None] Running cmd (subprocess): sudo cinder-rootwrap /etc/cinder/rootwrap.conf cinder-rtstool add-initiator iqn.2010-10.org.openstack:volume-964ba140-4b45-4072-ac6a-4a3c0ff50fc8 kMQqe7C9R67buRENfic3 aRBksd8xc8M23UqP iqn.1994-05.com.redhat:ce630fd6190 {{(pid=22852) execute /usr/lib/python2.7/site-packages/oslo_concurrency/processutils.py:372}}
Jul 2 22:20:31 DevStack-Rocky-Controller-21 cinder-volume: DEBUG oslo_concurrency.processutils [req-97bdb30a-2461-4d92-8d77-1da241b2f3a5 req-8b498153-3faf-4bc2-bda8-6c290b69c6dc admin None] CMD "sudo cinder-rootwrap /etc/cinder/rootwrap.conf cinder-rtstool add-initiator iqn.2010-10.org.openstack:volume-964ba140-4b45-4072-ac6a-4a3c0ff50fc8 kMQqe7C9R67buRENfic3 aRBksd8xc8M23UqP iqn.1994-05.com.redhat:ce630fd6190" returned: 0 in 0.536s {{(pid=22852) execute /usr/lib/python2.7/site-packages/oslo_concurrency/processutils.py:409}}
Jul 2 22:20:31 DevStack-Rocky-Controller-21 cinder-volume: DEBUG oslo_concurrency.lockutils [req-97bdb30a-2461-4d92-8d77-1da241b2f3a5 req-8b498153-3faf-4bc2-bda8-6c290b69c6dc admin None] Lock "lioadm" released by "cinder.volume.targets.lio._execute" :: held 0.539s {{(pid=22852) inner /usr/lib/python2.7/site-packages/oslo_concurrency/lockutils.py:285}}
Jul 2 22:20:31 DevStack-Rocky-Controller-21 cinder-volume: DEBUG oslo_concurrency.lockutils [req-97bdb30a-2461-4d92-8d77-1da241b2f3a5 req-8b498153-3faf-4bc2-bda8-6c290b69c6dc admin None] Lock "lioadm" acquired by "cinder.volume.targets.lio._execute" :: waited 0.000s {{(pid=22852) inner /usr/lib/python2.7/site-packages/oslo_concurrency/lockutils.py:273}}
Jul 2 22:20:31 DevStack-Rocky-Controller-21 cinder-volume: DEBUG oslo_concurrency.processutils [req-97bdb30a-2461-4d92-8d77-1da241b2f3a5 req-8b498153-3faf-4bc2-bda8-6c290b69c6dc admin None] Running cmd (subprocess): sudo cinder-rootwrap /etc/cinder/rootwrap.conf cinder-rtstool save {{(pid=22852) execute /usr/lib/python2.7/site-packages/oslo_concurrency/processutils.py:372}}
Jul 2 22:20:32 DevStack-Rocky-Controller-21 cinder-volume: DEBUG oslo_concurrency.processutils [req-97bdb30a-2461-4d92-8d77-1da241b2f3a5 req-8b498153-3faf-4bc2-bda8-6c290b69c6dc admin None] CMD "sudo cinder-rootwrap /etc/cinder/rootwrap.conf cinder-rtstool save" returned: 0 in 0.591s {{(pid=22852) execute /usr/lib/python2.7/site-packages/oslo_concurrency/processutils.py:409}}
Jul 2 22:20:32 DevStack-Rocky-Controller-21 cinder-volume: DEBUG oslo_concurrency.lockutils [req-97bdb30a-2461-4d92-8d77-1da241b2f3a5 req-8b498153-3faf-4bc2-bda8-6c290b69c6dc admin None] Lock "lioadm" released by "cinder.volume.targets.lio._execute" :: held 0.593s {{(pid=22852) inner /usr/lib/python2.7/site-packages/oslo_concurrency/lockutils.py:285}}
Jul 2 22:20:32 DevStack-Rocky-Controller-21 cinder-volume: INFO cinder.volume.manager [req-97bdb30a-2461-4d92-8d77-1da241b2f3a5 req-8b498153-3faf-4bc2-bda8-6c290b69c6dc admin None] Initialize volume connection completed successfully.
Jul 2 22:20:59 DevStack-Rocky-Controller-21 cinder-volume: DEBUG oslo_concurrency.lockutils [req-97bdb30a-2461-4d92-8d77-1da241b2f3a5 req-8b498153-3faf-4bc2-bda8-6c290b69c6dc admin None] Lock "lioadm" acquired by "cinder.volume.targets.lio._execute" :: waited 0.000s {{(pid=22852) inner /usr/lib/python2.7/site-packages/oslo_concurrency/lockutils.py:273}}
Jul 2 22:20:59 DevStack-Rocky-Controller-21 cinder-volume: DEBUG oslo_concurrency.processutils [req-97bdb30a-2461-4d92-8d77-1da241b2f3a5 req-8b498153-3faf-4bc2-bda8-6c290b69c6dc admin None] Running cmd (subprocess): sudo cinder-rootwrap /etc/cinder/rootwrap.conf cinder-rtstool delete-initiator iqn.2010-10.org.openstack:volume-964ba140-4b45-4072-ac6a-4a3c0ff50fc8 iqn.1994-05.com.redhat:ce630fd6190 {{(pid=22852) execute /usr/lib/python2.7/site-packages/oslo_concurrency/processutils.py:372}}
Jul 2 22:21:00 DevStack-Rocky-Controller-21 cinder-volume: DEBUG oslo_concurrency.processutils [req-97bdb30a-2461-4d92-8d77-1da241b2f3a5 req-8b498153-3faf-4bc2-bda8-6c290b69c6dc admin None] CMD "sudo cinder-rootwrap /etc/cinder/rootwrap.conf cinder-rtstool delete-initiator iqn.2010-10.org.openstack:volume-964ba140-4b45-4072-ac6a-4a3c0ff50fc8 iqn.1994-05.com.redhat:ce630fd6190" returned: 0 in 1.041s {{(pid=22852) execute /usr/lib/python2.7/site-packages/oslo_concurrency/processutils.py:409}}
Jul 2 22:21:00 DevStack-Rocky-Controller-21 cinder-volume: DEBUG oslo_concurrency.lockutils [req-97bdb30a-2461-4d92-8d77-1da241b2f3a5 req-8b498153-3faf-4bc2-bda8-6c290b69c6dc admin None] Lock "lioadm" released by "cinder.volume.targets.lio._execute" :: held 1.042s {{(pid=22852) inner /usr/lib/python2.7/site-packages/oslo_concurrency/lockutils.py:285}}
Jul 2 22:21:00 DevStack-Rocky-Controller-21 cinder-volume: DEBUG oslo_concurrency.lockutils [req-97bdb30a-2461-4d92-8d77-1da241b2f3a5 req-8b498153-3faf-4bc2-bda8-6c290b69c6dc admin None] Lock "lioadm" acquired by "cinder.volume.targets.lio._execute" :: waited 0.000s {{(pid=22852) inner /usr/lib/python2.7/site-packages/oslo_concurrency/lockutils.py:273}}
Jul 2 22:21:00 DevStack-Rocky-Controller-21 cinder-volume: DEBUG oslo_concurrency.processutils [req-97bdb30a-2461-4d92-8d77-1da241b2f3a5 req-8b498153-3faf-4bc2-bda8-6c290b69c6dc admin None] Running cmd (subprocess): sudo cinder-rootwrap /etc/cinder/rootwrap.conf cinder-rtstool save {{(pid=22852) execute /usr/lib/python2.7/site-packages/oslo_concurrency/processutils.py:372}}
Jul 2 22:21:01 DevStack-Rocky-Controller-21 cinder-volume: DEBUG oslo_concurrency.processutils [req-97bdb30a-2461-4d92-8d77-1da241b2f3a5 req-8b498153-3faf-4bc2-bda8-6c290b69c6dc admin None] CMD "sudo cinder-rootwrap /etc/cinder/rootwrap.conf cinder-rtstool save" returned: 0 in 0.588s {{(pid=22852) execute /usr/lib/python2.7/site-packages/oslo_concurrency/processutils.py:409}}
Jul 2 22:21:01 DevStack-Rocky-Controller-21 cinder-volume: DEBUG oslo_concurrency.lockutils [req-97bdb30a-2461-4d92-8d77-1da241b2f3a5 req-8b498153-3faf-4bc2-bda8-6c290b69c6dc admin None] Lock "lioadm" released by "cinder.volume.targets.lio._execute" :: held 0.590s {{(pid=22852) inner /usr/lib/python2.7/site-packages/oslo_concurrency/lockutils.py:285}}
Jul 2 22:21:01 DevStack-Rocky-Controller-21 cinder-volume: INFO cinder.volume.manager [req-97bdb30a-2461-4d92-8d77-1da241b2f3a5 req-8b498153-3faf-4bc2-bda8-6c290b69c6dc admin None] Terminate volume connection completed successfully.
Jul 2 22:21:01 DevStack-Rocky-Controller-21 cinder-volume: DEBUG oslo_concurrency.lockutils [req-97bdb30a-2461-4d92-8d77-1da241b2f3a5 req-8b498153-3faf-4bc2-bda8-6c290b69c6dc admin None] Lock "lioadm" acquired by "cinder.volume.targets.lio._execute" :: waited 0.000s {{(pid=22852) inner /usr/lib/python2.7/site-packages/oslo_concurrency/lockutils.py:273}}
Jul 2 22:21:01 DevStack-Rocky-Controller-21 cinder-volume: DEBUG oslo_concurrency.processutils [req-97bdb30a-2461-4d92-8d77-1da241b2f3a5 req-8b498153-3faf-4bc2-bda8-6c290b69c6dc admin None] Running cmd (subprocess): sudo cinder-rootwrap /etc/cinder/rootwrap.conf cinder-rtstool get-targets {{(pid=22852) execute /usr/lib/python2.7/site-packages/oslo_concurrency/processutils.py:372}}
Jul 2 22:21:01 DevStack-Rocky-Controller-21 cinder-volume: DEBUG cinder.coordination [req-97bdb30a-2461-4d92-8d77-1da241b2f3a5 req-8b498153-3faf-4bc2-bda8-6c290b69c6dc admin None] Lock "cinder-964ba140-4b45-4072-ac6a-4a3c0ff50fc8-delete_volume" acquired by "delete_volume" :: waited 0.048s {{(pid=22852) _synchronized /opt/stack/cinder/cinder/coordination.py:150}}
Jul 2 22:21:01 DevStack-Rocky-Controller-21 cinder-volume: INFO cinder.volume.manager [req-97bdb30a-2461-4d92-8d77-1da241b2f3a5 req-8b498153-3faf-4bc2-bda8-6c290b69c6dc admin None] Trying to delete temp volume: 964ba140-4b45-4072-ac6a-4a3c0ff50fc8
Jul 2 22:21:01 DevStack-Rocky-Controller-21 cinder-volume: DEBUG oslo_concurrency.processutils [req-97bdb30a-2461-4d92-8d77-1da241b2f3a5 req-8b498153-3faf-4bc2-bda8-6c290b69c6dc admin None] CMD "sudo cinder-rootwrap /etc/cinder/rootwrap.conf cinder-rtstool get-targets" returned: 0 in 0.518s {{(pid=22852) execute /usr/lib/python2.7/site-packages/oslo_concurrency/processutils.py:409}}
Jul 2 22:21:01 DevStack-Rocky-Controller-21 cinder-volume: DEBUG oslo_concurrency.lockutils [req-97bdb30a-2461-4d92-8d77-1da241b2f3a5 req-8b498153-3faf-4bc2-bda8-6c290b69c6dc admin None] Lock "lioadm" released by "cinder.volume.targets.lio._execute" :: held 0.520s {{(pid=22852) inner /usr/lib/python2.7/site-packages/oslo_concurrency/lockutils.py:285}}
Jul 2 22:21:01 DevStack-Rocky-Controller-21 cinder-volume: INFO cinder.volume.targets.lio [req-97bdb30a-2461-4d92-8d77-1da241b2f3a5 req-8b498153-3faf-4bc2-bda8-6c290b69c6dc admin None] Removing iscsi_target: 964ba140-4b45-4072-ac6a-4a3c0ff50fc8
Jul 2 22:21:01 DevStack-Rocky-Controller-21 cinder-volume: DEBUG oslo_concurrency.lockutils [req-97bdb30a-2461-4d92-8d77-1da241b2f3a5 req-8b498153-3faf-4bc2-bda8-6c290b69c6dc admin None] Lock "lioadm" acquired by "cinder.volume.targets.lio._execute" :: waited 0.000s {{(pid=22852) inner /usr/lib/python2.7/site-packages/oslo_concurrency/lockutils.py:273}}
Jul 2 22:21:01 DevStack-Rocky-Controller-21 cinder-volume: DEBUG oslo_concurrency.processutils [req-97bdb30a-2461-4d92-8d77-1da241b2f3a5 req-8b498153-3faf-4bc2-bda8-6c290b69c6dc admin None] Running cmd (subprocess): sudo cinder-rootwrap /etc/cinder/rootwrap.conf cinder-rtstool delete iqn.2010-10.org.openstack:volume-964ba140-4b45-4072-ac6a-4a3c0ff50fc8 {{(pid=22852) execute /usr/lib/python2.7/site-packages/oslo_concurrency/processutils.py:372}}
Jul 2 22:21:02 DevStack-Rocky-Controller-21 cinder-volume: DEBUG oslo_concurrency.processutils [req-97bdb30a-2461-4d92-8d77-1da241b2f3a5 req-8b498153-3faf-4bc2-bda8-6c290b69c6dc admin None] CMD "sudo cinder-rootwrap /etc/cinder/rootwrap.conf cinder-rtstool delete iqn.2010-10.org.openstack:volume-964ba140-4b45-4072-ac6a-4a3c0ff50fc8" returned: 0 in 0.551s {{(pid=22852) execute /usr/lib/python2.7/site-packages/oslo_concurrency/processutils.py:409}}
Jul 2 22:21:02 DevStack-Rocky-Controller-21 cinder-volume: DEBUG oslo_concurrency.lockutils [req-97bdb30a-2461-4d92-8d77-1da241b2f3a5 req-8b498153-3faf-4bc2-bda8-6c290b69c6dc admin None] Lock "lioadm" released by "cinder.volume.targets.lio._execute" :: held 0.553s {{(pid=22852) inner /usr/lib/python2.7/site-packages/oslo_concurrency/lockutils.py:285}}
Jul 2 22:21:02 DevStack-Rocky-Controller-21 cinder-volume: DEBUG oslo_concurrency.lockutils [req-97bdb30a-2461-4d92-8d77-1da241b2f3a5 req-8b498153-3faf-4bc2-bda8-6c290b69c6dc admin None] Lock "lioadm" acquired by "cinder.volume.targets.lio._execute" :: waited 0.000s {{(pid=22852) inner /usr/lib/python2.7/site-packages/oslo_concurrency/lockutils.py:273}}
Jul 2 22:21:02 DevStack-Rocky-Controller-21 cinder-volume: DEBUG oslo_concurrency.processutils [req-97bdb30a-2461-4d92-8d77-1da241b2f3a5 req-8b498153-3faf-4bc2-bda8-6c290b69c6dc admin None] Running cmd (subprocess): sudo cinder-rootwrap /etc/cinder/rootwrap.conf cinder-rtstool save {{(pid=22852) execute /usr/lib/python2.7/site-packages/oslo_concurrency/processutils.py:372}}
Jul 2 22:21:02 DevStack-Rocky-Controller-21 cinder-volume: DEBUG oslo_concurrency.processutils [req-97bdb30a-2461-4d92-8d77-1da241b2f3a5 req-8b498153-3faf-4bc2-bda8-6c290b69c6dc admin None] CMD "sudo cinder-rootwrap /etc/cinder/rootwrap.conf cinder-rtstool save" returned: 0 in 0.558s {{(pid=22852) execute /usr/lib/python2.7/site-packages/oslo_concurrency/processutils.py:409}}
Jul 2 22:21:02 DevStack-Rocky-Controller-21 cinder-volume: DEBUG oslo_concurrency.lockutils [req-97bdb30a-2461-4d92-8d77-1da241b2f3a5 req-8b498153-3faf-4bc2-bda8-6c290b69c6dc admin None] Lock "lioadm" released by "cinder.volume.targets.lio._execute" :: held 0.562s {{(pid=22852) inner /usr/lib/python2.7/site-packages/oslo_concurrency/lockutils.py:285}}
Jul 2 22:21:02 DevStack-Rocky-Controller-21 cinder-volume: INFO cinder.volume.manager [req-97bdb30a-2461-4d92-8d77-1da241b2f3a5 req-8b498153-3faf-4bc2-bda8-6c290b69c6dc admin None] Remove volume export completed successfully.
Jul 2 22:21:02 DevStack-Rocky-Controller-21 cinder-volume: DEBUG oslo_concurrency.lockutils [req-97bdb30a-2461-4d92-8d77-1da241b2f3a5 req-8b498153-3faf-4bc2-bda8-6c290b69c6dc admin None] Lock "lioadm" acquired by "cinder.volume.targets.lio._execute" :: waited 1.532s {{(pid=22852) inner /usr/lib/python2.7/site-packages/oslo_concurrency/lockutils.py:273}}
Jul 2 22:21:02 DevStack-Rocky-Controller-21 cinder-volume: DEBUG oslo_concurrency.processutils [req-97bdb30a-2461-4d92-8d77-1da241b2f3a5 req-8b498153-3faf-4bc2-bda8-6c290b69c6dc admin None] Running cmd (subprocess): sudo cinder-rootwrap /etc/cinder/rootwrap.conf cinder-rtstool get-targets {{(pid=22852) execute /usr/lib/python2.7/site-packages/oslo_concurrency/processutils.py:372}}
Jul 2 22:21:03 DevStack-Rocky-Controller-21 cinder-volume: DEBUG oslo_concurrency.processutils [req-97bdb30a-2461-4d92-8d77-1da241b2f3a5 req-8b498153-3faf-4bc2-bda8-6c290b69c6dc admin None] CMD "sudo cinder-rootwrap /etc/cinder/rootwrap.conf cinder-rtstool get-targets" returned: 0 in 0.515s {{(pid=22852) execute /usr/lib/python2.7/site-packages/oslo_concurrency/processutils.py:409}}
Jul 2 22:21:03 DevStack-Rocky-Controller-21 cinder-volume: DEBUG oslo_concurrency.lockutils [req-97bdb30a-2461-4d92-8d77-1da241b2f3a5 req-8b498153-3faf-4bc2-bda8-6c290b69c6dc admin None] Lock "lioadm" released by "cinder.volume.targets.lio._execute" :: held 0.516s {{(pid=22852) inner /usr/lib/python2.7/site-packages/oslo_concurrency/lockutils.py:285}}
Jul 2 22:21:03 DevStack-Rocky-Controller-21 cinder-volume: INFO cinder.volume.targets.iscsi [req-97bdb30a-2461-4d92-8d77-1da241b2f3a5 req-8b498153-3faf-4bc2-bda8-6c290b69c6dc admin None] Skipping remove_export. No iscsi_target is presently exported for volume: 964ba140-4b45-4072-ac6a-4a3c0ff50fc8
Jul 2 22:21:03 DevStack-Rocky-Controller-21 cinder-volume: DEBUG oslo_concurrency.processutils [req-97bdb30a-2461-4d92-8d77-1da241b2f3a5 req-8b498153-3faf-4bc2-bda8-6c290b69c6dc admin None] Running cmd (subprocess): sudo cinder-rootwrap /etc/cinder/rootwrap.conf env LC_ALL=C lvs --noheadings --unit=g -o vg_name,name,size --nosuffix stack-volumes-lvmdriver-1/volume-964ba140-4b45-4072-ac6a-4a3c0ff50fc8 {{(pid=22852) execute /usr/lib/python2.7/site-packages/oslo_concurrency/processutils.py:372}}
Jul 2 22:21:03 DevStack-Rocky-Controller-21 cinder-volume: DEBUG oslo_concurrency.processutils [req-97bdb30a-2461-4d92-8d77-1da241b2f3a5 req-8b498153-3faf-4bc2-bda8-6c290b69c6dc admin None] CMD "sudo cinder-rootwrap /etc/cinder/rootwrap.conf env LC_ALL=C lvs --noheadings --unit=g -o vg_name,name,size --nosuffix stack-volumes-lvmdriver-1/volume-964ba140-4b45-4072-ac6a-4a3c0ff50fc8" returned: 0 in 0.286s {{(pid=22852) execute /usr/lib/python2.7/site-packages/oslo_concurrency/processutils.py:409}}
Jul 2 22:21:03 DevStack-Rocky-Controller-21 cinder-volume: DEBUG oslo_concurrency.processutils [req-97bdb30a-2461-4d92-8d77-1da241b2f3a5 req-8b498153-3faf-4bc2-bda8-6c290b69c6dc admin None] Running cmd (subprocess): sudo cinder-rootwrap /etc/cinder/rootwrap.conf env LC_ALL=C lvdisplay --noheading -C -o Attr stack-volumes-lvmdriver-1/volume-964ba140-4b45-4072-ac6a-4a3c0ff50fc8 {{(pid=22852) execute /usr/lib/python2.7/site-packages/oslo_concurrency/processutils.py:372}}
Jul 2 22:21:03 DevStack-Rocky-Controller-21 cinder-volume: DEBUG oslo_concurrency.processutils [req-97bdb30a-2461-4d92-8d77-1da241b2f3a5 req-8b498153-3faf-4bc2-bda8-6c290b69c6dc admin None] CMD "sudo cinder-rootwrap /etc/cinder/rootwrap.conf env LC_ALL=C lvdisplay --noheading -C -o Attr stack-volumes-lvmdriver-1/volume-964ba140-4b45-4072-ac6a-4a3c0ff50fc8" returned: 0 in 0.289s {{(pid=22852) execute /usr/lib/python2.7/site-packages/oslo_concurrency/processutils.py:409}}
Jul 2 22:21:03 DevStack-Rocky-Controller-21 cinder-volume: DEBUG oslo_concurrency.processutils [req-97bdb30a-2461-4d92-8d77-1da241b2f3a5 req-8b498153-3faf-4bc2-bda8-6c290b69c6dc admin None] Running cmd (subprocess): sudo cinder-rootwrap /etc/cinder/rootwrap.conf lvremove --config activation { retry_deactivation = 1} -f stack-volumes-lvmdriver-1/volume-964ba140-4b45-4072-ac6a-4a3c0ff50fc8 {{(pid=22852) execute /usr/lib/python2.7/site-packages/oslo_concurrency/processutils.py:372}}
Jul 2 22:21:04 DevStack-Rocky-Controller-21 cinder-volume: DEBUG oslo_concurrency.processutils [req-97bdb30a-2461-4d92-8d77-1da241b2f3a5 req-8b498153-3faf-4bc2-bda8-6c290b69c6dc admin None] CMD "sudo cinder-rootwrap /etc/cinder/rootwrap.conf lvremove --config activation { retry_deactivation = 1} -f stack-volumes-lvmdriver-1/volume-964ba140-4b45-4072-ac6a-4a3c0ff50fc8" returned: 0 in 0.365s {{(pid=22852) execute /usr/lib/python2.7/site-packages/oslo_concurrency/processutils.py:409}}
Jul 2 22:21:04 DevStack-Rocky-Controller-21 cinder-volume: INFO cinder.volume.drivers.lvm [req-97bdb30a-2461-4d92-8d77-1da241b2f3a5 req-8b498153-3faf-4bc2-bda8-6c290b69c6dc admin None] Successfully deleted volume: 964ba140-4b45-4072-ac6a-4a3c0ff50fc8
Jul 2 22:21:04 DevStack-Rocky-Controller-21 cinder-volume: WARNING py.warnings [req-97bdb30a-2461-4d92-8d77-1da241b2f3a5 req-8b498153-3faf-4bc2-bda8-6c290b69c6dc admin None] /usr/lib64/python2.7/site-packages/sqlalchemy/orm/evaluator.py:71: SAWarning: Evaluating non-mapped column expression 'updated_at' onto ORM instances; this is a deprecated use case. Please make use of the actual mapped columns in ORM-evaluated UPDATE / DELETE expressions.
Jul 2 22:21:04 DevStack-Rocky-Controller-21 cinder-volume: INFO cinder.volume.manager [req-97bdb30a-2461-4d92-8d77-1da241b2f3a5 req-8b498153-3faf-4bc2-bda8-6c290b69c6dc admin None] Deleted volume successfully.
Jul 2 22:21:04 DevStack-Rocky-Controller-21 cinder-volume: DEBUG cinder.coordination [req-97bdb30a-2461-4d92-8d77-1da241b2f3a5 req-8b498153-3faf-4bc2-bda8-6c290b69c6dc admin None] Lock "cinder-964ba140-4b45-4072-ac6a-4a3c0ff50fc8-delete_volume" released by "delete_volume" :: held 3.087s {{(pid=22852) _synchronized /opt/stack/cinder/cinder/coordination.py:162}}