I0409 22:31:22.609402       1 cephcsi.go:171] Driver version: v3.5.1 and Git version: 00f88e58a0b08be3d7ea009a0cfde8dca23021bf
E0409 22:31:22.609560       1 cephcsi.go:187] Failed to get the PID limit, can not reconfigure: could not find a cgroup for 'pids'
I0409 22:31:22.609592       1 cephcsi.go:220] Starting driver type: rbd with name: rbd.csi.ceph.com
I0409 22:31:22.609817       1 driver.go:94] Enabling controller service capability: CREATE_DELETE_VOLUME
I0409 22:31:22.609829       1 driver.go:94] Enabling controller service capability: CREATE_DELETE_SNAPSHOT
I0409 22:31:22.609833       1 driver.go:94] Enabling controller service capability: CLONE_VOLUME
I0409 22:31:22.609836       1 driver.go:94] Enabling controller service capability: EXPAND_VOLUME
I0409 22:31:22.609841       1 driver.go:106] Enabling volume access mode: SINGLE_NODE_WRITER
I0409 22:31:22.609845       1 driver.go:106] Enabling volume access mode: MULTI_NODE_MULTI_WRITER
I0409 22:31:22.609849       1 driver.go:106] Enabling volume access mode: SINGLE_NODE_SINGLE_WRITER
I0409 22:31:22.609854       1 driver.go:106] Enabling volume access mode: SINGLE_NODE_MULTI_WRITER
I0409 22:31:22.610042       1 server.go:126] Listening for connections on address: &net.UnixAddr{Name:"//csi/csi-provisioner.sock", Net:"unix"}
I0409 22:31:22.610671       1 server.go:114] listening for CSI-Addons requests on address: &net.UnixAddr{Name:"/csi/csi-addons.sock", Net:"unix"}
I0409 22:31:22.933069       1 utils.go:191] ID: 1 GRPC call: /csi.v1.Identity/Probe
I0409 22:31:22.935284       1 utils.go:195] ID: 1 GRPC request: {}
I0409 22:31:22.935339       1 utils.go:202] ID: 1 GRPC response: {}
I0409 22:31:22.936172       1 utils.go:191] ID: 2 GRPC call: /csi.v1.Identity/GetPluginInfo
I0409 22:31:22.936234       1 utils.go:195] ID: 2 GRPC request: {}
I0409 22:31:22.936310       1 identityserver-default.go:38] ID: 2 Using default GetPluginInfo
I0409 22:31:22.936361       1 utils.go:202] ID: 2 GRPC response: {"name":"rbd.csi.ceph.com","vendor_version":"v3.5.1"}
I0409 22:31:22.937561       1 utils.go:191] ID: 3 GRPC call: /csi.v1.Identity/Probe
I0409 22:31:22.937590       1 utils.go:195] ID: 3 GRPC request: {}
I0409 22:31:22.937686       1 utils.go:202] ID: 3 GRPC response: {}
I0409 22:31:22.938098       1 utils.go:191] ID: 4 GRPC call: /csi.v1.Identity/GetPluginCapabilities
I0409 22:31:22.938186       1 utils.go:195] ID: 4 GRPC request: {}
I0409 22:31:22.938385       1 utils.go:202] ID: 4 GRPC response: {"capabilities":[{"Type":{"Service":{"type":1}}},{"Type":{"VolumeExpansion":{"type":1}}},{"Type":{"Service":{"type":2}}}]}
I0409 22:31:22.941535       1 utils.go:191] ID: 5 GRPC call: /csi.v1.Controller/ControllerGetCapabilities
I0409 22:31:22.941624       1 utils.go:195] ID: 5 GRPC request: {}
I0409 22:31:22.941660       1 controllerserver-default.go:74] ID: 5 Using default ControllerGetCapabilities
I0409 22:31:22.941978       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}}}]}
I0409 22:31:23.283364       1 utils.go:191] ID: 6 GRPC call: /csi.v1.Identity/Probe
I0409 22:31:23.283441       1 utils.go:195] ID: 6 GRPC request: {}
I0409 22:31:23.283468       1 utils.go:202] ID: 6 GRPC response: {}
I0409 22:31:23.284974       1 utils.go:191] ID: 7 GRPC call: /csi.v1.Identity/GetPluginInfo
I0409 22:31:23.285015       1 utils.go:195] ID: 7 GRPC request: {}
I0409 22:31:23.285164       1 identityserver-default.go:38] ID: 7 Using default GetPluginInfo
I0409 22:31:23.285269       1 utils.go:202] ID: 7 GRPC response: {"name":"rbd.csi.ceph.com","vendor_version":"v3.5.1"}
I0409 22:31:23.286968       1 utils.go:191] ID: 8 GRPC call: /csi.v1.Identity/GetPluginCapabilities
I0409 22:31:23.287000       1 utils.go:195] ID: 8 GRPC request: {}
I0409 22:31:23.287165       1 utils.go:202] ID: 8 GRPC response: {"capabilities":[{"Type":{"Service":{"type":1}}},{"Type":{"VolumeExpansion":{"type":1}}},{"Type":{"Service":{"type":2}}}]}
I0409 22:31:23.288218       1 utils.go:191] ID: 9 GRPC call: /csi.v1.Controller/ControllerGetCapabilities
I0409 22:31:23.288255       1 utils.go:195] ID: 9 GRPC request: {}
I0409 22:31:23.288262       1 controllerserver-default.go:74] ID: 9 Using default ControllerGetCapabilities
I0409 22:31:23.288358       1 utils.go:202] ID: 9 GRPC response: {"capabilities":[{"Type":{"Rpc":{"type":1}}},{"Type":{"Rpc":{"type":5}}},{"Type":{"Rpc":{"type":7}}},{"Type":{"Rpc":{"type":9}}}]}
I0409 22:31:23.288882       1 utils.go:191] ID: 10 GRPC call: /csi.v1.Controller/ControllerGetCapabilities
I0409 22:31:23.288917       1 utils.go:195] ID: 10 GRPC request: {}
I0409 22:31:23.288924       1 controllerserver-default.go:74] ID: 10 Using default ControllerGetCapabilities
I0409 22:31:23.289027       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}}}]}
I0409 22:31:23.454660       1 utils.go:191] ID: 11 GRPC call: /csi.v1.Identity/GetPluginInfo
I0409 22:31:23.454729       1 utils.go:195] ID: 11 GRPC request: {}
I0409 22:31:23.454744       1 identityserver-default.go:38] ID: 11 Using default GetPluginInfo
I0409 22:31:23.454781       1 utils.go:202] ID: 11 GRPC response: {"name":"rbd.csi.ceph.com","vendor_version":"v3.5.1"}
I0409 22:31:23.455821       1 utils.go:191] ID: 12 GRPC call: /csi.v1.Identity/Probe
I0409 22:31:23.456017       1 utils.go:195] ID: 12 GRPC request: {}
I0409 22:31:23.456201       1 utils.go:202] ID: 12 GRPC response: {}
I0409 22:31:23.457278       1 utils.go:191] ID: 13 GRPC call: /csi.v1.Controller/ControllerGetCapabilities
I0409 22:31:23.457449       1 utils.go:195] ID: 13 GRPC request: {}
I0409 22:31:23.457468       1 controllerserver-default.go:74] ID: 13 Using default ControllerGetCapabilities
I0409 22:31:23.457750       1 utils.go:202] ID: 13 GRPC response: {"capabilities":[{"Type":{"Rpc":{"type":1}}},{"Type":{"Rpc":{"type":5}}},{"Type":{"Rpc":{"type":7}}},{"Type":{"Rpc":{"type":9}}}]}
I0409 22:31:23.498741       1 utils.go:191] ID: 14 GRPC call: /csi.v1.Identity/Probe
I0409 22:31:23.498995       1 utils.go:195] ID: 14 GRPC request: {}
I0409 22:31:23.499211       1 utils.go:202] ID: 14 GRPC response: {}
I0409 22:31:23.500319       1 utils.go:191] ID: 15 GRPC call: /csi.v1.Identity/GetPluginInfo
I0409 22:31:23.500518       1 utils.go:195] ID: 15 GRPC request: {}
I0409 22:31:23.500539       1 identityserver-default.go:38] ID: 15 Using default GetPluginInfo
I0409 22:31:23.500698       1 utils.go:202] ID: 15 GRPC response: {"name":"rbd.csi.ceph.com","vendor_version":"v3.5.1"}
I0409 22:31:23.502568       1 utils.go:191] ID: 16 GRPC call: /csi.v1.Identity/Probe
I0409 22:31:23.502664       1 utils.go:195] ID: 16 GRPC request: {}
I0409 22:31:23.502720       1 utils.go:202] ID: 16 GRPC response: {}
I0409 22:31:23.503190       1 utils.go:191] ID: 17 GRPC call: /csi.v1.Identity/GetPluginCapabilities
I0409 22:31:23.503263       1 utils.go:195] ID: 17 GRPC request: {}
I0409 22:31:23.503398       1 utils.go:202] ID: 17 GRPC response: {"capabilities":[{"Type":{"Service":{"type":1}}},{"Type":{"VolumeExpansion":{"type":1}}},{"Type":{"Service":{"type":2}}}]}
I0409 22:31:23.504149       1 utils.go:191] ID: 18 GRPC call: /csi.v1.Controller/ControllerGetCapabilities
I0409 22:31:23.504226       1 utils.go:195] ID: 18 GRPC request: {}
I0409 22:31:23.504266       1 controllerserver-default.go:74] ID: 18 Using default ControllerGetCapabilities
I0409 22:31:23.504439       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}}}]}
I0409 22:32:22.709331       1 utils.go:191] ID: 19 GRPC call: /csi.v1.Identity/Probe
I0409 22:32:22.709491       1 utils.go:195] ID: 19 GRPC request: {}
I0409 22:32:22.709597       1 utils.go:202] ID: 19 GRPC response: {}
I0409 22:33:22.711446       1 utils.go:191] ID: 20 GRPC call: /csi.v1.Identity/Probe
I0409 22:33:22.711534       1 utils.go:195] ID: 20 GRPC request: {}
I0409 22:33:22.711572       1 utils.go:202] ID: 20 GRPC response: {}
I0409 22:34:22.708569       1 utils.go:191] ID: 21 GRPC call: /csi.v1.Identity/Probe
I0409 22:34:22.708694       1 utils.go:195] ID: 21 GRPC request: {}
I0409 22:34:22.708744       1 utils.go:202] ID: 21 GRPC response: {}
I0409 22:34:24.544585       1 utils.go:191] ID: 22 Req-ID: pvc-2cb003fa-9a08-4876-b15f-b0a168d5c1c2 GRPC call: /csi.v1.Controller/CreateVolume
I0409 22:34:24.544999       1 utils.go:195] ID: 22 Req-ID: pvc-2cb003fa-9a08-4876-b15f-b0a168d5c1c2 GRPC request: {"capacity_range":{"required_bytes":5368709120},"name":"pvc-2cb003fa-9a08-4876-b15f-b0a168d5c1c2","parameters":{"clusterID":"4837cbf8-4f90-4300-b3f6-726c9b9f89b4","csi.storage.k8s.io/pv/name":"pvc-2cb003fa-9a08-4876-b15f-b0a168d5c1c2","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}}]}
I0409 22:34:24.545286       1 rbd_util.go:1296] ID: 22 Req-ID: pvc-2cb003fa-9a08-4876-b15f-b0a168d5c1c2 setting disableInUseChecks: false image features: [layering] mounter: rbd
W0409 22:34:24.545306       1 controllerserver.go:1555] thick-provisioning is deprecated and will be removed in a future release
E0409 22:34:24.561579       1 omap.go:78] ID: 22 Req-ID: pvc-2cb003fa-9a08-4876-b15f-b0a168d5c1c2 omap not found (pool="kube", namespace="", name="csi.volumes.default"): rados: ret=-2, No such file or directory
I0409 22:34:24.619851       1 omap.go:155] ID: 22 Req-ID: pvc-2cb003fa-9a08-4876-b15f-b0a168d5c1c2 set omap keys (pool="kube", namespace="", name="csi.volumes.default"): map[csi.volume.pvc-2cb003fa-9a08-4876-b15f-b0a168d5c1c2:42b34ae1-3464-11f1-9cc4-426ae69b7012])
I0409 22:34:24.633655       1 omap.go:155] ID: 22 Req-ID: pvc-2cb003fa-9a08-4876-b15f-b0a168d5c1c2 set omap keys (pool="kube", namespace="", name="csi.volume.42b34ae1-3464-11f1-9cc4-426ae69b7012"): map[csi.imagename:csi-vol-42b34ae1-3464-11f1-9cc4-426ae69b7012 csi.volname:pvc-2cb003fa-9a08-4876-b15f-b0a168d5c1c2 csi.volume.owner:default])
I0409 22:34:24.633707       1 rbd_journal.go:482] ID: 22 Req-ID: pvc-2cb003fa-9a08-4876-b15f-b0a168d5c1c2 generated Volume ID (0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-42b34ae1-3464-11f1-9cc4-426ae69b7012) and image name (csi-vol-42b34ae1-3464-11f1-9cc4-426ae69b7012) for request name (pvc-2cb003fa-9a08-4876-b15f-b0a168d5c1c2)
I0409 22:34:24.633810       1 rbd_util.go:352] ID: 22 Req-ID: pvc-2cb003fa-9a08-4876-b15f-b0a168d5c1c2 rbd: create kube/csi-vol-42b34ae1-3464-11f1-9cc4-426ae69b7012 size 5120M (features: [layering]) using mon 199.204.45.33
I0409 22:34:26.713157       1 controllerserver.go:666] ID: 22 Req-ID: pvc-2cb003fa-9a08-4876-b15f-b0a168d5c1c2 created image kube/csi-vol-42b34ae1-3464-11f1-9cc4-426ae69b7012 backed for request name pvc-2cb003fa-9a08-4876-b15f-b0a168d5c1c2
I0409 22:34:26.741110       1 omap.go:155] ID: 22 Req-ID: pvc-2cb003fa-9a08-4876-b15f-b0a168d5c1c2 set omap keys (pool="kube", namespace="", name="csi.volume.42b34ae1-3464-11f1-9cc4-426ae69b7012"): map[csi.imageid:37d97ae71376])
I0409 22:34:26.741557       1 utils.go:202] ID: 22 Req-ID: pvc-2cb003fa-9a08-4876-b15f-b0a168d5c1c2 GRPC response: {"volume":{"capacity_bytes":5368709120,"volume_context":{"clusterID":"4837cbf8-4f90-4300-b3f6-726c9b9f89b4","csi.storage.k8s.io/pv/name":"pvc-2cb003fa-9a08-4876-b15f-b0a168d5c1c2","csi.storage.k8s.io/pvc/name":"test-pvc","csi.storage.k8s.io/pvc/namespace":"default","imageFeatures":"layering","imageName":"csi-vol-42b34ae1-3464-11f1-9cc4-426ae69b7012","journalPool":"kube","pool":"kube","thickProvision":"false"},"volume_id":"0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-42b34ae1-3464-11f1-9cc4-426ae69b7012"}}