argoproj / argoproj/argo-workflows

Error workflow sometimes try start pod when node doesn't have enough resources

Open
#9,268 4 comments 7 reactions 0 assignees View on GitHub
Dominant language
Go
Stars
17k
Forks
3.7k
Avg merge
1d 15h
Merged PRs (30d)
138

Description

## Checklist

* [x] Double-checked my configuration.
* [x] Tested using the latest version.
* [x] Used the Emissary executor.

## Summary

What happened/what you expected to happen?

In the kubernetes cluster, we have implemented cluster autoscaler, however, sometimes we received next error.

![Captura de pantalla 2022-08-01 a las 12 46 15](https://user-images.githubusercontent.com/34077334/182132012-08c67933-aaf4-4ca3-ae66-054f44d83767.png)

> Pod Node didn't have enough resource: cpu, requested: 1100, used: 950, capacity: 2000

But all steps are configured with requests and limits resources

The problem doesn't critical because we us retryStrategy, but I believe that it isn't a good solution.

But other times we get the next message:

> Unschedulable: 0/8 nodes are available: 1 Insufficient memory, 3 node(s) had taint {node-role.kubernetes.io/master: }, that the pod didn't tolerate, 5 Insufficient cpu.

Which I believe to be the correct operation, in this case works correct at the first attempt, once the node starts up.

What version are you running?

Kubernetes: 1.22.8
Argo-Workflows: 3.3.8

## Diagnostics

```bash
# Logs from the workflow controller:
kubectl logs -n argo deploy/workflow-controller | grep ${workflow}
time="2022-08-01T10:02:49.299Z" level=info msg="Processing workflow" namespace=argo-events workflow=workflow-problem
time="2022-08-01T10:02:49.658Z" level=info msg="Updated phase -> Running" namespace=argo-events workflow=workflow-problem
time="2022-08-01T10:02:49.658Z" level=info msg="Creating pvc workflow-problem-workdir" namespace=argo-events workflow=workflow-problem
time="2022-08-01T10:02:49.692Z" level=info msg="Retry node workflow-problem initialized Running" namespace=argo-events workflow=workflow-problem
time="2022-08-01T10:02:49.695Z" level=info msg="DAG node workflow-problem-3634127727 initialized Running" namespace=argo-events workflow=workflow-problem
time="2022-08-01T10:02:49.698Z" level=info msg="All of node workflow-problem(0).checkout dependencies [] completed" namespace=argo-events workflow=workflow-problem
time="2022-08-01T10:02:49.699Z" level=info msg="Retry node workflow-problem-3281735407 initialized Running" namespace=argo-events workflow=workflow-problem
time="2022-08-01T10:02:49.702Z" level=info msg="Pod node workflow-problem-3604343922 initialized Pending" namespace=argo-events workflow=workflow-problem
time="2022-08-01T10:02:49.738Z" level=info msg="Created pod: workflow-problem(0).checkout(0) (workflow-problem-3604343922)" namespace=argo-events workflow=workflow-problem
time="2022-08-01T10:02:49.739Z" level=info msg="TaskSet Reconciliation" namespace=argo-events workflow=workflow-problem
time="2022-08-01T10:02:49.739Z" level=info msg=reconcileAgentPod namespace=argo-events workflow=workflow-problem
time="2022-08-01T10:02:49.845Z" level=info msg="Workflow update successful" namespace=argo-events phase=Running resourceVersion=85421568 workflow=workflow-problem
time="2022-08-01T10:02:59.300Z" level=info msg="Processing workflow" namespace=argo-events workflow=workflow-problem
time="2022-08-01T10:02:59.301Z" level=info msg="Task-result reconciliation" namespace=argo-events numObjs=0 workflow=workflow-problem
time="2022-08-01T10:02:59.301Z" level=info msg="node changed" new.message=PodInitializing new.phase=Pending new.progress=0/1 nodeID=workflow-problem-3604343922 old.message= old.phase=Pending old.progress=0/1
time="2022-08-01T10:02:59.308Z" level=info msg="TaskSet Reconciliation" namespace=argo-events workflow=workflow-problem
time="2022-08-01T10:02:59.308Z" level=info msg=reconcileAgentPod namespace=argo-events workflow=workflow-problem
time="2022-08-01T10:02:59.360Z" level=info msg="Workflow update successful" namespace=argo-events phase=Running resourceVersion=85421645 workflow=workflow-problem
time="2022-08-01T10:03:15.177Z" level=info msg="Processing workflow" namespace=argo-events workflow=workflow-problem
time="2022-08-01T10:03:15.178Z" level=info msg="Task-result reconciliation" namespace=argo-events numObjs=1 workflow=workflow-problem
time="2022-08-01T10:03:15.178Z" level=info msg="task-result changed" namespace=argo-events nodeID=workflow-problem-3604343922 workflow=workflow-problem
time="2022-08-01T10:03:15.178Z" level=info msg="node changed" new.message= new.phase=Succeeded new.progress=0/1 nodeID=workflow-problem-3604343922 old.message=PodInitializing old.phase=Pending old.progress=0/1
time="2022-08-01T10:03:15.184Z" level=info msg="node workflow-problem-3281735407 phase Running -> Succeeded" namespace=argo-events workflow=workflow-problem
time="2022-08-01T10:03:15.184Z" level=info msg="node workflow-problem-3281735407 finished: 2022-08-01 10:03:15.184422367 +0000 UTC" namespace=argo-events workflow=workflow-problem
time="2022-08-01T10:03:15.185Z" level=info msg="All of node workflow-problem(0).install-dependencies dependencies [checkout] completed" namespace=argo-events workflow=workflow-problem
time="2022-08-01T10:03:15.186Z" level=info msg="Retry node workflow-problem-3466809896 initialized Running" namespace=argo-events workflow=workflow-problem
time="2022-08-01T10:03:15.186Z" level=info msg="Pod node workflow-problem-2980461115 initialized Pending" namespace=argo-events workflow=workflow-problem
time="2022-08-01T10:03:15.226Z" level=info msg="Created pod: workflow-problem(0).install-dependencies(0) (workflow-problem-2980461115)" namespace=argo-events workflow=workflow-problem
time="2022-08-01T10:03:15.226Z" level=info msg="TaskSet Reconciliation" namespace=argo-events workflow=workflow-problem
time="2022-08-01T10:03:15.226Z" level=info msg=reconcileAgentPod namespace=argo-events workflow=workflow-problem
time="2022-08-01T10:03:15.356Z" level=info msg="Workflow update successful" namespace=argo-events phase=Running resourceVersion=85421771 workflow=workflow-problem
time="2022-08-01T10:03:20.366Z" level=info msg="cleaning up pod" action=deletePod key=argo-events/workflow-problem-3604343922/deletePod
time="2022-08-01T10:03:25.294Z" level=info msg="Processing workflow" namespace=argo-events workflow=workflow-problem
time="2022-08-01T10:03:25.295Z" level=info msg="Task-result reconciliation" namespace=argo-events numObjs=1 workflow=workflow-problem
time="2022-08-01T10:03:25.296Z" level=info msg="node changed" new.message= new.phase=Running new.progress=0/1 nodeID=workflow-problem-2980461115 old.message= old.phase=Pending old.progress=0/1
time="2022-08-01T10:03:25.300Z" level=info msg="TaskSet Reconciliation" namespace=argo-events workflow=workflow-problem
time="2022-08-01T10:03:25.300Z" level=info msg=reconcileAgentPod namespace=argo-events workflow=workflow-problem
time="2022-08-01T10:03:25.372Z" level=info msg="Workflow update successful" namespace=argo-events phase=Running resourceVersion=85421850 workflow=workflow-problem
time="2022-08-01T10:03:35.360Z" level=info msg="Processing workflow" namespace=argo-events workflow=workflow-problem
time="2022-08-01T10:03:35.362Z" level=info msg="Task-result reconciliation" namespace=argo-events numObjs=1 workflow=workflow-problem
time="2022-08-01T10:03:35.363Z" level=info msg="node unchanged" nodeID=workflow-problem-2980461115
time="2022-08-01T10:03:35.387Z" level=info msg="TaskSet Reconciliation" namespace=argo-events workflow=workflow-problem
time="2022-08-01T10:03:35.387Z" level=info msg=reconcileAgentPod namespace=argo-events workflow=workflow-problem
time="2022-08-01T10:04:29.409Z" level=info msg="Processing workflow" namespace=argo-events workflow=workflow-problem
time="2022-08-01T10:04:29.410Z" level=info msg="Task-result reconciliation" namespace=argo-events numObjs=2 workflow=workflow-problem
time="2022-08-01T10:04:29.410Z" level=info msg="task-result changed" namespace=argo-events nodeID=workflow-problem-2980461115 workflow=workflow-problem
time="2022-08-01T10:04:29.410Z" level=info msg="node changed" new.message= new.phase=Succeeded new.progress=0/1 nodeID=workflow-problem-2980461115 old.message= old.phase=Running old.progress=0/1
time="2022-08-01T10:04:29.417Z" level=info msg="node workflow-problem-3466809896 phase Running -> Succeeded" namespace=argo-events workflow=workflow-problem
time="2022-08-01T10:04:29.418Z" level=info msg="node workflow-problem-3466809896 finished: 2022-08-01 10:04:29.418062242 +0000 UTC" namespace=argo-events workflow=workflow-problem
time="2022-08-01T10:04:29.418Z" level=info msg="All of node workflow-problem(0).unit-test dependencies [install-dependencies] completed" namespace=argo-events workflow=workflow-problem
time="2022-08-01T10:04:29.419Z" level=info msg="Retry node workflow-problem-1511311464 initialized Running" namespace=argo-events workflow=workflow-problem
time="2022-08-01T10:04:29.419Z" level=info msg="Pod node workflow-problem-2668797691 initialized Pending" namespace=argo-events workflow=workflow-problem
time="2022-08-01T10:04:29.460Z" level=info msg="Created pod: workflow-problem(0).unit-test(0) (workflow-problem-2668797691)" namespace=argo-events workflow=workflow-problem
time="2022-08-01T10:04:29.460Z" level=info msg="TaskSet Reconciliation" namespace=argo-events workflow=workflow-problem
time="2022-08-01T10:04:29.460Z" level=info msg=reconcileAgentPod namespace=argo-events workflow=workflow-problem
time="2022-08-01T10:04:29.518Z" level=info msg="Workflow update successful" namespace=argo-events phase=Running resourceVersion=85422304 workflow=workflow-problem
time="2022-08-01T10:04:34.534Z" level=info msg="cleaning up pod" action=deletePod key=argo-events/workflow-problem-2980461115/deletePod
time="2022-08-01T10:04:39.456Z" level=info msg="Processing workflow" namespace=argo-events workflow=workflow-problem
time="2022-08-01T10:04:39.457Z" level=info msg="Task-result reconciliation" namespace=argo-events numObjs=2 workflow=workflow-problem
time="2022-08-01T10:04:39.458Z" level=info msg="node changed" new.message= new.phase=Running new.progress=0/1 nodeID=workflow-problem-2668797691 old.message= old.phase=Pending old.progress=0/1
time="2022-08-01T10:04:39.467Z" level=info msg="TaskSet Reconciliation" namespace=argo-events workflow=workflow-problem
time="2022-08-01T10:04:39.467Z" level=info msg=reconcileAgentPod namespace=argo-events workflow=workflow-problem
time="2022-08-01T10:04:39.513Z" level=info msg="Workflow update successful" namespace=argo-events phase=Running resourceVersion=85422383 workflow=workflow-problem
time="2022-08-01T10:05:33.716Z" level=info msg="Processing workflow" namespace=argo-events workflow=workflow-problem
time="2022-08-01T10:05:33.717Z" level=info msg="Task-result reconciliation" namespace=argo-events numObjs=3 workflow=workflow-problem
time="2022-08-01T10:05:33.717Z" level=info msg="task-result changed" namespace=argo-events nodeID=workflow-problem-2668797691 workflow=workflow-problem
time="2022-08-01T10:05:33.720Z" level=info msg="node changed" new.message= new.phase=Succeeded new.progress=0/1 nodeID=workflow-problem-2668797691 old.message= old.phase=Running old.progress=0/1
time="2022-08-01T10:05:33.730Z" level=info msg="node workflow-problem-1511311464 phase Running -> Succeeded" namespace=argo-events workflow=workflow-problem
time="2022-08-01T10:05:33.731Z" level=info msg="node workflow-problem-1511311464 finished: 2022-08-01 10:05:33.731042729 +0000 UTC" namespace=argo-events workflow=workflow-problem
time="2022-08-01T10:05:33.731Z" level=info msg="All of node workflow-problem(0).code-analysis dependencies [unit-test] completed" namespace=argo-events workflow=workflow-problem
time="2022-08-01T10:05:33.732Z" level=info msg="Retry node workflow-problem-529018627 initialized Running" namespace=argo-events workflow=workflow-problem
time="2022-08-01T10:05:33.732Z" level=info msg="Pod node workflow-problem-1191980110 initialized Pending" namespace=argo-events workflow=workflow-problem
time="2022-08-01T10:05:33.807Z" level=info msg="Created pod: workflow-problem(0).code-analysis(0) (workflow-problem-1191980110)" namespace=argo-events workflow=workflow-problem
time="2022-08-01T10:05:33.807Z" level=info msg="TaskSet Reconciliation" namespace=argo-events workflow=workflow-problem
time="2022-08-01T10:05:33.807Z" level=info msg=reconcileAgentPod namespace=argo-events workflow=workflow-problem
time="2022-08-01T10:05:33.911Z" level=info msg="Workflow update successful" namespace=argo-events phase=Running resourceVersion=85422779 workflow=workflow-problem
time="2022-08-01T10:05:38.931Z" level=info msg="cleaning up pod" action=deletePod key=argo-events/workflow-problem-2668797691/deletePod
time="2022-08-01T10:05:43.809Z" level=info msg="Processing workflow" namespace=argo-events workflow=workflow-problem
time="2022-08-01T10:05:43.814Z" level=info msg="Task-result reconciliation" namespace=argo-events numObjs=3 workflow=workflow-problem
time="2022-08-01T10:05:43.815Z" level=info msg="node changed" new.message=PodInitializing new.phase=Pending new.progress=0/1 nodeID=workflow-problem-1191980110 old.message= old.phase=Pending old.progress=0/1
time="2022-08-01T10:05:43.832Z" level=info msg="TaskSet Reconciliation" namespace=argo-events workflow=workflow-problem
time="2022-08-01T10:05:43.833Z" level=info msg=reconcileAgentPod namespace=argo-events workflow=workflow-problem
time="2022-08-01T10:05:43.907Z" level=info msg="Workflow update successful" namespace=argo-events phase=Running resourceVersion=85422858 workflow=workflow-problem
time="2022-08-01T10:05:55.712Z" level=info msg="Processing workflow" namespace=argo-events workflow=workflow-problem
time="2022-08-01T10:05:55.713Z" level=info msg="Task-result reconciliation" namespace=argo-events numObjs=3 workflow=workflow-problem
time="2022-08-01T10:05:55.714Z" level=info msg="node changed" new.message= new.phase=Running new.progress=0/1 nodeID=workflow-problem-1191980110 old.message=PodInitializing old.phase=Pending old.progress=0/1
time="2022-08-01T10:05:55.720Z" level=info msg="TaskSet Reconciliation" namespace=argo-events workflow=workflow-problem
time="2022-08-01T10:05:55.720Z" level=info msg=reconcileAgentPod namespace=argo-events workflow=workflow-problem
time="2022-08-01T10:05:55.801Z" level=info msg="Workflow update successful" namespace=argo-events phase=Running resourceVersion=85422947 workflow=workflow-problem
time="2022-08-01T10:06:05.806Z" level=info msg="Processing workflow" namespace=argo-events workflow=workflow-problem
time="2022-08-01T10:06:05.807Z" level=info msg="Task-result reconciliation" namespace=argo-events numObjs=3 workflow=workflow-problem
time="2022-08-01T10:06:05.808Z" level=info msg="node unchanged" nodeID=workflow-problem-1191980110
time="2022-08-01T10:06:05.843Z" level=info msg="TaskSet Reconciliation" namespace=argo-events workflow=workflow-problem
time="2022-08-01T10:06:05.858Z" level=info msg=reconcileAgentPod namespace=argo-events workflow=workflow-problem
time="2022-08-01T10:07:38.998Z" level=info msg="Processing workflow" namespace=argo-events workflow=workflow-problem
time="2022-08-01T10:07:38.999Z" level=info msg="Task-result reconciliation" namespace=argo-events numObjs=4 workflow=workflow-problem
time="2022-08-01T10:07:38.999Z" level=info msg="task-result changed" namespace=argo-events nodeID=workflow-problem-1191980110 workflow=workflow-problem
time="2022-08-01T10:07:39.000Z" level=info msg="node changed" new.message= new.phase=Succeeded new.progress=0/1 nodeID=workflow-problem-1191980110 old.message= old.phase=Running old.progress=0/1
time="2022-08-01T10:07:39.011Z" level=info msg="node workflow-problem-529018627 phase Running -> Succeeded" namespace=argo-events workflow=workflow-problem
time="2022-08-01T10:07:39.011Z" level=info msg="node workflow-problem-529018627 finished: 2022-08-01 10:07:39.011440638 +0000 UTC" namespace=argo-events workflow=workflow-problem
time="2022-08-01T10:07:39.012Z" level=info msg="All of node workflow-problem(0).build-project dependencies [code-analysis] completed" namespace=argo-events workflow=workflow-problem
time="2022-08-01T10:07:39.012Z" level=info msg="Retry node workflow-problem-2672008721 initialized Running" namespace=argo-events workflow=workflow-problem
time="2022-08-01T10:07:39.013Z" level=info msg="Pod node workflow-problem-3962601320 initialized Pending" namespace=argo-events workflow=workflow-problem
time="2022-08-01T10:07:39.044Z" level=info msg="Created pod: workflow-problem(0).build-project(0) (workflow-problem-3962601320)" namespace=argo-events workflow=workflow-problem
time="2022-08-01T10:07:39.045Z" level=info msg="TaskSet Reconciliation" namespace=argo-events workflow=workflow-problem
time="2022-08-01T10:07:39.045Z" level=info msg=reconcileAgentPod namespace=argo-events workflow=workflow-problem
time="2022-08-01T10:07:39.113Z" level=info msg="Workflow update successful" namespace=argo-events phase=Running resourceVersion=85423678 workflow=workflow-problem
time="2022-08-01T10:07:44.139Z" level=info msg="cleaning up pod" action=deletePod key=argo-events/workflow-problem-1191980110/deletePod
time="2022-08-01T10:07:49.045Z" level=info msg="Processing workflow" namespace=argo-events workflow=workflow-problem
time="2022-08-01T10:07:49.046Z" level=info msg="Task-result reconciliation" namespace=argo-events numObjs=4 workflow=workflow-problem
time="2022-08-01T10:07:49.046Z" level=info msg="node changed" new.message= new.phase=Running new.progress=0/1 nodeID=workflow-problem-3962601320 old.message= old.phase=Pending old.progress=0/1
time="2022-08-01T10:07:49.052Z" level=info msg="TaskSet Reconciliation" namespace=argo-events workflow=workflow-problem
time="2022-08-01T10:07:49.052Z" level=info msg=reconcileAgentPod namespace=argo-events workflow=workflow-problem
time="2022-08-01T10:07:49.102Z" level=info msg="Workflow update successful" namespace=argo-events phase=Running resourceVersion=85423764 workflow=workflow-problem
time="2022-08-01T10:08:44.188Z" level=info msg="Processing workflow" namespace=argo-events workflow=workflow-problem
time="2022-08-01T10:08:44.189Z" level=info msg="Task-result reconciliation" namespace=argo-events numObjs=5 workflow=workflow-problem
time="2022-08-01T10:08:44.191Z" level=info msg="task-result changed" namespace=argo-events nodeID=workflow-problem-3962601320 workflow=workflow-problem
time="2022-08-01T10:08:44.191Z" level=info msg="node changed" new.message= new.phase=Succeeded new.progress=0/1 nodeID=workflow-problem-3962601320 old.message= old.phase=Running old.progress=0/1
time="2022-08-01T10:08:44.196Z" level=info msg="node workflow-problem-2672008721 phase Running -> Succeeded" namespace=argo-events workflow=workflow-problem
time="2022-08-01T10:08:44.196Z" level=info msg="node workflow-problem-2672008721 finished: 2022-08-01 10:08:44.196924672 +0000 UTC" namespace=argo-events workflow=workflow-problem
time="2022-08-01T10:08:44.198Z" level=info msg="All of node workflow-problem(0).build-image dependencies [build-project] completed" namespace=argo-events workflow=workflow-problem
time="2022-08-01T10:08:44.199Z" level=info msg="Retry node workflow-problem-1670788505 initialized Running" namespace=argo-events workflow=workflow-problem
time="2022-08-01T10:08:44.199Z" level=info msg="Pod node workflow-problem-3328874176 initialized Pending" namespace=argo-events workflow=workflow-problem
time="2022-08-01T10:08:44.244Z" level=info msg="Created pod: workflow-problem(0).build-image(0) (workflow-problem-3328874176)" namespace=argo-events workflow=workflow-problem
time="2022-08-01T10:08:44.244Z" level=info msg="TaskSet Reconciliation" namespace=argo-events workflow=workflow-problem
time="2022-08-01T10:08:44.244Z" level=info msg=reconcileAgentPod namespace=argo-events workflow=workflow-problem
time="2022-08-01T10:08:44.340Z" level=info msg="Workflow update successful" namespace=argo-events phase=Running resourceVersion=85424178 workflow=workflow-problem
time="2022-08-01T10:08:49.344Z" level=info msg="cleaning up pod" action=deletePod key=argo-events/workflow-problem-3962601320/deletePod
time="2022-08-01T10:08:54.243Z" level=info msg="Processing workflow" namespace=argo-events workflow=workflow-problem
time="2022-08-01T10:08:54.243Z" level=info msg="Task-result reconciliation" namespace=argo-events numObjs=5 workflow=workflow-problem
time="2022-08-01T10:08:54.244Z" level=info msg="node changed" new.message=PodInitializing new.phase=Pending new.progress=0/1 nodeID=workflow-problem-3328874176 old.message= old.phase=Pending old.progress=0/1
time="2022-08-01T10:08:54.249Z" level=info msg="TaskSet Reconciliation" namespace=argo-events workflow=workflow-problem
time="2022-08-01T10:08:54.249Z" level=info msg=reconcileAgentPod namespace=argo-events workflow=workflow-problem
time="2022-08-01T10:08:54.302Z" level=info msg="Workflow update successful" namespace=argo-events phase=Running resourceVersion=85424259 workflow=workflow-problem
time="2022-08-01T10:09:05.268Z" level=info msg="Processing workflow" namespace=argo-events workflow=workflow-problem
time="2022-08-01T10:09:05.269Z" level=info msg="Task-result reconciliation" namespace=argo-events numObjs=5 workflow=workflow-problem
time="2022-08-01T10:09:05.270Z" level=info msg="node changed" new.message= new.phase=Running new.progress=0/1 nodeID=workflow-problem-3328874176 old.message=PodInitializing old.phase=Pending old.progress=0/1
time="2022-08-01T10:09:05.278Z" level=info msg="TaskSet Reconciliation" namespace=argo-events workflow=workflow-problem
time="2022-08-01T10:09:05.278Z" level=info msg=reconcileAgentPod namespace=argo-events workflow=workflow-problem
time="2022-08-01T10:09:05.342Z" level=info msg="Workflow update successful" namespace=argo-events phase=Running resourceVersion=85424343 workflow=workflow-problem
time="2022-08-01T10:09:15.347Z" level=info msg="Processing workflow" namespace=argo-events workflow=workflow-problem
time="2022-08-01T10:09:15.348Z" level=info msg="Task-result reconciliation" namespace=argo-events numObjs=5 workflow=workflow-problem
time="2022-08-01T10:09:15.349Z" level=info msg="node unchanged" nodeID=workflow-problem-3328874176
time="2022-08-01T10:09:15.358Z" level=info msg="TaskSet Reconciliation" namespace=argo-events workflow=workflow-problem
time="2022-08-01T10:09:15.359Z" level=info msg=reconcileAgentPod namespace=argo-events workflow=workflow-problem
time="2022-08-01T10:09:37.347Z" level=info msg="Processing workflow" namespace=argo-events workflow=workflow-problem
time="2022-08-01T10:09:37.353Z" level=info msg="Task-result reconciliation" namespace=argo-events numObjs=6 workflow=workflow-problem
time="2022-08-01T10:09:37.353Z" level=info msg="task-result changed" namespace=argo-events nodeID=workflow-problem-3328874176 workflow=workflow-problem
time="2022-08-01T10:09:37.355Z" level=info msg="node changed" new.message= new.phase=Succeeded new.progress=0/1 nodeID=workflow-problem-3328874176 old.message= old.phase=Running old.progress=0/1
time="2022-08-01T10:09:37.391Z" level=info msg="node workflow-problem-1670788505 phase Running -> Succeeded" namespace=argo-events workflow=workflow-problem
time="2022-08-01T10:09:37.391Z" level=info msg="node workflow-problem-1670788505 finished: 2022-08-01 10:09:37.391316011 +0000 UTC" namespace=argo-events workflow=workflow-problem
time="2022-08-01T10:09:37.394Z" level=info msg="All of node workflow-problem(0).deploy-dev dependencies [build-image] completed" namespace=argo-events workflow=workflow-problem
time="2022-08-01T10:09:37.396Z" level=info msg="Retry node workflow-problem-1803627774 initialized Running" namespace=argo-events workflow=workflow-problem
time="2022-08-01T10:09:37.400Z" level=info msg="Pod node workflow-problem-3058589357 initialized Pending" namespace=argo-events workflow=workflow-problem
time="2022-08-01T10:09:37.437Z" level=info msg="Created pod: workflow-problem(0).deploy-dev(0) (workflow-problem-3058589357)" namespace=argo-events workflow=workflow-problem
time="2022-08-01T10:09:37.437Z" level=info msg="TaskSet Reconciliation" namespace=argo-events workflow=workflow-problem
time="2022-08-01T10:09:37.437Z" level=info msg=reconcileAgentPod namespace=argo-events workflow=workflow-problem
time="2022-08-01T10:09:37.532Z" level=info msg="Workflow update successful" namespace=argo-events phase=Running resourceVersion=85424585 workflow=workflow-problem
time="2022-08-01T10:09:42.546Z" level=info msg="cleaning up pod" action=deletePod key=argo-events/workflow-problem-3328874176/deletePod
time="2022-08-01T10:09:47.454Z" level=info msg="Processing workflow" namespace=argo-events workflow=workflow-problem
time="2022-08-01T10:09:47.456Z" level=info msg="Task-result reconciliation" namespace=argo-events numObjs=6 workflow=workflow-problem
time="2022-08-01T10:09:47.456Z" level=info msg="node changed" new.message=PodInitializing new.phase=Pending new.progress=0/1 nodeID=workflow-problem-3058589357 old.message= old.phase=Pending old.progress=0/1
time="2022-08-01T10:09:47.462Z" level=info msg="TaskSet Reconciliation" namespace=argo-events workflow=workflow-problem
time="2022-08-01T10:09:47.462Z" level=info msg=reconcileAgentPod namespace=argo-events workflow=workflow-problem
time="2022-08-01T10:09:47.534Z" level=info msg="Workflow update successful" namespace=argo-events phase=Running resourceVersion=85424661 workflow=workflow-problem
time="2022-08-01T10:10:03.434Z" level=info msg="Processing workflow" namespace=argo-events workflow=workflow-problem
time="2022-08-01T10:10:03.436Z" level=info msg="Task-result reconciliation" namespace=argo-events numObjs=7 workflow=workflow-problem
time="2022-08-01T10:10:03.436Z" level=info msg="task-result changed" namespace=argo-events nodeID=workflow-problem-3058589357 workflow=workflow-problem
time="2022-08-01T10:10:03.436Z" level=info msg="node changed" new.message= new.phase=Succeeded new.progress=0/1 nodeID=workflow-problem-3058589357 old.message=PodInitializing old.phase=Pending old.progress=0/1
time="2022-08-01T10:10:03.444Z" level=info msg="node workflow-problem-1803627774 phase Running -> Succeeded" namespace=argo-events workflow=workflow-problem
time="2022-08-01T10:10:03.444Z" level=info msg="node workflow-problem-1803627774 finished: 2022-08-01 10:10:03.444811889 +0000 UTC" namespace=argo-events workflow=workflow-problem
time="2022-08-01T10:10:03.445Z" level=info msg="All of node workflow-problem(0).smoke-test dependencies [deploy-dev] completed" namespace=argo-events workflow=workflow-problem
time="2022-08-01T10:10:03.445Z" level=info msg="Retry node workflow-problem-911625487 initialized Running" namespace=argo-events workflow=workflow-problem
time="2022-08-01T10:10:03.446Z" level=info msg="Pod node workflow-problem-3172818194 initialized Pending" namespace=argo-events workflow=workflow-problem
time="2022-08-01T10:10:03.472Z" level=info msg="Created pod: workflow-problem(0).smoke-test(0) (workflow-problem-3172818194)" namespace=argo-events workflow=workflow-problem
time="2022-08-01T10:10:03.472Z" level=info msg="TaskSet Reconciliation" namespace=argo-events workflow=workflow-problem
time="2022-08-01T10:10:03.472Z" level=info msg=reconcileAgentPod namespace=argo-events workflow=workflow-problem
time="2022-08-01T10:10:03.580Z" level=info msg="Workflow update successful" namespace=argo-events phase=Running resourceVersion=85424787 workflow=workflow-problem
time="2022-08-01T10:10:08.588Z" level=info msg="cleaning up pod" action=deletePod key=argo-events/workflow-problem-3058589357/deletePod
time="2022-08-01T10:10:13.474Z" level=info msg="Processing workflow" namespace=argo-events workflow=workflow-problem
time="2022-08-01T10:10:13.476Z" level=info msg="Task-result reconciliation" namespace=argo-events numObjs=7 workflow=workflow-problem
time="2022-08-01T10:10:13.476Z" level=info msg="node changed" new.message="Pod Node didn't have enough resource: cpu, requested: 1100, used: 950, capacity: 2000" new.phase=Failed new.progress=0/1 nodeID=workflow-problem-3172818194 old.message= old.phase=Pending old.progress=0/1
time="2022-08-01T10:10:13.481Z" level=info msg="1 child nodes of workflow-problem(0).smoke-test failed. Trying again..." namespace=argo-events workflow=workflow-problem
time="2022-08-01T10:10:13.481Z" level=info msg="Pod node workflow-problem-1494909199 initialized Pending" namespace=argo-events workflow=workflow-problem
time="2022-08-01T10:10:13.540Z" level=info msg="Created pod: workflow-problem(0).smoke-test(1) (workflow-problem-1494909199)" namespace=argo-events workflow=workflow-problem
time="2022-08-01T10:10:13.541Z" level=info msg="TaskSet Reconciliation" namespace=argo-events workflow=workflow-problem
time="2022-08-01T10:10:13.541Z" level=info msg=reconcileAgentPod namespace=argo-events workflow=workflow-problem
time="2022-08-01T10:10:13.624Z" level=info msg="Workflow update successful" namespace=argo-events phase=Running resourceVersion=85424869 workflow=workflow-problem
time="2022-08-01T10:10:13.632Z" level=info msg="cleaning up pod" action=labelPodCompleted key=argo-events/workflow-problem-3172818194/labelPodCompleted
time="2022-08-01T10:10:23.536Z" level=info msg="Processing workflow" namespace=argo-events workflow=workflow-problem
time="2022-08-01T10:10:23.537Z" level=info msg="Task-result reconciliation" namespace=argo-events numObjs=7 workflow=workflow-problem
time="2022-08-01T10:10:23.537Z" level=info msg="node changed" new.message= new.phase=Running new.progress=0/1 nodeID=workflow-problem-1494909199 old.message= old.phase=Pending old.progress=0/1
time="2022-08-01T10:10:23.548Z" level=info msg="TaskSet Reconciliation" namespace=argo-events workflow=workflow-problem
time="2022-08-01T10:10:23.548Z" level=info msg=reconcileAgentPod namespace=argo-events workflow=workflow-problem
time="2022-08-01T10:10:23.590Z" level=info msg="Workflow update successful" namespace=argo-events phase=Running resourceVersion=85424952 workflow=workflow-problem
time="2022-08-01T10:10:33.550Z" level=info msg="Processing workflow" namespace=argo-events workflow=workflow-problem
time="2022-08-01T10:10:33.551Z" level=info msg="Task-result reconciliation" namespace=argo-events numObjs=8 workflow=workflow-problem
time="2022-08-01T10:10:33.553Z" level=info msg="task-result changed" namespace=argo-events nodeID=workflow-problem-1494909199 workflow=workflow-problem
time="2022-08-01T10:10:33.554Z" level=info msg="node changed" new.message= new.phase=Succeeded new.progress=0/1 nodeID=workflow-problem-1494909199 old.message= old.phase=Running old.progress=0/1
time="2022-08-01T10:10:33.566Z" level=info msg="node workflow-problem-911625487 phase Running -> Succeeded" namespace=argo-events workflow=workflow-problem
time="2022-08-01T10:10:33.566Z" level=info msg="node workflow-problem-911625487 finished: 2022-08-01 10:10:33.566696344 +0000 UTC" namespace=argo-events workflow=workflow-problem
time="2022-08-01T10:10:33.569Z" level=info msg="All of node workflow-problem(0).e2e-test dependencies [smoke-test] completed" namespace=argo-events workflow=workflow-problem
time="2022-08-01T10:10:33.569Z" level=info msg="Retry node workflow-problem-4236232846 initialized Running" namespace=argo-events workflow=workflow-problem
time="2022-08-01T10:10:33.569Z" level=info msg="Pod node workflow-problem-1426571709 initialized Pending" namespace=argo-events workflow=workflow-problem
time="2022-08-01T10:10:33.599Z" level=info msg="Created pod: workflow-problem(0).e2e-test(0) (workflow-problem-1426571709)" namespace=argo-events workflow=workflow-problem
time="2022-08-01T10:10:33.599Z" level=info msg="TaskSet Reconciliation" namespace=argo-events workflow=workflow-problem
time="2022-08-01T10:10:33.599Z" level=info msg=reconcileAgentPod namespace=argo-events workflow=workflow-problem
time="2022-08-01T10:10:33.678Z" level=info msg="Workflow update successful" namespace=argo-events phase=Running resourceVersion=85425027 workflow=workflow-problem
time="2022-08-01T10:10:38.683Z" level=info msg="cleaning up pod" action=deletePod key=argo-events/workflow-problem-1494909199/deletePod
time="2022-08-01T10:10:43.600Z" level=info msg="Processing workflow" namespace=argo-events workflow=workflow-problem
time="2022-08-01T10:10:43.601Z" level=info msg="Task-result reconciliation" namespace=argo-events numObjs=8 workflow=workflow-problem
time="2022-08-01T10:10:43.601Z" level=info msg="node changed" new.message= new.phase=Running new.progress=0/1 nodeID=workflow-problem-1426571709 old.message= old.phase=Pending old.progress=0/1
time="2022-08-01T10:10:43.610Z" level=info msg="TaskSet Reconciliation" namespace=argo-events workflow=workflow-problem
time="2022-08-01T10:10:43.611Z" level=info msg=reconcileAgentPod namespace=argo-events workflow=workflow-problem
time="2022-08-01T10:10:43.676Z" level=info msg="Workflow update successful" namespace=argo-events phase=Running resourceVersion=85425108 workflow=workflow-problem
time="2022-08-01T10:10:53.634Z" level=info msg="Processing workflow" namespace=argo-events workflow=workflow-problem
time="2022-08-01T10:10:53.635Z" level=info msg="Task-result reconciliation" namespace=argo-events numObjs=9 workflow=workflow-problem
time="2022-08-01T10:10:53.636Z" level=info msg="task-result changed" namespace=argo-events nodeID=workflow-problem-1426571709 workflow=workflow-problem
time="2022-08-01T10:10:53.636Z" level=info msg="node changed" new.message= new.phase=Succeeded new.progress=0/1 nodeID=workflow-problem-1426571709 old.message= old.phase=Running old.progress=0/1
time="2022-08-01T10:10:53.641Z" level=info msg="node workflow-problem-4236232846 phase Running -> Succeeded" namespace=argo-events workflow=workflow-problem
time="2022-08-01T10:10:53.641Z" level=info msg="node workflow-problem-4236232846 finished: 2022-08-01 10:10:53.641563732 +0000 UTC" namespace=argo-events workflow=workflow-problem
time="2022-08-01T10:10:53.641Z" level=info msg="Outbound nodes of workflow-problem-3634127727 set to [workflow-problem-1426571709]" namespace=argo-events workflow=workflow-problem
time="2022-08-01T10:10:53.642Z" level=info msg="node workflow-problem-3634127727 phase Running -> Succeeded" namespace=argo-events workflow=workflow-problem
time="2022-08-01T10:10:53.642Z" level=info msg="node workflow-problem-3634127727 finished: 2022-08-01 10:10:53.642174491 +0000 UTC" namespace=argo-events workflow=workflow-problem
time="2022-08-01T10:10:53.642Z" level=info msg="Checking daemoned children of workflow-problem-3634127727" namespace=argo-events workflow=workflow-problem
time="2022-08-01T10:10:53.644Z" level=info msg="node workflow-problem phase Running -> Succeeded" namespace=argo-events workflow=workflow-problem
time="2022-08-01T10:10:53.644Z" level=info msg="node workflow-problem finished: 2022-08-01 10:10:53.644956252 +0000 UTC" namespace=argo-events workflow=workflow-problem
time="2022-08-01T10:10:53.645Z" level=info msg="TaskSet Reconciliation" namespace=argo-events workflow=workflow-problem
time="2022-08-01T10:10:53.645Z" level=info msg=reconcileAgentPod namespace=argo-events workflow=workflow-problem
time="2022-08-01T10:10:53.645Z" level=info msg="Updated phase Running -> Succeeded" namespace=argo-events workflow=workflow-problem
time="2022-08-01T10:10:53.645Z" level=info msg="Marking workflow completed" namespace=argo-events workflow=workflow-problem
time="2022-08-01T10:10:53.645Z" level=info msg="Marking workflow as pending archiving" namespace=argo-events workflow=workflow-problem
time="2022-08-01T10:10:53.645Z" level=info msg="Deleting PVC workflow-problem-workdir" namespace=argo-events workflow=workflow-problem
time="2022-08-01T10:10:53.651Z" level=info msg="cleaning up pod" action=deletePod key=argo-events/workflow-problem-1340600742-agent/deletePod
time="2022-08-01T10:10:53.666Z" level=info msg="Deleted 1/1 PVCs" namespace=argo-events workflow=workflow-problem
time="2022-08-01T10:10:53.666Z" level=info msg="Checking daemoned children of " namespace=argo-events workflow=workflow-problem
time="2022-08-01T10:10:53.781Z" level=info msg="Workflow update successful" namespace=argo-events phase=Succeeded resourceVersion=85425184 workflow=workflow-problem
time="2022-08-01T10:10:54.221Z" level=info msg="archiving workflow" namespace=argo-events uid=3c0839c6-76d0-4c0e-a85d-56547dc36c54 workflow=workflow-problem
time="2022-08-01T10:10:54.319Z" level=info msg="Queueing Succeeded workflow argo-events/workflow-problem for delete in 59s due to TTL"
time="2022-08-01T10:10:59.219Z" level=info msg="cleaning up pod" action=deletePod key=argo-events/workflow-problem-1426571709/deletePod
time="2022-08-01T10:11:54.000Z" level=info msg="Deleting garbage collected workflow 'argo-events/workflow-problem'"
time="2022-08-01T10:11:54.026Z" level=info msg="Successfully deleted 'argo-events/workflow-problem'"

---

**Message from the maintainers**:

Impacted by this bug? Give it a 👍. We prioritise the issues with the most 👍.

Contributor guide

Open the contributing guide

Research direction

Reproduce the resource-insufficient pod behavior with Kubernetes 1.22.8 and Argo Workflows 3.3.8, using the workflow-controller logs and the Emissary executor configuration shown in the report. Compare the erroneous pod-start behavior with the expected Unschedulable result; done means resource shortages are handled consistently with cluster autoscaler scheduling.

Written by the indexing model from the issue text.

Assessment

Tech stack
go, kubernetes
Domain
infrastructure
Issue type
Bug
Difficulty
4/5
Estimated time
3-5 days
Activity status
Stale
Clarity
Needs clarification
Newbie friendliness
35/100

Get new issues in your inbox

A short digest of beginner-friendly GitHub issues.