I0225 06:13:24.421713       1 main.go:93] Version : v1.3.0
I0225 06:13:24.421763       1 feature_gate.go:245] feature gates: &{map[]}
I0225 06:13:24.423101       1 connection.go:154] Connecting to unix:///csi/csi-provisioner.sock
I0225 06:13:30.667439       1 common.go:111] Probing CSI driver for readiness
I0225 06:13:30.667467       1 connection.go:183] GRPC call: /csi.v1.Identity/Probe
I0225 06:13:30.667474       1 connection.go:184] GRPC request: {}
I0225 06:13:30.678094       1 connection.go:186] GRPC response: {}
I0225 06:13:30.678142       1 connection.go:187] GRPC error: <nil>
I0225 06:13:30.678151       1 connection.go:183] GRPC call: /csi.v1.Identity/GetPluginInfo
I0225 06:13:30.678154       1 connection.go:184] GRPC request: {}
I0225 06:13:30.678857       1 connection.go:186] GRPC response: {"name":"rbd.csi.ceph.com","vendor_version":"v3.5.1"}
I0225 06:13:30.678905       1 connection.go:187] GRPC error: <nil>
I0225 06:13:30.678913       1 main.go:141] CSI driver name: "rbd.csi.ceph.com"
I0225 06:13:30.678921       1 connection.go:183] GRPC call: /csi.v1.Identity/GetPluginCapabilities
I0225 06:13:30.678924       1 connection.go:184] GRPC request: {}
I0225 06:13:30.679957       1 connection.go:186] GRPC response: {"capabilities":[{"Type":{"Service":{"type":1}}},{"Type":{"VolumeExpansion":{"type":1}}},{"Type":{"Service":{"type":2}}}]}
I0225 06:13:30.680135       1 connection.go:187] GRPC error: <nil>
I0225 06:13:30.680150       1 connection.go:183] GRPC call: /csi.v1.Controller/ControllerGetCapabilities
I0225 06:13:30.680155       1 connection.go:184] GRPC request: {}
I0225 06:13:30.681159       1 connection.go:186] GRPC response: {"capabilities":[{"Type":{"Rpc":{"type":1}}},{"Type":{"Rpc":{"type":5}}},{"Type":{"Rpc":{"type":7}}},{"Type":{"Rpc":{"type":9}}}]}
I0225 06:13:30.681254       1 connection.go:187] GRPC error: <nil>
I0225 06:13:30.681262       1 connection.go:183] GRPC call: /csi.v1.Controller/ControllerGetCapabilities
I0225 06:13:30.681265       1 connection.go:184] GRPC request: {}
I0225 06:13:30.681885       1 connection.go:186] GRPC response: {"capabilities":[{"Type":{"Rpc":{"type":1}}},{"Type":{"Rpc":{"type":5}}},{"Type":{"Rpc":{"type":7}}},{"Type":{"Rpc":{"type":9}}}]}
I0225 06:13:30.681948       1 connection.go:187] GRPC error: <nil>
I0225 06:13:30.683050       1 leaderelection.go:248] attempting to acquire leader lease kube-system/external-resizer-rbd-csi-ceph-com...
I0225 06:13:30.696200       1 leaderelection.go:258] successfully acquired lease kube-system/external-resizer-rbd-csi-ceph-com
I0225 06:13:30.697078       1 leader_election.go:212] new leader detected, current leader: ceph-csi-rbd-provisioner-5d8ff44fc9-z5phb
I0225 06:13:30.697611       1 leader_election.go:205] became leader, starting
I0225 06:13:30.697636       1 controller.go:251] Starting external resizer rbd.csi.ceph.com
I0225 06:13:30.698040       1 reflector.go:219] Starting reflector *v1.PersistentVolume (10m0s) from k8s.io/client-go/informers/factory.go:134
I0225 06:13:30.698061       1 reflector.go:255] Listing and watching *v1.PersistentVolume from k8s.io/client-go/informers/factory.go:134
I0225 06:13:30.698759       1 reflector.go:219] Starting reflector *v1.PersistentVolumeClaim (10m0s) from k8s.io/client-go/informers/factory.go:134
I0225 06:13:30.698785       1 reflector.go:255] Listing and watching *v1.PersistentVolumeClaim from k8s.io/client-go/informers/factory.go:134
I0225 06:13:30.705358       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0225 06:13:30.798082       1 shared_informer.go:270] caches populated
I0225 06:13:35.714879       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0225 06:13:40.724235       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0225 06:13:45.735452       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0225 06:13:50.746033       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0225 06:13:55.755554       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0225 06:14:00.765773       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0225 06:14:05.777204       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0225 06:14:10.786161       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0225 06:14:15.798456       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0225 06:14:20.807191       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0225 06:14:25.815987       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0225 06:14:30.826302       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0225 06:14:35.835129       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0225 06:14:40.845106       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0225 06:14:45.853583       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0225 06:14:50.863738       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0225 06:14:55.874501       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0225 06:15:00.883007       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0225 06:15:05.890724       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0225 06:15:10.901119       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0225 06:15:15.911629       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0225 06:15:20.919287       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0225 06:15:25.927378       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0225 06:15:30.935703       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0225 06:15:35.943739       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0225 06:15:40.954364       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0225 06:15:45.964757       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0225 06:15:50.974330       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0225 06:15:55.983091       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0225 06:16:00.992050       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0225 06:16:06.000172       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0225 06:16:11.008457       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0225 06:16:16.016801       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0225 06:16:19.008082       1 controller.go:291] Started PVC processing "default/test-pvc"
W0225 06:16:19.008118       1 controller.go:318] PV "" bound to PVC default/test-pvc not found
I0225 06:16:21.026930       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0225 06:16:21.066370       1 controller.go:291] Started PVC processing "default/test-pvc"
I0225 06:16:21.066398       1 controller.go:334] No need to resize PVC "default/test-pvc"
I0225 06:16:26.038985       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0225 06:16:31.051044       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0225 06:16:36.059499       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0225 06:16:41.157181       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0225 06:16:46.166049       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0225 06:16:51.175859       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0225 06:16:56.184424       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0225 06:17:01.193509       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0225 06:17:06.202145       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0225 06:17:11.214708       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com