trace_mmiotrace.c 8.7 KB

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