I0428 22:28:20.504746       1 main.go:93] Version : v1.3.0
I0428 22:28:20.504791       1 feature_gate.go:245] feature gates: &{map[]}
I0428 22:28:20.506050       1 connection.go:154] Connecting to unix:///csi/csi-provisioner.sock
I0428 22:28:25.669407       1 common.go:111] Probing CSI driver for readiness
I0428 22:28:25.669507       1 connection.go:183] GRPC call: /csi.v1.Identity/Probe
I0428 22:28:25.669578       1 connection.go:184] GRPC request: {}
I0428 22:28:25.678400       1 connection.go:186] GRPC response: {}
I0428 22:28:25.678605       1 connection.go:187] GRPC error: <nil>
I0428 22:28:25.678656       1 connection.go:183] GRPC call: /csi.v1.Identity/GetPluginInfo
I0428 22:28:25.678680       1 connection.go:184] GRPC request: {}
I0428 22:28:25.679787       1 connection.go:186] GRPC response: {"name":"rbd.csi.ceph.com","vendor_version":"v3.5.1"}
I0428 22:28:25.679963       1 connection.go:187] GRPC error: <nil>
I0428 22:28:25.680078       1 main.go:141] CSI driver name: "rbd.csi.ceph.com"
I0428 22:28:25.680233       1 connection.go:183] GRPC call: /csi.v1.Identity/GetPluginCapabilities
I0428 22:28:25.680344       1 connection.go:184] GRPC request: {}
I0428 22:28:25.681315       1 connection.go:186] GRPC response: {"capabilities":[{"Type":{"Service":{"type":1}}},{"Type":{"VolumeExpansion":{"type":1}}},{"Type":{"Service":{"type":2}}}]}
I0428 22:28:25.681512       1 connection.go:187] GRPC error: <nil>
I0428 22:28:25.681562       1 connection.go:183] GRPC call: /csi.v1.Controller/ControllerGetCapabilities
I0428 22:28:25.681567       1 connection.go:184] GRPC request: {}
I0428 22:28:25.682333       1 connection.go:186] GRPC response: {"capabilities":[{"Type":{"Rpc":{"type":1}}},{"Type":{"Rpc":{"type":5}}},{"Type":{"Rpc":{"type":7}}},{"Type":{"Rpc":{"type":9}}}]}
I0428 22:28:25.682450       1 connection.go:187] GRPC error: <nil>
I0428 22:28:25.682459       1 connection.go:183] GRPC call: /csi.v1.Controller/ControllerGetCapabilities
I0428 22:28:25.682463       1 connection.go:184] GRPC request: {}
I0428 22:28:25.683201       1 connection.go:186] GRPC response: {"capabilities":[{"Type":{"Rpc":{"type":1}}},{"Type":{"Rpc":{"type":5}}},{"Type":{"Rpc":{"type":7}}},{"Type":{"Rpc":{"type":9}}}]}
I0428 22:28:25.683264       1 connection.go:187] GRPC error: <nil>
I0428 22:28:25.685177       1 leaderelection.go:248] attempting to acquire leader lease kube-system/external-resizer-rbd-csi-ceph-com...
I0428 22:28:25.700151       1 leader_election.go:212] new leader detected, current leader: ceph-csi-rbd-provisioner-6f6497f79c-swpjj
I0428 22:28:25.700295       1 leaderelection.go:258] successfully acquired lease kube-system/external-resizer-rbd-csi-ceph-com
I0428 22:28:25.700672       1 leader_election.go:205] became leader, starting
I0428 22:28:25.700860       1 controller.go:251] Starting external resizer rbd.csi.ceph.com
I0428 22:28:25.701511       1 reflector.go:219] Starting reflector *v1.PersistentVolumeClaim (10m0s) from k8s.io/client-go/informers/factory.go:134
I0428 22:28:25.701671       1 reflector.go:255] Listing and watching *v1.PersistentVolumeClaim from k8s.io/client-go/informers/factory.go:134
I0428 22:28:25.702212       1 reflector.go:219] Starting reflector *v1.PersistentVolume (10m0s) from k8s.io/client-go/informers/factory.go:134
I0428 22:28:25.702252       1 reflector.go:255] Listing and watching *v1.PersistentVolume from k8s.io/client-go/informers/factory.go:134
I0428 22:28:25.711036       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0428 22:28:25.801192       1 shared_informer.go:270] caches populated
I0428 22:28:30.720519       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0428 22:28:35.737025       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0428 22:28:40.745188       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0428 22:28:45.754473       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0428 22:28:50.762337       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0428 22:28:55.771350       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0428 22:29:00.778728       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0428 22:29:05.792259       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0428 22:29:10.800224       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0428 22:29:15.812676       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0428 22:29:20.822435       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0428 22:29:25.836352       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0428 22:29:30.844647       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0428 22:29:35.851785       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0428 22:29:40.861298       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0428 22:29:45.871362       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0428 22:29:50.880552       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0428 22:29:55.889189       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0428 22:30:00.900397       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0428 22:30:05.906707       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0428 22:30:10.918201       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0428 22:30:15.928352       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0428 22:30:20.938154       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0428 22:30:25.945936       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0428 22:30:30.956175       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0428 22:30:35.966854       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0428 22:30:40.976694       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0428 22:30:45.984620       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0428 22:30:50.991897       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0428 22:30:56.002375       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0428 22:31:01.011137       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0428 22:31:06.020590       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0428 22:31:11.031492       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0428 22:31:16.041451       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0428 22:31:21.048973       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0428 22:31:26.061680       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0428 22:31:30.859518       1 controller.go:291] Started PVC processing "default/test-pvc"
W0428 22:31:30.859588       1 controller.go:318] PV "" bound to PVC default/test-pvc not found
I0428 22:31:31.069024       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0428 22:31:32.997975       1 controller.go:291] Started PVC processing "default/test-pvc"
I0428 22:31:32.998002       1 controller.go:334] No need to resize PVC "default/test-pvc"
I0428 22:31:36.076947       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0428 22:31:41.087087       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0428 22:31:46.095059       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0428 22:31:51.105255       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0428 22:31:56.114349       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0428 22:32:01.122691       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0428 22:32:06.131019       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0428 22:32:11.139590       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0428 22:32:16.146332       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0428 22:32:21.159947       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0428 22:32:26.168810       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com