I0420 21:00:39.998165       1 main.go:92] Version: v3.4.0
I0420 21:00:39.999269       1 connection.go:154] Connecting to unix:///csi/csi-provisioner.sock
I0420 21:00:41.000645       1 common.go:111] Probing CSI driver for readiness
I0420 21:00:41.000683       1 connection.go:183] GRPC call: /csi.v1.Identity/Probe
I0420 21:00:41.000690       1 connection.go:184] GRPC request: {}
I0420 21:00:41.006803       1 connection.go:186] GRPC response: {}
I0420 21:00:41.006896       1 connection.go:187] GRPC error: <nil>
I0420 21:00:41.006921       1 connection.go:183] GRPC call: /csi.v1.Identity/GetPluginInfo
I0420 21:00:41.006928       1 connection.go:184] GRPC request: {}
I0420 21:00:41.007884       1 connection.go:186] GRPC response: {"name":"rbd.csi.ceph.com","vendor_version":"v3.5.1"}
I0420 21:00:41.007962       1 connection.go:187] GRPC error: <nil>
I0420 21:00:41.007973       1 main.go:148] CSI driver name: "rbd.csi.ceph.com"
I0420 21:00:41.008597       1 connection.go:154] Connecting to unix:///csi/csi-provisioner.sock
I0420 21:00:41.009187       1 common.go:111] Probing CSI driver for readiness
I0420 21:00:41.009214       1 connection.go:183] GRPC call: /csi.v1.Identity/Probe
I0420 21:00:41.009223       1 connection.go:184] GRPC request: {}
I0420 21:00:41.009972       1 connection.go:186] GRPC response: {}
I0420 21:00:41.010021       1 connection.go:187] GRPC error: <nil>
I0420 21:00:41.010030       1 connection.go:183] GRPC call: /csi.v1.Identity/GetPluginCapabilities
I0420 21:00:41.010037       1 connection.go:184] GRPC request: {}
I0420 21:00:41.011021       1 connection.go:186] GRPC response: {"capabilities":[{"Type":{"Service":{"type":1}}},{"Type":{"VolumeExpansion":{"type":1}}},{"Type":{"Service":{"type":2}}}]}
I0420 21:00:41.011276       1 connection.go:187] GRPC error: <nil>
I0420 21:00:41.011295       1 connection.go:183] GRPC call: /csi.v1.Controller/ControllerGetCapabilities
I0420 21:00:41.011322       1 connection.go:184] GRPC request: {}
I0420 21:00:41.012861       1 connection.go:186] GRPC response: {"capabilities":[{"Type":{"Rpc":{"type":1}}},{"Type":{"Rpc":{"type":5}}},{"Type":{"Rpc":{"type":7}}},{"Type":{"Rpc":{"type":9}}}]}
I0420 21:00:41.012985       1 connection.go:187] GRPC error: <nil>
I0420 21:00:41.012998       1 main.go:226] CSI driver does not support ControllerPublishUnpublish, using trivial handler
I0420 21:00:41.013595       1 leaderelection.go:248] attempting to acquire leader lease kube-system/external-attacher-leader-rbd-csi-ceph-com...
I0420 21:00:41.026091       1 leaderelection.go:258] successfully acquired lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0420 21:00:41.026131       1 leader_election.go:212] new leader detected, current leader: ceph-csi-rbd-provisioner-6f6497f79c-jhp5n
I0420 21:00:41.026159       1 leader_election.go:205] became leader, starting
I0420 21:00:41.026196       1 controller.go:128] Starting CSI attacher
I0420 21:00:41.026584       1 reflector.go:219] Starting reflector *v1.VolumeAttachment (10m0s) from k8s.io/client-go/informers/factory.go:134
I0420 21:00:41.026606       1 reflector.go:255] Listing and watching *v1.VolumeAttachment from k8s.io/client-go/informers/factory.go:134
I0420 21:00:41.026618       1 reflector.go:219] Starting reflector *v1.PersistentVolume (10m0s) from k8s.io/client-go/informers/factory.go:134
I0420 21:00:41.026634       1 reflector.go:255] Listing and watching *v1.PersistentVolume from k8s.io/client-go/informers/factory.go:134
I0420 21:00:41.038552       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0420 21:00:41.127156       1 shared_informer.go:270] caches populated
I0420 21:00:46.051575       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0420 21:00:51.060852       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0420 21:00:56.070981       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0420 21:01:01.081892       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0420 21:01:06.096903       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0420 21:01:11.106920       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0420 21:01:16.115244       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0420 21:01:21.264888       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0420 21:01:26.275253       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0420 21:01:31.286707       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0420 21:01:36.296076       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0420 21:01:41.305056       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0420 21:01:46.315045       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0420 21:01:51.323776       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0420 21:01:56.338335       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0420 21:02:01.407919       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0420 21:02:06.416403       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0420 21:02:11.426424       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0420 21:02:16.435669       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0420 21:02:21.444438       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0420 21:02:26.452916       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0420 21:02:31.461474       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0420 21:02:36.470552       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0420 21:02:41.481907       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0420 21:02:46.525297       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0420 21:02:51.535034       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0420 21:02:56.545026       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0420 21:03:01.554362       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0420 21:03:06.567692       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0420 21:03:11.576558       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0420 21:03:16.585757       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0420 21:03:21.593827       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0420 21:03:26.604158       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0420 21:03:31.611216       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0420 21:03:36.622103       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0420 21:03:41.634276       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0420 21:03:46.643370       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0420 21:03:47.149440       1 controller.go:208] Started VA processing "csi-d4b4c72ea55d97cddf1dd875e577baac2507297ecd1669fe520bd3835015fa1d"
I0420 21:03:47.149471       1 trivial_handler.go:53] Trivial sync[csi-d4b4c72ea55d97cddf1dd875e577baac2507297ecd1669fe520bd3835015fa1d] started
I0420 21:03:47.149477       1 util.go:38] Marking as attached "csi-d4b4c72ea55d97cddf1dd875e577baac2507297ecd1669fe520bd3835015fa1d"
I0420 21:03:47.154363       1 util.go:52] Marked as attached "csi-d4b4c72ea55d97cddf1dd875e577baac2507297ecd1669fe520bd3835015fa1d"
I0420 21:03:47.154381       1 trivial_handler.go:61] Marked VolumeAttachment csi-d4b4c72ea55d97cddf1dd875e577baac2507297ecd1669fe520bd3835015fa1d as attached
I0420 21:03:47.154926       1 controller.go:208] Started VA processing "csi-d4b4c72ea55d97cddf1dd875e577baac2507297ecd1669fe520bd3835015fa1d"
I0420 21:03:47.154943       1 trivial_handler.go:53] Trivial sync[csi-d4b4c72ea55d97cddf1dd875e577baac2507297ecd1669fe520bd3835015fa1d] started
I0420 21:03:51.651037       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0420 21:03:56.659947       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0420 21:04:01.827574       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0420 21:04:06.836846       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0420 21:04:11.845229       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0420 21:04:12.211947       1 controller.go:259] Started PV processing "pvc-a0590e5b-15b9-456b-9fb9-cfd4b550f1ef"
I0420 21:04:16.853877       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0420 21:04:21.862415       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0420 21:04:26.870896       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0420 21:04:31.878276       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0420 21:04:36.890216       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com