132 lines
3.6 KiB
C++
132 lines
3.6 KiB
C++
#include <stdio.h>
|
|
#include <unistd.h>
|
|
#include <stdlib.h>
|
|
#include <string.h>
|
|
#include <inttypes.h>
|
|
#include "trace_reader.h"
|
|
#include "parse_options.h"
|
|
|
|
const int kMillion = 1000000;
|
|
const int kMHz = 200 * kMillion;
|
|
|
|
struct symbol {
|
|
int count; // number of times a function is executed
|
|
uint64_t elapsed; // elapsed time for this function
|
|
};
|
|
|
|
typedef TraceReader<symbol> TraceReaderType;
|
|
|
|
#include "parse_options-inl.h"
|
|
|
|
static const uint32_t kOffsetThreshold = 0x100000;
|
|
|
|
// This comparison function is called from qsort() to sort
|
|
// symbols into decreasing elapsed time.
|
|
int cmp_sym_elapsed(const void *a, const void *b) {
|
|
const symbol_type *syma, *symb;
|
|
uint64_t elapsed1, elapsed2;
|
|
|
|
syma = static_cast<symbol_type const *>(a);
|
|
symb = static_cast<symbol_type const *>(b);
|
|
elapsed1 = syma->elapsed;
|
|
elapsed2 = symb->elapsed;
|
|
if (elapsed1 < elapsed2)
|
|
return 1;
|
|
if (elapsed1 == elapsed2)
|
|
return strcmp(syma->name, symb->name);
|
|
return -1;
|
|
}
|
|
|
|
void Usage(const char *program)
|
|
{
|
|
fprintf(stderr, "Usage: %s [options] trace_file elf_file\n", program);
|
|
OptionsUsage();
|
|
}
|
|
|
|
int main(int argc, char **argv)
|
|
{
|
|
ParseOptions(argc, argv);
|
|
if (argc - optind != 2) {
|
|
Usage(argv[0]);
|
|
exit(1);
|
|
}
|
|
|
|
char *trace_filename = argv[optind++];
|
|
char *elf_file = argv[optind++];
|
|
TraceReader<symbol> *trace = new TraceReader<symbol>;
|
|
trace->Open(trace_filename);
|
|
trace->SetDemangle(demangle);
|
|
trace->ReadKernelSymbols(elf_file);
|
|
trace->SetRoot(root);
|
|
|
|
symbol_type dummy;
|
|
dummy.count = 0;
|
|
dummy.elapsed = 0;
|
|
symbol_type *prev_sym = &dummy;
|
|
uint64_t prev_bb_time = 0;
|
|
while (1) {
|
|
symbol_type *sym;
|
|
BBEvent event;
|
|
BBEvent first_ignored_event;
|
|
|
|
bool eof = GetNextValidEvent(trace, &event, &first_ignored_event, &sym);
|
|
|
|
// Assign the elapsed time to the previous function symbol
|
|
uint64_t elapsed = 0;
|
|
if (first_ignored_event.time != 0)
|
|
elapsed = first_ignored_event.time - prev_bb_time;
|
|
else if (!eof)
|
|
elapsed = event.time - prev_bb_time;
|
|
prev_sym->elapsed += elapsed;
|
|
|
|
if (eof)
|
|
break;
|
|
|
|
prev_bb_time = event.time;
|
|
sym->count += 1;
|
|
prev_sym = sym;
|
|
#if 0
|
|
printf("t%lld bb_num: %d, bb_addr: 0x%x func: %s, addr: 0x%x, count: %d\n",
|
|
bb_time, bb_num, bb_addr, sym->name, sym->addr, sym->count);
|
|
#endif
|
|
}
|
|
|
|
int nsyms;
|
|
symbol_type *syms = trace->GetSymbols(&nsyms);
|
|
|
|
// Sort the symbols into decreasing order of elapsed time
|
|
qsort(syms, nsyms, sizeof(symbol_type), cmp_sym_elapsed);
|
|
|
|
// Add up all the cycles
|
|
uint64_t total = 0;
|
|
symbol_type *sym = syms;
|
|
for (int ii = 0; ii < nsyms; ++ii, ++sym) {
|
|
total += sym->elapsed;
|
|
}
|
|
|
|
double secs = 1.0 * total / kMHz;
|
|
printf("Total seconds: %.2f, total cycles: %lld, MHz: %d\n\n",
|
|
secs, total, kMHz / kMillion);
|
|
|
|
uint64_t sum = 0;
|
|
printf("Elapsed secs Elapsed cyc %% %% Function\n");
|
|
sym = syms;
|
|
for (int ii = 0; ii < nsyms; ++ii, ++sym) {
|
|
if (sym->elapsed == 0)
|
|
break;
|
|
sum += sym->elapsed;
|
|
double per = 100.0 * sym->elapsed / total;
|
|
double sum_per = 100.0 * sum / total;
|
|
double secs = 1.0 * sym->elapsed / kMHz;
|
|
const char *ksym = " ";
|
|
if (sym->region->flags & region_type::kIsKernelRegion)
|
|
ksym = "k";
|
|
printf("%12.2f %11lld %6.2f %6.2f %s %s\n",
|
|
secs, sym->elapsed, per, sum_per, ksym, sym->name);
|
|
}
|
|
delete[] syms;
|
|
delete trace;
|
|
|
|
return 0;
|
|
}
|