This job view page is being replaced by Spyglass soon. Check out the new job view.
ResultFAILURE
Tests 1 failed / 5 succeeded
Started2019-09-10 22:22
Elapsed27m51s
Revision
Buildergke-prow-ssd-pool-1a225945-3ng5
links{u'resultstore': {u'url': u'https://source.cloud.google.com/results/invocations/2e4a7ac1-733f-4336-8d87-05ea0b6b2c4e/targets/test'}}
pod58f1c366-d419-11e9-9d26-329cee23a2e0
resultstorehttps://source.cloud.google.com/results/invocations/2e4a7ac1-733f-4336-8d87-05ea0b6b2c4e/targets/test
infra-commit3d026cf14
job-versionv1.17.0-alpha.0.1213+7351f1acd7e67c
pod58f1c366-d419-11e9-9d26-329cee23a2e0
revisionv1.17.0-alpha.0.1213+7351f1acd7e67c

Test Failures


Up 22m31s

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 ...
I0910 22:22:24.857] process 44 exited with code 0 after 0.0m
I0910 22:22:24.858] Will upload results to gs://kubernetes-jenkins/logs using pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com
I0910 22:22:24.858] Root: /workspace
I0910 22:22:24.858] cd to /workspace
I0910 22:22:24.858] Configure environment...
I0910 22:22:24.859] Call:  git show -s --format=format:%ct HEAD
W0910 22:22:24.864] fatal: Not a git repository (or any of the parent directories): .git
I0910 22:22:24.864] process 56 exited with code 128 after 0.0m
W0910 22:22:24.865] Unable to print commit date for HEAD
I0910 22:22:24.865] Call:  gcloud auth activate-service-account --key-file=/etc/service-account/service-account.json
W0910 22:22:25.539] Activated service account credentials for: [pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com]
I0910 22:22:25.596] process 57 exited with code 0 after 0.0m
I0910 22:22:25.596] Call:  gcloud config get-value account
... skipping 701 lines ...
I0910 22:23:31.018]  * read about installing addons at: https://github.com/kubernetes/kops/blob/master/docs/addons.md.
I0910 22:23:31.019] 
W0910 22:23:31.119] 2019/09/10 22:23:31 process.go:155: Step '/workspace/kops update cluster e2e-kops-aws.test-cncf-aws.k8s.io --yes' finished in 22.578490326s
W0910 22:23:31.119] 2019/09/10 22:23:31 process.go:153: Running: kubectl get nodes -ojson
W0910 22:23:31.256] 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
W0910 22:23:31.261] 2019/09/10 22:23:31 process.go:155: Step 'kubectl get nodes -ojson' finished in 236.791628ms
W0910 22:23:31.261] 2019/09/10 22:23:31 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0910 22:23:31.262] 2019/09/10 22:23:31 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0910 22:24:01.261] 2019/09/10 22:24:01 process.go:153: Running: kubectl get nodes -ojson
W0910 22:24:31.412] 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
W0910 22:24:31.415] 2019/09/10 22:24:31 process.go:155: Step 'kubectl get nodes -ojson' finished in 30.153481327s
W0910 22:24:31.415] 2019/09/10 22:24:31 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0910 22:24:31.416] 2019/09/10 22:24:31 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0910 22:25:01.415] 2019/09/10 22:25:01 process.go:153: Running: kubectl get nodes -ojson
W0910 22:27:01.521] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0910 22:27:01.524] 2019/09/10 22:27:01 process.go:155: Step 'kubectl get nodes -ojson' finished in 2m0.108816259s
W0910 22:27:01.524] 2019/09/10 22:27:01 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0910 22:27:01.525] 2019/09/10 22:27:01 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0910 22:27:31.525] 2019/09/10 22:27:31 process.go:153: Running: kubectl get nodes -ojson
W0910 22:30:01.696] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0910 22:30:01.705] 2019/09/10 22:30:01 process.go:155: Step 'kubectl get nodes -ojson' finished in 2m30.179622571s
W0910 22:30:01.706] 2019/09/10 22:30:01 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0910 22:30:01.707] 2019/09/10 22:30:01 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0910 22:30:31.705] 2019/09/10 22:30:31 process.go:153: Running: kubectl get nodes -ojson
W0910 22:33:01.799] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0910 22:33:01.809] 2019/09/10 22:33:01 process.go:155: Step 'kubectl get nodes -ojson' finished in 2m30.104632989s
W0910 22:33:01.810] 2019/09/10 22:33:01 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0910 22:33:01.811] 2019/09/10 22:33:01 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0910 22:33:31.810] 2019/09/10 22:33:31 process.go:153: Running: kubectl get nodes -ojson
W0910 22:36:01.950] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0910 22:36:01.961] 2019/09/10 22:36:01 process.go:155: Step 'kubectl get nodes -ojson' finished in 2m30.140112979s
W0910 22:36:01.963] 2019/09/10 22:36:01 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0910 22:36:01.964] 2019/09/10 22:36:01 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0910 22:36:31.951] 2019/09/10 22:36:31 process.go:153: Running: kubectl get nodes -ojson
W0910 22:39:02.068] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0910 22:39:02.069] 2019/09/10 22:39:02 process.go:155: Step 'kubectl get nodes -ojson' finished in 2m30.118020659s
W0910 22:39:02.070] 2019/09/10 22:39:02 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0910 22:39:02.070] 2019/09/10 22:39:02 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0910 22:39:32.072] 2019/09/10 22:39:32 process.go:153: Running: kubectl get nodes -ojson
W0910 22:42:02.608] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0910 22:42:02.608] 2019/09/10 22:42:02 process.go:155: Step 'kubectl get nodes -ojson' finished in 2m30.538795226s
W0910 22:42:02.609] 2019/09/10 22:42:02 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0910 22:42:02.609] 2019/09/10 22:42:02 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0910 22:42:32.609] 2019/09/10 22:42:32 process.go:153: Running: kubectl get nodes -ojson
W0910 22:45:02.707] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0910 22:45:02.707] 2019/09/10 22:45:02 process.go:155: Step 'kubectl get nodes -ojson' finished in 2m30.098015745s
W0910 22:45:02.708] 2019/09/10 22:45:02 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0910 22:45:02.708] 2019/09/10 22:45:02 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0910 22:45:32.716] 2019/09/10 22:45:32 process.go:153: Running: /workspace/kops toolbox dump --name e2e-kops-aws.test-cncf-aws.k8s.io -ojson
W0910 22:45:41.172] 2019/09/10 22:45:41 process.go:155: Step '/workspace/kops toolbox dump --name e2e-kops-aws.test-cncf-aws.k8s.io -ojson' finished in 8.455218085s
W0910 22:45:41.175] 2019/09/10 22:45:41 process.go:153: Running: kubectl get nodes -ojson
W0910 22:48:11.308] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0910 22:48:11.311] 2019/09/10 22:48:11 process.go:155: Step 'kubectl get nodes -ojson' finished in 2m30.136490087s
W0910 22:48:11.312] 2019/09/10 22:48:11 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0910 22:48:11.312] 2019/09/10 22:48:11 dump.go:89: Failed to get nodes for dumping via kubectl: error during kubectl get nodes -ojson: exit status 1
W0910 22:48:11.312] 2019/09/10 22:48:11 dump.go:123: dumping node not registered in kubernetes: 54.238.153.80
W0910 22:48:11.313] 2019/09/10 22:48:11 dump.go:157: Dumping node 54.238.153.80
W0910 22:48:12.668] 2019/09/10 22:48:12 dump.go:358: Running SSH command: sudo journalctl --output=short-precise -k
W0910 22:48:13.198] 2019/09/10 22:48:13 dump.go:358: Running SSH command: sudo journalctl --output=short-precise
W0910 22:48:16.537] 2019/09/10 22:48:16 dump.go:358: Running SSH command: sudo systemctl list-units -t service --no-pager --no-legend --all
W0910 22:48:16.810] 2019/09/10 22:48:16 dump.go:358: Running SSH command: sudo journalctl --output=cat -u kubelet.service
... skipping 158 lines ...
W0910 22:49:54.229]     check_env(env, self.command, *args)
W0910 22:49:54.229]   File "/workspace/./test-infra/jenkins/../scenarios/kubernetes_e2e.py", line 111, in check_env
W0910 22:49:54.229]     subprocess.check_call(cmd, env=env)
W0910 22:49:54.230]   File "/usr/lib/python2.7/subprocess.py", line 186, in check_call
W0910 22:49:54.230]     raise CalledProcessError(retcode, cmd)
W0910 22:49:54.233] 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
E0910 22:49:54.234] Command failed
I0910 22:49:54.234] process 259 exited with code 1 after 27.4m
E0910 22:49:54.235] FAIL: ci-kubernetes-e2e-kops-aws
I0910 22:49:54.241] Call:  gcloud auth activate-service-account --key-file=/etc/service-account/service-account.json
W0910 22:49:55.380] Activated service account credentials for: [pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com]
I0910 22:49:55.500] process 605 exited with code 0 after 0.0m
I0910 22:49:55.500] Call:  gcloud config get-value account
I0910 22:49:56.122] process 617 exited with code 0 after 0.0m
I0910 22:49:56.123] Will upload results to gs://kubernetes-jenkins/logs using pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com
I0910 22:49:56.123] Upload result and artifacts...
I0910 22:49:56.123] Gubernator results at https://gubernator.k8s.io/build/kubernetes-jenkins/logs/ci-kubernetes-e2e-kops-aws/1171549434970902528
I0910 22:49:56.124] Call:  gsutil ls gs://kubernetes-jenkins/logs/ci-kubernetes-e2e-kops-aws/1171549434970902528/artifacts
W0910 22:49:58.250] CommandException: One or more URLs matched no objects.
E0910 22:49:58.540] Command failed
I0910 22:49:58.541] process 629 exited with code 1 after 0.0m
W0910 22:49:58.542] Remote dir gs://kubernetes-jenkins/logs/ci-kubernetes-e2e-kops-aws/1171549434970902528/artifacts not exist yet
I0910 22:49:58.543] 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/1171549434970902528/artifacts
I0910 22:50:07.107] process 771 exited with code 0 after 0.1m
I0910 22:50:07.108] Call:  git rev-parse HEAD
W0910 22:50:07.116] fatal: Not a git repository (or any of the parent directories): .git
E0910 22:50:07.117] Command failed
I0910 22:50:07.117] process 1410 exited with code 128 after 0.0m
I0910 22:50:07.118] Call:  git rev-parse HEAD
I0910 22:50:07.130] process 1411 exited with code 0 after 0.0m
I0910 22:50:07.131] Call:  gsutil stat gs://kubernetes-jenkins/logs/ci-kubernetes-e2e-kops-aws/jobResultsCache.json
I0910 22:50:09.514] process 1412 exited with code 0 after 0.0m
I0910 22:50:09.515] Call:  gsutil -q cat 'gs://kubernetes-jenkins/logs/ci-kubernetes-e2e-kops-aws/jobResultsCache.json#1568153938888446'
... skipping 8 lines ...