I0623 18:48:11.455013 1 main.go:92] Version: v3.4.0 I0623 18:48:11.455931 1 connection.go:154] Connecting to unix:///csi/csi-provisioner.sock I0623 18:48:12.457188 1 common.go:111] Probing CSI driver for readiness I0623 18:48:12.457232 1 connection.go:183] GRPC call: /csi.v1.Identity/Probe I0623 18:48:12.457241 1 connection.go:184] GRPC request: {} I0623 18:48:12.463117 1 connection.go:186] GRPC response: {} I0623 18:48:12.463268 1 connection.go:187] GRPC error: I0623 18:48:12.463283 1 connection.go:183] GRPC call: /csi.v1.Identity/GetPluginInfo I0623 18:48:12.463288 1 connection.go:184] GRPC request: {} I0623 18:48:12.464231 1 connection.go:186] GRPC response: {"name":"rbd.csi.ceph.com","vendor_version":"v3.5.1"} I0623 18:48:12.464304 1 connection.go:187] GRPC error: I0623 18:48:12.464316 1 main.go:148] CSI driver name: "rbd.csi.ceph.com" I0623 18:48:12.465155 1 connection.go:154] Connecting to unix:///csi/csi-provisioner.sock I0623 18:48:12.465642 1 common.go:111] Probing CSI driver for readiness I0623 18:48:12.465702 1 connection.go:183] GRPC call: /csi.v1.Identity/Probe I0623 18:48:12.465727 1 connection.go:184] GRPC request: {} I0623 18:48:12.466307 1 connection.go:186] GRPC response: {} I0623 18:48:12.466383 1 connection.go:187] GRPC error: I0623 18:48:12.466410 1 connection.go:183] GRPC call: /csi.v1.Identity/GetPluginCapabilities I0623 18:48:12.466432 1 connection.go:184] GRPC request: {} I0623 18:48:12.467142 1 connection.go:186] GRPC response: {"capabilities":[{"Type":{"Service":{"type":1}}},{"Type":{"VolumeExpansion":{"type":1}}},{"Type":{"Service":{"type":2}}}]} I0623 18:48:12.467265 1 connection.go:187] GRPC error: I0623 18:48:12.467270 1 connection.go:183] GRPC call: /csi.v1.Controller/ControllerGetCapabilities I0623 18:48:12.467273 1 connection.go:184] GRPC request: {} I0623 18:48:12.469564 1 connection.go:186] GRPC response: {"capabilities":[{"Type":{"Rpc":{"type":1}}},{"Type":{"Rpc":{"type":5}}},{"Type":{"Rpc":{"type":7}}},{"Type":{"Rpc":{"type":9}}}]} I0623 18:48:12.469640 1 connection.go:187] GRPC error: I0623 18:48:12.469649 1 main.go:226] CSI driver does not support ControllerPublishUnpublish, using trivial handler I0623 18:48:12.470006 1 leaderelection.go:248] attempting to acquire leader lease kube-system/external-attacher-leader-rbd-csi-ceph-com... I0623 18:48:12.493179 1 leaderelection.go:258] successfully acquired lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0623 18:48:12.493399 1 leader_election.go:212] new leader detected, current leader: ceph-csi-rbd-provisioner-6f6497f79c-pvcdq I0623 18:48:12.493892 1 leader_election.go:205] became leader, starting I0623 18:48:12.493913 1 controller.go:128] Starting CSI attacher I0623 18:48:12.494159 1 reflector.go:219] Starting reflector *v1.VolumeAttachment (10m0s) from k8s.io/client-go/informers/factory.go:134 I0623 18:48:12.494176 1 reflector.go:255] Listing and watching *v1.VolumeAttachment from k8s.io/client-go/informers/factory.go:134 I0623 18:48:12.494574 1 reflector.go:219] Starting reflector *v1.PersistentVolume (10m0s) from k8s.io/client-go/informers/factory.go:134 I0623 18:48:12.494593 1 reflector.go:255] Listing and watching *v1.PersistentVolume from k8s.io/client-go/informers/factory.go:134 I0623 18:48:12.505323 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0623 18:48:12.594591 1 shared_informer.go:270] caches populated I0623 18:48:17.515854 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0623 18:48:22.524632 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0623 18:48:27.534159 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0623 18:48:32.542511 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0623 18:48:37.554212 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0623 18:48:42.564745 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0623 18:48:47.572194 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0623 18:48:52.580309 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0623 18:48:57.588407 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0623 18:49:02.601377 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0623 18:49:07.610219 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0623 18:49:12.616039 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0623 18:49:17.625492 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0623 18:49:22.641304 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0623 18:49:27.654480 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0623 18:49:32.663009 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0623 18:49:37.672209 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0623 18:49:42.680392 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0623 18:49:47.689651 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0623 18:49:52.697684 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0623 18:49:57.705793 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0623 18:50:02.714303 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0623 18:50:07.726053 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0623 18:50:12.734749 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0623 18:50:17.744685 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0623 18:50:22.753672 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0623 18:50:27.762373 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0623 18:50:32.772051 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0623 18:50:37.780468 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0623 18:50:42.787901 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0623 18:50:47.797272 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0623 18:50:52.806024 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0623 18:50:57.813258 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0623 18:51:02.820979 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0623 18:51:07.833398 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0623 18:51:12.841393 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0623 18:51:17.854000 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0623 18:51:22.863503 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0623 18:51:27.872187 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0623 18:51:32.879743 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0623 18:51:37.888215 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0623 18:51:42.898996 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0623 18:51:47.907712 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0623 18:51:52.915110 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0623 18:51:56.527944 1 controller.go:208] Started VA processing "csi-26f99d26400859d82673a78eddf7c16befc491b96b7f12756d61b7744cfedceb" I0623 18:51:56.527986 1 trivial_handler.go:53] Trivial sync[csi-26f99d26400859d82673a78eddf7c16befc491b96b7f12756d61b7744cfedceb] started I0623 18:51:56.527993 1 util.go:38] Marking as attached "csi-26f99d26400859d82673a78eddf7c16befc491b96b7f12756d61b7744cfedceb" I0623 18:51:56.533173 1 util.go:52] Marked as attached "csi-26f99d26400859d82673a78eddf7c16befc491b96b7f12756d61b7744cfedceb" I0623 18:51:56.533191 1 trivial_handler.go:61] Marked VolumeAttachment csi-26f99d26400859d82673a78eddf7c16befc491b96b7f12756d61b7744cfedceb as attached I0623 18:51:56.533275 1 controller.go:208] Started VA processing "csi-26f99d26400859d82673a78eddf7c16befc491b96b7f12756d61b7744cfedceb" I0623 18:51:56.533301 1 trivial_handler.go:53] Trivial sync[csi-26f99d26400859d82673a78eddf7c16befc491b96b7f12756d61b7744cfedceb] started I0623 18:51:57.921653 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0623 18:52:02.928220 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0623 18:52:07.936776 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0623 18:52:12.945581 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0623 18:52:17.074255 1 controller.go:259] Started PV processing "pvc-209def2f-4096-4f5c-a322-603b8fc77527" I0623 18:52:17.955520 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0623 18:52:22.962672 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0623 18:52:27.974095 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0623 18:52:32.980907 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0623 18:52:37.988223 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com