I0628 20:01:42.238493       1 main.go:92] Version: v3.4.0
I0628 20:01:42.241139       1 connection.go:154] Connecting to unix:///csi/csi-provisioner.sock
I0628 20:01:43.244439       1 common.go:111] Probing CSI driver for readiness
I0628 20:01:43.244466       1 connection.go:183] GRPC call: /csi.v1.Identity/Probe
I0628 20:01:43.244473       1 connection.go:184] GRPC request: {}
I0628 20:01:43.249902       1 connection.go:186] GRPC response: {}
I0628 20:01:43.250004       1 connection.go:187] GRPC error: <nil>
I0628 20:01:43.250023       1 connection.go:183] GRPC call: /csi.v1.Identity/GetPluginInfo
I0628 20:01:43.250032       1 connection.go:184] GRPC request: {}
I0628 20:01:43.250732       1 connection.go:186] GRPC response: {"name":"rbd.csi.ceph.com","vendor_version":"v3.5.1"}
I0628 20:01:43.250817       1 connection.go:187] GRPC error: <nil>
I0628 20:01:43.250828       1 main.go:148] CSI driver name: "rbd.csi.ceph.com"
I0628 20:01:43.251629       1 connection.go:154] Connecting to unix:///csi/csi-provisioner.sock
I0628 20:01:43.252099       1 common.go:111] Probing CSI driver for readiness
I0628 20:01:43.252128       1 connection.go:183] GRPC call: /csi.v1.Identity/Probe
I0628 20:01:43.252151       1 connection.go:184] GRPC request: {}
I0628 20:01:43.252624       1 connection.go:186] GRPC response: {}
I0628 20:01:43.252644       1 connection.go:187] GRPC error: <nil>
I0628 20:01:43.252650       1 connection.go:183] GRPC call: /csi.v1.Identity/GetPluginCapabilities
I0628 20:01:43.252653       1 connection.go:184] GRPC request: {}
I0628 20:01:43.253126       1 connection.go:186] GRPC response: {"capabilities":[{"Type":{"Service":{"type":1}}},{"Type":{"VolumeExpansion":{"type":1}}},{"Type":{"Service":{"type":2}}}]}
I0628 20:01:43.253246       1 connection.go:187] GRPC error: <nil>
I0628 20:01:43.253261       1 connection.go:183] GRPC call: /csi.v1.Controller/ControllerGetCapabilities
I0628 20:01:43.253272       1 connection.go:184] GRPC request: {}
I0628 20:01:43.253771       1 connection.go:186] GRPC response: {"capabilities":[{"Type":{"Rpc":{"type":1}}},{"Type":{"Rpc":{"type":5}}},{"Type":{"Rpc":{"type":7}}},{"Type":{"Rpc":{"type":9}}}]}
I0628 20:01:43.253899       1 connection.go:187] GRPC error: <nil>
I0628 20:01:43.253929       1 main.go:226] CSI driver does not support ControllerPublishUnpublish, using trivial handler
I0628 20:01:43.254326       1 leaderelection.go:248] attempting to acquire leader lease kube-system/external-attacher-leader-rbd-csi-ceph-com...
I0628 20:01:43.265772       1 leaderelection.go:258] successfully acquired lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0628 20:01:43.265820       1 leader_election.go:212] new leader detected, current leader: ceph-csi-rbd-provisioner-6f6497f79c-gbdt9
I0628 20:01:43.265897       1 leader_election.go:205] became leader, starting
I0628 20:01:43.265971       1 controller.go:128] Starting CSI attacher
I0628 20:01:43.266298       1 reflector.go:219] Starting reflector *v1.PersistentVolume (10m0s) from k8s.io/client-go/informers/factory.go:134
I0628 20:01:43.266313       1 reflector.go:255] Listing and watching *v1.PersistentVolume from k8s.io/client-go/informers/factory.go:134
I0628 20:01:43.266451       1 reflector.go:219] Starting reflector *v1.VolumeAttachment (10m0s) from k8s.io/client-go/informers/factory.go:134
I0628 20:01:43.266475       1 reflector.go:255] Listing and watching *v1.VolumeAttachment from k8s.io/client-go/informers/factory.go:134
I0628 20:01:43.276101       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0628 20:01:43.366258       1 shared_informer.go:270] caches populated
I0628 20:01:48.287421       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0628 20:01:53.295198       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0628 20:01:58.303921       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0628 20:02:03.317643       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0628 20:02:08.326891       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0628 20:02:13.334977       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0628 20:02:18.343391       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0628 20:02:23.350405       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0628 20:02:28.359637       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0628 20:02:33.370673       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0628 20:02:38.379101       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0628 20:02:43.387897       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0628 20:02:48.396591       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0628 20:02:53.407025       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0628 20:02:58.416348       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0628 20:03:03.428375       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0628 20:03:08.435603       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0628 20:03:13.445458       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0628 20:03:18.453659       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0628 20:03:23.464018       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0628 20:03:28.472478       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0628 20:03:33.480873       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0628 20:03:38.490686       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0628 20:03:43.499035       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0628 20:03:48.508626       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0628 20:03:53.516455       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0628 20:03:58.525749       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0628 20:04:03.534071       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0628 20:04:08.543011       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0628 20:04:13.552087       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0628 20:04:18.561632       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0628 20:04:23.569466       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0628 20:04:28.578030       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0628 20:04:33.585777       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0628 20:04:38.595832       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0628 20:04:43.604777       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0628 20:04:48.611714       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0628 20:04:53.620415       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0628 20:04:58.628930       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0628 20:05:03.638195       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0628 20:05:08.646816       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0628 20:05:13.655928       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0628 20:05:18.664347       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0628 20:05:20.050506       1 controller.go:208] Started VA processing "csi-f11c77a33161e37ff8c79d31a3954035f983c2c98538068ffaff48dee7246969"
I0628 20:05:20.050535       1 trivial_handler.go:53] Trivial sync[csi-f11c77a33161e37ff8c79d31a3954035f983c2c98538068ffaff48dee7246969] started
I0628 20:05:20.050540       1 util.go:38] Marking as attached "csi-f11c77a33161e37ff8c79d31a3954035f983c2c98538068ffaff48dee7246969"
I0628 20:05:20.055040       1 util.go:52] Marked as attached "csi-f11c77a33161e37ff8c79d31a3954035f983c2c98538068ffaff48dee7246969"
I0628 20:05:20.055058       1 trivial_handler.go:61] Marked VolumeAttachment csi-f11c77a33161e37ff8c79d31a3954035f983c2c98538068ffaff48dee7246969 as attached
I0628 20:05:20.055153       1 controller.go:208] Started VA processing "csi-f11c77a33161e37ff8c79d31a3954035f983c2c98538068ffaff48dee7246969"
I0628 20:05:20.055179       1 trivial_handler.go:53] Trivial sync[csi-f11c77a33161e37ff8c79d31a3954035f983c2c98538068ffaff48dee7246969] started
I0628 20:05:23.674091       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0628 20:05:28.684488       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0628 20:05:33.693422       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0628 20:05:38.701451       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0628 20:05:41.896078       1 controller.go:259] Started PV processing "pvc-45558e11-00d7-4c3a-bd3f-82edae7ae516"
I0628 20:05:43.710386       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0628 20:05:48.717750       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0628 20:05:53.731280       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0628 20:05:58.738246       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0628 20:06:03.752376       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com