I0314 01:35:04.141805 1 main.go:92] Version: v3.4.0 I0314 01:35:04.142890 1 connection.go:154] Connecting to unix:///csi/csi-provisioner.sock I0314 01:35:05.144004 1 common.go:111] Probing CSI driver for readiness I0314 01:35:05.144052 1 connection.go:183] GRPC call: /csi.v1.Identity/Probe I0314 01:35:05.144059 1 connection.go:184] GRPC request: {} I0314 01:35:05.150450 1 connection.go:186] GRPC response: {} I0314 01:35:05.150556 1 connection.go:187] GRPC error: I0314 01:35:05.150576 1 connection.go:183] GRPC call: /csi.v1.Identity/GetPluginInfo I0314 01:35:05.150580 1 connection.go:184] GRPC request: {} I0314 01:35:05.152687 1 connection.go:186] GRPC response: {"name":"rbd.csi.ceph.com","vendor_version":"v3.5.1"} I0314 01:35:05.152797 1 connection.go:187] GRPC error: I0314 01:35:05.152824 1 main.go:148] CSI driver name: "rbd.csi.ceph.com" I0314 01:35:05.153722 1 connection.go:154] Connecting to unix:///csi/csi-provisioner.sock I0314 01:35:05.154450 1 common.go:111] Probing CSI driver for readiness I0314 01:35:05.154522 1 connection.go:183] GRPC call: /csi.v1.Identity/Probe I0314 01:35:05.154562 1 connection.go:184] GRPC request: {} I0314 01:35:05.155257 1 connection.go:186] GRPC response: {} I0314 01:35:05.155307 1 connection.go:187] GRPC error: I0314 01:35:05.155318 1 connection.go:183] GRPC call: /csi.v1.Identity/GetPluginCapabilities I0314 01:35:05.155325 1 connection.go:184] GRPC request: {} I0314 01:35:05.156775 1 connection.go:186] GRPC response: {"capabilities":[{"Type":{"Service":{"type":1}}},{"Type":{"VolumeExpansion":{"type":1}}},{"Type":{"Service":{"type":2}}}]} I0314 01:35:05.156941 1 connection.go:187] GRPC error: I0314 01:35:05.156947 1 connection.go:183] GRPC call: /csi.v1.Controller/ControllerGetCapabilities I0314 01:35:05.156952 1 connection.go:184] GRPC request: {} I0314 01:35:05.158101 1 connection.go:186] GRPC response: {"capabilities":[{"Type":{"Rpc":{"type":1}}},{"Type":{"Rpc":{"type":5}}},{"Type":{"Rpc":{"type":7}}},{"Type":{"Rpc":{"type":9}}}]} I0314 01:35:05.158231 1 connection.go:187] GRPC error: I0314 01:35:05.158242 1 main.go:226] CSI driver does not support ControllerPublishUnpublish, using trivial handler I0314 01:35:05.159273 1 leaderelection.go:248] attempting to acquire leader lease kube-system/external-attacher-leader-rbd-csi-ceph-com... I0314 01:35:05.175369 1 leaderelection.go:258] successfully acquired lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0314 01:35:05.175638 1 leader_election.go:212] new leader detected, current leader: ceph-csi-rbd-provisioner-6f6497f79c-n5tql I0314 01:35:05.176381 1 leader_election.go:205] became leader, starting I0314 01:35:05.176407 1 controller.go:128] Starting CSI attacher I0314 01:35:05.176857 1 reflector.go:219] Starting reflector *v1.VolumeAttachment (10m0s) from k8s.io/client-go/informers/factory.go:134 I0314 01:35:05.176876 1 reflector.go:255] Listing and watching *v1.VolumeAttachment from k8s.io/client-go/informers/factory.go:134 I0314 01:35:05.176938 1 reflector.go:219] Starting reflector *v1.PersistentVolume (10m0s) from k8s.io/client-go/informers/factory.go:134 I0314 01:35:05.176954 1 reflector.go:255] Listing and watching *v1.PersistentVolume from k8s.io/client-go/informers/factory.go:134 I0314 01:35:05.186461 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0314 01:35:05.277068 1 shared_informer.go:270] caches populated I0314 01:35:10.199502 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0314 01:35:15.210328 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0314 01:35:20.218754 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0314 01:35:25.230213 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0314 01:35:30.239151 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0314 01:35:35.246034 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0314 01:35:40.257913 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0314 01:35:45.268951 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0314 01:35:50.278183 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0314 01:35:55.287089 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0314 01:36:00.297010 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0314 01:36:05.308222 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0314 01:36:10.320349 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0314 01:36:15.329073 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0314 01:36:20.336541 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0314 01:36:25.345425 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0314 01:36:30.354914 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0314 01:36:35.364311 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0314 01:36:40.372666 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0314 01:36:45.381734 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0314 01:36:50.393271 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0314 01:36:55.402158 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0314 01:37:00.411389 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0314 01:37:05.420744 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0314 01:37:10.429150 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0314 01:37:15.439621 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0314 01:37:20.449434 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0314 01:37:25.457599 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0314 01:37:30.465620 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0314 01:37:35.474983 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0314 01:37:40.485218 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0314 01:37:45.496111 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0314 01:37:50.504022 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0314 01:37:55.513337 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0314 01:38:00.525284 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0314 01:38:05.532337 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0314 01:38:09.713275 1 controller.go:208] Started VA processing "csi-e6422a3f2dcd0f17d0c5ec43f1e1d6231e7510cc6096ac2ece1d8ce25cc70719" I0314 01:38:09.713305 1 trivial_handler.go:53] Trivial sync[csi-e6422a3f2dcd0f17d0c5ec43f1e1d6231e7510cc6096ac2ece1d8ce25cc70719] started I0314 01:38:09.713311 1 util.go:38] Marking as attached "csi-e6422a3f2dcd0f17d0c5ec43f1e1d6231e7510cc6096ac2ece1d8ce25cc70719" I0314 01:38:09.718785 1 util.go:52] Marked as attached "csi-e6422a3f2dcd0f17d0c5ec43f1e1d6231e7510cc6096ac2ece1d8ce25cc70719" I0314 01:38:09.718872 1 trivial_handler.go:61] Marked VolumeAttachment csi-e6422a3f2dcd0f17d0c5ec43f1e1d6231e7510cc6096ac2ece1d8ce25cc70719 as attached I0314 01:38:09.718992 1 controller.go:208] Started VA processing "csi-e6422a3f2dcd0f17d0c5ec43f1e1d6231e7510cc6096ac2ece1d8ce25cc70719" I0314 01:38:09.719045 1 trivial_handler.go:53] Trivial sync[csi-e6422a3f2dcd0f17d0c5ec43f1e1d6231e7510cc6096ac2ece1d8ce25cc70719] started I0314 01:38:10.542400 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0314 01:38:15.552739 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0314 01:38:20.564016 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0314 01:38:20.595115 1 controller.go:259] Started PV processing "pvc-2882bd8a-322f-4af4-bbc0-20384cb19cf6" I0314 01:38:25.573953 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0314 01:38:30.587076 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0314 01:38:35.598897 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0314 01:38:40.607195 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0314 01:38:45.615239 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com