I0418 22:20:16.400672 1 main.go:93] Version : v1.3.0 I0418 22:20:16.400735 1 feature_gate.go:245] feature gates: &{map[]} I0418 22:20:16.404077 1 connection.go:154] Connecting to unix:///csi/csi-provisioner.sock W0418 22:20:26.405291 1 connection.go:173] Still connecting to unix:///csi/csi-provisioner.sock I0418 22:20:26.852230 1 common.go:111] Probing CSI driver for readiness I0418 22:20:26.852292 1 connection.go:183] GRPC call: /csi.v1.Identity/Probe I0418 22:20:26.852300 1 connection.go:184] GRPC request: {} I0418 22:20:26.859023 1 connection.go:186] GRPC response: {} I0418 22:20:26.859108 1 connection.go:187] GRPC error: I0418 22:20:26.859120 1 connection.go:183] GRPC call: /csi.v1.Identity/GetPluginInfo I0418 22:20:26.859123 1 connection.go:184] GRPC request: {} I0418 22:20:26.859874 1 connection.go:186] GRPC response: {"name":"rbd.csi.ceph.com","vendor_version":"v3.5.1"} I0418 22:20:26.859924 1 connection.go:187] GRPC error: I0418 22:20:26.859933 1 main.go:141] CSI driver name: "rbd.csi.ceph.com" I0418 22:20:26.859940 1 connection.go:183] GRPC call: /csi.v1.Identity/GetPluginCapabilities I0418 22:20:26.859943 1 connection.go:184] GRPC request: {} I0418 22:20:26.862929 1 connection.go:186] GRPC response: {"capabilities":[{"Type":{"Service":{"type":1}}},{"Type":{"VolumeExpansion":{"type":1}}},{"Type":{"Service":{"type":2}}}]} I0418 22:20:26.863154 1 connection.go:187] GRPC error: I0418 22:20:26.863172 1 connection.go:183] GRPC call: /csi.v1.Controller/ControllerGetCapabilities I0418 22:20:26.863175 1 connection.go:184] GRPC request: {} I0418 22:20:26.866059 1 connection.go:186] GRPC response: {"capabilities":[{"Type":{"Rpc":{"type":1}}},{"Type":{"Rpc":{"type":5}}},{"Type":{"Rpc":{"type":7}}},{"Type":{"Rpc":{"type":9}}}]} I0418 22:20:26.866264 1 connection.go:187] GRPC error: I0418 22:20:26.866283 1 connection.go:183] GRPC call: /csi.v1.Controller/ControllerGetCapabilities I0418 22:20:26.866288 1 connection.go:184] GRPC request: {} I0418 22:20:26.867099 1 connection.go:186] GRPC response: {"capabilities":[{"Type":{"Rpc":{"type":1}}},{"Type":{"Rpc":{"type":5}}},{"Type":{"Rpc":{"type":7}}},{"Type":{"Rpc":{"type":9}}}]} I0418 22:20:26.867157 1 connection.go:187] GRPC error: I0418 22:20:26.868524 1 leaderelection.go:248] attempting to acquire leader lease kube-system/external-resizer-rbd-csi-ceph-com... I0418 22:20:26.885665 1 leaderelection.go:258] successfully acquired lease kube-system/external-resizer-rbd-csi-ceph-com I0418 22:20:26.885982 1 leader_election.go:212] new leader detected, current leader: ceph-csi-rbd-provisioner-6f6497f79c-dxg27 I0418 22:20:26.886527 1 leader_election.go:205] became leader, starting I0418 22:20:26.886547 1 controller.go:251] Starting external resizer rbd.csi.ceph.com I0418 22:20:26.886830 1 reflector.go:219] Starting reflector *v1.PersistentVolume (10m0s) from k8s.io/client-go/informers/factory.go:134 I0418 22:20:26.886843 1 reflector.go:255] Listing and watching *v1.PersistentVolume from k8s.io/client-go/informers/factory.go:134 I0418 22:20:26.886951 1 reflector.go:219] Starting reflector *v1.PersistentVolumeClaim (10m0s) from k8s.io/client-go/informers/factory.go:134 I0418 22:20:26.886967 1 reflector.go:255] Listing and watching *v1.PersistentVolumeClaim from k8s.io/client-go/informers/factory.go:134 I0418 22:20:26.893420 1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com I0418 22:20:26.986771 1 shared_informer.go:270] caches populated I0418 22:20:32.017430 1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com I0418 22:20:37.026950 1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com I0418 22:20:42.037759 1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com I0418 22:20:47.043780 1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com I0418 22:20:52.052826 1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com I0418 22:20:57.061888 1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com I0418 22:21:02.069500 1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com I0418 22:21:07.078278 1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com I0418 22:21:12.085329 1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com I0418 22:21:17.095822 1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com I0418 22:21:22.107305 1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com I0418 22:21:27.128488 1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com I0418 22:21:32.138594 1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com I0418 22:21:37.147756 1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com I0418 22:21:42.157189 1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com I0418 22:21:47.165951 1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com I0418 22:21:52.177293 1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com I0418 22:21:57.189612 1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com I0418 22:22:02.199934 1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com I0418 22:22:07.208286 1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com I0418 22:22:12.219450 1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com I0418 22:22:17.289559 1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com I0418 22:22:22.298646 1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com I0418 22:22:27.460188 1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com I0418 22:22:32.469179 1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com I0418 22:22:37.479874 1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com I0418 22:22:42.490407 1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com I0418 22:22:47.507751 1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com I0418 22:22:52.517022 1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com I0418 22:22:57.524612 1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com I0418 22:23:02.534188 1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com I0418 22:23:07.554778 1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com I0418 22:23:12.563054 1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com I0418 22:23:17.575770 1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com I0418 22:23:22.587232 1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com I0418 22:23:27.595083 1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com I0418 22:23:32.604243 1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com I0418 22:23:35.800263 1 controller.go:291] Started PVC processing "default/test-pvc" W0418 22:23:35.800319 1 controller.go:318] PV "" bound to PVC default/test-pvc not found I0418 22:23:37.617239 1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com I0418 22:23:37.793178 1 controller.go:291] Started PVC processing "default/test-pvc" I0418 22:23:37.793218 1 controller.go:334] No need to resize PVC "default/test-pvc" I0418 22:23:42.630615 1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com I0418 22:23:47.641762 1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com I0418 22:23:52.650135 1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com I0418 22:23:57.664098 1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com I0418 22:24:02.671913 1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com I0418 22:24:07.684015 1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com I0418 22:24:12.692509 1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com I0418 22:24:17.700721 1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com I0418 22:24:22.708341 1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com I0418 22:24:27.718951 1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com