I0625 22:28:37.061457       1 main.go:92] Version: v3.4.0
I0625 22:28:37.062429       1 connection.go:154] Connecting to unix:///csi/csi-provisioner.sock
I0625 22:28:38.064026       1 common.go:111] Probing CSI driver for readiness
I0625 22:28:38.064062       1 connection.go:183] GRPC call: /csi.v1.Identity/Probe
I0625 22:28:38.064071       1 connection.go:184] GRPC request: {}
I0625 22:28:38.068222       1 connection.go:186] GRPC response: {}
I0625 22:28:38.068300       1 connection.go:187] GRPC error: <nil>
I0625 22:28:38.068316       1 connection.go:183] GRPC call: /csi.v1.Identity/GetPluginInfo
I0625 22:28:38.068323       1 connection.go:184] GRPC request: {}
I0625 22:28:38.068873       1 connection.go:186] GRPC response: {"name":"rbd.csi.ceph.com","vendor_version":"v3.5.1"}
I0625 22:28:38.068969       1 connection.go:187] GRPC error: <nil>
I0625 22:28:38.068983       1 main.go:148] CSI driver name: "rbd.csi.ceph.com"
I0625 22:28:38.069820       1 connection.go:154] Connecting to unix:///csi/csi-provisioner.sock
I0625 22:28:38.070421       1 common.go:111] Probing CSI driver for readiness
I0625 22:28:38.070452       1 connection.go:183] GRPC call: /csi.v1.Identity/Probe
I0625 22:28:38.070460       1 connection.go:184] GRPC request: {}
I0625 22:28:38.071210       1 connection.go:186] GRPC response: {}
I0625 22:28:38.071268       1 connection.go:187] GRPC error: <nil>
I0625 22:28:38.071279       1 connection.go:183] GRPC call: /csi.v1.Identity/GetPluginCapabilities
I0625 22:28:38.071286       1 connection.go:184] GRPC request: {}
I0625 22:28:38.073112       1 connection.go:186] GRPC response: {"capabilities":[{"Type":{"Service":{"type":1}}},{"Type":{"VolumeExpansion":{"type":1}}},{"Type":{"Service":{"type":2}}}]}
I0625 22:28:38.073336       1 connection.go:187] GRPC error: <nil>
I0625 22:28:38.073346       1 connection.go:183] GRPC call: /csi.v1.Controller/ControllerGetCapabilities
I0625 22:28:38.073354       1 connection.go:184] GRPC request: {}
I0625 22:28:38.074243       1 connection.go:186] GRPC response: {"capabilities":[{"Type":{"Rpc":{"type":1}}},{"Type":{"Rpc":{"type":5}}},{"Type":{"Rpc":{"type":7}}},{"Type":{"Rpc":{"type":9}}}]}
I0625 22:28:38.074427       1 connection.go:187] GRPC error: <nil>
I0625 22:28:38.074501       1 main.go:226] CSI driver does not support ControllerPublishUnpublish, using trivial handler
I0625 22:28:38.075157       1 leaderelection.go:248] attempting to acquire leader lease kube-system/external-attacher-leader-rbd-csi-ceph-com...
I0625 22:28:38.086322       1 leaderelection.go:258] successfully acquired lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0625 22:28:38.086599       1 leader_election.go:212] new leader detected, current leader: ceph-csi-rbd-provisioner-6f6497f79c-pnsbn
I0625 22:28:38.087297       1 leader_election.go:205] became leader, starting
I0625 22:28:38.087343       1 controller.go:128] Starting CSI attacher
I0625 22:28:38.087565       1 reflector.go:219] Starting reflector *v1.VolumeAttachment (10m0s) from k8s.io/client-go/informers/factory.go:134
I0625 22:28:38.087579       1 reflector.go:255] Listing and watching *v1.VolumeAttachment from k8s.io/client-go/informers/factory.go:134
I0625 22:28:38.087850       1 reflector.go:219] Starting reflector *v1.PersistentVolume (10m0s) from k8s.io/client-go/informers/factory.go:134
I0625 22:28:38.087862       1 reflector.go:255] Listing and watching *v1.PersistentVolume from k8s.io/client-go/informers/factory.go:134
I0625 22:28:38.094817       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0625 22:28:38.188002       1 shared_informer.go:270] caches populated
I0625 22:28:43.108989       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0625 22:28:48.118589       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0625 22:28:53.125433       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0625 22:28:58.133393       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0625 22:29:03.141674       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0625 22:29:08.149826       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0625 22:29:13.157938       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0625 22:29:18.165284       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0625 22:29:23.174154       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0625 22:29:28.183161       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0625 22:29:33.191387       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0625 22:29:38.199136       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0625 22:29:43.207734       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0625 22:29:48.214225       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0625 22:29:53.228607       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0625 22:29:58.238642       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0625 22:30:03.248234       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0625 22:30:08.256800       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0625 22:30:13.266415       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0625 22:30:18.275472       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0625 22:30:23.287393       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0625 22:30:28.294530       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0625 22:30:33.305980       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0625 22:30:38.314536       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0625 22:30:43.322992       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0625 22:30:48.330645       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0625 22:30:53.340649       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0625 22:30:58.352056       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0625 22:31:03.359855       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0625 22:31:08.364852       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0625 22:31:13.373429       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0625 22:31:18.380456       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0625 22:31:23.390162       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0625 22:31:28.396463       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0625 22:31:33.405997       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0625 22:31:38.413255       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0625 22:31:43.420874       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0625 22:31:48.431401       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0625 22:31:53.440409       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0625 22:31:58.448698       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0625 22:32:03.459418       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0625 22:32:08.466621       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0625 22:32:13.475706       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0625 22:32:15.780842       1 controller.go:208] Started VA processing "csi-d68009c46a668a0694e525e49ec7179e3642a349d619ca6176767bc54b6f71bf"
I0625 22:32:15.780866       1 trivial_handler.go:53] Trivial sync[csi-d68009c46a668a0694e525e49ec7179e3642a349d619ca6176767bc54b6f71bf] started
I0625 22:32:15.780870       1 util.go:38] Marking as attached "csi-d68009c46a668a0694e525e49ec7179e3642a349d619ca6176767bc54b6f71bf"
I0625 22:32:15.788074       1 util.go:52] Marked as attached "csi-d68009c46a668a0694e525e49ec7179e3642a349d619ca6176767bc54b6f71bf"
I0625 22:32:15.788101       1 trivial_handler.go:61] Marked VolumeAttachment csi-d68009c46a668a0694e525e49ec7179e3642a349d619ca6176767bc54b6f71bf as attached
I0625 22:32:15.788491       1 controller.go:208] Started VA processing "csi-d68009c46a668a0694e525e49ec7179e3642a349d619ca6176767bc54b6f71bf"
I0625 22:32:15.788526       1 trivial_handler.go:53] Trivial sync[csi-d68009c46a668a0694e525e49ec7179e3642a349d619ca6176767bc54b6f71bf] started
I0625 22:32:18.485374       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0625 22:32:23.494649       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0625 22:32:28.502913       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0625 22:32:32.814577       1 controller.go:259] Started PV processing "pvc-5737d3e2-ea7b-4933-a368-0efa50748b6f"
I0625 22:32:33.511083       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0625 22:32:38.524682       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0625 22:32:43.531134       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0625 22:32:48.538049       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0625 22:32:53.546725       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0625 22:32:58.564814       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0625 22:33:03.572875       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com