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 23:55
Elapsed28m24s
Revision
Buildergke-prow-ssd-pool-1a225945-2x74
links{u'resultstore': {u'url': u'https://source.cloud.google.com/results/invocations/8a572bb5-2411-4ba3-a6e9-88bb62323fae/targets/test'}}
pod57aebfa5-d426-11e9-9d26-329cee23a2e0
resultstorehttps://source.cloud.google.com/results/invocations/8a572bb5-2411-4ba3-a6e9-88bb62323fae/targets/test
infra-commit1a3702547
job-versionv1.17.0-alpha.0.1215+4ce0a300d7ebd1
pod57aebfa5-d426-11e9-9d26-329cee23a2e0
revisionv1.17.0-alpha.0.1215+4ce0a300d7ebd1

Test Failures


Up 23m3s

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 23:55:18.103] process 45 exited with code 0 after 0.0m
I0910 23:55:18.104] Will upload results to gs://kubernetes-jenkins/logs using pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com
I0910 23:55:18.104] Root: /workspace
I0910 23:55:18.105] cd to /workspace
I0910 23:55:18.105] Configure environment...
I0910 23:55:18.106] Call:  git show -s --format=format:%ct HEAD
W0910 23:55:18.110] fatal: Not a git repository (or any of the parent directories): .git
I0910 23:55:18.110] process 57 exited with code 128 after 0.0m
W0910 23:55:18.111] Unable to print commit date for HEAD
I0910 23:55:18.111] Call:  gcloud auth activate-service-account --key-file=/etc/service-account/service-account.json
W0910 23:55:18.642] Activated service account credentials for: [pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com]
I0910 23:55:18.693] process 58 exited with code 0 after 0.0m
I0910 23:55:18.694] Call:  gcloud config get-value account
... skipping 701 lines ...
I0910 23:56:20.977]  * read about installing addons at: https://github.com/kubernetes/kops/blob/master/docs/addons.md.
I0910 23:56:20.977] 
W0910 23:56:21.077] 2019/09/10 23:56:20 process.go:155: Step '/workspace/kops update cluster e2e-kops-aws.test-cncf-aws.k8s.io --yes' finished in 23.22076532s
W0910 23:56:21.078] 2019/09/10 23:56:20 process.go:153: Running: kubectl get nodes -ojson
W0910 23:56:21.203] 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 23:56:21.207] 2019/09/10 23:56:21 process.go:155: Step 'kubectl get nodes -ojson' finished in 224.404719ms
W0910 23:56:21.207] 2019/09/10 23:56:21 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0910 23:56:21.207] 2019/09/10 23:56:21 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0910 23:56:51.207] 2019/09/10 23:56:51 process.go:153: Running: kubectl get nodes -ojson
W0910 23:57:21.370] 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 23:57:21.371] 2019/09/10 23:57:21 process.go:155: Step 'kubectl get nodes -ojson' finished in 30.164255451s
W0910 23:57:21.371] 2019/09/10 23:57:21 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0910 23:57:21.372] 2019/09/10 23:57:21 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0910 23:57:51.372] 2019/09/10 23:57:51 process.go:153: Running: kubectl get nodes -ojson
W0910 23:58:21.576] 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 23:58:21.581] 2019/09/10 23:58:21 process.go:155: Step 'kubectl get nodes -ojson' finished in 30.209126793s
W0910 23:58:21.582] 2019/09/10 23:58:21 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0910 23:58:21.583] 2019/09/10 23:58:21 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0910 23:58:51.581] 2019/09/10 23:58:51 process.go:153: Running: kubectl get nodes -ojson
W0911 00:00:21.754] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0911 00:00:21.766] 2019/09/11 00:00:21 process.go:155: Step 'kubectl get nodes -ojson' finished in 1m30.185076664s
W0911 00:00:21.767] 2019/09/11 00:00:21 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0911 00:00:21.767] 2019/09/11 00:00:21 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0911 00:00:51.767] 2019/09/11 00:00:51 process.go:153: Running: kubectl get nodes -ojson
W0911 00:03:21.944] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0911 00:03:21.946] 2019/09/11 00:03:21 process.go:155: Step 'kubectl get nodes -ojson' finished in 2m30.179837187s
W0911 00:03:21.947] 2019/09/11 00:03:21 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0911 00:03:21.947] 2019/09/11 00:03:21 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0911 00:03:51.947] 2019/09/11 00:03:51 process.go:153: Running: kubectl get nodes -ojson
W0911 00:06:22.075] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0911 00:06:22.078] 2019/09/11 00:06:22 process.go:155: Step 'kubectl get nodes -ojson' finished in 2m30.13089697s
W0911 00:06:22.078] 2019/09/11 00:06:22 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0911 00:06:22.079] 2019/09/11 00:06:22 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0911 00:06:52.078] 2019/09/11 00:06:52 process.go:153: Running: kubectl get nodes -ojson
W0911 00:09:22.301] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0911 00:09:22.302] 2019/09/11 00:09:22 process.go:155: Step 'kubectl get nodes -ojson' finished in 2m30.223419287s
W0911 00:09:22.302] 2019/09/11 00:09:22 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0911 00:09:22.302] 2019/09/11 00:09:22 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0911 00:09:52.303] 2019/09/11 00:09:52 process.go:153: Running: kubectl get nodes -ojson
W0911 00:12:22.504] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0911 00:12:22.504] 2019/09/11 00:12:22 process.go:155: Step 'kubectl get nodes -ojson' finished in 2m30.201296639s
W0911 00:12:22.505] 2019/09/11 00:12:22 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0911 00:12:22.505] 2019/09/11 00:12:22 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0911 00:12:52.505] 2019/09/11 00:12:52 process.go:153: Running: kubectl get nodes -ojson
W0911 00:15:22.608] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0911 00:15:22.610] 2019/09/11 00:15:22 process.go:155: Step 'kubectl get nodes -ojson' finished in 2m30.105508021s
W0911 00:15:22.611] 2019/09/11 00:15:22 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0911 00:15:22.611] 2019/09/11 00:15:22 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0911 00:15:52.610] 2019/09/11 00:15:52 process.go:153: Running: kubectl get nodes -ojson
W0911 00:18:22.701] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0911 00:18:22.704] 2019/09/11 00:18:22 process.go:155: Step 'kubectl get nodes -ojson' finished in 2m30.093250728s
W0911 00:18:22.704] 2019/09/11 00:18:22 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0911 00:18:22.705] 2019/09/11 00:18:22 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W0911 00:18:52.707] 2019/09/11 00:18:52 process.go:153: Running: /workspace/kops toolbox dump --name e2e-kops-aws.test-cncf-aws.k8s.io -ojson
W0911 00:19:03.536] 2019/09/11 00:19:03 process.go:155: Step '/workspace/kops toolbox dump --name e2e-kops-aws.test-cncf-aws.k8s.io -ojson' finished in 10.828521655s
W0911 00:19:03.539] 2019/09/11 00:19:03 process.go:153: Running: kubectl get nodes -ojson
W0911 00:21:33.621] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W0911 00:21:33.624] 2019/09/11 00:21:33 process.go:155: Step 'kubectl get nodes -ojson' finished in 2m30.085136294s
W0911 00:21:33.625] 2019/09/11 00:21:33 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W0911 00:21:33.625] 2019/09/11 00:21:33 dump.go:89: Failed to get nodes for dumping via kubectl: error during kubectl get nodes -ojson: exit status 1
W0911 00:21:33.625] 2019/09/11 00:21:33 dump.go:123: dumping node not registered in kubernetes: 13.229.143.29
W0911 00:21:33.626] 2019/09/11 00:21:33 dump.go:157: Dumping node 13.229.143.29
W0911 00:21:35.563] 2019/09/11 00:21:35 dump.go:358: Running SSH command: sudo journalctl --output=short-precise -k
W0911 00:21:36.601] 2019/09/11 00:21:36 dump.go:358: Running SSH command: sudo journalctl --output=short-precise
W0911 00:21:41.307] 2019/09/11 00:21:41 dump.go:358: Running SSH command: sudo systemctl list-units -t service --no-pager --no-legend --all
W0911 00:21:41.692] 2019/09/11 00:21:41 dump.go:358: Running SSH command: sudo journalctl --output=cat -u kubelet.service
... skipping 85 lines ...
I0911 00:22:48.222] subnet			ap-southeast-1c.e2e-kops-aws.test-cncf-aws.k8s.io						subnet-0daab4b5d521fb5bc
I0911 00:22:48.222] volume			c.etcd-events.e2e-kops-aws.test-cncf-aws.k8s.io							vol-01caecd8f40fbe5b1
I0911 00:22:48.222] volume			c.etcd-main.e2e-kops-aws.test-cncf-aws.k8s.io							vol-0581a606dd390f11c
I0911 00:22:48.223] vpc			e2e-kops-aws.test-cncf-aws.k8s.io								vpc-069c8e3c1d771d48c
I0911 00:22:48.223] 
I0911 00:22:48.288] route53-record:ZEMLNXIIWQ0RV/api.internal.e2e-kops-aws.test-cncf-aws.k8s.io.	ok
I0911 00:22:48.490] iam-role:masters.e2e-kops-aws.test-cncf-aws.k8s.io	error deleting resources, will retry: error deleting IAM role "masters.e2e-kops-aws.test-cncf-aws.k8s.io": DeleteConflict: Cannot delete entity, must remove roles from instance profile first.
I0911 00:22:48.491] 	status code: 409, request id: 48ab46d2-d42a-11e9-802b-b9c99487764f
I0911 00:22:48.542] autoscaling-group:nodes.e2e-kops-aws.test-cncf-aws.k8s.io	ok
I0911 00:22:48.558] iam-role:nodes.e2e-kops-aws.test-cncf-aws.k8s.io	ok
I0911 00:22:48.610] iam-instance-profile:nodes.e2e-kops-aws.test-cncf-aws.k8s.io	ok
I0911 00:22:48.692] keypair:kubernetes.e2e-kops-aws.test-cncf-aws.k8s.io-a4:44:93:63:d1:46:cf:75:92:ff:3a:37:96:28:f8:c9	ok
I0911 00:22:48.878] autoscaling-group:master-ap-southeast-1c.masters.e2e-kops-aws.test-cncf-aws.k8s.io	ok
... skipping 65 lines ...
W0911 00:23:31.190]     check_env(env, self.command, *args)
W0911 00:23:31.190]   File "/workspace/./test-infra/jenkins/../scenarios/kubernetes_e2e.py", line 111, in check_env
W0911 00:23:31.191]     subprocess.check_call(cmd, env=env)
W0911 00:23:31.191]   File "/usr/lib/python2.7/subprocess.py", line 186, in check_call
W0911 00:23:31.191]     raise CalledProcessError(retcode, cmd)
W0911 00:23:31.192] 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-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
E0911 00:23:31.192] Command failed
I0911 00:23:31.192] process 260 exited with code 1 after 28.2m
E0911 00:23:31.192] FAIL: ci-kubernetes-e2e-kops-aws
I0911 00:23:31.193] Call:  gcloud auth activate-service-account --key-file=/etc/service-account/service-account.json
W0911 00:23:31.824] Activated service account credentials for: [pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com]
I0911 00:23:31.883] process 615 exited with code 0 after 0.0m
I0911 00:23:31.883] Call:  gcloud config get-value account
I0911 00:23:32.226] process 627 exited with code 0 after 0.0m
I0911 00:23:32.227] Will upload results to gs://kubernetes-jenkins/logs using pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com
I0911 00:23:32.227] Upload result and artifacts...
I0911 00:23:32.228] Gubernator results at https://gubernator.k8s.io/build/kubernetes-jenkins/logs/ci-kubernetes-e2e-kops-aws/1171572838566465540
I0911 00:23:32.228] Call:  gsutil ls gs://kubernetes-jenkins/logs/ci-kubernetes-e2e-kops-aws/1171572838566465540/artifacts
W0911 00:23:33.414] CommandException: One or more URLs matched no objects.
E0911 00:23:33.544] Command failed
I0911 00:23:33.545] process 639 exited with code 1 after 0.0m
W0911 00:23:33.545] Remote dir gs://kubernetes-jenkins/logs/ci-kubernetes-e2e-kops-aws/1171572838566465540/artifacts not exist yet
I0911 00:23:33.545] 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/1171572838566465540/artifacts
I0911 00:23:37.810] process 781 exited with code 0 after 0.1m
I0911 00:23:37.812] Call:  git rev-parse HEAD
W0911 00:23:37.816] fatal: Not a git repository (or any of the parent directories): .git
E0911 00:23:37.817] Command failed
I0911 00:23:37.817] process 1420 exited with code 128 after 0.0m
I0911 00:23:37.817] Call:  git rev-parse HEAD
I0911 00:23:37.830] process 1421 exited with code 0 after 0.0m
I0911 00:23:37.831] Call:  gsutil stat gs://kubernetes-jenkins/logs/ci-kubernetes-e2e-kops-aws/jobResultsCache.json
I0911 00:23:39.066] process 1422 exited with code 0 after 0.0m
I0911 00:23:39.067] Call:  gsutil -q cat 'gs://kubernetes-jenkins/logs/ci-kubernetes-e2e-kops-aws/jobResultsCache.json#1568159550442117'
... skipping 8 lines ...