]> git.ipfire.org Git - thirdparty/gcc.git/blame - gcc/timevar.c
extend.texi, [...]: Eliminate overfull or underfull hboxes.
[thirdparty/gcc.git] / gcc / timevar.c
CommitLineData
2a9a326b
AS
1/* Timing variables for measuring compiler performance.
2 Copyright (C) 2000 Free Software Foundation, Inc.
3 Contributed by Alex Samuel <samuel@codesourcery.com>
4
5 This file is part of GNU CC.
6
7 GNU CC is free software; you can redistribute it and/or modify
8 it under the terms of the GNU General Public License as published by
9 the Free Software Foundation; either version 2, or (at your option)
10 any later version.
11
12 GNU CC is distributed in the hope that it will be useful,
13 but WITHOUT ANY WARRANTY; without even the implied warranty of
14 MERCHANTABILITY or FITNESS FOR A PARTICULAR PURPOSE. See the
15 GNU General Public License for more details.
16
17 You should have received a copy of the GNU General Public License
18 along with GNU CC; see the file COPYING. If not, write to
19 the Free Software Foundation, 59 Temple Place - Suite 330,
20 Boston, MA 02111-1307, USA. */
21
22#include "config.h"
23#include "system.h"
993c790e 24#include "intl.h"
2a9a326b
AS
25
26#ifdef HAVE_SYS_TIMES_H
27# include <sys/times.h>
28#endif
f9721d41
HPN
29#ifdef HAVE_SYS_RESOURCE_H
30#include <sys/resource.h>
31#endif
c1800ec8
ZW
32
33#ifndef HAVE_CLOCK_T
34typedef int clock_t;
35#endif
36
37#ifndef HAVE_STRUCT_TMS
38struct tms
39{
40 clock_t tms_utime;
41 clock_t tms_stime;
42 clock_t tms_cutime;
43 clock_t tms_cstime;
44};
45#endif
46
47#if defined HAVE_DECL_GETRUSAGE && !HAVE_DECL_GETRUSAGE
f9721d41
HPN
48extern int getrusage PARAMS ((int, struct rusage *));
49#endif
c1800ec8
ZW
50#if defined HAVE_DECL_TIMES && !HAVE_DECL_TIMES
51extern clock_t times PARAMS ((struct tms *));
52#endif
53#if defined HAVE_DECL_CLOCK && !HAVE_DECL_CLOCK
54extern clock_t clock PARAMS ((void));
55#endif
56
57#ifndef RUSAGE_SELF
58# define RUSAGE_SELF 0
59#endif
60
61/* Calculation of scale factor to convert ticks to microseconds.
62 We mustn't use CLOCKS_PER_SEC except with clock(). */
63#if HAVE_SYSCONF && defined _SC_CLK_TCK
64# define TICKS_PER_SECOND sysconf (_SC_CLK_TCK) /* POSIX 1003.1-1996 */
65#else
66# ifdef CLK_TCK
67# define TICKS_PER_SECOND CLK_TCK /* POSIX 1003.1-1988; obsolescent */
68# else
69# ifdef HZ
70# define TICKS_PER_SECOND HZ /* traditional UNIX */
71# else
72# define TICKS_PER_SECOND 100 /* often the correct value */
73# endif
74# endif
75#endif
76
c1800ec8
ZW
77/* Prefer times to getrusage to clock (each gives successively less
78 information). */
79#ifdef HAVE_TIMES
80# define USE_TIMES
81# define HAVE_USER_TIME
82# define HAVE_SYS_TIME
83# define HAVE_WALL_TIME
84#else
85#ifdef HAVE_GETRUSAGE
86# define USE_GETRUSAGE
87# define HAVE_USER_TIME
88# define HAVE_SYS_TIME
89#else
90#ifdef HAVE_CLOCK
91# define USE_CLOCK
92# define HAVE_USER_TIME
93#endif
94#endif
95#endif
f9721d41 96
d9b6874b
ZW
97/* libc is very likely to have snuck a call to sysconf() into one of
98 the underlying constants, and that can be very slow, so we have to
99 precompute them. Whose wonderful idea was it to make all those
100 _constants_ variable at run time, anyway? */
101#ifdef USE_TIMES
102static int ticks_to_msec;
103#define TICKS_TO_MSEC (1000 / TICKS_PER_SECOND)
104#endif
105
106#ifdef USE_CLOCK
107static int clocks_to_msec;
108#define CLOCKS_TO_MSEC (1000 / CLOCKS_PER_SEC)
109#endif
110
26026d38 111#include "flags.h"
2a9a326b
AS
112#include "timevar.h"
113
114/* See timevar.h for an explanation of timing variables. */
115
2d76cb1a 116/* This macro evaluates to non-zero if timing variables are enabled. */
fba0bfd4 117#define TIMEVAR_ENABLE (time_report)
26026d38 118
2a9a326b
AS
119/* A timing variable. */
120
121struct timevar_def
122{
123 /* Elapsed time for this variable. */
124 struct timevar_time_def elapsed;
125
126 /* If this variable is timed independently of the timing stack,
127 using timevar_start, this contains the start time. */
128 struct timevar_time_def start_time;
129
26026d38
AS
130 /* The name of this timing variable. */
131 const char *name;
132
2a9a326b
AS
133 /* Non-zero if this timing variable is running as a standalone
134 timer. */
26026d38 135 unsigned standalone : 1;
2a9a326b 136
26026d38
AS
137 /* Non-zero if this timing variable was ever started or pushed onto
138 the timing stack. */
139 unsigned used : 1;
2a9a326b
AS
140};
141
142/* An element on the timing stack. Elapsed time is attributed to the
143 topmost timing variable on the stack. */
144
145struct timevar_stack_def
146{
147 /* The timing variable at this stack level. */
148 struct timevar_def *timevar;
149
150 /* The next lower timing variable context in the stack. */
151 struct timevar_stack_def *next;
152};
153
154/* Declared timing variables. Constructed from the contents of
155 timevar.def. */
156static struct timevar_def timevars[TIMEVAR_LAST];
157
158/* The top of the timing stack. */
159static struct timevar_stack_def *stack;
160
26026d38
AS
161/* A list of unused (i.e. allocated and subsequently popped)
162 timevar_stack_def instances. */
163static struct timevar_stack_def *unused_stack_instances;
164
2a9a326b
AS
165/* The time at which the topmost element on the timing stack was
166 pushed. Time elapsed since then is attributed to the topmost
167 element. */
168static struct timevar_time_def start_time;
169
170static void get_time
171 PARAMS ((struct timevar_time_def *));
2a9a326b
AS
172static void timevar_accumulate
173 PARAMS ((struct timevar_time_def *, struct timevar_time_def *,
174 struct timevar_time_def *));
175
176/* Fill the current times into TIME. The definition of this function
177 also defines any or all of the HAVE_USER_TIME, HAVE_SYS_TIME, and
178 HAVA_WALL_TIME macros. */
179
180static void
26026d38
AS
181get_time (now)
182 struct timevar_time_def *now;
2a9a326b 183{
26026d38
AS
184 now->user = 0;
185 now->sys = 0;
186 now->wall = 0;
187
188 if (!TIMEVAR_ENABLE)
189 return;
2a9a326b 190
2a9a326b 191 {
c1800ec8 192#ifdef USE_TIMES
2a9a326b 193 struct tms tms;
d9b6874b
ZW
194 now->wall = times (&tms) * ticks_to_msec;
195 now->user = tms.tms_utime * ticks_to_msec;
196 now->sys = tms.tms_stime * ticks_to_msec;
c1800ec8
ZW
197#endif
198#ifdef USE_GETRUSAGE
2a9a326b 199 struct rusage rusage;
c1800ec8 200 getrusage (RUSAGE_SELF, &rusage);
d9b6874b
ZW
201 now->user = rusage.ru_utime.tv_sec * 1000 + rusage.ru_utime.tv_usec / 1000;
202 now->sys = rusage.ru_stime.tv_sec * 1000 + rusage.ru_stime.tv_usec / 1000;
c1800ec8
ZW
203#endif
204#ifdef USE_CLOCK
d9b6874b 205 now->user = clock () * clocks_to_msec;
c1800ec8 206#endif
2a9a326b 207 }
c1800ec8 208}
2a9a326b 209
2a9a326b
AS
210/* Add the difference between STOP_TIME and START_TIME to TIMER. */
211
212static void
213timevar_accumulate (timer, start_time, stop_time)
214 struct timevar_time_def *timer;
215 struct timevar_time_def *start_time;
216 struct timevar_time_def *stop_time;
217{
218 timer->user += stop_time->user - start_time->user;
219 timer->sys += stop_time->sys - start_time->sys;
220 timer->wall += stop_time->wall - start_time->wall;
221}
222
223/* Initialize timing variables. */
224
225void
4fbe8d07 226init_timevar ()
2a9a326b 227{
26026d38
AS
228 if (!TIMEVAR_ENABLE)
229 return;
230
2a9a326b
AS
231 /* Zero all elapsed times. */
232 memset ((void *) timevars, 0, sizeof (timevars));
233
234 /* Initialize the names of timing variables. */
235#define DEFTIMEVAR(identifer__, name__) \
236 timevars[identifer__].name = name__;
237#include "timevar.def"
238#undef DEFTIMEVAR
d9b6874b
ZW
239
240#ifdef USE_TIMES
241 ticks_to_msec = TICKS_TO_MSEC;
242#endif
243#ifdef USE_CLOCK
244 clocks_to_msec = CLOCKS_TO_MSEC;
245#endif
2a9a326b
AS
246}
247
248/* Push TIMEVAR onto the timing stack. No further elapsed time is
249 attributed to the previous topmost timing variable on the stack;
250 subsequent elapsed time is attributed to TIMEVAR, until it is
251 popped or another element is pushed on top.
252
253 TIMEVAR cannot be running as a standalone timer. */
254
255void
256timevar_push (timevar)
257 timevar_id_t timevar;
258{
259 struct timevar_def *tv = &timevars[timevar];
260 struct timevar_stack_def *context;
261 struct timevar_time_def now;
262
26026d38
AS
263 if (!TIMEVAR_ENABLE)
264 return;
265
266 /* Mark this timing variable as used. */
267 tv->used = 1;
268
2a9a326b
AS
269 /* Can't push a standalone timer. */
270 if (tv->standalone)
271 abort ();
272
273 /* What time is it? */
274 get_time (&now);
275
276 /* If the stack isn't empty, attribute the current elapsed time to
277 the old topmost element. */
278 if (stack)
279 timevar_accumulate (&stack->timevar->elapsed, &start_time, &now);
280
281 /* Reset the start time; from now on, time is attributed to
2d76cb1a 282 TIMEVAR. */
2a9a326b
AS
283 start_time = now;
284
26026d38
AS
285 /* See if we have a previously-allocated stack instance. If so,
286 take it off the list. If not, malloc a new one. */
287 if (unused_stack_instances != NULL)
288 {
289 context = unused_stack_instances;
290 unused_stack_instances = unused_stack_instances->next;
291 }
292 else
293 context = (struct timevar_stack_def *)
294 xmalloc (sizeof (struct timevar_stack_def));
295
296 /* Fill it in and put it on the stack. */
2a9a326b
AS
297 context->timevar = tv;
298 context->next = stack;
299 stack = context;
300}
301
302/* Pop the topmost timing variable element off the timing stack. The
303 popped variable must be TIMEVAR. Elapsed time since the that
304 element was pushed on, or since it was last exposed on top of the
305 stack when the element above it was popped off, is credited to that
306 timing variable. */
307
308void
309timevar_pop (timevar)
310 timevar_id_t timevar;
311{
312 struct timevar_time_def now;
26026d38
AS
313 struct timevar_stack_def *popped = stack;
314
315 if (!TIMEVAR_ENABLE)
316 return;
2a9a326b
AS
317
318 if (&timevars[timevar] != stack->timevar)
319 abort ();
320
321 /* What time is it? */
322 get_time (&now);
323
324 /* Attribute the elapsed time to the element we're popping. */
26026d38 325 timevar_accumulate (&popped->timevar->elapsed, &start_time, &now);
2a9a326b
AS
326
327 /* Reset the start time; from now on, time is attributed to the
328 element just exposed on the stack. */
329 start_time = now;
330
26026d38
AS
331 /* Take the item off the stack. */
332 stack = stack->next;
333
334 /* Don't delete the stack element; instead, add it to the list of
335 unused elements for later use. */
336 popped->next = unused_stack_instances;
337 unused_stack_instances = popped;
2a9a326b
AS
338}
339
340/* Start timing TIMEVAR independently of the timing stack. Elapsed
341 time until timevar_stop is called for the same timing variable is
342 attributed to TIMEVAR. */
343
344void
345timevar_start (timevar)
346 timevar_id_t timevar;
347{
348 struct timevar_def *tv = &timevars[timevar];
349
26026d38
AS
350 if (!TIMEVAR_ENABLE)
351 return;
352
353 /* Mark this timing variable as used. */
354 tv->used = 1;
355
2a9a326b
AS
356 /* Don't allow the same timing variable to be started more than
357 once. */
358 if (tv->standalone)
359 abort ();
360 tv->standalone = 1;
361
362 get_time (&tv->start_time);
363}
364
365/* Stop timing TIMEVAR. Time elapsed since timevar_start was called
366 is attributed to it. */
367
368void
369timevar_stop (timevar)
370 timevar_id_t timevar;
371{
372 struct timevar_def *tv = &timevars[timevar];
373 struct timevar_time_def now;
374
26026d38
AS
375 if (!TIMEVAR_ENABLE)
376 return;
377
2a9a326b
AS
378 /* TIMEVAR must have been started via timevar_start. */
379 if (!tv->standalone)
380 abort ();
381
382 get_time (&now);
383 timevar_accumulate (&tv->elapsed, &tv->start_time, &now);
384}
385
386/* Fill the elapsed time for TIMEVAR into ELAPSED. Returns
387 update-to-date information even if TIMEVAR is currently running. */
388
389void
390timevar_get (timevar, elapsed)
391 timevar_id_t timevar;
392 struct timevar_time_def *elapsed;
393{
394 struct timevar_def *tv = &timevars[timevar];
eab828ba 395 struct timevar_time_def now;
2a9a326b
AS
396
397 *elapsed = tv->elapsed;
eab828ba 398
2a9a326b
AS
399 /* Is TIMEVAR currently running as a standalone timer? */
400 if (tv->standalone)
eab828ba
ZW
401 {
402 get_time (&now);
403 timevar_accumulate (elapsed, &tv->start_time, &now);
404 }
405 /* Or is TIMEVAR at the top of the timer stack? */
406 else if (stack->timevar == tv)
407 {
408 get_time (&now);
409 timevar_accumulate (elapsed, &start_time, &now);
410 }
2a9a326b
AS
411}
412
413/* Summarize timing variables to FP. The timing variable TV_TOTAL has
414 a special meaning -- it's considered to be the total elapsed time,
415 for normalizing the others, and is displayed last. */
416
417void
418timevar_print (fp)
419 FILE *fp;
420{
421 /* Only print stuff if we have some sort of time information. */
422#if defined (HAVE_USER_TIME) || defined (HAVE_SYS_TIME) || defined (HAVE_WALL_TIME)
dbbbbf3b 423 unsigned int /* timevar_id_t */ id;
2a9a326b 424 struct timevar_time_def *total = &timevars[TV_TOTAL].elapsed;
ea11ca7e 425 struct timevar_time_def now;
2a9a326b 426
26026d38
AS
427 if (!TIMEVAR_ENABLE)
428 return;
429
ea11ca7e
JM
430 /* Update timing information in case we're calling this from GDB. */
431
432 if (fp == 0)
433 fp = stderr;
434
435 /* What time is it? */
436 get_time (&now);
437
438 /* If the stack isn't empty, attribute the current elapsed time to
439 the old topmost element. */
440 if (stack)
441 timevar_accumulate (&stack->timevar->elapsed, &start_time, &now);
442
443 /* Reset the start time; from now on, time is attributed to
2d76cb1a 444 TIMEVAR. */
ea11ca7e
JM
445 start_time = now;
446
d9b6874b 447 fputs (_("\nExecution times (seconds)\n"), fp);
dbbbbf3b 448 for (id = 0; id < (unsigned int) TIMEVAR_LAST; ++id)
2a9a326b 449 {
dbbbbf3b 450 struct timevar_def *tv = &timevars[(timevar_id_t) id];
2a9a326b
AS
451
452 /* Don't print the total execution time here; that goes at the
453 end. */
dbbbbf3b 454 if ((timevar_id_t) id == TV_TOTAL)
2a9a326b
AS
455 continue;
456
26026d38
AS
457 /* Don't print timing variables that were never used. */
458 if (!tv->used)
459 continue;
460
d9b6874b
ZW
461 /* Don't print timing variables if we're going to get a row of
462 zeroes. */
463 if (tv->elapsed.user < 10 && tv->elapsed.sys < 10
464 && tv->elapsed.wall < 10)
465 continue;
466
2a9a326b
AS
467 /* The timing variable name. */
468 fprintf (fp, " %-22s:", tv->name);
469
470#ifdef HAVE_USER_TIME
471 /* Print user-mode time for this process. */
472 fprintf (fp, "%4ld.%02ld (%2.0f%%) usr",
d9b6874b
ZW
473 tv->elapsed.user / 1000, (tv->elapsed.user % 1000) / 10,
474 (total->user == 0) ? 0.0
2a9a326b
AS
475 : (100.0 * tv->elapsed.user / (double) total->user));
476#endif /* HAVE_USER_TIME */
477
478#ifdef HAVE_SYS_TIME
479 /* Print system-mode time for this process. */
480 fprintf (fp, "%4ld.%02ld (%2.0f%%) sys",
d9b6874b
ZW
481 tv->elapsed.sys / 1000, (tv->elapsed.sys % 1000) / 10,
482 (total->sys == 0) ? 0.0
2a9a326b
AS
483 : (100.0 * tv->elapsed.sys / (double) total->sys));
484#endif /* HAVE_SYS_TIME */
485
486#ifdef HAVE_WALL_TIME
487 /* Print wall clock time elapsed. */
488 fprintf (fp, "%4ld.%02ld (%2.0f%%) wall",
d9b6874b
ZW
489 tv->elapsed.wall / 1000, (tv->elapsed.wall % 1000) / 10,
490 (total->wall == 0) ? 0.0
2a9a326b
AS
491 : (100.0 * tv->elapsed.wall / (double) total->wall));
492#endif /* HAVE_WALL_TIME */
493
d9b6874b 494 putc ('\n', fp);
2a9a326b
AS
495 }
496
497 /* Print total time. */
d9b6874b 498 fputs (_(" TOTAL :"), fp);
2a9a326b
AS
499#ifdef HAVE_USER_TIME
500 fprintf (fp, "%4ld.%02ld ",
d9b6874b 501 total->user / 1000, (total->user % 1000) / 10);
2a9a326b
AS
502#endif
503#ifdef HAVE_SYS_TIME
504 fprintf (fp, "%4ld.%02ld ",
d9b6874b 505 total->sys / 1000, (total->sys % 1000) / 10);
2a9a326b
AS
506#endif
507#ifdef HAVE_WALL_TIME
508 fprintf (fp, "%4ld.%02ld\n",
d9b6874b 509 total->wall / 1000, (total->wall % 1000) / 10);
2a9a326b
AS
510#endif
511
512#endif /* defined (HAVE_USER_TIME) || defined (HAVE_SYS_TIME)
513 || defined (HAVE_WALL_TIME) */
514}
515
516/* Returns time (user + system) used so far by the compiler process,
517 in microseconds. */
518
519long
520get_run_time ()
521{
522 struct timevar_time_def total_elapsed;
523 timevar_get (TV_TOTAL, &total_elapsed);
524 return total_elapsed.user + total_elapsed.sys;
525}
526
527/* Prints a message to stderr stating that time elapsed in STR is
528 TOTAL (given in microseconds). */
529
530void
531print_time (str, total)
532 const char *str;
533 long total;
534{
535 long all_time = get_run_time ();
536 fprintf (stderr,
5e4adfba 537 _("time in %s: %ld.%06ld (%ld%%)\n"),
2a9a326b
AS
538 str, total / 1000000, total % 1000000,
539 all_time == 0 ? 0
540 : (long) (((100.0 * (double) total) / (double) all_time) + .5));
541}