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 15:26
Elapsed26m54s
Revision
Buildergke-prow-ssd-pool-1a225945-2rml
links{u'resultstore': {u'url': u'https://source.cloud.google.com/results/invocations/4ce9da1a-5abe-496c-bc21-00a1efb781e3/targets/test'}}
pod66f505a8-d4a8-11e9-9d26-329cee23a2e0
resultstorehttps://source.cloud.google.com/results/invocations/4ce9da1a-5abe-496c-bc21-00a1efb781e3/targets/test
infra-commit3d071c448
job-versionv1.17.0-alpha.0.1235+aa07db3b775415
pod66f505a8-d4a8-11e9-9d26-329cee23a2e0
revisionv1.17.0-alpha.0.1235+aa07db3b775415

Test Failures


Up 21m39s

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 15:26:21.361] process 45 exited with code 0 after 0.0m
I0911 15:26:21.362] Will upload results to gs://kubernetes-jenkins/logs using pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com
I0911 15:26:21.362] Root: /workspace
I0911 15:26:21.362] cd to /workspace
I0911 15:26:21.362] Configure environment...
I0911 15:26:21.363] Call:  git show -s --format=format:%ct HEAD
W0911 15:26:21.366] fatal: Not a git repository (or any of the parent directories): .git
I0911 15:26:21.367] process 57 exited with code 128 after 0.0m
W0911 15:26:21.367] Unable to print commit date for HEAD
I0911 15:26:21.368] Call:  gcloud auth activate-service-account --key-file=/etc/service-account/service-account.json
W0911 15:26:21.905] Activated service account credentials for: [pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com]
I0911 15:26:21.973] process 58 exited with code 0 after 0.0m
I0911 15:26:21.974] Call:  gcloud config get-value account
... skipping 701 lines ...
I0911 15:27:31.528]  * read about installing addons at: https://github.com/kubernetes/kops/blob/master/docs/addons.md.
I0911 15:27:31.528] 
W0911 15:27:31.628] 2019/09/11 15:27:31 process.go:155: Step '/workspace/kops update cluster e2e-kops-aws.test-cncf-aws.k8s.io --yes' finished in 28.378279932s
W0911 15:27:31.628] 2019/09/11 15:27:31 process.go:153: Running: kubectl get nodes -ojson
W0911 15:27:31.817] 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 15:27:31.820] 2019/09/11 15:27:31 process.go:155: Step 'kubectl get nodes -ojson' finished in 284.952673ms
W0911 15:27:31.821] 2019/09/11 15:27:31 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0911 15:27:31.821] 2019/09/11 15:27:31 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0911 15:28:01.821] 2019/09/11 15:28:01 process.go:153: Running: kubectl get nodes -ojson
W0911 15:29:02.010] 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 15:29:02.013] 2019/09/11 15:29:02 process.go:155: Step 'kubectl get nodes -ojson' finished in 1m0.192184689s
W0911 15:29:02.013] 2019/09/11 15:29:02 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0911 15:29:02.013] 2019/09/11 15:29:02 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0911 15:29:32.013] 2019/09/11 15:29:32 process.go:153: Running: kubectl get nodes -ojson
W0911 15:29:32.181] 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 15:29:32.183] 2019/09/11 15:29:32 process.go:155: Step 'kubectl get nodes -ojson' finished in 170.259521ms
W0911 15:29:32.184] 2019/09/11 15:29:32 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0911 15:29:32.184] 2019/09/11 15:29:32 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0911 15:30:02.184] 2019/09/11 15:30:02 process.go:153: Running: kubectl get nodes -ojson
W0911 15:31:02.359] 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 15:31:02.360] 2019/09/11 15:31:02 process.go:155: Step 'kubectl get nodes -ojson' finished in 1m0.174060053s
W0911 15:31:02.360] 2019/09/11 15:31:02 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0911 15:31:02.360] 2019/09/11 15:31:02 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0911 15:31:32.359] 2019/09/11 15:31:32 process.go:153: Running: kubectl get nodes -ojson
W0911 15:33:02.689] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0911 15:33:02.695] 2019/09/11 15:33:02 process.go:155: Step 'kubectl get nodes -ojson' finished in 1m30.336106271s
W0911 15:33:02.695] 2019/09/11 15:33:02 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0911 15:33:02.696] 2019/09/11 15:33:02 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0911 15:33:32.696] 2019/09/11 15:33:32 process.go:153: Running: kubectl get nodes -ojson
W0911 15:36:02.814] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0911 15:36:02.817] 2019/09/11 15:36:02 process.go:155: Step 'kubectl get nodes -ojson' finished in 2m30.121338587s
W0911 15:36:02.817] 2019/09/11 15:36:02 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0911 15:36:02.817] 2019/09/11 15:36:02 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0911 15:36:32.817] 2019/09/11 15:36:32 process.go:153: Running: kubectl get nodes -ojson
W0911 15:39:02.931] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0911 15:39:02.933] 2019/09/11 15:39:02 process.go:155: Step 'kubectl get nodes -ojson' finished in 2m30.115622762s
W0911 15:39:02.933] 2019/09/11 15:39:02 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0911 15:39:02.933] 2019/09/11 15:39:02 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0911 15:39:32.933] 2019/09/11 15:39:32 process.go:153: Running: kubectl get nodes -ojson
W0911 15:42:03.028] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0911 15:42:03.032] 2019/09/11 15:42:03 process.go:155: Step 'kubectl get nodes -ojson' finished in 2m30.098861937s
W0911 15:42:03.033] 2019/09/11 15:42:03 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0911 15:42:03.033] 2019/09/11 15:42:03 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0911 15:42:33.033] 2019/09/11 15:42:33 process.go:153: Running: kubectl get nodes -ojson
W0911 15:45:03.154] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0911 15:45:03.156] 2019/09/11 15:45:03 process.go:155: Step 'kubectl get nodes -ojson' finished in 2m30.123593589s
W0911 15:45:03.156] 2019/09/11 15:45:03 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0911 15:45:03.157] 2019/09/11 15:45:03 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0911 15:45:33.157] 2019/09/11 15:45:33 process.go:153: Running: kubectl get nodes -ojson
W0911 15:48:03.244] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0911 15:48:03.246] 2019/09/11 15:48:03 process.go:155: Step 'kubectl get nodes -ojson' finished in 2m30.089819799s
W0911 15:48:03.246] 2019/09/11 15:48:03 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0911 15:48:03.247] 2019/09/11 15:48:03 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0911 15:48:33.247] 2019/09/11 15:48:33 process.go:153: Running: /workspace/kops toolbox dump --name e2e-kops-aws.test-cncf-aws.k8s.io -ojson
W0911 15:48:43.617] 2019/09/11 15:48:43 process.go:155: Step '/workspace/kops toolbox dump --name e2e-kops-aws.test-cncf-aws.k8s.io -ojson' finished in 10.369751499s
W0911 15:48:43.621] 2019/09/11 15:48:43 process.go:153: Running: kubectl get nodes -ojson
W0911 15:51:13.708] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0911 15:51:13.711] 2019/09/11 15:51:13 process.go:155: Step 'kubectl get nodes -ojson' finished in 2m30.089809903s
W0911 15:51:13.711] 2019/09/11 15:51:13 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0911 15:51:13.711] 2019/09/11 15:51:13 dump.go:89: Failed to get nodes for dumping via kubectl: error during kubectl get nodes -ojson: exit status 1
W0911 15:51:13.711] 2019/09/11 15:51:13 dump.go:123: dumping node not registered in kubernetes: 54.252.241.69
W0911 15:51:13.711] 2019/09/11 15:51:13 dump.go:157: Dumping node 54.252.241.69
W0911 15:51:15.784] 2019/09/11 15:51:15 dump.go:358: Running SSH command: sudo journalctl --output=short-precise -k
W0911 15:51:16.627] 2019/09/11 15:51:16 dump.go:358: Running SSH command: sudo journalctl --output=short-precise
W0911 15:51:21.051] 2019/09/11 15:51:21 dump.go:358: Running SSH command: sudo systemctl list-units -t service --no-pager --no-legend --all
W0911 15:51:21.462] 2019/09/11 15:51:21 dump.go:358: Running SSH command: sudo journalctl --output=cat -u kubelet.service
... skipping 150 lines ...
W0911 15:53:03.812]     check_env(env, self.command, *args)
W0911 15:53:03.812]   File "/workspace/./test-infra/jenkins/../scenarios/kubernetes_e2e.py", line 111, in check_env
W0911 15:53:03.813]     subprocess.check_call(cmd, env=env)
W0911 15:53:03.813]   File "/usr/lib/python2.7/subprocess.py", line 186, in check_call
W0911 15:53:03.813]     raise CalledProcessError(retcode, cmd)
W0911 15:53:03.814] 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-southeast-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 15:53:03.814] Command failed
I0911 15:53:03.814] process 260 exited with code 1 after 26.7m
E0911 15:53:03.814] FAIL: ci-kubernetes-e2e-kops-aws
I0911 15:53:03.815] Call:  gcloud auth activate-service-account --key-file=/etc/service-account/service-account.json
W0911 15:53:04.365] Activated service account credentials for: [pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com]
I0911 15:53:04.437] process 614 exited with code 0 after 0.0m
I0911 15:53:04.437] Call:  gcloud config get-value account
I0911 15:53:04.752] process 626 exited with code 0 after 0.0m
I0911 15:53:04.753] Will upload results to gs://kubernetes-jenkins/logs using pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com
I0911 15:53:04.753] Upload result and artifacts...
I0911 15:53:04.753] Gubernator results at https://gubernator.k8s.io/build/kubernetes-jenkins/logs/ci-kubernetes-e2e-kops-aws/1171807138280902659
I0911 15:53:04.754] Call:  gsutil ls gs://kubernetes-jenkins/logs/ci-kubernetes-e2e-kops-aws/1171807138280902659/artifacts
W0911 15:53:05.964] CommandException: One or more URLs matched no objects.
E0911 15:53:06.089] Command failed
I0911 15:53:06.089] process 638 exited with code 1 after 0.0m
W0911 15:53:06.089] Remote dir gs://kubernetes-jenkins/logs/ci-kubernetes-e2e-kops-aws/1171807138280902659/artifacts not exist yet
I0911 15:53:06.090] 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/1171807138280902659/artifacts
I0911 15:53:10.308] process 780 exited with code 0 after 0.1m
I0911 15:53:10.308] Call:  git rev-parse HEAD
W0911 15:53:10.312] fatal: Not a git repository (or any of the parent directories): .git
E0911 15:53:10.313] Command failed
I0911 15:53:10.313] process 1419 exited with code 128 after 0.0m
I0911 15:53:10.313] Call:  git rev-parse HEAD
I0911 15:53:10.317] process 1420 exited with code 0 after 0.0m
I0911 15:53:10.317] Call:  gsutil stat gs://kubernetes-jenkins/logs/ci-kubernetes-e2e-kops-aws/jobResultsCache.json
I0911 15:53:11.447] process 1421 exited with code 0 after 0.0m
I0911 15:53:11.448] Call:  gsutil -q cat 'gs://kubernetes-jenkins/logs/ci-kubernetes-e2e-kops-aws/jobResultsCache.json#1568215481400511'
... skipping 8 lines ...