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