linux-trace-kernel.vger.kernel.org archive mirror
 help / color / mirror / Atom feed
From: Linyu Yuan <quic_linyyuan@quicinc.com>
To: Steven Rostedt <rostedt@goodmis.org>
Cc: Thinh Nguyen <Thinh.Nguyen@synopsys.com>,
	Chunfeng Yun <chunfeng.yun@mediatek.com>, Bin Liu <b-liu@ti.com>,
	Peter Chen <peter.chen@kernel.org>,
	Pawel Laszczak <pawell@cadence.com>,
	Roger Quadros <rogerq@kernel.org>,
	Alan Stern <stern@rowland.harvard.edu>,
	Masami Hiramatsu <mhiramat@kernel.org>,
	Greg Kroah-Hartman <gregkh@linuxfoundation.org>,
	<linux-usb@vger.kernel.org>, <linux-trace-kernel@vger.kernel.org>
Subject: Re: [PATCH 3/8] usb: udc: trace: reduce buffer usage of trace event
Date: Fri, 15 Sep 2023 09:11:06 +0800	[thread overview]
Message-ID: <dc54b48f-f2ad-9948-f50f-a6f2c004c77c@quicinc.com> (raw)
In-Reply-To: <20230914125410.432ca343@gandalf.local.home>


On 9/15/2023 12:54 AM, Steven Rostedt wrote:
> On Thu, 14 Sep 2023 18:02:57 +0800
> Linyu Yuan <quic_linyyuan@quicinc.com> wrote:
>
>> Save u32 members into trace event ring buffer and parse it for possible
>> bit fields.
>>
>> Use new DECLARE_EVENT_CLASS_PRINT_INIT() class macro for output stage.
>>
>> Signed-off-by: Linyu Yuan <quic_linyyuan@quicinc.com>
>> ---
>>   drivers/usb/gadget/udc/trace.h | 154 +++++++++++++++------------------
>>   1 file changed, 69 insertions(+), 85 deletions(-)
>>
>> diff --git a/drivers/usb/gadget/udc/trace.h b/drivers/usb/gadget/udc/trace.h
>> index a5ed26fbc2da..e1754667f1d2 100644
>> --- a/drivers/usb/gadget/udc/trace.h
>> +++ b/drivers/usb/gadget/udc/trace.h
>> @@ -17,7 +17,7 @@
>>   #include <asm/byteorder.h>
>>   #include <linux/usb/gadget.h>
>>   
>> -DECLARE_EVENT_CLASS(udc_log_gadget,
>> +DECLARE_EVENT_CLASS_PRINT_INIT(udc_log_gadget,
>>   	TP_PROTO(struct usb_gadget *g, int ret),
>>   	TP_ARGS(g, ret),
>>   	TP_STRUCT__entry(
>> @@ -25,20 +25,7 @@ DECLARE_EVENT_CLASS(udc_log_gadget,
>>   		__field(enum usb_device_speed, max_speed)
>>   		__field(enum usb_device_state, state)
>>   		__field(unsigned, mA)
>> -		__field(unsigned, sg_supported)
>> -		__field(unsigned, is_otg)
>> -		__field(unsigned, is_a_peripheral)
>> -		__field(unsigned, b_hnp_enable)
>> -		__field(unsigned, a_hnp_support)
>> -		__field(unsigned, hnp_polling_support)
>> -		__field(unsigned, host_request_flag)
>> -		__field(unsigned, quirk_ep_out_aligned_size)
>> -		__field(unsigned, quirk_altset_not_supp)
>> -		__field(unsigned, quirk_stall_not_supp)
>> -		__field(unsigned, quirk_zlp_not_supp)
>> -		__field(unsigned, is_selfpowered)
>> -		__field(unsigned, deactivated)
>> -		__field(unsigned, connected)
>> +		__field(u32, gdw1)
>>   		__field(int, ret)
>>   	),
>>   	TP_fast_assign(
>> @@ -46,39 +33,35 @@ DECLARE_EVENT_CLASS(udc_log_gadget,
>>   		__entry->max_speed = g->max_speed;
>>   		__entry->state = g->state;
>>   		__entry->mA = g->mA;
>> -		__entry->sg_supported = g->sg_supported;
>> -		__entry->is_otg = g->is_otg;
>> -		__entry->is_a_peripheral = g->is_a_peripheral;
>> -		__entry->b_hnp_enable = g->b_hnp_enable;
>> -		__entry->a_hnp_support = g->a_hnp_support;
>> -		__entry->hnp_polling_support = g->hnp_polling_support;
>> -		__entry->host_request_flag = g->host_request_flag;
>> -		__entry->quirk_ep_out_aligned_size = g->quirk_ep_out_aligned_size;
>> -		__entry->quirk_altset_not_supp = g->quirk_altset_not_supp;
>> -		__entry->quirk_stall_not_supp = g->quirk_stall_not_supp;
>> -		__entry->quirk_zlp_not_supp = g->quirk_zlp_not_supp;
>> -		__entry->is_selfpowered = g->is_selfpowered;
>> -		__entry->deactivated = g->deactivated;
>> -		__entry->connected = g->connected;
>> +		__entry->gdw1 = g->dw1;
>>   		__entry->ret = ret;
>>   	),
>> -	TP_printk("speed %d/%d state %d %dmA [%s%s%s%s%s%s%s%s%s%s%s%s%s%s] --> %d",
>> +	TP_printk("speed %d/%d state %d %dmA [%s%s%s%s%s%s%s%s%s%s%s%s%s%s%s%s%s%s%s] --> %d",
>>   		__entry->speed, __entry->max_speed, __entry->state, __entry->mA,
>> -		__entry->sg_supported ? "sg:" : "",
>> -		__entry->is_otg ? "OTG:" : "",
>> -		__entry->is_a_peripheral ? "a_peripheral:" : "",
>> -		__entry->b_hnp_enable ? "b_hnp:" : "",
>> -		__entry->a_hnp_support ? "a_hnp:" : "",
>> -		__entry->hnp_polling_support ? "hnp_poll:" : "",
>> -		__entry->host_request_flag ? "hostreq:" : "",
>> -		__entry->quirk_ep_out_aligned_size ? "out_aligned:" : "",
>> -		__entry->quirk_altset_not_supp ? "no_altset:" : "",
>> -		__entry->quirk_stall_not_supp ? "no_stall:" : "",
>> -		__entry->quirk_zlp_not_supp ? "no_zlp" : "",
>> -		__entry->is_selfpowered ? "self-powered:" : "bus-powered:",
>> -		__entry->deactivated ? "deactivated:" : "activated:",
>> -		__entry->connected ? "connected" : "disconnected",
>> -		__entry->ret)
>> +		tg.sg_supported ? "sg:" : "",
>> +		tg.is_otg ? "OTG:" : "",
>> +		tg.is_a_peripheral ? "a_peripheral:" : "",
>> +		tg.b_hnp_enable ? "b_hnp:" : "",
>> +		tg.a_hnp_support ? "a_hnp:" : "",
>> +		tg.a_alt_hnp_support ? "a_alt_hnp:" : "",
>> +		tg.hnp_polling_support ? "hnp_poll:" : "",
>> +		tg.host_request_flag ? "hostreq:" : "",
>> +		tg.quirk_ep_out_aligned_size ? "out_aligned:" : "",
>> +		tg.quirk_altset_not_supp ? "no_altset:" : "",
>> +		tg.quirk_stall_not_supp ? "no_stall:" : "",
>> +		tg.quirk_zlp_not_supp ? "no_zlp" : "",
>> +		tg.quirk_avoids_skb_reserve ? "no_skb_reserve" : "",
>> +		tg.is_selfpowered ? "self-powered:" : "bus-powered:",
>> +		tg.deactivated ? "deactivated:" : "activated:",
>> +		tg.connected ? "connected" : "disconnected",
>> +		tg.lpm_capable ? "lpm-capable" : "",
>> +		tg.wakeup_capable ? "wakeup-capable" : "",
>> +		tg.wakeup_armed ? "wakeup-armed" : "",
> You can accomplish the above using __print_flags(), if you make it into a
> bitmask, and that make a macro for each bit.


thanks for suggestion, good idea.


>
>> +		__entry->ret),
>> +	TP_printk_init(
>> +		struct usb_gadget tg;
>> +		tg.dw1 = __entry->gdw1;
>> +	)
>>   );
>>   
>>   DEFINE_EVENT(udc_log_gadget, usb_gadget_frame_number,
>> @@ -141,38 +124,36 @@ DEFINE_EVENT(udc_log_gadget, usb_gadget_activate,
>>   	TP_ARGS(g, ret)
>>   );
>>   
>> -DECLARE_EVENT_CLASS(udc_log_ep,
>> +DECLARE_EVENT_CLASS_PRINT_INIT(udc_log_ep,
>>   	TP_PROTO(struct usb_ep *ep, int ret),
>>   	TP_ARGS(ep, ret),
>>   	TP_STRUCT__entry(
>> -		__string(name, ep->name)
>> -		__field(unsigned, maxpacket)
>> -		__field(unsigned, maxpacket_limit)
>> -		__field(unsigned, max_streams)
>> -		__field(unsigned, mult)
>> -		__field(unsigned, maxburst)
>> -		__field(u8, address)
>> -		__field(bool, claimed)
>> -		__field(bool, enabled)
>> +		__field(u32, edw3)
>> +		__field(u32, edw1)
>> +		__field(u32, edw2)
>>   		__field(int, ret)
>>   	),
>>   	TP_fast_assign(
>> -		__assign_str(name, ep->name);
>> -		__entry->maxpacket = ep->maxpacket;
>> -		__entry->maxpacket_limit = ep->maxpacket_limit;
>> -		__entry->max_streams = ep->max_streams;
>> -		__entry->mult = ep->mult;
>> -		__entry->maxburst = ep->maxburst;
>> -		__entry->address = ep->address,
>> -		__entry->claimed = ep->claimed;
>> -		__entry->enabled = ep->enabled;
>> +		__entry->edw3 = ep->dw3;
>> +		__entry->edw1 = ep->dw1;
>> +		__entry->edw2 = ep->dw2;
>>   		__entry->ret = ret;
>>   	),
>>   	TP_printk("%s: mps %d/%d streams %d mult %d burst %d addr %02x %s%s --> %d",
>> -		__get_str(name), __entry->maxpacket, __entry->maxpacket_limit,
>> -		__entry->max_streams, __entry->mult, __entry->maxburst,
>> -		__entry->address, __entry->claimed ? "claimed:" : "released:",
>> -		__entry->enabled ? "enabled" : "disabled", ret)
>> +		__s, te.maxpacket, te.maxpacket_limit,
>> +		te.max_streams, te.mult, te.maxburst,
>> +		te.address, te.claimed ? "claimed:" : "released:",
>> +		te.enabled ? "enabled" : "disabled", ret),
>> +	TP_printk_init(
>> +		struct usb_ep te;
>> +		char __s[9];
>> +		te.dw1 = __entry->edw1;
>> +		te.dw2 = __entry->edw2;
>> +		te.dw3 = __entry->edw3;
>> +		snprintf(__s, 9, "ep%d%s", te.address, \
>> +			(te.caps.dir_in && te.caps.dir_out) ? "" : \
>> +			te.caps.dir_in ? "in" : "out");
> Note, there's a temp buffer trace_seq 'p' available for use as well. See
> both include/trace/events/libata.h and include/trace/events/scsi.h:
>
>    const char *libata_trace_parse_status(struct trace_seq*, unsigned char);
>    #define __parse_status(s) libata_trace_parse_status(p, s)
>
> I think that can be used instead of adding this TP_printk_init().


the reason add TP_printk_init() because when i first design some macro 
which not

related to tracepoint,  it use too much stack.


but i think  TP_printk_init()  is good as it following most common way 
to print.


>
> -- Steve
>
>
>> +	)
>>   );
>>   
>>   DEFINE_EVENT(udc_log_ep, usb_ep_set_maxpacket_limit,
>> @@ -215,44 +196,47 @@ DEFINE_EVENT(udc_log_ep, usb_ep_fifo_flush,
>>   	TP_ARGS(ep, ret)
>>   );
>>   
>> -DECLARE_EVENT_CLASS(udc_log_req,
>> +DECLARE_EVENT_CLASS_PRINT_INIT(udc_log_req,
>>   	TP_PROTO(struct usb_ep *ep, struct usb_request *req, int ret),
>>   	TP_ARGS(ep, req, ret),
>>   	TP_STRUCT__entry(
>> -		__string(name, ep->name)
>> +		__field(u32, edw3)
>>   		__field(unsigned, length)
>>   		__field(unsigned, actual)
>>   		__field(unsigned, num_sgs)
>>   		__field(unsigned, num_mapped_sgs)
>> -		__field(unsigned, stream_id)
>> -		__field(unsigned, no_interrupt)
>> -		__field(unsigned, zero)
>> -		__field(unsigned, short_not_ok)
>> +		__field(u32, rdw1)
>>   		__field(int, status)
>>   		__field(int, ret)
>>   		__field(struct usb_request *, req)
>>   	),
>>   	TP_fast_assign(
>> -		__assign_str(name, ep->name);
>> +		__entry->edw3 = ep->dw3;
>>   		__entry->length = req->length;
>>   		__entry->actual = req->actual;
>>   		__entry->num_sgs = req->num_sgs;
>>   		__entry->num_mapped_sgs = req->num_mapped_sgs;
>> -		__entry->stream_id = req->stream_id;
>> -		__entry->no_interrupt = req->no_interrupt;
>> -		__entry->zero = req->zero;
>> -		__entry->short_not_ok = req->short_not_ok;
>> +		__entry->rdw1 = req->dw1;
>>   		__entry->status = req->status;
>>   		__entry->ret = ret;
>>   		__entry->req = req;
>>   	),
>>   	TP_printk("%s: req %p length %d/%d sgs %d/%d stream %d %s%s%s status %d --> %d",
>> -		__get_str(name),__entry->req,  __entry->actual, __entry->length,
>> -		__entry->num_mapped_sgs, __entry->num_sgs, __entry->stream_id,
>> -		__entry->zero ? "Z" : "z",
>> -		__entry->short_not_ok ? "S" : "s",
>> -		__entry->no_interrupt ? "i" : "I",
>> -		__entry->status, __entry->ret
>> +		__s,__entry->req,  __entry->actual, __entry->length,
>> +		__entry->num_mapped_sgs, __entry->num_sgs, tr.stream_id,
>> +		tr.zero ? "Z" : "z",
>> +		tr.short_not_ok ? "S" : "s",
>> +		tr.no_interrupt ? "i" : "I",
>> +		__entry->status, __entry->ret),
>> +	TP_printk_init(
>> +		struct usb_ep te;
>> +		struct usb_request tr;
>> +		char __s[9];
>> +		te.dw3 = __entry->edw3;
>> +		tr.dw1 = __entry->rdw1;
>> +		snprintf(__s, 9, "ep%d%s", te.address, \
>> +			(te.caps.dir_in && te.caps.dir_out) ? "" : \
>> +			te.caps.dir_in ? "in" : "out");
>>   	)
>>   );
>>   

  reply	other threads:[~2023-09-15  1:11 UTC|newest]

Thread overview: 19+ messages / expand[flat|nested]  mbox.gz  Atom feed  top
2023-09-14 10:02 [PATCH 0/8] usb: gadget: reduce usb gadget trace event buffer usage Linyu Yuan
2023-09-14 10:02 ` [PATCH 1/8] trace: add new DECLARE_EVENT_CLASS_PRINT_INIT class type Linyu Yuan
2023-09-14 14:29   ` kernel test robot
2023-09-14 10:02 ` [PATCH 2/8] usb: gadget: add anonymous definition in some struct for trace purpose Linyu Yuan
2023-09-14 14:54   ` Alan Stern
2023-09-15  1:02     ` Linyu Yuan
2023-09-15  1:51       ` Alan Stern
2023-09-15  1:56         ` Linyu Yuan
2023-09-14 10:02 ` [PATCH 3/8] usb: udc: trace: reduce buffer usage of trace event Linyu Yuan
2023-09-14 16:54   ` Steven Rostedt
2023-09-15  1:11     ` Linyu Yuan [this message]
2023-09-15  2:16       ` Steven Rostedt
2023-09-15  2:25         ` Linyu Yuan
2023-09-14 10:02 ` [PATCH 4/8] usb: cdns3: " Linyu Yuan
2023-09-14 10:02 ` [PATCH 5/8] usb: dwc3: " Linyu Yuan
2023-09-14 10:03 ` [PATCH 6/8] usb: cdns2: " Linyu Yuan
2023-09-14 10:03 ` [PATCH 7/8] usb: mtu3: " Linyu Yuan
2023-09-14 10:03 ` [PATCH 8/8] usb: musb: " Linyu Yuan
2023-09-14 16:42 ` [PATCH 0/8] usb: gadget: reduce usb gadget trace event buffer usage Steven Rostedt

Reply instructions:

You may reply publicly to this message via plain-text email
using any one of the following methods:

* Save the following mbox file, import it into your mail client,
  and reply-to-all from there: mbox

  Avoid top-posting and favor interleaved quoting:
  https://en.wikipedia.org/wiki/Posting_style#Interleaved_style

* Reply using the --to, --cc, and --in-reply-to
  switches of git-send-email(1):

  git send-email \
    --in-reply-to=dc54b48f-f2ad-9948-f50f-a6f2c004c77c@quicinc.com \
    --to=quic_linyyuan@quicinc.com \
    --cc=Thinh.Nguyen@synopsys.com \
    --cc=b-liu@ti.com \
    --cc=chunfeng.yun@mediatek.com \
    --cc=gregkh@linuxfoundation.org \
    --cc=linux-trace-kernel@vger.kernel.org \
    --cc=linux-usb@vger.kernel.org \
    --cc=mhiramat@kernel.org \
    --cc=pawell@cadence.com \
    --cc=peter.chen@kernel.org \
    --cc=rogerq@kernel.org \
    --cc=rostedt@goodmis.org \
    --cc=stern@rowland.harvard.edu \
    /path/to/YOUR_REPLY

  https://kernel.org/pub/software/scm/git/docs/git-send-email.html

* If your mail client supports setting the In-Reply-To header
  via mailto: links, try the mailto: link
Be sure your reply has a Subject: header at the top and a blank line before the message body.
This is a public inbox, see mirroring instructions
for how to clone and mirror all data and code used for this inbox;
as well as URLs for NNTP newsgroup(s).