I0730 21:11:09.782623       1 cephcsi.go:191] Driver version: v3.11.0 and Git version: bc24b5eca87626d690a29effa9d7420cc0154a7a
I0730 21:11:09.782748       1 cephcsi.go:223] Starting driver type: rbd with name: rbd.csi.ceph.com
I0730 21:11:09.782762       1 driver.go:95] Enabling controller service capability: CREATE_DELETE_VOLUME
I0730 21:11:09.782765       1 driver.go:95] Enabling controller service capability: CREATE_DELETE_SNAPSHOT
I0730 21:11:09.782769       1 driver.go:95] Enabling controller service capability: CLONE_VOLUME
I0730 21:11:09.782779       1 driver.go:95] Enabling controller service capability: EXPAND_VOLUME
I0730 21:11:09.782783       1 driver.go:108] Enabling volume access mode: SINGLE_NODE_WRITER
I0730 21:11:09.782785       1 driver.go:108] Enabling volume access mode: MULTI_NODE_MULTI_WRITER
I0730 21:11:09.782789       1 driver.go:108] Enabling volume access mode: SINGLE_NODE_SINGLE_WRITER
I0730 21:11:09.782792       1 driver.go:108] Enabling volume access mode: SINGLE_NODE_MULTI_WRITER
I0730 21:11:09.783104       1 server.go:117] Listening for connections on address: &net.UnixAddr{Name:"//csi/csi-provisioner.sock", Net:"unix"}
I0730 21:11:09.783123       1 server.go:114] listening for CSI-Addons requests on address: &net.UnixAddr{Name:"/csi/csi-addons.sock", Net:"unix"}
I0730 21:11:17.200333       1 utils.go:198] ID: 1 GRPC call: /csi.v1.Identity/Probe
I0730 21:11:17.201711       1 utils.go:199] ID: 1 GRPC request: {}
I0730 21:11:17.201767       1 utils.go:205] ID: 1 GRPC response: {}
I0730 21:11:17.205444       1 utils.go:198] ID: 2 GRPC call: /csi.v1.Identity/GetPluginInfo
I0730 21:11:17.205531       1 utils.go:199] ID: 2 GRPC request: {}
I0730 21:11:17.205548       1 identityserver-default.go:40] ID: 2 Using default GetPluginInfo
I0730 21:11:17.205591       1 utils.go:205] ID: 2 GRPC response: {"name":"rbd.csi.ceph.com","vendor_version":"v3.11.0"}
I0730 21:11:17.206954       1 utils.go:198] ID: 3 GRPC call: /csi.v1.Identity/Probe
I0730 21:11:17.206996       1 utils.go:199] ID: 3 GRPC request: {}
I0730 21:11:17.207013       1 utils.go:205] ID: 3 GRPC response: {}
I0730 21:11:17.207342       1 utils.go:198] ID: 4 GRPC call: /csi.v1.Identity/GetPluginCapabilities
I0730 21:11:17.207391       1 utils.go:199] ID: 4 GRPC request: {}
I0730 21:11:17.207516       1 utils.go:205] ID: 4 GRPC response: {"capabilities":[{"Type":{"Service":{"type":1}}},{"Type":{"VolumeExpansion":{"type":1}}},{"Type":{"Service":{"type":2}}}]}
I0730 21:11:17.208181       1 utils.go:198] ID: 5 GRPC call: /csi.v1.Controller/ControllerGetCapabilities
I0730 21:11:17.208249       1 utils.go:199] ID: 5 GRPC request: {}
I0730 21:11:17.208263       1 controllerserver-default.go:42] ID: 5 Using default ControllerGetCapabilities
I0730 21:11:17.208398       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 21:11:19.240991       1 utils.go:198] ID: 6 GRPC call: /csi.v1.Identity/Probe
I0730 21:11:19.241059       1 utils.go:199] ID: 6 GRPC request: {}
I0730 21:11:19.241078       1 utils.go:205] ID: 6 GRPC response: {}
I0730 21:11:19.244046       1 utils.go:198] ID: 7 GRPC call: /csi.v1.Identity/GetPluginInfo
I0730 21:11:19.244073       1 utils.go:199] ID: 7 GRPC request: {}
I0730 21:11:19.244080       1 identityserver-default.go:40] ID: 7 Using default GetPluginInfo
I0730 21:11:19.244130       1 utils.go:205] ID: 7 GRPC response: {"name":"rbd.csi.ceph.com","vendor_version":"v3.11.0"}
I0730 21:11:19.246474       1 utils.go:198] ID: 8 GRPC call: /csi.v1.Identity/Probe
I0730 21:11:19.246496       1 utils.go:199] ID: 8 GRPC request: {}
I0730 21:11:19.246507       1 utils.go:205] ID: 8 GRPC response: {}
I0730 21:11:19.247007       1 utils.go:198] ID: 9 GRPC call: /csi.v1.Identity/GetPluginCapabilities
I0730 21:11:19.247027       1 utils.go:199] ID: 9 GRPC request: {}
I0730 21:11:19.247127       1 utils.go:205] ID: 9 GRPC response: {"capabilities":[{"Type":{"Service":{"type":1}}},{"Type":{"VolumeExpansion":{"type":1}}},{"Type":{"Service":{"type":2}}}]}
I0730 21:11:19.249405       1 utils.go:198] ID: 10 GRPC call: /csi.v1.Controller/ControllerGetCapabilities
I0730 21:11:19.250996       1 utils.go:199] ID: 10 GRPC request: {}
I0730 21:11:19.251272       1 controllerserver-default.go:42] ID: 10 Using default ControllerGetCapabilities
I0730 21:11:19.251957       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 21:11:19.252723       1 utils.go:198] ID: 11 GRPC call: /csi.v1.Controller/ControllerGetCapabilities
I0730 21:11:19.252751       1 utils.go:199] ID: 11 GRPC request: {}
I0730 21:11:19.252760       1 controllerserver-default.go:42] ID: 11 Using default ControllerGetCapabilities
I0730 21:11:19.252841       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 21:11:19.253180       1 utils.go:198] ID: 12 GRPC call: /csi.v1.Controller/ControllerGetCapabilities
I0730 21:11:19.253194       1 utils.go:199] ID: 12 GRPC request: {}
I0730 21:11:19.253200       1 controllerserver-default.go:42] ID: 12 Using default ControllerGetCapabilities
I0730 21:11:19.253250       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 21:11:23.016916       1 utils.go:198] ID: 13 GRPC call: /csi.v1.Identity/GetPluginInfo
I0730 21:11:23.016961       1 utils.go:199] ID: 13 GRPC request: {}
I0730 21:11:23.016970       1 identityserver-default.go:40] ID: 13 Using default GetPluginInfo
I0730 21:11:23.016998       1 utils.go:205] ID: 13 GRPC response: {"name":"rbd.csi.ceph.com","vendor_version":"v3.11.0"}
I0730 21:11:23.019264       1 utils.go:198] ID: 14 GRPC call: /csi.v1.Identity/Probe
I0730 21:11:23.019315       1 utils.go:199] ID: 14 GRPC request: {}
I0730 21:11:23.019344       1 utils.go:205] ID: 14 GRPC response: {}
I0730 21:11:23.019859       1 utils.go:198] ID: 15 GRPC call: /csi.v1.Controller/ControllerGetCapabilities
I0730 21:11:23.019882       1 utils.go:199] ID: 15 GRPC request: {}
I0730 21:11:23.019891       1 controllerserver-default.go:42] ID: 15 Using default ControllerGetCapabilities
I0730 21:11:23.019973       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 21:11:24.685212       1 utils.go:198] ID: 16 GRPC call: /csi.v1.Identity/Probe
I0730 21:11:24.685313       1 utils.go:199] ID: 16 GRPC request: {}
I0730 21:11:24.685343       1 utils.go:205] ID: 16 GRPC response: {}
I0730 21:11:24.688615       1 utils.go:198] ID: 17 GRPC call: /csi.v1.Identity/GetPluginInfo
I0730 21:11:24.688663       1 utils.go:199] ID: 17 GRPC request: {}
I0730 21:11:24.688677       1 identityserver-default.go:40] ID: 17 Using default GetPluginInfo
I0730 21:11:24.688702       1 utils.go:205] ID: 17 GRPC response: {"name":"rbd.csi.ceph.com","vendor_version":"v3.11.0"}
I0730 21:11:24.691228       1 utils.go:198] ID: 18 GRPC call: /csi.v1.Identity/Probe
I0730 21:11:24.691281       1 utils.go:199] ID: 18 GRPC request: {}
I0730 21:11:24.691328       1 utils.go:205] ID: 18 GRPC response: {}
I0730 21:11:24.691913       1 utils.go:198] ID: 19 GRPC call: /csi.v1.Identity/GetPluginCapabilities
I0730 21:11:24.691943       1 utils.go:199] ID: 19 GRPC request: {}
I0730 21:11:24.692101       1 utils.go:205] ID: 19 GRPC response: {"capabilities":[{"Type":{"Service":{"type":1}}},{"Type":{"VolumeExpansion":{"type":1}}},{"Type":{"Service":{"type":2}}}]}
I0730 21:11:24.692720       1 utils.go:198] ID: 20 GRPC call: /csi.v1.Controller/ControllerGetCapabilities
I0730 21:11:24.692760       1 utils.go:199] ID: 20 GRPC request: {}
I0730 21:11:24.692773       1 controllerserver-default.go:42] ID: 20 Using default ControllerGetCapabilities
I0730 21:11:24.692860       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 21:12:06.471142       1 utils.go:198] ID: 21 Req-ID: pvc-3d1d381f-9088-4398-ba8f-105c284502e0 GRPC call: /csi.v1.Controller/CreateVolume
I0730 21:12:06.471546       1 utils.go:199] ID: 21 Req-ID: pvc-3d1d381f-9088-4398-ba8f-105c284502e0 GRPC request: {"capacity_range":{"required_bytes":171798691840},"name":"pvc-3d1d381f-9088-4398-ba8f-105c284502e0","parameters":{"clusterID":"4837cbf8-4f90-4300-b3f6-726c9b9f89b4","csi.storage.k8s.io/pv/name":"pvc-3d1d381f-9088-4398-ba8f-105c284502e0","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 21:12:06.471830       1 rbd_util.go:1315] ID: 21 Req-ID: pvc-3d1d381f-9088-4398-ba8f-105c284502e0 setting disableInUseChecks: false image features: [layering] mounter: rbd
E0730 21:12:06.490416       1 omap.go:80] ID: 21 Req-ID: pvc-3d1d381f-9088-4398-ba8f-105c284502e0 omap not found (pool="kube", namespace="", name="csi.volumes.default"): rados: ret=-2, No such file or directory
I0730 21:12:06.506360       1 omap.go:159] ID: 21 Req-ID: pvc-3d1d381f-9088-4398-ba8f-105c284502e0 set omap keys (pool="kube", namespace="", name="csi.volumes.default"): map[csi.volume.pvc-3d1d381f-9088-4398-ba8f-105c284502e0:80b005e8-4487-4e65-a20d-291f7534f1aa])
I0730 21:12:06.514590       1 omap.go:159] ID: 21 Req-ID: pvc-3d1d381f-9088-4398-ba8f-105c284502e0 set omap keys (pool="kube", namespace="", name="csi.volume.80b005e8-4487-4e65-a20d-291f7534f1aa"): map[csi.imagename:csi-vol-80b005e8-4487-4e65-a20d-291f7534f1aa csi.volname:pvc-3d1d381f-9088-4398-ba8f-105c284502e0 csi.volume.owner:openstack])
I0730 21:12:06.514623       1 rbd_journal.go:491] ID: 21 Req-ID: pvc-3d1d381f-9088-4398-ba8f-105c284502e0 generated Volume ID (0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-80b005e8-4487-4e65-a20d-291f7534f1aa) and image name (csi-vol-80b005e8-4487-4e65-a20d-291f7534f1aa) for request name (pvc-3d1d381f-9088-4398-ba8f-105c284502e0)
I0730 21:12:06.514724       1 rbd_util.go:423] ID: 21 Req-ID: pvc-3d1d381f-9088-4398-ba8f-105c284502e0 rbd: create kube/csi-vol-80b005e8-4487-4e65-a20d-291f7534f1aa size 163840M (features: [layering]) using mon 10.96.240.200
I0730 21:12:06.514785       1 rbd_util.go:1563] ID: 21 Req-ID: pvc-3d1d381f-9088-4398-ba8f-105c284502e0 setting image options on kube/csi-vol-80b005e8-4487-4e65-a20d-291f7534f1aa
I0730 21:12:06.550361       1 controllerserver.go:763] ID: 21 Req-ID: pvc-3d1d381f-9088-4398-ba8f-105c284502e0 created image kube/csi-vol-80b005e8-4487-4e65-a20d-291f7534f1aa backed for request name pvc-3d1d381f-9088-4398-ba8f-105c284502e0
I0730 21:12:06.586106       1 omap.go:159] ID: 21 Req-ID: pvc-3d1d381f-9088-4398-ba8f-105c284502e0 set omap keys (pool="kube", namespace="", name="csi.volume.80b005e8-4487-4e65-a20d-291f7534f1aa"): map[csi.imageid:37c6d91117c9])
I0730 21:12:06.677615       1 utils.go:205] ID: 21 Req-ID: pvc-3d1d381f-9088-4398-ba8f-105c284502e0 GRPC response: {"volume":{"capacity_bytes":171798691840,"volume_context":{"clusterID":"4837cbf8-4f90-4300-b3f6-726c9b9f89b4","imageFeatures":"layering","imageName":"csi-vol-80b005e8-4487-4e65-a20d-291f7534f1aa","journalPool":"kube","pool":"kube"},"volume_id":"0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-80b005e8-4487-4e65-a20d-291f7534f1aa"}}
I0730 21:12:24.864365       1 utils.go:198] ID: 22 GRPC call: /csi.v1.Identity/Probe
I0730 21:12:24.864414       1 utils.go:199] ID: 22 GRPC request: {}
I0730 21:12:24.864437       1 utils.go:205] ID: 22 GRPC response: {}
I0730 21:13:24.866902       1 utils.go:198] ID: 23 GRPC call: /csi.v1.Identity/Probe
I0730 21:13:24.866975       1 utils.go:199] ID: 23 GRPC request: {}
I0730 21:13:24.867001       1 utils.go:205] ID: 23 GRPC response: {}
I0730 21:14:24.917711       1 utils.go:198] ID: 24 GRPC call: /csi.v1.Identity/Probe
I0730 21:14:24.917767       1 utils.go:199] ID: 24 GRPC request: {}
I0730 21:14:24.917790       1 utils.go:205] ID: 24 GRPC response: {}
I0730 21:15:24.875405       1 utils.go:198] ID: 25 GRPC call: /csi.v1.Identity/Probe
I0730 21:15:24.875498       1 utils.go:199] ID: 25 GRPC request: {}
I0730 21:15:24.875529       1 utils.go:205] ID: 25 GRPC response: {}
I0730 21:16:24.864318       1 utils.go:198] ID: 26 GRPC call: /csi.v1.Identity/Probe
I0730 21:16:24.864398       1 utils.go:199] ID: 26 GRPC request: {}
I0730 21:16:24.864422       1 utils.go:205] ID: 26 GRPC response: {}
I0730 21:17:24.885090       1 utils.go:198] ID: 27 GRPC call: /csi.v1.Identity/Probe
I0730 21:17:24.885166       1 utils.go:199] ID: 27 GRPC request: {}
I0730 21:17:24.885200       1 utils.go:205] ID: 27 GRPC response: {}
I0730 21:18:24.864016       1 utils.go:198] ID: 28 GRPC call: /csi.v1.Identity/Probe
I0730 21:18:24.864072       1 utils.go:199] ID: 28 GRPC request: {}
I0730 21:18:24.864106       1 utils.go:205] ID: 28 GRPC response: {}
I0730 21:19:24.895907       1 utils.go:198] ID: 29 GRPC call: /csi.v1.Identity/Probe
I0730 21:19:24.895978       1 utils.go:199] ID: 29 GRPC request: {}
I0730 21:19:24.896006       1 utils.go:205] ID: 29 GRPC response: {}
I0730 21:20:24.864073       1 utils.go:198] ID: 30 GRPC call: /csi.v1.Identity/Probe
I0730 21:20:24.864121       1 utils.go:199] ID: 30 GRPC request: {}
I0730 21:20:24.864156       1 utils.go:205] ID: 30 GRPC response: {}
I0730 21:21:24.906276       1 utils.go:198] ID: 31 GRPC call: /csi.v1.Identity/Probe
I0730 21:21:24.906346       1 utils.go:199] ID: 31 GRPC request: {}
I0730 21:21:24.906372       1 utils.go:205] ID: 31 GRPC response: {}
I0730 21:22:24.864089       1 utils.go:198] ID: 32 GRPC call: /csi.v1.Identity/Probe
I0730 21:22:24.864157       1 utils.go:199] ID: 32 GRPC request: {}
I0730 21:22:24.864189       1 utils.go:205] ID: 32 GRPC response: {}
I0730 21:22:27.507950       1 utils.go:198] ID: 33 Req-ID: pvc-91193530-98bb-495f-806e-2eb02debb32e GRPC call: /csi.v1.Controller/CreateVolume
I0730 21:22:27.508131       1 utils.go:199] ID: 33 Req-ID: pvc-91193530-98bb-495f-806e-2eb02debb32e GRPC request: {"capacity_range":{"required_bytes":10737418240},"name":"pvc-91193530-98bb-495f-806e-2eb02debb32e","parameters":{"clusterID":"4837cbf8-4f90-4300-b3f6-726c9b9f89b4","csi.storage.k8s.io/pv/name":"pvc-91193530-98bb-495f-806e-2eb02debb32e","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:22:27.508271       1 rbd_util.go:1315] ID: 33 Req-ID: pvc-91193530-98bb-495f-806e-2eb02debb32e setting disableInUseChecks: false image features: [layering] mounter: rbd
I0730 21:22:27.509512       1 omap.go:89] ID: 33 Req-ID: pvc-91193530-98bb-495f-806e-2eb02debb32e got omap values: (pool="kube", namespace="", name="csi.volumes.default"): map[]
I0730 21:22:27.528922       1 omap.go:159] ID: 33 Req-ID: pvc-91193530-98bb-495f-806e-2eb02debb32e set omap keys (pool="kube", namespace="", name="csi.volumes.default"): map[csi.volume.pvc-91193530-98bb-495f-806e-2eb02debb32e:91011a9f-5f64-44ee-918c-f43175e5c966])
I0730 21:22:27.536360       1 omap.go:159] ID: 33 Req-ID: pvc-91193530-98bb-495f-806e-2eb02debb32e set omap keys (pool="kube", namespace="", name="csi.volume.91011a9f-5f64-44ee-918c-f43175e5c966"): map[csi.imagename:csi-vol-91011a9f-5f64-44ee-918c-f43175e5c966 csi.volname:pvc-91193530-98bb-495f-806e-2eb02debb32e csi.volume.owner:openstack])
I0730 21:22:27.536396       1 rbd_journal.go:491] ID: 33 Req-ID: pvc-91193530-98bb-495f-806e-2eb02debb32e generated Volume ID (0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-91011a9f-5f64-44ee-918c-f43175e5c966) and image name (csi-vol-91011a9f-5f64-44ee-918c-f43175e5c966) for request name (pvc-91193530-98bb-495f-806e-2eb02debb32e)
I0730 21:22:27.536503       1 rbd_util.go:423] ID: 33 Req-ID: pvc-91193530-98bb-495f-806e-2eb02debb32e rbd: create kube/csi-vol-91011a9f-5f64-44ee-918c-f43175e5c966 size 10240M (features: [layering]) using mon 10.96.240.200
I0730 21:22:27.536948       1 rbd_util.go:1563] ID: 33 Req-ID: pvc-91193530-98bb-495f-806e-2eb02debb32e setting image options on kube/csi-vol-91011a9f-5f64-44ee-918c-f43175e5c966
I0730 21:22:27.566453       1 controllerserver.go:763] ID: 33 Req-ID: pvc-91193530-98bb-495f-806e-2eb02debb32e created image kube/csi-vol-91011a9f-5f64-44ee-918c-f43175e5c966 backed for request name pvc-91193530-98bb-495f-806e-2eb02debb32e
I0730 21:22:27.596972       1 omap.go:159] ID: 33 Req-ID: pvc-91193530-98bb-495f-806e-2eb02debb32e set omap keys (pool="kube", namespace="", name="csi.volume.91011a9f-5f64-44ee-918c-f43175e5c966"): map[csi.imageid:37c637bdcf1f])
I0730 21:22:27.694777       1 utils.go:205] ID: 33 Req-ID: pvc-91193530-98bb-495f-806e-2eb02debb32e GRPC response: {"volume":{"capacity_bytes":10737418240,"volume_context":{"clusterID":"4837cbf8-4f90-4300-b3f6-726c9b9f89b4","imageFeatures":"layering","imageName":"csi-vol-91011a9f-5f64-44ee-918c-f43175e5c966","journalPool":"kube","pool":"kube"},"volume_id":"0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-91011a9f-5f64-44ee-918c-f43175e5c966"}}
I0730 21:23:24.868688       1 utils.go:198] ID: 34 GRPC call: /csi.v1.Identity/Probe
I0730 21:23:24.868737       1 utils.go:199] ID: 34 GRPC request: {}
I0730 21:23:24.868759       1 utils.go:205] ID: 34 GRPC response: {}
I0730 21:24:24.866211       1 utils.go:198] ID: 35 GRPC call: /csi.v1.Identity/Probe
I0730 21:24:24.866267       1 utils.go:199] ID: 35 GRPC request: {}
I0730 21:24:24.866288       1 utils.go:205] ID: 35 GRPC response: {}
I0730 21:25:24.876085       1 utils.go:198] ID: 36 GRPC call: /csi.v1.Identity/Probe
I0730 21:25:24.876202       1 utils.go:199] ID: 36 GRPC request: {}
I0730 21:25:24.876275       1 utils.go:205] ID: 36 GRPC response: {}
I0730 21:26:24.866362       1 utils.go:198] ID: 37 GRPC call: /csi.v1.Identity/Probe
I0730 21:26:24.866434       1 utils.go:199] ID: 37 GRPC request: {}
I0730 21:26:24.866457       1 utils.go:205] ID: 37 GRPC response: {}
I0730 21:26:26.227251       1 utils.go:198] ID: 38 Req-ID: pvc-263eb685-b5b2-4d63-8bba-de8a8735f4e0 GRPC call: /csi.v1.Controller/CreateVolume
I0730 21:26:26.227447       1 utils.go:199] ID: 38 Req-ID: pvc-263eb685-b5b2-4d63-8bba-de8a8735f4e0 GRPC request: {"capacity_range":{"required_bytes":10737418240},"name":"pvc-263eb685-b5b2-4d63-8bba-de8a8735f4e0","parameters":{"clusterID":"4837cbf8-4f90-4300-b3f6-726c9b9f89b4","csi.storage.k8s.io/pv/name":"pvc-263eb685-b5b2-4d63-8bba-de8a8735f4e0","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:26:26.227602       1 rbd_util.go:1315] ID: 38 Req-ID: pvc-263eb685-b5b2-4d63-8bba-de8a8735f4e0 setting disableInUseChecks: false image features: [layering] mounter: rbd
I0730 21:26:26.229521       1 omap.go:89] ID: 38 Req-ID: pvc-263eb685-b5b2-4d63-8bba-de8a8735f4e0 got omap values: (pool="kube", namespace="", name="csi.volumes.default"): map[]
I0730 21:26:26.241995       1 omap.go:159] ID: 38 Req-ID: pvc-263eb685-b5b2-4d63-8bba-de8a8735f4e0 set omap keys (pool="kube", namespace="", name="csi.volumes.default"): map[csi.volume.pvc-263eb685-b5b2-4d63-8bba-de8a8735f4e0:fab04dfc-929a-4966-ad5a-9d96a04c7188])
I0730 21:26:26.250003       1 omap.go:159] ID: 38 Req-ID: pvc-263eb685-b5b2-4d63-8bba-de8a8735f4e0 set omap keys (pool="kube", namespace="", name="csi.volume.fab04dfc-929a-4966-ad5a-9d96a04c7188"): map[csi.imagename:csi-vol-fab04dfc-929a-4966-ad5a-9d96a04c7188 csi.volname:pvc-263eb685-b5b2-4d63-8bba-de8a8735f4e0 csi.volume.owner:openstack])
I0730 21:26:26.250032       1 rbd_journal.go:491] ID: 38 Req-ID: pvc-263eb685-b5b2-4d63-8bba-de8a8735f4e0 generated Volume ID (0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-fab04dfc-929a-4966-ad5a-9d96a04c7188) and image name (csi-vol-fab04dfc-929a-4966-ad5a-9d96a04c7188) for request name (pvc-263eb685-b5b2-4d63-8bba-de8a8735f4e0)
I0730 21:26:26.250106       1 rbd_util.go:423] ID: 38 Req-ID: pvc-263eb685-b5b2-4d63-8bba-de8a8735f4e0 rbd: create kube/csi-vol-fab04dfc-929a-4966-ad5a-9d96a04c7188 size 10240M (features: [layering]) using mon 10.96.240.200
I0730 21:26:26.250140       1 rbd_util.go:1563] ID: 38 Req-ID: pvc-263eb685-b5b2-4d63-8bba-de8a8735f4e0 setting image options on kube/csi-vol-fab04dfc-929a-4966-ad5a-9d96a04c7188
I0730 21:26:26.280956       1 controllerserver.go:763] ID: 38 Req-ID: pvc-263eb685-b5b2-4d63-8bba-de8a8735f4e0 created image kube/csi-vol-fab04dfc-929a-4966-ad5a-9d96a04c7188 backed for request name pvc-263eb685-b5b2-4d63-8bba-de8a8735f4e0
I0730 21:26:26.309011       1 omap.go:159] ID: 38 Req-ID: pvc-263eb685-b5b2-4d63-8bba-de8a8735f4e0 set omap keys (pool="kube", namespace="", name="csi.volume.fab04dfc-929a-4966-ad5a-9d96a04c7188"): map[csi.imageid:37c6281b1627])
I0730 21:26:26.396125       1 utils.go:205] ID: 38 Req-ID: pvc-263eb685-b5b2-4d63-8bba-de8a8735f4e0 GRPC response: {"volume":{"capacity_bytes":10737418240,"volume_context":{"clusterID":"4837cbf8-4f90-4300-b3f6-726c9b9f89b4","imageFeatures":"layering","imageName":"csi-vol-fab04dfc-929a-4966-ad5a-9d96a04c7188","journalPool":"kube","pool":"kube"},"volume_id":"0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-fab04dfc-929a-4966-ad5a-9d96a04c7188"}}
I0730 21:27:24.863985       1 utils.go:198] ID: 39 GRPC call: /csi.v1.Identity/Probe
I0730 21:27:24.864047       1 utils.go:199] ID: 39 GRPC request: {}
I0730 21:27:24.864107       1 utils.go:205] ID: 39 GRPC response: {}
I0730 21:28:24.874409       1 utils.go:198] ID: 40 GRPC call: /csi.v1.Identity/Probe
I0730 21:28:24.874466       1 utils.go:199] ID: 40 GRPC request: {}
I0730 21:28:24.874490       1 utils.go:205] ID: 40 GRPC response: {}
I0730 21:29:24.863999       1 utils.go:198] ID: 41 GRPC call: /csi.v1.Identity/Probe
I0730 21:29:24.864055       1 utils.go:199] ID: 41 GRPC request: {}
I0730 21:29:24.864078       1 utils.go:205] ID: 41 GRPC response: {}
I0730 21:30:24.885003       1 utils.go:198] ID: 42 GRPC call: /csi.v1.Identity/Probe
I0730 21:30:24.885094       1 utils.go:199] ID: 42 GRPC request: {}
I0730 21:30:24.885153       1 utils.go:205] ID: 42 GRPC response: {}
I0730 21:31:24.864013       1 utils.go:198] ID: 43 GRPC call: /csi.v1.Identity/Probe
I0730 21:31:24.864065       1 utils.go:199] ID: 43 GRPC request: {}
I0730 21:31:24.864086       1 utils.go:205] ID: 43 GRPC response: {}
I0730 21:31:37.297833       1 utils.go:198] ID: 44 Req-ID: pvc-44a8805f-72d2-4eed-bc27-e85a5b4cfc97 GRPC call: /csi.v1.Controller/CreateVolume
I0730 21:31:37.298009       1 utils.go:199] ID: 44 Req-ID: pvc-44a8805f-72d2-4eed-bc27-e85a5b4cfc97 GRPC request: {"capacity_range":{"required_bytes":10737418240},"name":"pvc-44a8805f-72d2-4eed-bc27-e85a5b4cfc97","parameters":{"clusterID":"4837cbf8-4f90-4300-b3f6-726c9b9f89b4","csi.storage.k8s.io/pv/name":"pvc-44a8805f-72d2-4eed-bc27-e85a5b4cfc97","csi.storage.k8s.io/pvc/name":"persistence-rabbitmq-cinder-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:31:37.298168       1 rbd_util.go:1315] ID: 44 Req-ID: pvc-44a8805f-72d2-4eed-bc27-e85a5b4cfc97 setting disableInUseChecks: false image features: [layering] mounter: rbd
I0730 21:31:37.301754       1 omap.go:89] ID: 44 Req-ID: pvc-44a8805f-72d2-4eed-bc27-e85a5b4cfc97 got omap values: (pool="kube", namespace="", name="csi.volumes.default"): map[]
I0730 21:31:37.316605       1 omap.go:159] ID: 44 Req-ID: pvc-44a8805f-72d2-4eed-bc27-e85a5b4cfc97 set omap keys (pool="kube", namespace="", name="csi.volumes.default"): map[csi.volume.pvc-44a8805f-72d2-4eed-bc27-e85a5b4cfc97:1707a31e-7e11-43cb-a1dc-0cd3d3b6e8ed])
I0730 21:31:37.327792       1 omap.go:159] ID: 44 Req-ID: pvc-44a8805f-72d2-4eed-bc27-e85a5b4cfc97 set omap keys (pool="kube", namespace="", name="csi.volume.1707a31e-7e11-43cb-a1dc-0cd3d3b6e8ed"): map[csi.imagename:csi-vol-1707a31e-7e11-43cb-a1dc-0cd3d3b6e8ed csi.volname:pvc-44a8805f-72d2-4eed-bc27-e85a5b4cfc97 csi.volume.owner:openstack])
I0730 21:31:37.327832       1 rbd_journal.go:491] ID: 44 Req-ID: pvc-44a8805f-72d2-4eed-bc27-e85a5b4cfc97 generated Volume ID (0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-1707a31e-7e11-43cb-a1dc-0cd3d3b6e8ed) and image name (csi-vol-1707a31e-7e11-43cb-a1dc-0cd3d3b6e8ed) for request name (pvc-44a8805f-72d2-4eed-bc27-e85a5b4cfc97)
I0730 21:31:37.327918       1 rbd_util.go:423] ID: 44 Req-ID: pvc-44a8805f-72d2-4eed-bc27-e85a5b4cfc97 rbd: create kube/csi-vol-1707a31e-7e11-43cb-a1dc-0cd3d3b6e8ed size 10240M (features: [layering]) using mon 10.96.240.200
I0730 21:31:37.327973       1 rbd_util.go:1563] ID: 44 Req-ID: pvc-44a8805f-72d2-4eed-bc27-e85a5b4cfc97 setting image options on kube/csi-vol-1707a31e-7e11-43cb-a1dc-0cd3d3b6e8ed
I0730 21:31:37.364399       1 controllerserver.go:763] ID: 44 Req-ID: pvc-44a8805f-72d2-4eed-bc27-e85a5b4cfc97 created image kube/csi-vol-1707a31e-7e11-43cb-a1dc-0cd3d3b6e8ed backed for request name pvc-44a8805f-72d2-4eed-bc27-e85a5b4cfc97
I0730 21:31:37.406065       1 omap.go:159] ID: 44 Req-ID: pvc-44a8805f-72d2-4eed-bc27-e85a5b4cfc97 set omap keys (pool="kube", namespace="", name="csi.volume.1707a31e-7e11-43cb-a1dc-0cd3d3b6e8ed"): map[csi.imageid:37c6658e797a])
I0730 21:31:37.513395       1 utils.go:205] ID: 44 Req-ID: pvc-44a8805f-72d2-4eed-bc27-e85a5b4cfc97 GRPC response: {"volume":{"capacity_bytes":10737418240,"volume_context":{"clusterID":"4837cbf8-4f90-4300-b3f6-726c9b9f89b4","imageFeatures":"layering","imageName":"csi-vol-1707a31e-7e11-43cb-a1dc-0cd3d3b6e8ed","journalPool":"kube","pool":"kube"},"volume_id":"0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-1707a31e-7e11-43cb-a1dc-0cd3d3b6e8ed"}}
I0730 21:32:24.901435       1 utils.go:198] ID: 45 GRPC call: /csi.v1.Identity/Probe
I0730 21:32:24.901521       1 utils.go:199] ID: 45 GRPC request: {}
I0730 21:32:24.901551       1 utils.go:205] ID: 45 GRPC response: {}
I0730 21:33:24.863784       1 utils.go:198] ID: 46 GRPC call: /csi.v1.Identity/Probe
I0730 21:33:24.863859       1 utils.go:199] ID: 46 GRPC request: {}
I0730 21:33:24.863887       1 utils.go:205] ID: 46 GRPC response: {}
I0730 21:34:24.884231       1 utils.go:198] ID: 47 GRPC call: /csi.v1.Identity/Probe
I0730 21:34:24.884293       1 utils.go:199] ID: 47 GRPC request: {}
I0730 21:34:24.884320       1 utils.go:205] ID: 47 GRPC response: {}
I0730 21:35:24.869216       1 utils.go:198] ID: 48 GRPC call: /csi.v1.Identity/Probe
I0730 21:35:24.869429       1 utils.go:199] ID: 48 GRPC request: {}
I0730 21:35:24.869457       1 utils.go:205] ID: 48 GRPC response: {}
I0730 21:36:24.919295       1 utils.go:198] ID: 49 GRPC call: /csi.v1.Identity/Probe
I0730 21:36:24.919331       1 utils.go:199] ID: 49 GRPC request: {}
I0730 21:36:24.919347       1 utils.go:205] ID: 49 GRPC response: {}
I0730 21:37:24.877194       1 utils.go:198] ID: 50 GRPC call: /csi.v1.Identity/Probe
I0730 21:37:24.877257       1 utils.go:199] ID: 50 GRPC request: {}
I0730 21:37:24.877280       1 utils.go:205] ID: 50 GRPC response: {}
I0730 21:38:24.920003       1 utils.go:198] ID: 51 GRPC call: /csi.v1.Identity/Probe
I0730 21:38:24.920041       1 utils.go:199] ID: 51 GRPC request: {}
I0730 21:38:24.920053       1 utils.go:205] ID: 51 GRPC response: {}
I0730 21:39:08.929337       1 utils.go:198] ID: 52 Req-ID: pvc-7b4330d2-c8c6-4211-b1c5-66ae69281f86 GRPC call: /csi.v1.Controller/CreateVolume
I0730 21:39:08.929608       1 utils.go:199] ID: 52 Req-ID: pvc-7b4330d2-c8c6-4211-b1c5-66ae69281f86 GRPC request: {"capacity_range":{"required_bytes":10737418240},"name":"pvc-7b4330d2-c8c6-4211-b1c5-66ae69281f86","parameters":{"clusterID":"4837cbf8-4f90-4300-b3f6-726c9b9f89b4","csi.storage.k8s.io/pv/name":"pvc-7b4330d2-c8c6-4211-b1c5-66ae69281f86","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:39:08.930278       1 rbd_util.go:1315] ID: 52 Req-ID: pvc-7b4330d2-c8c6-4211-b1c5-66ae69281f86 setting disableInUseChecks: false image features: [layering] mounter: rbd
I0730 21:39:08.932340       1 omap.go:89] ID: 52 Req-ID: pvc-7b4330d2-c8c6-4211-b1c5-66ae69281f86 got omap values: (pool="kube", namespace="", name="csi.volumes.default"): map[]
I0730 21:39:08.949719       1 omap.go:159] ID: 52 Req-ID: pvc-7b4330d2-c8c6-4211-b1c5-66ae69281f86 set omap keys (pool="kube", namespace="", name="csi.volumes.default"): map[csi.volume.pvc-7b4330d2-c8c6-4211-b1c5-66ae69281f86:62807a1d-8f28-421d-aa2b-de0069475cb7])
I0730 21:39:08.957720       1 omap.go:159] ID: 52 Req-ID: pvc-7b4330d2-c8c6-4211-b1c5-66ae69281f86 set omap keys (pool="kube", namespace="", name="csi.volume.62807a1d-8f28-421d-aa2b-de0069475cb7"): map[csi.imagename:csi-vol-62807a1d-8f28-421d-aa2b-de0069475cb7 csi.volname:pvc-7b4330d2-c8c6-4211-b1c5-66ae69281f86 csi.volume.owner:openstack])
I0730 21:39:08.957796       1 rbd_journal.go:491] ID: 52 Req-ID: pvc-7b4330d2-c8c6-4211-b1c5-66ae69281f86 generated Volume ID (0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-62807a1d-8f28-421d-aa2b-de0069475cb7) and image name (csi-vol-62807a1d-8f28-421d-aa2b-de0069475cb7) for request name (pvc-7b4330d2-c8c6-4211-b1c5-66ae69281f86)
I0730 21:39:08.957923       1 rbd_util.go:423] ID: 52 Req-ID: pvc-7b4330d2-c8c6-4211-b1c5-66ae69281f86 rbd: create kube/csi-vol-62807a1d-8f28-421d-aa2b-de0069475cb7 size 10240M (features: [layering]) using mon 10.96.240.200
I0730 21:39:08.958000       1 rbd_util.go:1563] ID: 52 Req-ID: pvc-7b4330d2-c8c6-4211-b1c5-66ae69281f86 setting image options on kube/csi-vol-62807a1d-8f28-421d-aa2b-de0069475cb7
I0730 21:39:08.987465       1 controllerserver.go:763] ID: 52 Req-ID: pvc-7b4330d2-c8c6-4211-b1c5-66ae69281f86 created image kube/csi-vol-62807a1d-8f28-421d-aa2b-de0069475cb7 backed for request name pvc-7b4330d2-c8c6-4211-b1c5-66ae69281f86
I0730 21:39:09.015982       1 omap.go:159] ID: 52 Req-ID: pvc-7b4330d2-c8c6-4211-b1c5-66ae69281f86 set omap keys (pool="kube", namespace="", name="csi.volume.62807a1d-8f28-421d-aa2b-de0069475cb7"): map[csi.imageid:37c66d3be0e8])
I0730 21:39:09.114433       1 utils.go:205] ID: 52 Req-ID: pvc-7b4330d2-c8c6-4211-b1c5-66ae69281f86 GRPC response: {"volume":{"capacity_bytes":10737418240,"volume_context":{"clusterID":"4837cbf8-4f90-4300-b3f6-726c9b9f89b4","imageFeatures":"layering","imageName":"csi-vol-62807a1d-8f28-421d-aa2b-de0069475cb7","journalPool":"kube","pool":"kube"},"volume_id":"0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-62807a1d-8f28-421d-aa2b-de0069475cb7"}}
I0730 21:39:24.885570       1 utils.go:198] ID: 53 GRPC call: /csi.v1.Identity/Probe
I0730 21:39:24.885659       1 utils.go:199] ID: 53 GRPC request: {}
I0730 21:39:24.885690       1 utils.go:205] ID: 53 GRPC response: {}
I0730 21:40:24.917768       1 utils.go:198] ID: 54 GRPC call: /csi.v1.Identity/Probe
I0730 21:40:24.917815       1 utils.go:199] ID: 54 GRPC request: {}
I0730 21:40:24.917836       1 utils.go:205] ID: 54 GRPC response: {}
I0730 21:41:24.895438       1 utils.go:198] ID: 55 GRPC call: /csi.v1.Identity/Probe
I0730 21:41:24.895493       1 utils.go:199] ID: 55 GRPC request: {}
I0730 21:41:24.895517       1 utils.go:205] ID: 55 GRPC response: {}
I0730 21:42:24.863993       1 utils.go:198] ID: 56 GRPC call: /csi.v1.Identity/Probe
I0730 21:42:24.864051       1 utils.go:199] ID: 56 GRPC request: {}
I0730 21:42:24.864098       1 utils.go:205] ID: 56 GRPC response: {}
I0730 21:43:24.905282       1 utils.go:198] ID: 57 GRPC call: /csi.v1.Identity/Probe
I0730 21:43:24.905441       1 utils.go:199] ID: 57 GRPC request: {}
I0730 21:43:24.905483       1 utils.go:205] ID: 57 GRPC response: {}
I0730 21:44:24.864103       1 utils.go:198] ID: 58 GRPC call: /csi.v1.Identity/Probe
I0730 21:44:24.864156       1 utils.go:199] ID: 58 GRPC request: {}
I0730 21:44:24.864178       1 utils.go:205] ID: 58 GRPC response: {}
I0730 21:45:24.915374       1 utils.go:198] ID: 59 GRPC call: /csi.v1.Identity/Probe
I0730 21:45:24.915452       1 utils.go:199] ID: 59 GRPC request: {}
I0730 21:45:24.915499       1 utils.go:205] ID: 59 GRPC response: {}
I0730 21:45:33.277828       1 utils.go:198] ID: 60 Req-ID: pvc-3c7339bf-e11d-4b05-99cb-5883f01d0862 GRPC call: /csi.v1.Controller/CreateVolume
I0730 21:45:33.277995       1 utils.go:199] ID: 60 Req-ID: pvc-3c7339bf-e11d-4b05-99cb-5883f01d0862 GRPC request: {"capacity_range":{"required_bytes":10737418240},"name":"pvc-3c7339bf-e11d-4b05-99cb-5883f01d0862","parameters":{"clusterID":"4837cbf8-4f90-4300-b3f6-726c9b9f89b4","csi.storage.k8s.io/pv/name":"pvc-3c7339bf-e11d-4b05-99cb-5883f01d0862","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:45:33.278144       1 rbd_util.go:1315] ID: 60 Req-ID: pvc-3c7339bf-e11d-4b05-99cb-5883f01d0862 setting disableInUseChecks: false image features: [layering] mounter: rbd
I0730 21:45:33.279360       1 omap.go:89] ID: 60 Req-ID: pvc-3c7339bf-e11d-4b05-99cb-5883f01d0862 got omap values: (pool="kube", namespace="", name="csi.volumes.default"): map[]
I0730 21:45:33.295536       1 omap.go:159] ID: 60 Req-ID: pvc-3c7339bf-e11d-4b05-99cb-5883f01d0862 set omap keys (pool="kube", namespace="", name="csi.volumes.default"): map[csi.volume.pvc-3c7339bf-e11d-4b05-99cb-5883f01d0862:e6b8880f-bbd7-4269-8137-82a9b149b1e0])
I0730 21:45:33.303704       1 omap.go:159] ID: 60 Req-ID: pvc-3c7339bf-e11d-4b05-99cb-5883f01d0862 set omap keys (pool="kube", namespace="", name="csi.volume.e6b8880f-bbd7-4269-8137-82a9b149b1e0"): map[csi.imagename:csi-vol-e6b8880f-bbd7-4269-8137-82a9b149b1e0 csi.volname:pvc-3c7339bf-e11d-4b05-99cb-5883f01d0862 csi.volume.owner:openstack])
I0730 21:45:33.303739       1 rbd_journal.go:491] ID: 60 Req-ID: pvc-3c7339bf-e11d-4b05-99cb-5883f01d0862 generated Volume ID (0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-e6b8880f-bbd7-4269-8137-82a9b149b1e0) and image name (csi-vol-e6b8880f-bbd7-4269-8137-82a9b149b1e0) for request name (pvc-3c7339bf-e11d-4b05-99cb-5883f01d0862)
I0730 21:45:33.303810       1 rbd_util.go:423] ID: 60 Req-ID: pvc-3c7339bf-e11d-4b05-99cb-5883f01d0862 rbd: create kube/csi-vol-e6b8880f-bbd7-4269-8137-82a9b149b1e0 size 10240M (features: [layering]) using mon 10.96.240.200
I0730 21:45:33.303874       1 rbd_util.go:1563] ID: 60 Req-ID: pvc-3c7339bf-e11d-4b05-99cb-5883f01d0862 setting image options on kube/csi-vol-e6b8880f-bbd7-4269-8137-82a9b149b1e0
I0730 21:45:33.344649       1 controllerserver.go:763] ID: 60 Req-ID: pvc-3c7339bf-e11d-4b05-99cb-5883f01d0862 created image kube/csi-vol-e6b8880f-bbd7-4269-8137-82a9b149b1e0 backed for request name pvc-3c7339bf-e11d-4b05-99cb-5883f01d0862
I0730 21:45:33.379689       1 omap.go:159] ID: 60 Req-ID: pvc-3c7339bf-e11d-4b05-99cb-5883f01d0862 set omap keys (pool="kube", namespace="", name="csi.volume.e6b8880f-bbd7-4269-8137-82a9b149b1e0"): map[csi.imageid:37c67f6a3805])
I0730 21:45:33.480030       1 utils.go:205] ID: 60 Req-ID: pvc-3c7339bf-e11d-4b05-99cb-5883f01d0862 GRPC response: {"volume":{"capacity_bytes":10737418240,"volume_context":{"clusterID":"4837cbf8-4f90-4300-b3f6-726c9b9f89b4","imageFeatures":"layering","imageName":"csi-vol-e6b8880f-bbd7-4269-8137-82a9b149b1e0","journalPool":"kube","pool":"kube"},"volume_id":"0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-e6b8880f-bbd7-4269-8137-82a9b149b1e0"}}
I0730 21:46:24.889832       1 utils.go:198] ID: 61 GRPC call: /csi.v1.Identity/Probe
I0730 21:46:24.889882       1 utils.go:199] ID: 61 GRPC request: {}
I0730 21:46:24.889903       1 utils.go:205] ID: 61 GRPC response: {}
I0730 21:47:24.918131       1 utils.go:198] ID: 62 GRPC call: /csi.v1.Identity/Probe
I0730 21:47:24.918193       1 utils.go:199] ID: 62 GRPC request: {}
I0730 21:47:24.918214       1 utils.go:205] ID: 62 GRPC response: {}
I0730 21:48:24.864659       1 utils.go:198] ID: 63 GRPC call: /csi.v1.Identity/Probe
I0730 21:48:24.864713       1 utils.go:199] ID: 63 GRPC request: {}
I0730 21:48:24.864754       1 utils.go:205] ID: 63 GRPC response: {}
I0730 21:49:24.918027       1 utils.go:198] ID: 64 GRPC call: /csi.v1.Identity/Probe
I0730 21:49:24.918071       1 utils.go:199] ID: 64 GRPC request: {}
I0730 21:49:24.918087       1 utils.go:205] ID: 64 GRPC response: {}
I0730 21:50:24.864665       1 utils.go:198] ID: 65 GRPC call: /csi.v1.Identity/Probe
I0730 21:50:24.864725       1 utils.go:199] ID: 65 GRPC request: {}
I0730 21:50:24.864749       1 utils.go:205] ID: 65 GRPC response: {}
I0730 21:51:24.867363       1 utils.go:198] ID: 66 GRPC call: /csi.v1.Identity/Probe
I0730 21:51:24.867427       1 utils.go:199] ID: 66 GRPC request: {}
I0730 21:51:24.867462       1 utils.go:205] ID: 66 GRPC response: {}
I0730 21:52:24.885129       1 utils.go:198] ID: 67 GRPC call: /csi.v1.Identity/Probe
I0730 21:52:24.885184       1 utils.go:199] ID: 67 GRPC request: {}
I0730 21:52:24.885206       1 utils.go:205] ID: 67 GRPC response: {}
I0730 21:53:07.935635       1 utils.go:198] ID: 68 Req-ID: pvc-97bdd86e-586f-431f-a417-ef9c12c10989 GRPC call: /csi.v1.Controller/CreateVolume
I0730 21:53:07.936060       1 utils.go:199] ID: 68 Req-ID: pvc-97bdd86e-586f-431f-a417-ef9c12c10989 GRPC request: {"capacity_range":{"required_bytes":10737418240},"name":"pvc-97bdd86e-586f-431f-a417-ef9c12c10989","parameters":{"clusterID":"4837cbf8-4f90-4300-b3f6-726c9b9f89b4","csi.storage.k8s.io/pv/name":"pvc-97bdd86e-586f-431f-a417-ef9c12c10989","csi.storage.k8s.io/pvc/name":"persistence-rabbitmq-manila-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:53:07.936366       1 rbd_util.go:1315] ID: 68 Req-ID: pvc-97bdd86e-586f-431f-a417-ef9c12c10989 setting disableInUseChecks: false image features: [layering] mounter: rbd
I0730 21:53:07.937942       1 omap.go:89] ID: 68 Req-ID: pvc-97bdd86e-586f-431f-a417-ef9c12c10989 got omap values: (pool="kube", namespace="", name="csi.volumes.default"): map[]
I0730 21:53:07.949780       1 omap.go:159] ID: 68 Req-ID: pvc-97bdd86e-586f-431f-a417-ef9c12c10989 set omap keys (pool="kube", namespace="", name="csi.volumes.default"): map[csi.volume.pvc-97bdd86e-586f-431f-a417-ef9c12c10989:6cae6ae7-e5ad-449c-b13f-63da59da4243])
I0730 21:53:07.957110       1 omap.go:159] ID: 68 Req-ID: pvc-97bdd86e-586f-431f-a417-ef9c12c10989 set omap keys (pool="kube", namespace="", name="csi.volume.6cae6ae7-e5ad-449c-b13f-63da59da4243"): map[csi.imagename:csi-vol-6cae6ae7-e5ad-449c-b13f-63da59da4243 csi.volname:pvc-97bdd86e-586f-431f-a417-ef9c12c10989 csi.volume.owner:openstack])
I0730 21:53:07.957161       1 rbd_journal.go:491] ID: 68 Req-ID: pvc-97bdd86e-586f-431f-a417-ef9c12c10989 generated Volume ID (0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-6cae6ae7-e5ad-449c-b13f-63da59da4243) and image name (csi-vol-6cae6ae7-e5ad-449c-b13f-63da59da4243) for request name (pvc-97bdd86e-586f-431f-a417-ef9c12c10989)
I0730 21:53:07.957222       1 rbd_util.go:423] ID: 68 Req-ID: pvc-97bdd86e-586f-431f-a417-ef9c12c10989 rbd: create kube/csi-vol-6cae6ae7-e5ad-449c-b13f-63da59da4243 size 10240M (features: [layering]) using mon 10.96.240.200
I0730 21:53:07.957269       1 rbd_util.go:1563] ID: 68 Req-ID: pvc-97bdd86e-586f-431f-a417-ef9c12c10989 setting image options on kube/csi-vol-6cae6ae7-e5ad-449c-b13f-63da59da4243
I0730 21:53:07.979090       1 controllerserver.go:763] ID: 68 Req-ID: pvc-97bdd86e-586f-431f-a417-ef9c12c10989 created image kube/csi-vol-6cae6ae7-e5ad-449c-b13f-63da59da4243 backed for request name pvc-97bdd86e-586f-431f-a417-ef9c12c10989
I0730 21:53:08.007920       1 omap.go:159] ID: 68 Req-ID: pvc-97bdd86e-586f-431f-a417-ef9c12c10989 set omap keys (pool="kube", namespace="", name="csi.volume.6cae6ae7-e5ad-449c-b13f-63da59da4243"): map[csi.imageid:37c6f44a0e70])
I0730 21:53:08.090539       1 utils.go:205] ID: 68 Req-ID: pvc-97bdd86e-586f-431f-a417-ef9c12c10989 GRPC response: {"volume":{"capacity_bytes":10737418240,"volume_context":{"clusterID":"4837cbf8-4f90-4300-b3f6-726c9b9f89b4","imageFeatures":"layering","imageName":"csi-vol-6cae6ae7-e5ad-449c-b13f-63da59da4243","journalPool":"kube","pool":"kube"},"volume_id":"0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-6cae6ae7-e5ad-449c-b13f-63da59da4243"}}
I0730 21:53:24.918253       1 utils.go:198] ID: 69 GRPC call: /csi.v1.Identity/Probe
I0730 21:53:24.918391       1 utils.go:199] ID: 69 GRPC request: {}
I0730 21:53:24.918464       1 utils.go:205] ID: 69 GRPC response: {}
I0730 21:54:24.894722       1 utils.go:198] ID: 70 GRPC call: /csi.v1.Identity/Probe
I0730 21:54:24.894797       1 utils.go:199] ID: 70 GRPC request: {}
I0730 21:54:24.894824       1 utils.go:205] ID: 70 GRPC response: {}
I0730 21:55:24.863908       1 utils.go:198] ID: 71 GRPC call: /csi.v1.Identity/Probe
I0730 21:55:24.863969       1 utils.go:199] ID: 71 GRPC request: {}
I0730 21:55:24.864010       1 utils.go:205] ID: 71 GRPC response: {}
I0730 21:56:24.904931       1 utils.go:198] ID: 72 GRPC call: /csi.v1.Identity/Probe
I0730 21:56:24.904979       1 utils.go:199] ID: 72 GRPC request: {}
I0730 21:56:24.904996       1 utils.go:205] ID: 72 GRPC response: {}
I0730 21:57:24.864046       1 utils.go:198] ID: 73 GRPC call: /csi.v1.Identity/Probe
I0730 21:57:24.864149       1 utils.go:199] ID: 73 GRPC request: {}
I0730 21:57:24.864181       1 utils.go:205] ID: 73 GRPC response: {}
I0730 21:58:24.915843       1 utils.go:198] ID: 74 GRPC call: /csi.v1.Identity/Probe
I0730 21:58:24.915898       1 utils.go:199] ID: 74 GRPC request: {}
I0730 21:58:24.915921       1 utils.go:205] ID: 74 GRPC response: {}
I0730 21:59:24.864034       1 utils.go:198] ID: 75 GRPC call: /csi.v1.Identity/Probe
I0730 21:59:24.864101       1 utils.go:199] ID: 75 GRPC request: {}
I0730 21:59:24.864130       1 utils.go:205] ID: 75 GRPC response: {}
I0730 22:00:24.922267       1 utils.go:198] ID: 76 GRPC call: /csi.v1.Identity/Probe
I0730 22:00:24.922337       1 utils.go:199] ID: 76 GRPC request: {}
I0730 22:00:24.922364       1 utils.go:205] ID: 76 GRPC response: {}
I0730 22:01:24.863810       1 utils.go:198] ID: 77 GRPC call: /csi.v1.Identity/Probe
I0730 22:01:24.863855       1 utils.go:199] ID: 77 GRPC request: {}
I0730 22:01:24.863872       1 utils.go:205] ID: 77 GRPC response: {}
I0730 22:02:24.920798       1 utils.go:198] ID: 78 GRPC call: /csi.v1.Identity/Probe
I0730 22:02:24.920863       1 utils.go:199] ID: 78 GRPC request: {}
I0730 22:02:24.920892       1 utils.go:205] ID: 78 GRPC response: {}
I0730 22:03:24.868571       1 utils.go:198] ID: 79 GRPC call: /csi.v1.Identity/Probe
I0730 22:03:24.868625       1 utils.go:199] ID: 79 GRPC request: {}
I0730 22:03:24.868646       1 utils.go:205] ID: 79 GRPC response: {}
I0730 22:04:24.864050       1 utils.go:198] ID: 80 GRPC call: /csi.v1.Identity/Probe
I0730 22:04:24.864120       1 utils.go:199] ID: 80 GRPC request: {}
I0730 22:04:24.864153       1 utils.go:205] ID: 80 GRPC response: {}
I0730 22:05:24.874506       1 utils.go:198] ID: 81 GRPC call: /csi.v1.Identity/Probe
I0730 22:05:24.874637       1 utils.go:199] ID: 81 GRPC request: {}
I0730 22:05:24.874686       1 utils.go:205] ID: 81 GRPC response: {}
I0730 22:06:24.863941       1 utils.go:198] ID: 82 GRPC call: /csi.v1.Identity/Probe
I0730 22:06:24.863994       1 utils.go:199] ID: 82 GRPC request: {}
I0730 22:06:24.864014       1 utils.go:205] ID: 82 GRPC response: {}
I0730 22:07:24.889339       1 utils.go:198] ID: 83 GRPC call: /csi.v1.Identity/Probe
I0730 22:07:24.889438       1 utils.go:199] ID: 83 GRPC request: {}
I0730 22:07:24.889488       1 utils.go:205] ID: 83 GRPC response: {}
I0730 22:08:24.917814       1 utils.go:198] ID: 84 GRPC call: /csi.v1.Identity/Probe
I0730 22:08:24.917863       1 utils.go:199] ID: 84 GRPC request: {}
I0730 22:08:24.917878       1 utils.go:205] ID: 84 GRPC response: {}
I0730 22:09:24.890338       1 utils.go:198] ID: 85 GRPC call: /csi.v1.Identity/Probe
I0730 22:09:24.890392       1 utils.go:199] ID: 85 GRPC request: {}
I0730 22:09:24.890413       1 utils.go:205] ID: 85 GRPC response: {}
I0730 22:10:24.917677       1 utils.go:198] ID: 86 GRPC call: /csi.v1.Identity/Probe
I0730 22:10:24.917717       1 utils.go:199] ID: 86 GRPC request: {}
I0730 22:10:24.917733       1 utils.go:205] ID: 86 GRPC response: {}
I0730 22:11:24.896307       1 utils.go:198] ID: 87 GRPC call: /csi.v1.Identity/Probe
I0730 22:11:24.896357       1 utils.go:199] ID: 87 GRPC request: {}
I0730 22:11:24.896379       1 utils.go:205] ID: 87 GRPC response: {}
I0730 22:12:24.927756       1 utils.go:198] ID: 88 GRPC call: /csi.v1.Identity/Probe
I0730 22:12:24.927821       1 utils.go:199] ID: 88 GRPC request: {}
I0730 22:12:24.927844       1 utils.go:205] ID: 88 GRPC response: {}
I0730 22:13:24.910804       1 utils.go:198] ID: 89 GRPC call: /csi.v1.Identity/Probe
I0730 22:13:24.910871       1 utils.go:199] ID: 89 GRPC request: {}
I0730 22:13:24.910894       1 utils.go:205] ID: 89 GRPC response: {}
I0730 22:14:24.918018       1 utils.go:198] ID: 90 GRPC call: /csi.v1.Identity/Probe
I0730 22:14:24.918075       1 utils.go:199] ID: 90 GRPC request: {}
I0730 22:14:24.918090       1 utils.go:205] ID: 90 GRPC response: {}