W1106 18:22:27.847] **************************************************************************
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:22:27.847] 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:22:27.847] Bootstrap chewong-pull-azuredisk-csi-driver-e2e-multi-az...
I1106 18:22:27.851] Builder: 54d0b270-00c2-11ea-b3d3-b20db476995a
I1106 18:22:27.851] Image: chewong/kubekins-e2e:v20191105-test-2
I1106 18:22:27.851] 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/1192145172217991168
I1106 18:22:27.851] Call:  gcloud auth activate-service-account --key-file=/etc/service-account/service-account.json
W1106 18:22:28.354] Activated service account credentials for: [kubernetes-upstream@kubernetes-upstream.iam.gserviceaccount.com]
I1106 18:22:28.384] process 199 exited with code 0 after 0.0m
I1106 18:22:28.384] Call:  gcloud config get-value account
I1106 18:22:28.625] process 211 exited with code 0 after 0.0m
I1106 18:22:28.626] Will upload results to gs://kubernetes-upstream/pr-logs using kubernetes-upstream@kubernetes-upstream.iam.gserviceaccount.com
I1106 18:22:28.626] Root: /go/src
I1106 18:22:28.626] cd to /go/src
I1106 18:22:28.626] Checkout: /go/src/k8s.io/kubernetes master to /go/src/k8s.io/kubernetes
I1106 18:22:28.626] Call:  git init k8s.io/kubernetes
I1106 18:22:28.630] Initialized empty Git repository in /go/src/k8s.io/kubernetes/.git/
I1106 18:22:28.630] process 223 exited with code 0 after 0.0m
I1106 18:22:28.631] Call:  git config --local user.name 'K8S Bootstrap'
I1106 18:22:28.633] process 224 exited with code 0 after 0.0m
I1106 18:22:28.633] Call:  git config --local user.email k8s_bootstrap@localhost
I1106 18:22:28.636] process 225 exited with code 0 after 0.0m
I1106 18:22:28.636] Call:  git fetch --quiet --tags https://github.com/kubernetes/kubernetes master
I1106 18:23:29.181] process 226 exited with code 0 after 1.0m
I1106 18:23:29.182] Call:  git checkout -B test FETCH_HEAD
W1106 18:23:31.363] Switched to a new branch 'test'
I1106 18:23:31.372] process 237 exited with code 0 after 0.0m
I1106 18:23:31.372] Call:  git show -s --format=format:%ct HEAD
I1106 18:23:31.435] process 238 exited with code 0 after 0.0m
I1106 18:23:31.435] Checkout: /go/src/sigs.k8s.io/azuredisk-csi-driver master:b7c03af8eae7388e84115ace30cf2ff3285b0dc9,180:3d974a552d3f3a8ed615de3a6a819edc818404e4 to /go/src/sigs.k8s.io/azuredisk-csi-driver
I1106 18:23:31.436] Call:  git init sigs.k8s.io/azuredisk-csi-driver
I1106 18:23:31.439] Initialized empty Git repository in /go/src/sigs.k8s.io/azuredisk-csi-driver/.git/
I1106 18:23:31.440] process 239 exited with code 0 after 0.0m
I1106 18:23:31.440] Call:  git config --local user.name 'K8S Bootstrap'
I1106 18:23:31.442] process 240 exited with code 0 after 0.0m
I1106 18:23:31.442] Call:  git config --local user.email k8s_bootstrap@localhost
I1106 18:23:31.445] process 241 exited with code 0 after 0.0m
I1106 18:23:31.445] Call:  git fetch --quiet --tags https://github.com/kubernetes-sigs/azuredisk-csi-driver master +refs/pull/180/head:refs/pr/180
I1106 18:23:37.558] process 242 exited with code 0 after 0.1m
I1106 18:23:37.558] Call:  git checkout -B test b7c03af8eae7388e84115ace30cf2ff3285b0dc9
W1106 18:23:38.135] Switched to a new branch 'test'
I1106 18:23:38.139] process 253 exited with code 0 after 0.0m
I1106 18:23:38.139] Call:  git show -s --format=format:%ct HEAD
I1106 18:23:38.142] process 254 exited with code 0 after 0.0m
I1106 18:23:38.142] Call:  git merge --no-ff -m 'Merge +refs/pull/180/head:refs/pr/180' 3d974a552d3f3a8ed615de3a6a819edc818404e4
W1106 18:23:38.146] merge: 3d974a552d3f3a8ed615de3a6a819edc818404e4 - not something we can merge
E1106 18:23:38.146] Command failed
I1106 18:23:38.146] process 255 exited with code 1 after 0.0m
E1106 18:23:38.146] 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:23:38.147] Call:  gcloud auth activate-service-account --key-file=/etc/service-account/service-account.json
W1106 18:23:38.695] Activated service account credentials for: [kubernetes-upstream@kubernetes-upstream.iam.gserviceaccount.com]
I1106 18:23:38.726] process 256 exited with code 0 after 0.0m
I1106 18:23:38.727] Call:  gcloud config get-value account
I1106 18:23:38.973] process 268 exited with code 0 after 0.0m
I1106 18:23:38.973] Will upload results to gs://kubernetes-upstream/pr-logs using kubernetes-upstream@kubernetes-upstream.iam.gserviceaccount.com
I1106 18:23:38.973] Upload result and artifacts...
I1106 18:23:38.973] 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/1192145172217991168
W1106 18:23:38.974] Missing local artifacts : /workspace/_artifacts
W1106 18:23:38.974] metadata path /workspace/_artifacts/metadata.json does not exist
W1106 18:23:38.974] metadata not found or invalid, init with empty metadata
I1106 18:23:38.974] Call:  git rev-parse HEAD
I1106 18:23:38.976] process 280 exited with code 0 after 0.0m
I1106 18:23:38.977] Call:  git rev-parse HEAD
I1106 18:23:38.979] process 281 exited with code 0 after 0.0m
I1106 18:23:38.979] Call:  gsutil stat gs://kubernetes-upstream/pr-logs/directory/chewong-pull-azuredisk-csi-driver-e2e-multi-az/jobResultsCache.json
I1106 18:23:39.913] process 282 exited with code 0 after 0.0m
I1106 18:23:39.914] Call:  gsutil -q cat 'gs://kubernetes-upstream/pr-logs/directory/chewong-pull-azuredisk-csi-driver-e2e-multi-az/jobResultsCache.json#1573010836176734'
I1106 18:23:41.052] process 426 exited with code 0 after 0.0m
I1106 18:23:41.054] Call:  gsutil -q -h Content-Type:application/json -h x-goog-if-generation-match:1573010836176734 cp /tmp/gsutil_EuUMCj gs://kubernetes-upstream/pr-logs/directory/chewong-pull-azuredisk-csi-driver-e2e-multi-az/jobResultsCache.json
I1106 18:23:42.237] process 572 exited with code 0 after 0.0m
I1106 18:23:42.238] 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:23:43.051] process 752 exited with code 0 after 0.0m
I1106 18:23:43.051] 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#1573010839327824'
I1106 18:23:44.150] process 896 exited with code 0 after 0.0m
I1106 18:23:44.150] Call:  gsutil -q -h Content-Type:application/json -h x-goog-if-generation-match:1573010839327824 cp /tmp/gsutil_QPc4Vj 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:23:45.414] process 1042 exited with code 0 after 0.0m
I1106 18:23:45.415] Call:  gsutil -q -h Content-Type:application/json cp /tmp/gsutil_pXUBZP gs://kubernetes-upstream/pr-logs/pull/sigs.k8s.io_azuredisk-csi-driver/180/chewong-pull-azuredisk-csi-driver-e2e-multi-az/1192145172217991168/finished.json
I1106 18:23:46.520] process 1222 exited with code 0 after 0.0m
I1106 18:23:46.520] Call:  gsutil -q -h Content-Type:text/plain -h 'Cache-Control:private, max-age=0, no-transform' cp /tmp/gsutil_3Afrnu 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:23:47.799] process 1402 exited with code 0 after 0.0m
I1106 18:23:47.800] Call:  gsutil -q -h Content-Type:text/plain -h 'Cache-Control:private, max-age=0, no-transform' cp /tmp/gsutil_fbP7LM gs://kubernetes-upstream/pr-logs/directory/chewong-pull-azuredisk-csi-driver-e2e-multi-az/latest-build.txt
I1106 18:23:49.005] process 1582 exited with code 0 after 0.0m