I0224 10:52:41.963868 1 main.go:92] Version: v3.4.0 I0224 10:52:41.964773 1 connection.go:154] Connecting to unix:///csi/csi-provisioner.sock I0224 10:52:42.966396 1 common.go:111] Probing CSI driver for readiness I0224 10:52:42.966425 1 connection.go:183] GRPC call: /csi.v1.Identity/Probe I0224 10:52:42.966434 1 connection.go:184] GRPC request: {} I0224 10:52:42.971229 1 connection.go:186] GRPC response: {} I0224 10:52:42.971337 1 connection.go:187] GRPC error: I0224 10:52:42.971351 1 connection.go:183] GRPC call: /csi.v1.Identity/GetPluginInfo I0224 10:52:42.971358 1 connection.go:184] GRPC request: {} I0224 10:52:42.973156 1 connection.go:186] GRPC response: {"name":"rbd.csi.ceph.com","vendor_version":"v3.5.1"} I0224 10:52:42.973274 1 connection.go:187] GRPC error: I0224 10:52:42.973289 1 main.go:148] CSI driver name: "rbd.csi.ceph.com" I0224 10:52:42.974218 1 connection.go:154] Connecting to unix:///csi/csi-provisioner.sock I0224 10:52:42.974768 1 common.go:111] Probing CSI driver for readiness I0224 10:52:42.974787 1 connection.go:183] GRPC call: /csi.v1.Identity/Probe I0224 10:52:42.974792 1 connection.go:184] GRPC request: {} I0224 10:52:42.975441 1 connection.go:186] GRPC response: {} I0224 10:52:42.975506 1 connection.go:187] GRPC error: I0224 10:52:42.975523 1 connection.go:183] GRPC call: /csi.v1.Identity/GetPluginCapabilities I0224 10:52:42.975533 1 connection.go:184] GRPC request: {} I0224 10:52:42.976477 1 connection.go:186] GRPC response: {"capabilities":[{"Type":{"Service":{"type":1}}},{"Type":{"VolumeExpansion":{"type":1}}},{"Type":{"Service":{"type":2}}}]} I0224 10:52:42.976612 1 connection.go:187] GRPC error: I0224 10:52:42.976619 1 connection.go:183] GRPC call: /csi.v1.Controller/ControllerGetCapabilities I0224 10:52:42.976626 1 connection.go:184] GRPC request: {} I0224 10:52:42.977259 1 connection.go:186] GRPC response: {"capabilities":[{"Type":{"Rpc":{"type":1}}},{"Type":{"Rpc":{"type":5}}},{"Type":{"Rpc":{"type":7}}},{"Type":{"Rpc":{"type":9}}}]} I0224 10:52:42.977456 1 connection.go:187] GRPC error: I0224 10:52:42.977485 1 main.go:226] CSI driver does not support ControllerPublishUnpublish, using trivial handler I0224 10:52:42.978257 1 leaderelection.go:248] attempting to acquire leader lease kube-system/external-attacher-leader-rbd-csi-ceph-com... I0224 10:52:42.989385 1 leaderelection.go:258] successfully acquired lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0224 10:52:42.989457 1 leader_election.go:212] new leader detected, current leader: ceph-csi-rbd-provisioner-5d8ff44fc9-cbxkf I0224 10:52:42.989517 1 leader_election.go:205] became leader, starting I0224 10:52:42.989540 1 controller.go:128] Starting CSI attacher I0224 10:52:42.989722 1 reflector.go:219] Starting reflector *v1.VolumeAttachment (10m0s) from k8s.io/client-go/informers/factory.go:134 I0224 10:52:42.989730 1 reflector.go:255] Listing and watching *v1.VolumeAttachment from k8s.io/client-go/informers/factory.go:134 I0224 10:52:42.989846 1 reflector.go:219] Starting reflector *v1.PersistentVolume (10m0s) from k8s.io/client-go/informers/factory.go:134 I0224 10:52:42.989859 1 reflector.go:255] Listing and watching *v1.PersistentVolume from k8s.io/client-go/informers/factory.go:134 I0224 10:52:42.999759 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0224 10:52:43.089880 1 shared_informer.go:270] caches populated I0224 10:52:48.009663 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0224 10:52:53.021635 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0224 10:52:58.051882 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0224 10:53:03.066746 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0224 10:53:08.076182 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0224 10:53:13.084813 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0224 10:53:18.095738 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0224 10:53:23.108250 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0224 10:53:28.116812 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0224 10:53:33.128584 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0224 10:53:38.139417 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0224 10:53:43.151398 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0224 10:53:48.162750 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0224 10:53:53.173094 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0224 10:53:58.183062 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0224 10:54:03.193393 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0224 10:54:08.203308 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0224 10:54:13.215478 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0224 10:54:18.224378 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0224 10:54:23.234114 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0224 10:54:28.244053 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0224 10:54:33.253618 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0224 10:54:38.267172 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0224 10:54:43.277119 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0224 10:54:48.286128 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0224 10:54:53.296797 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0224 10:54:58.307488 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0224 10:55:03.317674 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0224 10:55:08.327299 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0224 10:55:13.336812 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0224 10:55:18.349218 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0224 10:55:23.357543 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0224 10:55:28.367700 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0224 10:55:33.377009 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0224 10:55:38.386588 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0224 10:55:39.710881 1 controller.go:208] Started VA processing "csi-7ee28e982a626210f018a91c4570a2dc4e76a06c96eedf64a50c60c80281e897" I0224 10:55:39.710917 1 trivial_handler.go:53] Trivial sync[csi-7ee28e982a626210f018a91c4570a2dc4e76a06c96eedf64a50c60c80281e897] started I0224 10:55:39.710924 1 util.go:38] Marking as attached "csi-7ee28e982a626210f018a91c4570a2dc4e76a06c96eedf64a50c60c80281e897" I0224 10:55:39.717231 1 util.go:52] Marked as attached "csi-7ee28e982a626210f018a91c4570a2dc4e76a06c96eedf64a50c60c80281e897" I0224 10:55:39.717250 1 trivial_handler.go:61] Marked VolumeAttachment csi-7ee28e982a626210f018a91c4570a2dc4e76a06c96eedf64a50c60c80281e897 as attached I0224 10:55:39.717284 1 controller.go:208] Started VA processing "csi-7ee28e982a626210f018a91c4570a2dc4e76a06c96eedf64a50c60c80281e897" I0224 10:55:39.717292 1 trivial_handler.go:53] Trivial sync[csi-7ee28e982a626210f018a91c4570a2dc4e76a06c96eedf64a50c60c80281e897] started I0224 10:55:43.395440 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0224 10:55:48.406137 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0224 10:55:53.413371 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0224 10:55:58.425694 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0224 10:56:00.985287 1 controller.go:259] Started PV processing "pvc-e1729255-8bed-47dd-a376-84f9ce4a1bb7" I0224 10:56:03.433708 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0224 10:56:08.442521 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0224 10:56:13.459956 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0224 10:56:18.469016 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com