This job view page is being replaced by Spyglass soon. Check out the new job view.
ResultFAILURE
Tests 1 failed / 6 succeeded
Started2019-12-29 22:01
Elapsed21m16s
Revision
Buildergke-prow-ssd-pool-1a225945-03kr
links{u'resultstore': {u'url': u'https://source.cloud.google.com/results/invocations/225b07f6-1f8e-4601-9e60-dee33c1aa71f/targets/test'}}
pod9af94dc9-2a86-11ea-a07b-c6eb1bf16817
resultstorehttps://source.cloud.google.com/results/invocations/225b07f6-1f8e-4601-9e60-dee33c1aa71f/targets/test
infra-commit09d9247dc
job-versionv1.17.1-beta.0.30+7d04da8a4a80f2
pod9af94dc9-2a86-11ea-a07b-c6eb1bf16817
revisionv1.17.1-beta.0.30+7d04da8a4a80f2

Test Failures


Up 9m46s

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 ...
I1229 22:01:03.807] process 47 exited with code 0 after 0.0m
I1229 22:01:03.808] Will upload results to gs://kubernetes-jenkins/logs using pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com
I1229 22:01:03.809] Root: /workspace
I1229 22:01:03.810] cd to /workspace
I1229 22:01:03.810] Configure environment...
I1229 22:01:03.811] Call:  git show -s --format=format:%ct HEAD
W1229 22:01:03.819] fatal: not a git repository (or any of the parent directories): .git
I1229 22:01:03.821] process 60 exited with code 128 after 0.0m
W1229 22:01:03.821] Unable to print commit date for HEAD
I1229 22:01:03.821] Call:  gcloud auth activate-service-account --key-file=/etc/service-account/service-account.json
W1229 22:01:04.512] Activated service account credentials for: [pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com]
I1229 22:01:04.668] process 61 exited with code 0 after 0.0m
I1229 22:01:04.669] Call:  gcloud config get-value account
... skipping 389 lines ...
W1229 22:07:42.334] NODE_NAMES=bootstrap-e2e-minion-group-4s55 bootstrap-e2e-minion-group-69lk bootstrap-e2e-minion-group-nwtg
W1229 22:07:42.334] Trying to find master named 'bootstrap-e2e-master'
W1229 22:07:42.334] Looking for address 'bootstrap-e2e-master-ip'
I1229 22:07:43.467] Waiting up to 300 seconds for cluster initialization.
I1229 22:07:43.468] 
I1229 22:07:43.468]   This will continually check to see if the API for kubernetes is reachable.
I1229 22:07:43.469]   This may time out if there was some uncaught error during start up.
I1229 22:07:43.469] 
W1229 22:07:43.570] Using master: bootstrap-e2e-master (external IP: 104.196.241.63; internal IP: (not set))
I1229 22:12:49.753] ..........................................................................................Checking for custom logdump instances, if any
I1229 22:12:49.763] Sourcing kube-util.sh
W1229 22:12:49.865] Cluster failed to initialize within 300 seconds.
W1229 22:12:49.865] Last output from querying API server follows:
W1229 22:12:49.865] -----------------------------------------------------
W1229 22:12:49.866]   % Total    % Received % Xferd  Average Speed   Time    Time     Time  Current
W1229 22:12:49.866]                                  Dload  Upload   Total   Spent    Left  Speed
W1229 22:12:49.866] 
  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
W1229 22:12:49.866] curl: (28) Operation timed out after 5000 milliseconds with 0 out of 0 bytes received
... skipping 16 lines ...
W1229 22:13:38.995] scp: /var/log/glbc.log*: No such file or directory
W1229 22:13:38.996] scp: /var/log/cluster-autoscaler.log*: No such file or directory
W1229 22:13:38.996] scp: /var/log/kube-addon-manager.log*: No such file or directory
W1229 22:13:38.996] scp: /var/log/fluentd.log*: No such file or directory
W1229 22:13:38.996] scp: /var/log/kubelet.cov*: No such file or directory
W1229 22:13:38.997] scp: /var/log/startupscript.log*: No such file or directory
W1229 22:13:39.003] ERROR: (gcloud.compute.scp) [/usr/bin/scp] exited with return code [1].
I1229 22:13:39.128] Dumping logs from nodes locally to '/workspace/_artifacts'
I1229 22:13:39.128] Detecting nodes in the cluster
I1229 22:14:27.624] Changing logfiles to be world-readable for download
I1229 22:14:27.631] Changing logfiles to be world-readable for download
I1229 22:14:27.780] Changing logfiles to be world-readable for download
I1229 22:14:32.118] Copying 'kube-proxy.log fluentd.log node-problem-detector.log kubelet.cov startupscript.log' from bootstrap-e2e-minion-group-69lk
... skipping 6 lines ...
W1229 22:14:33.877] 
W1229 22:14:33.878] Specify --start=39061 in the next get-serial-port-output invocation to get only the new output starting from here.
W1229 22:14:36.015] scp: /var/log/fluentd.log*: No such file or directory
W1229 22:14:36.016] scp: /var/log/node-problem-detector.log*: No such file or directory
W1229 22:14:36.016] scp: /var/log/kubelet.cov*: No such file or directory
W1229 22:14:36.016] scp: /var/log/startupscript.log*: No such file or directory
W1229 22:14:36.020] ERROR: (gcloud.compute.scp) [/usr/bin/scp] exited with return code [1].
W1229 22:14:36.075] scp: /var/log/fluentd.log*: No such file or directory
W1229 22:14:36.075] scp: /var/log/node-problem-detector.log*: No such file or directory
W1229 22:14:36.075] scp: /var/log/kubelet.cov*: No such file or directory
W1229 22:14:36.076] scp: /var/log/startupscript.log*: No such file or directory
W1229 22:14:36.081] scp: /var/log/fluentd.log*: No such file or directory
W1229 22:14:36.082] scp: /var/log/node-problem-detector.log*: No such file or directory
W1229 22:14:36.084] scp: /var/log/kubelet.cov*: No such file or directory
W1229 22:14:36.084] scp: /var/log/startupscript.log*: No such file or directory
W1229 22:14:36.084] ERROR: (gcloud.compute.scp) [/usr/bin/scp] exited with return code [1].
W1229 22:14:36.088] ERROR: (gcloud.compute.scp) [/usr/bin/scp] exited with return code [1].
W1229 22:14:41.008] INSTANCE_GROUPS=bootstrap-e2e-minion-group
W1229 22:14:41.008] NODE_NAMES=bootstrap-e2e-minion-group-4s55 bootstrap-e2e-minion-group-69lk bootstrap-e2e-minion-group-nwtg
I1229 22:14:42.513] Failures for bootstrap-e2e-minion-group (if any):
W1229 22:14:43.928] 2019/12/29 22:14:43 process.go:155: Step './cluster/log-dump/log-dump.sh /workspace/_artifacts' finished in 1m54.18059975s
W1229 22:14:43.928] 2019/12/29 22:14:43 process.go:153: Running: ./hack/e2e-internal/e2e-down.sh
W1229 22:14:44.061] Project: k8s-jkns-e2e-gke-gpus
... skipping 13 lines ...
W1229 22:14:56.276] Deleting Managed Instance Group...
W1229 22:16:46.177] .........................Deleted [https://www.googleapis.com/compute/v1/projects/k8s-jkns-e2e-gke-gpus/zones/us-west1-b/instanceGroupManagers/bootstrap-e2e-minion-group].
W1229 22:16:46.178] done.
W1229 22:16:53.541] Deleted [https://www.googleapis.com/compute/v1/projects/k8s-jkns-e2e-gke-gpus/global/instanceTemplates/bootstrap-e2e-minion-template].
W1229 22:16:54.863] Deleted [https://www.googleapis.com/compute/v1/projects/k8s-jkns-e2e-gke-gpus/global/instanceTemplates/bootstrap-e2e-windows-node-template].
I1229 22:17:59.200] Removing etcd replica, name: bootstrap-e2e-master, port: 2379, result: 1
W1229 22:17:59.301] 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
W1229 22:17:59.301] Last attempt failed with: 
I1229 22:18:01.376] 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
I1229 22:18:01.376] Removing etcd replica, name: bootstrap-e2e-master, port: 4002, result: 0
W1229 22:18:07.192] Updated [https://www.googleapis.com/compute/v1/projects/k8s-jkns-e2e-gke-gpus/zones/us-west1-b/instances/bootstrap-e2e-master].
W1229 22:20:17.421] Deleted [https://www.googleapis.com/compute/v1/projects/k8s-jkns-e2e-gke-gpus/zones/us-west1-b/instances/bootstrap-e2e-master].
W1229 22:20:30.588] Deleted [https://www.googleapis.com/compute/v1/projects/k8s-jkns-e2e-gke-gpus/global/firewalls/bootstrap-e2e-master-https].
W1229 22:20:36.190] Deleted [https://www.googleapis.com/compute/v1/projects/k8s-jkns-e2e-gke-gpus/global/firewalls/bootstrap-e2e-master-etcd].
... skipping 18 lines ...
W1229 22:22:00.079] W1229 22:22:00.078991   10247 loader.go:223] Config not found: /workspace/.kube/config
W1229 22:22:00.128] 2019/12/29 22:22:00 process.go:155: Step './hack/e2e-internal/e2e-down.sh' finished in 7m16.197773391s
W1229 22:22:00.128] 2019/12/29 22:22:00 process.go:96: Saved XML output to /workspace/_artifacts/junit_runner.xml.
I1229 22:22:00.230] Property "contexts.k8s-jkns-e2e-gke-gpus_bootstrap-e2e" unset.
I1229 22:22:00.230] Cleared config for k8s-jkns-e2e-gke-gpus_bootstrap-e2e from /workspace/.kube/config
I1229 22:22:00.231] Done
W1229 22:22:06.094] 2019/12/29 22:22:06 main.go:319: Something went wrong: starting e2e cluster: error during ./hack/e2e-internal/e2e-up.sh: exit status 2
W1229 22:22:06.100] Traceback (most recent call last):
W1229 22:22:06.100]   File "/workspace/./test-infra/jenkins/../scenarios/kubernetes_e2e.py", line 778, in <module>
W1229 22:22:06.101]     main(parse_args())
W1229 22:22:06.101]   File "/workspace/./test-infra/jenkins/../scenarios/kubernetes_e2e.py", line 626, in main
W1229 22:22:06.101]     mode.start(runner_args)
W1229 22:22:06.102]   File "/workspace/./test-infra/jenkins/../scenarios/kubernetes_e2e.py", line 262, in start
W1229 22:22:06.102]     check_env(env, self.command, *args)
W1229 22:22:06.102]   File "/workspace/./test-infra/jenkins/../scenarios/kubernetes_e2e.py", line 111, in check_env
W1229 22:22:06.102]     subprocess.check_call(cmd, env=env)
W1229 22:22:06.103]   File "/usr/lib/python2.7/subprocess.py", line 190, in check_call
W1229 22:22:06.103]     raise CalledProcessError(retcode, cmd)
W1229 22:22:06.104] 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-project-type=gpu-project', '--gcp-zone=us-west1-b', '--test_args=--kubectl-path=../../../../kubernetes_skew/cluster/kubectl.sh --minStartupPods=8 --ginkgo.skip=\\[.+\\]|Initializers|Dashboard', '--timeout=150m', '--upgrade_args=--ginkgo.focus=\\[Feature:GPUClusterDowngrade\\] --upgrade-target=ci/k8s-stable1 --upgrade-image=gci')' returned non-zero exit status 1
E1229 22:22:06.112] Command failed
I1229 22:22:06.112] process 268 exited with code 1 after 21.0m
E1229 22:22:06.113] FAIL: ci-kubernetes-e2e-gce-gpu-beta-stable1-cluster-downgrade
I1229 22:22:06.114] Call:  gcloud auth activate-service-account --key-file=/etc/service-account/service-account.json
W1229 22:22:06.829] Activated service account credentials for: [pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com]
I1229 22:22:06.918] process 10257 exited with code 0 after 0.0m
I1229 22:22:06.918] Call:  gcloud config get-value account
I1229 22:22:07.481] process 10270 exited with code 0 after 0.0m
I1229 22:22:07.482] Will upload results to gs://kubernetes-jenkins/logs using pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com
I1229 22:22:07.482] Upload result and artifacts...
I1229 22:22:07.482] Gubernator results at https://gubernator.k8s.io/build/kubernetes-jenkins/logs/ci-kubernetes-e2e-gce-gpu-beta-stable1-cluster-downgrade/1211406719318495232
I1229 22:22:07.483] Call:  gsutil ls gs://kubernetes-jenkins/logs/ci-kubernetes-e2e-gce-gpu-beta-stable1-cluster-downgrade/1211406719318495232/artifacts
W1229 22:22:08.831] CommandException: One or more URLs matched no objects.
E1229 22:22:09.061] Command failed
I1229 22:22:09.062] process 10283 exited with code 1 after 0.0m
W1229 22:22:09.062] Remote dir gs://kubernetes-jenkins/logs/ci-kubernetes-e2e-gce-gpu-beta-stable1-cluster-downgrade/1211406719318495232/artifacts not exist yet
I1229 22:22:09.062] 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-gpu-beta-stable1-cluster-downgrade/1211406719318495232/artifacts
I1229 22:22:12.949] process 10428 exited with code 0 after 0.1m
I1229 22:22:12.950] Call:  git rev-parse HEAD
W1229 22:22:12.962] fatal: not a git repository (or any of the parent directories): .git
E1229 22:22:12.962] Command failed
I1229 22:22:12.963] process 11075 exited with code 128 after 0.0m
I1229 22:22:12.963] Call:  git rev-parse HEAD
I1229 22:22:12.972] process 11076 exited with code 0 after 0.0m
I1229 22:22:12.973] Call:  gsutil stat gs://kubernetes-jenkins/logs/ci-kubernetes-e2e-gce-gpu-beta-stable1-cluster-downgrade/jobResultsCache.json
I1229 22:22:14.659] process 11077 exited with code 0 after 0.0m
I1229 22:22:14.660] Call:  gsutil -q cat 'gs://kubernetes-jenkins/logs/ci-kubernetes-e2e-gce-gpu-beta-stable1-cluster-downgrade/jobResultsCache.json#1577614650535016'
... skipping 8 lines ...