]> git.sommitrealweird.co.uk Git - onak.git/blob - onak.gprof
cscvs to tla changeset 18
[onak.git] / onak.gprof
1 Flat profile:
2
3 Each sample counts as 0.01 seconds.
4   %   cumulative   self              self     total           
5  time   seconds   seconds    calls  us/call  us/call  name    
6  44.57      0.41     0.41    44208     9.27    14.02  transform
7  22.83      0.62     0.21  9902592     0.02     0.02  rol
8   9.78      0.71     0.09    31610     2.85    19.66  sha1_write
9   7.61      0.78     0.07    33623     2.08     2.08  stdin_getchar
10   2.17      0.80     0.02     6937     2.88   106.67  get_keyid
11   2.17      0.82     0.02     1690    11.83    17.75  write_openpgp_stream
12   2.17      0.84     0.02                             Letext
13   1.09      0.85     0.01    30179     0.33     0.33  keydb_putchar
14   1.09      0.86     0.01    17848     0.56     0.56  packet_dup
15   1.09      0.87     0.01     6322     1.58    35.26  sha1_final
16   1.09      0.88     0.01     1690     5.92     8.88  flatten_publickey
17   1.09      0.89     0.01     1690     5.92     5.92  keyuids
18   1.09      0.90     0.01     1690     5.92   262.98  store_key
19   1.09      0.91     0.01        1 10000.00 10000.00  free_publickey
20   1.09      0.92     0.01        1 10000.00 815000.00  update_keys
21   0.00      0.92     0.00    17848     0.00     0.00  free_packet
22   0.00      0.92     0.00     6322     0.00     0.00  sha1_init
23   0.00      0.92     0.00     6322     0.00     0.00  sha1_read
24   0.00      0.92     0.00     3438     0.00     0.00  free_packet_list
25   0.00      0.92     0.00     3227     0.00     0.00  free_signedpacket_list
26   0.00      0.92     0.00     1690     0.00     0.00  endtrans
27   0.00      0.92     0.00     1690     0.00     0.00  fetch_key
28   0.00      0.92     0.00     1690     0.00     0.00  spsize
29   0.00      0.92     0.00     1690     0.00     0.00  starttrans
30   0.00      0.92     0.00        1     0.00     0.00  cleanupdb
31   0.00      0.92     0.00        1     0.00     0.00  initdb
32   0.00      0.92     0.00        1     0.00  5000.00  parse_keys
33   0.00      0.92     0.00        1     0.00 70000.00  read_openpgp_stream
34
35  %         the percentage of the total running time of the
36 time       program used by this function.
37
38 cumulative a running sum of the number of seconds accounted
39  seconds   for by this function and those listed above it.
40
41  self      the number of seconds accounted for by this
42 seconds    function alone.  This is the major sort for this
43            listing.
44
45 calls      the number of times this function was invoked, if
46            this function is profiled, else blank.
47  
48  self      the average number of milliseconds spent in this
49 ms/call    function per call, if this function is profiled,
50            else blank.
51
52  total     the average number of milliseconds spent in this
53 ms/call    function and its descendents per call, if this 
54            function is profiled, else blank.
55
56 name       the name of the function.  This is the minor sort
57            for this listing. The index shows the location of
58            the function in the gprof listing. If the index is
59            in parenthesis it shows where it would appear in
60            the gprof listing if it were to be printed.
61 \f
62                      Call graph (explanation follows)
63
64
65 granularity: each sample hit covers 4 byte(s) for 1.09% of 0.92 seconds
66
67 index % time    self  children    called     name
68                                                  <spontaneous>
69 [1]     97.8    0.00    0.90                 main [1]
70                 0.01    0.81       1/1           update_keys [2]
71                 0.00    0.07       1/1           read_openpgp_stream [10]
72                 0.01    0.00       1/1           free_publickey [17]
73                 0.00    0.01       1/1           parse_keys [18]
74                 0.00    0.00       1/3438        free_packet_list [22]
75                 0.00    0.00       1/1           initdb [29]
76                 0.00    0.00       1/1           cleanupdb [28]
77 -----------------------------------------------
78                 0.01    0.81       1/1           main [1]
79 [2]     88.6    0.01    0.81       1         update_keys [2]
80                 0.01    0.43    1690/1690        store_key [6]
81                 0.01    0.35    3380/6937        get_keyid [3]
82                 0.00    0.00    1690/1690        starttrans [27]
83                 0.00    0.00    1690/1690        fetch_key [25]
84                 0.00    0.00    1690/1690        endtrans [24]
85 -----------------------------------------------
86                 0.01    0.35    3380/6937        update_keys [2]
87                 0.01    0.37    3557/6937        store_key [6]
88 [3]     80.4    0.02    0.72    6937         get_keyid [3]
89                 0.07    0.43   25288/31610       sha1_write [4]
90                 0.01    0.21    6322/6322        sha1_final [7]
91                 0.00    0.00    6322/6322        sha1_init [20]
92                 0.00    0.00    6322/6322        sha1_read [21]
93 -----------------------------------------------
94                                18966             sha1_write [4]
95                 0.02    0.11    6322/31610       sha1_final [7]
96                 0.07    0.43   25288/31610       get_keyid [3]
97 [4]     67.5    0.09    0.53   31610+18966   sha1_write [4]
98                 0.35    0.18   37886/44208       transform [5]
99                                18966             sha1_write [4]
100 -----------------------------------------------
101                 0.06    0.03    6322/44208       sha1_final [7]
102                 0.35    0.18   37886/44208       sha1_write [4]
103 [5]     67.4    0.41    0.21   44208         transform [5]
104                 0.21    0.00 9902592/9902592     rol [8]
105 -----------------------------------------------
106                 0.01    0.43    1690/1690        update_keys [2]
107 [6]     48.3    0.01    0.43    1690         store_key [6]
108                 0.01    0.37    3557/6937        get_keyid [3]
109                 0.02    0.01    1690/1690        write_openpgp_stream [11]
110                 0.01    0.01    1690/1690        flatten_publickey [13]
111                 0.01    0.00    1690/1690        keyuids [16]
112 -----------------------------------------------
113                 0.01    0.21    6322/6322        get_keyid [3]
114 [7]     24.2    0.01    0.21    6322         sha1_final [7]
115                 0.02    0.11    6322/31610       sha1_write [4]
116                 0.06    0.03    6322/44208       transform [5]
117 -----------------------------------------------
118                 0.21    0.00 9902592/9902592     transform [5]
119 [8]     22.8    0.21    0.00 9902592         rol [8]
120 -----------------------------------------------
121                 0.07    0.00   33623/33623       read_openpgp_stream [10]
122 [9]      7.6    0.07    0.00   33623         stdin_getchar [9]
123 -----------------------------------------------
124                 0.00    0.07       1/1           main [1]
125 [10]     7.6    0.00    0.07       1         read_openpgp_stream [10]
126                 0.07    0.00   33623/33623       stdin_getchar [9]
127 -----------------------------------------------
128                 0.02    0.01    1690/1690        store_key [6]
129 [11]     3.3    0.02    0.01    1690         write_openpgp_stream [11]
130                 0.01    0.00   30179/30179       keydb_putchar [14]
131 -----------------------------------------------
132                                                  <spontaneous>
133 [12]     2.2    0.02    0.00                 Letext [12]
134 -----------------------------------------------
135                 0.01    0.01    1690/1690        store_key [6]
136 [13]     1.6    0.01    0.01    1690         flatten_publickey [13]
137                 0.01    0.00    8924/17848       packet_dup [15]
138 -----------------------------------------------
139                 0.01    0.00   30179/30179       write_openpgp_stream [11]
140 [14]     1.1    0.01    0.00   30179         keydb_putchar [14]
141 -----------------------------------------------
142                 0.01    0.00    8924/17848       parse_keys [18]
143                 0.01    0.00    8924/17848       flatten_publickey [13]
144 [15]     1.1    0.01    0.00   17848         packet_dup [15]
145 -----------------------------------------------
146                 0.01    0.00    1690/1690        store_key [6]
147 [16]     1.1    0.01    0.00    1690         keyuids [16]
148                 0.00    0.00    1690/1690        spsize [26]
149 -----------------------------------------------
150                 0.01    0.00       1/1           main [1]
151 [17]     1.1    0.01    0.00       1         free_publickey [17]
152                 0.00    0.00    3227/3227        free_signedpacket_list [23]
153                 0.00    0.00    1690/17848       free_packet [19]
154                 0.00    0.00      41/3438        free_packet_list [22]
155 -----------------------------------------------
156                 0.00    0.01       1/1           main [1]
157 [18]     0.5    0.00    0.01       1         parse_keys [18]
158                 0.01    0.00    8924/17848       packet_dup [15]
159 -----------------------------------------------
160                 0.00    0.00    1690/17848       free_publickey [17]
161                 0.00    0.00    3410/17848       free_signedpacket_list [23]
162                 0.00    0.00   12748/17848       free_packet_list [22]
163 [19]     0.0    0.00    0.00   17848         free_packet [19]
164 -----------------------------------------------
165                 0.00    0.00    6322/6322        get_keyid [3]
166 [20]     0.0    0.00    0.00    6322         sha1_init [20]
167 -----------------------------------------------
168                 0.00    0.00    6322/6322        get_keyid [3]
169 [21]     0.0    0.00    0.00    6322         sha1_read [21]
170 -----------------------------------------------
171                 0.00    0.00       1/3438        main [1]
172                 0.00    0.00      41/3438        free_publickey [17]
173                 0.00    0.00    3396/3438        free_signedpacket_list [23]
174 [22]     0.0    0.00    0.00    3438         free_packet_list [22]
175                 0.00    0.00   12748/17848       free_packet [19]
176 -----------------------------------------------
177                 0.00    0.00    3227/3227        free_publickey [17]
178 [23]     0.0    0.00    0.00    3227         free_signedpacket_list [23]
179                 0.00    0.00    3410/17848       free_packet [19]
180                 0.00    0.00    3396/3438        free_packet_list [22]
181 -----------------------------------------------
182                 0.00    0.00    1690/1690        update_keys [2]
183 [24]     0.0    0.00    0.00    1690         endtrans [24]
184 -----------------------------------------------
185                 0.00    0.00    1690/1690        update_keys [2]
186 [25]     0.0    0.00    0.00    1690         fetch_key [25]
187 -----------------------------------------------
188                 0.00    0.00    1690/1690        keyuids [16]
189 [26]     0.0    0.00    0.00    1690         spsize [26]
190 -----------------------------------------------
191                 0.00    0.00    1690/1690        update_keys [2]
192 [27]     0.0    0.00    0.00    1690         starttrans [27]
193 -----------------------------------------------
194                 0.00    0.00       1/1           main [1]
195 [28]     0.0    0.00    0.00       1         cleanupdb [28]
196 -----------------------------------------------
197                 0.00    0.00       1/1           main [1]
198 [29]     0.0    0.00    0.00       1         initdb [29]
199 -----------------------------------------------
200
201  This table describes the call tree of the program, and was sorted by
202  the total amount of time spent in each function and its children.
203
204  Each entry in this table consists of several lines.  The line with the
205  index number at the left hand margin lists the current function.
206  The lines above it list the functions that called this function,
207  and the lines below it list the functions this one called.
208  This line lists:
209      index      A unique number given to each element of the table.
210                 Index numbers are sorted numerically.
211                 The index number is printed next to every function name so
212                 it is easier to look up where the function in the table.
213
214      % time     This is the percentage of the `total' time that was spent
215                 in this function and its children.  Note that due to
216                 different viewpoints, functions excluded by options, etc,
217                 these numbers will NOT add up to 100%.
218
219      self       This is the total amount of time spent in this function.
220
221      children   This is the total amount of time propagated into this
222                 function by its children.
223
224      called     This is the number of times the function was called.
225                 If the function called itself recursively, the number
226                 only includes non-recursive calls, and is followed by
227                 a `+' and the number of recursive calls.
228
229      name       The name of the current function.  The index number is
230                 printed after it.  If the function is a member of a
231                 cycle, the cycle number is printed between the
232                 function's name and the index number.
233
234
235  For the function's parents, the fields have the following meanings:
236
237      self       This is the amount of time that was propagated directly
238                 from the function into this parent.
239
240      children   This is the amount of time that was propagated from
241                 the function's children into this parent.
242
243      called     This is the number of times this parent called the
244                 function `/' the total number of times the function
245                 was called.  Recursive calls to the function are not
246                 included in the number after the `/'.
247
248      name       This is the name of the parent.  The parent's index
249                 number is printed after it.  If the parent is a
250                 member of a cycle, the cycle number is printed between
251                 the name and the index number.
252
253  If the parents of the function cannot be determined, the word
254  `<spontaneous>' is printed in the `name' field, and all the other
255  fields are blank.
256
257  For the function's children, the fields have the following meanings:
258
259      self       This is the amount of time that was propagated directly
260                 from the child into the function.
261
262      children   This is the amount of time that was propagated from the
263                 child's children to the function.
264
265      called     This is the number of times the function called
266                 this child `/' the total number of times the child
267                 was called.  Recursive calls by the child are not
268                 listed in the number after the `/'.
269
270      name       This is the name of the child.  The child's index
271                 number is printed after it.  If the child is a
272                 member of a cycle, the cycle number is printed
273                 between the name and the index number.
274
275  If there are any cycles (circles) in the call graph, there is an
276  entry for the cycle-as-a-whole.  This entry shows who called the
277  cycle (as parents) and the members of the cycle (as children.)
278  The `+' recursive calls entry shows the number of function calls that
279  were internal to the cycle, and the calls entry for each member shows,
280  for that member, how many times it was called from other members of
281  the cycle.
282
283 \f
284 Index by function name
285
286   [12] Letext (bithelp.h)     [29] initdb                  [4] sha1_write
287   [28] cleanupdb              [14] keydb_putchar (keydb_pg.c) [26] spsize
288   [24] endtrans               [16] keyuids                [27] starttrans
289   [25] fetch_key              [15] packet_dup              [9] stdin_getchar
290   [13] flatten_publickey      [18] parse_keys              [6] store_key
291   [19] free_packet            [10] read_openpgp_stream     [5] transform (sha.c)
292   [22] free_packet_list        [8] rol (bithelp.h)         [2] update_keys
293   [17] free_publickey          [7] sha1_final             [11] write_openpgp_stream
294   [23] free_signedpacket_list [20] sha1_init
295    [3] get_keyid              [21] sha1_read