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 05:47
Elapsed26m41s
Revision
Buildergke-prow-ssd-pool-1a225945-qlhl
links{u'resultstore': {u'url': u'https://source.cloud.google.com/results/invocations/9d9cafff-78de-484a-b943-c57ca540db63/targets/test'}}
podadd95be0-d9d7-11e9-9368-d2ad95f0993d
resultstorehttps://source.cloud.google.com/results/invocations/9d9cafff-78de-484a-b943-c57ca540db63/targets/test
infra-commitf11ee8b6f
job-versionv1.17.0-alpha.0.1517+e8f26a0445a8b9
podadd95be0-d9d7-11e9-9368-d2ad95f0993d
revisionv1.17.0-alpha.0.1517+e8f26a0445a8b9

Test Failures


Up 20m37s

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 05:47:28.737] process 48 exited with code 0 after 0.0m
I0918 05:47:28.737] Will upload results to gs://kubernetes-jenkins/logs using pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com
I0918 05:47:28.737] Root: /workspace
I0918 05:47:28.738] cd to /workspace
I0918 05:47:28.738] Configure environment...
I0918 05:47:28.738] Call:  git show -s --format=format:%ct HEAD
W0918 05:47:28.744] fatal: Not a git repository (or any of the parent directories): .git
I0918 05:47:28.745] process 60 exited with code 128 after 0.0m
W0918 05:47:28.745] Unable to print commit date for HEAD
I0918 05:47:28.746] Call:  gcloud auth activate-service-account --key-file=/etc/service-account/service-account.json
W0918 05:47:29.416] Activated service account credentials for: [pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com]
I0918 05:47:29.495] process 61 exited with code 0 after 0.0m
I0918 05:47:29.495] Call:  gcloud config get-value account
... skipping 701 lines ...
I0918 05:48:47.354]  * read about installing addons at: https://github.com/kubernetes/kops/blob/master/docs/addons.md.
I0918 05:48:47.354] 
W0918 05:48:47.455] 2019/09/18 05:48:47 process.go:155: Step '/workspace/kops update cluster e2e-kops-aws.test-cncf-aws.k8s.io --yes' finished in 25.714105559s
W0918 05:48:47.456] 2019/09/18 05:48:47 process.go:153: Running: kubectl get nodes -ojson
W0918 05:48:47.722] 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 05:48:47.727] 2019/09/18 05:48:47 process.go:155: Step 'kubectl get nodes -ojson' finished in 363.724759ms
W0918 05:48:47.728] 2019/09/18 05:48:47 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0918 05:48:47.729] 2019/09/18 05:48:47 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0918 05:49:17.728] 2019/09/18 05:49:17 process.go:153: Running: kubectl get nodes -ojson
W0918 05:50:47.970] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0918 05:50:47.974] 2019/09/18 05:50:47 process.go:155: Step 'kubectl get nodes -ojson' finished in 1m30.24533312s
W0918 05:50:47.974] 2019/09/18 05:50:47 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0918 05:50:47.975] 2019/09/18 05:50:47 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0918 05:51:17.974] 2019/09/18 05:51:17 process.go:153: Running: kubectl get nodes -ojson
W0918 05:53:18.223] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0918 05:53:18.224] 2019/09/18 05:53:18 process.go:155: Step 'kubectl get nodes -ojson' finished in 2m0.24964842s
W0918 05:53:18.225] 2019/09/18 05:53:18 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0918 05:53:18.225] 2019/09/18 05:53:18 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0918 05:53:48.228] 2019/09/18 05:53:48 process.go:153: Running: kubectl get nodes -ojson
W0918 05:56:18.340] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0918 05:56:18.346] 2019/09/18 05:56:18 process.go:155: Step 'kubectl get nodes -ojson' finished in 2m30.118576428s
W0918 05:56:18.349] 2019/09/18 05:56:18 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0918 05:56:18.350] 2019/09/18 05:56:18 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0918 05:56:48.348] 2019/09/18 05:56:48 process.go:153: Running: kubectl get nodes -ojson
W0918 05:59:18.503] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0918 05:59:18.506] 2019/09/18 05:59:18 process.go:155: Step 'kubectl get nodes -ojson' finished in 2m30.15798281s
W0918 05:59:18.507] 2019/09/18 05:59:18 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0918 05:59:18.508] 2019/09/18 05:59:18 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0918 05:59:48.508] 2019/09/18 05:59:48 process.go:153: Running: kubectl get nodes -ojson
W0918 06:02:18.790] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0918 06:02:18.791] 2019/09/18 06:02:18 process.go:155: Step 'kubectl get nodes -ojson' finished in 2m30.279013224s
W0918 06:02:18.791] 2019/09/18 06:02:18 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0918 06:02:18.791] 2019/09/18 06:02:18 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0918 06:02:48.787] 2019/09/18 06:02:48 process.go:153: Running: kubectl get nodes -ojson
W0918 06:05:19.053] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0918 06:05:19.055] 2019/09/18 06:05:19 process.go:155: Step 'kubectl get nodes -ojson' finished in 2m30.268183s
W0918 06:05:19.055] 2019/09/18 06:05:19 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0918 06:05:19.055] 2019/09/18 06:05:19 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0918 06:05:49.056] 2019/09/18 06:05:49 process.go:153: Running: kubectl get nodes -ojson
W0918 06:08:19.134] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0918 06:08:19.135] 2019/09/18 06:08:19 process.go:155: Step 'kubectl get nodes -ojson' finished in 2m30.078697957s
W0918 06:08:19.135] 2019/09/18 06:08:19 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0918 06:08:19.135] 2019/09/18 06:08:19 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0918 06:08:49.137] 2019/09/18 06:08:49 process.go:153: Running: /workspace/kops toolbox dump --name e2e-kops-aws.test-cncf-aws.k8s.io -ojson
W0918 06:09:00.530] 2019/09/18 06:09:00 process.go:155: Step '/workspace/kops toolbox dump --name e2e-kops-aws.test-cncf-aws.k8s.io -ojson' finished in 11.391063613s
W0918 06:09:00.531] 2019/09/18 06:09:00 process.go:153: Running: kubectl get nodes -ojson
W0918 06:11:30.682] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0918 06:11:30.682] 2019/09/18 06:11:30 process.go:155: Step 'kubectl get nodes -ojson' finished in 2m30.152157382s
W0918 06:11:30.683] 2019/09/18 06:11:30 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0918 06:11:30.683] 2019/09/18 06:11:30 dump.go:89: Failed to get nodes for dumping via kubectl: error during kubectl get nodes -ojson: exit status 1
W0918 06:11:30.683] 2019/09/18 06:11:30 dump.go:123: dumping node not registered in kubernetes: 3.104.105.180
W0918 06:11:30.683] 2019/09/18 06:11:30 dump.go:157: Dumping node 3.104.105.180
W0918 06:11:32.721] 2019/09/18 06:11:32 dump.go:358: Running SSH command: sudo journalctl --output=short-precise -k
W0918 06:11:33.536] 2019/09/18 06:11:33 dump.go:358: Running SSH command: sudo journalctl --output=short-precise
W0918 06:11:37.491] 2019/09/18 06:11:37 dump.go:358: Running SSH command: sudo systemctl list-units -t service --no-pager --no-legend --all
W0918 06:11:37.896] 2019/09/18 06:11:37 dump.go:358: Running SSH command: sudo journalctl --output=cat -u kubelet.service
... skipping 178 lines ...
W0918 06:13:59.044]     check_env(env, self.command, *args)
W0918 06:13:59.044]   File "/workspace/./test-infra/jenkins/../scenarios/kubernetes_e2e.py", line 111, in check_env
W0918 06:13:59.044]     subprocess.check_call(cmd, env=env)
W0918 06:13:59.045]   File "/usr/lib/python2.7/subprocess.py", line 186, in check_call
W0918 06:13:59.045]     raise CalledProcessError(retcode, cmd)
W0918 06:13:59.045] 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
E0918 06:13:59.046] Command failed
I0918 06:13:59.046] process 263 exited with code 1 after 26.4m
E0918 06:13:59.046] FAIL: ci-kubernetes-e2e-kops-aws
I0918 06:13:59.046] Call:  gcloud auth activate-service-account --key-file=/etc/service-account/service-account.json
W0918 06:13:59.547] Activated service account credentials for: [pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com]
I0918 06:13:59.597] process 593 exited with code 0 after 0.0m
I0918 06:13:59.597] Call:  gcloud config get-value account
I0918 06:13:59.900] process 605 exited with code 0 after 0.0m
I0918 06:13:59.901] Will upload results to gs://kubernetes-jenkins/logs using pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com
I0918 06:13:59.901] Upload result and artifacts...
I0918 06:13:59.901] Gubernator results at https://gubernator.k8s.io/build/kubernetes-jenkins/logs/ci-kubernetes-e2e-kops-aws/1174198158960365575
I0918 06:13:59.902] Call:  gsutil ls gs://kubernetes-jenkins/logs/ci-kubernetes-e2e-kops-aws/1174198158960365575/artifacts
W0918 06:14:01.062] CommandException: One or more URLs matched no objects.
E0918 06:14:01.176] Command failed
I0918 06:14:01.177] process 617 exited with code 1 after 0.0m
W0918 06:14:01.177] Remote dir gs://kubernetes-jenkins/logs/ci-kubernetes-e2e-kops-aws/1174198158960365575/artifacts not exist yet
I0918 06:14:01.177] 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/1174198158960365575/artifacts
I0918 06:14:05.093] process 759 exited with code 0 after 0.1m
I0918 06:14:05.094] Call:  git rev-parse HEAD
W0918 06:14:05.098] fatal: Not a git repository (or any of the parent directories): .git
E0918 06:14:05.099] Command failed
I0918 06:14:05.099] process 1398 exited with code 128 after 0.0m
I0918 06:14:05.099] Call:  git rev-parse HEAD
I0918 06:14:05.104] process 1399 exited with code 0 after 0.0m
I0918 06:14:05.104] Call:  gsutil stat gs://kubernetes-jenkins/logs/ci-kubernetes-e2e-kops-aws/jobResultsCache.json
I0918 06:14:06.234] process 1400 exited with code 0 after 0.0m
I0918 06:14:06.236] Call:  gsutil -q cat 'gs://kubernetes-jenkins/logs/ci-kubernetes-e2e-kops-aws/jobResultsCache.json#1568785524827962'
... skipping 8 lines ...