I0227 20:31:07.932096       1 main.go:93] Version : v1.3.0
I0227 20:31:07.932332       1 feature_gate.go:245] feature gates: &{map[]}
I0227 20:31:07.934755       1 connection.go:154] Connecting to unix:///csi/csi-provisioner.sock
W0227 20:31:17.935796       1 connection.go:173] Still connecting to unix:///csi/csi-provisioner.sock
I0227 20:31:23.014625       1 common.go:111] Probing CSI driver for readiness
I0227 20:31:23.014657       1 connection.go:183] GRPC call: /csi.v1.Identity/Probe
I0227 20:31:23.014665       1 connection.go:184] GRPC request: {}
I0227 20:31:23.018830       1 connection.go:186] GRPC response: {}
I0227 20:31:23.018995       1 connection.go:187] GRPC error: <nil>
I0227 20:31:23.019010       1 connection.go:183] GRPC call: /csi.v1.Identity/GetPluginInfo
I0227 20:31:23.019023       1 connection.go:184] GRPC request: {}
I0227 20:31:23.020738       1 connection.go:186] GRPC response: {"name":"rbd.csi.ceph.com","vendor_version":"v3.5.1"}
I0227 20:31:23.020802       1 connection.go:187] GRPC error: <nil>
I0227 20:31:23.020813       1 main.go:141] CSI driver name: "rbd.csi.ceph.com"
I0227 20:31:23.020824       1 connection.go:183] GRPC call: /csi.v1.Identity/GetPluginCapabilities
I0227 20:31:23.020828       1 connection.go:184] GRPC request: {}
I0227 20:31:23.021947       1 connection.go:186] GRPC response: {"capabilities":[{"Type":{"Service":{"type":1}}},{"Type":{"VolumeExpansion":{"type":1}}},{"Type":{"Service":{"type":2}}}]}
I0227 20:31:23.022228       1 connection.go:187] GRPC error: <nil>
I0227 20:31:23.022244       1 connection.go:183] GRPC call: /csi.v1.Controller/ControllerGetCapabilities
I0227 20:31:23.022251       1 connection.go:184] GRPC request: {}
I0227 20:31:23.022824       1 connection.go:186] GRPC response: {"capabilities":[{"Type":{"Rpc":{"type":1}}},{"Type":{"Rpc":{"type":5}}},{"Type":{"Rpc":{"type":7}}},{"Type":{"Rpc":{"type":9}}}]}
I0227 20:31:23.022930       1 connection.go:187] GRPC error: <nil>
I0227 20:31:23.022938       1 connection.go:183] GRPC call: /csi.v1.Controller/ControllerGetCapabilities
I0227 20:31:23.022945       1 connection.go:184] GRPC request: {}
I0227 20:31:23.023766       1 connection.go:186] GRPC response: {"capabilities":[{"Type":{"Rpc":{"type":1}}},{"Type":{"Rpc":{"type":5}}},{"Type":{"Rpc":{"type":7}}},{"Type":{"Rpc":{"type":9}}}]}
I0227 20:31:23.023856       1 connection.go:187] GRPC error: <nil>
I0227 20:31:23.025076       1 leaderelection.go:248] attempting to acquire leader lease kube-system/external-resizer-rbd-csi-ceph-com...
I0227 20:31:24.936823       1 leaderelection.go:258] successfully acquired lease kube-system/external-resizer-rbd-csi-ceph-com
I0227 20:31:24.937175       1 leader_election.go:212] new leader detected, current leader: ceph-csi-rbd-provisioner-6f6497f79c-2jk4t
I0227 20:31:24.937539       1 leader_election.go:205] became leader, starting
I0227 20:31:24.937599       1 controller.go:251] Starting external resizer rbd.csi.ceph.com
I0227 20:31:24.938000       1 reflector.go:219] Starting reflector *v1.PersistentVolume (10m0s) from k8s.io/client-go/informers/factory.go:134
I0227 20:31:24.938024       1 reflector.go:255] Listing and watching *v1.PersistentVolume from k8s.io/client-go/informers/factory.go:134
I0227 20:31:24.938059       1 reflector.go:219] Starting reflector *v1.PersistentVolumeClaim (10m0s) from k8s.io/client-go/informers/factory.go:134
I0227 20:31:24.938071       1 reflector.go:255] Listing and watching *v1.PersistentVolumeClaim from k8s.io/client-go/informers/factory.go:134
I0227 20:31:25.038697       1 shared_informer.go:270] caches populated
I0227 20:31:25.410084       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0227 20:31:30.420912       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0227 20:31:35.429387       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0227 20:31:40.439416       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0227 20:31:45.747111       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0227 20:31:50.785991       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0227 20:31:55.795230       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0227 20:32:00.806393       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0227 20:32:05.815786       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0227 20:32:10.823898       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0227 20:32:15.836488       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0227 20:32:21.051686       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0227 20:32:26.062011       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0227 20:32:31.074081       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0227 20:32:36.088871       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0227 20:32:41.098538       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0227 20:32:46.106990       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0227 20:32:51.120378       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0227 20:32:56.128469       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0227 20:33:01.141947       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0227 20:33:06.147632       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0227 20:33:11.156850       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0227 20:33:16.165040       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0227 20:33:21.174139       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0227 20:33:26.181369       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0227 20:33:31.187556       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0227 20:33:36.196893       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0227 20:33:41.232558       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0227 20:33:46.243221       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0227 20:33:51.251752       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0227 20:33:56.262414       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0227 20:34:01.281462       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0227 20:34:06.290155       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0227 20:34:11.303601       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0227 20:34:16.316447       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0227 20:34:16.602117       1 controller.go:291] Started PVC processing "default/test-pvc"
W0227 20:34:16.602151       1 controller.go:318] PV "" bound to PVC default/test-pvc not found
I0227 20:34:18.818131       1 controller.go:291] Started PVC processing "default/test-pvc"
I0227 20:34:18.818155       1 controller.go:334] No need to resize PVC "default/test-pvc"
I0227 20:34:21.325179       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0227 20:34:26.333425       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0227 20:34:31.343324       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0227 20:34:36.352492       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0227 20:34:41.361519       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0227 20:34:46.369275       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0227 20:34:51.381665       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0227 20:34:56.388198       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0227 20:35:01.397632       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0227 20:35:06.410686       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com