W1025 18:20:52.404] **************************************************************************
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
**************************************************************************
I1025 18:20:52.404] Args: --job=ci-kubernetes-e2enode-ubuntu1-k8sstable2-gkespec --service-account=/etc/service-account/service-account.json --upload=gs://kubernetes-jenkins/logs --timeout=140 --repo=k8s.io/kubernetes=release-1.17 --root=/go/src --scenario=kubernetes_e2e -- --deployment=node --node-tests=true --provider=gce --gcp-zone=us-west1-b --image-family=pipeline-1 --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
I1025 18:20:52.405] Bootstrap ci-kubernetes-e2enode-ubuntu1-k8sstable2-gkespec...
I1025 18:20:52.407] Builder: beeff019-16ee-11eb-b256-6ee25ea2e440
I1025 18:20:52.407] Image: gcr.io/k8s-testimages/kubekins-e2e:v20201021-a62ce8a-1.17
I1025 18:20:52.407] Gubernator results at https://gubernator.k8s.io/build/kubernetes-jenkins/logs/ci-kubernetes-e2enode-ubuntu1-k8sstable2-gkespec/1320430015019487232
I1025 18:20:52.408] Call:  gcloud auth activate-service-account --key-file=/etc/service-account/service-account.json
W1025 18:20:53.086] Activated service account credentials for: [pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com]
I1025 18:20:53.216] process 34 exited with code 0 after 0.0m
I1025 18:20:53.216] Call:  gcloud config get-value account
I1025 18:20:53.891] process 47 exited with code 0 after 0.0m
I1025 18:20:53.891] Will upload results to gs://kubernetes-jenkins/logs using pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com
I1025 18:20:53.891] Root: /go/src
I1025 18:20:53.892] cd to /go/src
I1025 18:20:53.892] Checkout: /go/src/k8s.io/kubernetes release-1.17 to /go/src/k8s.io/kubernetes
I1025 18:20:53.892] Call:  git init k8s.io/kubernetes
I1025 18:20:53.900] Initialized empty Git repository in /go/src/k8s.io/kubernetes/.git/
I1025 18:20:53.900] process 60 exited with code 0 after 0.0m
I1025 18:20:53.900] Call:  git config --local user.name 'K8S Bootstrap'
I1025 18:20:53.905] process 61 exited with code 0 after 0.0m
I1025 18:20:53.905] Call:  git config --local user.email k8s_bootstrap@localhost
I1025 18:20:53.909] process 62 exited with code 0 after 0.0m
I1025 18:20:53.909] Call:  git fetch --quiet --tags https://github.com/kubernetes/kubernetes release-1.17
I1025 18:23:05.992] process 63 exited with code 0 after 2.2m
I1025 18:23:05.992] Call:  git checkout -B test FETCH_HEAD
W1025 18:23:09.185] Switched to a new branch 'test'
I1025 18:23:09.210] process 74 exited with code 0 after 0.1m
I1025 18:23:09.210] Call:  git show -s --format=format:%ct HEAD
I1025 18:23:09.217] process 75 exited with code 0 after 0.0m
I1025 18:23:09.218] Configure environment...
I1025 18:23:09.219] Call:  git show -s --format=format:%ct HEAD
I1025 18:23:09.225] process 76 exited with code 0 after 0.0m
I1025 18:23:09.226] Call:  gcloud auth activate-service-account --key-file=/etc/service-account/service-account.json
W1025 18:23:09.990] Activated service account credentials for: [pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com]
I1025 18:23:11.063] process 77 exited with code 0 after 0.0m
I1025 18:23:11.063] Call:  gcloud config get-value account
I1025 18:23:11.758] process 90 exited with code 0 after 0.0m
I1025 18:23:11.758] Will upload results to gs://kubernetes-jenkins/logs using pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com
I1025 18:23:11.758] 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
'
I1025 18:23:12.135] process 103 exited with code 0 after 0.0m
I1025 18:23:12.136] Start 1320430015019487232 at v1.17.14-rc.0.15+54f3c097502f5b...
I1025 18:23:12.138] Call:  gsutil -q -h Content-Type:application/json cp /tmp/gsutil_1AVQEY gs://kubernetes-jenkins/logs/ci-kubernetes-e2enode-ubuntu1-k8sstable2-gkespec/1320430015019487232/started.json
I1025 18:23:14.239] process 136 exited with code 0 after 0.0m
I1025 18:23:14.239] Call:  /workspace/./test-infra/jenkins/../scenarios/kubernetes_e2e.py --deployment=node --node-tests=true --provider=gce --gcp-zone=us-west1-b --image-family=pipeline-1 --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
W1025 18:23:14.289] starts with local mode
W1025 18:23:14.289] Environment:
W1025 18:23:14.290] ARTIFACTS=/workspace/_artifacts
W1025 18:23:14.290] AWS_SSH_PRIVATE_KEY_FILE=/root/.ssh/kube_aws_rsa
W1025 18:23:14.290] AWS_SSH_PUBLIC_KEY_FILE=/root/.ssh/kube_aws_rsa.pub
W1025 18:23:14.290] BAZEL_REMOTE_CACHE_ENABLED=false
W1025 18:23:14.290] BAZEL_VERSION=2.2.0
W1025 18:23:14.290] BOOTSTRAP_MIGRATION=yes
W1025 18:23:14.290] BOSKOS_METRICS_PORT=tcp://10.63.252.110:9090
W1025 18:23:14.291] BOSKOS_METRICS_PORT_9090_TCP=tcp://10.63.252.110:9090
W1025 18:23:14.291] BOSKOS_METRICS_PORT_9090_TCP_ADDR=10.63.252.110
W1025 18:23:14.291] BOSKOS_METRICS_PORT_9090_TCP_PORT=9090
W1025 18:23:14.291] BOSKOS_METRICS_PORT_9090_TCP_PROTO=tcp
W1025 18:23:14.291] BOSKOS_METRICS_SERVICE_HOST=10.63.252.110
W1025 18:23:14.291] BOSKOS_METRICS_SERVICE_PORT=9090
W1025 18:23:14.291] BOSKOS_METRICS_SERVICE_PORT_METRICS=9090
W1025 18:23:14.292] BOSKOS_PORT=tcp://10.63.250.132:80
W1025 18:23:14.292] BOSKOS_PORT_80_TCP=tcp://10.63.250.132:80
W1025 18:23:14.292] BOSKOS_PORT_80_TCP_ADDR=10.63.250.132
W1025 18:23:14.292] BOSKOS_PORT_80_TCP_PORT=80
W1025 18:23:14.292] BOSKOS_PORT_80_TCP_PROTO=tcp
W1025 18:23:14.292] BOSKOS_SERVICE_HOST=10.63.250.132
W1025 18:23:14.292] BOSKOS_SERVICE_PORT=80
W1025 18:23:14.292] BOSKOS_SERVICE_PORT_DEFAULT=80
W1025 18:23:14.293] BUILD_ID=1320430015019487232
W1025 18:23:14.293] BUILD_NUMBER=1320430015019487232
W1025 18:23:14.293] CI=true
W1025 18:23:14.293] CLOUDSDK_COMPONENT_MANAGER_DISABLE_UPDATE_CHECK=true
W1025 18:23:14.293] CLOUDSDK_CONFIG=/go/src/k8s.io/kubernetes/.config/gcloud
W1025 18:23:14.293] CLOUDSDK_CORE_DISABLE_PROMPTS=1
W1025 18:23:14.293] CLOUDSDK_EXPERIMENTAL_FAST_COMPONENT_UPDATE=false
W1025 18:23:14.293] DOCKER_IN_DOCKER_ENABLED=false
W1025 18:23:14.294] DOCKER_IN_DOCKER_IPV6_ENABLED=false
W1025 18:23:14.294] E2E_GOOGLE_APPLICATION_CREDENTIALS=/etc/service-account/service-account.json
W1025 18:23:14.294] GCS_ARTIFACTS_DIR=gs://kubernetes-jenkins/logs/ci-kubernetes-e2enode-ubuntu1-k8sstable2-gkespec/1320430015019487232/artifacts
W1025 18:23:14.294] GOOGLE_APPLICATION_CREDENTIALS=/etc/service-account/service-account.json
W1025 18:23:14.294] GOOGLE_APPLICATION_CREDENTIALS_DEPRECATED=Migrate to workload identity, contact sig-testing
W1025 18:23:14.295] GOPATH=/go
W1025 18:23:14.295] GOPROXY=https://proxy.golang.org
W1025 18:23:14.295] GO_TARBALL=go1.13.15.linux-amd64.tar.gz
W1025 18:23:14.295] HOME=/workspace
W1025 18:23:14.295] HOSTNAME=beeff019-16ee-11eb-b256-6ee25ea2e440
W1025 18:23:14.295] IMAGE=gcr.io/k8s-testimages/kubekins-e2e:v20201021-a62ce8a-1.17
W1025 18:23:14.296] INSTANCE_PREFIX=bootstrap-e2e
W1025 18:23:14.296] JENKINS_GCE_SSH_PRIVATE_KEY_FILE=/workspace/.ssh/google_compute_engine
W1025 18:23:14.296] JENKINS_GCE_SSH_PUBLIC_KEY_FILE=/workspace/.ssh/google_compute_engine.pub
W1025 18:23:14.296] JOB_NAME=ci-kubernetes-e2enode-ubuntu1-k8sstable2-gkespec
W1025 18:23:14.296] JOB_SPEC={"type":"periodic","job":"ci-kubernetes-e2enode-ubuntu1-k8sstable2-gkespec","buildid":"1320430015019487232","prowjobid":"beeff019-16ee-11eb-b256-6ee25ea2e440"}
W1025 18:23:14.297] JOB_TYPE=periodic
W1025 18:23:14.297] KUBERNETES_PORT=tcp://10.63.240.1:443
W1025 18:23:14.297] KUBERNETES_PORT_443_TCP=tcp://10.63.240.1:443
W1025 18:23:14.297] KUBERNETES_PORT_443_TCP_ADDR=10.63.240.1
W1025 18:23:14.297] KUBERNETES_PORT_443_TCP_PORT=443
W1025 18:23:14.297] KUBERNETES_PORT_443_TCP_PROTO=tcp
W1025 18:23:14.297] KUBERNETES_SERVICE_HOST=10.63.240.1
W1025 18:23:14.297] KUBERNETES_SERVICE_PORT=443
W1025 18:23:14.298] KUBERNETES_SERVICE_PORT_HTTPS=443
W1025 18:23:14.298] KUBETEST_IN_DOCKER=true
W1025 18:23:14.298] KUBETEST_MANUAL_DUMP=y
W1025 18:23:14.298] KUBE_AWS_INSTANCE_PREFIX=bootstrap-e2e
W1025 18:23:14.298] KUBE_GCE_INSTANCE_PREFIX=bootstrap-e2e
W1025 18:23:14.298] LOG_DUMP_SCRIPT_PATH=/workspace/log-dump.sh
W1025 18:23:14.298] NODE_NAME=beeff019-16ee-11eb-b256-6ee25ea2e440
W1025 18:23:14.299] 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
W1025 18:23:14.299] PROW_JOB_ID=beeff019-16ee-11eb-b256-6ee25ea2e440
W1025 18:23:14.299] PWD=/workspace
W1025 18:23:14.299] SHLVL=2
W1025 18:23:14.299] SOURCE_DATE_EPOCH=1603464596
W1025 18:23:14.299] TERM=xterm
W1025 18:23:14.299] USER=prow
W1025 18:23:14.299] WORKSPACE=/workspace
W1025 18:23:14.300] _=./test-infra/jenkins/bootstrap.py
W1025 18:23:14.300] 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-1', '--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')
W1025 18:23:14.596] 2020/10/25 18:23:14 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
W1025 18:23:14.598] 2020/10/25 18:23:14 main.go:329: Limiting testing to 2h0m0s
W1025 18:23:14.598] 2020/10/25 18:23:14 process.go:153: Running: gcloud auth activate-service-account --key-file=/etc/service-account/service-account.json
W1025 18:23:15.291] Activated service account credentials for: [pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com]
W1025 18:23:15.411] 2020/10/25 18:23:15 process.go:155: Step 'gcloud auth activate-service-account --key-file=/etc/service-account/service-account.json' finished in 813.170078ms
W1025 18:23:15.412] 2020/10/25 18:23:15 process.go:153: Running: gcloud compute images describe-from-family pipeline-1 --project ubuntu-os-gke-cloud-devel
W1025 18:23:16.558] 2020/10/25 18:23:16 process.go:155: Step 'gcloud compute images describe-from-family pipeline-1 --project ubuntu-os-gke-cloud-devel' finished in 1.146275923s
W1025 18:23:16.558] 2020/10/25 18:23:16 process.go:153: Running: gcloud config set project ubuntu-image-validation
W1025 18:23:17.068] Updated property [core/project].
W1025 18:23:17.341] 2020/10/25 18:23:17 process.go:155: Step 'gcloud config set project ubuntu-image-validation' finished in 782.959533ms
W1025 18:23:17.342] 2020/10/25 18:23:17 main.go:779: Checking existing of GCP ssh keys...
W1025 18:23:17.342] 2020/10/25 18:23:17 main.go:789: Checking presence of public key in ubuntu-image-validation
W1025 18:23:17.342] 2020/10/25 18:23:17 process.go:153: Running: gcloud compute --project=ubuntu-image-validation project-info describe
W1025 18:23:18.513] 2020/10/25 18:23:18 process.go:155: Step 'gcloud compute --project=ubuntu-image-validation project-info describe' finished in 1.171887797s
W1025 18:23:18.515] 2020/10/25 18:23:18 node.go:62: Noop - Node KubectlCommand()
W1025 18:23:18.515] 2020/10/25 18:23:18 node.go:53: Noop - Node Down()
W1025 18:23:18.515] 2020/10/25 18:23:18 node.go:34: Noop - Node Up()
W1025 18:23:18.516] 2020/10/25 18:23:18 node.go:48: Noop - Node TestSetup()
W1025 18:23:18.516] 2020/10/25 18:23:18 e2e.go:560: cwd : /go/src/k8s.io/kubernetes
W1025 18:23:18.516] 2020/10/25 18:23:18 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-15-v20200824 --image-project=ubuntu-os-gke-cloud-devel
W1025 18:23:19.521] go: downloading google.golang.org/api v0.6.1-0.20190607001116-5213b8090861
W1025 18:23:19.522] go: downloading k8s.io/klog v1.0.0
W1025 18:23:19.571] go: downloading sigs.k8s.io/yaml v1.1.0
W1025 18:23:19.573] go: downloading github.com/google/uuid v1.1.1
W1025 18:23:19.577] go: downloading github.com/davecgh/go-spew v1.1.1
W1025 18:23:19.578] go: downloading github.com/gogo/protobuf v1.2.2-0.20190723190241-65acae22fc9d
W1025 18:23:19.668] go: extracting k8s.io/klog v1.0.0
W1025 18:23:19.678] go: extracting github.com/google/uuid v1.1.1
W1025 18:23:19.683] go: extracting github.com/davecgh/go-spew v1.1.1
W1025 18:23:19.684] go: downloading golang.org/x/net v0.0.0-20191004110552-13f9640d40b9
W1025 18:23:19.768] go: extracting sigs.k8s.io/yaml v1.1.0
W1025 18:23:19.772] go: downloading k8s.io/utils v0.0.0-20191114184206-e782cd3c129f
W1025 18:23:19.773] go: downloading github.com/golang/protobuf v1.3.2
W1025 18:23:19.774] go: downloading gopkg.in/inf.v0 v0.9.1
W1025 18:23:19.777] go: downloading golang.org/x/oauth2 v0.0.0-20190604053449-0f29369cfe45
W1025 18:23:19.782] go: downloading github.com/prometheus/client_golang v1.0.0
W1025 18:23:19.874] go: extracting gopkg.in/inf.v0 v0.9.1
W1025 18:23:19.891] go: extracting golang.org/x/oauth2 v0.0.0-20190604053449-0f29369cfe45
W1025 18:23:19.980] go: extracting k8s.io/utils v0.0.0-20191114184206-e782cd3c129f
W1025 18:23:20.079] go: downloading github.com/stretchr/testify v1.4.0
W1025 18:23:20.168] go: downloading github.com/hashicorp/golang-lru v0.5.1
W1025 18:23:20.172] go: extracting github.com/prometheus/client_golang v1.0.0
W1025 18:23:20.268] go: extracting github.com/hashicorp/golang-lru v0.5.1
W1025 18:23:20.269] go: downloading github.com/modern-go/reflect2 v1.0.1
W1025 18:23:20.269] go: extracting github.com/stretchr/testify v1.4.0
W1025 18:23:20.269] go: extracting github.com/golang/protobuf v1.3.2
W1025 18:23:20.368] go: downloading github.com/google/gofuzz v1.0.0
W1025 18:23:20.369] go: downloading github.com/spf13/pflag v1.0.5
W1025 18:23:20.369] go: extracting github.com/modern-go/reflect2 v1.0.1
W1025 18:23:20.379] go: extracting github.com/google/gofuzz v1.0.0
W1025 18:23:20.381] go: downloading github.com/evanphx/json-patch v4.9.0+incompatible
W1025 18:23:20.569] go: extracting github.com/spf13/pflag v1.0.5
W1025 18:23:20.570] go: downloading gopkg.in/yaml.v2 v2.2.8
W1025 18:23:20.575] go: extracting github.com/evanphx/json-patch v4.9.0+incompatible
W1025 18:23:20.579] go: downloading github.com/golang/groupcache v0.0.0-20160516000752-02826c3e7903
W1025 18:23:20.673] go: extracting gopkg.in/yaml.v2 v2.2.8
W1025 18:23:20.676] go: downloading github.com/prometheus/procfs v0.0.2
W1025 18:23:20.679] go: extracting github.com/golang/groupcache v0.0.0-20160516000752-02826c3e7903
W1025 18:23:20.775] go: downloading github.com/prometheus/common v0.4.1
W1025 18:23:20.776] go: downloading cloud.google.com/go v0.38.0
W1025 18:23:20.779] go: extracting golang.org/x/net v0.0.0-20191004110552-13f9640d40b9
W1025 18:23:20.870] go: extracting github.com/prometheus/procfs v0.0.2
W1025 18:23:20.871] go: downloading github.com/google/go-cmp v0.3.0
W1025 18:23:20.977] go: extracting github.com/google/go-cmp v0.3.0
W1025 18:23:21.068] go: extracting github.com/prometheus/common v0.4.1
W1025 18:23:21.069] go: downloading golang.org/x/time v0.0.0-20190308202827-9d24e82272b4
W1025 18:23:21.079] go: extracting golang.org/x/time v0.0.0-20190308202827-9d24e82272b4
W1025 18:23:21.080] go: downloading github.com/modern-go/concurrent v0.0.0-20180306012644-bacd9c7ef1dd
W1025 18:23:21.175] go: downloading github.com/blang/semver v3.5.0+incompatible
W1025 18:23:21.179] go: extracting github.com/modern-go/concurrent v0.0.0-20180306012644-bacd9c7ef1dd
W1025 18:23:21.268] go: downloading github.com/beorn7/perks v1.0.0
W1025 18:23:21.269] go: downloading gopkg.in/square/go-jose.v2 v2.2.2
W1025 18:23:21.271] go: downloading github.com/matttproud/golang_protobuf_extensions v1.0.1
W1025 18:23:21.278] go: extracting github.com/blang/semver v3.5.0+incompatible
W1025 18:23:21.369] go: downloading github.com/googleapis/gnostic v0.0.0-20170729233727-0c5108395e2d
W1025 18:23:21.370] go: extracting github.com/beorn7/perks v1.0.0
W1025 18:23:21.376] go: extracting github.com/matttproud/golang_protobuf_extensions v1.0.1
W1025 18:23:21.471] go: downloading github.com/pkg/errors v0.8.1
W1025 18:23:21.479] go: extracting gopkg.in/square/go-jose.v2 v2.2.2
W1025 18:23:21.483] go: extracting github.com/pkg/errors v0.8.1
W1025 18:23:21.573] go: downloading github.com/pmezard/go-difflib v1.0.0
W1025 18:23:21.583] go: extracting github.com/gogo/protobuf v1.2.2-0.20190723190241-65acae22fc9d
W1025 18:23:21.584] go: extracting github.com/pmezard/go-difflib v1.0.0
W1025 18:23:21.675] go: downloading k8s.io/kube-openapi v0.0.0-20200410145947-bcb3869e6f29
W1025 18:23:21.682] go: downloading golang.org/x/crypto v0.0.0-20200220183623-bac4c82f6975
W1025 18:23:21.774] go: extracting github.com/googleapis/gnostic v0.0.0-20170729233727-0c5108395e2d
W1025 18:23:21.969] go: downloading github.com/imdario/mergo v0.3.5
W1025 18:23:22.074] go: extracting github.com/imdario/mergo v0.3.5
W1025 18:23:22.079] go: downloading github.com/prometheus/client_model v0.0.0-20190129233127-fd36f4220a90
W1025 18:23:22.269] go: extracting github.com/prometheus/client_model v0.0.0-20190129233127-fd36f4220a90
W1025 18:23:22.277] go: downloading golang.org/x/text v0.3.2
W1025 18:23:22.568] go: extracting golang.org/x/crypto v0.0.0-20200220183623-bac4c82f6975
W1025 18:23:22.575] go: extracting k8s.io/kube-openapi v0.0.0-20200410145947-bcb3869e6f29
W1025 18:23:22.586] go: extracting cloud.google.com/go v0.38.0
W1025 18:23:23.178] go: downloading github.com/json-iterator/go v1.1.8
W1025 18:23:23.274] go: downloading golang.org/x/sys v0.0.0-20190813064441-fde4db37ae7a
W1025 18:23:23.368] go: extracting github.com/json-iterator/go v1.1.8
W1025 18:23:23.569] go: downloading github.com/docker/distribution v2.7.1+incompatible
W1025 18:23:23.968] go: extracting github.com/docker/distribution v2.7.1+incompatible
W1025 18:23:24.279] go: extracting golang.org/x/sys v0.0.0-20190813064441-fde4db37ae7a
W1025 18:23:24.373] go: downloading github.com/opencontainers/go-digest v1.0.0-rc1
W1025 18:23:24.387] go: extracting github.com/opencontainers/go-digest v1.0.0-rc1
W1025 18:23:24.885] go: extracting golang.org/x/text v0.3.2
W1025 18:23:25.591] go: extracting google.golang.org/api v0.6.1-0.20190607001116-5213b8090861
W1025 18:23:26.891] go: downloading google.golang.org/grpc v1.23.1
W1025 18:23:26.891] go: downloading go.opencensus.io v0.21.0
W1025 18:23:26.999] go: extracting go.opencensus.io v0.21.0
W1025 18:23:27.081] go: extracting google.golang.org/grpc v1.23.1
W1025 18:23:27.268] go: downloading google.golang.org/genproto v0.0.0-20190502173448-54afdca5d873
W1025 18:23:27.831] go: extracting google.golang.org/genproto v0.0.0-20190502173448-54afdca5d873
W1025 18:23:28.595] go: finding github.com/google/uuid v1.1.1
W1025 18:23:28.625] go: finding golang.org/x/oauth2 v0.0.0-20190604053449-0f29369cfe45
W1025 18:23:28.630] go: finding cloud.google.com/go v0.38.0
W1025 18:23:28.685] go: finding golang.org/x/net v0.0.0-20191004110552-13f9640d40b9
W1025 18:23:28.693] go: finding google.golang.org/api v0.6.1-0.20190607001116-5213b8090861
W1025 18:23:28.709] go: finding google.golang.org/grpc v1.23.1
W1025 18:23:28.729] go: finding github.com/golang/protobuf v1.3.2
W1025 18:23:28.743] go: finding google.golang.org/genproto v0.0.0-20190502173448-54afdca5d873
W1025 18:23:28.759] go: finding golang.org/x/sys v0.0.0-20190813064441-fde4db37ae7a
W1025 18:23:28.769] go: finding golang.org/x/text v0.3.2
W1025 18:23:28.785] go: finding go.opencensus.io v0.21.0
W1025 18:23:28.802] go: finding github.com/hashicorp/golang-lru v0.5.1
W1025 18:23:28.818] go: finding k8s.io/klog v1.0.0
W1025 18:23:28.828] go: finding github.com/davecgh/go-spew v1.1.1
W1025 18:23:28.834] go: finding github.com/pkg/errors v0.8.1
W1025 18:23:28.839] go: finding github.com/stretchr/testify v1.4.0
W1025 18:23:28.844] go: finding github.com/pmezard/go-difflib v1.0.0
W1025 18:23:28.850] go: finding gopkg.in/yaml.v2 v2.2.8
W1025 18:23:28.861] go: finding github.com/gogo/protobuf v1.2.2-0.20190723190241-65acae22fc9d
W1025 18:23:28.869] go: finding github.com/google/gofuzz v1.0.0
W1025 18:23:28.876] go: finding gopkg.in/inf.v0 v0.9.1
W1025 18:23:28.903] go: finding sigs.k8s.io/yaml v1.1.0
W1025 18:23:28.909] go: finding k8s.io/kube-openapi v0.0.0-20200410145947-bcb3869e6f29
W1025 18:23:28.914] go: finding github.com/googleapis/gnostic v0.0.0-20170729233727-0c5108395e2d
W1025 18:23:28.929] go: finding github.com/evanphx/json-patch v4.9.0+incompatible
W1025 18:23:28.938] go: finding github.com/json-iterator/go v1.1.8
W1025 18:23:28.944] go: finding github.com/modern-go/concurrent v0.0.0-20180306012644-bacd9c7ef1dd
W1025 18:23:28.949] go: finding github.com/modern-go/reflect2 v1.0.1
W1025 18:23:28.970] go: finding github.com/blang/semver v3.5.0+incompatible
W1025 18:23:28.978] go: finding github.com/prometheus/client_golang v1.0.0
W1025 18:23:28.984] go: finding github.com/beorn7/perks v1.0.0
W1025 18:23:28.990] go: finding github.com/prometheus/client_model v0.0.0-20190129233127-fd36f4220a90
W1025 18:23:28.996] go: finding github.com/prometheus/common v0.4.1
W1025 18:23:29.001] go: finding github.com/matttproud/golang_protobuf_extensions v1.0.1
W1025 18:23:29.010] go: finding github.com/prometheus/procfs v0.0.2
W1025 18:23:29.024] go: finding golang.org/x/crypto v0.0.0-20200220183623-bac4c82f6975
W1025 18:23:29.035] go: finding golang.org/x/time v0.0.0-20190308202827-9d24e82272b4
W1025 18:23:29.041] go: finding k8s.io/utils v0.0.0-20191114184206-e782cd3c129f
W1025 18:23:29.048] go: finding github.com/imdario/mergo v0.3.5
W1025 18:23:29.059] go: finding github.com/spf13/pflag v1.0.5
W1025 18:23:29.133] go: finding github.com/google/go-cmp v0.3.0
W1025 18:23:29.287] go: finding github.com/golang/groupcache v0.0.0-20160516000752-02826c3e7903
W1025 18:23:29.301] go: finding github.com/docker/distribution v2.7.1+incompatible
W1025 18:23:29.306] go: finding github.com/opencontainers/go-digest v1.0.0-rc1
W1025 18:23:29.320] go: finding gopkg.in/square/go-jose.v2 v2.2.2
I1025 18:26:59.726] Initializing e2e tests using image ubuntu-gke-1804-1-15-v20200824.
I1025 18:26:59.730] make: Entering directory '/go/src/k8s.io/kubernetes'
I1025 18:26:59.734] make[1]: Entering directory '/go/src/k8s.io/kubernetes'
W1025 18:26:59.868] I1025 18:26:59.726592    4329 remote.go:40] Building archive...
W1025 18:26:59.869] I1025 18:26:59.726799    4329 build.go:42] Building k8s binaries...
W1025 18:27:00.133] I1025 18:27:00.133376    4329 run_remote.go:568] Creating instance {image:ubuntu-gke-1804-1-15-v20200824 imageDesc: project:ubuntu-os-gke-cloud-devel resources:{Accelerators:[]} metadata:<nil> machine: tests:[]} with service account "1050223417337-compute@developer.gserviceaccount.com"
I1025 18:27:13.768] +++ [1025 18:27:13] Building go targets for linux/amd64:
I1025 18:27:13.768]     ./vendor/k8s.io/code-generator/cmd/deepcopy-gen
I1025 18:27:32.748] +++ [1025 18:27:32] Building go targets for linux/amd64:
I1025 18:27:32.748]     ./vendor/k8s.io/code-generator/cmd/defaulter-gen
I1025 18:27:44.623] +++ [1025 18:27:44] Building go targets for linux/amd64:
I1025 18:27:44.623]     ./vendor/k8s.io/code-generator/cmd/conversion-gen
I1025 18:28:05.210] +++ [1025 18:28:05] Building go targets for linux/amd64:
I1025 18:28:05.210]     ./vendor/k8s.io/kube-openapi/cmd/openapi-gen
I1025 18:28:30.848] +++ [1025 18:28:30] Building go targets for linux/amd64:
I1025 18:28:30.849]     ./vendor/github.com/go-bindata/go-bindata/go-bindata
I1025 18:28:32.638] make[1]: Leaving directory '/go/src/k8s.io/kubernetes'
I1025 18:28:33.102] +++ [1025 18:28:33] Building go targets for linux/amd64:
I1025 18:28:33.102]     cmd/kubelet
I1025 18:28:33.102]     test/e2e_node/e2e_node.test
I1025 18:28:33.102]     vendor/github.com/onsi/ginkgo/ginkgo
I1025 18:28:33.103]     cluster/gce/gci/mounter
I1025 18:46:43.090] make: Leaving directory '/go/src/k8s.io/kubernetes'
W1025 18:46:57.251] I1025 18:46:57.249428    4329 remote.go:70] Staging test binaries on "tmp-node-e2e-027cee82-ubuntu-gke-1804-1-15-v20200824"
W1025 18:47:00.186] I1025 18:47:00.186118    4329 remote.go:97] Extracting tar on "tmp-node-e2e-027cee82-ubuntu-gke-1804-1-15-v20200824"
W1025 18:47:03.749] I1025 18:47:03.748715    4329 remote.go:112] Running test on "tmp-node-e2e-027cee82-ubuntu-gke-1804-1-15-v20200824"
W1025 18:47:03.749] I1025 18:47:03.748793    4329 utils.go:55] Install CNI on "tmp-node-e2e-027cee82-ubuntu-gke-1804-1-15-v20200824"
W1025 18:47:06.184] I1025 18:47:06.183993    4329 utils.go:68] Adding CNI configuration on "tmp-node-e2e-027cee82-ubuntu-gke-1804-1-15-v20200824"
W1025 18:47:06.868] I1025 18:47:06.865869    4329 utils.go:82] Configure iptables firewall rules on "tmp-node-e2e-027cee82-ubuntu-gke-1804-1-15-v20200824"
W1025 18:47:08.886] I1025 18:47:08.886081    4329 utils.go:117] Killing any existing node processes on "tmp-node-e2e-027cee82-ubuntu-gke-1804-1-15-v20200824"
W1025 18:47:10.257] I1025 18:47:10.257273    4329 node_e2e.go:147] Starting tests on "tmp-node-e2e-027cee82-ubuntu-gke-1804-1-15-v20200824"
W1025 18:47:13.525] I1025 18:47:13.524897    4329 remote.go:197] Test failed unexpectedly. Attempting to retrieving system logs (only works for nodes with journald)
W1025 18:47:14.200] I1025 18:47:14.200411    4329 remote.go:202] Got the system logs from journald; copying it back...
W1025 18:47:15.077] I1025 18:47:15.076759    4329 remote.go:122] Copying test artifacts from "tmp-node-e2e-027cee82-ubuntu-gke-1804-1-15-v20200824"
W1025 18:47:16.301] I1025 18:47:16.301110    4329 run_remote.go:744] Deleting instance "tmp-node-e2e-027cee82-ubuntu-gke-1804-1-15-v20200824"
I1025 18:47:16.798] 
I1025 18:47:16.798] >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
I1025 18:47:16.798] >                              START TEST                                >
I1025 18:47:16.798] >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
I1025 18:47:16.799] Start Test Suite on Host tmp-node-e2e-027cee82-ubuntu-gke-1804-1-15-v20200824
I1025 18:47:16.799] Running Suite: E2eNode Suite
I1025 18:47:16.799] ============================
I1025 18:47:16.799] Random Seed: 1603651630 - Will randomize all specs
I1025 18:47:16.799] Will run 312 specs
I1025 18:47:16.799] 
I1025 18:47:16.799] Running in parallel across 8 nodes
I1025 18:47:16.800] 
I1025 18:47:16.800] Oct 25 18:47:13.055: INFO: Parsing ds from https://raw.githubusercontent.com/kubernetes/kubernetes/master/cluster/addons/device-plugins/nvidia-gpu/daemonset.yaml
I1025 18:47:16.800] STEP: Enabling support for Kubelet Plugins Watcher
I1025 18:47:16.800] W1025 18:47:13.205785    2967 test_context.go:410] Unable to find in-cluster config, using default host : http://127.0.0.1:8080
I1025 18:47:16.801] I1025 18:47:13.205830    2967 test_context.go:419] Tolerating taints "node-role.kubernetes.io/master" when considering if nodes are ready
I1025 18:47:16.801] Oct 25 18:47:13.205: INFO: The --provider flag is not set. Continuing as if --provider=skeleton had been used.
I1025 18:47:16.801] Validating os...
I1025 18:47:16.801] OS: Linux
I1025 18:47:16.801] Validating kernel...
I1025 18:47:16.801] KERNEL_VERSION: 5.0.0-1046-gke
I1025 18:47:16.801] CONFIG_BOOTPARAM_HARDLOCKUP_PANIC: enabled
I1025 18:47:16.802] CONFIG_BOOTPARAM_SOFTLOCKUP_PANIC: enabled
I1025 18:47:16.802] CONFIG_PANIC_ON_OOPS: enabled
I1025 18:47:16.802] CONFIG_PVPANIC: enabled (as module)
I1025 18:47:16.802] CONFIG_DMIID: enabled
I1025 18:47:16.802] CONFIG_ACPI_BUTTON: enabled
I1025 18:47:16.802] CONFIG_INET: enabled
I1025 18:47:16.802] CONFIG_VXLAN: enabled (as module)
I1025 18:47:16.803] CONFIG_IP_SET: enabled (as module)
I1025 18:47:16.803] CONFIG_IP_SET_HASH_IP: enabled (as module)
I1025 18:47:16.803] CONFIG_IPVLAN: enabled (as module)
I1025 18:47:16.803] CONFIG_IPV6: enabled
I1025 18:47:16.803] CONFIG_IP6_NF_IPTABLES: enabled (as module)
I1025 18:47:16.803] CONFIG_IP_NF_TARGET_REDIRECT: enabled (as module)
I1025 18:47:16.804] CONFIG_NETFILTER_XT_MATCH_COMMENT: enabled (as module)
I1025 18:47:16.804] CONFIG_PACKET_DIAG: enabled (as module)
I1025 18:47:16.804] CONFIG_UNIX_DIAG: enabled (as module)
I1025 18:47:16.804] CONFIG_INET_DIAG: enabled (as module)
I1025 18:47:16.804] CONFIG_INET_TCP_DIAG: enabled (as module)
I1025 18:47:16.804] CONFIG_INET_UDP_DIAG: enabled (as module)
I1025 18:47:16.805] CONFIG_NETLINK_DIAG: enabled (as module)
I1025 18:47:16.805] CONFIG_EXT4_FS: enabled
I1025 18:47:16.805] CONFIG_DEBUG_FS: enabled
I1025 18:47:16.805] CONFIG_PROC_FS: enabled
I1025 18:47:16.805] CONFIG_XFS_FS: enabled (as module)
I1025 18:47:16.805] CONFIG_SCSI_PROC_FS: enabled
I1025 18:47:16.805] CONFIG_OVERLAY_FS: enabled (as module)
I1025 18:47:16.806] CONFIG_NFS_FS: enabled (as module)
I1025 18:47:16.806] CONFIG_AUTOFS4_FS: enabled (as module)
I1025 18:47:16.806] CONFIG_NFS_FSCACHE: enabled
I1025 18:47:16.806] CONFIG_FSCACHE: enabled (as module)
I1025 18:47:16.806] CONFIG_CACHEFILES: enabled (as module)
I1025 18:47:16.806] CONFIG_FUSE_FS: enabled
I1025 18:47:16.806] CONFIG_BCACHE: enabled (as module)
I1025 18:47:16.807] CONFIG_NAMESPACES: enabled
I1025 18:47:16.807] CONFIG_IPC_NS: enabled
I1025 18:47:16.807] CONFIG_NET_NS: enabled
I1025 18:47:16.807] CONFIG_PID_NS: enabled
I1025 18:47:16.807] CONFIG_UTS_NS: enabled
I1025 18:47:16.807] CONFIG_CGROUPS: enabled
I1025 18:47:16.807] CONFIG_CGROUP_CPUACCT: enabled
I1025 18:47:16.808] CONFIG_CGROUP_DEVICE: enabled
I1025 18:47:16.808] CONFIG_CGROUP_SCHED: enabled
I1025 18:47:16.808] CONFIG_CPUSETS: enabled
I1025 18:47:16.808] CONFIG_MEMCG: enabled
I1025 18:47:16.808] CONFIG_QUOTA: enabled
I1025 18:47:16.808] CONFIG_SECCOMP: enabled
I1025 18:47:16.808] CONFIG_SECURITY_APPARMOR: enabled
I1025 18:47:16.809] CONFIG_CC_STACKPROTECTOR_STRONG: not set - Add the stack buffer overflow protections.
I1025 18:47:16.809] CONFIG_STRICT_DEVMEM: enabled
I1025 18:47:16.809] CONFIG_IMA: enabled
I1025 18:47:16.809] CONFIG_AUDIT: enabled
I1025 18:47:16.809] CONFIG_AUDITSYSCALL: enabled
I1025 18:47:16.809] CONFIG_MODULES: enabled
I1025 18:47:16.810] CONFIG_PRINTK: enabled
I1025 18:47:16.810] CONFIG_MMU: enabled
I1025 18:47:16.810] Validating cgroups...
I1025 18:47:16.810] Validating package...
I1025 18:47:16.810] apparmor (>=2.10.1): 2.12
I1025 18:47:16.810] autofs (>=5.0.7): 5.1.2
I1025 18:47:16.810] bash (>=4.3): 4.4.18
I1025 18:47:16.810] bridge-utils (>=1.5): 1.5
I1025 18:47:16.811] cloud-init (>=0.7.6): 20.2
I1025 18:47:16.811] coreutils (>=8.24): 8.28
I1025 18:47:16.811] dbus (>=1.6.8): 1.12.2
I1025 18:47:16.811] e2fsprogs (>=1.4.3): 1.44.1
I1025 18:47:16.811] ebtables (>=2.0.10): 2.0.10.4
I1025 18:47:16.811] ethtool (>=3.18): 4.15
I1025 18:47:16.811] iproute2 (>=4.2.0): 4.15.0
I1025 18:47:16.812] less (>=481): 487
I1025 18:47:16.812] netcat-openbsd (>=1.10): 1.187
I1025 18:47:16.812] python (>=2.7.10): 2.7.15~rc1
I1025 18:47:16.812] pv (>=1.3.4): 1.6.6
I1025 18:47:16.812] sudo (>=1.8.12): 1.8.21p2
I1025 18:47:16.812] systemd (>=225): 237
I1025 18:47:16.812] tar (>=1.28): 1.29b
I1025 18:47:16.813] util-linux (>=2.27.1): 2.31.1
I1025 18:47:16.813] gce-compute-image-packages (>=20170227): 20190801
I1025 18:47:16.813] auditd (>=2.4.5): 2.8.2
I1025 18:47:16.813] grub-common (>=2.2): 2.02
I1025 18:47:16.813] wget (>=1.17.1): 1.19.4
I1025 18:47:16.813] Validating docker...
I1025 18:47:16.814] F1025 18:47:13.437536    2967 e2e_node_suite_test.go:149] system validation failed: [unexpected kernel config: CONFIG_CC_STACKPROTECTOR_STRONG]
I1025 18:47:16.814] 
I1025 18:47:16.814] 
I1025 18:47:16.814] Failure [0.765 seconds]
I1025 18:47:16.814] [BeforeSuite] BeforeSuite 
I1025 18:47:16.814] _output/local/go/src/k8s.io/kubernetes/test/e2e_node/e2e_node_suite_test.go:172
I1025 18:47:16.814] 
I1025 18:47:16.814]   system validation
I1025 18:47:16.814]   Expected success, but got an error:
I1025 18:47:16.815]       <*errors.errorString | 0xc000722370>: {
I1025 18:47:16.815]           s: "system validation failed: exit status 1",
I1025 18:47:16.815]       }
I1025 18:47:16.815]       system validation failed: exit status 1
I1025 18:47:16.815] 
I1025 18:47:16.815]   _output/local/go/src/k8s.io/kubernetes/test/e2e_node/e2e_node_suite_test.go:174
I1025 18:47:16.815] ------------------------------
I1025 18:47:16.815] Failure [0.757 seconds]
I1025 18:47:16.816] [BeforeSuite] BeforeSuite 
I1025 18:47:16.816] _output/local/go/src/k8s.io/kubernetes/test/e2e_node/e2e_node_suite_test.go:172
I1025 18:47:16.816] 
I1025 18:47:16.816]   BeforeSuite on Node 1 failed
I1025 18:47:16.816] 
I1025 18:47:16.816]   _output/local/go/src/k8s.io/kubernetes/test/e2e_node/e2e_node_suite_test.go:172
I1025 18:47:16.816] ------------------------------
I1025 18:47:16.816] Failure [0.760 seconds]
I1025 18:47:16.816] [BeforeSuite] BeforeSuite 
I1025 18:47:16.816] _output/local/go/src/k8s.io/kubernetes/test/e2e_node/e2e_node_suite_test.go:172
I1025 18:47:16.817] 
I1025 18:47:16.817]   BeforeSuite on Node 1 failed
I1025 18:47:16.817] 
I1025 18:47:16.817]   _output/local/go/src/k8s.io/kubernetes/test/e2e_node/e2e_node_suite_test.go:172
I1025 18:47:16.817] ------------------------------
I1025 18:47:16.817] Failure [0.758 seconds]
I1025 18:47:16.817] [BeforeSuite] BeforeSuite 
I1025 18:47:16.817] _output/local/go/src/k8s.io/kubernetes/test/e2e_node/e2e_node_suite_test.go:172
I1025 18:47:16.817] 
I1025 18:47:16.817]   BeforeSuite on Node 1 failed
I1025 18:47:16.818] 
I1025 18:47:16.818]   _output/local/go/src/k8s.io/kubernetes/test/e2e_node/e2e_node_suite_test.go:172
I1025 18:47:16.818] ------------------------------
I1025 18:47:16.818] Failure [0.758 seconds]
I1025 18:47:16.818] [BeforeSuite] BeforeSuite 
I1025 18:47:16.818] _output/local/go/src/k8s.io/kubernetes/test/e2e_node/e2e_node_suite_test.go:172
I1025 18:47:16.818] 
I1025 18:47:16.818]   BeforeSuite on Node 1 failed
I1025 18:47:16.818] 
I1025 18:47:16.819]   _output/local/go/src/k8s.io/kubernetes/test/e2e_node/e2e_node_suite_test.go:172
I1025 18:47:16.819] ------------------------------
I1025 18:47:16.819] Failure [0.761 seconds]
I1025 18:47:16.819] [BeforeSuite] BeforeSuite 
I1025 18:47:16.819] _output/local/go/src/k8s.io/kubernetes/test/e2e_node/e2e_node_suite_test.go:172
I1025 18:47:16.819] 
I1025 18:47:16.819]   BeforeSuite on Node 1 failed
I1025 18:47:16.819] 
I1025 18:47:16.819]   _output/local/go/src/k8s.io/kubernetes/test/e2e_node/e2e_node_suite_test.go:172
I1025 18:47:16.819] ------------------------------
I1025 18:47:16.820] Failure [0.762 seconds]
I1025 18:47:16.820] [BeforeSuite] BeforeSuite 
I1025 18:47:16.820] _output/local/go/src/k8s.io/kubernetes/test/e2e_node/e2e_node_suite_test.go:172
I1025 18:47:16.820] 
I1025 18:47:16.820]   BeforeSuite on Node 1 failed
I1025 18:47:16.820] 
I1025 18:47:16.820]   _output/local/go/src/k8s.io/kubernetes/test/e2e_node/e2e_node_suite_test.go:172
I1025 18:47:16.820] ------------------------------
I1025 18:47:16.820] Failure [0.758 seconds]
I1025 18:47:16.821] [BeforeSuite] BeforeSuite 
I1025 18:47:16.821] _output/local/go/src/k8s.io/kubernetes/test/e2e_node/e2e_node_suite_test.go:172
I1025 18:47:16.821] 
I1025 18:47:16.821]   BeforeSuite on Node 1 failed
I1025 18:47:16.821] 
I1025 18:47:16.821]   _output/local/go/src/k8s.io/kubernetes/test/e2e_node/e2e_node_suite_test.go:172
I1025 18:47:16.821] ------------------------------
I1025 18:47:16.821] I1025 18:47:13.491781    2873 e2e_node_suite_test.go:221] Tests Finished
I1025 18:47:16.821] 
I1025 18:47:16.822] 
I1025 18:47:16.822] Ran 2496 of 0 Specs in 0.818 seconds
I1025 18:47:16.822] FAIL! -- 0 Passed | 2496 Failed | 0 Pending | 0 Skipped
I1025 18:47:16.822] 
I1025 18:47:16.822] 
I1025 18:47:16.822] Ginkgo ran 1 suite in 2.587891113s
I1025 18:47:16.822] Test Suite Failed
I1025 18:47:16.822] 
I1025 18:47:16.822] Failure Finished Test Suite on Host tmp-node-e2e-027cee82-ubuntu-gke-1804-1-15-v20200824
I1025 18:47:16.823] [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.230.87.78 -- sudo sh -c 'cd /tmp/node-e2e-20201025T184657 && 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-027cee82-ubuntu-gke-1804-1-15-v20200824 --report-dir=/tmp/node-e2e-20201025T184657/results --report-prefix=ubuntu-gke-1804-1-15-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.230.87.78:/tmp/node-e2e-20201025T184657/results/*.log /workspace/_artifacts/tmp-node-e2e-027cee82-ubuntu-gke-1804-1-15-v20200824] failed with error: exit status 1]
I1025 18:47:16.823] <<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<
I1025 18:47:16.824] <                              FINISH TEST                               <
I1025 18:47:16.824] <<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<
I1025 18:47:16.824] 
I1025 18:47:16.824] Failure: 1 errors encountered.
W1025 18:47:16.924] exit status 1
W1025 18:47:16.974] 2020/10/25 18:47:16 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-15-v20200824 --image-project=ubuntu-os-gke-cloud-devel' finished in 23m58.458401464s
W1025 18:47:16.975] 2020/10/25 18:47:16 e2e.go:544: Dumping logs locally to: /workspace/_artifacts
W1025 18:47:16.975] 2020/10/25 18:47:16 process.go:153: Running: ./cluster/log-dump/log-dump.sh /workspace/_artifacts
W1025 18:47:17.057] Trying to find master named 'bootstrap-e2e-master'
W1025 18:47:17.058] Looking for address 'bootstrap-e2e-master-ip'
I1025 18:47:17.158] Checking for custom logdump instances, if any
I1025 18:47:17.159] Sourcing kube-util.sh
I1025 18:47:17.159] Detecting project
I1025 18:47:17.159] Project: ubuntu-image-validation
I1025 18:47:17.159] Network Project: ubuntu-image-validation
I1025 18:47:17.159] Zone: us-west1-b
I1025 18:47:17.160] Dumping logs from master locally to '/workspace/_artifacts'
W1025 18:47:18.025] ERROR: (gcloud.compute.addresses.describe) Could not fetch resource:
W1025 18:47:18.026]  - The resource 'projects/ubuntu-image-validation/regions/us-west1/addresses/bootstrap-e2e-master-ip' was not found
W1025 18:47:18.026] 
W1025 18:47:18.208] Could not detect Kubernetes master node.  Make sure you've launched a cluster with 'kube-up.sh'
I1025 18:47:18.309] Master not detected. Is the cluster up?
I1025 18:47:18.309] Dumping logs from nodes locally to '/workspace/_artifacts'
I1025 18:47:18.309] Detecting nodes in the cluster
I1025 18:47:20.363] No nodes found!
W1025 18:47:22.529] INSTANCE_GROUPS=
W1025 18:47:22.530] NODE_NAMES=
W1025 18:47:22.530] 2020/10/25 18:47:22 process.go:155: Step './cluster/log-dump/log-dump.sh /workspace/_artifacts' finished in 5.556346657s
W1025 18:47:22.531] 2020/10/25 18:47:22 node.go:53: Noop - Node Down()
W1025 18:47:22.531] 2020/10/25 18:47:22 process.go:96: Saved XML output to /workspace/_artifacts/junit_runner.xml.
W1025 18:47:22.532] 2020/10/25 18:47:22 process.go:153: Running: bash -c . hack/lib/version.sh && KUBE_ROOT=. kube::version::get_version_vars && echo "${KUBE_GIT_VERSION-}"
W1025 18:47:24.099] 2020/10/25 18:47:24 process.go:155: Step 'bash -c . hack/lib/version.sh && KUBE_ROOT=. kube::version::get_version_vars && echo "${KUBE_GIT_VERSION-}"' finished in 1.567630683s
W1025 18:47:24.100] 2020/10/25 18:47:24 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-15-v20200824 --image-project=ubuntu-os-gke-cloud-devel: exit status 1]
W1025 18:47:24.103] Traceback (most recent call last):
W1025 18:47:24.104]   File "/workspace/./test-infra/jenkins/../scenarios/kubernetes_e2e.py", line 720, in <module>
W1025 18:47:24.105]     main(parse_args())
W1025 18:47:24.105]   File "/workspace/./test-infra/jenkins/../scenarios/kubernetes_e2e.py", line 570, in main
W1025 18:47:24.106]     mode.start(runner_args)
W1025 18:47:24.106]   File "/workspace/./test-infra/jenkins/../scenarios/kubernetes_e2e.py", line 228, in start
W1025 18:47:24.106]     check_env(env, self.command, *args)
W1025 18:47:24.106]   File "/workspace/./test-infra/jenkins/../scenarios/kubernetes_e2e.py", line 111, in check_env
W1025 18:47:24.106]     subprocess.check_call(cmd, env=env)
W1025 18:47:24.107]   File "/usr/lib/python2.7/subprocess.py", line 190, in check_call
W1025 18:47:24.107]     raise CalledProcessError(retcode, cmd)
W1025 18:47:24.107] 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-1', '--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
E1025 18:47:24.122] Command failed
I1025 18:47:24.122] process 315 exited with code 1 after 24.2m
E1025 18:47:24.122] FAIL: ci-kubernetes-e2enode-ubuntu1-k8sstable2-gkespec
I1025 18:47:24.124] Call:  gcloud auth activate-service-account --key-file=/etc/service-account/service-account.json
W1025 18:47:24.804] Activated service account credentials for: [pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com]
I1025 18:47:24.922] process 39225 exited with code 0 after 0.0m
I1025 18:47:24.922] Call:  gcloud config get-value account
I1025 18:47:25.548] process 39238 exited with code 0 after 0.0m
I1025 18:47:25.549] Will upload results to gs://kubernetes-jenkins/logs using pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com
I1025 18:47:25.549] Upload result and artifacts...
I1025 18:47:25.549] Gubernator results at https://gubernator.k8s.io/build/kubernetes-jenkins/logs/ci-kubernetes-e2enode-ubuntu1-k8sstable2-gkespec/1320430015019487232
I1025 18:47:25.549] Call:  gsutil ls gs://kubernetes-jenkins/logs/ci-kubernetes-e2enode-ubuntu1-k8sstable2-gkespec/1320430015019487232/artifacts
W1025 18:47:26.909] CommandException: One or more URLs matched no objects.
E1025 18:47:27.118] Command failed
I1025 18:47:27.119] process 39251 exited with code 1 after 0.0m
W1025 18:47:27.119] Remote dir gs://kubernetes-jenkins/logs/ci-kubernetes-e2enode-ubuntu1-k8sstable2-gkespec/1320430015019487232/artifacts not exist yet
I1025 18:47:27.119] 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-ubuntu1-k8sstable2-gkespec/1320430015019487232/artifacts
I1025 18:47:29.633] process 39394 exited with code 0 after 0.0m
I1025 18:47:29.634] Call:  git rev-parse HEAD
I1025 18:47:29.639] process 39925 exited with code 0 after 0.0m
I1025 18:47:29.639] Call:  git rev-parse HEAD
I1025 18:47:29.648] process 39926 exited with code 0 after 0.0m
I1025 18:47:29.649] Call:  gsutil stat gs://kubernetes-jenkins/logs/ci-kubernetes-e2enode-ubuntu1-k8sstable2-gkespec/jobResultsCache.json
I1025 18:47:31.096] process 39927 exited with code 0 after 0.0m
I1025 18:47:31.098] Call:  gsutil -q cat 'gs://kubernetes-jenkins/logs/ci-kubernetes-e2enode-ubuntu1-k8sstable2-gkespec/jobResultsCache.json#1603644278783228'
I1025 18:47:32.543] process 40070 exited with code 0 after 0.0m
I1025 18:47:32.549] Call:  gsutil -q -h Content-Type:application/json -h x-goog-if-generation-match:1603644278783228 cp /tmp/gsutil_51DOVu gs://kubernetes-jenkins/logs/ci-kubernetes-e2enode-ubuntu1-k8sstable2-gkespec/jobResultsCache.json
I1025 18:47:34.120] process 40215 exited with code 0 after 0.0m
I1025 18:47:34.121] Call:  gsutil -q -h Content-Type:application/json cp /tmp/gsutil_veQWep gs://kubernetes-jenkins/logs/ci-kubernetes-e2enode-ubuntu1-k8sstable2-gkespec/1320430015019487232/finished.json
I1025 18:47:35.620] process 40394 exited with code 0 after 0.0m
I1025 18:47:35.621] Call:  gsutil -q -h Content-Type:text/plain -h 'Cache-Control:private, max-age=0, no-transform' cp /tmp/gsutil_mLNPHU gs://kubernetes-jenkins/logs/ci-kubernetes-e2enode-ubuntu1-k8sstable2-gkespec/latest-build.txt
I1025 18:47:37.091] process 40573 exited with code 0 after 0.0m