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 20:17
Elapsed25m35s
Revision
Buildergke-prow-ssd-pool-1a225945-4sp7
links{u'resultstore': {u'url': u'https://source.cloud.google.com/results/invocations/e208fd04-0e92-476c-a7b0-cf0b4eb7ab13/targets/test'}}
podbf3bf9dc-d7f5-11e9-9f18-22ab134e4c57
resultstorehttps://source.cloud.google.com/results/invocations/e208fd04-0e92-476c-a7b0-cf0b4eb7ab13/targets/test
infra-commite1cbc3ccd
job-versionv1.17.0-alpha.0.1440+ba07527278ef2c
podbf3bf9dc-d7f5-11e9-9f18-22ab134e4c57
revisionv1.17.0-alpha.0.1440+ba07527278ef2c

Test Failures


Up 20m31s

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 20:17:12.666] process 45 exited with code 0 after 0.0m
I0915 20:17:12.667] Will upload results to gs://kubernetes-jenkins/logs using pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com
I0915 20:17:12.667] Root: /workspace
I0915 20:17:12.667] cd to /workspace
I0915 20:17:12.668] Configure environment...
I0915 20:17:12.668] Call:  git show -s --format=format:%ct HEAD
W0915 20:17:12.672] fatal: Not a git repository (or any of the parent directories): .git
I0915 20:17:12.673] process 57 exited with code 128 after 0.0m
W0915 20:17:12.673] Unable to print commit date for HEAD
I0915 20:17:12.674] Call:  gcloud auth activate-service-account --key-file=/etc/service-account/service-account.json
W0915 20:17:13.223] Activated service account credentials for: [pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com]
I0915 20:17:13.274] process 58 exited with code 0 after 0.0m
I0915 20:17:13.275] Call:  gcloud config get-value account
... skipping 701 lines ...
I0915 20:18:13.709]  * read about installing addons at: https://github.com/kubernetes/kops/blob/master/docs/addons.md.
I0915 20:18:13.709] 
W0915 20:18:13.809] 2019/09/15 20:18:13 process.go:155: Step '/workspace/kops update cluster e2e-kops-aws.test-cncf-aws.k8s.io --yes' finished in 22.405952286s
W0915 20:18:13.810] 2019/09/15 20:18:13 process.go:153: Running: kubectl get nodes -ojson
W0915 20:18:14.051] 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 20:18:14.055] 2019/09/15 20:18:14 process.go:155: Step 'kubectl get nodes -ojson' finished in 338.305737ms
W0915 20:18:14.055] 2019/09/15 20:18:14 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0915 20:18:14.056] 2019/09/15 20:18:14 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0915 20:18:44.055] 2019/09/15 20:18:44 process.go:153: Running: kubectl get nodes -ojson
W0915 20:20:14.175] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0915 20:20:14.178] 2019/09/15 20:20:14 process.go:155: Step 'kubectl get nodes -ojson' finished in 1m30.122816358s
W0915 20:20:14.179] 2019/09/15 20:20:14 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0915 20:20:14.179] 2019/09/15 20:20:14 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0915 20:20:44.179] 2019/09/15 20:20:44 process.go:153: Running: kubectl get nodes -ojson
W0915 20:21:14.350] 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 20:21:14.351] 2019/09/15 20:21:14 process.go:155: Step 'kubectl get nodes -ojson' finished in 30.172627506s
W0915 20:21:14.351] 2019/09/15 20:21:14 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0915 20:21:14.352] 2019/09/15 20:21:14 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0915 20:21:44.358] 2019/09/15 20:21:44 process.go:153: Running: kubectl get nodes -ojson
W0915 20:21:44.746] 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 20:21:44.750] 2019/09/15 20:21:44 process.go:155: Step 'kubectl get nodes -ojson' finished in 392.798995ms
W0915 20:21:44.751] 2019/09/15 20:21:44 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0915 20:21:44.752] 2019/09/15 20:21:44 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0915 20:22:14.756] 2019/09/15 20:22:14 process.go:153: Running: kubectl get nodes -ojson
W0915 20:22:44.897] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0915 20:22:44.902] 2019/09/15 20:22:44 process.go:155: Step 'kubectl get nodes -ojson' finished in 30.14663668s
W0915 20:22:44.904] 2019/09/15 20:22:44 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0915 20:22:44.905] 2019/09/15 20:22:44 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0915 20:23:14.914] 2019/09/15 20:23:14 process.go:153: Running: kubectl get nodes -ojson
W0915 20:25:45.023] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0915 20:25:45.038] 2019/09/15 20:25:45 process.go:155: Step 'kubectl get nodes -ojson' finished in 2m30.120278607s
W0915 20:25:45.041] 2019/09/15 20:25:45 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0915 20:25:45.041] 2019/09/15 20:25:45 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0915 20:26:15.043] 2019/09/15 20:26:15 process.go:153: Running: kubectl get nodes -ojson
W0915 20:28:45.147] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0915 20:28:45.150] 2019/09/15 20:28:45 process.go:155: Step 'kubectl get nodes -ojson' finished in 2m30.107366612s
W0915 20:28:45.150] 2019/09/15 20:28:45 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0915 20:28:45.151] 2019/09/15 20:28:45 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0915 20:29:15.151] 2019/09/15 20:29:15 process.go:153: Running: kubectl get nodes -ojson
W0915 20:31:45.243] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0915 20:31:45.246] 2019/09/15 20:31:45 process.go:155: Step 'kubectl get nodes -ojson' finished in 2m30.09592561s
W0915 20:31:45.247] 2019/09/15 20:31:45 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0915 20:31:45.247] 2019/09/15 20:31:45 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0915 20:32:15.247] 2019/09/15 20:32:15 process.go:153: Running: kubectl get nodes -ojson
W0915 20:34:45.333] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0915 20:34:45.334] 2019/09/15 20:34:45 process.go:155: Step 'kubectl get nodes -ojson' finished in 2m30.087567848s
W0915 20:34:45.335] 2019/09/15 20:34:45 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0915 20:34:45.335] 2019/09/15 20:34:45 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0915 20:35:15.335] 2019/09/15 20:35:15 process.go:153: Running: kubectl get nodes -ojson
W0915 20:37:45.427] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0915 20:37:45.436] 2019/09/15 20:37:45 process.go:155: Step 'kubectl get nodes -ojson' finished in 2m30.100622382s
W0915 20:37:45.436] 2019/09/15 20:37:45 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0915 20:37:45.437] 2019/09/15 20:37:45 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0915 20:38:15.456] 2019/09/15 20:38:15 process.go:153: Running: /workspace/kops toolbox dump --name e2e-kops-aws.test-cncf-aws.k8s.io -ojson
W0915 20:38:24.085] 2019/09/15 20:38:24 process.go:155: Step '/workspace/kops toolbox dump --name e2e-kops-aws.test-cncf-aws.k8s.io -ojson' finished in 8.629335905s
W0915 20:38:24.097] 2019/09/15 20:38:24 process.go:153: Running: kubectl get nodes -ojson
W0915 20:40:54.180] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0915 20:40:54.182] 2019/09/15 20:40:54 process.go:155: Step 'kubectl get nodes -ojson' finished in 2m30.085417156s
W0915 20:40:54.183] 2019/09/15 20:40:54 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0915 20:40:54.186] 2019/09/15 20:40:54 dump.go:89: Failed to get nodes for dumping via kubectl: error during kubectl get nodes -ojson: exit status 1
W0915 20:40:54.187] 2019/09/15 20:40:54 dump.go:123: dumping node not registered in kubernetes: 13.125.206.234
W0915 20:40:54.187] 2019/09/15 20:40:54 dump.go:157: Dumping node 13.125.206.234
W0915 20:40:55.782] 2019/09/15 20:40:55 dump.go:358: Running SSH command: sudo journalctl --output=short-precise -k
W0915 20:40:56.505] 2019/09/15 20:40:56 dump.go:358: Running SSH command: sudo journalctl --output=short-precise
W0915 20:41:00.624] 2019/09/15 20:41:00 dump.go:358: Running SSH command: sudo systemctl list-units -t service --no-pager --no-legend --all
W0915 20:41:00.937] 2019/09/15 20:41:00 dump.go:358: Running SSH command: sudo journalctl --output=cat -u kubelet.service
... skipping 158 lines ...
W0915 20:42:35.902]     check_env(env, self.command, *args)
W0915 20:42:35.902]   File "/workspace/./test-infra/jenkins/../scenarios/kubernetes_e2e.py", line 111, in check_env
W0915 20:42:35.902]     subprocess.check_call(cmd, env=env)
W0915 20:42:35.902]   File "/usr/lib/python2.7/subprocess.py", line 186, in check_call
W0915 20:42:35.902]     raise CalledProcessError(retcode, cmd)
W0915 20:42:35.903] 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-2c', '--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 20:42:35.903] Command failed
I0915 20:42:35.903] process 260 exited with code 1 after 25.3m
E0915 20:42:35.903] FAIL: ci-kubernetes-e2e-kops-aws
I0915 20:42:35.904] Call:  gcloud auth activate-service-account --key-file=/etc/service-account/service-account.json
W0915 20:42:36.449] Activated service account credentials for: [pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com]
I0915 20:42:36.503] process 610 exited with code 0 after 0.0m
I0915 20:42:36.504] Call:  gcloud config get-value account
I0915 20:42:36.816] process 622 exited with code 0 after 0.0m
I0915 20:42:36.816] Will upload results to gs://kubernetes-jenkins/logs using pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com
I0915 20:42:36.816] Upload result and artifacts...
I0915 20:42:36.817] Gubernator results at https://gubernator.k8s.io/build/kubernetes-jenkins/logs/ci-kubernetes-e2e-kops-aws/1173329891244904448
I0915 20:42:36.817] Call:  gsutil ls gs://kubernetes-jenkins/logs/ci-kubernetes-e2e-kops-aws/1173329891244904448/artifacts
W0915 20:42:37.872] CommandException: One or more URLs matched no objects.
E0915 20:42:38.000] Command failed
I0915 20:42:38.001] process 634 exited with code 1 after 0.0m
W0915 20:42:38.001] Remote dir gs://kubernetes-jenkins/logs/ci-kubernetes-e2e-kops-aws/1173329891244904448/artifacts not exist yet
I0915 20:42:38.001] 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/1173329891244904448/artifacts
I0915 20:42:42.229] process 776 exited with code 0 after 0.1m
I0915 20:42:42.230] Call:  git rev-parse HEAD
W0915 20:42:42.233] fatal: Not a git repository (or any of the parent directories): .git
E0915 20:42:42.234] Command failed
I0915 20:42:42.234] process 1415 exited with code 128 after 0.0m
I0915 20:42:42.234] Call:  git rev-parse HEAD
I0915 20:42:42.253] process 1416 exited with code 0 after 0.0m
I0915 20:42:42.254] Call:  gsutil stat gs://kubernetes-jenkins/logs/ci-kubernetes-e2e-kops-aws/jobResultsCache.json
I0915 20:42:43.426] process 1417 exited with code 0 after 0.0m
I0915 20:42:43.427] Call:  gsutil -q cat 'gs://kubernetes-jenkins/logs/ci-kubernetes-e2e-kops-aws/jobResultsCache.json#1568578478159818'
... skipping 8 lines ...