This job view page is being replaced by Spyglass soon. Check out the new job view.
ResultFAILURE
Tests 1 failed / 6 succeeded
Started2020-01-15 12:27
Elapsed18m54s
Revision
Buildergke-prow-default-pool-cf4891d4-7kk8
links{u'resultstore': {u'url': u'https://source.cloud.google.com/results/invocations/b1021973-000d-4272-8eac-6bd223dda438/targets/test'}}
pod5601f2e3-3792-11ea-8603-da2f7a5855b4
resultstorehttps://source.cloud.google.com/results/invocations/b1021973-000d-4272-8eac-6bd223dda438/targets/test
infra-commitff065cbb3
job-versionv1.17.2-beta.0
pod5601f2e3-3792-11ea-8603-da2f7a5855b4
revisionv1.17.2-beta.0

Test Failures


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

Error lines from build-log.txt

... skipping 15 lines ...
I0115 12:27:51.322] process 47 exited with code 0 after 0.0m
I0115 12:27:51.323] Will upload results to gs://kubernetes-jenkins/logs using pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com
I0115 12:27:51.323] Root: /workspace
I0115 12:27:51.323] cd to /workspace
I0115 12:27:51.323] Configure environment...
I0115 12:27:51.323] Call:  git show -s --format=format:%ct HEAD
W0115 12:27:51.328] fatal: not a git repository (or any of the parent directories): .git
I0115 12:27:51.328] process 60 exited with code 128 after 0.0m
W0115 12:27:51.328] Unable to print commit date for HEAD
I0115 12:27:51.328] Call:  gcloud auth activate-service-account --key-file=/etc/service-account/service-account.json
W0115 12:27:51.876] Activated service account credentials for: [pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com]
I0115 12:27:52.199] process 61 exited with code 0 after 0.0m
I0115 12:27:52.199] Call:  gcloud config get-value account
... skipping 380 lines ...
W0115 12:31:38.425] Trying to find master named 'bootstrap-e2e-master'
W0115 12:31:38.425] Looking for address 'bootstrap-e2e-master-ip'
W0115 12:31:39.310] Using master: bootstrap-e2e-master (external IP: 34.83.40.32; internal IP: (not set))
I0115 12:31:39.411] Waiting up to 300 seconds for cluster initialization.
I0115 12:31:39.411] 
I0115 12:31:39.411]   This will continually check to see if the API for kubernetes is reachable.
I0115 12:31:39.411]   This may time out if there was some uncaught error during start up.
I0115 12:31:39.411] 
I0115 12:36:42.541] ..................................................................................Checking for custom logdump instances, if any
I0115 12:36:42.549] Sourcing kube-util.sh
I0115 12:36:42.611] Detecting project
I0115 12:36:42.611] Project: gce-cvm-upg-1-3-lat-ctl-skew
I0115 12:36:42.613] Network Project: gce-cvm-upg-1-3-lat-ctl-skew
I0115 12:36:42.613] Zone: us-west1-b
I0115 12:36:42.613] Dumping logs from master locally to '/workspace/_artifacts'
W0115 12:36:42.714] Cluster failed to initialize within 300 seconds.
W0115 12:36:42.714] Last output from querying API server follows:
W0115 12:36:42.714] -----------------------------------------------------
W0115 12:36:42.714]   % Total    % Received % Xferd  Average Speed   Time    Time     Time  Current
W0115 12:36:42.715]                                  Dload  Upload   Total   Spent    Left  Speed
W0115 12:36:42.715] 
  0     0    0     0    0     0      0      0 --:--:-- --:--:-- --:--:--     0
  0     0    0     0    0     0      0      0 --:--:-- --:--:-- --:--:--     0
  0     0    0     0    0     0      0      0 --:--:--  0:00:01 --:--:--     0
  0     0    0     0    0     0      0      0 --:--:--  0:00:02 --:--:--     0
  0     0    0     0    0     0      0      0 --:--:--  0:00:03 --:--:--     0
  0     0    0     0    0     0      0      0 --:--:--  0:00:04 --:--:--     0
  0     0    0     0    0     0      0      0 --:--:--  0:00:05 --:--:--     0
W0115 12:36:42.715] curl: (28) Operation timed out after 5000 milliseconds with 0 out of 0 bytes received
... skipping 11 lines ...
W0115 12:37:24.559] scp: /var/log/glbc.log*: No such file or directory
W0115 12:37:24.560] scp: /var/log/cluster-autoscaler.log*: No such file or directory
W0115 12:37:24.560] scp: /var/log/kube-addon-manager.log*: No such file or directory
W0115 12:37:24.560] scp: /var/log/fluentd.log*: No such file or directory
W0115 12:37:24.560] scp: /var/log/kubelet.cov*: No such file or directory
W0115 12:37:24.561] scp: /var/log/startupscript.log*: No such file or directory
W0115 12:37:24.563] ERROR: (gcloud.compute.scp) [/usr/bin/scp] exited with return code [1].
I0115 12:37:24.663] Dumping logs from nodes locally to '/workspace/_artifacts'
I0115 12:37:24.664] Detecting nodes in the cluster
I0115 12:38:29.319] Changing logfiles to be world-readable for download
I0115 12:38:30.667] Changing logfiles to be world-readable for download
I0115 12:38:30.707] Changing logfiles to be world-readable for download
I0115 12:38:32.874] Copying 'kube-proxy.log fluentd.log node-problem-detector.log kubelet.cov startupscript.log' from bootstrap-e2e-minion-group-2bm3
... skipping 6 lines ...
W0115 12:38:35.944] 
W0115 12:38:35.944] Specify --start=47247 in the next get-serial-port-output invocation to get only the new output starting from here.
W0115 12:38:36.368] scp: /var/log/fluentd.log*: No such file or directory
W0115 12:38:36.369] scp: /var/log/node-problem-detector.log*: No such file or directory
W0115 12:38:36.369] scp: /var/log/kubelet.cov*: No such file or directory
W0115 12:38:36.369] scp: /var/log/startupscript.log*: No such file or directory
W0115 12:38:36.373] ERROR: (gcloud.compute.scp) [/usr/bin/scp] exited with return code [1].
W0115 12:38:37.667] scp: /var/log/fluentd.log*: No such file or directory
W0115 12:38:37.668] scp: /var/log/node-problem-detector.log*: No such file or directory
W0115 12:38:37.668] scp: /var/log/kubelet.cov*: No such file or directory
W0115 12:38:37.668] scp: /var/log/startupscript.log*: No such file or directory
W0115 12:38:37.671] ERROR: (gcloud.compute.scp) [/usr/bin/scp] exited with return code [1].
W0115 12:38:37.711] scp: /var/log/fluentd.log*: No such file or directory
W0115 12:38:37.712] scp: /var/log/node-problem-detector.log*: No such file or directory
W0115 12:38:37.712] scp: /var/log/kubelet.cov*: No such file or directory
W0115 12:38:37.712] scp: /var/log/startupscript.log*: No such file or directory
W0115 12:38:37.716] ERROR: (gcloud.compute.scp) [/usr/bin/scp] exited with return code [1].
W0115 12:38:41.939] INSTANCE_GROUPS=bootstrap-e2e-minion-group
W0115 12:38:41.939] NODE_NAMES=bootstrap-e2e-minion-group-2bm3 bootstrap-e2e-minion-group-gw73 bootstrap-e2e-minion-group-qgj8
I0115 12:38:43.735] Failures for bootstrap-e2e-minion-group (if any):
W0115 12:38:44.874] 2020/01/15 12:38:44 process.go:155: Step './cluster/log-dump/log-dump.sh /workspace/_artifacts' finished in 2m2.336069953s
W0115 12:38:44.875] 2020/01/15 12:38:44 process.go:153: Running: ./hack/e2e-internal/e2e-down.sh
W0115 12:38:44.970] Project: gce-cvm-upg-1-3-lat-ctl-skew
... skipping 12 lines ...
I0115 12:38:51.127] Bringing down cluster
W0115 12:38:53.863] Deleting Managed Instance Group...
W0115 12:40:08.185] ..................Deleted [https://www.googleapis.com/compute/v1/projects/gce-cvm-upg-1-3-lat-ctl-skew/zones/us-west1-b/instanceGroupManagers/bootstrap-e2e-minion-group].
W0115 12:40:08.185] done.
W0115 12:40:12.502] Deleted [https://www.googleapis.com/compute/v1/projects/gce-cvm-upg-1-3-lat-ctl-skew/global/instanceTemplates/bootstrap-e2e-minion-template].
W0115 12:40:18.970] Deleted [https://www.googleapis.com/compute/v1/projects/gce-cvm-upg-1-3-lat-ctl-skew/global/instanceTemplates/bootstrap-e2e-windows-node-template].
W0115 12:41:21.039] 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
W0115 12:41:21.039] Last attempt failed with: 
I0115 12:41:21.140] Removing etcd replica, name: bootstrap-e2e-master, port: 2379, result: 1
I0115 12:41:22.886] 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
I0115 12:41:22.887] Removing etcd replica, name: bootstrap-e2e-master, port: 4002, result: 0
W0115 12:41:28.470] Updated [https://www.googleapis.com/compute/v1/projects/gce-cvm-upg-1-3-lat-ctl-skew/zones/us-west1-b/instances/bootstrap-e2e-master].
W0115 12:44:01.194] Deleted [https://www.googleapis.com/compute/v1/projects/gce-cvm-upg-1-3-lat-ctl-skew/zones/us-west1-b/instances/bootstrap-e2e-master].
W0115 12:44:13.334] Deleted [https://www.googleapis.com/compute/v1/projects/gce-cvm-upg-1-3-lat-ctl-skew/global/firewalls/bootstrap-e2e-master-https].
... skipping 19 lines ...
I0115 12:45:49.132] Cleared config for gce-cvm-upg-1-3-lat-ctl-skew_bootstrap-e2e from /workspace/.kube/config
I0115 12:45:49.138] Done
W0115 12:45:49.239] W0115 12:45:49.103269   10221 loader.go:223] Config not found: /workspace/.kube/config
W0115 12:45:49.268] W0115 12:45:49.103599   10221 loader.go:223] Config not found: /workspace/.kube/config
W0115 12:45:49.331] 2020/01/15 12:45:49 process.go:155: Step './hack/e2e-internal/e2e-down.sh' finished in 7m4.264488829s
W0115 12:45:49.333] 2020/01/15 12:45:49 process.go:96: Saved XML output to /workspace/_artifacts/junit_runner.xml.
W0115 12:45:52.480] 2020/01/15 12:45:52 main.go:316: Something went wrong: starting e2e cluster: error during ./hack/e2e-internal/e2e-up.sh: exit status 2
W0115 12:45:52.528] Traceback (most recent call last):
W0115 12:45:52.532]   File "/workspace/./test-infra/jenkins/../scenarios/kubernetes_e2e.py", line 778, in <module>
W0115 12:45:52.532]     main(parse_args())
W0115 12:45:52.533]   File "/workspace/./test-infra/jenkins/../scenarios/kubernetes_e2e.py", line 626, in main
W0115 12:45:52.533]     mode.start(runner_args)
W0115 12:45:52.534]   File "/workspace/./test-infra/jenkins/../scenarios/kubernetes_e2e.py", line 262, in start
W0115 12:45:52.534]     check_env(env, self.command, *args)
W0115 12:45:52.535]   File "/workspace/./test-infra/jenkins/../scenarios/kubernetes_e2e.py", line 111, in check_env
W0115 12:45:52.535]     subprocess.check_call(cmd, env=env)
W0115 12:45:52.536]   File "/usr/lib/python2.7/subprocess.py", line 190, in check_call
W0115 12:45:52.537]     raise CalledProcessError(retcode, cmd)
W0115 12:45:52.549] 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
E0115 12:45:52.554] Command failed
I0115 12:45:52.554] process 268 exited with code 1 after 18.0m
E0115 12:45:52.555] FAIL: ci-kubernetes-e2e-gce-beta-stable1-downgrade-cluster-parallel
I0115 12:45:52.556] Call:  gcloud auth activate-service-account --key-file=/etc/service-account/service-account.json
W0115 12:45:58.336] Activated service account credentials for: [pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com]
I0115 12:45:59.026] process 10232 exited with code 0 after 0.1m
I0115 12:45:59.027] Call:  gcloud config get-value account
I0115 12:46:01.000] process 10245 exited with code 0 after 0.0m
I0115 12:46:01.000] Will upload results to gs://kubernetes-jenkins/logs using pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com
I0115 12:46:01.001] Upload result and artifacts...
I0115 12:46:01.001] Gubernator results at https://gubernator.k8s.io/build/kubernetes-jenkins/logs/ci-kubernetes-e2e-gce-beta-stable1-downgrade-cluster-parallel/1217423083757899777
I0115 12:46:01.001] Call:  gsutil ls gs://kubernetes-jenkins/logs/ci-kubernetes-e2e-gce-beta-stable1-downgrade-cluster-parallel/1217423083757899777/artifacts
W0115 12:46:06.544] CommandException: One or more URLs matched no objects.
E0115 12:46:06.783] Command failed
I0115 12:46:06.783] process 10258 exited with code 1 after 0.1m
W0115 12:46:06.784] Remote dir gs://kubernetes-jenkins/logs/ci-kubernetes-e2e-gce-beta-stable1-downgrade-cluster-parallel/1217423083757899777/artifacts not exist yet
I0115 12:46:06.784] 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/1217423083757899777/artifacts
I0115 12:46:30.255] process 10403 exited with code 0 after 0.4m
I0115 12:46:30.256] Call:  git rev-parse HEAD
W0115 12:46:30.262] fatal: not a git repository (or any of the parent directories): .git
E0115 12:46:30.263] Command failed
I0115 12:46:30.263] process 11050 exited with code 128 after 0.0m
I0115 12:46:30.264] Call:  git rev-parse HEAD
I0115 12:46:30.301] process 11051 exited with code 0 after 0.0m
I0115 12:46:30.302] Call:  gsutil stat gs://kubernetes-jenkins/logs/ci-kubernetes-e2e-gce-beta-stable1-downgrade-cluster-parallel/jobResultsCache.json
I0115 12:46:37.355] process 11052 exited with code 0 after 0.1m
I0115 12:46:37.356] Call:  gsutil -q cat 'gs://kubernetes-jenkins/logs/ci-kubernetes-e2e-gce-beta-stable1-downgrade-cluster-parallel/jobResultsCache.json#1579085199639146'
... skipping 8 lines ...