I0812 11:10:32.379742 1 main.go:92] Version: v3.4.0 I0812 11:10:32.380931 1 connection.go:154] Connecting to unix:///csi/csi-provisioner.sock I0812 11:10:33.381791 1 common.go:111] Probing CSI driver for readiness I0812 11:10:33.381821 1 connection.go:183] GRPC call: /csi.v1.Identity/Probe I0812 11:10:33.381828 1 connection.go:184] GRPC request: {} I0812 11:10:33.387084 1 connection.go:186] GRPC response: {} I0812 11:10:33.387148 1 connection.go:187] GRPC error: I0812 11:10:33.387158 1 connection.go:183] GRPC call: /csi.v1.Identity/GetPluginInfo I0812 11:10:33.387163 1 connection.go:184] GRPC request: {} I0812 11:10:33.387902 1 connection.go:186] GRPC response: {"name":"rbd.csi.ceph.com","vendor_version":"v3.5.1"} I0812 11:10:33.387978 1 connection.go:187] GRPC error: I0812 11:10:33.387990 1 main.go:148] CSI driver name: "rbd.csi.ceph.com" I0812 11:10:33.388906 1 connection.go:154] Connecting to unix:///csi/csi-provisioner.sock I0812 11:10:33.390002 1 common.go:111] Probing CSI driver for readiness I0812 11:10:33.390022 1 connection.go:183] GRPC call: /csi.v1.Identity/Probe I0812 11:10:33.390029 1 connection.go:184] GRPC request: {} I0812 11:10:33.391299 1 connection.go:186] GRPC response: {} I0812 11:10:33.391332 1 connection.go:187] GRPC error: I0812 11:10:33.391338 1 connection.go:183] GRPC call: /csi.v1.Identity/GetPluginCapabilities I0812 11:10:33.391342 1 connection.go:184] GRPC request: {} I0812 11:10:33.394148 1 connection.go:186] GRPC response: {"capabilities":[{"Type":{"Service":{"type":1}}},{"Type":{"VolumeExpansion":{"type":1}}},{"Type":{"Service":{"type":2}}}]} I0812 11:10:33.394286 1 connection.go:187] GRPC error: I0812 11:10:33.394293 1 connection.go:183] GRPC call: /csi.v1.Controller/ControllerGetCapabilities I0812 11:10:33.394296 1 connection.go:184] GRPC request: {} I0812 11:10:33.395422 1 connection.go:186] GRPC response: {"capabilities":[{"Type":{"Rpc":{"type":1}}},{"Type":{"Rpc":{"type":5}}},{"Type":{"Rpc":{"type":7}}},{"Type":{"Rpc":{"type":9}}}]} I0812 11:10:33.395548 1 connection.go:187] GRPC error: I0812 11:10:33.395561 1 main.go:226] CSI driver does not support ControllerPublishUnpublish, using trivial handler I0812 11:10:33.396051 1 leaderelection.go:248] attempting to acquire leader lease kube-system/external-attacher-leader-rbd-csi-ceph-com... I0812 11:10:33.406747 1 leaderelection.go:258] successfully acquired lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0812 11:10:33.407036 1 leader_election.go:205] became leader, starting I0812 11:10:33.407169 1 leader_election.go:212] new leader detected, current leader: ceph-csi-rbd-provisioner-6f6497f79c-nkbf8 I0812 11:10:33.407233 1 controller.go:128] Starting CSI attacher I0812 11:10:33.407596 1 reflector.go:219] Starting reflector *v1.VolumeAttachment (10m0s) from k8s.io/client-go/informers/factory.go:134 I0812 11:10:33.407632 1 reflector.go:255] Listing and watching *v1.VolumeAttachment from k8s.io/client-go/informers/factory.go:134 I0812 11:10:33.407630 1 reflector.go:219] Starting reflector *v1.PersistentVolume (10m0s) from k8s.io/client-go/informers/factory.go:134 I0812 11:10:33.407654 1 reflector.go:255] Listing and watching *v1.PersistentVolume from k8s.io/client-go/informers/factory.go:134 I0812 11:10:33.419248 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0812 11:10:33.508528 1 shared_informer.go:270] caches populated I0812 11:10:38.426944 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0812 11:10:43.437206 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0812 11:10:48.444616 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0812 11:10:53.452042 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0812 11:10:58.458562 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0812 11:11:03.465464 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0812 11:11:08.474984 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0812 11:11:13.484376 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0812 11:11:18.491333 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0812 11:11:23.498427 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0812 11:11:28.505637 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0812 11:11:33.513005 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0812 11:11:38.521801 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0812 11:11:43.530846 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0812 11:11:48.539528 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0812 11:11:53.550189 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0812 11:11:58.560182 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0812 11:12:03.567887 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0812 11:12:08.577192 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0812 11:12:13.589305 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0812 11:12:18.597213 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0812 11:12:23.606240 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0812 11:12:28.613971 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0812 11:12:33.622102 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0812 11:12:38.670686 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0812 11:12:43.678954 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0812 11:12:48.687799 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0812 11:12:53.695136 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0812 11:12:58.702231 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0812 11:13:03.710671 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0812 11:13:08.720244 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0812 11:13:12.203974 1 controller.go:208] Started VA processing "csi-d032e415bc6f40fde4adaf4f21d186c02d636f7949f967c02f6cb8742077487a" I0812 11:13:12.204007 1 trivial_handler.go:53] Trivial sync[csi-d032e415bc6f40fde4adaf4f21d186c02d636f7949f967c02f6cb8742077487a] started I0812 11:13:12.204015 1 util.go:38] Marking as attached "csi-d032e415bc6f40fde4adaf4f21d186c02d636f7949f967c02f6cb8742077487a" I0812 11:13:12.208667 1 util.go:52] Marked as attached "csi-d032e415bc6f40fde4adaf4f21d186c02d636f7949f967c02f6cb8742077487a" I0812 11:13:12.208683 1 trivial_handler.go:61] Marked VolumeAttachment csi-d032e415bc6f40fde4adaf4f21d186c02d636f7949f967c02f6cb8742077487a as attached I0812 11:13:12.208869 1 controller.go:208] Started VA processing "csi-d032e415bc6f40fde4adaf4f21d186c02d636f7949f967c02f6cb8742077487a" I0812 11:13:12.208899 1 trivial_handler.go:53] Trivial sync[csi-d032e415bc6f40fde4adaf4f21d186c02d636f7949f967c02f6cb8742077487a] started I0812 11:13:13.729030 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0812 11:13:18.738877 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0812 11:13:23.764414 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0812 11:13:28.773890 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0812 11:13:30.841832 1 controller.go:259] Started PV processing "pvc-18ff1ce0-2e2d-4213-8948-ee0394da38f5" I0812 11:13:33.781748 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0812 11:13:38.789660 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0812 11:13:43.798330 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0812 11:13:48.804364 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0812 11:13:53.808488 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0812 11:13:58.816860 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0812 11:14:03.824292 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0812 11:14:08.832409 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com