___________________________________________________________________________________________ System: Linux elm3b96.eng 2.4.17-dch2 #15 SMP Thu Feb 28 19:39:04 PST 2002 i686 Total counts All (8) CPUs Start time: Fri Mar 1 04:32:18 2002 End time: Fri Mar 1 04:35:21 2002 Delta Time: 182.73 sec. Hash table slots in use: 255. Global read lock slots in use: 999. *************************** Warnings! ****************************** Read Lock table overflowed. The data in this report may be in error due to this. ************************ End of Warnings! ************************** - - - - - - - - - - - - - - - - - - - - - - - - - - - - - - - - - - - - - - - - - - - - - - - - - - - - - SPINLOCKS HOLD WAIT UTIL CON MEAN( MAX ) MEAN( MAX )(% CPU) TOTAL NOWAIT SPIN RJECT NAME 13.6% 1.0us( 16ms) 9.0us( 16ms)( 8.7%) 104015326 86.4% 13.6% 0.00% *TOTAL* 0.00% 0% 4.7us( 6.1us) 0us 21 100% 0% 0% [0xde3dfaf0] 0.00% 0% 3.3us( 4.8us) 0us 2 100% 0% 0% unmap_fixup+0x8c 0.00% 0% 4.9us( 6.1us) 0us 19 100% 0% 0% unmap_fixup+0x134 0.00% 0% 0.1us( 0.4us) 0us 120 100% 0% 0% [0xf2fb4658] 0.00% 0% 0.1us( 0.4us) 0us 120 100% 0% 0% sys_rt_sigprocmask+0x18c 0.00% 1.6% 1.6us( 2.6us) 0.4us( 0.4us)(0.00%) 61 98.4% 1.6% 0% [0xf77f25c8] 0.00% 1.6% 1.6us( 2.6us) 0.4us( 0.4us)(0.00%) 61 98.4% 1.6% 0% unmap_fixup+0xa8 0.00% 0% 1.5us( 5.8us) 0us 731 100% 0% 0% [0xf7b32698] 0.00% 0% 1.5us( 5.8us) 0us 731 100% 0% 0% rh_int_timer_do+0x4c 0.00% 0% 5.3us( 14us) 0us 46 100% 0% 0% [0xf7b7b0d0] 0.00% 0% 5.3us( 14us) 0us 46 100% 0% 0% dev_watchdog+0x14 0.00% 0% 0.1us( 0.1us) 0us 80 100% 0% 0% [0xf7bb64ec] 0.00% 0% 0.1us( 0.1us) 0us 20 100% 0% 0% shmem_delete_inode+0x68 0.00% 0% 0.1us( 0.1us) 0us 20 100% 0% 0% shmem_get_inode+0x1c 0.00% 0% 0.1us( 0.1us) 0us 20 100% 0% 0% shmem_getpage_locked+0x274 0.00% 0% 0.1us( 0.1us) 0us 20 100% 0% 0% shmem_recalc_inode+0x48 0.00% 0% 3.4us( 41us) 0us 541 100% 0% 0% [0xf7bca810] 0.00% 0% 3.4us( 41us) 0us 541 100% 0% 0% ahc_linux_queue+0x38 0.00% 0% 1.1us( 5.2us) 0us 242 100% 0% 0% allocator_request_lock 0.00% 0% 1.7us( 5.2us) 0us 121 100% 0% 0% scsi_free+0x1c 0.00% 0% 0.4us( 3.4us) 0us 121 100% 0% 0% scsi_malloc+0x48 0.12% 0.04% 0.3us( 34us) 1.8us( 36us)(0.00%) 676108 100% 0.04% 0% arbitration_lock 0.00% 0.27% 0.4us( 1.9us) 1.7us( 1.7us)(0.00%) 366 99.7% 0.27% 0% deny_write_access+0xc 0.12% 0.04% 0.3us( 34us) 1.8us( 36us)(0.00%) 675742 100% 0.04% 0% get_write_access+0xc 0.00% 0% 2.5us( 6.7us) 0us 146 100% 0% 0% bdev_lock 0.00% 0% 2.5us( 6.7us) 0us 146 100% 0% 0% bdget+0x34 0.03% 0% 13us( 97us) 0us 4635 100% 0% 0% call_lock 0.03% 0% 13us( 97us) 0us 4635 100% 0% 0% smp_call_function+0x58 4.3% 8.4% 0.7us( 821us) 4.2us( 649us)(0.27%) 11300186 91.6% 8.4% 0% dcache_lock 0.00% 16.7% 1.5us( 2.5us) 12us( 23us)(0.00%) 12 83.3% 16.7% 0% autofs4_expire+0x38 0.01% 7.4% 0.3us( 6.3us) 4.1us( 92us)(0.00%) 81502 92.6% 7.4% 0% d_alloc+0x138 0.03% 12.3% 0.3us( 6.8us) 4.5us( 438us)(0.01%) 174980 87.7% 12.3% 0% d_delete+0x10 0.00% 3.1% 0.2us( 4.6us) 3.7us( 31us)(0.00%) 3800 96.9% 3.1% 0% d_delete+0x94 0.03% 10.2% 0.2us( 14us) 4.0us( 158us)(0.01%) 256483 89.8% 10.2% 0% d_instantiate+0x30 3.7% 8.2% 0.7us( 85us) 4.2us( 648us)(0.22%) 9546160 91.8% 8.2% 0% d_lookup+0x5c 0.02% 10.2% 1.2us( 38us) 4.2us( 106us)(0.00%) 35100 89.8% 10.2% 0% d_move+0x48 0.01% 5.3% 0.2us( 40us) 3.6us( 99us)(0.00%) 81482 94.7% 5.3% 0% d_rehash+0x50 0.00% 2.1% 0.2us( 3.4us) 2.7us( 16us)(0.00%) 1260 97.9% 2.1% 0% d_unhash+0x44 0.42% 9.7% 0.7us( 48us) 4.4us( 649us)(0.03%) 1043238 90.3% 9.7% 0% dput+0x30 0.00% 0% 1.3us( 4.9us) 0us 50 100% 0% 0% link_path_walk+0x2c8 0.00% 3.8% 1.8us( 158us) 4.8us( 37us)(0.00%) 3126 96.2% 3.8% 0% prune_dcache+0x14 0.03% 5.2% 0.9us( 468us) 4.5us( 198us)(0.00%) 67708 94.8% 5.2% 0% prune_dcache+0x148 0.02% 2.2% 6.9us( 821us) 3.4us( 18us)(0.00%) 5285 97.8% 2.2% 0% select_parent+0x20 0.00% 0% 1.2us( 7.1us) 0us 1082 100% 0% 0% device_request_lock 0.00% 0% 0.6us( 3.7us) 0us 541 100% 0% 0% __scsi_release_command+0x14 0.00% 0% 1.9us( 7.1us) 0us 541 100% 0% 0% scsi_allocate_device+0x30 0.00% 0% 2.9us( 13us) 0us 386 100% 0% 0% emergency_lock 0.00% 0% 2.9us( 13us) 0us 386 100% 0% 0% bounce_end_io_write+0x28 1.0% 2.9% 1.0us( 88us) 2.6us( 53us)(0.01%) 1961660 97.1% 2.9% 0% files_lock 0.00% 0% 0.5us( 0.9us) 0us 40 100% 0% 0% check_tty_count+0x10 0.20% 4.1% 0.5us( 27us) 2.7us( 53us)(0.00%) 653792 95.9% 4.1% 0% file_move+0x18 0.14% 2.6% 0.4us( 68us) 2.6us( 50us)(0.00%) 653914 97.4% 2.6% 0% fput+0x80 0.70% 2.0% 2.0us( 88us) 2.3us( 32us)(0.00%) 653914 98.0% 2.0% 0% get_empty_filp+0xc 0.09% 0.02% 9.0us(1621us) 0us 19229 100% 0% 0.02% global_bh_lock 0.09% 0.02% 9.0us(1621us) 0us 19229 100% 0% 0.02% bh_action+0x18 0.09% 0% 8.7us( 16us) 0us 18273 100% 0% 0% i8253_lock 0.09% 0% 8.7us( 16us) 0us 18273 100% 0% 0% timer_interrupt+0x2c 0.03% 0% 2.8us( 8.1us) 0us 18273 100% 0% 0% i8259A_lock 0.03% 0% 2.8us( 8.1us) 0us 18273 100% 0% 0% timer_interrupt+0x90 0.00% 0% 0.6us( 0.7us) 0us 2 100% 0% 0% inet_peer_unused_lock 0.00% 0% 0.6us( 0.7us) 0us 2 100% 0% 0% cleanup_once+0x24 0.36% 0.38% 0.8us( 60us) 2.3us( 58us)(0.00%) 796964 99.6% 0.38% 0% inode_lock 0.06% 0.14% 0.6us( 38us) 2.4us( 9.4us)(0.00%) 198549 99.9% 0.14% 0% __mark_inode_dirty+0x48 0.12% 0.37% 1.2us( 50us) 2.2us( 12us)(0.00%) 175062 99.6% 0.37% 0% get_empty_inode+0x24 0.00% 0% 1.0us( 2.9us) 0us 27 100% 0% 0% get_new_inode+0x34 0.02% 0.29% 2.5us( 52us) 1.6us( 4.1us)(0.00%) 14589 99.7% 0.29% 0% iget4+0x3c 0.05% 0.15% 0.6us( 60us) 2.1us( 6.4us)(0.00%) 174981 99.8% 0.15% 0% insert_inode_hash+0x44 0.09% 0.82% 0.8us( 35us) 2.4us( 58us)(0.00%) 214836 99.2% 0.82% 0% iput+0x78 0.00% 0% 7.3us( 11us) 0us 36 100% 0% 0% sync_unlocked_inodes+0x10 0.01% 0% 1.0us( 8.9us) 0us 18884 100% 0% 0% sync_unlocked_inodes+0x12c 0.01% 0.03% 3.0us( 51us) 8.0us( 8.0us)(0.00%) 3718 100% 0.03% 0% io_request_lock 0.00% 0% 1.6us( 16us) 0us 992 100% 0% 0% __make_request+0xec 0.00% 0% 6.9us( 21us) 0us 541 100% 0% 0% ahc_linux_isr+0x2ec 0.00% 0% 12us( 20us) 0us 21 100% 0% 0% generic_unplug_device+0x10 0.00% 0% 4.1us( 51us) 0us 541 100% 0% 0% scsi_dispatch_cmd+0x11c 0.00% 0% 0.7us( 4.0us) 0us 541 100% 0% 0% scsi_finish_command+0x18 0.00% 0.18% 2.6us( 11us) 8.0us( 8.0us)(0.00%) 541 99.8% 0.18% 0% scsi_queue_next_request+0x18 0.00% 0% 2.7us( 13us) 0us 541 100% 0% 0% scsi_request_fn+0x31c 11.8% 10.1% 2.4us( 16ms) 22us( 16ms)( 1.3%) 8890644 89.9% 10.1% 0% kernel_flag 0.00% 0% 34us( 40us) 0us 20 100% 0% 0% chrdev_open+0x4c 0.00% 3.8% 0.7us( 1.9us) 0.9us( 0.9us)(0.00%) 26 96.2% 3.8% 0% de_put+0x28 0.43% 10.4% 3249us( 16ms) 2195us(8284us)(0.00%) 241 89.6% 10.4% 0% do_exit+0xe8 2.4% 17.7% 25us( 730us) 58us( 14ms)(0.12%) 173160 82.3% 17.7% 0% ext2_delete_inode+0x80 0.06% 4.8% 0.3us( 13us) 11us(5067us)(0.01%) 400105 95.2% 4.8% 0% ext2_free_blocks+0x230 0.08% 10.3% 0.4us( 27us) 14us(5004us)(0.04%) 361857 89.7% 10.3% 0% ext2_new_block+0x564 0.21% 2.4% 0.2us( 70us) 5.5us(3782us)(0.02%) 2313416 97.6% 2.4% 0% ext2_new_block+0x764 0.01% 1.7% 0.2us( 7.9us) 4.8us( 61us)(0.00%) 61847 98.3% 1.7% 0% ext2_new_block+0x7f8 0.00% 0% 4.0us( 4.4us) 0us 20 100% 0% 0% get_chrfops+0x8c 0.62% 16.9% 15us( 457us) 38us(5917us)(0.03%) 76222 83.1% 16.9% 0% lookup_hash+0x80 0.21% 16.9% 16us( 256us) 23us(5055us)(0.01%) 23040 83.1% 16.9% 0% notify_change+0x64 0.04% 15.1% 14us( 517us) 56us(3483us)(0.00%) 5199 84.9% 15.1% 0% real_lookup+0x64 1.1% 24.8% 37us(7851us) 25us(5267us)(0.02%) 52856 75.2% 24.8% 0% schedule+0x558 0.06% 5.6% 3090us(5067us) 1300us(1505us)(0.00%) 36 94.4% 5.6% 0% sync_old_buffers+0x1c 0.00% 23.1% 14us( 39us) 18us( 48us)(0.00%) 13 76.9% 23.1% 0% sys_ioctl+0x4c 0.00% 0% 0.7us( 1.1us) 0us 20 100% 0% 0% sys_llseek+0x88 1.7% 12.8% 0.6us( 62us) 22us(6389us)(0.97%) 5037300 87.2% 12.8% 0% sys_lseek+0x6c 0.59% 14.9% 31us( 432us) 19us(4715us)(0.01%) 35100 85.1% 14.9% 0% sys_rename+0x1a0 0.00% 0% 9.9us( 15us) 0us 20 100% 0% 0% tty_release+0x1c 0.00% 0% 25us( 75us) 0us 22 100% 0% 0% tty_write+0x1bc 2.7% 22.9% 29us( 451us) 14us(4690us)(0.04%) 172981 77.1% 22.9% 0% vfs_create+0x8c 0.12% 35.5% 112us( 576us) 41us( 904us)(0.00%) 2000 64.5% 35.5% 0% vfs_mkdir+0x88 0.02% 17.0% 15us( 332us) 307us( 16ms)(0.01%) 2160 83.0% 17.0% 0% vfs_rmdir+0x158 0.00% 0% 8.2us( 9.8us) 0us 3 100% 0% 0% vfs_statfs+0x4c 1.5% 17.3% 16us( 405us) 23us(9690us)(0.05%) 172980 82.7% 17.3% 0% vfs_unlink+0x118 10.7% 20.8% 0.6us( 461us) 7.7us( 10ms)( 3.7%) 33840674 79.2% 20.8% 0% kmap_lock 6.5% 21.3% 0.7us( 461us) 7.7us( 10ms)( 1.9%) 16920337 78.7% 21.3% 0% kmap_high+0x10 4.2% 20.4% 0.5us( 69us) 7.7us( 471us)( 1.8%) 16920337 79.6% 20.4% 0% kunmap_high+0xc 0.00% 0% 0.3us( 1.0us) 0us 241 100% 0% 0% lastpid_lock 0.00% 0% 0.3us( 1.0us) 0us 241 100% 0% 0% get_pid+0x20 10.2% 23.9% 1.4us( 253us) 14us( 819us)( 3.0%) 12905898 76.1% 23.9% 0% lru_list_lock 0.88% 10.0% 0.7us( 67us) 7.5us( 469us)(0.11%) 2178618 90.0% 10.0% 0% buffer_insert_inode_data_queue+0x10 0.29% 19.6% 0.3us( 64us) 8.0us( 678us)(0.17%) 1585800 80.4% 19.6% 0% buffer_insert_inode_queue+0x14 0.03% 16.8% 0.3us( 6.6us) 11us( 485us)(0.02%) 175088 83.2% 16.8% 0% inode_has_buffers+0x10 0.04% 17.6% 0.4us( 12us) 11us( 524us)(0.02%) 175061 82.4% 17.6% 0% invalidate_inode_buffers+0x10 0.00% 2.8% 11us( 253us) 2.0us( 2.0us)(0.00%) 36 97.2% 2.8% 0% kupdate+0x98 3.7% 29.1% 1.5us( 77us) 15us( 717us)( 1.3%) 4429428 70.9% 29.1% 0% refile_buffer+0xc 2.0% 26.4% 1.7us( 63us) 16us( 645us)(0.63%) 2178560 73.6% 26.4% 0% remove_from_queues+0xc 0.00% 4.5% 14us( 37us) 2.5us( 3.8us)(0.00%) 67 95.5% 4.5% 0% sync_old_buffers+0x74 3.2% 29.1% 2.7us( 179us) 16us( 819us)(0.70%) 2183240 70.9% 29.1% 0% try_to_free_buffers+0x1c 0.00% 0% 0.5us( 4.4us) 0us 482 100% 0% 0% mmlist_lock 0.00% 0% 0.3us( 1.4us) 0us 241 100% 0% 0% copy_mm+0x120 0.00% 0% 0.8us( 4.4us) 0us 241 100% 0% 0% mmput+0x28 6.8% 10.2% 0.8us( 129us) 2.8us( 134us)(0.32%) 16421251 89.8% 10.2% 0% pagecache_lock 0.14% 11.3% 0.5us( 28us) 2.9us( 119us)(0.01%) 518184 88.7% 11.3% 0% __find_get_page+0x18 2.3% 10.5% 0.6us( 76us) 2.9us( 134us)(0.14%) 6785860 89.5% 10.5% 0% __find_lock_page+0xc 0.00% 0% 1.3us( 2.2us) 0us 20 100% 0% 0% add_to_page_cache+0x18 1.9% 10.8% 1.6us( 73us) 3.2us( 95us)(0.05%) 2176561 89.2% 10.8% 0% add_to_page_cache_unique+0x18 0.93% 10.2% 0.7us( 129us) 2.7us( 76us)(0.05%) 2416066 89.8% 10.2% 0% do_generic_file_read+0x1a4 0.00% 11.1% 1.6us( 42us) 3.3us( 22us)(0.00%) 4680 88.9% 11.1% 0% do_generic_file_read+0x370 0.00% 0.87% 0.1us( 2.2us) 1.5us( 8.6us)(0.00%) 18884 99.1% 0.87% 0% filemap_fdatasync+0x1c 0.00% 0.79% 0.1us( 2.1us) 1.6us( 7.7us)(0.00%) 18884 99.2% 0.79% 0% filemap_fdatawait+0x10 0.00% 13.6% 1.2us( 20us) 3.9us( 29us)(0.00%) 2146 86.4% 13.6% 0% find_or_create_page+0x38 0.00% 11.6% 1.8us( 38us) 4.0us( 38us)(0.00%) 2146 88.4% 11.6% 0% find_or_create_page+0x78 0.94% 8.7% 0.8us( 50us) 2.5us( 63us)(0.03%) 2183260 91.3% 8.7% 0% remove_inode_page+0x28 0.00% 15.0% 0.8us( 1.1us) 8.6us( 14us)(0.00%) 20 85.0% 15.0% 0% set_page_dirty+0x24 0.06% 12.4% 1.0us( 9.8us) 2.7us( 50us)(0.00%) 111280 87.6% 12.4% 0% truncate_inode_pages+0x38 0.55% 10.1% 0.5us( 77us) 2.6us( 69us)(0.04%) 2183260 89.9% 10.1% 0% truncate_list_pages+0x1f8 1.7% 2.8% 0.7us( 485us) 1.9us( 434us)(0.02%) 4607455 97.2% 2.8% 0% pagemap_lru_lock 0.18% 5.8% 1.5us( 485us) 2.1us( 70us)(0.00%) 224806 94.2% 5.8% 0% activate_page+0xc 0.99% 4.1% 0.8us( 91us) 1.8us( 434us)(0.01%) 2191398 95.9% 4.1% 0% lru_cache_add+0x1c 0.56% 1.1% 0.5us( 80us) 2.1us( 69us)(0.00%) 2191251 98.9% 1.1% 0% lru_cache_del+0xc 1.0% 9.7% 4.0us( 32us) 4.5us( 63us)(0.01%) 453216 90.3% 9.7% 0% runqueue_lock 0.43% 10.7% 4.8us( 32us) 3.9us( 32us)(0.00%) 160608 89.3% 10.7% 0% __wake_up+0x5c 0.00% 43.6% 0.4us( 1.8us) 3.7us( 10us)(0.00%) 218 56.4% 43.6% 0% deliver_signal+0x48 0.00% 0.80% 7.7us( 24us) 5.4us( 7.7us)(0.00%) 373 99.2% 0.80% 0% process_timeout+0x14 0.00% 41.4% 1.9us( 3.5us) 3.1us( 6.1us)(0.00%) 58 58.6% 41.4% 0% schedule_tail+0x58 0.46% 7.1% 3.4us( 20us) 5.4us( 63us)(0.01%) 246317 92.9% 7.1% 0% schedule+0xc0 0.00% 5.8% 1.3us( 10us) 5.3us( 47us)(0.00%) 3174 94.2% 5.8% 0% schedule+0x284 0.11% 20.9% 4.8us( 28us) 3.8us( 51us)(0.00%) 42023 79.1% 20.9% 0% schedule+0x518 0.00% 0.90% 3.7us( 13us) 2.3us( 3.4us)(0.00%) 445 99.1% 0.90% 0% wake_up_process+0x14 0.00% 0% 1.5us( 9.1us) 0us 200 100% 0% 0% sb_lock 0.00% 0% 0.4us( 1.6us) 0us 36 100% 0% 0% drop_super+0x24 0.00% 0% 1.0us( 9.1us) 0us 72 100% 0% 0% sync_supers+0x6c 0.00% 0% 5.0us( 8.0us) 0us 36 100% 0% 0% sync_unlocked_inodes+0x18 0.00% 0% 0.7us( 1.7us) 0us 56 100% 0% 0% sync_unlocked_inodes+0x1ac 0.00% 0% 0.4us( 3.7us) 0us 1608 100% 0% 0% scsi_bhqueue_lock 0.00% 0% 0.2us( 3.7us) 0us 1067 100% 0% 0% scsi_bottom_half_handler+0x1c 0.00% 0% 0.7us( 3.6us) 0us 541 100% 0% 0% scsi_done+0x3c 0.11% 1.0% 0.8us( 8.3us) 2.5us( 19us)(0.00%) 253392 99.0% 1.0% 0% semaphore_lock 0.02% 1.6% 0.4us( 7.3us) 2.4us( 13us)(0.00%) 109356 98.4% 1.6% 0% __down+0x44 0.08% 0.61% 1.1us( 8.3us) 2.5us( 19us)(0.00%) 144016 99.4% 0.61% 0% __down+0x78 0.00% 0% 1.0us( 2.9us) 0us 13 100% 0% 0% __down_interruptible+0x48 0.00% 0% 0.6us( 1.8us) 0us 7 100% 0% 0% __down_interruptible+0x88 0.00% 0% 1.0us( 5.5us) 0us 480 100% 0% 0% shm_ids+0x28 0.00% 0% 0.8us( 1.3us) 0us 20 100% 0% 0% ipc_addid+0x94 0.00% 0% 1.7us( 5.5us) 0us 200 100% 0% 0% shm_close+0x54 0.00% 0% 0.2us( 0.4us) 0us 20 100% 0% 0% shm_mmap+0x54 0.00% 0% 0.4us( 2.0us) 0us 180 100% 0% 0% shm_open+0x40 0.00% 0% 1.8us( 2.5us) 0us 20 100% 0% 0% sys_shmat+0xb8 0.00% 0% 0.5us( 1.2us) 0us 20 100% 0% 0% sys_shmat+0x25c 0.00% 0% 1.1us( 1.5us) 0us 20 100% 0% 0% sys_shmctl+0x684 0.00% 0% 0.3us( 1.0us) 0us