[<prev] [next>] [<thread-prev] [thread-next>] [day] [month] [year] [list]
Message-ID: <20200618223045.GB2723@paulmck-ThinkPad-P72>
Date: Thu, 18 Jun 2020 15:30:45 -0700
From: "Paul E. McKenney" <paulmck@...nel.org>
To: "Joel Fernandes (Google)" <joel@...lfernandes.org>
Cc: linux-kernel@...r.kernel.org, Davidlohr Bueso <dave@...olabs.net>,
Ingo Molnar <mingo@...hat.com>,
Josh Triplett <josh@...htriplett.org>,
Lai Jiangshan <jiangshanlai@...il.com>,
Marco Elver <elver@...gle.com>,
Mathieu Desnoyers <mathieu.desnoyers@...icios.com>,
rcu@...r.kernel.org, Steven Rostedt <rostedt@...dmis.org>,
"Uladzislau Rezki (Sony)" <urezki@...il.com>
Subject: Re: [PATCH 4/7] rcu/trace: Print negative GP numbers correctly
On Thu, Jun 18, 2020 at 04:29:52PM -0400, Joel Fernandes (Google) wrote:
> GP numbers start from -300 and gp_seq numbers start of -1200 (for a
> shift of 2). These negative numbers are printed as unsigned long which
> not only takes up more text space, but is rather confusing to the reader
> as they have to constantly expend energy to truncate the number. Just
> print the negative numbering directly.
Good! This also makes the ftrace versions of the grace-period sequence
numbers consistent with those of rcutorture.
Thanx, Paul
> Signed-off-by: Joel Fernandes (Google) <joel@...lfernandes.org>
> ---
> include/trace/events/rcu.h | 62 ++++++++++++++++++++------------------
> 1 file changed, 32 insertions(+), 30 deletions(-)
>
> diff --git a/include/trace/events/rcu.h b/include/trace/events/rcu.h
> index cb5363564f7ed..bc24862790623 100644
> --- a/include/trace/events/rcu.h
> +++ b/include/trace/events/rcu.h
> @@ -76,18 +76,18 @@ TRACE_EVENT_RCU(rcu_grace_period,
> TP_STRUCT__entry(
> __field(const char *, rcuname)
> __field(const char *, gp_seq_src)
> - __field(unsigned long, gp_seq)
> + __field(long, gp_seq)
> __field(const char *, gpevent)
> ),
>
> TP_fast_assign(
> __entry->rcuname = rcuname;
> __entry->gp_seq_src = gp_seq_src;
> - __entry->gp_seq = gp_seq;
> + __entry->gp_seq = (long)gp_seq;
> __entry->gpevent = gpevent;
> ),
>
> - TP_printk("%s %s_gp_seq=%lu %s",
> + TP_printk("%s %s_gp_seq=%ld %s",
> __entry->rcuname, __entry->gp_seq_src,
> __entry->gp_seq, __entry->gpevent)
> );
> @@ -118,8 +118,8 @@ TRACE_EVENT_RCU(rcu_future_grace_period,
>
> TP_STRUCT__entry(
> __field(const char *, rcuname)
> - __field(unsigned long, gp_seq)
> - __field(unsigned long, gp_seq_req)
> + __field(long, gp_seq)
> + __field(long, gp_seq_req)
> __field(u8, level)
> __field(int, grplo)
> __field(int, grphi)
> @@ -128,16 +128,16 @@ TRACE_EVENT_RCU(rcu_future_grace_period,
>
> TP_fast_assign(
> __entry->rcuname = rcuname;
> - __entry->gp_seq = gp_seq;
> - __entry->gp_seq_req = gp_seq_req;
> + __entry->gp_seq = (long)gp_seq;
> + __entry->gp_seq_req = (long)gp_seq_req;
> __entry->level = level;
> __entry->grplo = grplo;
> __entry->grphi = grphi;
> __entry->gpevent = gpevent;
> ),
>
> - TP_printk("%s %lu %lu %u %d %d %s",
> - __entry->rcuname, __entry->gp_seq, __entry->gp_seq_req, __entry->level,
> + TP_printk("%s %ld %ld %u %d %d %s",
> + __entry->rcuname, (long)__entry->gp_seq, (long)__entry->gp_seq_req, __entry->level,
> __entry->grplo, __entry->grphi, __entry->gpevent)
> );
>
> @@ -157,7 +157,7 @@ TRACE_EVENT_RCU(rcu_grace_period_init,
>
> TP_STRUCT__entry(
> __field(const char *, rcuname)
> - __field(unsigned long, gp_seq)
> + __field(long, gp_seq)
> __field(u8, level)
> __field(int, grplo)
> __field(int, grphi)
> @@ -166,14 +166,14 @@ TRACE_EVENT_RCU(rcu_grace_period_init,
>
> TP_fast_assign(
> __entry->rcuname = rcuname;
> - __entry->gp_seq = gp_seq;
> + __entry->gp_seq = (long)gp_seq;
> __entry->level = level;
> __entry->grplo = grplo;
> __entry->grphi = grphi;
> __entry->qsmask = qsmask;
> ),
>
> - TP_printk("%s %lu %u %d %d %lx",
> + TP_printk("%s %ld %u %d %d %lx",
> __entry->rcuname, __entry->gp_seq, __entry->level,
> __entry->grplo, __entry->grphi, __entry->qsmask)
> );
> @@ -201,17 +201,17 @@ TRACE_EVENT_RCU(rcu_exp_grace_period,
>
> TP_STRUCT__entry(
> __field(const char *, rcuname)
> - __field(unsigned long, gpseq)
> + __field(long, gpseq)
> __field(const char *, gpevent)
> ),
>
> TP_fast_assign(
> __entry->rcuname = rcuname;
> - __entry->gpseq = gpseq;
> + __entry->gpseq = (long)gpseq;
> __entry->gpevent = gpevent;
> ),
>
> - TP_printk("%s %lu %s",
> + TP_printk("%s %ld %s",
> __entry->rcuname, __entry->gpseq, __entry->gpevent)
> );
>
> @@ -320,17 +320,17 @@ TRACE_EVENT_RCU(rcu_preempt_task,
>
> TP_STRUCT__entry(
> __field(const char *, rcuname)
> - __field(unsigned long, gp_seq)
> + __field(long, gp_seq)
> __field(int, pid)
> ),
>
> TP_fast_assign(
> __entry->rcuname = rcuname;
> - __entry->gp_seq = gp_seq;
> + __entry->gp_seq = (long)gp_seq;
> __entry->pid = pid;
> ),
>
> - TP_printk("%s %lu %d",
> + TP_printk("%s %ld %d",
> __entry->rcuname, __entry->gp_seq, __entry->pid)
> );
>
> @@ -347,17 +347,17 @@ TRACE_EVENT_RCU(rcu_unlock_preempted_task,
>
> TP_STRUCT__entry(
> __field(const char *, rcuname)
> - __field(unsigned long, gp_seq)
> + __field(long, gp_seq)
> __field(int, pid)
> ),
>
> TP_fast_assign(
> __entry->rcuname = rcuname;
> - __entry->gp_seq = gp_seq;
> + __entry->gp_seq = (long)gp_seq;
> __entry->pid = pid;
> ),
>
> - TP_printk("%s %lu %d", __entry->rcuname, __entry->gp_seq, __entry->pid)
> + TP_printk("%s %ld %d", __entry->rcuname, __entry->gp_seq, __entry->pid)
> );
>
> /*
> @@ -378,7 +378,7 @@ TRACE_EVENT_RCU(rcu_quiescent_state_report,
>
> TP_STRUCT__entry(
> __field(const char *, rcuname)
> - __field(unsigned long, gp_seq)
> + __field(long, gp_seq)
> __field(unsigned long, mask)
> __field(unsigned long, qsmask)
> __field(u8, level)
> @@ -389,7 +389,7 @@ TRACE_EVENT_RCU(rcu_quiescent_state_report,
>
> TP_fast_assign(
> __entry->rcuname = rcuname;
> - __entry->gp_seq = gp_seq;
> + __entry->gp_seq = (long)gp_seq;
> __entry->mask = mask;
> __entry->qsmask = qsmask;
> __entry->level = level;
> @@ -398,7 +398,7 @@ TRACE_EVENT_RCU(rcu_quiescent_state_report,
> __entry->gp_tasks = gp_tasks;
> ),
>
> - TP_printk("%s %lu %lx>%lx %u %d %d %u",
> + TP_printk("%s %ld %lx>%lx %u %d %d %u",
> __entry->rcuname, __entry->gp_seq,
> __entry->mask, __entry->qsmask, __entry->level,
> __entry->grplo, __entry->grphi, __entry->gp_tasks)
> @@ -419,19 +419,19 @@ TRACE_EVENT_RCU(rcu_fqs,
>
> TP_STRUCT__entry(
> __field(const char *, rcuname)
> - __field(unsigned long, gp_seq)
> + __field(long, gp_seq)
> __field(int, cpu)
> __field(const char *, qsevent)
> ),
>
> TP_fast_assign(
> __entry->rcuname = rcuname;
> - __entry->gp_seq = gp_seq;
> + __entry->gp_seq = (long)gp_seq;
> __entry->cpu = cpu;
> __entry->qsevent = qsevent;
> ),
>
> - TP_printk("%s %lu %d %s",
> + TP_printk("%s %ld %d %s",
> __entry->rcuname, __entry->gp_seq,
> __entry->cpu, __entry->qsevent)
> );
> @@ -520,17 +520,19 @@ TRACE_EVENT_RCU(rcu_segcb,
> TP_STRUCT__entry(
> __field(const char *, ctx)
> __array(int, cb_count, 4)
> - __array(unsigned long, gp_seq, 4)
> + __array(long, gp_seq, 4)
> ),
>
> TP_fast_assign(
> + int i;
> __entry->ctx = ctx;
> memcpy(__entry->cb_count, cb_count, 4 * sizeof(int));
> - memcpy(__entry->gp_seq, gp_seq, 4 * sizeof(unsigned long));
> + for (i = 0; i < 4; i++)
> + __entry->gp_seq[i] = (long)(gp_seq[i]);
> ),
>
> TP_printk("%s cb_count: (DONE=%d, WAIT=%d, NEXT_READY=%d, NEXT=%d) "
> - "gp_seq: (DONE=%lu, WAIT=%lu, NEXT_READY=%lu, NEXT=%lu)", __entry->ctx,
> + "gp_seq: (DONE=%ld, WAIT=%ld, NEXT_READY=%ld, NEXT=%ld)", __entry->ctx,
> __entry->cb_count[0], __entry->cb_count[1], __entry->cb_count[2], __entry->cb_count[3],
> __entry->gp_seq[0], __entry->gp_seq[1], __entry->gp_seq[2], __entry->gp_seq[3])
>
> --
> 2.27.0.111.gc72c7da667-goog
>
Powered by blists - more mailing lists