I0325 21:12:15.302886       1 main.go:93] Version : v1.3.0
I0325 21:12:15.302957       1 feature_gate.go:245] feature gates: &{map[]}
I0325 21:12:15.304227       1 connection.go:154] Connecting to unix:///csi/csi-provisioner.sock
I0325 21:12:23.961754       1 common.go:111] Probing CSI driver for readiness
I0325 21:12:23.961807       1 connection.go:183] GRPC call: /csi.v1.Identity/Probe
I0325 21:12:23.961815       1 connection.go:184] GRPC request: {}
I0325 21:12:23.968430       1 connection.go:186] GRPC response: {}
I0325 21:12:23.968612       1 connection.go:187] GRPC error: <nil>
I0325 21:12:23.968647       1 connection.go:183] GRPC call: /csi.v1.Identity/GetPluginInfo
I0325 21:12:23.968660       1 connection.go:184] GRPC request: {}
I0325 21:12:23.969295       1 connection.go:186] GRPC response: {"name":"rbd.csi.ceph.com","vendor_version":"v3.5.1"}
I0325 21:12:23.969362       1 connection.go:187] GRPC error: <nil>
I0325 21:12:23.969374       1 main.go:141] CSI driver name: "rbd.csi.ceph.com"
I0325 21:12:23.969384       1 connection.go:183] GRPC call: /csi.v1.Identity/GetPluginCapabilities
I0325 21:12:23.969389       1 connection.go:184] GRPC request: {}
I0325 21:12:23.970234       1 connection.go:186] GRPC response: {"capabilities":[{"Type":{"Service":{"type":1}}},{"Type":{"VolumeExpansion":{"type":1}}},{"Type":{"Service":{"type":2}}}]}
I0325 21:12:23.970458       1 connection.go:187] GRPC error: <nil>
I0325 21:12:23.970473       1 connection.go:183] GRPC call: /csi.v1.Controller/ControllerGetCapabilities
I0325 21:12:23.970479       1 connection.go:184] GRPC request: {}
I0325 21:12:23.971091       1 connection.go:186] GRPC response: {"capabilities":[{"Type":{"Rpc":{"type":1}}},{"Type":{"Rpc":{"type":5}}},{"Type":{"Rpc":{"type":7}}},{"Type":{"Rpc":{"type":9}}}]}
I0325 21:12:23.971241       1 connection.go:187] GRPC error: <nil>
I0325 21:12:23.971252       1 connection.go:183] GRPC call: /csi.v1.Controller/ControllerGetCapabilities
I0325 21:12:23.971257       1 connection.go:184] GRPC request: {}
I0325 21:12:23.971752       1 connection.go:186] GRPC response: {"capabilities":[{"Type":{"Rpc":{"type":1}}},{"Type":{"Rpc":{"type":5}}},{"Type":{"Rpc":{"type":7}}},{"Type":{"Rpc":{"type":9}}}]}
I0325 21:12:23.971869       1 connection.go:187] GRPC error: <nil>
I0325 21:12:23.973624       1 leaderelection.go:248] attempting to acquire leader lease kube-system/external-resizer-rbd-csi-ceph-com...
I0325 21:12:23.988112       1 leaderelection.go:258] successfully acquired lease kube-system/external-resizer-rbd-csi-ceph-com
I0325 21:12:23.988213       1 leader_election.go:212] new leader detected, current leader: ceph-csi-rbd-provisioner-6f6497f79c-m54lr
I0325 21:12:23.988285       1 leader_election.go:205] became leader, starting
I0325 21:12:23.988320       1 controller.go:251] Starting external resizer rbd.csi.ceph.com
I0325 21:12:23.988675       1 reflector.go:219] Starting reflector *v1.PersistentVolume (10m0s) from k8s.io/client-go/informers/factory.go:134
I0325 21:12:23.988693       1 reflector.go:255] Listing and watching *v1.PersistentVolume from k8s.io/client-go/informers/factory.go:134
I0325 21:12:23.988779       1 reflector.go:219] Starting reflector *v1.PersistentVolumeClaim (10m0s) from k8s.io/client-go/informers/factory.go:134
I0325 21:12:23.988802       1 reflector.go:255] Listing and watching *v1.PersistentVolumeClaim from k8s.io/client-go/informers/factory.go:134
I0325 21:12:24.004269       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0325 21:12:24.089405       1 shared_informer.go:270] caches populated
I0325 21:12:29.015166       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0325 21:12:34.025786       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0325 21:12:39.035093       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0325 21:12:44.096444       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0325 21:12:49.108210       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0325 21:12:54.128052       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0325 21:12:59.139476       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0325 21:13:04.147697       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0325 21:13:09.158063       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0325 21:13:14.166936       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0325 21:13:19.208410       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0325 21:13:24.226491       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0325 21:13:29.240006       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0325 21:13:34.249358       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0325 21:13:39.260017       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0325 21:13:44.268328       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0325 21:13:49.278300       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0325 21:13:54.287296       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0325 21:13:59.299033       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0325 21:14:04.325727       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0325 21:14:09.333519       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0325 21:14:14.342813       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0325 21:14:19.353897       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0325 21:14:24.363000       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0325 21:14:29.372956       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0325 21:14:34.381766       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0325 21:14:39.390045       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0325 21:14:44.398096       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0325 21:14:49.409092       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0325 21:14:54.419690       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0325 21:14:59.433028       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0325 21:15:04.441514       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0325 21:15:09.451681       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0325 21:15:14.459364       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0325 21:15:19.469899       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0325 21:15:22.427993       1 controller.go:291] Started PVC processing "default/test-pvc"
W0325 21:15:22.428015       1 controller.go:318] PV "" bound to PVC default/test-pvc not found
I0325 21:15:24.227771       1 controller.go:291] Started PVC processing "default/test-pvc"
I0325 21:15:24.227802       1 controller.go:334] No need to resize PVC "default/test-pvc"
I0325 21:15:24.477319       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0325 21:15:29.570304       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0325 21:15:34.582076       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0325 21:15:39.593952       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0325 21:15:44.794537       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0325 21:15:49.807193       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0325 21:15:54.815842       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0325 21:15:59.827447       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0325 21:16:04.836781       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0325 21:16:09.850292       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0325 21:16:14.856904       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com