2
This commit is contained in:
214
server-exp/perf.txt
Normal file
214
server-exp/perf.txt
Normal file
@@ -0,0 +1,214 @@
|
||||
Flat profile:
|
||||
|
||||
Each sample counts as 0.01 seconds.
|
||||
% cumulative self self total
|
||||
time seconds seconds calls ns/call ns/call name
|
||||
28.57 0.10 0.10 1461740 68.41 116.30 rio_readlineb
|
||||
25.71 0.19 0.09 365435 246.28 930.40 process_trans
|
||||
20.00 0.26 0.07 29966110 2.34 2.34 rio_read
|
||||
5.71 0.28 0.02 974534 20.52 20.52 rio_writen
|
||||
5.71 0.30 0.02 243603 82.10 123.15 feed_static
|
||||
5.71 0.32 0.02 121832 164.16 246.25 error_request
|
||||
2.86 0.33 0.01 365435 27.36 376.26 read_requesthdrs
|
||||
2.86 0.34 0.01 121832 82.08 82.08 parse_dynamic_uri
|
||||
2.86 0.35 0.01 main
|
||||
0.00 0.35 0.00 365435 0.00 0.00 is_static
|
||||
0.00 0.35 0.00 365435 0.00 0.00 rio_readinitb
|
||||
0.00 0.35 0.00 243603 0.00 0.00 get_filetype
|
||||
0.00 0.35 0.00 243603 0.00 0.00 parse_static_uri
|
||||
0.00 0.35 0.00 1 0.00 0.00 open_listen_sock
|
||||
|
||||
% 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.
|
||||
|
||||
Copyright (C) 2012-2026 Free Software Foundation, Inc.
|
||||
|
||||
Copying and distribution of this file, with or without modification,
|
||||
are permitted in any medium without royalty provided the copyright
|
||||
notice and this notice are preserved.
|
||||
|
||||
Call graph (explanation follows)
|
||||
|
||||
|
||||
granularity: each sample hit covers 4 byte(s) for 2.86% of 0.35 seconds
|
||||
|
||||
index % time self children called name
|
||||
<spontaneous>
|
||||
[1] 100.0 0.01 0.34 main [1]
|
||||
0.09 0.25 365435/365435 process_trans [2]
|
||||
0.00 0.00 1/1 open_listen_sock [14]
|
||||
-----------------------------------------------
|
||||
0.09 0.25 365435/365435 main [1]
|
||||
[2] 97.1 0.09 0.25 365435 process_trans [2]
|
||||
0.01 0.13 365435/365435 read_requesthdrs [4]
|
||||
0.03 0.02 365435/1461740 rio_readlineb [3]
|
||||
0.02 0.01 121832/121832 error_request [6]
|
||||
0.02 0.01 243603/243603 feed_static [7]
|
||||
0.01 0.00 121832/121832 parse_dynamic_uri [9]
|
||||
0.00 0.00 365435/365435 rio_readinitb [11]
|
||||
0.00 0.00 365435/365435 is_static [10]
|
||||
0.00 0.00 243603/243603 parse_static_uri [13]
|
||||
-----------------------------------------------
|
||||
0.03 0.02 365435/1461740 process_trans [2]
|
||||
0.07 0.05 1096305/1461740 read_requesthdrs [4]
|
||||
[3] 48.6 0.10 0.07 1461740 rio_readlineb [3]
|
||||
0.07 0.00 29966110/29966110 rio_read [5]
|
||||
-----------------------------------------------
|
||||
0.01 0.13 365435/365435 process_trans [2]
|
||||
[4] 39.3 0.01 0.13 365435 read_requesthdrs [4]
|
||||
0.07 0.05 1096305/1461740 rio_readlineb [3]
|
||||
-----------------------------------------------
|
||||
0.07 0.00 29966110/29966110 rio_readlineb [3]
|
||||
[5] 20.0 0.07 0.00 29966110 rio_read [5]
|
||||
-----------------------------------------------
|
||||
0.02 0.01 121832/121832 process_trans [2]
|
||||
[6] 8.6 0.02 0.01 121832 error_request [6]
|
||||
0.01 0.00 487328/974534 rio_writen [8]
|
||||
-----------------------------------------------
|
||||
0.02 0.01 243603/243603 process_trans [2]
|
||||
[7] 8.6 0.02 0.01 243603 feed_static [7]
|
||||
0.01 0.00 487206/974534 rio_writen [8]
|
||||
0.00 0.00 243603/243603 get_filetype [12]
|
||||
-----------------------------------------------
|
||||
0.01 0.00 487206/974534 feed_static [7]
|
||||
0.01 0.00 487328/974534 error_request [6]
|
||||
[8] 5.7 0.02 0.00 974534 rio_writen [8]
|
||||
-----------------------------------------------
|
||||
0.01 0.00 121832/121832 process_trans [2]
|
||||
[9] 2.9 0.01 0.00 121832 parse_dynamic_uri [9]
|
||||
-----------------------------------------------
|
||||
0.00 0.00 365435/365435 process_trans [2]
|
||||
[10] 0.0 0.00 0.00 365435 is_static [10]
|
||||
-----------------------------------------------
|
||||
0.00 0.00 365435/365435 process_trans [2]
|
||||
[11] 0.0 0.00 0.00 365435 rio_readinitb [11]
|
||||
-----------------------------------------------
|
||||
0.00 0.00 243603/243603 feed_static [7]
|
||||
[12] 0.0 0.00 0.00 243603 get_filetype [12]
|
||||
-----------------------------------------------
|
||||
0.00 0.00 243603/243603 process_trans [2]
|
||||
[13] 0.0 0.00 0.00 243603 parse_static_uri [13]
|
||||
-----------------------------------------------
|
||||
0.00 0.00 1/1 main [1]
|
||||
[14] 0.0 0.00 0.00 1 open_listen_sock [14]
|
||||
-----------------------------------------------
|
||||
|
||||
This table describes the call tree of the program, and was sorted by
|
||||
the total amount of time spent in each function and its children.
|
||||
|
||||
Each entry in this table consists of several lines. The line with the
|
||||
index number at the left hand margin lists the current function.
|
||||
The lines above it list the functions that called this function,
|
||||
and the lines below it list the functions this one called.
|
||||
This line lists:
|
||||
index A unique number given to each element of the table.
|
||||
Index numbers are sorted numerically.
|
||||
The index number is printed next to every function name so
|
||||
it is easier to look up where the function is in the table.
|
||||
|
||||
% time This is the percentage of the `total' time that was spent
|
||||
in this function and its children. Note that due to
|
||||
different viewpoints, functions excluded by options, etc,
|
||||
these numbers will NOT add up to 100%.
|
||||
|
||||
self This is the total amount of time spent in this function.
|
||||
|
||||
children This is the total amount of time propagated into this
|
||||
function by its children.
|
||||
|
||||
called This is the number of times the function was called.
|
||||
If the function called itself recursively, the number
|
||||
only includes non-recursive calls, and is followed by
|
||||
a `+' and the number of recursive calls.
|
||||
|
||||
name The name of the current function. The index number is
|
||||
printed after it. If the function is a member of a
|
||||
cycle, the cycle number is printed between the
|
||||
function's name and the index number.
|
||||
|
||||
|
||||
For the function's parents, the fields have the following meanings:
|
||||
|
||||
self This is the amount of time that was propagated directly
|
||||
from the function into this parent.
|
||||
|
||||
children This is the amount of time that was propagated from
|
||||
the function's children into this parent.
|
||||
|
||||
called This is the number of times this parent called the
|
||||
function `/' the total number of times the function
|
||||
was called. Recursive calls to the function are not
|
||||
included in the number after the `/'.
|
||||
|
||||
name This is the name of the parent. The parent's index
|
||||
number is printed after it. If the parent is a
|
||||
member of a cycle, the cycle number is printed between
|
||||
the name and the index number.
|
||||
|
||||
If the parents of the function cannot be determined, the word
|
||||
`<spontaneous>' is printed in the `name' field, and all the other
|
||||
fields are blank.
|
||||
|
||||
For the function's children, the fields have the following meanings:
|
||||
|
||||
self This is the amount of time that was propagated directly
|
||||
from the child into the function.
|
||||
|
||||
children This is the amount of time that was propagated from the
|
||||
child's children to the function.
|
||||
|
||||
called This is the number of times the function called
|
||||
this child `/' the total number of times the child
|
||||
was called. Recursive calls by the child are not
|
||||
listed in the number after the `/'.
|
||||
|
||||
name This is the name of the child. The child's index
|
||||
number is printed after it. If the child is a
|
||||
member of a cycle, the cycle number is printed
|
||||
between the name and the index number.
|
||||
|
||||
If there are any cycles (circles) in the call graph, there is an
|
||||
entry for the cycle-as-a-whole. This entry shows who called the
|
||||
cycle (as parents) and the members of the cycle (as children.)
|
||||
The `+' recursive calls entry shows the number of function calls that
|
||||
were internal to the cycle, and the calls entry for each member shows,
|
||||
for that member, how many times it was called from other members of
|
||||
the cycle.
|
||||
|
||||
Copyright (C) 2012-2026 Free Software Foundation, Inc.
|
||||
|
||||
Copying and distribution of this file, with or without modification,
|
||||
are permitted in any medium without royalty provided the copyright
|
||||
notice and this notice are preserved.
|
||||
|
||||
Index by function name
|
||||
|
||||
[6] error_request [14] open_listen_sock [5] rio_read (common.c)
|
||||
[7] feed_static [9] parse_dynamic_uri [11] rio_readinitb
|
||||
[12] get_filetype [13] parse_static_uri [3] rio_readlineb
|
||||
[10] is_static [2] process_trans [8] rio_writen
|
||||
[1] main [4] read_requesthdrs
|
||||
Reference in New Issue
Block a user