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 07:08
Elapsed25m36s
Revision
Buildergke-prow-ssd-pool-1a225945-w688
links{u'resultstore': {u'url': u'https://source.cloud.google.com/results/invocations/abcffb8a-0e3b-4902-82d3-d6fd1d59ef6f/targets/test'}}
podb091cb2a-d850-11e9-9f18-22ab134e4c57
resultstorehttps://source.cloud.google.com/results/invocations/abcffb8a-0e3b-4902-82d3-d6fd1d59ef6f/targets/test
infra-commite1cbc3ccd
job-versionv1.17.0-alpha.0.1440+ba07527278ef2c
podb091cb2a-d850-11e9-9f18-22ab134e4c57
revisionv1.17.0-alpha.0.1440+ba07527278ef2c

Test Failures


Up 20m30s

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 07:08:11.329] process 44 exited with code 0 after 0.0m
I0916 07:08:11.329] Will upload results to gs://kubernetes-jenkins/logs using pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com
I0916 07:08:11.329] Root: /workspace
I0916 07:08:11.330] cd to /workspace
I0916 07:08:11.330] Configure environment...
I0916 07:08:11.330] Call:  git show -s --format=format:%ct HEAD
W0916 07:08:11.334] fatal: Not a git repository (or any of the parent directories): .git
I0916 07:08:11.335] process 56 exited with code 128 after 0.0m
W0916 07:08:11.335] Unable to print commit date for HEAD
I0916 07:08:11.335] Call:  gcloud auth activate-service-account --key-file=/etc/service-account/service-account.json
W0916 07:08:11.854] Activated service account credentials for: [pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com]
I0916 07:08:11.904] process 57 exited with code 0 after 0.0m
I0916 07:08:11.905] Call:  gcloud config get-value account
... skipping 701 lines ...
I0916 07:09:12.319]  * read about installing addons at: https://github.com/kubernetes/kops/blob/master/docs/addons.md.
I0916 07:09:12.319] 
W0916 07:09:12.419] 2019/09/16 07:09:12 process.go:155: Step '/workspace/kops update cluster e2e-kops-aws.test-cncf-aws.k8s.io --yes' finished in 22.420599647s
W0916 07:09:12.420] 2019/09/16 07:09:12 process.go:153: Running: kubectl get nodes -ojson
W0916 07:09:12.563] 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 07:09:12.567] 2019/09/16 07:09:12 process.go:155: Step 'kubectl get nodes -ojson' finished in 244.49468ms
W0916 07:09:12.567] 2019/09/16 07:09:12 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0916 07:09:12.567] 2019/09/16 07:09:12 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0916 07:09:42.567] 2019/09/16 07:09:42 process.go:153: Running: kubectl get nodes -ojson
W0916 07:10:42.706] 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 07:10:42.711] 2019/09/16 07:10:42 process.go:155: Step 'kubectl get nodes -ojson' finished in 1m0.143569167s
W0916 07:10:42.711] 2019/09/16 07:10:42 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0916 07:10:42.711] 2019/09/16 07:10:42 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0916 07:11:12.711] 2019/09/16 07:11:12 process.go:153: Running: kubectl get nodes -ojson
W0916 07:11:42.898] 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 07:11:42.901] 2019/09/16 07:11:42 process.go:155: Step 'kubectl get nodes -ojson' finished in 30.189985279s
W0916 07:11:42.901] 2019/09/16 07:11:42 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0916 07:11:42.901] 2019/09/16 07:11:42 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0916 07:12:12.903] 2019/09/16 07:12:12 process.go:153: Running: kubectl get nodes -ojson
W0916 07:12:43.086] 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 07:12:43.087] 2019/09/16 07:12:43 process.go:155: Step 'kubectl get nodes -ojson' finished in 30.185015138s
W0916 07:12:43.087] 2019/09/16 07:12:43 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0916 07:12:43.088] 2019/09/16 07:12:43 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0916 07:13:13.087] 2019/09/16 07:13:13 process.go:153: Running: kubectl get nodes -ojson
W0916 07:13:43.252] 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 07:13:43.254] 2019/09/16 07:13:43 process.go:155: Step 'kubectl get nodes -ojson' finished in 30.165661804s
W0916 07:13:43.255] 2019/09/16 07:13:43 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0916 07:13:43.255] 2019/09/16 07:13:43 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0916 07:14:13.253] 2019/09/16 07:14:13 process.go:153: Running: kubectl get nodes -ojson
W0916 07:16:43.333] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0916 07:16:43.336] 2019/09/16 07:16:43 process.go:155: Step 'kubectl get nodes -ojson' finished in 2m30.082742046s
W0916 07:16:43.336] 2019/09/16 07:16:43 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0916 07:16:43.337] 2019/09/16 07:16:43 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0916 07:17:13.336] 2019/09/16 07:17:13 process.go:153: Running: kubectl get nodes -ojson
W0916 07:19:43.413] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0916 07:19:43.417] 2019/09/16 07:19:43 process.go:155: Step 'kubectl get nodes -ojson' finished in 2m30.080460772s
W0916 07:19:43.417] 2019/09/16 07:19:43 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0916 07:19:43.417] 2019/09/16 07:19:43 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0916 07:20:13.417] 2019/09/16 07:20:13 process.go:153: Running: kubectl get nodes -ojson
W0916 07:22:43.582] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0916 07:22:43.585] 2019/09/16 07:22:43 process.go:155: Step 'kubectl get nodes -ojson' finished in 2m30.167904643s
W0916 07:22:43.586] 2019/09/16 07:22:43 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0916 07:22:43.586] 2019/09/16 07:22:43 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0916 07:23:13.585] 2019/09/16 07:23:13 process.go:153: Running: kubectl get nodes -ojson
W0916 07:25:43.676] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0916 07:25:43.680] 2019/09/16 07:25:43 process.go:155: Step 'kubectl get nodes -ojson' finished in 2m30.093540651s
W0916 07:25:43.680] 2019/09/16 07:25:43 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0916 07:25:43.680] 2019/09/16 07:25:43 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0916 07:26:13.679] 2019/09/16 07:26:13 process.go:153: Running: kubectl get nodes -ojson
W0916 07:28:43.758] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0916 07:28:43.762] 2019/09/16 07:28:43 process.go:155: Step 'kubectl get nodes -ojson' finished in 2m30.082559566s
W0916 07:28:43.762] 2019/09/16 07:28:43 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0916 07:28:43.762] 2019/09/16 07:28:43 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0916 07:29:13.763] 2019/09/16 07:29:13 process.go:153: Running: /workspace/kops toolbox dump --name e2e-kops-aws.test-cncf-aws.k8s.io -ojson
W0916 07:29:22.858] 2019/09/16 07:29:22 process.go:155: Step '/workspace/kops toolbox dump --name e2e-kops-aws.test-cncf-aws.k8s.io -ojson' finished in 9.095776683s
W0916 07:29:22.859] 2019/09/16 07:29:22 process.go:153: Running: kubectl get nodes -ojson
W0916 07:31:52.942] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0916 07:31:52.948] 2019/09/16 07:31:52 process.go:155: Step 'kubectl get nodes -ojson' finished in 2m30.088660592s
W0916 07:31:52.949] 2019/09/16 07:31:52 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0916 07:31:52.949] 2019/09/16 07:31:52 dump.go:89: Failed to get nodes for dumping via kubectl: error during kubectl get nodes -ojson: exit status 1
W0916 07:31:52.949] 2019/09/16 07:31:52 dump.go:123: dumping node not registered in kubernetes: 52.79.108.38
W0916 07:31:52.950] 2019/09/16 07:31:52 dump.go:157: Dumping node 52.79.108.38
W0916 07:31:54.571] 2019/09/16 07:31:54 dump.go:358: Running SSH command: sudo journalctl --output=short-precise -k
W0916 07:31:55.239] 2019/09/16 07:31:55 dump.go:358: Running SSH command: sudo journalctl --output=short-precise
W0916 07:31:58.682] 2019/09/16 07:31:58 dump.go:358: Running SSH command: sudo systemctl list-units -t service --no-pager --no-legend --all
W0916 07:31:59.009] 2019/09/16 07:31:59 dump.go:358: Running SSH command: sudo journalctl --output=cat -u kubelet.service
... skipping 158 lines ...
W0916 07:33:36.213]     check_env(env, self.command, *args)
W0916 07:33:36.213]   File "/workspace/./test-infra/jenkins/../scenarios/kubernetes_e2e.py", line 111, in check_env
W0916 07:33:36.214]     subprocess.check_call(cmd, env=env)
W0916 07:33:36.214]   File "/usr/lib/python2.7/subprocess.py", line 186, in check_call
W0916 07:33:36.214]     raise CalledProcessError(retcode, cmd)
W0916 07:33:36.215] 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-northeast-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
E0916 07:33:36.215] Command failed
I0916 07:33:36.215] process 259 exited with code 1 after 25.4m
E0916 07:33:36.216] FAIL: ci-kubernetes-e2e-kops-aws
I0916 07:33:36.216] Call:  gcloud auth activate-service-account --key-file=/etc/service-account/service-account.json
W0916 07:33:36.805] Activated service account credentials for: [pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com]
I0916 07:33:36.851] process 616 exited with code 0 after 0.0m
I0916 07:33:36.852] Call:  gcloud config get-value account
I0916 07:33:37.145] process 628 exited with code 0 after 0.0m
I0916 07:33:37.146] Will upload results to gs://kubernetes-jenkins/logs using pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com
I0916 07:33:37.146] Upload result and artifacts...
I0916 07:33:37.146] Gubernator results at https://gubernator.k8s.io/build/kubernetes-jenkins/logs/ci-kubernetes-e2e-kops-aws/1173493717907017732
I0916 07:33:37.147] Call:  gsutil ls gs://kubernetes-jenkins/logs/ci-kubernetes-e2e-kops-aws/1173493717907017732/artifacts
W0916 07:33:38.185] CommandException: One or more URLs matched no objects.
E0916 07:33:38.303] Command failed
I0916 07:33:38.304] process 640 exited with code 1 after 0.0m
W0916 07:33:38.304] Remote dir gs://kubernetes-jenkins/logs/ci-kubernetes-e2e-kops-aws/1173493717907017732/artifacts not exist yet
I0916 07:33:38.304] 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/1173493717907017732/artifacts
I0916 07:33:42.158] process 782 exited with code 0 after 0.1m
I0916 07:33:42.159] Call:  git rev-parse HEAD
W0916 07:33:42.163] fatal: Not a git repository (or any of the parent directories): .git
E0916 07:33:42.163] Command failed
I0916 07:33:42.163] process 1421 exited with code 128 after 0.0m
I0916 07:33:42.164] Call:  git rev-parse HEAD
I0916 07:33:42.167] process 1422 exited with code 0 after 0.0m
I0916 07:33:42.168] Call:  gsutil stat gs://kubernetes-jenkins/logs/ci-kubernetes-e2e-kops-aws/jobResultsCache.json
I0916 07:33:43.295] process 1423 exited with code 0 after 0.0m
I0916 07:33:43.296] Call:  gsutil -q cat 'gs://kubernetes-jenkins/logs/ci-kubernetes-e2e-kops-aws/jobResultsCache.json#1568617355276849'
... skipping 8 lines ...