This job view page is being replaced by Spyglass soon. Check out the new job view.
ResultFAILURE
Tests 1 failed / 5 succeeded
Started2019-09-18 08:22
Elapsed26m38s
Revision
Buildergke-prow-ssd-pool-1a225945-nk4t
links{u'resultstore': {u'url': u'https://source.cloud.google.com/results/invocations/2449f2af-aa47-4327-9cf1-fa239e2a38bf/targets/test'}}
pod558a22ba-d9ed-11e9-9368-d2ad95f0993d
resultstorehttps://source.cloud.google.com/results/invocations/2449f2af-aa47-4327-9cf1-fa239e2a38bf/targets/test
infra-commit6dc9fbe41
job-versionv1.17.0-alpha.0.1519+57d87502ba6408
pod558a22ba-d9ed-11e9-9368-d2ad95f0993d
revisionv1.17.0-alpha.0.1519+57d87502ba6408

Test Failures


Up 21m7s

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 ...
I0918 08:22:32.525] process 44 exited with code 0 after 0.0m
I0918 08:22:32.526] Will upload results to gs://kubernetes-jenkins/logs using pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com
I0918 08:22:32.526] Root: /workspace
I0918 08:22:32.527] cd to /workspace
I0918 08:22:32.527] Configure environment...
I0918 08:22:32.527] Call:  git show -s --format=format:%ct HEAD
W0918 08:22:32.536] fatal: Not a git repository (or any of the parent directories): .git
I0918 08:22:32.536] process 56 exited with code 128 after 0.0m
W0918 08:22:32.537] Unable to print commit date for HEAD
I0918 08:22:32.537] Call:  gcloud auth activate-service-account --key-file=/etc/service-account/service-account.json
W0918 08:22:33.346] Activated service account credentials for: [pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com]
I0918 08:22:33.419] process 57 exited with code 0 after 0.0m
I0918 08:22:33.420] Call:  gcloud config get-value account
... skipping 701 lines ...
I0918 08:23:50.718]  * read about installing addons at: https://github.com/kubernetes/kops/blob/master/docs/addons.md.
I0918 08:23:50.718] 
W0918 08:23:50.819] 2019/09/18 08:23:50 process.go:155: Step '/workspace/kops update cluster e2e-kops-aws.test-cncf-aws.k8s.io --yes' finished in 25.0450318s
W0918 08:23:50.819] 2019/09/18 08:23:50 process.go:153: Running: kubectl get nodes -ojson
W0918 08:23:51.001] 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
W0918 08:23:51.005] 2019/09/18 08:23:51 process.go:155: Step 'kubectl get nodes -ojson' finished in 280.028128ms
W0918 08:23:51.006] 2019/09/18 08:23:51 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0918 08:23:51.006] 2019/09/18 08:23:51 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0918 08:24:21.006] 2019/09/18 08:24:21 process.go:153: Running: kubectl get nodes -ojson
W0918 08:24:51.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
W0918 08:24:51.309] 2019/09/18 08:24:51 process.go:155: Step 'kubectl get nodes -ojson' finished in 30.303414065s
W0918 08:24:51.310] 2019/09/18 08:24:51 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0918 08:24:51.310] 2019/09/18 08:24:51 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0918 08:25:21.309] 2019/09/18 08:25:21 process.go:153: Running: kubectl get nodes -ojson
W0918 08:26:21.474] 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
W0918 08:26:21.477] 2019/09/18 08:26:21 process.go:155: Step 'kubectl get nodes -ojson' finished in 1m0.167892458s
W0918 08:26:21.478] 2019/09/18 08:26:21 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0918 08:26:21.478] 2019/09/18 08:26:21 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0918 08:26:51.478] 2019/09/18 08:26:51 process.go:153: Running: kubectl get nodes -ojson
W0918 08:27:21.655] 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
W0918 08:27:21.657] 2019/09/18 08:27:21 process.go:155: Step 'kubectl get nodes -ojson' finished in 30.179252613s
W0918 08:27:21.657] 2019/09/18 08:27:21 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0918 08:27:21.658] 2019/09/18 08:27:21 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0918 08:27:51.657] 2019/09/18 08:27:51 process.go:153: Running: kubectl get nodes -ojson
W0918 08:28:51.813] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0918 08:28:51.817] 2019/09/18 08:28:51 process.go:155: Step 'kubectl get nodes -ojson' finished in 1m0.160036876s
W0918 08:28:51.818] 2019/09/18 08:28:51 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0918 08:28:51.818] 2019/09/18 08:28:51 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0918 08:29:21.818] 2019/09/18 08:29:21 process.go:153: Running: kubectl get nodes -ojson
W0918 08:31:51.914] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0918 08:31:51.917] 2019/09/18 08:31:51 process.go:155: Step 'kubectl get nodes -ojson' finished in 2m30.099680373s
W0918 08:31:51.917] 2019/09/18 08:31:51 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0918 08:31:51.918] 2019/09/18 08:31:51 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0918 08:32:21.919] 2019/09/18 08:32:21 process.go:153: Running: kubectl get nodes -ojson
W0918 08:34:52.043] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0918 08:34:52.046] 2019/09/18 08:34:52 process.go:155: Step 'kubectl get nodes -ojson' finished in 2m30.127601778s
W0918 08:34:52.046] 2019/09/18 08:34:52 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0918 08:34:52.046] 2019/09/18 08:34:52 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0918 08:35:22.047] 2019/09/18 08:35:22 process.go:153: Running: kubectl get nodes -ojson
W0918 08:37:52.130] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0918 08:37:52.130] 2019/09/18 08:37:52 process.go:155: Step 'kubectl get nodes -ojson' finished in 2m30.083631645s
W0918 08:37:52.130] 2019/09/18 08:37:52 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0918 08:37:52.130] 2019/09/18 08:37:52 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0918 08:38:22.130] 2019/09/18 08:38:22 process.go:153: Running: kubectl get nodes -ojson
W0918 08:40:52.221] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0918 08:40:52.223] 2019/09/18 08:40:52 process.go:155: Step 'kubectl get nodes -ojson' finished in 2m30.092569647s
W0918 08:40:52.223] 2019/09/18 08:40:52 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0918 08:40:52.223] 2019/09/18 08:40:52 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0918 08:41:22.223] 2019/09/18 08:41:22 process.go:153: Running: kubectl get nodes -ojson
W0918 08:43:52.318] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0918 08:43:52.320] 2019/09/18 08:43:52 process.go:155: Step 'kubectl get nodes -ojson' finished in 2m30.096872376s
W0918 08:43:52.320] 2019/09/18 08:43:52 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0918 08:43:52.321] 2019/09/18 08:43:52 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0918 08:44:22.321] 2019/09/18 08:44:22 process.go:153: Running: /workspace/kops toolbox dump --name e2e-kops-aws.test-cncf-aws.k8s.io -ojson
W0918 08:44:33.385] 2019/09/18 08:44:33 process.go:155: Step '/workspace/kops toolbox dump --name e2e-kops-aws.test-cncf-aws.k8s.io -ojson' finished in 11.064110166s
W0918 08:44:33.386] 2019/09/18 08:44:33 process.go:153: Running: kubectl get nodes -ojson
W0918 08:47:03.473] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0918 08:47:03.476] 2019/09/18 08:47:03 process.go:155: Step 'kubectl get nodes -ojson' finished in 2m30.090333412s
W0918 08:47:03.476] 2019/09/18 08:47:03 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0918 08:47:03.477] 2019/09/18 08:47:03 dump.go:89: Failed to get nodes for dumping via kubectl: error during kubectl get nodes -ojson: exit status 1
W0918 08:47:03.477] 2019/09/18 08:47:03 dump.go:123: dumping node not registered in kubernetes: 52.64.196.39
W0918 08:47:03.477] 2019/09/18 08:47:03 dump.go:157: Dumping node 52.64.196.39
W0918 08:47:05.506] 2019/09/18 08:47:05 dump.go:358: Running SSH command: sudo journalctl --output=short-precise -k
W0918 08:47:06.346] 2019/09/18 08:47:06 dump.go:358: Running SSH command: sudo journalctl --output=short-precise
W0918 08:47:11.855] 2019/09/18 08:47:11 dump.go:358: Running SSH command: sudo systemctl list-units -t service --no-pager --no-legend --all
W0918 08:47:12.261] 2019/09/18 08:47:12 dump.go:358: Running SSH command: sudo journalctl --output=cat -u kubelet.service
... skipping 150 lines ...
W0918 08:48:56.663]     check_env(env, self.command, *args)
W0918 08:48:56.663]   File "/workspace/./test-infra/jenkins/../scenarios/kubernetes_e2e.py", line 111, in check_env
W0918 08:48:56.664]     subprocess.check_call(cmd, env=env)
W0918 08:48:56.664]   File "/usr/lib/python2.7/subprocess.py", line 186, in check_call
W0918 08:48:56.664]     raise CalledProcessError(retcode, cmd)
W0918 08:48:56.664] 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-2a', '--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
E0918 08:48:56.665] Command failed
I0918 08:48:56.665] process 259 exited with code 1 after 26.3m
E0918 08:48:56.665] FAIL: ci-kubernetes-e2e-kops-aws
I0918 08:48:56.665] Call:  gcloud auth activate-service-account --key-file=/etc/service-account/service-account.json
W0918 08:48:58.712] Activated service account credentials for: [pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com]
I0918 08:48:58.760] process 625 exited with code 0 after 0.0m
I0918 08:48:58.760] Call:  gcloud config get-value account
I0918 08:48:59.090] process 637 exited with code 0 after 0.0m
I0918 08:48:59.090] Will upload results to gs://kubernetes-jenkins/logs using pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com
I0918 08:48:59.090] Upload result and artifacts...
I0918 08:48:59.091] Gubernator results at https://gubernator.k8s.io/build/kubernetes-jenkins/logs/ci-kubernetes-e2e-kops-aws/1174237166985809924
I0918 08:48:59.091] Call:  gsutil ls gs://kubernetes-jenkins/logs/ci-kubernetes-e2e-kops-aws/1174237166985809924/artifacts
W0918 08:49:00.257] CommandException: One or more URLs matched no objects.
E0918 08:49:00.386] Command failed
I0918 08:49:00.386] process 649 exited with code 1 after 0.0m
W0918 08:49:00.386] Remote dir gs://kubernetes-jenkins/logs/ci-kubernetes-e2e-kops-aws/1174237166985809924/artifacts not exist yet
I0918 08:49:00.387] 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/1174237166985809924/artifacts
I0918 08:49:04.679] process 791 exited with code 0 after 0.1m
I0918 08:49:04.680] Call:  git rev-parse HEAD
W0918 08:49:04.684] fatal: Not a git repository (or any of the parent directories): .git
E0918 08:49:04.684] Command failed
I0918 08:49:04.684] process 1430 exited with code 128 after 0.0m
I0918 08:49:04.685] Call:  git rev-parse HEAD
I0918 08:49:04.688] process 1431 exited with code 0 after 0.0m
I0918 08:49:04.689] Call:  gsutil stat gs://kubernetes-jenkins/logs/ci-kubernetes-e2e-kops-aws/jobResultsCache.json
I0918 08:49:05.828] process 1432 exited with code 0 after 0.0m
I0918 08:49:05.829] Call:  gsutil -q cat 'gs://kubernetes-jenkins/logs/ci-kubernetes-e2e-kops-aws/jobResultsCache.json#1568794601953400'
... skipping 8 lines ...