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 00:29
Elapsed25m57s
Revision
Buildergke-prow-ssd-pool-1a225945-ldhb
links{u'resultstore': {u'url': u'https://source.cloud.google.com/results/invocations/88146003-ef9b-461d-9a12-dad0e3882a6f/targets/test'}}
pod41518e33-d9ab-11e9-9368-d2ad95f0993d
resultstorehttps://source.cloud.google.com/results/invocations/88146003-ef9b-461d-9a12-dad0e3882a6f/targets/test
infra-commit8d88940b4
job-versionv1.17.0-alpha.0.1511+124ed02c93b868
pod41518e33-d9ab-11e9-9368-d2ad95f0993d
revisionv1.17.0-alpha.0.1511+124ed02c93b868

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 ...
I0918 00:29:23.711] process 44 exited with code 0 after 0.0m
I0918 00:29:23.711] Will upload results to gs://kubernetes-jenkins/logs using pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com
I0918 00:29:23.711] Root: /workspace
I0918 00:29:23.711] cd to /workspace
I0918 00:29:23.712] Configure environment...
I0918 00:29:23.712] Call:  git show -s --format=format:%ct HEAD
W0918 00:29:23.716] fatal: Not a git repository (or any of the parent directories): .git
I0918 00:29:23.716] process 56 exited with code 128 after 0.0m
W0918 00:29:23.717] Unable to print commit date for HEAD
I0918 00:29:23.717] Call:  gcloud auth activate-service-account --key-file=/etc/service-account/service-account.json
W0918 00:29:24.310] Activated service account credentials for: [pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com]
I0918 00:29:24.384] process 57 exited with code 0 after 0.0m
I0918 00:29:24.384] Call:  gcloud config get-value account
... skipping 701 lines ...
I0918 00:30:29.697]  * read about installing addons at: https://github.com/kubernetes/kops/blob/master/docs/addons.md.
I0918 00:30:29.697] 
W0918 00:30:29.797] 2019/09/18 00:30:29 process.go:155: Step '/workspace/kops update cluster e2e-kops-aws.test-cncf-aws.k8s.io --yes' finished in 23.03198816s
W0918 00:30:29.798] 2019/09/18 00:30:29 process.go:153: Running: kubectl get nodes -ojson
W0918 00:30:29.891] 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 00:30:29.894] 2019/09/18 00:30:29 process.go:155: Step 'kubectl get nodes -ojson' finished in 194.052207ms
W0918 00:30:29.895] 2019/09/18 00:30:29 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0918 00:30:29.895] 2019/09/18 00:30:29 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0918 00:30:59.895] 2019/09/18 00:30:59 process.go:153: Running: kubectl get nodes -ojson
W0918 00:31:00.099] 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 00:31:00.103] 2019/09/18 00:31:00 process.go:155: Step 'kubectl get nodes -ojson' finished in 208.024193ms
W0918 00:31:00.104] 2019/09/18 00:31:00 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0918 00:31:00.104] 2019/09/18 00:31:00 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0918 00:31:30.104] 2019/09/18 00:31:30 process.go:153: Running: kubectl get nodes -ojson
W0918 00:32:00.274] 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 00:32:00.277] 2019/09/18 00:32:00 process.go:155: Step 'kubectl get nodes -ojson' finished in 30.173902055s
W0918 00:32:00.278] 2019/09/18 00:32:00 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0918 00:32:00.278] 2019/09/18 00:32:00 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0918 00:32:30.278] 2019/09/18 00:32:30 process.go:153: Running: kubectl get nodes -ojson
W0918 00:32:30.468] 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 00:32:30.471] 2019/09/18 00:32:30 process.go:155: Step 'kubectl get nodes -ojson' finished in 193.54987ms
W0918 00:32:30.472] 2019/09/18 00:32:30 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0918 00:32:30.472] 2019/09/18 00:32:30 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0918 00:33:00.472] 2019/09/18 00:33:00 process.go:153: Running: kubectl get nodes -ojson
W0918 00:33:30.628] 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 00:33:30.632] 2019/09/18 00:33:30 process.go:155: Step 'kubectl get nodes -ojson' finished in 30.160310147s
W0918 00:33:30.633] 2019/09/18 00:33:30 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0918 00:33:30.634] 2019/09/18 00:33:30 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0918 00:34:00.633] 2019/09/18 00:34:00 process.go:153: Running: kubectl get nodes -ojson
W0918 00:34:00.813] 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 00:34:00.816] 2019/09/18 00:34:00 process.go:155: Step 'kubectl get nodes -ojson' finished in 182.643629ms
W0918 00:34:00.816] 2019/09/18 00:34:00 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0918 00:34:00.816] 2019/09/18 00:34:00 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0918 00:34:30.816] 2019/09/18 00:34:30 process.go:153: Running: kubectl get nodes -ojson
W0918 00:35:00.974] 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 00:35:00.977] 2019/09/18 00:35:00 process.go:155: Step 'kubectl get nodes -ojson' finished in 30.161048719s
W0918 00:35:00.977] 2019/09/18 00:35:00 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0918 00:35:00.978] 2019/09/18 00:35:00 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0918 00:35:30.978] 2019/09/18 00:35:30 process.go:153: Running: kubectl get nodes -ojson
W0918 00:38:01.065] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0918 00:38:01.068] 2019/09/18 00:38:01 process.go:155: Step 'kubectl get nodes -ojson' finished in 2m30.090996098s
W0918 00:38:01.069] 2019/09/18 00:38:01 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0918 00:38:01.069] 2019/09/18 00:38:01 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0918 00:38:31.069] 2019/09/18 00:38:31 process.go:153: Running: kubectl get nodes -ojson
W0918 00:41:01.159] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0918 00:41:01.159] 2019/09/18 00:41:01 process.go:155: Step 'kubectl get nodes -ojson' finished in 2m30.090117276s
W0918 00:41:01.159] 2019/09/18 00:41:01 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0918 00:41:01.160] 2019/09/18 00:41:01 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0918 00:41:31.160] 2019/09/18 00:41:31 process.go:153: Running: kubectl get nodes -ojson
W0918 00:44:01.256] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0918 00:44:01.263] 2019/09/18 00:44:01 process.go:155: Step 'kubectl get nodes -ojson' finished in 2m30.103997665s
W0918 00:44:01.264] 2019/09/18 00:44:01 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0918 00:44:01.264] 2019/09/18 00:44:01 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0918 00:44:31.265] 2019/09/18 00:44:31 process.go:153: Running: kubectl get nodes -ojson
W0918 00:47:01.350] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0918 00:47:01.354] 2019/09/18 00:47:01 process.go:155: Step 'kubectl get nodes -ojson' finished in 2m30.089945336s
W0918 00:47:01.355] 2019/09/18 00:47:01 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0918 00:47:01.355] 2019/09/18 00:47:01 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0918 00:47:31.355] 2019/09/18 00:47:31 process.go:153: Running: kubectl get nodes -ojson
W0918 00:50:01.437] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0918 00:50:01.440] 2019/09/18 00:50:01 process.go:155: Step 'kubectl get nodes -ojson' finished in 2m30.084992617s
W0918 00:50:01.440] 2019/09/18 00:50:01 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0918 00:50:01.440] 2019/09/18 00:50:01 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0918 00:50:31.441] 2019/09/18 00:50:31 process.go:153: Running: /workspace/kops toolbox dump --name e2e-kops-aws.test-cncf-aws.k8s.io -ojson
W0918 00:50:39.876] 2019/09/18 00:50:39 process.go:155: Step '/workspace/kops toolbox dump --name e2e-kops-aws.test-cncf-aws.k8s.io -ojson' finished in 8.434987184s
W0918 00:50:39.877] 2019/09/18 00:50:39 process.go:153: Running: kubectl get nodes -ojson
W0918 00:53:09.965] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0918 00:53:09.966] 2019/09/18 00:53:09 process.go:155: Step 'kubectl get nodes -ojson' finished in 2m30.089583795s
W0918 00:53:09.967] 2019/09/18 00:53:09 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0918 00:53:09.967] 2019/09/18 00:53:09 dump.go:89: Failed to get nodes for dumping via kubectl: error during kubectl get nodes -ojson: exit status 1
W0918 00:53:09.967] 2019/09/18 00:53:09 dump.go:123: dumping node not registered in kubernetes: 3.114.209.122
W0918 00:53:09.967] 2019/09/18 00:53:09 dump.go:157: Dumping node 3.114.209.122
W0918 00:53:11.286] 2019/09/18 00:53:11 dump.go:358: Running SSH command: sudo journalctl --output=short-precise -k
W0918 00:53:11.841] 2019/09/18 00:53:11 dump.go:358: Running SSH command: sudo journalctl --output=short-precise
W0918 00:53:14.982] 2019/09/18 00:53:14 dump.go:358: Running SSH command: sudo systemctl list-units -t service --no-pager --no-legend --all
W0918 00:53:15.243] 2019/09/18 00:53:15 dump.go:358: Running SSH command: sudo journalctl --output=cat -u kubelet.service
... skipping 180 lines ...
W0918 00:55:08.522]     check_env(env, self.command, *args)
W0918 00:55:08.522]   File "/workspace/./test-infra/jenkins/../scenarios/kubernetes_e2e.py", line 111, in check_env
W0918 00:55:08.522]     subprocess.check_call(cmd, env=env)
W0918 00:55:08.522]   File "/usr/lib/python2.7/subprocess.py", line 186, in check_call
W0918 00:55:08.522]     raise CalledProcessError(retcode, cmd)
W0918 00:55:08.523] 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-1d', '--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 00:55:08.523] Command failed
I0918 00:55:08.523] process 259 exited with code 1 after 25.7m
E0918 00:55:08.523] FAIL: ci-kubernetes-e2e-kops-aws
I0918 00:55:08.524] Call:  gcloud auth activate-service-account --key-file=/etc/service-account/service-account.json
W0918 00:55:09.052] Activated service account credentials for: [pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com]
I0918 00:55:09.129] process 645 exited with code 0 after 0.0m
I0918 00:55:09.130] Call:  gcloud config get-value account
I0918 00:55:09.481] process 657 exited with code 0 after 0.0m
I0918 00:55:09.481] Will upload results to gs://kubernetes-jenkins/logs using pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com
I0918 00:55:09.481] Upload result and artifacts...
I0918 00:55:09.481] Gubernator results at https://gubernator.k8s.io/build/kubernetes-jenkins/logs/ci-kubernetes-e2e-kops-aws/1174118128410431492
I0918 00:55:09.482] Call:  gsutil ls gs://kubernetes-jenkins/logs/ci-kubernetes-e2e-kops-aws/1174118128410431492/artifacts
W0918 00:55:10.604] CommandException: One or more URLs matched no objects.
E0918 00:55:10.721] Command failed
I0918 00:55:10.721] process 669 exited with code 1 after 0.0m
W0918 00:55:10.722] Remote dir gs://kubernetes-jenkins/logs/ci-kubernetes-e2e-kops-aws/1174118128410431492/artifacts not exist yet
I0918 00:55:10.722] 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/1174118128410431492/artifacts
I0918 00:55:14.824] process 811 exited with code 0 after 0.1m
I0918 00:55:14.825] Call:  git rev-parse HEAD
W0918 00:55:14.830] fatal: Not a git repository (or any of the parent directories): .git
E0918 00:55:14.831] Command failed
I0918 00:55:14.831] process 1448 exited with code 128 after 0.0m
I0918 00:55:14.831] Call:  git rev-parse HEAD
I0918 00:55:14.836] process 1449 exited with code 0 after 0.0m
I0918 00:55:14.837] Call:  gsutil stat gs://kubernetes-jenkins/logs/ci-kubernetes-e2e-kops-aws/jobResultsCache.json
I0918 00:55:16.099] process 1450 exited with code 0 after 0.0m
I0918 00:55:16.100] Call:  gsutil -q cat 'gs://kubernetes-jenkins/logs/ci-kubernetes-e2e-kops-aws/jobResultsCache.json#1568766271665798'
... skipping 8 lines ...