I0313 09:54:46.033829       1 main.go:93] Version : v1.3.0
I0313 09:54:46.033880       1 feature_gate.go:245] feature gates: &{map[]}
I0313 09:54:46.035104       1 connection.go:154] Connecting to unix:///csi/csi-provisioner.sock
I0313 09:54:54.316312       1 common.go:111] Probing CSI driver for readiness
I0313 09:54:54.316340       1 connection.go:183] GRPC call: /csi.v1.Identity/Probe
I0313 09:54:54.316382       1 connection.go:184] GRPC request: {}
I0313 09:54:54.325221       1 connection.go:186] GRPC response: {}
I0313 09:54:54.326357       1 connection.go:187] GRPC error: <nil>
I0313 09:54:54.326374       1 connection.go:183] GRPC call: /csi.v1.Identity/GetPluginInfo
I0313 09:54:54.326378       1 connection.go:184] GRPC request: {}
I0313 09:54:54.327272       1 connection.go:186] GRPC response: {"name":"rbd.csi.ceph.com","vendor_version":"v3.5.1"}
I0313 09:54:54.327387       1 connection.go:187] GRPC error: <nil>
I0313 09:54:54.327414       1 main.go:141] CSI driver name: "rbd.csi.ceph.com"
I0313 09:54:54.327444       1 connection.go:183] GRPC call: /csi.v1.Identity/GetPluginCapabilities
I0313 09:54:54.327461       1 connection.go:184] GRPC request: {}
I0313 09:54:54.328213       1 connection.go:186] GRPC response: {"capabilities":[{"Type":{"Service":{"type":1}}},{"Type":{"VolumeExpansion":{"type":1}}},{"Type":{"Service":{"type":2}}}]}
I0313 09:54:54.328402       1 connection.go:187] GRPC error: <nil>
I0313 09:54:54.328413       1 connection.go:183] GRPC call: /csi.v1.Controller/ControllerGetCapabilities
I0313 09:54:54.328418       1 connection.go:184] GRPC request: {}
I0313 09:54:54.330580       1 connection.go:186] GRPC response: {"capabilities":[{"Type":{"Rpc":{"type":1}}},{"Type":{"Rpc":{"type":5}}},{"Type":{"Rpc":{"type":7}}},{"Type":{"Rpc":{"type":9}}}]}
I0313 09:54:54.330832       1 connection.go:187] GRPC error: <nil>
I0313 09:54:54.330848       1 connection.go:183] GRPC call: /csi.v1.Controller/ControllerGetCapabilities
I0313 09:54:54.330853       1 connection.go:184] GRPC request: {}
I0313 09:54:54.331925       1 connection.go:186] GRPC response: {"capabilities":[{"Type":{"Rpc":{"type":1}}},{"Type":{"Rpc":{"type":5}}},{"Type":{"Rpc":{"type":7}}},{"Type":{"Rpc":{"type":9}}}]}
I0313 09:54:54.332022       1 connection.go:187] GRPC error: <nil>
I0313 09:54:54.333617       1 leaderelection.go:248] attempting to acquire leader lease kube-system/external-resizer-rbd-csi-ceph-com...
I0313 09:54:54.574282       1 leaderelection.go:258] successfully acquired lease kube-system/external-resizer-rbd-csi-ceph-com
I0313 09:54:54.574344       1 leader_election.go:212] new leader detected, current leader: ceph-csi-rbd-provisioner-6f6497f79c-tr9j5
I0313 09:54:54.574412       1 leader_election.go:205] became leader, starting
I0313 09:54:54.574609       1 controller.go:251] Starting external resizer rbd.csi.ceph.com
I0313 09:54:54.574833       1 reflector.go:219] Starting reflector *v1.PersistentVolume (10m0s) from k8s.io/client-go/informers/factory.go:134
I0313 09:54:54.574851       1 reflector.go:255] Listing and watching *v1.PersistentVolume from k8s.io/client-go/informers/factory.go:134
I0313 09:54:54.574954       1 reflector.go:219] Starting reflector *v1.PersistentVolumeClaim (10m0s) from k8s.io/client-go/informers/factory.go:134
I0313 09:54:54.574972       1 reflector.go:255] Listing and watching *v1.PersistentVolumeClaim from k8s.io/client-go/informers/factory.go:134
I0313 09:54:54.674953       1 shared_informer.go:270] caches populated
I0313 09:54:54.786857       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0313 09:54:59.932465       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0313 09:55:04.943575       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0313 09:55:09.954630       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0313 09:55:14.963148       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0313 09:55:19.974620       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0313 09:55:24.987297       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0313 09:55:30.001262       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0313 09:55:35.014338       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0313 09:55:40.022308       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0313 09:55:45.034829       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0313 09:55:50.986319       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0313 09:55:56.026474       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0313 09:56:01.033398       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0313 09:56:06.041351       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0313 09:56:11.068217       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0313 09:56:16.074149       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0313 09:56:21.084288       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0313 09:56:26.092351       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0313 09:56:31.141450       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0313 09:56:36.151013       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0313 09:56:41.160067       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0313 09:56:46.169209       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0313 09:56:51.180522       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0313 09:56:56.188459       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0313 09:57:01.195151       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0313 09:57:06.204683       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0313 09:57:11.211430       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0313 09:57:16.221368       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0313 09:57:21.230520       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0313 09:57:26.238526       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0313 09:57:31.248121       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0313 09:57:36.256926       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0313 09:57:41.266207       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0313 09:57:46.275032       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0313 09:57:51.285894       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0313 09:57:56.305377       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0313 09:57:59.210029       1 controller.go:291] Started PVC processing "default/test-pvc"
W0313 09:57:59.210060       1 controller.go:318] PV "" bound to PVC default/test-pvc not found
I0313 09:58:01.315937       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0313 09:58:01.413147       1 controller.go:291] Started PVC processing "default/test-pvc"
I0313 09:58:01.413175       1 controller.go:334] No need to resize PVC "default/test-pvc"
I0313 09:58:06.326776       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0313 09:58:11.335811       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0313 09:58:16.343531       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0313 09:58:21.353308       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0313 09:58:26.364015       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0313 09:58:31.371775       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0313 09:58:36.378339       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0313 09:58:41.386590       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0313 09:58:46.395588       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0313 09:58:51.403241       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com