I0509 01:41:01.802146       1 main.go:93] Version : v1.3.0
I0509 01:41:01.802198       1 feature_gate.go:245] feature gates: &{map[]}
I0509 01:41:01.804215       1 connection.go:154] Connecting to unix:///csi/csi-provisioner.sock
W0509 01:41:11.805007       1 connection.go:173] Still connecting to unix:///csi/csi-provisioner.sock
I0509 01:41:15.273068       1 common.go:111] Probing CSI driver for readiness
I0509 01:41:15.273146       1 connection.go:183] GRPC call: /csi.v1.Identity/Probe
I0509 01:41:15.273203       1 connection.go:184] GRPC request: {}
I0509 01:41:15.280831       1 connection.go:186] GRPC response: {}
I0509 01:41:15.281694       1 connection.go:187] GRPC error: <nil>
I0509 01:41:15.281749       1 connection.go:183] GRPC call: /csi.v1.Identity/GetPluginInfo
I0509 01:41:15.281760       1 connection.go:184] GRPC request: {}
I0509 01:41:15.283077       1 connection.go:186] GRPC response: {"name":"rbd.csi.ceph.com","vendor_version":"v3.5.1"}
I0509 01:41:15.283214       1 connection.go:187] GRPC error: <nil>
I0509 01:41:15.283242       1 main.go:141] CSI driver name: "rbd.csi.ceph.com"
I0509 01:41:15.283279       1 connection.go:183] GRPC call: /csi.v1.Identity/GetPluginCapabilities
I0509 01:41:15.283291       1 connection.go:184] GRPC request: {}
I0509 01:41:15.284429       1 connection.go:186] GRPC response: {"capabilities":[{"Type":{"Service":{"type":1}}},{"Type":{"VolumeExpansion":{"type":1}}},{"Type":{"Service":{"type":2}}}]}
I0509 01:41:15.284647       1 connection.go:187] GRPC error: <nil>
I0509 01:41:15.284661       1 connection.go:183] GRPC call: /csi.v1.Controller/ControllerGetCapabilities
I0509 01:41:15.284666       1 connection.go:184] GRPC request: {}
I0509 01:41:15.285419       1 connection.go:186] GRPC response: {"capabilities":[{"Type":{"Rpc":{"type":1}}},{"Type":{"Rpc":{"type":5}}},{"Type":{"Rpc":{"type":7}}},{"Type":{"Rpc":{"type":9}}}]}
I0509 01:41:15.285521       1 connection.go:187] GRPC error: <nil>
I0509 01:41:15.285530       1 connection.go:183] GRPC call: /csi.v1.Controller/ControllerGetCapabilities
I0509 01:41:15.285533       1 connection.go:184] GRPC request: {}
I0509 01:41:15.286138       1 connection.go:186] GRPC response: {"capabilities":[{"Type":{"Rpc":{"type":1}}},{"Type":{"Rpc":{"type":5}}},{"Type":{"Rpc":{"type":7}}},{"Type":{"Rpc":{"type":9}}}]}
I0509 01:41:15.286268       1 connection.go:187] GRPC error: <nil>
I0509 01:41:15.288936       1 leaderelection.go:248] attempting to acquire leader lease kube-system/external-resizer-rbd-csi-ceph-com...
I0509 01:41:15.304085       1 leaderelection.go:258] successfully acquired lease kube-system/external-resizer-rbd-csi-ceph-com
I0509 01:41:15.304155       1 leader_election.go:212] new leader detected, current leader: ceph-csi-rbd-provisioner-6f6497f79c-424xq
I0509 01:41:15.304189       1 leader_election.go:205] became leader, starting
I0509 01:41:15.304218       1 controller.go:251] Starting external resizer rbd.csi.ceph.com
I0509 01:41:15.304663       1 reflector.go:219] Starting reflector *v1.PersistentVolumeClaim (10m0s) from k8s.io/client-go/informers/factory.go:134
I0509 01:41:15.304681       1 reflector.go:255] Listing and watching *v1.PersistentVolumeClaim from k8s.io/client-go/informers/factory.go:134
I0509 01:41:15.305244       1 reflector.go:219] Starting reflector *v1.PersistentVolume (10m0s) from k8s.io/client-go/informers/factory.go:134
I0509 01:41:15.305253       1 reflector.go:255] Listing and watching *v1.PersistentVolume from k8s.io/client-go/informers/factory.go:134
I0509 01:41:15.319708       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0509 01:41:15.404329       1 shared_informer.go:270] caches populated
I0509 01:41:20.427296       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0509 01:41:25.445505       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0509 01:41:30.453143       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0509 01:41:35.463805       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0509 01:41:40.477190       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0509 01:41:45.490734       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0509 01:41:50.525768       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0509 01:41:55.534829       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0509 01:42:00.550718       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0509 01:42:05.572174       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0509 01:42:10.586765       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0509 01:42:15.610087       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0509 01:42:20.622315       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0509 01:42:25.632193       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0509 01:42:30.642710       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0509 01:42:35.649707       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0509 01:42:40.660629       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0509 01:42:45.668858       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0509 01:42:50.683319       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0509 01:42:55.692276       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0509 01:43:00.706923       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0509 01:43:05.716438       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0509 01:43:10.726804       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0509 01:43:15.736847       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0509 01:43:20.747558       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0509 01:43:25.755545       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0509 01:43:30.766509       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0509 01:43:35.777233       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0509 01:43:40.787622       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0509 01:43:45.804794       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0509 01:43:50.816521       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0509 01:43:55.829980       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0509 01:44:00.838776       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0509 01:44:05.848167       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0509 01:44:10.857701       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0509 01:44:13.816302       1 controller.go:291] Started PVC processing "default/test-pvc"
W0509 01:44:13.816335       1 controller.go:318] PV "" bound to PVC default/test-pvc not found
I0509 01:44:15.820182       1 controller.go:291] Started PVC processing "default/test-pvc"
I0509 01:44:15.820210       1 controller.go:334] No need to resize PVC "default/test-pvc"
I0509 01:44:15.868762       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0509 01:44:20.882442       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0509 01:44:25.891856       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0509 01:44:30.938094       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0509 01:44:35.948486       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0509 01:44:40.956684       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0509 01:44:45.963541       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0509 01:44:50.973325       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0509 01:44:55.980387       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0509 01:45:00.990618       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0509 01:45:06.000790       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com