This job view page is being replaced by Spyglass soon. Check out the new job view.
ResultFAILURE
Tests 1 failed / 6 succeeded
Started2020-10-24 01:29
Elapsed15m49s
Revision
Builder5924c15e-1598-11eb-b256-6ee25ea2e440
infra-commitd88010efd
job-versionv1.19.4-rc.0.22+9e8ad8ce9d8a30
revisionv1.19.4-rc.0.22+9e8ad8ce9d8a30

Test Failures


Up 7m2s

error during ./hack/e2e-internal/e2e-up.sh: exit status 2
				from junit_runner.xml

Filter through log files | View test history on testgrid


Show 6 Passed Tests

Error lines from build-log.txt

... skipping 15 lines ...
I1024 01:29:39.913] process 47 exited with code 0 after 0.0m
I1024 01:29:39.913] Will upload results to gs://kubernetes-jenkins/logs using pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com
I1024 01:29:39.913] Root: /workspace
I1024 01:29:39.914] cd to /workspace
I1024 01:29:39.914] Configure environment...
I1024 01:29:39.914] Call:  git show -s --format=format:%ct HEAD
W1024 01:29:39.918] fatal: not a git repository (or any of the parent directories): .git
I1024 01:29:39.918] process 60 exited with code 128 after 0.0m
W1024 01:29:39.919] Unable to print commit date for HEAD
I1024 01:29:39.919] Call:  gcloud auth activate-service-account --key-file=/etc/service-account/service-account.json
W1024 01:29:40.576] Activated service account credentials for: [pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com]
I1024 01:29:40.803] process 61 exited with code 0 after 0.0m
I1024 01:29:40.803] Call:  gcloud config get-value account
... skipping 373 lines ...
W1024 01:33:22.092] Trying to find master named 'bootstrap-e2e-master'
W1024 01:33:22.092] Looking for address 'bootstrap-e2e-master-ip'
W1024 01:33:23.040] Using master: bootstrap-e2e-master (external IP: 35.185.208.92; internal IP: (not set))
I1024 01:33:23.141] Waiting up to 300 seconds for cluster initialization.
I1024 01:33:23.141] 
I1024 01:33:23.142]   This will continually check to see if the API for kubernetes is reachable.
I1024 01:33:23.142]   This may time out if there was some uncaught error during start up.
I1024 01:33:23.142] 
I1024 01:38:24.261] ................................................................................................Checking for custom logdump instances, if any
I1024 01:38:24.266] Sourcing kube-util.sh
I1024 01:38:24.326] Detecting project
I1024 01:38:24.327] Project: k8s-jkns-gci-gke-reboot-1-4
I1024 01:38:24.327] Network Project: k8s-jkns-gci-gke-reboot-1-4
I1024 01:38:24.327] Zone: us-west1-b
I1024 01:38:24.327] Dumping logs from master locally to '/workspace/_artifacts'
W1024 01:38:24.428] Cluster failed to initialize within 300 seconds.
W1024 01:38:24.428] Last output from querying API server follows:
W1024 01:38:24.428] -----------------------------------------------------
W1024 01:38:24.428] * Expire in 0 ms for 6 (transfer 0x55d57ca70f50)
W1024 01:38:24.429] * Expire in 5000 ms for 8 (transfer 0x55d57ca70f50)
W1024 01:38:24.429] *   Trying 35.185.208.92...
W1024 01:38:24.429] * TCP_NODELAY set
W1024 01:38:24.429] * Expire in 200 ms for 4 (transfer 0x55d57ca70f50)
W1024 01:38:24.429] * connect to 35.185.208.92 port 443 failed: Connection refused
W1024 01:38:24.429] * Failed to connect to 35.185.208.92 port 443: Connection refused
W1024 01:38:24.430] * Closing connection 0
W1024 01:38:24.430] curl: (7) Failed to connect to 35.185.208.92 port 443: Connection refused
W1024 01:38:24.430] -----------------------------------------------------
W1024 01:38:24.430] 2020/10/24 01:38:24 process.go:155: Step './hack/e2e-internal/e2e-up.sh' finished in 7m2.496307508s
W1024 01:38:24.430] 2020/10/24 01:38:24 e2e.go:544: Dumping logs locally to: /workspace/_artifacts
W1024 01:38:24.430] 2020/10/24 01:38:24 process.go:153: Running: ./cluster/log-dump/log-dump.sh /workspace/_artifacts
W1024 01:38:24.431] Trying to find master named 'bootstrap-e2e-master'
W1024 01:38:24.431] Looking for address 'bootstrap-e2e-master-ip'
... skipping 6 lines ...
W1024 01:39:08.131] scp: /var/log/cluster-autoscaler.log*: No such file or directory
W1024 01:39:08.131] scp: /var/log/kube-addon-manager.log*: No such file or directory
W1024 01:39:08.131] scp: /var/log/konnectivity-server.log*: No such file or directory
W1024 01:39:08.131] scp: /var/log/fluentd.log*: No such file or directory
W1024 01:39:08.131] scp: /var/log/kubelet.cov*: No such file or directory
W1024 01:39:08.131] scp: /var/log/startupscript.log*: No such file or directory
W1024 01:39:08.135] ERROR: (gcloud.compute.scp) [/usr/bin/scp] exited with return code [1].
I1024 01:39:08.341] Dumping logs from nodes locally to '/workspace/_artifacts'
I1024 01:39:08.342] Detecting nodes in the cluster
I1024 01:39:55.781] Changing logfiles to be world-readable for download
I1024 01:39:55.814] Changing logfiles to be world-readable for download
I1024 01:39:56.085] Changing logfiles to be world-readable for download
I1024 01:39:59.530] Copying 'kube-proxy.log fluentd.log node-problem-detector.log kubelet.cov  startupscript.log' from bootstrap-e2e-minion-group-d3vn
... skipping 6 lines ...
W1024 01:40:01.127] 
W1024 01:40:01.128] Specify --start=44082 in the next get-serial-port-output invocation to get only the new output starting from here.
W1024 01:40:02.702] scp: /var/log/fluentd.log*: No such file or directory
W1024 01:40:02.702] scp: /var/log/node-problem-detector.log*: No such file or directory
W1024 01:40:02.703] scp: /var/log/kubelet.cov*: No such file or directory
W1024 01:40:02.703] scp: /var/log/startupscript.log*: No such file or directory
W1024 01:40:02.706] ERROR: (gcloud.compute.scp) [/usr/bin/scp] exited with return code [1].
W1024 01:40:02.758] scp: /var/log/fluentd.log*: No such file or directory
W1024 01:40:02.758] scp: /var/log/node-problem-detector.log*: No such file or directory
W1024 01:40:02.759] scp: /var/log/kubelet.cov*: No such file or directory
W1024 01:40:02.759] scp: /var/log/startupscript.log*: No such file or directory
W1024 01:40:02.763] ERROR: (gcloud.compute.scp) [/usr/bin/scp] exited with return code [1].
W1024 01:40:03.136] scp: /var/log/fluentd.log*: No such file or directory
W1024 01:40:03.136] scp: /var/log/node-problem-detector.log*: No such file or directory
W1024 01:40:03.137] scp: /var/log/kubelet.cov*: No such file or directory
W1024 01:40:03.137] scp: /var/log/startupscript.log*: No such file or directory
W1024 01:40:03.140] ERROR: (gcloud.compute.scp) [/usr/bin/scp] exited with return code [1].
W1024 01:40:06.992] INSTANCE_GROUPS=bootstrap-e2e-minion-group
W1024 01:40:06.992] NODE_NAMES=bootstrap-e2e-minion-group-4lgl bootstrap-e2e-minion-group-bg7t bootstrap-e2e-minion-group-d3vn
I1024 01:40:08.163] Failures for bootstrap-e2e-minion-group (if any):
W1024 01:40:10.382] 2020/10/24 01:40:10 process.go:155: Step './cluster/log-dump/log-dump.sh /workspace/_artifacts' finished in 1m46.124939262s
W1024 01:40:10.383] 2020/10/24 01:40:10 process.go:153: Running: ./hack/e2e-internal/e2e-down.sh
W1024 01:40:10.443] Project: k8s-jkns-gci-gke-reboot-1-4
... skipping 12 lines ...
I1024 01:40:16.998] Bringing down cluster
W1024 01:40:54.670] Deleting Managed Instance Group...
W1024 01:40:54.671] ..Deleted [https://www.googleapis.com/compute/v1/projects/k8s-jkns-gci-gke-reboot-1-4/zones/us-west1-b/instanceGroupManagers/bootstrap-e2e-minion-group].
W1024 01:40:54.674] done.
W1024 01:40:59.254] Deleted [https://www.googleapis.com/compute/v1/projects/k8s-jkns-gci-gke-reboot-1-4/global/instanceTemplates/bootstrap-e2e-minion-template].
W1024 01:40:59.815] Deleted [https://www.googleapis.com/compute/v1/projects/k8s-jkns-gci-gke-reboot-1-4/global/instanceTemplates/bootstrap-e2e-windows-node-template].
W1024 01:42:03.135] Failed to execute 'curl -s --cacert /etc/srv/kubernetes/pki/etcd-apiserver-ca.crt --cert /etc/srv/kubernetes/pki/etcd-apiserver-client.crt --key /etc/srv/kubernetes/pki/etcd-apiserver-client.key https://127.0.0.1:2379/v2/members/$(curl -s --cacert /etc/srv/kubernetes/pki/etcd-apiserver-ca.crt --cert /etc/srv/kubernetes/pki/etcd-apiserver-client.crt --key /etc/srv/kubernetes/pki/etcd-apiserver-client.key https://127.0.0.1:2379/v2/members -XGET | sed 's/{\"id/\n/g' | grep bootstrap-e2e-master\" | cut -f 3 -d \") -XDELETE -L 2>/dev/null' on bootstrap-e2e-master despite 5 attempts
W1024 01:42:03.135] Last attempt failed with: 
I1024 01:42:03.236] Removing etcd replica, name: bootstrap-e2e-master, port: 2379, result: 1
I1024 01:42:05.024] Successfully executed 'curl -s  http://127.0.0.1:4002/v2/members/$(curl -s  http://127.0.0.1:4002/v2/members -XGET | sed 's/{\"id/\n/g' | grep bootstrap-e2e-master\" | cut -f 3 -d \") -XDELETE -L 2>/dev/null' on bootstrap-e2e-master
I1024 01:42:05.024] Removing etcd replica, name: bootstrap-e2e-master, port: 4002, result: 0
W1024 01:42:09.352] Updated [https://www.googleapis.com/compute/v1/projects/k8s-jkns-gci-gke-reboot-1-4/zones/us-west1-b/instances/bootstrap-e2e-master].
W1024 01:43:54.199] Deleted [https://www.googleapis.com/compute/v1/projects/k8s-jkns-gci-gke-reboot-1-4/zones/us-west1-b/instances/bootstrap-e2e-master].
W1024 01:44:03.620] Deleted [https://www.googleapis.com/compute/v1/projects/k8s-jkns-gci-gke-reboot-1-4/global/firewalls/bootstrap-e2e-master-https].
... skipping 19 lines ...
I1024 01:45:15.539] Cleared config for k8s-jkns-gci-gke-reboot-1-4_bootstrap-e2e from /workspace/.kube/config
I1024 01:45:15.539] Done
W1024 01:45:15.582] W1024 01:45:15.536048    9008 loader.go:223] Config not found: /workspace/.kube/config
W1024 01:45:15.582] W1024 01:45:15.536271    9008 loader.go:223] Config not found: /workspace/.kube/config
W1024 01:45:15.582] 2020/10/24 01:45:15 process.go:155: Step './hack/e2e-internal/e2e-down.sh' finished in 5m5.159284735s
W1024 01:45:15.582] 2020/10/24 01:45:15 process.go:96: Saved XML output to /workspace/_artifacts/junit_runner.xml.
W1024 01:45:15.583] 2020/10/24 01:45:15 main.go:316: Something went wrong: starting e2e cluster: error during ./hack/e2e-internal/e2e-up.sh: exit status 2
W1024 01:45:15.583] Traceback (most recent call last):
W1024 01:45:15.583]   File "/workspace/./test-infra/jenkins/../scenarios/kubernetes_e2e.py", line 720, in <module>
W1024 01:45:15.583]     main(parse_args())
W1024 01:45:15.583]   File "/workspace/./test-infra/jenkins/../scenarios/kubernetes_e2e.py", line 570, in main
W1024 01:45:15.584]     mode.start(runner_args)
W1024 01:45:15.584]   File "/workspace/./test-infra/jenkins/../scenarios/kubernetes_e2e.py", line 228, in start
W1024 01:45:15.584]     check_env(env, self.command, *args)
W1024 01:45:15.584]   File "/workspace/./test-infra/jenkins/../scenarios/kubernetes_e2e.py", line 111, in check_env
W1024 01:45:15.584]     subprocess.check_call(cmd, env=env)
W1024 01:45:15.584]   File "/usr/lib/python2.7/subprocess.py", line 190, in check_call
W1024 01:45:15.585]     raise CalledProcessError(retcode, cmd)
W1024 01:45:15.585] subprocess.CalledProcessError: Command '('kubetest', '--dump=/workspace/_artifacts', '--gcp-service-account=/etc/service-account/service-account.json', '--up', '--down', '--test', '--provider=gce', '--cluster=bootstrap-e2e', '--gcp-network=bootstrap-e2e', '--check-leaked-resources', '--check-version-skew=false', '--extract=ci/k8s-stable1', '--extract=ci/k8s-beta', '--gcp-node-image=gci', '--gcp-zone=us-west1-b', '--ginkgo-parallel', '--skew', '--test_args=--ginkgo.skip=\\[Slow\\]|\\[Serial\\]|\\[Disruptive\\]|\\[Flaky\\]|\\[Feature:.+\\] --kubectl-path=../../../../kubernetes_skew/cluster/kubectl.sh --minStartupPods=8', '--timeout=120m', '--upgrade_args=--ginkgo.focus=\\[Feature:ClusterDowngrade\\] --upgrade-target=ci/k8s-stable1 --upgrade-image=gci')' returned non-zero exit status 1
E1024 01:45:15.586] Command failed
I1024 01:45:15.586] process 266 exited with code 1 after 15.5m
E1024 01:45:15.586] FAIL: ci-kubernetes-e2e-gce-beta-stable1-downgrade-cluster-parallel
I1024 01:45:15.588] Call:  gcloud auth activate-service-account --key-file=/etc/service-account/service-account.json
W1024 01:45:16.446] Activated service account credentials for: [pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com]
I1024 01:45:16.583] process 9018 exited with code 0 after 0.0m
I1024 01:45:16.584] Call:  gcloud config get-value account
I1024 01:45:17.356] process 9031 exited with code 0 after 0.0m
I1024 01:45:17.357] Will upload results to gs://kubernetes-jenkins/logs using pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com
I1024 01:45:17.357] Upload result and artifacts...
I1024 01:45:17.357] Gubernator results at https://gubernator.k8s.io/build/kubernetes-jenkins/logs/ci-kubernetes-e2e-gce-beta-stable1-downgrade-cluster-parallel/1319813206272643072
I1024 01:45:17.357] Call:  gsutil ls gs://kubernetes-jenkins/logs/ci-kubernetes-e2e-gce-beta-stable1-downgrade-cluster-parallel/1319813206272643072/artifacts
W1024 01:45:18.657] CommandException: One or more URLs matched no objects.
E1024 01:45:18.903] Command failed
I1024 01:45:18.904] process 9044 exited with code 1 after 0.0m
W1024 01:45:18.904] Remote dir gs://kubernetes-jenkins/logs/ci-kubernetes-e2e-gce-beta-stable1-downgrade-cluster-parallel/1319813206272643072/artifacts not exist yet
I1024 01:45:18.905] 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-gce-beta-stable1-downgrade-cluster-parallel/1319813206272643072/artifacts
I1024 01:45:22.285] process 9187 exited with code 0 after 0.1m
I1024 01:45:22.286] Call:  git rev-parse HEAD
W1024 01:45:22.290] fatal: not a git repository (or any of the parent directories): .git
E1024 01:45:22.290] Command failed
I1024 01:45:22.290] process 9832 exited with code 128 after 0.0m
I1024 01:45:22.291] Call:  git rev-parse HEAD
I1024 01:45:22.295] process 9833 exited with code 0 after 0.0m
I1024 01:45:22.296] Call:  gsutil stat gs://kubernetes-jenkins/logs/ci-kubernetes-e2e-gce-beta-stable1-downgrade-cluster-parallel/jobResultsCache.json
I1024 01:45:23.730] process 9834 exited with code 0 after 0.0m
I1024 01:45:23.732] Call:  gsutil -q cat 'gs://kubernetes-jenkins/logs/ci-kubernetes-e2e-gce-beta-stable1-downgrade-cluster-parallel/jobResultsCache.json#1603496647208339'
... skipping 8 lines ...