I0810 22:34:40.707391 1 main.go:92] Version: v3.4.0 I0810 22:34:40.709126 1 connection.go:154] Connecting to unix:///csi/csi-provisioner.sock I0810 22:34:41.710546 1 common.go:111] Probing CSI driver for readiness I0810 22:34:41.710579 1 connection.go:183] GRPC call: /csi.v1.Identity/Probe I0810 22:34:41.710588 1 connection.go:184] GRPC request: {} I0810 22:34:41.717376 1 connection.go:186] GRPC response: {} I0810 22:34:41.717506 1 connection.go:187] GRPC error: I0810 22:34:41.717527 1 connection.go:183] GRPC call: /csi.v1.Identity/GetPluginInfo I0810 22:34:41.717548 1 connection.go:184] GRPC request: {} I0810 22:34:41.718015 1 connection.go:186] GRPC response: {"name":"rbd.csi.ceph.com","vendor_version":"v3.5.1"} I0810 22:34:41.718068 1 connection.go:187] GRPC error: I0810 22:34:41.718085 1 main.go:148] CSI driver name: "rbd.csi.ceph.com" I0810 22:34:41.718557 1 connection.go:154] Connecting to unix:///csi/csi-provisioner.sock I0810 22:34:41.719034 1 common.go:111] Probing CSI driver for readiness I0810 22:34:41.719052 1 connection.go:183] GRPC call: /csi.v1.Identity/Probe I0810 22:34:41.719058 1 connection.go:184] GRPC request: {} I0810 22:34:41.719746 1 connection.go:186] GRPC response: {} I0810 22:34:41.719788 1 connection.go:187] GRPC error: I0810 22:34:41.719800 1 connection.go:183] GRPC call: /csi.v1.Identity/GetPluginCapabilities I0810 22:34:41.719808 1 connection.go:184] GRPC request: {} I0810 22:34:41.720413 1 connection.go:186] GRPC response: {"capabilities":[{"Type":{"Service":{"type":1}}},{"Type":{"VolumeExpansion":{"type":1}}},{"Type":{"Service":{"type":2}}}]} I0810 22:34:41.720559 1 connection.go:187] GRPC error: I0810 22:34:41.720607 1 connection.go:183] GRPC call: /csi.v1.Controller/ControllerGetCapabilities I0810 22:34:41.720638 1 connection.go:184] GRPC request: {} I0810 22:34:41.721316 1 connection.go:186] GRPC response: {"capabilities":[{"Type":{"Rpc":{"type":1}}},{"Type":{"Rpc":{"type":5}}},{"Type":{"Rpc":{"type":7}}},{"Type":{"Rpc":{"type":9}}}]} I0810 22:34:41.721455 1 connection.go:187] GRPC error: I0810 22:34:41.721469 1 main.go:226] CSI driver does not support ControllerPublishUnpublish, using trivial handler I0810 22:34:41.722166 1 leaderelection.go:248] attempting to acquire leader lease kube-system/external-attacher-leader-rbd-csi-ceph-com... I0810 22:34:41.733817 1 leaderelection.go:258] successfully acquired lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0810 22:34:41.734063 1 leader_election.go:205] became leader, starting I0810 22:34:41.734121 1 leader_election.go:212] new leader detected, current leader: ceph-csi-rbd-provisioner-6f6497f79c-k65k4 I0810 22:34:41.734283 1 controller.go:128] Starting CSI attacher I0810 22:34:41.734480 1 reflector.go:219] Starting reflector *v1.PersistentVolume (10m0s) from k8s.io/client-go/informers/factory.go:134 I0810 22:34:41.734493 1 reflector.go:255] Listing and watching *v1.PersistentVolume from k8s.io/client-go/informers/factory.go:134 I0810 22:34:41.734564 1 reflector.go:219] Starting reflector *v1.VolumeAttachment (10m0s) from k8s.io/client-go/informers/factory.go:134 I0810 22:34:41.734577 1 reflector.go:255] Listing and watching *v1.VolumeAttachment from k8s.io/client-go/informers/factory.go:134 I0810 22:34:41.742236 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0810 22:34:41.835435 1 shared_informer.go:270] caches populated I0810 22:34:46.776152 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0810 22:34:51.792034 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0810 22:34:56.802331 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0810 22:35:01.811637 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0810 22:35:06.820603 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0810 22:35:11.829140 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0810 22:35:16.838919 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0810 22:35:21.846561 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0810 22:35:26.855518 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0810 22:35:31.866303 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0810 22:35:36.873974 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0810 22:35:41.884396 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0810 22:35:46.895646 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0810 22:35:51.904249 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0810 22:35:56.911967 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0810 22:36:01.921025 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0810 22:36:06.929581 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0810 22:36:11.938835 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0810 22:36:16.948757 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0810 22:36:21.956945 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0810 22:36:26.967761 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0810 22:36:31.975744 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0810 22:36:36.985367 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0810 22:36:41.993126 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0810 22:36:47.003992 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0810 22:36:52.014674 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0810 22:36:57.023800 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0810 22:37:02.031776 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0810 22:37:07.041373 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0810 22:37:12.047671 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0810 22:37:17.056962 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0810 22:37:22.065989 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0810 22:37:27.075375 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0810 22:37:29.661928 1 controller.go:208] Started VA processing "csi-48c287f41a7e72133d3db1f404ff25a1adc6f556cc1764cfa06da6588998c9db" I0810 22:37:29.661952 1 trivial_handler.go:53] Trivial sync[csi-48c287f41a7e72133d3db1f404ff25a1adc6f556cc1764cfa06da6588998c9db] started I0810 22:37:29.661956 1 util.go:38] Marking as attached "csi-48c287f41a7e72133d3db1f404ff25a1adc6f556cc1764cfa06da6588998c9db" I0810 22:37:29.666903 1 util.go:52] Marked as attached "csi-48c287f41a7e72133d3db1f404ff25a1adc6f556cc1764cfa06da6588998c9db" I0810 22:37:29.666926 1 trivial_handler.go:61] Marked VolumeAttachment csi-48c287f41a7e72133d3db1f404ff25a1adc6f556cc1764cfa06da6588998c9db as attached I0810 22:37:29.666973 1 controller.go:208] Started VA processing "csi-48c287f41a7e72133d3db1f404ff25a1adc6f556cc1764cfa06da6588998c9db" I0810 22:37:29.666985 1 trivial_handler.go:53] Trivial sync[csi-48c287f41a7e72133d3db1f404ff25a1adc6f556cc1764cfa06da6588998c9db] started I0810 22:37:32.083934 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0810 22:37:37.092196 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0810 22:37:42.100654 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0810 22:37:47.108015 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0810 22:37:51.519223 1 controller.go:259] Started PV processing "pvc-e12de772-516a-46d6-94d5-35bbfccb6e82" I0810 22:37:52.116282 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0810 22:37:57.123722 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0810 22:38:02.130851 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0810 22:38:07.139423 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com I0810 22:38:12.148275 1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com