Obsolete:Oprofile
Appearance
Note: This page was created as a temporary pastebin and probably doesn't make any sense without its proper context
Apache profiling
Full system profiling of an application server, srv43. Dual AMD Opteron 248. 2007-03-07. Truncated after 200 lines. The two columns shown are (loosely speaking) CPU usage and L2 cache misses. There is a strong correlation between the two metrics, which is especially striking in the case of ap_unblock_alarms, a short and simple function to decrement a variable. This demonstrates that L2 cache misses have a real impact on performance.
[root@srv43 ~]# opreport -l | head -n200 warning: /3w_xxxx could not be found. warning: /ext3 could not be found. warning: /ipv6 could not be found. warning: /nfs could not be found. warning: /ohci_hcd could not be found. warning: /oprofile could not be found. warning: /reiserfs could not be found. warning: /scsi_mod could not be found. warning: /sd_mod could not be found. warning: /sunrpc could not be found. warning: /tg3 could not be found. warning: /usr/lib/locale/locale-archive is not in a usable binary format. CPU: AMD64 processors, speed 2205.07 MHz (estimated) Counted CPU_CLK_UNHALTED events (Cycles outside of halt state) with a unit mask of 0x00 (No unit mask) count 1000000 Counted DATA_CACHE_REFILLS_FROM_SYSTEM events (Data cache refills from system) with a unit mask of 0x1f (All cache states) count 2000 samples % samples % app name symbol name 195393 5.7190 190234 7.2153 libc-2.3.6.so memcpy 171730 5.0264 255991 9.7094 httpd ap_unblock_alarms 167041 4.8891 111303 4.2216 libphp5.so zend_hash_find 136979 4.0093 88804 3.3682 libphp5.so _zend_hash_add_or_update 133298 3.9015 189376 7.1828 libc-2.3.6.so _int_free 124500 3.6440 32837 1.2455 libc-2.3.6.so _int_malloc 122811 3.5946 335312 12.7180 libc-2.3.6.so malloc_consolidate 110317 3.2289 122704 4.6540 libphp5.so _efree 107758 3.1540 88188 3.3449 libphp5.so _emalloc 84605 2.4763 4968 0.1884 libphp5.so match 65575 1.9193 72437 2.7474 libphp5.so _zval_ptr_dtor 62234 1.8215 21624 0.8202 libphp5.so zend_do_fcall_common_helper_SPEC 58158 1.7022 52308 1.9840 libphp5.so zend_hash_quick_find 49646 1.4531 60244 2.2850 libc-2.3.6.so free 45518 1.3323 50035 1.8978 libphp5.so _zval_dtor_func 43952 1.2864 28246 1.0713 libc-2.3.6.so malloc 42778 1.2521 25894 0.9821 httpd ap_block_alarms 41493 1.2145 25614 0.9715 libphp5.so _zend_hash_quick_add_or_update 40553 1.1870 23062 0.8747 libphp5.so zend_hash_destroy 37485 1.0972 28241 1.0711 libphp5.so anonymous symbol from section .plt 31693 0.9276 166 0.0063 vmlinux timer_interrupt 30559 0.8944 11006 0.4174 libphp5.so zend_assign_to_variable 29532 0.8644 13120 0.4976 libphp5.so execute 28040 0.8207 13052 0.4950 libphp5.so _zend_hash_index_update_or_next_insert 26241 0.7681 14178 0.5378 libc-2.3.6.so memset 25535 0.7474 11404 0.4325 libphp5.so _erealloc 24855 0.7275 15387 0.5836 vmlinux __d_lookup 24627 0.7208 19846 0.7527 libphp5.so ZEND_SEND_VAR_SPEC_CV_HANDLER 24579 0.7194 12909 0.4896 libphp5.so zend_hash_rehash 24027 0.7032 33415 1.2674 vmlinux unmap_vmas 22997 0.6731 1451 0.0550 libphp5.so php_pcre_exec 20398 0.5970 3869 0.1467 libphp5.so zend_str_tolower_copy 20088 0.5880 10344 0.3923 libphp5.so zend_fetch_dimension_address 18797 0.5502 30399 1.1530 vmlinux copy_page_range 18371 0.5377 9938 0.3769 libphp5.so ZEND_JMPZ_SPEC_TMP_HANDLER 17636 0.5162 7553 0.2865 libphp5.so _estrndup 17604 0.5153 8487 0.3219 libphp5.so ZEND_ASSIGN_REF_SPEC_CV_VAR_HANDLER 16064 0.4702 11209 0.4251 libphp5.so zend_get_hash_value 16053 0.4699 16675 0.6325 libphp5.so ZEND_RECV_SPEC_HANDLER 16013 0.4687 45583 1.7289 apc.so my_prepare_op_array_for_execution 13273 0.3885 1120 0.0425 libphp5.so php_var_unserialize 13267 0.3883 13105 0.4971 apc.so my_copy_hashtable_ex 13158 0.3851 1435 0.0544 vmlinux do_gettimeoffset_pm 12134 0.3552 2076 0.0787 vmlinux __link_path_walk 11505 0.3367 2542 0.0964 libphp5.so compare_function 11472 0.3358 24011 0.9107 libphp5.so shutdown_memory_manager 11468 0.3357 5095 0.1932 libphp5.so ZEND_RECV_INIT_SPEC_CONST_HANDLER 11411 0.3340 1005 0.0381 libphp5.so zend_hash_clean 11174 0.3271 6182 0.2345 libphp5.so _get_zval_ptr_var 11062 0.3238 1772 0.0672 libphp5.so zend_parse_va_args 10846 0.3175 4930 0.1870 libphp5.so ZEND_DO_FCALL_SPEC_CONST_HANDLER 10079 0.2950 6702 0.2542 libphp5.so ZEND_SEND_VAL_SPEC_CONST_HANDLER 10034 0.2937 5778 0.2192 libphp5.so _zval_copy_ctor_func 9917 0.2903 2781 0.1055 libc-2.3.6.so _int_realloc 9781 0.2863 4857 0.1842 libphp5.so zend_assign_to_object 9619 0.2815 6794 0.2577 vmlinux copy_user_generic_c 9431 0.2760 1168 0.0443 libz.so.1.2.1.2 fill_window 9375 0.2744 3225 0.1223 libphp5.so ZEND_ASSIGN_SPEC_CV_VAR_HANDLER 9199 0.2692 3786 0.1436 libphp5.so zend_fetch_var_address_helper_SPEC_CONST 9022 0.2641 2609 0.0990 libphp5.so zend_get_property_info 8820 0.2582 3538 0.1342 libc-2.3.6.so realloc 8775 0.2568 848 0.0322 libphp5.so zend_call_function 8127 0.2379 1774 0.0673 libc-2.3.6.so ____strtol_l_internal 8091 0.2368 345 0.0131 libphp5.so zend_get_parameters_ex 7608 0.2227 3960 0.1502 libc-2.3.6.so strlen 7430 0.2175 14543 0.5516 vmlinux clear_page 7068 0.2069 3992 0.1514 vmlinux page_fault 6879 0.2013 1592 0.0604 libphp5.so zend_hash_copy 6653 0.1947 8629 0.3273 libphp5.so zend_binary_strcmp 6477 0.1896 2985 0.1132 libc-2.3.6.so memchr 6435 0.1883 3604 0.1367 libphp5.so ZEND_INIT_METHOD_CALL_SPEC_CV_CONST_HANDLER 6384 0.1869 7969 0.3023 libphp5.so zend_hash_del_key_or_index 6097 0.1785 2811 0.1066 libphp5.so ZEND_FE_FETCH_SPEC_VAR_HANDLER 6070 0.1777 1216 0.0461 libc-2.3.6.so vfprintf 5990 0.1753 3267 0.1239 libphp5.so ZEND_ADD_ARRAY_ELEMENT_SPEC_CONST_CONST_HANDLER 5966 0.1746 1866 0.0708 vmlinux groups_search 5452 0.1596 409 0.0155 libphp5.so zendi_smart_strcmp 5369 0.1571 1840 0.0698 reiserfs (no symbols) 5288 0.1548 3894 0.1477 libc-2.3.6.so __ctype_tolower_loc 5240 0.1534 3805 0.1443 libphp5.so zend_std_get_method 5029 0.1472 2986 0.1133 libphp5.so ZEND_RETURN_SPEC_CONST_HANDLER 5008 0.1466 2417 0.0917 libmysqlclient.so.10.0.0 (no symbols) 4986 0.1459 1332 0.0505 libphp5.so ZEND_JMPZ_SPEC_VAR_HANDLER 4878 0.1428 526 0.0200 libphp5.so php_escape_html_entities 4815 0.1409 4298 0.1630 libphp5.so ZEND_DO_FCALL_BY_NAME_SPEC_HANDLER 4805 0.1406 1402 0.0532 libphp5.so _zend_hash_init 4781 0.1399 190 0.0072 libphp5.so zend_strtod 4605 0.1348 4012 0.1522 libphp5.so ZEND_INIT_METHOD_CALL_SPEC_UNUSED_CONST_HANDLER 4599 0.1346 3551 0.1347 fss.so kwsincr 4555 0.1333 126 0.0048 libphp5.so zend_assign_to_variable_reference 4537 0.1328 1950 0.0740 libphp5.so ZEND_FETCH_W_SPEC_CONST_HANDLER 4529 0.1326 1403 0.0532 libphp5.so zend_std_read_property 4423 0.1295 2079 0.0789 libz.so.1.2.1.2 deflate_slow 4414 0.1292 422 0.0160 libz.so.1.2.1.2 inflate_fast 4226 0.1237 3736 0.1417 tg3 (no symbols) 4180 0.1223 1905 0.0723 libphp5.so zend_fetch_property_address_read_helper_SPEC_UNUSED_CONST 4123 0.1207 3095 0.1174 libphp5.so ZEND_JMPZ_EX_SPEC_TMP_HANDLER 4059 0.1188 2197 0.0833 libphp5.so ZEND_ADD_STRING_SPEC_TMP_CONST_HANDLER 4040 0.1182 3215 0.1219 libphp5.so ZEND_FETCH_OBJ_R_SPEC_UNUSED_CONST_HANDLER 3890 0.1139 36 0.0014 vmlinux pmtimer_mark_offset 3856 0.1129 3361 0.1275 libc-2.3.6.so strcmp 3839 0.1124 1718 0.0652 libphp5.so ZEND_JMPZ_SPEC_CV_HANDLER 3827 0.1120 736 0.0279 libphp5.so _ecalloc 3823 0.1119 2972 0.1127 vmlinux dput 3751 0.1098 6106 0.2316 apc.so apc_copy_op_array_for_execution 3750 0.1098 2571 0.0975 libphp5.so ZEND_SEND_VAR_SPEC_VAR_HANDLER 3723 0.1090 349 0.0132 vmlinux do_wp_page 3661 0.1072 875 0.0332 libphp5.so add_string_to_string 3626 0.1061 835 0.0317 vmlinux release_pages 3579 0.1048 1549 0.0588 libphp5.so ZEND_RETURN_SPEC_VAR_HANDLER 3564 0.1043 1773 0.0672 libphp5.so zend_make_printable_zval 3554 0.1040 2605 0.0988 libphp5.so ZEND_RETURN_SPEC_CV_HANDLER 3531 0.1033 128 0.0049 libphp5.so php_trim 3489 0.1021 4274 0.1621 vmlinux memcpy 3465 0.1014 1364 0.0517 libphp5.so concat_function 3441 0.1007 2443 0.0927 libz.so.1.2.1.2 deflate_fast 3409 0.0998 355 0.0135 libphp5.so convert_to_boolean 3389 0.0992 100 0.0038 libphp5.so php_pcre_match 3363 0.0984 712 0.0270 vmlinux system_call 3292 0.0964 2353 0.0892 libphp5.so zend_hash_get_current_key_ex 3281 0.0960 3875 0.1470 vmlinux can_share_swap_page 3278 0.0959 5899 0.2237 vmlinux copy_page 3233 0.0946 5200 0.1972 fss.so kwsprep 3211 0.0940 979 0.0371 libphp5.so ZEND_JMP_SPEC_HANDLER 3152 0.0923 2450 0.0929 libphp5.so zend_hash_exists 3107 0.0909 8510 0.3228 apc.so prevent_garbage_collection 3060 0.0896 104 0.0039 libz.so.1.2.1.2 __do_global_ctors_aux 3036 0.0889 16 6.1e-04 libphp5.so zif_strtr 3021 0.0884 313 0.0119 libphp5.so zend_std_write_property 2946 0.0862 106 0.0040 vmlinux strncpy_from_user 2922 0.0855 1834 0.0696 libphp5.so ZEND_SEND_VAL_SPEC_TMP_HANDLER 2910 0.0852 227 0.0086 libphp5.so zend_object_store_get_object 2792 0.0817 1073 0.0407 vmlinux flush_tlb_page 2772 0.0811 1510 0.0573 vmlinux kmem_cache_alloc 2730 0.0799 1861 0.0706 vmlinux find_vma 2695 0.0789 1011 0.0383 libphp5.so ZEND_BOOL_NOT_SPEC_VAR_HANDLER 2674 0.0783 2260 0.0857 libphp5.so zend_llist_del_element 2646 0.0774 1063 0.0403 vmlinux _atomic_dec_and_lock 2629 0.0769 726 0.0275 opreport (no symbols) 2583 0.0756 1284 0.0487 fss.so hasevery 2534 0.0742 1216 0.0461 vmlinux kmem_cache_free 2528 0.0740 1805 0.0685 libphp5.so zend_hash_get_current_data_ex 2442 0.0715 2321 0.0880 libphp5.so virtual_file_ex 2433 0.0712 1451 0.0550 libphp5.so ZEND_SEND_VAR_NO_REF_SPEC_VAR_HANDLER 2416 0.0707 230 0.0087 libphp5.so _safe_emalloc 2397 0.0702 743 0.0282 libphp5.so ZEND_RETURN_SPEC_TMP_HANDLER 2377 0.0696 313 0.0119 vmlinux do_page_fault 2335 0.0683 1 3.8e-05 libtidy-0.99.so.0.0.0 EncodeCharToUTF8Bytes 2319 0.0679 921 0.0349 libphp5.so add_function 2307 0.0675 366 0.0139 vmlinux do_lookup 2300 0.0673 1288 0.0489 libphp5.so ZEND_BOOL_SPEC_TMP_HANDLER 2293 0.0671 556 0.0211 vmlinux path_lookup 2286 0.0669 2802 0.1063 libphp5.so zval_update_constant 2283 0.0668 1257 0.0477 vmlinux schedule 2281 0.0668 132 0.0050 libphp5.so php_pcre_replace 2276 0.0666 346 0.0131 vmlinux permission 2273 0.0665 156 0.0059 apc.so apc_php_malloc 2261 0.0662 1068 0.0405 libphp5.so boolean_not_function 2247 0.0658 224 0.0085 libphp5.so php_pcre_fullinfo 2233 0.0654 461 0.0175 libphp5.so sub_function 2216 0.0649 831 0.0315 libphp5.so zend_hash_index_find 2203 0.0645 1028 0.0390 fss.so treefails 2188 0.0640 827 0.0314 vmlinux __posix_lock_file 2179 0.0638 694 0.0263 libphp5.so format_converter 2178 0.0637 34 0.0013 vmlinux pte_alloc_map 2175 0.0637 950 0.0360 libphp5.so ZEND_INIT_STATIC_METHOD_CALL_SPEC_CONST_HANDLER 2164 0.0633 161 0.0061 libphp5.so zif_array_map 2163 0.0633 688 0.0261 vmlinux __mod_page_state 2111 0.0618 215 0.0082 vmlinux handle_mm_fault 2102 0.0615 2090 0.0793 vmlinux __wake_up_bit 2102 0.0615 316 0.0120 vmlinux do_no_page 2095 0.0613 965 0.0366 libphp5.so zend_isset_isempty_dim_prop_obj_handler_SPEC_VAR_CV 2091 0.0612 1110 0.0421 libphp5.so ZEND_FETCH_DIM_R_SPEC_CV_CONST_HANDLER 2091 0.0612 1513 0.0574 oprofiled (no symbols) 2083 0.0610 214 0.0081 libphp5.so zend_is_callable_ex 2074 0.0607 1284 0.0487 libphp5.so ZEND_ASSIGN_OBJ_SPEC_UNUSED_CONST_HANDLER 2065 0.0604 688 0.0261 libphp5.so _array_init 2046 0.0599 44 0.0017 libphp5.so zval_add_ref 1995 0.0584 2285 0.0867 ld-2.3.6.so do_lookup_x 1990 0.0582 870 0.0330 libphp5.so ZEND_FETCH_DIM_R_SPEC_CV_CV_HANDLER 1973 0.0577 962 0.0365 libphp5.so ZEND_ASSIGN_SPEC_CV_TMP_HANDLER 1966 0.0575 1447 0.0549 libphp5.so zend_fetch_class 1944 0.0569 1298 0.0492 libphp5.so zend_isset_isempty_dim_prop_obj_handler_SPEC_CV_CV 1939 0.0568 695 0.0264 libphp5.so is_identical_function 1886 0.0552 39 0.0015 libphp5.so preg_replace_impl 1858 0.0544 941 0.0357 libphp5.so zend_get_constant 1847 0.0541 249 0.0094 libphp5.so _zend_hash_merge 1838 0.0538 781 0.0296 vmlinux acpi_processor_idle 1829 0.0535 566 0.0215 libphp5.so ZEND_ADD_ARRAY_ELEMENT_SPEC_VAR_UNUSED_HANDLER 1828 0.0535 434 0.0165 libphp5.so zend_objects_store_del_ref 1812 0.0530 1392 0.0528 libphp5.so ZEND_ADD_VAR_SPEC_TMP_CV_HANDLER 1803 0.0528 34 0.0013 libphp5.so php_char_to_str_ex 1795 0.0525 751 0.0285 libphp5.so ZEND_FETCH_DIM_R_SPEC_VAR_CONST_HANDLER 1787 0.0523 175 0.0066 libphp5.so zend_parse_parameters 1773 0.0519 510 0.0193 vmlinux in_group_p 1742 0.0510 1766 0.0670 libc-2.3.6.so strcasecmp