I0919 01:10:03.988692       1 main.go:93] Version : v1.3.0
I0919 01:10:03.988750       1 feature_gate.go:245] feature gates: &{map[]}
I0919 01:10:03.994308       1 connection.go:154] Connecting to unix:///csi/csi-provisioner.sock
I0919 01:10:08.840073       1 common.go:111] Probing CSI driver for readiness
I0919 01:10:08.840103       1 connection.go:183] GRPC call: /csi.v1.Identity/Probe
I0919 01:10:08.840110       1 connection.go:184] GRPC request: {}
I0919 01:10:08.852301       1 connection.go:186] GRPC response: {}
I0919 01:10:08.852406       1 connection.go:187] GRPC error: <nil>
I0919 01:10:08.852427       1 connection.go:183] GRPC call: /csi.v1.Identity/GetPluginInfo
I0919 01:10:08.852435       1 connection.go:184] GRPC request: {}
I0919 01:10:08.854028       1 connection.go:186] GRPC response: {"name":"rbd.csi.ceph.com","vendor_version":"v3.5.1"}
I0919 01:10:08.854259       1 connection.go:187] GRPC error: <nil>
I0919 01:10:08.854278       1 main.go:141] CSI driver name: "rbd.csi.ceph.com"
I0919 01:10:08.854294       1 connection.go:183] GRPC call: /csi.v1.Identity/GetPluginCapabilities
I0919 01:10:08.854301       1 connection.go:184] GRPC request: {}
I0919 01:10:08.855814       1 connection.go:186] GRPC response: {"capabilities":[{"Type":{"Service":{"type":1}}},{"Type":{"VolumeExpansion":{"type":1}}},{"Type":{"Service":{"type":2}}}]}
I0919 01:10:08.856013       1 connection.go:187] GRPC error: <nil>
I0919 01:10:08.856027       1 connection.go:183] GRPC call: /csi.v1.Controller/ControllerGetCapabilities
I0919 01:10:08.856037       1 connection.go:184] GRPC request: {}
I0919 01:10:08.857501       1 connection.go:186] GRPC response: {"capabilities":[{"Type":{"Rpc":{"type":1}}},{"Type":{"Rpc":{"type":5}}},{"Type":{"Rpc":{"type":7}}},{"Type":{"Rpc":{"type":9}}}]}
I0919 01:10:08.857641       1 connection.go:187] GRPC error: <nil>
I0919 01:10:08.857653       1 connection.go:183] GRPC call: /csi.v1.Controller/ControllerGetCapabilities
I0919 01:10:08.857658       1 connection.go:184] GRPC request: {}
I0919 01:10:08.858724       1 connection.go:186] GRPC response: {"capabilities":[{"Type":{"Rpc":{"type":1}}},{"Type":{"Rpc":{"type":5}}},{"Type":{"Rpc":{"type":7}}},{"Type":{"Rpc":{"type":9}}}]}
I0919 01:10:08.858811       1 connection.go:187] GRPC error: <nil>
I0919 01:10:08.860566       1 leaderelection.go:248] attempting to acquire leader lease kube-system/external-resizer-rbd-csi-ceph-com...
I0919 01:10:08.876911       1 leaderelection.go:258] successfully acquired lease kube-system/external-resizer-rbd-csi-ceph-com
I0919 01:10:08.878030       1 leader_election.go:212] new leader detected, current leader: ceph-csi-rbd-provisioner-6f6497f79c-9h6g5
I0919 01:10:08.878367       1 leader_election.go:205] became leader, starting
I0919 01:10:08.878403       1 controller.go:251] Starting external resizer rbd.csi.ceph.com
I0919 01:10:08.878687       1 reflector.go:219] Starting reflector *v1.PersistentVolume (10m0s) from k8s.io/client-go/informers/factory.go:134
I0919 01:10:08.878717       1 reflector.go:255] Listing and watching *v1.PersistentVolume from k8s.io/client-go/informers/factory.go:134
I0919 01:10:08.879012       1 reflector.go:219] Starting reflector *v1.PersistentVolumeClaim (10m0s) from k8s.io/client-go/informers/factory.go:134
I0919 01:10:08.879033       1 reflector.go:255] Listing and watching *v1.PersistentVolumeClaim from k8s.io/client-go/informers/factory.go:134
I0919 01:10:08.886729       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0919 01:10:08.979298       1 shared_informer.go:270] caches populated
I0919 01:10:13.897431       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0919 01:10:18.906601       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0919 01:10:23.914833       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0919 01:10:28.922628       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0919 01:10:33.933880       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0919 01:10:38.953442       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0919 01:10:43.967054       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0919 01:10:48.979768       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0919 01:10:53.991714       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0919 01:10:59.002038       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0919 01:11:04.011538       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0919 01:11:09.021450       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0919 01:11:14.031496       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0919 01:11:19.040760       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0919 01:11:24.050486       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0919 01:11:29.063764       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0919 01:11:34.072215       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0919 01:11:39.081567       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0919 01:11:44.089852       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0919 01:11:49.097675       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0919 01:11:54.108444       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0919 01:11:59.117664       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0919 01:12:04.127297       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0919 01:12:09.138033       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0919 01:12:14.148882       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0919 01:12:19.163173       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0919 01:12:24.172577       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0919 01:12:29.184308       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0919 01:12:34.191798       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0919 01:12:39.201095       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0919 01:12:44.210967       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0919 01:12:49.225079       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0919 01:12:54.234919       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0919 01:12:59.242996       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0919 01:13:04.252550       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0919 01:13:09.262239       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0919 01:13:14.274607       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0919 01:13:19.284954       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0919 01:13:24.292736       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0919 01:13:29.301971       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0919 01:13:34.309612       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0919 01:13:39.319300       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0919 01:13:44.328921       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0919 01:13:49.337295       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0919 01:13:54.346418       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0919 01:13:59.356705       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0919 01:14:04.365549       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0919 01:14:09.374784       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0919 01:14:14.384050       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0919 01:14:19.392304       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0919 01:14:24.404088       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0919 01:14:29.413429       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0919 01:14:30.548692       1 controller.go:291] Started PVC processing "default/test-pvc"
W0919 01:14:30.548818       1 controller.go:318] PV "" bound to PVC default/test-pvc not found
I0919 01:14:30.748300       1 controller.go:291] Started PVC processing "default/test-pvc"
I0919 01:14:30.748339       1 controller.go:334] No need to resize PVC "default/test-pvc"
I0919 01:14:34.424636       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0919 01:14:39.435457       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0919 01:14:44.444754       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0919 01:14:49.457081       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0919 01:14:54.469194       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0919 01:14:59.478230       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0919 01:15:04.487071       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0919 01:15:09.497475       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0919 01:15:14.506123       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0919 01:15:19.515935       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0919 01:15:24.527441       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com