I0730 18:58:30.914811 1 cephcsi.go:191] Driver version: v3.11.0 and Git version: bc24b5eca87626d690a29effa9d7420cc0154a7a I0730 18:58:30.914971 1 cephcsi.go:223] Starting driver type: rbd with name: rbd.csi.ceph.com I0730 18:58:30.914984 1 driver.go:95] Enabling controller service capability: CREATE_DELETE_VOLUME I0730 18:58:30.914988 1 driver.go:95] Enabling controller service capability: CREATE_DELETE_SNAPSHOT I0730 18:58:30.914992 1 driver.go:95] Enabling controller service capability: CLONE_VOLUME I0730 18:58:30.914995 1 driver.go:95] Enabling controller service capability: EXPAND_VOLUME I0730 18:58:30.914999 1 driver.go:108] Enabling volume access mode: SINGLE_NODE_WRITER I0730 18:58:30.915002 1 driver.go:108] Enabling volume access mode: MULTI_NODE_MULTI_WRITER I0730 18:58:30.915005 1 driver.go:108] Enabling volume access mode: SINGLE_NODE_SINGLE_WRITER I0730 18:58:30.915009 1 driver.go:108] Enabling volume access mode: SINGLE_NODE_MULTI_WRITER I0730 18:58:30.915283 1 server.go:117] Listening for connections on address: &net.UnixAddr{Name:"//csi/csi-provisioner.sock", Net:"unix"} I0730 18:58:30.915369 1 server.go:114] listening for CSI-Addons requests on address: &net.UnixAddr{Name:"/csi/csi-addons.sock", Net:"unix"} I0730 18:58:39.704916 1 utils.go:198] ID: 1 GRPC call: /csi.v1.Identity/Probe I0730 18:58:39.705881 1 utils.go:199] ID: 1 GRPC request: {} I0730 18:58:39.705932 1 utils.go:205] ID: 1 GRPC response: {} I0730 18:58:39.708006 1 utils.go:198] ID: 2 GRPC call: /csi.v1.Identity/GetPluginInfo I0730 18:58:39.708046 1 utils.go:199] ID: 2 GRPC request: {} I0730 18:58:39.708074 1 identityserver-default.go:40] ID: 2 Using default GetPluginInfo I0730 18:58:39.708125 1 utils.go:205] ID: 2 GRPC response: {"name":"rbd.csi.ceph.com","vendor_version":"v3.11.0"} I0730 18:58:39.709174 1 utils.go:198] ID: 3 GRPC call: /csi.v1.Identity/Probe I0730 18:58:39.709199 1 utils.go:199] ID: 3 GRPC request: {} I0730 18:58:39.709210 1 utils.go:205] ID: 3 GRPC response: {} I0730 18:58:39.709744 1 utils.go:198] ID: 4 GRPC call: /csi.v1.Identity/GetPluginCapabilities I0730 18:58:39.709874 1 utils.go:199] ID: 4 GRPC request: {} I0730 18:58:39.710186 1 utils.go:205] ID: 4 GRPC response: {"capabilities":[{"Type":{"Service":{"type":1}}},{"Type":{"VolumeExpansion":{"type":1}}},{"Type":{"Service":{"type":2}}}]} I0730 18:58:39.711177 1 utils.go:198] ID: 5 GRPC call: /csi.v1.Controller/ControllerGetCapabilities I0730 18:58:39.711224 1 utils.go:199] ID: 5 GRPC request: {} I0730 18:58:39.711237 1 controllerserver-default.go:42] ID: 5 Using default ControllerGetCapabilities I0730 18:58:39.711339 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 18:58:45.827945 1 utils.go:198] ID: 6 GRPC call: /csi.v1.Identity/Probe I0730 18:58:45.828002 1 utils.go:199] ID: 6 GRPC request: {} I0730 18:58:45.828028 1 utils.go:205] ID: 6 GRPC response: {} I0730 18:58:45.831510 1 utils.go:198] ID: 7 GRPC call: /csi.v1.Identity/GetPluginInfo I0730 18:58:45.831565 1 utils.go:199] ID: 7 GRPC request: {} I0730 18:58:45.831577 1 identityserver-default.go:40] ID: 7 Using default GetPluginInfo I0730 18:58:45.831613 1 utils.go:205] ID: 7 GRPC response: {"name":"rbd.csi.ceph.com","vendor_version":"v3.11.0"} I0730 18:58:45.835758 1 utils.go:198] ID: 8 GRPC call: /csi.v1.Identity/Probe I0730 18:58:45.835801 1 utils.go:199] ID: 8 GRPC request: {} I0730 18:58:45.835823 1 utils.go:205] ID: 8 GRPC response: {} I0730 18:58:45.836615 1 utils.go:198] ID: 9 GRPC call: /csi.v1.Identity/GetPluginCapabilities I0730 18:58:45.836635 1 utils.go:199] ID: 9 GRPC request: {} I0730 18:58:45.836754 1 utils.go:205] ID: 9 GRPC response: {"capabilities":[{"Type":{"Service":{"type":1}}},{"Type":{"VolumeExpansion":{"type":1}}},{"Type":{"Service":{"type":2}}}]} I0730 18:58:45.837593 1 utils.go:198] ID: 10 GRPC call: /csi.v1.Controller/ControllerGetCapabilities I0730 18:58:45.837614 1 utils.go:199] ID: 10 GRPC request: {} I0730 18:58:45.837622 1 controllerserver-default.go:42] ID: 10 Using default ControllerGetCapabilities I0730 18:58:45.837684 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 18:58:45.839272 1 utils.go:198] ID: 11 GRPC call: /csi.v1.Controller/ControllerGetCapabilities I0730 18:58:45.839321 1 utils.go:199] ID: 11 GRPC request: {} I0730 18:58:45.839331 1 controllerserver-default.go:42] ID: 11 Using default ControllerGetCapabilities I0730 18:58:45.839436 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 18:58:45.839819 1 utils.go:198] ID: 12 GRPC call: /csi.v1.Controller/ControllerGetCapabilities I0730 18:58:45.839839 1 utils.go:199] ID: 12 GRPC request: {} I0730 18:58:45.839845 1 controllerserver-default.go:42] ID: 12 Using default ControllerGetCapabilities I0730 18:58:45.839913 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 18:58:52.346509 1 utils.go:198] ID: 13 GRPC call: /csi.v1.Identity/GetPluginInfo I0730 18:58:52.346567 1 utils.go:199] ID: 13 GRPC request: {} I0730 18:58:52.346580 1 identityserver-default.go:40] ID: 13 Using default GetPluginInfo I0730 18:58:52.346622 1 utils.go:205] ID: 13 GRPC response: {"name":"rbd.csi.ceph.com","vendor_version":"v3.11.0"} I0730 18:58:52.351181 1 utils.go:198] ID: 14 GRPC call: /csi.v1.Identity/Probe I0730 18:58:52.351212 1 utils.go:199] ID: 14 GRPC request: {} I0730 18:58:52.351235 1 utils.go:205] ID: 14 GRPC response: {} I0730 18:58:52.351763 1 utils.go:198] ID: 15 GRPC call: /csi.v1.Controller/ControllerGetCapabilities I0730 18:58:52.351815 1 utils.go:199] ID: 15 GRPC request: {} I0730 18:58:52.351834 1 controllerserver-default.go:42] ID: 15 Using default ControllerGetCapabilities I0730 18:58:52.351980 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 18:58:55.045866 1 utils.go:198] ID: 16 GRPC call: /csi.v1.Identity/Probe I0730 18:58:55.045902 1 utils.go:199] ID: 16 GRPC request: {} I0730 18:58:55.045923 1 utils.go:205] ID: 16 GRPC response: {} I0730 18:58:55.048972 1 utils.go:198] ID: 17 GRPC call: /csi.v1.Identity/GetPluginInfo I0730 18:58:55.048991 1 utils.go:199] ID: 17 GRPC request: {} I0730 18:58:55.048999 1 identityserver-default.go:40] ID: 17 Using default GetPluginInfo I0730 18:58:55.049030 1 utils.go:205] ID: 17 GRPC response: {"name":"rbd.csi.ceph.com","vendor_version":"v3.11.0"} I0730 18:58:55.050438 1 utils.go:198] ID: 18 GRPC call: /csi.v1.Identity/Probe I0730 18:58:55.050456 1 utils.go:199] ID: 18 GRPC request: {} I0730 18:58:55.050467 1 utils.go:205] ID: 18 GRPC response: {} I0730 18:58:55.050851 1 utils.go:198] ID: 19 GRPC call: /csi.v1.Identity/GetPluginCapabilities I0730 18:58:55.050885 1 utils.go:199] ID: 19 GRPC request: {} I0730 18:58:55.050983 1 utils.go:205] ID: 19 GRPC response: {"capabilities":[{"Type":{"Service":{"type":1}}},{"Type":{"VolumeExpansion":{"type":1}}},{"Type":{"Service":{"type":2}}}]} I0730 18:58:55.051766 1 utils.go:198] ID: 20 GRPC call: /csi.v1.Controller/ControllerGetCapabilities I0730 18:58:55.051790 1 utils.go:199] ID: 20 GRPC request: {} I0730 18:58:55.051800 1 controllerserver-default.go:42] ID: 20 Using default ControllerGetCapabilities I0730 18:58:55.051872 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 18:59:39.128769 1 utils.go:198] ID: 21 Req-ID: pvc-d84e6bef-8c62-4be0-bfd4-b35d0159b9bc GRPC call: /csi.v1.Controller/CreateVolume I0730 18:59:39.129151 1 utils.go:199] ID: 21 Req-ID: pvc-d84e6bef-8c62-4be0-bfd4-b35d0159b9bc GRPC request: {"capacity_range":{"required_bytes":171798691840},"name":"pvc-d84e6bef-8c62-4be0-bfd4-b35d0159b9bc","parameters":{"clusterID":"4837cbf8-4f90-4300-b3f6-726c9b9f89b4","csi.storage.k8s.io/pv/name":"pvc-d84e6bef-8c62-4be0-bfd4-b35d0159b9bc","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 18:59:39.129467 1 rbd_util.go:1315] ID: 21 Req-ID: pvc-d84e6bef-8c62-4be0-bfd4-b35d0159b9bc setting disableInUseChecks: false image features: [layering] mounter: rbd E0730 18:59:39.158483 1 omap.go:80] ID: 21 Req-ID: pvc-d84e6bef-8c62-4be0-bfd4-b35d0159b9bc omap not found (pool="kube", namespace="", name="csi.volumes.default"): rados: ret=-2, No such file or directory I0730 18:59:39.176090 1 omap.go:159] ID: 21 Req-ID: pvc-d84e6bef-8c62-4be0-bfd4-b35d0159b9bc set omap keys (pool="kube", namespace="", name="csi.volumes.default"): map[csi.volume.pvc-d84e6bef-8c62-4be0-bfd4-b35d0159b9bc:66199260-dec0-400f-ad9a-1d3f4da2361b]) I0730 18:59:39.183895 1 omap.go:159] ID: 21 Req-ID: pvc-d84e6bef-8c62-4be0-bfd4-b35d0159b9bc set omap keys (pool="kube", namespace="", name="csi.volume.66199260-dec0-400f-ad9a-1d3f4da2361b"): map[csi.imagename:csi-vol-66199260-dec0-400f-ad9a-1d3f4da2361b csi.volname:pvc-d84e6bef-8c62-4be0-bfd4-b35d0159b9bc csi.volume.owner:openstack]) I0730 18:59:39.183969 1 rbd_journal.go:491] ID: 21 Req-ID: pvc-d84e6bef-8c62-4be0-bfd4-b35d0159b9bc generated Volume ID (0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-66199260-dec0-400f-ad9a-1d3f4da2361b) and image name (csi-vol-66199260-dec0-400f-ad9a-1d3f4da2361b) for request name (pvc-d84e6bef-8c62-4be0-bfd4-b35d0159b9bc) I0730 18:59:39.184118 1 rbd_util.go:423] ID: 21 Req-ID: pvc-d84e6bef-8c62-4be0-bfd4-b35d0159b9bc rbd: create kube/csi-vol-66199260-dec0-400f-ad9a-1d3f4da2361b size 163840M (features: [layering]) using mon 10.96.240.200 I0730 18:59:39.184211 1 rbd_util.go:1563] ID: 21 Req-ID: pvc-d84e6bef-8c62-4be0-bfd4-b35d0159b9bc setting image options on kube/csi-vol-66199260-dec0-400f-ad9a-1d3f4da2361b I0730 18:59:39.218391 1 controllerserver.go:763] ID: 21 Req-ID: pvc-d84e6bef-8c62-4be0-bfd4-b35d0159b9bc created image kube/csi-vol-66199260-dec0-400f-ad9a-1d3f4da2361b backed for request name pvc-d84e6bef-8c62-4be0-bfd4-b35d0159b9bc I0730 18:59:39.252630 1 omap.go:159] ID: 21 Req-ID: pvc-d84e6bef-8c62-4be0-bfd4-b35d0159b9bc set omap keys (pool="kube", namespace="", name="csi.volume.66199260-dec0-400f-ad9a-1d3f4da2361b"): map[csi.imageid:37c6ca2c88ec]) I0730 18:59:39.353304 1 utils.go:205] ID: 21 Req-ID: pvc-d84e6bef-8c62-4be0-bfd4-b35d0159b9bc GRPC response: {"volume":{"capacity_bytes":171798691840,"volume_context":{"clusterID":"4837cbf8-4f90-4300-b3f6-726c9b9f89b4","imageFeatures":"layering","imageName":"csi-vol-66199260-dec0-400f-ad9a-1d3f4da2361b","journalPool":"kube","pool":"kube"},"volume_id":"0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-66199260-dec0-400f-ad9a-1d3f4da2361b"}} I0730 18:59:55.282251 1 utils.go:198] ID: 22 GRPC call: /csi.v1.Identity/Probe I0730 18:59:55.282302 1 utils.go:199] ID: 22 GRPC request: {} I0730 18:59:55.282324 1 utils.go:205] ID: 22 GRPC response: {} I0730 19:00:55.238544 1 utils.go:198] ID: 23 GRPC call: /csi.v1.Identity/Probe I0730 19:00:55.238620 1 utils.go:199] ID: 23 GRPC request: {} I0730 19:00:55.238670 1 utils.go:205] ID: 23 GRPC response: {} I0730 19:01:55.233989 1 utils.go:198] ID: 24 GRPC call: /csi.v1.Identity/Probe I0730 19:01:55.234035 1 utils.go:199] ID: 24 GRPC request: {} I0730 19:01:55.234070 1 utils.go:205] ID: 24 GRPC response: {} I0730 19:02:55.245250 1 utils.go:198] ID: 25 GRPC call: /csi.v1.Identity/Probe I0730 19:02:55.245309 1 utils.go:199] ID: 25 GRPC request: {} I0730 19:02:55.245331 1 utils.go:205] ID: 25 GRPC response: {} I0730 19:03:55.289752 1 utils.go:198] ID: 26 GRPC call: /csi.v1.Identity/Probe I0730 19:03:55.289825 1 utils.go:199] ID: 26 GRPC request: {} I0730 19:03:55.289851 1 utils.go:205] ID: 26 GRPC response: {} I0730 19:04:55.256169 1 utils.go:198] ID: 27 GRPC call: /csi.v1.Identity/Probe I0730 19:04:55.256251 1 utils.go:199] ID: 27 GRPC request: {} I0730 19:04:55.256314 1 utils.go:205] ID: 27 GRPC response: {} I0730 19:05:55.276615 1 utils.go:198] ID: 28 GRPC call: /csi.v1.Identity/Probe I0730 19:05:55.276683 1 utils.go:199] ID: 28 GRPC request: {} I0730 19:05:55.276844 1 utils.go:205] ID: 28 GRPC response: {} I0730 19:06:55.264847 1 utils.go:198] ID: 29 GRPC call: /csi.v1.Identity/Probe I0730 19:06:55.264896 1 utils.go:199] ID: 29 GRPC request: {} I0730 19:06:55.264918 1 utils.go:205] ID: 29 GRPC response: {} I0730 19:07:55.234074 1 utils.go:198] ID: 30 GRPC call: /csi.v1.Identity/Probe I0730 19:07:55.234249 1 utils.go:199] ID: 30 GRPC request: {} I0730 19:07:55.234287 1 utils.go:205] ID: 30 GRPC response: {} I0730 19:08:55.275696 1 utils.go:198] ID: 31 GRPC call: /csi.v1.Identity/Probe I0730 19:08:55.275761 1 utils.go:199] ID: 31 GRPC request: {} I0730 19:08:55.275784 1 utils.go:205] ID: 31 GRPC response: {} I0730 19:09:55.233829 1 utils.go:198] ID: 32 GRPC call: /csi.v1.Identity/Probe I0730 19:09:55.233882 1 utils.go:199] ID: 32 GRPC request: {} I0730 19:09:55.233903 1 utils.go:205] ID: 32 GRPC response: {} I0730 19:10:26.482275 1 utils.go:198] ID: 33 Req-ID: pvc-c1a8cb85-71c6-4ddb-86ce-5bb18b7bf7d2 GRPC call: /csi.v1.Controller/CreateVolume I0730 19:10:26.482478 1 utils.go:199] ID: 33 Req-ID: pvc-c1a8cb85-71c6-4ddb-86ce-5bb18b7bf7d2 GRPC request: {"capacity_range":{"required_bytes":10737418240},"name":"pvc-c1a8cb85-71c6-4ddb-86ce-5bb18b7bf7d2","parameters":{"clusterID":"4837cbf8-4f90-4300-b3f6-726c9b9f89b4","csi.storage.k8s.io/pv/name":"pvc-c1a8cb85-71c6-4ddb-86ce-5bb18b7bf7d2","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 19:10:26.482659 1 rbd_util.go:1315] ID: 33 Req-ID: pvc-c1a8cb85-71c6-4ddb-86ce-5bb18b7bf7d2 setting disableInUseChecks: false image features: [layering] mounter: rbd I0730 19:10:26.484022 1 omap.go:89] ID: 33 Req-ID: pvc-c1a8cb85-71c6-4ddb-86ce-5bb18b7bf7d2 got omap values: (pool="kube", namespace="", name="csi.volumes.default"): map[] I0730 19:10:26.503399 1 omap.go:159] ID: 33 Req-ID: pvc-c1a8cb85-71c6-4ddb-86ce-5bb18b7bf7d2 set omap keys (pool="kube", namespace="", name="csi.volumes.default"): map[csi.volume.pvc-c1a8cb85-71c6-4ddb-86ce-5bb18b7bf7d2:4bfc32da-4c40-459c-83ac-9b598ab68286]) I0730 19:10:26.509228 1 omap.go:159] ID: 33 Req-ID: pvc-c1a8cb85-71c6-4ddb-86ce-5bb18b7bf7d2 set omap keys (pool="kube", namespace="", name="csi.volume.4bfc32da-4c40-459c-83ac-9b598ab68286"): map[csi.imagename:csi-vol-4bfc32da-4c40-459c-83ac-9b598ab68286 csi.volname:pvc-c1a8cb85-71c6-4ddb-86ce-5bb18b7bf7d2 csi.volume.owner:openstack]) I0730 19:10:26.509262 1 rbd_journal.go:491] ID: 33 Req-ID: pvc-c1a8cb85-71c6-4ddb-86ce-5bb18b7bf7d2 generated Volume ID (0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-4bfc32da-4c40-459c-83ac-9b598ab68286) and image name (csi-vol-4bfc32da-4c40-459c-83ac-9b598ab68286) for request name (pvc-c1a8cb85-71c6-4ddb-86ce-5bb18b7bf7d2) I0730 19:10:26.509388 1 rbd_util.go:423] ID: 33 Req-ID: pvc-c1a8cb85-71c6-4ddb-86ce-5bb18b7bf7d2 rbd: create kube/csi-vol-4bfc32da-4c40-459c-83ac-9b598ab68286 size 10240M (features: [layering]) using mon 10.96.240.200 I0730 19:10:26.509422 1 rbd_util.go:1563] ID: 33 Req-ID: pvc-c1a8cb85-71c6-4ddb-86ce-5bb18b7bf7d2 setting image options on kube/csi-vol-4bfc32da-4c40-459c-83ac-9b598ab68286 I0730 19:10:26.543798 1 controllerserver.go:763] ID: 33 Req-ID: pvc-c1a8cb85-71c6-4ddb-86ce-5bb18b7bf7d2 created image kube/csi-vol-4bfc32da-4c40-459c-83ac-9b598ab68286 backed for request name pvc-c1a8cb85-71c6-4ddb-86ce-5bb18b7bf7d2 I0730 19:10:26.574588 1 omap.go:159] ID: 33 Req-ID: pvc-c1a8cb85-71c6-4ddb-86ce-5bb18b7bf7d2 set omap keys (pool="kube", namespace="", name="csi.volume.4bfc32da-4c40-459c-83ac-9b598ab68286"): map[csi.imageid:37c6b40fcfe1]) I0730 19:10:26.678603 1 utils.go:205] ID: 33 Req-ID: pvc-c1a8cb85-71c6-4ddb-86ce-5bb18b7bf7d2 GRPC response: {"volume":{"capacity_bytes":10737418240,"volume_context":{"clusterID":"4837cbf8-4f90-4300-b3f6-726c9b9f89b4","imageFeatures":"layering","imageName":"csi-vol-4bfc32da-4c40-459c-83ac-9b598ab68286","journalPool":"kube","pool":"kube"},"volume_id":"0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-4bfc32da-4c40-459c-83ac-9b598ab68286"}} I0730 19:10:55.286297 1 utils.go:198] ID: 34 GRPC call: /csi.v1.Identity/Probe I0730 19:10:55.286372 1 utils.go:199] ID: 34 GRPC request: {} I0730 19:10:55.286412 1 utils.go:205] ID: 34 GRPC response: {} I0730 19:11:55.261707 1 utils.go:198] ID: 35 GRPC call: /csi.v1.Identity/Probe I0730 19:11:55.261762 1 utils.go:199] ID: 35 GRPC request: {} I0730 19:11:55.261785 1 utils.go:205] ID: 35 GRPC response: {} I0730 19:12:55.294226 1 utils.go:198] ID: 36 GRPC call: /csi.v1.Identity/Probe I0730 19:12:55.294295 1 utils.go:199] ID: 36 GRPC request: {} I0730 19:12:55.294320 1 utils.go:205] ID: 36 GRPC response: {} I0730 19:13:55.277705 1 utils.go:198] ID: 37 GRPC call: /csi.v1.Identity/Probe I0730 19:13:55.277771 1 utils.go:199] ID: 37 GRPC request: {} I0730 19:13:55.277804 1 utils.go:205] ID: 37 GRPC response: {} I0730 19:14:33.555819 1 utils.go:198] ID: 38 Req-ID: pvc-353badb2-f629-41ae-bcb6-a982e325b827 GRPC call: /csi.v1.Controller/CreateVolume I0730 19:14:33.556054 1 utils.go:199] ID: 38 Req-ID: pvc-353badb2-f629-41ae-bcb6-a982e325b827 GRPC request: {"capacity_range":{"required_bytes":10737418240},"name":"pvc-353badb2-f629-41ae-bcb6-a982e325b827","parameters":{"clusterID":"4837cbf8-4f90-4300-b3f6-726c9b9f89b4","csi.storage.k8s.io/pv/name":"pvc-353badb2-f629-41ae-bcb6-a982e325b827","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 19:14:33.556210 1 rbd_util.go:1315] ID: 38 Req-ID: pvc-353badb2-f629-41ae-bcb6-a982e325b827 setting disableInUseChecks: false image features: [layering] mounter: rbd I0730 19:14:33.558515 1 omap.go:89] ID: 38 Req-ID: pvc-353badb2-f629-41ae-bcb6-a982e325b827 got omap values: (pool="kube", namespace="", name="csi.volumes.default"): map[] I0730 19:14:33.577894 1 omap.go:159] ID: 38 Req-ID: pvc-353badb2-f629-41ae-bcb6-a982e325b827 set omap keys (pool="kube", namespace="", name="csi.volumes.default"): map[csi.volume.pvc-353badb2-f629-41ae-bcb6-a982e325b827:4106e1be-d597-4d72-b1ef-cc63d80ae8bb]) I0730 19:14:33.586028 1 omap.go:159] ID: 38 Req-ID: pvc-353badb2-f629-41ae-bcb6-a982e325b827 set omap keys (pool="kube", namespace="", name="csi.volume.4106e1be-d597-4d72-b1ef-cc63d80ae8bb"): map[csi.imagename:csi-vol-4106e1be-d597-4d72-b1ef-cc63d80ae8bb csi.volname:pvc-353badb2-f629-41ae-bcb6-a982e325b827 csi.volume.owner:openstack]) I0730 19:14:33.586087 1 rbd_journal.go:491] ID: 38 Req-ID: pvc-353badb2-f629-41ae-bcb6-a982e325b827 generated Volume ID (0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-4106e1be-d597-4d72-b1ef-cc63d80ae8bb) and image name (csi-vol-4106e1be-d597-4d72-b1ef-cc63d80ae8bb) for request name (pvc-353badb2-f629-41ae-bcb6-a982e325b827) I0730 19:14:33.586230 1 rbd_util.go:423] ID: 38 Req-ID: pvc-353badb2-f629-41ae-bcb6-a982e325b827 rbd: create kube/csi-vol-4106e1be-d597-4d72-b1ef-cc63d80ae8bb size 10240M (features: [layering]) using mon 10.96.240.200 I0730 19:14:33.586273 1 rbd_util.go:1563] ID: 38 Req-ID: pvc-353badb2-f629-41ae-bcb6-a982e325b827 setting image options on kube/csi-vol-4106e1be-d597-4d72-b1ef-cc63d80ae8bb I0730 19:14:33.616929 1 controllerserver.go:763] ID: 38 Req-ID: pvc-353badb2-f629-41ae-bcb6-a982e325b827 created image kube/csi-vol-4106e1be-d597-4d72-b1ef-cc63d80ae8bb backed for request name pvc-353badb2-f629-41ae-bcb6-a982e325b827 I0730 19:14:33.651528 1 omap.go:159] ID: 38 Req-ID: pvc-353badb2-f629-41ae-bcb6-a982e325b827 set omap keys (pool="kube", namespace="", name="csi.volume.4106e1be-d597-4d72-b1ef-cc63d80ae8bb"): map[csi.imageid:37c6ef65a63f]) I0730 19:14:33.746282 1 utils.go:205] ID: 38 Req-ID: pvc-353badb2-f629-41ae-bcb6-a982e325b827 GRPC response: {"volume":{"capacity_bytes":10737418240,"volume_context":{"clusterID":"4837cbf8-4f90-4300-b3f6-726c9b9f89b4","imageFeatures":"layering","imageName":"csi-vol-4106e1be-d597-4d72-b1ef-cc63d80ae8bb","journalPool":"kube","pool":"kube"},"volume_id":"0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-4106e1be-d597-4d72-b1ef-cc63d80ae8bb"}} I0730 19:14:55.289549 1 utils.go:198] ID: 39 GRPC call: /csi.v1.Identity/Probe I0730 19:14:55.289625 1 utils.go:199] ID: 39 GRPC request: {} I0730 19:14:55.289649 1 utils.go:205] ID: 39 GRPC response: {} I0730 19:15:55.234859 1 utils.go:198] ID: 40 GRPC call: /csi.v1.Identity/Probe I0730 19:15:55.234956 1 utils.go:199] ID: 40 GRPC request: {} I0730 19:15:55.235031 1 utils.go:205] ID: 40 GRPC response: {} I0730 19:16:55.289655 1 utils.go:198] ID: 41 GRPC call: /csi.v1.Identity/Probe I0730 19:16:55.289720 1 utils.go:199] ID: 41 GRPC request: {} I0730 19:16:55.289740 1 utils.go:205] ID: 41 GRPC response: {} I0730 19:17:55.234875 1 utils.go:198] ID: 42 GRPC call: /csi.v1.Identity/Probe I0730 19:17:55.234933 1 utils.go:199] ID: 42 GRPC request: {} I0730 19:17:55.234957 1 utils.go:205] ID: 42 GRPC response: {} I0730 19:18:55.234188 1 utils.go:198] ID: 43 GRPC call: /csi.v1.Identity/Probe I0730 19:18:55.234261 1 utils.go:199] ID: 43 GRPC request: {} I0730 19:18:55.234290 1 utils.go:205] ID: 43 GRPC response: {} I0730 19:19:55.244495 1 utils.go:198] ID: 44 GRPC call: /csi.v1.Identity/Probe I0730 19:19:55.244544 1 utils.go:199] ID: 44 GRPC request: {} I0730 19:19:55.244565 1 utils.go:205] ID: 44 GRPC response: {} I0730 19:20:55.247364 1 utils.go:198] ID: 45 GRPC call: /csi.v1.Identity/Probe I0730 19:20:55.247470 1 utils.go:199] ID: 45 GRPC request: {} I0730 19:20:55.247496 1 utils.go:205] ID: 45 GRPC response: {} I0730 19:21:48.329434 1 utils.go:198] ID: 46 Req-ID: pvc-f5f975b1-cc05-4e57-bfc3-98b24a5a0456 GRPC call: /csi.v1.Controller/CreateVolume I0730 19:21:48.329867 1 utils.go:199] ID: 46 Req-ID: pvc-f5f975b1-cc05-4e57-bfc3-98b24a5a0456 GRPC request: {"capacity_range":{"required_bytes":21474836480},"name":"pvc-f5f975b1-cc05-4e57-bfc3-98b24a5a0456","parameters":{"clusterID":"4837cbf8-4f90-4300-b3f6-726c9b9f89b4","csi.storage.k8s.io/pv/name":"pvc-f5f975b1-cc05-4e57-bfc3-98b24a5a0456","csi.storage.k8s.io/pvc/name":"data-ovn-ovsdb-nb-0","csi.storage.k8s.io/pvc/namespace":"openstack","imageFeatures":"layering","pool":"kube"},"secrets":"***stripped***","volume_capabilities":[{"AccessType":{"Mount":{"fs_type":"ext4","mount_flags":["discard"]}},"access_mode":{"mode":1}}]} I0730 19:21:48.330191 1 rbd_util.go:1315] ID: 46 Req-ID: pvc-f5f975b1-cc05-4e57-bfc3-98b24a5a0456 setting disableInUseChecks: false image features: [layering] mounter: rbd I0730 19:21:48.332265 1 omap.go:89] ID: 46 Req-ID: pvc-f5f975b1-cc05-4e57-bfc3-98b24a5a0456 got omap values: (pool="kube", namespace="", name="csi.volumes.default"): map[] I0730 19:21:48.337983 1 utils.go:198] ID: 47 Req-ID: pvc-dc2934f4-ea62-4b5b-bd16-9b9ae80a6840 GRPC call: /csi.v1.Controller/CreateVolume I0730 19:21:48.338386 1 utils.go:199] ID: 47 Req-ID: pvc-dc2934f4-ea62-4b5b-bd16-9b9ae80a6840 GRPC request: {"capacity_range":{"required_bytes":21474836480},"name":"pvc-dc2934f4-ea62-4b5b-bd16-9b9ae80a6840","parameters":{"clusterID":"4837cbf8-4f90-4300-b3f6-726c9b9f89b4","csi.storage.k8s.io/pv/name":"pvc-dc2934f4-ea62-4b5b-bd16-9b9ae80a6840","csi.storage.k8s.io/pvc/name":"data-ovn-ovsdb-sb-0","csi.storage.k8s.io/pvc/namespace":"openstack","imageFeatures":"layering","pool":"kube"},"secrets":"***stripped***","volume_capabilities":[{"AccessType":{"Mount":{"fs_type":"ext4","mount_flags":["discard"]}},"access_mode":{"mode":1}}]} I0730 19:21:48.338696 1 rbd_util.go:1315] ID: 47 Req-ID: pvc-dc2934f4-ea62-4b5b-bd16-9b9ae80a6840 setting disableInUseChecks: false image features: [layering] mounter: rbd I0730 19:21:48.345889 1 omap.go:89] ID: 47 Req-ID: pvc-dc2934f4-ea62-4b5b-bd16-9b9ae80a6840 got omap values: (pool="kube", namespace="", name="csi.volumes.default"): map[] I0730 19:21:48.353846 1 omap.go:159] ID: 46 Req-ID: pvc-f5f975b1-cc05-4e57-bfc3-98b24a5a0456 set omap keys (pool="kube", namespace="", name="csi.volumes.default"): map[csi.volume.pvc-f5f975b1-cc05-4e57-bfc3-98b24a5a0456:674fb6ca-a640-46a8-87d0-e9d2176122af]) I0730 19:21:48.365259 1 omap.go:159] ID: 46 Req-ID: pvc-f5f975b1-cc05-4e57-bfc3-98b24a5a0456 set omap keys (pool="kube", namespace="", name="csi.volume.674fb6ca-a640-46a8-87d0-e9d2176122af"): map[csi.imagename:csi-vol-674fb6ca-a640-46a8-87d0-e9d2176122af csi.volname:pvc-f5f975b1-cc05-4e57-bfc3-98b24a5a0456 csi.volume.owner:openstack]) I0730 19:21:48.365285 1 rbd_journal.go:491] ID: 46 Req-ID: pvc-f5f975b1-cc05-4e57-bfc3-98b24a5a0456 generated Volume ID (0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-674fb6ca-a640-46a8-87d0-e9d2176122af) and image name (csi-vol-674fb6ca-a640-46a8-87d0-e9d2176122af) for request name (pvc-f5f975b1-cc05-4e57-bfc3-98b24a5a0456) I0730 19:21:48.365369 1 rbd_util.go:423] ID: 46 Req-ID: pvc-f5f975b1-cc05-4e57-bfc3-98b24a5a0456 rbd: create kube/csi-vol-674fb6ca-a640-46a8-87d0-e9d2176122af size 20480M (features: [layering]) using mon 10.96.240.200 I0730 19:21:48.365392 1 rbd_util.go:1563] ID: 46 Req-ID: pvc-f5f975b1-cc05-4e57-bfc3-98b24a5a0456 setting image options on kube/csi-vol-674fb6ca-a640-46a8-87d0-e9d2176122af I0730 19:21:48.372488 1 omap.go:159] ID: 47 Req-ID: pvc-dc2934f4-ea62-4b5b-bd16-9b9ae80a6840 set omap keys (pool="kube", namespace="", name="csi.volumes.default"): map[csi.volume.pvc-dc2934f4-ea62-4b5b-bd16-9b9ae80a6840:da5f82ee-eb4b-4568-ae9d-f482801ee10b]) I0730 19:21:48.380506 1 omap.go:159] ID: 47 Req-ID: pvc-dc2934f4-ea62-4b5b-bd16-9b9ae80a6840 set omap keys (pool="kube", namespace="", name="csi.volume.da5f82ee-eb4b-4568-ae9d-f482801ee10b"): map[csi.imagename:csi-vol-da5f82ee-eb4b-4568-ae9d-f482801ee10b csi.volname:pvc-dc2934f4-ea62-4b5b-bd16-9b9ae80a6840 csi.volume.owner:openstack]) I0730 19:21:48.380540 1 rbd_journal.go:491] ID: 47 Req-ID: pvc-dc2934f4-ea62-4b5b-bd16-9b9ae80a6840 generated Volume ID (0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-da5f82ee-eb4b-4568-ae9d-f482801ee10b) and image name (csi-vol-da5f82ee-eb4b-4568-ae9d-f482801ee10b) for request name (pvc-dc2934f4-ea62-4b5b-bd16-9b9ae80a6840) I0730 19:21:48.380618 1 rbd_util.go:423] ID: 47 Req-ID: pvc-dc2934f4-ea62-4b5b-bd16-9b9ae80a6840 rbd: create kube/csi-vol-da5f82ee-eb4b-4568-ae9d-f482801ee10b size 20480M (features: [layering]) using mon 10.96.240.200 I0730 19:21:48.380643 1 rbd_util.go:1563] ID: 47 Req-ID: pvc-dc2934f4-ea62-4b5b-bd16-9b9ae80a6840 setting image options on kube/csi-vol-da5f82ee-eb4b-4568-ae9d-f482801ee10b I0730 19:21:48.416685 1 controllerserver.go:763] ID: 46 Req-ID: pvc-f5f975b1-cc05-4e57-bfc3-98b24a5a0456 created image kube/csi-vol-674fb6ca-a640-46a8-87d0-e9d2176122af backed for request name pvc-f5f975b1-cc05-4e57-bfc3-98b24a5a0456 I0730 19:21:48.422310 1 controllerserver.go:763] ID: 47 Req-ID: pvc-dc2934f4-ea62-4b5b-bd16-9b9ae80a6840 created image kube/csi-vol-da5f82ee-eb4b-4568-ae9d-f482801ee10b backed for request name pvc-dc2934f4-ea62-4b5b-bd16-9b9ae80a6840 I0730 19:21:48.461133 1 omap.go:159] ID: 46 Req-ID: pvc-f5f975b1-cc05-4e57-bfc3-98b24a5a0456 set omap keys (pool="kube", namespace="", name="csi.volume.674fb6ca-a640-46a8-87d0-e9d2176122af"): map[csi.imageid:37c6bc4e3248]) I0730 19:21:48.467698 1 omap.go:159] ID: 47 Req-ID: pvc-dc2934f4-ea62-4b5b-bd16-9b9ae80a6840 set omap keys (pool="kube", namespace="", name="csi.volume.da5f82ee-eb4b-4568-ae9d-f482801ee10b"): map[csi.imageid:37c61f08fd98]) I0730 19:21:48.586310 1 utils.go:205] ID: 46 Req-ID: pvc-f5f975b1-cc05-4e57-bfc3-98b24a5a0456 GRPC response: {"volume":{"capacity_bytes":21474836480,"volume_context":{"clusterID":"4837cbf8-4f90-4300-b3f6-726c9b9f89b4","imageFeatures":"layering","imageName":"csi-vol-674fb6ca-a640-46a8-87d0-e9d2176122af","journalPool":"kube","pool":"kube"},"volume_id":"0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-674fb6ca-a640-46a8-87d0-e9d2176122af"}} I0730 19:21:48.602610 1 utils.go:205] ID: 47 Req-ID: pvc-dc2934f4-ea62-4b5b-bd16-9b9ae80a6840 GRPC response: {"volume":{"capacity_bytes":21474836480,"volume_context":{"clusterID":"4837cbf8-4f90-4300-b3f6-726c9b9f89b4","imageFeatures":"layering","imageName":"csi-vol-da5f82ee-eb4b-4568-ae9d-f482801ee10b","journalPool":"kube","pool":"kube"},"volume_id":"0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-da5f82ee-eb4b-4568-ae9d-f482801ee10b"}} I0730 19:21:55.255907 1 utils.go:198] ID: 48 GRPC call: /csi.v1.Identity/Probe I0730 19:21:55.255973 1 utils.go:199] ID: 48 GRPC request: {} I0730 19:21:55.256000 1 utils.go:205] ID: 48 GRPC response: {} I0730 19:22:01.892009 1 utils.go:198] ID: 49 Req-ID: pvc-f80245f7-3330-4ffa-bf73-85f2697e9007 GRPC call: /csi.v1.Controller/CreateVolume I0730 19:22:01.892233 1 utils.go:199] ID: 49 Req-ID: pvc-f80245f7-3330-4ffa-bf73-85f2697e9007 GRPC request: {"capacity_range":{"required_bytes":10737418240},"name":"pvc-f80245f7-3330-4ffa-bf73-85f2697e9007","parameters":{"clusterID":"4837cbf8-4f90-4300-b3f6-726c9b9f89b4","csi.storage.k8s.io/pv/name":"pvc-f80245f7-3330-4ffa-bf73-85f2697e9007","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 19:22:01.892457 1 rbd_util.go:1315] ID: 49 Req-ID: pvc-f80245f7-3330-4ffa-bf73-85f2697e9007 setting disableInUseChecks: false image features: [layering] mounter: rbd I0730 19:22:01.894211 1 omap.go:89] ID: 49 Req-ID: pvc-f80245f7-3330-4ffa-bf73-85f2697e9007 got omap values: (pool="kube", namespace="", name="csi.volumes.default"): map[] I0730 19:22:01.933236 1 omap.go:159] ID: 49 Req-ID: pvc-f80245f7-3330-4ffa-bf73-85f2697e9007 set omap keys (pool="kube", namespace="", name="csi.volumes.default"): map[csi.volume.pvc-f80245f7-3330-4ffa-bf73-85f2697e9007:d69c7ebe-6d0e-47bb-a754-947e35b6852e]) I0730 19:22:01.951072 1 omap.go:159] ID: 49 Req-ID: pvc-f80245f7-3330-4ffa-bf73-85f2697e9007 set omap keys (pool="kube", namespace="", name="csi.volume.d69c7ebe-6d0e-47bb-a754-947e35b6852e"): map[csi.imagename:csi-vol-d69c7ebe-6d0e-47bb-a754-947e35b6852e csi.volname:pvc-f80245f7-3330-4ffa-bf73-85f2697e9007 csi.volume.owner:openstack]) I0730 19:22:01.951099 1 rbd_journal.go:491] ID: 49 Req-ID: pvc-f80245f7-3330-4ffa-bf73-85f2697e9007 generated Volume ID (0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-d69c7ebe-6d0e-47bb-a754-947e35b6852e) and image name (csi-vol-d69c7ebe-6d0e-47bb-a754-947e35b6852e) for request name (pvc-f80245f7-3330-4ffa-bf73-85f2697e9007) I0730 19:22:01.951181 1 rbd_util.go:423] ID: 49 Req-ID: pvc-f80245f7-3330-4ffa-bf73-85f2697e9007 rbd: create kube/csi-vol-d69c7ebe-6d0e-47bb-a754-947e35b6852e size 10240M (features: [layering]) using mon 10.96.240.200 I0730 19:22:01.951206 1 rbd_util.go:1563] ID: 49 Req-ID: pvc-f80245f7-3330-4ffa-bf73-85f2697e9007 setting image options on kube/csi-vol-d69c7ebe-6d0e-47bb-a754-947e35b6852e I0730 19:22:02.014828 1 controllerserver.go:763] ID: 49 Req-ID: pvc-f80245f7-3330-4ffa-bf73-85f2697e9007 created image kube/csi-vol-d69c7ebe-6d0e-47bb-a754-947e35b6852e backed for request name pvc-f80245f7-3330-4ffa-bf73-85f2697e9007 I0730 19:22:02.088120 1 omap.go:159] ID: 49 Req-ID: pvc-f80245f7-3330-4ffa-bf73-85f2697e9007 set omap keys (pool="kube", namespace="", name="csi.volume.d69c7ebe-6d0e-47bb-a754-947e35b6852e"): map[csi.imageid:37c6ebef9b61]) I0730 19:22:02.349293 1 utils.go:205] ID: 49 Req-ID: pvc-f80245f7-3330-4ffa-bf73-85f2697e9007 GRPC response: {"volume":{"capacity_bytes":10737418240,"volume_context":{"clusterID":"4837cbf8-4f90-4300-b3f6-726c9b9f89b4","imageFeatures":"layering","imageName":"csi-vol-d69c7ebe-6d0e-47bb-a754-947e35b6852e","journalPool":"kube","pool":"kube"},"volume_id":"0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-d69c7ebe-6d0e-47bb-a754-947e35b6852e"}} I0730 19:22:55.290575 1 utils.go:198] ID: 50 GRPC call: /csi.v1.Identity/Probe I0730 19:22:55.290719 1 utils.go:199] ID: 50 GRPC request: {} I0730 19:22:55.290780 1 utils.go:205] ID: 50 GRPC response: {} I0730 19:23:55.266120 1 utils.go:198] ID: 51 GRPC call: /csi.v1.Identity/Probe I0730 19:23:55.266176 1 utils.go:199] ID: 51 GRPC request: {} I0730 19:23:55.266210 1 utils.go:205] ID: 51 GRPC response: {} I0730 19:24:55.289702 1 utils.go:198] ID: 52 GRPC call: /csi.v1.Identity/Probe I0730 19:24:55.289760 1 utils.go:199] ID: 52 GRPC request: {} I0730 19:24:55.289785 1 utils.go:205] ID: 52 GRPC response: {} I0730 19:25:55.277334 1 utils.go:198] ID: 53 GRPC call: /csi.v1.Identity/Probe I0730 19:25:55.277528 1 utils.go:199] ID: 53 GRPC request: {} I0730 19:25:55.277562 1 utils.go:205] ID: 53 GRPC response: {} I0730 19:26:55.289701 1 utils.go:198] ID: 54 GRPC call: /csi.v1.Identity/Probe I0730 19:26:55.289757 1 utils.go:199] ID: 54 GRPC request: {} I0730 19:26:55.289782 1 utils.go:205] ID: 54 GRPC response: {} I0730 19:27:55.278549 1 utils.go:198] ID: 55 GRPC call: /csi.v1.Identity/Probe I0730 19:27:55.278600 1 utils.go:199] ID: 55 GRPC request: {} I0730 19:27:55.278619 1 utils.go:205] ID: 55 GRPC response: {} I0730 19:28:55.235443 1 utils.go:198] ID: 56 GRPC call: /csi.v1.Identity/Probe I0730 19:28:55.235500 1 utils.go:199] ID: 56 GRPC request: {} I0730 19:28:55.235522 1 utils.go:205] ID: 56 GRPC response: {} I0730 19:29:13.213446 1 utils.go:198] ID: 57 Req-ID: pvc-1820d47c-d963-4d9e-9ed7-78ee5ba31424 GRPC call: /csi.v1.Controller/CreateVolume I0730 19:29:13.213698 1 utils.go:199] ID: 57 Req-ID: pvc-1820d47c-d963-4d9e-9ed7-78ee5ba31424 GRPC request: {"capacity_range":{"required_bytes":10737418240},"name":"pvc-1820d47c-d963-4d9e-9ed7-78ee5ba31424","parameters":{"clusterID":"4837cbf8-4f90-4300-b3f6-726c9b9f89b4","csi.storage.k8s.io/pv/name":"pvc-1820d47c-d963-4d9e-9ed7-78ee5ba31424","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 19:29:13.213913 1 rbd_util.go:1315] ID: 57 Req-ID: pvc-1820d47c-d963-4d9e-9ed7-78ee5ba31424 setting disableInUseChecks: false image features: [layering] mounter: rbd I0730 19:29:13.216663 1 omap.go:89] ID: 57 Req-ID: pvc-1820d47c-d963-4d9e-9ed7-78ee5ba31424 got omap values: (pool="kube", namespace="", name="csi.volumes.default"): map[] I0730 19:29:13.230708 1 omap.go:159] ID: 57 Req-ID: pvc-1820d47c-d963-4d9e-9ed7-78ee5ba31424 set omap keys (pool="kube", namespace="", name="csi.volumes.default"): map[csi.volume.pvc-1820d47c-d963-4d9e-9ed7-78ee5ba31424:02325d24-b0d4-4e31-995d-92681d796f36]) I0730 19:29:13.241737 1 omap.go:159] ID: 57 Req-ID: pvc-1820d47c-d963-4d9e-9ed7-78ee5ba31424 set omap keys (pool="kube", namespace="", name="csi.volume.02325d24-b0d4-4e31-995d-92681d796f36"): map[csi.imagename:csi-vol-02325d24-b0d4-4e31-995d-92681d796f36 csi.volname:pvc-1820d47c-d963-4d9e-9ed7-78ee5ba31424 csi.volume.owner:openstack]) I0730 19:29:13.241777 1 rbd_journal.go:491] ID: 57 Req-ID: pvc-1820d47c-d963-4d9e-9ed7-78ee5ba31424 generated Volume ID (0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-02325d24-b0d4-4e31-995d-92681d796f36) and image name (csi-vol-02325d24-b0d4-4e31-995d-92681d796f36) for request name (pvc-1820d47c-d963-4d9e-9ed7-78ee5ba31424) I0730 19:29:13.241887 1 rbd_util.go:423] ID: 57 Req-ID: pvc-1820d47c-d963-4d9e-9ed7-78ee5ba31424 rbd: create kube/csi-vol-02325d24-b0d4-4e31-995d-92681d796f36 size 10240M (features: [layering]) using mon 10.96.240.200 I0730 19:29:13.241916 1 rbd_util.go:1563] ID: 57 Req-ID: pvc-1820d47c-d963-4d9e-9ed7-78ee5ba31424 setting image options on kube/csi-vol-02325d24-b0d4-4e31-995d-92681d796f36 I0730 19:29:13.279540 1 controllerserver.go:763] ID: 57 Req-ID: pvc-1820d47c-d963-4d9e-9ed7-78ee5ba31424 created image kube/csi-vol-02325d24-b0d4-4e31-995d-92681d796f36 backed for request name pvc-1820d47c-d963-4d9e-9ed7-78ee5ba31424 I0730 19:29:13.319057 1 omap.go:159] ID: 57 Req-ID: pvc-1820d47c-d963-4d9e-9ed7-78ee5ba31424 set omap keys (pool="kube", namespace="", name="csi.volume.02325d24-b0d4-4e31-995d-92681d796f36"): map[csi.imageid:37c6486e3a6f]) I0730 19:29:13.468027 1 utils.go:205] ID: 57 Req-ID: pvc-1820d47c-d963-4d9e-9ed7-78ee5ba31424 GRPC response: {"volume":{"capacity_bytes":10737418240,"volume_context":{"clusterID":"4837cbf8-4f90-4300-b3f6-726c9b9f89b4","imageFeatures":"layering","imageName":"csi-vol-02325d24-b0d4-4e31-995d-92681d796f36","journalPool":"kube","pool":"kube"},"volume_id":"0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-02325d24-b0d4-4e31-995d-92681d796f36"}} I0730 19:29:55.289798 1 utils.go:198] ID: 58 GRPC call: /csi.v1.Identity/Probe I0730 19:29:55.289891 1 utils.go:199] ID: 58 GRPC request: {} I0730 19:29:55.289914 1 utils.go:205] ID: 58 GRPC response: {} I0730 19:30:55.235626 1 utils.go:198] ID: 59 GRPC call: /csi.v1.Identity/Probe I0730 19:30:55.235734 1 utils.go:199] ID: 59 GRPC request: {} I0730 19:30:55.235904 1 utils.go:205] ID: 59 GRPC response: {} I0730 19:31:55.286375 1 utils.go:198] ID: 60 GRPC call: /csi.v1.Identity/Probe I0730 19:31:55.286433 1 utils.go:199] ID: 60 GRPC request: {} I0730 19:31:55.286456 1 utils.go:205] ID: 60 GRPC response: {} I0730 19:32:55.245254 1 utils.go:198] ID: 61 GRPC call: /csi.v1.Identity/Probe I0730 19:32:55.245315 1 utils.go:199] ID: 61 GRPC request: {} I0730 19:32:55.245342 1 utils.go:205] ID: 61 GRPC response: {} I0730 19:33:55.235498 1 utils.go:198] ID: 62 GRPC call: /csi.v1.Identity/Probe I0730 19:33:55.235545 1 utils.go:199] ID: 62 GRPC request: {} I0730 19:33:55.235604 1 utils.go:205] ID: 62 GRPC response: {} I0730 19:34:55.256536 1 utils.go:198] ID: 63 GRPC call: /csi.v1.Identity/Probe I0730 19:34:55.256614 1 utils.go:199] ID: 63 GRPC request: {} I0730 19:34:55.256665 1 utils.go:205] ID: 63 GRPC response: {} I0730 19:35:55.289695 1 utils.go:198] ID: 64 GRPC call: /csi.v1.Identity/Probe I0730 19:35:55.289737 1 utils.go:199] ID: 64 GRPC request: {} I0730 19:35:55.289755 1 utils.go:205] ID: 64 GRPC response: {} I0730 19:36:55.265546 1 utils.go:198] ID: 65 GRPC call: /csi.v1.Identity/Probe I0730 19:36:55.265626 1 utils.go:199] ID: 65 GRPC request: {} I0730 19:36:55.265658 1 utils.go:205] ID: 65 GRPC response: {} I0730 19:37:55.233764 1 utils.go:198] ID: 66 GRPC call: /csi.v1.Identity/Probe I0730 19:37:55.233808 1 utils.go:199] ID: 66 GRPC request: {} I0730 19:37:55.233823 1 utils.go:205] ID: 66 GRPC response: {} I0730 19:38:55.275286 1 utils.go:198] ID: 67 GRPC call: /csi.v1.Identity/Probe I0730 19:38:55.275348 1 utils.go:199] ID: 67 GRPC request: {} I0730 19:38:55.275372 1 utils.go:205] ID: 67 GRPC response: {} I0730 19:39:55.233735 1 utils.go:198] ID: 68 GRPC call: /csi.v1.Identity/Probe I0730 19:39:55.233788 1 utils.go:199] ID: 68 GRPC request: {} I0730 19:39:55.233811 1 utils.go:205] ID: 68 GRPC response: {} I0730 19:40:55.286443 1 utils.go:198] ID: 69 GRPC call: /csi.v1.Identity/Probe I0730 19:40:55.286500 1 utils.go:199] ID: 69 GRPC request: {} I0730 19:40:55.286521 1 utils.go:205] ID: 69 GRPC response: {} I0730 19:41:55.290923 1 utils.go:198] ID: 70 GRPC call: /csi.v1.Identity/Probe I0730 19:41:55.290979 1 utils.go:199] ID: 70 GRPC request: {} I0730 19:41:55.291002 1 utils.go:205] ID: 70 GRPC response: {} I0730 19:42:55.258649 1 utils.go:198] ID: 71 GRPC call: /csi.v1.Identity/Probe I0730 19:42:55.258700 1 utils.go:199] ID: 71 GRPC request: {} I0730 19:42:55.258729 1 utils.go:205] ID: 71 GRPC response: {} I0730 19:43:55.236928 1 utils.go:198] ID: 72 GRPC call: /csi.v1.Identity/Probe I0730 19:43:55.237162 1 utils.go:199] ID: 72 GRPC request: {} I0730 19:43:55.237318 1 utils.go:205] ID: 72 GRPC response: {} I0730 19:44:55.287994 1 utils.go:198] ID: 73 GRPC call: /csi.v1.Identity/Probe I0730 19:44:55.288082 1 utils.go:199] ID: 73 GRPC request: {} I0730 19:44:55.288110 1 utils.go:205] ID: 73 GRPC response: {} I0730 19:45:55.234710 1 utils.go:198] ID: 74 GRPC call: /csi.v1.Identity/Probe I0730 19:45:55.234776 1 utils.go:199] ID: 74 GRPC request: {} I0730 19:45:55.234800 1 utils.go:205] ID: 74 GRPC response: {} I0730 19:46:55.233866 1 utils.go:198] ID: 75 GRPC call: /csi.v1.Identity/Probe I0730 19:46:55.233923 1 utils.go:199] ID: 75 GRPC request: {} I0730 19:46:55.234144 1 utils.go:205] ID: 75 GRPC response: {} I0730 19:47:55.245874 1 utils.go:198] ID: 76 GRPC call: /csi.v1.Identity/Probe I0730 19:47:55.245929 1 utils.go:199] ID: 76 GRPC request: {} I0730 19:47:55.245962 1 utils.go:205] ID: 76 GRPC response: {} I0730 19:48:55.286594 1 utils.go:198] ID: 77 GRPC call: /csi.v1.Identity/Probe I0730 19:48:55.286662 1 utils.go:199] ID: 77 GRPC request: {} I0730 19:48:55.286691 1 utils.go:205] ID: 77 GRPC response: {} I0730 19:49:55.254427 1 utils.go:198] ID: 78 GRPC call: /csi.v1.Identity/Probe I0730 19:49:55.255231 1 utils.go:199] ID: 78 GRPC request: {} I0730 19:49:55.255311 1 utils.go:205] ID: 78 GRPC response: {} I0730 19:50:55.289570 1 utils.go:198] ID: 79 GRPC call: /csi.v1.Identity/Probe I0730 19:50:55.289614 1 utils.go:199] ID: 79 GRPC request: {} I0730 19:50:55.289630 1 utils.go:205] ID: 79 GRPC response: {} I0730 19:51:55.266655 1 utils.go:198] ID: 80 GRPC call: /csi.v1.Identity/Probe I0730 19:51:55.266706 1 utils.go:199] ID: 80 GRPC request: {} I0730 19:51:55.266754 1 utils.go:205] ID: 80 GRPC response: {}