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
 
Hash Suite: Windows password security audit tool. GUI, reports in PDF.
[<prev] [next>] [<thread-prev] [day] [month] [year] [list]
Message-ID: <CAP-5=fWSFgkWggNaYDRno=Lv+s980_9ckr3vKy+CX2TsCJH+vA@mail.gmail.com>
Date: Tue, 9 Dec 2025 13:03:14 -0800
From: Ian Rogers <irogers@...gle.com>
To: "Sapkal, Swapnil" <swapnil.sapkal@....com>
Cc: peterz@...radead.org, mingo@...hat.com, acme@...nel.org, 
	namhyung@...nel.org, james.clark@....com, ravi.bangoria@....com, 
	yu.c.chen@...el.com, mark.rutland@....com, alexander.shishkin@...ux.intel.com, 
	jolsa@...nel.org, rostedt@...dmis.org, vincent.guittot@...aro.org, 
	adrian.hunter@...el.com, kan.liang@...ux.intel.com, gautham.shenoy@....com, 
	kprateek.nayak@....com, juri.lelli@...hat.com, yangjihong@...edance.com, 
	void@...ifault.com, tj@...nel.org, sshegde@...ux.ibm.com, 
	linux-kernel@...r.kernel.org, linux-perf-users@...r.kernel.org, 
	santosh.shukla@....com, sandipan.das@....com, 
	Cristian Prundeanu <cpru@...zon.com>
Subject: Re: [PATCH v4 00/11] perf sched: Introduce stats tool

On Wed, Aug 27, 2025 at 9:43 PM Sapkal, Swapnil <swapnil.sapkal@....com> wrote:
>
> Hello all,
>
> Missed to add perf folks to the list. Adding them here. Sorry about that.

Hi Swapnil,

I was wondering if this patch series was active? The kernel test robot
mentioned an issue.

> --
> Thanks and Regards,
> Swapnil
>
> On 8/26/2025 10:40 AM, Swapnil Sapkal wrote:
> > Apologies for long delay, I was side tracked on some other items. I was
> > not able to focus on this.
> >
> > MOTIVATION
> > ----------
> >
> > Existing `perf sched` is quite exhaustive and provides lot of insights
> > into scheduler behavior but it quickly becomes impractical to use for
> > long running or scheduler intensive workload. For ex, `perf sched record`
> > has ~7.77% overhead on hackbench (with 25 groups each running 700K loops
> > on a 2-socket 128 Cores 256 Threads 3rd Generation EPYC Server), and it
> > generates huge 56G perf.data for which perf takes ~137 mins to prepare
> > and write it to disk [1].
> >
> > Unlike `perf sched record`, which hooks onto set of scheduler tracepoints
> > and generates samples on a tracepoint hit, `perf sched stats record` takes
> > snapshot of the /proc/schedstat file before and after the workload, i.e.
> > there is almost zero interference on workload run. Also, it takes very
> > minimal time to parse /proc/schedstat, convert it into perf samples and
> > save those samples into perf.data file. Result perf.data file is much
> > smaller. So, overall `perf sched stats record` is much more light weight
> > compare to `perf sched record`.
> >
> > We, internally at AMD, have been using this (a variant of this, known as
> > "sched-scoreboard"[2]) and found it to be very useful to analyse impact
> > of any scheduler code changes[3][4]. Prateek used v2[5] of this patch
> > series to report the analysis[6][7].
> >
> > Please note that, this is not a replacement of perf sched record/report.
> > The intended users of the new tool are scheduler developers, not regular
> > users.
> >
> > USAGE
> > -----
> >
> >    # perf sched stats record
> >    # perf sched stats report
> >    # perf sched stats diff
> >
> > Note: Although `perf sched stats` tool supports workload profiling syntax
> > (i.e. -- <workload> ), the recorded profile is still systemwide since the
> > /proc/schedstat is a systemwide file.
> >
> > HOW TO INTERPRET THE REPORT
> > ---------------------------
> >
> > The `perf sched stats report` starts with description of the columns
> > present in the report. These column names are given before cpu and
> > domain stats to improve the readability of the report.
> >
> >    ----------------------------------------------------------------------------------------------------
> >    DESC                    -> Description of the field
> >    COUNT                   -> Value of the field
> >    PCT_CHANGE              -> Percent change with corresponding base value
> >    AVG_JIFFIES             -> Avg time in jiffies between two consecutive occurrence of event
> >    ----------------------------------------------------------------------------------------------------
> >
> > Next is the total profiling time in terms of jiffies:
> >
> >    ----------------------------------------------------------------------------------------------------
> >    Time elapsed (in jiffies)                                   :       24537
> >    ----------------------------------------------------------------------------------------------------
> >
> > Next is CPU scheduling statistics. These are simple diffs of
> > /proc/schedstat CPU lines along with description. The report also
> > prints % relative to base stat.

I wonder if this is similar to user_time and system_time:
```
$ perf list
...
tool:
...
 system_time
      [System/kernel time in nanoseconds. Unit: tool]
...
 user_time
      [User (non-kernel) time in nanoseconds. Unit: tool]
...
```
These events are implemented by reading /proc/stat and /proc/pid/stat:
https://web.git.kernel.org/pub/scm/linux/kernel/git/perf/perf-tools-next.git/tree/tools/perf/util/tool_pmu.c?h=perf-tools-next#n267

As they are events then they can appear in perf stat output and also
within metrics.

Thanks,
Ian

> >
> > In the example below, schedule() left the CPU0 idle 36.58% of the time.
> > 0.45% of total try_to_wake_up() was to wakeup local CPU. And, the total
> > waittime by tasks on CPU0 is 48.70% of the total runtime by tasks on the
> > same CPU.
> >
> >    ----------------------------------------------------------------------------------------------------
> >    CPU 0
> >    ----------------------------------------------------------------------------------------------------
> >    DESC                                                                     COUNT   PCT_CHANGE
> >    ----------------------------------------------------------------------------------------------------
> >    yld_count                                                        :           0
> >    array_exp                                                        :           0
> >    sched_count                                                      :      402267
> >    sched_goidle                                                     :      147161  (    36.58% )
> >    ttwu_count                                                       :      236309
> >    ttwu_local                                                       :        1062  (     0.45% )
> >    rq_cpu_time                                                      :  7083791148
> >    run_delay                                                        :  3449973971  (    48.70% )
> >    pcount                                                           :      255035
> >    ----------------------------------------------------------------------------------------------------
> >
> > Next is load balancing statistics. For each of the sched domains
> > (eg: `SMT`, `MC`, `DIE`...), the scheduler computes statistics under
> > the following three categories:
> >
> >    1) Idle Load Balance: Load balancing performed on behalf of a long
> >                          idling CPU by some other CPU.
> >    2) Busy Load Balance: Load balancing performed when the CPU was busy.
> >    3) New Idle Balance : Load balancing performed when a CPU just became
> >                          idle.
> >
> > Under each of these three categories, sched stats report provides
> > different load balancing statistics. Along with direct stats, the
> > report also contains derived metrics prefixed with *. Example:
> >
> >    ----------------------------------------------------------------------------------------------------
> >    CPU 0, DOMAIN SMT CPUS 0,64
> >    ----------------------------------------------------------------------------------------------------
> >    DESC                                                                     COUNT    AVG_JIFFIES
> >    ----------------------------------------- <Category busy> ------------------------------------------
> >    busy_lb_count                                                    :         136  $       17.08 $
> >    busy_lb_balanced                                                 :         131  $       17.73 $
> >    busy_lb_failed                                                   :           0  $        0.00 $
> >    busy_lb_imbalance_load                                           :          58
> >    busy_lb_imbalance_util                                           :           0
> >    busy_lb_imbalance_task                                           :           0
> >    busy_lb_imbalance_misfit                                         :           0
> >    busy_lb_gained                                                   :           7
> >    busy_lb_hot_gained                                               :           0
> >    busy_lb_nobusyq                                                  :           2  $     1161.50 $
> >    busy_lb_nobusyg                                                  :         129  $       18.01 $
> >    *busy_lb_success_count                                           :           5
> >    *busy_lb_avg_pulled                                              :        1.40
> >    ----------------------------------------- <Category idle> ------------------------------------------
> >    idle_lb_count                                                    :         449  $        5.17 $
> >    idle_lb_balanced                                                 :         382  $        6.08 $
> >    idle_lb_failed                                                   :           3  $      774.33 $
> >    idle_lb_imbalance_load                                           :           0
> >    idle_lb_imbalance_util                                           :           0
> >    idle_lb_imbalance_task                                           :          71
> >    idle_lb_imbalance_misfit                                         :           0
> >    idle_lb_gained                                                   :          67
> >    idle_lb_hot_gained                                               :           0
> >    idle_lb_nobusyq                                                  :           0  $        0.00 $
> >    idle_lb_nobusyg                                                  :         382  $        6.08 $
> >    *idle_lb_success_count                                           :          64
> >    *idle_lb_avg_pulled                                              :        1.05
> >    ---------------------------------------- <Category newidle> ----------------------------------------
> >    newidle_lb_count                                                 :       30471  $        0.08 $
> >    newidle_lb_balanced                                              :       28490  $        0.08 $
> >    newidle_lb_failed                                                :         633  $        3.67 $
> >    newidle_lb_imbalance_load                                        :           0
> >    newidle_lb_imbalance_util                                        :           0
> >    newidle_lb_imbalance_task                                        :        2040
> >    newidle_lb_imbalance_misfit                                      :           0
> >    newidle_lb_gained                                                :        1348
> >    newidle_lb_hot_gained                                            :           0
> >    newidle_lb_nobusyq                                               :           6  $      387.17 $
> >    newidle_lb_nobusyg                                               :       26634  $        0.09 $
> >    *newidle_lb_success_count                                        :        1348
> >    *newidle_lb_avg_pulled                                           :        1.00
> >    ----------------------------------------------------------------------------------------------------
> >
> > Consider following line:
> >
> > newidle_lb_balanced                                              :       28490  $        0.08 $
> >
> > While profiling was active, the load-balancer found 28490 times the load
> > needs to be balanced on a newly idle CPU 0. Following value encapsulated
> > inside $ is average jiffies between two events (28490 / 24537 = 0.08).
> >
> > Next are active_load_balance() stats. alb did not trigger while the
> > profiling was active, hence it's all 0s.
> >
> >
> >    --------------------------------- <Category active_load_balance()> ---------------------------------
> >    alb_count                                                        :           0
> >    alb_failed                                                       :           0
> >    alb_pushed                                                       :           0
> >    ----------------------------------------------------------------------------------------------------
> >
> > Next are sched_balance_exec() and sched_balance_fork() stats. They are
> > not used but we kept it in RFC just for legacy purpose. Unless opposed,
> > we plan to remove them in next revision.
> >
> > Next are wakeup statistics. For every domain, the report also shows
> > task-wakeup statistics. Example:
> >
> >    ------------------------------------------ <Wakeup Info> -------------------------------------------
> >    ttwu_wake_remote                                                 :        1590
> >    ttwu_move_affine                                                 :          84
> >    ttwu_move_balance                                                :           0
> >    ----------------------------------------------------------------------------------------------------
> >
> > Same set of stats are reported for each CPU and each domain level.
> >
> > HOW TO INTERPRET THE DIFF
> > -------------------------
> >
> > The `perf sched stats diff` will also start with explaining the columns
> > present in the diff. Then it will show the diff in time in terms of
> > jiffies. The order of the values depends on the order of input data
> > files. Example:
> >
> >    ----------------------------------------------------------------------------------------------------
> >    Time elapsed (in jiffies)                                        :        2763,       2763
> >    ----------------------------------------------------------------------------------------------------
> >
> > Below is the sample representing the difference in cpu and domain stats of
> > two runs. Here third column or the values enclosed in `|...|` shows the
> > percent change between the two. Second and fourth columns shows the
> > side-by-side representions of the corresponding fields from `perf sched
> > stats report`.
> >
> >    ----------------------------------------------------------------------------------------------------
> >    CPU <ALL CPUS SUMMARY>
> >    ----------------------------------------------------------------------------------------------------
> >    DESC                                                                    COUNT1      COUNT2   PCT_CHANG>
> >    ----------------------------------------------------------------------------------------------------
> >    yld_count                                                        :           0,          0  |     0.00>
> >    array_exp                                                        :           0,          0  |     0.00>
> >    sched_count                                                      :      528533,     412573  |   -21.94>
> >    sched_goidle                                                     :      193426,     146082  |   -24.48>
> >    ttwu_count                                                       :      313134,     385975  |    23.26>
> >    ttwu_local                                                       :        1126,       1282  |    13.85>
> >    rq_cpu_time                                                      :  8257200244, 8301250047  |     0.53>
> >    run_delay                                                        :  4728347053, 3997100703  |   -15.47>
> >    pcount                                                           :      335031,     266396  |   -20.49>
> >    ----------------------------------------------------------------------------------------------------
> >
> > Below is the sample of domain stats diff:
> >
> >    ----------------------------------------------------------------------------------------------------
> >    CPU <ALL CPUS SUMMARY>, DOMAIN SMT
> >    ----------------------------------------------------------------------------------------------------
> >    DESC                                                                    COUNT1      COUNT2   PCT_CHANG>
> >    ----------------------------------------- <Category busy> ------------------------------------------
> >    busy_lb_count                                                    :         122,         80  |   -34.43>
> >    busy_lb_balanced                                                 :         115,         76  |   -33.91>
> >    busy_lb_failed                                                   :           1,          3  |   200.00>
> >    busy_lb_imbalance_load                                           :          35,         49  |    40.00>
> >    busy_lb_imbalance_util                                           :           0,          0  |     0.00>
> >    busy_lb_imbalance_task                                           :           0,          0  |     0.00>
> >    busy_lb_imbalance_misfit                                         :           0,          0  |     0.00>
> >    busy_lb_gained                                                   :           7,          2  |   -71.43>
> >    busy_lb_hot_gained                                               :           0,          0  |     0.00>
> >    busy_lb_nobusyq                                                  :           0,          0  |     0.00>
> >    busy_lb_nobusyg                                                  :         115,         76  |   -33.91>
> >    *busy_lb_success_count                                           :           6,          1  |   -83.33>
> >    *busy_lb_avg_pulled                                              :        1.17,       2.00  |    71.43>
> >    ----------------------------------------- <Category idle> ------------------------------------------
> >    idle_lb_count                                                    :         568,        620  |     9.15>
> >    idle_lb_balanced                                                 :         462,        449  |    -2.81>
> >    idle_lb_failed                                                   :          11,         21  |    90.91>
> >    idle_lb_imbalance_load                                           :           0,          0  |     0.00>
> >    idle_lb_imbalance_util                                           :           0,          0  |     0.00>
> >    idle_lb_imbalance_task                                           :         115,        189  |    64.35>
> >    idle_lb_imbalance_misfit                                         :           0,          0  |     0.00>
> >    idle_lb_gained                                                   :         103,        169  |    64.08>
> >    idle_lb_hot_gained                                               :           0,          0  |     0.00>
> >    idle_lb_nobusyq                                                  :           0,          0  |     0.00>
> >    idle_lb_nobusyg                                                  :         462,        449  |    -2.81>
> >    *idle_lb_success_count                                           :          95,        150  |    57.89>
> >    *idle_lb_avg_pulled                                              :        1.08,       1.13  |     3.92>
> >    ---------------------------------------- <Category newidle> ----------------------------------------
> >    newidle_lb_count                                                 :       16961,       3155  |   -81.40>
> >    newidle_lb_balanced                                              :       15646,       2556  |   -83.66>
> >    newidle_lb_failed                                                :         397,        142  |   -64.23>
> >    newidle_lb_imbalance_load                                        :           0,          0  |     0.00>
> >    newidle_lb_imbalance_util                                        :           0,          0  |     0.00>
> >    newidle_lb_imbalance_task                                        :        1376,        655  |   -52.40>
> >    newidle_lb_imbalance_misfit                                      :           0,          0  |     0.00>
> >    newidle_lb_gained                                                :         917,        457  |   -50.16>
> >    newidle_lb_hot_gained                                            :           0,          0  |     0.00>
> >    newidle_lb_nobusyq                                               :           3,          1  |   -66.67>
> >    newidle_lb_nobusyg                                               :       14480,       2103  |   -85.48>
> >    *newidle_lb_success_count                                        :         918,        457  |   -50.22>
> >    *newidle_lb_avg_pulled                                           :        1.00,       1.00  |     0.11>
> >    --------------------------------- <Category active_load_balance()> ---------------------------------
> >    alb_count                                                        :           0,          1  |     0.00>
> >    alb_failed                                                       :           0,          0  |     0.00>
> >    alb_pushed                                                       :           0,          1  |     0.00>
> >    --------------------------------- <Category sched_balance_exec()> ----------------------------------
> >    sbe_count                                                        :           0,          0  |     0.00>
> >    sbe_balanced                                                     :           0,          0  |     0.00>
> >    sbe_pushed                                                       :           0,          0  |     0.00>
> >    --------------------------------- <Category sched_balance_fork()> ----------------------------------
> >    sbf_count                                                        :           0,          0  |     0.00>
> >    sbf_balanced                                                     :           0,          0  |     0.00>
> >    sbf_pushed                                                       :           0,          0  |     0.00>
> >    ------------------------------------------ <Wakeup Info> -------------------------------------------
> >    ttwu_wake_remote                                                 :        2031,       2914  |    43.48>
> >    ttwu_move_affine                                                 :          73,        124  |    69.86>
> >    ttwu_move_balance                                                :           0,          0  |     0.00>
> >    ----------------------------------------------------------------------------------------------------
> >
> > v3: https://lore.kernel.org/all/20250311120230.61774-1-swapnil.sapkal@amd.com/
> > v3->v4:
> >   - All the review comments from v3 are addressed [Namhyung Kim].
> >   - Print short names instead of field descripion in the report [Peter Zijlstra]
> >   - Fix the double free issue [Cristian Prundeanu]
> >   - Documentation update related to `perf sched stats diff` [Chen yu]
> >   - Bail out `perf sched stats diff` if perf.data files have different schedstat
> >     versions [Peter Zijlstra]
> >
> > v2: https://lore.kernel.org/all/20241122084452.1064968-1-swapnil.sapkal@amd.com/
> > v2->v3:
> >   - Add perf unit test for basic sched stats functionalities
> >   - Describe new tool, it's usage and interpretation of report data in the
> >     perf-sched man page.
> >   - Add /proc/schedstat version 17 support.
> >
> > v1: https://lore.kernel.org/lkml/20240916164722.1838-1-ravi.bangoria@amd.com
> > v1->v2
> >   - Add the support for `perf sched stats diff`
> >   - Add column header in report for better readability. Use
> >     procfs__mountpoint for consistency. Add hint for enabling
> >     CONFIG_SCHEDSTAT if disabled. [James Clark]
> >   - Use a single header file for both cpu and domain fileds. Change
> >     the layout of structs to minimise the padding. I tried changing
> >     `v15` to `15` in the header files but it was not giving any
> >     benefits so drop the idea. [Namhyung Kim]
> >   - Add tested-by.
> >
> > RFC: https://lore.kernel.org/r/20240508060427.417-1-ravi.bangoria@amd.com
> > RFC->v1:
> >   - [Kernel] Print domain name along with domain number in /proc/schedstat
> >     file.
> >   - s/schedstat/stats/ for the subcommand.
> >   - Record domain name and cpumask details, also show them in report.
> >   - Add CPU filtering capability at record and report time.
> >   - Add /proc/schedstat v16 support.
> >   - Live mode support. Similar to perf stat command, live mode prints the
> >     sched stats on the stdout.
> >   - Add pager support in `perf sched stats report` for better scrolling.
> >   - Some minor cosmetic changes in report output to improve readability.
> >   - Rebase to latest perf-tools-next/perf-tools-next (1de5b5dcb835).
> >
> > TODO:
> >   - perf sched stats records /proc/schedstat which is a CPU and domain
> >     level scheduler statistic. We are planning to add taskstat tool which
> >     reads task stats from procfs and generate scheduler statistic report
> >     at task granularity. this will probably a standalone tool, something
> >     like `perf sched taskstat record/report`.
> >   - Except pre-processor related checkpatch warnings, we have addressed
> >     most of the other possible warnings.
> >   - This version supports diff for two perf.data files captured for same
> >     schedstats version but the target is to show diff for multiple
> >     perf.data files. Plan is to support diff if perf.data files provided
> >     has different schedstat versions.
> >
> > Patches are prepared on v6.17-rc3 (1b237f190eb3).
> >
> > [1] https://youtu.be/lg-9aG2ajA0?t=283
> > [2] https://github.com/AMDESE/sched-scoreboard
> > [3] https://lore.kernel.org/lkml/c50bdbfe-02ce-c1bc-c761-c95f8e216ca0@amd.com/
> > [4] https://lore.kernel.org/lkml/3e32bec6-5e59-c66a-7676-7d15df2c961c@amd.com/
> > [5] https://lore.kernel.org/all/20241122084452.1064968-1-swapnil.sapkal@amd.com/
> > [6] https://lore.kernel.org/lkml/3170d16e-eb67-4db8-a327-eb8188397fdb@amd.com/
> > [7] https://lore.kernel.org/lkml/feb31b6e-6457-454c-a4f3-ce8ad96bf8de@amd.com/
> >
> > Swapnil Sapkal (11):
> >    perf: Add print_separator to util
> >    tools/lib: Add list_is_first()
> >    perf header: Support CPU DOMAIN relation info
> >    perf sched stats: Add record and rawdump support
> >    perf sched stats: Add schedstat v16 support
> >    perf sched stats: Add schedstat v17 support
> >    perf sched stats: Add support for report subcommand
> >    perf sched stats: Add support for live mode
> >    perf sched stats: Add support for diff subcommand
> >    perf sched stats: Add basic perf sched stats test
> >    perf sched stats: Add details in man page
> >
> >   tools/include/linux/list.h                    |   10 +
> >   tools/lib/perf/Documentation/libperf.txt      |    2 +
> >   tools/lib/perf/Makefile                       |    1 +
> >   tools/lib/perf/include/perf/event.h           |   69 ++
> >   tools/lib/perf/include/perf/schedstat-v15.h   |  146 +++
> >   tools/lib/perf/include/perf/schedstat-v16.h   |  146 +++
> >   tools/lib/perf/include/perf/schedstat-v17.h   |  164 +++
> >   tools/perf/Documentation/perf-sched.txt       |  261 ++++-
> >   .../Documentation/perf.data-file-format.txt   |   17 +
> >   tools/perf/builtin-inject.c                   |    3 +
> >   tools/perf/builtin-kwork.c                    |   13 +-
> >   tools/perf/builtin-sched.c                    | 1027 ++++++++++++++++-
> >   tools/perf/tests/shell/perf_sched_stats.sh    |   64 +
> >   tools/perf/util/env.h                         |   16 +
> >   tools/perf/util/event.c                       |   52 +
> >   tools/perf/util/event.h                       |    2 +
> >   tools/perf/util/header.c                      |  304 +++++
> >   tools/perf/util/header.h                      |    6 +
> >   tools/perf/util/session.c                     |   22 +
> >   tools/perf/util/synthetic-events.c            |  196 ++++
> >   tools/perf/util/synthetic-events.h            |    3 +
> >   tools/perf/util/tool.c                        |   18 +
> >   tools/perf/util/tool.h                        |    4 +-
> >   tools/perf/util/util.c                        |   48 +
> >   tools/perf/util/util.h                        |    5 +
> >   25 files changed, 2587 insertions(+), 12 deletions(-)
> >   create mode 100644 tools/lib/perf/include/perf/schedstat-v15.h
> >   create mode 100644 tools/lib/perf/include/perf/schedstat-v16.h
> >   create mode 100644 tools/lib/perf/include/perf/schedstat-v17.h
> >   create mode 100755 tools/perf/tests/shell/perf_sched_stats.sh
> >
>

Powered by blists - more mailing lists

Powered by Openwall GNU/*/Linux Powered by OpenVZ