====================================== | [ 48.483882][ C0] common_startup_64 (arch/x86/kernel/head_64.S:421) | [ 48.484130][ C0] | [ 48.484207][ C0] | [ 48.484207][ C0] stack backtrace: [ 48.484620][ C0] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS rel-1.16.3-0-ga6ed6b701f0a-prebuilt.qemu.org 04/01/2014 [ 48.485185][ C0] Call Trace: [ 48.485313][ C0] [ 48.485395][ C0] dump_stack_lvl (lib/dump_stack.c:117) [ 48.485649][ C0] print_irq_inversion_bug.part.0 (kernel/locking/lockdep.c:4024) [ 48.485839][ C0] ? common_startup_64 (arch/x86/kernel/head_64.S:421) [ 48.485998][ C0] ? __pfx_print_irq_inversion_bug.part.0 (kernel/locking/lockdep.c:4024) [ 48.486190][ C0] ? __pfx_usage_skip (kernel/locking/lockdep.c:2264) [ 48.486440][ C0] ? __pfx_usage_match (kernel/locking/lockdep.c:2256) [ 48.486590][ C0] ? arch_stack_walk (arch/x86/kernel/stacktrace.c:24) [ 48.486742][ C0] mark_lock_irq (kernel/locking/lockdep.c:4244) [ 48.486897][ C0] ? __pfx_mark_lock_irq (kernel/locking/lockdep.c:4207) [ 48.487049][ C0] ? stack_trace_save (kernel/stacktrace.c:123) [ 48.487201][ C0] ? add_chain_cache (kernel/locking/lockdep.c:3730) [ 48.487356][ C0] ? save_trace (kernel/locking/lockdep.c:586) [ 48.487506][ C0] mark_lock (kernel/locking/lockdep.c:4678) [ 48.487627][ C0] mark_usage (kernel/locking/lockdep.c:4567) [ 48.487836][ C0] __lock_acquire (kernel/locking/lockdep.c:5091) [ 48.487993][ C0] ? __lock_acquire (kernel/locking/lockdep.c:5137) [ 48.488144][ C0] ? __pfx_br_forward_delay_timer_expired (net/bridge/br_stp_timer.c:80) bridge [ 48.488406][ C0] lock_acquire.part.0 (kernel/locking/lockdep.c:467 kernel/locking/lockdep.c:5756) [ 48.488653][ C0] ? br_forward_delay_timer_expired (net/bridge/br_stp_timer.c:87) bridge [ 48.488879][ C0] ? __pfx_lock_acquire.part.0 (kernel/locking/lockdep.c:5719) [ 48.489039][ C0] ? trace_lock_acquire (./include/trace/events/lock.h:24 (discriminator 52)) [ 48.489204][ C0] ? br_forward_delay_timer_expired (net/bridge/br_stp_timer.c:87) bridge [ 48.489536][ C0] ? lock_acquire (kernel/locking/lockdep.c:5727) [ 48.489712][ C0] ? br_forward_delay_timer_expired (net/bridge/br_stp_timer.c:87) bridge [ 48.489950][ C0] _raw_spin_lock (./include/linux/spinlock_api_smp.h:134 kernel/locking/spinlock.c:154) [ 48.490104][ C0] ? br_forward_delay_timer_expired (net/bridge/br_stp_timer.c:87) bridge [ 48.490424][ C0] br_forward_delay_timer_expired (net/bridge/br_stp_timer.c:87) bridge [ 48.490654][ C0] ? __pfx_br_forward_delay_timer_expired (net/bridge/br_stp_timer.c:80) bridge [ 48.490931][ C0] call_timer_fn (kernel/time/timer.c:1793) [ 48.491086][ C0] ? call_timer_fn (./include/linux/lockdep.h:31 kernel/time/timer.c:1783) [ 48.491236][ C0] ? call_timer_fn (./include/linux/lockdep.h:31 kernel/time/timer.c:1783) [ 48.491399][ C0] ? __pfx_call_timer_fn (kernel/time/timer.c:1770) [ 48.491551][ C0] ? mark_lock (kernel/locking/lockdep.c:4656 (discriminator 3)) [ 48.491678][ C0] __run_timers (kernel/time/timer.c:1845 kernel/time/timer.c:2418) [ 48.491838][ C0] ? __pfx_br_forward_delay_timer_expired (net/bridge/br_stp_timer.c:80) bridge [ 48.492119][ C0] ? __pfx___run_timers (kernel/time/timer.c:2389) [ 48.492271][ C0] ? __lock_release (kernel/locking/lockdep.c:5430) [ 48.492527][ 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) [ 48.492678][ C0] ? __pfx_do_raw_spin_lock (kernel/locking/spinlock_debug.c:114) [ 48.492829][ C0] ? lock_acquire (kernel/locking/lockdep.c:5727) [ 48.492980][ C0] ? timer_expire_remote (kernel/time/timer.c:2429 kernel/time/timer.c:2422 kernel/time/timer.c:2181) [ 48.493227][ C0] timer_expire_remote (kernel/time/timer.c:2430 kernel/time/timer.c:2422 kernel/time/timer.c:2181) [ 48.493385][ 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) [ 48.493542][ C0] ? __pfx_tmigr_handle_remote_cpu (kernel/time/timer_migration.c:869) [ 48.493734][ C0] tmigr_handle_remote_up (kernel/time/timer_migration.c:1003) [ 48.493986][ C0] tmigr_handle_remote (kernel/time/timer_migration.c:488 kernel/time/timer_migration.c:1061) [ 48.494141][ 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) [ 48.494293][ C0] ? __pfx_tmigr_handle_remote (kernel/time/timer_migration.c:1026) [ 48.494443][ C0] ? __pfx_do_raw_spin_lock (kernel/locking/spinlock_debug.c:114) [ 48.494601][ C0] ? lockdep_hardirqs_on_prepare.part.0 (kernel/locking/lockdep.c:4292 kernel/locking/lockdep.c:4359) [ 48.494891][ C0] __do_softirq (kernel/softirq.c:554) [ 48.495047][ C0] irq_exit_rcu (kernel/softirq.c:428 kernel/softirq.c:633 kernel/softirq.c:645) [ 48.495177][ C0] sysvec_apic_timer_interrupt (arch/x86/kernel/apic/apic.c:1043 arch/x86/kernel/apic/apic.c:1043) [ 48.495338][ C0] [ 48.495513][ C0] [ 48.495592][ C0] asm_sysvec_apic_timer_interrupt (./arch/x86/include/asm/idtentry.h:702) [ 48.495780][ 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) [ 48.495944][ 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 [ 48.496596][ C0] RSP: 0018:ffffffff8ec07e00 EFLAGS: 00000246 [ 48.496803][ C0] RAX: 00000000000d024d RBX: 1ffffffff1d80fc2 RCX: ffffffff8dd0e9d5 [ 48.497140][ C0] RDX: 0000000000000000 RSI: 0000000000000000 RDI: ffffffff8b6aa4a4 [ 48.497369][ C0] RBP: 0000000000000000 R08: 0000000000000001 R09: ffffed1006c0709c [ 48.497599][ C0] R10: ffff8880360384e3 R11: ffff88803602d9b0 R12: 0000000000000000 [ 48.497937][ C0] R13: ffffffff8ec1d000 R14: dffffc0000000000 R15: 0000000000014770 [ 48.498173][ C0] ? ct_kernel_exit.constprop.0 (kernel/context_tracking.c:147) [ 48.498331][ C0] ? cpuidle_idle_call (kernel/sched/idle.c:192) [ 48.498581][ C0] default_idle_call (./include/linux/cpuidle.h:143 kernel/sched/idle.c:118) [ 48.498742][ C0] cpuidle_idle_call (kernel/sched/idle.c:192) [ 48.498894][ C0] ? __pfx_cpuidle_idle_call (kernel/sched/idle.c:168) [ 48.499062][ C0] ? tsc_verify_tsc_adjust (arch/x86/kernel/tsc_sync.c:59) [ 48.499218][ C0] do_idle (kernel/sched/idle.c:332) [ 48.499434][ C0] cpu_startup_entry (kernel/sched/idle.c:429 (discriminator 1)) [ 48.499589][ C0] rest_init (./include/linux/rcupdate.h:782 init/main.c:703) [ 48.499707][ C0] start_kernel (init/main.c:1024 (discriminator 1)) [ 48.499863][ C0] x86_64_start_reservations (arch/x86/kernel/head64.c:495) [ 48.500013][ 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