I0212 02:15:13.439572 1 main.go:92] Version: v3.4.0 I0212 02:15:13.440623 1 connection.go:154] Connecting to unix:///csi/csi-provisioner.sock I0212 02:15:14.442570 1 common.go:111] Probing CSI driver for readiness I0212 02:15:14.442703 1 connection.go:183] GRPC call: /csi.v1.Identity/Probe I0212 02:15:14.442782 1 connection.go:184] GRPC request: {} I0212 02:15:14.447795 1 connection.go:186] GRPC response: {} I0212 02:15:14.447956 1 connection.go:187] GRPC error: I0212 02:15:14.448029 1 connection.go:183] GRPC call: /csi.v1.Identity/GetPluginInfo I0212 02:15:14.448072 1 connection.go:184] GRPC request: {} I0212 02:15:14.449108 1 connection.go:186] GRPC response: {"name":"rbd.csi.ceph.com","vendor_version":"v3.5.1"} I0212 02:15:14.449238 1 connection.go:187] GRPC error: I0212 02:15:14.449276 1 main.go:148] CSI driver name: "rbd.csi.ceph.com" I0212 02:15:14.450261 1 connection.go:154] Connecting to unix:///csi/csi-provisioner.sock I0212 02:15:14.450997 1 common.go:111] Probing CSI driver for readiness I0212 02:15:14.451016 1 connection.go:183] GRPC call: /csi.v1.Identity/Probe I0212 02:15:14.451120 1 connection.go:184] GRPC request: {} I0212 02:15:14.451733 1 connection.go:186] GRPC response: {} I0212 02:15:14.451776 1 connection.go:187] GRPC error: I0212 02:15:14.451797 1 connection.go:183] GRPC call: /csi.v1.Identity/GetPluginCapabilities I0212 02:15:14.451809 1 connection.go:184] GRPC request: {} I0212 02:15:14.452682 1 connection.go:186] GRPC response: {"capabilities":[{"Type":{"Service":{"type":1}}},{"Type":{"VolumeExpansion":{"type":1}}},{"Type":{"Service":{"type":2}}}]} I0212 02:15:14.452803 1 connection.go:187] GRPC error: I0212 02:15:14.452818 1 connection.go:183] GRPC call: /csi.v1.Controller/ControllerGetCapabilities I0212 02:15:14.452835 1 connection.go:184] GRPC request: {} I0212 02:15:14.453675 1 connection.go:186] GRPC response: {"capabilities":[{"Type":{"Rpc":{"type":1}}},{"Type":{"Rpc":{"type":5}}},{"Type":{"Rpc":{"type":7}}},{"Type":{"Rpc":{"type":9}}}]} I0212 02:15:14.454204 1 connection.go:187] GRPC error: I0212 02:15:14.454332 1 main.go:226] CSI driver does not support ControllerPublishUnpublish, using trivial handler I0212 02:15:14.457138 1 leaderelection.go:248] attempting to acquire leader lease kube-system/external-attacher-leader-rbd-csi-ceph-com... I0212 02:15:14.466630 1 leaderelection.go:258] successfully acquired lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0212 02:15:14.466801 1 leader_election.go:205] became leader, starting I0212 02:15:14.466839 1 controller.go:128] Starting CSI attacher I0212 02:15:14.467304 1 reflector.go:219] Starting reflector *v1.VolumeAttachment (10m0s) from k8s.io/client-go/informers/factory.go:134 I0212 02:15:14.467340 1 reflector.go:255] Listing and watching *v1.VolumeAttachment from k8s.io/client-go/informers/factory.go:134 I0212 02:15:14.467947 1 leader_election.go:212] new leader detected, current leader: ceph-csi-rbd-provisioner-5d8ff44fc9-qt477 I0212 02:15:14.468210 1 reflector.go:219] Starting reflector *v1.PersistentVolume (10m0s) from k8s.io/client-go/informers/factory.go:134 I0212 02:15:14.468222 1 reflector.go:255] Listing and watching *v1.PersistentVolume from k8s.io/client-go/informers/factory.go:134 I0212 02:15:14.473086 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0212 02:15:14.567416 1 shared_informer.go:270] caches populated I0212 02:15:19.479433 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0212 02:15:24.488101 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0212 02:15:29.495951 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0212 02:15:34.559665 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0212 02:15:39.579655 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0212 02:15:44.590398 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0212 02:15:49.599593 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0212 02:15:54.608510 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0212 02:15:59.618085 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0212 02:16:04.628767 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0212 02:16:09.647817 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0212 02:16:14.656323 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0212 02:16:19.666436 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0212 02:16:24.673930 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0212 02:16:29.685104 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0212 02:16:34.694172 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0212 02:16:39.703577 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0212 02:16:44.711768 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0212 02:16:49.720152 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0212 02:16:54.727185 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0212 02:16:59.735486 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0212 02:17:04.742554 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0212 02:17:09.751486 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0212 02:17:14.759137 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0212 02:17:19.766247 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0212 02:17:24.774864 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0212 02:17:29.784011 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0212 02:17:34.790934 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0212 02:17:39.800614 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0212 02:17:44.809659 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0212 02:17:49.818508 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0212 02:17:54.827795 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0212 02:17:58.251680 1 controller.go:208] Started VA processing "csi-0b6c689b68ef9ba3e447530692210dffa0e7d01fa9b36822f5fd7039bf19b5ca" I0212 02:17:58.251707 1 trivial_handler.go:53] Trivial sync[csi-0b6c689b68ef9ba3e447530692210dffa0e7d01fa9b36822f5fd7039bf19b5ca] started I0212 02:17:58.251712 1 util.go:38] Marking as attached "csi-0b6c689b68ef9ba3e447530692210dffa0e7d01fa9b36822f5fd7039bf19b5ca" I0212 02:17:58.256902 1 util.go:52] Marked as attached "csi-0b6c689b68ef9ba3e447530692210dffa0e7d01fa9b36822f5fd7039bf19b5ca" I0212 02:17:58.256944 1 trivial_handler.go:61] Marked VolumeAttachment csi-0b6c689b68ef9ba3e447530692210dffa0e7d01fa9b36822f5fd7039bf19b5ca as attached I0212 02:17:58.257000 1 controller.go:208] Started VA processing "csi-0b6c689b68ef9ba3e447530692210dffa0e7d01fa9b36822f5fd7039bf19b5ca" I0212 02:17:58.257022 1 trivial_handler.go:53] Trivial sync[csi-0b6c689b68ef9ba3e447530692210dffa0e7d01fa9b36822f5fd7039bf19b5ca] started I0212 02:17:59.837773 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0212 02:18:04.847385 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0212 02:18:09.874521 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0212 02:18:14.889482 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0212 02:18:17.506838 1 controller.go:259] Started PV processing "pvc-cd2b492d-175b-4952-835e-0d14f5067e7e" I0212 02:18:19.896182 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0212 02:18:24.946516 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0212 02:18:29.954053 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0212 02:18:34.960630 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0212 02:18:39.965983 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0212 02:18:45.055757 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0212 02:18:50.073101 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com