| lists.openwall.net | lists / announce owl-users owl-dev john-users john-dev passwdqc-users yescrypt popa3d-users / oss-security kernel-hardening musl sabotage tlsify passwords / crypt-dev xvendor / Bugtraq Full-Disclosure linux-kernel linux-netdev linux-ext4 linux-hardening linux-cve-announce PHC | |
|
Open Source and information security mailing list archives
| ||
|
Date: Wed, 8 Mar 2023 14:48:56 -0800
From: Gokul Krishna Krishnakumar <quic_gokukris@...cinc.com>
To: Mukesh Ojha <quic_mojha@...cinc.com>,
Andy Gross <agross@...nel.org>,
Bjorn Andersson <andersson@...nel.org>,
Konrad Dybcio <konrad.dybcio@...ainline.org>,
Mathieu Poirier <mathieu.poirier@...aro.org>
CC: <linux-arm-msm@...r.kernel.org>,
<linux-remoteproc@...r.kernel.org>, <linux-kernel@...r.kernel.org>,
Trilok Soni <quic_tsoni@...cinc.com>,
"Satya Durga Srinivasu Prabhala" <quic_satyap@...cinc.com>,
Rajendra Nayak <quic_rjendra@...cinc.com>,
Elliot Berman <quic_eberman@...cinc.com>,
"Guru Das Srinagesh" <quic_gurus@...cinc.com>,
Sibi Sankar <quic_sibis@...cinc.com>,
<linux-trace-kernel@...r.kernel.org>
Subject: Re: [PATCH v2 1/1] remoteproc: qcom: Add remoteproc tracing
On 3/6/2023 4:17 AM, Mukesh Ojha wrote:
>
>
> On 3/3/2023 9:24 AM, Gokul krishna Krishnakumar wrote:
>> This change attempts to add traces for start, stop, crash
>> subsystem/subdevice event these will serve as standard checkpoints in
>> code and could help in debugging the failures in subdevice/subsystem
>> prepare, start, stop and unprepare functions. This will also breakdown
>> the time taken for each step in remoteproc bootup/shutdown process.
>>
>> Change-Id: I202814452192ca0733f134daf7c99201881e2c9c
>> Signed-off-by: Gokul krishna Krishnakumar <quic_gokukris@...cinc.com>
>> ---
>> drivers/remoteproc/Makefile | 1 +
>> drivers/remoteproc/qcom_common.c | 37 ++++++++
>> drivers/remoteproc/qcom_q6v5.c | 9 ++
>> drivers/remoteproc/qcom_tracepoints.c | 12 +++
>> drivers/remoteproc/remoteproc_core.c | 8 ++
>> include/trace/events/rproc_qcom.h | 128 ++++++++++++++++++++++++++
>> 6 files changed, 195 insertions(+)
>> create mode 100644 drivers/remoteproc/qcom_tracepoints.c
>> create mode 100644 include/trace/events/rproc_qcom.h
>
>
> I think, it is better to split this where first patch will introduce the
> trace event and in the later you can use at respective places.
>
Done.
>>
>> diff --git a/drivers/remoteproc/Makefile b/drivers/remoteproc/Makefile
>> index 91314a9b43ce..3399fcaba39b 100644
>> --- a/drivers/remoteproc/Makefile
>> +++ b/drivers/remoteproc/Makefile
>> @@ -10,6 +10,7 @@ remoteproc-y += remoteproc_debugfs.o
>> remoteproc-y += remoteproc_sysfs.o
>> remoteproc-y += remoteproc_virtio.o
>> remoteproc-y += remoteproc_elf_loader.o
>> +remoteproc-y += qcom_tracepoints.o
>> obj-$(CONFIG_REMOTEPROC_CDEV) += remoteproc_cdev.o
>> obj-$(CONFIG_IMX_REMOTEPROC) += imx_rproc.o
>> obj-$(CONFIG_IMX_DSP_REMOTEPROC) += imx_dsp_rproc.o
>> diff --git a/drivers/remoteproc/qcom_common.c
>> b/drivers/remoteproc/qcom_common.c
>> index 020349f8979d..09b79f39ccd6 100644
>> --- a/drivers/remoteproc/qcom_common.c
>> +++ b/drivers/remoteproc/qcom_common.c
>> @@ -18,6 +18,7 @@
>> #include <linux/slab.h>
>> #include <linux/soc/qcom/mdt_loader.h>
>> #include <linux/soc/qcom/smem.h>
>> +#include <trace/events/rproc_qcom.h>
>> #include "remoteproc_internal.h"
>> #include "qcom_common.h"
>> @@ -186,6 +187,10 @@ static int glink_subdev_start(struct rproc_subdev
>> *subdev)
>> glink->edge = qcom_glink_smem_register(glink->dev, glink->node);
>> + trace_rproc_subdev_event(dev_name(glink->dev->parent),
>> + "glink", "start",
>> + PTR_ERR_OR_ZERO(glink->edge));
>> +
>> return PTR_ERR_OR_ZERO(glink->edge);
>> }
>> @@ -194,6 +199,11 @@ static void glink_subdev_stop(struct rproc_subdev
>> *subdev, bool crashed)
>> struct qcom_rproc_glink *glink = to_glink_subdev(subdev);
>> qcom_glink_smem_unregister(glink->edge);
>> +
>> + trace_rproc_subdev_event(dev_name(glink->dev->parent),
>> + "glink", "stop",
>> + PTR_ERR_OR_ZERO(glink->edge));
>> +
>> glink->edge = NULL;
>> }
>> @@ -201,6 +211,10 @@ static void glink_subdev_unprepare(struct
>> rproc_subdev *subdev)
>> {
>> struct qcom_rproc_glink *glink = to_glink_subdev(subdev);
>> + trace_rproc_subdev_event(dev_name(glink->dev->parent),
>> + "glink", "unprepare",
>> + PTR_ERR_OR_ZERO(glink->edge));
>> +
>> qcom_glink_ssr_notify(glink->ssr_name);
>> }
>> @@ -295,6 +309,10 @@ static int smd_subdev_start(struct rproc_subdev
>> *subdev)
>> {
>> struct qcom_rproc_subdev *smd = to_smd_subdev(subdev);
>> + trace_rproc_subdev_event(dev_name(smd->dev->parent),
>> + "smd", "start",
>> + PTR_ERR_OR_ZERO(smd->edge));
>> +
>> smd->edge = qcom_smd_register_edge(smd->dev, smd->node);
>> return PTR_ERR_OR_ZERO(smd->edge);
>> @@ -304,6 +322,10 @@ static void smd_subdev_stop(struct rproc_subdev
>> *subdev, bool crashed)
>> {
>> struct qcom_rproc_subdev *smd = to_smd_subdev(subdev);
>> + trace_rproc_subdev_event(dev_name(smd->dev->parent),
>> + "smd", "stop",
>> + PTR_ERR_OR_ZERO(smd->edge));
>> +
>> qcom_smd_unregister_edge(smd->edge);
>> smd->edge = NULL;
>> }
>> @@ -420,6 +442,10 @@ static int ssr_notify_prepare(struct rproc_subdev
>> *subdev)
>> .crashed = false,
>> };
>> + trace_rproc_subdev_event(ssr->info->name,
>> + "ssr", "QCOM_SSR_BEFORE_POWERUP",
>> + data.crashed);
>> +
>> srcu_notifier_call_chain(&ssr->info->notifier_list,
>> QCOM_SSR_BEFORE_POWERUP, &data);
>> return 0;
>> @@ -432,6 +458,9 @@ static int ssr_notify_start(struct rproc_subdev
>> *subdev)
>> .name = ssr->info->name,
>> .crashed = false,
>> };
>> + trace_rproc_subdev_event(ssr->info->name,
>> + "ssr", "QCOM_SSR_AFTER_POWERUP",
>> + data.crashed);
>> srcu_notifier_call_chain(&ssr->info->notifier_list,
>> QCOM_SSR_AFTER_POWERUP, &data);
>> @@ -446,6 +475,10 @@ static void ssr_notify_stop(struct rproc_subdev
>> *subdev, bool crashed)
>> .crashed = crashed,
>> };
>> + trace_rproc_subdev_event(ssr->info->name,
>> + "ssr", "QCOM_SSR_BEFORE_SHUTDOWN",
>> + data.crashed);
>> +
>> srcu_notifier_call_chain(&ssr->info->notifier_list,
>> QCOM_SSR_BEFORE_SHUTDOWN, &data);
>> }
>> @@ -458,6 +491,10 @@ static void ssr_notify_unprepare(struct
>> rproc_subdev *subdev)
>> .crashed = false,
>> };
>> + trace_rproc_subdev_event(ssr->info->name,
>> + "ssr", "QCOM_SSR_AFTER_SHUTDOWN",
>> + data.crashed);
>> +
>> srcu_notifier_call_chain(&ssr->info->notifier_list,
>> QCOM_SSR_AFTER_SHUTDOWN, &data);
>> }
>> diff --git a/drivers/remoteproc/qcom_q6v5.c
>> b/drivers/remoteproc/qcom_q6v5.c
>> index 497acfb33f8f..aff91de3cea0 100644
>> --- a/drivers/remoteproc/qcom_q6v5.c
>> +++ b/drivers/remoteproc/qcom_q6v5.c
>> @@ -15,6 +15,7 @@
>> #include <linux/soc/qcom/smem.h>
>> #include <linux/soc/qcom/smem_state.h>
>> #include <linux/remoteproc.h>
>> +#include <trace/events/rproc_qcom.h>
>> #include "qcom_common.h"
>> #include "qcom_q6v5.h"
>> @@ -113,6 +114,7 @@ static irqreturn_t q6v5_wdog_interrupt(int irq,
>> void *data)
>> dev_err(q6v5->dev, "watchdog without message\n");
>> q6v5->running = false;
>> + trace_rproc_interrupt_event(q6v5->rproc, "q6v5_wdog", msg);
>> rproc_report_crash(q6v5->rproc, RPROC_WATCHDOG);
>> return IRQ_HANDLED;
>> @@ -134,6 +136,7 @@ static irqreturn_t q6v5_fatal_interrupt(int irq,
>> void *data)
>> dev_err(q6v5->dev, "fatal error without message\n");
>> q6v5->running = false;
>> + trace_rproc_interrupt_event(q6v5->rproc, "fatal", msg);
>> rproc_report_crash(q6v5->rproc, RPROC_FATAL_ERROR);
>> return IRQ_HANDLED;
>> @@ -165,6 +168,8 @@ int qcom_q6v5_wait_for_start(struct qcom_q6v5
>> *q6v5, int timeout)
>> if (!ret)
>> disable_irq(q6v5->handover_irq);
>> + trace_rproc_interrupt_event(q6v5->rproc, "Ready", !ret?
>> "-ETIMEDOUT":"done");
>> +
>> return !ret ? -ETIMEDOUT : 0;
>> }
>> EXPORT_SYMBOL_GPL(qcom_q6v5_wait_for_start);
>> @@ -180,6 +185,8 @@ static irqreturn_t q6v5_handover_interrupt(int
>> irq, void *data)
>> q6v5->handover_issued = true;
>> + trace_rproc_interrupt_event(q6v5->rproc, "handover", "Proxy votes
>> removed");
>> +
>> return IRQ_HANDLED;
>> }
>> @@ -216,6 +223,8 @@ int qcom_q6v5_request_stop(struct qcom_q6v5 *q6v5,
>> struct qcom_sysmon *sysmon)
>> qcom_smem_state_update_bits(q6v5->state, BIT(q6v5->stop_bit), 0);
>> + trace_rproc_interrupt_event(q6v5->rproc, "Stop", ret?
>> "done":"-EETIMEDOUT");
>> +
>> return ret == 0 ? -ETIMEDOUT : 0;
>> }
>> EXPORT_SYMBOL_GPL(qcom_q6v5_request_stop);
>> diff --git a/drivers/remoteproc/qcom_tracepoints.c
>> b/drivers/remoteproc/qcom_tracepoints.c
>> new file mode 100644
>> index 000000000000..1b587ef54aa7
>> --- /dev/null
>> +++ b/drivers/remoteproc/qcom_tracepoints.c'
>
> is it qcom specific ? No, i guess, as you have put traces in generic
> path as well.
> Yes you are right the traces are generic to remoteproc events.
> -Mukesh
>
Thanks for the review,
Gokul
>> @@ -0,0 +1,12 @@
>> +// SPDX-License-Identifier: GPL-2.0-only
>> +/*
>> + * Copyright (c) 2023 Qualcomm Innovation Center, Inc. All rights
>> reserved.
>> + */
>> +
>> +#define CREATE_TRACE_POINTS
>> +#include <trace/events/rproc_qcom.h>
>> +EXPORT_TRACEPOINT_SYMBOL(rproc_load_event);
>> +EXPORT_TRACEPOINT_SYMBOL(rproc_start_event);
>> +EXPORT_TRACEPOINT_SYMBOL(rproc_stop_event);
>> +EXPORT_TRACEPOINT_SYMBOL(rproc_interrupt_event);
>> +EXPORT_TRACEPOINT_SYMBOL(rproc_subdev_event);
>> diff --git a/drivers/remoteproc/remoteproc_core.c
>> b/drivers/remoteproc/remoteproc_core.c
>> index 1cd4815a6dd1..6def868f0a98 100644
>> --- a/drivers/remoteproc/remoteproc_core.c
>> +++ b/drivers/remoteproc/remoteproc_core.c
>> @@ -38,6 +38,7 @@
>> #include <linux/virtio_ring.h>
>> #include <asm/byteorder.h>
>> #include <linux/platform_device.h>
>> +#include <trace/events/rproc_qcom.h>
>> #include "remoteproc_internal.h"
>> @@ -1270,6 +1271,7 @@ static int rproc_start(struct rproc *rproc,
>> const struct firmware *fw)
>> /* load the ELF segments to memory */
>> ret = rproc_load_segments(rproc, fw);
>> + trace_rproc_load_event(rproc, ret);
>> if (ret) {
>> dev_err(dev, "Failed to load program segments: %d\n", ret);
>> return ret;
>> @@ -1305,6 +1307,7 @@ static int rproc_start(struct rproc *rproc,
>> const struct firmware *fw)
>> /* Start any subdevices for the remote processor */
>> ret = rproc_start_subdevices(rproc);
>> +
>> if (ret) {
>> dev_err(dev, "failed to probe subdevices for %s: %d\n",
>> rproc->name, ret);
>> @@ -1729,6 +1732,8 @@ static int rproc_stop(struct rproc *rproc, bool
>> crashed)
>> return ret;
>> }
>> + trace_rproc_stop_event(rproc, crashed ? "crash stop" : "stop");
>> +
>> rproc_unprepare_subdevices(rproc);
>> rproc->state = RPROC_OFFLINE;
>> @@ -1939,6 +1944,8 @@ int rproc_boot(struct rproc *rproc)
>> dev_info(dev, "attaching to %s\n", rproc->name);
>> ret = rproc_attach(rproc);
>> + trace_rproc_start_event(rproc, ret);
>> +
>> } else {
>> dev_info(dev, "powering up %s\n", rproc->name);
>> @@ -1950,6 +1957,7 @@ int rproc_boot(struct rproc *rproc)
>> }
>> ret = rproc_fw_boot(rproc, firmware_p);
>> + trace_rproc_start_event(rproc, ret);
>> release_firmware(firmware_p);
>> }
>> diff --git a/include/trace/events/rproc_qcom.h
>> b/include/trace/events/rproc_qcom.h
>> new file mode 100644
>> index 000000000000..66b10cb17965
>> --- /dev/null
>> +++ b/include/trace/events/rproc_qcom.h
>> @@ -0,0 +1,128 @@
>> +/* SPDX-License-Identifier: GPL-2.0-only */
>> +/*
>> + * Copyright (c) 2023 Qualcomm Innovation Center, Inc. All rights
>> reserved.
>> + */
>> +
>> +#undef TRACE_SYSTEM
>> +#define TRACE_SYSTEM rproc_qcom
>> +
>> +#if !defined(_TRACE_RPROC_QCOM_H) || defined(TRACE_HEADER_MULTI_READ)
>> +#define _TRACE_RPROC_QCOM_H
>> +#include <linux/tracepoint.h>
>> +#include <linux/remoteproc.h>
>> +
>> +/*
>> + * Tracepoints for remoteproc and subdevice events
>> + */
>> +TRACE_EVENT(rproc_load_event,
>> +
>> + TP_PROTO(struct rproc *rproc, int ret),
>> +
>> + TP_ARGS(rproc, ret),
>> +
>> + TP_STRUCT__entry(
>> + __string(name, rproc->name)
>> + __string(firmware, rproc->firmware)
>> + __field(int,ret)
>> + ),
>> +
>> + TP_fast_assign(
>> + __assign_str(name, rproc->name);
>> + __assign_str(firmware, rproc->firmware);
>> + __entry->ret = ret;
>> + ),
>> +
>> + TP_printk("%s loading firmware %s returned %d",
>> + __get_str(name), __get_str(firmware),
>> + __entry->ret)
>> +);
>> +
>> +TRACE_EVENT(rproc_start_event,
>> +
>> + TP_PROTO(struct rproc *rproc, int ret),
>> +
>> + TP_ARGS(rproc, ret),
>> +
>> + TP_STRUCT__entry(
>> + __string(name, rproc->name)
>> + __field(int, ret)
>> + ),
>> +
>> + TP_fast_assign(
>> + __assign_str(name, rproc->name);
>> + __entry->ret = ret;
>> + ),
>> +
>> + TP_printk("%s %d", __get_str(name), __entry->ret)
>> +);
>> +
>> +TRACE_EVENT(rproc_stop_event,
>> +
>> + TP_PROTO(struct rproc *rproc, char* crash_msg),
>> +
>> + TP_ARGS(rproc, crash_msg),
>> +
>> + TP_STRUCT__entry(
>> + __string(name, rproc->name)
>> + __string(crash_msg, crash_msg)
>> + ),
>> +
>> + TP_fast_assign(
>> + __assign_str(name, rproc->name);
>> + __assign_str(crash_msg, crash_msg)
>> + ),
>> +
>> + TP_printk("%s %s", __get_str(name), __get_str(crash_msg))
>> +);
>> +
>> +TRACE_EVENT(rproc_interrupt_event,
>> +
>> + TP_PROTO(struct rproc *rproc, const char* event,
>> + const char* msg),
>> +
>> + TP_ARGS(rproc, event, msg),
>> +
>> + TP_STRUCT__entry(
>> + __string(name, rproc->name)
>> + __string(event, event)
>> + __string(msg, msg)
>> + ),
>> +
>> + TP_fast_assign(
>> + __assign_str(name, rproc->name);
>> + __assign_str(event, event);
>> + __assign_str(msg, msg);
>> + ),
>> +
>> + TP_printk("%s %s returned %s", __get_str(name),
>> + __get_str(event), __get_str(msg))
>> +);
>> +
>> +TRACE_EVENT(rproc_subdev_event,
>> +
>> + TP_PROTO(const char* rproc, const char* subdev,
>> + const char* event, int ret),
>> +
>> + TP_ARGS(rproc, subdev, event, ret),
>> +
>> + TP_STRUCT__entry(
>> + __string(rproc, rproc)
>> + __string(subdev, subdev)
>> + __string(event, event)
>> + __field(int, ret)
>> + ),
>> +
>> + TP_fast_assign(
>> + __assign_str(rproc, rproc);
>> + __assign_str(subdev, subdev);
>> + __assign_str(event, event);
>> + __entry->ret = ret;
>> + ),
>> +
>> + TP_printk("%s %s %s %d", __get_str(rproc), __get_str(subdev),
>> + __get_str(event), __entry->ret)
>> +);
>> +#endif /* _TRACE_RPROC_QCOM_H */
>> +
>> +/* This part must be outside protection */
>> +#include <trace/define_trace.h>
>
Powered by blists - more mailing lists