I0226 21:40:28.269921       1 main.go:93] Version : v1.3.0
I0226 21:40:28.270020       1 feature_gate.go:245] feature gates: &{map[]}
I0226 21:40:28.271869       1 connection.go:154] Connecting to unix:///csi/csi-provisioner.sock
W0226 21:40:38.272816       1 connection.go:173] Still connecting to unix:///csi/csi-provisioner.sock
I0226 21:40:40.890299       1 common.go:111] Probing CSI driver for readiness
I0226 21:40:40.890380       1 connection.go:183] GRPC call: /csi.v1.Identity/Probe
I0226 21:40:40.890396       1 connection.go:184] GRPC request: {}
I0226 21:40:40.894577       1 connection.go:186] GRPC response: {}
I0226 21:40:40.894660       1 connection.go:187] GRPC error: <nil>
I0226 21:40:40.894742       1 connection.go:183] GRPC call: /csi.v1.Identity/GetPluginInfo
I0226 21:40:40.894782       1 connection.go:184] GRPC request: {}
I0226 21:40:40.895376       1 connection.go:186] GRPC response: {"name":"rbd.csi.ceph.com","vendor_version":"v3.5.1"}
I0226 21:40:40.895451       1 connection.go:187] GRPC error: <nil>
I0226 21:40:40.895485       1 main.go:141] CSI driver name: "rbd.csi.ceph.com"
I0226 21:40:40.895502       1 connection.go:183] GRPC call: /csi.v1.Identity/GetPluginCapabilities
I0226 21:40:40.895515       1 connection.go:184] GRPC request: {}
I0226 21:40:40.896229       1 connection.go:186] GRPC response: {"capabilities":[{"Type":{"Service":{"type":1}}},{"Type":{"VolumeExpansion":{"type":1}}},{"Type":{"Service":{"type":2}}}]}
I0226 21:40:40.896517       1 connection.go:187] GRPC error: <nil>
I0226 21:40:40.896539       1 connection.go:183] GRPC call: /csi.v1.Controller/ControllerGetCapabilities
I0226 21:40:40.896638       1 connection.go:184] GRPC request: {}
I0226 21:40:40.897201       1 connection.go:186] GRPC response: {"capabilities":[{"Type":{"Rpc":{"type":1}}},{"Type":{"Rpc":{"type":5}}},{"Type":{"Rpc":{"type":7}}},{"Type":{"Rpc":{"type":9}}}]}
I0226 21:40:40.897538       1 connection.go:187] GRPC error: <nil>
I0226 21:40:40.897600       1 connection.go:183] GRPC call: /csi.v1.Controller/ControllerGetCapabilities
I0226 21:40:40.897621       1 connection.go:184] GRPC request: {}
I0226 21:40:40.897950       1 connection.go:186] GRPC response: {"capabilities":[{"Type":{"Rpc":{"type":1}}},{"Type":{"Rpc":{"type":5}}},{"Type":{"Rpc":{"type":7}}},{"Type":{"Rpc":{"type":9}}}]}
I0226 21:40:40.898002       1 connection.go:187] GRPC error: <nil>
I0226 21:40:40.899296       1 leaderelection.go:248] attempting to acquire leader lease kube-system/external-resizer-rbd-csi-ceph-com...
I0226 21:40:42.309725       1 leaderelection.go:258] successfully acquired lease kube-system/external-resizer-rbd-csi-ceph-com
I0226 21:40:42.309999       1 leader_election.go:212] new leader detected, current leader: ceph-csi-rbd-provisioner-6f6497f79c-4fblh
I0226 21:40:42.310687       1 leader_election.go:205] became leader, starting
I0226 21:40:42.310728       1 controller.go:251] Starting external resizer rbd.csi.ceph.com
I0226 21:40:42.310976       1 reflector.go:219] Starting reflector *v1.PersistentVolumeClaim (10m0s) from k8s.io/client-go/informers/factory.go:134
I0226 21:40:42.310984       1 reflector.go:255] Listing and watching *v1.PersistentVolumeClaim from k8s.io/client-go/informers/factory.go:134
I0226 21:40:42.311633       1 reflector.go:219] Starting reflector *v1.PersistentVolume (10m0s) from k8s.io/client-go/informers/factory.go:134
I0226 21:40:42.311664       1 reflector.go:255] Listing and watching *v1.PersistentVolume from k8s.io/client-go/informers/factory.go:134
I0226 21:40:42.411504       1 shared_informer.go:270] caches populated
I0226 21:40:44.181999       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0226 21:40:49.248787       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0226 21:40:54.264196       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0226 21:40:59.335083       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0226 21:41:04.346727       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0226 21:41:09.358040       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0226 21:41:14.366996       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0226 21:41:19.376394       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0226 21:41:24.385056       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0226 21:41:29.414859       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0226 21:41:34.421448       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0226 21:41:39.463986       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0226 21:41:44.491453       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0226 21:41:49.502181       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0226 21:41:54.511653       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0226 21:41:59.520100       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0226 21:42:04.529428       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0226 21:42:09.560336       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0226 21:42:14.570419       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0226 21:42:19.580573       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0226 21:42:24.610166       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0226 21:42:29.682671       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0226 21:42:34.691609       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0226 21:42:39.700889       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0226 21:42:44.709790       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0226 21:42:49.718531       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0226 21:42:54.728140       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0226 21:42:59.738446       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0226 21:43:04.750333       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0226 21:43:09.761371       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0226 21:43:14.776378       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0226 21:43:19.783825       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0226 21:43:24.795131       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0226 21:43:29.812834       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0226 21:43:34.821623       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0226 21:43:35.439398       1 controller.go:291] Started PVC processing "default/test-pvc"
W0226 21:43:35.439432       1 controller.go:318] PV "" bound to PVC default/test-pvc not found
I0226 21:43:37.770004       1 controller.go:291] Started PVC processing "default/test-pvc"
I0226 21:43:37.770030       1 controller.go:334] No need to resize PVC "default/test-pvc"
I0226 21:43:39.832406       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0226 21:43:44.846421       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0226 21:43:49.855729       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0226 21:43:54.863070       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0226 21:44:00.027032       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0226 21:44:05.033217       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0226 21:44:10.039215       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0226 21:44:15.047151       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0226 21:44:20.057925       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0226 21:44:25.066049       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com