I0309 01:41:40.512015 1 main.go:92] Version: v3.4.0 I0309 01:41:40.513482 1 connection.go:154] Connecting to unix:///csi/csi-provisioner.sock I0309 01:41:41.514669 1 common.go:111] Probing CSI driver for readiness I0309 01:41:41.514706 1 connection.go:183] GRPC call: /csi.v1.Identity/Probe I0309 01:41:41.514726 1 connection.go:184] GRPC request: {} I0309 01:41:41.520280 1 connection.go:186] GRPC response: {} I0309 01:41:41.520449 1 connection.go:187] GRPC error: I0309 01:41:41.520513 1 connection.go:183] GRPC call: /csi.v1.Identity/GetPluginInfo I0309 01:41:41.520521 1 connection.go:184] GRPC request: {} I0309 01:41:41.522618 1 connection.go:186] GRPC response: {"name":"rbd.csi.ceph.com","vendor_version":"v3.5.1"} I0309 01:41:41.522862 1 connection.go:187] GRPC error: I0309 01:41:41.522884 1 main.go:148] CSI driver name: "rbd.csi.ceph.com" I0309 01:41:41.523882 1 connection.go:154] Connecting to unix:///csi/csi-provisioner.sock I0309 01:41:41.524395 1 common.go:111] Probing CSI driver for readiness I0309 01:41:41.524412 1 connection.go:183] GRPC call: /csi.v1.Identity/Probe I0309 01:41:41.524419 1 connection.go:184] GRPC request: {} I0309 01:41:41.526926 1 connection.go:186] GRPC response: {} I0309 01:41:41.526981 1 connection.go:187] GRPC error: I0309 01:41:41.526991 1 connection.go:183] GRPC call: /csi.v1.Identity/GetPluginCapabilities I0309 01:41:41.526998 1 connection.go:184] GRPC request: {} I0309 01:41:41.529107 1 connection.go:186] GRPC response: {"capabilities":[{"Type":{"Service":{"type":1}}},{"Type":{"VolumeExpansion":{"type":1}}},{"Type":{"Service":{"type":2}}}]} I0309 01:41:41.529939 1 connection.go:187] GRPC error: I0309 01:41:41.530058 1 connection.go:183] GRPC call: /csi.v1.Controller/ControllerGetCapabilities I0309 01:41:41.530076 1 connection.go:184] GRPC request: {} I0309 01:41:41.532224 1 connection.go:186] GRPC response: {"capabilities":[{"Type":{"Rpc":{"type":1}}},{"Type":{"Rpc":{"type":5}}},{"Type":{"Rpc":{"type":7}}},{"Type":{"Rpc":{"type":9}}}]} I0309 01:41:41.532343 1 connection.go:187] GRPC error: I0309 01:41:41.532357 1 main.go:226] CSI driver does not support ControllerPublishUnpublish, using trivial handler I0309 01:41:41.532918 1 leaderelection.go:248] attempting to acquire leader lease kube-system/external-attacher-leader-rbd-csi-ceph-com... I0309 01:41:41.556814 1 leaderelection.go:258] successfully acquired lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0309 01:41:41.556985 1 leader_election.go:212] new leader detected, current leader: ceph-csi-rbd-provisioner-6f6497f79c-6pmwr I0309 01:41:41.557020 1 leader_election.go:205] became leader, starting I0309 01:41:41.557043 1 controller.go:128] Starting CSI attacher I0309 01:41:41.558303 1 reflector.go:219] Starting reflector *v1.PersistentVolume (10m0s) from k8s.io/client-go/informers/factory.go:134 I0309 01:41:41.558325 1 reflector.go:255] Listing and watching *v1.PersistentVolume from k8s.io/client-go/informers/factory.go:134 I0309 01:41:41.558389 1 reflector.go:219] Starting reflector *v1.VolumeAttachment (10m0s) from k8s.io/client-go/informers/factory.go:134 I0309 01:41:41.558428 1 reflector.go:255] Listing and watching *v1.VolumeAttachment from k8s.io/client-go/informers/factory.go:134 I0309 01:41:41.641920 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0309 01:41:41.658071 1 shared_informer.go:270] caches populated I0309 01:41:46.650347 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0309 01:41:51.658719 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0309 01:41:56.667316 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0309 01:42:01.675064 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0309 01:42:06.684912 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0309 01:42:11.693547 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0309 01:42:16.702500 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0309 01:42:21.714767 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0309 01:42:26.723167 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0309 01:42:31.731890 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0309 01:42:36.748189 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0309 01:42:41.757701 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0309 01:42:46.765638 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0309 01:42:51.773819 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0309 01:42:56.783772 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0309 01:43:01.791629 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0309 01:43:06.799620 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0309 01:43:11.808931 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0309 01:43:16.817207 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0309 01:43:21.824565 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0309 01:43:26.832940 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0309 01:43:31.841011 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0309 01:43:36.850450 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0309 01:43:41.858864 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0309 01:43:46.871651 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0309 01:43:51.878657 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0309 01:43:56.889635 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0309 01:44:01.901244 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0309 01:44:06.909558 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0309 01:44:11.916954 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0309 01:44:16.925860 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0309 01:44:21.935080 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0309 01:44:26.947103 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0309 01:44:31.956548 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0309 01:44:34.903131 1 controller.go:208] Started VA processing "csi-38489a32936dcb0fcf1bf819d1550a917f800b40de414c5896dfeefb230194b5" I0309 01:44:34.903158 1 trivial_handler.go:53] Trivial sync[csi-38489a32936dcb0fcf1bf819d1550a917f800b40de414c5896dfeefb230194b5] started I0309 01:44:34.903163 1 util.go:38] Marking as attached "csi-38489a32936dcb0fcf1bf819d1550a917f800b40de414c5896dfeefb230194b5" I0309 01:44:34.908026 1 util.go:52] Marked as attached "csi-38489a32936dcb0fcf1bf819d1550a917f800b40de414c5896dfeefb230194b5" I0309 01:44:34.908048 1 trivial_handler.go:61] Marked VolumeAttachment csi-38489a32936dcb0fcf1bf819d1550a917f800b40de414c5896dfeefb230194b5 as attached I0309 01:44:34.908128 1 controller.go:208] Started VA processing "csi-38489a32936dcb0fcf1bf819d1550a917f800b40de414c5896dfeefb230194b5" I0309 01:44:34.908143 1 trivial_handler.go:53] Trivial sync[csi-38489a32936dcb0fcf1bf819d1550a917f800b40de414c5896dfeefb230194b5] started I0309 01:44:36.964198 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0309 01:44:41.972414 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0309 01:44:46.981049 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0309 01:44:48.007939 1 controller.go:259] Started PV processing "pvc-40bfd2f7-fefb-48ee-b679-350c09eeff85" I0309 01:44:51.988708 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0309 01:44:56.995219 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0309 01:45:02.005657 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0309 01:45:07.017951 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0309 01:45:12.025257 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com