I0324 14:53:50.150316       1 cephcsi.go:171] Driver version: v3.5.1 and Git version: 00f88e58a0b08be3d7ea009a0cfde8dca23021bf
E0324 14:53:50.150498       1 cephcsi.go:187] Failed to get the PID limit, can not reconfigure: could not find a cgroup for 'pids'
I0324 14:53:50.150538       1 cephcsi.go:220] Starting driver type: rbd with name: rbd.csi.ceph.com
I0324 14:53:50.150782       1 driver.go:94] Enabling controller service capability: CREATE_DELETE_VOLUME
I0324 14:53:50.150797       1 driver.go:94] Enabling controller service capability: CREATE_DELETE_SNAPSHOT
I0324 14:53:50.150803       1 driver.go:94] Enabling controller service capability: CLONE_VOLUME
I0324 14:53:50.150809       1 driver.go:94] Enabling controller service capability: EXPAND_VOLUME
I0324 14:53:50.150816       1 driver.go:106] Enabling volume access mode: SINGLE_NODE_WRITER
I0324 14:53:50.150822       1 driver.go:106] Enabling volume access mode: MULTI_NODE_MULTI_WRITER
I0324 14:53:50.150827       1 driver.go:106] Enabling volume access mode: SINGLE_NODE_SINGLE_WRITER
I0324 14:53:50.150832       1 driver.go:106] Enabling volume access mode: SINGLE_NODE_MULTI_WRITER
I0324 14:53:50.151073       1 server.go:126] Listening for connections on address: &net.UnixAddr{Name:"//csi/csi-provisioner.sock", Net:"unix"}
I0324 14:53:50.151088       1 server.go:114] listening for CSI-Addons requests on address: &net.UnixAddr{Name:"/csi/csi-addons.sock", Net:"unix"}
I0324 14:53:50.611206       1 utils.go:191] ID: 1 GRPC call: /csi.v1.Identity/Probe
I0324 14:53:50.613300       1 utils.go:195] ID: 1 GRPC request: {}
I0324 14:53:50.613392       1 utils.go:202] ID: 1 GRPC response: {}
I0324 14:53:50.614888       1 utils.go:191] ID: 2 GRPC call: /csi.v1.Identity/GetPluginInfo
I0324 14:53:50.614926       1 utils.go:195] ID: 2 GRPC request: {}
I0324 14:53:50.614935       1 identityserver-default.go:38] ID: 2 Using default GetPluginInfo
I0324 14:53:50.614977       1 utils.go:202] ID: 2 GRPC response: {"name":"rbd.csi.ceph.com","vendor_version":"v3.5.1"}
I0324 14:53:50.615869       1 utils.go:191] ID: 3 GRPC call: /csi.v1.Identity/GetPluginCapabilities
I0324 14:53:50.615897       1 utils.go:195] ID: 3 GRPC request: {}
I0324 14:53:50.616064       1 utils.go:202] ID: 3 GRPC response: {"capabilities":[{"Type":{"Service":{"type":1}}},{"Type":{"VolumeExpansion":{"type":1}}},{"Type":{"Service":{"type":2}}}]}
I0324 14:53:50.616763       1 utils.go:191] ID: 4 GRPC call: /csi.v1.Controller/ControllerGetCapabilities
I0324 14:53:50.616792       1 utils.go:195] ID: 4 GRPC request: {}
I0324 14:53:50.616801       1 controllerserver-default.go:74] ID: 4 Using default ControllerGetCapabilities
I0324 14:53:50.616917       1 utils.go:202] ID: 4 GRPC response: {"capabilities":[{"Type":{"Rpc":{"type":1}}},{"Type":{"Rpc":{"type":5}}},{"Type":{"Rpc":{"type":7}}},{"Type":{"Rpc":{"type":9}}}]}
I0324 14:53:50.617525       1 utils.go:191] ID: 5 GRPC call: /csi.v1.Controller/ControllerGetCapabilities
I0324 14:53:50.617551       1 utils.go:195] ID: 5 GRPC request: {}
I0324 14:53:50.617556       1 controllerserver-default.go:74] ID: 5 Using default ControllerGetCapabilities
I0324 14:53:50.617626       1 utils.go:202] ID: 5 GRPC response: {"capabilities":[{"Type":{"Rpc":{"type":1}}},{"Type":{"Rpc":{"type":5}}},{"Type":{"Rpc":{"type":7}}},{"Type":{"Rpc":{"type":9}}}]}
I0324 14:53:50.825184       1 utils.go:191] ID: 6 GRPC call: /csi.v1.Identity/Probe
I0324 14:53:50.825284       1 utils.go:195] ID: 6 GRPC request: {}
I0324 14:53:50.825320       1 utils.go:202] ID: 6 GRPC response: {}
I0324 14:53:50.826707       1 utils.go:191] ID: 7 GRPC call: /csi.v1.Identity/GetPluginInfo
I0324 14:53:50.826751       1 utils.go:195] ID: 7 GRPC request: {}
I0324 14:53:50.826762       1 identityserver-default.go:38] ID: 7 Using default GetPluginInfo
I0324 14:53:50.826800       1 utils.go:202] ID: 7 GRPC response: {"name":"rbd.csi.ceph.com","vendor_version":"v3.5.1"}
I0324 14:53:50.829142       1 utils.go:191] ID: 8 GRPC call: /csi.v1.Identity/Probe
I0324 14:53:50.829198       1 utils.go:195] ID: 8 GRPC request: {}
I0324 14:53:50.829239       1 utils.go:202] ID: 8 GRPC response: {}
I0324 14:53:50.829796       1 utils.go:191] ID: 9 GRPC call: /csi.v1.Identity/GetPluginCapabilities
I0324 14:53:50.829824       1 utils.go:195] ID: 9 GRPC request: {}
I0324 14:53:50.829955       1 utils.go:202] ID: 9 GRPC response: {"capabilities":[{"Type":{"Service":{"type":1}}},{"Type":{"VolumeExpansion":{"type":1}}},{"Type":{"Service":{"type":2}}}]}
I0324 14:53:50.830886       1 utils.go:191] ID: 10 GRPC call: /csi.v1.Controller/ControllerGetCapabilities
I0324 14:53:50.830911       1 utils.go:195] ID: 10 GRPC request: {}
I0324 14:53:50.830918       1 controllerserver-default.go:74] ID: 10 Using default ControllerGetCapabilities
I0324 14:53:50.830983       1 utils.go:202] ID: 10 GRPC response: {"capabilities":[{"Type":{"Rpc":{"type":1}}},{"Type":{"Rpc":{"type":5}}},{"Type":{"Rpc":{"type":7}}},{"Type":{"Rpc":{"type":9}}}]}
I0324 14:53:51.046982       1 utils.go:191] ID: 11 GRPC call: /csi.v1.Identity/Probe
I0324 14:53:51.047064       1 utils.go:195] ID: 11 GRPC request: {}
I0324 14:53:51.047094       1 utils.go:202] ID: 11 GRPC response: {}
I0324 14:53:51.048189       1 utils.go:191] ID: 12 GRPC call: /csi.v1.Identity/GetPluginInfo
I0324 14:53:51.048239       1 utils.go:195] ID: 12 GRPC request: {}
I0324 14:53:51.048251       1 identityserver-default.go:38] ID: 12 Using default GetPluginInfo
I0324 14:53:51.048347       1 utils.go:202] ID: 12 GRPC response: {"name":"rbd.csi.ceph.com","vendor_version":"v3.5.1"}
I0324 14:53:51.051256       1 utils.go:191] ID: 13 GRPC call: /csi.v1.Identity/Probe
I0324 14:53:51.051303       1 utils.go:195] ID: 13 GRPC request: {}
I0324 14:53:51.051327       1 utils.go:202] ID: 13 GRPC response: {}
I0324 14:53:51.051782       1 utils.go:191] ID: 14 GRPC call: /csi.v1.Identity/GetPluginCapabilities
I0324 14:53:51.051934       1 utils.go:195] ID: 14 GRPC request: {}
I0324 14:53:51.052164       1 utils.go:202] ID: 14 GRPC response: {"capabilities":[{"Type":{"Service":{"type":1}}},{"Type":{"VolumeExpansion":{"type":1}}},{"Type":{"Service":{"type":2}}}]}
I0324 14:53:51.053399       1 utils.go:191] ID: 15 GRPC call: /csi.v1.Controller/ControllerGetCapabilities
I0324 14:53:51.053556       1 utils.go:195] ID: 15 GRPC request: {}
I0324 14:53:51.053570       1 controllerserver-default.go:74] ID: 15 Using default ControllerGetCapabilities
I0324 14:53:51.053697       1 utils.go:202] ID: 15 GRPC response: {"capabilities":[{"Type":{"Rpc":{"type":1}}},{"Type":{"Rpc":{"type":5}}},{"Type":{"Rpc":{"type":7}}},{"Type":{"Rpc":{"type":9}}}]}
I0324 14:53:51.110132       1 utils.go:191] ID: 16 GRPC call: /csi.v1.Identity/GetPluginInfo
I0324 14:53:51.110355       1 utils.go:195] ID: 16 GRPC request: {}
I0324 14:53:51.110380       1 identityserver-default.go:38] ID: 16 Using default GetPluginInfo
I0324 14:53:51.110504       1 utils.go:202] ID: 16 GRPC response: {"name":"rbd.csi.ceph.com","vendor_version":"v3.5.1"}
I0324 14:53:51.111651       1 utils.go:191] ID: 17 GRPC call: /csi.v1.Identity/Probe
I0324 14:53:51.111832       1 utils.go:195] ID: 17 GRPC request: {}
I0324 14:53:51.111888       1 utils.go:202] ID: 17 GRPC response: {}
I0324 14:53:51.112619       1 utils.go:191] ID: 18 GRPC call: /csi.v1.Controller/ControllerGetCapabilities
I0324 14:53:51.112759       1 utils.go:195] ID: 18 GRPC request: {}
I0324 14:53:51.112778       1 controllerserver-default.go:74] ID: 18 Using default ControllerGetCapabilities
I0324 14:53:51.113013       1 utils.go:202] ID: 18 GRPC response: {"capabilities":[{"Type":{"Rpc":{"type":1}}},{"Type":{"Rpc":{"type":5}}},{"Type":{"Rpc":{"type":7}}},{"Type":{"Rpc":{"type":9}}}]}
I0324 14:54:50.366475       1 utils.go:191] ID: 19 GRPC call: /csi.v1.Identity/Probe
I0324 14:54:50.366558       1 utils.go:195] ID: 19 GRPC request: {}
I0324 14:54:50.366584       1 utils.go:202] ID: 19 GRPC response: {}
I0324 14:55:50.366193       1 utils.go:191] ID: 20 GRPC call: /csi.v1.Identity/Probe
I0324 14:55:50.366301       1 utils.go:195] ID: 20 GRPC request: {}
I0324 14:55:50.366324       1 utils.go:202] ID: 20 GRPC response: {}
I0324 14:56:50.365473       1 utils.go:191] ID: 21 GRPC call: /csi.v1.Identity/Probe
I0324 14:56:50.365545       1 utils.go:195] ID: 21 GRPC request: {}
I0324 14:56:50.365569       1 utils.go:202] ID: 21 GRPC response: {}
I0324 14:56:50.684094       1 utils.go:191] ID: 22 Req-ID: pvc-a66faf7c-d1cc-4660-ad22-6b680df02e4b GRPC call: /csi.v1.Controller/CreateVolume
I0324 14:56:50.684350       1 utils.go:195] ID: 22 Req-ID: pvc-a66faf7c-d1cc-4660-ad22-6b680df02e4b GRPC request: {"capacity_range":{"required_bytes":5368709120},"name":"pvc-a66faf7c-d1cc-4660-ad22-6b680df02e4b","parameters":{"clusterID":"4837cbf8-4f90-4300-b3f6-726c9b9f89b4","csi.storage.k8s.io/pv/name":"pvc-a66faf7c-d1cc-4660-ad22-6b680df02e4b","csi.storage.k8s.io/pvc/name":"test-pvc","csi.storage.k8s.io/pvc/namespace":"default","imageFeatures":"layering","pool":"kube","thickProvision":"false"},"secrets":"***stripped***","volume_capabilities":[{"AccessType":{"Mount":{"fs_type":"ext4","mount_flags":["discard"]}},"access_mode":{"mode":1}}]}
I0324 14:56:50.684540       1 rbd_util.go:1296] ID: 22 Req-ID: pvc-a66faf7c-d1cc-4660-ad22-6b680df02e4b setting disableInUseChecks: false image features: [layering] mounter: rbd
W0324 14:56:50.684561       1 controllerserver.go:1555] thick-provisioning is deprecated and will be removed in a future release
E0324 14:56:50.709018       1 omap.go:78] ID: 22 Req-ID: pvc-a66faf7c-d1cc-4660-ad22-6b680df02e4b omap not found (pool="kube", namespace="", name="csi.volumes.default"): rados: ret=-2, No such file or directory
I0324 14:56:50.723245       1 omap.go:155] ID: 22 Req-ID: pvc-a66faf7c-d1cc-4660-ad22-6b680df02e4b set omap keys (pool="kube", namespace="", name="csi.volumes.default"): map[csi.volume.pvc-a66faf7c-d1cc-4660-ad22-6b680df02e4b:b051d923-2791-11f1-8013-d61b816c4dbe])
I0324 14:56:50.729613       1 omap.go:155] ID: 22 Req-ID: pvc-a66faf7c-d1cc-4660-ad22-6b680df02e4b set omap keys (pool="kube", namespace="", name="csi.volume.b051d923-2791-11f1-8013-d61b816c4dbe"): map[csi.imagename:csi-vol-b051d923-2791-11f1-8013-d61b816c4dbe csi.volname:pvc-a66faf7c-d1cc-4660-ad22-6b680df02e4b csi.volume.owner:default])
I0324 14:56:50.729655       1 rbd_journal.go:482] ID: 22 Req-ID: pvc-a66faf7c-d1cc-4660-ad22-6b680df02e4b generated Volume ID (0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-b051d923-2791-11f1-8013-d61b816c4dbe) and image name (csi-vol-b051d923-2791-11f1-8013-d61b816c4dbe) for request name (pvc-a66faf7c-d1cc-4660-ad22-6b680df02e4b)
I0324 14:56:50.729784       1 rbd_util.go:352] ID: 22 Req-ID: pvc-a66faf7c-d1cc-4660-ad22-6b680df02e4b rbd: create kube/csi-vol-b051d923-2791-11f1-8013-d61b816c4dbe size 5120M (features: [layering]) using mon 199.19.213.61
I0324 14:56:52.602776       1 controllerserver.go:666] ID: 22 Req-ID: pvc-a66faf7c-d1cc-4660-ad22-6b680df02e4b created image kube/csi-vol-b051d923-2791-11f1-8013-d61b816c4dbe backed for request name pvc-a66faf7c-d1cc-4660-ad22-6b680df02e4b
I0324 14:56:52.641372       1 omap.go:155] ID: 22 Req-ID: pvc-a66faf7c-d1cc-4660-ad22-6b680df02e4b set omap keys (pool="kube", namespace="", name="csi.volume.b051d923-2791-11f1-8013-d61b816c4dbe"): map[csi.imageid:37d998d8798d])
I0324 14:56:52.641750       1 utils.go:202] ID: 22 Req-ID: pvc-a66faf7c-d1cc-4660-ad22-6b680df02e4b GRPC response: {"volume":{"capacity_bytes":5368709120,"volume_context":{"clusterID":"4837cbf8-4f90-4300-b3f6-726c9b9f89b4","csi.storage.k8s.io/pv/name":"pvc-a66faf7c-d1cc-4660-ad22-6b680df02e4b","csi.storage.k8s.io/pvc/name":"test-pvc","csi.storage.k8s.io/pvc/namespace":"default","imageFeatures":"layering","imageName":"csi-vol-b051d923-2791-11f1-8013-d61b816c4dbe","journalPool":"kube","pool":"kube","thickProvision":"false"},"volume_id":"0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-b051d923-2791-11f1-8013-d61b816c4dbe"}}