src/vm/statistics.c

   1 /* src/vm/statistics.c - global varables for statistics
   2
   3    Copyright (C) 1996-2005 R. Grafl, A. Krall, C. Kruegel, C. Oates,
   4    R. Obermaisser, M. Platter, M. Probst, S. Ring, E. Steiner,
   5    C. Thalinger, D. Thuernbeck, P. Tomsich, C. Ullrich, J. Wenninger,
   6    Institut f. Computersprachen - TU Wien
   7
   8    This file is part of CACAO.
   9
  10    This program is free software; you can redistribute it and/or
  11    modify it under the terms of the GNU General Public License as
  12    published by the Free Software Foundation; either version 2, or (at
  13    your option) any later version.
  14
  15    This program is distributed in the hope that it will be useful, but
  16    WITHOUT ANY WARRANTY; without even the implied warranty of
  17    MERCHANTABILITY or FITNESS FOR A PARTICULAR PURPOSE.  See the GNU
  18    General Public License for more details.
  19
  20    You should have received a copy of the GNU General Public License
  21    along with this program; if not, write to the Free Software
  22    Foundation, Inc., 59 Temple Place - Suite 330, Boston, MA
  23    02111-1307, USA.
  24
  25    Contact: cacao@complang.tuwien.ac.at
  26
  27    Authors: Christian Thalinger
  28
  29    $Id: statistics.c 2424 2005-04-30 13:45:06Z jowenn $
  30
  31 */
  32
  33
  34 #include <sys/time.h>
  35 #include <sys/resource.h>
  36
  37 #include "toolbox/logging.h"
  38 #include "vm/global.h"
  39 #include "vm/options.h"
  40 #include "vm/statistics.h"
  41 #include <string.h>
  42
  43
  44 /* global variables */
  45
  46 static s8 loadingtime = 0;              /* accumulated loading time           */
  47 static s8 loadingstarttime = 0;
  48 static s8 loadingstoptime = 0;
  49 static s4 loadingtime_recursion = 0;
  50
  51 static s8 compilingtime = 0;            /* accumulated compile time           */
  52 static s8 compilingstarttime = 0;
  53 static s8 compilingstoptime = 0;
  54 static s4 compilingtime_recursion = 0;
  55
  56 s4 memoryusage = 0;
  57 s4 maxmemusage = 0;
  58 s4 maxdumpsize = 0;
  59
  60 s4 globalallocateddumpsize = 0;
  61 s4 globaluseddumpsize = 0;
  62
  63 int count_class_infos = 0;              /* variables for measurements         */
  64 int count_const_pool_len = 0;
  65 int count_classref_len = 0;
  66 int count_parsed_desc_len = 0;
  67 int count_vftbl_len = 0;
  68 int count_all_methods = 0;
  69 int count_methods_marked_used = 0;  /* RTA */
  70
  71 int count_vmcode_len = 0;
  72 int count_extable_len = 0;
  73 int count_class_loads = 0;
  74 int count_class_inits = 0;
  75
  76 int count_utf_len = 0;                  /* size of utf hash                   */
  77 int count_utf_new = 0;                  /* calls of utf_new                   */
  78 int count_utf_new_found  = 0;           /* calls of utf_new with fast return  */
  79
  80 int count_locals_conflicts = 0;         /* register allocator statistics */
  81 int count_locals_spilled = 0;
  82 int count_locals_register = 0;
  83 int count_ss_spilled = 0;
  84 int count_ss_register = 0;
  85 int count_methods_allocated_by_lsra = 0;
  86 int count_mem_move_bb = 0;
  87 int count_interface_size = 0;
  88 int count_argument_mem_ss = 0;
  89 int count_argument_reg_ss = 0;
  90 int count_method_in_register = 0;
  91 int count_mov_reg_reg = 0;
  92 int count_mov_mem_reg = 0;
  93 int count_mov_reg_mem = 0;
  94 int count_mov_mem_mem = 0;
  95
  96 int count_jit_calls = 0;
  97 int count_methods = 0;
  98 int count_spills = 0;
  99 int count_spills_read = 0;
 100 int count_pcmd_activ = 0;
 101 int count_pcmd_drop = 0;
 102 int count_pcmd_zero = 0;
 103 int count_pcmd_const_store = 0;
 104 int count_pcmd_const_alu = 0;
 105 int count_pcmd_const_bra = 0;
 106 int count_pcmd_load = 0;
 107 int count_pcmd_move = 0;
 108 int count_load_instruction = 0;
 109 int count_pcmd_store = 0;
 110 int count_pcmd_store_comb = 0;
 111 int count_dup_instruction = 0;
 112 int count_pcmd_op = 0;
 113 int count_pcmd_mem = 0;
 114 int count_pcmd_met = 0;
 115 int count_pcmd_bra = 0;
 116 int count_pcmd_table = 0;
 117 int count_pcmd_return = 0;
 118 int count_pcmd_returnx = 0;
 119 int count_check_null = 0;
 120 int count_check_bound = 0;
 121 int count_max_basic_blocks = 0;
 122 int count_basic_blocks = 0;
 123 int count_javainstr = 0;
 124 int count_max_javainstr = 0;
 125 int count_javacodesize = 0;
 126 int count_javaexcsize = 0;
 127 int count_calls = 0;
 128 int count_tryblocks = 0;
 129 int count_code_len = 0;
 130 int count_data_len = 0;
 131 int count_cstub_len = 0;
 132 int count_nstub_len = 0;
 133 int count_max_new_stack = 0;
 134 int count_upper_bound_new_stack = 0;
 135                                 /* in_  inline statistics */
 136 int count_in = 0;
 137 int count_in_uniqVirt = 0;
 138 int count_in_uniqIntf = 0;
 139 int count_in_rejected = 0;
 140 int count_in_rejected_mult = 0;
 141 int count_in_outsiders = 0;
 142 int count_in_uniqueVirt_not_inlined = 0;
 143 int count_in_uniqueInterface_not_inlined = 0;
 144 int count_in_maxDepth = 0;
 145 int count_in_maxMethods = 0;
 146
 147 u8 count_native_function_calls=0;
 148 u8 count_compiled_function_calls=0;
 149 u8 count_jni_callXmethod_calls=0;
 150 u8 count_jni_calls=0;
 151
 152 u2 count_in_not   [512];
 153 /***
 154 int count_no_in[12] = {0,0,0,0, 0,0,0,0, 0,0,0,0};
 155 ***/
 156
 157
 158
 159 static int count_block_stack_init[11] = {
 160         0, 0, 0, 0, 0,
 161         0, 0, 0, 0, 0,
 162         0
 163 };
 164 int *count_block_stack = count_block_stack_init;
 165 static int count_analyse_iterations_init[5] = {
 166         0, 0, 0, 0, 0
 167 };
 168 int *count_analyse_iterations = count_analyse_iterations_init;
 169 static int count_method_bb_distribution_init[9] = {
 170         0, 0, 0, 0, 0,
 171         0, 0, 0, 0
 172 };
 173 int *count_method_bb_distribution = count_method_bb_distribution_init;
 174 static int count_block_size_distribution_init[18] = {
 175         0, 0, 0, 0, 0,
 176         0, 0, 0, 0, 0,
 177         0, 0, 0, 0, 0,
 178         0, 0, 0
 179 };
 180 int *count_block_size_distribution = count_block_size_distribution_init;
 181 static int count_store_length_init[21] = {
 182         0, 0, 0, 0, 0,
 183         0, 0, 0, 0, 0,
 184         0, 0, 0, 0, 0,
 185         0, 0, 0, 0, 0,
 186         0
 187 };
 188 int *count_store_length = count_store_length_init;
 189 static int count_store_depth_init[11] = {
 190         0, 0, 0, 0, 0,
 191         0, 0, 0, 0, 0,
 192         0
 193 };
 194 int *count_store_depth = count_store_depth_init;
 195
 196
 197 /* instruction scheduler statistics *******************************************/
 198
 199 s4 count_schedule_basic_blocks = 0;
 200 s4 count_schedule_nodes = 0;
 201 s4 count_schedule_leaders = 0;
 202 s4 count_schedule_max_leaders = 0;
 203 s4 count_schedule_critical_path = 0;
 204
 205
 206
 207 /* nativeinvokation ***********************************************************
 208
 209    increments the native invokation count by one
 210
 211 *******************************************************************************/
 212 void nativeinvokation() {
 213         /*do locking here */
 214         count_native_function_calls++;
 215 }
 216
 217 /* compiledinvokation *********************************************************
 218
 219    increments the compiled invokation count by one
 220
 221 *******************************************************************************/
 222 void compiledinvokation() {
 223         /* do locking here*/
 224         count_compiled_function_calls++;
 225 }
 226
 227
 228 /* jnicallXmethodinvokation ***************************************************
 229
 230    increments the jni CallXMethod invokation count by one
 231
 232 *******************************************************************************/
 233 void jnicallXmethodnvokation() {
 234         /*do locking here */
 235         count_jni_callXmethod_calls++;
 236 }
 237
 238 /* jniinvokation *************************************************************
 239
 240    increments the jni overall  invokation count by one
 241
 242 *******************************************************************************/
 243 void jniinvokation() {
 244         /*do locking here */
 245         count_jni_calls++;
 246 }
 247
 248
 249 /* getcputime *********************************** ******************************
 250
 251    Returns the used CPU time in microseconds
 252
 253 *******************************************************************************/
 254
 255 s8 getcputime()
 256 {
 257         struct rusage ru;
 258         int sec, usec;
 259
 260         getrusage(RUSAGE_SELF, &ru);
 261         sec = ru.ru_utime.tv_sec + ru.ru_stime.tv_sec;
 262         usec = ru.ru_utime.tv_usec + ru.ru_stime.tv_usec;
 263
 264         return sec * 1000000 + usec;
 265 }
 266
 267
 268 /* loadingtime_stop ************************************************************
 269
 270    XXX
 271
 272 *******************************************************************************/
 273
 274 void loadingtime_start()
 275 {
 276         loadingtime_recursion++;
 277
 278         if (loadingtime_recursion == 1)
 279                 loadingstarttime = getcputime();
 280 }
 281
 282
 283 /* loadingtime_stop ************************************************************
 284
 285    XXX
 286
 287 *******************************************************************************/
 288
 289 void loadingtime_stop()
 290 {
 291         if (loadingtime_recursion == 1) {
 292                 loadingstoptime = getcputime();
 293                 loadingtime += (loadingstoptime - loadingstarttime);
 294         }
 295
 296         loadingtime_recursion--;
 297 }
 298
 299
 300 /* compilingtime_stop **********************************************************
 301
 302    XXX
 303
 304 *******************************************************************************/
 305
 306 void compilingtime_start()
 307 {
 308         compilingtime_recursion++;
 309
 310         if (compilingtime_recursion == 1)
 311                 compilingstarttime = getcputime();
 312 }
 313
 314
 315 /* compilingtime_stop **********************************************************
 316
 317    XXX
 318
 319 *******************************************************************************/
 320
 321 void compilingtime_stop()
 322 {
 323         if (compilingtime_recursion == 1) {
 324                 compilingstoptime = getcputime();
 325                 compilingtime += (compilingstoptime - compilingstarttime);
 326         }
 327
 328         compilingtime_recursion--;
 329 }
 330
 331
 332 /* print_times *****************************************************************
 333
 334    Prints a summary of CPU time usage.
 335
 336 *******************************************************************************/
 337
 338 void print_times()
 339 {
 340         s8 totaltime = getcputime();
 341         s8 runtime = totaltime - loadingtime - compilingtime;
 342         char logtext[MAXLOGTEXT];
 343
 344 #if defined(__I386__) || defined(__POWERPC__)
 345         sprintf(logtext, "Time for loading classes: %lld secs, %lld millis",
 346 #else
 347         sprintf(logtext, "Time for loading classes: %ld secs, %ld millis",
 348 #endif
 349                         loadingtime / 1000000, (loadingtime % 1000000) / 1000);
 350         log_text(logtext);
 351
 352 #if defined(__I386__) || defined(__POWERPC__)
 353         sprintf(logtext, "Time for compiling code:  %lld secs, %lld millis",
 354 #else
 355         sprintf(logtext, "Time for compiling code:  %ld secs, %ld millis",
 356 #endif
 357                         compilingtime / 1000000, (compilingtime % 1000000) / 1000);
 358         log_text(logtext);
 359
 360 #if defined(__I386__) || defined(__POWERPC__)
 361         sprintf(logtext, "Time for running program: %lld secs, %lld millis",
 362 #else
 363         sprintf(logtext, "Time for running program: %ld secs, %ld millis",
 364 #endif
 365                         runtime / 1000000, (runtime % 1000000) / 1000);
 366         log_text(logtext);
 367
 368 #if defined(__I386__) || defined(__POWERPC__)
 369         sprintf(logtext, "Total time: %lld secs, %lld millis",
 370 #else
 371         sprintf(logtext, "Total time: %ld secs, %ld millis",
 372 #endif
 373                         totaltime / 1000000, (totaltime % 1000000) / 1000);
 374         log_text(logtext);
 375 }
 376
 377
 378 /* print_stats *****************************************************************
 379
 380    outputs detailed compiler statistics
 381
 382 *******************************************************************************/
 383
 384 void print_stats()
 385 {
 386         char logtext[MAXLOGTEXT];
 387
 388         sprintf(logtext, "Number of JitCompiler Calls: %d", count_jit_calls);
 389         log_text(logtext);
 390         sprintf(logtext, "Number of compiled Methods: %d", count_methods);
 391         log_text(logtext);
 392         if (opt_rt) {
 393           sprintf(logtext, "Number of Methods marked Used: %d", count_methods_marked_used);
 394           log_text(logtext);
 395           }
 396         sprintf(logtext, "Number of max basic blocks per method: %d", count_max_basic_blocks);
 397         log_text(logtext);
 398         sprintf(logtext, "Number of compiled basic blocks: %d", count_basic_blocks);
 399         log_text(logtext);
 400         sprintf(logtext, "Number of max JavaVM-Instructions per method: %d", count_max_javainstr);
 401         log_text(logtext);
 402         sprintf(logtext, "Number of compiled JavaVM-Instructions: %d", count_javainstr);
 403         log_text(logtext);
 404         sprintf(logtext, "Size of compiled JavaVM-Instructions:   %d(%d)", count_javacodesize,
 405                         count_javacodesize - count_methods * 18);
 406         log_text(logtext);
 407         sprintf(logtext, "Size of compiled Exception Tables:      %d", count_javaexcsize);
 408         log_text(logtext);
 409         sprintf(logtext, "Number of Machine-Instructions: %d", count_code_len >> 2);
 410         log_text(logtext);
 411         sprintf(logtext, "Number of Spills (write to memory): %d", count_spills);
 412         log_text(logtext);
 413         sprintf(logtext, "Number of Spills (read from memory): %d", count_spills_read);
 414         log_text(logtext);
 415         sprintf(logtext, "Number of Activ    Pseudocommands: %6d", count_pcmd_activ);
 416         log_text(logtext);
 417         sprintf(logtext, "Number of Drop     Pseudocommands: %6d", count_pcmd_drop);
 418         log_text(logtext);
 419         sprintf(logtext, "Number of Const    Pseudocommands: %6d (zero:%5d)", count_pcmd_load, count_pcmd_zero);
 420         log_text(logtext);
 421         sprintf(logtext, "Number of ConstAlu Pseudocommands: %6d (cmp: %5d, store:%5d)", count_pcmd_const_alu, count_pcmd_const_bra, count_pcmd_const_store);
 422         log_text(logtext);
 423         sprintf(logtext, "Number of Move     Pseudocommands: %6d", count_pcmd_move);
 424         log_text(logtext);
 425         sprintf(logtext, "Number of Load     Pseudocommands: %6d", count_load_instruction);
 426         log_text(logtext);
 427         sprintf(logtext, "Number of Store    Pseudocommands: %6d (combined: %5d)", count_pcmd_store, count_pcmd_store - count_pcmd_store_comb);
 428         log_text(logtext);
 429         sprintf(logtext, "Number of OP       Pseudocommands: %6d", count_pcmd_op);
 430         log_text(logtext);
 431         sprintf(logtext, "Number of DUP      Pseudocommands: %6d", count_dup_instruction);
 432         log_text(logtext);
 433         sprintf(logtext, "Number of Mem      Pseudocommands: %6d", count_pcmd_mem);
 434         log_text(logtext);
 435         sprintf(logtext, "Number of Method   Pseudocommands: %6d", count_pcmd_met);
 436         log_text(logtext);
 437         sprintf(logtext, "Number of Branch   Pseudocommands: %6d (rets:%5d, Xrets: %5d)",
 438                         count_pcmd_bra, count_pcmd_return, count_pcmd_returnx);
 439         log_text(logtext);
 440         sprintf(logtext, "Number of Table    Pseudocommands: %6d", count_pcmd_table);
 441         log_text(logtext);
 442         sprintf(logtext, "Number of Useful   Pseudocommands: %6d", count_pcmd_table +
 443                         count_pcmd_bra + count_pcmd_load + count_pcmd_mem + count_pcmd_op);
 444         log_text(logtext);
 445         sprintf(logtext, "Number of Null Pointer Checks:     %6d", count_check_null);
 446         log_text(logtext);
 447         sprintf(logtext, "Number of Array Bound Checks:      %6d", count_check_bound);
 448         log_text(logtext);
 449         sprintf(logtext, "Number of Try-Blocks: %d", count_tryblocks);
 450         log_text(logtext);
 451         sprintf(logtext, "Maximal count of stack elements:   %d", count_max_new_stack);
 452         log_text(logtext);
 453         sprintf(logtext, "Upper bound of max stack elements: %d", count_upper_bound_new_stack);
 454         log_text(logtext);
 455         sprintf(logtext, "Distribution of stack sizes at block boundary");
 456         log_text(logtext);
 457         sprintf(logtext, "     0     1     2     3     4     5     6     7     8     9  >=10");
 458         log_text(logtext);
 459         sprintf(logtext, "%6d%6d%6d%6d%6d%6d%6d%6d%6d%6d%6d", count_block_stack[0],
 460                         count_block_stack[1], count_block_stack[2], count_block_stack[3], count_block_stack[4],
 461                         count_block_stack[5], count_block_stack[6], count_block_stack[7], count_block_stack[8],
 462                         count_block_stack[9], count_block_stack[10]);
 463         log_text(logtext);
 464         sprintf(logtext, "Distribution of store stack depth");
 465         log_text(logtext);
 466         sprintf(logtext, "     0     1     2     3     4     5     6     7     8     9  >=10");
 467         log_text(logtext);
 468         sprintf(logtext, "%6d%6d%6d%6d%6d%6d%6d%6d%6d%6d%6d", count_store_depth[0],
 469                         count_store_depth[1], count_store_depth[2], count_store_depth[3], count_store_depth[4],
 470                         count_store_depth[5], count_store_depth[6], count_store_depth[7], count_store_depth[8],
 471                         count_store_depth[9], count_store_depth[10]);
 472         log_text(logtext);
 473         sprintf(logtext, "Distribution of store creator chains first part");
 474         log_text(logtext);
 475         sprintf(logtext, "     0     1     2     3     4     5     6     7     8     9");
 476         log_text(logtext);
 477         sprintf(logtext, "%6d%6d%6d%6d%6d%6d%6d%6d%6d%6d", count_store_length[0],
 478                         count_store_length[1], count_store_length[2], count_store_length[3], count_store_length[4],
 479                         count_store_length[5], count_store_length[6], count_store_length[7], count_store_length[8],
 480                         count_store_length[9]);
 481         log_text(logtext);
 482         sprintf(logtext, "Distribution of store creator chains second part");
 483         log_text(logtext);
 484         sprintf(logtext, "    10    11    12    13    14    15    16    17    18    19  >=20");
 485         log_text(logtext);
 486         sprintf(logtext, "%6d%6d%6d%6d%6d%6d%6d%6d%6d%6d%6d", count_store_length[10],
 487                         count_store_length[11], count_store_length[12], count_store_length[13], count_store_length[14],
 488                         count_store_length[15], count_store_length[16], count_store_length[17], count_store_length[18],
 489                         count_store_length[19], count_store_length[20]);
 490         log_text(logtext);
 491         sprintf(logtext, "Distribution of analysis iterations");
 492         log_text(logtext);
 493         sprintf(logtext, "     1     2     3     4   >=5");
 494         log_text(logtext);
 495         sprintf(logtext, "%6d%6d%6d%6d%6d", count_analyse_iterations[0], count_analyse_iterations[1],
 496                         count_analyse_iterations[2], count_analyse_iterations[3], count_analyse_iterations[4]);
 497         log_text(logtext);
 498         sprintf(logtext, "Distribution of basic blocks per method");
 499         log_text(logtext);
 500         sprintf(logtext, "   <=5  <=10  <=15  <=20  <=30  <=40  <=50  <=75   >75");
 501         log_text(logtext);
 502         sprintf(logtext, "%6d%6d%6d%6d%6d%6d%6d%6d%6d", count_method_bb_distribution[0],
 503                         count_method_bb_distribution[1], count_method_bb_distribution[2], count_method_bb_distribution[3],
 504                         count_method_bb_distribution[4], count_method_bb_distribution[5], count_method_bb_distribution[6],
 505                         count_method_bb_distribution[7], count_method_bb_distribution[8]);
 506         log_text(logtext);
 507         sprintf(logtext, "Distribution of basic block sizes");
 508         log_text(logtext);
 509         sprintf(logtext, "     0     1     2     3     4    5    6    7    8    9  <13  <15  <17  <19  <21  <26  <31  >30");
 510         log_text(logtext);
 511         sprintf(logtext, "%6d%6d%6d%6d%6d%5d%5d%5d%5d%5d%5d%5d%5d%5d%5d%5d%5d%5d",
 512                         count_block_size_distribution[0], count_block_size_distribution[1], count_block_size_distribution[2],
 513                         count_block_size_distribution[3], count_block_size_distribution[4], count_block_size_distribution[5],
 514                         count_block_size_distribution[6], count_block_size_distribution[7], count_block_size_distribution[8],
 515                         count_block_size_distribution[9], count_block_size_distribution[10], count_block_size_distribution[11],
 516                         count_block_size_distribution[12], count_block_size_distribution[13], count_block_size_distribution[14],
 517                         count_block_size_distribution[15], count_block_size_distribution[16], count_block_size_distribution[17]);
 518         log_text(logtext);
 519         sprintf(logtext, "Size of Code Area (Kb):  %10.3f", (float) count_code_len / 1024);
 520         log_text(logtext);
 521         sprintf(logtext, "Size of data Area (Kb):  %10.3f", (float) count_data_len / 1024);
 522         log_text(logtext);
 523         sprintf(logtext, "Size of Class Infos (Kb):%10.3f", (float) (count_class_infos) / 1024);
 524         log_text(logtext);
 525         sprintf(logtext, "Size of Const Pool (Kb): %10.3f", (float) (count_const_pool_len + count_utf_len) / 1024);
 526         log_text(logtext);
 527         sprintf(logtext, "Size of Class refs (Kb): %10.3f", (float) (count_classref_len) / 1024);
 528         log_text(logtext);
 529         sprintf(logtext, "Size of descriptors(Kb): %10.3f", (float) (count_parsed_desc_len) / 1024);
 530         log_text(logtext);
 531         sprintf(logtext, "Size of Vftbl (Kb):      %10.3f", (float) count_vftbl_len / 1024);
 532         log_text(logtext);
 533         sprintf(logtext, "Size of comp stub (Kb):  %10.3f", (float) count_cstub_len / 1024);
 534         log_text(logtext);
 535         sprintf(logtext, "Size of native stub (Kb):%10.3f", (float) count_nstub_len / 1024);
 536         log_text(logtext);
 537         sprintf(logtext, "Size of Utf (Kb):        %10.3f", (float) count_utf_len / 1024);
 538         log_text(logtext);
 539         sprintf(logtext, "Size of VMCode (Kb):     %10.3f(%d)", (float) count_vmcode_len / 1024,
 540                         count_vmcode_len - 18 * count_all_methods);
 541         log_text(logtext);
 542         sprintf(logtext, "Size of ExTable (Kb):    %10.3f", (float) count_extable_len / 1024);
 543         log_text(logtext);
 544         sprintf(logtext, "Number of class loads:   %d", count_class_loads);
 545         log_text(logtext);
 546         sprintf(logtext, "Number of class inits:   %d", count_class_inits);
 547         log_text(logtext);
 548         sprintf(logtext, "Number of loaded Methods: %d\n", count_all_methods);
 549         log_text(logtext);
 550
 551         sprintf(logtext, "Calls of utf_new: %22d", count_utf_new);
 552         log_text(logtext);
 553         sprintf(logtext, "Calls of utf_new (element found): %6d\n", count_utf_new_found);
 554         log_text(logtext);
 555
 556
 557         /* LSRA statistics ********************************************************/
 558         sprintf(logtext, "Moves reg -> reg:     %6d",count_mov_reg_reg );
 559         log_text(logtext);
 560         sprintf(logtext, "Moves mem -> reg:     %6d",count_mov_mem_reg );
 561         log_text(logtext);
 562         sprintf(logtext, "Moves reg -> mem:     %6d",count_mov_reg_mem );
 563         log_text(logtext);
 564         sprintf(logtext, "Moves mem -> mem:     %6d",count_mov_mem_mem );
 565         log_text(logtext);
 566
 567         sprintf(logtext, "Methods allocated by LSRA:         %6d", count_methods_allocated_by_lsra);
 568         log_text(logtext);
 569         sprintf(logtext, "Conflicts between local Variables: %6d", count_locals_conflicts);
 570         log_text(logtext);
 571         sprintf(logtext, "Local Variables held in Memory:    %6d", count_locals_spilled);
 572         log_text(logtext);
 573         sprintf(logtext, "Local Variables held in Registers: %6d", count_locals_register);
 574         log_text(logtext);
 575         sprintf(logtext, "Stackslots held in Memory:         %6d", count_ss_spilled);
 576         log_text(logtext);
 577         sprintf(logtext, "Stackslots held in Registers:      %6d",count_ss_register );
 578         log_text(logtext);
 579         sprintf(logtext, "Memory moves at BB Boundaries:     %6d",count_mem_move_bb );
 580         log_text(logtext);
 581         sprintf(logtext, "Number of interface slots:         %6d\n",count_interface_size );
 582         log_text(logtext);
 583         sprintf(logtext, "Number of Argument stack slots in register:  %6d",count_argument_reg_ss );
 584         log_text(logtext);
 585         sprintf(logtext, "Number of Argument stack slots in memory:    %6d\n",count_argument_mem_ss );
 586         log_text(logtext);
 587         sprintf(logtext, "Number of Methods kept in registers:         %6d\n",count_method_in_register );
 588         log_text(logtext);
 589
 590         /****if (useinlining)  ***/
 591          {
 592                 u2 ii;
 593                 char * in_not_reasons[IN_MAX] = {
 594                                                 "unqVirt    | ",
 595                                                 "unqIntf    | ",
 596                                                 "outsider   | ",
 597                                                 "maxDepth   | ",
 598                                                 "maxcode    | ",
 599                                                 "maxlen     | ",
 600                                                 "exception  | ",
 601                                                 "notUnqVirt | ",
 602                                                 "notUnqIntf |"
 603                                                 };
 604
 605                 sprintf(logtext, "Number of Methods Inlined :                              \t%6d",count_in );
 606                 log_text(logtext);
 607                 if (inlinevirtuals) {
 608                   sprintf(logtext, "Number of Unique Virtual Methods inlined:                \t%6d",count_in_uniqVirt);
 609                   log_text(logtext);
 610                   sprintf(logtext, "Number of Unique Implemented Interface Methods inlined:    %6d",count_in_uniqIntf);
 611                   log_text(logtext);
 612                   }
 613                 sprintf(logtext, "Number of Methods Inlines (total) rejected:              \t%6d",count_in_rejected);
 614                 log_text(logtext);
 615                 sprintf(logtext, "Number of Methods Inlined rejected for multiple reasons: \t%6d",count_in_rejected_mult);
 616                 log_text(logtext);
 617                 sprintf(logtext, "Number of Methods where Inline max depth hit:            \t%6d",count_in_maxDepth);
 618                 log_text(logtext);
 619                 sprintf(logtext, "Number of Methods Inlined rejected for max methods       \t%6d\n",count_in_maxMethods);
 620                 log_text(logtext);
 621                 sprintf(logtext, "Number of Methods calls fom Outsider Class not inlined:  \t%6d",count_in_outsiders);
 622                 log_text(logtext);
 623
 624                 sprintf(logtext, "Number of Unique Virtual Methods not inlined:            \t%6d",count_in_uniqueVirt_not_inlined);
 625                 log_text(logtext);
 626                 sprintf(logtext, "Number of Unique Implemented Interface Methods not inlined:%6d",count_in_uniqueInterface_not_inlined);
 627                 log_text(logtext);
 628 #define INLINEDETAILS
 629 #ifdef  INLINEDETAILS
 630                 sprintf(logtext, "\nDetails about Not Inlined Reasons :");
 631                 log_text(logtext);
 632                 for (ii=0;ii<512;ii++) {
 633                         if (count_in_not[ii]>0) {
 634                                 char logtext2[MAXLOGTEXT]="\t";
 635
 636                                 if (inlinevirtuals) {
 637                                   if (ii & IN_UNIQUEVIRT) strcat(logtext2, in_not_reasons[N_UNIQUEVIRT]);
 638                                   if (ii & IN_UNIQUE_INTERFACE) strcat(logtext2,  in_not_reasons[N_UNIQUE_INTERFACE]);
 639                                   if (ii & IN_NOT_UNIQUE_VIRT) strcat(logtext2,  in_not_reasons[N_NOT_UNIQUE_VIRT]);
 640                                   if (ii & IN_NOT_UNIQUE_INTERFACE) strcat(logtext2,  in_not_reasons[N_NOT_UNIQUE_INTERFACE]);
 641                                   }
 642                                 if (ii & IN_OUTSIDERS) strcat(logtext2,  in_not_reasons[N_OUTSIDERS]);
 643                                 if (ii & IN_MAXDEPTH) strcat(logtext2,  in_not_reasons[N_MAXDEPTH]);
 644                                 if (ii & IN_MAXCODE) strcat(logtext2,  in_not_reasons[N_MAXCODE]);
 645                                 if (ii & IN_JCODELENGTH) strcat(logtext2,  in_not_reasons[N_JCODELENGTH]);
 646                                 if (ii & IN_EXCEPTION) strcat(logtext2,  in_not_reasons[N_EXCEPTION]);
 647                                 sprintf(logtext, "  [%X]=%6d    %s",ii, count_in_not[ii], logtext2 );
 648                                 log_text(logtext);
 649                                 }
 650                         }
 651 #endif
 652                 }
 653
 654
 655          /* instruction scheduler statistics **************************************/
 656
 657          sprintf(logtext, "Instruction scheduler statistics:");
 658          log_text(logtext);
 659          sprintf(logtext, "Number of basic blocks:       %7d", count_schedule_basic_blocks);
 660          log_text(logtext);
 661          sprintf(logtext, "Number of nodes:              %7d", count_schedule_nodes);
 662          log_text(logtext);
 663          sprintf(logtext, "Number of leaders nodes:      %7d", count_schedule_leaders);
 664          log_text(logtext);
 665          sprintf(logtext, "Number of max. leaders nodes: %7d", count_schedule_max_leaders);
 666          log_text(logtext);
 667          sprintf(logtext, "Length of critical path:      %7d\n", count_schedule_critical_path);
 668          log_text(logtext);
 669
 670
 671         /* call statistics */
 672         log_text("Function call statistics:");
 673         sprintf(logtext,"Number of native function invokations:           %ld", count_native_function_calls);
 674         log_text(logtext);
 675         sprintf(logtext,"Number of compiled function invokations:         %ld", count_compiled_function_calls);
 676         log_text(logtext);
 677         sprintf(logtext,"Number of jni->CallXMethod function invokations: %ld", count_jni_callXmethod_calls);
 678         log_text(logtext);
 679         sprintf(logtext,"Overall number of jni invokations:               %ld", count_jni_calls);
 680         log_text(logtext);
 681 }
 682
 683
 684 /* mem_usagelog ****************************************************************
 685
 686    prints some memory related infos
 687
 688 *******************************************************************************/
 689
 690 void mem_usagelog(bool givewarnings)
 691 {
 692         if ((memoryusage != 0) && givewarnings) {
 693                 dolog("Allocated memory not returned: %d", (s4) memoryusage);
 694         }
 695
 696         if ((globalallocateddumpsize != 0) && givewarnings) {
 697                 dolog("Dump memory not returned: %d", (s4) globalallocateddumpsize);
 698         }
 699
 700         dolog("Random/Dump - max. memory usage: %dkB/%dkB",
 701                   (s4) ((maxmemusage + 1023) / 1024),
 702                   (s4) ((maxdumpsize + 1023) / 1024));
 703 }
 704
 705
 706 /*
 707  * These are local overrides for various environment variables in Emacs.
 708  * Please do not remove this and leave it at the end of the file, where
 709  * Emacs will automagically detect them.
 710  * ---------------------------------------------------------------------
 711  * Local variables:
 712  * mode: c
 713  * indent-tabs-mode: t
 714  * c-basic-offset: 4
 715  * tab-width: 4
 716  * End:
 717  */