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 03:31
Elapsed27m11s
Revision
Buildergke-prow-ssd-pool-1a225945-wbxk
links{u'resultstore': {u'url': u'https://source.cloud.google.com/results/invocations/bd3d6f4d-1395-4bec-8385-bae095ebb8df/targets/test'}}
pod60474ac8-d832-11e9-9f18-22ab134e4c57
resultstorehttps://source.cloud.google.com/results/invocations/bd3d6f4d-1395-4bec-8385-bae095ebb8df/targets/test
infra-commite1cbc3ccd
job-versionv1.17.0-alpha.0.1440+ba07527278ef2c
pod60474ac8-d832-11e9-9f18-22ab134e4c57
revisionv1.17.0-alpha.0.1440+ba07527278ef2c

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 ...
I0916 03:31:20.378] process 46 exited with code 0 after 0.0m
I0916 03:31:20.378] Will upload results to gs://kubernetes-jenkins/logs using pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com
I0916 03:31:20.379] Root: /workspace
I0916 03:31:20.379] cd to /workspace
I0916 03:31:20.379] Configure environment...
I0916 03:31:20.379] Call:  git show -s --format=format:%ct HEAD
W0916 03:31:20.389] fatal: Not a git repository (or any of the parent directories): .git
I0916 03:31:20.393] process 58 exited with code 128 after 0.0m
W0916 03:31:20.395] Unable to print commit date for HEAD
I0916 03:31:20.397] Call:  gcloud auth activate-service-account --key-file=/etc/service-account/service-account.json
W0916 03:31:21.325] Activated service account credentials for: [pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com]
I0916 03:31:21.423] process 59 exited with code 0 after 0.0m
I0916 03:31:21.424] Call:  gcloud config get-value account
... skipping 701 lines ...
I0916 03:32:34.405]  * read about installing addons at: https://github.com/kubernetes/kops/blob/master/docs/addons.md.
I0916 03:32:34.405] 
W0916 03:32:34.506] 2019/09/16 03:32:34 process.go:155: Step '/workspace/kops update cluster e2e-kops-aws.test-cncf-aws.k8s.io --yes' finished in 24.531737934s
W0916 03:32:34.506] 2019/09/16 03:32:34 process.go:153: Running: kubectl get nodes -ojson
W0916 03:32:34.681] 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 03:32:34.686] 2019/09/16 03:32:34 process.go:155: Step 'kubectl get nodes -ojson' finished in 272.212558ms
W0916 03:32:34.687] 2019/09/16 03:32:34 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0916 03:32:34.687] 2019/09/16 03:32:34 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0916 03:33:04.687] 2019/09/16 03:33:04 process.go:153: Running: kubectl get nodes -ojson
W0916 03:33:04.988] 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 03:33:04.995] 2019/09/16 03:33:04 process.go:155: Step 'kubectl get nodes -ojson' finished in 309.087304ms
W0916 03:33:04.996] 2019/09/16 03:33:04 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0916 03:33:04.997] 2019/09/16 03:33:04 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0916 03:33:34.998] 2019/09/16 03:33:34 process.go:153: Running: kubectl get nodes -ojson
W0916 03:34:05.219] 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 03:34:05.224] 2019/09/16 03:34:05 process.go:155: Step 'kubectl get nodes -ojson' finished in 30.226986121s
W0916 03:34:05.225] 2019/09/16 03:34:05 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0916 03:34:05.225] 2019/09/16 03:34:05 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0916 03:34:35.225] 2019/09/16 03:34:35 process.go:153: Running: kubectl get nodes -ojson
W0916 03:36:05.491] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0916 03:36:05.508] 2019/09/16 03:36:05 process.go:155: Step 'kubectl get nodes -ojson' finished in 1m30.278609991s
W0916 03:36:05.508] 2019/09/16 03:36:05 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0916 03:36:05.509] 2019/09/16 03:36:05 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0916 03:36:35.558] 2019/09/16 03:36:35 process.go:153: Running: kubectl get nodes -ojson
W0916 03:38:05.791] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0916 03:38:05.800] 2019/09/16 03:38:05 process.go:155: Step 'kubectl get nodes -ojson' finished in 1m30.241530759s
W0916 03:38:05.804] 2019/09/16 03:38:05 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0916 03:38:05.806] 2019/09/16 03:38:05 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0916 03:38:35.805] 2019/09/16 03:38:35 process.go:153: Running: kubectl get nodes -ojson
W0916 03:41:06.284] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0916 03:41:06.288] 2019/09/16 03:41:06 process.go:155: Step 'kubectl get nodes -ojson' finished in 2m30.480603755s
W0916 03:41:06.288] 2019/09/16 03:41:06 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0916 03:41:06.290] 2019/09/16 03:41:06 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0916 03:41:36.287] 2019/09/16 03:41:36 process.go:153: Running: kubectl get nodes -ojson
W0916 03:44:06.511] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0916 03:44:06.514] 2019/09/16 03:44:06 process.go:155: Step 'kubectl get nodes -ojson' finished in 2m30.228138089s
W0916 03:44:06.515] 2019/09/16 03:44:06 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0916 03:44:06.515] 2019/09/16 03:44:06 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0916 03:44:36.515] 2019/09/16 03:44:36 process.go:153: Running: kubectl get nodes -ojson
W0916 03:47:06.663] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0916 03:47:06.664] 2019/09/16 03:47:06 process.go:155: Step 'kubectl get nodes -ojson' finished in 2m30.147742926s
W0916 03:47:06.664] 2019/09/16 03:47:06 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0916 03:47:06.665] 2019/09/16 03:47:06 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0916 03:47:36.664] 2019/09/16 03:47:36 process.go:153: Running: kubectl get nodes -ojson
W0916 03:50:07.048] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0916 03:50:07.051] 2019/09/16 03:50:07 process.go:155: Step 'kubectl get nodes -ojson' finished in 2m30.386916534s
W0916 03:50:07.052] 2019/09/16 03:50:07 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0916 03:50:07.052] 2019/09/16 03:50:07 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0916 03:50:37.053] 2019/09/16 03:50:37 process.go:153: Running: kubectl get nodes -ojson
W0916 03:53:07.456] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0916 03:53:07.458] 2019/09/16 03:53:07 process.go:155: Step 'kubectl get nodes -ojson' finished in 2m30.403966084s
W0916 03:53:07.458] 2019/09/16 03:53:07 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0916 03:53:07.459] 2019/09/16 03:53:07 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0916 03:53:37.460] 2019/09/16 03:53:37 process.go:153: Running: /workspace/kops toolbox dump --name e2e-kops-aws.test-cncf-aws.k8s.io -ojson
W0916 03:53:47.912] 2019/09/16 03:53:47 process.go:155: Step '/workspace/kops toolbox dump --name e2e-kops-aws.test-cncf-aws.k8s.io -ojson' finished in 10.450324029s
W0916 03:53:47.913] 2019/09/16 03:53:47 process.go:153: Running: kubectl get nodes -ojson
W0916 03:56:18.314] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0916 03:56:18.320] 2019/09/16 03:56:18 process.go:155: Step 'kubectl get nodes -ojson' finished in 2m30.407845159s
W0916 03:56:18.320] 2019/09/16 03:56:18 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0916 03:56:18.320] 2019/09/16 03:56:18 dump.go:89: Failed to get nodes for dumping via kubectl: error during kubectl get nodes -ojson: exit status 1
W0916 03:56:18.321] 2019/09/16 03:56:18 dump.go:123: dumping node not registered in kubernetes: 3.113.11.241
W0916 03:56:18.321] 2019/09/16 03:56:18 dump.go:157: Dumping node 3.113.11.241
W0916 03:56:19.663] 2019/09/16 03:56:19 dump.go:358: Running SSH command: sudo journalctl --output=short-precise -k
W0916 03:56:20.223] 2019/09/16 03:56:20 dump.go:358: Running SSH command: sudo journalctl --output=short-precise
W0916 03:56:24.335] 2019/09/16 03:56:24 dump.go:358: Running SSH command: sudo systemctl list-units -t service --no-pager --no-legend --all
W0916 03:56:24.602] 2019/09/16 03:56:24 dump.go:358: Running SSH command: sudo journalctl --output=cat -u kubelet.service
... skipping 158 lines ...
W0916 03:58:07.911]     check_env(env, self.command, *args)
W0916 03:58:07.912]   File "/workspace/./test-infra/jenkins/../scenarios/kubernetes_e2e.py", line 111, in check_env
W0916 03:58:07.912]     subprocess.check_call(cmd, env=env)
W0916 03:58:07.912]   File "/usr/lib/python2.7/subprocess.py", line 186, in check_call
W0916 03:58:07.912]     raise CalledProcessError(retcode, cmd)
W0916 03:58:07.913] 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-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
E0916 03:58:07.914] Command failed
I0916 03:58:07.914] process 261 exited with code 1 after 26.7m
E0916 03:58:07.914] FAIL: ci-kubernetes-e2e-kops-aws
I0916 03:58:07.915] Call:  gcloud auth activate-service-account --key-file=/etc/service-account/service-account.json
W0916 03:58:08.964] Activated service account credentials for: [pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com]
I0916 03:58:09.035] process 621 exited with code 0 after 0.0m
I0916 03:58:09.036] Call:  gcloud config get-value account
I0916 03:58:09.668] process 633 exited with code 0 after 0.0m
I0916 03:58:09.669] Will upload results to gs://kubernetes-jenkins/logs using pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com
I0916 03:58:09.669] Upload result and artifacts...
I0916 03:58:09.669] Gubernator results at https://gubernator.k8s.io/build/kubernetes-jenkins/logs/ci-kubernetes-e2e-kops-aws/1173439109532749824
I0916 03:58:09.669] Call:  gsutil ls gs://kubernetes-jenkins/logs/ci-kubernetes-e2e-kops-aws/1173439109532749824/artifacts
W0916 03:58:11.792] CommandException: One or more URLs matched no objects.
E0916 03:58:12.051] Command failed
I0916 03:58:12.051] process 645 exited with code 1 after 0.0m
W0916 03:58:12.051] Remote dir gs://kubernetes-jenkins/logs/ci-kubernetes-e2e-kops-aws/1173439109532749824/artifacts not exist yet
I0916 03:58:12.052] 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/1173439109532749824/artifacts
I0916 03:58:21.688] process 787 exited with code 0 after 0.2m
I0916 03:58:21.689] Call:  git rev-parse HEAD
W0916 03:58:21.697] fatal: Not a git repository (or any of the parent directories): .git
E0916 03:58:21.699] Command failed
I0916 03:58:21.701] process 1426 exited with code 128 after 0.0m
I0916 03:58:21.701] Call:  git rev-parse HEAD
I0916 03:58:21.717] process 1427 exited with code 0 after 0.0m
I0916 03:58:21.719] Call:  gsutil stat gs://kubernetes-jenkins/logs/ci-kubernetes-e2e-kops-aws/jobResultsCache.json
I0916 03:58:24.061] process 1428 exited with code 0 after 0.0m
I0916 03:58:24.063] Call:  gsutil -q cat 'gs://kubernetes-jenkins/logs/ci-kubernetes-e2e-kops-aws/jobResultsCache.json#1568604323122674'
... skipping 8 lines ...