W1113 19:24:58.834] ************************************************************************** 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 ************************************************************************** I1113 19:24:58.835] Args: --job=chewong-pull-in-tree-azure-disk-e2e --service-account=/etc/service-account/service-account.json --upload=gs://kubernetes-jenkins/logs --job=chewong-pull-in-tree-azure-disk-e2e --root=/go/src --service-account=/etc/service-account/service-account.json --repo=k8s.io/kubernetes --repo=sigs.k8s.io/azuredisk-csi-driver=master:a6a3e9b4c8eb15f983b9cfc34935ebd72f18b698,188:463a1299807122c7d9e078a5bb09bb13492c20cf --upload=gs://kubernetes-upstream/pr-logs --timeout=460 --scenario=kubernetes_e2e -- --gce-ssh= --test=true --up=true --down=true --deployment=acsengine --build=host-go --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_DS2_v2 --acsengine-hyperkube=True --acsengine-location=westus2 '--acsengine-public-key=$AZURE_SSH_PUBLIC_KEY_FILE' --acsengine-template-url=https://raw.githubusercontent.com/Azure/aks-engine/master/examples/kubernetes.json --acsengine-download-url=https://chuwontest.blob.core.windows.net/aks-engine/aks-engine-8cf7c2a74-linux-amd64.tar.gz --timeout=420m I1113 19:24:58.835] Bootstrap chewong-pull-in-tree-azure-disk-e2e... I1113 19:24:58.838] Builder: 38d1efd4-064b-11ea-b3d3-b20db476995a I1113 19:24:58.839] Image: gcr.io/k8s-testimages/kubekins-e2e:v20191112-9f04410-master I1113 19:24:58.839] Gubernator results at https://gubernator.k8s.io/build/kubernetes-upstream/pr-logs/pull/sigs.k8s.io_azuredisk-csi-driver/188/chewong-pull-in-tree-azure-disk-e2e/1194697615929774080 I1113 19:24:58.839] Call: gcloud auth activate-service-account --key-file=/etc/service-account/service-account.json W1113 19:24:59.300] Activated service account credentials for: [kubernetes-upstream@kubernetes-upstream.iam.gserviceaccount.com] I1113 19:24:59.331] process 192 exited with code 0 after 0.0m I1113 19:24:59.331] Call: gcloud config get-value account I1113 19:24:59.555] process 204 exited with code 0 after 0.0m I1113 19:24:59.556] Will upload results to gs://kubernetes-upstream/pr-logs using kubernetes-upstream@kubernetes-upstream.iam.gserviceaccount.com I1113 19:24:59.556] Root: /go/src I1113 19:24:59.556] cd to /go/src I1113 19:24:59.556] Checkout: /go/src/k8s.io/kubernetes master to /go/src/k8s.io/kubernetes I1113 19:24:59.556] Call: git init k8s.io/kubernetes I1113 19:24:59.560] Initialized empty Git repository in /go/src/k8s.io/kubernetes/.git/ I1113 19:24:59.560] process 216 exited with code 0 after 0.0m I1113 19:24:59.560] Call: git config --local user.name 'K8S Bootstrap' I1113 19:24:59.563] process 217 exited with code 0 after 0.0m I1113 19:24:59.563] Call: git config --local user.email k8s_bootstrap@localhost I1113 19:24:59.565] process 218 exited with code 0 after 0.0m I1113 19:24:59.565] Call: git fetch --quiet --tags https://github.com/kubernetes/kubernetes master I1113 19:25:57.951] process 219 exited with code 0 after 1.0m I1113 19:25:57.952] Call: git checkout -B test FETCH_HEAD W1113 19:25:59.864] Switched to a new branch 'test' I1113 19:25:59.874] process 230 exited with code 0 after 0.0m I1113 19:25:59.874] Call: git show -s --format=format:%ct HEAD I1113 19:25:59.877] process 231 exited with code 0 after 0.0m I1113 19:25:59.877] Checkout: /go/src/sigs.k8s.io/azuredisk-csi-driver master:a6a3e9b4c8eb15f983b9cfc34935ebd72f18b698,188:463a1299807122c7d9e078a5bb09bb13492c20cf to /go/src/sigs.k8s.io/azuredisk-csi-driver I1113 19:25:59.877] Call: git init sigs.k8s.io/azuredisk-csi-driver I1113 19:25:59.880] Initialized empty Git repository in /go/src/sigs.k8s.io/azuredisk-csi-driver/.git/ I1113 19:25:59.880] process 232 exited with code 0 after 0.0m I1113 19:25:59.880] Call: git config --local user.name 'K8S Bootstrap' I1113 19:25:59.883] process 233 exited with code 0 after 0.0m I1113 19:25:59.883] Call: git config --local user.email k8s_bootstrap@localhost I1113 19:25:59.885] process 234 exited with code 0 after 0.0m I1113 19:25:59.885] Call: git fetch --quiet --tags https://github.com/kubernetes-sigs/azuredisk-csi-driver master +refs/pull/188/head:refs/pr/188 I1113 19:26:05.968] process 235 exited with code 0 after 0.1m I1113 19:26:05.968] Call: git checkout -B test a6a3e9b4c8eb15f983b9cfc34935ebd72f18b698 W1113 19:26:06.487] Switched to a new branch 'test' I1113 19:26:06.491] process 246 exited with code 0 after 0.0m I1113 19:26:06.491] Call: git show -s --format=format:%ct HEAD I1113 19:26:06.494] process 247 exited with code 0 after 0.0m I1113 19:26:06.495] Call: git merge --no-ff -m 'Merge +refs/pull/188/head:refs/pr/188' 463a1299807122c7d9e078a5bb09bb13492c20cf I1113 19:26:07.155] Merge made by the 'recursive' strategy. I1113 19:26:07.157] ...{safe_mounter_linux.go => safe_mounter_unix.go} | 2 +- I1113 19:26:07.157] test/e2e/README.md | 9 +- I1113 19:26:07.157] test/e2e/driver/azuredisk_csi_driver.go | 23 +++- I1113 19:26:07.158] test/e2e/suite_test.go | 119 +++++++++++---------- I1113 19:26:07.158] 4 files changed, 89 insertions(+), 64 deletions(-) I1113 19:26:07.158] rename pkg/mounter/{safe_mounter_linux.go => safe_mounter_unix.go} (97%) I1113 19:26:07.158] process 248 exited with code 0 after 0.0m I1113 19:26:07.158] Configure environment... I1113 19:26:07.159] Call: git show -s --format=format:%ct HEAD I1113 19:26:07.161] process 264 exited with code 0 after 0.0m I1113 19:26:07.162] Call: gcloud auth activate-service-account --key-file=/etc/service-account/service-account.json W1113 19:26:07.737] Activated service account credentials for: [kubernetes-upstream@kubernetes-upstream.iam.gserviceaccount.com] I1113 19:26:07.849] process 265 exited with code 0 after 0.0m I1113 19:26:07.849] Call: gcloud config get-value account I1113 19:26:08.072] process 277 exited with code 0 after 0.0m I1113 19:26:08.072] Will upload results to gs://kubernetes-upstream/pr-logs using kubernetes-upstream@kubernetes-upstream.iam.gserviceaccount.com I1113 19:26:08.072] Call: bash -c ' set -o errexit set -o nounset export KUBE_ROOT=. source hack/lib/version.sh kube::version::get_version_vars echo $KUBE_GIT_VERSION ' I1113 19:26:08.810] process 289 exited with code 0 after 0.0m I1113 19:26:08.810] Start 1194697615929774080 at v1.18.0-alpha.0.789+e7ce8d8a6f82a3... I1113 19:26:08.812] Call: gsutil -q -h Content-Type:application/json cp /tmp/gsutil_V7Wqjp gs://kubernetes-upstream/pr-logs/pull/sigs.k8s.io_azuredisk-csi-driver/188/chewong-pull-in-tree-azure-disk-e2e/1194697615929774080/started.json I1113 19:26:10.245] process 322 exited with code 0 after 0.0m I1113 19:26:10.246] Call: gsutil -q -h Content-Type:text/plain -h 'x-goog-meta-link: gs://kubernetes-upstream/pr-logs/pull/sigs.k8s.io_azuredisk-csi-driver/188/chewong-pull-in-tree-azure-disk-e2e/1194697615929774080' cp /tmp/gsutil_eh9vUL gs://kubernetes-upstream/pr-logs/directory/chewong-pull-in-tree-azure-disk-e2e/1194697615929774080.txt I1113 19:26:11.436] process 502 exited with code 0 after 0.0m I1113 19:26:11.437] Call: /workspace/./test-infra/jenkins/../scenarios/kubernetes_e2e.py --gce-ssh= --test=true --up=true --down=true --deployment=acsengine --build=host-go --provider=skeleton --ginkgo-parallel=1 --acsengine-agentpoolcount=2 --acsengine-admin-username=azureuser --acsengine-creds=/etc/azure-cred/credentials --acsengine-orchestratorRelease=1.16 --acsengine-mastervmsize=Standard_DS2_v2 --acsengine-agentvmsize=Standard_DS2_v2 --acsengine-hyperkube=True --acsengine-location=westus2 --acsengine-public-key=/etc/azure-ssh/azure-ssh-pub --acsengine-template-url=https://raw.githubusercontent.com/Azure/aks-engine/master/examples/kubernetes.json --acsengine-download-url=https://chuwontest.blob.core.windows.net/aks-engine/aks-engine-8cf7c2a74-linux-amd64.tar.gz --timeout=420m W1113 19:26:11.472] starts with local mode W1113 19:26:11.472] Environment: W1113 19:26:11.472] ARTIFACTS=/workspace/_artifacts W1113 19:26:11.472] AWS_SSH_PRIVATE_KEY_FILE=/root/.ssh/kube_aws_rsa W1113 19:26:11.472] AWS_SSH_PUBLIC_KEY_FILE=/root/.ssh/kube_aws_rsa.pub W1113 19:26:11.472] AZURE_CREDENTIALS=/etc/azure-cred/credentials W1113 19:26:11.473] AZURE_SSH_PUBLIC_KEY_FILE=/etc/azure-ssh/azure-ssh-pub W1113 19:26:11.473] AZURE_STORAGE_DRIVER=kubernetes.io/azure-disk W1113 19:26:11.473] AZ_STORAGE_CONTAINER_NAME=mystoragecontainer W1113 19:26:11.473] BAZEL_REMOTE_CACHE_ENABLED=false W1113 19:26:11.473] BAZEL_VERSION=0.23.2 W1113 19:26:11.474] BOOTSTRAP_MIGRATION=yes W1113 19:26:11.474] BUILD_ID=1194697615929774080 W1113 19:26:11.474] BUILD_NUMBER=1194697615929774080 W1113 19:26:11.474] CLOUDSDK_COMPONENT_MANAGER_DISABLE_UPDATE_CHECK=true W1113 19:26:11.474] CLOUDSDK_CONFIG=/go/src/k8s.io/kubernetes/.config/gcloud W1113 19:26:11.474] CLOUDSDK_CORE_DISABLE_PROMPTS=1 W1113 19:26:11.474] CLOUDSDK_EXPERIMENTAL_FAST_COMPONENT_UPDATE=false W1113 19:26:11.475] CLOUD_CONFIG=random W1113 19:26:11.475] DECK_PORT=tcp://10.0.160.83:80 W1113 19:26:11.475] DECK_PORT_80_TCP=tcp://10.0.160.83:80 W1113 19:26:11.475] DECK_PORT_80_TCP_ADDR=10.0.160.83 W1113 19:26:11.475] DECK_PORT_80_TCP_PORT=80 W1113 19:26:11.475] DECK_PORT_80_TCP_PROTO=tcp W1113 19:26:11.476] DECK_SERVICE_HOST=10.0.160.83 W1113 19:26:11.476] DECK_SERVICE_PORT=80 W1113 19:26:11.476] DOCKER_IN_DOCKER_ENABLED=true W1113 19:26:11.476] DOCKER_IN_DOCKER_IPV6_ENABLED=false W1113 19:26:11.476] GCS_ARTIFACTS_DIR=gs://kubernetes-upstream/pr-logs/pull/sigs.k8s.io_azuredisk-csi-driver/188/chewong-pull-in-tree-azure-disk-e2e/1194697615929774080/artifacts W1113 19:26:11.476] GOOGLE_APPLICATION_CREDENTIALS=/etc/service-account/service-account.json W1113 19:26:11.477] GOPATH=/go W1113 19:26:11.477] GO_TARBALL=go1.12.12.linux-amd64.tar.gz W1113 19:26:11.477] HOME=/workspace W1113 19:26:11.478] HOOK_PORT=tcp://10.0.144.133:8888 W1113 19:26:11.478] HOOK_PORT_8888_TCP=tcp://10.0.144.133:8888 W1113 19:26:11.478] HOOK_PORT_8888_TCP_ADDR=10.0.144.133 W1113 19:26:11.478] HOOK_PORT_8888_TCP_PORT=8888 W1113 19:26:11.478] HOOK_PORT_8888_TCP_PROTO=tcp W1113 19:26:11.478] HOOK_SERVICE_HOST=10.0.144.133 W1113 19:26:11.478] HOOK_SERVICE_PORT=8888 W1113 19:26:11.478] HOSTNAME=38d1efd4-064b-11ea-b3d3-b20db476995a W1113 19:26:11.479] IMAGE=gcr.io/k8s-testimages/kubekins-e2e:v20191112-9f04410-master W1113 19:26:11.479] INSTANCE_PREFIX=bootstrap-e2e W1113 19:26:11.479] JENKINS_GCE_SSH_PRIVATE_KEY_FILE=/root/.ssh/google_compute_engine W1113 19:26:11.479] JENKINS_GCE_SSH_PUBLIC_KEY_FILE=/root/.ssh/google_compute_engine.pub W1113 19:26:11.479] JOB_NAME=chewong-pull-in-tree-azure-disk-e2e W1113 19:26:11.480] JOB_SPEC={"type":"presubmit","job":"chewong-pull-in-tree-azure-disk-e2e","buildid":"1194697615929774080","prowjobid":"38d1efd4-064b-11ea-b3d3-b20db476995a","refs":{"org":"Azure","repo":"kubernetes","repo_link":"https://github.com/Azure/kubernetes","base_ref":"master","base_sha":"e7ce8d8a6f82a366a94ee7eb2a29b023cb361007","base_link":"https://github.com/Azure/kubernetes/commit/e7ce8d8a6f82a366a94ee7eb2a29b023cb361007","pulls":[{"number":113,"author":"chewong","sha":"879465972041635fd7bc8269da49153b67e63822","link":"https://github.com/Azure/kubernetes/pull/113","commit_link":"https://github.com/Azure/kubernetes/pull/113/commits/879465972041635fd7bc8269da49153b67e63822","author_link":"https://github.com/chewong"}]}} W1113 19:26:11.480] JOB_TYPE=presubmit W1113 19:26:11.480] KUBERNETES_PORT=tcp://10.0.0.1:443 W1113 19:26:11.480] KUBERNETES_PORT_443_TCP=tcp://10.0.0.1:443 W1113 19:26:11.480] KUBERNETES_PORT_443_TCP_ADDR=10.0.0.1 W1113 19:26:11.480] KUBERNETES_PORT_443_TCP_PORT=443 W1113 19:26:11.480] KUBERNETES_PORT_443_TCP_PROTO=tcp W1113 19:26:11.480] KUBERNETES_SERVICE_HOST=10.0.0.1 W1113 19:26:11.480] KUBERNETES_SERVICE_PORT=443 W1113 19:26:11.481] KUBERNETES_SERVICE_PORT_HTTPS=443 W1113 19:26:11.481] KUBETEST_IN_DOCKER=true W1113 19:26:11.482] KUBETEST_MANUAL_DUMP=y W1113 19:26:11.482] KUBE_AWS_INSTANCE_PREFIX=bootstrap-e2e W1113 19:26:11.482] KUBE_GCE_INSTANCE_PREFIX=bootstrap-e2e W1113 19:26:11.482] KUBE_SSH_KEY_PATH=/etc/ssh-key-secret/ssh-private W1113 19:26:11.482] KUBE_SSH_PUBLIC_KEY_PATH=/etc/ssh-key-secret/ssh-public W1113 19:26:11.482] KUBE_SSH_USER=azureuser W1113 19:26:11.482] KUBE_VERBOSE=0 W1113 19:26:11.482] NODE_NAME=38d1efd4-064b-11ea-b3d3-b20db476995a W1113 19:26:11.483] PATH=/go/bin:/go/bin:/usr/local/go/bin:/google-cloud-sdk/bin:/workspace:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin W1113 19:26:11.483] PROW_JOB_ID=38d1efd4-064b-11ea-b3d3-b20db476995a W1113 19:26:11.483] PULL_BASE_REF=master W1113 19:26:11.483] PULL_BASE_SHA=e7ce8d8a6f82a366a94ee7eb2a29b023cb361007 W1113 19:26:11.483] PULL_NUMBER=113 W1113 19:26:11.483] PULL_PULL_SHA=879465972041635fd7bc8269da49153b67e63822 W1113 19:26:11.483] PULL_REFS=master:e7ce8d8a6f82a366a94ee7eb2a29b023cb361007,113:879465972041635fd7bc8269da49153b67e63822 W1113 19:26:11.483] PWD=/workspace W1113 19:26:11.484] REGISTRY=k8sprowinternal.azurecr.io W1113 19:26:11.484] REPO_NAME=kubernetes W1113 19:26:11.484] REPO_OWNER=Azure W1113 19:26:11.484] SHLVL=2 W1113 19:26:11.484] SOURCE_DATE_EPOCH=1573669339 W1113 19:26:11.484] TERM=xterm W1113 19:26:11.484] TIDE_PORT=tcp://10.0.180.53:80 W1113 19:26:11.484] TIDE_PORT_80_TCP=tcp://10.0.180.53:80 W1113 19:26:11.484] TIDE_PORT_80_TCP_ADDR=10.0.180.53 W1113 19:26:11.484] TIDE_PORT_80_TCP_PORT=80 W1113 19:26:11.484] TIDE_PORT_80_TCP_PROTO=tcp W1113 19:26:11.485] TIDE_SERVICE_HOST=10.0.180.53 W1113 19:26:11.485] TIDE_SERVICE_PORT=80 W1113 19:26:11.485] WORKSPACE=/workspace W1113 19:26:11.485] _=./test-infra/jenkins/bootstrap.py W1113 19:26:11.485] Run: ('kubetest', '--dump=/workspace/_artifacts', '--gcp-service-account=/etc/service-account/service-account.json', '--build=host-go', '--up', '--down', '--test', '--deployment=acsengine', '--provider=skeleton', '--cluster=bootstrap-e2e', '--gcp-network=bootstrap-e2e', '--ginkgo-parallel=1', '--acsengine-agentpoolcount=2', '--acsengine-admin-username=azureuser', '--acsengine-creds=/etc/azure-cred/credentials', '--acsengine-orchestratorRelease=1.16', '--acsengine-mastervmsize=Standard_DS2_v2', '--acsengine-agentvmsize=Standard_DS2_v2', '--acsengine-hyperkube=True', '--acsengine-location=westus2', '--acsengine-public-key=/etc/azure-ssh/azure-ssh-pub', '--acsengine-template-url=https://raw.githubusercontent.com/Azure/aks-engine/master/examples/kubernetes.json', '--acsengine-download-url=https://chuwontest.blob.core.windows.net/aks-engine/aks-engine-8cf7c2a74-linux-amd64.tar.gz', '--timeout=420m') W1113 19:26:11.488] 2019/11/13 19:26:11 main.go:332: Limiting testing to 7h0m0s W1113 19:26:11.490] 2019/11/13 19:26:11 azure.go:232: Reading credentials file /etc/azure-cred/credentials W1113 19:26:11.490] 2019/11/13 19:26:11 process.go:153: Running: make -C /go/src/k8s.io/kubernetes all I1113 19:26:11.591] make: Entering directory '/go/src/k8s.io/kubernetes' I1113 19:26:11.591] make[1]: Entering directory '/go/src/k8s.io/kubernetes' I1113 19:26:18.487] +++ [1113 19:26:18] Building go targets for linux/amd64: I1113 19:26:18.487] ./vendor/k8s.io/code-generator/cmd/deepcopy-gen I1113 19:26:24.996] +++ [1113 19:26:24] Building go targets for linux/amd64: I1113 19:26:24.996] ./vendor/k8s.io/code-generator/cmd/defaulter-gen I1113 19:26:30.088] +++ [1113 19:26:30] Building go targets for linux/amd64: I1113 19:26:30.088] ./vendor/k8s.io/code-generator/cmd/conversion-gen I1113 19:26:39.513] +++ [1113 19:26:39] Building go targets for linux/amd64: I1113 19:26:39.513] ./vendor/k8s.io/kube-openapi/cmd/openapi-gen I1113 19:26:51.011] +++ [1113 19:26:51] Building go targets for linux/amd64: I1113 19:26:51.011] ./vendor/github.com/go-bindata/go-bindata/go-bindata I1113 19:26:52.159] make[1]: Leaving directory '/go/src/k8s.io/kubernetes' I1113 19:26:52.440] +++ [1113 19:26:52] Building go targets for linux/amd64: I1113 19:26:52.440] cmd/kube-proxy I1113 19:26:52.440] cmd/kube-apiserver I1113 19:26:52.440] cmd/kube-controller-manager I1113 19:26:52.440] cmd/kubelet I1113 19:26:52.440] cmd/kubeadm I1113 19:26:52.440] cmd/kube-scheduler I1113 19:26:52.441] vendor/k8s.io/apiextensions-apiserver I1113 19:26:52.441] cluster/gce/gci/mounter I1113 19:26:52.441] cmd/kubectl I1113 19:26:52.441] cmd/gendocs I1113 19:26:52.441] cmd/genkubedocs I1113 19:26:52.441] cmd/genman I1113 19:26:52.441] cmd/genyaml I1113 19:26:52.441] cmd/genswaggertypedocs I1113 19:26:52.442] cmd/linkcheck I1113 19:26:52.442] vendor/github.com/onsi/ginkgo/ginkgo I1113 19:26:52.442] test/e2e/e2e.test I1113 19:26:52.442] cluster/images/conformance/go-runner I1113 19:26:52.442] cmd/kubemark I1113 19:26:52.442] vendor/github.com/onsi/ginkgo/ginkgo I1113 19:26:52.442] test/e2e_node/e2e_node.test I1113 19:31:05.258] make: Leaving directory '/go/src/k8s.io/kubernetes' W1113 19:31:05.360] 2019/11/13 19:31:05 process.go:155: Step 'make -C /go/src/k8s.io/kubernetes all' finished in 4m53.767442528s W1113 19:31:05.360] 2019/11/13 19:31:05 util.go:265: Flushing memory. W1113 19:31:25.018] 2019/11/13 19:31:25 azure.go:916: Deleting resource group: kubetest-734be7fa-064b-11ea-b44f-0242e925600d. W1113 19:31:25.483] 2019/11/13 19:31:25 azure.go:654: CWD /go/src/k8s.io/kubernetes W1113 19:31:25.484] 2019/11/13 19:31:25 azure.go:673: Attempting Docker login with azure cred. W1113 19:31:33.214] 2019/11/13 19:31:33 azure.go:922: Skippng DumpClusterLogs due to CCM not being enabled. W1113 19:31:33.214] 2019/11/13 19:31:33 azure.go:916: Deleting resource group: kubetest-734be7fa-064b-11ea-b44f-0242e925600d. W1113 19:31:33.227] 2019/11/13 19:31:33 process.go:96: Saved XML output to /workspace/_artifacts/junit_runner.xml. W1113 19:31:33.227] 2019/11/13 19:31:33 process.go:153: Running: bash -c . hack/lib/version.sh && KUBE_ROOT=. kube::version::get_version_vars && echo "${KUBE_GIT_VERSION-}" W1113 19:31:34.397] 2019/11/13 19:31:34 process.go:155: Step 'bash -c . hack/lib/version.sh && KUBE_ROOT=. kube::version::get_version_vars && echo "${KUBE_GIT_VERSION-}"' finished in 1.169860998s W1113 19:31:34.397] 2019/11/13 19:31:34 main.go:319: Something went wrong: starting e2e cluster: error building hyperkube failed Docker login with error: exit status 1 W1113 19:31:34.400] Traceback (most recent call last): W1113 19:31:34.400] File "/workspace/./test-infra/jenkins/../scenarios/kubernetes_e2e.py", line 778, in W1113 19:31:34.401] main(parse_args()) W1113 19:31:34.401] File "/workspace/./test-infra/jenkins/../scenarios/kubernetes_e2e.py", line 626, in main W1113 19:31:34.401] mode.start(runner_args) W1113 19:31:34.401] File "/workspace/./test-infra/jenkins/../scenarios/kubernetes_e2e.py", line 262, in start W1113 19:31:34.401] check_env(env, self.command, *args) W1113 19:31:34.401] File "/workspace/./test-infra/jenkins/../scenarios/kubernetes_e2e.py", line 111, in check_env W1113 19:31:34.402] subprocess.check_call(cmd, env=env) W1113 19:31:34.402] File "/usr/lib/python2.7/subprocess.py", line 190, in check_call W1113 19:31:34.402] raise CalledProcessError(retcode, cmd) W1113 19:31:34.402] subprocess.CalledProcessError: Command '('kubetest', '--dump=/workspace/_artifacts', '--gcp-service-account=/etc/service-account/service-account.json', '--build=host-go', '--up', '--down', '--test', '--deployment=acsengine', '--provider=skeleton', '--cluster=bootstrap-e2e', '--gcp-network=bootstrap-e2e', '--ginkgo-parallel=1', '--acsengine-agentpoolcount=2', '--acsengine-admin-username=azureuser', '--acsengine-creds=/etc/azure-cred/credentials', '--acsengine-orchestratorRelease=1.16', '--acsengine-mastervmsize=Standard_DS2_v2', '--acsengine-agentvmsize=Standard_DS2_v2', '--acsengine-hyperkube=True', '--acsengine-location=westus2', '--acsengine-public-key=/etc/azure-ssh/azure-ssh-pub', '--acsengine-template-url=https://raw.githubusercontent.com/Azure/aks-engine/master/examples/kubernetes.json', '--acsengine-download-url=https://chuwontest.blob.core.windows.net/aks-engine/aks-engine-8cf7c2a74-linux-amd64.tar.gz', '--timeout=420m')' returned non-zero exit status 1 E1113 19:31:34.412] Command failed I1113 19:31:34.412] process 682 exited with code 1 after 5.4m E1113 19:31:34.412] FAIL: chewong-pull-in-tree-azure-disk-e2e I1113 19:31:34.413] Call: gcloud auth activate-service-account --key-file=/etc/service-account/service-account.json W1113 19:31:35.148] Activated service account credentials for: [kubernetes-upstream@kubernetes-upstream.iam.gserviceaccount.com] I1113 19:31:35.180] process 13318 exited with code 0 after 0.0m I1113 19:31:35.180] Call: gcloud config get-value account I1113 19:31:35.408] process 13330 exited with code 0 after 0.0m I1113 19:31:35.408] Will upload results to gs://kubernetes-upstream/pr-logs using kubernetes-upstream@kubernetes-upstream.iam.gserviceaccount.com I1113 19:31:35.408] Upload result and artifacts... I1113 19:31:35.408] Gubernator results at https://gubernator.k8s.io/build/kubernetes-upstream/pr-logs/pull/sigs.k8s.io_azuredisk-csi-driver/188/chewong-pull-in-tree-azure-disk-e2e/1194697615929774080 I1113 19:31:35.408] Call: gsutil ls gs://kubernetes-upstream/pr-logs/pull/sigs.k8s.io_azuredisk-csi-driver/188/chewong-pull-in-tree-azure-disk-e2e/1194697615929774080/artifacts W1113 19:31:36.447] CommandException: One or more URLs matched no objects. E1113 19:31:36.516] Command failed I1113 19:31:36.516] process 13342 exited with code 1 after 0.0m W1113 19:31:36.516] Remote dir gs://kubernetes-upstream/pr-logs/pull/sigs.k8s.io_azuredisk-csi-driver/188/chewong-pull-in-tree-azure-disk-e2e/1194697615929774080/artifacts not exist yet I1113 19:31:36.517] Call: gsutil -m -q -o GSUtil:use_magicfile=True cp -r -c -z log,txt,xml /workspace/_artifacts gs://kubernetes-upstream/pr-logs/pull/sigs.k8s.io_azuredisk-csi-driver/188/chewong-pull-in-tree-azure-disk-e2e/1194697615929774080/artifacts I1113 19:31:38.595] process 13486 exited with code 0 after 0.0m I1113 19:31:38.596] Call: git rev-parse HEAD I1113 19:31:38.599] process 14012 exited with code 0 after 0.0m I1113 19:31:38.599] Call: git rev-parse HEAD I1113 19:31:38.604] process 14013 exited with code 0 after 0.0m I1113 19:31:38.605] Call: gsutil stat gs://kubernetes-upstream/pr-logs/directory/chewong-pull-in-tree-azure-disk-e2e/jobResultsCache.json W1113 19:31:39.416] No URLs matched: gs://kubernetes-upstream/pr-logs/directory/chewong-pull-in-tree-azure-disk-e2e/jobResultsCache.json I1113 19:31:39.417] process 14014 exited with code 1 after 0.0m I1113 19:31:39.417] Call: gsutil -q -h Content-Type:application/json -h x-goog-if-generation-match:0 cp /tmp/gsutil_BHvn6l gs://kubernetes-upstream/pr-logs/directory/chewong-pull-in-tree-azure-disk-e2e/jobResultsCache.json I1113 19:31:40.542] process 14158 exited with code 0 after 0.0m I1113 19:31:40.542] Call: gsutil stat gs://kubernetes-upstream/pr-logs/pull/sigs.k8s.io_azuredisk-csi-driver/188/chewong-pull-in-tree-azure-disk-e2e/jobResultsCache.json W1113 19:31:41.308] No URLs matched: gs://kubernetes-upstream/pr-logs/pull/sigs.k8s.io_azuredisk-csi-driver/188/chewong-pull-in-tree-azure-disk-e2e/jobResultsCache.json I1113 19:31:41.308] process 14338 exited with code 1 after 0.0m I1113 19:31:41.309] Call: gsutil -q -h Content-Type:application/json -h x-goog-if-generation-match:0 cp /tmp/gsutil_iERh2Q gs://kubernetes-upstream/pr-logs/pull/sigs.k8s.io_azuredisk-csi-driver/188/chewong-pull-in-tree-azure-disk-e2e/jobResultsCache.json I1113 19:31:42.520] process 14482 exited with code 0 after 0.0m I1113 19:31:42.521] Call: gsutil -q -h Content-Type:application/json cp /tmp/gsutil_atcOxA gs://kubernetes-upstream/pr-logs/pull/sigs.k8s.io_azuredisk-csi-driver/188/chewong-pull-in-tree-azure-disk-e2e/1194697615929774080/finished.json I1113 19:31:43.685] process 14662 exited with code 0 after 0.0m I1113 19:31:43.685] Call: gsutil -q -h Content-Type:text/plain -h 'Cache-Control:private, max-age=0, no-transform' cp /tmp/gsutil_jlCyVR gs://kubernetes-upstream/pr-logs/pull/sigs.k8s.io_azuredisk-csi-driver/188/chewong-pull-in-tree-azure-disk-e2e/latest-build.txt I1113 19:31:44.919] process 14842 exited with code 0 after 0.0m I1113 19:31:44.919] Call: gsutil -q -h Content-Type:text/plain -h 'Cache-Control:private, max-age=0, no-transform' cp /tmp/gsutil_EfgKzW gs://kubernetes-upstream/pr-logs/directory/chewong-pull-in-tree-azure-disk-e2e/latest-build.txt I1113 19:31:46.194] process 15022 exited with code 0 after 0.0m