I0922 02:00:21.685957       1 main.go:93] Version : v1.3.0
I0922 02:00:21.686009       1 feature_gate.go:245] feature gates: &{map[]}
I0922 02:00:21.691098       1 connection.go:154] Connecting to unix:///csi/csi-provisioner.sock
I0922 02:00:26.325447       1 common.go:111] Probing CSI driver for readiness
I0922 02:00:26.325473       1 connection.go:183] GRPC call: /csi.v1.Identity/Probe
I0922 02:00:26.325480       1 connection.go:184] GRPC request: {}
I0922 02:00:26.329710       1 connection.go:186] GRPC response: {}
I0922 02:00:26.329782       1 connection.go:187] GRPC error: <nil>
I0922 02:00:26.329795       1 connection.go:183] GRPC call: /csi.v1.Identity/GetPluginInfo
I0922 02:00:26.329800       1 connection.go:184] GRPC request: {}
I0922 02:00:26.331165       1 connection.go:186] GRPC response: {"name":"rbd.csi.ceph.com","vendor_version":"v3.5.1"}
I0922 02:00:26.331235       1 connection.go:187] GRPC error: <nil>
I0922 02:00:26.331249       1 main.go:141] CSI driver name: "rbd.csi.ceph.com"
I0922 02:00:26.331261       1 connection.go:183] GRPC call: /csi.v1.Identity/GetPluginCapabilities
I0922 02:00:26.331282       1 connection.go:184] GRPC request: {}
I0922 02:00:26.332965       1 connection.go:186] GRPC response: {"capabilities":[{"Type":{"Service":{"type":1}}},{"Type":{"VolumeExpansion":{"type":1}}},{"Type":{"Service":{"type":2}}}]}
I0922 02:00:26.334150       1 connection.go:187] GRPC error: <nil>
I0922 02:00:26.334190       1 connection.go:183] GRPC call: /csi.v1.Controller/ControllerGetCapabilities
I0922 02:00:26.334256       1 connection.go:184] GRPC request: {}
I0922 02:00:26.338563       1 connection.go:186] GRPC response: {"capabilities":[{"Type":{"Rpc":{"type":1}}},{"Type":{"Rpc":{"type":5}}},{"Type":{"Rpc":{"type":7}}},{"Type":{"Rpc":{"type":9}}}]}
I0922 02:00:26.339293       1 connection.go:187] GRPC error: <nil>
I0922 02:00:26.339385       1 connection.go:183] GRPC call: /csi.v1.Controller/ControllerGetCapabilities
I0922 02:00:26.339465       1 connection.go:184] GRPC request: {}
I0922 02:00:26.340406       1 connection.go:186] GRPC response: {"capabilities":[{"Type":{"Rpc":{"type":1}}},{"Type":{"Rpc":{"type":5}}},{"Type":{"Rpc":{"type":7}}},{"Type":{"Rpc":{"type":9}}}]}
I0922 02:00:26.340634       1 connection.go:187] GRPC error: <nil>
I0922 02:00:26.342814       1 leaderelection.go:248] attempting to acquire leader lease kube-system/external-resizer-rbd-csi-ceph-com...
I0922 02:00:26.358619       1 leaderelection.go:258] successfully acquired lease kube-system/external-resizer-rbd-csi-ceph-com
I0922 02:00:26.359113       1 leader_election.go:212] new leader detected, current leader: ceph-csi-rbd-provisioner-6f6497f79c-6qpm6
I0922 02:00:26.359967       1 leader_election.go:205] became leader, starting
I0922 02:00:26.360069       1 controller.go:251] Starting external resizer rbd.csi.ceph.com
I0922 02:00:26.360634       1 reflector.go:219] Starting reflector *v1.PersistentVolume (10m0s) from k8s.io/client-go/informers/factory.go:134
I0922 02:00:26.360672       1 reflector.go:255] Listing and watching *v1.PersistentVolume from k8s.io/client-go/informers/factory.go:134
I0922 02:00:26.361077       1 reflector.go:219] Starting reflector *v1.PersistentVolumeClaim (10m0s) from k8s.io/client-go/informers/factory.go:134
I0922 02:00:26.361230       1 reflector.go:255] Listing and watching *v1.PersistentVolumeClaim from k8s.io/client-go/informers/factory.go:134
I0922 02:00:26.372188       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0922 02:00:26.460700       1 shared_informer.go:270] caches populated
I0922 02:00:31.386986       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0922 02:00:36.397942       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0922 02:00:41.415074       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0922 02:00:46.425578       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0922 02:00:51.439707       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0922 02:00:56.450051       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0922 02:01:01.460002       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0922 02:01:06.470767       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0922 02:01:11.483828       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0922 02:01:16.493569       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0922 02:01:21.507982       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0922 02:01:26.520359       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0922 02:01:31.533715       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0922 02:01:36.542654       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0922 02:01:41.556591       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0922 02:01:46.566042       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0922 02:01:51.577366       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0922 02:01:56.593108       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0922 02:02:01.606227       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0922 02:02:06.616783       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0922 02:02:11.629517       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0922 02:02:16.641082       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0922 02:02:21.653360       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0922 02:02:26.669344       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0922 02:02:31.683317       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0922 02:02:36.692693       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0922 02:02:41.702766       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0922 02:02:46.713117       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0922 02:02:51.725395       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0922 02:02:56.738248       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0922 02:03:01.751387       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0922 02:03:06.758888       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0922 02:03:11.769558       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0922 02:03:16.781064       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0922 02:03:21.791161       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0922 02:03:26.801908       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0922 02:03:31.812665       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0922 02:03:36.820541       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0922 02:03:41.829322       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0922 02:03:46.838663       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0922 02:03:51.848876       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0922 02:03:56.856937       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0922 02:04:01.869509       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0922 02:04:06.883560       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0922 02:04:11.893477       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0922 02:04:16.900329       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0922 02:04:21.908877       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0922 02:04:26.916438       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0922 02:04:31.923785       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0922 02:04:36.932250       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0922 02:04:41.944435       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0922 02:04:46.954147       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0922 02:04:51.962834       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0922 02:04:56.972386       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0922 02:05:01.980812       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0922 02:05:03.798006       1 controller.go:291] Started PVC processing "default/test-pvc"
W0922 02:05:03.798067       1 controller.go:318] PV "" bound to PVC default/test-pvc not found
I0922 02:05:03.986937       1 controller.go:291] Started PVC processing "default/test-pvc"
I0922 02:05:03.986970       1 controller.go:334] No need to resize PVC "default/test-pvc"
I0922 02:05:06.988396       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0922 02:05:12.007510       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0922 02:05:17.016874       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0922 02:05:22.026193       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0922 02:05:27.034506       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0922 02:05:32.043146       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0922 02:05:37.051449       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0922 02:05:42.061255       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0922 02:05:47.069495       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com
I0922 02:05:52.078350       1 leaderelection.go:278] successfully renewed lease kube-system/external-resizer-rbd-csi-ceph-com