This job view page is being replaced by Spyglass soon. Check out the new job view.
PRbart0sh: Pass pod annotations to Allocate
ResultFAILURE
Tests 1 failed / 19 succeeded
Started2019-03-15 21:11
Elapsed44m18s
Revision
Buildergke-prow-containerd-pool-99179761-hr9n
Refs master:df2094b3
61775:5d1012de
podc817026f-4766-11e9-be52-0a580a6c0982
infra-commit5def04463
job-versionv1.15.0-alpha.0.1230+bfc470e4e5ae5b
podc817026f-4766-11e9-be52-0a580a6c0982
repok8s.io/kubernetes
repo-commitbfc470e4e5ae5bac94ba19cf8c33e5f6b7938f34
repos{u'k8s.io/kubernetes': u'master:df2094b3d728bd58c5f23b41add109e32fc7c301,61775:5d1012de6ab6e540578a9bd743b6d571682ea883', u'k8s.io/perf-tests': u'master', u'k8s.io/release': u'master'}
revisionv1.15.0-alpha.0.1230+bfc470e4e5ae5b

Test Failures


ClusterLoaderV2 1m0s

error during /go/src/k8s.io/perf-tests/run-e2e.sh cluster-loader2 --nodes=500 --provider=kubemark --report-dir=/workspace/_artifacts --testconfig=testing/density/config.yaml --testconfig=testing/load/config.yaml --testoverrides=./testing/load/kubemark/500_nodes/override.yaml: exit status 255
				from junit_runner.xml

Filter through log files | View test history on testgrid


Show 19 Passed Tests

Error lines from build-log.txt

... skipping 1174 lines ...
W0315 21:38:28.698] Trying to find master named 'e2e-61775-ac87c-master'
W0315 21:38:28.698] Looking for address 'e2e-61775-ac87c-master-ip'
W0315 21:38:29.596] Using master: e2e-61775-ac87c-master (external IP: 35.237.126.3)
I0315 21:38:29.697] Waiting up to 300 seconds for cluster initialization.
I0315 21:38:29.697] 
I0315 21:38:29.697]   This will continually check to see if the API for kubernetes is reachable.
I0315 21:38:29.698]   This may time out if there was some uncaught error during start up.
I0315 21:38:29.698] 
I0315 21:38:30.659] Kubernetes cluster created.
I0315 21:38:30.822] Cluster "k8s-presubmit-scale_e2e-61775-ac87c" set.
I0315 21:38:30.977] User "k8s-presubmit-scale_e2e-61775-ac87c" set.
I0315 21:38:31.136] Context "k8s-presubmit-scale_e2e-61775-ac87c" created.
I0315 21:38:31.297] Switched to context "k8s-presubmit-scale_e2e-61775-ac87c".
... skipping 22 lines ...
I0315 21:39:16.343] e2e-61775-ac87c-minion-group-86rg   Ready                      <none>   19s   v1.15.0-alpha.0.1230+bfc470e4e5ae5b
I0315 21:39:16.343] e2e-61775-ac87c-minion-group-8q1q   Ready                      <none>   17s   v1.15.0-alpha.0.1230+bfc470e4e5ae5b
I0315 21:39:16.343] e2e-61775-ac87c-minion-group-hdsv   Ready                      <none>   13s   v1.15.0-alpha.0.1230+bfc470e4e5ae5b
I0315 21:39:16.343] e2e-61775-ac87c-minion-group-n81p   Ready                      <none>   2s    v1.15.0-alpha.0.1230+bfc470e4e5ae5b
I0315 21:39:16.344] e2e-61775-ac87c-minion-group-swjs   Ready                      <none>   6s    v1.15.0-alpha.0.1230+bfc470e4e5ae5b
I0315 21:39:16.770] Validate output:
I0315 21:39:17.163] NAME                 STATUS    MESSAGE             ERROR
I0315 21:39:17.164] controller-manager   Healthy   ok                  
I0315 21:39:17.164] etcd-0               Healthy   {"health":"true"}   
I0315 21:39:17.164] scheduler            Healthy   ok                  
I0315 21:39:17.165] etcd-1               Healthy   {"health":"true"}   
I0315 21:39:17.171] Cluster validation succeeded
W0315 21:39:17.272] Done, listing cluster services:
... skipping 60 lines ...
W0315 21:39:49.325] 2019/03/15 21:39:49 process.go:155: Step './hack/e2e-internal/e2e-up.sh' finished in 4m22.557454297s
W0315 21:39:49.326] 2019/03/15 21:39:49 process.go:153: Running: ./cluster/kubectl.sh --match-server-version=false version
W0315 21:39:49.663] 2019/03/15 21:39:49 process.go:155: Step './cluster/kubectl.sh --match-server-version=false version' finished in 345.055109ms
W0315 21:39:49.664] 2019/03/15 21:39:49 process.go:153: Running: ./cluster/kubectl.sh --match-server-version=false get nodes -oyaml
W0315 21:39:50.086] 2019/03/15 21:39:50 process.go:155: Step './cluster/kubectl.sh --match-server-version=false get nodes -oyaml' finished in 422.489837ms
W0315 21:39:50.087] 2019/03/15 21:39:50 process.go:153: Running: ./test/kubemark/stop-kubemark.sh
W0315 21:39:51.746] ERROR: (gcloud.compute.instances.delete) Could not fetch resource:
W0315 21:39:51.747]  - The resource 'projects/k8s-presubmit-scale/zones/us-east1-b/instances/e2e-61775-ac87c-kubemark-master' was not found
W0315 21:39:51.747] 
W0315 21:39:52.812] ERROR: (gcloud.compute.disks.delete) Could not fetch resource:
W0315 21:39:52.812]  - The resource 'projects/k8s-presubmit-scale/zones/us-east1-b/disks/e2e-61775-ac87c-kubemark-master-pd' was not found
W0315 21:39:52.813] 
W0315 21:39:54.902] ERROR: (gcloud.compute.addresses.delete) Could not fetch resource:
W0315 21:39:54.903]  - The resource 'projects/k8s-presubmit-scale/regions/us-east1/addresses/e2e-61775-ac87c-kubemark-master-ip' was not found
W0315 21:39:54.903] 
W0315 21:39:55.695] ERROR: (gcloud.compute.firewall-rules.delete) Could not fetch resource:
W0315 21:39:55.695]  - The resource 'projects/k8s-presubmit-scale/global/firewalls/e2e-61775-ac87c-kubemark-master-https' was not found
W0315 21:39:55.695] 
W0315 21:39:55.787] 2019/03/15 21:39:55 process.go:155: Step './test/kubemark/stop-kubemark.sh' finished in 5.700453092s
W0315 21:39:55.787] 2019/03/15 21:39:55 process.go:153: Running: ./hack/e2e-internal/e2e-status.sh
W0315 21:39:55.852] Project: k8s-presubmit-scale
W0315 21:39:55.853] Network Project: k8s-presubmit-scale
W0315 21:39:55.853] Zone: us-east1-b
I0315 21:39:56.367] Client Version: version.Info{Major:"1", Minor:"15+", GitVersion:"v1.15.0-alpha.0.1230+bfc470e4e5ae5b", GitCommit:"bfc470e4e5ae5bac94ba19cf8c33e5f6b7938f34", GitTreeState:"clean", BuildDate:"2019-03-15T19:40:58Z", GoVersion:"go1.12", Compiler:"gc", Platform:"linux/amd64"}
I0315 21:39:56.367] Server Version: version.Info{Major:"1", Minor:"15+", GitVersion:"v1.15.0-alpha.0.1230+bfc470e4e5ae5b", GitCommit:"bfc470e4e5ae5bac94ba19cf8c33e5f6b7938f34", GitTreeState:"clean", BuildDate:"2019-03-15T19:40:58Z", GoVersion:"go1.12", Compiler:"gc", Platform:"linux/amd64"}
W0315 21:39:56.468] 2019/03/15 21:39:56 process.go:155: Step './hack/e2e-internal/e2e-status.sh' finished in 586.248505ms
W0315 21:39:56.468] 2019/03/15 21:39:56 process.go:153: Running: ./test/kubemark/start-kubemark.sh
W0315 21:39:57.694] ERROR: (gcloud.compute.addresses.describe) Could not fetch resource:
W0315 21:39:57.694]  - The resource 'projects/k8s-presubmit-scale/regions/us-east1/addresses/e2e-61775-ac87c-kubemark-master-ip' was not found
W0315 21:39:57.694] 
I0315 21:40:02.530] Created [https://www.googleapis.com/compute/v1/projects/k8s-presubmit-scale/regions/us-east1/addresses/e2e-61775-ac87c-kubemark-master-ip].
I0315 21:40:02.861] Succeeded to gcloud compute addresses.
I0315 21:40:03.778] Generating certs for alternate-names: IP:35.227.54.143,IP:10.0.0.1,DNS:kubernetes,DNS:kubernetes.default,DNS:kubernetes.default.svc,DNS:kubernetes.default.svc.cluster.local,DNS:e2e-61775-ac87c-kubemark-master
I0315 21:40:07.551] Generated PKI authentication data for kubemark.
... skipping 660 lines ...
W0315 21:45:33.676] I0315 21:45:33.676044   89436 prometheus.go:145] Applying /go/src/k8s.io/perf-tests/clusterloader2/pkg/prometheus/manifests/prometheus-roleSpecificNamespaces.yaml
W0315 21:45:33.804] I0315 21:45:33.803911   89436 prometheus.go:145] Applying /go/src/k8s.io/perf-tests/clusterloader2/pkg/prometheus/manifests/prometheus-service.yaml
W0315 21:45:33.855] I0315 21:45:33.855214   89436 prometheus.go:145] Applying /go/src/k8s.io/perf-tests/clusterloader2/pkg/prometheus/manifests/prometheus-serviceAccount.yaml
W0315 21:45:33.900] I0315 21:45:33.900399   89436 prometheus.go:145] Applying /go/src/k8s.io/perf-tests/clusterloader2/pkg/prometheus/manifests/prometheus-serviceMonitor.yaml
W0315 21:45:33.945] I0315 21:45:33.945422   89436 prometheus.go:172] Exposing kube-apiserver metrics in kubemark cluster
W0315 21:45:34.151] I0315 21:45:34.149791   89436 prometheus.go:145] Applying /go/src/k8s.io/perf-tests/clusterloader2/pkg/prometheus/manifests/kubemark/kube-apiserver-endpoints.yaml
W0315 21:45:34.155] F0315 21:45:34.154852   89436 clusterloader.go:203] Error while setting up prometheus stack: unmarshaling error: yaml: line 14: could not find expected ':'
W0315 21:45:34.155] goroutine 1 [running]:
W0315 21:45:34.155] k8s.io/perf-tests/clusterloader2/vendor/k8s.io/klog.stacks(0xc000022300, 0xc000456000, 0x9c, 0x1b7)
W0315 21:45:34.155] 	/go/src/k8s.io/perf-tests/clusterloader2/vendor/k8s.io/klog/klog.go:830 +0xb1
W0315 21:45:34.156] k8s.io/perf-tests/clusterloader2/vendor/k8s.io/klog.(*loggingT).output(0x25b5be0, 0xc000000003, 0xc0004e09a0, 0x2528909, 0x10, 0xcb, 0x0)
W0315 21:45:34.156] 	/go/src/k8s.io/perf-tests/clusterloader2/vendor/k8s.io/klog/klog.go:781 +0x25e
W0315 21:45:34.156] k8s.io/perf-tests/clusterloader2/vendor/k8s.io/klog.(*loggingT).printf(0x25b5be0, 0x3, 0x16175e4, 0x2b, 0xc000405d50, 0x1, 0x1)
... skipping 34 lines ...
W0315 21:46:09.108] scp: /var/log/kube-apiserver-audit.log*: No such file or directory
W0315 21:46:09.407] scp: /var/log/glbc.log*: No such file or directory
W0315 21:46:09.408] scp: /var/log/cluster-autoscaler.log*: No such file or directory
W0315 21:46:09.482] scp: /var/log/fluentd.log*: No such file or directory
W0315 21:46:09.482] scp: /var/log/kubelet.cov*: No such file or directory
W0315 21:46:09.482] scp: /var/log/startupscript.log*: No such file or directory
W0315 21:46:09.621] ERROR: (gcloud.compute.scp) [/usr/bin/scp] exited with return code [1].
W0315 21:46:09.716] 2019/03/15 21:46:09 process.go:155: Step './test/kubemark/master-log-dump.sh /workspace/_artifacts' finished in 35.535345961s
W0315 21:46:09.717] 2019/03/15 21:46:09 process.go:153: Running: ./test/kubemark/stop-kubemark.sh
I0315 21:46:09.817] Skipping dumping of node logs
W0315 21:46:10.437] scp: /var/log/cluster-autoscaler.log*: No such file or directory
W0315 21:46:10.513] scp: /var/log/fluentd.log*: No such file or directory
W0315 21:46:10.513] scp: /var/log/kubelet.cov*: No such file or directory
W0315 21:46:10.513] scp: /var/log/startupscript.log*: No such file or directory
W0315 21:46:10.519] ERROR: (gcloud.compute.scp) [/usr/bin/scp] exited with return code [1].
I0315 21:46:10.624] Dumping logs from nodes locally to '/workspace/_artifacts'
I0315 21:46:10.624] Detecting nodes in the cluster
I0315 21:46:47.817] Changing logfiles to be world-readable for download
I0315 21:46:47.979] Changing logfiles to be world-readable for download
I0315 21:46:48.453] Changing logfiles to be world-readable for download
I0315 21:46:48.851] Changing logfiles to be world-readable for download
... skipping 41 lines ...
W0315 21:46:55.650] scp: /var/log/kubelet.cov*: No such file or directory
W0315 21:46:55.721] scp: /var/log/fluentd.log*: No such file or directory
W0315 21:46:55.721] scp: /var/log/node-problem-detector.log*: No such file or directory
W0315 21:46:55.721] scp: /var/log/kubelet.cov*: No such file or directory
W0315 21:47:03.842] Deleted [https://www.googleapis.com/compute/v1/projects/k8s-presubmit-scale/zones/us-east1-b/instances/e2e-61775-ac87c-kubemark-master].
W0315 21:47:08.105] scp: /var/log/startupscript.log*: No such file or directory
W0315 21:47:08.109] ERROR: (gcloud.compute.scp) [/usr/bin/scp] exited with return code [1].
W0315 21:47:08.369] Deleted [https://www.googleapis.com/compute/v1/projects/k8s-presubmit-scale/zones/us-east1-b/disks/e2e-61775-ac87c-kubemark-master-pd].
W0315 21:47:08.934] scp: /var/log/startupscript.log*: No such file or directory
W0315 21:47:08.940] ERROR: (gcloud.compute.scp) [/usr/bin/scp] exited with return code [1].
W0315 21:47:09.292] scp: /var/log/startupscript.log*: No such file or directory
W0315 21:47:09.297] ERROR: (gcloud.compute.scp) [/usr/bin/scp] exited with return code [1].
W0315 21:47:12.161] scp: /var/log/startupscript.log*: No such file or directory
W0315 21:47:12.165] ERROR: (gcloud.compute.scp) [/usr/bin/scp] exited with return code [1].
W0315 21:47:12.686] scp: /var/log/startupscript.log*: No such file or directory
W0315 21:47:12.691] ERROR: (gcloud.compute.scp) [/usr/bin/scp] exited with return code [1].
W0315 21:47:13.298] scp: /var/log/startupscript.log*: No such file or directory
W0315 21:47:13.304] ERROR: (gcloud.compute.scp) [/usr/bin/scp] exited with return code [1].
W0315 21:47:13.592] scp: /var/log/startupscript.log*: No such file or directory
W0315 21:47:13.597] ERROR: (gcloud.compute.scp) [/usr/bin/scp] exited with return code [1].
W0315 21:47:17.047] INSTANCE_GROUPS=e2e-61775-ac87c-minion-group
W0315 21:47:17.048] NODE_NAMES=e2e-61775-ac87c-minion-group-41kd e2e-61775-ac87c-minion-group-6b89 e2e-61775-ac87c-minion-group-86rg e2e-61775-ac87c-minion-group-8q1q e2e-61775-ac87c-minion-group-hdsv e2e-61775-ac87c-minion-group-n81p e2e-61775-ac87c-minion-group-swjs
W0315 21:47:17.434] Deleted [https://www.googleapis.com/compute/v1/projects/k8s-presubmit-scale/regions/us-east1/addresses/e2e-61775-ac87c-kubemark-master-ip].
I0315 21:47:18.044] Failures for e2e-61775-ac87c-minion-group
W0315 21:47:19.098] 2019/03/15 21:47:19 process.go:155: Step './cluster/log-dump/log-dump.sh /workspace/_artifacts' finished in 1m44.917113298s
W0315 21:47:19.098] 2019/03/15 21:47:19 process.go:153: Running: ./hack/e2e-internal/e2e-down.sh
... skipping 17 lines ...
I0315 21:47:47.616] Bringing down cluster
W0315 21:47:50.351] Deleting Managed Instance Group...
W0315 21:50:35.875] ...................................Deleted [https://www.googleapis.com/compute/v1/projects/k8s-presubmit-scale/zones/us-east1-b/instanceGroupManagers/e2e-61775-ac87c-minion-group].
W0315 21:50:35.875] done.
W0315 21:50:45.366] Deleted [https://www.googleapis.com/compute/v1/projects/k8s-presubmit-scale/global/instanceTemplates/e2e-61775-ac87c-minion-template].
W0315 21:50:55.583] Deleted [https://www.googleapis.com/compute/v1/projects/k8s-presubmit-scale/global/instanceTemplates/e2e-61775-ac87c-windows-node-template].
I0315 21:51:02.044] {"message":"Internal Server Error"}Removing etcd replica, name: e2e-61775-ac87c-master, port: 2379, result: 0
I0315 21:51:03.670] {"message":"Internal Server Error"}Removing etcd replica, name: e2e-61775-ac87c-master, port: 4002, result: 0
W0315 21:51:10.255] Updated [https://www.googleapis.com/compute/v1/projects/k8s-presubmit-scale/zones/us-east1-b/instances/e2e-61775-ac87c-master].
W0315 21:53:30.165] Deleted [https://www.googleapis.com/compute/v1/projects/k8s-presubmit-scale/zones/us-east1-b/instances/e2e-61775-ac87c-master].
W0315 21:53:50.527] Deleted [https://www.googleapis.com/compute/v1/projects/k8s-presubmit-scale/global/firewalls/e2e-61775-ac87c-master-https].
W0315 21:53:51.890] Deleted [https://www.googleapis.com/compute/v1/projects/k8s-presubmit-scale/global/firewalls/e2e-61775-ac87c-minion-all].
W0315 21:53:56.175] Deleted [https://www.googleapis.com/compute/v1/projects/k8s-presubmit-scale/global/firewalls/e2e-61775-ac87c-master-etcd].
W0315 21:54:05.135] Deleted [https://www.googleapis.com/compute/v1/projects/k8s-presubmit-scale/regions/us-east1/addresses/e2e-61775-ac87c-master-ip].
... skipping 9 lines ...
I0315 21:55:27.084] Property "users.k8s-presubmit-scale_e2e-61775-ac87c-basic-auth" unset.
I0315 21:55:27.238] Property "contexts.k8s-presubmit-scale_e2e-61775-ac87c" unset.
I0315 21:55:27.243] Cleared config for k8s-presubmit-scale_e2e-61775-ac87c from /go/src/k8s.io/kubernetes/kubernetes/test/kubemark/resources/kubeconfig.kubemark
I0315 21:55:27.243] Done
W0315 21:55:27.344] 2019/03/15 21:55:27 process.go:155: Step './hack/e2e-internal/e2e-down.sh' finished in 8m8.147173376s
W0315 21:55:27.344] 2019/03/15 21:55:27 process.go:96: Saved XML output to /workspace/_artifacts/junit_runner.xml.
W0315 21:55:27.344] 2019/03/15 21:55:27 main.go:307: Something went wrong: encountered 1 errors: [error during /go/src/k8s.io/perf-tests/run-e2e.sh cluster-loader2 --nodes=500 --provider=kubemark --report-dir=/workspace/_artifacts --testconfig=testing/density/config.yaml --testconfig=testing/load/config.yaml --testoverrides=./testing/load/kubemark/500_nodes/override.yaml: exit status 255]
W0315 21:55:27.344] Traceback (most recent call last):
W0315 21:55:27.345]   File "/workspace/./test-infra/jenkins/../scenarios/kubernetes_e2e.py", line 764, in <module>
W0315 21:55:27.392]     main(parse_args())
W0315 21:55:27.392]   File "/workspace/./test-infra/jenkins/../scenarios/kubernetes_e2e.py", line 615, in main
W0315 21:55:27.392]     mode.start(runner_args)
W0315 21:55:27.392]   File "/workspace/./test-infra/jenkins/../scenarios/kubernetes_e2e.py", line 262, in start
W0315 21:55:27.393]     check_env(env, self.command, *args)
W0315 21:55:27.393]   File "/workspace/./test-infra/jenkins/../scenarios/kubernetes_e2e.py", line 111, in check_env
W0315 21:55:27.393]     subprocess.check_call(cmd, env=env)
W0315 21:55:27.393]   File "/usr/lib/python2.7/subprocess.py", line 186, in check_call
W0315 21:55:27.393]     raise CalledProcessError(retcode, cmd)
W0315 21:55:27.394] subprocess.CalledProcessError: Command '('kubetest', '--dump=/workspace/_artifacts', '--gcp-service-account=/etc/service-account/service-account.json', '--build=bazel', '--stage=gs://kubernetes-release-pull/ci/pull-kubernetes-kubemark-e2e-gce-big', '--up', '--down', '--provider=gce', '--cluster=e2e-61775-ac87c', '--gcp-network=e2e-61775-ac87c', '--extract=local', '--gcp-master-size=n1-standard-4', '--gcp-node-size=n1-standard-8', '--gcp-nodes=7', '--gcp-project=k8s-presubmit-scale', '--gcp-zone=us-east1-b', '--kubemark', '--kubemark-nodes=500', '--test_args=--ginkgo.focus=xxxx', '--test-cmd=/go/src/k8s.io/perf-tests/run-e2e.sh', '--test-cmd-args=cluster-loader2', '--test-cmd-args=--nodes=500', '--test-cmd-args=--provider=kubemark', '--test-cmd-args=--report-dir=/workspace/_artifacts', '--test-cmd-args=--testconfig=testing/density/config.yaml', '--test-cmd-args=--testconfig=testing/load/config.yaml', '--test-cmd-args=--testoverrides=./testing/load/kubemark/500_nodes/override.yaml', '--test-cmd-name=ClusterLoaderV2', '--timeout=100m')' returned non-zero exit status 1
E0315 21:55:27.408] Command failed
I0315 21:55:27.408] process 720 exited with code 1 after 41.8m
E0315 21:55:27.408] FAIL: pull-kubernetes-kubemark-e2e-gce-big
I0315 21:55:27.409] Call:  gcloud auth activate-service-account --key-file=/etc/service-account/service-account.json
W0315 21:55:27.923] Activated service account credentials for: [pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com]
I0315 21:55:28.006] process 93645 exited with code 0 after 0.0m
I0315 21:55:28.006] Call:  gcloud config get-value account
I0315 21:55:28.341] process 93657 exited with code 0 after 0.0m
I0315 21:55:28.341] Will upload results to gs://kubernetes-jenkins/pr-logs using pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com
I0315 21:55:28.342] Upload result and artifacts...
I0315 21:55:28.342] Gubernator results at https://gubernator.k8s.io/build/kubernetes-jenkins/pr-logs/pull/61775/pull-kubernetes-kubemark-e2e-gce-big/41500
I0315 21:55:28.342] Call:  gsutil ls gs://kubernetes-jenkins/pr-logs/pull/61775/pull-kubernetes-kubemark-e2e-gce-big/41500/artifacts
W0315 21:55:29.521] CommandException: One or more URLs matched no objects.
E0315 21:55:29.687] Command failed
I0315 21:55:29.687] process 93669 exited with code 1 after 0.0m
W0315 21:55:29.687] Remote dir gs://kubernetes-jenkins/pr-logs/pull/61775/pull-kubernetes-kubemark-e2e-gce-big/41500/artifacts not exist yet
I0315 21:55:29.688] Call:  gsutil -m -q -o GSUtil:use_magicfile=True cp -r -c -z log,txt,xml /workspace/_artifacts gs://kubernetes-jenkins/pr-logs/pull/61775/pull-kubernetes-kubemark-e2e-gce-big/41500/artifacts
I0315 21:55:46.355] process 93811 exited with code 0 after 0.3m
I0315 21:55:46.356] Call:  git rev-parse HEAD
I0315 21:55:46.360] process 96013 exited with code 0 after 0.0m
... skipping 21 lines ...