I0420 02:07:56.856375       1 main.go:92] Version: v3.4.0
I0420 02:07:56.859510       1 connection.go:154] Connecting to unix:///csi/csi-provisioner.sock
I0420 02:07:57.860690       1 common.go:111] Probing CSI driver for readiness
I0420 02:07:57.860712       1 connection.go:183] GRPC call: /csi.v1.Identity/Probe
I0420 02:07:57.860716       1 connection.go:184] GRPC request: {}
I0420 02:07:57.865693       1 connection.go:186] GRPC response: {}
I0420 02:07:57.865842       1 connection.go:187] GRPC error: <nil>
I0420 02:07:57.865861       1 connection.go:183] GRPC call: /csi.v1.Identity/GetPluginInfo
I0420 02:07:57.865872       1 connection.go:184] GRPC request: {}
I0420 02:07:57.867440       1 connection.go:186] GRPC response: {"name":"rbd.csi.ceph.com","vendor_version":"v3.5.1"}
I0420 02:07:57.867565       1 connection.go:187] GRPC error: <nil>
I0420 02:07:57.867580       1 main.go:148] CSI driver name: "rbd.csi.ceph.com"
I0420 02:07:57.868777       1 connection.go:154] Connecting to unix:///csi/csi-provisioner.sock
I0420 02:07:57.869596       1 common.go:111] Probing CSI driver for readiness
I0420 02:07:57.869623       1 connection.go:183] GRPC call: /csi.v1.Identity/Probe
I0420 02:07:57.869632       1 connection.go:184] GRPC request: {}
I0420 02:07:57.870309       1 connection.go:186] GRPC response: {}
I0420 02:07:57.870353       1 connection.go:187] GRPC error: <nil>
I0420 02:07:57.870364       1 connection.go:183] GRPC call: /csi.v1.Identity/GetPluginCapabilities
I0420 02:07:57.870371       1 connection.go:184] GRPC request: {}
I0420 02:07:57.871447       1 connection.go:186] GRPC response: {"capabilities":[{"Type":{"Service":{"type":1}}},{"Type":{"VolumeExpansion":{"type":1}}},{"Type":{"Service":{"type":2}}}]}
I0420 02:07:57.871601       1 connection.go:187] GRPC error: <nil>
I0420 02:07:57.871609       1 connection.go:183] GRPC call: /csi.v1.Controller/ControllerGetCapabilities
I0420 02:07:57.871612       1 connection.go:184] GRPC request: {}
I0420 02:07:57.872345       1 connection.go:186] GRPC response: {"capabilities":[{"Type":{"Rpc":{"type":1}}},{"Type":{"Rpc":{"type":5}}},{"Type":{"Rpc":{"type":7}}},{"Type":{"Rpc":{"type":9}}}]}
I0420 02:07:57.872444       1 connection.go:187] GRPC error: <nil>
I0420 02:07:57.872455       1 main.go:226] CSI driver does not support ControllerPublishUnpublish, using trivial handler
I0420 02:07:57.873036       1 leaderelection.go:248] attempting to acquire leader lease kube-system/external-attacher-leader-rbd-csi-ceph-com...
I0420 02:07:57.887623       1 leaderelection.go:258] successfully acquired lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0420 02:07:57.887725       1 leader_election.go:212] new leader detected, current leader: ceph-csi-rbd-provisioner-6f6497f79c-zkq7g
I0420 02:07:57.887772       1 leader_election.go:205] became leader, starting
I0420 02:07:57.887825       1 controller.go:128] Starting CSI attacher
I0420 02:07:57.888174       1 reflector.go:219] Starting reflector *v1.PersistentVolume (10m0s) from k8s.io/client-go/informers/factory.go:134
I0420 02:07:57.888208       1 reflector.go:255] Listing and watching *v1.PersistentVolume from k8s.io/client-go/informers/factory.go:134
I0420 02:07:57.888224       1 reflector.go:219] Starting reflector *v1.VolumeAttachment (10m0s) from k8s.io/client-go/informers/factory.go:134
I0420 02:07:57.888238       1 reflector.go:255] Listing and watching *v1.VolumeAttachment from k8s.io/client-go/informers/factory.go:134
I0420 02:07:57.901084       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0420 02:07:57.988243       1 shared_informer.go:270] caches populated
I0420 02:08:02.913903       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0420 02:08:07.923739       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0420 02:08:12.935008       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0420 02:08:17.944518       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0420 02:08:22.952954       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0420 02:08:27.961880       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0420 02:08:32.971428       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0420 02:08:37.980494       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0420 02:08:42.986558       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0420 02:08:47.995383       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0420 02:08:53.006148       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0420 02:08:58.071858       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0420 02:09:03.080571       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0420 02:09:08.089665       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0420 02:09:13.097156       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0420 02:09:18.105794       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0420 02:09:23.113148       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0420 02:09:28.120183       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0420 02:09:33.130219       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0420 02:09:38.139595       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0420 02:09:43.151501       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0420 02:09:48.161417       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0420 02:09:53.169135       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0420 02:09:58.175672       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0420 02:10:03.187649       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0420 02:10:08.194845       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0420 02:10:13.204670       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0420 02:10:18.214387       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0420 02:10:23.224369       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0420 02:10:28.231979       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0420 02:10:33.243114       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0420 02:10:38.251821       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0420 02:10:43.263133       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0420 02:10:48.272019       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0420 02:10:55.664564       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0420 02:11:00.677626       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0420 02:11:05.688697       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0420 02:11:10.698075       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0420 02:11:14.438795       1 controller.go:208] Started VA processing "csi-850b8694f40939f3a10d3d2aef10bd21611da3ff51e9cece1d3fa94331eb9a98"
I0420 02:11:14.438888       1 trivial_handler.go:53] Trivial sync[csi-850b8694f40939f3a10d3d2aef10bd21611da3ff51e9cece1d3fa94331eb9a98] started
I0420 02:11:14.438897       1 util.go:38] Marking as attached "csi-850b8694f40939f3a10d3d2aef10bd21611da3ff51e9cece1d3fa94331eb9a98"
I0420 02:11:14.444564       1 util.go:52] Marked as attached "csi-850b8694f40939f3a10d3d2aef10bd21611da3ff51e9cece1d3fa94331eb9a98"
I0420 02:11:14.444604       1 trivial_handler.go:61] Marked VolumeAttachment csi-850b8694f40939f3a10d3d2aef10bd21611da3ff51e9cece1d3fa94331eb9a98 as attached
I0420 02:11:14.444717       1 controller.go:208] Started VA processing "csi-850b8694f40939f3a10d3d2aef10bd21611da3ff51e9cece1d3fa94331eb9a98"
I0420 02:11:14.444771       1 trivial_handler.go:53] Trivial sync[csi-850b8694f40939f3a10d3d2aef10bd21611da3ff51e9cece1d3fa94331eb9a98] started
I0420 02:11:15.707878       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0420 02:11:20.718458       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0420 02:11:25.732447       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0420 02:11:30.743541       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0420 02:11:35.751823       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0420 02:11:40.760875       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0420 02:11:42.935143       1 controller.go:259] Started PV processing "pvc-3f7836d3-3d8c-4889-8dac-481f572f5d67"
I0420 02:11:45.770166       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0420 02:11:50.780725       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0420 02:11:55.790579       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0420 02:12:00.801743       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0420 02:12:05.815080       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0420 02:12:10.825341       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com