olo@mbp /Users/olo kubectl logs -n argo-test deploy/workflow-controller | grep parallelism-nested-gtfdh time="2022-01-25T09:05:37.252Z" level=info msg="Processing workflow" namespace=argo-test workflow=parallelism-nested-gtfdh time="2022-01-25T09:05:37.276Z" level=info msg="Updated phase -> Running" namespace=argo-test workflow=parallelism-nested-gtfdh time="2022-01-25T09:05:37.280Z" level=info msg="Steps node parallelism-nested-gtfdh initialized Running" namespace=argo-test workflow=parallelism-nested-gtfdh time="2022-01-25T09:05:37.280Z" level=info msg="StepGroup node parallelism-nested-gtfdh-1970057705 initialized Running" namespace=argo-test workflow=parallelism-nested-gtfdh time="2022-01-25T09:05:37.285Z" level=info msg="argo-test/ConfigMap/my-config/count2 acquired by argo-test/parallelism-nested-gtfdh/parallelism-nested-gtfdh-3629111355 " semaphore=argo-test/ConfigMap/my-config/count2 time="2022-01-25T09:05:37.285Z" level=info msg="Node parallelism-nested-gtfdh[0].seq-step(0:1) acquired synchronization lock" namespace=argo-test workflow=parallelism-nested-gtfdh time="2022-01-25T09:05:37.285Z" level=info msg="Pod node parallelism-nested-gtfdh-3629111355 initialized Pending" namespace=argo-test workflow=parallelism-nested-gtfdh time="2022-01-25T09:05:37.321Z" level=info msg="Created pod: parallelism-nested-gtfdh[0].seq-step(0:1) (parallelism-nested-gtfdh-3629111355)" namespace=argo-test workflow=parallelism-nested-gtfdh time="2022-01-25T09:05:37.344Z" level=info msg="argo-test/ConfigMap/my-config/count2 acquired by argo-test/parallelism-nested-gtfdh/parallelism-nested-gtfdh-3112308281 " semaphore=argo-test/ConfigMap/my-config/count2 time="2022-01-25T09:05:37.344Z" level=info msg="Node parallelism-nested-gtfdh[0].seq-step(1:2) acquired synchronization lock" namespace=argo-test workflow=parallelism-nested-gtfdh time="2022-01-25T09:05:37.344Z" level=info msg="Pod node parallelism-nested-gtfdh-3112308281 initialized Pending" namespace=argo-test workflow=parallelism-nested-gtfdh time="2022-01-25T09:05:37.362Z" level=info msg="Created pod: parallelism-nested-gtfdh[0].seq-step(1:2) (parallelism-nested-gtfdh-3112308281)" namespace=argo-test workflow=parallelism-nested-gtfdh time="2022-01-25T09:05:37.366Z" level=info msg="Pod node parallelism-nested-gtfdh-616974379 initialized Pending" namespace=argo-test workflow=parallelism-nested-gtfdh time="2022-01-25T09:05:37.370Z" level=info msg="Pod node parallelism-nested-gtfdh-3339266557 initialized Pending" namespace=argo-test workflow=parallelism-nested-gtfdh time="2022-01-25T09:05:37.378Z" level=info msg="Pod node parallelism-nested-gtfdh-1369296587 initialized Pending" namespace=argo-test workflow=parallelism-nested-gtfdh time="2022-01-25T09:05:37.382Z" level=info msg="Pod node parallelism-nested-gtfdh-85415633 initialized Pending" namespace=argo-test workflow=parallelism-nested-gtfdh time="2022-01-25T09:05:37.387Z" level=info msg="Pod node parallelism-nested-gtfdh-1386970491 initialized Pending" namespace=argo-test workflow=parallelism-nested-gtfdh time="2022-01-25T09:05:37.399Z" level=info msg="Pod node parallelism-nested-gtfdh-26472525 initialized Pending" namespace=argo-test workflow=parallelism-nested-gtfdh time="2022-01-25T09:05:37.403Z" level=info msg="Pod node parallelism-nested-gtfdh-4061899387 initialized Pending" namespace=argo-test workflow=parallelism-nested-gtfdh time="2022-01-25T09:05:37.403Z" level=info msg="Workflow step group node parallelism-nested-gtfdh-1970057705 not yet completed" namespace=argo-test workflow=parallelism-nested-gtfdh time="2022-01-25T09:05:37.403Z" level=info msg="TaskSet Reconciliation" namespace=argo-test workflow=parallelism-nested-gtfdh time="2022-01-25T09:05:37.403Z" level=info msg=reconcileAgentPod namespace=argo-test workflow=parallelism-nested-gtfdh time="2022-01-25T09:05:37.418Z" level=info msg="Workflow update successful" namespace=argo-test phase=Running resourceVersion=22185545 workflow=parallelism-nested-gtfdh time="2022-01-25T09:05:47.323Z" level=info msg="Processing workflow" namespace=argo-test workflow=parallelism-nested-gtfdh time="2022-01-25T09:05:47.324Z" level=info msg="Updating node parallelism-nested-gtfdh-3112308281 status Pending -> Running" namespace=argo-test workflow=parallelism-nested-gtfdh time="2022-01-25T09:05:47.324Z" level=info msg="Updating node parallelism-nested-gtfdh-3629111355 status Pending -> Running" namespace=argo-test workflow=parallelism-nested-gtfdh time="2022-01-25T09:05:47.324Z" level=info msg="Workflow pod is missing" namespace=argo-test nodeName="parallelism-nested-gtfdh[0].seq-step(7:8)" nodePhase=Pending recentlyStarted=false workflow=parallelism-nested-gtfdh time="2022-01-25T09:05:47.324Z" level=info msg="Workflow pod is missing" namespace=argo-test nodeName="parallelism-nested-gtfdh[0].seq-step(3:4)" nodePhase=Pending recentlyStarted=false workflow=parallelism-nested-gtfdh time="2022-01-25T09:05:47.324Z" level=info msg="Workflow pod is missing" namespace=argo-test nodeName="parallelism-nested-gtfdh[0].seq-step(8:9)" nodePhase=Pending recentlyStarted=false workflow=parallelism-nested-gtfdh time="2022-01-25T09:05:47.324Z" level=info msg="Workflow pod is missing" namespace=argo-test nodeName="parallelism-nested-gtfdh[0].seq-step(2:3)" nodePhase=Pending recentlyStarted=false workflow=parallelism-nested-gtfdh time="2022-01-25T09:05:47.324Z" level=info msg="Workflow pod is missing" namespace=argo-test nodeName="parallelism-nested-gtfdh[0].seq-step(6:7)" nodePhase=Pending recentlyStarted=false workflow=parallelism-nested-gtfdh time="2022-01-25T09:05:47.324Z" level=info msg="Workflow pod is missing" namespace=argo-test nodeName="parallelism-nested-gtfdh[0].seq-step(5:6)" nodePhase=Pending recentlyStarted=false workflow=parallelism-nested-gtfdh time="2022-01-25T09:05:47.324Z" level=info msg="Workflow pod is missing" namespace=argo-test nodeName="parallelism-nested-gtfdh[0].seq-step(4:5)" nodePhase=Pending recentlyStarted=false workflow=parallelism-nested-gtfdh time="2022-01-25T09:05:47.330Z" level=info msg="Node parallelism-nested-gtfdh[0].seq-step(0:1) acquired synchronization lock" namespace=argo-test workflow=parallelism-nested-gtfdh time="2022-01-25T09:05:47.344Z" level=info msg="Node parallelism-nested-gtfdh[0].seq-step(1:2) acquired synchronization lock" namespace=argo-test workflow=parallelism-nested-gtfdh time="2022-01-25T09:05:47.390Z" level=info msg="Workflow step group node parallelism-nested-gtfdh-1970057705 not yet completed" namespace=argo-test workflow=parallelism-nested-gtfdh time="2022-01-25T09:05:47.390Z" level=info msg="TaskSet Reconciliation" namespace=argo-test workflow=parallelism-nested-gtfdh time="2022-01-25T09:05:47.390Z" level=info msg=reconcileAgentPod namespace=argo-test workflow=parallelism-nested-gtfdh time="2022-01-25T09:05:47.402Z" level=info msg="Workflow update successful" namespace=argo-test phase=Running resourceVersion=22185608 workflow=parallelism-nested-gtfdh time="2022-01-25T09:05:57.469Z" level=info msg="Processing workflow" namespace=argo-test workflow=parallelism-nested-gtfdh time="2022-01-25T09:05:57.469Z" level=info msg="Updating node parallelism-nested-gtfdh-3629111355 exit code 0" namespace=argo-test workflow=parallelism-nested-gtfdh time="2022-01-25T09:05:57.469Z" level=info msg="Setting node parallelism-nested-gtfdh-3629111355 outputs: {\"artifacts\":[{\"name\":\"main-logs\",\"s3\":{\"key\":\"my-artifacts/2022/01/25/parallelism-nested-gtfdh/parallelism-nested-gtfdh-3629111355/main.log\"}}]}" namespace=argo-test workflow=parallelism-nested-gtfdh time="2022-01-25T09:05:57.469Z" level=info msg="Updating node parallelism-nested-gtfdh-3629111355 status Running -> Succeeded" namespace=argo-test workflow=parallelism-nested-gtfdh time="2022-01-25T09:05:57.469Z" level=info msg="Updating node parallelism-nested-gtfdh-3112308281 exit code 0" namespace=argo-test workflow=parallelism-nested-gtfdh time="2022-01-25T09:05:57.469Z" level=info msg="Setting node parallelism-nested-gtfdh-3112308281 outputs: {\"artifacts\":[{\"name\":\"main-logs\",\"s3\":{\"key\":\"my-artifacts/2022/01/25/parallelism-nested-gtfdh/parallelism-nested-gtfdh-3112308281/main.log\"}}]}" namespace=argo-test workflow=parallelism-nested-gtfdh time="2022-01-25T09:05:57.469Z" level=info msg="Updating node parallelism-nested-gtfdh-3112308281 status Running -> Succeeded" namespace=argo-test workflow=parallelism-nested-gtfdh time="2022-01-25T09:05:57.469Z" level=info msg="Workflow pod is missing" namespace=argo-test nodeName="parallelism-nested-gtfdh[0].seq-step(8:9)" nodePhase=Pending recentlyStarted=false workflow=parallelism-nested-gtfdh time="2022-01-25T09:05:57.469Z" level=info msg="Workflow pod is missing" namespace=argo-test nodeName="parallelism-nested-gtfdh[0].seq-step(3:4)" nodePhase=Pending recentlyStarted=false workflow=parallelism-nested-gtfdh time="2022-01-25T09:05:57.469Z" level=info msg="Workflow pod is missing" namespace=argo-test nodeName="parallelism-nested-gtfdh[0].seq-step(7:8)" nodePhase=Pending recentlyStarted=false workflow=parallelism-nested-gtfdh time="2022-01-25T09:05:57.469Z" level=info msg="Workflow pod is missing" namespace=argo-test nodeName="parallelism-nested-gtfdh[0].seq-step(5:6)" nodePhase=Pending recentlyStarted=false workflow=parallelism-nested-gtfdh time="2022-01-25T09:05:57.469Z" level=info msg="Workflow pod is missing" namespace=argo-test nodeName="parallelism-nested-gtfdh[0].seq-step(4:5)" nodePhase=Pending recentlyStarted=false workflow=parallelism-nested-gtfdh time="2022-01-25T09:05:57.469Z" level=info msg="Workflow pod is missing" namespace=argo-test nodeName="parallelism-nested-gtfdh[0].seq-step(6:7)" nodePhase=Pending recentlyStarted=false workflow=parallelism-nested-gtfdh time="2022-01-25T09:05:57.469Z" level=info msg="Workflow pod is missing" namespace=argo-test nodeName="parallelism-nested-gtfdh[0].seq-step(2:3)" nodePhase=Pending recentlyStarted=false workflow=parallelism-nested-gtfdh time="2022-01-25T09:05:57.470Z" level=info msg="Lock has been released by argo-test/parallelism-nested-gtfdh/parallelism-nested-gtfdh-3629111355. Available locks: 1" semaphore=argo-test/ConfigMap/my-config/count2 time="2022-01-25T09:05:57.470Z" level=info msg="Lock has been released by argo-test/parallelism-nested-gtfdh/parallelism-nested-gtfdh-3112308281. Available locks: 2" semaphore=argo-test/ConfigMap/my-config/count2 time="2022-01-25T09:05:57.479Z" level=info msg="argo-test/ConfigMap/my-config/count2 acquired by argo-test/parallelism-nested-gtfdh/parallelism-nested-gtfdh-616974379 " semaphore=argo-test/ConfigMap/my-config/count2 time="2022-01-25T09:05:57.479Z" level=info msg="Node parallelism-nested-gtfdh[0].seq-step(2:3) acquired synchronization lock" namespace=argo-test workflow=parallelism-nested-gtfdh time="2022-01-25T09:05:57.493Z" level=info msg="Created pod: parallelism-nested-gtfdh[0].seq-step(2:3) (parallelism-nested-gtfdh-616974379)" namespace=argo-test workflow=parallelism-nested-gtfdh time="2022-01-25T09:05:57.497Z" level=info msg="argo-test/ConfigMap/my-config/count2 acquired by argo-test/parallelism-nested-gtfdh/parallelism-nested-gtfdh-4061899387 " semaphore=argo-test/ConfigMap/my-config/count2 time="2022-01-25T09:05:57.497Z" level=info msg="Node parallelism-nested-gtfdh[0].seq-step(3:4) acquired synchronization lock" namespace=argo-test workflow=parallelism-nested-gtfdh time="2022-01-25T09:05:57.512Z" level=info msg="Created pod: parallelism-nested-gtfdh[0].seq-step(3:4) (parallelism-nested-gtfdh-3339266557)" namespace=argo-test workflow=parallelism-nested-gtfdh time="2022-01-25T09:05:57.548Z" level=info msg="Workflow step group node parallelism-nested-gtfdh-1970057705 not yet completed" namespace=argo-test workflow=parallelism-nested-gtfdh time="2022-01-25T09:05:57.548Z" level=info msg="TaskSet Reconciliation" namespace=argo-test workflow=parallelism-nested-gtfdh time="2022-01-25T09:05:57.548Z" level=info msg=reconcileAgentPod namespace=argo-test workflow=parallelism-nested-gtfdh time="2022-01-25T09:05:57.565Z" level=info msg="Workflow update successful" namespace=argo-test phase=Running resourceVersion=22185671 workflow=parallelism-nested-gtfdh time="2022-01-25T09:05:57.571Z" level=info msg="cleaning up pod" action=labelPodCompleted key=argo-test/parallelism-nested-gtfdh-3629111355/labelPodCompleted time="2022-01-25T09:05:57.571Z" level=info msg="cleaning up pod" action=labelPodCompleted key=argo-test/parallelism-nested-gtfdh-3112308281/labelPodCompleted time="2022-01-25T09:06:07.472Z" level=info msg="Processing workflow" namespace=argo-test workflow=parallelism-nested-gtfdh time="2022-01-25T09:06:07.472Z" level=info msg="Updating node parallelism-nested-gtfdh-616974379 status Pending -> Running" namespace=argo-test workflow=parallelism-nested-gtfdh time="2022-01-25T09:06:07.472Z" level=info msg="Shutting down pod parallelism-nested-gtfdh-616974379" namespace=argo-test workflow=parallelism-nested-gtfdh time="2022-01-25T09:06:07.472Z" level=info msg="Updating node parallelism-nested-gtfdh-3339266557 exit code 0" namespace=argo-test workflow=parallelism-nested-gtfdh time="2022-01-25T09:06:07.472Z" level=info msg="Setting node parallelism-nested-gtfdh-3339266557 outputs: {\"artifacts\":[{\"name\":\"main-logs\",\"s3\":{\"key\":\"my-artifacts/2022/01/25/parallelism-nested-gtfdh/parallelism-nested-gtfdh-3339266557/main.log\"}}]}" namespace=argo-test workflow=parallelism-nested-gtfdh time="2022-01-25T09:06:07.473Z" level=info msg="Updating node parallelism-nested-gtfdh-3339266557 status Pending -> Succeeded" namespace=argo-test workflow=parallelism-nested-gtfdh time="2022-01-25T09:06:07.473Z" level=info msg="Workflow pod is missing" namespace=argo-test nodeName="parallelism-nested-gtfdh[0].seq-step(7:8)" nodePhase=Pending recentlyStarted=false workflow=parallelism-nested-gtfdh time="2022-01-25T09:06:07.473Z" level=info msg="Workflow pod is missing" namespace=argo-test nodeName="parallelism-nested-gtfdh[0].seq-step(5:6)" nodePhase=Pending recentlyStarted=false workflow=parallelism-nested-gtfdh time="2022-01-25T09:06:07.473Z" level=info msg="Workflow pod is missing" namespace=argo-test nodeName="parallelism-nested-gtfdh[0].seq-step(6:7)" nodePhase=Pending recentlyStarted=false workflow=parallelism-nested-gtfdh time="2022-01-25T09:06:07.473Z" level=info msg="Workflow pod is missing" namespace=argo-test nodeName="parallelism-nested-gtfdh[0].seq-step(4:5)" nodePhase=Pending recentlyStarted=false workflow=parallelism-nested-gtfdh time="2022-01-25T09:06:07.473Z" level=info msg="Workflow pod is missing" namespace=argo-test nodeName="parallelism-nested-gtfdh[0].seq-step(8:9)" nodePhase=Pending recentlyStarted=false workflow=parallelism-nested-gtfdh time="2022-01-25T09:06:07.478Z" level=info msg="cleaning up pod" action=shutdownPod key=argo-test/parallelism-nested-gtfdh-616974379/shutdownPod time="2022-01-25T09:06:07.479Z" level=info msg="https://172.20.0.1:443/api/v1/namespaces/argo-test/pods/parallelism-nested-gtfdh-616974379/exec?command=%2Fbin%2Fsh&command=-c&command=kill+-15+%24%28pidof+argoexec%29&container=wait&stderr=true&stdout=true&tty=false" time="2022-01-25T09:06:07.484Z" level=info msg="Node parallelism-nested-gtfdh[0].seq-step(2:3) acquired synchronization lock" namespace=argo-test workflow=parallelism-nested-gtfdh time="2022-01-25T09:06:07.484Z" level=info msg="Lock has been released by argo-test/parallelism-nested-gtfdh/parallelism-nested-gtfdh-3339266557. Available locks: 1" semaphore=argo-test/ConfigMap/my-config/count2 time="2022-01-25T09:06:07.488Z" level=info msg="argo-test/ConfigMap/my-config/count2 acquired by argo-test/parallelism-nested-gtfdh/parallelism-nested-gtfdh-26472525 " semaphore=argo-test/ConfigMap/my-config/count2 time="2022-01-25T09:06:07.488Z" level=info msg="Node parallelism-nested-gtfdh[0].seq-step(4:5) acquired synchronization lock" namespace=argo-test workflow=parallelism-nested-gtfdh time="2022-01-25T09:06:07.488Z" level=info msg="node parallelism-nested-gtfdh-1369296587 phase Pending -> Skipped" namespace=argo-test workflow=parallelism-nested-gtfdh time="2022-01-25T09:06:07.489Z" level=info msg="node parallelism-nested-gtfdh-1369296587 message: workflow shutdown with strategy: Terminate" namespace=argo-test workflow=parallelism-nested-gtfdh time="2022-01-25T09:06:07.489Z" level=info msg="node parallelism-nested-gtfdh-1369296587 finished: 2022-01-25 09:06:07.489036214 +0000 UTC" namespace=argo-test workflow=parallelism-nested-gtfdh time="2022-01-25T09:06:07.523Z" level=info msg="Workflow step group node parallelism-nested-gtfdh-1970057705 not yet completed" namespace=argo-test workflow=parallelism-nested-gtfdh time="2022-01-25T09:06:07.523Z" level=info msg="TaskSet Reconciliation" namespace=argo-test workflow=parallelism-nested-gtfdh time="2022-01-25T09:06:07.523Z" level=info msg=reconcileAgentPod namespace=argo-test workflow=parallelism-nested-gtfdh time="2022-01-25T09:06:07.534Z" level=info msg="Workflow update successful" namespace=argo-test phase=Running resourceVersion=22185743 workflow=parallelism-nested-gtfdh time="2022-01-25T09:06:07.540Z" level=info msg="cleaning up pod" action=labelPodCompleted key=argo-test/parallelism-nested-gtfdh-3339266557/labelPodCompleted time="2022-01-25T09:06:07.590Z" level=info msg="signaled container" container=wait error="" namespace=argo-test pod=parallelism-nested-gtfdh-616974379 stderr= stdout= time="2022-01-25T09:06:17.486Z" level=info msg="Processing workflow" namespace=argo-test workflow=parallelism-nested-gtfdh time="2022-01-25T09:06:17.486Z" level=info msg="Updating node parallelism-nested-gtfdh-616974379 exit code 0" namespace=argo-test workflow=parallelism-nested-gtfdh time="2022-01-25T09:06:17.486Z" level=info msg="Setting node parallelism-nested-gtfdh-616974379 outputs: {\"artifacts\":[{\"name\":\"main-logs\",\"s3\":{\"key\":\"my-artifacts/2022/01/25/parallelism-nested-gtfdh/parallelism-nested-gtfdh-616974379/main.log\"}}]}" namespace=argo-test workflow=parallelism-nested-gtfdh time="2022-01-25T09:06:17.486Z" level=info msg="Updating node parallelism-nested-gtfdh-616974379 status Running -> Succeeded" namespace=argo-test workflow=parallelism-nested-gtfdh time="2022-01-25T09:06:17.486Z" level=info msg="Workflow pod is missing" namespace=argo-test nodeName="parallelism-nested-gtfdh[0].seq-step(7:8)" nodePhase=Pending recentlyStarted=false workflow=parallelism-nested-gtfdh time="2022-01-25T09:06:17.486Z" level=info msg="Workflow pod is missing" namespace=argo-test nodeName="parallelism-nested-gtfdh[0].seq-step(8:9)" nodePhase=Pending recentlyStarted=false workflow=parallelism-nested-gtfdh time="2022-01-25T09:06:17.486Z" level=info msg="Workflow pod is missing" namespace=argo-test nodeName="parallelism-nested-gtfdh[0].seq-step(6:7)" nodePhase=Pending recentlyStarted=false workflow=parallelism-nested-gtfdh time="2022-01-25T09:06:17.486Z" level=info msg="Workflow pod is missing" namespace=argo-test nodeName="parallelism-nested-gtfdh[0].seq-step(5:6)" nodePhase=Pending recentlyStarted=false workflow=parallelism-nested-gtfdh time="2022-01-25T09:06:17.487Z" level=info msg="Lock has been released by argo-test/parallelism-nested-gtfdh/parallelism-nested-gtfdh-616974379. Available locks: 1" semaphore=argo-test/ConfigMap/my-config/count2 time="2022-01-25T09:06:17.487Z" level=info msg="Lock has been released by argo-test/parallelism-nested-gtfdh/parallelism-nested-gtfdh-1369296587. Available locks: 2" semaphore=argo-test/ConfigMap/my-config/count2 time="2022-01-25T09:06:17.493Z" level=info msg="argo-test/ConfigMap/my-config/count2 acquired by argo-test/parallelism-nested-gtfdh/parallelism-nested-gtfdh-1386970491 " semaphore=argo-test/ConfigMap/my-config/count2 time="2022-01-25T09:06:17.493Z" level=info msg="Node parallelism-nested-gtfdh[0].seq-step(5:6) acquired synchronization lock" namespace=argo-test workflow=parallelism-nested-gtfdh time="2022-01-25T09:06:17.493Z" level=info msg="node parallelism-nested-gtfdh-85415633 phase Pending -> Skipped" namespace=argo-test workflow=parallelism-nested-gtfdh time="2022-01-25T09:06:17.493Z" level=info msg="node parallelism-nested-gtfdh-85415633 message: workflow shutdown with strategy: Terminate" namespace=argo-test workflow=parallelism-nested-gtfdh time="2022-01-25T09:06:17.493Z" level=info msg="node parallelism-nested-gtfdh-85415633 finished: 2022-01-25 09:06:17.493405757 +0000 UTC" namespace=argo-test workflow=parallelism-nested-gtfdh time="2022-01-25T09:06:17.503Z" level=info msg="argo-test/ConfigMap/my-config/count2 acquired by argo-test/parallelism-nested-gtfdh/parallelism-nested-gtfdh-85415633 " semaphore=argo-test/ConfigMap/my-config/count2 time="2022-01-25T09:06:17.504Z" level=info msg="Node parallelism-nested-gtfdh[0].seq-step(6:7) acquired synchronization lock" namespace=argo-test workflow=parallelism-nested-gtfdh time="2022-01-25T09:06:17.504Z" level=info msg="node parallelism-nested-gtfdh-1386970491 phase Pending -> Skipped" namespace=argo-test workflow=parallelism-nested-gtfdh time="2022-01-25T09:06:17.504Z" level=info msg="node parallelism-nested-gtfdh-1386970491 message: workflow shutdown with strategy: Terminate" namespace=argo-test workflow=parallelism-nested-gtfdh time="2022-01-25T09:06:17.504Z" level=info msg="node parallelism-nested-gtfdh-1386970491 finished: 2022-01-25 09:06:17.50413747 +0000 UTC" namespace=argo-test workflow=parallelism-nested-gtfdh time="2022-01-25T09:06:17.512Z" level=info msg="Workflow step group node parallelism-nested-gtfdh-1970057705 not yet completed" namespace=argo-test workflow=parallelism-nested-gtfdh time="2022-01-25T09:06:17.512Z" level=info msg="TaskSet Reconciliation" namespace=argo-test workflow=parallelism-nested-gtfdh time="2022-01-25T09:06:17.512Z" level=info msg=reconcileAgentPod namespace=argo-test workflow=parallelism-nested-gtfdh time="2022-01-25T09:06:17.523Z" level=info msg="Workflow update successful" namespace=argo-test phase=Running resourceVersion=22185793 workflow=parallelism-nested-gtfdh time="2022-01-25T09:06:17.528Z" level=info msg="cleaning up pod" action=labelPodCompleted key=argo-test/parallelism-nested-gtfdh-616974379/labelPodCompleted time="2022-01-25T09:06:27.488Z" level=info msg="Processing workflow" namespace=argo-test workflow=parallelism-nested-gtfdh time="2022-01-25T09:06:27.488Z" level=info msg="Workflow pod is missing" namespace=argo-test nodeName="parallelism-nested-gtfdh[0].seq-step(7:8)" nodePhase=Pending recentlyStarted=false workflow=parallelism-nested-gtfdh time="2022-01-25T09:06:27.488Z" level=info msg="Workflow pod is missing" namespace=argo-test nodeName="parallelism-nested-gtfdh[0].seq-step(8:9)" nodePhase=Pending recentlyStarted=false workflow=parallelism-nested-gtfdh time="2022-01-25T09:06:27.489Z" level=info msg="Lock has been released by argo-test/parallelism-nested-gtfdh/parallelism-nested-gtfdh-85415633. Available locks: 1" semaphore=argo-test/ConfigMap/my-config/count2 time="2022-01-25T09:06:27.489Z" level=info msg="Lock has been released by argo-test/parallelism-nested-gtfdh/parallelism-nested-gtfdh-1386970491. Available locks: 2" semaphore=argo-test/ConfigMap/my-config/count2 time="2022-01-25T09:06:27.503Z" level=info msg="argo-test/ConfigMap/my-config/count2 acquired by argo-test/parallelism-nested-gtfdh/parallelism-nested-gtfdh-26472525 " semaphore=argo-test/ConfigMap/my-config/count2 time="2022-01-25T09:06:27.503Z" level=info msg="Node parallelism-nested-gtfdh[0].seq-step(7:8) acquired synchronization lock" namespace=argo-test workflow=parallelism-nested-gtfdh time="2022-01-25T09:06:27.503Z" level=info msg="node parallelism-nested-gtfdh-26472525 phase Pending -> Skipped" namespace=argo-test workflow=parallelism-nested-gtfdh time="2022-01-25T09:06:27.503Z" level=info msg="node parallelism-nested-gtfdh-26472525 message: workflow shutdown with strategy: Terminate" namespace=argo-test workflow=parallelism-nested-gtfdh time="2022-01-25T09:06:27.503Z" level=info msg="node parallelism-nested-gtfdh-26472525 finished: 2022-01-25 09:06:27.503689126 +0000 UTC" namespace=argo-test workflow=parallelism-nested-gtfdh time="2022-01-25T09:06:27.507Z" level=info msg="argo-test/ConfigMap/my-config/count2 acquired by argo-test/parallelism-nested-gtfdh/parallelism-nested-gtfdh-4061899387 " semaphore=argo-test/ConfigMap/my-config/count2 time="2022-01-25T09:06:27.507Z" level=info msg="Node parallelism-nested-gtfdh[0].seq-step(8:9) acquired synchronization lock" namespace=argo-test workflow=parallelism-nested-gtfdh time="2022-01-25T09:06:27.507Z" level=info msg="node parallelism-nested-gtfdh-4061899387 phase Pending -> Skipped" namespace=argo-test workflow=parallelism-nested-gtfdh time="2022-01-25T09:06:27.508Z" level=info msg="node parallelism-nested-gtfdh-4061899387 message: workflow shutdown with strategy: Terminate" namespace=argo-test workflow=parallelism-nested-gtfdh time="2022-01-25T09:06:27.508Z" level=info msg="node parallelism-nested-gtfdh-4061899387 finished: 2022-01-25 09:06:27.508025886 +0000 UTC" namespace=argo-test workflow=parallelism-nested-gtfdh time="2022-01-25T09:06:27.508Z" level=info msg="Step group node parallelism-nested-gtfdh-1970057705 successful" namespace=argo-test workflow=parallelism-nested-gtfdh time="2022-01-25T09:06:27.508Z" level=info msg="node parallelism-nested-gtfdh-1970057705 phase Running -> Succeeded" namespace=argo-test workflow=parallelism-nested-gtfdh time="2022-01-25T09:06:27.508Z" level=info msg="node parallelism-nested-gtfdh-1970057705 finished: 2022-01-25 09:06:27.508074925 +0000 UTC" namespace=argo-test workflow=parallelism-nested-gtfdh time="2022-01-25T09:06:27.508Z" level=info msg="Outbound nodes of parallelism-nested-gtfdh-3629111355 is [parallelism-nested-gtfdh-3629111355]" namespace=argo-test workflow=parallelism-nested-gtfdh time="2022-01-25T09:06:27.508Z" level=info msg="Outbound nodes of parallelism-nested-gtfdh-3112308281 is [parallelism-nested-gtfdh-3112308281]" namespace=argo-test workflow=parallelism-nested-gtfdh time="2022-01-25T09:06:27.508Z" level=info msg="Outbound nodes of parallelism-nested-gtfdh-616974379 is [parallelism-nested-gtfdh-616974379]" namespace=argo-test workflow=parallelism-nested-gtfdh time="2022-01-25T09:06:27.508Z" level=info msg="Outbound nodes of parallelism-nested-gtfdh-3339266557 is [parallelism-nested-gtfdh-3339266557]" namespace=argo-test workflow=parallelism-nested-gtfdh time="2022-01-25T09:06:27.508Z" level=info msg="Outbound nodes of parallelism-nested-gtfdh-1369296587 is [parallelism-nested-gtfdh-1369296587]" namespace=argo-test workflow=parallelism-nested-gtfdh time="2022-01-25T09:06:27.508Z" level=info msg="Outbound nodes of parallelism-nested-gtfdh-85415633 is [parallelism-nested-gtfdh-85415633]" namespace=argo-test workflow=parallelism-nested-gtfdh time="2022-01-25T09:06:27.508Z" level=info msg="Outbound nodes of parallelism-nested-gtfdh-1386970491 is [parallelism-nested-gtfdh-1386970491]" namespace=argo-test workflow=parallelism-nested-gtfdh time="2022-01-25T09:06:27.508Z" level=info msg="Outbound nodes of parallelism-nested-gtfdh-26472525 is [parallelism-nested-gtfdh-26472525]" namespace=argo-test workflow=parallelism-nested-gtfdh time="2022-01-25T09:06:27.508Z" level=info msg="Outbound nodes of parallelism-nested-gtfdh-4061899387 is [parallelism-nested-gtfdh-4061899387]" namespace=argo-test workflow=parallelism-nested-gtfdh time="2022-01-25T09:06:27.508Z" level=info msg="Outbound nodes of parallelism-nested-gtfdh is [parallelism-nested-gtfdh-3629111355 parallelism-nested-gtfdh-3112308281 parallelism-nested-gtfdh-616974379 parallelism-nested-gtfdh-3339266557 parallelism-nested-gtfdh-1369296587 parallelism-nested-gtfdh-85415633 parallelism-nested-gtfdh-1386970491 parallelism-nested-gtfdh-26472525 parallelism-nested-gtfdh-4061899387]" namespace=argo-test workflow=parallelism-nested-gtfdh time="2022-01-25T09:06:27.508Z" level=info msg="node parallelism-nested-gtfdh phase Running -> Succeeded" namespace=argo-test workflow=parallelism-nested-gtfdh time="2022-01-25T09:06:27.508Z" level=info msg="node parallelism-nested-gtfdh finished: 2022-01-25 09:06:27.508347203 +0000 UTC" namespace=argo-test workflow=parallelism-nested-gtfdh time="2022-01-25T09:06:27.508Z" level=info msg="Checking daemoned children of parallelism-nested-gtfdh" namespace=argo-test workflow=parallelism-nested-gtfdh time="2022-01-25T09:06:27.508Z" level=info msg="TaskSet Reconciliation" namespace=argo-test workflow=parallelism-nested-gtfdh time="2022-01-25T09:06:27.508Z" level=info msg=reconcileAgentPod namespace=argo-test workflow=parallelism-nested-gtfdh time="2022-01-25T09:06:27.508Z" level=info msg="Updated phase Running -> Succeeded" namespace=argo-test workflow=parallelism-nested-gtfdh time="2022-01-25T09:06:27.508Z" level=info msg="Marking workflow completed" namespace=argo-test workflow=parallelism-nested-gtfdh time="2022-01-25T09:06:27.508Z" level=info msg="Marking workflow as pending archiving" namespace=argo-test workflow=parallelism-nested-gtfdh time="2022-01-25T09:06:27.508Z" level=info msg="Checking daemoned children of " namespace=argo-test workflow=parallelism-nested-gtfdh time="2022-01-25T09:06:27.508Z" level=info msg="Lock has been released by argo-test/parallelism-nested-gtfdh/parallelism-nested-gtfdh-26472525. Available locks: 1" semaphore=argo-test/ConfigMap/my-config/count2 time="2022-01-25T09:06:27.508Z" level=info msg="argo-test/parallelism-nested-gtfdh/parallelism-nested-gtfdh-26472525 released a lock from argo-test/ConfigMap/my-config/count2" time="2022-01-25T09:06:27.508Z" level=info msg="Lock has been released by argo-test/parallelism-nested-gtfdh/parallelism-nested-gtfdh-4061899387. Available locks: 2" semaphore=argo-test/ConfigMap/my-config/count2 time="2022-01-25T09:06:27.508Z" level=info msg="argo-test/parallelism-nested-gtfdh/parallelism-nested-gtfdh-4061899387 released a lock from argo-test/ConfigMap/my-config/count2" time="2022-01-25T09:06:27.508Z" level=info msg="Released all acquired locks" key=parallelism-nested-gtfdh namespace=argo-test workflow=parallelism-nested-gtfdh time="2022-01-25T09:06:27.519Z" level=info msg="Workflow update successful" namespace=argo-test phase=Succeeded resourceVersion=22185845 workflow=parallelism-nested-gtfdh time="2022-01-25T09:06:27.523Z" level=info msg="archiving workflow" namespace=argo-test uid=ce6d44ad-6b3a-40b3-baaf-7f11fd7213d0 workflow=parallelism-nested-gtfdh time="2022-01-25T09:06:27.557Z" level=info msg="archiving workflow" namespace=argo-test uid=ce6d44ad-6b3a-40b3-baaf-7f11fd7213d0 workflow=parallelism-nested-gtfdh