I0505 17:03:36.307001       1 main.go:93] Version : v1.3.0
I0505 17:03:36.307139       1 feature_gate.go:245] feature gates: &{map[]}
I0505 17:03:36.308645       1 connection.go:154] Connecting to unix:///csi/csi-provisioner.sock
W0505 17:03:46.309024       1 connection.go:173] Still connecting to unix:///csi/csi-provisioner.sock
I0505 17:03:46.659322       1 common.go:111] Probing CSI driver for readiness
I0505 17:03:46.659362       1 connection.go:183] GRPC call: /csi.v1.Identity/Probe
I0505 17:03:46.659369       1 connection.go:184] GRPC request: {}
I0505 17:03:46.664049       1 connection.go:186] GRPC response: {}
I0505 17:03:46.664198       1 connection.go:187] GRPC error: <nil>
I0505 17:03:46.664223       1 connection.go:183] GRPC call: /csi.v1.Identity/GetPluginInfo
I0505 17:03:46.664231       1 connection.go:184] GRPC request: {}
I0505 17:03:46.665429       1 connection.go:186] GRPC response: {"name":"rbd.csi.ceph.com","vendor_version":"v3.5.1"}
I0505 17:03:46.665507       1 connection.go:187] GRPC error: <nil>
I0505 17:03:46.665521       1 main.go:141] CSI driver name: "rbd.csi.ceph.com"
I0505 17:03:46.665532       1 connection.go:183] GRPC call: /csi.v1.Identity/GetPluginCapabilities
I0505 17:03:46.665536       1 connection.go:184] GRPC request: {}
I0505 17:03:46.668455       1 connection.go:186] GRPC response: {"capabilities":[{"Type":{"Service":{"type":1}}},{"Type":{"VolumeExpansion":{"type":1}}},{"Type":{"Service":{"type":2}}}]}
I0505 17:03:46.668690       1 connection.go:187] GRPC error: <nil>
I0505 17:03:46.668709       1 connection.go:183] GRPC call: /csi.v1.Controller/ControllerGetCapabilities
I0505 17:03:46.668923       1 connection.go:184] GRPC request: {}
I0505 17:03:46.670130       1 connection.go:186] GRPC response: {"capabilities":[{"Type":{"Rpc":{"type":1}}},{"Type":{"Rpc":{"type":5}}},{"Type":{"Rpc":{"type":7}}},{"Type":{"Rpc":{"type":9}}}]}
I0505 17:03:46.670281       1 connection.go:187] GRPC error: <nil>
I0505 17:03:46.670293       1 connection.go:183] GRPC call: /csi.v1.Controller/ControllerGetCapabilities
I0505 17:03:46.670297       1 connection.go:184] GRPC request: {}
I0505 17:03:46.670820       1 connection.go:186] GRPC response: {"capabilities":[{"Type":{"Rpc":{"type":1}}},{"Type":{"Rpc":{"type":5}}},{"Type":{"Rpc":{"type":7}}},{"Type":{"Rpc":{"type":9}}}]}
I0505 17:03:46.670881       1 connection.go:187] GRPC error: <nil>
I0505 17:03:46.671768       1 leaderelection.go:248] attempting to acquire leader lease kube-system/external-resizer-rbd-csi-ceph-com...
I0505 17:03:46.683138       1 leaderelection.go:258] successfully acquired lease kube-system/external-resizer-rbd-csi-ceph-com
I0505 17:03:46.683156       1 leader_election.go:212] new leader detected, current leader: ceph-csi-rbd-provisioner-6f6497f79c-h89r6
I0505 17:03:46.683374       1 leader_election.go:205] became leader, starting
I0505 17:03:46.683518       1 controller.go:251] Starting external resizer rbd.csi.ceph.com
I0505 17:03:46.684103       1 reflector.go:219] Starting reflector *v1.PersistentVolume (10m0s) from k8s.io/client-go/informers/factory.go:134
I0505 17:03:46.684146       1 reflector.go:255] Listing and watching *v1.PersistentVolume from k8s.io/client-go/informers/factory.go:134
I0505 17:03:46.684104       1 reflector.go:219] Starting reflector *v1.PersistentVolumeClaim (10m0s) from k8s.io/client-go/informers/factory.go:134
I0505 17:03:46.684163       1 reflector.go:255] Listing and watching *v1.PersistentVolumeClaim from k8s.io/client-go/informers/factory.go:134
I0505 17:03:46.692599       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0505 17:03:46.784523       1 shared_informer.go:270] caches populated
I0505 17:03:51.701891       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0505 17:03:56.711257       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0505 17:04:01.720671       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0505 17:04:06.806150       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0505 17:04:11.813958       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0505 17:04:16.821305       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0505 17:04:21.829998       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0505 17:04:26.838081       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0505 17:04:31.847120       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0505 17:04:36.858562       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0505 17:04:41.870036       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0505 17:04:46.879121       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0505 17:04:51.893974       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0505 17:04:56.904339       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0505 17:05:01.911321       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0505 17:05:06.919425       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0505 17:05:11.927671       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0505 17:05:16.943201       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0505 17:05:21.951624       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0505 17:05:26.960003       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0505 17:05:31.970348       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0505 17:05:36.979094       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0505 17:05:41.990602       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0505 17:05:46.998857       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0505 17:05:52.007382       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0505 17:05:57.016525       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0505 17:06:02.024483       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0505 17:06:07.030447       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0505 17:06:12.037349       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0505 17:06:17.046275       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0505 17:06:22.055528       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0505 17:06:27.065781       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0505 17:06:32.073451       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0505 17:06:37.080544       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0505 17:06:42.091424       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0505 17:06:43.331566       1 controller.go:291] Started PVC processing "default/test-pvc"
W0505 17:06:43.331601       1 controller.go:318] PV "" bound to PVC default/test-pvc not found
I0505 17:06:44.784467       1 controller.go:291] Started PVC processing "default/test-pvc"
I0505 17:06:44.784489       1 controller.go:334] No need to resize PVC "default/test-pvc"
I0505 17:06:47.100254       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0505 17:06:52.114511       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0505 17:06:57.124162       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0505 17:07:02.392373       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0505 17:07:07.404854       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0505 17:07:12.424799       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0505 17:07:17.431974       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0505 17:07:22.439990       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0505 17:07:27.478979       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0505 17:07:32.521559       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com