This job view page is being replaced by Spyglass soon. Check out the new job view.
ResultFAILURE
Tests 1 failed / 5 succeeded
Started2019-09-18 11:28
Elapsed26m31s
Revision
Buildergke-prow-ssd-pool-1a225945-g8h1
links{u'resultstore': {u'url': u'https://source.cloud.google.com/results/invocations/f3b146c3-3c3e-4d50-b321-e4448c7c7c33/targets/test'}}
pod51139b8f-da07-11e9-9368-d2ad95f0993d
resultstorehttps://source.cloud.google.com/results/invocations/f3b146c3-3c3e-4d50-b321-e4448c7c7c33/targets/test
infra-commit7b24b623a
job-versionv1.17.0-alpha.0.1519+57d87502ba6408
pod51139b8f-da07-11e9-9368-d2ad95f0993d
revisionv1.17.0-alpha.0.1519+57d87502ba6408

Test Failures


Up 21m30s

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 ...
I0918 11:28:23.825] process 44 exited with code 0 after 0.0m
I0918 11:28:23.826] Will upload results to gs://kubernetes-jenkins/logs using pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com
I0918 11:28:23.826] Root: /workspace
I0918 11:28:23.826] cd to /workspace
I0918 11:28:23.826] Configure environment...
I0918 11:28:23.826] Call:  git show -s --format=format:%ct HEAD
W0918 11:28:23.830] fatal: Not a git repository (or any of the parent directories): .git
I0918 11:28:23.831] process 56 exited with code 128 after 0.0m
W0918 11:28:23.831] Unable to print commit date for HEAD
I0918 11:28:23.831] Call:  gcloud auth activate-service-account --key-file=/etc/service-account/service-account.json
W0918 11:28:24.366] Activated service account credentials for: [pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com]
I0918 11:28:24.422] process 57 exited with code 0 after 0.0m
I0918 11:28:24.422] Call:  gcloud config get-value account
... skipping 701 lines ...
I0918 11:29:25.135]  * read about installing addons at: https://github.com/kubernetes/kops/blob/master/docs/addons.md.
I0918 11:29:25.135] 
W0918 11:29:25.235] 2019/09/18 11:29:25 process.go:155: Step '/workspace/kops update cluster e2e-kops-aws.test-cncf-aws.k8s.io --yes' finished in 22.628456008s
W0918 11:29:25.235] 2019/09/18 11:29:25 process.go:153: Running: kubectl get nodes -ojson
W0918 11:29:25.362] 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
W0918 11:29:25.365] 2019/09/18 11:29:25 process.go:155: Step 'kubectl get nodes -ojson' finished in 223.423975ms
W0918 11:29:25.366] 2019/09/18 11:29:25 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0918 11:29:25.366] 2019/09/18 11:29:25 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0918 11:29:55.366] 2019/09/18 11:29:55 process.go:153: Running: kubectl get nodes -ojson
W0918 11:30:25.512] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0918 11:30:25.515] 2019/09/18 11:30:25 process.go:155: Step 'kubectl get nodes -ojson' finished in 30.148987328s
W0918 11:30:25.515] 2019/09/18 11:30:25 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0918 11:30:25.515] 2019/09/18 11:30:25 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0918 11:30:55.515] 2019/09/18 11:30:55 process.go:153: Running: kubectl get nodes -ojson
W0918 11:30:55.691] 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
W0918 11:30:55.694] 2019/09/18 11:30:55 process.go:155: Step 'kubectl get nodes -ojson' finished in 178.967087ms
W0918 11:30:55.694] 2019/09/18 11:30:55 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0918 11:30:55.695] 2019/09/18 11:30:55 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0918 11:31:25.694] 2019/09/18 11:31:25 process.go:153: Running: kubectl get nodes -ojson
W0918 11:31:25.838] 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
W0918 11:31:25.841] 2019/09/18 11:31:25 process.go:155: Step 'kubectl get nodes -ojson' finished in 146.159156ms
W0918 11:31:25.841] 2019/09/18 11:31:25 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0918 11:31:25.841] 2019/09/18 11:31:25 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0918 11:31:55.841] 2019/09/18 11:31:55 process.go:153: Running: kubectl get nodes -ojson
W0918 11:32:55.959] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0918 11:32:55.961] 2019/09/18 11:32:55 process.go:155: Step 'kubectl get nodes -ojson' finished in 1m0.12019769s
W0918 11:32:55.961] 2019/09/18 11:32:55 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0918 11:32:55.961] 2019/09/18 11:32:55 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0918 11:33:25.962] 2019/09/18 11:33:25 process.go:153: Running: kubectl get nodes -ojson
W0918 11:34:56.084] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0918 11:34:56.087] 2019/09/18 11:34:56 process.go:155: Step 'kubectl get nodes -ojson' finished in 1m30.125188637s
W0918 11:34:56.087] 2019/09/18 11:34:56 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0918 11:34:56.087] 2019/09/18 11:34:56 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0918 11:35:26.087] 2019/09/18 11:35:26 process.go:153: Running: kubectl get nodes -ojson
W0918 11:37:56.167] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0918 11:37:56.171] 2019/09/18 11:37:56 process.go:155: Step 'kubectl get nodes -ojson' finished in 2m30.084192279s
W0918 11:37:56.172] 2019/09/18 11:37:56 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0918 11:37:56.172] 2019/09/18 11:37:56 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0918 11:38:26.172] 2019/09/18 11:38:26 process.go:153: Running: kubectl get nodes -ojson
W0918 11:40:56.255] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0918 11:40:56.256] 2019/09/18 11:40:56 process.go:155: Step 'kubectl get nodes -ojson' finished in 2m30.083652594s
W0918 11:40:56.256] 2019/09/18 11:40:56 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0918 11:40:56.256] 2019/09/18 11:40:56 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0918 11:41:26.256] 2019/09/18 11:41:26 process.go:153: Running: kubectl get nodes -ojson
W0918 11:43:56.340] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0918 11:43:56.343] 2019/09/18 11:43:56 process.go:155: Step 'kubectl get nodes -ojson' finished in 2m30.086977899s
W0918 11:43:56.343] 2019/09/18 11:43:56 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0918 11:43:56.343] 2019/09/18 11:43:56 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0918 11:44:26.343] 2019/09/18 11:44:26 process.go:153: Running: kubectl get nodes -ojson
W0918 11:46:56.427] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0918 11:46:56.430] 2019/09/18 11:46:56 process.go:155: Step 'kubectl get nodes -ojson' finished in 2m30.087473942s
W0918 11:46:56.431] 2019/09/18 11:46:56 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0918 11:46:56.431] 2019/09/18 11:46:56 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0918 11:47:26.431] 2019/09/18 11:47:26 process.go:153: Running: kubectl get nodes -ojson
W0918 11:49:56.523] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0918 11:49:56.527] 2019/09/18 11:49:56 process.go:155: Step 'kubectl get nodes -ojson' finished in 2m30.09578363s
W0918 11:49:56.527] 2019/09/18 11:49:56 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0918 11:49:56.527] 2019/09/18 11:49:56 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0918 11:50:26.527] 2019/09/18 11:50:26 process.go:153: Running: /workspace/kops toolbox dump --name e2e-kops-aws.test-cncf-aws.k8s.io -ojson
W0918 11:50:34.650] 2019/09/18 11:50:34 process.go:155: Step '/workspace/kops toolbox dump --name e2e-kops-aws.test-cncf-aws.k8s.io -ojson' finished in 8.122767533s
W0918 11:50:34.651] 2019/09/18 11:50:34 process.go:153: Running: kubectl get nodes -ojson
W0918 11:53:04.758] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0918 11:53:04.760] 2019/09/18 11:53:04 process.go:155: Step 'kubectl get nodes -ojson' finished in 2m30.109501061s
W0918 11:53:04.761] 2019/09/18 11:53:04 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0918 11:53:04.761] 2019/09/18 11:53:04 dump.go:89: Failed to get nodes for dumping via kubectl: error during kubectl get nodes -ojson: exit status 1
W0918 11:53:04.761] 2019/09/18 11:53:04 dump.go:123: dumping node not registered in kubernetes: 13.113.248.249
W0918 11:53:04.761] 2019/09/18 11:53:04 dump.go:157: Dumping node 13.113.248.249
W0918 11:53:06.079] 2019/09/18 11:53:06 dump.go:358: Running SSH command: sudo journalctl --output=short-precise -k
W0918 11:53:06.807] 2019/09/18 11:53:06 dump.go:358: Running SSH command: sudo journalctl --output=short-precise
W0918 11:53:11.936] 2019/09/18 11:53:11 dump.go:358: Running SSH command: sudo systemctl list-units -t service --no-pager --no-legend --all
W0918 11:53:12.195] 2019/09/18 11:53:12 dump.go:358: Running SSH command: sudo journalctl --output=cat -u kubelet.service
... skipping 160 lines ...
W0918 11:54:42.861]     check_env(env, self.command, *args)
W0918 11:54:42.861]   File "/workspace/./test-infra/jenkins/../scenarios/kubernetes_e2e.py", line 111, in check_env
W0918 11:54:42.861]     subprocess.check_call(cmd, env=env)
W0918 11:54:42.861]   File "/usr/lib/python2.7/subprocess.py", line 186, in check_call
W0918 11:54:42.861]     raise CalledProcessError(retcode, cmd)
W0918 11:54:42.862] 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-1c', '--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
E0918 11:54:42.862] Command failed
I0918 11:54:42.862] process 259 exited with code 1 after 26.3m
E0918 11:54:42.862] FAIL: ci-kubernetes-e2e-kops-aws
I0918 11:54:42.863] Call:  gcloud auth activate-service-account --key-file=/etc/service-account/service-account.json
W0918 11:54:43.417] Activated service account credentials for: [pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com]
I0918 11:54:43.484] process 629 exited with code 0 after 0.0m
I0918 11:54:43.484] Call:  gcloud config get-value account
I0918 11:54:43.828] process 641 exited with code 0 after 0.0m
I0918 11:54:43.828] Will upload results to gs://kubernetes-jenkins/logs using pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com
I0918 11:54:43.829] Upload result and artifacts...
I0918 11:54:43.829] Gubernator results at https://gubernator.k8s.io/build/kubernetes-jenkins/logs/ci-kubernetes-e2e-kops-aws/1174283975166791680
I0918 11:54:43.829] Call:  gsutil ls gs://kubernetes-jenkins/logs/ci-kubernetes-e2e-kops-aws/1174283975166791680/artifacts
W0918 11:54:44.923] CommandException: One or more URLs matched no objects.
E0918 11:54:45.050] Command failed
I0918 11:54:45.051] process 653 exited with code 1 after 0.0m
W0918 11:54:45.051] Remote dir gs://kubernetes-jenkins/logs/ci-kubernetes-e2e-kops-aws/1174283975166791680/artifacts not exist yet
I0918 11:54:45.051] 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/1174283975166791680/artifacts
I0918 11:54:49.256] process 795 exited with code 0 after 0.1m
I0918 11:54:49.257] Call:  git rev-parse HEAD
W0918 11:54:49.261] fatal: Not a git repository (or any of the parent directories): .git
E0918 11:54:49.261] Command failed
I0918 11:54:49.262] process 1434 exited with code 128 after 0.0m
I0918 11:54:49.262] Call:  git rev-parse HEAD
I0918 11:54:49.266] process 1435 exited with code 0 after 0.0m
I0918 11:54:49.267] Call:  gsutil stat gs://kubernetes-jenkins/logs/ci-kubernetes-e2e-kops-aws/jobResultsCache.json
I0918 11:54:50.406] process 1436 exited with code 0 after 0.0m
I0918 11:54:50.407] Call:  gsutil -q cat 'gs://kubernetes-jenkins/logs/ci-kubernetes-e2e-kops-aws/jobResultsCache.json#1568805855138027'
... skipping 8 lines ...