This job view page is being replaced by Spyglass soon. Check out the new job view.
ResultFAILURE
Tests 1 failed / 5 succeeded
Started2019-09-15 14:36
Elapsed25m5s
Revision
Buildergke-prow-ssd-pool-1a225945-l1d7
links{u'resultstore': {u'url': u'https://source.cloud.google.com/results/invocations/931624b0-e493-40b1-8dee-358ad63ae4b8/targets/test'}}
pod1c7da59e-d7c6-11e9-9f18-22ab134e4c57
resultstorehttps://source.cloud.google.com/results/invocations/931624b0-e493-40b1-8dee-358ad63ae4b8/targets/test
infra-commite1cbc3ccd
job-versionv1.17.0-alpha.0.1440+ba07527278ef2c
pod1c7da59e-d7c6-11e9-9f18-22ab134e4c57
revisionv1.17.0-alpha.0.1440+ba07527278ef2c

Test Failures


Up 20m26s

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 ...
I0915 14:36:44.467] process 45 exited with code 0 after 0.0m
I0915 14:36:44.468] Will upload results to gs://kubernetes-jenkins/logs using pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com
I0915 14:36:44.468] Root: /workspace
I0915 14:36:44.468] cd to /workspace
I0915 14:36:44.468] Configure environment...
I0915 14:36:44.469] Call:  git show -s --format=format:%ct HEAD
W0915 14:36:44.473] fatal: Not a git repository (or any of the parent directories): .git
I0915 14:36:44.474] process 57 exited with code 128 after 0.0m
W0915 14:36:44.474] Unable to print commit date for HEAD
I0915 14:36:44.475] Call:  gcloud auth activate-service-account --key-file=/etc/service-account/service-account.json
W0915 14:36:45.069] Activated service account credentials for: [pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com]
I0915 14:36:45.139] process 58 exited with code 0 after 0.0m
I0915 14:36:45.140] Call:  gcloud config get-value account
... skipping 701 lines ...
I0915 14:37:46.266]  * read about installing addons at: https://github.com/kubernetes/kops/blob/master/docs/addons.md.
I0915 14:37:46.266] 
W0915 14:37:46.367] 2019/09/15 14:37:46 process.go:155: Step '/workspace/kops update cluster e2e-kops-aws.test-cncf-aws.k8s.io --yes' finished in 19.495381567s
W0915 14:37:46.368] 2019/09/15 14:37:46 process.go:153: Running: kubectl get nodes -ojson
W0915 14:37:46.533] 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
W0915 14:37:46.541] 2019/09/15 14:37:46 process.go:155: Step 'kubectl get nodes -ojson' finished in 264.814134ms
W0915 14:37:46.541] 2019/09/15 14:37:46 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0915 14:37:46.542] 2019/09/15 14:37:46 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0915 14:38:16.541] 2019/09/15 14:38:16 process.go:153: Running: kubectl get nodes -ojson
W0915 14:38:46.696] 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
W0915 14:38:46.702] 2019/09/15 14:38:46 process.go:155: Step 'kubectl get nodes -ojson' finished in 30.160408261s
W0915 14:38:46.703] 2019/09/15 14:38:46 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0915 14:38:46.703] 2019/09/15 14:38:46 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0915 14:39:16.703] 2019/09/15 14:39:16 process.go:153: Running: kubectl get nodes -ojson
W0915 14:39:16.912] 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
W0915 14:39:16.916] 2019/09/15 14:39:16 process.go:155: Step 'kubectl get nodes -ojson' finished in 213.82174ms
W0915 14:39:16.916] 2019/09/15 14:39:16 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0915 14:39:16.917] 2019/09/15 14:39:16 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0915 14:39:46.919] 2019/09/15 14:39:46 process.go:153: Running: kubectl get nodes -ojson
W0915 14:39:47.090] 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
W0915 14:39:47.096] 2019/09/15 14:39:47 process.go:155: Step 'kubectl get nodes -ojson' finished in 179.193125ms
W0915 14:39:47.096] 2019/09/15 14:39:47 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0915 14:39:47.096] 2019/09/15 14:39:47 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0915 14:40:17.096] 2019/09/15 14:40:17 process.go:153: Running: kubectl get nodes -ojson
W0915 14:40:47.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
W0915 14:40:47.278] 2019/09/15 14:40:47 process.go:155: Step 'kubectl get nodes -ojson' finished in 30.181420949s
W0915 14:40:47.278] 2019/09/15 14:40:47 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0915 14:40:47.279] 2019/09/15 14:40:47 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0915 14:41:17.278] 2019/09/15 14:41:17 process.go:153: Running: kubectl get nodes -ojson
W0915 14:41:17.476] 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
W0915 14:41:17.483] 2019/09/15 14:41:17 process.go:155: Step 'kubectl get nodes -ojson' finished in 204.708478ms
W0915 14:41:17.483] 2019/09/15 14:41:17 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0915 14:41:17.483] 2019/09/15 14:41:17 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0915 14:41:47.483] 2019/09/15 14:41:47 process.go:153: Running: kubectl get nodes -ojson
W0915 14:41:47.696] 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
W0915 14:41:47.701] 2019/09/15 14:41:47 process.go:155: Step 'kubectl get nodes -ojson' finished in 217.790846ms
W0915 14:41:47.701] 2019/09/15 14:41:47 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0915 14:41:47.702] 2019/09/15 14:41:47 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0915 14:42:17.701] 2019/09/15 14:42:17 process.go:153: Running: kubectl get nodes -ojson
W0915 14:42:17.882] 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
W0915 14:42:17.886] 2019/09/15 14:42:17 process.go:155: Step 'kubectl get nodes -ojson' finished in 185.349978ms
W0915 14:42:17.887] 2019/09/15 14:42:17 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0915 14:42:17.887] 2019/09/15 14:42:17 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0915 14:42:47.887] 2019/09/15 14:42:47 process.go:153: Running: kubectl get nodes -ojson
W0915 14:45:17.982] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0915 14:45:17.987] 2019/09/15 14:45:17 process.go:155: Step 'kubectl get nodes -ojson' finished in 2m30.099864914s
W0915 14:45:17.987] 2019/09/15 14:45:17 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0915 14:45:17.987] 2019/09/15 14:45:17 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0915 14:45:47.988] 2019/09/15 14:45:47 process.go:153: Running: kubectl get nodes -ojson
W0915 14:48:18.093] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0915 14:48:18.098] 2019/09/15 14:48:18 process.go:155: Step 'kubectl get nodes -ojson' finished in 2m30.111081697s
W0915 14:48:18.099] 2019/09/15 14:48:18 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0915 14:48:18.099] 2019/09/15 14:48:18 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0915 14:48:48.099] 2019/09/15 14:48:48 process.go:153: Running: kubectl get nodes -ojson
W0915 14:51:18.190] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0915 14:51:18.194] 2019/09/15 14:51:18 process.go:155: Step 'kubectl get nodes -ojson' finished in 2m30.095716282s
W0915 14:51:18.195] 2019/09/15 14:51:18 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0915 14:51:18.195] 2019/09/15 14:51:18 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0915 14:51:48.195] 2019/09/15 14:51:48 process.go:153: Running: kubectl get nodes -ojson
W0915 14:54:18.297] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0915 14:54:18.298] 2019/09/15 14:54:18 process.go:155: Step 'kubectl get nodes -ojson' finished in 2m30.102505593s
W0915 14:54:18.298] 2019/09/15 14:54:18 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0915 14:54:18.298] 2019/09/15 14:54:18 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0915 14:54:48.299] 2019/09/15 14:54:48 process.go:153: Running: kubectl get nodes -ojson
W0915 14:57:18.494] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0915 14:57:18.496] 2019/09/15 14:57:18 process.go:155: Step 'kubectl get nodes -ojson' finished in 2m30.19649497s
W0915 14:57:18.496] 2019/09/15 14:57:18 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0915 14:57:18.496] 2019/09/15 14:57:18 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0915 14:57:48.497] 2019/09/15 14:57:48 process.go:153: Running: /workspace/kops toolbox dump --name e2e-kops-aws.test-cncf-aws.k8s.io -ojson
W0915 14:57:53.869] 2019/09/15 14:57:53 process.go:155: Step '/workspace/kops toolbox dump --name e2e-kops-aws.test-cncf-aws.k8s.io -ojson' finished in 5.370912861s
W0915 14:57:53.872] 2019/09/15 14:57:53 process.go:153: Running: kubectl get nodes -ojson
W0915 15:00:24.037] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0915 15:00:24.039] 2019/09/15 15:00:24 process.go:155: Step 'kubectl get nodes -ojson' finished in 2m30.16520229s
W0915 15:00:24.040] 2019/09/15 15:00:24 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0915 15:00:24.040] 2019/09/15 15:00:24 dump.go:89: Failed to get nodes for dumping via kubectl: error during kubectl get nodes -ojson: exit status 1
W0915 15:00:24.042] 2019/09/15 15:00:24 dump.go:123: dumping node not registered in kubernetes: 54.215.251.6
W0915 15:00:24.042] 2019/09/15 15:00:24 dump.go:157: Dumping node 54.215.251.6
W0915 15:00:24.539] 2019/09/15 15:00:24 dump.go:358: Running SSH command: sudo journalctl --output=short-precise -k
W0915 15:00:24.734] 2019/09/15 15:00:24 dump.go:358: Running SSH command: sudo journalctl --output=short-precise
W0915 15:00:28.128] 2019/09/15 15:00:28 dump.go:358: Running SSH command: sudo systemctl list-units -t service --no-pager --no-legend --all
W0915 15:00:28.223] 2019/09/15 15:00:28 dump.go:358: Running SSH command: sudo journalctl --output=cat -u kubelet.service
... skipping 150 lines ...
W0915 15:01:29.189]     check_env(env, self.command, *args)
W0915 15:01:29.189]   File "/workspace/./test-infra/jenkins/../scenarios/kubernetes_e2e.py", line 111, in check_env
W0915 15:01:29.189]     subprocess.check_call(cmd, env=env)
W0915 15:01:29.190]   File "/usr/lib/python2.7/subprocess.py", line 186, in check_call
W0915 15:01:29.190]     raise CalledProcessError(retcode, cmd)
W0915 15:01:29.195] 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=us-west-1a', '--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
E0915 15:01:29.196] Command failed
I0915 15:01:29.196] process 260 exited with code 1 after 24.7m
E0915 15:01:29.196] FAIL: ci-kubernetes-e2e-kops-aws
I0915 15:01:29.197] Call:  gcloud auth activate-service-account --key-file=/etc/service-account/service-account.json
W0915 15:01:30.051] Activated service account credentials for: [pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com]
I0915 15:01:30.140] process 661 exited with code 0 after 0.0m
I0915 15:01:30.140] Call:  gcloud config get-value account
I0915 15:01:30.663] process 673 exited with code 0 after 0.0m
I0915 15:01:30.664] Will upload results to gs://kubernetes-jenkins/logs using pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com
I0915 15:01:30.664] Upload result and artifacts...
I0915 15:01:30.664] Gubernator results at https://gubernator.k8s.io/build/kubernetes-jenkins/logs/ci-kubernetes-e2e-kops-aws/1173244208975187969
I0915 15:01:30.664] Call:  gsutil ls gs://kubernetes-jenkins/logs/ci-kubernetes-e2e-kops-aws/1173244208975187969/artifacts
W0915 15:01:32.604] CommandException: One or more URLs matched no objects.
E0915 15:01:32.856] Command failed
I0915 15:01:32.856] process 685 exited with code 1 after 0.0m
W0915 15:01:32.856] Remote dir gs://kubernetes-jenkins/logs/ci-kubernetes-e2e-kops-aws/1173244208975187969/artifacts not exist yet
I0915 15:01:32.857] 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/1173244208975187969/artifacts
I0915 15:01:40.965] process 827 exited with code 0 after 0.1m
I0915 15:01:40.966] Call:  git rev-parse HEAD
W0915 15:01:40.974] fatal: Not a git repository (or any of the parent directories): .git
E0915 15:01:40.975] Command failed
I0915 15:01:40.975] process 1466 exited with code 128 after 0.0m
I0915 15:01:40.975] Call:  git rev-parse HEAD
I0915 15:01:40.982] process 1467 exited with code 0 after 0.0m
I0915 15:01:40.983] Call:  gsutil stat gs://kubernetes-jenkins/logs/ci-kubernetes-e2e-kops-aws/jobResultsCache.json
I0915 15:01:43.052] process 1468 exited with code 0 after 0.0m
I0915 15:01:43.055] Call:  gsutil -q cat 'gs://kubernetes-jenkins/logs/ci-kubernetes-e2e-kops-aws/jobResultsCache.json#1568557874077963'
... skipping 8 lines ...