I0626 03:41:25.693184       1 main.go:92] Version: v3.4.0
I0626 03:41:25.694147       1 connection.go:154] Connecting to unix:///csi/csi-provisioner.sock
I0626 03:41:28.562509       1 common.go:111] Probing CSI driver for readiness
I0626 03:41:28.562548       1 connection.go:183] GRPC call: /csi.v1.Identity/Probe
I0626 03:41:28.562556       1 connection.go:184] GRPC request: {}
I0626 03:41:28.567704       1 connection.go:186] GRPC response: {}
I0626 03:41:28.567896       1 connection.go:187] GRPC error: <nil>
I0626 03:41:28.568895       1 connection.go:183] GRPC call: /csi.v1.Identity/GetPluginInfo
I0626 03:41:28.568939       1 connection.go:184] GRPC request: {}
I0626 03:41:28.571353       1 connection.go:186] GRPC response: {"name":"rbd.csi.ceph.com","vendor_version":"v3.5.1"}
I0626 03:41:28.571424       1 connection.go:187] GRPC error: <nil>
I0626 03:41:28.571435       1 main.go:148] CSI driver name: "rbd.csi.ceph.com"
I0626 03:41:28.572125       1 connection.go:154] Connecting to unix:///csi/csi-provisioner.sock
I0626 03:41:28.572727       1 common.go:111] Probing CSI driver for readiness
I0626 03:41:28.572756       1 connection.go:183] GRPC call: /csi.v1.Identity/Probe
I0626 03:41:28.572847       1 connection.go:184] GRPC request: {}
I0626 03:41:28.573494       1 connection.go:186] GRPC response: {}
I0626 03:41:28.573547       1 connection.go:187] GRPC error: <nil>
I0626 03:41:28.573554       1 connection.go:183] GRPC call: /csi.v1.Identity/GetPluginCapabilities
I0626 03:41:28.573559       1 connection.go:184] GRPC request: {}
I0626 03:41:28.574544       1 connection.go:186] GRPC response: {"capabilities":[{"Type":{"Service":{"type":1}}},{"Type":{"VolumeExpansion":{"type":1}}},{"Type":{"Service":{"type":2}}}]}
I0626 03:41:28.574741       1 connection.go:187] GRPC error: <nil>
I0626 03:41:28.574751       1 connection.go:183] GRPC call: /csi.v1.Controller/ControllerGetCapabilities
I0626 03:41:28.575044       1 connection.go:184] GRPC request: {}
I0626 03:41:28.576010       1 connection.go:186] GRPC response: {"capabilities":[{"Type":{"Rpc":{"type":1}}},{"Type":{"Rpc":{"type":5}}},{"Type":{"Rpc":{"type":7}}},{"Type":{"Rpc":{"type":9}}}]}
I0626 03:41:28.576226       1 connection.go:187] GRPC error: <nil>
I0626 03:41:28.576440       1 main.go:226] CSI driver does not support ControllerPublishUnpublish, using trivial handler
I0626 03:41:28.577247       1 leaderelection.go:248] attempting to acquire leader lease kube-system/external-attacher-leader-rbd-csi-ceph-com...
I0626 03:41:29.928065       1 leaderelection.go:258] successfully acquired lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0626 03:41:29.928834       1 leader_election.go:212] new leader detected, current leader: ceph-csi-rbd-provisioner-6f6497f79c-hkf7h
I0626 03:41:29.929806       1 leader_election.go:205] became leader, starting
I0626 03:41:29.929855       1 controller.go:128] Starting CSI attacher
I0626 03:41:29.930123       1 reflector.go:219] Starting reflector *v1.VolumeAttachment (10m0s) from k8s.io/client-go/informers/factory.go:134
I0626 03:41:29.930143       1 reflector.go:255] Listing and watching *v1.VolumeAttachment from k8s.io/client-go/informers/factory.go:134
I0626 03:41:29.930380       1 reflector.go:219] Starting reflector *v1.PersistentVolume (10m0s) from k8s.io/client-go/informers/factory.go:134
I0626 03:41:29.930422       1 reflector.go:255] Listing and watching *v1.PersistentVolume from k8s.io/client-go/informers/factory.go:134
I0626 03:41:29.946663       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0626 03:41:30.030757       1 shared_informer.go:270] caches populated
I0626 03:41:34.964504       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0626 03:41:39.973742       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0626 03:41:44.984641       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0626 03:41:49.993789       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0626 03:41:55.003056       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0626 03:42:00.013881       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0626 03:42:05.024689       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0626 03:42:10.036467       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0626 03:42:15.043929       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0626 03:42:20.053717       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0626 03:42:25.059576       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0626 03:42:30.068461       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0626 03:42:35.082661       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0626 03:42:40.097887       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0626 03:42:45.109312       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0626 03:42:50.121734       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0626 03:42:55.133070       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0626 03:43:00.141367       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0626 03:43:05.161790       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0626 03:43:10.170670       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0626 03:43:15.178866       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0626 03:43:20.187798       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0626 03:43:25.196188       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0626 03:43:30.202471       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0626 03:43:35.210903       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0626 03:43:40.219220       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0626 03:43:45.229785       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0626 03:43:50.238922       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0626 03:43:55.251490       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0626 03:44:00.259591       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0626 03:44:05.270645       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0626 03:44:10.277405       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0626 03:44:15.286272       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0626 03:44:20.296589       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0626 03:44:25.305420       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0626 03:44:30.313772       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0626 03:44:35.326690       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0626 03:44:40.340627       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0626 03:44:45.349945       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0626 03:44:50.362931       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0626 03:44:55.376739       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0626 03:45:00.385417       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0626 03:45:05.395149       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0626 03:45:10.406802       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0626 03:45:12.036459       1 controller.go:208] Started VA processing "csi-a1dea2a933f7e20e399829640de34e9dbaf46ffd567ff4151aa997bd20b4d8d5"
I0626 03:45:12.036486       1 trivial_handler.go:53] Trivial sync[csi-a1dea2a933f7e20e399829640de34e9dbaf46ffd567ff4151aa997bd20b4d8d5] started
I0626 03:45:12.036491       1 util.go:38] Marking as attached "csi-a1dea2a933f7e20e399829640de34e9dbaf46ffd567ff4151aa997bd20b4d8d5"
I0626 03:45:12.042466       1 util.go:52] Marked as attached "csi-a1dea2a933f7e20e399829640de34e9dbaf46ffd567ff4151aa997bd20b4d8d5"
I0626 03:45:12.042612       1 trivial_handler.go:61] Marked VolumeAttachment csi-a1dea2a933f7e20e399829640de34e9dbaf46ffd567ff4151aa997bd20b4d8d5 as attached
I0626 03:45:12.042711       1 controller.go:208] Started VA processing "csi-a1dea2a933f7e20e399829640de34e9dbaf46ffd567ff4151aa997bd20b4d8d5"
I0626 03:45:12.042769       1 trivial_handler.go:53] Trivial sync[csi-a1dea2a933f7e20e399829640de34e9dbaf46ffd567ff4151aa997bd20b4d8d5] started
I0626 03:45:15.416483       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0626 03:45:20.431265       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0626 03:45:25.440401       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0626 03:45:29.872527       1 controller.go:259] Started PV processing "pvc-5157c910-7356-4dc3-9024-e3d2b0f53750"
I0626 03:45:30.452151       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0626 03:45:35.466146       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0626 03:45:40.474464       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0626 03:45:45.485645       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0626 03:45:50.505776       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0626 03:45:55.518911       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0626 03:46:00.527900       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com
I0626 03:46:05.541659       1 leaderelection.go:278] successfully renewed lease kube-system/external-attacher-leader-rbd-csi-ceph-com