I0427 21:03:51.607099       1 main.go:92] Version: v3.4.0
I0427 21:03:51.609513       1 connection.go:154] Connecting to unix:///csi/csi-provisioner.sock
I0427 21:03:52.610986       1 common.go:111] Probing CSI driver for readiness
I0427 21:03:52.611032       1 connection.go:183] GRPC call: /csi.v1.Identity/Probe
I0427 21:03:52.611042       1 connection.go:184] GRPC request: {}
I0427 21:03:52.618541       1 connection.go:186] GRPC response: {}
I0427 21:03:52.618657       1 connection.go:187] GRPC error: <nil>
I0427 21:03:52.618696       1 connection.go:183] GRPC call: /csi.v1.Identity/GetPluginInfo
I0427 21:03:52.618701       1 connection.go:184] GRPC request: {}
I0427 21:03:52.619485       1 connection.go:186] GRPC response: {"name":"rbd.csi.ceph.com","vendor_version":"v3.5.1"}
I0427 21:03:52.619538       1 connection.go:187] GRPC error: <nil>
I0427 21:03:52.619549       1 main.go:148] CSI driver name: "rbd.csi.ceph.com"
I0427 21:03:52.620175       1 connection.go:154] Connecting to unix:///csi/csi-provisioner.sock
I0427 21:03:52.620732       1 common.go:111] Probing CSI driver for readiness
I0427 21:03:52.620765       1 connection.go:183] GRPC call: /csi.v1.Identity/Probe
I0427 21:03:52.620769       1 connection.go:184] GRPC request: {}
I0427 21:03:52.621594       1 connection.go:186] GRPC response: {}
I0427 21:03:52.621614       1 connection.go:187] GRPC error: <nil>
I0427 21:03:52.621620       1 connection.go:183] GRPC call: /csi.v1.Identity/GetPluginCapabilities
I0427 21:03:52.621624       1 connection.go:184] GRPC request: {}
I0427 21:03:52.622595       1 connection.go:186] GRPC response: {"capabilities":[{"Type":{"Service":{"type":1}}},{"Type":{"VolumeExpansion":{"type":1}}},{"Type":{"Service":{"type":2}}}]}
I0427 21:03:52.622712       1 connection.go:187] GRPC error: <nil>
I0427 21:03:52.622716       1 connection.go:183] GRPC call: /csi.v1.Controller/ControllerGetCapabilities
I0427 21:03:52.622719       1 connection.go:184] GRPC request: {}
I0427 21:03:52.623456       1 connection.go:186] GRPC response: {"capabilities":[{"Type":{"Rpc":{"type":1}}},{"Type":{"Rpc":{"type":5}}},{"Type":{"Rpc":{"type":7}}},{"Type":{"Rpc":{"type":9}}}]}
I0427 21:03:52.623552       1 connection.go:187] GRPC error: <nil>
I0427 21:03:52.623561       1 main.go:226] CSI driver does not support ControllerPublishUnpublish, using trivial handler
I0427 21:03:52.624115       1 leaderelection.go:248] attempting to acquire leader lease kube-system/external-attacher-leader-rbd-csi-ceph-com...
I0427 21:03:52.641801       1 leaderelection.go:258] successfully acquired lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0427 21:03:52.641951       1 leader_election.go:212] new leader detected, current leader: ceph-csi-rbd-provisioner-6f6497f79c-g55wc
I0427 21:03:52.642050       1 leader_election.go:205] became leader, starting
I0427 21:03:52.642139       1 controller.go:128] Starting CSI attacher
I0427 21:03:52.642448       1 reflector.go:219] Starting reflector *v1.PersistentVolume (10m0s) from k8s.io/client-go/informers/factory.go:134
I0427 21:03:52.642463       1 reflector.go:255] Listing and watching *v1.PersistentVolume from k8s.io/client-go/informers/factory.go:134
I0427 21:03:52.642500       1 reflector.go:219] Starting reflector *v1.VolumeAttachment (10m0s) from k8s.io/client-go/informers/factory.go:134
I0427 21:03:52.642523       1 reflector.go:255] Listing and watching *v1.VolumeAttachment from k8s.io/client-go/informers/factory.go:134
I0427 21:03:52.652709       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0427 21:03:52.742734       1 shared_informer.go:270] caches populated
I0427 21:03:57.661861       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0427 21:04:02.673079       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0427 21:04:07.681451       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0427 21:04:12.691330       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0427 21:04:17.700811       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0427 21:04:22.710283       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0427 21:04:27.719490       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0427 21:04:32.727025       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0427 21:04:37.738045       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0427 21:04:42.746549       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0427 21:04:47.755377       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0427 21:04:52.763080       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0427 21:04:57.773398       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0427 21:05:02.785253       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0427 21:05:07.794901       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0427 21:05:12.803656       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0427 21:05:17.813007       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0427 21:05:22.824390       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0427 21:05:27.835755       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0427 21:05:32.847139       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0427 21:05:37.859381       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0427 21:05:42.866503       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0427 21:05:47.876042       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0427 21:05:52.888857       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0427 21:05:57.900856       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0427 21:06:02.908239       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0427 21:06:07.918653       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0427 21:06:12.927588       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0427 21:06:17.937592       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0427 21:06:22.945442       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0427 21:06:27.956675       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0427 21:06:32.970720       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0427 21:06:37.980202       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0427 21:06:42.988723       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0427 21:06:47.997464       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0427 21:06:53.006104       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0427 21:06:58.013277       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0427 21:07:03.021021       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0427 21:07:08.030741       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0427 21:07:10.600926       1 controller.go:208] Started VA processing "csi-3dc9a3ef0a8cb732a9041b31595c3baa183957e8eb4cefddd536c0f1eba73449"
I0427 21:07:10.600951       1 trivial_handler.go:53] Trivial sync[csi-3dc9a3ef0a8cb732a9041b31595c3baa183957e8eb4cefddd536c0f1eba73449] started
I0427 21:07:10.600955       1 util.go:38] Marking as attached "csi-3dc9a3ef0a8cb732a9041b31595c3baa183957e8eb4cefddd536c0f1eba73449"
I0427 21:07:10.606322       1 util.go:52] Marked as attached "csi-3dc9a3ef0a8cb732a9041b31595c3baa183957e8eb4cefddd536c0f1eba73449"
I0427 21:07:10.606353       1 trivial_handler.go:61] Marked VolumeAttachment csi-3dc9a3ef0a8cb732a9041b31595c3baa183957e8eb4cefddd536c0f1eba73449 as attached
I0427 21:07:10.606439       1 controller.go:208] Started VA processing "csi-3dc9a3ef0a8cb732a9041b31595c3baa183957e8eb4cefddd536c0f1eba73449"
I0427 21:07:10.606463       1 trivial_handler.go:53] Trivial sync[csi-3dc9a3ef0a8cb732a9041b31595c3baa183957e8eb4cefddd536c0f1eba73449] started
I0427 21:07:13.038015       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0427 21:07:18.131781       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0427 21:07:23.141332       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0427 21:07:25.910067       1 controller.go:259] Started PV processing "pvc-ead55d46-c9e6-431e-8343-9de5012dbb06"
I0427 21:07:28.150151       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0427 21:07:33.184870       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0427 21:07:38.192631       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0427 21:07:43.199775       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0427 21:07:48.208111       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0427 21:07:53.217464       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0427 21:07:58.226751       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com