WebSVN - shark - Blame - Rev 1521 - /demos/trunk/newtrace/utils/example

Rev	Author	Line No.	Line
1509	giacomo	1	This is an example file from "extract" utility,
1506	giacomo	2	some comments are added to make it clearer.
		3
		4	Jumpball demo (ecp) statistics
		5
1521	giacomo	6	Clk/msec = 2202900 (CPU Athlon 64 3200+)
1506	giacomo	7
1521	giacomo	8	EVT:Log starts at [147140694139]
		9	EVT:Log ends at [196093930505]
1506	giacomo	10
1521	giacomo	11	Total dTSC [ 48953236366] ns [ 22222113928]
		12	Events [ 144915]
		13	Execs [ 131127]
		14	EndCycles [ 13759]
1506	giacomo	15
		16	Preemption Removing....
		17
1521	giacomo	18	Total nsec of jobs [ 3604781671]
		19	Total nsec of exec [ 22222113928]
		20	Total nsec considering last clk/msec [ 22222178204]
		21
1506	giacomo	22	Compute Task Statistics....
		23
		24	Interrupts
1521	giacomo	25	Total Execution [ 29399348 ns]
		26	Mean CPU Bandwidth [ 0.132298% ]
		27	after first int [ 0.132298% ]
		28	Interrupts Number [ 45842 ]
		29	Min Interrupt [ 189 ns]
		30	Mean Interrupt [ 641 ns]
		31	Max Interrupt [ 13056 ns]
1506	giacomo	32
1521	giacomo	33	Min Arr. Delta [ 1881 ns]
		34	Mean Arr. Delta [ 484763 ns]
		35	Max Arr. Delta [ 10000131 ns]
1506	giacomo	36
		37	- System Interrupts: All the hardware interrupts
		38
1509	giacomo	39	Periodical Task CTX [ 256] PID [ 9]
1521	giacomo	40	Total Execution [ 276253550 ns]
		41	Mean CPU Bandwidth [ 1.243147% ]
		42	after first exec [ 1.630252% ]
		43	Execs Number [ 9335 ]
		44	Min Exec [ 240 ns]
		45	Mean Exec [ 29593 ns]
		46	Max Exec [ 91661 ns]
1506	giacomo	47
1521	giacomo	48	Total Job Exec [ 276253550 ns]
		49	Jobs Number [ 1695 ]
		50	Min Job [ 162239 ns]
		51	Mean Job [ 162981 ns]
		52	Max Job [ 164505 ns]
1506	giacomo	53
1521	giacomo	54	Min Arr. Delta [ 4411818 ns]
		55	Mean Arr. Delta [ 9999965 ns]
		56	Max Arr. Delta [ 15588054 ns]
1506	giacomo	57
1509	giacomo	58	- Task 9 "palla0": Soft Task. The CTX 256 was at the beginning assigned
		59	to the "main" task. After the task death, the context was free until the
		60	new "palla0" task was created. "main" task context number is converted to
		61	1256 to make independent statistics.
1506	giacomo	62
1509	giacomo	63	Background Task CTX [ 264] PID [ 1]
1521	giacomo	64	Total Execution [ 18583350900 ns]
		65	Mean CPU Bandwidth [ 83.625487% ]
		66	after first exec [ 83.669980% ]
		67	Execs Number [ 16908 ]
		68	Min Exec [ 515 ns]
		69	Mean Exec [ 1099086 ns]
		70	Max Exec [ 9836143 ns]
1509	giacomo	71
		72	- Task 1 "dummy": The dummy task, it represents the system
1521	giacomo	73	idle time, near 83% as mean value
1509	giacomo	74
		75	Background Task CTX [ 272] PID [ 2]
1521	giacomo	76	Total Execution [ 926 ns]
		77	Mean CPU Bandwidth [ 0.000004% ]
		78	after first exec [ 100.000000% ]
		79	Execs Number [ 1 ]
		80	Min Exec [ 926 ns]
		81	Mean Exec [ 926 ns]
		82	Max Exec [ 926 ns]
1509	giacomo	83
		84	- Task 2 "shutdown task": Shutting down the system. It closes
		85	the tracer too (this is the reason of only 3 us exec time).
		86
		87	Periodical Task CTX [ 280] PID [ 3]
1521	giacomo	88	Total Execution [ 1445626 ns]
		89	Mean CPU Bandwidth [ 0.006505% ]
		90	after first exec [ 0.006512% ]
		91	Execs Number [ 461 ]
		92	Min Exec [ 2583 ns]
		93	Mean Exec [ 3135 ns]
		94	Max Exec [ 4206 ns]
1509	giacomo	95
1521	giacomo	96	Total Job Exec [ 1445626 ns]
		97	Jobs Number [ 461 ]
		98	Min Job [ 2583 ns]
		99	Mean Job [ 3135 ns]
		100	Max Job [ 4206 ns]
1509	giacomo	101
1521	giacomo	102	Min Arr. Delta [ 2021387 ns]
		103	Mean Arr. Delta [ 48260445 ns]
		104	Max Arr. Delta [ 50010461 ns]
1509	giacomo	105
		106	- Task 3 "interrupt server": The interrupt context
		107
		108	Periodical Task CTX [ 288] PID [ 4]
1521	giacomo	109	Total Execution [ 59506 ns]
		110	Mean CPU Bandwidth [ 0.000268% ]
		111	after first exec [ 0.000351% ]
		112	Execs Number [ 43 ]
		113	Min Exec [ 566 ns]
		114	Mean Exec [ 1383 ns]
		115	Max Exec [ 5850 ns]
1509	giacomo	116
1521	giacomo	117	Total Job Exec [ 59506 ns]
		118	Jobs Number [ 17 ]
		119	Min Job [ 1217 ns]
		120	Mean Job [ 3500 ns]
		121	Max Job [ 9358 ns]
1509	giacomo	122
1521	giacomo	123	Min Arr. Delta [ 65650086 ns]
		124	Mean Arr. Delta [ 1059090305 ns]
		125	Max Arr. Delta [ 7168628909 ns]
1509	giacomo	126
		127	- Task 4 "key task": The task for keyboard handler
		128
1506	giacomo	129	Periodical Task CTX [ 296] PID [ 5]
1521	giacomo	130	Total Execution [ 1201275196 ns]
		131	Mean CPU Bandwidth [ 5.405765% ]
		132	after first exec [ 5.406917% ]
		133	Execs Number [ 825 ]
		134	Min Exec [ 11133 ns]
		135	Mean Exec [ 1456091 ns]
		136	Max Exec [ 4500554 ns]
1506	giacomo	137
1521	giacomo	138	Total Job Exec [ 1201275196 ns]
		139	Jobs Number [ 223 ]
		140	Min Job [ 5296076 ns]
		141	Mean Job [ 5386884 ns]
		142	Max Job [ 5515636 ns]
1506	giacomo	143
1521	giacomo	144	Min Arr. Delta [ 99757430 ns]
		145	Mean Arr. Delta [ 100006689 ns]
		146	Max Arr. Delta [ 101061945 ns]
1506	giacomo	147
		148	- Task 5 "jetctrl" : Soft task
		149
		150	Periodical Task CTX [ 304] PID [ 6]
1521	giacomo	151	Total Execution [ 4254996 ns]
		152	Mean CPU Bandwidth [ 0.019148% ]
		153	after first exec [ 0.019156% ]
		154	Execs Number [ 446 ]
		155	Min Exec [ 1111 ns]
		156	Mean Exec [ 9540 ns]
		157	Max Exec [ 18912 ns]
1506	giacomo	158
1521	giacomo	159	Total Job Exec [ 4254996 ns]
		160	Jobs Number [ 223 ]
		161	Min Job [ 18971 ns]
		162	Mean Job [ 19080 ns]
		163	Max Job [ 21052 ns]
1506	giacomo	164
1521	giacomo	165	Min Arr. Delta [ 95501610 ns]
		166	Mean Arr. Delta [ 99979413 ns]
		167	Max Arr. Delta [ 102456106 ns]
1506	giacomo	168
		169	- Task 6 "jetdummy" : Soft Task
		170
		171	Periodical Task CTX [ 312] PID [ 7]
1521	giacomo	172	Total Execution [ 341582118 ns]
		173	Mean CPU Bandwidth [ 1.537127% ]
		174	after first exec [ 1.537767% ]
		175	Execs Number [ 936 ]
		176	Min Exec [ 520 ns]
		177	Mean Exec [ 364938 ns]
		178	Max Exec [ 1300811 ns]
1506	giacomo	179
1521	giacomo	180	Total Job Exec [ 341582118 ns]
		181	Jobs Number [ 223 ]
		182	Min Job [ 1530776 ns]
		183	Mean Job [ 1531758 ns]
		184	Max Job [ 1533632 ns]
1506	giacomo	185
1521	giacomo	186	Min Arr. Delta [ 95494710 ns]
		187	Mean Arr. Delta [ 99979490 ns]
		188	Max Arr. Delta [ 102948741 ns]
1506	giacomo	189
		190	- Task 7 "jetslice": Soft Task
		191
		192	Periodical Task CTX [ 320] PID [ 8]
1521	giacomo	193	Total Execution [ 361875645 ns]
		194	Mean CPU Bandwidth [ 1.628448% ]
		195	after first exec [ 1.628782% ]
		196	Execs Number [ 6750 ]
		197	Min Exec [ 2540 ns]
		198	Mean Exec [ 53611 ns]
		199	Max Exec [ 92451 ns]
1506	giacomo	200
1521	giacomo	201	Total Job Exec [ 361875645 ns]
		202	Jobs Number [ 2222 ]
		203	Min Job [ 162349 ns]
		204	Mean Job [ 162860 ns]
		205	Max Job [ 166904 ns]
1506	giacomo	206
1521	giacomo	207	Min Arr. Delta [ 9989352 ns]
		208	Mean Arr. Delta [ 9999971 ns]
		209	Max Arr. Delta [ 10010719 ns]
1506	giacomo	210
		211	- Task 8 "pallaEDF": Hard Task
		212
1509	giacomo	213	Background Task CTX [ 1256] PID [ 0]
1521	giacomo	214	Total Execution [ 4573409 ns]
		215	Mean CPU Bandwidth [ 0.020580% ]
		216	after first exec [ 0.020580% ]
		217	Execs Number [ 6 ]
		218	Min Exec [ 7166 ns]
		219	Mean Exec [ 762234 ns]
		220	Max Exec [ 2000656 ns]
1506	giacomo	221
1509	giacomo	222	- Task 0 "main": Main task was killed, so the original context
		223	number 256 became 1256
1506	giacomo	224
		225	Periodical Task CTX [ 328] PID [ 10]
1521	giacomo	226	Total Execution [ 270267226 ns]
		227	Mean CPU Bandwidth [ 1.216208% ]
		228	after first exec [ 1.629184% ]
		229	Execs Number [ 8846 ]
		230	Min Exec [ 241 ns]
		231	Mean Exec [ 30552 ns]
		232	Max Exec [ 91592 ns]
1506	giacomo	233
1521	giacomo	234	Total Job Exec [ 270267226 ns]
		235	Jobs Number [ 1659 ]
		236	Min Job [ 162232 ns]
		237	Mean Job [ 162909 ns]
		238	Max Job [ 164270 ns]
1506	giacomo	239
1521	giacomo	240	Min Arr. Delta [ 9988124 ns]
		241	Mean Arr. Delta [ 9999982 ns]
		242	Max Arr. Delta [ 10032718 ns]
1506	giacomo	243
		244	- Task 10 "palla1": Soft Task
		245
		246	Periodical Task CTX [ 336] PID [ 11]
1521	giacomo	247	Total Execution [ 264105857 ns]
		248	Mean CPU Bandwidth [ 1.188482% ]
		249	after first exec [ 1.630505% ]
		250	Execs Number [ 8949 ]
		251	Min Exec [ 239 ns]
		252	Mean Exec [ 29512 ns]
		253	Max Exec [ 91573 ns]
1506	giacomo	254
1521	giacomo	255	Total Job Exec [ 264105857 ns]
		256	Jobs Number [ 1620 ]
		257	Min Job [ 162271 ns]
		258	Mean Job [ 163028 ns]
		259	Max Job [ 164299 ns]
1506	giacomo	260
1521	giacomo	261	Min Arr. Delta [ 9989381 ns]
		262	Mean Arr. Delta [ 9999964 ns]
		263	Max Arr. Delta [ 10010620 ns]
1506	giacomo	264
		265	- Task 11 "palla2": Soft Task
		266
		267	Periodical Task CTX [ 344] PID [ 12]
1521	giacomo	268	Total Execution [ 257971822 ns]
		269	Mean CPU Bandwidth [ 1.160879% ]
		270	after first exec [ 1.634880% ]
		271	Execs Number [ 10631 ]
		272	Min Exec [ 238 ns]
		273	Mean Exec [ 24265 ns]
		274	Max Exec [ 63831 ns]
1506	giacomo	275
1521	giacomo	276	Total Job Exec [ 257971822 ns]
		277	Jobs Number [ 1578 ]
		278	Min Job [ 162684 ns]
		279	Mean Job [ 163480 ns]
		280	Max Job [ 164782 ns]
1506	giacomo	281
1521	giacomo	282	Min Arr. Delta [ 9989399 ns]
		283	Mean Arr. Delta [ 9999963 ns]
		284	Max Arr. Delta [ 10010599 ns]
1506	giacomo	285
		286	- Task 12 "palla3": Soft Task
		287
		288	Periodical Task CTX [ 352] PID [ 13]
1521	giacomo	289	Total Execution [ 250406676 ns]
		290	Mean CPU Bandwidth [ 1.126836% ]
		291	after first exec [ 1.630586% ]
		292	Execs Number [ 8461 ]
		293	Min Exec [ 240 ns]
		294	Mean Exec [ 29595 ns]
		295	Max Exec [ 91753 ns]
1506	giacomo	296
1521	giacomo	297	Total Job Exec [ 250406676 ns]
		298	Jobs Number [ 1536 ]
		299	Min Job [ 162225 ns]
		300	Mean Job [ 163025 ns]
		301	Max Job [ 164557 ns]
1506	giacomo	302
1521	giacomo	303	Min Arr. Delta [ 3184436 ns]
		304	Mean Arr. Delta [ 9999970 ns]
		305	Max Arr. Delta [ 16815492 ns]
1506	giacomo	306
		307	- Task 13 "palla4": Soft Task
		308
		309	Periodical Task CTX [ 360] PID [ 14]
1521	giacomo	310	Total Execution [ 132048658 ns]
		311	Mean CPU Bandwidth [ 0.594222% ]
		312	after first exec [ 1.631180% ]
		313	Execs Number [ 4462 ]
		314	Min Exec [ 244 ns]
		315	Mean Exec [ 29594 ns]
		316	Max Exec [ 91702 ns]
1506	giacomo	317
1521	giacomo	318	Total Job Exec [ 132048658 ns]
		319	Jobs Number [ 810 ]
		320	Min Job [ 162240 ns]
		321	Mean Job [ 163023 ns]
		322	Max Job [ 164337 ns]
1506	giacomo	323
1521	giacomo	324	Min Arr. Delta [ 4934088 ns]
		325	Mean Arr. Delta [ 9999968 ns]
		326	Max Arr. Delta [ 15066505 ns]
1506	giacomo	327
		328	- Task 14 "palla5": Soft Task
		329
		330	Periodical Task CTX [ 368] PID [ 15]
1521	giacomo	331	Total Execution [ 125033245 ns]
		332	Mean CPU Bandwidth [ 0.562652% ]
		333	after first exec [ 1.632032% ]
		334	Execs Number [ 4239 ]
		335	Min Exec [ 242 ns]
		336	Mean Exec [ 29495 ns]
		337	Max Exec [ 91828 ns]
1506	giacomo	338
1521	giacomo	339	Total Job Exec [ 125033245 ns]
		340	Jobs Number [ 767 ]
		341	Min Job [ 162266 ns]
		342	Mean Job [ 163015 ns]
		343	Max Job [ 164284 ns]
1506	giacomo	344
1521	giacomo	345	Min Arr. Delta [ 9187114 ns]
		346	Mean Arr. Delta [ 9999969 ns]
		347	Max Arr. Delta [ 10802835 ns]
1506	giacomo	348
		349	- Task 15 "palla6": Soft Task
		350
1521	giacomo	351	Periodical Task CTX [ 376] PID [ 16]
		352	Total Execution [ 118201550 ns]
		353	Mean CPU Bandwidth [ 0.531910% ]
		354	after first exec [ 1.631159% ]
		355	Execs Number [ 3985 ]
		356	Min Exec [ 244 ns]
		357	Mean Exec [ 29661 ns]
		358	Max Exec [ 91622 ns]
		359
		360	Total Job Exec [ 118201550 ns]
		361	Jobs Number [ 725 ]
		362	Min Job [ 162270 ns]
		363	Mean Job [ 163036 ns]
		364	Max Job [ 164089 ns]
		365
		366	Min Arr. Delta [ 7797571 ns]
		367	Mean Arr. Delta [ 9999955 ns]
		368	Max Arr. Delta [ 12192001 ns]
		369
		370	- Task 16 "palla7": Soft Task
		371
1506	giacomo	372	Background Task CTX [ 248] PID [NODEF]
1521	giacomo	373	Total Execution [ 7674 ns]
		374	Mean CPU Bandwidth [ 0.000035% ]
		375	after first exec [ 72.711768% ]
		376	Execs Number [ 1 ]
		377	Min Exec [ 7674 ns]
		378	Mean Exec [ 7674 ns]
		379	Max Exec [ 7674 ns]
1506	giacomo	380
		381	- Global context: the kernel context
1521	giacomo	382

Subversion Repositories shark

(root)/demos/trunk/newtrace/utils/example_results - Rev 1521