[mirror_ubuntu-artful-kernel.git] / tools / perf / tests / perf-record.c

#include <errno.h>
#include <inttypes.h>
/* For the CLR_() macros */
#include <pthread.h>

#include <sched.h>
#include "evlist.h"
#include "evsel.h"
#include "perf.h"
#include "debug.h"
#include "tests.h"

static int sched__get_first_possible_cpu(pid_t pid, cpu_set_t *maskp)
{
	int i, cpu = -1, nrcpus = 1024;
realloc:
	CPU_ZERO(maskp);

	if (sched_getaffinity(pid, sizeof(*maskp), maskp) == -1) {
		if (errno == EINVAL && nrcpus < (1024 << 8)) {
			nrcpus = nrcpus << 2;
			goto realloc;
		}
		perror("sched_getaffinity");
			return -1;
	}

	for (i = 0; i < nrcpus; i++) {
		if (CPU_ISSET(i, maskp)) {
			if (cpu == -1)
				cpu = i;
			else
				CPU_CLR(i, maskp);
		}
	}

	return cpu;
}

int test__PERF_RECORD(int subtest __maybe_unused)
{
	struct record_opts opts = {
		.target = {
			.uid = UINT_MAX,
			.uses_mmap = true,
		},
		.no_buffering = true,
		.mmap_pages   = 256,
	};
	cpu_set_t cpu_mask;
	size_t cpu_mask_size = sizeof(cpu_mask);
	struct perf_evlist *evlist = perf_evlist__new_dummy();
	struct perf_evsel *evsel;
	struct perf_sample sample;
	const char *cmd = "sleep";
	const char *argv[] = { cmd, "1", NULL, };
	char *bname, *mmap_filename;
	u64 prev_time = 0;
	bool found_cmd_mmap = false,
	     found_libc_mmap = false,
	     found_vdso_mmap = false,
	     found_ld_mmap = false;
	int err = -1, errs = 0, i, wakeups = 0;
	u32 cpu;
	int total_events = 0, nr_events[PERF_RECORD_MAX] = { 0, };
	char sbuf[STRERR_BUFSIZE];

	if (evlist == NULL) /* Fallback for kernels lacking PERF_COUNT_SW_DUMMY */
		evlist = perf_evlist__new_default();

	if (evlist == NULL) {
		pr_debug("Not enough memory to create evlist\n");
		goto out;
	}

	/*
	 * Create maps of threads and cpus to monitor. In this case
	 * we start with all threads and cpus (-1, -1) but then in
	 * perf_evlist__prepare_workload we'll fill in the only thread
	 * we're monitoring, the one forked there.
	 */
	err = perf_evlist__create_maps(evlist, &opts.target);
	if (err < 0) {
		pr_debug("Not enough memory to create thread/cpu maps\n");
		goto out_delete_evlist;
	}

	/*
	 * Prepare the workload in argv[] to run, it'll fork it, and then wait
	 * for perf_evlist__start_workload() to exec it. This is done this way
	 * so that we have time to open the evlist (calling sys_perf_event_open
	 * on all the fds) and then mmap them.
	 */
	err = perf_evlist__prepare_workload(evlist, &opts.target, argv, false, NULL);
	if (err < 0) {
		pr_debug("Couldn't run the workload!\n");
		goto out_delete_evlist;
	}

	/*
	 * Config the evsels, setting attr->comm on the first one, etc.
	 */
	evsel = perf_evlist__first(evlist);
	perf_evsel__set_sample_bit(evsel, CPU);
	perf_evsel__set_sample_bit(evsel, TID);
	perf_evsel__set_sample_bit(evsel, TIME);
	perf_evlist__config(evlist, &opts, NULL);

	err = sched__get_first_possible_cpu(evlist->workload.pid, &cpu_mask);
	if (err < 0) {
		pr_debug("sched__get_first_possible_cpu: %s\n",
			 str_error_r(errno, sbuf, sizeof(sbuf)));
		goto out_delete_evlist;
	}

	cpu = err;

	/*
	 * So that we can check perf_sample.cpu on all the samples.
	 */
	if (sched_setaffinity(evlist->workload.pid, cpu_mask_size, &cpu_mask) < 0) {
		pr_debug("sched_setaffinity: %s\n",
			 str_error_r(errno, sbuf, sizeof(sbuf)));
		goto out_delete_evlist;
	}

	/*
	 * Call sys_perf_event_open on all the fds on all the evsels,
	 * grouping them if asked to.
	 */
	err = perf_evlist__open(evlist);
	if (err < 0) {
		pr_debug("perf_evlist__open: %s\n",
			 str_error_r(errno, sbuf, sizeof(sbuf)));
		goto out_delete_evlist;
	}

	/*
	 * mmap the first fd on a given CPU and ask for events for the other
	 * fds in the same CPU to be injected in the same mmap ring buffer
	 * (using ioctl(PERF_EVENT_IOC_SET_OUTPUT)).
	 */
	err = perf_evlist__mmap(evlist, opts.mmap_pages, false);
	if (err < 0) {
		pr_debug("perf_evlist__mmap: %s\n",
			 str_error_r(errno, sbuf, sizeof(sbuf)));
		goto out_delete_evlist;
	}

	/*
	 * Now that all is properly set up, enable the events, they will
	 * count just on workload.pid, which will start...
	 */
	perf_evlist__enable(evlist);

	/*
	 * Now!
	 */
	perf_evlist__start_workload(evlist);

	while (1) {
		int before = total_events;

		for (i = 0; i < evlist->nr_mmaps; i++) {
			union perf_event *event;

			while ((event = perf_evlist__mmap_read(evlist, i)) != NULL) {
				const u32 type = event->header.type;
				const char *name = perf_event__name(type);

				++total_events;
				if (type < PERF_RECORD_MAX)
					nr_events[type]++;

				err = perf_evlist__parse_sample(evlist, event, &sample);
				if (err < 0) {
					if (verbose > 0)
						perf_event__fprintf(event, stderr);
					pr_debug("Couldn't parse sample\n");
					goto out_delete_evlist;
				}

				if (verbose > 0) {
					pr_info("%" PRIu64" %d ", sample.time, sample.cpu);
					perf_event__fprintf(event, stderr);
				}

				if (prev_time > sample.time) {
					pr_debug("%s going backwards in time, prev=%" PRIu64 ", curr=%" PRIu64 "\n",
						 name, prev_time, sample.time);
					++errs;
				}

				prev_time = sample.time;

				if (sample.cpu != cpu) {
					pr_debug("%s with unexpected cpu, expected %d, got %d\n",
						 name, cpu, sample.cpu);
					++errs;
				}

				if ((pid_t)sample.pid != evlist->workload.pid) {
					pr_debug("%s with unexpected pid, expected %d, got %d\n",
						 name, evlist->workload.pid, sample.pid);
					++errs;
				}

				if ((pid_t)sample.tid != evlist->workload.pid) {
					pr_debug("%s with unexpected tid, expected %d, got %d\n",
						 name, evlist->workload.pid, sample.tid);
					++errs;
				}

				if ((type == PERF_RECORD_COMM ||
				     type == PERF_RECORD_MMAP ||
				     type == PERF_RECORD_MMAP2 ||
				     type == PERF_RECORD_FORK ||
				     type == PERF_RECORD_EXIT) &&
				     (pid_t)event->comm.pid != evlist->workload.pid) {
					pr_debug("%s with unexpected pid/tid\n", name);
					++errs;
				}

				if ((type == PERF_RECORD_COMM ||
				     type == PERF_RECORD_MMAP ||
				     type == PERF_RECORD_MMAP2) &&
				     event->comm.pid != event->comm.tid) {
					pr_debug("%s with different pid/tid!\n", name);
					++errs;
				}

				switch (type) {
				case PERF_RECORD_COMM:
					if (strcmp(event->comm.comm, cmd)) {
						pr_debug("%s with unexpected comm!\n", name);
						++errs;
					}
					break;
				case PERF_RECORD_EXIT:
					goto found_exit;
				case PERF_RECORD_MMAP:
					mmap_filename = event->mmap.filename;
					goto check_bname;
				case PERF_RECORD_MMAP2:
					mmap_filename = event->mmap2.filename;
				check_bname:
					bname = strrchr(mmap_filename, '/');
					if (bname != NULL) {
						if (!found_cmd_mmap)
							found_cmd_mmap = !strcmp(bname + 1, cmd);
						if (!found_libc_mmap)
							found_libc_mmap = !strncmp(bname + 1, "libc", 4);
						if (!found_ld_mmap)
							found_ld_mmap = !strncmp(bname + 1, "ld", 2);
					} else if (!found_vdso_mmap)
						found_vdso_mmap = !strcmp(mmap_filename, "[vdso]");
					break;

				case PERF_RECORD_SAMPLE:
					/* Just ignore samples for now */
					break;
				default:
					pr_debug("Unexpected perf_event->header.type %d!\n",
						 type);
					++errs;
				}

				perf_evlist__mmap_consume(evlist, i);
			}
		}

		/*
		 * We don't use poll here because at least at 3.1 times the
		 * PERF_RECORD_{!SAMPLE} events don't honour
		 * perf_event_attr.wakeup_events, just PERF_EVENT_SAMPLE does.
		 */
		if (total_events == before && false)
			perf_evlist__poll(evlist, -1);

		sleep(1);
		if (++wakeups > 5) {
			pr_debug("No PERF_RECORD_EXIT event!\n");
			break;
		}
	}

found_exit:
	if (nr_events[PERF_RECORD_COMM] > 1) {
		pr_debug("Excessive number of PERF_RECORD_COMM events!\n");
		++errs;
	}

	if (nr_events[PERF_RECORD_COMM] == 0) {
		pr_debug("Missing PERF_RECORD_COMM for %s!\n", cmd);
		++errs;
	}

	if (!found_cmd_mmap) {
		pr_debug("PERF_RECORD_MMAP for %s missing!\n", cmd);
		++errs;
	}

	if (!found_libc_mmap) {
		pr_debug("PERF_RECORD_MMAP for %s missing!\n", "libc");
		++errs;
	}

	if (!found_ld_mmap) {
		pr_debug("PERF_RECORD_MMAP for %s missing!\n", "ld");
		++errs;
	}

	if (!found_vdso_mmap) {
		pr_debug("PERF_RECORD_MMAP for %s missing!\n", "[vdso]");
		++errs;
	}
out_delete_evlist:
	perf_evlist__delete(evlist);
out:
	return (err < 0 || errs > 0) ? -1 : 0;
}
Commit	Line	Data
a43783ae	1	#include <errno.h>
fd20e811	2	#include <inttypes.h>
1fbe7df8 ACM	3	/* For the CLR_() macros */
	4	#include <pthread.h>
	5
16d00fee JO	6	#include <sched.h>
	7	#include "evlist.h"
	8	#include "evsel.h"
	9	#include "perf.h"
	10	#include "debug.h"
	11	#include "tests.h"
	12
	13	static int sched__get_first_possible_cpu(pid_t pid, cpu_set_t *maskp)
	14	{
	15	int i, cpu = -1, nrcpus = 1024;
	16	realloc:
	17	CPU_ZERO(maskp);
	18
	19	if (sched_getaffinity(pid, sizeof(*maskp), maskp) == -1) {
	20	if (errno == EINVAL && nrcpus < (1024 << 8)) {
	21	nrcpus = nrcpus << 2;
	22	goto realloc;
	23	}
	24	perror("sched_getaffinity");
	25	return -1;
	26	}
	27
	28	for (i = 0; i < nrcpus; i++) {
	29	if (CPU_ISSET(i, maskp)) {
	30	if (cpu == -1)
	31	cpu = i;
	32	else
	33	CPU_CLR(i, maskp);
	34	}
	35	}
	36
	37	return cpu;
	38	}
	39
721a1f53	40	int test__PERF_RECORD(int subtest __maybe_unused)
16d00fee	41	{
b4006796	42	struct record_opts opts = {
16d00fee JO	43	.target = {
	44	.uid = UINT_MAX,
	45	.uses_mmap = true,
	46	},
509051ea	47	.no_buffering = true,
509051ea	48	.mmap_pages = 256,
16d00fee JO	49	};
	50	cpu_set_t cpu_mask;
	51	size_t cpu_mask_size = sizeof(cpu_mask);
69ef8f47	52	struct perf_evlist *evlist = perf_evlist__new_dummy();
16d00fee JO	53	struct perf_evsel *evsel;
	54	struct perf_sample sample;
	55	const char *cmd = "sleep";
	56	const char *argv[] = { cmd, "1", NULL, };
5c5e854b	57	char bname, mmap_filename;
16d00fee JO	58	u64 prev_time = 0;
	59	bool found_cmd_mmap = false,
	60	found_libc_mmap = false,
	61	found_vdso_mmap = false,
	62	found_ld_mmap = false;
	63	int err = -1, errs = 0, i, wakeups = 0;
	64	u32 cpu;
	65	int total_events = 0, nr_events[PERF_RECORD_MAX] = { 0, };
ba3dfff8	66	char sbuf[STRERR_BUFSIZE];
16d00fee	67
69ef8f47 ACM	68	if (evlist == NULL) /* Fallback for kernels lacking PERF_COUNT_SW_DUMMY */
	69	evlist = perf_evlist__new_default();
	70
9ef6839b	71	if (evlist == NULL) {
16d00fee JO	72	pr_debug("Not enough memory to create evlist\n");
	73	goto out;
	74	}
	75
16d00fee JO	76	/*
	77	* Create maps of threads and cpus to monitor. In this case
	78	* we start with all threads and cpus (-1, -1) but then in
	79	* perf_evlist__prepare_workload we'll fill in the only thread
	80	* we're monitoring, the one forked there.
	81	*/
	82	err = perf_evlist__create_maps(evlist, &opts.target);
	83	if (err < 0) {
	84	pr_debug("Not enough memory to create thread/cpu maps\n");
	85	goto out_delete_evlist;
	86	}
	87
	88	/*
	89	* Prepare the workload in argv[] to run, it'll fork it, and then wait
	90	* for perf_evlist__start_workload() to exec it. This is done this way
	91	* so that we have time to open the evlist (calling sys_perf_event_open
	92	* on all the fds) and then mmap them.
	93	*/
735f7e0b	94	err = perf_evlist__prepare_workload(evlist, &opts.target, argv, false, NULL);
16d00fee JO	95	if (err < 0) {
16d00fee JO	96	pr_debug("Couldn't run the workload!\n");
03ad9747	97	goto out_delete_evlist;
16d00fee JO	98	}
	99
	100	/*
	101	* Config the evsels, setting attr->comm on the first one, etc.
	102	*/
	103	evsel = perf_evlist__first(evlist);
7be5ebe8 ACM	104	perf_evsel__set_sample_bit(evsel, CPU);
	105	perf_evsel__set_sample_bit(evsel, TID);
	106	perf_evsel__set_sample_bit(evsel, TIME);
e68ae9cf	107	perf_evlist__config(evlist, &opts, NULL);
16d00fee JO	108
	109	err = sched__get_first_possible_cpu(evlist->workload.pid, &cpu_mask);
	110	if (err < 0) {
ba3dfff8	111	pr_debug("sched__get_first_possible_cpu: %s\n",
c8b5f2c9	112	str_error_r(errno, sbuf, sizeof(sbuf)));
03ad9747	113	goto out_delete_evlist;
16d00fee JO	114	}
	115
	116	cpu = err;
	117
	118	/*
	119	* So that we can check perf_sample.cpu on all the samples.
	120	*/
	121	if (sched_setaffinity(evlist->workload.pid, cpu_mask_size, &cpu_mask) < 0) {
ba3dfff8	122	pr_debug("sched_setaffinity: %s\n",
c8b5f2c9	123	str_error_r(errno, sbuf, sizeof(sbuf)));
03ad9747	124	goto out_delete_evlist;
16d00fee JO	125	}
	126
	127	/*
	128	* Call sys_perf_event_open on all the fds on all the evsels,
	129	* grouping them if asked to.
	130	*/
	131	err = perf_evlist__open(evlist);
	132	if (err < 0) {
ba3dfff8	133	pr_debug("perf_evlist__open: %s\n",
c8b5f2c9	134	str_error_r(errno, sbuf, sizeof(sbuf)));
03ad9747	135	goto out_delete_evlist;
16d00fee JO	136	}
	137
	138	/*
	139	* mmap the first fd on a given CPU and ask for events for the other
	140	* fds in the same CPU to be injected in the same mmap ring buffer
	141	* (using ioctl(PERF_EVENT_IOC_SET_OUTPUT)).
	142	*/
	143	err = perf_evlist__mmap(evlist, opts.mmap_pages, false);
	144	if (err < 0) {
ba3dfff8	145	pr_debug("perf_evlist__mmap: %s\n",
c8b5f2c9	146	str_error_r(errno, sbuf, sizeof(sbuf)));
f26e1c7c	147	goto out_delete_evlist;
16d00fee JO	148	}
	149
	150	/*
	151	* Now that all is properly set up, enable the events, they will
	152	* count just on workload.pid, which will start...
	153	*/
	154	perf_evlist__enable(evlist);
	155
	156	/*
	157	* Now!
	158	*/
	159	perf_evlist__start_workload(evlist);
	160
	161	while (1) {
	162	int before = total_events;
	163
	164	for (i = 0; i < evlist->nr_mmaps; i++) {
	165	union perf_event *event;
	166
	167	while ((event = perf_evlist__mmap_read(evlist, i)) != NULL) {
	168	const u32 type = event->header.type;
	169	const char *name = perf_event__name(type);
	170
	171	++total_events;
	172	if (type < PERF_RECORD_MAX)
	173	nr_events[type]++;
	174
	175	err = perf_evlist__parse_sample(evlist, event, &sample);
	176	if (err < 0) {
bb963e16	177	if (verbose > 0)
16d00fee JO	178	perf_event__fprintf(event, stderr);
16d00fee JO	179	pr_debug("Couldn't parse sample\n");
983874d1	180	goto out_delete_evlist;
16d00fee JO	181	}
16d00fee JO	182
bb963e16	183	if (verbose > 0) {
16d00fee JO	184	pr_info("%" PRIu64" %d ", sample.time, sample.cpu);
	185	perf_event__fprintf(event, stderr);
	186	}
	187
	188	if (prev_time > sample.time) {
	189	pr_debug("%s going backwards in time, prev=%" PRIu64 ", curr=%" PRIu64 "\n",
	190	name, prev_time, sample.time);
	191	++errs;
	192	}
	193
	194	prev_time = sample.time;
	195
	196	if (sample.cpu != cpu) {
	197	pr_debug("%s with unexpected cpu, expected %d, got %d\n",
	198	name, cpu, sample.cpu);
	199	++errs;
	200	}
	201
	202	if ((pid_t)sample.pid != evlist->workload.pid) {
	203	pr_debug("%s with unexpected pid, expected %d, got %d\n",
	204	name, evlist->workload.pid, sample.pid);
	205	++errs;
	206	}
	207
	208	if ((pid_t)sample.tid != evlist->workload.pid) {
	209	pr_debug("%s with unexpected tid, expected %d, got %d\n",
	210	name, evlist->workload.pid, sample.tid);
	211	++errs;
	212	}
	213
	214	if ((type == PERF_RECORD_COMM \|\|
	215	type == PERF_RECORD_MMAP \|\|
5c5e854b	216	type == PERF_RECORD_MMAP2 \|\|
16d00fee JO	217	type == PERF_RECORD_FORK \|\|
	218	type == PERF_RECORD_EXIT) &&
	219	(pid_t)event->comm.pid != evlist->workload.pid) {
	220	pr_debug("%s with unexpected pid/tid\n", name);
	221	++errs;
	222	}
	223
	224	if ((type == PERF_RECORD_COMM \|\|
5c5e854b SE	225	type == PERF_RECORD_MMAP \|\|
5c5e854b SE	226	type == PERF_RECORD_MMAP2) &&
16d00fee JO	227	event->comm.pid != event->comm.tid) {
	228	pr_debug("%s with different pid/tid!\n", name);
	229	++errs;
	230	}
	231
	232	switch (type) {
	233	case PERF_RECORD_COMM:
	234	if (strcmp(event->comm.comm, cmd)) {
	235	pr_debug("%s with unexpected comm!\n", name);
	236	++errs;
	237	}
	238	break;
	239	case PERF_RECORD_EXIT:
	240	goto found_exit;
	241	case PERF_RECORD_MMAP:
5c5e854b SE	242	mmap_filename = event->mmap.filename;
	243	goto check_bname;
	244	case PERF_RECORD_MMAP2:
	245	mmap_filename = event->mmap2.filename;
	246	check_bname:
	247	bname = strrchr(mmap_filename, '/');
16d00fee JO	248	if (bname != NULL) {
	249	if (!found_cmd_mmap)
	250	found_cmd_mmap = !strcmp(bname + 1, cmd);
	251	if (!found_libc_mmap)
	252	found_libc_mmap = !strncmp(bname + 1, "libc", 4);
	253	if (!found_ld_mmap)
	254	found_ld_mmap = !strncmp(bname + 1, "ld", 2);
	255	} else if (!found_vdso_mmap)
5c5e854b	256	found_vdso_mmap = !strcmp(mmap_filename, "[vdso]");
16d00fee JO	257	break;
	258
	259	case PERF_RECORD_SAMPLE:
	260	/* Just ignore samples for now */
	261	break;
	262	default:
	263	pr_debug("Unexpected perf_event->header.type %d!\n",
	264	type);
	265	++errs;
	266	}
8e50d384 ZZ	267
8e50d384 ZZ	268	perf_evlist__mmap_consume(evlist, i);
16d00fee JO	269	}
	270	}
	271
	272	/*
	273	* We don't use poll here because at least at 3.1 times the
	274	* PERF_RECORD_{!SAMPLE} events don't honour
	275	* perf_event_attr.wakeup_events, just PERF_EVENT_SAMPLE does.
	276	*/
	277	if (total_events == before && false)
f66a889d	278	perf_evlist__poll(evlist, -1);
16d00fee JO	279
	280	sleep(1);
	281	if (++wakeups > 5) {
	282	pr_debug("No PERF_RECORD_EXIT event!\n");
	283	break;
	284	}
	285	}
	286
	287	found_exit:
	288	if (nr_events[PERF_RECORD_COMM] > 1) {
	289	pr_debug("Excessive number of PERF_RECORD_COMM events!\n");
	290	++errs;
	291	}
	292
	293	if (nr_events[PERF_RECORD_COMM] == 0) {
	294	pr_debug("Missing PERF_RECORD_COMM for %s!\n", cmd);
	295	++errs;
	296	}
	297
	298	if (!found_cmd_mmap) {
	299	pr_debug("PERF_RECORD_MMAP for %s missing!\n", cmd);
	300	++errs;
	301	}
	302
	303	if (!found_libc_mmap) {
	304	pr_debug("PERF_RECORD_MMAP for %s missing!\n", "libc");
	305	++errs;
	306	}
	307
	308	if (!found_ld_mmap) {
	309	pr_debug("PERF_RECORD_MMAP for %s missing!\n", "ld");
	310	++errs;
	311	}
	312
	313	if (!found_vdso_mmap) {
	314	pr_debug("PERF_RECORD_MMAP for %s missing!\n", "[vdso]");
	315	++errs;
	316	}
16d00fee JO	317	out_delete_evlist:
	318	perf_evlist__delete(evlist);
	319	out:
	320	return (err < 0 \|\| errs > 0) ? -1 : 0;
	321	}