This job view page is being replaced by Spyglass soon. Check out the new job view.
PRjustaugustus: Update CNI to v0.8.6
ResultFAILURE
Tests 1 failed / 7 succeeded
Started2020-05-22 22:25
Elapsed20m20s
Revision
Builder0388e6a6-9c7b-11ea-987e-9ef8030a972f
Refs master:9f5d9a9b
91370:b692502a
infra-commit5ebaf9c52
job-versionv1.19.0-beta.0.135+3c50c20a46d07f
repok8s.io/kubernetes
repo-commit3c50c20a46d07fd13af8cfdeaf2d6f16ad12b49c
repos{u'k8s.io/kubernetes': u'master:9f5d9a9befb212eb9bd16246267df9266491785e,91370:b692502a9d55105ca412eb4f619b74b41fa01225', u'k8s.io/release': u'master'}
revisionv1.19.0-beta.0.135+3c50c20a46d07f

Test Failures


Up 7m5s

error during ./hack/e2e-internal/e2e-up.sh: exit status 2
				from junit_runner.xml

Filter through log files | View test history on testgrid


Show 7 Passed Tests

Error lines from build-log.txt

... skipping 201 lines ...
W0522 22:26:43.424] Analyzing: target //build/release-tars:release-tars (3260 packages loaded, 30159 targets configured)
W0522 22:26:45.536] Analyzing: target //build/release-tars:release-tars (3267 packages loaded, 35321 targets configured)
W0522 22:26:48.478] Analyzing: target //build/release-tars:release-tars (3268 packages loaded, 35350 targets configured)
W0522 22:26:52.809] Analyzing: target //build/release-tars:release-tars (3268 packages loaded, 35350 targets configured)
W0522 22:26:57.534] Analyzing: target //build/release-tars:release-tars (3269 packages loaded, 35469 targets configured)
W0522 22:27:01.696] Analyzing: target //build/release-tars:release-tars (3270 packages loaded, 35469 targets configured)
W0522 22:27:04.872] DEBUG: /bazel-scratch/.cache/bazel/_bazel_prow/48d5366022b4e3197674c8d6e2bee219/external/bazel_gazelle/internal/go_repository.bzl:184:13: org_golang_x_tools: gazelle: /bazel-scratch/.cache/bazel/_bazel_prow/48d5366022b4e3197674c8d6e2bee219/external/org_golang_x_tools/cmd/fiximports/testdata/src/old.com/bad/bad.go: error reading go file: /bazel-scratch/.cache/bazel/_bazel_prow/48d5366022b4e3197674c8d6e2bee219/external/org_golang_x_tools/cmd/fiximports/testdata/src/old.com/bad/bad.go:2:43: expected 'package', found 'EOF'
W0522 22:27:04.872] gazelle: found packages escapeinfo (escapeinfo.go) and issue30628 (issue30628.go) in /bazel-scratch/.cache/bazel/_bazel_prow/48d5366022b4e3197674c8d6e2bee219/external/org_golang_x_tools/go/internal/gccgoimporter/testdata
W0522 22:27:04.873] gazelle: found packages p (issue15920.go) and issue25301 (issue25301.go) in /bazel-scratch/.cache/bazel/_bazel_prow/48d5366022b4e3197674c8d6e2bee219/external/org_golang_x_tools/go/internal/gcimporter/testdata
W0522 22:27:04.873] gazelle: /bazel-scratch/.cache/bazel/_bazel_prow/48d5366022b4e3197674c8d6e2bee219/external/org_golang_x_tools/go/loader/testdata/badpkgdecl.go: error reading go file: /bazel-scratch/.cache/bazel/_bazel_prow/48d5366022b4e3197674c8d6e2bee219/external/org_golang_x_tools/go/loader/testdata/badpkgdecl.go:1:34: expected 'package', found 'EOF'
W0522 22:27:04.874] gazelle: /bazel-scratch/.cache/bazel/_bazel_prow/48d5366022b4e3197674c8d6e2bee219/external/org_golang_x_tools/go/packages/packagestest/testdata/groups/two/modules/example.com/extra/geez/help.go: error reading go file: /bazel-scratch/.cache/bazel/_bazel_prow/48d5366022b4e3197674c8d6e2bee219/external/org_golang_x_tools/go/packages/packagestest/testdata/groups/two/modules/example.com/extra/geez/help.go:1:16: expected ';', found '.'
W0522 22:27:04.874] gazelle: /bazel-scratch/.cache/bazel/_bazel_prow/48d5366022b4e3197674c8d6e2bee219/external/org_golang_x_tools/go/packages/packagestest/testdata/groups/two/modules/example.com/extra/v2/geez/help.go: error reading go file: /bazel-scratch/.cache/bazel/_bazel_prow/48d5366022b4e3197674c8d6e2bee219/external/org_golang_x_tools/go/packages/packagestest/testdata/groups/two/modules/example.com/extra/v2/geez/help.go:1:16: expected ';', found '.'
W0522 22:27:04.875] gazelle: /bazel-scratch/.cache/bazel/_bazel_prow/48d5366022b4e3197674c8d6e2bee219/external/org_golang_x_tools/go/packages/packagestest/testdata/groups/two/modules/example.com/extra/v2/me.go: error reading go file: /bazel-scratch/.cache/bazel/_bazel_prow/48d5366022b4e3197674c8d6e2bee219/external/org_golang_x_tools/go/packages/packagestest/testdata/groups/two/modules/example.com/extra/v2/me.go:1:16: expected ';', found '.'
W0522 22:27:04.875] gazelle: /bazel-scratch/.cache/bazel/_bazel_prow/48d5366022b4e3197674c8d6e2bee219/external/org_golang_x_tools/go/packages/packagestest/testdata/groups/two/modules/example.com/extra/yo.go: error reading go file: /bazel-scratch/.cache/bazel/_bazel_prow/48d5366022b4e3197674c8d6e2bee219/external/org_golang_x_tools/go/packages/packagestest/testdata/groups/two/modules/example.com/extra/yo.go:1:16: expected ';', found '.'
W0522 22:27:04.876] gazelle: /bazel-scratch/.cache/bazel/_bazel_prow/48d5366022b4e3197674c8d6e2bee219/external/org_golang_x_tools/go/packages/packagestest/testdata/groups/two/modules/example.com/tempmod/main.go: error reading go file: /bazel-scratch/.cache/bazel/_bazel_prow/48d5366022b4e3197674c8d6e2bee219/external/org_golang_x_tools/go/packages/packagestest/testdata/groups/two/modules/example.com/tempmod/main.go:1:16: expected ';', found '.'
W0522 22:27:04.877] gazelle: /bazel-scratch/.cache/bazel/_bazel_prow/48d5366022b4e3197674c8d6e2bee219/external/org_golang_x_tools/go/packages/packagestest/testdata/groups/two/modules/example.com/what@v1.0.0/main.go: error reading go file: /bazel-scratch/.cache/bazel/_bazel_prow/48d5366022b4e3197674c8d6e2bee219/external/org_golang_x_tools/go/packages/packagestest/testdata/groups/two/modules/example.com/what@v1.0.0/main.go:1:16: expected ';', found '.'
W0522 22:27:04.877] gazelle: /bazel-scratch/.cache/bazel/_bazel_prow/48d5366022b4e3197674c8d6e2bee219/external/org_golang_x_tools/go/packages/packagestest/testdata/groups/two/modules/example.com/what@v1.1.0/main.go: error reading go file: /bazel-scratch/.cache/bazel/_bazel_prow/48d5366022b4e3197674c8d6e2bee219/external/org_golang_x_tools/go/packages/packagestest/testdata/groups/two/modules/example.com/what@v1.1.0/main.go:1:16: expected ';', found '.'
W0522 22:27:04.878] gazelle: finding module path for import domain.name/importdecl: exit status 1: can't load package: package domain.name/importdecl: cannot find module providing package domain.name/importdecl
W0522 22:27:04.878] gazelle: finding module path for import old.com/one: exit status 1: can't load package: package old.com/one: cannot find module providing package old.com/one
W0522 22:27:04.878] gazelle: finding module path for import titanic.biz/bar: exit status 1: can't load package: package titanic.biz/bar: cannot find module providing package titanic.biz/bar
W0522 22:27:04.879] gazelle: finding module path for import titanic.biz/foo: exit status 1: can't load package: package titanic.biz/foo: cannot find module providing package titanic.biz/foo
W0522 22:27:04.879] gazelle: finding module path for import fruit.io/pear: exit status 1: can't load package: package fruit.io/pear: cannot find module providing package fruit.io/pear
W0522 22:27:04.879] gazelle: finding module path for import fruit.io/banana: exit status 1: can't load package: package fruit.io/banana: cannot find module providing package fruit.io/banana
... skipping 94 lines ...
W0522 22:28:42.756] INFO: Build completed successfully, 8048 total actions
W0522 22:28:42.788] $TEST_TMPDIR defined: output root default is '/bazel-scratch/.cache/bazel' and max_idle_secs default is '15'.
W0522 22:28:42.792] $TEST_TMPDIR defined: output root default is '/bazel-scratch/.cache/bazel' and max_idle_secs default is '15'.
I0522 22:28:43.341] make: Leaving directory '/go/src/k8s.io/kubernetes'
W0522 22:28:43.441] 2020/05/22 22:28:43 process.go:155: Step 'make -C /go/src/k8s.io/kubernetes bazel-release' finished in 2m17.709630809s
W0522 22:28:43.442] 2020/05/22 22:28:43 util.go:265: Flushing memory.
W0522 22:29:12.040] 2020/05/22 22:29:12 util.go:275: flushMem error (page cache): exit status 1
W0522 22:29:12.040] 2020/05/22 22:29:12 process.go:153: Running: /go/src/k8s.io/release/push-build.sh --nomock --verbose --noupdatelatest --bucket=kubernetes-release-pull --ci --gcs-suffix=/pull-kubernetes-e2e-gce --allow-dup
I0522 22:29:12.141] push-build.sh: BEGIN main on 0388e6a6-9c7b-11ea-987e-9ef8030a972f Fri May 22 22:29:12 UTC 2020
I0522 22:29:12.141] 
I0522 22:29:12.141] 
I0522 22:29:12.141] push-build.sh is running a *REAL* push!!
I0522 22:29:12.142] 
... skipping 744 lines ...
W0522 22:34:00.685] Trying to find master named 'e2e-87af5414f2-674b9-master'
W0522 22:34:00.685] Looking for address 'e2e-87af5414f2-674b9-master-ip'
W0522 22:34:01.726] Using master: e2e-87af5414f2-674b9-master (external IP: 104.198.15.145; internal IP: (not set))
I0522 22:34:01.826] Waiting up to 300 seconds for cluster initialization.
I0522 22:34:01.827] 
I0522 22:34:01.827]   This will continually check to see if the API for kubernetes is reachable.
I0522 22:34:01.827]   This may time out if there was some uncaught error during start up.
I0522 22:34:01.828] 
I0522 22:39:05.389] ..........................................Checking for custom logdump instances, if any
I0522 22:39:05.395] Sourcing kube-util.sh
I0522 22:39:05.451] Detecting project
I0522 22:39:05.451] Project: gce-gci-upg-lat-1-4-ctl-skew
I0522 22:39:05.452] Network Project: gce-gci-upg-lat-1-4-ctl-skew
I0522 22:39:05.452] Zone: us-west1-b
I0522 22:39:05.452] Dumping logs from master locally to '/workspace/_artifacts'
W0522 22:39:05.552] Cluster failed to initialize within 300 seconds.
W0522 22:39:05.553] Last output from querying API server follows:
W0522 22:39:05.553] -----------------------------------------------------
W0522 22:39:05.553] * Expire in 0 ms for 6 (transfer 0x560666bf9f50)
W0522 22:39:05.553] * Expire in 5000 ms for 8 (transfer 0x560666bf9f50)
W0522 22:39:05.553] *   Trying 104.198.15.145...
W0522 22:39:05.553] * TCP_NODELAY set
... skipping 22 lines ...
W0522 22:39:44.089] scp: /var/log/cluster-autoscaler.log*: No such file or directory
W0522 22:39:44.089] scp: /var/log/kube-addon-manager.log*: No such file or directory
W0522 22:39:44.089] scp: /var/log/konnectivity-server.log*: No such file or directory
W0522 22:39:44.089] scp: /var/log/fluentd.log*: No such file or directory
W0522 22:39:44.089] scp: /var/log/kubelet.cov*: No such file or directory
W0522 22:39:44.090] scp: /var/log/startupscript.log*: No such file or directory
W0522 22:39:44.093] ERROR: (gcloud.compute.scp) [/usr/bin/scp] exited with return code [1].
I0522 22:39:44.193] Dumping logs from nodes locally to '/workspace/_artifacts'
I0522 22:39:44.194] Detecting nodes in the cluster
I0522 22:40:23.644] Changing logfiles to be world-readable for download
I0522 22:40:23.768] Changing logfiles to be world-readable for download
I0522 22:40:23.880] Changing logfiles to be world-readable for download
I0522 22:40:27.146] Copying 'kube-proxy.log fluentd.log node-problem-detector.log kubelet.cov  startupscript.log' from e2e-87af5414f2-674b9-minion-group-x95v
... skipping 7 lines ...
W0522 22:40:28.685] Specify --start=41684 in the next get-serial-port-output invocation to get only the new output starting from here.
W0522 22:40:30.051] scp: /var/log/kube-proxy.log*: No such file or directory
W0522 22:40:30.052] scp: /var/log/fluentd.log*: No such file or directory
W0522 22:40:30.052] scp: /var/log/node-problem-detector.log*: No such file or directory
W0522 22:40:30.053] scp: /var/log/kubelet.cov*: No such file or directory
W0522 22:40:30.053] scp: /var/log/startupscript.log*: No such file or directory
W0522 22:40:30.057] ERROR: (gcloud.compute.scp) [/usr/bin/scp] exited with return code [1].
W0522 22:40:30.144] scp: /var/log/kube-proxy.log*: No such file or directory
W0522 22:40:30.145] scp: /var/log/fluentd.log*: No such file or directory
W0522 22:40:30.145] scp: /var/log/node-problem-detector.log*: No such file or directory
W0522 22:40:30.145] scp: /var/log/kubelet.cov*: No such file or directory
W0522 22:40:30.145] scp: /var/log/startupscript.log*: No such file or directory
W0522 22:40:30.148] ERROR: (gcloud.compute.scp) [/usr/bin/scp] exited with return code [1].
W0522 22:40:30.453] scp: /var/log/kube-proxy.log*: No such file or directory
W0522 22:40:30.454] scp: /var/log/fluentd.log*: No such file or directory
W0522 22:40:30.454] scp: /var/log/node-problem-detector.log*: No such file or directory
W0522 22:40:30.454] scp: /var/log/kubelet.cov*: No such file or directory
W0522 22:40:30.454] scp: /var/log/startupscript.log*: No such file or directory
W0522 22:40:30.458] ERROR: (gcloud.compute.scp) [/usr/bin/scp] exited with return code [1].
W0522 22:40:34.137] INSTANCE_GROUPS=e2e-87af5414f2-674b9-minion-group
W0522 22:40:34.138] NODE_NAMES=e2e-87af5414f2-674b9-minion-group-01hc e2e-87af5414f2-674b9-minion-group-x95v e2e-87af5414f2-674b9-minion-group-xjzk
I0522 22:40:35.208] Failures for e2e-87af5414f2-674b9-minion-group (if any):
W0522 22:40:36.564] 2020/05/22 22:40:36 process.go:155: Step './cluster/log-dump/log-dump.sh /workspace/_artifacts' finished in 1m31.177291851s
W0522 22:40:36.565] 2020/05/22 22:40:36 process.go:153: Running: ./hack/e2e-internal/e2e-down.sh
W0522 22:40:36.622] Project: gce-gci-upg-lat-1-4-ctl-skew
... skipping 12 lines ...
I0522 22:40:42.937] Bringing down cluster
W0522 22:40:45.710] Deleting Managed Instance Group...
W0522 22:41:35.676] ..Deleted [https://www.googleapis.com/compute/v1/projects/gce-gci-upg-lat-1-4-ctl-skew/zones/us-west1-b/instanceGroupManagers/e2e-87af5414f2-674b9-minion-group].
W0522 22:41:35.676] done.
W0522 22:41:39.831] Deleted [https://www.googleapis.com/compute/v1/projects/gce-gci-upg-lat-1-4-ctl-skew/global/instanceTemplates/e2e-87af5414f2-674b9-minion-template].
W0522 22:41:40.337] Deleted [https://www.googleapis.com/compute/v1/projects/gce-gci-upg-lat-1-4-ctl-skew/global/instanceTemplates/e2e-87af5414f2-674b9-windows-node-template].
W0522 22:42:42.472] Failed to execute 'curl -s --cacert /etc/srv/kubernetes/pki/etcd-apiserver-ca.crt --cert /etc/srv/kubernetes/pki/etcd-apiserver-client.crt --key /etc/srv/kubernetes/pki/etcd-apiserver-client.key https://127.0.0.1:2379/v2/members/$(curl -s --cacert /etc/srv/kubernetes/pki/etcd-apiserver-ca.crt --cert /etc/srv/kubernetes/pki/etcd-apiserver-client.crt --key /etc/srv/kubernetes/pki/etcd-apiserver-client.key https://127.0.0.1:2379/v2/members -XGET | sed 's/{\"id/\n/g' | grep e2e-87af5414f2-674b9-master\" | cut -f 3 -d \") -XDELETE -L 2>/dev/null' on e2e-87af5414f2-674b9-master despite 5 attempts
W0522 22:42:42.472] Last attempt failed with: 
I0522 22:42:42.572] Removing etcd replica, name: e2e-87af5414f2-674b9-master, port: 2379, result: 1
W0522 22:43:41.603] Failed to execute 'curl -s  http://127.0.0.1:4002/v2/members/$(curl -s  http://127.0.0.1:4002/v2/members -XGET | sed 's/{\"id/\n/g' | grep e2e-87af5414f2-674b9-master\" | cut -f 3 -d \") -XDELETE -L 2>/dev/null' on e2e-87af5414f2-674b9-master despite 5 attempts
W0522 22:43:41.603] Last attempt failed with: 
I0522 22:43:41.704] Removing etcd replica, name: e2e-87af5414f2-674b9-master, port: 4002, result: 1
W0522 22:43:46.319] Updated [https://www.googleapis.com/compute/v1/projects/gce-gci-upg-lat-1-4-ctl-skew/zones/us-west1-b/instances/e2e-87af5414f2-674b9-master].
W0522 22:44:10.345] Deleted [https://www.googleapis.com/compute/v1/projects/gce-gci-upg-lat-1-4-ctl-skew/zones/us-west1-b/instances/e2e-87af5414f2-674b9-master].
W0522 22:44:21.439] Deleted [https://www.googleapis.com/compute/v1/projects/gce-gci-upg-lat-1-4-ctl-skew/global/firewalls/e2e-87af5414f2-674b9-master-https].
W0522 22:44:24.064] Deleted [https://www.googleapis.com/compute/v1/projects/gce-gci-upg-lat-1-4-ctl-skew/global/firewalls/e2e-87af5414f2-674b9-master-etcd].
W0522 22:44:24.411] Deleted [https://www.googleapis.com/compute/v1/projects/gce-gci-upg-lat-1-4-ctl-skew/global/firewalls/e2e-87af5414f2-674b9-minion-all].
... skipping 16 lines ...
W0522 22:45:09.082] W0522 22:45:09.081839   16961 loader.go:223] Config not found: /workspace/.kube/config
I0522 22:45:09.182] Property "users.gce-gci-upg-lat-1-4-ctl-skew_e2e-87af5414f2-674b9-basic-auth" unset.
W0522 22:45:09.284] W0522 22:45:09.284302   17012 loader.go:223] Config not found: /workspace/.kube/config
W0522 22:45:09.284] W0522 22:45:09.284498   17012 loader.go:223] Config not found: /workspace/.kube/config
W0522 22:45:09.292] 2020/05/22 22:45:09 process.go:155: Step './hack/e2e-internal/e2e-down.sh' finished in 4m32.727685052s
W0522 22:45:09.293] 2020/05/22 22:45:09 process.go:96: Saved XML output to /workspace/_artifacts/junit_runner.xml.
W0522 22:45:09.301] 2020/05/22 22:45:09 main.go:312: Something went wrong: starting e2e cluster: error during ./hack/e2e-internal/e2e-up.sh: exit status 2
W0522 22:45:09.306] Traceback (most recent call last):
W0522 22:45:09.306]   File "/workspace/./test-infra/jenkins/../scenarios/kubernetes_e2e.py", line 720, in <module>
W0522 22:45:09.306]     main(parse_args())
W0522 22:45:09.306]   File "/workspace/./test-infra/jenkins/../scenarios/kubernetes_e2e.py", line 570, in main
W0522 22:45:09.307]     mode.start(runner_args)
W0522 22:45:09.307]   File "/workspace/./test-infra/jenkins/../scenarios/kubernetes_e2e.py", line 228, in start
... skipping 3 lines ...
W0522 22:45:09.307]   File "/usr/lib/python2.7/subprocess.py", line 190, in check_call
W0522 22:45:09.308]     raise CalledProcessError(retcode, cmd)
W0522 22:45:09.308] subprocess.CalledProcessError: Command '('kubetest', '--dump=/workspace/_artifacts', '--gcp-service-account=/etc/service-account/service-account.json', '--build=bazel', '--stage=gs://kubernetes-release-pull/ci/pull-kubernetes-e2e-gce', '--up', '--down', '--test', '--provider=gce', '--cluster=e2e-87af5414f2-674b9', '--gcp-network=e2e-87af5414f2-674b9', '--extract=local', '--gcp-node-image=gci', '--gcp-zone=us-west1-b', '--ginkgo-parallel=30', '--runtime-config=batch/v2alpha1=true', '--test_args=--ginkgo.skip=\\[Slow\\]|\\[Serial\\]|\\[Disruptive\\]|\\[Flaky\\]|\\[Feature:.+\\] --minStartupPods=8', '--timeout=80m')' returned non-zero exit status 1
I0522 22:45:09.320] Property "contexts.gce-gci-upg-lat-1-4-ctl-skew_e2e-87af5414f2-674b9" unset.
I0522 22:45:09.320] Cleared config for gce-gci-upg-lat-1-4-ctl-skew_e2e-87af5414f2-674b9 from /workspace/.kube/config
I0522 22:45:09.321] Done
E0522 22:45:09.321] Command failed
I0522 22:45:09.321] process 591 exited with code 1 after 18.8m
E0522 22:45:09.321] FAIL: pull-kubernetes-e2e-gce
I0522 22:45:09.322] Call:  gcloud auth activate-service-account --key-file=/etc/service-account/service-account.json
W0522 22:45:10.064] Activated service account credentials for: [pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com]
I0522 22:45:10.113] process 17022 exited with code 0 after 0.0m
I0522 22:45:10.114] Call:  gcloud config get-value account
I0522 22:45:10.616] process 17036 exited with code 0 after 0.0m
I0522 22:45:10.617] Will upload results to gs://kubernetes-jenkins/pr-logs using pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com
I0522 22:45:10.617] Upload result and artifacts...
I0522 22:45:10.617] Gubernator results at https://gubernator.k8s.io/build/kubernetes-jenkins/pr-logs/pull/91370/pull-kubernetes-e2e-gce/1263959023401570304
I0522 22:45:10.618] Call:  gsutil ls gs://kubernetes-jenkins/pr-logs/pull/91370/pull-kubernetes-e2e-gce/1263959023401570304/artifacts
W0522 22:45:11.674] CommandException: One or more URLs matched no objects.
E0522 22:45:11.812] Command failed
I0522 22:45:11.813] process 17050 exited with code 1 after 0.0m
W0522 22:45:11.813] Remote dir gs://kubernetes-jenkins/pr-logs/pull/91370/pull-kubernetes-e2e-gce/1263959023401570304/artifacts not exist yet
I0522 22:45:11.813] Call:  gsutil -m -q -o GSUtil:use_magicfile=True cp -r -c -z log,txt,xml /workspace/_artifacts gs://kubernetes-jenkins/pr-logs/pull/91370/pull-kubernetes-e2e-gce/1263959023401570304/artifacts
I0522 22:45:14.221] process 17196 exited with code 0 after 0.0m
I0522 22:45:14.221] Call:  git rev-parse HEAD
I0522 22:45:14.226] process 17829 exited with code 0 after 0.0m
... skipping 21 lines ...