All of lore.kernel.org
 help / color / mirror / Atom feed
* [boqun:rust-sync] [locking]  4a653dbaf6: WARNING:inconsistent_lock_state
@ 2026-03-11 14:14 kernel test robot
  0 siblings, 0 replies; only message in thread
From: kernel test robot @ 2026-03-11 14:14 UTC (permalink / raw)
  To: Boqun Feng; +Cc: oe-lkp, lkp, oliver.sang



Hello,

kernel test robot noticed "WARNING:inconsistent_lock_state" on:

commit: 4a653dbaf6f3a8c950a72e4b78e93576e1916381 ("locking: Switch to _irq_{disable,enable}() variants in cleanup guards")
https://git.kernel.org/cgit/linux/kernel/git/boqun/linux.git rust-sync

in testcase: rcuscale
version: 
with following parameters:

	runtime: 300s
	scale_type: tasks-tracing



config: i386-randconfig-016-20260307
compiler: gcc-14
test machine: qemu-system-i386 -enable-kvm -cpu SandyBridge -smp 2 -m 4G

(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/202603112101.7a93776e-lkp@intel.com



[  602.666894][    C0] WARNING: inconsistent lock state
[  602.667841][    C0] 7.0.0-rc1-00024-g4a653dbaf6f3 #1 Not tainted
[  602.668980][    C0] --------------------------------
[  602.669956][    C0] inconsistent {IN-HARDIRQ-W} -> {HARDIRQ-ON-W} usage.
[  602.671224][    C0] rb_consumer/46 [HC0[0]:SC1[1]:HE1:SE0] takes:
[  602.672305][    C0] ba254794 (&p->pi_lock){?.-.}-{2:2}, at: try_to_wake_up (kernel/sched/core.c:3946 (discriminator 1) kernel/sched/core.c:4132 (discriminator 1))
[  602.674764][    C0] {IN-HARDIRQ-W} state was registered at:
[  602.675825][    C0] irq event stamp: 133462036
[  602.676720][    C0] hardirqs last  enabled at (133462036): _raw_spin_unlock_irq (arch/x86/include/asm/irqflags.h:42 arch/x86/include/asm/irqflags.h:119 include/linux/spinlock_api_smp.h:207 kernel/locking/spinlock.c:223)
[  602.678511][    C0] hardirqs last disabled at (133462035): _raw_spin_lock_irq (include/linux/spinlock_api_smp.h:153 (discriminator 1) kernel/locking/spinlock.c:183 (discriminator 1))
[  602.684515][    C0] softirqs last  enabled at (133457152): handle_softirqs (kernel/softirq.c:474 (discriminator 2) kernel/softirq.c:655 (discriminator 2))
[  602.686374][    C0] softirqs last disabled at (133462033): __do_softirq (kernel/softirq.c:662)
[  602.687932][    C0]
[  602.687932][    C0] other info that might help us debug this:
[  602.689461][    C0]  Possible unsafe locking scenario:
[  602.689461][    C0]
[  602.690790][    C0]        CPU0
[  602.691385][    C0]        ----
[  602.692023][    C0]   lock(&p->pi_lock);
[  602.692794][    C0]   <Interrupt>
[  602.693590][    C0]     lock(&p->pi_lock);
[  602.694428][    C0]
[  602.694428][    C0]  *** DEADLOCK ***
[  602.694428][    C0]
[  602.696023][    C0] 1 lock held by rb_consumer/46:
[  602.696998][    C0]  #0: 446e1f04 ((&timer.timer)){+.-.}-{0:0}, at: call_timer_fn (kernel/time/timer.c:1745)
[  602.698784][    C0]
[  602.698784][    C0] stack backtrace:
[  602.699847][    C0] CPU: 0 UID: 0 PID: 46 Comm: rb_consumer Not tainted 7.0.0-rc1-00024-g4a653dbaf6f3 #1 PREEMPT(lazy)
[  602.699855][    C0] Call Trace:
[  602.699858][    C0]  <SOFTIRQ>
[  602.699860][    C0]  ? show_stack (arch/x86/kernel/dumpstack.c:338)
[  602.699871][    C0]  ? dump_stack_lvl (lib/dump_stack.c:122)
[  602.699877][    C0]  ? dump_stack (lib/dump_stack.c:130)
[  602.699881][    C0]  ? print_usage_bug+0x266/0x380
[  602.699890][    C0]  ? mark_lock_irq (kernel/locking/lockdep.c:4010 (discriminator 1) kernel/locking/lockdep.c:4056 (discriminator 1) kernel/locking/lockdep.c:4267 (discriminator 1))
[  602.699895][    C0]  ? save_trace (kernel/locking/lockdep.c:557 (discriminator 3) kernel/locking/lockdep.c:594 (discriminator 3))
[  602.699907][    C0]  ? mark_lock (kernel/locking/lockdep.c:4753)
[  602.699912][    C0]  ? mark_usage (kernel/locking/lockdep.c:4662 (discriminator 1))
[  602.699915][    C0]  ? __lock_acquire (kernel/locking/lockdep.c:5191 (discriminator 1))
[  602.699922][    C0]  ? lock_acquire (include/linux/srcutree.h:373 include/linux/srcu.h:385 include/linux/srcu.h:634 include/trace/events/lock.h:24 include/trace/events/lock.h:24 kernel/locking/lockdep.c:5831)
[  602.699926][    C0]  ? try_to_wake_up (kernel/sched/core.c:3946 (discriminator 1) kernel/sched/core.c:4132 (discriminator 1))
[  602.699933][    C0]  ? __lock_acquire (kernel/locking/lockdep.c:5237 (discriminator 1))
[  602.699938][    C0]  ? debug_smp_processor_id (lib/smp_processor_id.c:59)
[  602.699945][    C0]  ? lock_acquire (kernel/locking/lockdep.c:5872)
[  602.699949][    C0]  ? try_to_wake_up (kernel/sched/core.c:3946 (discriminator 1) kernel/sched/core.c:4132 (discriminator 1))
[  602.699953][    C0]  ? call_timer_fn (kernel/time/timer.c:1745)
[  602.699959][    C0]  ? _raw_spin_lock_irq_disable (include/linux/spinlock_api_smp.h:163 kernel/locking/spinlock.c:191)
[  602.699965][    C0]  ? try_to_wake_up (kernel/sched/core.c:3946 (discriminator 1) kernel/sched/core.c:4132 (discriminator 1))
[  602.699970][    C0]  ? try_to_wake_up (kernel/sched/core.c:3946 (discriminator 1) kernel/sched/core.c:4132 (discriminator 1))
[  602.699973][    C0]  ? debug_smp_processor_id (lib/smp_processor_id.c:59)
[  602.699979][    C0]  ? lock_acquire (kernel/locking/lockdep.c:5872)
[  602.699984][    C0]  ? hrtimers_cpu_dying (kernel/time/sleep_timeout.c:24)
[  602.699988][    C0]  ? wake_up_process (kernel/sched/core.c:4375)
[  602.699993][    C0]  ? process_timeout (kernel/time/sleep_timeout.c:28)
[  602.699996][    C0]  ? call_timer_fn (arch/x86/include/asm/atomic.h:23 include/linux/atomic/atomic-arch-fallback.h:457 include/linux/jump_label.h:262 include/trace/events/timer.h:127 kernel/time/timer.c:1749)
[  602.700002][    C0]  ? call_timer_fn (kernel/time/timer.c:1745)
[  602.700006][    C0]  ? hrtimers_cpu_dying (kernel/time/sleep_timeout.c:24)
[  602.700012][    C0]  ? __run_timers (kernel/time/timer.c:1800 kernel/time/timer.c:2373)
[  602.700017][    C0]  ? hrtimers_cpu_dying (kernel/time/sleep_timeout.c:24)
[  602.700025][    C0]  ? run_timer_base (kernel/time/timer.c:2386 kernel/time/timer.c:2377 kernel/time/timer.c:2394)
[  602.700030][    C0]  ? run_timer_softirq (kernel/time/timer.c:2405)
[  602.700035][    C0]  ? handle_softirqs (arch/x86/include/asm/atomic.h:23 include/linux/atomic/atomic-arch-fallback.h:457 include/linux/jump_label.h:262 include/trace/events/irq.h:142 kernel/softirq.c:628)
[  602.700043][    C0]  ? __kprobes_text_end (kernel/softirq.c:660)
[  602.700048][    C0]  ? __do_softirq (kernel/softirq.c:662)
[  602.700052][    C0]  ? do_softirq_own_stack (arch/x86/kernel/irq_32.c:56 arch/x86/kernel/irq_32.c:144)
[  602.700057][    C0]  </SOFTIRQ>
[  602.700060][    C0]  ? sysvec_call_function_single (arch/x86/kernel/apic/apic.c:1056)
[  602.700065][    C0]  ? irq_exit_rcu (arch/x86/include/asm/atomic.h:23 include/linux/atomic/atomic-arch-fallback.h:457 include/linux/jump_label.h:262 kernel/softirq.c:730 kernel/softirq.c:744)
[  602.700069][    C0]  ? sysvec_apic_timer_interrupt (arch/x86/kernel/apic/apic.c:1056 (discriminator 3))
[  602.700074][    C0]  ? handle_exception (arch/x86/entry/entry_32.S:1048)
[  602.700079][    C0]  ? __alloc_frozen_pages_noprof (mm/page_alloc.c:3797 (discriminator 1) mm/page_alloc.c:5028 (discriminator 1) mm/page_alloc.c:5239 (discriminator 1))
[  602.700083][    C0]  ? sysvec_call_function_single (arch/x86/kernel/apic/apic.c:1056)
[  602.700088][    C0]  ? _raw_spin_lock_irq_disable (arch/x86/include/asm/preempt.h:90 include/linux/interrupt_rc.h:32 include/linux/spinlock_api_smp.h:161 kernel/locking/spinlock.c:191)
[  602.700093][    C0]  ? sysvec_call_function_single (arch/x86/kernel/apic/apic.c:1056)
[  602.700097][    C0]  ? _raw_spin_lock_irq_disable (arch/x86/include/asm/preempt.h:90 include/linux/interrupt_rc.h:32 include/linux/spinlock_api_smp.h:161 kernel/locking/spinlock.c:191)
[  602.700102][    C0]  ? debug_smp_processor_id (lib/smp_processor_id.c:59)
[  602.700106][    C0]  ? ring_buffer_alloc_read_page (arch/x86/include/asm/irqflags.h:26 arch/x86/include/asm/irqflags.h:109 arch/x86/include/asm/irqflags.h:151 kernel/trace/ring_buffer.c:6527)
[  602.700111][    C0]  ? ring_buffer_read_page (kernel/trace/ring_buffer.c:6660)
[  602.700115][    C0]  ? lockdep_hardirqs_on (kernel/locking/lockdep.c:4472 (discriminator 4))
[  602.700120][    C0]  ? ring_buffer_alloc_read_page (arch/x86/include/asm/irqflags.h:26 arch/x86/include/asm/irqflags.h:109 arch/x86/include/asm/irqflags.h:151 kernel/trace/ring_buffer.c:6527)
[  602.700124][    C0]  ? ring_buffer_alloc_read_page (arch/x86/include/asm/irqflags.h:26 arch/x86/include/asm/irqflags.h:109 arch/x86/include/asm/irqflags.h:151 kernel/trace/ring_buffer.c:6527)
[  602.700132][    C0]  ? read_page (kernel/trace/ring_buffer_benchmark.c:123)
[  602.700139][    C0]  ? ring_buffer_consumer (kernel/trace/ring_buffer_benchmark.c:209)
[  602.700144][    C0]  ? complete (kernel/sched/completion.c:53)
[  602.700148][    C0]  ? ring_buffer_consumer_thread (kernel/trace/ring_buffer_benchmark.c:390 (discriminator 1))
[  602.700153][    C0]  ? kthread (kernel/kthread.c:467)
[  602.700160][    C0]  ? ring_buffer_producer (kernel/trace/ring_buffer_benchmark.c:384)
[  602.700164][    C0]  ? kthread_complete_and_exit (kernel/kthread.c:412)
[  602.700170][    C0]  ? ret_from_fork (arch/x86/kernel/process.c:164)
[  602.700174][    C0]  ? kthread_complete_and_exit (kernel/kthread.c:412)
[  602.700179][    C0]  ? ret_from_fork_asm (arch/x86/entry/entry_32.S:737)
[  602.700204][    C0]  ? entry_INT80_32 (arch/x86/entry/entry_32.S:945)
[  833.753184][  T247] 2026-03-08 15:15:06 rmmod rcuscale
[  833.753202][  T247]
[  833.755451][  T873] tasks-tracing-torture: Stopping rcu_scale_reader task
[  833.756913][  T446] tasks-tracing-torture: rcu_scale_reader is stopping
[  833.760360][  T448] tasks-tracing-torture: rcu_scale_reader is stopping
[  833.766344][  T452] tasks-tracing-torture: rcu_scale_writer is stopping
[  833.769461][  T454] tasks-tracing-torture: rcu_scale_writer is stopping
[  833.770550][  T873] tasks-tracing-torture: Stopping rcu_scale_reader task


The kernel config and materials to reproduce are available at:
https://download.01.org/0day-ci/archive/20260311/202603112101.7a93776e-lkp@intel.com



-- 
0-DAY CI Kernel Test Service
https://github.com/intel/lkp-tests/wiki


^ permalink raw reply	[flat|nested] only message in thread

only message in thread, other threads:[~2026-03-11 14:14 UTC | newest]

Thread overview: (only message) (download: mbox.gz follow: Atom feed
-- links below jump to the message on this page --
2026-03-11 14:14 [boqun:rust-sync] [locking] 4a653dbaf6: WARNING:inconsistent_lock_state 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.