W0923 20:20:34.017] **************************************************************************
bootstrap.py is deprecated!
test-infra oncall does not support any job still using bootstrap.py.
Please migrate your job to podutils!
https://github.com/kubernetes/test-infra/blob/master/prow/pod-utilities.md
**************************************************************************
I0923 20:20:34.017] Args: --job=pull-azurefile-csi-driver-sanity --service-account=/etc/service-account/service-account.json --upload=gs://kubernetes-jenkins/logs --job=pull-azurefile-csi-driver-sanity --root=/go/src --service-account=/etc/service-account/service-account.json --repo=github.com/kubernetes-sigs/azurefile-csi-driver=master:daea67167aecc01a8bfa2b24f33c4a08998cdc74,120:4490af2ec719fb25b69282d927e85a786d054ab3 --upload=gs://kubernetes-upstream/pr-logs --timeout=460 --scenario=execute -- make sanity-test
I0923 20:20:34.017] Bootstrap pull-azurefile-csi-driver-sanity...
I0923 20:20:34.020] Builder: 88cd060f-de3f-11e9-b3d3-b20db476995a
I0923 20:20:34.020] Image: gcr.io/k8s-testimages/kubekins-e2e:v20190903-df3b2f0-master
I0923 20:20:34.021] Gubernator results at https://gubernator.k8s.io/build/kubernetes-upstream/pr-logs/pull/kubernetes-sigs_azurefile-csi-driver/120/pull-azurefile-csi-driver-sanity/1176229801761968130
I0923 20:20:34.021] Call:  gcloud auth activate-service-account --key-file=/etc/service-account/service-account.json
W0923 20:20:34.619] Activated service account credentials for: [kubernetes-upstream@kubernetes-upstream.iam.gserviceaccount.com]
I0923 20:20:34.662] process 33 exited with code 0 after 0.0m
I0923 20:20:34.662] Call:  gcloud config get-value account
I0923 20:20:34.938] process 45 exited with code 0 after 0.0m
I0923 20:20:34.939] Will upload results to gs://kubernetes-upstream/pr-logs using kubernetes-upstream@kubernetes-upstream.iam.gserviceaccount.com
I0923 20:20:34.939] Root: /go/src
I0923 20:20:34.939] cd to /go/src
I0923 20:20:34.939] Checkout: /go/src/github.com/kubernetes-sigs/azurefile-csi-driver master:daea67167aecc01a8bfa2b24f33c4a08998cdc74,120:4490af2ec719fb25b69282d927e85a786d054ab3 to /go/src/github.com/kubernetes-sigs/azurefile-csi-driver
I0923 20:20:34.939] Call:  git init github.com/kubernetes-sigs/azurefile-csi-driver
I0923 20:20:34.943] Initialized empty Git repository in /go/src/github.com/kubernetes-sigs/azurefile-csi-driver/.git/
I0923 20:20:34.944] process 57 exited with code 0 after 0.0m
I0923 20:20:34.944] Call:  git config --local user.name 'K8S Bootstrap'
I0923 20:20:34.946] process 58 exited with code 0 after 0.0m
I0923 20:20:34.947] Call:  git config --local user.email k8s_bootstrap@localhost
I0923 20:20:34.949] process 59 exited with code 0 after 0.0m
I0923 20:20:34.950] Call:  git fetch --quiet --tags https://github.com/kubernetes-sigs/azurefile-csi-driver master +refs/pull/120/head:refs/pr/120
I0923 20:20:42.776] process 60 exited with code 0 after 0.1m
I0923 20:20:42.776] Call:  git checkout -B test daea67167aecc01a8bfa2b24f33c4a08998cdc74
W0923 20:20:43.335] Switched to a new branch 'test'
I0923 20:20:43.337] process 72 exited with code 0 after 0.0m
I0923 20:20:43.337] Call:  git show -s --format=format:%ct HEAD
I0923 20:20:43.355] process 73 exited with code 0 after 0.0m
I0923 20:20:43.356] Call:  git merge --no-ff -m 'Merge +refs/pull/120/head:refs/pr/120' 4490af2ec719fb25b69282d927e85a786d054ab3
W0923 20:20:43.362] merge: 4490af2ec719fb25b69282d927e85a786d054ab3 - not something we can merge
E0923 20:20:43.363] Command failed
I0923 20:20:43.363] process 74 exited with code 1 after 0.0m
E0923 20:20:43.363] unexpected error
Traceback (most recent call last):
  File "./test-infra/jenkins/bootstrap.py", line 1096, in bootstrap
  File "./test-infra/jenkins/bootstrap.py", line 981, in setup_root
  File "./test-infra/jenkins/bootstrap.py", line 307, in checkout
  File "./test-infra/jenkins/bootstrap.py", line 1054, in <lambda>
  File "./test-infra/jenkins/bootstrap.py", line 149, in _call
CalledProcessError: Command '['git', 'merge', '--no-ff', '-m', 'Merge +refs/pull/120/head:refs/pr/120', '4490af2ec719fb25b69282d927e85a786d054ab3']' returned non-zero exit status 1
I0923 20:20:43.364] Call:  gcloud auth activate-service-account --key-file=/etc/service-account/service-account.json
W0923 20:20:43.953] Activated service account credentials for: [kubernetes-upstream@kubernetes-upstream.iam.gserviceaccount.com]
I0923 20:20:43.999] process 75 exited with code 0 after 0.0m
I0923 20:20:43.999] Call:  gcloud config get-value account
I0923 20:20:44.312] process 87 exited with code 0 after 0.0m
I0923 20:20:44.313] Will upload results to gs://kubernetes-upstream/pr-logs using kubernetes-upstream@kubernetes-upstream.iam.gserviceaccount.com
I0923 20:20:44.313] Upload result and artifacts...
I0923 20:20:44.313] Gubernator results at https://gubernator.k8s.io/build/kubernetes-upstream/pr-logs/pull/kubernetes-sigs_azurefile-csi-driver/120/pull-azurefile-csi-driver-sanity/1176229801761968130
W0923 20:20:44.313] Missing local artifacts : /workspace/_artifacts
W0923 20:20:44.313] metadata path /workspace/_artifacts/metadata.json does not exist
W0923 20:20:44.314] metadata not found or invalid, init with empty metadata
I0923 20:20:44.314] Call:  git rev-parse HEAD
I0923 20:20:44.317] process 99 exited with code 0 after 0.0m
I0923 20:20:44.318] Call:  git rev-parse HEAD
I0923 20:20:44.320] process 100 exited with code 0 after 0.0m
I0923 20:20:44.320] Call:  gsutil stat gs://kubernetes-upstream/pr-logs/directory/pull-azurefile-csi-driver-sanity/jobResultsCache.json
I0923 20:20:45.667] process 101 exited with code 0 after 0.0m
I0923 20:20:45.668] Call:  gsutil -q cat 'gs://kubernetes-upstream/pr-logs/directory/pull-azurefile-csi-driver-sanity/jobResultsCache.json#1569268902438207'
I0923 20:20:46.998] process 243 exited with code 0 after 0.0m
I0923 20:20:47.002] Call:  gsutil -q -h Content-Type:application/json -h x-goog-if-generation-match:1569268902438207 cp /tmp/gsutil_Pmtj_9 gs://kubernetes-upstream/pr-logs/directory/pull-azurefile-csi-driver-sanity/jobResultsCache.json
I0923 20:20:48.479] process 387 exited with code 0 after 0.0m
I0923 20:20:48.479] Call:  gsutil stat gs://kubernetes-upstream/pr-logs/pull/kubernetes-sigs_azurefile-csi-driver/120/pull-azurefile-csi-driver-sanity/jobResultsCache.json
I0923 20:20:49.747] process 565 exited with code 0 after 0.0m
I0923 20:20:49.747] Call:  gsutil -q cat 'gs://kubernetes-upstream/pr-logs/pull/kubernetes-sigs_azurefile-csi-driver/120/pull-azurefile-csi-driver-sanity/jobResultsCache.json#1569268906004048'
I0923 20:20:51.136] process 707 exited with code 0 after 0.0m
I0923 20:20:51.137] Call:  gsutil -q -h Content-Type:application/json -h x-goog-if-generation-match:1569268906004048 cp /tmp/gsutil_gVfxUz gs://kubernetes-upstream/pr-logs/pull/kubernetes-sigs_azurefile-csi-driver/120/pull-azurefile-csi-driver-sanity/jobResultsCache.json
I0923 20:20:52.559] process 851 exited with code 0 after 0.0m
I0923 20:20:52.560] Call:  gsutil -q -h Content-Type:application/json cp /tmp/gsutil_tcIw_l gs://kubernetes-upstream/pr-logs/pull/kubernetes-sigs_azurefile-csi-driver/120/pull-azurefile-csi-driver-sanity/1176229801761968130/finished.json
I0923 20:20:54.136] process 1029 exited with code 0 after 0.0m
I0923 20:20:54.136] Call:  gsutil -q -h Content-Type:text/plain -h 'Cache-Control:private, max-age=0, no-transform' cp /tmp/gsutil_ttSxEp gs://kubernetes-upstream/pr-logs/directory/pull-azurefile-csi-driver-sanity/latest-build.txt
I0923 20:20:55.701] process 1207 exited with code 0 after 0.0m
I0923 20:20:55.701] Call:  gsutil -q -h Content-Type:text/plain -h 'Cache-Control:private, max-age=0, no-transform' cp /tmp/gsutil_LrOYVa gs://kubernetes-upstream/pr-logs/pull/kubernetes-sigs_azurefile-csi-driver/120/pull-azurefile-csi-driver-sanity/latest-build.txt
I0923 20:20:57.253] process 1385 exited with code 0 after 0.0m