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 15:48
Elapsed16m0s
Revision
Builder833c40f8-16d9-11eb-b256-6ee25ea2e440
infra-commitd88010efd
job-versionv1.19.4-rc.0.22+9e8ad8ce9d8a30
revisionv1.19.4-rc.0.22+9e8ad8ce9d8a30

Test Failures


Up 6m56s

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 15:48:38.970] process 47 exited with code 0 after 0.0m
I1025 15:48:38.970] Will upload results to gs://kubernetes-jenkins/logs using pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com
I1025 15:48:38.971] Root: /workspace
I1025 15:48:38.971] cd to /workspace
I1025 15:48:38.971] Configure environment...
I1025 15:48:38.972] Call:  git show -s --format=format:%ct HEAD
W1025 15:48:38.976] fatal: not a git repository (or any of the parent directories): .git
I1025 15:48:38.977] process 60 exited with code 128 after 0.0m
W1025 15:48:38.977] Unable to print commit date for HEAD
I1025 15:48:38.978] Call:  gcloud auth activate-service-account --key-file=/etc/service-account/service-account.json
W1025 15:48:40.039] Activated service account credentials for: [pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com]
I1025 15:48:40.392] process 61 exited with code 0 after 0.0m
I1025 15:48:40.392] Call:  gcloud config get-value account
... skipping 114 lines ...
I1025 15:48:50.076] Will download and extract kubernetes-test tarball(s) from https://storage.googleapis.com/kubernetes-release-dev/ci/v1.18.11-rc.0.13+806617c8cf1f0d
W1025 15:48:50.873]   % Total    % Received % Xferd  Average Speed   Time    Time     Time  Current
W1025 15:48:50.873]                                  Dload  Upload   Total   Spent    Left  Speed
W1025 15:48:51.523] 
  0     0    0     0    0     0      0      0 --:--:-- --:--:-- --:--:--     0
 10  518M   10 55.8M    0     0  85.9M      0  0:00:06 --:--:--  0:00:06 85.9M
W1025 15:48:51.524] curl: (56) OpenSSL SSL_read: SSL_ERROR_SYSCALL, errno 104
W1025 15:48:51.527] 2020/10/25 15:48:51 process.go:155: Step './get-kube.sh' finished in 2.892607995s
W1025 15:48:51.527] 2020/10/25 15:48:51 extract_k8s.go:302: U=https://storage.googleapis.com/kubernetes-release-dev/ci R=v1.18.11-rc.0.13+806617c8cf1f0d get-kube.sh failed: error during ./get-kube.sh: exit status 56
W1025 15:48:51.527] 2020/10/25 15:48:51 process.go:153: Running: ./get-kube.sh
I1025 15:48:51.628] Found preexisting kubernetes.tar.gz, release v1.18.11-rc.0.13+806617c8cf1f0d
I1025 15:48:51.628] Using preexisting kubernetes.tar.gz
I1025 15:48:51.628] Will also delete preexisting 'kubernetes' directory.
I1025 15:48:51.628] Unpacking kubernetes release v1.18.11-rc.0.13+806617c8cf1f0d
I1025 15:48:51.656] Kubernetes release: v1.18.11-rc.0.13+806617c8cf1f0d
... skipping 264 lines ...
W1025 15:52:35.460] Trying to find master named 'bootstrap-e2e-master'
W1025 15:52:35.461] Looking for address 'bootstrap-e2e-master-ip'
W1025 15:52:36.454] Using master: bootstrap-e2e-master (external IP: 35.247.94.56; internal IP: (not set))
I1025 15:52:36.554] Waiting up to 300 seconds for cluster initialization.
I1025 15:52:36.555] 
I1025 15:52:36.555]   This will continually check to see if the API for kubernetes is reachable.
I1025 15:52:36.555]   This may time out if there was some uncaught error during start up.
I1025 15:52:36.555] 
I1025 15:57:37.261] ..................................................................................................Checking for custom logdump instances, if any
I1025 15:57:37.266] Sourcing kube-util.sh
I1025 15:57:37.326] Detecting project
I1025 15:57:37.326] Project: gce-up-g1-4-glat-up-mas
I1025 15:57:37.327] Network Project: gce-up-g1-4-glat-up-mas
I1025 15:57:37.327] Zone: us-west1-b
I1025 15:57:37.327] Dumping logs from master locally to '/workspace/_artifacts'
W1025 15:57:37.427] Cluster failed to initialize within 300 seconds.
W1025 15:57:37.428] Last output from querying API server follows:
W1025 15:57:37.428] -----------------------------------------------------
W1025 15:57:37.428] * Expire in 0 ms for 6 (transfer 0x55612de5bf50)
W1025 15:57:37.428] * Expire in 5000 ms for 8 (transfer 0x55612de5bf50)
W1025 15:57:37.428] *   Trying 35.247.94.56...
W1025 15:57:37.428] * TCP_NODELAY set
W1025 15:57:37.429] * Expire in 200 ms for 4 (transfer 0x55612de5bf50)
W1025 15:57:37.429] * connect to 35.247.94.56 port 443 failed: Connection refused
W1025 15:57:37.429] * Failed to connect to 35.247.94.56 port 443: Connection refused
W1025 15:57:37.429] * Closing connection 0
W1025 15:57:37.429] curl: (7) Failed to connect to 35.247.94.56 port 443: Connection refused
W1025 15:57:37.429] -----------------------------------------------------
W1025 15:57:37.430] 2020/10/25 15:57:37 process.go:155: Step './hack/e2e-internal/e2e-up.sh' finished in 6m56.342207145s
W1025 15:57:37.430] 2020/10/25 15:57:37 e2e.go:544: Dumping logs locally to: /workspace/_artifacts
W1025 15:57:37.430] 2020/10/25 15:57:37 process.go:153: Running: ./cluster/log-dump/log-dump.sh /workspace/_artifacts
W1025 15:57:37.430] Trying to find master named 'bootstrap-e2e-master'
W1025 15:57:37.430] Looking for address 'bootstrap-e2e-master-ip'
... skipping 6 lines ...
W1025 15:58:19.663] scp: /var/log/cluster-autoscaler.log*: No such file or directory
W1025 15:58:19.664] scp: /var/log/kube-addon-manager.log*: No such file or directory
W1025 15:58:19.664] scp: /var/log/konnectivity-server.log*: No such file or directory
W1025 15:58:19.664] scp: /var/log/fluentd.log*: No such file or directory
W1025 15:58:19.664] scp: /var/log/kubelet.cov*: No such file or directory
W1025 15:58:19.664] scp: /var/log/startupscript.log*: No such file or directory
W1025 15:58:19.667] ERROR: (gcloud.compute.scp) [/usr/bin/scp] exited with return code [1].
I1025 15:58:19.874] Dumping logs from nodes locally to '/workspace/_artifacts'
I1025 15:58:19.874] Detecting nodes in the cluster
I1025 15:59:03.152] Changing logfiles to be world-readable for download
I1025 15:59:03.784] Changing logfiles to be world-readable for download
I1025 15:59:04.011] Changing logfiles to be world-readable for download
I1025 15:59:07.065] Copying 'kube-proxy.log fluentd.log node-problem-detector.log kubelet.cov  startupscript.log' from bootstrap-e2e-minion-group-4cvb
... skipping 6 lines ...
W1025 15:59:09.308] 
W1025 15:59:09.308] Specify --start=43931 in the next get-serial-port-output invocation to get only the new output starting from here.
W1025 15:59:10.290] scp: /var/log/fluentd.log*: No such file or directory
W1025 15:59:10.291] scp: /var/log/node-problem-detector.log*: No such file or directory
W1025 15:59:10.291] scp: /var/log/kubelet.cov*: No such file or directory
W1025 15:59:10.291] scp: /var/log/startupscript.log*: No such file or directory
W1025 15:59:10.295] ERROR: (gcloud.compute.scp) [/usr/bin/scp] exited with return code [1].
W1025 15:59:10.904] scp: /var/log/fluentd.log*: No such file or directory
W1025 15:59:10.905] scp: /var/log/node-problem-detector.log*: No such file or directory
W1025 15:59:10.905] scp: /var/log/kubelet.cov*: No such file or directory
W1025 15:59:10.905] scp: /var/log/startupscript.log*: No such file or directory
W1025 15:59:10.908] ERROR: (gcloud.compute.scp) [/usr/bin/scp] exited with return code [1].
W1025 15:59:11.367] scp: /var/log/fluentd.log*: No such file or directory
W1025 15:59:11.367] scp: /var/log/node-problem-detector.log*: No such file or directory
W1025 15:59:11.368] scp: /var/log/kubelet.cov*: No such file or directory
W1025 15:59:11.368] scp: /var/log/startupscript.log*: No such file or directory
W1025 15:59:11.372] ERROR: (gcloud.compute.scp) [/usr/bin/scp] exited with return code [1].
W1025 15:59:15.477] INSTANCE_GROUPS=bootstrap-e2e-minion-group
W1025 15:59:15.478] NODE_NAMES=bootstrap-e2e-minion-group-4cvb bootstrap-e2e-minion-group-gw2h bootstrap-e2e-minion-group-td4l
I1025 15:59:16.730] Failures for bootstrap-e2e-minion-group (if any):
W1025 15:59:18.743] 2020/10/25 15:59:18 process.go:155: Step './cluster/log-dump/log-dump.sh /workspace/_artifacts' finished in 1m41.485362866s
W1025 15:59:18.744] 2020/10/25 15:59:18 process.go:153: Running: ./hack/e2e-internal/e2e-down.sh
W1025 15:59:18.805] Project: gce-up-g1-4-glat-up-mas
... skipping 12 lines ...
I1025 15:59:26.899] Bringing down cluster
W1025 16:00:08.456] Deleting Managed Instance Group...
W1025 16:00:08.456] ..Deleted [https://www.googleapis.com/compute/v1/projects/gce-up-g1-4-glat-up-mas/zones/us-west1-b/instanceGroupManagers/bootstrap-e2e-minion-group].
W1025 16:00:08.465] done.
W1025 16:00:13.214] Deleted [https://www.googleapis.com/compute/v1/projects/gce-up-g1-4-glat-up-mas/global/instanceTemplates/bootstrap-e2e-minion-template].
W1025 16:00:14.510] Deleted [https://www.googleapis.com/compute/v1/projects/gce-up-g1-4-glat-up-mas/global/instanceTemplates/bootstrap-e2e-windows-node-template].
W1025 16:01:19.627] 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 16:01:19.627] Last attempt failed with: 
I1025 16:01:19.728] Removing etcd replica, name: bootstrap-e2e-master, port: 2379, result: 1
I1025 16:01:21.505] 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 16:01:21.505] Removing etcd replica, name: bootstrap-e2e-master, port: 4002, result: 0
W1025 16:01:26.078] Updated [https://www.googleapis.com/compute/v1/projects/gce-up-g1-4-glat-up-mas/zones/us-west1-b/instances/bootstrap-e2e-master].
W1025 16:03:19.474] Deleted [https://www.googleapis.com/compute/v1/projects/gce-up-g1-4-glat-up-mas/zones/us-west1-b/instances/bootstrap-e2e-master].
W1025 16:03:28.218] Deleted [https://www.googleapis.com/compute/v1/projects/gce-up-g1-4-glat-up-mas/global/firewalls/bootstrap-e2e-master-https].
... skipping 19 lines ...
I1025 16:04:28.809] Cleared config for gce-up-g1-4-glat-up-mas_bootstrap-e2e from /workspace/.kube/config
I1025 16:04:28.809] Done
W1025 16:04:28.836] W1025 16:04:28.804456   11091 loader.go:223] Config not found: /workspace/.kube/config
W1025 16:04:28.836] W1025 16:04:28.805039   11091 loader.go:223] Config not found: /workspace/.kube/config
W1025 16:04:28.836] 2020/10/25 16:04:28 process.go:155: Step './hack/e2e-internal/e2e-down.sh' finished in 5m10.067512082s
W1025 16:04:28.836] 2020/10/25 16:04:28 process.go:96: Saved XML output to /workspace/_artifacts/junit_runner.xml.
W1025 16:04:28.837] 2020/10/25 16:04:28 main.go:316: Something went wrong: starting e2e cluster: error during ./hack/e2e-internal/e2e-up.sh: exit status 2
W1025 16:04:28.837] Traceback (most recent call last):
W1025 16:04:28.837]   File "/workspace/./test-infra/jenkins/../scenarios/kubernetes_e2e.py", line 720, in <module>
W1025 16:04:28.838]     main(parse_args())
W1025 16:04:28.838]   File "/workspace/./test-infra/jenkins/../scenarios/kubernetes_e2e.py", line 570, in main
W1025 16:04:28.838]     mode.start(runner_args)
W1025 16:04:28.838]   File "/workspace/./test-infra/jenkins/../scenarios/kubernetes_e2e.py", line 228, in start
W1025 16:04:28.838]     check_env(env, self.command, *args)
W1025 16:04:28.838]   File "/workspace/./test-infra/jenkins/../scenarios/kubernetes_e2e.py", line 111, in check_env
W1025 16:04:28.838]     subprocess.check_call(cmd, env=env)
W1025 16:04:28.839]   File "/usr/lib/python2.7/subprocess.py", line 190, in check_call
W1025 16:04:28.839]     raise CalledProcessError(retcode, cmd)
W1025 16:04:28.839] 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 16:04:28.840] Command failed
I1025 16:04:28.840] process 266 exited with code 1 after 15.7m
E1025 16:04:28.840] FAIL: ci-kubernetes-e2e-gce-beta-stable1-downgrade-cluster-parallel
I1025 16:04:28.840] Call:  gcloud auth activate-service-account --key-file=/etc/service-account/service-account.json
W1025 16:04:29.498] Activated service account credentials for: [pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com]
I1025 16:04:29.608] process 11102 exited with code 0 after 0.0m
I1025 16:04:29.608] Call:  gcloud config get-value account
I1025 16:04:30.190] process 11115 exited with code 0 after 0.0m
I1025 16:04:30.190] Will upload results to gs://kubernetes-jenkins/logs using pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com
I1025 16:04:30.190] Upload result and artifacts...
I1025 16:04:30.191] Gubernator results at https://gubernator.k8s.io/build/kubernetes-jenkins/logs/ci-kubernetes-e2e-gce-beta-stable1-downgrade-cluster-parallel/1320391764661506048
I1025 16:04:30.191] Call:  gsutil ls gs://kubernetes-jenkins/logs/ci-kubernetes-e2e-gce-beta-stable1-downgrade-cluster-parallel/1320391764661506048/artifacts
W1025 16:04:31.149] CommandException: One or more URLs matched no objects.
E1025 16:04:31.345] Command failed
I1025 16:04:31.345] process 11128 exited with code 1 after 0.0m
W1025 16:04:31.345] Remote dir gs://kubernetes-jenkins/logs/ci-kubernetes-e2e-gce-beta-stable1-downgrade-cluster-parallel/1320391764661506048/artifacts not exist yet
I1025 16:04:31.345] 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/1320391764661506048/artifacts
I1025 16:04:33.662] process 11271 exited with code 0 after 0.0m
I1025 16:04:33.663] Call:  git rev-parse HEAD
W1025 16:04:33.667] fatal: not a git repository (or any of the parent directories): .git
E1025 16:04:33.667] Command failed
I1025 16:04:33.667] process 11916 exited with code 128 after 0.0m
I1025 16:04:33.667] Call:  git rev-parse HEAD
I1025 16:04:33.671] process 11917 exited with code 0 after 0.0m
I1025 16:04:33.671] Call:  gsutil stat gs://kubernetes-jenkins/logs/ci-kubernetes-e2e-gce-beta-stable1-downgrade-cluster-parallel/jobResultsCache.json
I1025 16:04:34.796] process 11918 exited with code 0 after 0.0m
I1025 16:04:34.797] Call:  gsutil -q cat 'gs://kubernetes-jenkins/logs/ci-kubernetes-e2e-gce-beta-stable1-downgrade-cluster-parallel/jobResultsCache.json#1603634611868393'
... skipping 8 lines ...