====================================== | [ 46.426121][ C0] common_startup_64 (arch/x86/kernel/head_64.S:421) | [ 46.426290][ C0] | [ 46.426372][ C0] | [ 46.426372][ C0] stack backtrace: [ 46.427012][ C0] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS rel-1.16.3-0-ga6ed6b701f0a-prebuilt.qemu.org 04/01/2014 [ 46.427473][ C0] Call Trace: [ 46.427613][ C0] [ 46.427697][ C0] dump_stack_lvl (lib/dump_stack.c:117) [ 46.427864][ C0] print_irq_inversion_bug.part.0 (kernel/locking/lockdep.c:4024) [ 46.428074][ C0] ? common_startup_64 (arch/x86/kernel/head_64.S:421) [ 46.428333][ C0] ? __pfx_print_irq_inversion_bug.part.0 (kernel/locking/lockdep.c:4024) [ 46.428533][ C0] ? __pfx_usage_skip (kernel/locking/lockdep.c:2264) [ 46.428703][ C0] ? __pfx_usage_match (kernel/locking/lockdep.c:2256) [ 46.428865][ C0] ? arch_stack_walk (arch/x86/kernel/stacktrace.c:24) [ 46.429160][ C0] mark_lock_irq (kernel/locking/lockdep.c:4244) [ 46.429324][ C0] ? __pfx_mark_lock_irq (kernel/locking/lockdep.c:4207) [ 46.429492][ C0] ? stack_trace_save (kernel/stacktrace.c:123) [ 46.429660][ C0] ? add_chain_cache (kernel/locking/lockdep.c:3730) [ 46.429823][ C0] ? save_trace (kernel/locking/lockdep.c:586) [ 46.429985][ C0] mark_lock (kernel/locking/lockdep.c:4678) [ 46.430108][ C0] mark_usage (kernel/locking/lockdep.c:4567) [ 46.430230][ C0] __lock_acquire (kernel/locking/lockdep.c:5091) [ 46.430390][ C0] ? __lock_acquire (kernel/locking/lockdep.c:5137) [ 46.430557][ C0] ? __pfx_br_forward_delay_timer_expired (net/bridge/br_stp_timer.c:80) bridge [ 46.430832][ C0] lock_acquire.part.0 (kernel/locking/lockdep.c:467 kernel/locking/lockdep.c:5756) [ 46.430999][ C0] ? br_forward_delay_timer_expired (net/bridge/br_stp_timer.c:87) bridge [ 46.431238][ C0] ? __pfx_lock_acquire.part.0 (kernel/locking/lockdep.c:5719) [ 46.431495][ C0] ? trace_lock_acquire (./include/trace/events/lock.h:24 (discriminator 52)) [ 46.431659][ C0] ? br_forward_delay_timer_expired (net/bridge/br_stp_timer.c:87) bridge [ 46.431896][ C0] ? lock_acquire (kernel/locking/lockdep.c:5727) [ 46.432058][ C0] ? br_forward_delay_timer_expired (net/bridge/br_stp_timer.c:87) bridge [ 46.432391][ C0] _raw_spin_lock (./include/linux/spinlock_api_smp.h:134 kernel/locking/spinlock.c:154) [ 46.432561][ C0] ? br_forward_delay_timer_expired (net/bridge/br_stp_timer.c:87) bridge [ 46.432809][ C0] br_forward_delay_timer_expired (net/bridge/br_stp_timer.c:87) bridge [ 46.433168][ C0] ? __pfx_br_forward_delay_timer_expired (net/bridge/br_stp_timer.c:80) bridge [ 46.433449][ C0] call_timer_fn (kernel/time/timer.c:1793) [ 46.433612][ C0] ? call_timer_fn (./include/linux/lockdep.h:31 kernel/time/timer.c:1783) [ 46.433774][ C0] ? call_timer_fn (./include/linux/lockdep.h:31 kernel/time/timer.c:1783) [ 46.433938][ C0] ? __pfx_call_timer_fn (kernel/time/timer.c:1770) [ 46.434116][ C0] ? mark_lock (kernel/locking/lockdep.c:4656 (discriminator 3)) [ 46.434244][ C0] __run_timers (kernel/time/timer.c:1845 kernel/time/timer.c:2418) [ 46.434410][ C0] ? __pfx_br_forward_delay_timer_expired (net/bridge/br_stp_timer.c:80) bridge [ 46.434692][ C0] ? __pfx___run_timers (kernel/time/timer.c:2389) [ 46.434854][ C0] ? __lock_release (kernel/locking/lockdep.c:5430) [ 46.435016][ 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) [ 46.435190][ C0] ? __pfx_do_raw_spin_lock (kernel/locking/spinlock_debug.c:114) [ 46.435447][ C0] ? lock_acquire (kernel/locking/lockdep.c:5727) [ 46.435617][ C0] ? timer_expire_remote (kernel/time/timer.c:2429 kernel/time/timer.c:2422 kernel/time/timer.c:2181) [ 46.435782][ C0] timer_expire_remote (kernel/time/timer.c:2430 kernel/time/timer.c:2422 kernel/time/timer.c:2181) [ 46.435950][ 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) [ 46.436210][ C0] ? __pfx_tmigr_handle_remote_cpu (kernel/time/timer_migration.c:869) [ 46.436414][ C0] tmigr_handle_remote_up (kernel/time/timer_migration.c:1003) [ 46.436588][ C0] tmigr_handle_remote (kernel/time/timer_migration.c:488 kernel/time/timer_migration.c:1061) [ 46.436747][ 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) [ 46.437009][ C0] ? __pfx_tmigr_handle_remote (kernel/time/timer_migration.c:1026) [ 46.437176][ C0] ? __pfx_do_raw_spin_lock (kernel/locking/spinlock_debug.c:114) [ 46.437340][ C0] ? lockdep_hardirqs_on_prepare.part.0 (kernel/locking/lockdep.c:4292 kernel/locking/lockdep.c:4359) [ 46.437566][ C0] __do_softirq (kernel/softirq.c:554) [ 46.437826][ C0] irq_exit_rcu (kernel/softirq.c:428 kernel/softirq.c:633 kernel/softirq.c:645) [ 46.437957][ C0] sysvec_apic_timer_interrupt (arch/x86/kernel/apic/apic.c:1043 arch/x86/kernel/apic/apic.c:1043) [ 46.438121][ C0] [ 46.438208][ C0] [ 46.438290][ C0] asm_sysvec_apic_timer_interrupt (./arch/x86/include/asm/idtentry.h:702) [ 46.438501][ 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) [ 46.438768][ 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 [ 46.439548][ C0] RSP: 0018:ffffffffa8c07e00 EFLAGS: 00000246 [ 46.439755][ C0] RAX: 00000000000c6359 RBX: 1ffffffff5180fc2 RCX: ffffffffa7d0e9d5 [ 46.440011][ C0] RDX: 0000000000000000 RSI: 0000000000000000 RDI: ffffffffa56aa4a4 [ 46.440349][ C0] RBP: 0000000000000000 R08: 0000000000000001 R09: ffffed1006c0709c [ 46.440591][ C0] R10: ffff8880360384e3 R11: ffff88803602d9b0 R12: 0000000000000000 [ 46.440830][ C0] R13: ffffffffa8c1d000 R14: dffffc0000000000 R15: 0000000000014770 [ 46.441181][ C0] ? ct_kernel_exit.constprop.0 (kernel/context_tracking.c:147) [ 46.441351][ C0] ? cpuidle_idle_call (kernel/sched/idle.c:192) [ 46.441520][ C0] default_idle_call (./include/linux/cpuidle.h:143 kernel/sched/idle.c:118) [ 46.441680][ C0] cpuidle_idle_call (kernel/sched/idle.c:192) [ 46.441842][ C0] ? __pfx_cpuidle_idle_call (kernel/sched/idle.c:168) [ 46.442004][ C0] ? tsc_verify_tsc_adjust (arch/x86/kernel/tsc_sync.c:59) [ 46.442167][ C0] do_idle (kernel/sched/idle.c:332) [ 46.442288][ C0] cpu_startup_entry (kernel/sched/idle.c:429 (discriminator 1)) [ 46.442447][ C0] rest_init (./include/linux/rcupdate.h:782 init/main.c:703) [ 46.442578][ C0] start_kernel (init/main.c:1024 (discriminator 1)) [ 46.442745][ C0] x86_64_start_reservations (arch/x86/kernel/head64.c:495) [ 46.442904][ 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