I0418 22:20:26.019582       1 main.go:92] Version: v3.4.0
I0418 22:20:26.020387       1 connection.go:154] Connecting to unix:///csi/csi-provisioner.sock
I0418 22:20:27.022550       1 common.go:111] Probing CSI driver for readiness
I0418 22:20:27.022582       1 connection.go:183] GRPC call: /csi.v1.Identity/Probe
I0418 22:20:27.022587       1 connection.go:184] GRPC request: {}
I0418 22:20:27.026027       1 connection.go:186] GRPC response: {}
I0418 22:20:27.026148       1 connection.go:187] GRPC error: <nil>
I0418 22:20:27.026165       1 connection.go:183] GRPC call: /csi.v1.Identity/GetPluginInfo
I0418 22:20:27.026171       1 connection.go:184] GRPC request: {}
I0418 22:20:27.026749       1 connection.go:186] GRPC response: {"name":"rbd.csi.ceph.com","vendor_version":"v3.5.1"}
I0418 22:20:27.026891       1 connection.go:187] GRPC error: <nil>
I0418 22:20:27.026925       1 main.go:148] CSI driver name: "rbd.csi.ceph.com"
I0418 22:20:27.028448       1 connection.go:154] Connecting to unix:///csi/csi-provisioner.sock
I0418 22:20:27.030784       1 common.go:111] Probing CSI driver for readiness
I0418 22:20:27.030837       1 connection.go:183] GRPC call: /csi.v1.Identity/Probe
I0418 22:20:27.030859       1 connection.go:184] GRPC request: {}
I0418 22:20:27.031876       1 connection.go:186] GRPC response: {}
I0418 22:20:27.031917       1 connection.go:187] GRPC error: <nil>
I0418 22:20:27.031925       1 connection.go:183] GRPC call: /csi.v1.Identity/GetPluginCapabilities
I0418 22:20:27.031929       1 connection.go:184] GRPC request: {}
I0418 22:20:27.032615       1 connection.go:186] GRPC response: {"capabilities":[{"Type":{"Service":{"type":1}}},{"Type":{"VolumeExpansion":{"type":1}}},{"Type":{"Service":{"type":2}}}]}
I0418 22:20:27.032747       1 connection.go:187] GRPC error: <nil>
I0418 22:20:27.032753       1 connection.go:183] GRPC call: /csi.v1.Controller/ControllerGetCapabilities
I0418 22:20:27.032755       1 connection.go:184] GRPC request: {}
I0418 22:20:27.033726       1 connection.go:186] GRPC response: {"capabilities":[{"Type":{"Rpc":{"type":1}}},{"Type":{"Rpc":{"type":5}}},{"Type":{"Rpc":{"type":7}}},{"Type":{"Rpc":{"type":9}}}]}
I0418 22:20:27.033807       1 connection.go:187] GRPC error: <nil>
I0418 22:20:27.033817       1 main.go:226] CSI driver does not support ControllerPublishUnpublish, using trivial handler
I0418 22:20:27.034379       1 leaderelection.go:248] attempting to acquire leader lease kube-system/external-attacher-leader-rbd-csi-ceph-com...
I0418 22:20:27.044924       1 leaderelection.go:258] successfully acquired lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0418 22:20:27.045129       1 leader_election.go:205] became leader, starting
I0418 22:20:27.045155       1 leader_election.go:212] new leader detected, current leader: ceph-csi-rbd-provisioner-6f6497f79c-dxg27
I0418 22:20:27.045160       1 controller.go:128] Starting CSI attacher
I0418 22:20:27.045439       1 reflector.go:219] Starting reflector *v1.PersistentVolume (10m0s) from k8s.io/client-go/informers/factory.go:134
I0418 22:20:27.045451       1 reflector.go:255] Listing and watching *v1.PersistentVolume from k8s.io/client-go/informers/factory.go:134
I0418 22:20:27.045455       1 reflector.go:219] Starting reflector *v1.VolumeAttachment (10m0s) from k8s.io/client-go/informers/factory.go:134
I0418 22:20:27.045466       1 reflector.go:255] Listing and watching *v1.VolumeAttachment from k8s.io/client-go/informers/factory.go:134
I0418 22:20:27.051493       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0418 22:20:27.145721       1 shared_informer.go:270] caches populated
I0418 22:20:32.107814       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0418 22:20:37.118602       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0418 22:20:42.133395       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0418 22:20:47.143011       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0418 22:20:52.151521       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0418 22:20:57.158962       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0418 22:21:02.166159       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0418 22:21:07.175168       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0418 22:21:12.186426       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0418 22:21:17.197341       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0418 22:21:22.210038       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0418 22:21:27.221745       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0418 22:21:32.231718       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0418 22:21:37.240529       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0418 22:21:42.252399       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0418 22:21:47.262512       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0418 22:21:52.272626       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0418 22:21:57.281833       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0418 22:22:02.290341       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0418 22:22:07.298742       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0418 22:22:12.309225       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0418 22:22:17.426480       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0418 22:22:22.435419       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0418 22:22:27.629241       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0418 22:22:32.638300       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0418 22:22:37.647822       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0418 22:22:42.656679       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0418 22:22:47.666276       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0418 22:22:52.674314       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0418 22:22:57.683408       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0418 22:23:02.693295       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0418 22:23:07.702039       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0418 22:23:12.714014       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0418 22:23:17.727566       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0418 22:23:22.739375       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0418 22:23:27.747308       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0418 22:23:32.755460       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0418 22:23:37.793151       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0418 22:23:39.891914       1 controller.go:208] Started VA processing "csi-447398054cf9841b523c680d90196a5f75dc0f07168c921ea8268443dbe0c9e0"
I0418 22:23:39.891945       1 trivial_handler.go:53] Trivial sync[csi-447398054cf9841b523c680d90196a5f75dc0f07168c921ea8268443dbe0c9e0] started
I0418 22:23:39.891949       1 util.go:38] Marking as attached "csi-447398054cf9841b523c680d90196a5f75dc0f07168c921ea8268443dbe0c9e0"
I0418 22:23:39.898133       1 util.go:52] Marked as attached "csi-447398054cf9841b523c680d90196a5f75dc0f07168c921ea8268443dbe0c9e0"
I0418 22:23:39.898160       1 trivial_handler.go:61] Marked VolumeAttachment csi-447398054cf9841b523c680d90196a5f75dc0f07168c921ea8268443dbe0c9e0 as attached
I0418 22:23:39.898196       1 controller.go:208] Started VA processing "csi-447398054cf9841b523c680d90196a5f75dc0f07168c921ea8268443dbe0c9e0"
I0418 22:23:39.898307       1 trivial_handler.go:53] Trivial sync[csi-447398054cf9841b523c680d90196a5f75dc0f07168c921ea8268443dbe0c9e0] started
I0418 22:23:42.804524       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0418 22:23:47.812659       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0418 22:23:52.821948       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0418 22:23:58.050177       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0418 22:24:03.064549       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0418 22:24:06.677392       1 controller.go:259] Started PV processing "pvc-9fbe4855-60ba-46e3-bee0-4888b4e9884b"
I0418 22:24:08.111643       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0418 22:24:13.120150       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0418 22:24:18.128948       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0418 22:24:23.136872       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0418 22:24:28.144053       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com