I0327 01:59:05.942727       1 main.go:93] Version : v1.3.0
I0327 01:59:05.942803       1 feature_gate.go:245] feature gates: &{map[]}
I0327 01:59:05.945639       1 connection.go:154] Connecting to unix:///csi/csi-provisioner.sock
I0327 01:59:08.790960       1 common.go:111] Probing CSI driver for readiness
I0327 01:59:08.790984       1 connection.go:183] GRPC call: /csi.v1.Identity/Probe
I0327 01:59:08.790992       1 connection.go:184] GRPC request: {}
I0327 01:59:08.795351       1 connection.go:186] GRPC response: {}
I0327 01:59:08.795481       1 connection.go:187] GRPC error: <nil>
I0327 01:59:08.795523       1 connection.go:183] GRPC call: /csi.v1.Identity/GetPluginInfo
I0327 01:59:08.795532       1 connection.go:184] GRPC request: {}
I0327 01:59:08.796627       1 connection.go:186] GRPC response: {"name":"rbd.csi.ceph.com","vendor_version":"v3.5.1"}
I0327 01:59:08.796731       1 connection.go:187] GRPC error: <nil>
I0327 01:59:08.796745       1 main.go:141] CSI driver name: "rbd.csi.ceph.com"
I0327 01:59:08.796756       1 connection.go:183] GRPC call: /csi.v1.Identity/GetPluginCapabilities
I0327 01:59:08.796760       1 connection.go:184] GRPC request: {}
I0327 01:59:08.797514       1 connection.go:186] GRPC response: {"capabilities":[{"Type":{"Service":{"type":1}}},{"Type":{"VolumeExpansion":{"type":1}}},{"Type":{"Service":{"type":2}}}]}
I0327 01:59:08.797631       1 connection.go:187] GRPC error: <nil>
I0327 01:59:08.797638       1 connection.go:183] GRPC call: /csi.v1.Controller/ControllerGetCapabilities
I0327 01:59:08.797641       1 connection.go:184] GRPC request: {}
I0327 01:59:08.798536       1 connection.go:186] GRPC response: {"capabilities":[{"Type":{"Rpc":{"type":1}}},{"Type":{"Rpc":{"type":5}}},{"Type":{"Rpc":{"type":7}}},{"Type":{"Rpc":{"type":9}}}]}
I0327 01:59:08.798726       1 connection.go:187] GRPC error: <nil>
I0327 01:59:08.798741       1 connection.go:183] GRPC call: /csi.v1.Controller/ControllerGetCapabilities
I0327 01:59:08.798745       1 connection.go:184] GRPC request: {}
I0327 01:59:08.799200       1 connection.go:186] GRPC response: {"capabilities":[{"Type":{"Rpc":{"type":1}}},{"Type":{"Rpc":{"type":5}}},{"Type":{"Rpc":{"type":7}}},{"Type":{"Rpc":{"type":9}}}]}
I0327 01:59:08.799270       1 connection.go:187] GRPC error: <nil>
I0327 01:59:08.800394       1 leaderelection.go:248] attempting to acquire leader lease kube-system/external-resizer-rbd-csi-ceph-com...
I0327 01:59:08.816297       1 leaderelection.go:258] successfully acquired lease kube-system/external-resizer-rbd-csi-ceph-com
I0327 01:59:08.816353       1 leader_election.go:212] new leader detected, current leader: ceph-csi-rbd-provisioner-6f6497f79c-xmq9z
I0327 01:59:08.816604       1 leader_election.go:205] became leader, starting
I0327 01:59:08.816637       1 controller.go:251] Starting external resizer rbd.csi.ceph.com
I0327 01:59:08.816973       1 reflector.go:219] Starting reflector *v1.PersistentVolume (10m0s) from k8s.io/client-go/informers/factory.go:134
I0327 01:59:08.816994       1 reflector.go:255] Listing and watching *v1.PersistentVolume from k8s.io/client-go/informers/factory.go:134
I0327 01:59:08.817334       1 reflector.go:219] Starting reflector *v1.PersistentVolumeClaim (10m0s) from k8s.io/client-go/informers/factory.go:134
I0327 01:59:08.817360       1 reflector.go:255] Listing and watching *v1.PersistentVolumeClaim from k8s.io/client-go/informers/factory.go:134
I0327 01:59:08.827827       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0327 01:59:08.916884       1 shared_informer.go:270] caches populated
I0327 01:59:13.840023       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0327 01:59:18.850815       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0327 01:59:23.860582       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0327 01:59:28.869784       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0327 01:59:33.882963       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0327 01:59:38.891778       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0327 01:59:43.903073       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0327 01:59:48.910492       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0327 01:59:53.921842       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0327 01:59:58.931393       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0327 02:00:03.943566       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0327 02:00:08.955520       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0327 02:00:13.966100       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0327 02:00:18.975539       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0327 02:00:23.985230       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0327 02:00:28.995865       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0327 02:00:34.008342       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0327 02:00:39.016557       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0327 02:00:44.027981       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0327 02:00:49.036535       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0327 02:00:54.052214       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0327 02:00:59.061512       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0327 02:01:04.071015       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0327 02:01:09.087913       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0327 02:01:14.097247       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0327 02:01:19.104794       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0327 02:01:24.115360       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0327 02:01:29.125660       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0327 02:01:34.138220       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0327 02:01:39.146713       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0327 02:01:44.153505       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0327 02:01:49.163765       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0327 02:01:54.174443       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0327 02:01:59.184852       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0327 02:02:04.195748       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0327 02:02:09.207321       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0327 02:02:14.216951       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0327 02:02:18.072074       1 controller.go:291] Started PVC processing "default/test-pvc"
W0327 02:02:18.072131       1 controller.go:318] PV "" bound to PVC default/test-pvc not found
I0327 02:02:19.227265       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0327 02:02:19.630431       1 controller.go:291] Started PVC processing "default/test-pvc"
I0327 02:02:19.630464       1 controller.go:334] No need to resize PVC "default/test-pvc"
I0327 02:02:24.241756       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0327 02:02:29.251462       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0327 02:02:34.262627       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0327 02:02:39.270840       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0327 02:02:44.279264       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0327 02:02:49.287169       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0327 02:02:54.296933       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0327 02:02:59.306376       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0327 02:03:04.312988       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com