I0730 20:57:04.997084       1 cephcsi.go:191] Driver version: v3.11.0 and Git version: bc24b5eca87626d690a29effa9d7420cc0154a7a
I0730 20:57:04.997191       1 cephcsi.go:223] Starting driver type: rbd with name: rbd.csi.ceph.com
I0730 20:57:04.997202       1 driver.go:95] Enabling controller service capability: CREATE_DELETE_VOLUME
I0730 20:57:04.997205       1 driver.go:95] Enabling controller service capability: CREATE_DELETE_SNAPSHOT
I0730 20:57:04.997207       1 driver.go:95] Enabling controller service capability: CLONE_VOLUME
I0730 20:57:04.997210       1 driver.go:95] Enabling controller service capability: EXPAND_VOLUME
I0730 20:57:04.997213       1 driver.go:108] Enabling volume access mode: SINGLE_NODE_WRITER
I0730 20:57:04.997216       1 driver.go:108] Enabling volume access mode: MULTI_NODE_MULTI_WRITER
I0730 20:57:04.997218       1 driver.go:108] Enabling volume access mode: SINGLE_NODE_SINGLE_WRITER
I0730 20:57:04.997225       1 driver.go:108] Enabling volume access mode: SINGLE_NODE_MULTI_WRITER
I0730 20:57:04.997476       1 server.go:117] Listening for connections on address: &net.UnixAddr{Name:"//csi/csi-provisioner.sock", Net:"unix"}
I0730 20:57:04.997513       1 server.go:114] listening for CSI-Addons requests on address: &net.UnixAddr{Name:"/csi/csi-addons.sock", Net:"unix"}
I0730 20:57:12.741483       1 utils.go:198] ID: 1 GRPC call: /csi.v1.Identity/Probe
I0730 20:57:12.743589       1 utils.go:199] ID: 1 GRPC request: {}
I0730 20:57:12.743662       1 utils.go:205] ID: 1 GRPC response: {}
I0730 20:57:12.745811       1 utils.go:198] ID: 2 GRPC call: /csi.v1.Identity/GetPluginInfo
I0730 20:57:12.745859       1 utils.go:199] ID: 2 GRPC request: {}
I0730 20:57:12.745870       1 identityserver-default.go:40] ID: 2 Using default GetPluginInfo
I0730 20:57:12.745906       1 utils.go:205] ID: 2 GRPC response: {"name":"rbd.csi.ceph.com","vendor_version":"v3.11.0"}
I0730 20:57:12.750136       1 utils.go:198] ID: 3 GRPC call: /csi.v1.Identity/Probe
I0730 20:57:12.750183       1 utils.go:199] ID: 3 GRPC request: {}
I0730 20:57:12.750221       1 utils.go:205] ID: 3 GRPC response: {}
I0730 20:57:12.750761       1 utils.go:198] ID: 4 GRPC call: /csi.v1.Identity/GetPluginCapabilities
I0730 20:57:12.750879       1 utils.go:199] ID: 4 GRPC request: {}
I0730 20:57:12.751108       1 utils.go:205] ID: 4 GRPC response: {"capabilities":[{"Type":{"Service":{"type":1}}},{"Type":{"VolumeExpansion":{"type":1}}},{"Type":{"Service":{"type":2}}}]}
I0730 20:57:12.751955       1 utils.go:198] ID: 5 GRPC call: /csi.v1.Controller/ControllerGetCapabilities
I0730 20:57:12.752043       1 utils.go:199] ID: 5 GRPC request: {}
I0730 20:57:12.752058       1 controllerserver-default.go:42] ID: 5 Using default ControllerGetCapabilities
I0730 20:57:12.752187       1 utils.go:205] ID: 5 GRPC response: {"capabilities":[{"Type":{"Rpc":{"type":1}}},{"Type":{"Rpc":{"type":5}}},{"Type":{"Rpc":{"type":7}}},{"Type":{"Rpc":{"type":9}}}]}
I0730 20:57:14.571624       1 utils.go:198] ID: 6 GRPC call: /csi.v1.Identity/Probe
I0730 20:57:14.571741       1 utils.go:199] ID: 6 GRPC request: {}
I0730 20:57:14.571810       1 utils.go:205] ID: 6 GRPC response: {}
I0730 20:57:14.574352       1 utils.go:198] ID: 7 GRPC call: /csi.v1.Identity/GetPluginInfo
I0730 20:57:14.574433       1 utils.go:199] ID: 7 GRPC request: {}
I0730 20:57:14.574472       1 identityserver-default.go:40] ID: 7 Using default GetPluginInfo
I0730 20:57:14.574506       1 utils.go:205] ID: 7 GRPC response: {"name":"rbd.csi.ceph.com","vendor_version":"v3.11.0"}
I0730 20:57:14.578086       1 utils.go:198] ID: 8 GRPC call: /csi.v1.Identity/Probe
I0730 20:57:14.578163       1 utils.go:199] ID: 8 GRPC request: {}
I0730 20:57:14.578228       1 utils.go:205] ID: 8 GRPC response: {}
I0730 20:57:14.579044       1 utils.go:198] ID: 9 GRPC call: /csi.v1.Identity/GetPluginCapabilities
I0730 20:57:14.579077       1 utils.go:199] ID: 9 GRPC request: {}
I0730 20:57:14.579209       1 utils.go:205] ID: 9 GRPC response: {"capabilities":[{"Type":{"Service":{"type":1}}},{"Type":{"VolumeExpansion":{"type":1}}},{"Type":{"Service":{"type":2}}}]}
I0730 20:57:14.580010       1 utils.go:198] ID: 10 GRPC call: /csi.v1.Controller/ControllerGetCapabilities
I0730 20:57:14.580024       1 utils.go:199] ID: 10 GRPC request: {}
I0730 20:57:14.580032       1 controllerserver-default.go:42] ID: 10 Using default ControllerGetCapabilities
I0730 20:57:14.580098       1 utils.go:205] ID: 10 GRPC response: {"capabilities":[{"Type":{"Rpc":{"type":1}}},{"Type":{"Rpc":{"type":5}}},{"Type":{"Rpc":{"type":7}}},{"Type":{"Rpc":{"type":9}}}]}
I0730 20:57:14.580556       1 utils.go:198] ID: 11 GRPC call: /csi.v1.Controller/ControllerGetCapabilities
I0730 20:57:14.580639       1 utils.go:199] ID: 11 GRPC request: {}
I0730 20:57:14.580689       1 controllerserver-default.go:42] ID: 11 Using default ControllerGetCapabilities
I0730 20:57:14.580831       1 utils.go:205] ID: 11 GRPC response: {"capabilities":[{"Type":{"Rpc":{"type":1}}},{"Type":{"Rpc":{"type":5}}},{"Type":{"Rpc":{"type":7}}},{"Type":{"Rpc":{"type":9}}}]}
I0730 20:57:14.581179       1 utils.go:198] ID: 12 GRPC call: /csi.v1.Controller/ControllerGetCapabilities
I0730 20:57:14.581194       1 utils.go:199] ID: 12 GRPC request: {}
I0730 20:57:14.581198       1 controllerserver-default.go:42] ID: 12 Using default ControllerGetCapabilities
I0730 20:57:14.581262       1 utils.go:205] ID: 12 GRPC response: {"capabilities":[{"Type":{"Rpc":{"type":1}}},{"Type":{"Rpc":{"type":5}}},{"Type":{"Rpc":{"type":7}}},{"Type":{"Rpc":{"type":9}}}]}
I0730 20:57:18.012824       1 utils.go:198] ID: 13 GRPC call: /csi.v1.Identity/GetPluginInfo
I0730 20:57:18.012922       1 utils.go:199] ID: 13 GRPC request: {}
I0730 20:57:18.012940       1 identityserver-default.go:40] ID: 13 Using default GetPluginInfo
I0730 20:57:18.012983       1 utils.go:205] ID: 13 GRPC response: {"name":"rbd.csi.ceph.com","vendor_version":"v3.11.0"}
I0730 20:57:18.014398       1 utils.go:198] ID: 14 GRPC call: /csi.v1.Identity/Probe
I0730 20:57:18.014426       1 utils.go:199] ID: 14 GRPC request: {}
I0730 20:57:18.014444       1 utils.go:205] ID: 14 GRPC response: {}
I0730 20:57:18.014781       1 utils.go:198] ID: 15 GRPC call: /csi.v1.Controller/ControllerGetCapabilities
I0730 20:57:18.014807       1 utils.go:199] ID: 15 GRPC request: {}
I0730 20:57:18.014818       1 controllerserver-default.go:42] ID: 15 Using default ControllerGetCapabilities
I0730 20:57:18.014929       1 utils.go:205] ID: 15 GRPC response: {"capabilities":[{"Type":{"Rpc":{"type":1}}},{"Type":{"Rpc":{"type":5}}},{"Type":{"Rpc":{"type":7}}},{"Type":{"Rpc":{"type":9}}}]}
I0730 20:57:19.475757       1 utils.go:198] ID: 16 GRPC call: /csi.v1.Identity/Probe
I0730 20:57:19.475830       1 utils.go:199] ID: 16 GRPC request: {}
I0730 20:57:19.475889       1 utils.go:205] ID: 16 GRPC response: {}
I0730 20:57:19.480006       1 utils.go:198] ID: 17 GRPC call: /csi.v1.Identity/GetPluginInfo
I0730 20:57:19.480064       1 utils.go:199] ID: 17 GRPC request: {}
I0730 20:57:19.480077       1 identityserver-default.go:40] ID: 17 Using default GetPluginInfo
I0730 20:57:19.480115       1 utils.go:205] ID: 17 GRPC response: {"name":"rbd.csi.ceph.com","vendor_version":"v3.11.0"}
I0730 20:57:19.483919       1 utils.go:198] ID: 18 GRPC call: /csi.v1.Identity/Probe
I0730 20:57:19.483969       1 utils.go:199] ID: 18 GRPC request: {}
I0730 20:57:19.483992       1 utils.go:205] ID: 18 GRPC response: {}
I0730 20:57:19.484511       1 utils.go:198] ID: 19 GRPC call: /csi.v1.Identity/GetPluginCapabilities
I0730 20:57:19.484539       1 utils.go:199] ID: 19 GRPC request: {}
I0730 20:57:19.484682       1 utils.go:205] ID: 19 GRPC response: {"capabilities":[{"Type":{"Service":{"type":1}}},{"Type":{"VolumeExpansion":{"type":1}}},{"Type":{"Service":{"type":2}}}]}
I0730 20:57:19.485649       1 utils.go:198] ID: 20 GRPC call: /csi.v1.Controller/ControllerGetCapabilities
I0730 20:57:19.486033       1 utils.go:199] ID: 20 GRPC request: {}
I0730 20:57:19.486059       1 controllerserver-default.go:42] ID: 20 Using default ControllerGetCapabilities
I0730 20:57:19.486198       1 utils.go:205] ID: 20 GRPC response: {"capabilities":[{"Type":{"Rpc":{"type":1}}},{"Type":{"Rpc":{"type":5}}},{"Type":{"Rpc":{"type":7}}},{"Type":{"Rpc":{"type":9}}}]}
I0730 20:58:03.873149       1 utils.go:198] ID: 21 Req-ID: pvc-9e0d9df6-a554-4993-b8b1-90ac298db048 GRPC call: /csi.v1.Controller/CreateVolume
I0730 20:58:03.875953       1 utils.go:199] ID: 21 Req-ID: pvc-9e0d9df6-a554-4993-b8b1-90ac298db048 GRPC request: {"capacity_range":{"required_bytes":171798691840},"name":"pvc-9e0d9df6-a554-4993-b8b1-90ac298db048","parameters":{"clusterID":"4837cbf8-4f90-4300-b3f6-726c9b9f89b4","csi.storage.k8s.io/pv/name":"pvc-9e0d9df6-a554-4993-b8b1-90ac298db048","csi.storage.k8s.io/pvc/name":"datadir-percona-xtradb-pxc-0","csi.storage.k8s.io/pvc/namespace":"openstack","imageFeatures":"layering","pool":"kube"},"secrets":"***stripped***","volume_capabilities":[{"AccessType":{"Mount":{"fs_type":"ext4","mount_flags":["discard"]}},"access_mode":{"mode":1}}]}
I0730 20:58:03.876252       1 rbd_util.go:1315] ID: 21 Req-ID: pvc-9e0d9df6-a554-4993-b8b1-90ac298db048 setting disableInUseChecks: false image features: [layering] mounter: rbd
E0730 20:58:03.903387       1 omap.go:80] ID: 21 Req-ID: pvc-9e0d9df6-a554-4993-b8b1-90ac298db048 omap not found (pool="kube", namespace="", name="csi.volumes.default"): rados: ret=-2, No such file or directory
I0730 20:58:03.921450       1 omap.go:159] ID: 21 Req-ID: pvc-9e0d9df6-a554-4993-b8b1-90ac298db048 set omap keys (pool="kube", namespace="", name="csi.volumes.default"): map[csi.volume.pvc-9e0d9df6-a554-4993-b8b1-90ac298db048:60dd50c9-7baa-48a2-b91c-fc56f1539563])
I0730 20:58:03.930206       1 omap.go:159] ID: 21 Req-ID: pvc-9e0d9df6-a554-4993-b8b1-90ac298db048 set omap keys (pool="kube", namespace="", name="csi.volume.60dd50c9-7baa-48a2-b91c-fc56f1539563"): map[csi.imagename:csi-vol-60dd50c9-7baa-48a2-b91c-fc56f1539563 csi.volname:pvc-9e0d9df6-a554-4993-b8b1-90ac298db048 csi.volume.owner:openstack])
I0730 20:58:03.930266       1 rbd_journal.go:491] ID: 21 Req-ID: pvc-9e0d9df6-a554-4993-b8b1-90ac298db048 generated Volume ID (0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-60dd50c9-7baa-48a2-b91c-fc56f1539563) and image name (csi-vol-60dd50c9-7baa-48a2-b91c-fc56f1539563) for request name (pvc-9e0d9df6-a554-4993-b8b1-90ac298db048)
I0730 20:58:03.930346       1 rbd_util.go:423] ID: 21 Req-ID: pvc-9e0d9df6-a554-4993-b8b1-90ac298db048 rbd: create kube/csi-vol-60dd50c9-7baa-48a2-b91c-fc56f1539563 size 163840M (features: [layering]) using mon 10.96.240.200
I0730 20:58:03.930413       1 rbd_util.go:1563] ID: 21 Req-ID: pvc-9e0d9df6-a554-4993-b8b1-90ac298db048 setting image options on kube/csi-vol-60dd50c9-7baa-48a2-b91c-fc56f1539563
I0730 20:58:03.967205       1 controllerserver.go:763] ID: 21 Req-ID: pvc-9e0d9df6-a554-4993-b8b1-90ac298db048 created image kube/csi-vol-60dd50c9-7baa-48a2-b91c-fc56f1539563 backed for request name pvc-9e0d9df6-a554-4993-b8b1-90ac298db048
I0730 20:58:03.998333       1 omap.go:159] ID: 21 Req-ID: pvc-9e0d9df6-a554-4993-b8b1-90ac298db048 set omap keys (pool="kube", namespace="", name="csi.volume.60dd50c9-7baa-48a2-b91c-fc56f1539563"): map[csi.imageid:37c6d803e493])
I0730 20:58:04.106817       1 utils.go:205] ID: 21 Req-ID: pvc-9e0d9df6-a554-4993-b8b1-90ac298db048 GRPC response: {"volume":{"capacity_bytes":171798691840,"volume_context":{"clusterID":"4837cbf8-4f90-4300-b3f6-726c9b9f89b4","imageFeatures":"layering","imageName":"csi-vol-60dd50c9-7baa-48a2-b91c-fc56f1539563","journalPool":"kube","pool":"kube"},"volume_id":"0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-60dd50c9-7baa-48a2-b91c-fc56f1539563"}}
I0730 20:58:19.714025       1 utils.go:198] ID: 22 GRPC call: /csi.v1.Identity/Probe
I0730 20:58:19.714086       1 utils.go:199] ID: 22 GRPC request: {}
I0730 20:58:19.714112       1 utils.go:205] ID: 22 GRPC response: {}
I0730 20:59:19.659379       1 utils.go:198] ID: 23 GRPC call: /csi.v1.Identity/Probe
I0730 20:59:19.659441       1 utils.go:199] ID: 23 GRPC request: {}
I0730 20:59:19.659466       1 utils.go:205] ID: 23 GRPC response: {}
I0730 21:00:19.713396       1 utils.go:198] ID: 24 GRPC call: /csi.v1.Identity/Probe
I0730 21:00:19.713454       1 utils.go:199] ID: 24 GRPC request: {}
I0730 21:00:19.713474       1 utils.go:205] ID: 24 GRPC response: {}
I0730 21:01:19.669409       1 utils.go:198] ID: 25 GRPC call: /csi.v1.Identity/Probe
I0730 21:01:19.669531       1 utils.go:199] ID: 25 GRPC request: {}
I0730 21:01:19.669562       1 utils.go:205] ID: 25 GRPC response: {}
I0730 21:02:19.658652       1 utils.go:198] ID: 26 GRPC call: /csi.v1.Identity/Probe
I0730 21:02:19.658720       1 utils.go:199] ID: 26 GRPC request: {}
I0730 21:02:19.658746       1 utils.go:205] ID: 26 GRPC response: {}
I0730 21:03:19.680144       1 utils.go:198] ID: 27 GRPC call: /csi.v1.Identity/Probe
I0730 21:03:19.680211       1 utils.go:199] ID: 27 GRPC request: {}
I0730 21:03:19.680249       1 utils.go:205] ID: 27 GRPC response: {}
I0730 21:04:19.658763       1 utils.go:198] ID: 28 GRPC call: /csi.v1.Identity/Probe
I0730 21:04:19.658835       1 utils.go:199] ID: 28 GRPC request: {}
I0730 21:04:19.658860       1 utils.go:205] ID: 28 GRPC response: {}
I0730 21:05:19.690051       1 utils.go:198] ID: 29 GRPC call: /csi.v1.Identity/Probe
I0730 21:05:19.690133       1 utils.go:199] ID: 29 GRPC request: {}
I0730 21:05:19.690162       1 utils.go:205] ID: 29 GRPC response: {}
I0730 21:06:19.658583       1 utils.go:198] ID: 30 GRPC call: /csi.v1.Identity/Probe
I0730 21:06:19.658652       1 utils.go:199] ID: 30 GRPC request: {}
I0730 21:06:19.658678       1 utils.go:205] ID: 30 GRPC response: {}
I0730 21:07:19.700144       1 utils.go:198] ID: 31 GRPC call: /csi.v1.Identity/Probe
I0730 21:07:19.700301       1 utils.go:199] ID: 31 GRPC request: {}
I0730 21:07:19.700367       1 utils.go:205] ID: 31 GRPC response: {}
I0730 21:08:19.658330       1 utils.go:198] ID: 32 GRPC call: /csi.v1.Identity/Probe
I0730 21:08:19.658386       1 utils.go:199] ID: 32 GRPC request: {}
I0730 21:08:19.658431       1 utils.go:205] ID: 32 GRPC response: {}
I0730 21:08:35.084391       1 utils.go:198] ID: 33 Req-ID: pvc-5ce9e03b-9719-438e-8368-019339982646 GRPC call: /csi.v1.Controller/CreateVolume
I0730 21:08:35.084710       1 utils.go:199] ID: 33 Req-ID: pvc-5ce9e03b-9719-438e-8368-019339982646 GRPC request: {"capacity_range":{"required_bytes":10737418240},"name":"pvc-5ce9e03b-9719-438e-8368-019339982646","parameters":{"clusterID":"4837cbf8-4f90-4300-b3f6-726c9b9f89b4","csi.storage.k8s.io/pv/name":"pvc-5ce9e03b-9719-438e-8368-019339982646","csi.storage.k8s.io/pvc/name":"persistence-rabbitmq-keystone-server-0","csi.storage.k8s.io/pvc/namespace":"openstack","imageFeatures":"layering","pool":"kube"},"secrets":"***stripped***","volume_capabilities":[{"AccessType":{"Mount":{"fs_type":"ext4","mount_flags":["discard"]}},"access_mode":{"mode":1}}]}
I0730 21:08:35.085042       1 rbd_util.go:1315] ID: 33 Req-ID: pvc-5ce9e03b-9719-438e-8368-019339982646 setting disableInUseChecks: false image features: [layering] mounter: rbd
I0730 21:08:35.087655       1 omap.go:89] ID: 33 Req-ID: pvc-5ce9e03b-9719-438e-8368-019339982646 got omap values: (pool="kube", namespace="", name="csi.volumes.default"): map[]
I0730 21:08:35.104458       1 omap.go:159] ID: 33 Req-ID: pvc-5ce9e03b-9719-438e-8368-019339982646 set omap keys (pool="kube", namespace="", name="csi.volumes.default"): map[csi.volume.pvc-5ce9e03b-9719-438e-8368-019339982646:fa7c6e38-d230-45e5-aa09-c70e52dfca51])
I0730 21:08:35.112377       1 omap.go:159] ID: 33 Req-ID: pvc-5ce9e03b-9719-438e-8368-019339982646 set omap keys (pool="kube", namespace="", name="csi.volume.fa7c6e38-d230-45e5-aa09-c70e52dfca51"): map[csi.imagename:csi-vol-fa7c6e38-d230-45e5-aa09-c70e52dfca51 csi.volname:pvc-5ce9e03b-9719-438e-8368-019339982646 csi.volume.owner:openstack])
I0730 21:08:35.112411       1 rbd_journal.go:491] ID: 33 Req-ID: pvc-5ce9e03b-9719-438e-8368-019339982646 generated Volume ID (0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-fa7c6e38-d230-45e5-aa09-c70e52dfca51) and image name (csi-vol-fa7c6e38-d230-45e5-aa09-c70e52dfca51) for request name (pvc-5ce9e03b-9719-438e-8368-019339982646)
I0730 21:08:35.112526       1 rbd_util.go:423] ID: 33 Req-ID: pvc-5ce9e03b-9719-438e-8368-019339982646 rbd: create kube/csi-vol-fa7c6e38-d230-45e5-aa09-c70e52dfca51 size 10240M (features: [layering]) using mon 10.96.240.200
I0730 21:08:35.112567       1 rbd_util.go:1563] ID: 33 Req-ID: pvc-5ce9e03b-9719-438e-8368-019339982646 setting image options on kube/csi-vol-fa7c6e38-d230-45e5-aa09-c70e52dfca51
I0730 21:08:35.143363       1 controllerserver.go:763] ID: 33 Req-ID: pvc-5ce9e03b-9719-438e-8368-019339982646 created image kube/csi-vol-fa7c6e38-d230-45e5-aa09-c70e52dfca51 backed for request name pvc-5ce9e03b-9719-438e-8368-019339982646
I0730 21:08:35.172168       1 omap.go:159] ID: 33 Req-ID: pvc-5ce9e03b-9719-438e-8368-019339982646 set omap keys (pool="kube", namespace="", name="csi.volume.fa7c6e38-d230-45e5-aa09-c70e52dfca51"): map[csi.imageid:37c6239fce9d])
I0730 21:08:35.270306       1 utils.go:205] ID: 33 Req-ID: pvc-5ce9e03b-9719-438e-8368-019339982646 GRPC response: {"volume":{"capacity_bytes":10737418240,"volume_context":{"clusterID":"4837cbf8-4f90-4300-b3f6-726c9b9f89b4","imageFeatures":"layering","imageName":"csi-vol-fa7c6e38-d230-45e5-aa09-c70e52dfca51","journalPool":"kube","pool":"kube"},"volume_id":"0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-fa7c6e38-d230-45e5-aa09-c70e52dfca51"}}
I0730 21:09:19.706017       1 utils.go:198] ID: 34 GRPC call: /csi.v1.Identity/Probe
I0730 21:09:19.706093       1 utils.go:199] ID: 34 GRPC request: {}
I0730 21:09:19.706283       1 utils.go:205] ID: 34 GRPC response: {}
I0730 21:10:19.660843       1 utils.go:198] ID: 35 GRPC call: /csi.v1.Identity/Probe
I0730 21:10:19.660932       1 utils.go:199] ID: 35 GRPC request: {}
I0730 21:10:19.660954       1 utils.go:205] ID: 35 GRPC response: {}
I0730 21:11:19.658284       1 utils.go:198] ID: 36 GRPC call: /csi.v1.Identity/Probe
I0730 21:11:19.658332       1 utils.go:199] ID: 36 GRPC request: {}
I0730 21:11:19.658348       1 utils.go:205] ID: 36 GRPC response: {}
I0730 21:12:19.672888       1 utils.go:198] ID: 37 GRPC call: /csi.v1.Identity/Probe
I0730 21:12:19.672953       1 utils.go:199] ID: 37 GRPC request: {}
I0730 21:12:19.672975       1 utils.go:205] ID: 37 GRPC response: {}
I0730 21:12:41.585178       1 utils.go:198] ID: 38 Req-ID: pvc-0d6d959a-bfdf-499a-9958-020005eec9b2 GRPC call: /csi.v1.Controller/CreateVolume
I0730 21:12:41.585433       1 utils.go:199] ID: 38 Req-ID: pvc-0d6d959a-bfdf-499a-9958-020005eec9b2 GRPC request: {"capacity_range":{"required_bytes":10737418240},"name":"pvc-0d6d959a-bfdf-499a-9958-020005eec9b2","parameters":{"clusterID":"4837cbf8-4f90-4300-b3f6-726c9b9f89b4","csi.storage.k8s.io/pv/name":"pvc-0d6d959a-bfdf-499a-9958-020005eec9b2","csi.storage.k8s.io/pvc/name":"persistence-rabbitmq-glance-server-0","csi.storage.k8s.io/pvc/namespace":"openstack","imageFeatures":"layering","pool":"kube"},"secrets":"***stripped***","volume_capabilities":[{"AccessType":{"Mount":{"fs_type":"ext4","mount_flags":["discard"]}},"access_mode":{"mode":1}}]}
I0730 21:12:41.585674       1 rbd_util.go:1315] ID: 38 Req-ID: pvc-0d6d959a-bfdf-499a-9958-020005eec9b2 setting disableInUseChecks: false image features: [layering] mounter: rbd
I0730 21:12:41.587700       1 omap.go:89] ID: 38 Req-ID: pvc-0d6d959a-bfdf-499a-9958-020005eec9b2 got omap values: (pool="kube", namespace="", name="csi.volumes.default"): map[]
I0730 21:12:41.601493       1 omap.go:159] ID: 38 Req-ID: pvc-0d6d959a-bfdf-499a-9958-020005eec9b2 set omap keys (pool="kube", namespace="", name="csi.volumes.default"): map[csi.volume.pvc-0d6d959a-bfdf-499a-9958-020005eec9b2:92292b5a-88a0-42b4-80aa-3e1be19ddade])
I0730 21:12:41.608996       1 omap.go:159] ID: 38 Req-ID: pvc-0d6d959a-bfdf-499a-9958-020005eec9b2 set omap keys (pool="kube", namespace="", name="csi.volume.92292b5a-88a0-42b4-80aa-3e1be19ddade"): map[csi.imagename:csi-vol-92292b5a-88a0-42b4-80aa-3e1be19ddade csi.volname:pvc-0d6d959a-bfdf-499a-9958-020005eec9b2 csi.volume.owner:openstack])
I0730 21:12:41.609042       1 rbd_journal.go:491] ID: 38 Req-ID: pvc-0d6d959a-bfdf-499a-9958-020005eec9b2 generated Volume ID (0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-92292b5a-88a0-42b4-80aa-3e1be19ddade) and image name (csi-vol-92292b5a-88a0-42b4-80aa-3e1be19ddade) for request name (pvc-0d6d959a-bfdf-499a-9958-020005eec9b2)
I0730 21:12:41.609163       1 rbd_util.go:423] ID: 38 Req-ID: pvc-0d6d959a-bfdf-499a-9958-020005eec9b2 rbd: create kube/csi-vol-92292b5a-88a0-42b4-80aa-3e1be19ddade size 10240M (features: [layering]) using mon 10.96.240.200
I0730 21:12:41.609221       1 rbd_util.go:1563] ID: 38 Req-ID: pvc-0d6d959a-bfdf-499a-9958-020005eec9b2 setting image options on kube/csi-vol-92292b5a-88a0-42b4-80aa-3e1be19ddade
I0730 21:12:41.642336       1 controllerserver.go:763] ID: 38 Req-ID: pvc-0d6d959a-bfdf-499a-9958-020005eec9b2 created image kube/csi-vol-92292b5a-88a0-42b4-80aa-3e1be19ddade backed for request name pvc-0d6d959a-bfdf-499a-9958-020005eec9b2
I0730 21:12:41.674595       1 omap.go:159] ID: 38 Req-ID: pvc-0d6d959a-bfdf-499a-9958-020005eec9b2 set omap keys (pool="kube", namespace="", name="csi.volume.92292b5a-88a0-42b4-80aa-3e1be19ddade"): map[csi.imageid:37c6caf4ae5a])
I0730 21:12:41.774088       1 utils.go:205] ID: 38 Req-ID: pvc-0d6d959a-bfdf-499a-9958-020005eec9b2 GRPC response: {"volume":{"capacity_bytes":10737418240,"volume_context":{"clusterID":"4837cbf8-4f90-4300-b3f6-726c9b9f89b4","imageFeatures":"layering","imageName":"csi-vol-92292b5a-88a0-42b4-80aa-3e1be19ddade","journalPool":"kube","pool":"kube"},"volume_id":"0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-92292b5a-88a0-42b4-80aa-3e1be19ddade"}}
I0730 21:13:19.658388       1 utils.go:198] ID: 39 GRPC call: /csi.v1.Identity/Probe
I0730 21:13:19.658451       1 utils.go:199] ID: 39 GRPC request: {}
I0730 21:13:19.658474       1 utils.go:205] ID: 39 GRPC response: {}
I0730 21:14:19.667152       1 utils.go:198] ID: 40 GRPC call: /csi.v1.Identity/Probe
I0730 21:14:19.667226       1 utils.go:199] ID: 40 GRPC request: {}
I0730 21:14:19.667253       1 utils.go:205] ID: 40 GRPC response: {}
I0730 21:15:19.661691       1 utils.go:198] ID: 41 GRPC call: /csi.v1.Identity/Probe
I0730 21:15:19.661746       1 utils.go:199] ID: 41 GRPC request: {}
I0730 21:15:19.661766       1 utils.go:205] ID: 41 GRPC response: {}
I0730 21:16:19.715190       1 utils.go:198] ID: 42 GRPC call: /csi.v1.Identity/Probe
I0730 21:16:19.715268       1 utils.go:199] ID: 42 GRPC request: {}
I0730 21:16:19.715295       1 utils.go:205] ID: 42 GRPC response: {}
I0730 21:17:19.669541       1 utils.go:198] ID: 43 GRPC call: /csi.v1.Identity/Probe
I0730 21:17:19.669595       1 utils.go:199] ID: 43 GRPC request: {}
I0730 21:17:19.669616       1 utils.go:205] ID: 43 GRPC response: {}
I0730 21:18:19.658323       1 utils.go:198] ID: 44 GRPC call: /csi.v1.Identity/Probe
I0730 21:18:19.658374       1 utils.go:199] ID: 44 GRPC request: {}
I0730 21:18:19.658398       1 utils.go:205] ID: 44 GRPC response: {}
I0730 21:19:19.680624       1 utils.go:198] ID: 45 GRPC call: /csi.v1.Identity/Probe
I0730 21:19:19.680684       1 utils.go:199] ID: 45 GRPC request: {}
I0730 21:19:19.680706       1 utils.go:205] ID: 45 GRPC response: {}
I0730 21:19:55.360104       1 utils.go:198] ID: 46 Req-ID: pvc-1b18140a-6773-4b4f-8a2f-a8a4a9817e0e GRPC call: /csi.v1.Controller/CreateVolume
I0730 21:19:55.360309       1 utils.go:199] ID: 46 Req-ID: pvc-1b18140a-6773-4b4f-8a2f-a8a4a9817e0e GRPC request: {"capacity_range":{"required_bytes":21474836480},"name":"pvc-1b18140a-6773-4b4f-8a2f-a8a4a9817e0e","parameters":{"clusterID":"4837cbf8-4f90-4300-b3f6-726c9b9f89b4","csi.storage.k8s.io/pv/name":"pvc-1b18140a-6773-4b4f-8a2f-a8a4a9817e0e","csi.storage.k8s.io/pvc/name":"data-ovn-ovsdb-nb-0","csi.storage.k8s.io/pvc/namespace":"openstack","imageFeatures":"layering","pool":"kube"},"secrets":"***stripped***","volume_capabilities":[{"AccessType":{"Mount":{"fs_type":"ext4","mount_flags":["discard"]}},"access_mode":{"mode":1}}]}
I0730 21:19:55.360462       1 rbd_util.go:1315] ID: 46 Req-ID: pvc-1b18140a-6773-4b4f-8a2f-a8a4a9817e0e setting disableInUseChecks: false image features: [layering] mounter: rbd
I0730 21:19:55.362314       1 omap.go:89] ID: 46 Req-ID: pvc-1b18140a-6773-4b4f-8a2f-a8a4a9817e0e got omap values: (pool="kube", namespace="", name="csi.volumes.default"): map[]
I0730 21:19:55.374739       1 utils.go:198] ID: 47 Req-ID: pvc-7038bb8b-fd04-43c9-a79d-43e9bdb5703c GRPC call: /csi.v1.Controller/CreateVolume
I0730 21:19:55.375085       1 utils.go:199] ID: 47 Req-ID: pvc-7038bb8b-fd04-43c9-a79d-43e9bdb5703c GRPC request: {"capacity_range":{"required_bytes":21474836480},"name":"pvc-7038bb8b-fd04-43c9-a79d-43e9bdb5703c","parameters":{"clusterID":"4837cbf8-4f90-4300-b3f6-726c9b9f89b4","csi.storage.k8s.io/pv/name":"pvc-7038bb8b-fd04-43c9-a79d-43e9bdb5703c","csi.storage.k8s.io/pvc/name":"data-ovn-ovsdb-sb-0","csi.storage.k8s.io/pvc/namespace":"openstack","imageFeatures":"layering","pool":"kube"},"secrets":"***stripped***","volume_capabilities":[{"AccessType":{"Mount":{"fs_type":"ext4","mount_flags":["discard"]}},"access_mode":{"mode":1}}]}
I0730 21:19:55.375279       1 rbd_util.go:1315] ID: 47 Req-ID: pvc-7038bb8b-fd04-43c9-a79d-43e9bdb5703c setting disableInUseChecks: false image features: [layering] mounter: rbd
I0730 21:19:55.382245       1 omap.go:159] ID: 46 Req-ID: pvc-1b18140a-6773-4b4f-8a2f-a8a4a9817e0e set omap keys (pool="kube", namespace="", name="csi.volumes.default"): map[csi.volume.pvc-1b18140a-6773-4b4f-8a2f-a8a4a9817e0e:7c74726e-2f40-49a2-9167-52811597f07a])
I0730 21:19:55.382489       1 omap.go:89] ID: 47 Req-ID: pvc-7038bb8b-fd04-43c9-a79d-43e9bdb5703c got omap values: (pool="kube", namespace="", name="csi.volumes.default"): map[]
I0730 21:19:55.393959       1 omap.go:159] ID: 46 Req-ID: pvc-1b18140a-6773-4b4f-8a2f-a8a4a9817e0e set omap keys (pool="kube", namespace="", name="csi.volume.7c74726e-2f40-49a2-9167-52811597f07a"): map[csi.imagename:csi-vol-7c74726e-2f40-49a2-9167-52811597f07a csi.volname:pvc-1b18140a-6773-4b4f-8a2f-a8a4a9817e0e csi.volume.owner:openstack])
I0730 21:19:55.393997       1 rbd_journal.go:491] ID: 46 Req-ID: pvc-1b18140a-6773-4b4f-8a2f-a8a4a9817e0e generated Volume ID (0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-7c74726e-2f40-49a2-9167-52811597f07a) and image name (csi-vol-7c74726e-2f40-49a2-9167-52811597f07a) for request name (pvc-1b18140a-6773-4b4f-8a2f-a8a4a9817e0e)
I0730 21:19:55.394207       1 rbd_util.go:423] ID: 46 Req-ID: pvc-1b18140a-6773-4b4f-8a2f-a8a4a9817e0e rbd: create kube/csi-vol-7c74726e-2f40-49a2-9167-52811597f07a size 20480M (features: [layering]) using mon 10.96.240.200
I0730 21:19:55.394235       1 rbd_util.go:1563] ID: 46 Req-ID: pvc-1b18140a-6773-4b4f-8a2f-a8a4a9817e0e setting image options on kube/csi-vol-7c74726e-2f40-49a2-9167-52811597f07a
I0730 21:19:55.400645       1 omap.go:159] ID: 47 Req-ID: pvc-7038bb8b-fd04-43c9-a79d-43e9bdb5703c set omap keys (pool="kube", namespace="", name="csi.volumes.default"): map[csi.volume.pvc-7038bb8b-fd04-43c9-a79d-43e9bdb5703c:52ebf765-52ff-417b-87c2-25df1d68aa3d])
I0730 21:19:55.410914       1 omap.go:159] ID: 47 Req-ID: pvc-7038bb8b-fd04-43c9-a79d-43e9bdb5703c set omap keys (pool="kube", namespace="", name="csi.volume.52ebf765-52ff-417b-87c2-25df1d68aa3d"): map[csi.imagename:csi-vol-52ebf765-52ff-417b-87c2-25df1d68aa3d csi.volname:pvc-7038bb8b-fd04-43c9-a79d-43e9bdb5703c csi.volume.owner:openstack])
I0730 21:19:55.410948       1 rbd_journal.go:491] ID: 47 Req-ID: pvc-7038bb8b-fd04-43c9-a79d-43e9bdb5703c generated Volume ID (0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-52ebf765-52ff-417b-87c2-25df1d68aa3d) and image name (csi-vol-52ebf765-52ff-417b-87c2-25df1d68aa3d) for request name (pvc-7038bb8b-fd04-43c9-a79d-43e9bdb5703c)
I0730 21:19:55.411236       1 rbd_util.go:423] ID: 47 Req-ID: pvc-7038bb8b-fd04-43c9-a79d-43e9bdb5703c rbd: create kube/csi-vol-52ebf765-52ff-417b-87c2-25df1d68aa3d size 20480M (features: [layering]) using mon 10.96.240.200
I0730 21:19:55.411312       1 rbd_util.go:1563] ID: 47 Req-ID: pvc-7038bb8b-fd04-43c9-a79d-43e9bdb5703c setting image options on kube/csi-vol-52ebf765-52ff-417b-87c2-25df1d68aa3d
I0730 21:19:55.423957       1 controllerserver.go:763] ID: 46 Req-ID: pvc-1b18140a-6773-4b4f-8a2f-a8a4a9817e0e created image kube/csi-vol-7c74726e-2f40-49a2-9167-52811597f07a backed for request name pvc-1b18140a-6773-4b4f-8a2f-a8a4a9817e0e
I0730 21:19:55.446636       1 controllerserver.go:763] ID: 47 Req-ID: pvc-7038bb8b-fd04-43c9-a79d-43e9bdb5703c created image kube/csi-vol-52ebf765-52ff-417b-87c2-25df1d68aa3d backed for request name pvc-7038bb8b-fd04-43c9-a79d-43e9bdb5703c
I0730 21:19:55.462535       1 omap.go:159] ID: 46 Req-ID: pvc-1b18140a-6773-4b4f-8a2f-a8a4a9817e0e set omap keys (pool="kube", namespace="", name="csi.volume.7c74726e-2f40-49a2-9167-52811597f07a"): map[csi.imageid:37c6222bc818])
I0730 21:19:55.482889       1 omap.go:159] ID: 47 Req-ID: pvc-7038bb8b-fd04-43c9-a79d-43e9bdb5703c set omap keys (pool="kube", namespace="", name="csi.volume.52ebf765-52ff-417b-87c2-25df1d68aa3d"): map[csi.imageid:37c636f08d47])
I0730 21:19:55.569852       1 utils.go:205] ID: 46 Req-ID: pvc-1b18140a-6773-4b4f-8a2f-a8a4a9817e0e GRPC response: {"volume":{"capacity_bytes":21474836480,"volume_context":{"clusterID":"4837cbf8-4f90-4300-b3f6-726c9b9f89b4","imageFeatures":"layering","imageName":"csi-vol-7c74726e-2f40-49a2-9167-52811597f07a","journalPool":"kube","pool":"kube"},"volume_id":"0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-7c74726e-2f40-49a2-9167-52811597f07a"}}
I0730 21:19:55.605072       1 utils.go:205] ID: 47 Req-ID: pvc-7038bb8b-fd04-43c9-a79d-43e9bdb5703c GRPC response: {"volume":{"capacity_bytes":21474836480,"volume_context":{"clusterID":"4837cbf8-4f90-4300-b3f6-726c9b9f89b4","imageFeatures":"layering","imageName":"csi-vol-52ebf765-52ff-417b-87c2-25df1d68aa3d","journalPool":"kube","pool":"kube"},"volume_id":"0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-52ebf765-52ff-417b-87c2-25df1d68aa3d"}}
I0730 21:20:06.611882       1 utils.go:198] ID: 48 Req-ID: pvc-2d2030bd-4c5b-47b7-b806-e49d5ffdf18a GRPC call: /csi.v1.Controller/CreateVolume
I0730 21:20:06.612098       1 utils.go:199] ID: 48 Req-ID: pvc-2d2030bd-4c5b-47b7-b806-e49d5ffdf18a GRPC request: {"capacity_range":{"required_bytes":10737418240},"name":"pvc-2d2030bd-4c5b-47b7-b806-e49d5ffdf18a","parameters":{"clusterID":"4837cbf8-4f90-4300-b3f6-726c9b9f89b4","csi.storage.k8s.io/pv/name":"pvc-2d2030bd-4c5b-47b7-b806-e49d5ffdf18a","csi.storage.k8s.io/pvc/name":"persistence-rabbitmq-nova-server-0","csi.storage.k8s.io/pvc/namespace":"openstack","imageFeatures":"layering","pool":"kube"},"secrets":"***stripped***","volume_capabilities":[{"AccessType":{"Mount":{"fs_type":"ext4","mount_flags":["discard"]}},"access_mode":{"mode":1}}]}
I0730 21:20:06.612291       1 rbd_util.go:1315] ID: 48 Req-ID: pvc-2d2030bd-4c5b-47b7-b806-e49d5ffdf18a setting disableInUseChecks: false image features: [layering] mounter: rbd
I0730 21:20:06.614215       1 omap.go:89] ID: 48 Req-ID: pvc-2d2030bd-4c5b-47b7-b806-e49d5ffdf18a got omap values: (pool="kube", namespace="", name="csi.volumes.default"): map[]
I0730 21:20:06.631391       1 omap.go:159] ID: 48 Req-ID: pvc-2d2030bd-4c5b-47b7-b806-e49d5ffdf18a set omap keys (pool="kube", namespace="", name="csi.volumes.default"): map[csi.volume.pvc-2d2030bd-4c5b-47b7-b806-e49d5ffdf18a:35acea77-5f72-418e-8cf4-95a1f6b7a5a2])
I0730 21:20:06.638474       1 omap.go:159] ID: 48 Req-ID: pvc-2d2030bd-4c5b-47b7-b806-e49d5ffdf18a set omap keys (pool="kube", namespace="", name="csi.volume.35acea77-5f72-418e-8cf4-95a1f6b7a5a2"): map[csi.imagename:csi-vol-35acea77-5f72-418e-8cf4-95a1f6b7a5a2 csi.volname:pvc-2d2030bd-4c5b-47b7-b806-e49d5ffdf18a csi.volume.owner:openstack])
I0730 21:20:06.638523       1 rbd_journal.go:491] ID: 48 Req-ID: pvc-2d2030bd-4c5b-47b7-b806-e49d5ffdf18a generated Volume ID (0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-35acea77-5f72-418e-8cf4-95a1f6b7a5a2) and image name (csi-vol-35acea77-5f72-418e-8cf4-95a1f6b7a5a2) for request name (pvc-2d2030bd-4c5b-47b7-b806-e49d5ffdf18a)
I0730 21:20:06.638613       1 rbd_util.go:423] ID: 48 Req-ID: pvc-2d2030bd-4c5b-47b7-b806-e49d5ffdf18a rbd: create kube/csi-vol-35acea77-5f72-418e-8cf4-95a1f6b7a5a2 size 10240M (features: [layering]) using mon 10.96.240.200
I0730 21:20:06.638645       1 rbd_util.go:1563] ID: 48 Req-ID: pvc-2d2030bd-4c5b-47b7-b806-e49d5ffdf18a setting image options on kube/csi-vol-35acea77-5f72-418e-8cf4-95a1f6b7a5a2
I0730 21:20:06.668601       1 controllerserver.go:763] ID: 48 Req-ID: pvc-2d2030bd-4c5b-47b7-b806-e49d5ffdf18a created image kube/csi-vol-35acea77-5f72-418e-8cf4-95a1f6b7a5a2 backed for request name pvc-2d2030bd-4c5b-47b7-b806-e49d5ffdf18a
I0730 21:20:06.703814       1 omap.go:159] ID: 48 Req-ID: pvc-2d2030bd-4c5b-47b7-b806-e49d5ffdf18a set omap keys (pool="kube", namespace="", name="csi.volume.35acea77-5f72-418e-8cf4-95a1f6b7a5a2"): map[csi.imageid:37c6419d1eb1])
I0730 21:20:06.796631       1 utils.go:205] ID: 48 Req-ID: pvc-2d2030bd-4c5b-47b7-b806-e49d5ffdf18a GRPC response: {"volume":{"capacity_bytes":10737418240,"volume_context":{"clusterID":"4837cbf8-4f90-4300-b3f6-726c9b9f89b4","imageFeatures":"layering","imageName":"csi-vol-35acea77-5f72-418e-8cf4-95a1f6b7a5a2","journalPool":"kube","pool":"kube"},"volume_id":"0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-35acea77-5f72-418e-8cf4-95a1f6b7a5a2"}}
I0730 21:20:19.658384       1 utils.go:198] ID: 49 GRPC call: /csi.v1.Identity/Probe
I0730 21:20:19.658437       1 utils.go:199] ID: 49 GRPC request: {}
I0730 21:20:19.658459       1 utils.go:205] ID: 49 GRPC response: {}
I0730 21:21:19.689381       1 utils.go:198] ID: 50 GRPC call: /csi.v1.Identity/Probe
I0730 21:21:19.689457       1 utils.go:199] ID: 50 GRPC request: {}
I0730 21:21:19.689486       1 utils.go:205] ID: 50 GRPC response: {}
I0730 21:22:19.658378       1 utils.go:198] ID: 51 GRPC call: /csi.v1.Identity/Probe
I0730 21:22:19.658433       1 utils.go:199] ID: 51 GRPC request: {}
I0730 21:22:19.658455       1 utils.go:205] ID: 51 GRPC response: {}
I0730 21:23:19.699233       1 utils.go:198] ID: 52 GRPC call: /csi.v1.Identity/Probe
I0730 21:23:19.699280       1 utils.go:199] ID: 52 GRPC request: {}
I0730 21:23:19.699300       1 utils.go:205] ID: 52 GRPC response: {}
I0730 21:24:19.713616       1 utils.go:198] ID: 53 GRPC call: /csi.v1.Identity/Probe
I0730 21:24:19.713703       1 utils.go:199] ID: 53 GRPC request: {}
I0730 21:24:19.713805       1 utils.go:205] ID: 53 GRPC response: {}
I0730 21:25:19.709580       1 utils.go:198] ID: 54 GRPC call: /csi.v1.Identity/Probe
I0730 21:25:19.709685       1 utils.go:199] ID: 54 GRPC request: {}
I0730 21:25:19.709708       1 utils.go:205] ID: 54 GRPC response: {}
I0730 21:26:19.658396       1 utils.go:198] ID: 55 GRPC call: /csi.v1.Identity/Probe
I0730 21:26:19.658450       1 utils.go:199] ID: 55 GRPC request: {}
I0730 21:26:19.658471       1 utils.go:205] ID: 55 GRPC response: {}
I0730 21:26:50.960412       1 utils.go:198] ID: 56 Req-ID: pvc-d491dfdb-84e4-453d-8226-9739a1e895a8 GRPC call: /csi.v1.Controller/CreateVolume
I0730 21:26:50.960902       1 utils.go:199] ID: 56 Req-ID: pvc-d491dfdb-84e4-453d-8226-9739a1e895a8 GRPC request: {"capacity_range":{"required_bytes":10737418240},"name":"pvc-d491dfdb-84e4-453d-8226-9739a1e895a8","parameters":{"clusterID":"4837cbf8-4f90-4300-b3f6-726c9b9f89b4","csi.storage.k8s.io/pv/name":"pvc-d491dfdb-84e4-453d-8226-9739a1e895a8","csi.storage.k8s.io/pvc/name":"persistence-rabbitmq-neutron-server-0","csi.storage.k8s.io/pvc/namespace":"openstack","imageFeatures":"layering","pool":"kube"},"secrets":"***stripped***","volume_capabilities":[{"AccessType":{"Mount":{"fs_type":"ext4","mount_flags":["discard"]}},"access_mode":{"mode":1}}]}
I0730 21:26:50.961270       1 rbd_util.go:1315] ID: 56 Req-ID: pvc-d491dfdb-84e4-453d-8226-9739a1e895a8 setting disableInUseChecks: false image features: [layering] mounter: rbd
I0730 21:26:50.962985       1 omap.go:89] ID: 56 Req-ID: pvc-d491dfdb-84e4-453d-8226-9739a1e895a8 got omap values: (pool="kube", namespace="", name="csi.volumes.default"): map[]
I0730 21:26:50.976235       1 omap.go:159] ID: 56 Req-ID: pvc-d491dfdb-84e4-453d-8226-9739a1e895a8 set omap keys (pool="kube", namespace="", name="csi.volumes.default"): map[csi.volume.pvc-d491dfdb-84e4-453d-8226-9739a1e895a8:2ca761cc-e2f4-46a2-9dbd-901f3e93c665])
I0730 21:26:50.983901       1 omap.go:159] ID: 56 Req-ID: pvc-d491dfdb-84e4-453d-8226-9739a1e895a8 set omap keys (pool="kube", namespace="", name="csi.volume.2ca761cc-e2f4-46a2-9dbd-901f3e93c665"): map[csi.imagename:csi-vol-2ca761cc-e2f4-46a2-9dbd-901f3e93c665 csi.volname:pvc-d491dfdb-84e4-453d-8226-9739a1e895a8 csi.volume.owner:openstack])
I0730 21:26:50.983934       1 rbd_journal.go:491] ID: 56 Req-ID: pvc-d491dfdb-84e4-453d-8226-9739a1e895a8 generated Volume ID (0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-2ca761cc-e2f4-46a2-9dbd-901f3e93c665) and image name (csi-vol-2ca761cc-e2f4-46a2-9dbd-901f3e93c665) for request name (pvc-d491dfdb-84e4-453d-8226-9739a1e895a8)
I0730 21:26:50.983999       1 rbd_util.go:423] ID: 56 Req-ID: pvc-d491dfdb-84e4-453d-8226-9739a1e895a8 rbd: create kube/csi-vol-2ca761cc-e2f4-46a2-9dbd-901f3e93c665 size 10240M (features: [layering]) using mon 10.96.240.200
I0730 21:26:50.984029       1 rbd_util.go:1563] ID: 56 Req-ID: pvc-d491dfdb-84e4-453d-8226-9739a1e895a8 setting image options on kube/csi-vol-2ca761cc-e2f4-46a2-9dbd-901f3e93c665
I0730 21:26:51.022285       1 controllerserver.go:763] ID: 56 Req-ID: pvc-d491dfdb-84e4-453d-8226-9739a1e895a8 created image kube/csi-vol-2ca761cc-e2f4-46a2-9dbd-901f3e93c665 backed for request name pvc-d491dfdb-84e4-453d-8226-9739a1e895a8
I0730 21:26:51.056934       1 omap.go:159] ID: 56 Req-ID: pvc-d491dfdb-84e4-453d-8226-9739a1e895a8 set omap keys (pool="kube", namespace="", name="csi.volume.2ca761cc-e2f4-46a2-9dbd-901f3e93c665"): map[csi.imageid:37c63857bd58])
I0730 21:26:51.209498       1 utils.go:205] ID: 56 Req-ID: pvc-d491dfdb-84e4-453d-8226-9739a1e895a8 GRPC response: {"volume":{"capacity_bytes":10737418240,"volume_context":{"clusterID":"4837cbf8-4f90-4300-b3f6-726c9b9f89b4","imageFeatures":"layering","imageName":"csi-vol-2ca761cc-e2f4-46a2-9dbd-901f3e93c665","journalPool":"kube","pool":"kube"},"volume_id":"0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-2ca761cc-e2f4-46a2-9dbd-901f3e93c665"}}
I0730 21:27:19.718105       1 utils.go:198] ID: 57 GRPC call: /csi.v1.Identity/Probe
I0730 21:27:19.718251       1 utils.go:199] ID: 57 GRPC request: {}
I0730 21:27:19.718418       1 utils.go:205] ID: 57 GRPC response: {}
I0730 21:28:19.713403       1 utils.go:198] ID: 58 GRPC call: /csi.v1.Identity/Probe
I0730 21:28:19.713453       1 utils.go:199] ID: 58 GRPC request: {}
I0730 21:28:19.713488       1 utils.go:205] ID: 58 GRPC response: {}
I0730 21:29:19.713368       1 utils.go:198] ID: 59 GRPC call: /csi.v1.Identity/Probe
I0730 21:29:19.713424       1 utils.go:199] ID: 59 GRPC request: {}
I0730 21:29:19.713445       1 utils.go:205] ID: 59 GRPC response: {}
I0730 21:30:19.658441       1 utils.go:198] ID: 60 GRPC call: /csi.v1.Identity/Probe
I0730 21:30:19.658494       1 utils.go:199] ID: 60 GRPC request: {}
I0730 21:30:19.658515       1 utils.go:205] ID: 60 GRPC response: {}
I0730 21:31:19.717527       1 utils.go:198] ID: 61 GRPC call: /csi.v1.Identity/Probe
I0730 21:31:19.717628       1 utils.go:199] ID: 61 GRPC request: {}
I0730 21:31:19.717654       1 utils.go:205] ID: 61 GRPC response: {}
I0730 21:32:19.659744       1 utils.go:198] ID: 62 GRPC call: /csi.v1.Identity/Probe
I0730 21:32:19.659810       1 utils.go:199] ID: 62 GRPC request: {}
I0730 21:32:19.659837       1 utils.go:205] ID: 62 GRPC response: {}
I0730 21:33:19.713445       1 utils.go:198] ID: 63 GRPC call: /csi.v1.Identity/Probe
I0730 21:33:19.713499       1 utils.go:199] ID: 63 GRPC request: {}
I0730 21:33:19.713521       1 utils.go:205] ID: 63 GRPC response: {}
I0730 21:34:19.678100       1 utils.go:198] ID: 64 GRPC call: /csi.v1.Identity/Probe
I0730 21:34:19.678331       1 utils.go:199] ID: 64 GRPC request: {}
I0730 21:34:19.678348       1 utils.go:205] ID: 64 GRPC response: {}
I0730 21:35:19.717369       1 utils.go:198] ID: 65 GRPC call: /csi.v1.Identity/Probe
I0730 21:35:19.717403       1 utils.go:199] ID: 65 GRPC request: {}
I0730 21:35:19.717418       1 utils.go:205] ID: 65 GRPC response: {}
I0730 21:36:19.680692       1 utils.go:198] ID: 66 GRPC call: /csi.v1.Identity/Probe
I0730 21:36:19.680779       1 utils.go:199] ID: 66 GRPC request: {}
I0730 21:36:19.680806       1 utils.go:205] ID: 66 GRPC response: {}
I0730 21:37:19.715146       1 utils.go:198] ID: 67 GRPC call: /csi.v1.Identity/Probe
I0730 21:37:19.715184       1 utils.go:199] ID: 67 GRPC request: {}
I0730 21:37:19.715196       1 utils.go:205] ID: 67 GRPC response: {}
I0730 21:38:19.666984       1 utils.go:198] ID: 68 GRPC call: /csi.v1.Identity/Probe
I0730 21:38:19.667058       1 utils.go:199] ID: 68 GRPC request: {}
I0730 21:38:19.667090       1 utils.go:205] ID: 68 GRPC response: {}
I0730 21:39:19.659556       1 utils.go:198] ID: 69 GRPC call: /csi.v1.Identity/Probe
I0730 21:39:19.659614       1 utils.go:199] ID: 69 GRPC request: {}
I0730 21:39:19.659635       1 utils.go:205] ID: 69 GRPC response: {}
I0730 21:40:19.658318       1 utils.go:198] ID: 70 GRPC call: /csi.v1.Identity/Probe
I0730 21:40:19.658374       1 utils.go:199] ID: 70 GRPC request: {}
I0730 21:40:19.658397       1 utils.go:205] ID: 70 GRPC response: {}
I0730 21:41:19.671979       1 utils.go:198] ID: 71 GRPC call: /csi.v1.Identity/Probe
I0730 21:41:19.672031       1 utils.go:199] ID: 71 GRPC request: {}
I0730 21:41:19.672052       1 utils.go:205] ID: 71 GRPC response: {}
I0730 21:42:19.713329       1 utils.go:198] ID: 72 GRPC call: /csi.v1.Identity/Probe
I0730 21:42:19.713381       1 utils.go:199] ID: 72 GRPC request: {}
I0730 21:42:19.713401       1 utils.go:205] ID: 72 GRPC response: {}
I0730 21:43:19.680809       1 utils.go:198] ID: 73 GRPC call: /csi.v1.Identity/Probe
I0730 21:43:19.683255       1 utils.go:199] ID: 73 GRPC request: {}
I0730 21:43:19.683297       1 utils.go:205] ID: 73 GRPC response: {}
I0730 21:44:19.713434       1 utils.go:198] ID: 74 GRPC call: /csi.v1.Identity/Probe
I0730 21:44:19.713487       1 utils.go:199] ID: 74 GRPC request: {}
I0730 21:44:19.713508       1 utils.go:205] ID: 74 GRPC response: {}
I0730 21:45:19.689711       1 utils.go:198] ID: 75 GRPC call: /csi.v1.Identity/Probe
I0730 21:45:19.690185       1 utils.go:199] ID: 75 GRPC request: {}
I0730 21:45:19.690215       1 utils.go:205] ID: 75 GRPC response: {}
I0730 21:46:19.658318       1 utils.go:198] ID: 76 GRPC call: /csi.v1.Identity/Probe
I0730 21:46:19.658378       1 utils.go:199] ID: 76 GRPC request: {}
I0730 21:46:19.658520       1 utils.go:205] ID: 76 GRPC response: {}
I0730 21:47:19.658255       1 utils.go:198] ID: 77 GRPC call: /csi.v1.Identity/Probe
I0730 21:47:19.658310       1 utils.go:199] ID: 77 GRPC request: {}
I0730 21:47:19.658332       1 utils.go:205] ID: 77 GRPC response: {}
I0730 21:48:19.658282       1 utils.go:198] ID: 78 GRPC call: /csi.v1.Identity/Probe
I0730 21:48:19.658326       1 utils.go:199] ID: 78 GRPC request: {}
I0730 21:48:19.658341       1 utils.go:205] ID: 78 GRPC response: {}