builtin-report.c 15.8 KB
Newer Older
1 2 3 4 5 6 7
/*
 * builtin-report.c
 *
 * Builtin report command: Analyze the perf.data input file,
 * look up and read DSOs and symbol information and display
 * a histogram of results, along various sorting keys.
 */
8
#include "builtin.h"
9

10 11
#include "util/util.h"

12
#include "util/annotate.h"
13
#include "util/color.h"
14
#include <linux/list.h>
15
#include "util/cache.h"
16
#include <linux/rbtree.h>
17
#include "util/symbol.h"
18
#include "util/callchain.h"
19
#include "util/strlist.h"
20
#include "util/values.h"
21

22
#include "perf.h"
23
#include "util/debug.h"
24 25
#include "util/evlist.h"
#include "util/evsel.h"
26
#include "util/header.h"
27
#include "util/session.h"
28 29 30 31

#include "util/parse-options.h"
#include "util/parse-events.h"

32
#include "util/thread.h"
33
#include "util/sort.h"
34
#include "util/hist.h"
35

36 37
#include <linux/bitmap.h>

38
static char		const *input_name = "perf.data";
39

40
static bool		force, use_tui, use_stdio;
41
static bool		hide_unresolved;
42
static bool		dont_use_callchains;
43
static bool		show_full_info;
44

45
static bool		show_threads;
46 47
static struct perf_read_values	show_threads_values;

48 49
static const char	default_pretty_printing_style[] = "normal";
static const char	*pretty_printing_style = default_pretty_printing_style;
50

51 52
static char		callchain_default_opt[] = "fractal,0.5,callee";
static bool		inverted_callchain;
53
static symbol_filter_t	annotate_init;
54

55 56 57
static const char	*cpu_list;
static DECLARE_BITMAP(cpu_bitmap, MAX_NR_CPUS);

58
static int perf_session__add_hist_entry(struct perf_session *session,
59
					struct addr_location *al,
60 61
					struct perf_sample *sample,
					struct perf_evsel *evsel)
62
{
63
	struct symbol *parent = NULL;
64
	int err = 0;
65 66
	struct hist_entry *he;

67 68 69
	if ((sort__has_parent || symbol_conf.use_callchain) && sample->callchain) {
		err = perf_session__resolve_callchain(session, al->thread,
						      sample->callchain, &parent);
70 71
		if (err)
			return err;
72
	}
73

74
	he = __hists__add_entry(&evsel->hists, al, parent, sample->period);
75
	if (he == NULL)
76 77
		return -ENOMEM;

78
	if (symbol_conf.use_callchain) {
79 80
		err = callchain_append(he->callchain, &session->callchain_cursor,
				       sample->period);
81
		if (err)
82
			return err;
83 84 85 86 87 88
	}
	/*
	 * Only in the newt browser we are doing integrated annotation,
	 * so we don't allocated the extra space needed because the stdio
	 * code will not use it.
	 */
89 90
	if (al->sym != NULL && use_browser > 0) {
		struct annotation *notes = symbol__annotation(he->ms.sym);
91 92 93 94

		assert(evsel != NULL);

		err = -ENOMEM;
95
		if (notes->src == NULL &&
96 97 98 99
		    symbol__alloc_hist(he->ms.sym, session->evlist->nr_entries) < 0)
			goto out;

		err = hist_entry__inc_addr_samples(he, evsel->idx, al->addr);
100
	}
101

102 103 104
	evsel->hists.stats.total_period += sample->period;
	hists__inc_nr_events(&evsel->hists, PERF_RECORD_SAMPLE);
out:
105
	return err;
106 107
}

108

109 110
static int process_sample_event(union perf_event *event,
				struct perf_sample *sample,
111
				struct perf_evsel *evsel,
112
				struct perf_session *session)
113
{
114
	struct addr_location al;
115

116
	if (perf_event__preprocess_sample(event, session, &al, sample,
117
					  annotate_init) < 0) {
118
		fprintf(stderr, "problem processing %d event, skipping it.\n",
119 120 121
			event->header.type);
		return -1;
	}
122

123
	if (al.filtered || (hide_unresolved && al.sym == NULL))
124
		return 0;
125

126 127 128
	if (cpu_list && !test_bit(sample->cpu, cpu_bitmap))
		return 0;

129 130 131
	if (al.map != NULL)
		al.map->dso->hit = 1;

132
	if (perf_session__add_hist_entry(session, &al, sample, evsel)) {
133
		pr_debug("problem incrementing symbol period, skipping event\n");
134
		return -1;
135
	}
136

137 138
	return 0;
}
I
Ingo Molnar 已提交
139

140 141
static int process_read_event(union perf_event *event,
			      struct perf_sample *sample __used,
142
			      struct perf_session *session)
143
{
144 145
	struct perf_evsel *evsel = perf_evlist__id2evsel(session->evlist,
							 event->read.id);
146
	if (show_threads) {
147
		const char *name = evsel ? event_name(evsel) : "unknown";
148 149 150 151 152 153 154
		perf_read_values_add_value(&show_threads_values,
					   event->read.pid, event->read.tid,
					   event->read.id,
					   name,
					   event->read.value);
	}

155
	dump_printf(": %d %d %s %" PRIu64 "\n", event->read.pid, event->read.tid,
156
		    evsel ? event_name(evsel) : "FAIL",
157
		    event->read.value);
158 159 160 161

	return 0;
}

162
static int perf_session__setup_sample_type(struct perf_session *self)
163
{
164
	if (!(self->sample_type & PERF_SAMPLE_CALLCHAIN)) {
165
		if (sort__has_parent) {
166 167 168
			ui__warning("Selected --sort parent, but no "
				    "callchain data. Did you call "
				    "'perf record' without -g?\n");
169
			return -EINVAL;
170
		}
171
		if (symbol_conf.use_callchain) {
172 173
			ui__warning("Selected -g but no callchain data. Did "
				    "you call 'perf record' without -g?\n");
174
			return -1;
175
		}
176 177
	} else if (!dont_use_callchains && callchain_param.mode != CHAIN_NONE &&
		   !symbol_conf.use_callchain) {
178
			symbol_conf.use_callchain = true;
179
			if (callchain_register_param(&callchain_param) < 0) {
180 181
				ui__warning("Can't register callchain "
					    "params.\n");
182
				return -EINVAL;
183
			}
184 185
	}

186 187
	return 0;
}
188

189
static struct perf_event_ops event_ops = {
190 191 192 193 194 195 196 197 198 199 200
	.sample		 = process_sample_event,
	.mmap		 = perf_event__process_mmap,
	.comm		 = perf_event__process_comm,
	.exit		 = perf_event__process_task,
	.fork		 = perf_event__process_task,
	.lost		 = perf_event__process_lost,
	.read		 = process_read_event,
	.attr		 = perf_event__process_attr,
	.event_type	 = perf_event__process_event_type,
	.tracing_data	 = perf_event__process_tracing_data,
	.build_id	 = perf_event__process_build_id,
201 202
	.ordered_samples = true,
	.ordering_requires_timestamps = true,
203
};
204

205 206
extern volatile int session_done;

207
static void sig_handler(int sig __used)
208 209 210 211
{
	session_done = 1;
}

212 213 214 215 216 217 218 219 220 221 222 223 224 225
static size_t hists__fprintf_nr_sample_events(struct hists *self,
					      const char *evname, FILE *fp)
{
	size_t ret;
	char unit;
	unsigned long nr_events = self->stats.nr_events[PERF_RECORD_SAMPLE];

	nr_events = convert_unit(nr_events, &unit);
	ret = fprintf(fp, "# Events: %lu%c", nr_events, unit);
	if (evname != NULL)
		ret += fprintf(fp, " %s", evname);
	return ret + fprintf(fp, "\n#\n");
}

226 227
static int perf_evlist__tty_browse_hists(struct perf_evlist *evlist,
					 const char *help)
228
{
229
	struct perf_evsel *pos;
230

231 232
	list_for_each_entry(pos, &evlist->entries, node) {
		struct hists *hists = &pos->hists;
233
		const char *evname = event_name(pos);
234 235

		hists__fprintf_nr_sample_events(hists, evname, stdout);
236
		hists__fprintf(hists, NULL, false, true, 0, 0, stdout);
237 238 239 240 241 242 243 244 245 246 247 248 249 250 251 252 253 254
		fprintf(stdout, "\n\n");
	}

	if (sort_order == default_sort_order &&
	    parent_pattern == default_parent_pattern) {
		fprintf(stdout, "#\n# (%s)\n#\n", help);

		if (show_threads) {
			bool style = !strcmp(pretty_printing_style, "raw");
			perf_read_values_display(stdout, &show_threads_values,
						 style);
			perf_read_values_destroy(&show_threads_values);
		}
	}

	return 0;
}

255 256
static int __cmd_report(void)
{
257
	int ret = -EINVAL;
258
	u64 nr_samples;
259
	struct perf_session *session;
260
	struct perf_evsel *pos;
261 262
	struct map *kernel_map;
	struct kmap *kernel_kmap;
263
	const char *help = "For a higher level overview, try: perf report --sort comm,dso";
264

265 266
	signal(SIGINT, sig_handler);

267
	session = perf_session__new(input_name, O_RDONLY, force, false, &event_ops);
268 269 270
	if (session == NULL)
		return -ENOMEM;

271 272 273 274 275 276
	if (cpu_list) {
		ret = perf_session__cpu_bitmap(session, cpu_list, cpu_bitmap);
		if (ret)
			goto out_delete;
	}

277 278 279
	if (use_browser <= 0)
		perf_session__fprintf_info(session, stdout, show_full_info);

280 281
	if (show_threads)
		perf_read_values_init(&show_threads_values);
282

283 284 285 286
	ret = perf_session__setup_sample_type(session);
	if (ret)
		goto out_delete;

287
	ret = perf_session__process_events(session, &event_ops);
288
	if (ret)
289
		goto out_delete;
290

291 292 293 294 295 296 297 298
	kernel_map = session->host_machine.vmlinux_maps[MAP__FUNCTION];
	kernel_kmap = map__kmap(kernel_map);
	if (kernel_map == NULL ||
	    (kernel_map->dso->hit &&
	     (kernel_kmap->ref_reloc_sym == NULL ||
	      kernel_kmap->ref_reloc_sym->addr == 0))) {
		const struct dso *kdso = kernel_map->dso;

299 300 301 302
		ui__warning(
"Kernel address maps (/proc/{kallsyms,modules}) were restricted.\n\n"
"Check /proc/sys/kernel/kptr_restrict before running 'perf record'.\n\n%s\n\n"
"Samples in kernel modules can't be resolved as well.\n\n",
303
			    RB_EMPTY_ROOT(&kdso->symbols[MAP__FUNCTION]) ?
304 305 306
"As no suitable kallsyms nor vmlinux was found, kernel samples\n"
"can't be resolved." :
"If some relocation was applied (e.g. kexec) symbols may be misresolved.");
307 308
	}

309
	if (dump_trace) {
310
		perf_session__fprintf_nr_events(session, stdout);
311
		goto out_delete;
312
	}
313

314
	if (verbose > 3)
315
		perf_session__fprintf(session, stdout);
316

317
	if (verbose > 2)
318
		perf_session__fprintf_dsos(session, stdout);
319

320 321 322
	nr_samples = 0;
	list_for_each_entry(pos, &session->evlist->entries, node) {
		struct hists *hists = &pos->hists;
323

324
		hists__collapse_resort(hists);
325
		hists__output_resort(hists);
326 327 328 329 330 331
		nr_samples += hists->stats.nr_events[PERF_RECORD_SAMPLE];
	}

	if (nr_samples == 0) {
		ui__warning("The %s file has no samples!\n", input_name);
		goto out_delete;
332 333
	}

334 335 336 337
	if (use_browser > 0) {
		perf_evlist__tui_browse_hists(session->evlist, help,
					      NULL, NULL, 0);
	} else
338
		perf_evlist__tty_browse_hists(session->evlist, help);
339

340
out_delete:
341 342 343 344 345 346 347 348 349 350 351 352
	/*
	 * Speed up the exit process, for large files this can
	 * take quite a while.
	 *
	 * XXX Enable this when using valgrind or if we ever
	 * librarize this command.
	 *
	 * Also experiment with obstacks to see how much speed
	 * up we'll get here.
	 *
 	 * perf_session__delete(session);
 	 */
353
	return ret;
354 355
}

356 357
static int
parse_callchain_opt(const struct option *opt __used, const char *arg,
358
		    int unset)
359
{
360
	char *tok, *tok2;
361 362
	char *endptr;

363 364 365 366 367 368 369 370
	/*
	 * --no-call-graph
	 */
	if (unset) {
		dont_use_callchains = true;
		return 0;
	}

371
	symbol_conf.use_callchain = true;
372 373 374 375

	if (!arg)
		return 0;

376 377 378 379 380 381
	tok = strtok((char *)arg, ",");
	if (!tok)
		return -1;

	/* get the output mode */
	if (!strncmp(tok, "graph", strlen(arg)))
382
		callchain_param.mode = CHAIN_GRAPH_ABS;
383

384
	else if (!strncmp(tok, "flat", strlen(arg)))
385 386 387 388 389
		callchain_param.mode = CHAIN_FLAT;

	else if (!strncmp(tok, "fractal", strlen(arg)))
		callchain_param.mode = CHAIN_GRAPH_REL;

390 391
	else if (!strncmp(tok, "none", strlen(arg))) {
		callchain_param.mode = CHAIN_NONE;
392
		symbol_conf.use_callchain = false;
393 394 395 396

		return 0;
	}

397 398 399
	else
		return -1;

400 401 402
	/* get the min percentage */
	tok = strtok(NULL, ",");
	if (!tok)
403
		goto setup;
404

405
	callchain_param.min_percent = strtod(tok, &endptr);
406 407 408
	if (tok == endptr)
		return -1;

409 410 411 412 413 414
	/* get the print limit */
	tok2 = strtok(NULL, ",");
	if (!tok2)
		goto setup;

	if (tok2[0] != 'c') {
415
		callchain_param.print_limit = strtod(tok2, &endptr);
416 417 418 419 420 421 422 423 424 425 426 427
		tok2 = strtok(NULL, ",");
		if (!tok2)
			goto setup;
	}

	/* get the call chain order */
	if (!strcmp(tok2, "caller"))
		callchain_param.order = ORDER_CALLER;
	else if (!strcmp(tok2, "callee"))
		callchain_param.order = ORDER_CALLEE;
	else
		return -1;
428
setup:
429
	if (callchain_register_param(&callchain_param) < 0) {
430 431 432
		fprintf(stderr, "Can't register callchain params\n");
		return -1;
	}
433 434 435
	return 0;
}

436
static const char * const report_usage[] = {
437 438 439 440 441 442 443
	"perf report [<options>] <command>",
	NULL
};

static const struct option options[] = {
	OPT_STRING('i', "input", &input_name, "file",
		    "input file name"),
444
	OPT_INCR('v', "verbose", &verbose,
445
		    "be more verbose (show symbol address, etc)"),
446 447
	OPT_BOOLEAN('D', "dump-raw-trace", &dump_trace,
		    "dump raw trace in ASCII"),
448 449
	OPT_STRING('k', "vmlinux", &symbol_conf.vmlinux_name,
		   "file", "vmlinux pathname"),
450 451
	OPT_STRING(0, "kallsyms", &symbol_conf.kallsyms_name,
		   "file", "kallsyms pathname"),
452
	OPT_BOOLEAN('f', "force", &force, "don't complain, do it"),
453
	OPT_BOOLEAN('m', "modules", &symbol_conf.use_modules,
454
		    "load module symbols - WARNING: use only with -k and LIVE kernel"),
455
	OPT_BOOLEAN('n', "show-nr-samples", &symbol_conf.show_nr_samples,
456
		    "Show a column with the number of samples"),
457 458
	OPT_BOOLEAN('T', "threads", &show_threads,
		    "Show per-thread event counters"),
459 460
	OPT_STRING(0, "pretty", &pretty_printing_style, "key",
		   "pretty printing style key: normal raw"),
461 462
	OPT_BOOLEAN(0, "tui", &use_tui, "Use the TUI interface"),
	OPT_BOOLEAN(0, "stdio", &use_stdio, "Use the stdio interface"),
463
	OPT_STRING('s', "sort", &sort_order, "key[,key2...]",
464
		   "sort by key(s): pid, comm, dso, symbol, parent"),
465 466
	OPT_BOOLEAN(0, "showcpuutilization", &symbol_conf.show_cpu_utilization,
		    "Show sample percentage for different cpu modes"),
467 468
	OPT_STRING('p', "parent", &parent_pattern, "regex",
		   "regex filter to identify parent, see: '--sort parent'"),
469
	OPT_BOOLEAN('x', "exclude-other", &symbol_conf.exclude_other,
470
		    "Only display entries with parent-match"),
471 472 473 474
	OPT_CALLBACK_DEFAULT('g', "call-graph", NULL, "output_type,min_percent, call_order",
		     "Display callchains using output_type (graph, flat, fractal, or none) , min percent threshold and callchain order. "
		     "Default: fractal,0.5,callee", &parse_callchain_opt, callchain_default_opt),
	OPT_BOOLEAN('G', "inverted", &inverted_callchain, "alias for inverted call graph"),
475
	OPT_STRING('d', "dsos", &symbol_conf.dso_list_str, "dso[,dso...]",
476
		   "only consider symbols in these dsos"),
477
	OPT_STRING('C', "comms", &symbol_conf.comm_list_str, "comm[,comm...]",
478
		   "only consider symbols in these comms"),
479
	OPT_STRING('S', "symbols", &symbol_conf.sym_list_str, "symbol[,symbol...]",
480
		   "only consider these symbols"),
481
	OPT_STRING('w', "column-widths", &symbol_conf.col_width_list_str,
482 483
		   "width[,width...]",
		   "don't try to adjust column width, use these fixed values"),
484
	OPT_STRING('t', "field-separator", &symbol_conf.field_sep, "separator",
485 486
		   "separator for columns, no spaces will be added between "
		   "columns '.' is reserved."),
487 488
	OPT_BOOLEAN('U', "hide-unresolved", &hide_unresolved,
		    "Only display entries resolved to a symbol"),
489 490
	OPT_STRING(0, "symfs", &symbol_conf.symfs, "directory",
		    "Look for files with symbols relative to this directory"),
491
	OPT_STRING('c', "cpu", &cpu_list, "cpu", "list of cpus to profile"),
492 493
	OPT_BOOLEAN('I', "show-info", &show_full_info,
		    "Display extended information about perf.data file"),
494 495
	OPT_STRING('M', "disassembler-style", &disassembler_style, "disassembler style",
		   "Specify disassembler style (e.g. -M intel for intel syntax)"),
496 497
	OPT_BOOLEAN(0, "show-total-period", &symbol_conf.show_total_period,
		    "Show a column with the sum of periods"),
498 499 500
	OPT_END()
};

501
int cmd_report(int argc, const char **argv, const char *prefix __used)
502
{
503 504
	argc = parse_options(argc, argv, options, report_usage, 0);

505 506 507 508 509
	if (use_stdio)
		use_browser = 0;
	else if (use_tui)
		use_browser = 1;

510 511 512
	if (inverted_callchain)
		callchain_param.order = ORDER_CALLER;

513
	if (strcmp(input_name, "-") != 0)
514
		setup_browser(true);
515 516
	else
		use_browser = 0;
517 518 519 520 521
	/*
	 * Only in the newt browser we are doing integrated annotation,
	 * so don't allocate extra space that won't be used in the stdio
	 * implementation.
	 */
522
	if (use_browser > 0) {
523
		symbol_conf.priv_size = sizeof(struct annotation);
524
		annotate_init	      = symbol__annotate_init;
525 526 527 528 529 530 531 532 533 534 535 536 537 538 539 540
		/*
 		 * For searching by name on the "Browse map details".
 		 * providing it only in verbose mode not to bloat too
 		 * much struct symbol.
 		 */
		if (verbose) {
			/*
			 * XXX: Need to provide a less kludgy way to ask for
			 * more space per symbol, the u32 is for the index on
			 * the ui browser.
			 * See symbol__browser_index.
			 */
			symbol_conf.priv_size += sizeof(u32);
			symbol_conf.sort_by_name = true;
		}
	}
541

542
	if (symbol__init() < 0)
543
		return -1;
544

545
	setup_sorting(report_usage, options);
546

547
	if (parent_pattern != default_parent_pattern) {
548 549
		if (sort_dimension__add("parent") < 0)
			return -1;
550 551 552 553 554 555 556 557

		/*
		 * Only show the parent fields if we explicitly
		 * sort that way. If we only use parent machinery
		 * for filtering, we don't want it.
		 */
		if (!strstr(sort_order, "parent"))
			sort_parent.elide = 1;
558
	} else
559
		symbol_conf.exclude_other = false;
560

561 562 563 564 565 566
	/*
	 * Any (unrecognized) arguments left?
	 */
	if (argc)
		usage_with_options(report_usage, options);

567 568 569
	sort_entry__setup_elide(&sort_dso, symbol_conf.dso_list, "dso", stdout);
	sort_entry__setup_elide(&sort_comm, symbol_conf.comm_list, "comm", stdout);
	sort_entry__setup_elide(&sort_sym, symbol_conf.sym_list, "symbol", stdout);
570

571 572
	return __cmd_report();
}