I0218 22:57:44.344716       1 main.go:93] Version : v1.3.0
I0218 22:57:44.344922       1 feature_gate.go:245] feature gates: &{map[]}
I0218 22:57:44.352303       1 connection.go:154] Connecting to unix:///csi/csi-provisioner.sock
I0218 22:57:48.394594       1 common.go:111] Probing CSI driver for readiness
I0218 22:57:48.395348       1 connection.go:183] GRPC call: /csi.v1.Identity/Probe
I0218 22:57:48.395355       1 connection.go:184] GRPC request: {}
I0218 22:57:48.442379       1 connection.go:186] GRPC response: {}
I0218 22:57:48.442444       1 connection.go:187] GRPC error: <nil>
I0218 22:57:48.442457       1 connection.go:183] GRPC call: /csi.v1.Identity/GetPluginInfo
I0218 22:57:48.442460       1 connection.go:184] GRPC request: {}
I0218 22:57:48.448236       1 connection.go:186] GRPC response: {"name":"rbd.csi.ceph.com","vendor_version":"v3.5.1"}
I0218 22:57:48.448335       1 connection.go:187] GRPC error: <nil>
I0218 22:57:48.448360       1 main.go:141] CSI driver name: "rbd.csi.ceph.com"
I0218 22:57:48.448479       1 connection.go:183] GRPC call: /csi.v1.Identity/GetPluginCapabilities
I0218 22:57:48.448502       1 connection.go:184] GRPC request: {}
I0218 22:57:48.451200       1 connection.go:186] GRPC response: {"capabilities":[{"Type":{"Service":{"type":1}}},{"Type":{"VolumeExpansion":{"type":1}}},{"Type":{"Service":{"type":2}}}]}
I0218 22:57:48.451338       1 connection.go:187] GRPC error: <nil>
I0218 22:57:48.451358       1 connection.go:183] GRPC call: /csi.v1.Controller/ControllerGetCapabilities
I0218 22:57:48.451371       1 connection.go:184] GRPC request: {}
I0218 22:57:48.455705       1 connection.go:186] GRPC response: {"capabilities":[{"Type":{"Rpc":{"type":1}}},{"Type":{"Rpc":{"type":5}}},{"Type":{"Rpc":{"type":7}}},{"Type":{"Rpc":{"type":9}}}]}
I0218 22:57:48.455820       1 connection.go:187] GRPC error: <nil>
I0218 22:57:48.455838       1 connection.go:183] GRPC call: /csi.v1.Controller/ControllerGetCapabilities
I0218 22:57:48.455851       1 connection.go:184] GRPC request: {}
I0218 22:57:48.456385       1 connection.go:186] GRPC response: {"capabilities":[{"Type":{"Rpc":{"type":1}}},{"Type":{"Rpc":{"type":5}}},{"Type":{"Rpc":{"type":7}}},{"Type":{"Rpc":{"type":9}}}]}
I0218 22:57:48.456450       1 connection.go:187] GRPC error: <nil>
I0218 22:57:48.457346       1 leaderelection.go:248] attempting to acquire leader lease kube-system/external-resizer-rbd-csi-ceph-com...
I0218 22:57:48.476075       1 leaderelection.go:258] successfully acquired lease kube-system/external-resizer-rbd-csi-ceph-com
I0218 22:57:48.476313       1 leader_election.go:212] new leader detected, current leader: ceph-csi-rbd-provisioner-5d8ff44fc9-znghb
I0218 22:57:48.477329       1 leader_election.go:205] became leader, starting
I0218 22:57:48.477383       1 controller.go:251] Starting external resizer rbd.csi.ceph.com
I0218 22:57:48.477550       1 reflector.go:219] Starting reflector *v1.PersistentVolume (10m0s) from k8s.io/client-go/informers/factory.go:134
I0218 22:57:48.477949       1 reflector.go:255] Listing and watching *v1.PersistentVolume from k8s.io/client-go/informers/factory.go:134
I0218 22:57:48.478264       1 reflector.go:219] Starting reflector *v1.PersistentVolumeClaim (10m0s) from k8s.io/client-go/informers/factory.go:134
I0218 22:57:48.478313       1 reflector.go:255] Listing and watching *v1.PersistentVolumeClaim from k8s.io/client-go/informers/factory.go:134
I0218 22:57:48.485826       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0218 22:57:48.578171       1 shared_informer.go:270] caches populated
I0218 22:57:54.188300       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0218 22:57:59.195234       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0218 22:58:04.209773       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0218 22:58:09.219939       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0218 22:58:14.230373       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0218 22:58:19.237354       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0218 22:58:24.251273       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0218 22:58:29.266405       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0218 22:58:34.283653       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0218 22:58:39.289518       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0218 22:58:44.304585       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0218 22:58:49.328802       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0218 22:58:54.335623       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0218 22:58:59.345577       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0218 22:59:04.356678       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0218 22:59:09.366055       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0218 22:59:14.373857       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0218 22:59:19.383005       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0218 22:59:24.400710       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0218 22:59:29.412367       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0218 22:59:34.425560       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0218 22:59:39.440661       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0218 22:59:44.451251       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0218 22:59:49.465590       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0218 22:59:54.478444       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0218 22:59:59.486402       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0218 23:00:04.492080       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0218 23:00:09.499224       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0218 23:00:14.505386       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0218 23:00:19.513042       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0218 23:00:24.519782       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0218 23:00:29.528372       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0218 23:00:34.536457       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0218 23:00:39.546788       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0218 23:00:44.552798       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0218 23:00:44.973022       1 controller.go:291] Started PVC processing "default/test-pvc"
W0218 23:00:44.973052       1 controller.go:318] PV "" bound to PVC default/test-pvc not found
I0218 23:00:46.488303       1 controller.go:291] Started PVC processing "default/test-pvc"
I0218 23:00:46.488357       1 controller.go:334] No need to resize PVC "default/test-pvc"
I0218 23:00:49.562651       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0218 23:00:54.573355       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0218 23:00:59.580329       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0218 23:01:04.591753       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0218 23:01:09.614319       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0218 23:01:14.625710       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0218 23:01:19.632939       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0218 23:01:24.644168       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0218 23:01:29.653851       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0218 23:01:34.663726       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0218 23:01:39.671225       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com