I0427 12:08:31.099937       1 main.go:93] Version : v1.3.0
I0427 12:08:31.099989       1 feature_gate.go:245] feature gates: &{map[]}
I0427 12:08:31.103132       1 connection.go:154] Connecting to unix:///csi/csi-provisioner.sock
I0427 12:08:34.117099       1 common.go:111] Probing CSI driver for readiness
I0427 12:08:34.117122       1 connection.go:183] GRPC call: /csi.v1.Identity/Probe
I0427 12:08:34.117127       1 connection.go:184] GRPC request: {}
I0427 12:08:34.129680       1 connection.go:186] GRPC response: {}
I0427 12:08:34.129767       1 connection.go:187] GRPC error: <nil>
I0427 12:08:34.129782       1 connection.go:183] GRPC call: /csi.v1.Identity/GetPluginInfo
I0427 12:08:34.129787       1 connection.go:184] GRPC request: {}
I0427 12:08:34.130818       1 connection.go:186] GRPC response: {"name":"rbd.csi.ceph.com","vendor_version":"v3.5.1"}
I0427 12:08:34.130930       1 connection.go:187] GRPC error: <nil>
I0427 12:08:34.130942       1 main.go:141] CSI driver name: "rbd.csi.ceph.com"
I0427 12:08:34.130951       1 connection.go:183] GRPC call: /csi.v1.Identity/GetPluginCapabilities
I0427 12:08:34.130956       1 connection.go:184] GRPC request: {}
I0427 12:08:34.131536       1 connection.go:186] GRPC response: {"capabilities":[{"Type":{"Service":{"type":1}}},{"Type":{"VolumeExpansion":{"type":1}}},{"Type":{"Service":{"type":2}}}]}
I0427 12:08:34.131695       1 connection.go:187] GRPC error: <nil>
I0427 12:08:34.131704       1 connection.go:183] GRPC call: /csi.v1.Controller/ControllerGetCapabilities
I0427 12:08:34.131710       1 connection.go:184] GRPC request: {}
I0427 12:08:34.132557       1 connection.go:186] GRPC response: {"capabilities":[{"Type":{"Rpc":{"type":1}}},{"Type":{"Rpc":{"type":5}}},{"Type":{"Rpc":{"type":7}}},{"Type":{"Rpc":{"type":9}}}]}
I0427 12:08:34.132729       1 connection.go:187] GRPC error: <nil>
I0427 12:08:34.132754       1 connection.go:183] GRPC call: /csi.v1.Controller/ControllerGetCapabilities
I0427 12:08:34.132802       1 connection.go:184] GRPC request: {}
I0427 12:08:34.133254       1 connection.go:186] GRPC response: {"capabilities":[{"Type":{"Rpc":{"type":1}}},{"Type":{"Rpc":{"type":5}}},{"Type":{"Rpc":{"type":7}}},{"Type":{"Rpc":{"type":9}}}]}
I0427 12:08:34.133322       1 connection.go:187] GRPC error: <nil>
I0427 12:08:34.134108       1 leaderelection.go:248] attempting to acquire leader lease kube-system/external-resizer-rbd-csi-ceph-com...
I0427 12:08:34.145801       1 leaderelection.go:258] successfully acquired lease kube-system/external-resizer-rbd-csi-ceph-com
I0427 12:08:34.145867       1 leader_election.go:212] new leader detected, current leader: ceph-csi-rbd-provisioner-6f6497f79c-hqr7r
I0427 12:08:34.146683       1 leader_election.go:205] became leader, starting
I0427 12:08:34.146762       1 controller.go:251] Starting external resizer rbd.csi.ceph.com
I0427 12:08:34.146999       1 reflector.go:219] Starting reflector *v1.PersistentVolume (10m0s) from k8s.io/client-go/informers/factory.go:134
I0427 12:08:34.147224       1 reflector.go:255] Listing and watching *v1.PersistentVolume from k8s.io/client-go/informers/factory.go:134
I0427 12:08:34.147102       1 reflector.go:219] Starting reflector *v1.PersistentVolumeClaim (10m0s) from k8s.io/client-go/informers/factory.go:134
I0427 12:08:34.147988       1 reflector.go:255] Listing and watching *v1.PersistentVolumeClaim from k8s.io/client-go/informers/factory.go:134
I0427 12:08:34.153838       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0427 12:08:34.247318       1 shared_informer.go:270] caches populated
I0427 12:08:39.425178       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0427 12:08:44.432508       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0427 12:08:49.443305       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0427 12:08:54.451084       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0427 12:08:59.463125       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0427 12:09:04.471468       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0427 12:09:09.482239       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0427 12:09:14.490968       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0427 12:09:19.501231       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0427 12:09:24.510461       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0427 12:09:29.521294       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0427 12:09:34.529773       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0427 12:09:39.539802       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0427 12:09:44.547932       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0427 12:09:49.556109       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0427 12:09:54.565195       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0427 12:09:59.577124       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0427 12:10:04.586091       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0427 12:10:09.593877       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0427 12:10:14.600370       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0427 12:10:19.611720       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0427 12:10:24.620200       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0427 12:10:29.628973       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0427 12:10:34.639563       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0427 12:10:39.649627       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0427 12:10:44.660414       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0427 12:10:49.665550       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0427 12:10:54.674054       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0427 12:10:59.683084       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0427 12:11:04.692319       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0427 12:11:09.702940       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0427 12:11:14.709062       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0427 12:11:19.718753       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0427 12:11:24.729165       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0427 12:11:29.740408       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0427 12:11:34.747724       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0427 12:11:39.760948       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0427 12:11:40.211802       1 controller.go:291] Started PVC processing "default/test-pvc"
W0427 12:11:40.211837       1 controller.go:318] PV "" bound to PVC default/test-pvc not found
I0427 12:11:41.817788       1 controller.go:291] Started PVC processing "default/test-pvc"
I0427 12:11:41.817816       1 controller.go:334] No need to resize PVC "default/test-pvc"
I0427 12:11:44.770412       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0427 12:11:49.783700       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0427 12:11:54.793340       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0427 12:11:59.811777       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0427 12:12:04.819558       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0427 12:12:09.831486       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0427 12:12:14.841231       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0427 12:12:19.847609       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0427 12:12:24.854416       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com