I0416 22:54:05.142251 1 main.go:93] Version : v1.3.0 I0416 22:54:05.142385 1 feature_gate.go:245] feature gates: &{map[]} I0416 22:54:05.144890 1 connection.go:154] Connecting to unix:///csi/csi-provisioner.sock W0416 22:54:15.145898 1 connection.go:173] Still connecting to unix:///csi/csi-provisioner.sock W0416 22:54:25.145674 1 connection.go:173] Still connecting to unix:///csi/csi-provisioner.sock W0416 22:54:35.145614 1 connection.go:173] Still connecting to unix:///csi/csi-provisioner.sock I0416 22:54:37.451264 1 common.go:111] Probing CSI driver for readiness I0416 22:54:37.451296 1 connection.go:183] GRPC call: /csi.v1.Identity/Probe I0416 22:54:37.451303 1 connection.go:184] GRPC request: {} I0416 22:54:37.457824 1 connection.go:186] GRPC response: {} I0416 22:54:37.457917 1 connection.go:187] GRPC error: I0416 22:54:37.457934 1 connection.go:183] GRPC call: /csi.v1.Identity/GetPluginInfo I0416 22:54:37.457939 1 connection.go:184] GRPC request: {} I0416 22:54:37.458585 1 connection.go:186] GRPC response: {"name":"rbd.csi.ceph.com","vendor_version":"v3.5.1"} I0416 22:54:37.458655 1 connection.go:187] GRPC error: I0416 22:54:37.458667 1 main.go:141] CSI driver name: "rbd.csi.ceph.com" I0416 22:54:37.458678 1 connection.go:183] GRPC call: /csi.v1.Identity/GetPluginCapabilities I0416 22:54:37.458683 1 connection.go:184] GRPC request: {} I0416 22:54:37.459668 1 connection.go:186] GRPC response: {"capabilities":[{"Type":{"Service":{"type":1}}},{"Type":{"VolumeExpansion":{"type":1}}},{"Type":{"Service":{"type":2}}}]} I0416 22:54:37.459930 1 connection.go:187] GRPC error: I0416 22:54:37.459957 1 connection.go:183] GRPC call: /csi.v1.Controller/ControllerGetCapabilities I0416 22:54:37.459974 1 connection.go:184] GRPC request: {} I0416 22:54:37.460867 1 connection.go:186] GRPC response: {"capabilities":[{"Type":{"Rpc":{"type":1}}},{"Type":{"Rpc":{"type":5}}},{"Type":{"Rpc":{"type":7}}},{"Type":{"Rpc":{"type":9}}}]} I0416 22:54:37.460995 1 connection.go:187] GRPC error: I0416 22:54:37.461005 1 connection.go:183] GRPC call: /csi.v1.Controller/ControllerGetCapabilities I0416 22:54:37.461010 1 connection.go:184] GRPC request: {} I0416 22:54:37.461543 1 connection.go:186] GRPC response: {"capabilities":[{"Type":{"Rpc":{"type":1}}},{"Type":{"Rpc":{"type":5}}},{"Type":{"Rpc":{"type":7}}},{"Type":{"Rpc":{"type":9}}}]} I0416 22:54:37.461630 1 connection.go:187] GRPC error: I0416 22:54:37.463452 1 leaderelection.go:248] attempting to acquire leader lease kube-system/external-resizer-rbd-csi-ceph-com... I0416 22:54:37.480079 1 leaderelection.go:258] successfully acquired lease kube-system/external-resizer-rbd-csi-ceph-com I0416 22:54:37.480126 1 leader_election.go:212] new leader detected, current leader: ceph-csi-rbd-provisioner-6f6497f79c-xq9kf I0416 22:54:37.480231 1 leader_election.go:205] became leader, starting I0416 22:54:37.480428 1 controller.go:251] Starting external resizer rbd.csi.ceph.com I0416 22:54:37.481720 1 reflector.go:219] Starting reflector *v1.PersistentVolumeClaim (10m0s) from k8s.io/client-go/informers/factory.go:134 I0416 22:54:37.481745 1 reflector.go:255] Listing and watching *v1.PersistentVolumeClaim from k8s.io/client-go/informers/factory.go:134 I0416 22:54:37.482382 1 reflector.go:219] Starting reflector *v1.PersistentVolume (10m0s) from k8s.io/client-go/informers/factory.go:134 I0416 22:54:37.482565 1 reflector.go:255] Listing and watching *v1.PersistentVolume from k8s.io/client-go/informers/factory.go:134 I0416 22:54:37.492528 1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com I0416 22:54:37.580600 1 shared_informer.go:270] caches populated I0416 22:54:42.500917 1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com I0416 22:54:47.512960 1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com I0416 22:54:52.523920 1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com I0416 22:54:57.534157 1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com I0416 22:55:02.546841 1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com I0416 22:55:07.557168 1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com I0416 22:55:12.565385 1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com I0416 22:55:17.577839 1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com I0416 22:55:22.589043 1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com I0416 22:55:27.759984 1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com I0416 22:55:32.779824 1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com I0416 22:55:37.795500 1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com I0416 22:55:42.804336 1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com I0416 22:55:47.817107 1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com I0416 22:55:52.828376 1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com I0416 22:55:57.835948 1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com I0416 22:56:02.846982 1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com I0416 22:56:07.855199 1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com I0416 22:56:12.864119 1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com I0416 22:56:17.874938 1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com I0416 22:56:22.886709 1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com I0416 22:56:27.899319 1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com I0416 22:56:32.906621 1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com I0416 22:56:37.916676 1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com I0416 22:56:42.926566 1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com I0416 22:56:47.935602 1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com I0416 22:56:52.990894 1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com I0416 22:56:57.996380 1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com I0416 22:57:03.004866 1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com I0416 22:57:08.012050 1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com I0416 22:57:13.017807 1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com I0416 22:57:18.024890 1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com I0416 22:57:23.035019 1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com I0416 22:57:28.041442 1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com I0416 22:57:33.048609 1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com I0416 22:57:38.061827 1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com I0416 22:57:40.232392 1 controller.go:291] Started PVC processing "default/test-pvc" W0416 22:57:40.232468 1 controller.go:318] PV "" bound to PVC default/test-pvc not found I0416 22:57:41.803744 1 controller.go:291] Started PVC processing "default/test-pvc" I0416 22:57:41.803773 1 controller.go:334] No need to resize PVC "default/test-pvc" I0416 22:57:43.071409 1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com I0416 22:57:48.083272 1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com I0416 22:57:53.094406 1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com I0416 22:57:58.103897 1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com I0416 22:58:03.112593 1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com I0416 22:58:08.121311 1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com I0416 22:58:13.131826 1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com I0416 22:58:18.138660 1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com I0416 22:58:23.149711 1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com I0416 22:58:28.157233 1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com I0416 22:58:33.165933 1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com