perf-record.c 7.7 KB

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