xref: /linux/tools/perf/builtin-record.c (revision dde5e3ffb770ef2854bbc32c51a365e932919e19)
1 /*
2  * builtin-record.c
3  *
4  * Builtin record command: Record the profile of a workload
5  * (or a CPU, or a PID) into the perf.data output file - for
6  * later analysis via perf report.
7  */
8 #include "builtin.h"
9 
10 #include "perf.h"
11 
12 #include "util/util.h"
13 #include "util/parse-options.h"
14 #include "util/parse-events.h"
15 #include "util/string.h"
16 
17 #include "util/header.h"
18 
19 #include <unistd.h>
20 #include <sched.h>
21 
22 #define ALIGN(x, a)		__ALIGN_MASK(x, (typeof(x))(a)-1)
23 #define __ALIGN_MASK(x, mask)	(((x)+(mask))&~(mask))
24 
25 static int			fd[MAX_NR_CPUS][MAX_COUNTERS];
26 
27 static long			default_interval		= 100000;
28 
29 static int			nr_cpus				= 0;
30 static unsigned int		page_size;
31 static unsigned int		mmap_pages			= 128;
32 static int			freq				= 0;
33 static int			output;
34 static const char		*output_name			= "perf.data";
35 static int			group				= 0;
36 static unsigned int		realtime_prio			= 0;
37 static int			system_wide			= 0;
38 static pid_t			target_pid			= -1;
39 static int			inherit				= 1;
40 static int			force				= 0;
41 static int			append_file			= 0;
42 static int			call_graph			= 0;
43 static int			verbose				= 0;
44 static int			inherit_stat			= 0;
45 static int			no_samples			= 0;
46 static int			sample_address			= 0;
47 
48 static long			samples;
49 static struct timeval		last_read;
50 static struct timeval		this_read;
51 
52 static u64			bytes_written;
53 
54 static struct pollfd		event_array[MAX_NR_CPUS * MAX_COUNTERS];
55 
56 static int			nr_poll;
57 static int			nr_cpu;
58 
59 static int			file_new = 1;
60 
61 struct perf_header		*header;
62 
63 struct mmap_event {
64 	struct perf_event_header	header;
65 	u32				pid;
66 	u32				tid;
67 	u64				start;
68 	u64				len;
69 	u64				pgoff;
70 	char				filename[PATH_MAX];
71 };
72 
73 struct comm_event {
74 	struct perf_event_header	header;
75 	u32				pid;
76 	u32				tid;
77 	char				comm[16];
78 };
79 
80 
81 struct mmap_data {
82 	int			counter;
83 	void			*base;
84 	unsigned int		mask;
85 	unsigned int		prev;
86 };
87 
88 static struct mmap_data		mmap_array[MAX_NR_CPUS][MAX_COUNTERS];
89 
90 static unsigned long mmap_read_head(struct mmap_data *md)
91 {
92 	struct perf_counter_mmap_page *pc = md->base;
93 	long head;
94 
95 	head = pc->data_head;
96 	rmb();
97 
98 	return head;
99 }
100 
101 static void mmap_write_tail(struct mmap_data *md, unsigned long tail)
102 {
103 	struct perf_counter_mmap_page *pc = md->base;
104 
105 	/*
106 	 * ensure all reads are done before we write the tail out.
107 	 */
108 	/* mb(); */
109 	pc->data_tail = tail;
110 }
111 
112 static void write_output(void *buf, size_t size)
113 {
114 	while (size) {
115 		int ret = write(output, buf, size);
116 
117 		if (ret < 0)
118 			die("failed to write");
119 
120 		size -= ret;
121 		buf += ret;
122 
123 		bytes_written += ret;
124 	}
125 }
126 
127 static void mmap_read(struct mmap_data *md)
128 {
129 	unsigned int head = mmap_read_head(md);
130 	unsigned int old = md->prev;
131 	unsigned char *data = md->base + page_size;
132 	unsigned long size;
133 	void *buf;
134 	int diff;
135 
136 	gettimeofday(&this_read, NULL);
137 
138 	/*
139 	 * If we're further behind than half the buffer, there's a chance
140 	 * the writer will bite our tail and mess up the samples under us.
141 	 *
142 	 * If we somehow ended up ahead of the head, we got messed up.
143 	 *
144 	 * In either case, truncate and restart at head.
145 	 */
146 	diff = head - old;
147 	if (diff < 0) {
148 		struct timeval iv;
149 		unsigned long msecs;
150 
151 		timersub(&this_read, &last_read, &iv);
152 		msecs = iv.tv_sec*1000 + iv.tv_usec/1000;
153 
154 		fprintf(stderr, "WARNING: failed to keep up with mmap data."
155 				"  Last read %lu msecs ago.\n", msecs);
156 
157 		/*
158 		 * head points to a known good entry, start there.
159 		 */
160 		old = head;
161 	}
162 
163 	last_read = this_read;
164 
165 	if (old != head)
166 		samples++;
167 
168 	size = head - old;
169 
170 	if ((old & md->mask) + size != (head & md->mask)) {
171 		buf = &data[old & md->mask];
172 		size = md->mask + 1 - (old & md->mask);
173 		old += size;
174 
175 		write_output(buf, size);
176 	}
177 
178 	buf = &data[old & md->mask];
179 	size = head - old;
180 	old += size;
181 
182 	write_output(buf, size);
183 
184 	md->prev = old;
185 	mmap_write_tail(md, old);
186 }
187 
188 static volatile int done = 0;
189 static volatile int signr = -1;
190 
191 static void sig_handler(int sig)
192 {
193 	done = 1;
194 	signr = sig;
195 }
196 
197 static void sig_atexit(void)
198 {
199 	if (signr == -1)
200 		return;
201 
202 	signal(signr, SIG_DFL);
203 	kill(getpid(), signr);
204 }
205 
206 static void pid_synthesize_comm_event(pid_t pid, int full)
207 {
208 	struct comm_event comm_ev;
209 	char filename[PATH_MAX];
210 	char bf[BUFSIZ];
211 	int fd;
212 	size_t size;
213 	char *field, *sep;
214 	DIR *tasks;
215 	struct dirent dirent, *next;
216 
217 	snprintf(filename, sizeof(filename), "/proc/%d/stat", pid);
218 
219 	fd = open(filename, O_RDONLY);
220 	if (fd < 0) {
221 		/*
222 		 * We raced with a task exiting - just return:
223 		 */
224 		if (verbose)
225 			fprintf(stderr, "couldn't open %s\n", filename);
226 		return;
227 	}
228 	if (read(fd, bf, sizeof(bf)) < 0) {
229 		fprintf(stderr, "couldn't read %s\n", filename);
230 		exit(EXIT_FAILURE);
231 	}
232 	close(fd);
233 
234 	/* 9027 (cat) R 6747 9027 6747 34816 9027 ... */
235 	memset(&comm_ev, 0, sizeof(comm_ev));
236 	field = strchr(bf, '(');
237 	if (field == NULL)
238 		goto out_failure;
239 	sep = strchr(++field, ')');
240 	if (sep == NULL)
241 		goto out_failure;
242 	size = sep - field;
243 	memcpy(comm_ev.comm, field, size++);
244 
245 	comm_ev.pid = pid;
246 	comm_ev.header.type = PERF_EVENT_COMM;
247 	size = ALIGN(size, sizeof(u64));
248 	comm_ev.header.size = sizeof(comm_ev) - (sizeof(comm_ev.comm) - size);
249 
250 	if (!full) {
251 		comm_ev.tid = pid;
252 
253 		write_output(&comm_ev, comm_ev.header.size);
254 		return;
255 	}
256 
257 	snprintf(filename, sizeof(filename), "/proc/%d/task", pid);
258 
259 	tasks = opendir(filename);
260 	while (!readdir_r(tasks, &dirent, &next) && next) {
261 		char *end;
262 		pid = strtol(dirent.d_name, &end, 10);
263 		if (*end)
264 			continue;
265 
266 		comm_ev.tid = pid;
267 
268 		write_output(&comm_ev, comm_ev.header.size);
269 	}
270 	closedir(tasks);
271 	return;
272 
273 out_failure:
274 	fprintf(stderr, "couldn't get COMM and pgid, malformed %s\n",
275 		filename);
276 	exit(EXIT_FAILURE);
277 }
278 
279 static void pid_synthesize_mmap_samples(pid_t pid)
280 {
281 	char filename[PATH_MAX];
282 	FILE *fp;
283 
284 	snprintf(filename, sizeof(filename), "/proc/%d/maps", pid);
285 
286 	fp = fopen(filename, "r");
287 	if (fp == NULL) {
288 		/*
289 		 * We raced with a task exiting - just return:
290 		 */
291 		if (verbose)
292 			fprintf(stderr, "couldn't open %s\n", filename);
293 		return;
294 	}
295 	while (1) {
296 		char bf[BUFSIZ], *pbf = bf;
297 		struct mmap_event mmap_ev = {
298 			.header = { .type = PERF_EVENT_MMAP },
299 		};
300 		int n;
301 		size_t size;
302 		if (fgets(bf, sizeof(bf), fp) == NULL)
303 			break;
304 
305 		/* 00400000-0040c000 r-xp 00000000 fd:01 41038  /bin/cat */
306 		n = hex2u64(pbf, &mmap_ev.start);
307 		if (n < 0)
308 			continue;
309 		pbf += n + 1;
310 		n = hex2u64(pbf, &mmap_ev.len);
311 		if (n < 0)
312 			continue;
313 		pbf += n + 3;
314 		if (*pbf == 'x') { /* vm_exec */
315 			char *execname = strchr(bf, '/');
316 
317 			/* Catch VDSO */
318 			if (execname == NULL)
319 				execname = strstr(bf, "[vdso]");
320 
321 			if (execname == NULL)
322 				continue;
323 
324 			size = strlen(execname);
325 			execname[size - 1] = '\0'; /* Remove \n */
326 			memcpy(mmap_ev.filename, execname, size);
327 			size = ALIGN(size, sizeof(u64));
328 			mmap_ev.len -= mmap_ev.start;
329 			mmap_ev.header.size = (sizeof(mmap_ev) -
330 					       (sizeof(mmap_ev.filename) - size));
331 			mmap_ev.pid = pid;
332 			mmap_ev.tid = pid;
333 
334 			write_output(&mmap_ev, mmap_ev.header.size);
335 		}
336 	}
337 
338 	fclose(fp);
339 }
340 
341 static void synthesize_all(void)
342 {
343 	DIR *proc;
344 	struct dirent dirent, *next;
345 
346 	proc = opendir("/proc");
347 
348 	while (!readdir_r(proc, &dirent, &next) && next) {
349 		char *end;
350 		pid_t pid;
351 
352 		pid = strtol(dirent.d_name, &end, 10);
353 		if (*end) /* only interested in proper numerical dirents */
354 			continue;
355 
356 		pid_synthesize_comm_event(pid, 1);
357 		pid_synthesize_mmap_samples(pid);
358 	}
359 
360 	closedir(proc);
361 }
362 
363 static int group_fd;
364 
365 static struct perf_header_attr *get_header_attr(struct perf_counter_attr *a, int nr)
366 {
367 	struct perf_header_attr *h_attr;
368 
369 	if (nr < header->attrs) {
370 		h_attr = header->attr[nr];
371 	} else {
372 		h_attr = perf_header_attr__new(a);
373 		perf_header__add_attr(header, h_attr);
374 	}
375 
376 	return h_attr;
377 }
378 
379 static void create_counter(int counter, int cpu, pid_t pid)
380 {
381 	struct perf_counter_attr *attr = attrs + counter;
382 	struct perf_header_attr *h_attr;
383 	int track = !counter; /* only the first counter needs these */
384 	struct {
385 		u64 count;
386 		u64 time_enabled;
387 		u64 time_running;
388 		u64 id;
389 	} read_data;
390 
391 	attr->read_format	= PERF_FORMAT_TOTAL_TIME_ENABLED |
392 				  PERF_FORMAT_TOTAL_TIME_RUNNING |
393 				  PERF_FORMAT_ID;
394 
395 	attr->sample_type	= PERF_SAMPLE_IP | PERF_SAMPLE_TID;
396 
397 	if (freq) {
398 		attr->sample_type	|= PERF_SAMPLE_PERIOD;
399 		attr->freq		= 1;
400 		attr->sample_freq	= freq;
401 	}
402 
403 	if (no_samples)
404 		attr->sample_freq = 0;
405 
406 	if (inherit_stat)
407 		attr->inherit_stat = 1;
408 
409 	if (sample_address)
410 		attr->sample_type	|= PERF_SAMPLE_ADDR;
411 
412 	if (call_graph)
413 		attr->sample_type	|= PERF_SAMPLE_CALLCHAIN;
414 
415 
416 	attr->mmap		= track;
417 	attr->comm		= track;
418 	attr->inherit		= (cpu < 0) && inherit;
419 	attr->disabled		= 1;
420 
421 try_again:
422 	fd[nr_cpu][counter] = sys_perf_counter_open(attr, pid, cpu, group_fd, 0);
423 
424 	if (fd[nr_cpu][counter] < 0) {
425 		int err = errno;
426 
427 		if (err == EPERM)
428 			die("Permission error - are you root?\n");
429 
430 		/*
431 		 * If it's cycles then fall back to hrtimer
432 		 * based cpu-clock-tick sw counter, which
433 		 * is always available even if no PMU support:
434 		 */
435 		if (attr->type == PERF_TYPE_HARDWARE
436 			&& attr->config == PERF_COUNT_HW_CPU_CYCLES) {
437 
438 			if (verbose)
439 				warning(" ... trying to fall back to cpu-clock-ticks\n");
440 			attr->type = PERF_TYPE_SOFTWARE;
441 			attr->config = PERF_COUNT_SW_CPU_CLOCK;
442 			goto try_again;
443 		}
444 		printf("\n");
445 		error("perfcounter syscall returned with %d (%s)\n",
446 			fd[nr_cpu][counter], strerror(err));
447 		die("No CONFIG_PERF_COUNTERS=y kernel support configured?\n");
448 		exit(-1);
449 	}
450 
451 	h_attr = get_header_attr(attr, counter);
452 
453 	if (!file_new) {
454 		if (memcmp(&h_attr->attr, attr, sizeof(*attr))) {
455 			fprintf(stderr, "incompatible append\n");
456 			exit(-1);
457 		}
458 	}
459 
460 	if (read(fd[nr_cpu][counter], &read_data, sizeof(read_data)) == -1) {
461 		perror("Unable to read perf file descriptor\n");
462 		exit(-1);
463 	}
464 
465 	perf_header_attr__add_id(h_attr, read_data.id);
466 
467 	assert(fd[nr_cpu][counter] >= 0);
468 	fcntl(fd[nr_cpu][counter], F_SETFL, O_NONBLOCK);
469 
470 	/*
471 	 * First counter acts as the group leader:
472 	 */
473 	if (group && group_fd == -1)
474 		group_fd = fd[nr_cpu][counter];
475 
476 	event_array[nr_poll].fd = fd[nr_cpu][counter];
477 	event_array[nr_poll].events = POLLIN;
478 	nr_poll++;
479 
480 	mmap_array[nr_cpu][counter].counter = counter;
481 	mmap_array[nr_cpu][counter].prev = 0;
482 	mmap_array[nr_cpu][counter].mask = mmap_pages*page_size - 1;
483 	mmap_array[nr_cpu][counter].base = mmap(NULL, (mmap_pages+1)*page_size,
484 			PROT_READ|PROT_WRITE, MAP_SHARED, fd[nr_cpu][counter], 0);
485 	if (mmap_array[nr_cpu][counter].base == MAP_FAILED) {
486 		error("failed to mmap with %d (%s)\n", errno, strerror(errno));
487 		exit(-1);
488 	}
489 
490 	ioctl(fd[nr_cpu][counter], PERF_COUNTER_IOC_ENABLE);
491 }
492 
493 static void open_counters(int cpu, pid_t pid)
494 {
495 	int counter;
496 
497 	group_fd = -1;
498 	for (counter = 0; counter < nr_counters; counter++)
499 		create_counter(counter, cpu, pid);
500 
501 	nr_cpu++;
502 }
503 
504 static void atexit_header(void)
505 {
506 	header->data_size += bytes_written;
507 
508 	perf_header__write(header, output);
509 }
510 
511 static int __cmd_record(int argc, const char **argv)
512 {
513 	int i, counter;
514 	struct stat st;
515 	pid_t pid = 0;
516 	int flags;
517 	int ret;
518 
519 	page_size = sysconf(_SC_PAGE_SIZE);
520 	nr_cpus = sysconf(_SC_NPROCESSORS_ONLN);
521 	assert(nr_cpus <= MAX_NR_CPUS);
522 	assert(nr_cpus >= 0);
523 
524 	atexit(sig_atexit);
525 	signal(SIGCHLD, sig_handler);
526 	signal(SIGINT, sig_handler);
527 
528 	if (!stat(output_name, &st) && st.st_size) {
529 		if (!force && !append_file) {
530 			fprintf(stderr, "Error, output file %s exists, use -A to append or -f to overwrite.\n",
531 					output_name);
532 			exit(-1);
533 		}
534 	} else {
535 		append_file = 0;
536 	}
537 
538 	flags = O_CREAT|O_RDWR;
539 	if (append_file)
540 		file_new = 0;
541 	else
542 		flags |= O_TRUNC;
543 
544 	output = open(output_name, flags, S_IRUSR|S_IWUSR);
545 	if (output < 0) {
546 		perror("failed to create output file");
547 		exit(-1);
548 	}
549 
550 	if (!file_new)
551 		header = perf_header__read(output);
552 	else
553 		header = perf_header__new();
554 
555 	atexit(atexit_header);
556 
557 	if (!system_wide) {
558 		pid = target_pid;
559 		if (pid == -1)
560 			pid = getpid();
561 
562 		open_counters(-1, pid);
563 	} else for (i = 0; i < nr_cpus; i++)
564 		open_counters(i, target_pid);
565 
566 	if (file_new)
567 		perf_header__write(header, output);
568 
569 	if (!system_wide) {
570 		pid_synthesize_comm_event(pid, 0);
571 		pid_synthesize_mmap_samples(pid);
572 	} else
573 		synthesize_all();
574 
575 	if (target_pid == -1 && argc) {
576 		pid = fork();
577 		if (pid < 0)
578 			perror("failed to fork");
579 
580 		if (!pid) {
581 			if (execvp(argv[0], (char **)argv)) {
582 				perror(argv[0]);
583 				exit(-1);
584 			}
585 		}
586 	}
587 
588 	if (realtime_prio) {
589 		struct sched_param param;
590 
591 		param.sched_priority = realtime_prio;
592 		if (sched_setscheduler(0, SCHED_FIFO, &param)) {
593 			printf("Could not set realtime priority.\n");
594 			exit(-1);
595 		}
596 	}
597 
598 	for (;;) {
599 		int hits = samples;
600 
601 		for (i = 0; i < nr_cpu; i++) {
602 			for (counter = 0; counter < nr_counters; counter++)
603 				mmap_read(&mmap_array[i][counter]);
604 		}
605 
606 		if (hits == samples) {
607 			if (done)
608 				break;
609 			ret = poll(event_array, nr_poll, 100);
610 		}
611 	}
612 
613 	/*
614 	 * Approximate RIP event size: 24 bytes.
615 	 */
616 	fprintf(stderr,
617 		"[ perf record: Captured and wrote %.3f MB %s (~%lld samples) ]\n",
618 		(double)bytes_written / 1024.0 / 1024.0,
619 		output_name,
620 		bytes_written / 24);
621 
622 	return 0;
623 }
624 
625 static const char * const record_usage[] = {
626 	"perf record [<options>] [<command>]",
627 	"perf record [<options>] -- <command> [<options>]",
628 	NULL
629 };
630 
631 static const struct option options[] = {
632 	OPT_CALLBACK('e', "event", NULL, "event",
633 		     "event selector. use 'perf list' to list available events",
634 		     parse_events),
635 	OPT_INTEGER('p', "pid", &target_pid,
636 		    "record events on existing pid"),
637 	OPT_INTEGER('r', "realtime", &realtime_prio,
638 		    "collect data with this RT SCHED_FIFO priority"),
639 	OPT_BOOLEAN('a', "all-cpus", &system_wide,
640 			    "system-wide collection from all CPUs"),
641 	OPT_BOOLEAN('A', "append", &append_file,
642 			    "append to the output file to do incremental profiling"),
643 	OPT_BOOLEAN('f', "force", &force,
644 			"overwrite existing data file"),
645 	OPT_LONG('c', "count", &default_interval,
646 		    "event period to sample"),
647 	OPT_STRING('o', "output", &output_name, "file",
648 		    "output file name"),
649 	OPT_BOOLEAN('i', "inherit", &inherit,
650 		    "child tasks inherit counters"),
651 	OPT_INTEGER('F', "freq", &freq,
652 		    "profile at this frequency"),
653 	OPT_INTEGER('m', "mmap-pages", &mmap_pages,
654 		    "number of mmap data pages"),
655 	OPT_BOOLEAN('g', "call-graph", &call_graph,
656 		    "do call-graph (stack chain/backtrace) recording"),
657 	OPT_BOOLEAN('v', "verbose", &verbose,
658 		    "be more verbose (show counter open errors, etc)"),
659 	OPT_BOOLEAN('s', "stat", &inherit_stat,
660 		    "per thread counts"),
661 	OPT_BOOLEAN('d', "data", &sample_address,
662 		    "Sample addresses"),
663 	OPT_BOOLEAN('n', "no-samples", &no_samples,
664 		    "don't sample"),
665 	OPT_END()
666 };
667 
668 int cmd_record(int argc, const char **argv, const char *prefix __used)
669 {
670 	int counter;
671 
672 	argc = parse_options(argc, argv, options, record_usage,
673 		PARSE_OPT_STOP_AT_NON_OPTION);
674 	if (!argc && target_pid == -1 && !system_wide)
675 		usage_with_options(record_usage, options);
676 
677 	if (!nr_counters) {
678 		nr_counters	= 1;
679 		attrs[0].type	= PERF_TYPE_HARDWARE;
680 		attrs[0].config = PERF_COUNT_HW_CPU_CYCLES;
681 	}
682 
683 	for (counter = 0; counter < nr_counters; counter++) {
684 		if (attrs[counter].sample_period)
685 			continue;
686 
687 		attrs[counter].sample_period = default_interval;
688 	}
689 
690 	return __cmd_record(argc, argv);
691 }
692