examples/msg/tracing/tasks.tesh

   1 #! ./tesh
   2
   3 p Tracing tasks
   4
   5 $ $SG_TEST_EXENV ${bindir:=.}/tracing/tasks$EXEEXT --cfg=tracing:1 --cfg=tracing/msg/task:1 --cfg=tracing/filename:tracing/tasks.trace ${srcdir:=.}/tracing/platform.xml ${srcdir:=.}/tracing/deployment.xml
   6 > [0.000000] [xbt_cfg/INFO] Configuration change: Set 'tracing' to '1'
   7 > [0.000000] [xbt_cfg/INFO] Configuration change: Set 'tracing/msg/task' to '1'
   8 > [0.000000] [xbt_cfg/INFO] Configuration change: Set 'tracing/filename' to 'tracing/tasks.trace'
   9 > [Tremblay:master:(1) 0.000000] [msg_test/INFO] master 20 50000000.000000 1000000.000000 5
  10 > [Tremblay:slave:(2) 0.002339] [msg_test/INFO] Executing task 50000000.000000
  11 > [Jupiter:slave:(3) 0.168300] [msg_test/INFO] Executing task 50000000.000000
  12 > [Fafard:slave:(4) 0.386454] [msg_test/INFO] Executing task 50000000.000000
  13 > [Tremblay:slave:(2) 0.512049] [msg_test/INFO] End of execution
  14 > [Ginette:slave:(5) 0.526913] [msg_test/INFO] Executing task 50000000.000000
  15 > [Bourassa:slave:(6) 0.742786] [msg_test/INFO] Executing task 50000000.000000
  16 > [Tremblay:slave:(2) 0.745124] [msg_test/INFO] Executing task 50000000.000000
  17 > [Jupiter:slave:(3) 0.823643] [msg_test/INFO] End of execution
  18 > [Jupiter:slave:(3) 0.989605] [msg_test/INFO] Executing task 50000000.000000
  19 > [Fafard:slave:(4) 1.041796] [msg_test/INFO] End of execution
  20 > [Tremblay:slave:(2) 1.254834] [msg_test/INFO] End of execution
  21 > [Fafard:slave:(4) 1.259949] [msg_test/INFO] Executing task 50000000.000000
  22 > [Tremblay:slave:(2) 1.262288] [msg_test/INFO] Executing task 50000000.000000
  23 > [Ginette:slave:(5) 1.558011] [msg_test/INFO] End of execution
  24 > [Jupiter:slave:(3) 1.644947] [msg_test/INFO] End of execution
  25 > [Ginette:slave:(5) 1.698471] [msg_test/INFO] Executing task 50000000.000000
  26 > [Tremblay:slave:(2) 1.771998] [msg_test/INFO] End of execution
  27 > [Bourassa:slave:(6) 1.773883] [msg_test/INFO] End of execution
  28 > [Jupiter:slave:(3) 1.864433] [msg_test/INFO] Executing task 50000000.000000
  29 > [Tremblay:slave:(2) 1.866771] [msg_test/INFO] Executing task 50000000.000000
  30 > [Fafard:slave:(4) 1.915291] [msg_test/INFO] End of execution
  31 > [Bourassa:slave:(6) 2.082643] [msg_test/INFO] Executing task 50000000.000000
  32 > [Fafard:slave:(4) 2.300797] [msg_test/INFO] Executing task 50000000.000000
  33 > [Tremblay:slave:(2) 2.376481] [msg_test/INFO] End of execution
  34 > [Tremblay:slave:(2) 2.378820] [msg_test/INFO] Executing task 50000000.000000
  35 > [Jupiter:slave:(3) 2.519775] [msg_test/INFO] End of execution
  36 > [Jupiter:slave:(3) 2.685737] [msg_test/INFO] Executing task 50000000.000000
  37 > [Ginette:slave:(5) 2.729569] [msg_test/INFO] End of execution
  38 > [Ginette:slave:(5) 2.870028] [msg_test/INFO] Executing task 50000000.000000
  39 > [Tremblay:slave:(2) 2.888530] [msg_test/INFO] End of execution
  40 > [Tremblay:slave:(2) 2.890868] [msg_test/INFO] Executing task 50000000.000000
  41 > [Fafard:slave:(4) 2.956139] [msg_test/INFO] End of execution
  42 > [Bourassa:slave:(6) 3.113741] [msg_test/INFO] End of execution
  43 > [Fafard:slave:(4) 3.174292] [msg_test/INFO] Executing task 50000000.000000
  44 > [Jupiter:slave:(3) 3.341079] [msg_test/INFO] End of execution
  45 > [Bourassa:slave:(6) 3.390164] [msg_test/INFO] Executing task 50000000.000000
  46 > [Tremblay:slave:(2) 3.400578] [msg_test/INFO] End of execution
  47 > [Fafard:slave:(4) 3.829634] [msg_test/INFO] End of execution
  48 > [Ginette:slave:(5) 3.901126] [msg_test/INFO] End of execution
  49 > [Bourassa:slave:(6) 4.421262] [msg_test/INFO] End of execution
  50 > [4.441598] [msg_test/INFO] Simulation time 4.4416
  51
  52
  53 $ cat tracing/tasks.trace
  54 > %EventDef PajeDefineContainerType 0
  55 > %       Alias string
  56 > %       ContainerType string
  57 > %       Name string
  58 > %EndEventDef
  59 > %EventDef PajeDefineVariableType 1
  60 > %       Alias string
  61 > %       ContainerType string
  62 > %       Name string
  63 > %       Color color
  64 > %EndEventDef
  65 > %EventDef PajeDefineStateType 2
  66 > %       Alias string
  67 > %       ContainerType string
  68 > %       Name string
  69 > %EndEventDef
  70 > %EventDef PajeDefineEventType 3
  71 > %       Alias string
  72 > %       EntityType string
  73 > %       Name string
  74 > %       Color color
  75 > %EndEventDef
  76 > %EventDef PajeDefineLinkType 4
  77 > %       Alias string
  78 > %       ContainerType string
  79 > %       SourceContainerType string
  80 > %       DestContainerType string
  81 > %       Name string
  82 > %EndEventDef
  83 > %EventDef PajeDefineEntityValue 5
  84 > %       Alias string
  85 > %       EntityType string
  86 > %       Name string
  87 > %       Color color
  88 > %EndEventDef
  89 > %EventDef PajeCreateContainer 6
  90 > %       Time date
  91 > %       Alias string
  92 > %       Type string
  93 > %       Container string
  94 > %       Name string
  95 > %EndEventDef
  96 > %EventDef PajeDestroyContainer 7
  97 > %       Time date
  98 > %       Type string
  99 > %       Container string
 100 > %EndEventDef
 101 > %EventDef PajeSetVariable 8
 102 > %       Time date
 103 > %       EntityType string
 104 > %       Container string
 105 > %       Value string
 106 > %EndEventDef
 107 > %EventDef PajeAddVariable 9
 108 > %       Time date
 109 > %       EntityType string
 110 > %       Container string
 111 > %       Value string
 112 > %EndEventDef
 113 > %EventDef PajeSubVariable 10
 114 > %       Time date
 115 > %       EntityType string
 116 > %       Container string
 117 > %       Value string
 118 > %EndEventDef
 119 > %EventDef PajeSetState 11
 120 > %       Time date
 121 > %       EntityType string
 122 > %       Container string
 123 > %       Value string
 124 > %EndEventDef
 125 > %EventDef PajePushState 12
 126 > %       Time date
 127 > %       EntityType string
 128 > %       Container string
 129 > %       Value string
 130 > %EndEventDef
 131 > %EventDef PajePopState 13
 132 > %       Time date
 133 > %       EntityType string
 134 > %       Container string
 135 > %EndEventDef
 136 > %EventDef PajeStartLink 14
 137 > %       Time date
 138 > %       EntityType string
 139 > %       Container string
 140 > %       Value string
 141 > %       SourceContainer string
 142 > %       Key string
 143 > %EndEventDef
 144 > %EventDef PajeEndLink 15
 145 > %       Time date
 146 > %       EntityType string
 147 > %       Container string
 148 > %       Value string
 149 > %       DestContainer string
 150 > %       Key string
 151 > %EndEventDef
 152 > %EventDef PajeNewEvent 16
 153 > %       Time date
 154 > %       EntityType string
 155 > %       Container string
 156 > %       Value string
 157 > %EndEventDef
 158 > 0 1 0 L1
 159 > 6 0 1 1 0 AS0
 160 > 0 2 1 HOST
 161 > 6 0 2 2 1 Tremblay
 162 > 1 3 2 power "1 1 1"
 163 > 0 4 2 MSG_TASK
 164 > 2 5 4 MSG_TASK_STATE
 165 > 5 6 5 MSG_task_execute "0 1 0"
 166 > 5 7 5 created "1 1 0"
 167 > 4 8 0 4 4 MSG_TASK_LINK
 168 > 6 0 3 2 1 Jupiter
 169 > 6 0 4 2 1 Fafard
 170 > 6 0 5 2 1 Ginette
 171 > 6 0 6 2 1 Bourassa
 172 > 0 9 1 ROUTER
 173 > 6 0 7 9 1 R.4-3
 174 > 6 0 8 9 1 R.3-2-5
 175 > 6 0 9 9 1 R.2-0
 176 > 6 0 10 9 1 R.1-0
 177 > 6 0 11 9 1 R.1-8-6
 178 > 6 0 12 9 1 R.6-7
 179 > 0 10 1 LINK
 180 > 6 0 13 10 1 6
 181 > 1 11 10 bandwidth "1 1 1"
 182 > 1 12 10 latency "1 1 1"
 183 > 6 0 14 10 1 11
 184 > 6 0 15 10 1 3
 185 > 6 0 16 10 1 7
 186 > 6 0 17 10 1 9
 187 > 6 0 18 10 1 12
 188 > 6 0 19 10 1 2
 189 > 6 0 20 10 1 8
 190 > 6 0 21 10 1 1
 191 > 6 0 22 10 1 4
 192 > 6 0 23 10 1 0
 193 > 6 0 24 10 1 10
 194 > 6 0 25 10 1 5
 195 > 6 0 26 10 1 loopback
 196 > 4 13 1 2 10 HOST-LINK
 197 > 4 14 1 10 9 LINK-ROUTER
 198 > 4 15 1 10 10 LINK-LINK
 199 > 4 16 1 10 2 LINK-HOST
 200 > 4 17 1 9 10 ROUTER-LINK
 201 > 8 0 3 2 98095000.000000
 202 > 8 0 3 3 76296000.000000
 203 > 8 0 3 4 76296000.000000
 204 > 8 0 3 5 48492000.000000
 205 > 8 0 3 6 48492000.000000
 206 > 8 0 11 13 41279125.000000
 207 > 8 0 12 13 0.000060
 208 > 8 0 11 14 252750.000000
 209 > 8 0 12 14 0.005705
 210 > 8 0 11 15 34285622.000000
 211 > 8 0 12 15 0.000514
 212 > 8 0 11 16 11618875.000000
 213 > 8 0 12 16 0.000190
 214 > 8 0 11 17 7209750.000000
 215 > 8 0 12 17 0.001462
 216 > 8 0 11 18 1792625.000000
 217 > 8 0 12 18 0.007878
 218 > 8 0 11 19 22222222.000000
 219 > 8 0 12 19 0.000137
 220 > 8 0 11 20 8158000.000000
 221 > 8 0 12 20 0.000271
 222 > 8 0 11 21 34285625.000000
 223 > 8 0 12 21 0.000514
 224 > 8 0 11 22 10099625.000000
 225 > 8 0 12 22 0.000480
 226 > 8 0 11 23 41279125.000000
 227 > 8 0 12 23 0.000060
 228 > 8 0 11 24 4679750.000000
 229 > 8 0 12 24 0.000849
 230 > 8 0 11 25 27946250.000000
 231 > 8 0 12 25 0.000278
 232 > 8 0 11 26 498000000.000000
 233 > 8 0 12 26 0.000015
 234 > 14 0 13 1 G 4 0
 235 > 15 0 13 1 G 26 0
 236 > 14 0 13 1 G 4 1
 237 > 15 0 13 1 G 20 1
 238 > 14 0 14 1 G 20 2
 239 > 15 0 14 1 G 11 2
 240 > 14 0 15 1 G 20 3
 241 > 15 0 15 1 G 21 3
 242 > 14 0 15 1 G 21 4
 243 > 15 0 15 1 G 23 4
 244 > 14 0 15 1 G 23 5
 245 > 15 0 15 1 G 19 5
 246 > 14 0 15 1 G 19 6
 247 > 15 0 15 1 G 15 6
 248 > 14 0 15 1 G 15 7
 249 > 15 0 15 1 G 22 7
 250 > 14 0 16 1 G 22 8
 251 > 15 0 16 1 G 2 8
 252 > 14 0 15 1 G 20 9
 253 > 15 0 15 1 G 13 9
 254 > 14 0 15 1 G 13 10
 255 > 15 0 15 1 G 16 10
 256 > 14 0 16 1 G 16 11
 257 > 15 0 16 1 G 6 11
 258 > 14 0 15 1 G 22 12
 259 > 15 0 15 1 G 17 12
 260 > 14 0 16 1 G 17 13
 261 > 15 0 16 1 G 3 13
 262 > 14 0 15 1 G 19 14
 263 > 15 0 15 1 G 25 14
 264 > 14 0 16 1 G 25 15
 265 > 15 0 16 1 G 5 15
 266 > 14 0 17 1 G 9 16
 267 > 15 0 17 1 G 19 16
 268 > 14 0 14 1 G 19 17
 269 > 15 0 14 1 G 8 17
 270 > 14 0 17 1 G 9 18
 271 > 15 0 17 1 G 23 18
 272 > 14 0 14 1 G 23 19
 273 > 15 0 14 1 G 10 19
 274 > 14 0 17 1 G 7 20
 275 > 15 0 17 1 G 15 20
 276 > 14 0 14 1 G 15 21
 277 > 15 0 14 1 G 8 21
 278 > 14 0 17 1 G 7 22
 279 > 15 0 17 1 G 22 22
 280 > 14 0 17 1 G 8 23
 281 > 15 0 17 1 G 25 23
 282 > 14 0 17 1 G 11 24
 283 > 15 0 17 1 G 13 24
 284 > 14 0 14 1 G 13 25
 285 > 15 0 14 1 G 12 25
 286 > 14 0 17 1 G 11 26
 287 > 15 0 17 1 G 21 26
 288 > 14 0 14 1 G 21 27
 289 > 15 0 14 1 G 10 27
 290 > 14 0 17 1 G 12 28
 291 > 15 0 17 1 G 16 28
 292 > 14 0 13 1 G 2 29
 293 > 15 0 13 1 G 26 29
 294 > 14 0 15 1 G 21 30
 295 > 15 0 15 1 G 13 30
 296 > 14 0 13 1 G 2 31
 297 > 15 0 13 1 G 17 31
 298 > 14 0 15 1 G 15 32
 299 > 15 0 15 1 G 25 32
 300 > 14 0 13 1 G 6 33
 301 > 15 0 13 1 G 26 33
 302 > 14 0 13 1 G 3 34
 303 > 15 0 13 1 G 26 34
 304 > 14 0 13 1 G 5 35
 305 > 15 0 13 1 G 26 35
 306 > 6 0 27 4 2 task-0
 307 > 1 18 4 compute "1 1 1"
 308 > 8 0 18 27 1.000000
 309 > 12 0 5 27 7
 310 > 13 0 5 27
 311 > 14 0 8 0 SR 27 0
 312 > 7 0 4 27
 313 > 6 0.002339 28 4 2 task-0
 314 > 6 0.002339 29 4 2 task-1
 315 > 8 0.002339 18 28 1.000000
 316 > 12 0.002339 5 28 7
 317 > 15 0.002339 8 0 SR 28 0
 318 > 12 0.002339 5 28 6
 319 > 8 0.002339 18 29 1.000000
 320 > 12 0.002339 5 29 7
 321 > 13 0.002339 5 29
 322 > 14 0.002339 8 0 SR 29 1
 323 > 7 0.002339 4 29
 324 > 6 0.168300 30 4 3 task-1
 325 > 6 0.168300 31 4 2 task-2
 326 > 8 0.168300 18 30 1.000000
 327 > 12 0.168300 5 30 7
 328 > 15 0.168300 8 0 SR 30 1
 329 > 12 0.168300 5 30 6
 330 > 8 0.168300 18 31 1.000000
 331 > 12 0.168300 5 31 7
 332 > 13 0.168300 5 31
 333 > 14 0.168300 8 0 SR 31 2
 334 > 7 0.168300 4 31
 335 > 6 0.386454 32 4 4 task-2
 336 > 6 0.386454 33 4 2 task-3
 337 > 8 0.386454 18 32 1.000000
 338 > 12 0.386454 5 32 7
 339 > 15 0.386454 8 0 SR 32 2
 340 > 12 0.386454 5 32 6
 341 > 8 0.386454 18 33 1.000000
 342 > 12 0.386454 5 33 7
 343 > 13 0.386454 5 33
 344 > 14 0.386454 8 0 SR 33 3
 345 > 7 0.386454 4 33
 346 > 13 0.512049 5 28
 347 > 7 0.512049 4 28
 348 > 6 0.526913 34 4 5 task-3
 349 > 6 0.526913 35 4 2 task-4
 350 > 8 0.526913 18 34 1.000000
 351 > 12 0.526913 5 34 7
 352 > 15 0.526913 8 0 SR 34 3
 353 > 12 0.526913 5 34 6
 354 > 8 0.526913 18 35 1.000000
 355 > 12 0.526913 5 35 7
 356 > 13 0.526913 5 35
 357 > 14 0.526913 8 0 SR 35 4
 358 > 7 0.526913 4 35
 359 > 6 0.742786 36 4 6 task-4
 360 > 6 0.742786 37 4 2 task-5
 361 > 8 0.742786 18 36 1.000000
 362 > 12 0.742786 5 36 7
 363 > 15 0.742786 8 0 SR 36 4
 364 > 12 0.742786 5 36 6
 365 > 8 0.742786 18 37 1.000000
 366 > 12 0.742786 5 37 7
 367 > 13 0.742786 5 37
 368 > 14 0.742786 8 0 SR 37 5
 369 > 7 0.742786 4 37
 370 > 6 0.745124 38 4 2 task-5
 371 > 6 0.745124 39 4 2 task-6
 372 > 8 0.745124 18 38 1.000000
 373 > 12 0.745124 5 38 7
 374 > 15 0.745124 8 0 SR 38 5
 375 > 12 0.745124 5 38 6
 376 > 8 0.745124 18 39 1.000000
 377 > 12 0.745124 5 39 7
 378 > 13 0.745124 5 39
 379 > 14 0.745124 8 0 SR 39 6
 380 > 7 0.745124 4 39
 381 > 13 0.823643 5 30
 382 > 7 0.823643 4 30
 383 > 6 0.989605 40 4 2 task-7
 384 > 8 0.989605 18 40 1.000000
 385 > 12 0.989605 5 40 7
 386 > 13 0.989605 5 40
 387 > 14 0.989605 8 0 SR 40 7
 388 > 7 0.989605 4 40
 389 > 6 0.989605 41 4 3 task-6
 390 > 8 0.989605 18 41 1.000000
 391 > 12 0.989605 5 41 7
 392 > 15 0.989605 8 0 SR 41 6
 393 > 12 0.989605 5 41 6
 394 > 13 1.041796 5 32
 395 > 7 1.041796 4 32
 396 > 13 1.254834 5 38
 397 > 7 1.254834 4 38
 398 > 6 1.259949 42 4 2 task-8
 399 > 8 1.259949 18 42 1.000000
 400 > 12 1.259949 5 42 7
 401 > 13 1.259949 5 42
 402 > 14 1.259949 8 0 SR 42 8
 403 > 7 1.259949 4 42
 404 > 6 1.259949 43 4 4 task-7
 405 > 6 1.262288 44 4 2 task-8
 406 > 6 1.262288 45 4 2 task-9
 407 > 8 1.259949 18 43 1.000000
 408 > 12 1.259949 5 43 7
 409 > 15 1.259949 8 0 SR 43 7
 410 > 12 1.259949 5 43 6
 411 > 8 1.262288 18 44 1.000000
 412 > 12 1.262288 5 44 7
 413 > 15 1.262288 8 0 SR 44 8
 414 > 12 1.262288 5 44 6
 415 > 8 1.262288 18 45 1.000000
 416 > 12 1.262288 5 45 7
 417 > 13 1.262288 5 45
 418 > 14 1.262288 8 0 SR 45 9
 419 > 7 1.262288 4 45
 420 > 13 1.558011 5 34
 421 > 7 1.558011 4 34
 422 > 13 1.644947 5 41
 423 > 7 1.644947 4 41
 424 > 6 1.698471 46 4 2 task-10
 425 > 8 1.698471 18 46 1.000000
 426 > 12 1.698471 5 46 7
 427 > 13 1.698471 5 46
 428 > 14 1.698471 8 0 SR 46 10
 429 > 7 1.698471 4 46
 430 > 6 1.698471 47 4 5 task-9
 431 > 8 1.698471 18 47 1.000000
 432 > 12 1.698471 5 47 7
 433 > 15 1.698471 8 0 SR 47 9
 434 > 12 1.698471 5 47 6
 435 > 13 1.771998 5 44
 436 > 7 1.771998 4 44
 437 > 13 1.773883 5 36
 438 > 7 1.773883 4 36
 439 > 6 1.864433 48 4 3 task-10
 440 > 6 1.864433 49 4 2 task-11
 441 > 8 1.864433 18 48 1.000000
 442 > 12 1.864433 5 48 7
 443 > 15 1.864433 8 0 SR 48 10
 444 > 12 1.864433 5 48 6
 445 > 8 1.864433 18 49 1.000000
 446 > 12 1.864433 5 49 7
 447 > 13 1.864433 5 49
 448 > 14 1.864433 8 0 SR 49 11
 449 > 7 1.864433 4 49
 450 > 6 1.866771 50 4 2 task-11
 451 > 6 1.866771 51 4 2 task-12
 452 > 8 1.866771 18 50 1.000000
 453 > 12 1.866771 5 50 7
 454 > 15 1.866771 8 0 SR 50 11
 455 > 12 1.866771 5 50 6
 456 > 8 1.866771 18 51 1.000000
 457 > 12 1.866771 5 51 7
 458 > 13 1.866771 5 51
 459 > 14 1.866771 8 0 SR 51 12
 460 > 7 1.866771 4 51
 461 > 13 1.915291 5 43
 462 > 7 1.915291 4 43
 463 > 6 2.082643 52 4 6 task-12
 464 > 6 2.082643 53 4 2 task-13
 465 > 8 2.082643 18 52 1.000000
 466 > 12 2.082643 5 52 7
 467 > 15 2.082643 8 0 SR 52 12
 468 > 12 2.082643 5 52 6
 469 > 8 2.082643 18 53 1.000000
 470 > 12 2.082643 5 53 7
 471 > 13 2.082643 5 53
 472 > 14 2.082643 8 0 SR 53 13
 473 > 7 2.082643 4 53
 474 > 6 2.300797 54 4 4 task-13
 475 > 6 2.300797 55 4 2 task-14
 476 > 8 2.300797 18 54 1.000000
 477 > 12 2.300797 5 54 7
 478 > 15 2.300797 8 0 SR 54 13
 479 > 12 2.300797 5 54 6
 480 > 8 2.300797 18 55 1.000000
 481 > 12 2.300797 5 55 7
 482 > 13 2.300797 5 55
 483 > 14 2.300797 8 0 SR 55 14
 484 > 7 2.300797 4 55
 485 > 13 2.376481 5 50
 486 > 7 2.376481 4 50
 487 > 6 2.378820 56 4 2 task-15
 488 > 8 2.378820 18 56 1.000000
 489 > 12 2.378820 5 56 7
 490 > 13 2.378820 5 56
 491 > 14 2.378820 8 0 SR 56 15
 492 > 7 2.378820 4 56
 493 > 6 2.378820 57 4 2 task-14
 494 > 8 2.378820 18 57 1.000000
 495 > 12 2.378820 5 57 7
 496 > 15 2.378820 8 0 SR 57 14
 497 > 12 2.378820 5 57 6
 498 > 13 2.519775 5 48
 499 > 7 2.519775 4 48
 500 > 6 2.685737 58 4 2 task-16
 501 > 8 2.685737 18 58 1.000000
 502 > 12 2.685737 5 58 7
 503 > 13 2.685737 5 58
 504 > 14 2.685737 8 0 SR 58 16
 505 > 7 2.685737 4 58
 506 > 6 2.685737 59 4 3 task-15
 507 > 8 2.685737 18 59 1.000000
 508 > 12 2.685737 5 59 7
 509 > 15 2.685737 8 0 SR 59 15
 510 > 12 2.685737 5 59 6
 511 > 13 2.729569 5 47
 512 > 7 2.729569 4 47
 513 > 6 2.870028 60 4 2 task-17
 514 > 8 2.870028 18 60 1.000000
 515 > 12 2.870028 5 60 7
 516 > 13 2.870028 5 60
 517 > 14 2.870028 8 0 SR 60 17
 518 > 7 2.870028 4 60
 519 > 6 2.870028 61 4 5 task-16
 520 > 8 2.870028 18 61 1.000000
 521 > 12 2.870028 5 61 7
 522 > 15 2.870028 8 0 SR 61 16
 523 > 12 2.870028 5 61 6
 524 > 13 2.888530 5 57
 525 > 7 2.888530 4 57
 526 > 6 2.890868 62 4 2 task-18
 527 > 8 2.890868 18 62 1.000000
 528 > 12 2.890868 5 62 7
 529 > 13 2.890868 5 62
 530 > 14 2.890868 8 0 SR 62 18
 531 > 7 2.890868 4 62
 532 > 6 2.890868 63 4 2 task-17
 533 > 8 2.890868 18 63 1.000000
 534 > 12 2.890868 5 63 7
 535 > 15 2.890868 8 0 SR 63 17
 536 > 12 2.890868 5 63 6
 537 > 13 2.956139 5 54
 538 > 7 2.956139 4 54
 539 > 13 3.113741 5 52
 540 > 7 3.113741 4 52
 541 > 6 3.174292 64 4 2 task-19
 542 > 8 3.174292 18 64 1.000000
 543 > 12 3.174292 5 64 7
 544 > 13 3.174292 5 64
 545 > 14 3.174292 8 0 SR 64 19
 546 > 7 3.174292 4 64
 547 > 6 3.174292 65 4 4 task-18
 548 > 8 3.174292 18 65 1.000000
 549 > 12 3.174292 5 65 7
 550 > 15 3.174292 8 0 SR 65 18
 551 > 12 3.174292 5 65 6
 552 > 13 3.341079 5 59
 553 > 7 3.341079 4 59
 554 > 6 3.390164 66 4 6 task-19
 555 > 6 3.390164 67 4 2 task-0
 556 > 1 19 4 finalize "1 1 1"
 557 > 8 3.390164 18 66 1.000000
 558 > 12 3.390164 5 66 7
 559 > 15 3.390164 8 0 SR 66 19
 560 > 12 3.390164 5 66 6
 561 > 8 3.390164 19 67 1.000000
 562 > 12 3.390164 5 67 7
 563 > 13 3.390164 5 67
 564 > 14 3.390164 8 0 SR 67 20
 565 > 7 3.390164 4 67
 566 > 13 3.400578 5 63
 567 > 7 3.400578 4 63
 568 > 6 3.405364 68 4 3 task-0
 569 > 8 3.405364 19 68 1.000000
 570 > 12 3.405364 5 68 7
 571 > 15 3.405364 8 0 SR 68 20
 572 > 7 3.405364 4 68
 573 > 6 3.405364 69 4 2 task-1
 574 > 8 3.405364 19 69 1.000000
 575 > 12 3.405364 5 69 7
 576 > 13 3.405364 5 69
 577 > 14 3.405364 8 0 SR 69 21
 578 > 7 3.405364 4 69
 579 > 6 3.405520 70 4 2 task-1
 580 > 8 3.405520 19 70 1.000000
 581 > 12 3.405520 5 70 7
 582 > 15 3.405520 8 0 SR 70 21
 583 > 7 3.405520 4 70
 584 > 6 3.405520 71 4 2 task-2
 585 > 8 3.405520 19 71 1.000000
 586 > 12 3.405520 5 71 7
 587 > 13 3.405520 5 71
 588 > 14 3.405520 8 0 SR 71 22
 589 > 7 3.405520 4 71
 590 > 13 3.829634 5 65
 591 > 7 3.829634 4 65
 592 > 6 3.850185 72 4 2 task-3
 593 > 8 3.850185 19 72 1.000000
 594 > 12 3.850185 5 72 7
 595 > 13 3.850185 5 72
 596 > 14 3.850185 8 0 SR 72 23
 597 > 7 3.850185 4 72
 598 > 6 3.850185 73 4 4 task-2
 599 > 8 3.850185 19 73 1.000000
 600 > 12 3.850185 5 73 7
 601 > 15 3.850185 8 0 SR 73 22
 602 > 7 3.850185 4 73
 603 > 13 3.901126 5 61
 604 > 7 3.901126 4 61
 605 > 6 3.914358 74 4 2 task-4
 606 > 8 3.914358 19 74 1.000000
 607 > 12 3.914358 5 74 7
 608 > 13 3.914358 5 74
 609 > 14 3.914358 8 0 SR 74 24
 610 > 7 3.914358 4 74
 611 > 6 3.914358 75 4 5 task-3
 612 > 8 3.914358 19 75 1.000000
 613 > 12 3.914358 5 75 7
 614 > 15 3.914358 8 0 SR 75 23
 615 > 7 3.914358 4 75
 616 > 13 4.421262 5 66
 617 > 7 4.421262 4 66
 618 > 6 4.441598 76 4 6 task-4
 619 > 8 4.441598 19 76 1.000000
 620 > 12 4.441598 5 76 7
 621 > 15 4.441598 8 0 SR 76 24
 622 > 7 4.441598 4 76
 623 > 7 4.441598 2 4
 624 > 7 4.441598 9 9
 625 > 7 4.441598 9 7
 626 > 7 4.441598 9 8
 627 > 7 4.441598 9 11
 628 > 7 4.441598 9 12
 629 > 7 4.441598 2 2
 630 > 7 4.441598 10 24
 631 > 7 4.441598 10 14
 632 > 7 4.441598 10 18
 633 > 7 4.441598 10 26
 634 > 7 4.441598 9 10
 635 > 7 4.441598 10 23
 636 > 7 4.441598 10 21
 637 > 7 4.441598 10 19
 638 > 7 4.441598 10 15
 639 > 7 4.441598 10 22
 640 > 7 4.441598 10 25
 641 > 7 4.441598 10 13
 642 > 7 4.441598 10 16
 643 > 7 4.441598 10 20
 644 > 7 4.441598 10 17
 645 > 7 4.441598 2 6
 646 > 7 4.441598 2 3
 647 > 7 4.441598 2 5
 648 > 7 4.441598 1 1
 649 > 7 4.441598 0 0
 650
 651 $ rm -rf tracing/tasks.trace