This job view page is being replaced by Spyglass soon. Check out the new job view.
ResultFAILURE
Tests 1 failed / 5 succeeded
Started2019-09-11 11:49
Elapsed25m54s
Revision
Buildergke-prow-ssd-pool-1a225945-xlz0
links{u'resultstore': {u'url': u'https://source.cloud.google.com/results/invocations/4728a942-b510-4f25-a69f-72cbb124f1ad/targets/test'}}
pod16a85001-d48a-11e9-9d26-329cee23a2e0
resultstorehttps://source.cloud.google.com/results/invocations/4728a942-b510-4f25-a69f-72cbb124f1ad/targets/test
infra-commit3d071c448
job-versionv1.17.0-alpha.0.1233+3870692dff4298
pod16a85001-d48a-11e9-9d26-329cee23a2e0
revisionv1.17.0-alpha.0.1233+3870692dff4298

Test Failures


Up 20m33s

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 ...
I0911 11:49:41.782] process 44 exited with code 0 after 0.0m
I0911 11:49:41.782] Will upload results to gs://kubernetes-jenkins/logs using pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com
I0911 11:49:41.783] Root: /workspace
I0911 11:49:41.783] cd to /workspace
I0911 11:49:41.783] Configure environment...
I0911 11:49:41.784] Call:  git show -s --format=format:%ct HEAD
W0911 11:49:41.804] fatal: Not a git repository (or any of the parent directories): .git
I0911 11:49:41.805] process 56 exited with code 128 after 0.0m
W0911 11:49:41.806] Unable to print commit date for HEAD
I0911 11:49:41.807] Call:  gcloud auth activate-service-account --key-file=/etc/service-account/service-account.json
W0911 11:49:42.680] Activated service account credentials for: [pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com]
I0911 11:49:42.755] process 57 exited with code 0 after 0.0m
I0911 11:49:42.755] Call:  gcloud config get-value account
... skipping 701 lines ...
I0911 11:51:02.563]  * read about installing addons at: https://github.com/kubernetes/kops/blob/master/docs/addons.md.
I0911 11:51:02.564] 
W0911 11:51:02.664] 2019/09/11 11:51:02 process.go:155: Step '/workspace/kops update cluster e2e-kops-aws.test-cncf-aws.k8s.io --yes' finished in 23.690769526s
W0911 11:51:02.665] 2019/09/11 11:51:02 process.go:153: Running: kubectl get nodes -ojson
W0911 11:51:02.878] 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
W0911 11:51:02.906] 2019/09/11 11:51:02 process.go:155: Step 'kubectl get nodes -ojson' finished in 309.483887ms
W0911 11:51:02.906] 2019/09/11 11:51:02 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0911 11:51:02.907] 2019/09/11 11:51:02 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0911 11:51:32.884] 2019/09/11 11:51:32 process.go:153: Running: kubectl get nodes -ojson
W0911 11:53:33.043] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0911 11:53:33.052] 2019/09/11 11:53:33 process.go:155: Step 'kubectl get nodes -ojson' finished in 2m0.168832443s
W0911 11:53:33.053] 2019/09/11 11:53:33 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0911 11:53:33.053] 2019/09/11 11:53:33 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0911 11:54:03.054] 2019/09/11 11:54:03 process.go:153: Running: kubectl get nodes -ojson
W0911 11:55:33.374] 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
W0911 11:55:33.378] 2019/09/11 11:55:33 process.go:155: Step 'kubectl get nodes -ojson' finished in 1m30.324915993s
W0911 11:55:33.379] 2019/09/11 11:55:33 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0911 11:55:33.379] 2019/09/11 11:55:33 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0911 11:56:03.380] 2019/09/11 11:56:03 process.go:153: Running: kubectl get nodes -ojson
W0911 11:58:33.587] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0911 11:58:33.590] 2019/09/11 11:58:33 process.go:155: Step 'kubectl get nodes -ojson' finished in 2m30.21035486s
W0911 11:58:33.590] 2019/09/11 11:58:33 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0911 11:58:33.591] 2019/09/11 11:58:33 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0911 11:59:03.591] 2019/09/11 11:59:03 process.go:153: Running: kubectl get nodes -ojson
W0911 12:01:33.683] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0911 12:01:33.687] 2019/09/11 12:01:33 process.go:155: Step 'kubectl get nodes -ojson' finished in 2m30.096591535s
W0911 12:01:33.687] 2019/09/11 12:01:33 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0911 12:01:33.688] 2019/09/11 12:01:33 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0911 12:02:03.687] 2019/09/11 12:02:03 process.go:153: Running: kubectl get nodes -ojson
W0911 12:04:33.802] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0911 12:04:33.803] 2019/09/11 12:04:33 process.go:155: Step 'kubectl get nodes -ojson' finished in 2m30.115360057s
W0911 12:04:33.803] 2019/09/11 12:04:33 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0911 12:04:33.804] 2019/09/11 12:04:33 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0911 12:05:03.804] 2019/09/11 12:05:03 process.go:153: Running: kubectl get nodes -ojson
W0911 12:07:33.917] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0911 12:07:33.920] 2019/09/11 12:07:33 process.go:155: Step 'kubectl get nodes -ojson' finished in 2m30.116286455s
W0911 12:07:33.920] 2019/09/11 12:07:33 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0911 12:07:33.920] 2019/09/11 12:07:33 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0911 12:08:03.921] 2019/09/11 12:08:03 process.go:153: Running: kubectl get nodes -ojson
W0911 12:10:34.016] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0911 12:10:34.018] 2019/09/11 12:10:34 process.go:155: Step 'kubectl get nodes -ojson' finished in 2m30.097523949s
W0911 12:10:34.018] 2019/09/11 12:10:34 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0911 12:10:34.019] 2019/09/11 12:10:34 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0911 12:11:04.020] 2019/09/11 12:11:04 process.go:153: Running: /workspace/kops toolbox dump --name e2e-kops-aws.test-cncf-aws.k8s.io -ojson
W0911 12:11:11.993] 2019/09/11 12:11:11 process.go:155: Step '/workspace/kops toolbox dump --name e2e-kops-aws.test-cncf-aws.k8s.io -ojson' finished in 7.971413786s
W0911 12:11:11.993] 2019/09/11 12:11:11 process.go:153: Running: kubectl get nodes -ojson
W0911 12:13:42.097] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0911 12:13:42.103] 2019/09/11 12:13:42 process.go:155: Step 'kubectl get nodes -ojson' finished in 2m30.110006195s
W0911 12:13:42.104] 2019/09/11 12:13:42 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0911 12:13:42.104] 2019/09/11 12:13:42 dump.go:89: Failed to get nodes for dumping via kubectl: error during kubectl get nodes -ojson: exit status 1
W0911 12:13:42.104] 2019/09/11 12:13:42 dump.go:123: dumping node not registered in kubernetes: 52.78.7.2
W0911 12:13:42.104] 2019/09/11 12:13:42 dump.go:157: Dumping node 52.78.7.2
W0911 12:13:43.738] 2019/09/11 12:13:43 dump.go:358: Running SSH command: sudo journalctl --output=short-precise -k
W0911 12:13:44.416] 2019/09/11 12:13:44 dump.go:358: Running SSH command: sudo journalctl --output=short-precise
W0911 12:13:48.201] 2019/09/11 12:13:48 dump.go:358: Running SSH command: sudo systemctl list-units -t service --no-pager --no-legend --all
W0911 12:13:48.522] 2019/09/11 12:13:48 dump.go:358: Running SSH command: sudo journalctl --output=cat -u kubelet.service
... skipping 150 lines ...
W0911 12:15:12.834]     check_env(env, self.command, *args)
W0911 12:15:12.835]   File "/workspace/./test-infra/jenkins/../scenarios/kubernetes_e2e.py", line 111, in check_env
W0911 12:15:12.835]     subprocess.check_call(cmd, env=env)
W0911 12:15:12.835]   File "/usr/lib/python2.7/subprocess.py", line 186, in check_call
W0911 12:15:12.836]     raise CalledProcessError(retcode, cmd)
W0911 12:15:12.837] 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-2a', '--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
E0911 12:15:12.838] Command failed
I0911 12:15:12.838] process 259 exited with code 1 after 25.4m
E0911 12:15:12.838] FAIL: ci-kubernetes-e2e-kops-aws
I0911 12:15:12.839] Call:  gcloud auth activate-service-account --key-file=/etc/service-account/service-account.json
W0911 12:15:13.899] Activated service account credentials for: [pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com]
I0911 12:15:14.004] process 596 exited with code 0 after 0.0m
I0911 12:15:14.005] Call:  gcloud config get-value account
I0911 12:15:14.594] process 608 exited with code 0 after 0.0m
I0911 12:15:14.595] Will upload results to gs://kubernetes-jenkins/logs using pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com
I0911 12:15:14.595] Upload result and artifacts...
I0911 12:15:14.595] Gubernator results at https://gubernator.k8s.io/build/kubernetes-jenkins/logs/ci-kubernetes-e2e-kops-aws/1171752527796899841
I0911 12:15:14.596] Call:  gsutil ls gs://kubernetes-jenkins/logs/ci-kubernetes-e2e-kops-aws/1171752527796899841/artifacts
W0911 12:15:16.880] CommandException: One or more URLs matched no objects.
E0911 12:15:17.150] Command failed
I0911 12:15:17.150] process 620 exited with code 1 after 0.0m
W0911 12:15:17.151] Remote dir gs://kubernetes-jenkins/logs/ci-kubernetes-e2e-kops-aws/1171752527796899841/artifacts not exist yet
I0911 12:15:17.151] 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/1171752527796899841/artifacts
I0911 12:15:26.288] process 762 exited with code 0 after 0.2m
I0911 12:15:26.291] Call:  git rev-parse HEAD
W0911 12:15:26.318] fatal: Not a git repository (or any of the parent directories): .git
E0911 12:15:26.319] Command failed
I0911 12:15:26.319] process 1401 exited with code 128 after 0.0m
I0911 12:15:26.319] Call:  git rev-parse HEAD
I0911 12:15:26.349] process 1402 exited with code 0 after 0.0m
I0911 12:15:26.352] Call:  gsutil stat gs://kubernetes-jenkins/logs/ci-kubernetes-e2e-kops-aws/jobResultsCache.json
I0911 12:15:28.803] process 1403 exited with code 0 after 0.0m
I0911 12:15:28.805] Call:  gsutil -q cat 'gs://kubernetes-jenkins/logs/ci-kubernetes-e2e-kops-aws/jobResultsCache.json#1568202416360561'
... skipping 8 lines ...