I0208 21:43:34.355673       1 main.go:93] Version : v1.3.0
I0208 21:43:34.355724       1 feature_gate.go:245] feature gates: &{map[]}
I0208 21:43:34.362341       1 connection.go:154] Connecting to unix:///csi/csi-provisioner.sock
W0208 21:43:44.363126       1 connection.go:173] Still connecting to unix:///csi/csi-provisioner.sock
W0208 21:43:54.363204       1 connection.go:173] Still connecting to unix:///csi/csi-provisioner.sock
I0208 21:43:59.702963       1 common.go:111] Probing CSI driver for readiness
I0208 21:43:59.703033       1 connection.go:183] GRPC call: /csi.v1.Identity/Probe
I0208 21:43:59.703093       1 connection.go:184] GRPC request: {}
I0208 21:43:59.707543       1 connection.go:186] GRPC response: {}
I0208 21:43:59.707674       1 connection.go:187] GRPC error: <nil>
I0208 21:43:59.707752       1 connection.go:183] GRPC call: /csi.v1.Identity/GetPluginInfo
I0208 21:43:59.707787       1 connection.go:184] GRPC request: {}
I0208 21:43:59.708629       1 connection.go:186] GRPC response: {"name":"rbd.csi.ceph.com","vendor_version":"v3.5.1"}
I0208 21:43:59.708712       1 connection.go:187] GRPC error: <nil>
I0208 21:43:59.708789       1 main.go:141] CSI driver name: "rbd.csi.ceph.com"
I0208 21:43:59.708889       1 connection.go:183] GRPC call: /csi.v1.Identity/GetPluginCapabilities
I0208 21:43:59.708944       1 connection.go:184] GRPC request: {}
I0208 21:43:59.710380       1 connection.go:186] GRPC response: {"capabilities":[{"Type":{"Service":{"type":1}}},{"Type":{"VolumeExpansion":{"type":1}}},{"Type":{"Service":{"type":2}}}]}
I0208 21:43:59.710561       1 connection.go:187] GRPC error: <nil>
I0208 21:43:59.710585       1 connection.go:183] GRPC call: /csi.v1.Controller/ControllerGetCapabilities
I0208 21:43:59.710612       1 connection.go:184] GRPC request: {}
I0208 21:43:59.711890       1 connection.go:186] GRPC response: {"capabilities":[{"Type":{"Rpc":{"type":1}}},{"Type":{"Rpc":{"type":5}}},{"Type":{"Rpc":{"type":7}}},{"Type":{"Rpc":{"type":9}}}]}
I0208 21:43:59.712080       1 connection.go:187] GRPC error: <nil>
I0208 21:43:59.712091       1 connection.go:183] GRPC call: /csi.v1.Controller/ControllerGetCapabilities
I0208 21:43:59.712096       1 connection.go:184] GRPC request: {}
I0208 21:43:59.715804       1 connection.go:186] GRPC response: {"capabilities":[{"Type":{"Rpc":{"type":1}}},{"Type":{"Rpc":{"type":5}}},{"Type":{"Rpc":{"type":7}}},{"Type":{"Rpc":{"type":9}}}]}
I0208 21:43:59.715931       1 connection.go:187] GRPC error: <nil>
I0208 21:43:59.716959       1 leaderelection.go:248] attempting to acquire leader lease kube-system/external-resizer-rbd-csi-ceph-com...
I0208 21:43:59.730359       1 leaderelection.go:258] successfully acquired lease kube-system/external-resizer-rbd-csi-ceph-com
I0208 21:43:59.730605       1 leader_election.go:212] new leader detected, current leader: ceph-csi-rbd-provisioner-5d8ff44fc9-lwn2s
I0208 21:43:59.732006       1 leader_election.go:205] became leader, starting
I0208 21:43:59.733238       1 controller.go:251] Starting external resizer rbd.csi.ceph.com
I0208 21:43:59.733458       1 reflector.go:219] Starting reflector *v1.PersistentVolume (10m0s) from k8s.io/client-go/informers/factory.go:134
I0208 21:43:59.734293       1 reflector.go:255] Listing and watching *v1.PersistentVolume from k8s.io/client-go/informers/factory.go:134
I0208 21:43:59.734442       1 reflector.go:219] Starting reflector *v1.PersistentVolumeClaim (10m0s) from k8s.io/client-go/informers/factory.go:134
I0208 21:43:59.734495       1 reflector.go:255] Listing and watching *v1.PersistentVolumeClaim from k8s.io/client-go/informers/factory.go:134
I0208 21:43:59.738613       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0208 21:43:59.833423       1 shared_informer.go:270] caches populated
I0208 21:44:04.823325       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0208 21:44:09.838455       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0208 21:44:14.854338       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0208 21:44:19.865944       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0208 21:44:24.872954       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0208 21:44:29.878970       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0208 21:44:34.885271       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0208 21:44:39.893038       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0208 21:44:44.900258       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0208 21:44:49.911412       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0208 21:44:54.919316       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0208 21:44:59.929544       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0208 21:45:04.946273       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0208 21:45:09.955171       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0208 21:45:14.964453       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0208 21:45:19.972998       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0208 21:45:24.982591       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0208 21:45:29.990951       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0208 21:45:34.997837       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0208 21:45:40.006360       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0208 21:45:45.014621       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0208 21:45:50.024008       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0208 21:45:55.031367       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0208 21:46:00.037842       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0208 21:46:05.045784       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0208 21:46:10.052006       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0208 21:46:15.061654       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0208 21:46:20.069143       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0208 21:46:25.077018       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0208 21:46:30.090114       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0208 21:46:35.098086       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0208 21:46:40.107322       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0208 21:46:45.114122       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0208 21:46:50.120795       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0208 21:46:54.239181       1 controller.go:291] Started PVC processing "default/test-pvc"
W0208 21:46:54.239286       1 controller.go:318] PV "" bound to PVC default/test-pvc not found
I0208 21:46:55.130161       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0208 21:46:56.447172       1 controller.go:291] Started PVC processing "default/test-pvc"
I0208 21:46:56.448296       1 controller.go:334] No need to resize PVC "default/test-pvc"
I0208 21:47:00.139457       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0208 21:47:05.148190       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0208 21:47:10.169141       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0208 21:47:15.179383       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0208 21:47:20.187009       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0208 21:47:25.195073       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0208 21:47:30.206136       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0208 21:47:35.212613       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0208 21:47:40.217977       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0208 21:47:45.233290       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0208 21:47:50.250630       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com