I0225 01:43:59.494993       1 main.go:93] Version : v1.3.0
I0225 01:43:59.495039       1 feature_gate.go:245] feature gates: &{map[]}
I0225 01:43:59.496200       1 connection.go:154] Connecting to unix:///csi/csi-provisioner.sock
W0225 01:44:09.496794       1 connection.go:173] Still connecting to unix:///csi/csi-provisioner.sock
I0225 01:44:09.568163       1 common.go:111] Probing CSI driver for readiness
I0225 01:44:09.568196       1 connection.go:183] GRPC call: /csi.v1.Identity/Probe
I0225 01:44:09.568206       1 connection.go:184] GRPC request: {}
I0225 01:44:09.578521       1 connection.go:186] GRPC response: {}
I0225 01:44:09.578612       1 connection.go:187] GRPC error: <nil>
I0225 01:44:09.578626       1 connection.go:183] GRPC call: /csi.v1.Identity/GetPluginInfo
I0225 01:44:09.578634       1 connection.go:184] GRPC request: {}
I0225 01:44:09.579451       1 connection.go:186] GRPC response: {"name":"rbd.csi.ceph.com","vendor_version":"v3.5.1"}
I0225 01:44:09.579544       1 connection.go:187] GRPC error: <nil>
I0225 01:44:09.579559       1 main.go:141] CSI driver name: "rbd.csi.ceph.com"
I0225 01:44:09.579573       1 connection.go:183] GRPC call: /csi.v1.Identity/GetPluginCapabilities
I0225 01:44:09.579577       1 connection.go:184] GRPC request: {}
I0225 01:44:09.581234       1 connection.go:186] GRPC response: {"capabilities":[{"Type":{"Service":{"type":1}}},{"Type":{"VolumeExpansion":{"type":1}}},{"Type":{"Service":{"type":2}}}]}
I0225 01:44:09.581382       1 connection.go:187] GRPC error: <nil>
I0225 01:44:09.581390       1 connection.go:183] GRPC call: /csi.v1.Controller/ControllerGetCapabilities
I0225 01:44:09.581393       1 connection.go:184] GRPC request: {}
I0225 01:44:09.582439       1 connection.go:186] GRPC response: {"capabilities":[{"Type":{"Rpc":{"type":1}}},{"Type":{"Rpc":{"type":5}}},{"Type":{"Rpc":{"type":7}}},{"Type":{"Rpc":{"type":9}}}]}
I0225 01:44:09.582513       1 connection.go:187] GRPC error: <nil>
I0225 01:44:09.582520       1 connection.go:183] GRPC call: /csi.v1.Controller/ControllerGetCapabilities
I0225 01:44:09.582523       1 connection.go:184] GRPC request: {}
I0225 01:44:09.582928       1 connection.go:186] GRPC response: {"capabilities":[{"Type":{"Rpc":{"type":1}}},{"Type":{"Rpc":{"type":5}}},{"Type":{"Rpc":{"type":7}}},{"Type":{"Rpc":{"type":9}}}]}
I0225 01:44:09.582974       1 connection.go:187] GRPC error: <nil>
I0225 01:44:09.584261       1 leaderelection.go:248] attempting to acquire leader lease kube-system/external-resizer-rbd-csi-ceph-com...
I0225 01:44:09.599400       1 leaderelection.go:258] successfully acquired lease kube-system/external-resizer-rbd-csi-ceph-com
I0225 01:44:09.599426       1 leader_election.go:212] new leader detected, current leader: ceph-csi-rbd-provisioner-5d8ff44fc9-wsv4q
I0225 01:44:09.599544       1 leader_election.go:205] became leader, starting
I0225 01:44:09.599574       1 controller.go:251] Starting external resizer rbd.csi.ceph.com
I0225 01:44:09.600054       1 reflector.go:219] Starting reflector *v1.PersistentVolumeClaim (10m0s) from k8s.io/client-go/informers/factory.go:134
I0225 01:44:09.600748       1 reflector.go:219] Starting reflector *v1.PersistentVolume (10m0s) from k8s.io/client-go/informers/factory.go:134
I0225 01:44:09.600770       1 reflector.go:255] Listing and watching *v1.PersistentVolume from k8s.io/client-go/informers/factory.go:134
I0225 01:44:09.600837       1 reflector.go:255] Listing and watching *v1.PersistentVolumeClaim from k8s.io/client-go/informers/factory.go:134
I0225 01:44:09.613476       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0225 01:44:09.701678       1 shared_informer.go:270] caches populated
I0225 01:44:14.624727       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0225 01:44:19.656503       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0225 01:44:24.667726       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0225 01:44:29.702357       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0225 01:44:34.812458       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0225 01:44:39.940383       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0225 01:44:45.231995       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0225 01:44:50.241804       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0225 01:44:55.254819       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0225 01:45:00.266193       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0225 01:45:05.275522       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0225 01:45:10.286496       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0225 01:45:15.298349       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0225 01:45:20.308052       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0225 01:45:25.319816       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0225 01:45:30.331379       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0225 01:45:35.339250       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0225 01:45:40.351637       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0225 01:45:45.359864       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0225 01:45:50.401808       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0225 01:45:55.409317       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0225 01:46:00.416637       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0225 01:46:05.425103       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0225 01:46:10.444663       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0225 01:46:15.462839       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0225 01:46:20.493555       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0225 01:46:25.546409       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0225 01:46:31.771264       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0225 01:46:36.870283       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0225 01:46:41.881790       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0225 01:46:46.897608       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0225 01:46:51.927762       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0225 01:46:56.956313       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0225 01:47:01.962711       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0225 01:47:06.973175       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0225 01:47:08.878368       1 controller.go:291] Started PVC processing "default/test-pvc"
W0225 01:47:08.878393       1 controller.go:318] PV "" bound to PVC default/test-pvc not found
I0225 01:47:10.149358       1 controller.go:291] Started PVC processing "default/test-pvc"
I0225 01:47:10.149439       1 controller.go:334] No need to resize PVC "default/test-pvc"
I0225 01:47:11.986170       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0225 01:47:17.005992       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0225 01:47:22.028980       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0225 01:47:27.294612       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0225 01:47:32.371305       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0225 01:47:37.482903       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0225 01:47:42.494732       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0225 01:47:47.503792       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0225 01:47:52.512640       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0225 01:47:57.523653       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com