1 // SPDX-License-Identifier: GPL-2.0
3 * xHCI host controller driver
5 * Copyright (C) 2013 Xenia Ragiadakou
7 * Author: Xenia Ragiadakou
8 * Email : burzalodowa@gmail.com
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 #define XHCI_MSG_MAX 500
30 DECLARE_EVENT_CLASS(xhci_log_msg,
31 TP_PROTO(struct va_format *vaf),
33 TP_STRUCT__entry(__dynamic_array(char, msg, XHCI_MSG_MAX)),
35 vsnprintf(__get_str(msg), XHCI_MSG_MAX, vaf->fmt, *vaf->va);
37 TP_printk("%s", __get_str(msg))
40 DEFINE_EVENT(xhci_log_msg, xhci_dbg_address,
41 TP_PROTO(struct va_format *vaf),
45 DEFINE_EVENT(xhci_log_msg, xhci_dbg_context_change,
46 TP_PROTO(struct va_format *vaf),
50 DEFINE_EVENT(xhci_log_msg, xhci_dbg_quirks,
51 TP_PROTO(struct va_format *vaf),
55 DEFINE_EVENT(xhci_log_msg, xhci_dbg_reset_ep,
56 TP_PROTO(struct va_format *vaf),
60 DEFINE_EVENT(xhci_log_msg, xhci_dbg_cancel_urb,
61 TP_PROTO(struct va_format *vaf),
65 DEFINE_EVENT(xhci_log_msg, xhci_dbg_init,
66 TP_PROTO(struct va_format *vaf),
70 DEFINE_EVENT(xhci_log_msg, xhci_dbg_ring_expansion,
71 TP_PROTO(struct va_format *vaf),
75 DECLARE_EVENT_CLASS(xhci_log_ctx,
76 TP_PROTO(struct xhci_hcd *xhci, struct xhci_container_ctx *ctx,
78 TP_ARGS(xhci, ctx, ep_num),
81 __field(unsigned, ctx_type)
82 __field(dma_addr_t, ctx_dma)
84 __field(unsigned, ctx_ep_num)
86 __dynamic_array(u32, ctx_data,
87 ((HCC_64BYTE_CONTEXT(xhci->hcc_params) + 1) * 8) *
88 ((ctx->type == XHCI_CTX_TYPE_INPUT) + ep_num + 1))
91 struct usb_device *udev;
93 udev = to_usb_device(xhci_to_hcd(xhci)->self.controller);
94 __entry->ctx_64 = HCC_64BYTE_CONTEXT(xhci->hcc_params);
95 __entry->ctx_type = ctx->type;
96 __entry->ctx_dma = ctx->dma;
97 __entry->ctx_va = ctx->bytes;
98 __entry->slot_id = udev->slot_id;
99 __entry->ctx_ep_num = ep_num;
100 memcpy(__get_dynamic_array(ctx_data), ctx->bytes,
101 ((HCC_64BYTE_CONTEXT(xhci->hcc_params) + 1) * 32) *
102 ((ctx->type == XHCI_CTX_TYPE_INPUT) + ep_num + 1));
104 TP_printk("ctx_64=%d, ctx_type=%u, ctx_dma=@%llx, ctx_va=@%p",
105 __entry->ctx_64, __entry->ctx_type,
106 (unsigned long long) __entry->ctx_dma, __entry->ctx_va
110 DEFINE_EVENT(xhci_log_ctx, xhci_address_ctx,
111 TP_PROTO(struct xhci_hcd *xhci, struct xhci_container_ctx *ctx,
112 unsigned int ep_num),
113 TP_ARGS(xhci, ctx, ep_num)
116 DECLARE_EVENT_CLASS(xhci_log_trb,
117 TP_PROTO(struct xhci_ring *ring, struct xhci_generic_trb *trb),
127 __entry->type = ring->type;
128 __entry->field0 = le32_to_cpu(trb->field[0]);
129 __entry->field1 = le32_to_cpu(trb->field[1]);
130 __entry->field2 = le32_to_cpu(trb->field[2]);
131 __entry->field3 = le32_to_cpu(trb->field[3]);
133 TP_printk("%s: %s", xhci_ring_type_string(__entry->type),
134 xhci_decode_trb(__entry->field0, __entry->field1,
135 __entry->field2, __entry->field3)
139 DEFINE_EVENT(xhci_log_trb, xhci_handle_event,
140 TP_PROTO(struct xhci_ring *ring, struct xhci_generic_trb *trb),
144 DEFINE_EVENT(xhci_log_trb, xhci_handle_command,
145 TP_PROTO(struct xhci_ring *ring, struct xhci_generic_trb *trb),
149 DEFINE_EVENT(xhci_log_trb, xhci_handle_transfer,
150 TP_PROTO(struct xhci_ring *ring, struct xhci_generic_trb *trb),
154 DEFINE_EVENT(xhci_log_trb, xhci_queue_trb,
155 TP_PROTO(struct xhci_ring *ring, struct xhci_generic_trb *trb),
159 DEFINE_EVENT(xhci_log_trb, xhci_dbc_handle_event,
160 TP_PROTO(struct xhci_ring *ring, struct xhci_generic_trb *trb),
164 DEFINE_EVENT(xhci_log_trb, xhci_dbc_handle_transfer,
165 TP_PROTO(struct xhci_ring *ring, struct xhci_generic_trb *trb),
169 DEFINE_EVENT(xhci_log_trb, xhci_dbc_gadget_ep_queue,
170 TP_PROTO(struct xhci_ring *ring, struct xhci_generic_trb *trb),
174 DECLARE_EVENT_CLASS(xhci_log_free_virt_dev,
175 TP_PROTO(struct xhci_virt_device *vdev),
178 __field(void *, vdev)
179 __field(unsigned long long, out_ctx)
180 __field(unsigned long long, in_ctx)
181 __field(u8, fake_port)
182 __field(u8, real_port)
183 __field(u16, current_mel)
187 __entry->vdev = vdev;
188 __entry->in_ctx = (unsigned long long) vdev->in_ctx->dma;
189 __entry->out_ctx = (unsigned long long) vdev->out_ctx->dma;
190 __entry->fake_port = (u8) vdev->fake_port;
191 __entry->real_port = (u8) vdev->real_port;
192 __entry->current_mel = (u16) vdev->current_mel;
194 TP_printk("vdev %p ctx %llx | %llx fake_port %d real_port %d current_mel %d",
195 __entry->vdev, __entry->in_ctx, __entry->out_ctx,
196 __entry->fake_port, __entry->real_port, __entry->current_mel
200 DEFINE_EVENT(xhci_log_free_virt_dev, xhci_free_virt_device,
201 TP_PROTO(struct xhci_virt_device *vdev),
205 DECLARE_EVENT_CLASS(xhci_log_virt_dev,
206 TP_PROTO(struct xhci_virt_device *vdev),
209 __field(void *, vdev)
210 __field(unsigned long long, out_ctx)
211 __field(unsigned long long, in_ctx)
217 __field(int, slot_id)
220 __entry->vdev = vdev;
221 __entry->in_ctx = (unsigned long long) vdev->in_ctx->dma;
222 __entry->out_ctx = (unsigned long long) vdev->out_ctx->dma;
223 __entry->devnum = vdev->udev->devnum;
224 __entry->state = vdev->udev->state;
225 __entry->speed = vdev->udev->speed;
226 __entry->portnum = vdev->udev->portnum;
227 __entry->level = vdev->udev->level;
228 __entry->slot_id = vdev->udev->slot_id;
230 TP_printk("vdev %p ctx %llx | %llx num %d state %d speed %d port %d level %d slot %d",
231 __entry->vdev, __entry->in_ctx, __entry->out_ctx,
232 __entry->devnum, __entry->state, __entry->speed,
233 __entry->portnum, __entry->level, __entry->slot_id
237 DEFINE_EVENT(xhci_log_virt_dev, xhci_alloc_virt_device,
238 TP_PROTO(struct xhci_virt_device *vdev),
242 DEFINE_EVENT(xhci_log_virt_dev, xhci_setup_device,
243 TP_PROTO(struct xhci_virt_device *vdev),
247 DEFINE_EVENT(xhci_log_virt_dev, xhci_setup_addressable_virt_device,
248 TP_PROTO(struct xhci_virt_device *vdev),
252 DEFINE_EVENT(xhci_log_virt_dev, xhci_stop_device,
253 TP_PROTO(struct xhci_virt_device *vdev),
257 DECLARE_EVENT_CLASS(xhci_log_urb,
258 TP_PROTO(struct urb *urb),
262 __field(unsigned int, pipe)
263 __field(unsigned int, stream)
265 __field(unsigned int, flags)
266 __field(int, num_mapped_sgs)
267 __field(int, num_sgs)
273 __field(int, slot_id)
277 __entry->pipe = urb->pipe;
278 __entry->stream = urb->stream_id;
279 __entry->status = urb->status;
280 __entry->flags = urb->transfer_flags;
281 __entry->num_mapped_sgs = urb->num_mapped_sgs;
282 __entry->num_sgs = urb->num_sgs;
283 __entry->length = urb->transfer_buffer_length;
284 __entry->actual = urb->actual_length;
285 __entry->epnum = usb_endpoint_num(&urb->ep->desc);
286 __entry->dir_in = usb_endpoint_dir_in(&urb->ep->desc);
287 __entry->type = usb_endpoint_type(&urb->ep->desc);
288 __entry->slot_id = urb->dev->slot_id;
290 TP_printk("ep%d%s-%s: urb %p pipe %u slot %d length %d/%d sgs %d/%d stream %d flags %08x",
291 __entry->epnum, __entry->dir_in ? "in" : "out",
293 switch (__entry->type) {
294 case USB_ENDPOINT_XFER_INT:
297 case USB_ENDPOINT_XFER_CONTROL:
300 case USB_ENDPOINT_XFER_BULK:
303 case USB_ENDPOINT_XFER_ISOC:
308 } s; }), __entry->urb, __entry->pipe, __entry->slot_id,
309 __entry->actual, __entry->length, __entry->num_mapped_sgs,
310 __entry->num_sgs, __entry->stream, __entry->flags
314 DEFINE_EVENT(xhci_log_urb, xhci_urb_enqueue,
315 TP_PROTO(struct urb *urb),
319 DEFINE_EVENT(xhci_log_urb, xhci_urb_giveback,
320 TP_PROTO(struct urb *urb),
324 DEFINE_EVENT(xhci_log_urb, xhci_urb_dequeue,
325 TP_PROTO(struct urb *urb),
329 DECLARE_EVENT_CLASS(xhci_log_ep_ctx,
330 TP_PROTO(struct xhci_ep_ctx *ctx),
336 __field(u32, tx_info)
339 __entry->info = le32_to_cpu(ctx->ep_info);
340 __entry->info2 = le32_to_cpu(ctx->ep_info2);
341 __entry->deq = le64_to_cpu(ctx->deq);
342 __entry->tx_info = le32_to_cpu(ctx->tx_info);
344 TP_printk("%s", xhci_decode_ep_context(__entry->info,
345 __entry->info2, __entry->deq, __entry->tx_info)
349 DEFINE_EVENT(xhci_log_ep_ctx, xhci_handle_cmd_stop_ep,
350 TP_PROTO(struct xhci_ep_ctx *ctx),
354 DEFINE_EVENT(xhci_log_ep_ctx, xhci_handle_cmd_set_deq_ep,
355 TP_PROTO(struct xhci_ep_ctx *ctx),
359 DEFINE_EVENT(xhci_log_ep_ctx, xhci_handle_cmd_reset_ep,
360 TP_PROTO(struct xhci_ep_ctx *ctx),
364 DEFINE_EVENT(xhci_log_ep_ctx, xhci_handle_cmd_config_ep,
365 TP_PROTO(struct xhci_ep_ctx *ctx),
369 DECLARE_EVENT_CLASS(xhci_log_slot_ctx,
370 TP_PROTO(struct xhci_slot_ctx *ctx),
375 __field(u32, tt_info)
379 __entry->info = le32_to_cpu(ctx->dev_info);
380 __entry->info2 = le32_to_cpu(ctx->dev_info2);
381 __entry->tt_info = le64_to_cpu(ctx->tt_info);
382 __entry->state = le32_to_cpu(ctx->dev_state);
384 TP_printk("%s", xhci_decode_slot_context(__entry->info,
385 __entry->info2, __entry->tt_info,
390 DEFINE_EVENT(xhci_log_slot_ctx, xhci_alloc_dev,
391 TP_PROTO(struct xhci_slot_ctx *ctx),
395 DEFINE_EVENT(xhci_log_slot_ctx, xhci_free_dev,
396 TP_PROTO(struct xhci_slot_ctx *ctx),
400 DEFINE_EVENT(xhci_log_slot_ctx, xhci_handle_cmd_disable_slot,
401 TP_PROTO(struct xhci_slot_ctx *ctx),
405 DEFINE_EVENT(xhci_log_slot_ctx, xhci_discover_or_reset_device,
406 TP_PROTO(struct xhci_slot_ctx *ctx),
410 DEFINE_EVENT(xhci_log_slot_ctx, xhci_setup_device_slot,
411 TP_PROTO(struct xhci_slot_ctx *ctx),
415 DEFINE_EVENT(xhci_log_slot_ctx, xhci_handle_cmd_addr_dev,
416 TP_PROTO(struct xhci_slot_ctx *ctx),
420 DEFINE_EVENT(xhci_log_slot_ctx, xhci_handle_cmd_reset_dev,
421 TP_PROTO(struct xhci_slot_ctx *ctx),
425 DEFINE_EVENT(xhci_log_slot_ctx, xhci_handle_cmd_set_deq,
426 TP_PROTO(struct xhci_slot_ctx *ctx),
430 DEFINE_EVENT(xhci_log_slot_ctx, xhci_configure_endpoint,
431 TP_PROTO(struct xhci_slot_ctx *ctx),
435 DECLARE_EVENT_CLASS(xhci_log_ring,
436 TP_PROTO(struct xhci_ring *ring),
440 __field(void *, ring)
441 __field(dma_addr_t, enq)
442 __field(dma_addr_t, deq)
443 __field(dma_addr_t, enq_seg)
444 __field(dma_addr_t, deq_seg)
445 __field(unsigned int, num_segs)
446 __field(unsigned int, stream_id)
447 __field(unsigned int, cycle_state)
448 __field(unsigned int, num_trbs_free)
449 __field(unsigned int, bounce_buf_len)
452 __entry->ring = ring;
453 __entry->type = ring->type;
454 __entry->num_segs = ring->num_segs;
455 __entry->stream_id = ring->stream_id;
456 __entry->enq_seg = ring->enq_seg->dma;
457 __entry->deq_seg = ring->deq_seg->dma;
458 __entry->cycle_state = ring->cycle_state;
459 __entry->num_trbs_free = ring->num_trbs_free;
460 __entry->bounce_buf_len = ring->bounce_buf_len;
461 __entry->enq = xhci_trb_virt_to_dma(ring->enq_seg, ring->enqueue);
462 __entry->deq = xhci_trb_virt_to_dma(ring->deq_seg, ring->dequeue);
464 TP_printk("%s %p: enq %pad(%pad) deq %pad(%pad) segs %d stream %d free_trbs %d bounce %d cycle %d",
465 xhci_ring_type_string(__entry->type), __entry->ring,
466 &__entry->enq, &__entry->enq_seg,
467 &__entry->deq, &__entry->deq_seg,
470 __entry->num_trbs_free,
471 __entry->bounce_buf_len,
476 DEFINE_EVENT(xhci_log_ring, xhci_ring_alloc,
477 TP_PROTO(struct xhci_ring *ring),
481 DEFINE_EVENT(xhci_log_ring, xhci_ring_free,
482 TP_PROTO(struct xhci_ring *ring),
486 DEFINE_EVENT(xhci_log_ring, xhci_ring_expansion,
487 TP_PROTO(struct xhci_ring *ring),
491 DEFINE_EVENT(xhci_log_ring, xhci_inc_enq,
492 TP_PROTO(struct xhci_ring *ring),
496 DEFINE_EVENT(xhci_log_ring, xhci_inc_deq,
497 TP_PROTO(struct xhci_ring *ring),
501 DECLARE_EVENT_CLASS(xhci_log_portsc,
502 TP_PROTO(u32 portnum, u32 portsc),
503 TP_ARGS(portnum, portsc),
505 __field(u32, portnum)
509 __entry->portnum = portnum;
510 __entry->portsc = portsc;
512 TP_printk("port-%d: %s",
514 xhci_decode_portsc(__entry->portsc)
518 DEFINE_EVENT(xhci_log_portsc, xhci_handle_port_status,
519 TP_PROTO(u32 portnum, u32 portsc),
520 TP_ARGS(portnum, portsc)
523 DEFINE_EVENT(xhci_log_portsc, xhci_get_port_status,
524 TP_PROTO(u32 portnum, u32 portsc),
525 TP_ARGS(portnum, portsc)
528 DEFINE_EVENT(xhci_log_portsc, xhci_hub_status_data,
529 TP_PROTO(u32 portnum, u32 portsc),
530 TP_ARGS(portnum, portsc)
533 DECLARE_EVENT_CLASS(xhci_dbc_log_request,
534 TP_PROTO(struct dbc_request *req),
537 __field(struct dbc_request *, req)
539 __field(unsigned int, actual)
540 __field(unsigned int, length)
545 __entry->dir = req->direction;
546 __entry->actual = req->actual;
547 __entry->length = req->length;
548 __entry->status = req->status;
550 TP_printk("%s: req %p length %u/%u ==> %d",
551 __entry->dir ? "bulk-in" : "bulk-out",
552 __entry->req, __entry->actual,
553 __entry->length, __entry->status
557 DEFINE_EVENT(xhci_dbc_log_request, xhci_dbc_alloc_request,
558 TP_PROTO(struct dbc_request *req),
562 DEFINE_EVENT(xhci_dbc_log_request, xhci_dbc_free_request,
563 TP_PROTO(struct dbc_request *req),
567 DEFINE_EVENT(xhci_dbc_log_request, xhci_dbc_queue_request,
568 TP_PROTO(struct dbc_request *req),
572 DEFINE_EVENT(xhci_dbc_log_request, xhci_dbc_giveback_request,
573 TP_PROTO(struct dbc_request *req),
576 #endif /* __XHCI_TRACE_H */
578 /* this part must be outside header guard */
580 #undef TRACE_INCLUDE_PATH
581 #define TRACE_INCLUDE_PATH .
583 #undef TRACE_INCLUDE_FILE
584 #define TRACE_INCLUDE_FILE xhci-trace
586 #include <trace/define_trace.h>