W1113 23:06:01.565] ************************************************************************** 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 23:06:01.566] 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_D4s_v3 --acsengine-hyperkube=True --acsengine-location=westus2 '--acsengine-public-key=$AZURE_SSH_PUBLIC_KEY_FILE' --acsengine-template-url=https://raw.githubusercontent.com/kubernetes-sigs/azuredisk-csi-driver/master/test/e2e/manifest/in-tree.json --acsengine-download-url=https://chuwontest.blob.core.windows.net/aks-engine/aks-engine-8cf7c2a74-linux-amd64.tar.gz --test-azure-disk-csi-driver=True --timeout=420m I1113 23:06:01.566] Bootstrap chewong-pull-in-tree-azure-disk-e2e... I1113 23:06:01.570] Builder: 16d1b1f7-066a-11ea-918b-16773c0c7aed I1113 23:06:01.570] Image: gcr.io/k8s-testimages/kubekins-e2e:v20191112-9f04410-master I1113 23:06:01.570] 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/1194753232421785600 I1113 23:06:01.571] Call: gcloud auth activate-service-account --key-file=/etc/service-account/service-account.json W1113 23:06:02.101] Activated service account credentials for: [kubernetes-upstream@kubernetes-upstream.iam.gserviceaccount.com] I1113 23:06:02.135] process 192 exited with code 0 after 0.0m I1113 23:06:02.135] Call: gcloud config get-value account I1113 23:06:02.380] process 204 exited with code 0 after 0.0m I1113 23:06:02.380] Will upload results to gs://kubernetes-upstream/pr-logs using kubernetes-upstream@kubernetes-upstream.iam.gserviceaccount.com I1113 23:06:02.380] Root: /go/src I1113 23:06:02.380] cd to /go/src I1113 23:06:02.381] Checkout: /go/src/k8s.io/kubernetes master to /go/src/k8s.io/kubernetes I1113 23:06:02.381] Call: git init k8s.io/kubernetes I1113 23:06:02.385] Initialized empty Git repository in /go/src/k8s.io/kubernetes/.git/ I1113 23:06:02.385] process 216 exited with code 0 after 0.0m I1113 23:06:02.385] Call: git config --local user.name 'K8S Bootstrap' I1113 23:06:02.387] process 217 exited with code 0 after 0.0m I1113 23:06:02.388] Call: git config --local user.email k8s_bootstrap@localhost I1113 23:06:02.390] process 218 exited with code 0 after 0.0m I1113 23:06:02.390] Call: git fetch --quiet --tags https://github.com/kubernetes/kubernetes master I1113 23:07:10.975] process 219 exited with code 0 after 1.1m I1113 23:07:10.975] Call: git checkout -B test FETCH_HEAD W1113 23:07:13.282] Switched to a new branch 'test' I1113 23:07:13.291] process 230 exited with code 0 after 0.0m I1113 23:07:13.292] Call: git show -s --format=format:%ct HEAD I1113 23:07:13.302] process 231 exited with code 0 after 0.0m I1113 23:07:13.303] Checkout: /go/src/sigs.k8s.io/azuredisk-csi-driver master:a6a3e9b4c8eb15f983b9cfc34935ebd72f18b698,188:463a1299807122c7d9e078a5bb09bb13492c20cf to /go/src/sigs.k8s.io/azuredisk-csi-driver I1113 23:07:13.303] Call: git init sigs.k8s.io/azuredisk-csi-driver I1113 23:07:13.306] Initialized empty Git repository in /go/src/sigs.k8s.io/azuredisk-csi-driver/.git/ I1113 23:07:13.306] process 232 exited with code 0 after 0.0m I1113 23:07:13.307] Call: git config --local user.name 'K8S Bootstrap' I1113 23:07:13.309] process 233 exited with code 0 after 0.0m I1113 23:07:13.309] Call: git config --local user.email k8s_bootstrap@localhost I1113 23:07:13.311] process 234 exited with code 0 after 0.0m I1113 23:07:13.311] Call: git fetch --quiet --tags https://github.com/kubernetes-sigs/azuredisk-csi-driver master +refs/pull/188/head:refs/pr/188 I1113 23:07:20.407] process 235 exited with code 0 after 0.1m I1113 23:07:20.408] Call: git checkout -B test a6a3e9b4c8eb15f983b9cfc34935ebd72f18b698 W1113 23:07:20.938] Switched to a new branch 'test' I1113 23:07:20.941] process 246 exited with code 0 after 0.0m I1113 23:07:20.941] Call: git show -s --format=format:%ct HEAD I1113 23:07:20.944] process 247 exited with code 0 after 0.0m I1113 23:07:20.945] Call: git merge --no-ff -m 'Merge +refs/pull/188/head:refs/pr/188' 463a1299807122c7d9e078a5bb09bb13492c20cf I1113 23:07:21.706] Merge made by the 'recursive' strategy. I1113 23:07:21.709] ...{safe_mounter_linux.go => safe_mounter_unix.go} | 2 +- I1113 23:07:21.709] test/e2e/README.md | 9 +- I1113 23:07:21.709] test/e2e/driver/azuredisk_csi_driver.go | 23 +++- I1113 23:07:21.709] test/e2e/suite_test.go | 119 +++++++++++---------- I1113 23:07:21.710] 4 files changed, 89 insertions(+), 64 deletions(-) I1113 23:07:21.710] rename pkg/mounter/{safe_mounter_linux.go => safe_mounter_unix.go} (97%) I1113 23:07:21.710] process 248 exited with code 0 after 0.0m I1113 23:07:21.710] Configure environment... I1113 23:07:21.710] Call: git show -s --format=format:%ct HEAD I1113 23:07:21.721] process 264 exited with code 0 after 0.0m I1113 23:07:21.721] Call: gcloud auth activate-service-account --key-file=/etc/service-account/service-account.json W1113 23:07:22.485] Activated service account credentials for: [kubernetes-upstream@kubernetes-upstream.iam.gserviceaccount.com] I1113 23:07:22.588] process 265 exited with code 0 after 0.0m I1113 23:07:22.588] Call: gcloud config get-value account I1113 23:07:22.822] process 277 exited with code 0 after 0.0m I1113 23:07:22.822] Will upload results to gs://kubernetes-upstream/pr-logs using kubernetes-upstream@kubernetes-upstream.iam.gserviceaccount.com I1113 23:07:22.822] 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 23:07:23.229] process 289 exited with code 0 after 0.0m I1113 23:07:23.230] Start 1194753232421785600 at v1.18.0-alpha.0.840+8af6906d1f300f... I1113 23:07:23.231] Call: gsutil -q -h Content-Type:application/json cp /tmp/gsutil_ahylRJ gs://kubernetes-upstream/pr-logs/pull/sigs.k8s.io_azuredisk-csi-driver/188/chewong-pull-in-tree-azure-disk-e2e/1194753232421785600/started.json I1113 23:07:24.530] process 322 exited with code 0 after 0.0m I1113 23:07:24.531] 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/1194753232421785600' cp /tmp/gsutil_YPASH4 gs://kubernetes-upstream/pr-logs/directory/chewong-pull-in-tree-azure-disk-e2e/1194753232421785600.txt I1113 23:07:25.705] process 502 exited with code 0 after 0.0m I1113 23:07:25.706] 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_D4s_v3 --acsengine-hyperkube=True --acsengine-location=westus2 --acsengine-public-key=/etc/azure-ssh/azure-ssh-pub --acsengine-template-url=https://raw.githubusercontent.com/kubernetes-sigs/azuredisk-csi-driver/master/test/e2e/manifest/in-tree.json --acsengine-download-url=https://chuwontest.blob.core.windows.net/aks-engine/aks-engine-8cf7c2a74-linux-amd64.tar.gz --test-azure-disk-csi-driver=True --timeout=420m W1113 23:07:25.746] starts with local mode W1113 23:07:25.747] Environment: W1113 23:07:25.747] ARTIFACTS=/workspace/_artifacts W1113 23:07:25.747] AWS_SSH_PRIVATE_KEY_FILE=/root/.ssh/kube_aws_rsa W1113 23:07:25.747] AWS_SSH_PUBLIC_KEY_FILE=/root/.ssh/kube_aws_rsa.pub W1113 23:07:25.747] AZURE_CREDENTIALS=/etc/azure-cred/credentials W1113 23:07:25.747] AZURE_SSH_PUBLIC_KEY_FILE=/etc/azure-ssh/azure-ssh-pub W1113 23:07:25.748] AZURE_STORAGE_DRIVER=kubernetes.io/azure-disk W1113 23:07:25.748] AZ_STORAGE_CONTAINER_NAME=mystoragecontainer W1113 23:07:25.748] BAZEL_REMOTE_CACHE_ENABLED=false W1113 23:07:25.748] BAZEL_VERSION=0.23.2 W1113 23:07:25.748] BOOTSTRAP_MIGRATION=yes W1113 23:07:25.748] BUILD_ID=1194753232421785600 W1113 23:07:25.748] BUILD_NUMBER=1194753232421785600 W1113 23:07:25.748] CLOUDSDK_COMPONENT_MANAGER_DISABLE_UPDATE_CHECK=true W1113 23:07:25.749] CLOUDSDK_CONFIG=/go/src/k8s.io/kubernetes/.config/gcloud W1113 23:07:25.749] CLOUDSDK_CORE_DISABLE_PROMPTS=1 W1113 23:07:25.749] CLOUDSDK_EXPERIMENTAL_FAST_COMPONENT_UPDATE=false W1113 23:07:25.749] CLOUD_CONFIG=random W1113 23:07:25.749] DECK_PORT=tcp://10.0.160.83:80 W1113 23:07:25.749] DECK_PORT_80_TCP=tcp://10.0.160.83:80 W1113 23:07:25.749] DECK_PORT_80_TCP_ADDR=10.0.160.83 W1113 23:07:25.749] DECK_PORT_80_TCP_PORT=80 W1113 23:07:25.750] DECK_PORT_80_TCP_PROTO=tcp W1113 23:07:25.750] DECK_SERVICE_HOST=10.0.160.83 W1113 23:07:25.750] DECK_SERVICE_PORT=80 W1113 23:07:25.750] DOCKER_IN_DOCKER_ENABLED=true W1113 23:07:25.750] DOCKER_IN_DOCKER_IPV6_ENABLED=false W1113 23:07:25.750] GCS_ARTIFACTS_DIR=gs://kubernetes-upstream/pr-logs/pull/sigs.k8s.io_azuredisk-csi-driver/188/chewong-pull-in-tree-azure-disk-e2e/1194753232421785600/artifacts W1113 23:07:25.751] GOOGLE_APPLICATION_CREDENTIALS=/etc/service-account/service-account.json W1113 23:07:25.751] GOPATH=/go W1113 23:07:25.751] GO_TARBALL=go1.12.12.linux-amd64.tar.gz W1113 23:07:25.751] HOME=/workspace W1113 23:07:25.751] HOOK_PORT=tcp://10.0.144.133:8888 W1113 23:07:25.751] HOOK_PORT_8888_TCP=tcp://10.0.144.133:8888 W1113 23:07:25.751] HOOK_PORT_8888_TCP_ADDR=10.0.144.133 W1113 23:07:25.752] HOOK_PORT_8888_TCP_PORT=8888 W1113 23:07:25.752] HOOK_PORT_8888_TCP_PROTO=tcp W1113 23:07:25.752] HOOK_SERVICE_HOST=10.0.144.133 W1113 23:07:25.752] HOOK_SERVICE_PORT=8888 W1113 23:07:25.752] HOSTNAME=16d1b1f7-066a-11ea-918b-16773c0c7aed W1113 23:07:25.752] IMAGE=gcr.io/k8s-testimages/kubekins-e2e:v20191112-9f04410-master W1113 23:07:25.752] INSTANCE_PREFIX=bootstrap-e2e W1113 23:07:25.752] JENKINS_GCE_SSH_PRIVATE_KEY_FILE=/root/.ssh/google_compute_engine W1113 23:07:25.753] JENKINS_GCE_SSH_PUBLIC_KEY_FILE=/root/.ssh/google_compute_engine.pub W1113 23:07:25.753] JOB_NAME=chewong-pull-in-tree-azure-disk-e2e W1113 23:07:25.753] JOB_SPEC={"type":"presubmit","job":"chewong-pull-in-tree-azure-disk-e2e","buildid":"1194753232421785600","prowjobid":"16d1b1f7-066a-11ea-918b-16773c0c7aed","refs":{"org":"Azure","repo":"kubernetes","repo_link":"https://github.com/Azure/kubernetes","base_ref":"master","base_sha":"8af6906d1f300ff739ac1a846d4108d134412103","base_link":"https://github.com/Azure/kubernetes/commit/8af6906d1f300ff739ac1a846d4108d134412103","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 23:07:25.753] JOB_TYPE=presubmit W1113 23:07:25.753] KUBERNETES_PORT=tcp://10.0.0.1:443 W1113 23:07:25.753] KUBERNETES_PORT_443_TCP=tcp://10.0.0.1:443 W1113 23:07:25.754] KUBERNETES_PORT_443_TCP_ADDR=10.0.0.1 W1113 23:07:25.754] KUBERNETES_PORT_443_TCP_PORT=443 W1113 23:07:25.754] KUBERNETES_PORT_443_TCP_PROTO=tcp W1113 23:07:25.754] KUBERNETES_SERVICE_HOST=10.0.0.1 W1113 23:07:25.754] KUBERNETES_SERVICE_PORT=443 W1113 23:07:25.755] KUBERNETES_SERVICE_PORT_HTTPS=443 W1113 23:07:25.755] KUBETEST_IN_DOCKER=true W1113 23:07:25.755] KUBETEST_MANUAL_DUMP=y W1113 23:07:25.755] KUBE_AWS_INSTANCE_PREFIX=bootstrap-e2e W1113 23:07:25.755] KUBE_GCE_INSTANCE_PREFIX=bootstrap-e2e W1113 23:07:25.755] KUBE_SSH_KEY_PATH=/etc/ssh-key-secret/ssh-private W1113 23:07:25.755] KUBE_SSH_PUBLIC_KEY_PATH=/etc/ssh-key-secret/ssh-public W1113 23:07:25.755] KUBE_SSH_USER=azureuser W1113 23:07:25.755] KUBE_VERBOSE=0 W1113 23:07:25.755] NODE_NAME=16d1b1f7-066a-11ea-918b-16773c0c7aed W1113 23:07:25.756] 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 23:07:25.756] PROW_JOB_ID=16d1b1f7-066a-11ea-918b-16773c0c7aed W1113 23:07:25.756] PULL_BASE_REF=master W1113 23:07:25.756] PULL_BASE_SHA=8af6906d1f300ff739ac1a846d4108d134412103 W1113 23:07:25.756] PULL_NUMBER=113 W1113 23:07:25.756] PULL_PULL_SHA=879465972041635fd7bc8269da49153b67e63822 W1113 23:07:25.756] PULL_REFS=master:8af6906d1f300ff739ac1a846d4108d134412103,113:879465972041635fd7bc8269da49153b67e63822 W1113 23:07:25.756] PWD=/workspace W1113 23:07:25.756] REGISTRY=k8sprowinternal.azurecr.io W1113 23:07:25.756] REPO_NAME=kubernetes W1113 23:07:25.757] REPO_OWNER=Azure W1113 23:07:25.757] SHLVL=2 W1113 23:07:25.757] SOURCE_DATE_EPOCH=1573685531 W1113 23:07:25.757] TERM=xterm W1113 23:07:25.757] TIDE_PORT=tcp://10.0.180.53:80 W1113 23:07:25.757] TIDE_PORT_80_TCP=tcp://10.0.180.53:80 W1113 23:07:25.757] TIDE_PORT_80_TCP_ADDR=10.0.180.53 W1113 23:07:25.757] TIDE_PORT_80_TCP_PORT=80 W1113 23:07:25.757] TIDE_PORT_80_TCP_PROTO=tcp W1113 23:07:25.757] TIDE_SERVICE_HOST=10.0.180.53 W1113 23:07:25.758] TIDE_SERVICE_PORT=80 W1113 23:07:25.758] WORKSPACE=/workspace W1113 23:07:25.758] _=./test-infra/jenkins/bootstrap.py W1113 23:07:25.758] 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_D4s_v3', '--acsengine-hyperkube=True', '--acsengine-location=westus2', '--acsengine-public-key=/etc/azure-ssh/azure-ssh-pub', '--acsengine-template-url=https://raw.githubusercontent.com/kubernetes-sigs/azuredisk-csi-driver/master/test/e2e/manifest/in-tree.json', '--acsengine-download-url=https://chuwontest.blob.core.windows.net/aks-engine/aks-engine-8cf7c2a74-linux-amd64.tar.gz', '--test-azure-disk-csi-driver=True', '--timeout=420m') W1113 23:07:25.762] 2019/11/13 23:07:25 main.go:332: Limiting testing to 7h0m0s W1113 23:07:25.763] 2019/11/13 23:07:25 azure.go:232: Reading credentials file /etc/azure-cred/credentials W1113 23:07:25.763] 2019/11/13 23:07:25 process.go:153: Running: make -C /go/src/k8s.io/kubernetes all I1113 23:07:25.863] make: Entering directory '/go/src/k8s.io/kubernetes' I1113 23:07:25.863] make[1]: Entering directory '/go/src/k8s.io/kubernetes' I1113 23:07:34.435] +++ [1113 23:07:34] Building go targets for linux/amd64: I1113 23:07:34.435] ./vendor/k8s.io/code-generator/cmd/deepcopy-gen I1113 23:07:43.140] +++ [1113 23:07:43] Building go targets for linux/amd64: I1113 23:07:43.140] ./vendor/k8s.io/code-generator/cmd/defaulter-gen I1113 23:07:53.492] +++ [1113 23:07:53] Building go targets for linux/amd64: I1113 23:07:53.492] ./vendor/k8s.io/code-generator/cmd/conversion-gen I1113 23:08:05.558] +++ [1113 23:08:05] Building go targets for linux/amd64: I1113 23:08:05.558] ./vendor/k8s.io/kube-openapi/cmd/openapi-gen I1113 23:08:18.817] +++ [1113 23:08:18] Building go targets for linux/amd64: I1113 23:08:18.818] ./vendor/github.com/go-bindata/go-bindata/go-bindata I1113 23:08:20.199] make[1]: Leaving directory '/go/src/k8s.io/kubernetes' I1113 23:08:20.516] +++ [1113 23:08:20] Building go targets for linux/amd64: I1113 23:08:20.516] cmd/kube-proxy I1113 23:08:20.516] cmd/kube-apiserver I1113 23:08:20.516] cmd/kube-controller-manager I1113 23:08:20.516] cmd/kubelet I1113 23:08:20.516] cmd/kubeadm I1113 23:08:20.517] cmd/kube-scheduler I1113 23:08:20.517] vendor/k8s.io/apiextensions-apiserver I1113 23:08:20.517] cluster/gce/gci/mounter I1113 23:08:20.517] cmd/kubectl I1113 23:08:20.517] cmd/gendocs I1113 23:08:20.517] cmd/genkubedocs I1113 23:08:20.517] cmd/genman I1113 23:08:20.517] cmd/genyaml I1113 23:08:20.517] cmd/genswaggertypedocs I1113 23:08:20.518] cmd/linkcheck I1113 23:08:20.518] vendor/github.com/onsi/ginkgo/ginkgo I1113 23:08:20.518] test/e2e/e2e.test I1113 23:08:20.518] cluster/images/conformance/go-runner I1113 23:08:20.518] cmd/kubemark I1113 23:08:20.518] vendor/github.com/onsi/ginkgo/ginkgo I1113 23:08:20.518] test/e2e_node/e2e_node.test I1113 23:16:08.557] make: Leaving directory '/go/src/k8s.io/kubernetes' W1113 23:16:08.657] 2019/11/13 23:16:08 process.go:155: Step 'make -C /go/src/k8s.io/kubernetes all' finished in 8m42.794049152s W1113 23:16:08.657] 2019/11/13 23:16:08 util.go:265: Flushing memory. W1113 23:16:42.570] 2019/11/13 23:16:42 azure.go:916: Deleting resource group: kubetest-5b615a81-066a-11ea-9749-0242b772b122. W1113 23:16:43.016] 2019/11/13 23:16:43 azure.go:654: CWD /go/src/k8s.io/kubernetes W1113 23:16:43.016] 2019/11/13 23:16:43 azure.go:673: Attempting Docker login with azure cred. W1113 23:16:44.427] 2019/11/13 23:16:44 azure.go:682: Docker login success. W1113 23:16:44.427] 2019/11/13 23:16:44 azure.go:727: Building hyperkube. W1113 23:16:44.427] 2019/11/13 23:16:44 util.go:56: Warning: Couldn't find directory src/k8s.io/kubernetes/cmd/hyperkube under any of GOPATH /go, defaulting to /go/src/k8s.io/kubernetes/cmd/hyperkube W1113 23:16:44.427] 2019/11/13 23:16:44 azure.go:745: Pushing hyperkube. W1113 23:16:44.428] 2019/11/13 23:16:44 process.go:153: Running: make -C /go/src/k8s.io/kubernetes/cluster/images/hyperkube push I1113 23:16:44.528] make: Entering directory '/go/src/k8s.io/kubernetes/cluster/images/hyperkube' I1113 23:16:44.528] cp -r ./* /tmp/hyperkubekxV8ua I1113 23:16:44.528] tar -cvzf /tmp/hyperkubekxV8ua/binaries.tgz -C /go/src/k8s.io/kubernetes/cluster/images/hyperkube/../../../_output/local/bin/linux/amd64 kube-apiserver kube-controller-manager \ I1113 23:16:44.528] kube-proxy kube-scheduler kubectl kubelet I1113 23:16:44.529] kube-apiserver I1113 23:16:49.572] kube-controller-manager I1113 23:16:54.484] kube-proxy I1113 23:16:56.377] kube-scheduler I1113 23:16:58.496] kubectl I1113 23:17:00.722] kubelet I1113 23:17:05.790] chmod a+rx /tmp/hyperkubekxV8ua/hyperkube I1113 23:17:05.794] cd /tmp/hyperkubekxV8ua && sed -i.back "s|BASEIMAGE|k8s.gcr.io/debian-hyperkube-base-amd64:0.12.1|g" Dockerfile I1113 23:17:05.799] docker build --pull -t k8sprowinternal.azurecr.io/hyperkube-amd64:azure-e2e-1194753232421785600-a7876ac7 /tmp/hyperkubekxV8ua I1113 23:17:06.551] Sending build context to Docker daemon 122MB I1113 23:17:06.574] Step 1/4 : FROM k8s.gcr.io/debian-hyperkube-base-amd64:0.12.1 I1113 23:17:06.905] 0.12.1: Pulling from debian-hyperkube-base-amd64 I1113 23:17:06.906] 346aee5ea5bc: Pulling fs layer I1113 23:17:06.906] 9c47fde751af: Pulling fs layer I1113 23:17:06.906] be2693a52daf: Pulling fs layer I1113 23:17:06.906] 6b69eb11d043: Pulling fs layer I1113 23:17:06.907] 0abeb1500767: Pulling fs layer I1113 23:17:06.907] 4062d80041b7: Pulling fs layer I1113 23:17:06.907] 23b6daf06fc2: Pulling fs layer I1113 23:17:06.907] 4062d80041b7: Waiting I1113 23:17:06.907] 23b6daf06fc2: Waiting I1113 23:17:06.907] 0abeb1500767: Waiting I1113 23:17:06.907] 6b69eb11d043: Waiting I1113 23:17:07.044] 9c47fde751af: Verifying Checksum I1113 23:17:07.044] 9c47fde751af: Download complete I1113 23:17:07.119] be2693a52daf: Verifying Checksum I1113 23:17:07.120] be2693a52daf: Download complete I1113 23:17:07.182] 6b69eb11d043: Download complete I1113 23:17:07.254] 0abeb1500767: Verifying Checksum I1113 23:17:07.255] 0abeb1500767: Download complete I1113 23:17:07.287] 346aee5ea5bc: Verifying Checksum I1113 23:17:07.287] 346aee5ea5bc: Download complete I1113 23:17:07.639] 23b6daf06fc2: Verifying Checksum I1113 23:17:07.639] 23b6daf06fc2: Download complete I1113 23:17:08.442] 4062d80041b7: Verifying Checksum I1113 23:17:08.442] 4062d80041b7: Download complete I1113 23:17:08.725] 346aee5ea5bc: Pull complete I1113 23:17:08.935] 9c47fde751af: Pull complete I1113 23:17:09.179] be2693a52daf: Pull complete I1113 23:17:09.363] 6b69eb11d043: Pull complete I1113 23:17:09.564] 0abeb1500767: Pull complete I1113 23:17:16.185] 4062d80041b7: Pull complete I1113 23:17:19.551] 23b6daf06fc2: Pull complete I1113 23:17:19.598] Digest: sha256:5d4ea2fb5fbe9a9a9da74f67cf2faefc881968bc39f2ac5d62d9167e575812a1 I1113 23:17:19.635] Status: Downloaded newer image for k8s.gcr.io/debian-hyperkube-base-amd64:0.12.1 I1113 23:17:19.636] ---> a46476511725 I1113 23:17:19.636] Step 2/4 : ADD binaries.tgz /usr/local/bin I1113 23:18:00.952] ---> d4bebf779475 I1113 23:18:00.953] Step 3/4 : COPY hyperkube /hyperkube I1113 23:18:02.090] ---> 9834f003bd87 I1113 23:18:02.091] Step 4/4 : ENTRYPOINT ["/hyperkube"] I1113 23:18:02.286] ---> Running in 26a6fea8f3b4 I1113 23:18:03.109] Removing intermediate container 26a6fea8f3b4 I1113 23:18:03.109] ---> 4495691c0b8d I1113 23:18:03.125] Successfully built 4495691c0b8d I1113 23:18:03.254] Successfully tagged k8sprowinternal.azurecr.io/hyperkube-amd64:azure-e2e-1194753232421785600-a7876ac7 I1113 23:18:03.258] rm -rf "/tmp/hyperkubekxV8ua" I1113 23:18:03.278] docker push k8sprowinternal.azurecr.io/hyperkube-amd64:azure-e2e-1194753232421785600-a7876ac7 I1113 23:18:03.347] The push refers to repository [k8sprowinternal.azurecr.io/hyperkube-amd64] I1113 23:18:03.360] 17a2ad1bc805: Preparing I1113 23:18:03.360] ebbbb9aca7be: Preparing I1113 23:18:03.360] 39b3ac6d96e9: Preparing I1113 23:18:03.360] 7bbae4dddb88: Preparing I1113 23:18:03.360] a00defcfe869: Preparing I1113 23:18:03.360] 2ab0ae805c74: Preparing I1113 23:18:03.361] 43a8fe7d2382: Preparing I1113 23:18:03.361] 3f6a6f542637: Preparing I1113 23:18:03.361] 5ba3be777c2d: Preparing I1113 23:18:03.361] 2ab0ae805c74: Waiting I1113 23:18:03.361] 43a8fe7d2382: Waiting I1113 23:18:03.361] 3f6a6f542637: Waiting I1113 23:18:03.361] 5ba3be777c2d: Waiting I1113 23:18:03.576] a00defcfe869: Layer already exists I1113 23:18:03.623] 39b3ac6d96e9: Layer already exists I1113 23:18:03.671] 7bbae4dddb88: Layer already exists I1113 23:18:03.710] 2ab0ae805c74: Layer already exists I1113 23:18:03.745] 43a8fe7d2382: Layer already exists I1113 23:18:03.791] 3f6a6f542637: Layer already exists I1113 23:18:03.822] 17a2ad1bc805: Pushed I1113 23:18:03.870] 5ba3be777c2d: Layer already exists I1113 23:18:28.946] ebbbb9aca7be: Pushed I1113 23:18:29.701] azure-e2e-1194753232421785600-a7876ac7: digest: sha256:e889dd41cca6d213446fb4dee4a70cd1e2faddcd22f8087ff606c8605b17c008 size: 2206 I1113 23:18:29.717] docker rmi k8sprowinternal.azurecr.io/hyperkube:azure-e2e-1194753232421785600-a7876ac7 2>/dev/null || true I1113 23:18:29.763] docker tag k8sprowinternal.azurecr.io/hyperkube-amd64:azure-e2e-1194753232421785600-a7876ac7 k8sprowinternal.azurecr.io/hyperkube:azure-e2e-1194753232421785600-a7876ac7 I1113 23:18:29.831] docker push k8sprowinternal.azurecr.io/hyperkube:azure-e2e-1194753232421785600-a7876ac7 I1113 23:18:29.897] The push refers to repository [k8sprowinternal.azurecr.io/hyperkube] I1113 23:18:29.913] 17a2ad1bc805: Preparing I1113 23:18:29.914] ebbbb9aca7be: Preparing I1113 23:18:29.914] 39b3ac6d96e9: Preparing I1113 23:18:29.914] 7bbae4dddb88: Preparing I1113 23:18:29.914] a00defcfe869: Preparing I1113 23:18:29.914] 2ab0ae805c74: Preparing I1113 23:18:29.914] 43a8fe7d2382: Preparing I1113 23:18:29.915] 3f6a6f542637: Preparing I1113 23:18:29.915] 5ba3be777c2d: Preparing I1113 23:18:29.915] 2ab0ae805c74: Waiting I1113 23:18:29.915] 3f6a6f542637: Waiting I1113 23:18:29.915] 43a8fe7d2382: Waiting I1113 23:18:29.915] 5ba3be777c2d: Waiting I1113 23:18:30.033] a00defcfe869: Layer already exists I1113 23:18:30.067] 7bbae4dddb88: Layer already exists I1113 23:18:30.090] 39b3ac6d96e9: Layer already exists I1113 23:18:30.114] 2ab0ae805c74: Layer already exists I1113 23:18:30.116] ebbbb9aca7be: Mounted from hyperkube-amd64 I1113 23:18:30.137] 43a8fe7d2382: Layer already exists I1113 23:18:30.181] 17a2ad1bc805: Mounted from hyperkube-amd64 I1113 23:18:30.205] 3f6a6f542637: Layer already exists I1113 23:18:30.251] 5ba3be777c2d: Layer already exists I1113 23:18:30.803] azure-e2e-1194753232421785600-a7876ac7: digest: sha256:e889dd41cca6d213446fb4dee4a70cd1e2faddcd22f8087ff606c8605b17c008 size: 2206 I1113 23:18:30.818] make: Leaving directory '/go/src/k8s.io/kubernetes/cluster/images/hyperkube' W1113 23:18:30.919] 2019/11/13 23:18:30 process.go:155: Step 'make -C /go/src/k8s.io/kubernetes/cluster/images/hyperkube push' finished in 1m46.391301082s W1113 23:18:30.919] 2019/11/13 23:18:30 azure.go:686: Docker logout. W1113 23:18:30.919] 2019/11/13 23:18:30 azure.go:754: Custom hyperkube URL: k8sprowinternal.azurecr.io/hyperkube-amd64:azure-e2e-1194753232421785600-a7876ac7 . W1113 23:18:30.919] 2019/11/13 23:18:30 azure.go:797: downloading /workspace/aks801008964/kubernetes.json from https://raw.githubusercontent.com/kubernetes-sigs/azuredisk-csi-driver/master/test/e2e/manifest/in-tree.json. W1113 23:18:30.920] 2019/11/13 23:18:30 util.go:42: curl https://raw.githubusercontent.com/kubernetes-sigs/azuredisk-csi-driver/master/test/e2e/manifest/in-tree.json W1113 23:18:31.067] 2019/11/13 23:18:31 azure.go:529: downloading /workspace/aks-engine.tar.gz from https://chuwontest.blob.core.windows.net/aks-engine/aks-engine-8cf7c2a74-linux-amd64.tar.gz. W1113 23:18:31.067] 2019/11/13 23:18:31 util.go:42: curl https://chuwontest.blob.core.windows.net/aks-engine/aks-engine-8cf7c2a74-linux-amd64.tar.gz W1113 23:18:32.093] 2019/11/13 23:18:32 azure.go:556: Extracting tar file /workspace/aks-engine.tar.gz into directory /go/src/k8s.io/kubernetes . W1113 23:18:32.093] 2019/11/13 23:18:32 process.go:153: Running: tar -xzf /workspace/aks-engine.tar.gz --strip 1 W1113 23:18:32.212] 2019/11/13 23:18:32 process.go:155: Step 'tar -xzf /workspace/aks-engine.tar.gz --strip 1' finished in 118.797019ms W1113 23:18:32.212] 2019/11/13 23:18:32 process.go:153: Running: /go/src/k8s.io/kubernetes/aks-engine generate /workspace/aks801008964/kubernetes.json --output-directory /workspace/aks801008964 I1113 23:18:32.384] INFO[0000] Generating assets into /workspace/aks801008964... W1113 23:18:39.399] 2019/11/13 23:18:39 process.go:155: Step '/go/src/k8s.io/kubernetes/aks-engine generate /workspace/aks801008964/kubernetes.json --output-directory /workspace/aks801008964' finished in 7.18718102s W1113 23:18:39.402] 2019/11/13 23:18:39 azure.go:627: Setting kubeconfig env variable: kubeconfig path: /workspace/aks801008964/kubeconfig/kubeconfig.westus2.json. W1113 23:18:39.403] 2019/11/13 23:18:39 azure.go:629: Creating resource group: kubetest-5b615a81-066a-11ea-9749-0242b772b122. W1113 23:18:39.403] 2019/11/13 23:18:39 azure.go:631: Creating Azure resource group: kubetest-5b615a81-066a-11ea-9749-0242b772b122 for cluster deployment. W1113 23:18:39.612] 2019/11/13 23:18:39 azure.go:636: Validating deployment ARM templates. W1113 23:18:40.932] 2019/11/13 23:18:40 azure.go:642: Deploying cluster kubetest-5b615a81-066a-11ea-9749-0242b772b122 in resource group kubetest-5b615a81-066a-11ea-9749-0242b772b122. W1113 23:26:42.241] 2019/11/13 23:26:42 process.go:153: Running: kubectl --match-server-version=false version W1113 23:26:42.614] 2019/11/13 23:26:42 process.go:155: Step 'kubectl --match-server-version=false version' finished in 372.969788ms W1113 23:26:42.615] 2019/11/13 23:26:42 process.go:153: Running: kubectl --match-server-version=false get nodes -oyaml W1113 23:26:43.514] 2019/11/13 23:26:43 process.go:155: Step 'kubectl --match-server-version=false get nodes -oyaml' finished in 899.83867ms W1113 23:26:43.514] 2019/11/13 23:26:43 azure.go:980: KUBE_TEST_REPO_LIST_DOWNLOAD_LOCATION not set. Using default test image repos. W1113 23:26:43.515] 2019/11/13 23:26:43 azure.go:980: KUBE_TEST_REPO_LIST_DOWNLOAD_LOCATION not set. Using default test image repos. W1113 23:26:43.515] 2019/11/13 23:26:43 process.go:153: Running: kubectl get nodes --no-headers W1113 23:26:43.621] 2019/11/13 23:26:43 process.go:155: Step 'kubectl get nodes --no-headers' finished in 106.254423ms W1113 23:26:43.621] 2019/11/13 23:26:43 e2e.go:474: Cluster nodes: W1113 23:26:43.621] k8s-agentpool1-47782289-0 Ready 20s v1.18.0-alpha.0.840+8af6906d1f300f W1113 23:26:43.621] k8s-agentpool1-47782289-1 Ready 20s v1.18.0-alpha.0.840+8af6906d1f300f W1113 23:26:43.622] k8s-master-47782289-0 Ready 20s v1.18.0-alpha.0.840+8af6906d1f300f W1113 23:26:43.622] 2019/11/13 23:26:43 process.go:153: Running: kubectl --match-server-version=false version W1113 23:26:43.752] 2019/11/13 23:26:43 process.go:155: Step 'kubectl --match-server-version=false version' finished in 130.756213ms W1113 23:26:43.752] 2019/11/13 23:26:43 process.go:153: Running: make e2e-test I1113 23:26:43.853] go test -v -timeout=0 ./test/e2e "-ginkgo.noColor" I1113 23:28:10.454] === RUN TestE2E I1113 23:28:10.454] Running Suite: AzureDisk CSI Driver End-to-End Tests I1113 23:28:10.454] ==================================================== I1113 23:28:10.455] Random Seed: 1573687690 I1113 23:28:10.455] Will run 9 of 9 specs I1113 23:28:10.455] I1113 23:28:11.065] 2019/11/13 23:28:11 Attempting docker login with Azure service principal I1113 23:28:11.304] Nov 13 23:28:10.454: INFO: The --provider flag is not set. Continuing as if --provider=skeleton had been used. I1113 23:28:11.304] Failure [0.850 seconds] I1113 23:28:11.304] [BeforeSuite] BeforeSuite I1113 23:28:11.304] /go/src/sigs.k8s.io/azuredisk-csi-driver/test/e2e/suite_test.go:44 I1113 23:28:11.304] I1113 23:28:11.304] Unexpected error: I1113 23:28:11.305] <*exec.ExitError | 0xc000ab8780>: { I1113 23:28:11.305] ProcessState: { I1113 23:28:11.305] pid: 25629, I1113 23:28:11.305] status: 256, I1113 23:28:11.305] rusage: { I1113 23:28:11.305] Utime: {Sec: 0, Usec: 27390}, I1113 23:28:11.305] Stime: {Sec: 0, Usec: 36521}, I1113 23:28:11.305] Maxrss: 72508, I1113 23:28:11.306] Ixrss: 0, I1113 23:28:11.306] Idrss: 0, I1113 23:28:11.306] Isrss: 0, I1113 23:28:11.306] Minflt: 6329, I1113 23:28:11.306] Majflt: 2, I1113 23:28:11.306] Nswap: 0, I1113 23:28:11.306] Inblock: 208, I1113 23:28:11.306] Oublock: 0, I1113 23:28:11.306] Msgsnd: 0, I1113 23:28:11.306] Msgrcv: 0, I1113 23:28:11.307] Nsignals: 0, I1113 23:28:11.307] Nvcsw: 266, I1113 23:28:11.307] Nivcsw: 3, I1113 23:28:11.307] }, I1113 23:28:11.307] }, I1113 23:28:11.307] Stderr: nil, I1113 23:28:11.307] } I1113 23:28:11.307] exit status 1 I1113 23:28:11.307] occurred I1113 23:28:11.307] I1113 23:28:11.308] /go/src/sigs.k8s.io/azuredisk-csi-driver/test/e2e/suite_test.go:71 I1113 23:28:11.308] ------------------------------ I1113 23:28:11.308] 2019/11/13 23:28:11 Uninstalling Azure Disk CSI Driver... I1113 23:28:11.308] make[1]: Entering directory '/go/src/sigs.k8s.io/azuredisk-csi-driver' I1113 23:28:11.308] helm delete --purge azuredisk-csi-driver I1113 23:28:11.308] make[1]: helm: Command not found I1113 23:28:11.308] make[1]: *** [Makefile:80: e2e-teardown] Error 127 I1113 23:28:11.309] make[1]: Leaving directory '/go/src/sigs.k8s.io/azuredisk-csi-driver' I1113 23:28:11.309] Failure [0.004 seconds] I1113 23:28:11.309] [AfterSuite] AfterSuite I1113 23:28:11.309] /go/src/sigs.k8s.io/azuredisk-csi-driver/test/e2e/suite_test.go:104 I1113 23:28:11.309] I1113 23:28:11.309] Unexpected error: I1113 23:28:11.309] <*exec.ExitError | 0xc000ab89e0>: { I1113 23:28:11.309] ProcessState: { I1113 23:28:11.310] pid: 25651, I1113 23:28:11.310] status: 512, I1113 23:28:11.310] rusage: { I1113 23:28:11.310] Utime: {Sec: 0, Usec: 3404}, I1113 23:28:11.310] Stime: {Sec: 0, Usec: 0}, I1113 23:28:11.310] Maxrss: 48244, I1113 23:28:11.310] Ixrss: 0, I1113 23:28:11.310] Idrss: 0, I1113 23:28:11.310] Isrss: 0, I1113 23:28:11.311] Minflt: 262, I1113 23:28:11.311] Majflt: 0, I1113 23:28:11.311] Nswap: 0, I1113 23:28:11.311] Inblock: 0, I1113 23:28:11.311] Oublock: 0, I1113 23:28:11.311] Msgsnd: 0, I1113 23:28:11.311] Msgrcv: 0, I1113 23:28:11.311] Nsignals: 0, I1113 23:28:11.311] Nvcsw: 6, I1113 23:28:11.312] Nivcsw: 0, I1113 23:28:11.312] }, I1113 23:28:11.312] }, I1113 23:28:11.312] Stderr: nil, I1113 23:28:11.312] } I1113 23:28:11.312] exit status 2 I1113 23:28:11.312] occurred I1113 23:28:11.312] I1113 23:28:11.312] /go/src/sigs.k8s.io/azuredisk-csi-driver/test/e2e/suite_test.go:123 I1113 23:28:11.313] ------------------------------ I1113 23:28:11.313] I1113 23:28:11.313] Ran 9 of 0 Specs in 0.854 seconds I1113 23:28:11.313] FAIL! -- 0 Passed | 9 Failed | 0 Pending | 0 Skipped I1113 23:28:11.313] --- FAIL: TestE2E (0.85s) I1113 23:28:11.313] FAIL I1113 23:28:11.313] FAIL sigs.k8s.io/azuredisk-csi-driver/test/e2e 0.918s I1113 23:28:11.316] FAIL W1113 23:28:12.008] make: *** [Makefile:59: e2e-test] Error 1 W1113 23:28:12.008] 2019/11/13 23:28:12 process.go:155: Step 'make e2e-test' finished in 1m28.255792805s W1113 23:28:12.008] 2019/11/13 23:28:12 azure.go:922: Skippng DumpClusterLogs due to CCM not being enabled. W1113 23:28:12.008] 2019/11/13 23:28:12 azure.go:916: Deleting resource group: kubetest-5b615a81-066a-11ea-9749-0242b772b122. W1113 23:35:57.509] 2019/11/13 23:35:57 process.go:96: Saved XML output to /workspace/_artifacts/junit_runner.xml. W1113 23:35:57.509] 2019/11/13 23:35:57 process.go:153: Running: bash -c . hack/lib/version.sh && KUBE_ROOT=. kube::version::get_version_vars && echo "${KUBE_GIT_VERSION-}" W1113 23:35:57.920] 2019/11/13 23:35:57 process.go:155: Step 'bash -c . hack/lib/version.sh && KUBE_ROOT=. kube::version::get_version_vars && echo "${KUBE_GIT_VERSION-}"' finished in 410.94873ms W1113 23:35:57.920] 2019/11/13 23:35:57 main.go:319: Something went wrong: encountered 1 errors: [error during make e2e-test: exit status 2] W1113 23:35:57.921] Traceback (most recent call last): W1113 23:35:57.922] File "/workspace/./test-infra/jenkins/../scenarios/kubernetes_e2e.py", line 778, in W1113 23:35:57.922] main(parse_args()) W1113 23:35:57.922] File "/workspace/./test-infra/jenkins/../scenarios/kubernetes_e2e.py", line 626, in main W1113 23:35:57.922] mode.start(runner_args) W1113 23:35:57.922] File "/workspace/./test-infra/jenkins/../scenarios/kubernetes_e2e.py", line 262, in start W1113 23:35:57.923] check_env(env, self.command, *args) W1113 23:35:57.923] File "/workspace/./test-infra/jenkins/../scenarios/kubernetes_e2e.py", line 111, in check_env W1113 23:35:57.923] subprocess.check_call(cmd, env=env) W1113 23:35:57.923] File "/usr/lib/python2.7/subprocess.py", line 190, in check_call W1113 23:35:57.923] raise CalledProcessError(retcode, cmd) W1113 23:35:57.924] 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_D4s_v3', '--acsengine-hyperkube=True', '--acsengine-location=westus2', '--acsengine-public-key=/etc/azure-ssh/azure-ssh-pub', '--acsengine-template-url=https://raw.githubusercontent.com/kubernetes-sigs/azuredisk-csi-driver/master/test/e2e/manifest/in-tree.json', '--acsengine-download-url=https://chuwontest.blob.core.windows.net/aks-engine/aks-engine-8cf7c2a74-linux-amd64.tar.gz', '--test-azure-disk-csi-driver=True', '--timeout=420m')' returned non-zero exit status 1 E1113 23:35:57.928] Command failed I1113 23:35:57.928] process 682 exited with code 1 after 28.5m E1113 23:35:57.929] FAIL: chewong-pull-in-tree-azure-disk-e2e I1113 23:35:57.929] Call: gcloud auth activate-service-account --key-file=/etc/service-account/service-account.json W1113 23:35:58.582] Activated service account credentials for: [kubernetes-upstream@kubernetes-upstream.iam.gserviceaccount.com] I1113 23:35:58.612] process 25689 exited with code 0 after 0.0m I1113 23:35:58.612] Call: gcloud config get-value account I1113 23:35:58.837] process 25701 exited with code 0 after 0.0m I1113 23:35:58.838] Will upload results to gs://kubernetes-upstream/pr-logs using kubernetes-upstream@kubernetes-upstream.iam.gserviceaccount.com I1113 23:35:58.838] Upload result and artifacts... I1113 23:35:58.838] 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/1194753232421785600 I1113 23:35:58.838] Call: gsutil ls gs://kubernetes-upstream/pr-logs/pull/sigs.k8s.io_azuredisk-csi-driver/188/chewong-pull-in-tree-azure-disk-e2e/1194753232421785600/artifacts W1113 23:35:59.751] CommandException: One or more URLs matched no objects. E1113 23:35:59.823] Command failed I1113 23:35:59.823] process 25713 exited with code 1 after 0.0m W1113 23:35:59.823] Remote dir gs://kubernetes-upstream/pr-logs/pull/sigs.k8s.io_azuredisk-csi-driver/188/chewong-pull-in-tree-azure-disk-e2e/1194753232421785600/artifacts not exist yet I1113 23:35:59.823] 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/1194753232421785600/artifacts I1113 23:36:01.265] process 25857 exited with code 0 after 0.0m I1113 23:36:01.265] Call: git rev-parse HEAD I1113 23:36:01.269] process 26386 exited with code 0 after 0.0m I1113 23:36:01.269] Call: git rev-parse HEAD I1113 23:36:01.273] process 26387 exited with code 0 after 0.0m I1113 23:36:01.273] Call: gsutil stat gs://kubernetes-upstream/pr-logs/directory/chewong-pull-in-tree-azure-disk-e2e/jobResultsCache.json I1113 23:36:01.985] process 26388 exited with code 0 after 0.0m I1113 23:36:01.985] Call: gsutil -q cat 'gs://kubernetes-upstream/pr-logs/directory/chewong-pull-in-tree-azure-disk-e2e/jobResultsCache.json#1573685092813753' I1113 23:36:03.007] process 26532 exited with code 0 after 0.0m I1113 23:36:03.008] Call: gsutil -q -h Content-Type:application/json -h x-goog-if-generation-match:1573685092813753 cp /tmp/gsutil_AV9Jkh gs://kubernetes-upstream/pr-logs/directory/chewong-pull-in-tree-azure-disk-e2e/jobResultsCache.json I1113 23:36:04.147] process 26678 exited with code 0 after 0.0m I1113 23:36:04.148] 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 I1113 23:36:04.890] process 26858 exited with code 0 after 0.0m I1113 23:36:04.890] Call: gsutil -q cat 'gs://kubernetes-upstream/pr-logs/pull/sigs.k8s.io_azuredisk-csi-driver/188/chewong-pull-in-tree-azure-disk-e2e/jobResultsCache.json#1573685095659550' I1113 23:36:05.831] process 27002 exited with code 0 after 0.0m I1113 23:36:05.832] Call: gsutil -q -h Content-Type:application/json -h x-goog-if-generation-match:1573685095659550 cp /tmp/gsutil_POv6nU gs://kubernetes-upstream/pr-logs/pull/sigs.k8s.io_azuredisk-csi-driver/188/chewong-pull-in-tree-azure-disk-e2e/jobResultsCache.json I1113 23:36:06.895] process 27148 exited with code 0 after 0.0m I1113 23:36:06.896] Call: gsutil -q -h Content-Type:application/json cp /tmp/gsutil_ws9pR9 gs://kubernetes-upstream/pr-logs/pull/sigs.k8s.io_azuredisk-csi-driver/188/chewong-pull-in-tree-azure-disk-e2e/1194753232421785600/finished.json I1113 23:36:08.088] process 27328 exited with code 0 after 0.0m I1113 23:36:08.088] Call: gsutil -q -h Content-Type:text/plain -h 'Cache-Control:private, max-age=0, no-transform' cp /tmp/gsutil_dHqIHu gs://kubernetes-upstream/pr-logs/pull/sigs.k8s.io_azuredisk-csi-driver/188/chewong-pull-in-tree-azure-disk-e2e/latest-build.txt I1113 23:36:09.295] process 27508 exited with code 0 after 0.0m I1113 23:36:09.295] Call: gsutil -q -h Content-Type:text/plain -h 'Cache-Control:private, max-age=0, no-transform' cp /tmp/gsutil_uGcpV7 gs://kubernetes-upstream/pr-logs/directory/chewong-pull-in-tree-azure-disk-e2e/latest-build.txt I1113 23:36:10.531] process 27688 exited with code 0 after 0.0m