I0211 01:53:34.434175 1 main.go:92] Version: v3.4.0 I0211 01:53:34.434860 1 connection.go:154] Connecting to unix:///csi/csi-provisioner.sock I0211 01:53:35.436351 1 common.go:111] Probing CSI driver for readiness I0211 01:53:35.436809 1 connection.go:183] GRPC call: /csi.v1.Identity/Probe I0211 01:53:35.437008 1 connection.go:184] GRPC request: {} I0211 01:53:35.447305 1 connection.go:186] GRPC response: {} I0211 01:53:35.447520 1 connection.go:187] GRPC error: I0211 01:53:35.447599 1 connection.go:183] GRPC call: /csi.v1.Identity/GetPluginInfo I0211 01:53:35.447668 1 connection.go:184] GRPC request: {} I0211 01:53:35.450053 1 connection.go:186] GRPC response: {"name":"rbd.csi.ceph.com","vendor_version":"v3.5.1"} I0211 01:53:35.450295 1 connection.go:187] GRPC error: I0211 01:53:35.450374 1 main.go:148] CSI driver name: "rbd.csi.ceph.com" I0211 01:53:35.450962 1 connection.go:154] Connecting to unix:///csi/csi-provisioner.sock I0211 01:53:35.453080 1 common.go:111] Probing CSI driver for readiness I0211 01:53:35.453209 1 connection.go:183] GRPC call: /csi.v1.Identity/Probe I0211 01:53:35.453256 1 connection.go:184] GRPC request: {} I0211 01:53:35.453759 1 connection.go:186] GRPC response: {} I0211 01:53:35.453849 1 connection.go:187] GRPC error: I0211 01:53:35.453889 1 connection.go:183] GRPC call: /csi.v1.Identity/GetPluginCapabilities I0211 01:53:35.453920 1 connection.go:184] GRPC request: {} I0211 01:53:35.454790 1 connection.go:186] GRPC response: {"capabilities":[{"Type":{"Service":{"type":1}}},{"Type":{"VolumeExpansion":{"type":1}}},{"Type":{"Service":{"type":2}}}]} I0211 01:53:35.455019 1 connection.go:187] GRPC error: I0211 01:53:35.455111 1 connection.go:183] GRPC call: /csi.v1.Controller/ControllerGetCapabilities I0211 01:53:35.455173 1 connection.go:184] GRPC request: {} I0211 01:53:35.456422 1 connection.go:186] GRPC response: {"capabilities":[{"Type":{"Rpc":{"type":1}}},{"Type":{"Rpc":{"type":5}}},{"Type":{"Rpc":{"type":7}}},{"Type":{"Rpc":{"type":9}}}]} I0211 01:53:35.456550 1 connection.go:187] GRPC error: I0211 01:53:35.456606 1 main.go:226] CSI driver does not support ControllerPublishUnpublish, using trivial handler I0211 01:53:35.457903 1 leaderelection.go:248] attempting to acquire leader lease kube-system/external-attacher-leader-rbd-csi-ceph-com... I0211 01:53:35.476298 1 leaderelection.go:258] successfully acquired lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0211 01:53:35.476480 1 leader_election.go:212] new leader detected, current leader: ceph-csi-rbd-provisioner-5d8ff44fc9-hmnzp I0211 01:53:35.477485 1 leader_election.go:205] became leader, starting I0211 01:53:35.477553 1 controller.go:128] Starting CSI attacher I0211 01:53:35.477810 1 reflector.go:219] Starting reflector *v1.VolumeAttachment (10m0s) from k8s.io/client-go/informers/factory.go:134 I0211 01:53:35.478644 1 reflector.go:255] Listing and watching *v1.VolumeAttachment from k8s.io/client-go/informers/factory.go:134 I0211 01:53:35.478587 1 reflector.go:219] Starting reflector *v1.PersistentVolume (10m0s) from k8s.io/client-go/informers/factory.go:134 I0211 01:53:35.479043 1 reflector.go:255] Listing and watching *v1.PersistentVolume from k8s.io/client-go/informers/factory.go:134 I0211 01:53:35.488885 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0211 01:53:35.579337 1 shared_informer.go:270] caches populated I0211 01:53:40.496675 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0211 01:53:45.502625 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0211 01:53:50.515716 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0211 01:53:55.525574 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0211 01:54:00.539089 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0211 01:54:05.584875 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0211 01:54:10.593070 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0211 01:54:15.599763 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0211 01:54:20.609147 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0211 01:54:25.616753 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0211 01:54:30.622935 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0211 01:54:35.631514 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0211 01:54:40.639937 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0211 01:54:45.649421 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0211 01:54:50.657492 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0211 01:54:55.666844 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0211 01:55:00.706978 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0211 01:55:05.722748 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0211 01:55:10.733035 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0211 01:55:15.744630 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0211 01:55:20.751308 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0211 01:55:25.759679 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0211 01:55:30.766571 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0211 01:55:35.775204 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0211 01:55:40.784333 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0211 01:55:45.793858 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0211 01:55:50.802665 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0211 01:55:55.811864 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0211 01:56:00.820911 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0211 01:56:05.833732 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0211 01:56:10.840989 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0211 01:56:15.849543 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0211 01:56:20.861291 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0211 01:56:25.870457 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0211 01:56:27.390608 1 controller.go:208] Started VA processing "csi-2ee033dc2e81eed9121a20094c9ad792ac2eea86183029a94344cd0f22e6450e" I0211 01:56:27.390636 1 trivial_handler.go:53] Trivial sync[csi-2ee033dc2e81eed9121a20094c9ad792ac2eea86183029a94344cd0f22e6450e] started I0211 01:56:27.390641 1 util.go:38] Marking as attached "csi-2ee033dc2e81eed9121a20094c9ad792ac2eea86183029a94344cd0f22e6450e" I0211 01:56:27.395749 1 util.go:52] Marked as attached "csi-2ee033dc2e81eed9121a20094c9ad792ac2eea86183029a94344cd0f22e6450e" I0211 01:56:27.395765 1 trivial_handler.go:61] Marked VolumeAttachment csi-2ee033dc2e81eed9121a20094c9ad792ac2eea86183029a94344cd0f22e6450e as attached I0211 01:56:27.396044 1 controller.go:208] Started VA processing "csi-2ee033dc2e81eed9121a20094c9ad792ac2eea86183029a94344cd0f22e6450e" I0211 01:56:27.396127 1 trivial_handler.go:53] Trivial sync[csi-2ee033dc2e81eed9121a20094c9ad792ac2eea86183029a94344cd0f22e6450e] started I0211 01:56:30.881159 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0211 01:56:35.887627 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0211 01:56:40.894088 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0211 01:56:45.900322 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0211 01:56:50.907501 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0211 01:56:51.975913 1 controller.go:259] Started PV processing "pvc-e079fc97-c634-4d95-9635-17e8f6dc5cc9" I0211 01:56:55.913777 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0211 01:57:00.976248 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0211 01:57:05.981685 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0211 01:57:10.987839 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0211 01:57:15.994125 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com