This job view page is being replaced by Spyglass soon. Check out the new job view.
ResultFAILURE
Tests 1 failed / 5 succeeded
Started2019-09-16 03:00
Elapsed25m9s
Revision
Buildergke-prow-ssd-pool-1a225945-q00f
links{u'resultstore': {u'url': u'https://source.cloud.google.com/results/invocations/6126d581-2d98-4a5b-9431-9f3f44147b06/targets/test'}}
pod0b720b9b-d82e-11e9-9f18-22ab134e4c57
resultstorehttps://source.cloud.google.com/results/invocations/6126d581-2d98-4a5b-9431-9f3f44147b06/targets/test
infra-commite1cbc3ccd
job-versionv1.17.0-alpha.0.1440+ba07527278ef2c
pod0b720b9b-d82e-11e9-9f18-22ab134e4c57
revisionv1.17.0-alpha.0.1440+ba07527278ef2c

Test Failures


Up 20m27s

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 ...
I0916 03:00:15.810] process 45 exited with code 0 after 0.0m
I0916 03:00:15.810] Will upload results to gs://kubernetes-jenkins/logs using pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com
I0916 03:00:15.811] Root: /workspace
I0916 03:00:15.811] cd to /workspace
I0916 03:00:15.811] Configure environment...
I0916 03:00:15.811] Call:  git show -s --format=format:%ct HEAD
W0916 03:00:15.816] fatal: Not a git repository (or any of the parent directories): .git
I0916 03:00:15.816] process 57 exited with code 128 after 0.0m
W0916 03:00:15.817] Unable to print commit date for HEAD
I0916 03:00:15.818] Call:  gcloud auth activate-service-account --key-file=/etc/service-account/service-account.json
W0916 03:00:16.426] Activated service account credentials for: [pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com]
I0916 03:00:16.490] process 58 exited with code 0 after 0.0m
I0916 03:00:16.490] Call:  gcloud config get-value account
... skipping 701 lines ...
I0916 03:01:15.808]  * read about installing addons at: https://github.com/kubernetes/kops/blob/master/docs/addons.md.
I0916 03:01:15.808] 
W0916 03:01:15.908] 2019/09/16 03:01:15 process.go:155: Step '/workspace/kops update cluster e2e-kops-aws.test-cncf-aws.k8s.io --yes' finished in 20.239741627s
W0916 03:01:15.909] 2019/09/16 03:01:15 process.go:153: Running: kubectl get nodes -ojson
W0916 03:01:16.124] 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
W0916 03:01:16.133] 2019/09/16 03:01:16 process.go:155: Step 'kubectl get nodes -ojson' finished in 306.951365ms
W0916 03:01:16.135] 2019/09/16 03:01:16 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0916 03:01:16.136] 2019/09/16 03:01:16 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0916 03:01:46.135] 2019/09/16 03:01:46 process.go:153: Running: kubectl get nodes -ojson
W0916 03:01:46.456] 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
W0916 03:01:46.465] 2019/09/16 03:01:46 process.go:155: Step 'kubectl get nodes -ojson' finished in 329.565732ms
W0916 03:01:46.466] 2019/09/16 03:01:46 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0916 03:01:46.466] 2019/09/16 03:01:46 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0916 03:02:16.467] 2019/09/16 03:02:16 process.go:153: Running: kubectl get nodes -ojson
W0916 03:03:16.694] 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
W0916 03:03:16.695] 2019/09/16 03:03:16 process.go:155: Step 'kubectl get nodes -ojson' finished in 1m0.224029195s
W0916 03:03:16.695] 2019/09/16 03:03:16 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0916 03:03:16.695] 2019/09/16 03:03:16 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0916 03:03:46.692] 2019/09/16 03:03:46 process.go:153: Running: kubectl get nodes -ojson
W0916 03:03:47.053] 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
W0916 03:03:47.060] 2019/09/16 03:03:47 process.go:155: Step 'kubectl get nodes -ojson' finished in 366.934357ms
W0916 03:03:47.061] 2019/09/16 03:03:47 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0916 03:03:47.062] 2019/09/16 03:03:47 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0916 03:04:17.062] 2019/09/16 03:04:17 process.go:153: Running: kubectl get nodes -ojson
W0916 03:04:17.391] 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
W0916 03:04:17.396] 2019/09/16 03:04:17 process.go:155: Step 'kubectl get nodes -ojson' finished in 334.776589ms
W0916 03:04:17.397] 2019/09/16 03:04:17 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0916 03:04:17.397] 2019/09/16 03:04:17 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0916 03:04:47.398] 2019/09/16 03:04:47 process.go:153: Running: kubectl get nodes -ojson
W0916 03:04:47.808] 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
W0916 03:04:47.813] 2019/09/16 03:04:47 process.go:155: Step 'kubectl get nodes -ojson' finished in 415.239624ms
W0916 03:04:47.813] 2019/09/16 03:04:47 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0916 03:04:47.814] 2019/09/16 03:04:47 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0916 03:05:17.813] 2019/09/16 03:05:17 process.go:153: Running: kubectl get nodes -ojson
W0916 03:05:48.118] 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
W0916 03:05:48.123] 2019/09/16 03:05:48 process.go:155: Step 'kubectl get nodes -ojson' finished in 30.309324s
W0916 03:05:48.124] 2019/09/16 03:05:48 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0916 03:05:48.125] 2019/09/16 03:05:48 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0916 03:06:18.123] 2019/09/16 03:06:18 process.go:153: Running: kubectl get nodes -ojson
W0916 03:08:48.262] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0916 03:08:48.265] 2019/09/16 03:08:48 process.go:155: Step 'kubectl get nodes -ojson' finished in 2m30.141451052s
W0916 03:08:48.265] 2019/09/16 03:08:48 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0916 03:08:48.266] 2019/09/16 03:08:48 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0916 03:09:18.265] 2019/09/16 03:09:18 process.go:153: Running: kubectl get nodes -ojson
W0916 03:11:48.357] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0916 03:11:48.360] 2019/09/16 03:11:48 process.go:155: Step 'kubectl get nodes -ojson' finished in 2m30.094843701s
W0916 03:11:48.361] 2019/09/16 03:11:48 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0916 03:11:48.361] 2019/09/16 03:11:48 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0916 03:12:18.361] 2019/09/16 03:12:18 process.go:153: Running: kubectl get nodes -ojson
W0916 03:14:48.437] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0916 03:14:48.440] 2019/09/16 03:14:48 process.go:155: Step 'kubectl get nodes -ojson' finished in 2m30.080032768s
W0916 03:14:48.441] 2019/09/16 03:14:48 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0916 03:14:48.441] 2019/09/16 03:14:48 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0916 03:15:18.442] 2019/09/16 03:15:18 process.go:153: Running: kubectl get nodes -ojson
W0916 03:17:48.604] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0916 03:17:48.608] 2019/09/16 03:17:48 process.go:155: Step 'kubectl get nodes -ojson' finished in 2m30.166204803s
W0916 03:17:48.608] 2019/09/16 03:17:48 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0916 03:17:48.608] 2019/09/16 03:17:48 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0916 03:18:18.608] 2019/09/16 03:18:18 process.go:153: Running: kubectl get nodes -ojson
W0916 03:20:48.689] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0916 03:20:48.690] 2019/09/16 03:20:48 process.go:155: Step 'kubectl get nodes -ojson' finished in 2m30.081265469s
W0916 03:20:48.690] 2019/09/16 03:20:48 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0916 03:20:48.690] 2019/09/16 03:20:48 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0916 03:21:18.690] 2019/09/16 03:21:18 process.go:153: Running: /workspace/kops toolbox dump --name e2e-kops-aws.test-cncf-aws.k8s.io -ojson
W0916 03:21:22.841] 2019/09/16 03:21:22 process.go:155: Step '/workspace/kops toolbox dump --name e2e-kops-aws.test-cncf-aws.k8s.io -ojson' finished in 4.150771668s
W0916 03:21:22.847] 2019/09/16 03:21:22 process.go:153: Running: kubectl get nodes -ojson
W0916 03:23:52.936] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0916 03:23:52.939] 2019/09/16 03:23:52 process.go:155: Step 'kubectl get nodes -ojson' finished in 2m30.092030677s
W0916 03:23:52.940] 2019/09/16 03:23:52 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0916 03:23:52.940] 2019/09/16 03:23:52 dump.go:89: Failed to get nodes for dumping via kubectl: error during kubectl get nodes -ojson: exit status 1
W0916 03:23:52.940] 2019/09/16 03:23:52 dump.go:123: dumping node not registered in kubernetes: 35.182.127.90
W0916 03:23:52.940] 2019/09/16 03:23:52 dump.go:157: Dumping node 35.182.127.90
W0916 03:23:53.311] 2019/09/16 03:23:53 dump.go:358: Running SSH command: sudo journalctl --output=short-precise -k
W0916 03:23:53.483] 2019/09/16 03:23:53 dump.go:358: Running SSH command: sudo journalctl --output=short-precise
W0916 03:23:56.779] 2019/09/16 03:23:56 dump.go:358: Running SSH command: sudo systemctl list-units -t service --no-pager --no-legend --all
W0916 03:23:56.854] 2019/09/16 03:23:56 dump.go:358: Running SSH command: sudo journalctl --output=cat -u kubelet.service
... skipping 170 lines ...
W0916 03:25:12.455]     check_env(env, self.command, *args)
W0916 03:25:12.455]   File "/workspace/./test-infra/jenkins/../scenarios/kubernetes_e2e.py", line 111, in check_env
W0916 03:25:12.455]     subprocess.check_call(cmd, env=env)
W0916 03:25:12.455]   File "/usr/lib/python2.7/subprocess.py", line 186, in check_call
W0916 03:25:12.455]     raise CalledProcessError(retcode, cmd)
W0916 03:25:12.456] 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=ca-central-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
E0916 03:25:12.456] Command failed
I0916 03:25:12.456] process 260 exited with code 1 after 24.9m
E0916 03:25:12.457] FAIL: ci-kubernetes-e2e-kops-aws
I0916 03:25:12.457] Call:  gcloud auth activate-service-account --key-file=/etc/service-account/service-account.json
W0916 03:25:13.028] Activated service account credentials for: [pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com]
I0916 03:25:13.086] process 643 exited with code 0 after 0.0m
I0916 03:25:13.086] Call:  gcloud config get-value account
I0916 03:25:13.431] process 655 exited with code 0 after 0.0m
I0916 03:25:13.432] Will upload results to gs://kubernetes-jenkins/logs using pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com
I0916 03:25:13.432] Upload result and artifacts...
I0916 03:25:13.432] Gubernator results at https://gubernator.k8s.io/build/kubernetes-jenkins/logs/ci-kubernetes-e2e-kops-aws/1173431309683396609
I0916 03:25:13.433] Call:  gsutil ls gs://kubernetes-jenkins/logs/ci-kubernetes-e2e-kops-aws/1173431309683396609/artifacts
W0916 03:25:14.603] CommandException: One or more URLs matched no objects.
E0916 03:25:14.749] Command failed
I0916 03:25:14.749] process 667 exited with code 1 after 0.0m
W0916 03:25:14.749] Remote dir gs://kubernetes-jenkins/logs/ci-kubernetes-e2e-kops-aws/1173431309683396609/artifacts not exist yet
I0916 03:25:14.749] 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/1173431309683396609/artifacts
I0916 03:25:18.903] process 809 exited with code 0 after 0.1m
I0916 03:25:18.904] Call:  git rev-parse HEAD
W0916 03:25:18.908] fatal: Not a git repository (or any of the parent directories): .git
E0916 03:25:18.909] Command failed
I0916 03:25:18.909] process 1448 exited with code 128 after 0.0m
I0916 03:25:18.909] Call:  git rev-parse HEAD
I0916 03:25:18.914] process 1449 exited with code 0 after 0.0m
I0916 03:25:18.914] Call:  gsutil stat gs://kubernetes-jenkins/logs/ci-kubernetes-e2e-kops-aws/jobResultsCache.json
I0916 03:25:20.201] process 1450 exited with code 0 after 0.0m
I0916 03:25:20.202] Call:  gsutil -q cat 'gs://kubernetes-jenkins/logs/ci-kubernetes-e2e-kops-aws/jobResultsCache.json#1568602505623245'
... skipping 8 lines ...