trace_mmiotrace.c 8.8 KB

123456789101112131415161718192021222324252627282930313233343536373839404142434445464748495051525354555657585960616263646566676869707172737475767778798081828384858687888990919293949596979899100101102103104105106107108109110111112113114115116117118119120121122123124125126127128129130131132133134135136137138139140141142143144145146147148149150151152153154155156157158159160161162163164165166167168169170171172173174175176177178179180181182183184185186187188189190191192193194195196197198199200201202203204205206207208209210211212213214215216217218219220221222223224225226227228229230231232233234235236237238239240241242243244245246247248249250251252253254255256257258259260261262263264265266267268269270271272273274275276277278279280281282283284285286287288289290291292293294295296297298299300301302303304305306307308309310311312313314315316317318319320321322323324325326327328329330331332333334335336337338339340341342343344345346347348349350351352353354355356357358359360361362363364365366367368369370
  1. /*
  2. * Memory mapped I/O tracing
  3. *
  4. * Copyright (C) 2008 Pekka Paalanen <pq@iki.fi>
  5. */
  6. #define DEBUG 1
  7. #include <linux/kernel.h>
  8. #include <linux/mmiotrace.h>
  9. #include <linux/pci.h>
  10. #include "trace.h"
  11. struct header_iter {
  12. struct pci_dev *dev;
  13. };
  14. static struct trace_array *mmio_trace_array;
  15. static bool overrun_detected;
  16. static unsigned long prev_overruns;
  17. static void mmio_reset_data(struct trace_array *tr)
  18. {
  19. int cpu;
  20. overrun_detected = false;
  21. prev_overruns = 0;
  22. tr->time_start = ftrace_now(tr->cpu);
  23. for_each_online_cpu(cpu)
  24. tracing_reset(tr, cpu);
  25. }
  26. static int mmio_trace_init(struct trace_array *tr)
  27. {
  28. pr_debug("in %s\n", __func__);
  29. mmio_trace_array = tr;
  30. mmio_reset_data(tr);
  31. enable_mmiotrace();
  32. return 0;
  33. }
  34. static void mmio_trace_reset(struct trace_array *tr)
  35. {
  36. pr_debug("in %s\n", __func__);
  37. disable_mmiotrace();
  38. mmio_reset_data(tr);
  39. mmio_trace_array = NULL;
  40. }
  41. static void mmio_trace_start(struct trace_array *tr)
  42. {
  43. pr_debug("in %s\n", __func__);
  44. mmio_reset_data(tr);
  45. }
  46. static int mmio_print_pcidev(struct trace_seq *s, const struct pci_dev *dev)
  47. {
  48. int ret = 0;
  49. int i;
  50. resource_size_t start, end;
  51. const struct pci_driver *drv = pci_dev_driver(dev);
  52. /* XXX: incomplete checks for trace_seq_printf() return value */
  53. ret += trace_seq_printf(s, "PCIDEV %02x%02x %04x%04x %x",
  54. dev->bus->number, dev->devfn,
  55. dev->vendor, dev->device, dev->irq);
  56. /*
  57. * XXX: is pci_resource_to_user() appropriate, since we are
  58. * supposed to interpret the __ioremap() phys_addr argument based on
  59. * these printed values?
  60. */
  61. for (i = 0; i < 7; i++) {
  62. pci_resource_to_user(dev, i, &dev->resource[i], &start, &end);
  63. ret += trace_seq_printf(s, " %llx",
  64. (unsigned long long)(start |
  65. (dev->resource[i].flags & PCI_REGION_FLAG_MASK)));
  66. }
  67. for (i = 0; i < 7; i++) {
  68. pci_resource_to_user(dev, i, &dev->resource[i], &start, &end);
  69. ret += trace_seq_printf(s, " %llx",
  70. dev->resource[i].start < dev->resource[i].end ?
  71. (unsigned long long)(end - start) + 1 : 0);
  72. }
  73. if (drv)
  74. ret += trace_seq_printf(s, " %s\n", drv->name);
  75. else
  76. ret += trace_seq_printf(s, " \n");
  77. return ret;
  78. }
  79. static void destroy_header_iter(struct header_iter *hiter)
  80. {
  81. if (!hiter)
  82. return;
  83. pci_dev_put(hiter->dev);
  84. kfree(hiter);
  85. }
  86. static void mmio_pipe_open(struct trace_iterator *iter)
  87. {
  88. struct header_iter *hiter;
  89. struct trace_seq *s = &iter->seq;
  90. trace_seq_printf(s, "VERSION 20070824\n");
  91. hiter = kzalloc(sizeof(*hiter), GFP_KERNEL);
  92. if (!hiter)
  93. return;
  94. hiter->dev = pci_get_device(PCI_ANY_ID, PCI_ANY_ID, NULL);
  95. iter->private = hiter;
  96. }
  97. /* XXX: This is not called when the pipe is closed! */
  98. static void mmio_close(struct trace_iterator *iter)
  99. {
  100. struct header_iter *hiter = iter->private;
  101. destroy_header_iter(hiter);
  102. iter->private = NULL;
  103. }
  104. static unsigned long count_overruns(struct trace_iterator *iter)
  105. {
  106. unsigned long cnt = 0;
  107. unsigned long over = ring_buffer_overruns(iter->tr->buffer);
  108. if (over > prev_overruns)
  109. cnt = over - prev_overruns;
  110. prev_overruns = over;
  111. return cnt;
  112. }
  113. static ssize_t mmio_read(struct trace_iterator *iter, struct file *filp,
  114. char __user *ubuf, size_t cnt, loff_t *ppos)
  115. {
  116. ssize_t ret;
  117. struct header_iter *hiter = iter->private;
  118. struct trace_seq *s = &iter->seq;
  119. unsigned long n;
  120. n = count_overruns(iter);
  121. if (n) {
  122. /* XXX: This is later than where events were lost. */
  123. trace_seq_printf(s, "MARK 0.000000 Lost %lu events.\n", n);
  124. if (!overrun_detected)
  125. pr_warning("mmiotrace has lost events.\n");
  126. overrun_detected = true;
  127. goto print_out;
  128. }
  129. if (!hiter)
  130. return 0;
  131. mmio_print_pcidev(s, hiter->dev);
  132. hiter->dev = pci_get_device(PCI_ANY_ID, PCI_ANY_ID, hiter->dev);
  133. if (!hiter->dev) {
  134. destroy_header_iter(hiter);
  135. iter->private = NULL;
  136. }
  137. print_out:
  138. ret = trace_seq_to_user(s, ubuf, cnt);
  139. return (ret == -EBUSY) ? 0 : ret;
  140. }
  141. static enum print_line_t mmio_print_rw(struct trace_iterator *iter)
  142. {
  143. struct trace_entry *entry = iter->ent;
  144. struct trace_mmiotrace_rw *field;
  145. struct mmiotrace_rw *rw;
  146. struct trace_seq *s = &iter->seq;
  147. unsigned long long t = ns2usecs(iter->ts);
  148. unsigned long usec_rem = do_div(t, 1000000ULL);
  149. unsigned secs = (unsigned long)t;
  150. int ret = 1;
  151. trace_assign_type(field, entry);
  152. rw = &field->rw;
  153. switch (rw->opcode) {
  154. case MMIO_READ:
  155. ret = trace_seq_printf(s,
  156. "R %d %lu.%06lu %d 0x%llx 0x%lx 0x%lx %d\n",
  157. rw->width, secs, usec_rem, rw->map_id,
  158. (unsigned long long)rw->phys,
  159. rw->value, rw->pc, 0);
  160. break;
  161. case MMIO_WRITE:
  162. ret = trace_seq_printf(s,
  163. "W %d %lu.%06lu %d 0x%llx 0x%lx 0x%lx %d\n",
  164. rw->width, secs, usec_rem, rw->map_id,
  165. (unsigned long long)rw->phys,
  166. rw->value, rw->pc, 0);
  167. break;
  168. case MMIO_UNKNOWN_OP:
  169. ret = trace_seq_printf(s,
  170. "UNKNOWN %lu.%06lu %d 0x%llx %02x,%02x,%02x 0x%lx %d\n",
  171. secs, usec_rem, rw->map_id,
  172. (unsigned long long)rw->phys,
  173. (rw->value >> 16) & 0xff, (rw->value >> 8) & 0xff,
  174. (rw->value >> 0) & 0xff, rw->pc, 0);
  175. break;
  176. default:
  177. ret = trace_seq_printf(s, "rw what?\n");
  178. break;
  179. }
  180. if (ret)
  181. return TRACE_TYPE_HANDLED;
  182. return TRACE_TYPE_PARTIAL_LINE;
  183. }
  184. static enum print_line_t mmio_print_map(struct trace_iterator *iter)
  185. {
  186. struct trace_entry *entry = iter->ent;
  187. struct trace_mmiotrace_map *field;
  188. struct mmiotrace_map *m;
  189. struct trace_seq *s = &iter->seq;
  190. unsigned long long t = ns2usecs(iter->ts);
  191. unsigned long usec_rem = do_div(t, 1000000ULL);
  192. unsigned secs = (unsigned long)t;
  193. int ret;
  194. trace_assign_type(field, entry);
  195. m = &field->map;
  196. switch (m->opcode) {
  197. case MMIO_PROBE:
  198. ret = trace_seq_printf(s,
  199. "MAP %lu.%06lu %d 0x%llx 0x%lx 0x%lx 0x%lx %d\n",
  200. secs, usec_rem, m->map_id,
  201. (unsigned long long)m->phys, m->virt, m->len,
  202. 0UL, 0);
  203. break;
  204. case MMIO_UNPROBE:
  205. ret = trace_seq_printf(s,
  206. "UNMAP %lu.%06lu %d 0x%lx %d\n",
  207. secs, usec_rem, m->map_id, 0UL, 0);
  208. break;
  209. default:
  210. ret = trace_seq_printf(s, "map what?\n");
  211. break;
  212. }
  213. if (ret)
  214. return TRACE_TYPE_HANDLED;
  215. return TRACE_TYPE_PARTIAL_LINE;
  216. }
  217. static enum print_line_t mmio_print_mark(struct trace_iterator *iter)
  218. {
  219. struct trace_entry *entry = iter->ent;
  220. struct print_entry *print = (struct print_entry *)entry;
  221. const char *msg = print->buf;
  222. struct trace_seq *s = &iter->seq;
  223. unsigned long long t = ns2usecs(iter->ts);
  224. unsigned long usec_rem = do_div(t, 1000000ULL);
  225. unsigned secs = (unsigned long)t;
  226. int ret;
  227. /* The trailing newline must be in the message. */
  228. ret = trace_seq_printf(s, "MARK %lu.%06lu %s", secs, usec_rem, msg);
  229. if (!ret)
  230. return TRACE_TYPE_PARTIAL_LINE;
  231. if (entry->flags & TRACE_FLAG_CONT)
  232. trace_seq_print_cont(s, iter);
  233. return TRACE_TYPE_HANDLED;
  234. }
  235. static enum print_line_t mmio_print_line(struct trace_iterator *iter)
  236. {
  237. switch (iter->ent->type) {
  238. case TRACE_MMIO_RW:
  239. return mmio_print_rw(iter);
  240. case TRACE_MMIO_MAP:
  241. return mmio_print_map(iter);
  242. case TRACE_PRINT:
  243. return mmio_print_mark(iter);
  244. default:
  245. return TRACE_TYPE_HANDLED; /* ignore unknown entries */
  246. }
  247. }
  248. static struct tracer mmio_tracer __read_mostly =
  249. {
  250. .name = "mmiotrace",
  251. .init = mmio_trace_init,
  252. .reset = mmio_trace_reset,
  253. .start = mmio_trace_start,
  254. .pipe_open = mmio_pipe_open,
  255. .close = mmio_close,
  256. .read = mmio_read,
  257. .print_line = mmio_print_line,
  258. };
  259. __init static int init_mmio_trace(void)
  260. {
  261. return register_tracer(&mmio_tracer);
  262. }
  263. device_initcall(init_mmio_trace);
  264. static void __trace_mmiotrace_rw(struct trace_array *tr,
  265. struct trace_array_cpu *data,
  266. struct mmiotrace_rw *rw)
  267. {
  268. struct ring_buffer_event *event;
  269. struct trace_mmiotrace_rw *entry;
  270. unsigned long irq_flags;
  271. event = ring_buffer_lock_reserve(tr->buffer, sizeof(*entry),
  272. &irq_flags);
  273. if (!event)
  274. return;
  275. entry = ring_buffer_event_data(event);
  276. tracing_generic_entry_update(&entry->ent, 0, preempt_count());
  277. entry->ent.type = TRACE_MMIO_RW;
  278. entry->rw = *rw;
  279. ring_buffer_unlock_commit(tr->buffer, event, irq_flags);
  280. trace_wake_up();
  281. }
  282. void mmio_trace_rw(struct mmiotrace_rw *rw)
  283. {
  284. struct trace_array *tr = mmio_trace_array;
  285. struct trace_array_cpu *data = tr->data[smp_processor_id()];
  286. __trace_mmiotrace_rw(tr, data, rw);
  287. }
  288. static void __trace_mmiotrace_map(struct trace_array *tr,
  289. struct trace_array_cpu *data,
  290. struct mmiotrace_map *map)
  291. {
  292. struct ring_buffer_event *event;
  293. struct trace_mmiotrace_map *entry;
  294. unsigned long irq_flags;
  295. event = ring_buffer_lock_reserve(tr->buffer, sizeof(*entry),
  296. &irq_flags);
  297. if (!event)
  298. return;
  299. entry = ring_buffer_event_data(event);
  300. tracing_generic_entry_update(&entry->ent, 0, preempt_count());
  301. entry->ent.type = TRACE_MMIO_MAP;
  302. entry->map = *map;
  303. ring_buffer_unlock_commit(tr->buffer, event, irq_flags);
  304. trace_wake_up();
  305. }
  306. void mmio_trace_mapping(struct mmiotrace_map *map)
  307. {
  308. struct trace_array *tr = mmio_trace_array;
  309. struct trace_array_cpu *data;
  310. preempt_disable();
  311. data = tr->data[smp_processor_id()];
  312. __trace_mmiotrace_map(tr, data, map);
  313. preempt_enable();
  314. }
  315. int mmio_trace_printk(const char *fmt, va_list args)
  316. {
  317. return trace_vprintk(0, -1, fmt, args);
  318. }