W1106 18:36:28.719] **************************************************************************
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
**************************************************************************
I1106 18:36:28.720] Args: --job=chewong-pull-azuredisk-csi-driver-e2e-multi-az --service-account=/etc/service-account/service-account.json --upload=gs://kubernetes-jenkins/logs --job=chewong-pull-azuredisk-csi-driver-e2e-multi-az --root=/go/src --service-account=/etc/service-account/service-account.json --repo=k8s.io/kubernetes=master --repo=sigs.k8s.io/azuredisk-csi-driver=master:b7c03af8eae7388e84115ace30cf2ff3285b0dc9,180:3d974a552d3f3a8ed615de3a6a819edc818404e4 --upload=gs://kubernetes-upstream/pr-logs --timeout=460 --scenario=kubernetes_e2e -- --gce-ssh= --test=true --up=true --down=true --deployment=acsengine --build=bazel --provider=skeleton --ginkgo-parallel=1 --acsengine-agentpoolcount=2 --acsengine-admin-username=azureuser '--acsengine-creds=$AZURE_CREDENTIALS' --acsengine-orchestratorRelease=1.16 --acsengine-mastervmsize=Standard_DS2_v2 --acsengine-agentvmsize=Standard_D4s_v3 --acsengine-location=eastus2 '--acsengine-public-key=$AZURE_SSH_PUBLIC_KEY_FILE' --acsengine-template-url=https://raw.githubusercontent.com/kubernetes-sigs/cloud-provider-azure/da4b9f5e9696ab00a5b1ac08606218f9f352d324/tests/k8s-azure/manifest/linux-vmss-multi-zones.json --acsengine-download-url=https://github.com/Azure/aks-engine/releases/download/v0.39.1/aks-engine-v0.39.1-linux-amd64.tar.gz --test-azure-disk-csi-driver=True '--test_args=--ginkgo.focus="\[multi\-az\]"' --timeout=420m
I1106 18:36:28.720] Bootstrap chewong-pull-azuredisk-csi-driver-e2e-multi-az...
I1106 18:36:28.723] Builder: 463648ef-00c4-11ea-918b-16773c0c7aed
I1106 18:36:28.723] Image: chewong/kubekins-e2e:v20191105-test-2
I1106 18:36:28.724] Gubernator results at https://gubernator.k8s.io/build/kubernetes-upstream/pr-logs/pull/sigs.k8s.io_azuredisk-csi-driver/180/chewong-pull-azuredisk-csi-driver-e2e-multi-az/1192148695437545472
I1106 18:36:28.724] Call:  gcloud auth activate-service-account --key-file=/etc/service-account/service-account.json
W1106 18:36:29.267] Activated service account credentials for: [kubernetes-upstream@kubernetes-upstream.iam.gserviceaccount.com]
I1106 18:36:29.300] process 193 exited with code 0 after 0.0m
I1106 18:36:29.300] Call:  gcloud config get-value account
I1106 18:36:29.562] process 205 exited with code 0 after 0.0m
I1106 18:36:29.562] Will upload results to gs://kubernetes-upstream/pr-logs using kubernetes-upstream@kubernetes-upstream.iam.gserviceaccount.com
I1106 18:36:29.562] Root: /go/src
I1106 18:36:29.563] cd to /go/src
I1106 18:36:29.563] Checkout: /go/src/k8s.io/kubernetes master to /go/src/k8s.io/kubernetes
I1106 18:36:29.563] Call:  git init k8s.io/kubernetes
I1106 18:36:29.567] Initialized empty Git repository in /go/src/k8s.io/kubernetes/.git/
I1106 18:36:29.567] process 217 exited with code 0 after 0.0m
I1106 18:36:29.567] Call:  git config --local user.name 'K8S Bootstrap'
I1106 18:36:29.570] process 218 exited with code 0 after 0.0m
I1106 18:36:29.570] Call:  git config --local user.email k8s_bootstrap@localhost
I1106 18:36:29.572] process 219 exited with code 0 after 0.0m
I1106 18:36:29.572] Call:  git fetch --quiet --tags https://github.com/kubernetes/kubernetes master
I1106 18:37:28.784] process 220 exited with code 0 after 1.0m
I1106 18:37:28.784] Call:  git checkout -B test FETCH_HEAD
W1106 18:37:30.988] Switched to a new branch 'test'
I1106 18:37:30.996] process 232 exited with code 0 after 0.0m
I1106 18:37:30.996] Call:  git show -s --format=format:%ct HEAD
I1106 18:37:31.062] process 233 exited with code 0 after 0.0m
I1106 18:37:31.062] Checkout: /go/src/sigs.k8s.io/azuredisk-csi-driver master:b7c03af8eae7388e84115ace30cf2ff3285b0dc9,180:3d974a552d3f3a8ed615de3a6a819edc818404e4 to /go/src/sigs.k8s.io/azuredisk-csi-driver
I1106 18:37:31.062] Call:  git init sigs.k8s.io/azuredisk-csi-driver
I1106 18:37:31.067] Initialized empty Git repository in /go/src/sigs.k8s.io/azuredisk-csi-driver/.git/
I1106 18:37:31.067] process 234 exited with code 0 after 0.0m
I1106 18:37:31.067] Call:  git config --local user.name 'K8S Bootstrap'
I1106 18:37:31.070] process 235 exited with code 0 after 0.0m
I1106 18:37:31.070] Call:  git config --local user.email k8s_bootstrap@localhost
I1106 18:37:31.073] process 236 exited with code 0 after 0.0m
I1106 18:37:31.073] Call:  git fetch --quiet --tags https://github.com/kubernetes-sigs/azuredisk-csi-driver master +refs/pull/180/head:refs/pr/180
I1106 18:37:37.172] process 237 exited with code 0 after 0.1m
I1106 18:37:37.173] Call:  git checkout -B test b7c03af8eae7388e84115ace30cf2ff3285b0dc9
W1106 18:37:37.759] Switched to a new branch 'test'
I1106 18:37:37.761] process 248 exited with code 0 after 0.0m
I1106 18:37:37.762] Call:  git show -s --format=format:%ct HEAD
I1106 18:37:37.765] process 249 exited with code 0 after 0.0m
I1106 18:37:37.765] Call:  git merge --no-ff -m 'Merge +refs/pull/180/head:refs/pr/180' 3d974a552d3f3a8ed615de3a6a819edc818404e4
W1106 18:37:37.769] merge: 3d974a552d3f3a8ed615de3a6a819edc818404e4 - not something we can merge
E1106 18:37:37.769] Command failed
I1106 18:37:37.769] process 250 exited with code 1 after 0.0m
E1106 18:37:37.769] 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/180/head:refs/pr/180', '3d974a552d3f3a8ed615de3a6a819edc818404e4']' returned non-zero exit status 1
I1106 18:37:37.770] Call:  gcloud auth activate-service-account --key-file=/etc/service-account/service-account.json
W1106 18:37:38.339] Activated service account credentials for: [kubernetes-upstream@kubernetes-upstream.iam.gserviceaccount.com]
I1106 18:37:38.375] process 251 exited with code 0 after 0.0m
I1106 18:37:38.375] Call:  gcloud config get-value account
I1106 18:37:38.625] process 263 exited with code 0 after 0.0m
I1106 18:37:38.626] Will upload results to gs://kubernetes-upstream/pr-logs using kubernetes-upstream@kubernetes-upstream.iam.gserviceaccount.com
I1106 18:37:38.626] Upload result and artifacts...
I1106 18:37:38.626] Gubernator results at https://gubernator.k8s.io/build/kubernetes-upstream/pr-logs/pull/sigs.k8s.io_azuredisk-csi-driver/180/chewong-pull-azuredisk-csi-driver-e2e-multi-az/1192148695437545472
W1106 18:37:38.626] Missing local artifacts : /workspace/_artifacts
W1106 18:37:38.627] metadata path /workspace/_artifacts/metadata.json does not exist
W1106 18:37:38.627] metadata not found or invalid, init with empty metadata
I1106 18:37:38.627] Call:  git rev-parse HEAD
I1106 18:37:38.629] process 275 exited with code 0 after 0.0m
I1106 18:37:38.630] Call:  git rev-parse HEAD
I1106 18:37:38.632] process 276 exited with code 0 after 0.0m
I1106 18:37:38.632] Call:  gsutil stat gs://kubernetes-upstream/pr-logs/directory/chewong-pull-azuredisk-csi-driver-e2e-multi-az/jobResultsCache.json
I1106 18:37:39.663] process 277 exited with code 0 after 0.0m
I1106 18:37:39.664] Call:  gsutil -q cat 'gs://kubernetes-upstream/pr-logs/directory/chewong-pull-azuredisk-csi-driver-e2e-multi-az/jobResultsCache.json#1573065129696817'
I1106 18:37:40.777] process 421 exited with code 0 after 0.0m
I1106 18:37:40.779] Call:  gsutil -q -h Content-Type:application/json -h x-goog-if-generation-match:1573065129696817 cp /tmp/gsutil_0oX8mY gs://kubernetes-upstream/pr-logs/directory/chewong-pull-azuredisk-csi-driver-e2e-multi-az/jobResultsCache.json
I1106 18:37:41.964] process 567 exited with code 0 after 0.0m
I1106 18:37:41.964] Call:  gsutil stat gs://kubernetes-upstream/pr-logs/pull/sigs.k8s.io_azuredisk-csi-driver/180/chewong-pull-azuredisk-csi-driver-e2e-multi-az/jobResultsCache.json
I1106 18:37:42.752] process 747 exited with code 0 after 0.0m
I1106 18:37:42.752] Call:  gsutil -q cat 'gs://kubernetes-upstream/pr-logs/pull/sigs.k8s.io_azuredisk-csi-driver/180/chewong-pull-azuredisk-csi-driver-e2e-multi-az/jobResultsCache.json#1573065132566921'
I1106 18:37:43.772] process 891 exited with code 0 after 0.0m
I1106 18:37:43.773] Call:  gsutil -q -h Content-Type:application/json -h x-goog-if-generation-match:1573065132566921 cp /tmp/gsutil_CwIEgb gs://kubernetes-upstream/pr-logs/pull/sigs.k8s.io_azuredisk-csi-driver/180/chewong-pull-azuredisk-csi-driver-e2e-multi-az/jobResultsCache.json
I1106 18:37:44.933] process 1037 exited with code 0 after 0.0m
I1106 18:37:44.934] Call:  gsutil -q -h Content-Type:application/json cp /tmp/gsutil_3yt2EN gs://kubernetes-upstream/pr-logs/pull/sigs.k8s.io_azuredisk-csi-driver/180/chewong-pull-azuredisk-csi-driver-e2e-multi-az/1192148695437545472/finished.json
I1106 18:37:46.142] process 1217 exited with code 0 after 0.0m
I1106 18:37:46.143] Call:  gsutil -q -h Content-Type:text/plain -h 'Cache-Control:private, max-age=0, no-transform' cp /tmp/gsutil_qwYG2l gs://kubernetes-upstream/pr-logs/pull/sigs.k8s.io_azuredisk-csi-driver/180/chewong-pull-azuredisk-csi-driver-e2e-multi-az/latest-build.txt
I1106 18:37:47.300] process 1397 exited with code 0 after 0.0m
I1106 18:37:47.300] Call:  gsutil -q -h Content-Type:text/plain -h 'Cache-Control:private, max-age=0, no-transform' cp /tmp/gsutil_1umt7O gs://kubernetes-upstream/pr-logs/directory/chewong-pull-azuredisk-csi-driver-e2e-multi-az/latest-build.txt
I1106 18:37:48.452] process 1577 exited with code 0 after 0.0m