W1025 04:13:51.935] ************************************************************************** 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 04:13:51.936] 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 04:13:51.936] Bootstrap ci-kubernetes-e2enode-ubuntu1-k8sstable2-gkespec... I1025 04:13:51.938] Builder: 6bfc4083-1678-11eb-b256-6ee25ea2e440 I1025 04:13:51.938] Image: gcr.io/k8s-testimages/kubekins-e2e:v20201021-a62ce8a-1.17 I1025 04:13:51.939] Gubernator results at https://gubernator.k8s.io/build/kubernetes-jenkins/logs/ci-kubernetes-e2enode-ubuntu1-k8sstable2-gkespec/1320216861387788288 I1025 04:13:51.939] Call: gcloud auth activate-service-account --key-file=/etc/service-account/service-account.json W1025 04:13:52.642] Activated service account credentials for: [pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com] I1025 04:13:52.765] process 35 exited with code 0 after 0.0m I1025 04:13:52.765] Call: gcloud config get-value account I1025 04:13:53.538] process 48 exited with code 0 after 0.0m I1025 04:13:53.538] Will upload results to gs://kubernetes-jenkins/logs using pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com I1025 04:13:53.539] Root: /go/src I1025 04:13:53.539] cd to /go/src I1025 04:13:53.539] Checkout: /go/src/k8s.io/kubernetes release-1.17 to /go/src/k8s.io/kubernetes I1025 04:13:53.539] Call: git init k8s.io/kubernetes I1025 04:13:53.546] Initialized empty Git repository in /go/src/k8s.io/kubernetes/.git/ I1025 04:13:53.546] process 61 exited with code 0 after 0.0m I1025 04:13:53.547] Call: git config --local user.name 'K8S Bootstrap' I1025 04:13:53.551] process 62 exited with code 0 after 0.0m I1025 04:13:53.552] Call: git config --local user.email k8s_bootstrap@localhost I1025 04:13:53.557] process 63 exited with code 0 after 0.0m I1025 04:13:53.558] Call: git fetch --quiet --tags https://github.com/kubernetes/kubernetes release-1.17 I1025 04:16:05.142] process 64 exited with code 0 after 2.2m I1025 04:16:05.143] Call: git checkout -B test FETCH_HEAD W1025 04:16:08.502] Switched to a new branch 'test' I1025 04:16:08.534] process 75 exited with code 0 after 0.1m I1025 04:16:08.534] Call: git show -s --format=format:%ct HEAD I1025 04:16:08.542] process 76 exited with code 0 after 0.0m I1025 04:16:08.543] Configure environment... I1025 04:16:08.543] Call: git show -s --format=format:%ct HEAD I1025 04:16:08.554] process 77 exited with code 0 after 0.0m I1025 04:16:08.554] Call: gcloud auth activate-service-account --key-file=/etc/service-account/service-account.json W1025 04:16:09.241] Activated service account credentials for: [pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com] I1025 04:16:09.476] process 78 exited with code 0 after 0.0m I1025 04:16:09.476] Call: gcloud config get-value account I1025 04:16:10.308] process 91 exited with code 0 after 0.0m I1025 04:16:10.309] Will upload results to gs://kubernetes-jenkins/logs using pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com I1025 04:16:10.309] 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 04:16:10.782] process 104 exited with code 0 after 0.0m I1025 04:16:10.783] Start 1320216861387788288 at v1.17.14-rc.0.15+54f3c097502f5b... I1025 04:16:10.785] Call: gsutil -q -h Content-Type:application/json cp /tmp/gsutil_B_PXrH gs://kubernetes-jenkins/logs/ci-kubernetes-e2enode-ubuntu1-k8sstable2-gkespec/1320216861387788288/started.json I1025 04:16:12.701] process 137 exited with code 0 after 0.0m I1025 04:16:12.702] 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 04:16:12.756] starts with local mode W1025 04:16:12.756] Environment: W1025 04:16:12.757] ARTIFACTS=/workspace/_artifacts W1025 04:16:12.757] AWS_SSH_PRIVATE_KEY_FILE=/root/.ssh/kube_aws_rsa W1025 04:16:12.757] AWS_SSH_PUBLIC_KEY_FILE=/root/.ssh/kube_aws_rsa.pub W1025 04:16:12.757] BAZEL_REMOTE_CACHE_ENABLED=false W1025 04:16:12.757] BAZEL_VERSION=2.2.0 W1025 04:16:12.757] BOOTSTRAP_MIGRATION=yes W1025 04:16:12.757] BOSKOS_METRICS_PORT=tcp://10.63.252.110:9090 W1025 04:16:12.758] BOSKOS_METRICS_PORT_9090_TCP=tcp://10.63.252.110:9090 W1025 04:16:12.758] BOSKOS_METRICS_PORT_9090_TCP_ADDR=10.63.252.110 W1025 04:16:12.758] BOSKOS_METRICS_PORT_9090_TCP_PORT=9090 W1025 04:16:12.758] BOSKOS_METRICS_PORT_9090_TCP_PROTO=tcp W1025 04:16:12.758] BOSKOS_METRICS_SERVICE_HOST=10.63.252.110 W1025 04:16:12.758] BOSKOS_METRICS_SERVICE_PORT=9090 W1025 04:16:12.758] BOSKOS_METRICS_SERVICE_PORT_METRICS=9090 W1025 04:16:12.758] BOSKOS_PORT=tcp://10.63.250.132:80 W1025 04:16:12.759] BOSKOS_PORT_80_TCP=tcp://10.63.250.132:80 W1025 04:16:12.759] BOSKOS_PORT_80_TCP_ADDR=10.63.250.132 W1025 04:16:12.759] BOSKOS_PORT_80_TCP_PORT=80 W1025 04:16:12.759] BOSKOS_PORT_80_TCP_PROTO=tcp W1025 04:16:12.759] BOSKOS_SERVICE_HOST=10.63.250.132 W1025 04:16:12.759] BOSKOS_SERVICE_PORT=80 W1025 04:16:12.759] BOSKOS_SERVICE_PORT_DEFAULT=80 W1025 04:16:12.759] BUILD_ID=1320216861387788288 W1025 04:16:12.760] BUILD_NUMBER=1320216861387788288 W1025 04:16:12.760] CI=true W1025 04:16:12.760] CLOUDSDK_COMPONENT_MANAGER_DISABLE_UPDATE_CHECK=true W1025 04:16:12.760] CLOUDSDK_CONFIG=/go/src/k8s.io/kubernetes/.config/gcloud W1025 04:16:12.760] CLOUDSDK_CORE_DISABLE_PROMPTS=1 W1025 04:16:12.760] CLOUDSDK_EXPERIMENTAL_FAST_COMPONENT_UPDATE=false W1025 04:16:12.760] DOCKER_IN_DOCKER_ENABLED=false W1025 04:16:12.761] DOCKER_IN_DOCKER_IPV6_ENABLED=false W1025 04:16:12.761] E2E_GOOGLE_APPLICATION_CREDENTIALS=/etc/service-account/service-account.json W1025 04:16:12.761] GCS_ARTIFACTS_DIR=gs://kubernetes-jenkins/logs/ci-kubernetes-e2enode-ubuntu1-k8sstable2-gkespec/1320216861387788288/artifacts W1025 04:16:12.761] GOOGLE_APPLICATION_CREDENTIALS=/etc/service-account/service-account.json W1025 04:16:12.761] GOOGLE_APPLICATION_CREDENTIALS_DEPRECATED=Migrate to workload identity, contact sig-testing W1025 04:16:12.761] GOPATH=/go W1025 04:16:12.762] GOPROXY=https://proxy.golang.org W1025 04:16:12.762] GO_TARBALL=go1.13.15.linux-amd64.tar.gz W1025 04:16:12.762] HOME=/workspace W1025 04:16:12.762] HOSTNAME=6bfc4083-1678-11eb-b256-6ee25ea2e440 W1025 04:16:12.762] IMAGE=gcr.io/k8s-testimages/kubekins-e2e:v20201021-a62ce8a-1.17 W1025 04:16:12.762] INSTANCE_PREFIX=bootstrap-e2e W1025 04:16:12.762] JENKINS_GCE_SSH_PRIVATE_KEY_FILE=/workspace/.ssh/google_compute_engine W1025 04:16:12.763] JENKINS_GCE_SSH_PUBLIC_KEY_FILE=/workspace/.ssh/google_compute_engine.pub W1025 04:16:12.763] JOB_NAME=ci-kubernetes-e2enode-ubuntu1-k8sstable2-gkespec W1025 04:16:12.763] JOB_SPEC={"type":"periodic","job":"ci-kubernetes-e2enode-ubuntu1-k8sstable2-gkespec","buildid":"1320216861387788288","prowjobid":"6bfc4083-1678-11eb-b256-6ee25ea2e440"} W1025 04:16:12.763] JOB_TYPE=periodic W1025 04:16:12.763] KUBERNETES_PORT=tcp://10.63.240.1:443 W1025 04:16:12.763] KUBERNETES_PORT_443_TCP=tcp://10.63.240.1:443 W1025 04:16:12.763] KUBERNETES_PORT_443_TCP_ADDR=10.63.240.1 W1025 04:16:12.764] KUBERNETES_PORT_443_TCP_PORT=443 W1025 04:16:12.764] KUBERNETES_PORT_443_TCP_PROTO=tcp W1025 04:16:12.764] KUBERNETES_SERVICE_HOST=10.63.240.1 W1025 04:16:12.764] KUBERNETES_SERVICE_PORT=443 W1025 04:16:12.764] KUBERNETES_SERVICE_PORT_HTTPS=443 W1025 04:16:12.764] KUBETEST_IN_DOCKER=true W1025 04:16:12.764] KUBETEST_MANUAL_DUMP=y W1025 04:16:12.764] KUBE_AWS_INSTANCE_PREFIX=bootstrap-e2e W1025 04:16:12.765] KUBE_GCE_INSTANCE_PREFIX=bootstrap-e2e W1025 04:16:12.765] LOG_DUMP_SCRIPT_PATH=/workspace/log-dump.sh W1025 04:16:12.765] NODE_NAME=6bfc4083-1678-11eb-b256-6ee25ea2e440 W1025 04:16:12.765] 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 04:16:12.765] PROW_JOB_ID=6bfc4083-1678-11eb-b256-6ee25ea2e440 W1025 04:16:12.766] PWD=/workspace W1025 04:16:12.766] SHLVL=2 W1025 04:16:12.766] SOURCE_DATE_EPOCH=1603464596 W1025 04:16:12.766] TERM=xterm W1025 04:16:12.766] USER=prow W1025 04:16:12.766] WORKSPACE=/workspace W1025 04:16:12.766] _=./test-infra/jenkins/bootstrap.py W1025 04:16:12.767] 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 04:16:13.176] 2020/10/25 04:16:13 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 04:16:13.178] 2020/10/25 04:16:13 main.go:329: Limiting testing to 2h0m0s W1025 04:16:13.179] 2020/10/25 04:16:13 process.go:153: Running: gcloud auth activate-service-account --key-file=/etc/service-account/service-account.json W1025 04:16:13.828] Activated service account credentials for: [pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com] W1025 04:16:13.943] 2020/10/25 04:16:13 process.go:155: Step 'gcloud auth activate-service-account --key-file=/etc/service-account/service-account.json' finished in 764.28427ms W1025 04:16:13.943] 2020/10/25 04:16:13 process.go:153: Running: gcloud compute images describe-from-family pipeline-1 --project ubuntu-os-gke-cloud-devel W1025 04:16:15.210] 2020/10/25 04:16:15 process.go:155: Step 'gcloud compute images describe-from-family pipeline-1 --project ubuntu-os-gke-cloud-devel' finished in 1.266662494s W1025 04:16:15.210] 2020/10/25 04:16:15 process.go:153: Running: gcloud config set project ubuntu-image-validation W1025 04:16:15.736] Updated property [core/project]. W1025 04:16:15.998] 2020/10/25 04:16:15 process.go:155: Step 'gcloud config set project ubuntu-image-validation' finished in 788.206212ms W1025 04:16:15.998] 2020/10/25 04:16:15 main.go:779: Checking existing of GCP ssh keys... W1025 04:16:15.999] 2020/10/25 04:16:15 main.go:789: Checking presence of public key in ubuntu-image-validation W1025 04:16:15.999] 2020/10/25 04:16:15 process.go:153: Running: gcloud compute --project=ubuntu-image-validation project-info describe W1025 04:16:17.210] 2020/10/25 04:16:17 process.go:155: Step 'gcloud compute --project=ubuntu-image-validation project-info describe' finished in 1.211744214s W1025 04:16:17.212] 2020/10/25 04:16:17 node.go:62: Noop - Node KubectlCommand() W1025 04:16:17.212] 2020/10/25 04:16:17 node.go:53: Noop - Node Down() W1025 04:16:17.213] 2020/10/25 04:16:17 node.go:34: Noop - Node Up() W1025 04:16:17.213] 2020/10/25 04:16:17 node.go:48: Noop - Node TestSetup() W1025 04:16:17.214] 2020/10/25 04:16:17 e2e.go:560: cwd : /go/src/k8s.io/kubernetes W1025 04:16:17.214] 2020/10/25 04:16:17 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 04:16:18.191] go: downloading sigs.k8s.io/yaml v1.1.0 W1025 04:16:18.192] go: downloading k8s.io/klog v1.0.0 W1025 04:16:18.193] go: downloading google.golang.org/api v0.6.1-0.20190607001116-5213b8090861 W1025 04:16:18.199] go: downloading golang.org/x/oauth2 v0.0.0-20190604053449-0f29369cfe45 W1025 04:16:18.255] go: downloading github.com/google/uuid v1.1.1 W1025 04:16:18.257] go: downloading github.com/gogo/protobuf v1.2.2-0.20190723190241-65acae22fc9d W1025 04:16:18.260] go: extracting sigs.k8s.io/yaml v1.1.0 W1025 04:16:18.266] go: extracting k8s.io/klog v1.0.0 W1025 04:16:18.354] go: extracting github.com/google/uuid v1.1.1 W1025 04:16:18.355] go: downloading k8s.io/kube-openapi v0.0.0-20200410145947-bcb3869e6f29 W1025 04:16:18.360] go: extracting golang.org/x/oauth2 v0.0.0-20190604053449-0f29369cfe45 W1025 04:16:18.456] go: downloading github.com/google/gofuzz v1.0.0 W1025 04:16:18.457] go: downloading gopkg.in/inf.v0 v0.9.1 W1025 04:16:18.463] go: downloading k8s.io/utils v0.0.0-20191114184206-e782cd3c129f W1025 04:16:18.465] go: downloading github.com/hashicorp/golang-lru v0.5.1 W1025 04:16:18.555] go: extracting github.com/google/gofuzz v1.0.0 W1025 04:16:18.556] go: downloading golang.org/x/crypto v0.0.0-20200220183623-bac4c82f6975 W1025 04:16:18.557] go: extracting gopkg.in/inf.v0 v0.9.1 W1025 04:16:18.559] go: downloading github.com/prometheus/client_golang v1.0.0 W1025 04:16:18.561] go: extracting github.com/hashicorp/golang-lru v0.5.1 W1025 04:16:18.653] go: downloading github.com/golang/protobuf v1.3.2 W1025 04:16:18.658] go: downloading cloud.google.com/go v0.38.0 W1025 04:16:18.658] go: extracting k8s.io/utils v0.0.0-20191114184206-e782cd3c129f W1025 04:16:18.760] go: extracting github.com/prometheus/client_golang v1.0.0 W1025 04:16:18.953] go: downloading golang.org/x/net v0.0.0-20191004110552-13f9640d40b9 W1025 04:16:18.954] go: downloading github.com/davecgh/go-spew v1.1.1 W1025 04:16:19.055] go: downloading github.com/json-iterator/go v1.1.8 W1025 04:16:19.068] go: extracting github.com/golang/protobuf v1.3.2 W1025 04:16:19.159] go: extracting github.com/davecgh/go-spew v1.1.1 W1025 04:16:19.253] go: extracting k8s.io/kube-openapi v0.0.0-20200410145947-bcb3869e6f29 W1025 04:16:19.354] go: extracting github.com/json-iterator/go v1.1.8 W1025 04:16:19.368] go: extracting golang.org/x/crypto v0.0.0-20200220183623-bac4c82f6975 W1025 04:16:19.563] go: downloading github.com/googleapis/gnostic v0.0.0-20170729233727-0c5108395e2d W1025 04:16:19.664] go: downloading github.com/modern-go/reflect2 v1.0.1 W1025 04:16:19.763] go: extracting github.com/modern-go/reflect2 v1.0.1 W1025 04:16:19.853] go: downloading github.com/prometheus/client_model v0.0.0-20190129233127-fd36f4220a90 W1025 04:16:19.860] go: extracting golang.org/x/net v0.0.0-20191004110552-13f9640d40b9 W1025 04:16:19.866] go: downloading gopkg.in/yaml.v2 v2.2.8 W1025 04:16:19.961] go: extracting github.com/prometheus/client_model v0.0.0-20190129233127-fd36f4220a90 W1025 04:16:20.053] go: extracting github.com/googleapis/gnostic v0.0.0-20170729233727-0c5108395e2d W1025 04:16:20.058] go: extracting gopkg.in/yaml.v2 v2.2.8 W1025 04:16:20.066] go: downloading github.com/spf13/pflag v1.0.5 W1025 04:16:20.156] go: downloading github.com/google/go-cmp v0.3.0 W1025 04:16:20.253] go: extracting github.com/spf13/pflag v1.0.5 W1025 04:16:20.264] go: extracting github.com/google/go-cmp v0.3.0 W1025 04:16:20.357] go: downloading github.com/prometheus/common v0.4.1 W1025 04:16:20.465] go: downloading github.com/golang/groupcache v0.0.0-20160516000752-02826c3e7903 W1025 04:16:20.467] go: downloading github.com/pkg/errors v0.8.1 W1025 04:16:20.553] go: downloading github.com/stretchr/testify v1.4.0 W1025 04:16:20.555] go: extracting github.com/pkg/errors v0.8.1 W1025 04:16:20.562] go: extracting github.com/gogo/protobuf v1.2.2-0.20190723190241-65acae22fc9d W1025 04:16:20.563] go: extracting github.com/golang/groupcache v0.0.0-20160516000752-02826c3e7903 W1025 04:16:20.563] go: extracting github.com/prometheus/common v0.4.1 W1025 04:16:20.656] go: downloading golang.org/x/sys v0.0.0-20190813064441-fde4db37ae7a W1025 04:16:20.657] go: downloading github.com/prometheus/procfs v0.0.2 W1025 04:16:20.663] go: extracting github.com/stretchr/testify v1.4.0 W1025 04:16:20.773] go: downloading github.com/matttproud/golang_protobuf_extensions v1.0.1 W1025 04:16:20.874] go: extracting cloud.google.com/go v0.38.0 W1025 04:16:20.953] go: extracting github.com/prometheus/procfs v0.0.2 W1025 04:16:20.956] go: downloading golang.org/x/time v0.0.0-20190308202827-9d24e82272b4 W1025 04:16:20.964] go: extracting github.com/matttproud/golang_protobuf_extensions v1.0.1 W1025 04:16:21.059] go: extracting golang.org/x/time v0.0.0-20190308202827-9d24e82272b4 W1025 04:16:21.061] go: downloading github.com/evanphx/json-patch v4.9.0+incompatible W1025 04:16:21.158] go: downloading github.com/modern-go/concurrent v0.0.0-20180306012644-bacd9c7ef1dd W1025 04:16:21.160] go: downloading github.com/blang/semver v3.5.0+incompatible W1025 04:16:21.163] go: extracting github.com/evanphx/json-patch v4.9.0+incompatible W1025 04:16:21.164] go: downloading golang.org/x/text v0.3.2 W1025 04:16:21.256] go: extracting github.com/modern-go/concurrent v0.0.0-20180306012644-bacd9c7ef1dd W1025 04:16:21.256] go: extracting github.com/blang/semver v3.5.0+incompatible W1025 04:16:21.258] go: downloading github.com/beorn7/perks v1.0.0 W1025 04:16:21.266] go: downloading github.com/docker/distribution v2.7.1+incompatible W1025 04:16:21.363] go: extracting github.com/beorn7/perks v1.0.0 W1025 04:16:21.753] go: extracting golang.org/x/sys v0.0.0-20190813064441-fde4db37ae7a W1025 04:16:21.759] go: extracting github.com/docker/distribution v2.7.1+incompatible W1025 04:16:22.456] go: downloading github.com/imdario/mergo v0.3.5 W1025 04:16:22.556] go: extracting github.com/imdario/mergo v0.3.5 W1025 04:16:22.560] go: downloading github.com/opencontainers/go-digest v1.0.0-rc1 W1025 04:16:22.659] go: extracting github.com/opencontainers/go-digest v1.0.0-rc1 W1025 04:16:22.660] go: downloading gopkg.in/square/go-jose.v2 v2.2.2 W1025 04:16:22.666] go: downloading github.com/pmezard/go-difflib v1.0.0 W1025 04:16:22.758] go: extracting github.com/pmezard/go-difflib v1.0.0 W1025 04:16:22.857] go: extracting gopkg.in/square/go-jose.v2 v2.2.2 W1025 04:16:23.397] go: extracting golang.org/x/text v0.3.2 W1025 04:16:23.988] go: extracting google.golang.org/api v0.6.1-0.20190607001116-5213b8090861 W1025 04:16:25.394] go: downloading google.golang.org/grpc v1.23.1 W1025 04:16:25.395] go: downloading go.opencensus.io v0.21.0 W1025 04:16:25.469] go: extracting go.opencensus.io v0.21.0 W1025 04:16:25.591] go: extracting google.golang.org/grpc v1.23.1 W1025 04:16:25.774] go: downloading google.golang.org/genproto v0.0.0-20190502173448-54afdca5d873 W1025 04:16:26.364] go: extracting google.golang.org/genproto v0.0.0-20190502173448-54afdca5d873 W1025 04:16:27.168] go: finding github.com/google/uuid v1.1.1 W1025 04:16:27.200] go: finding golang.org/x/oauth2 v0.0.0-20190604053449-0f29369cfe45 W1025 04:16:27.207] go: finding cloud.google.com/go v0.38.0 W1025 04:16:27.262] go: finding golang.org/x/net v0.0.0-20191004110552-13f9640d40b9 W1025 04:16:27.272] go: finding google.golang.org/api v0.6.1-0.20190607001116-5213b8090861 W1025 04:16:27.288] go: finding google.golang.org/grpc v1.23.1 W1025 04:16:27.308] go: finding github.com/golang/protobuf v1.3.2 W1025 04:16:27.331] go: finding google.golang.org/genproto v0.0.0-20190502173448-54afdca5d873 W1025 04:16:27.360] go: finding golang.org/x/sys v0.0.0-20190813064441-fde4db37ae7a W1025 04:16:27.372] go: finding golang.org/x/text v0.3.2 W1025 04:16:27.391] go: finding go.opencensus.io v0.21.0 W1025 04:16:27.400] go: finding github.com/hashicorp/golang-lru v0.5.1 W1025 04:16:27.426] go: finding k8s.io/klog v1.0.0 W1025 04:16:27.437] go: finding github.com/davecgh/go-spew v1.1.1 W1025 04:16:27.457] go: finding github.com/pkg/errors v0.8.1 W1025 04:16:27.464] go: finding github.com/stretchr/testify v1.4.0 W1025 04:16:27.470] go: finding github.com/pmezard/go-difflib v1.0.0 W1025 04:16:27.477] go: finding gopkg.in/yaml.v2 v2.2.8 W1025 04:16:27.488] go: finding github.com/gogo/protobuf v1.2.2-0.20190723190241-65acae22fc9d W1025 04:16:27.499] go: finding github.com/google/gofuzz v1.0.0 W1025 04:16:27.507] go: finding gopkg.in/inf.v0 v0.9.1 W1025 04:16:27.534] go: finding sigs.k8s.io/yaml v1.1.0 W1025 04:16:27.542] go: finding k8s.io/kube-openapi v0.0.0-20200410145947-bcb3869e6f29 W1025 04:16:27.548] go: finding github.com/googleapis/gnostic v0.0.0-20170729233727-0c5108395e2d W1025 04:16:27.558] go: finding github.com/evanphx/json-patch v4.9.0+incompatible W1025 04:16:27.569] go: finding github.com/json-iterator/go v1.1.8 W1025 04:16:27.575] go: finding github.com/modern-go/concurrent v0.0.0-20180306012644-bacd9c7ef1dd W1025 04:16:27.583] go: finding github.com/modern-go/reflect2 v1.0.1 W1025 04:16:27.601] go: finding github.com/blang/semver v3.5.0+incompatible W1025 04:16:27.609] go: finding github.com/prometheus/client_golang v1.0.0 W1025 04:16:27.616] go: finding github.com/beorn7/perks v1.0.0 W1025 04:16:27.622] go: finding github.com/prometheus/client_model v0.0.0-20190129233127-fd36f4220a90 W1025 04:16:27.628] go: finding github.com/prometheus/common v0.4.1 W1025 04:16:27.634] go: finding github.com/matttproud/golang_protobuf_extensions v1.0.1 W1025 04:16:27.645] go: finding github.com/prometheus/procfs v0.0.2 W1025 04:16:27.663] go: finding golang.org/x/crypto v0.0.0-20200220183623-bac4c82f6975 W1025 04:16:27.674] go: finding golang.org/x/time v0.0.0-20190308202827-9d24e82272b4 W1025 04:16:27.681] go: finding k8s.io/utils v0.0.0-20191114184206-e782cd3c129f W1025 04:16:27.689] go: finding github.com/imdario/mergo v0.3.5 W1025 04:16:27.697] go: finding github.com/spf13/pflag v1.0.5 W1025 04:16:27.793] go: finding github.com/google/go-cmp v0.3.0 W1025 04:16:27.920] go: finding github.com/golang/groupcache v0.0.0-20160516000752-02826c3e7903 W1025 04:16:27.958] go: finding github.com/docker/distribution v2.7.1+incompatible W1025 04:16:27.964] go: finding github.com/opencontainers/go-digest v1.0.0-rc1 W1025 04:16:27.978] go: finding gopkg.in/square/go-jose.v2 v2.2.2 I1025 04:20:00.938] Initializing e2e tests using image ubuntu-gke-1804-1-15-v20200824. I1025 04:20:00.957] make: Entering directory '/go/src/k8s.io/kubernetes' I1025 04:20:00.961] make[1]: Entering directory '/go/src/k8s.io/kubernetes' W1025 04:20:01.062] I1025 04:20:00.937957 4310 remote.go:40] Building archive... W1025 04:20:01.062] I1025 04:20:00.938571 4310 build.go:42] Building k8s binaries... W1025 04:20:01.402] I1025 04:20:01.401717 4310 run_remote.go:568] Creating instance {image:ubuntu-gke-1804-1-15-v20200824 imageDesc: project:ubuntu-os-gke-cloud-devel resources:{Accelerators:[]} metadata: machine: tests:[]} with service account "1050223417337-compute@developer.gserviceaccount.com" I1025 04:20:15.409] +++ [1025 04:20:15] Building go targets for linux/amd64: I1025 04:20:15.410] ./vendor/k8s.io/code-generator/cmd/deepcopy-gen I1025 04:20:33.947] +++ [1025 04:20:33] Building go targets for linux/amd64: I1025 04:20:33.947] ./vendor/k8s.io/code-generator/cmd/defaulter-gen I1025 04:20:46.657] +++ [1025 04:20:46] Building go targets for linux/amd64: I1025 04:20:46.657] ./vendor/k8s.io/code-generator/cmd/conversion-gen I1025 04:21:07.764] +++ [1025 04:21:07] Building go targets for linux/amd64: I1025 04:21:07.765] ./vendor/k8s.io/kube-openapi/cmd/openapi-gen I1025 04:21:33.716] +++ [1025 04:21:33] Building go targets for linux/amd64: I1025 04:21:33.716] ./vendor/github.com/go-bindata/go-bindata/go-bindata I1025 04:21:35.614] make[1]: Leaving directory '/go/src/k8s.io/kubernetes' I1025 04:21:36.081] +++ [1025 04:21:36] Building go targets for linux/amd64: I1025 04:21:36.081] cmd/kubelet I1025 04:21:36.081] test/e2e_node/e2e_node.test I1025 04:21:36.082] vendor/github.com/onsi/ginkgo/ginkgo I1025 04:21:36.082] cluster/gce/gci/mounter I1025 04:39:46.673] make: Leaving directory '/go/src/k8s.io/kubernetes' W1025 04:40:00.977] I1025 04:40:00.975611 4310 remote.go:70] Staging test binaries on "tmp-node-e2e-39987f18-ubuntu-gke-1804-1-15-v20200824" W1025 04:40:03.933] I1025 04:40:03.933013 4310 remote.go:97] Extracting tar on "tmp-node-e2e-39987f18-ubuntu-gke-1804-1-15-v20200824" W1025 04:40:07.708] I1025 04:40:07.708119 4310 remote.go:112] Running test on "tmp-node-e2e-39987f18-ubuntu-gke-1804-1-15-v20200824" W1025 04:40:07.710] I1025 04:40:07.709716 4310 utils.go:55] Install CNI on "tmp-node-e2e-39987f18-ubuntu-gke-1804-1-15-v20200824" W1025 04:40:09.603] I1025 04:40:09.602779 4310 utils.go:68] Adding CNI configuration on "tmp-node-e2e-39987f18-ubuntu-gke-1804-1-15-v20200824" W1025 04:40:10.325] I1025 04:40:10.325164 4310 utils.go:82] Configure iptables firewall rules on "tmp-node-e2e-39987f18-ubuntu-gke-1804-1-15-v20200824" W1025 04:40:12.434] I1025 04:40:12.434164 4310 utils.go:117] Killing any existing node processes on "tmp-node-e2e-39987f18-ubuntu-gke-1804-1-15-v20200824" W1025 04:40:13.844] I1025 04:40:13.844268 4310 node_e2e.go:147] Starting tests on "tmp-node-e2e-39987f18-ubuntu-gke-1804-1-15-v20200824" W1025 04:40:17.963] I1025 04:40:17.963245 4310 remote.go:197] Test failed unexpectedly. Attempting to retrieving system logs (only works for nodes with journald) W1025 04:40:18.663] I1025 04:40:18.663486 4310 remote.go:202] Got the system logs from journald; copying it back... W1025 04:40:19.607] I1025 04:40:19.607132 4310 remote.go:122] Copying test artifacts from "tmp-node-e2e-39987f18-ubuntu-gke-1804-1-15-v20200824" W1025 04:40:20.970] I1025 04:40:20.970634 4310 run_remote.go:744] Deleting instance "tmp-node-e2e-39987f18-ubuntu-gke-1804-1-15-v20200824" I1025 04:40:21.483] I1025 04:40:21.484] >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>> I1025 04:40:21.484] > START TEST > I1025 04:40:21.484] >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>> I1025 04:40:21.484] Start Test Suite on Host tmp-node-e2e-39987f18-ubuntu-gke-1804-1-15-v20200824 I1025 04:40:21.485] Running Suite: E2eNode Suite I1025 04:40:21.485] ============================ I1025 04:40:21.485] Random Seed: 1603600814 - Will randomize all specs I1025 04:40:21.485] Will run 312 specs I1025 04:40:21.485] I1025 04:40:21.485] Running in parallel across 8 nodes I1025 04:40:21.485] I1025 04:40:21.486] Oct 25 04:40:17.445: INFO: Parsing ds from https://raw.githubusercontent.com/kubernetes/kubernetes/master/cluster/addons/device-plugins/nvidia-gpu/daemonset.yaml I1025 04:40:21.486] STEP: Enabling support for Kubelet Plugins Watcher I1025 04:40:21.486] W1025 04:40:17.617042 2969 test_context.go:410] Unable to find in-cluster config, using default host : http://127.0.0.1:8080 I1025 04:40:21.486] I1025 04:40:17.621885 2969 test_context.go:419] Tolerating taints "node-role.kubernetes.io/master" when considering if nodes are ready I1025 04:40:21.486] Oct 25 04:40:17.621: INFO: The --provider flag is not set. Continuing as if --provider=skeleton had been used. I1025 04:40:21.486] Validating os... I1025 04:40:21.486] OS: Linux I1025 04:40:21.487] Validating kernel... I1025 04:40:21.487] KERNEL_VERSION: 5.0.0-1046-gke I1025 04:40:21.487] CONFIG_BOOTPARAM_HARDLOCKUP_PANIC: enabled I1025 04:40:21.487] CONFIG_BOOTPARAM_SOFTLOCKUP_PANIC: enabled I1025 04:40:21.487] CONFIG_PANIC_ON_OOPS: enabled I1025 04:40:21.487] CONFIG_PVPANIC: enabled (as module) I1025 04:40:21.487] CONFIG_DMIID: enabled I1025 04:40:21.487] CONFIG_ACPI_BUTTON: enabled I1025 04:40:21.488] CONFIG_INET: enabled I1025 04:40:21.488] CONFIG_VXLAN: enabled (as module) I1025 04:40:21.488] CONFIG_IP_SET: enabled (as module) I1025 04:40:21.488] CONFIG_IP_SET_HASH_IP: enabled (as module) I1025 04:40:21.488] CONFIG_IPVLAN: enabled (as module) I1025 04:40:21.488] CONFIG_IPV6: enabled I1025 04:40:21.488] CONFIG_IP6_NF_IPTABLES: enabled (as module) I1025 04:40:21.488] CONFIG_IP_NF_TARGET_REDIRECT: enabled (as module) I1025 04:40:21.489] CONFIG_NETFILTER_XT_MATCH_COMMENT: enabled (as module) I1025 04:40:21.489] CONFIG_PACKET_DIAG: enabled (as module) I1025 04:40:21.489] CONFIG_UNIX_DIAG: enabled (as module) I1025 04:40:21.489] CONFIG_INET_DIAG: enabled (as module) I1025 04:40:21.489] CONFIG_INET_TCP_DIAG: enabled (as module) I1025 04:40:21.489] CONFIG_INET_UDP_DIAG: enabled (as module) I1025 04:40:21.489] CONFIG_NETLINK_DIAG: enabled (as module) I1025 04:40:21.490] CONFIG_EXT4_FS: enabled I1025 04:40:21.490] CONFIG_DEBUG_FS: enabled I1025 04:40:21.490] CONFIG_PROC_FS: enabled I1025 04:40:21.490] CONFIG_XFS_FS: enabled (as module) I1025 04:40:21.490] CONFIG_SCSI_PROC_FS: enabled I1025 04:40:21.490] CONFIG_OVERLAY_FS: enabled (as module) I1025 04:40:21.490] CONFIG_NFS_FS: enabled (as module) I1025 04:40:21.491] CONFIG_AUTOFS4_FS: enabled (as module) I1025 04:40:21.491] CONFIG_NFS_FSCACHE: enabled I1025 04:40:21.491] CONFIG_FSCACHE: enabled (as module) I1025 04:40:21.491] CONFIG_CACHEFILES: enabled (as module) I1025 04:40:21.491] CONFIG_FUSE_FS: enabled I1025 04:40:21.491] CONFIG_BCACHE: enabled (as module) I1025 04:40:21.491] CONFIG_NAMESPACES: enabled I1025 04:40:21.491] CONFIG_IPC_NS: enabled I1025 04:40:21.492] CONFIG_NET_NS: enabled I1025 04:40:21.492] CONFIG_PID_NS: enabled I1025 04:40:21.492] CONFIG_UTS_NS: enabled I1025 04:40:21.492] CONFIG_CGROUPS: enabled I1025 04:40:21.492] CONFIG_CGROUP_CPUACCT: enabled I1025 04:40:21.492] CONFIG_CGROUP_DEVICE: enabled I1025 04:40:21.492] CONFIG_CGROUP_SCHED: enabled I1025 04:40:21.492] CONFIG_CPUSETS: enabled I1025 04:40:21.493] CONFIG_MEMCG: enabled I1025 04:40:21.493] CONFIG_QUOTA: enabled I1025 04:40:21.493] CONFIG_SECCOMP: enabled I1025 04:40:21.493] CONFIG_SECURITY_APPARMOR: enabled I1025 04:40:21.494] CONFIG_CC_STACKPROTECTOR_STRONG: not set - Add the stack buffer overflow protections. I1025 04:40:21.494] CONFIG_STRICT_DEVMEM: enabled I1025 04:40:21.494] CONFIG_IMA: enabled I1025 04:40:21.494] CONFIG_AUDIT: enabled I1025 04:40:21.494] CONFIG_AUDITSYSCALL: enabled I1025 04:40:21.494] CONFIG_MODULES: enabled I1025 04:40:21.494] CONFIG_PRINTK: enabled I1025 04:40:21.495] CONFIG_MMU: enabled I1025 04:40:21.495] Validating cgroups... I1025 04:40:21.495] Validating package... I1025 04:40:21.495] apparmor (>=2.10.1): 2.12 I1025 04:40:21.495] autofs (>=5.0.7): 5.1.2 I1025 04:40:21.495] bash (>=4.3): 4.4.18 I1025 04:40:21.495] bridge-utils (>=1.5): 1.5 I1025 04:40:21.496] cloud-init (>=0.7.6): 20.2 I1025 04:40:21.496] coreutils (>=8.24): 8.28 I1025 04:40:21.496] dbus (>=1.6.8): 1.12.2 I1025 04:40:21.496] e2fsprogs (>=1.4.3): 1.44.1 I1025 04:40:21.496] ebtables (>=2.0.10): 2.0.10.4 I1025 04:40:21.496] ethtool (>=3.18): 4.15 I1025 04:40:21.496] iproute2 (>=4.2.0): 4.15.0 I1025 04:40:21.497] less (>=481): 487 I1025 04:40:21.497] netcat-openbsd (>=1.10): 1.187 I1025 04:40:21.497] python (>=2.7.10): 2.7.15~rc1 I1025 04:40:21.497] pv (>=1.3.4): 1.6.6 I1025 04:40:21.497] sudo (>=1.8.12): 1.8.21p2 I1025 04:40:21.497] systemd (>=225): 237 I1025 04:40:21.497] tar (>=1.28): 1.29b I1025 04:40:21.498] util-linux (>=2.27.1): 2.31.1 I1025 04:40:21.498] gce-compute-image-packages (>=20170227): 20190801 I1025 04:40:21.498] auditd (>=2.4.5): 2.8.2 I1025 04:40:21.498] grub-common (>=2.2): 2.02 I1025 04:40:21.498] wget (>=1.17.1): 1.19.4 I1025 04:40:21.498] Validating docker... I1025 04:40:21.499] F1025 04:40:17.865600 2969 e2e_node_suite_test.go:149] system validation failed: [unexpected kernel config: CONFIG_CC_STACKPROTECTOR_STRONG] I1025 04:40:21.499] I1025 04:40:21.499] I1025 04:40:21.499] Failure [1.534 seconds] I1025 04:40:21.499] [BeforeSuite] BeforeSuite  I1025 04:40:21.499] _output/local/go/src/k8s.io/kubernetes/test/e2e_node/e2e_node_suite_test.go:172 I1025 04:40:21.499] I1025 04:40:21.499] system validation I1025 04:40:21.500] Expected success, but got an error: I1025 04:40:21.500] <*errors.errorString | 0xc0007847a0>: { I1025 04:40:21.500] s: "system validation failed: exit status 1", I1025 04:40:21.500] } I1025 04:40:21.500] system validation failed: exit status 1 I1025 04:40:21.500] I1025 04:40:21.501] _output/local/go/src/k8s.io/kubernetes/test/e2e_node/e2e_node_suite_test.go:174 I1025 04:40:21.501] ------------------------------ I1025 04:40:21.501] Failure [1.166 seconds] I1025 04:40:21.501] [BeforeSuite] BeforeSuite  I1025 04:40:21.501] _output/local/go/src/k8s.io/kubernetes/test/e2e_node/e2e_node_suite_test.go:172 I1025 04:40:21.501] I1025 04:40:21.501] BeforeSuite on Node 1 failed I1025 04:40:21.501] I1025 04:40:21.502] _output/local/go/src/k8s.io/kubernetes/test/e2e_node/e2e_node_suite_test.go:172 I1025 04:40:21.502] ------------------------------ I1025 04:40:21.502] Failure [1.166 seconds] I1025 04:40:21.502] [BeforeSuite] BeforeSuite  I1025 04:40:21.502] _output/local/go/src/k8s.io/kubernetes/test/e2e_node/e2e_node_suite_test.go:172 I1025 04:40:21.502] I1025 04:40:21.502] BeforeSuite on Node 1 failed I1025 04:40:21.502] I1025 04:40:21.503] _output/local/go/src/k8s.io/kubernetes/test/e2e_node/e2e_node_suite_test.go:172 I1025 04:40:21.503] ------------------------------ I1025 04:40:21.503] Failure [1.162 seconds] I1025 04:40:21.503] [BeforeSuite] BeforeSuite  I1025 04:40:21.503] _output/local/go/src/k8s.io/kubernetes/test/e2e_node/e2e_node_suite_test.go:172 I1025 04:40:21.503] I1025 04:40:21.503] BeforeSuite on Node 1 failed I1025 04:40:21.503] I1025 04:40:21.504] _output/local/go/src/k8s.io/kubernetes/test/e2e_node/e2e_node_suite_test.go:172 I1025 04:40:21.504] ------------------------------ I1025 04:40:21.504] Failure [1.165 seconds] I1025 04:40:21.504] [BeforeSuite] BeforeSuite  I1025 04:40:21.504] _output/local/go/src/k8s.io/kubernetes/test/e2e_node/e2e_node_suite_test.go:172 I1025 04:40:21.504] I1025 04:40:21.504] BeforeSuite on Node 1 failed I1025 04:40:21.504] I1025 04:40:21.505] _output/local/go/src/k8s.io/kubernetes/test/e2e_node/e2e_node_suite_test.go:172 I1025 04:40:21.505] ------------------------------ I1025 04:40:21.505] Failure [1.166 seconds] I1025 04:40:21.505] [BeforeSuite] BeforeSuite  I1025 04:40:21.505] _output/local/go/src/k8s.io/kubernetes/test/e2e_node/e2e_node_suite_test.go:172 I1025 04:40:21.505] I1025 04:40:21.505] BeforeSuite on Node 1 failed I1025 04:40:21.506] I1025 04:40:21.506] _output/local/go/src/k8s.io/kubernetes/test/e2e_node/e2e_node_suite_test.go:172 I1025 04:40:21.506] ------------------------------ I1025 04:40:21.506] Failure [1.531 seconds] I1025 04:40:21.506] [BeforeSuite] BeforeSuite  I1025 04:40:21.506] _output/local/go/src/k8s.io/kubernetes/test/e2e_node/e2e_node_suite_test.go:172 I1025 04:40:21.506] I1025 04:40:21.507] BeforeSuite on Node 1 failed I1025 04:40:21.507] I1025 04:40:21.507] _output/local/go/src/k8s.io/kubernetes/test/e2e_node/e2e_node_suite_test.go:172 I1025 04:40:21.507] ------------------------------ I1025 04:40:21.507] Failure [1.214 seconds] I1025 04:40:21.507] [BeforeSuite] BeforeSuite  I1025 04:40:21.507] _output/local/go/src/k8s.io/kubernetes/test/e2e_node/e2e_node_suite_test.go:172 I1025 04:40:21.508] I1025 04:40:21.508] BeforeSuite on Node 1 failed I1025 04:40:21.508] I1025 04:40:21.508] _output/local/go/src/k8s.io/kubernetes/test/e2e_node/e2e_node_suite_test.go:172 I1025 04:40:21.508] ------------------------------ I1025 04:40:21.508] I1025 04:40:17.921634 2853 e2e_node_suite_test.go:221] Tests Finished I1025 04:40:21.508] I1025 04:40:21.508] I1025 04:40:21.508] Ran 2496 of 0 Specs in 1.589 seconds I1025 04:40:21.509] FAIL! -- 0 Passed | 2496 Failed | 0 Pending | 0 Skipped I1025 04:40:21.509] I1025 04:40:21.509] I1025 04:40:21.509] Ginkgo ran 1 suite in 3.428396437s I1025 04:40:21.509] Test Suite Failed I1025 04:40:21.509] I1025 04:40:21.509] Failure Finished Test Suite on Host tmp-node-e2e-39987f18-ubuntu-gke-1804-1-15-v20200824 I1025 04:40:21.510] [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.185.249.111 -- sudo sh -c 'cd /tmp/node-e2e-20201025T044000 && 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-39987f18-ubuntu-gke-1804-1-15-v20200824 --report-dir=/tmp/node-e2e-20201025T044000/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.185.249.111:/tmp/node-e2e-20201025T044000/results/*.log /workspace/_artifacts/tmp-node-e2e-39987f18-ubuntu-gke-1804-1-15-v20200824] failed with error: exit status 1] I1025 04:40:21.511] <<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<< I1025 04:40:21.511] < FINISH TEST < I1025 04:40:21.511] <<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<< I1025 04:40:21.511] I1025 04:40:21.511] Failure: 1 errors encountered. W1025 04:40:21.612] exit status 1 W1025 04:40:21.706] 2020/10/25 04:40:21 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 24m4.483841301s W1025 04:40:21.713] 2020/10/25 04:40:21 e2e.go:544: Dumping logs locally to: /workspace/_artifacts W1025 04:40:21.717] 2020/10/25 04:40:21 process.go:153: Running: ./cluster/log-dump/log-dump.sh /workspace/_artifacts W1025 04:40:21.812] Trying to find master named 'bootstrap-e2e-master' W1025 04:40:21.812] Looking for address 'bootstrap-e2e-master-ip' I1025 04:40:21.912] Checking for custom logdump instances, if any I1025 04:40:21.913] Sourcing kube-util.sh I1025 04:40:21.913] Detecting project I1025 04:40:21.913] Project: ubuntu-image-validation I1025 04:40:21.913] Network Project: ubuntu-image-validation I1025 04:40:21.913] Zone: us-west1-b I1025 04:40:21.913] Dumping logs from master locally to '/workspace/_artifacts' W1025 04:40:23.437] ERROR: (gcloud.compute.addresses.describe) Could not fetch resource: W1025 04:40:23.438] - The resource 'projects/ubuntu-image-validation/regions/us-west1/addresses/bootstrap-e2e-master-ip' was not found W1025 04:40:23.438] W1025 04:40:23.636] Could not detect Kubernetes master node. Make sure you've launched a cluster with 'kube-up.sh' I1025 04:40:23.736] Master not detected. Is the cluster up? I1025 04:40:23.737] Dumping logs from nodes locally to '/workspace/_artifacts' I1025 04:40:23.737] Detecting nodes in the cluster I1025 04:40:26.003] No nodes found! W1025 04:40:28.468] INSTANCE_GROUPS= W1025 04:40:28.469] NODE_NAMES= W1025 04:40:28.469] 2020/10/25 04:40:28 process.go:155: Step './cluster/log-dump/log-dump.sh /workspace/_artifacts' finished in 6.752678009s W1025 04:40:28.473] 2020/10/25 04:40:28 node.go:53: Noop - Node Down() W1025 04:40:28.492] 2020/10/25 04:40:28 process.go:96: Saved XML output to /workspace/_artifacts/junit_runner.xml. W1025 04:40:28.494] 2020/10/25 04:40:28 process.go:153: Running: bash -c . hack/lib/version.sh && KUBE_ROOT=. kube::version::get_version_vars && echo "${KUBE_GIT_VERSION-}" W1025 04:40:30.078] 2020/10/25 04:40:30 process.go:155: Step 'bash -c . hack/lib/version.sh && KUBE_ROOT=. kube::version::get_version_vars && echo "${KUBE_GIT_VERSION-}"' finished in 1.584560919s W1025 04:40:30.086] 2020/10/25 04:40:30 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 04:40:30.092] Traceback (most recent call last): W1025 04:40:30.093] File "/workspace/./test-infra/jenkins/../scenarios/kubernetes_e2e.py", line 720, in W1025 04:40:30.094] main(parse_args()) W1025 04:40:30.095] File "/workspace/./test-infra/jenkins/../scenarios/kubernetes_e2e.py", line 570, in main W1025 04:40:30.095] mode.start(runner_args) W1025 04:40:30.095] File "/workspace/./test-infra/jenkins/../scenarios/kubernetes_e2e.py", line 228, in start W1025 04:40:30.095] check_env(env, self.command, *args) W1025 04:40:30.096] File "/workspace/./test-infra/jenkins/../scenarios/kubernetes_e2e.py", line 111, in check_env W1025 04:40:30.096] subprocess.check_call(cmd, env=env) W1025 04:40:30.096] File "/usr/lib/python2.7/subprocess.py", line 190, in check_call W1025 04:40:30.096] raise CalledProcessError(retcode, cmd) W1025 04:40:30.097] 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 04:40:30.113] Command failed I1025 04:40:30.114] process 316 exited with code 1 after 24.3m E1025 04:40:30.115] FAIL: ci-kubernetes-e2enode-ubuntu1-k8sstable2-gkespec I1025 04:40:30.116] Call: gcloud auth activate-service-account --key-file=/etc/service-account/service-account.json W1025 04:40:30.777] Activated service account credentials for: [pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com] I1025 04:40:30.898] process 39108 exited with code 0 after 0.0m I1025 04:40:30.898] Call: gcloud config get-value account I1025 04:40:31.540] process 39121 exited with code 0 after 0.0m I1025 04:40:31.540] Will upload results to gs://kubernetes-jenkins/logs using pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com I1025 04:40:31.541] Upload result and artifacts... I1025 04:40:31.541] Gubernator results at https://gubernator.k8s.io/build/kubernetes-jenkins/logs/ci-kubernetes-e2enode-ubuntu1-k8sstable2-gkespec/1320216861387788288 I1025 04:40:31.541] Call: gsutil ls gs://kubernetes-jenkins/logs/ci-kubernetes-e2enode-ubuntu1-k8sstable2-gkespec/1320216861387788288/artifacts W1025 04:40:32.848] CommandException: One or more URLs matched no objects. E1025 04:40:33.066] Command failed I1025 04:40:33.066] process 39134 exited with code 1 after 0.0m W1025 04:40:33.066] Remote dir gs://kubernetes-jenkins/logs/ci-kubernetes-e2enode-ubuntu1-k8sstable2-gkespec/1320216861387788288/artifacts not exist yet I1025 04:40:33.066] 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/1320216861387788288/artifacts I1025 04:40:35.594] process 39277 exited with code 0 after 0.0m I1025 04:40:35.596] Call: git rev-parse HEAD I1025 04:40:35.600] process 39808 exited with code 0 after 0.0m I1025 04:40:35.601] Call: git rev-parse HEAD I1025 04:40:35.608] process 39809 exited with code 0 after 0.0m I1025 04:40:35.608] Call: gsutil stat gs://kubernetes-jenkins/logs/ci-kubernetes-e2enode-ubuntu1-k8sstable2-gkespec/jobResultsCache.json I1025 04:40:36.921] process 39810 exited with code 0 after 0.0m I1025 04:40:36.922] Call: gsutil -q cat 'gs://kubernetes-jenkins/logs/ci-kubernetes-e2enode-ubuntu1-k8sstable2-gkespec/jobResultsCache.json#1603593761187283' I1025 04:40:38.392] process 39953 exited with code 0 after 0.0m I1025 04:40:38.397] Call: gsutil -q -h Content-Type:application/json -h x-goog-if-generation-match:1603593761187283 cp /tmp/gsutil_aY1XLd gs://kubernetes-jenkins/logs/ci-kubernetes-e2enode-ubuntu1-k8sstable2-gkespec/jobResultsCache.json I1025 04:40:39.994] process 40098 exited with code 0 after 0.0m I1025 04:40:39.996] Call: gsutil -q -h Content-Type:application/json cp /tmp/gsutil_TEKvxJ gs://kubernetes-jenkins/logs/ci-kubernetes-e2enode-ubuntu1-k8sstable2-gkespec/1320216861387788288/finished.json I1025 04:40:41.553] process 40277 exited with code 0 after 0.0m I1025 04:40:41.554] Call: gsutil -q -h Content-Type:text/plain -h 'Cache-Control:private, max-age=0, no-transform' cp /tmp/gsutil_q45s7p gs://kubernetes-jenkins/logs/ci-kubernetes-e2enode-ubuntu1-k8sstable2-gkespec/latest-build.txt I1025 04:40:43.224] process 40456 exited with code 0 after 0.0m