I0416 22:54:36.429267       1 main.go:92] Version: v3.4.0
I0416 22:54:36.430193       1 connection.go:154] Connecting to unix:///csi/csi-provisioner.sock
I0416 22:54:37.431478       1 common.go:111] Probing CSI driver for readiness
I0416 22:54:37.431515       1 connection.go:183] GRPC call: /csi.v1.Identity/Probe
I0416 22:54:37.431525       1 connection.go:184] GRPC request: {}
I0416 22:54:37.437288       1 connection.go:186] GRPC response: {}
I0416 22:54:37.437534       1 connection.go:187] GRPC error: <nil>
I0416 22:54:37.437563       1 connection.go:183] GRPC call: /csi.v1.Identity/GetPluginInfo
I0416 22:54:37.437570       1 connection.go:184] GRPC request: {}
I0416 22:54:37.438634       1 connection.go:186] GRPC response: {"name":"rbd.csi.ceph.com","vendor_version":"v3.5.1"}
I0416 22:54:37.438743       1 connection.go:187] GRPC error: <nil>
I0416 22:54:37.438757       1 main.go:148] CSI driver name: "rbd.csi.ceph.com"
I0416 22:54:37.439923       1 connection.go:154] Connecting to unix:///csi/csi-provisioner.sock
I0416 22:54:37.440659       1 common.go:111] Probing CSI driver for readiness
I0416 22:54:37.440803       1 connection.go:183] GRPC call: /csi.v1.Identity/Probe
I0416 22:54:37.440950       1 connection.go:184] GRPC request: {}
I0416 22:54:37.442122       1 connection.go:186] GRPC response: {}
I0416 22:54:37.442215       1 connection.go:187] GRPC error: <nil>
I0416 22:54:37.442251       1 connection.go:183] GRPC call: /csi.v1.Identity/GetPluginCapabilities
I0416 22:54:37.442285       1 connection.go:184] GRPC request: {}
I0416 22:54:37.443262       1 connection.go:186] GRPC response: {"capabilities":[{"Type":{"Service":{"type":1}}},{"Type":{"VolumeExpansion":{"type":1}}},{"Type":{"Service":{"type":2}}}]}
I0416 22:54:37.443446       1 connection.go:187] GRPC error: <nil>
I0416 22:54:37.443456       1 connection.go:183] GRPC call: /csi.v1.Controller/ControllerGetCapabilities
I0416 22:54:37.443460       1 connection.go:184] GRPC request: {}
I0416 22:54:37.444695       1 connection.go:186] GRPC response: {"capabilities":[{"Type":{"Rpc":{"type":1}}},{"Type":{"Rpc":{"type":5}}},{"Type":{"Rpc":{"type":7}}},{"Type":{"Rpc":{"type":9}}}]}
I0416 22:54:37.444841       1 connection.go:187] GRPC error: <nil>
I0416 22:54:37.444858       1 main.go:226] CSI driver does not support ControllerPublishUnpublish, using trivial handler
I0416 22:54:37.445630       1 leaderelection.go:248] attempting to acquire leader lease kube-system/external-attacher-leader-rbd-csi-ceph-com...
I0416 22:54:37.463900       1 leaderelection.go:258] successfully acquired lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0416 22:54:37.463967       1 leader_election.go:212] new leader detected, current leader: ceph-csi-rbd-provisioner-6f6497f79c-xq9kf
I0416 22:54:37.464026       1 leader_election.go:205] became leader, starting
I0416 22:54:37.464052       1 controller.go:128] Starting CSI attacher
I0416 22:54:37.464404       1 reflector.go:219] Starting reflector *v1.PersistentVolume (10m0s) from k8s.io/client-go/informers/factory.go:134
I0416 22:54:37.464420       1 reflector.go:255] Listing and watching *v1.PersistentVolume from k8s.io/client-go/informers/factory.go:134
I0416 22:54:37.464696       1 reflector.go:219] Starting reflector *v1.VolumeAttachment (10m0s) from k8s.io/client-go/informers/factory.go:134
I0416 22:54:37.466399       1 reflector.go:255] Listing and watching *v1.VolumeAttachment from k8s.io/client-go/informers/factory.go:134
I0416 22:54:37.472186       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0416 22:54:37.564259       1 shared_informer.go:270] caches populated
I0416 22:54:42.481200       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0416 22:54:47.492763       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0416 22:54:52.501658       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0416 22:54:57.509809       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0416 22:55:02.518834       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0416 22:55:07.530185       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0416 22:55:12.543781       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0416 22:55:17.553059       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0416 22:55:22.562866       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0416 22:55:27.762904       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0416 22:55:32.780007       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0416 22:55:37.794163       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0416 22:55:42.803696       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0416 22:55:47.813000       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0416 22:55:52.822058       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0416 22:55:57.832237       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0416 22:56:02.841327       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0416 22:56:07.853921       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0416 22:56:12.861167       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0416 22:56:17.870237       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0416 22:56:22.879951       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0416 22:56:27.893434       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0416 22:56:32.902416       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0416 22:56:37.913262       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0416 22:56:42.922179       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0416 22:56:47.931773       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0416 22:56:52.971680       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0416 22:56:57.980443       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0416 22:57:02.990130       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0416 22:57:08.001114       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0416 22:57:13.009400       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0416 22:57:18.017755       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0416 22:57:23.025189       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0416 22:57:28.034116       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0416 22:57:33.043558       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0416 22:57:38.057511       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0416 22:57:41.959464       1 controller.go:208] Started VA processing "csi-c6e7ef4a4b4e4de4f60fbf5fbe98d643aea0b5271dc52335a981eb427fcc8990"
I0416 22:57:41.959494       1 trivial_handler.go:53] Trivial sync[csi-c6e7ef4a4b4e4de4f60fbf5fbe98d643aea0b5271dc52335a981eb427fcc8990] started
I0416 22:57:41.959499       1 util.go:38] Marking as attached "csi-c6e7ef4a4b4e4de4f60fbf5fbe98d643aea0b5271dc52335a981eb427fcc8990"
I0416 22:57:41.966018       1 util.go:52] Marked as attached "csi-c6e7ef4a4b4e4de4f60fbf5fbe98d643aea0b5271dc52335a981eb427fcc8990"
I0416 22:57:41.966051       1 trivial_handler.go:61] Marked VolumeAttachment csi-c6e7ef4a4b4e4de4f60fbf5fbe98d643aea0b5271dc52335a981eb427fcc8990 as attached
I0416 22:57:41.966092       1 controller.go:208] Started VA processing "csi-c6e7ef4a4b4e4de4f60fbf5fbe98d643aea0b5271dc52335a981eb427fcc8990"
I0416 22:57:41.966103       1 trivial_handler.go:53] Trivial sync[csi-c6e7ef4a4b4e4de4f60fbf5fbe98d643aea0b5271dc52335a981eb427fcc8990] started
I0416 22:57:43.068608       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0416 22:57:48.080982       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0416 22:57:53.089943       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0416 22:57:58.099305       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0416 22:58:03.108626       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0416 22:58:05.133075       1 controller.go:259] Started PV processing "pvc-32b25e9f-2a25-4792-a18a-89ac15da89ed"
I0416 22:58:08.118693       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0416 22:58:13.127946       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0416 22:58:18.135981       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0416 22:58:23.144494       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0416 22:58:28.154328       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0416 22:58:33.163270       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com