I0422 16:33:50.568967 1 main.go:93] Version : v1.3.0 I0422 16:33:50.569039 1 feature_gate.go:245] feature gates: &{map[]} I0422 16:33:50.570456 1 connection.go:154] Connecting to unix:///csi/csi-provisioner.sock W0422 16:34:00.570567 1 connection.go:173] Still connecting to unix:///csi/csi-provisioner.sock I0422 16:34:05.336442 1 common.go:111] Probing CSI driver for readiness I0422 16:34:05.336471 1 connection.go:183] GRPC call: /csi.v1.Identity/Probe I0422 16:34:05.336478 1 connection.go:184] GRPC request: {} I0422 16:34:05.347849 1 connection.go:186] GRPC response: {} I0422 16:34:05.347929 1 connection.go:187] GRPC error: I0422 16:34:05.347943 1 connection.go:183] GRPC call: /csi.v1.Identity/GetPluginInfo I0422 16:34:05.347948 1 connection.go:184] GRPC request: {} I0422 16:34:05.348643 1 connection.go:186] GRPC response: {"name":"rbd.csi.ceph.com","vendor_version":"v3.5.1"} I0422 16:34:05.348742 1 connection.go:187] GRPC error: I0422 16:34:05.348755 1 main.go:141] CSI driver name: "rbd.csi.ceph.com" I0422 16:34:05.348785 1 connection.go:183] GRPC call: /csi.v1.Identity/GetPluginCapabilities I0422 16:34:05.348790 1 connection.go:184] GRPC request: {} I0422 16:34:05.349865 1 connection.go:186] GRPC response: {"capabilities":[{"Type":{"Service":{"type":1}}},{"Type":{"VolumeExpansion":{"type":1}}},{"Type":{"Service":{"type":2}}}]} I0422 16:34:05.350057 1 connection.go:187] GRPC error: I0422 16:34:05.350068 1 connection.go:183] GRPC call: /csi.v1.Controller/ControllerGetCapabilities I0422 16:34:05.350072 1 connection.go:184] GRPC request: {} I0422 16:34:05.351009 1 connection.go:186] GRPC response: {"capabilities":[{"Type":{"Rpc":{"type":1}}},{"Type":{"Rpc":{"type":5}}},{"Type":{"Rpc":{"type":7}}},{"Type":{"Rpc":{"type":9}}}]} I0422 16:34:05.351160 1 connection.go:187] GRPC error: I0422 16:34:05.351170 1 connection.go:183] GRPC call: /csi.v1.Controller/ControllerGetCapabilities I0422 16:34:05.351174 1 connection.go:184] GRPC request: {} I0422 16:34:05.351612 1 connection.go:186] GRPC response: {"capabilities":[{"Type":{"Rpc":{"type":1}}},{"Type":{"Rpc":{"type":5}}},{"Type":{"Rpc":{"type":7}}},{"Type":{"Rpc":{"type":9}}}]} I0422 16:34:05.351690 1 connection.go:187] GRPC error: I0422 16:34:05.353182 1 leaderelection.go:248] attempting to acquire leader lease kube-system/external-resizer-rbd-csi-ceph-com... I0422 16:34:06.125300 1 leaderelection.go:258] successfully acquired lease kube-system/external-resizer-rbd-csi-ceph-com I0422 16:34:06.125382 1 leader_election.go:212] new leader detected, current leader: ceph-csi-rbd-provisioner-6f6497f79c-svqq7 I0422 16:34:06.125554 1 leader_election.go:205] became leader, starting I0422 16:34:06.125580 1 controller.go:251] Starting external resizer rbd.csi.ceph.com I0422 16:34:06.127311 1 reflector.go:219] Starting reflector *v1.PersistentVolume (10m0s) from k8s.io/client-go/informers/factory.go:134 I0422 16:34:06.127399 1 reflector.go:255] Listing and watching *v1.PersistentVolume from k8s.io/client-go/informers/factory.go:134 I0422 16:34:06.128419 1 reflector.go:219] Starting reflector *v1.PersistentVolumeClaim (10m0s) from k8s.io/client-go/informers/factory.go:134 I0422 16:34:06.128447 1 reflector.go:255] Listing and watching *v1.PersistentVolumeClaim from k8s.io/client-go/informers/factory.go:134 I0422 16:34:06.225851 1 shared_informer.go:270] caches populated I0422 16:34:08.095602 1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com I0422 16:34:13.159231 1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com I0422 16:34:18.167337 1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com I0422 16:34:23.175559 1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com I0422 16:34:28.198676 1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com I0422 16:34:33.417831 1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com I0422 16:34:38.430998 1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com I0422 16:34:43.467504 1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com I0422 16:34:48.476520 1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com I0422 16:34:53.487869 1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com I0422 16:34:58.497375 1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com I0422 16:35:03.509190 1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com I0422 16:35:08.520400 1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com I0422 16:35:13.533120 1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com I0422 16:35:18.540932 1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com I0422 16:35:23.549329 1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com I0422 16:35:28.560341 1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com I0422 16:35:33.691769 1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com I0422 16:35:38.699887 1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com I0422 16:35:43.710398 1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com I0422 16:35:48.719870 1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com I0422 16:35:53.730615 1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com I0422 16:35:58.742749 1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com I0422 16:36:03.751025 1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com I0422 16:36:08.762951 1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com I0422 16:36:13.770619 1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com I0422 16:36:18.782548 1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com I0422 16:36:23.792032 1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com I0422 16:36:28.808222 1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com I0422 16:36:33.818452 1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com I0422 16:36:38.829177 1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com I0422 16:36:43.838246 1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com I0422 16:36:48.847855 1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com I0422 16:36:53.856974 1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com I0422 16:36:58.868101 1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com I0422 16:37:03.877161 1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com I0422 16:37:08.888402 1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com I0422 16:37:13.899740 1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com I0422 16:37:18.801467 1 controller.go:291] Started PVC processing "default/test-pvc" W0422 16:37:18.801501 1 controller.go:318] PV "" bound to PVC default/test-pvc not found I0422 16:37:18.907864 1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com I0422 16:37:20.107393 1 controller.go:291] Started PVC processing "default/test-pvc" I0422 16:37:20.107443 1 controller.go:334] No need to resize PVC "default/test-pvc" I0422 16:37:23.917923 1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com I0422 16:37:28.932484 1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com I0422 16:37:33.944740 1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com I0422 16:37:38.956805 1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com I0422 16:37:43.967777 1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com I0422 16:37:48.978651 1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com I0422 16:37:53.988404 1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com I0422 16:37:58.997211 1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com I0422 16:38:04.005851 1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com I0422 16:38:09.014989 1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com