I0729 14:06:25.072015       1 cephcsi.go:191] Driver version: v3.11.0 and Git version: bc24b5eca87626d690a29effa9d7420cc0154a7a
I0729 14:06:25.072156       1 cephcsi.go:223] Starting driver type: rbd with name: rbd.csi.ceph.com
I0729 14:06:25.072176       1 driver.go:95] Enabling controller service capability: CREATE_DELETE_VOLUME
I0729 14:06:25.072180       1 driver.go:95] Enabling controller service capability: CREATE_DELETE_SNAPSHOT
I0729 14:06:25.072183       1 driver.go:95] Enabling controller service capability: CLONE_VOLUME
I0729 14:06:25.072186       1 driver.go:95] Enabling controller service capability: EXPAND_VOLUME
I0729 14:06:25.072191       1 driver.go:108] Enabling volume access mode: SINGLE_NODE_WRITER
I0729 14:06:25.072194       1 driver.go:108] Enabling volume access mode: MULTI_NODE_MULTI_WRITER
I0729 14:06:25.072197       1 driver.go:108] Enabling volume access mode: SINGLE_NODE_SINGLE_WRITER
I0729 14:06:25.072200       1 driver.go:108] Enabling volume access mode: SINGLE_NODE_MULTI_WRITER
I0729 14:06:25.072533       1 server.go:117] Listening for connections on address: &net.UnixAddr{Name:"//csi/csi-provisioner.sock", Net:"unix"}
I0729 14:06:25.072564       1 server.go:114] listening for CSI-Addons requests on address: &net.UnixAddr{Name:"/csi/csi-addons.sock", Net:"unix"}
I0729 14:06:38.372459       1 utils.go:198] ID: 1 GRPC call: /csi.v1.Identity/Probe
I0729 14:06:38.386325       1 utils.go:199] ID: 1 GRPC request: {}
I0729 14:06:38.386487       1 utils.go:205] ID: 1 GRPC response: {}
I0729 14:06:38.389901       1 utils.go:198] ID: 2 GRPC call: /csi.v1.Identity/GetPluginInfo
I0729 14:06:38.390126       1 utils.go:199] ID: 2 GRPC request: {}
I0729 14:06:38.390158       1 identityserver-default.go:40] ID: 2 Using default GetPluginInfo
I0729 14:06:38.390216       1 utils.go:205] ID: 2 GRPC response: {"name":"rbd.csi.ceph.com","vendor_version":"v3.11.0"}
I0729 14:06:38.391900       1 utils.go:198] ID: 3 GRPC call: /csi.v1.Identity/Probe
I0729 14:06:38.391921       1 utils.go:199] ID: 3 GRPC request: {}
I0729 14:06:38.391940       1 utils.go:205] ID: 3 GRPC response: {}
I0729 14:06:38.392359       1 utils.go:198] ID: 4 GRPC call: /csi.v1.Identity/GetPluginCapabilities
I0729 14:06:38.392403       1 utils.go:199] ID: 4 GRPC request: {}
I0729 14:06:38.392574       1 utils.go:205] ID: 4 GRPC response: {"capabilities":[{"Type":{"Service":{"type":1}}},{"Type":{"VolumeExpansion":{"type":1}}},{"Type":{"Service":{"type":2}}}]}
I0729 14:06:38.393408       1 utils.go:198] ID: 5 GRPC call: /csi.v1.Controller/ControllerGetCapabilities
I0729 14:06:38.393468       1 utils.go:199] ID: 5 GRPC request: {}
I0729 14:06:38.393483       1 controllerserver-default.go:42] ID: 5 Using default ControllerGetCapabilities
I0729 14:06:38.393621       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}}}]}
I0729 14:06:39.980724       1 utils.go:198] ID: 6 GRPC call: /csi.v1.Identity/Probe
I0729 14:06:39.980764       1 utils.go:199] ID: 6 GRPC request: {}
I0729 14:06:39.980781       1 utils.go:205] ID: 6 GRPC response: {}
I0729 14:06:39.984240       1 utils.go:198] ID: 7 GRPC call: /csi.v1.Identity/GetPluginInfo
I0729 14:06:39.984289       1 utils.go:199] ID: 7 GRPC request: {}
I0729 14:06:39.984300       1 identityserver-default.go:40] ID: 7 Using default GetPluginInfo
I0729 14:06:39.984329       1 utils.go:205] ID: 7 GRPC response: {"name":"rbd.csi.ceph.com","vendor_version":"v3.11.0"}
I0729 14:06:39.986991       1 utils.go:198] ID: 8 GRPC call: /csi.v1.Identity/Probe
I0729 14:06:39.987016       1 utils.go:199] ID: 8 GRPC request: {}
I0729 14:06:39.987030       1 utils.go:205] ID: 8 GRPC response: {}
I0729 14:06:39.987538       1 utils.go:198] ID: 9 GRPC call: /csi.v1.Identity/GetPluginCapabilities
I0729 14:06:39.987556       1 utils.go:199] ID: 9 GRPC request: {}
I0729 14:06:39.987664       1 utils.go:205] ID: 9 GRPC response: {"capabilities":[{"Type":{"Service":{"type":1}}},{"Type":{"VolumeExpansion":{"type":1}}},{"Type":{"Service":{"type":2}}}]}
I0729 14:06:39.988397       1 utils.go:198] ID: 10 GRPC call: /csi.v1.Controller/ControllerGetCapabilities
I0729 14:06:39.988429       1 utils.go:199] ID: 10 GRPC request: {}
I0729 14:06:39.988437       1 controllerserver-default.go:42] ID: 10 Using default ControllerGetCapabilities
I0729 14:06:39.988518       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}}}]}
I0729 14:06:39.988948       1 utils.go:198] ID: 11 GRPC call: /csi.v1.Controller/ControllerGetCapabilities
I0729 14:06:39.988967       1 utils.go:199] ID: 11 GRPC request: {}
I0729 14:06:39.988973       1 controllerserver-default.go:42] ID: 11 Using default ControllerGetCapabilities
I0729 14:06:39.989107       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}}}]}
I0729 14:06:39.989408       1 utils.go:198] ID: 12 GRPC call: /csi.v1.Controller/ControllerGetCapabilities
I0729 14:06:39.989423       1 utils.go:199] ID: 12 GRPC request: {}
I0729 14:06:39.989477       1 controllerserver-default.go:42] ID: 12 Using default ControllerGetCapabilities
I0729 14:06:39.989601       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}}}]}
I0729 14:06:41.398178       1 utils.go:198] ID: 13 GRPC call: /csi.v1.Identity/GetPluginInfo
I0729 14:06:41.398219       1 utils.go:199] ID: 13 GRPC request: {}
I0729 14:06:41.398228       1 identityserver-default.go:40] ID: 13 Using default GetPluginInfo
I0729 14:06:41.398267       1 utils.go:205] ID: 13 GRPC response: {"name":"rbd.csi.ceph.com","vendor_version":"v3.11.0"}
I0729 14:06:41.400831       1 utils.go:198] ID: 14 GRPC call: /csi.v1.Identity/Probe
I0729 14:06:41.400867       1 utils.go:199] ID: 14 GRPC request: {}
I0729 14:06:41.400886       1 utils.go:205] ID: 14 GRPC response: {}
I0729 14:06:41.405709       1 utils.go:198] ID: 15 GRPC call: /csi.v1.Controller/ControllerGetCapabilities
I0729 14:06:41.405745       1 utils.go:199] ID: 15 GRPC request: {}
I0729 14:06:41.405752       1 controllerserver-default.go:42] ID: 15 Using default ControllerGetCapabilities
I0729 14:06:41.405840       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}}}]}
I0729 14:06:42.914808       1 utils.go:198] ID: 16 GRPC call: /csi.v1.Identity/Probe
I0729 14:06:42.914860       1 utils.go:199] ID: 16 GRPC request: {}
I0729 14:06:42.914883       1 utils.go:205] ID: 16 GRPC response: {}
I0729 14:06:42.920801       1 utils.go:198] ID: 17 GRPC call: /csi.v1.Identity/GetPluginInfo
I0729 14:06:42.920825       1 utils.go:199] ID: 17 GRPC request: {}
I0729 14:06:42.920836       1 identityserver-default.go:40] ID: 17 Using default GetPluginInfo
I0729 14:06:42.920857       1 utils.go:205] ID: 17 GRPC response: {"name":"rbd.csi.ceph.com","vendor_version":"v3.11.0"}
I0729 14:06:42.925482       1 utils.go:198] ID: 18 GRPC call: /csi.v1.Identity/Probe
I0729 14:06:42.925504       1 utils.go:199] ID: 18 GRPC request: {}
I0729 14:06:42.925548       1 utils.go:205] ID: 18 GRPC response: {}
I0729 14:06:42.926205       1 utils.go:198] ID: 19 GRPC call: /csi.v1.Identity/GetPluginCapabilities
I0729 14:06:42.926242       1 utils.go:199] ID: 19 GRPC request: {}
I0729 14:06:42.926349       1 utils.go:205] ID: 19 GRPC response: {"capabilities":[{"Type":{"Service":{"type":1}}},{"Type":{"VolumeExpansion":{"type":1}}},{"Type":{"Service":{"type":2}}}]}
I0729 14:06:42.927946       1 utils.go:198] ID: 20 GRPC call: /csi.v1.Controller/ControllerGetCapabilities
I0729 14:06:42.927968       1 utils.go:199] ID: 20 GRPC request: {}
I0729 14:06:42.927976       1 controllerserver-default.go:42] ID: 20 Using default ControllerGetCapabilities
I0729 14:06:42.928037       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}}}]}
I0729 14:07:22.960175       1 utils.go:198] ID: 21 Req-ID: pvc-75ea8774-8f8e-4ae2-b896-b024da00ea79 GRPC call: /csi.v1.Controller/CreateVolume
I0729 14:07:22.960397       1 utils.go:199] ID: 21 Req-ID: pvc-75ea8774-8f8e-4ae2-b896-b024da00ea79 GRPC request: {"capacity_range":{"required_bytes":171798691840},"name":"pvc-75ea8774-8f8e-4ae2-b896-b024da00ea79","parameters":{"clusterID":"4837cbf8-4f90-4300-b3f6-726c9b9f89b4","csi.storage.k8s.io/pv/name":"pvc-75ea8774-8f8e-4ae2-b896-b024da00ea79","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}}]}
I0729 14:07:22.960584       1 rbd_util.go:1315] ID: 21 Req-ID: pvc-75ea8774-8f8e-4ae2-b896-b024da00ea79 setting disableInUseChecks: false image features: [layering] mounter: rbd
E0729 14:07:22.974804       1 omap.go:80] ID: 21 Req-ID: pvc-75ea8774-8f8e-4ae2-b896-b024da00ea79 omap not found (pool="kube", namespace="", name="csi.volumes.default"): rados: ret=-2, No such file or directory
I0729 14:07:22.987729       1 omap.go:159] ID: 21 Req-ID: pvc-75ea8774-8f8e-4ae2-b896-b024da00ea79 set omap keys (pool="kube", namespace="", name="csi.volumes.default"): map[csi.volume.pvc-75ea8774-8f8e-4ae2-b896-b024da00ea79:ca640b09-99be-40ca-b1d5-d58d3b0ef54c])
I0729 14:07:22.993007       1 omap.go:159] ID: 21 Req-ID: pvc-75ea8774-8f8e-4ae2-b896-b024da00ea79 set omap keys (pool="kube", namespace="", name="csi.volume.ca640b09-99be-40ca-b1d5-d58d3b0ef54c"): map[csi.imagename:csi-vol-ca640b09-99be-40ca-b1d5-d58d3b0ef54c csi.volname:pvc-75ea8774-8f8e-4ae2-b896-b024da00ea79 csi.volume.owner:openstack])
I0729 14:07:22.993039       1 rbd_journal.go:491] ID: 21 Req-ID: pvc-75ea8774-8f8e-4ae2-b896-b024da00ea79 generated Volume ID (0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-ca640b09-99be-40ca-b1d5-d58d3b0ef54c) and image name (csi-vol-ca640b09-99be-40ca-b1d5-d58d3b0ef54c) for request name (pvc-75ea8774-8f8e-4ae2-b896-b024da00ea79)
I0729 14:07:22.993126       1 rbd_util.go:423] ID: 21 Req-ID: pvc-75ea8774-8f8e-4ae2-b896-b024da00ea79 rbd: create kube/csi-vol-ca640b09-99be-40ca-b1d5-d58d3b0ef54c size 163840M (features: [layering]) using mon 10.96.240.200
I0729 14:07:22.993166       1 rbd_util.go:1563] ID: 21 Req-ID: pvc-75ea8774-8f8e-4ae2-b896-b024da00ea79 setting image options on kube/csi-vol-ca640b09-99be-40ca-b1d5-d58d3b0ef54c
I0729 14:07:23.026650       1 controllerserver.go:763] ID: 21 Req-ID: pvc-75ea8774-8f8e-4ae2-b896-b024da00ea79 created image kube/csi-vol-ca640b09-99be-40ca-b1d5-d58d3b0ef54c backed for request name pvc-75ea8774-8f8e-4ae2-b896-b024da00ea79
I0729 14:07:23.066131       1 omap.go:159] ID: 21 Req-ID: pvc-75ea8774-8f8e-4ae2-b896-b024da00ea79 set omap keys (pool="kube", namespace="", name="csi.volume.ca640b09-99be-40ca-b1d5-d58d3b0ef54c"): map[csi.imageid:37c6aeffb77d])
I0729 14:07:23.167666       1 utils.go:205] ID: 21 Req-ID: pvc-75ea8774-8f8e-4ae2-b896-b024da00ea79 GRPC response: {"volume":{"capacity_bytes":171798691840,"volume_context":{"clusterID":"4837cbf8-4f90-4300-b3f6-726c9b9f89b4","imageFeatures":"layering","imageName":"csi-vol-ca640b09-99be-40ca-b1d5-d58d3b0ef54c","journalPool":"kube","pool":"kube"},"volume_id":"0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-ca640b09-99be-40ca-b1d5-d58d3b0ef54c"}}
I0729 14:07:43.154855       1 utils.go:198] ID: 22 GRPC call: /csi.v1.Identity/Probe
I0729 14:07:43.154900       1 utils.go:199] ID: 22 GRPC request: {}
I0729 14:07:43.154917       1 utils.go:205] ID: 22 GRPC response: {}
I0729 14:08:43.097734       1 utils.go:198] ID: 23 GRPC call: /csi.v1.Identity/Probe
I0729 14:08:43.097831       1 utils.go:199] ID: 23 GRPC request: {}
I0729 14:08:43.097883       1 utils.go:205] ID: 23 GRPC response: {}
I0729 14:09:43.150521       1 utils.go:198] ID: 24 GRPC call: /csi.v1.Identity/Probe
I0729 14:09:43.150570       1 utils.go:199] ID: 24 GRPC request: {}
I0729 14:09:43.150591       1 utils.go:205] ID: 24 GRPC response: {}
I0729 14:10:43.108123       1 utils.go:198] ID: 25 GRPC call: /csi.v1.Identity/Probe
I0729 14:10:43.108272       1 utils.go:199] ID: 25 GRPC request: {}
I0729 14:10:43.108389       1 utils.go:205] ID: 25 GRPC response: {}
I0729 14:11:43.150691       1 utils.go:198] ID: 26 GRPC call: /csi.v1.Identity/Probe
I0729 14:11:43.150755       1 utils.go:199] ID: 26 GRPC request: {}
I0729 14:11:43.150783       1 utils.go:205] ID: 26 GRPC response: {}
I0729 14:12:43.118086       1 utils.go:198] ID: 27 GRPC call: /csi.v1.Identity/Probe
I0729 14:12:43.118156       1 utils.go:199] ID: 27 GRPC request: {}
I0729 14:12:43.118187       1 utils.go:205] ID: 27 GRPC response: {}
I0729 14:13:43.095669       1 utils.go:198] ID: 28 GRPC call: /csi.v1.Identity/Probe
I0729 14:13:43.095727       1 utils.go:199] ID: 28 GRPC request: {}
I0729 14:13:43.095758       1 utils.go:205] ID: 28 GRPC response: {}
I0729 14:14:43.128095       1 utils.go:198] ID: 29 GRPC call: /csi.v1.Identity/Probe
I0729 14:14:43.128165       1 utils.go:199] ID: 29 GRPC request: {}
I0729 14:14:43.128212       1 utils.go:205] ID: 29 GRPC response: {}
I0729 14:15:43.095618       1 utils.go:198] ID: 30 GRPC call: /csi.v1.Identity/Probe
I0729 14:15:43.095681       1 utils.go:199] ID: 30 GRPC request: {}
I0729 14:15:43.095705       1 utils.go:205] ID: 30 GRPC response: {}
I0729 14:16:43.137806       1 utils.go:198] ID: 31 GRPC call: /csi.v1.Identity/Probe
I0729 14:16:43.137848       1 utils.go:199] ID: 31 GRPC request: {}
I0729 14:16:43.138594       1 utils.go:205] ID: 31 GRPC response: {}
I0729 14:17:43.095952       1 utils.go:198] ID: 32 GRPC call: /csi.v1.Identity/Probe
I0729 14:17:43.096201       1 utils.go:199] ID: 32 GRPC request: {}
I0729 14:17:43.096369       1 utils.go:205] ID: 32 GRPC response: {}
I0729 14:18:43.144358       1 utils.go:198] ID: 33 GRPC call: /csi.v1.Identity/Probe
I0729 14:18:43.144414       1 utils.go:199] ID: 33 GRPC request: {}
I0729 14:18:43.144441       1 utils.go:205] ID: 33 GRPC response: {}
I0729 14:19:43.096241       1 utils.go:198] ID: 34 GRPC call: /csi.v1.Identity/Probe
I0729 14:19:43.096308       1 utils.go:199] ID: 34 GRPC request: {}
I0729 14:19:43.096336       1 utils.go:205] ID: 34 GRPC response: {}
I0729 14:20:43.096088       1 utils.go:198] ID: 35 GRPC call: /csi.v1.Identity/Probe
I0729 14:20:43.096200       1 utils.go:199] ID: 35 GRPC request: {}
I0729 14:20:43.096231       1 utils.go:205] ID: 35 GRPC response: {}
I0729 14:21:38.107917       1 utils.go:198] ID: 36 Req-ID: pvc-cf4901f5-d8ea-4475-9747-47c0acc52428 GRPC call: /csi.v1.Controller/CreateVolume
I0729 14:21:38.108278       1 utils.go:199] ID: 36 Req-ID: pvc-cf4901f5-d8ea-4475-9747-47c0acc52428 GRPC request: {"capacity_range":{"required_bytes":10737418240},"name":"pvc-cf4901f5-d8ea-4475-9747-47c0acc52428","parameters":{"clusterID":"4837cbf8-4f90-4300-b3f6-726c9b9f89b4","csi.storage.k8s.io/pv/name":"pvc-cf4901f5-d8ea-4475-9747-47c0acc52428","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}}]}
I0729 14:21:38.108488       1 rbd_util.go:1315] ID: 36 Req-ID: pvc-cf4901f5-d8ea-4475-9747-47c0acc52428 setting disableInUseChecks: false image features: [layering] mounter: rbd
I0729 14:21:38.110714       1 omap.go:89] ID: 36 Req-ID: pvc-cf4901f5-d8ea-4475-9747-47c0acc52428 got omap values: (pool="kube", namespace="", name="csi.volumes.default"): map[]
I0729 14:21:38.130285       1 omap.go:159] ID: 36 Req-ID: pvc-cf4901f5-d8ea-4475-9747-47c0acc52428 set omap keys (pool="kube", namespace="", name="csi.volumes.default"): map[csi.volume.pvc-cf4901f5-d8ea-4475-9747-47c0acc52428:2f5227f6-64d4-412f-b171-0ec58bf1a893])
I0729 14:21:38.141337       1 omap.go:159] ID: 36 Req-ID: pvc-cf4901f5-d8ea-4475-9747-47c0acc52428 set omap keys (pool="kube", namespace="", name="csi.volume.2f5227f6-64d4-412f-b171-0ec58bf1a893"): map[csi.imagename:csi-vol-2f5227f6-64d4-412f-b171-0ec58bf1a893 csi.volname:pvc-cf4901f5-d8ea-4475-9747-47c0acc52428 csi.volume.owner:openstack])
I0729 14:21:38.141376       1 rbd_journal.go:491] ID: 36 Req-ID: pvc-cf4901f5-d8ea-4475-9747-47c0acc52428 generated Volume ID (0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-2f5227f6-64d4-412f-b171-0ec58bf1a893) and image name (csi-vol-2f5227f6-64d4-412f-b171-0ec58bf1a893) for request name (pvc-cf4901f5-d8ea-4475-9747-47c0acc52428)
I0729 14:21:38.141453       1 rbd_util.go:423] ID: 36 Req-ID: pvc-cf4901f5-d8ea-4475-9747-47c0acc52428 rbd: create kube/csi-vol-2f5227f6-64d4-412f-b171-0ec58bf1a893 size 10240M (features: [layering]) using mon 10.96.240.200
I0729 14:21:38.141543       1 rbd_util.go:1563] ID: 36 Req-ID: pvc-cf4901f5-d8ea-4475-9747-47c0acc52428 setting image options on kube/csi-vol-2f5227f6-64d4-412f-b171-0ec58bf1a893
I0729 14:21:38.167961       1 controllerserver.go:763] ID: 36 Req-ID: pvc-cf4901f5-d8ea-4475-9747-47c0acc52428 created image kube/csi-vol-2f5227f6-64d4-412f-b171-0ec58bf1a893 backed for request name pvc-cf4901f5-d8ea-4475-9747-47c0acc52428
I0729 14:21:38.198713       1 omap.go:159] ID: 36 Req-ID: pvc-cf4901f5-d8ea-4475-9747-47c0acc52428 set omap keys (pool="kube", namespace="", name="csi.volume.2f5227f6-64d4-412f-b171-0ec58bf1a893"): map[csi.imageid:37c6b488b177])
I0729 14:21:38.308694       1 utils.go:205] ID: 36 Req-ID: pvc-cf4901f5-d8ea-4475-9747-47c0acc52428 GRPC response: {"volume":{"capacity_bytes":10737418240,"volume_context":{"clusterID":"4837cbf8-4f90-4300-b3f6-726c9b9f89b4","imageFeatures":"layering","imageName":"csi-vol-2f5227f6-64d4-412f-b171-0ec58bf1a893","journalPool":"kube","pool":"kube"},"volume_id":"0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-2f5227f6-64d4-412f-b171-0ec58bf1a893"}}
I0729 14:21:43.100167       1 utils.go:198] ID: 37 GRPC call: /csi.v1.Identity/Probe
I0729 14:21:43.100209       1 utils.go:199] ID: 37 GRPC request: {}
I0729 14:21:43.100225       1 utils.go:205] ID: 37 GRPC response: {}
I0729 14:22:43.096068       1 utils.go:198] ID: 38 GRPC call: /csi.v1.Identity/Probe
I0729 14:22:43.096138       1 utils.go:199] ID: 38 GRPC request: {}
I0729 14:22:43.096258       1 utils.go:205] ID: 38 GRPC response: {}
I0729 14:23:43.106990       1 utils.go:198] ID: 39 GRPC call: /csi.v1.Identity/Probe
I0729 14:23:43.107044       1 utils.go:199] ID: 39 GRPC request: {}
I0729 14:23:43.107064       1 utils.go:205] ID: 39 GRPC response: {}
I0729 14:24:43.150568       1 utils.go:198] ID: 40 GRPC call: /csi.v1.Identity/Probe
I0729 14:24:43.150628       1 utils.go:199] ID: 40 GRPC request: {}
I0729 14:24:43.150660       1 utils.go:205] ID: 40 GRPC response: {}
I0729 14:25:43.117778       1 utils.go:198] ID: 41 GRPC call: /csi.v1.Identity/Probe
I0729 14:25:43.117854       1 utils.go:199] ID: 41 GRPC request: {}
I0729 14:25:43.117879       1 utils.go:205] ID: 41 GRPC response: {}
I0729 14:25:47.859919       1 utils.go:198] ID: 42 Req-ID: pvc-f95ec463-8a32-4de0-9f56-5862958a928c GRPC call: /csi.v1.Controller/CreateVolume
I0729 14:25:47.860118       1 utils.go:199] ID: 42 Req-ID: pvc-f95ec463-8a32-4de0-9f56-5862958a928c GRPC request: {"capacity_range":{"required_bytes":10737418240},"name":"pvc-f95ec463-8a32-4de0-9f56-5862958a928c","parameters":{"clusterID":"4837cbf8-4f90-4300-b3f6-726c9b9f89b4","csi.storage.k8s.io/pv/name":"pvc-f95ec463-8a32-4de0-9f56-5862958a928c","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}}]}
I0729 14:25:47.860331       1 rbd_util.go:1315] ID: 42 Req-ID: pvc-f95ec463-8a32-4de0-9f56-5862958a928c setting disableInUseChecks: false image features: [layering] mounter: rbd
I0729 14:25:47.862581       1 omap.go:89] ID: 42 Req-ID: pvc-f95ec463-8a32-4de0-9f56-5862958a928c got omap values: (pool="kube", namespace="", name="csi.volumes.default"): map[]
I0729 14:25:47.873621       1 omap.go:159] ID: 42 Req-ID: pvc-f95ec463-8a32-4de0-9f56-5862958a928c set omap keys (pool="kube", namespace="", name="csi.volumes.default"): map[csi.volume.pvc-f95ec463-8a32-4de0-9f56-5862958a928c:8478902b-aeb0-4b66-b9cc-255cee15dcf2])
I0729 14:25:47.878805       1 omap.go:159] ID: 42 Req-ID: pvc-f95ec463-8a32-4de0-9f56-5862958a928c set omap keys (pool="kube", namespace="", name="csi.volume.8478902b-aeb0-4b66-b9cc-255cee15dcf2"): map[csi.imagename:csi-vol-8478902b-aeb0-4b66-b9cc-255cee15dcf2 csi.volname:pvc-f95ec463-8a32-4de0-9f56-5862958a928c csi.volume.owner:openstack])
I0729 14:25:47.878843       1 rbd_journal.go:491] ID: 42 Req-ID: pvc-f95ec463-8a32-4de0-9f56-5862958a928c generated Volume ID (0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-8478902b-aeb0-4b66-b9cc-255cee15dcf2) and image name (csi-vol-8478902b-aeb0-4b66-b9cc-255cee15dcf2) for request name (pvc-f95ec463-8a32-4de0-9f56-5862958a928c)
I0729 14:25:47.878951       1 rbd_util.go:423] ID: 42 Req-ID: pvc-f95ec463-8a32-4de0-9f56-5862958a928c rbd: create kube/csi-vol-8478902b-aeb0-4b66-b9cc-255cee15dcf2 size 10240M (features: [layering]) using mon 10.96.240.200
I0729 14:25:47.879007       1 rbd_util.go:1563] ID: 42 Req-ID: pvc-f95ec463-8a32-4de0-9f56-5862958a928c setting image options on kube/csi-vol-8478902b-aeb0-4b66-b9cc-255cee15dcf2
I0729 14:25:47.906687       1 controllerserver.go:763] ID: 42 Req-ID: pvc-f95ec463-8a32-4de0-9f56-5862958a928c created image kube/csi-vol-8478902b-aeb0-4b66-b9cc-255cee15dcf2 backed for request name pvc-f95ec463-8a32-4de0-9f56-5862958a928c
I0729 14:25:47.937936       1 omap.go:159] ID: 42 Req-ID: pvc-f95ec463-8a32-4de0-9f56-5862958a928c set omap keys (pool="kube", namespace="", name="csi.volume.8478902b-aeb0-4b66-b9cc-255cee15dcf2"): map[csi.imageid:37c6b30d6d09])
I0729 14:25:48.018970       1 utils.go:205] ID: 42 Req-ID: pvc-f95ec463-8a32-4de0-9f56-5862958a928c GRPC response: {"volume":{"capacity_bytes":10737418240,"volume_context":{"clusterID":"4837cbf8-4f90-4300-b3f6-726c9b9f89b4","imageFeatures":"layering","imageName":"csi-vol-8478902b-aeb0-4b66-b9cc-255cee15dcf2","journalPool":"kube","pool":"kube"},"volume_id":"0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-8478902b-aeb0-4b66-b9cc-255cee15dcf2"}}
I0729 14:26:43.129903       1 utils.go:198] ID: 43 GRPC call: /csi.v1.Identity/Probe
I0729 14:26:43.129940       1 utils.go:199] ID: 43 GRPC request: {}
I0729 14:26:43.129952       1 utils.go:205] ID: 43 GRPC response: {}
I0729 14:27:43.127984       1 utils.go:198] ID: 44 GRPC call: /csi.v1.Identity/Probe
I0729 14:27:43.128094       1 utils.go:199] ID: 44 GRPC request: {}
I0729 14:27:43.128131       1 utils.go:205] ID: 44 GRPC response: {}
I0729 14:28:43.095646       1 utils.go:198] ID: 45 GRPC call: /csi.v1.Identity/Probe
I0729 14:28:43.095694       1 utils.go:199] ID: 45 GRPC request: {}
I0729 14:28:43.095711       1 utils.go:205] ID: 45 GRPC response: {}
I0729 14:29:43.138814       1 utils.go:198] ID: 46 GRPC call: /csi.v1.Identity/Probe
I0729 14:29:43.138909       1 utils.go:199] ID: 46 GRPC request: {}
I0729 14:29:43.138990       1 utils.go:205] ID: 46 GRPC response: {}
I0729 14:30:43.095866       1 utils.go:198] ID: 47 GRPC call: /csi.v1.Identity/Probe
I0729 14:30:43.095918       1 utils.go:199] ID: 47 GRPC request: {}
I0729 14:30:43.095939       1 utils.go:205] ID: 47 GRPC response: {}
I0729 14:31:43.151394       1 utils.go:198] ID: 48 GRPC call: /csi.v1.Identity/Probe
I0729 14:31:43.151463       1 utils.go:199] ID: 48 GRPC request: {}
I0729 14:31:43.151494       1 utils.go:205] ID: 48 GRPC response: {}
I0729 14:32:43.150579       1 utils.go:198] ID: 49 GRPC call: /csi.v1.Identity/Probe
I0729 14:32:43.150656       1 utils.go:199] ID: 49 GRPC request: {}
I0729 14:32:43.151173       1 utils.go:205] ID: 49 GRPC response: {}
I0729 14:33:43.158279       1 utils.go:198] ID: 50 GRPC call: /csi.v1.Identity/Probe
I0729 14:33:43.158542       1 utils.go:199] ID: 50 GRPC request: {}
I0729 14:33:43.158601       1 utils.go:205] ID: 50 GRPC response: {}
I0729 14:34:43.096257       1 utils.go:198] ID: 51 GRPC call: /csi.v1.Identity/Probe
I0729 14:34:43.096306       1 utils.go:199] ID: 51 GRPC request: {}
I0729 14:34:43.096326       1 utils.go:205] ID: 51 GRPC response: {}
I0729 14:35:43.154577       1 utils.go:198] ID: 52 GRPC call: /csi.v1.Identity/Probe
I0729 14:35:43.154654       1 utils.go:199] ID: 52 GRPC request: {}
I0729 14:35:43.154679       1 utils.go:205] ID: 52 GRPC response: {}
I0729 14:36:43.096656       1 utils.go:198] ID: 53 GRPC call: /csi.v1.Identity/Probe
I0729 14:36:43.096720       1 utils.go:199] ID: 53 GRPC request: {}
I0729 14:36:43.096750       1 utils.go:205] ID: 53 GRPC response: {}
I0729 14:37:43.096325       1 utils.go:198] ID: 54 GRPC call: /csi.v1.Identity/Probe
I0729 14:37:43.096363       1 utils.go:199] ID: 54 GRPC request: {}
I0729 14:37:43.096412       1 utils.go:205] ID: 54 GRPC response: {}
I0729 14:38:43.108997       1 utils.go:198] ID: 55 GRPC call: /csi.v1.Identity/Probe
I0729 14:38:43.109138       1 utils.go:199] ID: 55 GRPC request: {}
I0729 14:38:43.109801       1 utils.go:205] ID: 55 GRPC response: {}
I0729 14:39:43.150596       1 utils.go:198] ID: 56 GRPC call: /csi.v1.Identity/Probe
I0729 14:39:43.150641       1 utils.go:199] ID: 56 GRPC request: {}
I0729 14:39:43.150657       1 utils.go:205] ID: 56 GRPC response: {}