Logo AND Algorithmique Numérique Distribuée

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