* [jimc:dd-drm-fix] [drm] e2a703d652: WARNING:suspicious_RCU_usage
@ 2025-11-12 2:55 kernel test robot
0 siblings, 0 replies; only message in thread
From: kernel test robot @ 2025-11-12 2:55 UTC (permalink / raw)
To: Jim Cromie, Łukasz Bartosik; +Cc: oe-lkp, lkp, oliver.sang
[-- Attachment #1: Type: text/plain, Size: 15157 bytes --]
hi, Jim,
this report is just FYI.
for parent commit
f8241f5267959 drm-dyndbg: DRM_CLASSMAP_USE in drm_crtc_helper
we actuall observe seemingly more severe issues, that crash early.
=========================================================================================
tbox_group/testcase/rootfs/kconfig/compiler/runtime/group/nr_groups:
vm-snb/trinity/yocto-i386-minimal-20190520.cgz/i386-randconfig-015-20251110/clang-20/300s/group-03/5
f8241f526795939e e2a703d65295b8bce9b8a7e4663
---------------- ---------------------------
fail:runs %reproduction fail:runs
| | |
6:6 -100% :6 dmesg.BUG:kernel_NULL_pointer_dereference,address
6:6 -100% :6 dmesg.EIP:ddebug_condense_sites
6:6 -100% :6 dmesg.Kernel_panic-not_syncing:Fatal_exception
6:6 -100% :6 dmesg.Oops
:6 100% 6:6 dmesg.WARNING:suspicious_RCU_usage
:6 100% 6:6 dmesg.lib/maple_tree.c:#suspicious_rcu_dereference_check()usage
one dmesg is attached as dmesg-f8241f5267.xz
[ 0.405069][ T1] Performance Events: unsupported CPU family 6 model 42 no PMU driver, software events only.
[ 0.406705][ T1] signal: max sigframe size: 1760
[ 0.407679][ T1] BUG: kernel NULL pointer dereference, address: 00000004
[ 0.408501][ T1] #PF: supervisor read access in kernel mode
[ 0.409175][ T1] #PF: error_code(0x0000) - not-present page
[ 0.409860][ T1] *pdpt = 0000000000000000 *pde = f000ff53f000ff53
[ 0.410580][ T1] Oops: Oops: 0000 [#1] PTI
[ 0.411093][ T1] CPU: 0 UID: 0 PID: 1 Comm: swapper/0 Not tainted 6.17.0-00058-gf8241f526795 #1 PREEMPTLAZY
[ 0.411135][ T1] EIP: ddebug_condense_sites+0x76/0x4c0
[ 0.411135][ T1] Code: 89 d3 89 d7 eb 22 90 90 90 90 90 90 90 90 90 90 90 90 90 90 ff 45 e0 89 fa 83 c7 18 83 c3 18 3b 7d e8 0f 83 83 00 00 00 8b 02 <8b> 70 04 8b 07 3b 70 04 74 e5 8d 4b e8 83 3d f0 3f 94 8c 03 7d 2d
[ 0.411135][ T1] EAX: 00000000 EBX: 8c0bcb14 ECX: 811a5c7c EDX: 8c0bcb14
[ 0.411135][ T1] ESI: 8c1e3d04 EDI: 8c0bcb14 EBP: 811a5c28 ESP: 811a5c00
[ 0.411135][ T1] DS: 007b ES: 007b FS: 0000 GS: 0000 SS: 0068 EFLAGS: 00010287
[ 0.411135][ T1] CR0: 80050033 CR2: 00000004 CR3: 0c1f8000 CR4: 000406b0
[ 0.411135][ T1] Call Trace:
[ 0.411135][ T1] ? up_write+0xc6/0x180
[ 0.411135][ T1] dynamic_debug_init+0xaa/0x210
[ 0.411135][ T1] ? _raw_spin_unlock_irqrestore+0x58/0x94
[ 0.411135][ T1] ? add_device_randomness+0x57/0x80
[ 0.411135][ T1] ? trace_preempt_on+0xf/0x50
[ 0.411135][ T1] ? _raw_spin_unlock_irqrestore+0x58/0x94
[ 0.411135][ T1] ? preempt_count_sub+0x7b/0xe0
[ 0.411135][ T1] do_one_initcall+0xb0/0x2c0
[ 0.411135][ T1] ? dyndbg_setup+0x8/0x8
[ 0.411135][ T1] ? kvm_sched_clock_read+0xd/0x1c
[ 0.411135][ T1] ? sched_clock_noinstr+0x8/0xc
[ 0.411135][ T1] ? local_clock_noinstr+0x38/0x120
[ 0.411135][ T1] ? kvm_sched_clock_read+0xd/0x1c
[ 0.411135][ T1] ? sched_clock_noinstr+0x8/0xc
[ 0.411135][ T1] ? kvm_sched_clock_read+0xd/0x1c
[ 0.411135][ T1] ? local_clock_noinstr+0x38/0x120
[ 0.411135][ T1] ? kvm_sched_clock_read+0xd/0x1c
[ 0.411135][ T1] ? sched_clock_noinstr+0x8/0xc
[ 0.411135][ T1] ? local_clock_noinstr+0x38/0x120
[ 0.411135][ T1] ? __lock_acquire+0x564/0x2a40
[ 0.411135][ T1] ? kvm_sched_clock_read+0xd/0x1c
[ 0.411135][ T1] ? sched_clock_noinstr+0x8/0xc
[ 0.411135][ T1] ? local_clock_noinstr+0x38/0x120
[ 0.411135][ T1] ? __this_cpu_preempt_check+0xf/0x17
[ 0.411135][ T1] ? _raw_spin_unlock+0x27/0x40
[ 0.411135][ T1] ? __register_sysctl_table+0x5bc/0x600
[ 0.411135][ T1] ? trace_preempt_on+0xf/0x50
[ 0.411135][ T1] ? _raw_spin_unlock+0x27/0x40
[ 0.411135][ T1] ? preempt_count_sub+0x7b/0xe0
[ 0.411135][ T1] ? _raw_spin_unlock+0x27/0x40
[ 0.411135][ T1] ? __register_sysctl_table+0x5bc/0x600
[ 0.411135][ T1] ? rest_init+0xfc/0xfc
[ 0.411135][ T1] do_pre_smp_initcalls+0x2a/0x6c
[ 0.411135][ T1] ? rest_init+0xfc/0xfc
[ 0.411135][ T1] kernel_init_freeable+0x52/0xcc
[ 0.411135][ T1] kernel_init+0x17/0x128
[ 0.411135][ T1] ret_from_fork+0x137/0x1e0
[ 0.411135][ T1] ? rest_init+0xfc/0xfc
[ 0.411135][ T1] ret_from_fork_asm+0x12/0x18
[ 0.411135][ T1] entry_INT80_32+0x107/0x107
[ 0.411135][ T1] Modules linked in:
[ 0.411135][ T1] CR2: 0000000000000004
[ 0.411135][ T1] ---[ end trace 0000000000000000 ]---
[ 0.411135][ T1] EIP: ddebug_condense_sites+0x76/0x4c0
[ 0.411135][ T1] Code: 89 d3 89 d7 eb 22 90 90 90 90 90 90 90 90 90 90 90 90 90 90 ff 45 e0 89 fa 83 c7 18 83 c3 18 3b 7d e8 0f 83 83 00 00 00 8b 02 <8b> 70 04 8b 07 3b 70 04 74 e5 8d 4b e8 83 3d f0 3f 94 8c 03 7d 2d
[ 0.411135][ T1] EAX: 00000000 EBX: 8c0bcb14 ECX: 811a5c7c EDX: 8c0bcb14
[ 0.411135][ T1] ESI: 8c1e3d04 EDI: 8c0bcb14 EBP: 811a5c28 ESP: 811a5c00
[ 0.411135][ T1] DS: 007b ES: 007b FS: 0000 GS: 0000 SS: 0068 EFLAGS: 00010287
[ 0.411135][ T1] CR0: 80050033 CR2: 00000004 CR3: 0c1f8000 CR4: 000406b0
[ 0.411135][ T1] Kernel panic - not syncing: Fatal exception
we don't have enough knowledge if e2a703d652 is just the fix of above issue.
since now kernel will not crash but show "WARNING:suspicious_RCU_usage" still
in very early time, we just make out this report FYI what we observed in our
tests.
Hello,
kernel test robot noticed "WARNING:suspicious_RCU_usage" on:
commit: e2a703d65295b8bce9b8a7e4663c409fa25bd194 ("drm-dyndbg: DRM_CLASSMAP_USE in drm_dp_helper")
https://github.com/jimc/linux.git dd-drm-fix
in testcase: trinity
version:
with following parameters:
runtime: 300s
group: group-03
nr_groups: 5
config: i386-randconfig-015-20251110
compiler: clang-20
test machine: qemu-system-x86_64 -enable-kvm -cpu SandyBridge -smp 2 -m 32G
(please refer to attached dmesg/kmsg for entire log/backtrace)
If you fix the issue in a separate patch/commit (i.e. not just a new version of
the same patch/commit), kindly add following tags
| Reported-by: kernel test robot <oliver.sang@intel.com>
| Closes: https://lore.kernel.org/oe-lkp/202511111514.ecbaaa39-lkp@intel.com
[ 0.526141][ T1] WARNING: suspicious RCU usage
[ 0.527180][ T1] 6.17.0-00059-ge2a703d65295 #1 Not tainted
[ 0.528409][ T1] -----------------------------
[ 0.529086][ T1] lib/maple_tree.c:844 suspicious rcu_dereference_check() usage!
[ 0.530839][ T1]
[ 0.530839][ T1] other info that might help us debug this:
[ 0.530839][ T1]
[ 0.533092][ T1]
[ 0.533092][ T1] rcu_scheduler_active = 2, debug_locks = 1
[ 0.534816][ T1] no locks held by swapper/0/1.
[ 0.535841][ T1]
[ 0.535841][ T1] stack backtrace:
[ 0.537088][ T1] CPU: 0 UID: 0 PID: 1 Comm: swapper/0 Not tainted 6.17.0-00059-ge2a703d65295 #1 PREEMPTLAZY
[ 0.539384][ T1] Call Trace:
[ 0.540260][ T1] __dump_stack (lib/dump_stack.c:95)
[ 0.541066][ T1] dump_stack_lvl (lib/dump_stack.c:123 (discriminator 3))
[ 0.541066][ T1] dump_stack (lib/dump_stack.c:129)
[ 0.541066][ T1] lockdep_rcu_suspicious (kernel/locking/lockdep.c:6877)
[ 0.541066][ T1] mas_start (lib/maple_tree.c:?)
[ 0.541066][ T1] mas_find (lib/maple_tree.c:284 lib/maple_tree.c:3630 lib/maple_tree.c:4939 lib/maple_tree.c:6018 lib/maple_tree.c:6058)
[ 0.541066][ T1] dynamic_debug_init (lib/dynamic_debug.c:1972 (discriminator 1))
[ 0.541066][ T1] ? _raw_spin_unlock_irqrestore (arch/x86/include/asm/preempt.h:104 include/linux/spinlock_api_smp.h:152 kernel/locking/spinlock.c:194)
[ 0.541066][ T1] do_one_initcall (init/main.c:1269)
[ 0.541066][ T1] ? dyndbg_setup (lib/dynamic_debug.c:1931)
[ 0.541066][ T1] ? kvm_sched_clock_read (arch/x86/kernel/kvmclock.c:91)
[ 0.541066][ T1] ? sched_clock_noinstr (arch/x86/kernel/tsc.c:271)
[ 0.541066][ T1] ? local_clock_noinstr (kernel/sched/clock.c:272 kernel/sched/clock.c:309)
[ 0.541066][ T1] ? kvm_sched_clock_read (arch/x86/kernel/kvmclock.c:91)
[ 0.541066][ T1] ? sched_clock_noinstr (arch/x86/kernel/tsc.c:271)
[ 0.541066][ T1] ? kvm_sched_clock_read (arch/x86/kernel/kvmclock.c:91)
[ 0.541066][ T1] ? local_clock_noinstr (kernel/sched/clock.c:272 kernel/sched/clock.c:309)
[ 0.541066][ T1] ? kvm_sched_clock_read (arch/x86/kernel/kvmclock.c:91)
[ 0.541066][ T1] ? sched_clock_noinstr (arch/x86/kernel/tsc.c:271)
[ 0.541066][ T1] ? local_clock_noinstr (kernel/sched/clock.c:272 kernel/sched/clock.c:309)
[ 0.541066][ T1] ? __lock_acquire (kernel/locking/lockdep.c:4674)
[ 0.541066][ T1] ? kvm_sched_clock_read (arch/x86/kernel/kvmclock.c:91)
[ 0.541066][ T1] ? sched_clock_noinstr (arch/x86/kernel/tsc.c:271)
[ 0.541066][ T1] ? local_clock_noinstr (kernel/sched/clock.c:272 kernel/sched/clock.c:309)
[ 0.541066][ T1] ? __this_cpu_preempt_check (lib/smp_processor_id.c:65)
[ 0.541066][ T1] ? _raw_spin_unlock (arch/x86/include/asm/preempt.h:104 include/linux/spinlock_api_smp.h:143 kernel/locking/spinlock.c:186)
[ 0.541066][ T1] ? __register_sysctl_table (fs/proc/proc_sysctl.c:1399)
[ 0.541066][ T1] ? trace_preempt_on (kernel/trace/trace_preemptirq.c:122)
[ 0.541066][ T1] ? _raw_spin_unlock (arch/x86/include/asm/preempt.h:104 include/linux/spinlock_api_smp.h:143 kernel/locking/spinlock.c:186)
[ 0.541066][ T1] ? preempt_count_sub (arch/x86/include/asm/preempt.h:85 (discriminator 1) kernel/sched/core.c:5864 (discriminator 1))
[ 0.541066][ T1] ? _raw_spin_unlock (arch/x86/include/asm/preempt.h:104 include/linux/spinlock_api_smp.h:143 kernel/locking/spinlock.c:186)
[ 0.541066][ T1] ? __register_sysctl_table (fs/proc/proc_sysctl.c:1399)
[ 0.541066][ T1] ? rest_init (init/main.c:1461)
[ 0.541066][ T1] do_pre_smp_initcalls (init/main.c:1374 (discriminator 2))
[ 0.541066][ T1] ? rest_init (init/main.c:1461)
[ 0.541066][ T1] kernel_init_freeable (init/main.c:1569)
[ 0.541066][ T1] kernel_init (init/main.c:1471)
[ 0.541066][ T1] ret_from_fork (arch/x86/kernel/process.c:154)
[ 0.541066][ T1] ? rest_init (init/main.c:1461)
[ 0.541066][ T1] ret_from_fork_asm (arch/x86/entry/entry_32.S:737)
[ 0.541066][ T1] entry_INT80_32 (arch/x86/entry/entry_32.S:945)
[ 0.541090][ T1]
[ 0.541618][ T1] =============================
[ 0.542722][ T1] WARNING: suspicious RCU usage
[ 0.543814][ T1] 6.17.0-00059-ge2a703d65295 #1 Not tainted
[ 0.545085][ T1] -----------------------------
[ 0.546167][ T1] lib/maple_tree.c:800 suspicious rcu_dereference_check() usage!
[ 0.547824][ T1]
[ 0.547824][ T1] other info that might help us debug this:
[ 0.547824][ T1]
[ 0.549088][ T1]
[ 0.549088][ T1] rcu_scheduler_active = 2, debug_locks = 1
[ 0.550905][ T1] no locks held by swapper/0/1.
[ 0.553083][ T1]
[ 0.553083][ T1] stack backtrace:
[ 0.554374][ T1] CPU: 0 UID: 0 PID: 1 Comm: swapper/0 Not tainted 6.17.0-00059-ge2a703d65295 #1 PREEMPTLAZY
[ 0.556518][ T1] Call Trace:
[ 0.557066][ T1] __dump_stack (lib/dump_stack.c:95)
[ 0.557066][ T1] dump_stack_lvl (lib/dump_stack.c:123 (discriminator 3))
[ 0.557066][ T1] dump_stack (lib/dump_stack.c:129)
[ 0.557066][ T1] lockdep_rcu_suspicious (kernel/locking/lockdep.c:6877)
[ 0.557066][ T1] mtree_range_walk (lib/maple_tree.c:?)
[ 0.557066][ T1] mas_find (lib/maple_tree.c:279 lib/maple_tree.c:4940 lib/maple_tree.c:6018 lib/maple_tree.c:6058)
[ 0.557066][ T1] dynamic_debug_init (lib/dynamic_debug.c:1972 (discriminator 1))
[ 0.557066][ T1] ? _raw_spin_unlock_irqrestore (arch/x86/include/asm/preempt.h:104 include/linux/spinlock_api_smp.h:152 kernel/locking/spinlock.c:194)
[ 0.557066][ T1] do_one_initcall (init/main.c:1269)
[ 0.557066][ T1] ? dyndbg_setup (lib/dynamic_debug.c:1931)
[ 0.557066][ T1] ? kvm_sched_clock_read (arch/x86/kernel/kvmclock.c:91)
[ 0.557066][ T1] ? sched_clock_noinstr (arch/x86/kernel/tsc.c:271)
[ 0.557066][ T1] ? local_clock_noinstr (kernel/sched/clock.c:272 kernel/sched/clock.c:309)
[ 0.557066][ T1] ? kvm_sched_clock_read (arch/x86/kernel/kvmclock.c:91)
[ 0.557066][ T1] ? sched_clock_noinstr (arch/x86/kernel/tsc.c:271)
[ 0.557066][ T1] ? kvm_sched_clock_read (arch/x86/kernel/kvmclock.c:91)
[ 0.557066][ T1] ? local_clock_noinstr (kernel/sched/clock.c:272 kernel/sched/clock.c:309)
[ 0.557066][ T1] ? kvm_sched_clock_read (arch/x86/kernel/kvmclock.c:91)
[ 0.557066][ T1] ? sched_clock_noinstr (arch/x86/kernel/tsc.c:271)
[ 0.557066][ T1] ? local_clock_noinstr (kernel/sched/clock.c:272 kernel/sched/clock.c:309)
[ 0.557066][ T1] ? __lock_acquire (kernel/locking/lockdep.c:4674)
[ 0.557066][ T1] ? kvm_sched_clock_read (arch/x86/kernel/kvmclock.c:91)
[ 0.557066][ T1] ? sched_clock_noinstr (arch/x86/kernel/tsc.c:271)
[ 0.557066][ T1] ? local_clock_noinstr (kernel/sched/clock.c:272 kernel/sched/clock.c:309)
[ 0.557066][ T1] ? __this_cpu_preempt_check (lib/smp_processor_id.c:65)
[ 0.557066][ T1] ? _raw_spin_unlock (arch/x86/include/asm/preempt.h:104 include/linux/spinlock_api_smp.h:143 kernel/locking/spinlock.c:186)
[ 0.557066][ T1] ? __register_sysctl_table (fs/proc/proc_sysctl.c:1399)
[ 0.557066][ T1] ? trace_preempt_on (kernel/trace/trace_preemptirq.c:122)
[ 0.557066][ T1] ? _raw_spin_unlock (arch/x86/include/asm/preempt.h:104 include/linux/spinlock_api_smp.h:143 kernel/locking/spinlock.c:186)
[ 0.557066][ T1] ? preempt_count_sub (arch/x86/include/asm/preempt.h:85 (discriminator 1) kernel/sched/core.c:5864 (discriminator 1))
[ 0.557066][ T1] ? _raw_spin_unlock (arch/x86/include/asm/preempt.h:104 include/linux/spinlock_api_smp.h:143 kernel/locking/spinlock.c:186)
[ 0.557066][ T1] ? __register_sysctl_table (fs/proc/proc_sysctl.c:1399)
[ 0.557066][ T1] ? rest_init (init/main.c:1461)
[ 0.557066][ T1] do_pre_smp_initcalls (init/main.c:1374 (discriminator 2))
[ 0.557066][ T1] ? rest_init (init/main.c:1461)
[ 0.557066][ T1] kernel_init_freeable (init/main.c:1569)
[ 0.557066][ T1] kernel_init (init/main.c:1471)
[ 0.557066][ T1] ret_from_fork (arch/x86/kernel/process.c:154)
[ 0.557066][ T1] ? rest_init (init/main.c:1461)
[ 0.557066][ T1] ret_from_fork_asm (arch/x86/entry/entry_32.S:737)
[ 0.557066][ T1] entry_INT80_32 (arch/x86/entry/entry_32.S:945)
The kernel config and materials to reproduce are available at:
https://download.01.org/0day-ci/archive/20251111/202511111514.ecbaaa39-lkp@intel.com
--
0-DAY CI Kernel Test Service
https://github.com/intel/lkp-tests/wiki
[-- Attachment #2: dmesg-f8241f5267.xz --]
[-- Type: application/x-xz, Size: 5612 bytes --]
^ permalink raw reply [flat|nested] only message in thread
only message in thread, other threads:[~2025-11-12 2:55 UTC | newest]
Thread overview: (only message) (download: mbox.gz follow: Atom feed
-- links below jump to the message on this page --
2025-11-12 2:55 [jimc:dd-drm-fix] [drm] e2a703d652: WARNING:suspicious_RCU_usage kernel test robot
This is an external index of several public inboxes,
see mirroring instructions on how to clone and mirror
all data and code used by this external index.