====================================== | [ 44.919601][ C0] common_startup_64 (arch/x86/kernel/head_64.S:421) | [ 44.919765][ C0] | [ 44.919847][ C0] | [ 44.919847][ C0] stack backtrace: [ 44.920310][ C0] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS rel-1.16.3-0-ga6ed6b701f0a-prebuilt.qemu.org 04/01/2014 [ 44.920668][ C0] Call Trace: [ 44.920795][ C0] [ 44.920976][ C0] dump_stack_lvl (lib/dump_stack.c:117) [ 44.921146][ C0] print_irq_inversion_bug.part.0 (kernel/locking/lockdep.c:4024) [ 44.921348][ C0] ? common_startup_64 (arch/x86/kernel/head_64.S:421) [ 44.921518][ C0] ? __pfx_print_irq_inversion_bug.part.0 (kernel/locking/lockdep.c:4024) [ 44.921821][ C0] ? __pfx_usage_skip (kernel/locking/lockdep.c:2264) [ 44.921985][ C0] ? __pfx_usage_match (kernel/locking/lockdep.c:2256) [ 44.922150][ C0] ? arch_stack_walk (arch/x86/kernel/stacktrace.c:24) [ 44.922315][ C0] mark_lock_irq (kernel/locking/lockdep.c:4244) [ 44.922573][ C0] ? __pfx_mark_lock_irq (kernel/locking/lockdep.c:4207) [ 44.922738][ C0] ? stack_trace_save (kernel/stacktrace.c:123) [ 44.922904][ C0] ? add_chain_cache (kernel/locking/lockdep.c:3730) [ 44.923067][ C0] ? save_trace (kernel/locking/lockdep.c:586) [ 44.923328][ C0] mark_lock (kernel/locking/lockdep.c:4678) [ 44.923453][ C0] mark_usage (kernel/locking/lockdep.c:4567) [ 44.923576][ C0] __lock_acquire (kernel/locking/lockdep.c:5091) [ 44.923741][ C0] ? __lock_acquire (kernel/locking/lockdep.c:5137) [ 44.923904][ C0] ? __pfx_br_forward_delay_timer_expired (net/bridge/br_stp_timer.c:80) bridge [ 44.924278][ C0] lock_acquire.part.0 (kernel/locking/lockdep.c:467 kernel/locking/lockdep.c:5756) [ 44.924441][ C0] ? br_forward_delay_timer_expired (net/bridge/br_stp_timer.c:87) bridge [ 44.924680][ C0] ? __pfx_lock_acquire.part.0 (kernel/locking/lockdep.c:5719) [ 44.924849][ C0] ? trace_lock_acquire (./include/trace/events/lock.h:24 (discriminator 52)) [ 44.925111][ C0] ? br_forward_delay_timer_expired (net/bridge/br_stp_timer.c:87) bridge [ 44.925364][ C0] ? lock_acquire (kernel/locking/lockdep.c:5727) [ 44.925526][ C0] ? br_forward_delay_timer_expired (net/bridge/br_stp_timer.c:87) bridge [ 44.925965][ C0] _raw_spin_lock (./include/linux/spinlock_api_smp.h:134 kernel/locking/spinlock.c:154) [ 44.926129][ C0] ? br_forward_delay_timer_expired (net/bridge/br_stp_timer.c:87) bridge [ 44.926372][ C0] br_forward_delay_timer_expired (net/bridge/br_stp_timer.c:87) bridge [ 44.926641][ C0] ? __pfx_br_forward_delay_timer_expired (net/bridge/br_stp_timer.c:80) bridge [ 44.927024][ C0] call_timer_fn (kernel/time/timer.c:1793) [ 44.927191][ C0] ? call_timer_fn (./include/linux/lockdep.h:31 kernel/time/timer.c:1783) [ 44.927355][ C0] ? call_timer_fn (./include/linux/lockdep.h:31 kernel/time/timer.c:1783) [ 44.927521][ C0] ? __pfx_call_timer_fn (kernel/time/timer.c:1770) [ 44.927779][ C0] ? mark_lock (kernel/locking/lockdep.c:4656 (discriminator 3)) [ 44.927909][ C0] __run_timers (kernel/time/timer.c:1845 kernel/time/timer.c:2418) [ 44.928073][ C0] ? __pfx_br_forward_delay_timer_expired (net/bridge/br_stp_timer.c:80) bridge [ 44.928351][ C0] ? __pfx___run_timers (kernel/time/timer.c:2389) [ 44.928615][ C0] ? __lock_release (kernel/locking/lockdep.c:5430) [ 44.928781][ C0] ? do_raw_spin_lock (./arch/x86/include/asm/atomic.h:115 ./include/linux/atomic/atomic-arch-fallback.h:2170 ./include/linux/atomic/atomic-instrumented.h:1302 ./include/asm-generic/qspinlock.h:111 kernel/locking/spinlock_debug.c:116) [ 44.928945][ C0] ? __pfx_do_raw_spin_lock (kernel/locking/spinlock_debug.c:114) [ 44.929112][ C0] ? lock_acquire (kernel/locking/lockdep.c:5727) [ 44.929371][ C0] ? timer_expire_remote (kernel/time/timer.c:2429 kernel/time/timer.c:2422 kernel/time/timer.c:2181) [ 44.929567][ C0] timer_expire_remote (kernel/time/timer.c:2430 kernel/time/timer.c:2422 kernel/time/timer.c:2181) [ 44.929740][ C0] tmigr_handle_remote_cpu (./arch/x86/include/asm/irqflags.h:26 ./arch/x86/include/asm/irqflags.h:67 ./arch/x86/include/asm/irqflags.h:127 kernel/time/timer_migration.c:925) [ 44.929927][ C0] ? __pfx_tmigr_handle_remote_cpu (kernel/time/timer_migration.c:869) [ 44.930240][ C0] tmigr_handle_remote_up (kernel/time/timer_migration.c:1003) [ 44.930418][ C0] tmigr_handle_remote (kernel/time/timer_migration.c:488 kernel/time/timer_migration.c:1061) [ 44.930595][ C0] ? do_raw_spin_lock (./arch/x86/include/asm/atomic.h:115 ./include/linux/atomic/atomic-arch-fallback.h:2170 ./include/linux/atomic/atomic-instrumented.h:1302 ./include/asm-generic/qspinlock.h:111 kernel/locking/spinlock_debug.c:116) [ 44.930778][ C0] ? __pfx_tmigr_handle_remote (kernel/time/timer_migration.c:1026) [ 44.931063][ C0] ? __pfx_do_raw_spin_lock (kernel/locking/spinlock_debug.c:114) [ 44.931242][ C0] ? lockdep_hardirqs_on_prepare.part.0 (kernel/locking/lockdep.c:4292 kernel/locking/lockdep.c:4359) [ 44.931460][ C0] __do_softirq (kernel/softirq.c:554) [ 44.931643][ C0] irq_exit_rcu (kernel/softirq.c:428 kernel/softirq.c:633 kernel/softirq.c:645) [ 44.931768][ C0] sysvec_apic_timer_interrupt (arch/x86/kernel/apic/apic.c:1043 arch/x86/kernel/apic/apic.c:1043) [ 44.932046][ C0] [ 44.932130][ C0] [ 44.932224][ C0] asm_sysvec_apic_timer_interrupt (./arch/x86/include/asm/idtentry.h:702) [ 44.932442][ C0] RIP: 0010:default_idle (./arch/x86/include/asm/irqflags.h:37 ./arch/x86/include/asm/irqflags.h:72 arch/x86/kernel/process.c:743) [ 44.932636][ C0] Code: 4c 01 c7 4c 29 c2 e9 72 ff ff ff 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 a3 30 35 00 fb f4 c3 cc cc cc cc 66 66 2e 0f 1f 84 00 00 00 00 00 90 90 90 90 90 All code ======== 0: 4c 01 c7 add %r8,%rdi 3: 4c 29 c2 sub %r8,%rdx 6: e9 72 ff ff ff jmp 0xffffffffffffff7d 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 a3 30 35 00 verw 0x3530a3(%rip) # 0x3530cb 28: fb sti 29: f4 hlt 2a:* fa cli <-- trapping instruction 2b: c3 ret 2c: cc int3 2d: cc int3 2e: cc int3 2f: cc int3 30: 66 66 2e 0f 1f 84 00 data16 cs nopw 0x0(%rax,%rax,1) 37: 00 00 00 00 3b: 90 nop 3c: 90 nop 3d: 90 nop 3e: 90 nop 3f: 90 nop Code starting with the faulting instruction =========================================== 0: fa cli 1: c3 ret 2: cc int3 3: cc int3 4: cc int3 5: cc int3 6: 66 66 2e 0f 1f 84 00 data16 cs nopw 0x0(%rax,%rax,1) d: 00 00 00 00 11: 90 nop 12: 90 nop 13: 90 nop 14: 90 nop 15: 90 nop [ 44.933367][ C0] RSP: 0018:ffffffff90e07e00 EFLAGS: 00000246 [ 44.933704][ C0] RAX: 000000000009d0c9 RBX: 1ffffffff21c0fc2 RCX: ffffffff8ff0e9d5 [ 44.933959][ C0] RDX: 0000000000000000 RSI: 0000000000000000 RDI: ffffffff8d8aa4a4 [ 44.934234][ C0] RBP: 0000000000000000 R08: 0000000000000001 R09: ffffed1005f0709c [ 44.934602][ C0] R10: ffff88802f8384e3 R11: ffff88802f82d9b0 R12: 0000000000000000 [ 44.934853][ C0] R13: ffffffff90e1d000 R14: dffffc0000000000 R15: 0000000000014770 [ 44.935153][ C0] ? ct_kernel_exit.constprop.0 (kernel/context_tracking.c:147) [ 44.935344][ C0] ? cpuidle_idle_call (kernel/sched/idle.c:192) [ 44.935514][ C0] default_idle_call (./include/linux/cpuidle.h:143 kernel/sched/idle.c:118) [ 44.935703][ C0] cpuidle_idle_call (kernel/sched/idle.c:192) [ 44.935881][ C0] ? __pfx_cpuidle_idle_call (kernel/sched/idle.c:168) [ 44.936155][ C0] ? tsc_verify_tsc_adjust (arch/x86/kernel/tsc_sync.c:59) [ 44.936335][ C0] do_idle (kernel/sched/idle.c:332) [ 44.936484][ C0] cpu_startup_entry (kernel/sched/idle.c:429 (discriminator 1)) [ 44.936695][ C0] rest_init (./include/linux/rcupdate.h:782 init/main.c:703) [ 44.936828][ C0] start_kernel (init/main.c:1024 (discriminator 1)) [ 44.937098][ C0] x86_64_start_reservations (arch/x86/kernel/head64.c:495) [ 44.937285][ C0] x86_64_start_kernel (arch/x86/kernel/head64.c:437 (discriminator 17)) Finger prints: common_startup_64:dump_stack_lvl:mark_lock_irq:mark_lock