I0421 18:20:39.545227       1 main.go:93] Version : v1.3.0
I0421 18:20:39.545297       1 feature_gate.go:245] feature gates: &{map[]}
I0421 18:20:39.547010       1 connection.go:154] Connecting to unix:///csi/csi-provisioner.sock
I0421 18:20:42.285228       1 common.go:111] Probing CSI driver for readiness
I0421 18:20:42.285260       1 connection.go:183] GRPC call: /csi.v1.Identity/Probe
I0421 18:20:42.285267       1 connection.go:184] GRPC request: {}
I0421 18:20:42.291455       1 connection.go:186] GRPC response: {}
I0421 18:20:42.291523       1 connection.go:187] GRPC error: <nil>
I0421 18:20:42.291532       1 connection.go:183] GRPC call: /csi.v1.Identity/GetPluginInfo
I0421 18:20:42.291535       1 connection.go:184] GRPC request: {}
I0421 18:20:42.292398       1 connection.go:186] GRPC response: {"name":"rbd.csi.ceph.com","vendor_version":"v3.5.1"}
I0421 18:20:42.292466       1 connection.go:187] GRPC error: <nil>
I0421 18:20:42.292478       1 main.go:141] CSI driver name: "rbd.csi.ceph.com"
I0421 18:20:42.292576       1 connection.go:183] GRPC call: /csi.v1.Identity/GetPluginCapabilities
I0421 18:20:42.292587       1 connection.go:184] GRPC request: {}
I0421 18:20:42.293858       1 connection.go:186] GRPC response: {"capabilities":[{"Type":{"Service":{"type":1}}},{"Type":{"VolumeExpansion":{"type":1}}},{"Type":{"Service":{"type":2}}}]}
I0421 18:20:42.294017       1 connection.go:187] GRPC error: <nil>
I0421 18:20:42.294025       1 connection.go:183] GRPC call: /csi.v1.Controller/ControllerGetCapabilities
I0421 18:20:42.294028       1 connection.go:184] GRPC request: {}
I0421 18:20:42.297996       1 connection.go:186] GRPC response: {"capabilities":[{"Type":{"Rpc":{"type":1}}},{"Type":{"Rpc":{"type":5}}},{"Type":{"Rpc":{"type":7}}},{"Type":{"Rpc":{"type":9}}}]}
I0421 18:20:42.298171       1 connection.go:187] GRPC error: <nil>
I0421 18:20:42.298187       1 connection.go:183] GRPC call: /csi.v1.Controller/ControllerGetCapabilities
I0421 18:20:42.298191       1 connection.go:184] GRPC request: {}
I0421 18:20:42.298690       1 connection.go:186] GRPC response: {"capabilities":[{"Type":{"Rpc":{"type":1}}},{"Type":{"Rpc":{"type":5}}},{"Type":{"Rpc":{"type":7}}},{"Type":{"Rpc":{"type":9}}}]}
I0421 18:20:42.298779       1 connection.go:187] GRPC error: <nil>
I0421 18:20:42.299867       1 leaderelection.go:248] attempting to acquire leader lease kube-system/external-resizer-rbd-csi-ceph-com...
I0421 18:20:42.312613       1 leaderelection.go:258] successfully acquired lease kube-system/external-resizer-rbd-csi-ceph-com
I0421 18:20:42.312635       1 leader_election.go:212] new leader detected, current leader: ceph-csi-rbd-provisioner-6f6497f79c-cgkr4
I0421 18:20:42.312688       1 leader_election.go:205] became leader, starting
I0421 18:20:42.312721       1 controller.go:251] Starting external resizer rbd.csi.ceph.com
I0421 18:20:42.312914       1 reflector.go:219] Starting reflector *v1.PersistentVolumeClaim (10m0s) from k8s.io/client-go/informers/factory.go:134
I0421 18:20:42.312925       1 reflector.go:255] Listing and watching *v1.PersistentVolumeClaim from k8s.io/client-go/informers/factory.go:134
I0421 18:20:42.313169       1 reflector.go:219] Starting reflector *v1.PersistentVolume (10m0s) from k8s.io/client-go/informers/factory.go:134
I0421 18:20:42.313192       1 reflector.go:255] Listing and watching *v1.PersistentVolume from k8s.io/client-go/informers/factory.go:134
I0421 18:20:42.322537       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0421 18:20:42.412934       1 shared_informer.go:270] caches populated
I0421 18:20:47.340986       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0421 18:20:52.355159       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0421 18:20:57.361697       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0421 18:21:02.370317       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0421 18:21:07.381167       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0421 18:21:12.391063       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0421 18:21:17.401203       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0421 18:21:22.409777       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0421 18:21:27.419475       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0421 18:21:32.430252       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0421 18:21:37.442458       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0421 18:21:42.451907       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0421 18:21:47.464166       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0421 18:21:52.473726       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0421 18:21:57.484114       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0421 18:22:02.491354       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0421 18:22:07.499161       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0421 18:22:12.508558       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0421 18:22:17.519471       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0421 18:22:22.528967       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0421 18:22:27.539337       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0421 18:22:32.553957       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0421 18:22:37.563445       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0421 18:22:42.572427       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0421 18:22:47.582330       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0421 18:22:52.590682       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0421 18:22:57.605267       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0421 18:23:02.615941       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0421 18:23:07.629355       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0421 18:23:12.640832       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0421 18:23:17.649289       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0421 18:23:22.660262       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0421 18:23:27.671816       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0421 18:23:32.682352       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0421 18:23:37.693440       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0421 18:23:42.702367       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0421 18:23:47.717327       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0421 18:23:52.002629       1 controller.go:291] Started PVC processing "default/test-pvc"
W0421 18:23:52.002707       1 controller.go:318] PV "" bound to PVC default/test-pvc not found
I0421 18:23:52.726955       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0421 18:23:54.048575       1 controller.go:291] Started PVC processing "default/test-pvc"
I0421 18:23:54.048621       1 controller.go:334] No need to resize PVC "default/test-pvc"
I0421 18:23:57.737575       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0421 18:24:02.745828       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0421 18:24:07.758991       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0421 18:24:12.768141       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0421 18:24:17.779738       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0421 18:24:22.788702       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0421 18:24:27.797916       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0421 18:24:32.804282       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0421 18:24:37.814099       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0421 18:24:42.828996       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0421 18:24:47.840063       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com