This job view page is being replaced by Spyglass soon. Check out the new job view.
ResultFAILURE
Tests 1 failed / 8 succeeded
Started2022-08-12 05:04
Elapsed14m54s
Revision
Builder3ea8fd38-19fc-11ed-93e1-babc36ce5807
infra-commit228f8bc1d
job-versionv1.22.13-rc.0.17+cdfdbd03d6b159
kubetest-versionv20220804-4fa19ea91a
revisionv1.22.13-rc.0.17+cdfdbd03d6b159

Test Failures


kubetest Up 6m59s

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

Error lines from build-log.txt

... skipping 15 lines ...
I0812 05:04:35.339] process 58 exited with code 0 after 0.0m
I0812 05:04:35.340] Will upload results to gs://kubernetes-jenkins/logs using prow-build@k8s-infra-prow-build.iam.gserviceaccount.com
I0812 05:04:35.340] Root: /workspace
I0812 05:04:35.340] cd to /workspace
I0812 05:04:35.340] Configure environment...
I0812 05:04:35.341] Call:  git show -s --format=format:%ct HEAD
W0812 05:04:35.343] fatal: not a git repository (or any of the parent directories): .git
I0812 05:04:35.344] process 72 exited with code 128 after 0.0m
W0812 05:04:35.344] Unable to print commit date for HEAD
I0812 05:04:35.344] Call:  gcloud auth activate-service-account --key-file=/etc/service-account/service-account.json
W0812 05:04:36.068] Activated service account credentials for: [prow-build@k8s-infra-prow-build.iam.gserviceaccount.com]
I0812 05:04:36.243] process 73 exited with code 0 after 0.0m
I0812 05:04:36.243] Call:  gcloud config get-value account
... skipping 359 lines ...
W0812 05:07:40.608] Trying to find master named 'test-1d30227e33-master'
W0812 05:07:40.608] Looking for address 'test-1d30227e33-master-ip'
W0812 05:07:41.493] Using master: test-1d30227e33-master (external IP: 35.230.47.106; internal IP: (not set))
I0812 05:07:41.594] Waiting up to 300 seconds for cluster initialization.
I0812 05:07:41.594] 
I0812 05:07:41.594]   This will continually check to see if the API for kubernetes is reachable.
I0812 05:07:41.594]   This may time out if there was some uncaught error during start up.
I0812 05:07:41.594] 
I0812 05:12:42.674] ...........................................................................................................................................Checking for custom logdump instances, if any
I0812 05:12:42.679] ----------------------------------------------------------------------------------------------------
I0812 05:12:42.679] k/k version of the log-dump.sh script is deprecated!
I0812 05:12:42.679] Please migrate your test job to use test-infra's repo version of log-dump.sh!
I0812 05:12:42.680] Migration steps can be found in the readme file.
I0812 05:12:42.680] ----------------------------------------------------------------------------------------------------
I0812 05:12:42.680] Sourcing kube-util.sh
I0812 05:12:42.726] Detecting project
I0812 05:12:42.726] Project: k8s-infra-e2e-boskos-044
I0812 05:12:42.727] Network Project: k8s-infra-e2e-boskos-044
I0812 05:12:42.727] Zone: us-west1-b
I0812 05:12:42.734] Dumping logs from master locally to '/workspace/_artifacts'
W0812 05:12:42.835] Cluster failed to initialize within 300 seconds.
W0812 05:12:42.835] Last output from querying API server follows:
W0812 05:12:42.835] -----------------------------------------------------
W0812 05:12:42.835] * Expire in 0 ms for 6 (transfer 0x5576915160f0)
W0812 05:12:42.835] * Expire in 5000 ms for 8 (transfer 0x5576915160f0)
W0812 05:12:42.835] *   Trying 35.230.47.106...
W0812 05:12:42.836] * TCP_NODELAY set
W0812 05:12:42.836] * Expire in 200 ms for 4 (transfer 0x5576915160f0)
W0812 05:12:42.836] * connect to 35.230.47.106 port 443 failed: Connection refused
W0812 05:12:42.836] * Failed to connect to 35.230.47.106 port 443: Connection refused
W0812 05:12:42.836] * Closing connection 0
W0812 05:12:42.836] curl: (7) Failed to connect to 35.230.47.106 port 443: Connection refused
W0812 05:12:42.836] -----------------------------------------------------
W0812 05:12:42.837] 2022/08/12 05:12:42 process.go:155: Step './hack/e2e-internal/e2e-up.sh' finished in 6m59.741669476s
W0812 05:12:42.837] 2022/08/12 05:12:42 e2e.go:574: Dumping logs locally to: /workspace/_artifacts
W0812 05:12:42.837] 2022/08/12 05:12:42 process.go:153: Running: ./cluster/log-dump/log-dump.sh /workspace/_artifacts
W0812 05:12:42.837] Trying to find master named 'test-1d30227e33-master'
W0812 05:12:42.837] Looking for address 'test-1d30227e33-master-ip'
... skipping 5 lines ...
W0812 05:13:21.632] scp: /var/log/glbc.log*: No such file or directory
W0812 05:13:21.632] scp: /var/log/cluster-autoscaler.log*: No such file or directory
W0812 05:13:21.632] scp: /var/log/kube-addon-manager.log*: No such file or directory
W0812 05:13:21.710] scp: /var/log/fluentd.log*: No such file or directory
W0812 05:13:21.710] scp: /var/log/kubelet.cov*: No such file or directory
W0812 05:13:21.710] scp: /var/log/startupscript.log*: No such file or directory
W0812 05:13:21.714] ERROR: (gcloud.compute.scp) [/usr/bin/scp] exited with return code [1].
I0812 05:13:21.865] Dumping logs from nodes locally to '/workspace/_artifacts'
I0812 05:13:21.866] Detecting nodes in the cluster
I0812 05:14:25.495] Changing logfiles to be world-readable for download
I0812 05:14:26.401] Changing logfiles to be world-readable for download
I0812 05:14:30.535] Changing logfiles to be world-readable for download
I0812 05:14:31.303] Copying 'kube-proxy.log containers/konnectivity-agent-*.log fluentd.log node-problem-detector.log kubelet.cov startupscript.log' from test-1d30227e33-minion-group-8kz2
... skipping 6 lines ...
W0812 05:14:36.116] scp: /var/log/kube-proxy.log*: No such file or directory
W0812 05:14:36.117] scp: /var/log/containers/konnectivity-agent-*.log*: No such file or directory
W0812 05:14:36.117] scp: /var/log/fluentd.log*: No such file or directory
W0812 05:14:36.117] scp: /var/log/node-problem-detector.log*: No such file or directory
W0812 05:14:36.117] scp: /var/log/kubelet.cov*: No such file or directory
W0812 05:14:36.117] scp: /var/log/startupscript.log*: No such file or directory
W0812 05:14:36.120] ERROR: (gcloud.compute.scp) [/usr/bin/scp] exited with return code [1].
W0812 05:14:36.401] scp: /var/log/kube-proxy.log*: No such file or directory
W0812 05:14:36.401] scp: /var/log/containers/konnectivity-agent-*.log*: No such file or directory
W0812 05:14:36.401] scp: /var/log/fluentd.log*: No such file or directory
W0812 05:14:36.401] scp: /var/log/node-problem-detector.log*: No such file or directory
W0812 05:14:36.402] scp: /var/log/kubelet.cov*: No such file or directory
W0812 05:14:36.402] scp: /var/log/startupscript.log*: No such file or directory
W0812 05:14:36.405] ERROR: (gcloud.compute.scp) [/usr/bin/scp] exited with return code [1].
W0812 05:14:37.254] 
W0812 05:14:37.254] Specify --start=91741 in the next get-serial-port-output invocation to get only the new output starting from here.
W0812 05:14:38.893] scp: /var/log/kube-proxy.log*: No such file or directory
W0812 05:14:38.893] scp: /var/log/containers/konnectivity-agent-*.log*: No such file or directory
W0812 05:14:38.893] scp: /var/log/fluentd.log*: No such file or directory
W0812 05:14:38.894] scp: /var/log/node-problem-detector.log*: No such file or directory
W0812 05:14:38.894] scp: /var/log/kubelet.cov*: No such file or directory
W0812 05:14:38.894] scp: /var/log/startupscript.log*: No such file or directory
W0812 05:14:38.896] ERROR: (gcloud.compute.scp) [/usr/bin/scp] exited with return code [1].
W0812 05:14:43.406] INSTANCE_GROUPS=test-1d30227e33-minion-group
W0812 05:14:43.406] NODE_NAMES=test-1d30227e33-minion-group-4bs6 test-1d30227e33-minion-group-8kz2 test-1d30227e33-minion-group-xhzq
I0812 05:14:44.385] Failures for test-1d30227e33-minion-group (if any):
W0812 05:14:45.430] 2022/08/12 05:14:45 process.go:155: Step './cluster/log-dump/log-dump.sh /workspace/_artifacts' finished in 2m2.758483161s
W0812 05:14:45.431] 2022/08/12 05:14:45 process.go:153: Running: ./hack/e2e-internal/e2e-down.sh
W0812 05:14:45.481] Project: k8s-infra-e2e-boskos-044
... skipping 14 lines ...
I0812 05:14:51.896] Bringing down cluster
W0812 05:15:17.759] Deleting Managed Instance Group...
W0812 05:15:17.759] ..Deleted [https://www.googleapis.com/compute/v1/projects/k8s-infra-e2e-boskos-044/zones/us-west1-b/instanceGroupManagers/test-1d30227e33-minion-group].
W0812 05:15:17.762] done.
W0812 05:15:23.556] Deleted [https://www.googleapis.com/compute/v1/projects/k8s-infra-e2e-boskos-044/global/instanceTemplates/test-1d30227e33-minion-template].
W0812 05:15:24.870] Deleted [https://www.googleapis.com/compute/v1/projects/k8s-infra-e2e-boskos-044/global/instanceTemplates/test-1d30227e33-windows-node-template].
W0812 05:16:26.127] 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 test-1d30227e33-master\" | cut -f 3 -d \") -XDELETE -L 2>/dev/null' on test-1d30227e33-master despite 5 attempts
W0812 05:16:26.127] Last attempt failed with: 
I0812 05:16:26.228] Removing etcd replica, name: test-1d30227e33-master, port: 2379, result: 1
W0812 05:17:24.825] 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 test-1d30227e33-master\" | cut -f 3 -d \") -XDELETE -L 2>/dev/null' on test-1d30227e33-master despite 5 attempts
W0812 05:17:24.825] Last attempt failed with: 
I0812 05:17:24.925] Removing etcd replica, name: test-1d30227e33-master, port: 4002, result: 1
W0812 05:17:28.320] Updated [https://www.googleapis.com/compute/v1/projects/k8s-infra-e2e-boskos-044/zones/us-west1-b/instances/test-1d30227e33-master].
W0812 05:17:43.726] Deleted [https://www.googleapis.com/compute/v1/projects/k8s-infra-e2e-boskos-044/zones/us-west1-b/instances/test-1d30227e33-master].
W0812 05:17:45.799] WARNING: The following filter keys were not present in any resource : name
W0812 05:17:53.836] Deleted [https://www.googleapis.com/compute/v1/projects/k8s-infra-e2e-boskos-044/global/firewalls/test-1d30227e33-master-https].
W0812 05:17:57.263] Deleted [https://www.googleapis.com/compute/v1/projects/k8s-infra-e2e-boskos-044/global/firewalls/test-1d30227e33-master-etcd].
... skipping 20 lines ...
I0812 05:19:18.051] Cleared config for k8s-infra-e2e-boskos-044_test-1d30227e33 from /workspace/.kube/config
I0812 05:19:18.051] Done
W0812 05:19:18.077] W0812 05:19:18.048865   11275 loader.go:221] Config not found: /workspace/.kube/config
W0812 05:19:18.077] W0812 05:19:18.049004   11275 loader.go:221] Config not found: /workspace/.kube/config
W0812 05:19:18.077] 2022/08/12 05:19:18 process.go:155: Step './hack/e2e-internal/e2e-down.sh' finished in 4m32.621385405s
W0812 05:19:18.077] 2022/08/12 05:19:18 process.go:96: Saved XML output to /workspace/_artifacts/junit_runner.xml.
W0812 05:19:18.078] 2022/08/12 05:19:18 main.go:331: Something went wrong: starting e2e cluster: error during ./hack/e2e-internal/e2e-up.sh: exit status 2
W0812 05:19:18.078] Traceback (most recent call last):
W0812 05:19:18.078]   File "/workspace/./test-infra/jenkins/../scenarios/kubernetes_e2e.py", line 723, in <module>
W0812 05:19:18.078]     main(parse_args())
W0812 05:19:18.078]   File "/workspace/./test-infra/jenkins/../scenarios/kubernetes_e2e.py", line 569, in main
W0812 05:19:18.078]     mode.start(runner_args)
W0812 05:19:18.078]   File "/workspace/./test-infra/jenkins/../scenarios/kubernetes_e2e.py", line 228, in start
W0812 05:19:18.078]     check_env(env, self.command, *args)
W0812 05:19:18.078]   File "/workspace/./test-infra/jenkins/../scenarios/kubernetes_e2e.py", line 111, in check_env
W0812 05:19:18.078]     subprocess.check_call(cmd, env=env)
W0812 05:19:18.079]   File "/usr/lib/python2.7/subprocess.py", line 190, in check_call
W0812 05:19:18.079]     raise CalledProcessError(retcode, cmd)
W0812 05:19:18.079] subprocess.CalledProcessError: Command '('kubetest', '--dump=/workspace/_artifacts', '--gcp-service-account=/etc/service-account/service-account.json', '--up', '--down', '--test', '--provider=gce', '--cluster=test-1d30227e33', '--gcp-network=test-1d30227e33', '--check-leaked-resources', '--gcp-zone=us-west1-b', '--gcp-node-image=gci', '--extract=ci/latest-1.22', '--extract-ci-bucket=k8s-release-dev', '--timeout=180m', '--test_args=--ginkgo.focus=\\[Feature:(ExternalTrafficLocalOnly)\\] --minStartupPods=8', '--runtime-config=api/all=true')' returned non-zero exit status 1
E0812 05:19:18.079] Command failed
I0812 05:19:18.079] process 273 exited with code 1 after 14.7m
E0812 05:19:18.079] FAIL: ci-kubernetes-e2e-gce-cos-k8sstable3-alphafeatures
I0812 05:19:18.080] Call:  gcloud auth activate-service-account --key-file=/etc/service-account/service-account.json
W0812 05:19:18.754] Activated service account credentials for: [prow-build@k8s-infra-prow-build.iam.gserviceaccount.com]
I0812 05:19:18.846] process 11286 exited with code 0 after 0.0m
I0812 05:19:18.846] Call:  gcloud config get-value account
I0812 05:19:19.401] process 11300 exited with code 0 after 0.0m
I0812 05:19:19.402] Will upload results to gs://kubernetes-jenkins/logs using prow-build@k8s-infra-prow-build.iam.gserviceaccount.com
I0812 05:19:19.402] Upload result and artifacts...
I0812 05:19:19.402] Gubernator results at https://gubernator.k8s.io/build/kubernetes-jenkins/logs/ci-kubernetes-e2e-gce-cos-k8sstable3-alphafeatures/1557956162467401728
I0812 05:19:19.402] Call:  gsutil ls gs://kubernetes-jenkins/logs/ci-kubernetes-e2e-gce-cos-k8sstable3-alphafeatures/1557956162467401728/artifacts
W0812 05:19:20.376] CommandException: One or more URLs matched no objects.
E0812 05:19:20.533] Command failed
I0812 05:19:20.533] process 11314 exited with code 1 after 0.0m
W0812 05:19:20.533] Remote dir gs://kubernetes-jenkins/logs/ci-kubernetes-e2e-gce-cos-k8sstable3-alphafeatures/1557956162467401728/artifacts not exist yet
I0812 05:19:20.533] 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-cos-k8sstable3-alphafeatures/1557956162467401728/artifacts
I0812 05:19:25.014] process 11454 exited with code 0 after 0.1m
I0812 05:19:25.015] Call:  git rev-parse HEAD
W0812 05:19:25.018] fatal: not a git repository (or any of the parent directories): .git
E0812 05:19:25.018] Command failed
I0812 05:19:25.018] process 12082 exited with code 128 after 0.0m
I0812 05:19:25.018] Call:  git rev-parse HEAD
I0812 05:19:25.021] process 12083 exited with code 0 after 0.0m
I0812 05:19:25.021] Call:  gsutil stat gs://kubernetes-jenkins/logs/ci-kubernetes-e2e-gce-cos-k8sstable3-alphafeatures/jobResultsCache.json
I0812 05:19:26.097] process 12084 exited with code 0 after 0.0m
I0812 05:19:26.098] Call:  gsutil -q cat 'gs://kubernetes-jenkins/logs/ci-kubernetes-e2e-gce-cos-k8sstable3-alphafeatures/jobResultsCache.json#1660195252605898'
... skipping 8 lines ...