lkml.org 
[lkml]   [1998]   [Jul]   [10]   [last100]   RSS Feed
Views: [wrap][no wrap]   [headers]  [forward] 
 
Messages in this thread
/
Date
From
SubjectRe: patch-ikd + real profiling [first profiling result]
On Fri, 10 Jul 1998, Andrea Arcangeli wrote:

>I' ll try if it will compile tomorrow ;-). Sould work though...

Ok the memleak stuff compile and run fine now, thanks.

You can see the first result of the profiling after 16minutes of uptime
on my machine here:

ftp://e-mind.com/pub/linux/kernel-patch/profiling-output-16min.gz

Here the most recalled functions:

542378 real__get_free_pages 1243.9862
574714 write_null 28735.7000
607598 real_free_pages 2052.6959
662338 getblk 777.3920
662853 __brelse 7891.1071
706239 sys_write 2385.9426
712595 set_writetime 9897.1528
714758 get_hash_table 6381.7679
744656 __kfree_skb 4329.3953
744656 kfree_skbmem 4432.4762
763203 refile_buffer 1004.2145
767084 find_buffer 8716.8636
855457 real_kmem_cache_free 2275.1516
861704 real_kmem_cache_alloc 2992.0278
956774 __generic_copy_to_user 11959.6750
1051117 __generic_copy_from_user 13138.9625
1263361 __wake_up 7896.0063
1452378 do_IRQ 17290.2143
1904317 free_addr 13224.4236
1920554 alloc_addr 7502.1641
2169644 system_call 27120.5500
2251804 ret_from_sys_call 93825.1667

And here the most CPU eater functions:

225133 skb_copy_datagram_iovec 5628.3250
240400 do_normal_gettime 6010.0000
320103 sock_wspace 6155.8269
320622 sock_poll 6165.8077
377471 end_buffer_io_sync 6291.1833
714758 get_hash_table 6381.7679
1920554 alloc_addr 7502.1641
185006 __delay 7708.5833
662853 __brelse 7891.1071
1263361 __wake_up 7896.0063
521685 ide_get_queue 8151.3281
240400 get_fast_time 8585.7143
767084 find_buffer 8716.8636
225237 ip_masq_get_debug_level 9384.8750
712595 set_writetime 9897.1528
225237 icmp_discard 11261.8500
956774 __generic_copy_to_user 11959.6750
1051117 __generic_copy_from_user 13138.9625
1904317 free_addr 13224.4236
1452378 do_IRQ 17290.2143
2169644 system_call 27120.5500
574714 write_null 28735.7000
2251804 ret_from_sys_call 93825.1667

In the first 16minutes the system was sometimes loaded with ping -f, cat
/dev/zero | toport dragon 3000, cp /dev/hda /dev/null, cp /dev/zero file,
cp file /dev/null and finally find / &>/dev/null.

Andrea[s] Arcangeli

PS. Here the two scripts to reorder the readprofile output (just to avoid
one minute of perl developing ;-).

----------------------------------------------------------------
#!/usr/bin/perl

@lines = <STDIN>;
@lines = sort { ($a =~ /(\d+)/)[0] <=>
($b =~ /(\d+)/)[0] } @lines;
print @lines;
----------------------------------------------------------------
#!/usr/bin/perl

@lines = <STDIN>;
@lines = sort { ($a =~ /\d+\s+[^\s]+\s+(\d+\.?\d*)/)[0] <=>
($b =~ /\d+\s+[^\s]+\s+(\d+\.?\d*)/)[0] } @lines;
print @lines;


-
To unsubscribe from this list: send the line "unsubscribe linux-kernel" in
the body of a message to majordomo@vger.rutgers.edu
Please read the FAQ at http://www.altern.org/andrebalsa/doc/lkml-faq.html

\
 
 \ /
  Last update: 2005-03-22 13:43    [W:0.763 / U:0.964 seconds]
©2003-2020 Jasper Spaans|hosted at Digital Ocean and TransIP|Read the blog|Advertise on this site