This job view page is being replaced by Spyglass soon. Check out the new job view.
ResultFAILURE
Tests 1 failed / 5 succeeded
Started2019-07-21 13:39
Elapsed26m11s
Revision
Buildergke-prow-ssd-pool-1a225945-4zm0
links{u'resultstore': {u'url': u'https://source.cloud.google.com/results/invocations/c3ae677e-e524-41a8-866b-be2aa200b70c/targets/test'}}
pode7a3a61b-abbc-11e9-b82b-365474bd0c86
resultstorehttps://source.cloud.google.com/results/invocations/c3ae677e-e524-41a8-866b-be2aa200b70c/targets/test
infra-commit6d769e14d
job-versionv1.16.0-alpha.1.124+c2a4369ba4f37e
pode7a3a61b-abbc-11e9-b82b-365474bd0c86
revisionv1.16.0-alpha.1.124+c2a4369ba4f37e

Test Failures


Up 20m32s

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 ...
I0721 13:39:31.962] process 44 exited with code 0 after 0.0m
I0721 13:39:31.963] Will upload results to gs://kubernetes-jenkins/logs using pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com
I0721 13:39:31.963] Root: /workspace
I0721 13:39:31.963] cd to /workspace
I0721 13:39:31.963] Configure environment...
I0721 13:39:31.964] Call:  git show -s --format=format:%ct HEAD
W0721 13:39:31.968] fatal: Not a git repository (or any of the parent directories): .git
I0721 13:39:31.969] process 56 exited with code 128 after 0.0m
W0721 13:39:31.969] Unable to print commit date for HEAD
I0721 13:39:31.970] Call:  gcloud auth activate-service-account --key-file=/etc/service-account/service-account.json
W0721 13:39:32.466] Activated service account credentials for: [pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com]
I0721 13:39:32.826] process 57 exited with code 0 after 0.0m
I0721 13:39:32.827] Call:  gcloud config get-value account
... skipping 602 lines ...
I0721 13:40:31.584]  * read about installing addons at: https://github.com/kubernetes/kops/blob/master/docs/addons.md.
I0721 13:40:31.584] 
W0721 13:40:31.685] 2019/07/21 13:40:31 process.go:155: Step '/tmp/kops737952025/kops update cluster e2e-kops-aws-newrunner.test-cncf-aws.k8s.io --yes' finished in 23.388121417s
W0721 13:40:31.685] 2019/07/21 13:40:31 process.go:153: Running: kubectl get nodes -ojson
W0721 13:40:31.792] Unable to connect to the server: dial tcp: lookup api.e2e-kops-aws-newrunner.test-cncf-aws.k8s.io on 10.63.240.10:53: no such host
W0721 13:40:31.796] 2019/07/21 13:40:31 process.go:155: Step 'kubectl get nodes -ojson' finished in 206.600301ms
W0721 13:40:31.796] 2019/07/21 13:40:31 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0721 13:40:31.797] 2019/07/21 13:40:31 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0721 13:41:01.796] 2019/07/21 13:41:01 process.go:153: Running: kubectl get nodes -ojson
W0721 13:41:01.961] Unable to connect to the server: dial tcp: lookup api.e2e-kops-aws-newrunner.test-cncf-aws.k8s.io on 10.63.240.10:53: no such host
W0721 13:41:01.961] 2019/07/21 13:41:01 process.go:155: Step 'kubectl get nodes -ojson' finished in 164.876193ms
W0721 13:41:01.962] 2019/07/21 13:41:01 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0721 13:41:01.962] 2019/07/21 13:41:01 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0721 13:41:31.962] 2019/07/21 13:41:31 process.go:153: Running: kubectl get nodes -ojson
W0721 13:43:02.069] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0721 13:43:02.072] 2019/07/21 13:43:02 process.go:155: Step 'kubectl get nodes -ojson' finished in 1m30.110964903s
W0721 13:43:02.073] 2019/07/21 13:43:02 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0721 13:43:02.073] 2019/07/21 13:43:02 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0721 13:43:32.073] 2019/07/21 13:43:32 process.go:153: Running: kubectl get nodes -ojson
W0721 13:43:32.218] Unable to connect to the server: dial tcp: lookup api.e2e-kops-aws-newrunner.test-cncf-aws.k8s.io on 10.63.240.10:53: no such host
W0721 13:43:32.221] 2019/07/21 13:43:32 process.go:155: Step 'kubectl get nodes -ojson' finished in 148.590577ms
W0721 13:43:32.222] 2019/07/21 13:43:32 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0721 13:43:32.222] 2019/07/21 13:43:32 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0721 13:44:02.222] 2019/07/21 13:44:02 process.go:153: Running: kubectl get nodes -ojson
W0721 13:45:02.373] Unable to connect to the server: dial tcp: lookup api.e2e-kops-aws-newrunner.test-cncf-aws.k8s.io on 10.63.240.10:53: no such host
W0721 13:45:02.375] 2019/07/21 13:45:02 process.go:155: Step 'kubectl get nodes -ojson' finished in 1m0.153664965s
W0721 13:45:02.376] 2019/07/21 13:45:02 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0721 13:45:02.376] 2019/07/21 13:45:02 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0721 13:45:32.376] 2019/07/21 13:45:32 process.go:153: Running: kubectl get nodes -ojson
W0721 13:48:02.453] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0721 13:48:02.457] 2019/07/21 13:48:02 process.go:155: Step 'kubectl get nodes -ojson' finished in 2m30.080422037s
W0721 13:48:02.457] 2019/07/21 13:48:02 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0721 13:48:02.457] 2019/07/21 13:48:02 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0721 13:48:32.457] 2019/07/21 13:48:32 process.go:153: Running: kubectl get nodes -ojson
W0721 13:51:02.549] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0721 13:51:02.551] 2019/07/21 13:51:02 process.go:155: Step 'kubectl get nodes -ojson' finished in 2m30.09363439s
W0721 13:51:02.551] 2019/07/21 13:51:02 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0721 13:51:02.551] 2019/07/21 13:51:02 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0721 13:51:32.551] 2019/07/21 13:51:32 process.go:153: Running: kubectl get nodes -ojson
W0721 13:54:02.634] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0721 13:54:02.637] 2019/07/21 13:54:02 process.go:155: Step 'kubectl get nodes -ojson' finished in 2m30.085649048s
W0721 13:54:02.637] 2019/07/21 13:54:02 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0721 13:54:02.638] 2019/07/21 13:54:02 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0721 13:54:32.637] 2019/07/21 13:54:32 process.go:153: Running: kubectl get nodes -ojson
W0721 13:57:02.714] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0721 13:57:02.717] 2019/07/21 13:57:02 process.go:155: Step 'kubectl get nodes -ojson' finished in 2m30.079874707s
W0721 13:57:02.717] 2019/07/21 13:57:02 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0721 13:57:02.718] 2019/07/21 13:57:02 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0721 13:57:32.717] 2019/07/21 13:57:32 process.go:153: Running: kubectl get nodes -ojson
W0721 14:00:02.808] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0721 14:00:02.808] 2019/07/21 14:00:02 process.go:155: Step 'kubectl get nodes -ojson' finished in 2m30.090637639s
W0721 14:00:02.809] 2019/07/21 14:00:02 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0721 14:00:02.809] 2019/07/21 14:00:02 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0721 14:00:32.810] 2019/07/21 14:00:32 process.go:153: Running: /tmp/kops737952025/kops toolbox dump --name e2e-kops-aws-newrunner.test-cncf-aws.k8s.io -ojson
W0721 14:00:42.254] 2019/07/21 14:00:42 process.go:155: Step '/tmp/kops737952025/kops toolbox dump --name e2e-kops-aws-newrunner.test-cncf-aws.k8s.io -ojson' finished in 9.443676483s
W0721 14:00:42.255] 2019/07/21 14:00:42 process.go:153: Running: kubectl get nodes -ojson
W0721 14:03:12.354] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0721 14:03:12.385] 2019/07/21 14:03:12 process.go:155: Step 'kubectl get nodes -ojson' finished in 2m30.129143178s
W0721 14:03:12.385] 2019/07/21 14:03:12 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0721 14:03:12.385] 2019/07/21 14:03:12 dump.go:89: Failed to get nodes for dumping via kubectl: error during kubectl get nodes -ojson: exit status 1
W0721 14:03:12.386] 2019/07/21 14:03:12 dump.go:123: dumping node not registered in kubernetes: 54.255.166.204
W0721 14:03:12.397] 2019/07/21 14:03:12 dump.go:157: Dumping node 54.255.166.204
W0721 14:03:14.493] 2019/07/21 14:03:14 dump.go:358: Running SSH command: sudo journalctl --output=short-precise -k
W0721 14:03:15.399] 2019/07/21 14:03:15 dump.go:358: Running SSH command: sudo journalctl --output=short-precise
W0721 14:03:19.336] 2019/07/21 14:03:19 dump.go:358: Running SSH command: sudo systemctl list-units -t service --no-pager --no-legend --all
W0721 14:03:19.724] 2019/07/21 14:03:19 dump.go:358: Running SSH command: sudo journalctl --output=cat -u kubelet.service
... skipping 158 lines ...
W0721 14:05:32.239]     check_env(env, self.command, *args)
W0721 14:05:32.239]   File "/workspace/./test-infra/jenkins/../scenarios/kubernetes_e2e.py", line 111, in check_env
W0721 14:05:32.240]     subprocess.check_call(cmd, env=env)
W0721 14:05:32.240]   File "/usr/lib/python2.7/subprocess.py", line 186, in check_call
W0721 14:05:32.240]     raise CalledProcessError(retcode, cmd)
W0721 14:05:32.240] subprocess.CalledProcessError: Command '('kubetest', '--dump=/workspace/_artifacts', '--gcp-service-account=/etc/service-account/service-account.json', '--up', '--down', '--test', '--deployment=kops', '--provider=aws', '--cluster=e2e-kops-aws-newrunner.test-cncf-aws.k8s.io', '--gcp-network=e2e-kops-aws-newrunner.test-cncf-aws.k8s.io', '--extract=ci/latest', '--ginkgo-parallel', '--kops-version=https://storage.googleapis.com/kops-ci/bin/latest-ci-updown-green.txt', '--test_args=--ginkgo.flakeAttempts=2 --ginkgo.skip=\\[Slow\\]|\\[Serial\\]|\\[Disruptive\\]|\\[Flaky\\]|\\[Feature:.+\\]|\\[HPA\\]|Dashboard|Services.*functioning.*NodePort', '--timeout=120m', '--kops-zones=ap-southeast-1a', '--kops-cluster=e2e-kops-aws-newrunner.test-cncf-aws.k8s.io', '--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
E0721 14:05:32.241] Command failed
I0721 14:05:32.241] process 259 exited with code 1 after 26.0m
E0721 14:05:32.241] FAIL: ci-kubernetes-e2e-kops-aws-newrunner
I0721 14:05:32.242] Call:  gcloud auth activate-service-account --key-file=/etc/service-account/service-account.json
W0721 14:05:32.715] Activated service account credentials for: [pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com]
I0721 14:05:32.769] process 600 exited with code 0 after 0.0m
I0721 14:05:32.769] Call:  gcloud config get-value account
I0721 14:05:33.069] process 612 exited with code 0 after 0.0m
I0721 14:05:33.069] Will upload results to gs://kubernetes-jenkins/logs using pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com
I0721 14:05:33.069] Upload result and artifacts...
I0721 14:05:33.070] Gubernator results at https://gubernator.k8s.io/build/kubernetes-jenkins/logs/ci-kubernetes-e2e-kops-aws-newrunner/1152936093406990336
I0721 14:05:33.070] Call:  gsutil ls gs://kubernetes-jenkins/logs/ci-kubernetes-e2e-kops-aws-newrunner/1152936093406990336/artifacts
W0721 14:05:34.106] CommandException: One or more URLs matched no objects.
E0721 14:05:34.236] Command failed
I0721 14:05:34.237] process 624 exited with code 1 after 0.0m
W0721 14:05:34.237] Remote dir gs://kubernetes-jenkins/logs/ci-kubernetes-e2e-kops-aws-newrunner/1152936093406990336/artifacts not exist yet
I0721 14:05:34.237] 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-newrunner/1152936093406990336/artifacts
I0721 14:05:38.295] process 766 exited with code 0 after 0.1m
I0721 14:05:38.296] Call:  git rev-parse HEAD
W0721 14:05:38.300] fatal: Not a git repository (or any of the parent directories): .git
E0721 14:05:38.301] Command failed
I0721 14:05:38.301] process 1405 exited with code 128 after 0.0m
I0721 14:05:38.301] Call:  git rev-parse HEAD
I0721 14:05:38.305] process 1406 exited with code 0 after 0.0m
I0721 14:05:38.305] Call:  gsutil stat gs://kubernetes-jenkins/logs/ci-kubernetes-e2e-kops-aws-newrunner/jobResultsCache.json
I0721 14:05:39.432] process 1407 exited with code 0 after 0.0m
I0721 14:05:39.433] Call:  gsutil -q cat 'gs://kubernetes-jenkins/logs/ci-kubernetes-e2e-kops-aws-newrunner/jobResultsCache.json#1563714284353630'
... skipping 8 lines ...