1 /* SPDX-License-Identifier: GPL-2.0 */
3 * xHCI host controller driver
5 * Copyright (C) 2013 Xenia Ragiadakou
7 * Author: Xenia Ragiadakou
12 #define TRACE_SYSTEM xhci-hcd
15 * The TRACE_SYSTEM_VAR defaults to TRACE_SYSTEM, but must be a
16 * legitimate C variable. It is not exported to user space.
18 #undef TRACE_SYSTEM_VAR
19 #define TRACE_SYSTEM_VAR xhci_hcd
21 #if !defined(__XHCI_TRACE_H) || defined(TRACE_HEADER_MULTI_READ)
22 #define __XHCI_TRACE_H
24 #include <linux/tracepoint.h>
26 #include "xhci-dbgcap.h"
28 DECLARE_EVENT_CLASS(xhci_log_msg,
29 TP_PROTO(struct va_format *vaf),
31 TP_STRUCT__entry(__vstring(msg, vaf->fmt, vaf->va)),
33 __assign_vstr(msg, vaf->fmt, vaf->va);
35 TP_printk("%s", __get_str(msg))
38 DEFINE_EVENT(xhci_log_msg, xhci_dbg_address,
39 TP_PROTO(struct va_format *vaf),
43 DEFINE_EVENT(xhci_log_msg, xhci_dbg_context_change,
44 TP_PROTO(struct va_format *vaf),
48 DEFINE_EVENT(xhci_log_msg, xhci_dbg_quirks,
49 TP_PROTO(struct va_format *vaf),
53 DEFINE_EVENT(xhci_log_msg, xhci_dbg_reset_ep,
54 TP_PROTO(struct va_format *vaf),
58 DEFINE_EVENT(xhci_log_msg, xhci_dbg_cancel_urb,
59 TP_PROTO(struct va_format *vaf),
63 DEFINE_EVENT(xhci_log_msg, xhci_dbg_init,
64 TP_PROTO(struct va_format *vaf),
68 DEFINE_EVENT(xhci_log_msg, xhci_dbg_ring_expansion,
69 TP_PROTO(struct va_format *vaf),
73 DECLARE_EVENT_CLASS(xhci_log_ctx,
74 TP_PROTO(struct xhci_hcd *xhci, struct xhci_container_ctx *ctx,
76 TP_ARGS(xhci, ctx, ep_num),
79 __field(unsigned, ctx_type)
80 __field(dma_addr_t, ctx_dma)
82 __field(unsigned, ctx_ep_num)
83 __dynamic_array(u32, ctx_data,
84 ((HCC_64BYTE_CONTEXT(xhci->hcc_params) + 1) * 8) *
85 ((ctx->type == XHCI_CTX_TYPE_INPUT) + ep_num + 1))
89 __entry->ctx_64 = HCC_64BYTE_CONTEXT(xhci->hcc_params);
90 __entry->ctx_type = ctx->type;
91 __entry->ctx_dma = ctx->dma;
92 __entry->ctx_va = ctx->bytes;
93 __entry->ctx_ep_num = ep_num;
94 memcpy(__get_dynamic_array(ctx_data), ctx->bytes,
95 ((HCC_64BYTE_CONTEXT(xhci->hcc_params) + 1) * 32) *
96 ((ctx->type == XHCI_CTX_TYPE_INPUT) + ep_num + 1));
98 TP_printk("ctx_64=%d, ctx_type=%u, ctx_dma=@%llx, ctx_va=@%p",
99 __entry->ctx_64, __entry->ctx_type,
100 (unsigned long long) __entry->ctx_dma, __entry->ctx_va
104 DEFINE_EVENT(xhci_log_ctx, xhci_address_ctx,
105 TP_PROTO(struct xhci_hcd *xhci, struct xhci_container_ctx *ctx,
106 unsigned int ep_num),
107 TP_ARGS(xhci, ctx, ep_num)
110 DECLARE_EVENT_CLASS(xhci_log_trb,
111 TP_PROTO(struct xhci_ring *ring, struct xhci_generic_trb *trb, dma_addr_t dma),
112 TP_ARGS(ring, trb, dma),
114 __field(dma_addr_t, dma)
123 __entry->type = ring->type;
124 __entry->field0 = le32_to_cpu(trb->field[0]);
125 __entry->field1 = le32_to_cpu(trb->field[1]);
126 __entry->field2 = le32_to_cpu(trb->field[2]);
127 __entry->field3 = le32_to_cpu(trb->field[3]);
129 TP_printk("%s: @%pad %s",
130 xhci_ring_type_string(__entry->type), &__entry->dma,
131 xhci_decode_trb(__get_buf(XHCI_MSG_MAX), XHCI_MSG_MAX, __entry->field0,
132 __entry->field1, __entry->field2, __entry->field3)
136 DEFINE_EVENT(xhci_log_trb, xhci_handle_event,
137 TP_PROTO(struct xhci_ring *ring, struct xhci_generic_trb *trb, dma_addr_t dma),
138 TP_ARGS(ring, trb, dma)
141 DEFINE_EVENT(xhci_log_trb, xhci_handle_command,
142 TP_PROTO(struct xhci_ring *ring, struct xhci_generic_trb *trb, dma_addr_t dma),
143 TP_ARGS(ring, trb, dma)
146 DEFINE_EVENT(xhci_log_trb, xhci_handle_transfer,
147 TP_PROTO(struct xhci_ring *ring, struct xhci_generic_trb *trb, dma_addr_t dma),
148 TP_ARGS(ring, trb, dma)
151 DEFINE_EVENT(xhci_log_trb, xhci_queue_trb,
152 TP_PROTO(struct xhci_ring *ring, struct xhci_generic_trb *trb, dma_addr_t dma),
153 TP_ARGS(ring, trb, dma)
157 DEFINE_EVENT(xhci_log_trb, xhci_dbc_handle_event,
158 TP_PROTO(struct xhci_ring *ring, struct xhci_generic_trb *trb, dma_addr_t dma),
159 TP_ARGS(ring, trb, dma)
162 DEFINE_EVENT(xhci_log_trb, xhci_dbc_handle_transfer,
163 TP_PROTO(struct xhci_ring *ring, struct xhci_generic_trb *trb, dma_addr_t dma),
164 TP_ARGS(ring, trb, dma)
167 DEFINE_EVENT(xhci_log_trb, xhci_dbc_gadget_ep_queue,
168 TP_PROTO(struct xhci_ring *ring, struct xhci_generic_trb *trb, dma_addr_t dma),
169 TP_ARGS(ring, trb, dma)
172 DECLARE_EVENT_CLASS(xhci_log_free_virt_dev,
173 TP_PROTO(struct xhci_virt_device *vdev),
176 __field(void *, vdev)
177 __field(unsigned long long, out_ctx)
178 __field(unsigned long long, in_ctx)
179 __field(int, slot_id)
180 __field(u16, current_mel)
184 __entry->vdev = vdev;
185 __entry->in_ctx = (unsigned long long) vdev->in_ctx->dma;
186 __entry->out_ctx = (unsigned long long) vdev->out_ctx->dma;
187 __entry->slot_id = (int) vdev->slot_id;
188 __entry->current_mel = (u16) vdev->current_mel;
190 TP_printk("vdev %p slot %d ctx %llx | %llx current_mel %d",
191 __entry->vdev, __entry->slot_id, __entry->in_ctx,
192 __entry->out_ctx, __entry->current_mel
196 DEFINE_EVENT(xhci_log_free_virt_dev, xhci_free_virt_device,
197 TP_PROTO(struct xhci_virt_device *vdev),
201 DECLARE_EVENT_CLASS(xhci_log_virt_dev,
202 TP_PROTO(struct xhci_virt_device *vdev),
205 __field(void *, vdev)
206 __field(unsigned long long, out_ctx)
207 __field(unsigned long long, in_ctx)
213 __field(int, slot_id)
216 __entry->vdev = vdev;
217 __entry->in_ctx = (unsigned long long) vdev->in_ctx->dma;
218 __entry->out_ctx = (unsigned long long) vdev->out_ctx->dma;
219 __entry->devnum = vdev->udev->devnum;
220 __entry->state = vdev->udev->state;
221 __entry->speed = vdev->udev->speed;
222 __entry->portnum = vdev->udev->portnum;
223 __entry->level = vdev->udev->level;
224 __entry->slot_id = vdev->udev->slot_id;
226 TP_printk("vdev %p ctx %llx | %llx num %d state %d speed %d port %d level %d slot %d",
227 __entry->vdev, __entry->in_ctx, __entry->out_ctx,
228 __entry->devnum, __entry->state, __entry->speed,
229 __entry->portnum, __entry->level, __entry->slot_id
233 DEFINE_EVENT(xhci_log_virt_dev, xhci_alloc_virt_device,
234 TP_PROTO(struct xhci_virt_device *vdev),
238 DEFINE_EVENT(xhci_log_virt_dev, xhci_setup_device,
239 TP_PROTO(struct xhci_virt_device *vdev),
243 DEFINE_EVENT(xhci_log_virt_dev, xhci_setup_addressable_virt_device,
244 TP_PROTO(struct xhci_virt_device *vdev),
248 DEFINE_EVENT(xhci_log_virt_dev, xhci_stop_device,
249 TP_PROTO(struct xhci_virt_device *vdev),
253 DECLARE_EVENT_CLASS(xhci_log_urb,
254 TP_PROTO(struct urb *urb),
257 __string(devname, dev_name(&urb->dev->dev))
259 __field(unsigned int, pipe)
260 __field(unsigned int, stream)
262 __field(unsigned int, flags)
263 __field(int, num_mapped_sgs)
264 __field(int, num_sgs)
270 __field(int, slot_id)
273 __assign_str(devname);
275 __entry->pipe = urb->pipe;
276 __entry->stream = urb->stream_id;
277 __entry->status = urb->status;
278 __entry->flags = urb->transfer_flags;
279 __entry->num_mapped_sgs = urb->num_mapped_sgs;
280 __entry->num_sgs = urb->num_sgs;
281 __entry->length = urb->transfer_buffer_length;
282 __entry->actual = urb->actual_length;
283 __entry->epnum = usb_endpoint_num(&urb->ep->desc);
284 __entry->dir_in = usb_endpoint_dir_in(&urb->ep->desc);
285 __entry->type = usb_endpoint_type(&urb->ep->desc);
286 __entry->slot_id = urb->dev->slot_id;
288 TP_printk("%s ep%d%s-%s: urb %p pipe %u slot %d length %d/%d sgs %d/%d stream %d flags %08x",
290 __entry->epnum, __entry->dir_in ? "in" : "out",
291 __print_symbolic(__entry->type,
292 { USB_ENDPOINT_XFER_INT, "intr" },
293 { USB_ENDPOINT_XFER_CONTROL, "control" },
294 { USB_ENDPOINT_XFER_BULK, "bulk" },
295 { USB_ENDPOINT_XFER_ISOC, "isoc" }),
296 __entry->urb, __entry->pipe, __entry->slot_id,
297 __entry->actual, __entry->length, __entry->num_mapped_sgs,
298 __entry->num_sgs, __entry->stream, __entry->flags
302 DEFINE_EVENT(xhci_log_urb, xhci_urb_enqueue,
303 TP_PROTO(struct urb *urb),
307 DEFINE_EVENT(xhci_log_urb, xhci_urb_giveback,
308 TP_PROTO(struct urb *urb),
312 DEFINE_EVENT(xhci_log_urb, xhci_urb_dequeue,
313 TP_PROTO(struct urb *urb),
317 DECLARE_EVENT_CLASS(xhci_log_stream_ctx,
318 TP_PROTO(struct xhci_stream_info *info, unsigned int stream_id),
319 TP_ARGS(info, stream_id),
321 __field(unsigned int, stream_id)
322 __field(u64, stream_ring)
323 __field(dma_addr_t, ctx_array_dma)
327 __entry->stream_id = stream_id;
328 __entry->stream_ring = le64_to_cpu(info->stream_ctx_array[stream_id].stream_ring);
329 __entry->ctx_array_dma = info->ctx_array_dma + stream_id * 16;
332 TP_printk("stream %u ctx @%pad: SCT %llu deq %llx", __entry->stream_id,
333 &__entry->ctx_array_dma, CTX_TO_SCT(__entry->stream_ring),
338 DEFINE_EVENT(xhci_log_stream_ctx, xhci_alloc_stream_info_ctx,
339 TP_PROTO(struct xhci_stream_info *info, unsigned int stream_id),
340 TP_ARGS(info, stream_id)
343 DEFINE_EVENT(xhci_log_stream_ctx, xhci_handle_cmd_set_deq_stream,
344 TP_PROTO(struct xhci_stream_info *info, unsigned int stream_id),
345 TP_ARGS(info, stream_id)
348 DECLARE_EVENT_CLASS(xhci_log_ep_ctx,
349 TP_PROTO(struct xhci_ep_ctx *ctx),
355 __field(u32, tx_info)
358 __entry->info = le32_to_cpu(ctx->ep_info);
359 __entry->info2 = le32_to_cpu(ctx->ep_info2);
360 __entry->deq = le64_to_cpu(ctx->deq);
361 __entry->tx_info = le32_to_cpu(ctx->tx_info);
363 TP_printk("%s", xhci_decode_ep_context(__get_buf(XHCI_MSG_MAX),
364 __entry->info, __entry->info2, __entry->deq, __entry->tx_info)
368 DEFINE_EVENT(xhci_log_ep_ctx, xhci_handle_cmd_stop_ep,
369 TP_PROTO(struct xhci_ep_ctx *ctx),
373 DEFINE_EVENT(xhci_log_ep_ctx, xhci_handle_cmd_set_deq_ep,
374 TP_PROTO(struct xhci_ep_ctx *ctx),
378 DEFINE_EVENT(xhci_log_ep_ctx, xhci_handle_cmd_reset_ep,
379 TP_PROTO(struct xhci_ep_ctx *ctx),
383 DEFINE_EVENT(xhci_log_ep_ctx, xhci_handle_cmd_config_ep,
384 TP_PROTO(struct xhci_ep_ctx *ctx),
388 DEFINE_EVENT(xhci_log_ep_ctx, xhci_add_endpoint,
389 TP_PROTO(struct xhci_ep_ctx *ctx),
393 DECLARE_EVENT_CLASS(xhci_log_slot_ctx,
394 TP_PROTO(struct xhci_slot_ctx *ctx),
399 __field(u32, tt_info)
403 __entry->info = le32_to_cpu(ctx->dev_info);
404 __entry->info2 = le32_to_cpu(ctx->dev_info2);
405 __entry->tt_info = le64_to_cpu(ctx->tt_info);
406 __entry->state = le32_to_cpu(ctx->dev_state);
408 TP_printk("%s", xhci_decode_slot_context(__get_buf(XHCI_MSG_MAX),
409 __entry->info, __entry->info2,
410 __entry->tt_info, __entry->state)
414 DEFINE_EVENT(xhci_log_slot_ctx, xhci_alloc_dev,
415 TP_PROTO(struct xhci_slot_ctx *ctx),
419 DEFINE_EVENT(xhci_log_slot_ctx, xhci_free_dev,
420 TP_PROTO(struct xhci_slot_ctx *ctx),
424 DEFINE_EVENT(xhci_log_slot_ctx, xhci_handle_cmd_disable_slot,
425 TP_PROTO(struct xhci_slot_ctx *ctx),
429 DEFINE_EVENT(xhci_log_slot_ctx, xhci_discover_or_reset_device,
430 TP_PROTO(struct xhci_slot_ctx *ctx),
434 DEFINE_EVENT(xhci_log_slot_ctx, xhci_setup_device_slot,
435 TP_PROTO(struct xhci_slot_ctx *ctx),
439 DEFINE_EVENT(xhci_log_slot_ctx, xhci_handle_cmd_addr_dev,
440 TP_PROTO(struct xhci_slot_ctx *ctx),
444 DEFINE_EVENT(xhci_log_slot_ctx, xhci_handle_cmd_reset_dev,
445 TP_PROTO(struct xhci_slot_ctx *ctx),
449 DEFINE_EVENT(xhci_log_slot_ctx, xhci_handle_cmd_set_deq,
450 TP_PROTO(struct xhci_slot_ctx *ctx),
454 DEFINE_EVENT(xhci_log_slot_ctx, xhci_configure_endpoint,
455 TP_PROTO(struct xhci_slot_ctx *ctx),
459 DECLARE_EVENT_CLASS(xhci_log_ctrl_ctx,
460 TP_PROTO(struct xhci_input_control_ctx *ctrl_ctx),
467 __entry->drop = le32_to_cpu(ctrl_ctx->drop_flags);
468 __entry->add = le32_to_cpu(ctrl_ctx->add_flags);
470 TP_printk("%s", xhci_decode_ctrl_ctx(__get_buf(XHCI_MSG_MAX), __entry->drop, __entry->add)
474 DEFINE_EVENT(xhci_log_ctrl_ctx, xhci_address_ctrl_ctx,
475 TP_PROTO(struct xhci_input_control_ctx *ctrl_ctx),
479 DEFINE_EVENT(xhci_log_ctrl_ctx, xhci_configure_endpoint_ctrl_ctx,
480 TP_PROTO(struct xhci_input_control_ctx *ctrl_ctx),
484 DECLARE_EVENT_CLASS(xhci_log_ring,
485 TP_PROTO(struct xhci_ring *ring),
489 __field(void *, ring)
490 __field(dma_addr_t, enq)
491 __field(dma_addr_t, deq)
492 __field(unsigned int, num_segs)
493 __field(unsigned int, stream_id)
494 __field(unsigned int, cycle_state)
495 __field(unsigned int, bounce_buf_len)
498 __entry->ring = ring;
499 __entry->type = ring->type;
500 __entry->num_segs = ring->num_segs;
501 __entry->stream_id = ring->stream_id;
502 __entry->cycle_state = ring->cycle_state;
503 __entry->bounce_buf_len = ring->bounce_buf_len;
504 __entry->enq = xhci_trb_virt_to_dma(ring->enq_seg, ring->enqueue);
505 __entry->deq = xhci_trb_virt_to_dma(ring->deq_seg, ring->dequeue);
507 TP_printk("%s %p: enq %pad deq %pad segs %d stream %d bounce %d cycle %d",
508 xhci_ring_type_string(__entry->type), __entry->ring,
513 __entry->bounce_buf_len,
518 DEFINE_EVENT(xhci_log_ring, xhci_ring_alloc,
519 TP_PROTO(struct xhci_ring *ring),
523 DEFINE_EVENT(xhci_log_ring, xhci_ring_free,
524 TP_PROTO(struct xhci_ring *ring),
528 DEFINE_EVENT(xhci_log_ring, xhci_ring_expansion,
529 TP_PROTO(struct xhci_ring *ring),
533 DEFINE_EVENT(xhci_log_ring, xhci_inc_enq,
534 TP_PROTO(struct xhci_ring *ring),
538 DEFINE_EVENT(xhci_log_ring, xhci_inc_deq,
539 TP_PROTO(struct xhci_ring *ring),
543 DECLARE_EVENT_CLASS(xhci_log_portsc,
544 TP_PROTO(struct xhci_port *port, u32 portsc),
545 TP_ARGS(port, portsc),
548 __field(u32, portnum)
552 __entry->busnum = port->rhub->hcd->self.busnum;
553 __entry->portnum = port->hcd_portnum;
554 __entry->portsc = portsc;
556 TP_printk("port %d-%d: %s",
559 xhci_decode_portsc(__get_buf(XHCI_MSG_MAX), __entry->portsc)
563 DEFINE_EVENT(xhci_log_portsc, xhci_handle_port_status,
564 TP_PROTO(struct xhci_port *port, u32 portsc),
565 TP_ARGS(port, portsc)
568 DEFINE_EVENT(xhci_log_portsc, xhci_get_port_status,
569 TP_PROTO(struct xhci_port *port, u32 portsc),
570 TP_ARGS(port, portsc)
573 DEFINE_EVENT(xhci_log_portsc, xhci_hub_status_data,
574 TP_PROTO(struct xhci_port *port, u32 portsc),
575 TP_ARGS(port, portsc)
578 DECLARE_EVENT_CLASS(xhci_log_doorbell,
579 TP_PROTO(u32 slot, u32 doorbell),
580 TP_ARGS(slot, doorbell),
583 __field(u32, doorbell)
586 __entry->slot = slot;
587 __entry->doorbell = doorbell;
589 TP_printk("Ring doorbell for %s",
590 xhci_decode_doorbell(__get_buf(XHCI_MSG_MAX), __entry->slot, __entry->doorbell)
594 DEFINE_EVENT(xhci_log_doorbell, xhci_ring_ep_doorbell,
595 TP_PROTO(u32 slot, u32 doorbell),
596 TP_ARGS(slot, doorbell)
599 DEFINE_EVENT(xhci_log_doorbell, xhci_ring_host_doorbell,
600 TP_PROTO(u32 slot, u32 doorbell),
601 TP_ARGS(slot, doorbell)
604 DECLARE_EVENT_CLASS(xhci_dbc_log_request,
605 TP_PROTO(struct dbc_request *req),
608 __field(struct dbc_request *, req)
610 __field(unsigned int, actual)
611 __field(unsigned int, length)
616 __entry->dir = req->direction;
617 __entry->actual = req->actual;
618 __entry->length = req->length;
619 __entry->status = req->status;
621 TP_printk("%s: req %p length %u/%u ==> %d",
622 __entry->dir ? "bulk-in" : "bulk-out",
623 __entry->req, __entry->actual,
624 __entry->length, __entry->status
628 DEFINE_EVENT(xhci_dbc_log_request, xhci_dbc_alloc_request,
629 TP_PROTO(struct dbc_request *req),
633 DEFINE_EVENT(xhci_dbc_log_request, xhci_dbc_free_request,
634 TP_PROTO(struct dbc_request *req),
638 DEFINE_EVENT(xhci_dbc_log_request, xhci_dbc_queue_request,
639 TP_PROTO(struct dbc_request *req),
643 DEFINE_EVENT(xhci_dbc_log_request, xhci_dbc_giveback_request,
644 TP_PROTO(struct dbc_request *req),
647 #endif /* __XHCI_TRACE_H */
649 /* this part must be outside header guard */
651 #undef TRACE_INCLUDE_PATH
652 #define TRACE_INCLUDE_PATH .
654 #undef TRACE_INCLUDE_FILE
655 #define TRACE_INCLUDE_FILE xhci-trace
657 #include <trace/define_trace.h>