I0428 07:35:01.895691       1 main.go:92] Version: v3.4.0
I0428 07:35:01.896708       1 connection.go:154] Connecting to unix:///csi/csi-provisioner.sock
I0428 07:35:02.900699       1 common.go:111] Probing CSI driver for readiness
I0428 07:35:02.900745       1 connection.go:183] GRPC call: /csi.v1.Identity/Probe
I0428 07:35:02.900754       1 connection.go:184] GRPC request: {}
I0428 07:35:02.905159       1 connection.go:186] GRPC response: {}
I0428 07:35:02.905221       1 connection.go:187] GRPC error: <nil>
I0428 07:35:02.905237       1 connection.go:183] GRPC call: /csi.v1.Identity/GetPluginInfo
I0428 07:35:02.905241       1 connection.go:184] GRPC request: {}
I0428 07:35:02.906495       1 connection.go:186] GRPC response: {"name":"rbd.csi.ceph.com","vendor_version":"v3.5.1"}
I0428 07:35:02.906670       1 connection.go:187] GRPC error: <nil>
I0428 07:35:02.906686       1 main.go:148] CSI driver name: "rbd.csi.ceph.com"
I0428 07:35:02.907794       1 connection.go:154] Connecting to unix:///csi/csi-provisioner.sock
I0428 07:35:02.908999       1 common.go:111] Probing CSI driver for readiness
I0428 07:35:02.909028       1 connection.go:183] GRPC call: /csi.v1.Identity/Probe
I0428 07:35:02.909040       1 connection.go:184] GRPC request: {}
I0428 07:35:02.909775       1 connection.go:186] GRPC response: {}
I0428 07:35:02.909837       1 connection.go:187] GRPC error: <nil>
I0428 07:35:02.909850       1 connection.go:183] GRPC call: /csi.v1.Identity/GetPluginCapabilities
I0428 07:35:02.909886       1 connection.go:184] GRPC request: {}
I0428 07:35:02.910873       1 connection.go:186] GRPC response: {"capabilities":[{"Type":{"Service":{"type":1}}},{"Type":{"VolumeExpansion":{"type":1}}},{"Type":{"Service":{"type":2}}}]}
I0428 07:35:02.911048       1 connection.go:187] GRPC error: <nil>
I0428 07:35:02.911059       1 connection.go:183] GRPC call: /csi.v1.Controller/ControllerGetCapabilities
I0428 07:35:02.911063       1 connection.go:184] GRPC request: {}
I0428 07:35:02.911877       1 connection.go:186] GRPC response: {"capabilities":[{"Type":{"Rpc":{"type":1}}},{"Type":{"Rpc":{"type":5}}},{"Type":{"Rpc":{"type":7}}},{"Type":{"Rpc":{"type":9}}}]}
I0428 07:35:02.912002       1 connection.go:187] GRPC error: <nil>
I0428 07:35:02.912017       1 main.go:226] CSI driver does not support ControllerPublishUnpublish, using trivial handler
I0428 07:35:02.912723       1 leaderelection.go:248] attempting to acquire leader lease kube-system/external-attacher-leader-rbd-csi-ceph-com...
I0428 07:35:02.926862       1 leaderelection.go:258] successfully acquired lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0428 07:35:02.926970       1 leader_election.go:205] became leader, starting
I0428 07:35:02.926994       1 controller.go:128] Starting CSI attacher
I0428 07:35:02.926995       1 leader_election.go:212] new leader detected, current leader: ceph-csi-rbd-provisioner-6f6497f79c-djbj6
I0428 07:35:02.927315       1 reflector.go:219] Starting reflector *v1.VolumeAttachment (10m0s) from k8s.io/client-go/informers/factory.go:134
I0428 07:35:02.927333       1 reflector.go:255] Listing and watching *v1.VolumeAttachment from k8s.io/client-go/informers/factory.go:134
I0428 07:35:02.927337       1 reflector.go:219] Starting reflector *v1.PersistentVolume (10m0s) from k8s.io/client-go/informers/factory.go:134
I0428 07:35:02.927409       1 reflector.go:255] Listing and watching *v1.PersistentVolume from k8s.io/client-go/informers/factory.go:134
I0428 07:35:02.935929       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0428 07:35:03.028299       1 shared_informer.go:270] caches populated
I0428 07:35:07.982274       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0428 07:35:13.050842       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0428 07:35:18.061736       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0428 07:35:23.075812       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0428 07:35:28.084886       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0428 07:35:33.093425       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0428 07:35:38.103721       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0428 07:35:43.192072       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0428 07:35:48.278806       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0428 07:35:53.289058       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0428 07:35:58.300207       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0428 07:36:03.308417       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0428 07:36:08.390737       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0428 07:36:13.399375       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0428 07:36:18.421930       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0428 07:36:23.429432       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0428 07:36:28.440219       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0428 07:36:33.507152       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0428 07:36:38.516945       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0428 07:36:43.526052       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0428 07:36:48.536789       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0428 07:36:53.544459       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0428 07:36:58.550224       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0428 07:37:03.560681       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0428 07:37:08.571204       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0428 07:37:13.584716       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0428 07:37:18.593448       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0428 07:37:23.603642       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0428 07:37:28.612600       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0428 07:37:33.621541       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0428 07:37:38.633089       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0428 07:37:43.656633       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0428 07:37:48.666023       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0428 07:37:53.675010       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0428 07:37:58.683859       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0428 07:38:03.705465       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0428 07:38:08.721165       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0428 07:38:13.732024       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0428 07:38:16.845764       1 controller.go:208] Started VA processing "csi-1cfc3ae676ead4d6607e074541bd95962935bd83e647420dbef9a7d5b27871fa"
I0428 07:38:16.845796       1 trivial_handler.go:53] Trivial sync[csi-1cfc3ae676ead4d6607e074541bd95962935bd83e647420dbef9a7d5b27871fa] started
I0428 07:38:16.845801       1 util.go:38] Marking as attached "csi-1cfc3ae676ead4d6607e074541bd95962935bd83e647420dbef9a7d5b27871fa"
I0428 07:38:16.852432       1 util.go:52] Marked as attached "csi-1cfc3ae676ead4d6607e074541bd95962935bd83e647420dbef9a7d5b27871fa"
I0428 07:38:16.852463       1 trivial_handler.go:61] Marked VolumeAttachment csi-1cfc3ae676ead4d6607e074541bd95962935bd83e647420dbef9a7d5b27871fa as attached
I0428 07:38:16.852613       1 controller.go:208] Started VA processing "csi-1cfc3ae676ead4d6607e074541bd95962935bd83e647420dbef9a7d5b27871fa"
I0428 07:38:16.852659       1 trivial_handler.go:53] Trivial sync[csi-1cfc3ae676ead4d6607e074541bd95962935bd83e647420dbef9a7d5b27871fa] started
I0428 07:38:18.742009       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0428 07:38:23.788825       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0428 07:38:28.850507       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0428 07:38:33.862301       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0428 07:38:37.495014       1 controller.go:259] Started PV processing "pvc-6254d168-d606-4dbe-9ab0-643a39c6391f"
I0428 07:38:38.873802       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0428 07:38:43.883468       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0428 07:38:48.892710       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0428 07:38:53.899498       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0428 07:38:58.907982       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0428 07:39:03.918131       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com