I0421 18:20:42.059442       1 main.go:92] Version: v3.4.0
I0421 18:20:42.060832       1 connection.go:154] Connecting to unix:///csi/csi-provisioner.sock
I0421 18:20:43.061771       1 common.go:111] Probing CSI driver for readiness
I0421 18:20:43.061809       1 connection.go:183] GRPC call: /csi.v1.Identity/Probe
I0421 18:20:43.061817       1 connection.go:184] GRPC request: {}
I0421 18:20:43.066980       1 connection.go:186] GRPC response: {}
I0421 18:20:43.067128       1 connection.go:187] GRPC error: <nil>
I0421 18:20:43.067146       1 connection.go:183] GRPC call: /csi.v1.Identity/GetPluginInfo
I0421 18:20:43.067153       1 connection.go:184] GRPC request: {}
I0421 18:20:43.069090       1 connection.go:186] GRPC response: {"name":"rbd.csi.ceph.com","vendor_version":"v3.5.1"}
I0421 18:20:43.069210       1 connection.go:187] GRPC error: <nil>
I0421 18:20:43.069227       1 main.go:148] CSI driver name: "rbd.csi.ceph.com"
I0421 18:20:43.070041       1 connection.go:154] Connecting to unix:///csi/csi-provisioner.sock
I0421 18:20:43.070571       1 common.go:111] Probing CSI driver for readiness
I0421 18:20:43.070586       1 connection.go:183] GRPC call: /csi.v1.Identity/Probe
I0421 18:20:43.070590       1 connection.go:184] GRPC request: {}
I0421 18:20:43.071167       1 connection.go:186] GRPC response: {}
I0421 18:20:43.071198       1 connection.go:187] GRPC error: <nil>
I0421 18:20:43.071238       1 connection.go:183] GRPC call: /csi.v1.Identity/GetPluginCapabilities
I0421 18:20:43.071255       1 connection.go:184] GRPC request: {}
I0421 18:20:43.071943       1 connection.go:186] GRPC response: {"capabilities":[{"Type":{"Service":{"type":1}}},{"Type":{"VolumeExpansion":{"type":1}}},{"Type":{"Service":{"type":2}}}]}
I0421 18:20:43.072077       1 connection.go:187] GRPC error: <nil>
I0421 18:20:43.072109       1 connection.go:183] GRPC call: /csi.v1.Controller/ControllerGetCapabilities
I0421 18:20:43.072113       1 connection.go:184] GRPC request: {}
I0421 18:20:43.073065       1 connection.go:186] GRPC response: {"capabilities":[{"Type":{"Rpc":{"type":1}}},{"Type":{"Rpc":{"type":5}}},{"Type":{"Rpc":{"type":7}}},{"Type":{"Rpc":{"type":9}}}]}
I0421 18:20:43.073153       1 connection.go:187] GRPC error: <nil>
I0421 18:20:43.073164       1 main.go:226] CSI driver does not support ControllerPublishUnpublish, using trivial handler
I0421 18:20:43.073841       1 leaderelection.go:248] attempting to acquire leader lease kube-system/external-attacher-leader-rbd-csi-ceph-com...
I0421 18:20:43.085889       1 leaderelection.go:258] successfully acquired lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0421 18:20:43.085918       1 leader_election.go:212] new leader detected, current leader: ceph-csi-rbd-provisioner-6f6497f79c-cgkr4
I0421 18:20:43.086015       1 leader_election.go:205] became leader, starting
I0421 18:20:43.086042       1 controller.go:128] Starting CSI attacher
I0421 18:20:43.086295       1 reflector.go:219] Starting reflector *v1.VolumeAttachment (10m0s) from k8s.io/client-go/informers/factory.go:134
I0421 18:20:43.086325       1 reflector.go:255] Listing and watching *v1.VolumeAttachment from k8s.io/client-go/informers/factory.go:134
I0421 18:20:43.086764       1 reflector.go:219] Starting reflector *v1.PersistentVolume (10m0s) from k8s.io/client-go/informers/factory.go:134
I0421 18:20:43.086791       1 reflector.go:255] Listing and watching *v1.PersistentVolume from k8s.io/client-go/informers/factory.go:134
I0421 18:20:43.092552       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0421 18:20:43.186705       1 shared_informer.go:270] caches populated
I0421 18:20:48.116746       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0421 18:20:53.131723       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0421 18:20:58.143929       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0421 18:21:03.155356       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0421 18:21:08.165218       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0421 18:21:13.175569       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0421 18:21:18.182614       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0421 18:21:23.193891       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0421 18:21:28.202655       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0421 18:21:33.211453       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0421 18:21:38.221264       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0421 18:21:43.231900       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0421 18:21:48.243125       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0421 18:21:53.250248       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0421 18:21:58.258411       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0421 18:22:03.270926       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0421 18:22:08.279210       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0421 18:22:13.286597       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0421 18:22:18.294859       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0421 18:22:23.303427       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0421 18:22:28.311647       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0421 18:22:33.320506       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0421 18:22:38.333787       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0421 18:22:43.342522       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0421 18:22:48.350872       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0421 18:22:53.362062       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0421 18:22:58.370858       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0421 18:23:03.379768       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0421 18:23:08.388587       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0421 18:23:13.400759       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0421 18:23:18.408344       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0421 18:23:23.417591       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0421 18:23:28.428486       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0421 18:23:33.436971       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0421 18:23:38.447315       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0421 18:23:43.454607       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0421 18:23:48.465173       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0421 18:23:53.474006       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0421 18:23:56.140957       1 controller.go:208] Started VA processing "csi-f63ba969c2887f66465a936fc2edc47d76f85022680d29cc7ce7afd142d6a256"
I0421 18:23:56.141055       1 trivial_handler.go:53] Trivial sync[csi-f63ba969c2887f66465a936fc2edc47d76f85022680d29cc7ce7afd142d6a256] started
I0421 18:23:56.141098       1 util.go:38] Marking as attached "csi-f63ba969c2887f66465a936fc2edc47d76f85022680d29cc7ce7afd142d6a256"
I0421 18:23:56.147077       1 util.go:52] Marked as attached "csi-f63ba969c2887f66465a936fc2edc47d76f85022680d29cc7ce7afd142d6a256"
I0421 18:23:56.147109       1 trivial_handler.go:61] Marked VolumeAttachment csi-f63ba969c2887f66465a936fc2edc47d76f85022680d29cc7ce7afd142d6a256 as attached
I0421 18:23:56.147169       1 controller.go:208] Started VA processing "csi-f63ba969c2887f66465a936fc2edc47d76f85022680d29cc7ce7afd142d6a256"
I0421 18:23:56.147186       1 trivial_handler.go:53] Trivial sync[csi-f63ba969c2887f66465a936fc2edc47d76f85022680d29cc7ce7afd142d6a256] started
I0421 18:23:58.486349       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0421 18:24:03.494446       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0421 18:24:08.504241       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0421 18:24:13.513310       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0421 18:24:16.371704       1 controller.go:259] Started PV processing "pvc-b6ac413e-eef3-4bea-a266-0b059f1e16ee"
I0421 18:24:18.524830       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0421 18:24:23.532978       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0421 18:24:28.539875       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0421 18:24:33.546968       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0421 18:24:38.557351       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0421 18:24:43.564600       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0421 18:24:48.575465       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com