I0417 18:46:18.012976       1 main.go:93] Version : v1.3.0
I0417 18:46:18.013199       1 feature_gate.go:245] feature gates: &{map[]}
I0417 18:46:18.015241       1 connection.go:154] Connecting to unix:///csi/csi-provisioner.sock
I0417 18:46:20.661843       1 common.go:111] Probing CSI driver for readiness
I0417 18:46:20.661873       1 connection.go:183] GRPC call: /csi.v1.Identity/Probe
I0417 18:46:20.661880       1 connection.go:184] GRPC request: {}
I0417 18:46:20.668032       1 connection.go:186] GRPC response: {}
I0417 18:46:20.668293       1 connection.go:187] GRPC error: <nil>
I0417 18:46:20.668418       1 connection.go:183] GRPC call: /csi.v1.Identity/GetPluginInfo
I0417 18:46:20.668527       1 connection.go:184] GRPC request: {}
I0417 18:46:20.669223       1 connection.go:186] GRPC response: {"name":"rbd.csi.ceph.com","vendor_version":"v3.5.1"}
I0417 18:46:20.669315       1 connection.go:187] GRPC error: <nil>
I0417 18:46:20.669333       1 main.go:141] CSI driver name: "rbd.csi.ceph.com"
I0417 18:46:20.669347       1 connection.go:183] GRPC call: /csi.v1.Identity/GetPluginCapabilities
I0417 18:46:20.669360       1 connection.go:184] GRPC request: {}
I0417 18:46:20.670238       1 connection.go:186] GRPC response: {"capabilities":[{"Type":{"Service":{"type":1}}},{"Type":{"VolumeExpansion":{"type":1}}},{"Type":{"Service":{"type":2}}}]}
I0417 18:46:20.670454       1 connection.go:187] GRPC error: <nil>
I0417 18:46:20.670468       1 connection.go:183] GRPC call: /csi.v1.Controller/ControllerGetCapabilities
I0417 18:46:20.670473       1 connection.go:184] GRPC request: {}
I0417 18:46:20.671585       1 connection.go:186] GRPC response: {"capabilities":[{"Type":{"Rpc":{"type":1}}},{"Type":{"Rpc":{"type":5}}},{"Type":{"Rpc":{"type":7}}},{"Type":{"Rpc":{"type":9}}}]}
I0417 18:46:20.671757       1 connection.go:187] GRPC error: <nil>
I0417 18:46:20.671771       1 connection.go:183] GRPC call: /csi.v1.Controller/ControllerGetCapabilities
I0417 18:46:20.671776       1 connection.go:184] GRPC request: {}
I0417 18:46:20.672251       1 connection.go:186] GRPC response: {"capabilities":[{"Type":{"Rpc":{"type":1}}},{"Type":{"Rpc":{"type":5}}},{"Type":{"Rpc":{"type":7}}},{"Type":{"Rpc":{"type":9}}}]}
I0417 18:46:20.672326       1 connection.go:187] GRPC error: <nil>
I0417 18:46:20.673356       1 leaderelection.go:248] attempting to acquire leader lease kube-system/external-resizer-rbd-csi-ceph-com...
I0417 18:46:20.688795       1 leaderelection.go:258] successfully acquired lease kube-system/external-resizer-rbd-csi-ceph-com
I0417 18:46:20.688895       1 leader_election.go:212] new leader detected, current leader: ceph-csi-rbd-provisioner-6f6497f79c-8z6jq
I0417 18:46:20.689023       1 leader_election.go:205] became leader, starting
I0417 18:46:20.689175       1 controller.go:251] Starting external resizer rbd.csi.ceph.com
I0417 18:46:20.689584       1 reflector.go:219] Starting reflector *v1.PersistentVolumeClaim (10m0s) from k8s.io/client-go/informers/factory.go:134
I0417 18:46:20.689609       1 reflector.go:219] Starting reflector *v1.PersistentVolume (10m0s) from k8s.io/client-go/informers/factory.go:134
I0417 18:46:20.689611       1 reflector.go:255] Listing and watching *v1.PersistentVolumeClaim from k8s.io/client-go/informers/factory.go:134
I0417 18:46:20.689622       1 reflector.go:255] Listing and watching *v1.PersistentVolume from k8s.io/client-go/informers/factory.go:134
I0417 18:46:20.697418       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0417 18:46:20.789577       1 shared_informer.go:270] caches populated
I0417 18:46:25.704963       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0417 18:46:30.768167       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0417 18:46:35.778699       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0417 18:46:40.791094       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0417 18:46:45.810933       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0417 18:46:50.820654       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0417 18:46:55.830084       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0417 18:47:00.842325       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0417 18:47:05.853009       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0417 18:47:10.862453       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0417 18:47:15.872449       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0417 18:47:20.882935       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0417 18:47:25.896302       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0417 18:47:30.907307       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0417 18:47:35.918213       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0417 18:47:40.926083       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0417 18:47:45.937900       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0417 18:47:50.945586       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0417 18:47:55.957861       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0417 18:48:00.965795       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0417 18:48:05.977411       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0417 18:48:10.986366       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0417 18:48:15.996398       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0417 18:48:21.004424       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0417 18:48:26.017770       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0417 18:48:31.027300       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0417 18:48:36.037674       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0417 18:48:41.047439       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0417 18:48:46.056100       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0417 18:48:51.067887       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0417 18:48:56.078135       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0417 18:49:01.088165       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0417 18:49:06.097571       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0417 18:49:11.108034       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0417 18:49:16.117362       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0417 18:49:21.124579       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0417 18:49:25.312748       1 controller.go:291] Started PVC processing "default/test-pvc"
W0417 18:49:25.312781       1 controller.go:318] PV "" bound to PVC default/test-pvc not found
I0417 18:49:26.138177       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0417 18:49:26.674621       1 controller.go:291] Started PVC processing "default/test-pvc"
I0417 18:49:26.674717       1 controller.go:334] No need to resize PVC "default/test-pvc"
I0417 18:49:31.146688       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0417 18:49:36.155069       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0417 18:49:41.164169       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0417 18:49:46.175105       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0417 18:49:51.183130       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0417 18:49:56.193666       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0417 18:50:01.199963       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0417 18:50:06.208033       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0417 18:50:11.215369       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com