This job view page is being replaced by Spyglass soon. Check out the new job view.
ResultFAILURE
Tests 1 failed / 5 succeeded
Started2019-07-20 18:20
Elapsed26m0s
Revision
Buildergke-prow-ssd-pool-1a225945-03kr
links{u'resultstore': {u'url': u'https://source.cloud.google.com/results/invocations/1b5b6872-f33a-4bf9-9029-c8bf0acc8f12/targets/test'}}
podfef1925d-ab1a-11e9-b82b-365474bd0c86
resultstorehttps://source.cloud.google.com/results/invocations/1b5b6872-f33a-4bf9-9029-c8bf0acc8f12/targets/test
infra-commita7f2c5488
job-versionv1.16.0-alpha.1.119+2e6eea5517bc58
podfef1925d-ab1a-11e9-b82b-365474bd0c86
revisionv1.16.0-alpha.1.119+2e6eea5517bc58

Test Failures


Up 20m59s

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 ...
I0720 18:20:34.638] process 44 exited with code 0 after 0.0m
I0720 18:20:34.638] Will upload results to gs://kubernetes-jenkins/logs using pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com
I0720 18:20:34.638] Root: /workspace
I0720 18:20:34.638] cd to /workspace
I0720 18:20:34.638] Configure environment...
I0720 18:20:34.639] Call:  git show -s --format=format:%ct HEAD
W0720 18:20:34.643] fatal: Not a git repository (or any of the parent directories): .git
I0720 18:20:34.643] process 56 exited with code 128 after 0.0m
W0720 18:20:34.643] Unable to print commit date for HEAD
I0720 18:20:34.644] Call:  gcloud auth activate-service-account --key-file=/etc/service-account/service-account.json
W0720 18:20:35.141] Activated service account credentials for: [pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com]
I0720 18:20:35.491] process 57 exited with code 0 after 0.0m
I0720 18:20:35.491] Call:  gcloud config get-value account
... skipping 602 lines ...
I0720 18:21:33.628]  * read about installing addons at: https://github.com/kubernetes/kops/blob/master/docs/addons.md.
I0720 18:21:33.628] 
W0720 18:21:33.728] 2019/07/20 18:21:33 process.go:155: Step '/tmp/kops497888506/kops update cluster e2e-kops-aws-newrunner.test-cncf-aws.k8s.io --yes' finished in 21.7424616s
W0720 18:21:33.729] 2019/07/20 18:21:33 process.go:153: Running: kubectl get nodes -ojson
W0720 18:21:33.876] Unable to connect to the server: dial tcp: lookup api.e2e-kops-aws-newrunner.test-cncf-aws.k8s.io on 10.63.240.10:53: no such host
W0720 18:21:33.879] 2019/07/20 18:21:33 process.go:155: Step 'kubectl get nodes -ojson' finished in 241.106138ms
W0720 18:21:33.879] 2019/07/20 18:21:33 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0720 18:21:33.879] 2019/07/20 18:21:33 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0720 18:22:03.879] 2019/07/20 18:22:03 process.go:153: Running: kubectl get nodes -ojson
W0720 18:22:34.064] Unable to connect to the server: dial tcp: lookup api.e2e-kops-aws-newrunner.test-cncf-aws.k8s.io on 10.63.240.10:53: no such host
W0720 18:22:34.066] 2019/07/20 18:22:34 process.go:155: Step 'kubectl get nodes -ojson' finished in 30.187554151s
W0720 18:22:34.067] 2019/07/20 18:22:34 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0720 18:22:34.067] 2019/07/20 18:22:34 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0720 18:23:04.067] 2019/07/20 18:23:04 process.go:153: Running: kubectl get nodes -ojson
W0720 18:24:04.208] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0720 18:24:04.212] 2019/07/20 18:24:04 process.go:155: Step 'kubectl get nodes -ojson' finished in 1m0.145540047s
W0720 18:24:04.213] 2019/07/20 18:24:04 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0720 18:24:04.213] 2019/07/20 18:24:04 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0720 18:24:34.213] 2019/07/20 18:24:34 process.go:153: Running: kubectl get nodes -ojson
W0720 18:25:04.349] Unable to connect to the server: dial tcp: lookup api.e2e-kops-aws-newrunner.test-cncf-aws.k8s.io on 10.63.240.10:53: no such host
W0720 18:25:04.353] 2019/07/20 18:25:04 process.go:155: Step 'kubectl get nodes -ojson' finished in 30.140220636s
W0720 18:25:04.353] 2019/07/20 18:25:04 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0720 18:25:04.353] 2019/07/20 18:25:04 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0720 18:25:34.353] 2019/07/20 18:25:34 process.go:153: Running: kubectl get nodes -ojson
W0720 18:26:34.472] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0720 18:26:34.473] 2019/07/20 18:26:34 process.go:155: Step 'kubectl get nodes -ojson' finished in 1m0.119486335s
W0720 18:26:34.473] 2019/07/20 18:26:34 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0720 18:26:34.473] 2019/07/20 18:26:34 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0720 18:27:04.473] 2019/07/20 18:27:04 process.go:153: Running: kubectl get nodes -ojson
W0720 18:29:34.552] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0720 18:29:34.555] 2019/07/20 18:29:34 process.go:155: Step 'kubectl get nodes -ojson' finished in 2m30.081193002s
W0720 18:29:34.555] 2019/07/20 18:29:34 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0720 18:29:34.555] 2019/07/20 18:29:34 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0720 18:30:04.555] 2019/07/20 18:30:04 process.go:153: Running: kubectl get nodes -ojson
W0720 18:32:34.648] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0720 18:32:34.652] 2019/07/20 18:32:34 process.go:155: Step 'kubectl get nodes -ojson' finished in 2m30.097274993s
W0720 18:32:34.653] 2019/07/20 18:32:34 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0720 18:32:34.653] 2019/07/20 18:32:34 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0720 18:33:04.656] 2019/07/20 18:33:04 process.go:153: Running: kubectl get nodes -ojson
W0720 18:35:34.735] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0720 18:35:34.735] 2019/07/20 18:35:34 process.go:155: Step 'kubectl get nodes -ojson' finished in 2m30.07867693s
W0720 18:35:34.735] 2019/07/20 18:35:34 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0720 18:35:34.736] 2019/07/20 18:35:34 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0720 18:36:04.736] 2019/07/20 18:36:04 process.go:153: Running: kubectl get nodes -ojson
W0720 18:38:34.834] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0720 18:38:34.838] 2019/07/20 18:38:34 process.go:155: Step 'kubectl get nodes -ojson' finished in 2m30.102621621s
W0720 18:38:34.838] 2019/07/20 18:38:34 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0720 18:38:34.838] 2019/07/20 18:38:34 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0720 18:39:04.839] 2019/07/20 18:39:04 process.go:153: Running: kubectl get nodes -ojson
W0720 18:41:34.929] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0720 18:41:34.933] 2019/07/20 18:41:34 process.go:155: Step 'kubectl get nodes -ojson' finished in 2m30.094242059s
W0720 18:41:34.933] 2019/07/20 18:41:34 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0720 18:41:34.933] 2019/07/20 18:41:34 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0720 18:42:04.934] 2019/07/20 18:42:04 process.go:153: Running: /tmp/kops497888506/kops toolbox dump --name e2e-kops-aws-newrunner.test-cncf-aws.k8s.io -ojson
W0720 18:42:12.774] 2019/07/20 18:42:12 process.go:155: Step '/tmp/kops497888506/kops toolbox dump --name e2e-kops-aws-newrunner.test-cncf-aws.k8s.io -ojson' finished in 7.839513416s
W0720 18:42:12.775] 2019/07/20 18:42:12 process.go:153: Running: kubectl get nodes -ojson
W0720 18:44:42.846] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0720 18:44:42.851] 2019/07/20 18:44:42 process.go:155: Step 'kubectl get nodes -ojson' finished in 2m30.076108989s
W0720 18:44:42.851] 2019/07/20 18:44:42 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0720 18:44:42.851] 2019/07/20 18:44:42 dump.go:89: Failed to get nodes for dumping via kubectl: error during kubectl get nodes -ojson: exit status 1
W0720 18:44:42.851] 2019/07/20 18:44:42 dump.go:123: dumping node not registered in kubernetes: 13.115.250.118
W0720 18:44:42.852] 2019/07/20 18:44:42 dump.go:157: Dumping node 13.115.250.118
W0720 18:44:44.246] 2019/07/20 18:44:44 dump.go:358: Running SSH command: sudo journalctl --output=short-precise -k
W0720 18:44:44.816] 2019/07/20 18:44:44 dump.go:358: Running SSH command: sudo journalctl --output=short-precise
W0720 18:44:49.232] 2019/07/20 18:44:49 dump.go:358: Running SSH command: sudo systemctl list-units -t service --no-pager --no-legend --all
W0720 18:44:49.507] 2019/07/20 18:44:49 dump.go:358: Running SSH command: sudo journalctl --output=cat -u kubelet.service
... skipping 168 lines ...
W0720 18:46:24.455]     check_env(env, self.command, *args)
W0720 18:46:24.455]   File "/workspace/./test-infra/jenkins/../scenarios/kubernetes_e2e.py", line 111, in check_env
W0720 18:46:24.455]     subprocess.check_call(cmd, env=env)
W0720 18:46:24.456]   File "/usr/lib/python2.7/subprocess.py", line 186, in check_call
W0720 18:46:24.456]     raise CalledProcessError(retcode, cmd)
W0720 18:46:24.457] subprocess.CalledProcessError: Command '('kubetest', '--dump=/workspace/_artifacts', '--gcp-service-account=/etc/service-account/service-account.json', '--up', '--down', '--test', '--deployment=kops', '--provider=aws', '--cluster=e2e-kops-aws-newrunner.test-cncf-aws.k8s.io', '--gcp-network=e2e-kops-aws-newrunner.test-cncf-aws.k8s.io', '--extract=ci/latest', '--ginkgo-parallel', '--kops-version=https://storage.googleapis.com/kops-ci/bin/latest-ci-updown-green.txt', '--test_args=--ginkgo.flakeAttempts=2 --ginkgo.skip=\\[Slow\\]|\\[Serial\\]|\\[Disruptive\\]|\\[Flaky\\]|\\[Feature:.+\\]|\\[HPA\\]|Dashboard|Services.*functioning.*NodePort', '--timeout=120m', '--kops-zones=ap-northeast-1c', '--kops-cluster=e2e-kops-aws-newrunner.test-cncf-aws.k8s.io', '--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
E0720 18:46:24.457] Command failed
I0720 18:46:24.457] process 259 exited with code 1 after 25.8m
E0720 18:46:24.458] FAIL: ci-kubernetes-e2e-kops-aws-newrunner
I0720 18:46:24.459] Call:  gcloud auth activate-service-account --key-file=/etc/service-account/service-account.json
W0720 18:46:24.957] Activated service account credentials for: [pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com]
I0720 18:46:25.007] process 602 exited with code 0 after 0.0m
I0720 18:46:25.007] Call:  gcloud config get-value account
I0720 18:46:25.300] process 614 exited with code 0 after 0.0m
I0720 18:46:25.301] Will upload results to gs://kubernetes-jenkins/logs using pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com
I0720 18:46:25.301] Upload result and artifacts...
I0720 18:46:25.301] Gubernator results at https://gubernator.k8s.io/build/kubernetes-jenkins/logs/ci-kubernetes-e2e-kops-aws-newrunner/1152644428578426881
I0720 18:46:25.302] Call:  gsutil ls gs://kubernetes-jenkins/logs/ci-kubernetes-e2e-kops-aws-newrunner/1152644428578426881/artifacts
W0720 18:46:26.363] CommandException: One or more URLs matched no objects.
E0720 18:46:26.470] Command failed
I0720 18:46:26.471] process 626 exited with code 1 after 0.0m
W0720 18:46:26.471] Remote dir gs://kubernetes-jenkins/logs/ci-kubernetes-e2e-kops-aws-newrunner/1152644428578426881/artifacts not exist yet
I0720 18:46:26.471] 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-newrunner/1152644428578426881/artifacts
I0720 18:46:30.195] process 768 exited with code 0 after 0.1m
I0720 18:46:30.196] Call:  git rev-parse HEAD
W0720 18:46:30.200] fatal: Not a git repository (or any of the parent directories): .git
E0720 18:46:30.201] Command failed
I0720 18:46:30.201] process 1407 exited with code 128 after 0.0m
I0720 18:46:30.201] Call:  git rev-parse HEAD
I0720 18:46:30.206] process 1408 exited with code 0 after 0.0m
I0720 18:46:30.206] Call:  gsutil stat gs://kubernetes-jenkins/logs/ci-kubernetes-e2e-kops-aws-newrunner/jobResultsCache.json
I0720 18:46:31.240] process 1409 exited with code 0 after 0.0m
I0720 18:46:31.241] Call:  gsutil -q cat 'gs://kubernetes-jenkins/logs/ci-kubernetes-e2e-kops-aws-newrunner/jobResultsCache.json#1563644819439554'
... skipping 8 lines ...