This job view page is being replaced by Spyglass soon. Check out the new job view.
ResultFAILURE
Tests 1 failed / 5 succeeded
Started2019-11-08 15:53
Elapsed23m15s
Revision
Buildergke-prow-ssd-pool-1a225945-jhsp
links{u'resultstore': {u'url': u'https://source.cloud.google.com/results/invocations/7f04cc7d-b1b3-47c5-8e8a-44fce71baa7b/targets/test'}}
pode2b131ed-023f-11ea-952f-2277ac613adf
resultstorehttps://source.cloud.google.com/results/invocations/7f04cc7d-b1b3-47c5-8e8a-44fce71baa7b/targets/test
infra-commita76f902fc
job-versionv1.18.0-alpha.0.517+5cc945ad0d2fad
pode2b131ed-023f-11ea-952f-2277ac613adf
revisionv1.18.0-alpha.0.517+5cc945ad0d2fad

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 15 lines ...
I1108 15:53:55.161] process 45 exited with code 0 after 0.0m
I1108 15:53:55.161] Will upload results to gs://kubernetes-jenkins/logs using pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com
I1108 15:53:55.162] Root: /workspace
I1108 15:53:55.162] cd to /workspace
I1108 15:53:55.162] Configure environment...
I1108 15:53:55.162] Call:  git show -s --format=format:%ct HEAD
W1108 15:53:55.166] fatal: not a git repository (or any of the parent directories): .git
I1108 15:53:55.166] process 57 exited with code 128 after 0.0m
W1108 15:53:55.167] Unable to print commit date for HEAD
I1108 15:53:55.167] Call:  gcloud auth activate-service-account --key-file=/etc/service-account/service-account.json
W1108 15:53:55.669] Activated service account credentials for: [pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com]
I1108 15:53:55.720] process 58 exited with code 0 after 0.0m
I1108 15:53:55.721] Call:  gcloud config get-value account
... skipping 704 lines ...
I1108 15:54:57.856]  * read about installing addons at: https://github.com/kubernetes/kops/blob/master/docs/operations/addons.md.
I1108 15:54:57.856] 
W1108 15:54:57.956] 2019/11/08 15:54:57 process.go:155: Step '/workspace/kops update cluster e2e-kops-aws.test-cncf-aws.k8s.io --yes' finished in 23.132242096s
W1108 15:54:57.957] 2019/11/08 15:54:57 process.go:153: Running: kubectl get nodes -ojson
W1108 15:54:58.080] 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
W1108 15:54:58.083] 2019/11/08 15:54:58 process.go:155: Step 'kubectl get nodes -ojson' finished in 223.929334ms
W1108 15:54:58.084] 2019/11/08 15:54:58 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W1108 15:54:58.084] 2019/11/08 15:54:58 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W1108 15:55:28.084] 2019/11/08 15:55:28 process.go:153: Running: kubectl get nodes -ojson
W1108 15:55:58.248] 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
W1108 15:55:58.250] 2019/11/08 15:55:58 process.go:155: Step 'kubectl get nodes -ojson' finished in 30.1661025s
W1108 15:55:58.250] 2019/11/08 15:55:58 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W1108 15:55:58.250] 2019/11/08 15:55:58 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W1108 15:56:28.250] 2019/11/08 15:56:28 process.go:153: Running: kubectl get nodes -ojson
W1108 15:57:58.986] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W1108 15:57:58.990] 2019/11/08 15:57:58 process.go:155: Step 'kubectl get nodes -ojson' finished in 1m30.739134594s
W1108 15:57:58.990] 2019/11/08 15:57:58 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W1108 15:57:58.992] 2019/11/08 15:57:58 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W1108 15:58:28.990] 2019/11/08 15:58:28 process.go:153: Running: kubectl get nodes -ojson
W1108 15:59:59.125] Unable to connect to the server: dial tcp 203.0.113.123:443: i/o timeout
W1108 15:59:59.128] 2019/11/08 15:59:59 process.go:155: Step 'kubectl get nodes -ojson' finished in 1m30.138027381s
W1108 15:59:59.128] 2019/11/08 15:59:59 kubernetes.go:34: kubectl get nodes failed: error during kubectl get nodes -ojson: exit status 1
W1108 15:59:59.128] 2019/11/08 15:59:59 kubernetes.go:69: kubectl get nodes failed, sleeping: error during kubectl get nodes -ojson: exit status 1
W1108 16:00:29.128] 2019/11/08 16:00:29 process.go:153: Running: kubectl get nodes -ojson
W1108 16:01:31.006] 2019/11/08 16:01:31 process.go:155: Step 'kubectl get nodes -ojson' finished in 1m1.876632479s
W1108 16:01:31.006] 2019/11/08 16:01:31 kubernetes.go:90: 4 (ready nodes) < 5 (requested instances), sleeping
W1108 16:02:01.006] 2019/11/08 16:02:01 process.go:153: Running: kubectl get nodes -ojson
W1108 16:02:02.322] 2019/11/08 16:02:02 process.go:155: Step 'kubectl get nodes -ojson' finished in 1.315725162s
W1108 16:02:02.322] 2019/11/08 16:02:02 kubernetes.go:90: 4 (ready nodes) < 5 (requested instances), sleeping
... skipping 122 lines ...
W1108 16:15:41.836] 2019/11/08 16:15:41 dump.go:358: Running SSH command: sudo find /var/log -print0
W1108 16:15:42.215] 2019/11/08 16:15:42 dump.go:358: Running SSH command: sudo cat /var/log/kube-proxy.log
W1108 16:15:42.779] 2019/11/08 16:15:42 dump.go:358: Running SSH command: sudo cat /var/log/cloud-init-output.log
W1108 16:15:43.156] 2019/11/08 16:15:43 dump.go:358: Running SSH command: sudo cat /var/log/kern.log
W1108 16:15:43.349] 2019/11/08 16:15:43 dump.go:123: dumping node not registered in kubernetes: 18.136.204.188
W1108 16:15:43.349] 2019/11/08 16:15:43 dump.go:157: Dumping node 18.136.204.188
W1108 16:15:43.725] 2019/11/08 16:15:43 dump.go:126: error dumping node 18.136.204.188: could not connect: unable to SSH to "18.136.204.188": ssh: handshake failed: EOF
W1108 16:15:43.725] 2019/11/08 16:15:43 process.go:153: Running: /workspace/kops get clusters e2e-kops-aws.test-cncf-aws.k8s.io
I1108 16:15:44.387] NAME					CLOUD	ZONES
I1108 16:15:44.387] e2e-kops-aws.test-cncf-aws.k8s.io	aws	ap-southeast-1b
W1108 16:15:44.488] 2019/11/08 16:15:44 process.go:155: Step '/workspace/kops get clusters e2e-kops-aws.test-cncf-aws.k8s.io' finished in 668.235199ms
W1108 16:15:44.490] 2019/11/08 16:15:44 process.go:153: Running: /workspace/kops delete cluster e2e-kops-aws.test-cncf-aws.k8s.io --yes
I1108 16:15:53.142] TYPE			NAME												ID
... skipping 122 lines ...
W1108 16:16:59.260]     check_env(env, self.command, *args)
W1108 16:16:59.260]   File "/workspace/./test-infra/jenkins/../scenarios/kubernetes_e2e.py", line 111, in check_env
W1108 16:16:59.261]     subprocess.check_call(cmd, env=env)
W1108 16:16:59.261]   File "/usr/lib/python2.7/subprocess.py", line 190, in check_call
W1108 16:16:59.261]     raise CalledProcessError(retcode, cmd)
W1108 16:16:59.262] 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-1b', '--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
E1108 16:16:59.262] Command failed
I1108 16:16:59.262] process 262 exited with code 1 after 23.0m
E1108 16:16:59.262] FAIL: ci-kubernetes-e2e-kops-aws
I1108 16:16:59.263] Call:  gcloud auth activate-service-account --key-file=/etc/service-account/service-account.json
W1108 16:16:59.913] Activated service account credentials for: [pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com]
I1108 16:16:59.974] process 863 exited with code 0 after 0.0m
I1108 16:16:59.974] Call:  gcloud config get-value account
I1108 16:17:00.379] process 875 exited with code 0 after 0.0m
I1108 16:17:00.389] Will upload results to gs://kubernetes-jenkins/logs using pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com
I1108 16:17:00.391] Upload result and artifacts...
I1108 16:17:00.391] Gubernator results at https://gubernator.k8s.io/build/kubernetes-jenkins/logs/ci-kubernetes-e2e-kops-aws/1192832570685919232
I1108 16:17:00.392] Call:  gsutil ls gs://kubernetes-jenkins/logs/ci-kubernetes-e2e-kops-aws/1192832570685919232/artifacts
W1108 16:17:01.842] CommandException: One or more URLs matched no objects.
E1108 16:17:02.045] Command failed
I1108 16:17:02.045] process 887 exited with code 1 after 0.0m
W1108 16:17:02.047] Remote dir gs://kubernetes-jenkins/logs/ci-kubernetes-e2e-kops-aws/1192832570685919232/artifacts not exist yet
I1108 16:17:02.048] 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/1192832570685919232/artifacts
I1108 16:17:05.165] process 1031 exited with code 0 after 0.1m
I1108 16:17:05.166] Call:  git rev-parse HEAD
W1108 16:17:05.171] fatal: not a git repository (or any of the parent directories): .git
E1108 16:17:05.171] Command failed
I1108 16:17:05.171] process 1659 exited with code 128 after 0.0m
I1108 16:17:05.171] Call:  git rev-parse HEAD
I1108 16:17:05.177] process 1660 exited with code 0 after 0.0m
I1108 16:17:05.177] Call:  gsutil stat gs://kubernetes-jenkins/logs/ci-kubernetes-e2e-kops-aws/jobResultsCache.json
I1108 16:17:06.662] process 1661 exited with code 0 after 0.0m
I1108 16:17:06.664] Call:  gsutil -q cat 'gs://kubernetes-jenkins/logs/ci-kubernetes-e2e-kops-aws/jobResultsCache.json#1573228193390730'
... skipping 8 lines ...