This job view page is being replaced by Spyglass soon. Check out the new job view.
ResultFAILURE
Tests 1 failed / 6 succeeded
Started2020-10-25 21:51
Elapsed15m45s
Revision
Builder38c91958-170c-11eb-b256-6ee25ea2e440
infra-commitd88010efd
job-versionv1.19.4-rc.0.22+9e8ad8ce9d8a30
revisionv1.19.4-rc.0.22+9e8ad8ce9d8a30

Test Failures


Up 7m11s

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 6 Passed Tests

Error lines from build-log.txt

... skipping 15 lines ...
I1025 21:51:39.282] process 47 exited with code 0 after 0.0m
I1025 21:51:39.282] Will upload results to gs://kubernetes-jenkins/logs using pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com
I1025 21:51:39.282] Root: /workspace
I1025 21:51:39.282] cd to /workspace
I1025 21:51:39.282] Configure environment...
I1025 21:51:39.283] Call:  git show -s --format=format:%ct HEAD
W1025 21:51:39.287] fatal: not a git repository (or any of the parent directories): .git
I1025 21:51:39.287] process 60 exited with code 128 after 0.0m
W1025 21:51:39.287] Unable to print commit date for HEAD
I1025 21:51:39.287] Call:  gcloud auth activate-service-account --key-file=/etc/service-account/service-account.json
W1025 21:51:39.935] Activated service account credentials for: [pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com]
I1025 21:51:40.949] process 61 exited with code 0 after 0.0m
I1025 21:51:40.950] Call:  gcloud config get-value account
... skipping 373 lines ...
W1025 21:55:24.353] Trying to find master named 'bootstrap-e2e-master'
W1025 21:55:24.353] Looking for address 'bootstrap-e2e-master-ip'
W1025 21:55:25.326] Using master: bootstrap-e2e-master (external IP: 34.83.143.21; internal IP: (not set))
I1025 21:55:25.426] Waiting up to 300 seconds for cluster initialization.
I1025 21:55:25.426] 
I1025 21:55:25.427]   This will continually check to see if the API for kubernetes is reachable.
I1025 21:55:25.427]   This may time out if there was some uncaught error during start up.
I1025 21:55:25.427] 
I1025 22:00:26.569] ...................................................................................................Checking for custom logdump instances, if any
I1025 22:00:26.575] Sourcing kube-util.sh
I1025 22:00:26.628] Detecting project
I1025 22:00:26.628] Project: gce-gci-upg-1-4-1-3-ctl-skew
I1025 22:00:26.628] Network Project: gce-gci-upg-1-4-1-3-ctl-skew
I1025 22:00:26.629] Zone: us-west1-b
I1025 22:00:26.629] Dumping logs from master locally to '/workspace/_artifacts'
W1025 22:00:26.729] Cluster failed to initialize within 300 seconds.
W1025 22:00:26.730] Last output from querying API server follows:
W1025 22:00:26.730] -----------------------------------------------------
W1025 22:00:26.730] * Expire in 0 ms for 6 (transfer 0x5564976e0f50)
W1025 22:00:26.730] * Expire in 5000 ms for 8 (transfer 0x5564976e0f50)
W1025 22:00:26.730] *   Trying 34.83.143.21...
W1025 22:00:26.730] * TCP_NODELAY set
W1025 22:00:26.730] * Expire in 200 ms for 4 (transfer 0x5564976e0f50)
W1025 22:00:26.731] * connect to 34.83.143.21 port 443 failed: Connection refused
W1025 22:00:26.731] * Failed to connect to 34.83.143.21 port 443: Connection refused
W1025 22:00:26.731] * Closing connection 0
W1025 22:00:26.731] curl: (7) Failed to connect to 34.83.143.21 port 443: Connection refused
W1025 22:00:26.731] -----------------------------------------------------
W1025 22:00:26.731] 2020/10/25 22:00:26 process.go:155: Step './hack/e2e-internal/e2e-up.sh' finished in 7m11.626734052s
W1025 22:00:26.731] 2020/10/25 22:00:26 e2e.go:544: Dumping logs locally to: /workspace/_artifacts
W1025 22:00:26.732] 2020/10/25 22:00:26 process.go:153: Running: ./cluster/log-dump/log-dump.sh /workspace/_artifacts
W1025 22:00:26.732] Trying to find master named 'bootstrap-e2e-master'
W1025 22:00:26.732] Looking for address 'bootstrap-e2e-master-ip'
... skipping 6 lines ...
W1025 22:01:08.065] scp: /var/log/cluster-autoscaler.log*: No such file or directory
W1025 22:01:08.065] scp: /var/log/kube-addon-manager.log*: No such file or directory
W1025 22:01:08.065] scp: /var/log/konnectivity-server.log*: No such file or directory
W1025 22:01:08.065] scp: /var/log/fluentd.log*: No such file or directory
W1025 22:01:08.065] scp: /var/log/kubelet.cov*: No such file or directory
W1025 22:01:08.066] scp: /var/log/startupscript.log*: No such file or directory
W1025 22:01:08.071] ERROR: (gcloud.compute.scp) [/usr/bin/scp] exited with return code [1].
I1025 22:01:08.251] Dumping logs from nodes locally to '/workspace/_artifacts'
I1025 22:01:08.251] Detecting nodes in the cluster
I1025 22:01:49.364] Changing logfiles to be world-readable for download
I1025 22:01:49.404] Changing logfiles to be world-readable for download
I1025 22:01:49.429] Changing logfiles to be world-readable for download
I1025 22:01:53.018] Copying 'kube-proxy.log fluentd.log node-problem-detector.log kubelet.cov  startupscript.log' from bootstrap-e2e-minion-group-gp11
... skipping 6 lines ...
W1025 22:01:54.292] 
W1025 22:01:54.293] Specify --start=43959 in the next get-serial-port-output invocation to get only the new output starting from here.
W1025 22:01:56.166] scp: /var/log/fluentd.log*: No such file or directory
W1025 22:01:56.166] scp: /var/log/node-problem-detector.log*: No such file or directory
W1025 22:01:56.166] scp: /var/log/kubelet.cov*: No such file or directory
W1025 22:01:56.167] scp: /var/log/startupscript.log*: No such file or directory
W1025 22:01:56.170] ERROR: (gcloud.compute.scp) [/usr/bin/scp] exited with return code [1].
W1025 22:01:56.243] scp: /var/log/fluentd.log*: No such file or directory
W1025 22:01:56.243] scp: /var/log/node-problem-detector.log*: No such file or directory
W1025 22:01:56.243] scp: /var/log/kubelet.cov*: No such file or directory
W1025 22:01:56.243] scp: /var/log/startupscript.log*: No such file or directory
W1025 22:01:56.247] ERROR: (gcloud.compute.scp) [/usr/bin/scp] exited with return code [1].
W1025 22:01:56.270] scp: /var/log/fluentd.log*: No such file or directory
W1025 22:01:56.270] scp: /var/log/node-problem-detector.log*: No such file or directory
W1025 22:01:56.270] scp: /var/log/kubelet.cov*: No such file or directory
W1025 22:01:56.271] scp: /var/log/startupscript.log*: No such file or directory
W1025 22:01:56.274] ERROR: (gcloud.compute.scp) [/usr/bin/scp] exited with return code [1].
W1025 22:02:00.120] INSTANCE_GROUPS=bootstrap-e2e-minion-group
W1025 22:02:00.121] NODE_NAMES=bootstrap-e2e-minion-group-gp11 bootstrap-e2e-minion-group-rsvw bootstrap-e2e-minion-group-trnl
I1025 22:02:01.363] Failures for bootstrap-e2e-minion-group (if any):
W1025 22:02:03.508] 2020/10/25 22:02:03 process.go:155: Step './cluster/log-dump/log-dump.sh /workspace/_artifacts' finished in 1m36.941101682s
W1025 22:02:03.508] 2020/10/25 22:02:03 process.go:153: Running: ./hack/e2e-internal/e2e-down.sh
W1025 22:02:03.564] Project: gce-gci-upg-1-4-1-3-ctl-skew
... skipping 12 lines ...
I1025 22:02:09.952] Bringing down cluster
W1025 22:02:56.656] Deleting Managed Instance Group...
W1025 22:02:56.656] ..Deleted [https://www.googleapis.com/compute/v1/projects/gce-gci-upg-1-4-1-3-ctl-skew/zones/us-west1-b/instanceGroupManagers/bootstrap-e2e-minion-group].
W1025 22:02:56.661] done.
W1025 22:03:00.365] Deleted [https://www.googleapis.com/compute/v1/projects/gce-gci-upg-1-4-1-3-ctl-skew/global/instanceTemplates/bootstrap-e2e-windows-node-template].
W1025 22:03:00.540] Deleted [https://www.googleapis.com/compute/v1/projects/gce-gci-upg-1-4-1-3-ctl-skew/global/instanceTemplates/bootstrap-e2e-minion-template].
W1025 22:04:03.477] 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 bootstrap-e2e-master\" | cut -f 3 -d \") -XDELETE -L 2>/dev/null' on bootstrap-e2e-master despite 5 attempts
W1025 22:04:03.478] Last attempt failed with: 
I1025 22:04:03.578] Removing etcd replica, name: bootstrap-e2e-master, port: 2379, result: 1
I1025 22:04:05.271] Successfully executed '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 bootstrap-e2e-master\" | cut -f 3 -d \") -XDELETE -L 2>/dev/null' on bootstrap-e2e-master
I1025 22:04:05.272] Removing etcd replica, name: bootstrap-e2e-master, port: 4002, result: 0
W1025 22:04:10.265] Updated [https://www.googleapis.com/compute/v1/projects/gce-gci-upg-1-4-1-3-ctl-skew/zones/us-west1-b/instances/bootstrap-e2e-master].
W1025 22:06:01.450] Deleted [https://www.googleapis.com/compute/v1/projects/gce-gci-upg-1-4-1-3-ctl-skew/zones/us-west1-b/instances/bootstrap-e2e-master].
W1025 22:06:10.193] Deleted [https://www.googleapis.com/compute/v1/projects/gce-gci-upg-1-4-1-3-ctl-skew/global/firewalls/bootstrap-e2e-master-https].
... skipping 19 lines ...
I1025 22:07:14.155] Cleared config for gce-gci-upg-1-4-1-3-ctl-skew_bootstrap-e2e from /workspace/.kube/config
I1025 22:07:14.156] Done
W1025 22:07:14.177] W1025 22:07:14.152409   11067 loader.go:223] Config not found: /workspace/.kube/config
W1025 22:07:14.178] W1025 22:07:14.152607   11067 loader.go:223] Config not found: /workspace/.kube/config
W1025 22:07:14.178] 2020/10/25 22:07:14 process.go:155: Step './hack/e2e-internal/e2e-down.sh' finished in 5m10.64919025s
W1025 22:07:14.178] 2020/10/25 22:07:14 process.go:96: Saved XML output to /workspace/_artifacts/junit_runner.xml.
W1025 22:07:14.178] 2020/10/25 22:07:14 main.go:316: Something went wrong: starting e2e cluster: error during ./hack/e2e-internal/e2e-up.sh: exit status 2
W1025 22:07:14.178] Traceback (most recent call last):
W1025 22:07:14.179]   File "/workspace/./test-infra/jenkins/../scenarios/kubernetes_e2e.py", line 720, in <module>
W1025 22:07:14.179]     main(parse_args())
W1025 22:07:14.179]   File "/workspace/./test-infra/jenkins/../scenarios/kubernetes_e2e.py", line 570, in main
W1025 22:07:14.179]     mode.start(runner_args)
W1025 22:07:14.179]   File "/workspace/./test-infra/jenkins/../scenarios/kubernetes_e2e.py", line 228, in start
W1025 22:07:14.179]     check_env(env, self.command, *args)
W1025 22:07:14.179]   File "/workspace/./test-infra/jenkins/../scenarios/kubernetes_e2e.py", line 111, in check_env
W1025 22:07:14.180]     subprocess.check_call(cmd, env=env)
W1025 22:07:14.180]   File "/usr/lib/python2.7/subprocess.py", line 190, in check_call
W1025 22:07:14.180]     raise CalledProcessError(retcode, cmd)
W1025 22:07:14.181] subprocess.CalledProcessError: Command '('kubetest', '--dump=/workspace/_artifacts', '--gcp-service-account=/etc/service-account/service-account.json', '--up', '--down', '--test', '--provider=gce', '--cluster=bootstrap-e2e', '--gcp-network=bootstrap-e2e', '--check-leaked-resources', '--check-version-skew=false', '--extract=ci/k8s-stable1', '--extract=ci/k8s-beta', '--gcp-node-image=gci', '--gcp-zone=us-west1-b', '--ginkgo-parallel', '--skew', '--test_args=--ginkgo.skip=\\[Slow\\]|\\[Serial\\]|\\[Disruptive\\]|\\[Flaky\\]|\\[Feature:.+\\] --kubectl-path=../../../../kubernetes_skew/cluster/kubectl.sh --minStartupPods=8', '--timeout=120m', '--upgrade_args=--ginkgo.focus=\\[Feature:ClusterDowngrade\\] --upgrade-target=ci/k8s-stable1 --upgrade-image=gci')' returned non-zero exit status 1
E1025 22:07:14.181] Command failed
I1025 22:07:14.181] process 266 exited with code 1 after 15.5m
E1025 22:07:14.181] FAIL: ci-kubernetes-e2e-gce-beta-stable1-downgrade-cluster-parallel
I1025 22:07:14.181] Call:  gcloud auth activate-service-account --key-file=/etc/service-account/service-account.json
W1025 22:07:14.819] Activated service account credentials for: [pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com]
I1025 22:07:14.930] process 11078 exited with code 0 after 0.0m
I1025 22:07:14.930] Call:  gcloud config get-value account
I1025 22:07:15.538] process 11091 exited with code 0 after 0.0m
I1025 22:07:15.538] Will upload results to gs://kubernetes-jenkins/logs using pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com
I1025 22:07:15.538] Upload result and artifacts...
I1025 22:07:15.538] Gubernator results at https://gubernator.k8s.io/build/kubernetes-jenkins/logs/ci-kubernetes-e2e-gce-beta-stable1-downgrade-cluster-parallel/1320483115029762048
I1025 22:07:15.539] Call:  gsutil ls gs://kubernetes-jenkins/logs/ci-kubernetes-e2e-gce-beta-stable1-downgrade-cluster-parallel/1320483115029762048/artifacts
W1025 22:07:16.475] CommandException: One or more URLs matched no objects.
E1025 22:07:16.653] Command failed
I1025 22:07:16.653] process 11104 exited with code 1 after 0.0m
W1025 22:07:16.653] Remote dir gs://kubernetes-jenkins/logs/ci-kubernetes-e2e-gce-beta-stable1-downgrade-cluster-parallel/1320483115029762048/artifacts not exist yet
I1025 22:07:16.654] Call:  gsutil -m -q -o GSUtil:use_magicfile=True cp -r -c -z log,txt,xml /workspace/_artifacts gs://kubernetes-jenkins/logs/ci-kubernetes-e2e-gce-beta-stable1-downgrade-cluster-parallel/1320483115029762048/artifacts
I1025 22:07:18.745] process 11247 exited with code 0 after 0.0m
I1025 22:07:18.745] Call:  git rev-parse HEAD
W1025 22:07:18.749] fatal: not a git repository (or any of the parent directories): .git
E1025 22:07:18.750] Command failed
I1025 22:07:18.750] process 11892 exited with code 128 after 0.0m
I1025 22:07:18.750] Call:  git rev-parse HEAD
I1025 22:07:18.754] process 11893 exited with code 0 after 0.0m
I1025 22:07:18.755] Call:  gsutil stat gs://kubernetes-jenkins/logs/ci-kubernetes-e2e-gce-beta-stable1-downgrade-cluster-parallel/jobResultsCache.json
I1025 22:07:19.877] process 11894 exited with code 0 after 0.0m
I1025 22:07:19.878] Call:  gsutil -q cat 'gs://kubernetes-jenkins/logs/ci-kubernetes-e2e-gce-beta-stable1-downgrade-cluster-parallel/jobResultsCache.json#1603656414082139'
... skipping 8 lines ...