This job view page is being replaced by Spyglass soon. Check out the new job view.
PRklueska: Fix Bugs in CPUManager distribute NUMA policy option
ResultABORTED
Tests 0 failed / 45 succeeded
Started2021-11-24 19:33
Elapsed56m48s
Revision52e03a8ea3b59ed836885e1528bec2b32b3683cd
Refs 106599
job-versionv1.24.0-alpha.0.17+9fb7faa19a0655
kubetest-version
revisionv1.24.0-alpha.0.17+9fb7faa19a0655

No Test Failures!


Show 45 Passed Tests

Error lines from build-log.txt

... skipping 713 lines ...
Looking for address 'e2e-106599-95a39-master-ip'
Looking for address 'e2e-106599-95a39-master-internal-ip'
Using master: e2e-106599-95a39-master (external IP: 34.139.149.117; 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-15_e2e-106599-95a39" set.
User "k8s-infra-e2e-boskos-scale-15_e2e-106599-95a39" set.
Context "k8s-infra-e2e-boskos-scale-15_e2e-106599-95a39" created.
Switched to context "k8s-infra-e2e-boskos-scale-15_e2e-106599-95a39".
... skipping 227 lines ...
e2e-106599-95a39-minion-group-zcq0   Ready                         <none>   51s    v1.24.0-alpha.0.17+9fb7faa19a0655
e2e-106599-95a39-minion-group-zwht   Ready                         <none>   50s    v1.24.0-alpha.0.17+9fb7faa19a0655
e2e-106599-95a39-minion-heapster     Ready                         <none>   81s    v1.24.0-alpha.0.17+9fb7faa19a0655
Warning: v1 ComponentStatus is deprecated in v1.19+
Validate output:
Warning: v1 ComponentStatus is deprecated in v1.19+
NAME                 STATUS    MESSAGE                         ERROR
etcd-1               Healthy   {"health":"true","reason":""}   
etcd-0               Healthy   {"health":"true","reason":""}   
scheduler            Healthy   ok                              
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.139.149.117
GLBCDefaultBackend is running at https://34.139.149.117/api/v1/namespaces/kube-system/services/default-http-backend:http/proxy
CoreDNS is running at https://34.139.149.117/api/v1/namespaces/kube-system/services/kube-dns:dns/proxy
Metrics-server is running at https://34.139.149.117/api/v1/namespaces/kube-system/services/https:metrics-server:/proxy
... skipping 333 lines ...
I1124 19:57:27.047905   87435 framework.go:274] Applying /home/prow/go/src/k8s.io/perf-tests/clusterloader2/pkg/prometheus/manifests/default/prometheus-serviceMonitorLegacyKubeDNS.yaml
I1124 19:57:27.082814   87435 prometheus.go:296] Exposing kube-apiserver metrics in the cluster
I1124 19:57:27.217691   87435 framework.go:274] Applying /home/prow/go/src/k8s.io/perf-tests/clusterloader2/pkg/prometheus/manifests/master-ip/master-endpoints.yaml
I1124 19:57:27.251960   87435 framework.go:274] Applying /home/prow/go/src/k8s.io/perf-tests/clusterloader2/pkg/prometheus/manifests/master-ip/master-service.yaml
I1124 19:57:27.289356   87435 framework.go:274] Applying /home/prow/go/src/k8s.io/perf-tests/clusterloader2/pkg/prometheus/manifests/master-ip/master-serviceMonitor.yaml
I1124 19:57:27.324711   87435 prometheus.go:375] Waiting for Prometheus stack to become healthy...
W1124 19:57:57.360188   87435 util.go:72] error while calling prometheus api: the server is currently unable to handle the request (get services http:prometheus-k8s:9090), response: "k8s\x00\n\f\n\x02v1\x12\x06Status\x12]\n\x06\n\x00\x12\x00\x1a\x00\x12\aFailure\x1a3no endpoints available for service \"prometheus-k8s\"\"\x12ServiceUnavailable0\xf7\x03\x1a\x00\"\x00"
I1124 19:58:27.490896   87435 util.go:101] 90/112 targets are ready, example not ready target: {map[endpoint:http-metrics instance:10.40.3.208:10249 job:kube-proxy namespace:kube-system pod:kube-proxy-e2e-106599-95a39-minion-group-2tl9 service:kube-proxy] unknown}
I1124 19:58:57.425234   87435 util.go:104] All 112 expected targets are ready
I1124 19:58:57.554948   87435 util.go:104] All 1 expected targets are ready
I1124 19:58:57.554991   87435 prometheus.go:240] Prometheus stack set up successfully
I1124 19:58:57.555084   87435 exec_service.go:62] Exec service: setting up service!
I1124 19:58:57.658122   87435 framework.go:274] Applying pkg/execservice/manifest/exec_deployment.yaml
... skipping 39 lines ...
I1124 19:59:39.751584   87435 util.go:93] Not enough active targets (0), expected at least (3), waiting for more to become active...
I1124 19:59:39.931904   87435 util.go:93] Not enough active targets (0), expected at least (6), waiting for more to become active...
I1124 19:59:54.754672   87435 util.go:93] Not enough active targets (0), expected at least (3), waiting for more to become active...
I1124 19:59:54.928732   87435 util.go:93] Not enough active targets (0), expected at least (6), waiting for more to become active...
I1124 20:00:09.754565   87435 util.go:93] Not enough active targets (0), expected at least (3), waiting for more to become active...
I1124 20:00:09.929113   87435 util.go:93] Not enough active targets (0), expected at least (6), waiting for more to become active...
E1124 20:00:10.043469   87435 etcd_metrics.go:147] EtcdMetrics: failed to collect etcd database size
I1124 20:00:24.753474   87435 util.go:93] Not enough active targets (0), expected at least (3), waiting for more to become active...
I1124 20:00:24.928564   87435 util.go:93] Not enough active targets (0), expected at least (6), waiting for more to become active...
I1124 20:00:39.755723   87435 util.go:101] 1/3 targets are ready, example not ready target: {map[container:dns endpoint:metrics instance:10.64.58.3:8080 job:dns namespace:probes pod:dns-7c5f768667-bhg7w service:dns] unknown}
I1124 20:00:39.931507   87435 util.go:101] 0/6 targets are ready, example not ready target: {map[container:ping-server endpoint:metrics instance:10.64.99.3:8080 job:ping-server namespace:probes pod:ping-server-56d8b8978-jfmsf service:ping-server] unknown}
I1124 20:00:54.761242   87435 util.go:101] 2/3 targets are ready, example not ready target: {map[container:dns endpoint:metrics instance:10.64.58.3:8080 job:dns namespace:probes pod:dns-7c5f768667-bhg7w service:dns] unknown}
I1124 20:00:54.928245   87435 util.go:104] All 6 expected targets are ready
I1124 20:01:09.757306   87435 util.go:104] All 3 expected targets are ready
I1124 20:01:09.757363   87435 prometheus_measurement.go:75] SLOMeasurement has started
I1124 20:01:09.757379   87435 simple_test_executor.go:173] Step "[step: 01] starting measurements" ended
I1124 20:01:09.757396   87435 simple_test_executor.go:145] Step "[step: 02] Creating k8s services" started
E1124 20:01:10.590536   87435 etcd_metrics.go:147] EtcdMetrics: failed to collect etcd database size
I1124 20:01:15.498080   87435 simple_test_executor.go:173] Step "[step: 02] Creating k8s services" ended
I1124 20:01:15.498108   87435 simple_test_executor.go:145] Step "[step: 03] Creating PriorityClass for DaemonSets" started
I1124 20:01:15.532762   87435 simple_test_executor.go:173] Step "[step: 03] Creating PriorityClass for DaemonSets" ended
I1124 20:01:15.532791   87435 simple_test_executor.go:145] Step "[step: 04] create objects configmaps and secrets" started
I1124 20:01:20.030103   87435 simple_test_executor.go:173] Step "[step: 04] create objects configmaps and secrets" ended
I1124 20:01:20.030145   87435 simple_test_executor.go:145] Step "[step: 05] Starting measurement for 'create objects'" started
... skipping 100 lines ...
I1124 20:02:06.991490   87435 wait_for_pods.go:96] WaitForControlledPodsRunning: namespace(test-k411ju-1), labelSelector(name=small-deployment-75): Pods: 5 out of 5 created, 5 running (5 updated), 0 pending scheduled, 0 not scheduled, 0 inactive, 0 terminating, 0 unknown, 0 runningButNotReady 
I1124 20:02:06.997684   87435 wait_for_pods.go:96] WaitForControlledPodsRunning: namespace(test-k411ju-1), labelSelector(name=small-deployment-288): Pods: 5 out of 5 created, 5 running (5 updated), 0 pending scheduled, 0 not scheduled, 0 inactive, 0 terminating, 0 unknown, 0 runningButNotReady 
I1124 20:02:07.995941   87435 wait_for_pods.go:96] WaitForControlledPodsRunning: namespace(test-k411ju-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 
I1124 20:02:09.079059   87435 wait_for_pods.go:96] WaitForControlledPodsRunning: namespace(test-k411ju-1), labelSelector(name=small-deployment-268): Pods: 5 out of 5 created, 5 running (5 updated), 0 pending scheduled, 0 not scheduled, 0 inactive, 0 terminating, 0 unknown, 0 runningButNotReady 
I1124 20:02:09.336435   87435 wait_for_pods.go:96] WaitForControlledPodsRunning: namespace(test-k411ju-1), labelSelector(name=medium-deployment-21): Pods: 30 out of 30 created, 30 running (30 updated), 0 pending scheduled, 0 not scheduled, 0 inactive, 0 terminating, 0 unknown, 0 runningButNotReady 
I1124 20:02:10.134035   87435 wait_for_pods.go:96] WaitForControlledPodsRunning: namespace(test-k411ju-1), labelSelector(name=small-deployment-249): Pods: 5 out of 5 created, 5 running (5 updated), 0 pending scheduled, 0 not scheduled, 0 inactive, 0 terminating, 0 unknown, 0 runningButNotReady 
E1124 20:02:11.131487   87435 etcd_metrics.go:147] EtcdMetrics: failed to collect etcd database size
I1124 20:02:11.255927   87435 wait_for_pods.go:96] WaitForControlledPodsRunning: namespace(test-k411ju-1), labelSelector(name=small-deployment-47): Pods: 5 out of 5 created, 5 running (5 updated), 0 pending scheduled, 0 not scheduled, 0 inactive, 0 terminating, 0 unknown, 0 runningButNotReady 
I1124 20:02:11.348135   87435 wait_for_pods.go:96] WaitForControlledPodsRunning: namespace(test-k411ju-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 
I1124 20:02:11.711116   87435 wait_for_pods.go:96] WaitForControlledPodsRunning: namespace(test-k411ju-1), labelSelector(name=small-deployment-13): Pods: 5 out of 5 created, 5 running (5 updated), 0 pending scheduled, 0 not scheduled, 0 inactive, 0 terminating, 0 unknown, 0 runningButNotReady 
I1124 20:02:12.477589   87435 wait_for_pods.go:96] WaitForControlledPodsRunning: namespace(test-k411ju-1), labelSelector(name=small-deployment-237): Pods: 5 out of 5 created, 5 running (5 updated), 0 pending scheduled, 0 not scheduled, 0 inactive, 0 terminating, 0 unknown, 0 runningButNotReady 
I1124 20:02:12.840906   87435 wait_for_pods.go:96] WaitForControlledPodsRunning: namespace(test-k411ju-1), labelSelector(name=small-deployment-167): Pods: 5 out of 5 created, 5 running (5 updated), 0 pending scheduled, 0 not scheduled, 0 inactive, 0 terminating, 0 unknown, 0 runningButNotReady 
I1124 20:02:13.001696   87435 wait_for_pods.go:96] WaitForControlledPodsRunning: namespace(test-k411ju-1), labelSelector(name=small-deployment-226): 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 149 lines ...
I1124 20:03:11.028624   87435 wait_for_pods.go:96] WaitForControlledPodsRunning: namespace(test-k411ju-1), labelSelector(name=small-deployment-294): Pods: 5 out of 5 created, 5 running (5 updated), 0 pending scheduled, 0 not scheduled, 0 inactive, 0 terminating, 0 unknown, 0 runningButNotReady 
I1124 20:03:11.133340   87435 wait_for_pods.go:96] WaitForControlledPodsRunning: namespace(test-k411ju-1), labelSelector(group=load,name=medium-statefulset-0): Pods: 30 out of 30 created, 20 running (20 updated), 10 pending scheduled, 0 not scheduled, 0 inactive, 0 terminating, 0 unknown, 0 runningButNotReady 
I1124 20:03:11.186543   87435 wait_for_pods.go:96] WaitForControlledPodsRunning: namespace(test-k411ju-1), labelSelector(name=small-deployment-54): Pods: 5 out of 5 created, 5 running (5 updated), 0 pending scheduled, 0 not scheduled, 0 inactive, 0 terminating, 0 unknown, 0 runningButNotReady 
I1124 20:03:11.444999   87435 wait_for_pods.go:96] WaitForControlledPodsRunning: namespace(test-k411ju-1), labelSelector(name=small-deployment-70): Pods: 5 out of 5 created, 4 running (4 updated), 1 pending scheduled, 0 not scheduled, 0 inactive, 0 terminating, 0 unknown, 0 runningButNotReady 
I1124 20:03:11.486570   87435 wait_for_pods.go:96] WaitForControlledPodsRunning: namespace(test-k411ju-1), labelSelector(name=small-deployment-173): Pods: 5 out of 5 created, 5 running (5 updated), 0 pending scheduled, 0 not scheduled, 0 inactive, 0 terminating, 0 unknown, 0 runningButNotReady 
I1124 20:03:11.643939   87435 wait_for_pods.go:96] WaitForControlledPodsRunning: namespace(test-k411ju-1), labelSelector(name=small-deployment-60): Pods: 5 out of 5 created, 4 running (4 updated), 1 pending scheduled, 0 not scheduled, 0 inactive, 0 terminating, 0 unknown, 0 runningButNotReady 
E1124 20:03:11.695636   87435 etcd_metrics.go:147] EtcdMetrics: failed to collect etcd database size
I1124 20:03:11.705857   87435 wait_for_pods.go:96] WaitForControlledPodsRunning: namespace(test-k411ju-1), labelSelector(name=small-deployment-221): Pods: 5 out of 5 created, 4 running (4 updated), 1 pending scheduled, 0 not scheduled, 0 inactive, 0 terminating, 0 unknown, 0 runningButNotReady 
I1124 20:03:11.911418   87435 wait_for_pods.go:96] WaitForControlledPodsRunning: namespace(test-k411ju-1), labelSelector(name=small-deployment-89): Pods: 5 out of 5 created, 5 running (5 updated), 0 pending scheduled, 0 not scheduled, 0 inactive, 0 terminating, 0 unknown, 0 runningButNotReady 
I1124 20:03:11.961081   87435 wait_for_pods.go:96] WaitForControlledPodsRunning: namespace(test-k411ju-1), labelSelector(name=small-deployment-87): Pods: 5 out of 5 created, 5 running (5 updated), 0 pending scheduled, 0 not scheduled, 0 inactive, 0 terminating, 0 unknown, 0 runningButNotReady 
I1124 20:03:12.788388   87435 wait_for_pods.go:96] WaitForControlledPodsRunning: namespace(test-k411ju-1), labelSelector(name=small-deployment-155): Pods: 5 out of 5 created, 5 running (5 updated), 0 pending scheduled, 0 not scheduled, 0 inactive, 0 terminating, 0 unknown, 0 runningButNotReady 
I1124 20:03:13.018784   87435 wait_for_pods.go:96] WaitForControlledPodsRunning: namespace(test-k411ju-1), labelSelector(name=small-deployment-72): Pods: 5 out of 5 created, 5 running (5 updated), 0 pending scheduled, 0 not scheduled, 0 inactive, 0 terminating, 0 unknown, 0 runningButNotReady 
I1124 20:03:13.185365   87435 wait_for_pods.go:96] WaitForControlledPodsRunning: namespace(test-k411ju-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 178 lines ...
I1124 20:04:07.531523   87435 wait_for_pods.go:96] WaitForControlledPodsRunning: namespace(test-k411ju-5), labelSelector(name=scheduler-throughput-deployment-0): Pods: 100 out of 100 created, 100 running (100 updated), 0 pending scheduled, 0 not scheduled, 0 inactive, 0 terminating, 0 unknown, 0 runningButNotReady 
I1124 20:04:07.566500   87435 wait_for_pods.go:96] WaitForControlledPodsRunning: namespace(test-k411ju-7), labelSelector(name=scheduler-throughput-deployment-0): Pods: 100 out of 100 created, 20 running (20 updated), 80 pending scheduled, 0 not scheduled, 0 inactive, 0 terminating, 0 unknown, 0 runningButNotReady 
I1124 20:04:07.566604   87435 wait_for_pods.go:96] WaitForControlledPodsRunning: namespace(test-k411ju-6), labelSelector(name=scheduler-throughput-deployment-0): Pods: 100 out of 100 created, 25 running (25 updated), 75 pending scheduled, 0 not scheduled, 0 inactive, 0 terminating, 0 unknown, 0 runningButNotReady 
I1124 20:04:07.567467   87435 wait_for_pods.go:96] WaitForControlledPodsRunning: namespace(test-k411ju-2), labelSelector(name=scheduler-throughput-deployment-0): Pods: 100 out of 100 created, 44 running (44 updated), 56 pending scheduled, 0 not scheduled, 0 inactive, 0 terminating, 0 unknown, 0 runningButNotReady 
I1124 20:04:07.567767   87435 wait_for_pods.go:96] WaitForControlledPodsRunning: namespace(test-k411ju-10), labelSelector(name=scheduler-throughput-deployment-0): Pods: 100 out of 100 created, 73 running (73 updated), 27 pending scheduled, 0 not scheduled, 0 inactive, 0 terminating, 0 unknown, 0 runningButNotReady 
I1124 20:04:07.577674   87435 wait_for_pods.go:96] WaitForControlledPodsRunning: namespace(test-k411ju-9), labelSelector(name=scheduler-throughput-deployment-0): Pods: 100 out of 100 created, 29 running (29 updated), 71 pending scheduled, 0 not scheduled, 0 inactive, 0 terminating, 0 unknown, 0 runningButNotReady 
E1124 20:04:12.246673   87435 etcd_metrics.go:147] EtcdMetrics: failed to collect etcd database size
I1124 20:04:12.533894   87435 wait_for_pods.go:96] WaitForControlledPodsRunning: namespace(test-k411ju-3), labelSelector(name=scheduler-throughput-deployment-0): Pods: 100 out of 100 created, 100 running (100 updated), 0 pending scheduled, 0 not scheduled, 0 inactive, 0 terminating, 0 unknown, 0 runningButNotReady 
I1124 20:04:12.569052   87435 wait_for_pods.go:96] WaitForControlledPodsRunning: namespace(test-k411ju-6), labelSelector(name=scheduler-throughput-deployment-0): Pods: 100 out of 100 created, 100 running (100 updated), 0 pending scheduled, 0 not scheduled, 0 inactive, 0 terminating, 0 unknown, 0 runningButNotReady 
I1124 20:04:12.569393   87435 wait_for_pods.go:96] WaitForControlledPodsRunning: namespace(test-k411ju-7), labelSelector(name=scheduler-throughput-deployment-0): Pods: 100 out of 100 created, 100 running (100 updated), 0 pending scheduled, 0 not scheduled, 0 inactive, 0 terminating, 0 unknown, 0 runningButNotReady 
I1124 20:04:12.570270   87435 wait_for_pods.go:96] WaitForControlledPodsRunning: namespace(test-k411ju-10), labelSelector(name=scheduler-throughput-deployment-0): Pods: 100 out of 100 created, 100 running (100 updated), 0 pending scheduled, 0 not scheduled, 0 inactive, 0 terminating, 0 unknown, 0 runningButNotReady 
I1124 20:04:12.570680   87435 wait_for_pods.go:96] WaitForControlledPodsRunning: namespace(test-k411ju-2), labelSelector(name=scheduler-throughput-deployment-0): Pods: 100 out of 100 created, 100 running (100 updated), 0 pending scheduled, 0 not scheduled, 0 inactive, 0 terminating, 0 unknown, 0 runningButNotReady 
I1124 20:04:12.580369   87435 wait_for_pods.go:96] WaitForControlledPodsRunning: namespace(test-k411ju-9), labelSelector(name=scheduler-throughput-deployment-0): Pods: 100 out of 100 created, 100 running (100 updated), 0 pending scheduled, 0 not scheduled, 0 inactive, 0 terminating, 0 unknown, 0 runningButNotReady 
... skipping 34 lines ...
I1124 20:04:12.959966   87435 phase_latency.go:141] PodStartupLatency: 0 worst pod_startup latencies: []
I1124 20:04:12.959986   87435 phase_latency.go:146] PodStartupLatency: perc50: 0s, perc90: 0s, perc99: 0s; threshold 1h0m0s
I1124 20:04:12.960067   87435 simple_test_executor.go:173] Step "[step: 12] Collecting scheduler throughput measurements" ended
I1124 20:04:12.960099   87435 simple_test_executor.go:145] Step "[step: 13] delete scheduler throughput pods" started
I1124 20:04:18.098910   87435 wait_for_pods.go:96] WaitForControlledPodsRunning: namespace(test-k411ju-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 
I1124 20:04:48.049310   87435 wait_for_pods.go:96] WaitForControlledPodsRunning: namespace(test-k411ju-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 
E1124 20:05:12.783896   87435 etcd_metrics.go:147] EtcdMetrics: failed to collect etcd database size
I1124 20:05:18.049764   87435 wait_for_pods.go:96] WaitForControlledPodsRunning: namespace(test-k411ju-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 
I1124 20:05:48.051072   87435 wait_for_pods.go:96] WaitForControlledPodsRunning: namespace(test-k411ju-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 
E1124 20:06:13.328150   87435 etcd_metrics.go:147] EtcdMetrics: failed to collect etcd database size
I1124 20:06:18.053615   87435 wait_for_pods.go:96] WaitForControlledPodsRunning: namespace(test-k411ju-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 
I1124 20:06:48.053094   87435 wait_for_pods.go:96] WaitForControlledPodsRunning: namespace(test-k411ju-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 
E1124 20:07:13.881938   87435 etcd_metrics.go:147] EtcdMetrics: failed to collect etcd database size
I1124 20:07:18.053663   87435 wait_for_pods.go:96] WaitForControlledPodsRunning: namespace(test-k411ju-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 
I1124 20:07:48.056310   87435 wait_for_pods.go:96] WaitForControlledPodsRunning: namespace(test-k411ju-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 
E1124 20:08:14.434756   87435 etcd_metrics.go:147] EtcdMetrics: failed to collect etcd database size
I1124 20:08:18.055852   87435 wait_for_pods.go:96] WaitForControlledPodsRunning: namespace(test-k411ju-10), 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 
I1124 20:08:48.055274   87435 wait_for_pods.go:96] WaitForControlledPodsRunning: namespace(test-k411ju-11), 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 
I1124 20:09:12.970999   87435 simple_test_executor.go:173] Step "[step: 13] delete scheduler throughput pods" ended
I1124 20:09:12.971038   87435 simple_test_executor.go:145] Step "[step: 14] Waiting for scheduler throughput pods to be deleted" started
I1124 20:09:12.971191   87435 wait_for_controlled_pods.go:200] WaitForControlledPodsRunning: waiting for controlled pods measurement...
E1124 20:09:14.974160   87435 etcd_metrics.go:147] EtcdMetrics: failed to collect etcd database size
I1124 20:09:18.019144   87435 wait_for_controlled_pods.go:267] WaitForControlledPodsRunning: running 0, deleted 10, timeout: 0, unknown: 0
I1124 20:09:18.019191   87435 wait_for_controlled_pods.go:281] WaitForControlledPodsRunning: 0/0 Deployments are running with all pods
I1124 20:09:18.019212   87435 simple_test_executor.go:173] Step "[step: 14] Waiting for scheduler throughput pods to be deleted" ended
I1124 20:09:18.019232   87435 simple_test_executor.go:145] Step "[step: 15] delete huge services" started
I1124 20:09:18.444964   87435 simple_test_executor.go:173] Step "[step: 15] delete huge services" ended
I1124 20:09:18.444997   87435 simple_test_executor.go:145] Step "[step: 16] Starting latency pod measurements" started
... skipping 257 lines ...
I1124 20:10:14.411618   87435 wait_for_pods.go:96] WaitForControlledPodsRunning: namespace(test-k411ju-1), labelSelector(name=latency-deployment-253): Pods: 1 out of 1 created, 1 running (1 updated), 0 pending scheduled, 0 not scheduled, 0 inactive, 0 terminating, 0 unknown, 0 runningButNotReady 
I1124 20:10:14.586367   87435 wait_for_pods.go:96] WaitForControlledPodsRunning: namespace(test-k411ju-1), labelSelector(name=latency-deployment-254): Pods: 1 out of 1 created, 1 running (1 updated), 0 pending scheduled, 0 not scheduled, 0 inactive, 0 terminating, 0 unknown, 0 runningButNotReady 
I1124 20:10:14.785917   87435 wait_for_pods.go:96] WaitForControlledPodsRunning: namespace(test-k411ju-1), labelSelector(name=latency-deployment-255): Pods: 1 out of 1 created, 1 running (1 updated), 0 pending scheduled, 0 not scheduled, 0 inactive, 0 terminating, 0 unknown, 0 runningButNotReady 
I1124 20:10:14.986963   87435 wait_for_pods.go:96] WaitForControlledPodsRunning: namespace(test-k411ju-1), labelSelector(name=latency-deployment-256): Pods: 1 out of 1 created, 1 running (1 updated), 0 pending scheduled, 0 not scheduled, 0 inactive, 0 terminating, 0 unknown, 0 runningButNotReady 
I1124 20:10:15.186325   87435 wait_for_pods.go:96] WaitForControlledPodsRunning: namespace(test-k411ju-1), labelSelector(name=latency-deployment-257): Pods: 1 out of 1 created, 1 running (1 updated), 0 pending scheduled, 0 not scheduled, 0 inactive, 0 terminating, 0 unknown, 0 runningButNotReady 
I1124 20:10:15.388173   87435 wait_for_pods.go:96] WaitForControlledPodsRunning: namespace(test-k411ju-1), labelSelector(name=latency-deployment-258): Pods: 1 out of 1 created, 1 running (1 updated), 0 pending scheduled, 0 not scheduled, 0 inactive, 0 terminating, 0 unknown, 0 runningButNotReady 
E1124 20:10:15.508947   87435 etcd_metrics.go:147] EtcdMetrics: failed to collect etcd database size
I1124 20:10:15.588691   87435 wait_for_pods.go:96] WaitForControlledPodsRunning: namespace(test-k411ju-1), labelSelector(name=latency-deployment-259): Pods: 1 out of 1 created, 1 running (1 updated), 0 pending scheduled, 0 not scheduled, 0 inactive, 0 terminating, 0 unknown, 0 runningButNotReady 
I1124 20:10:15.788819   87435 wait_for_pods.go:96] WaitForControlledPodsRunning: namespace(test-k411ju-1), labelSelector(name=latency-deployment-260): Pods: 1 out of 1 created, 1 running (1 updated), 0 pending scheduled, 0 not scheduled, 0 inactive, 0 terminating, 0 unknown, 0 runningButNotReady 
I1124 20:10:15.989724   87435 wait_for_pods.go:96] WaitForControlledPodsRunning: namespace(test-k411ju-1), labelSelector(name=latency-deployment-261): Pods: 1 out of 1 created, 1 running (1 updated), 0 pending scheduled, 0 not scheduled, 0 inactive, 0 terminating, 0 unknown, 0 runningButNotReady 
I1124 20:10:16.190005   87435 wait_for_pods.go:96] WaitForControlledPodsRunning: namespace(test-k411ju-1), labelSelector(name=latency-deployment-262): Pods: 1 out of 1 created, 1 running (1 updated), 0 pending scheduled, 0 not scheduled, 0 inactive, 0 terminating, 0 unknown, 0 runningButNotReady 
I1124 20:10:16.391494   87435 wait_for_pods.go:96] WaitForControlledPodsRunning: namespace(test-k411ju-1), labelSelector(name=latency-deployment-263): Pods: 1 out of 1 created, 1 running (1 updated), 0 pending scheduled, 0 not scheduled, 0 inactive, 0 terminating, 0 unknown, 0 runningButNotReady 
I1124 20:10:16.590659   87435 wait_for_pods.go:96] WaitForControlledPodsRunning: namespace(test-k411ju-1), labelSelector(name=latency-deployment-264): Pods: 1 out of 1 created, 1 running (1 updated), 0 pending scheduled, 0 not scheduled, 0 inactive, 0 terminating, 0 unknown, 0 runningButNotReady 
... skipping 271 lines ...
I1124 20:11:14.995880   87435 wait_for_pods.go:96] WaitForControlledPodsRunning: namespace(test-k411ju-1), labelSelector(name=latency-deployment-29): Pods: 0 out of 0 created, 0 running (0 updated), 0 pending scheduled, 0 not scheduled, 0 inactive, 0 terminating, 0 unknown, 0 runningButNotReady 
I1124 20:11:15.195653   87435 wait_for_pods.go:96] WaitForControlledPodsRunning: namespace(test-k411ju-1), labelSelector(name=latency-deployment-30): Pods: 0 out of 0 created, 0 running (0 updated), 0 pending scheduled, 0 not scheduled, 0 inactive, 0 terminating, 0 unknown, 0 runningButNotReady 
I1124 20:11:15.397263   87435 wait_for_pods.go:96] WaitForControlledPodsRunning: namespace(test-k411ju-1), labelSelector(name=latency-deployment-31): Pods: 0 out of 0 created, 0 running (0 updated), 0 pending scheduled, 0 not scheduled, 0 inactive, 0 terminating, 0 unknown, 0 runningButNotReady 
I1124 20:11:15.597220   87435 wait_for_pods.go:96] WaitForControlledPodsRunning: namespace(test-k411ju-1), labelSelector(name=latency-deployment-32): Pods: 0 out of 0 created, 0 running (0 updated), 0 pending scheduled, 0 not scheduled, 0 inactive, 0 terminating, 0 unknown, 0 runningButNotReady 
I1124 20:11:15.797677   87435 wait_for_pods.go:96] WaitForControlledPodsRunning: namespace(test-k411ju-1), labelSelector(name=latency-deployment-33): Pods: 0 out of 0 created, 0 running (0 updated), 0 pending scheduled, 0 not scheduled, 0 inactive, 0 terminating, 0 unknown, 0 runningButNotReady 
I1124 20:11:15.999411   87435 wait_for_pods.go:96] WaitForControlledPodsRunning: namespace(test-k411ju-1), labelSelector(name=latency-deployment-34): Pods: 0 out of 0 created, 0 running (0 updated), 0 pending scheduled, 0 not scheduled, 0 inactive, 0 terminating, 0 unknown, 0 runningButNotReady 
E1124 20:11:16.048399   87435 etcd_metrics.go:147] EtcdMetrics: failed to collect etcd database size
I1124 20:11:16.200357   87435 wait_for_pods.go:96] WaitForControlledPodsRunning: namespace(test-k411ju-1), labelSelector(name=latency-deployment-35): Pods: 0 out of 0 created, 0 running (0 updated), 0 pending scheduled, 0 not scheduled, 0 inactive, 0 terminating, 0 unknown, 0 runningButNotReady 
I1124 20:11:16.399585   87435 wait_for_pods.go:96] WaitForControlledPodsRunning: namespace(test-k411ju-1), labelSelector(name=latency-deployment-36): Pods: 0 out of 0 created, 0 running (0 updated), 0 pending scheduled, 0 not scheduled, 0 inactive, 0 terminating, 0 unknown, 0 runningButNotReady 
I1124 20:11:16.600639   87435 wait_for_pods.go:96] WaitForControlledPodsRunning: namespace(test-k411ju-1), labelSelector(name=latency-deployment-37): Pods: 0 out of 0 created, 0 running (0 updated), 0 pending scheduled, 0 not scheduled, 0 inactive, 0 terminating, 0 unknown, 0 runningButNotReady 
I1124 20:11:16.801337   87435 wait_for_pods.go:96] WaitForControlledPodsRunning: namespace(test-k411ju-1), labelSelector(name=latency-deployment-38): Pods: 0 out of 0 created, 0 running (0 updated), 0 pending scheduled, 0 not scheduled, 0 inactive, 0 terminating, 0 unknown, 0 runningButNotReady 
I1124 20:11:17.001167   87435 wait_for_pods.go:96] WaitForControlledPodsRunning: namespace(test-k411ju-1), labelSelector(name=latency-deployment-39): Pods: 0 out of 0 created, 0 running (0 updated), 0 pending scheduled, 0 not scheduled, 0 inactive, 0 terminating, 0 unknown, 0 runningButNotReady 
I1124 20:11:17.205964   87435 wait_for_pods.go:96] WaitForControlledPodsRunning: namespace(test-k411ju-1), labelSelector(name=latency-deployment-40): Pods: 0 out of 0 created, 0 running (0 updated), 0 pending scheduled, 0 not scheduled, 0 inactive, 0 terminating, 0 unknown, 0 runningButNotReady 
... skipping 290 lines ...
I1124 20:12:15.574003   87435 wait_for_pods.go:96] WaitForControlledPodsRunning: namespace(test-k411ju-1), labelSelector(name=latency-deployment-331): Pods: 0 out of 0 created, 0 running (0 updated), 0 pending scheduled, 0 not scheduled, 0 inactive, 0 terminating, 0 unknown, 0 runningButNotReady 
I1124 20:12:15.774002   87435 wait_for_pods.go:96] WaitForControlledPodsRunning: namespace(test-k411ju-1), labelSelector(name=latency-deployment-332): Pods: 0 out of 0 created, 0 running (0 updated), 0 pending scheduled, 0 not scheduled, 0 inactive, 0 terminating, 0 unknown, 0 runningButNotReady 
I1124 20:12:15.974888   87435 wait_for_pods.go:96] WaitForControlledPodsRunning: namespace(test-k411ju-1), labelSelector(name=latency-deployment-333): Pods: 0 out of 0 created, 0 running (0 updated), 0 pending scheduled, 0 not scheduled, 0 inactive, 0 terminating, 0 unknown, 0 runningButNotReady 
I1124 20:12:16.175778   87435 wait_for_pods.go:96] WaitForControlledPodsRunning: namespace(test-k411ju-1), labelSelector(name=latency-deployment-334): Pods: 0 out of 0 created, 0 running (0 updated), 0 pending scheduled, 0 not scheduled, 0 inactive, 0 terminating, 0 unknown, 0 runningButNotReady 
I1124 20:12:16.375688   87435 wait_for_pods.go:96] WaitForControlledPodsRunning: namespace(test-k411ju-1), labelSelector(name=latency-deployment-335): Pods: 0 out of 0 created, 0 running (0 updated), 0 pending scheduled, 0 not scheduled, 0 inactive, 0 terminating, 0 unknown, 0 runningButNotReady 
I1124 20:12:16.576692   87435 wait_for_pods.go:96] WaitForControlledPodsRunning: namespace(test-k411ju-1), labelSelector(name=latency-deployment-336): Pods: 0 out of 0 created, 0 running (0 updated), 0 pending scheduled, 0 not scheduled, 0 inactive, 0 terminating, 0 unknown, 0 runningButNotReady 
E1124 20:12:16.601230   87435 etcd_metrics.go:147] EtcdMetrics: failed to collect etcd database size
I1124 20:12:16.778310   87435 wait_for_pods.go:96] WaitForControlledPodsRunning: namespace(test-k411ju-1), labelSelector(name=latency-deployment-337): Pods: 0 out of 0 created, 0 running (0 updated), 0 pending scheduled, 0 not scheduled, 0 inactive, 0 terminating, 0 unknown, 0 runningButNotReady 
I1124 20:12:16.979221   87435 wait_for_pods.go:96] WaitForControlledPodsRunning: namespace(test-k411ju-1), labelSelector(name=latency-deployment-338): Pods: 0 out of 0 created, 0 running (0 updated), 0 pending scheduled, 0 not scheduled, 0 inactive, 0 terminating, 0 unknown, 0 runningButNotReady 
I1124 20:12:17.179660   87435 wait_for_pods.go:96] WaitForControlledPodsRunning: namespace(test-k411ju-1), labelSelector(name=latency-deployment-339): Pods: 0 out of 0 created, 0 running (0 updated), 0 pending scheduled, 0 not scheduled, 0 inactive, 0 terminating, 0 unknown, 0 runningButNotReady 
I1124 20:12:17.379782   87435 wait_for_pods.go:96] WaitForControlledPodsRunning: namespace(test-k411ju-1), labelSelector(name=latency-deployment-340): Pods: 0 out of 0 created, 0 running (0 updated), 0 pending scheduled, 0 not scheduled, 0 inactive, 0 terminating, 0 unknown, 0 runningButNotReady 
I1124 20:12:17.580898   87435 wait_for_pods.go:96] WaitForControlledPodsRunning: namespace(test-k411ju-1), labelSelector(name=latency-deployment-341): Pods: 0 out of 0 created, 0 running (0 updated), 0 pending scheduled, 0 not scheduled, 0 inactive, 0 terminating, 0 unknown, 0 runningButNotReady 
I1124 20:12:17.781372   87435 wait_for_pods.go:96] WaitForControlledPodsRunning: namespace(test-k411ju-1), labelSelector(name=latency-deployment-342): Pods: 0 out of 0 created, 0 running (0 updated), 0 pending scheduled, 0 not scheduled, 0 inactive, 0 terminating, 0 unknown, 0 runningButNotReady 
... skipping 367 lines ...
I1124 20:13:16.518931   87435 wait_for_pods.go:96] WaitForControlledPodsRunning: namespace(test-k411ju-1), labelSelector(name=small-deployment-40): Pods: 7 out of 7 created, 7 running (7 updated), 0 pending scheduled, 0 not scheduled, 0 inactive, 0 terminating, 0 unknown, 0 runningButNotReady 
I1124 20:13:16.593853   87435 wait_for_pods.go:96] WaitForControlledPodsRunning: namespace(test-k411ju-1), labelSelector(name=small-deployment-134): Pods: 4 out of 4 created, 4 running (4 updated), 0 pending scheduled, 0 not scheduled, 0 inactive, 0 terminating, 0 unknown, 0 runningButNotReady 
I1124 20:13:16.667052   87435 wait_for_pods.go:96] WaitForControlledPodsRunning: namespace(test-k411ju-1), labelSelector(name=small-deployment-63): Pods: 2 out of 2 created, 2 running (2 updated), 0 pending scheduled, 0 not scheduled, 0 inactive, 0 terminating, 0 unknown, 0 runningButNotReady 
I1124 20:13:16.745675   87435 wait_for_pods.go:96] WaitForControlledPodsRunning: namespace(test-k411ju-1), labelSelector(name=medium-deployment-22): Pods: 22 out of 22 created, 22 running (22 updated), 0 pending scheduled, 0 not scheduled, 0 inactive, 0 terminating, 0 unknown, 0 runningButNotReady 
I1124 20:13:16.784187   87435 wait_for_pods.go:96] WaitForControlledPodsRunning: namespace(test-k411ju-1), labelSelector(name=small-deployment-151): Pods: 4 out of 4 created, 4 running (4 updated), 0 pending scheduled, 0 not scheduled, 0 inactive, 0 terminating, 0 unknown, 0 runningButNotReady 
I1124 20:13:16.836633   87435 wait_for_pods.go:96] WaitForControlledPodsRunning: namespace(test-k411ju-1), labelSelector(name=small-deployment-192): Pods: 4 out of 4 created, 4 running (4 updated), 0 pending scheduled, 0 not scheduled, 0 inactive, 0 terminating, 0 unknown, 0 runningButNotReady 
E1124 20:13:17.143040   87435 etcd_metrics.go:147] EtcdMetrics: failed to collect etcd database size
I1124 20:13:17.372794   87435 wait_for_pods.go:96] WaitForControlledPodsRunning: namespace(test-k411ju-1), labelSelector(name=small-deployment-231): Pods: 4 out of 4 created, 4 running (4 updated), 0 pending scheduled, 0 not scheduled, 0 inactive, 0 terminating, 0 unknown, 0 runningButNotReady 
I1124 20:13:17.418279   87435 wait_for_pods.go:96] WaitForControlledPodsRunning: namespace(test-k411ju-1), labelSelector(name=small-deployment-275): Pods: 7 out of 7 created, 7 running (7 updated), 0 pending scheduled, 0 not scheduled, 0 inactive, 0 terminating, 0 unknown, 0 runningButNotReady 
I1124 20:13:17.532893   87435 wait_for_pods.go:96] WaitForControlledPodsRunning: namespace(test-k411ju-1), labelSelector(name=small-deployment-223): Pods: 6 out of 6 created, 6 running (6 updated), 0 pending scheduled, 0 not scheduled, 0 inactive, 0 terminating, 0 unknown, 0 runningButNotReady 
I1124 20:13:17.563354   87435 wait_for_pods.go:96] WaitForControlledPodsRunning: namespace(test-k411ju-1), labelSelector(name=small-deployment-137): Pods: 2 out of 2 created, 2 running (2 updated), 0 pending scheduled, 0 not scheduled, 0 inactive, 0 terminating, 0 unknown, 0 runningButNotReady 
I1124 20:13:17.564563   87435 wait_for_pods.go:96] WaitForControlledPodsRunning: namespace(test-k411ju-1), labelSelector(name=small-deployment-124): Pods: 6 out of 6 created, 6 running (6 updated), 0 pending scheduled, 0 not scheduled, 0 inactive, 0 terminating, 0 unknown, 0 runningButNotReady 
I1124 20:13:17.763778   87435 wait_for_pods.go:96] WaitForControlledPodsRunning: namespace(test-k411ju-1), labelSelector(name=small-deployment-255): Pods: 4 out of 4 created, 4 running (4 updated), 0 pending scheduled, 0 not scheduled, 0 inactive, 0 terminating, 0 unknown, 0 runningButNotReady 
... skipping 140 lines ...
I1124 20:14:10.957865   87435 wait_for_controlled_pods.go:172] WaitForControlledPodsRunning: wait for controlled pods measurement already running
I1124 20:14:10.957895   87435 wait_for_controlled_pods.go:172] WaitForControlledPodsRunning: wait for controlled pods measurement already running
I1124 20:14:10.957867   87435 wait_for_controlled_pods.go:172] WaitForControlledPodsRunning: wait for controlled pods measurement already running
I1124 20:14:10.957944   87435 simple_test_executor.go:173] Step "[step: 25] Starting measurement for 'delete objects'" ended
I1124 20:14:10.957971   87435 simple_test_executor.go:145] Step "[step: 26] delete objects" started
I1124 20:14:16.265428   87435 wait_for_pods.go:96] WaitForControlledPodsRunning: namespace(test-k411ju-1), labelSelector(name=small-deployment-82): Pods: 0 out of 0 created, 0 running (0 updated), 0 pending scheduled, 0 not scheduled, 0 inactive, 0 terminating, 0 unknown, 0 runningButNotReady 
E1124 20:14:17.691654   87435 etcd_metrics.go:147] EtcdMetrics: failed to collect etcd database size
I1124 20:14:19.837759   87435 wait_for_pods.go:96] WaitForControlledPodsRunning: namespace(test-k411ju-1), labelSelector(name=medium-deployment-8): Pods: 0 out of 0 created, 0 running (0 updated), 0 pending scheduled, 0 not scheduled, 0 inactive, 0 terminating, 0 unknown, 0 runningButNotReady 
I1124 20:14:20.544506   87435 wait_for_pods.go:96] WaitForControlledPodsRunning: namespace(test-k411ju-1), labelSelector(name=small-deployment-273): Pods: 0 out of 0 created, 0 running (0 updated), 0 pending scheduled, 0 not scheduled, 0 inactive, 0 terminating, 0 unknown, 0 runningButNotReady 
I1124 20:14:20.689593   87435 wait_for_pods.go:96] WaitForControlledPodsRunning: namespace(test-k411ju-1), labelSelector(name=small-deployment-42): Pods: 0 out of 0 created, 0 running (0 updated), 0 pending scheduled, 0 not scheduled, 0 inactive, 0 terminating, 0 unknown, 0 runningButNotReady 
I1124 20:14:20.860246   87435 wait_for_pods.go:96] WaitForControlledPodsRunning: namespace(test-k411ju-1), labelSelector(name=small-deployment-32): Pods: 0 out of 0 created, 0 running (0 updated), 0 pending scheduled, 0 not scheduled, 0 inactive, 0 terminating, 0 unknown, 0 runningButNotReady 
I1124 20:14:21.010839   87435 wait_for_pods.go:96] WaitForControlledPodsRunning: namespace(test-k411ju-1), labelSelector(name=medium-deployment-10): Pods: 0 out of 0 created, 0 running (0 updated), 0 pending scheduled, 0 not scheduled, 0 inactive, 0 terminating, 0 unknown, 0 runningButNotReady 
I1124 20:14:21.109421   87435 wait_for_pods.go:96] WaitForControlledPodsRunning: namespace(test-k411ju-1), labelSelector(name=small-deployment-30): Pods: 0 out of 0 created, 0 running (0 updated), 0 pending scheduled, 0 not scheduled, 0 inactive, 0 terminating, 0 unknown, 0 runningButNotReady 
... skipping 83 lines ...
I1124 20:15:14.119265   87435 wait_for_pods.go:96] WaitForControlledPodsRunning: namespace(test-k411ju-1), labelSelector(name=small-deployment-275): Pods: 0 out of 0 created, 0 running (0 updated), 0 pending scheduled, 0 not scheduled, 0 inactive, 0 terminating, 0 unknown, 0 runningButNotReady 
I1124 20:15:15.486732   87435 wait_for_pods.go:96] WaitForControlledPodsRunning: namespace(test-k411ju-1), labelSelector(name=small-deployment-191): Pods: 0 out of 0 created, 0 running (0 updated), 0 pending scheduled, 0 not scheduled, 0 inactive, 0 terminating, 0 unknown, 0 runningButNotReady 
I1124 20:15:16.446045   87435 wait_for_pods.go:96] WaitForControlledPodsRunning: namespace(test-k411ju-1), labelSelector(name=small-deployment-121): Pods: 0 out of 0 created, 0 running (0 updated), 0 pending scheduled, 0 not scheduled, 0 inactive, 0 terminating, 0 unknown, 0 runningButNotReady 
I1124 20:15:16.829484   87435 wait_for_pods.go:96] WaitForControlledPodsRunning: namespace(test-k411ju-1), labelSelector(name=small-deployment-261): Pods: 0 out of 0 created, 0 running (0 updated), 0 pending scheduled, 0 not scheduled, 0 inactive, 0 terminating, 0 unknown, 0 runningButNotReady 
I1124 20:15:17.533693   87435 wait_for_pods.go:96] WaitForControlledPodsRunning: namespace(test-k411ju-1), labelSelector(name=small-deployment-7): Pods: 0 out of 0 created, 0 running (0 updated), 0 pending scheduled, 0 not scheduled, 0 inactive, 0 terminating, 0 unknown, 0 runningButNotReady 
I1124 20:15:17.981157   87435 wait_for_pods.go:96] WaitForControlledPodsRunning: namespace(test-k411ju-1), labelSelector(name=small-deployment-46): Pods: 0 out of 0 created, 0 running (0 updated), 0 pending scheduled, 0 not scheduled, 0 inactive, 0 terminating, 0 unknown, 0 runningButNotReady 
E1124 20:15:18.237147   87435 etcd_metrics.go:147] EtcdMetrics: failed to collect etcd database size
I1124 20:15:18.454350   87435 wait_for_pods.go:96] WaitForControlledPodsRunning: namespace(test-k411ju-1), labelSelector(name=medium-deployment-11): Pods: 0 out of 0 created, 0 running (0 updated), 0 pending scheduled, 0 not scheduled, 0 inactive, 0 terminating, 0 unknown, 0 runningButNotReady 
I1124 20:15:19.056022   87435 wait_for_pods.go:96] WaitForControlledPodsRunning: namespace(test-k411ju-1), labelSelector(name=small-deployment-213): Pods: 0 out of 0 created, 0 running (0 updated), 0 pending scheduled, 0 not scheduled, 0 inactive, 0 terminating, 0 unknown, 0 runningButNotReady 
I1124 20:15:19.354072   87435 wait_for_pods.go:96] WaitForControlledPodsRunning: namespace(test-k411ju-1), labelSelector(name=small-deployment-146): Pods: 0 out of 0 created, 0 running (0 updated), 0 pending scheduled, 0 not scheduled, 0 inactive, 0 terminating, 0 unknown, 0 runningButNotReady 
I1124 20:15:20.155203   87435 wait_for_pods.go:96] WaitForControlledPodsRunning: namespace(test-k411ju-1), labelSelector(name=small-deployment-97): Pods: 0 out of 0 created, 0 running (0 updated), 0 pending scheduled, 0 not scheduled, 0 inactive, 0 terminating, 0 unknown, 0 runningButNotReady 
I1124 20:15:20.482554   87435 wait_for_pods.go:96] WaitForControlledPodsRunning: namespace(test-k411ju-1), labelSelector(name=small-deployment-145): Pods: 0 out of 0 created, 0 running (0 updated), 0 pending scheduled, 0 not scheduled, 0 inactive, 0 terminating, 0 unknown, 0 runningButNotReady 
I1124 20:15:23.263883   87435 wait_for_pods.go:96] WaitForControlledPodsRunning: namespace(test-k411ju-1), labelSelector(name=small-deployment-1): Pods: 0 out of 0 created, 0 running (0 updated), 0 pending scheduled, 0 not scheduled, 0 inactive, 0 terminating, 0 unknown, 0 runningButNotReady 
... skipping 89 lines ...
I1124 20:16:15.800759   87435 wait_for_pods.go:96] WaitForControlledPodsRunning: namespace(test-k411ju-1), labelSelector(name=small-deployment-109): Pods: 0 out of 0 created, 0 running (0 updated), 0 pending scheduled, 0 not scheduled, 0 inactive, 0 terminating, 0 unknown, 0 runningButNotReady 
I1124 20:16:15.995244   87435 wait_for_pods.go:96] WaitForControlledPodsRunning: namespace(test-k411ju-1), labelSelector(name=small-deployment-216): Pods: 0 out of 0 created, 0 running (0 updated), 0 pending scheduled, 0 not scheduled, 0 inactive, 0 terminating, 0 unknown, 0 runningButNotReady 
I1124 20:16:16.299193   87435 wait_for_pods.go:96] WaitForControlledPodsRunning: namespace(test-k411ju-1), labelSelector(name=small-deployment-81): Pods: 0 out of 0 created, 0 running (0 updated), 0 pending scheduled, 0 not scheduled, 0 inactive, 0 terminating, 0 unknown, 0 runningButNotReady 
I1124 20:16:16.992490   87435 wait_for_pods.go:96] WaitForControlledPodsRunning: namespace(test-k411ju-1), labelSelector(name=small-deployment-55): Pods: 0 out of 0 created, 0 running (0 updated), 0 pending scheduled, 0 not scheduled, 0 inactive, 0 terminating, 0 unknown, 0 runningButNotReady 
I1124 20:16:17.046146   87435 wait_for_pods.go:96] WaitForControlledPodsRunning: namespace(test-k411ju-1), labelSelector(name=small-deployment-67): Pods: 0 out of 0 created, 0 running (0 updated), 0 pending scheduled, 0 not scheduled, 0 inactive, 0 terminating, 0 unknown, 0 runningButNotReady 
I1124 20:16:17.152741   87435 wait_for_pods.go:96] WaitForControlledPodsRunning: namespace(test-k411ju-1), labelSelector(name=small-deployment-80): Pods: 0 out of 0 created, 0 running (0 updated), 0 pending scheduled, 0 not scheduled, 0 inactive, 0 terminating, 0 unknown, 0 runningButNotReady 
E1124 20:16:18.781138   87435 etcd_metrics.go:147] EtcdMetrics: failed to collect etcd database size
I1124 20:16:18.960534   87435 wait_for_pods.go:96] WaitForControlledPodsRunning: namespace(test-k411ju-1), labelSelector(name=medium-job-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 
I1124 20:16:20.165253   87435 wait_for_pods.go:96] WaitForControlledPodsRunning: namespace(test-k411ju-1), labelSelector(name=small-deployment-256): Pods: 0 out of 0 created, 0 running (0 updated), 0 pending scheduled, 0 not scheduled, 0 inactive, 0 terminating, 0 unknown, 0 runningButNotReady 
I1124 20:16:20.392844   87435 wait_for_pods.go:96] WaitForControlledPodsRunning: namespace(test-k411ju-1), labelSelector(name=small-deployment-120): Pods: 0 out of 0 created, 0 running (0 updated), 0 pending scheduled, 0 not scheduled, 0 inactive, 0 terminating, 0 unknown, 0 runningButNotReady 
I1124 20:16:20.731859   87435 wait_for_pods.go:96] WaitForControlledPodsRunning: namespace(test-k411ju-1), labelSelector(name=small-deployment-271): Pods: 0 out of 0 created, 0 running (0 updated), 0 pending scheduled, 0 not scheduled, 0 inactive, 0 terminating, 0 unknown, 0 runningButNotReady 
I1124 20:16:21.558570   87435 wait_for_pods.go:96] WaitForControlledPodsRunning: namespace(test-k411ju-1), labelSelector(name=small-deployment-24): Pods: 0 out of 0 created, 0 running (0 updated), 0 pending scheduled, 0 not scheduled, 0 inactive, 0 terminating, 0 unknown, 0 runningButNotReady 
I1124 20:16:23.512414   87435 wait_for_pods.go:96] WaitForControlledPodsRunning: namespace(test-k411ju-1), labelSelector(name=small-deployment-119): Pods: 0 out of 0 created, 0 running (0 updated), 0 pending scheduled, 0 not scheduled, 0 inactive, 0 terminating, 0 unknown, 0 runningButNotReady 
... skipping 72 lines ...
I1124 20:17:15.302938   87435 wait_for_pods.go:96] WaitForControlledPodsRunning: namespace(test-k411ju-1), labelSelector(name=small-deployment-206): Pods: 0 out of 0 created, 0 running (0 updated), 0 pending scheduled, 0 not scheduled, 0 inactive, 0 terminating, 0 unknown, 0 runningButNotReady 
I1124 20:17:17.136790   87435 wait_for_pods.go:96] WaitForControlledPodsRunning: namespace(test-k411ju-1), labelSelector(name=small-deployment-296): Pods: 0 out of 0 created, 0 running (0 updated), 0 pending scheduled, 0 not scheduled, 0 inactive, 0 terminating, 0 unknown, 0 runningButNotReady 
I1124 20:17:17.466381   87435 wait_for_pods.go:96] WaitForControlledPodsRunning: namespace(test-k411ju-1), labelSelector(name=small-deployment-285): Pods: 0 out of 0 created, 0 running (0 updated), 0 pending scheduled, 0 not scheduled, 0 inactive, 0 terminating, 0 unknown, 0 runningButNotReady 
I1124 20:17:17.607127   87435 wait_for_pods.go:96] WaitForControlledPodsRunning: namespace(test-k411ju-1), labelSelector(name=small-deployment-115): Pods: 0 out of 0 created, 0 running (0 updated), 0 pending scheduled, 0 not scheduled, 0 inactive, 0 terminating, 0 unknown, 0 runningButNotReady 
I1124 20:17:17.618329   87435 wait_for_pods.go:96] WaitForControlledPodsRunning: namespace(test-k411ju-1), labelSelector(name=medium-deployment-19): Pods: 0 out of 0 created, 0 running (0 updated), 0 pending scheduled, 0 not scheduled, 0 inactive, 0 terminating, 0 unknown, 0 runningButNotReady 
I1124 20:17:18.084805   87435 wait_for_pods.go:96] WaitForControlledPodsRunning: namespace(test-k411ju-1), labelSelector(name=medium-deployment-15): Pods: 0 out of 0 created, 0 running (0 updated), 0 pending scheduled, 0 not scheduled, 0 inactive, 0 terminating, 0 unknown, 0 runningButNotReady 
E1124 20:17:19.321665   87435 etcd_metrics.go:147] EtcdMetrics: failed to collect etcd database size
I1124 20:17:20.120217   87435 wait_for_pods.go:96] WaitForControlledPodsRunning: namespace(test-k411ju-1), labelSelector(name=small-deployment-190): Pods: 0 out of 0 created, 0 running (0 updated), 0 pending scheduled, 0 not scheduled, 0 inactive, 0 terminating, 0 unknown, 0 runningButNotReady 
I1124 20:17:20.302285   87435 wait_for_pods.go:96] WaitForControlledPodsRunning: namespace(test-k411ju-1), labelSelector(name=small-deployment-183): Pods: 0 out of 0 created, 0 running (0 updated), 0 pending scheduled, 0 not scheduled, 0 inactive, 0 terminating, 0 unknown, 0 runningButNotReady 
I1124 20:17:20.617779   87435 wait_for_pods.go:96] WaitForControlledPodsRunning: namespace(test-k411ju-1), labelSelector(name=small-deployment-201): Pods: 0 out of 0 created, 0 running (0 updated), 0 pending scheduled, 0 not scheduled, 0 inactive, 0 terminating, 0 unknown, 0 runningButNotReady 
I1124 20:17:20.934278   87435 wait_for_pods.go:96] WaitForControlledPodsRunning: namespace(test-k411ju-1), labelSelector(name=small-deployment-243): Pods: 0 out of 0 created, 0 running (0 updated), 0 pending scheduled, 0 not scheduled, 0 inactive, 0 terminating, 0 unknown, 0 runningButNotReady 
I1124 20:17:23.384199   87435 wait_for_pods.go:96] WaitForControlledPodsRunning: namespace(test-k411ju-1), labelSelector(name=small-deployment-241): Pods: 0 out of 0 created, 0 running (0 updated), 0 pending scheduled, 0 not scheduled, 0 inactive, 0 terminating, 0 unknown, 0 runningButNotReady 
I1124 20:17:23.993852   87435 wait_for_pods.go:96] WaitForControlledPodsRunning: namespace(test-k411ju-1), labelSelector(name=small-deployment-15): Pods: 0 out of 0 created, 0 running (0 updated), 0 pending scheduled, 0 not scheduled, 0 inactive, 0 terminating, 0 unknown, 0 runningButNotReady 
... skipping 284 lines ...
Specify --start=59777 in the next get-serial-port-output invocation to get only the new output starting from here.
scp: /var/log/cluster-autoscaler.log*: No such file or directory
scp: /var/log/fluentd.log*: No such file or directory
scp: /var/log/kubelet.cov*: No such file or directory
scp: /var/log/cl2-**: No such file or directory
scp: /var/log/startupscript.log*: No such file or directory
ERROR: (gcloud.compute.scp) [/usr/bin/scp] exited with return code [1].
Dumping logs from nodes to GCS directly at 'gs://sig-scalability-logs/pull-kubernetes-e2e-gce-100-performance/1463591222525300736' using logexporter
Detecting nodes in the cluster
namespace/logexporter created
secret/google-service-account created
daemonset.apps/logexporter created
Listing marker files (gs://sig-scalability-logs/pull-kubernetes-e2e-gce-100-performance/1463591222525300736/logexported-nodes-registry) for successful nodes...
... skipping 397 lines ...