W0927 17:34:13.851] ************************************************************************** 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 ************************************************************************** I0927 17:34:13.851] Args: --job=pull-azurefile-csi-driver-e2e --service-account=/etc/service-account/service-account.json --upload=gs://kubernetes-jenkins/logs --job=pull-azurefile-csi-driver-e2e --root=/go/src --service-account=/etc/service-account/service-account.json --repo=k8s.io/kubernetes --repo=github.com/kubernetes-sigs/azurefile-csi-driver=master:daea67167aecc01a8bfa2b24f33c4a08998cdc74,120:6666f757a86806b2431f777db7a014780d880a47 --upload=gs://kubernetes-upstream/pr-logs --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/cloud-provider-azure/master/tests/k8s-azure/manifest/linux.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-file-csi-driver=True I0927 17:34:13.852] Bootstrap pull-azurefile-csi-driver-e2e... I0927 17:34:13.855] Builder: e203aaed-e14c-11e9-b3d3-b20db476995a I0927 17:34:13.856] Image: chewong/kubekins-e2e:v20190927-1d9518f-master I0927 17:34:13.856] Gubernator results at https://gubernator.k8s.io/build/kubernetes-upstream/pr-logs/pull/kubernetes-sigs_azurefile-csi-driver/120/pull-azurefile-csi-driver-e2e/1177637452253237252 I0927 17:34:13.856] Call: gcloud auth activate-service-account --key-file=/etc/service-account/service-account.json W0927 17:34:14.702] Activated service account credentials for: [kubernetes-upstream@kubernetes-upstream.iam.gserviceaccount.com] I0927 17:34:14.746] process 208 exited with code 0 after 0.0m I0927 17:34:14.746] Call: gcloud config get-value account I0927 17:34:15.171] process 220 exited with code 0 after 0.0m I0927 17:34:15.172] Will upload results to gs://kubernetes-upstream/pr-logs using kubernetes-upstream@kubernetes-upstream.iam.gserviceaccount.com I0927 17:34:15.172] Root: /go/src I0927 17:34:15.172] cd to /go/src I0927 17:34:15.173] Checkout: /go/src/k8s.io/kubernetes master to /go/src/k8s.io/kubernetes I0927 17:34:15.175] Call: git init k8s.io/kubernetes I0927 17:34:15.186] Initialized empty Git repository in /go/src/k8s.io/kubernetes/.git/ I0927 17:34:15.188] process 232 exited with code 0 after 0.0m I0927 17:34:15.188] Call: git config --local user.name 'K8S Bootstrap' I0927 17:34:15.194] process 233 exited with code 0 after 0.0m I0927 17:34:15.194] Call: git config --local user.email k8s_bootstrap@localhost I0927 17:34:15.200] process 234 exited with code 0 after 0.0m I0927 17:34:15.201] Call: git fetch --quiet --tags https://github.com/kubernetes/kubernetes master I0927 17:36:19.377] process 235 exited with code 0 after 2.1m I0927 17:36:19.377] Call: git checkout -B test FETCH_HEAD W0927 17:36:26.914] Switched to a new branch 'test' I0927 17:36:26.927] process 249 exited with code 0 after 0.1m I0927 17:36:26.928] Call: git show -s --format=format:%ct HEAD I0927 17:36:26.973] process 250 exited with code 0 after 0.0m I0927 17:36:26.974] Checkout: /go/src/github.com/kubernetes-sigs/azurefile-csi-driver master:daea67167aecc01a8bfa2b24f33c4a08998cdc74,120:6666f757a86806b2431f777db7a014780d880a47 to /go/src/github.com/kubernetes-sigs/azurefile-csi-driver I0927 17:36:26.974] Call: git init github.com/kubernetes-sigs/azurefile-csi-driver I0927 17:36:27.017] Initialized empty Git repository in /go/src/github.com/kubernetes-sigs/azurefile-csi-driver/.git/ I0927 17:36:27.018] process 251 exited with code 0 after 0.0m I0927 17:36:27.018] Call: git config --local user.name 'K8S Bootstrap' I0927 17:36:27.054] process 252 exited with code 0 after 0.0m I0927 17:36:27.055] Call: git config --local user.email k8s_bootstrap@localhost I0927 17:36:27.066] process 253 exited with code 0 after 0.0m I0927 17:36:27.067] Call: git fetch --quiet --tags https://github.com/kubernetes-sigs/azurefile-csi-driver master +refs/pull/120/head:refs/pr/120 I0927 17:36:39.158] process 254 exited with code 0 after 0.2m I0927 17:36:39.159] Call: git checkout -B test daea67167aecc01a8bfa2b24f33c4a08998cdc74 W0927 17:36:41.674] Switched to a new branch 'test' I0927 17:36:41.678] process 266 exited with code 0 after 0.0m I0927 17:36:41.678] Call: git show -s --format=format:%ct HEAD I0927 17:36:41.702] process 267 exited with code 0 after 0.0m I0927 17:36:41.702] Call: git merge --no-ff -m 'Merge +refs/pull/120/head:refs/pr/120' 6666f757a86806b2431f777db7a014780d880a47 I0927 17:36:41.923] Auto-merging test/utils/credentials/credentials_test.go I0927 17:36:41.924] Auto-merging test/utils/credentials/credentials.go I0927 17:36:41.924] Removing test/e2e/run-test.sh I0927 17:36:41.924] Removing hack/template/azure.json I0927 17:36:41.925] Removing .travis.yml I0927 17:36:41.925] Merge made by the 'recursive' strategy. I0927 17:36:41.934] .travis.yml | 30 -------- I0927 17:36:41.934] Makefile | 60 +++++++++++----- I0927 17:36:41.934] hack/template/azure.json | 9 --- I0927 17:36:41.937] hack/verify-golint.sh | 7 +- I0927 17:36:41.939] test/e2e/README.md | 24 +++++-- I0927 17:36:41.939] test/e2e/dynamic_provisioning.go | 17 ----- I0927 17:36:41.939] test/e2e/pre_provisioning.go | 23 +------ I0927 17:36:41.939] test/e2e/run-test.sh | 31 --------- I0927 17:36:41.940] test/e2e/suite_test.go | 87 ++++++++++++++++++++++++ I0927 17:36:41.940] test/integration/integration_test.go | 20 +++++- I0927 17:36:41.940] test/integration/run-tests-all-clouds.sh | 4 +- I0927 17:36:41.940] test/sanity/run-test.sh | 3 +- I0927 17:36:41.941] test/sanity/run-tests-all-clouds.sh | 4 +- I0927 17:36:41.941] test/sanity/sanity_test.go | 17 ++--- I0927 17:36:41.941] test/{ => utils}/azure/azure_helpers.go | 0 I0927 17:36:41.941] test/{ => utils}/credentials/credentials.go | 65 ++++++++++++------ I0927 17:36:41.946] test/{ => utils}/credentials/credentials_test.go | 54 +++++++-------- I0927 17:36:41.946] test/utils/testutil/testutil.go | 8 +++ I0927 17:36:41.946] 18 files changed, 263 insertions(+), 200 deletions(-) I0927 17:36:41.946] delete mode 100644 .travis.yml I0927 17:36:41.947] delete mode 100644 hack/template/azure.json I0927 17:36:41.947] delete mode 100755 test/e2e/run-test.sh I0927 17:36:41.947] rename test/{ => utils}/azure/azure_helpers.go (100%) I0927 17:36:41.948] rename test/{ => utils}/credentials/credentials.go (68%) I0927 17:36:41.948] rename test/{ => utils}/credentials/credentials_test.go (77%) I0927 17:36:41.948] create mode 100644 test/utils/testutil/testutil.go I0927 17:36:41.950] process 268 exited with code 0 after 0.0m I0927 17:36:41.950] Configure environment... I0927 17:36:41.951] Call: git show -s --format=format:%ct HEAD I0927 17:36:41.963] process 270 exited with code 0 after 0.0m I0927 17:36:41.964] Call: gcloud auth activate-service-account --key-file=/etc/service-account/service-account.json W0927 17:36:46.164] Activated service account credentials for: [kubernetes-upstream@kubernetes-upstream.iam.gserviceaccount.com] I0927 17:36:46.422] process 271 exited with code 0 after 0.1m I0927 17:36:46.422] Call: gcloud config get-value account I0927 17:36:47.223] process 283 exited with code 0 after 0.0m I0927 17:36:47.223] Will upload results to gs://kubernetes-upstream/pr-logs using kubernetes-upstream@kubernetes-upstream.iam.gserviceaccount.com I0927 17:36:47.223] 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 ' I0927 17:36:48.626] process 295 exited with code 0 after 0.0m I0927 17:36:49.479] Start 1177637452253237252 at v1.17.0-alpha.0.1880+cd95e57c71a194... I0927 17:36:49.482] Call: gsutil -q -h Content-Type:application/json cp /tmp/gsutil_MDVyHN gs://kubernetes-upstream/pr-logs/pull/kubernetes-sigs_azurefile-csi-driver/120/pull-azurefile-csi-driver-e2e/1177637452253237252/started.json I0927 17:36:54.370] process 328 exited with code 0 after 0.1m I0927 17:36:54.638] Call: gsutil -q -h Content-Type:text/plain -h 'x-goog-meta-link: gs://kubernetes-upstream/pr-logs/pull/kubernetes-sigs_azurefile-csi-driver/120/pull-azurefile-csi-driver-e2e/1177637452253237252' cp /tmp/gsutil_sUVJy7 gs://kubernetes-upstream/pr-logs/directory/pull-azurefile-csi-driver-e2e/1177637452253237252.txt I0927 17:36:57.810] process 506 exited with code 0 after 0.1m I0927 17:36:57.812] Call: /workspace/./test-infra/jenkins/../scenarios/kubernetes_e2e.py --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=/etc/azure-cred/credentials --acsengine-orchestratorRelease=1.16 --acsengine-mastervmsize=Standard_DS2_v2 --acsengine-agentvmsize=Standard_D4s_v3 --acsengine-location=eastus2 --acsengine-public-key=/etc/azure-ssh/azure-ssh-pub --acsengine-template-url=https://raw.githubusercontent.com/kubernetes/cloud-provider-azure/master/tests/k8s-azure/manifest/linux.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-file-csi-driver=True W0927 17:36:57.964] starts with local mode W0927 17:36:57.966] Environment: W0927 17:36:57.966] ARTIFACTS=/workspace/_artifacts W0927 17:36:57.966] AWS_SSH_PRIVATE_KEY_FILE=/root/.ssh/kube_aws_rsa W0927 17:36:57.967] AWS_SSH_PUBLIC_KEY_FILE=/root/.ssh/kube_aws_rsa.pub W0927 17:36:57.967] AZURE_CREDENTIALS=/etc/azure-cred/credentials W0927 17:36:57.968] AZURE_SSH_PUBLIC_KEY_FILE=/etc/azure-ssh/azure-ssh-pub W0927 17:36:57.968] AZ_STORAGE_CONTAINER_NAME=mystoragecontainer W0927 17:36:57.969] BAZEL_REMOTE_CACHE_ENABLED=false W0927 17:36:57.969] BAZEL_VERSION=0.23.2 W0927 17:36:57.969] BOOTSTRAP_MIGRATION=yes W0927 17:36:57.970] BUILD_ID=1177637452253237252 W0927 17:36:57.970] BUILD_NUMBER=1177637452253237252 W0927 17:36:57.971] CLOUDSDK_COMPONENT_MANAGER_DISABLE_UPDATE_CHECK=true W0927 17:36:57.971] CLOUDSDK_CONFIG=/go/src/k8s.io/kubernetes/.config/gcloud W0927 17:36:57.972] CLOUDSDK_CORE_DISABLE_PROMPTS=1 W0927 17:36:57.972] CLOUDSDK_EXPERIMENTAL_FAST_COMPONENT_UPDATE=false W0927 17:36:57.973] CLOUD_CONFIG=random W0927 17:36:57.974] DECK_PORT=tcp://10.0.160.83:80 W0927 17:36:57.974] DECK_PORT_80_TCP=tcp://10.0.160.83:80 W0927 17:36:57.975] DECK_PORT_80_TCP_ADDR=10.0.160.83 W0927 17:36:57.975] DECK_PORT_80_TCP_PORT=80 W0927 17:36:57.977] DECK_PORT_80_TCP_PROTO=tcp W0927 17:36:57.978] DECK_SERVICE_HOST=10.0.160.83 W0927 17:36:57.978] DECK_SERVICE_PORT=80 W0927 17:36:57.978] DOCKER_IN_DOCKER_ENABLED=true W0927 17:36:57.979] DOCKER_IN_DOCKER_IPV6_ENABLED=false W0927 17:36:57.979] GCS_ARTIFACTS_DIR=gs://kubernetes-upstream/pr-logs/pull/kubernetes-sigs_azurefile-csi-driver/120/pull-azurefile-csi-driver-e2e/1177637452253237252/artifacts W0927 17:36:57.980] GOOGLE_APPLICATION_CREDENTIALS=/etc/service-account/service-account.json W0927 17:36:57.980] GOPATH=/go W0927 17:36:57.980] GO_TARBALL=go1.12.1.linux-amd64.tar.gz W0927 17:36:57.981] HOME=/workspace W0927 17:36:57.981] HOOK_PORT=tcp://10.0.144.133:8888 W0927 17:36:57.981] HOOK_PORT_8888_TCP=tcp://10.0.144.133:8888 W0927 17:36:57.982] HOOK_PORT_8888_TCP_ADDR=10.0.144.133 W0927 17:36:57.982] HOOK_PORT_8888_TCP_PORT=8888 W0927 17:36:57.982] HOOK_PORT_8888_TCP_PROTO=tcp W0927 17:36:57.982] HOOK_SERVICE_HOST=10.0.144.133 W0927 17:36:57.983] HOOK_SERVICE_PORT=8888 W0927 17:36:57.983] HOSTNAME=e203aaed-e14c-11e9-b3d3-b20db476995a W0927 17:36:57.983] IMAGE=chewong/kubekins-e2e:v20190927-1d9518f-master W0927 17:36:57.984] INSTANCE_PREFIX=bootstrap-e2e W0927 17:36:57.984] JENKINS_GCE_SSH_PRIVATE_KEY_FILE=/root/.ssh/google_compute_engine W0927 17:36:57.984] JENKINS_GCE_SSH_PUBLIC_KEY_FILE=/root/.ssh/google_compute_engine.pub W0927 17:36:57.985] JOB_NAME=pull-azurefile-csi-driver-e2e W0927 17:36:57.986] JOB_SPEC={"type":"presubmit","job":"pull-azurefile-csi-driver-e2e","buildid":"1177637452253237252","prowjobid":"e203aaed-e14c-11e9-b3d3-b20db476995a","refs":{"org":"Azure","repo":"kubernetes","repo_link":"https://github.com/Azure/kubernetes","base_ref":"master","base_sha":"cd95e57c71a194a80064b00a44e42a222003dac8","base_link":"https://github.com/Azure/kubernetes/commit/cd95e57c71a194a80064b00a44e42a222003dac8","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"}]}} W0927 17:36:57.986] JOB_TYPE=presubmit W0927 17:36:57.986] KUBERNETES_PORT=tcp://10.0.0.1:443 W0927 17:36:57.986] KUBERNETES_PORT_443_TCP=tcp://10.0.0.1:443 W0927 17:36:57.987] KUBERNETES_PORT_443_TCP_ADDR=10.0.0.1 W0927 17:36:57.987] KUBERNETES_PORT_443_TCP_PORT=443 W0927 17:36:57.987] KUBERNETES_PORT_443_TCP_PROTO=tcp W0927 17:36:57.988] KUBERNETES_SERVICE_HOST=10.0.0.1 W0927 17:36:57.988] KUBERNETES_SERVICE_PORT=443 W0927 17:36:57.988] KUBERNETES_SERVICE_PORT_HTTPS=443 W0927 17:36:57.988] KUBETEST_IN_DOCKER=true W0927 17:36:57.989] KUBETEST_MANUAL_DUMP=y W0927 17:36:57.989] KUBE_AWS_INSTANCE_PREFIX=bootstrap-e2e W0927 17:36:57.989] KUBE_GCE_INSTANCE_PREFIX=bootstrap-e2e W0927 17:36:57.989] KUBE_VERBOSE=0 W0927 17:36:57.990] NODE_NAME=e203aaed-e14c-11e9-b3d3-b20db476995a W0927 17:36:57.990] 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 W0927 17:36:57.990] PROW_JOB_ID=e203aaed-e14c-11e9-b3d3-b20db476995a W0927 17:36:57.990] PULL_BASE_REF=master W0927 17:36:57.991] PULL_BASE_SHA=cd95e57c71a194a80064b00a44e42a222003dac8 W0927 17:36:57.991] PULL_NUMBER=113 W0927 17:36:57.991] PULL_PULL_SHA=879465972041635fd7bc8269da49153b67e63822 W0927 17:36:57.992] PULL_REFS=master:cd95e57c71a194a80064b00a44e42a222003dac8,113:879465972041635fd7bc8269da49153b67e63822 W0927 17:36:57.992] PWD=/workspace W0927 17:36:57.992] REGISTRY=k8sprowinternal.azurecr.io W0927 17:36:57.993] REPO_NAME=kubernetes W0927 17:36:57.993] REPO_OWNER=Azure W0927 17:36:57.993] SHLVL=2 W0927 17:36:57.993] SOURCE_DATE_EPOCH=1569603456 W0927 17:36:57.994] TERM=xterm W0927 17:36:57.994] TIDE_PORT=tcp://10.0.180.53:80 W0927 17:36:57.994] TIDE_PORT_80_TCP=tcp://10.0.180.53:80 W0927 17:36:57.994] TIDE_PORT_80_TCP_ADDR=10.0.180.53 W0927 17:36:57.995] TIDE_PORT_80_TCP_PORT=80 W0927 17:36:57.995] TIDE_PORT_80_TCP_PROTO=tcp W0927 17:36:57.995] TIDE_SERVICE_HOST=10.0.180.53 W0927 17:36:57.995] TIDE_SERVICE_PORT=80 W0927 17:36:57.996] WORKSPACE=/workspace W0927 17:36:57.996] _=./test-infra/jenkins/bootstrap.py W0927 17:36:57.997] Run: ('kubetest', '--dump=/workspace/_artifacts', '--gcp-service-account=/etc/service-account/service-account.json', '--build=bazel', '--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-location=eastus2', '--acsengine-public-key=/etc/azure-ssh/azure-ssh-pub', '--acsengine-template-url=https://raw.githubusercontent.com/kubernetes/cloud-provider-azure/master/tests/k8s-azure/manifest/linux.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-file-csi-driver=True') W0927 17:36:58.026] 2019/09/27 17:36:58 azure.go:230: Reading credentials file /etc/azure-cred/credentials W0927 17:36:58.027] 2019/09/27 17:36:58 process.go:153: Running: make -C /go/src/k8s.io/kubernetes bazel-release I0927 17:36:58.130] make: Entering directory '/go/src/k8s.io/kubernetes' W0927 17:36:58.278] Extracting Bazel installation... W0927 17:37:26.030] Starting local Bazel server and connecting to it... W0927 17:37:34.790] Loading: W0927 17:37:34.800] Loading: 0 packages loaded W0927 17:37:35.822] Loading: 0 packages loaded W0927 17:37:39.939] Loading: 0 packages loaded W0927 17:37:41.627] Loading: 0 packages loaded W0927 17:37:43.001] Loading: 0 packages loaded W0927 17:37:45.166] Loading: 0 packages loaded W0927 17:37:46.794] Loading: 0 packages loaded W0927 17:37:49.051] Loading: 0 packages loaded W0927 17:37:49.051] currently loading: build/release-tars W0927 17:37:51.252] Analyzing: target //build/release-tars:release-tars (1 packages loaded) W0927 17:37:51.444] Analyzing: target //build/release-tars:release-tars (1 packages loaded, 0 targets configured) W0927 17:37:54.034] Analyzing: target //build/release-tars:release-tars (23 packages loaded, 75 targets configured) W0927 17:37:56.998] Analyzing: target //build/release-tars:release-tars (54 packages loaded, 462 targets configured) W0927 17:38:00.399] Analyzing: target //build/release-tars:release-tars (144 packages loaded, 948 targets configured) W0927 17:38:04.411] Analyzing: target //build/release-tars:release-tars (526 packages loaded, 1825 targets configured) W0927 17:38:08.939] Analyzing: target //build/release-tars:release-tars (975 packages loaded, 4279 targets configured) W0927 17:38:14.149] Analyzing: target //build/release-tars:release-tars (2020 packages loaded, 12233 targets configured) W0927 17:38:20.502] Analyzing: target //build/release-tars:release-tars (2871 packages loaded, 24251 targets configured) W0927 17:38:28.415] Analyzing: target //build/release-tars:release-tars (3027 packages loaded, 27097 targets configured) W0927 17:38:36.520] Analyzing: target //build/release-tars:release-tars (3060 packages loaded, 30716 targets configured) W0927 17:38:45.916] Analyzing: target //build/release-tars:release-tars (3072 packages loaded, 34693 targets configured) W0927 17:39:07.377] Analyzing: target //build/release-tars:release-tars (3072 packages loaded, 42146 targets configured) W0927 17:39:14.678] INFO: Analysed target //build/release-tars:release-tars (3072 packages loaded, 42238 targets configured). W0927 17:39:14.684] INFO: Found 1 target... W0927 17:39:15.092] [0 / 24] [-----] BazelWorkspaceStatusAction stable-status.txt W0927 17:39:30.663] [132 / 5,292] GoCompile vendor/golang.org/x/tools/go/ast/astutil/linux_amd64_stripped/go_default_library%/k8s.io/kubernetes/vendor/golang.org/x/tools/go/ast/astutil.a [for host]; 2s linux-sandbox ... (7 actions, 6 running) W0927 17:39:49.702] [260 / 5,292] GoCompile vendor/github.com/coreos/etcd/pkg/srv/linux_amd64_stripped/go_default_library%/k8s.io/kubernetes/vendor/github.com/coreos/etcd/pkg/srv.a; 2s linux-sandbox ... (7 actions, 6 running) W0927 17:40:10.310] [382 / 5,292] GoCompile vendor/github.com/gophercloud/gophercloud/openstack/networking/v2/extensions/lbaas_v2/l7policies/linux_amd64_stripped/go_default_library%/k8s.io/kubernetes/vendor/github.com/gophercloud/gophercloud/openstack/networking/v2/extensions/lbaas_v2/l7policies.a; 3s linux-sandbox ... (8 actions, 7 running) W0927 17:40:34.371] [536 / 5,292] GoStdlib external/io_bazel_rules_go/linux_amd64_pure_stripped/stdlib%/pkg; 13s linux-sandbox ... (8 actions, 7 running) W0927 17:41:02.230] [767 / 5,292] GoStdlib external/io_bazel_rules_go/linux_amd64_pure_stripped/stdlib%/pkg; 41s linux-sandbox ... (8 actions, 6 running) W0927 17:41:33.712] [986 / 5,292] GoCompile vendor/gonum.org/v1/gonum/blas/linux_amd64_pure_stripped/go_default_library%/k8s.io/kubernetes/vendor/gonum.org/v1/gonum/blas.a; 5s linux-sandbox ... (8 actions, 7 running) W0927 17:42:09.675] [1,269 / 5,292] GoCompile vendor/github.com/aws/aws-sdk-go/service/ec2/linux_amd64_pure_stripped/go_default_library%/k8s.io/kubernetes/vendor/github.com/aws/aws-sdk-go/service/ec2.a; 9s linux-sandbox ... (8 actions, 7 running) W0927 17:42:51.011] [1,537 / 5,292] GoCompile vendor/github.com/Azure/azure-sdk-for-go/services/network/mgmt/2019-06-01/network/linux_amd64_pure_stripped/go_default_library%/k8s.io/kubernetes/vendor/github.com/Azure/azure-sdk-for-go/services/network/mgmt/2019-06-01/network.a; 7s linux-sandbox ... (8 actions, 7 running) W0927 17:43:40.444] [1,882 / 5,292] GoCompile vendor/github.com/docker/docker/api/types/registry/linux_amd64_stripped/go_default_library%/k8s.io/kubernetes/vendor/github.com/docker/docker/api/types/registry.a; 4s linux-sandbox ... (8 actions running) W0927 17:44:35.352] [2,592 / 5,296] GoCompile vendor/google.golang.org/grpc/internal/transport/linux_amd64_stripped/go_default_library%/k8s.io/kubernetes/vendor/google.golang.org/grpc/internal/transport.a; 9s linux-sandbox ... (8 actions running) W0927 17:45:38.610] [3,045 / 5,296] GoCompile staging/src/k8s.io/apiserver/pkg/endpoints/handlers/fieldmanager/internal/linux_amd64_stripped/go_default_library%/k8s.io/kubernetes/vendor/k8s.io/apiserver/pkg/endpoints/handlers/fieldmanager/internal.a; 1s linux-sandbox ... (8 actions, 7 running) W0927 17:46:51.673] [3,311 / 5,296] ; 8s linux-sandbox ... (8 actions running) W0927 17:48:15.972] [3,615 / 5,296] GoCompile staging/src/k8s.io/api/core/v1/linux_amd64_pure_stripped/go_default_library%/k8s.io/kubernetes/vendor/k8s.io/api/core/v1.a; 14s linux-sandbox ... (8 actions running) W0927 17:49:54.220] [4,128 / 5,296] GoCompile pkg/registry/core/pod/linux_amd64_pure_stripped/go_default_library%/k8s.io/kubernetes/pkg/registry/core/pod.a; 5s linux-sandbox ... (8 actions, 7 running) W0927 17:51:46.162] [4,712 / 5,296] GoCompile staging/src/k8s.io/kubectl/pkg/describe/versioned/linux_amd64_stripped/go_default_library%/k8s.io/kubernetes/vendor/k8s.io/kubectl/pkg/describe/versioned.a; 7s linux-sandbox ... (8 actions, 7 running) W0927 17:53:54.561] [5,169 / 5,296] GoCompile pkg/registry/networking/rest/linux_amd64_stripped/go_default_library%/k8s.io/kubernetes/pkg/registry/networking/rest.a; 2s linux-sandbox ... (8 actions, 7 running) W0927 17:56:26.106] [5,285 / 5,296] GoLink cmd/genman/genman; 111s linux-sandbox ... (5 actions running) W0927 17:58:38.877] Target //build/release-tars:release-tars up-to-date: W0927 17:58:38.879] bazel-bin/build/release-tars/kubernetes-client-linux-amd64.tar.gz W0927 17:58:38.879] bazel-bin/build/release-tars/kubernetes-node-linux-amd64.tar.gz W0927 17:58:38.879] bazel-bin/build/release-tars/kubernetes-server-linux-amd64.tar.gz W0927 17:58:38.879] bazel-bin/build/release-tars/kubernetes-manifests.tar.gz W0927 17:58:38.880] bazel-bin/build/release-tars/kubernetes-test-portable.tar.gz W0927 17:58:38.880] bazel-bin/build/release-tars/kubernetes-test-linux-amd64.tar.gz W0927 17:58:38.880] bazel-bin/build/release-tars/kubernetes.tar.gz W0927 17:58:38.881] bazel-bin/build/release-tars/kubernetes-src.tar.gz W0927 17:58:39.079] INFO: Elapsed time: 1300.662s, Critical Path: 377.89s W0927 17:58:39.079] INFO: 5205 processes: 5205 linux-sandbox. W0927 17:58:39.131] INFO: Build completed successfully, 5296 total actions W0927 17:58:39.179] INFO: Build completed successfully, 5296 total actions W0927 17:58:39.275] 2019/09/27 17:58:39 process.go:155: Step 'make -C /go/src/k8s.io/kubernetes bazel-release' finished in 21m41.200807234s W0927 17:58:39.276] 2019/09/27 17:58:39 util.go:277: Flushing memory. I0927 17:58:39.376] make: Leaving directory '/go/src/k8s.io/kubernetes' W0927 17:59:01.659] 2019/09/27 17:59:01 azure.go:899: Deleting resource group: kubetest-67b67849-e14d-11e9-b1b0-0242b3fbd891. W0927 17:59:02.219] 2019/09/27 17:59:02 azure.go:780: downloading /workspace/aks730635094/kubernetes.json from https://raw.githubusercontent.com/kubernetes/cloud-provider-azure/master/tests/k8s-azure/manifest/linux.json. W0927 17:59:02.219] 2019/09/27 17:59:02 util.go:42: curl https://raw.githubusercontent.com/kubernetes/cloud-provider-azure/master/tests/k8s-azure/manifest/linux.json W0927 17:59:02.399] 2019/09/27 17:59:02 azure.go:527: downloading /workspace/aks-engine.tar.gz from https://github.com/Azure/aks-engine/releases/download/v0.39.1/aks-engine-v0.39.1-linux-amd64.tar.gz. W0927 17:59:02.400] 2019/09/27 17:59:02 util.go:42: curl https://github.com/Azure/aks-engine/releases/download/v0.39.1/aks-engine-v0.39.1-linux-amd64.tar.gz W0927 17:59:03.739] 2019/09/27 17:59:03 azure.go:554: Extracting tar file /workspace/aks-engine.tar.gz into directory /go/src/k8s.io/kubernetes . W0927 17:59:03.745] 2019/09/27 17:59:03 process.go:153: Running: tar -xzf /workspace/aks-engine.tar.gz --strip 1 W0927 17:59:03.912] 2019/09/27 17:59:03 process.go:155: Step 'tar -xzf /workspace/aks-engine.tar.gz --strip 1' finished in 166.673069ms W0927 17:59:03.912] 2019/09/27 17:59:03 process.go:153: Running: /go/src/k8s.io/kubernetes/aks-engine generate /workspace/aks730635094/kubernetes.json --output-directory /workspace/aks730635094 I0927 17:59:04.113] INFO[0000] Generating assets into /workspace/aks730635094... W0927 17:59:17.852] 2019/09/27 17:59:17 process.go:155: Step '/go/src/k8s.io/kubernetes/aks-engine generate /workspace/aks730635094/kubernetes.json --output-directory /workspace/aks730635094' finished in 13.940512788s W0927 17:59:17.855] 2019/09/27 17:59:17 azure.go:625: Setting kubeconfig env variable: kubeconfig path: /workspace/aks730635094/kubeconfig/kubeconfig.eastus2.json. W0927 17:59:17.855] 2019/09/27 17:59:17 azure.go:627: Creating resource group: kubetest-67b67849-e14d-11e9-b1b0-0242b3fbd891. W0927 17:59:17.856] 2019/09/27 17:59:17 azure.go:629: Creating Azure resource group: kubetest-67b67849-e14d-11e9-b1b0-0242b3fbd891 for cluster deployment. W0927 17:59:19.511] 2019/09/27 17:59:19 azure.go:634: Validating deployment ARM templates. W0927 17:59:21.476] 2019/09/27 17:59:21 azure.go:640: Deploying cluster kubetest-67b67849-e14d-11e9-b1b0-0242b3fbd891 in resource group kubetest-67b67849-e14d-11e9-b1b0-0242b3fbd891. W0927 18:08:29.032] 2019/09/27 18:08:29 process.go:153: Running: ./cluster/kubectl.sh --match-server-version=false version W0927 18:08:29.708] 2019/09/27 18:08:29 process.go:155: Step './cluster/kubectl.sh --match-server-version=false version' finished in 675.728465ms W0927 18:08:29.708] 2019/09/27 18:08:29 process.go:153: Running: ./cluster/kubectl.sh --match-server-version=false get nodes -oyaml W0927 18:08:31.210] 2019/09/27 18:08:31 process.go:155: Step './cluster/kubectl.sh --match-server-version=false get nodes -oyaml' finished in 1.501815224s W0927 18:08:31.211] 2019/09/27 18:08:31 azure.go:944: KUBE_TEST_REPO_LIST_DOWNLOAD_LOCATION not set. Using default test image repos. W0927 18:08:31.211] 2019/09/27 18:08:31 azure.go:944: KUBE_TEST_REPO_LIST_DOWNLOAD_LOCATION not set. Using default test image repos. W0927 18:08:31.211] 2019/09/27 18:08:31 process.go:153: Running: kubectl get nodes --no-headers W0927 18:08:32.030] 2019/09/27 18:08:32 process.go:155: Step 'kubectl get nodes --no-headers' finished in 818.090595ms W0927 18:08:32.030] 2019/09/27 18:08:32 e2e.go:462: Cluster nodes: W0927 18:08:32.030] k8s-agentpool1-20602161-0 Ready agent 21s v1.15.0 W0927 18:08:32.030] k8s-master-20602161-0 Ready master 50s v1.15.0 W0927 18:08:32.030] 2019/09/27 18:08:32 process.go:153: Running: ./cluster/kubectl.sh --match-server-version=false version W0927 18:08:32.433] 2019/09/27 18:08:32 process.go:155: Step './cluster/kubectl.sh --match-server-version=false version' finished in 403.0145ms W0927 18:08:32.433] 2019/09/27 18:08:32 process.go:153: Running: make e2e-test I0927 18:08:32.534] go test -v -timeout=30m ./test/e2e "-ginkgo.noColor" W0927 18:08:32.634] go: finding github.com/PuerkitoBio/purell v1.1.1 W0927 18:08:32.634] go: finding github.com/jonboulle/clockwork v0.1.0 W0927 18:08:32.635] go: finding github.com/golang/protobuf v1.3.0 W0927 18:08:32.635] go: finding github.com/googleapis/gnostic v0.2.0 W0927 18:08:32.635] go: finding github.com/Azure/go-autorest v11.5.1+incompatible W0927 18:08:32.635] go: finding github.com/docker/distribution v0.0.0-20170905204447-5db89f0ca686 W0927 18:08:32.636] go: finding github.com/go-openapi/swag v0.19.0 W0927 18:08:32.636] go: finding github.com/coreos/go-systemd v0.0.0-20190321100706-95778dfbb74e W0927 18:08:32.766] go: finding golang.org/x/net v0.0.0-20190301231341-16b79f2e4e95 W0927 18:08:32.769] go: finding k8s.io/legacy-cloud-providers v0.0.0-20190624091455-d8621ceb9c64 W0927 18:08:33.209] go: finding github.com/coreos/etcd v3.3.12+incompatible W0927 18:08:33.295] go: finding github.com/grpc-ecosystem/go-grpc-middleware v1.0.0 W0927 18:08:33.375] go: finding github.com/xiang90/probing v0.0.0-20190116061207-43a291ad63a2 W0927 18:08:33.440] go: finding k8s.io/apiserver v0.0.0-20190313205120-8b27c41bdbb1 W0927 18:08:33.459] go: finding k8s.io/apimachinery v0.0.0-20190313205120-d7deff9243b1 W0927 18:08:33.648] go: finding sigs.k8s.io/kustomize v2.0.3+incompatible W0927 18:08:33.675] go: finding gopkg.in/yaml.v2 v2.2.2 W0927 18:08:33.758] go: finding go.uber.org/multierr v1.1.0 W0927 18:08:33.931] go: finding github.com/opencontainers/go-digest v1.0.0-rc1 W0927 18:08:34.172] go: finding github.com/elazarl/goproxy v0.0.0-20190410145444-c548f45dcf1d W0927 18:08:34.524] go: finding github.com/spf13/cobra v0.0.3 W0927 18:08:34.529] go: finding github.com/GoogleCloudPlatform/k8s-cloud-provider v0.0.0-20181220005116-f8e995905100 W0927 18:08:34.639] go: finding gopkg.in/warnings.v0 v0.1.1 W0927 18:08:34.642] go: finding gopkg.in/square/go-jose.v2 v2.3.0 W0927 18:08:34.757] go: finding github.com/davecgh/go-spew v1.1.1 W0927 18:08:34.772] go: finding github.com/prometheus/client_model v0.0.0-20190129233127-fd36f4220a90 W0927 18:08:34.796] go: finding github.com/soheilhy/cmux v0.1.4 W0927 18:08:34.829] go: finding github.com/elazarl/goproxy/ext v0.0.0-20190410145444-c548f45dcf1d W0927 18:08:34.920] go: finding golang.org/x/sync v0.0.0-20190227155943-e225da77a7e6 W0927 18:08:35.194] go: finding github.com/rogpeppe/go-charset v0.0.0-20180617210344-2471d30d28b4 W0927 18:08:35.275] go: finding github.com/tmc/grpc-websocket-proxy v0.0.0-20190109142713-0ad062ec5ee5 W0927 18:08:35.301] go: finding go.uber.org/atomic v1.3.2 W0927 18:08:35.383] go: finding github.com/inconshreveable/mousetrap v1.0.0 W0927 18:08:35.488] go: finding github.com/rubiojr/go-vhd v0.0.0-20160810183302-0bfd3b39853c W0927 18:08:35.543] go: finding github.com/pelletier/go-toml v1.4.0 W0927 18:08:35.669] go: finding github.com/hashicorp/golang-lru v0.5.1 W0927 18:08:35.872] go: finding github.com/marstr/guid v1.1.0 W0927 18:08:35.879] go: finding k8s.io/utils v0.0.0-20190221042446-c2654d5206da W0927 18:08:35.925] go: finding golang.org/x/crypto v0.0.0-20190228161510-8dd112bcdc25 W0927 18:08:35.968] go: finding google.golang.org/genproto v0.0.0-20190307195333-5fe7a883aa19 W0927 18:08:36.072] go: finding github.com/go-openapi/spec v0.19.0 W0927 18:08:36.074] go: finding github.com/stretchr/testify v1.3.0 W0927 18:08:36.195] go: finding github.com/coreos/bbolt v1.3.2 W0927 18:08:36.245] go: finding google.golang.org/api v0.1.0 W0927 18:08:36.419] go: finding github.com/google/uuid v1.1.1 W0927 18:08:36.547] go: finding github.com/pkg/errors v0.8.1 W0927 18:08:36.719] go: finding github.com/coreos/pkg v0.0.0-20180928190104-399ea9e2e55f W0927 18:08:36.760] go: finding cloud.google.com/go v0.34.0 W0927 18:08:36.786] go: finding github.com/satori/go.uuid v1.2.0 W0927 18:08:36.791] go: finding github.com/gregjones/httpcache v0.0.0-20190212212710-3befbb6ad0cc W0927 18:08:36.931] go: finding github.com/imdario/mergo v0.3.7 W0927 18:08:37.080] go: finding github.com/go-openapi/jsonreference v0.19.0 W0927 18:08:37.264] go: finding github.com/kubernetes-csi/external-snapshotter v1.0.1 W0927 18:08:37.324] go: finding github.com/prometheus/procfs v0.0.0-20190306233201-d0f344d83b0c W0927 18:08:37.415] go: finding github.com/prometheus/common v0.2.0 W0927 18:08:37.433] go: finding github.com/fatih/camelcase v1.0.0 W0927 18:08:37.740] go: finding github.com/Azure/azure-sdk-for-go v21.4.0+incompatible W0927 18:08:37.811] go: finding k8s.io/klog v0.2.0 W0927 18:08:38.099] go: finding github.com/dgrijalva/jwt-go v3.2.0+incompatible W0927 18:08:38.127] go: finding k8s.io/apiextensions-apiserver v0.0.0-20190315093550-53c4693659ed W0927 18:08:38.222] go: finding github.com/google/btree v1.0.0 W0927 18:08:38.392] go: finding github.com/container-storage-interface/spec v1.1.0 W0927 18:08:38.927] go: finding github.com/alecthomas/template v0.0.0-20160405071501-a0175ee3bccc W0927 18:08:38.930] go: finding github.com/go-openapi/jsonpointer v0.19.0 W0927 18:08:38.965] go: finding github.com/gogo/protobuf v1.2.1 W0927 18:08:38.976] go: finding github.com/json-iterator/go v1.1.5 W0927 18:08:39.357] go: finding github.com/go-logfmt/logfmt v0.3.0 W0927 18:08:39.457] go: finding github.com/PuerkitoBio/urlesc v0.0.0-20170810143723-de5bf2ad4578 W0927 18:08:39.826] go: finding k8s.io/cluster-bootstrap v0.0.0-20190313124217-0fa624df11e9 W0927 18:08:40.015] go: finding github.com/modern-go/reflect2 v0.0.0-20180701023420-4b7aa43c6742 W0927 18:08:40.435] go: finding github.com/docker/spdystream v0.0.0-20181023171402-6480d4af844c W0927 18:08:40.449] go: finding github.com/google/go-cmp v0.2.0 W0927 18:08:40.489] go: finding github.com/golang/groupcache v0.0.0-20190129154638-5b532d6fd5ef W0927 18:08:40.503] go: finding golang.org/x/oauth2 v0.0.0-20190226205417-e64efc72b421 W0927 18:08:40.523] go: finding github.com/spf13/pflag v1.0.3 W0927 18:08:40.538] go: finding gopkg.in/gcfg.v1 v1.2.0 W0927 18:08:40.736] go: finding sigs.k8s.io/yaml v1.1.0 W0927 18:08:41.074] go: finding k8s.io/component-base v0.0.0-20190313120452-4727f38490bc W0927 18:08:41.092] go: finding github.com/onsi/ginkgo v1.7.0 W0927 18:08:41.117] go: finding k8s.io/kubernetes v1.14.0 W0927 18:08:41.168] go: finding github.com/Azure/azure-storage-file-go v0.5.0 W0927 18:08:41.309] go: finding github.com/prometheus/client_golang v0.9.2 W0927 18:08:41.754] go: finding github.com/go-kit/kit v0.8.0 W0927 18:08:41.764] go: finding github.com/google/gofuzz v0.0.0-20170612174753-24818f796faf W0927 18:08:41.787] go: finding github.com/kr/logfmt v0.0.0-20140226030751-b84e30acd515 W0927 18:08:41.989] go: finding k8s.io/cloud-provider v0.0.0-20190308083404-05ccf96446f8 W0927 18:08:42.090] go: finding k8s.io/client-go v11.0.0+incompatible W0927 18:08:42.871] go: finding k8s.io/csi-translation-lib v0.0.0-20190313124639-7f5cabc6aac8 W0927 18:08:42.910] go: finding golang.org/x/lint v0.0.0-20190227174305-5b3e6a55c961 W0927 18:08:42.959] go: finding github.com/pborman/uuid v0.0.0-20180906182336-adf5a7427709 W0927 18:08:42.994] go: finding gopkg.in/check.v1 v0.0.0-20161208181325-20d25e280405 W0927 18:08:43.128] go: finding github.com/aws/aws-sdk-go v1.16.26 W0927 18:08:43.519] go: finding github.com/go-stack/stack v1.8.0 W0927 18:08:43.595] go: finding github.com/dnaeon/go-vcr v1.0.1 W0927 18:08:43.920] go: finding github.com/census-instrumentation/opencensus-proto v0.1.0 W0927 18:08:43.964] go: finding github.com/mailru/easyjson v0.0.0-20190312143242-1de009706dbe W0927 18:08:44.077] go: finding github.com/grpc-ecosystem/go-grpc-prometheus v1.2.0 W0927 18:08:44.596] go: finding google.golang.org/grpc v1.19.0 W0927 18:08:44.632] go: finding k8s.io/cli-runtime v0.0.0-20190314001948-2899ed30580f W0927 18:08:44.643] go: finding golang.org/x/sys v0.0.0-20190308023053-584f3b12f43e W0927 18:08:44.784] go: finding honnef.co/go/tools v0.0.0-20190102054323-c2f93a96b099 W0927 18:08:45.346] go: finding github.com/beorn7/perks v0.0.0-20180321164747-3a771d992973 W0927 18:08:45.408] go: finding gopkg.in/alecthomas/kingpin.v2 v2.2.6 W0927 18:08:45.791] go: finding github.com/onsi/gomega v1.4.3 W0927 18:08:46.351] go: finding golang.org/x/text v0.3.0 W0927 18:08:47.000] go: finding go.uber.org/zap v1.9.1 W0927 18:08:47.860] go: finding github.com/BurntSushi/toml v0.3.1 W0927 18:08:48.356] go: finding golang.org/x/tools v0.0.0-20190226205152-f727befe758c W0927 18:08:50.904] go: finding github.com/pmezard/go-difflib v1.0.0 W0927 18:08:50.906] go: finding github.com/vmware/govmomi v0.20.1 W0927 18:08:50.907] go: finding github.com/golang/mock v1.1.1 W0927 18:08:51.290] go: finding github.com/kr/pty v1.1.5 W0927 18:08:51.378] go: finding github.com/mwitkow/go-conntrack v0.0.0-20161129095857-cc309e4a2223 W0927 18:08:51.557] go: finding gopkg.in/inf.v0 v0.9.1 W0927 18:08:51.848] go: finding github.com/emicklei/go-restful v2.9.3+incompatible W0927 18:08:51.927] go: finding github.com/Azure/azure-pipeline-go v0.2.1 W0927 18:08:52.436] go: finding github.com/alecthomas/units v0.0.0-20151022065526-2efee857e7cf W0927 18:08:52.466] go: finding github.com/julienschmidt/httprouter v1.2.0 W0927 18:08:52.469] go: finding github.com/fsnotify/fsnotify v1.4.7 W0927 18:08:52.908] go: finding github.com/mattn/go-ieproxy v0.0.0-20190610004146-91bb50d98149 W0927 18:08:53.044] go: finding go.etcd.io/bbolt v1.3.2 W0927 18:08:53.057] go: finding google.golang.org/appengine v1.4.0 W0927 18:08:53.147] go: finding go.opencensus.io v0.18.0 W0927 18:08:53.367] go: finding github.com/golang/glog v0.0.0-20160126235308-23def4e6c14b W0927 18:08:53.744] go: finding github.com/client9/misspell v0.3.4 W0927 18:08:53.753] go: finding contrib.go.opencensus.io/exporter/ocagent v0.2.0 W0927 18:08:53.845] go: finding k8s.io/kube-openapi v0.0.0-20190306001800-15615b16d372 W0927 18:08:54.272] go: finding github.com/apache/thrift v0.0.0-20180902110319-2566ecd5d999 W0927 18:08:54.356] go: finding github.com/kisielk/errcheck v1.1.0 W0927 18:08:54.543] go: finding github.com/coreos/go-semver v0.3.0 W0927 18:08:54.943] go: finding golang.org/x/time v0.0.0-20181108054448-85acf8d2951c W0927 18:08:55.452] go: finding github.com/kr/pretty v0.1.0 W0927 18:08:55.453] go: finding github.com/stretchr/objx v0.1.1 W0927 18:08:55.455] go: finding github.com/ghodss/yaml v1.0.0 W0927 18:08:55.460] go: finding github.com/gorilla/websocket v1.4.0 W0927 18:08:55.496] go: finding golang.org/x/exp v0.0.0-20190121172915-509febef88a4 W0927 18:08:55.518] go: finding k8s.io/api v0.0.0-20190313235455-40a48860b5ab W0927 18:08:55.598] go: finding gopkg.in/fsnotify.v1 v1.4.7 W0927 18:08:55.756] go: finding github.com/grpc-ecosystem/grpc-gateway v1.5.0 W0927 18:08:56.464] go: finding github.com/spf13/afero v1.2.2 W0927 18:08:56.506] go: finding gopkg.in/tomb.v1 v1.0.0-20141024135613-dd632973f1e7 W0927 18:08:56.546] go: finding github.com/openzipkin/zipkin-go v0.1.1 W0927 18:08:56.551] go: finding github.com/modern-go/concurrent v0.0.0-20180306012644-bacd9c7ef1dd W0927 18:08:56.676] go: finding github.com/evanphx/json-patch v3.0.0+incompatible W0927 18:08:56.679] go: finding github.com/kisielk/gotool v1.0.0 W0927 18:08:57.175] go: finding github.com/matttproud/golang_protobuf_extensions v1.0.1 W0927 18:08:57.177] go: finding github.com/jmespath/go-jmespath v0.0.0-20180206201540-c2b33e8439af W0927 18:08:57.274] go: finding github.com/hpcloud/tail v1.0.0 W0927 18:08:57.311] go: finding github.com/ugorji/go v1.1.4 W0927 18:08:57.347] go: finding github.com/sirupsen/logrus v1.2.0 W0927 18:08:57.376] go: finding k8s.io/kube-aggregator v0.0.0-20190401185513-77f9841f26eb W0927 18:08:57.413] go: finding github.com/peterbourgon/diskv v2.0.1+incompatible W0927 18:08:57.487] go: finding github.com/kr/text v0.1.0 W0927 18:08:57.974] go: finding github.com/konsorten/go-windows-terminal-sequences v1.0.1 W0927 18:08:59.628] go: downloading k8s.io/api v0.0.0-20190313235455-40a48860b5ab W0927 18:08:59.628] go: downloading k8s.io/kubernetes v1.14.0 W0927 18:08:59.628] go: downloading k8s.io/client-go v11.0.0+incompatible W0927 18:08:59.631] go: downloading github.com/onsi/gomega v1.4.3 W0927 18:08:59.632] go: downloading github.com/kubernetes-csi/external-snapshotter v1.0.1 W0927 18:08:59.635] go: downloading github.com/Azure/azure-storage-file-go v0.5.0 W0927 18:08:59.704] go: downloading github.com/container-storage-interface/spec v1.1.0 W0927 18:08:59.777] go: extracting github.com/Azure/azure-storage-file-go v0.5.0 W0927 18:08:59.793] go: downloading k8s.io/apimachinery v0.0.0-20190313205120-d7deff9243b1 W0927 18:08:59.796] go: extracting github.com/onsi/gomega v1.4.3 W0927 18:08:59.845] go: extracting github.com/container-storage-interface/spec v1.1.0 W0927 18:08:59.879] go: downloading github.com/Azure/azure-pipeline-go v0.2.1 W0927 18:08:59.941] go: extracting github.com/Azure/azure-pipeline-go v0.2.1 W0927 18:09:00.226] go: extracting k8s.io/apimachinery v0.0.0-20190313205120-d7deff9243b1 W0927 18:09:00.337] go: downloading google.golang.org/grpc v1.19.0 W0927 18:09:00.337] go: downloading github.com/pborman/uuid v0.0.0-20180906182336-adf5a7427709 W0927 18:09:00.342] go: extracting k8s.io/api v0.0.0-20190313235455-40a48860b5ab W0927 18:09:00.389] go: extracting github.com/pborman/uuid v0.0.0-20180906182336-adf5a7427709 W0927 18:09:00.415] go: downloading k8s.io/legacy-cloud-providers v0.0.0-20190624091455-d8621ceb9c64 W0927 18:09:00.465] go: extracting k8s.io/client-go v11.0.0+incompatible W0927 18:09:00.474] go: downloading github.com/gogo/protobuf v1.2.1 W0927 18:09:00.480] go: downloading github.com/golang/protobuf v1.3.0 W0927 18:09:00.716] go: downloading sigs.k8s.io/yaml v1.1.0 W0927 18:09:00.895] go: extracting google.golang.org/grpc v1.19.0 W0927 18:09:00.905] go: extracting sigs.k8s.io/yaml v1.1.0 W0927 18:09:00.928] go: downloading github.com/Azure/azure-sdk-for-go v21.4.0+incompatible W0927 18:09:01.023] go: extracting k8s.io/legacy-cloud-providers v0.0.0-20190624091455-d8621ceb9c64 W0927 18:09:01.081] go: extracting github.com/golang/protobuf v1.3.0 W0927 18:09:01.122] go: downloading k8s.io/cloud-provider v0.0.0-20190308083404-05ccf96446f8 W0927 18:09:01.513] go: extracting k8s.io/cloud-provider v0.0.0-20190308083404-05ccf96446f8 W0927 18:09:01.520] go: downloading github.com/Azure/go-autorest v11.5.1+incompatible W0927 18:09:01.671] go: extracting github.com/Azure/go-autorest v11.5.1+incompatible W0927 18:09:01.692] go: downloading gopkg.in/yaml.v2 v2.2.2 W0927 18:09:01.780] go: extracting gopkg.in/yaml.v2 v2.2.2 W0927 18:09:01.789] go: downloading k8s.io/klog v0.2.0 W0927 18:09:01.852] go: extracting k8s.io/klog v0.2.0 W0927 18:09:01.873] go: downloading github.com/google/gofuzz v0.0.0-20170612174753-24818f796faf W0927 18:09:01.917] go: extracting github.com/google/gofuzz v0.0.0-20170612174753-24818f796faf W0927 18:09:01.921] go: downloading golang.org/x/net v0.0.0-20190301231341-16b79f2e4e95 W0927 18:09:02.203] go: extracting github.com/gogo/protobuf v1.2.1 W0927 18:09:02.437] go: downloading golang.org/x/oauth2 v0.0.0-20190226205417-e64efc72b421 W0927 18:09:02.451] go: downloading github.com/pelletier/go-toml v1.4.0 W0927 18:09:02.589] go: extracting golang.org/x/oauth2 v0.0.0-20190226205417-e64efc72b421 W0927 18:09:02.637] go: extracting github.com/pelletier/go-toml v1.4.0 W0927 18:09:02.644] go: downloading github.com/golang/groupcache v0.0.0-20190129154638-5b532d6fd5ef W0927 18:09:02.721] go: extracting github.com/golang/groupcache v0.0.0-20190129154638-5b532d6fd5ef W0927 18:09:02.725] go: downloading github.com/davecgh/go-spew v1.1.1 W0927 18:09:02.794] go: extracting golang.org/x/net v0.0.0-20190301231341-16b79f2e4e95 W0927 18:09:02.801] go: extracting github.com/davecgh/go-spew v1.1.1 W0927 18:09:02.880] go: downloading golang.org/x/crypto v0.0.0-20190228161510-8dd112bcdc25 W0927 18:09:02.888] go: downloading github.com/google/uuid v1.1.1 W0927 18:09:02.979] go: extracting github.com/google/uuid v1.1.1 W0927 18:09:02.982] go: downloading github.com/onsi/ginkgo v1.7.0 W0927 18:09:03.246] go: extracting github.com/onsi/ginkgo v1.7.0 W0927 18:09:03.297] go: downloading golang.org/x/time v0.0.0-20181108054448-85acf8d2951c W0927 18:09:03.376] go: extracting golang.org/x/time v0.0.0-20181108054448-85acf8d2951c W0927 18:09:03.380] go: downloading github.com/prometheus/client_golang v0.9.2 W0927 18:09:03.770] go: extracting github.com/prometheus/client_golang v0.9.2 W0927 18:09:03.796] go: downloading golang.org/x/text v0.3.0 W0927 18:09:03.829] go: extracting golang.org/x/crypto v0.0.0-20190228161510-8dd112bcdc25 W0927 18:09:03.896] go: downloading github.com/beorn7/perks v0.0.0-20180321164747-3a771d992973 W0927 18:09:03.939] go: extracting github.com/beorn7/perks v0.0.0-20180321164747-3a771d992973 W0927 18:09:03.941] go: downloading github.com/rubiojr/go-vhd v0.0.0-20160810183302-0bfd3b39853c W0927 18:09:04.392] go: extracting github.com/rubiojr/go-vhd v0.0.0-20160810183302-0bfd3b39853c W0927 18:09:07.485] go: extracting golang.org/x/text v0.3.0 W0927 18:09:07.755] go: downloading k8s.io/utils v0.0.0-20190221042446-c2654d5206da W0927 18:09:07.756] go: downloading github.com/json-iterator/go v1.1.5 W0927 18:09:07.861] go: extracting k8s.io/utils v0.0.0-20190221042446-c2654d5206da W0927 18:09:07.869] go: extracting github.com/json-iterator/go v1.1.5 W0927 18:09:07.876] go: downloading github.com/prometheus/common v0.2.0 W0927 18:09:07.883] go: downloading k8s.io/kube-openapi v0.0.0-20190306001800-15615b16d372 W0927 18:09:07.976] go: extracting github.com/prometheus/common v0.2.0 W0927 18:09:07.995] go: downloading github.com/prometheus/procfs v0.0.0-20190306233201-d0f344d83b0c W0927 18:09:08.099] go: extracting github.com/prometheus/procfs v0.0.0-20190306233201-d0f344d83b0c W0927 18:09:08.162] go: downloading github.com/hashicorp/golang-lru v0.5.1 W0927 18:09:08.207] go: extracting github.com/hashicorp/golang-lru v0.5.1 W0927 18:09:08.211] go: downloading github.com/matttproud/golang_protobuf_extensions v1.0.1 W0927 18:09:08.273] go: extracting github.com/matttproud/golang_protobuf_extensions v1.0.1 W0927 18:09:08.285] go: downloading google.golang.org/genproto v0.0.0-20190307195333-5fe7a883aa19 W0927 18:09:08.631] go: extracting k8s.io/kube-openapi v0.0.0-20190306001800-15615b16d372 W0927 18:09:08.678] go: downloading github.com/prometheus/client_model v0.0.0-20190129233127-fd36f4220a90 W0927 18:09:08.781] go: extracting github.com/prometheus/client_model v0.0.0-20190129233127-fd36f4220a90 W0927 18:09:08.786] go: downloading github.com/dgrijalva/jwt-go v3.2.0+incompatible W0927 18:09:08.910] go: extracting github.com/dgrijalva/jwt-go v3.2.0+incompatible W0927 18:09:08.919] go: downloading github.com/mattn/go-ieproxy v0.0.0-20190610004146-91bb50d98149 W0927 18:09:08.964] go: extracting github.com/mattn/go-ieproxy v0.0.0-20190610004146-91bb50d98149 W0927 18:09:08.967] go: downloading github.com/modern-go/concurrent v0.0.0-20180306012644-bacd9c7ef1dd W0927 18:09:08.978] go: extracting github.com/kubernetes-csi/external-snapshotter v1.0.1 W0927 18:09:09.007] go: extracting github.com/modern-go/concurrent v0.0.0-20180306012644-bacd9c7ef1dd W0927 18:09:09.024] go: downloading github.com/modern-go/reflect2 v0.0.0-20180701023420-4b7aa43c6742 W0927 18:09:09.076] go: extracting github.com/modern-go/reflect2 v0.0.0-20180701023420-4b7aa43c6742 W0927 18:09:09.081] go: downloading golang.org/x/sys v0.0.0-20190308023053-584f3b12f43e W0927 18:09:10.189] go: extracting golang.org/x/sys v0.0.0-20190308023053-584f3b12f43e W0927 18:09:10.279] go: downloading go.opencensus.io v0.18.0 W0927 18:09:10.485] go: extracting go.opencensus.io v0.18.0 W0927 18:09:10.518] go: downloading contrib.go.opencensus.io/exporter/ocagent v0.2.0 W0927 18:09:10.575] go: extracting contrib.go.opencensus.io/exporter/ocagent v0.2.0 W0927 18:09:10.586] go: downloading github.com/googleapis/gnostic v0.2.0 W0927 18:09:11.082] go: extracting github.com/googleapis/gnostic v0.2.0 W0927 18:09:11.126] go: downloading github.com/census-instrumentation/opencensus-proto v0.1.0 W0927 18:09:11.383] go: extracting github.com/census-instrumentation/opencensus-proto v0.1.0 W0927 18:09:11.739] go: extracting github.com/Azure/azure-sdk-for-go v21.4.0+incompatible W0927 18:09:11.756] go: extracting google.golang.org/genproto v0.0.0-20190307195333-5fe7a883aa19 W0927 18:09:12.104] go: downloading google.golang.org/api v0.1.0 W0927 18:09:12.819] go: extracting k8s.io/kubernetes v1.14.0 W0927 18:09:13.208] go: downloading github.com/hpcloud/tail v1.0.0 W0927 18:09:13.210] go: downloading gopkg.in/inf.v0 v0.9.1 W0927 18:09:13.215] go: downloading github.com/satori/go.uuid v1.2.0 W0927 18:09:13.215] go: downloading github.com/marstr/guid v1.1.0 W0927 18:09:13.331] go: extracting gopkg.in/inf.v0 v0.9.1 W0927 18:09:13.339] go: extracting github.com/hpcloud/tail v1.0.0 W0927 18:09:13.339] go: extracting github.com/marstr/guid v1.1.0 W0927 18:09:13.339] go: extracting github.com/satori/go.uuid v1.2.0 W0927 18:09:13.343] go: downloading gopkg.in/tomb.v1 v1.0.0-20141024135613-dd632973f1e7 W0927 18:09:13.344] go: downloading gopkg.in/fsnotify.v1 v1.4.7 W0927 18:09:13.377] go: extracting gopkg.in/tomb.v1 v1.0.0-20141024135613-dd632973f1e7 W0927 18:09:13.401] go: extracting gopkg.in/fsnotify.v1 v1.4.7 W0927 18:09:14.431] go: downloading k8s.io/apiserver v0.0.0-20190313205120-8b27c41bdbb1 W0927 18:09:14.432] go: downloading github.com/pkg/errors v0.8.1 W0927 18:09:14.433] go: downloading k8s.io/component-base v0.0.0-20190313120452-4727f38490bc W0927 18:09:14.434] go: downloading k8s.io/kube-aggregator v0.0.0-20190401185513-77f9841f26eb W0927 18:09:14.435] go: downloading github.com/stretchr/testify v1.3.0 W0927 18:09:14.439] go: downloading k8s.io/apiextensions-apiserver v0.0.0-20190315093550-53c4693659ed W0927 18:09:14.600] go: extracting github.com/pkg/errors v0.8.1 W0927 18:09:14.609] go: extracting github.com/stretchr/testify v1.3.0 W0927 18:09:14.618] go: downloading github.com/spf13/pflag v1.0.3 W0927 18:09:14.634] go: extracting k8s.io/component-base v0.0.0-20190313120452-4727f38490bc W0927 18:09:14.646] go: downloading github.com/docker/spdystream v0.0.0-20181023171402-6480d4af844c W0927 18:09:14.679] go: extracting github.com/spf13/pflag v1.0.3 W0927 18:09:14.688] go: downloading github.com/imdario/mergo v0.3.7 W0927 18:09:14.706] go: extracting github.com/docker/spdystream v0.0.0-20181023171402-6480d4af844c W0927 18:09:14.739] go: extracting github.com/imdario/mergo v0.3.7 W0927 18:09:14.753] go: downloading k8s.io/csi-translation-lib v0.0.0-20190313124639-7f5cabc6aac8 W0927 18:09:14.970] go: extracting k8s.io/csi-translation-lib v0.0.0-20190313124639-7f5cabc6aac8 W0927 18:09:14.975] go: downloading k8s.io/cluster-bootstrap v0.0.0-20190313124217-0fa624df11e9 W0927 18:09:15.149] go: extracting k8s.io/apiserver v0.0.0-20190313205120-8b27c41bdbb1 W0927 18:09:15.190] go: extracting k8s.io/cluster-bootstrap v0.0.0-20190313124217-0fa624df11e9 W0927 18:09:15.193] go: downloading github.com/docker/distribution v0.0.0-20170905204447-5db89f0ca686 W0927 18:09:15.235] go: downloading gopkg.in/square/go-jose.v2 v2.3.0 W0927 18:09:15.236] go: downloading k8s.io/cli-runtime v0.0.0-20190314001948-2899ed30580f W0927 18:09:15.236] go: downloading github.com/pmezard/go-difflib v1.0.0 W0927 18:09:15.238] go: downloading github.com/fatih/camelcase v1.0.0 W0927 18:09:15.314] go: extracting github.com/fatih/camelcase v1.0.0 W0927 18:09:15.321] go: extracting github.com/pmezard/go-difflib v1.0.0 W0927 18:09:15.351] go: extracting k8s.io/cli-runtime v0.0.0-20190314001948-2899ed30580f W0927 18:09:15.367] go: downloading github.com/spf13/cobra v0.0.3 W0927 18:09:15.368] go: downloading sigs.k8s.io/kustomize v2.0.3+incompatible W0927 18:09:15.368] go: downloading github.com/gregjones/httpcache v0.0.0-20190212212710-3befbb6ad0cc W0927 18:09:15.369] go: downloading github.com/evanphx/json-patch v3.0.0+incompatible W0927 18:09:15.455] go: extracting github.com/gregjones/httpcache v0.0.0-20190212212710-3befbb6ad0cc W0927 18:09:15.456] go: extracting github.com/evanphx/json-patch v3.0.0+incompatible W0927 18:09:15.458] go: downloading github.com/peterbourgon/diskv v2.0.1+incompatible W0927 18:09:15.462] go: extracting gopkg.in/square/go-jose.v2 v2.3.0 W0927 18:09:15.508] go: extracting github.com/peterbourgon/diskv v2.0.1+incompatible W0927 18:09:15.546] go: extracting github.com/spf13/cobra v0.0.3 W0927 18:09:15.832] go: extracting github.com/docker/distribution v0.0.0-20170905204447-5db89f0ca686 W0927 18:09:16.061] go: extracting k8s.io/kube-aggregator v0.0.0-20190401185513-77f9841f26eb W0927 18:09:16.078] go: downloading github.com/google/btree v1.0.0 W0927 18:09:16.120] go: extracting github.com/google/btree v1.0.0 W0927 18:09:16.439] go: extracting sigs.k8s.io/kustomize v2.0.3+incompatible W0927 18:09:16.475] go: downloading github.com/ghodss/yaml v1.0.0 W0927 18:09:16.476] go: downloading github.com/opencontainers/go-digest v1.0.0-rc1 W0927 18:09:16.476] go: downloading github.com/go-openapi/spec v0.19.0 W0927 18:09:16.477] go: downloading github.com/emicklei/go-restful v2.9.3+incompatible W0927 18:09:16.640] go: extracting github.com/ghodss/yaml v1.0.0 W0927 18:09:16.696] go: extracting k8s.io/apiextensions-apiserver v0.0.0-20190315093550-53c4693659ed W0927 18:09:16.696] go: extracting github.com/opencontainers/go-digest v1.0.0-rc1 W0927 18:09:16.697] go: extracting github.com/emicklei/go-restful v2.9.3+incompatible W0927 18:09:16.746] go: extracting github.com/go-openapi/spec v0.19.0 W0927 18:09:16.774] go: downloading github.com/go-openapi/jsonreference v0.19.0 W0927 18:09:16.774] go: downloading github.com/go-openapi/jsonpointer v0.19.0 W0927 18:09:16.774] go: downloading github.com/go-openapi/swag v0.19.0 W0927 18:09:16.865] go: extracting github.com/go-openapi/jsonreference v0.19.0 W0927 18:09:16.867] go: downloading github.com/PuerkitoBio/purell v1.1.1 W0927 18:09:16.893] go: extracting github.com/go-openapi/jsonpointer v0.19.0 W0927 18:09:16.900] go: extracting github.com/go-openapi/swag v0.19.0 W0927 18:09:16.904] go: downloading github.com/mailru/easyjson v0.0.0-20190312143242-1de009706dbe W0927 18:09:16.924] go: extracting github.com/PuerkitoBio/purell v1.1.1 W0927 18:09:16.927] go: downloading github.com/PuerkitoBio/urlesc v0.0.0-20170810143723-de5bf2ad4578 W0927 18:09:16.957] go: extracting github.com/PuerkitoBio/urlesc v0.0.0-20170810143723-de5bf2ad4578 W0927 18:09:16.986] go: extracting github.com/mailru/easyjson v0.0.0-20190312143242-1de009706dbe W0927 18:09:18.321] go: extracting google.golang.org/api v0.1.0 W0927 18:09:18.826] go: downloading golang.org/x/sync v0.0.0-20190227155943-e225da77a7e6 W0927 18:09:19.305] go: extracting golang.org/x/sync v0.0.0-20190227155943-e225da77a7e6 I0927 18:10:09.857] Sep 27 18:10:09.857: INFO: The --provider flag is not set. Continuing as if --provider=skeleton had been used. I0927 18:10:09.857] === RUN TestE2E I0927 18:10:09.858] Running Suite: AzureFile CSI Driver End-to-End Tests I0927 18:10:09.858] ==================================================== I0927 18:10:09.858] Random Seed: 1569607809 - Will randomize all specs I0927 18:10:09.858] Will run 8 of 8 specs I0927 18:10:09.858] I0927 18:10:12.159] 2019/09/27 18:10:12 Attempting docker login with Azure service principal I0927 18:10:14.644] 2019/09/27 18:10:14 docker login is successful I0927 18:10:14.644] 2019/09/27 18:10:14 Installing Azure File CSI Driver... I0927 18:10:14.645] make[1]: Entering directory '/go/src/github.com/kubernetes-sigs/azurefile-csi-driver' I0927 18:10:14.646] # Use v2.11.0 helm to match tiller's version in clusters made by aks-engine I0927 18:10:14.646] curl https://raw.githubusercontent.com/helm/helm/master/scripts/get | DESIRED_VERSION=v2.11.0 bash I0927 18:10:14.676] % Total % Received % Xferd Average Speed Time Time Time Current I0927 18:10:14.676] Dload Upload Total Spent Left Speed I0927 18:10:14.718] 0 0 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0 100 7034 100 7034 0 0 162k 0 --:--:-- --:--:-- --:--:-- 163k I0927 18:10:14.734] Downloading https://get.helm.sh/helm-v2.11.0-linux-amd64.tar.gz I0927 18:10:16.654] Preparing to install helm and tiller into /usr/local/bin I0927 18:10:16.681] helm installed into /usr/local/bin/helm I0927 18:10:16.706] tiller installed into /usr/local/bin/tiller I0927 18:10:16.708] Run 'helm init' to configure helm. I0927 18:10:16.722] # Make sure tiller is ready I0927 18:10:16.723] kubectl wait pod -l name=tiller --namespace kube-system --for condition=ready I0927 18:10:19.068] pod/tiller-deploy-54c96cb5df-cr94j condition met I0927 18:10:19.070] helm version I0927 18:10:19.124] Client: &version.Version{SemVer:"v2.11.0", GitCommit:"2e55dbe1fdb5fdb96b75ff144a339489417b146b", GitTreeState:"clean"} I0927 18:10:19.818] Error: forwarding ports: error upgrading connection: no preferred addresses found; known addresses: [] I0927 18:10:19.820] Makefile:74: recipe for target 'install-helm' failed I0927 18:10:19.820] make[1]: *** [install-helm] Error 1 I0927 18:10:19.820] make[1]: Leaving directory '/go/src/github.com/kubernetes-sigs/azurefile-csi-driver' I0927 18:10:19.820] Failure [9.963 seconds] I0927 18:10:19.821] [BeforeSuite] BeforeSuite I0927 18:10:19.821] /go/src/github.com/kubernetes-sigs/azurefile-csi-driver/test/e2e/suite_test.go:54 I0927 18:10:19.821] I0927 18:10:19.821] Expected error: I0927 18:10:19.821] <*exec.ExitError | 0xc0009ce480>: { I0927 18:10:19.821] ProcessState: { I0927 18:10:19.821] pid: 23008, I0927 18:10:19.821] status: 512, I0927 18:10:19.822] rusage: { I0927 18:10:19.822] Utime: {Sec: 0, Usec: 897746}, I0927 18:10:19.822] Stime: {Sec: 0, Usec: 337855}, I0927 18:10:19.822] Maxrss: 50116, I0927 18:10:19.822] Ixrss: 0, I0927 18:10:19.822] Idrss: 0, I0927 18:10:19.822] Isrss: 0, I0927 18:10:19.822] Minflt: 10448, I0927 18:10:19.823] Majflt: 43, I0927 18:10:19.823] Nswap: 0, I0927 18:10:19.823] Inblock: 11104, I0927 18:10:19.823] Oublock: 286584, I0927 18:10:19.823] Msgsnd: 0, I0927 18:10:19.823] Msgrcv: 0, I0927 18:10:19.823] Nsignals: 0, I0927 18:10:19.823] Nvcsw: 3755, I0927 18:10:19.824] Nivcsw: 89, I0927 18:10:19.824] }, I0927 18:10:19.824] }, I0927 18:10:19.824] Stderr: nil, I0927 18:10:19.824] } I0927 18:10:19.824] exit status 2 I0927 18:10:19.824] not to have occurred I0927 18:10:19.824] I0927 18:10:19.824] /go/src/github.com/kubernetes-sigs/azurefile-csi-driver/test/e2e/suite_test.go:93 I0927 18:10:19.824] ------------------------------ I0927 18:10:19.825] 2019/09/27 18:10:19 Uninstalling Azure File CSI Driver... I0927 18:10:19.825] make[1]: Entering directory '/go/src/github.com/kubernetes-sigs/azurefile-csi-driver' I0927 18:10:19.825] helm delete --purge azurefile-csi-driver I0927 18:10:20.545] Error: forwarding ports: error upgrading connection: no preferred addresses found; known addresses: [] I0927 18:10:20.547] Makefile:82: recipe for target 'e2e-teardown' failed I0927 18:10:20.547] make[1]: *** [e2e-teardown] Error 1 I0927 18:10:20.547] make[1]: Leaving directory '/go/src/github.com/kubernetes-sigs/azurefile-csi-driver' I0927 18:10:20.548] Failure [0.727 seconds] I0927 18:10:20.548] [AfterSuite] AfterSuite I0927 18:10:20.548] /go/src/github.com/kubernetes-sigs/azurefile-csi-driver/test/e2e/suite_test.go:104 I0927 18:10:20.548] I0927 18:10:20.548] Expected error: I0927 18:10:20.548] <*exec.ExitError | 0xc0009ce6e0>: { I0927 18:10:20.548] ProcessState: { I0927 18:10:20.549] pid: 23069, I0927 18:10:20.549] status: 512, I0927 18:10:20.549] rusage: { I0927 18:10:20.549] Utime: {Sec: 0, Usec: 123363}, I0927 18:10:20.549] Stime: {Sec: 0, Usec: 21451}, I0927 18:10:20.549] Maxrss: 50116, I0927 18:10:20.549] Ixrss: 0, I0927 18:10:20.549] Idrss: 0, I0927 18:10:20.549] Isrss: 0, I0927 18:10:20.550] Minflt: 3857, I0927 18:10:20.550] Majflt: 0, I0927 18:10:20.550] Nswap: 0, I0927 18:10:20.550] Inblock: 0, I0927 18:10:20.550] Oublock: 0, I0927 18:10:20.550] Msgsnd: 0, I0927 18:10:20.550] Msgrcv: 0, I0927 18:10:20.550] Nsignals: 0, I0927 18:10:20.551] Nvcsw: 750, I0927 18:10:20.551] Nivcsw: 7, I0927 18:10:20.551] }, I0927 18:10:20.551] }, I0927 18:10:20.551] Stderr: nil, I0927 18:10:20.551] } I0927 18:10:20.551] exit status 2 I0927 18:10:20.551] not to have occurred I0927 18:10:20.551] I0927 18:10:20.552] /go/src/github.com/kubernetes-sigs/azurefile-csi-driver/test/e2e/suite_test.go:122 I0927 18:10:20.552] ------------------------------ I0927 18:10:20.552] I0927 18:10:20.552] Ran 8 of 0 Specs in 10.691 seconds I0927 18:10:20.552] FAIL! -- 0 Passed | 8 Failed | 0 Pending | 0 Skipped I0927 18:10:20.552] --- FAIL: TestE2E (10.69s) I0927 18:10:20.552] FAIL I0927 18:10:20.553] FAIL github.com/kubernetes-sigs/azurefile-csi-driver/test/e2e 10.742s I0927 18:10:21.400] Makefile:58: recipe for target 'e2e-test' failed W0927 18:10:21.501] make: *** [e2e-test] Error 1 W0927 18:10:21.501] 2019/09/27 18:10:21 process.go:155: Step 'make e2e-test' finished in 1m48.967490564s W0927 18:10:21.501] 2019/09/27 18:10:21 azure.go:899: Deleting resource group: kubetest-67b67849-e14d-11e9-b1b0-0242b3fbd891. W0927 18:21:46.394] 2019/09/27 18:21:46 process.go:96: Saved XML output to /workspace/_artifacts/junit_runner.xml. W0927 18:21:46.394] 2019/09/27 18:21:46 process.go:153: Running: bash -c . hack/lib/version.sh && KUBE_ROOT=. kube::version::get_version_vars && echo "${KUBE_GIT_VERSION-}" W0927 18:21:47.079] 2019/09/27 18:21:47 process.go:155: Step 'bash -c . hack/lib/version.sh && KUBE_ROOT=. kube::version::get_version_vars && echo "${KUBE_GIT_VERSION-}"' finished in 685.140568ms W0927 18:21:47.079] 2019/09/27 18:21:47 main.go:319: Something went wrong: encountered 1 errors: [error during make e2e-test: exit status 2] W0927 18:21:47.081] Traceback (most recent call last): W0927 18:21:47.081] File "/workspace/./test-infra/jenkins/../scenarios/kubernetes_e2e.py", line 778, in W0927 18:21:47.082] main(parse_args()) W0927 18:21:47.082] File "/workspace/./test-infra/jenkins/../scenarios/kubernetes_e2e.py", line 626, in main W0927 18:21:47.082] mode.start(runner_args) W0927 18:21:47.082] File "/workspace/./test-infra/jenkins/../scenarios/kubernetes_e2e.py", line 262, in start W0927 18:21:47.082] check_env(env, self.command, *args) W0927 18:21:47.082] File "/workspace/./test-infra/jenkins/../scenarios/kubernetes_e2e.py", line 111, in check_env W0927 18:21:47.083] subprocess.check_call(cmd, env=env) W0927 18:21:47.083] File "/usr/lib/python2.7/subprocess.py", line 186, in check_call W0927 18:21:47.083] raise CalledProcessError(retcode, cmd) W0927 18:21:47.084] subprocess.CalledProcessError: Command '('kubetest', '--dump=/workspace/_artifacts', '--gcp-service-account=/etc/service-account/service-account.json', '--build=bazel', '--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-location=eastus2', '--acsengine-public-key=/etc/azure-ssh/azure-ssh-pub', '--acsengine-template-url=https://raw.githubusercontent.com/kubernetes/cloud-provider-azure/master/tests/k8s-azure/manifest/linux.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-file-csi-driver=True')' returned non-zero exit status 1 E0927 18:21:47.088] Command failed I0927 18:21:47.089] process 684 exited with code 1 after 44.8m E0927 18:21:47.089] FAIL: pull-azurefile-csi-driver-e2e I0927 18:21:47.089] Call: gcloud auth activate-service-account --key-file=/etc/service-account/service-account.json W0927 18:21:47.911] Activated service account credentials for: [kubernetes-upstream@kubernetes-upstream.iam.gserviceaccount.com] I0927 18:21:47.942] process 23119 exited with code 0 after 0.0m I0927 18:21:47.943] Call: gcloud config get-value account I0927 18:21:48.176] process 23131 exited with code 0 after 0.0m I0927 18:21:48.177] Will upload results to gs://kubernetes-upstream/pr-logs using kubernetes-upstream@kubernetes-upstream.iam.gserviceaccount.com I0927 18:21:48.177] Upload result and artifacts... I0927 18:21:48.177] Gubernator results at https://gubernator.k8s.io/build/kubernetes-upstream/pr-logs/pull/kubernetes-sigs_azurefile-csi-driver/120/pull-azurefile-csi-driver-e2e/1177637452253237252 I0927 18:21:48.177] Call: gsutil ls gs://kubernetes-upstream/pr-logs/pull/kubernetes-sigs_azurefile-csi-driver/120/pull-azurefile-csi-driver-e2e/1177637452253237252/artifacts W0927 18:21:49.362] CommandException: One or more URLs matched no objects. E0927 18:21:49.442] Command failed I0927 18:21:49.442] process 23143 exited with code 1 after 0.0m W0927 18:21:49.442] Remote dir gs://kubernetes-upstream/pr-logs/pull/kubernetes-sigs_azurefile-csi-driver/120/pull-azurefile-csi-driver-e2e/1177637452253237252/artifacts not exist yet I0927 18:21:49.442] Call: gsutil -m -q -o GSUtil:use_magicfile=True cp -r -c -z log,txt,xml /workspace/_artifacts gs://kubernetes-upstream/pr-logs/pull/kubernetes-sigs_azurefile-csi-driver/120/pull-azurefile-csi-driver-e2e/1177637452253237252/artifacts I0927 18:21:51.102] process 23285 exited with code 0 after 0.0m I0927 18:21:51.102] Call: git rev-parse HEAD I0927 18:21:51.106] process 23812 exited with code 0 after 0.0m I0927 18:21:51.106] Call: git rev-parse HEAD I0927 18:21:51.110] process 23813 exited with code 0 after 0.0m I0927 18:21:51.110] Call: gsutil stat gs://kubernetes-upstream/pr-logs/directory/pull-azurefile-csi-driver-e2e/jobResultsCache.json I0927 18:21:52.035] process 23814 exited with code 0 after 0.0m I0927 18:21:52.035] Call: gsutil -q cat 'gs://kubernetes-upstream/pr-logs/directory/pull-azurefile-csi-driver-e2e/jobResultsCache.json#1569566845733824' I0927 18:21:53.229] process 23956 exited with code 0 after 0.0m I0927 18:21:53.230] Call: gsutil -q -h Content-Type:application/json -h x-goog-if-generation-match:1569566845733824 cp /tmp/gsutil_Mg75wp gs://kubernetes-upstream/pr-logs/directory/pull-azurefile-csi-driver-e2e/jobResultsCache.json I0927 18:21:54.464] process 24100 exited with code 0 after 0.0m I0927 18:21:54.465] Call: gsutil stat gs://kubernetes-upstream/pr-logs/pull/kubernetes-sigs_azurefile-csi-driver/120/pull-azurefile-csi-driver-e2e/jobResultsCache.json I0927 18:21:55.379] process 24278 exited with code 0 after 0.0m I0927 18:21:55.379] Call: gsutil -q cat 'gs://kubernetes-upstream/pr-logs/pull/kubernetes-sigs_azurefile-csi-driver/120/pull-azurefile-csi-driver-e2e/jobResultsCache.json#1569566849216742' I0927 18:21:56.481] process 24420 exited with code 0 after 0.0m I0927 18:21:56.482] Call: gsutil -q -h Content-Type:application/json -h x-goog-if-generation-match:1569566849216742 cp /tmp/gsutil_1J4Xti gs://kubernetes-upstream/pr-logs/pull/kubernetes-sigs_azurefile-csi-driver/120/pull-azurefile-csi-driver-e2e/jobResultsCache.json I0927 18:21:57.844] process 24564 exited with code 0 after 0.0m I0927 18:21:57.844] Call: gsutil -q -h Content-Type:application/json cp /tmp/gsutil_DccXFQ gs://kubernetes-upstream/pr-logs/pull/kubernetes-sigs_azurefile-csi-driver/120/pull-azurefile-csi-driver-e2e/1177637452253237252/finished.json I0927 18:21:59.071] process 24742 exited with code 0 after 0.0m I0927 18:21:59.072] Call: gsutil -q -h Content-Type:text/plain -h 'Cache-Control:private, max-age=0, no-transform' cp /tmp/gsutil_YecwCv gs://kubernetes-upstream/pr-logs/pull/kubernetes-sigs_azurefile-csi-driver/120/pull-azurefile-csi-driver-e2e/latest-build.txt I0927 18:22:00.358] process 24920 exited with code 0 after 0.0m I0927 18:22:00.358] Call: gsutil -q -h Content-Type:text/plain -h 'Cache-Control:private, max-age=0, no-transform' cp /tmp/gsutil_Sg7FAM gs://kubernetes-upstream/pr-logs/directory/pull-azurefile-csi-driver-e2e/latest-build.txt I0927 18:22:01.764] process 25098 exited with code 0 after 0.0m