This job view page is being replaced by Spyglass soon. Check out the new job view.
ResultFAILURE
Tests 1 failed / 27 succeeded
Started2022-09-29 11:13
Elapsed1h21m
Revision
Builderb7ae8b77-3fe7-11ed-a508-62ecda79ba9a
infra-commit4693eb3a9
job-versionv1.26.0-alpha.1.179+ef56451ae52407
kubetest-versionv20220928-cd48f52a16
repok8s.io/autoscaler
repo-commitca6ed150671afa0eadb78510ae740d8b93a5b1de
repos{u'k8s.io/autoscaler': u'master'}
revisionv1.26.0-alpha.1.179+ef56451ae52407

Test Failures


kubetest diffResources 0.00s

Error: 2 leaked resources
+ca-master-ip   35.197.120.235  EXTERNAL                    us-west1          IN_USE
+hpa-master-ip  34.127.106.163  EXTERNAL                    us-west1          IN_USE
				from junit_runner.xml

Filter through log files | View test history on testgrid


Show 27 Passed Tests

Show 289 Skipped Tests

Error lines from build-log.txt

... skipping 384 lines ...
W0929 11:18:02.775] NODE_NAMES=bootstrap-e2e-minion-group-70wk bootstrap-e2e-minion-group-gxdp bootstrap-e2e-minion-group-tx1g
W0929 11:18:02.776] Trying to find master named 'bootstrap-e2e-master'
W0929 11:18:02.776] Looking for address 'bootstrap-e2e-master-ip'
I0929 11:18:05.517] Waiting up to 300 seconds for cluster initialization.
I0929 11:18:05.518] 
I0929 11:18:05.518]   This will continually check to see if the API for kubernetes is reachable.
I0929 11:18:05.518]   This may time out if there was some uncaught error during start up.
I0929 11:18:05.518] 
W0929 11:18:05.621] Using master: bootstrap-e2e-master (external IP: 34.127.31.176; internal IP: (not set))
I0929 11:18:44.191] .........Kubernetes cluster created.
I0929 11:18:44.380] Cluster "k8s-jkns-gci-autoscaling-migs_bootstrap-e2e" set.
I0929 11:18:44.561] User "k8s-jkns-gci-autoscaling-migs_bootstrap-e2e" set.
I0929 11:18:44.742] Context "k8s-jkns-gci-autoscaling-migs_bootstrap-e2e" created.
... skipping 26 lines ...
I0929 11:19:39.319] bootstrap-e2e-minion-group-tx1g   Ready                      <none>   24s   v1.26.0-alpha.1.179+ef56451ae52407
W0929 11:19:39.643] Warning: v1 ComponentStatus is deprecated in v1.19+
I0929 11:19:39.744] Validate output:
W0929 11:19:40.009] Warning: v1 ComponentStatus is deprecated in v1.19+
W0929 11:19:40.017] Done, listing cluster services:
W0929 11:19:40.017] 
I0929 11:19:40.118] NAME                 STATUS    MESSAGE                         ERROR
I0929 11:19:40.119] etcd-1               Healthy   {"health":"true","reason":""}   
I0929 11:19:40.119] etcd-0               Healthy   {"health":"true","reason":""}   
I0929 11:19:40.120] controller-manager   Healthy   ok                              
I0929 11:19:40.120] scheduler            Healthy   ok                              
I0929 11:19:40.120] Cluster validation succeeded
I0929 11:19:40.353] Kubernetes control plane is running at https://34.127.31.176
... skipping 66 lines ...
W0929 11:20:08.398] To show all fields in table format, please see the examples in --help.
W0929 11:20:08.398] 
W0929 11:20:10.076] Listed 0 items.
W0929 11:20:11.741] Listed 0 items.
W0929 11:20:13.284] 2022/09/29 11:20:13 process.go:155: Step './cluster/gce/list-resources.sh' finished in 17.651128841s
W0929 11:20:13.285] 2022/09/29 11:20:13 process.go:153: Running: ../vertical-pod-autoscaler/hack/run-e2e.sh recommender
W0929 11:20:13.562] Error from server (NotFound): error when deleting "STDIN": customresourcedefinitions.apiextensions.k8s.io "verticalpodautoscalercheckpoints.autoscaling.k8s.io" not found
W0929 11:20:13.562] Error from server (NotFound): error when deleting "STDIN": customresourcedefinitions.apiextensions.k8s.io "verticalpodautoscalers.autoscaling.k8s.io" not found
W0929 11:20:14.383] Error from server (NotFound): error when deleting "STDIN": clusterroles.rbac.authorization.k8s.io "system:metrics-reader" not found
W0929 11:20:14.383] Error from server (NotFound): error when deleting "STDIN": clusterroles.rbac.authorization.k8s.io "system:vpa-actor" not found
W0929 11:20:14.383] Error from server (NotFound): error when deleting "STDIN": clusterroles.rbac.authorization.k8s.io "system:vpa-checkpoint-actor" not found
W0929 11:20:14.384] Error from server (NotFound): error when deleting "STDIN": clusterroles.rbac.authorization.k8s.io "system:evictioner" not found
W0929 11:20:14.384] Error from server (NotFound): error when deleting "STDIN": clusterrolebindings.rbac.authorization.k8s.io "system:metrics-reader" not found
W0929 11:20:14.384] Error from server (NotFound): error when deleting "STDIN": clusterrolebindings.rbac.authorization.k8s.io "system:vpa-actor" not found
W0929 11:20:14.385] Error from server (NotFound): error when deleting "STDIN": clusterrolebindings.rbac.authorization.k8s.io "system:vpa-checkpoint-actor" not found
W0929 11:20:14.385] Error from server (NotFound): error when deleting "STDIN": clusterroles.rbac.authorization.k8s.io "system:vpa-target-reader" not found
W0929 11:20:14.385] Error from server (NotFound): error when deleting "STDIN": clusterrolebindings.rbac.authorization.k8s.io "system:vpa-target-reader-binding" not found
W0929 11:20:14.385] Error from server (NotFound): error when deleting "STDIN": clusterrolebindings.rbac.authorization.k8s.io "system:vpa-evictionter-binding" not found
W0929 11:20:14.385] Error from server (NotFound): error when deleting "STDIN": serviceaccounts "vpa-admission-controller" not found
W0929 11:20:14.386] Error from server (NotFound): error when deleting "STDIN": clusterroles.rbac.authorization.k8s.io "system:vpa-admission-controller" not found
W0929 11:20:14.386] Error from server (NotFound): error when deleting "STDIN": clusterrolebindings.rbac.authorization.k8s.io "system:vpa-admission-controller" not found
W0929 11:20:14.386] Error from server (NotFound): error when deleting "STDIN": clusterroles.rbac.authorization.k8s.io "system:vpa-status-reader" not found
W0929 11:20:14.386] Error from server (NotFound): error when deleting "STDIN": clusterrolebindings.rbac.authorization.k8s.io "system:vpa-status-reader-binding" not found
W0929 11:20:14.637] Error from server (NotFound): error when deleting "STDIN": serviceaccounts "vpa-updater" not found
W0929 11:20:14.638] Error from server (NotFound): error when deleting "STDIN": deployments.apps "vpa-updater" not found
W0929 11:20:14.884] Error from server (NotFound): error when deleting "STDIN": serviceaccounts "vpa-recommender" not found
W0929 11:20:14.885] Error from server (NotFound): error when deleting "STDIN": deployments.apps "vpa-recommender" not found
I0929 11:20:14.985] Deleting VPA Admission Controller certs.
W0929 11:20:15.095] Error from server (NotFound): secrets "vpa-tls-certs" not found
W0929 11:20:15.176] Warning: deleting cluster-scoped resources, not scoped to the provided namespace
I0929 11:20:15.277] Unregistering VPA admission controller webhook
W0929 11:20:15.378] Error from server (NotFound): mutatingwebhookconfigurations.admissionregistration.k8s.io "vpa-webhook-config" not found
W0929 11:20:15.567] Error from server (NotFound): error when deleting "STDIN": deployments.apps "vpa-admission-controller" not found
W0929 11:20:15.567] Error from server (NotFound): error when deleting "STDIN": services "vpa-webhook" not found
W0929 11:20:15.941] resource mapping not found for name: "verticalpodautoscalers.autoscaling.k8s.io" namespace: "" from "STDIN": no matches for kind "CustomResourceDefinition" in version "apiextensions.k8s.io/v1beta1"
W0929 11:20:15.942] ensure CRDs are installed first
W0929 11:20:15.942] resource mapping not found for name: "verticalpodautoscalercheckpoints.autoscaling.k8s.io" namespace: "" from "STDIN": no matches for kind "CustomResourceDefinition" in version "apiextensions.k8s.io/v1beta1"
W0929 11:20:15.942] ensure CRDs are installed first
I0929 11:20:17.474] Configuring registry authentication
W0929 11:20:18.269] Adding credentials for all GCR repositories.
... skipping 563 lines ...
I0929 11:54:55.769] [ReportAfterSuite] PASSED [0.005 seconds]
I0929 11:54:55.769] [ReportAfterSuite] Kubernetes e2e JUnit report
I0929 11:54:55.770] /go/src/k8s.io/autoscaler/vertical-pod-autoscaler/e2e/vendor/k8s.io/kubernetes/test/e2e/framework/test_context.go:559
I0929 11:54:55.770] ------------------------------
I0929 11:54:55.770] 
I0929 11:54:55.770] Ran 8 of 282 Specs in 1654.816 seconds
I0929 11:54:55.770] SUCCESS! -- 8 Passed | 0 Failed | 0 Pending | 274 Skipped
I0929 11:54:55.771] --- PASS: TestE2E (1654.83s)
I0929 11:54:55.771] PASS
I0929 11:54:55.771] ok  	command-line-arguments	1654.921s
I0929 11:55:09.648] Sep 29 11:55:09.648: INFO: The --provider flag is not set. Continuing as if --provider=skeleton had been used.
I0929 11:55:09.649] === RUN   TestE2E
I0929 11:55:09.665] Running Suite: Kubernetes e2e suite - /go/src/k8s.io/autoscaler/vertical-pod-autoscaler/e2e/v1
... skipping 387 lines ...
I0929 12:23:06.525] [ReportAfterSuite] PASSED [0.003 seconds]
I0929 12:23:06.525] [ReportAfterSuite] Kubernetes e2e JUnit report
I0929 12:23:06.525] /go/src/k8s.io/autoscaler/vertical-pod-autoscaler/e2e/vendor/k8s.io/kubernetes/test/e2e/framework/test_context.go:559
I0929 12:23:06.525] ------------------------------
I0929 12:23:06.525] 
I0929 12:23:06.526] Ran 8 of 297 Specs in 1676.848 seconds
I0929 12:23:06.526] SUCCESS! -- 8 Passed | 0 Failed | 0 Pending | 289 Skipped
I0929 12:23:06.526] --- PASS: TestE2E (1676.87s)
I0929 12:23:06.526] PASS
I0929 12:23:06.527] ok  	command-line-arguments	1677.005s
I0929 12:23:06.632] /go/src/k8s.io/autoscaler/kubernetes
I0929 12:23:06.632] v1beta2 test result: 0
I0929 12:23:06.632] v1 test result: 0
... skipping 20 lines ...
W0929 12:24:09.637] 
W0929 12:24:09.637] Specify --start=71156 in the next get-serial-port-output invocation to get only the new output starting from here.
W0929 12:24:15.917] scp: /var/log/cluster-autoscaler.log*: No such file or directory
W0929 12:24:16.194] scp: /var/log/fluentd.log*: No such file or directory
W0929 12:24:16.194] scp: /var/log/kubelet.cov*: No such file or directory
W0929 12:24:16.195] scp: /var/log/startupscript.log*: No such file or directory
W0929 12:24:16.201] ERROR: (gcloud.compute.scp) [/usr/bin/scp] exited with return code [1].
I0929 12:24:16.505] Dumping logs from nodes locally to '/workspace/_artifacts'
I0929 12:24:16.505] Detecting nodes in the cluster
I0929 12:25:20.668] Changing logfiles to be world-readable for download
I0929 12:25:20.905] Changing logfiles to be world-readable for download
I0929 12:25:21.065] Changing logfiles to be world-readable for download
I0929 12:25:25.413] Copying 'kube-proxy.log containers/konnectivity-agent-*.log fluentd.log node-problem-detector.log kubelet.cov startupscript.log' from bootstrap-e2e-minion-group-gxdp
... skipping 6 lines ...
W0929 12:25:27.562] 
W0929 12:25:27.562] Specify --start=119243 in the next get-serial-port-output invocation to get only the new output starting from here.
W0929 12:25:29.168] scp: /var/log/fluentd.log*: No such file or directory
W0929 12:25:29.169] scp: /var/log/node-problem-detector.log*: No such file or directory
W0929 12:25:29.170] scp: /var/log/kubelet.cov*: No such file or directory
W0929 12:25:29.170] scp: /var/log/startupscript.log*: No such file or directory
W0929 12:25:29.174] ERROR: (gcloud.compute.scp) [/usr/bin/scp] exited with return code [1].
W0929 12:25:29.726] scp: /var/log/fluentd.log*: No such file or directory
W0929 12:25:29.726] scp: /var/log/node-problem-detector.log*: No such file or directory
W0929 12:25:29.726] scp: /var/log/kubelet.cov*: No such file or directory
W0929 12:25:29.726] scp: /var/log/startupscript.log*: No such file or directory
W0929 12:25:29.732] ERROR: (gcloud.compute.scp) [/usr/bin/scp] exited with return code [1].
W0929 12:25:30.105] scp: /var/log/fluentd.log*: No such file or directory
W0929 12:25:30.105] scp: /var/log/node-problem-detector.log*: No such file or directory
W0929 12:25:30.106] scp: /var/log/kubelet.cov*: No such file or directory
W0929 12:25:30.106] scp: /var/log/startupscript.log*: No such file or directory
W0929 12:25:30.110] ERROR: (gcloud.compute.scp) [/usr/bin/scp] exited with return code [1].
W0929 12:25:35.761] INSTANCE_GROUPS=bootstrap-e2e-minion-group
W0929 12:25:35.761] NODE_NAMES=bootstrap-e2e-minion-group-70wk bootstrap-e2e-minion-group-gxdp bootstrap-e2e-minion-group-tx1g
I0929 12:25:37.176] Failures for bootstrap-e2e-minion-group (if any):
W0929 12:25:38.585] 2022/09/29 12:25:38 process.go:155: Step './cluster/log-dump/log-dump.sh /workspace/_artifacts' finished in 2m31.949955695s
W0929 12:25:38.585] 2022/09/29 12:25:38 e2e.go:472: Listing resources...
W0929 12:25:38.586] 2022/09/29 12:25:38 process.go:153: Running: ./cluster/gce/list-resources.sh
... skipping 68 lines ...
W0929 12:34:17.462] Listed 0 items.
W0929 12:34:20.216] Listed 0 items.
W0929 12:34:21.856] 2022/09/29 12:34:21 process.go:155: Step './cluster/gce/list-resources.sh' finished in 25.673263186s
W0929 12:34:21.857] 2022/09/29 12:34:21 process.go:153: Running: diff -sw -U0 -F^\[.*\]$ /workspace/_artifacts/gcp-resources-before.txt /workspace/_artifacts/gcp-resources-after.txt
W0929 12:34:21.860] 2022/09/29 12:34:21 process.go:155: Step 'diff -sw -U0 -F^\[.*\]$ /workspace/_artifacts/gcp-resources-before.txt /workspace/_artifacts/gcp-resources-after.txt' finished in 2.814371ms
W0929 12:34:21.863] 2022/09/29 12:34:21 process.go:96: Saved XML output to /workspace/_artifacts/junit_runner.xml.
W0929 12:34:21.872] 2022/09/29 12:34:21 main.go:331: Something went wrong: encountered 1 errors: [Error: 2 leaked resources
W0929 12:34:21.873] +ca-master-ip   35.197.120.235  EXTERNAL                    us-west1          IN_USE
W0929 12:34:21.873] +hpa-master-ip  34.127.106.163  EXTERNAL                    us-west1          IN_USE]
W0929 12:34:21.882] Traceback (most recent call last):
W0929 12:34:21.882]   File "/workspace/./test-infra/jenkins/../scenarios/kubernetes_e2e.py", line 723, in <module>
W0929 12:34:21.885]     main(parse_args())
W0929 12:34:21.885]   File "/workspace/./test-infra/jenkins/../scenarios/kubernetes_e2e.py", line 569, in main
... skipping 2 lines ...
W0929 12:34:21.885]     check_env(env, self.command, *args)
W0929 12:34:21.886]   File "/workspace/./test-infra/jenkins/../scenarios/kubernetes_e2e.py", line 111, in check_env
W0929 12:34:21.886]     subprocess.check_call(cmd, env=env)
W0929 12:34:21.886]   File "/usr/lib/python2.7/subprocess.py", line 190, in check_call
W0929 12:34:21.886]     raise CalledProcessError(retcode, cmd)
W0929 12:34:21.886] subprocess.CalledProcessError: Command '('kubetest', '--dump=/workspace/_artifacts', '--gcp-service-account=/etc/service-account/service-account.json', '--up', '--down', '--provider=gce', '--cluster=bootstrap-e2e', '--gcp-network=bootstrap-e2e', '--check-leaked-resources', '--extract=ci/latest', '--gcp-node-image=gci', '--gcp-zone=us-west1-b', '--test-cmd=../vertical-pod-autoscaler/hack/run-e2e.sh', '--test-cmd-args=recommender', '--timeout=120m')' returned non-zero exit status 1
E0929 12:34:21.921] Command failed
I0929 12:34:21.921] process 435 exited with code 1 after 80.5m
E0929 12:34:21.922] FAIL: ci-kubernetes-e2e-autoscaling-vpa-recommender
I0929 12:34:21.924] Call:  gcloud auth activate-service-account --key-file=/etc/service-account/service-account.json
W0929 12:34:22.853] Activated service account credentials for: [pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com]
I0929 12:34:23.044] process 39863 exited with code 0 after 0.0m
I0929 12:34:23.045] Call:  gcloud config get-value account
I0929 12:34:24.239] process 39877 exited with code 0 after 0.0m
I0929 12:34:24.240] Will upload results to gs://kubernetes-jenkins/logs using pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com
I0929 12:34:24.240] Upload result and artifacts...
I0929 12:34:24.240] Gubernator results at https://gubernator.k8s.io/build/kubernetes-jenkins/logs/ci-kubernetes-e2e-autoscaling-vpa-recommender/1575443590719475712
I0929 12:34:24.241] Call:  gsutil ls gs://kubernetes-jenkins/logs/ci-kubernetes-e2e-autoscaling-vpa-recommender/1575443590719475712/artifacts
W0929 12:34:27.727] CommandException: One or more URLs matched no objects.
E0929 12:34:28.056] Command failed
I0929 12:34:28.056] process 39891 exited with code 1 after 0.1m
W0929 12:34:28.057] Remote dir gs://kubernetes-jenkins/logs/ci-kubernetes-e2e-autoscaling-vpa-recommender/1575443590719475712/artifacts not exist yet
I0929 12:34:28.057] 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-autoscaling-vpa-recommender/1575443590719475712/artifacts
I0929 12:34:34.616] process 40031 exited with code 0 after 0.1m
I0929 12:34:34.617] Call:  git rev-parse HEAD
I0929 12:34:34.624] process 40682 exited with code 0 after 0.0m
... skipping 13 lines ...