I0425 11:33:47.039689   55648 cephcsi.go:191] Driver version: v3.11.0 and Git version: bc24b5eca87626d690a29effa9d7420cc0154a7a
I0425 11:33:47.039850   55648 cephcsi.go:268] Initial PID limit is set to -1
I0425 11:33:47.039881   55648 cephcsi.go:274] Reconfigured PID limit to -1 (max)
I0425 11:33:47.039899   55648 cephcsi.go:223] Starting driver type: rbd with name: rbd.csi.ceph.com
I0425 11:33:47.052958   55648 mount_linux.go:282] Detected umount with safe 'not mounted' behavior
I0425 11:33:47.076679   55648 rbd_attach.go:242] nbd module loaded
I0425 11:33:47.076734   55648 rbd_attach.go:256] kernel version "5.15.0-176-generic" supports cookie feature
I0425 11:33:47.099049   55648 rbd_attach.go:272] rbd-nbd tool supports cookie feature
I0425 11:33:47.099596   55648 server.go:114] listening for CSI-Addons requests on address: &net.UnixAddr{Name:"/csi/csi-addons.sock", Net:"unix"}
I0425 11:33:47.099702   55648 server.go:117] Listening for connections on address: &net.UnixAddr{Name:"//csi/csi.sock", Net:"unix"}
I0425 11:33:48.207801   55648 utils.go:198] ID: 1 GRPC call: /csi.v1.Identity/GetPluginInfo
I0425 11:33:48.209068   55648 utils.go:199] ID: 1 GRPC request: {}
I0425 11:33:48.209087   55648 identityserver-default.go:40] ID: 1 Using default GetPluginInfo
I0425 11:33:48.209133   55648 utils.go:205] ID: 1 GRPC response: {"name":"rbd.csi.ceph.com","vendor_version":"v3.11.0"}
I0425 11:33:48.333156   55648 utils.go:198] ID: 2 GRPC call: /csi.v1.Node/NodeGetInfo
I0425 11:33:48.333370   55648 utils.go:199] ID: 2 GRPC request: {}
I0425 11:33:48.333391   55648 nodeserver-default.go:45] ID: 2 Using default NodeGetInfo
I0425 11:33:48.333573   55648 utils.go:205] ID: 2 GRPC response: {"accessible_topology":{},"node_id":"instance"}
I0425 11:33:59.477390   55648 utils.go:198] ID: 3 GRPC call: /csi.v1.Node/NodeGetCapabilities
I0425 11:33:59.477504   55648 utils.go:199] ID: 3 GRPC request: {}
I0425 11:33:59.477687   55648 utils.go:205] ID: 3 GRPC response: {"capabilities":[{"Type":{"Rpc":{"type":1}}},{"Type":{"Rpc":{"type":2}}},{"Type":{"Rpc":{"type":3}}},{"Type":{"Rpc":{"type":5}}}]}
I0425 11:33:59.483582   55648 utils.go:198] ID: 4 GRPC call: /csi.v1.Node/NodeGetCapabilities
I0425 11:33:59.483651   55648 utils.go:199] ID: 4 GRPC request: {}
I0425 11:33:59.483797   55648 utils.go:205] ID: 4 GRPC response: {"capabilities":[{"Type":{"Rpc":{"type":1}}},{"Type":{"Rpc":{"type":2}}},{"Type":{"Rpc":{"type":3}}},{"Type":{"Rpc":{"type":5}}}]}
I0425 11:33:59.484970   55648 utils.go:198] ID: 5 GRPC call: /csi.v1.Node/NodeGetCapabilities
I0425 11:33:59.485042   55648 utils.go:199] ID: 5 GRPC request: {}
I0425 11:33:59.485119   55648 utils.go:205] ID: 5 GRPC response: {"capabilities":[{"Type":{"Rpc":{"type":1}}},{"Type":{"Rpc":{"type":2}}},{"Type":{"Rpc":{"type":3}}},{"Type":{"Rpc":{"type":5}}}]}
I0425 11:33:59.486333   55648 utils.go:198] ID: 6 Req-ID: 0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-541c069f-691b-4394-9549-e7d6c20c862f GRPC call: /csi.v1.Node/NodeStageVolume
I0425 11:33:59.486653   55648 utils.go:199] ID: 6 Req-ID: 0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-541c069f-691b-4394-9549-e7d6c20c862f GRPC request: {"secrets":"***stripped***","staging_target_path":"/var/lib/kubelet/plugins/kubernetes.io/csi/rbd.csi.ceph.com/03cc22f39d71700f7fd7615fbb8e2fc1676a28cf6689c1af25f4a260bc49db57/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-541c069f-691b-4394-9549-e7d6c20c862f","journalPool":"kube","pool":"kube","storage.kubernetes.io/csiProvisionerIdentity":"1777116829408-9167-rbd.csi.ceph.com"},"volume_id":"0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-541c069f-691b-4394-9549-e7d6c20c862f"}
I0425 11:33:59.505553   55648 omap.go:89] ID: 6 Req-ID: 0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-541c069f-691b-4394-9549-e7d6c20c862f got omap values: (pool="kube", namespace="", name="csi.volume.541c069f-691b-4394-9549-e7d6c20c862f"): map[csi.imageid:37b364149d89 csi.imagename:csi-vol-541c069f-691b-4394-9549-e7d6c20c862f csi.volname:pvc-59a5d16a-c251-473a-8de4-58c2425950c0 csi.volume.owner:default]
I0425 11:33:59.556555   55648 rbd_util.go:352] ID: 6 Req-ID: 0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-541c069f-691b-4394-9549-e7d6c20c862f checking for ImageFeatures: [layering]
I0425 11:33:59.595475   55648 cephcmds.go:105] ID: 6 Req-ID: 0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-541c069f-691b-4394-9549-e7d6c20c862f command succeeded: rbd [device list --format=json --device-type krbd]
I0425 11:33:59.620993   55648 rbd_attach.go:437] ID: 6 Req-ID: 0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-541c069f-691b-4394-9549-e7d6c20c862f rbd: map mon 199.204.45.89
I0425 11:33:59.704005   55648 cephcmds.go:105] ID: 6 Req-ID: 0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-541c069f-691b-4394-9549-e7d6c20c862f command succeeded: rbd [--id kube -m 199.204.45.89 --keyfile=***stripped*** map kube/csi-vol-541c069f-691b-4394-9549-e7d6c20c862f --device-type krbd --options noudev]
I0425 11:33:59.704058   55648 nodeserver.go:422] ID: 6 Req-ID: 0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-541c069f-691b-4394-9549-e7d6c20c862f rbd image: kube/csi-vol-541c069f-691b-4394-9549-e7d6c20c862f was successfully mapped at /dev/rbd0
I0425 11:33:59.704189   55648 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])
I0425 11:33:59.717387   55648 mount_linux.go:580] Output: ""
I0425 11:33:59.885524   55648 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])
I0425 11:33:59.900484   55648 mount_linux.go:580] Output: "DEVNAME=/dev/rbd0\nTYPE=ext4\n"
I0425 11:33:59.900501   55648 mount_linux.go:439] Checking for issues with fsck on disk: /dev/rbd0
I0425 11:33:59.937041   55648 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/03cc22f39d71700f7fd7615fbb8e2fc1676a28cf6689c1af25f4a260bc49db57/globalmount/0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-541c069f-691b-4394-9549-e7d6c20c862f
I0425 11:33:59.937082   55648 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/03cc22f39d71700f7fd7615fbb8e2fc1676a28cf6689c1af25f4a260bc49db57/globalmount/0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-541c069f-691b-4394-9549-e7d6c20c862f)
I0425 11:33:59.953994   55648 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])
I0425 11:33:59.962601   55648 mount_linux.go:580] Output: "DEVNAME=/dev/rbd0\nTYPE=ext4\n"
I0425 11:33:59.962623   55648 resizefs_linux.go:137] ResizeFs.needResize - checking mounted volume /dev/rbd0
I0425 11:33:59.965854   55648 resizefs_linux.go:141] Ext size: filesystem size=5368709120, block size=4096
I0425 11:33:59.965870   55648 resizefs_linux.go:156] Volume /dev/rbd0: device size=5368709120, filesystem size=5368709120, block size=4096
I0425 11:33:59.965891   55648 nodeserver.go:382] ID: 6 Req-ID: 0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-541c069f-691b-4394-9549-e7d6c20c862f rbd: successfully mounted volume 0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-541c069f-691b-4394-9549-e7d6c20c862f to stagingTargetPath /var/lib/kubelet/plugins/kubernetes.io/csi/rbd.csi.ceph.com/03cc22f39d71700f7fd7615fbb8e2fc1676a28cf6689c1af25f4a260bc49db57/globalmount/0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-541c069f-691b-4394-9549-e7d6c20c862f
I0425 11:33:59.965983   55648 utils.go:205] ID: 6 Req-ID: 0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-541c069f-691b-4394-9549-e7d6c20c862f GRPC response: {}
I0425 11:33:59.967397   55648 utils.go:198] ID: 7 GRPC call: /csi.v1.Node/NodeGetCapabilities
I0425 11:33:59.967441   55648 utils.go:199] ID: 7 GRPC request: {}
I0425 11:33:59.967559   55648 utils.go:205] ID: 7 GRPC response: {"capabilities":[{"Type":{"Rpc":{"type":1}}},{"Type":{"Rpc":{"type":2}}},{"Type":{"Rpc":{"type":3}}},{"Type":{"Rpc":{"type":5}}}]}
I0425 11:33:59.971043   55648 utils.go:198] ID: 8 GRPC call: /csi.v1.Node/NodeGetCapabilities
I0425 11:33:59.971075   55648 utils.go:199] ID: 8 GRPC request: {}
I0425 11:33:59.971161   55648 utils.go:205] ID: 8 GRPC response: {"capabilities":[{"Type":{"Rpc":{"type":1}}},{"Type":{"Rpc":{"type":2}}},{"Type":{"Rpc":{"type":3}}},{"Type":{"Rpc":{"type":5}}}]}
I0425 11:33:59.972387   55648 utils.go:198] ID: 9 GRPC call: /csi.v1.Node/NodeGetCapabilities
I0425 11:33:59.972414   55648 utils.go:199] ID: 9 GRPC request: {}
I0425 11:33:59.972499   55648 utils.go:205] ID: 9 GRPC response: {"capabilities":[{"Type":{"Rpc":{"type":1}}},{"Type":{"Rpc":{"type":2}}},{"Type":{"Rpc":{"type":3}}},{"Type":{"Rpc":{"type":5}}}]}
I0425 11:33:59.973479   55648 utils.go:198] ID: 10 Req-ID: 0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-541c069f-691b-4394-9549-e7d6c20c862f GRPC call: /csi.v1.Node/NodePublishVolume
I0425 11:33:59.973689   55648 utils.go:199] ID: 10 Req-ID: 0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-541c069f-691b-4394-9549-e7d6c20c862f GRPC request: {"staging_target_path":"/var/lib/kubelet/plugins/kubernetes.io/csi/rbd.csi.ceph.com/03cc22f39d71700f7fd7615fbb8e2fc1676a28cf6689c1af25f4a260bc49db57/globalmount","target_path":"/var/lib/kubelet/pods/4efd6397-bb50-40a4-b3b3-1d74325c47e3/volumes/kubernetes.io~csi/pvc-59a5d16a-c251-473a-8de4-58c2425950c0/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-541c069f-691b-4394-9549-e7d6c20c862f","journalPool":"kube","pool":"kube","storage.kubernetes.io/csiProvisionerIdentity":"1777116829408-9167-rbd.csi.ceph.com"},"volume_id":"0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-541c069f-691b-4394-9549-e7d6c20c862f"}
I0425 11:33:59.973849   55648 nodeserver.go:859] ID: 10 Req-ID: 0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-541c069f-691b-4394-9549-e7d6c20c862f target /var/lib/kubelet/pods/4efd6397-bb50-40a4-b3b3-1d74325c47e3/volumes/kubernetes.io~csi/pvc-59a5d16a-c251-473a-8de4-58c2425950c0/mount
isBlock false
fstype ext4
stagingPath /var/lib/kubelet/plugins/kubernetes.io/csi/rbd.csi.ceph.com/03cc22f39d71700f7fd7615fbb8e2fc1676a28cf6689c1af25f4a260bc49db57/globalmount/0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-541c069f-691b-4394-9549-e7d6c20c862f
readonly false
mountflags [bind _netdev discard]
I0425 11:33:59.973868   55648 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/03cc22f39d71700f7fd7615fbb8e2fc1676a28cf6689c1af25f4a260bc49db57/globalmount/0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-541c069f-691b-4394-9549-e7d6c20c862f /var/lib/kubelet/pods/4efd6397-bb50-40a4-b3b3-1d74325c47e3/volumes/kubernetes.io~csi/pvc-59a5d16a-c251-473a-8de4-58c2425950c0/mount)
I0425 11:33:59.978853   55648 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/03cc22f39d71700f7fd7615fbb8e2fc1676a28cf6689c1af25f4a260bc49db57/globalmount/0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-541c069f-691b-4394-9549-e7d6c20c862f /var/lib/kubelet/pods/4efd6397-bb50-40a4-b3b3-1d74325c47e3/volumes/kubernetes.io~csi/pvc-59a5d16a-c251-473a-8de4-58c2425950c0/mount)
I0425 11:33:59.980534   55648 nodeserver.go:742] ID: 10 Req-ID: 0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-541c069f-691b-4394-9549-e7d6c20c862f rbd: successfully mounted stagingPath /var/lib/kubelet/plugins/kubernetes.io/csi/rbd.csi.ceph.com/03cc22f39d71700f7fd7615fbb8e2fc1676a28cf6689c1af25f4a260bc49db57/globalmount/0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-541c069f-691b-4394-9549-e7d6c20c862f to targetPath /var/lib/kubelet/pods/4efd6397-bb50-40a4-b3b3-1d74325c47e3/volumes/kubernetes.io~csi/pvc-59a5d16a-c251-473a-8de4-58c2425950c0/mount
I0425 11:33:59.980596   55648 utils.go:205] ID: 10 Req-ID: 0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-541c069f-691b-4394-9549-e7d6c20c862f GRPC response: {}
I0425 11:34:15.953326   55648 utils.go:198] ID: 11 Req-ID: 0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-541c069f-691b-4394-9549-e7d6c20c862f GRPC call: /csi.v1.Node/NodeUnpublishVolume
I0425 11:34:15.953514   55648 utils.go:199] ID: 11 Req-ID: 0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-541c069f-691b-4394-9549-e7d6c20c862f GRPC request: {"target_path":"/var/lib/kubelet/pods/4efd6397-bb50-40a4-b3b3-1d74325c47e3/volumes/kubernetes.io~csi/pvc-59a5d16a-c251-473a-8de4-58c2425950c0/mount","volume_id":"0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-541c069f-691b-4394-9549-e7d6c20c862f"}
I0425 11:34:15.953666   55648 mount_linux.go:360] Unmounting /var/lib/kubelet/pods/4efd6397-bb50-40a4-b3b3-1d74325c47e3/volumes/kubernetes.io~csi/pvc-59a5d16a-c251-473a-8de4-58c2425950c0/mount
I0425 11:34:15.958503   55648 nodeserver.go:945] ID: 11 Req-ID: 0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-541c069f-691b-4394-9549-e7d6c20c862f rbd: successfully unbound volume 0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-541c069f-691b-4394-9549-e7d6c20c862f from /var/lib/kubelet/pods/4efd6397-bb50-40a4-b3b3-1d74325c47e3/volumes/kubernetes.io~csi/pvc-59a5d16a-c251-473a-8de4-58c2425950c0/mount
I0425 11:34:15.958597   55648 utils.go:205] ID: 11 Req-ID: 0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-541c069f-691b-4394-9549-e7d6c20c862f GRPC response: {}
I0425 11:34:16.056180   55648 utils.go:198] ID: 12 GRPC call: /csi.v1.Node/NodeGetCapabilities
I0425 11:34:16.056218   55648 utils.go:199] ID: 12 GRPC request: {}
I0425 11:34:16.056340   55648 utils.go:205] ID: 12 GRPC response: {"capabilities":[{"Type":{"Rpc":{"type":1}}},{"Type":{"Rpc":{"type":2}}},{"Type":{"Rpc":{"type":3}}},{"Type":{"Rpc":{"type":5}}}]}
I0425 11:34:16.057345   55648 utils.go:198] ID: 13 Req-ID: 0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-541c069f-691b-4394-9549-e7d6c20c862f GRPC call: /csi.v1.Node/NodeUnstageVolume
I0425 11:34:16.057442   55648 utils.go:199] ID: 13 Req-ID: 0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-541c069f-691b-4394-9549-e7d6c20c862f GRPC request: {"staging_target_path":"/var/lib/kubelet/plugins/kubernetes.io/csi/rbd.csi.ceph.com/03cc22f39d71700f7fd7615fbb8e2fc1676a28cf6689c1af25f4a260bc49db57/globalmount","volume_id":"0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-541c069f-691b-4394-9549-e7d6c20c862f"}
I0425 11:34:16.057544   55648 mount_linux.go:360] Unmounting /var/lib/kubelet/plugins/kubernetes.io/csi/rbd.csi.ceph.com/03cc22f39d71700f7fd7615fbb8e2fc1676a28cf6689c1af25f4a260bc49db57/globalmount/0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-541c069f-691b-4394-9549-e7d6c20c862f
I0425 11:34:16.368718   55648 nodeserver.go:1001] ID: 13 Req-ID: 0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-541c069f-691b-4394-9549-e7d6c20c862f successfully unmounted volume (0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-541c069f-691b-4394-9549-e7d6c20c862f) from staging path (/var/lib/kubelet/plugins/kubernetes.io/csi/rbd.csi.ceph.com/03cc22f39d71700f7fd7615fbb8e2fc1676a28cf6689c1af25f4a260bc49db57/globalmount/0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-541c069f-691b-4394-9549-e7d6c20c862f)
I0425 11:34:16.543647   55648 cephcmds.go:105] ID: 13 Req-ID: 0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-541c069f-691b-4394-9549-e7d6c20c862f command succeeded: rbd [unmap kube/csi-vol-541c069f-691b-4394-9549-e7d6c20c862f --device-type krbd --options noudev]
I0425 11:34:16.543693   55648 nodeserver.go:1059] ID: 13 Req-ID: 0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-541c069f-691b-4394-9549-e7d6c20c862f successfully unmapped volume (0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-541c069f-691b-4394-9549-e7d6c20c862f)
I0425 11:34:16.543965   55648 utils.go:205] ID: 13 Req-ID: 0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-541c069f-691b-4394-9549-e7d6c20c862f GRPC response: {}