I0415 07:13:25.303297   53016 cephcsi.go:191] Driver version: v3.11.0 and Git version: bc24b5eca87626d690a29effa9d7420cc0154a7a
I0415 07:13:25.303471   53016 cephcsi.go:268] Initial PID limit is set to -1
I0415 07:13:25.303504   53016 cephcsi.go:274] Reconfigured PID limit to -1 (max)
I0415 07:13:25.303523   53016 cephcsi.go:223] Starting driver type: rbd with name: rbd.csi.ceph.com
I0415 07:13:25.328699   53016 mount_linux.go:282] Detected umount with safe 'not mounted' behavior
I0415 07:13:25.357467   53016 rbd_attach.go:242] nbd module loaded
I0415 07:13:25.357527   53016 rbd_attach.go:256] kernel version "5.15.0-174-generic" supports cookie feature
I0415 07:13:25.385216   53016 rbd_attach.go:272] rbd-nbd tool supports cookie feature
I0415 07:13:25.386152   53016 server.go:114] listening for CSI-Addons requests on address: &net.UnixAddr{Name:"/csi/csi-addons.sock", Net:"unix"}
I0415 07:13:25.386217   53016 server.go:117] Listening for connections on address: &net.UnixAddr{Name:"//csi/csi.sock", Net:"unix"}
I0415 07:13:26.175318   53016 utils.go:198] ID: 1 GRPC call: /csi.v1.Identity/GetPluginInfo
I0415 07:13:26.177202   53016 utils.go:199] ID: 1 GRPC request: {}
I0415 07:13:26.177270   53016 identityserver-default.go:40] ID: 1 Using default GetPluginInfo
I0415 07:13:26.177365   53016 utils.go:205] ID: 1 GRPC response: {"name":"rbd.csi.ceph.com","vendor_version":"v3.11.0"}
I0415 07:13:26.513256   53016 utils.go:198] ID: 2 GRPC call: /csi.v1.Node/NodeGetInfo
I0415 07:13:26.513422   53016 utils.go:199] ID: 2 GRPC request: {}
I0415 07:13:26.513438   53016 nodeserver-default.go:45] ID: 2 Using default NodeGetInfo
I0415 07:13:26.513580   53016 utils.go:205] ID: 2 GRPC response: {"accessible_topology":{},"node_id":"instance"}
I0415 07:13:36.331187   53016 utils.go:198] ID: 3 GRPC call: /csi.v1.Node/NodeGetCapabilities
I0415 07:13:36.331396   53016 utils.go:199] ID: 3 GRPC request: {}
I0415 07:13:36.331700   53016 utils.go:205] ID: 3 GRPC response: {"capabilities":[{"Type":{"Rpc":{"type":1}}},{"Type":{"Rpc":{"type":2}}},{"Type":{"Rpc":{"type":3}}},{"Type":{"Rpc":{"type":5}}}]}
I0415 07:13:36.339171   53016 utils.go:198] ID: 4 GRPC call: /csi.v1.Node/NodeGetCapabilities
I0415 07:13:36.339201   53016 utils.go:199] ID: 4 GRPC request: {}
I0415 07:13:36.339318   53016 utils.go:205] ID: 4 GRPC response: {"capabilities":[{"Type":{"Rpc":{"type":1}}},{"Type":{"Rpc":{"type":2}}},{"Type":{"Rpc":{"type":3}}},{"Type":{"Rpc":{"type":5}}}]}
I0415 07:13:36.344443   53016 utils.go:198] ID: 5 GRPC call: /csi.v1.Node/NodeGetCapabilities
I0415 07:13:36.344514   53016 utils.go:199] ID: 5 GRPC request: {}
I0415 07:13:36.345491   53016 utils.go:205] ID: 5 GRPC response: {"capabilities":[{"Type":{"Rpc":{"type":1}}},{"Type":{"Rpc":{"type":2}}},{"Type":{"Rpc":{"type":3}}},{"Type":{"Rpc":{"type":5}}}]}
I0415 07:13:36.347037   53016 utils.go:198] ID: 6 Req-ID: 0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-a4e1cb02-589c-4fa5-a660-bb353f25e95c GRPC call: /csi.v1.Node/NodeStageVolume
I0415 07:13:36.347396   53016 utils.go:199] ID: 6 Req-ID: 0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-a4e1cb02-589c-4fa5-a660-bb353f25e95c GRPC request: {"secrets":"***stripped***","staging_target_path":"/var/lib/kubelet/plugins/kubernetes.io/csi/rbd.csi.ceph.com/de032685e5d85e952970d199fbbd15abc3680f87a6667321fbf2e3060558155b/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-a4e1cb02-589c-4fa5-a660-bb353f25e95c","journalPool":"kube","pool":"kube","storage.kubernetes.io/csiProvisionerIdentity":"1776237207319-5138-rbd.csi.ceph.com"},"volume_id":"0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-a4e1cb02-589c-4fa5-a660-bb353f25e95c"}
I0415 07:13:36.367417   53016 omap.go:89] ID: 6 Req-ID: 0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-a4e1cb02-589c-4fa5-a660-bb353f25e95c got omap values: (pool="kube", namespace="", name="csi.volume.a4e1cb02-589c-4fa5-a660-bb353f25e95c"): map[csi.imageid:37b4ce32126d csi.imagename:csi-vol-a4e1cb02-589c-4fa5-a660-bb353f25e95c csi.volname:pvc-c27f90cd-21fb-4843-ac92-6d0f666f8137 csi.volume.owner:default]
I0415 07:13:36.416252   53016 rbd_util.go:352] ID: 6 Req-ID: 0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-a4e1cb02-589c-4fa5-a660-bb353f25e95c checking for ImageFeatures: [layering]
I0415 07:13:36.449774   53016 cephcmds.go:105] ID: 6 Req-ID: 0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-a4e1cb02-589c-4fa5-a660-bb353f25e95c command succeeded: rbd [device list --format=json --device-type krbd]
I0415 07:13:36.474113   53016 rbd_attach.go:437] ID: 6 Req-ID: 0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-a4e1cb02-589c-4fa5-a660-bb353f25e95c rbd: map mon 162.253.55.221
I0415 07:13:36.559670   53016 cephcmds.go:105] ID: 6 Req-ID: 0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-a4e1cb02-589c-4fa5-a660-bb353f25e95c command succeeded: rbd [--id kube -m 162.253.55.221 --keyfile=***stripped*** map kube/csi-vol-a4e1cb02-589c-4fa5-a660-bb353f25e95c --device-type krbd --options noudev]
I0415 07:13:36.559773   53016 nodeserver.go:422] ID: 6 Req-ID: 0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-a4e1cb02-589c-4fa5-a660-bb353f25e95c rbd image: kube/csi-vol-a4e1cb02-589c-4fa5-a660-bb353f25e95c was successfully mapped at /dev/rbd0
I0415 07:13:36.559882   53016 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])
I0415 07:13:36.569164   53016 mount_linux.go:580] Output: ""
I0415 07:13:36.656532   53016 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])
I0415 07:13:36.670236   53016 mount_linux.go:580] Output: "DEVNAME=/dev/rbd0\nTYPE=ext4\n"
I0415 07:13:36.670381   53016 mount_linux.go:439] Checking for issues with fsck on disk: /dev/rbd0
I0415 07:13:36.699126   53016 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/de032685e5d85e952970d199fbbd15abc3680f87a6667321fbf2e3060558155b/globalmount/0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-a4e1cb02-589c-4fa5-a660-bb353f25e95c
I0415 07:13:36.699219   53016 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/de032685e5d85e952970d199fbbd15abc3680f87a6667321fbf2e3060558155b/globalmount/0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-a4e1cb02-589c-4fa5-a660-bb353f25e95c)
I0415 07:13:36.714943   53016 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])
I0415 07:13:36.726038   53016 mount_linux.go:580] Output: "DEVNAME=/dev/rbd0\nTYPE=ext4\n"
I0415 07:13:36.726059   53016 resizefs_linux.go:137] ResizeFs.needResize - checking mounted volume /dev/rbd0
I0415 07:13:36.729433   53016 resizefs_linux.go:141] Ext size: filesystem size=5368709120, block size=4096
I0415 07:13:36.729453   53016 resizefs_linux.go:156] Volume /dev/rbd0: device size=5368709120, filesystem size=5368709120, block size=4096
I0415 07:13:36.729472   53016 nodeserver.go:382] ID: 6 Req-ID: 0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-a4e1cb02-589c-4fa5-a660-bb353f25e95c rbd: successfully mounted volume 0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-a4e1cb02-589c-4fa5-a660-bb353f25e95c to stagingTargetPath /var/lib/kubelet/plugins/kubernetes.io/csi/rbd.csi.ceph.com/de032685e5d85e952970d199fbbd15abc3680f87a6667321fbf2e3060558155b/globalmount/0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-a4e1cb02-589c-4fa5-a660-bb353f25e95c
I0415 07:13:36.729559   53016 utils.go:205] ID: 6 Req-ID: 0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-a4e1cb02-589c-4fa5-a660-bb353f25e95c GRPC response: {}
I0415 07:13:36.730604   53016 utils.go:198] ID: 7 GRPC call: /csi.v1.Node/NodeGetCapabilities
I0415 07:13:36.730658   53016 utils.go:199] ID: 7 GRPC request: {}
I0415 07:13:36.730824   53016 utils.go:205] ID: 7 GRPC response: {"capabilities":[{"Type":{"Rpc":{"type":1}}},{"Type":{"Rpc":{"type":2}}},{"Type":{"Rpc":{"type":3}}},{"Type":{"Rpc":{"type":5}}}]}
I0415 07:13:36.735123   53016 utils.go:198] ID: 8 GRPC call: /csi.v1.Node/NodeGetCapabilities
I0415 07:13:36.735157   53016 utils.go:199] ID: 8 GRPC request: {}
I0415 07:13:36.735381   53016 utils.go:205] ID: 8 GRPC response: {"capabilities":[{"Type":{"Rpc":{"type":1}}},{"Type":{"Rpc":{"type":2}}},{"Type":{"Rpc":{"type":3}}},{"Type":{"Rpc":{"type":5}}}]}
I0415 07:13:36.736585   53016 utils.go:198] ID: 9 GRPC call: /csi.v1.Node/NodeGetCapabilities
I0415 07:13:36.736606   53016 utils.go:199] ID: 9 GRPC request: {}
I0415 07:13:36.736673   53016 utils.go:205] ID: 9 GRPC response: {"capabilities":[{"Type":{"Rpc":{"type":1}}},{"Type":{"Rpc":{"type":2}}},{"Type":{"Rpc":{"type":3}}},{"Type":{"Rpc":{"type":5}}}]}
I0415 07:13:36.737466   53016 utils.go:198] ID: 10 Req-ID: 0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-a4e1cb02-589c-4fa5-a660-bb353f25e95c GRPC call: /csi.v1.Node/NodePublishVolume
I0415 07:13:36.737603   53016 utils.go:199] ID: 10 Req-ID: 0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-a4e1cb02-589c-4fa5-a660-bb353f25e95c GRPC request: {"staging_target_path":"/var/lib/kubelet/plugins/kubernetes.io/csi/rbd.csi.ceph.com/de032685e5d85e952970d199fbbd15abc3680f87a6667321fbf2e3060558155b/globalmount","target_path":"/var/lib/kubelet/pods/091789b3-9a2d-4361-80a9-5f0fd88000eb/volumes/kubernetes.io~csi/pvc-c27f90cd-21fb-4843-ac92-6d0f666f8137/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-a4e1cb02-589c-4fa5-a660-bb353f25e95c","journalPool":"kube","pool":"kube","storage.kubernetes.io/csiProvisionerIdentity":"1776237207319-5138-rbd.csi.ceph.com"},"volume_id":"0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-a4e1cb02-589c-4fa5-a660-bb353f25e95c"}
I0415 07:13:36.737702   53016 nodeserver.go:859] ID: 10 Req-ID: 0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-a4e1cb02-589c-4fa5-a660-bb353f25e95c target /var/lib/kubelet/pods/091789b3-9a2d-4361-80a9-5f0fd88000eb/volumes/kubernetes.io~csi/pvc-c27f90cd-21fb-4843-ac92-6d0f666f8137/mount
isBlock false
fstype ext4
stagingPath /var/lib/kubelet/plugins/kubernetes.io/csi/rbd.csi.ceph.com/de032685e5d85e952970d199fbbd15abc3680f87a6667321fbf2e3060558155b/globalmount/0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-a4e1cb02-589c-4fa5-a660-bb353f25e95c
readonly false
mountflags [bind _netdev discard]
I0415 07:13:36.737724   53016 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/de032685e5d85e952970d199fbbd15abc3680f87a6667321fbf2e3060558155b/globalmount/0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-a4e1cb02-589c-4fa5-a660-bb353f25e95c /var/lib/kubelet/pods/091789b3-9a2d-4361-80a9-5f0fd88000eb/volumes/kubernetes.io~csi/pvc-c27f90cd-21fb-4843-ac92-6d0f666f8137/mount)
I0415 07:13:36.742991   53016 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/de032685e5d85e952970d199fbbd15abc3680f87a6667321fbf2e3060558155b/globalmount/0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-a4e1cb02-589c-4fa5-a660-bb353f25e95c /var/lib/kubelet/pods/091789b3-9a2d-4361-80a9-5f0fd88000eb/volumes/kubernetes.io~csi/pvc-c27f90cd-21fb-4843-ac92-6d0f666f8137/mount)
I0415 07:13:36.745630   53016 nodeserver.go:742] ID: 10 Req-ID: 0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-a4e1cb02-589c-4fa5-a660-bb353f25e95c rbd: successfully mounted stagingPath /var/lib/kubelet/plugins/kubernetes.io/csi/rbd.csi.ceph.com/de032685e5d85e952970d199fbbd15abc3680f87a6667321fbf2e3060558155b/globalmount/0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-a4e1cb02-589c-4fa5-a660-bb353f25e95c to targetPath /var/lib/kubelet/pods/091789b3-9a2d-4361-80a9-5f0fd88000eb/volumes/kubernetes.io~csi/pvc-c27f90cd-21fb-4843-ac92-6d0f666f8137/mount
I0415 07:13:36.745826   53016 utils.go:205] ID: 10 Req-ID: 0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-a4e1cb02-589c-4fa5-a660-bb353f25e95c GRPC response: {}
I0415 07:13:45.699717   53016 utils.go:198] ID: 11 Req-ID: 0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-a4e1cb02-589c-4fa5-a660-bb353f25e95c GRPC call: /csi.v1.Node/NodeUnpublishVolume
I0415 07:13:45.699881   53016 utils.go:199] ID: 11 Req-ID: 0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-a4e1cb02-589c-4fa5-a660-bb353f25e95c GRPC request: {"target_path":"/var/lib/kubelet/pods/091789b3-9a2d-4361-80a9-5f0fd88000eb/volumes/kubernetes.io~csi/pvc-c27f90cd-21fb-4843-ac92-6d0f666f8137/mount","volume_id":"0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-a4e1cb02-589c-4fa5-a660-bb353f25e95c"}
I0415 07:13:45.700014   53016 mount_linux.go:360] Unmounting /var/lib/kubelet/pods/091789b3-9a2d-4361-80a9-5f0fd88000eb/volumes/kubernetes.io~csi/pvc-c27f90cd-21fb-4843-ac92-6d0f666f8137/mount
I0415 07:13:45.705499   53016 nodeserver.go:945] ID: 11 Req-ID: 0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-a4e1cb02-589c-4fa5-a660-bb353f25e95c rbd: successfully unbound volume 0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-a4e1cb02-589c-4fa5-a660-bb353f25e95c from /var/lib/kubelet/pods/091789b3-9a2d-4361-80a9-5f0fd88000eb/volumes/kubernetes.io~csi/pvc-c27f90cd-21fb-4843-ac92-6d0f666f8137/mount
I0415 07:13:45.705550   53016 utils.go:205] ID: 11 Req-ID: 0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-a4e1cb02-589c-4fa5-a660-bb353f25e95c GRPC response: {}
I0415 07:13:45.802216   53016 utils.go:198] ID: 12 GRPC call: /csi.v1.Node/NodeGetCapabilities
I0415 07:13:45.802266   53016 utils.go:199] ID: 12 GRPC request: {}
I0415 07:13:45.802381   53016 utils.go:205] ID: 12 GRPC response: {"capabilities":[{"Type":{"Rpc":{"type":1}}},{"Type":{"Rpc":{"type":2}}},{"Type":{"Rpc":{"type":3}}},{"Type":{"Rpc":{"type":5}}}]}
I0415 07:13:45.803838   53016 utils.go:198] ID: 13 Req-ID: 0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-a4e1cb02-589c-4fa5-a660-bb353f25e95c GRPC call: /csi.v1.Node/NodeUnstageVolume
I0415 07:13:45.803970   53016 utils.go:199] ID: 13 Req-ID: 0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-a4e1cb02-589c-4fa5-a660-bb353f25e95c GRPC request: {"staging_target_path":"/var/lib/kubelet/plugins/kubernetes.io/csi/rbd.csi.ceph.com/de032685e5d85e952970d199fbbd15abc3680f87a6667321fbf2e3060558155b/globalmount","volume_id":"0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-a4e1cb02-589c-4fa5-a660-bb353f25e95c"}
I0415 07:13:45.804088   53016 mount_linux.go:360] Unmounting /var/lib/kubelet/plugins/kubernetes.io/csi/rbd.csi.ceph.com/de032685e5d85e952970d199fbbd15abc3680f87a6667321fbf2e3060558155b/globalmount/0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-a4e1cb02-589c-4fa5-a660-bb353f25e95c
I0415 07:13:45.840245   53016 nodeserver.go:1001] ID: 13 Req-ID: 0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-a4e1cb02-589c-4fa5-a660-bb353f25e95c successfully unmounted volume (0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-a4e1cb02-589c-4fa5-a660-bb353f25e95c) from staging path (/var/lib/kubelet/plugins/kubernetes.io/csi/rbd.csi.ceph.com/de032685e5d85e952970d199fbbd15abc3680f87a6667321fbf2e3060558155b/globalmount/0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-a4e1cb02-589c-4fa5-a660-bb353f25e95c)
I0415 07:13:45.911619   53016 cephcmds.go:105] ID: 13 Req-ID: 0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-a4e1cb02-589c-4fa5-a660-bb353f25e95c command succeeded: rbd [unmap kube/csi-vol-a4e1cb02-589c-4fa5-a660-bb353f25e95c --device-type krbd --options noudev]
I0415 07:13:45.911670   53016 nodeserver.go:1059] ID: 13 Req-ID: 0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-a4e1cb02-589c-4fa5-a660-bb353f25e95c successfully unmapped volume (0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-a4e1cb02-589c-4fa5-a660-bb353f25e95c)
I0415 07:13:45.911841   53016 utils.go:205] ID: 13 Req-ID: 0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-a4e1cb02-589c-4fa5-a660-bb353f25e95c GRPC response: {}