I0218 19:50:43.080803 1 feature_gate.go:245] feature gates: &{map[]} I0218 19:50:43.080856 1 csi-provisioner.go:139] Version: v3.1.0 I0218 19:50:43.080860 1 csi-provisioner.go:162] Building kube configs for running in cluster... I0218 19:50:43.083357 1 connection.go:154] Connecting to unix:///csi/csi-provisioner.sock W0218 19:50:53.084312 1 connection.go:173] Still connecting to unix:///csi/csi-provisioner.sock W0218 19:51:03.083422 1 connection.go:173] Still connecting to unix:///csi/csi-provisioner.sock I0218 19:51:11.090797 1 common.go:111] Probing CSI driver for readiness I0218 19:51:11.090891 1 connection.go:183] GRPC call: /csi.v1.Identity/Probe I0218 19:51:11.090947 1 connection.go:184] GRPC request: {} I0218 19:51:11.112120 1 connection.go:186] GRPC response: {} I0218 19:51:11.112314 1 connection.go:187] GRPC error: I0218 19:51:11.112397 1 connection.go:183] GRPC call: /csi.v1.Identity/GetPluginInfo I0218 19:51:11.112420 1 connection.go:184] GRPC request: {} I0218 19:51:11.113356 1 connection.go:186] GRPC response: {"name":"rbd.csi.ceph.com","vendor_version":"v3.5.1"} I0218 19:51:11.113432 1 connection.go:187] GRPC error: I0218 19:51:11.113444 1 csi-provisioner.go:206] Detected CSI driver rbd.csi.ceph.com I0218 19:51:11.113453 1 csi-provisioner.go:216] Supports migration from in-tree plugin: kubernetes.io/rbd I0218 19:51:11.113532 1 connection.go:154] Connecting to unix:///csi/csi-provisioner.sock I0218 19:51:11.115795 1 common.go:111] Probing CSI driver for readiness I0218 19:51:11.116022 1 connection.go:183] GRPC call: /csi.v1.Identity/Probe I0218 19:51:11.116104 1 connection.go:184] GRPC request: {} I0218 19:51:11.117132 1 connection.go:186] GRPC response: {} I0218 19:51:11.117181 1 connection.go:187] GRPC error: I0218 19:51:11.117258 1 connection.go:183] GRPC call: /csi.v1.Identity/GetPluginCapabilities I0218 19:51:11.117304 1 connection.go:184] GRPC request: {} I0218 19:51:11.118289 1 connection.go:186] GRPC response: {"capabilities":[{"Type":{"Service":{"type":1}}},{"Type":{"VolumeExpansion":{"type":1}}},{"Type":{"Service":{"type":2}}}]} I0218 19:51:11.119895 1 connection.go:187] GRPC error: I0218 19:51:11.119951 1 connection.go:183] GRPC call: /csi.v1.Controller/ControllerGetCapabilities I0218 19:51:11.119974 1 connection.go:184] GRPC request: {} I0218 19:51:11.121109 1 connection.go:186] GRPC response: {"capabilities":[{"Type":{"Rpc":{"type":1}}},{"Type":{"Rpc":{"type":5}}},{"Type":{"Rpc":{"type":7}}},{"Type":{"Rpc":{"type":9}}}]} I0218 19:51:11.121355 1 connection.go:187] GRPC error: I0218 19:51:11.124212 1 csi-provisioner.go:278] CSI driver does not support PUBLISH_UNPUBLISH_VOLUME, not watching VolumeAttachments I0218 19:51:11.128310 1 controller.go:732] Using saving PVs to API server in background I0218 19:51:11.128917 1 leaderelection.go:248] attempting to acquire leader lease kube-system/rbd-csi-ceph-com... I0218 19:51:11.157041 1 leaderelection.go:258] successfully acquired lease kube-system/rbd-csi-ceph-com I0218 19:51:11.157291 1 leader_election.go:205] became leader, starting I0218 19:51:11.158138 1 leader_election.go:212] new leader detected, current leader: ceph-csi-rbd-provisioner-5d8ff44fc9-kmjzm I0218 19:51:11.161358 1 reflector.go:219] Starting reflector *v1.PersistentVolumeClaim (15m0s) from k8s.io/client-go/informers/factory.go:134 I0218 19:51:11.161369 1 reflector.go:255] Listing and watching *v1.PersistentVolumeClaim from k8s.io/client-go/informers/factory.go:134 I0218 19:51:11.161644 1 reflector.go:219] Starting reflector *v1.StorageClass (1h0m0s) from k8s.io/client-go/informers/factory.go:134 I0218 19:51:11.161726 1 reflector.go:255] Listing and watching *v1.StorageClass from k8s.io/client-go/informers/factory.go:134 I0218 19:51:11.168865 1 leaderelection.go:278] successfully renewed lease kube-system/rbd-csi-ceph-com I0218 19:51:11.259057 1 shared_informer.go:270] caches populated I0218 19:51:11.259393 1 shared_informer.go:270] caches populated I0218 19:51:11.259519 1 controller.go:811] Starting provisioner controller rbd.csi.ceph.com_ceph-csi-rbd-provisioner-5d8ff44fc9-kmjzm_950a6782-bfb9-49f6-8d0a-6b3e49a6a246! I0218 19:51:11.259678 1 volume_store.go:97] Starting save volume queue I0218 19:51:11.259871 1 clone_controller.go:66] Starting CloningProtection controller I0218 19:51:11.260100 1 clone_controller.go:82] Started CloningProtection controller I0218 19:51:11.260314 1 reflector.go:219] Starting reflector *v1.PersistentVolume (15m0s) from sigs.k8s.io/sig-storage-lib-external-provisioner/v8/controller/controller.go:845 I0218 19:51:11.260435 1 reflector.go:255] Listing and watching *v1.PersistentVolume from sigs.k8s.io/sig-storage-lib-external-provisioner/v8/controller/controller.go:845 I0218 19:51:11.260799 1 reflector.go:219] Starting reflector *v1.StorageClass (15m0s) from sigs.k8s.io/sig-storage-lib-external-provisioner/v8/controller/controller.go:848 I0218 19:51:11.260821 1 reflector.go:255] Listing and watching *v1.StorageClass from sigs.k8s.io/sig-storage-lib-external-provisioner/v8/controller/controller.go:848 I0218 19:51:11.359775 1 shared_informer.go:270] caches populated I0218 19:51:11.360547 1 controller.go:860] Started provisioner controller rbd.csi.ceph.com_ceph-csi-rbd-provisioner-5d8ff44fc9-kmjzm_950a6782-bfb9-49f6-8d0a-6b3e49a6a246! I0218 19:51:16.178337 1 leaderelection.go:278] successfully renewed lease kube-system/rbd-csi-ceph-com I0218 19:51:21.188848 1 leaderelection.go:278] successfully renewed lease kube-system/rbd-csi-ceph-com I0218 19:51:26.195848 1 leaderelection.go:278] successfully renewed lease kube-system/rbd-csi-ceph-com I0218 19:51:31.201855 1 leaderelection.go:278] successfully renewed lease kube-system/rbd-csi-ceph-com I0218 19:51:36.209511 1 leaderelection.go:278] successfully renewed lease kube-system/rbd-csi-ceph-com I0218 19:51:41.215083 1 leaderelection.go:278] successfully renewed lease kube-system/rbd-csi-ceph-com I0218 19:51:46.221294 1 leaderelection.go:278] successfully renewed lease kube-system/rbd-csi-ceph-com I0218 19:51:51.229151 1 leaderelection.go:278] successfully renewed lease kube-system/rbd-csi-ceph-com