This job view page is being replaced by Spyglass soon. Check out the new job view.
ResultFAILURE
Tests 1 failed / 5 succeeded
Started2019-09-11 04:03
Elapsed26m25s
Revision
Buildergke-prow-ssd-pool-1a225945-4zm0
links{u'resultstore': {u'url': u'https://source.cloud.google.com/results/invocations/baa7794b-ef92-4c18-84f3-e0b50a00a277/targets/test'}}
podfc8a53cb-d448-11e9-9d26-329cee23a2e0
resultstorehttps://source.cloud.google.com/results/invocations/baa7794b-ef92-4c18-84f3-e0b50a00a277/targets/test
infra-commitf04792505
job-versionv1.17.0-alpha.0.1219+afe8543a9ac3e7
podfc8a53cb-d448-11e9-9d26-329cee23a2e0
revisionv1.17.0-alpha.0.1219+afe8543a9ac3e7

Test Failures


Up 21m35s

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 ...
I0911 04:03:25.817] process 45 exited with code 0 after 0.0m
I0911 04:03:25.817] Will upload results to gs://kubernetes-jenkins/logs using pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com
I0911 04:03:25.818] Root: /workspace
I0911 04:03:25.818] cd to /workspace
I0911 04:03:25.818] Configure environment...
I0911 04:03:25.819] Call:  git show -s --format=format:%ct HEAD
W0911 04:03:25.823] fatal: Not a git repository (or any of the parent directories): .git
I0911 04:03:25.823] process 57 exited with code 128 after 0.0m
W0911 04:03:25.824] Unable to print commit date for HEAD
I0911 04:03:25.824] Call:  gcloud auth activate-service-account --key-file=/etc/service-account/service-account.json
W0911 04:03:26.422] Activated service account credentials for: [pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com]
I0911 04:03:26.487] process 58 exited with code 0 after 0.0m
I0911 04:03:26.487] Call:  gcloud config get-value account
... skipping 701 lines ...
I0911 04:04:32.328]  * read about installing addons at: https://github.com/kubernetes/kops/blob/master/docs/addons.md.
I0911 04:04:32.328] 
W0911 04:04:32.429] 2019/09/11 04:04:32 process.go:155: Step '/workspace/kops update cluster e2e-kops-aws.test-cncf-aws.k8s.io --yes' finished in 24.697190747s
W0911 04:04:32.429] 2019/09/11 04:04:32 process.go:153: Running: kubectl get nodes -ojson
W0911 04:04:32.557] 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
W0911 04:04:32.561] 2019/09/11 04:04:32 process.go:155: Step 'kubectl get nodes -ojson' finished in 226.165063ms
W0911 04:04:32.563] 2019/09/11 04:04:32 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0911 04:04:32.563] 2019/09/11 04:04:32 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0911 04:05:02.562] 2019/09/11 04:05:02 process.go:153: Running: kubectl get nodes -ojson
W0911 04:06:32.724] 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
W0911 04:06:32.725] 2019/09/11 04:06:32 process.go:155: Step 'kubectl get nodes -ojson' finished in 1m30.163574298s
W0911 04:06:32.726] 2019/09/11 04:06:32 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0911 04:06:32.726] 2019/09/11 04:06:32 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0911 04:07:02.726] 2019/09/11 04:07:02 process.go:153: Running: kubectl get nodes -ojson
W0911 04:07:02.900] 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
W0911 04:07:02.904] 2019/09/11 04:07:02 process.go:155: Step 'kubectl get nodes -ojson' finished in 178.56146ms
W0911 04:07:02.904] 2019/09/11 04:07:02 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0911 04:07:02.905] 2019/09/11 04:07:02 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0911 04:07:32.905] 2019/09/11 04:07:32 process.go:153: Running: kubectl get nodes -ojson
W0911 04:08:33.050] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0911 04:08:33.053] 2019/09/11 04:08:33 process.go:155: Step 'kubectl get nodes -ojson' finished in 1m0.148299606s
W0911 04:08:33.053] 2019/09/11 04:08:33 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0911 04:08:33.053] 2019/09/11 04:08:33 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0911 04:09:03.053] 2019/09/11 04:09:03 process.go:153: Running: kubectl get nodes -ojson
W0911 04:10:03.181] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0911 04:10:03.185] 2019/09/11 04:10:03 process.go:155: Step 'kubectl get nodes -ojson' finished in 1m0.131728949s
W0911 04:10:03.185] 2019/09/11 04:10:03 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0911 04:10:03.186] 2019/09/11 04:10:03 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0911 04:10:33.186] 2019/09/11 04:10:33 process.go:153: Running: kubectl get nodes -ojson
W0911 04:13:03.283] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0911 04:13:03.286] 2019/09/11 04:13:03 process.go:155: Step 'kubectl get nodes -ojson' finished in 2m30.101062476s
W0911 04:13:03.287] 2019/09/11 04:13:03 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0911 04:13:03.287] 2019/09/11 04:13:03 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0911 04:13:33.287] 2019/09/11 04:13:33 process.go:153: Running: kubectl get nodes -ojson
W0911 04:16:03.367] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0911 04:16:03.371] 2019/09/11 04:16:03 process.go:155: Step 'kubectl get nodes -ojson' finished in 2m30.084148973s
W0911 04:16:03.371] 2019/09/11 04:16:03 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0911 04:16:03.371] 2019/09/11 04:16:03 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0911 04:16:33.371] 2019/09/11 04:16:33 process.go:153: Running: kubectl get nodes -ojson
W0911 04:19:03.452] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0911 04:19:03.455] 2019/09/11 04:19:03 process.go:155: Step 'kubectl get nodes -ojson' finished in 2m30.083598079s
W0911 04:19:03.455] 2019/09/11 04:19:03 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0911 04:19:03.455] 2019/09/11 04:19:03 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0911 04:19:33.455] 2019/09/11 04:19:33 process.go:153: Running: kubectl get nodes -ojson
W0911 04:22:03.542] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0911 04:22:03.546] 2019/09/11 04:22:03 process.go:155: Step 'kubectl get nodes -ojson' finished in 2m30.090970352s
W0911 04:22:03.546] 2019/09/11 04:22:03 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0911 04:22:03.547] 2019/09/11 04:22:03 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0911 04:22:33.546] 2019/09/11 04:22:33 process.go:153: Running: kubectl get nodes -ojson
W0911 04:25:03.627] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0911 04:25:03.630] 2019/09/11 04:25:03 process.go:155: Step 'kubectl get nodes -ojson' finished in 2m30.083145629s
W0911 04:25:03.630] 2019/09/11 04:25:03 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0911 04:25:03.630] 2019/09/11 04:25:03 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0911 04:25:33.631] 2019/09/11 04:25:33 process.go:153: Running: /workspace/kops toolbox dump --name e2e-kops-aws.test-cncf-aws.k8s.io -ojson
W0911 04:25:44.486] 2019/09/11 04:25:44 process.go:155: Step '/workspace/kops toolbox dump --name e2e-kops-aws.test-cncf-aws.k8s.io -ojson' finished in 10.854928134s
W0911 04:25:44.487] 2019/09/11 04:25:44 process.go:153: Running: kubectl get nodes -ojson
W0911 04:28:14.568] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0911 04:28:14.574] 2019/09/11 04:28:14 process.go:155: Step 'kubectl get nodes -ojson' finished in 2m30.087645866s
W0911 04:28:14.574] 2019/09/11 04:28:14 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0911 04:28:14.576] 2019/09/11 04:28:14 dump.go:89: Failed to get nodes for dumping via kubectl: error during kubectl get nodes -ojson: exit status 1
W0911 04:28:14.576] 2019/09/11 04:28:14 dump.go:123: dumping node not registered in kubernetes: 13.236.187.67
W0911 04:28:14.577] 2019/09/11 04:28:14 dump.go:157: Dumping node 13.236.187.67
W0911 04:28:16.626] 2019/09/11 04:28:16 dump.go:358: Running SSH command: sudo journalctl --output=short-precise -k
W0911 04:28:17.457] 2019/09/11 04:28:17 dump.go:358: Running SSH command: sudo journalctl --output=short-precise
W0911 04:28:18.258] 2019/09/11 04:28:18 dump.go:358: Running SSH command: sudo systemctl list-units -t service --no-pager --no-legend --all
W0911 04:28:18.663] 2019/09/11 04:28:18 dump.go:358: Running SSH command: sudo journalctl --output=cat -u docker.service
... skipping 146 lines ...
W0911 04:29:41.257]     check_env(env, self.command, *args)
W0911 04:29:41.257]   File "/workspace/./test-infra/jenkins/../scenarios/kubernetes_e2e.py", line 111, in check_env
W0911 04:29:41.257]     subprocess.check_call(cmd, env=env)
W0911 04:29:41.257]   File "/usr/lib/python2.7/subprocess.py", line 186, in check_call
W0911 04:29:41.257]     raise CalledProcessError(retcode, cmd)
W0911 04:29:41.258] 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-southeast-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
E0911 04:29:41.259] Command failed
I0911 04:29:41.259] process 260 exited with code 1 after 26.2m
E0911 04:29:41.259] FAIL: ci-kubernetes-e2e-kops-aws
I0911 04:29:41.260] Call:  gcloud auth activate-service-account --key-file=/etc/service-account/service-account.json
W0911 04:29:41.773] Activated service account credentials for: [pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com]
I0911 04:29:41.822] process 617 exited with code 0 after 0.0m
I0911 04:29:41.823] Call:  gcloud config get-value account
I0911 04:29:42.130] process 629 exited with code 0 after 0.0m
I0911 04:29:42.130] Will upload results to gs://kubernetes-jenkins/logs using pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com
I0911 04:29:42.131] Upload result and artifacts...
I0911 04:29:42.131] Gubernator results at https://gubernator.k8s.io/build/kubernetes-jenkins/logs/ci-kubernetes-e2e-kops-aws/1171635252016189441
I0911 04:29:42.131] Call:  gsutil ls gs://kubernetes-jenkins/logs/ci-kubernetes-e2e-kops-aws/1171635252016189441/artifacts
W0911 04:29:43.194] CommandException: One or more URLs matched no objects.
E0911 04:29:43.329] Command failed
I0911 04:29:43.329] process 641 exited with code 1 after 0.0m
W0911 04:29:43.329] Remote dir gs://kubernetes-jenkins/logs/ci-kubernetes-e2e-kops-aws/1171635252016189441/artifacts not exist yet
I0911 04:29:43.330] 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/1171635252016189441/artifacts
I0911 04:29:45.668] process 783 exited with code 0 after 0.0m
I0911 04:29:45.669] Call:  git rev-parse HEAD
W0911 04:29:45.673] fatal: Not a git repository (or any of the parent directories): .git
E0911 04:29:45.674] Command failed
I0911 04:29:45.674] process 1382 exited with code 128 after 0.0m
I0911 04:29:45.674] Call:  git rev-parse HEAD
I0911 04:29:45.678] process 1383 exited with code 0 after 0.0m
I0911 04:29:45.679] Call:  gsutil stat gs://kubernetes-jenkins/logs/ci-kubernetes-e2e-kops-aws/jobResultsCache.json
I0911 04:29:46.790] process 1384 exited with code 0 after 0.0m
I0911 04:29:46.791] Call:  gsutil -q cat 'gs://kubernetes-jenkins/logs/ci-kubernetes-e2e-kops-aws/jobResultsCache.json#1568174457590332'
... skipping 8 lines ...