W1026 17:13:51.402] **************************************************************************
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
**************************************************************************
I1026 17:13:51.403] Args: --job=ci-kubernetes-e2enode-ubuntu2-k8sstable3-gkespec --service-account=/etc/service-account/service-account.json --upload=gs://kubernetes-jenkins/logs --timeout=140 --repo=k8s.io/kubernetes=release-1.16 --root=/go/src --scenario=kubernetes_e2e -- --deployment=node --node-tests=true --provider=gce --gcp-zone=us-west1-b --image-family=pipeline-2 --image-project=ubuntu-os-gke-cloud-devel --timeout=120m '--test_args=--nodes=8 --skip="\[Flaky\]|\[Serial\]|\[NodeAlphaFeature:.+\]"' --node-args=--system-spec-name=gke --gcp-project=ubuntu-image-validation
I1026 17:13:51.403] Bootstrap ci-kubernetes-e2enode-ubuntu2-k8sstable3-gkespec...
I1026 17:13:51.405] Builder: 8d8396f5-17ae-11eb-b256-6ee25ea2e440
I1026 17:13:51.405] Image: gcr.io/k8s-testimages/kubekins-e2e:v20201021-a62ce8a-1.16
I1026 17:13:51.405] Gubernator results at https://gubernator.k8s.io/build/kubernetes-jenkins/logs/ci-kubernetes-e2enode-ubuntu2-k8sstable3-gkespec/1320775543683026944
I1026 17:13:51.406] Call:  gcloud auth activate-service-account --key-file=/etc/service-account/service-account.json
W1026 17:13:52.108] Activated service account credentials for: [pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com]
I1026 17:13:52.240] process 35 exited with code 0 after 0.0m
I1026 17:13:52.240] Call:  gcloud config get-value account
I1026 17:13:52.906] process 48 exited with code 0 after 0.0m
I1026 17:13:52.906] Will upload results to gs://kubernetes-jenkins/logs using pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com
I1026 17:13:52.907] Root: /go/src
I1026 17:13:52.907] cd to /go/src
I1026 17:13:52.907] Checkout: /go/src/k8s.io/kubernetes release-1.16 to /go/src/k8s.io/kubernetes
I1026 17:13:52.907] Call:  git init k8s.io/kubernetes
I1026 17:13:52.914] Initialized empty Git repository in /go/src/k8s.io/kubernetes/.git/
I1026 17:13:52.915] process 61 exited with code 0 after 0.0m
I1026 17:13:52.916] Call:  git config --local user.name 'K8S Bootstrap'
I1026 17:13:52.921] process 62 exited with code 0 after 0.0m
I1026 17:13:52.921] Call:  git config --local user.email k8s_bootstrap@localhost
I1026 17:13:52.927] process 63 exited with code 0 after 0.0m
I1026 17:13:52.927] Call:  git fetch --quiet --tags https://github.com/kubernetes/kubernetes release-1.16
I1026 17:16:01.722] process 64 exited with code 0 after 2.1m
I1026 17:16:01.723] Call:  git checkout -B test FETCH_HEAD
W1026 17:16:04.802] Switched to a new branch 'test'
I1026 17:16:04.841] process 75 exited with code 0 after 0.1m
I1026 17:16:04.841] Call:  git show -s --format=format:%ct HEAD
I1026 17:16:04.847] process 76 exited with code 0 after 0.0m
I1026 17:16:04.847] Configure environment...
I1026 17:16:04.848] Call:  git show -s --format=format:%ct HEAD
I1026 17:16:04.854] process 77 exited with code 0 after 0.0m
I1026 17:16:04.854] Call:  gcloud auth activate-service-account --key-file=/etc/service-account/service-account.json
W1026 17:16:05.690] Activated service account credentials for: [pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com]
I1026 17:16:06.071] process 78 exited with code 0 after 0.0m
I1026 17:16:06.072] Call:  gcloud config get-value account
I1026 17:16:06.724] process 91 exited with code 0 after 0.0m
I1026 17:16:06.725] Will upload results to gs://kubernetes-jenkins/logs using pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com
I1026 17:16:06.725] 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
'
I1026 17:16:07.379] process 104 exited with code 0 after 0.0m
I1026 17:16:07.379] Start 1320775543683026944 at v1.16.16-rc.0.1+18936c8b181de5...
I1026 17:16:07.382] Call:  gsutil -q -h Content-Type:application/json cp /tmp/gsutil_XlGOdp gs://kubernetes-jenkins/logs/ci-kubernetes-e2enode-ubuntu2-k8sstable3-gkespec/1320775543683026944/started.json
I1026 17:16:09.121] process 137 exited with code 0 after 0.0m
I1026 17:16:09.122] Call:  /workspace/./test-infra/jenkins/../scenarios/kubernetes_e2e.py --deployment=node --node-tests=true --provider=gce --gcp-zone=us-west1-b --image-family=pipeline-2 --image-project=ubuntu-os-gke-cloud-devel --timeout=120m '--test_args=--nodes=8 --skip="\[Flaky\]|\[Serial\]|\[NodeAlphaFeature:.+\]"' --node-args=--system-spec-name=gke --gcp-project=ubuntu-image-validation
W1026 17:16:09.177] starts with local mode
W1026 17:16:09.177] Environment:
W1026 17:16:09.177] ARTIFACTS=/workspace/_artifacts
W1026 17:16:09.177] AWS_SSH_PRIVATE_KEY_FILE=/root/.ssh/kube_aws_rsa
W1026 17:16:09.178] AWS_SSH_PUBLIC_KEY_FILE=/root/.ssh/kube_aws_rsa.pub
W1026 17:16:09.178] BAZEL_REMOTE_CACHE_ENABLED=false
W1026 17:16:09.178] BAZEL_VERSION=2.2.0
W1026 17:16:09.178] BOOTSTRAP_MIGRATION=yes
W1026 17:16:09.178] BOSKOS_METRICS_PORT=tcp://10.63.252.110:9090
W1026 17:16:09.178] BOSKOS_METRICS_PORT_9090_TCP=tcp://10.63.252.110:9090
W1026 17:16:09.178] BOSKOS_METRICS_PORT_9090_TCP_ADDR=10.63.252.110
W1026 17:16:09.179] BOSKOS_METRICS_PORT_9090_TCP_PORT=9090
W1026 17:16:09.179] BOSKOS_METRICS_PORT_9090_TCP_PROTO=tcp
W1026 17:16:09.179] BOSKOS_METRICS_SERVICE_HOST=10.63.252.110
W1026 17:16:09.179] BOSKOS_METRICS_SERVICE_PORT=9090
W1026 17:16:09.179] BOSKOS_METRICS_SERVICE_PORT_METRICS=9090
W1026 17:16:09.179] BOSKOS_PORT=tcp://10.63.250.132:80
W1026 17:16:09.179] BOSKOS_PORT_80_TCP=tcp://10.63.250.132:80
W1026 17:16:09.179] BOSKOS_PORT_80_TCP_ADDR=10.63.250.132
W1026 17:16:09.180] BOSKOS_PORT_80_TCP_PORT=80
W1026 17:16:09.180] BOSKOS_PORT_80_TCP_PROTO=tcp
W1026 17:16:09.180] BOSKOS_SERVICE_HOST=10.63.250.132
W1026 17:16:09.180] BOSKOS_SERVICE_PORT=80
W1026 17:16:09.180] BOSKOS_SERVICE_PORT_DEFAULT=80
W1026 17:16:09.180] BUILD_ID=1320775543683026944
W1026 17:16:09.180] BUILD_NUMBER=1320775543683026944
W1026 17:16:09.181] CI=true
W1026 17:16:09.181] CLOUDSDK_COMPONENT_MANAGER_DISABLE_UPDATE_CHECK=true
W1026 17:16:09.181] CLOUDSDK_CONFIG=/go/src/k8s.io/kubernetes/.config/gcloud
W1026 17:16:09.181] CLOUDSDK_CORE_DISABLE_PROMPTS=1
W1026 17:16:09.181] CLOUDSDK_EXPERIMENTAL_FAST_COMPONENT_UPDATE=false
W1026 17:16:09.181] DOCKER_IN_DOCKER_ENABLED=false
W1026 17:16:09.181] DOCKER_IN_DOCKER_IPV6_ENABLED=false
W1026 17:16:09.182] E2E_GOOGLE_APPLICATION_CREDENTIALS=/etc/service-account/service-account.json
W1026 17:16:09.182] GCS_ARTIFACTS_DIR=gs://kubernetes-jenkins/logs/ci-kubernetes-e2enode-ubuntu2-k8sstable3-gkespec/1320775543683026944/artifacts
W1026 17:16:09.182] GOOGLE_APPLICATION_CREDENTIALS=/etc/service-account/service-account.json
W1026 17:16:09.182] GOOGLE_APPLICATION_CREDENTIALS_DEPRECATED=Migrate to workload identity, contact sig-testing
W1026 17:16:09.182] GOPATH=/go
W1026 17:16:09.182] GOPROXY=https://proxy.golang.org
W1026 17:16:09.183] GO_TARBALL=go1.13.15.linux-amd64.tar.gz
W1026 17:16:09.183] HOME=/workspace
W1026 17:16:09.183] HOSTNAME=8d8396f5-17ae-11eb-b256-6ee25ea2e440
W1026 17:16:09.183] IMAGE=gcr.io/k8s-testimages/kubekins-e2e:v20201021-a62ce8a-1.16
W1026 17:16:09.183] INSTANCE_PREFIX=bootstrap-e2e
W1026 17:16:09.183] JENKINS_GCE_SSH_PRIVATE_KEY_FILE=/workspace/.ssh/google_compute_engine
W1026 17:16:09.184] JENKINS_GCE_SSH_PUBLIC_KEY_FILE=/workspace/.ssh/google_compute_engine.pub
W1026 17:16:09.184] JOB_NAME=ci-kubernetes-e2enode-ubuntu2-k8sstable3-gkespec
W1026 17:16:09.184] JOB_SPEC={"type":"periodic","job":"ci-kubernetes-e2enode-ubuntu2-k8sstable3-gkespec","buildid":"1320775543683026944","prowjobid":"8d8396f5-17ae-11eb-b256-6ee25ea2e440"}
W1026 17:16:09.184] JOB_TYPE=periodic
W1026 17:16:09.184] KUBERNETES_PORT=tcp://10.63.240.1:443
W1026 17:16:09.185] KUBERNETES_PORT_443_TCP=tcp://10.63.240.1:443
W1026 17:16:09.185] KUBERNETES_PORT_443_TCP_ADDR=10.63.240.1
W1026 17:16:09.185] KUBERNETES_PORT_443_TCP_PORT=443
W1026 17:16:09.185] KUBERNETES_PORT_443_TCP_PROTO=tcp
W1026 17:16:09.185] KUBERNETES_SERVICE_HOST=10.63.240.1
W1026 17:16:09.185] KUBERNETES_SERVICE_PORT=443
W1026 17:16:09.185] KUBERNETES_SERVICE_PORT_HTTPS=443
W1026 17:16:09.186] KUBETEST_IN_DOCKER=true
W1026 17:16:09.186] KUBETEST_MANUAL_DUMP=y
W1026 17:16:09.186] KUBE_AWS_INSTANCE_PREFIX=bootstrap-e2e
W1026 17:16:09.186] KUBE_GCE_INSTANCE_PREFIX=bootstrap-e2e
W1026 17:16:09.186] LOG_DUMP_SCRIPT_PATH=/workspace/log-dump.sh
W1026 17:16:09.186] NODE_NAME=8d8396f5-17ae-11eb-b256-6ee25ea2e440
W1026 17:16:09.186] 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
W1026 17:16:09.187] PROW_JOB_ID=8d8396f5-17ae-11eb-b256-6ee25ea2e440
W1026 17:16:09.187] PWD=/workspace
W1026 17:16:09.187] SHLVL=2
W1026 17:16:09.187] SOURCE_DATE_EPOCH=1599050720
W1026 17:16:09.187] TERM=xterm
W1026 17:16:09.187] USER=prow
W1026 17:16:09.187] WORKSPACE=/workspace
W1026 17:16:09.187] _=./test-infra/jenkins/bootstrap.py
W1026 17:16:09.188] Run: ('kubetest', '--dump=/workspace/_artifacts', '--gcp-service-account=/etc/service-account/service-account.json', '--up', '--down', '--test', '--deployment=node', '--provider=gce', '--cluster=bootstrap-e2e', '--gcp-network=bootstrap-e2e', '--node-tests=true', '--gcp-zone=us-west1-b', '--image-family=pipeline-2', '--image-project=ubuntu-os-gke-cloud-devel', '--timeout=120m', '--test_args=--nodes=8 --skip="\\[Flaky\\]|\\[Serial\\]|\\[NodeAlphaFeature:.+\\]"', '--node-args=--system-spec-name=gke', '--gcp-project=ubuntu-image-validation')
W1026 17:16:09.462] 2020/10/26 17:16:09 Warning: Couldn't find directory src/sigs.k8s.io/cloud-provider-azure under any of GOPATH /go, defaulting to /go/src/k8s.io/cloud-provider-azure
W1026 17:16:09.463] 2020/10/26 17:16:09 main.go:329: Limiting testing to 2h0m0s
W1026 17:16:09.463] 2020/10/26 17:16:09 process.go:153: Running: gcloud auth activate-service-account --key-file=/etc/service-account/service-account.json
W1026 17:16:10.146] Activated service account credentials for: [pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com]
W1026 17:16:10.278] 2020/10/26 17:16:10 process.go:155: Step 'gcloud auth activate-service-account --key-file=/etc/service-account/service-account.json' finished in 815.290331ms
W1026 17:16:10.279] 2020/10/26 17:16:10 process.go:153: Running: gcloud compute images describe-from-family pipeline-2 --project ubuntu-os-gke-cloud-devel
W1026 17:16:11.641] 2020/10/26 17:16:11 process.go:155: Step 'gcloud compute images describe-from-family pipeline-2 --project ubuntu-os-gke-cloud-devel' finished in 1.362197252s
W1026 17:16:11.641] 2020/10/26 17:16:11 process.go:153: Running: gcloud config set project ubuntu-image-validation
W1026 17:16:12.179] Updated property [core/project].
W1026 17:16:12.454] 2020/10/26 17:16:12 process.go:155: Step 'gcloud config set project ubuntu-image-validation' finished in 813.362877ms
W1026 17:16:12.455] 2020/10/26 17:16:12 main.go:779: Checking existing of GCP ssh keys...
W1026 17:16:12.455] 2020/10/26 17:16:12 main.go:789: Checking presence of public key in ubuntu-image-validation
W1026 17:16:12.455] 2020/10/26 17:16:12 process.go:153: Running: gcloud compute --project=ubuntu-image-validation project-info describe
W1026 17:16:13.741] 2020/10/26 17:16:13 process.go:155: Step 'gcloud compute --project=ubuntu-image-validation project-info describe' finished in 1.286739084s
W1026 17:16:13.742] 2020/10/26 17:16:13 node.go:62: Noop - Node KubectlCommand()
W1026 17:16:13.742] 2020/10/26 17:16:13 node.go:53: Noop - Node Down()
W1026 17:16:13.742] 2020/10/26 17:16:13 node.go:34: Noop - Node Up()
W1026 17:16:13.742] 2020/10/26 17:16:13 node.go:48: Noop - Node TestSetup()
W1026 17:16:13.742] 2020/10/26 17:16:13 e2e.go:560: cwd : /go/src/k8s.io/kubernetes
W1026 17:16:13.743] 2020/10/26 17:16:13 process.go:153: Running: go run /go/src/k8s.io/kubernetes/test/e2e_node/runner/remote/run_remote.go --cleanup --logtostderr --vmodule=*=4 --ssh-env=gce --results-dir=/workspace/_artifacts --project=ubuntu-image-validation --zone=us-west1-b --ssh-user=prow --ssh-key=/workspace/.ssh/google_compute_engine --ginkgo-flags=--nodes=8 --skip="\[Flaky\]|\[Serial\]|\[NodeAlphaFeature:.+\]" --test_args= --test-timeout=2h0m0s --system-spec-name=gke --images=ubuntu-gke-1804-1-16-v20200824 --image-project=ubuntu-os-gke-cloud-devel
W1026 17:16:14.684] go: downloading google.golang.org/api v0.6.1-0.20190607001116-5213b8090861
W1026 17:16:14.684] go: downloading golang.org/x/oauth2 v0.0.0-20190604053449-0f29369cfe45
W1026 17:16:14.685] go: downloading k8s.io/klog v1.0.0
W1026 17:16:14.691] go: downloading github.com/pborman/uuid v1.2.0
W1026 17:16:14.760] go: downloading sigs.k8s.io/yaml v1.1.0
W1026 17:16:14.771] go: downloading github.com/pkg/errors v0.8.1
W1026 17:16:14.772] go: downloading github.com/gogo/protobuf v1.2.2-0.20190723190241-65acae22fc9d
W1026 17:16:14.773] go: extracting golang.org/x/oauth2 v0.0.0-20190604053449-0f29369cfe45
W1026 17:16:14.775] go: extracting github.com/pborman/uuid v1.2.0
W1026 17:16:14.862] go: extracting github.com/pkg/errors v0.8.1
W1026 17:16:14.863] go: extracting k8s.io/klog v1.0.0
W1026 17:16:14.863] go: extracting sigs.k8s.io/yaml v1.1.0
W1026 17:16:14.869] go: downloading github.com/davecgh/go-spew v1.1.1
W1026 17:16:14.876] go: downloading gopkg.in/inf.v0 v0.9.1
W1026 17:16:14.962] go: downloading gopkg.in/yaml.v2 v2.2.8
W1026 17:16:14.965] go: downloading golang.org/x/net v0.0.0-20191004110552-13f9640d40b9
W1026 17:16:14.970] go: downloading github.com/google/uuid v1.1.1
W1026 17:16:14.974] go: downloading github.com/evanphx/json-patch v4.9.0+incompatible
W1026 17:16:15.060] go: extracting gopkg.in/inf.v0 v0.9.1
W1026 17:16:15.061] go: downloading golang.org/x/time v0.0.0-20190308202827-9d24e82272b4
W1026 17:16:15.063] go: extracting github.com/evanphx/json-patch v4.9.0+incompatible
W1026 17:16:15.065] go: downloading golang.org/x/crypto v0.0.0-20200220183623-bac4c82f6975
W1026 17:16:15.069] go: extracting github.com/google/uuid v1.1.1
W1026 17:16:15.070] go: extracting gopkg.in/yaml.v2 v2.2.8
W1026 17:16:15.070] go: extracting github.com/davecgh/go-spew v1.1.1
W1026 17:16:15.075] go: extracting golang.org/x/time v0.0.0-20190308202827-9d24e82272b4
W1026 17:16:15.167] go: downloading k8s.io/utils v0.0.0-20190801114015-581e00157fb1
W1026 17:16:15.168] go: downloading github.com/golang/protobuf v1.3.1
W1026 17:16:15.260] go: downloading github.com/modern-go/reflect2 v1.0.1
W1026 17:16:15.263] go: downloading github.com/hashicorp/golang-lru v0.5.1
W1026 17:16:15.274] go: extracting github.com/modern-go/reflect2 v1.0.1
W1026 17:16:15.363] go: extracting github.com/hashicorp/golang-lru v0.5.1
W1026 17:16:15.363] go: extracting k8s.io/utils v0.0.0-20190801114015-581e00157fb1
W1026 17:16:15.371] go: downloading github.com/prometheus/client_golang v0.9.2
W1026 17:16:15.460] go: downloading github.com/prometheus/procfs v0.0.0-20181204211112-1dc9a6cbc91a
W1026 17:16:15.566] go: downloading github.com/blang/semver v3.5.0+incompatible
W1026 17:16:15.569] go: extracting github.com/golang/protobuf v1.3.1
W1026 17:16:15.571] go: extracting github.com/prometheus/procfs v0.0.0-20181204211112-1dc9a6cbc91a
W1026 17:16:15.665] go: extracting github.com/prometheus/client_golang v0.9.2
W1026 17:16:15.668] go: extracting github.com/blang/semver v3.5.0+incompatible
W1026 17:16:15.768] go: downloading github.com/prometheus/client_model v0.0.0-20180712105110-5c3871d89910
W1026 17:16:15.771] go: downloading k8s.io/kube-openapi v0.0.0-20200410163147-594e756bea31
W1026 17:16:15.871] go: downloading github.com/prometheus/common v0.0.0-20181126121408-4724e9255275
W1026 17:16:15.876] go: extracting github.com/prometheus/client_model v0.0.0-20180712105110-5c3871d89910
W1026 17:16:16.063] go: downloading github.com/googleapis/gnostic v0.0.0-20170729233727-0c5108395e2d
W1026 17:16:16.064] go: extracting golang.org/x/net v0.0.0-20191004110552-13f9640d40b9
W1026 17:16:16.071] go: downloading github.com/google/gofuzz v1.0.0
W1026 17:16:16.072] go: extracting github.com/prometheus/common v0.0.0-20181126121408-4724e9255275
W1026 17:16:16.161] go: extracting golang.org/x/crypto v0.0.0-20200220183623-bac4c82f6975
W1026 17:16:16.168] go: extracting github.com/google/gofuzz v1.0.0
W1026 17:16:16.172] go: downloading github.com/stretchr/testify v1.3.0
W1026 17:16:16.363] go: downloading github.com/beorn7/perks v0.0.0-20180321164747-3a771d992973
W1026 17:16:16.369] go: extracting github.com/stretchr/testify v1.3.0
W1026 17:16:16.460] go: extracting github.com/beorn7/perks v0.0.0-20180321164747-3a771d992973
W1026 17:16:16.466] go: downloading cloud.google.com/go v0.38.0
W1026 17:16:16.468] go: extracting github.com/googleapis/gnostic v0.0.0-20170729233727-0c5108395e2d
W1026 17:16:16.568] go: downloading github.com/google/go-cmp v0.3.0
W1026 17:16:16.667] go: extracting k8s.io/kube-openapi v0.0.0-20200410163147-594e756bea31
W1026 17:16:16.765] go: extracting github.com/google/go-cmp v0.3.0
W1026 17:16:16.863] go: downloading github.com/modern-go/concurrent v0.0.0-20180306012644-bacd9c7ef1dd
W1026 17:16:16.961] go: extracting github.com/modern-go/concurrent v0.0.0-20180306012644-bacd9c7ef1dd
W1026 17:16:16.971] go: extracting github.com/gogo/protobuf v1.2.2-0.20190723190241-65acae22fc9d
W1026 17:16:16.972] go: downloading github.com/json-iterator/go v1.1.7
W1026 17:16:17.063] go: downloading github.com/golang/groupcache v0.0.0-20160516000752-02826c3e7903
W1026 17:16:17.160] go: extracting github.com/golang/groupcache v0.0.0-20160516000752-02826c3e7903
W1026 17:16:17.168] go: downloading gopkg.in/square/go-jose.v2 v2.2.2
W1026 17:16:17.262] go: downloading github.com/spf13/pflag v1.0.5
W1026 17:16:17.268] go: extracting github.com/json-iterator/go v1.1.7
W1026 17:16:17.364] go: extracting github.com/spf13/pflag v1.0.5
W1026 17:16:17.372] go: downloading github.com/matttproud/golang_protobuf_extensions v1.0.1
W1026 17:16:17.374] go: extracting gopkg.in/square/go-jose.v2 v2.2.2
W1026 17:16:17.464] go: downloading github.com/pmezard/go-difflib v1.0.0
W1026 17:16:17.472] go: downloading golang.org/x/sys v0.0.0-20190813064441-fde4db37ae7a
W1026 17:16:17.475] go: extracting github.com/matttproud/golang_protobuf_extensions v1.0.1
W1026 17:16:17.574] go: downloading golang.org/x/text v0.3.2
W1026 17:16:17.574] go: downloading github.com/imdario/mergo v0.3.5
W1026 17:16:17.661] go: extracting github.com/pmezard/go-difflib v1.0.0
W1026 17:16:17.664] go: downloading github.com/docker/distribution v2.7.1+incompatible
W1026 17:16:17.761] go: extracting github.com/imdario/mergo v0.3.5
W1026 17:16:18.276] go: extracting github.com/docker/distribution v2.7.1+incompatible
W1026 17:16:18.278] go: extracting cloud.google.com/go v0.38.0
W1026 17:16:18.576] go: extracting golang.org/x/sys v0.0.0-20190813064441-fde4db37ae7a
W1026 17:16:18.760] go: downloading github.com/opencontainers/go-digest v1.0.0-rc1
W1026 17:16:18.772] go: extracting github.com/opencontainers/go-digest v1.0.0-rc1
W1026 17:16:19.962] go: extracting golang.org/x/text v0.3.2
W1026 17:16:20.596] go: extracting google.golang.org/api v0.6.1-0.20190607001116-5213b8090861
W1026 17:16:21.913] go: downloading go.opencensus.io v0.21.0
W1026 17:16:21.914] go: downloading google.golang.org/grpc v1.23.0
W1026 17:16:21.973] go: extracting go.opencensus.io v0.21.0
W1026 17:16:22.107] go: extracting google.golang.org/grpc v1.23.0
W1026 17:16:22.293] go: downloading google.golang.org/genproto v0.0.0-20190502173448-54afdca5d873
W1026 17:16:22.871] go: extracting google.golang.org/genproto v0.0.0-20190502173448-54afdca5d873
W1026 17:16:23.701] go: finding github.com/pborman/uuid v1.2.0
W1026 17:16:23.727] go: finding github.com/google/uuid v1.1.1
W1026 17:16:23.763] go: finding golang.org/x/oauth2 v0.0.0-20190604053449-0f29369cfe45
W1026 17:16:23.778] go: finding golang.org/x/net v0.0.0-20191004110552-13f9640d40b9
W1026 17:16:23.800] go: finding cloud.google.com/go v0.38.0
W1026 17:16:23.807] go: finding google.golang.org/api v0.6.1-0.20190607001116-5213b8090861
W1026 17:16:23.818] go: finding google.golang.org/grpc v1.23.0
W1026 17:16:23.832] go: finding github.com/golang/protobuf v1.3.1
W1026 17:16:23.870] go: finding google.golang.org/genproto v0.0.0-20190502173448-54afdca5d873
W1026 17:16:23.881] go: finding golang.org/x/sys v0.0.0-20190813064441-fde4db37ae7a
W1026 17:16:23.891] go: finding golang.org/x/text v0.3.2
W1026 17:16:23.906] go: finding go.opencensus.io v0.21.0
W1026 17:16:23.912] go: finding github.com/hashicorp/golang-lru v0.5.1
W1026 17:16:23.927] go: finding k8s.io/klog v1.0.0
W1026 17:16:23.936] go: finding github.com/davecgh/go-spew v1.1.1
W1026 17:16:23.942] go: finding github.com/pkg/errors v0.8.1
W1026 17:16:23.947] go: finding github.com/stretchr/testify v1.3.0
W1026 17:16:23.951] go: finding github.com/pmezard/go-difflib v1.0.0
W1026 17:16:23.962] go: finding github.com/gogo/protobuf v1.2.2-0.20190723190241-65acae22fc9d
W1026 17:16:23.971] go: finding github.com/google/gofuzz v1.0.0
W1026 17:16:23.977] go: finding gopkg.in/inf.v0 v0.9.1
W1026 17:16:23.999] go: finding sigs.k8s.io/yaml v1.1.0
W1026 17:16:24.005] go: finding gopkg.in/yaml.v2 v2.2.8
W1026 17:16:24.012] go: finding k8s.io/kube-openapi v0.0.0-20200410163147-594e756bea31
W1026 17:16:24.017] go: finding github.com/googleapis/gnostic v0.0.0-20170729233727-0c5108395e2d
W1026 17:16:24.025] go: finding github.com/evanphx/json-patch v4.9.0+incompatible
W1026 17:16:24.033] go: finding github.com/json-iterator/go v1.1.7
W1026 17:16:24.039] go: finding github.com/modern-go/concurrent v0.0.0-20180306012644-bacd9c7ef1dd
W1026 17:16:24.048] go: finding github.com/modern-go/reflect2 v1.0.1
W1026 17:16:24.065] go: finding github.com/blang/semver v3.5.0+incompatible
W1026 17:16:24.073] go: finding github.com/prometheus/client_golang v0.9.2
W1026 17:16:24.080] go: finding github.com/beorn7/perks v0.0.0-20180321164747-3a771d992973
W1026 17:16:24.084] go: finding github.com/prometheus/client_model v0.0.0-20180712105110-5c3871d89910
W1026 17:16:24.096] go: finding github.com/prometheus/common v0.0.0-20181126121408-4724e9255275
W1026 17:16:24.107] go: finding github.com/matttproud/golang_protobuf_extensions v1.0.1
W1026 17:16:24.114] go: finding github.com/prometheus/procfs v0.0.0-20181204211112-1dc9a6cbc91a
W1026 17:16:24.133] go: finding golang.org/x/crypto v0.0.0-20200220183623-bac4c82f6975
W1026 17:16:24.143] go: finding golang.org/x/time v0.0.0-20190308202827-9d24e82272b4
W1026 17:16:24.148] go: finding k8s.io/utils v0.0.0-20190801114015-581e00157fb1
W1026 17:16:24.160] go: finding github.com/imdario/mergo v0.3.5
W1026 17:16:24.166] go: finding github.com/spf13/pflag v1.0.5
W1026 17:16:24.272] go: finding github.com/google/go-cmp v0.3.0
W1026 17:16:24.381] go: finding github.com/golang/groupcache v0.0.0-20160516000752-02826c3e7903
W1026 17:16:24.397] go: finding github.com/docker/distribution v2.7.1+incompatible
W1026 17:16:24.402] go: finding github.com/opencontainers/go-digest v1.0.0-rc1
W1026 17:16:24.417] go: finding gopkg.in/square/go-jose.v2 v2.2.2
I1026 17:19:53.598] Initializing e2e tests using image ubuntu-gke-1804-1-16-v20200824.
I1026 17:19:53.603] make: Entering directory '/go/src/k8s.io/kubernetes'
I1026 17:19:53.607] make[1]: Entering directory '/go/src/k8s.io/kubernetes'
W1026 17:19:53.760] I1026 17:19:53.598519    4210 remote.go:40] Building archive...
W1026 17:19:53.761] I1026 17:19:53.598888    4210 build.go:42] Building k8s binaries...
W1026 17:19:54.001] I1026 17:19:54.001274    4210 run_remote.go:567] Creating instance {image:ubuntu-gke-1804-1-16-v20200824 imageDesc: project:ubuntu-os-gke-cloud-devel resources:{Accelerators:[]} metadata:<nil> machine: tests:[]} with service account "1050223417337-compute@developer.gserviceaccount.com"
I1026 17:20:07.501] +++ [1026 17:20:07] Building go targets for linux/amd64:
I1026 17:20:07.501]     ./vendor/k8s.io/code-generator/cmd/deepcopy-gen
I1026 17:20:26.022] +++ [1026 17:20:26] Building go targets for linux/amd64:
I1026 17:20:26.023]     ./vendor/k8s.io/code-generator/cmd/defaulter-gen
I1026 17:20:37.717] +++ [1026 17:20:37] Building go targets for linux/amd64:
I1026 17:20:37.718]     ./vendor/k8s.io/code-generator/cmd/conversion-gen
I1026 17:20:58.172] +++ [1026 17:20:58] Building go targets for linux/amd64:
I1026 17:20:58.172]     ./vendor/k8s.io/kube-openapi/cmd/openapi-gen
I1026 17:21:23.406] +++ [1026 17:21:23] Building go targets for linux/amd64:
I1026 17:21:23.406]     ./vendor/github.com/go-bindata/go-bindata/go-bindata
I1026 17:21:25.212] make[1]: Leaving directory '/go/src/k8s.io/kubernetes'
I1026 17:21:25.656] +++ [1026 17:21:25] Building go targets for linux/amd64:
I1026 17:21:25.656]     cmd/kubelet
I1026 17:21:25.656]     test/e2e_node/e2e_node.test
I1026 17:21:25.656]     vendor/github.com/onsi/ginkgo/ginkgo
I1026 17:21:25.656]     cluster/gce/gci/mounter
I1026 17:40:13.011] make: Leaving directory '/go/src/k8s.io/kubernetes'
W1026 17:40:27.526] I1026 17:40:27.523985    4210 remote.go:70] Staging test binaries on "tmp-node-e2e-764691f6-ubuntu-gke-1804-1-16-v20200824"
W1026 17:40:30.302] I1026 17:40:30.302115    4210 remote.go:97] Extracting tar on "tmp-node-e2e-764691f6-ubuntu-gke-1804-1-16-v20200824"
W1026 17:40:33.707] I1026 17:40:33.706917    4210 remote.go:112] Running test on "tmp-node-e2e-764691f6-ubuntu-gke-1804-1-16-v20200824"
W1026 17:40:33.707] I1026 17:40:33.706975    4210 utils.go:55] Install CNI on "tmp-node-e2e-764691f6-ubuntu-gke-1804-1-16-v20200824"
W1026 17:40:35.420] I1026 17:40:35.419930    4210 utils.go:68] Adding CNI configuration on "tmp-node-e2e-764691f6-ubuntu-gke-1804-1-16-v20200824"
W1026 17:40:36.033] I1026 17:40:36.032401    4210 utils.go:82] Configure iptables firewall rules on "tmp-node-e2e-764691f6-ubuntu-gke-1804-1-16-v20200824"
W1026 17:40:37.777] I1026 17:40:37.777127    4210 utils.go:117] Killing any existing node processes on "tmp-node-e2e-764691f6-ubuntu-gke-1804-1-16-v20200824"
W1026 17:40:38.999] I1026 17:40:38.999505    4210 node_e2e.go:147] Starting tests on "tmp-node-e2e-764691f6-ubuntu-gke-1804-1-16-v20200824"
W1026 17:40:42.121] I1026 17:40:42.120815    4210 remote.go:197] Test failed unexpectedly. Attempting to retrieving system logs (only works for nodes with journald)
W1026 17:40:42.728] I1026 17:40:42.728738    4210 remote.go:202] Got the system logs from journald; copying it back...
W1026 17:40:43.571] I1026 17:40:43.571175    4210 remote.go:122] Copying test artifacts from "tmp-node-e2e-764691f6-ubuntu-gke-1804-1-16-v20200824"
W1026 17:40:44.830] I1026 17:40:44.830162    4210 run_remote.go:742] Deleting instance "tmp-node-e2e-764691f6-ubuntu-gke-1804-1-16-v20200824"
I1026 17:40:45.337] 
I1026 17:40:45.337] >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
I1026 17:40:45.337] >                              START TEST                                >
I1026 17:40:45.338] >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
I1026 17:40:45.338] Start Test Suite on Host tmp-node-e2e-764691f6-ubuntu-gke-1804-1-16-v20200824
I1026 17:40:45.338] Running Suite: E2eNode Suite
I1026 17:40:45.338] ============================
I1026 17:40:45.338] Random Seed: 1603734039 - Will randomize all specs
I1026 17:40:45.338] Will run 313 specs
I1026 17:40:45.338] 
I1026 17:40:45.339] Running in parallel across 8 nodes
I1026 17:40:45.339] 
I1026 17:40:45.339] Oct 26 17:40:41.526: INFO: Parsing ds from https://raw.githubusercontent.com/kubernetes/kubernetes/master/cluster/addons/device-plugins/nvidia-gpu/daemonset.yaml
I1026 17:40:45.339] STEP: Enabling support for Kubelet Plugins Watcher
I1026 17:40:45.339] W1026 17:40:41.685857    2909 test_context.go:418] Unable to find in-cluster config, using default host : http://127.0.0.1:8080
I1026 17:40:45.340] Oct 26 17:40:41.685: INFO: The --provider flag is not set. Continuing as if --provider=skeleton had been used.
I1026 17:40:45.340] Validating os...
I1026 17:40:45.340] OS: Linux
I1026 17:40:45.340] Validating kernel...
I1026 17:40:45.340] KERNEL_VERSION: 5.3.0-1033-gke
I1026 17:40:45.340] CONFIG_BOOTPARAM_HARDLOCKUP_PANIC: enabled
I1026 17:40:45.340] CONFIG_BOOTPARAM_SOFTLOCKUP_PANIC: enabled
I1026 17:40:45.340] CONFIG_PANIC_ON_OOPS: enabled
I1026 17:40:45.341] CONFIG_PVPANIC: enabled (as module)
I1026 17:40:45.341] CONFIG_DMIID: enabled
I1026 17:40:45.341] CONFIG_ACPI_BUTTON: enabled
I1026 17:40:45.341] CONFIG_INET: enabled
I1026 17:40:45.341] CONFIG_VXLAN: enabled (as module)
I1026 17:40:45.341] CONFIG_IP_SET: enabled (as module)
I1026 17:40:45.341] CONFIG_IP_SET_HASH_IP: enabled (as module)
I1026 17:40:45.342] CONFIG_IPVLAN: enabled (as module)
I1026 17:40:45.342] CONFIG_IPV6: enabled
I1026 17:40:45.342] CONFIG_IP6_NF_IPTABLES: enabled (as module)
I1026 17:40:45.342] CONFIG_IP_NF_TARGET_REDIRECT: enabled (as module)
I1026 17:40:45.342] CONFIG_NETFILTER_XT_MATCH_COMMENT: enabled (as module)
I1026 17:40:45.342] CONFIG_PACKET_DIAG: enabled (as module)
I1026 17:40:45.342] CONFIG_UNIX_DIAG: enabled (as module)
I1026 17:40:45.342] CONFIG_INET_DIAG: enabled (as module)
I1026 17:40:45.343] CONFIG_INET_TCP_DIAG: enabled (as module)
I1026 17:40:45.343] CONFIG_INET_UDP_DIAG: enabled (as module)
I1026 17:40:45.343] CONFIG_NETLINK_DIAG: enabled (as module)
I1026 17:40:45.343] CONFIG_EXT4_FS: enabled
I1026 17:40:45.343] CONFIG_DEBUG_FS: enabled
I1026 17:40:45.343] CONFIG_PROC_FS: enabled
I1026 17:40:45.344] CONFIG_XFS_FS: enabled (as module)
I1026 17:40:45.344] CONFIG_SCSI_PROC_FS: enabled
I1026 17:40:45.344] CONFIG_OVERLAY_FS: enabled (as module)
I1026 17:40:45.344] CONFIG_NFS_FS: enabled (as module)
I1026 17:40:45.345] CONFIG_AUTOFS4_FS: enabled (as module)
I1026 17:40:45.345] CONFIG_NFS_FSCACHE: enabled
I1026 17:40:45.345] CONFIG_FSCACHE: enabled (as module)
I1026 17:40:45.345] CONFIG_CACHEFILES: enabled (as module)
I1026 17:40:45.345] CONFIG_FUSE_FS: enabled
I1026 17:40:45.345] CONFIG_BCACHE: enabled (as module)
I1026 17:40:45.345] CONFIG_NAMESPACES: enabled
I1026 17:40:45.345] CONFIG_IPC_NS: enabled
I1026 17:40:45.346] CONFIG_NET_NS: enabled
I1026 17:40:45.346] CONFIG_PID_NS: enabled
I1026 17:40:45.346] CONFIG_UTS_NS: enabled
I1026 17:40:45.346] CONFIG_CGROUPS: enabled
I1026 17:40:45.346] CONFIG_CGROUP_CPUACCT: enabled
I1026 17:40:45.346] CONFIG_CGROUP_DEVICE: enabled
I1026 17:40:45.346] CONFIG_CGROUP_SCHED: enabled
I1026 17:40:45.347] CONFIG_CPUSETS: enabled
I1026 17:40:45.347] CONFIG_MEMCG: enabled
I1026 17:40:45.347] CONFIG_QUOTA: enabled
I1026 17:40:45.347] CONFIG_SECCOMP: enabled
I1026 17:40:45.347] CONFIG_SECURITY_APPARMOR: enabled
I1026 17:40:45.347] CONFIG_CC_STACKPROTECTOR_STRONG: not set - Add the stack buffer overflow protections.
I1026 17:40:45.348] CONFIG_STRICT_DEVMEM: enabled
I1026 17:40:45.348] CONFIG_IMA: enabled
I1026 17:40:45.348] CONFIG_AUDIT: enabled
I1026 17:40:45.348] CONFIG_AUDITSYSCALL: enabled
I1026 17:40:45.348] CONFIG_MODULES: enabled
I1026 17:40:45.348] CONFIG_PRINTK: enabled
I1026 17:40:45.349] CONFIG_MMU: enabled
I1026 17:40:45.349] Validating cgroups...
I1026 17:40:45.349] Validating package...
I1026 17:40:45.349] apparmor (>=2.10.1): 2.12
I1026 17:40:45.349] autofs (>=5.0.7): 5.1.2
I1026 17:40:45.349] bash (>=4.3): 4.4.18
I1026 17:40:45.349] bridge-utils (>=1.5): 1.5
I1026 17:40:45.349] cloud-init (>=0.7.6): 20.2
I1026 17:40:45.350] coreutils (>=8.24): 8.28
I1026 17:40:45.350] dbus (>=1.6.8): 1.12.2
I1026 17:40:45.350] e2fsprogs (>=1.4.3): 1.44.1
I1026 17:40:45.350] ebtables (>=2.0.10): 2.0.10.4
I1026 17:40:45.350] ethtool (>=3.18): 4.15
I1026 17:40:45.350] iproute2 (>=4.2.0): 4.15.0
I1026 17:40:45.350] less (>=481): 487
I1026 17:40:45.351] netcat-openbsd (>=1.10): 1.187
I1026 17:40:45.351] python (>=2.7.10): 2.7.15~rc1
I1026 17:40:45.351] pv (>=1.3.4): 1.6.6
I1026 17:40:45.351] sudo (>=1.8.12): 1.8.21p2
I1026 17:40:45.351] systemd (>=225): 237
I1026 17:40:45.351] tar (>=1.28): 1.29b
I1026 17:40:45.351] util-linux (>=2.27.1): 2.31.1
I1026 17:40:45.352] gce-compute-image-packages (>=20170227): 20190801
I1026 17:40:45.352] auditd (>=2.4.5): 2.8.2
I1026 17:40:45.352] grub-common (>=2.2): 2.02
I1026 17:40:45.352] wget (>=1.17.1): 1.19.4
I1026 17:40:45.352] Validating docker...
I1026 17:40:45.352] F1026 17:40:41.982385    2909 e2e_node_suite_test.go:130] system validation failed: unexpected kernel config: CONFIG_CC_STACKPROTECTOR_STRONG
I1026 17:40:45.352] 
I1026 17:40:45.353] 
I1026 17:40:45.353] Failure [0.566 seconds]
I1026 17:40:45.353] [BeforeSuite] BeforeSuite 
I1026 17:40:45.353] _output/local/go/src/k8s.io/kubernetes/test/e2e_node/e2e_node_suite_test.go:153
I1026 17:40:45.353] 
I1026 17:40:45.353]   system validation
I1026 17:40:45.353]   Expected success, but got an error:
I1026 17:40:45.353]       <*errors.errorString | 0xc000874320>: {
I1026 17:40:45.354]           s: "system validation failed: exit status 1",
I1026 17:40:45.354]       }
I1026 17:40:45.354]       system validation failed: exit status 1
I1026 17:40:45.354] 
I1026 17:40:45.354]   _output/local/go/src/k8s.io/kubernetes/test/e2e_node/e2e_node_suite_test.go:155
I1026 17:40:45.354] ------------------------------
I1026 17:40:45.354] Failure [0.608 seconds]
I1026 17:40:45.354] [BeforeSuite] BeforeSuite 
I1026 17:40:45.355] _output/local/go/src/k8s.io/kubernetes/test/e2e_node/e2e_node_suite_test.go:153
I1026 17:40:45.355] 
I1026 17:40:45.355]   BeforeSuite on Node 1 failed
I1026 17:40:45.355] 
I1026 17:40:45.355]   _output/local/go/src/k8s.io/kubernetes/test/e2e_node/e2e_node_suite_test.go:153
I1026 17:40:45.355] ------------------------------
I1026 17:40:45.355] Failure [0.606 seconds]
I1026 17:40:45.356] [BeforeSuite] BeforeSuite 
I1026 17:40:45.356] _output/local/go/src/k8s.io/kubernetes/test/e2e_node/e2e_node_suite_test.go:153
I1026 17:40:45.356] 
I1026 17:40:45.356]   BeforeSuite on Node 1 failed
I1026 17:40:45.356] 
I1026 17:40:45.356]   _output/local/go/src/k8s.io/kubernetes/test/e2e_node/e2e_node_suite_test.go:153
I1026 17:40:45.356] ------------------------------
I1026 17:40:45.356] Failure [0.606 seconds]
I1026 17:40:45.357] [BeforeSuite] BeforeSuite 
I1026 17:40:45.357] _output/local/go/src/k8s.io/kubernetes/test/e2e_node/e2e_node_suite_test.go:153
I1026 17:40:45.357] 
I1026 17:40:45.357]   BeforeSuite on Node 1 failed
I1026 17:40:45.357] 
I1026 17:40:45.357]   _output/local/go/src/k8s.io/kubernetes/test/e2e_node/e2e_node_suite_test.go:153
I1026 17:40:45.357] ------------------------------
I1026 17:40:45.357] Failure [0.608 seconds]
I1026 17:40:45.358] [BeforeSuite] BeforeSuite 
I1026 17:40:45.358] _output/local/go/src/k8s.io/kubernetes/test/e2e_node/e2e_node_suite_test.go:153
I1026 17:40:45.358] 
I1026 17:40:45.358]   BeforeSuite on Node 1 failed
I1026 17:40:45.358] 
I1026 17:40:45.358]   _output/local/go/src/k8s.io/kubernetes/test/e2e_node/e2e_node_suite_test.go:153
I1026 17:40:45.358] ------------------------------
I1026 17:40:45.358] Failure [0.610 seconds]
I1026 17:40:45.359] [BeforeSuite] BeforeSuite 
I1026 17:40:45.359] _output/local/go/src/k8s.io/kubernetes/test/e2e_node/e2e_node_suite_test.go:153
I1026 17:40:45.359] 
I1026 17:40:45.359]   BeforeSuite on Node 1 failed
I1026 17:40:45.359] 
I1026 17:40:45.359]   _output/local/go/src/k8s.io/kubernetes/test/e2e_node/e2e_node_suite_test.go:153
I1026 17:40:45.359] ------------------------------
I1026 17:40:45.359] Failure [0.610 seconds]
I1026 17:40:45.360] [BeforeSuite] BeforeSuite 
I1026 17:40:45.360] _output/local/go/src/k8s.io/kubernetes/test/e2e_node/e2e_node_suite_test.go:153
I1026 17:40:45.360] 
I1026 17:40:45.360]   BeforeSuite on Node 1 failed
I1026 17:40:45.360] 
I1026 17:40:45.360]   _output/local/go/src/k8s.io/kubernetes/test/e2e_node/e2e_node_suite_test.go:153
I1026 17:40:45.360] ------------------------------
I1026 17:40:45.361] Failure [0.606 seconds]
I1026 17:40:45.361] [BeforeSuite] BeforeSuite 
I1026 17:40:45.361] _output/local/go/src/k8s.io/kubernetes/test/e2e_node/e2e_node_suite_test.go:153
I1026 17:40:45.361] 
I1026 17:40:45.361]   BeforeSuite on Node 1 failed
I1026 17:40:45.361] 
I1026 17:40:45.361]   _output/local/go/src/k8s.io/kubernetes/test/e2e_node/e2e_node_suite_test.go:153
I1026 17:40:45.361] ------------------------------
I1026 17:40:45.362] I1026 17:40:42.087085    2818 e2e_node_suite_test.go:202] Tests Finished
I1026 17:40:45.362] 
I1026 17:40:45.362] 
I1026 17:40:45.362] Ran 2504 of 0 Specs in 0.685 seconds
I1026 17:40:45.362] FAIL! -- 0 Passed | 2504 Failed | 0 Pending | 0 Skipped
I1026 17:40:45.362] 
I1026 17:40:45.362] 
I1026 17:40:45.362] Ginkgo ran 1 suite in 2.536437342s
I1026 17:40:45.362] Test Suite Failed
I1026 17:40:45.363] 
I1026 17:40:45.363] Failure Finished Test Suite on Host tmp-node-e2e-764691f6-ubuntu-gke-1804-1-16-v20200824
I1026 17:40:45.364] [command [ssh -o UserKnownHostsFile=/dev/null -o IdentitiesOnly=yes -o CheckHostIP=no -o StrictHostKeyChecking=no -o ServerAliveInterval=30 -o LogLevel=ERROR -i /workspace/.ssh/google_compute_engine prow@35.227.149.12 -- sudo sh -c 'cd /tmp/node-e2e-20201026T174027 && timeout -k 30s 7200.000000s ./ginkgo --nodes=8 --skip="\[Flaky\]|\[Serial\]|\[NodeAlphaFeature:.+\]" ./e2e_node.test -- --system-spec-name=gke --system-spec-file=gke.yaml --extra-envs= --logtostderr --v 4 --node-name=tmp-node-e2e-764691f6-ubuntu-gke-1804-1-16-v20200824 --report-dir=/tmp/node-e2e-20201026T174027/results --report-prefix=ubuntu-gke-1804-1-16-v20200824 --image-description="" --kubelet-flags=--experimental-kernel-memcg-notification=true '] failed with error: exit status 1, command [scp -o UserKnownHostsFile=/dev/null -o IdentitiesOnly=yes -o CheckHostIP=no -o StrictHostKeyChecking=no -o ServerAliveInterval=30 -o LogLevel=ERROR -i /workspace/.ssh/google_compute_engine -r prow@35.227.149.12:/tmp/node-e2e-20201026T174027/results/*.log /workspace/_artifacts/tmp-node-e2e-764691f6-ubuntu-gke-1804-1-16-v20200824] failed with error: exit status 1]
I1026 17:40:45.364] <<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<
I1026 17:40:45.364] <                              FINISH TEST                               <
I1026 17:40:45.364] <<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<
I1026 17:40:45.364] 
I1026 17:40:45.364] Failure: 1 errors encountered.
W1026 17:40:45.465] exit status 1
W1026 17:40:45.514] 2020/10/26 17:40:45 process.go:155: Step 'go run /go/src/k8s.io/kubernetes/test/e2e_node/runner/remote/run_remote.go --cleanup --logtostderr --vmodule=*=4 --ssh-env=gce --results-dir=/workspace/_artifacts --project=ubuntu-image-validation --zone=us-west1-b --ssh-user=prow --ssh-key=/workspace/.ssh/google_compute_engine --ginkgo-flags=--nodes=8 --skip="\[Flaky\]|\[Serial\]|\[NodeAlphaFeature:.+\]" --test_args= --test-timeout=2h0m0s --system-spec-name=gke --images=ubuntu-gke-1804-1-16-v20200824 --image-project=ubuntu-os-gke-cloud-devel' finished in 24m31.771457868s
W1026 17:40:45.514] 2020/10/26 17:40:45 e2e.go:544: Dumping logs locally to: /workspace/_artifacts
W1026 17:40:45.515] 2020/10/26 17:40:45 process.go:153: Running: ./cluster/log-dump/log-dump.sh /workspace/_artifacts
I1026 17:40:45.615] Checking for custom logdump instances, if any
I1026 17:40:45.615] Sourcing kube-util.sh
I1026 17:40:45.641] Detecting project
I1026 17:40:45.641] Project: ubuntu-image-validation
I1026 17:40:45.641] Network Project: ubuntu-image-validation
I1026 17:40:45.641] Zone: us-west1-b
I1026 17:40:45.642] Dumping logs from master locally to '/workspace/_artifacts'
W1026 17:40:45.742] Trying to find master named 'bootstrap-e2e-master'
W1026 17:40:45.742] Looking for address 'bootstrap-e2e-master-ip'
W1026 17:40:46.587] ERROR: (gcloud.compute.addresses.describe) Could not fetch resource:
W1026 17:40:46.587]  - The resource 'projects/ubuntu-image-validation/regions/us-west1/addresses/bootstrap-e2e-master-ip' was not found
W1026 17:40:46.588] 
W1026 17:40:46.774] Could not detect Kubernetes master node.  Make sure you've launched a cluster with 'kube-up.sh'
I1026 17:40:46.874] Master not detected. Is the cluster up?
I1026 17:40:46.875] Dumping logs from nodes locally to '/workspace/_artifacts'
I1026 17:40:46.875] Detecting nodes in the cluster
I1026 17:40:49.528] No nodes found!
W1026 17:40:51.838] INSTANCE_GROUPS=
W1026 17:40:51.838] NODE_NAMES=
W1026 17:40:51.839] 2020/10/26 17:40:51 process.go:155: Step './cluster/log-dump/log-dump.sh /workspace/_artifacts' finished in 6.325140362s
W1026 17:40:51.839] 2020/10/26 17:40:51 node.go:53: Noop - Node Down()
W1026 17:40:51.840] 2020/10/26 17:40:51 process.go:96: Saved XML output to /workspace/_artifacts/junit_runner.xml.
W1026 17:40:51.840] 2020/10/26 17:40:51 process.go:153: Running: bash -c . hack/lib/version.sh && KUBE_ROOT=. kube::version::get_version_vars && echo "${KUBE_GIT_VERSION-}"
W1026 17:40:53.557] 2020/10/26 17:40:53 process.go:155: Step 'bash -c . hack/lib/version.sh && KUBE_ROOT=. kube::version::get_version_vars && echo "${KUBE_GIT_VERSION-}"' finished in 1.71666266s
W1026 17:40:53.558] 2020/10/26 17:40:53 main.go:316: Something went wrong: encountered 1 errors: [error during go run /go/src/k8s.io/kubernetes/test/e2e_node/runner/remote/run_remote.go --cleanup --logtostderr --vmodule=*=4 --ssh-env=gce --results-dir=/workspace/_artifacts --project=ubuntu-image-validation --zone=us-west1-b --ssh-user=prow --ssh-key=/workspace/.ssh/google_compute_engine --ginkgo-flags=--nodes=8 --skip="\[Flaky\]|\[Serial\]|\[NodeAlphaFeature:.+\]" --test_args= --test-timeout=2h0m0s --system-spec-name=gke --images=ubuntu-gke-1804-1-16-v20200824 --image-project=ubuntu-os-gke-cloud-devel: exit status 1]
W1026 17:40:53.561] Traceback (most recent call last):
W1026 17:40:53.562]   File "/workspace/./test-infra/jenkins/../scenarios/kubernetes_e2e.py", line 720, in <module>
W1026 17:40:53.563]     main(parse_args())
W1026 17:40:53.564]   File "/workspace/./test-infra/jenkins/../scenarios/kubernetes_e2e.py", line 570, in main
W1026 17:40:53.564]     mode.start(runner_args)
W1026 17:40:53.564]   File "/workspace/./test-infra/jenkins/../scenarios/kubernetes_e2e.py", line 228, in start
W1026 17:40:53.564]     check_env(env, self.command, *args)
W1026 17:40:53.564]   File "/workspace/./test-infra/jenkins/../scenarios/kubernetes_e2e.py", line 111, in check_env
W1026 17:40:53.565]     subprocess.check_call(cmd, env=env)
W1026 17:40:53.565]   File "/usr/lib/python2.7/subprocess.py", line 190, in check_call
W1026 17:40:53.565]     raise CalledProcessError(retcode, cmd)
W1026 17:40:53.565] subprocess.CalledProcessError: Command '('kubetest', '--dump=/workspace/_artifacts', '--gcp-service-account=/etc/service-account/service-account.json', '--up', '--down', '--test', '--deployment=node', '--provider=gce', '--cluster=bootstrap-e2e', '--gcp-network=bootstrap-e2e', '--node-tests=true', '--gcp-zone=us-west1-b', '--image-family=pipeline-2', '--image-project=ubuntu-os-gke-cloud-devel', '--timeout=120m', '--test_args=--nodes=8 --skip="\\[Flaky\\]|\\[Serial\\]|\\[NodeAlphaFeature:.+\\]"', '--node-args=--system-spec-name=gke', '--gcp-project=ubuntu-image-validation')' returned non-zero exit status 1
E1026 17:40:53.580] Command failed
I1026 17:40:53.580] process 316 exited with code 1 after 24.7m
E1026 17:40:53.581] FAIL: ci-kubernetes-e2enode-ubuntu2-k8sstable3-gkespec
I1026 17:40:53.581] Call:  gcloud auth activate-service-account --key-file=/etc/service-account/service-account.json
W1026 17:40:54.292] Activated service account credentials for: [pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com]
I1026 17:40:54.417] process 38164 exited with code 0 after 0.0m
I1026 17:40:54.417] Call:  gcloud config get-value account
I1026 17:40:55.071] process 38177 exited with code 0 after 0.0m
I1026 17:40:55.071] Will upload results to gs://kubernetes-jenkins/logs using pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com
I1026 17:40:55.072] Upload result and artifacts...
I1026 17:40:55.072] Gubernator results at https://gubernator.k8s.io/build/kubernetes-jenkins/logs/ci-kubernetes-e2enode-ubuntu2-k8sstable3-gkespec/1320775543683026944
I1026 17:40:55.072] Call:  gsutil ls gs://kubernetes-jenkins/logs/ci-kubernetes-e2enode-ubuntu2-k8sstable3-gkespec/1320775543683026944/artifacts
W1026 17:40:56.127] CommandException: One or more URLs matched no objects.
E1026 17:40:56.328] Command failed
I1026 17:40:56.328] process 38190 exited with code 1 after 0.0m
W1026 17:40:56.329] Remote dir gs://kubernetes-jenkins/logs/ci-kubernetes-e2enode-ubuntu2-k8sstable3-gkespec/1320775543683026944/artifacts not exist yet
I1026 17:40:56.329] Call:  gsutil -m -q -o GSUtil:use_magicfile=True cp -r -c -z log,txt,xml /workspace/_artifacts gs://kubernetes-jenkins/logs/ci-kubernetes-e2enode-ubuntu2-k8sstable3-gkespec/1320775543683026944/artifacts
I1026 17:40:58.867] process 38333 exited with code 0 after 0.0m
I1026 17:40:58.868] Call:  git rev-parse HEAD
I1026 17:40:58.873] process 38864 exited with code 0 after 0.0m
I1026 17:40:58.873] Call:  git rev-parse HEAD
I1026 17:40:58.880] process 38865 exited with code 0 after 0.0m
I1026 17:40:58.881] Call:  gsutil stat gs://kubernetes-jenkins/logs/ci-kubernetes-e2enode-ubuntu2-k8sstable3-gkespec/jobResultsCache.json
I1026 17:41:00.122] process 38866 exited with code 0 after 0.0m
I1026 17:41:00.123] Call:  gsutil -q cat 'gs://kubernetes-jenkins/logs/ci-kubernetes-e2enode-ubuntu2-k8sstable3-gkespec/jobResultsCache.json#1603726729619457'
I1026 17:41:01.525] process 39009 exited with code 0 after 0.0m
I1026 17:41:01.531] Call:  gsutil -q -h Content-Type:application/json -h x-goog-if-generation-match:1603726729619457 cp /tmp/gsutil_2fisBU gs://kubernetes-jenkins/logs/ci-kubernetes-e2enode-ubuntu2-k8sstable3-gkespec/jobResultsCache.json
I1026 17:41:03.025] process 39154 exited with code 0 after 0.0m
I1026 17:41:03.026] Call:  gsutil -q -h Content-Type:application/json cp /tmp/gsutil_hw4bao gs://kubernetes-jenkins/logs/ci-kubernetes-e2enode-ubuntu2-k8sstable3-gkespec/1320775543683026944/finished.json
I1026 17:41:04.533] process 39333 exited with code 0 after 0.0m
I1026 17:41:04.534] Call:  gsutil -q -h Content-Type:text/plain -h 'Cache-Control:private, max-age=0, no-transform' cp /tmp/gsutil_V8GhGP gs://kubernetes-jenkins/logs/ci-kubernetes-e2enode-ubuntu2-k8sstable3-gkespec/latest-build.txt
I1026 17:41:06.043] process 39512 exited with code 0 after 0.0m