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