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 08:42
Elapsed25m45s
Revision
Buildergke-prow-ssd-pool-1a225945-d46v
links{u'resultstore': {u'url': u'https://source.cloud.google.com/results/invocations/33d80482-1943-46cd-a93c-f29a5a1a360c/targets/test'}}
podf6566d76-d46f-11e9-9d26-329cee23a2e0
resultstorehttps://source.cloud.google.com/results/invocations/33d80482-1943-46cd-a93c-f29a5a1a360c/targets/test
infra-commit0708557a1
job-versionv1.17.0-alpha.0.1229+3bf2b1258da74a
podf6566d76-d46f-11e9-9d26-329cee23a2e0
revisionv1.17.0-alpha.0.1229+3bf2b1258da74a

Test Failures


Up 20m34s

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 08:42:26.346] process 45 exited with code 0 after 0.0m
I0911 08:42:26.346] Will upload results to gs://kubernetes-jenkins/logs using pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com
I0911 08:42:26.347] Root: /workspace
I0911 08:42:26.347] cd to /workspace
I0911 08:42:26.347] Configure environment...
I0911 08:42:26.348] Call:  git show -s --format=format:%ct HEAD
W0911 08:42:26.352] fatal: Not a git repository (or any of the parent directories): .git
I0911 08:42:26.354] process 57 exited with code 128 after 0.0m
W0911 08:42:26.354] Unable to print commit date for HEAD
I0911 08:42:26.355] Call:  gcloud auth activate-service-account --key-file=/etc/service-account/service-account.json
W0911 08:42:26.975] Activated service account credentials for: [pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com]
I0911 08:42:27.041] process 58 exited with code 0 after 0.0m
I0911 08:42:27.041] Call:  gcloud config get-value account
... skipping 701 lines ...
I0911 08:43:36.429]  * read about installing addons at: https://github.com/kubernetes/kops/blob/master/docs/addons.md.
I0911 08:43:36.429] 
W0911 08:43:36.530] 2019/09/11 08:43:36 process.go:155: Step '/workspace/kops update cluster e2e-kops-aws.test-cncf-aws.k8s.io --yes' finished in 25.401490409s
W0911 08:43:36.569] 2019/09/11 08:43:36 process.go:153: Running: kubectl get nodes -ojson
W0911 08:43:36.719] 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 08:43:36.720] 2019/09/11 08:43:36 process.go:155: Step 'kubectl get nodes -ojson' finished in 284.587107ms
W0911 08:43:36.721] 2019/09/11 08:43:36 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0911 08:43:36.721] 2019/09/11 08:43:36 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0911 08:44:06.721] 2019/09/11 08:44:06 process.go:153: Running: kubectl get nodes -ojson
W0911 08:46:06.892] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0911 08:46:06.892] 2019/09/11 08:46:06 process.go:155: Step 'kubectl get nodes -ojson' finished in 2m0.170754409s
W0911 08:46:06.893] 2019/09/11 08:46:06 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0911 08:46:06.893] 2019/09/11 08:46:06 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0911 08:46:36.893] 2019/09/11 08:46:36 process.go:153: Running: kubectl get nodes -ojson
W0911 08:48:07.120] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0911 08:48:07.123] 2019/09/11 08:48:07 process.go:155: Step 'kubectl get nodes -ojson' finished in 1m30.230385808s
W0911 08:48:07.123] 2019/09/11 08:48:07 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0911 08:48:07.124] 2019/09/11 08:48:07 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0911 08:48:37.123] 2019/09/11 08:48:37 process.go:153: Running: kubectl get nodes -ojson
W0911 08:51:07.218] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0911 08:51:07.225] 2019/09/11 08:51:07 process.go:155: Step 'kubectl get nodes -ojson' finished in 2m30.100914106s
W0911 08:51:07.226] 2019/09/11 08:51:07 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0911 08:51:07.227] 2019/09/11 08:51:07 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0911 08:51:37.225] 2019/09/11 08:51:37 process.go:153: Running: kubectl get nodes -ojson
W0911 08:54:07.316] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0911 08:54:07.319] 2019/09/11 08:54:07 process.go:155: Step 'kubectl get nodes -ojson' finished in 2m30.093987177s
W0911 08:54:07.319] 2019/09/11 08:54:07 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0911 08:54:07.319] 2019/09/11 08:54:07 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0911 08:54:37.319] 2019/09/11 08:54:37 process.go:153: Running: kubectl get nodes -ojson
W0911 08:57:07.415] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0911 08:57:07.419] 2019/09/11 08:57:07 process.go:155: Step 'kubectl get nodes -ojson' finished in 2m30.099665889s
W0911 08:57:07.419] 2019/09/11 08:57:07 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0911 08:57:07.420] 2019/09/11 08:57:07 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0911 08:57:37.420] 2019/09/11 08:57:37 process.go:153: Running: kubectl get nodes -ojson
W0911 09:00:07.533] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0911 09:00:07.533] 2019/09/11 09:00:07 process.go:155: Step 'kubectl get nodes -ojson' finished in 2m30.113311806s
W0911 09:00:07.534] 2019/09/11 09:00:07 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0911 09:00:07.534] 2019/09/11 09:00:07 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0911 09:00:37.535] 2019/09/11 09:00:37 process.go:153: Running: kubectl get nodes -ojson
W0911 09:03:07.629] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0911 09:03:07.633] 2019/09/11 09:03:07 process.go:155: Step 'kubectl get nodes -ojson' finished in 2m30.098346941s
W0911 09:03:07.635] 2019/09/11 09:03:07 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0911 09:03:07.635] 2019/09/11 09:03:07 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0911 09:03:37.635] 2019/09/11 09:03:37 process.go:153: Running: /workspace/kops toolbox dump --name e2e-kops-aws.test-cncf-aws.k8s.io -ojson
W0911 09:03:45.901] 2019/09/11 09:03:45 process.go:155: Step '/workspace/kops toolbox dump --name e2e-kops-aws.test-cncf-aws.k8s.io -ojson' finished in 8.265581362s
W0911 09:03:45.907] 2019/09/11 09:03:45 process.go:153: Running: kubectl get nodes -ojson
W0911 09:06:16.010] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0911 09:06:16.010] 2019/09/11 09:06:16 process.go:155: Step 'kubectl get nodes -ojson' finished in 2m30.103516713s
W0911 09:06:16.011] 2019/09/11 09:06:16 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0911 09:06:16.011] 2019/09/11 09:06:16 dump.go:89: Failed to get nodes for dumping via kubectl: error during kubectl get nodes -ojson: exit status 1
W0911 09:06:16.011] 2019/09/11 09:06:16 dump.go:123: dumping node not registered in kubernetes: 52.67.146.118
W0911 09:06:16.011] 2019/09/11 09:06:16 dump.go:157: Dumping node 52.67.146.118
W0911 09:06:17.495] 2019/09/11 09:06:17 dump.go:358: Running SSH command: sudo journalctl --output=short-precise -k
W0911 09:06:18.595] 2019/09/11 09:06:18 dump.go:358: Running SSH command: sudo journalctl --output=short-precise
W0911 09:06:23.117] 2019/09/11 09:06:23 dump.go:358: Running SSH command: sudo systemctl list-units -t service --no-pager --no-legend --all
W0911 09:06:23.412] 2019/09/11 09:06:23 dump.go:358: Running SSH command: sudo journalctl --output=cat -u kubelet.service
... skipping 156 lines ...
W0911 09:07:59.386]     check_env(env, self.command, *args)
W0911 09:07:59.386]   File "/workspace/./test-infra/jenkins/../scenarios/kubernetes_e2e.py", line 111, in check_env
W0911 09:07:59.386]     subprocess.check_call(cmd, env=env)
W0911 09:07:59.386]   File "/usr/lib/python2.7/subprocess.py", line 186, in check_call
W0911 09:07:59.386]     raise CalledProcessError(retcode, cmd)
W0911 09:07:59.387] 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=sa-east-1a', '--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 09:07:59.387] Command failed
I0911 09:07:59.388] process 260 exited with code 1 after 25.5m
E0911 09:07:59.388] FAIL: ci-kubernetes-e2e-kops-aws
I0911 09:07:59.388] Call:  gcloud auth activate-service-account --key-file=/etc/service-account/service-account.json
W0911 09:07:59.972] Activated service account credentials for: [pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com]
I0911 09:08:00.043] process 590 exited with code 0 after 0.0m
I0911 09:08:00.044] Call:  gcloud config get-value account
I0911 09:08:00.412] process 602 exited with code 0 after 0.0m
I0911 09:08:00.412] Will upload results to gs://kubernetes-jenkins/logs using pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com
I0911 09:08:00.412] Upload result and artifacts...
I0911 09:08:00.412] Gubernator results at https://gubernator.k8s.io/build/kubernetes-jenkins/logs/ci-kubernetes-e2e-kops-aws/1171705466053464068
I0911 09:08:00.413] Call:  gsutil ls gs://kubernetes-jenkins/logs/ci-kubernetes-e2e-kops-aws/1171705466053464068/artifacts
W0911 09:08:01.693] CommandException: One or more URLs matched no objects.
E0911 09:08:01.820] Command failed
I0911 09:08:01.821] process 614 exited with code 1 after 0.0m
W0911 09:08:01.821] Remote dir gs://kubernetes-jenkins/logs/ci-kubernetes-e2e-kops-aws/1171705466053464068/artifacts not exist yet
I0911 09:08:01.821] 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/1171705466053464068/artifacts
I0911 09:08:05.905] process 756 exited with code 0 after 0.1m
I0911 09:08:05.906] Call:  git rev-parse HEAD
W0911 09:08:05.910] fatal: Not a git repository (or any of the parent directories): .git
E0911 09:08:05.911] Command failed
I0911 09:08:05.912] process 1395 exited with code 128 after 0.0m
I0911 09:08:05.912] Call:  git rev-parse HEAD
I0911 09:08:05.917] process 1396 exited with code 0 after 0.0m
I0911 09:08:05.917] Call:  gsutil stat gs://kubernetes-jenkins/logs/ci-kubernetes-e2e-kops-aws/jobResultsCache.json
I0911 09:08:07.186] process 1397 exited with code 0 after 0.0m
I0911 09:08:07.187] Call:  gsutil -q cat 'gs://kubernetes-jenkins/logs/ci-kubernetes-e2e-kops-aws/jobResultsCache.json#1568191084119401'
... skipping 8 lines ...