I0730 21:09:32.609527       1 cephcsi.go:191] Driver version: v3.11.0 and Git version: bc24b5eca87626d690a29effa9d7420cc0154a7a
I0730 21:09:32.609685       1 cephcsi.go:223] Starting driver type: rbd with name: rbd.csi.ceph.com
I0730 21:09:32.609700       1 driver.go:95] Enabling controller service capability: CREATE_DELETE_VOLUME
I0730 21:09:32.609706       1 driver.go:95] Enabling controller service capability: CREATE_DELETE_SNAPSHOT
I0730 21:09:32.609709       1 driver.go:95] Enabling controller service capability: CLONE_VOLUME
I0730 21:09:32.609712       1 driver.go:95] Enabling controller service capability: EXPAND_VOLUME
I0730 21:09:32.609716       1 driver.go:108] Enabling volume access mode: SINGLE_NODE_WRITER
I0730 21:09:32.609718       1 driver.go:108] Enabling volume access mode: MULTI_NODE_MULTI_WRITER
I0730 21:09:32.609721       1 driver.go:108] Enabling volume access mode: SINGLE_NODE_SINGLE_WRITER
I0730 21:09:32.609723       1 driver.go:108] Enabling volume access mode: SINGLE_NODE_MULTI_WRITER
I0730 21:09:32.610045       1 server.go:117] Listening for connections on address: &net.UnixAddr{Name:"//csi/csi-provisioner.sock", Net:"unix"}
I0730 21:09:32.610122       1 server.go:114] listening for CSI-Addons requests on address: &net.UnixAddr{Name:"/csi/csi-addons.sock", Net:"unix"}
I0730 21:09:39.810059       1 utils.go:198] ID: 1 GRPC call: /csi.v1.Identity/Probe
I0730 21:09:39.811499       1 utils.go:199] ID: 1 GRPC request: {}
I0730 21:09:39.811569       1 utils.go:205] ID: 1 GRPC response: {}
I0730 21:09:39.816272       1 utils.go:198] ID: 2 GRPC call: /csi.v1.Identity/GetPluginInfo
I0730 21:09:39.816386       1 utils.go:199] ID: 2 GRPC request: {}
I0730 21:09:39.816412       1 identityserver-default.go:40] ID: 2 Using default GetPluginInfo
I0730 21:09:39.816469       1 utils.go:205] ID: 2 GRPC response: {"name":"rbd.csi.ceph.com","vendor_version":"v3.11.0"}
I0730 21:09:39.818720       1 utils.go:198] ID: 3 GRPC call: /csi.v1.Identity/Probe
I0730 21:09:39.818784       1 utils.go:199] ID: 3 GRPC request: {}
I0730 21:09:39.818818       1 utils.go:205] ID: 3 GRPC response: {}
I0730 21:09:39.819501       1 utils.go:198] ID: 4 GRPC call: /csi.v1.Identity/GetPluginCapabilities
I0730 21:09:39.819706       1 utils.go:199] ID: 4 GRPC request: {}
I0730 21:09:39.820133       1 utils.go:205] ID: 4 GRPC response: {"capabilities":[{"Type":{"Service":{"type":1}}},{"Type":{"VolumeExpansion":{"type":1}}},{"Type":{"Service":{"type":2}}}]}
I0730 21:09:39.821628       1 utils.go:198] ID: 5 GRPC call: /csi.v1.Controller/ControllerGetCapabilities
I0730 21:09:39.821813       1 utils.go:199] ID: 5 GRPC request: {}
I0730 21:09:39.821836       1 controllerserver-default.go:42] ID: 5 Using default ControllerGetCapabilities
I0730 21:09:39.822103       1 utils.go:205] ID: 5 GRPC response: {"capabilities":[{"Type":{"Rpc":{"type":1}}},{"Type":{"Rpc":{"type":5}}},{"Type":{"Rpc":{"type":7}}},{"Type":{"Rpc":{"type":9}}}]}
I0730 21:09:41.425347       1 utils.go:198] ID: 6 GRPC call: /csi.v1.Identity/Probe
I0730 21:09:41.425387       1 utils.go:199] ID: 6 GRPC request: {}
I0730 21:09:41.425403       1 utils.go:205] ID: 6 GRPC response: {}
I0730 21:09:41.428544       1 utils.go:198] ID: 7 GRPC call: /csi.v1.Identity/GetPluginInfo
I0730 21:09:41.428597       1 utils.go:199] ID: 7 GRPC request: {}
I0730 21:09:41.428609       1 identityserver-default.go:40] ID: 7 Using default GetPluginInfo
I0730 21:09:41.428647       1 utils.go:205] ID: 7 GRPC response: {"name":"rbd.csi.ceph.com","vendor_version":"v3.11.0"}
I0730 21:09:41.431177       1 utils.go:198] ID: 8 GRPC call: /csi.v1.Identity/Probe
I0730 21:09:41.431234       1 utils.go:199] ID: 8 GRPC request: {}
I0730 21:09:41.431268       1 utils.go:205] ID: 8 GRPC response: {}
I0730 21:09:41.431886       1 utils.go:198] ID: 9 GRPC call: /csi.v1.Identity/GetPluginCapabilities
I0730 21:09:41.431921       1 utils.go:199] ID: 9 GRPC request: {}
I0730 21:09:41.432118       1 utils.go:205] ID: 9 GRPC response: {"capabilities":[{"Type":{"Service":{"type":1}}},{"Type":{"VolumeExpansion":{"type":1}}},{"Type":{"Service":{"type":2}}}]}
I0730 21:09:41.433306       1 utils.go:198] ID: 10 GRPC call: /csi.v1.Controller/ControllerGetCapabilities
I0730 21:09:41.433351       1 utils.go:199] ID: 10 GRPC request: {}
I0730 21:09:41.433363       1 controllerserver-default.go:42] ID: 10 Using default ControllerGetCapabilities
I0730 21:09:41.433496       1 utils.go:205] ID: 10 GRPC response: {"capabilities":[{"Type":{"Rpc":{"type":1}}},{"Type":{"Rpc":{"type":5}}},{"Type":{"Rpc":{"type":7}}},{"Type":{"Rpc":{"type":9}}}]}
I0730 21:09:41.434319       1 utils.go:198] ID: 11 GRPC call: /csi.v1.Controller/ControllerGetCapabilities
I0730 21:09:41.434369       1 utils.go:199] ID: 11 GRPC request: {}
I0730 21:09:41.434384       1 controllerserver-default.go:42] ID: 11 Using default ControllerGetCapabilities
I0730 21:09:41.434506       1 utils.go:205] ID: 11 GRPC response: {"capabilities":[{"Type":{"Rpc":{"type":1}}},{"Type":{"Rpc":{"type":5}}},{"Type":{"Rpc":{"type":7}}},{"Type":{"Rpc":{"type":9}}}]}
I0730 21:09:41.435118       1 utils.go:198] ID: 12 GRPC call: /csi.v1.Controller/ControllerGetCapabilities
I0730 21:09:41.435146       1 utils.go:199] ID: 12 GRPC request: {}
I0730 21:09:41.435154       1 controllerserver-default.go:42] ID: 12 Using default ControllerGetCapabilities
I0730 21:09:41.435233       1 utils.go:205] ID: 12 GRPC response: {"capabilities":[{"Type":{"Rpc":{"type":1}}},{"Type":{"Rpc":{"type":5}}},{"Type":{"Rpc":{"type":7}}},{"Type":{"Rpc":{"type":9}}}]}
I0730 21:09:46.010544       1 utils.go:198] ID: 13 GRPC call: /csi.v1.Identity/GetPluginInfo
I0730 21:09:46.010585       1 utils.go:199] ID: 13 GRPC request: {}
I0730 21:09:46.010593       1 identityserver-default.go:40] ID: 13 Using default GetPluginInfo
I0730 21:09:46.010619       1 utils.go:205] ID: 13 GRPC response: {"name":"rbd.csi.ceph.com","vendor_version":"v3.11.0"}
I0730 21:09:46.015199       1 utils.go:198] ID: 14 GRPC call: /csi.v1.Identity/Probe
I0730 21:09:46.015310       1 utils.go:199] ID: 14 GRPC request: {}
I0730 21:09:46.015450       1 utils.go:205] ID: 14 GRPC response: {}
I0730 21:09:46.016279       1 utils.go:198] ID: 15 GRPC call: /csi.v1.Controller/ControllerGetCapabilities
I0730 21:09:46.016336       1 utils.go:199] ID: 15 GRPC request: {}
I0730 21:09:46.016350       1 controllerserver-default.go:42] ID: 15 Using default ControllerGetCapabilities
I0730 21:09:46.016484       1 utils.go:205] ID: 15 GRPC response: {"capabilities":[{"Type":{"Rpc":{"type":1}}},{"Type":{"Rpc":{"type":5}}},{"Type":{"Rpc":{"type":7}}},{"Type":{"Rpc":{"type":9}}}]}
I0730 21:09:47.701185       1 utils.go:198] ID: 16 GRPC call: /csi.v1.Identity/Probe
I0730 21:09:47.701248       1 utils.go:199] ID: 16 GRPC request: {}
I0730 21:09:47.701278       1 utils.go:205] ID: 16 GRPC response: {}
I0730 21:09:47.703985       1 utils.go:198] ID: 17 GRPC call: /csi.v1.Identity/GetPluginInfo
I0730 21:09:47.704056       1 utils.go:199] ID: 17 GRPC request: {}
I0730 21:09:47.704077       1 identityserver-default.go:40] ID: 17 Using default GetPluginInfo
I0730 21:09:47.704144       1 utils.go:205] ID: 17 GRPC response: {"name":"rbd.csi.ceph.com","vendor_version":"v3.11.0"}
I0730 21:09:47.708852       1 utils.go:198] ID: 18 GRPC call: /csi.v1.Identity/Probe
I0730 21:09:47.708983       1 utils.go:199] ID: 18 GRPC request: {}
I0730 21:09:47.709014       1 utils.go:205] ID: 18 GRPC response: {}
I0730 21:09:47.709983       1 utils.go:198] ID: 19 GRPC call: /csi.v1.Identity/GetPluginCapabilities
I0730 21:09:47.710013       1 utils.go:199] ID: 19 GRPC request: {}
I0730 21:09:47.710120       1 utils.go:205] ID: 19 GRPC response: {"capabilities":[{"Type":{"Service":{"type":1}}},{"Type":{"VolumeExpansion":{"type":1}}},{"Type":{"Service":{"type":2}}}]}
I0730 21:09:47.710871       1 utils.go:198] ID: 20 GRPC call: /csi.v1.Controller/ControllerGetCapabilities
I0730 21:09:47.710918       1 utils.go:199] ID: 20 GRPC request: {}
I0730 21:09:47.710934       1 controllerserver-default.go:42] ID: 20 Using default ControllerGetCapabilities
I0730 21:09:47.711256       1 utils.go:205] ID: 20 GRPC response: {"capabilities":[{"Type":{"Rpc":{"type":1}}},{"Type":{"Rpc":{"type":5}}},{"Type":{"Rpc":{"type":7}}},{"Type":{"Rpc":{"type":9}}}]}
I0730 21:10:31.594274       1 utils.go:198] ID: 21 Req-ID: pvc-f109aa83-6294-4211-b640-a49e7c8d561a GRPC call: /csi.v1.Controller/CreateVolume
I0730 21:10:31.594664       1 utils.go:199] ID: 21 Req-ID: pvc-f109aa83-6294-4211-b640-a49e7c8d561a GRPC request: {"capacity_range":{"required_bytes":171798691840},"name":"pvc-f109aa83-6294-4211-b640-a49e7c8d561a","parameters":{"clusterID":"4837cbf8-4f90-4300-b3f6-726c9b9f89b4","csi.storage.k8s.io/pv/name":"pvc-f109aa83-6294-4211-b640-a49e7c8d561a","csi.storage.k8s.io/pvc/name":"datadir-percona-xtradb-pxc-0","csi.storage.k8s.io/pvc/namespace":"openstack","imageFeatures":"layering","pool":"kube"},"secrets":"***stripped***","volume_capabilities":[{"AccessType":{"Mount":{"fs_type":"ext4","mount_flags":["discard"]}},"access_mode":{"mode":1}}]}
I0730 21:10:31.594951       1 rbd_util.go:1315] ID: 21 Req-ID: pvc-f109aa83-6294-4211-b640-a49e7c8d561a setting disableInUseChecks: false image features: [layering] mounter: rbd
E0730 21:10:31.617116       1 omap.go:80] ID: 21 Req-ID: pvc-f109aa83-6294-4211-b640-a49e7c8d561a omap not found (pool="kube", namespace="", name="csi.volumes.default"): rados: ret=-2, No such file or directory
I0730 21:10:31.636974       1 omap.go:159] ID: 21 Req-ID: pvc-f109aa83-6294-4211-b640-a49e7c8d561a set omap keys (pool="kube", namespace="", name="csi.volumes.default"): map[csi.volume.pvc-f109aa83-6294-4211-b640-a49e7c8d561a:50aee703-e379-46ac-a41f-ee69163512fd])
I0730 21:10:31.646868       1 omap.go:159] ID: 21 Req-ID: pvc-f109aa83-6294-4211-b640-a49e7c8d561a set omap keys (pool="kube", namespace="", name="csi.volume.50aee703-e379-46ac-a41f-ee69163512fd"): map[csi.imagename:csi-vol-50aee703-e379-46ac-a41f-ee69163512fd csi.volname:pvc-f109aa83-6294-4211-b640-a49e7c8d561a csi.volume.owner:openstack])
I0730 21:10:31.646919       1 rbd_journal.go:491] ID: 21 Req-ID: pvc-f109aa83-6294-4211-b640-a49e7c8d561a generated Volume ID (0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-50aee703-e379-46ac-a41f-ee69163512fd) and image name (csi-vol-50aee703-e379-46ac-a41f-ee69163512fd) for request name (pvc-f109aa83-6294-4211-b640-a49e7c8d561a)
I0730 21:10:31.647031       1 rbd_util.go:423] ID: 21 Req-ID: pvc-f109aa83-6294-4211-b640-a49e7c8d561a rbd: create kube/csi-vol-50aee703-e379-46ac-a41f-ee69163512fd size 163840M (features: [layering]) using mon 10.96.240.200
I0730 21:10:31.647079       1 rbd_util.go:1563] ID: 21 Req-ID: pvc-f109aa83-6294-4211-b640-a49e7c8d561a setting image options on kube/csi-vol-50aee703-e379-46ac-a41f-ee69163512fd
I0730 21:10:31.684728       1 controllerserver.go:763] ID: 21 Req-ID: pvc-f109aa83-6294-4211-b640-a49e7c8d561a created image kube/csi-vol-50aee703-e379-46ac-a41f-ee69163512fd backed for request name pvc-f109aa83-6294-4211-b640-a49e7c8d561a
I0730 21:10:31.720638       1 omap.go:159] ID: 21 Req-ID: pvc-f109aa83-6294-4211-b640-a49e7c8d561a set omap keys (pool="kube", namespace="", name="csi.volume.50aee703-e379-46ac-a41f-ee69163512fd"): map[csi.imageid:37c6d74fc099])
I0730 21:10:31.824703       1 utils.go:205] ID: 21 Req-ID: pvc-f109aa83-6294-4211-b640-a49e7c8d561a GRPC response: {"volume":{"capacity_bytes":171798691840,"volume_context":{"clusterID":"4837cbf8-4f90-4300-b3f6-726c9b9f89b4","imageFeatures":"layering","imageName":"csi-vol-50aee703-e379-46ac-a41f-ee69163512fd","journalPool":"kube","pool":"kube"},"volume_id":"0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-50aee703-e379-46ac-a41f-ee69163512fd"}}
I0730 21:10:47.947438       1 utils.go:198] ID: 22 GRPC call: /csi.v1.Identity/Probe
I0730 21:10:47.947500       1 utils.go:199] ID: 22 GRPC request: {}
I0730 21:10:47.947525       1 utils.go:205] ID: 22 GRPC response: {}
I0730 21:11:47.919224       1 utils.go:198] ID: 23 GRPC call: /csi.v1.Identity/Probe
I0730 21:11:47.919376       1 utils.go:199] ID: 23 GRPC request: {}
I0730 21:11:47.919406       1 utils.go:205] ID: 23 GRPC response: {}
I0730 21:12:47.946385       1 utils.go:198] ID: 24 GRPC call: /csi.v1.Identity/Probe
I0730 21:12:47.946430       1 utils.go:199] ID: 24 GRPC request: {}
I0730 21:12:47.946448       1 utils.go:205] ID: 24 GRPC response: {}
I0730 21:13:47.936163       1 utils.go:198] ID: 25 GRPC call: /csi.v1.Identity/Probe
I0730 21:13:47.936632       1 utils.go:199] ID: 25 GRPC request: {}
I0730 21:13:47.936718       1 utils.go:205] ID: 25 GRPC response: {}
I0730 21:14:47.918691       1 utils.go:198] ID: 26 GRPC call: /csi.v1.Identity/Probe
I0730 21:14:47.918765       1 utils.go:199] ID: 26 GRPC request: {}
I0730 21:14:47.918790       1 utils.go:205] ID: 26 GRPC response: {}
I0730 21:15:47.941084       1 utils.go:198] ID: 27 GRPC call: /csi.v1.Identity/Probe
I0730 21:15:47.941239       1 utils.go:199] ID: 27 GRPC request: {}
I0730 21:15:47.941343       1 utils.go:205] ID: 27 GRPC response: {}
I0730 21:16:47.974544       1 utils.go:198] ID: 28 GRPC call: /csi.v1.Identity/Probe
I0730 21:16:47.974599       1 utils.go:199] ID: 28 GRPC request: {}
I0730 21:16:47.974621       1 utils.go:205] ID: 28 GRPC response: {}
I0730 21:17:47.950942       1 utils.go:198] ID: 29 GRPC call: /csi.v1.Identity/Probe
I0730 21:17:47.951029       1 utils.go:199] ID: 29 GRPC request: {}
I0730 21:17:47.951060       1 utils.go:205] ID: 29 GRPC response: {}
I0730 21:18:47.918382       1 utils.go:198] ID: 30 GRPC call: /csi.v1.Identity/Probe
I0730 21:18:47.918445       1 utils.go:199] ID: 30 GRPC request: {}
I0730 21:18:47.918469       1 utils.go:205] ID: 30 GRPC response: {}
I0730 21:19:47.959834       1 utils.go:198] ID: 31 GRPC call: /csi.v1.Identity/Probe
I0730 21:19:47.959923       1 utils.go:199] ID: 31 GRPC request: {}
I0730 21:19:47.959964       1 utils.go:205] ID: 31 GRPC response: {}
I0730 21:20:47.974879       1 utils.go:198] ID: 32 GRPC call: /csi.v1.Identity/Probe
I0730 21:20:47.974945       1 utils.go:199] ID: 32 GRPC request: {}
I0730 21:20:47.974975       1 utils.go:205] ID: 32 GRPC response: {}
I0730 21:20:58.665176       1 utils.go:198] ID: 33 Req-ID: pvc-9d00b4ea-2748-4d82-9797-59c0e3ae1e99 GRPC call: /csi.v1.Controller/CreateVolume
I0730 21:20:58.665482       1 utils.go:199] ID: 33 Req-ID: pvc-9d00b4ea-2748-4d82-9797-59c0e3ae1e99 GRPC request: {"capacity_range":{"required_bytes":10737418240},"name":"pvc-9d00b4ea-2748-4d82-9797-59c0e3ae1e99","parameters":{"clusterID":"4837cbf8-4f90-4300-b3f6-726c9b9f89b4","csi.storage.k8s.io/pv/name":"pvc-9d00b4ea-2748-4d82-9797-59c0e3ae1e99","csi.storage.k8s.io/pvc/name":"persistence-rabbitmq-keystone-server-0","csi.storage.k8s.io/pvc/namespace":"openstack","imageFeatures":"layering","pool":"kube"},"secrets":"***stripped***","volume_capabilities":[{"AccessType":{"Mount":{"fs_type":"ext4","mount_flags":["discard"]}},"access_mode":{"mode":1}}]}
I0730 21:20:58.665745       1 rbd_util.go:1315] ID: 33 Req-ID: pvc-9d00b4ea-2748-4d82-9797-59c0e3ae1e99 setting disableInUseChecks: false image features: [layering] mounter: rbd
I0730 21:20:58.667002       1 omap.go:89] ID: 33 Req-ID: pvc-9d00b4ea-2748-4d82-9797-59c0e3ae1e99 got omap values: (pool="kube", namespace="", name="csi.volumes.default"): map[]
I0730 21:20:58.681851       1 omap.go:159] ID: 33 Req-ID: pvc-9d00b4ea-2748-4d82-9797-59c0e3ae1e99 set omap keys (pool="kube", namespace="", name="csi.volumes.default"): map[csi.volume.pvc-9d00b4ea-2748-4d82-9797-59c0e3ae1e99:35078cef-2d88-48a4-9d02-066dde8a6a00])
I0730 21:20:58.696990       1 omap.go:159] ID: 33 Req-ID: pvc-9d00b4ea-2748-4d82-9797-59c0e3ae1e99 set omap keys (pool="kube", namespace="", name="csi.volume.35078cef-2d88-48a4-9d02-066dde8a6a00"): map[csi.imagename:csi-vol-35078cef-2d88-48a4-9d02-066dde8a6a00 csi.volname:pvc-9d00b4ea-2748-4d82-9797-59c0e3ae1e99 csi.volume.owner:openstack])
I0730 21:20:58.697023       1 rbd_journal.go:491] ID: 33 Req-ID: pvc-9d00b4ea-2748-4d82-9797-59c0e3ae1e99 generated Volume ID (0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-35078cef-2d88-48a4-9d02-066dde8a6a00) and image name (csi-vol-35078cef-2d88-48a4-9d02-066dde8a6a00) for request name (pvc-9d00b4ea-2748-4d82-9797-59c0e3ae1e99)
I0730 21:20:58.697181       1 rbd_util.go:423] ID: 33 Req-ID: pvc-9d00b4ea-2748-4d82-9797-59c0e3ae1e99 rbd: create kube/csi-vol-35078cef-2d88-48a4-9d02-066dde8a6a00 size 10240M (features: [layering]) using mon 10.96.240.200
I0730 21:20:58.697283       1 rbd_util.go:1563] ID: 33 Req-ID: pvc-9d00b4ea-2748-4d82-9797-59c0e3ae1e99 setting image options on kube/csi-vol-35078cef-2d88-48a4-9d02-066dde8a6a00
I0730 21:20:58.753578       1 controllerserver.go:763] ID: 33 Req-ID: pvc-9d00b4ea-2748-4d82-9797-59c0e3ae1e99 created image kube/csi-vol-35078cef-2d88-48a4-9d02-066dde8a6a00 backed for request name pvc-9d00b4ea-2748-4d82-9797-59c0e3ae1e99
I0730 21:20:58.787117       1 omap.go:159] ID: 33 Req-ID: pvc-9d00b4ea-2748-4d82-9797-59c0e3ae1e99 set omap keys (pool="kube", namespace="", name="csi.volume.35078cef-2d88-48a4-9d02-066dde8a6a00"): map[csi.imageid:37c6330c1fa7])
I0730 21:20:58.881027       1 utils.go:205] ID: 33 Req-ID: pvc-9d00b4ea-2748-4d82-9797-59c0e3ae1e99 GRPC response: {"volume":{"capacity_bytes":10737418240,"volume_context":{"clusterID":"4837cbf8-4f90-4300-b3f6-726c9b9f89b4","imageFeatures":"layering","imageName":"csi-vol-35078cef-2d88-48a4-9d02-066dde8a6a00","journalPool":"kube","pool":"kube"},"volume_id":"0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-35078cef-2d88-48a4-9d02-066dde8a6a00"}}
I0730 21:21:47.969226       1 utils.go:198] ID: 34 GRPC call: /csi.v1.Identity/Probe
I0730 21:21:47.969272       1 utils.go:199] ID: 34 GRPC request: {}
I0730 21:21:47.969292       1 utils.go:205] ID: 34 GRPC response: {}
I0730 21:22:47.918348       1 utils.go:198] ID: 35 GRPC call: /csi.v1.Identity/Probe
I0730 21:22:47.918427       1 utils.go:199] ID: 35 GRPC request: {}
I0730 21:22:47.918456       1 utils.go:205] ID: 35 GRPC response: {}
I0730 21:23:47.974429       1 utils.go:198] ID: 36 GRPC call: /csi.v1.Identity/Probe
I0730 21:23:47.974530       1 utils.go:199] ID: 36 GRPC request: {}
I0730 21:23:47.974554       1 utils.go:205] ID: 36 GRPC response: {}
I0730 21:24:47.969738       1 utils.go:198] ID: 37 GRPC call: /csi.v1.Identity/Probe
I0730 21:24:47.969792       1 utils.go:199] ID: 37 GRPC request: {}
I0730 21:24:47.969815       1 utils.go:205] ID: 37 GRPC response: {}
I0730 21:25:03.193463       1 utils.go:198] ID: 38 Req-ID: pvc-0f0b51e1-7347-4b90-a0ba-36598ca4c18c GRPC call: /csi.v1.Controller/CreateVolume
I0730 21:25:03.193653       1 utils.go:199] ID: 38 Req-ID: pvc-0f0b51e1-7347-4b90-a0ba-36598ca4c18c GRPC request: {"capacity_range":{"required_bytes":10737418240},"name":"pvc-0f0b51e1-7347-4b90-a0ba-36598ca4c18c","parameters":{"clusterID":"4837cbf8-4f90-4300-b3f6-726c9b9f89b4","csi.storage.k8s.io/pv/name":"pvc-0f0b51e1-7347-4b90-a0ba-36598ca4c18c","csi.storage.k8s.io/pvc/name":"persistence-rabbitmq-glance-server-0","csi.storage.k8s.io/pvc/namespace":"openstack","imageFeatures":"layering","pool":"kube"},"secrets":"***stripped***","volume_capabilities":[{"AccessType":{"Mount":{"fs_type":"ext4","mount_flags":["discard"]}},"access_mode":{"mode":1}}]}
I0730 21:25:03.193806       1 rbd_util.go:1315] ID: 38 Req-ID: pvc-0f0b51e1-7347-4b90-a0ba-36598ca4c18c setting disableInUseChecks: false image features: [layering] mounter: rbd
I0730 21:25:03.195266       1 omap.go:89] ID: 38 Req-ID: pvc-0f0b51e1-7347-4b90-a0ba-36598ca4c18c got omap values: (pool="kube", namespace="", name="csi.volumes.default"): map[]
I0730 21:25:03.212286       1 omap.go:159] ID: 38 Req-ID: pvc-0f0b51e1-7347-4b90-a0ba-36598ca4c18c set omap keys (pool="kube", namespace="", name="csi.volumes.default"): map[csi.volume.pvc-0f0b51e1-7347-4b90-a0ba-36598ca4c18c:139f7e1d-4341-4395-965f-e4ea4e4d6340])
I0730 21:25:03.219101       1 omap.go:159] ID: 38 Req-ID: pvc-0f0b51e1-7347-4b90-a0ba-36598ca4c18c set omap keys (pool="kube", namespace="", name="csi.volume.139f7e1d-4341-4395-965f-e4ea4e4d6340"): map[csi.imagename:csi-vol-139f7e1d-4341-4395-965f-e4ea4e4d6340 csi.volname:pvc-0f0b51e1-7347-4b90-a0ba-36598ca4c18c csi.volume.owner:openstack])
I0730 21:25:03.219127       1 rbd_journal.go:491] ID: 38 Req-ID: pvc-0f0b51e1-7347-4b90-a0ba-36598ca4c18c generated Volume ID (0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-139f7e1d-4341-4395-965f-e4ea4e4d6340) and image name (csi-vol-139f7e1d-4341-4395-965f-e4ea4e4d6340) for request name (pvc-0f0b51e1-7347-4b90-a0ba-36598ca4c18c)
I0730 21:25:03.219188       1 rbd_util.go:423] ID: 38 Req-ID: pvc-0f0b51e1-7347-4b90-a0ba-36598ca4c18c rbd: create kube/csi-vol-139f7e1d-4341-4395-965f-e4ea4e4d6340 size 10240M (features: [layering]) using mon 10.96.240.200
I0730 21:25:03.219219       1 rbd_util.go:1563] ID: 38 Req-ID: pvc-0f0b51e1-7347-4b90-a0ba-36598ca4c18c setting image options on kube/csi-vol-139f7e1d-4341-4395-965f-e4ea4e4d6340
I0730 21:25:03.252885       1 controllerserver.go:763] ID: 38 Req-ID: pvc-0f0b51e1-7347-4b90-a0ba-36598ca4c18c created image kube/csi-vol-139f7e1d-4341-4395-965f-e4ea4e4d6340 backed for request name pvc-0f0b51e1-7347-4b90-a0ba-36598ca4c18c
I0730 21:25:03.284862       1 omap.go:159] ID: 38 Req-ID: pvc-0f0b51e1-7347-4b90-a0ba-36598ca4c18c set omap keys (pool="kube", namespace="", name="csi.volume.139f7e1d-4341-4395-965f-e4ea4e4d6340"): map[csi.imageid:37c6c84d07fb])
I0730 21:25:03.389541       1 utils.go:205] ID: 38 Req-ID: pvc-0f0b51e1-7347-4b90-a0ba-36598ca4c18c GRPC response: {"volume":{"capacity_bytes":10737418240,"volume_context":{"clusterID":"4837cbf8-4f90-4300-b3f6-726c9b9f89b4","imageFeatures":"layering","imageName":"csi-vol-139f7e1d-4341-4395-965f-e4ea4e4d6340","journalPool":"kube","pool":"kube"},"volume_id":"0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-139f7e1d-4341-4395-965f-e4ea4e4d6340"}}
I0730 21:25:47.977438       1 utils.go:198] ID: 39 GRPC call: /csi.v1.Identity/Probe
I0730 21:25:47.977487       1 utils.go:199] ID: 39 GRPC request: {}
I0730 21:25:47.977509       1 utils.go:205] ID: 39 GRPC response: {}
I0730 21:26:47.918411       1 utils.go:198] ID: 40 GRPC call: /csi.v1.Identity/Probe
I0730 21:26:47.918465       1 utils.go:199] ID: 40 GRPC request: {}
I0730 21:26:47.918488       1 utils.go:205] ID: 40 GRPC response: {}
I0730 21:27:47.973662       1 utils.go:198] ID: 41 GRPC call: /csi.v1.Identity/Probe
I0730 21:27:47.973713       1 utils.go:199] ID: 41 GRPC request: {}
I0730 21:27:47.973746       1 utils.go:205] ID: 41 GRPC response: {}
I0730 21:28:47.921453       1 utils.go:198] ID: 42 GRPC call: /csi.v1.Identity/Probe
I0730 21:28:47.921527       1 utils.go:199] ID: 42 GRPC request: {}
I0730 21:28:47.921552       1 utils.go:205] ID: 42 GRPC response: {}
I0730 21:29:47.918240       1 utils.go:198] ID: 43 GRPC call: /csi.v1.Identity/Probe
I0730 21:29:47.918340       1 utils.go:199] ID: 43 GRPC request: {}
I0730 21:29:47.918364       1 utils.go:205] ID: 43 GRPC response: {}
I0730 21:30:10.556696       1 utils.go:198] ID: 44 Req-ID: pvc-9315dd99-8306-450c-b9e7-b0bcf31fc1e2 GRPC call: /csi.v1.Controller/CreateVolume
I0730 21:30:10.556946       1 utils.go:199] ID: 44 Req-ID: pvc-9315dd99-8306-450c-b9e7-b0bcf31fc1e2 GRPC request: {"capacity_range":{"required_bytes":10737418240},"name":"pvc-9315dd99-8306-450c-b9e7-b0bcf31fc1e2","parameters":{"clusterID":"4837cbf8-4f90-4300-b3f6-726c9b9f89b4","csi.storage.k8s.io/pv/name":"pvc-9315dd99-8306-450c-b9e7-b0bcf31fc1e2","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 21:30:10.557180       1 rbd_util.go:1315] ID: 44 Req-ID: pvc-9315dd99-8306-450c-b9e7-b0bcf31fc1e2 setting disableInUseChecks: false image features: [layering] mounter: rbd
I0730 21:30:10.559197       1 omap.go:89] ID: 44 Req-ID: pvc-9315dd99-8306-450c-b9e7-b0bcf31fc1e2 got omap values: (pool="kube", namespace="", name="csi.volumes.default"): map[]
I0730 21:30:10.573867       1 omap.go:159] ID: 44 Req-ID: pvc-9315dd99-8306-450c-b9e7-b0bcf31fc1e2 set omap keys (pool="kube", namespace="", name="csi.volumes.default"): map[csi.volume.pvc-9315dd99-8306-450c-b9e7-b0bcf31fc1e2:fceb1cc8-93e6-407e-bde9-167f940aea7c])
I0730 21:30:10.581788       1 omap.go:159] ID: 44 Req-ID: pvc-9315dd99-8306-450c-b9e7-b0bcf31fc1e2 set omap keys (pool="kube", namespace="", name="csi.volume.fceb1cc8-93e6-407e-bde9-167f940aea7c"): map[csi.imagename:csi-vol-fceb1cc8-93e6-407e-bde9-167f940aea7c csi.volname:pvc-9315dd99-8306-450c-b9e7-b0bcf31fc1e2 csi.volume.owner:openstack])
I0730 21:30:10.581827       1 rbd_journal.go:491] ID: 44 Req-ID: pvc-9315dd99-8306-450c-b9e7-b0bcf31fc1e2 generated Volume ID (0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-fceb1cc8-93e6-407e-bde9-167f940aea7c) and image name (csi-vol-fceb1cc8-93e6-407e-bde9-167f940aea7c) for request name (pvc-9315dd99-8306-450c-b9e7-b0bcf31fc1e2)
I0730 21:30:10.581908       1 rbd_util.go:423] ID: 44 Req-ID: pvc-9315dd99-8306-450c-b9e7-b0bcf31fc1e2 rbd: create kube/csi-vol-fceb1cc8-93e6-407e-bde9-167f940aea7c size 10240M (features: [layering]) using mon 10.96.240.200
I0730 21:30:10.581955       1 rbd_util.go:1563] ID: 44 Req-ID: pvc-9315dd99-8306-450c-b9e7-b0bcf31fc1e2 setting image options on kube/csi-vol-fceb1cc8-93e6-407e-bde9-167f940aea7c
I0730 21:30:10.615083       1 controllerserver.go:763] ID: 44 Req-ID: pvc-9315dd99-8306-450c-b9e7-b0bcf31fc1e2 created image kube/csi-vol-fceb1cc8-93e6-407e-bde9-167f940aea7c backed for request name pvc-9315dd99-8306-450c-b9e7-b0bcf31fc1e2
I0730 21:30:10.645315       1 omap.go:159] ID: 44 Req-ID: pvc-9315dd99-8306-450c-b9e7-b0bcf31fc1e2 set omap keys (pool="kube", namespace="", name="csi.volume.fceb1cc8-93e6-407e-bde9-167f940aea7c"): map[csi.imageid:37c615f81050])
I0730 21:30:10.757860       1 utils.go:205] ID: 44 Req-ID: pvc-9315dd99-8306-450c-b9e7-b0bcf31fc1e2 GRPC response: {"volume":{"capacity_bytes":10737418240,"volume_context":{"clusterID":"4837cbf8-4f90-4300-b3f6-726c9b9f89b4","imageFeatures":"layering","imageName":"csi-vol-fceb1cc8-93e6-407e-bde9-167f940aea7c","journalPool":"kube","pool":"kube"},"volume_id":"0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-fceb1cc8-93e6-407e-bde9-167f940aea7c"}}
I0730 21:30:47.932042       1 utils.go:198] ID: 45 GRPC call: /csi.v1.Identity/Probe
I0730 21:30:47.932105       1 utils.go:199] ID: 45 GRPC request: {}
I0730 21:30:47.932131       1 utils.go:205] ID: 45 GRPC response: {}
I0730 21:31:47.974157       1 utils.go:198] ID: 46 GRPC call: /csi.v1.Identity/Probe
I0730 21:31:47.974211       1 utils.go:199] ID: 46 GRPC request: {}
I0730 21:31:47.974233       1 utils.go:205] ID: 46 GRPC response: {}
I0730 21:32:47.940069       1 utils.go:198] ID: 47 GRPC call: /csi.v1.Identity/Probe
I0730 21:32:47.940140       1 utils.go:199] ID: 47 GRPC request: {}
I0730 21:32:47.940167       1 utils.go:205] ID: 47 GRPC response: {}
I0730 21:33:47.918335       1 utils.go:198] ID: 48 GRPC call: /csi.v1.Identity/Probe
I0730 21:33:47.918395       1 utils.go:199] ID: 48 GRPC request: {}
I0730 21:33:47.918428       1 utils.go:205] ID: 48 GRPC response: {}
I0730 21:34:47.948750       1 utils.go:198] ID: 49 GRPC call: /csi.v1.Identity/Probe
I0730 21:34:47.949795       1 utils.go:199] ID: 49 GRPC request: {}
I0730 21:34:47.949842       1 utils.go:205] ID: 49 GRPC response: {}
I0730 21:35:47.918293       1 utils.go:198] ID: 50 GRPC call: /csi.v1.Identity/Probe
I0730 21:35:47.918344       1 utils.go:199] ID: 50 GRPC request: {}
I0730 21:35:47.918365       1 utils.go:205] ID: 50 GRPC response: {}
I0730 21:36:47.960808       1 utils.go:198] ID: 51 GRPC call: /csi.v1.Identity/Probe
I0730 21:36:47.960855       1 utils.go:199] ID: 51 GRPC request: {}
I0730 21:36:47.960873       1 utils.go:205] ID: 51 GRPC response: {}
I0730 21:37:45.575155       1 utils.go:198] ID: 52 Req-ID: pvc-11cf9a3f-23b8-4d34-96c5-796b55cef9f5 GRPC call: /csi.v1.Controller/CreateVolume
I0730 21:37:45.575302       1 utils.go:199] ID: 52 Req-ID: pvc-11cf9a3f-23b8-4d34-96c5-796b55cef9f5 GRPC request: {"capacity_range":{"required_bytes":10737418240},"name":"pvc-11cf9a3f-23b8-4d34-96c5-796b55cef9f5","parameters":{"clusterID":"4837cbf8-4f90-4300-b3f6-726c9b9f89b4","csi.storage.k8s.io/pv/name":"pvc-11cf9a3f-23b8-4d34-96c5-796b55cef9f5","csi.storage.k8s.io/pvc/name":"persistence-rabbitmq-nova-server-0","csi.storage.k8s.io/pvc/namespace":"openstack","imageFeatures":"layering","pool":"kube"},"secrets":"***stripped***","volume_capabilities":[{"AccessType":{"Mount":{"fs_type":"ext4","mount_flags":["discard"]}},"access_mode":{"mode":1}}]}
I0730 21:37:45.575462       1 rbd_util.go:1315] ID: 52 Req-ID: pvc-11cf9a3f-23b8-4d34-96c5-796b55cef9f5 setting disableInUseChecks: false image features: [layering] mounter: rbd
I0730 21:37:45.577138       1 omap.go:89] ID: 52 Req-ID: pvc-11cf9a3f-23b8-4d34-96c5-796b55cef9f5 got omap values: (pool="kube", namespace="", name="csi.volumes.default"): map[]
I0730 21:37:45.603071       1 omap.go:159] ID: 52 Req-ID: pvc-11cf9a3f-23b8-4d34-96c5-796b55cef9f5 set omap keys (pool="kube", namespace="", name="csi.volumes.default"): map[csi.volume.pvc-11cf9a3f-23b8-4d34-96c5-796b55cef9f5:8dced655-c219-4a6d-84c6-c88ba61ba5c7])
I0730 21:37:45.613058       1 omap.go:159] ID: 52 Req-ID: pvc-11cf9a3f-23b8-4d34-96c5-796b55cef9f5 set omap keys (pool="kube", namespace="", name="csi.volume.8dced655-c219-4a6d-84c6-c88ba61ba5c7"): map[csi.imagename:csi-vol-8dced655-c219-4a6d-84c6-c88ba61ba5c7 csi.volname:pvc-11cf9a3f-23b8-4d34-96c5-796b55cef9f5 csi.volume.owner:openstack])
I0730 21:37:45.613094       1 rbd_journal.go:491] ID: 52 Req-ID: pvc-11cf9a3f-23b8-4d34-96c5-796b55cef9f5 generated Volume ID (0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-8dced655-c219-4a6d-84c6-c88ba61ba5c7) and image name (csi-vol-8dced655-c219-4a6d-84c6-c88ba61ba5c7) for request name (pvc-11cf9a3f-23b8-4d34-96c5-796b55cef9f5)
I0730 21:37:45.613169       1 rbd_util.go:423] ID: 52 Req-ID: pvc-11cf9a3f-23b8-4d34-96c5-796b55cef9f5 rbd: create kube/csi-vol-8dced655-c219-4a6d-84c6-c88ba61ba5c7 size 10240M (features: [layering]) using mon 10.96.240.200
I0730 21:37:45.613215       1 rbd_util.go:1563] ID: 52 Req-ID: pvc-11cf9a3f-23b8-4d34-96c5-796b55cef9f5 setting image options on kube/csi-vol-8dced655-c219-4a6d-84c6-c88ba61ba5c7
I0730 21:37:45.653834       1 controllerserver.go:763] ID: 52 Req-ID: pvc-11cf9a3f-23b8-4d34-96c5-796b55cef9f5 created image kube/csi-vol-8dced655-c219-4a6d-84c6-c88ba61ba5c7 backed for request name pvc-11cf9a3f-23b8-4d34-96c5-796b55cef9f5
I0730 21:37:45.717723       1 omap.go:159] ID: 52 Req-ID: pvc-11cf9a3f-23b8-4d34-96c5-796b55cef9f5 set omap keys (pool="kube", namespace="", name="csi.volume.8dced655-c219-4a6d-84c6-c88ba61ba5c7"): map[csi.imageid:37c67433f490])
I0730 21:37:45.830439       1 utils.go:205] ID: 52 Req-ID: pvc-11cf9a3f-23b8-4d34-96c5-796b55cef9f5 GRPC response: {"volume":{"capacity_bytes":10737418240,"volume_context":{"clusterID":"4837cbf8-4f90-4300-b3f6-726c9b9f89b4","imageFeatures":"layering","imageName":"csi-vol-8dced655-c219-4a6d-84c6-c88ba61ba5c7","journalPool":"kube","pool":"kube"},"volume_id":"0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-8dced655-c219-4a6d-84c6-c88ba61ba5c7"}}
I0730 21:37:47.973682       1 utils.go:198] ID: 53 GRPC call: /csi.v1.Identity/Probe
I0730 21:37:47.973748       1 utils.go:199] ID: 53 GRPC request: {}
I0730 21:37:47.973778       1 utils.go:205] ID: 53 GRPC response: {}
I0730 21:38:47.970763       1 utils.go:198] ID: 54 GRPC call: /csi.v1.Identity/Probe
I0730 21:38:47.970816       1 utils.go:199] ID: 54 GRPC request: {}
I0730 21:38:47.970842       1 utils.go:205] ID: 54 GRPC response: {}
I0730 21:39:47.965262       1 utils.go:198] ID: 55 GRPC call: /csi.v1.Identity/Probe
I0730 21:39:47.965299       1 utils.go:199] ID: 55 GRPC request: {}
I0730 21:39:47.965312       1 utils.go:205] ID: 55 GRPC response: {}
I0730 21:40:47.973506       1 utils.go:198] ID: 56 GRPC call: /csi.v1.Identity/Probe
I0730 21:40:47.973559       1 utils.go:199] ID: 56 GRPC request: {}
I0730 21:40:47.974274       1 utils.go:205] ID: 56 GRPC response: {}
I0730 21:41:47.918839       1 utils.go:198] ID: 57 GRPC call: /csi.v1.Identity/Probe
I0730 21:41:47.918910       1 utils.go:199] ID: 57 GRPC request: {}
I0730 21:41:47.918961       1 utils.go:205] ID: 57 GRPC response: {}
I0730 21:42:47.973550       1 utils.go:198] ID: 58 GRPC call: /csi.v1.Identity/Probe
I0730 21:42:47.973587       1 utils.go:199] ID: 58 GRPC request: {}
I0730 21:42:47.973602       1 utils.go:205] ID: 58 GRPC response: {}
I0730 21:43:47.935099       1 utils.go:198] ID: 59 GRPC call: /csi.v1.Identity/Probe
I0730 21:43:47.935165       1 utils.go:199] ID: 59 GRPC request: {}
I0730 21:43:47.935190       1 utils.go:205] ID: 59 GRPC response: {}
I0730 21:44:20.714678       1 utils.go:198] ID: 60 Req-ID: pvc-a4a50994-6a67-4a46-92bc-e48da6772194 GRPC call: /csi.v1.Controller/CreateVolume
I0730 21:44:20.714841       1 utils.go:199] ID: 60 Req-ID: pvc-a4a50994-6a67-4a46-92bc-e48da6772194 GRPC request: {"capacity_range":{"required_bytes":10737418240},"name":"pvc-a4a50994-6a67-4a46-92bc-e48da6772194","parameters":{"clusterID":"4837cbf8-4f90-4300-b3f6-726c9b9f89b4","csi.storage.k8s.io/pv/name":"pvc-a4a50994-6a67-4a46-92bc-e48da6772194","csi.storage.k8s.io/pvc/name":"persistence-rabbitmq-neutron-server-0","csi.storage.k8s.io/pvc/namespace":"openstack","imageFeatures":"layering","pool":"kube"},"secrets":"***stripped***","volume_capabilities":[{"AccessType":{"Mount":{"fs_type":"ext4","mount_flags":["discard"]}},"access_mode":{"mode":1}}]}
I0730 21:44:20.715026       1 rbd_util.go:1315] ID: 60 Req-ID: pvc-a4a50994-6a67-4a46-92bc-e48da6772194 setting disableInUseChecks: false image features: [layering] mounter: rbd
I0730 21:44:20.716596       1 omap.go:89] ID: 60 Req-ID: pvc-a4a50994-6a67-4a46-92bc-e48da6772194 got omap values: (pool="kube", namespace="", name="csi.volumes.default"): map[]
I0730 21:44:20.728496       1 omap.go:159] ID: 60 Req-ID: pvc-a4a50994-6a67-4a46-92bc-e48da6772194 set omap keys (pool="kube", namespace="", name="csi.volumes.default"): map[csi.volume.pvc-a4a50994-6a67-4a46-92bc-e48da6772194:eeacdca4-8b17-488b-b039-ed91c75fe347])
I0730 21:44:20.738656       1 omap.go:159] ID: 60 Req-ID: pvc-a4a50994-6a67-4a46-92bc-e48da6772194 set omap keys (pool="kube", namespace="", name="csi.volume.eeacdca4-8b17-488b-b039-ed91c75fe347"): map[csi.imagename:csi-vol-eeacdca4-8b17-488b-b039-ed91c75fe347 csi.volname:pvc-a4a50994-6a67-4a46-92bc-e48da6772194 csi.volume.owner:openstack])
I0730 21:44:20.738689       1 rbd_journal.go:491] ID: 60 Req-ID: pvc-a4a50994-6a67-4a46-92bc-e48da6772194 generated Volume ID (0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-eeacdca4-8b17-488b-b039-ed91c75fe347) and image name (csi-vol-eeacdca4-8b17-488b-b039-ed91c75fe347) for request name (pvc-a4a50994-6a67-4a46-92bc-e48da6772194)
I0730 21:44:20.738751       1 rbd_util.go:423] ID: 60 Req-ID: pvc-a4a50994-6a67-4a46-92bc-e48da6772194 rbd: create kube/csi-vol-eeacdca4-8b17-488b-b039-ed91c75fe347 size 10240M (features: [layering]) using mon 10.96.240.200
I0730 21:44:20.738795       1 rbd_util.go:1563] ID: 60 Req-ID: pvc-a4a50994-6a67-4a46-92bc-e48da6772194 setting image options on kube/csi-vol-eeacdca4-8b17-488b-b039-ed91c75fe347
I0730 21:44:20.768263       1 controllerserver.go:763] ID: 60 Req-ID: pvc-a4a50994-6a67-4a46-92bc-e48da6772194 created image kube/csi-vol-eeacdca4-8b17-488b-b039-ed91c75fe347 backed for request name pvc-a4a50994-6a67-4a46-92bc-e48da6772194
I0730 21:44:20.800165       1 omap.go:159] ID: 60 Req-ID: pvc-a4a50994-6a67-4a46-92bc-e48da6772194 set omap keys (pool="kube", namespace="", name="csi.volume.eeacdca4-8b17-488b-b039-ed91c75fe347"): map[csi.imageid:37c69b2ffbd4])
I0730 21:44:20.899050       1 utils.go:205] ID: 60 Req-ID: pvc-a4a50994-6a67-4a46-92bc-e48da6772194 GRPC response: {"volume":{"capacity_bytes":10737418240,"volume_context":{"clusterID":"4837cbf8-4f90-4300-b3f6-726c9b9f89b4","imageFeatures":"layering","imageName":"csi-vol-eeacdca4-8b17-488b-b039-ed91c75fe347","journalPool":"kube","pool":"kube"},"volume_id":"0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-eeacdca4-8b17-488b-b039-ed91c75fe347"}}
I0730 21:44:47.973781       1 utils.go:198] ID: 61 GRPC call: /csi.v1.Identity/Probe
I0730 21:44:47.973833       1 utils.go:199] ID: 61 GRPC request: {}
I0730 21:44:47.973858       1 utils.go:205] ID: 61 GRPC response: {}
I0730 21:45:47.938980       1 utils.go:198] ID: 62 GRPC call: /csi.v1.Identity/Probe
I0730 21:45:47.939059       1 utils.go:199] ID: 62 GRPC request: {}
I0730 21:45:47.939084       1 utils.go:205] ID: 62 GRPC response: {}
I0730 21:46:47.918499       1 utils.go:198] ID: 63 GRPC call: /csi.v1.Identity/Probe
I0730 21:46:47.918567       1 utils.go:199] ID: 63 GRPC request: {}
I0730 21:46:47.918598       1 utils.go:205] ID: 63 GRPC response: {}
I0730 21:47:47.949687       1 utils.go:198] ID: 64 GRPC call: /csi.v1.Identity/Probe
I0730 21:47:47.949722       1 utils.go:199] ID: 64 GRPC request: {}
I0730 21:47:47.949735       1 utils.go:205] ID: 64 GRPC response: {}
I0730 21:48:47.973543       1 utils.go:198] ID: 65 GRPC call: /csi.v1.Identity/Probe
I0730 21:48:47.973665       1 utils.go:199] ID: 65 GRPC request: {}
I0730 21:48:47.973686       1 utils.go:205] ID: 65 GRPC response: {}
I0730 21:49:47.962863       1 utils.go:198] ID: 66 GRPC call: /csi.v1.Identity/Probe
I0730 21:49:47.962957       1 utils.go:199] ID: 66 GRPC request: {}
I0730 21:49:47.962986       1 utils.go:205] ID: 66 GRPC response: {}
I0730 21:50:47.973699       1 utils.go:198] ID: 67 GRPC call: /csi.v1.Identity/Probe
I0730 21:50:47.973750       1 utils.go:199] ID: 67 GRPC request: {}
I0730 21:50:47.973770       1 utils.go:205] ID: 67 GRPC response: {}
I0730 21:51:47.970087       1 utils.go:198] ID: 68 GRPC call: /csi.v1.Identity/Probe
I0730 21:51:47.970140       1 utils.go:199] ID: 68 GRPC request: {}
I0730 21:51:47.970161       1 utils.go:205] ID: 68 GRPC response: {}
I0730 21:52:47.918318       1 utils.go:198] ID: 69 GRPC call: /csi.v1.Identity/Probe
I0730 21:52:47.918372       1 utils.go:199] ID: 69 GRPC request: {}
I0730 21:52:47.918393       1 utils.go:205] ID: 69 GRPC response: {}
I0730 21:53:47.977566       1 utils.go:198] ID: 70 GRPC call: /csi.v1.Identity/Probe
I0730 21:53:47.977629       1 utils.go:199] ID: 70 GRPC request: {}
I0730 21:53:47.977655       1 utils.go:205] ID: 70 GRPC response: {}
I0730 21:54:47.921631       1 utils.go:198] ID: 71 GRPC call: /csi.v1.Identity/Probe
I0730 21:54:47.921707       1 utils.go:199] ID: 71 GRPC request: {}
I0730 21:54:47.921732       1 utils.go:205] ID: 71 GRPC response: {}
I0730 21:55:47.975103       1 utils.go:198] ID: 72 GRPC call: /csi.v1.Identity/Probe
I0730 21:55:47.975267       1 utils.go:199] ID: 72 GRPC request: {}
I0730 21:55:47.975518       1 utils.go:205] ID: 72 GRPC response: {}
I0730 21:56:47.923509       1 utils.go:198] ID: 73 GRPC call: /csi.v1.Identity/Probe
I0730 21:56:47.923618       1 utils.go:199] ID: 73 GRPC request: {}
I0730 21:56:47.923689       1 utils.go:205] ID: 73 GRPC response: {}
I0730 21:57:47.975075       1 utils.go:198] ID: 74 GRPC call: /csi.v1.Identity/Probe
I0730 21:57:47.975143       1 utils.go:199] ID: 74 GRPC request: {}
I0730 21:57:47.975168       1 utils.go:205] ID: 74 GRPC response: {}
I0730 21:58:47.934634       1 utils.go:198] ID: 75 GRPC call: /csi.v1.Identity/Probe
I0730 21:58:47.934954       1 utils.go:199] ID: 75 GRPC request: {}
I0730 21:58:47.935159       1 utils.go:205] ID: 75 GRPC response: {}
I0730 21:59:47.974728       1 utils.go:198] ID: 76 GRPC call: /csi.v1.Identity/Probe
I0730 21:59:47.974791       1 utils.go:199] ID: 76 GRPC request: {}
I0730 21:59:47.974818       1 utils.go:205] ID: 76 GRPC response: {}
I0730 22:00:47.938833       1 utils.go:198] ID: 77 GRPC call: /csi.v1.Identity/Probe
I0730 22:00:47.938874       1 utils.go:199] ID: 77 GRPC request: {}
I0730 22:00:47.938892       1 utils.go:205] ID: 77 GRPC response: {}
I0730 22:01:47.918638       1 utils.go:198] ID: 78 GRPC call: /csi.v1.Identity/Probe
I0730 22:01:47.918709       1 utils.go:199] ID: 78 GRPC request: {}
I0730 22:01:47.918729       1 utils.go:205] ID: 78 GRPC response: {}
I0730 22:02:47.948930       1 utils.go:198] ID: 79 GRPC call: /csi.v1.Identity/Probe
I0730 22:02:47.948986       1 utils.go:199] ID: 79 GRPC request: {}
I0730 22:02:47.949011       1 utils.go:205] ID: 79 GRPC response: {}
I0730 22:03:47.918449       1 utils.go:198] ID: 80 GRPC call: /csi.v1.Identity/Probe
I0730 22:03:47.918524       1 utils.go:199] ID: 80 GRPC request: {}
I0730 22:03:47.918550       1 utils.go:205] ID: 80 GRPC response: {}
I0730 22:04:47.960428       1 utils.go:198] ID: 81 GRPC call: /csi.v1.Identity/Probe
I0730 22:04:47.960501       1 utils.go:199] ID: 81 GRPC request: {}
I0730 22:04:47.960524       1 utils.go:205] ID: 81 GRPC response: {}
I0730 22:05:47.974353       1 utils.go:198] ID: 82 GRPC call: /csi.v1.Identity/Probe
I0730 22:05:47.974398       1 utils.go:199] ID: 82 GRPC request: {}
I0730 22:05:47.974415       1 utils.go:205] ID: 82 GRPC response: {}
I0730 22:06:47.970370       1 utils.go:198] ID: 83 GRPC call: /csi.v1.Identity/Probe
I0730 22:06:47.970457       1 utils.go:199] ID: 83 GRPC request: {}
I0730 22:06:47.970486       1 utils.go:205] ID: 83 GRPC response: {}