I0507 03:28:38.592753       1 cephcsi.go:171] Driver version: v3.5.1 and Git version: 00f88e58a0b08be3d7ea009a0cfde8dca23021bf
E0507 03:28:38.592980       1 cephcsi.go:187] Failed to get the PID limit, can not reconfigure: could not find a cgroup for 'pids'
I0507 03:28:38.593025       1 cephcsi.go:220] Starting driver type: rbd with name: rbd.csi.ceph.com
I0507 03:28:38.593277       1 driver.go:94] Enabling controller service capability: CREATE_DELETE_VOLUME
I0507 03:28:38.593290       1 driver.go:94] Enabling controller service capability: CREATE_DELETE_SNAPSHOT
I0507 03:28:38.593297       1 driver.go:94] Enabling controller service capability: CLONE_VOLUME
I0507 03:28:38.593303       1 driver.go:94] Enabling controller service capability: EXPAND_VOLUME
I0507 03:28:38.593310       1 driver.go:106] Enabling volume access mode: SINGLE_NODE_WRITER
I0507 03:28:38.593315       1 driver.go:106] Enabling volume access mode: MULTI_NODE_MULTI_WRITER
I0507 03:28:38.593321       1 driver.go:106] Enabling volume access mode: SINGLE_NODE_SINGLE_WRITER
I0507 03:28:38.593327       1 driver.go:106] Enabling volume access mode: SINGLE_NODE_MULTI_WRITER
I0507 03:28:38.593488       1 server.go:126] Listening for connections on address: &net.UnixAddr{Name:"//csi/csi-provisioner.sock", Net:"unix"}
I0507 03:28:38.593545       1 server.go:114] listening for CSI-Addons requests on address: &net.UnixAddr{Name:"/csi/csi-addons.sock", Net:"unix"}
I0507 03:28:38.808547       1 utils.go:191] ID: 1 GRPC call: /csi.v1.Identity/Probe
I0507 03:28:38.810069       1 utils.go:195] ID: 1 GRPC request: {}
I0507 03:28:38.810234       1 utils.go:202] ID: 1 GRPC response: {}
I0507 03:28:38.811447       1 utils.go:191] ID: 2 GRPC call: /csi.v1.Identity/GetPluginInfo
I0507 03:28:38.811533       1 utils.go:195] ID: 2 GRPC request: {}
I0507 03:28:38.811577       1 identityserver-default.go:38] ID: 2 Using default GetPluginInfo
I0507 03:28:38.811679       1 utils.go:202] ID: 2 GRPC response: {"name":"rbd.csi.ceph.com","vendor_version":"v3.5.1"}
I0507 03:28:38.812507       1 utils.go:191] ID: 3 GRPC call: /csi.v1.Identity/GetPluginCapabilities
I0507 03:28:38.812571       1 utils.go:195] ID: 3 GRPC request: {}
I0507 03:28:38.812772       1 utils.go:202] ID: 3 GRPC response: {"capabilities":[{"Type":{"Service":{"type":1}}},{"Type":{"VolumeExpansion":{"type":1}}},{"Type":{"Service":{"type":2}}}]}
I0507 03:28:38.814028       1 utils.go:191] ID: 4 GRPC call: /csi.v1.Controller/ControllerGetCapabilities
I0507 03:28:38.814101       1 utils.go:195] ID: 4 GRPC request: {}
I0507 03:28:38.814140       1 controllerserver-default.go:74] ID: 4 Using default ControllerGetCapabilities
I0507 03:28:38.814358       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}}}]}
I0507 03:28:38.821353       1 utils.go:191] ID: 5 GRPC call: /csi.v1.Controller/ControllerGetCapabilities
I0507 03:28:38.821448       1 utils.go:195] ID: 5 GRPC request: {}
I0507 03:28:38.821484       1 controllerserver-default.go:74] ID: 5 Using default ControllerGetCapabilities
I0507 03:28:38.822904       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}}}]}
I0507 03:28:38.928656       1 utils.go:191] ID: 6 GRPC call: /csi.v1.Identity/Probe
I0507 03:28:38.928737       1 utils.go:195] ID: 6 GRPC request: {}
I0507 03:28:38.928759       1 utils.go:202] ID: 6 GRPC response: {}
I0507 03:28:38.929375       1 utils.go:191] ID: 7 GRPC call: /csi.v1.Identity/GetPluginInfo
I0507 03:28:38.929411       1 utils.go:195] ID: 7 GRPC request: {}
I0507 03:28:38.929419       1 identityserver-default.go:38] ID: 7 Using default GetPluginInfo
I0507 03:28:38.929445       1 utils.go:202] ID: 7 GRPC response: {"name":"rbd.csi.ceph.com","vendor_version":"v3.5.1"}
I0507 03:28:38.930634       1 utils.go:191] ID: 8 GRPC call: /csi.v1.Identity/Probe
I0507 03:28:38.930674       1 utils.go:195] ID: 8 GRPC request: {}
I0507 03:28:38.930688       1 utils.go:202] ID: 8 GRPC response: {}
I0507 03:28:38.931098       1 utils.go:191] ID: 9 GRPC call: /csi.v1.Identity/GetPluginCapabilities
I0507 03:28:38.931132       1 utils.go:195] ID: 9 GRPC request: {}
I0507 03:28:38.931241       1 utils.go:202] ID: 9 GRPC response: {"capabilities":[{"Type":{"Service":{"type":1}}},{"Type":{"VolumeExpansion":{"type":1}}},{"Type":{"Service":{"type":2}}}]}
I0507 03:28:38.932132       1 utils.go:191] ID: 10 GRPC call: /csi.v1.Controller/ControllerGetCapabilities
I0507 03:28:38.932166       1 utils.go:195] ID: 10 GRPC request: {}
I0507 03:28:38.932180       1 controllerserver-default.go:74] ID: 10 Using default ControllerGetCapabilities
I0507 03:28:38.932257       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}}}]}
I0507 03:28:39.056952       1 utils.go:191] ID: 11 GRPC call: /csi.v1.Identity/GetPluginInfo
I0507 03:28:39.057022       1 utils.go:195] ID: 11 GRPC request: {}
I0507 03:28:39.057031       1 identityserver-default.go:38] ID: 11 Using default GetPluginInfo
I0507 03:28:39.057059       1 utils.go:202] ID: 11 GRPC response: {"name":"rbd.csi.ceph.com","vendor_version":"v3.5.1"}
I0507 03:28:39.058140       1 utils.go:191] ID: 12 GRPC call: /csi.v1.Identity/Probe
I0507 03:28:39.058178       1 utils.go:195] ID: 12 GRPC request: {}
I0507 03:28:39.058193       1 utils.go:202] ID: 12 GRPC response: {}
I0507 03:28:39.058781       1 utils.go:191] ID: 13 GRPC call: /csi.v1.Controller/ControllerGetCapabilities
I0507 03:28:39.058812       1 utils.go:195] ID: 13 GRPC request: {}
I0507 03:28:39.058820       1 controllerserver-default.go:74] ID: 13 Using default ControllerGetCapabilities
I0507 03:28:39.058935       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}}}]}
I0507 03:28:39.470505       1 utils.go:191] ID: 14 GRPC call: /csi.v1.Identity/Probe
I0507 03:28:39.470792       1 utils.go:195] ID: 14 GRPC request: {}
I0507 03:28:39.470979       1 utils.go:202] ID: 14 GRPC response: {}
I0507 03:28:39.472342       1 utils.go:191] ID: 15 GRPC call: /csi.v1.Identity/GetPluginInfo
I0507 03:28:39.472426       1 utils.go:195] ID: 15 GRPC request: {}
I0507 03:28:39.472444       1 identityserver-default.go:38] ID: 15 Using default GetPluginInfo
I0507 03:28:39.472484       1 utils.go:202] ID: 15 GRPC response: {"name":"rbd.csi.ceph.com","vendor_version":"v3.5.1"}
I0507 03:28:39.475230       1 utils.go:191] ID: 16 GRPC call: /csi.v1.Identity/Probe
I0507 03:28:39.475340       1 utils.go:195] ID: 16 GRPC request: {}
I0507 03:28:39.475367       1 utils.go:202] ID: 16 GRPC response: {}
I0507 03:28:39.475944       1 utils.go:191] ID: 17 GRPC call: /csi.v1.Identity/GetPluginCapabilities
I0507 03:28:39.476073       1 utils.go:195] ID: 17 GRPC request: {}
I0507 03:28:39.476269       1 utils.go:202] ID: 17 GRPC response: {"capabilities":[{"Type":{"Service":{"type":1}}},{"Type":{"VolumeExpansion":{"type":1}}},{"Type":{"Service":{"type":2}}}]}
I0507 03:28:39.477019       1 utils.go:191] ID: 18 GRPC call: /csi.v1.Controller/ControllerGetCapabilities
I0507 03:28:39.477123       1 utils.go:195] ID: 18 GRPC request: {}
I0507 03:28:39.477177       1 controllerserver-default.go:74] ID: 18 Using default ControllerGetCapabilities
I0507 03:28:39.477305       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}}}]}
I0507 03:29:38.870915       1 utils.go:191] ID: 19 GRPC call: /csi.v1.Identity/Probe
I0507 03:29:38.870987       1 utils.go:195] ID: 19 GRPC request: {}
I0507 03:29:38.871003       1 utils.go:202] ID: 19 GRPC response: {}
I0507 03:30:38.871325       1 utils.go:191] ID: 20 GRPC call: /csi.v1.Identity/Probe
I0507 03:30:38.871410       1 utils.go:195] ID: 20 GRPC request: {}
I0507 03:30:38.871434       1 utils.go:202] ID: 20 GRPC response: {}
I0507 03:31:38.870343       1 utils.go:191] ID: 21 GRPC call: /csi.v1.Identity/Probe
I0507 03:31:38.870476       1 utils.go:195] ID: 21 GRPC request: {}
I0507 03:31:38.870510       1 utils.go:202] ID: 21 GRPC response: {}
I0507 03:31:39.428406       1 utils.go:191] ID: 22 Req-ID: pvc-44af2a80-e142-4a41-9951-8b6d1d4a9483 GRPC call: /csi.v1.Controller/CreateVolume
I0507 03:31:39.428799       1 utils.go:195] ID: 22 Req-ID: pvc-44af2a80-e142-4a41-9951-8b6d1d4a9483 GRPC request: {"capacity_range":{"required_bytes":5368709120},"name":"pvc-44af2a80-e142-4a41-9951-8b6d1d4a9483","parameters":{"clusterID":"4837cbf8-4f90-4300-b3f6-726c9b9f89b4","csi.storage.k8s.io/pv/name":"pvc-44af2a80-e142-4a41-9951-8b6d1d4a9483","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}}]}
I0507 03:31:39.429652       1 rbd_util.go:1296] ID: 22 Req-ID: pvc-44af2a80-e142-4a41-9951-8b6d1d4a9483 setting disableInUseChecks: false image features: [layering] mounter: rbd
W0507 03:31:39.429752       1 controllerserver.go:1555] thick-provisioning is deprecated and will be removed in a future release
E0507 03:31:39.448629       1 omap.go:78] ID: 22 Req-ID: pvc-44af2a80-e142-4a41-9951-8b6d1d4a9483 omap not found (pool="kube", namespace="", name="csi.volumes.default"): rados: ret=-2, No such file or directory
I0507 03:31:39.467395       1 omap.go:155] ID: 22 Req-ID: pvc-44af2a80-e142-4a41-9951-8b6d1d4a9483 set omap keys (pool="kube", namespace="", name="csi.volumes.default"): map[csi.volume.pvc-44af2a80-e142-4a41-9951-8b6d1d4a9483:42465e8b-49c5-11f1-a5e5-4eccbb8af138])
I0507 03:31:39.475189       1 omap.go:155] ID: 22 Req-ID: pvc-44af2a80-e142-4a41-9951-8b6d1d4a9483 set omap keys (pool="kube", namespace="", name="csi.volume.42465e8b-49c5-11f1-a5e5-4eccbb8af138"): map[csi.imagename:csi-vol-42465e8b-49c5-11f1-a5e5-4eccbb8af138 csi.volname:pvc-44af2a80-e142-4a41-9951-8b6d1d4a9483 csi.volume.owner:default])
I0507 03:31:39.475271       1 rbd_journal.go:482] ID: 22 Req-ID: pvc-44af2a80-e142-4a41-9951-8b6d1d4a9483 generated Volume ID (0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-42465e8b-49c5-11f1-a5e5-4eccbb8af138) and image name (csi-vol-42465e8b-49c5-11f1-a5e5-4eccbb8af138) for request name (pvc-44af2a80-e142-4a41-9951-8b6d1d4a9483)
I0507 03:31:39.475422       1 rbd_util.go:352] ID: 22 Req-ID: pvc-44af2a80-e142-4a41-9951-8b6d1d4a9483 rbd: create kube/csi-vol-42465e8b-49c5-11f1-a5e5-4eccbb8af138 size 5120M (features: [layering]) using mon 199.204.45.235
I0507 03:31:41.331753       1 controllerserver.go:666] ID: 22 Req-ID: pvc-44af2a80-e142-4a41-9951-8b6d1d4a9483 created image kube/csi-vol-42465e8b-49c5-11f1-a5e5-4eccbb8af138 backed for request name pvc-44af2a80-e142-4a41-9951-8b6d1d4a9483
I0507 03:31:41.369828       1 omap.go:155] ID: 22 Req-ID: pvc-44af2a80-e142-4a41-9951-8b6d1d4a9483 set omap keys (pool="kube", namespace="", name="csi.volume.42465e8b-49c5-11f1-a5e5-4eccbb8af138"): map[csi.imageid:37d99a8d4a97])
I0507 03:31:41.370210       1 utils.go:202] ID: 22 Req-ID: pvc-44af2a80-e142-4a41-9951-8b6d1d4a9483 GRPC response: {"volume":{"capacity_bytes":5368709120,"volume_context":{"clusterID":"4837cbf8-4f90-4300-b3f6-726c9b9f89b4","csi.storage.k8s.io/pv/name":"pvc-44af2a80-e142-4a41-9951-8b6d1d4a9483","csi.storage.k8s.io/pvc/name":"test-pvc","csi.storage.k8s.io/pvc/namespace":"default","imageFeatures":"layering","imageName":"csi-vol-42465e8b-49c5-11f1-a5e5-4eccbb8af138","journalPool":"kube","pool":"kube","thickProvision":"false"},"volume_id":"0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-42465e8b-49c5-11f1-a5e5-4eccbb8af138"}}