Thanks that cleared it up. I am using the Jenkins Mesos plugin and trying to figure out where latencies are coming from and this plugin is a big help. Thanks Victor.
tarted by user anonymous
Running: Execute sub-workflows in parallel : Start
[Task One] Running: Parallel branch: Task One
[Task Two] Running: Parallel branch: Task Two
[Task One] Running: Allocate node : Start
[Task Two] Running: Allocate node : Start
[Task One] Still waiting to schedule task
[Task One] Waiting for next available executor
[Task Two] Still waiting to schedule task
[Task Two] Waiting for next available executor
[Task One] Running on mesos-jenkins-1bb8e9c1-451c-41b1-a1cd-32711ca29d05 in /scratch/jenkins/workspace/Case 1 - Basic multi-task job
[Task One] Running: Allocate node : Body : Start
[Task One] Running: General Build Wrapper : Start
[Task One] Running: General Build Wrapper : Body : Start
[Task One] Running: Print Message
00:00:23.354 [Task One] Task One
[Task One] Running: Shell Script
00:00:24.662 [Task One] [Case 1 - Basic multi-task job] Running shell script
00:00:25.104 [Task One] + uname -a
00:00:25.104 [Task One] Linux sca00anu 3.8.13-35.3.1.el7uek.x86_64 #2 SMP Wed Jun 25 15:27:43 PDT 2014 x86_64 x86_64 x86_64 GNU/Linux
00:00:25.104 [Task One] + sleep 120
[Task Two] Running on mesos-jenkins-4061014a-666b-4b47-b3ce-080b964b9640 in /scratch/jenkins/workspace/Case 1 - Basic multi-task job
[Task Two] Running: Allocate node : Body : Start
[Task Two] Running: General Build Wrapper : Start
[Task Two] Running: General Build Wrapper : Body : Start
[Task Two] Running: Print Message
One minute delay for second mesos job to start
00:01:35.043 [Task Two] Task Two
[Task Two] Running: Shell Script
00:01:36.234 [Task Two] [Case 1 - Basic multi-task job] Running shell script
00:01:36.625 [Task Two] + uname -a
00:01:36.625 [Task Two] Linux sca00beo3.8.13-35.3.1.el7uek.x86_64 #2 SMP Wed Jun 25 15:27:43 PDT 2014 x86_64 x86_64 x86_64 GNU/Linux
00:01:36.625 [Task Two] + sleep 120
Running: General Build Wrapper : Body : End
Running: General Build Wrapper : End
Running: Allocate node : Body : End
Running: Allocate node : End
Running: Execute sub-workflows in parallel : Body : End
Running: General Build Wrapper : Body : End
Running: General Build Wrapper : End
Running: Allocate node : Body : End
Running: Allocate node : End
Running: Execute sub-workflows in parallel : Body : End
Running: Execute sub-workflows in parallel : End
Running: End of Workflow
Finished: SUCCESS
BTW if you switch the console output to text view the time values are lost.
Thanks for your help!!!!