I0325 07:38:57.725176       1 main.go:93] Version : v1.3.0
I0325 07:38:57.725259       1 feature_gate.go:245] feature gates: &{map[]}
I0325 07:38:57.727628       1 connection.go:154] Connecting to unix:///csi/csi-provisioner.sock
I0325 07:39:01.045816       1 common.go:111] Probing CSI driver for readiness
I0325 07:39:01.045838       1 connection.go:183] GRPC call: /csi.v1.Identity/Probe
I0325 07:39:01.045843       1 connection.go:184] GRPC request: {}
I0325 07:39:01.060757       1 connection.go:186] GRPC response: {}
I0325 07:39:01.060839       1 connection.go:187] GRPC error: <nil>
I0325 07:39:01.060854       1 connection.go:183] GRPC call: /csi.v1.Identity/GetPluginInfo
I0325 07:39:01.060887       1 connection.go:184] GRPC request: {}
I0325 07:39:01.061786       1 connection.go:186] GRPC response: {"name":"rbd.csi.ceph.com","vendor_version":"v3.5.1"}
I0325 07:39:01.061839       1 connection.go:187] GRPC error: <nil>
I0325 07:39:01.061849       1 main.go:141] CSI driver name: "rbd.csi.ceph.com"
I0325 07:39:01.061861       1 connection.go:183] GRPC call: /csi.v1.Identity/GetPluginCapabilities
I0325 07:39:01.061865       1 connection.go:184] GRPC request: {}
I0325 07:39:01.062704       1 connection.go:186] GRPC response: {"capabilities":[{"Type":{"Service":{"type":1}}},{"Type":{"VolumeExpansion":{"type":1}}},{"Type":{"Service":{"type":2}}}]}
I0325 07:39:01.062825       1 connection.go:187] GRPC error: <nil>
I0325 07:39:01.062834       1 connection.go:183] GRPC call: /csi.v1.Controller/ControllerGetCapabilities
I0325 07:39:01.062838       1 connection.go:184] GRPC request: {}
I0325 07:39:01.063928       1 connection.go:186] GRPC response: {"capabilities":[{"Type":{"Rpc":{"type":1}}},{"Type":{"Rpc":{"type":5}}},{"Type":{"Rpc":{"type":7}}},{"Type":{"Rpc":{"type":9}}}]}
I0325 07:39:01.064005       1 connection.go:187] GRPC error: <nil>
I0325 07:39:01.064012       1 connection.go:183] GRPC call: /csi.v1.Controller/ControllerGetCapabilities
I0325 07:39:01.064016       1 connection.go:184] GRPC request: {}
I0325 07:39:01.064473       1 connection.go:186] GRPC response: {"capabilities":[{"Type":{"Rpc":{"type":1}}},{"Type":{"Rpc":{"type":5}}},{"Type":{"Rpc":{"type":7}}},{"Type":{"Rpc":{"type":9}}}]}
I0325 07:39:01.064522       1 connection.go:187] GRPC error: <nil>
I0325 07:39:01.065950       1 leaderelection.go:248] attempting to acquire leader lease kube-system/external-resizer-rbd-csi-ceph-com...
I0325 07:39:01.086626       1 leaderelection.go:258] successfully acquired lease kube-system/external-resizer-rbd-csi-ceph-com
I0325 07:39:01.086780       1 leader_election.go:212] new leader detected, current leader: ceph-csi-rbd-provisioner-6f6497f79c-bxpf7
I0325 07:39:01.087175       1 leader_election.go:205] became leader, starting
I0325 07:39:01.087193       1 controller.go:251] Starting external resizer rbd.csi.ceph.com
I0325 07:39:01.087389       1 reflector.go:219] Starting reflector *v1.PersistentVolume (10m0s) from k8s.io/client-go/informers/factory.go:134
I0325 07:39:01.087399       1 reflector.go:255] Listing and watching *v1.PersistentVolume from k8s.io/client-go/informers/factory.go:134
I0325 07:39:01.087778       1 reflector.go:219] Starting reflector *v1.PersistentVolumeClaim (10m0s) from k8s.io/client-go/informers/factory.go:134
I0325 07:39:01.087788       1 reflector.go:255] Listing and watching *v1.PersistentVolumeClaim from k8s.io/client-go/informers/factory.go:134
I0325 07:39:01.097359       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0325 07:39:01.187342       1 shared_informer.go:270] caches populated
I0325 07:39:06.122432       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0325 07:39:11.384231       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0325 07:39:16.396336       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0325 07:39:21.404016       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0325 07:39:26.417376       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0325 07:39:31.424562       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0325 07:39:36.433928       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0325 07:39:41.445760       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0325 07:39:46.453683       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0325 07:39:51.464775       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0325 07:39:56.473045       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0325 07:40:01.481735       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0325 07:40:06.493248       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0325 07:40:11.504643       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0325 07:40:16.515943       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0325 07:40:21.524413       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0325 07:40:26.540049       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0325 07:40:31.550391       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0325 07:40:36.561403       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0325 07:40:41.572438       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0325 07:40:46.580068       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0325 07:40:51.593172       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0325 07:40:56.602465       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0325 07:41:01.611309       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0325 07:41:06.622436       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0325 07:41:11.630938       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0325 07:41:16.643639       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0325 07:41:21.652695       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0325 07:41:26.663519       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0325 07:41:31.674441       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0325 07:41:36.689027       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0325 07:41:41.698409       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0325 07:41:46.711087       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0325 07:41:51.722926       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0325 07:41:56.737229       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0325 07:42:01.753518       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0325 07:42:06.611405       1 controller.go:291] Started PVC processing "default/test-pvc"
W0325 07:42:06.611442       1 controller.go:318] PV "" bound to PVC default/test-pvc not found
I0325 07:42:06.762443       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0325 07:42:08.487774       1 controller.go:291] Started PVC processing "default/test-pvc"
I0325 07:42:08.487797       1 controller.go:334] No need to resize PVC "default/test-pvc"
I0325 07:42:11.773971       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0325 07:42:16.782309       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0325 07:42:21.789552       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0325 07:42:26.800543       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0325 07:42:31.806428       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0325 07:42:36.817562       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0325 07:42:41.826793       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0325 07:42:46.835268       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0325 07:42:51.841124       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com