I0730 04:59:50.906814       1 cephcsi.go:191] Driver version: v3.11.0 and Git version: bc24b5eca87626d690a29effa9d7420cc0154a7a
I0730 04:59:50.906934       1 cephcsi.go:223] Starting driver type: rbd with name: rbd.csi.ceph.com
I0730 04:59:50.906949       1 driver.go:95] Enabling controller service capability: CREATE_DELETE_VOLUME
I0730 04:59:50.906952       1 driver.go:95] Enabling controller service capability: CREATE_DELETE_SNAPSHOT
I0730 04:59:50.906955       1 driver.go:95] Enabling controller service capability: CLONE_VOLUME
I0730 04:59:50.906958       1 driver.go:95] Enabling controller service capability: EXPAND_VOLUME
I0730 04:59:50.906962       1 driver.go:108] Enabling volume access mode: SINGLE_NODE_WRITER
I0730 04:59:50.906964       1 driver.go:108] Enabling volume access mode: MULTI_NODE_MULTI_WRITER
I0730 04:59:50.906967       1 driver.go:108] Enabling volume access mode: SINGLE_NODE_SINGLE_WRITER
I0730 04:59:50.906970       1 driver.go:108] Enabling volume access mode: SINGLE_NODE_MULTI_WRITER
I0730 04:59:50.907228       1 server.go:117] Listening for connections on address: &net.UnixAddr{Name:"//csi/csi-provisioner.sock", Net:"unix"}
I0730 04:59:50.907320       1 server.go:114] listening for CSI-Addons requests on address: &net.UnixAddr{Name:"/csi/csi-addons.sock", Net:"unix"}
I0730 04:59:59.717184       1 utils.go:198] ID: 1 GRPC call: /csi.v1.Identity/Probe
I0730 04:59:59.718303       1 utils.go:199] ID: 1 GRPC request: {}
I0730 04:59:59.718355       1 utils.go:205] ID: 1 GRPC response: {}
I0730 04:59:59.724369       1 utils.go:198] ID: 2 GRPC call: /csi.v1.Identity/GetPluginInfo
I0730 04:59:59.724480       1 utils.go:199] ID: 2 GRPC request: {}
I0730 04:59:59.724503       1 identityserver-default.go:40] ID: 2 Using default GetPluginInfo
I0730 04:59:59.724574       1 utils.go:205] ID: 2 GRPC response: {"name":"rbd.csi.ceph.com","vendor_version":"v3.11.0"}
I0730 04:59:59.727041       1 utils.go:198] ID: 3 GRPC call: /csi.v1.Identity/Probe
I0730 04:59:59.727138       1 utils.go:199] ID: 3 GRPC request: {}
I0730 04:59:59.727216       1 utils.go:205] ID: 3 GRPC response: {}
I0730 04:59:59.727925       1 utils.go:198] ID: 4 GRPC call: /csi.v1.Identity/GetPluginCapabilities
I0730 04:59:59.728035       1 utils.go:199] ID: 4 GRPC request: {}
I0730 04:59:59.728205       1 utils.go:205] ID: 4 GRPC response: {"capabilities":[{"Type":{"Service":{"type":1}}},{"Type":{"VolumeExpansion":{"type":1}}},{"Type":{"Service":{"type":2}}}]}
I0730 04:59:59.729225       1 utils.go:198] ID: 5 GRPC call: /csi.v1.Controller/ControllerGetCapabilities
I0730 04:59:59.729270       1 utils.go:199] ID: 5 GRPC request: {}
I0730 04:59:59.729283       1 controllerserver-default.go:42] ID: 5 Using default ControllerGetCapabilities
I0730 04:59:59.729455       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 05:00:03.859450       1 utils.go:198] ID: 6 GRPC call: /csi.v1.Identity/Probe
I0730 05:00:03.859494       1 utils.go:199] ID: 6 GRPC request: {}
I0730 05:00:03.859522       1 utils.go:205] ID: 6 GRPC response: {}
I0730 05:00:03.864889       1 utils.go:198] ID: 7 GRPC call: /csi.v1.Identity/GetPluginInfo
I0730 05:00:03.864949       1 utils.go:199] ID: 7 GRPC request: {}
I0730 05:00:03.864962       1 identityserver-default.go:40] ID: 7 Using default GetPluginInfo
I0730 05:00:03.864999       1 utils.go:205] ID: 7 GRPC response: {"name":"rbd.csi.ceph.com","vendor_version":"v3.11.0"}
I0730 05:00:03.868290       1 utils.go:198] ID: 8 GRPC call: /csi.v1.Identity/Probe
I0730 05:00:03.868325       1 utils.go:199] ID: 8 GRPC request: {}
I0730 05:00:03.868345       1 utils.go:205] ID: 8 GRPC response: {}
I0730 05:00:03.870545       1 utils.go:198] ID: 9 GRPC call: /csi.v1.Identity/GetPluginCapabilities
I0730 05:00:03.870764       1 utils.go:199] ID: 9 GRPC request: {}
I0730 05:00:03.871119       1 utils.go:205] ID: 9 GRPC response: {"capabilities":[{"Type":{"Service":{"type":1}}},{"Type":{"VolumeExpansion":{"type":1}}},{"Type":{"Service":{"type":2}}}]}
I0730 05:00:03.872553       1 utils.go:198] ID: 10 GRPC call: /csi.v1.Controller/ControllerGetCapabilities
I0730 05:00:03.872622       1 utils.go:199] ID: 10 GRPC request: {}
I0730 05:00:03.872645       1 controllerserver-default.go:42] ID: 10 Using default ControllerGetCapabilities
I0730 05:00:03.872915       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 05:00:03.873579       1 utils.go:198] ID: 11 GRPC call: /csi.v1.Controller/ControllerGetCapabilities
I0730 05:00:03.873603       1 utils.go:199] ID: 11 GRPC request: {}
I0730 05:00:03.873612       1 controllerserver-default.go:42] ID: 11 Using default ControllerGetCapabilities
I0730 05:00:03.873726       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 05:00:03.874272       1 utils.go:198] ID: 12 GRPC call: /csi.v1.Controller/ControllerGetCapabilities
I0730 05:00:03.874290       1 utils.go:199] ID: 12 GRPC request: {}
I0730 05:00:03.874296       1 controllerserver-default.go:42] ID: 12 Using default ControllerGetCapabilities
I0730 05:00:03.874431       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 05:00:09.599187       1 utils.go:198] ID: 13 GRPC call: /csi.v1.Identity/GetPluginInfo
I0730 05:00:09.599227       1 utils.go:199] ID: 13 GRPC request: {}
I0730 05:00:09.599235       1 identityserver-default.go:40] ID: 13 Using default GetPluginInfo
I0730 05:00:09.599260       1 utils.go:205] ID: 13 GRPC response: {"name":"rbd.csi.ceph.com","vendor_version":"v3.11.0"}
I0730 05:00:09.603389       1 utils.go:198] ID: 14 GRPC call: /csi.v1.Identity/Probe
I0730 05:00:09.603446       1 utils.go:199] ID: 14 GRPC request: {}
I0730 05:00:09.603492       1 utils.go:205] ID: 14 GRPC response: {}
I0730 05:00:09.604004       1 utils.go:198] ID: 15 GRPC call: /csi.v1.Controller/ControllerGetCapabilities
I0730 05:00:09.604027       1 utils.go:199] ID: 15 GRPC request: {}
I0730 05:00:09.604035       1 controllerserver-default.go:42] ID: 15 Using default ControllerGetCapabilities
I0730 05:00:09.604145       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 05:00:11.732440       1 utils.go:198] ID: 16 GRPC call: /csi.v1.Identity/Probe
I0730 05:00:11.732530       1 utils.go:199] ID: 16 GRPC request: {}
I0730 05:00:11.732584       1 utils.go:205] ID: 16 GRPC response: {}
I0730 05:00:11.735180       1 utils.go:198] ID: 17 GRPC call: /csi.v1.Identity/GetPluginInfo
I0730 05:00:11.735208       1 utils.go:199] ID: 17 GRPC request: {}
I0730 05:00:11.735219       1 identityserver-default.go:40] ID: 17 Using default GetPluginInfo
I0730 05:00:11.735285       1 utils.go:205] ID: 17 GRPC response: {"name":"rbd.csi.ceph.com","vendor_version":"v3.11.0"}
I0730 05:00:11.741214       1 utils.go:198] ID: 18 GRPC call: /csi.v1.Identity/Probe
I0730 05:00:11.741268       1 utils.go:199] ID: 18 GRPC request: {}
I0730 05:00:11.741311       1 utils.go:205] ID: 18 GRPC response: {}
I0730 05:00:11.741991       1 utils.go:198] ID: 19 GRPC call: /csi.v1.Identity/GetPluginCapabilities
I0730 05:00:11.742030       1 utils.go:199] ID: 19 GRPC request: {}
I0730 05:00:11.742152       1 utils.go:205] ID: 19 GRPC response: {"capabilities":[{"Type":{"Service":{"type":1}}},{"Type":{"VolumeExpansion":{"type":1}}},{"Type":{"Service":{"type":2}}}]}
I0730 05:00:11.743237       1 utils.go:198] ID: 20 GRPC call: /csi.v1.Controller/ControllerGetCapabilities
I0730 05:00:11.743267       1 utils.go:199] ID: 20 GRPC request: {}
I0730 05:00:11.743280       1 controllerserver-default.go:42] ID: 20 Using default ControllerGetCapabilities
I0730 05:00:11.743380       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 05:00:57.606088       1 utils.go:198] ID: 21 Req-ID: pvc-95144619-8230-46ab-8929-c0e07fac3fe9 GRPC call: /csi.v1.Controller/CreateVolume
I0730 05:00:57.606397       1 utils.go:199] ID: 21 Req-ID: pvc-95144619-8230-46ab-8929-c0e07fac3fe9 GRPC request: {"capacity_range":{"required_bytes":171798691840},"name":"pvc-95144619-8230-46ab-8929-c0e07fac3fe9","parameters":{"clusterID":"4837cbf8-4f90-4300-b3f6-726c9b9f89b4","csi.storage.k8s.io/pv/name":"pvc-95144619-8230-46ab-8929-c0e07fac3fe9","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 05:00:57.606607       1 rbd_util.go:1315] ID: 21 Req-ID: pvc-95144619-8230-46ab-8929-c0e07fac3fe9 setting disableInUseChecks: false image features: [layering] mounter: rbd
E0730 05:00:57.624083       1 omap.go:80] ID: 21 Req-ID: pvc-95144619-8230-46ab-8929-c0e07fac3fe9 omap not found (pool="kube", namespace="", name="csi.volumes.default"): rados: ret=-2, No such file or directory
I0730 05:00:57.640457       1 omap.go:159] ID: 21 Req-ID: pvc-95144619-8230-46ab-8929-c0e07fac3fe9 set omap keys (pool="kube", namespace="", name="csi.volumes.default"): map[csi.volume.pvc-95144619-8230-46ab-8929-c0e07fac3fe9:b9ec3c60-4958-408f-9e2c-4f2c529c996f])
I0730 05:00:57.650028       1 omap.go:159] ID: 21 Req-ID: pvc-95144619-8230-46ab-8929-c0e07fac3fe9 set omap keys (pool="kube", namespace="", name="csi.volume.b9ec3c60-4958-408f-9e2c-4f2c529c996f"): map[csi.imagename:csi-vol-b9ec3c60-4958-408f-9e2c-4f2c529c996f csi.volname:pvc-95144619-8230-46ab-8929-c0e07fac3fe9 csi.volume.owner:openstack])
I0730 05:00:57.650071       1 rbd_journal.go:491] ID: 21 Req-ID: pvc-95144619-8230-46ab-8929-c0e07fac3fe9 generated Volume ID (0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-b9ec3c60-4958-408f-9e2c-4f2c529c996f) and image name (csi-vol-b9ec3c60-4958-408f-9e2c-4f2c529c996f) for request name (pvc-95144619-8230-46ab-8929-c0e07fac3fe9)
I0730 05:00:57.650168       1 rbd_util.go:423] ID: 21 Req-ID: pvc-95144619-8230-46ab-8929-c0e07fac3fe9 rbd: create kube/csi-vol-b9ec3c60-4958-408f-9e2c-4f2c529c996f size 163840M (features: [layering]) using mon 10.96.240.200
I0730 05:00:57.650231       1 rbd_util.go:1563] ID: 21 Req-ID: pvc-95144619-8230-46ab-8929-c0e07fac3fe9 setting image options on kube/csi-vol-b9ec3c60-4958-408f-9e2c-4f2c529c996f
I0730 05:00:57.684747       1 controllerserver.go:763] ID: 21 Req-ID: pvc-95144619-8230-46ab-8929-c0e07fac3fe9 created image kube/csi-vol-b9ec3c60-4958-408f-9e2c-4f2c529c996f backed for request name pvc-95144619-8230-46ab-8929-c0e07fac3fe9
I0730 05:00:57.722412       1 omap.go:159] ID: 21 Req-ID: pvc-95144619-8230-46ab-8929-c0e07fac3fe9 set omap keys (pool="kube", namespace="", name="csi.volume.b9ec3c60-4958-408f-9e2c-4f2c529c996f"): map[csi.imageid:37c68c76a3d4])
I0730 05:00:57.844870       1 utils.go:205] ID: 21 Req-ID: pvc-95144619-8230-46ab-8929-c0e07fac3fe9 GRPC response: {"volume":{"capacity_bytes":171798691840,"volume_context":{"clusterID":"4837cbf8-4f90-4300-b3f6-726c9b9f89b4","imageFeatures":"layering","imageName":"csi-vol-b9ec3c60-4958-408f-9e2c-4f2c529c996f","journalPool":"kube","pool":"kube"},"volume_id":"0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-b9ec3c60-4958-408f-9e2c-4f2c529c996f"}}
I0730 05:01:11.977555       1 utils.go:198] ID: 22 GRPC call: /csi.v1.Identity/Probe
I0730 05:01:11.977617       1 utils.go:199] ID: 22 GRPC request: {}
I0730 05:01:11.977646       1 utils.go:205] ID: 22 GRPC response: {}
I0730 05:02:11.946108       1 utils.go:198] ID: 23 GRPC call: /csi.v1.Identity/Probe
I0730 05:02:11.946604       1 utils.go:199] ID: 23 GRPC request: {}
I0730 05:02:11.946647       1 utils.go:205] ID: 23 GRPC response: {}
I0730 05:03:11.995690       1 utils.go:198] ID: 24 GRPC call: /csi.v1.Identity/Probe
I0730 05:03:11.995745       1 utils.go:199] ID: 24 GRPC request: {}
I0730 05:03:11.995769       1 utils.go:205] ID: 24 GRPC response: {}
I0730 05:04:11.952072       1 utils.go:198] ID: 25 GRPC call: /csi.v1.Identity/Probe
I0730 05:04:11.952429       1 utils.go:199] ID: 25 GRPC request: {}
I0730 05:04:11.952754       1 utils.go:205] ID: 25 GRPC response: {}
I0730 05:05:11.993614       1 utils.go:198] ID: 26 GRPC call: /csi.v1.Identity/Probe
I0730 05:05:11.993669       1 utils.go:199] ID: 26 GRPC request: {}
I0730 05:05:11.993719       1 utils.go:205] ID: 26 GRPC response: {}
I0730 05:06:11.960837       1 utils.go:198] ID: 27 GRPC call: /csi.v1.Identity/Probe
I0730 05:06:11.960899       1 utils.go:199] ID: 27 GRPC request: {}
I0730 05:06:11.960919       1 utils.go:205] ID: 27 GRPC response: {}
I0730 05:07:11.991584       1 utils.go:198] ID: 28 GRPC call: /csi.v1.Identity/Probe
I0730 05:07:11.991696       1 utils.go:199] ID: 28 GRPC request: {}
I0730 05:07:11.991732       1 utils.go:205] ID: 28 GRPC response: {}
I0730 05:08:11.970853       1 utils.go:198] ID: 29 GRPC call: /csi.v1.Identity/Probe
I0730 05:08:11.970927       1 utils.go:199] ID: 29 GRPC request: {}
I0730 05:08:11.970971       1 utils.go:205] ID: 29 GRPC response: {}
I0730 05:09:11.993367       1 utils.go:198] ID: 30 GRPC call: /csi.v1.Identity/Probe
I0730 05:09:11.993502       1 utils.go:199] ID: 30 GRPC request: {}
I0730 05:09:11.993534       1 utils.go:205] ID: 30 GRPC response: {}
I0730 05:10:11.937474       1 utils.go:198] ID: 31 GRPC call: /csi.v1.Identity/Probe
I0730 05:10:11.937556       1 utils.go:199] ID: 31 GRPC request: {}
I0730 05:10:11.937579       1 utils.go:205] ID: 31 GRPC response: {}
I0730 05:11:11.939290       1 utils.go:198] ID: 32 GRPC call: /csi.v1.Identity/Probe
I0730 05:11:11.939353       1 utils.go:199] ID: 32 GRPC request: {}
I0730 05:11:11.939378       1 utils.go:205] ID: 32 GRPC response: {}
I0730 05:12:11.937485       1 utils.go:198] ID: 33 GRPC call: /csi.v1.Identity/Probe
I0730 05:12:11.937539       1 utils.go:199] ID: 33 GRPC request: {}
I0730 05:12:11.937561       1 utils.go:205] ID: 33 GRPC response: {}
I0730 05:12:39.678105       1 utils.go:198] ID: 34 Req-ID: pvc-2fcc05e7-7212-436f-b47d-f75fe606a1e0 GRPC call: /csi.v1.Controller/CreateVolume
I0730 05:12:39.678310       1 utils.go:199] ID: 34 Req-ID: pvc-2fcc05e7-7212-436f-b47d-f75fe606a1e0 GRPC request: {"capacity_range":{"required_bytes":10737418240},"name":"pvc-2fcc05e7-7212-436f-b47d-f75fe606a1e0","parameters":{"clusterID":"4837cbf8-4f90-4300-b3f6-726c9b9f89b4","csi.storage.k8s.io/pv/name":"pvc-2fcc05e7-7212-436f-b47d-f75fe606a1e0","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:12:39.678495       1 rbd_util.go:1315] ID: 34 Req-ID: pvc-2fcc05e7-7212-436f-b47d-f75fe606a1e0 setting disableInUseChecks: false image features: [layering] mounter: rbd
I0730 05:12:39.680191       1 omap.go:89] ID: 34 Req-ID: pvc-2fcc05e7-7212-436f-b47d-f75fe606a1e0 got omap values: (pool="kube", namespace="", name="csi.volumes.default"): map[]
I0730 05:12:39.715114       1 omap.go:159] ID: 34 Req-ID: pvc-2fcc05e7-7212-436f-b47d-f75fe606a1e0 set omap keys (pool="kube", namespace="", name="csi.volumes.default"): map[csi.volume.pvc-2fcc05e7-7212-436f-b47d-f75fe606a1e0:5eef71de-08dd-42ee-8ae2-d96f208354db])
I0730 05:12:39.722172       1 omap.go:159] ID: 34 Req-ID: pvc-2fcc05e7-7212-436f-b47d-f75fe606a1e0 set omap keys (pool="kube", namespace="", name="csi.volume.5eef71de-08dd-42ee-8ae2-d96f208354db"): map[csi.imagename:csi-vol-5eef71de-08dd-42ee-8ae2-d96f208354db csi.volname:pvc-2fcc05e7-7212-436f-b47d-f75fe606a1e0 csi.volume.owner:openstack])
I0730 05:12:39.722211       1 rbd_journal.go:491] ID: 34 Req-ID: pvc-2fcc05e7-7212-436f-b47d-f75fe606a1e0 generated Volume ID (0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-5eef71de-08dd-42ee-8ae2-d96f208354db) and image name (csi-vol-5eef71de-08dd-42ee-8ae2-d96f208354db) for request name (pvc-2fcc05e7-7212-436f-b47d-f75fe606a1e0)
I0730 05:12:39.722392       1 rbd_util.go:423] ID: 34 Req-ID: pvc-2fcc05e7-7212-436f-b47d-f75fe606a1e0 rbd: create kube/csi-vol-5eef71de-08dd-42ee-8ae2-d96f208354db size 10240M (features: [layering]) using mon 10.96.240.200
I0730 05:12:39.722461       1 rbd_util.go:1563] ID: 34 Req-ID: pvc-2fcc05e7-7212-436f-b47d-f75fe606a1e0 setting image options on kube/csi-vol-5eef71de-08dd-42ee-8ae2-d96f208354db
I0730 05:12:39.755532       1 controllerserver.go:763] ID: 34 Req-ID: pvc-2fcc05e7-7212-436f-b47d-f75fe606a1e0 created image kube/csi-vol-5eef71de-08dd-42ee-8ae2-d96f208354db backed for request name pvc-2fcc05e7-7212-436f-b47d-f75fe606a1e0
I0730 05:12:39.791919       1 omap.go:159] ID: 34 Req-ID: pvc-2fcc05e7-7212-436f-b47d-f75fe606a1e0 set omap keys (pool="kube", namespace="", name="csi.volume.5eef71de-08dd-42ee-8ae2-d96f208354db"): map[csi.imageid:37c6686aaf90])
I0730 05:12:39.892437       1 utils.go:205] ID: 34 Req-ID: pvc-2fcc05e7-7212-436f-b47d-f75fe606a1e0 GRPC response: {"volume":{"capacity_bytes":10737418240,"volume_context":{"clusterID":"4837cbf8-4f90-4300-b3f6-726c9b9f89b4","imageFeatures":"layering","imageName":"csi-vol-5eef71de-08dd-42ee-8ae2-d96f208354db","journalPool":"kube","pool":"kube"},"volume_id":"0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-5eef71de-08dd-42ee-8ae2-d96f208354db"}}
I0730 05:13:11.939641       1 utils.go:198] ID: 35 GRPC call: /csi.v1.Identity/Probe
I0730 05:13:11.939695       1 utils.go:199] ID: 35 GRPC request: {}
I0730 05:13:11.939717       1 utils.go:205] ID: 35 GRPC response: {}
I0730 05:14:11.938187       1 utils.go:198] ID: 36 GRPC call: /csi.v1.Identity/Probe
I0730 05:14:11.938275       1 utils.go:199] ID: 36 GRPC request: {}
I0730 05:14:11.938304       1 utils.go:205] ID: 36 GRPC response: {}
I0730 05:15:11.969381       1 utils.go:198] ID: 37 GRPC call: /csi.v1.Identity/Probe
I0730 05:15:11.969457       1 utils.go:199] ID: 37 GRPC request: {}
I0730 05:15:11.969485       1 utils.go:205] ID: 37 GRPC response: {}
I0730 05:16:11.952372       1 utils.go:198] ID: 38 GRPC call: /csi.v1.Identity/Probe
I0730 05:16:11.952426       1 utils.go:199] ID: 38 GRPC request: {}
I0730 05:16:11.952448       1 utils.go:205] ID: 38 GRPC response: {}
I0730 05:16:47.363040       1 utils.go:198] ID: 39 Req-ID: pvc-2e0110d5-7029-4475-85c5-70137afcb1ec GRPC call: /csi.v1.Controller/CreateVolume
I0730 05:16:47.363212       1 utils.go:199] ID: 39 Req-ID: pvc-2e0110d5-7029-4475-85c5-70137afcb1ec GRPC request: {"capacity_range":{"required_bytes":10737418240},"name":"pvc-2e0110d5-7029-4475-85c5-70137afcb1ec","parameters":{"clusterID":"4837cbf8-4f90-4300-b3f6-726c9b9f89b4","csi.storage.k8s.io/pv/name":"pvc-2e0110d5-7029-4475-85c5-70137afcb1ec","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:16:47.363374       1 rbd_util.go:1315] ID: 39 Req-ID: pvc-2e0110d5-7029-4475-85c5-70137afcb1ec setting disableInUseChecks: false image features: [layering] mounter: rbd
I0730 05:16:47.365315       1 omap.go:89] ID: 39 Req-ID: pvc-2e0110d5-7029-4475-85c5-70137afcb1ec got omap values: (pool="kube", namespace="", name="csi.volumes.default"): map[]
I0730 05:16:47.380215       1 omap.go:159] ID: 39 Req-ID: pvc-2e0110d5-7029-4475-85c5-70137afcb1ec set omap keys (pool="kube", namespace="", name="csi.volumes.default"): map[csi.volume.pvc-2e0110d5-7029-4475-85c5-70137afcb1ec:34d27e31-6274-4b2d-99bc-33aa2dffdd09])
I0730 05:16:47.395094       1 omap.go:159] ID: 39 Req-ID: pvc-2e0110d5-7029-4475-85c5-70137afcb1ec set omap keys (pool="kube", namespace="", name="csi.volume.34d27e31-6274-4b2d-99bc-33aa2dffdd09"): map[csi.imagename:csi-vol-34d27e31-6274-4b2d-99bc-33aa2dffdd09 csi.volname:pvc-2e0110d5-7029-4475-85c5-70137afcb1ec csi.volume.owner:openstack])
I0730 05:16:47.395160       1 rbd_journal.go:491] ID: 39 Req-ID: pvc-2e0110d5-7029-4475-85c5-70137afcb1ec generated Volume ID (0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-34d27e31-6274-4b2d-99bc-33aa2dffdd09) and image name (csi-vol-34d27e31-6274-4b2d-99bc-33aa2dffdd09) for request name (pvc-2e0110d5-7029-4475-85c5-70137afcb1ec)
I0730 05:16:47.395280       1 rbd_util.go:423] ID: 39 Req-ID: pvc-2e0110d5-7029-4475-85c5-70137afcb1ec rbd: create kube/csi-vol-34d27e31-6274-4b2d-99bc-33aa2dffdd09 size 10240M (features: [layering]) using mon 10.96.240.200
I0730 05:16:47.395337       1 rbd_util.go:1563] ID: 39 Req-ID: pvc-2e0110d5-7029-4475-85c5-70137afcb1ec setting image options on kube/csi-vol-34d27e31-6274-4b2d-99bc-33aa2dffdd09
I0730 05:16:47.429772       1 controllerserver.go:763] ID: 39 Req-ID: pvc-2e0110d5-7029-4475-85c5-70137afcb1ec created image kube/csi-vol-34d27e31-6274-4b2d-99bc-33aa2dffdd09 backed for request name pvc-2e0110d5-7029-4475-85c5-70137afcb1ec
I0730 05:16:47.466064       1 omap.go:159] ID: 39 Req-ID: pvc-2e0110d5-7029-4475-85c5-70137afcb1ec set omap keys (pool="kube", namespace="", name="csi.volume.34d27e31-6274-4b2d-99bc-33aa2dffdd09"): map[csi.imageid:37c619eb8d06])
I0730 05:16:47.591547       1 utils.go:205] ID: 39 Req-ID: pvc-2e0110d5-7029-4475-85c5-70137afcb1ec GRPC response: {"volume":{"capacity_bytes":10737418240,"volume_context":{"clusterID":"4837cbf8-4f90-4300-b3f6-726c9b9f89b4","imageFeatures":"layering","imageName":"csi-vol-34d27e31-6274-4b2d-99bc-33aa2dffdd09","journalPool":"kube","pool":"kube"},"volume_id":"0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-34d27e31-6274-4b2d-99bc-33aa2dffdd09"}}
I0730 05:17:11.937338       1 utils.go:198] ID: 40 GRPC call: /csi.v1.Identity/Probe
I0730 05:17:11.937394       1 utils.go:199] ID: 40 GRPC request: {}
I0730 05:17:11.937418       1 utils.go:205] ID: 40 GRPC response: {}
I0730 05:18:11.958513       1 utils.go:198] ID: 41 GRPC call: /csi.v1.Identity/Probe
I0730 05:18:11.958566       1 utils.go:199] ID: 41 GRPC request: {}
I0730 05:18:11.958590       1 utils.go:205] ID: 41 GRPC response: {}
I0730 05:19:11.955593       1 utils.go:198] ID: 42 GRPC call: /csi.v1.Identity/Probe
I0730 05:19:11.955648       1 utils.go:199] ID: 42 GRPC request: {}
I0730 05:19:11.955670       1 utils.go:205] ID: 42 GRPC response: {}
I0730 05:20:11.968073       1 utils.go:198] ID: 43 GRPC call: /csi.v1.Identity/Probe
I0730 05:20:11.968118       1 utils.go:199] ID: 43 GRPC request: {}
I0730 05:20:11.968140       1 utils.go:205] ID: 43 GRPC response: {}
I0730 05:21:11.939763       1 utils.go:198] ID: 44 GRPC call: /csi.v1.Identity/Probe
I0730 05:21:11.939850       1 utils.go:199] ID: 44 GRPC request: {}
I0730 05:21:11.939877       1 utils.go:205] ID: 44 GRPC response: {}
I0730 05:22:11.954254       1 utils.go:198] ID: 45 GRPC call: /csi.v1.Identity/Probe
I0730 05:22:11.954313       1 utils.go:199] ID: 45 GRPC request: {}
I0730 05:22:11.954337       1 utils.go:205] ID: 45 GRPC response: {}
I0730 05:23:11.939962       1 utils.go:198] ID: 46 GRPC call: /csi.v1.Identity/Probe
I0730 05:23:11.940030       1 utils.go:199] ID: 46 GRPC request: {}
I0730 05:23:11.940078       1 utils.go:205] ID: 46 GRPC response: {}
I0730 05:24:11.995833       1 utils.go:198] ID: 47 GRPC call: /csi.v1.Identity/Probe
I0730 05:24:11.995921       1 utils.go:199] ID: 47 GRPC request: {}
I0730 05:24:11.995947       1 utils.go:205] ID: 47 GRPC response: {}
I0730 05:25:11.938136       1 utils.go:198] ID: 48 GRPC call: /csi.v1.Identity/Probe
I0730 05:25:11.938200       1 utils.go:199] ID: 48 GRPC request: {}
I0730 05:25:11.938224       1 utils.go:205] ID: 48 GRPC response: {}
I0730 05:26:11.937428       1 utils.go:198] ID: 49 GRPC call: /csi.v1.Identity/Probe
I0730 05:26:11.937539       1 utils.go:199] ID: 49 GRPC request: {}
I0730 05:26:11.937563       1 utils.go:205] ID: 49 GRPC response: {}
I0730 05:27:11.950372       1 utils.go:198] ID: 50 GRPC call: /csi.v1.Identity/Probe
I0730 05:27:11.950448       1 utils.go:199] ID: 50 GRPC request: {}
I0730 05:27:11.950478       1 utils.go:205] ID: 50 GRPC response: {}
I0730 05:28:11.938140       1 utils.go:198] ID: 51 GRPC call: /csi.v1.Identity/Probe
I0730 05:28:11.938201       1 utils.go:199] ID: 51 GRPC request: {}
I0730 05:28:11.938224       1 utils.go:205] ID: 51 GRPC response: {}
I0730 05:29:11.958424       1 utils.go:198] ID: 52 GRPC call: /csi.v1.Identity/Probe
I0730 05:29:11.958510       1 utils.go:199] ID: 52 GRPC request: {}
I0730 05:29:11.958549       1 utils.go:205] ID: 52 GRPC response: {}
I0730 05:30:11.987579       1 utils.go:198] ID: 53 GRPC call: /csi.v1.Identity/Probe
I0730 05:30:11.987645       1 utils.go:199] ID: 53 GRPC request: {}
I0730 05:30:11.987668       1 utils.go:205] ID: 53 GRPC response: {}