I0518 00:45:28.753348       1 main.go:92] Version: v3.4.0
I0518 00:45:28.754258       1 connection.go:154] Connecting to unix:///csi/csi-provisioner.sock
I0518 00:45:29.755399       1 common.go:111] Probing CSI driver for readiness
I0518 00:45:29.755428       1 connection.go:183] GRPC call: /csi.v1.Identity/Probe
I0518 00:45:29.755433       1 connection.go:184] GRPC request: {}
I0518 00:45:29.764636       1 connection.go:186] GRPC response: {}
I0518 00:45:29.764750       1 connection.go:187] GRPC error: <nil>
I0518 00:45:29.764766       1 connection.go:183] GRPC call: /csi.v1.Identity/GetPluginInfo
I0518 00:45:29.764772       1 connection.go:184] GRPC request: {}
I0518 00:45:29.765558       1 connection.go:186] GRPC response: {"name":"rbd.csi.ceph.com","vendor_version":"v3.5.1"}
I0518 00:45:29.765628       1 connection.go:187] GRPC error: <nil>
I0518 00:45:29.765637       1 main.go:148] CSI driver name: "rbd.csi.ceph.com"
I0518 00:45:29.768458       1 connection.go:154] Connecting to unix:///csi/csi-provisioner.sock
I0518 00:45:29.769278       1 common.go:111] Probing CSI driver for readiness
I0518 00:45:29.769361       1 connection.go:183] GRPC call: /csi.v1.Identity/Probe
I0518 00:45:29.769365       1 connection.go:184] GRPC request: {}
I0518 00:45:29.770016       1 connection.go:186] GRPC response: {}
I0518 00:45:29.770079       1 connection.go:187] GRPC error: <nil>
I0518 00:45:29.770087       1 connection.go:183] GRPC call: /csi.v1.Identity/GetPluginCapabilities
I0518 00:45:29.770091       1 connection.go:184] GRPC request: {}
I0518 00:45:29.772428       1 connection.go:186] GRPC response: {"capabilities":[{"Type":{"Service":{"type":1}}},{"Type":{"VolumeExpansion":{"type":1}}},{"Type":{"Service":{"type":2}}}]}
I0518 00:45:29.772537       1 connection.go:187] GRPC error: <nil>
I0518 00:45:29.772542       1 connection.go:183] GRPC call: /csi.v1.Controller/ControllerGetCapabilities
I0518 00:45:29.772545       1 connection.go:184] GRPC request: {}
I0518 00:45:29.773354       1 connection.go:186] GRPC response: {"capabilities":[{"Type":{"Rpc":{"type":1}}},{"Type":{"Rpc":{"type":5}}},{"Type":{"Rpc":{"type":7}}},{"Type":{"Rpc":{"type":9}}}]}
I0518 00:45:29.773516       1 connection.go:187] GRPC error: <nil>
I0518 00:45:29.773541       1 main.go:226] CSI driver does not support ControllerPublishUnpublish, using trivial handler
I0518 00:45:29.773982       1 leaderelection.go:248] attempting to acquire leader lease kube-system/external-attacher-leader-rbd-csi-ceph-com...
I0518 00:45:29.804801       1 leaderelection.go:258] successfully acquired lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0518 00:45:29.804997       1 leader_election.go:212] new leader detected, current leader: ceph-csi-rbd-provisioner-6f6497f79c-rxnj6
I0518 00:45:29.805400       1 leader_election.go:205] became leader, starting
I0518 00:45:29.805482       1 controller.go:128] Starting CSI attacher
I0518 00:45:29.805837       1 reflector.go:219] Starting reflector *v1.VolumeAttachment (10m0s) from k8s.io/client-go/informers/factory.go:134
I0518 00:45:29.805923       1 reflector.go:255] Listing and watching *v1.VolumeAttachment from k8s.io/client-go/informers/factory.go:134
I0518 00:45:29.806346       1 reflector.go:219] Starting reflector *v1.PersistentVolume (10m0s) from k8s.io/client-go/informers/factory.go:134
I0518 00:45:29.806368       1 reflector.go:255] Listing and watching *v1.PersistentVolume from k8s.io/client-go/informers/factory.go:134
I0518 00:45:29.822840       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0518 00:45:29.906271       1 shared_informer.go:270] caches populated
I0518 00:45:34.830746       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0518 00:45:40.075564       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0518 00:45:45.084562       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0518 00:45:50.233514       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0518 00:45:55.297467       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0518 00:46:00.332261       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0518 00:46:05.341652       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0518 00:46:10.628952       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0518 00:46:15.641022       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0518 00:46:20.655008       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0518 00:46:25.663610       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0518 00:46:30.674788       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0518 00:46:35.738896       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0518 00:46:40.750683       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0518 00:46:45.760472       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0518 00:46:50.771275       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0518 00:46:55.917822       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0518 00:47:00.925800       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0518 00:47:05.936314       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0518 00:47:10.943935       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0518 00:47:15.957532       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0518 00:47:20.964255       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0518 00:47:25.973717       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0518 00:47:30.985227       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0518 00:47:35.994108       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0518 00:47:41.002912       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0518 00:47:46.015076       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0518 00:47:51.204187       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0518 00:47:56.215381       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0518 00:48:01.224171       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0518 00:48:06.489887       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0518 00:48:11.498672       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0518 00:48:16.507345       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0518 00:48:21.517120       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0518 00:48:26.526911       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0518 00:48:31.534849       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0518 00:48:36.543741       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0518 00:48:41.556651       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0518 00:48:46.567965       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0518 00:48:47.012827       1 controller.go:208] Started VA processing "csi-3c5e0857e49d00f87828a5f99b36d7630bf9a49b8d2850d579f317c868f0ea96"
I0518 00:48:47.012875       1 trivial_handler.go:53] Trivial sync[csi-3c5e0857e49d00f87828a5f99b36d7630bf9a49b8d2850d579f317c868f0ea96] started
I0518 00:48:47.012882       1 util.go:38] Marking as attached "csi-3c5e0857e49d00f87828a5f99b36d7630bf9a49b8d2850d579f317c868f0ea96"
I0518 00:48:47.024582       1 util.go:52] Marked as attached "csi-3c5e0857e49d00f87828a5f99b36d7630bf9a49b8d2850d579f317c868f0ea96"
I0518 00:48:47.024615       1 trivial_handler.go:61] Marked VolumeAttachment csi-3c5e0857e49d00f87828a5f99b36d7630bf9a49b8d2850d579f317c868f0ea96 as attached
I0518 00:48:47.024661       1 controller.go:208] Started VA processing "csi-3c5e0857e49d00f87828a5f99b36d7630bf9a49b8d2850d579f317c868f0ea96"
I0518 00:48:47.024672       1 trivial_handler.go:53] Trivial sync[csi-3c5e0857e49d00f87828a5f99b36d7630bf9a49b8d2850d579f317c868f0ea96] started
I0518 00:48:51.581127       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0518 00:48:56.591113       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0518 00:49:02.614397       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0518 00:49:07.626281       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0518 00:49:11.814632       1 controller.go:259] Started PV processing "pvc-e76875ea-520a-495a-a6d6-0e724cf7ac6d"
I0518 00:49:12.635253       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0518 00:49:17.645007       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0518 00:49:22.659819       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0518 00:49:27.669993       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0518 00:49:32.677486       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com