This job view page is being replaced by Spyglass soon. Check out the new job view.
ResultFAILURE
Tests 1 failed / 5 succeeded
Started2019-09-16 01:58
Elapsed29m4s
Revision
Buildergke-prow-ssd-pool-1a225945-txmz
links{u'resultstore': {u'url': u'https://source.cloud.google.com/results/invocations/f09dbdbf-99d4-4b5d-93bc-ae4eaa2d6e2e/targets/test'}}
pod621814d3-d825-11e9-9f18-22ab134e4c57
resultstorehttps://source.cloud.google.com/results/invocations/f09dbdbf-99d4-4b5d-93bc-ae4eaa2d6e2e/targets/test
infra-commite1cbc3ccd
job-versionv1.17.0-alpha.0.1440+ba07527278ef2c
pod621814d3-d825-11e9-9f18-22ab134e4c57
revisionv1.17.0-alpha.0.1440+ba07527278ef2c

Test Failures


Up 23m16s

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 ...
I0916 01:58:12.495] process 45 exited with code 0 after 0.0m
I0916 01:58:12.495] Will upload results to gs://kubernetes-jenkins/logs using pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com
I0916 01:58:12.495] Root: /workspace
I0916 01:58:12.496] cd to /workspace
I0916 01:58:12.496] Configure environment...
I0916 01:58:12.496] Call:  git show -s --format=format:%ct HEAD
W0916 01:58:12.500] fatal: Not a git repository (or any of the parent directories): .git
I0916 01:58:12.500] process 57 exited with code 128 after 0.0m
W0916 01:58:12.500] Unable to print commit date for HEAD
I0916 01:58:12.501] Call:  gcloud auth activate-service-account --key-file=/etc/service-account/service-account.json
W0916 01:58:21.690] Activated service account credentials for: [pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com]
I0916 01:58:21.749] process 58 exited with code 0 after 0.2m
I0916 01:58:21.749] Call:  gcloud config get-value account
... skipping 701 lines ...
I0916 02:00:11.101]  * read about installing addons at: https://github.com/kubernetes/kops/blob/master/docs/addons.md.
I0916 02:00:11.101] 
W0916 02:00:11.202] 2019/09/16 02:00:11 process.go:155: Step '/workspace/kops update cluster e2e-kops-aws.test-cncf-aws.k8s.io --yes' finished in 22.101115951s
W0916 02:00:11.202] 2019/09/16 02:00:11 process.go:153: Running: kubectl get nodes -ojson
W0916 02:00:11.311] 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
W0916 02:00:11.315] 2019/09/16 02:00:11 process.go:155: Step 'kubectl get nodes -ojson' finished in 205.688464ms
W0916 02:00:11.316] 2019/09/16 02:00:11 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0916 02:00:11.316] 2019/09/16 02:00:11 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0916 02:00:41.316] 2019/09/16 02:00:41 process.go:153: Running: kubectl get nodes -ojson
W0916 02:00:41.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
W0916 02:00:41.841] 2019/09/16 02:00:41 process.go:155: Step 'kubectl get nodes -ojson' finished in 525.533764ms
W0916 02:00:41.842] 2019/09/16 02:00:41 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0916 02:00:41.842] 2019/09/16 02:00:41 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0916 02:01:11.842] 2019/09/16 02:01:11 process.go:153: Running: kubectl get nodes -ojson
W0916 02:01:42.091] 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
W0916 02:01:42.093] 2019/09/16 02:01:42 process.go:155: Step 'kubectl get nodes -ojson' finished in 30.25158981s
W0916 02:01:42.093] 2019/09/16 02:01:42 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0916 02:01:42.094] 2019/09/16 02:01:42 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0916 02:02:12.094] 2019/09/16 02:02:12 process.go:153: Running: kubectl get nodes -ojson
W0916 02:02:42.975] 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
W0916 02:02:42.975] 2019/09/16 02:02:42 process.go:155: Step 'kubectl get nodes -ojson' finished in 30.881511616s
W0916 02:02:42.975] 2019/09/16 02:02:42 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0916 02:02:42.975] 2019/09/16 02:02:42 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0916 02:03:12.975] 2019/09/16 02:03:12 process.go:153: Running: kubectl get nodes -ojson
W0916 02:04:13.195] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0916 02:04:13.198] 2019/09/16 02:04:13 process.go:155: Step 'kubectl get nodes -ojson' finished in 1m0.22285123s
W0916 02:04:13.199] 2019/09/16 02:04:13 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0916 02:04:13.199] 2019/09/16 02:04:13 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0916 02:04:43.199] 2019/09/16 02:04:43 process.go:153: Running: kubectl get nodes -ojson
W0916 02:07:13.277] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0916 02:07:13.277] 2019/09/16 02:07:13 process.go:155: Step 'kubectl get nodes -ojson' finished in 2m30.078256697s
W0916 02:07:13.277] 2019/09/16 02:07:13 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0916 02:07:13.278] 2019/09/16 02:07:13 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0916 02:07:43.278] 2019/09/16 02:07:43 process.go:153: Running: kubectl get nodes -ojson
W0916 02:10:13.362] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0916 02:10:13.365] 2019/09/16 02:10:13 process.go:155: Step 'kubectl get nodes -ojson' finished in 2m30.087602129s
W0916 02:10:13.365] 2019/09/16 02:10:13 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0916 02:10:13.366] 2019/09/16 02:10:13 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0916 02:10:43.365] 2019/09/16 02:10:43 process.go:153: Running: kubectl get nodes -ojson
W0916 02:13:13.449] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0916 02:13:13.451] 2019/09/16 02:13:13 process.go:155: Step 'kubectl get nodes -ojson' finished in 2m30.085716741s
W0916 02:13:13.452] 2019/09/16 02:13:13 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0916 02:13:13.452] 2019/09/16 02:13:13 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0916 02:13:43.452] 2019/09/16 02:13:43 process.go:153: Running: kubectl get nodes -ojson
W0916 02:16:13.526] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0916 02:16:13.526] 2019/09/16 02:16:13 process.go:155: Step 'kubectl get nodes -ojson' finished in 2m30.075139989s
W0916 02:16:13.527] 2019/09/16 02:16:13 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0916 02:16:13.527] 2019/09/16 02:16:13 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0916 02:16:43.527] 2019/09/16 02:16:43 process.go:153: Running: kubectl get nodes -ojson
W0916 02:19:13.643] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0916 02:19:13.643] 2019/09/16 02:19:13 process.go:155: Step 'kubectl get nodes -ojson' finished in 2m30.115897524s
W0916 02:19:13.643] 2019/09/16 02:19:13 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0916 02:19:13.643] 2019/09/16 02:19:13 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0916 02:19:43.643] 2019/09/16 02:19:43 process.go:153: Running: kubectl get nodes -ojson
W0916 02:22:13.727] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0916 02:22:13.730] 2019/09/16 02:22:13 process.go:155: Step 'kubectl get nodes -ojson' finished in 2m30.087117285s
W0916 02:22:13.731] 2019/09/16 02:22:13 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0916 02:22:13.731] 2019/09/16 02:22:13 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0916 02:22:43.733] 2019/09/16 02:22:43 process.go:153: Running: /workspace/kops toolbox dump --name e2e-kops-aws.test-cncf-aws.k8s.io -ojson
W0916 02:22:52.609] 2019/09/16 02:22:52 process.go:155: Step '/workspace/kops toolbox dump --name e2e-kops-aws.test-cncf-aws.k8s.io -ojson' finished in 8.875975144s
W0916 02:22:52.609] 2019/09/16 02:22:52 process.go:153: Running: kubectl get nodes -ojson
W0916 02:25:22.722] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0916 02:25:22.728] 2019/09/16 02:25:22 process.go:155: Step 'kubectl get nodes -ojson' finished in 2m30.119555012s
W0916 02:25:22.729] 2019/09/16 02:25:22 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0916 02:25:22.729] 2019/09/16 02:25:22 dump.go:89: Failed to get nodes for dumping via kubectl: error during kubectl get nodes -ojson: exit status 1
W0916 02:25:22.729] 2019/09/16 02:25:22 dump.go:123: dumping node not registered in kubernetes: 3.115.88.26
W0916 02:25:22.729] 2019/09/16 02:25:22 dump.go:157: Dumping node 3.115.88.26
W0916 02:25:24.089] 2019/09/16 02:25:24 dump.go:358: Running SSH command: sudo journalctl --output=short-precise -k
W0916 02:25:24.649] 2019/09/16 02:25:24 dump.go:358: Running SSH command: sudo journalctl --output=short-precise
W0916 02:25:28.996] 2019/09/16 02:25:28 dump.go:358: Running SSH command: sudo systemctl list-units -t service --no-pager --no-legend --all
W0916 02:25:29.259] 2019/09/16 02:25:29 dump.go:358: Running SSH command: sudo journalctl --output=cat -u kubelet.service
... skipping 150 lines ...
W0916 02:26:55.211]     check_env(env, self.command, *args)
W0916 02:26:55.211]   File "/workspace/./test-infra/jenkins/../scenarios/kubernetes_e2e.py", line 111, in check_env
W0916 02:26:55.212]     subprocess.check_call(cmd, env=env)
W0916 02:26:55.212]   File "/usr/lib/python2.7/subprocess.py", line 186, in check_call
W0916 02:26:55.213]     raise CalledProcessError(retcode, cmd)
W0916 02:26:55.214] 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-1d', '--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
E0916 02:26:55.215] Command failed
I0916 02:26:55.215] process 260 exited with code 1 after 28.5m
E0916 02:26:55.217] FAIL: ci-kubernetes-e2e-kops-aws
I0916 02:26:55.217] Call:  gcloud auth activate-service-account --key-file=/etc/service-account/service-account.json
W0916 02:26:56.154] Activated service account credentials for: [pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com]
I0916 02:26:56.222] process 630 exited with code 0 after 0.0m
I0916 02:26:56.222] Call:  gcloud config get-value account
I0916 02:26:56.891] process 642 exited with code 0 after 0.0m
I0916 02:26:56.892] Will upload results to gs://kubernetes-jenkins/logs using pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com
I0916 02:26:56.892] Upload result and artifacts...
I0916 02:26:56.892] Gubernator results at https://gubernator.k8s.io/build/kubernetes-jenkins/logs/ci-kubernetes-e2e-kops-aws/1173415704280436739
I0916 02:26:56.893] Call:  gsutil ls gs://kubernetes-jenkins/logs/ci-kubernetes-e2e-kops-aws/1173415704280436739/artifacts
W0916 02:26:58.996] CommandException: One or more URLs matched no objects.
E0916 02:26:59.272] Command failed
I0916 02:26:59.272] process 654 exited with code 1 after 0.0m
W0916 02:26:59.272] Remote dir gs://kubernetes-jenkins/logs/ci-kubernetes-e2e-kops-aws/1173415704280436739/artifacts not exist yet
I0916 02:26:59.273] 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/1173415704280436739/artifacts
I0916 02:27:08.304] process 796 exited with code 0 after 0.2m
I0916 02:27:08.305] Call:  git rev-parse HEAD
W0916 02:27:08.310] fatal: Not a git repository (or any of the parent directories): .git
E0916 02:27:08.311] Command failed
I0916 02:27:08.312] process 1435 exited with code 128 after 0.0m
I0916 02:27:08.312] Call:  git rev-parse HEAD
I0916 02:27:08.318] process 1436 exited with code 0 after 0.0m
I0916 02:27:08.319] Call:  gsutil stat gs://kubernetes-jenkins/logs/ci-kubernetes-e2e-kops-aws/jobResultsCache.json
I0916 02:27:10.763] process 1437 exited with code 0 after 0.0m
I0916 02:27:10.764] Call:  gsutil -q cat 'gs://kubernetes-jenkins/logs/ci-kubernetes-e2e-kops-aws/jobResultsCache.json#1568598797974385'
... skipping 8 lines ...