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 10:15
Elapsed25m57s
Revision
Buildergke-prow-ssd-pool-1a225945-4sp7
links{u'resultstore': {u'url': u'https://source.cloud.google.com/results/invocations/3e79aab9-c852-4ce8-a1f9-6c538fcaa85e/targets/test'}}
podf4ac6093-d47c-11e9-9d26-329cee23a2e0
resultstorehttps://source.cloud.google.com/results/invocations/3e79aab9-c852-4ce8-a1f9-6c538fcaa85e/targets/test
infra-commit3d071c448
job-versionv1.17.0-alpha.0.1231+e60fd899e46ccd
podf4ac6093-d47c-11e9-9d26-329cee23a2e0
revisionv1.17.0-alpha.0.1231+e60fd899e46ccd

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 ...
I0911 10:15:50.594] process 44 exited with code 0 after 0.0m
I0911 10:15:50.595] Will upload results to gs://kubernetes-jenkins/logs using pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com
I0911 10:15:50.595] Root: /workspace
I0911 10:15:50.595] cd to /workspace
I0911 10:15:50.595] Configure environment...
I0911 10:15:50.595] Call:  git show -s --format=format:%ct HEAD
W0911 10:15:50.600] fatal: Not a git repository (or any of the parent directories): .git
I0911 10:15:50.601] process 56 exited with code 128 after 0.0m
W0911 10:15:50.601] Unable to print commit date for HEAD
I0911 10:15:50.602] Call:  gcloud auth activate-service-account --key-file=/etc/service-account/service-account.json
W0911 10:15:51.144] Activated service account credentials for: [pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com]
I0911 10:15:51.203] process 57 exited with code 0 after 0.0m
I0911 10:15:51.204] Call:  gcloud config get-value account
... skipping 701 lines ...
I0911 10:16:55.434]  * read about installing addons at: https://github.com/kubernetes/kops/blob/master/docs/addons.md.
I0911 10:16:55.434] 
W0911 10:16:55.535] 2019/09/11 10:16:55 process.go:155: Step '/workspace/kops update cluster e2e-kops-aws.test-cncf-aws.k8s.io --yes' finished in 22.694058657s
W0911 10:16:55.536] 2019/09/11 10:16:55 process.go:153: Running: kubectl get nodes -ojson
W0911 10:16:55.831] 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 10:16:55.839] 2019/09/11 10:16:55 process.go:155: Step 'kubectl get nodes -ojson' finished in 391.660657ms
W0911 10:16:55.839] 2019/09/11 10:16:55 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0911 10:16:55.840] 2019/09/11 10:16:55 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0911 10:17:25.839] 2019/09/11 10:17:25 process.go:153: Running: kubectl get nodes -ojson
W0911 10:18:25.972] 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 10:18:25.976] 2019/09/11 10:18:25 process.go:155: Step 'kubectl get nodes -ojson' finished in 1m0.137224906s
W0911 10:18:25.977] 2019/09/11 10:18:25 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0911 10:18:25.977] 2019/09/11 10:18:25 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0911 10:18:55.977] 2019/09/11 10:18:55 process.go:153: Running: kubectl get nodes -ojson
W0911 10:19:56.188] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0911 10:19:56.190] 2019/09/11 10:19:56 process.go:155: Step 'kubectl get nodes -ojson' finished in 1m0.213580962s
W0911 10:19:56.191] 2019/09/11 10:19:56 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0911 10:19:56.191] 2019/09/11 10:19:56 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0911 10:20:26.191] 2019/09/11 10:20:26 process.go:153: Running: kubectl get nodes -ojson
W0911 10:20:56.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
W0911 10:20:56.354] 2019/09/11 10:20:56 process.go:155: Step 'kubectl get nodes -ojson' finished in 30.163456677s
W0911 10:20:56.354] 2019/09/11 10:20:56 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0911 10:20:56.355] 2019/09/11 10:20:56 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0911 10:21:26.354] 2019/09/11 10:21:26 process.go:153: Running: kubectl get nodes -ojson
W0911 10:21:26.499] 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 10:21:26.500] 2019/09/11 10:21:26 process.go:155: Step 'kubectl get nodes -ojson' finished in 145.529878ms
W0911 10:21:26.500] 2019/09/11 10:21:26 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0911 10:21:26.501] 2019/09/11 10:21:26 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0911 10:21:56.500] 2019/09/11 10:21:56 process.go:153: Running: kubectl get nodes -ojson
W0911 10:24:26.612] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0911 10:24:26.613] 2019/09/11 10:24:26 process.go:155: Step 'kubectl get nodes -ojson' finished in 2m30.112088758s
W0911 10:24:26.613] 2019/09/11 10:24:26 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0911 10:24:26.613] 2019/09/11 10:24:26 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0911 10:24:56.613] 2019/09/11 10:24:56 process.go:153: Running: kubectl get nodes -ojson
W0911 10:27:26.722] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0911 10:27:26.726] 2019/09/11 10:27:26 process.go:155: Step 'kubectl get nodes -ojson' finished in 2m30.113599674s
W0911 10:27:26.727] 2019/09/11 10:27:26 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0911 10:27:26.727] 2019/09/11 10:27:26 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0911 10:27:56.728] 2019/09/11 10:27:56 process.go:153: Running: kubectl get nodes -ojson
W0911 10:30:26.920] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0911 10:30:26.932] 2019/09/11 10:30:26 process.go:155: Step 'kubectl get nodes -ojson' finished in 2m30.203041983s
W0911 10:30:26.932] 2019/09/11 10:30:26 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0911 10:30:26.933] 2019/09/11 10:30:26 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0911 10:30:56.931] 2019/09/11 10:30:56 process.go:153: Running: kubectl get nodes -ojson
W0911 10:33:27.057] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0911 10:33:27.063] 2019/09/11 10:33:27 process.go:155: Step 'kubectl get nodes -ojson' finished in 2m30.131565981s
W0911 10:33:27.064] 2019/09/11 10:33:27 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0911 10:33:27.065] 2019/09/11 10:33:27 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0911 10:33:57.064] 2019/09/11 10:33:57 process.go:153: Running: kubectl get nodes -ojson
W0911 10:36:27.292] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0911 10:36:27.296] 2019/09/11 10:36:27 process.go:155: Step 'kubectl get nodes -ojson' finished in 2m30.232098984s
W0911 10:36:27.297] 2019/09/11 10:36:27 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0911 10:36:27.297] 2019/09/11 10:36:27 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0911 10:36:57.300] 2019/09/11 10:36:57 process.go:153: Running: /workspace/kops toolbox dump --name e2e-kops-aws.test-cncf-aws.k8s.io -ojson
W0911 10:37:06.189] 2019/09/11 10:37:06 process.go:155: Step '/workspace/kops toolbox dump --name e2e-kops-aws.test-cncf-aws.k8s.io -ojson' finished in 8.889552551s
W0911 10:37:06.192] 2019/09/11 10:37:06 process.go:153: Running: kubectl get nodes -ojson
W0911 10:39:36.467] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0911 10:39:36.470] 2019/09/11 10:39:36 process.go:155: Step 'kubectl get nodes -ojson' finished in 2m30.27361567s
W0911 10:39:36.470] 2019/09/11 10:39:36 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0911 10:39:36.471] 2019/09/11 10:39:36 dump.go:89: Failed to get nodes for dumping via kubectl: error during kubectl get nodes -ojson: exit status 1
W0911 10:39:36.471] 2019/09/11 10:39:36 dump.go:123: dumping node not registered in kubernetes: 54.180.102.128
W0911 10:39:36.471] 2019/09/11 10:39:36 dump.go:157: Dumping node 54.180.102.128
W0911 10:39:38.134] 2019/09/11 10:39:38 dump.go:358: Running SSH command: sudo journalctl --output=short-precise -k
W0911 10:39:38.848] 2019/09/11 10:39:38 dump.go:358: Running SSH command: sudo journalctl --output=short-precise
W0911 10:39:42.558] 2019/09/11 10:39:42 dump.go:358: Running SSH command: sudo systemctl list-units -t service --no-pager --no-legend --all
W0911 10:39:42.883] 2019/09/11 10:39:42 dump.go:358: Running SSH command: sudo journalctl --output=cat -u kubelet.service
... skipping 158 lines ...
W0911 10:41:20.631]     check_env(env, self.command, *args)
W0911 10:41:20.631]   File "/workspace/./test-infra/jenkins/../scenarios/kubernetes_e2e.py", line 111, in check_env
W0911 10:41:20.632]     subprocess.check_call(cmd, env=env)
W0911 10:41:20.632]   File "/usr/lib/python2.7/subprocess.py", line 186, in check_call
W0911 10:41:20.632]     raise CalledProcessError(retcode, cmd)
W0911 10:41:20.633] 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
E0911 10:41:20.633] Command failed
I0911 10:41:20.633] process 259 exited with code 1 after 25.5m
E0911 10:41:20.637] FAIL: ci-kubernetes-e2e-kops-aws
I0911 10:41:20.638] Call:  gcloud auth activate-service-account --key-file=/etc/service-account/service-account.json
W0911 10:41:25.014] Activated service account credentials for: [pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com]
I0911 10:41:25.106] process 613 exited with code 0 after 0.1m
I0911 10:41:25.251] Call:  gcloud config get-value account
I0911 10:41:25.910] process 625 exited with code 0 after 0.0m
I0911 10:41:25.910] Will upload results to gs://kubernetes-jenkins/logs using pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com
I0911 10:41:25.910] Upload result and artifacts...
I0911 10:41:25.911] Gubernator results at https://gubernator.k8s.io/build/kubernetes-jenkins/logs/ci-kubernetes-e2e-kops-aws/1171728872442433538
I0911 10:41:25.911] Call:  gsutil ls gs://kubernetes-jenkins/logs/ci-kubernetes-e2e-kops-aws/1171728872442433538/artifacts
W0911 10:41:28.266] CommandException: One or more URLs matched no objects.
E0911 10:41:28.679] Command failed
I0911 10:41:28.679] process 637 exited with code 1 after 0.0m
W0911 10:41:28.680] Remote dir gs://kubernetes-jenkins/logs/ci-kubernetes-e2e-kops-aws/1171728872442433538/artifacts not exist yet
I0911 10:41:28.680] 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/1171728872442433538/artifacts
I0911 10:41:38.436] process 779 exited with code 0 after 0.2m
I0911 10:41:38.436] Call:  git rev-parse HEAD
W0911 10:41:38.443] fatal: Not a git repository (or any of the parent directories): .git
E0911 10:41:38.444] Command failed
I0911 10:41:38.444] process 1418 exited with code 128 after 0.0m
I0911 10:41:38.444] Call:  git rev-parse HEAD
I0911 10:41:38.463] process 1419 exited with code 0 after 0.0m
I0911 10:41:38.465] Call:  gsutil stat gs://kubernetes-jenkins/logs/ci-kubernetes-e2e-kops-aws/jobResultsCache.json
I0911 10:41:40.891] process 1420 exited with code 0 after 0.0m
I0911 10:41:40.892] Call:  gsutil -q cat 'gs://kubernetes-jenkins/logs/ci-kubernetes-e2e-kops-aws/jobResultsCache.json#1568196678207612'
... skipping 8 lines ...