This job view page is being replaced by Spyglass soon. Check out the new job view.
PRMikeSpreitzer: Introduce event clocks based on k8s.io/utils/clock
ResultABORTED
Tests 0 failed / 32 succeeded
Started2021-07-22 03:00
Elapsed50m5s
Revision82451ee71fc0b1b8df3fbbd3d2818eb78da33b8c
Refs 103830

No Test Failures!


Show 32 Passed Tests

Error lines from build-log.txt

... skipping 681 lines ...
Looking for address 'e2e-103830-95a39-master-ip'
Looking for address 'e2e-103830-95a39-master-internal-ip'
Using master: e2e-103830-95a39-master (external IP: 34.73.106.197; internal IP: 10.40.0.2)
Waiting up to 300 seconds for cluster initialization.

  This will continually check to see if the API for kubernetes is reachable.
  This may time out if there was some uncaught error during start up.

Kubernetes cluster created.
Cluster "k8s-infra-e2e-boskos-scale-08_e2e-103830-95a39" set.
User "k8s-infra-e2e-boskos-scale-08_e2e-103830-95a39" set.
Context "k8s-infra-e2e-boskos-scale-08_e2e-103830-95a39" created.
Switched to context "k8s-infra-e2e-boskos-scale-08_e2e-103830-95a39".
... skipping 227 lines ...
e2e-103830-95a39-minion-group-z2t7   Ready                         <none>   50s    v1.23.0-alpha.0.10+1c29d2153e6fe4
e2e-103830-95a39-minion-group-z6d7   Ready                         <none>   48s    v1.23.0-alpha.0.10+1c29d2153e6fe4
e2e-103830-95a39-minion-group-zpd7   Ready                         <none>   47s    v1.23.0-alpha.0.10+1c29d2153e6fe4
Warning: v1 ComponentStatus is deprecated in v1.19+
Validate output:
Warning: v1 ComponentStatus is deprecated in v1.19+
NAME                 STATUS    MESSAGE                         ERROR
scheduler            Healthy   ok                              
etcd-1               Healthy   {"health":"true","reason":""}   
etcd-0               Healthy   {"health":"true","reason":""}   
controller-manager   Healthy   ok                              
Cluster validation encountered some problems, but cluster should be in working order
...ignoring non-fatal errors in validate-cluster
Done, listing cluster services:

Kubernetes control plane is running at https://34.73.106.197
GLBCDefaultBackend is running at https://34.73.106.197/api/v1/namespaces/kube-system/services/default-http-backend:http/proxy
CoreDNS is running at https://34.73.106.197/api/v1/namespaces/kube-system/services/kube-dns:dns/proxy
Metrics-server is running at https://34.73.106.197/api/v1/namespaces/kube-system/services/https:metrics-server:/proxy
... skipping 375 lines ...
I0722 03:29:12.839570  105723 reflector.go:175] Starting reflector *v1.Pod (0s) from *v1.PodStore: namespace(test-fx58jg-1), labelSelector(name=big-deployment-0)
I0722 03:29:13.276330  105723 reflector.go:175] Starting reflector *v1.Pod (0s) from *v1.PodStore: namespace(test-fx58jg-1), labelSelector(name=small-deployment-125)
I0722 03:29:13.480579  105723 reflector.go:175] Starting reflector *v1.Pod (0s) from *v1.PodStore: namespace(test-fx58jg-1), labelSelector(name=medium-job-0)
I0722 03:29:14.352440  105723 reflector.go:175] Starting reflector *v1.Pod (0s) from *v1.PodStore: namespace(test-fx58jg-1), labelSelector(name=small-deployment-293)
I0722 03:29:14.863632  105723 reflector.go:175] Starting reflector *v1.Pod (0s) from *v1.PodStore: namespace(test-fx58jg-1), labelSelector(name=small-deployment-196)
I0722 03:29:15.366827  105723 reflector.go:175] Starting reflector *v1.Pod (0s) from *v1.PodStore: namespace(test-fx58jg-1), labelSelector(name=small-deployment-132)
E0722 03:29:15.524070  105723 etcd_metrics.go:147] EtcdMetrics: failed to collect etcd database size
I0722 03:29:16.190910  105723 reflector.go:175] Starting reflector *v1.Pod (0s) from *v1.PodStore: namespace(test-fx58jg-1), labelSelector(name=small-deployment-198)
I0722 03:29:16.506263  105723 wait_for_pods.go:94] WaitForControlledPodsRunning: namespace(test-fx58jg-1), labelSelector(name=small-deployment-272): Pods: 5 out of 5 created, 5 running (5 updated), 0 pending scheduled, 0 not scheduled, 0 inactive, 0 terminating, 0 unknown, 0 runningButNotReady 
I0722 03:29:16.506381  105723 reflector.go:181] Stopping reflector *v1.Pod (0s) from *v1.PodStore: namespace(test-fx58jg-1), labelSelector(name=small-deployment-272)
I0722 03:29:16.868080  105723 wait_for_pods.go:94] WaitForControlledPodsRunning: namespace(test-fx58jg-1), labelSelector(name=small-deployment-62): Pods: 5 out of 5 created, 5 running (5 updated), 0 pending scheduled, 0 not scheduled, 0 inactive, 0 terminating, 0 unknown, 0 runningButNotReady 
I0722 03:29:16.868218  105723 reflector.go:181] Stopping reflector *v1.Pod (0s) from *v1.PodStore: namespace(test-fx58jg-1), labelSelector(name=small-deployment-62)
I0722 03:29:16.916048  105723 wait_for_pods.go:94] WaitForControlledPodsRunning: namespace(test-fx58jg-1), labelSelector(name=small-deployment-140): Pods: 5 out of 5 created, 5 running (5 updated), 0 pending scheduled, 0 not scheduled, 0 inactive, 0 terminating, 0 unknown, 0 runningButNotReady 
... skipping 387 lines ...
I0722 03:30:14.890969  105723 reflector.go:181] Stopping reflector *v1.Pod (0s) from *v1.PodStore: namespace(test-fx58jg-1), labelSelector(name=small-deployment-108)
I0722 03:30:15.508755  105723 reflector.go:175] Starting reflector *v1.Pod (0s) from *v1.PodStore: namespace(test-fx58jg-1), labelSelector(name=small-deployment-42)
I0722 03:30:15.701638  105723 wait_for_pods.go:94] WaitForControlledPodsRunning: namespace(test-fx58jg-1), labelSelector(name=small-deployment-74): Pods: 5 out of 5 created, 5 running (5 updated), 0 pending scheduled, 0 not scheduled, 0 inactive, 0 terminating, 0 unknown, 0 runningButNotReady 
I0722 03:30:15.701853  105723 reflector.go:181] Stopping reflector *v1.Pod (0s) from *v1.PodStore: namespace(test-fx58jg-1), labelSelector(name=small-deployment-74)
I0722 03:30:16.005891  105723 wait_for_pods.go:94] WaitForControlledPodsRunning: namespace(test-fx58jg-1), labelSelector(name=small-deployment-78): Pods: 5 out of 5 created, 5 running (5 updated), 0 pending scheduled, 0 not scheduled, 0 inactive, 0 terminating, 0 unknown, 0 runningButNotReady 
I0722 03:30:16.006013  105723 reflector.go:181] Stopping reflector *v1.Pod (0s) from *v1.PodStore: namespace(test-fx58jg-1), labelSelector(name=small-deployment-78)
E0722 03:30:16.076317  105723 etcd_metrics.go:147] EtcdMetrics: failed to collect etcd database size
I0722 03:30:16.555718  105723 reflector.go:175] Starting reflector *v1.Pod (0s) from *v1.PodStore: namespace(test-fx58jg-1), labelSelector(name=small-deployment-270)
I0722 03:30:16.655207  105723 wait_for_pods.go:94] WaitForControlledPodsRunning: namespace(test-fx58jg-1), labelSelector(name=small-deployment-207): Pods: 5 out of 5 created, 5 running (5 updated), 0 pending scheduled, 0 not scheduled, 0 inactive, 0 terminating, 0 unknown, 0 runningButNotReady 
I0722 03:30:16.655393  105723 reflector.go:181] Stopping reflector *v1.Pod (0s) from *v1.PodStore: namespace(test-fx58jg-1), labelSelector(name=small-deployment-207)
I0722 03:30:16.914180  105723 reflector.go:175] Starting reflector *v1.Pod (0s) from *v1.PodStore: namespace(test-fx58jg-1), labelSelector(name=small-deployment-41)
I0722 03:30:16.940019  105723 reflector.go:175] Starting reflector *v1.Pod (0s) from *v1.PodStore: namespace(test-fx58jg-1), labelSelector(name=small-deployment-261)
I0722 03:30:17.066740  105723 reflector.go:175] Starting reflector *v1.Pod (0s) from *v1.PodStore: namespace(test-fx58jg-1), labelSelector(name=small-deployment-225)
... skipping 426 lines ...
I0722 03:31:16.005453  105723 reflector.go:181] Stopping reflector *v1.Pod (0s) from *v1.PodStore: namespace(test-fx58jg-1), labelSelector(name=medium-deployment-13)
I0722 03:31:16.137057  105723 reflector.go:175] Starting reflector *v1.Pod (0s) from *v1.PodStore: namespace(test-fx58jg-1), labelSelector(name=small-deployment-103)
I0722 03:31:16.274365  105723 reflector.go:175] Starting reflector *v1.Pod (0s) from *v1.PodStore: namespace(test-fx58jg-1), labelSelector(name=small-deployment-130)
I0722 03:31:16.422180  105723 reflector.go:175] Starting reflector *v1.Pod (0s) from *v1.PodStore: namespace(test-fx58jg-1), labelSelector(name=medium-deployment-11)
I0722 03:31:16.586992  105723 wait_for_pods.go:94] WaitForControlledPodsRunning: namespace(test-fx58jg-1), labelSelector(name=small-deployment-107): Pods: 5 out of 5 created, 5 running (5 updated), 0 pending scheduled, 0 not scheduled, 0 inactive, 0 terminating, 0 unknown, 0 runningButNotReady 
I0722 03:31:16.587135  105723 reflector.go:181] Stopping reflector *v1.Pod (0s) from *v1.PodStore: namespace(test-fx58jg-1), labelSelector(name=small-deployment-107)
E0722 03:31:16.629046  105723 etcd_metrics.go:147] EtcdMetrics: failed to collect etcd database size
I0722 03:31:17.580138  105723 wait_for_pods.go:94] WaitForControlledPodsRunning: namespace(test-fx58jg-1), labelSelector(name=small-deployment-93): Pods: 5 out of 5 created, 5 running (5 updated), 0 pending scheduled, 0 not scheduled, 0 inactive, 0 terminating, 0 unknown, 0 runningButNotReady 
I0722 03:31:17.580297  105723 reflector.go:181] Stopping reflector *v1.Pod (0s) from *v1.PodStore: namespace(test-fx58jg-1), labelSelector(name=small-deployment-93)
I0722 03:31:17.892058  105723 wait_for_pods.go:94] WaitForControlledPodsRunning: namespace(test-fx58jg-1), labelSelector(name=small-deployment-246): Pods: 5 out of 5 created, 5 running (5 updated), 0 pending scheduled, 0 not scheduled, 0 inactive, 0 terminating, 0 unknown, 0 runningButNotReady 
I0722 03:31:17.892224  105723 reflector.go:181] Stopping reflector *v1.Pod (0s) from *v1.PodStore: namespace(test-fx58jg-1), labelSelector(name=small-deployment-246)
I0722 03:31:18.628367  105723 wait_for_pods.go:94] WaitForControlledPodsRunning: namespace(test-fx58jg-1), labelSelector(name=small-deployment-245): Pods: 5 out of 5 created, 5 running (5 updated), 0 pending scheduled, 0 not scheduled, 0 inactive, 0 terminating, 0 unknown, 0 runningButNotReady 
I0722 03:31:18.628511  105723 reflector.go:181] Stopping reflector *v1.Pod (0s) from *v1.PodStore: namespace(test-fx58jg-1), labelSelector(name=small-deployment-245)
... skipping 255 lines ...
I0722 03:32:02.647150  105723 phase_latency.go:146] PodStartupLatency: perc50: 0s, perc90: 0s, perc99: 0s
I0722 03:32:02.647221  105723 simple_test_executor.go:173] Step "[step: 12] Collecting scheduler throughput measurements" ended
I0722 03:32:02.647242  105723 simple_test_executor.go:145] Step "[step: 13] delete scheduler throughput pods" started
I0722 03:32:02.686841  105723 reflector.go:175] Starting reflector *v1.Pod (0s) from *v1.PodStore: namespace(test-fx58jg-2), labelSelector(name=scheduler-throughput-deployment-0)
I0722 03:32:07.738277  105723 wait_for_pods.go:94] WaitForControlledPodsRunning: namespace(test-fx58jg-2), labelSelector(name=scheduler-throughput-deployment-0): Pods: 0 out of 0 created, 0 running (0 updated), 0 pending scheduled, 0 not scheduled, 0 inactive, 0 terminating, 0 unknown, 0 runningButNotReady 
I0722 03:32:07.738454  105723 reflector.go:181] Stopping reflector *v1.Pod (0s) from *v1.PodStore: namespace(test-fx58jg-2), labelSelector(name=scheduler-throughput-deployment-0)
E0722 03:32:17.172184  105723 etcd_metrics.go:147] EtcdMetrics: failed to collect etcd database size
I0722 03:32:32.688535  105723 reflector.go:175] Starting reflector *v1.Pod (0s) from *v1.PodStore: namespace(test-fx58jg-3), labelSelector(name=scheduler-throughput-deployment-0)
I0722 03:32:37.739438  105723 wait_for_pods.go:94] WaitForControlledPodsRunning: namespace(test-fx58jg-3), labelSelector(name=scheduler-throughput-deployment-0): Pods: 0 out of 0 created, 0 running (0 updated), 0 pending scheduled, 0 not scheduled, 0 inactive, 0 terminating, 0 unknown, 0 runningButNotReady 
I0722 03:32:37.739678  105723 reflector.go:181] Stopping reflector *v1.Pod (0s) from *v1.PodStore: namespace(test-fx58jg-3), labelSelector(name=scheduler-throughput-deployment-0)
I0722 03:33:02.690909  105723 reflector.go:175] Starting reflector *v1.Pod (0s) from *v1.PodStore: namespace(test-fx58jg-4), labelSelector(name=scheduler-throughput-deployment-0)
I0722 03:33:07.792131  105723 wait_for_pods.go:94] WaitForControlledPodsRunning: namespace(test-fx58jg-4), labelSelector(name=scheduler-throughput-deployment-0): Pods: 0 out of 0 created, 0 running (0 updated), 0 pending scheduled, 0 not scheduled, 0 inactive, 0 terminating, 0 unknown, 0 runningButNotReady 
I0722 03:33:07.792369  105723 reflector.go:181] Stopping reflector *v1.Pod (0s) from *v1.PodStore: namespace(test-fx58jg-4), labelSelector(name=scheduler-throughput-deployment-0)
E0722 03:33:17.704083  105723 etcd_metrics.go:147] EtcdMetrics: failed to collect etcd database size
I0722 03:33:32.690336  105723 reflector.go:175] Starting reflector *v1.Pod (0s) from *v1.PodStore: namespace(test-fx58jg-5), labelSelector(name=scheduler-throughput-deployment-0)
I0722 03:33:37.741274  105723 wait_for_pods.go:94] WaitForControlledPodsRunning: namespace(test-fx58jg-5), labelSelector(name=scheduler-throughput-deployment-0): Pods: 0 out of 0 created, 0 running (0 updated), 0 pending scheduled, 0 not scheduled, 0 inactive, 0 terminating, 0 unknown, 0 runningButNotReady 
I0722 03:33:37.741545  105723 reflector.go:181] Stopping reflector *v1.Pod (0s) from *v1.PodStore: namespace(test-fx58jg-5), labelSelector(name=scheduler-throughput-deployment-0)
I0722 03:34:02.690939  105723 reflector.go:175] Starting reflector *v1.Pod (0s) from *v1.PodStore: namespace(test-fx58jg-6), labelSelector(name=scheduler-throughput-deployment-0)
I0722 03:34:07.792336  105723 wait_for_pods.go:94] WaitForControlledPodsRunning: namespace(test-fx58jg-6), labelSelector(name=scheduler-throughput-deployment-0): Pods: 0 out of 0 created, 0 running (0 updated), 0 pending scheduled, 0 not scheduled, 0 inactive, 0 terminating, 0 unknown, 0 runningButNotReady 
I0722 03:34:07.792548  105723 reflector.go:181] Stopping reflector *v1.Pod (0s) from *v1.PodStore: namespace(test-fx58jg-6), labelSelector(name=scheduler-throughput-deployment-0)
E0722 03:34:18.246453  105723 etcd_metrics.go:147] EtcdMetrics: failed to collect etcd database size
I0722 03:34:32.691850  105723 reflector.go:175] Starting reflector *v1.Pod (0s) from *v1.PodStore: namespace(test-fx58jg-7), labelSelector(name=scheduler-throughput-deployment-0)
I0722 03:34:37.793707  105723 wait_for_pods.go:94] WaitForControlledPodsRunning: namespace(test-fx58jg-7), labelSelector(name=scheduler-throughput-deployment-0): Pods: 0 out of 0 created, 0 running (0 updated), 0 pending scheduled, 0 not scheduled, 0 inactive, 0 terminating, 0 unknown, 0 runningButNotReady 
I0722 03:34:37.793877  105723 reflector.go:181] Stopping reflector *v1.Pod (0s) from *v1.PodStore: namespace(test-fx58jg-7), labelSelector(name=scheduler-throughput-deployment-0)
I0722 03:35:02.692382  105723 reflector.go:175] Starting reflector *v1.Pod (0s) from *v1.PodStore: namespace(test-fx58jg-8), labelSelector(name=scheduler-throughput-deployment-0)
I0722 03:35:07.743291  105723 wait_for_pods.go:94] WaitForControlledPodsRunning: namespace(test-fx58jg-8), labelSelector(name=scheduler-throughput-deployment-0): Pods: 0 out of 0 created, 0 running (0 updated), 0 pending scheduled, 0 not scheduled, 0 inactive, 0 terminating, 0 unknown, 0 runningButNotReady 
I0722 03:35:07.743443  105723 reflector.go:181] Stopping reflector *v1.Pod (0s) from *v1.PodStore: namespace(test-fx58jg-8), labelSelector(name=scheduler-throughput-deployment-0)
E0722 03:35:18.810237  105723 etcd_metrics.go:147] EtcdMetrics: failed to collect etcd database size
I0722 03:35:32.693393  105723 reflector.go:175] Starting reflector *v1.Pod (0s) from *v1.PodStore: namespace(test-fx58jg-9), labelSelector(name=scheduler-throughput-deployment-0)
I0722 03:35:37.744244  105723 wait_for_pods.go:94] WaitForControlledPodsRunning: namespace(test-fx58jg-9), labelSelector(name=scheduler-throughput-deployment-0): Pods: 0 out of 0 created, 0 running (0 updated), 0 pending scheduled, 0 not scheduled, 0 inactive, 0 terminating, 0 unknown, 0 runningButNotReady 
I0722 03:35:37.744440  105723 reflector.go:181] Stopping reflector *v1.Pod (0s) from *v1.PodStore: namespace(test-fx58jg-9), labelSelector(name=scheduler-throughput-deployment-0)