I0729 08:04:26.296785       1 cephcsi.go:191] Driver version: v3.11.0 and Git version: bc24b5eca87626d690a29effa9d7420cc0154a7a
I0729 08:04:26.296915       1 cephcsi.go:223] Starting driver type: rbd with name: rbd.csi.ceph.com
I0729 08:04:26.296925       1 driver.go:95] Enabling controller service capability: CREATE_DELETE_VOLUME
I0729 08:04:26.296929       1 driver.go:95] Enabling controller service capability: CREATE_DELETE_SNAPSHOT
I0729 08:04:26.296934       1 driver.go:95] Enabling controller service capability: CLONE_VOLUME
I0729 08:04:26.296948       1 driver.go:95] Enabling controller service capability: EXPAND_VOLUME
I0729 08:04:26.296951       1 driver.go:108] Enabling volume access mode: SINGLE_NODE_WRITER
I0729 08:04:26.296954       1 driver.go:108] Enabling volume access mode: MULTI_NODE_MULTI_WRITER
I0729 08:04:26.296957       1 driver.go:108] Enabling volume access mode: SINGLE_NODE_SINGLE_WRITER
I0729 08:04:26.296960       1 driver.go:108] Enabling volume access mode: SINGLE_NODE_MULTI_WRITER
I0729 08:04:26.297210       1 server.go:117] Listening for connections on address: &net.UnixAddr{Name:"//csi/csi-provisioner.sock", Net:"unix"}
I0729 08:04:26.297227       1 server.go:114] listening for CSI-Addons requests on address: &net.UnixAddr{Name:"/csi/csi-addons.sock", Net:"unix"}
I0729 08:04:34.529988       1 utils.go:198] ID: 1 GRPC call: /csi.v1.Identity/Probe
I0729 08:04:34.531007       1 utils.go:199] ID: 1 GRPC request: {}
I0729 08:04:34.531056       1 utils.go:205] ID: 1 GRPC response: {}
I0729 08:04:34.535226       1 utils.go:198] ID: 2 GRPC call: /csi.v1.Identity/GetPluginInfo
I0729 08:04:34.535304       1 utils.go:199] ID: 2 GRPC request: {}
I0729 08:04:34.535323       1 identityserver-default.go:40] ID: 2 Using default GetPluginInfo
I0729 08:04:34.535374       1 utils.go:205] ID: 2 GRPC response: {"name":"rbd.csi.ceph.com","vendor_version":"v3.11.0"}
I0729 08:04:34.537376       1 utils.go:198] ID: 3 GRPC call: /csi.v1.Identity/Probe
I0729 08:04:34.537427       1 utils.go:199] ID: 3 GRPC request: {}
I0729 08:04:34.537459       1 utils.go:205] ID: 3 GRPC response: {}
I0729 08:04:34.537958       1 utils.go:198] ID: 4 GRPC call: /csi.v1.Identity/GetPluginCapabilities
I0729 08:04:34.538018       1 utils.go:199] ID: 4 GRPC request: {}
I0729 08:04:34.538176       1 utils.go:205] ID: 4 GRPC response: {"capabilities":[{"Type":{"Service":{"type":1}}},{"Type":{"VolumeExpansion":{"type":1}}},{"Type":{"Service":{"type":2}}}]}
I0729 08:04:34.538843       1 utils.go:198] ID: 5 GRPC call: /csi.v1.Controller/ControllerGetCapabilities
I0729 08:04:34.538876       1 utils.go:199] ID: 5 GRPC request: {}
I0729 08:04:34.538883       1 controllerserver-default.go:42] ID: 5 Using default ControllerGetCapabilities
I0729 08:04:34.538958       1 utils.go:205] ID: 5 GRPC response: {"capabilities":[{"Type":{"Rpc":{"type":1}}},{"Type":{"Rpc":{"type":5}}},{"Type":{"Rpc":{"type":7}}},{"Type":{"Rpc":{"type":9}}}]}
I0729 08:04:36.436277       1 utils.go:198] ID: 6 GRPC call: /csi.v1.Identity/Probe
I0729 08:04:36.436337       1 utils.go:199] ID: 6 GRPC request: {}
I0729 08:04:36.436358       1 utils.go:205] ID: 6 GRPC response: {}
I0729 08:04:36.438584       1 utils.go:198] ID: 7 GRPC call: /csi.v1.Identity/GetPluginInfo
I0729 08:04:36.438622       1 utils.go:199] ID: 7 GRPC request: {}
I0729 08:04:36.438631       1 identityserver-default.go:40] ID: 7 Using default GetPluginInfo
I0729 08:04:36.438677       1 utils.go:205] ID: 7 GRPC response: {"name":"rbd.csi.ceph.com","vendor_version":"v3.11.0"}
I0729 08:04:36.441666       1 utils.go:198] ID: 8 GRPC call: /csi.v1.Identity/Probe
I0729 08:04:36.441691       1 utils.go:199] ID: 8 GRPC request: {}
I0729 08:04:36.441704       1 utils.go:205] ID: 8 GRPC response: {}
I0729 08:04:36.442166       1 utils.go:198] ID: 9 GRPC call: /csi.v1.Identity/GetPluginCapabilities
I0729 08:04:36.442192       1 utils.go:199] ID: 9 GRPC request: {}
I0729 08:04:36.442395       1 utils.go:205] ID: 9 GRPC response: {"capabilities":[{"Type":{"Service":{"type":1}}},{"Type":{"VolumeExpansion":{"type":1}}},{"Type":{"Service":{"type":2}}}]}
I0729 08:04:36.443321       1 utils.go:198] ID: 10 GRPC call: /csi.v1.Controller/ControllerGetCapabilities
I0729 08:04:36.443344       1 utils.go:199] ID: 10 GRPC request: {}
I0729 08:04:36.443370       1 controllerserver-default.go:42] ID: 10 Using default ControllerGetCapabilities
I0729 08:04:36.443464       1 utils.go:205] ID: 10 GRPC response: {"capabilities":[{"Type":{"Rpc":{"type":1}}},{"Type":{"Rpc":{"type":5}}},{"Type":{"Rpc":{"type":7}}},{"Type":{"Rpc":{"type":9}}}]}
I0729 08:04:36.444242       1 utils.go:198] ID: 11 GRPC call: /csi.v1.Controller/ControllerGetCapabilities
I0729 08:04:36.444259       1 utils.go:199] ID: 11 GRPC request: {}
I0729 08:04:36.444265       1 controllerserver-default.go:42] ID: 11 Using default ControllerGetCapabilities
I0729 08:04:36.444326       1 utils.go:205] ID: 11 GRPC response: {"capabilities":[{"Type":{"Rpc":{"type":1}}},{"Type":{"Rpc":{"type":5}}},{"Type":{"Rpc":{"type":7}}},{"Type":{"Rpc":{"type":9}}}]}
I0729 08:04:36.444919       1 utils.go:198] ID: 12 GRPC call: /csi.v1.Controller/ControllerGetCapabilities
I0729 08:04:36.444987       1 utils.go:199] ID: 12 GRPC request: {}
I0729 08:04:36.445025       1 controllerserver-default.go:42] ID: 12 Using default ControllerGetCapabilities
I0729 08:04:36.445200       1 utils.go:205] ID: 12 GRPC response: {"capabilities":[{"Type":{"Rpc":{"type":1}}},{"Type":{"Rpc":{"type":5}}},{"Type":{"Rpc":{"type":7}}},{"Type":{"Rpc":{"type":9}}}]}
I0729 08:04:38.159634       1 utils.go:198] ID: 13 GRPC call: /csi.v1.Identity/GetPluginInfo
I0729 08:04:38.159749       1 utils.go:199] ID: 13 GRPC request: {}
I0729 08:04:38.159799       1 identityserver-default.go:40] ID: 13 Using default GetPluginInfo
I0729 08:04:38.159883       1 utils.go:205] ID: 13 GRPC response: {"name":"rbd.csi.ceph.com","vendor_version":"v3.11.0"}
I0729 08:04:38.162945       1 utils.go:198] ID: 14 GRPC call: /csi.v1.Identity/Probe
I0729 08:04:38.162992       1 utils.go:199] ID: 14 GRPC request: {}
I0729 08:04:38.163040       1 utils.go:205] ID: 14 GRPC response: {}
I0729 08:04:38.163554       1 utils.go:198] ID: 15 GRPC call: /csi.v1.Controller/ControllerGetCapabilities
I0729 08:04:38.163604       1 utils.go:199] ID: 15 GRPC request: {}
I0729 08:04:38.163621       1 controllerserver-default.go:42] ID: 15 Using default ControllerGetCapabilities
I0729 08:04:38.163722       1 utils.go:205] ID: 15 GRPC response: {"capabilities":[{"Type":{"Rpc":{"type":1}}},{"Type":{"Rpc":{"type":5}}},{"Type":{"Rpc":{"type":7}}},{"Type":{"Rpc":{"type":9}}}]}
I0729 08:04:39.777186       1 utils.go:198] ID: 16 GRPC call: /csi.v1.Identity/Probe
I0729 08:04:39.777238       1 utils.go:199] ID: 16 GRPC request: {}
I0729 08:04:39.777383       1 utils.go:205] ID: 16 GRPC response: {}
I0729 08:04:39.780611       1 utils.go:198] ID: 17 GRPC call: /csi.v1.Identity/GetPluginInfo
I0729 08:04:39.780644       1 utils.go:199] ID: 17 GRPC request: {}
I0729 08:04:39.780652       1 identityserver-default.go:40] ID: 17 Using default GetPluginInfo
I0729 08:04:39.780672       1 utils.go:205] ID: 17 GRPC response: {"name":"rbd.csi.ceph.com","vendor_version":"v3.11.0"}
I0729 08:04:39.783370       1 utils.go:198] ID: 18 GRPC call: /csi.v1.Identity/Probe
I0729 08:04:39.783389       1 utils.go:199] ID: 18 GRPC request: {}
I0729 08:04:39.783401       1 utils.go:205] ID: 18 GRPC response: {}
I0729 08:04:39.783644       1 utils.go:198] ID: 19 GRPC call: /csi.v1.Identity/GetPluginCapabilities
I0729 08:04:39.783658       1 utils.go:199] ID: 19 GRPC request: {}
I0729 08:04:39.783727       1 utils.go:205] ID: 19 GRPC response: {"capabilities":[{"Type":{"Service":{"type":1}}},{"Type":{"VolumeExpansion":{"type":1}}},{"Type":{"Service":{"type":2}}}]}
I0729 08:04:39.784272       1 utils.go:198] ID: 20 GRPC call: /csi.v1.Controller/ControllerGetCapabilities
I0729 08:04:39.784288       1 utils.go:199] ID: 20 GRPC request: {}
I0729 08:04:39.784295       1 controllerserver-default.go:42] ID: 20 Using default ControllerGetCapabilities
I0729 08:04:39.784403       1 utils.go:205] ID: 20 GRPC response: {"capabilities":[{"Type":{"Rpc":{"type":1}}},{"Type":{"Rpc":{"type":5}}},{"Type":{"Rpc":{"type":7}}},{"Type":{"Rpc":{"type":9}}}]}
I0729 08:05:32.760473       1 utils.go:198] ID: 21 Req-ID: pvc-cbb7098d-b2e5-4679-81d9-4e020af6405a GRPC call: /csi.v1.Controller/CreateVolume
I0729 08:05:32.760779       1 utils.go:199] ID: 21 Req-ID: pvc-cbb7098d-b2e5-4679-81d9-4e020af6405a GRPC request: {"capacity_range":{"required_bytes":171798691840},"name":"pvc-cbb7098d-b2e5-4679-81d9-4e020af6405a","parameters":{"clusterID":"4837cbf8-4f90-4300-b3f6-726c9b9f89b4","csi.storage.k8s.io/pv/name":"pvc-cbb7098d-b2e5-4679-81d9-4e020af6405a","csi.storage.k8s.io/pvc/name":"datadir-percona-xtradb-pxc-0","csi.storage.k8s.io/pvc/namespace":"openstack","imageFeatures":"layering","pool":"kube"},"secrets":"***stripped***","volume_capabilities":[{"AccessType":{"Mount":{"fs_type":"ext4","mount_flags":["discard"]}},"access_mode":{"mode":1}}]}
I0729 08:05:32.760983       1 rbd_util.go:1315] ID: 21 Req-ID: pvc-cbb7098d-b2e5-4679-81d9-4e020af6405a setting disableInUseChecks: false image features: [layering] mounter: rbd
E0729 08:05:32.778524       1 omap.go:80] ID: 21 Req-ID: pvc-cbb7098d-b2e5-4679-81d9-4e020af6405a omap not found (pool="kube", namespace="", name="csi.volumes.default"): rados: ret=-2, No such file or directory
I0729 08:05:32.798758       1 omap.go:159] ID: 21 Req-ID: pvc-cbb7098d-b2e5-4679-81d9-4e020af6405a set omap keys (pool="kube", namespace="", name="csi.volumes.default"): map[csi.volume.pvc-cbb7098d-b2e5-4679-81d9-4e020af6405a:41d21789-4ea9-49a2-b1fc-e14dcbd201b1])
I0729 08:05:32.807451       1 omap.go:159] ID: 21 Req-ID: pvc-cbb7098d-b2e5-4679-81d9-4e020af6405a set omap keys (pool="kube", namespace="", name="csi.volume.41d21789-4ea9-49a2-b1fc-e14dcbd201b1"): map[csi.imagename:csi-vol-41d21789-4ea9-49a2-b1fc-e14dcbd201b1 csi.volname:pvc-cbb7098d-b2e5-4679-81d9-4e020af6405a csi.volume.owner:openstack])
I0729 08:05:32.807609       1 rbd_journal.go:491] ID: 21 Req-ID: pvc-cbb7098d-b2e5-4679-81d9-4e020af6405a generated Volume ID (0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-41d21789-4ea9-49a2-b1fc-e14dcbd201b1) and image name (csi-vol-41d21789-4ea9-49a2-b1fc-e14dcbd201b1) for request name (pvc-cbb7098d-b2e5-4679-81d9-4e020af6405a)
I0729 08:05:32.807799       1 rbd_util.go:423] ID: 21 Req-ID: pvc-cbb7098d-b2e5-4679-81d9-4e020af6405a rbd: create kube/csi-vol-41d21789-4ea9-49a2-b1fc-e14dcbd201b1 size 163840M (features: [layering]) using mon 10.96.240.200
I0729 08:05:32.807952       1 rbd_util.go:1563] ID: 21 Req-ID: pvc-cbb7098d-b2e5-4679-81d9-4e020af6405a setting image options on kube/csi-vol-41d21789-4ea9-49a2-b1fc-e14dcbd201b1
I0729 08:05:32.849883       1 controllerserver.go:763] ID: 21 Req-ID: pvc-cbb7098d-b2e5-4679-81d9-4e020af6405a created image kube/csi-vol-41d21789-4ea9-49a2-b1fc-e14dcbd201b1 backed for request name pvc-cbb7098d-b2e5-4679-81d9-4e020af6405a
I0729 08:05:32.881541       1 omap.go:159] ID: 21 Req-ID: pvc-cbb7098d-b2e5-4679-81d9-4e020af6405a set omap keys (pool="kube", namespace="", name="csi.volume.41d21789-4ea9-49a2-b1fc-e14dcbd201b1"): map[csi.imageid:37c6e233c96f])
I0729 08:05:32.980337       1 utils.go:205] ID: 21 Req-ID: pvc-cbb7098d-b2e5-4679-81d9-4e020af6405a GRPC response: {"volume":{"capacity_bytes":171798691840,"volume_context":{"clusterID":"4837cbf8-4f90-4300-b3f6-726c9b9f89b4","imageFeatures":"layering","imageName":"csi-vol-41d21789-4ea9-49a2-b1fc-e14dcbd201b1","journalPool":"kube","pool":"kube"},"volume_id":"0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-41d21789-4ea9-49a2-b1fc-e14dcbd201b1"}}
I0729 08:05:40.015276       1 utils.go:198] ID: 22 GRPC call: /csi.v1.Identity/Probe
I0729 08:05:40.015352       1 utils.go:199] ID: 22 GRPC request: {}
I0729 08:05:40.015375       1 utils.go:205] ID: 22 GRPC response: {}
I0729 08:06:39.956145       1 utils.go:198] ID: 23 GRPC call: /csi.v1.Identity/Probe
I0729 08:06:39.956196       1 utils.go:199] ID: 23 GRPC request: {}
I0729 08:06:39.956218       1 utils.go:205] ID: 23 GRPC response: {}
I0729 08:07:40.011135       1 utils.go:198] ID: 24 GRPC call: /csi.v1.Identity/Probe
I0729 08:07:40.011180       1 utils.go:199] ID: 24 GRPC request: {}
I0729 08:07:40.011195       1 utils.go:205] ID: 24 GRPC response: {}
I0729 08:08:39.967487       1 utils.go:198] ID: 25 GRPC call: /csi.v1.Identity/Probe
I0729 08:08:39.967548       1 utils.go:199] ID: 25 GRPC request: {}
I0729 08:08:39.967573       1 utils.go:205] ID: 25 GRPC response: {}
I0729 08:09:39.955701       1 utils.go:198] ID: 26 GRPC call: /csi.v1.Identity/Probe
I0729 08:09:39.955751       1 utils.go:199] ID: 26 GRPC request: {}
I0729 08:09:39.955788       1 utils.go:205] ID: 26 GRPC response: {}
I0729 08:10:39.977759       1 utils.go:198] ID: 27 GRPC call: /csi.v1.Identity/Probe
I0729 08:10:39.977822       1 utils.go:199] ID: 27 GRPC request: {}
I0729 08:10:39.977849       1 utils.go:205] ID: 27 GRPC response: {}
I0729 08:11:40.008311       1 utils.go:198] ID: 28 GRPC call: /csi.v1.Identity/Probe
I0729 08:11:40.008364       1 utils.go:199] ID: 28 GRPC request: {}
I0729 08:11:40.008388       1 utils.go:205] ID: 28 GRPC response: {}
I0729 08:12:39.986627       1 utils.go:198] ID: 29 GRPC call: /csi.v1.Identity/Probe
I0729 08:12:39.986700       1 utils.go:199] ID: 29 GRPC request: {}
I0729 08:12:39.986726       1 utils.go:205] ID: 29 GRPC response: {}
I0729 08:13:39.955731       1 utils.go:198] ID: 30 GRPC call: /csi.v1.Identity/Probe
I0729 08:13:39.955797       1 utils.go:199] ID: 30 GRPC request: {}
I0729 08:13:39.955819       1 utils.go:205] ID: 30 GRPC response: {}
I0729 08:14:39.997817       1 utils.go:198] ID: 31 GRPC call: /csi.v1.Identity/Probe
I0729 08:14:39.997883       1 utils.go:199] ID: 31 GRPC request: {}
I0729 08:14:39.997908       1 utils.go:205] ID: 31 GRPC response: {}
I0729 08:15:39.955675       1 utils.go:198] ID: 32 GRPC call: /csi.v1.Identity/Probe
I0729 08:15:39.955720       1 utils.go:199] ID: 32 GRPC request: {}
I0729 08:15:39.955771       1 utils.go:205] ID: 32 GRPC response: {}
I0729 08:16:28.031161       1 utils.go:198] ID: 33 Req-ID: pvc-f3899245-d880-419f-b9c1-c8b21dc15458 GRPC call: /csi.v1.Controller/CreateVolume
I0729 08:16:28.031331       1 utils.go:199] ID: 33 Req-ID: pvc-f3899245-d880-419f-b9c1-c8b21dc15458 GRPC request: {"capacity_range":{"required_bytes":10737418240},"name":"pvc-f3899245-d880-419f-b9c1-c8b21dc15458","parameters":{"clusterID":"4837cbf8-4f90-4300-b3f6-726c9b9f89b4","csi.storage.k8s.io/pv/name":"pvc-f3899245-d880-419f-b9c1-c8b21dc15458","csi.storage.k8s.io/pvc/name":"persistence-rabbitmq-keystone-server-0","csi.storage.k8s.io/pvc/namespace":"openstack","imageFeatures":"layering","pool":"kube"},"secrets":"***stripped***","volume_capabilities":[{"AccessType":{"Mount":{"fs_type":"ext4","mount_flags":["discard"]}},"access_mode":{"mode":1}}]}
I0729 08:16:28.031468       1 rbd_util.go:1315] ID: 33 Req-ID: pvc-f3899245-d880-419f-b9c1-c8b21dc15458 setting disableInUseChecks: false image features: [layering] mounter: rbd
I0729 08:16:28.032548       1 omap.go:89] ID: 33 Req-ID: pvc-f3899245-d880-419f-b9c1-c8b21dc15458 got omap values: (pool="kube", namespace="", name="csi.volumes.default"): map[]
I0729 08:16:28.057104       1 omap.go:159] ID: 33 Req-ID: pvc-f3899245-d880-419f-b9c1-c8b21dc15458 set omap keys (pool="kube", namespace="", name="csi.volumes.default"): map[csi.volume.pvc-f3899245-d880-419f-b9c1-c8b21dc15458:87d6ccc7-999c-45a2-81c7-188b5f54221a])
I0729 08:16:28.061609       1 omap.go:159] ID: 33 Req-ID: pvc-f3899245-d880-419f-b9c1-c8b21dc15458 set omap keys (pool="kube", namespace="", name="csi.volume.87d6ccc7-999c-45a2-81c7-188b5f54221a"): map[csi.imagename:csi-vol-87d6ccc7-999c-45a2-81c7-188b5f54221a csi.volname:pvc-f3899245-d880-419f-b9c1-c8b21dc15458 csi.volume.owner:openstack])
I0729 08:16:28.061635       1 rbd_journal.go:491] ID: 33 Req-ID: pvc-f3899245-d880-419f-b9c1-c8b21dc15458 generated Volume ID (0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-87d6ccc7-999c-45a2-81c7-188b5f54221a) and image name (csi-vol-87d6ccc7-999c-45a2-81c7-188b5f54221a) for request name (pvc-f3899245-d880-419f-b9c1-c8b21dc15458)
I0729 08:16:28.061714       1 rbd_util.go:423] ID: 33 Req-ID: pvc-f3899245-d880-419f-b9c1-c8b21dc15458 rbd: create kube/csi-vol-87d6ccc7-999c-45a2-81c7-188b5f54221a size 10240M (features: [layering]) using mon 10.96.240.200
I0729 08:16:28.061875       1 rbd_util.go:1563] ID: 33 Req-ID: pvc-f3899245-d880-419f-b9c1-c8b21dc15458 setting image options on kube/csi-vol-87d6ccc7-999c-45a2-81c7-188b5f54221a
I0729 08:16:28.087422       1 controllerserver.go:763] ID: 33 Req-ID: pvc-f3899245-d880-419f-b9c1-c8b21dc15458 created image kube/csi-vol-87d6ccc7-999c-45a2-81c7-188b5f54221a backed for request name pvc-f3899245-d880-419f-b9c1-c8b21dc15458
I0729 08:16:28.115192       1 omap.go:159] ID: 33 Req-ID: pvc-f3899245-d880-419f-b9c1-c8b21dc15458 set omap keys (pool="kube", namespace="", name="csi.volume.87d6ccc7-999c-45a2-81c7-188b5f54221a"): map[csi.imageid:37c64a9e4cc9])
I0729 08:16:28.197920       1 utils.go:205] ID: 33 Req-ID: pvc-f3899245-d880-419f-b9c1-c8b21dc15458 GRPC response: {"volume":{"capacity_bytes":10737418240,"volume_context":{"clusterID":"4837cbf8-4f90-4300-b3f6-726c9b9f89b4","imageFeatures":"layering","imageName":"csi-vol-87d6ccc7-999c-45a2-81c7-188b5f54221a","journalPool":"kube","pool":"kube"},"volume_id":"0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-87d6ccc7-999c-45a2-81c7-188b5f54221a"}}
I0729 08:16:40.007381       1 utils.go:198] ID: 34 GRPC call: /csi.v1.Identity/Probe
I0729 08:16:40.007478       1 utils.go:199] ID: 34 GRPC request: {}
I0729 08:16:40.007525       1 utils.go:205] ID: 34 GRPC response: {}
I0729 08:17:39.955793       1 utils.go:198] ID: 35 GRPC call: /csi.v1.Identity/Probe
I0729 08:17:39.955856       1 utils.go:199] ID: 35 GRPC request: {}
I0729 08:17:39.955880       1 utils.go:205] ID: 35 GRPC response: {}
I0729 08:18:40.013725       1 utils.go:198] ID: 36 GRPC call: /csi.v1.Identity/Probe
I0729 08:18:40.013875       1 utils.go:199] ID: 36 GRPC request: {}
I0729 08:18:40.013906       1 utils.go:205] ID: 36 GRPC response: {}
I0729 08:19:39.959832       1 utils.go:198] ID: 37 GRPC call: /csi.v1.Identity/Probe
I0729 08:19:39.959876       1 utils.go:199] ID: 37 GRPC request: {}
I0729 08:19:39.959892       1 utils.go:205] ID: 37 GRPC response: {}
I0729 08:20:37.925522       1 utils.go:198] ID: 38 Req-ID: pvc-27f48e0c-e61a-45d5-84f7-4ae075f4b549 GRPC call: /csi.v1.Controller/CreateVolume
I0729 08:20:37.925716       1 utils.go:199] ID: 38 Req-ID: pvc-27f48e0c-e61a-45d5-84f7-4ae075f4b549 GRPC request: {"capacity_range":{"required_bytes":10737418240},"name":"pvc-27f48e0c-e61a-45d5-84f7-4ae075f4b549","parameters":{"clusterID":"4837cbf8-4f90-4300-b3f6-726c9b9f89b4","csi.storage.k8s.io/pv/name":"pvc-27f48e0c-e61a-45d5-84f7-4ae075f4b549","csi.storage.k8s.io/pvc/name":"persistence-rabbitmq-glance-server-0","csi.storage.k8s.io/pvc/namespace":"openstack","imageFeatures":"layering","pool":"kube"},"secrets":"***stripped***","volume_capabilities":[{"AccessType":{"Mount":{"fs_type":"ext4","mount_flags":["discard"]}},"access_mode":{"mode":1}}]}
I0729 08:20:37.925902       1 rbd_util.go:1315] ID: 38 Req-ID: pvc-27f48e0c-e61a-45d5-84f7-4ae075f4b549 setting disableInUseChecks: false image features: [layering] mounter: rbd
I0729 08:20:37.927405       1 omap.go:89] ID: 38 Req-ID: pvc-27f48e0c-e61a-45d5-84f7-4ae075f4b549 got omap values: (pool="kube", namespace="", name="csi.volumes.default"): map[]
I0729 08:20:37.943335       1 omap.go:159] ID: 38 Req-ID: pvc-27f48e0c-e61a-45d5-84f7-4ae075f4b549 set omap keys (pool="kube", namespace="", name="csi.volumes.default"): map[csi.volume.pvc-27f48e0c-e61a-45d5-84f7-4ae075f4b549:a939b4e8-92f8-489f-ad83-3d44b2c388d0])
I0729 08:20:37.951475       1 omap.go:159] ID: 38 Req-ID: pvc-27f48e0c-e61a-45d5-84f7-4ae075f4b549 set omap keys (pool="kube", namespace="", name="csi.volume.a939b4e8-92f8-489f-ad83-3d44b2c388d0"): map[csi.imagename:csi-vol-a939b4e8-92f8-489f-ad83-3d44b2c388d0 csi.volname:pvc-27f48e0c-e61a-45d5-84f7-4ae075f4b549 csi.volume.owner:openstack])
I0729 08:20:37.951518       1 rbd_journal.go:491] ID: 38 Req-ID: pvc-27f48e0c-e61a-45d5-84f7-4ae075f4b549 generated Volume ID (0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-a939b4e8-92f8-489f-ad83-3d44b2c388d0) and image name (csi-vol-a939b4e8-92f8-489f-ad83-3d44b2c388d0) for request name (pvc-27f48e0c-e61a-45d5-84f7-4ae075f4b549)
I0729 08:20:37.951645       1 rbd_util.go:423] ID: 38 Req-ID: pvc-27f48e0c-e61a-45d5-84f7-4ae075f4b549 rbd: create kube/csi-vol-a939b4e8-92f8-489f-ad83-3d44b2c388d0 size 10240M (features: [layering]) using mon 10.96.240.200
I0729 08:20:37.951701       1 rbd_util.go:1563] ID: 38 Req-ID: pvc-27f48e0c-e61a-45d5-84f7-4ae075f4b549 setting image options on kube/csi-vol-a939b4e8-92f8-489f-ad83-3d44b2c388d0
I0729 08:20:37.985961       1 controllerserver.go:763] ID: 38 Req-ID: pvc-27f48e0c-e61a-45d5-84f7-4ae075f4b549 created image kube/csi-vol-a939b4e8-92f8-489f-ad83-3d44b2c388d0 backed for request name pvc-27f48e0c-e61a-45d5-84f7-4ae075f4b549
I0729 08:20:38.020320       1 omap.go:159] ID: 38 Req-ID: pvc-27f48e0c-e61a-45d5-84f7-4ae075f4b549 set omap keys (pool="kube", namespace="", name="csi.volume.a939b4e8-92f8-489f-ad83-3d44b2c388d0"): map[csi.imageid:37c6c1f893d0])
I0729 08:20:38.125812       1 utils.go:205] ID: 38 Req-ID: pvc-27f48e0c-e61a-45d5-84f7-4ae075f4b549 GRPC response: {"volume":{"capacity_bytes":10737418240,"volume_context":{"clusterID":"4837cbf8-4f90-4300-b3f6-726c9b9f89b4","imageFeatures":"layering","imageName":"csi-vol-a939b4e8-92f8-489f-ad83-3d44b2c388d0","journalPool":"kube","pool":"kube"},"volume_id":"0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-a939b4e8-92f8-489f-ad83-3d44b2c388d0"}}
I0729 08:20:40.011257       1 utils.go:198] ID: 39 GRPC call: /csi.v1.Identity/Probe
I0729 08:20:40.011311       1 utils.go:199] ID: 39 GRPC request: {}
I0729 08:20:40.011333       1 utils.go:205] ID: 39 GRPC response: {}
I0729 08:21:39.960322       1 utils.go:198] ID: 40 GRPC call: /csi.v1.Identity/Probe
I0729 08:21:39.960370       1 utils.go:199] ID: 40 GRPC request: {}
I0729 08:21:39.960387       1 utils.go:205] ID: 40 GRPC response: {}
I0729 08:22:39.992713       1 utils.go:198] ID: 41 GRPC call: /csi.v1.Identity/Probe
I0729 08:22:39.992773       1 utils.go:199] ID: 41 GRPC request: {}
I0729 08:22:39.992799       1 utils.go:205] ID: 41 GRPC response: {}
I0729 08:23:39.971933       1 utils.go:198] ID: 42 GRPC call: /csi.v1.Identity/Probe
I0729 08:23:39.972028       1 utils.go:199] ID: 42 GRPC request: {}
I0729 08:23:39.972062       1 utils.go:205] ID: 42 GRPC response: {}
I0729 08:24:40.012349       1 utils.go:198] ID: 43 GRPC call: /csi.v1.Identity/Probe
I0729 08:24:40.012406       1 utils.go:199] ID: 43 GRPC request: {}
I0729 08:24:40.012451       1 utils.go:205] ID: 43 GRPC response: {}
I0729 08:25:39.976945       1 utils.go:198] ID: 44 GRPC call: /csi.v1.Identity/Probe
I0729 08:25:39.977014       1 utils.go:199] ID: 44 GRPC request: {}
I0729 08:25:39.977041       1 utils.go:205] ID: 44 GRPC response: {}
I0729 08:26:40.012503       1 utils.go:198] ID: 45 GRPC call: /csi.v1.Identity/Probe
I0729 08:26:40.012602       1 utils.go:199] ID: 45 GRPC request: {}
I0729 08:26:40.012671       1 utils.go:205] ID: 45 GRPC response: {}
I0729 08:27:39.987622       1 utils.go:198] ID: 46 GRPC call: /csi.v1.Identity/Probe
I0729 08:27:39.987687       1 utils.go:199] ID: 46 GRPC request: {}
I0729 08:27:39.987712       1 utils.go:205] ID: 46 GRPC response: {}
I0729 08:28:39.956052       1 utils.go:198] ID: 47 GRPC call: /csi.v1.Identity/Probe
I0729 08:28:39.956094       1 utils.go:199] ID: 47 GRPC request: {}
I0729 08:28:39.956111       1 utils.go:205] ID: 47 GRPC response: {}
I0729 08:29:39.997211       1 utils.go:198] ID: 48 GRPC call: /csi.v1.Identity/Probe
I0729 08:29:39.997275       1 utils.go:199] ID: 48 GRPC request: {}
I0729 08:29:39.997300       1 utils.go:205] ID: 48 GRPC response: {}
I0729 08:30:39.955606       1 utils.go:198] ID: 49 GRPC call: /csi.v1.Identity/Probe
I0729 08:30:39.955656       1 utils.go:199] ID: 49 GRPC request: {}
I0729 08:30:39.955684       1 utils.go:205] ID: 49 GRPC response: {}
I0729 08:31:40.008462       1 utils.go:198] ID: 50 GRPC call: /csi.v1.Identity/Probe
I0729 08:31:40.008618       1 utils.go:199] ID: 50 GRPC request: {}
I0729 08:31:40.008693       1 utils.go:205] ID: 50 GRPC response: {}
I0729 08:32:40.012295       1 utils.go:198] ID: 51 GRPC call: /csi.v1.Identity/Probe
I0729 08:32:40.012350       1 utils.go:199] ID: 51 GRPC request: {}
I0729 08:32:40.012415       1 utils.go:205] ID: 51 GRPC response: {}
I0729 08:33:39.999732       1 utils.go:198] ID: 52 GRPC call: /csi.v1.Identity/Probe
I0729 08:33:39.999861       1 utils.go:199] ID: 52 GRPC request: {}
I0729 08:33:39.999911       1 utils.go:205] ID: 52 GRPC response: {}
I0729 08:34:39.960209       1 utils.go:198] ID: 53 GRPC call: /csi.v1.Identity/Probe
I0729 08:34:39.960263       1 utils.go:199] ID: 53 GRPC request: {}
I0729 08:34:39.960286       1 utils.go:205] ID: 53 GRPC response: {}