I0730 04:51:41.831510       1 cephcsi.go:191] Driver version: v3.11.0 and Git version: bc24b5eca87626d690a29effa9d7420cc0154a7a
I0730 04:51:41.831662       1 cephcsi.go:223] Starting driver type: rbd with name: rbd.csi.ceph.com
I0730 04:51:41.831679       1 driver.go:95] Enabling controller service capability: CREATE_DELETE_VOLUME
I0730 04:51:41.831687       1 driver.go:95] Enabling controller service capability: CREATE_DELETE_SNAPSHOT
I0730 04:51:41.831691       1 driver.go:95] Enabling controller service capability: CLONE_VOLUME
I0730 04:51:41.831696       1 driver.go:95] Enabling controller service capability: EXPAND_VOLUME
I0730 04:51:41.831701       1 driver.go:108] Enabling volume access mode: SINGLE_NODE_WRITER
I0730 04:51:41.831705       1 driver.go:108] Enabling volume access mode: MULTI_NODE_MULTI_WRITER
I0730 04:51:41.831709       1 driver.go:108] Enabling volume access mode: SINGLE_NODE_SINGLE_WRITER
I0730 04:51:41.831713       1 driver.go:108] Enabling volume access mode: SINGLE_NODE_MULTI_WRITER
I0730 04:51:41.832293       1 server.go:117] Listening for connections on address: &net.UnixAddr{Name:"//csi/csi-provisioner.sock", Net:"unix"}
I0730 04:51:41.832382       1 server.go:114] listening for CSI-Addons requests on address: &net.UnixAddr{Name:"/csi/csi-addons.sock", Net:"unix"}
I0730 04:51:51.133593       1 utils.go:198] ID: 1 GRPC call: /csi.v1.Identity/Probe
I0730 04:51:51.135082       1 utils.go:199] ID: 1 GRPC request: {}
I0730 04:51:51.135147       1 utils.go:205] ID: 1 GRPC response: {}
I0730 04:51:51.140255       1 utils.go:198] ID: 2 GRPC call: /csi.v1.Identity/GetPluginInfo
I0730 04:51:51.140403       1 utils.go:199] ID: 2 GRPC request: {}
I0730 04:51:51.140430       1 identityserver-default.go:40] ID: 2 Using default GetPluginInfo
I0730 04:51:51.140512       1 utils.go:205] ID: 2 GRPC response: {"name":"rbd.csi.ceph.com","vendor_version":"v3.11.0"}
I0730 04:51:51.142514       1 utils.go:198] ID: 3 GRPC call: /csi.v1.Identity/Probe
I0730 04:51:51.142582       1 utils.go:199] ID: 3 GRPC request: {}
I0730 04:51:51.142617       1 utils.go:205] ID: 3 GRPC response: {}
I0730 04:51:51.143221       1 utils.go:198] ID: 4 GRPC call: /csi.v1.Identity/GetPluginCapabilities
I0730 04:51:51.143288       1 utils.go:199] ID: 4 GRPC request: {}
I0730 04:51:51.143456       1 utils.go:205] ID: 4 GRPC response: {"capabilities":[{"Type":{"Service":{"type":1}}},{"Type":{"VolumeExpansion":{"type":1}}},{"Type":{"Service":{"type":2}}}]}
I0730 04:51:51.144288       1 utils.go:198] ID: 5 GRPC call: /csi.v1.Controller/ControllerGetCapabilities
I0730 04:51:51.144330       1 utils.go:199] ID: 5 GRPC request: {}
I0730 04:51:51.144346       1 controllerserver-default.go:42] ID: 5 Using default ControllerGetCapabilities
I0730 04:51:51.144467       1 utils.go:205] ID: 5 GRPC response: {"capabilities":[{"Type":{"Rpc":{"type":1}}},{"Type":{"Rpc":{"type":5}}},{"Type":{"Rpc":{"type":7}}},{"Type":{"Rpc":{"type":9}}}]}
I0730 04:51:52.752385       1 utils.go:198] ID: 6 GRPC call: /csi.v1.Identity/Probe
I0730 04:51:52.752455       1 utils.go:199] ID: 6 GRPC request: {}
I0730 04:51:52.752484       1 utils.go:205] ID: 6 GRPC response: {}
I0730 04:51:52.755841       1 utils.go:198] ID: 7 GRPC call: /csi.v1.Identity/GetPluginInfo
I0730 04:51:52.755938       1 utils.go:199] ID: 7 GRPC request: {}
I0730 04:51:52.755976       1 identityserver-default.go:40] ID: 7 Using default GetPluginInfo
I0730 04:51:52.756073       1 utils.go:205] ID: 7 GRPC response: {"name":"rbd.csi.ceph.com","vendor_version":"v3.11.0"}
I0730 04:51:52.758929       1 utils.go:198] ID: 8 GRPC call: /csi.v1.Identity/Probe
I0730 04:51:52.758985       1 utils.go:199] ID: 8 GRPC request: {}
I0730 04:51:52.759018       1 utils.go:205] ID: 8 GRPC response: {}
I0730 04:51:52.760546       1 utils.go:198] ID: 9 GRPC call: /csi.v1.Identity/GetPluginCapabilities
I0730 04:51:52.760583       1 utils.go:199] ID: 9 GRPC request: {}
I0730 04:51:52.760744       1 utils.go:205] ID: 9 GRPC response: {"capabilities":[{"Type":{"Service":{"type":1}}},{"Type":{"VolumeExpansion":{"type":1}}},{"Type":{"Service":{"type":2}}}]}
I0730 04:51:52.761950       1 utils.go:198] ID: 10 GRPC call: /csi.v1.Controller/ControllerGetCapabilities
I0730 04:51:52.762067       1 utils.go:199] ID: 10 GRPC request: {}
I0730 04:51:52.762111       1 controllerserver-default.go:42] ID: 10 Using default ControllerGetCapabilities
I0730 04:51:52.762301       1 utils.go:205] ID: 10 GRPC response: {"capabilities":[{"Type":{"Rpc":{"type":1}}},{"Type":{"Rpc":{"type":5}}},{"Type":{"Rpc":{"type":7}}},{"Type":{"Rpc":{"type":9}}}]}
I0730 04:51:52.763356       1 utils.go:198] ID: 11 GRPC call: /csi.v1.Controller/ControllerGetCapabilities
I0730 04:51:52.763405       1 utils.go:199] ID: 11 GRPC request: {}
I0730 04:51:52.763417       1 controllerserver-default.go:42] ID: 11 Using default ControllerGetCapabilities
I0730 04:51:52.763619       1 utils.go:205] ID: 11 GRPC response: {"capabilities":[{"Type":{"Rpc":{"type":1}}},{"Type":{"Rpc":{"type":5}}},{"Type":{"Rpc":{"type":7}}},{"Type":{"Rpc":{"type":9}}}]}
I0730 04:51:52.764275       1 utils.go:198] ID: 12 GRPC call: /csi.v1.Controller/ControllerGetCapabilities
I0730 04:51:52.764296       1 utils.go:199] ID: 12 GRPC request: {}
I0730 04:51:52.764303       1 controllerserver-default.go:42] ID: 12 Using default ControllerGetCapabilities
I0730 04:51:52.764437       1 utils.go:205] ID: 12 GRPC response: {"capabilities":[{"Type":{"Rpc":{"type":1}}},{"Type":{"Rpc":{"type":5}}},{"Type":{"Rpc":{"type":7}}},{"Type":{"Rpc":{"type":9}}}]}
I0730 04:51:55.723116       1 utils.go:198] ID: 13 GRPC call: /csi.v1.Identity/GetPluginInfo
I0730 04:51:55.723185       1 utils.go:199] ID: 13 GRPC request: {}
I0730 04:51:55.723200       1 identityserver-default.go:40] ID: 13 Using default GetPluginInfo
I0730 04:51:55.723242       1 utils.go:205] ID: 13 GRPC response: {"name":"rbd.csi.ceph.com","vendor_version":"v3.11.0"}
I0730 04:51:55.726398       1 utils.go:198] ID: 14 GRPC call: /csi.v1.Identity/Probe
I0730 04:51:55.726451       1 utils.go:199] ID: 14 GRPC request: {}
I0730 04:51:55.726472       1 utils.go:205] ID: 14 GRPC response: {}
I0730 04:51:55.727194       1 utils.go:198] ID: 15 GRPC call: /csi.v1.Controller/ControllerGetCapabilities
I0730 04:51:55.727350       1 utils.go:199] ID: 15 GRPC request: {}
I0730 04:51:55.727416       1 controllerserver-default.go:42] ID: 15 Using default ControllerGetCapabilities
I0730 04:51:55.727674       1 utils.go:205] ID: 15 GRPC response: {"capabilities":[{"Type":{"Rpc":{"type":1}}},{"Type":{"Rpc":{"type":5}}},{"Type":{"Rpc":{"type":7}}},{"Type":{"Rpc":{"type":9}}}]}
I0730 04:52:01.142576       1 utils.go:198] ID: 16 GRPC call: /csi.v1.Identity/Probe
I0730 04:52:01.142655       1 utils.go:199] ID: 16 GRPC request: {}
I0730 04:52:01.142701       1 utils.go:205] ID: 16 GRPC response: {}
I0730 04:52:01.146638       1 utils.go:198] ID: 17 GRPC call: /csi.v1.Identity/GetPluginInfo
I0730 04:52:01.146690       1 utils.go:199] ID: 17 GRPC request: {}
I0730 04:52:01.146701       1 identityserver-default.go:40] ID: 17 Using default GetPluginInfo
I0730 04:52:01.146734       1 utils.go:205] ID: 17 GRPC response: {"name":"rbd.csi.ceph.com","vendor_version":"v3.11.0"}
I0730 04:52:01.149921       1 utils.go:198] ID: 18 GRPC call: /csi.v1.Identity/Probe
I0730 04:52:01.149970       1 utils.go:199] ID: 18 GRPC request: {}
I0730 04:52:01.149995       1 utils.go:205] ID: 18 GRPC response: {}
I0730 04:52:01.151249       1 utils.go:198] ID: 19 GRPC call: /csi.v1.Identity/GetPluginCapabilities
I0730 04:52:01.151277       1 utils.go:199] ID: 19 GRPC request: {}
I0730 04:52:01.151411       1 utils.go:205] ID: 19 GRPC response: {"capabilities":[{"Type":{"Service":{"type":1}}},{"Type":{"VolumeExpansion":{"type":1}}},{"Type":{"Service":{"type":2}}}]}
I0730 04:52:01.152216       1 utils.go:198] ID: 20 GRPC call: /csi.v1.Controller/ControllerGetCapabilities
I0730 04:52:01.152245       1 utils.go:199] ID: 20 GRPC request: {}
I0730 04:52:01.152257       1 controllerserver-default.go:42] ID: 20 Using default ControllerGetCapabilities
I0730 04:52:01.152351       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 04:52:48.148947       1 utils.go:198] ID: 21 Req-ID: pvc-bb560cf4-f74f-4e47-993c-a666eb987293 GRPC call: /csi.v1.Controller/CreateVolume
I0730 04:52:48.149308       1 utils.go:199] ID: 21 Req-ID: pvc-bb560cf4-f74f-4e47-993c-a666eb987293 GRPC request: {"capacity_range":{"required_bytes":171798691840},"name":"pvc-bb560cf4-f74f-4e47-993c-a666eb987293","parameters":{"clusterID":"4837cbf8-4f90-4300-b3f6-726c9b9f89b4","csi.storage.k8s.io/pv/name":"pvc-bb560cf4-f74f-4e47-993c-a666eb987293","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 04:52:48.149555       1 rbd_util.go:1315] ID: 21 Req-ID: pvc-bb560cf4-f74f-4e47-993c-a666eb987293 setting disableInUseChecks: false image features: [layering] mounter: rbd
E0730 04:52:48.172233       1 omap.go:80] ID: 21 Req-ID: pvc-bb560cf4-f74f-4e47-993c-a666eb987293 omap not found (pool="kube", namespace="", name="csi.volumes.default"): rados: ret=-2, No such file or directory
I0730 04:52:48.191773       1 omap.go:159] ID: 21 Req-ID: pvc-bb560cf4-f74f-4e47-993c-a666eb987293 set omap keys (pool="kube", namespace="", name="csi.volumes.default"): map[csi.volume.pvc-bb560cf4-f74f-4e47-993c-a666eb987293:8594ec4e-d39f-437f-b02f-e4bb4c06e0c5])
I0730 04:52:48.199790       1 omap.go:159] ID: 21 Req-ID: pvc-bb560cf4-f74f-4e47-993c-a666eb987293 set omap keys (pool="kube", namespace="", name="csi.volume.8594ec4e-d39f-437f-b02f-e4bb4c06e0c5"): map[csi.imagename:csi-vol-8594ec4e-d39f-437f-b02f-e4bb4c06e0c5 csi.volname:pvc-bb560cf4-f74f-4e47-993c-a666eb987293 csi.volume.owner:openstack])
I0730 04:52:48.199888       1 rbd_journal.go:491] ID: 21 Req-ID: pvc-bb560cf4-f74f-4e47-993c-a666eb987293 generated Volume ID (0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-8594ec4e-d39f-437f-b02f-e4bb4c06e0c5) and image name (csi-vol-8594ec4e-d39f-437f-b02f-e4bb4c06e0c5) for request name (pvc-bb560cf4-f74f-4e47-993c-a666eb987293)
I0730 04:52:48.200052       1 rbd_util.go:423] ID: 21 Req-ID: pvc-bb560cf4-f74f-4e47-993c-a666eb987293 rbd: create kube/csi-vol-8594ec4e-d39f-437f-b02f-e4bb4c06e0c5 size 163840M (features: [layering]) using mon 10.96.240.200
I0730 04:52:48.200780       1 rbd_util.go:1563] ID: 21 Req-ID: pvc-bb560cf4-f74f-4e47-993c-a666eb987293 setting image options on kube/csi-vol-8594ec4e-d39f-437f-b02f-e4bb4c06e0c5
I0730 04:52:48.259229       1 controllerserver.go:763] ID: 21 Req-ID: pvc-bb560cf4-f74f-4e47-993c-a666eb987293 created image kube/csi-vol-8594ec4e-d39f-437f-b02f-e4bb4c06e0c5 backed for request name pvc-bb560cf4-f74f-4e47-993c-a666eb987293
I0730 04:52:48.302498       1 omap.go:159] ID: 21 Req-ID: pvc-bb560cf4-f74f-4e47-993c-a666eb987293 set omap keys (pool="kube", namespace="", name="csi.volume.8594ec4e-d39f-437f-b02f-e4bb4c06e0c5"): map[csi.imageid:37c6112de61f])
I0730 04:52:48.407020       1 utils.go:205] ID: 21 Req-ID: pvc-bb560cf4-f74f-4e47-993c-a666eb987293 GRPC response: {"volume":{"capacity_bytes":171798691840,"volume_context":{"clusterID":"4837cbf8-4f90-4300-b3f6-726c9b9f89b4","imageFeatures":"layering","imageName":"csi-vol-8594ec4e-d39f-437f-b02f-e4bb4c06e0c5","journalPool":"kube","pool":"kube"},"volume_id":"0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-8594ec4e-d39f-437f-b02f-e4bb4c06e0c5"}}
I0730 04:53:01.372533       1 utils.go:198] ID: 22 GRPC call: /csi.v1.Identity/Probe
I0730 04:53:01.372585       1 utils.go:199] ID: 22 GRPC request: {}
I0730 04:53:01.372606       1 utils.go:205] ID: 22 GRPC response: {}
I0730 04:54:01.342849       1 utils.go:198] ID: 23 GRPC call: /csi.v1.Identity/Probe
I0730 04:54:01.343030       1 utils.go:199] ID: 23 GRPC request: {}
I0730 04:54:01.343075       1 utils.go:205] ID: 23 GRPC response: {}
I0730 04:55:01.340813       1 utils.go:198] ID: 24 GRPC call: /csi.v1.Identity/Probe
I0730 04:55:01.340886       1 utils.go:199] ID: 24 GRPC request: {}
I0730 04:55:01.340919       1 utils.go:205] ID: 24 GRPC response: {}
I0730 04:55:09.995288       1 utils.go:198] ID: 25 Req-ID: pvc-50fde6db-8b8f-448c-8c32-55169420e5f4 GRPC call: /csi.v1.Controller/CreateVolume
I0730 04:55:09.995758       1 utils.go:199] ID: 25 Req-ID: pvc-50fde6db-8b8f-448c-8c32-55169420e5f4 GRPC request: {"capacity_range":{"required_bytes":8589934592},"name":"pvc-50fde6db-8b8f-448c-8c32-55169420e5f4","parameters":{"clusterID":"4837cbf8-4f90-4300-b3f6-726c9b9f89b4","csi.storage.k8s.io/pv/name":"pvc-50fde6db-8b8f-448c-8c32-55169420e5f4","csi.storage.k8s.io/pvc/name":"valkey-data-valkey-node-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 04:55:09.996903       1 rbd_util.go:1315] ID: 25 Req-ID: pvc-50fde6db-8b8f-448c-8c32-55169420e5f4 setting disableInUseChecks: false image features: [layering] mounter: rbd
I0730 04:55:09.999474       1 omap.go:89] ID: 25 Req-ID: pvc-50fde6db-8b8f-448c-8c32-55169420e5f4 got omap values: (pool="kube", namespace="", name="csi.volumes.default"): map[]
I0730 04:55:10.027771       1 omap.go:159] ID: 25 Req-ID: pvc-50fde6db-8b8f-448c-8c32-55169420e5f4 set omap keys (pool="kube", namespace="", name="csi.volumes.default"): map[csi.volume.pvc-50fde6db-8b8f-448c-8c32-55169420e5f4:8abfaf09-808c-431e-901f-e4058b6ab692])
I0730 04:55:10.037555       1 omap.go:159] ID: 25 Req-ID: pvc-50fde6db-8b8f-448c-8c32-55169420e5f4 set omap keys (pool="kube", namespace="", name="csi.volume.8abfaf09-808c-431e-901f-e4058b6ab692"): map[csi.imagename:csi-vol-8abfaf09-808c-431e-901f-e4058b6ab692 csi.volname:pvc-50fde6db-8b8f-448c-8c32-55169420e5f4 csi.volume.owner:openstack])
I0730 04:55:10.037618       1 rbd_journal.go:491] ID: 25 Req-ID: pvc-50fde6db-8b8f-448c-8c32-55169420e5f4 generated Volume ID (0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-8abfaf09-808c-431e-901f-e4058b6ab692) and image name (csi-vol-8abfaf09-808c-431e-901f-e4058b6ab692) for request name (pvc-50fde6db-8b8f-448c-8c32-55169420e5f4)
I0730 04:55:10.037701       1 rbd_util.go:423] ID: 25 Req-ID: pvc-50fde6db-8b8f-448c-8c32-55169420e5f4 rbd: create kube/csi-vol-8abfaf09-808c-431e-901f-e4058b6ab692 size 8192M (features: [layering]) using mon 10.96.240.200
I0730 04:55:10.037821       1 rbd_util.go:1563] ID: 25 Req-ID: pvc-50fde6db-8b8f-448c-8c32-55169420e5f4 setting image options on kube/csi-vol-8abfaf09-808c-431e-901f-e4058b6ab692
I0730 04:55:10.073248       1 controllerserver.go:763] ID: 25 Req-ID: pvc-50fde6db-8b8f-448c-8c32-55169420e5f4 created image kube/csi-vol-8abfaf09-808c-431e-901f-e4058b6ab692 backed for request name pvc-50fde6db-8b8f-448c-8c32-55169420e5f4
I0730 04:55:10.104231       1 omap.go:159] ID: 25 Req-ID: pvc-50fde6db-8b8f-448c-8c32-55169420e5f4 set omap keys (pool="kube", namespace="", name="csi.volume.8abfaf09-808c-431e-901f-e4058b6ab692"): map[csi.imageid:37c6f0c0fc9e])
I0730 04:55:10.232755       1 utils.go:205] ID: 25 Req-ID: pvc-50fde6db-8b8f-448c-8c32-55169420e5f4 GRPC response: {"volume":{"capacity_bytes":8589934592,"volume_context":{"clusterID":"4837cbf8-4f90-4300-b3f6-726c9b9f89b4","imageFeatures":"layering","imageName":"csi-vol-8abfaf09-808c-431e-901f-e4058b6ab692","journalPool":"kube","pool":"kube"},"volume_id":"0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-8abfaf09-808c-431e-901f-e4058b6ab692"}}
I0730 04:56:01.352354       1 utils.go:198] ID: 26 GRPC call: /csi.v1.Identity/Probe
I0730 04:56:01.352480       1 utils.go:199] ID: 26 GRPC request: {}
I0730 04:56:01.352523       1 utils.go:205] ID: 26 GRPC response: {}
I0730 04:57:01.340918       1 utils.go:198] ID: 27 GRPC call: /csi.v1.Identity/Probe
I0730 04:57:01.340990       1 utils.go:199] ID: 27 GRPC request: {}
I0730 04:57:01.341019       1 utils.go:205] ID: 27 GRPC response: {}
I0730 04:58:01.362440       1 utils.go:198] ID: 28 GRPC call: /csi.v1.Identity/Probe
I0730 04:58:01.362501       1 utils.go:199] ID: 28 GRPC request: {}
I0730 04:58:01.362528       1 utils.go:205] ID: 28 GRPC response: {}
I0730 04:59:01.340759       1 utils.go:198] ID: 29 GRPC call: /csi.v1.Identity/Probe
I0730 04:59:01.340821       1 utils.go:199] ID: 29 GRPC request: {}
I0730 04:59:01.340849       1 utils.go:205] ID: 29 GRPC response: {}
I0730 05:00:01.372353       1 utils.go:198] ID: 30 GRPC call: /csi.v1.Identity/Probe
I0730 05:00:01.372546       1 utils.go:199] ID: 30 GRPC request: {}
I0730 05:00:01.372663       1 utils.go:205] ID: 30 GRPC response: {}
I0730 05:01:01.389027       1 utils.go:198] ID: 31 GRPC call: /csi.v1.Identity/Probe
I0730 05:01:01.389083       1 utils.go:199] ID: 31 GRPC request: {}
I0730 05:01:01.389130       1 utils.go:205] ID: 31 GRPC response: {}
I0730 05:02:01.382240       1 utils.go:198] ID: 32 GRPC call: /csi.v1.Identity/Probe
I0730 05:02:01.382324       1 utils.go:199] ID: 32 GRPC request: {}
I0730 05:02:01.382350       1 utils.go:205] ID: 32 GRPC response: {}
I0730 05:03:01.397347       1 utils.go:198] ID: 33 GRPC call: /csi.v1.Identity/Probe
I0730 05:03:01.397391       1 utils.go:199] ID: 33 GRPC request: {}
I0730 05:03:01.397408       1 utils.go:205] ID: 33 GRPC response: {}
I0730 05:04:01.391533       1 utils.go:198] ID: 34 GRPC call: /csi.v1.Identity/Probe
I0730 05:04:01.392286       1 utils.go:199] ID: 34 GRPC request: {}
I0730 05:04:01.392473       1 utils.go:205] ID: 34 GRPC response: {}
I0730 05:05:01.387439       1 utils.go:198] ID: 35 GRPC call: /csi.v1.Identity/Probe
I0730 05:05:01.387495       1 utils.go:199] ID: 35 GRPC request: {}
I0730 05:05:01.387522       1 utils.go:205] ID: 35 GRPC response: {}
I0730 05:05:45.469043       1 utils.go:198] ID: 36 Req-ID: pvc-0c29ae45-d01b-4c0f-92c1-ad30ef712373 GRPC call: /csi.v1.Controller/CreateVolume
I0730 05:05:45.469453       1 utils.go:199] ID: 36 Req-ID: pvc-0c29ae45-d01b-4c0f-92c1-ad30ef712373 GRPC request: {"capacity_range":{"required_bytes":42949672960},"name":"pvc-0c29ae45-d01b-4c0f-92c1-ad30ef712373","parameters":{"clusterID":"4837cbf8-4f90-4300-b3f6-726c9b9f89b4","csi.storage.k8s.io/pv/name":"pvc-0c29ae45-d01b-4c0f-92c1-ad30ef712373","csi.storage.k8s.io/pvc/name":"alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0","csi.storage.k8s.io/pvc/namespace":"monitoring","imageFeatures":"layering","pool":"kube"},"secrets":"***stripped***","volume_capabilities":[{"AccessType":{"Mount":{"fs_type":"ext4","mount_flags":["discard"]}},"access_mode":{"mode":1}}]}
I0730 05:05:45.470414       1 rbd_util.go:1315] ID: 36 Req-ID: pvc-0c29ae45-d01b-4c0f-92c1-ad30ef712373 setting disableInUseChecks: false image features: [layering] mounter: rbd
I0730 05:05:45.477730       1 omap.go:89] ID: 36 Req-ID: pvc-0c29ae45-d01b-4c0f-92c1-ad30ef712373 got omap values: (pool="kube", namespace="", name="csi.volumes.default"): map[]
I0730 05:05:45.502300       1 omap.go:159] ID: 36 Req-ID: pvc-0c29ae45-d01b-4c0f-92c1-ad30ef712373 set omap keys (pool="kube", namespace="", name="csi.volumes.default"): map[csi.volume.pvc-0c29ae45-d01b-4c0f-92c1-ad30ef712373:3398987b-616f-4117-ae2e-8a9dcebf0c92])
I0730 05:05:45.510405       1 omap.go:159] ID: 36 Req-ID: pvc-0c29ae45-d01b-4c0f-92c1-ad30ef712373 set omap keys (pool="kube", namespace="", name="csi.volume.3398987b-616f-4117-ae2e-8a9dcebf0c92"): map[csi.imagename:csi-vol-3398987b-616f-4117-ae2e-8a9dcebf0c92 csi.volname:pvc-0c29ae45-d01b-4c0f-92c1-ad30ef712373 csi.volume.owner:monitoring])
I0730 05:05:45.510461       1 rbd_journal.go:491] ID: 36 Req-ID: pvc-0c29ae45-d01b-4c0f-92c1-ad30ef712373 generated Volume ID (0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-3398987b-616f-4117-ae2e-8a9dcebf0c92) and image name (csi-vol-3398987b-616f-4117-ae2e-8a9dcebf0c92) for request name (pvc-0c29ae45-d01b-4c0f-92c1-ad30ef712373)
I0730 05:05:45.510615       1 rbd_util.go:423] ID: 36 Req-ID: pvc-0c29ae45-d01b-4c0f-92c1-ad30ef712373 rbd: create kube/csi-vol-3398987b-616f-4117-ae2e-8a9dcebf0c92 size 40960M (features: [layering]) using mon 10.96.240.200
I0730 05:05:45.510661       1 rbd_util.go:1563] ID: 36 Req-ID: pvc-0c29ae45-d01b-4c0f-92c1-ad30ef712373 setting image options on kube/csi-vol-3398987b-616f-4117-ae2e-8a9dcebf0c92
I0730 05:05:45.549260       1 controllerserver.go:763] ID: 36 Req-ID: pvc-0c29ae45-d01b-4c0f-92c1-ad30ef712373 created image kube/csi-vol-3398987b-616f-4117-ae2e-8a9dcebf0c92 backed for request name pvc-0c29ae45-d01b-4c0f-92c1-ad30ef712373
I0730 05:05:45.594521       1 omap.go:159] ID: 36 Req-ID: pvc-0c29ae45-d01b-4c0f-92c1-ad30ef712373 set omap keys (pool="kube", namespace="", name="csi.volume.3398987b-616f-4117-ae2e-8a9dcebf0c92"): map[csi.imageid:37c64bf5c0f4])
I0730 05:05:45.775824       1 utils.go:205] ID: 36 Req-ID: pvc-0c29ae45-d01b-4c0f-92c1-ad30ef712373 GRPC response: {"volume":{"capacity_bytes":42949672960,"volume_context":{"clusterID":"4837cbf8-4f90-4300-b3f6-726c9b9f89b4","imageFeatures":"layering","imageName":"csi-vol-3398987b-616f-4117-ae2e-8a9dcebf0c92","journalPool":"kube","pool":"kube"},"volume_id":"0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-3398987b-616f-4117-ae2e-8a9dcebf0c92"}}
I0730 05:05:45.936675       1 utils.go:198] ID: 37 Req-ID: pvc-14211c45-7025-4e2b-b245-ef4a964287fe GRPC call: /csi.v1.Controller/CreateVolume
I0730 05:05:45.936874       1 utils.go:199] ID: 37 Req-ID: pvc-14211c45-7025-4e2b-b245-ef4a964287fe GRPC request: {"capacity_range":{"required_bytes":107374182400},"name":"pvc-14211c45-7025-4e2b-b245-ef4a964287fe","parameters":{"clusterID":"4837cbf8-4f90-4300-b3f6-726c9b9f89b4","csi.storage.k8s.io/pv/name":"pvc-14211c45-7025-4e2b-b245-ef4a964287fe","csi.storage.k8s.io/pvc/name":"prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0","csi.storage.k8s.io/pvc/namespace":"monitoring","imageFeatures":"layering","pool":"kube"},"secrets":"***stripped***","volume_capabilities":[{"AccessType":{"Mount":{"fs_type":"ext4","mount_flags":["discard"]}},"access_mode":{"mode":1}}]}
I0730 05:05:45.937071       1 rbd_util.go:1315] ID: 37 Req-ID: pvc-14211c45-7025-4e2b-b245-ef4a964287fe setting disableInUseChecks: false image features: [layering] mounter: rbd
I0730 05:05:45.939308       1 omap.go:89] ID: 37 Req-ID: pvc-14211c45-7025-4e2b-b245-ef4a964287fe got omap values: (pool="kube", namespace="", name="csi.volumes.default"): map[]
I0730 05:05:45.969759       1 omap.go:159] ID: 37 Req-ID: pvc-14211c45-7025-4e2b-b245-ef4a964287fe set omap keys (pool="kube", namespace="", name="csi.volumes.default"): map[csi.volume.pvc-14211c45-7025-4e2b-b245-ef4a964287fe:73127da2-09f6-4206-b22f-08a561a0eb88])
I0730 05:05:45.980471       1 omap.go:159] ID: 37 Req-ID: pvc-14211c45-7025-4e2b-b245-ef4a964287fe set omap keys (pool="kube", namespace="", name="csi.volume.73127da2-09f6-4206-b22f-08a561a0eb88"): map[csi.imagename:csi-vol-73127da2-09f6-4206-b22f-08a561a0eb88 csi.volname:pvc-14211c45-7025-4e2b-b245-ef4a964287fe csi.volume.owner:monitoring])
I0730 05:05:45.980498       1 rbd_journal.go:491] ID: 37 Req-ID: pvc-14211c45-7025-4e2b-b245-ef4a964287fe generated Volume ID (0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-73127da2-09f6-4206-b22f-08a561a0eb88) and image name (csi-vol-73127da2-09f6-4206-b22f-08a561a0eb88) for request name (pvc-14211c45-7025-4e2b-b245-ef4a964287fe)
I0730 05:05:45.980588       1 rbd_util.go:423] ID: 37 Req-ID: pvc-14211c45-7025-4e2b-b245-ef4a964287fe rbd: create kube/csi-vol-73127da2-09f6-4206-b22f-08a561a0eb88 size 102400M (features: [layering]) using mon 10.96.240.200
I0730 05:05:45.980627       1 rbd_util.go:1563] ID: 37 Req-ID: pvc-14211c45-7025-4e2b-b245-ef4a964287fe setting image options on kube/csi-vol-73127da2-09f6-4206-b22f-08a561a0eb88
I0730 05:05:46.017619       1 controllerserver.go:763] ID: 37 Req-ID: pvc-14211c45-7025-4e2b-b245-ef4a964287fe created image kube/csi-vol-73127da2-09f6-4206-b22f-08a561a0eb88 backed for request name pvc-14211c45-7025-4e2b-b245-ef4a964287fe
I0730 05:05:46.072461       1 omap.go:159] ID: 37 Req-ID: pvc-14211c45-7025-4e2b-b245-ef4a964287fe set omap keys (pool="kube", namespace="", name="csi.volume.73127da2-09f6-4206-b22f-08a561a0eb88"): map[csi.imageid:37c6c69c224d])
I0730 05:05:46.195710       1 utils.go:205] ID: 37 Req-ID: pvc-14211c45-7025-4e2b-b245-ef4a964287fe GRPC response: {"volume":{"capacity_bytes":107374182400,"volume_context":{"clusterID":"4837cbf8-4f90-4300-b3f6-726c9b9f89b4","imageFeatures":"layering","imageName":"csi-vol-73127da2-09f6-4206-b22f-08a561a0eb88","journalPool":"kube","pool":"kube"},"volume_id":"0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-73127da2-09f6-4206-b22f-08a561a0eb88"}}
I0730 05:05:50.110067       1 utils.go:198] ID: 38 Req-ID: pvc-ef77963e-594e-429e-9e3e-d03ceeaa46e5 GRPC call: /csi.v1.Controller/CreateVolume
I0730 05:05:50.110376       1 utils.go:199] ID: 38 Req-ID: pvc-ef77963e-594e-429e-9e3e-d03ceeaa46e5 GRPC request: {"capacity_range":{"required_bytes":274877906944},"name":"pvc-ef77963e-594e-429e-9e3e-d03ceeaa46e5","parameters":{"clusterID":"4837cbf8-4f90-4300-b3f6-726c9b9f89b4","csi.storage.k8s.io/pv/name":"pvc-ef77963e-594e-429e-9e3e-d03ceeaa46e5","csi.storage.k8s.io/pvc/name":"storage-loki-0","csi.storage.k8s.io/pvc/namespace":"monitoring","imageFeatures":"layering","pool":"kube"},"secrets":"***stripped***","volume_capabilities":[{"AccessType":{"Mount":{"fs_type":"ext4","mount_flags":["discard"]}},"access_mode":{"mode":1}}]}
I0730 05:05:50.110604       1 rbd_util.go:1315] ID: 38 Req-ID: pvc-ef77963e-594e-429e-9e3e-d03ceeaa46e5 setting disableInUseChecks: false image features: [layering] mounter: rbd
I0730 05:05:50.116534       1 omap.go:89] ID: 38 Req-ID: pvc-ef77963e-594e-429e-9e3e-d03ceeaa46e5 got omap values: (pool="kube", namespace="", name="csi.volumes.default"): map[]
I0730 05:05:50.143434       1 omap.go:159] ID: 38 Req-ID: pvc-ef77963e-594e-429e-9e3e-d03ceeaa46e5 set omap keys (pool="kube", namespace="", name="csi.volumes.default"): map[csi.volume.pvc-ef77963e-594e-429e-9e3e-d03ceeaa46e5:778121ba-ae18-409f-920d-821445f9a964])
I0730 05:05:50.151711       1 omap.go:159] ID: 38 Req-ID: pvc-ef77963e-594e-429e-9e3e-d03ceeaa46e5 set omap keys (pool="kube", namespace="", name="csi.volume.778121ba-ae18-409f-920d-821445f9a964"): map[csi.imagename:csi-vol-778121ba-ae18-409f-920d-821445f9a964 csi.volname:pvc-ef77963e-594e-429e-9e3e-d03ceeaa46e5 csi.volume.owner:monitoring])
I0730 05:05:50.151745       1 rbd_journal.go:491] ID: 38 Req-ID: pvc-ef77963e-594e-429e-9e3e-d03ceeaa46e5 generated Volume ID (0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-778121ba-ae18-409f-920d-821445f9a964) and image name (csi-vol-778121ba-ae18-409f-920d-821445f9a964) for request name (pvc-ef77963e-594e-429e-9e3e-d03ceeaa46e5)
I0730 05:05:50.151823       1 rbd_util.go:423] ID: 38 Req-ID: pvc-ef77963e-594e-429e-9e3e-d03ceeaa46e5 rbd: create kube/csi-vol-778121ba-ae18-409f-920d-821445f9a964 size 262144M (features: [layering]) using mon 10.96.240.200
I0730 05:05:50.151853       1 rbd_util.go:1563] ID: 38 Req-ID: pvc-ef77963e-594e-429e-9e3e-d03ceeaa46e5 setting image options on kube/csi-vol-778121ba-ae18-409f-920d-821445f9a964
I0730 05:05:50.198772       1 controllerserver.go:763] ID: 38 Req-ID: pvc-ef77963e-594e-429e-9e3e-d03ceeaa46e5 created image kube/csi-vol-778121ba-ae18-409f-920d-821445f9a964 backed for request name pvc-ef77963e-594e-429e-9e3e-d03ceeaa46e5
I0730 05:05:50.247129       1 omap.go:159] ID: 38 Req-ID: pvc-ef77963e-594e-429e-9e3e-d03ceeaa46e5 set omap keys (pool="kube", namespace="", name="csi.volume.778121ba-ae18-409f-920d-821445f9a964"): map[csi.imageid:37c684d662cd])
I0730 05:05:50.427463       1 utils.go:205] ID: 38 Req-ID: pvc-ef77963e-594e-429e-9e3e-d03ceeaa46e5 GRPC response: {"volume":{"capacity_bytes":274877906944,"volume_context":{"clusterID":"4837cbf8-4f90-4300-b3f6-726c9b9f89b4","imageFeatures":"layering","imageName":"csi-vol-778121ba-ae18-409f-920d-821445f9a964","journalPool":"kube","pool":"kube"},"volume_id":"0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-778121ba-ae18-409f-920d-821445f9a964"}}
I0730 05:06:01.388791       1 utils.go:198] ID: 39 GRPC call: /csi.v1.Identity/Probe
I0730 05:06:01.388844       1 utils.go:199] ID: 39 GRPC request: {}
I0730 05:06:01.388867       1 utils.go:205] ID: 39 GRPC response: {}
I0730 05:06:14.232069       1 utils.go:198] ID: 40 Req-ID: pvc-445e6753-8a41-40e1-b08f-eee9e8f85ce5 GRPC call: /csi.v1.Controller/CreateVolume
I0730 05:06:14.232428       1 utils.go:199] ID: 40 Req-ID: pvc-445e6753-8a41-40e1-b08f-eee9e8f85ce5 GRPC request: {"capacity_range":{"required_bytes":10737418240},"name":"pvc-445e6753-8a41-40e1-b08f-eee9e8f85ce5","parameters":{"clusterID":"4837cbf8-4f90-4300-b3f6-726c9b9f89b4","csi.storage.k8s.io/pv/name":"pvc-445e6753-8a41-40e1-b08f-eee9e8f85ce5","csi.storage.k8s.io/pvc/name":"persistence-rabbitmq-keystone-server-0","csi.storage.k8s.io/pvc/namespace":"openstack","imageFeatures":"layering","pool":"kube"},"secrets":"***stripped***","volume_capabilities":[{"AccessType":{"Mount":{"fs_type":"ext4","mount_flags":["discard"]}},"access_mode":{"mode":1}}]}
I0730 05:06:14.232641       1 rbd_util.go:1315] ID: 40 Req-ID: pvc-445e6753-8a41-40e1-b08f-eee9e8f85ce5 setting disableInUseChecks: false image features: [layering] mounter: rbd
I0730 05:06:14.241577       1 omap.go:89] ID: 40 Req-ID: pvc-445e6753-8a41-40e1-b08f-eee9e8f85ce5 got omap values: (pool="kube", namespace="", name="csi.volumes.default"): map[]
I0730 05:06:14.257700       1 omap.go:159] ID: 40 Req-ID: pvc-445e6753-8a41-40e1-b08f-eee9e8f85ce5 set omap keys (pool="kube", namespace="", name="csi.volumes.default"): map[csi.volume.pvc-445e6753-8a41-40e1-b08f-eee9e8f85ce5:ca4c49d7-3dd6-450a-94e5-3125e733359c])
I0730 05:06:14.264379       1 omap.go:159] ID: 40 Req-ID: pvc-445e6753-8a41-40e1-b08f-eee9e8f85ce5 set omap keys (pool="kube", namespace="", name="csi.volume.ca4c49d7-3dd6-450a-94e5-3125e733359c"): map[csi.imagename:csi-vol-ca4c49d7-3dd6-450a-94e5-3125e733359c csi.volname:pvc-445e6753-8a41-40e1-b08f-eee9e8f85ce5 csi.volume.owner:openstack])
I0730 05:06:14.264412       1 rbd_journal.go:491] ID: 40 Req-ID: pvc-445e6753-8a41-40e1-b08f-eee9e8f85ce5 generated Volume ID (0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-ca4c49d7-3dd6-450a-94e5-3125e733359c) and image name (csi-vol-ca4c49d7-3dd6-450a-94e5-3125e733359c) for request name (pvc-445e6753-8a41-40e1-b08f-eee9e8f85ce5)
I0730 05:06:14.264503       1 rbd_util.go:423] ID: 40 Req-ID: pvc-445e6753-8a41-40e1-b08f-eee9e8f85ce5 rbd: create kube/csi-vol-ca4c49d7-3dd6-450a-94e5-3125e733359c size 10240M (features: [layering]) using mon 10.96.240.200
I0730 05:06:14.264540       1 rbd_util.go:1563] ID: 40 Req-ID: pvc-445e6753-8a41-40e1-b08f-eee9e8f85ce5 setting image options on kube/csi-vol-ca4c49d7-3dd6-450a-94e5-3125e733359c
I0730 05:06:14.326036       1 controllerserver.go:763] ID: 40 Req-ID: pvc-445e6753-8a41-40e1-b08f-eee9e8f85ce5 created image kube/csi-vol-ca4c49d7-3dd6-450a-94e5-3125e733359c backed for request name pvc-445e6753-8a41-40e1-b08f-eee9e8f85ce5
I0730 05:06:14.355715       1 omap.go:159] ID: 40 Req-ID: pvc-445e6753-8a41-40e1-b08f-eee9e8f85ce5 set omap keys (pool="kube", namespace="", name="csi.volume.ca4c49d7-3dd6-450a-94e5-3125e733359c"): map[csi.imageid:37c641fbd83a])
I0730 05:06:14.463593       1 utils.go:205] ID: 40 Req-ID: pvc-445e6753-8a41-40e1-b08f-eee9e8f85ce5 GRPC response: {"volume":{"capacity_bytes":10737418240,"volume_context":{"clusterID":"4837cbf8-4f90-4300-b3f6-726c9b9f89b4","imageFeatures":"layering","imageName":"csi-vol-ca4c49d7-3dd6-450a-94e5-3125e733359c","journalPool":"kube","pool":"kube"},"volume_id":"0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-ca4c49d7-3dd6-450a-94e5-3125e733359c"}}
I0730 05:07:01.388830       1 utils.go:198] ID: 41 GRPC call: /csi.v1.Identity/Probe
I0730 05:07:01.388886       1 utils.go:199] ID: 41 GRPC request: {}
I0730 05:07:01.388911       1 utils.go:205] ID: 41 GRPC response: {}
I0730 05:08:01.396820       1 utils.go:198] ID: 42 GRPC call: /csi.v1.Identity/Probe
I0730 05:08:01.396884       1 utils.go:199] ID: 42 GRPC request: {}
I0730 05:08:01.396915       1 utils.go:205] ID: 42 GRPC response: {}
I0730 05:09:01.341261       1 utils.go:198] ID: 43 GRPC call: /csi.v1.Identity/Probe
I0730 05:09:01.341336       1 utils.go:199] ID: 43 GRPC request: {}
I0730 05:09:01.341518       1 utils.go:205] ID: 43 GRPC response: {}
I0730 05:10:01.396772       1 utils.go:198] ID: 44 GRPC call: /csi.v1.Identity/Probe
I0730 05:10:01.396851       1 utils.go:199] ID: 44 GRPC request: {}
I0730 05:10:01.396919       1 utils.go:205] ID: 44 GRPC response: {}
I0730 05:11:01.341277       1 utils.go:198] ID: 45 GRPC call: /csi.v1.Identity/Probe
I0730 05:11:01.341334       1 utils.go:199] ID: 45 GRPC request: {}
I0730 05:11:01.341380       1 utils.go:205] ID: 45 GRPC response: {}
I0730 05:11:12.573175       1 utils.go:198] ID: 46 GRPC call: /csi.v1.Identity/Probe
I0730 05:11:12.573223       1 utils.go:199] ID: 46 GRPC request: {}
I0730 05:11:12.573246       1 utils.go:205] ID: 46 GRPC response: {}
I0730 05:11:12.576310       1 utils.go:198] ID: 47 GRPC call: /csi.v1.Identity/GetPluginInfo
I0730 05:11:12.576534       1 utils.go:199] ID: 47 GRPC request: {}
I0730 05:11:12.576545       1 identityserver-default.go:40] ID: 47 Using default GetPluginInfo
I0730 05:11:12.576593       1 utils.go:205] ID: 47 GRPC response: {"name":"rbd.csi.ceph.com","vendor_version":"v3.11.0"}
I0730 05:11:12.578589       1 utils.go:198] ID: 48 GRPC call: /csi.v1.Identity/Probe
I0730 05:11:12.578647       1 utils.go:199] ID: 48 GRPC request: {}
I0730 05:11:12.578671       1 utils.go:205] ID: 48 GRPC response: {}
I0730 05:11:12.579287       1 utils.go:198] ID: 49 GRPC call: /csi.v1.Identity/GetPluginCapabilities
I0730 05:11:12.579312       1 utils.go:199] ID: 49 GRPC request: {}
I0730 05:11:12.579474       1 utils.go:205] ID: 49 GRPC response: {"capabilities":[{"Type":{"Service":{"type":1}}},{"Type":{"VolumeExpansion":{"type":1}}},{"Type":{"Service":{"type":2}}}]}
I0730 05:11:12.580199       1 utils.go:198] ID: 50 GRPC call: /csi.v1.Controller/ControllerGetCapabilities
I0730 05:11:12.580236       1 utils.go:199] ID: 50 GRPC request: {}
I0730 05:11:12.580247       1 controllerserver-default.go:42] ID: 50 Using default ControllerGetCapabilities
I0730 05:11:12.580340       1 utils.go:205] ID: 50 GRPC response: {"capabilities":[{"Type":{"Rpc":{"type":1}}},{"Type":{"Rpc":{"type":5}}},{"Type":{"Rpc":{"type":7}}},{"Type":{"Rpc":{"type":9}}}]}
I0730 05:11:12.688444       1 utils.go:198] ID: 51 GRPC call: /csi.v1.Identity/Probe
I0730 05:11:12.688486       1 utils.go:199] ID: 51 GRPC request: {}
I0730 05:11:12.688502       1 utils.go:205] ID: 51 GRPC response: {}
I0730 05:11:12.689976       1 utils.go:198] ID: 52 GRPC call: /csi.v1.Identity/GetPluginInfo
I0730 05:11:12.689989       1 utils.go:199] ID: 52 GRPC request: {}
I0730 05:11:12.689997       1 identityserver-default.go:40] ID: 52 Using default GetPluginInfo
I0730 05:11:12.690018       1 utils.go:205] ID: 52 GRPC response: {"name":"rbd.csi.ceph.com","vendor_version":"v3.11.0"}
I0730 05:11:12.695729       1 utils.go:198] ID: 53 GRPC call: /csi.v1.Identity/Probe
I0730 05:11:12.695781       1 utils.go:199] ID: 53 GRPC request: {}
I0730 05:11:12.695811       1 utils.go:205] ID: 53 GRPC response: {}
I0730 05:11:12.696490       1 utils.go:198] ID: 54 GRPC call: /csi.v1.Identity/GetPluginCapabilities
I0730 05:11:12.696536       1 utils.go:199] ID: 54 GRPC request: {}
I0730 05:11:12.696645       1 utils.go:205] ID: 54 GRPC response: {"capabilities":[{"Type":{"Service":{"type":1}}},{"Type":{"VolumeExpansion":{"type":1}}},{"Type":{"Service":{"type":2}}}]}
I0730 05:11:12.697225       1 utils.go:198] ID: 55 GRPC call: /csi.v1.Controller/ControllerGetCapabilities
I0730 05:11:12.697245       1 utils.go:199] ID: 55 GRPC request: {}
I0730 05:11:12.697256       1 controllerserver-default.go:42] ID: 55 Using default ControllerGetCapabilities
I0730 05:11:12.697322       1 utils.go:205] ID: 55 GRPC response: {"capabilities":[{"Type":{"Rpc":{"type":1}}},{"Type":{"Rpc":{"type":5}}},{"Type":{"Rpc":{"type":7}}},{"Type":{"Rpc":{"type":9}}}]}
I0730 05:11:12.697894       1 utils.go:198] ID: 56 GRPC call: /csi.v1.Controller/ControllerGetCapabilities
I0730 05:11:12.697912       1 utils.go:199] ID: 56 GRPC request: {}
I0730 05:11:12.697917       1 controllerserver-default.go:42] ID: 56 Using default ControllerGetCapabilities
I0730 05:11:12.697965       1 utils.go:205] ID: 56 GRPC response: {"capabilities":[{"Type":{"Rpc":{"type":1}}},{"Type":{"Rpc":{"type":5}}},{"Type":{"Rpc":{"type":7}}},{"Type":{"Rpc":{"type":9}}}]}
I0730 05:11:12.698462       1 utils.go:198] ID: 57 GRPC call: /csi.v1.Controller/ControllerGetCapabilities
I0730 05:11:12.698495       1 utils.go:199] ID: 57 GRPC request: {}
I0730 05:11:12.698508       1 controllerserver-default.go:42] ID: 57 Using default ControllerGetCapabilities
I0730 05:11:12.698639       1 utils.go:205] ID: 57 GRPC response: {"capabilities":[{"Type":{"Rpc":{"type":1}}},{"Type":{"Rpc":{"type":5}}},{"Type":{"Rpc":{"type":7}}},{"Type":{"Rpc":{"type":9}}}]}
I0730 05:11:12.873059       1 utils.go:198] ID: 58 GRPC call: /csi.v1.Identity/GetPluginInfo
I0730 05:11:12.873108       1 utils.go:199] ID: 58 GRPC request: {}
I0730 05:11:12.873119       1 identityserver-default.go:40] ID: 58 Using default GetPluginInfo
I0730 05:11:12.873151       1 utils.go:205] ID: 58 GRPC response: {"name":"rbd.csi.ceph.com","vendor_version":"v3.11.0"}
I0730 05:11:12.875814       1 utils.go:198] ID: 59 GRPC call: /csi.v1.Identity/Probe
I0730 05:11:12.875835       1 utils.go:199] ID: 59 GRPC request: {}
I0730 05:11:12.875852       1 utils.go:205] ID: 59 GRPC response: {}
I0730 05:11:12.876489       1 utils.go:198] ID: 60 GRPC call: /csi.v1.Controller/ControllerGetCapabilities
I0730 05:11:12.876546       1 utils.go:199] ID: 60 GRPC request: {}
I0730 05:11:12.876561       1 controllerserver-default.go:42] ID: 60 Using default ControllerGetCapabilities
I0730 05:11:12.876691       1 utils.go:205] ID: 60 GRPC response: {"capabilities":[{"Type":{"Rpc":{"type":1}}},{"Type":{"Rpc":{"type":5}}},{"Type":{"Rpc":{"type":7}}},{"Type":{"Rpc":{"type":9}}}]}
I0730 05:11:13.034541       1 utils.go:198] ID: 61 GRPC call: /csi.v1.Identity/Probe
I0730 05:11:13.034581       1 utils.go:199] ID: 61 GRPC request: {}
I0730 05:11:13.034653       1 utils.go:205] ID: 61 GRPC response: {}
I0730 05:11:13.037612       1 utils.go:198] ID: 62 GRPC call: /csi.v1.Identity/GetPluginInfo
I0730 05:11:13.037666       1 utils.go:199] ID: 62 GRPC request: {}
I0730 05:11:13.037694       1 identityserver-default.go:40] ID: 62 Using default GetPluginInfo
I0730 05:11:13.037746       1 utils.go:205] ID: 62 GRPC response: {"name":"rbd.csi.ceph.com","vendor_version":"v3.11.0"}
I0730 05:11:13.040681       1 utils.go:198] ID: 63 GRPC call: /csi.v1.Identity/Probe
I0730 05:11:13.040752       1 utils.go:199] ID: 63 GRPC request: {}
I0730 05:11:13.040783       1 utils.go:205] ID: 63 GRPC response: {}
I0730 05:11:13.041977       1 utils.go:198] ID: 64 GRPC call: /csi.v1.Identity/GetPluginCapabilities
I0730 05:11:13.042000       1 utils.go:199] ID: 64 GRPC request: {}
I0730 05:11:13.042092       1 utils.go:205] ID: 64 GRPC response: {"capabilities":[{"Type":{"Service":{"type":1}}},{"Type":{"VolumeExpansion":{"type":1}}},{"Type":{"Service":{"type":2}}}]}
I0730 05:11:13.043013       1 utils.go:198] ID: 65 GRPC call: /csi.v1.Controller/ControllerGetCapabilities
I0730 05:11:13.043046       1 utils.go:199] ID: 65 GRPC request: {}
I0730 05:11:13.043059       1 controllerserver-default.go:42] ID: 65 Using default ControllerGetCapabilities
I0730 05:11:13.043204       1 utils.go:205] ID: 65 GRPC response: {"capabilities":[{"Type":{"Rpc":{"type":1}}},{"Type":{"Rpc":{"type":5}}},{"Type":{"Rpc":{"type":7}}},{"Type":{"Rpc":{"type":9}}}]}
I0730 05:12:01.392947       1 utils.go:198] ID: 66 GRPC call: /csi.v1.Identity/Probe
I0730 05:12:01.393013       1 utils.go:199] ID: 66 GRPC request: {}
I0730 05:12:01.393107       1 utils.go:205] ID: 66 GRPC response: {}
I0730 05:13:01.351204       1 utils.go:198] ID: 67 GRPC call: /csi.v1.Identity/Probe
I0730 05:13:01.351279       1 utils.go:199] ID: 67 GRPC request: {}
I0730 05:13:01.351316       1 utils.go:205] ID: 67 GRPC response: {}
I0730 05:14:01.341499       1 utils.go:198] ID: 68 GRPC call: /csi.v1.Identity/Probe
I0730 05:14:01.341571       1 utils.go:199] ID: 68 GRPC request: {}
I0730 05:14:01.341614       1 utils.go:205] ID: 68 GRPC response: {}
I0730 05:15:01.362080       1 utils.go:198] ID: 69 GRPC call: /csi.v1.Identity/Probe
I0730 05:15:01.362150       1 utils.go:199] ID: 69 GRPC request: {}
I0730 05:15:01.362170       1 utils.go:205] ID: 69 GRPC response: {}
I0730 05:16:01.340776       1 utils.go:198] ID: 70 GRPC call: /csi.v1.Identity/Probe
I0730 05:16:01.340841       1 utils.go:199] ID: 70 GRPC request: {}
I0730 05:16:01.340868       1 utils.go:205] ID: 70 GRPC response: {}
I0730 05:17:01.371635       1 utils.go:198] ID: 71 GRPC call: /csi.v1.Identity/Probe
I0730 05:17:01.371710       1 utils.go:199] ID: 71 GRPC request: {}
I0730 05:17:01.371744       1 utils.go:205] ID: 71 GRPC response: {}
I0730 05:17:19.122683       1 utils.go:198] ID: 72 Req-ID: pvc-58cc9289-1a80-495c-ad77-4e22d183cc82 GRPC call: /csi.v1.Controller/CreateVolume
I0730 05:17:19.122881       1 utils.go:199] ID: 72 Req-ID: pvc-58cc9289-1a80-495c-ad77-4e22d183cc82 GRPC request: {"capacity_range":{"required_bytes":10737418240},"name":"pvc-58cc9289-1a80-495c-ad77-4e22d183cc82","parameters":{"clusterID":"4837cbf8-4f90-4300-b3f6-726c9b9f89b4","csi.storage.k8s.io/pv/name":"pvc-58cc9289-1a80-495c-ad77-4e22d183cc82","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 05:17:19.123081       1 rbd_util.go:1315] ID: 72 Req-ID: pvc-58cc9289-1a80-495c-ad77-4e22d183cc82 setting disableInUseChecks: false image features: [layering] mounter: rbd
I0730 05:17:19.124817       1 omap.go:89] ID: 72 Req-ID: pvc-58cc9289-1a80-495c-ad77-4e22d183cc82 got omap values: (pool="kube", namespace="", name="csi.volumes.default"): map[]
I0730 05:17:19.158275       1 omap.go:159] ID: 72 Req-ID: pvc-58cc9289-1a80-495c-ad77-4e22d183cc82 set omap keys (pool="kube", namespace="", name="csi.volumes.default"): map[csi.volume.pvc-58cc9289-1a80-495c-ad77-4e22d183cc82:da8d799c-6bbc-4a17-b856-0bf2fb127506])
I0730 05:17:19.172328       1 omap.go:159] ID: 72 Req-ID: pvc-58cc9289-1a80-495c-ad77-4e22d183cc82 set omap keys (pool="kube", namespace="", name="csi.volume.da8d799c-6bbc-4a17-b856-0bf2fb127506"): map[csi.imagename:csi-vol-da8d799c-6bbc-4a17-b856-0bf2fb127506 csi.volname:pvc-58cc9289-1a80-495c-ad77-4e22d183cc82 csi.volume.owner:openstack])
I0730 05:17:19.172379       1 rbd_journal.go:491] ID: 72 Req-ID: pvc-58cc9289-1a80-495c-ad77-4e22d183cc82 generated Volume ID (0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-da8d799c-6bbc-4a17-b856-0bf2fb127506) and image name (csi-vol-da8d799c-6bbc-4a17-b856-0bf2fb127506) for request name (pvc-58cc9289-1a80-495c-ad77-4e22d183cc82)
I0730 05:17:19.172556       1 rbd_util.go:423] ID: 72 Req-ID: pvc-58cc9289-1a80-495c-ad77-4e22d183cc82 rbd: create kube/csi-vol-da8d799c-6bbc-4a17-b856-0bf2fb127506 size 10240M (features: [layering]) using mon 10.96.240.200
I0730 05:17:19.172639       1 rbd_util.go:1563] ID: 72 Req-ID: pvc-58cc9289-1a80-495c-ad77-4e22d183cc82 setting image options on kube/csi-vol-da8d799c-6bbc-4a17-b856-0bf2fb127506
I0730 05:17:19.216002       1 controllerserver.go:763] ID: 72 Req-ID: pvc-58cc9289-1a80-495c-ad77-4e22d183cc82 created image kube/csi-vol-da8d799c-6bbc-4a17-b856-0bf2fb127506 backed for request name pvc-58cc9289-1a80-495c-ad77-4e22d183cc82
I0730 05:17:19.275646       1 omap.go:159] ID: 72 Req-ID: pvc-58cc9289-1a80-495c-ad77-4e22d183cc82 set omap keys (pool="kube", namespace="", name="csi.volume.da8d799c-6bbc-4a17-b856-0bf2fb127506"): map[csi.imageid:37c6dac915e8])
I0730 05:17:19.403125       1 utils.go:205] ID: 72 Req-ID: pvc-58cc9289-1a80-495c-ad77-4e22d183cc82 GRPC response: {"volume":{"capacity_bytes":10737418240,"volume_context":{"clusterID":"4837cbf8-4f90-4300-b3f6-726c9b9f89b4","imageFeatures":"layering","imageName":"csi-vol-da8d799c-6bbc-4a17-b856-0bf2fb127506","journalPool":"kube","pool":"kube"},"volume_id":"0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-da8d799c-6bbc-4a17-b856-0bf2fb127506"}}
I0730 05:18:01.344075       1 utils.go:198] ID: 73 GRPC call: /csi.v1.Identity/Probe
I0730 05:18:01.344116       1 utils.go:199] ID: 73 GRPC request: {}
I0730 05:18:01.344190       1 utils.go:205] ID: 73 GRPC response: {}
I0730 05:19:01.381987       1 utils.go:198] ID: 74 GRPC call: /csi.v1.Identity/Probe
I0730 05:19:01.382071       1 utils.go:199] ID: 74 GRPC request: {}
I0730 05:19:01.382099       1 utils.go:205] ID: 74 GRPC response: {}
I0730 05:20:01.396656       1 utils.go:198] ID: 75 GRPC call: /csi.v1.Identity/Probe
I0730 05:20:01.396727       1 utils.go:199] ID: 75 GRPC request: {}
I0730 05:20:01.396758       1 utils.go:205] ID: 75 GRPC response: {}
I0730 05:21:01.392109       1 utils.go:198] ID: 76 GRPC call: /csi.v1.Identity/Probe
I0730 05:21:01.392205       1 utils.go:199] ID: 76 GRPC request: {}
I0730 05:21:01.392242       1 utils.go:205] ID: 76 GRPC response: {}
I0730 05:22:01.381382       1 utils.go:198] ID: 77 GRPC call: /csi.v1.Identity/Probe
I0730 05:22:01.381435       1 utils.go:199] ID: 77 GRPC request: {}
I0730 05:22:01.381457       1 utils.go:205] ID: 77 GRPC response: {}
I0730 05:22:43.853098       1 utils.go:198] ID: 78 Req-ID: pvc-f6f2274c-8959-4ead-9832-8613d47152ae GRPC call: /csi.v1.Controller/CreateVolume
I0730 05:22:43.853283       1 utils.go:199] ID: 78 Req-ID: pvc-f6f2274c-8959-4ead-9832-8613d47152ae GRPC request: {"capacity_range":{"required_bytes":10737418240},"name":"pvc-f6f2274c-8959-4ead-9832-8613d47152ae","parameters":{"clusterID":"4837cbf8-4f90-4300-b3f6-726c9b9f89b4","csi.storage.k8s.io/pv/name":"pvc-f6f2274c-8959-4ead-9832-8613d47152ae","csi.storage.k8s.io/pvc/name":"persistence-rabbitmq-glance-server-0","csi.storage.k8s.io/pvc/namespace":"openstack","imageFeatures":"layering","pool":"kube"},"secrets":"***stripped***","volume_capabilities":[{"AccessType":{"Mount":{"fs_type":"ext4","mount_flags":["discard"]}},"access_mode":{"mode":1}}]}
I0730 05:22:43.853427       1 rbd_util.go:1315] ID: 78 Req-ID: pvc-f6f2274c-8959-4ead-9832-8613d47152ae setting disableInUseChecks: false image features: [layering] mounter: rbd
I0730 05:22:43.854904       1 omap.go:89] ID: 78 Req-ID: pvc-f6f2274c-8959-4ead-9832-8613d47152ae got omap values: (pool="kube", namespace="", name="csi.volumes.default"): map[]
I0730 05:22:43.870674       1 omap.go:159] ID: 78 Req-ID: pvc-f6f2274c-8959-4ead-9832-8613d47152ae set omap keys (pool="kube", namespace="", name="csi.volumes.default"): map[csi.volume.pvc-f6f2274c-8959-4ead-9832-8613d47152ae:37b871e5-9bea-40c2-94c2-969ba0e94c30])
I0730 05:22:43.878550       1 omap.go:159] ID: 78 Req-ID: pvc-f6f2274c-8959-4ead-9832-8613d47152ae set omap keys (pool="kube", namespace="", name="csi.volume.37b871e5-9bea-40c2-94c2-969ba0e94c30"): map[csi.imagename:csi-vol-37b871e5-9bea-40c2-94c2-969ba0e94c30 csi.volname:pvc-f6f2274c-8959-4ead-9832-8613d47152ae csi.volume.owner:openstack])
I0730 05:22:43.878586       1 rbd_journal.go:491] ID: 78 Req-ID: pvc-f6f2274c-8959-4ead-9832-8613d47152ae generated Volume ID (0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-37b871e5-9bea-40c2-94c2-969ba0e94c30) and image name (csi-vol-37b871e5-9bea-40c2-94c2-969ba0e94c30) for request name (pvc-f6f2274c-8959-4ead-9832-8613d47152ae)
I0730 05:22:43.878685       1 rbd_util.go:423] ID: 78 Req-ID: pvc-f6f2274c-8959-4ead-9832-8613d47152ae rbd: create kube/csi-vol-37b871e5-9bea-40c2-94c2-969ba0e94c30 size 10240M (features: [layering]) using mon 10.96.240.200
I0730 05:22:43.878745       1 rbd_util.go:1563] ID: 78 Req-ID: pvc-f6f2274c-8959-4ead-9832-8613d47152ae setting image options on kube/csi-vol-37b871e5-9bea-40c2-94c2-969ba0e94c30
I0730 05:22:43.920018       1 controllerserver.go:763] ID: 78 Req-ID: pvc-f6f2274c-8959-4ead-9832-8613d47152ae created image kube/csi-vol-37b871e5-9bea-40c2-94c2-969ba0e94c30 backed for request name pvc-f6f2274c-8959-4ead-9832-8613d47152ae
I0730 05:22:43.961850       1 omap.go:159] ID: 78 Req-ID: pvc-f6f2274c-8959-4ead-9832-8613d47152ae set omap keys (pool="kube", namespace="", name="csi.volume.37b871e5-9bea-40c2-94c2-969ba0e94c30"): map[csi.imageid:37c655403485])
I0730 05:22:44.078048       1 utils.go:205] ID: 78 Req-ID: pvc-f6f2274c-8959-4ead-9832-8613d47152ae GRPC response: {"volume":{"capacity_bytes":10737418240,"volume_context":{"clusterID":"4837cbf8-4f90-4300-b3f6-726c9b9f89b4","imageFeatures":"layering","imageName":"csi-vol-37b871e5-9bea-40c2-94c2-969ba0e94c30","journalPool":"kube","pool":"kube"},"volume_id":"0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-37b871e5-9bea-40c2-94c2-969ba0e94c30"}}
I0730 05:23:01.377868       1 utils.go:198] ID: 79 GRPC call: /csi.v1.Identity/Probe
I0730 05:23:01.377935       1 utils.go:199] ID: 79 GRPC request: {}
I0730 05:23:01.377965       1 utils.go:205] ID: 79 GRPC response: {}
I0730 05:24:01.340700       1 utils.go:198] ID: 80 GRPC call: /csi.v1.Identity/Probe
I0730 05:24:01.340780       1 utils.go:199] ID: 80 GRPC request: {}
I0730 05:24:01.340820       1 utils.go:205] ID: 80 GRPC response: {}
I0730 05:25:01.397598       1 utils.go:198] ID: 81 GRPC call: /csi.v1.Identity/Probe
I0730 05:25:01.397672       1 utils.go:199] ID: 81 GRPC request: {}
I0730 05:25:01.397690       1 utils.go:205] ID: 81 GRPC response: {}
I0730 05:26:01.340729       1 utils.go:198] ID: 82 GRPC call: /csi.v1.Identity/Probe
I0730 05:26:01.340779       1 utils.go:199] ID: 82 GRPC request: {}
I0730 05:26:01.340803       1 utils.go:205] ID: 82 GRPC response: {}
I0730 05:27:01.396782       1 utils.go:198] ID: 83 GRPC call: /csi.v1.Identity/Probe
I0730 05:27:01.396855       1 utils.go:199] ID: 83 GRPC request: {}
I0730 05:27:01.396910       1 utils.go:205] ID: 83 GRPC response: {}
I0730 05:28:01.341068       1 utils.go:198] ID: 84 GRPC call: /csi.v1.Identity/Probe
I0730 05:28:01.341132       1 utils.go:199] ID: 84 GRPC request: {}
I0730 05:28:01.341156       1 utils.go:205] ID: 84 GRPC response: {}
I0730 05:28:25.725467       1 utils.go:198] ID: 85 Req-ID: pvc-9c9323a1-0695-4b12-9636-f1b89aa4cc74 GRPC call: /csi.v1.Controller/CreateVolume
I0730 05:28:25.725645       1 utils.go:199] ID: 85 Req-ID: pvc-9c9323a1-0695-4b12-9636-f1b89aa4cc74 GRPC request: {"capacity_range":{"required_bytes":10737418240},"name":"pvc-9c9323a1-0695-4b12-9636-f1b89aa4cc74","parameters":{"clusterID":"4837cbf8-4f90-4300-b3f6-726c9b9f89b4","csi.storage.k8s.io/pv/name":"pvc-9c9323a1-0695-4b12-9636-f1b89aa4cc74","csi.storage.k8s.io/pvc/name":"persistence-rabbitmq-cinder-server-0","csi.storage.k8s.io/pvc/namespace":"openstack","imageFeatures":"layering","pool":"kube"},"secrets":"***stripped***","volume_capabilities":[{"AccessType":{"Mount":{"fs_type":"ext4","mount_flags":["discard"]}},"access_mode":{"mode":1}}]}
I0730 05:28:25.725780       1 rbd_util.go:1315] ID: 85 Req-ID: pvc-9c9323a1-0695-4b12-9636-f1b89aa4cc74 setting disableInUseChecks: false image features: [layering] mounter: rbd
I0730 05:28:25.729658       1 omap.go:89] ID: 85 Req-ID: pvc-9c9323a1-0695-4b12-9636-f1b89aa4cc74 got omap values: (pool="kube", namespace="", name="csi.volumes.default"): map[]
I0730 05:28:25.757318       1 omap.go:159] ID: 85 Req-ID: pvc-9c9323a1-0695-4b12-9636-f1b89aa4cc74 set omap keys (pool="kube", namespace="", name="csi.volumes.default"): map[csi.volume.pvc-9c9323a1-0695-4b12-9636-f1b89aa4cc74:0e1f978a-cd70-4eae-8c24-9a2f182dd378])
I0730 05:28:25.766424       1 omap.go:159] ID: 85 Req-ID: pvc-9c9323a1-0695-4b12-9636-f1b89aa4cc74 set omap keys (pool="kube", namespace="", name="csi.volume.0e1f978a-cd70-4eae-8c24-9a2f182dd378"): map[csi.imagename:csi-vol-0e1f978a-cd70-4eae-8c24-9a2f182dd378 csi.volname:pvc-9c9323a1-0695-4b12-9636-f1b89aa4cc74 csi.volume.owner:openstack])
I0730 05:28:25.766460       1 rbd_journal.go:491] ID: 85 Req-ID: pvc-9c9323a1-0695-4b12-9636-f1b89aa4cc74 generated Volume ID (0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-0e1f978a-cd70-4eae-8c24-9a2f182dd378) and image name (csi-vol-0e1f978a-cd70-4eae-8c24-9a2f182dd378) for request name (pvc-9c9323a1-0695-4b12-9636-f1b89aa4cc74)
I0730 05:28:25.766535       1 rbd_util.go:423] ID: 85 Req-ID: pvc-9c9323a1-0695-4b12-9636-f1b89aa4cc74 rbd: create kube/csi-vol-0e1f978a-cd70-4eae-8c24-9a2f182dd378 size 10240M (features: [layering]) using mon 10.96.240.200
I0730 05:28:25.766592       1 rbd_util.go:1563] ID: 85 Req-ID: pvc-9c9323a1-0695-4b12-9636-f1b89aa4cc74 setting image options on kube/csi-vol-0e1f978a-cd70-4eae-8c24-9a2f182dd378
I0730 05:28:25.801833       1 controllerserver.go:763] ID: 85 Req-ID: pvc-9c9323a1-0695-4b12-9636-f1b89aa4cc74 created image kube/csi-vol-0e1f978a-cd70-4eae-8c24-9a2f182dd378 backed for request name pvc-9c9323a1-0695-4b12-9636-f1b89aa4cc74
I0730 05:28:25.835152       1 omap.go:159] ID: 85 Req-ID: pvc-9c9323a1-0695-4b12-9636-f1b89aa4cc74 set omap keys (pool="kube", namespace="", name="csi.volume.0e1f978a-cd70-4eae-8c24-9a2f182dd378"): map[csi.imageid:37c6b46049ae])
I0730 05:28:26.312793       1 utils.go:205] ID: 85 Req-ID: pvc-9c9323a1-0695-4b12-9636-f1b89aa4cc74 GRPC response: {"volume":{"capacity_bytes":10737418240,"volume_context":{"clusterID":"4837cbf8-4f90-4300-b3f6-726c9b9f89b4","imageFeatures":"layering","imageName":"csi-vol-0e1f978a-cd70-4eae-8c24-9a2f182dd378","journalPool":"kube","pool":"kube"},"volume_id":"0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-0e1f978a-cd70-4eae-8c24-9a2f182dd378"}}
I0730 05:29:01.395307       1 utils.go:198] ID: 86 GRPC call: /csi.v1.Identity/Probe
I0730 05:29:01.395353       1 utils.go:199] ID: 86 GRPC request: {}
I0730 05:29:01.395385       1 utils.go:205] ID: 86 GRPC response: {}
I0730 05:30:01.351264       1 utils.go:198] ID: 87 GRPC call: /csi.v1.Identity/Probe
I0730 05:30:01.351310       1 utils.go:199] ID: 87 GRPC request: {}
I0730 05:30:01.351328       1 utils.go:205] ID: 87 GRPC response: {}
I0730 05:31:01.340677       1 utils.go:198] ID: 88 GRPC call: /csi.v1.Identity/Probe
I0730 05:31:01.340740       1 utils.go:199] ID: 88 GRPC request: {}
I0730 05:31:01.340767       1 utils.go:205] ID: 88 GRPC response: {}
I0730 05:32:01.365778       1 utils.go:198] ID: 89 GRPC call: /csi.v1.Identity/Probe
I0730 05:32:01.365848       1 utils.go:199] ID: 89 GRPC request: {}
I0730 05:32:01.365874       1 utils.go:205] ID: 89 GRPC response: {}
I0730 05:33:01.397053       1 utils.go:198] ID: 90 GRPC call: /csi.v1.Identity/Probe
I0730 05:33:01.397116       1 utils.go:199] ID: 90 GRPC request: {}
I0730 05:33:01.397146       1 utils.go:205] ID: 90 GRPC response: {}
I0730 05:34:01.373170       1 utils.go:198] ID: 91 GRPC call: /csi.v1.Identity/Probe
I0730 05:34:01.373240       1 utils.go:199] ID: 91 GRPC request: {}
I0730 05:34:01.373291       1 utils.go:205] ID: 91 GRPC response: {}
I0730 05:35:01.397617       1 utils.go:198] ID: 92 GRPC call: /csi.v1.Identity/Probe
I0730 05:35:01.397718       1 utils.go:199] ID: 92 GRPC request: {}
I0730 05:35:01.397757       1 utils.go:205] ID: 92 GRPC response: {}
I0730 05:36:01.382475       1 utils.go:198] ID: 93 GRPC call: /csi.v1.Identity/Probe
I0730 05:36:01.382519       1 utils.go:199] ID: 93 GRPC request: {}
I0730 05:36:01.382540       1 utils.go:205] ID: 93 GRPC response: {}
I0730 05:37:01.341953       1 utils.go:198] ID: 94 GRPC call: /csi.v1.Identity/Probe
I0730 05:37:01.342136       1 utils.go:199] ID: 94 GRPC request: {}
I0730 05:37:01.342195       1 utils.go:205] ID: 94 GRPC response: {}
I0730 05:38:01.393694       1 utils.go:198] ID: 95 GRPC call: /csi.v1.Identity/Probe
I0730 05:38:01.393763       1 utils.go:199] ID: 95 GRPC request: {}
I0730 05:38:01.393791       1 utils.go:205] ID: 95 GRPC response: {}
I0730 05:39:01.340608       1 utils.go:198] ID: 96 GRPC call: /csi.v1.Identity/Probe
I0730 05:39:01.340699       1 utils.go:199] ID: 96 GRPC request: {}
I0730 05:39:01.340740       1 utils.go:205] ID: 96 GRPC response: {}
I0730 05:40:01.400194       1 utils.go:198] ID: 97 GRPC call: /csi.v1.Identity/Probe
I0730 05:40:01.400301       1 utils.go:199] ID: 97 GRPC request: {}
I0730 05:40:01.400352       1 utils.go:205] ID: 97 GRPC response: {}
I0730 05:40:13.626899       1 utils.go:198] ID: 98 Req-ID: pvc-bdefe56e-3beb-41ff-9242-e6b8e1e77869 GRPC call: /csi.v1.Controller/CreateVolume
I0730 05:40:13.627104       1 utils.go:199] ID: 98 Req-ID: pvc-bdefe56e-3beb-41ff-9242-e6b8e1e77869 GRPC request: {"capacity_range":{"required_bytes":10737418240},"name":"pvc-bdefe56e-3beb-41ff-9242-e6b8e1e77869","parameters":{"clusterID":"4837cbf8-4f90-4300-b3f6-726c9b9f89b4","csi.storage.k8s.io/pv/name":"pvc-bdefe56e-3beb-41ff-9242-e6b8e1e77869","csi.storage.k8s.io/pvc/name":"persistence-rabbitmq-nova-server-0","csi.storage.k8s.io/pvc/namespace":"openstack","imageFeatures":"layering","pool":"kube"},"secrets":"***stripped***","volume_capabilities":[{"AccessType":{"Mount":{"fs_type":"ext4","mount_flags":["discard"]}},"access_mode":{"mode":1}}]}
I0730 05:40:13.627387       1 rbd_util.go:1315] ID: 98 Req-ID: pvc-bdefe56e-3beb-41ff-9242-e6b8e1e77869 setting disableInUseChecks: false image features: [layering] mounter: rbd
I0730 05:40:13.630211       1 omap.go:89] ID: 98 Req-ID: pvc-bdefe56e-3beb-41ff-9242-e6b8e1e77869 got omap values: (pool="kube", namespace="", name="csi.volumes.default"): map[]
I0730 05:40:13.653355       1 omap.go:159] ID: 98 Req-ID: pvc-bdefe56e-3beb-41ff-9242-e6b8e1e77869 set omap keys (pool="kube", namespace="", name="csi.volumes.default"): map[csi.volume.pvc-bdefe56e-3beb-41ff-9242-e6b8e1e77869:552b43cd-33da-407d-9e0a-7ce5130a4bfc])
I0730 05:40:13.660349       1 omap.go:159] ID: 98 Req-ID: pvc-bdefe56e-3beb-41ff-9242-e6b8e1e77869 set omap keys (pool="kube", namespace="", name="csi.volume.552b43cd-33da-407d-9e0a-7ce5130a4bfc"): map[csi.imagename:csi-vol-552b43cd-33da-407d-9e0a-7ce5130a4bfc csi.volname:pvc-bdefe56e-3beb-41ff-9242-e6b8e1e77869 csi.volume.owner:openstack])
I0730 05:40:13.660392       1 rbd_journal.go:491] ID: 98 Req-ID: pvc-bdefe56e-3beb-41ff-9242-e6b8e1e77869 generated Volume ID (0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-552b43cd-33da-407d-9e0a-7ce5130a4bfc) and image name (csi-vol-552b43cd-33da-407d-9e0a-7ce5130a4bfc) for request name (pvc-bdefe56e-3beb-41ff-9242-e6b8e1e77869)
I0730 05:40:13.660505       1 rbd_util.go:423] ID: 98 Req-ID: pvc-bdefe56e-3beb-41ff-9242-e6b8e1e77869 rbd: create kube/csi-vol-552b43cd-33da-407d-9e0a-7ce5130a4bfc size 10240M (features: [layering]) using mon 10.96.240.200
I0730 05:40:13.660566       1 rbd_util.go:1563] ID: 98 Req-ID: pvc-bdefe56e-3beb-41ff-9242-e6b8e1e77869 setting image options on kube/csi-vol-552b43cd-33da-407d-9e0a-7ce5130a4bfc
I0730 05:40:13.701280       1 controllerserver.go:763] ID: 98 Req-ID: pvc-bdefe56e-3beb-41ff-9242-e6b8e1e77869 created image kube/csi-vol-552b43cd-33da-407d-9e0a-7ce5130a4bfc backed for request name pvc-bdefe56e-3beb-41ff-9242-e6b8e1e77869
I0730 05:40:13.756027       1 omap.go:159] ID: 98 Req-ID: pvc-bdefe56e-3beb-41ff-9242-e6b8e1e77869 set omap keys (pool="kube", namespace="", name="csi.volume.552b43cd-33da-407d-9e0a-7ce5130a4bfc"): map[csi.imageid:37c6b9264903])
I0730 05:40:13.886969       1 utils.go:205] ID: 98 Req-ID: pvc-bdefe56e-3beb-41ff-9242-e6b8e1e77869 GRPC response: {"volume":{"capacity_bytes":10737418240,"volume_context":{"clusterID":"4837cbf8-4f90-4300-b3f6-726c9b9f89b4","imageFeatures":"layering","imageName":"csi-vol-552b43cd-33da-407d-9e0a-7ce5130a4bfc","journalPool":"kube","pool":"kube"},"volume_id":"0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-552b43cd-33da-407d-9e0a-7ce5130a4bfc"}}
I0730 05:41:01.340620       1 utils.go:198] ID: 99 GRPC call: /csi.v1.Identity/Probe
I0730 05:41:01.340687       1 utils.go:199] ID: 99 GRPC request: {}
I0730 05:41:01.340719       1 utils.go:205] ID: 99 GRPC response: {}
I0730 05:42:01.401580       1 utils.go:198] ID: 100 GRPC call: /csi.v1.Identity/Probe
I0730 05:42:01.401624       1 utils.go:199] ID: 100 GRPC request: {}
I0730 05:42:01.401642       1 utils.go:205] ID: 100 GRPC response: {}
I0730 05:43:01.341324       1 utils.go:198] ID: 101 GRPC call: /csi.v1.Identity/Probe
I0730 05:43:01.341398       1 utils.go:199] ID: 101 GRPC request: {}
I0730 05:43:01.341431       1 utils.go:205] ID: 101 GRPC response: {}
I0730 05:44:01.340725       1 utils.go:198] ID: 102 GRPC call: /csi.v1.Identity/Probe
I0730 05:44:01.340794       1 utils.go:199] ID: 102 GRPC request: {}
I0730 05:44:01.340822       1 utils.go:205] ID: 102 GRPC response: {}
I0730 05:45:01.352037       1 utils.go:198] ID: 103 GRPC call: /csi.v1.Identity/Probe
I0730 05:45:01.352111       1 utils.go:199] ID: 103 GRPC request: {}
I0730 05:45:01.352167       1 utils.go:205] ID: 103 GRPC response: {}
I0730 05:46:01.340783       1 utils.go:198] ID: 104 GRPC call: /csi.v1.Identity/Probe
I0730 05:46:01.340833       1 utils.go:199] ID: 104 GRPC request: {}
I0730 05:46:01.340851       1 utils.go:205] ID: 104 GRPC response: {}
I0730 05:47:01.362326       1 utils.go:198] ID: 105 GRPC call: /csi.v1.Identity/Probe
I0730 05:47:01.362397       1 utils.go:199] ID: 105 GRPC request: {}
I0730 05:47:01.362428       1 utils.go:205] ID: 105 GRPC response: {}
I0730 05:48:01.340763       1 utils.go:198] ID: 106 GRPC call: /csi.v1.Identity/Probe
I0730 05:48:01.340847       1 utils.go:199] ID: 106 GRPC request: {}
I0730 05:48:01.340877       1 utils.go:205] ID: 106 GRPC response: {}
I0730 05:49:01.371558       1 utils.go:198] ID: 107 GRPC call: /csi.v1.Identity/Probe
I0730 05:49:01.371606       1 utils.go:199] ID: 107 GRPC request: {}
I0730 05:49:01.371625       1 utils.go:205] ID: 107 GRPC response: {}
I0730 05:50:01.340631       1 utils.go:198] ID: 108 GRPC call: /csi.v1.Identity/Probe
I0730 05:50:01.340681       1 utils.go:199] ID: 108 GRPC request: {}
I0730 05:50:01.340795       1 utils.go:205] ID: 108 GRPC response: {}
I0730 05:51:01.383737       1 utils.go:198] ID: 109 GRPC call: /csi.v1.Identity/Probe
I0730 05:51:01.383828       1 utils.go:199] ID: 109 GRPC request: {}
I0730 05:51:01.383879       1 utils.go:205] ID: 109 GRPC response: {}
I0730 05:52:01.396529       1 utils.go:198] ID: 110 GRPC call: /csi.v1.Identity/Probe
I0730 05:52:01.396575       1 utils.go:199] ID: 110 GRPC request: {}
I0730 05:52:01.396592       1 utils.go:205] ID: 110 GRPC response: {}
I0730 05:53:01.396532       1 utils.go:198] ID: 111 GRPC call: /csi.v1.Identity/Probe
I0730 05:53:01.396610       1 utils.go:199] ID: 111 GRPC request: {}
I0730 05:53:01.396688       1 utils.go:205] ID: 111 GRPC response: {}
I0730 05:54:01.394230       1 utils.go:198] ID: 112 GRPC call: /csi.v1.Identity/Probe
I0730 05:54:01.394288       1 utils.go:199] ID: 112 GRPC request: {}
I0730 05:54:01.394327       1 utils.go:205] ID: 112 GRPC response: {}