This job view page is being replaced by Spyglass soon. Check out the new job view.
ResultFAILURE
Tests 1 failed / 5 succeeded
Started2019-09-15 19:15
Elapsed26m36s
Revision
Buildergke-prow-ssd-pool-1a225945-n4mt
links{u'resultstore': {u'url': u'https://source.cloud.google.com/results/invocations/06322e7b-be2f-4217-99e0-23927f6e7d48/targets/test'}}
pod15dd2dbb-d7ed-11e9-9f18-22ab134e4c57
resultstorehttps://source.cloud.google.com/results/invocations/06322e7b-be2f-4217-99e0-23927f6e7d48/targets/test
infra-commite1cbc3ccd
job-versionv1.17.0-alpha.0.1440+ba07527278ef2c
pod15dd2dbb-d7ed-11e9-9f18-22ab134e4c57
revisionv1.17.0-alpha.0.1440+ba07527278ef2c

Test Failures


Up 21m3s

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 ...
I0915 19:15:17.711] process 44 exited with code 0 after 0.0m
I0915 19:15:17.711] Will upload results to gs://kubernetes-jenkins/logs using pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com
I0915 19:15:17.711] Root: /workspace
I0915 19:15:17.712] cd to /workspace
I0915 19:15:17.712] Configure environment...
I0915 19:15:17.712] Call:  git show -s --format=format:%ct HEAD
W0915 19:15:17.717] fatal: Not a git repository (or any of the parent directories): .git
I0915 19:15:17.718] process 56 exited with code 128 after 0.0m
W0915 19:15:17.718] Unable to print commit date for HEAD
I0915 19:15:17.719] Call:  gcloud auth activate-service-account --key-file=/etc/service-account/service-account.json
W0915 19:15:18.564] Activated service account credentials for: [pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com]
I0915 19:15:18.654] process 57 exited with code 0 after 0.0m
I0915 19:15:18.655] Call:  gcloud config get-value account
... skipping 701 lines ...
I0915 19:16:30.543]  * read about installing addons at: https://github.com/kubernetes/kops/blob/master/docs/addons.md.
I0915 19:16:30.543] 
W0915 19:16:30.644] 2019/09/15 19:16:30 process.go:155: Step '/workspace/kops update cluster e2e-kops-aws.test-cncf-aws.k8s.io --yes' finished in 24.313848012s
W0915 19:16:30.646] 2019/09/15 19:16:30 process.go:153: Running: kubectl get nodes -ojson
W0915 19:16:30.855] 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
W0915 19:16:30.867] 2019/09/15 19:16:30 process.go:155: Step 'kubectl get nodes -ojson' finished in 316.231065ms
W0915 19:16:30.868] 2019/09/15 19:16:30 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0915 19:16:30.869] 2019/09/15 19:16:30 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0915 19:17:00.868] 2019/09/15 19:17:00 process.go:153: Running: kubectl get nodes -ojson
W0915 19:18:31.165] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0915 19:18:31.165] 2019/09/15 19:18:31 process.go:155: Step 'kubectl get nodes -ojson' finished in 1m30.296747915s
W0915 19:18:31.166] 2019/09/15 19:18:31 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0915 19:18:31.166] 2019/09/15 19:18:31 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0915 19:19:01.165] 2019/09/15 19:19:01 process.go:153: Running: kubectl get nodes -ojson
W0915 19:21:31.282] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0915 19:21:31.285] 2019/09/15 19:21:31 process.go:155: Step 'kubectl get nodes -ojson' finished in 2m30.120202409s
W0915 19:21:31.287] 2019/09/15 19:21:31 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0915 19:21:31.288] 2019/09/15 19:21:31 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0915 19:22:01.289] 2019/09/15 19:22:01 process.go:153: Running: kubectl get nodes -ojson
W0915 19:24:31.494] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0915 19:24:31.501] 2019/09/15 19:24:31 process.go:155: Step 'kubectl get nodes -ojson' finished in 2m30.212072837s
W0915 19:24:31.501] 2019/09/15 19:24:31 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0915 19:24:31.501] 2019/09/15 19:24:31 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0915 19:25:01.501] 2019/09/15 19:25:01 process.go:153: Running: kubectl get nodes -ojson
W0915 19:27:31.607] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0915 19:27:31.608] 2019/09/15 19:27:31 process.go:155: Step 'kubectl get nodes -ojson' finished in 2m30.103436124s
W0915 19:27:31.609] 2019/09/15 19:27:31 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0915 19:27:31.609] 2019/09/15 19:27:31 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0915 19:28:01.606] 2019/09/15 19:28:01 process.go:153: Running: kubectl get nodes -ojson
W0915 19:30:31.767] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0915 19:30:31.772] 2019/09/15 19:30:31 process.go:155: Step 'kubectl get nodes -ojson' finished in 2m30.16598318s
W0915 19:30:31.774] 2019/09/15 19:30:31 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0915 19:30:31.775] 2019/09/15 19:30:31 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0915 19:31:01.775] 2019/09/15 19:31:01 process.go:153: Running: kubectl get nodes -ojson
W0915 19:33:31.985] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0915 19:33:31.988] 2019/09/15 19:33:31 process.go:155: Step 'kubectl get nodes -ojson' finished in 2m30.21412622s
W0915 19:33:31.988] 2019/09/15 19:33:31 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0915 19:33:31.989] 2019/09/15 19:33:31 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0915 19:34:01.989] 2019/09/15 19:34:01 process.go:153: Running: kubectl get nodes -ojson
W0915 19:36:32.116] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0915 19:36:32.120] 2019/09/15 19:36:32 process.go:155: Step 'kubectl get nodes -ojson' finished in 2m30.131091659s
W0915 19:36:32.120] 2019/09/15 19:36:32 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0915 19:36:32.121] 2019/09/15 19:36:32 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0915 19:37:02.124] 2019/09/15 19:37:02 process.go:153: Running: /workspace/kops toolbox dump --name e2e-kops-aws.test-cncf-aws.k8s.io -ojson
W0915 19:37:10.586] 2019/09/15 19:37:10 process.go:155: Step '/workspace/kops toolbox dump --name e2e-kops-aws.test-cncf-aws.k8s.io -ojson' finished in 8.462218589s
W0915 19:37:10.589] 2019/09/15 19:37:10 process.go:153: Running: kubectl get nodes -ojson
W0915 19:39:40.700] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0915 19:39:40.706] 2019/09/15 19:39:40 process.go:155: Step 'kubectl get nodes -ojson' finished in 2m30.117238932s
W0915 19:39:40.707] 2019/09/15 19:39:40 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0915 19:39:40.707] 2019/09/15 19:39:40 dump.go:89: Failed to get nodes for dumping via kubectl: error during kubectl get nodes -ojson: exit status 1
W0915 19:39:40.707] 2019/09/15 19:39:40 dump.go:123: dumping node not registered in kubernetes: 52.197.204.3
W0915 19:39:40.708] 2019/09/15 19:39:40 dump.go:157: Dumping node 52.197.204.3
W0915 19:39:42.034] 2019/09/15 19:39:42 dump.go:358: Running SSH command: sudo journalctl --output=short-precise -k
W0915 19:39:42.832] 2019/09/15 19:39:42 dump.go:358: Running SSH command: sudo journalctl --output=short-precise
W0915 19:39:45.988] 2019/09/15 19:39:45 dump.go:358: Running SSH command: sudo systemctl list-units -t service --no-pager --no-legend --all
W0915 19:39:46.257] 2019/09/15 19:39:46 dump.go:358: Running SSH command: sudo journalctl --output=cat -u kubelet.service
... skipping 168 lines ...
W0915 19:41:25.787]     check_env(env, self.command, *args)
W0915 19:41:25.787]   File "/workspace/./test-infra/jenkins/../scenarios/kubernetes_e2e.py", line 111, in check_env
W0915 19:41:25.787]     subprocess.check_call(cmd, env=env)
W0915 19:41:25.788]   File "/usr/lib/python2.7/subprocess.py", line 186, in check_call
W0915 19:41:25.788]     raise CalledProcessError(retcode, cmd)
W0915 19:41:25.789] 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
E0915 19:41:25.789] Command failed
I0915 19:41:25.790] process 259 exited with code 1 after 26.1m
E0915 19:41:25.790] FAIL: ci-kubernetes-e2e-kops-aws
I0915 19:41:25.791] Call:  gcloud auth activate-service-account --key-file=/etc/service-account/service-account.json
W0915 19:41:27.381] Activated service account credentials for: [pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com]
I0915 19:41:27.487] process 600 exited with code 0 after 0.0m
I0915 19:41:27.488] Call:  gcloud config get-value account
I0915 19:41:28.262] process 612 exited with code 0 after 0.0m
I0915 19:41:28.264] Will upload results to gs://kubernetes-jenkins/logs using pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com
I0915 19:41:28.264] Upload result and artifacts...
I0915 19:41:28.264] Gubernator results at https://gubernator.k8s.io/build/kubernetes-jenkins/logs/ci-kubernetes-e2e-kops-aws/1173314289038004226
I0915 19:41:28.266] Call:  gsutil ls gs://kubernetes-jenkins/logs/ci-kubernetes-e2e-kops-aws/1173314289038004226/artifacts
W0915 19:41:30.932] CommandException: One or more URLs matched no objects.
E0915 19:41:31.234] Command failed
I0915 19:41:31.234] process 624 exited with code 1 after 0.0m
W0915 19:41:31.234] Remote dir gs://kubernetes-jenkins/logs/ci-kubernetes-e2e-kops-aws/1173314289038004226/artifacts not exist yet
I0915 19:41:31.235] 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/1173314289038004226/artifacts
I0915 19:41:42.983] process 766 exited with code 0 after 0.2m
I0915 19:41:42.984] Call:  git rev-parse HEAD
W0915 19:41:42.995] fatal: Not a git repository (or any of the parent directories): .git
E0915 19:41:42.997] Command failed
I0915 19:41:42.999] process 1399 exited with code 128 after 0.0m
I0915 19:41:42.999] Call:  git rev-parse HEAD
I0915 19:41:43.028] process 1400 exited with code 0 after 0.0m
I0915 19:41:43.032] Call:  gsutil stat gs://kubernetes-jenkins/logs/ci-kubernetes-e2e-kops-aws/jobResultsCache.json
I0915 19:41:45.717] process 1401 exited with code 0 after 0.0m
I0915 19:41:45.718] Call:  gsutil -q cat 'gs://kubernetes-jenkins/logs/ci-kubernetes-e2e-kops-aws/jobResultsCache.json#1568574649946194'
... skipping 8 lines ...