I0331 20:23:41.658094       1 main.go:93] Version : v1.3.0
I0331 20:23:41.658154       1 feature_gate.go:245] feature gates: &{map[]}
I0331 20:23:41.659871       1 connection.go:154] Connecting to unix:///csi/csi-provisioner.sock
I0331 20:23:44.918126       1 common.go:111] Probing CSI driver for readiness
I0331 20:23:44.918146       1 connection.go:183] GRPC call: /csi.v1.Identity/Probe
I0331 20:23:44.918153       1 connection.go:184] GRPC request: {}
I0331 20:23:44.923443       1 connection.go:186] GRPC response: {}
I0331 20:23:44.923505       1 connection.go:187] GRPC error: <nil>
I0331 20:23:44.923519       1 connection.go:183] GRPC call: /csi.v1.Identity/GetPluginInfo
I0331 20:23:44.923523       1 connection.go:184] GRPC request: {}
I0331 20:23:44.924274       1 connection.go:186] GRPC response: {"name":"rbd.csi.ceph.com","vendor_version":"v3.5.1"}
I0331 20:23:44.924318       1 connection.go:187] GRPC error: <nil>
I0331 20:23:44.924326       1 main.go:141] CSI driver name: "rbd.csi.ceph.com"
I0331 20:23:44.924334       1 connection.go:183] GRPC call: /csi.v1.Identity/GetPluginCapabilities
I0331 20:23:44.924337       1 connection.go:184] GRPC request: {}
I0331 20:23:44.925533       1 connection.go:186] GRPC response: {"capabilities":[{"Type":{"Service":{"type":1}}},{"Type":{"VolumeExpansion":{"type":1}}},{"Type":{"Service":{"type":2}}}]}
I0331 20:23:44.925656       1 connection.go:187] GRPC error: <nil>
I0331 20:23:44.925663       1 connection.go:183] GRPC call: /csi.v1.Controller/ControllerGetCapabilities
I0331 20:23:44.925667       1 connection.go:184] GRPC request: {}
I0331 20:23:44.926645       1 connection.go:186] GRPC response: {"capabilities":[{"Type":{"Rpc":{"type":1}}},{"Type":{"Rpc":{"type":5}}},{"Type":{"Rpc":{"type":7}}},{"Type":{"Rpc":{"type":9}}}]}
I0331 20:23:44.926738       1 connection.go:187] GRPC error: <nil>
I0331 20:23:44.926745       1 connection.go:183] GRPC call: /csi.v1.Controller/ControllerGetCapabilities
I0331 20:23:44.926748       1 connection.go:184] GRPC request: {}
I0331 20:23:44.927389       1 connection.go:186] GRPC response: {"capabilities":[{"Type":{"Rpc":{"type":1}}},{"Type":{"Rpc":{"type":5}}},{"Type":{"Rpc":{"type":7}}},{"Type":{"Rpc":{"type":9}}}]}
I0331 20:23:44.927438       1 connection.go:187] GRPC error: <nil>
I0331 20:23:44.928675       1 leaderelection.go:248] attempting to acquire leader lease kube-system/external-resizer-rbd-csi-ceph-com...
I0331 20:23:44.944316       1 leaderelection.go:258] successfully acquired lease kube-system/external-resizer-rbd-csi-ceph-com
I0331 20:23:44.944356       1 leader_election.go:212] new leader detected, current leader: ceph-csi-rbd-provisioner-6f6497f79c-wrf9v
I0331 20:23:44.944570       1 leader_election.go:205] became leader, starting
I0331 20:23:44.944598       1 controller.go:251] Starting external resizer rbd.csi.ceph.com
I0331 20:23:44.944800       1 reflector.go:219] Starting reflector *v1.PersistentVolume (10m0s) from k8s.io/client-go/informers/factory.go:134
I0331 20:23:44.944828       1 reflector.go:255] Listing and watching *v1.PersistentVolume from k8s.io/client-go/informers/factory.go:134
I0331 20:23:44.946038       1 reflector.go:219] Starting reflector *v1.PersistentVolumeClaim (10m0s) from k8s.io/client-go/informers/factory.go:134
I0331 20:23:44.946073       1 reflector.go:255] Listing and watching *v1.PersistentVolumeClaim from k8s.io/client-go/informers/factory.go:134
I0331 20:23:44.960369       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0331 20:23:45.045578       1 shared_informer.go:270] caches populated
I0331 20:23:49.970969       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0331 20:23:54.985295       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0331 20:23:59.998648       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0331 20:24:05.009120       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0331 20:24:10.022406       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0331 20:24:15.031229       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0331 20:24:20.171055       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0331 20:24:25.180058       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0331 20:24:30.191465       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0331 20:24:35.208724       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0331 20:24:40.220344       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0331 20:24:45.228529       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0331 20:24:50.241020       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0331 20:24:55.251809       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0331 20:25:00.262379       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0331 20:25:05.272478       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0331 20:25:10.287560       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0331 20:25:15.296391       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0331 20:25:20.424859       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0331 20:25:25.435391       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0331 20:25:30.446276       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0331 20:25:35.457678       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0331 20:25:40.466996       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0331 20:25:45.525247       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0331 20:25:50.536288       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0331 20:25:55.545806       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0331 20:26:00.560568       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0331 20:26:05.571035       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0331 20:26:10.580969       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0331 20:26:15.591499       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0331 20:26:20.604040       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0331 20:26:25.615164       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0331 20:26:30.625478       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0331 20:26:35.659194       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0331 20:26:40.673870       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0331 20:26:45.684267       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0331 20:26:50.693592       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0331 20:26:54.167275       1 controller.go:291] Started PVC processing "default/test-pvc"
W0331 20:26:54.167325       1 controller.go:318] PV "" bound to PVC default/test-pvc not found
I0331 20:26:55.610505       1 controller.go:291] Started PVC processing "default/test-pvc"
I0331 20:26:55.610537       1 controller.go:334] No need to resize PVC "default/test-pvc"
I0331 20:26:55.704966       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0331 20:27:00.719436       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0331 20:27:05.875967       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0331 20:27:10.921910       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0331 20:27:15.931499       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0331 20:27:20.943634       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0331 20:27:25.950749       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0331 20:27:30.958105       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0331 20:27:35.965123       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0331 20:27:40.975771       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0331 20:27:45.983345       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com