I0225 02:21:26.188944       1 main.go:93] Version : v1.3.0
I0225 02:21:26.189004       1 feature_gate.go:245] feature gates: &{map[]}
I0225 02:21:26.192488       1 connection.go:154] Connecting to unix:///csi/csi-provisioner.sock
I0225 02:21:30.133518       1 common.go:111] Probing CSI driver for readiness
I0225 02:21:30.133562       1 connection.go:183] GRPC call: /csi.v1.Identity/Probe
I0225 02:21:30.133570       1 connection.go:184] GRPC request: {}
I0225 02:21:30.138120       1 connection.go:186] GRPC response: {}
I0225 02:21:30.138257       1 connection.go:187] GRPC error: <nil>
I0225 02:21:30.138295       1 connection.go:183] GRPC call: /csi.v1.Identity/GetPluginInfo
I0225 02:21:30.138350       1 connection.go:184] GRPC request: {}
I0225 02:21:30.140442       1 connection.go:186] GRPC response: {"name":"rbd.csi.ceph.com","vendor_version":"v3.5.1"}
I0225 02:21:30.140531       1 connection.go:187] GRPC error: <nil>
I0225 02:21:30.140551       1 main.go:141] CSI driver name: "rbd.csi.ceph.com"
I0225 02:21:30.140561       1 connection.go:183] GRPC call: /csi.v1.Identity/GetPluginCapabilities
I0225 02:21:30.140565       1 connection.go:184] GRPC request: {}
I0225 02:21:30.142441       1 connection.go:186] GRPC response: {"capabilities":[{"Type":{"Service":{"type":1}}},{"Type":{"VolumeExpansion":{"type":1}}},{"Type":{"Service":{"type":2}}}]}
I0225 02:21:30.142812       1 connection.go:187] GRPC error: <nil>
I0225 02:21:30.142832       1 connection.go:183] GRPC call: /csi.v1.Controller/ControllerGetCapabilities
I0225 02:21:30.142839       1 connection.go:184] GRPC request: {}
I0225 02:21:30.143600       1 connection.go:186] GRPC response: {"capabilities":[{"Type":{"Rpc":{"type":1}}},{"Type":{"Rpc":{"type":5}}},{"Type":{"Rpc":{"type":7}}},{"Type":{"Rpc":{"type":9}}}]}
I0225 02:21:30.143722       1 connection.go:187] GRPC error: <nil>
I0225 02:21:30.143731       1 connection.go:183] GRPC call: /csi.v1.Controller/ControllerGetCapabilities
I0225 02:21:30.143735       1 connection.go:184] GRPC request: {}
I0225 02:21:30.144308       1 connection.go:186] GRPC response: {"capabilities":[{"Type":{"Rpc":{"type":1}}},{"Type":{"Rpc":{"type":5}}},{"Type":{"Rpc":{"type":7}}},{"Type":{"Rpc":{"type":9}}}]}
I0225 02:21:30.144359       1 connection.go:187] GRPC error: <nil>
I0225 02:21:30.145610       1 leaderelection.go:248] attempting to acquire leader lease kube-system/external-resizer-rbd-csi-ceph-com...
I0225 02:21:30.161089       1 leaderelection.go:258] successfully acquired lease kube-system/external-resizer-rbd-csi-ceph-com
I0225 02:21:30.161152       1 leader_election.go:212] new leader detected, current leader: ceph-csi-rbd-provisioner-5d8ff44fc9-s75sx
I0225 02:21:30.161192       1 leader_election.go:205] became leader, starting
I0225 02:21:30.161426       1 controller.go:251] Starting external resizer rbd.csi.ceph.com
I0225 02:21:30.161572       1 reflector.go:219] Starting reflector *v1.PersistentVolume (10m0s) from k8s.io/client-go/informers/factory.go:134
I0225 02:21:30.161588       1 reflector.go:255] Listing and watching *v1.PersistentVolume from k8s.io/client-go/informers/factory.go:134
I0225 02:21:30.161984       1 reflector.go:219] Starting reflector *v1.PersistentVolumeClaim (10m0s) from k8s.io/client-go/informers/factory.go:134
I0225 02:21:30.162015       1 reflector.go:255] Listing and watching *v1.PersistentVolumeClaim from k8s.io/client-go/informers/factory.go:134
I0225 02:21:30.177195       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0225 02:21:30.262374       1 shared_informer.go:270] caches populated
I0225 02:21:35.186425       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0225 02:21:40.194249       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0225 02:21:45.204081       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0225 02:21:50.211494       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0225 02:21:55.220935       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0225 02:22:00.227062       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0225 02:22:05.237670       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0225 02:22:10.245836       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0225 02:22:15.254178       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0225 02:22:20.263100       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0225 02:22:25.272955       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0225 02:22:30.281885       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0225 02:22:35.292076       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0225 02:22:40.299269       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0225 02:22:45.309187       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0225 02:22:50.318333       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0225 02:22:55.331612       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0225 02:23:00.340334       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0225 02:23:05.347637       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0225 02:23:10.358651       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0225 02:23:15.369323       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0225 02:23:20.378910       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0225 02:23:25.388286       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0225 02:23:30.397852       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0225 02:23:35.414440       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0225 02:23:40.423145       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0225 02:23:45.434066       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0225 02:23:50.442734       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0225 02:23:55.450576       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0225 02:24:00.458808       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0225 02:24:05.470509       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0225 02:24:10.480281       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0225 02:24:15.492533       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0225 02:24:20.503307       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0225 02:24:25.511989       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0225 02:24:25.528708       1 controller.go:291] Started PVC processing "default/test-pvc"
W0225 02:24:25.528736       1 controller.go:318] PV "" bound to PVC default/test-pvc not found
I0225 02:24:26.823312       1 controller.go:291] Started PVC processing "default/test-pvc"
I0225 02:24:26.823348       1 controller.go:334] No need to resize PVC "default/test-pvc"
I0225 02:24:30.522592       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0225 02:24:35.535978       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0225 02:24:40.545920       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0225 02:24:45.557070       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0225 02:24:50.572014       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0225 02:24:55.708505       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0225 02:25:00.723588       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0225 02:25:05.749398       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0225 02:25:10.762096       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com