====================================== | [ 46.939125][ C3] common_startup_64 (arch/x86/kernel/head_64.S:421) | [ 46.939279][ C3] | [ 46.939356][ C3] | [ 46.939356][ C3] stack backtrace: [ 46.939864][ C3] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS rel-1.16.3-0-ga6ed6b701f0a-prebuilt.qemu.org 04/01/2014 [ 46.940211][ C3] Call Trace: [ 46.940409][ C3] [ 46.940491][ C3] dump_stack_lvl (lib/dump_stack.c:117) [ 46.940663][ C3] print_irq_inversion_bug.part.0 (kernel/locking/lockdep.c:4024) [ 46.940855][ C3] ? common_startup_64 (arch/x86/kernel/head_64.S:421) [ 46.941096][ C3] ? __pfx_print_irq_inversion_bug.part.0 (kernel/locking/lockdep.c:4024) [ 46.941291][ C3] ? __pfx_usage_skip (kernel/locking/lockdep.c:2264) [ 46.941447][ C3] ? __pfx_usage_match (kernel/locking/lockdep.c:2256) [ 46.941612][ C3] ? arch_stack_walk (arch/x86/kernel/stacktrace.c:24) [ 46.941846][ C3] mark_lock_irq (kernel/locking/lockdep.c:4244) [ 46.942005][ C3] ? __pfx_mark_lock_irq (kernel/locking/lockdep.c:4207) [ 46.942158][ C3] ? stack_trace_save (kernel/stacktrace.c:123) [ 46.942312][ C3] ? add_chain_cache (kernel/locking/lockdep.c:3730) [ 46.942467][ C3] ? save_trace (kernel/locking/lockdep.c:586) [ 46.942706][ C3] mark_lock (kernel/locking/lockdep.c:4678) [ 46.942829][ C3] mark_usage (kernel/locking/lockdep.c:4567) [ 46.942945][ C3] __lock_acquire (kernel/locking/lockdep.c:5091) [ 46.943104][ C3] ? __lock_acquire (kernel/locking/lockdep.c:5137) [ 46.943337][ C3] ? __pfx_br_forward_delay_timer_expired (net/bridge/br_stp_timer.c:80) bridge [ 46.943609][ C3] lock_acquire.part.0 (kernel/locking/lockdep.c:467 kernel/locking/lockdep.c:5756) [ 46.943764][ C3] ? br_forward_delay_timer_expired (net/bridge/br_stp_timer.c:87) bridge [ 46.943992][ C3] ? __pfx_lock_acquire.part.0 (kernel/locking/lockdep.c:5719) [ 46.944229][ C3] ? trace_lock_acquire (./include/trace/events/lock.h:24 (discriminator 52)) [ 46.944383][ C3] ? br_forward_delay_timer_expired (net/bridge/br_stp_timer.c:87) bridge [ 46.944620][ C3] ? lock_acquire (kernel/locking/lockdep.c:5727) [ 46.944773][ C3] ? br_forward_delay_timer_expired (net/bridge/br_stp_timer.c:87) bridge [ 46.945084][ C3] _raw_spin_lock (./include/linux/spinlock_api_smp.h:134 kernel/locking/spinlock.c:154) [ 46.945237][ C3] ? br_forward_delay_timer_expired (net/bridge/br_stp_timer.c:87) bridge [ 46.945460][ C3] br_forward_delay_timer_expired (net/bridge/br_stp_timer.c:87) bridge [ 46.945767][ C3] ? __pfx_br_forward_delay_timer_expired (net/bridge/br_stp_timer.c:80) bridge [ 46.946034][ C3] call_timer_fn (kernel/time/timer.c:1793) [ 46.946188][ C3] ? call_timer_fn (./include/linux/lockdep.h:31 kernel/time/timer.c:1783) [ 46.946341][ C3] ? call_timer_fn (./include/linux/lockdep.h:31 kernel/time/timer.c:1783) [ 46.946576][ C3] ? __pfx_call_timer_fn (kernel/time/timer.c:1770) [ 46.946730][ C3] ? mark_lock (kernel/locking/lockdep.c:4656 (discriminator 3)) [ 46.946854][ C3] __run_timers (kernel/time/timer.c:1845 kernel/time/timer.c:2418) [ 46.947009][ C3] ? __pfx_br_forward_delay_timer_expired (net/bridge/br_stp_timer.c:80) bridge [ 46.947355][ C3] ? __pfx___run_timers (kernel/time/timer.c:2389) [ 46.947515][ C3] ? __lock_release (kernel/locking/lockdep.c:5430) [ 46.947668][ C3] ? 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.947822][ C3] ? __pfx_do_raw_spin_lock (kernel/locking/spinlock_debug.c:114) [ 46.948137][ C3] ? lock_acquire (kernel/locking/lockdep.c:5727) [ 46.948291][ C3] ? timer_expire_remote (kernel/time/timer.c:2429 kernel/time/timer.c:2422 kernel/time/timer.c:2181) [ 46.948446][ C3] timer_expire_remote (kernel/time/timer.c:2430 kernel/time/timer.c:2422 kernel/time/timer.c:2181) [ 46.948602][ C3] 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.948767][ C3] ? __pfx_tmigr_handle_remote_cpu (kernel/time/timer_migration.c:869) [ 46.949050][ C3] tmigr_handle_remote_up (kernel/time/timer_migration.c:1003) [ 46.949205][ C3] tmigr_handle_remote (kernel/time/timer_migration.c:488 kernel/time/timer_migration.c:1061) [ 46.949361][ C3] ? 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.949513][ C3] ? __pfx_tmigr_handle_remote (kernel/time/timer_migration.c:1026) [ 46.949747][ C3] ? __pfx_do_raw_spin_lock (kernel/locking/spinlock_debug.c:114) [ 46.949913][ C3] ? lockdep_hardirqs_on_prepare.part.0 (kernel/locking/lockdep.c:4292 kernel/locking/lockdep.c:4359) [ 46.950105][ C3] __do_softirq (kernel/softirq.c:554) [ 46.950258][ C3] irq_exit_rcu (kernel/softirq.c:428 kernel/softirq.c:633 kernel/softirq.c:645) [ 46.950466][ C3] sysvec_apic_timer_interrupt (arch/x86/kernel/apic/apic.c:1043 arch/x86/kernel/apic/apic.c:1043) [ 46.950619][ C3] [ 46.950700][ C3] [ 46.950781][ C3] asm_sysvec_apic_timer_interrupt (./arch/x86/include/asm/idtentry.h:702) [ 46.950979][ C3] 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.951227][ C3] 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.951777][ C3] RSP: 0018:ffffc9000016fdf8 EFLAGS: 00000246 [ 46.952059][ C3] RAX: 0000000000097187 RBX: 1ffff9200002dfc1 RCX: ffffffff9450e9d5 [ 46.952310][ C3] RDX: 0000000000000000 RSI: 0000000000000000 RDI: ffffffff91eaa4a4 [ 46.952547][ C3] RBP: 0000000000000000 R08: 0000000000000001 R09: ffffed1005f3709c [ 46.952859][ C3] R10: ffff88802f9b84e3 R11: ffff88802f9ad9b0 R12: 0000000000000000 [ 46.953097][ C3] R13: ffff888001b88040 R14: dffffc0000000000 R15: 0000000000000000 [ 46.953414][ C3] ? ct_kernel_exit.constprop.0 (kernel/context_tracking.c:147) [ 46.953570][ C3] ? cpuidle_idle_call (kernel/sched/idle.c:192) [ 46.953723][ C3] default_idle_call (./include/linux/cpuidle.h:143 kernel/sched/idle.c:118) [ 46.953875][ C3] cpuidle_idle_call (kernel/sched/idle.c:192) [ 46.954038][ C3] ? __pfx_cpuidle_idle_call (kernel/sched/idle.c:168) [ 46.954278][ C3] ? tsc_verify_tsc_adjust (arch/x86/kernel/tsc_sync.c:59) [ 46.954444][ C3] do_idle (kernel/sched/idle.c:332) [ 46.954563][ C3] cpu_startup_entry (kernel/sched/idle.c:429 (discriminator 1)) [ 46.954717][ C3] start_secondary (arch/x86/kernel/smpboot.c:201 arch/x86/kernel/smpboot.c:281) [ 46.954951][ C3] ? __pfx_start_secondary (arch/x86/kernel/smpboot.c:231) Finger prints: common_startup_64:dump_stack_lvl:mark_lock_irq:mark_lock