I0417 00:31:14.176348   60020 cephcsi.go:191] Driver version: v3.11.0 and Git version: bc24b5eca87626d690a29effa9d7420cc0154a7a
I0417 00:31:14.176555   60020 cephcsi.go:268] Initial PID limit is set to -1
I0417 00:31:14.176591   60020 cephcsi.go:274] Reconfigured PID limit to -1 (max)
I0417 00:31:14.176611   60020 cephcsi.go:223] Starting driver type: rbd with name: rbd.csi.ceph.com
I0417 00:31:14.190976   60020 mount_linux.go:282] Detected umount with safe 'not mounted' behavior
I0417 00:31:14.210296   60020 rbd_attach.go:242] nbd module loaded
I0417 00:31:14.210383   60020 rbd_attach.go:256] kernel version "5.15.0-176-generic" supports cookie feature
I0417 00:31:14.231986   60020 rbd_attach.go:272] rbd-nbd tool supports cookie feature
I0417 00:31:14.232422   60020 server.go:114] listening for CSI-Addons requests on address: &net.UnixAddr{Name:"/csi/csi-addons.sock", Net:"unix"}
I0417 00:31:14.232603   60020 server.go:117] Listening for connections on address: &net.UnixAddr{Name:"//csi/csi.sock", Net:"unix"}
I0417 00:31:15.317762   60020 utils.go:198] ID: 1 GRPC call: /csi.v1.Identity/GetPluginInfo
I0417 00:31:15.319285   60020 utils.go:199] ID: 1 GRPC request: {}
I0417 00:31:15.319319   60020 identityserver-default.go:40] ID: 1 Using default GetPluginInfo
I0417 00:31:15.319382   60020 utils.go:205] ID: 1 GRPC response: {"name":"rbd.csi.ceph.com","vendor_version":"v3.11.0"}
I0417 00:31:15.831447   60020 utils.go:198] ID: 2 GRPC call: /csi.v1.Node/NodeGetInfo
I0417 00:31:15.831542   60020 utils.go:199] ID: 2 GRPC request: {}
I0417 00:31:15.831555   60020 nodeserver-default.go:45] ID: 2 Using default NodeGetInfo
I0417 00:31:15.831649   60020 utils.go:205] ID: 2 GRPC response: {"accessible_topology":{},"node_id":"instance"}
I0417 00:31:27.935291   60020 utils.go:198] ID: 3 GRPC call: /csi.v1.Node/NodeGetCapabilities
I0417 00:31:27.935762   60020 utils.go:199] ID: 3 GRPC request: {}
I0417 00:31:27.936152   60020 utils.go:205] ID: 3 GRPC response: {"capabilities":[{"Type":{"Rpc":{"type":1}}},{"Type":{"Rpc":{"type":2}}},{"Type":{"Rpc":{"type":3}}},{"Type":{"Rpc":{"type":5}}}]}
I0417 00:31:27.943257   60020 utils.go:198] ID: 4 GRPC call: /csi.v1.Node/NodeGetCapabilities
I0417 00:31:27.943311   60020 utils.go:199] ID: 4 GRPC request: {}
I0417 00:31:27.943521   60020 utils.go:205] ID: 4 GRPC response: {"capabilities":[{"Type":{"Rpc":{"type":1}}},{"Type":{"Rpc":{"type":2}}},{"Type":{"Rpc":{"type":3}}},{"Type":{"Rpc":{"type":5}}}]}
I0417 00:31:27.944531   60020 utils.go:198] ID: 5 GRPC call: /csi.v1.Node/NodeGetCapabilities
I0417 00:31:27.944551   60020 utils.go:199] ID: 5 GRPC request: {}
I0417 00:31:27.944682   60020 utils.go:205] ID: 5 GRPC response: {"capabilities":[{"Type":{"Rpc":{"type":1}}},{"Type":{"Rpc":{"type":2}}},{"Type":{"Rpc":{"type":3}}},{"Type":{"Rpc":{"type":5}}}]}
I0417 00:31:27.946153   60020 utils.go:198] ID: 6 Req-ID: 0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-d648a79e-3b63-41f3-8805-9edd0ba16a5c GRPC call: /csi.v1.Node/NodeStageVolume
I0417 00:31:27.946498   60020 utils.go:199] ID: 6 Req-ID: 0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-d648a79e-3b63-41f3-8805-9edd0ba16a5c GRPC request: {"secrets":"***stripped***","staging_target_path":"/var/lib/kubelet/plugins/kubernetes.io/csi/rbd.csi.ceph.com/60513dcfc9cbe76166f3b1e45df39f863d8369998e0d8357abb4c16399563863/globalmount","volume_capability":{"AccessType":{"Mount":{"fs_type":"ext4","mount_flags":["discard"]}},"access_mode":{"mode":7}},"volume_context":{"clusterID":"4837cbf8-4f90-4300-b3f6-726c9b9f89b4","imageFeatures":"layering","imageName":"csi-vol-d648a79e-3b63-41f3-8805-9edd0ba16a5c","journalPool":"kube","pool":"kube","storage.kubernetes.io/csiProvisionerIdentity":"1776385876553-2927-rbd.csi.ceph.com"},"volume_id":"0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-d648a79e-3b63-41f3-8805-9edd0ba16a5c"}
I0417 00:31:27.966619   60020 omap.go:89] ID: 6 Req-ID: 0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-d648a79e-3b63-41f3-8805-9edd0ba16a5c got omap values: (pool="kube", namespace="", name="csi.volume.d648a79e-3b63-41f3-8805-9edd0ba16a5c"): map[csi.imageid:37b5845f9397 csi.imagename:csi-vol-d648a79e-3b63-41f3-8805-9edd0ba16a5c csi.volname:pvc-b01aa330-38d2-4a14-ae35-c6ac57104e5f csi.volume.owner:default]
I0417 00:31:28.025528   60020 rbd_util.go:352] ID: 6 Req-ID: 0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-d648a79e-3b63-41f3-8805-9edd0ba16a5c checking for ImageFeatures: [layering]
I0417 00:31:28.060551   60020 cephcmds.go:105] ID: 6 Req-ID: 0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-d648a79e-3b63-41f3-8805-9edd0ba16a5c command succeeded: rbd [device list --format=json --device-type krbd]
I0417 00:31:28.084235   60020 rbd_attach.go:437] ID: 6 Req-ID: 0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-d648a79e-3b63-41f3-8805-9edd0ba16a5c rbd: map mon 199.204.45.33
I0417 00:31:28.159507   60020 cephcmds.go:105] ID: 6 Req-ID: 0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-d648a79e-3b63-41f3-8805-9edd0ba16a5c command succeeded: rbd [--id kube -m 199.204.45.33 --keyfile=***stripped*** map kube/csi-vol-d648a79e-3b63-41f3-8805-9edd0ba16a5c --device-type krbd --options noudev]
I0417 00:31:28.159567   60020 nodeserver.go:422] ID: 6 Req-ID: 0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-d648a79e-3b63-41f3-8805-9edd0ba16a5c rbd image: kube/csi-vol-d648a79e-3b63-41f3-8805-9edd0ba16a5c was successfully mapped at /dev/rbd0
I0417 00:31:28.159680   60020 mount_linux.go:577] Attempting to determine if disk "/dev/rbd0" is formatted using blkid with args: ([-p -s TYPE -s PTTYPE -o export /dev/rbd0])
I0417 00:31:28.168381   60020 mount_linux.go:580] Output: ""
I0417 00:31:28.249818   60020 mount_linux.go:577] Attempting to determine if disk "/dev/rbd0" is formatted using blkid with args: ([-p -s TYPE -s PTTYPE -o export /dev/rbd0])
I0417 00:31:28.261957   60020 mount_linux.go:580] Output: "DEVNAME=/dev/rbd0\nTYPE=ext4\n"
I0417 00:31:28.261975   60020 mount_linux.go:439] Checking for issues with fsck on disk: /dev/rbd0
I0417 00:31:28.287149   60020 mount_linux.go:544] Attempting to mount disk /dev/rbd0 in ext4 format at /var/lib/kubelet/plugins/kubernetes.io/csi/rbd.csi.ceph.com/60513dcfc9cbe76166f3b1e45df39f863d8369998e0d8357abb4c16399563863/globalmount/0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-d648a79e-3b63-41f3-8805-9edd0ba16a5c
I0417 00:31:28.287203   60020 mount_linux.go:218] Mounting cmd (mount) with arguments (-t ext4 -o _netdev,discard,defaults /dev/rbd0 /var/lib/kubelet/plugins/kubernetes.io/csi/rbd.csi.ceph.com/60513dcfc9cbe76166f3b1e45df39f863d8369998e0d8357abb4c16399563863/globalmount/0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-d648a79e-3b63-41f3-8805-9edd0ba16a5c)
I0417 00:31:28.303780   60020 mount_linux.go:577] Attempting to determine if disk "/dev/rbd0" is formatted using blkid with args: ([-p -s TYPE -s PTTYPE -o export /dev/rbd0])
I0417 00:31:28.313670   60020 mount_linux.go:580] Output: "DEVNAME=/dev/rbd0\nTYPE=ext4\n"
I0417 00:31:28.313700   60020 resizefs_linux.go:137] ResizeFs.needResize - checking mounted volume /dev/rbd0
I0417 00:31:28.316273   60020 resizefs_linux.go:141] Ext size: filesystem size=5368709120, block size=4096
I0417 00:31:28.316301   60020 resizefs_linux.go:156] Volume /dev/rbd0: device size=5368709120, filesystem size=5368709120, block size=4096
I0417 00:31:28.316325   60020 nodeserver.go:382] ID: 6 Req-ID: 0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-d648a79e-3b63-41f3-8805-9edd0ba16a5c rbd: successfully mounted volume 0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-d648a79e-3b63-41f3-8805-9edd0ba16a5c to stagingTargetPath /var/lib/kubelet/plugins/kubernetes.io/csi/rbd.csi.ceph.com/60513dcfc9cbe76166f3b1e45df39f863d8369998e0d8357abb4c16399563863/globalmount/0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-d648a79e-3b63-41f3-8805-9edd0ba16a5c
I0417 00:31:28.316447   60020 utils.go:205] ID: 6 Req-ID: 0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-d648a79e-3b63-41f3-8805-9edd0ba16a5c GRPC response: {}
I0417 00:31:28.317730   60020 utils.go:198] ID: 7 GRPC call: /csi.v1.Node/NodeGetCapabilities
I0417 00:31:28.317759   60020 utils.go:199] ID: 7 GRPC request: {}
I0417 00:31:28.317829   60020 utils.go:205] ID: 7 GRPC response: {"capabilities":[{"Type":{"Rpc":{"type":1}}},{"Type":{"Rpc":{"type":2}}},{"Type":{"Rpc":{"type":3}}},{"Type":{"Rpc":{"type":5}}}]}
I0417 00:31:28.321643   60020 utils.go:198] ID: 8 GRPC call: /csi.v1.Node/NodeGetCapabilities
I0417 00:31:28.321659   60020 utils.go:199] ID: 8 GRPC request: {}
I0417 00:31:28.321707   60020 utils.go:205] ID: 8 GRPC response: {"capabilities":[{"Type":{"Rpc":{"type":1}}},{"Type":{"Rpc":{"type":2}}},{"Type":{"Rpc":{"type":3}}},{"Type":{"Rpc":{"type":5}}}]}
I0417 00:31:28.322654   60020 utils.go:198] ID: 9 GRPC call: /csi.v1.Node/NodeGetCapabilities
I0417 00:31:28.322671   60020 utils.go:199] ID: 9 GRPC request: {}
I0417 00:31:28.322715   60020 utils.go:205] ID: 9 GRPC response: {"capabilities":[{"Type":{"Rpc":{"type":1}}},{"Type":{"Rpc":{"type":2}}},{"Type":{"Rpc":{"type":3}}},{"Type":{"Rpc":{"type":5}}}]}
I0417 00:31:28.323652   60020 utils.go:198] ID: 10 Req-ID: 0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-d648a79e-3b63-41f3-8805-9edd0ba16a5c GRPC call: /csi.v1.Node/NodePublishVolume
I0417 00:31:28.323762   60020 utils.go:199] ID: 10 Req-ID: 0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-d648a79e-3b63-41f3-8805-9edd0ba16a5c GRPC request: {"staging_target_path":"/var/lib/kubelet/plugins/kubernetes.io/csi/rbd.csi.ceph.com/60513dcfc9cbe76166f3b1e45df39f863d8369998e0d8357abb4c16399563863/globalmount","target_path":"/var/lib/kubelet/pods/9863d0d8-5346-4275-bfc4-f25d68c32e76/volumes/kubernetes.io~csi/pvc-b01aa330-38d2-4a14-ae35-c6ac57104e5f/mount","volume_capability":{"AccessType":{"Mount":{"fs_type":"ext4","mount_flags":["discard"]}},"access_mode":{"mode":7}},"volume_context":{"clusterID":"4837cbf8-4f90-4300-b3f6-726c9b9f89b4","imageFeatures":"layering","imageName":"csi-vol-d648a79e-3b63-41f3-8805-9edd0ba16a5c","journalPool":"kube","pool":"kube","storage.kubernetes.io/csiProvisionerIdentity":"1776385876553-2927-rbd.csi.ceph.com"},"volume_id":"0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-d648a79e-3b63-41f3-8805-9edd0ba16a5c"}
I0417 00:31:28.323844   60020 nodeserver.go:859] ID: 10 Req-ID: 0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-d648a79e-3b63-41f3-8805-9edd0ba16a5c target /var/lib/kubelet/pods/9863d0d8-5346-4275-bfc4-f25d68c32e76/volumes/kubernetes.io~csi/pvc-b01aa330-38d2-4a14-ae35-c6ac57104e5f/mount
isBlock false
fstype ext4
stagingPath /var/lib/kubelet/plugins/kubernetes.io/csi/rbd.csi.ceph.com/60513dcfc9cbe76166f3b1e45df39f863d8369998e0d8357abb4c16399563863/globalmount/0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-d648a79e-3b63-41f3-8805-9edd0ba16a5c
readonly false
mountflags [bind _netdev discard]
I0417 00:31:28.323863   60020 mount_linux.go:218] Mounting cmd (mount) with arguments (-t ext4 -o bind,_netdev /var/lib/kubelet/plugins/kubernetes.io/csi/rbd.csi.ceph.com/60513dcfc9cbe76166f3b1e45df39f863d8369998e0d8357abb4c16399563863/globalmount/0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-d648a79e-3b63-41f3-8805-9edd0ba16a5c /var/lib/kubelet/pods/9863d0d8-5346-4275-bfc4-f25d68c32e76/volumes/kubernetes.io~csi/pvc-b01aa330-38d2-4a14-ae35-c6ac57104e5f/mount)
I0417 00:31:28.328787   60020 mount_linux.go:218] Mounting cmd (mount) with arguments (-t ext4 -o bind,remount,_netdev,discard /var/lib/kubelet/plugins/kubernetes.io/csi/rbd.csi.ceph.com/60513dcfc9cbe76166f3b1e45df39f863d8369998e0d8357abb4c16399563863/globalmount/0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-d648a79e-3b63-41f3-8805-9edd0ba16a5c /var/lib/kubelet/pods/9863d0d8-5346-4275-bfc4-f25d68c32e76/volumes/kubernetes.io~csi/pvc-b01aa330-38d2-4a14-ae35-c6ac57104e5f/mount)
I0417 00:31:28.331289   60020 nodeserver.go:742] ID: 10 Req-ID: 0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-d648a79e-3b63-41f3-8805-9edd0ba16a5c rbd: successfully mounted stagingPath /var/lib/kubelet/plugins/kubernetes.io/csi/rbd.csi.ceph.com/60513dcfc9cbe76166f3b1e45df39f863d8369998e0d8357abb4c16399563863/globalmount/0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-d648a79e-3b63-41f3-8805-9edd0ba16a5c to targetPath /var/lib/kubelet/pods/9863d0d8-5346-4275-bfc4-f25d68c32e76/volumes/kubernetes.io~csi/pvc-b01aa330-38d2-4a14-ae35-c6ac57104e5f/mount
I0417 00:31:28.331343   60020 utils.go:205] ID: 10 Req-ID: 0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-d648a79e-3b63-41f3-8805-9edd0ba16a5c GRPC response: {}
I0417 00:31:39.920023   60020 utils.go:198] ID: 11 Req-ID: 0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-d648a79e-3b63-41f3-8805-9edd0ba16a5c GRPC call: /csi.v1.Node/NodeUnpublishVolume
I0417 00:31:39.920202   60020 utils.go:199] ID: 11 Req-ID: 0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-d648a79e-3b63-41f3-8805-9edd0ba16a5c GRPC request: {"target_path":"/var/lib/kubelet/pods/9863d0d8-5346-4275-bfc4-f25d68c32e76/volumes/kubernetes.io~csi/pvc-b01aa330-38d2-4a14-ae35-c6ac57104e5f/mount","volume_id":"0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-d648a79e-3b63-41f3-8805-9edd0ba16a5c"}
I0417 00:31:39.920314   60020 mount_linux.go:360] Unmounting /var/lib/kubelet/pods/9863d0d8-5346-4275-bfc4-f25d68c32e76/volumes/kubernetes.io~csi/pvc-b01aa330-38d2-4a14-ae35-c6ac57104e5f/mount
I0417 00:31:39.925842   60020 nodeserver.go:945] ID: 11 Req-ID: 0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-d648a79e-3b63-41f3-8805-9edd0ba16a5c rbd: successfully unbound volume 0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-d648a79e-3b63-41f3-8805-9edd0ba16a5c from /var/lib/kubelet/pods/9863d0d8-5346-4275-bfc4-f25d68c32e76/volumes/kubernetes.io~csi/pvc-b01aa330-38d2-4a14-ae35-c6ac57104e5f/mount
I0417 00:31:39.925951   60020 utils.go:205] ID: 11 Req-ID: 0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-d648a79e-3b63-41f3-8805-9edd0ba16a5c GRPC response: {}
I0417 00:31:40.022400   60020 utils.go:198] ID: 12 GRPC call: /csi.v1.Node/NodeGetCapabilities
I0417 00:31:40.022470   60020 utils.go:199] ID: 12 GRPC request: {}
I0417 00:31:40.022598   60020 utils.go:205] ID: 12 GRPC response: {"capabilities":[{"Type":{"Rpc":{"type":1}}},{"Type":{"Rpc":{"type":2}}},{"Type":{"Rpc":{"type":3}}},{"Type":{"Rpc":{"type":5}}}]}
I0417 00:31:40.023844   60020 utils.go:198] ID: 13 Req-ID: 0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-d648a79e-3b63-41f3-8805-9edd0ba16a5c GRPC call: /csi.v1.Node/NodeUnstageVolume
I0417 00:31:40.023990   60020 utils.go:199] ID: 13 Req-ID: 0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-d648a79e-3b63-41f3-8805-9edd0ba16a5c GRPC request: {"staging_target_path":"/var/lib/kubelet/plugins/kubernetes.io/csi/rbd.csi.ceph.com/60513dcfc9cbe76166f3b1e45df39f863d8369998e0d8357abb4c16399563863/globalmount","volume_id":"0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-d648a79e-3b63-41f3-8805-9edd0ba16a5c"}
I0417 00:31:40.024176   60020 mount_linux.go:360] Unmounting /var/lib/kubelet/plugins/kubernetes.io/csi/rbd.csi.ceph.com/60513dcfc9cbe76166f3b1e45df39f863d8369998e0d8357abb4c16399563863/globalmount/0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-d648a79e-3b63-41f3-8805-9edd0ba16a5c
I0417 00:31:40.158320   60020 nodeserver.go:1001] ID: 13 Req-ID: 0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-d648a79e-3b63-41f3-8805-9edd0ba16a5c successfully unmounted volume (0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-d648a79e-3b63-41f3-8805-9edd0ba16a5c) from staging path (/var/lib/kubelet/plugins/kubernetes.io/csi/rbd.csi.ceph.com/60513dcfc9cbe76166f3b1e45df39f863d8369998e0d8357abb4c16399563863/globalmount/0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-d648a79e-3b63-41f3-8805-9edd0ba16a5c)
I0417 00:31:40.217686   60020 cephcmds.go:105] ID: 13 Req-ID: 0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-d648a79e-3b63-41f3-8805-9edd0ba16a5c command succeeded: rbd [unmap kube/csi-vol-d648a79e-3b63-41f3-8805-9edd0ba16a5c --device-type krbd --options noudev]
I0417 00:31:40.217760   60020 nodeserver.go:1059] ID: 13 Req-ID: 0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-d648a79e-3b63-41f3-8805-9edd0ba16a5c successfully unmapped volume (0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-d648a79e-3b63-41f3-8805-9edd0ba16a5c)
I0417 00:31:40.217944   60020 utils.go:205] ID: 13 Req-ID: 0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-d648a79e-3b63-41f3-8805-9edd0ba16a5c GRPC response: {}