I0420 21:00:37.202370       1 main.go:93] Version : v1.3.0
I0420 21:00:37.202440       1 feature_gate.go:245] feature gates: &{map[]}
I0420 21:00:37.205645       1 connection.go:154] Connecting to unix:///csi/csi-provisioner.sock
I0420 21:00:41.256044       1 common.go:111] Probing CSI driver for readiness
I0420 21:00:41.256079       1 connection.go:183] GRPC call: /csi.v1.Identity/Probe
I0420 21:00:41.256088       1 connection.go:184] GRPC request: {}
I0420 21:00:41.261861       1 connection.go:186] GRPC response: {}
I0420 21:00:41.261949       1 connection.go:187] GRPC error: <nil>
I0420 21:00:41.261963       1 connection.go:183] GRPC call: /csi.v1.Identity/GetPluginInfo
I0420 21:00:41.261968       1 connection.go:184] GRPC request: {}
I0420 21:00:41.263719       1 connection.go:186] GRPC response: {"name":"rbd.csi.ceph.com","vendor_version":"v3.5.1"}
I0420 21:00:41.263853       1 connection.go:187] GRPC error: <nil>
I0420 21:00:41.263873       1 main.go:141] CSI driver name: "rbd.csi.ceph.com"
I0420 21:00:41.263890       1 connection.go:183] GRPC call: /csi.v1.Identity/GetPluginCapabilities
I0420 21:00:41.263903       1 connection.go:184] GRPC request: {}
I0420 21:00:41.264875       1 connection.go:186] GRPC response: {"capabilities":[{"Type":{"Service":{"type":1}}},{"Type":{"VolumeExpansion":{"type":1}}},{"Type":{"Service":{"type":2}}}]}
I0420 21:00:41.265036       1 connection.go:187] GRPC error: <nil>
I0420 21:00:41.265049       1 connection.go:183] GRPC call: /csi.v1.Controller/ControllerGetCapabilities
I0420 21:00:41.265056       1 connection.go:184] GRPC request: {}
I0420 21:00:41.266101       1 connection.go:186] GRPC response: {"capabilities":[{"Type":{"Rpc":{"type":1}}},{"Type":{"Rpc":{"type":5}}},{"Type":{"Rpc":{"type":7}}},{"Type":{"Rpc":{"type":9}}}]}
I0420 21:00:41.266335       1 connection.go:187] GRPC error: <nil>
I0420 21:00:41.266401       1 connection.go:183] GRPC call: /csi.v1.Controller/ControllerGetCapabilities
I0420 21:00:41.266417       1 connection.go:184] GRPC request: {}
I0420 21:00:41.267109       1 connection.go:186] GRPC response: {"capabilities":[{"Type":{"Rpc":{"type":1}}},{"Type":{"Rpc":{"type":5}}},{"Type":{"Rpc":{"type":7}}},{"Type":{"Rpc":{"type":9}}}]}
I0420 21:00:41.267402       1 connection.go:187] GRPC error: <nil>
I0420 21:00:41.268754       1 leaderelection.go:248] attempting to acquire leader lease kube-system/external-resizer-rbd-csi-ceph-com...
I0420 21:00:41.282485       1 leaderelection.go:258] successfully acquired lease kube-system/external-resizer-rbd-csi-ceph-com
I0420 21:00:41.282517       1 leader_election.go:212] new leader detected, current leader: ceph-csi-rbd-provisioner-6f6497f79c-jhp5n
I0420 21:00:41.282601       1 leader_election.go:205] became leader, starting
I0420 21:00:41.282632       1 controller.go:251] Starting external resizer rbd.csi.ceph.com
I0420 21:00:41.282916       1 reflector.go:219] Starting reflector *v1.PersistentVolume (10m0s) from k8s.io/client-go/informers/factory.go:134
I0420 21:00:41.282932       1 reflector.go:255] Listing and watching *v1.PersistentVolume from k8s.io/client-go/informers/factory.go:134
I0420 21:00:41.282976       1 reflector.go:219] Starting reflector *v1.PersistentVolumeClaim (10m0s) from k8s.io/client-go/informers/factory.go:134
I0420 21:00:41.282991       1 reflector.go:255] Listing and watching *v1.PersistentVolumeClaim from k8s.io/client-go/informers/factory.go:134
I0420 21:00:41.292783       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0420 21:00:41.383490       1 shared_informer.go:270] caches populated
I0420 21:00:46.339743       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0420 21:00:51.348591       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0420 21:00:56.360490       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0420 21:01:01.371528       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0420 21:01:06.381788       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0420 21:01:11.393132       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0420 21:01:16.405851       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0420 21:01:21.415658       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0420 21:01:26.426112       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0420 21:01:31.436440       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0420 21:01:36.449242       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0420 21:01:41.458806       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0420 21:01:46.470848       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0420 21:01:51.478992       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0420 21:01:56.497226       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0420 21:02:01.552620       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0420 21:02:06.562503       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0420 21:02:11.573137       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0420 21:02:16.582237       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0420 21:02:21.591612       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0420 21:02:26.600238       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0420 21:02:31.609723       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0420 21:02:36.622489       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0420 21:02:41.630205       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0420 21:02:46.654344       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0420 21:02:51.663621       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0420 21:02:56.675722       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0420 21:03:01.685081       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0420 21:03:06.696739       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0420 21:03:11.705546       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0420 21:03:16.717010       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0420 21:03:21.726813       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0420 21:03:26.741577       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0420 21:03:31.752558       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0420 21:03:36.765677       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0420 21:03:41.774105       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0420 21:03:44.695830       1 controller.go:291] Started PVC processing "default/test-pvc"
W0420 21:03:44.695915       1 controller.go:318] PV "" bound to PVC default/test-pvc not found
I0420 21:03:46.192731       1 controller.go:291] Started PVC processing "default/test-pvc"
I0420 21:03:46.196204       1 controller.go:334] No need to resize PVC "default/test-pvc"
I0420 21:03:46.782511       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0420 21:03:51.791264       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0420 21:03:56.801108       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0420 21:04:01.840083       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0420 21:04:06.849592       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0420 21:04:11.856256       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0420 21:04:16.871680       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0420 21:04:21.879051       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0420 21:04:26.886959       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0420 21:04:31.902538       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com