I0512 20:03:19.616759       1 main.go:93] Version : v1.3.0
I0512 20:03:19.616865       1 feature_gate.go:245] feature gates: &{map[]}
I0512 20:03:19.618250       1 connection.go:154] Connecting to unix:///csi/csi-provisioner.sock
I0512 20:03:26.061101       1 common.go:111] Probing CSI driver for readiness
I0512 20:03:26.061131       1 connection.go:183] GRPC call: /csi.v1.Identity/Probe
I0512 20:03:26.061138       1 connection.go:184] GRPC request: {}
I0512 20:03:26.066710       1 connection.go:186] GRPC response: {}
I0512 20:03:26.066899       1 connection.go:187] GRPC error: <nil>
I0512 20:03:26.066941       1 connection.go:183] GRPC call: /csi.v1.Identity/GetPluginInfo
I0512 20:03:26.066973       1 connection.go:184] GRPC request: {}
I0512 20:03:26.067504       1 connection.go:186] GRPC response: {"name":"rbd.csi.ceph.com","vendor_version":"v3.5.1"}
I0512 20:03:26.067561       1 connection.go:187] GRPC error: <nil>
I0512 20:03:26.067572       1 main.go:141] CSI driver name: "rbd.csi.ceph.com"
I0512 20:03:26.067582       1 connection.go:183] GRPC call: /csi.v1.Identity/GetPluginCapabilities
I0512 20:03:26.067586       1 connection.go:184] GRPC request: {}
I0512 20:03:26.068751       1 connection.go:186] GRPC response: {"capabilities":[{"Type":{"Service":{"type":1}}},{"Type":{"VolumeExpansion":{"type":1}}},{"Type":{"Service":{"type":2}}}]}
I0512 20:03:26.068896       1 connection.go:187] GRPC error: <nil>
I0512 20:03:26.068905       1 connection.go:183] GRPC call: /csi.v1.Controller/ControllerGetCapabilities
I0512 20:03:26.068909       1 connection.go:184] GRPC request: {}
I0512 20:03:26.069738       1 connection.go:186] GRPC response: {"capabilities":[{"Type":{"Rpc":{"type":1}}},{"Type":{"Rpc":{"type":5}}},{"Type":{"Rpc":{"type":7}}},{"Type":{"Rpc":{"type":9}}}]}
I0512 20:03:26.069961       1 connection.go:187] GRPC error: <nil>
I0512 20:03:26.069998       1 connection.go:183] GRPC call: /csi.v1.Controller/ControllerGetCapabilities
I0512 20:03:26.070034       1 connection.go:184] GRPC request: {}
I0512 20:03:26.070621       1 connection.go:186] GRPC response: {"capabilities":[{"Type":{"Rpc":{"type":1}}},{"Type":{"Rpc":{"type":5}}},{"Type":{"Rpc":{"type":7}}},{"Type":{"Rpc":{"type":9}}}]}
I0512 20:03:26.070719       1 connection.go:187] GRPC error: <nil>
I0512 20:03:26.072296       1 leaderelection.go:248] attempting to acquire leader lease kube-system/external-resizer-rbd-csi-ceph-com...
I0512 20:03:26.633608       1 leaderelection.go:258] successfully acquired lease kube-system/external-resizer-rbd-csi-ceph-com
I0512 20:03:26.633886       1 leader_election.go:212] new leader detected, current leader: ceph-csi-rbd-provisioner-6f6497f79c-2j5wn
I0512 20:03:26.634217       1 leader_election.go:205] became leader, starting
I0512 20:03:26.634242       1 controller.go:251] Starting external resizer rbd.csi.ceph.com
I0512 20:03:26.634517       1 reflector.go:219] Starting reflector *v1.PersistentVolumeClaim (10m0s) from k8s.io/client-go/informers/factory.go:134
I0512 20:03:26.634529       1 reflector.go:255] Listing and watching *v1.PersistentVolumeClaim from k8s.io/client-go/informers/factory.go:134
I0512 20:03:26.634865       1 reflector.go:219] Starting reflector *v1.PersistentVolume (10m0s) from k8s.io/client-go/informers/factory.go:134
I0512 20:03:26.634878       1 reflector.go:255] Listing and watching *v1.PersistentVolume from k8s.io/client-go/informers/factory.go:134
I0512 20:03:26.654021       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0512 20:03:26.734716       1 shared_informer.go:270] caches populated
I0512 20:03:31.797208       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0512 20:03:36.805348       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0512 20:03:41.814713       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0512 20:03:46.823212       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0512 20:03:51.831653       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0512 20:03:56.840669       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0512 20:04:01.857601       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0512 20:04:06.868961       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0512 20:04:11.878490       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0512 20:04:16.888162       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0512 20:04:21.898731       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0512 20:04:26.908929       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0512 20:04:31.917514       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0512 20:04:36.926785       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0512 20:04:41.936899       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0512 20:04:46.952006       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0512 20:04:51.959706       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0512 20:04:56.967400       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0512 20:05:01.976226       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0512 20:05:06.984410       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0512 20:05:11.991607       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0512 20:05:17.001864       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0512 20:05:22.042922       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0512 20:05:27.053480       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0512 20:05:32.062032       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0512 20:05:37.073946       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0512 20:05:42.080535       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0512 20:05:47.090105       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0512 20:05:52.101076       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0512 20:05:57.110120       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0512 20:06:02.122868       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0512 20:06:07.132178       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0512 20:06:12.143597       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0512 20:06:17.155395       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0512 20:06:22.164710       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0512 20:06:27.175460       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0512 20:06:32.184747       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0512 20:06:32.268737       1 controller.go:291] Started PVC processing "default/test-pvc"
W0512 20:06:32.268776       1 controller.go:318] PV "" bound to PVC default/test-pvc not found
I0512 20:06:33.971964       1 controller.go:291] Started PVC processing "default/test-pvc"
I0512 20:06:33.971995       1 controller.go:334] No need to resize PVC "default/test-pvc"
I0512 20:06:37.195341       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0512 20:06:42.204812       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0512 20:06:47.214223       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0512 20:06:52.221629       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0512 20:06:57.230393       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0512 20:07:02.240074       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0512 20:07:07.248372       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0512 20:07:12.254541       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0512 20:07:17.262132       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0512 20:07:22.272261       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0512 20:07:27.280561       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com