I0226 01:36:52.267612       1 main.go:93] Version : v1.3.0
I0226 01:36:52.267699       1 feature_gate.go:245] feature gates: &{map[]}
I0226 01:36:52.271283       1 connection.go:154] Connecting to unix:///csi/csi-provisioner.sock
I0226 01:36:55.502715       1 common.go:111] Probing CSI driver for readiness
I0226 01:36:55.502741       1 connection.go:183] GRPC call: /csi.v1.Identity/Probe
I0226 01:36:55.502747       1 connection.go:184] GRPC request: {}
I0226 01:36:55.507856       1 connection.go:186] GRPC response: {}
I0226 01:36:55.507946       1 connection.go:187] GRPC error: <nil>
I0226 01:36:55.507959       1 connection.go:183] GRPC call: /csi.v1.Identity/GetPluginInfo
I0226 01:36:55.507963       1 connection.go:184] GRPC request: {}
I0226 01:36:55.509712       1 connection.go:186] GRPC response: {"name":"rbd.csi.ceph.com","vendor_version":"v3.5.1"}
I0226 01:36:55.509780       1 connection.go:187] GRPC error: <nil>
I0226 01:36:55.509790       1 main.go:141] CSI driver name: "rbd.csi.ceph.com"
I0226 01:36:55.509800       1 connection.go:183] GRPC call: /csi.v1.Identity/GetPluginCapabilities
I0226 01:36:55.509804       1 connection.go:184] GRPC request: {}
I0226 01:36:55.511199       1 connection.go:186] GRPC response: {"capabilities":[{"Type":{"Service":{"type":1}}},{"Type":{"VolumeExpansion":{"type":1}}},{"Type":{"Service":{"type":2}}}]}
I0226 01:36:55.511441       1 connection.go:187] GRPC error: <nil>
I0226 01:36:55.511457       1 connection.go:183] GRPC call: /csi.v1.Controller/ControllerGetCapabilities
I0226 01:36:55.511464       1 connection.go:184] GRPC request: {}
I0226 01:36:55.512533       1 connection.go:186] GRPC response: {"capabilities":[{"Type":{"Rpc":{"type":1}}},{"Type":{"Rpc":{"type":5}}},{"Type":{"Rpc":{"type":7}}},{"Type":{"Rpc":{"type":9}}}]}
I0226 01:36:55.512690       1 connection.go:187] GRPC error: <nil>
I0226 01:36:55.512705       1 connection.go:183] GRPC call: /csi.v1.Controller/ControllerGetCapabilities
I0226 01:36:55.512709       1 connection.go:184] GRPC request: {}
I0226 01:36:55.513773       1 connection.go:186] GRPC response: {"capabilities":[{"Type":{"Rpc":{"type":1}}},{"Type":{"Rpc":{"type":5}}},{"Type":{"Rpc":{"type":7}}},{"Type":{"Rpc":{"type":9}}}]}
I0226 01:36:55.513901       1 connection.go:187] GRPC error: <nil>
I0226 01:36:55.515758       1 leaderelection.go:248] attempting to acquire leader lease kube-system/external-resizer-rbd-csi-ceph-com...
I0226 01:36:55.529498       1 leaderelection.go:258] successfully acquired lease kube-system/external-resizer-rbd-csi-ceph-com
I0226 01:36:55.529575       1 leader_election.go:212] new leader detected, current leader: ceph-csi-rbd-provisioner-6f6497f79c-k5v42
I0226 01:36:55.529662       1 leader_election.go:205] became leader, starting
I0226 01:36:55.529758       1 controller.go:251] Starting external resizer rbd.csi.ceph.com
I0226 01:36:55.530050       1 reflector.go:219] Starting reflector *v1.PersistentVolumeClaim (10m0s) from k8s.io/client-go/informers/factory.go:134
I0226 01:36:55.530071       1 reflector.go:255] Listing and watching *v1.PersistentVolumeClaim from k8s.io/client-go/informers/factory.go:134
I0226 01:36:55.530591       1 reflector.go:219] Starting reflector *v1.PersistentVolume (10m0s) from k8s.io/client-go/informers/factory.go:134
I0226 01:36:55.530621       1 reflector.go:255] Listing and watching *v1.PersistentVolume from k8s.io/client-go/informers/factory.go:134
I0226 01:36:55.537711       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0226 01:36:55.630055       1 shared_informer.go:270] caches populated
I0226 01:37:00.547921       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0226 01:37:05.557339       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0226 01:37:10.575110       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0226 01:37:15.582912       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0226 01:37:20.593559       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0226 01:37:25.601538       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0226 01:37:30.610864       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0226 01:37:35.622184       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0226 01:37:40.634049       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0226 01:37:45.645721       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0226 01:37:50.658566       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0226 01:37:55.670931       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0226 01:38:00.681960       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0226 01:38:05.694173       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0226 01:38:10.702222       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0226 01:38:15.712052       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0226 01:38:20.724125       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0226 01:38:25.734004       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0226 01:38:30.743074       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0226 01:38:35.751391       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0226 01:38:40.758285       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0226 01:38:45.767602       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0226 01:38:50.778125       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0226 01:38:55.792297       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0226 01:39:00.801202       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0226 01:39:05.810036       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0226 01:39:10.817914       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0226 01:39:15.826876       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0226 01:39:20.838516       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0226 01:39:25.847173       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0226 01:39:30.859484       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0226 01:39:35.868197       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0226 01:39:40.879971       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0226 01:39:45.891623       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0226 01:39:50.898826       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0226 01:39:53.225338       1 controller.go:291] Started PVC processing "default/test-pvc"
W0226 01:39:53.225378       1 controller.go:318] PV "" bound to PVC default/test-pvc not found
I0226 01:39:55.236429       1 controller.go:291] Started PVC processing "default/test-pvc"
I0226 01:39:55.236451       1 controller.go:334] No need to resize PVC "default/test-pvc"
I0226 01:39:55.908346       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0226 01:40:00.917307       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0226 01:40:05.925241       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0226 01:40:10.934901       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0226 01:40:15.945935       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0226 01:40:20.954451       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0226 01:40:25.962928       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0226 01:40:30.975579       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0226 01:40:35.983339       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0226 01:40:40.991183       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com