Subversion Repositories shark

Rev

Rev 1509 | Go to most recent revision | Details | Last modification | View Log | RSS feed

Rev Author Line No. Line
1506 giacomo 1
This is an example result file made through "extract" utility,
2
some comments are added to make it clearer.
3
 
4
Jumpball demo (ecp) statistics
5
 
6
Clk/msec = 651652 (CPU Pentium 3 - 650 MHz)
7
 
8
EVT:Log starts at [227521097059]
9
EVT:Log   ends at [239828158320]
10
 
11
Total dTSC [ 12307061261] us [    18885941]
12
Events     [       85737]
13
Execs      [       74832]
14
EndCycles  [       10862]
15
 
16
Exec TSC sum = 12307061261 (100.00)
17
 
18
Preemption Removing....
19
 
20
Compute Task Statistics....
21
 
22
Background Task CTX [    0] PID [NODEF]
23
  Total Execution dTSC [      516556] us [         792]
24
  Mean  CPU Bandwidth  [   0.004197%]
25
    after first exec   [   0.004197%]
26
  Execs Number         [           1]
27
  Min  Exec       dTSC [      516556] us [         792]
28
  Mean Exec       dTSC [      516556] us [         792]
29
  Max  Exec       dTSC [      516556] us [         792]
30
 
31
- Unknown context: this is the context running when the tracer
32
is enabled. Before the first context switch, the tracer doesn't
33
know who is executing... 792 unkwnown microseconds
34
 
35
Interrupts
36
  Total Execution dTSC [    57502840] us [       88241]
37
  Mean  CPU Bandwidth  [   0.467235%]
38
    after first int    [   0.467254%]
39
  Interrupts Number    [       20880]
40
  Min  Interrupt  dTSC [         606] us [           0]
41
  Mean Interrupt  dTSC [        2753] us [           4]
42
  Max  Interrupt  dTSC [       17724] us [          27]
43
 
44
  Min  Arr. Delta dTSC [        1108] us [           1]
45
  Mean Arr. Delta dTSC [      589421] us [         904]
46
  Max  Arr. Delta dTSC [     7478507] us [       11476]
47
 
48
- System Interrupts: All the hardware interrupts
49
 
50
Periodical Task CTX [  256] PID [NODEF]
51
  Total Execution dTSC [   111566216] us [      171205]
52
  Mean  CPU Bandwidth  [   0.906522%]
53
    after first exec   [   0.906560%]
54
  Execs Number         [        6053]
55
  Min  Exec       dTSC [         593] us [           0]
56
  Mean Exec       dTSC [       18431] us [          28]
57
  Max  Exec       dTSC [     1296917] us [        1990]
58
 
59
  Total Job Exec  dTSC [   111566216] us [      171205]
60
  Jobs Number          [        1450]
61
  Min  Job        dTSC [       74908] us [         114]
62
  Mean Job        dTSC [       76942] us [         118]
63
  Max  Job        dTSC [     2404229] us [        3689]
64
 
65
  Min  Arr. Delta dTSC [     4664213] us [        7157]
66
  Mean Arr. Delta dTSC [     8491748] us [       13031]
67
  Max  Arr. Delta dTSC [  2870899538] us [     4405571]
68
 
69
- Main task + palla0: Actually the extract utility doesn't elaborate
70
correctly this situation. The "main" task (pid 0) terminated after the system
71
beginning. Palla0 was created after this event, so it got the same context
72
number... statistics are not useful for this context
73
 
74
Periodical Task CTX [  296] PID [    5]
75
  Total Execution dTSC [   519672442] us [      797469]
76
  Mean  CPU Bandwidth  [   4.222555%]
77
    after first exec   [   4.223554%]
78
  Execs Number         [         561]
79
  Min  Exec       dTSC [       23230] us [          35]
80
  Mean Exec       dTSC [      926332] us [        1421]
81
  Max  Exec       dTSC [     2809219] us [        4310]
82
 
83
  Total Job Exec  dTSC [   519672442] us [      797469]
84
  Jobs Number          [         189]
85
  Min  Job        dTSC [     2706411] us [        4153]
86
  Mean Job        dTSC [     2749589] us [        4219]
87
  Max  Job        dTSC [     2809219] us [        4310]
88
 
89
  Min  Arr. Delta dTSC [    65129805] us [       99945]
90
  Mean Arr. Delta dTSC [    65149366] us [       99975]
91
  Max  Arr. Delta dTSC [    65169337] us [      100006]
92
 
93
- Task 5 "jetctrl" : Soft task
94
 
95
Periodical Task CTX [  304] PID [    6]
96
  Total Execution dTSC [     3204033] us [        4916]
97
  Mean  CPU Bandwidth  [   0.026034%]
98
    after first exec   [   0.026046%]
99
  Execs Number         [         378]
100
  Min  Exec       dTSC [        2971] us [           4]
101
  Mean Exec       dTSC [        8476] us [          13]
102
  Max  Exec       dTSC [       14336] us [          21]
103
 
104
  Total Job Exec  dTSC [     3204033] us [        4916]
105
  Jobs Number          [         189]
106
  Min  Job        dTSC [       16705] us [          25]
107
  Mean Job        dTSC [       16952] us [          26]
108
  Max  Job        dTSC [       19797] us [          30]
109
 
110
  Min  Arr. Delta dTSC [    62335693] us [       95657]
111
  Mean Arr. Delta dTSC [    65144811] us [       99968]
112
  Max  Arr. Delta dTSC [    67938428] us [      104255]
113
 
114
- Task 6 "jetdummy" : Soft Task
115
 
116
Periodical Task CTX [  312] PID [    7]
117
  Total Execution dTSC [   147655794] us [      226586]
118
  Mean  CPU Bandwidth  [   1.199765%]
119
    after first exec   [   1.200323%]
120
  Execs Number         [         601]
121
  Min  Exec       dTSC [       12701] us [          19]
122
  Mean Exec       dTSC [      245683] us [         377]
123
  Max  Exec       dTSC [      767697] us [        1178]
124
 
125
  Total Job Exec  dTSC [   147655794] us [      226586]
126
  Jobs Number          [         189]
127
  Min  Job        dTSC [      778980] us [        1195]
128
  Mean Job        dTSC [      781247] us [        1198]
129
  Max  Job        dTSC [      784959] us [        1204]
130
 
131
  Min  Arr. Delta dTSC [    62315034] us [       95626]
132
  Mean Arr. Delta dTSC [    65144799] us [       99968]
133
  Max  Arr. Delta dTSC [    67955268] us [      104281]
134
 
135
- Task 7 "jetslice": Soft Task
136
 
137
Periodical Task CTX [  320] PID [    8]
138
  Total Execution dTSC [   140490906] us [      215591]
139
  Mean  CPU Bandwidth  [   1.141547%]
140
    after first exec   [   1.141806%]
141
  Execs Number         [        5667]
142
  Min  Exec       dTSC [       22227] us [          34]
143
  Mean Exec       dTSC [       24791] us [          38]
144
  Max  Exec       dTSC [       35605] us [          54]
145
 
146
  Total Job Exec  dTSC [   140490906] us [      215591]
147
  Jobs Number          [        1889]
148
  Min  Job        dTSC [       73080] us [         112]
149
  Mean Job        dTSC [       74373] us [         114]
150
  Max  Job        dTSC [       86976] us [         133]
151
 
152
  Min  Arr. Delta dTSC [     6509377] us [        9989]
153
  Mean Arr. Delta dTSC [     6514942] us [        9997]
154
  Max  Arr. Delta dTSC [     6516991] us [       10000]
155
 
156
- Task 8 "pallaEDF": Hard Task
157
 
158
Background Task CTX [  264] PID [NODEF]
159
  Total Execution dTSC [ 10800997729] us [    16574794]
160
  Mean  CPU Bandwidth  [  87.762606%]
161
    after first exec   [  87.809315%]
162
  Execs Number         [        9520]
163
  Min  Exec       dTSC [        1077] us [           1]
164
  Mean Exec       dTSC [     1134558] us [        1741]
165
  Max  Exec       dTSC [     6438142] us [        9879]
166
 
167
- Task 1 "dummy": The dummy task, it represents the system
168
idle time, near 87% of mean value
169
 
170
Background Task CTX [  280] PID [NODEF]
171
  Total Execution dTSC [     1826185] us [        2802]
172
  Mean  CPU Bandwidth  [   0.014839%]
173
    after first exec   [   0.014862%]
174
  Execs Number         [         396]
175
  Min  Exec       dTSC [        2591] us [           3]
176
  Mean Exec       dTSC [        4611] us [           7]
177
  Max  Exec       dTSC [       11683] us [          17]
178
 
179
- Task 3 "interrupt server": The interrupt context
180
 
181
Periodical Task CTX [  288] PID [NODEF]
182
  Total Execution dTSC [      230386] us [         353]
183
  Mean  CPU Bandwidth  [   0.001872%]
184
    after first exec   [   0.002440%]
185
  Execs Number         [          44]
186
  Min  Exec       dTSC [        2064] us [           3]
187
  Mean Exec       dTSC [        5236] us [           8]
188
  Max  Exec       dTSC [       23701] us [          36]
189
 
190
  Total Job Exec  dTSC [      230386] us [         353]
191
  Jobs Number          [          17]
192
  Min  Job        dTSC [        4577] us [           7]
193
  Mean Job        dTSC [       13552] us [          20]
194
  Max  Job        dTSC [       31166] us [          47]
195
 
196
  Min  Arr. Delta dTSC [    75908314] us [      116485]
197
  Mean Arr. Delta dTSC [   590133555] us [      905596]
198
  Max  Arr. Delta dTSC [  3892330642] us [     5973020]
199
 
200
- Task 4 "key task": The task for keyboard handler
201
 
202
Periodical Task CTX [  328] PID [   10]
203
  Total Execution dTSC [   107254213] us [      164588]
204
  Mean  CPU Bandwidth  [   0.871485%]
205
    after first exec   [   1.178209%]
206
  Execs Number         [        6595]
207
  Min  Exec       dTSC [         593] us [           0]
208
  Mean Exec       dTSC [       16262] us [          24]
209
  Max  Exec       dTSC [       28584] us [          43]
210
 
211
  Total Job Exec  dTSC [   107254213] us [      164588]
212
  Jobs Number          [        1398]
213
  Min  Job        dTSC [       74241] us [         113]
214
  Mean Job        dTSC [       76719] us [         117]
215
  Max  Job        dTSC [       80220] us [         123]
216
 
217
  Min  Arr. Delta dTSC [     4901729] us [        7522]
218
  Mean Arr. Delta dTSC [     6514947] us [        9997]
219
  Max  Arr. Delta dTSC [     8128401] us [       12473]
220
 
221
- Task 10 "palla1": Soft Task
222
 
223
Periodical Task CTX [  336] PID [   11]
224
  Total Execution dTSC [    99733351] us [      153046]
225
  Mean  CPU Bandwidth  [   0.810375%]
226
    after first exec   [   1.145890%]
227
  Execs Number         [        5556]
228
  Min  Exec       dTSC [         593] us [           0]
229
  Mean Exec       dTSC [       17950] us [          27]
230
  Max  Exec       dTSC [       28056] us [          43]
231
 
232
  Total Job Exec  dTSC [    99733351] us [      153046]
233
  Jobs Number          [        1336]
234
  Min  Job        dTSC [       74232] us [         113]
235
  Mean Job        dTSC [       74650] us [         114]
236
  Max  Job        dTSC [       78187] us [         119]
237
 
238
  Min  Arr. Delta dTSC [     6513949] us [        9996]
239
  Mean Arr. Delta dTSC [     6514947] us [        9997]
240
  Max  Arr. Delta dTSC [     6515750] us [        9998]
241
 
242
- Task 11 "palla2": Soft Task
243
 
244
Periodical Task CTX [  344] PID [   12]
245
  Total Execution dTSC [    97526379] us [      149660]
246
  Mean  CPU Bandwidth  [   0.792442%]
247
    after first exec   [   1.168335%]
248
  Execs Number         [        6365]
249
  Min  Exec       dTSC [         593] us [           0]
250
  Mean Exec       dTSC [       15322] us [          23]
251
  Max  Exec       dTSC [       27742] us [          42]
252
 
253
  Total Job Exec  dTSC [    97526379] us [      149660]
254
  Jobs Number          [        1282]
255
  Min  Job        dTSC [       74299] us [         114]
256
  Mean Job        dTSC [       76073] us [         116]
257
  Max  Job        dTSC [       80211] us [         123]
258
 
259
  Min  Arr. Delta dTSC [     4715741] us [        7236]
260
  Mean Arr. Delta dTSC [     6514947] us [        9997]
261
  Max  Arr. Delta dTSC [     8314456] us [       12759]
262
 
263
- Task 12 "palla3": Soft Task
264
 
265
Periodical Task CTX [  352] PID [   13]
266
  Total Execution dTSC [    92464627] us [      141892]
267
  Mean  CPU Bandwidth  [   0.751314%]
268
    after first exec   [   1.154592%]
269
  Execs Number         [        5124]
270
  Min  Exec       dTSC [         593] us [           0]
271
  Mean Exec       dTSC [       18045] us [          27]
272
  Max  Exec       dTSC [       28894] us [          44]
273
 
274
  Total Job Exec  dTSC [    92464627] us [      141892]
275
  Jobs Number          [        1230]
276
  Min  Job        dTSC [       74777] us [         114]
277
  Mean Job        dTSC [       75174] us [         115]
278
  Max  Job        dTSC [       77966] us [         119]
279
 
280
  Min  Arr. Delta dTSC [     5278519] us [        8100]
281
  Mean Arr. Delta dTSC [     6514946] us [        9997]
282
  Max  Arr. Delta dTSC [     7751458] us [       11895]
283
 
284
- Task 13 "palla4": Soft Task
285
 
286
Periodical Task CTX [  360] PID [   14]
287
  Total Execution dTSC [    46390637] us [       71189]
288
  Mean  CPU Bandwidth  [   0.376943%]
289
    after first exec   [   1.148241%]
290
  Execs Number         [        2582]
291
  Min  Exec       dTSC [         594] us [           0]
292
  Mean Exec       dTSC [       17966] us [          27]
293
  Max  Exec       dTSC [       29618] us [          45]
294
 
295
  Total Job Exec  dTSC [    46390637] us [       71189]
296
  Jobs Number          [         621]
297
  Min  Job        dTSC [       74331] us [         114]
298
  Mean Job        dTSC [       74703] us [         114]
299
  Max  Job        dTSC [       79147] us [         121]
300
 
301
  Min  Arr. Delta dTSC [     6044798] us [        9276]
302
  Mean Arr. Delta dTSC [     6514943] us [        9997]
303
  Max  Arr. Delta dTSC [     6985324] us [       10719]
304
 
305
- Task 14 "palla5": Soft Task
306
 
307
Periodical Task CTX [  368] PID [   15]
308
  Total Execution dTSC [    41635493] us [       63892]
309
  Mean  CPU Bandwidth  [   0.338306%]
310
    after first exec   [   1.143778%]
311
  Execs Number         [        2323]
312
  Min  Exec       dTSC [         595] us [           0]
313
  Mean Exec       dTSC [       17923] us [          27]
314
  Max  Exec       dTSC [       28879] us [          44]
315
 
316
  Total Job Exec  dTSC [    41635493] us [       63892]
317
  Jobs Number          [         559]
318
  Min  Job        dTSC [       74213] us [         113]
319
  Mean Job        dTSC [       74482] us [         114]
320
  Max  Job        dTSC [       77867] us [         119]
321
 
322
  Min  Arr. Delta dTSC [     6514111] us [        9996]
323
  Mean Arr. Delta dTSC [     6514946] us [        9997]
324
  Max  Arr. Delta dTSC [     6515625] us [        9998]
325
 
326
- Task 15 "palla6": Soft Task
327
 
328
Periodical Task CTX [  376] PID [   16]
329
  Total Execution dTSC [    38373232] us [       58886]
330
  Mean  CPU Bandwidth  [   0.311798%]
331
    after first exec   [   1.150347%]
332
  Execs Number         [        2184]
333
  Min  Exec       dTSC [         595] us [           0]
334
  Mean Exec       dTSC [       17570] us [          26]
335
  Max  Exec       dTSC [       28905] us [          44]
336
 
337
  Total Job Exec  dTSC [    38373232] us [       58886]
338
  Jobs Number          [         513]
339
  Min  Job        dTSC [       74175] us [         113]
340
  Mean Job        dTSC [       74801] us [         114]
341
  Max  Job        dTSC [       78805] us [         120]
342
 
343
  Min  Arr. Delta dTSC [     6513761] us [        9995]
344
  Mean Arr. Delta dTSC [     6514945] us [        9997]
345
  Max  Arr. Delta dTSC [     6516034] us [        9999]
346
 
347
- Task 16 "palla7": Soft Task
348
 
349
Background Task CTX [  248] PID [NODEF]
350
  Total Execution dTSC [       17867] us [          27]
351
  Mean  CPU Bandwidth  [   0.000145%]
352
    after first exec   [  57.157939%]
353
  Execs Number         [           1]
354
  Min  Exec       dTSC [       17867] us [          27]
355
  Mean Exec       dTSC [       17867] us [          27]
356
  Max  Exec       dTSC [       17867] us [          27]
357
 
358
- Global context: the kernel context
359
 
360
Background Task CTX [  272] PID [NODEF]
361
  Total Execution dTSC [        2375] us [           3]
362
  Mean  CPU Bandwidth  [   0.000019%]
363
    after first exec   [ 100.000000%]
364
  Execs Number         [           1]
365
  Min  Exec       dTSC [        2375] us [           3]
366
  Mean Exec       dTSC [        2375] us [           3]
367
  Max  Exec       dTSC [        2375] us [           3]
368
 
369
- Task 2 "shutdown task": Shutting down the system. It closes
370
the tracer too (this is the reason of only 3 us exec time).