I0730 04:59:39.961903       1 cephcsi.go:191] Driver version: v3.11.0 and Git version: bc24b5eca87626d690a29effa9d7420cc0154a7a
I0730 04:59:39.962082       1 cephcsi.go:223] Starting driver type: rbd with name: rbd.csi.ceph.com
I0730 04:59:39.962100       1 driver.go:95] Enabling controller service capability: CREATE_DELETE_VOLUME
I0730 04:59:39.962104       1 driver.go:95] Enabling controller service capability: CREATE_DELETE_SNAPSHOT
I0730 04:59:39.962108       1 driver.go:95] Enabling controller service capability: CLONE_VOLUME
I0730 04:59:39.962112       1 driver.go:95] Enabling controller service capability: EXPAND_VOLUME
I0730 04:59:39.962118       1 driver.go:108] Enabling volume access mode: SINGLE_NODE_WRITER
I0730 04:59:39.962122       1 driver.go:108] Enabling volume access mode: MULTI_NODE_MULTI_WRITER
I0730 04:59:39.962127       1 driver.go:108] Enabling volume access mode: SINGLE_NODE_SINGLE_WRITER
I0730 04:59:39.962131       1 driver.go:108] Enabling volume access mode: SINGLE_NODE_MULTI_WRITER
I0730 04:59:39.962567       1 server.go:117] Listening for connections on address: &net.UnixAddr{Name:"//csi/csi-provisioner.sock", Net:"unix"}
I0730 04:59:39.962594       1 server.go:114] listening for CSI-Addons requests on address: &net.UnixAddr{Name:"/csi/csi-addons.sock", Net:"unix"}
I0730 04:59:46.961277       1 utils.go:198] ID: 1 GRPC call: /csi.v1.Identity/Probe
I0730 04:59:46.963252       1 utils.go:199] ID: 1 GRPC request: {}
I0730 04:59:46.963340       1 utils.go:205] ID: 1 GRPC response: {}
I0730 04:59:46.966636       1 utils.go:198] ID: 2 GRPC call: /csi.v1.Identity/GetPluginInfo
I0730 04:59:46.966775       1 utils.go:199] ID: 2 GRPC request: {}
I0730 04:59:46.966804       1 identityserver-default.go:40] ID: 2 Using default GetPluginInfo
I0730 04:59:46.966897       1 utils.go:205] ID: 2 GRPC response: {"name":"rbd.csi.ceph.com","vendor_version":"v3.11.0"}
I0730 04:59:46.970982       1 utils.go:198] ID: 3 GRPC call: /csi.v1.Identity/Probe
I0730 04:59:46.971008       1 utils.go:199] ID: 3 GRPC request: {}
I0730 04:59:46.971047       1 utils.go:205] ID: 3 GRPC response: {}
I0730 04:59:46.971625       1 utils.go:198] ID: 4 GRPC call: /csi.v1.Identity/GetPluginCapabilities
I0730 04:59:46.971683       1 utils.go:199] ID: 4 GRPC request: {}
I0730 04:59:46.971865       1 utils.go:205] ID: 4 GRPC response: {"capabilities":[{"Type":{"Service":{"type":1}}},{"Type":{"VolumeExpansion":{"type":1}}},{"Type":{"Service":{"type":2}}}]}
I0730 04:59:46.973063       1 utils.go:198] ID: 5 GRPC call: /csi.v1.Controller/ControllerGetCapabilities
I0730 04:59:46.973134       1 utils.go:199] ID: 5 GRPC request: {}
I0730 04:59:46.973148       1 controllerserver-default.go:42] ID: 5 Using default ControllerGetCapabilities
I0730 04:59:46.973269       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 04:59:48.721349       1 utils.go:198] ID: 6 GRPC call: /csi.v1.Identity/Probe
I0730 04:59:48.721410       1 utils.go:199] ID: 6 GRPC request: {}
I0730 04:59:48.721430       1 utils.go:205] ID: 6 GRPC response: {}
I0730 04:59:48.723175       1 utils.go:198] ID: 7 GRPC call: /csi.v1.Identity/GetPluginInfo
I0730 04:59:48.723227       1 utils.go:199] ID: 7 GRPC request: {}
I0730 04:59:48.723250       1 identityserver-default.go:40] ID: 7 Using default GetPluginInfo
I0730 04:59:48.723292       1 utils.go:205] ID: 7 GRPC response: {"name":"rbd.csi.ceph.com","vendor_version":"v3.11.0"}
I0730 04:59:48.725028       1 utils.go:198] ID: 8 GRPC call: /csi.v1.Identity/Probe
I0730 04:59:48.725071       1 utils.go:199] ID: 8 GRPC request: {}
I0730 04:59:48.725097       1 utils.go:205] ID: 8 GRPC response: {}
I0730 04:59:48.725759       1 utils.go:198] ID: 9 GRPC call: /csi.v1.Identity/GetPluginCapabilities
I0730 04:59:48.725835       1 utils.go:199] ID: 9 GRPC request: {}
I0730 04:59:48.725979       1 utils.go:205] ID: 9 GRPC response: {"capabilities":[{"Type":{"Service":{"type":1}}},{"Type":{"VolumeExpansion":{"type":1}}},{"Type":{"Service":{"type":2}}}]}
I0730 04:59:48.726872       1 utils.go:198] ID: 10 GRPC call: /csi.v1.Controller/ControllerGetCapabilities
I0730 04:59:48.726946       1 utils.go:199] ID: 10 GRPC request: {}
I0730 04:59:48.726982       1 controllerserver-default.go:42] ID: 10 Using default ControllerGetCapabilities
I0730 04:59:48.727135       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 04:59:48.727733       1 utils.go:198] ID: 11 GRPC call: /csi.v1.Controller/ControllerGetCapabilities
I0730 04:59:48.727790       1 utils.go:199] ID: 11 GRPC request: {}
I0730 04:59:48.727820       1 controllerserver-default.go:42] ID: 11 Using default ControllerGetCapabilities
I0730 04:59:48.727950       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 04:59:48.728332       1 utils.go:198] ID: 12 GRPC call: /csi.v1.Controller/ControllerGetCapabilities
I0730 04:59:48.728373       1 utils.go:199] ID: 12 GRPC request: {}
I0730 04:59:48.728393       1 controllerserver-default.go:42] ID: 12 Using default ControllerGetCapabilities
I0730 04:59:48.728465       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 04:59:52.766443       1 utils.go:198] ID: 13 GRPC call: /csi.v1.Identity/GetPluginInfo
I0730 04:59:52.766502       1 utils.go:199] ID: 13 GRPC request: {}
I0730 04:59:52.766512       1 identityserver-default.go:40] ID: 13 Using default GetPluginInfo
I0730 04:59:52.766566       1 utils.go:205] ID: 13 GRPC response: {"name":"rbd.csi.ceph.com","vendor_version":"v3.11.0"}
I0730 04:59:52.769593       1 utils.go:198] ID: 14 GRPC call: /csi.v1.Identity/Probe
I0730 04:59:52.769644       1 utils.go:199] ID: 14 GRPC request: {}
I0730 04:59:52.769662       1 utils.go:205] ID: 14 GRPC response: {}
I0730 04:59:52.770418       1 utils.go:198] ID: 15 GRPC call: /csi.v1.Controller/ControllerGetCapabilities
I0730 04:59:52.770441       1 utils.go:199] ID: 15 GRPC request: {}
I0730 04:59:52.770450       1 controllerserver-default.go:42] ID: 15 Using default ControllerGetCapabilities
I0730 04:59:52.770581       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 04:59:54.389443       1 utils.go:198] ID: 16 GRPC call: /csi.v1.Identity/Probe
I0730 04:59:54.389508       1 utils.go:199] ID: 16 GRPC request: {}
I0730 04:59:54.389534       1 utils.go:205] ID: 16 GRPC response: {}
I0730 04:59:54.393209       1 utils.go:198] ID: 17 GRPC call: /csi.v1.Identity/GetPluginInfo
I0730 04:59:54.393272       1 utils.go:199] ID: 17 GRPC request: {}
I0730 04:59:54.393288       1 identityserver-default.go:40] ID: 17 Using default GetPluginInfo
I0730 04:59:54.393364       1 utils.go:205] ID: 17 GRPC response: {"name":"rbd.csi.ceph.com","vendor_version":"v3.11.0"}
I0730 04:59:54.396437       1 utils.go:198] ID: 18 GRPC call: /csi.v1.Identity/Probe
I0730 04:59:54.396478       1 utils.go:199] ID: 18 GRPC request: {}
I0730 04:59:54.396502       1 utils.go:205] ID: 18 GRPC response: {}
I0730 04:59:54.397004       1 utils.go:198] ID: 19 GRPC call: /csi.v1.Identity/GetPluginCapabilities
I0730 04:59:54.397034       1 utils.go:199] ID: 19 GRPC request: {}
I0730 04:59:54.397169       1 utils.go:205] ID: 19 GRPC response: {"capabilities":[{"Type":{"Service":{"type":1}}},{"Type":{"VolumeExpansion":{"type":1}}},{"Type":{"Service":{"type":2}}}]}
I0730 04:59:54.397808       1 utils.go:198] ID: 20 GRPC call: /csi.v1.Controller/ControllerGetCapabilities
I0730 04:59:54.397837       1 utils.go:199] ID: 20 GRPC request: {}
I0730 04:59:54.397850       1 controllerserver-default.go:42] ID: 20 Using default ControllerGetCapabilities
I0730 04:59:54.397994       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 05:00:38.249347       1 utils.go:198] ID: 21 Req-ID: pvc-ceda809c-e9bf-49b7-9fef-cd228635f438 GRPC call: /csi.v1.Controller/CreateVolume
I0730 05:00:38.250100       1 utils.go:199] ID: 21 Req-ID: pvc-ceda809c-e9bf-49b7-9fef-cd228635f438 GRPC request: {"capacity_range":{"required_bytes":171798691840},"name":"pvc-ceda809c-e9bf-49b7-9fef-cd228635f438","parameters":{"clusterID":"4837cbf8-4f90-4300-b3f6-726c9b9f89b4","csi.storage.k8s.io/pv/name":"pvc-ceda809c-e9bf-49b7-9fef-cd228635f438","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 05:00:38.250621       1 rbd_util.go:1315] ID: 21 Req-ID: pvc-ceda809c-e9bf-49b7-9fef-cd228635f438 setting disableInUseChecks: false image features: [layering] mounter: rbd
E0730 05:00:38.273225       1 omap.go:80] ID: 21 Req-ID: pvc-ceda809c-e9bf-49b7-9fef-cd228635f438 omap not found (pool="kube", namespace="", name="csi.volumes.default"): rados: ret=-2, No such file or directory
I0730 05:00:38.291067       1 omap.go:159] ID: 21 Req-ID: pvc-ceda809c-e9bf-49b7-9fef-cd228635f438 set omap keys (pool="kube", namespace="", name="csi.volumes.default"): map[csi.volume.pvc-ceda809c-e9bf-49b7-9fef-cd228635f438:35b67e9f-72cd-4b7b-8ec7-7834384e7c55])
I0730 05:00:38.299367       1 omap.go:159] ID: 21 Req-ID: pvc-ceda809c-e9bf-49b7-9fef-cd228635f438 set omap keys (pool="kube", namespace="", name="csi.volume.35b67e9f-72cd-4b7b-8ec7-7834384e7c55"): map[csi.imagename:csi-vol-35b67e9f-72cd-4b7b-8ec7-7834384e7c55 csi.volname:pvc-ceda809c-e9bf-49b7-9fef-cd228635f438 csi.volume.owner:openstack])
I0730 05:00:38.299532       1 rbd_journal.go:491] ID: 21 Req-ID: pvc-ceda809c-e9bf-49b7-9fef-cd228635f438 generated Volume ID (0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-35b67e9f-72cd-4b7b-8ec7-7834384e7c55) and image name (csi-vol-35b67e9f-72cd-4b7b-8ec7-7834384e7c55) for request name (pvc-ceda809c-e9bf-49b7-9fef-cd228635f438)
I0730 05:00:38.299715       1 rbd_util.go:423] ID: 21 Req-ID: pvc-ceda809c-e9bf-49b7-9fef-cd228635f438 rbd: create kube/csi-vol-35b67e9f-72cd-4b7b-8ec7-7834384e7c55 size 163840M (features: [layering]) using mon 10.96.240.200
I0730 05:00:38.299838       1 rbd_util.go:1563] ID: 21 Req-ID: pvc-ceda809c-e9bf-49b7-9fef-cd228635f438 setting image options on kube/csi-vol-35b67e9f-72cd-4b7b-8ec7-7834384e7c55
I0730 05:00:38.335475       1 controllerserver.go:763] ID: 21 Req-ID: pvc-ceda809c-e9bf-49b7-9fef-cd228635f438 created image kube/csi-vol-35b67e9f-72cd-4b7b-8ec7-7834384e7c55 backed for request name pvc-ceda809c-e9bf-49b7-9fef-cd228635f438
I0730 05:00:38.373876       1 omap.go:159] ID: 21 Req-ID: pvc-ceda809c-e9bf-49b7-9fef-cd228635f438 set omap keys (pool="kube", namespace="", name="csi.volume.35b67e9f-72cd-4b7b-8ec7-7834384e7c55"): map[csi.imageid:37c626217f6a])
I0730 05:00:38.470118       1 utils.go:205] ID: 21 Req-ID: pvc-ceda809c-e9bf-49b7-9fef-cd228635f438 GRPC response: {"volume":{"capacity_bytes":171798691840,"volume_context":{"clusterID":"4837cbf8-4f90-4300-b3f6-726c9b9f89b4","imageFeatures":"layering","imageName":"csi-vol-35b67e9f-72cd-4b7b-8ec7-7834384e7c55","journalPool":"kube","pool":"kube"},"volume_id":"0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-35b67e9f-72cd-4b7b-8ec7-7834384e7c55"}}
I0730 05:00:54.575970       1 utils.go:198] ID: 22 GRPC call: /csi.v1.Identity/Probe
I0730 05:00:54.576043       1 utils.go:199] ID: 22 GRPC request: {}
I0730 05:00:54.576062       1 utils.go:205] ID: 22 GRPC response: {}
I0730 05:01:54.575813       1 utils.go:198] ID: 23 GRPC call: /csi.v1.Identity/Probe
I0730 05:01:54.575871       1 utils.go:199] ID: 23 GRPC request: {}
I0730 05:01:54.575896       1 utils.go:205] ID: 23 GRPC response: {}
I0730 05:02:54.576314       1 utils.go:198] ID: 24 GRPC call: /csi.v1.Identity/Probe
I0730 05:02:54.576379       1 utils.go:199] ID: 24 GRPC request: {}
I0730 05:02:54.576436       1 utils.go:205] ID: 24 GRPC response: {}
I0730 05:03:54.586090       1 utils.go:198] ID: 25 GRPC call: /csi.v1.Identity/Probe
I0730 05:03:54.586250       1 utils.go:199] ID: 25 GRPC request: {}
I0730 05:03:54.586332       1 utils.go:205] ID: 25 GRPC response: {}
I0730 05:04:54.576087       1 utils.go:198] ID: 26 GRPC call: /csi.v1.Identity/Probe
I0730 05:04:54.576152       1 utils.go:199] ID: 26 GRPC request: {}
I0730 05:04:54.576188       1 utils.go:205] ID: 26 GRPC response: {}
I0730 05:05:54.590353       1 utils.go:198] ID: 27 GRPC call: /csi.v1.Identity/Probe
I0730 05:05:54.590425       1 utils.go:199] ID: 27 GRPC request: {}
I0730 05:05:54.590452       1 utils.go:205] ID: 27 GRPC response: {}
I0730 05:06:54.576149       1 utils.go:198] ID: 28 GRPC call: /csi.v1.Identity/Probe
I0730 05:06:54.576223       1 utils.go:199] ID: 28 GRPC request: {}
I0730 05:06:54.576255       1 utils.go:205] ID: 28 GRPC response: {}
I0730 05:07:54.631797       1 utils.go:198] ID: 29 GRPC call: /csi.v1.Identity/Probe
I0730 05:07:54.631901       1 utils.go:199] ID: 29 GRPC request: {}
I0730 05:07:54.631931       1 utils.go:205] ID: 29 GRPC response: {}
I0730 05:08:54.586082       1 utils.go:198] ID: 30 GRPC call: /csi.v1.Identity/Probe
I0730 05:08:54.586156       1 utils.go:199] ID: 30 GRPC request: {}
I0730 05:08:54.586185       1 utils.go:205] ID: 30 GRPC response: {}
I0730 05:09:54.575372       1 utils.go:198] ID: 31 GRPC call: /csi.v1.Identity/Probe
I0730 05:09:54.575420       1 utils.go:199] ID: 31 GRPC request: {}
I0730 05:09:54.575438       1 utils.go:205] ID: 31 GRPC response: {}
I0730 05:10:54.596243       1 utils.go:198] ID: 32 GRPC call: /csi.v1.Identity/Probe
I0730 05:10:54.596294       1 utils.go:199] ID: 32 GRPC request: {}
I0730 05:10:54.596313       1 utils.go:205] ID: 32 GRPC response: {}
I0730 05:10:56.893073       1 utils.go:198] ID: 33 Req-ID: pvc-702576ab-b1d5-44a8-8a6d-943505f2931e GRPC call: /csi.v1.Controller/CreateVolume
I0730 05:10:56.893263       1 utils.go:199] ID: 33 Req-ID: pvc-702576ab-b1d5-44a8-8a6d-943505f2931e GRPC request: {"capacity_range":{"required_bytes":10737418240},"name":"pvc-702576ab-b1d5-44a8-8a6d-943505f2931e","parameters":{"clusterID":"4837cbf8-4f90-4300-b3f6-726c9b9f89b4","csi.storage.k8s.io/pv/name":"pvc-702576ab-b1d5-44a8-8a6d-943505f2931e","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 05:10:56.893418       1 rbd_util.go:1315] ID: 33 Req-ID: pvc-702576ab-b1d5-44a8-8a6d-943505f2931e setting disableInUseChecks: false image features: [layering] mounter: rbd
I0730 05:10:56.895099       1 omap.go:89] ID: 33 Req-ID: pvc-702576ab-b1d5-44a8-8a6d-943505f2931e got omap values: (pool="kube", namespace="", name="csi.volumes.default"): map[]
I0730 05:10:56.910617       1 omap.go:159] ID: 33 Req-ID: pvc-702576ab-b1d5-44a8-8a6d-943505f2931e set omap keys (pool="kube", namespace="", name="csi.volumes.default"): map[csi.volume.pvc-702576ab-b1d5-44a8-8a6d-943505f2931e:a3034e50-b6ce-4fd2-acea-2613a6f60cb2])
I0730 05:10:56.918826       1 omap.go:159] ID: 33 Req-ID: pvc-702576ab-b1d5-44a8-8a6d-943505f2931e set omap keys (pool="kube", namespace="", name="csi.volume.a3034e50-b6ce-4fd2-acea-2613a6f60cb2"): map[csi.imagename:csi-vol-a3034e50-b6ce-4fd2-acea-2613a6f60cb2 csi.volname:pvc-702576ab-b1d5-44a8-8a6d-943505f2931e csi.volume.owner:openstack])
I0730 05:10:56.918853       1 rbd_journal.go:491] ID: 33 Req-ID: pvc-702576ab-b1d5-44a8-8a6d-943505f2931e generated Volume ID (0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-a3034e50-b6ce-4fd2-acea-2613a6f60cb2) and image name (csi-vol-a3034e50-b6ce-4fd2-acea-2613a6f60cb2) for request name (pvc-702576ab-b1d5-44a8-8a6d-943505f2931e)
I0730 05:10:56.918900       1 rbd_util.go:423] ID: 33 Req-ID: pvc-702576ab-b1d5-44a8-8a6d-943505f2931e rbd: create kube/csi-vol-a3034e50-b6ce-4fd2-acea-2613a6f60cb2 size 10240M (features: [layering]) using mon 10.96.240.200
I0730 05:10:56.919918       1 rbd_util.go:1563] ID: 33 Req-ID: pvc-702576ab-b1d5-44a8-8a6d-943505f2931e setting image options on kube/csi-vol-a3034e50-b6ce-4fd2-acea-2613a6f60cb2
I0730 05:10:56.955041       1 controllerserver.go:763] ID: 33 Req-ID: pvc-702576ab-b1d5-44a8-8a6d-943505f2931e created image kube/csi-vol-a3034e50-b6ce-4fd2-acea-2613a6f60cb2 backed for request name pvc-702576ab-b1d5-44a8-8a6d-943505f2931e
I0730 05:10:56.993622       1 omap.go:159] ID: 33 Req-ID: pvc-702576ab-b1d5-44a8-8a6d-943505f2931e set omap keys (pool="kube", namespace="", name="csi.volume.a3034e50-b6ce-4fd2-acea-2613a6f60cb2"): map[csi.imageid:37c637c01f60])
I0730 05:10:57.098353       1 utils.go:205] ID: 33 Req-ID: pvc-702576ab-b1d5-44a8-8a6d-943505f2931e GRPC response: {"volume":{"capacity_bytes":10737418240,"volume_context":{"clusterID":"4837cbf8-4f90-4300-b3f6-726c9b9f89b4","imageFeatures":"layering","imageName":"csi-vol-a3034e50-b6ce-4fd2-acea-2613a6f60cb2","journalPool":"kube","pool":"kube"},"volume_id":"0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-a3034e50-b6ce-4fd2-acea-2613a6f60cb2"}}
I0730 05:11:54.575266       1 utils.go:198] ID: 34 GRPC call: /csi.v1.Identity/Probe
I0730 05:11:54.575364       1 utils.go:199] ID: 34 GRPC request: {}
I0730 05:11:54.575421       1 utils.go:205] ID: 34 GRPC response: {}
I0730 05:12:54.608273       1 utils.go:198] ID: 35 GRPC call: /csi.v1.Identity/Probe
I0730 05:12:54.608394       1 utils.go:199] ID: 35 GRPC request: {}
I0730 05:12:54.608435       1 utils.go:205] ID: 35 GRPC response: {}
I0730 05:13:54.590784       1 utils.go:198] ID: 36 GRPC call: /csi.v1.Identity/Probe
I0730 05:13:54.590858       1 utils.go:199] ID: 36 GRPC request: {}
I0730 05:13:54.590884       1 utils.go:205] ID: 36 GRPC response: {}
I0730 05:14:54.620563       1 utils.go:198] ID: 37 GRPC call: /csi.v1.Identity/Probe
I0730 05:14:54.620652       1 utils.go:199] ID: 37 GRPC request: {}
I0730 05:14:54.620686       1 utils.go:205] ID: 37 GRPC response: {}
I0730 05:14:58.597621       1 utils.go:198] ID: 38 Req-ID: pvc-05da9806-ec41-47be-a0d6-0aa35c8b3481 GRPC call: /csi.v1.Controller/CreateVolume
I0730 05:14:58.597824       1 utils.go:199] ID: 38 Req-ID: pvc-05da9806-ec41-47be-a0d6-0aa35c8b3481 GRPC request: {"capacity_range":{"required_bytes":10737418240},"name":"pvc-05da9806-ec41-47be-a0d6-0aa35c8b3481","parameters":{"clusterID":"4837cbf8-4f90-4300-b3f6-726c9b9f89b4","csi.storage.k8s.io/pv/name":"pvc-05da9806-ec41-47be-a0d6-0aa35c8b3481","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 05:14:58.597965       1 rbd_util.go:1315] ID: 38 Req-ID: pvc-05da9806-ec41-47be-a0d6-0aa35c8b3481 setting disableInUseChecks: false image features: [layering] mounter: rbd
I0730 05:14:58.599589       1 omap.go:89] ID: 38 Req-ID: pvc-05da9806-ec41-47be-a0d6-0aa35c8b3481 got omap values: (pool="kube", namespace="", name="csi.volumes.default"): map[]
I0730 05:14:58.614668       1 omap.go:159] ID: 38 Req-ID: pvc-05da9806-ec41-47be-a0d6-0aa35c8b3481 set omap keys (pool="kube", namespace="", name="csi.volumes.default"): map[csi.volume.pvc-05da9806-ec41-47be-a0d6-0aa35c8b3481:801a40c5-c407-40e8-9899-ae5f15c3db78])
I0730 05:14:58.621656       1 omap.go:159] ID: 38 Req-ID: pvc-05da9806-ec41-47be-a0d6-0aa35c8b3481 set omap keys (pool="kube", namespace="", name="csi.volume.801a40c5-c407-40e8-9899-ae5f15c3db78"): map[csi.imagename:csi-vol-801a40c5-c407-40e8-9899-ae5f15c3db78 csi.volname:pvc-05da9806-ec41-47be-a0d6-0aa35c8b3481 csi.volume.owner:openstack])
I0730 05:14:58.621690       1 rbd_journal.go:491] ID: 38 Req-ID: pvc-05da9806-ec41-47be-a0d6-0aa35c8b3481 generated Volume ID (0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-801a40c5-c407-40e8-9899-ae5f15c3db78) and image name (csi-vol-801a40c5-c407-40e8-9899-ae5f15c3db78) for request name (pvc-05da9806-ec41-47be-a0d6-0aa35c8b3481)
I0730 05:14:58.621760       1 rbd_util.go:423] ID: 38 Req-ID: pvc-05da9806-ec41-47be-a0d6-0aa35c8b3481 rbd: create kube/csi-vol-801a40c5-c407-40e8-9899-ae5f15c3db78 size 10240M (features: [layering]) using mon 10.96.240.200
I0730 05:14:58.621814       1 rbd_util.go:1563] ID: 38 Req-ID: pvc-05da9806-ec41-47be-a0d6-0aa35c8b3481 setting image options on kube/csi-vol-801a40c5-c407-40e8-9899-ae5f15c3db78
I0730 05:14:58.651843       1 controllerserver.go:763] ID: 38 Req-ID: pvc-05da9806-ec41-47be-a0d6-0aa35c8b3481 created image kube/csi-vol-801a40c5-c407-40e8-9899-ae5f15c3db78 backed for request name pvc-05da9806-ec41-47be-a0d6-0aa35c8b3481
I0730 05:14:58.681562       1 omap.go:159] ID: 38 Req-ID: pvc-05da9806-ec41-47be-a0d6-0aa35c8b3481 set omap keys (pool="kube", namespace="", name="csi.volume.801a40c5-c407-40e8-9899-ae5f15c3db78"): map[csi.imageid:37c6a375604f])
I0730 05:14:58.775800       1 utils.go:205] ID: 38 Req-ID: pvc-05da9806-ec41-47be-a0d6-0aa35c8b3481 GRPC response: {"volume":{"capacity_bytes":10737418240,"volume_context":{"clusterID":"4837cbf8-4f90-4300-b3f6-726c9b9f89b4","imageFeatures":"layering","imageName":"csi-vol-801a40c5-c407-40e8-9899-ae5f15c3db78","journalPool":"kube","pool":"kube"},"volume_id":"0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-801a40c5-c407-40e8-9899-ae5f15c3db78"}}
I0730 05:15:54.630399       1 utils.go:198] ID: 39 GRPC call: /csi.v1.Identity/Probe
I0730 05:15:54.630483       1 utils.go:199] ID: 39 GRPC request: {}
I0730 05:15:54.630509       1 utils.go:205] ID: 39 GRPC response: {}
I0730 05:16:54.628907       1 utils.go:198] ID: 40 GRPC call: /csi.v1.Identity/Probe
I0730 05:16:54.629001       1 utils.go:199] ID: 40 GRPC request: {}
I0730 05:16:54.629032       1 utils.go:205] ID: 40 GRPC response: {}
I0730 05:17:54.618064       1 utils.go:198] ID: 41 GRPC call: /csi.v1.Identity/Probe
I0730 05:17:54.618277       1 utils.go:199] ID: 41 GRPC request: {}
I0730 05:17:54.618317       1 utils.go:205] ID: 41 GRPC response: {}
I0730 05:18:54.631231       1 utils.go:198] ID: 42 GRPC call: /csi.v1.Identity/Probe
I0730 05:18:54.631288       1 utils.go:199] ID: 42 GRPC request: {}
I0730 05:18:54.631313       1 utils.go:205] ID: 42 GRPC response: {}
I0730 05:19:54.577882       1 utils.go:198] ID: 43 GRPC call: /csi.v1.Identity/Probe
I0730 05:19:54.577994       1 utils.go:199] ID: 43 GRPC request: {}
I0730 05:19:54.578031       1 utils.go:205] ID: 43 GRPC response: {}
I0730 05:20:05.510443       1 utils.go:198] ID: 44 Req-ID: pvc-0a01c30f-5ab0-4f83-ac20-e7534fc991cd GRPC call: /csi.v1.Controller/CreateVolume
I0730 05:20:05.510691       1 utils.go:199] ID: 44 Req-ID: pvc-0a01c30f-5ab0-4f83-ac20-e7534fc991cd GRPC request: {"capacity_range":{"required_bytes":10737418240},"name":"pvc-0a01c30f-5ab0-4f83-ac20-e7534fc991cd","parameters":{"clusterID":"4837cbf8-4f90-4300-b3f6-726c9b9f89b4","csi.storage.k8s.io/pv/name":"pvc-0a01c30f-5ab0-4f83-ac20-e7534fc991cd","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 05:20:05.510860       1 rbd_util.go:1315] ID: 44 Req-ID: pvc-0a01c30f-5ab0-4f83-ac20-e7534fc991cd setting disableInUseChecks: false image features: [layering] mounter: rbd
I0730 05:20:05.514898       1 omap.go:89] ID: 44 Req-ID: pvc-0a01c30f-5ab0-4f83-ac20-e7534fc991cd got omap values: (pool="kube", namespace="", name="csi.volumes.default"): map[]
I0730 05:20:05.527679       1 omap.go:159] ID: 44 Req-ID: pvc-0a01c30f-5ab0-4f83-ac20-e7534fc991cd set omap keys (pool="kube", namespace="", name="csi.volumes.default"): map[csi.volume.pvc-0a01c30f-5ab0-4f83-ac20-e7534fc991cd:91c75202-44e7-4262-a5ac-c3444b92c2f6])
I0730 05:20:05.534586       1 omap.go:159] ID: 44 Req-ID: pvc-0a01c30f-5ab0-4f83-ac20-e7534fc991cd set omap keys (pool="kube", namespace="", name="csi.volume.91c75202-44e7-4262-a5ac-c3444b92c2f6"): map[csi.imagename:csi-vol-91c75202-44e7-4262-a5ac-c3444b92c2f6 csi.volname:pvc-0a01c30f-5ab0-4f83-ac20-e7534fc991cd csi.volume.owner:openstack])
I0730 05:20:05.534613       1 rbd_journal.go:491] ID: 44 Req-ID: pvc-0a01c30f-5ab0-4f83-ac20-e7534fc991cd generated Volume ID (0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-91c75202-44e7-4262-a5ac-c3444b92c2f6) and image name (csi-vol-91c75202-44e7-4262-a5ac-c3444b92c2f6) for request name (pvc-0a01c30f-5ab0-4f83-ac20-e7534fc991cd)
I0730 05:20:05.534670       1 rbd_util.go:423] ID: 44 Req-ID: pvc-0a01c30f-5ab0-4f83-ac20-e7534fc991cd rbd: create kube/csi-vol-91c75202-44e7-4262-a5ac-c3444b92c2f6 size 10240M (features: [layering]) using mon 10.96.240.200
I0730 05:20:05.534728       1 rbd_util.go:1563] ID: 44 Req-ID: pvc-0a01c30f-5ab0-4f83-ac20-e7534fc991cd setting image options on kube/csi-vol-91c75202-44e7-4262-a5ac-c3444b92c2f6
I0730 05:20:05.561238       1 controllerserver.go:763] ID: 44 Req-ID: pvc-0a01c30f-5ab0-4f83-ac20-e7534fc991cd created image kube/csi-vol-91c75202-44e7-4262-a5ac-c3444b92c2f6 backed for request name pvc-0a01c30f-5ab0-4f83-ac20-e7534fc991cd
I0730 05:20:05.589846       1 omap.go:159] ID: 44 Req-ID: pvc-0a01c30f-5ab0-4f83-ac20-e7534fc991cd set omap keys (pool="kube", namespace="", name="csi.volume.91c75202-44e7-4262-a5ac-c3444b92c2f6"): map[csi.imageid:37c624ae32b6])
I0730 05:20:05.680951       1 utils.go:205] ID: 44 Req-ID: pvc-0a01c30f-5ab0-4f83-ac20-e7534fc991cd GRPC response: {"volume":{"capacity_bytes":10737418240,"volume_context":{"clusterID":"4837cbf8-4f90-4300-b3f6-726c9b9f89b4","imageFeatures":"layering","imageName":"csi-vol-91c75202-44e7-4262-a5ac-c3444b92c2f6","journalPool":"kube","pool":"kube"},"volume_id":"0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-91c75202-44e7-4262-a5ac-c3444b92c2f6"}}
I0730 05:20:54.632026       1 utils.go:198] ID: 45 GRPC call: /csi.v1.Identity/Probe
I0730 05:20:54.632099       1 utils.go:199] ID: 45 GRPC request: {}
I0730 05:20:54.632129       1 utils.go:205] ID: 45 GRPC response: {}
I0730 05:21:54.586700       1 utils.go:198] ID: 46 GRPC call: /csi.v1.Identity/Probe
I0730 05:21:54.586866       1 utils.go:199] ID: 46 GRPC request: {}
I0730 05:21:54.586910       1 utils.go:205] ID: 46 GRPC response: {}
I0730 05:22:54.575185       1 utils.go:198] ID: 47 GRPC call: /csi.v1.Identity/Probe
I0730 05:22:54.575227       1 utils.go:199] ID: 47 GRPC request: {}
I0730 05:22:54.575243       1 utils.go:205] ID: 47 GRPC response: {}
I0730 05:23:54.596681       1 utils.go:198] ID: 48 GRPC call: /csi.v1.Identity/Probe
I0730 05:23:54.596786       1 utils.go:199] ID: 48 GRPC request: {}
I0730 05:23:54.596824       1 utils.go:205] ID: 48 GRPC response: {}
I0730 05:24:54.630258       1 utils.go:198] ID: 49 GRPC call: /csi.v1.Identity/Probe
I0730 05:24:54.630336       1 utils.go:199] ID: 49 GRPC request: {}
I0730 05:24:54.630364       1 utils.go:205] ID: 49 GRPC response: {}
I0730 05:25:54.608105       1 utils.go:198] ID: 50 GRPC call: /csi.v1.Identity/Probe
I0730 05:25:54.608543       1 utils.go:199] ID: 50 GRPC request: {}
I0730 05:25:54.608613       1 utils.go:205] ID: 50 GRPC response: {}
I0730 05:26:54.575394       1 utils.go:198] ID: 51 GRPC call: /csi.v1.Identity/Probe
I0730 05:26:54.575493       1 utils.go:199] ID: 51 GRPC request: {}
I0730 05:26:54.575528       1 utils.go:205] ID: 51 GRPC response: {}
I0730 05:27:39.352703       1 utils.go:198] ID: 52 Req-ID: pvc-4567a394-8891-4721-806e-c7af835424dc GRPC call: /csi.v1.Controller/CreateVolume
I0730 05:27:39.353057       1 utils.go:199] ID: 52 Req-ID: pvc-4567a394-8891-4721-806e-c7af835424dc GRPC request: {"capacity_range":{"required_bytes":10737418240},"name":"pvc-4567a394-8891-4721-806e-c7af835424dc","parameters":{"clusterID":"4837cbf8-4f90-4300-b3f6-726c9b9f89b4","csi.storage.k8s.io/pv/name":"pvc-4567a394-8891-4721-806e-c7af835424dc","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 05:27:39.353263       1 rbd_util.go:1315] ID: 52 Req-ID: pvc-4567a394-8891-4721-806e-c7af835424dc setting disableInUseChecks: false image features: [layering] mounter: rbd
I0730 05:27:39.359206       1 omap.go:89] ID: 52 Req-ID: pvc-4567a394-8891-4721-806e-c7af835424dc got omap values: (pool="kube", namespace="", name="csi.volumes.default"): map[]
I0730 05:27:39.381797       1 omap.go:159] ID: 52 Req-ID: pvc-4567a394-8891-4721-806e-c7af835424dc set omap keys (pool="kube", namespace="", name="csi.volumes.default"): map[csi.volume.pvc-4567a394-8891-4721-806e-c7af835424dc:ae1084a1-c888-4708-89dc-e358dbadabe5])
I0730 05:27:39.393735       1 omap.go:159] ID: 52 Req-ID: pvc-4567a394-8891-4721-806e-c7af835424dc set omap keys (pool="kube", namespace="", name="csi.volume.ae1084a1-c888-4708-89dc-e358dbadabe5"): map[csi.imagename:csi-vol-ae1084a1-c888-4708-89dc-e358dbadabe5 csi.volname:pvc-4567a394-8891-4721-806e-c7af835424dc csi.volume.owner:openstack])
I0730 05:27:39.393784       1 rbd_journal.go:491] ID: 52 Req-ID: pvc-4567a394-8891-4721-806e-c7af835424dc generated Volume ID (0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-ae1084a1-c888-4708-89dc-e358dbadabe5) and image name (csi-vol-ae1084a1-c888-4708-89dc-e358dbadabe5) for request name (pvc-4567a394-8891-4721-806e-c7af835424dc)
I0730 05:27:39.393856       1 rbd_util.go:423] ID: 52 Req-ID: pvc-4567a394-8891-4721-806e-c7af835424dc rbd: create kube/csi-vol-ae1084a1-c888-4708-89dc-e358dbadabe5 size 10240M (features: [layering]) using mon 10.96.240.200
I0730 05:27:39.393912       1 rbd_util.go:1563] ID: 52 Req-ID: pvc-4567a394-8891-4721-806e-c7af835424dc setting image options on kube/csi-vol-ae1084a1-c888-4708-89dc-e358dbadabe5
I0730 05:27:39.434524       1 controllerserver.go:763] ID: 52 Req-ID: pvc-4567a394-8891-4721-806e-c7af835424dc created image kube/csi-vol-ae1084a1-c888-4708-89dc-e358dbadabe5 backed for request name pvc-4567a394-8891-4721-806e-c7af835424dc
I0730 05:27:39.487018       1 omap.go:159] ID: 52 Req-ID: pvc-4567a394-8891-4721-806e-c7af835424dc set omap keys (pool="kube", namespace="", name="csi.volume.ae1084a1-c888-4708-89dc-e358dbadabe5"): map[csi.imageid:37c6bd57cbb7])
I0730 05:27:39.609744       1 utils.go:205] ID: 52 Req-ID: pvc-4567a394-8891-4721-806e-c7af835424dc GRPC response: {"volume":{"capacity_bytes":10737418240,"volume_context":{"clusterID":"4837cbf8-4f90-4300-b3f6-726c9b9f89b4","imageFeatures":"layering","imageName":"csi-vol-ae1084a1-c888-4708-89dc-e358dbadabe5","journalPool":"kube","pool":"kube"},"volume_id":"0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-ae1084a1-c888-4708-89dc-e358dbadabe5"}}
I0730 05:27:54.616907       1 utils.go:198] ID: 53 GRPC call: /csi.v1.Identity/Probe
I0730 05:27:54.617120       1 utils.go:199] ID: 53 GRPC request: {}
I0730 05:27:54.617201       1 utils.go:205] ID: 53 GRPC response: {}
I0730 05:28:54.575122       1 utils.go:198] ID: 54 GRPC call: /csi.v1.Identity/Probe
I0730 05:28:54.575168       1 utils.go:199] ID: 54 GRPC request: {}
I0730 05:28:54.575188       1 utils.go:205] ID: 54 GRPC response: {}
I0730 05:29:54.627173       1 utils.go:198] ID: 55 GRPC call: /csi.v1.Identity/Probe
I0730 05:29:54.627264       1 utils.go:199] ID: 55 GRPC request: {}
I0730 05:29:54.627295       1 utils.go:205] ID: 55 GRPC response: {}
I0730 05:30:54.575371       1 utils.go:198] ID: 56 GRPC call: /csi.v1.Identity/Probe
I0730 05:30:54.575452       1 utils.go:199] ID: 56 GRPC request: {}
I0730 05:30:54.575479       1 utils.go:205] ID: 56 GRPC response: {}
I0730 05:31:54.631456       1 utils.go:198] ID: 57 GRPC call: /csi.v1.Identity/Probe
I0730 05:31:54.631576       1 utils.go:199] ID: 57 GRPC request: {}
I0730 05:31:54.631631       1 utils.go:205] ID: 57 GRPC response: {}
I0730 05:32:54.575431       1 utils.go:198] ID: 58 GRPC call: /csi.v1.Identity/Probe
I0730 05:32:54.575502       1 utils.go:199] ID: 58 GRPC request: {}
I0730 05:32:54.575527       1 utils.go:205] ID: 58 GRPC response: {}
I0730 05:33:54.612173       1 utils.go:198] ID: 59 GRPC call: /csi.v1.Identity/Probe
I0730 05:33:54.612231       1 utils.go:199] ID: 59 GRPC request: {}
I0730 05:33:54.612258       1 utils.go:205] ID: 59 GRPC response: {}
I0730 05:34:23.013657       1 utils.go:198] ID: 60 Req-ID: pvc-68a67b74-6844-441a-be03-d60970094661 GRPC call: /csi.v1.Controller/CreateVolume
I0730 05:34:23.013955       1 utils.go:199] ID: 60 Req-ID: pvc-68a67b74-6844-441a-be03-d60970094661 GRPC request: {"capacity_range":{"required_bytes":10737418240},"name":"pvc-68a67b74-6844-441a-be03-d60970094661","parameters":{"clusterID":"4837cbf8-4f90-4300-b3f6-726c9b9f89b4","csi.storage.k8s.io/pv/name":"pvc-68a67b74-6844-441a-be03-d60970094661","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 05:34:23.014217       1 rbd_util.go:1315] ID: 60 Req-ID: pvc-68a67b74-6844-441a-be03-d60970094661 setting disableInUseChecks: false image features: [layering] mounter: rbd
I0730 05:34:23.016695       1 omap.go:89] ID: 60 Req-ID: pvc-68a67b74-6844-441a-be03-d60970094661 got omap values: (pool="kube", namespace="", name="csi.volumes.default"): map[]
I0730 05:34:23.034931       1 omap.go:159] ID: 60 Req-ID: pvc-68a67b74-6844-441a-be03-d60970094661 set omap keys (pool="kube", namespace="", name="csi.volumes.default"): map[csi.volume.pvc-68a67b74-6844-441a-be03-d60970094661:935acdc1-e055-4e68-bda6-55c932cc4340])
I0730 05:34:23.044080       1 omap.go:159] ID: 60 Req-ID: pvc-68a67b74-6844-441a-be03-d60970094661 set omap keys (pool="kube", namespace="", name="csi.volume.935acdc1-e055-4e68-bda6-55c932cc4340"): map[csi.imagename:csi-vol-935acdc1-e055-4e68-bda6-55c932cc4340 csi.volname:pvc-68a67b74-6844-441a-be03-d60970094661 csi.volume.owner:openstack])
I0730 05:34:23.044121       1 rbd_journal.go:491] ID: 60 Req-ID: pvc-68a67b74-6844-441a-be03-d60970094661 generated Volume ID (0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-935acdc1-e055-4e68-bda6-55c932cc4340) and image name (csi-vol-935acdc1-e055-4e68-bda6-55c932cc4340) for request name (pvc-68a67b74-6844-441a-be03-d60970094661)
I0730 05:34:23.044214       1 rbd_util.go:423] ID: 60 Req-ID: pvc-68a67b74-6844-441a-be03-d60970094661 rbd: create kube/csi-vol-935acdc1-e055-4e68-bda6-55c932cc4340 size 10240M (features: [layering]) using mon 10.96.240.200
I0730 05:34:23.044310       1 rbd_util.go:1563] ID: 60 Req-ID: pvc-68a67b74-6844-441a-be03-d60970094661 setting image options on kube/csi-vol-935acdc1-e055-4e68-bda6-55c932cc4340
I0730 05:34:23.077557       1 controllerserver.go:763] ID: 60 Req-ID: pvc-68a67b74-6844-441a-be03-d60970094661 created image kube/csi-vol-935acdc1-e055-4e68-bda6-55c932cc4340 backed for request name pvc-68a67b74-6844-441a-be03-d60970094661
I0730 05:34:23.110438       1 omap.go:159] ID: 60 Req-ID: pvc-68a67b74-6844-441a-be03-d60970094661 set omap keys (pool="kube", namespace="", name="csi.volume.935acdc1-e055-4e68-bda6-55c932cc4340"): map[csi.imageid:37c6fb5738a8])
I0730 05:34:23.214849       1 utils.go:205] ID: 60 Req-ID: pvc-68a67b74-6844-441a-be03-d60970094661 GRPC response: {"volume":{"capacity_bytes":10737418240,"volume_context":{"clusterID":"4837cbf8-4f90-4300-b3f6-726c9b9f89b4","imageFeatures":"layering","imageName":"csi-vol-935acdc1-e055-4e68-bda6-55c932cc4340","journalPool":"kube","pool":"kube"},"volume_id":"0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-935acdc1-e055-4e68-bda6-55c932cc4340"}}
I0730 05:34:54.576166       1 utils.go:198] ID: 61 GRPC call: /csi.v1.Identity/Probe
I0730 05:34:54.576278       1 utils.go:199] ID: 61 GRPC request: {}
I0730 05:34:54.576317       1 utils.go:205] ID: 61 GRPC response: {}
I0730 05:35:54.575166       1 utils.go:198] ID: 62 GRPC call: /csi.v1.Identity/Probe
I0730 05:35:54.575259       1 utils.go:199] ID: 62 GRPC request: {}
I0730 05:35:54.575316       1 utils.go:205] ID: 62 GRPC response: {}
I0730 05:36:54.586191       1 utils.go:198] ID: 63 GRPC call: /csi.v1.Identity/Probe
I0730 05:36:54.586312       1 utils.go:199] ID: 63 GRPC request: {}
I0730 05:36:54.586338       1 utils.go:205] ID: 63 GRPC response: {}
I0730 05:37:54.575313       1 utils.go:198] ID: 64 GRPC call: /csi.v1.Identity/Probe
I0730 05:37:54.575372       1 utils.go:199] ID: 64 GRPC request: {}
I0730 05:37:54.575401       1 utils.go:205] ID: 64 GRPC response: {}
I0730 05:38:54.601730       1 utils.go:198] ID: 65 GRPC call: /csi.v1.Identity/Probe
I0730 05:38:54.601805       1 utils.go:199] ID: 65 GRPC request: {}
I0730 05:38:54.601829       1 utils.go:205] ID: 65 GRPC response: {}
I0730 05:39:54.575459       1 utils.go:198] ID: 66 GRPC call: /csi.v1.Identity/Probe
I0730 05:39:54.575556       1 utils.go:199] ID: 66 GRPC request: {}
I0730 05:39:54.575583       1 utils.go:205] ID: 66 GRPC response: {}
I0730 05:40:54.606132       1 utils.go:198] ID: 67 GRPC call: /csi.v1.Identity/Probe
I0730 05:40:54.606203       1 utils.go:199] ID: 67 GRPC request: {}
I0730 05:40:54.606227       1 utils.go:205] ID: 67 GRPC response: {}
I0730 05:41:54.575587       1 utils.go:198] ID: 68 GRPC call: /csi.v1.Identity/Probe
I0730 05:41:54.575665       1 utils.go:199] ID: 68 GRPC request: {}
I0730 05:41:54.575693       1 utils.go:205] ID: 68 GRPC response: {}
I0730 05:41:59.351887       1 utils.go:198] ID: 69 Req-ID: pvc-89e68d33-9601-43d5-998c-12f885f83b4e GRPC call: /csi.v1.Controller/CreateVolume
I0730 05:41:59.352292       1 utils.go:199] ID: 69 Req-ID: pvc-89e68d33-9601-43d5-998c-12f885f83b4e GRPC request: {"capacity_range":{"required_bytes":10737418240},"name":"pvc-89e68d33-9601-43d5-998c-12f885f83b4e","parameters":{"clusterID":"4837cbf8-4f90-4300-b3f6-726c9b9f89b4","csi.storage.k8s.io/pv/name":"pvc-89e68d33-9601-43d5-998c-12f885f83b4e","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 05:41:59.352652       1 rbd_util.go:1315] ID: 69 Req-ID: pvc-89e68d33-9601-43d5-998c-12f885f83b4e setting disableInUseChecks: false image features: [layering] mounter: rbd
I0730 05:41:59.354816       1 omap.go:89] ID: 69 Req-ID: pvc-89e68d33-9601-43d5-998c-12f885f83b4e got omap values: (pool="kube", namespace="", name="csi.volumes.default"): map[]
I0730 05:41:59.372692       1 omap.go:159] ID: 69 Req-ID: pvc-89e68d33-9601-43d5-998c-12f885f83b4e set omap keys (pool="kube", namespace="", name="csi.volumes.default"): map[csi.volume.pvc-89e68d33-9601-43d5-998c-12f885f83b4e:51525255-4e29-4f0f-8dc6-7437f27daa59])
I0730 05:41:59.380675       1 omap.go:159] ID: 69 Req-ID: pvc-89e68d33-9601-43d5-998c-12f885f83b4e set omap keys (pool="kube", namespace="", name="csi.volume.51525255-4e29-4f0f-8dc6-7437f27daa59"): map[csi.imagename:csi-vol-51525255-4e29-4f0f-8dc6-7437f27daa59 csi.volname:pvc-89e68d33-9601-43d5-998c-12f885f83b4e csi.volume.owner:openstack])
I0730 05:41:59.380714       1 rbd_journal.go:491] ID: 69 Req-ID: pvc-89e68d33-9601-43d5-998c-12f885f83b4e generated Volume ID (0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-51525255-4e29-4f0f-8dc6-7437f27daa59) and image name (csi-vol-51525255-4e29-4f0f-8dc6-7437f27daa59) for request name (pvc-89e68d33-9601-43d5-998c-12f885f83b4e)
I0730 05:41:59.380986       1 rbd_util.go:423] ID: 69 Req-ID: pvc-89e68d33-9601-43d5-998c-12f885f83b4e rbd: create kube/csi-vol-51525255-4e29-4f0f-8dc6-7437f27daa59 size 10240M (features: [layering]) using mon 10.96.240.200
I0730 05:41:59.381088       1 rbd_util.go:1563] ID: 69 Req-ID: pvc-89e68d33-9601-43d5-998c-12f885f83b4e setting image options on kube/csi-vol-51525255-4e29-4f0f-8dc6-7437f27daa59
I0730 05:41:59.424459       1 controllerserver.go:763] ID: 69 Req-ID: pvc-89e68d33-9601-43d5-998c-12f885f83b4e created image kube/csi-vol-51525255-4e29-4f0f-8dc6-7437f27daa59 backed for request name pvc-89e68d33-9601-43d5-998c-12f885f83b4e
I0730 05:41:59.481762       1 omap.go:159] ID: 69 Req-ID: pvc-89e68d33-9601-43d5-998c-12f885f83b4e set omap keys (pool="kube", namespace="", name="csi.volume.51525255-4e29-4f0f-8dc6-7437f27daa59"): map[csi.imageid:37c63d57265])
I0730 05:41:59.611713       1 utils.go:205] ID: 69 Req-ID: pvc-89e68d33-9601-43d5-998c-12f885f83b4e GRPC response: {"volume":{"capacity_bytes":10737418240,"volume_context":{"clusterID":"4837cbf8-4f90-4300-b3f6-726c9b9f89b4","imageFeatures":"layering","imageName":"csi-vol-51525255-4e29-4f0f-8dc6-7437f27daa59","journalPool":"kube","pool":"kube"},"volume_id":"0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-51525255-4e29-4f0f-8dc6-7437f27daa59"}}
I0730 05:42:54.626398       1 utils.go:198] ID: 70 GRPC call: /csi.v1.Identity/Probe
I0730 05:42:54.626466       1 utils.go:199] ID: 70 GRPC request: {}
I0730 05:42:54.626486       1 utils.go:205] ID: 70 GRPC response: {}
I0730 05:43:54.630158       1 utils.go:198] ID: 71 GRPC call: /csi.v1.Identity/Probe
I0730 05:43:54.630230       1 utils.go:199] ID: 71 GRPC request: {}
I0730 05:43:54.630250       1 utils.go:205] ID: 71 GRPC response: {}
I0730 05:44:54.626406       1 utils.go:198] ID: 72 GRPC call: /csi.v1.Identity/Probe
I0730 05:44:54.626543       1 utils.go:199] ID: 72 GRPC request: {}
I0730 05:44:54.626600       1 utils.go:205] ID: 72 GRPC response: {}
I0730 05:45:54.630643       1 utils.go:198] ID: 73 GRPC call: /csi.v1.Identity/Probe
I0730 05:45:54.630768       1 utils.go:199] ID: 73 GRPC request: {}
I0730 05:45:54.630796       1 utils.go:205] ID: 73 GRPC response: {}
I0730 05:46:54.634914       1 utils.go:198] ID: 74 GRPC call: /csi.v1.Identity/Probe
I0730 05:46:54.634986       1 utils.go:199] ID: 74 GRPC request: {}
I0730 05:46:54.635012       1 utils.go:205] ID: 74 GRPC response: {}
I0730 05:47:54.575569       1 utils.go:198] ID: 75 GRPC call: /csi.v1.Identity/Probe
I0730 05:47:54.575624       1 utils.go:199] ID: 75 GRPC request: {}
I0730 05:47:54.575652       1 utils.go:205] ID: 75 GRPC response: {}
I0730 05:48:54.630214       1 utils.go:198] ID: 76 GRPC call: /csi.v1.Identity/Probe
I0730 05:48:54.630274       1 utils.go:199] ID: 76 GRPC request: {}
I0730 05:48:54.630298       1 utils.go:205] ID: 76 GRPC response: {}
I0730 05:49:54.575809       1 utils.go:198] ID: 77 GRPC call: /csi.v1.Identity/Probe
I0730 05:49:54.575901       1 utils.go:199] ID: 77 GRPC request: {}
I0730 05:49:54.575926       1 utils.go:205] ID: 77 GRPC response: {}
I0730 05:50:54.575366       1 utils.go:198] ID: 78 GRPC call: /csi.v1.Identity/Probe
I0730 05:50:54.575456       1 utils.go:199] ID: 78 GRPC request: {}
I0730 05:50:54.576321       1 utils.go:205] ID: 78 GRPC response: {}
I0730 05:51:54.588369       1 utils.go:198] ID: 79 GRPC call: /csi.v1.Identity/Probe
I0730 05:51:54.588425       1 utils.go:199] ID: 79 GRPC request: {}
I0730 05:51:54.588467       1 utils.go:205] ID: 79 GRPC response: {}
I0730 05:52:54.575178       1 utils.go:198] ID: 80 GRPC call: /csi.v1.Identity/Probe
I0730 05:52:54.575235       1 utils.go:199] ID: 80 GRPC request: {}
I0730 05:52:54.575260       1 utils.go:205] ID: 80 GRPC response: {}
I0730 05:53:54.584026       1 utils.go:198] ID: 81 GRPC call: /csi.v1.Identity/Probe
I0730 05:53:54.584079       1 utils.go:199] ID: 81 GRPC request: {}
I0730 05:53:54.584098       1 utils.go:205] ID: 81 GRPC response: {}
I0730 05:54:54.576205       1 utils.go:198] ID: 82 GRPC call: /csi.v1.Identity/Probe
I0730 05:54:54.576303       1 utils.go:199] ID: 82 GRPC request: {}
I0730 05:54:54.576349       1 utils.go:205] ID: 82 GRPC response: {}
I0730 05:55:54.575379       1 utils.go:198] ID: 83 GRPC call: /csi.v1.Identity/Probe
I0730 05:55:54.575458       1 utils.go:199] ID: 83 GRPC request: {}
I0730 05:55:54.575487       1 utils.go:205] ID: 83 GRPC response: {}
I0730 05:56:54.590791       1 utils.go:198] ID: 84 GRPC call: /csi.v1.Identity/Probe
I0730 05:56:54.590877       1 utils.go:199] ID: 84 GRPC request: {}
I0730 05:56:54.590927       1 utils.go:205] ID: 84 GRPC response: {}
I0730 05:57:54.576741       1 utils.go:198] ID: 85 GRPC call: /csi.v1.Identity/Probe
I0730 05:57:54.576816       1 utils.go:199] ID: 85 GRPC request: {}
I0730 05:57:54.576849       1 utils.go:205] ID: 85 GRPC response: {}
I0730 05:58:54.596439       1 utils.go:198] ID: 86 GRPC call: /csi.v1.Identity/Probe
I0730 05:58:54.596499       1 utils.go:199] ID: 86 GRPC request: {}
I0730 05:58:54.596521       1 utils.go:205] ID: 86 GRPC response: {}
I0730 05:59:54.575225       1 utils.go:198] ID: 87 GRPC call: /csi.v1.Identity/Probe
I0730 05:59:54.575283       1 utils.go:199] ID: 87 GRPC request: {}
I0730 05:59:54.575303       1 utils.go:205] ID: 87 GRPC response: {}