基本
-pg
でコンパイルして実行すると gmon.out というファイルが生成されるので、実行ファイルを第1引数、gmon.outを第二引数にして gprof
を実行する。
$ gcc -pg main.c
$ ./a.out
$ gprof ./a.out gmon.out
出力
サンプリングされた回数が多い順の関数のリストと、コールグラフが見られる。
Each sample counts as 0.01 seconds.
% cumulative self self total
time seconds seconds calls ms/call ms/call name
38.46 0.05 0.05 6336 0.01 0.01 forward_DCT
30.77 0.09 0.04 576 0.07 0.07 rgb_ycc_convert
23.08 0.12 0.03 9504 0.00 0.00 jpeg_fdct_islow
7.69 0.13 0.01 9504 0.00 0.00 encode_one_block
0.00 0.13 0.00 38770 0.00 0.00 emit_bits
0.00 0.13 0.00 1584 0.00 0.01 encode_mcu_huff
0.00 0.13 0.00 864 0.00 0.00 expand_right_edge
0.00 0.13 0.00 753 0.00 0.00 emit_byte
0.00 0.13 0.00 611 0.00 0.07 pre_process_data
0.00 0.13 0.00 576 0.00 0.00 get_raw_row
granularity: each sample hit covers 4 byte(s) for 7.69% of 0.13 seconds
index % time self children called name
0.00 0.13 576/576 main [3]
[1] 100.0 0.00 0.13 576 jpeg_write_scanlines [1]
0.00 0.13 576/576 process_data_simple_main [2]
0.00 0.00 1/1 pass_startup [85]
-----------------------------------------------
0.00 0.13 576/576 jpeg_write_scanlines [1]
[2] 100.0 0.00 0.13 576 process_data_simple_main [2]
0.00 0.09 36/36 compress_data [4]
0.00 0.04 611/611 pre_process_data [6]
-----------------------------------------------
同じファイルに書いてあるが、読み方は以下の通り:
% the percentage of the total running time of the
time program used by this function.
cumulative a running sum of the number of seconds accounted
seconds for by this function and those listed above it.
self the number of seconds accounted for by this
seconds function alone. This is the major sort for this
listing.
calls the number of times this function was invoked, if
this function is profiled, else blank.
self the average number of milliseconds spent in this
ms/call function per call, if this function is profiled,
else blank.
total the average number of milliseconds spent in this
ms/call function and its descendents per call, if this
function is profiled, else blank.
name the name of the function. This is the minor sort
for this listing. The index shows the location of
the function in the gprof listing. If the index is
in parenthesis it shows where it would appear in
the gprof listing if it were to be printed.
ソースコード中に実行回数を表示
実行ファイルは -pg
に加え、-g
つきでコンパイルする。その後 -A
つきで gprof を実行する。
*** File /app/test.c:
test_table (test_ptr arg)
2 -> {
TEST *test;
test = null;
return test;
}
test_alloc (test_ptr arg)
4 -> {
Top 10 Lines:
Line Count
99 4
87 2
30 1
70 1
Execution Summary:
4 Executable lines in this file
4 Lines executed
100.00 Percent of the file executed
8 Total number of line executions
2.00 Average executions per line
ソースコードと実行回数、その後に同ファイルのトップ10行やサマリが出てくる。