I0219 06:01:45.617258       1 cephcsi.go:171] Driver version: v3.5.1 and Git version: 00f88e58a0b08be3d7ea009a0cfde8dca23021bf
E0219 06:01:45.617386       1 cephcsi.go:187] Failed to get the PID limit, can not reconfigure: could not find a cgroup for 'pids'
I0219 06:01:45.617408       1 cephcsi.go:220] Starting driver type: rbd with name: rbd.csi.ceph.com
I0219 06:01:45.617610       1 driver.go:94] Enabling controller service capability: CREATE_DELETE_VOLUME
I0219 06:01:45.617615       1 driver.go:94] Enabling controller service capability: CREATE_DELETE_SNAPSHOT
I0219 06:01:45.617618       1 driver.go:94] Enabling controller service capability: CLONE_VOLUME
I0219 06:01:45.617621       1 driver.go:94] Enabling controller service capability: EXPAND_VOLUME
I0219 06:01:45.617625       1 driver.go:106] Enabling volume access mode: SINGLE_NODE_WRITER
I0219 06:01:45.617628       1 driver.go:106] Enabling volume access mode: MULTI_NODE_MULTI_WRITER
I0219 06:01:45.617631       1 driver.go:106] Enabling volume access mode: SINGLE_NODE_SINGLE_WRITER
I0219 06:01:45.617633       1 driver.go:106] Enabling volume access mode: SINGLE_NODE_MULTI_WRITER
I0219 06:01:45.617749       1 server.go:126] Listening for connections on address: &net.UnixAddr{Name:"//csi/csi-provisioner.sock", Net:"unix"}
I0219 06:01:45.617803       1 server.go:114] listening for CSI-Addons requests on address: &net.UnixAddr{Name:"/csi/csi-addons.sock", Net:"unix"}
I0219 06:01:45.755895       1 utils.go:191] ID: 1 GRPC call: /csi.v1.Identity/Probe
I0219 06:01:45.761002       1 utils.go:195] ID: 1 GRPC request: {}
I0219 06:01:45.761084       1 utils.go:202] ID: 1 GRPC response: {}
I0219 06:01:45.762854       1 utils.go:191] ID: 2 GRPC call: /csi.v1.Identity/GetPluginInfo
I0219 06:01:45.763228       1 utils.go:195] ID: 2 GRPC request: {}
I0219 06:01:45.763245       1 identityserver-default.go:38] ID: 2 Using default GetPluginInfo
I0219 06:01:45.763382       1 utils.go:202] ID: 2 GRPC response: {"name":"rbd.csi.ceph.com","vendor_version":"v3.5.1"}
I0219 06:01:45.771509       1 utils.go:191] ID: 3 GRPC call: /csi.v1.Identity/Probe
I0219 06:01:45.771544       1 utils.go:195] ID: 3 GRPC request: {}
I0219 06:01:45.771555       1 utils.go:202] ID: 3 GRPC response: {}
I0219 06:01:45.772203       1 utils.go:191] ID: 4 GRPC call: /csi.v1.Identity/GetPluginCapabilities
I0219 06:01:45.772234       1 utils.go:195] ID: 4 GRPC request: {}
I0219 06:01:45.772432       1 utils.go:202] ID: 4 GRPC response: {"capabilities":[{"Type":{"Service":{"type":1}}},{"Type":{"VolumeExpansion":{"type":1}}},{"Type":{"Service":{"type":2}}}]}
I0219 06:01:45.773563       1 utils.go:191] ID: 5 GRPC call: /csi.v1.Controller/ControllerGetCapabilities
I0219 06:01:45.773630       1 utils.go:195] ID: 5 GRPC request: {}
I0219 06:01:45.773646       1 controllerserver-default.go:74] ID: 5 Using default ControllerGetCapabilities
I0219 06:01:45.773790       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}}}]}
I0219 06:01:46.114859       1 utils.go:191] ID: 6 GRPC call: /csi.v1.Identity/GetPluginInfo
I0219 06:01:46.114962       1 utils.go:195] ID: 6 GRPC request: {}
I0219 06:01:46.114982       1 identityserver-default.go:38] ID: 6 Using default GetPluginInfo
I0219 06:01:46.115052       1 utils.go:202] ID: 6 GRPC response: {"name":"rbd.csi.ceph.com","vendor_version":"v3.5.1"}
I0219 06:01:46.117567       1 utils.go:191] ID: 7 GRPC call: /csi.v1.Identity/Probe
I0219 06:01:46.117729       1 utils.go:195] ID: 7 GRPC request: {}
I0219 06:01:46.117847       1 utils.go:202] ID: 7 GRPC response: {}
I0219 06:01:46.119046       1 utils.go:191] ID: 8 GRPC call: /csi.v1.Controller/ControllerGetCapabilities
I0219 06:01:46.119153       1 utils.go:195] ID: 8 GRPC request: {}
I0219 06:01:46.119175       1 controllerserver-default.go:74] ID: 8 Using default ControllerGetCapabilities
I0219 06:01:46.119361       1 utils.go:202] ID: 8 GRPC response: {"capabilities":[{"Type":{"Rpc":{"type":1}}},{"Type":{"Rpc":{"type":5}}},{"Type":{"Rpc":{"type":7}}},{"Type":{"Rpc":{"type":9}}}]}
I0219 06:01:46.258084       1 utils.go:191] ID: 9 GRPC call: /csi.v1.Identity/Probe
I0219 06:01:46.258237       1 utils.go:195] ID: 9 GRPC request: {}
I0219 06:01:46.258299       1 utils.go:202] ID: 9 GRPC response: {}
I0219 06:01:46.259255       1 utils.go:191] ID: 10 GRPC call: /csi.v1.Identity/GetPluginInfo
I0219 06:01:46.259326       1 utils.go:195] ID: 10 GRPC request: {}
I0219 06:01:46.259348       1 identityserver-default.go:38] ID: 10 Using default GetPluginInfo
I0219 06:01:46.259390       1 utils.go:202] ID: 10 GRPC response: {"name":"rbd.csi.ceph.com","vendor_version":"v3.5.1"}
I0219 06:01:46.259873       1 utils.go:191] ID: 11 GRPC call: /csi.v1.Identity/GetPluginCapabilities
I0219 06:01:46.259953       1 utils.go:195] ID: 11 GRPC request: {}
I0219 06:01:46.260078       1 utils.go:202] ID: 11 GRPC response: {"capabilities":[{"Type":{"Service":{"type":1}}},{"Type":{"VolumeExpansion":{"type":1}}},{"Type":{"Service":{"type":2}}}]}
I0219 06:01:46.260745       1 utils.go:191] ID: 12 GRPC call: /csi.v1.Controller/ControllerGetCapabilities
I0219 06:01:46.260831       1 utils.go:195] ID: 12 GRPC request: {}
I0219 06:01:46.260969       1 controllerserver-default.go:74] ID: 12 Using default ControllerGetCapabilities
I0219 06:01:46.261170       1 utils.go:202] ID: 12 GRPC response: {"capabilities":[{"Type":{"Rpc":{"type":1}}},{"Type":{"Rpc":{"type":5}}},{"Type":{"Rpc":{"type":7}}},{"Type":{"Rpc":{"type":9}}}]}
I0219 06:01:46.261823       1 utils.go:191] ID: 13 GRPC call: /csi.v1.Controller/ControllerGetCapabilities
I0219 06:01:46.261934       1 utils.go:195] ID: 13 GRPC request: {}
I0219 06:01:46.261956       1 controllerserver-default.go:74] ID: 13 Using default ControllerGetCapabilities
I0219 06:01:46.262122       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}}}]}
I0219 06:01:46.507943       1 utils.go:191] ID: 14 GRPC call: /csi.v1.Identity/Probe
I0219 06:01:46.508047       1 utils.go:195] ID: 14 GRPC request: {}
I0219 06:01:46.508086       1 utils.go:202] ID: 14 GRPC response: {}
I0219 06:01:46.511263       1 utils.go:191] ID: 15 GRPC call: /csi.v1.Identity/GetPluginInfo
I0219 06:01:46.511306       1 utils.go:195] ID: 15 GRPC request: {}
I0219 06:01:46.511314       1 identityserver-default.go:38] ID: 15 Using default GetPluginInfo
I0219 06:01:46.511341       1 utils.go:202] ID: 15 GRPC response: {"name":"rbd.csi.ceph.com","vendor_version":"v3.5.1"}
I0219 06:01:46.513432       1 utils.go:191] ID: 16 GRPC call: /csi.v1.Identity/Probe
I0219 06:01:46.513456       1 utils.go:195] ID: 16 GRPC request: {}
I0219 06:01:46.513465       1 utils.go:202] ID: 16 GRPC response: {}
I0219 06:01:46.513800       1 utils.go:191] ID: 17 GRPC call: /csi.v1.Identity/GetPluginCapabilities
I0219 06:01:46.513821       1 utils.go:195] ID: 17 GRPC request: {}
I0219 06:01:46.513902       1 utils.go:202] ID: 17 GRPC response: {"capabilities":[{"Type":{"Service":{"type":1}}},{"Type":{"VolumeExpansion":{"type":1}}},{"Type":{"Service":{"type":2}}}]}
I0219 06:01:46.514847       1 utils.go:191] ID: 18 GRPC call: /csi.v1.Controller/ControllerGetCapabilities
I0219 06:01:46.514872       1 utils.go:195] ID: 18 GRPC request: {}
I0219 06:01:46.514880       1 controllerserver-default.go:74] ID: 18 Using default ControllerGetCapabilities
I0219 06:01:46.514942       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}}}]}
I0219 06:02:45.807136       1 utils.go:191] ID: 19 GRPC call: /csi.v1.Identity/Probe
I0219 06:02:45.807393       1 utils.go:195] ID: 19 GRPC request: {}
I0219 06:02:45.807465       1 utils.go:202] ID: 19 GRPC response: {}
I0219 06:03:45.808426       1 utils.go:191] ID: 20 GRPC call: /csi.v1.Identity/Probe
I0219 06:03:45.808707       1 utils.go:195] ID: 20 GRPC request: {}
I0219 06:03:45.808739       1 utils.go:202] ID: 20 GRPC response: {}
I0219 06:04:45.806354       1 utils.go:191] ID: 21 GRPC call: /csi.v1.Identity/Probe
I0219 06:04:45.806471       1 utils.go:195] ID: 21 GRPC request: {}
I0219 06:04:45.806499       1 utils.go:202] ID: 21 GRPC response: {}
I0219 06:04:49.621643       1 utils.go:191] ID: 22 Req-ID: pvc-9c8115e1-8433-4b16-99f2-80ce4590aa17 GRPC call: /csi.v1.Controller/CreateVolume
I0219 06:04:49.622196       1 utils.go:195] ID: 22 Req-ID: pvc-9c8115e1-8433-4b16-99f2-80ce4590aa17 GRPC request: {"capacity_range":{"required_bytes":5368709120},"name":"pvc-9c8115e1-8433-4b16-99f2-80ce4590aa17","parameters":{"clusterID":"4837cbf8-4f90-4300-b3f6-726c9b9f89b4","csi.storage.k8s.io/pv/name":"pvc-9c8115e1-8433-4b16-99f2-80ce4590aa17","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}}]}
I0219 06:04:49.622615       1 rbd_util.go:1296] ID: 22 Req-ID: pvc-9c8115e1-8433-4b16-99f2-80ce4590aa17 setting disableInUseChecks: false image features: [layering] mounter: rbd
W0219 06:04:49.622678       1 controllerserver.go:1555] thick-provisioning is deprecated and will be removed in a future release
E0219 06:04:49.644838       1 omap.go:78] ID: 22 Req-ID: pvc-9c8115e1-8433-4b16-99f2-80ce4590aa17 omap not found (pool="kube", namespace="", name="csi.volumes.default"): rados: ret=-2, No such file or directory
I0219 06:04:49.661684       1 omap.go:155] ID: 22 Req-ID: pvc-9c8115e1-8433-4b16-99f2-80ce4590aa17 set omap keys (pool="kube", namespace="", name="csi.volumes.default"): map[csi.volume.pvc-9c8115e1-8433-4b16-99f2-80ce4590aa17:e6404a65-0d58-11f1-9c19-d6947278c9e8])
I0219 06:04:49.669590       1 omap.go:155] ID: 22 Req-ID: pvc-9c8115e1-8433-4b16-99f2-80ce4590aa17 set omap keys (pool="kube", namespace="", name="csi.volume.e6404a65-0d58-11f1-9c19-d6947278c9e8"): map[csi.imagename:csi-vol-e6404a65-0d58-11f1-9c19-d6947278c9e8 csi.volname:pvc-9c8115e1-8433-4b16-99f2-80ce4590aa17 csi.volume.owner:default])
I0219 06:04:49.669630       1 rbd_journal.go:482] ID: 22 Req-ID: pvc-9c8115e1-8433-4b16-99f2-80ce4590aa17 generated Volume ID (0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-e6404a65-0d58-11f1-9c19-d6947278c9e8) and image name (csi-vol-e6404a65-0d58-11f1-9c19-d6947278c9e8) for request name (pvc-9c8115e1-8433-4b16-99f2-80ce4590aa17)
I0219 06:04:49.669846       1 rbd_util.go:352] ID: 22 Req-ID: pvc-9c8115e1-8433-4b16-99f2-80ce4590aa17 rbd: create kube/csi-vol-e6404a65-0d58-11f1-9c19-d6947278c9e8 size 5120M (features: [layering]) using mon 199.204.45.33
I0219 06:04:51.118021       1 controllerserver.go:666] ID: 22 Req-ID: pvc-9c8115e1-8433-4b16-99f2-80ce4590aa17 created image kube/csi-vol-e6404a65-0d58-11f1-9c19-d6947278c9e8 backed for request name pvc-9c8115e1-8433-4b16-99f2-80ce4590aa17
I0219 06:04:51.155757       1 omap.go:155] ID: 22 Req-ID: pvc-9c8115e1-8433-4b16-99f2-80ce4590aa17 set omap keys (pool="kube", namespace="", name="csi.volume.e6404a65-0d58-11f1-9c19-d6947278c9e8"): map[csi.imageid:37d9a952ce6f])
I0219 06:04:51.156166       1 utils.go:202] ID: 22 Req-ID: pvc-9c8115e1-8433-4b16-99f2-80ce4590aa17 GRPC response: {"volume":{"capacity_bytes":5368709120,"volume_context":{"clusterID":"4837cbf8-4f90-4300-b3f6-726c9b9f89b4","csi.storage.k8s.io/pv/name":"pvc-9c8115e1-8433-4b16-99f2-80ce4590aa17","csi.storage.k8s.io/pvc/name":"test-pvc","csi.storage.k8s.io/pvc/namespace":"default","imageFeatures":"layering","imageName":"csi-vol-e6404a65-0d58-11f1-9c19-d6947278c9e8","journalPool":"kube","pool":"kube","thickProvision":"false"},"volume_id":"0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-e6404a65-0d58-11f1-9c19-d6947278c9e8"}}