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 06:18
Elapsed26m32s
Revision
Buildergke-prow-ssd-pool-1a225945-fgds
links{u'resultstore': {u'url': u'https://source.cloud.google.com/results/invocations/fe0802eb-8be8-4e39-ac3d-c2f991d61fdc/targets/test'}}
pod0292aed0-d9dc-11e9-9368-d2ad95f0993d
resultstorehttps://source.cloud.google.com/results/invocations/fe0802eb-8be8-4e39-ac3d-c2f991d61fdc/targets/test
infra-commitf11ee8b6f
job-versionv1.17.0-alpha.0.1519+57d87502ba6408
pod0292aed0-d9dc-11e9-9368-d2ad95f0993d
revisionv1.17.0-alpha.0.1519+57d87502ba6408

Test Failures


Up 21m1s

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 06:18:22.462] process 44 exited with code 0 after 0.0m
I0918 06:18:22.462] Will upload results to gs://kubernetes-jenkins/logs using pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com
I0918 06:18:22.462] Root: /workspace
I0918 06:18:22.463] cd to /workspace
I0918 06:18:22.463] Configure environment...
I0918 06:18:22.463] Call:  git show -s --format=format:%ct HEAD
W0918 06:18:22.467] fatal: Not a git repository (or any of the parent directories): .git
I0918 06:18:22.467] process 56 exited with code 128 after 0.0m
W0918 06:18:22.467] Unable to print commit date for HEAD
I0918 06:18:22.468] Call:  gcloud auth activate-service-account --key-file=/etc/service-account/service-account.json
W0918 06:18:22.975] Activated service account credentials for: [pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com]
I0918 06:18:23.016] process 57 exited with code 0 after 0.0m
I0918 06:18:23.016] Call:  gcloud config get-value account
... skipping 701 lines ...
I0918 06:19:23.245]  * read about installing addons at: https://github.com/kubernetes/kops/blob/master/docs/addons.md.
I0918 06:19:23.245] 
W0918 06:19:23.345] 2019/09/18 06:19:23 process.go:155: Step '/workspace/kops update cluster e2e-kops-aws.test-cncf-aws.k8s.io --yes' finished in 22.985864513s
W0918 06:19:23.346] 2019/09/18 06:19:23 process.go:153: Running: kubectl get nodes -ojson
W0918 06:19:23.502] 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 06:19:23.506] 2019/09/18 06:19:23 process.go:155: Step 'kubectl get nodes -ojson' finished in 255.138268ms
W0918 06:19:23.506] 2019/09/18 06:19:23 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0918 06:19:23.506] 2019/09/18 06:19:23 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0918 06:19:53.506] 2019/09/18 06:19:53 process.go:153: Running: kubectl get nodes -ojson
W0918 06:20:53.645] 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 06:20:53.647] 2019/09/18 06:20:53 process.go:155: Step 'kubectl get nodes -ojson' finished in 1m0.140595569s
W0918 06:20:53.647] 2019/09/18 06:20:53 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0918 06:20:53.647] 2019/09/18 06:20:53 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0918 06:21:23.647] 2019/09/18 06:21:23 process.go:153: Running: kubectl get nodes -ojson
W0918 06:21:53.789] 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 06:21:53.792] 2019/09/18 06:21:53 process.go:155: Step 'kubectl get nodes -ojson' finished in 30.145387612s
W0918 06:21:53.793] 2019/09/18 06:21:53 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0918 06:21:53.793] 2019/09/18 06:21:53 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0918 06:22:23.794] 2019/09/18 06:22:23 process.go:153: Running: kubectl get nodes -ojson
W0918 06:22:54.012] 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 06:22:54.021] 2019/09/18 06:22:54 process.go:155: Step 'kubectl get nodes -ojson' finished in 30.227223975s
W0918 06:22:54.022] 2019/09/18 06:22:54 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0918 06:22:54.024] 2019/09/18 06:22:54 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0918 06:23:24.022] 2019/09/18 06:23:24 process.go:153: Running: kubectl get nodes -ojson
W0918 06:24:24.584] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0918 06:24:24.587] 2019/09/18 06:24:24 process.go:155: Step 'kubectl get nodes -ojson' finished in 1m0.56515036s
W0918 06:24:24.588] 2019/09/18 06:24:24 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0918 06:24:24.588] 2019/09/18 06:24:24 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0918 06:24:54.588] 2019/09/18 06:24:54 process.go:153: Running: kubectl get nodes -ojson
W0918 06:27:24.657] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0918 06:27:24.661] 2019/09/18 06:27:24 process.go:155: Step 'kubectl get nodes -ojson' finished in 2m30.072989698s
W0918 06:27:24.661] 2019/09/18 06:27:24 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0918 06:27:24.662] 2019/09/18 06:27:24 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0918 06:27:54.663] 2019/09/18 06:27:54 process.go:153: Running: kubectl get nodes -ojson
W0918 06:30:24.911] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0918 06:30:24.914] 2019/09/18 06:30:24 process.go:155: Step 'kubectl get nodes -ojson' finished in 2m30.251986511s
W0918 06:30:24.914] 2019/09/18 06:30:24 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0918 06:30:24.914] 2019/09/18 06:30:24 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0918 06:30:54.915] 2019/09/18 06:30:54 process.go:153: Running: kubectl get nodes -ojson
W0918 06:33:25.092] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0918 06:33:25.096] 2019/09/18 06:33:25 process.go:155: Step 'kubectl get nodes -ojson' finished in 2m30.181267403s
W0918 06:33:25.096] 2019/09/18 06:33:25 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0918 06:33:25.096] 2019/09/18 06:33:25 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0918 06:33:55.097] 2019/09/18 06:33:55 process.go:153: Running: kubectl get nodes -ojson
W0918 06:36:25.327] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0918 06:36:25.335] 2019/09/18 06:36:25 process.go:155: Step 'kubectl get nodes -ojson' finished in 2m30.237972963s
W0918 06:36:25.336] 2019/09/18 06:36:25 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0918 06:36:25.336] 2019/09/18 06:36:25 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0918 06:36:55.335] 2019/09/18 06:36:55 process.go:153: Running: kubectl get nodes -ojson
W0918 06:39:25.458] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0918 06:39:25.464] 2019/09/18 06:39:25 process.go:155: Step 'kubectl get nodes -ojson' finished in 2m30.128891843s
W0918 06:39:25.464] 2019/09/18 06:39:25 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0918 06:39:25.465] 2019/09/18 06:39:25 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0918 06:39:55.467] 2019/09/18 06:39:55 process.go:153: Running: /workspace/kops toolbox dump --name e2e-kops-aws.test-cncf-aws.k8s.io -ojson
W0918 06:40:04.599] 2019/09/18 06:40:04 process.go:155: Step '/workspace/kops toolbox dump --name e2e-kops-aws.test-cncf-aws.k8s.io -ojson' finished in 9.131169791s
W0918 06:40:04.605] 2019/09/18 06:40:04 process.go:153: Running: kubectl get nodes -ojson
W0918 06:42:34.753] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0918 06:42:34.756] 2019/09/18 06:42:34 process.go:155: Step 'kubectl get nodes -ojson' finished in 2m30.151874715s
W0918 06:42:34.756] 2019/09/18 06:42:34 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0918 06:42:34.757] 2019/09/18 06:42:34 dump.go:89: Failed to get nodes for dumping via kubectl: error during kubectl get nodes -ojson: exit status 1
W0918 06:42:34.757] 2019/09/18 06:42:34 dump.go:123: dumping node not registered in kubernetes: 3.112.6.3
W0918 06:42:34.757] 2019/09/18 06:42:34 dump.go:157: Dumping node 3.112.6.3
W0918 06:42:36.039] 2019/09/18 06:42:36 dump.go:358: Running SSH command: sudo journalctl --output=short-precise -k
W0918 06:42:36.806] 2019/09/18 06:42:36 dump.go:358: Running SSH command: sudo journalctl --output=short-precise
W0918 06:42:40.210] 2019/09/18 06:42:40 dump.go:358: Running SSH command: sudo systemctl list-units -t service --no-pager --no-legend --all
W0918 06:42:40.463] 2019/09/18 06:42:40 dump.go:358: Running SSH command: sudo journalctl --output=cat -u kubelet.service
... skipping 190 lines ...
W0918 06:44:44.624]     check_env(env, self.command, *args)
W0918 06:44:44.624]   File "/workspace/./test-infra/jenkins/../scenarios/kubernetes_e2e.py", line 111, in check_env
W0918 06:44:44.624]     subprocess.check_call(cmd, env=env)
W0918 06:44:44.625]   File "/usr/lib/python2.7/subprocess.py", line 186, in check_call
W0918 06:44:44.625]     raise CalledProcessError(retcode, cmd)
W0918 06:44:44.625] 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-1c', '--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 06:44:44.626] Command failed
I0918 06:44:44.626] process 259 exited with code 1 after 26.3m
E0918 06:44:44.626] FAIL: ci-kubernetes-e2e-kops-aws
I0918 06:44:44.626] Call:  gcloud auth activate-service-account --key-file=/etc/service-account/service-account.json
W0918 06:44:45.085] Activated service account credentials for: [pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com]
I0918 06:44:45.127] process 608 exited with code 0 after 0.0m
I0918 06:44:45.127] Call:  gcloud config get-value account
I0918 06:44:45.422] process 620 exited with code 0 after 0.0m
I0918 06:44:45.422] Will upload results to gs://kubernetes-jenkins/logs using pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com
I0918 06:44:45.422] Upload result and artifacts...
I0918 06:44:45.422] Gubernator results at https://gubernator.k8s.io/build/kubernetes-jenkins/logs/ci-kubernetes-e2e-kops-aws/1174205959015239682
I0918 06:44:45.423] Call:  gsutil ls gs://kubernetes-jenkins/logs/ci-kubernetes-e2e-kops-aws/1174205959015239682/artifacts
W0918 06:44:46.448] CommandException: One or more URLs matched no objects.
E0918 06:44:46.553] Command failed
I0918 06:44:46.553] process 632 exited with code 1 after 0.0m
W0918 06:44:46.553] Remote dir gs://kubernetes-jenkins/logs/ci-kubernetes-e2e-kops-aws/1174205959015239682/artifacts not exist yet
I0918 06:44:46.553] 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/1174205959015239682/artifacts
I0918 06:44:50.391] process 774 exited with code 0 after 0.1m
I0918 06:44:50.392] Call:  git rev-parse HEAD
W0918 06:44:50.396] fatal: Not a git repository (or any of the parent directories): .git
E0918 06:44:50.396] Command failed
I0918 06:44:50.397] process 1413 exited with code 128 after 0.0m
I0918 06:44:50.397] Call:  git rev-parse HEAD
I0918 06:44:50.400] process 1414 exited with code 0 after 0.0m
I0918 06:44:50.401] Call:  gsutil stat gs://kubernetes-jenkins/logs/ci-kubernetes-e2e-kops-aws/jobResultsCache.json
I0918 06:44:51.415] process 1415 exited with code 0 after 0.0m
I0918 06:44:51.416] Call:  gsutil -q cat 'gs://kubernetes-jenkins/logs/ci-kubernetes-e2e-kops-aws/jobResultsCache.json#1568787248772915'
... skipping 8 lines ...