[<prev] [next>] [<thread-prev] [day] [month] [year] [list]
Message-ID: <3c6bddfd-a674-486c-add4-35ef93ec88c4@arm.com>
Date: Fri, 23 Jan 2026 11:43:37 +0000
From: Elif Topuz <elif.topuz@....com>
To: Cristian Marussi <cristian.marussi@....com>,
linux-kernel@...r.kernel.org, linux-arm-kernel@...ts.infradead.org,
arm-scmi@...r.kernel.org, linux-fsdevel@...r.kernel.org
Cc: sudeep.holla@....com, james.quinlan@...adcom.com, f.fainelli@...il.com,
vincent.guittot@...aro.org, etienne.carriere@...com, peng.fan@....nxp.com,
michal.simek@....com, dan.carpenter@...aro.org, d-gole@...com,
jonathan.cameron@...wei.com, lukasz.luba@....com, philip.radford@....com,
souvik.chakravarty@....com, elif.topuz@....com
Subject: Re: [PATCH v2 07/17] firmware: arm_scmi: Use new Telemetry traces
Hi Cristian,
On 14/01/2026 11:46, Cristian Marussi wrote:
> Track failed SHMTI accesses and received notifications.
>
> Signed-off-by: Cristian Marussi <cristian.marussi@....com>
> ---
> drivers/firmware/arm_scmi/telemetry.c | 57 ++++++++++++++++++++++-----
> 1 file changed, 48 insertions(+), 9 deletions(-)
>
> diff --git a/drivers/firmware/arm_scmi/telemetry.c b/drivers/firmware/arm_scmi/telemetry.c
> index 16bcdcdc1dc3..443e032a3553 100644
> --- a/drivers/firmware/arm_scmi/telemetry.c
> +++ b/drivers/firmware/arm_scmi/telemetry.c
> @@ -25,6 +25,8 @@
> #include "protocols.h"
> #include "notify.h"
>
> +#include <trace/events/scmi.h>
> +
> /* Updated only after ALL the mandatory features for that version are merged */
> #define SCMI_PROTOCOL_SUPPORTED_VERSION 0x10000
>
> @@ -1366,8 +1368,10 @@ static void scmi_telemetry_tdcf_blkts_parse(struct telemetry_info *ti,
>
> /* Check for spec compliance */
> if (USE_LINE_TS(payld) || USE_BLK_TS(payld) ||
> - DATA_INVALID(payld) || (PAYLD_ID(payld) != 0))
> + DATA_INVALID(payld) || (PAYLD_ID(payld) != 0)) {
> + trace_scmi_tlm_access(0, "BLK_TS_INVALID", 0, 0);
> return;
> + }
>
> /* A BLK_TS descriptor MUST be returned: it is found or it is crated */
> bts = scmi_telemetry_blkts_lookup(ti->ph->dev, &ti->xa_bts, payld);
> @@ -1376,6 +1380,9 @@ static void scmi_telemetry_tdcf_blkts_parse(struct telemetry_info *ti,
>
> /* Update the descriptor with the lastest TS*/
> scmi_telemetry_blkts_update(shmti->last_magic, bts);
> +
> + trace_scmi_tlm_collect(bts->last_ts, (u64)payld,
> + bts->last_magic, "SHMTI_BLK_TS");
> }
>
> static void scmi_telemetry_tdcf_data_parse(struct telemetry_info *ti,
> @@ -1393,8 +1400,10 @@ static void scmi_telemetry_tdcf_data_parse(struct telemetry_info *ti,
> /* Is thi DE ID know ? */
> tde = scmi_telemetry_tde_lookup(ti, de_id);
> if (!tde) {
> - if (mode != SCAN_DISCOVERY)
> + if (mode != SCAN_DISCOVERY) {
> + trace_scmi_tlm_access(de_id, "DE_INVALID", 0, 0);
> return;
> + }
>
> /* In SCAN_DISCOVERY mode we allocate new DEs for unknown IDs */
> tde = scmi_telemetry_tde_get(ti, de_id);
> @@ -1462,6 +1471,8 @@ static void scmi_telemetry_tdcf_data_parse(struct telemetry_info *ti,
> tde->last_ts = tstamp;
> else
> tde->last_ts = 0;
> +
> + trace_scmi_tlm_collect(0, tde->de.info->id, tde->last_val, "SHMTI_DE_UPDT");
tde->last_ts instead of 0?
> }
>
> static int scmi_telemetry_tdcf_line_parse(struct telemetry_info *ti,
> @@ -1507,8 +1518,10 @@ static int scmi_telemetry_shmti_scan(struct telemetry_info *ti,
> fsleep((SCMI_TLM_TDCF_MAX_RETRIES - retries) * 1000);
>
> startm = TDCF_START_SEQ_GET(tdcf);
> - if (IS_BAD_START_SEQ(startm))
> + if (IS_BAD_START_SEQ(startm)) {
> + trace_scmi_tlm_access(0, "MSEQ_BADSTART", startm, 0);
> continue;
> + }
>
> /* On a BAD_SEQ this will be updated on the next attempt */
> shmti->last_magic = startm;
> @@ -1520,18 +1533,25 @@ static int scmi_telemetry_shmti_scan(struct telemetry_info *ti,
>
> used_qwords = scmi_telemetry_tdcf_line_parse(ti, next,
> shmti, mode);
> - if (qwords < used_qwords)
> + if (qwords < used_qwords) {
> + trace_scmi_tlm_access(PAYLD_ID(next),
> + "BAD_QWORDS", startm, 0);
> return -EINVAL;
> + }
>
> next += used_qwords * 8;
> qwords -= used_qwords;
> }
>
> endm = TDCF_END_SEQ_GET(eplg);
> + if (startm != endm)
> + trace_scmi_tlm_access(0, "MSEQ_MISMATCH", startm, endm);
> } while (startm != endm && --retries);
>
> - if (startm != endm)
> + if (startm != endm) {
> + trace_scmi_tlm_access(0, "TDCF_SCAN_FAIL", startm, endm);
> return -EPROTO;
> + }
>
> return 0;
> }
> @@ -1923,6 +1943,8 @@ static void scmi_telemetry_scan_update(struct telemetry_info *ti, u64 ts)
> tde->last_ts = tstamp;
> else
> tde->last_ts = 0;
> +
> + trace_scmi_tlm_collect(ts, tde->de.info->id, tde->last_val, "FC_UPDATE");
tde->last_ts instead of ts?
> }
> }
>
> @@ -2001,8 +2023,11 @@ static int scmi_telemetry_tdcf_de_parse(struct telemetry_de *tde,
> fsleep((SCMI_TLM_TDCF_MAX_RETRIES - retries) * 1000);
>
> startm = TDCF_START_SEQ_GET(tdcf);
> - if (IS_BAD_START_SEQ(startm))
> + if (IS_BAD_START_SEQ(startm)) {
> + trace_scmi_tlm_access(tde->de.info->id, "MSEQ_BADSTART",
> + startm, 0);
> continue;
> + }
>
> /* Has anything changed at all at the SHMTI level ? */
> scoped_guard(mutex, &tde->mtx) {
> @@ -2018,11 +2043,16 @@ static int scmi_telemetry_tdcf_de_parse(struct telemetry_de *tde,
> if (DATA_INVALID(payld))
> return -EINVAL;
>
> - if (IS_BLK_TS(payld))
> + if (IS_BLK_TS(payld)) {
> + trace_scmi_tlm_access(tde->de.info->id,
> + "BAD_DE_META", 0, 0);
> return -EINVAL;
> + }
>
> - if (PAYLD_ID(payld) != tde->de.info->id)
> + if (PAYLD_ID(payld) != tde->de.info->id) {
> + trace_scmi_tlm_access(tde->de.info->id, "DE_INVALID", 0, 0);
> return -EINVAL;
> + }
>
> /* Data is always valid since NOT handling BLK TS lines here */
> *val = LINE_DATA_GET(&payld->l);
> @@ -2046,10 +2076,16 @@ static int scmi_telemetry_tdcf_de_parse(struct telemetry_de *tde,
> }
>
> endm = TDCF_END_SEQ_GET(tde->eplg);
> + if (startm != endm)
> + trace_scmi_tlm_access(tde->de.info->id, "MSEQ_MISMATCH",
> + startm, endm);
> } while (startm != endm && --retries);
>
> - if (startm != endm)
> + if (startm != endm) {
> + trace_scmi_tlm_access(tde->de.info->id, "TDCF_DE_FAIL",
> + startm, endm);
> return -EPROTO;
> + }
>
> guard(mutex)(&tde->mtx);
> tde->last_magic = startm;
> @@ -2230,6 +2266,9 @@ scmi_telemetry_msg_payld_process(struct telemetry_info *ti,
> tde->last_ts = LINE_TSTAMP_GET(&payld->tsl);
> else
> tde->last_ts = 0;
> +
> + trace_scmi_tlm_collect(timestamp, tde->de.info->id, tde->last_val,
> + "MESSAGE");
tde->last_ts instead of timestamp? If I understand correctly, tde->last_ts
corresponds to the time coming from the platform. We have kernel time anyway
coming from ftrace format.
> }
> }
>
Thanks,
Elif
Powered by blists - more mailing lists