I0730 21:08:03.662690       1 cephcsi.go:191] Driver version: v3.11.0 and Git version: bc24b5eca87626d690a29effa9d7420cc0154a7a
I0730 21:08:03.662826       1 cephcsi.go:223] Starting driver type: rbd with name: rbd.csi.ceph.com
I0730 21:08:03.662840       1 driver.go:95] Enabling controller service capability: CREATE_DELETE_VOLUME
I0730 21:08:03.662853       1 driver.go:95] Enabling controller service capability: CREATE_DELETE_SNAPSHOT
I0730 21:08:03.662857       1 driver.go:95] Enabling controller service capability: CLONE_VOLUME
I0730 21:08:03.662861       1 driver.go:95] Enabling controller service capability: EXPAND_VOLUME
I0730 21:08:03.662865       1 driver.go:108] Enabling volume access mode: SINGLE_NODE_WRITER
I0730 21:08:03.662868       1 driver.go:108] Enabling volume access mode: MULTI_NODE_MULTI_WRITER
I0730 21:08:03.662871       1 driver.go:108] Enabling volume access mode: SINGLE_NODE_SINGLE_WRITER
I0730 21:08:03.662874       1 driver.go:108] Enabling volume access mode: SINGLE_NODE_MULTI_WRITER
I0730 21:08:03.663120       1 server.go:117] Listening for connections on address: &net.UnixAddr{Name:"//csi/csi-provisioner.sock", Net:"unix"}
I0730 21:08:03.663159       1 server.go:114] listening for CSI-Addons requests on address: &net.UnixAddr{Name:"/csi/csi-addons.sock", Net:"unix"}
I0730 21:08:10.808863       1 utils.go:198] ID: 1 GRPC call: /csi.v1.Identity/Probe
I0730 21:08:10.810220       1 utils.go:199] ID: 1 GRPC request: {}
I0730 21:08:10.810285       1 utils.go:205] ID: 1 GRPC response: {}
I0730 21:08:10.812581       1 utils.go:198] ID: 2 GRPC call: /csi.v1.Identity/GetPluginInfo
I0730 21:08:10.812724       1 utils.go:199] ID: 2 GRPC request: {}
I0730 21:08:10.812762       1 identityserver-default.go:40] ID: 2 Using default GetPluginInfo
I0730 21:08:10.812855       1 utils.go:205] ID: 2 GRPC response: {"name":"rbd.csi.ceph.com","vendor_version":"v3.11.0"}
I0730 21:08:10.814460       1 utils.go:198] ID: 3 GRPC call: /csi.v1.Identity/Probe
I0730 21:08:10.814483       1 utils.go:199] ID: 3 GRPC request: {}
I0730 21:08:10.814495       1 utils.go:205] ID: 3 GRPC response: {}
I0730 21:08:10.814881       1 utils.go:198] ID: 4 GRPC call: /csi.v1.Identity/GetPluginCapabilities
I0730 21:08:10.814929       1 utils.go:199] ID: 4 GRPC request: {}
I0730 21:08:10.815075       1 utils.go:205] ID: 4 GRPC response: {"capabilities":[{"Type":{"Service":{"type":1}}},{"Type":{"VolumeExpansion":{"type":1}}},{"Type":{"Service":{"type":2}}}]}
I0730 21:08:10.816229       1 utils.go:198] ID: 5 GRPC call: /csi.v1.Controller/ControllerGetCapabilities
I0730 21:08:10.816339       1 utils.go:199] ID: 5 GRPC request: {}
I0730 21:08:10.816358       1 controllerserver-default.go:42] ID: 5 Using default ControllerGetCapabilities
I0730 21:08:10.816581       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:08:12.399446       1 utils.go:198] ID: 6 GRPC call: /csi.v1.Identity/Probe
I0730 21:08:12.399481       1 utils.go:199] ID: 6 GRPC request: {}
I0730 21:08:12.399500       1 utils.go:205] ID: 6 GRPC response: {}
I0730 21:08:12.402510       1 utils.go:198] ID: 7 GRPC call: /csi.v1.Identity/GetPluginInfo
I0730 21:08:12.402549       1 utils.go:199] ID: 7 GRPC request: {}
I0730 21:08:12.402560       1 identityserver-default.go:40] ID: 7 Using default GetPluginInfo
I0730 21:08:12.402595       1 utils.go:205] ID: 7 GRPC response: {"name":"rbd.csi.ceph.com","vendor_version":"v3.11.0"}
I0730 21:08:12.404809       1 utils.go:198] ID: 8 GRPC call: /csi.v1.Identity/Probe
I0730 21:08:12.404844       1 utils.go:199] ID: 8 GRPC request: {}
I0730 21:08:12.404867       1 utils.go:205] ID: 8 GRPC response: {}
I0730 21:08:12.405648       1 utils.go:198] ID: 9 GRPC call: /csi.v1.Identity/GetPluginCapabilities
I0730 21:08:12.405685       1 utils.go:199] ID: 9 GRPC request: {}
I0730 21:08:12.405792       1 utils.go:205] ID: 9 GRPC response: {"capabilities":[{"Type":{"Service":{"type":1}}},{"Type":{"VolumeExpansion":{"type":1}}},{"Type":{"Service":{"type":2}}}]}
I0730 21:08:12.406469       1 utils.go:198] ID: 10 GRPC call: /csi.v1.Controller/ControllerGetCapabilities
I0730 21:08:12.406486       1 utils.go:199] ID: 10 GRPC request: {}
I0730 21:08:12.406494       1 controllerserver-default.go:42] ID: 10 Using default ControllerGetCapabilities
I0730 21:08:12.406552       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:08:12.406981       1 utils.go:198] ID: 11 GRPC call: /csi.v1.Controller/ControllerGetCapabilities
I0730 21:08:12.406994       1 utils.go:199] ID: 11 GRPC request: {}
I0730 21:08:12.407000       1 controllerserver-default.go:42] ID: 11 Using default ControllerGetCapabilities
I0730 21:08:12.407054       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:08:12.407395       1 utils.go:198] ID: 12 GRPC call: /csi.v1.Controller/ControllerGetCapabilities
I0730 21:08:12.407413       1 utils.go:199] ID: 12 GRPC request: {}
I0730 21:08:12.407418       1 controllerserver-default.go:42] ID: 12 Using default ControllerGetCapabilities
I0730 21:08:12.407474       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:08:16.760104       1 utils.go:198] ID: 13 GRPC call: /csi.v1.Identity/GetPluginInfo
I0730 21:08:16.760153       1 utils.go:199] ID: 13 GRPC request: {}
I0730 21:08:16.760165       1 identityserver-default.go:40] ID: 13 Using default GetPluginInfo
I0730 21:08:16.760199       1 utils.go:205] ID: 13 GRPC response: {"name":"rbd.csi.ceph.com","vendor_version":"v3.11.0"}
I0730 21:08:16.763292       1 utils.go:198] ID: 14 GRPC call: /csi.v1.Identity/Probe
I0730 21:08:16.763310       1 utils.go:199] ID: 14 GRPC request: {}
I0730 21:08:16.763323       1 utils.go:205] ID: 14 GRPC response: {}
I0730 21:08:16.763790       1 utils.go:198] ID: 15 GRPC call: /csi.v1.Controller/ControllerGetCapabilities
I0730 21:08:16.763809       1 utils.go:199] ID: 15 GRPC request: {}
I0730 21:08:16.763817       1 controllerserver-default.go:42] ID: 15 Using default ControllerGetCapabilities
I0730 21:08:16.763891       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:08:18.394928       1 utils.go:198] ID: 16 GRPC call: /csi.v1.Identity/Probe
I0730 21:08:18.395139       1 utils.go:199] ID: 16 GRPC request: {}
I0730 21:08:18.395533       1 utils.go:205] ID: 16 GRPC response: {}
I0730 21:08:18.397642       1 utils.go:198] ID: 17 GRPC call: /csi.v1.Identity/GetPluginInfo
I0730 21:08:18.397678       1 utils.go:199] ID: 17 GRPC request: {}
I0730 21:08:18.397686       1 identityserver-default.go:40] ID: 17 Using default GetPluginInfo
I0730 21:08:18.397719       1 utils.go:205] ID: 17 GRPC response: {"name":"rbd.csi.ceph.com","vendor_version":"v3.11.0"}
I0730 21:08:18.399357       1 utils.go:198] ID: 18 GRPC call: /csi.v1.Identity/Probe
I0730 21:08:18.399377       1 utils.go:199] ID: 18 GRPC request: {}
I0730 21:08:18.399393       1 utils.go:205] ID: 18 GRPC response: {}
I0730 21:08:18.399821       1 utils.go:198] ID: 19 GRPC call: /csi.v1.Identity/GetPluginCapabilities
I0730 21:08:18.399882       1 utils.go:199] ID: 19 GRPC request: {}
I0730 21:08:18.400040       1 utils.go:205] ID: 19 GRPC response: {"capabilities":[{"Type":{"Service":{"type":1}}},{"Type":{"VolumeExpansion":{"type":1}}},{"Type":{"Service":{"type":2}}}]}
I0730 21:08:18.400620       1 utils.go:198] ID: 20 GRPC call: /csi.v1.Controller/ControllerGetCapabilities
I0730 21:08:18.400641       1 utils.go:199] ID: 20 GRPC request: {}
I0730 21:08:18.400648       1 controllerserver-default.go:42] ID: 20 Using default ControllerGetCapabilities
I0730 21:08:18.400772       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:08:59.570913       1 utils.go:198] ID: 21 Req-ID: pvc-d384d28a-1a42-4fcc-b574-4655e34039c4 GRPC call: /csi.v1.Controller/CreateVolume
I0730 21:08:59.571215       1 utils.go:199] ID: 21 Req-ID: pvc-d384d28a-1a42-4fcc-b574-4655e34039c4 GRPC request: {"capacity_range":{"required_bytes":171798691840},"name":"pvc-d384d28a-1a42-4fcc-b574-4655e34039c4","parameters":{"clusterID":"4837cbf8-4f90-4300-b3f6-726c9b9f89b4","csi.storage.k8s.io/pv/name":"pvc-d384d28a-1a42-4fcc-b574-4655e34039c4","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:08:59.571452       1 rbd_util.go:1315] ID: 21 Req-ID: pvc-d384d28a-1a42-4fcc-b574-4655e34039c4 setting disableInUseChecks: false image features: [layering] mounter: rbd
E0730 21:08:59.590426       1 omap.go:80] ID: 21 Req-ID: pvc-d384d28a-1a42-4fcc-b574-4655e34039c4 omap not found (pool="kube", namespace="", name="csi.volumes.default"): rados: ret=-2, No such file or directory
I0730 21:08:59.608390       1 omap.go:159] ID: 21 Req-ID: pvc-d384d28a-1a42-4fcc-b574-4655e34039c4 set omap keys (pool="kube", namespace="", name="csi.volumes.default"): map[csi.volume.pvc-d384d28a-1a42-4fcc-b574-4655e34039c4:584094da-e330-4b06-83a6-621d6b6d4480])
I0730 21:08:59.614595       1 omap.go:159] ID: 21 Req-ID: pvc-d384d28a-1a42-4fcc-b574-4655e34039c4 set omap keys (pool="kube", namespace="", name="csi.volume.584094da-e330-4b06-83a6-621d6b6d4480"): map[csi.imagename:csi-vol-584094da-e330-4b06-83a6-621d6b6d4480 csi.volname:pvc-d384d28a-1a42-4fcc-b574-4655e34039c4 csi.volume.owner:openstack])
I0730 21:08:59.614648       1 rbd_journal.go:491] ID: 21 Req-ID: pvc-d384d28a-1a42-4fcc-b574-4655e34039c4 generated Volume ID (0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-584094da-e330-4b06-83a6-621d6b6d4480) and image name (csi-vol-584094da-e330-4b06-83a6-621d6b6d4480) for request name (pvc-d384d28a-1a42-4fcc-b574-4655e34039c4)
I0730 21:08:59.614742       1 rbd_util.go:423] ID: 21 Req-ID: pvc-d384d28a-1a42-4fcc-b574-4655e34039c4 rbd: create kube/csi-vol-584094da-e330-4b06-83a6-621d6b6d4480 size 163840M (features: [layering]) using mon 10.96.240.200
I0730 21:08:59.614821       1 rbd_util.go:1563] ID: 21 Req-ID: pvc-d384d28a-1a42-4fcc-b574-4655e34039c4 setting image options on kube/csi-vol-584094da-e330-4b06-83a6-621d6b6d4480
I0730 21:08:59.643642       1 controllerserver.go:763] ID: 21 Req-ID: pvc-d384d28a-1a42-4fcc-b574-4655e34039c4 created image kube/csi-vol-584094da-e330-4b06-83a6-621d6b6d4480 backed for request name pvc-d384d28a-1a42-4fcc-b574-4655e34039c4
I0730 21:08:59.679952       1 omap.go:159] ID: 21 Req-ID: pvc-d384d28a-1a42-4fcc-b574-4655e34039c4 set omap keys (pool="kube", namespace="", name="csi.volume.584094da-e330-4b06-83a6-621d6b6d4480"): map[csi.imageid:37c6d1896f71])
I0730 21:08:59.770173       1 utils.go:205] ID: 21 Req-ID: pvc-d384d28a-1a42-4fcc-b574-4655e34039c4 GRPC response: {"volume":{"capacity_bytes":171798691840,"volume_context":{"clusterID":"4837cbf8-4f90-4300-b3f6-726c9b9f89b4","imageFeatures":"layering","imageName":"csi-vol-584094da-e330-4b06-83a6-621d6b6d4480","journalPool":"kube","pool":"kube"},"volume_id":"0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-584094da-e330-4b06-83a6-621d6b6d4480"}}
I0730 21:09:18.607588       1 utils.go:198] ID: 22 GRPC call: /csi.v1.Identity/Probe
I0730 21:09:18.607682       1 utils.go:199] ID: 22 GRPC request: {}
I0730 21:09:18.607714       1 utils.go:205] ID: 22 GRPC response: {}
I0730 21:10:18.570340       1 utils.go:198] ID: 23 GRPC call: /csi.v1.Identity/Probe
I0730 21:10:18.570418       1 utils.go:199] ID: 23 GRPC request: {}
I0730 21:10:18.570443       1 utils.go:205] ID: 23 GRPC response: {}
I0730 21:11:18.622054       1 utils.go:198] ID: 24 GRPC call: /csi.v1.Identity/Probe
I0730 21:11:18.622121       1 utils.go:199] ID: 24 GRPC request: {}
I0730 21:11:18.622148       1 utils.go:205] ID: 24 GRPC response: {}
I0730 21:12:18.579773       1 utils.go:198] ID: 25 GRPC call: /csi.v1.Identity/Probe
I0730 21:12:18.579845       1 utils.go:199] ID: 25 GRPC request: {}
I0730 21:12:18.579871       1 utils.go:205] ID: 25 GRPC response: {}
I0730 21:13:18.622057       1 utils.go:198] ID: 26 GRPC call: /csi.v1.Identity/Probe
I0730 21:13:18.622121       1 utils.go:199] ID: 26 GRPC request: {}
I0730 21:13:18.622145       1 utils.go:205] ID: 26 GRPC response: {}
I0730 21:14:18.590140       1 utils.go:198] ID: 27 GRPC call: /csi.v1.Identity/Probe
I0730 21:14:18.590224       1 utils.go:199] ID: 27 GRPC request: {}
I0730 21:14:18.590252       1 utils.go:205] ID: 27 GRPC response: {}
I0730 21:15:18.608890       1 utils.go:198] ID: 28 GRPC call: /csi.v1.Identity/Probe
I0730 21:15:18.608944       1 utils.go:199] ID: 28 GRPC request: {}
I0730 21:15:18.608967       1 utils.go:205] ID: 28 GRPC response: {}
I0730 21:16:18.600540       1 utils.go:198] ID: 29 GRPC call: /csi.v1.Identity/Probe
I0730 21:16:18.600626       1 utils.go:199] ID: 29 GRPC request: {}
I0730 21:16:18.600648       1 utils.go:205] ID: 29 GRPC response: {}
I0730 21:17:18.568565       1 utils.go:198] ID: 30 GRPC call: /csi.v1.Identity/Probe
I0730 21:17:18.568662       1 utils.go:199] ID: 30 GRPC request: {}
I0730 21:17:18.568796       1 utils.go:205] ID: 30 GRPC response: {}
I0730 21:18:18.609462       1 utils.go:198] ID: 31 GRPC call: /csi.v1.Identity/Probe
I0730 21:18:18.609583       1 utils.go:199] ID: 31 GRPC request: {}
I0730 21:18:18.609634       1 utils.go:205] ID: 31 GRPC response: {}
I0730 21:18:40.724570       1 utils.go:198] ID: 32 Req-ID: pvc-b3980e17-9b6b-4797-9c4e-f68e09a0c836 GRPC call: /csi.v1.Controller/CreateVolume
I0730 21:18:40.724874       1 utils.go:199] ID: 32 Req-ID: pvc-b3980e17-9b6b-4797-9c4e-f68e09a0c836 GRPC request: {"capacity_range":{"required_bytes":10737418240},"name":"pvc-b3980e17-9b6b-4797-9c4e-f68e09a0c836","parameters":{"clusterID":"4837cbf8-4f90-4300-b3f6-726c9b9f89b4","csi.storage.k8s.io/pv/name":"pvc-b3980e17-9b6b-4797-9c4e-f68e09a0c836","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:18:40.725144       1 rbd_util.go:1315] ID: 32 Req-ID: pvc-b3980e17-9b6b-4797-9c4e-f68e09a0c836 setting disableInUseChecks: false image features: [layering] mounter: rbd
I0730 21:18:40.726645       1 omap.go:89] ID: 32 Req-ID: pvc-b3980e17-9b6b-4797-9c4e-f68e09a0c836 got omap values: (pool="kube", namespace="", name="csi.volumes.default"): map[]
I0730 21:18:40.742309       1 omap.go:159] ID: 32 Req-ID: pvc-b3980e17-9b6b-4797-9c4e-f68e09a0c836 set omap keys (pool="kube", namespace="", name="csi.volumes.default"): map[csi.volume.pvc-b3980e17-9b6b-4797-9c4e-f68e09a0c836:aafa4ef5-2b96-4c10-bae4-a7bc6cd95f6f])
I0730 21:18:40.749855       1 omap.go:159] ID: 32 Req-ID: pvc-b3980e17-9b6b-4797-9c4e-f68e09a0c836 set omap keys (pool="kube", namespace="", name="csi.volume.aafa4ef5-2b96-4c10-bae4-a7bc6cd95f6f"): map[csi.imagename:csi-vol-aafa4ef5-2b96-4c10-bae4-a7bc6cd95f6f csi.volname:pvc-b3980e17-9b6b-4797-9c4e-f68e09a0c836 csi.volume.owner:openstack])
I0730 21:18:40.749883       1 rbd_journal.go:491] ID: 32 Req-ID: pvc-b3980e17-9b6b-4797-9c4e-f68e09a0c836 generated Volume ID (0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-aafa4ef5-2b96-4c10-bae4-a7bc6cd95f6f) and image name (csi-vol-aafa4ef5-2b96-4c10-bae4-a7bc6cd95f6f) for request name (pvc-b3980e17-9b6b-4797-9c4e-f68e09a0c836)
I0730 21:18:40.749965       1 rbd_util.go:423] ID: 32 Req-ID: pvc-b3980e17-9b6b-4797-9c4e-f68e09a0c836 rbd: create kube/csi-vol-aafa4ef5-2b96-4c10-bae4-a7bc6cd95f6f size 10240M (features: [layering]) using mon 10.96.240.200
I0730 21:18:40.750000       1 rbd_util.go:1563] ID: 32 Req-ID: pvc-b3980e17-9b6b-4797-9c4e-f68e09a0c836 setting image options on kube/csi-vol-aafa4ef5-2b96-4c10-bae4-a7bc6cd95f6f
I0730 21:18:40.778241       1 controllerserver.go:763] ID: 32 Req-ID: pvc-b3980e17-9b6b-4797-9c4e-f68e09a0c836 created image kube/csi-vol-aafa4ef5-2b96-4c10-bae4-a7bc6cd95f6f backed for request name pvc-b3980e17-9b6b-4797-9c4e-f68e09a0c836
I0730 21:18:40.812737       1 omap.go:159] ID: 32 Req-ID: pvc-b3980e17-9b6b-4797-9c4e-f68e09a0c836 set omap keys (pool="kube", namespace="", name="csi.volume.aafa4ef5-2b96-4c10-bae4-a7bc6cd95f6f"): map[csi.imageid:37c6e451bee0])
I0730 21:18:40.916640       1 utils.go:205] ID: 32 Req-ID: pvc-b3980e17-9b6b-4797-9c4e-f68e09a0c836 GRPC response: {"volume":{"capacity_bytes":10737418240,"volume_context":{"clusterID":"4837cbf8-4f90-4300-b3f6-726c9b9f89b4","imageFeatures":"layering","imageName":"csi-vol-aafa4ef5-2b96-4c10-bae4-a7bc6cd95f6f","journalPool":"kube","pool":"kube"},"volume_id":"0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-aafa4ef5-2b96-4c10-bae4-a7bc6cd95f6f"}}
I0730 21:19:18.568581       1 utils.go:198] ID: 33 GRPC call: /csi.v1.Identity/Probe
I0730 21:19:18.568637       1 utils.go:199] ID: 33 GRPC request: {}
I0730 21:19:18.568660       1 utils.go:205] ID: 33 GRPC response: {}
I0730 21:20:18.592187       1 utils.go:198] ID: 34 GRPC call: /csi.v1.Identity/Probe
I0730 21:20:18.592239       1 utils.go:199] ID: 34 GRPC request: {}
I0730 21:20:18.592262       1 utils.go:205] ID: 34 GRPC response: {}
I0730 21:21:18.569847       1 utils.go:198] ID: 35 GRPC call: /csi.v1.Identity/Probe
I0730 21:21:18.569894       1 utils.go:199] ID: 35 GRPC request: {}
I0730 21:21:18.569911       1 utils.go:205] ID: 35 GRPC response: {}
I0730 21:22:18.568504       1 utils.go:198] ID: 36 GRPC call: /csi.v1.Identity/Probe
I0730 21:22:18.568555       1 utils.go:199] ID: 36 GRPC request: {}
I0730 21:22:18.568572       1 utils.go:205] ID: 36 GRPC response: {}
I0730 21:22:40.717283       1 utils.go:198] ID: 37 Req-ID: pvc-9f82fa64-e9b3-4fa4-9e52-a6bbb8329215 GRPC call: /csi.v1.Controller/CreateVolume
I0730 21:22:40.717819       1 utils.go:199] ID: 37 Req-ID: pvc-9f82fa64-e9b3-4fa4-9e52-a6bbb8329215 GRPC request: {"capacity_range":{"required_bytes":10737418240},"name":"pvc-9f82fa64-e9b3-4fa4-9e52-a6bbb8329215","parameters":{"clusterID":"4837cbf8-4f90-4300-b3f6-726c9b9f89b4","csi.storage.k8s.io/pv/name":"pvc-9f82fa64-e9b3-4fa4-9e52-a6bbb8329215","csi.storage.k8s.io/pvc/name":"persistence-rabbitmq-barbican-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:40.718009       1 rbd_util.go:1315] ID: 37 Req-ID: pvc-9f82fa64-e9b3-4fa4-9e52-a6bbb8329215 setting disableInUseChecks: false image features: [layering] mounter: rbd
I0730 21:22:40.722345       1 omap.go:89] ID: 37 Req-ID: pvc-9f82fa64-e9b3-4fa4-9e52-a6bbb8329215 got omap values: (pool="kube", namespace="", name="csi.volumes.default"): map[]
I0730 21:22:40.742715       1 omap.go:159] ID: 37 Req-ID: pvc-9f82fa64-e9b3-4fa4-9e52-a6bbb8329215 set omap keys (pool="kube", namespace="", name="csi.volumes.default"): map[csi.volume.pvc-9f82fa64-e9b3-4fa4-9e52-a6bbb8329215:5fb628f7-efb5-4ce8-9655-6b95f09cac76])
I0730 21:22:40.749842       1 omap.go:159] ID: 37 Req-ID: pvc-9f82fa64-e9b3-4fa4-9e52-a6bbb8329215 set omap keys (pool="kube", namespace="", name="csi.volume.5fb628f7-efb5-4ce8-9655-6b95f09cac76"): map[csi.imagename:csi-vol-5fb628f7-efb5-4ce8-9655-6b95f09cac76 csi.volname:pvc-9f82fa64-e9b3-4fa4-9e52-a6bbb8329215 csi.volume.owner:openstack])
I0730 21:22:40.749871       1 rbd_journal.go:491] ID: 37 Req-ID: pvc-9f82fa64-e9b3-4fa4-9e52-a6bbb8329215 generated Volume ID (0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-5fb628f7-efb5-4ce8-9655-6b95f09cac76) and image name (csi-vol-5fb628f7-efb5-4ce8-9655-6b95f09cac76) for request name (pvc-9f82fa64-e9b3-4fa4-9e52-a6bbb8329215)
I0730 21:22:40.749942       1 rbd_util.go:423] ID: 37 Req-ID: pvc-9f82fa64-e9b3-4fa4-9e52-a6bbb8329215 rbd: create kube/csi-vol-5fb628f7-efb5-4ce8-9655-6b95f09cac76 size 10240M (features: [layering]) using mon 10.96.240.200
I0730 21:22:40.749983       1 rbd_util.go:1563] ID: 37 Req-ID: pvc-9f82fa64-e9b3-4fa4-9e52-a6bbb8329215 setting image options on kube/csi-vol-5fb628f7-efb5-4ce8-9655-6b95f09cac76
I0730 21:22:40.778643       1 controllerserver.go:763] ID: 37 Req-ID: pvc-9f82fa64-e9b3-4fa4-9e52-a6bbb8329215 created image kube/csi-vol-5fb628f7-efb5-4ce8-9655-6b95f09cac76 backed for request name pvc-9f82fa64-e9b3-4fa4-9e52-a6bbb8329215
I0730 21:22:40.810056       1 omap.go:159] ID: 37 Req-ID: pvc-9f82fa64-e9b3-4fa4-9e52-a6bbb8329215 set omap keys (pool="kube", namespace="", name="csi.volume.5fb628f7-efb5-4ce8-9655-6b95f09cac76"): map[csi.imageid:37c6a4b1a2a9])
I0730 21:22:40.905673       1 utils.go:205] ID: 37 Req-ID: pvc-9f82fa64-e9b3-4fa4-9e52-a6bbb8329215 GRPC response: {"volume":{"capacity_bytes":10737418240,"volume_context":{"clusterID":"4837cbf8-4f90-4300-b3f6-726c9b9f89b4","imageFeatures":"layering","imageName":"csi-vol-5fb628f7-efb5-4ce8-9655-6b95f09cac76","journalPool":"kube","pool":"kube"},"volume_id":"0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-5fb628f7-efb5-4ce8-9655-6b95f09cac76"}}
I0730 21:23:18.575329       1 utils.go:198] ID: 38 GRPC call: /csi.v1.Identity/Probe
I0730 21:23:18.575377       1 utils.go:199] ID: 38 GRPC request: {}
I0730 21:23:18.575393       1 utils.go:205] ID: 38 GRPC response: {}
I0730 21:24:18.568503       1 utils.go:198] ID: 39 GRPC call: /csi.v1.Identity/Probe
I0730 21:24:18.568551       1 utils.go:199] ID: 39 GRPC request: {}
I0730 21:24:18.568573       1 utils.go:205] ID: 39 GRPC response: {}
I0730 21:25:18.580464       1 utils.go:198] ID: 40 GRPC call: /csi.v1.Identity/Probe
I0730 21:25:18.580518       1 utils.go:199] ID: 40 GRPC request: {}
I0730 21:25:18.580536       1 utils.go:205] ID: 40 GRPC response: {}
I0730 21:26:18.615160       1 utils.go:198] ID: 41 GRPC call: /csi.v1.Identity/Probe
I0730 21:26:18.615222       1 utils.go:199] ID: 41 GRPC request: {}
I0730 21:26:18.615238       1 utils.go:205] ID: 41 GRPC response: {}
I0730 21:27:18.573224       1 utils.go:198] ID: 42 GRPC call: /csi.v1.Identity/Probe
I0730 21:27:18.573275       1 utils.go:199] ID: 42 GRPC request: {}
I0730 21:27:18.573298       1 utils.go:205] ID: 42 GRPC response: {}
I0730 21:28:18.569488       1 utils.go:198] ID: 43 GRPC call: /csi.v1.Identity/Probe
I0730 21:28:18.569563       1 utils.go:199] ID: 43 GRPC request: {}
I0730 21:28:18.569646       1 utils.go:205] ID: 43 GRPC response: {}
I0730 21:29:18.589959       1 utils.go:198] ID: 44 GRPC call: /csi.v1.Identity/Probe
I0730 21:29:18.590068       1 utils.go:199] ID: 44 GRPC request: {}
I0730 21:29:18.590102       1 utils.go:205] ID: 44 GRPC response: {}
I0730 21:30:18.570060       1 utils.go:198] ID: 45 GRPC call: /csi.v1.Identity/Probe
I0730 21:30:18.570143       1 utils.go:199] ID: 45 GRPC request: {}
I0730 21:30:18.570165       1 utils.go:205] ID: 45 GRPC response: {}
I0730 21:31:18.569185       1 utils.go:198] ID: 46 GRPC call: /csi.v1.Identity/Probe
I0730 21:31:18.569320       1 utils.go:199] ID: 46 GRPC request: {}
I0730 21:31:18.569395       1 utils.go:205] ID: 46 GRPC response: {}
I0730 21:32:18.579249       1 utils.go:198] ID: 47 GRPC call: /csi.v1.Identity/Probe
I0730 21:32:18.579305       1 utils.go:199] ID: 47 GRPC request: {}
I0730 21:32:18.579327       1 utils.go:205] ID: 47 GRPC response: {}
I0730 21:33:18.622201       1 utils.go:198] ID: 48 GRPC call: /csi.v1.Identity/Probe
I0730 21:33:18.622268       1 utils.go:199] ID: 48 GRPC request: {}
I0730 21:33:18.622288       1 utils.go:205] ID: 48 GRPC response: {}
I0730 21:34:18.577541       1 utils.go:198] ID: 49 GRPC call: /csi.v1.Identity/Probe
I0730 21:34:18.577598       1 utils.go:199] ID: 49 GRPC request: {}
I0730 21:34:18.577619       1 utils.go:205] ID: 49 GRPC response: {}
I0730 21:35:18.569794       1 utils.go:198] ID: 50 GRPC call: /csi.v1.Identity/Probe
I0730 21:35:18.569847       1 utils.go:199] ID: 50 GRPC request: {}
I0730 21:35:18.569964       1 utils.go:205] ID: 50 GRPC response: {}