[LTP] [next] WARNING: CPU: 0 PID: 0 at kernel/trace/trace_events.c:417 trace_event_raw_init

[Naresh Kamboju]

[Please ignore this report if it is already reported]

Following kernel WARNING: reported while boot linux next 20220125 tag
on qemu_arm64.
While testing LTP ftrace the following kernel WARNING: noticed.

[    0.000000] ------------[ cut here ]------------
[    0.000000] WARNING: CPU: 0 PID: 0 at
kernel/trace/trace_events.c:417 trace_event_raw_init+0x490/0x4ec
[    0.000000] Modules linked in:
[    0.000000] CPU: 0 PID: 0 Comm: swapper/0 Not tainted
5.17.0-rc1-next-20220125 #1
[    0.000000] Hardware name: linux,dummy-virt (DT)
[    0.000000] pstate: 600000c5 (nZCv daIF -PAN -UAO -TCO -DIT -SSBS BTYPE=--)
[    0.000000] pc : trace_event_raw_init+0x490/0x4ec
[    0.000000] lr : trace_event_raw_init+0x250/0x4ec
[    0.000000] sp : ffffc91900963d30
[    0.000000] x29: ffffc91900963d30 x28: 0000000000000005 x27: 0000000000000000
[    0.000000] x26: 0000000000000003 x25: ffffc918ff56c8e8 x24: ffffc918ffc57bf8
[    0.000000] x23: 0000000000000001 x22: ffffc91900d4bf18 x21: 0000000000000000
[    0.000000] x20: ffffc91900d44fa8 x19: 0000000000000251 x18: 00000000ffffffff
[    0.000000] x17: 000000000000003f x16: 0000000000000009 x15: ffffffffffffffff
[    0.000000] x14: 0000000000000000 x13: ffffffffffffffff x12: 0000000000000028
[    0.000000] x11: 0101010101010101 x10: 0000000000000403 x9 : ffffc918fe3d2600
[    0.000000] x8 : 0101010101010101 x7 : 7f7f7f7f7f7f7f7f x6 : fefefefefefeff28
[    0.000000] x5 : 000000000000003e x4 : 0000000000000008 x3 : 0000000000000000
[    0.000000] x2 : 000000000000023f x1 : 0000000000000000 x0 : 0000000000000000
[    0.000000] Call trace:
[    0.000000]  trace_event_raw_init+0x490/0x4ec
[    0.000000]  event_init+0x38/0xb0
[    0.000000]  trace_event_init+0x9c/0x2ac
[    0.000000]  trace_init+0x10/0x1c
[    0.000000]  start_kernel+0x474/0x710
[    0.000000]  __primary_switched+0xc0/0xc8
[    0.000000] ---[ end trace 0000000000000000 ]---

and
Running tests.......
[    6.791530] ------------[ ftrace bug ]------------
[    6.791941] ftrace faulted on modifying
[    6.791943] [<ffffc918fff403fc>] set_reset_devices+0x8/0x24
[    6.792681] Setting ftrace call site to call ftrace function
[    6.793111] ftrace record flags: 80000001
[    6.793384]  (1)
[    6.793384]  expected tramp: ffffc918fe22bd20
[    6.793868] ------------[ cut here ]------------
[    6.794212] WARNING: CPU: 1 PID: 468 at kernel/trace/ftrace.c:2068
ftrace_bug+0x280/0x2b0
[    6.794879] Modules linked in: rfkill crct10dif_ce fuse
[    6.795300] CPU: 1 PID: 468 Comm: ftrace_regressi Tainted: G
W         5.17.0-rc1-next-20220125 #1
[    6.796074] Hardware name: linux,dummy-virt (DT)
[    6.796453] pstate: 60400005 (nZCv daif +PAN -UAO -TCO -DIT -SSBS BTYPE=--)
[    6.797016] pc : ftrace_bug+0x280/0x2b0
[    6.797331] lr : ftrace_bug+0x280/0x2b0
[    6.797649] sp : ffff8000088a3af0
[    6.797921] x29: ffff8000088a3af0 x28: ffff0000c1b2a000 x27: 0000000000000000
[    6.798507] x26: 0000000000000000 x25: ffff8000088a3d40 x24: ffffc91900e24000
[    6.799090] x23: 00000000fffffff2 x22: ffffc918ffc46248 x21: ffffc9190096ecc8
[    6.799670] x20: ffff0000c0080030 x19: ffffc9190096e000 x18: ffffffffffffffff
[    6.800242] x17: 0000000000000000 x16: 0000000000000000 x15: ffff8000888a3817
[    6.800815] x14: 0000000000000000 x13: 3032646232326566 x12: 3831396366666666
[    6.801398] x11: 203a706d61727420 x10: ffffc91900991ba0 x9 : ffffc918fe31bbc4
[    6.801979] x8 : 00000000ffffefff x7 : ffffc919009e9ba0 x6 : 0000000000000001
[    6.802557] x5 : ffffc9190096f000 x4 : ffffc9190096f280 x3 : 0000000000000000
[    6.803138] x2 : 0000000000000000 x1 : ffff0000c1b2a000 x0 : 0000000000000022
[    6.803700] Call trace:
[    6.803899]  ftrace_bug+0x280/0x2b0
[    6.804185]  ftrace_replace_code+0x94/0xa0
[    6.804523]  ftrace_modify_all_code+0xe0/0x14c
[    6.804886]  arch_ftrace_update_code+0x14/0x20
[    6.805255]  ftrace_run_update_code+0x24/0x7c
[    6.805611]  ftrace_startup+0xf4/0x1b0
[    6.805919]  register_ftrace_function+0x38/0x90
[    6.806290]  stack_trace_sysctl+0xa0/0x190
[    6.806630]  proc_sys_call_handler+0x18c/0x250
[    6.806993]  proc_sys_write+0x20/0x30
[    6.807295]  new_sync_write+0xf0/0x18c
[    6.807607]  vfs_write+0x244/0x2b0
[    6.807889]  ksys_write+0x74/0x100
[    6.808168]  __arm64_sys_write+0x28/0x3c
[    6.808491]  invoke_syscall+0x50/0x120
[    6.808800]  el0_svc_common.constprop.0+0x104/0x124
[    6.809427]  do_el0_svc+0x34/0x9c
[    6.809703]  el0_svc+0x2c/0x90
[    6.809961]  el0t_64_sync_handler+0xa4/0x130
[    6.810318]  el0t_64_sync+0x1a0/0x1a4
[    6.810617] ---[ end trace 0000000000000000 ]---

Reported-by: Linux Kernel Functional Testing <lkft@linaro.org>

ref:
  - https://qa-reports.linaro.org/lkft/linux-next-master/build/next-20220125/testrun/7535055/suite/linux-log-parser/test/check-kernel-warning-4390834/log
  - https://lkft.validation.linaro.org/scheduler/job/4390834#L282

metadata:
  git branch: master
  git repo: https://gitlab.com/Linaro/lkft/mirrors/next/linux-next
  git describe: next-20220125
  kernel-config: https://builds.tuxbuild.com/24B14LVWVfE8GOgox8KftnlXxPf/config


--
Linaro LKFT
https://lkft.linaro.org