This job view page is being replaced by Spyglass soon. Check out the new job view.
ResultFAILURE
Tests 1 failed / 6 succeeded
Started2020-10-26 05:55
Elapsed16m24s
Revision
Builderd5d6b6b2-174f-11eb-b256-6ee25ea2e440
infra-commitd88010efd
job-versionv1.19.4-rc.0.22+9e8ad8ce9d8a30
revisionv1.19.4-rc.0.22+9e8ad8ce9d8a30

Test Failures


Up 7m14s

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 ...
I1026 05:55:38.410] process 48 exited with code 0 after 0.0m
I1026 05:55:38.410] Will upload results to gs://kubernetes-jenkins/logs using pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com
I1026 05:55:38.411] Root: /workspace
I1026 05:55:38.411] cd to /workspace
I1026 05:55:38.411] Configure environment...
I1026 05:55:38.411] Call:  git show -s --format=format:%ct HEAD
W1026 05:55:38.415] fatal: not a git repository (or any of the parent directories): .git
I1026 05:55:38.415] process 61 exited with code 128 after 0.0m
W1026 05:55:38.415] Unable to print commit date for HEAD
I1026 05:55:38.416] Call:  gcloud auth activate-service-account --key-file=/etc/service-account/service-account.json
W1026 05:55:39.092] Activated service account credentials for: [pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com]
I1026 05:55:39.317] process 62 exited with code 0 after 0.0m
I1026 05:55:39.317] Call:  gcloud config get-value account
... skipping 373 lines ...
W1026 05:59:51.454] Trying to find master named 'bootstrap-e2e-master'
W1026 05:59:51.455] Looking for address 'bootstrap-e2e-master-ip'
W1026 05:59:52.553] Using master: bootstrap-e2e-master (external IP: 34.82.55.120; internal IP: (not set))
I1026 05:59:52.654] Waiting up to 300 seconds for cluster initialization.
I1026 05:59:52.654] 
I1026 05:59:52.655]   This will continually check to see if the API for kubernetes is reachable.
I1026 05:59:52.655]   This may time out if there was some uncaught error during start up.
I1026 05:59:52.655] 
I1026 06:04:53.914] ................................................................................................Checking for custom logdump instances, if any
I1026 06:04:53.920] Sourcing kube-util.sh
I1026 06:04:53.986] Detecting project
I1026 06:04:53.987] Project: k8s-jkns-e2e-gce-slow-1-2
I1026 06:04:53.987] Network Project: k8s-jkns-e2e-gce-slow-1-2
I1026 06:04:53.987] Zone: us-west1-b
I1026 06:04:53.987] Dumping logs from master locally to '/workspace/_artifacts'
W1026 06:04:54.088] Cluster failed to initialize within 300 seconds.
W1026 06:04:54.088] Last output from querying API server follows:
W1026 06:04:54.088] -----------------------------------------------------
W1026 06:04:54.088] * Expire in 0 ms for 6 (transfer 0x5579499fff50)
W1026 06:04:54.089] * Expire in 5000 ms for 8 (transfer 0x5579499fff50)
W1026 06:04:54.089] *   Trying 34.82.55.120...
W1026 06:04:54.089] * TCP_NODELAY set
W1026 06:04:54.089] * Expire in 200 ms for 4 (transfer 0x5579499fff50)
W1026 06:04:54.089] * connect to 34.82.55.120 port 443 failed: Connection refused
W1026 06:04:54.089] * Failed to connect to 34.82.55.120 port 443: Connection refused
W1026 06:04:54.089] * Closing connection 0
W1026 06:04:54.090] curl: (7) Failed to connect to 34.82.55.120 port 443: Connection refused
W1026 06:04:54.090] -----------------------------------------------------
W1026 06:04:54.090] 2020/10/26 06:04:53 process.go:155: Step './hack/e2e-internal/e2e-up.sh' finished in 7m14.887389599s
W1026 06:04:54.090] 2020/10/26 06:04:53 e2e.go:544: Dumping logs locally to: /workspace/_artifacts
W1026 06:04:54.090] 2020/10/26 06:04:53 process.go:153: Running: ./cluster/log-dump/log-dump.sh /workspace/_artifacts
W1026 06:04:54.090] Trying to find master named 'bootstrap-e2e-master'
W1026 06:04:54.091] Looking for address 'bootstrap-e2e-master-ip'
... skipping 6 lines ...
W1026 06:05:38.474] scp: /var/log/cluster-autoscaler.log*: No such file or directory
W1026 06:05:38.474] scp: /var/log/kube-addon-manager.log*: No such file or directory
W1026 06:05:38.474] scp: /var/log/konnectivity-server.log*: No such file or directory
W1026 06:05:38.474] scp: /var/log/fluentd.log*: No such file or directory
W1026 06:05:38.474] scp: /var/log/kubelet.cov*: No such file or directory
W1026 06:05:38.474] scp: /var/log/startupscript.log*: No such file or directory
W1026 06:05:38.481] ERROR: (gcloud.compute.scp) [/usr/bin/scp] exited with return code [1].
I1026 06:05:38.685] Dumping logs from nodes locally to '/workspace/_artifacts'
I1026 06:05:38.685] Detecting nodes in the cluster
I1026 06:06:27.443] Changing logfiles to be world-readable for download
I1026 06:06:27.494] Changing logfiles to be world-readable for download
I1026 06:06:27.943] Changing logfiles to be world-readable for download
I1026 06:06:32.283] Copying 'kube-proxy.log fluentd.log node-problem-detector.log kubelet.cov  startupscript.log' from bootstrap-e2e-minion-group-3k92
... skipping 6 lines ...
W1026 06:06:34.521] 
W1026 06:06:34.522] Specify --start=43948 in the next get-serial-port-output invocation to get only the new output starting from here.
W1026 06:06:36.543] scp: /var/log/fluentd.log*: No such file or directory
W1026 06:06:36.544] scp: /var/log/node-problem-detector.log*: No such file or directory
W1026 06:06:36.544] scp: /var/log/kubelet.cov*: No such file or directory
W1026 06:06:36.545] scp: /var/log/startupscript.log*: No such file or directory
W1026 06:06:36.555] ERROR: (gcloud.compute.scp) [/usr/bin/scp] exited with return code [1].
W1026 06:06:36.786] scp: /var/log/fluentd.log*: No such file or directory
W1026 06:06:36.787] scp: /var/log/node-problem-detector.log*: No such file or directory
W1026 06:06:36.787] scp: /var/log/kubelet.cov*: No such file or directory
W1026 06:06:36.788] scp: /var/log/startupscript.log*: No such file or directory
W1026 06:06:36.795] ERROR: (gcloud.compute.scp) [/usr/bin/scp] exited with return code [1].
W1026 06:06:37.116] scp: /var/log/fluentd.log*: No such file or directory
W1026 06:06:37.117] scp: /var/log/node-problem-detector.log*: No such file or directory
W1026 06:06:37.118] scp: /var/log/kubelet.cov*: No such file or directory
W1026 06:06:37.119] scp: /var/log/startupscript.log*: No such file or directory
W1026 06:06:37.124] ERROR: (gcloud.compute.scp) [/usr/bin/scp] exited with return code [1].
W1026 06:06:43.250] INSTANCE_GROUPS=bootstrap-e2e-minion-group
W1026 06:06:43.250] NODE_NAMES=bootstrap-e2e-minion-group-3k92 bootstrap-e2e-minion-group-5fnh bootstrap-e2e-minion-group-p0pg
I1026 06:06:44.460] Failures for bootstrap-e2e-minion-group (if any):
W1026 06:06:46.099] 2020/10/26 06:06:46 process.go:155: Step './cluster/log-dump/log-dump.sh /workspace/_artifacts' finished in 1m52.187203831s
W1026 06:06:46.100] 2020/10/26 06:06:46 process.go:153: Running: ./hack/e2e-internal/e2e-down.sh
W1026 06:06:46.167] Project: k8s-jkns-e2e-gce-slow-1-2
... skipping 13 lines ...
W1026 06:07:30.319] Deleting Managed Instance Group...
W1026 06:07:30.319] ..Deleted [https://www.googleapis.com/compute/v1/projects/k8s-jkns-e2e-gce-slow-1-2/zones/us-west1-b/instanceGroupManagers/bootstrap-e2e-minion-group].
W1026 06:07:30.322] done.
W1026 06:07:34.577] Deleted [https://www.googleapis.com/compute/v1/projects/k8s-jkns-e2e-gce-slow-1-2/global/instanceTemplates/bootstrap-e2e-minion-template].
W1026 06:07:37.107] Deleted [https://www.googleapis.com/compute/v1/projects/k8s-jkns-e2e-gce-slow-1-2/global/instanceTemplates/bootstrap-e2e-windows-node-template].
I1026 06:08:42.600] Removing etcd replica, name: bootstrap-e2e-master, port: 2379, result: 1
W1026 06:08:42.701] 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
W1026 06:08:42.702] Last attempt failed with: 
I1026 06:08:45.152] 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
I1026 06:08:45.153] Removing etcd replica, name: bootstrap-e2e-master, port: 4002, result: 0
W1026 06:08:51.200] Updated [https://www.googleapis.com/compute/v1/projects/k8s-jkns-e2e-gce-slow-1-2/zones/us-west1-b/instances/bootstrap-e2e-master].
W1026 06:10:36.674] Deleted [https://www.googleapis.com/compute/v1/projects/k8s-jkns-e2e-gce-slow-1-2/zones/us-west1-b/instances/bootstrap-e2e-master].
W1026 06:10:45.539] Deleted [https://www.googleapis.com/compute/v1/projects/k8s-jkns-e2e-gce-slow-1-2/global/firewalls/bootstrap-e2e-master-https].
W1026 06:10:47.680] Deleted [https://www.googleapis.com/compute/v1/projects/k8s-jkns-e2e-gce-slow-1-2/global/firewalls/bootstrap-e2e-master-etcd].
... skipping 18 lines ...
I1026 06:11:51.936] Cleared config for k8s-jkns-e2e-gce-slow-1-2_bootstrap-e2e from /workspace/.kube/config
I1026 06:11:51.936] Done
W1026 06:11:51.966] W1026 06:11:51.931005   11055 loader.go:223] Config not found: /workspace/.kube/config
W1026 06:11:51.966] W1026 06:11:51.931209   11055 loader.go:223] Config not found: /workspace/.kube/config
W1026 06:11:51.967] 2020/10/26 06:11:51 process.go:155: Step './hack/e2e-internal/e2e-down.sh' finished in 5m5.839380701s
W1026 06:11:51.967] 2020/10/26 06:11:51 process.go:96: Saved XML output to /workspace/_artifacts/junit_runner.xml.
W1026 06:11:51.967] 2020/10/26 06:11:51 main.go:316: Something went wrong: starting e2e cluster: error during ./hack/e2e-internal/e2e-up.sh: exit status 2
W1026 06:11:51.967] Traceback (most recent call last):
W1026 06:11:51.967]   File "/workspace/./test-infra/jenkins/../scenarios/kubernetes_e2e.py", line 720, in <module>
W1026 06:11:51.968]     main(parse_args())
W1026 06:11:51.968]   File "/workspace/./test-infra/jenkins/../scenarios/kubernetes_e2e.py", line 570, in main
W1026 06:11:51.968]     mode.start(runner_args)
W1026 06:11:51.968]   File "/workspace/./test-infra/jenkins/../scenarios/kubernetes_e2e.py", line 228, in start
W1026 06:11:51.968]     check_env(env, self.command, *args)
W1026 06:11:51.969]   File "/workspace/./test-infra/jenkins/../scenarios/kubernetes_e2e.py", line 111, in check_env
W1026 06:11:51.969]     subprocess.check_call(cmd, env=env)
W1026 06:11:51.969]   File "/usr/lib/python2.7/subprocess.py", line 190, in check_call
W1026 06:11:51.969]     raise CalledProcessError(retcode, cmd)
W1026 06:11:51.970] 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
E1026 06:11:51.970] Command failed
I1026 06:11:51.971] process 267 exited with code 1 after 16.2m
E1026 06:11:51.971] FAIL: ci-kubernetes-e2e-gce-beta-stable1-downgrade-cluster-parallel
I1026 06:11:51.971] Call:  gcloud auth activate-service-account --key-file=/etc/service-account/service-account.json
W1026 06:11:52.683] Activated service account credentials for: [pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com]
I1026 06:11:52.825] process 11065 exited with code 0 after 0.0m
I1026 06:11:52.825] Call:  gcloud config get-value account
I1026 06:11:53.472] process 11078 exited with code 0 after 0.0m
I1026 06:11:53.473] Will upload results to gs://kubernetes-jenkins/logs using pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com
I1026 06:11:53.473] Upload result and artifacts...
I1026 06:11:53.473] Gubernator results at https://gubernator.k8s.io/build/kubernetes-jenkins/logs/ci-kubernetes-e2e-gce-beta-stable1-downgrade-cluster-parallel/1320604915831148544
I1026 06:11:53.474] Call:  gsutil ls gs://kubernetes-jenkins/logs/ci-kubernetes-e2e-gce-beta-stable1-downgrade-cluster-parallel/1320604915831148544/artifacts
W1026 06:11:54.429] CommandException: One or more URLs matched no objects.
E1026 06:11:54.613] Command failed
I1026 06:11:54.613] process 11091 exited with code 1 after 0.0m
W1026 06:11:54.613] Remote dir gs://kubernetes-jenkins/logs/ci-kubernetes-e2e-gce-beta-stable1-downgrade-cluster-parallel/1320604915831148544/artifacts not exist yet
I1026 06:11:54.613] 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/1320604915831148544/artifacts
I1026 06:11:56.817] process 11234 exited with code 0 after 0.0m
I1026 06:11:56.818] Call:  git rev-parse HEAD
W1026 06:11:56.822] fatal: not a git repository (or any of the parent directories): .git
E1026 06:11:56.822] Command failed
I1026 06:11:56.822] process 11879 exited with code 128 after 0.0m
I1026 06:11:56.823] Call:  git rev-parse HEAD
I1026 06:11:56.826] process 11880 exited with code 0 after 0.0m
I1026 06:11:56.827] Call:  gsutil stat gs://kubernetes-jenkins/logs/ci-kubernetes-e2e-gce-beta-stable1-downgrade-cluster-parallel/jobResultsCache.json
I1026 06:11:57.983] process 11881 exited with code 0 after 0.0m
I1026 06:11:57.984] Call:  gsutil -q cat 'gs://kubernetes-jenkins/logs/ci-kubernetes-e2e-gce-beta-stable1-downgrade-cluster-parallel/jobResultsCache.json#1603685399109072'
... skipping 8 lines ...