Re: [PATCH v2 08/10] usb: cdnsp: Add tracepoints for CDNSP driver
From: Peter Chen
Date: Tue Nov 10 2020 - 22:30:08 EST
On 20-11-06 12:42:58, Pawel Laszczak wrote:
> Patch adds the series of tracepoints that can be used for
> debugging issues detected in driver.
>
> Signed-off-by: Pawel Laszczak <pawell@xxxxxxxxxxx>
Reviewed-by: Peter Chen <peter.chen@xxxxxxx>
> ---
> drivers/usb/cdns3/Makefile | 5 +
> drivers/usb/cdns3/cdnsp-debug.h | 583 +++++++++++++++++++++
> drivers/usb/cdns3/cdnsp-ep0.c | 22 +-
> drivers/usb/cdns3/cdnsp-gadget.c | 75 ++-
> drivers/usb/cdns3/cdnsp-mem.c | 18 +-
> drivers/usb/cdns3/cdnsp-ring.c | 75 ++-
> drivers/usb/cdns3/cdnsp-trace.c | 12 +
> drivers/usb/cdns3/cdnsp-trace.h | 840 +++++++++++++++++++++++++++++++
> 8 files changed, 1614 insertions(+), 16 deletions(-)
> create mode 100644 drivers/usb/cdns3/cdnsp-debug.h
> create mode 100644 drivers/usb/cdns3/cdnsp-trace.c
> create mode 100644 drivers/usb/cdns3/cdnsp-trace.h
>
> diff --git a/drivers/usb/cdns3/Makefile b/drivers/usb/cdns3/Makefile
> index a84b129f14b8..a4fdaabdbe18 100644
> --- a/drivers/usb/cdns3/Makefile
> +++ b/drivers/usb/cdns3/Makefile
> @@ -1,6 +1,7 @@
> # SPDX-License-Identifier: GPL-2.0
> # define_trace.h needs to know how to find our header
> CFLAGS_trace.o := -I$(src)
> +CFLAGS_cdnsp-trace.o := -I$(src)
>
> cdns-usb-common-y := core.o drd.o
> cdns3-y := cdns3-plat.o
> @@ -23,3 +24,7 @@ cdnsp-udc-pci-y := cdnsp-pci.o
> obj-$(CONFIG_USB_CDNSP_PCI) += cdnsp-udc-pci.o
> cdnsp-udc-pci-$(CONFIG_USB_CDNSP_GADGET) += cdnsp-ring.o cdnsp-gadget.o \
> cdnsp-mem.o cdnsp-ep0.o
> +
> +ifneq ($(CONFIG_USB_CDNSP_GADGET),)
> +cdnsp-udc-pci-$(CONFIG_TRACING) += cdnsp-trace.o
> +endif
> diff --git a/drivers/usb/cdns3/cdnsp-debug.h b/drivers/usb/cdns3/cdnsp-debug.h
> new file mode 100644
> index 000000000000..d6345d4d2911
> --- /dev/null
> +++ b/drivers/usb/cdns3/cdnsp-debug.h
> @@ -0,0 +1,583 @@
> +/* SPDX-License-Identifier: GPL-2.0 */
> +/*
> + * Cadence CDNSP DRD Driver.
> + *
> + * Copyright (C) 2020 Cadence.
> + *
> + * Author: Pawel Laszczak <pawell@xxxxxxxxxxx>
> + *
> + */
> +#ifndef __LINUX_CDNSP_DEBUG
> +#define __LINUX_CDNSP_DEBUG
> +
> +static inline const char *cdnsp_trb_comp_code_string(u8 status)
> +{
> + switch (status) {
> + case COMP_INVALID:
> + return "Invalid";
> + case COMP_SUCCESS:
> + return "Success";
> + case COMP_DATA_BUFFER_ERROR:
> + return "Data Buffer Error";
> + case COMP_BABBLE_DETECTED_ERROR:
> + return "Babble Detected";
> + case COMP_TRB_ERROR:
> + return "TRB Error";
> + case COMP_RESOURCE_ERROR:
> + return "Resource Error";
> + case COMP_NO_SLOTS_AVAILABLE_ERROR:
> + return "No Slots Available Error";
> + case COMP_INVALID_STREAM_TYPE_ERROR:
> + return "Invalid Stream Type Error";
> + case COMP_SLOT_NOT_ENABLED_ERROR:
> + return "Slot Not Enabled Error";
> + case COMP_ENDPOINT_NOT_ENABLED_ERROR:
> + return "Endpoint Not Enabled Error";
> + case COMP_SHORT_PACKET:
> + return "Short Packet";
> + case COMP_RING_UNDERRUN:
> + return "Ring Underrun";
> + case COMP_RING_OVERRUN:
> + return "Ring Overrun";
> + case COMP_VF_EVENT_RING_FULL_ERROR:
> + return "VF Event Ring Full Error";
> + case COMP_PARAMETER_ERROR:
> + return "Parameter Error";
> + case COMP_CONTEXT_STATE_ERROR:
> + return "Context State Error";
> + case COMP_EVENT_RING_FULL_ERROR:
> + return "Event Ring Full Error";
> + case COMP_INCOMPATIBLE_DEVICE_ERROR:
> + return "Incompatible Device Error";
> + case COMP_MISSED_SERVICE_ERROR:
> + return "Missed Service Error";
> + case COMP_COMMAND_RING_STOPPED:
> + return "Command Ring Stopped";
> + case COMP_COMMAND_ABORTED:
> + return "Command Aborted";
> + case COMP_STOPPED:
> + return "Stopped";
> + case COMP_STOPPED_LENGTH_INVALID:
> + return "Stopped - Length Invalid";
> + case COMP_STOPPED_SHORT_PACKET:
> + return "Stopped - Short Packet";
> + case COMP_MAX_EXIT_LATENCY_TOO_LARGE_ERROR:
> + return "Max Exit Latency Too Large Error";
> + case COMP_ISOCH_BUFFER_OVERRUN:
> + return "Isoch Buffer Overrun";
> + case COMP_EVENT_LOST_ERROR:
> + return "Event Lost Error";
> + case COMP_UNDEFINED_ERROR:
> + return "Undefined Error";
> + case COMP_INVALID_STREAM_ID_ERROR:
> + return "Invalid Stream ID Error";
> + default:
> + return "Unknown!!";
> + }
> +}
> +
> +static inline const char *cdnsp_trb_type_string(u8 type)
> +{
> + switch (type) {
> + case TRB_NORMAL:
> + return "Normal";
> + case TRB_SETUP:
> + return "Setup Stage";
> + case TRB_DATA:
> + return "Data Stage";
> + case TRB_STATUS:
> + return "Status Stage";
> + case TRB_ISOC:
> + return "Isoch";
> + case TRB_LINK:
> + return "Link";
> + case TRB_EVENT_DATA:
> + return "Event Data";
> + case TRB_TR_NOOP:
> + return "No-Op";
> + case TRB_ENABLE_SLOT:
> + return "Enable Slot Command";
> + case TRB_DISABLE_SLOT:
> + return "Disable Slot Command";
> + case TRB_ADDR_DEV:
> + return "Address Device Command";
> + case TRB_CONFIG_EP:
> + return "Configure Endpoint Command";
> + case TRB_EVAL_CONTEXT:
> + return "Evaluate Context Command";
> + case TRB_RESET_EP:
> + return "Reset Endpoint Command";
> + case TRB_STOP_RING:
> + return "Stop Ring Command";
> + case TRB_SET_DEQ:
> + return "Set TR Dequeue Pointer Command";
> + case TRB_RESET_DEV:
> + return "Reset Device Command";
> + case TRB_FORCE_HEADER:
> + return "Force Header Command";
> + case TRB_CMD_NOOP:
> + return "No-Op Command";
> + case TRB_TRANSFER:
> + return "Transfer Event";
> + case TRB_COMPLETION:
> + return "Command Completion Event";
> + case TRB_PORT_STATUS:
> + return "Port Status Change Event";
> + case TRB_HC_EVENT:
> + return "Device Controller Event";
> + case TRB_MFINDEX_WRAP:
> + return "MFINDEX Wrap Event";
> + case TRB_ENDPOINT_NRDY:
> + return "Endpoint Not ready";
> + case TRB_HALT_ENDPOINT:
> + return "Halt Endpoint";
> + case TRB_FLUSH_ENDPOINT:
> + return "FLush Endpoint";
> + default:
> + return "UNKNOWN";
> + }
> +}
> +
> +static inline const char *cdnsp_ring_type_string(enum cdnsp_ring_type type)
> +{
> + switch (type) {
> + case TYPE_CTRL:
> + return "CTRL";
> + case TYPE_ISOC:
> + return "ISOC";
> + case TYPE_BULK:
> + return "BULK";
> + case TYPE_INTR:
> + return "INTR";
> + case TYPE_STREAM:
> + return "STREAM";
> + case TYPE_COMMAND:
> + return "CMD";
> + case TYPE_EVENT:
> + return "EVENT";
> + }
> +
> + return "UNKNOWN";
> +}
> +
> +static inline char *cdnsp_slot_state_string(u32 state)
> +{
> + switch (state) {
> + case SLOT_STATE_ENABLED:
> + return "enabled/disabled";
> + case SLOT_STATE_DEFAULT:
> + return "default";
> + case SLOT_STATE_ADDRESSED:
> + return "addressed";
> + case SLOT_STATE_CONFIGURED:
> + return "configured";
> + default:
> + return "reserved";
> + }
> +}
> +
> +static inline const char *cdnsp_decode_trb(char *str, size_t size, u32 field0,
> + u32 field1, u32 field2, u32 field3)
> +{
> + int ep_id = TRB_TO_EP_INDEX(field3) - 1;
> + int type = TRB_FIELD_TO_TYPE(field3);
> + unsigned int ep_num;
> + int ret = 0;
> + u32 temp;
> +
> + ep_num = DIV_ROUND_UP(ep_id, 2);
> +
> + switch (type) {
> + case TRB_LINK:
> + ret += snprintf(str, size,
> + "LINK %08x%08x intr %ld type '%s' flags %c:%c:%c:%c",
> + field1, field0, GET_INTR_TARGET(field2),
> + cdnsp_trb_type_string(type),
> + field3 & TRB_IOC ? 'I' : 'i',
> + field3 & TRB_CHAIN ? 'C' : 'c',
> + field3 & TRB_TC ? 'T' : 't',
> + field3 & TRB_CYCLE ? 'C' : 'c');
> + break;
> + case TRB_TRANSFER:
> + case TRB_COMPLETION:
> + case TRB_PORT_STATUS:
> + case TRB_HC_EVENT:
> + ret += snprintf(str, size,
> + "ep%d%s(%d) type '%s' TRB %08x%08x status '%s'"
> + " len %ld slot %ld flags %c:%c",
> + ep_num, ep_id % 2 ? "out" : "in",
> + TRB_TO_EP_INDEX(field3),
> + cdnsp_trb_type_string(type), field1, field0,
> + cdnsp_trb_comp_code_string(GET_COMP_CODE(field2)),
> + EVENT_TRB_LEN(field2), TRB_TO_SLOT_ID(field3),
> + field3 & EVENT_DATA ? 'E' : 'e',
> + field3 & TRB_CYCLE ? 'C' : 'c');
> + break;
> + case TRB_MFINDEX_WRAP:
> + ret += snprintf(str, size, "%s: flags %c",
> + cdnsp_trb_type_string(type),
> + field3 & TRB_CYCLE ? 'C' : 'c');
> + break;
> + case TRB_SETUP:
> + ret += snprintf(str, size,
> + "type '%s' bRequestType %02x bRequest %02x "
> + "wValue %02x%02x wIndex %02x%02x wLength %d "
> + "length %ld TD size %ld intr %ld Setup ID %ld "
> + "flags %c:%c:%c",
> + cdnsp_trb_type_string(type),
> + field0 & 0xff,
> + (field0 & 0xff00) >> 8,
> + (field0 & 0xff000000) >> 24,
> + (field0 & 0xff0000) >> 16,
> + (field1 & 0xff00) >> 8,
> + field1 & 0xff,
> + (field1 & 0xff000000) >> 16 |
> + (field1 & 0xff0000) >> 16,
> + TRB_LEN(field2), GET_TD_SIZE(field2),
> + GET_INTR_TARGET(field2),
> + TRB_SETUPID_TO_TYPE(field3),
> + field3 & TRB_IDT ? 'D' : 'd',
> + field3 & TRB_IOC ? 'I' : 'i',
> + field3 & TRB_CYCLE ? 'C' : 'c');
> + break;
> + case TRB_DATA:
> + ret += snprintf(str, size,
> + "type '%s' Buffer %08x%08x length %ld TD size %ld "
> + "intr %ld flags %c:%c:%c:%c:%c:%c:%c",
> + cdnsp_trb_type_string(type),
> + field1, field0, TRB_LEN(field2),
> + GET_TD_SIZE(field2),
> + GET_INTR_TARGET(field2),
> + field3 & TRB_IDT ? 'D' : 'i',
> + field3 & TRB_IOC ? 'I' : 'i',
> + field3 & TRB_CHAIN ? 'C' : 'c',
> + field3 & TRB_NO_SNOOP ? 'S' : 's',
> + field3 & TRB_ISP ? 'I' : 'i',
> + field3 & TRB_ENT ? 'E' : 'e',
> + field3 & TRB_CYCLE ? 'C' : 'c');
> + break;
> + case TRB_STATUS:
> + ret += snprintf(str, size,
> + "Buffer %08x%08x length %ld TD size %ld intr"
> + "%ld type '%s' flags %c:%c:%c:%c",
> + field1, field0, TRB_LEN(field2),
> + GET_TD_SIZE(field2),
> + GET_INTR_TARGET(field2),
> + cdnsp_trb_type_string(type),
> + field3 & TRB_IOC ? 'I' : 'i',
> + field3 & TRB_CHAIN ? 'C' : 'c',
> + field3 & TRB_ENT ? 'E' : 'e',
> + field3 & TRB_CYCLE ? 'C' : 'c');
> + break;
> + case TRB_NORMAL:
> + case TRB_ISOC:
> + case TRB_EVENT_DATA:
> + case TRB_TR_NOOP:
> + ret += snprintf(str, size,
> + "type '%s' Buffer %08x%08x length %ld "
> + "TD size %ld intr %ld "
> + "flags %c:%c:%c:%c:%c:%c:%c:%c:%c",
> + cdnsp_trb_type_string(type),
> + field1, field0, TRB_LEN(field2),
> + GET_TD_SIZE(field2),
> + GET_INTR_TARGET(field2),
> + field3 & TRB_BEI ? 'B' : 'b',
> + field3 & TRB_IDT ? 'T' : 't',
> + field3 & TRB_IOC ? 'I' : 'i',
> + field3 & TRB_CHAIN ? 'C' : 'c',
> + field3 & TRB_NO_SNOOP ? 'S' : 's',
> + field3 & TRB_ISP ? 'I' : 'i',
> + field3 & TRB_ENT ? 'E' : 'e',
> + field3 & TRB_CYCLE ? 'C' : 'c',
> + !(field3 & TRB_EVENT_INVALIDATE) ? 'V' : 'v');
> + break;
> + case TRB_CMD_NOOP:
> + case TRB_ENABLE_SLOT:
> + ret += snprintf(str, size, "%s: flags %c",
> + cdnsp_trb_type_string(type),
> + field3 & TRB_CYCLE ? 'C' : 'c');
> + break;
> + case TRB_DISABLE_SLOT:
> + ret += snprintf(str, size, "%s: slot %ld flags %c",
> + cdnsp_trb_type_string(type),
> + TRB_TO_SLOT_ID(field3),
> + field3 & TRB_CYCLE ? 'C' : 'c');
> + break;
> + case TRB_ADDR_DEV:
> + ret += snprintf(str, size,
> + "%s: ctx %08x%08x slot %ld flags %c:%c",
> + cdnsp_trb_type_string(type), field1, field0,
> + TRB_TO_SLOT_ID(field3),
> + field3 & TRB_BSR ? 'B' : 'b',
> + field3 & TRB_CYCLE ? 'C' : 'c');
> + break;
> + case TRB_CONFIG_EP:
> + ret += snprintf(str, size,
> + "%s: ctx %08x%08x slot %ld flags %c:%c",
> + cdnsp_trb_type_string(type), field1, field0,
> + TRB_TO_SLOT_ID(field3),
> + field3 & TRB_DC ? 'D' : 'd',
> + field3 & TRB_CYCLE ? 'C' : 'c');
> + break;
> + case TRB_EVAL_CONTEXT:
> + ret += snprintf(str, size,
> + "%s: ctx %08x%08x slot %ld flags %c",
> + cdnsp_trb_type_string(type), field1, field0,
> + TRB_TO_SLOT_ID(field3),
> + field3 & TRB_CYCLE ? 'C' : 'c');
> + break;
> + case TRB_RESET_EP:
> + case TRB_HALT_ENDPOINT:
> + case TRB_FLUSH_ENDPOINT:
> + ret += snprintf(str, size,
> + "%s: ep%d%s(%d) ctx %08x%08x slot %ld flags %c",
> + cdnsp_trb_type_string(type),
> + ep_num, ep_id % 2 ? "out" : "in",
> + TRB_TO_EP_INDEX(field3), field1, field0,
> + TRB_TO_SLOT_ID(field3),
> + field3 & TRB_CYCLE ? 'C' : 'c');
> + break;
> + case TRB_STOP_RING:
> + ret += snprintf(str, size,
> + "%s: ep%d%s(%d) slot %ld sp %d flags %c",
> + cdnsp_trb_type_string(type),
> + ep_num, ep_id % 2 ? "out" : "in",
> + TRB_TO_EP_INDEX(field3),
> + TRB_TO_SLOT_ID(field3),
> + TRB_TO_SUSPEND_PORT(field3),
> + field3 & TRB_CYCLE ? 'C' : 'c');
> + break;
> + case TRB_SET_DEQ:
> + ret += snprintf(str, size,
> + "%s: ep%d%s(%d) deq %08x%08x stream %ld slot %ld flags %c",
> + cdnsp_trb_type_string(type),
> + ep_num, ep_id % 2 ? "out" : "in",
> + TRB_TO_EP_INDEX(field3), field1, field0,
> + TRB_TO_STREAM_ID(field2),
> + TRB_TO_SLOT_ID(field3),
> + field3 & TRB_CYCLE ? 'C' : 'c');
> + break;
> + case TRB_RESET_DEV:
> + ret += snprintf(str, size, "%s: slot %ld flags %c",
> + cdnsp_trb_type_string(type),
> + TRB_TO_SLOT_ID(field3),
> + field3 & TRB_CYCLE ? 'C' : 'c');
> + break;
> + case TRB_ENDPOINT_NRDY:
> + temp = TRB_TO_HOST_STREAM(field2);
> +
> + ret += snprintf(str, size,
> + "%s: ep%d%s(%d) H_SID %x%s%s D_SID %lx flags %c:%c",
> + cdnsp_trb_type_string(type),
> + ep_num, ep_id % 2 ? "out" : "in",
> + TRB_TO_EP_INDEX(field3), temp,
> + temp == STREAM_PRIME_ACK ? "(PRIME)" : "",
> + temp == STREAM_REJECTED ? "(REJECTED)" : "",
> + TRB_TO_DEV_STREAM(field0),
> + field3 & TRB_STAT ? 'S' : 's',
> + field3 & TRB_CYCLE ? 'C' : 'c');
> + break;
> + default:
> + ret += snprintf(str, size,
> + "type '%s' -> raw %08x %08x %08x %08x",
> + cdnsp_trb_type_string(type),
> + field0, field1, field2, field3);
> + }
> +
> + return str;
> +}
> +
> +static inline const char *cdnsp_decode_slot_context(u32 info, u32 info2,
> + u32 int_target, u32 state)
> +{
> + static char str[1024];
> + int ret = 0;
> + u32 speed;
> + char *s;
> +
> + speed = info & DEV_SPEED;
> +
> + switch (speed) {
> + case SLOT_SPEED_FS:
> + s = "full-speed";
> + break;
> + case SLOT_SPEED_HS:
> + s = "high-speed";
> + break;
> + case SLOT_SPEED_SS:
> + s = "super-speed";
> + break;
> + case SLOT_SPEED_SSP:
> + s = "super-speed plus";
> + break;
> + default:
> + s = "UNKNOWN speed";
> + }
> +
> + ret = sprintf(str, "%s Ctx Entries %ld",
> + s, (info & LAST_CTX_MASK) >> 27);
> +
> + ret += sprintf(str + ret, " [Intr %ld] Addr %ld State %s",
> + GET_INTR_TARGET(int_target), state & DEV_ADDR_MASK,
> + cdnsp_slot_state_string(GET_SLOT_STATE(state)));
> +
> + return str;
> +}
> +
> +static inline const char *cdnsp_portsc_link_state_string(u32 portsc)
> +{
> + switch (portsc & PORT_PLS_MASK) {
> + case XDEV_U0:
> + return "U0";
> + case XDEV_U1:
> + return "U1";
> + case XDEV_U2:
> + return "U2";
> + case XDEV_U3:
> + return "U3";
> + case XDEV_DISABLED:
> + return "Disabled";
> + case XDEV_RXDETECT:
> + return "RxDetect";
> + case XDEV_INACTIVE:
> + return "Inactive";
> + case XDEV_POLLING:
> + return "Polling";
> + case XDEV_RECOVERY:
> + return "Recovery";
> + case XDEV_HOT_RESET:
> + return "Hot Reset";
> + case XDEV_COMP_MODE:
> + return "Compliance mode";
> + case XDEV_TEST_MODE:
> + return "Test mode";
> + case XDEV_RESUME:
> + return "Resume";
> + default:
> + break;
> + }
> +
> + return "Unknown";
> +}
> +
> +static inline const char *cdnsp_decode_portsc(char *str, size_t size,
> + u32 portsc)
> +{
> + int ret;
> +
> + ret = snprintf(str, size, "%s %s %s Link:%s PortSpeed:%d ",
> + portsc & PORT_POWER ? "Powered" : "Powered-off",
> + portsc & PORT_CONNECT ? "Connected" : "Not-connected",
> + portsc & PORT_PED ? "Enabled" : "Disabled",
> + cdnsp_portsc_link_state_string(portsc),
> + DEV_PORT_SPEED(portsc));
> +
> + if (portsc & PORT_RESET)
> + ret += snprintf(str + ret, size - ret, "In-Reset ");
> +
> + ret += snprintf(str + ret, size - ret, "Change: ");
> + if (portsc & PORT_CSC)
> + ret += snprintf(str + ret, size - ret, "CSC ");
> + if (portsc & PORT_WRC)
> + ret += snprintf(str + ret, size - ret, "WRC ");
> + if (portsc & PORT_RC)
> + ret += snprintf(str + ret, size - ret, "PRC ");
> + if (portsc & PORT_PLC)
> + ret += snprintf(str + ret, size - ret, "PLC ");
> + if (portsc & PORT_CEC)
> + ret += snprintf(str + ret, size - ret, "CEC ");
> + ret += snprintf(str + ret, size - ret, "Wake: ");
> + if (portsc & PORT_WKCONN_E)
> + ret += snprintf(str + ret, size - ret, "WCE ");
> + if (portsc & PORT_WKDISC_E)
> + ret += snprintf(str + ret, size - ret, "WDE ");
> +
> + return str;
> +}
> +
> +static inline const char *cdnsp_ep_state_string(u8 state)
> +{
> + switch (state) {
> + case EP_STATE_DISABLED:
> + return "disabled";
> + case EP_STATE_RUNNING:
> + return "running";
> + case EP_STATE_HALTED:
> + return "halted";
> + case EP_STATE_STOPPED:
> + return "stopped";
> + case EP_STATE_ERROR:
> + return "error";
> + default:
> + return "INVALID";
> + }
> +}
> +
> +static inline const char *cdnsp_ep_type_string(u8 type)
> +{
> + switch (type) {
> + case ISOC_OUT_EP:
> + return "Isoc OUT";
> + case BULK_OUT_EP:
> + return "Bulk OUT";
> + case INT_OUT_EP:
> + return "Int OUT";
> + case CTRL_EP:
> + return "Ctrl";
> + case ISOC_IN_EP:
> + return "Isoc IN";
> + case BULK_IN_EP:
> + return "Bulk IN";
> + case INT_IN_EP:
> + return "Int IN";
> + default:
> + return "INVALID";
> + }
> +}
> +
> +static inline const char *cdnsp_decode_ep_context(char *str, size_t size,
> + u32 info, u32 info2,
> + u64 deq, u32 tx_info)
> +{
> + u8 max_pstr, ep_state, interval, ep_type, burst, cerr, mult;
> + bool lsa, hid;
> + u16 maxp, avg;
> + u32 esit;
> + int ret;
> +
> + esit = CTX_TO_MAX_ESIT_PAYLOAD_HI(info) << 16 |
> + CTX_TO_MAX_ESIT_PAYLOAD_LO(tx_info);
> +
> + ep_state = info & EP_STATE_MASK;
> + max_pstr = CTX_TO_EP_MAXPSTREAMS(info);
> + interval = CTX_TO_EP_INTERVAL(info);
> + mult = CTX_TO_EP_MULT(info) + 1;
> + lsa = !!(info & EP_HAS_LSA);
> +
> + cerr = (info2 & (3 << 1)) >> 1;
> + ep_type = CTX_TO_EP_TYPE(info2);
> + hid = !!(info2 & (1 << 7));
> + burst = CTX_TO_MAX_BURST(info2);
> + maxp = MAX_PACKET_DECODED(info2);
> +
> + avg = EP_AVG_TRB_LENGTH(tx_info);
> +
> + ret = snprintf(str, size, "State %s mult %d max P. Streams %d %s",
> + cdnsp_ep_state_string(ep_state), mult,
> + max_pstr, lsa ? "LSA " : "");
> +
> + ret += snprintf(str + ret, size - ret,
> + "interval %d us max ESIT payload %d CErr %d ",
> + (1 << interval) * 125, esit, cerr);
> +
> + ret += snprintf(str + ret, size - ret,
> + "Type %s %sburst %d maxp %d deq %016llx ",
> + cdnsp_ep_type_string(ep_type), hid ? "HID" : "",
> + burst, maxp, deq);
> +
> + ret += snprintf(str + ret, size - ret, "avg trb len %d", avg);
> +
> + return str;
> +}
> +
> +#endif /*__LINUX_CDNSP_DEBUG*/
> diff --git a/drivers/usb/cdns3/cdnsp-ep0.c b/drivers/usb/cdns3/cdnsp-ep0.c
> index 6235a7e4e5da..13771a7087ef 100644
> --- a/drivers/usb/cdns3/cdnsp-ep0.c
> +++ b/drivers/usb/cdns3/cdnsp-ep0.c
> @@ -13,6 +13,7 @@
> #include <linux/list.h>
>
> #include "cdnsp-gadget.h"
> +#include "cdnsp-trace.h"
>
> static void cdnsp_ep0_stall(struct cdnsp_device *pdev)
> {
> @@ -23,11 +24,13 @@ static void cdnsp_ep0_stall(struct cdnsp_device *pdev)
> preq = next_request(&pep->pending_list);
>
> if (pdev->three_stage_setup) {
> + trace_cdnsp_ep0_data_stage("send stall");
> cdnsp_halt_endpoint(pdev, pep, true);
>
> if (preq)
> cdnsp_gadget_giveback(pep, preq, -ECONNRESET);
> } else {
> + trace_cdnsp_ep0_status_stage("send stall");
> pep->ep_state |= EP0_HALTED_STATUS;
>
> if (preq)
> @@ -42,6 +45,8 @@ static int cdnsp_ep0_delegate_req(struct cdnsp_device *pdev,
> {
> int ret;
>
> + trace_cdnsp_ep0_request("delagete");
> +
> spin_unlock(&pdev->lock);
> ret = pdev->gadget_driver->setup(&pdev->gadget, ctrl);
> spin_lock(&pdev->lock);
> @@ -60,8 +65,10 @@ static int cdnsp_ep0_set_config(struct cdnsp_device *pdev,
>
> switch (state) {
> case USB_STATE_ADDRESS:
> + trace_cdnsp_ep0_set_config("from Address state");
> break;
> case USB_STATE_CONFIGURED:
> + trace_cdnsp_ep0_set_config("from Configured state");
> break;
> default:
> dev_err(pdev->dev, "Set Configuration - bad device state\n");
> @@ -123,6 +130,7 @@ static int cdnsp_ep0_set_address(struct cdnsp_device *pdev,
>
> int cdnsp_status_stage(struct cdnsp_device *pdev)
> {
> + trace_cdnsp_ep0_status_stage("preparing");
> pdev->ep0_stage = CDNSP_STATUS_STAGE;
> pdev->ep0_preq.request.length = 0;
>
> @@ -212,18 +220,21 @@ static int cdnsp_ep0_handle_feature_device(struct cdnsp_device *pdev,
> switch (le16_to_cpu(ctrl->wValue)) {
> case USB_DEVICE_REMOTE_WAKEUP:
> pdev->may_wakeup = !!set;
> + trace_cdnsp_may_wakeup(set);
> break;
> case USB_DEVICE_U1_ENABLE:
> if (state != USB_STATE_CONFIGURED || speed < USB_SPEED_SUPER)
> return -EINVAL;
>
> pdev->u1_allowed = !!set;
> + trace_cdnsp_u1(set);
> break;
> case USB_DEVICE_U2_ENABLE:
> if (state != USB_STATE_CONFIGURED || speed < USB_SPEED_SUPER)
> return -EINVAL;
>
> pdev->u2_allowed = !!set;
> + trace_cdnsp_u2(set);
> break;
> case USB_DEVICE_LTM_ENABLE:
> return -EINVAL;
> @@ -427,6 +438,8 @@ void cdnsp_setup_analyze(struct cdnsp_device *pdev)
> int ret = 0;
> __le16 len;
>
> + trace_cdnsp_ctrl_req(ctrl);
> +
> if (!pdev->gadget_driver)
> goto out;
>
> @@ -437,8 +450,10 @@ void cdnsp_setup_analyze(struct cdnsp_device *pdev)
> }
>
> /* Restore the ep0 to Stopped/Running state. */
> - if (pdev->eps[0].ep_state & EP_HALTED)
> + if (pdev->eps[0].ep_state & EP_HALTED) {
> + trace_cdnsp_ep0_halted("Restore to normal state");
> cdnsp_halt_endpoint(pdev, &pdev->eps[0], 0);
> + }
>
> /*
> * Finishing previous SETUP transfer by removing request from
> @@ -447,6 +462,7 @@ void cdnsp_setup_analyze(struct cdnsp_device *pdev)
> if (!list_empty(&pdev->eps[0].pending_list)) {
> struct cdnsp_request *req;
>
> + trace_cdnsp_ep0_request("Remove previous");
> req = next_request(&pdev->eps[0].pending_list);
> cdnsp_ep_dequeue(&pdev->eps[0], req);
> }
> @@ -468,8 +484,10 @@ void cdnsp_setup_analyze(struct cdnsp_device *pdev)
> if (!len)
> pdev->ep0_stage = CDNSP_STATUS_STAGE;
>
> - if (ret == USB_GADGET_DELAYED_STATUS)
> + if (ret == USB_GADGET_DELAYED_STATUS) {
> + trace_cdnsp_ep0_status_stage("delayed");
> return;
> + }
> out:
> if (ret < 0)
> cdnsp_ep0_stall(pdev);
> diff --git a/drivers/usb/cdns3/cdnsp-gadget.c b/drivers/usb/cdns3/cdnsp-gadget.c
> index 1366c3686331..10abad16c26d 100644
> --- a/drivers/usb/cdns3/cdnsp-gadget.c
> +++ b/drivers/usb/cdns3/cdnsp-gadget.c
> @@ -23,6 +23,7 @@
> #include "gadget-export.h"
> #include "drd.h"
> #include "cdnsp-gadget.h"
> +#include "cdnsp-trace.h"
>
> unsigned int cdnsp_port_speed(unsigned int port_status)
> {
> @@ -100,6 +101,7 @@ void cdnsp_set_link_state(struct cdnsp_device *pdev,
> __le32 __iomem *port_regs,
> u32 link_state)
> {
> + int port_num = 0xFF;
> u32 temp;
>
> temp = readl(port_regs);
> @@ -110,7 +112,12 @@ void cdnsp_set_link_state(struct cdnsp_device *pdev,
> temp &= ~PORT_PLS_MASK;
> temp |= PORT_LINK_STROBE | link_state;
>
> + if (pdev->active_port)
> + port_num = pdev->active_port->port_num;
> +
> + trace_cdnsp_handle_port_status(port_num, readl(port_regs));
> writel(temp, port_regs);
> + trace_cdnsp_link_state_changed(port_num, readl(port_regs));
> }
>
> static void cdnsp_disable_port(struct cdnsp_device *pdev,
> @@ -230,6 +237,8 @@ static int cdnsp_start(struct cdnsp_device *pdev)
> temp |= (CMD_R_S | CMD_DEVEN);
> writel(temp, &pdev->op_regs->command);
>
> + trace_cdnsp_init("Turn on controller");
> +
> pdev->cdnsp_state = 0;
>
> /*
> @@ -339,8 +348,10 @@ int cdnsp_ep_enqueue(struct cdnsp_ep *pep, struct cdnsp_request *preq)
> struct usb_request *request;
> int ret;
>
> - if (preq->epnum == 0 && !list_empty(&pep->pending_list))
> + if (preq->epnum == 0 && !list_empty(&pep->pending_list)) {
> + trace_cdnsp_request_enqueue_busy(preq);
> return -EBUSY;
> + }
>
> request = &preq->request;
> request->actual = 0;
> @@ -350,11 +361,15 @@ int cdnsp_ep_enqueue(struct cdnsp_ep *pep, struct cdnsp_request *preq)
> preq->td.drbl = 0;
>
> ret = usb_gadget_map_request_by_dev(pdev->dev, request, pep->direction);
> - if (ret)
> + if (ret) {
> + trace_cdnsp_request_enqueue_error(preq);
> return ret;
> + }
>
> list_add_tail(&preq->list, &pep->pending_list);
>
> + trace_cdnsp_request_enqueue(preq);
> +
> switch (usb_endpoint_type(pep->endpoint.desc)) {
> case USB_ENDPOINT_XFER_CONTROL:
> ret = cdnsp_queue_ctrl_tx(pdev, preq);
> @@ -376,6 +391,7 @@ int cdnsp_ep_enqueue(struct cdnsp_ep *pep, struct cdnsp_request *preq)
> usb_gadget_unmap_request_by_dev(pdev->dev, &preq->request,
> pep->direction);
> list_del(&preq->list);
> + trace_cdnsp_request_enqueue_error(preq);
>
> return ret;
> }
> @@ -410,6 +426,8 @@ int cdnsp_ep_dequeue(struct cdnsp_ep *pep, struct cdnsp_request *preq)
> struct cdnsp_device *pdev = pep->pdev;
> int ret;
>
> + trace_cdnsp_request_dequeue(preq);
> +
> if (GET_EP_CTX_STATE(pep->out_ctx) == EP_STATE_RUNNING) {
> ret = cdnsp_cmd_stop_ep(pdev, pep);
> if (ret)
> @@ -516,11 +534,14 @@ int cdnsp_wait_for_cmd_compl(struct cdnsp_device *pdev)
> cmd_trb = pdev->cmd.command_trb;
> pdev->cmd.status = 0;
>
> + trace_cdnsp_cmd_wait_for_compl(pdev->cmd_ring, &cmd_trb->generic);
> +
> ret = readl_poll_timeout_atomic(&pdev->op_regs->cmd_ring, val,
> !CMD_RING_BUSY(val), 1,
> CDNSP_CMD_TIMEOUT);
> if (ret) {
> dev_err(pdev->dev, "ERR: Timeout while waiting for command\n");
> + trace_cdnsp_cmd_timeout(pdev->cmd_ring, &cmd_trb->generic);
> pdev->cdnsp_state = CDNSP_STATE_DYING;
> return -ETIMEDOUT;
> }
> @@ -562,6 +583,8 @@ int cdnsp_wait_for_cmd_compl(struct cdnsp_device *pdev)
> continue;
> }
>
> + trace_cdnsp_handle_command(pdev->cmd_ring, &cmd_trb->generic);
> +
> pdev->cmd.status = GET_COMP_CODE(le32_to_cpu(event->event_cmd.status));
> if (pdev->cmd.status == COMP_SUCCESS)
> return 0;
> @@ -576,6 +599,8 @@ int cdnsp_halt_endpoint(struct cdnsp_device *pdev,
> {
> int ret;
>
> + trace_cdnsp_ep_halt(value ? "Set" : "Clear");
> +
> if (value) {
> ret = cdnsp_cmd_stop_ep(pdev, pep);
> if (ret)
> @@ -596,6 +621,8 @@ int cdnsp_halt_endpoint(struct cdnsp_device *pdev,
> cdnsp_queue_reset_ep(pdev, pep->idx);
> cdnsp_ring_cmd_db(pdev);
> ret = cdnsp_wait_for_cmd_compl(pdev);
> + trace_cdnsp_handle_cmd_reset_ep(pep->out_ctx);
> +
> if (ret)
> return ret;
>
> @@ -649,6 +676,9 @@ static int cdnsp_update_eps_configuration(struct cdnsp_device *pdev,
> (ep_sts != EP_STATE_DISABLED && ctrl_ctx->drop_flags))
> ret = cdnsp_configure_endpoint(pdev);
>
> + trace_cdnsp_configure_endpoint(cdnsp_get_slot_ctx(&pdev->out_ctx));
> + trace_cdnsp_handle_cmd_config_ep(pep->out_ctx);
> +
> cdnsp_zero_in_ctx(pdev);
>
> return ret;
> @@ -673,6 +703,7 @@ int cdnsp_reset_device(struct cdnsp_device *pdev)
> /* If device is not setup, there is no point in resetting it. */
> slot_ctx = cdnsp_get_slot_ctx(&pdev->out_ctx);
> slot_state = GET_SLOT_STATE(le32_to_cpu(slot_ctx->dev_state));
> + trace_cdnsp_reset_device(slot_ctx);
>
> if (slot_state <= SLOT_STATE_DEFAULT &&
> pdev->eps[0].ep_state & EP_HALTED) {
> @@ -700,6 +731,8 @@ int cdnsp_reset_device(struct cdnsp_device *pdev)
> for (i = 1; i < 31; ++i)
> pdev->eps[i].ep_state |= EP_STOPPED;
>
> + trace_cdnsp_handle_cmd_reset_dev(slot_ctx);
> +
> if (ret)
> dev_err(pdev->dev, "Reset device failed with error code %d",
> ret);
> @@ -756,6 +789,8 @@ int cdnsp_alloc_streams(struct cdnsp_device *pdev, struct cdnsp_ep *pep)
> /* The stream context array size must be a power of two */
> num_stream_ctxs = roundup_pow_of_two(num_streams);
>
> + trace_cdnsp_stream_number(pep, num_stream_ctxs, num_streams);
> +
> ret = cdnsp_alloc_stream_info(pdev, pep, num_stream_ctxs, num_streams);
> if (ret)
> return ret;
> @@ -781,6 +816,8 @@ int cdnsp_disable_slot(struct cdnsp_device *pdev)
> pdev->slot_id = 0;
> pdev->active_port = NULL;
>
> + trace_cdnsp_handle_cmd_disable_slot(cdnsp_get_slot_ctx(&pdev->out_ctx));
> +
> memset(pdev->in_ctx.bytes, 0, CDNSP_CTX_SIZE);
> memset(pdev->out_ctx.bytes, 0, CDNSP_CTX_SIZE);
>
> @@ -804,11 +841,14 @@ int cdnsp_enable_slot(struct cdnsp_device *pdev)
> cdnsp_ring_cmd_db(pdev);
> ret = cdnsp_wait_for_cmd_compl(pdev);
> if (ret)
> - return ret;
> + goto show_trace;
>
> pdev->slot_id = 1;
>
> - return 0;
> +show_trace:
> + trace_cdnsp_handle_cmd_enable_slot(cdnsp_get_slot_ctx(&pdev->out_ctx));
> +
> + return ret;
> }
>
> /*
> @@ -822,8 +862,10 @@ int cdnsp_setup_device(struct cdnsp_device *pdev, enum cdnsp_setup_dev setup)
> int dev_state = 0;
> int ret;
>
> - if (!pdev->slot_id)
> + if (!pdev->slot_id) {
> + trace_cdnsp_slot_id("incorrect");
> return -EINVAL;
> + }
>
> if (!pdev->active_port->port_num)
> return -EINVAL;
> @@ -831,8 +873,10 @@ int cdnsp_setup_device(struct cdnsp_device *pdev, enum cdnsp_setup_dev setup)
> slot_ctx = cdnsp_get_slot_ctx(&pdev->out_ctx);
> dev_state = GET_SLOT_STATE(le32_to_cpu(slot_ctx->dev_state));
>
> - if (setup == SETUP_CONTEXT_ONLY && dev_state == SLOT_STATE_DEFAULT)
> + if (setup == SETUP_CONTEXT_ONLY && dev_state == SLOT_STATE_DEFAULT) {
> + trace_cdnsp_slot_already_in_default(slot_ctx);
> return 0;
> + }
>
> slot_ctx = cdnsp_get_slot_ctx(&pdev->in_ctx);
> ctrl_ctx = cdnsp_get_input_control_ctx(&pdev->in_ctx);
> @@ -848,10 +892,14 @@ int cdnsp_setup_device(struct cdnsp_device *pdev, enum cdnsp_setup_dev setup)
> ctrl_ctx->add_flags = cpu_to_le32(SLOT_FLAG | EP0_FLAG);
> ctrl_ctx->drop_flags = 0;
>
> + trace_cdnsp_setup_device_slot(slot_ctx);
> +
> cdnsp_queue_address_device(pdev, pdev->in_ctx.dma, setup);
> cdnsp_ring_cmd_db(pdev);
> ret = cdnsp_wait_for_cmd_compl(pdev);
>
> + trace_cdnsp_handle_cmd_addr_dev(cdnsp_get_slot_ctx(&pdev->out_ctx));
> +
> /* Zero the input context control for later use. */
> ctrl_ctx->add_flags = 0;
> ctrl_ctx->drop_flags = 0;
> @@ -866,6 +914,8 @@ void cdnsp_set_usb2_hardware_lpm(struct cdnsp_device *pdev,
> if (pdev->active_port != &pdev->usb2_port || !pdev->gadget.lpm_capable)
> return;
>
> + trace_cdnsp_lpm(enable);
> +
> if (enable)
> writel(PORT_BESL(CDNSP_DEFAULT_BESL) | PORT_L1S_NYET | PORT_HLE,
> &pdev->active_port->regs->portpmsc);
> @@ -945,6 +995,7 @@ static int cdnsp_gadget_ep_enable(struct usb_ep *ep,
> pep->ep_state &= ~EP_STOPPED;
>
> unlock:
> + trace_cdnsp_ep_enable_end(pep, 0);
> spin_unlock_irqrestore(&pdev->lock, flags);
>
> return ret;
> @@ -1001,6 +1052,7 @@ static int cdnsp_gadget_ep_disable(struct usb_ep *ep)
> pep->ep_state |= EP_STOPPED;
>
> finish:
> + trace_cdnsp_ep_disable_end(pep, 0);
> spin_unlock_irqrestore(&pdev->lock, flags);
>
> return ret;
> @@ -1019,6 +1071,8 @@ static struct usb_request *cdnsp_gadget_ep_alloc_request(struct usb_ep *ep,
> preq->epnum = pep->number;
> preq->pep = pep;
>
> + trace_cdnsp_alloc_request(preq);
> +
> return &preq->request;
> }
>
> @@ -1027,6 +1081,7 @@ static void cdnsp_gadget_ep_free_request(struct usb_ep *ep,
> {
> struct cdnsp_request *preq = to_cdnsp_request(request);
>
> + trace_cdnsp_free_request(preq);
> kfree(preq);
> }
>
> @@ -1095,6 +1150,7 @@ static int cdnsp_gadget_ep_set_halt(struct usb_ep *ep, int value)
> preq = next_request(&pep->pending_list);
> if (value) {
> if (preq) {
> + trace_cdnsp_ep_busy_try_halt_again(pep, 0);
> ret = -EAGAIN;
> goto done;
> }
> @@ -1158,6 +1214,8 @@ void cdnsp_gadget_giveback(struct cdnsp_ep *pep,
> usb_gadget_unmap_request_by_dev(pdev->dev, &preq->request,
> preq->direction);
>
> + trace_cdnsp_request_giveback(preq);
> +
> if (preq != &pdev->ep0_preq) {
> spin_unlock(&pdev->lock);
> usb_gadget_giveback_request(&pep->endpoint, &preq->request);
> @@ -1238,6 +1296,7 @@ static int cdnsp_run(struct cdnsp_device *pdev,
> temp = readl(&pdev->ir_set->irq_pending);
> writel(IMAN_IE_SET(temp), &pdev->ir_set->irq_pending);
>
> + trace_cdnsp_init("Controller ready to work");
> return 0;
> err:
> cdnsp_halt(pdev);
> @@ -1390,6 +1449,8 @@ static void cdnsp_stop(struct cdnsp_device *pdev)
>
> cdnsp_consume_all_events(pdev);
> cdnsp_clear_cmd_ring(pdev);
> +
> + trace_cdnsp_exit("Controller stopped.");
> }
>
> /*
> @@ -1471,6 +1532,8 @@ static int cdnsp_gadget_pullup(struct usb_gadget *gadget, int is_on)
> struct cdnsp_device *pdev = gadget_to_cdnsp(gadget);
> struct cdns *cdns = dev_get_drvdata(pdev->dev);
>
> + trace_cdnsp_pullup(is_on);
> +
> if (!is_on) {
> cdnsp_reset_device(pdev);
> cdns_clear_vbus(cdns);
> diff --git a/drivers/usb/cdns3/cdnsp-mem.c b/drivers/usb/cdns3/cdnsp-mem.c
> index 3487367c1bb4..4b16ae7f775d 100644
> --- a/drivers/usb/cdns3/cdnsp-mem.c
> +++ b/drivers/usb/cdns3/cdnsp-mem.c
> @@ -16,6 +16,7 @@
> #include <linux/usb.h>
>
> #include "cdnsp-gadget.h"
> +#include "cdnsp-trace.h"
>
> static void cdnsp_free_stream_info(struct cdnsp_device *pdev,
> struct cdnsp_ep *pep);
> @@ -281,6 +282,8 @@ static void cdnsp_ring_free(struct cdnsp_device *pdev, struct cdnsp_ring *ring)
> if (!ring)
> return;
>
> + trace_cdnsp_ring_free(ring);
> +
> if (ring->first_seg) {
> if (ring->type == TYPE_STREAM)
> cdnsp_remove_stream_mapping(ring);
> @@ -397,7 +400,7 @@ static struct cdnsp_ring *cdnsp_ring_alloc(struct cdnsp_device *pdev,
> cpu_to_le32(LINK_TOGGLE);
>
> cdnsp_initialize_ring_info(ring);
> -
> + trace_cdnsp_ring_alloc(ring);
> return ring;
> fail:
> kfree(ring);
> @@ -450,6 +453,7 @@ int cdnsp_ring_expansion(struct cdnsp_device *pdev,
> }
>
> cdnsp_link_rings(pdev, ring, first, last, num_segs);
> + trace_cdnsp_ring_expansion(ring);
>
> return 0;
> }
> @@ -610,6 +614,8 @@ int cdnsp_alloc_stream_info(struct cdnsp_device *pdev,
> stream_info->stream_ctx_array[cur_stream].stream_ring =
> cpu_to_le64(addr);
>
> + trace_cdnsp_set_stream_ring(cur_ring);
> +
> ret = cdnsp_update_stream_mapping(cur_ring);
> if (ret)
> goto cleanup_rings;
> @@ -695,6 +701,7 @@ static int cdnsp_alloc_priv_device(struct cdnsp_device *pdev, gfp_t flags)
> pdev->dcbaa->dev_context_ptrs[1] = cpu_to_le64(pdev->out_ctx.dma);
> pdev->cmd.in_ctx = &pdev->in_ctx;
>
> + trace_cdnsp_alloc_priv_device(pdev);
> return 0;
> fail:
> dma_pool_free(pdev->device_pool, pdev->out_ctx.bytes,
> @@ -761,6 +768,8 @@ int cdnsp_setup_addressable_priv_dev(struct cdnsp_device *pdev)
> ep0_ctx->deq = cpu_to_le64(pdev->eps[0].ring->first_seg->dma |
> pdev->eps[0].ring->cycle_state);
>
> + trace_cdnsp_setup_addressable_priv_device(pdev);
> +
> return 0;
> }
>
> @@ -1112,7 +1121,7 @@ static void cdnsp_add_in_port(struct cdnsp_device *pdev,
> struct cdnsp_port *port,
> __le32 __iomem *addr)
> {
> - u32 temp, port_offset;
> + u32 temp, port_offset, port_count;
>
> temp = readl(addr);
> port->maj_rev = CDNSP_EXT_PORT_MAJOR(temp);
> @@ -1121,6 +1130,9 @@ static void cdnsp_add_in_port(struct cdnsp_device *pdev,
> /* Port offset and count in the third dword.*/
> temp = readl(addr + 2);
> port_offset = CDNSP_EXT_PORT_OFF(temp);
> + port_count = CDNSP_EXT_PORT_COUNT(temp);
> +
> + trace_cdnsp_port_info(addr, port_offset, port_count, port->maj_rev);
>
> port->port_num = port_offset;
> port->exist = 1;
> @@ -1171,6 +1183,8 @@ static int cdnsp_setup_port_arrays(struct cdnsp_device *pdev, gfp_t flags)
> return -ENODEV;
> }
>
> + trace_cdnsp_init("Found USB 2.0 ports and USB 3.0 ports.");
> +
> pdev->usb2_port.regs = (struct cdnsp_port_regs *)
> (&pdev->op_regs->port_reg_base + NUM_PORT_REGS *
> (pdev->usb2_port.port_num - 1));
> diff --git a/drivers/usb/cdns3/cdnsp-ring.c b/drivers/usb/cdns3/cdnsp-ring.c
> index a28faca41a8f..874d9ff5406c 100644
> --- a/drivers/usb/cdns3/cdnsp-ring.c
> +++ b/drivers/usb/cdns3/cdnsp-ring.c
> @@ -61,6 +61,7 @@
> #include <linux/slab.h>
> #include <linux/irq.h>
>
> +#include "cdnsp-trace.h"
> #include "cdnsp-gadget.h"
>
> /*
> @@ -148,7 +149,7 @@ void cdnsp_inc_deq(struct cdnsp_device *pdev, struct cdnsp_ring *ring)
> if (ring->type == TYPE_EVENT) {
> if (!cdnsp_last_trb_on_seg(ring->deq_seg, ring->dequeue)) {
> ring->dequeue++;
> - return;
> + goto out;
> }
>
> if (cdnsp_last_trb_on_ring(ring, ring->deq_seg, ring->dequeue))
> @@ -156,7 +157,7 @@ void cdnsp_inc_deq(struct cdnsp_device *pdev, struct cdnsp_ring *ring)
>
> ring->deq_seg = ring->deq_seg->next;
> ring->dequeue = ring->deq_seg->trbs;
> - return;
> + goto out;
> }
>
> /* All other rings have link trbs. */
> @@ -168,6 +169,8 @@ void cdnsp_inc_deq(struct cdnsp_device *pdev, struct cdnsp_ring *ring)
> ring->deq_seg = ring->deq_seg->next;
> ring->dequeue = ring->deq_seg->trbs;
> }
> +out:
> + trace_cdnsp_inc_deq(ring);
> }
>
> /*
> @@ -222,6 +225,8 @@ static void cdnsp_inc_enq(struct cdnsp_device *pdev,
> ring->enqueue = ring->enq_seg->trbs;
> next = ring->enqueue;
> }
> +
> + trace_cdnsp_inc_enq(ring);
> }
>
> /*
> @@ -261,6 +266,7 @@ static void cdnsp_force_l0_go(struct cdnsp_device *pdev)
> /* Ring the doorbell after placing a command on the ring. */
> void cdnsp_ring_cmd_db(struct cdnsp_device *pdev)
> {
> + trace_cdnsp_cmd_drbl("Ding Dong");
> writel(DB_VALUE_CMD, &pdev->dba->cmd_db);
> }
>
> @@ -299,6 +305,8 @@ static bool cdnsp_ring_ep_doorbell(struct cdnsp_device *pdev,
> else
> db_value = DB_VALUE(pep->idx, stream_id);
>
> + trace_cdnsp_tr_drbl(pep, stream_id);
> +
> writel(db_value, reg_addr);
>
> cdnsp_force_l0_go(pdev);
> @@ -484,6 +492,8 @@ static void cdnsp_find_new_dequeue_state(struct cdnsp_device *pdev,
>
> state->new_deq_seg = new_seg;
> state->new_deq_ptr = new_deq;
> +
> + trace_cdnsp_new_deq_state(state);
> }
>
> /*
> @@ -544,6 +554,10 @@ static struct cdnsp_segment *cdnsp_trb_in_td(struct cdnsp_device *pdev,
> /* If the end TRB isn't in this segment, this is set to 0 */
> end_trb_dma = cdnsp_trb_virt_to_dma(cur_seg, end_trb);
>
> + trace_cdnsp_looking_trb_in_td(suspect_dma, start_dma,
> + end_trb_dma, cur_seg->dma,
> + end_seg_dma);
> +
> if (end_trb_dma > 0) {
> /*
> * The end TRB is in this segment, so suspect should
> @@ -594,6 +608,9 @@ static void cdnsp_unmap_td_bounce_buffer(struct cdnsp_device *pdev,
>
> preq = td->preq;
>
> + trace_cdnsp_bounce_unmap(td->preq, seg->bounce_len, seg->bounce_offs,
> + seg->bounce_dma, 0);
> +
> if (!preq->direction) {
> dma_unmap_single(pdev->dev, seg->bounce_dma,
> ring->bounce_buf_len, DMA_TO_DEVICE);
> @@ -631,6 +648,9 @@ static int cdnsp_cmd_set_deq(struct cdnsp_device *pdev,
> cdnsp_ring_cmd_db(pdev);
> ret = cdnsp_wait_for_cmd_compl(pdev);
>
> + trace_cdnsp_handle_cmd_set_deq(cdnsp_get_slot_ctx(&pdev->out_ctx));
> + trace_cdnsp_handle_cmd_set_deq_ep(pep->out_ctx);
> +
> /*
> * Update the ring's dequeue segment and dequeue pointer
> * to reflect the new position.
> @@ -682,6 +702,9 @@ int cdnsp_remove_request(struct cdnsp_device *pdev,
>
> memset(&deq_state, 0, sizeof(deq_state));
>
> + trace_cdnsp_remove_request(pep->out_ctx);
> + trace_cdnsp_remove_request_td(preq);
> +
> cur_td = &preq->td;
> ep_ring = cdnsp_request_to_transfer_ring(pdev, preq);
>
> @@ -789,6 +812,8 @@ static void cdnsp_handle_port_status(struct cdnsp_device *pdev,
> writel(cdnsp_port_state_to_neutral(portsc) |
> (portsc & PORT_CHANGE_BITS), &port_regs->portsc);
>
> + trace_cdnsp_handle_port_status(pdev->active_port->port_num, portsc);
> +
> pdev->gadget.speed = cdnsp_port_speed(portsc);
> link_state = portsc & PORT_PLS_MASK;
>
> @@ -954,8 +979,10 @@ static int cdnsp_giveback_first_trb(struct cdnsp_device *pdev,
> start_trb->field[3] &= cpu_to_le32(~TRB_CYCLE);
>
> if ((pep->ep_state & EP_HAS_STREAMS) &&
> - !pep->stream_info.first_prime_det)
> + !pep->stream_info.first_prime_det) {
> + trace_cdnsp_wait_for_prime(pep, stream_id);
> return 0;
> + }
>
> return cdnsp_ring_ep_doorbell(pdev, pep, stream_id);
> }
> @@ -1226,8 +1253,10 @@ static int cdnsp_handle_tx_event(struct cdnsp_device *pdev,
> if (invalidate || !pdev->gadget.connected)
> goto cleanup;
>
> - if (GET_EP_CTX_STATE(pep->out_ctx) == EP_STATE_DISABLED)
> + if (GET_EP_CTX_STATE(pep->out_ctx) == EP_STATE_DISABLED) {
> + trace_cdnsp_ep_disabled(pep->out_ctx);
> goto err_out;
> + }
>
> /* Some transfer events don't always point to a trb*/
> if (!ep_ring) {
> @@ -1274,8 +1303,23 @@ static int cdnsp_handle_tx_event(struct cdnsp_device *pdev,
> * list.
> */
> if (list_empty(&ep_ring->td_list)) {
> - if (pep->skip)
> + /*
> + * Don't print warnings if it's due to a stopped
> + * endpoint generating an extra completion event, or
> + * a event for the last TRB of a short TD we already
> + * got a short event for.
> + * The short TD is already removed from the TD list.
> + */
> + if (!(trb_comp_code == COMP_STOPPED ||
> + trb_comp_code == COMP_STOPPED_LENGTH_INVALID ||
> + ep_ring->last_td_was_short))
> + trace_cdnsp_trb_without_td(ep_ring,
> + (struct cdnsp_generic_trb *)event);
> +
> + if (pep->skip) {
> pep->skip = false;
> + trace_cdnsp_ep_list_empty_with_skip(pep, 0);
> + }
>
> goto cleanup;
> }
> @@ -1332,6 +1376,9 @@ static int cdnsp_handle_tx_event(struct cdnsp_device *pdev,
> ep_trb = &ep_seg->trbs[(ep_trb_dma - ep_seg->dma)
> / sizeof(*ep_trb)];
>
> + trace_cdnsp_handle_transfer(ep_ring,
> + (struct cdnsp_generic_trb *)ep_trb);
> +
> if (cdnsp_trb_is_noop(ep_trb))
> goto cleanup;
>
> @@ -1397,6 +1444,8 @@ static bool cdnsp_handle_event(struct cdnsp_device *pdev)
> if (cycle_bit != pdev->event_ring->cycle_state)
> return false;
>
> + trace_cdnsp_handle_event(pdev->event_ring, &event->generic);
> +
> /*
> * Barrier between reading the TRB_CYCLE (valid) flag above and any
> * reads of the event's flags/data below.
> @@ -1544,6 +1593,7 @@ static void cdnsp_queue_trb(struct cdnsp_device *pdev, struct cdnsp_ring *ring,
> trb->field[2] = cpu_to_le32(field3);
> trb->field[3] = cpu_to_le32(field4);
>
> + trace_cdnsp_queue_trb(ring, trb);
> cdnsp_inc_enq(pdev, ring, more_trbs_coming);
> }
>
> @@ -1574,6 +1624,8 @@ static int cdnsp_prepare_ring(struct cdnsp_device *pdev,
> if (cdnsp_room_on_ring(pdev, ep_ring, num_trbs))
> break;
>
> + trace_cdnsp_no_room_on_ring("try ring expansion");
> +
> num_trbs_needed = num_trbs - ep_ring->num_trbs_free;
> if (cdnsp_ring_expansion(pdev, ep_ring, num_trbs_needed,
> mem_flags)) {
> @@ -1737,6 +1789,8 @@ static int cdnsp_align_td(struct cdnsp_device *pdev,
> /* Is the last nornal TRB alignable by splitting it. */
> if (*trb_buff_len > unalign) {
> *trb_buff_len -= unalign;
> + trace_cdnsp_bounce_align_td_split(preq, *trb_buff_len,
> + enqd_len, 0, unalign);
> return 0;
> }
>
> @@ -1773,6 +1827,9 @@ static int cdnsp_align_td(struct cdnsp_device *pdev,
> seg->bounce_len = new_buff_len;
> seg->bounce_offs = enqd_len;
>
> + trace_cdnsp_bounce_map(preq, new_buff_len, enqd_len, seg->bounce_dma,
> + unalign);
> +
> /*
> * Bounce buffer successful aligned and seg->bounce_dma will be used
> * in transfer TRB as new transfer buffer address.
> @@ -2009,13 +2066,17 @@ int cdnsp_cmd_stop_ep(struct cdnsp_device *pdev, struct cdnsp_ep *pep)
> u32 ep_state = GET_EP_CTX_STATE(pep->out_ctx);
> int ret = 0;
>
> - if (ep_state == EP_STATE_STOPPED || ep_state == EP_STATE_DISABLED)
> + if (ep_state == EP_STATE_STOPPED || ep_state == EP_STATE_DISABLED) {
> + trace_cdnsp_ep_stopped_or_disabled(pep->out_ctx);
> goto ep_stopped;
> + }
>
> cdnsp_queue_stop_endpoint(pdev, pep->idx);
> cdnsp_ring_cmd_db(pdev);
> ret = cdnsp_wait_for_cmd_compl(pdev);
>
> + trace_cdnsp_handle_cmd_stop_ep(pep->out_ctx);
> +
> ep_stopped:
> pep->ep_state |= EP_STOPPED;
> return ret;
> @@ -2029,6 +2090,8 @@ int cdnsp_cmd_flush_ep(struct cdnsp_device *pdev, struct cdnsp_ep *pep)
> cdnsp_ring_cmd_db(pdev);
> ret = cdnsp_wait_for_cmd_compl(pdev);
>
> + trace_cdnsp_handle_cmd_flush_ep(pep->out_ctx);
> +
> return ret;
> }
>
> diff --git a/drivers/usb/cdns3/cdnsp-trace.c b/drivers/usb/cdns3/cdnsp-trace.c
> new file mode 100644
> index 000000000000..e50ab799ad95
> --- /dev/null
> +++ b/drivers/usb/cdns3/cdnsp-trace.c
> @@ -0,0 +1,12 @@
> +// SPDX-License-Identifier: GPL-2.0
> +/*
> + * Cadence CDNSP DRD Driver.
> + *
> + * Copyright (C) 2020 Cadence.
> + *
> + * Author: Pawel Laszczak <pawell@xxxxxxxxxxx>
> + *
> + */
> +
> +#define CREATE_TRACE_POINTS
> +#include "cdnsp-trace.h"
> diff --git a/drivers/usb/cdns3/cdnsp-trace.h b/drivers/usb/cdns3/cdnsp-trace.h
> new file mode 100644
> index 000000000000..b68e282464d2
> --- /dev/null
> +++ b/drivers/usb/cdns3/cdnsp-trace.h
> @@ -0,0 +1,840 @@
> +/* SPDX-License-Identifier: GPL-2.0 */
> +/*
> + * Cadence CDNSP DRD Driver.
> + * Trace support header file
> + *
> + * Copyright (C) 2020 Cadence.
> + *
> + * Author: Pawel Laszczak <pawell@xxxxxxxxxxx>
> + *
> + */
> +
> +#undef TRACE_SYSTEM
> +#define TRACE_SYSTEM cdnsp-dev
> +
> +/*
> + * The TRACE_SYSTEM_VAR defaults to TRACE_SYSTEM, but must be a
> + * legitimate C variable. It is not exported to user space.
> + */
> +#undef TRACE_SYSTEM_VAR
> +#define TRACE_SYSTEM_VAR cdnsp_dev
> +
> +#if !defined(__CDNSP_DEV_TRACE_H) || defined(TRACE_HEADER_MULTI_READ)
> +#define __CDNSP_DEV_TRACE_H
> +
> +#include <linux/tracepoint.h>
> +#include "cdnsp-gadget.h"
> +#include "cdnsp-debug.h"
> +
> +/*
> + * There is limitation for single buffer size in TRACEPOINT subsystem.
> + * By default TRACE_BUF_SIZE is 1024, so no all data will be logged.
> + * To show more data this must be increased. In most cases the default
> + * value is sufficient.
> + */
> +#define CDNSP_MSG_MAX 500
> +
> +DECLARE_EVENT_CLASS(cdnsp_log_ep,
> + TP_PROTO(struct cdnsp_ep *pep, u32 stream_id),
> + TP_ARGS(pep, stream_id),
> + TP_STRUCT__entry(
> + __string(name, pep->name)
> + __field(unsigned int, state)
> + __field(u32, stream_id)
> + __field(u8, enabled)
> + __field(unsigned int, num_streams)
> + __field(int, td_count)
> + __field(u8, first_prime_det)
> + __field(u8, drbls_count)
> + ),
> + TP_fast_assign(
> + __assign_str(name, pep->name);
> + __entry->state = pep->ep_state;
> + __entry->stream_id = stream_id;
> + __entry->enabled = pep->ep_state & EP_HAS_STREAMS;
> + __entry->num_streams = pep->stream_info.num_streams;
> + __entry->td_count = pep->stream_info.td_count;
> + __entry->first_prime_det = pep->stream_info.first_prime_det;
> + __entry->drbls_count = pep->stream_info.drbls_count;
> + ),
> + TP_printk("%s: SID: %08x ep state: %x stream: enabled: %d num %d "
> + "tds %d, first prime: %d drbls %d",
> + __get_str(name), __entry->state, __entry->stream_id,
> + __entry->enabled, __entry->num_streams, __entry->td_count,
> + __entry->first_prime_det, __entry->drbls_count)
> +);
> +
> +DEFINE_EVENT(cdnsp_log_ep, cdnsp_tr_drbl,
> + TP_PROTO(struct cdnsp_ep *pep, u32 stream_id),
> + TP_ARGS(pep, stream_id)
> +);
> +
> +DEFINE_EVENT(cdnsp_log_ep, cdnsp_wait_for_prime,
> + TP_PROTO(struct cdnsp_ep *pep, u32 stream_id),
> + TP_ARGS(pep, stream_id)
> +);
> +
> +DEFINE_EVENT(cdnsp_log_ep, cdnsp_ep_list_empty_with_skip,
> + TP_PROTO(struct cdnsp_ep *pep, u32 stream_id),
> + TP_ARGS(pep, stream_id)
> +);
> +
> +DEFINE_EVENT(cdnsp_log_ep, cdnsp_ep_enable_end,
> + TP_PROTO(struct cdnsp_ep *pep, u32 stream_id),
> + TP_ARGS(pep, stream_id)
> +);
> +
> +DEFINE_EVENT(cdnsp_log_ep, cdnsp_ep_disable_end,
> + TP_PROTO(struct cdnsp_ep *pep, u32 stream_id),
> + TP_ARGS(pep, stream_id)
> +);
> +
> +DEFINE_EVENT(cdnsp_log_ep, cdnsp_ep_busy_try_halt_again,
> + TP_PROTO(struct cdnsp_ep *pep, u32 stream_id),
> + TP_ARGS(pep, stream_id)
> +);
> +
> +DECLARE_EVENT_CLASS(cdnsp_log_enable_disable,
> + TP_PROTO(int set),
> + TP_ARGS(set),
> + TP_STRUCT__entry(
> + __field(int, set)
> + ),
> + TP_fast_assign(
> + __entry->set = set;
> + ),
> + TP_printk("%s", __entry->set ? "enabled" : "disabled")
> +);
> +
> +DEFINE_EVENT(cdnsp_log_enable_disable, cdnsp_pullup,
> + TP_PROTO(int set),
> + TP_ARGS(set)
> +);
> +
> +DEFINE_EVENT(cdnsp_log_enable_disable, cdnsp_u1,
> + TP_PROTO(int set),
> + TP_ARGS(set)
> +);
> +
> +DEFINE_EVENT(cdnsp_log_enable_disable, cdnsp_u2,
> + TP_PROTO(int set),
> + TP_ARGS(set)
> +);
> +
> +DEFINE_EVENT(cdnsp_log_enable_disable, cdnsp_lpm,
> + TP_PROTO(int set),
> + TP_ARGS(set)
> +);
> +
> +DEFINE_EVENT(cdnsp_log_enable_disable, cdnsp_may_wakeup,
> + TP_PROTO(int set),
> + TP_ARGS(set)
> +);
> +
> +DECLARE_EVENT_CLASS(cdnsp_log_simple,
> + TP_PROTO(char *msg),
> + TP_ARGS(msg),
> + TP_STRUCT__entry(
> + __string(text, msg)
> + ),
> + TP_fast_assign(
> + __assign_str(text, msg)
> + ),
> + TP_printk("%s", __get_str(text))
> +);
> +
> +DEFINE_EVENT(cdnsp_log_simple, cdnsp_exit,
> + TP_PROTO(char *msg),
> + TP_ARGS(msg)
> +);
> +
> +DEFINE_EVENT(cdnsp_log_simple, cdnsp_init,
> + TP_PROTO(char *msg),
> + TP_ARGS(msg)
> +);
> +
> +DEFINE_EVENT(cdnsp_log_simple, cdnsp_slot_id,
> + TP_PROTO(char *msg),
> + TP_ARGS(msg)
> +);
> +
> +DEFINE_EVENT(cdnsp_log_simple, cdnsp_cmd_drbl,
> + TP_PROTO(char *msg),
> + TP_ARGS(msg)
> +);
> +
> +DEFINE_EVENT(cdnsp_log_simple, cdnsp_no_room_on_ring,
> + TP_PROTO(char *msg),
> + TP_ARGS(msg)
> +);
> +
> +DEFINE_EVENT(cdnsp_log_simple, cdnsp_ep0_status_stage,
> + TP_PROTO(char *msg),
> + TP_ARGS(msg)
> +);
> +
> +DEFINE_EVENT(cdnsp_log_simple, cdnsp_ep0_data_stage,
> + TP_PROTO(char *msg),
> + TP_ARGS(msg)
> +);
> +
> +DEFINE_EVENT(cdnsp_log_simple, cdnsp_ep0_request,
> + TP_PROTO(char *msg),
> + TP_ARGS(msg)
> +);
> +
> +DEFINE_EVENT(cdnsp_log_simple, cdnsp_ep0_set_config,
> + TP_PROTO(char *msg),
> + TP_ARGS(msg)
> +);
> +
> +DEFINE_EVENT(cdnsp_log_simple, cdnsp_ep0_halted,
> + TP_PROTO(char *msg),
> + TP_ARGS(msg)
> +);
> +
> +DEFINE_EVENT(cdnsp_log_simple, cdnsp_ep_halt,
> + TP_PROTO(char *msg),
> + TP_ARGS(msg)
> +);
> +
> +TRACE_EVENT(cdnsp_looking_trb_in_td,
> + TP_PROTO(dma_addr_t suspect, dma_addr_t trb_start, dma_addr_t trb_end,
> + dma_addr_t curr_seg, dma_addr_t end_seg),
> + TP_ARGS(suspect, trb_start, trb_end, curr_seg, end_seg),
> + TP_STRUCT__entry(
> + __field(dma_addr_t, suspect)
> + __field(dma_addr_t, trb_start)
> + __field(dma_addr_t, trb_end)
> + __field(dma_addr_t, curr_seg)
> + __field(dma_addr_t, end_seg)
> + ),
> + TP_fast_assign(
> + __entry->suspect = suspect;
> + __entry->trb_start = trb_start;
> + __entry->trb_end = trb_end;
> + __entry->curr_seg = curr_seg;
> + __entry->end_seg = end_seg;
> + ),
> + TP_printk("DMA: suspect event: %pad, trb-start: %pad, trb-end %pad, "
> + "seg-start %pad, seg-end %pad",
> + &__entry->suspect, &__entry->trb_start, &__entry->trb_end,
> + &__entry->curr_seg, &__entry->end_seg)
> +);
> +
> +TRACE_EVENT(cdnsp_port_info,
> + TP_PROTO(__le32 __iomem *addr, u32 offset, u32 count, u32 rev),
> + TP_ARGS(addr, offset, count, rev),
> + TP_STRUCT__entry(
> + __field(__le32 __iomem *, addr)
> + __field(u32, offset)
> + __field(u32, count)
> + __field(u32, rev)
> + ),
> + TP_fast_assign(
> + __entry->addr = addr;
> + __entry->offset = offset;
> + __entry->count = count;
> + __entry->rev = rev;
> + ),
> + TP_printk("Ext Cap %p, port offset = %u, count = %u, rev = 0x%x",
> + __entry->addr, __entry->offset, __entry->count, __entry->rev)
> +);
> +
> +DECLARE_EVENT_CLASS(cdnsp_log_deq_state,
> + TP_PROTO(struct cdnsp_dequeue_state *state),
> + TP_ARGS(state),
> + TP_STRUCT__entry(
> + __field(int, new_cycle_state)
> + __field(struct cdnsp_segment *, new_deq_seg)
> + __field(dma_addr_t, deq_seg_dma)
> + __field(union cdnsp_trb *, new_deq_ptr)
> + __field(dma_addr_t, deq_ptr_dma)
> + ),
> + TP_fast_assign(
> + __entry->new_cycle_state = state->new_cycle_state;
> + __entry->new_deq_seg = state->new_deq_seg;
> + __entry->deq_seg_dma = state->new_deq_seg->dma;
> + __entry->new_deq_ptr = state->new_deq_ptr,
> + __entry->deq_ptr_dma = cdnsp_trb_virt_to_dma(state->new_deq_seg,
> + state->new_deq_ptr);
> + ),
> + TP_printk("New cycle state = 0x%x, New dequeue segment = %p (0x%pad dma), "
> + "New dequeue pointer = %p (0x%pad dma)",
> + __entry->new_cycle_state, __entry->new_deq_seg,
> + &__entry->deq_seg_dma, __entry->new_deq_ptr,
> + &__entry->deq_ptr_dma
> + )
> +);
> +
> +DEFINE_EVENT(cdnsp_log_deq_state, cdnsp_new_deq_state,
> + TP_PROTO(struct cdnsp_dequeue_state *state),
> + TP_ARGS(state)
> +);
> +
> +DECLARE_EVENT_CLASS(cdnsp_log_ctrl,
> + TP_PROTO(struct usb_ctrlrequest *ctrl),
> + TP_ARGS(ctrl),
> + TP_STRUCT__entry(
> + __field(u8, bRequestType)
> + __field(u8, bRequest)
> + __field(u16, wValue)
> + __field(u16, wIndex)
> + __field(u16, wLength)
> + __dynamic_array(char, str, CDNSP_MSG_MAX)
> + ),
> + TP_fast_assign(
> + __entry->bRequestType = ctrl->bRequestType;
> + __entry->bRequest = ctrl->bRequest;
> + __entry->wValue = le16_to_cpu(ctrl->wValue);
> + __entry->wIndex = le16_to_cpu(ctrl->wIndex);
> + __entry->wLength = le16_to_cpu(ctrl->wLength);
> + ),
> + TP_printk("%s", usb_decode_ctrl(__get_str(str), CDNSP_MSG_MAX,
> + __entry->bRequestType,
> + __entry->bRequest, __entry->wValue,
> + __entry->wIndex, __entry->wLength)
> + )
> +);
> +
> +DEFINE_EVENT(cdnsp_log_ctrl, cdnsp_ctrl_req,
> + TP_PROTO(struct usb_ctrlrequest *ctrl),
> + TP_ARGS(ctrl)
> +);
> +
> +DECLARE_EVENT_CLASS(cdnsp_log_bounce,
> + TP_PROTO(struct cdnsp_request *preq, u32 new_buf_len, u32 offset,
> + dma_addr_t dma, unsigned int unalign),
> + TP_ARGS(preq, new_buf_len, offset, dma, unalign),
> + TP_STRUCT__entry(
> + __string(name, preq->pep->name)
> + __field(u32, new_buf_len)
> + __field(u32, offset)
> + __field(dma_addr_t, dma)
> + __field(unsigned int, unalign)
> + ),
> + TP_fast_assign(
> + __assign_str(name, preq->pep->name);
> + __entry->new_buf_len = new_buf_len;
> + __entry->offset = offset;
> + __entry->dma = dma;
> + __entry->unalign = unalign;
> + ),
> + TP_printk("%s buf len %d, offset %d, dma %pad, unalign %d",
> + __get_str(name), __entry->new_buf_len,
> + __entry->offset, &__entry->dma, __entry->unalign
> + )
> +);
> +
> +DEFINE_EVENT(cdnsp_log_bounce, cdnsp_bounce_align_td_split,
> + TP_PROTO(struct cdnsp_request *preq, u32 new_buf_len, u32 offset,
> + dma_addr_t dma, unsigned int unalign),
> + TP_ARGS(preq, new_buf_len, offset, dma, unalign)
> +);
> +
> +DEFINE_EVENT(cdnsp_log_bounce, cdnsp_bounce_map,
> + TP_PROTO(struct cdnsp_request *preq, u32 new_buf_len, u32 offset,
> + dma_addr_t dma, unsigned int unalign),
> + TP_ARGS(preq, new_buf_len, offset, dma, unalign)
> +);
> +
> +DEFINE_EVENT(cdnsp_log_bounce, cdnsp_bounce_unmap,
> + TP_PROTO(struct cdnsp_request *preq, u32 new_buf_len, u32 offset,
> + dma_addr_t dma, unsigned int unalign),
> + TP_ARGS(preq, new_buf_len, offset, dma, unalign)
> +);
> +
> +DECLARE_EVENT_CLASS(cdnsp_log_trb,
> + TP_PROTO(struct cdnsp_ring *ring, struct cdnsp_generic_trb *trb),
> + TP_ARGS(ring, trb),
> + TP_STRUCT__entry(
> + __field(u32, type)
> + __field(u32, field0)
> + __field(u32, field1)
> + __field(u32, field2)
> + __field(u32, field3)
> + __field(union cdnsp_trb *, trb)
> + __field(dma_addr_t, trb_dma)
> + __dynamic_array(char, str, CDNSP_MSG_MAX)
> + ),
> + TP_fast_assign(
> + __entry->type = ring->type;
> + __entry->field0 = le32_to_cpu(trb->field[0]);
> + __entry->field1 = le32_to_cpu(trb->field[1]);
> + __entry->field2 = le32_to_cpu(trb->field[2]);
> + __entry->field3 = le32_to_cpu(trb->field[3]);
> + __entry->trb = (union cdnsp_trb *)trb;
> + __entry->trb_dma = cdnsp_trb_virt_to_dma(ring->deq_seg,
> + (union cdnsp_trb *)trb);
> +
> + ),
> + TP_printk("%s: %s trb: %p(%pad)", cdnsp_ring_type_string(__entry->type),
> + cdnsp_decode_trb(__get_str(str), CDNSP_MSG_MAX,
> + __entry->field0, __entry->field1,
> + __entry->field2, __entry->field3),
> + __entry->trb, &__entry->trb_dma
> + )
> +);
> +
> +DEFINE_EVENT(cdnsp_log_trb, cdnsp_handle_event,
> + TP_PROTO(struct cdnsp_ring *ring, struct cdnsp_generic_trb *trb),
> + TP_ARGS(ring, trb)
> +);
> +
> +DEFINE_EVENT(cdnsp_log_trb, cdnsp_trb_without_td,
> + TP_PROTO(struct cdnsp_ring *ring, struct cdnsp_generic_trb *trb),
> + TP_ARGS(ring, trb)
> +);
> +
> +DEFINE_EVENT(cdnsp_log_trb, cdnsp_handle_command,
> + TP_PROTO(struct cdnsp_ring *ring, struct cdnsp_generic_trb *trb),
> + TP_ARGS(ring, trb)
> +);
> +
> +DEFINE_EVENT(cdnsp_log_trb, cdnsp_handle_transfer,
> + TP_PROTO(struct cdnsp_ring *ring, struct cdnsp_generic_trb *trb),
> + TP_ARGS(ring, trb)
> +);
> +
> +DEFINE_EVENT(cdnsp_log_trb, cdnsp_queue_trb,
> + TP_PROTO(struct cdnsp_ring *ring, struct cdnsp_generic_trb *trb),
> + TP_ARGS(ring, trb)
> +);
> +
> +DEFINE_EVENT(cdnsp_log_trb, cdnsp_cmd_wait_for_compl,
> + TP_PROTO(struct cdnsp_ring *ring, struct cdnsp_generic_trb *trb),
> + TP_ARGS(ring, trb)
> +);
> +
> +DEFINE_EVENT(cdnsp_log_trb, cdnsp_cmd_timeout,
> + TP_PROTO(struct cdnsp_ring *ring, struct cdnsp_generic_trb *trb),
> + TP_ARGS(ring, trb)
> +);
> +
> +DEFINE_EVENT(cdnsp_log_trb, cdnsp_defered_event,
> + TP_PROTO(struct cdnsp_ring *ring, struct cdnsp_generic_trb *trb),
> + TP_ARGS(ring, trb)
> +);
> +
> +DECLARE_EVENT_CLASS(cdnsp_log_pdev,
> + TP_PROTO(struct cdnsp_device *pdev),
> + TP_ARGS(pdev),
> + TP_STRUCT__entry(
> + __field(struct cdnsp_device *, pdev)
> + __field(struct usb_gadget *, gadget)
> + __field(dma_addr_t, out_ctx)
> + __field(dma_addr_t, in_ctx)
> + __field(u8, port_num)
> + ),
> + TP_fast_assign(
> + __entry->pdev = pdev;
> + __entry->gadget = &pdev->gadget;
> + __entry->in_ctx = pdev->in_ctx.dma;
> + __entry->out_ctx = pdev->out_ctx.dma;
> + __entry->port_num = pdev->active_port ?
> + pdev->active_port->port_num : 0xFF;
> + ),
> + TP_printk("pdev %p gadget %p ctx %pad | %pad, port %d ",
> + __entry->pdev, __entry->gadget, &__entry->in_ctx,
> + &__entry->out_ctx, __entry->port_num
> + )
> +);
> +
> +DEFINE_EVENT(cdnsp_log_pdev, cdnsp_alloc_priv_device,
> + TP_PROTO(struct cdnsp_device *vdev),
> + TP_ARGS(vdev)
> +);
> +
> +DEFINE_EVENT(cdnsp_log_pdev, cdnsp_free_priv_device,
> + TP_PROTO(struct cdnsp_device *vdev),
> + TP_ARGS(vdev)
> +);
> +
> +DEFINE_EVENT(cdnsp_log_pdev, cdnsp_setup_device,
> + TP_PROTO(struct cdnsp_device *vdev),
> + TP_ARGS(vdev)
> +);
> +
> +DEFINE_EVENT(cdnsp_log_pdev, cdnsp_setup_addressable_priv_device,
> + TP_PROTO(struct cdnsp_device *vdev),
> + TP_ARGS(vdev)
> +);
> +
> +DECLARE_EVENT_CLASS(cdnsp_log_request,
> + TP_PROTO(struct cdnsp_request *req),
> + TP_ARGS(req),
> + TP_STRUCT__entry(
> + __string(name, req->pep->name)
> + __field(struct usb_request *, request)
> + __field(struct cdnsp_request *, preq)
> + __field(void *, buf)
> + __field(unsigned int, actual)
> + __field(unsigned int, length)
> + __field(int, status)
> + __field(dma_addr_t, dma)
> + __field(unsigned int, stream_id)
> + __field(unsigned int, zero)
> + __field(unsigned int, short_not_ok)
> + __field(unsigned int, no_interrupt)
> + __field(struct scatterlist*, sg)
> + __field(unsigned int, num_sgs)
> + __field(unsigned int, num_mapped_sgs)
> +
> + ),
> + TP_fast_assign(
> + __assign_str(name, req->pep->name);
> + __entry->request = &req->request;
> + __entry->preq = req;
> + __entry->buf = req->request.buf;
> + __entry->actual = req->request.actual;
> + __entry->length = req->request.length;
> + __entry->status = req->request.status;
> + __entry->dma = req->request.dma;
> + __entry->stream_id = req->request.stream_id;
> + __entry->zero = req->request.zero;
> + __entry->short_not_ok = req->request.short_not_ok;
> + __entry->no_interrupt = req->request.no_interrupt;
> + __entry->sg = req->request.sg;
> + __entry->num_sgs = req->request.num_sgs;
> + __entry->num_mapped_sgs = req->request.num_mapped_sgs;
> + ),
> + TP_printk("%s; req U:%p/P:%p, req buf %p, length %u/%u, status %d, "
> + "buf dma (%pad), SID %u, %s%s%s, sg %p, num_sg %d,"
> + " num_m_sg %d",
> + __get_str(name), __entry->request, __entry->preq,
> + __entry->buf, __entry->actual, __entry->length,
> + __entry->status, &__entry->dma,
> + __entry->stream_id, __entry->zero ? "Z" : "z",
> + __entry->short_not_ok ? "S" : "s",
> + __entry->no_interrupt ? "I" : "i",
> + __entry->sg, __entry->num_sgs, __entry->num_mapped_sgs
> + )
> +);
> +
> +DEFINE_EVENT(cdnsp_log_request, cdnsp_request_enqueue,
> + TP_PROTO(struct cdnsp_request *req),
> + TP_ARGS(req)
> +);
> +
> +DEFINE_EVENT(cdnsp_log_request, cdnsp_request_enqueue_busy,
> + TP_PROTO(struct cdnsp_request *req),
> + TP_ARGS(req)
> +);
> +
> +DEFINE_EVENT(cdnsp_log_request, cdnsp_request_enqueue_error,
> + TP_PROTO(struct cdnsp_request *req),
> + TP_ARGS(req)
> +);
> +
> +DEFINE_EVENT(cdnsp_log_request, cdnsp_request_dequeue,
> + TP_PROTO(struct cdnsp_request *req),
> + TP_ARGS(req)
> +);
> +
> +DEFINE_EVENT(cdnsp_log_request, cdnsp_request_giveback,
> + TP_PROTO(struct cdnsp_request *req),
> + TP_ARGS(req)
> +);
> +
> +DEFINE_EVENT(cdnsp_log_request, cdnsp_alloc_request,
> + TP_PROTO(struct cdnsp_request *req),
> + TP_ARGS(req)
> +);
> +
> +DEFINE_EVENT(cdnsp_log_request, cdnsp_free_request,
> + TP_PROTO(struct cdnsp_request *req),
> + TP_ARGS(req)
> +);
> +
> +DECLARE_EVENT_CLASS(cdnsp_log_ep_ctx,
> + TP_PROTO(struct cdnsp_ep_ctx *ctx),
> + TP_ARGS(ctx),
> + TP_STRUCT__entry(
> + __field(u32, info)
> + __field(u32, info2)
> + __field(u64, deq)
> + __field(u32, tx_info)
> + __dynamic_array(char, str, CDNSP_MSG_MAX)
> + ),
> + TP_fast_assign(
> + __entry->info = le32_to_cpu(ctx->ep_info);
> + __entry->info2 = le32_to_cpu(ctx->ep_info2);
> + __entry->deq = le64_to_cpu(ctx->deq);
> + __entry->tx_info = le32_to_cpu(ctx->tx_info);
> + ),
> + TP_printk("%s", cdnsp_decode_ep_context(__get_str(str), CDNSP_MSG_MAX,
> + __entry->info, __entry->info2,
> + __entry->deq, __entry->tx_info)
> + )
> +);
> +
> +DEFINE_EVENT(cdnsp_log_ep_ctx, cdnsp_ep_disabled,
> + TP_PROTO(struct cdnsp_ep_ctx *ctx),
> + TP_ARGS(ctx)
> +);
> +
> +DEFINE_EVENT(cdnsp_log_ep_ctx, cdnsp_ep_stopped_or_disabled,
> + TP_PROTO(struct cdnsp_ep_ctx *ctx),
> + TP_ARGS(ctx)
> +);
> +
> +DEFINE_EVENT(cdnsp_log_ep_ctx, cdnsp_remove_request,
> + TP_PROTO(struct cdnsp_ep_ctx *ctx),
> + TP_ARGS(ctx)
> +);
> +
> +DEFINE_EVENT(cdnsp_log_ep_ctx, cdnsp_handle_cmd_stop_ep,
> + TP_PROTO(struct cdnsp_ep_ctx *ctx),
> + TP_ARGS(ctx)
> +);
> +
> +DEFINE_EVENT(cdnsp_log_ep_ctx, cdnsp_handle_cmd_flush_ep,
> + TP_PROTO(struct cdnsp_ep_ctx *ctx),
> + TP_ARGS(ctx)
> +);
> +
> +DEFINE_EVENT(cdnsp_log_ep_ctx, cdnsp_handle_cmd_set_deq_ep,
> + TP_PROTO(struct cdnsp_ep_ctx *ctx),
> + TP_ARGS(ctx)
> +);
> +
> +DEFINE_EVENT(cdnsp_log_ep_ctx, cdnsp_handle_cmd_reset_ep,
> + TP_PROTO(struct cdnsp_ep_ctx *ctx),
> + TP_ARGS(ctx)
> +);
> +
> +DEFINE_EVENT(cdnsp_log_ep_ctx, cdnsp_handle_cmd_config_ep,
> + TP_PROTO(struct cdnsp_ep_ctx *ctx),
> + TP_ARGS(ctx)
> +);
> +
> +DECLARE_EVENT_CLASS(cdnsp_log_slot_ctx,
> + TP_PROTO(struct cdnsp_slot_ctx *ctx),
> + TP_ARGS(ctx),
> + TP_STRUCT__entry(
> + __field(u32, info)
> + __field(u32, info2)
> + __field(u32, int_target)
> + __field(u32, state)
> + ),
> + TP_fast_assign(
> + __entry->info = le32_to_cpu(ctx->dev_info);
> + __entry->info2 = le32_to_cpu(ctx->dev_port);
> + __entry->int_target = le64_to_cpu(ctx->int_target);
> + __entry->state = le32_to_cpu(ctx->dev_state);
> + ),
> + TP_printk("%s", cdnsp_decode_slot_context(__entry->info,
> + __entry->info2,
> + __entry->int_target,
> + __entry->state)
> + )
> +);
> +
> +DEFINE_EVENT(cdnsp_log_slot_ctx, cdnsp_slot_already_in_default,
> + TP_PROTO(struct cdnsp_slot_ctx *ctx),
> + TP_ARGS(ctx)
> +);
> +
> +DEFINE_EVENT(cdnsp_log_slot_ctx, cdnsp_handle_cmd_enable_slot,
> + TP_PROTO(struct cdnsp_slot_ctx *ctx),
> + TP_ARGS(ctx)
> +);
> +
> +DEFINE_EVENT(cdnsp_log_slot_ctx, cdnsp_handle_cmd_disable_slot,
> + TP_PROTO(struct cdnsp_slot_ctx *ctx),
> + TP_ARGS(ctx)
> +);
> +
> +DEFINE_EVENT(cdnsp_log_slot_ctx, cdnsp_reset_device,
> + TP_PROTO(struct cdnsp_slot_ctx *ctx),
> + TP_ARGS(ctx)
> +);
> +
> +DEFINE_EVENT(cdnsp_log_slot_ctx, cdnsp_setup_device_slot,
> + TP_PROTO(struct cdnsp_slot_ctx *ctx),
> + TP_ARGS(ctx)
> +);
> +
> +DEFINE_EVENT(cdnsp_log_slot_ctx, cdnsp_handle_cmd_addr_dev,
> + TP_PROTO(struct cdnsp_slot_ctx *ctx),
> + TP_ARGS(ctx)
> +);
> +
> +DEFINE_EVENT(cdnsp_log_slot_ctx, cdnsp_handle_cmd_reset_dev,
> + TP_PROTO(struct cdnsp_slot_ctx *ctx),
> + TP_ARGS(ctx)
> +);
> +
> +DEFINE_EVENT(cdnsp_log_slot_ctx, cdnsp_handle_cmd_set_deq,
> + TP_PROTO(struct cdnsp_slot_ctx *ctx),
> + TP_ARGS(ctx)
> +);
> +
> +DEFINE_EVENT(cdnsp_log_slot_ctx, cdnsp_configure_endpoint,
> + TP_PROTO(struct cdnsp_slot_ctx *ctx),
> + TP_ARGS(ctx)
> +);
> +
> +DECLARE_EVENT_CLASS(cdnsp_log_td_info,
> + TP_PROTO(struct cdnsp_request *preq),
> + TP_ARGS(preq),
> + TP_STRUCT__entry(
> + __string(name, preq->pep->name)
> + __field(struct usb_request *, request)
> + __field(struct cdnsp_request *, preq)
> + __field(union cdnsp_trb *, first_trb)
> + __field(union cdnsp_trb *, last_trb)
> + __field(dma_addr_t, trb_dma)
> + ),
> + TP_fast_assign(
> + __assign_str(name, preq->pep->name);
> + __entry->request = &preq->request;
> + __entry->preq = preq;
> + __entry->first_trb = preq->td.first_trb;
> + __entry->last_trb = preq->td.last_trb;
> + __entry->trb_dma = cdnsp_trb_virt_to_dma(preq->td.start_seg,
> + preq->td.first_trb)
> + ),
> + TP_printk("%s req/preq: %p/%p, first trb %p[vir]/%pad(dma), last trb %p",
> + __get_str(name), __entry->request, __entry->preq,
> + __entry->first_trb, &__entry->trb_dma,
> + __entry->last_trb
> + )
> +);
> +
> +DEFINE_EVENT(cdnsp_log_td_info, cdnsp_remove_request_td,
> + TP_PROTO(struct cdnsp_request *preq),
> + TP_ARGS(preq)
> +);
> +
> +DECLARE_EVENT_CLASS(cdnsp_log_ring,
> + TP_PROTO(struct cdnsp_ring *ring),
> + TP_ARGS(ring),
> + TP_STRUCT__entry(
> + __field(u32, type)
> + __field(void *, ring)
> + __field(dma_addr_t, enq)
> + __field(dma_addr_t, deq)
> + __field(dma_addr_t, enq_seg)
> + __field(dma_addr_t, deq_seg)
> + __field(unsigned int, num_segs)
> + __field(unsigned int, stream_id)
> + __field(unsigned int, cycle_state)
> + __field(unsigned int, num_trbs_free)
> + __field(unsigned int, bounce_buf_len)
> + ),
> + TP_fast_assign(
> + __entry->ring = ring;
> + __entry->type = ring->type;
> + __entry->num_segs = ring->num_segs;
> + __entry->stream_id = ring->stream_id;
> + __entry->enq_seg = ring->enq_seg->dma;
> + __entry->deq_seg = ring->deq_seg->dma;
> + __entry->cycle_state = ring->cycle_state;
> + __entry->num_trbs_free = ring->num_trbs_free;
> + __entry->bounce_buf_len = ring->bounce_buf_len;
> + __entry->enq = cdnsp_trb_virt_to_dma(ring->enq_seg,
> + ring->enqueue);
> + __entry->deq = cdnsp_trb_virt_to_dma(ring->deq_seg,
> + ring->dequeue);
> + ),
> + TP_printk("%s %p: enq %pad(%pad) deq %pad(%pad) segs %d stream %d"
> + " free_trbs %d bounce %d cycle %d",
> + cdnsp_ring_type_string(__entry->type), __entry->ring,
> + &__entry->enq, &__entry->enq_seg,
> + &__entry->deq, &__entry->deq_seg,
> + __entry->num_segs,
> + __entry->stream_id,
> + __entry->num_trbs_free,
> + __entry->bounce_buf_len,
> + __entry->cycle_state
> + )
> +);
> +
> +DEFINE_EVENT(cdnsp_log_ring, cdnsp_ring_alloc,
> + TP_PROTO(struct cdnsp_ring *ring),
> + TP_ARGS(ring)
> +);
> +
> +DEFINE_EVENT(cdnsp_log_ring, cdnsp_ring_free,
> + TP_PROTO(struct cdnsp_ring *ring),
> + TP_ARGS(ring)
> +);
> +
> +DEFINE_EVENT(cdnsp_log_ring, cdnsp_set_stream_ring,
> + TP_PROTO(struct cdnsp_ring *ring),
> + TP_ARGS(ring)
> +);
> +
> +DEFINE_EVENT(cdnsp_log_ring, cdnsp_ring_expansion,
> + TP_PROTO(struct cdnsp_ring *ring),
> + TP_ARGS(ring)
> +);
> +
> +DEFINE_EVENT(cdnsp_log_ring, cdnsp_inc_enq,
> + TP_PROTO(struct cdnsp_ring *ring),
> + TP_ARGS(ring)
> +);
> +
> +DEFINE_EVENT(cdnsp_log_ring, cdnsp_inc_deq,
> + TP_PROTO(struct cdnsp_ring *ring),
> + TP_ARGS(ring)
> +);
> +
> +DECLARE_EVENT_CLASS(cdnsp_log_portsc,
> + TP_PROTO(u32 portnum, u32 portsc),
> + TP_ARGS(portnum, portsc),
> + TP_STRUCT__entry(
> + __field(u32, portnum)
> + __field(u32, portsc)
> + __dynamic_array(char, str, CDNSP_MSG_MAX)
> + ),
> + TP_fast_assign(
> + __entry->portnum = portnum;
> + __entry->portsc = portsc;
> + ),
> + TP_printk("port-%d: %s",
> + __entry->portnum,
> + cdnsp_decode_portsc(__get_str(str), CDNSP_MSG_MAX,
> + __entry->portsc)
> + )
> +);
> +
> +DEFINE_EVENT(cdnsp_log_portsc, cdnsp_handle_port_status,
> + TP_PROTO(u32 portnum, u32 portsc),
> + TP_ARGS(portnum, portsc)
> +);
> +
> +DEFINE_EVENT(cdnsp_log_portsc, cdnsp_link_state_changed,
> + TP_PROTO(u32 portnum, u32 portsc),
> + TP_ARGS(portnum, portsc)
> +);
> +
> +TRACE_EVENT(cdnsp_stream_number,
> + TP_PROTO(struct cdnsp_ep *pep, int num_stream_ctxs, int num_streams),
> + TP_ARGS(pep, num_stream_ctxs, num_streams),
> + TP_STRUCT__entry(
> + __string(name, pep->name)
> + __field(int, num_stream_ctxs)
> + __field(int, num_streams)
> + ),
> + TP_fast_assign(
> + __entry->num_stream_ctxs = num_stream_ctxs;
> + __entry->num_streams = num_streams;
> + ),
> + TP_printk("%s Need %u stream ctx entries for %u stream IDs.",
> + __get_str(name), __entry->num_stream_ctxs,
> + __entry->num_streams)
> +);
> +
> +#endif /* __CDNSP_TRACE_H */
> +
> +/* this part must be outside header guard */
> +
> +#undef TRACE_INCLUDE_PATH
> +#define TRACE_INCLUDE_PATH .
> +
> +#undef TRACE_INCLUDE_FILE
> +#define TRACE_INCLUDE_FILE cdnsp-trace
> +
> +#include <trace/define_trace.h>
> --
> 2.17.1
>
--
Thanks,
Peter Chen