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 09:43
Elapsed25m51s
Revision
Buildergke-prow-ssd-pool-1a225945-n4mt
links{u'resultstore': {u'url': u'https://source.cloud.google.com/results/invocations/b28a5110-8273-4766-8980-0ed3941821db/targets/test'}}
pod57d90fad-d866-11e9-9f18-22ab134e4c57
resultstorehttps://source.cloud.google.com/results/invocations/b28a5110-8273-4766-8980-0ed3941821db/targets/test
infra-commite1cbc3ccd
job-versionv1.17.0-alpha.0.1442+ebd8f9ccb5c7a7
pod57d90fad-d866-11e9-9f18-22ab134e4c57
revisionv1.17.0-alpha.0.1442+ebd8f9ccb5c7a7

Test Failures


Up 20m35s

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 09:43:13.344] process 45 exited with code 0 after 0.0m
I0916 09:43:13.345] Will upload results to gs://kubernetes-jenkins/logs using pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com
I0916 09:43:13.345] Root: /workspace
I0916 09:43:13.345] cd to /workspace
I0916 09:43:13.345] Configure environment...
I0916 09:43:13.346] Call:  git show -s --format=format:%ct HEAD
W0916 09:43:13.350] fatal: Not a git repository (or any of the parent directories): .git
I0916 09:43:13.350] process 57 exited with code 128 after 0.0m
W0916 09:43:13.351] Unable to print commit date for HEAD
I0916 09:43:13.352] Call:  gcloud auth activate-service-account --key-file=/etc/service-account/service-account.json
W0916 09:43:13.925] Activated service account credentials for: [pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com]
I0916 09:43:13.992] process 58 exited with code 0 after 0.0m
I0916 09:43:13.992] Call:  gcloud config get-value account
... skipping 701 lines ...
I0916 09:44:19.779]  * read about installing addons at: https://github.com/kubernetes/kops/blob/master/docs/addons.md.
I0916 09:44:19.779] 
W0916 09:44:19.880] 2019/09/16 09:44:19 process.go:155: Step '/workspace/kops update cluster e2e-kops-aws.test-cncf-aws.k8s.io --yes' finished in 24.454960367s
W0916 09:44:19.880] 2019/09/16 09:44:19 process.go:153: Running: kubectl get nodes -ojson
W0916 09:44:20.023] 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 09:44:20.028] 2019/09/16 09:44:20 process.go:155: Step 'kubectl get nodes -ojson' finished in 242.093486ms
W0916 09:44:20.028] 2019/09/16 09:44:20 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0916 09:44:20.028] 2019/09/16 09:44:20 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0916 09:44:50.028] 2019/09/16 09:44:50 process.go:153: Running: kubectl get nodes -ojson
W0916 09:45:50.305] 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 09:45:50.308] 2019/09/16 09:45:50 process.go:155: Step 'kubectl get nodes -ojson' finished in 1m0.280021236s
W0916 09:45:50.309] 2019/09/16 09:45:50 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0916 09:45:50.309] 2019/09/16 09:45:50 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0916 09:46:20.309] 2019/09/16 09:46:20 process.go:153: Running: kubectl get nodes -ojson
W0916 09:46:20.533] 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 09:46:20.539] 2019/09/16 09:46:20 process.go:155: Step 'kubectl get nodes -ojson' finished in 228.994491ms
W0916 09:46:20.539] 2019/09/16 09:46:20 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0916 09:46:20.539] 2019/09/16 09:46:20 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0916 09:46:50.539] 2019/09/16 09:46:50 process.go:153: Running: kubectl get nodes -ojson
W0916 09:46:50.705] 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 09:46:50.709] 2019/09/16 09:46:50 process.go:155: Step 'kubectl get nodes -ojson' finished in 171.045547ms
W0916 09:46:50.710] 2019/09/16 09:46:50 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0916 09:46:50.710] 2019/09/16 09:46:50 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0916 09:47:20.710] 2019/09/16 09:47:20 process.go:153: Running: kubectl get nodes -ojson
W0916 09:47:20.883] 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 09:47:20.887] 2019/09/16 09:47:20 process.go:155: Step 'kubectl get nodes -ojson' finished in 176.812784ms
W0916 09:47:20.887] 2019/09/16 09:47:20 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0916 09:47:20.888] 2019/09/16 09:47:20 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0916 09:47:50.888] 2019/09/16 09:47:50 process.go:153: Running: kubectl get nodes -ojson
W0916 09:48:51.066] 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 09:48:51.067] 2019/09/16 09:48:51 process.go:155: Step 'kubectl get nodes -ojson' finished in 1m0.180145234s
W0916 09:48:51.068] 2019/09/16 09:48:51 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0916 09:48:51.068] 2019/09/16 09:48:51 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0916 09:49:21.068] 2019/09/16 09:49:21 process.go:153: Running: kubectl get nodes -ojson
W0916 09:51:51.154] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0916 09:51:51.155] 2019/09/16 09:51:51 process.go:155: Step 'kubectl get nodes -ojson' finished in 2m30.086974395s
W0916 09:51:51.155] 2019/09/16 09:51:51 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0916 09:51:51.155] 2019/09/16 09:51:51 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0916 09:52:21.155] 2019/09/16 09:52:21 process.go:153: Running: kubectl get nodes -ojson
W0916 09:54:51.243] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0916 09:54:51.244] 2019/09/16 09:54:51 process.go:155: Step 'kubectl get nodes -ojson' finished in 2m30.089186984s
W0916 09:54:51.245] 2019/09/16 09:54:51 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0916 09:54:51.245] 2019/09/16 09:54:51 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0916 09:55:21.245] 2019/09/16 09:55:21 process.go:153: Running: kubectl get nodes -ojson
W0916 09:57:51.343] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0916 09:57:51.347] 2019/09/16 09:57:51 process.go:155: Step 'kubectl get nodes -ojson' finished in 2m30.102490956s
W0916 09:57:51.348] 2019/09/16 09:57:51 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0916 09:57:51.348] 2019/09/16 09:57:51 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0916 09:58:21.348] 2019/09/16 09:58:21 process.go:153: Running: kubectl get nodes -ojson
W0916 10:00:51.436] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0916 10:00:51.439] 2019/09/16 10:00:51 process.go:155: Step 'kubectl get nodes -ojson' finished in 2m30.090992s
W0916 10:00:51.439] 2019/09/16 10:00:51 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0916 10:00:51.439] 2019/09/16 10:00:51 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0916 10:01:21.439] 2019/09/16 10:01:21 process.go:153: Running: kubectl get nodes -ojson
W0916 10:03:51.533] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0916 10:03:51.537] 2019/09/16 10:03:51 process.go:155: Step 'kubectl get nodes -ojson' finished in 2m30.097739045s
W0916 10:03:51.538] 2019/09/16 10:03:51 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0916 10:03:51.538] 2019/09/16 10:03:51 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0916 10:04:21.538] 2019/09/16 10:04:21 process.go:153: Running: /workspace/kops toolbox dump --name e2e-kops-aws.test-cncf-aws.k8s.io -ojson
W0916 10:04:32.514] 2019/09/16 10:04:32 process.go:155: Step '/workspace/kops toolbox dump --name e2e-kops-aws.test-cncf-aws.k8s.io -ojson' finished in 10.976200905s
W0916 10:04:32.515] 2019/09/16 10:04:32 process.go:153: Running: kubectl get nodes -ojson
W0916 10:07:02.628] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0916 10:07:02.631] 2019/09/16 10:07:02 process.go:155: Step 'kubectl get nodes -ojson' finished in 2m30.115992269s
W0916 10:07:02.631] 2019/09/16 10:07:02 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0916 10:07:02.632] 2019/09/16 10:07:02 dump.go:89: Failed to get nodes for dumping via kubectl: error during kubectl get nodes -ojson: exit status 1
W0916 10:07:02.632] 2019/09/16 10:07:02 dump.go:123: dumping node not registered in kubernetes: 54.79.111.163
W0916 10:07:02.632] 2019/09/16 10:07:02 dump.go:157: Dumping node 54.79.111.163
W0916 10:07:04.714] 2019/09/16 10:07:04 dump.go:358: Running SSH command: sudo journalctl --output=short-precise -k
W0916 10:07:05.563] 2019/09/16 10:07:05 dump.go:358: Running SSH command: sudo journalctl --output=short-precise
W0916 10:07:10.230] 2019/09/16 10:07:10 dump.go:358: Running SSH command: sudo systemctl list-units -t service --no-pager --no-legend --all
W0916 10:07:10.644] 2019/09/16 10:07:10 dump.go:358: Running SSH command: sudo journalctl --output=cat -u kubelet.service
... skipping 150 lines ...
W0916 10:08:52.199]     check_env(env, self.command, *args)
W0916 10:08:52.199]   File "/workspace/./test-infra/jenkins/../scenarios/kubernetes_e2e.py", line 111, in check_env
W0916 10:08:52.199]     subprocess.check_call(cmd, env=env)
W0916 10:08:52.199]   File "/usr/lib/python2.7/subprocess.py", line 186, in check_call
W0916 10:08:52.200]     raise CalledProcessError(retcode, cmd)
W0916 10:08:52.200] 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-southeast-2b', '--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 10:08:52.201] Command failed
I0916 10:08:52.201] process 260 exited with code 1 after 25.6m
E0916 10:08:52.201] FAIL: ci-kubernetes-e2e-kops-aws
I0916 10:08:52.201] Call:  gcloud auth activate-service-account --key-file=/etc/service-account/service-account.json
W0916 10:08:52.747] Activated service account credentials for: [pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com]
I0916 10:08:52.803] process 624 exited with code 0 after 0.0m
I0916 10:08:52.803] Call:  gcloud config get-value account
I0916 10:08:53.143] process 636 exited with code 0 after 0.0m
I0916 10:08:53.143] Will upload results to gs://kubernetes-jenkins/logs using pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com
I0916 10:08:53.143] Upload result and artifacts...
I0916 10:08:53.144] Gubernator results at https://gubernator.k8s.io/build/kubernetes-jenkins/logs/ci-kubernetes-e2e-kops-aws/1173532726758739969
I0916 10:08:53.144] Call:  gsutil ls gs://kubernetes-jenkins/logs/ci-kubernetes-e2e-kops-aws/1173532726758739969/artifacts
W0916 10:08:54.314] CommandException: One or more URLs matched no objects.
E0916 10:08:54.446] Command failed
I0916 10:08:54.447] process 648 exited with code 1 after 0.0m
W0916 10:08:54.447] Remote dir gs://kubernetes-jenkins/logs/ci-kubernetes-e2e-kops-aws/1173532726758739969/artifacts not exist yet
I0916 10:08:54.447] 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/1173532726758739969/artifacts
I0916 10:08:59.144] process 790 exited with code 0 after 0.1m
I0916 10:08:59.145] Call:  git rev-parse HEAD
W0916 10:08:59.149] fatal: Not a git repository (or any of the parent directories): .git
E0916 10:08:59.150] Command failed
I0916 10:08:59.150] process 1429 exited with code 128 after 0.0m
I0916 10:08:59.150] Call:  git rev-parse HEAD
I0916 10:08:59.155] process 1430 exited with code 0 after 0.0m
I0916 10:08:59.156] Call:  gsutil stat gs://kubernetes-jenkins/logs/ci-kubernetes-e2e-kops-aws/jobResultsCache.json
I0916 10:09:00.551] process 1431 exited with code 0 after 0.0m
I0916 10:09:00.552] Call:  gsutil -q cat 'gs://kubernetes-jenkins/logs/ci-kubernetes-e2e-kops-aws/jobResultsCache.json#1568626690818613'
... skipping 8 lines ...