I0714 17:52:24.464897 1 main.go:92] Version: v3.4.0 I0714 17:52:24.466603 1 connection.go:154] Connecting to unix:///csi/csi-provisioner.sock I0714 17:52:25.468371 1 common.go:111] Probing CSI driver for readiness I0714 17:52:25.468404 1 connection.go:183] GRPC call: /csi.v1.Identity/Probe I0714 17:52:25.468408 1 connection.go:184] GRPC request: {} I0714 17:52:25.470641 1 connection.go:186] GRPC response: {} I0714 17:52:25.470696 1 connection.go:187] GRPC error: I0714 17:52:25.470704 1 connection.go:183] GRPC call: /csi.v1.Identity/GetPluginInfo I0714 17:52:25.470707 1 connection.go:184] GRPC request: {} I0714 17:52:25.471107 1 connection.go:186] GRPC response: {"name":"rbd.csi.ceph.com","vendor_version":"v3.5.1"} I0714 17:52:25.471155 1 connection.go:187] GRPC error: I0714 17:52:25.471162 1 main.go:148] CSI driver name: "rbd.csi.ceph.com" I0714 17:52:25.471716 1 connection.go:154] Connecting to unix:///csi/csi-provisioner.sock I0714 17:52:25.472605 1 common.go:111] Probing CSI driver for readiness I0714 17:52:25.472626 1 connection.go:183] GRPC call: /csi.v1.Identity/Probe I0714 17:52:25.472631 1 connection.go:184] GRPC request: {} I0714 17:52:25.473847 1 connection.go:186] GRPC response: {} I0714 17:52:25.473882 1 connection.go:187] GRPC error: I0714 17:52:25.473890 1 connection.go:183] GRPC call: /csi.v1.Identity/GetPluginCapabilities I0714 17:52:25.473893 1 connection.go:184] GRPC request: {} I0714 17:52:25.474719 1 connection.go:186] GRPC response: {"capabilities":[{"Type":{"Service":{"type":1}}},{"Type":{"VolumeExpansion":{"type":1}}},{"Type":{"Service":{"type":2}}}]} I0714 17:52:25.474909 1 connection.go:187] GRPC error: I0714 17:52:25.474916 1 connection.go:183] GRPC call: /csi.v1.Controller/ControllerGetCapabilities I0714 17:52:25.474920 1 connection.go:184] GRPC request: {} I0714 17:52:25.475545 1 connection.go:186] GRPC response: {"capabilities":[{"Type":{"Rpc":{"type":1}}},{"Type":{"Rpc":{"type":5}}},{"Type":{"Rpc":{"type":7}}},{"Type":{"Rpc":{"type":9}}}]} I0714 17:52:25.475658 1 connection.go:187] GRPC error: I0714 17:52:25.475671 1 main.go:226] CSI driver does not support ControllerPublishUnpublish, using trivial handler I0714 17:52:25.476367 1 leaderelection.go:248] attempting to acquire leader lease kube-system/external-attacher-leader-rbd-csi-ceph-com... I0714 17:52:25.489789 1 leaderelection.go:258] successfully acquired lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0714 17:52:25.489956 1 leader_election.go:212] new leader detected, current leader: ceph-csi-rbd-provisioner-6f6497f79c-8ftzl I0714 17:52:25.489974 1 leader_election.go:205] became leader, starting I0714 17:52:25.489984 1 controller.go:128] Starting CSI attacher I0714 17:52:25.490180 1 reflector.go:219] Starting reflector *v1.VolumeAttachment (10m0s) from k8s.io/client-go/informers/factory.go:134 I0714 17:52:25.490193 1 reflector.go:255] Listing and watching *v1.VolumeAttachment from k8s.io/client-go/informers/factory.go:134 I0714 17:52:25.490214 1 reflector.go:219] Starting reflector *v1.PersistentVolume (10m0s) from k8s.io/client-go/informers/factory.go:134 I0714 17:52:25.490242 1 reflector.go:255] Listing and watching *v1.PersistentVolume from k8s.io/client-go/informers/factory.go:134 I0714 17:52:25.497324 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0714 17:52:25.590716 1 shared_informer.go:270] caches populated I0714 17:52:30.506859 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0714 17:52:35.514049 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0714 17:52:40.524378 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0714 17:52:45.537123 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0714 17:52:50.546335 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0714 17:52:55.555030 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0714 17:53:00.563583 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0714 17:53:05.574329 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0714 17:53:10.581864 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0714 17:53:15.590354 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0714 17:53:20.598991 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0714 17:53:25.607518 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0714 17:53:30.620816 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0714 17:53:35.628882 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0714 17:53:40.635954 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0714 17:53:45.646518 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0714 17:53:50.653925 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0714 17:53:55.661815 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0714 17:54:00.671720 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0714 17:54:05.681108 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0714 17:54:10.689843 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0714 17:54:15.698413 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0714 17:54:20.709086 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0714 17:54:25.717894 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0714 17:54:30.727623 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0714 17:54:35.735323 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0714 17:54:40.748151 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0714 17:54:45.755374 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0714 17:54:50.767650 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0714 17:54:55.775891 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0714 17:55:00.784824 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0714 17:55:05.795218 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0714 17:55:10.802241 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0714 17:55:15.811225 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0714 17:55:20.824414 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0714 17:55:25.834101 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0714 17:55:30.844737 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0714 17:55:35.852067 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0714 17:55:40.860229 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0714 17:55:45.870044 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0714 17:55:50.878632 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0714 17:55:55.886997 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0714 17:56:00.896407 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0714 17:56:05.901922 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0714 17:56:10.911049 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0714 17:56:15.920730 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0714 17:56:20.929075 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0714 17:56:25.944845 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0714 17:56:30.952539 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0714 17:56:35.962829 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0714 17:56:39.677644 1 controller.go:208] Started VA processing "csi-c964c5ed946a48a40d7224be355c50828db18b623071a64d285473a8bd78a1f5" I0714 17:56:39.677677 1 trivial_handler.go:53] Trivial sync[csi-c964c5ed946a48a40d7224be355c50828db18b623071a64d285473a8bd78a1f5] started I0714 17:56:39.677685 1 util.go:38] Marking as attached "csi-c964c5ed946a48a40d7224be355c50828db18b623071a64d285473a8bd78a1f5" I0714 17:56:39.683189 1 util.go:52] Marked as attached "csi-c964c5ed946a48a40d7224be355c50828db18b623071a64d285473a8bd78a1f5" I0714 17:56:39.683221 1 trivial_handler.go:61] Marked VolumeAttachment csi-c964c5ed946a48a40d7224be355c50828db18b623071a64d285473a8bd78a1f5 as attached I0714 17:56:39.683250 1 controller.go:208] Started VA processing "csi-c964c5ed946a48a40d7224be355c50828db18b623071a64d285473a8bd78a1f5" I0714 17:56:39.683260 1 trivial_handler.go:53] Trivial sync[csi-c964c5ed946a48a40d7224be355c50828db18b623071a64d285473a8bd78a1f5] started I0714 17:56:40.970983 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0714 17:56:45.980235 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0714 17:56:50.989443 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0714 17:56:55.997459 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0714 17:57:00.324472 1 controller.go:259] Started PV processing "pvc-5c3d8493-8aeb-4a42-a648-814c7323625f" I0714 17:57:01.005159 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0714 17:57:06.012000 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0714 17:57:11.022047 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0714 17:57:16.029482 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0714 17:57:21.037979 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com