This job view page is being replaced by Spyglass soon. Check out the new job view.
ResultFAILURE
Tests 1 failed / 6 succeeded
Started2020-01-14 22:21
Elapsed20m26s
Revision
Buildergke-prow-default-pool-cf4891d4-hdxc
links{u'resultstore': {u'url': u'https://source.cloud.google.com/results/invocations/ac097064-8630-4754-9998-0a44f18c2c1b/targets/test'}}
pod025ca55e-371c-11ea-8603-da2f7a5855b4
resultstorehttps://source.cloud.google.com/results/invocations/ac097064-8630-4754-9998-0a44f18c2c1b/targets/test
infra-commit0dd34c2b2
job-versionv1.17.1-beta.0.52+d224476cd0730b
pod025ca55e-371c-11ea-8603-da2f7a5855b4
revisionv1.17.1-beta.0.52+d224476cd0730b

Test Failures


Up 7m26s

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 ...
I0114 22:21:02.219] process 47 exited with code 0 after 0.0m
I0114 22:21:02.219] Will upload results to gs://kubernetes-jenkins/logs using pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com
I0114 22:21:02.220] Root: /workspace
I0114 22:21:02.220] cd to /workspace
I0114 22:21:02.220] Configure environment...
I0114 22:21:02.220] Call:  git show -s --format=format:%ct HEAD
W0114 22:21:02.228] fatal: not a git repository (or any of the parent directories): .git
I0114 22:21:02.229] process 60 exited with code 128 after 0.0m
W0114 22:21:02.230] Unable to print commit date for HEAD
I0114 22:21:02.230] Call:  gcloud auth activate-service-account --key-file=/etc/service-account/service-account.json
W0114 22:21:02.900] Activated service account credentials for: [pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com]
I0114 22:21:03.227] process 61 exited with code 0 after 0.0m
I0114 22:21:03.227] Call:  gcloud config get-value account
... skipping 380 lines ...
W0114 22:25:34.633] Trying to find master named 'bootstrap-e2e-master'
W0114 22:25:34.633] Looking for address 'bootstrap-e2e-master-ip'
W0114 22:25:35.732] Using master: bootstrap-e2e-master (external IP: 34.82.242.62; internal IP: (not set))
I0114 22:25:35.833] Waiting up to 300 seconds for cluster initialization.
I0114 22:25:35.833] 
I0114 22:25:35.834]   This will continually check to see if the API for kubernetes is reachable.
I0114 22:25:35.834]   This may time out if there was some uncaught error during start up.
I0114 22:25:35.834] 
I0114 22:30:36.065] ................................................................................Checking for custom logdump instances, if any
I0114 22:30:36.083] Sourcing kube-util.sh
W0114 22:30:36.185] Cluster failed to initialize within 300 seconds.
W0114 22:30:36.186] Last output from querying API server follows:
W0114 22:30:36.186] -----------------------------------------------------
W0114 22:30:36.186]   % Total    % Received % Xferd  Average Speed   Time    Time     Time  Current
W0114 22:30:36.186]                                  Dload  Upload   Total   Spent    Left  Speed
W0114 22:30:36.187] 
  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
W0114 22:30:36.187] curl: (28) Operation timed out after 5001 milliseconds with 0 out of 0 bytes received
... skipping 16 lines ...
W0114 22:31:39.677] scp: /var/log/glbc.log*: No such file or directory
W0114 22:31:39.677] scp: /var/log/cluster-autoscaler.log*: No such file or directory
W0114 22:31:39.677] scp: /var/log/kube-addon-manager.log*: No such file or directory
W0114 22:31:39.678] scp: /var/log/fluentd.log*: No such file or directory
W0114 22:31:39.678] scp: /var/log/kubelet.cov*: No such file or directory
W0114 22:31:39.678] scp: /var/log/startupscript.log*: No such file or directory
W0114 22:31:39.689] ERROR: (gcloud.compute.scp) [/usr/bin/scp] exited with return code [1].
I0114 22:31:39.845] Dumping logs from nodes locally to '/workspace/_artifacts'
I0114 22:31:39.846] Detecting nodes in the cluster
I0114 22:32:58.334] Changing logfiles to be world-readable for download
I0114 22:32:59.430] Changing logfiles to be world-readable for download
I0114 22:33:00.110] Changing logfiles to be world-readable for download
I0114 22:33:03.555] Copying 'kube-proxy.log fluentd.log node-problem-detector.log kubelet.cov startupscript.log' from bootstrap-e2e-minion-group-xlmh
... skipping 6 lines ...
W0114 22:33:07.865] 
W0114 22:33:07.866] Specify --start=47152 in the next get-serial-port-output invocation to get only the new output starting from here.
W0114 22:33:08.239] scp: /var/log/fluentd.log*: No such file or directory
W0114 22:33:08.240] scp: /var/log/node-problem-detector.log*: No such file or directory
W0114 22:33:08.240] scp: /var/log/kubelet.cov*: No such file or directory
W0114 22:33:08.240] scp: /var/log/startupscript.log*: No such file or directory
W0114 22:33:08.244] ERROR: (gcloud.compute.scp) [/usr/bin/scp] exited with return code [1].
W0114 22:33:09.501] scp: /var/log/fluentd.log*: No such file or directory
W0114 22:33:09.501] scp: /var/log/node-problem-detector.log*: No such file or directory
W0114 22:33:09.501] scp: /var/log/kubelet.cov*: No such file or directory
W0114 22:33:09.502] scp: /var/log/startupscript.log*: No such file or directory
W0114 22:33:09.513] ERROR: (gcloud.compute.scp) [/usr/bin/scp] exited with return code [1].
W0114 22:33:10.543] scp: /var/log/fluentd.log*: No such file or directory
W0114 22:33:10.544] scp: /var/log/node-problem-detector.log*: No such file or directory
W0114 22:33:10.544] scp: /var/log/kubelet.cov*: No such file or directory
W0114 22:33:10.544] scp: /var/log/startupscript.log*: No such file or directory
W0114 22:33:10.549] ERROR: (gcloud.compute.scp) [/usr/bin/scp] exited with return code [1].
W0114 22:33:15.914] INSTANCE_GROUPS=bootstrap-e2e-minion-group
W0114 22:33:15.915] NODE_NAMES=bootstrap-e2e-minion-group-2f54 bootstrap-e2e-minion-group-6sqn bootstrap-e2e-minion-group-xlmh
I0114 22:33:17.367] Failures for bootstrap-e2e-minion-group (if any):
W0114 22:33:18.590] 2020/01/14 22:33:18 process.go:155: Step './cluster/log-dump/log-dump.sh /workspace/_artifacts' finished in 2m42.531346343s
W0114 22:33:18.591] 2020/01/14 22:33:18 process.go:153: Running: ./hack/e2e-internal/e2e-down.sh
W0114 22:33:18.689] Project: e2e-gce-gci-ci-slow-1-4
... skipping 12 lines ...
I0114 22:33:26.733] Bringing down cluster
W0114 22:33:30.728] Deleting Managed Instance Group...
W0114 22:35:25.892] ..........................Deleted [https://www.googleapis.com/compute/v1/projects/e2e-gce-gci-ci-slow-1-4/zones/us-west1-b/instanceGroupManagers/bootstrap-e2e-minion-group].
W0114 22:35:25.892] done.
W0114 22:35:31.866] Deleted [https://www.googleapis.com/compute/v1/projects/e2e-gce-gci-ci-slow-1-4/global/instanceTemplates/bootstrap-e2e-windows-node-template].
W0114 22:35:33.471] Deleted [https://www.googleapis.com/compute/v1/projects/e2e-gce-gci-ci-slow-1-4/global/instanceTemplates/bootstrap-e2e-minion-template].
W0114 22:36:39.373] 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
W0114 22:36:39.373] Last attempt failed with: 
I0114 22:36:39.474] Removing etcd replica, name: bootstrap-e2e-master, port: 2379, result: 1
I0114 22:36:41.521] 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
I0114 22:36:41.521] Removing etcd replica, name: bootstrap-e2e-master, port: 4002, result: 0
W0114 22:36:47.916] Updated [https://www.googleapis.com/compute/v1/projects/e2e-gce-gci-ci-slow-1-4/zones/us-west1-b/instances/bootstrap-e2e-master].
W0114 22:39:08.895] Deleted [https://www.googleapis.com/compute/v1/projects/e2e-gce-gci-ci-slow-1-4/zones/us-west1-b/instances/bootstrap-e2e-master].
W0114 22:39:25.843] Deleted [https://www.googleapis.com/compute/v1/projects/e2e-gce-gci-ci-slow-1-4/global/firewalls/bootstrap-e2e-master-https].
... skipping 19 lines ...
W0114 22:40:52.860] W0114 22:40:52.859539   10196 loader.go:223] Config not found: /workspace/.kube/config
W0114 22:40:52.869] 2020/01/14 22:40:52 process.go:155: Step './hack/e2e-internal/e2e-down.sh' finished in 7m34.278419852s
W0114 22:40:52.869] 2020/01/14 22:40:52 process.go:96: Saved XML output to /workspace/_artifacts/junit_runner.xml.
I0114 22:40:52.970] Property "contexts.e2e-gce-gci-ci-slow-1-4_bootstrap-e2e" unset.
I0114 22:40:52.971] Cleared config for e2e-gce-gci-ci-slow-1-4_bootstrap-e2e from /workspace/.kube/config
I0114 22:40:52.971] Done
W0114 22:41:19.732] 2020/01/14 22:41:19 main.go:316: Something went wrong: starting e2e cluster: error during ./hack/e2e-internal/e2e-up.sh: exit status 2
W0114 22:41:19.737] Traceback (most recent call last):
W0114 22:41:19.737]   File "/workspace/./test-infra/jenkins/../scenarios/kubernetes_e2e.py", line 778, in <module>
W0114 22:41:19.738]     main(parse_args())
W0114 22:41:19.739]   File "/workspace/./test-infra/jenkins/../scenarios/kubernetes_e2e.py", line 626, in main
W0114 22:41:19.739]     mode.start(runner_args)
W0114 22:41:19.739]   File "/workspace/./test-infra/jenkins/../scenarios/kubernetes_e2e.py", line 262, in start
W0114 22:41:19.739]     check_env(env, self.command, *args)
W0114 22:41:19.751]   File "/workspace/./test-infra/jenkins/../scenarios/kubernetes_e2e.py", line 111, in check_env
W0114 22:41:19.751]     subprocess.check_call(cmd, env=env)
W0114 22:41:19.751]   File "/usr/lib/python2.7/subprocess.py", line 190, in check_call
W0114 22:41:19.752]     raise CalledProcessError(retcode, cmd)
W0114 22:41:19.753] 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
E0114 22:41:19.753] Command failed
I0114 22:41:19.753] process 268 exited with code 1 after 20.2m
E0114 22:41:19.753] FAIL: ci-kubernetes-e2e-gce-beta-stable1-downgrade-cluster-parallel
I0114 22:41:19.754] Call:  gcloud auth activate-service-account --key-file=/etc/service-account/service-account.json
W0114 22:41:20.313] Activated service account credentials for: [pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com]
I0114 22:41:20.360] process 10207 exited with code 0 after 0.0m
I0114 22:41:20.361] Call:  gcloud config get-value account
I0114 22:41:20.675] process 10220 exited with code 0 after 0.0m
I0114 22:41:20.675] Will upload results to gs://kubernetes-jenkins/logs using pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com
I0114 22:41:20.675] Upload result and artifacts...
I0114 22:41:20.675] Gubernator results at https://gubernator.k8s.io/build/kubernetes-jenkins/logs/ci-kubernetes-e2e-gce-beta-stable1-downgrade-cluster-parallel/1217209915811041281
I0114 22:41:20.676] Call:  gsutil ls gs://kubernetes-jenkins/logs/ci-kubernetes-e2e-gce-beta-stable1-downgrade-cluster-parallel/1217209915811041281/artifacts
W0114 22:41:21.633] CommandException: One or more URLs matched no objects.
E0114 22:41:21.744] Command failed
I0114 22:41:21.745] process 10233 exited with code 1 after 0.0m
W0114 22:41:21.745] Remote dir gs://kubernetes-jenkins/logs/ci-kubernetes-e2e-gce-beta-stable1-downgrade-cluster-parallel/1217209915811041281/artifacts not exist yet
I0114 22:41:21.745] 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/1217209915811041281/artifacts
I0114 22:41:24.127] process 10378 exited with code 0 after 0.0m
I0114 22:41:24.128] Call:  git rev-parse HEAD
W0114 22:41:24.155] fatal: not a git repository (or any of the parent directories): .git
E0114 22:41:24.156] Command failed
I0114 22:41:24.156] process 11025 exited with code 128 after 0.0m
I0114 22:41:24.156] Call:  git rev-parse HEAD
I0114 22:41:24.163] process 11026 exited with code 0 after 0.0m
I0114 22:41:24.163] Call:  gsutil stat gs://kubernetes-jenkins/logs/ci-kubernetes-e2e-gce-beta-stable1-downgrade-cluster-parallel/jobResultsCache.json
I0114 22:41:25.238] process 11027 exited with code 0 after 0.0m
I0114 22:41:25.239] Call:  gsutil -q cat 'gs://kubernetes-jenkins/logs/ci-kubernetes-e2e-gce-beta-stable1-downgrade-cluster-parallel/jobResultsCache.json#1579034499555820'
... skipping 8 lines ...