I0729 14:07:15.851798 1 cephcsi.go:191] Driver version: v3.11.0 and Git version: bc24b5eca87626d690a29effa9d7420cc0154a7a I0729 14:07:15.851938 1 cephcsi.go:223] Starting driver type: rbd with name: rbd.csi.ceph.com I0729 14:07:15.851951 1 driver.go:95] Enabling controller service capability: CREATE_DELETE_VOLUME I0729 14:07:15.851955 1 driver.go:95] Enabling controller service capability: CREATE_DELETE_SNAPSHOT I0729 14:07:15.851958 1 driver.go:95] Enabling controller service capability: CLONE_VOLUME I0729 14:07:15.851962 1 driver.go:95] Enabling controller service capability: EXPAND_VOLUME I0729 14:07:15.851965 1 driver.go:108] Enabling volume access mode: SINGLE_NODE_WRITER I0729 14:07:15.851968 1 driver.go:108] Enabling volume access mode: MULTI_NODE_MULTI_WRITER I0729 14:07:15.851970 1 driver.go:108] Enabling volume access mode: SINGLE_NODE_SINGLE_WRITER I0729 14:07:15.851973 1 driver.go:108] Enabling volume access mode: SINGLE_NODE_MULTI_WRITER I0729 14:07:15.852237 1 server.go:117] Listening for connections on address: &net.UnixAddr{Name:"//csi/csi-provisioner.sock", Net:"unix"} I0729 14:07:15.852293 1 server.go:114] listening for CSI-Addons requests on address: &net.UnixAddr{Name:"/csi/csi-addons.sock", Net:"unix"} I0729 14:07:23.072909 1 utils.go:198] ID: 1 GRPC call: /csi.v1.Identity/Probe I0729 14:07:23.074696 1 utils.go:199] ID: 1 GRPC request: {} I0729 14:07:23.074756 1 utils.go:205] ID: 1 GRPC response: {} I0729 14:07:23.077852 1 utils.go:198] ID: 2 GRPC call: /csi.v1.Identity/GetPluginInfo I0729 14:07:23.077911 1 utils.go:199] ID: 2 GRPC request: {} I0729 14:07:23.077925 1 identityserver-default.go:40] ID: 2 Using default GetPluginInfo I0729 14:07:23.078057 1 utils.go:205] ID: 2 GRPC response: {"name":"rbd.csi.ceph.com","vendor_version":"v3.11.0"} I0729 14:07:23.080752 1 utils.go:198] ID: 3 GRPC call: /csi.v1.Identity/Probe I0729 14:07:23.080819 1 utils.go:199] ID: 3 GRPC request: {} I0729 14:07:23.080848 1 utils.go:205] ID: 3 GRPC response: {} I0729 14:07:23.081302 1 utils.go:198] ID: 4 GRPC call: /csi.v1.Identity/GetPluginCapabilities I0729 14:07:23.081485 1 utils.go:199] ID: 4 GRPC request: {} I0729 14:07:23.081771 1 utils.go:205] ID: 4 GRPC response: {"capabilities":[{"Type":{"Service":{"type":1}}},{"Type":{"VolumeExpansion":{"type":1}}},{"Type":{"Service":{"type":2}}}]} I0729 14:07:23.082675 1 utils.go:198] ID: 5 GRPC call: /csi.v1.Controller/ControllerGetCapabilities I0729 14:07:23.082721 1 utils.go:199] ID: 5 GRPC request: {} I0729 14:07:23.082840 1 controllerserver-default.go:42] ID: 5 Using default ControllerGetCapabilities I0729 14:07:23.083073 1 utils.go:205] ID: 5 GRPC response: {"capabilities":[{"Type":{"Rpc":{"type":1}}},{"Type":{"Rpc":{"type":5}}},{"Type":{"Rpc":{"type":7}}},{"Type":{"Rpc":{"type":9}}}]} I0729 14:07:24.690966 1 utils.go:198] ID: 6 GRPC call: /csi.v1.Identity/Probe I0729 14:07:24.691441 1 utils.go:199] ID: 6 GRPC request: {} I0729 14:07:24.691522 1 utils.go:205] ID: 6 GRPC response: {} I0729 14:07:24.699356 1 utils.go:198] ID: 7 GRPC call: /csi.v1.Identity/GetPluginInfo I0729 14:07:24.699408 1 utils.go:199] ID: 7 GRPC request: {} I0729 14:07:24.699420 1 identityserver-default.go:40] ID: 7 Using default GetPluginInfo I0729 14:07:24.699458 1 utils.go:205] ID: 7 GRPC response: {"name":"rbd.csi.ceph.com","vendor_version":"v3.11.0"} I0729 14:07:24.701877 1 utils.go:198] ID: 8 GRPC call: /csi.v1.Identity/Probe I0729 14:07:24.701933 1 utils.go:199] ID: 8 GRPC request: {} I0729 14:07:24.701959 1 utils.go:205] ID: 8 GRPC response: {} I0729 14:07:24.702830 1 utils.go:198] ID: 9 GRPC call: /csi.v1.Identity/GetPluginCapabilities I0729 14:07:24.702896 1 utils.go:199] ID: 9 GRPC request: {} I0729 14:07:24.703144 1 utils.go:205] ID: 9 GRPC response: {"capabilities":[{"Type":{"Service":{"type":1}}},{"Type":{"VolumeExpansion":{"type":1}}},{"Type":{"Service":{"type":2}}}]} I0729 14:07:24.704130 1 utils.go:198] ID: 10 GRPC call: /csi.v1.Controller/ControllerGetCapabilities I0729 14:07:24.704166 1 utils.go:199] ID: 10 GRPC request: {} I0729 14:07:24.704177 1 controllerserver-default.go:42] ID: 10 Using default ControllerGetCapabilities I0729 14:07:24.704321 1 utils.go:205] ID: 10 GRPC response: {"capabilities":[{"Type":{"Rpc":{"type":1}}},{"Type":{"Rpc":{"type":5}}},{"Type":{"Rpc":{"type":7}}},{"Type":{"Rpc":{"type":9}}}]} I0729 14:07:24.704988 1 utils.go:198] ID: 11 GRPC call: /csi.v1.Controller/ControllerGetCapabilities I0729 14:07:24.705021 1 utils.go:199] ID: 11 GRPC request: {} I0729 14:07:24.705067 1 controllerserver-default.go:42] ID: 11 Using default ControllerGetCapabilities I0729 14:07:24.705237 1 utils.go:205] ID: 11 GRPC response: {"capabilities":[{"Type":{"Rpc":{"type":1}}},{"Type":{"Rpc":{"type":5}}},{"Type":{"Rpc":{"type":7}}},{"Type":{"Rpc":{"type":9}}}]} I0729 14:07:24.705727 1 utils.go:198] ID: 12 GRPC call: /csi.v1.Controller/ControllerGetCapabilities I0729 14:07:24.705749 1 utils.go:199] ID: 12 GRPC request: {} I0729 14:07:24.705757 1 controllerserver-default.go:42] ID: 12 Using default ControllerGetCapabilities I0729 14:07:24.705825 1 utils.go:205] ID: 12 GRPC response: {"capabilities":[{"Type":{"Rpc":{"type":1}}},{"Type":{"Rpc":{"type":5}}},{"Type":{"Rpc":{"type":7}}},{"Type":{"Rpc":{"type":9}}}]} I0729 14:07:30.645664 1 utils.go:198] ID: 13 GRPC call: /csi.v1.Identity/GetPluginInfo I0729 14:07:30.645710 1 utils.go:199] ID: 13 GRPC request: {} I0729 14:07:30.645721 1 identityserver-default.go:40] ID: 13 Using default GetPluginInfo I0729 14:07:30.645753 1 utils.go:205] ID: 13 GRPC response: {"name":"rbd.csi.ceph.com","vendor_version":"v3.11.0"} I0729 14:07:30.648984 1 utils.go:198] ID: 14 GRPC call: /csi.v1.Identity/Probe I0729 14:07:30.649023 1 utils.go:199] ID: 14 GRPC request: {} I0729 14:07:30.649040 1 utils.go:205] ID: 14 GRPC response: {} I0729 14:07:30.649677 1 utils.go:198] ID: 15 GRPC call: /csi.v1.Controller/ControllerGetCapabilities I0729 14:07:30.649712 1 utils.go:199] ID: 15 GRPC request: {} I0729 14:07:30.649722 1 controllerserver-default.go:42] ID: 15 Using default ControllerGetCapabilities I0729 14:07:30.649825 1 utils.go:205] ID: 15 GRPC response: {"capabilities":[{"Type":{"Rpc":{"type":1}}},{"Type":{"Rpc":{"type":5}}},{"Type":{"Rpc":{"type":7}}},{"Type":{"Rpc":{"type":9}}}]} I0729 14:07:32.871422 1 utils.go:198] ID: 16 GRPC call: /csi.v1.Identity/Probe I0729 14:07:32.871477 1 utils.go:199] ID: 16 GRPC request: {} I0729 14:07:32.871506 1 utils.go:205] ID: 16 GRPC response: {} I0729 14:07:32.873606 1 utils.go:198] ID: 17 GRPC call: /csi.v1.Identity/GetPluginInfo I0729 14:07:32.873660 1 utils.go:199] ID: 17 GRPC request: {} I0729 14:07:32.873674 1 identityserver-default.go:40] ID: 17 Using default GetPluginInfo I0729 14:07:32.873847 1 utils.go:205] ID: 17 GRPC response: {"name":"rbd.csi.ceph.com","vendor_version":"v3.11.0"} I0729 14:07:32.876212 1 utils.go:198] ID: 18 GRPC call: /csi.v1.Identity/Probe I0729 14:07:32.876244 1 utils.go:199] ID: 18 GRPC request: {} I0729 14:07:32.876262 1 utils.go:205] ID: 18 GRPC response: {} I0729 14:07:32.876825 1 utils.go:198] ID: 19 GRPC call: /csi.v1.Identity/GetPluginCapabilities I0729 14:07:32.876889 1 utils.go:199] ID: 19 GRPC request: {} I0729 14:07:32.877072 1 utils.go:205] ID: 19 GRPC response: {"capabilities":[{"Type":{"Service":{"type":1}}},{"Type":{"VolumeExpansion":{"type":1}}},{"Type":{"Service":{"type":2}}}]} I0729 14:07:32.877706 1 utils.go:198] ID: 20 GRPC call: /csi.v1.Controller/ControllerGetCapabilities I0729 14:07:32.877743 1 utils.go:199] ID: 20 GRPC request: {} I0729 14:07:32.877753 1 controllerserver-default.go:42] ID: 20 Using default ControllerGetCapabilities I0729 14:07:32.877833 1 utils.go:205] ID: 20 GRPC response: {"capabilities":[{"Type":{"Rpc":{"type":1}}},{"Type":{"Rpc":{"type":5}}},{"Type":{"Rpc":{"type":7}}},{"Type":{"Rpc":{"type":9}}}]} I0729 14:08:14.960166 1 utils.go:198] ID: 21 Req-ID: pvc-a0670b7b-1660-4e9e-ae09-127fc78e02b4 GRPC call: /csi.v1.Controller/CreateVolume I0729 14:08:14.961323 1 utils.go:199] ID: 21 Req-ID: pvc-a0670b7b-1660-4e9e-ae09-127fc78e02b4 GRPC request: {"capacity_range":{"required_bytes":171798691840},"name":"pvc-a0670b7b-1660-4e9e-ae09-127fc78e02b4","parameters":{"clusterID":"4837cbf8-4f90-4300-b3f6-726c9b9f89b4","csi.storage.k8s.io/pv/name":"pvc-a0670b7b-1660-4e9e-ae09-127fc78e02b4","csi.storage.k8s.io/pvc/name":"datadir-percona-xtradb-pxc-0","csi.storage.k8s.io/pvc/namespace":"openstack","imageFeatures":"layering","pool":"kube"},"secrets":"***stripped***","volume_capabilities":[{"AccessType":{"Mount":{"fs_type":"ext4","mount_flags":["discard"]}},"access_mode":{"mode":1}}]} I0729 14:08:14.962050 1 rbd_util.go:1315] ID: 21 Req-ID: pvc-a0670b7b-1660-4e9e-ae09-127fc78e02b4 setting disableInUseChecks: false image features: [layering] mounter: rbd E0729 14:08:14.981031 1 omap.go:80] ID: 21 Req-ID: pvc-a0670b7b-1660-4e9e-ae09-127fc78e02b4 omap not found (pool="kube", namespace="", name="csi.volumes.default"): rados: ret=-2, No such file or directory I0729 14:08:14.998155 1 omap.go:159] ID: 21 Req-ID: pvc-a0670b7b-1660-4e9e-ae09-127fc78e02b4 set omap keys (pool="kube", namespace="", name="csi.volumes.default"): map[csi.volume.pvc-a0670b7b-1660-4e9e-ae09-127fc78e02b4:b36851a8-3af1-48b5-9f64-c62d49f13aed]) I0729 14:08:15.004505 1 omap.go:159] ID: 21 Req-ID: pvc-a0670b7b-1660-4e9e-ae09-127fc78e02b4 set omap keys (pool="kube", namespace="", name="csi.volume.b36851a8-3af1-48b5-9f64-c62d49f13aed"): map[csi.imagename:csi-vol-b36851a8-3af1-48b5-9f64-c62d49f13aed csi.volname:pvc-a0670b7b-1660-4e9e-ae09-127fc78e02b4 csi.volume.owner:openstack]) I0729 14:08:15.004562 1 rbd_journal.go:491] ID: 21 Req-ID: pvc-a0670b7b-1660-4e9e-ae09-127fc78e02b4 generated Volume ID (0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-b36851a8-3af1-48b5-9f64-c62d49f13aed) and image name (csi-vol-b36851a8-3af1-48b5-9f64-c62d49f13aed) for request name (pvc-a0670b7b-1660-4e9e-ae09-127fc78e02b4) I0729 14:08:15.004663 1 rbd_util.go:423] ID: 21 Req-ID: pvc-a0670b7b-1660-4e9e-ae09-127fc78e02b4 rbd: create kube/csi-vol-b36851a8-3af1-48b5-9f64-c62d49f13aed size 163840M (features: [layering]) using mon 10.96.240.200 I0729 14:08:15.004737 1 rbd_util.go:1563] ID: 21 Req-ID: pvc-a0670b7b-1660-4e9e-ae09-127fc78e02b4 setting image options on kube/csi-vol-b36851a8-3af1-48b5-9f64-c62d49f13aed I0729 14:08:15.040785 1 controllerserver.go:763] ID: 21 Req-ID: pvc-a0670b7b-1660-4e9e-ae09-127fc78e02b4 created image kube/csi-vol-b36851a8-3af1-48b5-9f64-c62d49f13aed backed for request name pvc-a0670b7b-1660-4e9e-ae09-127fc78e02b4 I0729 14:08:15.075803 1 omap.go:159] ID: 21 Req-ID: pvc-a0670b7b-1660-4e9e-ae09-127fc78e02b4 set omap keys (pool="kube", namespace="", name="csi.volume.b36851a8-3af1-48b5-9f64-c62d49f13aed"): map[csi.imageid:37c65dba4dbc]) I0729 14:08:15.187816 1 utils.go:205] ID: 21 Req-ID: pvc-a0670b7b-1660-4e9e-ae09-127fc78e02b4 GRPC response: {"volume":{"capacity_bytes":171798691840,"volume_context":{"clusterID":"4837cbf8-4f90-4300-b3f6-726c9b9f89b4","imageFeatures":"layering","imageName":"csi-vol-b36851a8-3af1-48b5-9f64-c62d49f13aed","journalPool":"kube","pool":"kube"},"volume_id":"0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-b36851a8-3af1-48b5-9f64-c62d49f13aed"}} I0729 14:08:33.128658 1 utils.go:198] ID: 22 GRPC call: /csi.v1.Identity/Probe I0729 14:08:33.128731 1 utils.go:199] ID: 22 GRPC request: {} I0729 14:08:33.128754 1 utils.go:205] ID: 22 GRPC response: {} I0729 14:09:33.073090 1 utils.go:198] ID: 23 GRPC call: /csi.v1.Identity/Probe I0729 14:09:33.073194 1 utils.go:199] ID: 23 GRPC request: {} I0729 14:09:33.073251 1 utils.go:205] ID: 23 GRPC response: {} I0729 14:10:33.069582 1 utils.go:198] ID: 24 GRPC call: /csi.v1.Identity/Probe I0729 14:10:33.069637 1 utils.go:199] ID: 24 GRPC request: {} I0729 14:10:33.069658 1 utils.go:205] ID: 24 GRPC response: {} I0729 14:11:33.889057 1 utils.go:198] ID: 25 GRPC call: /csi.v1.Identity/Probe I0729 14:11:33.889983 1 utils.go:199] ID: 25 GRPC request: {} I0729 14:11:33.890086 1 utils.go:205] ID: 25 GRPC response: {} I0729 14:12:33.070013 1 utils.go:198] ID: 26 GRPC call: /csi.v1.Identity/Probe I0729 14:12:33.070049 1 utils.go:199] ID: 26 GRPC request: {} I0729 14:12:33.070061 1 utils.go:205] ID: 26 GRPC response: {} I0729 14:13:33.124615 1 utils.go:198] ID: 27 GRPC call: /csi.v1.Identity/Probe I0729 14:13:33.124673 1 utils.go:199] ID: 27 GRPC request: {} I0729 14:13:33.124690 1 utils.go:205] ID: 27 GRPC response: {} I0729 14:14:33.069693 1 utils.go:198] ID: 28 GRPC call: /csi.v1.Identity/Probe I0729 14:14:33.069760 1 utils.go:199] ID: 28 GRPC request: {} I0729 14:14:33.069777 1 utils.go:205] ID: 28 GRPC response: {} I0729 14:15:33.127502 1 utils.go:198] ID: 29 GRPC call: /csi.v1.Identity/Probe I0729 14:15:33.127553 1 utils.go:199] ID: 29 GRPC request: {} I0729 14:15:33.127576 1 utils.go:205] ID: 29 GRPC response: {} I0729 14:16:33.070743 1 utils.go:198] ID: 30 GRPC call: /csi.v1.Identity/Probe I0729 14:16:33.070831 1 utils.go:199] ID: 30 GRPC request: {} I0729 14:16:33.070867 1 utils.go:205] ID: 30 GRPC response: {} I0729 14:17:33.124399 1 utils.go:198] ID: 31 GRPC call: /csi.v1.Identity/Probe I0729 14:17:33.124499 1 utils.go:199] ID: 31 GRPC request: {} I0729 14:17:33.124523 1 utils.go:205] ID: 31 GRPC response: {} I0729 14:18:33.081947 1 utils.go:198] ID: 32 GRPC call: /csi.v1.Identity/Probe I0729 14:18:33.082028 1 utils.go:199] ID: 32 GRPC request: {} I0729 14:18:33.082063 1 utils.go:205] ID: 32 GRPC response: {} I0729 14:19:33.096833 1 utils.go:198] ID: 33 GRPC call: /csi.v1.Identity/Probe I0729 14:19:33.096871 1 utils.go:199] ID: 33 GRPC request: {} I0729 14:19:33.096882 1 utils.go:205] ID: 33 GRPC response: {} I0729 14:19:36.149467 1 utils.go:198] ID: 34 Req-ID: pvc-280c4f7e-8344-4b06-823d-f73d7148f729 GRPC call: /csi.v1.Controller/CreateVolume I0729 14:19:36.149756 1 utils.go:199] ID: 34 Req-ID: pvc-280c4f7e-8344-4b06-823d-f73d7148f729 GRPC request: {"capacity_range":{"required_bytes":10737418240},"name":"pvc-280c4f7e-8344-4b06-823d-f73d7148f729","parameters":{"clusterID":"4837cbf8-4f90-4300-b3f6-726c9b9f89b4","csi.storage.k8s.io/pv/name":"pvc-280c4f7e-8344-4b06-823d-f73d7148f729","csi.storage.k8s.io/pvc/name":"persistence-rabbitmq-keystone-server-0","csi.storage.k8s.io/pvc/namespace":"openstack","imageFeatures":"layering","pool":"kube"},"secrets":"***stripped***","volume_capabilities":[{"AccessType":{"Mount":{"fs_type":"ext4","mount_flags":["discard"]}},"access_mode":{"mode":1}}]} I0729 14:19:36.149962 1 rbd_util.go:1315] ID: 34 Req-ID: pvc-280c4f7e-8344-4b06-823d-f73d7148f729 setting disableInUseChecks: false image features: [layering] mounter: rbd I0729 14:19:36.155847 1 omap.go:89] ID: 34 Req-ID: pvc-280c4f7e-8344-4b06-823d-f73d7148f729 got omap values: (pool="kube", namespace="", name="csi.volumes.default"): map[] I0729 14:19:36.170419 1 omap.go:159] ID: 34 Req-ID: pvc-280c4f7e-8344-4b06-823d-f73d7148f729 set omap keys (pool="kube", namespace="", name="csi.volumes.default"): map[csi.volume.pvc-280c4f7e-8344-4b06-823d-f73d7148f729:83a79c47-faab-4a30-8158-f0f9ba55c456]) I0729 14:19:36.176181 1 omap.go:159] ID: 34 Req-ID: pvc-280c4f7e-8344-4b06-823d-f73d7148f729 set omap keys (pool="kube", namespace="", name="csi.volume.83a79c47-faab-4a30-8158-f0f9ba55c456"): map[csi.imagename:csi-vol-83a79c47-faab-4a30-8158-f0f9ba55c456 csi.volname:pvc-280c4f7e-8344-4b06-823d-f73d7148f729 csi.volume.owner:openstack]) I0729 14:19:36.176208 1 rbd_journal.go:491] ID: 34 Req-ID: pvc-280c4f7e-8344-4b06-823d-f73d7148f729 generated Volume ID (0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-83a79c47-faab-4a30-8158-f0f9ba55c456) and image name (csi-vol-83a79c47-faab-4a30-8158-f0f9ba55c456) for request name (pvc-280c4f7e-8344-4b06-823d-f73d7148f729) I0729 14:19:36.176295 1 rbd_util.go:423] ID: 34 Req-ID: pvc-280c4f7e-8344-4b06-823d-f73d7148f729 rbd: create kube/csi-vol-83a79c47-faab-4a30-8158-f0f9ba55c456 size 10240M (features: [layering]) using mon 10.96.240.200 I0729 14:19:36.176333 1 rbd_util.go:1563] ID: 34 Req-ID: pvc-280c4f7e-8344-4b06-823d-f73d7148f729 setting image options on kube/csi-vol-83a79c47-faab-4a30-8158-f0f9ba55c456 I0729 14:19:36.205520 1 controllerserver.go:763] ID: 34 Req-ID: pvc-280c4f7e-8344-4b06-823d-f73d7148f729 created image kube/csi-vol-83a79c47-faab-4a30-8158-f0f9ba55c456 backed for request name pvc-280c4f7e-8344-4b06-823d-f73d7148f729 I0729 14:19:36.235124 1 omap.go:159] ID: 34 Req-ID: pvc-280c4f7e-8344-4b06-823d-f73d7148f729 set omap keys (pool="kube", namespace="", name="csi.volume.83a79c47-faab-4a30-8158-f0f9ba55c456"): map[csi.imageid:37c698ca8aae]) I0729 14:19:36.334089 1 utils.go:205] ID: 34 Req-ID: pvc-280c4f7e-8344-4b06-823d-f73d7148f729 GRPC response: {"volume":{"capacity_bytes":10737418240,"volume_context":{"clusterID":"4837cbf8-4f90-4300-b3f6-726c9b9f89b4","imageFeatures":"layering","imageName":"csi-vol-83a79c47-faab-4a30-8158-f0f9ba55c456","journalPool":"kube","pool":"kube"},"volume_id":"0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-83a79c47-faab-4a30-8158-f0f9ba55c456"}} I0729 14:20:33.094718 1 utils.go:198] ID: 35 GRPC call: /csi.v1.Identity/Probe I0729 14:20:33.094785 1 utils.go:199] ID: 35 GRPC request: {} I0729 14:20:33.094812 1 utils.go:205] ID: 35 GRPC response: {} I0729 14:21:33.123522 1 utils.go:198] ID: 36 GRPC call: /csi.v1.Identity/Probe I0729 14:21:33.123577 1 utils.go:199] ID: 36 GRPC request: {} I0729 14:21:33.123600 1 utils.go:205] ID: 36 GRPC response: {} I0729 14:22:33.103960 1 utils.go:198] ID: 37 GRPC call: /csi.v1.Identity/Probe I0729 14:22:33.104036 1 utils.go:199] ID: 37 GRPC request: {} I0729 14:22:33.104087 1 utils.go:205] ID: 37 GRPC response: {} I0729 14:23:33.120437 1 utils.go:198] ID: 38 GRPC call: /csi.v1.Identity/Probe I0729 14:23:33.120573 1 utils.go:199] ID: 38 GRPC request: {} I0729 14:23:33.120597 1 utils.go:205] ID: 38 GRPC response: {} I0729 14:23:42.179237 1 utils.go:198] ID: 39 Req-ID: pvc-9898ece1-85a0-4087-8dbe-fb8287913980 GRPC call: /csi.v1.Controller/CreateVolume I0729 14:23:42.179470 1 utils.go:199] ID: 39 Req-ID: pvc-9898ece1-85a0-4087-8dbe-fb8287913980 GRPC request: {"capacity_range":{"required_bytes":10737418240},"name":"pvc-9898ece1-85a0-4087-8dbe-fb8287913980","parameters":{"clusterID":"4837cbf8-4f90-4300-b3f6-726c9b9f89b4","csi.storage.k8s.io/pv/name":"pvc-9898ece1-85a0-4087-8dbe-fb8287913980","csi.storage.k8s.io/pvc/name":"persistence-rabbitmq-glance-server-0","csi.storage.k8s.io/pvc/namespace":"openstack","imageFeatures":"layering","pool":"kube"},"secrets":"***stripped***","volume_capabilities":[{"AccessType":{"Mount":{"fs_type":"ext4","mount_flags":["discard"]}},"access_mode":{"mode":1}}]} I0729 14:23:42.179712 1 rbd_util.go:1315] ID: 39 Req-ID: pvc-9898ece1-85a0-4087-8dbe-fb8287913980 setting disableInUseChecks: false image features: [layering] mounter: rbd I0729 14:23:42.181278 1 omap.go:89] ID: 39 Req-ID: pvc-9898ece1-85a0-4087-8dbe-fb8287913980 got omap values: (pool="kube", namespace="", name="csi.volumes.default"): map[] I0729 14:23:42.194971 1 omap.go:159] ID: 39 Req-ID: pvc-9898ece1-85a0-4087-8dbe-fb8287913980 set omap keys (pool="kube", namespace="", name="csi.volumes.default"): map[csi.volume.pvc-9898ece1-85a0-4087-8dbe-fb8287913980:121390c5-a1e8-4635-8ef9-6e862f205163]) I0729 14:23:42.202975 1 omap.go:159] ID: 39 Req-ID: pvc-9898ece1-85a0-4087-8dbe-fb8287913980 set omap keys (pool="kube", namespace="", name="csi.volume.121390c5-a1e8-4635-8ef9-6e862f205163"): map[csi.imagename:csi-vol-121390c5-a1e8-4635-8ef9-6e862f205163 csi.volname:pvc-9898ece1-85a0-4087-8dbe-fb8287913980 csi.volume.owner:openstack]) I0729 14:23:42.203048 1 rbd_journal.go:491] ID: 39 Req-ID: pvc-9898ece1-85a0-4087-8dbe-fb8287913980 generated Volume ID (0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-121390c5-a1e8-4635-8ef9-6e862f205163) and image name (csi-vol-121390c5-a1e8-4635-8ef9-6e862f205163) for request name (pvc-9898ece1-85a0-4087-8dbe-fb8287913980) I0729 14:23:42.203192 1 rbd_util.go:423] ID: 39 Req-ID: pvc-9898ece1-85a0-4087-8dbe-fb8287913980 rbd: create kube/csi-vol-121390c5-a1e8-4635-8ef9-6e862f205163 size 10240M (features: [layering]) using mon 10.96.240.200 I0729 14:23:42.203288 1 rbd_util.go:1563] ID: 39 Req-ID: pvc-9898ece1-85a0-4087-8dbe-fb8287913980 setting image options on kube/csi-vol-121390c5-a1e8-4635-8ef9-6e862f205163 I0729 14:23:42.233068 1 controllerserver.go:763] ID: 39 Req-ID: pvc-9898ece1-85a0-4087-8dbe-fb8287913980 created image kube/csi-vol-121390c5-a1e8-4635-8ef9-6e862f205163 backed for request name pvc-9898ece1-85a0-4087-8dbe-fb8287913980 I0729 14:23:42.266527 1 omap.go:159] ID: 39 Req-ID: pvc-9898ece1-85a0-4087-8dbe-fb8287913980 set omap keys (pool="kube", namespace="", name="csi.volume.121390c5-a1e8-4635-8ef9-6e862f205163"): map[csi.imageid:37c660ec58a2]) I0729 14:23:42.365004 1 utils.go:205] ID: 39 Req-ID: pvc-9898ece1-85a0-4087-8dbe-fb8287913980 GRPC response: {"volume":{"capacity_bytes":10737418240,"volume_context":{"clusterID":"4837cbf8-4f90-4300-b3f6-726c9b9f89b4","imageFeatures":"layering","imageName":"csi-vol-121390c5-a1e8-4635-8ef9-6e862f205163","journalPool":"kube","pool":"kube"},"volume_id":"0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-121390c5-a1e8-4635-8ef9-6e862f205163"}} I0729 14:24:33.102710 1 utils.go:198] ID: 40 GRPC call: /csi.v1.Identity/Probe I0729 14:24:33.102766 1 utils.go:199] ID: 40 GRPC request: {} I0729 14:24:33.102803 1 utils.go:205] ID: 40 GRPC response: {} I0729 14:25:33.105728 1 utils.go:198] ID: 41 GRPC call: /csi.v1.Identity/Probe I0729 14:25:33.105780 1 utils.go:199] ID: 41 GRPC request: {} I0729 14:25:33.105800 1 utils.go:205] ID: 41 GRPC response: {} I0729 14:26:33.110543 1 utils.go:198] ID: 42 GRPC call: /csi.v1.Identity/Probe I0729 14:26:33.110598 1 utils.go:199] ID: 42 GRPC request: {} I0729 14:26:33.110620 1 utils.go:205] ID: 42 GRPC response: {} I0729 14:26:48.767993 1 utils.go:198] ID: 43 GRPC call: /csi.v1.Identity/Probe I0729 14:26:48.768042 1 utils.go:199] ID: 43 GRPC request: {} I0729 14:26:48.768063 1 utils.go:205] ID: 43 GRPC response: {} I0729 14:26:48.771991 1 utils.go:198] ID: 44 GRPC call: /csi.v1.Identity/GetPluginInfo I0729 14:26:48.772016 1 utils.go:199] ID: 44 GRPC request: {} I0729 14:26:48.772024 1 identityserver-default.go:40] ID: 44 Using default GetPluginInfo I0729 14:26:48.772048 1 utils.go:205] ID: 44 GRPC response: {"name":"rbd.csi.ceph.com","vendor_version":"v3.11.0"} I0729 14:26:48.775834 1 utils.go:198] ID: 45 GRPC call: /csi.v1.Identity/Probe I0729 14:26:48.775857 1 utils.go:199] ID: 45 GRPC request: {} I0729 14:26:48.775879 1 utils.go:205] ID: 45 GRPC response: {} I0729 14:26:48.777121 1 utils.go:198] ID: 46 GRPC call: /csi.v1.Identity/GetPluginCapabilities I0729 14:26:48.777167 1 utils.go:199] ID: 46 GRPC request: {} I0729 14:26:48.777271 1 utils.go:205] ID: 46 GRPC response: {"capabilities":[{"Type":{"Service":{"type":1}}},{"Type":{"VolumeExpansion":{"type":1}}},{"Type":{"Service":{"type":2}}}]} I0729 14:26:48.779400 1 utils.go:198] ID: 47 GRPC call: /csi.v1.Controller/ControllerGetCapabilities I0729 14:26:48.779425 1 utils.go:199] ID: 47 GRPC request: {} I0729 14:26:48.779432 1 controllerserver-default.go:42] ID: 47 Using default ControllerGetCapabilities I0729 14:26:48.779610 1 utils.go:205] ID: 47 GRPC response: {"capabilities":[{"Type":{"Rpc":{"type":1}}},{"Type":{"Rpc":{"type":5}}},{"Type":{"Rpc":{"type":7}}},{"Type":{"Rpc":{"type":9}}}]} I0729 14:26:48.780479 1 utils.go:198] ID: 48 GRPC call: /csi.v1.Controller/ControllerGetCapabilities I0729 14:26:48.780505 1 utils.go:199] ID: 48 GRPC request: {} I0729 14:26:48.780512 1 controllerserver-default.go:42] ID: 48 Using default ControllerGetCapabilities I0729 14:26:48.780595 1 utils.go:205] ID: 48 GRPC response: {"capabilities":[{"Type":{"Rpc":{"type":1}}},{"Type":{"Rpc":{"type":5}}},{"Type":{"Rpc":{"type":7}}},{"Type":{"Rpc":{"type":9}}}]} I0729 14:26:48.781007 1 utils.go:198] ID: 49 GRPC call: /csi.v1.Controller/ControllerGetCapabilities I0729 14:26:48.781022 1 utils.go:199] ID: 49 GRPC request: {} I0729 14:26:48.781028 1 controllerserver-default.go:42] ID: 49 Using default ControllerGetCapabilities I0729 14:26:48.781097 1 utils.go:205] ID: 49 GRPC response: {"capabilities":[{"Type":{"Rpc":{"type":1}}},{"Type":{"Rpc":{"type":5}}},{"Type":{"Rpc":{"type":7}}},{"Type":{"Rpc":{"type":9}}}]} I0729 14:26:48.910724 1 utils.go:198] ID: 50 GRPC call: /csi.v1.Identity/GetPluginInfo I0729 14:26:48.910772 1 utils.go:199] ID: 50 GRPC request: {} I0729 14:26:48.910783 1 identityserver-default.go:40] ID: 50 Using default GetPluginInfo I0729 14:26:48.910817 1 utils.go:205] ID: 50 GRPC response: {"name":"rbd.csi.ceph.com","vendor_version":"v3.11.0"} I0729 14:26:48.916212 1 utils.go:198] ID: 51 GRPC call: /csi.v1.Identity/Probe I0729 14:26:48.916248 1 utils.go:199] ID: 51 GRPC request: {} I0729 14:26:48.916268 1 utils.go:205] ID: 51 GRPC response: {} I0729 14:26:48.916840 1 utils.go:198] ID: 52 GRPC call: /csi.v1.Controller/ControllerGetCapabilities I0729 14:26:48.916885 1 utils.go:199] ID: 52 GRPC request: {} I0729 14:26:48.916898 1 controllerserver-default.go:42] ID: 52 Using default ControllerGetCapabilities I0729 14:26:48.916992 1 utils.go:205] ID: 52 GRPC response: {"capabilities":[{"Type":{"Rpc":{"type":1}}},{"Type":{"Rpc":{"type":5}}},{"Type":{"Rpc":{"type":7}}},{"Type":{"Rpc":{"type":9}}}]} I0729 14:26:49.218680 1 utils.go:198] ID: 53 GRPC call: /csi.v1.Identity/Probe I0729 14:26:49.218714 1 utils.go:199] ID: 53 GRPC request: {} I0729 14:26:49.218729 1 utils.go:205] ID: 53 GRPC response: {} I0729 14:26:49.221935 1 utils.go:198] ID: 54 GRPC call: /csi.v1.Identity/GetPluginInfo I0729 14:26:49.221959 1 utils.go:199] ID: 54 GRPC request: {} I0729 14:26:49.221967 1 identityserver-default.go:40] ID: 54 Using default GetPluginInfo I0729 14:26:49.221994 1 utils.go:205] ID: 54 GRPC response: {"name":"rbd.csi.ceph.com","vendor_version":"v3.11.0"} I0729 14:26:49.228145 1 utils.go:198] ID: 55 GRPC call: /csi.v1.Identity/Probe I0729 14:26:49.228171 1 utils.go:199] ID: 55 GRPC request: {} I0729 14:26:49.228185 1 utils.go:205] ID: 55 GRPC response: {} I0729 14:26:49.228518 1 utils.go:198] ID: 56 GRPC call: /csi.v1.Identity/GetPluginCapabilities I0729 14:26:49.228538 1 utils.go:199] ID: 56 GRPC request: {} I0729 14:26:49.228610 1 utils.go:205] ID: 56 GRPC response: {"capabilities":[{"Type":{"Service":{"type":1}}},{"Type":{"VolumeExpansion":{"type":1}}},{"Type":{"Service":{"type":2}}}]} I0729 14:26:49.229138 1 utils.go:198] ID: 57 GRPC call: /csi.v1.Controller/ControllerGetCapabilities I0729 14:26:49.229154 1 utils.go:199] ID: 57 GRPC request: {} I0729 14:26:49.229161 1 controllerserver-default.go:42] ID: 57 Using default ControllerGetCapabilities I0729 14:26:49.229218 1 utils.go:205] ID: 57 GRPC response: {"capabilities":[{"Type":{"Rpc":{"type":1}}},{"Type":{"Rpc":{"type":5}}},{"Type":{"Rpc":{"type":7}}},{"Type":{"Rpc":{"type":9}}}]} I0729 14:26:49.320673 1 utils.go:198] ID: 58 GRPC call: /csi.v1.Identity/Probe I0729 14:26:49.320718 1 utils.go:199] ID: 58 GRPC request: {} I0729 14:26:49.320740 1 utils.go:205] ID: 58 GRPC response: {} I0729 14:26:49.323218 1 utils.go:198] ID: 59 GRPC call: /csi.v1.Identity/GetPluginInfo I0729 14:26:49.323248 1 utils.go:199] ID: 59 GRPC request: {} I0729 14:26:49.323258 1 identityserver-default.go:40] ID: 59 Using default GetPluginInfo I0729 14:26:49.323317 1 utils.go:205] ID: 59 GRPC response: {"name":"rbd.csi.ceph.com","vendor_version":"v3.11.0"} I0729 14:26:49.325064 1 utils.go:198] ID: 60 GRPC call: /csi.v1.Identity/Probe I0729 14:26:49.325096 1 utils.go:199] ID: 60 GRPC request: {} I0729 14:26:49.325109 1 utils.go:205] ID: 60 GRPC response: {} I0729 14:26:49.325505 1 utils.go:198] ID: 61 GRPC call: /csi.v1.Identity/GetPluginCapabilities I0729 14:26:49.325524 1 utils.go:199] ID: 61 GRPC request: {} I0729 14:26:49.325610 1 utils.go:205] ID: 61 GRPC response: {"capabilities":[{"Type":{"Service":{"type":1}}},{"Type":{"VolumeExpansion":{"type":1}}},{"Type":{"Service":{"type":2}}}]} I0729 14:26:49.326880 1 utils.go:198] ID: 62 GRPC call: /csi.v1.Controller/ControllerGetCapabilities I0729 14:26:49.327052 1 utils.go:199] ID: 62 GRPC request: {} I0729 14:26:49.327101 1 controllerserver-default.go:42] ID: 62 Using default ControllerGetCapabilities I0729 14:26:49.327262 1 utils.go:205] ID: 62 GRPC response: {"capabilities":[{"Type":{"Rpc":{"type":1}}},{"Type":{"Rpc":{"type":5}}},{"Type":{"Rpc":{"type":7}}},{"Type":{"Rpc":{"type":9}}}]} I0729 14:27:33.069689 1 utils.go:198] ID: 63 GRPC call: /csi.v1.Identity/Probe I0729 14:27:33.069754 1 utils.go:199] ID: 63 GRPC request: {} I0729 14:27:33.069782 1 utils.go:205] ID: 63 GRPC response: {} I0729 14:27:50.696540 1 utils.go:198] ID: 64 GRPC call: /csi.v1.Identity/Probe I0729 14:27:50.696578 1 utils.go:199] ID: 64 GRPC request: {} I0729 14:27:50.696595 1 utils.go:205] ID: 64 GRPC response: {} I0729 14:27:50.700878 1 utils.go:198] ID: 65 GRPC call: /csi.v1.Identity/GetPluginInfo I0729 14:27:50.700904 1 utils.go:199] ID: 65 GRPC request: {} I0729 14:27:50.700914 1 identityserver-default.go:40] ID: 65 Using default GetPluginInfo I0729 14:27:50.700942 1 utils.go:205] ID: 65 GRPC response: {"name":"rbd.csi.ceph.com","vendor_version":"v3.11.0"} I0729 14:27:50.703554 1 utils.go:198] ID: 66 GRPC call: /csi.v1.Identity/Probe I0729 14:27:50.703600 1 utils.go:199] ID: 66 GRPC request: {} I0729 14:27:50.703623 1 utils.go:205] ID: 66 GRPC response: {} I0729 14:27:50.704149 1 utils.go:198] ID: 67 GRPC call: /csi.v1.Identity/GetPluginCapabilities I0729 14:27:50.704175 1 utils.go:199] ID: 67 GRPC request: {} I0729 14:27:50.704291 1 utils.go:205] ID: 67 GRPC response: {"capabilities":[{"Type":{"Service":{"type":1}}},{"Type":{"VolumeExpansion":{"type":1}}},{"Type":{"Service":{"type":2}}}]} I0729 14:27:50.705366 1 utils.go:198] ID: 68 GRPC call: /csi.v1.Controller/ControllerGetCapabilities I0729 14:27:50.705393 1 utils.go:199] ID: 68 GRPC request: {} I0729 14:27:50.705404 1 controllerserver-default.go:42] ID: 68 Using default ControllerGetCapabilities I0729 14:27:50.705495 1 utils.go:205] ID: 68 GRPC response: {"capabilities":[{"Type":{"Rpc":{"type":1}}},{"Type":{"Rpc":{"type":5}}},{"Type":{"Rpc":{"type":7}}},{"Type":{"Rpc":{"type":9}}}]} I0729 14:27:50.767977 1 utils.go:198] ID: 69 GRPC call: /csi.v1.Identity/Probe I0729 14:27:50.768023 1 utils.go:199] ID: 69 GRPC request: {} I0729 14:27:50.768086 1 utils.go:205] ID: 69 GRPC response: {} I0729 14:27:50.770639 1 utils.go:198] ID: 70 GRPC call: /csi.v1.Identity/GetPluginInfo I0729 14:27:50.770673 1 utils.go:199] ID: 70 GRPC request: {} I0729 14:27:50.770680 1 identityserver-default.go:40] ID: 70 Using default GetPluginInfo I0729 14:27:50.770700 1 utils.go:205] ID: 70 GRPC response: {"name":"rbd.csi.ceph.com","vendor_version":"v3.11.0"} I0729 14:27:50.774026 1 utils.go:198] ID: 71 GRPC call: /csi.v1.Identity/Probe I0729 14:27:50.774059 1 utils.go:199] ID: 71 GRPC request: {} I0729 14:27:50.774077 1 utils.go:205] ID: 71 GRPC response: {} I0729 14:27:50.774636 1 utils.go:198] ID: 72 GRPC call: /csi.v1.Identity/GetPluginCapabilities I0729 14:27:50.774663 1 utils.go:199] ID: 72 GRPC request: {} I0729 14:27:50.774781 1 utils.go:205] ID: 72 GRPC response: {"capabilities":[{"Type":{"Service":{"type":1}}},{"Type":{"VolumeExpansion":{"type":1}}},{"Type":{"Service":{"type":2}}}]} I0729 14:27:50.775364 1 utils.go:198] ID: 73 GRPC call: /csi.v1.Controller/ControllerGetCapabilities I0729 14:27:50.775381 1 utils.go:199] ID: 73 GRPC request: {} I0729 14:27:50.775388 1 controllerserver-default.go:42] ID: 73 Using default ControllerGetCapabilities I0729 14:27:50.775569 1 utils.go:205] ID: 73 GRPC response: {"capabilities":[{"Type":{"Rpc":{"type":1}}},{"Type":{"Rpc":{"type":5}}},{"Type":{"Rpc":{"type":7}}},{"Type":{"Rpc":{"type":9}}}]} I0729 14:27:50.776400 1 utils.go:198] ID: 74 GRPC call: /csi.v1.Controller/ControllerGetCapabilities I0729 14:27:50.776422 1 utils.go:199] ID: 74 GRPC request: {} I0729 14:27:50.776431 1 controllerserver-default.go:42] ID: 74 Using default ControllerGetCapabilities I0729 14:27:50.776491 1 utils.go:205] ID: 74 GRPC response: {"capabilities":[{"Type":{"Rpc":{"type":1}}},{"Type":{"Rpc":{"type":5}}},{"Type":{"Rpc":{"type":7}}},{"Type":{"Rpc":{"type":9}}}]} I0729 14:27:50.776990 1 utils.go:198] ID: 75 GRPC call: /csi.v1.Controller/ControllerGetCapabilities I0729 14:27:50.777005 1 utils.go:199] ID: 75 GRPC request: {} I0729 14:27:50.777010 1 controllerserver-default.go:42] ID: 75 Using default ControllerGetCapabilities I0729 14:27:50.777065 1 utils.go:205] ID: 75 GRPC response: {"capabilities":[{"Type":{"Rpc":{"type":1}}},{"Type":{"Rpc":{"type":5}}},{"Type":{"Rpc":{"type":7}}},{"Type":{"Rpc":{"type":9}}}]} I0729 14:27:50.841365 1 utils.go:198] ID: 76 GRPC call: /csi.v1.Identity/GetPluginInfo I0729 14:27:50.841416 1 utils.go:199] ID: 76 GRPC request: {} I0729 14:27:50.841428 1 identityserver-default.go:40] ID: 76 Using default GetPluginInfo I0729 14:27:50.841463 1 utils.go:205] ID: 76 GRPC response: {"name":"rbd.csi.ceph.com","vendor_version":"v3.11.0"} I0729 14:27:50.844398 1 utils.go:198] ID: 77 GRPC call: /csi.v1.Identity/Probe I0729 14:27:50.844441 1 utils.go:199] ID: 77 GRPC request: {} I0729 14:27:50.844469 1 utils.go:205] ID: 77 GRPC response: {} I0729 14:27:50.845399 1 utils.go:198] ID: 78 GRPC call: /csi.v1.Controller/ControllerGetCapabilities I0729 14:27:50.845453 1 utils.go:199] ID: 78 GRPC request: {} I0729 14:27:50.845465 1 controllerserver-default.go:42] ID: 78 Using default ControllerGetCapabilities I0729 14:27:50.845586 1 utils.go:205] ID: 78 GRPC response: {"capabilities":[{"Type":{"Rpc":{"type":1}}},{"Type":{"Rpc":{"type":5}}},{"Type":{"Rpc":{"type":7}}},{"Type":{"Rpc":{"type":9}}}]} I0729 14:27:50.909987 1 utils.go:198] ID: 79 GRPC call: /csi.v1.Identity/Probe I0729 14:27:50.910048 1 utils.go:199] ID: 79 GRPC request: {} I0729 14:27:50.910089 1 utils.go:205] ID: 79 GRPC response: {} I0729 14:27:50.913144 1 utils.go:198] ID: 80 GRPC call: /csi.v1.Identity/GetPluginInfo I0729 14:27:50.913193 1 utils.go:199] ID: 80 GRPC request: {} I0729 14:27:50.913205 1 identityserver-default.go:40] ID: 80 Using default GetPluginInfo I0729 14:27:50.913244 1 utils.go:205] ID: 80 GRPC response: {"name":"rbd.csi.ceph.com","vendor_version":"v3.11.0"} I0729 14:27:50.916532 1 utils.go:198] ID: 81 GRPC call: /csi.v1.Identity/Probe I0729 14:27:50.916551 1 utils.go:199] ID: 81 GRPC request: {} I0729 14:27:50.916561 1 utils.go:205] ID: 81 GRPC response: {} I0729 14:27:50.917068 1 utils.go:198] ID: 82 GRPC call: /csi.v1.Identity/GetPluginCapabilities I0729 14:27:50.917100 1 utils.go:199] ID: 82 GRPC request: {} I0729 14:27:50.917228 1 utils.go:205] ID: 82 GRPC response: {"capabilities":[{"Type":{"Service":{"type":1}}},{"Type":{"VolumeExpansion":{"type":1}}},{"Type":{"Service":{"type":2}}}]} I0729 14:27:50.918374 1 utils.go:198] ID: 83 GRPC call: /csi.v1.Controller/ControllerGetCapabilities I0729 14:27:50.918403 1 utils.go:199] ID: 83 GRPC request: {} I0729 14:27:50.918415 1 controllerserver-default.go:42] ID: 83 Using default ControllerGetCapabilities I0729 14:27:50.918511 1 utils.go:205] ID: 83 GRPC response: {"capabilities":[{"Type":{"Rpc":{"type":1}}},{"Type":{"Rpc":{"type":5}}},{"Type":{"Rpc":{"type":7}}},{"Type":{"Rpc":{"type":9}}}]} I0729 14:28:33.111443 1 utils.go:198] ID: 84 GRPC call: /csi.v1.Identity/Probe I0729 14:28:33.111666 1 utils.go:199] ID: 84 GRPC request: {} I0729 14:28:33.111687 1 utils.go:205] ID: 84 GRPC response: {} I0729 14:28:48.743580 1 utils.go:198] ID: 85 Req-ID: pvc-a922e2b8-dd07-489a-a26f-fe161c796b17 GRPC call: /csi.v1.Controller/CreateVolume I0729 14:28:48.744116 1 utils.go:199] ID: 85 Req-ID: pvc-a922e2b8-dd07-489a-a26f-fe161c796b17 GRPC request: {"capacity_range":{"required_bytes":10737418240},"name":"pvc-a922e2b8-dd07-489a-a26f-fe161c796b17","parameters":{"clusterID":"4837cbf8-4f90-4300-b3f6-726c9b9f89b4","csi.storage.k8s.io/pv/name":"pvc-a922e2b8-dd07-489a-a26f-fe161c796b17","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}}]} I0729 14:28:48.744400 1 rbd_util.go:1315] ID: 85 Req-ID: pvc-a922e2b8-dd07-489a-a26f-fe161c796b17 setting disableInUseChecks: false image features: [layering] mounter: rbd I0729 14:28:48.747043 1 omap.go:89] ID: 85 Req-ID: pvc-a922e2b8-dd07-489a-a26f-fe161c796b17 got omap values: (pool="kube", namespace="", name="csi.volumes.default"): map[] I0729 14:28:48.762692 1 omap.go:159] ID: 85 Req-ID: pvc-a922e2b8-dd07-489a-a26f-fe161c796b17 set omap keys (pool="kube", namespace="", name="csi.volumes.default"): map[csi.volume.pvc-a922e2b8-dd07-489a-a26f-fe161c796b17:54b3fdc0-f496-4284-a772-f7907124a2be]) I0729 14:28:48.770294 1 omap.go:159] ID: 85 Req-ID: pvc-a922e2b8-dd07-489a-a26f-fe161c796b17 set omap keys (pool="kube", namespace="", name="csi.volume.54b3fdc0-f496-4284-a772-f7907124a2be"): map[csi.imagename:csi-vol-54b3fdc0-f496-4284-a772-f7907124a2be csi.volname:pvc-a922e2b8-dd07-489a-a26f-fe161c796b17 csi.volume.owner:openstack]) I0729 14:28:48.770335 1 rbd_journal.go:491] ID: 85 Req-ID: pvc-a922e2b8-dd07-489a-a26f-fe161c796b17 generated Volume ID (0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-54b3fdc0-f496-4284-a772-f7907124a2be) and image name (csi-vol-54b3fdc0-f496-4284-a772-f7907124a2be) for request name (pvc-a922e2b8-dd07-489a-a26f-fe161c796b17) I0729 14:28:48.770438 1 rbd_util.go:423] ID: 85 Req-ID: pvc-a922e2b8-dd07-489a-a26f-fe161c796b17 rbd: create kube/csi-vol-54b3fdc0-f496-4284-a772-f7907124a2be size 10240M (features: [layering]) using mon 10.96.240.200 I0729 14:28:48.770468 1 rbd_util.go:1563] ID: 85 Req-ID: pvc-a922e2b8-dd07-489a-a26f-fe161c796b17 setting image options on kube/csi-vol-54b3fdc0-f496-4284-a772-f7907124a2be I0729 14:28:48.799791 1 controllerserver.go:763] ID: 85 Req-ID: pvc-a922e2b8-dd07-489a-a26f-fe161c796b17 created image kube/csi-vol-54b3fdc0-f496-4284-a772-f7907124a2be backed for request name pvc-a922e2b8-dd07-489a-a26f-fe161c796b17 I0729 14:28:48.830097 1 omap.go:159] ID: 85 Req-ID: pvc-a922e2b8-dd07-489a-a26f-fe161c796b17 set omap keys (pool="kube", namespace="", name="csi.volume.54b3fdc0-f496-4284-a772-f7907124a2be"): map[csi.imageid:37c64e421bd2]) I0729 14:28:48.987514 1 utils.go:205] ID: 85 Req-ID: pvc-a922e2b8-dd07-489a-a26f-fe161c796b17 GRPC response: {"volume":{"capacity_bytes":10737418240,"volume_context":{"clusterID":"4837cbf8-4f90-4300-b3f6-726c9b9f89b4","imageFeatures":"layering","imageName":"csi-vol-54b3fdc0-f496-4284-a772-f7907124a2be","journalPool":"kube","pool":"kube"},"volume_id":"0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-54b3fdc0-f496-4284-a772-f7907124a2be"}} I0729 14:29:33.069433 1 utils.go:198] ID: 86 GRPC call: /csi.v1.Identity/Probe I0729 14:29:33.069471 1 utils.go:199] ID: 86 GRPC request: {} I0729 14:29:33.069487 1 utils.go:205] ID: 86 GRPC response: {} I0729 14:30:33.107629 1 utils.go:198] ID: 87 GRPC call: /csi.v1.Identity/Probe I0729 14:30:33.107679 1 utils.go:199] ID: 87 GRPC request: {} I0729 14:30:33.107701 1 utils.go:205] ID: 87 GRPC response: {} I0729 14:31:33.073181 1 utils.go:198] ID: 88 GRPC call: /csi.v1.Identity/Probe I0729 14:31:33.073452 1 utils.go:199] ID: 88 GRPC request: {} I0729 14:31:33.073549 1 utils.go:205] ID: 88 GRPC response: {} I0729 14:32:33.096226 1 utils.go:198] ID: 89 GRPC call: /csi.v1.Identity/Probe I0729 14:32:33.096307 1 utils.go:199] ID: 89 GRPC request: {} I0729 14:32:33.096336 1 utils.go:205] ID: 89 GRPC response: {} I0729 14:33:33.082472 1 utils.go:198] ID: 90 GRPC call: /csi.v1.Identity/Probe I0729 14:33:33.082552 1 utils.go:199] ID: 90 GRPC request: {} I0729 14:33:33.082596 1 utils.go:205] ID: 90 GRPC response: {} I0729 14:34:33.069658 1 utils.go:198] ID: 91 GRPC call: /csi.v1.Identity/Probe I0729 14:34:33.069718 1 utils.go:199] ID: 91 GRPC request: {} I0729 14:34:33.069749 1 utils.go:205] ID: 91 GRPC response: {} I0729 14:35:33.091048 1 utils.go:198] ID: 92 GRPC call: /csi.v1.Identity/Probe I0729 14:35:33.091095 1 utils.go:199] ID: 92 GRPC request: {} I0729 14:35:33.091112 1 utils.go:205] ID: 92 GRPC response: {} I0729 14:36:33.069834 1 utils.go:198] ID: 93 GRPC call: /csi.v1.Identity/Probe I0729 14:36:33.069907 1 utils.go:199] ID: 93 GRPC request: {} I0729 14:36:33.069937 1 utils.go:205] ID: 93 GRPC response: {} I0729 14:37:33.103002 1 utils.go:198] ID: 94 GRPC call: /csi.v1.Identity/Probe I0729 14:37:33.103074 1 utils.go:199] ID: 94 GRPC request: {} I0729 14:37:33.103349 1 utils.go:205] ID: 94 GRPC response: {} I0729 14:38:33.123549 1 utils.go:198] ID: 95 GRPC call: /csi.v1.Identity/Probe I0729 14:38:33.123601 1 utils.go:199] ID: 95 GRPC request: {} I0729 14:38:33.123624 1 utils.go:205] ID: 95 GRPC response: {} I0729 14:39:33.111415 1 utils.go:198] ID: 96 GRPC call: /csi.v1.Identity/Probe I0729 14:39:33.111528 1 utils.go:199] ID: 96 GRPC request: {} I0729 14:39:33.111563 1 utils.go:205] ID: 96 GRPC response: {} I0729 14:40:33.069622 1 utils.go:198] ID: 97 GRPC call: /csi.v1.Identity/Probe I0729 14:40:33.069684 1 utils.go:199] ID: 97 GRPC request: {} I0729 14:40:33.069707 1 utils.go:205] ID: 97 GRPC response: {} I0729 14:41:33.120588 1 utils.go:198] ID: 98 GRPC call: /csi.v1.Identity/Probe I0729 14:41:33.120645 1 utils.go:199] ID: 98 GRPC request: {} I0729 14:41:33.120666 1 utils.go:205] ID: 98 GRPC response: {} I0729 14:42:33.069490 1 utils.go:198] ID: 99 GRPC call: /csi.v1.Identity/Probe I0729 14:42:33.069542 1 utils.go:199] ID: 99 GRPC request: {} I0729 14:42:33.069563 1 utils.go:205] ID: 99 GRPC response: {} I0729 14:43:33.123641 1 utils.go:198] ID: 100 GRPC call: /csi.v1.Identity/Probe I0729 14:43:33.123680 1 utils.go:199] ID: 100 GRPC request: {} I0729 14:43:33.123696 1 utils.go:205] ID: 100 GRPC response: {}