I0420 11:57:56.787360       1 main.go:93] Version : v1.3.0
I0420 11:57:56.787413       1 feature_gate.go:245] feature gates: &{map[]}
I0420 11:57:56.791181       1 connection.go:154] Connecting to unix:///csi/csi-provisioner.sock
I0420 11:58:00.160913       1 common.go:111] Probing CSI driver for readiness
I0420 11:58:00.160959       1 connection.go:183] GRPC call: /csi.v1.Identity/Probe
I0420 11:58:00.160969       1 connection.go:184] GRPC request: {}
I0420 11:58:00.166919       1 connection.go:186] GRPC response: {}
I0420 11:58:00.167006       1 connection.go:187] GRPC error: <nil>
I0420 11:58:00.167023       1 connection.go:183] GRPC call: /csi.v1.Identity/GetPluginInfo
I0420 11:58:00.167027       1 connection.go:184] GRPC request: {}
I0420 11:58:00.167415       1 connection.go:186] GRPC response: {"name":"rbd.csi.ceph.com","vendor_version":"v3.5.1"}
I0420 11:58:00.167486       1 connection.go:187] GRPC error: <nil>
I0420 11:58:00.167501       1 main.go:141] CSI driver name: "rbd.csi.ceph.com"
I0420 11:58:00.167513       1 connection.go:183] GRPC call: /csi.v1.Identity/GetPluginCapabilities
I0420 11:58:00.167520       1 connection.go:184] GRPC request: {}
I0420 11:58:00.168324       1 connection.go:186] GRPC response: {"capabilities":[{"Type":{"Service":{"type":1}}},{"Type":{"VolumeExpansion":{"type":1}}},{"Type":{"Service":{"type":2}}}]}
I0420 11:58:00.168496       1 connection.go:187] GRPC error: <nil>
I0420 11:58:00.168511       1 connection.go:183] GRPC call: /csi.v1.Controller/ControllerGetCapabilities
I0420 11:58:00.168515       1 connection.go:184] GRPC request: {}
I0420 11:58:00.169021       1 connection.go:186] GRPC response: {"capabilities":[{"Type":{"Rpc":{"type":1}}},{"Type":{"Rpc":{"type":5}}},{"Type":{"Rpc":{"type":7}}},{"Type":{"Rpc":{"type":9}}}]}
I0420 11:58:00.169121       1 connection.go:187] GRPC error: <nil>
I0420 11:58:00.169129       1 connection.go:183] GRPC call: /csi.v1.Controller/ControllerGetCapabilities
I0420 11:58:00.169133       1 connection.go:184] GRPC request: {}
I0420 11:58:00.169451       1 connection.go:186] GRPC response: {"capabilities":[{"Type":{"Rpc":{"type":1}}},{"Type":{"Rpc":{"type":5}}},{"Type":{"Rpc":{"type":7}}},{"Type":{"Rpc":{"type":9}}}]}
I0420 11:58:00.169526       1 connection.go:187] GRPC error: <nil>
I0420 11:58:00.172861       1 leaderelection.go:248] attempting to acquire leader lease kube-system/external-resizer-rbd-csi-ceph-com...
I0420 11:58:00.185606       1 leaderelection.go:258] successfully acquired lease kube-system/external-resizer-rbd-csi-ceph-com
I0420 11:58:00.185977       1 leader_election.go:205] became leader, starting
I0420 11:58:00.187797       1 controller.go:251] Starting external resizer rbd.csi.ceph.com
I0420 11:58:00.187990       1 leader_election.go:212] new leader detected, current leader: ceph-csi-rbd-provisioner-6f6497f79c-tq8bj
I0420 11:58:00.188386       1 reflector.go:219] Starting reflector *v1.PersistentVolume (10m0s) from k8s.io/client-go/informers/factory.go:134
I0420 11:58:00.188423       1 reflector.go:255] Listing and watching *v1.PersistentVolume from k8s.io/client-go/informers/factory.go:134
I0420 11:58:00.189328       1 reflector.go:219] Starting reflector *v1.PersistentVolumeClaim (10m0s) from k8s.io/client-go/informers/factory.go:134
I0420 11:58:00.189813       1 reflector.go:255] Listing and watching *v1.PersistentVolumeClaim from k8s.io/client-go/informers/factory.go:134
I0420 11:58:00.193909       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0420 11:58:00.288027       1 shared_informer.go:270] caches populated
I0420 11:58:05.212187       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0420 11:58:10.222280       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0420 11:58:15.237320       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0420 11:58:20.248009       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0420 11:58:25.258685       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0420 11:58:30.266766       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0420 11:58:35.276451       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0420 11:58:40.288455       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0420 11:58:45.298871       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0420 11:58:50.310137       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0420 11:58:55.319428       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0420 11:59:00.328106       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0420 11:59:05.341437       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0420 11:59:10.350195       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0420 11:59:15.363970       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0420 11:59:20.373727       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0420 11:59:25.385240       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0420 11:59:30.394690       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0420 11:59:35.405596       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0420 11:59:40.416649       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0420 11:59:45.429754       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0420 11:59:50.439825       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0420 11:59:55.451862       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0420 12:00:00.460011       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0420 12:00:05.471401       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0420 12:00:10.483113       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0420 12:00:15.495316       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0420 12:00:20.503350       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0420 12:00:25.516798       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0420 12:00:30.528757       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0420 12:00:35.552402       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0420 12:00:40.562654       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0420 12:00:45.575714       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0420 12:00:50.589498       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0420 12:00:55.598975       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0420 12:01:00.606644       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0420 12:01:05.621205       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0420 12:01:10.629180       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0420 12:01:11.419568       1 controller.go:291] Started PVC processing "default/test-pvc"
W0420 12:01:11.419714       1 controller.go:318] PV "" bound to PVC default/test-pvc not found
I0420 12:01:13.454143       1 controller.go:291] Started PVC processing "default/test-pvc"
I0420 12:01:13.454167       1 controller.go:334] No need to resize PVC "default/test-pvc"
I0420 12:01:15.637872       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0420 12:01:20.650289       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0420 12:01:25.662841       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0420 12:01:30.673306       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0420 12:01:35.679640       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0420 12:01:40.687661       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0420 12:01:45.700910       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0420 12:01:50.713225       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0420 12:01:55.725546       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0420 12:02:00.735720       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0420 12:02:05.747770       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com