This job view page is being replaced by Spyglass soon. Check out the new job view.
ResultFAILURE
Tests 1 failed / 5 succeeded
Started2019-09-18 09:55
Elapsed25m21s
Revision
Buildergke-prow-ssd-pool-1a225945-n47b
links{u'resultstore': {u'url': u'https://source.cloud.google.com/results/invocations/cb84cf99-6619-4637-a417-4b973e230d59/targets/test'}}
pod53564953-d9fa-11e9-9368-d2ad95f0993d
resultstorehttps://source.cloud.google.com/results/invocations/cb84cf99-6619-4637-a417-4b973e230d59/targets/test
infra-commit6dc9fbe41
job-versionv1.17.0-alpha.0.1519+57d87502ba6408
pod53564953-d9fa-11e9-9368-d2ad95f0993d
revisionv1.17.0-alpha.0.1519+57d87502ba6408

Test Failures


Up 20m30s

waiting for ready nodes timed out
				from junit_runner.xml

Filter through log files | View test history on testgrid


Show 5 Passed Tests

Error lines from build-log.txt

... skipping 12 lines ...
I0918 09:55:23.297] process 45 exited with code 0 after 0.0m
I0918 09:55:23.298] Will upload results to gs://kubernetes-jenkins/logs using pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com
I0918 09:55:23.298] Root: /workspace
I0918 09:55:23.299] cd to /workspace
I0918 09:55:23.299] Configure environment...
I0918 09:55:23.299] Call:  git show -s --format=format:%ct HEAD
W0918 09:55:23.303] fatal: Not a git repository (or any of the parent directories): .git
I0918 09:55:23.304] process 57 exited with code 128 after 0.0m
W0918 09:55:23.304] Unable to print commit date for HEAD
I0918 09:55:23.305] Call:  gcloud auth activate-service-account --key-file=/etc/service-account/service-account.json
W0918 09:55:23.826] Activated service account credentials for: [pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com]
I0918 09:55:23.881] process 58 exited with code 0 after 0.0m
I0918 09:55:23.881] Call:  gcloud config get-value account
... skipping 701 lines ...
I0918 09:56:26.097]  * read about installing addons at: https://github.com/kubernetes/kops/blob/master/docs/addons.md.
I0918 09:56:26.097] 
W0918 09:56:26.197] 2019/09/18 09:56:26 process.go:155: Step '/workspace/kops update cluster e2e-kops-aws.test-cncf-aws.k8s.io --yes' finished in 22.289649324s
W0918 09:56:26.198] 2019/09/18 09:56:26 process.go:153: Running: kubectl get nodes -ojson
W0918 09:56:26.325] Unable to connect to the server: dial tcp: lookup api.e2e-kops-aws.test-cncf-aws.k8s.io on 10.63.240.10:53: no such host
W0918 09:56:26.329] 2019/09/18 09:56:26 process.go:155: Step 'kubectl get nodes -ojson' finished in 227.847757ms
W0918 09:56:26.329] 2019/09/18 09:56:26 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0918 09:56:26.330] 2019/09/18 09:56:26 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0918 09:56:56.329] 2019/09/18 09:56:56 process.go:153: Running: kubectl get nodes -ojson
W0918 09:57:56.494] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0918 09:57:56.497] 2019/09/18 09:57:56 process.go:155: Step 'kubectl get nodes -ojson' finished in 1m0.167563002s
W0918 09:57:56.497] 2019/09/18 09:57:56 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0918 09:57:56.497] 2019/09/18 09:57:56 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0918 09:58:26.497] 2019/09/18 09:58:26 process.go:153: Running: kubectl get nodes -ojson
W0918 09:58:56.680] Unable to connect to the server: dial tcp: lookup api.e2e-kops-aws.test-cncf-aws.k8s.io on 10.63.240.10:53: no such host
W0918 09:58:56.683] 2019/09/18 09:58:56 process.go:155: Step 'kubectl get nodes -ojson' finished in 30.186150687s
W0918 09:58:56.684] 2019/09/18 09:58:56 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0918 09:58:56.685] 2019/09/18 09:58:56 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0918 09:59:26.684] 2019/09/18 09:59:26 process.go:153: Running: kubectl get nodes -ojson
W0918 09:59:56.816] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0918 09:59:56.818] 2019/09/18 09:59:56 process.go:155: Step 'kubectl get nodes -ojson' finished in 30.134946673s
W0918 09:59:56.819] 2019/09/18 09:59:56 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0918 09:59:56.819] 2019/09/18 09:59:56 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0918 10:00:26.819] 2019/09/18 10:00:26 process.go:153: Running: kubectl get nodes -ojson
W0918 10:00:56.970] Unable to connect to the server: dial tcp: lookup api.e2e-kops-aws.test-cncf-aws.k8s.io on 10.63.240.10:53: no such host
W0918 10:00:56.972] 2019/09/18 10:00:56 process.go:155: Step 'kubectl get nodes -ojson' finished in 30.153309397s
W0918 10:00:56.973] 2019/09/18 10:00:56 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0918 10:00:56.973] 2019/09/18 10:00:56 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0918 10:01:26.973] 2019/09/18 10:01:26 process.go:153: Running: kubectl get nodes -ojson
W0918 10:03:57.057] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0918 10:03:57.059] 2019/09/18 10:03:57 process.go:155: Step 'kubectl get nodes -ojson' finished in 2m30.086504309s
W0918 10:03:57.059] 2019/09/18 10:03:57 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0918 10:03:57.059] 2019/09/18 10:03:57 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0918 10:04:27.060] 2019/09/18 10:04:27 process.go:153: Running: kubectl get nodes -ojson
W0918 10:06:57.135] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0918 10:06:57.137] 2019/09/18 10:06:57 process.go:155: Step 'kubectl get nodes -ojson' finished in 2m30.077899185s
W0918 10:06:57.138] 2019/09/18 10:06:57 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0918 10:06:57.138] 2019/09/18 10:06:57 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0918 10:07:27.138] 2019/09/18 10:07:27 process.go:153: Running: kubectl get nodes -ojson
W0918 10:09:57.225] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0918 10:09:57.226] 2019/09/18 10:09:57 process.go:155: Step 'kubectl get nodes -ojson' finished in 2m30.087780028s
W0918 10:09:57.226] 2019/09/18 10:09:57 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0918 10:09:57.226] 2019/09/18 10:09:57 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0918 10:10:27.226] 2019/09/18 10:10:27 process.go:153: Running: kubectl get nodes -ojson
W0918 10:12:57.300] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0918 10:12:57.303] 2019/09/18 10:12:57 process.go:155: Step 'kubectl get nodes -ojson' finished in 2m30.076915464s
W0918 10:12:57.303] 2019/09/18 10:12:57 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0918 10:12:57.303] 2019/09/18 10:12:57 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0918 10:13:27.303] 2019/09/18 10:13:27 process.go:153: Running: kubectl get nodes -ojson
W0918 10:15:57.388] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0918 10:15:57.391] 2019/09/18 10:15:57 process.go:155: Step 'kubectl get nodes -ojson' finished in 2m30.08750942s
W0918 10:15:57.391] 2019/09/18 10:15:57 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0918 10:15:57.392] 2019/09/18 10:15:57 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0918 10:16:27.392] 2019/09/18 10:16:27 process.go:153: Running: /workspace/kops toolbox dump --name e2e-kops-aws.test-cncf-aws.k8s.io -ojson
W0918 10:16:35.528] 2019/09/18 10:16:35 process.go:155: Step '/workspace/kops toolbox dump --name e2e-kops-aws.test-cncf-aws.k8s.io -ojson' finished in 8.13589959s
W0918 10:16:35.531] 2019/09/18 10:16:35 process.go:153: Running: kubectl get nodes -ojson
W0918 10:19:05.610] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0918 10:19:05.612] 2019/09/18 10:19:05 process.go:155: Step 'kubectl get nodes -ojson' finished in 2m30.080580591s
W0918 10:19:05.612] 2019/09/18 10:19:05 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0918 10:19:05.613] 2019/09/18 10:19:05 dump.go:89: Failed to get nodes for dumping via kubectl: error during kubectl get nodes -ojson: exit status 1
W0918 10:19:05.613] 2019/09/18 10:19:05 dump.go:123: dumping node not registered in kubernetes: 13.114.9.194
W0918 10:19:05.613] 2019/09/18 10:19:05 dump.go:157: Dumping node 13.114.9.194
W0918 10:19:06.958] 2019/09/18 10:19:06 dump.go:358: Running SSH command: sudo journalctl --output=short-precise -k
W0918 10:19:07.522] 2019/09/18 10:19:07 dump.go:358: Running SSH command: sudo journalctl --output=short-precise
W0918 10:19:10.727] 2019/09/18 10:19:10 dump.go:358: Running SSH command: sudo systemctl list-units -t service --no-pager --no-legend --all
W0918 10:19:11.002] 2019/09/18 10:19:11 dump.go:358: Running SSH command: sudo journalctl --output=cat -u kubelet.service
... skipping 150 lines ...
W0918 10:20:34.493]     check_env(env, self.command, *args)
W0918 10:20:34.493]   File "/workspace/./test-infra/jenkins/../scenarios/kubernetes_e2e.py", line 111, in check_env
W0918 10:20:34.493]     subprocess.check_call(cmd, env=env)
W0918 10:20:34.494]   File "/usr/lib/python2.7/subprocess.py", line 186, in check_call
W0918 10:20:34.494]     raise CalledProcessError(retcode, cmd)
W0918 10:20:34.494] subprocess.CalledProcessError: Command '('/workspace/kops-e2e-runner.sh', '--dump=/workspace/_artifacts', '--gcp-service-account=/etc/service-account/service-account.json', '--up', '--down', '--test', '--provider=aws', '--cluster=e2e-kops-aws.test-cncf-aws.k8s.io', '--gcp-network=e2e-kops-aws.test-cncf-aws.k8s.io', '--extract=ci/latest', '--ginkgo-parallel', '--test_args=--ginkgo.flakeAttempts=2 --ginkgo.skip=\\[Slow\\]|\\[Serial\\]|\\[Disruptive\\]|\\[Flaky\\]|\\[Feature:.+\\]|\\[HPA\\]|Dashboard|Services.*functioning.*NodePort', '--timeout=120m', '--kops-cluster=e2e-kops-aws.test-cncf-aws.k8s.io', '--kops-zones=ap-northeast-1a', '--kops-state=s3://k8s-kops-prow/', '--kops-nodes=4', '--kops-ssh-key=/workspace/.ssh/kube_aws_rsa', '--kops-ssh-user=admin')' returned non-zero exit status 1
E0918 10:20:34.495] Command failed
I0918 10:20:34.495] process 260 exited with code 1 after 25.1m
E0918 10:20:34.495] FAIL: ci-kubernetes-e2e-kops-aws
I0918 10:20:34.495] Call:  gcloud auth activate-service-account --key-file=/etc/service-account/service-account.json
W0918 10:20:34.974] Activated service account credentials for: [pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com]
I0918 10:20:35.021] process 621 exited with code 0 after 0.0m
I0918 10:20:35.022] Call:  gcloud config get-value account
I0918 10:20:35.318] process 633 exited with code 0 after 0.0m
I0918 10:20:35.319] Will upload results to gs://kubernetes-jenkins/logs using pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com
I0918 10:20:35.319] Upload result and artifacts...
I0918 10:20:35.319] Gubernator results at https://gubernator.k8s.io/build/kubernetes-jenkins/logs/ci-kubernetes-e2e-kops-aws/1174260572137459713
I0918 10:20:35.319] Call:  gsutil ls gs://kubernetes-jenkins/logs/ci-kubernetes-e2e-kops-aws/1174260572137459713/artifacts
W0918 10:20:36.464] CommandException: One or more URLs matched no objects.
E0918 10:20:36.574] Command failed
I0918 10:20:36.574] process 645 exited with code 1 after 0.0m
W0918 10:20:36.574] Remote dir gs://kubernetes-jenkins/logs/ci-kubernetes-e2e-kops-aws/1174260572137459713/artifacts not exist yet
I0918 10:20:36.574] 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-kops-aws/1174260572137459713/artifacts
I0918 10:20:40.275] process 787 exited with code 0 after 0.1m
I0918 10:20:40.276] Call:  git rev-parse HEAD
W0918 10:20:40.280] fatal: Not a git repository (or any of the parent directories): .git
E0918 10:20:40.281] Command failed
I0918 10:20:40.281] process 1426 exited with code 128 after 0.0m
I0918 10:20:40.281] Call:  git rev-parse HEAD
I0918 10:20:40.285] process 1427 exited with code 0 after 0.0m
I0918 10:20:40.286] Call:  gsutil stat gs://kubernetes-jenkins/logs/ci-kubernetes-e2e-kops-aws/jobResultsCache.json
I0918 10:20:41.355] process 1428 exited with code 0 after 0.0m
I0918 10:20:41.356] Call:  gsutil -q cat 'gs://kubernetes-jenkins/logs/ci-kubernetes-e2e-kops-aws/jobResultsCache.json#1568800278530946'
... skipping 8 lines ...