I0419 13:33:46.393724       1 main.go:93] Version : v1.3.0
I0419 13:33:46.393770       1 feature_gate.go:245] feature gates: &{map[]}
I0419 13:33:46.395012       1 connection.go:154] Connecting to unix:///csi/csi-provisioner.sock
I0419 13:33:50.136586       1 common.go:111] Probing CSI driver for readiness
I0419 13:33:50.136622       1 connection.go:183] GRPC call: /csi.v1.Identity/Probe
I0419 13:33:50.136630       1 connection.go:184] GRPC request: {}
I0419 13:33:50.143804       1 connection.go:186] GRPC response: {}
I0419 13:33:50.144186       1 connection.go:187] GRPC error: <nil>
I0419 13:33:50.144323       1 connection.go:183] GRPC call: /csi.v1.Identity/GetPluginInfo
I0419 13:33:50.144371       1 connection.go:184] GRPC request: {}
I0419 13:33:50.145639       1 connection.go:186] GRPC response: {"name":"rbd.csi.ceph.com","vendor_version":"v3.5.1"}
I0419 13:33:50.145780       1 connection.go:187] GRPC error: <nil>
I0419 13:33:50.145867       1 main.go:141] CSI driver name: "rbd.csi.ceph.com"
I0419 13:33:50.145924       1 connection.go:183] GRPC call: /csi.v1.Identity/GetPluginCapabilities
I0419 13:33:50.145957       1 connection.go:184] GRPC request: {}
I0419 13:33:50.147061       1 connection.go:186] GRPC response: {"capabilities":[{"Type":{"Service":{"type":1}}},{"Type":{"VolumeExpansion":{"type":1}}},{"Type":{"Service":{"type":2}}}]}
I0419 13:33:50.147323       1 connection.go:187] GRPC error: <nil>
I0419 13:33:50.147343       1 connection.go:183] GRPC call: /csi.v1.Controller/ControllerGetCapabilities
I0419 13:33:50.147350       1 connection.go:184] GRPC request: {}
I0419 13:33:50.148012       1 connection.go:186] GRPC response: {"capabilities":[{"Type":{"Rpc":{"type":1}}},{"Type":{"Rpc":{"type":5}}},{"Type":{"Rpc":{"type":7}}},{"Type":{"Rpc":{"type":9}}}]}
I0419 13:33:50.148115       1 connection.go:187] GRPC error: <nil>
I0419 13:33:50.148124       1 connection.go:183] GRPC call: /csi.v1.Controller/ControllerGetCapabilities
I0419 13:33:50.148128       1 connection.go:184] GRPC request: {}
I0419 13:33:50.148591       1 connection.go:186] GRPC response: {"capabilities":[{"Type":{"Rpc":{"type":1}}},{"Type":{"Rpc":{"type":5}}},{"Type":{"Rpc":{"type":7}}},{"Type":{"Rpc":{"type":9}}}]}
I0419 13:33:50.148743       1 connection.go:187] GRPC error: <nil>
I0419 13:33:50.150547       1 leaderelection.go:248] attempting to acquire leader lease kube-system/external-resizer-rbd-csi-ceph-com...
I0419 13:33:50.164018       1 leaderelection.go:258] successfully acquired lease kube-system/external-resizer-rbd-csi-ceph-com
I0419 13:33:50.164064       1 leader_election.go:212] new leader detected, current leader: ceph-csi-rbd-provisioner-6f6497f79c-sct67
I0419 13:33:50.164096       1 leader_election.go:205] became leader, starting
I0419 13:33:50.164269       1 controller.go:251] Starting external resizer rbd.csi.ceph.com
I0419 13:33:50.164596       1 reflector.go:219] Starting reflector *v1.PersistentVolumeClaim (10m0s) from k8s.io/client-go/informers/factory.go:134
I0419 13:33:50.164614       1 reflector.go:255] Listing and watching *v1.PersistentVolumeClaim from k8s.io/client-go/informers/factory.go:134
I0419 13:33:50.164685       1 reflector.go:219] Starting reflector *v1.PersistentVolume (10m0s) from k8s.io/client-go/informers/factory.go:134
I0419 13:33:50.164719       1 reflector.go:255] Listing and watching *v1.PersistentVolume from k8s.io/client-go/informers/factory.go:134
I0419 13:33:50.173577       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0419 13:33:50.264589       1 shared_informer.go:270] caches populated
I0419 13:33:55.184875       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0419 13:34:00.191728       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0419 13:34:05.204223       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0419 13:34:10.213042       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0419 13:34:15.225325       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0419 13:34:20.235453       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0419 13:34:25.243051       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0419 13:34:30.253876       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0419 13:34:35.263572       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0419 13:34:40.271920       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0419 13:34:45.281721       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0419 13:34:50.291218       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0419 13:34:55.314335       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0419 13:35:00.323565       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0419 13:35:05.334800       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0419 13:35:10.344248       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0419 13:35:15.353673       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0419 13:35:20.363915       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0419 13:35:25.377858       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0419 13:35:30.387837       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0419 13:35:35.402191       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0419 13:35:40.409240       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0419 13:35:45.417739       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0419 13:35:50.427227       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0419 13:35:55.437695       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0419 13:36:00.446319       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0419 13:36:05.456925       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0419 13:36:10.466620       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0419 13:36:15.480071       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0419 13:36:20.489323       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0419 13:36:25.504012       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0419 13:36:30.513868       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0419 13:36:35.524157       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0419 13:36:40.532444       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0419 13:36:45.543103       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0419 13:36:50.554282       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0419 13:36:53.488792       1 controller.go:291] Started PVC processing "default/test-pvc"
W0419 13:36:53.488848       1 controller.go:318] PV "" bound to PVC default/test-pvc not found
I0419 13:36:54.750442       1 controller.go:291] Started PVC processing "default/test-pvc"
I0419 13:36:54.750465       1 controller.go:334] No need to resize PVC "default/test-pvc"
I0419 13:36:55.563294       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0419 13:37:00.573201       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0419 13:37:05.578463       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0419 13:37:10.587363       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0419 13:37:15.597731       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0419 13:37:20.607205       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0419 13:37:25.617161       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0419 13:37:30.625656       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0419 13:37:35.636554       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com