I0730 21:12:07.005233       1 cephcsi.go:191] Driver version: v3.11.0 and Git version: bc24b5eca87626d690a29effa9d7420cc0154a7a
I0730 21:12:07.005402       1 cephcsi.go:223] Starting driver type: rbd with name: rbd.csi.ceph.com
I0730 21:12:07.005423       1 driver.go:95] Enabling controller service capability: CREATE_DELETE_VOLUME
I0730 21:12:07.005428       1 driver.go:95] Enabling controller service capability: CREATE_DELETE_SNAPSHOT
I0730 21:12:07.005432       1 driver.go:95] Enabling controller service capability: CLONE_VOLUME
I0730 21:12:07.005436       1 driver.go:95] Enabling controller service capability: EXPAND_VOLUME
I0730 21:12:07.005442       1 driver.go:108] Enabling volume access mode: SINGLE_NODE_WRITER
I0730 21:12:07.005446       1 driver.go:108] Enabling volume access mode: MULTI_NODE_MULTI_WRITER
I0730 21:12:07.005449       1 driver.go:108] Enabling volume access mode: SINGLE_NODE_SINGLE_WRITER
I0730 21:12:07.005452       1 driver.go:108] Enabling volume access mode: SINGLE_NODE_MULTI_WRITER
I0730 21:12:07.005780       1 server.go:117] Listening for connections on address: &net.UnixAddr{Name:"//csi/csi-provisioner.sock", Net:"unix"}
I0730 21:12:07.005856       1 server.go:114] listening for CSI-Addons requests on address: &net.UnixAddr{Name:"/csi/csi-addons.sock", Net:"unix"}
I0730 21:12:15.104604       1 utils.go:198] ID: 1 GRPC call: /csi.v1.Identity/Probe
I0730 21:12:15.106769       1 utils.go:199] ID: 1 GRPC request: {}
I0730 21:12:15.106859       1 utils.go:205] ID: 1 GRPC response: {}
I0730 21:12:15.111978       1 utils.go:198] ID: 2 GRPC call: /csi.v1.Identity/GetPluginInfo
I0730 21:12:15.112579       1 utils.go:199] ID: 2 GRPC request: {}
I0730 21:12:15.112618       1 identityserver-default.go:40] ID: 2 Using default GetPluginInfo
I0730 21:12:15.112781       1 utils.go:205] ID: 2 GRPC response: {"name":"rbd.csi.ceph.com","vendor_version":"v3.11.0"}
I0730 21:12:15.115155       1 utils.go:198] ID: 3 GRPC call: /csi.v1.Identity/Probe
I0730 21:12:15.115204       1 utils.go:199] ID: 3 GRPC request: {}
I0730 21:12:15.115244       1 utils.go:205] ID: 3 GRPC response: {}
I0730 21:12:15.115953       1 utils.go:198] ID: 4 GRPC call: /csi.v1.Identity/GetPluginCapabilities
I0730 21:12:15.116055       1 utils.go:199] ID: 4 GRPC request: {}
I0730 21:12:15.116346       1 utils.go:205] ID: 4 GRPC response: {"capabilities":[{"Type":{"Service":{"type":1}}},{"Type":{"VolumeExpansion":{"type":1}}},{"Type":{"Service":{"type":2}}}]}
I0730 21:12:15.117404       1 utils.go:198] ID: 5 GRPC call: /csi.v1.Controller/ControllerGetCapabilities
I0730 21:12:15.117459       1 utils.go:199] ID: 5 GRPC request: {}
I0730 21:12:15.117470       1 controllerserver-default.go:42] ID: 5 Using default ControllerGetCapabilities
I0730 21:12:15.117663       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:12:16.897761       1 utils.go:198] ID: 6 GRPC call: /csi.v1.Identity/Probe
I0730 21:12:16.897909       1 utils.go:199] ID: 6 GRPC request: {}
I0730 21:12:16.897943       1 utils.go:205] ID: 6 GRPC response: {}
I0730 21:12:16.900561       1 utils.go:198] ID: 7 GRPC call: /csi.v1.Identity/GetPluginInfo
I0730 21:12:16.900588       1 utils.go:199] ID: 7 GRPC request: {}
I0730 21:12:16.900598       1 identityserver-default.go:40] ID: 7 Using default GetPluginInfo
I0730 21:12:16.900626       1 utils.go:205] ID: 7 GRPC response: {"name":"rbd.csi.ceph.com","vendor_version":"v3.11.0"}
I0730 21:12:16.904705       1 utils.go:198] ID: 8 GRPC call: /csi.v1.Identity/Probe
I0730 21:12:16.904765       1 utils.go:199] ID: 8 GRPC request: {}
I0730 21:12:16.904805       1 utils.go:205] ID: 8 GRPC response: {}
I0730 21:12:16.905745       1 utils.go:198] ID: 9 GRPC call: /csi.v1.Identity/GetPluginCapabilities
I0730 21:12:16.905803       1 utils.go:199] ID: 9 GRPC request: {}
I0730 21:12:16.905987       1 utils.go:205] ID: 9 GRPC response: {"capabilities":[{"Type":{"Service":{"type":1}}},{"Type":{"VolumeExpansion":{"type":1}}},{"Type":{"Service":{"type":2}}}]}
I0730 21:12:16.906825       1 utils.go:198] ID: 10 GRPC call: /csi.v1.Controller/ControllerGetCapabilities
I0730 21:12:16.906859       1 utils.go:199] ID: 10 GRPC request: {}
I0730 21:12:16.906878       1 controllerserver-default.go:42] ID: 10 Using default ControllerGetCapabilities
I0730 21:12:16.906986       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:12:16.907558       1 utils.go:198] ID: 11 GRPC call: /csi.v1.Controller/ControllerGetCapabilities
I0730 21:12:16.907594       1 utils.go:199] ID: 11 GRPC request: {}
I0730 21:12:16.907608       1 controllerserver-default.go:42] ID: 11 Using default ControllerGetCapabilities
I0730 21:12:16.907779       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:12:16.908372       1 utils.go:198] ID: 12 GRPC call: /csi.v1.Controller/ControllerGetCapabilities
I0730 21:12:16.908418       1 utils.go:199] ID: 12 GRPC request: {}
I0730 21:12:16.908427       1 controllerserver-default.go:42] ID: 12 Using default ControllerGetCapabilities
I0730 21:12:16.908516       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:12:19.915221       1 utils.go:198] ID: 13 GRPC call: /csi.v1.Identity/GetPluginInfo
I0730 21:12:19.915277       1 utils.go:199] ID: 13 GRPC request: {}
I0730 21:12:19.915290       1 identityserver-default.go:40] ID: 13 Using default GetPluginInfo
I0730 21:12:19.915327       1 utils.go:205] ID: 13 GRPC response: {"name":"rbd.csi.ceph.com","vendor_version":"v3.11.0"}
I0730 21:12:19.919889       1 utils.go:198] ID: 14 GRPC call: /csi.v1.Identity/Probe
I0730 21:12:19.919932       1 utils.go:199] ID: 14 GRPC request: {}
I0730 21:12:19.919953       1 utils.go:205] ID: 14 GRPC response: {}
I0730 21:12:19.920379       1 utils.go:198] ID: 15 GRPC call: /csi.v1.Controller/ControllerGetCapabilities
I0730 21:12:19.920398       1 utils.go:199] ID: 15 GRPC request: {}
I0730 21:12:19.920407       1 controllerserver-default.go:42] ID: 15 Using default ControllerGetCapabilities
I0730 21:12:19.920693       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:12:21.682706       1 utils.go:198] ID: 16 GRPC call: /csi.v1.Identity/Probe
I0730 21:12:21.682755       1 utils.go:199] ID: 16 GRPC request: {}
I0730 21:12:21.682778       1 utils.go:205] ID: 16 GRPC response: {}
I0730 21:12:21.685865       1 utils.go:198] ID: 17 GRPC call: /csi.v1.Identity/GetPluginInfo
I0730 21:12:21.685945       1 utils.go:199] ID: 17 GRPC request: {}
I0730 21:12:21.685956       1 identityserver-default.go:40] ID: 17 Using default GetPluginInfo
I0730 21:12:21.685991       1 utils.go:205] ID: 17 GRPC response: {"name":"rbd.csi.ceph.com","vendor_version":"v3.11.0"}
I0730 21:12:21.688406       1 utils.go:198] ID: 18 GRPC call: /csi.v1.Identity/Probe
I0730 21:12:21.688460       1 utils.go:199] ID: 18 GRPC request: {}
I0730 21:12:21.688486       1 utils.go:205] ID: 18 GRPC response: {}
I0730 21:12:21.689086       1 utils.go:198] ID: 19 GRPC call: /csi.v1.Identity/GetPluginCapabilities
I0730 21:12:21.689116       1 utils.go:199] ID: 19 GRPC request: {}
I0730 21:12:21.689243       1 utils.go:205] ID: 19 GRPC response: {"capabilities":[{"Type":{"Service":{"type":1}}},{"Type":{"VolumeExpansion":{"type":1}}},{"Type":{"Service":{"type":2}}}]}
I0730 21:12:21.692150       1 utils.go:198] ID: 20 GRPC call: /csi.v1.Controller/ControllerGetCapabilities
I0730 21:12:21.692179       1 utils.go:199] ID: 20 GRPC request: {}
I0730 21:12:21.692192       1 controllerserver-default.go:42] ID: 20 Using default ControllerGetCapabilities
I0730 21:12:21.692352       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:13:16.339680       1 utils.go:198] ID: 21 Req-ID: pvc-f8e67079-0fcd-4e0b-862b-df875a49e045 GRPC call: /csi.v1.Controller/CreateVolume
I0730 21:13:16.340438       1 utils.go:199] ID: 21 Req-ID: pvc-f8e67079-0fcd-4e0b-862b-df875a49e045 GRPC request: {"capacity_range":{"required_bytes":171798691840},"name":"pvc-f8e67079-0fcd-4e0b-862b-df875a49e045","parameters":{"clusterID":"4837cbf8-4f90-4300-b3f6-726c9b9f89b4","csi.storage.k8s.io/pv/name":"pvc-f8e67079-0fcd-4e0b-862b-df875a49e045","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:13:16.340790       1 rbd_util.go:1315] ID: 21 Req-ID: pvc-f8e67079-0fcd-4e0b-862b-df875a49e045 setting disableInUseChecks: false image features: [layering] mounter: rbd
E0730 21:13:16.359185       1 omap.go:80] ID: 21 Req-ID: pvc-f8e67079-0fcd-4e0b-862b-df875a49e045 omap not found (pool="kube", namespace="", name="csi.volumes.default"): rados: ret=-2, No such file or directory
I0730 21:13:16.379188       1 omap.go:159] ID: 21 Req-ID: pvc-f8e67079-0fcd-4e0b-862b-df875a49e045 set omap keys (pool="kube", namespace="", name="csi.volumes.default"): map[csi.volume.pvc-f8e67079-0fcd-4e0b-862b-df875a49e045:98cc51c6-927a-4ecb-8997-1706c7f32faa])
I0730 21:13:16.388742       1 omap.go:159] ID: 21 Req-ID: pvc-f8e67079-0fcd-4e0b-862b-df875a49e045 set omap keys (pool="kube", namespace="", name="csi.volume.98cc51c6-927a-4ecb-8997-1706c7f32faa"): map[csi.imagename:csi-vol-98cc51c6-927a-4ecb-8997-1706c7f32faa csi.volname:pvc-f8e67079-0fcd-4e0b-862b-df875a49e045 csi.volume.owner:openstack])
I0730 21:13:16.388855       1 rbd_journal.go:491] ID: 21 Req-ID: pvc-f8e67079-0fcd-4e0b-862b-df875a49e045 generated Volume ID (0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-98cc51c6-927a-4ecb-8997-1706c7f32faa) and image name (csi-vol-98cc51c6-927a-4ecb-8997-1706c7f32faa) for request name (pvc-f8e67079-0fcd-4e0b-862b-df875a49e045)
I0730 21:13:16.388960       1 rbd_util.go:423] ID: 21 Req-ID: pvc-f8e67079-0fcd-4e0b-862b-df875a49e045 rbd: create kube/csi-vol-98cc51c6-927a-4ecb-8997-1706c7f32faa size 163840M (features: [layering]) using mon 10.96.240.200
I0730 21:13:16.389013       1 rbd_util.go:1563] ID: 21 Req-ID: pvc-f8e67079-0fcd-4e0b-862b-df875a49e045 setting image options on kube/csi-vol-98cc51c6-927a-4ecb-8997-1706c7f32faa
I0730 21:13:16.426246       1 controllerserver.go:763] ID: 21 Req-ID: pvc-f8e67079-0fcd-4e0b-862b-df875a49e045 created image kube/csi-vol-98cc51c6-927a-4ecb-8997-1706c7f32faa backed for request name pvc-f8e67079-0fcd-4e0b-862b-df875a49e045
I0730 21:13:16.463104       1 omap.go:159] ID: 21 Req-ID: pvc-f8e67079-0fcd-4e0b-862b-df875a49e045 set omap keys (pool="kube", namespace="", name="csi.volume.98cc51c6-927a-4ecb-8997-1706c7f32faa"): map[csi.imageid:37c62ad42fee])
I0730 21:13:16.564526       1 utils.go:205] ID: 21 Req-ID: pvc-f8e67079-0fcd-4e0b-862b-df875a49e045 GRPC response: {"volume":{"capacity_bytes":171798691840,"volume_context":{"clusterID":"4837cbf8-4f90-4300-b3f6-726c9b9f89b4","imageFeatures":"layering","imageName":"csi-vol-98cc51c6-927a-4ecb-8997-1706c7f32faa","journalPool":"kube","pool":"kube"},"volume_id":"0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-98cc51c6-927a-4ecb-8997-1706c7f32faa"}}
I0730 21:13:21.861825       1 utils.go:198] ID: 22 GRPC call: /csi.v1.Identity/Probe
I0730 21:13:21.861900       1 utils.go:199] ID: 22 GRPC request: {}
I0730 21:13:21.861925       1 utils.go:205] ID: 22 GRPC response: {}
I0730 21:14:21.861991       1 utils.go:198] ID: 23 GRPC call: /csi.v1.Identity/Probe
I0730 21:14:21.862062       1 utils.go:199] ID: 23 GRPC request: {}
I0730 21:14:21.862090       1 utils.go:205] ID: 23 GRPC response: {}
I0730 21:15:21.916117       1 utils.go:198] ID: 24 GRPC call: /csi.v1.Identity/Probe
I0730 21:15:21.916206       1 utils.go:199] ID: 24 GRPC request: {}
I0730 21:15:21.916232       1 utils.go:205] ID: 24 GRPC response: {}
I0730 21:16:21.861835       1 utils.go:198] ID: 25 GRPC call: /csi.v1.Identity/Probe
I0730 21:16:21.861892       1 utils.go:199] ID: 25 GRPC request: {}
I0730 21:16:21.861914       1 utils.go:205] ID: 25 GRPC response: {}
I0730 21:17:21.861845       1 utils.go:198] ID: 26 GRPC call: /csi.v1.Identity/Probe
I0730 21:17:21.862044       1 utils.go:199] ID: 26 GRPC request: {}
I0730 21:17:21.862261       1 utils.go:205] ID: 26 GRPC response: {}
I0730 21:18:21.862295       1 utils.go:198] ID: 27 GRPC call: /csi.v1.Identity/Probe
I0730 21:18:21.862359       1 utils.go:199] ID: 27 GRPC request: {}
I0730 21:18:21.862421       1 utils.go:205] ID: 27 GRPC response: {}
I0730 21:19:21.872041       1 utils.go:198] ID: 28 GRPC call: /csi.v1.Identity/Probe
I0730 21:19:21.872097       1 utils.go:199] ID: 28 GRPC request: {}
I0730 21:19:21.872120       1 utils.go:205] ID: 28 GRPC response: {}
I0730 21:20:21.861257       1 utils.go:198] ID: 29 GRPC call: /csi.v1.Identity/Probe
I0730 21:20:21.861306       1 utils.go:199] ID: 29 GRPC request: {}
I0730 21:20:21.861338       1 utils.go:205] ID: 29 GRPC response: {}
I0730 21:21:21.883890       1 utils.go:198] ID: 30 GRPC call: /csi.v1.Identity/Probe
I0730 21:21:21.883950       1 utils.go:199] ID: 30 GRPC request: {}
I0730 21:21:21.883973       1 utils.go:205] ID: 30 GRPC response: {}
I0730 21:22:21.861360       1 utils.go:198] ID: 31 GRPC call: /csi.v1.Identity/Probe
I0730 21:22:21.861417       1 utils.go:199] ID: 31 GRPC request: {}
I0730 21:22:21.861440       1 utils.go:205] ID: 31 GRPC response: {}
I0730 21:23:21.892630       1 utils.go:198] ID: 32 GRPC call: /csi.v1.Identity/Probe
I0730 21:23:21.892699       1 utils.go:199] ID: 32 GRPC request: {}
I0730 21:23:21.892724       1 utils.go:205] ID: 32 GRPC response: {}
I0730 21:24:21.916183       1 utils.go:198] ID: 33 GRPC call: /csi.v1.Identity/Probe
I0730 21:24:21.916235       1 utils.go:199] ID: 33 GRPC request: {}
I0730 21:24:21.916255       1 utils.go:205] ID: 33 GRPC response: {}
I0730 21:24:24.979952       1 utils.go:198] ID: 34 Req-ID: pvc-64cb0efe-9748-4b46-86e6-32028a81c6bb GRPC call: /csi.v1.Controller/CreateVolume
I0730 21:24:24.980413       1 utils.go:199] ID: 34 Req-ID: pvc-64cb0efe-9748-4b46-86e6-32028a81c6bb GRPC request: {"capacity_range":{"required_bytes":10737418240},"name":"pvc-64cb0efe-9748-4b46-86e6-32028a81c6bb","parameters":{"clusterID":"4837cbf8-4f90-4300-b3f6-726c9b9f89b4","csi.storage.k8s.io/pv/name":"pvc-64cb0efe-9748-4b46-86e6-32028a81c6bb","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:24:24.980759       1 rbd_util.go:1315] ID: 34 Req-ID: pvc-64cb0efe-9748-4b46-86e6-32028a81c6bb setting disableInUseChecks: false image features: [layering] mounter: rbd
I0730 21:24:24.982581       1 omap.go:89] ID: 34 Req-ID: pvc-64cb0efe-9748-4b46-86e6-32028a81c6bb got omap values: (pool="kube", namespace="", name="csi.volumes.default"): map[]
I0730 21:24:24.997390       1 omap.go:159] ID: 34 Req-ID: pvc-64cb0efe-9748-4b46-86e6-32028a81c6bb set omap keys (pool="kube", namespace="", name="csi.volumes.default"): map[csi.volume.pvc-64cb0efe-9748-4b46-86e6-32028a81c6bb:1f983259-8788-49a4-999f-abfc7b056464])
I0730 21:24:25.003603       1 omap.go:159] ID: 34 Req-ID: pvc-64cb0efe-9748-4b46-86e6-32028a81c6bb set omap keys (pool="kube", namespace="", name="csi.volume.1f983259-8788-49a4-999f-abfc7b056464"): map[csi.imagename:csi-vol-1f983259-8788-49a4-999f-abfc7b056464 csi.volname:pvc-64cb0efe-9748-4b46-86e6-32028a81c6bb csi.volume.owner:openstack])
I0730 21:24:25.003633       1 rbd_journal.go:491] ID: 34 Req-ID: pvc-64cb0efe-9748-4b46-86e6-32028a81c6bb generated Volume ID (0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-1f983259-8788-49a4-999f-abfc7b056464) and image name (csi-vol-1f983259-8788-49a4-999f-abfc7b056464) for request name (pvc-64cb0efe-9748-4b46-86e6-32028a81c6bb)
I0730 21:24:25.003715       1 rbd_util.go:423] ID: 34 Req-ID: pvc-64cb0efe-9748-4b46-86e6-32028a81c6bb rbd: create kube/csi-vol-1f983259-8788-49a4-999f-abfc7b056464 size 10240M (features: [layering]) using mon 10.96.240.200
I0730 21:24:25.003772       1 rbd_util.go:1563] ID: 34 Req-ID: pvc-64cb0efe-9748-4b46-86e6-32028a81c6bb setting image options on kube/csi-vol-1f983259-8788-49a4-999f-abfc7b056464
I0730 21:24:25.034076       1 controllerserver.go:763] ID: 34 Req-ID: pvc-64cb0efe-9748-4b46-86e6-32028a81c6bb created image kube/csi-vol-1f983259-8788-49a4-999f-abfc7b056464 backed for request name pvc-64cb0efe-9748-4b46-86e6-32028a81c6bb
I0730 21:24:25.066750       1 omap.go:159] ID: 34 Req-ID: pvc-64cb0efe-9748-4b46-86e6-32028a81c6bb set omap keys (pool="kube", namespace="", name="csi.volume.1f983259-8788-49a4-999f-abfc7b056464"): map[csi.imageid:37c679ce76f6])
I0730 21:24:25.200095       1 utils.go:205] ID: 34 Req-ID: pvc-64cb0efe-9748-4b46-86e6-32028a81c6bb GRPC response: {"volume":{"capacity_bytes":10737418240,"volume_context":{"clusterID":"4837cbf8-4f90-4300-b3f6-726c9b9f89b4","imageFeatures":"layering","imageName":"csi-vol-1f983259-8788-49a4-999f-abfc7b056464","journalPool":"kube","pool":"kube"},"volume_id":"0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-1f983259-8788-49a4-999f-abfc7b056464"}}
I0730 21:25:21.902527       1 utils.go:198] ID: 35 GRPC call: /csi.v1.Identity/Probe
I0730 21:25:21.902581       1 utils.go:199] ID: 35 GRPC request: {}
I0730 21:25:21.902599       1 utils.go:205] ID: 35 GRPC response: {}
I0730 21:26:21.915505       1 utils.go:198] ID: 36 GRPC call: /csi.v1.Identity/Probe
I0730 21:26:21.915560       1 utils.go:199] ID: 36 GRPC request: {}
I0730 21:26:21.915582       1 utils.go:205] ID: 36 GRPC response: {}
I0730 21:27:21.909313       1 utils.go:198] ID: 37 GRPC call: /csi.v1.Identity/Probe
I0730 21:27:21.909368       1 utils.go:199] ID: 37 GRPC request: {}
I0730 21:27:21.909386       1 utils.go:205] ID: 37 GRPC response: {}
I0730 21:28:21.861397       1 utils.go:198] ID: 38 GRPC call: /csi.v1.Identity/Probe
I0730 21:28:21.861450       1 utils.go:199] ID: 38 GRPC request: {}
I0730 21:28:21.861472       1 utils.go:205] ID: 38 GRPC response: {}
I0730 21:28:38.124057       1 utils.go:198] ID: 39 Req-ID: pvc-2ba97f85-bd74-4e45-bf37-2c3e17a76c6e GRPC call: /csi.v1.Controller/CreateVolume
I0730 21:28:38.124257       1 utils.go:199] ID: 39 Req-ID: pvc-2ba97f85-bd74-4e45-bf37-2c3e17a76c6e GRPC request: {"capacity_range":{"required_bytes":10737418240},"name":"pvc-2ba97f85-bd74-4e45-bf37-2c3e17a76c6e","parameters":{"clusterID":"4837cbf8-4f90-4300-b3f6-726c9b9f89b4","csi.storage.k8s.io/pv/name":"pvc-2ba97f85-bd74-4e45-bf37-2c3e17a76c6e","csi.storage.k8s.io/pvc/name":"persistence-rabbitmq-glance-server-0","csi.storage.k8s.io/pvc/namespace":"openstack","imageFeatures":"layering","pool":"kube"},"secrets":"***stripped***","volume_capabilities":[{"AccessType":{"Mount":{"fs_type":"ext4","mount_flags":["discard"]}},"access_mode":{"mode":1}}]}
I0730 21:28:38.124406       1 rbd_util.go:1315] ID: 39 Req-ID: pvc-2ba97f85-bd74-4e45-bf37-2c3e17a76c6e setting disableInUseChecks: false image features: [layering] mounter: rbd
I0730 21:28:38.126229       1 omap.go:89] ID: 39 Req-ID: pvc-2ba97f85-bd74-4e45-bf37-2c3e17a76c6e got omap values: (pool="kube", namespace="", name="csi.volumes.default"): map[]
I0730 21:28:38.141958       1 omap.go:159] ID: 39 Req-ID: pvc-2ba97f85-bd74-4e45-bf37-2c3e17a76c6e set omap keys (pool="kube", namespace="", name="csi.volumes.default"): map[csi.volume.pvc-2ba97f85-bd74-4e45-bf37-2c3e17a76c6e:fb4c4c2a-ba30-42d8-b7ea-7276c4d4edf0])
I0730 21:28:38.149234       1 omap.go:159] ID: 39 Req-ID: pvc-2ba97f85-bd74-4e45-bf37-2c3e17a76c6e set omap keys (pool="kube", namespace="", name="csi.volume.fb4c4c2a-ba30-42d8-b7ea-7276c4d4edf0"): map[csi.imagename:csi-vol-fb4c4c2a-ba30-42d8-b7ea-7276c4d4edf0 csi.volname:pvc-2ba97f85-bd74-4e45-bf37-2c3e17a76c6e csi.volume.owner:openstack])
I0730 21:28:38.149310       1 rbd_journal.go:491] ID: 39 Req-ID: pvc-2ba97f85-bd74-4e45-bf37-2c3e17a76c6e generated Volume ID (0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-fb4c4c2a-ba30-42d8-b7ea-7276c4d4edf0) and image name (csi-vol-fb4c4c2a-ba30-42d8-b7ea-7276c4d4edf0) for request name (pvc-2ba97f85-bd74-4e45-bf37-2c3e17a76c6e)
I0730 21:28:38.149395       1 rbd_util.go:423] ID: 39 Req-ID: pvc-2ba97f85-bd74-4e45-bf37-2c3e17a76c6e rbd: create kube/csi-vol-fb4c4c2a-ba30-42d8-b7ea-7276c4d4edf0 size 10240M (features: [layering]) using mon 10.96.240.200
I0730 21:28:38.149436       1 rbd_util.go:1563] ID: 39 Req-ID: pvc-2ba97f85-bd74-4e45-bf37-2c3e17a76c6e setting image options on kube/csi-vol-fb4c4c2a-ba30-42d8-b7ea-7276c4d4edf0
I0730 21:28:38.183776       1 controllerserver.go:763] ID: 39 Req-ID: pvc-2ba97f85-bd74-4e45-bf37-2c3e17a76c6e created image kube/csi-vol-fb4c4c2a-ba30-42d8-b7ea-7276c4d4edf0 backed for request name pvc-2ba97f85-bd74-4e45-bf37-2c3e17a76c6e
I0730 21:28:38.217918       1 omap.go:159] ID: 39 Req-ID: pvc-2ba97f85-bd74-4e45-bf37-2c3e17a76c6e set omap keys (pool="kube", namespace="", name="csi.volume.fb4c4c2a-ba30-42d8-b7ea-7276c4d4edf0"): map[csi.imageid:37c61f0845b9])
I0730 21:28:38.319653       1 utils.go:205] ID: 39 Req-ID: pvc-2ba97f85-bd74-4e45-bf37-2c3e17a76c6e GRPC response: {"volume":{"capacity_bytes":10737418240,"volume_context":{"clusterID":"4837cbf8-4f90-4300-b3f6-726c9b9f89b4","imageFeatures":"layering","imageName":"csi-vol-fb4c4c2a-ba30-42d8-b7ea-7276c4d4edf0","journalPool":"kube","pool":"kube"},"volume_id":"0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-fb4c4c2a-ba30-42d8-b7ea-7276c4d4edf0"}}
I0730 21:29:21.915347       1 utils.go:198] ID: 40 GRPC call: /csi.v1.Identity/Probe
I0730 21:29:21.915423       1 utils.go:199] ID: 40 GRPC request: {}
I0730 21:29:21.915476       1 utils.go:205] ID: 40 GRPC response: {}
I0730 21:30:21.862046       1 utils.go:198] ID: 41 GRPC call: /csi.v1.Identity/Probe
I0730 21:30:21.862144       1 utils.go:199] ID: 41 GRPC request: {}
I0730 21:30:21.862167       1 utils.go:205] ID: 41 GRPC response: {}
I0730 21:31:21.867144       1 utils.go:198] ID: 42 GRPC call: /csi.v1.Identity/Probe
I0730 21:31:21.867190       1 utils.go:199] ID: 42 GRPC request: {}
I0730 21:31:21.867210       1 utils.go:205] ID: 42 GRPC response: {}
I0730 21:32:21.867207       1 utils.go:198] ID: 43 GRPC call: /csi.v1.Identity/Probe
I0730 21:32:21.867265       1 utils.go:199] ID: 43 GRPC request: {}
I0730 21:32:21.867287       1 utils.go:205] ID: 43 GRPC response: {}
I0730 21:33:21.914459       1 utils.go:198] ID: 44 GRPC call: /csi.v1.Identity/Probe
I0730 21:33:21.914527       1 utils.go:199] ID: 44 GRPC request: {}
I0730 21:33:21.914549       1 utils.go:205] ID: 44 GRPC response: {}
I0730 21:34:21.872618       1 utils.go:198] ID: 45 GRPC call: /csi.v1.Identity/Probe
I0730 21:34:21.874151       1 utils.go:199] ID: 45 GRPC request: {}
I0730 21:34:21.874193       1 utils.go:205] ID: 45 GRPC response: {}
I0730 21:35:21.914440       1 utils.go:198] ID: 46 GRPC call: /csi.v1.Identity/Probe
I0730 21:35:21.914493       1 utils.go:199] ID: 46 GRPC request: {}
I0730 21:35:21.914528       1 utils.go:205] ID: 46 GRPC response: {}
I0730 21:35:57.324111       1 utils.go:198] ID: 47 Req-ID: pvc-1ed797cc-202e-4e15-8ad4-0a095e5ae4d3 GRPC call: /csi.v1.Controller/CreateVolume
I0730 21:35:57.324325       1 utils.go:199] ID: 47 Req-ID: pvc-1ed797cc-202e-4e15-8ad4-0a095e5ae4d3 GRPC request: {"capacity_range":{"required_bytes":21474836480},"name":"pvc-1ed797cc-202e-4e15-8ad4-0a095e5ae4d3","parameters":{"clusterID":"4837cbf8-4f90-4300-b3f6-726c9b9f89b4","csi.storage.k8s.io/pv/name":"pvc-1ed797cc-202e-4e15-8ad4-0a095e5ae4d3","csi.storage.k8s.io/pvc/name":"data-ovn-ovsdb-sb-0","csi.storage.k8s.io/pvc/namespace":"openstack","imageFeatures":"layering","pool":"kube"},"secrets":"***stripped***","volume_capabilities":[{"AccessType":{"Mount":{"fs_type":"ext4","mount_flags":["discard"]}},"access_mode":{"mode":1}}]}
I0730 21:35:57.324472       1 rbd_util.go:1315] ID: 47 Req-ID: pvc-1ed797cc-202e-4e15-8ad4-0a095e5ae4d3 setting disableInUseChecks: false image features: [layering] mounter: rbd
I0730 21:35:57.327786       1 omap.go:89] ID: 47 Req-ID: pvc-1ed797cc-202e-4e15-8ad4-0a095e5ae4d3 got omap values: (pool="kube", namespace="", name="csi.volumes.default"): map[]
I0730 21:35:57.329463       1 utils.go:198] ID: 48 Req-ID: pvc-62a6a3a1-42a5-41bf-b229-1872f6b0e5ec GRPC call: /csi.v1.Controller/CreateVolume
I0730 21:35:57.329823       1 utils.go:199] ID: 48 Req-ID: pvc-62a6a3a1-42a5-41bf-b229-1872f6b0e5ec GRPC request: {"capacity_range":{"required_bytes":21474836480},"name":"pvc-62a6a3a1-42a5-41bf-b229-1872f6b0e5ec","parameters":{"clusterID":"4837cbf8-4f90-4300-b3f6-726c9b9f89b4","csi.storage.k8s.io/pv/name":"pvc-62a6a3a1-42a5-41bf-b229-1872f6b0e5ec","csi.storage.k8s.io/pvc/name":"data-ovn-ovsdb-nb-0","csi.storage.k8s.io/pvc/namespace":"openstack","imageFeatures":"layering","pool":"kube"},"secrets":"***stripped***","volume_capabilities":[{"AccessType":{"Mount":{"fs_type":"ext4","mount_flags":["discard"]}},"access_mode":{"mode":1}}]}
I0730 21:35:57.330037       1 rbd_util.go:1315] ID: 48 Req-ID: pvc-62a6a3a1-42a5-41bf-b229-1872f6b0e5ec setting disableInUseChecks: false image features: [layering] mounter: rbd
I0730 21:35:57.333535       1 omap.go:89] ID: 48 Req-ID: pvc-62a6a3a1-42a5-41bf-b229-1872f6b0e5ec got omap values: (pool="kube", namespace="", name="csi.volumes.default"): map[]
I0730 21:35:57.347301       1 omap.go:159] ID: 47 Req-ID: pvc-1ed797cc-202e-4e15-8ad4-0a095e5ae4d3 set omap keys (pool="kube", namespace="", name="csi.volumes.default"): map[csi.volume.pvc-1ed797cc-202e-4e15-8ad4-0a095e5ae4d3:bc99a661-5b9e-4822-a7b1-ed6a4340cfb2])
I0730 21:35:57.358603       1 omap.go:159] ID: 48 Req-ID: pvc-62a6a3a1-42a5-41bf-b229-1872f6b0e5ec set omap keys (pool="kube", namespace="", name="csi.volumes.default"): map[csi.volume.pvc-62a6a3a1-42a5-41bf-b229-1872f6b0e5ec:dd8b7936-87b5-476f-b44d-eb834d8b1565])
I0730 21:35:57.360505       1 omap.go:159] ID: 47 Req-ID: pvc-1ed797cc-202e-4e15-8ad4-0a095e5ae4d3 set omap keys (pool="kube", namespace="", name="csi.volume.bc99a661-5b9e-4822-a7b1-ed6a4340cfb2"): map[csi.imagename:csi-vol-bc99a661-5b9e-4822-a7b1-ed6a4340cfb2 csi.volname:pvc-1ed797cc-202e-4e15-8ad4-0a095e5ae4d3 csi.volume.owner:openstack])
I0730 21:35:57.360544       1 rbd_journal.go:491] ID: 47 Req-ID: pvc-1ed797cc-202e-4e15-8ad4-0a095e5ae4d3 generated Volume ID (0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-bc99a661-5b9e-4822-a7b1-ed6a4340cfb2) and image name (csi-vol-bc99a661-5b9e-4822-a7b1-ed6a4340cfb2) for request name (pvc-1ed797cc-202e-4e15-8ad4-0a095e5ae4d3)
I0730 21:35:57.360638       1 rbd_util.go:423] ID: 47 Req-ID: pvc-1ed797cc-202e-4e15-8ad4-0a095e5ae4d3 rbd: create kube/csi-vol-bc99a661-5b9e-4822-a7b1-ed6a4340cfb2 size 20480M (features: [layering]) using mon 10.96.240.200
I0730 21:35:57.360681       1 rbd_util.go:1563] ID: 47 Req-ID: pvc-1ed797cc-202e-4e15-8ad4-0a095e5ae4d3 setting image options on kube/csi-vol-bc99a661-5b9e-4822-a7b1-ed6a4340cfb2
I0730 21:35:57.366268       1 omap.go:159] ID: 48 Req-ID: pvc-62a6a3a1-42a5-41bf-b229-1872f6b0e5ec set omap keys (pool="kube", namespace="", name="csi.volume.dd8b7936-87b5-476f-b44d-eb834d8b1565"): map[csi.imagename:csi-vol-dd8b7936-87b5-476f-b44d-eb834d8b1565 csi.volname:pvc-62a6a3a1-42a5-41bf-b229-1872f6b0e5ec csi.volume.owner:openstack])
I0730 21:35:57.366295       1 rbd_journal.go:491] ID: 48 Req-ID: pvc-62a6a3a1-42a5-41bf-b229-1872f6b0e5ec generated Volume ID (0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-dd8b7936-87b5-476f-b44d-eb834d8b1565) and image name (csi-vol-dd8b7936-87b5-476f-b44d-eb834d8b1565) for request name (pvc-62a6a3a1-42a5-41bf-b229-1872f6b0e5ec)
I0730 21:35:57.366527       1 rbd_util.go:423] ID: 48 Req-ID: pvc-62a6a3a1-42a5-41bf-b229-1872f6b0e5ec rbd: create kube/csi-vol-dd8b7936-87b5-476f-b44d-eb834d8b1565 size 20480M (features: [layering]) using mon 10.96.240.200
I0730 21:35:57.366553       1 rbd_util.go:1563] ID: 48 Req-ID: pvc-62a6a3a1-42a5-41bf-b229-1872f6b0e5ec setting image options on kube/csi-vol-dd8b7936-87b5-476f-b44d-eb834d8b1565
I0730 21:35:57.398356       1 controllerserver.go:763] ID: 47 Req-ID: pvc-1ed797cc-202e-4e15-8ad4-0a095e5ae4d3 created image kube/csi-vol-bc99a661-5b9e-4822-a7b1-ed6a4340cfb2 backed for request name pvc-1ed797cc-202e-4e15-8ad4-0a095e5ae4d3
I0730 21:35:57.416933       1 controllerserver.go:763] ID: 48 Req-ID: pvc-62a6a3a1-42a5-41bf-b229-1872f6b0e5ec created image kube/csi-vol-dd8b7936-87b5-476f-b44d-eb834d8b1565 backed for request name pvc-62a6a3a1-42a5-41bf-b229-1872f6b0e5ec
I0730 21:35:57.449258       1 omap.go:159] ID: 47 Req-ID: pvc-1ed797cc-202e-4e15-8ad4-0a095e5ae4d3 set omap keys (pool="kube", namespace="", name="csi.volume.bc99a661-5b9e-4822-a7b1-ed6a4340cfb2"): map[csi.imageid:37c6eae05c44])
I0730 21:35:57.462452       1 omap.go:159] ID: 48 Req-ID: pvc-62a6a3a1-42a5-41bf-b229-1872f6b0e5ec set omap keys (pool="kube", namespace="", name="csi.volume.dd8b7936-87b5-476f-b44d-eb834d8b1565"): map[csi.imageid:37c6b26bc6d5])
I0730 21:35:57.566900       1 utils.go:205] ID: 47 Req-ID: pvc-1ed797cc-202e-4e15-8ad4-0a095e5ae4d3 GRPC response: {"volume":{"capacity_bytes":21474836480,"volume_context":{"clusterID":"4837cbf8-4f90-4300-b3f6-726c9b9f89b4","imageFeatures":"layering","imageName":"csi-vol-bc99a661-5b9e-4822-a7b1-ed6a4340cfb2","journalPool":"kube","pool":"kube"},"volume_id":"0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-bc99a661-5b9e-4822-a7b1-ed6a4340cfb2"}}
I0730 21:35:57.590803       1 utils.go:205] ID: 48 Req-ID: pvc-62a6a3a1-42a5-41bf-b229-1872f6b0e5ec GRPC response: {"volume":{"capacity_bytes":21474836480,"volume_context":{"clusterID":"4837cbf8-4f90-4300-b3f6-726c9b9f89b4","imageFeatures":"layering","imageName":"csi-vol-dd8b7936-87b5-476f-b44d-eb834d8b1565","journalPool":"kube","pool":"kube"},"volume_id":"0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-dd8b7936-87b5-476f-b44d-eb834d8b1565"}}
I0730 21:36:09.309659       1 utils.go:198] ID: 49 Req-ID: pvc-74091842-f67b-4bd4-9047-27bc4eaf7afe GRPC call: /csi.v1.Controller/CreateVolume
I0730 21:36:09.309863       1 utils.go:199] ID: 49 Req-ID: pvc-74091842-f67b-4bd4-9047-27bc4eaf7afe GRPC request: {"capacity_range":{"required_bytes":10737418240},"name":"pvc-74091842-f67b-4bd4-9047-27bc4eaf7afe","parameters":{"clusterID":"4837cbf8-4f90-4300-b3f6-726c9b9f89b4","csi.storage.k8s.io/pv/name":"pvc-74091842-f67b-4bd4-9047-27bc4eaf7afe","csi.storage.k8s.io/pvc/name":"persistence-rabbitmq-nova-server-0","csi.storage.k8s.io/pvc/namespace":"openstack","imageFeatures":"layering","pool":"kube"},"secrets":"***stripped***","volume_capabilities":[{"AccessType":{"Mount":{"fs_type":"ext4","mount_flags":["discard"]}},"access_mode":{"mode":1}}]}
I0730 21:36:09.310155       1 rbd_util.go:1315] ID: 49 Req-ID: pvc-74091842-f67b-4bd4-9047-27bc4eaf7afe setting disableInUseChecks: false image features: [layering] mounter: rbd
I0730 21:36:09.313312       1 omap.go:89] ID: 49 Req-ID: pvc-74091842-f67b-4bd4-9047-27bc4eaf7afe got omap values: (pool="kube", namespace="", name="csi.volumes.default"): map[]
I0730 21:36:09.336890       1 omap.go:159] ID: 49 Req-ID: pvc-74091842-f67b-4bd4-9047-27bc4eaf7afe set omap keys (pool="kube", namespace="", name="csi.volumes.default"): map[csi.volume.pvc-74091842-f67b-4bd4-9047-27bc4eaf7afe:904d33f1-8498-48d5-96d8-8c76d073cdc5])
I0730 21:36:09.346604       1 omap.go:159] ID: 49 Req-ID: pvc-74091842-f67b-4bd4-9047-27bc4eaf7afe set omap keys (pool="kube", namespace="", name="csi.volume.904d33f1-8498-48d5-96d8-8c76d073cdc5"): map[csi.imagename:csi-vol-904d33f1-8498-48d5-96d8-8c76d073cdc5 csi.volname:pvc-74091842-f67b-4bd4-9047-27bc4eaf7afe csi.volume.owner:openstack])
I0730 21:36:09.346636       1 rbd_journal.go:491] ID: 49 Req-ID: pvc-74091842-f67b-4bd4-9047-27bc4eaf7afe generated Volume ID (0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-904d33f1-8498-48d5-96d8-8c76d073cdc5) and image name (csi-vol-904d33f1-8498-48d5-96d8-8c76d073cdc5) for request name (pvc-74091842-f67b-4bd4-9047-27bc4eaf7afe)
I0730 21:36:09.346765       1 rbd_util.go:423] ID: 49 Req-ID: pvc-74091842-f67b-4bd4-9047-27bc4eaf7afe rbd: create kube/csi-vol-904d33f1-8498-48d5-96d8-8c76d073cdc5 size 10240M (features: [layering]) using mon 10.96.240.200
I0730 21:36:09.346800       1 rbd_util.go:1563] ID: 49 Req-ID: pvc-74091842-f67b-4bd4-9047-27bc4eaf7afe setting image options on kube/csi-vol-904d33f1-8498-48d5-96d8-8c76d073cdc5
I0730 21:36:09.382554       1 controllerserver.go:763] ID: 49 Req-ID: pvc-74091842-f67b-4bd4-9047-27bc4eaf7afe created image kube/csi-vol-904d33f1-8498-48d5-96d8-8c76d073cdc5 backed for request name pvc-74091842-f67b-4bd4-9047-27bc4eaf7afe
I0730 21:36:09.419492       1 omap.go:159] ID: 49 Req-ID: pvc-74091842-f67b-4bd4-9047-27bc4eaf7afe set omap keys (pool="kube", namespace="", name="csi.volume.904d33f1-8498-48d5-96d8-8c76d073cdc5"): map[csi.imageid:37c6b02e2571])
I0730 21:36:10.962373       1 utils.go:205] ID: 49 Req-ID: pvc-74091842-f67b-4bd4-9047-27bc4eaf7afe GRPC response: {"volume":{"capacity_bytes":10737418240,"volume_context":{"clusterID":"4837cbf8-4f90-4300-b3f6-726c9b9f89b4","imageFeatures":"layering","imageName":"csi-vol-904d33f1-8498-48d5-96d8-8c76d073cdc5","journalPool":"kube","pool":"kube"},"volume_id":"0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-904d33f1-8498-48d5-96d8-8c76d073cdc5"}}
I0730 21:36:21.882800       1 utils.go:198] ID: 50 GRPC call: /csi.v1.Identity/Probe
I0730 21:36:21.882936       1 utils.go:199] ID: 50 GRPC request: {}
I0730 21:36:21.882984       1 utils.go:205] ID: 50 GRPC response: {}
I0730 21:37:21.861338       1 utils.go:198] ID: 51 GRPC call: /csi.v1.Identity/Probe
I0730 21:37:21.861485       1 utils.go:199] ID: 51 GRPC request: {}
I0730 21:37:21.861581       1 utils.go:205] ID: 51 GRPC response: {}
I0730 21:38:21.892185       1 utils.go:198] ID: 52 GRPC call: /csi.v1.Identity/Probe
I0730 21:38:21.892245       1 utils.go:199] ID: 52 GRPC request: {}
I0730 21:38:21.892267       1 utils.go:205] ID: 52 GRPC response: {}
I0730 21:39:21.861455       1 utils.go:198] ID: 53 GRPC call: /csi.v1.Identity/Probe
I0730 21:39:21.861529       1 utils.go:199] ID: 53 GRPC request: {}
I0730 21:39:21.861559       1 utils.go:205] ID: 53 GRPC response: {}
I0730 21:40:21.902186       1 utils.go:198] ID: 54 GRPC call: /csi.v1.Identity/Probe
I0730 21:40:21.902248       1 utils.go:199] ID: 54 GRPC request: {}
I0730 21:40:21.902270       1 utils.go:205] ID: 54 GRPC response: {}
I0730 21:41:21.861344       1 utils.go:198] ID: 55 GRPC call: /csi.v1.Identity/Probe
I0730 21:41:21.861407       1 utils.go:199] ID: 55 GRPC request: {}
I0730 21:41:21.861436       1 utils.go:205] ID: 55 GRPC response: {}
I0730 21:42:21.915340       1 utils.go:198] ID: 56 GRPC call: /csi.v1.Identity/Probe
I0730 21:42:21.915420       1 utils.go:199] ID: 56 GRPC request: {}
I0730 21:42:21.915446       1 utils.go:205] ID: 56 GRPC response: {}
I0730 21:43:21.861216       1 utils.go:198] ID: 57 GRPC call: /csi.v1.Identity/Probe
I0730 21:43:21.861279       1 utils.go:199] ID: 57 GRPC request: {}
I0730 21:43:21.861301       1 utils.go:205] ID: 57 GRPC response: {}
I0730 21:43:32.296751       1 utils.go:198] ID: 58 Req-ID: pvc-9e7e105d-88eb-4266-b2f1-c9eba4dde5ab GRPC call: /csi.v1.Controller/CreateVolume
I0730 21:43:32.296998       1 utils.go:199] ID: 58 Req-ID: pvc-9e7e105d-88eb-4266-b2f1-c9eba4dde5ab GRPC request: {"capacity_range":{"required_bytes":10737418240},"name":"pvc-9e7e105d-88eb-4266-b2f1-c9eba4dde5ab","parameters":{"clusterID":"4837cbf8-4f90-4300-b3f6-726c9b9f89b4","csi.storage.k8s.io/pv/name":"pvc-9e7e105d-88eb-4266-b2f1-c9eba4dde5ab","csi.storage.k8s.io/pvc/name":"persistence-rabbitmq-neutron-server-0","csi.storage.k8s.io/pvc/namespace":"openstack","imageFeatures":"layering","pool":"kube"},"secrets":"***stripped***","volume_capabilities":[{"AccessType":{"Mount":{"fs_type":"ext4","mount_flags":["discard"]}},"access_mode":{"mode":1}}]}
I0730 21:43:32.297370       1 rbd_util.go:1315] ID: 58 Req-ID: pvc-9e7e105d-88eb-4266-b2f1-c9eba4dde5ab setting disableInUseChecks: false image features: [layering] mounter: rbd
I0730 21:43:32.299895       1 omap.go:89] ID: 58 Req-ID: pvc-9e7e105d-88eb-4266-b2f1-c9eba4dde5ab got omap values: (pool="kube", namespace="", name="csi.volumes.default"): map[]
I0730 21:43:32.314386       1 omap.go:159] ID: 58 Req-ID: pvc-9e7e105d-88eb-4266-b2f1-c9eba4dde5ab set omap keys (pool="kube", namespace="", name="csi.volumes.default"): map[csi.volume.pvc-9e7e105d-88eb-4266-b2f1-c9eba4dde5ab:942d4261-b025-4709-b2a9-cd1d3e633089])
I0730 21:43:32.322748       1 omap.go:159] ID: 58 Req-ID: pvc-9e7e105d-88eb-4266-b2f1-c9eba4dde5ab set omap keys (pool="kube", namespace="", name="csi.volume.942d4261-b025-4709-b2a9-cd1d3e633089"): map[csi.imagename:csi-vol-942d4261-b025-4709-b2a9-cd1d3e633089 csi.volname:pvc-9e7e105d-88eb-4266-b2f1-c9eba4dde5ab csi.volume.owner:openstack])
I0730 21:43:32.322800       1 rbd_journal.go:491] ID: 58 Req-ID: pvc-9e7e105d-88eb-4266-b2f1-c9eba4dde5ab generated Volume ID (0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-942d4261-b025-4709-b2a9-cd1d3e633089) and image name (csi-vol-942d4261-b025-4709-b2a9-cd1d3e633089) for request name (pvc-9e7e105d-88eb-4266-b2f1-c9eba4dde5ab)
I0730 21:43:32.322963       1 rbd_util.go:423] ID: 58 Req-ID: pvc-9e7e105d-88eb-4266-b2f1-c9eba4dde5ab rbd: create kube/csi-vol-942d4261-b025-4709-b2a9-cd1d3e633089 size 10240M (features: [layering]) using mon 10.96.240.200
I0730 21:43:32.323197       1 rbd_util.go:1563] ID: 58 Req-ID: pvc-9e7e105d-88eb-4266-b2f1-c9eba4dde5ab setting image options on kube/csi-vol-942d4261-b025-4709-b2a9-cd1d3e633089
I0730 21:43:32.356561       1 controllerserver.go:763] ID: 58 Req-ID: pvc-9e7e105d-88eb-4266-b2f1-c9eba4dde5ab created image kube/csi-vol-942d4261-b025-4709-b2a9-cd1d3e633089 backed for request name pvc-9e7e105d-88eb-4266-b2f1-c9eba4dde5ab
I0730 21:43:32.394381       1 omap.go:159] ID: 58 Req-ID: pvc-9e7e105d-88eb-4266-b2f1-c9eba4dde5ab set omap keys (pool="kube", namespace="", name="csi.volume.942d4261-b025-4709-b2a9-cd1d3e633089"): map[csi.imageid:37c6a59d4074])
I0730 21:43:32.501979       1 utils.go:205] ID: 58 Req-ID: pvc-9e7e105d-88eb-4266-b2f1-c9eba4dde5ab GRPC response: {"volume":{"capacity_bytes":10737418240,"volume_context":{"clusterID":"4837cbf8-4f90-4300-b3f6-726c9b9f89b4","imageFeatures":"layering","imageName":"csi-vol-942d4261-b025-4709-b2a9-cd1d3e633089","journalPool":"kube","pool":"kube"},"volume_id":"0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-942d4261-b025-4709-b2a9-cd1d3e633089"}}
I0730 21:44:21.908882       1 utils.go:198] ID: 59 GRPC call: /csi.v1.Identity/Probe
I0730 21:44:21.908926       1 utils.go:199] ID: 59 GRPC request: {}
I0730 21:44:21.908941       1 utils.go:205] ID: 59 GRPC response: {}
I0730 21:45:21.864481       1 utils.go:198] ID: 60 GRPC call: /csi.v1.Identity/Probe
I0730 21:45:21.864558       1 utils.go:199] ID: 60 GRPC request: {}
I0730 21:45:21.864582       1 utils.go:205] ID: 60 GRPC response: {}
I0730 21:46:21.861343       1 utils.go:198] ID: 61 GRPC call: /csi.v1.Identity/Probe
I0730 21:46:21.861391       1 utils.go:199] ID: 61 GRPC request: {}
I0730 21:46:21.861413       1 utils.go:205] ID: 61 GRPC response: {}
I0730 21:47:21.871780       1 utils.go:198] ID: 62 GRPC call: /csi.v1.Identity/Probe
I0730 21:47:21.871820       1 utils.go:199] ID: 62 GRPC request: {}
I0730 21:47:21.871836       1 utils.go:205] ID: 62 GRPC response: {}
I0730 21:48:21.861460       1 utils.go:198] ID: 63 GRPC call: /csi.v1.Identity/Probe
I0730 21:48:21.861528       1 utils.go:199] ID: 63 GRPC request: {}
I0730 21:48:21.861556       1 utils.go:205] ID: 63 GRPC response: {}
I0730 21:49:21.890591       1 utils.go:198] ID: 64 GRPC call: /csi.v1.Identity/Probe
I0730 21:49:21.890673       1 utils.go:199] ID: 64 GRPC request: {}
I0730 21:49:21.890693       1 utils.go:205] ID: 64 GRPC response: {}
I0730 21:50:21.915088       1 utils.go:198] ID: 65 GRPC call: /csi.v1.Identity/Probe
I0730 21:50:21.915169       1 utils.go:199] ID: 65 GRPC request: {}
I0730 21:50:21.915191       1 utils.go:205] ID: 65 GRPC response: {}
I0730 21:51:21.893262       1 utils.go:198] ID: 66 GRPC call: /csi.v1.Identity/Probe
I0730 21:51:21.893925       1 utils.go:199] ID: 66 GRPC request: {}
I0730 21:51:21.893951       1 utils.go:205] ID: 66 GRPC response: {}
I0730 21:52:21.912302       1 utils.go:198] ID: 67 GRPC call: /csi.v1.Identity/Probe
I0730 21:52:21.912358       1 utils.go:199] ID: 67 GRPC request: {}
I0730 21:52:21.912380       1 utils.go:205] ID: 67 GRPC response: {}
I0730 21:53:21.867328       1 utils.go:198] ID: 68 GRPC call: /csi.v1.Identity/Probe
I0730 21:53:21.867387       1 utils.go:199] ID: 68 GRPC request: {}
I0730 21:53:21.867409       1 utils.go:205] ID: 68 GRPC response: {}
I0730 21:54:21.861484       1 utils.go:198] ID: 69 GRPC call: /csi.v1.Identity/Probe
I0730 21:54:21.861554       1 utils.go:199] ID: 69 GRPC request: {}
I0730 21:54:21.861600       1 utils.go:205] ID: 69 GRPC response: {}
I0730 21:55:21.917626       1 utils.go:198] ID: 70 GRPC call: /csi.v1.Identity/Probe
I0730 21:55:21.917681       1 utils.go:199] ID: 70 GRPC request: {}
I0730 21:55:21.917703       1 utils.go:205] ID: 70 GRPC response: {}
I0730 21:56:21.864650       1 utils.go:198] ID: 71 GRPC call: /csi.v1.Identity/Probe
I0730 21:56:21.864706       1 utils.go:199] ID: 71 GRPC request: {}
I0730 21:56:21.864738       1 utils.go:205] ID: 71 GRPC response: {}
I0730 21:57:21.912291       1 utils.go:198] ID: 72 GRPC call: /csi.v1.Identity/Probe
I0730 21:57:21.912339       1 utils.go:199] ID: 72 GRPC request: {}
I0730 21:57:21.912420       1 utils.go:205] ID: 72 GRPC response: {}
I0730 21:58:21.873638       1 utils.go:198] ID: 73 GRPC call: /csi.v1.Identity/Probe
I0730 21:58:21.873781       1 utils.go:199] ID: 73 GRPC request: {}
I0730 21:58:21.873830       1 utils.go:205] ID: 73 GRPC response: {}
I0730 21:59:21.914608       1 utils.go:198] ID: 74 GRPC call: /csi.v1.Identity/Probe
I0730 21:59:21.914685       1 utils.go:199] ID: 74 GRPC request: {}
I0730 21:59:21.914716       1 utils.go:205] ID: 74 GRPC response: {}
I0730 22:00:21.885245       1 utils.go:198] ID: 75 GRPC call: /csi.v1.Identity/Probe
I0730 22:00:21.885338       1 utils.go:199] ID: 75 GRPC request: {}
I0730 22:00:21.885369       1 utils.go:205] ID: 75 GRPC response: {}
I0730 22:01:21.861412       1 utils.go:198] ID: 76 GRPC call: /csi.v1.Identity/Probe
I0730 22:01:21.861490       1 utils.go:199] ID: 76 GRPC request: {}
I0730 22:01:21.861514       1 utils.go:205] ID: 76 GRPC response: {}
I0730 22:02:21.893807       1 utils.go:198] ID: 77 GRPC call: /csi.v1.Identity/Probe
I0730 22:02:21.893855       1 utils.go:199] ID: 77 GRPC request: {}
I0730 22:02:21.893889       1 utils.go:205] ID: 77 GRPC response: {}
I0730 22:03:21.914460       1 utils.go:198] ID: 78 GRPC call: /csi.v1.Identity/Probe
I0730 22:03:21.914513       1 utils.go:199] ID: 78 GRPC request: {}
I0730 22:03:21.914534       1 utils.go:205] ID: 78 GRPC response: {}
I0730 22:04:21.902108       1 utils.go:198] ID: 79 GRPC call: /csi.v1.Identity/Probe
I0730 22:04:21.902151       1 utils.go:199] ID: 79 GRPC request: {}
I0730 22:04:21.902167       1 utils.go:205] ID: 79 GRPC response: {}
I0730 22:05:21.861389       1 utils.go:198] ID: 80 GRPC call: /csi.v1.Identity/Probe
I0730 22:05:21.861444       1 utils.go:199] ID: 80 GRPC request: {}
I0730 22:05:21.861466       1 utils.go:205] ID: 80 GRPC response: {}
I0730 22:06:21.917029       1 utils.go:198] ID: 81 GRPC call: /csi.v1.Identity/Probe
I0730 22:06:21.917084       1 utils.go:199] ID: 81 GRPC request: {}
I0730 22:06:21.917102       1 utils.go:205] ID: 81 GRPC response: {}
I0730 22:07:21.914973       1 utils.go:198] ID: 82 GRPC call: /csi.v1.Identity/Probe
I0730 22:07:21.915014       1 utils.go:199] ID: 82 GRPC request: {}
I0730 22:07:21.915033       1 utils.go:205] ID: 82 GRPC response: {}