I0412 20:53:33.084274       1 main.go:93] Version : v1.3.0
I0412 20:53:33.084318       1 feature_gate.go:245] feature gates: &{map[]}
I0412 20:53:33.085628       1 connection.go:154] Connecting to unix:///csi/csi-provisioner.sock
W0412 20:53:43.086304       1 connection.go:173] Still connecting to unix:///csi/csi-provisioner.sock
I0412 20:53:43.489582       1 common.go:111] Probing CSI driver for readiness
I0412 20:53:43.489621       1 connection.go:183] GRPC call: /csi.v1.Identity/Probe
I0412 20:53:43.489629       1 connection.go:184] GRPC request: {}
I0412 20:53:43.495902       1 connection.go:186] GRPC response: {}
I0412 20:53:43.496024       1 connection.go:187] GRPC error: <nil>
I0412 20:53:43.496045       1 connection.go:183] GRPC call: /csi.v1.Identity/GetPluginInfo
I0412 20:53:43.496052       1 connection.go:184] GRPC request: {}
I0412 20:53:43.496706       1 connection.go:186] GRPC response: {"name":"rbd.csi.ceph.com","vendor_version":"v3.5.1"}
I0412 20:53:43.496795       1 connection.go:187] GRPC error: <nil>
I0412 20:53:43.496810       1 main.go:141] CSI driver name: "rbd.csi.ceph.com"
I0412 20:53:43.496855       1 connection.go:183] GRPC call: /csi.v1.Identity/GetPluginCapabilities
I0412 20:53:43.496862       1 connection.go:184] GRPC request: {}
I0412 20:53:43.497592       1 connection.go:186] GRPC response: {"capabilities":[{"Type":{"Service":{"type":1}}},{"Type":{"VolumeExpansion":{"type":1}}},{"Type":{"Service":{"type":2}}}]}
I0412 20:53:43.497735       1 connection.go:187] GRPC error: <nil>
I0412 20:53:43.497745       1 connection.go:183] GRPC call: /csi.v1.Controller/ControllerGetCapabilities
I0412 20:53:43.497749       1 connection.go:184] GRPC request: {}
I0412 20:53:43.498594       1 connection.go:186] GRPC response: {"capabilities":[{"Type":{"Rpc":{"type":1}}},{"Type":{"Rpc":{"type":5}}},{"Type":{"Rpc":{"type":7}}},{"Type":{"Rpc":{"type":9}}}]}
I0412 20:53:43.498807       1 connection.go:187] GRPC error: <nil>
I0412 20:53:43.498825       1 connection.go:183] GRPC call: /csi.v1.Controller/ControllerGetCapabilities
I0412 20:53:43.498832       1 connection.go:184] GRPC request: {}
I0412 20:53:43.499415       1 connection.go:186] GRPC response: {"capabilities":[{"Type":{"Rpc":{"type":1}}},{"Type":{"Rpc":{"type":5}}},{"Type":{"Rpc":{"type":7}}},{"Type":{"Rpc":{"type":9}}}]}
I0412 20:53:43.499484       1 connection.go:187] GRPC error: <nil>
I0412 20:53:43.500726       1 leaderelection.go:248] attempting to acquire leader lease kube-system/external-resizer-rbd-csi-ceph-com...
I0412 20:53:43.512134       1 leaderelection.go:258] successfully acquired lease kube-system/external-resizer-rbd-csi-ceph-com
I0412 20:53:43.512180       1 leader_election.go:212] new leader detected, current leader: ceph-csi-rbd-provisioner-6f6497f79c-hgf5d
I0412 20:53:43.512205       1 leader_election.go:205] became leader, starting
I0412 20:53:43.512811       1 reflector.go:219] Starting reflector *v1.PersistentVolume (10m0s) from k8s.io/client-go/informers/factory.go:134
I0412 20:53:43.512837       1 reflector.go:255] Listing and watching *v1.PersistentVolume from k8s.io/client-go/informers/factory.go:134
I0412 20:53:43.513037       1 controller.go:251] Starting external resizer rbd.csi.ceph.com
I0412 20:53:43.514349       1 reflector.go:219] Starting reflector *v1.PersistentVolumeClaim (10m0s) from k8s.io/client-go/informers/factory.go:134
I0412 20:53:43.514415       1 reflector.go:255] Listing and watching *v1.PersistentVolumeClaim from k8s.io/client-go/informers/factory.go:134
I0412 20:53:43.522266       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0412 20:53:43.613416       1 shared_informer.go:270] caches populated
I0412 20:53:48.531454       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0412 20:53:53.540409       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0412 20:53:58.549689       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0412 20:54:03.560058       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0412 20:54:08.567433       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0412 20:54:13.575277       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0412 20:54:18.587335       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0412 20:54:23.598623       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0412 20:54:28.606640       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0412 20:54:33.614916       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0412 20:54:38.624941       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0412 20:54:43.635150       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0412 20:54:48.652635       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0412 20:54:53.661294       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0412 20:54:58.670708       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0412 20:55:03.678672       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0412 20:55:08.691315       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0412 20:55:13.700402       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0412 20:55:18.710305       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0412 20:55:23.719875       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0412 20:55:28.728161       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0412 20:55:33.735876       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0412 20:55:38.742481       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0412 20:55:43.752865       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0412 20:55:48.761694       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0412 20:55:53.770670       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0412 20:55:58.779646       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0412 20:56:03.787380       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0412 20:56:08.799118       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0412 20:56:13.807521       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0412 20:56:18.816001       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0412 20:56:23.825610       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0412 20:56:28.836238       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0412 20:56:30.539858       1 controller.go:291] Started PVC processing "default/test-pvc"
W0412 20:56:30.539896       1 controller.go:318] PV "" bound to PVC default/test-pvc not found
I0412 20:56:32.644544       1 controller.go:291] Started PVC processing "default/test-pvc"
I0412 20:56:32.645438       1 controller.go:334] No need to resize PVC "default/test-pvc"
I0412 20:56:33.845952       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0412 20:56:38.862568       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0412 20:56:43.872137       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0412 20:56:48.880181       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0412 20:56:53.891133       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0412 20:56:58.899659       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0412 20:57:03.908725       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0412 20:57:08.916712       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0412 20:57:13.925855       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0412 20:57:18.936104       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com