I0222 17:53:02.332317       1 main.go:93] Version : v1.3.0
I0222 17:53:02.332387       1 feature_gate.go:245] feature gates: &{map[]}
I0222 17:53:02.335790       1 connection.go:154] Connecting to unix:///csi/csi-provisioner.sock
W0222 17:53:12.336640       1 connection.go:173] Still connecting to unix:///csi/csi-provisioner.sock
I0222 17:53:12.435557       1 common.go:111] Probing CSI driver for readiness
I0222 17:53:12.435592       1 connection.go:183] GRPC call: /csi.v1.Identity/Probe
I0222 17:53:12.435600       1 connection.go:184] GRPC request: {}
I0222 17:53:12.441848       1 connection.go:186] GRPC response: {}
I0222 17:53:12.441975       1 connection.go:187] GRPC error: <nil>
I0222 17:53:12.441994       1 connection.go:183] GRPC call: /csi.v1.Identity/GetPluginInfo
I0222 17:53:12.442001       1 connection.go:184] GRPC request: {}
I0222 17:53:12.442843       1 connection.go:186] GRPC response: {"name":"rbd.csi.ceph.com","vendor_version":"v3.5.1"}
I0222 17:53:12.442967       1 connection.go:187] GRPC error: <nil>
I0222 17:53:12.442985       1 main.go:141] CSI driver name: "rbd.csi.ceph.com"
I0222 17:53:12.443002       1 connection.go:183] GRPC call: /csi.v1.Identity/GetPluginCapabilities
I0222 17:53:12.443011       1 connection.go:184] GRPC request: {}
I0222 17:53:12.444619       1 connection.go:186] GRPC response: {"capabilities":[{"Type":{"Service":{"type":1}}},{"Type":{"VolumeExpansion":{"type":1}}},{"Type":{"Service":{"type":2}}}]}
I0222 17:53:12.444841       1 connection.go:187] GRPC error: <nil>
I0222 17:53:12.444856       1 connection.go:183] GRPC call: /csi.v1.Controller/ControllerGetCapabilities
I0222 17:53:12.444865       1 connection.go:184] GRPC request: {}
I0222 17:53:12.445754       1 connection.go:186] GRPC response: {"capabilities":[{"Type":{"Rpc":{"type":1}}},{"Type":{"Rpc":{"type":5}}},{"Type":{"Rpc":{"type":7}}},{"Type":{"Rpc":{"type":9}}}]}
I0222 17:53:12.445863       1 connection.go:187] GRPC error: <nil>
I0222 17:53:12.445872       1 connection.go:183] GRPC call: /csi.v1.Controller/ControllerGetCapabilities
I0222 17:53:12.445876       1 connection.go:184] GRPC request: {}
I0222 17:53:12.446798       1 connection.go:186] GRPC response: {"capabilities":[{"Type":{"Rpc":{"type":1}}},{"Type":{"Rpc":{"type":5}}},{"Type":{"Rpc":{"type":7}}},{"Type":{"Rpc":{"type":9}}}]}
I0222 17:53:12.446882       1 connection.go:187] GRPC error: <nil>
I0222 17:53:12.448434       1 leaderelection.go:248] attempting to acquire leader lease kube-system/external-resizer-rbd-csi-ceph-com...
I0222 17:53:12.576264       1 leaderelection.go:258] successfully acquired lease kube-system/external-resizer-rbd-csi-ceph-com
I0222 17:53:12.576298       1 leader_election.go:212] new leader detected, current leader: ceph-csi-rbd-provisioner-5d8ff44fc9-2g9dw
I0222 17:53:12.576325       1 leader_election.go:205] became leader, starting
I0222 17:53:12.576347       1 controller.go:251] Starting external resizer rbd.csi.ceph.com
I0222 17:53:12.576631       1 reflector.go:219] Starting reflector *v1.PersistentVolumeClaim (10m0s) from k8s.io/client-go/informers/factory.go:134
I0222 17:53:12.576651       1 reflector.go:255] Listing and watching *v1.PersistentVolumeClaim from k8s.io/client-go/informers/factory.go:134
I0222 17:53:12.576723       1 reflector.go:219] Starting reflector *v1.PersistentVolume (10m0s) from k8s.io/client-go/informers/factory.go:134
I0222 17:53:12.576744       1 reflector.go:255] Listing and watching *v1.PersistentVolume from k8s.io/client-go/informers/factory.go:134
I0222 17:53:12.592045       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0222 17:53:12.677267       1 shared_informer.go:270] caches populated
I0222 17:53:17.600124       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0222 17:53:22.609404       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0222 17:53:27.620358       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0222 17:53:32.692028       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0222 17:53:37.702819       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0222 17:53:42.712779       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0222 17:53:47.720766       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0222 17:53:52.729751       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0222 17:53:57.738921       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0222 17:54:02.804445       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0222 17:54:07.814099       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0222 17:54:12.824485       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0222 17:54:17.835790       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0222 17:54:22.844848       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0222 17:54:27.853976       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0222 17:54:32.862498       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0222 17:54:37.876715       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0222 17:54:42.882586       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0222 17:54:47.913057       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0222 17:54:52.920696       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0222 17:54:57.928492       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0222 17:55:02.936024       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0222 17:55:07.943906       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0222 17:55:12.952562       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0222 17:55:17.961265       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0222 17:55:22.971977       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0222 17:55:27.980539       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0222 17:55:32.997957       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0222 17:55:38.008088       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0222 17:55:43.018560       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0222 17:55:48.026666       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0222 17:55:53.034071       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0222 17:55:58.041648       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0222 17:56:02.409967       1 controller.go:291] Started PVC processing "default/test-pvc"
W0222 17:56:02.410014       1 controller.go:318] PV "" bound to PVC default/test-pvc not found
I0222 17:56:03.050439       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0222 17:56:04.245636       1 controller.go:291] Started PVC processing "default/test-pvc"
I0222 17:56:04.245664       1 controller.go:334] No need to resize PVC "default/test-pvc"
I0222 17:56:08.058681       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0222 17:56:13.067751       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0222 17:56:18.077840       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0222 17:56:23.086663       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0222 17:56:28.095655       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0222 17:56:33.104230       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0222 17:56:38.111163       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0222 17:56:43.120772       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0222 17:56:48.130225       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com