====================================== | [ 14.707364][ C3] 1 lock held by ksoftirqd/3/32: | [ 14.707549][ C3] #0: ffffffffa59774c0 (rcu_callback){....}-{0:0}, at: rcu_do_batch (./include/linux/rcupdate.h:331 kernel/rcu/tree.c:2570) | [ 14.707868][ C3] | [ 14.707868][ C3] stack backtrace: [ 14.708094][ C3] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 14.708097][ C3] Call Trace: [ 14.708099][ C3] [ 14.708101][ C3] dump_stack_lvl (lib/dump_stack.c:123) [ 14.708109][ C3] print_usage_bug.part.0 (kernel/locking/lockdep.c:4048) [ 14.708113][ C3] mark_lock_irq (kernel/locking/lockdep.c:4013 kernel/locking/lockdep.c:4059 kernel/locking/lockdep.c:4270) [ 14.708118][ C3] ? __pfx_unwind_next_frame (arch/x86/kernel/unwind_orc.c:469) [ 14.708123][ C3] ? save_trace (kernel/locking/lockdep.c:595) [ 14.708130][ C3] mark_lock (kernel/locking/lockdep.c:4756) [ 14.708134][ C3] mark_usage (kernel/locking/lockdep.c:4645) [ 14.708137][ C3] __lock_acquire (kernel/locking/lockdep.c:5194) [ 14.708140][ C3] ? __lock_acquire (kernel/locking/lockdep.c:5240) [ 14.708144][ C3] lock_acquire.part.0 (kernel/locking/lockdep.c:473 kernel/locking/lockdep.c:5873) [ 14.708147][ C3] ? simple_pin_fs (fs/libfs.c:1067) [ 14.708151][ C3] ? rcu_is_watching (./include/linux/context_tracking.h:128 kernel/rcu/tree.c:745) [ 14.708156][ C3] ? lock_acquire (./include/trace/events/lock.h:24 kernel/locking/lockdep.c:5834) [ 14.708159][ C3] ? simple_pin_fs (fs/libfs.c:1067) [ 14.708163][ C3] _raw_spin_lock (./include/linux/spinlock_api_smp.h:134 kernel/locking/spinlock.c:154) [ 14.708167][ C3] ? simple_pin_fs (fs/libfs.c:1067) [ 14.708170][ C3] simple_pin_fs (fs/libfs.c:1067) [ 14.708174][ C3] debugfs_remove (fs/debugfs/inode.c:805 fs/debugfs/inode.c:799) [ 14.708177][ C3] ref_tracker_dir_exit (lib/ref_tracker.c:412 lib/ref_tracker.c:196) [ 14.708185][ C3] ? __pfx_ref_tracker_free (lib/ref_tracker.c:254) [ 14.708188][ C3] ? __sk_destruct (./include/linux/instrumented.h:96 ./include/linux/atomic/atomic-instrumented.h:400 ./include/linux/refcount.h:389 ./include/linux/refcount.h:432 ./include/linux/refcount.h:450 ./include/net/net_namespace.h:287 ./include/net/net_namespace.h:390 net/core/sock.c:2376) [ 14.708195][ C3] ? rcu_do_batch (kernel/rcu/tree.c:2576) [ 14.708198][ C3] ? __pfx_ref_tracker_dir_exit (lib/ref_tracker.c:190) [ 14.708201][ C3] ? smpboot_thread_fn (kernel/smpboot.c:164 (discriminator 3)) [ 14.708207][ C3] ? kthread (kernel/kthread.c:464) [ 14.708210][ C3] ? ret_from_fork (arch/x86/kernel/process.c:148) [ 14.708213][ C3] ? ret_from_fork_asm (arch/x86/entry/entry_64.S:258) [ 14.708216][ C3] ? migrate_enable (./arch/x86/include/asm/preempt.h:104 ./include/linux/preempt.h:481 ./include/linux/preempt.h:481 kernel/sched/core.c:2427) [ 14.708221][ C3] ? __pfx_migrate_enable (kernel/sched/core.c:2402) [ 14.708226][ C3] __put_net (net/core/net_namespace.c:732) [ 14.708230][ C3] __sk_destruct (./include/net/net_namespace.h:288 ./include/net/net_namespace.h:390 net/core/sock.c:2376) [ 14.708235][ C3] ? rcu_do_batch (kernel/rcu/tree.c:2576) [ 14.708237][ C3] rcu_do_batch (kernel/rcu/tree.c:2576) [ 14.708242][ C3] ? __pfx_rcu_do_batch (kernel/rcu/tree.c:2500) [ 14.708245][ C3] ? rcu_is_watching (./include/linux/context_tracking.h:128 kernel/rcu/tree.c:745) [ 14.708248][ C3] ? note_gp_changes (kernel/rcu/tree.c:1326 (discriminator 1)) [ 14.708251][ C3] ? lockdep_hardirqs_on (kernel/locking/lockdep.c:4475) [ 14.708255][ C3] rcu_core (kernel/rcu/tree.c:2834) [ 14.708260][ C3] handle_softirqs (kernel/softirq.c:579) [ 14.708264][ C3] ? __pfx_run_ksoftirqd (kernel/softirq.c:961) [ 14.708268][ C3] run_ksoftirqd (kernel/softirq.c:436 kernel/softirq.c:969 kernel/softirq.c:960) [ 14.708270][ C3] smpboot_thread_fn (kernel/smpboot.c:164 (discriminator 3)) [ 14.708274][ C3] ? __pfx_smpboot_thread_fn (kernel/smpboot.c:107) [ 14.708278][ C3] kthread (kernel/kthread.c:464) [ 14.708281][ C3] ? __pfx_kthread (kernel/kthread.c:413) [ 14.708283][ C3] ? ret_from_fork (arch/x86/kernel/process.c:147) [ 14.708285][ C3] ? __lock_release (kernel/locking/lockdep.c:5539) [ 14.708288][ C3] ? rcu_is_watching (./include/linux/context_tracking.h:128 kernel/rcu/tree.c:745) [ 14.708291][ C3] ? __pfx_kthread (kernel/kthread.c:413) [ 14.708294][ C3] ret_from_fork (arch/x86/kernel/process.c:148) [ 14.708297][ C3] ? __pfx_kthread (kernel/kthread.c:413) [ 14.708299][ C3] ret_from_fork_asm (arch/x86/entry/entry_64.S:258) | [ 14.719512][ C3] RCU nest depth: 0, expected: 0 | [ 14.719683][ C3] INFO: lockdep is turned off. | [ 14.719850][ C3] Preemption disabled at: | [ 14.719851][ C3] handle_softirqs (kernel/softirq.c:553) [ 14.720205][ C3] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 14.720207][ C3] Call Trace: [ 14.720208][ C3] [ 14.720210][ C3] dump_stack_lvl (lib/dump_stack.c:123) [ 14.720216][ C3] __might_resched (kernel/sched/core.c:8796) [ 14.720223][ C3] down_write (./include/linux/kernel.h:73 kernel/locking/rwsem.c:1576) [ 14.720227][ C3] ? __pfx_down_write (kernel/locking/rwsem.c:1575) [ 14.720230][ C3] ? simple_recursive_removal (fs/libfs.c:614) [ 14.720233][ C3] ? rcu_is_watching (./include/linux/context_tracking.h:128 kernel/rcu/tree.c:745) [ 14.720238][ C3] ? do_raw_spin_unlock (./arch/x86/include/asm/atomic.h:23 ./include/linux/atomic/atomic-arch-fallback.h:457 ./include/linux/atomic/atomic-instrumented.h:33 ./include/asm-generic/qspinlock.h:57 kernel/locking/spinlock_debug.c:101 kernel/locking/spinlock_debug.c:141) [ 14.720243][ C3] simple_recursive_removal (./include/linux/dcache.h:409 ./include/linux/dcache.h:424 ./include/linux/dcache.h:434 fs/libfs.c:617) [ 14.720246][ C3] ? do_raw_spin_unlock (./arch/x86/include/asm/atomic.h:23 ./include/linux/atomic/atomic-arch-fallback.h:457 ./include/linux/atomic/atomic-instrumented.h:33 ./include/asm-generic/qspinlock.h:57 kernel/locking/spinlock_debug.c:101 kernel/locking/spinlock_debug.c:141) [ 14.720250][ C3] ? __pfx_remove_one (fs/debugfs/inode.c:780) [ 14.720255][ C3] debugfs_remove (fs/debugfs/inode.c:806 fs/debugfs/inode.c:799) [ 14.720258][ C3] ref_tracker_dir_exit (lib/ref_tracker.c:412 lib/ref_tracker.c:196) [ 14.720263][ C3] ? __pfx_ref_tracker_free (lib/ref_tracker.c:254) [ 14.720266][ C3] ? __sk_destruct (./include/linux/instrumented.h:96 ./include/linux/atomic/atomic-instrumented.h:400 ./include/linux/refcount.h:389 ./include/linux/refcount.h:432 ./include/linux/refcount.h:450 ./include/net/net_namespace.h:287 ./include/net/net_namespace.h:390 net/core/sock.c:2376) [ 14.720270][ C3] ? rcu_do_batch (kernel/rcu/tree.c:2576) [ 14.720273][ C3] ? __pfx_ref_tracker_dir_exit (lib/ref_tracker.c:190) [ 14.720277][ C3] ? smpboot_thread_fn (kernel/smpboot.c:164 (discriminator 3)) [ 14.720280][ C3] ? kthread (kernel/kthread.c:464) [ 14.720283][ C3] ? ret_from_fork (arch/x86/kernel/process.c:148) [ 14.720286][ C3] ? ret_from_fork_asm (arch/x86/entry/entry_64.S:258) [ 14.720290][ C3] ? migrate_enable (./arch/x86/include/asm/preempt.h:104 ./include/linux/preempt.h:481 ./include/linux/preempt.h:481 kernel/sched/core.c:2427) [ 14.720294][ C3] ? __pfx_migrate_enable (kernel/sched/core.c:2402) [ 14.720299][ C3] __put_net (net/core/net_namespace.c:732) [ 14.720302][ C3] __sk_destruct (./include/net/net_namespace.h:288 ./include/net/net_namespace.h:390 net/core/sock.c:2376) [ 14.720306][ C3] ? rcu_do_batch (kernel/rcu/tree.c:2576) [ 14.720308][ C3] rcu_do_batch (kernel/rcu/tree.c:2576) [ 14.720313][ C3] ? __pfx_rcu_do_batch (kernel/rcu/tree.c:2500) [ 14.720317][ C3] ? rcu_is_watching (./include/linux/context_tracking.h:128 kernel/rcu/tree.c:745) [ 14.720319][ C3] ? note_gp_changes (kernel/rcu/tree.c:1326 (discriminator 1)) [ 14.720322][ C3] ? lockdep_hardirqs_on (kernel/locking/lockdep.c:4475) [ 14.720326][ C3] rcu_core (kernel/rcu/tree.c:2834) [ 14.720330][ C3] handle_softirqs (kernel/softirq.c:579) [ 14.720334][ C3] ? __pfx_run_ksoftirqd (kernel/softirq.c:961) [ 14.720337][ C3] run_ksoftirqd (kernel/softirq.c:436 kernel/softirq.c:969 kernel/softirq.c:960) [ 14.720340][ C3] smpboot_thread_fn (kernel/smpboot.c:164 (discriminator 3)) [ 14.720344][ C3] ? __pfx_smpboot_thread_fn (kernel/smpboot.c:107) [ 14.720348][ C3] kthread (kernel/kthread.c:464) [ 14.720350][ C3] ? __pfx_kthread (kernel/kthread.c:413) [ 14.720352][ C3] ? ret_from_fork (arch/x86/kernel/process.c:147) [ 14.720355][ C3] ? __lock_release (kernel/locking/lockdep.c:5539) [ 14.720358][ C3] ? rcu_is_watching (./include/linux/context_tracking.h:128 kernel/rcu/tree.c:745) [ 14.720361][ C3] ? __pfx_kthread (kernel/kthread.c:413) [ 14.720364][ C3] ret_from_fork (arch/x86/kernel/process.c:148) [ 14.720367][ C3] ? __pfx_kthread (kernel/kthread.c:413) [ 14.720369][ C3] ret_from_fork_asm (arch/x86/entry/entry_64.S:258) | [ 16.334298][ C0] INFO: lockdep is turned off. | [ 16.334496][ C0] Preemption disabled at: | [ 16.334498][ C0] schedule_preempt_disabled (kernel/sched/core.c:6933) | [ 16.334947][ C0] Tainted: [W]=WARN [ 16.334949][ C0] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 16.334951][ C0] Call Trace: [ 16.334953][ C0] [ 16.334955][ C0] dump_stack_lvl (lib/dump_stack.c:123) [ 16.334963][ C0] __might_resched (kernel/sched/core.c:8796) [ 16.334974][ C0] down_write (./include/linux/kernel.h:73 kernel/locking/rwsem.c:1576) [ 16.334979][ C0] ? __pfx_down_write (kernel/locking/rwsem.c:1575) [ 16.334982][ C0] ? simple_recursive_removal (fs/libfs.c:614) [ 16.334988][ C0] ? rcu_is_watching (./include/linux/context_tracking.h:128 kernel/rcu/tree.c:745) [ 16.334995][ C0] ? do_raw_spin_unlock (./arch/x86/include/asm/atomic.h:23 ./include/linux/atomic/atomic-arch-fallback.h:457 ./include/linux/atomic/atomic-instrumented.h:33 ./include/asm-generic/qspinlock.h:57 kernel/locking/spinlock_debug.c:101 kernel/locking/spinlock_debug.c:141) [ 16.335003][ C0] simple_recursive_removal (./include/linux/dcache.h:409 ./include/linux/dcache.h:424 ./include/linux/dcache.h:434 fs/libfs.c:617) [ 16.335006][ C0] ? do_raw_spin_unlock (./arch/x86/include/asm/atomic.h:23 ./include/linux/atomic/atomic-arch-fallback.h:457 ./include/linux/atomic/atomic-instrumented.h:33 ./include/asm-generic/qspinlock.h:57 kernel/locking/spinlock_debug.c:101 kernel/locking/spinlock_debug.c:141) [ 16.335009][ C0] ? __pfx_remove_one (fs/debugfs/inode.c:780) [ 16.335016][ C0] debugfs_remove (fs/debugfs/inode.c:806 fs/debugfs/inode.c:799) [ 16.335019][ C0] ref_tracker_dir_exit (lib/ref_tracker.c:412 lib/ref_tracker.c:196) [ 16.335028][ C0] ? __pfx_ref_tracker_free (lib/ref_tracker.c:254) [ 16.335031][ C0] ? __sk_destruct (./include/linux/instrumented.h:96 ./include/linux/atomic/atomic-instrumented.h:400 ./include/linux/refcount.h:389 ./include/linux/refcount.h:432 ./include/linux/refcount.h:450 ./include/net/net_namespace.h:287 ./include/net/net_namespace.h:390 net/core/sock.c:2376) [ 16.335040][ C0] ? rcu_do_batch (kernel/rcu/tree.c:2576) [ 16.335044][ C0] ? __pfx_ref_tracker_dir_exit (lib/ref_tracker.c:190) [ 16.335047][ C0] ? irq_exit_rcu (kernel/softirq.c:698) [ 16.335054][ C0] ? sysvec_apic_timer_interrupt (arch/x86/kernel/apic/apic.c:1050 arch/x86/kernel/apic/apic.c:1050) [ 16.335059][ C0] ? asm_sysvec_apic_timer_interrupt (./arch/x86/include/asm/idtentry.h:702) [ 16.335063][ C0] ? pv_native_safe_halt (arch/x86/kernel/paravirt.c:82) [ 16.335066][ C0] ? default_idle (./arch/x86/include/asm/paravirt.h:107 arch/x86/kernel/process.c:743) [ 16.335069][ C0] ? default_idle_call (./include/linux/cpuidle.h:143 kernel/sched/idle.c:118) [ 16.335072][ C0] ? cpuidle_idle_call (kernel/sched/idle.c:186) [ 16.335075][ C0] ? do_idle (kernel/sched/idle.c:325) [ 16.335078][ C0] ? cpu_startup_entry (kernel/sched/idle.c:422 (discriminator 1)) [ 16.335080][ C0] ? rest_init (./include/linux/rcupdate.h:842 init/main.c:714) [ 16.335084][ C0] ? start_kernel (init/main.c:1049 (discriminator 1)) [ 16.335091][ C0] ? bpf_sk_storage_free (./include/linux/rcupdate.h:341 ./include/linux/rcupdate.h:871 net/core/bpf_sk_storage.c:61) [ 16.335095][ C0] ? rcu_is_watching (./include/linux/context_tracking.h:128 kernel/rcu/tree.c:745) [ 16.335099][ C0] __put_net (net/core/net_namespace.c:732) [ 16.335105][ C0] __sk_destruct (./include/net/net_namespace.h:288 ./include/net/net_namespace.h:390 net/core/sock.c:2376) [ 16.335109][ C0] ? rcu_do_batch (kernel/rcu/tree.c:2576) [ 16.335111][ C0] rcu_do_batch (kernel/rcu/tree.c:2576) [ 16.335116][ C0] ? __pfx_rcu_do_batch (kernel/rcu/tree.c:2500) [ 16.335119][ C0] ? trace_irq_enable.constprop.0 (./include/trace/events/preemptirq.h:40) [ 16.335125][ C0] ? _raw_spin_unlock_irqrestore (./arch/x86/include/asm/preempt.h:104 ./include/linux/spinlock_api_smp.h:152 kernel/locking/spinlock.c:194) [ 16.335133][ C0] rcu_core (kernel/rcu/tree.c:2834) [ 16.335139][ C0] handle_softirqs (kernel/softirq.c:579) [ 16.335144][ C0] __irq_exit_rcu (kernel/softirq.c:614 kernel/softirq.c:453 kernel/softirq.c:680) [ 16.335147][ C0] irq_exit_rcu (kernel/softirq.c:698) [ 16.335150][ C0] sysvec_apic_timer_interrupt (arch/x86/kernel/apic/apic.c:1050 arch/x86/kernel/apic/apic.c:1050) [ 16.335154][ C0] [ 16.335155][ C0] [ 16.335156][ C0] asm_sysvec_apic_timer_interrupt (./arch/x86/include/asm/idtentry.h:702) [ 16.335159][ C0] RIP: 0010:pv_native_safe_halt (arch/x86/kernel/paravirt.c:82) [ 16.335163][ C0] Code: 92 b5 00 c3 cc cc cc cc 0f 1f 00 90 90 90 90 90 90 90 90 90 90 90 90 90 90 90 90 f3 0f 1e fa 66 90 0f 00 2d 83 37 10 00 fb f4 fc 54 02 00 66 2e 0f 1f 84 00 00 00 00 00 66 90 90 90 90 90 90 All code ======== 0: 92 xchg %eax,%edx 1: b5 00 mov $0x0,%ch 3: c3 ret 4: cc int3 5: cc int3 6: cc int3 7: cc int3 8: 0f 1f 00 nopl (%rax) b: 90 nop c: 90 nop d: 90 nop e: 90 nop f: 90 nop 10: 90 nop 11: 90 nop 12: 90 nop 13: 90 nop 14: 90 nop 15: 90 nop 16: 90 nop 17: 90 nop 18: 90 nop 19: 90 nop 1a: 90 nop 1b: f3 0f 1e fa endbr64 1f: 66 90 xchg %ax,%ax 21: 0f 00 2d 83 37 10 00 verw 0x103783(%rip) # 0x1037ab 28: fb sti 29: f4 hlt 2a:* e9 fc 54 02 00 jmp 0x2552b <-- trapping instruction 2f: 66 2e 0f 1f 84 00 00 cs nopw 0x0(%rax,%rax,1) 36: 00 00 00 39: 66 90 xchg %ax,%ax 3b: 90 nop 3c: 90 nop 3d: 90 nop 3e: 90 nop 3f: 90 nop Code starting with the faulting instruction =========================================== 0: e9 fc 54 02 00 jmp 0x25501 5: 66 2e 0f 1f 84 00 00 cs nopw 0x0(%rax,%rax,1) c: 00 00 00 f: 66 90 xchg %ax,%ax 11: 90 nop 12: 90 nop 13: 90 nop 14: 90 nop 15: 90 nop [ 16.335166][ C0] RSP: 0018:ffffffffa5607df8 EFLAGS: 00000246 [ 16.335169][ C0] RAX: 0000000000000000 RBX: 1ffffffff4ac0fc3 RCX: ffffffffa49905d9 [ 16.335171][ C0] RDX: ffffed1005e866fb RSI: ffffffffa4c53b60 RDI: ffffffffa218d18f [ 16.335173][ C0] RBP: 0000000000000000 R08: 0000000000000000 R09: ffffed1005e866fa [ 16.335175][ C0] R10: ffff88802f4337d3 R11: ffff888001bda818 R12: 0000000000000000 [ 16.335176][ C0] R13: ffffffffa561f240 R14: dffffc0000000000 R15: 0000000000014770 [ 16.335181][ C0] ? ct_kernel_exit.constprop.0 (kernel/context_tracking.c:146) [ 16.335184][ C0] ? cpuidle_idle_call (kernel/sched/idle.c:186) [ 16.335188][ C0] default_idle (./arch/x86/include/asm/paravirt.h:107 arch/x86/kernel/process.c:743) [ 16.335190][ C0] default_idle_call (./include/linux/cpuidle.h:143 kernel/sched/idle.c:118) [ 16.335193][ C0] cpuidle_idle_call (kernel/sched/idle.c:186) [ 16.335196][ C0] ? __pfx_cpuidle_idle_call (kernel/sched/idle.c:168) [ 16.335200][ C0] ? tsc_verify_tsc_adjust (arch/x86/kernel/tsc_sync.c:60) [ 16.335205][ C0] do_idle (kernel/sched/idle.c:325) [ 16.335209][ C0] cpu_startup_entry (kernel/sched/idle.c:422 (discriminator 1)) [ 16.335212][ C0] rest_init (./include/linux/rcupdate.h:842 init/main.c:714) [ 16.335215][ C0] start_kernel (init/main.c:1049 (discriminator 1)) [ 16.335219][ C0] x86_64_start_reservations (arch/x86/kernel/head64.c:295) [ 16.335224][ C0] x86_64_start_kernel (arch/x86/kernel/head64.c:231 (discriminator 17)) Finger prints: mark_lock_irq:mark_lock:mark_usage:__lock_acquire:_raw_spin_lock handle_softirqs:dump_stack_lvl:__might_resched:down_write:simple_recursive_removal schedule_preempt_disabled:dump_stack_lvl:__might_resched:down_write:simple_recursive_removal