====================================== | [ 18.172250][ C1] 1 lock held by ksoftirqd/1/23: | [ 18.172328][ C1] #0: ffffffffba777c00 (rcu_callback){....}-{0:0}, at: rcu_do_batch (./include/linux/rcupdate.h:300 (discriminator 2) kernel/rcu/tree.c:2611 (discriminator 2)) | [ 18.172467][ C1] | [ 18.172467][ C1] stack backtrace: [ 18.172566][ C1] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 18.172568][ C1] Call Trace: [ 18.172569][ C1] [ 18.172571][ C1] dump_stack_lvl (lib/dump_stack.c:94 lib/dump_stack.c:120) [ 18.172576][ C1] print_usage_bug.part.0.cold (kernel/locking/lockdep.c:4042) [ 18.172579][ C1] mark_lock_irq (kernel/locking/lockdep.c:4013 kernel/locking/lockdep.c:4056 kernel/locking/lockdep.c:4267) [ 18.172580][ C1] ? kthread (kernel/kthread.c:436) [ 18.172583][ C1] ? save_trace (kernel/locking/lockdep.c:589) [ 18.172584][ C1] ? __lock_acquire (kernel/locking/lockdep.c:5237) [ 18.172586][ C1] mark_lock (kernel/locking/lockdep.c:4753) [ 18.172588][ C1] mark_usage (kernel/locking/lockdep.c:4642) [ 18.172589][ C1] __lock_acquire (kernel/locking/lockdep.c:5191) [ 18.172591][ C1] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:752 (discriminator 3)) [ 18.172594][ C1] lock_acquire.part.0 (kernel/locking/lockdep.c:5868 (discriminator 1)) [ 18.172595][ C1] ? tcf_mirred_release (./include/linux/spinlock.h:342 net/sched/act_mirred.c:78) act_mirred [ 18.172597][ C1] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:752 (discriminator 3)) [ 18.172598][ C1] ? lock_acquire (./include/trace/events/lock.h:24 (discriminator 22) kernel/locking/lockdep.c:5831 (discriminator 22)) [ 18.172600][ C1] _raw_spin_lock (./include/linux/spinlock_api_smp.h:158 (discriminator 1) kernel/locking/spinlock.c:158 (discriminator 1)) [ 18.172602][ C1] ? tcf_mirred_release (./include/linux/spinlock.h:342 net/sched/act_mirred.c:78) act_mirred [ 18.172603][ C1] tcf_mirred_release (./include/linux/spinlock.h:342 net/sched/act_mirred.c:78) act_mirred [ 18.172605][ C1] tcf_action_rcu_free (net/sched/act_api.c:367 net/sched/act_api.c:378) [ 18.172606][ C1] ? rcu_do_batch (./include/linux/rcupdate.h:310 (discriminator 2) kernel/rcu/tree.c:2619 (discriminator 2)) [ 18.172608][ C1] rcu_do_batch (kernel/rcu/tree.c:2617) [ 18.172610][ C1] ? rcu_start_this_gp (kernel/rcu/tree.c:1040 (discriminator 1)) [ 18.172612][ C1] ? trace_rcu_batch_end (./include/trace/events/rcu.h:714 (discriminator 19)) [ 18.172614][ C1] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:752 (discriminator 3)) [ 18.172616][ C1] ? trace_irq_enable.constprop.0 (./include/trace/events/preemptirq.h:40 (discriminator 22)) [ 18.172619][ C1] rcu_core (kernel/rcu/tree.c:2869) [ 18.172621][ C1] handle_softirqs (kernel/softirq.c:622) [ 18.172623][ C1] ? find_held_lock (kernel/locking/lockdep.c:5350) [ 18.172626][ C1] ? _local_bh_enable (kernel/softirq.c:405 (discriminator 1)) [ 18.172627][ C1] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:752 (discriminator 3)) [ 18.172629][ C1] run_ksoftirqd (kernel/softirq.c:1076 kernel/softirq.c:1068) [ 18.172630][ C1] smpboot_thread_fn (kernel/smpboot.c:160) [ 18.172633][ C1] ? sort_range (kernel/range.c:164) [ 18.172634][ C1] kthread (kernel/kthread.c:436) [ 18.172636][ C1] ? trace_irq_enable.constprop.0 (./include/trace/events/preemptirq.h:40 (discriminator 22)) [ 18.172637][ C1] ? kthread_affine_node (kernel/kthread.c:378) [ 18.172639][ C1] ret_from_fork (arch/x86/kernel/process.c:158) [ 18.172642][ C1] ? arch_exit_to_user_mode_prepare.isra.0 (arch/x86/entry/syscall_64.c:37) [ 18.172644][ C1] ? __switch_to (arch/x86/kernel/process_64.c:403 arch/x86/kernel/process_64.c:663) [ 18.172646][ C1] ? kthread_affine_node (kernel/kthread.c:378) [ 18.172648][ C1] ret_from_fork_asm (arch/x86/entry/entry_64.S:245) | [ 24.741886][ C1] RCU nest depth: 0, expected: 0 | [ 24.741974][ C1] INFO: lockdep is turned off. | [ 24.742051][ C1] Preemption disabled at: | [ 24.742052][ C1] 0x0 [ 24.742206][ C1] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 24.742208][ C1] Call Trace: [ 24.742209][ C1] [ 24.742211][ C1] dump_stack_lvl (lib/dump_stack.c:94 lib/dump_stack.c:120) [ 24.742218][ C1] __might_resched.cold (kernel/sched/core.c:9163) [ 24.742222][ C1] ? default_idle_call (kernel/sched/idle.c:122) [ 24.742226][ C1] ? perf_trace_sched_switch (./include/linux/list.h:1021 (discriminator 3)) [ 24.742230][ C1] ? start_secondary (arch/x86/kernel/smpboot.c:312) [ 24.742234][ C1] __mutex_lock (kernel/locking/mutex.c:623 kernel/locking/mutex.c:820) [ 24.742236][ C1] ? __tcf_chain_put (net/sched/cls_api.c:694) [ 24.742240][ C1] ? ww_mutex_lock (kernel/locking/mutex.c:933) [ 24.742243][ C1] ? __tcf_chain_put (net/sched/cls_api.c:694) [ 24.742245][ C1] __tcf_chain_put (net/sched/cls_api.c:694) [ 24.742246][ C1] ? free_percpu.part.0 (./include/linux/spinlock.h:408 (discriminator 3) mm/percpu.c:2283 (discriminator 3)) [ 24.742250][ C1] tcf_action_rcu_free (net/sched/act_api.c:130 net/sched/act_api.c:370 net/sched/act_api.c:378) [ 24.742252][ C1] ? rcu_do_batch (./include/linux/rcupdate.h:310 (discriminator 2) kernel/rcu/tree.c:2619 (discriminator 2)) [ 24.742255][ C1] rcu_do_batch (kernel/rcu/tree.c:2617) [ 24.742258][ C1] ? trace_rcu_batch_end (./include/trace/events/rcu.h:714 (discriminator 19)) [ 24.742260][ C1] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:752 (discriminator 3)) [ 24.742261][ C1] ? trace_irq_enable.constprop.0 (./include/trace/events/preemptirq.h:40 (discriminator 22)) [ 24.742265][ C1] ? trace_irq_disable.constprop.0 (./include/trace/events/preemptirq.h:36 (discriminator 22)) [ 24.742267][ C1] rcu_core (kernel/rcu/tree.c:2869) [ 24.742269][ C1] handle_softirqs (kernel/softirq.c:622) [ 24.742271][ C1] ? clockevents_tick_resume (kernel/time/clockevents.c:193) [ 24.742274][ C1] ? _local_bh_enable (kernel/softirq.c:405 (discriminator 1)) [ 24.742275][ C1] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:752 (discriminator 3)) [ 24.742277][ C1] ? lock_release (./include/trace/events/lock.h:69 (discriminator 22) kernel/locking/lockdep.c:5879 (discriminator 22)) [ 24.742280][ C1] __irq_exit_rcu (kernel/softirq.c:656 kernel/softirq.c:496 kernel/softirq.c:735) [ 24.742281][ C1] irq_exit_rcu (kernel/softirq.c:752) [ 24.742282][ C1] sysvec_apic_timer_interrupt (arch/x86/kernel/apic/apic.c:1061 (discriminator 37) arch/x86/kernel/apic/apic.c:1061 (discriminator 37)) [ 24.742284][ C1] [ 24.742285][ C1] [ 24.742286][ C1] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:752 (discriminator 3)) [ 24.742287][ C1] asm_sysvec_apic_timer_interrupt (./arch/x86/include/asm/idtentry.h:697) [ 24.742289][ C1] RIP: 0010:pv_native_safe_halt (./arch/x86/include/asm/irqflags.h:48 arch/x86/kernel/paravirt.c:62) [ 24.742292][ C1] Code: 48 8b 3d 44 d3 00 02 e8 1f 00 00 00 48 2b 05 c8 71 a3 00 c3 0f 1f 80 00 00 00 00 f3 0f 1e fa eb 07 0f 00 2d 43 f4 22 00 fb f4 0f 1f 40 d6 48 83 ec 20 8b 17 49 89 f8 83 e2 fe 41 89 d2 0f 01 All code ======== 0: 48 8b 3d 44 d3 00 02 mov 0x200d344(%rip),%rdi # 0x200d34b 7: e8 1f 00 00 00 call 0x2b c: 48 2b 05 c8 71 a3 00 sub 0xa371c8(%rip),%rax # 0xa371db 13: c3 ret 14: 0f 1f 80 00 00 00 00 nopl 0x0(%rax) 1b: f3 0f 1e fa endbr64 1f: eb 07 jmp 0x28 21: 0f 00 2d 43 f4 22 00 verw 0x22f443(%rip) # 0x22f46b 28: fb sti 29: f4 hlt 2a:* c3 ret <-- trapping instruction 2b: 0f 1f 40 d6 nopl -0x2a(%rax) 2f: 48 83 ec 20 sub $0x20,%rsp 33: 8b 17 mov (%rdi),%edx 35: 49 89 f8 mov %rdi,%r8 38: 83 e2 fe and $0xfffffffe,%edx 3b: 41 89 d2 mov %edx,%r10d 3e: 0f .byte 0xf 3f: 01 .byte 0x1 Code starting with the faulting instruction =========================================== 0: c3 ret 1: 0f 1f 40 d6 nopl -0x2a(%rax) 5: 48 83 ec 20 sub $0x20,%rsp 9: 8b 17 mov (%rdi),%edx b: 49 89 f8 mov %rdi,%r8 e: 83 e2 fe and $0xfffffffe,%edx 11: 41 89 d2 mov %edx,%r10d 14: 0f .byte 0xf 15: 01 .byte 0x1 [ 24.742294][ C1] RSP: 0018:ffa0000000147de8 EFLAGS: 00000246 [ 24.742297][ C1] RAX: 0000000000000001 RBX: ff11000001bb2340 RCX: 0000000000000001 [ 24.742298][ C1] RDX: 0000000000000001 RSI: ffffffffb9c6f640 RDI: ffffffffb74d9667 [ 24.742299][ C1] RBP: 0000000000000000 R08: ffffffffb98694f1 R09: 1fe2200006a5639a [ 24.742300][ C1] R10: 0000000000000001 R11: 0000000000000000 R12: 1ff4000000028fc0 [ 24.742301][ C1] R13: 0000000000000000 R14: dffffc0000000000 R15: 0000000000000000 [ 24.742302][ C1] ? ct_kernel_exit.constprop.0 (./include/linux/instrumented.h:97 kernel/context_tracking.c:124) [ 24.742304][ C1] ? cpuidle_idle_call.constprop.0 (kernel/sched/idle.c:199) [ 24.742307][ C1] default_idle (./arch/x86/include/asm/paravirt.h:62 arch/x86/kernel/process.c:767) [ 24.742309][ C1] default_idle_call (kernel/sched/idle.c:122) [ 24.742310][ C1] cpuidle_idle_call.constprop.0 (kernel/sched/idle.c:199) [ 24.742312][ C1] ? arch_cpu_idle_exit+0x40/0x40 [ 24.742313][ C1] ? mark_tsc_async_resets (arch/x86/kernel/tsc_sync.c:49) [ 24.742315][ C1] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:752 (discriminator 3)) [ 24.742316][ C1] do_idle (kernel/sched/idle.c:352) [ 24.742318][ C1] cpu_startup_entry (kernel/sched/idle.c:451) [ 24.742319][ C1] start_secondary (arch/x86/kernel/smpboot.c:312) [ 24.742321][ C1] ? set_cpu_sibling_map (./arch/x86/include/asm/smp.h:148 (discriminator 4)) Finger prints: mark_lock_irq:mark_lock:mark_usage:__lock_acquire:_raw_spin_lock __mutex_lock:__tcf_chain_put:tcf_action_rcu_free:rcu_do_batch:rcu_core