Re: [PATCH V4 0/5] New metricgroup output in perf stat default mode

From: Ian Rogers
Date: Fri Jun 16 2023 - 01:59:38 EST

Next message: patchwork-bot+netdevbpf: "Re: [PATCH net-next] splice, net: Fix splice_to_socket() to handle pipe bufs larger than a page"
Previous message: Ian Rogers: "Re: [PATCH V4 5/5] perf vendor events arm64: Add default tags for Hisi hip08 L1 metrics"
Next in thread: Liang, Kan: "Re: [PATCH V4 0/5] New metricgroup output in perf stat default mode"
Messages sorted by: [ date ] [ thread ] [ subject ] [ author ]

On Thu, Jun 15, 2023 at 8:14 PM <kan.liang@xxxxxxxxxxxxxxx> wrote:
>
> From: Kan Liang <kan.liang@xxxxxxxxxxxxxxx>
>
> Changes since V3:
> - Move the full name (PMU + metricgroup name) generation from the metric
> code to the output code. (Ian)
> - Add default tags for Hisi hip08 L1 metrics (John)
> - Some patches have been merged. Drop them from the V4.
>
> Changes since V2:
> - Fixes memory leak (Ian)
> (Ian, I cannot reproduce the memory leak on all my machines. Please
> check whether the fix works on your side. Thanks.)
> - Add Reviewed-by tags for several patches.
>
> Changes since V1:
> - Remove EVSEL_EVENT_MASK and use the __evsel__match which is suggested
> by Ian.
> - Support TopdownL1 on both e-core and p-core of ADL in the default
> mode. (Ian)
> - Have separate patches for the modifications of metricgroup and output.
> (Ian)
> - Does 2nd sort for the Default metricgroup. Remove the logic of
> changing the associated metric event. (Ian)
> - Move all the metric related code to stat-shadow (Ian)
> - Move the commong functions between stat+csv_output and stat+std_output
> to the lib directory (Ian)
>
> In the default mode, the current output of the metricgroup include both
> events and metrics, which is not necessary and makes the output hard to
> read. Also, different ARCHs (even different generations of the ARCH) may
> have a different output format because of the different events in a
> metrics.
>
> The patch proposes a new output format which only outputting the value
> of each metric and the metricgroup name. It can brings a clean and
> consistent output format among ARCHs and generations.
>
> The patches 1-2 introduce the new metricgroup output.
>
> The patches 3-4 improve the tests to cover the default mode.
>
> The patch 5 update the event list for Hisi hip08.
>
> Here are some examples for the new output.
>
> STD output:
>
> On SPR
>
> perf stat -a sleep 1
>
> Performance counter stats for 'system wide':
>
> 226,054.13 msec cpu-clock # 224.588 CPUs utilized
> 932 context-switches # 4.123 /sec
> 224 cpu-migrations # 0.991 /sec
> 76 page-faults # 0.336 /sec
> 45,940,682 cycles # 0.000 GHz
> 36,676,047 instructions # 0.80 insn per cycle
> 7,044,516 branches # 31.163 K/sec
> 62,169 branch-misses # 0.88% of all branches
> TopdownL1 # 68.7 % tma_backend_bound
> # 3.1 % tma_bad_speculation
> # 13.0 % tma_frontend_bound
> # 15.2 % tma_retiring
> TopdownL2 # 2.7 % tma_branch_mispredicts
> # 19.6 % tma_core_bound
> # 4.8 % tma_fetch_bandwidth
> # 8.3 % tma_fetch_latency
> # 2.9 % tma_heavy_operations
> # 12.3 % tma_light_operations
> # 0.4 % tma_machine_clears
> # 49.1 % tma_memory_bound
>
> 1.006529767 seconds time elapsed
>
> perf stat -a sleep 1
>
> Performance counter stats for 'system wide':
>
> 32,127.99 msec cpu-clock # 31.992 CPUs utilized
> 240 context-switches # 7.470 /sec
> 32 cpu-migrations # 0.996 /sec
> 74 page-faults # 2.303 /sec
> 6,313,960 cpu_core/cycles/ # 0.000 GHz
> 257,711,907 cpu_atom/cycles/ # 0.008 GHz (54.18%)
> 4,477,162 cpu_core/instructions/ # 0.71 insn per cycle
> 37,721,481 cpu_atom/instructions/ # 5.97 insn per cycle (63.33%)
> 809,747 cpu_core/branches/ # 25.204 K/sec
> 6,621,226 cpu_atom/branches/ # 206.089 K/sec (63.32%)
> 39,667 cpu_core/branch-misses/ # 4.90% of all branches
> 1,032,146 cpu_atom/branch-misses/ # 127.47% of all branches (63.33%)
> TopdownL1 (cpu_core) # nan % tma_backend_bound
> # 0.0 % tma_bad_speculation
> # nan % tma_frontend_bound
> # nan % tma_retiring
> TopdownL1 (cpu_atom) # 13.6 % tma_bad_speculation (63.36%)
> # 41.1 % tma_frontend_bound (63.54%)
> # 39.2 % tma_backend_bound
> # 39.2 % tma_backend_bound_aux (63.93%)
> # 5.4 % tma_retiring (64.15%)
>
> 1.004244114 seconds time elapsed
>
> JSON output
>
> on SPR
>
> perf stat --json -a sleep 1
> {"counter-value" : "225904.823297", "unit" : "msec", "event" : "cpu-clock", "event-runtime" : 225904323425, "pcnt-running" : 100.00, "metric-value" : "224.456872", "metric-unit" : "CPUs utilized"}
> {"counter-value" : "986.000000", "unit" : "", "event" : "context-switches", "event-runtime" : 225904108985, "pcnt-running" : 100.00, "metric-value" : "4.364670", "metric-unit" : "/sec"}
> {"counter-value" : "224.000000", "unit" : "", "event" : "cpu-migrations", "event-runtime" : 225904016141, "pcnt-running" : 100.00, "metric-value" : "0.991568", "metric-unit" : "/sec"}
> {"counter-value" : "76.000000", "unit" : "", "event" : "page-faults", "event-runtime" : 225903913270, "pcnt-running" : 100.00, "metric-value" : "0.336425", "metric-unit" : "/sec"}
> {"counter-value" : "48433482.000000", "unit" : "", "event" : "cycles", "event-runtime" : 225903792732, "pcnt-running" : 100.00, "metric-value" : "0.000214", "metric-unit" : "GHz"}
> {"counter-value" : "38620409.000000", "unit" : "", "event" : "instructions", "event-runtime" : 225903657830, "pcnt-running" : 100.00, "metric-value" : "0.797391", "metric-unit" : "insn per cycle"}
> {"counter-value" : "7369473.000000", "unit" : "", "event" : "branches", "event-runtime" : 225903464328, "pcnt-running" : 100.00, "metric-value" : "32.622026", "metric-unit" : "K/sec"}
> {"counter-value" : "54747.000000", "unit" : "", "event" : "branch-misses", "event-runtime" : 225903234523, "pcnt-running" : 100.00, "metric-value" : "0.742889", "metric-unit" : "of all branches"}
> {"event-runtime" : 225902840555, "pcnt-running" : 100.00, "metricgroup" : "TopdownL1"}
> {"metric-value" : "69.950631", "metric-unit" : "% tma_backend_bound"}
> {"metric-value" : "2.771783", "metric-unit" : "% tma_bad_speculation"}
> {"metric-value" : "12.026074", "metric-unit" : "% tma_frontend_bound"}
> {"metric-value" : "15.251513", "metric-unit" : "% tma_retiring"}
> {"event-runtime" : 225902840555, "pcnt-running" : 100.00, "metricgroup" : "TopdownL2"}
> {"metric-value" : "2.351757", "metric-unit" : "% tma_branch_mispredicts"}
> {"metric-value" : "19.729771", "metric-unit" : "% tma_core_bound"}
> {"metric-value" : "4.555207", "metric-unit" : "% tma_fetch_bandwidth"}
> {"metric-value" : "7.470867", "metric-unit" : "% tma_fetch_latency"}
> {"metric-value" : "2.938808", "metric-unit" : "% tma_heavy_operations"}
> {"metric-value" : "12.312705", "metric-unit" : "% tma_light_operations"}
> {"metric-value" : "0.420026", "metric-unit" : "% tma_machine_clears"}
> {"metric-value" : "50.220860", "metric-unit" : "% tma_memory_bound"}
>
> On hybrid
>
> perf stat --json -a sleep 1
> {"counter-value" : "32131.530625", "unit" : "msec", "event" : "cpu-clock", "event-runtime" : 32131536951, "pcnt-running" : 100.00, "metric-value" : "31.992642", "metric-unit" : "CPUs utilized"}
> {"counter-value" : "328.000000", "unit" : "", "event" : "context-switches", "event-runtime" : 32131525778, "pcnt-running" : 100.00, "metric-value" : "10.208042", "metric-unit" : "/sec"}
> {"counter-value" : "32.000000", "unit" : "", "event" : "cpu-migrations", "event-runtime" : 32131515104, "pcnt-running" : 100.00, "metric-value" : "0.995906", "metric-unit" : "/sec"}
> {"counter-value" : "353.000000", "unit" : "", "event" : "page-faults", "event-runtime" : 32131501396, "pcnt-running" : 100.00, "metric-value" : "10.986094", "metric-unit" : "/sec"}
> {"counter-value" : "18685492.000000", "unit" : "", "event" : "cpu_core/cycles/", "event-runtime" : 16061585292, "pcnt-running" : 100.00, "metric-value" : "0.000582", "metric-unit" : "GHz"}
> {"counter-value" : "255620352.000000", "unit" : "", "event" : "cpu_atom/cycles/", "event-runtime" : 8690268422, "pcnt-running" : 54.00, "metric-value" : "0.007955", "metric-unit" : "GHz"}
> {"counter-value" : "15489913.000000", "unit" : "", "event" : "cpu_core/instructions/", "event-runtime" : 16061582200, "pcnt-running" : 100.00, "metric-value" : "0.828981", "metric-unit" : "insn per cycle"}
> {"counter-value" : "38790161.000000", "unit" : "", "event" : "cpu_atom/instructions/", "event-runtime" : 10163133324, "pcnt-running" : 63.00, "metric-value" : "2.075951", "metric-unit" : "insn per cycle"}
> {"counter-value" : "2908031.000000", "unit" : "", "event" : "cpu_core/branches/", "event-runtime" : 16061563416, "pcnt-running" : 100.00, "metric-value" : "90.503967", "metric-unit" : "K/sec"}
> {"counter-value" : "6814948.000000", "unit" : "", "event" : "cpu_atom/branches/", "event-runtime" : 10161711336, "pcnt-running" : 63.00, "metric-value" : "212.095343", "metric-unit" : "K/sec"}
> {"counter-value" : "97638.000000", "unit" : "", "event" : "cpu_core/branch-misses/", "event-runtime" : 16061535261, "pcnt-running" : 100.00, "metric-value" : "3.357530", "metric-unit" : "of all branches"}
> {"counter-value" : "1017066.000000", "unit" : "", "event" : "cpu_atom/branch-misses/", "event-runtime" : 10159971797, "pcnt-running" : 63.00, "metric-value" : "34.974386", "metric-unit" : "of all branches"}
> {"event-runtime" : 16061513607, "pcnt-running" : 100.00, "metricgroup" : "TopdownL1 (cpu_core)"}
> {"metric-value" : "nan", "metric-unit" : "% tma_backend_bound"}
> {"metric-value" : "0.000000", "metric-unit" : "% tma_bad_speculation"}
> {"metric-value" : "nan", "metric-unit" : "% tma_frontend_bound"}
> {"metric-value" : "nan", "metric-unit" : "% tma_retiring"}
> {"event-runtime" : 10157398501, "pcnt-running" : 63.00, "metricgroup" : "TopdownL1 (cpu_atom)"}
> {"metric-value" : "13.719821", "metric-unit" : "% tma_bad_speculation"}
> {"event-runtime" : 10178698656, "pcnt-running" : 63.00, "metric-value" : "41.016738", "metric-unit" : "% tma_frontend_bound"}
> {"event-runtime" : 10240582902, "pcnt-running" : 63.00, "metric-value" : "39.327764", "metric-unit" : "% tma_backend_bound"}
> {"metric-value" : "39.327764", "metric-unit" : "% tma_backend_bound_aux"}
> {"event-runtime" : 10284284920, "pcnt-running" : 64.00, "metric-value" : "5.374638", "metric-unit" : "% tma_retiring"}
>
> CSV output
>
> On SPR
>
> perf stat -x, -a sleep 1
> 225851.20,msec,cpu-clock,225850700108,100.00,224.431,CPUs utilized
> 976,,context-switches,225850504803,100.00,4.321,/sec
> 224,,cpu-migrations,225850410336,100.00,0.992,/sec
> 76,,page-faults,225850304155,100.00,0.337,/sec
> 52288305,,cycles,225850188531,100.00,0.000,GHz
> 37977214,,instructions,225850071251,100.00,0.73,insn per cycle
> 7299859,,branches,225849890722,100.00,32.322,K/sec
> 51102,,branch-misses,225849672536,100.00,0.70,of all branches
> ,225849327050,100.00,,,,TopdownL1
> ,,,,,70.1,% tma_backend_bound
> ,,,,,2.7,% tma_bad_speculation
> ,,,,,12.5,% tma_frontend_bound
> ,,,,,14.6,% tma_retiring
> ,225849327050,100.00,,,,TopdownL2
> ,,,,,2.3,% tma_branch_mispredicts
> ,,,,,19.6,% tma_core_bound
> ,,,,,4.6,% tma_fetch_bandwidth
> ,,,,,7.9,% tma_fetch_latency
> ,,,,,2.9,% tma_heavy_operations
> ,,,,,11.7,% tma_light_operations
> ,,,,,0.5,% tma_machine_clears
> ,,,,,50.5,% tma_memory_bound
>
> On Hybrid
>
> perf stat -x, -a sleep 1
> 32139.34,msec,cpu-clock,32139351409,100.00,32.001,CPUs utilized
> 225,,context-switches,32139342672,100.00,7.001,/sec
> 32,,cpu-migrations,32139337772,100.00,0.996,/sec
> 72,,page-faults,32139328384,100.00,2.240,/sec
> 6766433,,cpu_core/cycles/,16067551558,100.00,0.000,GHz
> 256500230,,cpu_atom/cycles/,8695757391,54.00,0.008,GHz
> 4688595,,cpu_core/instructions/,16067558976,100.00,0.69,insn per cycle
> 37487490,,cpu_atom/instructions/,10165193856,63.00,5.54,insn per cycle
> 845211,,cpu_core/branches/,16067540225,100.00,26.298,K/sec
> 6571193,,cpu_atom/branches/,10155940853,63.00,204.459,K/sec
> 41359,,cpu_core/branch-misses/,16067516493,100.00,4.89,of all branches
> 1020231,,cpu_atom/branch-misses/,10159363620,63.00,120.71,of all branches
> ,16067494476,100.00,,,,TopdownL1 (cpu_core)
> ,,,,,,% tma_backend_bound
> ,,,,,0.0,% tma_bad_speculation
> ,,,,,,% tma_frontend_bound
> ,,,,,,% tma_retiring
> ,10160989992,63.00,,,,TopdownL1 (cpu_atom)
> ,,,,,13.8,% tma_bad_speculation
> ,10188319019,63.00,,,41.3,% tma_frontend_bound
> ,10258326591,63.00,,,38.6,% tma_backend_bound
> ,,,,,38.6,% tma_backend_bound_aux
> ,10282689488,64.00,,,5.4,% tma_retiring
>
> Kan Liang (5):
> perf metrics: Sort the Default metricgroup
> perf stat: New metricgroup output for the default mode
> perf test: Move all the check functions of stat csv output to lib
> perf test: Add test case for the standard perf stat output
> perf vendor events arm64: Add default tags for Hisi hip08 L1 metrics

Just to be clear, I'm happy with this to be submitted having put
reviewed/acked-by on it.

Thanks,
Ian

> tools/perf/builtin-stat.c | 1 +
> .../arch/arm64/hisilicon/hip08/metrics.json | 12 +-
> tools/perf/tests/shell/lib/stat_output.sh | 169 ++++++++++++++++
> tools/perf/tests/shell/stat+csv_output.sh | 188 ++----------------
> tools/perf/tests/shell/stat+std_output.sh | 108 ++++++++++
> tools/perf/util/evsel.h | 1 +
> tools/perf/util/metricgroup.c | 26 +++
> tools/perf/util/metricgroup.h | 3 +
> tools/perf/util/stat-display.c | 108 +++++++++-
> tools/perf/util/stat-shadow.c | 131 ++++++++++--
> tools/perf/util/stat.h | 15 ++
> 11 files changed, 563 insertions(+), 199 deletions(-)
> create mode 100755 tools/perf/tests/shell/lib/stat_output.sh
> create mode 100755 tools/perf/tests/shell/stat+std_output.sh
>
> --
> 2.35.1
>

Next message: patchwork-bot+netdevbpf: "Re: [PATCH net-next] splice, net: Fix splice_to_socket() to handle pipe bufs larger than a page"
Previous message: Ian Rogers: "Re: [PATCH V4 5/5] perf vendor events arm64: Add default tags for Hisi hip08 L1 metrics"
Next in thread: Liang, Kan: "Re: [PATCH V4 0/5] New metricgroup output in perf stat default mode"
Messages sorted by: [ date ] [ thread ] [ subject ] [ author ]