I0324 14:53:46.535674       1 main.go:93] Version : v1.3.0
I0324 14:53:46.535723       1 feature_gate.go:245] feature gates: &{map[]}
I0324 14:53:46.537016       1 connection.go:154] Connecting to unix:///csi/csi-provisioner.sock
I0324 14:53:50.606293       1 common.go:111] Probing CSI driver for readiness
I0324 14:53:50.606327       1 connection.go:183] GRPC call: /csi.v1.Identity/Probe
I0324 14:53:50.606335       1 connection.go:184] GRPC request: {}
I0324 14:53:50.614511       1 connection.go:186] GRPC response: {}
I0324 14:53:50.614645       1 connection.go:187] GRPC error: <nil>
I0324 14:53:50.614663       1 connection.go:183] GRPC call: /csi.v1.Identity/GetPluginInfo
I0324 14:53:50.614669       1 connection.go:184] GRPC request: {}
I0324 14:53:50.615379       1 connection.go:186] GRPC response: {"name":"rbd.csi.ceph.com","vendor_version":"v3.5.1"}
I0324 14:53:50.615538       1 connection.go:187] GRPC error: <nil>
I0324 14:53:50.615558       1 main.go:141] CSI driver name: "rbd.csi.ceph.com"
I0324 14:53:50.615579       1 connection.go:183] GRPC call: /csi.v1.Identity/GetPluginCapabilities
I0324 14:53:50.615586       1 connection.go:184] GRPC request: {}
I0324 14:53:50.616426       1 connection.go:186] GRPC response: {"capabilities":[{"Type":{"Service":{"type":1}}},{"Type":{"VolumeExpansion":{"type":1}}},{"Type":{"Service":{"type":2}}}]}
I0324 14:53:50.616578       1 connection.go:187] GRPC error: <nil>
I0324 14:53:50.616587       1 connection.go:183] GRPC call: /csi.v1.Controller/ControllerGetCapabilities
I0324 14:53:50.616591       1 connection.go:184] GRPC request: {}
I0324 14:53:50.617256       1 connection.go:186] GRPC response: {"capabilities":[{"Type":{"Rpc":{"type":1}}},{"Type":{"Rpc":{"type":5}}},{"Type":{"Rpc":{"type":7}}},{"Type":{"Rpc":{"type":9}}}]}
I0324 14:53:50.617376       1 connection.go:187] GRPC error: <nil>
I0324 14:53:50.617387       1 connection.go:183] GRPC call: /csi.v1.Controller/ControllerGetCapabilities
I0324 14:53:50.617390       1 connection.go:184] GRPC request: {}
I0324 14:53:50.617847       1 connection.go:186] GRPC response: {"capabilities":[{"Type":{"Rpc":{"type":1}}},{"Type":{"Rpc":{"type":5}}},{"Type":{"Rpc":{"type":7}}},{"Type":{"Rpc":{"type":9}}}]}
I0324 14:53:50.618008       1 connection.go:187] GRPC error: <nil>
I0324 14:53:50.620257       1 leaderelection.go:248] attempting to acquire leader lease kube-system/external-resizer-rbd-csi-ceph-com...
I0324 14:53:50.634561       1 leaderelection.go:258] successfully acquired lease kube-system/external-resizer-rbd-csi-ceph-com
I0324 14:53:50.634612       1 leader_election.go:212] new leader detected, current leader: ceph-csi-rbd-provisioner-6f6497f79c-45z7s
I0324 14:53:50.634767       1 leader_election.go:205] became leader, starting
I0324 14:53:50.634889       1 controller.go:251] Starting external resizer rbd.csi.ceph.com
I0324 14:53:50.635461       1 reflector.go:219] Starting reflector *v1.PersistentVolume (10m0s) from k8s.io/client-go/informers/factory.go:134
I0324 14:53:50.635492       1 reflector.go:255] Listing and watching *v1.PersistentVolume from k8s.io/client-go/informers/factory.go:134
I0324 14:53:50.635490       1 reflector.go:219] Starting reflector *v1.PersistentVolumeClaim (10m0s) from k8s.io/client-go/informers/factory.go:134
I0324 14:53:50.635592       1 reflector.go:255] Listing and watching *v1.PersistentVolumeClaim from k8s.io/client-go/informers/factory.go:134
I0324 14:53:50.645280       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0324 14:53:50.735203       1 shared_informer.go:270] caches populated
I0324 14:53:55.657646       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0324 14:54:00.668256       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0324 14:54:05.680201       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0324 14:54:10.688866       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0324 14:54:15.700529       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0324 14:54:20.707835       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0324 14:54:25.717074       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0324 14:54:30.725262       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0324 14:54:35.734883       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0324 14:54:40.742855       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0324 14:54:45.755096       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0324 14:54:50.795161       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0324 14:54:55.806281       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0324 14:55:00.816523       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0324 14:55:05.828362       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0324 14:55:10.838239       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0324 14:55:15.853223       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0324 14:55:20.862217       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0324 14:55:25.875481       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0324 14:55:30.884189       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0324 14:55:35.896738       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0324 14:55:40.906857       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0324 14:55:45.915118       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0324 14:55:50.925789       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0324 14:55:55.934703       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0324 14:56:00.943080       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0324 14:56:05.954912       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0324 14:56:10.968826       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0324 14:56:15.981240       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0324 14:56:20.991710       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0324 14:56:26.000470       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0324 14:56:31.009927       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0324 14:56:36.020546       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0324 14:56:41.029881       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0324 14:56:46.036592       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0324 14:56:50.664823       1 controller.go:291] Started PVC processing "default/test-pvc"
W0324 14:56:50.664868       1 controller.go:318] PV "" bound to PVC default/test-pvc not found
I0324 14:56:51.045609       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0324 14:56:52.670174       1 controller.go:291] Started PVC processing "default/test-pvc"
I0324 14:56:52.670208       1 controller.go:334] No need to resize PVC "default/test-pvc"
I0324 14:56:56.057727       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0324 14:57:01.066982       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0324 14:57:06.080956       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0324 14:57:11.088523       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0324 14:57:16.097861       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0324 14:57:21.104914       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0324 14:57:26.113140       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0324 14:57:31.122056       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com