I0510 04:07:25.058670       1 main.go:93] Version : v1.3.0
I0510 04:07:25.058835       1 feature_gate.go:245] feature gates: &{map[]}
I0510 04:07:25.063039       1 connection.go:154] Connecting to unix:///csi/csi-provisioner.sock
W0510 04:07:35.063435       1 connection.go:173] Still connecting to unix:///csi/csi-provisioner.sock
I0510 04:07:44.601494       1 common.go:111] Probing CSI driver for readiness
I0510 04:07:44.601547       1 connection.go:183] GRPC call: /csi.v1.Identity/Probe
I0510 04:07:44.601556       1 connection.go:184] GRPC request: {}
I0510 04:07:44.609499       1 connection.go:186] GRPC response: {}
I0510 04:07:44.609604       1 connection.go:187] GRPC error: <nil>
I0510 04:07:44.609632       1 connection.go:183] GRPC call: /csi.v1.Identity/GetPluginInfo
I0510 04:07:44.609649       1 connection.go:184] GRPC request: {}
I0510 04:07:44.610768       1 connection.go:186] GRPC response: {"name":"rbd.csi.ceph.com","vendor_version":"v3.5.1"}
I0510 04:07:44.610900       1 connection.go:187] GRPC error: <nil>
I0510 04:07:44.610919       1 main.go:141] CSI driver name: "rbd.csi.ceph.com"
I0510 04:07:44.610936       1 connection.go:183] GRPC call: /csi.v1.Identity/GetPluginCapabilities
I0510 04:07:44.610948       1 connection.go:184] GRPC request: {}
I0510 04:07:44.612199       1 connection.go:186] GRPC response: {"capabilities":[{"Type":{"Service":{"type":1}}},{"Type":{"VolumeExpansion":{"type":1}}},{"Type":{"Service":{"type":2}}}]}
I0510 04:07:44.612432       1 connection.go:187] GRPC error: <nil>
I0510 04:07:44.612447       1 connection.go:183] GRPC call: /csi.v1.Controller/ControllerGetCapabilities
I0510 04:07:44.612454       1 connection.go:184] GRPC request: {}
I0510 04:07:44.613823       1 connection.go:186] GRPC response: {"capabilities":[{"Type":{"Rpc":{"type":1}}},{"Type":{"Rpc":{"type":5}}},{"Type":{"Rpc":{"type":7}}},{"Type":{"Rpc":{"type":9}}}]}
I0510 04:07:44.613944       1 connection.go:187] GRPC error: <nil>
I0510 04:07:44.613978       1 connection.go:183] GRPC call: /csi.v1.Controller/ControllerGetCapabilities
I0510 04:07:44.613986       1 connection.go:184] GRPC request: {}
I0510 04:07:44.614514       1 connection.go:186] GRPC response: {"capabilities":[{"Type":{"Rpc":{"type":1}}},{"Type":{"Rpc":{"type":5}}},{"Type":{"Rpc":{"type":7}}},{"Type":{"Rpc":{"type":9}}}]}
I0510 04:07:44.614626       1 connection.go:187] GRPC error: <nil>
I0510 04:07:44.616090       1 leaderelection.go:248] attempting to acquire leader lease kube-system/external-resizer-rbd-csi-ceph-com...
I0510 04:07:44.652841       1 leaderelection.go:258] successfully acquired lease kube-system/external-resizer-rbd-csi-ceph-com
I0510 04:07:44.652924       1 leader_election.go:212] new leader detected, current leader: ceph-csi-rbd-provisioner-6f6497f79c-j4mbs
I0510 04:07:44.653047       1 leader_election.go:205] became leader, starting
I0510 04:07:44.653148       1 controller.go:251] Starting external resizer rbd.csi.ceph.com
I0510 04:07:44.653545       1 reflector.go:219] Starting reflector *v1.PersistentVolumeClaim (10m0s) from k8s.io/client-go/informers/factory.go:134
I0510 04:07:44.653566       1 reflector.go:255] Listing and watching *v1.PersistentVolumeClaim from k8s.io/client-go/informers/factory.go:134
I0510 04:07:44.653635       1 reflector.go:219] Starting reflector *v1.PersistentVolume (10m0s) from k8s.io/client-go/informers/factory.go:134
I0510 04:07:44.653670       1 reflector.go:255] Listing and watching *v1.PersistentVolume from k8s.io/client-go/informers/factory.go:134
I0510 04:07:44.668602       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0510 04:07:44.753950       1 shared_informer.go:270] caches populated
I0510 04:07:49.775013       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0510 04:07:55.186081       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0510 04:08:00.196255       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0510 04:08:05.205917       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0510 04:08:10.234138       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0510 04:08:15.254536       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0510 04:08:20.268978       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0510 04:08:25.280073       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0510 04:08:30.294681       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0510 04:08:35.320373       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0510 04:08:40.331078       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0510 04:08:45.339208       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0510 04:08:50.358425       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0510 04:08:55.367431       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0510 04:09:00.378052       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0510 04:09:05.429872       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0510 04:09:10.438828       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0510 04:09:15.450307       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0510 04:09:20.458435       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0510 04:09:25.471758       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0510 04:09:30.483649       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0510 04:09:35.690432       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0510 04:09:40.701726       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0510 04:09:45.710900       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0510 04:09:50.718505       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0510 04:09:55.727178       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0510 04:10:00.737561       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0510 04:10:05.745886       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0510 04:10:10.757382       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0510 04:10:15.768043       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0510 04:10:20.779437       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0510 04:10:25.793479       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0510 04:10:30.802940       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0510 04:10:35.813051       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0510 04:10:40.822208       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0510 04:10:44.792903       1 controller.go:291] Started PVC processing "default/test-pvc"
W0510 04:10:44.793040       1 controller.go:318] PV "" bound to PVC default/test-pvc not found
I0510 04:10:45.831803       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0510 04:10:46.256995       1 controller.go:291] Started PVC processing "default/test-pvc"
I0510 04:10:46.257030       1 controller.go:334] No need to resize PVC "default/test-pvc"
I0510 04:10:50.842618       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0510 04:10:55.880604       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0510 04:11:00.888598       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0510 04:11:05.896585       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0510 04:11:10.903524       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0510 04:11:15.912967       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0510 04:11:20.922177       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0510 04:11:25.933440       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0510 04:11:30.942049       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0510 04:11:35.951653       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com