I0227 18:22:54.410968       1 main.go:93] Version : v1.3.0
I0227 18:22:54.411049       1 feature_gate.go:245] feature gates: &{map[]}
I0227 18:22:54.413673       1 connection.go:154] Connecting to unix:///csi/csi-provisioner.sock
W0227 18:23:04.414409       1 connection.go:173] Still connecting to unix:///csi/csi-provisioner.sock
I0227 18:23:05.421259       1 common.go:111] Probing CSI driver for readiness
I0227 18:23:05.421399       1 connection.go:183] GRPC call: /csi.v1.Identity/Probe
I0227 18:23:05.421449       1 connection.go:184] GRPC request: {}
I0227 18:23:05.427948       1 connection.go:186] GRPC response: {}
I0227 18:23:05.428012       1 connection.go:187] GRPC error: <nil>
I0227 18:23:05.428051       1 connection.go:183] GRPC call: /csi.v1.Identity/GetPluginInfo
I0227 18:23:05.428059       1 connection.go:184] GRPC request: {}
I0227 18:23:05.428562       1 connection.go:186] GRPC response: {"name":"rbd.csi.ceph.com","vendor_version":"v3.5.1"}
I0227 18:23:05.428609       1 connection.go:187] GRPC error: <nil>
I0227 18:23:05.428619       1 main.go:141] CSI driver name: "rbd.csi.ceph.com"
I0227 18:23:05.428700       1 connection.go:183] GRPC call: /csi.v1.Identity/GetPluginCapabilities
I0227 18:23:05.428734       1 connection.go:184] GRPC request: {}
I0227 18:23:05.429406       1 connection.go:186] GRPC response: {"capabilities":[{"Type":{"Service":{"type":1}}},{"Type":{"VolumeExpansion":{"type":1}}},{"Type":{"Service":{"type":2}}}]}
I0227 18:23:05.429703       1 connection.go:187] GRPC error: <nil>
I0227 18:23:05.429765       1 connection.go:183] GRPC call: /csi.v1.Controller/ControllerGetCapabilities
I0227 18:23:05.430023       1 connection.go:184] GRPC request: {}
I0227 18:23:05.430706       1 connection.go:186] GRPC response: {"capabilities":[{"Type":{"Rpc":{"type":1}}},{"Type":{"Rpc":{"type":5}}},{"Type":{"Rpc":{"type":7}}},{"Type":{"Rpc":{"type":9}}}]}
I0227 18:23:05.430816       1 connection.go:187] GRPC error: <nil>
I0227 18:23:05.430824       1 connection.go:183] GRPC call: /csi.v1.Controller/ControllerGetCapabilities
I0227 18:23:05.430828       1 connection.go:184] GRPC request: {}
I0227 18:23:05.431517       1 connection.go:186] GRPC response: {"capabilities":[{"Type":{"Rpc":{"type":1}}},{"Type":{"Rpc":{"type":5}}},{"Type":{"Rpc":{"type":7}}},{"Type":{"Rpc":{"type":9}}}]}
I0227 18:23:05.431581       1 connection.go:187] GRPC error: <nil>
I0227 18:23:05.432502       1 leaderelection.go:248] attempting to acquire leader lease kube-system/external-resizer-rbd-csi-ceph-com...
I0227 18:23:06.236337       1 leaderelection.go:258] successfully acquired lease kube-system/external-resizer-rbd-csi-ceph-com
I0227 18:23:06.236901       1 leader_election.go:212] new leader detected, current leader: ceph-csi-rbd-provisioner-6f6497f79c-slrd8
I0227 18:23:06.237252       1 leader_election.go:205] became leader, starting
I0227 18:23:06.237334       1 controller.go:251] Starting external resizer rbd.csi.ceph.com
I0227 18:23:06.237662       1 reflector.go:219] Starting reflector *v1.PersistentVolume (10m0s) from k8s.io/client-go/informers/factory.go:134
I0227 18:23:06.237689       1 reflector.go:255] Listing and watching *v1.PersistentVolume from k8s.io/client-go/informers/factory.go:134
I0227 18:23:06.238874       1 reflector.go:219] Starting reflector *v1.PersistentVolumeClaim (10m0s) from k8s.io/client-go/informers/factory.go:134
I0227 18:23:06.238902       1 reflector.go:255] Listing and watching *v1.PersistentVolumeClaim from k8s.io/client-go/informers/factory.go:134
I0227 18:23:06.338447       1 shared_informer.go:270] caches populated
I0227 18:23:06.542718       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0227 18:23:11.551539       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0227 18:23:16.561771       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0227 18:23:21.570543       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0227 18:23:26.581793       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0227 18:23:31.591713       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0227 18:23:36.601680       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0227 18:23:41.609514       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0227 18:23:46.618438       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0227 18:23:51.629439       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0227 18:23:56.638295       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0227 18:24:01.649350       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0227 18:24:06.658585       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0227 18:24:11.668354       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0227 18:24:16.677047       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0227 18:24:21.685764       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0227 18:24:26.693411       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0227 18:24:31.701873       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0227 18:24:36.711089       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0227 18:24:41.724861       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0227 18:24:46.733381       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0227 18:24:51.744046       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0227 18:24:56.755008       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0227 18:25:01.763492       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0227 18:25:06.772807       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0227 18:25:11.781832       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0227 18:25:16.793596       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0227 18:25:21.802582       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0227 18:25:26.810469       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0227 18:25:31.819027       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0227 18:25:36.827700       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0227 18:25:41.839580       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0227 18:25:46.851677       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0227 18:25:51.860444       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0227 18:25:56.867043       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0227 18:26:00.245962       1 controller.go:291] Started PVC processing "default/test-pvc"
W0227 18:26:00.246003       1 controller.go:318] PV "" bound to PVC default/test-pvc not found
I0227 18:26:01.652112       1 controller.go:291] Started PVC processing "default/test-pvc"
I0227 18:26:01.652139       1 controller.go:334] No need to resize PVC "default/test-pvc"
I0227 18:26:01.909309       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0227 18:26:06.919040       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0227 18:26:11.932597       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0227 18:26:16.943951       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0227 18:26:21.950881       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0227 18:26:26.956544       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0227 18:26:31.969071       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0227 18:26:36.977217       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0227 18:26:41.986411       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com