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 04:14
Elapsed27m30s
Revision
Buildergke-prow-ssd-pool-1a225945-p7vq
links{u'resultstore': {u'url': u'https://source.cloud.google.com/results/invocations/6ce62d09-0651-412f-9196-e9a0bfe4c7ff/targets/test'}}
podafd14819-d9ca-11e9-9368-d2ad95f0993d
resultstorehttps://source.cloud.google.com/results/invocations/6ce62d09-0651-412f-9196-e9a0bfe4c7ff/targets/test
infra-commit7672de02b
job-versionv1.17.0-alpha.0.1515+cfa3e2c499d531
podafd14819-d9ca-11e9-9368-d2ad95f0993d
revisionv1.17.0-alpha.0.1515+cfa3e2c499d531

Test Failures


Up 22m55s

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 04:14:23.816] process 48 exited with code 0 after 0.0m
I0918 04:14:23.816] Will upload results to gs://kubernetes-jenkins/logs using pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com
I0918 04:14:23.816] Root: /workspace
I0918 04:14:23.817] cd to /workspace
I0918 04:14:23.817] Configure environment...
I0918 04:14:23.817] Call:  git show -s --format=format:%ct HEAD
W0918 04:14:23.821] fatal: Not a git repository (or any of the parent directories): .git
I0918 04:14:23.822] process 60 exited with code 128 after 0.0m
W0918 04:14:23.822] Unable to print commit date for HEAD
I0918 04:14:23.823] Call:  gcloud auth activate-service-account --key-file=/etc/service-account/service-account.json
W0918 04:14:24.356] Activated service account credentials for: [pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com]
I0918 04:14:24.414] process 61 exited with code 0 after 0.0m
I0918 04:14:24.415] Call:  gcloud config get-value account
... skipping 701 lines ...
I0918 04:15:19.530]  * read about installing addons at: https://github.com/kubernetes/kops/blob/master/docs/addons.md.
I0918 04:15:19.530] 
W0918 04:15:19.631] 2019/09/18 04:15:19 process.go:155: Step '/workspace/kops update cluster e2e-kops-aws.test-cncf-aws.k8s.io --yes' finished in 19.398715393s
W0918 04:15:19.632] 2019/09/18 04:15:19 process.go:153: Running: kubectl get nodes -ojson
W0918 04:15:19.773] 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 04:15:19.778] 2019/09/18 04:15:19 process.go:155: Step 'kubectl get nodes -ojson' finished in 242.788455ms
W0918 04:15:19.779] 2019/09/18 04:15:19 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0918 04:15:19.779] 2019/09/18 04:15:19 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0918 04:15:49.779] 2019/09/18 04:15:49 process.go:153: Running: kubectl get nodes -ojson
W0918 04:16:19.929] 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 04:16:19.932] 2019/09/18 04:16:19 process.go:155: Step 'kubectl get nodes -ojson' finished in 30.153651668s
W0918 04:16:19.933] 2019/09/18 04:16:19 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0918 04:16:19.933] 2019/09/18 04:16:19 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0918 04:16:49.933] 2019/09/18 04:16:49 process.go:153: Running: kubectl get nodes -ojson
W0918 04:18:50.037] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0918 04:18:50.038] 2019/09/18 04:18:50 process.go:155: Step 'kubectl get nodes -ojson' finished in 2m0.104877759s
W0918 04:18:50.038] 2019/09/18 04:18:50 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0918 04:18:50.038] 2019/09/18 04:18:50 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0918 04:19:20.039] 2019/09/18 04:19:20 process.go:153: Running: kubectl get nodes -ojson
W0918 04:19:20.205] 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 04:19:20.208] 2019/09/18 04:19:20 process.go:155: Step 'kubectl get nodes -ojson' finished in 170.053784ms
W0918 04:19:20.209] 2019/09/18 04:19:20 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0918 04:19:20.209] 2019/09/18 04:19:20 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0918 04:19:50.209] 2019/09/18 04:19:50 process.go:153: Running: kubectl get nodes -ojson
W0918 04:22:20.296] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0918 04:22:20.297] 2019/09/18 04:22:20 process.go:155: Step 'kubectl get nodes -ojson' finished in 2m30.086200703s
W0918 04:22:20.297] 2019/09/18 04:22:20 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0918 04:22:20.297] 2019/09/18 04:22:20 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0918 04:22:50.295] 2019/09/18 04:22:50 process.go:153: Running: kubectl get nodes -ojson
W0918 04:25:20.454] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0918 04:25:20.469] 2019/09/18 04:25:20 process.go:155: Step 'kubectl get nodes -ojson' finished in 2m30.173972646s
W0918 04:25:20.470] 2019/09/18 04:25:20 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0918 04:25:20.470] 2019/09/18 04:25:20 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0918 04:25:50.471] 2019/09/18 04:25:50 process.go:153: Running: kubectl get nodes -ojson
W0918 04:28:20.642] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0918 04:28:20.642] 2019/09/18 04:28:20 process.go:155: Step 'kubectl get nodes -ojson' finished in 2m30.171090245s
W0918 04:28:20.642] 2019/09/18 04:28:20 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0918 04:28:20.643] 2019/09/18 04:28:20 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0918 04:28:50.642] 2019/09/18 04:28:50 process.go:153: Running: kubectl get nodes -ojson
W0918 04:31:20.730] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0918 04:31:20.731] 2019/09/18 04:31:20 process.go:155: Step 'kubectl get nodes -ojson' finished in 2m30.088729892s
W0918 04:31:20.731] 2019/09/18 04:31:20 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0918 04:31:20.731] 2019/09/18 04:31:20 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0918 04:31:50.731] 2019/09/18 04:31:50 process.go:153: Running: kubectl get nodes -ojson
W0918 04:34:20.810] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0918 04:34:20.810] 2019/09/18 04:34:20 process.go:155: Step 'kubectl get nodes -ojson' finished in 2m30.079226455s
W0918 04:34:20.811] 2019/09/18 04:34:20 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0918 04:34:20.811] 2019/09/18 04:34:20 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0918 04:34:50.811] 2019/09/18 04:34:50 process.go:153: Running: kubectl get nodes -ojson
W0918 04:37:20.895] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0918 04:37:20.900] 2019/09/18 04:37:20 process.go:155: Step 'kubectl get nodes -ojson' finished in 2m30.088732683s
W0918 04:37:20.901] 2019/09/18 04:37:20 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0918 04:37:20.901] 2019/09/18 04:37:20 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0918 04:37:50.900] 2019/09/18 04:37:50 process.go:153: Running: /workspace/kops toolbox dump --name e2e-kops-aws.test-cncf-aws.k8s.io -ojson
W0918 04:37:55.683] 2019/09/18 04:37:55 process.go:155: Step '/workspace/kops toolbox dump --name e2e-kops-aws.test-cncf-aws.k8s.io -ojson' finished in 4.782746526s
W0918 04:37:55.688] 2019/09/18 04:37:55 process.go:153: Running: kubectl get nodes -ojson
W0918 04:40:25.794] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0918 04:40:25.797] 2019/09/18 04:40:25 process.go:155: Step 'kubectl get nodes -ojson' finished in 2m30.108764744s
W0918 04:40:25.797] 2019/09/18 04:40:25 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0918 04:40:25.798] 2019/09/18 04:40:25 dump.go:89: Failed to get nodes for dumping via kubectl: error during kubectl get nodes -ojson: exit status 1
W0918 04:40:25.798] 2019/09/18 04:40:25 dump.go:123: dumping node not registered in kubernetes: 13.56.76.109
W0918 04:40:25.798] 2019/09/18 04:40:25 dump.go:157: Dumping node 13.56.76.109
W0918 04:40:26.271] 2019/09/18 04:40:26 dump.go:358: Running SSH command: sudo journalctl --output=short-precise -k
W0918 04:40:26.564] 2019/09/18 04:40:26 dump.go:358: Running SSH command: sudo journalctl --output=short-precise
W0918 04:40:30.148] 2019/09/18 04:40:30 dump.go:358: Running SSH command: sudo systemctl list-units -t service --no-pager --no-legend --all
W0918 04:40:30.237] 2019/09/18 04:40:30 dump.go:358: Running SSH command: sudo journalctl --output=cat -u kubelet.service
... skipping 160 lines ...
W0918 04:41:42.034]     check_env(env, self.command, *args)
W0918 04:41:42.034]   File "/workspace/./test-infra/jenkins/../scenarios/kubernetes_e2e.py", line 111, in check_env
W0918 04:41:42.034]     subprocess.check_call(cmd, env=env)
W0918 04:41:42.034]   File "/usr/lib/python2.7/subprocess.py", line 186, in check_call
W0918 04:41:42.034]     raise CalledProcessError(retcode, cmd)
W0918 04:41:42.035] 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-1b', '--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 04:41:42.035] Command failed
I0918 04:41:42.035] process 263 exited with code 1 after 27.3m
E0918 04:41:42.035] FAIL: ci-kubernetes-e2e-kops-aws
I0918 04:41:42.036] Call:  gcloud auth activate-service-account --key-file=/etc/service-account/service-account.json
W0918 04:41:42.571] Activated service account credentials for: [pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com]
I0918 04:41:42.632] process 619 exited with code 0 after 0.0m
I0918 04:41:42.633] Call:  gcloud config get-value account
I0918 04:41:42.955] process 631 exited with code 0 after 0.0m
I0918 04:41:42.956] Will upload results to gs://kubernetes-jenkins/logs using pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com
I0918 04:41:42.956] Upload result and artifacts...
I0918 04:41:42.957] Gubernator results at https://gubernator.k8s.io/build/kubernetes-jenkins/logs/ci-kubernetes-e2e-kops-aws/1174174753523503105
I0918 04:41:42.957] Call:  gsutil ls gs://kubernetes-jenkins/logs/ci-kubernetes-e2e-kops-aws/1174174753523503105/artifacts
W0918 04:41:44.029] CommandException: One or more URLs matched no objects.
E0918 04:41:44.157] Command failed
I0918 04:41:44.158] process 643 exited with code 1 after 0.0m
W0918 04:41:44.158] Remote dir gs://kubernetes-jenkins/logs/ci-kubernetes-e2e-kops-aws/1174174753523503105/artifacts not exist yet
I0918 04:41:44.158] 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/1174174753523503105/artifacts
I0918 04:41:48.417] process 785 exited with code 0 after 0.1m
I0918 04:41:48.418] Call:  git rev-parse HEAD
W0918 04:41:48.423] fatal: Not a git repository (or any of the parent directories): .git
E0918 04:41:48.425] Command failed
I0918 04:41:48.425] process 1424 exited with code 128 after 0.0m
I0918 04:41:48.425] Call:  git rev-parse HEAD
I0918 04:41:48.430] process 1425 exited with code 0 after 0.0m
I0918 04:41:48.431] Call:  gsutil stat gs://kubernetes-jenkins/logs/ci-kubernetes-e2e-kops-aws/jobResultsCache.json
I0918 04:41:49.703] process 1426 exited with code 0 after 0.0m
I0918 04:41:49.704] Call:  gsutil -q cat 'gs://kubernetes-jenkins/logs/ci-kubernetes-e2e-kops-aws/jobResultsCache.json#1568779907928455'
... skipping 8 lines ...