4 * Builtin report command: Analyze the perf.data input file,
5 * look up and read DSOs and symbol information and display
6 * a histogram of results, along various sorting keys.
10 #include "util/util.h"
12 #include "util/color.h"
13 #include <linux/list.h>
14 #include "util/cache.h"
15 #include <linux/rbtree.h>
16 #include "util/symbol.h"
17 #include "util/string.h"
18 #include "util/callchain.h"
19 #include "util/strlist.h"
20 #include "util/values.h"
23 #include "util/debug.h"
24 #include "util/header.h"
25 #include "util/session.h"
27 #include "util/parse-options.h"
28 #include "util/parse-events.h"
30 #include "util/thread.h"
31 #include "util/sort.h"
32 #include "util/hist.h"
34 static char const *input_name = "perf.data";
36 static char *dso_list_str, *comm_list_str, *sym_list_str,
38 static struct strlist *dso_list, *comm_list, *sym_list;
42 static int full_paths;
43 static int show_nr_samples;
45 static int show_threads;
46 static struct perf_read_values show_threads_values;
48 static char default_pretty_printing_style[] = "normal";
49 static char *pretty_printing_style = default_pretty_printing_style;
51 static int exclude_other = 1;
53 static char callchain_default_opt[] = "fractal,0.5";
55 static u64 sample_type;
57 struct symbol_conf symbol_conf;
61 callchain__fprintf_left_margin(FILE *fp, int left_margin)
66 ret = fprintf(fp, " ");
68 for (i = 0; i < left_margin; i++)
69 ret += fprintf(fp, " ");
74 static size_t ipchain__fprintf_graph_line(FILE *fp, int depth, int depth_mask,
80 ret += callchain__fprintf_left_margin(fp, left_margin);
82 for (i = 0; i < depth; i++)
83 if (depth_mask & (1 << i))
84 ret += fprintf(fp, "| ");
86 ret += fprintf(fp, " ");
88 ret += fprintf(fp, "\n");
93 ipchain__fprintf_graph(FILE *fp, struct callchain_list *chain, int depth,
94 int depth_mask, int count, u64 total_samples,
95 int hits, int left_margin)
100 ret += callchain__fprintf_left_margin(fp, left_margin);
101 for (i = 0; i < depth; i++) {
102 if (depth_mask & (1 << i))
103 ret += fprintf(fp, "|");
105 ret += fprintf(fp, " ");
106 if (!count && i == depth - 1) {
109 percent = hits * 100.0 / total_samples;
110 ret += percent_color_fprintf(fp, "--%2.2f%%-- ", percent);
112 ret += fprintf(fp, "%s", " ");
115 ret += fprintf(fp, "%s\n", chain->sym->name);
117 ret += fprintf(fp, "%p\n", (void *)(long)chain->ip);
122 static struct symbol *rem_sq_bracket;
123 static struct callchain_list rem_hits;
125 static void init_rem_hits(void)
127 rem_sq_bracket = malloc(sizeof(*rem_sq_bracket) + 6);
128 if (!rem_sq_bracket) {
129 fprintf(stderr, "Not enough memory to display remaining hits\n");
133 strcpy(rem_sq_bracket->name, "[...]");
134 rem_hits.sym = rem_sq_bracket;
138 __callchain__fprintf_graph(FILE *fp, struct callchain_node *self,
139 u64 total_samples, int depth, int depth_mask,
142 struct rb_node *node, *next;
143 struct callchain_node *child;
144 struct callchain_list *chain;
145 int new_depth_mask = depth_mask;
151 if (callchain_param.mode == CHAIN_GRAPH_REL)
152 new_total = self->children_hit;
154 new_total = total_samples;
156 remaining = new_total;
158 node = rb_first(&self->rb_root);
162 child = rb_entry(node, struct callchain_node, rb_node);
163 cumul = cumul_hits(child);
167 * The depth mask manages the output of pipes that show
168 * the depth. We don't want to keep the pipes of the current
169 * level for the last child of this depth.
170 * Except if we have remaining filtered hits. They will
171 * supersede the last child
173 next = rb_next(node);
174 if (!next && (callchain_param.mode != CHAIN_GRAPH_REL || !remaining))
175 new_depth_mask &= ~(1 << (depth - 1));
178 * But we keep the older depth mask for the line seperator
179 * to keep the level link until we reach the last child
181 ret += ipchain__fprintf_graph_line(fp, depth, depth_mask,
184 list_for_each_entry(chain, &child->val, list) {
185 if (chain->ip >= PERF_CONTEXT_MAX)
187 ret += ipchain__fprintf_graph(fp, chain, depth,
193 ret += __callchain__fprintf_graph(fp, child, new_total,
195 new_depth_mask | (1 << depth),
200 if (callchain_param.mode == CHAIN_GRAPH_REL &&
201 remaining && remaining != new_total) {
206 new_depth_mask &= ~(1 << (depth - 1));
208 ret += ipchain__fprintf_graph(fp, &rem_hits, depth,
209 new_depth_mask, 0, new_total,
210 remaining, left_margin);
218 callchain__fprintf_graph(FILE *fp, struct callchain_node *self,
219 u64 total_samples, int left_margin)
221 struct callchain_list *chain;
222 bool printed = false;
226 list_for_each_entry(chain, &self->val, list) {
227 if (chain->ip >= PERF_CONTEXT_MAX)
230 if (!i++ && sort__first_dimension == SORT_SYM)
234 ret += callchain__fprintf_left_margin(fp, left_margin);
235 ret += fprintf(fp, "|\n");
236 ret += callchain__fprintf_left_margin(fp, left_margin);
237 ret += fprintf(fp, "---");
242 ret += callchain__fprintf_left_margin(fp, left_margin);
245 ret += fprintf(fp, " %s\n", chain->sym->name);
247 ret += fprintf(fp, " %p\n", (void *)(long)chain->ip);
250 ret += __callchain__fprintf_graph(fp, self, total_samples, 1, 1, left_margin);
256 callchain__fprintf_flat(FILE *fp, struct callchain_node *self,
259 struct callchain_list *chain;
265 ret += callchain__fprintf_flat(fp, self->parent, total_samples);
268 list_for_each_entry(chain, &self->val, list) {
269 if (chain->ip >= PERF_CONTEXT_MAX)
272 ret += fprintf(fp, " %s\n", chain->sym->name);
274 ret += fprintf(fp, " %p\n",
275 (void *)(long)chain->ip);
282 hist_entry_callchain__fprintf(FILE *fp, struct hist_entry *self,
283 u64 total_samples, int left_margin)
285 struct rb_node *rb_node;
286 struct callchain_node *chain;
289 rb_node = rb_first(&self->sorted_chain);
293 chain = rb_entry(rb_node, struct callchain_node, rb_node);
294 percent = chain->hit * 100.0 / total_samples;
295 switch (callchain_param.mode) {
297 ret += percent_color_fprintf(fp, " %6.2f%%\n",
299 ret += callchain__fprintf_flat(fp, chain, total_samples);
301 case CHAIN_GRAPH_ABS: /* Falldown */
302 case CHAIN_GRAPH_REL:
303 ret += callchain__fprintf_graph(fp, chain, total_samples,
309 ret += fprintf(fp, "\n");
310 rb_node = rb_next(rb_node);
317 hist_entry__fprintf(FILE *fp, struct hist_entry *self, u64 total_samples)
319 struct sort_entry *se;
322 if (exclude_other && !self->parent)
326 ret = percent_color_fprintf(fp,
327 field_sep ? "%.2f" : " %6.2f%%",
328 (self->count * 100.0) / total_samples);
330 ret = fprintf(fp, field_sep ? "%lld" : "%12lld ", self->count);
332 if (show_nr_samples) {
334 fprintf(fp, "%c%lld", *field_sep, self->count);
336 fprintf(fp, "%11lld", self->count);
339 list_for_each_entry(se, &hist_entry__sort_list, list) {
343 fprintf(fp, "%s", field_sep ?: " ");
344 ret += se->print(fp, self, se->width ? *se->width : 0);
347 ret += fprintf(fp, "\n");
352 if (sort__first_dimension == SORT_COMM) {
353 se = list_first_entry(&hist_entry__sort_list, typeof(*se),
355 left_margin = se->width ? *se->width : 0;
356 left_margin -= thread__comm_len(self->thread);
359 hist_entry_callchain__fprintf(fp, self, total_samples,
370 static void dso__calc_col_width(struct dso *self)
372 if (!col_width_list_str && !field_sep &&
373 (!dso_list || strlist__has_entry(dso_list, self->name))) {
374 unsigned int slen = strlen(self->name);
375 if (slen > dsos__col_width)
376 dsos__col_width = slen;
379 self->slen_calculated = 1;
382 static void thread__comm_adjust(struct thread *self)
384 char *comm = self->comm;
386 if (!col_width_list_str && !field_sep &&
387 (!comm_list || strlist__has_entry(comm_list, comm))) {
388 unsigned int slen = strlen(comm);
390 if (slen > comms__col_width) {
391 comms__col_width = slen;
392 threads__col_width = slen + 6;
397 static int thread__set_comm_adjust(struct thread *self, const char *comm)
399 int ret = thread__set_comm(self, comm);
404 thread__comm_adjust(self);
409 static int call__match(struct symbol *sym)
411 if (sym->name && !regexec(&parent_regex, sym->name, 0, NULL, 0))
417 static struct symbol **resolve_callchain(struct thread *thread,
418 struct ip_callchain *chain,
419 struct symbol **parent)
421 u8 cpumode = PERF_RECORD_MISC_USER;
422 struct symbol **syms = NULL;
426 syms = calloc(chain->nr, sizeof(*syms));
428 fprintf(stderr, "Can't allocate memory for symbols\n");
433 for (i = 0; i < chain->nr; i++) {
434 u64 ip = chain->ips[i];
435 struct addr_location al;
437 if (ip >= PERF_CONTEXT_MAX) {
439 case PERF_CONTEXT_HV:
440 cpumode = PERF_RECORD_MISC_HYPERVISOR; break;
441 case PERF_CONTEXT_KERNEL:
442 cpumode = PERF_RECORD_MISC_KERNEL; break;
443 case PERF_CONTEXT_USER:
444 cpumode = PERF_RECORD_MISC_USER; break;
451 thread__find_addr_location(thread, cpumode, MAP__FUNCTION,
453 if (al.sym != NULL) {
454 if (sort__has_parent && !*parent &&
467 * collect histogram counts
470 static int hist_entry__add(struct addr_location *al,
471 struct ip_callchain *chain, u64 count)
473 struct symbol **syms = NULL, *parent = NULL;
475 struct hist_entry *he;
477 if ((sort__has_parent || callchain) && chain)
478 syms = resolve_callchain(al->thread, chain, &parent);
480 he = __hist_entry__add(al, parent, count, &hit);
489 callchain_init(&he->callchain);
490 append_chain(&he->callchain, chain, syms);
497 static size_t output__fprintf(FILE *fp, u64 total_samples)
499 struct hist_entry *pos;
500 struct sort_entry *se;
504 char *col_width = col_width_list_str;
505 int raw_printing_style;
507 raw_printing_style = !strcmp(pretty_printing_style, "raw");
511 fprintf(fp, "# Samples: %Ld\n", (u64)total_samples);
514 fprintf(fp, "# Overhead");
515 if (show_nr_samples) {
517 fprintf(fp, "%cSamples", *field_sep);
519 fputs(" Samples ", fp);
521 list_for_each_entry(se, &hist_entry__sort_list, list) {
525 fprintf(fp, "%c%s", *field_sep, se->header);
528 width = strlen(se->header);
530 if (col_width_list_str) {
532 *se->width = atoi(col_width);
533 col_width = strchr(col_width, ',');
538 width = *se->width = max(*se->width, width);
540 fprintf(fp, " %*s", width, se->header);
547 fprintf(fp, "# ........");
549 fprintf(fp, " ..........");
550 list_for_each_entry(se, &hist_entry__sort_list, list) {
560 width = strlen(se->header);
561 for (i = 0; i < width; i++)
569 for (nd = rb_first(&output_hists); nd; nd = rb_next(nd)) {
570 pos = rb_entry(nd, struct hist_entry, rb_node);
571 ret += hist_entry__fprintf(fp, pos, total_samples);
574 if (sort_order == default_sort_order &&
575 parent_pattern == default_parent_pattern) {
577 fprintf(fp, "# (For a higher level overview, try: perf report --sort comm,dso)\n");
582 free(rem_sq_bracket);
585 perf_read_values_display(fp, &show_threads_values,
591 static int validate_chain(struct ip_callchain *chain, event_t *event)
593 unsigned int chain_size;
595 chain_size = event->header.size;
596 chain_size -= (unsigned long)&event->ip.__more_data - (unsigned long)event;
598 if (chain->nr*sizeof(u64) > chain_size)
604 static int process_sample_event(event_t *event, struct perf_session *session __used)
606 struct sample_data data;
608 struct addr_location al;
609 struct thread *thread;
611 memset(&data, 0, sizeof(data));
614 event__parse_sample(event, sample_type, &data);
616 dump_printf("(IP, %d): %d/%d: %p period: %Ld\n",
619 (void *)(long)data.ip,
620 (long long)data.period);
622 if (sample_type & PERF_SAMPLE_CALLCHAIN) {
625 dump_printf("... chain: nr:%Lu\n", data.callchain->nr);
627 if (validate_chain(data.callchain, event) < 0) {
628 pr_debug("call-chain problem with event, "
634 for (i = 0; i < data.callchain->nr; i++)
635 dump_printf("..... %2d: %016Lx\n",
636 i, data.callchain->ips[i]);
640 thread = threads__findnew(data.pid);
641 if (thread == NULL) {
642 pr_debug("problem processing %d event, skipping it.\n",
647 dump_printf(" ... thread: %s:%d\n", thread->comm, thread->pid);
649 if (comm_list && !strlist__has_entry(comm_list, thread->comm))
652 cpumode = event->header.misc & PERF_RECORD_MISC_CPUMODE_MASK;
654 thread__find_addr_location(thread, cpumode,
655 MAP__FUNCTION, data.ip, &al, NULL);
657 * We have to do this here as we may have a dso with no symbol hit that
658 * has a name longer than the ones with symbols sampled.
660 if (al.map && !sort_dso.elide && !al.map->dso->slen_calculated)
661 dso__calc_col_width(al.map->dso);
664 (!al.map || !al.map->dso ||
665 !(strlist__has_entry(dso_list, al.map->dso->short_name) ||
666 (al.map->dso->short_name != al.map->dso->long_name &&
667 strlist__has_entry(dso_list, al.map->dso->long_name)))))
670 if (sym_list && al.sym && !strlist__has_entry(sym_list, al.sym->name))
673 if (hist_entry__add(&al, data.callchain, data.period)) {
674 pr_debug("problem incrementing symbol count, skipping event\n");
678 event__stats.total += data.period;
683 static int process_comm_event(event_t *event, struct perf_session *session __used)
685 struct thread *thread = threads__findnew(event->comm.pid);
687 dump_printf(": %s:%d\n", event->comm.comm, event->comm.pid);
689 if (thread == NULL ||
690 thread__set_comm_adjust(thread, event->comm.comm)) {
691 dump_printf("problem processing PERF_RECORD_COMM, skipping event.\n");
698 static int process_read_event(event_t *event, struct perf_session *session __used)
700 struct perf_event_attr *attr;
702 attr = perf_header__find_attr(event->read.id, &session->header);
705 const char *name = attr ? __event_name(attr->type, attr->config)
707 perf_read_values_add_value(&show_threads_values,
708 event->read.pid, event->read.tid,
714 dump_printf(": %d %d %s %Lu\n", event->read.pid, event->read.tid,
715 attr ? __event_name(attr->type, attr->config) : "FAIL",
721 static int sample_type_check(u64 type)
725 if (!(sample_type & PERF_SAMPLE_CALLCHAIN)) {
726 if (sort__has_parent) {
727 fprintf(stderr, "selected --sort parent, but no"
728 " callchain data. Did you call"
729 " perf record without -g?\n");
733 fprintf(stderr, "selected -g but no callchain data."
734 " Did you call perf record without"
738 } else if (callchain_param.mode != CHAIN_NONE && !callchain) {
740 if (register_callchain_param(&callchain_param) < 0) {
741 fprintf(stderr, "Can't register callchain"
750 static struct perf_event_ops event_ops = {
751 .process_sample_event = process_sample_event,
752 .process_mmap_event = event__process_mmap,
753 .process_comm_event = process_comm_event,
754 .process_exit_event = event__process_task,
755 .process_fork_event = event__process_task,
756 .process_lost_event = event__process_lost,
757 .process_read_event = process_read_event,
758 .sample_type_check = sample_type_check,
762 static int __cmd_report(void)
766 struct perf_session *session;
768 session = perf_session__new(input_name, O_RDONLY, force);
772 idle = register_idle_thread();
773 thread__comm_adjust(idle);
776 perf_read_values_init(&show_threads_values);
778 ret = perf_session__process_events(session, &event_ops, full_paths,
779 &event__cwdlen, &event__cwd);
784 event__print_totals();
789 threads__fprintf(stdout);
792 dsos__fprintf(stdout);
795 output__resort(event__stats.total);
796 output__fprintf(stdout, event__stats.total);
799 perf_read_values_destroy(&show_threads_values);
801 perf_session__delete(session);
806 parse_callchain_opt(const struct option *opt __used, const char *arg,
817 tok = strtok((char *)arg, ",");
821 /* get the output mode */
822 if (!strncmp(tok, "graph", strlen(arg)))
823 callchain_param.mode = CHAIN_GRAPH_ABS;
825 else if (!strncmp(tok, "flat", strlen(arg)))
826 callchain_param.mode = CHAIN_FLAT;
828 else if (!strncmp(tok, "fractal", strlen(arg)))
829 callchain_param.mode = CHAIN_GRAPH_REL;
831 else if (!strncmp(tok, "none", strlen(arg))) {
832 callchain_param.mode = CHAIN_NONE;
841 /* get the min percentage */
842 tok = strtok(NULL, ",");
846 callchain_param.min_percent = strtod(tok, &endptr);
851 if (register_callchain_param(&callchain_param) < 0) {
852 fprintf(stderr, "Can't register callchain params\n");
858 //static const char * const report_usage[] = {
859 const char * const report_usage[] = {
860 "perf report [<options>] <command>",
864 static const struct option options[] = {
865 OPT_STRING('i', "input", &input_name, "file",
867 OPT_BOOLEAN('v', "verbose", &verbose,
868 "be more verbose (show symbol address, etc)"),
869 OPT_BOOLEAN('D', "dump-raw-trace", &dump_trace,
870 "dump raw trace in ASCII"),
871 OPT_STRING('k', "vmlinux", &symbol_conf.vmlinux_name,
872 "file", "vmlinux pathname"),
873 OPT_BOOLEAN('f', "force", &force, "don't complain, do it"),
874 OPT_BOOLEAN('m', "modules", &symbol_conf.use_modules,
875 "load module symbols - WARNING: use only with -k and LIVE kernel"),
876 OPT_BOOLEAN('n', "show-nr-samples", &show_nr_samples,
877 "Show a column with the number of samples"),
878 OPT_BOOLEAN('T', "threads", &show_threads,
879 "Show per-thread event counters"),
880 OPT_STRING(0, "pretty", &pretty_printing_style, "key",
881 "pretty printing style key: normal raw"),
882 OPT_STRING('s', "sort", &sort_order, "key[,key2...]",
883 "sort by key(s): pid, comm, dso, symbol, parent"),
884 OPT_BOOLEAN('P', "full-paths", &full_paths,
885 "Don't shorten the pathnames taking into account the cwd"),
886 OPT_STRING('p', "parent", &parent_pattern, "regex",
887 "regex filter to identify parent, see: '--sort parent'"),
888 OPT_BOOLEAN('x', "exclude-other", &exclude_other,
889 "Only display entries with parent-match"),
890 OPT_CALLBACK_DEFAULT('g', "call-graph", NULL, "output_type,min_percent",
891 "Display callchains using output_type and min percent threshold. "
892 "Default: fractal,0.5", &parse_callchain_opt, callchain_default_opt),
893 OPT_STRING('d', "dsos", &dso_list_str, "dso[,dso...]",
894 "only consider symbols in these dsos"),
895 OPT_STRING('C', "comms", &comm_list_str, "comm[,comm...]",
896 "only consider symbols in these comms"),
897 OPT_STRING('S', "symbols", &sym_list_str, "symbol[,symbol...]",
898 "only consider these symbols"),
899 OPT_STRING('w', "column-widths", &col_width_list_str,
901 "don't try to adjust column width, use these fixed values"),
902 OPT_STRING('t', "field-separator", &field_sep, "separator",
903 "separator for columns, no spaces will be added between "
904 "columns '.' is reserved."),
908 static void setup_sorting(void)
910 char *tmp, *tok, *str = strdup(sort_order);
912 for (tok = strtok_r(str, ", ", &tmp);
913 tok; tok = strtok_r(NULL, ", ", &tmp)) {
914 if (sort_dimension__add(tok) < 0) {
915 error("Unknown --sort key: `%s'", tok);
916 usage_with_options(report_usage, options);
923 static void setup_list(struct strlist **list, const char *list_str,
924 struct sort_entry *se, const char *list_name,
928 *list = strlist__new(true, list_str);
930 fprintf(stderr, "problems parsing %s list\n",
934 if (strlist__nr_entries(*list) == 1) {
935 fprintf(fp, "# %s: %s\n", list_name,
936 strlist__entry(*list, 0)->s);
942 int cmd_report(int argc, const char **argv, const char *prefix __used)
944 if (symbol__init(&symbol_conf) < 0)
947 argc = parse_options(argc, argv, options, report_usage, 0);
951 if (parent_pattern != default_parent_pattern) {
952 sort_dimension__add("parent");
953 sort_parent.elide = 1;
958 * Any (unrecognized) arguments left?
961 usage_with_options(report_usage, options);
965 setup_list(&dso_list, dso_list_str, &sort_dso, "dso", stdout);
966 setup_list(&comm_list, comm_list_str, &sort_comm, "comm", stdout);
967 setup_list(&sym_list, sym_list_str, &sort_sym, "symbol", stdout);
969 if (field_sep && *field_sep == '.') {
970 fputs("'.' is the only non valid --field-separator argument\n",
975 return __cmd_report();