Re: Login timings and systemtap

[grundym us ibm com]

On Thu, May 03, 2007 at 11:25:32AM -0400, Morten Welinder wrote:
> >sys_open                11789           22167           261336348
> >sys_close               57760           1968            113720844
> 
> That's a lot of close calls.  /me wonders where the file descriptors came
> from.  Could you please put the full list somewhere?

Thanks for pointing that out! That would be a knucklehead mistake on my
part. When I want to play with the numbers I throw them into oocalc, I
must have messed them up. I should have noticed. I should also have
noticed that the timing counts on *that* list was in cycles, not
microseconds. D'oh! Should have had another cup of coffee before
posting. Here's what the top 25 list should look like:

syscall			count		avg time	total time (us)
------------------	------		--------	---------------
sys_futex		1819		45434		82645212
sys_poll		7731		8752		67669335
sys_select		3355		4180		14025491
sys_nanosleep		24		284829		6835914
sys_read		39276		141		5549463
sys_epoll_wait		77		55293		4257636
sys_wait4		195		4947		964712
sys_accept		360		1053		379194
sys_rt_sigsuspend	53		4407		233618
sys_stat64		5784		31		181885
sys_recvmsg		93		1540		143310
sys_fsync		1		129484		129484
sys_semtimedop		474		150		71120
sys_ioctl		2107		30		64919
sys_open		9470		6		62365
sys_readlinkat		76		780		59315
sys_mmap2		7082		6		43400
sys_vfork		4		10274		41098
sys_fcntl64		27310		0		24116
sys_writev		6788		3		23233
sys_munmap		1147		20		23041
sys_write		2767		8		22645
sys_gettimeofday	12006		1		20760
sys_close		9411		1		18713
sys_faccessat		5194		3		17453


Mike