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 22:48
Elapsed16m12s
Revision
Builderdabd8521-1a90-11ed-870b-9aa24abd17ed
infra-commit941471669
job-versionv1.23.10-rc.0.31+b49bf4e7ee339d
kubetest-versionv20220812-2d111f2c30
revisionv1.23.10-rc.0.31+b49bf4e7ee339d

Test Failures


kubetest Up 7m21s

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 22:48:23.411] process 57 exited with code 0 after 0.0m
I0812 22:48:23.411] Will upload results to gs://kubernetes-jenkins/logs using prow-build@k8s-infra-prow-build.iam.gserviceaccount.com
I0812 22:48:23.411] Root: /workspace
I0812 22:48:23.411] cd to /workspace
I0812 22:48:23.412] Configure environment...
I0812 22:48:23.412] Call:  git show -s --format=format:%ct HEAD
W0812 22:48:23.415] fatal: not a git repository (or any of the parent directories): .git
I0812 22:48:23.415] process 71 exited with code 128 after 0.0m
W0812 22:48:23.415] Unable to print commit date for HEAD
I0812 22:48:23.416] Call:  gcloud auth activate-service-account --key-file=/etc/service-account/service-account.json
W0812 22:48:24.068] Activated service account credentials for: [prow-build@k8s-infra-prow-build.iam.gserviceaccount.com]
I0812 22:48:24.296] process 72 exited with code 0 after 0.0m
I0812 22:48:24.297] Call:  gcloud config get-value account
... skipping 360 lines ...
W0812 22:52:09.086] Trying to find master named 'test-a8a0b221b9-master'
W0812 22:52:09.086] Looking for address 'test-a8a0b221b9-master-ip'
W0812 22:52:10.147] Using master: test-a8a0b221b9-master (external IP: 34.127.88.7; internal IP: (not set))
I0812 22:52:10.247] Waiting up to 300 seconds for cluster initialization.
I0812 22:52:10.247] 
I0812 22:52:10.248]   This will continually check to see if the API for kubernetes is reachable.
I0812 22:52:10.248]   This may time out if there was some uncaught error during start up.
I0812 22:52:10.248] 
I0812 22:57:11.254] .........................................................................................................................................Checking for custom logdump instances, if any
I0812 22:57:11.258] ----------------------------------------------------------------------------------------------------
I0812 22:57:11.258] k/k version of the log-dump.sh script is deprecated!
I0812 22:57:11.259] Please migrate your test job to use test-infra's repo version of log-dump.sh!
I0812 22:57:11.259] Migration steps can be found in the readme file.
I0812 22:57:11.259] ----------------------------------------------------------------------------------------------------
I0812 22:57:11.260] Sourcing kube-util.sh
I0812 22:57:11.309] Detecting project
I0812 22:57:11.309] Project: k8s-infra-e2e-boskos-116
I0812 22:57:11.309] Network Project: k8s-infra-e2e-boskos-116
I0812 22:57:11.310] Zone: us-west1-b
I0812 22:57:11.317] Dumping logs from master locally to '/workspace/_artifacts'
W0812 22:57:11.418] Cluster failed to initialize within 300 seconds.
W0812 22:57:11.418] Last output from querying API server follows:
W0812 22:57:11.418] -----------------------------------------------------
W0812 22:57:11.419] * Expire in 0 ms for 6 (transfer 0x56127abe30f0)
W0812 22:57:11.419] * Expire in 5000 ms for 8 (transfer 0x56127abe30f0)
W0812 22:57:11.419] *   Trying 34.127.88.7...
W0812 22:57:11.419] * TCP_NODELAY set
W0812 22:57:11.419] * Expire in 200 ms for 4 (transfer 0x56127abe30f0)
W0812 22:57:11.419] * connect to 34.127.88.7 port 443 failed: Connection refused
W0812 22:57:11.420] * Failed to connect to 34.127.88.7 port 443: Connection refused
W0812 22:57:11.420] * Closing connection 0
W0812 22:57:11.420] curl: (7) Failed to connect to 34.127.88.7 port 443: Connection refused
W0812 22:57:11.420] -----------------------------------------------------
W0812 22:57:11.420] 2022/08/12 22:57:11 process.go:155: Step './hack/e2e-internal/e2e-up.sh' finished in 7m21.710189753s
W0812 22:57:11.421] 2022/08/12 22:57:11 e2e.go:574: Dumping logs locally to: /workspace/_artifacts
W0812 22:57:11.421] 2022/08/12 22:57:11 process.go:153: Running: ./cluster/log-dump/log-dump.sh /workspace/_artifacts
W0812 22:57:11.421] Trying to find master named 'test-a8a0b221b9-master'
W0812 22:57:11.421] Looking for address 'test-a8a0b221b9-master-ip'
... skipping 5 lines ...
W0812 22:57:53.788] scp: /var/log/glbc.log*: No such file or directory
W0812 22:57:53.788] scp: /var/log/cluster-autoscaler.log*: No such file or directory
W0812 22:57:53.788] scp: /var/log/kube-addon-manager.log*: No such file or directory
W0812 22:57:53.866] scp: /var/log/fluentd.log*: No such file or directory
W0812 22:57:53.866] scp: /var/log/kubelet.cov*: No such file or directory
W0812 22:57:53.867] scp: /var/log/startupscript.log*: No such file or directory
W0812 22:57:53.870] ERROR: (gcloud.compute.scp) [/usr/bin/scp] exited with return code [1].
I0812 22:57:54.040] Dumping logs from nodes locally to '/workspace/_artifacts'
I0812 22:57:54.040] Detecting nodes in the cluster
I0812 22:59:08.247] Changing logfiles to be world-readable for download
I0812 22:59:10.952] Changing logfiles to be world-readable for download
I0812 22:59:12.235] Changing logfiles to be world-readable for download
I0812 22:59:14.934] Copying 'kube-proxy.log containers/konnectivity-agent-*.log fluentd.log node-problem-detector.log kubelet.cov startupscript.log' from test-a8a0b221b9-minion-group-76vl
... skipping 6 lines ...
W0812 22:59:21.380] scp: /var/log/kube-proxy.log*: No such file or directory
W0812 22:59:21.381] scp: /var/log/containers/konnectivity-agent-*.log*: No such file or directory
W0812 22:59:21.381] scp: /var/log/fluentd.log*: No such file or directory
W0812 22:59:21.381] scp: /var/log/node-problem-detector.log*: No such file or directory
W0812 22:59:21.381] scp: /var/log/kubelet.cov*: No such file or directory
W0812 22:59:21.381] scp: /var/log/startupscript.log*: No such file or directory
W0812 22:59:21.385] ERROR: (gcloud.compute.scp) [/usr/bin/scp] exited with return code [1].
W0812 22:59:21.444] 
W0812 22:59:21.444] Specify --start=99408 in the next get-serial-port-output invocation to get only the new output starting from here.
W0812 22:59:23.040] scp: /var/log/kube-proxy.log*: No such file or directory
W0812 22:59:23.040] scp: /var/log/containers/konnectivity-agent-*.log*: No such file or directory
W0812 22:59:23.041] scp: /var/log/fluentd.log*: No such file or directory
W0812 22:59:23.041] scp: /var/log/node-problem-detector.log*: No such file or directory
W0812 22:59:23.041] scp: /var/log/kubelet.cov*: No such file or directory
W0812 22:59:23.041] scp: /var/log/startupscript.log*: No such file or directory
W0812 22:59:23.044] ERROR: (gcloud.compute.scp) [/usr/bin/scp] exited with return code [1].
W0812 22:59:23.888] scp: /var/log/kube-proxy.log*: No such file or directory
W0812 22:59:23.888] scp: /var/log/containers/konnectivity-agent-*.log*: No such file or directory
W0812 22:59:23.888] scp: /var/log/fluentd.log*: No such file or directory
W0812 22:59:23.889] scp: /var/log/node-problem-detector.log*: No such file or directory
W0812 22:59:23.889] scp: /var/log/kubelet.cov*: No such file or directory
W0812 22:59:23.889] scp: /var/log/startupscript.log*: No such file or directory
W0812 22:59:23.892] ERROR: (gcloud.compute.scp) [/usr/bin/scp] exited with return code [1].
W0812 22:59:28.086] INSTANCE_GROUPS=test-a8a0b221b9-minion-group
W0812 22:59:28.086] NODE_NAMES=test-a8a0b221b9-minion-group-76vl test-a8a0b221b9-minion-group-gxpm test-a8a0b221b9-minion-group-m4p4
I0812 22:59:29.181] Failures for test-a8a0b221b9-minion-group (if any):
W0812 22:59:30.390] 2022/08/12 22:59:30 process.go:155: Step './cluster/log-dump/log-dump.sh /workspace/_artifacts' finished in 2m19.13859101s
W0812 22:59:30.390] 2022/08/12 22:59:30 process.go:153: Running: ./hack/e2e-internal/e2e-down.sh
W0812 22:59:30.446] Project: k8s-infra-e2e-boskos-116
... skipping 14 lines ...
I0812 22:59:37.781] Bringing down cluster
W0812 23:00:10.259] Deleting Managed Instance Group...
W0812 23:00:10.260] ..Deleted [https://www.googleapis.com/compute/v1/projects/k8s-infra-e2e-boskos-116/zones/us-west1-b/instanceGroupManagers/test-a8a0b221b9-minion-group].
W0812 23:00:10.263] done.
W0812 23:00:17.596] Deleted [https://www.googleapis.com/compute/v1/projects/k8s-infra-e2e-boskos-116/global/instanceTemplates/test-a8a0b221b9-minion-template].
W0812 23:00:18.212] Deleted [https://www.googleapis.com/compute/v1/projects/k8s-infra-e2e-boskos-116/global/instanceTemplates/test-a8a0b221b9-windows-node-template].
W0812 23:01:19.990] 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-a8a0b221b9-master\" | cut -f 3 -d \") -XDELETE -L 2>/dev/null' on test-a8a0b221b9-master despite 5 attempts
W0812 23:01:19.991] Last attempt failed with: 
I0812 23:01:20.091] Removing etcd replica, name: test-a8a0b221b9-master, port: 2379, result: 1
W0812 23:02:19.471] 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-a8a0b221b9-master\" | cut -f 3 -d \") -XDELETE -L 2>/dev/null' on test-a8a0b221b9-master despite 5 attempts
W0812 23:02:19.471] Last attempt failed with: 
I0812 23:02:19.572] Removing etcd replica, name: test-a8a0b221b9-master, port: 4002, result: 1
W0812 23:02:23.428] Updated [https://www.googleapis.com/compute/v1/projects/k8s-infra-e2e-boskos-116/zones/us-west1-b/instances/test-a8a0b221b9-master].
W0812 23:02:42.785] Deleted [https://www.googleapis.com/compute/v1/projects/k8s-infra-e2e-boskos-116/zones/us-west1-b/instances/test-a8a0b221b9-master].
W0812 23:02:45.034] WARNING: The following filter keys were not present in any resource : name
W0812 23:02:54.621] Deleted [https://www.googleapis.com/compute/v1/projects/k8s-infra-e2e-boskos-116/global/firewalls/test-a8a0b221b9-master-https].
W0812 23:02:57.710] Deleted [https://www.googleapis.com/compute/v1/projects/k8s-infra-e2e-boskos-116/global/firewalls/test-a8a0b221b9-minion-all].
... skipping 20 lines ...
I0812 23:04:22.430] Cleared config for k8s-infra-e2e-boskos-116_test-a8a0b221b9 from /workspace/.kube/config
I0812 23:04:22.430] Done
W0812 23:04:22.451] W0812 23:04:22.409578   11477 loader.go:221] Config not found: /workspace/.kube/config
W0812 23:04:22.451] W0812 23:04:22.409761   11477 loader.go:221] Config not found: /workspace/.kube/config
W0812 23:04:22.451] 2022/08/12 23:04:22 process.go:155: Step './hack/e2e-internal/e2e-down.sh' finished in 4m52.040814142s
W0812 23:04:22.452] 2022/08/12 23:04:22 process.go:96: Saved XML output to /workspace/_artifacts/junit_runner.xml.
W0812 23:04:22.452] 2022/08/12 23:04:22 main.go:331: Something went wrong: starting e2e cluster: error during ./hack/e2e-internal/e2e-up.sh: exit status 2
W0812 23:04:22.452] Traceback (most recent call last):
W0812 23:04:22.452]   File "/workspace/./test-infra/jenkins/../scenarios/kubernetes_e2e.py", line 723, in <module>
W0812 23:04:22.452]     main(parse_args())
W0812 23:04:22.453]   File "/workspace/./test-infra/jenkins/../scenarios/kubernetes_e2e.py", line 569, in main
W0812 23:04:22.453]     mode.start(runner_args)
W0812 23:04:22.453]   File "/workspace/./test-infra/jenkins/../scenarios/kubernetes_e2e.py", line 228, in start
W0812 23:04:22.453]     check_env(env, self.command, *args)
W0812 23:04:22.453]   File "/workspace/./test-infra/jenkins/../scenarios/kubernetes_e2e.py", line 111, in check_env
W0812 23:04:22.453]     subprocess.check_call(cmd, env=env)
W0812 23:04:22.453]   File "/usr/lib/python2.7/subprocess.py", line 190, in check_call
W0812 23:04:22.454]     raise CalledProcessError(retcode, cmd)
W0812 23:04:22.454] subprocess.CalledProcessError: Command '('kubetest', '--dump=/workspace/_artifacts', '--gcp-service-account=/etc/service-account/service-account.json', '--up', '--down', '--test', '--provider=gce', '--cluster=test-a8a0b221b9', '--gcp-network=test-a8a0b221b9', '--check-leaked-resources', '--gcp-zone=us-west1-b', '--gcp-node-image=gci', '--extract=ci/latest-1.23', '--extract-ci-bucket=k8s-release-dev', '--timeout=180m', '--runtime-config=api/all=true', '--test_args=--ginkgo.focus=\\[Feature:(Audit|BlockVolume|PodPreset|ExpandCSIVolumes|ExpandInUseVolumes)\\]|Networking --ginkgo.skip=Networking-Performance|IPv6|Feature:(Volumes|SCTPConnectivity) --minStartupPods=8')' returned non-zero exit status 1
E0812 23:04:22.454] Command failed
I0812 23:04:22.455] process 272 exited with code 1 after 15.9m
E0812 23:04:22.455] FAIL: ci-kubernetes-e2e-gce-cos-k8sstable2-alphafeatures
I0812 23:04:22.455] Call:  gcloud auth activate-service-account --key-file=/etc/service-account/service-account.json
W0812 23:04:23.078] Activated service account credentials for: [prow-build@k8s-infra-prow-build.iam.gserviceaccount.com]
I0812 23:04:23.179] process 11487 exited with code 0 after 0.0m
I0812 23:04:23.180] Call:  gcloud config get-value account
I0812 23:04:23.760] process 11501 exited with code 0 after 0.0m
I0812 23:04:23.761] Will upload results to gs://kubernetes-jenkins/logs using prow-build@k8s-infra-prow-build.iam.gserviceaccount.com
I0812 23:04:23.761] Upload result and artifacts...
I0812 23:04:23.761] Gubernator results at https://gubernator.k8s.io/build/kubernetes-jenkins/logs/ci-kubernetes-e2e-gce-cos-k8sstable2-alphafeatures/1558223873885868032
I0812 23:04:23.761] Call:  gsutil ls gs://kubernetes-jenkins/logs/ci-kubernetes-e2e-gce-cos-k8sstable2-alphafeatures/1558223873885868032/artifacts
W0812 23:04:24.835] CommandException: One or more URLs matched no objects.
E0812 23:04:25.015] Command failed
I0812 23:04:25.015] process 11515 exited with code 1 after 0.0m
W0812 23:04:25.016] Remote dir gs://kubernetes-jenkins/logs/ci-kubernetes-e2e-gce-cos-k8sstable2-alphafeatures/1558223873885868032/artifacts not exist yet
I0812 23:04:25.016] 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-k8sstable2-alphafeatures/1558223873885868032/artifacts
I0812 23:04:29.836] process 11655 exited with code 0 after 0.1m
I0812 23:04:29.837] Call:  git rev-parse HEAD
W0812 23:04:29.840] fatal: not a git repository (or any of the parent directories): .git
E0812 23:04:29.840] Command failed
I0812 23:04:29.840] process 12283 exited with code 128 after 0.0m
I0812 23:04:29.840] Call:  git rev-parse HEAD
I0812 23:04:29.843] process 12284 exited with code 0 after 0.0m
I0812 23:04:29.844] Call:  gsutil stat gs://kubernetes-jenkins/logs/ci-kubernetes-e2e-gce-cos-k8sstable2-alphafeatures/jobResultsCache.json
I0812 23:04:31.046] process 12285 exited with code 0 after 0.0m
I0812 23:04:31.047] Call:  gsutil -q cat 'gs://kubernetes-jenkins/logs/ci-kubernetes-e2e-gce-cos-k8sstable2-alphafeatures/jobResultsCache.json#1660323782055821'
... skipping 8 lines ...