+ date Fri Aug 17 20:22:29 EEST 2007 + rm -rf /var/lib/oprofile/ + opcontrol --vmlinux=/home/jimis/dist/src/linux-2.6.22.3/vmlinux + opcontrol --start Using default event: CPU_CLK_UNHALTED:100000:0:1:1 Daemon started. Profiler running. + sleep 5 + opcontrol --shutdown Stopping profiling. Killing daemon. + echo + echo + echo + opreport CPU: PIII, speed 798.02 MHz (estimated) Counted CPU_CLK_UNHALTED events (clocks processor is not halted) with a unit mask of 0x00 (No unit mask) count 100000 CPU_CLK_UNHALT...| samples| %| ------------------ 2528 52.9535 vmlinux 874 18.3075 libc-2.6.1.so 759 15.8986 ld-2.6.1.so 358 7.4990 bash CPU_CLK_UNHALT...| samples| %| ------------------ 357 99.7207 bash 1 0.2793 [vdso] (tgid:13041 range:0xb7f12000-0xb7f13000) 109 2.2832 gawk 68 1.4244 ISO8859-1.so 13 0.2723 grep 10 0.2095 locale-archive 7 0.1466 badblocks CPU_CLK_UNHALT...| samples| %| ------------------ 5 71.4286 badblocks 2 28.5714 [vdso] (tgid:10910 range:0xb7fc6000-0xb7fc7000) 7 0.1466 libnetsnmp.so.15.0.0 7 0.1466 imap-login 5 0.1047 libdl-2.6.1.so 4 0.0838 libncurses.so.5.6 3 0.0628 ophelp 3 0.0628 libcrypto.so.0.9.8 3 0.0628 libpopt.so.0.0.0 3 0.0628 dovecot-auth 2 0.0419 libhistory.so.5.2 2 0.0419 libnetsnmpmibs.so.15.0.0 1 0.0209 ls 1 0.0209 libext2fs.so.2.4 1 0.0209 libreadline.so.5.2 1 0.0209 init 1 0.0209 id 1 0.0209 oprofiled 1 0.0209 screen-4.0.3 1 0.0209 libnetsnmpagent.so.15.0.0 1 0.0209 sshd CPU_CLK_UNHALT...| samples| %| ------------------ 1 100.000 [vdso] (tgid:6746 range:0xb7f31000-0xb7f32000) + echo + echo + echo + opreport -l /home/jimis/dist/src/linux-2.6.22.3/vmlinux CPU: PIII, speed 798.02 MHz (estimated) Counted CPU_CLK_UNHALTED events (clocks processor is not halted) with a unit mask of 0x00 (No unit mask) count 100000 samples % symbol name 227 8.9794 rpc_print_iostats 206 8.1487 pre_reset 175 6.9225 kmem_cache_shrink 160 6.3291 irq_handler 112 4.4304 congestion_wait 100 3.9557 rpc_proc_open 79 3.1250 create_kmalloc_cache 76 3.0063 ide_do_request 72 2.8481 dump_task_extended_fpu 64 2.5316 vsscanf 56 2.2152 dump_task_regs 52 2.0570 do_syscall_trace 41 1.6218 interruptible_sleep_on 39 1.5427 __relay_reset 32 1.2658 do_wp_page 31 1.2263 kobject_rename 29 1.1472 sys_madvise 27 1.0680 __switch_to 24 0.9494 print_hex_dump 22 0.8703 test_set_page_writeback 20 0.7911 check_object 19 0.7516 do_ide_setup_pci_device 18 0.7120 sys_fadvise64_64 17 0.6725 rpc_proc_show 15 0.5934 ide_setup_pci_devices 14 0.5538 __handle_mm_fault 14 0.5538 handle_vm86_fault 14 0.5538 iput 13 0.5142 svc_seq_show 12 0.4747 do_page_fault 12 0.4747 vsnprintf 11 0.4351 calibrate_delay 11 0.4351 generic_file_buffered_write 11 0.4351 zap_pte 11 0.4351 zoneinfo_show 10 0.3956 access_process_vm 10 0.3956 vm_normal_page 9 0.3560 blk_release_queue 9 0.3560 block_truncate_page 9 0.3560 kmem_cache_create 9 0.3560 setup_sigcontext 8 0.3165 dio_get_page 7 0.2769 bdev_clear_inode 7 0.2769 elv_next_request 7 0.2769 loop_alloc 7 0.2769 print_bad_pte 7 0.2769 rpc_proc_exit 7 0.2769 unmap_vmas 7 0.2769 write_cache_pages 6 0.2373 __switch_to_xtra 6 0.2373 bio_split 6 0.2373 load_elf_binary 6 0.2373 on_freelist 6 0.2373 sys_mprotect 5 0.1978 __blk_put_request 5 0.1978 __blkdev_put 5 0.1978 bdget 5 0.1978 blk_cleanup_queue 5 0.1978 cont_prepare_write 5 0.1978 do_open 5 0.1978 do_sysctl_strategy 5 0.1978 idedisk_check_hpa 5 0.1978 lock_timer 5 0.1978 posix_cpu_nsleep 5 0.1978 sys_mq_timedsend 5 0.1978 test_clear_page_writeback 4 0.1582 __pte_alloc 4 0.1582 __setlease 4 0.1582 assign_all_busses 4 0.1582 bd_release_from_disk 4 0.1582 blk_get_request 4 0.1582 cdev_get 4 0.1582 dio_cleanup 4 0.1582 generic_ide_ioctl 4 0.1582 ioctl_by_bdev 4 0.1582 lookup_bdev 4 0.1582 prio_tree_insert 4 0.1582 relay_switch_subbuf 4 0.1582 rpc_count_iostats 4 0.1582 rpc_proc_init 4 0.1582 sched_setscheduler 4 0.1582 scsi_cmd_ioctl 4 0.1582 svc_proc_unregister 4 0.1582 sys_chroot 4 0.1582 sys_mincore 4 0.1582 sys_mq_open 4 0.1582 wake_up_new_task 3 0.1187 as_can_break_anticipation 3 0.1187 blk_init_queue_node 3 0.1187 blk_phys_contig_segment 3 0.1187 blkdev_close 3 0.1187 cap_bprm_apply_creds 3 0.1187 dio_new_bio 3 0.1187 do_sendfile 3 0.1187 do_sync_readv_writev 3 0.1187 do_sysctl 3 0.1187 elf_core_dump 3 0.1187 fcntl_setlk 3 0.1187 filemap_nopage 3 0.1187 follow_page 3 0.1187 generic_unplug_device 3 0.1187 locks_mandatory_area 3 0.1187 pcibios_setup 3 0.1187 pipe_write 3 0.1187 prio_tree_next 3 0.1187 proc_dodebug 3 0.1187 register_chrdev 3 0.1187 remap_pfn_range 3 0.1187 rw_copy_check_uvector 3 0.1187 send_group_sigqueue 3 0.1187 sys_fchmodat 3 0.1187 sys_remap_file_pages 3 0.1187 vfs_mkdir 3 0.1187 vfs_mknod 3 0.1187 vma_adjust 3 0.1187 vma_merge 2 0.0791 __end_that_request_first 2 0.0791 __free_slab 2 0.0791 add_to_page_cache_lru 2 0.0791 as_fifo_expired 2 0.0791 bd_claim_by_disk 2 0.0791 bio_pair_end_2 2 0.0791 blk_alloc_queue_node 2 0.0791 blk_done_softirq 2 0.0791 blk_ordered_req_seq 2 0.0791 blk_sync_queue 2 0.0791 calculate_totalreserve_pages 2 0.0791 copy_page_range 2 0.0791 dentry_open 2 0.0791 do_exit 2 0.0791 do_mmap_pgoff 2 0.0791 do_mremap 2 0.0791 do_msgrcv 2 0.0791 do_munmap 2 0.0791 do_notify_parent 2 0.0791 dump_thread 2 0.0791 elv_rb_del 2 0.0791 ext3_count_dirs 2 0.0791 ext3_free_inode 2 0.0791 ext3_new_inode 2 0.0791 flush_old_exec 2 0.0791 force_sig_info_fault 2 0.0791 generic_shutdown_super 2 0.0791 grab_cache_page_nowait 2 0.0791 handle_stop_signal 2 0.0791 ide_hwif_request_regions 2 0.0791 init_cpu_workqueue 2 0.0791 init_idedisk_capacity 2 0.0791 insert_vm_struct 2 0.0791 install_file_pte 2 0.0791 interruptible_sleep_on_timeout 2 0.0791 ll_back_merge_fn 2 0.0791 page_address_in_vma 2 0.0791 pirq_enable_irq 2 0.0791 proc_task_lookup 2 0.0791 read_port 2 0.0791 relay_file_read_consume 2 0.0791 rt_mutex_setprio 2 0.0791 rtc_cmos_read 2 0.0791 sg_scsi_ioctl 2 0.0791 subbuf_send_actor 2 0.0791 sync_page_range 2 0.0791 sys_chdir 2 0.0791 sys_chown 2 0.0791 sys_mlockall 2 0.0791 sys_sendfile 2 0.0791 sys_setfsuid 2 0.0791 sys_sysinfo 2 0.0791 t_start 2 0.0791 tick_notify 2 0.0791 vfs_rename 2 0.0791 vfs_unlink 2 0.0791 vgacon_startup 2 0.0791 vmtruncate 1 0.0396 __blk_free_tags 1 0.0396 __d_find_alias 1 0.0396 __elv_add_request 1 0.0396 __f_setown 1 0.0396 __filemap_copy_from_user_iovec_inatomic 1 0.0396 __group_complete_signal 1 0.0396 __is_prefetch 1 0.0396 __link_path_walk 1 0.0396 __netif_rx_schedule 1 0.0396 __oom_kill_task 1 0.0396 __pte_alloc_kernel 1 0.0396 __put_user_1 1 0.0396 __remove_suid 1 0.0396 __set_page_dirty_buffers 1 0.0396 __set_special_pids 1 0.0396 __strncpy_from_user 1 0.0396 __vmalloc_area_node 1 0.0396 __wait_on_freeing_inode 1 0.0396 __wake_up_common 1 0.0396 alloc_chrdev_region 1 0.0396 apply_microcode 1 0.0396 arch_align_stack 1 0.0396 as_antic_stop 1 0.0396 as_choose_req 1 0.0396 as_read_batch_expire_show 1 0.0396 as_read_expire_store 1 0.0396 as_update_iohist 1 0.0396 badness 1 0.0396 blk_execute_rq 1 0.0396 blk_execute_rq_nowait 1 0.0396 blk_free_tags 1 0.0396 blk_hw_contig_segment 1 0.0396 blk_plug_device 1 0.0396 blk_queue_find_tag 1 0.0396 blk_queue_hardsect_size 1 0.0396 blk_register_queue 1 0.0396 blk_remove_plug 1 0.0396 blkdev_direct_IO 1 0.0396 blkdev_get 1 0.0396 blkdev_open 1 0.0396 block_fsync 1 0.0396 call_usermodehelper_pipe 1 0.0396 can_do_mlock 1 0.0396 cap_ptrace 1 0.0396 cap_settime 1 0.0396 cap_task_post_setuid 1 0.0396 cascade 1 0.0396 cdev_del 1 0.0396 check_disk_change 1 0.0396 check_slab 1 0.0396 congestion_wait_interruptible 1 0.0396 cpu_idle_wait 1 0.0396 create_new_namespaces 1 0.0396 current_io_context 1 0.0396 d_alloc 1 0.0396 d_hash_and_lookup 1 0.0396 del_timer 1 0.0396 dev_hard_start_xmit 1 0.0396 dio_complete 1 0.0396 do_brk 1 0.0396 do_fcntl 1 0.0396 do_generic_mapping_read 1 0.0396 do_iret_error 1 0.0396 do_mpage_readpage 1 0.0396 do_sched_setscheduler 1 0.0396 do_sync 1 0.0396 do_writepages 1 0.0396 dup_fd 1 0.0396 elevator_alloc 1 0.0396 elv_completed_request 1 0.0396 elv_insert 1 0.0396 elv_merged_request 1 0.0396 elv_requeue_request 1 0.0396 elv_unregister 1 0.0396 end_buffer_read_sync 1 0.0396 exit_itimers 1 0.0396 ext3_bread 1 0.0396 ext3_rename 1 0.0396 ext3_xattr_trusted_list 1 0.0396 free_pgtables 1 0.0396 freed_request 1 0.0396 generic_drop_inode 1 0.0396 generic_file_sendfile 1 0.0396 generic_fillattr 1 0.0396 generic_ide_resume 1 0.0396 generic_ide_suspend 1 0.0396 generic_permission 1 0.0396 get_next_timer_interrupt 1 0.0396 get_symbol_offset 1 0.0396 get_timestamp 1 0.0396 getname 1 0.0396 ide_intr 1 0.0396 ide_pci_setup_ports 1 0.0396 ide_setup_pci_device 1 0.0396 ide_taskfile_ioctl 1 0.0396 init_object 1 0.0396 init_once 1 0.0396 internal_add_timer 1 0.0396 ip_options_get_from_user 1 0.0396 journal_add_journal_head 1 0.0396 kill_anon_super 1 0.0396 kmem_ptr_validate 1 0.0396 kobject_get_path 1 0.0396 kobject_move 1 0.0396 laptop_io_completion 1 0.0396 link_path_walk 1 0.0396 lock_task_sighand 1 0.0396 log_do_checkpoint 1 0.0396 lookup_one_len 1 0.0396 madvise_need_mmap_write 1 0.0396 may_open 1 0.0396 mb_cache_create 1 0.0396 microcode_write 1 0.0396 mm_release 1 0.0396 mounts_release 1 0.0396 mpage_readpages 1 0.0396 mqueue_read_file 1 0.0396 netstat_show 1 0.0396 nobh_prepare_write 1 0.0396 normalize_rt_tasks 1 0.0396 notify_arch_cmos_timer 1 0.0396 nr_processes 1 0.0396 number 1 0.0396 open_bdev_excl 1 0.0396 open_namei 1 0.0396 out_of_memory 1 0.0396 p4_start 1 0.0396 page_cache_read 1 0.0396 page_mkclean 1 0.0396 pcibios_disable_device 1 0.0396 pdflush 1 0.0396 pipe_poll 1 0.0396 poison_store 1 0.0396 posix_cpu_nsleep_restart 1 0.0396 prepare_timeout 1 0.0396 prio_tree_remove 1 0.0396 proc_pid_auxv 1 0.0396 profile_event_unregister 1 0.0396 profile_hits 1 0.0396 ptmx_open 1 0.0396 ptrace_attach 1 0.0396 read_cache_page_async 1 0.0396 read_profile 1 0.0396 recalc_task_prio 1 0.0396 register_console 1 0.0396 relay_file_mmap 1 0.0396 relay_file_open 1 0.0396 relay_file_poll 1 0.0396 release_task 1 0.0396 reparent_thread 1 0.0396 request_irq 1 0.0396 rpc_alloc_iostats 1 0.0396 rt_fill_info 1 0.0396 run_posix_cpu_timers 1 0.0396 rw_verify_area 1 0.0396 sb_set_blocksize 1 0.0396 sched_exit 1 0.0396 sched_fork 1 0.0396 send_signal 1 0.0396 set_bdi_congested 1 0.0396 set_blocksize 1 0.0396 set_load_weight 1 0.0396 set_page_dirty_lock 1 0.0396 setup_irq 1 0.0396 sg_io 1 0.0396 show_partition 1 0.0396 show_regs 1 0.0396 show_schedstat 1 0.0396 shrink_zone 1 0.0396 strpbrk 1 0.0396 subbuf_read_actor 1 0.0396 svc_proc_register 1 0.0396 sys_faccessat 1 0.0396 sys_io_getevents 1 0.0396 sys_mlock 1 0.0396 sys_munlock 1 0.0396 sys_sched_get_priority_min 1 0.0396 sys_setitimer 1 0.0396 sys_setregid 1 0.0396 sys_sigaction 1 0.0396 sys_splice 1 0.0396 sys_stat 1 0.0396 sys_statfs 1 0.0396 sys_sync_file_range 1 0.0396 sys_sysctl 1 0.0396 sys_vm86old 1 0.0396 sysctl_head_finish 1 0.0396 sysctl_head_next 1 0.0396 try_to_free_buffers 1 0.0396 unuse_table 1 0.0396 user_shm_lock 1 0.0396 validate_store 1 0.0396 vfs_ioctl 1 0.0396 vm_stat_account 1 0.0396 vma_link 1 0.0396 vprintk 1 0.0396 wait_on_retry_sync_kiocb 1 0.0396 wait_on_work 1 0.0396 wake_up_inode 1 0.0396 will_become_orphaned_pgrp 1 0.0396 write_boundary_block 1 0.0396 write_full + date Fri Aug 17 20:23:34 EEST 2007