I0511 05:40:45.134457       1 main.go:93] Version : v1.3.0
I0511 05:40:45.134529       1 feature_gate.go:245] feature gates: &{map[]}
I0511 05:40:45.136320       1 connection.go:154] Connecting to unix:///csi/csi-provisioner.sock
I0511 05:40:49.232092       1 common.go:111] Probing CSI driver for readiness
I0511 05:40:49.232131       1 connection.go:183] GRPC call: /csi.v1.Identity/Probe
I0511 05:40:49.232139       1 connection.go:184] GRPC request: {}
I0511 05:40:49.244500       1 connection.go:186] GRPC response: {}
I0511 05:40:49.244558       1 connection.go:187] GRPC error: <nil>
I0511 05:40:49.244568       1 connection.go:183] GRPC call: /csi.v1.Identity/GetPluginInfo
I0511 05:40:49.244572       1 connection.go:184] GRPC request: {}
I0511 05:40:49.248017       1 connection.go:186] GRPC response: {"name":"rbd.csi.ceph.com","vendor_version":"v3.5.1"}
I0511 05:40:49.248076       1 connection.go:187] GRPC error: <nil>
I0511 05:40:49.248084       1 main.go:141] CSI driver name: "rbd.csi.ceph.com"
I0511 05:40:49.248092       1 connection.go:183] GRPC call: /csi.v1.Identity/GetPluginCapabilities
I0511 05:40:49.248094       1 connection.go:184] GRPC request: {}
I0511 05:40:49.249248       1 connection.go:186] GRPC response: {"capabilities":[{"Type":{"Service":{"type":1}}},{"Type":{"VolumeExpansion":{"type":1}}},{"Type":{"Service":{"type":2}}}]}
I0511 05:40:49.249380       1 connection.go:187] GRPC error: <nil>
I0511 05:40:49.249387       1 connection.go:183] GRPC call: /csi.v1.Controller/ControllerGetCapabilities
I0511 05:40:49.249390       1 connection.go:184] GRPC request: {}
I0511 05:40:49.250146       1 connection.go:186] GRPC response: {"capabilities":[{"Type":{"Rpc":{"type":1}}},{"Type":{"Rpc":{"type":5}}},{"Type":{"Rpc":{"type":7}}},{"Type":{"Rpc":{"type":9}}}]}
I0511 05:40:49.250310       1 connection.go:187] GRPC error: <nil>
I0511 05:40:49.250323       1 connection.go:183] GRPC call: /csi.v1.Controller/ControllerGetCapabilities
I0511 05:40:49.250330       1 connection.go:184] GRPC request: {}
I0511 05:40:49.250766       1 connection.go:186] GRPC response: {"capabilities":[{"Type":{"Rpc":{"type":1}}},{"Type":{"Rpc":{"type":5}}},{"Type":{"Rpc":{"type":7}}},{"Type":{"Rpc":{"type":9}}}]}
I0511 05:40:49.250873       1 connection.go:187] GRPC error: <nil>
I0511 05:40:49.252470       1 leaderelection.go:248] attempting to acquire leader lease kube-system/external-resizer-rbd-csi-ceph-com...
I0511 05:40:49.265144       1 leaderelection.go:258] successfully acquired lease kube-system/external-resizer-rbd-csi-ceph-com
I0511 05:40:49.265253       1 leader_election.go:205] became leader, starting
I0511 05:40:49.265279       1 controller.go:251] Starting external resizer rbd.csi.ceph.com
I0511 05:40:49.265285       1 leader_election.go:212] new leader detected, current leader: ceph-csi-rbd-provisioner-6f6497f79c-fg742
I0511 05:40:49.265516       1 reflector.go:219] Starting reflector *v1.PersistentVolume (10m0s) from k8s.io/client-go/informers/factory.go:134
I0511 05:40:49.265530       1 reflector.go:255] Listing and watching *v1.PersistentVolume from k8s.io/client-go/informers/factory.go:134
I0511 05:40:49.265580       1 reflector.go:219] Starting reflector *v1.PersistentVolumeClaim (10m0s) from k8s.io/client-go/informers/factory.go:134
I0511 05:40:49.265593       1 reflector.go:255] Listing and watching *v1.PersistentVolumeClaim from k8s.io/client-go/informers/factory.go:134
I0511 05:40:49.276138       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0511 05:40:49.366062       1 shared_informer.go:270] caches populated
I0511 05:40:54.288178       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0511 05:40:59.296957       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0511 05:41:04.310450       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0511 05:41:09.320669       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0511 05:41:14.332511       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0511 05:41:19.341743       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0511 05:41:24.351275       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0511 05:41:29.359086       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0511 05:41:34.373087       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0511 05:41:39.381850       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0511 05:41:44.391239       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0511 05:41:49.400170       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0511 05:41:54.408324       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0511 05:41:59.417378       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0511 05:42:04.424645       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0511 05:42:09.434032       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0511 05:42:14.442256       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0511 05:42:19.453085       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0511 05:42:24.464925       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0511 05:42:29.474296       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0511 05:42:34.483641       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0511 05:42:39.493242       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0511 05:42:44.504512       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0511 05:42:49.517148       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0511 05:42:54.528612       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0511 05:42:59.537330       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0511 05:43:04.544656       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0511 05:43:09.552712       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0511 05:43:14.562954       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0511 05:43:19.572894       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0511 05:43:24.584285       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0511 05:43:29.593739       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0511 05:43:34.606692       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0511 05:43:39.614696       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0511 05:43:44.625333       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0511 05:43:49.634800       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0511 05:43:50.361808       1 controller.go:291] Started PVC processing "default/test-pvc"
W0511 05:43:50.361839       1 controller.go:318] PV "" bound to PVC default/test-pvc not found
I0511 05:43:52.543419       1 controller.go:291] Started PVC processing "default/test-pvc"
I0511 05:43:52.543447       1 controller.go:334] No need to resize PVC "default/test-pvc"
I0511 05:43:54.643301       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0511 05:43:59.652104       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0511 05:44:04.662055       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0511 05:44:09.671536       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0511 05:44:14.681184       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0511 05:44:19.690938       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0511 05:44:24.702234       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0511 05:44:29.709994       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0511 05:44:34.717386       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0511 05:44:39.725074       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com