5 $ $SG_TEST_EXENV ${bindir:=.}/tracing/tasks$EXEEXT --cfg=tracing:1 --cfg=tracing/buffer: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/buffer' to '1'
8 > [0.000000] [xbt_cfg/INFO] Configuration change: Set 'tracing/msg/task' to '1'
9 > [0.000000] [xbt_cfg/INFO] Configuration change: Set 'tracing/filename' to 'tracing/tasks.trace'
10 > [Tremblay:master:(1) 0.000000] [msg_test/INFO] master 20 50000000.000000 1000000.000000 5
11 > [Tremblay:slave:(2) 0.002164] [msg_test/INFO] Executing task 50000000.000000
12 > [Jupiter:slave:(3) 0.168126] [msg_test/INFO] Executing task 50000000.000000
13 > [Fafard:slave:(4) 0.386279] [msg_test/INFO] Executing task 50000000.000000
14 > [Tremblay:slave:(2) 0.511874] [msg_test/INFO] End of execution
15 > [Ginette:slave:(5) 0.526739] [msg_test/INFO] Executing task 50000000.000000
16 > [Bourassa:slave:(6) 0.742611] [msg_test/INFO] Executing task 50000000.000000
17 > [Tremblay:slave:(2) 0.744775] [msg_test/INFO] Executing task 50000000.000000
18 > [Jupiter:slave:(3) 0.823468] [msg_test/INFO] End of execution
19 > [Jupiter:slave:(3) 0.989430] [msg_test/INFO] Executing task 50000000.000000
20 > [Fafard:slave:(4) 1.041621] [msg_test/INFO] End of execution
21 > [Tremblay:slave:(2) 1.254485] [msg_test/INFO] End of execution
22 > [Fafard:slave:(4) 1.259775] [msg_test/INFO] Executing task 50000000.000000
23 > [Tremblay:slave:(2) 1.261939] [msg_test/INFO] Executing task 50000000.000000
24 > [Ginette:slave:(5) 1.557837] [msg_test/INFO] End of execution
25 > [Jupiter:slave:(3) 1.644772] [msg_test/INFO] End of execution
26 > [Ginette:slave:(5) 1.698296] [msg_test/INFO] Executing task 50000000.000000
27 > [Tremblay:slave:(2) 1.771649] [msg_test/INFO] End of execution
28 > [Bourassa:slave:(6) 1.773709] [msg_test/INFO] End of execution
29 > [Jupiter:slave:(3) 1.864258] [msg_test/INFO] Executing task 50000000.000000
30 > [Tremblay:slave:(2) 1.866422] [msg_test/INFO] Executing task 50000000.000000
31 > [Fafard:slave:(4) 1.915117] [msg_test/INFO] End of execution
32 > [Bourassa:slave:(6) 2.082294] [msg_test/INFO] Executing task 50000000.000000
33 > [Fafard:slave:(4) 2.300447] [msg_test/INFO] Executing task 50000000.000000
34 > [Tremblay:slave:(2) 2.376132] [msg_test/INFO] End of execution
35 > [Tremblay:slave:(2) 2.378296] [msg_test/INFO] Executing task 50000000.000000
36 > [Jupiter:slave:(3) 2.519600] [msg_test/INFO] End of execution
37 > [Jupiter:slave:(3) 2.685562] [msg_test/INFO] Executing task 50000000.000000
38 > [Ginette:slave:(5) 2.729394] [msg_test/INFO] End of execution
39 > [Ginette:slave:(5) 2.869854] [msg_test/INFO] Executing task 50000000.000000
40 > [Tremblay:slave:(2) 2.888006] [msg_test/INFO] End of execution
41 > [Tremblay:slave:(2) 2.890170] [msg_test/INFO] Executing task 50000000.000000
42 > [Fafard:slave:(4) 2.955790] [msg_test/INFO] End of execution
43 > [Bourassa:slave:(6) 3.113392] [msg_test/INFO] End of execution
44 > [Fafard:slave:(4) 3.173943] [msg_test/INFO] Executing task 50000000.000000
45 > [Jupiter:slave:(3) 3.340904] [msg_test/INFO] End of execution
46 > [Bourassa:slave:(6) 3.389815] [msg_test/INFO] Executing task 50000000.000000
47 > [Tremblay:slave:(2) 3.399880] [msg_test/INFO] End of execution
48 > [Fafard:slave:(4) 3.829285] [msg_test/INFO] End of execution
49 > [Ginette:slave:(5) 3.900952] [msg_test/INFO] End of execution
50 > [Bourassa:slave:(6) 4.420913] [msg_test/INFO] End of execution
51 > [4.441249] [msg_test/INFO] Simulation time 4.44125
53 $ cat tracing/tasks.trace
54 > %EventDef PajeDefineContainerType 0
56 > % ContainerType string
59 > %EventDef PajeDefineVariableType 1
61 > % ContainerType string
65 > %EventDef PajeDefineStateType 2
67 > % ContainerType string
70 > %EventDef PajeDefineEventType 3
76 > %EventDef PajeDefineLinkType 4
78 > % ContainerType string
79 > % SourceContainerType string
80 > % DestContainerType string
83 > %EventDef PajeDefineEntityValue 5
89 > %EventDef PajeCreateContainer 6
96 > %EventDef PajeDestroyContainer 7
101 > %EventDef PajeSetVariable 8
103 > % EntityType string
107 > %EventDef PajeAddVariable 9
109 > % EntityType string
113 > %EventDef PajeSubVariable 10
115 > % EntityType string
119 > %EventDef PajeSetState 11
121 > % EntityType string
125 > %EventDef PajePushState 12
127 > % EntityType string
131 > %EventDef PajePopState 13
133 > % EntityType string
136 > %EventDef PajeStartLink 14
138 > % EntityType string
141 > % SourceContainer string
144 > %EventDef PajeEndLink 15
146 > % EntityType string
149 > % DestContainer string
152 > %EventDef PajeNewEvent 16
154 > % EntityType string
160 > 1 2 1 power "1 1 1"
162 > 2 4 3 MSG_TASK_STATE
163 > 5 5 4 MSG_task_execute "0 1 0"
164 > 5 6 4 created "1 1 0"
165 > 4 7 0 3 3 MSG_TASK_LINK
172 > 1 9 8 bandwidth "1 1 1"
173 > 1 10 8 latency "1 1 1"
183 > 4 11 0 1 8 HOST-LINK
184 > 4 12 0 8 8 LINK-LINK
185 > 4 13 0 8 1 LINK-HOST
186 > 8 0 2 1 98095000.000000
187 > 8 0 2 2 76296000.000000
188 > 8 0 2 3 76296000.000000
189 > 8 0 2 4 48492000.000000
190 > 8 0 2 5 48492000.000000
191 > 8 0 9 6 41279125.000000
193 > 8 0 9 7 34285625.000000
195 > 8 0 9 8 11618875.000000
197 > 8 0 9 9 7209750.000000
199 > 8 0 9 10 118682500.000000
201 > 8 0 9 11 8158000.000000
203 > 8 0 9 12 34285625.000000
205 > 8 0 9 13 10099625.000000
207 > 8 0 9 14 41279125.000000
209 > 8 0 9 15 27946250.000000
246 > 1 14 3 compute "1 1 1"
252 > 6 0.002164 17 3 1 task-0
253 > 6 0.002164 18 3 1 task-1
254 > 8 0.002164 14 17 1.000000
256 > 15 0.002164 7 0 SR 17 0
258 > 8 0.002164 14 18 1.000000
261 > 14 0.002164 7 0 SR 18 1
263 > 6 0.168126 19 3 2 task-1
264 > 6 0.168126 20 3 1 task-2
265 > 8 0.168126 14 19 1.000000
267 > 15 0.168126 7 0 SR 19 1
269 > 8 0.168126 14 20 1.000000
272 > 14 0.168126 7 0 SR 20 2
274 > 6 0.386279 21 3 3 task-2
275 > 6 0.386279 22 3 1 task-3
276 > 8 0.386279 14 21 1.000000
278 > 15 0.386279 7 0 SR 21 2
280 > 8 0.386279 14 22 1.000000
283 > 14 0.386279 7 0 SR 22 3
287 > 6 0.526739 23 3 4 task-3
288 > 6 0.526739 24 3 1 task-4
289 > 8 0.526739 14 23 1.000000
291 > 15 0.526739 7 0 SR 23 3
293 > 8 0.526739 14 24 1.000000
296 > 14 0.526739 7 0 SR 24 4
298 > 6 0.742611 25 3 5 task-4
299 > 6 0.742611 26 3 1 task-5
300 > 8 0.742611 14 25 1.000000
302 > 15 0.742611 7 0 SR 25 4
304 > 8 0.742611 14 26 1.000000
307 > 14 0.742611 7 0 SR 26 5
309 > 6 0.744775 27 3 1 task-5
310 > 6 0.744775 28 3 1 task-6
311 > 8 0.744775 14 27 1.000000
313 > 15 0.744775 7 0 SR 27 5
315 > 8 0.744775 14 28 1.000000
318 > 14 0.744775 7 0 SR 28 6
322 > 6 0.989430 29 3 1 task-7
323 > 8 0.989430 14 29 1.000000
326 > 14 0.989430 7 0 SR 29 7
328 > 6 0.989430 30 3 2 task-6
329 > 8 0.989430 14 30 1.000000
331 > 15 0.989430 7 0 SR 30 6
337 > 6 1.259775 31 3 1 task-8
338 > 8 1.259775 14 31 1.000000
341 > 14 1.259775 7 0 SR 31 8
343 > 6 1.259775 32 3 3 task-7
344 > 6 1.261939 33 3 1 task-8
345 > 6 1.261939 34 3 1 task-9
346 > 8 1.259775 14 32 1.000000
348 > 15 1.259775 7 0 SR 32 7
350 > 8 1.261939 14 33 1.000000
352 > 15 1.261939 7 0 SR 33 8
354 > 8 1.261939 14 34 1.000000
357 > 14 1.261939 7 0 SR 34 9
363 > 6 1.698296 35 3 1 task-10
364 > 8 1.698296 14 35 1.000000
367 > 14 1.698296 7 0 SR 35 10
369 > 6 1.698296 36 3 4 task-9
370 > 8 1.698296 14 36 1.000000
372 > 15 1.698296 7 0 SR 36 9
378 > 6 1.864258 37 3 2 task-10
379 > 6 1.864258 38 3 1 task-11
380 > 8 1.864258 14 37 1.000000
382 > 15 1.864258 7 0 SR 37 10
384 > 8 1.864258 14 38 1.000000
387 > 14 1.864258 7 0 SR 38 11
389 > 6 1.866422 39 3 1 task-11
390 > 6 1.866422 40 3 1 task-12
391 > 8 1.866422 14 39 1.000000
393 > 15 1.866422 7 0 SR 39 11
395 > 8 1.866422 14 40 1.000000
398 > 14 1.866422 7 0 SR 40 12
402 > 6 2.082294 41 3 5 task-12
403 > 6 2.082294 42 3 1 task-13
404 > 8 2.082294 14 41 1.000000
406 > 15 2.082294 7 0 SR 41 12
408 > 8 2.082294 14 42 1.000000
411 > 14 2.082294 7 0 SR 42 13
413 > 6 2.300447 43 3 3 task-13
414 > 6 2.300447 44 3 1 task-14
415 > 8 2.300447 14 43 1.000000
417 > 15 2.300447 7 0 SR 43 13
419 > 8 2.300447 14 44 1.000000
422 > 14 2.300447 7 0 SR 44 14
426 > 6 2.378296 45 3 1 task-15
427 > 8 2.378296 14 45 1.000000
430 > 14 2.378296 7 0 SR 45 15
432 > 6 2.378296 46 3 1 task-14
433 > 8 2.378296 14 46 1.000000
435 > 15 2.378296 7 0 SR 46 14
439 > 6 2.685562 47 3 1 task-16
440 > 8 2.685562 14 47 1.000000
443 > 14 2.685562 7 0 SR 47 16
445 > 6 2.685562 48 3 2 task-15
446 > 8 2.685562 14 48 1.000000
448 > 15 2.685562 7 0 SR 48 15
452 > 6 2.869854 49 3 1 task-17
453 > 8 2.869854 14 49 1.000000
456 > 14 2.869854 7 0 SR 49 17
458 > 6 2.869854 50 3 4 task-16
459 > 8 2.869854 14 50 1.000000
461 > 15 2.869854 7 0 SR 50 16
465 > 6 2.890170 51 3 1 task-18
466 > 8 2.890170 14 51 1.000000
469 > 14 2.890170 7 0 SR 51 18
471 > 6 2.890170 52 3 1 task-17
472 > 8 2.890170 14 52 1.000000
474 > 15 2.890170 7 0 SR 52 17
480 > 6 3.173943 53 3 1 task-19
481 > 8 3.173943 14 53 1.000000
484 > 14 3.173943 7 0 SR 53 19
486 > 6 3.173943 54 3 3 task-18
487 > 8 3.173943 14 54 1.000000
489 > 15 3.173943 7 0 SR 54 18
493 > 6 3.389815 55 3 5 task-19
494 > 6 3.389815 56 3 1 task-0
495 > 1 15 3 finalize "1 1 1"
496 > 8 3.389815 14 55 1.000000
498 > 15 3.389815 7 0 SR 55 19
500 > 8 3.389815 15 56 1.000000
503 > 14 3.389815 7 0 SR 56 20
507 > 6 3.405015 57 3 2 task-0
508 > 8 3.405015 15 57 1.000000
510 > 15 3.405015 7 0 SR 57 20
512 > 6 3.405015 58 3 1 task-1
513 > 8 3.405015 15 58 1.000000
516 > 14 3.405015 7 0 SR 58 21
518 > 6 3.405171 59 3 1 task-1
519 > 8 3.405171 15 59 1.000000
521 > 15 3.405171 7 0 SR 59 21
523 > 6 3.405171 60 3 1 task-2
524 > 8 3.405171 15 60 1.000000
527 > 14 3.405171 7 0 SR 60 22
531 > 6 3.849836 61 3 1 task-3
532 > 8 3.849836 15 61 1.000000
535 > 14 3.849836 7 0 SR 61 23
537 > 6 3.849836 62 3 3 task-2
538 > 8 3.849836 15 62 1.000000
540 > 15 3.849836 7 0 SR 62 22
544 > 6 3.914183 63 3 1 task-4
545 > 8 3.914183 15 63 1.000000
548 > 14 3.914183 7 0 SR 63 24
550 > 6 3.914183 64 3 4 task-3
551 > 8 3.914183 15 64 1.000000
553 > 15 3.914183 7 0 SR 64 23
557 > 6 4.441249 65 3 5 task-4
558 > 8 4.441249 15 65 1.000000
560 > 15 4.441249 7 0 SR 65 24
579 $ rm -rf tracing/tasks.trace