I0626 02:25:16.245381       1 main.go:92] Version: v3.4.0
I0626 02:25:16.247339       1 connection.go:154] Connecting to unix:///csi/csi-provisioner.sock
I0626 02:25:17.248648       1 common.go:111] Probing CSI driver for readiness
I0626 02:25:17.248682       1 connection.go:183] GRPC call: /csi.v1.Identity/Probe
I0626 02:25:17.248689       1 connection.go:184] GRPC request: {}
I0626 02:25:17.254240       1 connection.go:186] GRPC response: {}
I0626 02:25:17.254394       1 connection.go:187] GRPC error: <nil>
I0626 02:25:17.254447       1 connection.go:183] GRPC call: /csi.v1.Identity/GetPluginInfo
I0626 02:25:17.254454       1 connection.go:184] GRPC request: {}
I0626 02:25:17.255864       1 connection.go:186] GRPC response: {"name":"rbd.csi.ceph.com","vendor_version":"v3.5.1"}
I0626 02:25:17.256147       1 connection.go:187] GRPC error: <nil>
I0626 02:25:17.256193       1 main.go:148] CSI driver name: "rbd.csi.ceph.com"
I0626 02:25:17.257386       1 connection.go:154] Connecting to unix:///csi/csi-provisioner.sock
I0626 02:25:17.258184       1 common.go:111] Probing CSI driver for readiness
I0626 02:25:17.258209       1 connection.go:183] GRPC call: /csi.v1.Identity/Probe
I0626 02:25:17.258216       1 connection.go:184] GRPC request: {}
I0626 02:25:17.259107       1 connection.go:186] GRPC response: {}
I0626 02:25:17.259141       1 connection.go:187] GRPC error: <nil>
I0626 02:25:17.259150       1 connection.go:183] GRPC call: /csi.v1.Identity/GetPluginCapabilities
I0626 02:25:17.259164       1 connection.go:184] GRPC request: {}
I0626 02:25:17.260206       1 connection.go:186] GRPC response: {"capabilities":[{"Type":{"Service":{"type":1}}},{"Type":{"VolumeExpansion":{"type":1}}},{"Type":{"Service":{"type":2}}}]}
I0626 02:25:17.260411       1 connection.go:187] GRPC error: <nil>
I0626 02:25:17.260420       1 connection.go:183] GRPC call: /csi.v1.Controller/ControllerGetCapabilities
I0626 02:25:17.260426       1 connection.go:184] GRPC request: {}
I0626 02:25:17.261885       1 connection.go:186] GRPC response: {"capabilities":[{"Type":{"Rpc":{"type":1}}},{"Type":{"Rpc":{"type":5}}},{"Type":{"Rpc":{"type":7}}},{"Type":{"Rpc":{"type":9}}}]}
I0626 02:25:17.262115       1 connection.go:187] GRPC error: <nil>
I0626 02:25:17.262139       1 main.go:226] CSI driver does not support ControllerPublishUnpublish, using trivial handler
I0626 02:25:17.263251       1 leaderelection.go:248] attempting to acquire leader lease kube-system/external-attacher-leader-rbd-csi-ceph-com...
I0626 02:25:17.309000       1 leaderelection.go:258] successfully acquired lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0626 02:25:17.309065       1 leader_election.go:212] new leader detected, current leader: ceph-csi-rbd-provisioner-6f6497f79c-bkg9l
I0626 02:25:17.309254       1 leader_election.go:205] became leader, starting
I0626 02:25:17.309278       1 controller.go:128] Starting CSI attacher
I0626 02:25:17.309842       1 reflector.go:219] Starting reflector *v1.PersistentVolume (10m0s) from k8s.io/client-go/informers/factory.go:134
I0626 02:25:17.309861       1 reflector.go:255] Listing and watching *v1.PersistentVolume from k8s.io/client-go/informers/factory.go:134
I0626 02:25:17.310135       1 reflector.go:219] Starting reflector *v1.VolumeAttachment (10m0s) from k8s.io/client-go/informers/factory.go:134
I0626 02:25:17.310161       1 reflector.go:255] Listing and watching *v1.VolumeAttachment from k8s.io/client-go/informers/factory.go:134
I0626 02:25:17.320156       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0626 02:25:17.409960       1 shared_informer.go:270] caches populated
I0626 02:25:22.332300       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0626 02:25:27.340044       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0626 02:25:32.350408       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0626 02:25:37.363501       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0626 02:25:42.372996       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0626 02:25:47.383915       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0626 02:25:52.395232       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0626 02:25:57.404606       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0626 02:26:02.416542       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0626 02:26:07.427068       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0626 02:26:12.437880       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0626 02:26:17.449892       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0626 02:26:22.460880       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0626 02:26:27.468557       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0626 02:26:32.476563       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0626 02:26:37.486259       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0626 02:26:42.498237       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0626 02:26:47.508224       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0626 02:26:52.519896       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0626 02:26:57.529403       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0626 02:27:02.538579       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0626 02:27:07.548829       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0626 02:27:12.558548       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0626 02:27:17.568689       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0626 02:27:22.579530       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0626 02:27:27.587577       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0626 02:27:32.596867       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0626 02:27:37.604522       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0626 02:27:42.613756       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0626 02:27:47.627870       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0626 02:27:52.638645       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0626 02:27:57.648855       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0626 02:28:02.661086       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0626 02:28:07.670279       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0626 02:28:12.682513       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0626 02:28:17.691687       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0626 02:28:22.702899       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0626 02:28:27.712900       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0626 02:28:32.721651       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0626 02:28:37.730622       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0626 02:28:42.741404       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0626 02:28:47.750646       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0626 02:28:52.762132       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0626 02:28:57.060902       1 controller.go:208] Started VA processing "csi-39077990dbda398e93be5fd69229b19832a9cc134e9eb57802c3630639824937"
I0626 02:28:57.060928       1 trivial_handler.go:53] Trivial sync[csi-39077990dbda398e93be5fd69229b19832a9cc134e9eb57802c3630639824937] started
I0626 02:28:57.060932       1 util.go:38] Marking as attached "csi-39077990dbda398e93be5fd69229b19832a9cc134e9eb57802c3630639824937"
I0626 02:28:57.066120       1 util.go:52] Marked as attached "csi-39077990dbda398e93be5fd69229b19832a9cc134e9eb57802c3630639824937"
I0626 02:28:57.066140       1 trivial_handler.go:61] Marked VolumeAttachment csi-39077990dbda398e93be5fd69229b19832a9cc134e9eb57802c3630639824937 as attached
I0626 02:28:57.066164       1 controller.go:208] Started VA processing "csi-39077990dbda398e93be5fd69229b19832a9cc134e9eb57802c3630639824937"
I0626 02:28:57.066174       1 trivial_handler.go:53] Trivial sync[csi-39077990dbda398e93be5fd69229b19832a9cc134e9eb57802c3630639824937] started
I0626 02:28:57.773841       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0626 02:29:02.784011       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0626 02:29:07.793612       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0626 02:29:11.765796       1 controller.go:259] Started PV processing "pvc-52c1107b-3cfe-45e6-bd8f-d8c7c972758d"
I0626 02:29:12.804456       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0626 02:29:17.812798       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0626 02:29:22.821538       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0626 02:29:27.830793       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0626 02:29:32.840092       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0626 02:29:37.850662       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0626 02:29:42.858736       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com