====================================== | [ 46.512376][ C2] entry_SYSCALL_64_after_hwframe (arch/x86/entry/entry_64.S:129) | [ 46.512850][ C2] | [ 46.512991][ C2] | [ 46.512991][ C2] stack backtrace: [ 46.513632][ C2] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS rel-1.16.3-0-ga6ed6b701f0a-prebuilt.qemu.org 04/01/2014 [ 46.514310][ C2] Call Trace: [ 46.514496][ C2] [ 46.514625][ C2] dump_stack_lvl (lib/dump_stack.c:117) [ 46.515060][ C2] print_irq_inversion_bug.part.0 (kernel/locking/lockdep.c:4024) [ 46.515366][ C2] ? __pfx_print_irq_inversion_bug.part.0 (kernel/locking/lockdep.c:4024) [ 46.515651][ C2] ? __pfx_usage_skip (kernel/locking/lockdep.c:2264) [ 46.515900][ C2] ? __pfx_usage_match (kernel/locking/lockdep.c:2256) [ 46.516298][ C2] ? arch_stack_walk (arch/x86/kernel/stacktrace.c:26) [ 46.516538][ C2] mark_lock_irq (kernel/locking/lockdep.c:4244) [ 46.516778][ C2] ? __pfx_mark_lock_irq (kernel/locking/lockdep.c:4207) [ 46.517020][ C2] ? stack_trace_save (kernel/stacktrace.c:123) [ 46.517430][ C2] ? add_chain_cache (kernel/locking/lockdep.c:3730) [ 46.517666][ C2] ? save_trace (kernel/locking/lockdep.c:586) [ 46.517909][ C2] mark_lock (kernel/locking/lockdep.c:4678) [ 46.518090][ C2] mark_usage (kernel/locking/lockdep.c:4567) [ 46.518270][ C2] __lock_acquire (kernel/locking/lockdep.c:5091) [ 46.518674][ C2] ? __lock_acquire (kernel/locking/lockdep.c:5137) [ 46.518936][ C2] ? __pfx_br_forward_delay_timer_expired (net/bridge/br_stp_timer.c:80) bridge [ 46.519359][ C2] lock_acquire.part.0 (kernel/locking/lockdep.c:467 kernel/locking/lockdep.c:5756) [ 46.519602][ C2] ? br_forward_delay_timer_expired (net/bridge/br_stp_timer.c:87) bridge [ 46.519991][ C2] ? __pfx_lock_acquire.part.0 (kernel/locking/lockdep.c:5719) [ 46.520245][ C2] ? trace_lock_acquire (./include/trace/events/lock.h:24 (discriminator 52)) [ 46.520482][ C2] ? br_forward_delay_timer_expired (net/bridge/br_stp_timer.c:87) bridge [ 46.520860][ C2] ? lock_acquire (kernel/locking/lockdep.c:5727) [ 46.521290][ C2] ? br_forward_delay_timer_expired (net/bridge/br_stp_timer.c:87) bridge [ 46.521679][ C2] _raw_spin_lock (./include/linux/spinlock_api_smp.h:134 kernel/locking/spinlock.c:154) [ 46.521944][ C2] ? br_forward_delay_timer_expired (net/bridge/br_stp_timer.c:87) bridge [ 46.522504][ C2] br_forward_delay_timer_expired (net/bridge/br_stp_timer.c:87) bridge [ 46.522871][ C2] ? __pfx_br_forward_delay_timer_expired (net/bridge/br_stp_timer.c:80) bridge [ 46.523327][ C2] call_timer_fn (kernel/time/timer.c:1793) [ 46.523582][ C2] ? call_timer_fn (./include/linux/lockdep.h:31 kernel/time/timer.c:1783) [ 46.524004][ C2] ? call_timer_fn (./include/linux/lockdep.h:31 kernel/time/timer.c:1783) [ 46.524244][ C2] ? __pfx_call_timer_fn (kernel/time/timer.c:1770) [ 46.524503][ C2] ? _raw_spin_unlock_irq (./arch/x86/include/asm/irqflags.h:42 ./arch/x86/include/asm/irqflags.h:77 ./include/linux/spinlock_api_smp.h:159 kernel/locking/spinlock.c:202) [ 46.524749][ C2] __run_timers (kernel/time/timer.c:1845 kernel/time/timer.c:2418) [ 46.525168][ C2] ? __pfx_br_forward_delay_timer_expired (net/bridge/br_stp_timer.c:80) bridge [ 46.525608][ C2] ? __pfx___run_timers (kernel/time/timer.c:2389) [ 46.525858][ C2] ? __lock_release (kernel/locking/lockdep.c:5430) [ 46.526107][ C2] ? 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.526531][ C2] ? __pfx_do_raw_spin_lock (kernel/locking/spinlock_debug.c:114) [ 46.526778][ C2] ? lock_acquire (kernel/locking/lockdep.c:5727) [ 46.527031][ C2] ? timer_expire_remote (kernel/time/timer.c:2429 kernel/time/timer.c:2422 kernel/time/timer.c:2181) [ 46.527278][ C2] timer_expire_remote (kernel/time/timer.c:2430 kernel/time/timer.c:2422 kernel/time/timer.c:2181) [ 46.527865][ C2] 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.528116][ C2] ? __pfx_tmigr_handle_remote_cpu (kernel/time/timer_migration.c:869) [ 46.528427][ C2] tmigr_handle_remote_up (kernel/time/timer_migration.c:1003) [ 46.528676][ C2] tmigr_handle_remote (kernel/time/timer_migration.c:488 kernel/time/timer_migration.c:1061) [ 46.529092][ C2] ? 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.529346][ C2] ? __pfx_tmigr_handle_remote (kernel/time/timer_migration.c:1026) [ 46.529593][ C2] ? __pfx_do_raw_spin_lock (kernel/locking/spinlock_debug.c:114) [ 46.529842][ C2] ? lockdep_hardirqs_on_prepare.part.0 (kernel/locking/lockdep.c:4292 kernel/locking/lockdep.c:4359) [ 46.530328][ C2] __do_softirq (kernel/softirq.c:554) [ 46.530582][ C2] irq_exit_rcu (kernel/softirq.c:428 kernel/softirq.c:633 kernel/softirq.c:645) [ 46.530766][ C2] sysvec_apic_timer_interrupt (arch/x86/kernel/apic/apic.c:1043 arch/x86/kernel/apic/apic.c:1043) [ 46.531037][ C2] [ 46.531175][ C2] [ 46.531305][ C2] asm_sysvec_apic_timer_interrupt (./arch/x86/include/asm/idtentry.h:702) [ 46.531794][ C2] RIP: 0010:_raw_spin_unlock_irqrestore (./include/linux/spinlock_api_smp.h:152 kernel/locking/spinlock.c:194) [ 46.532114][ C2] Code: 10 e8 21 49 9b fd 48 89 ef e8 59 b9 9b fd 81 e3 00 02 00 00 75 1d 9c 58 f6 c4 02 75 29 48 85 db 74 01 fb 65 ff 0d 05 bf af 4f <74> 0e 5b 5d c3 cc cc cc cc e8 4f b3 be fd eb dc 0f 1f 44 00 00 5b All code ======== 0: 10 e8 adc %ch,%al 2: 21 49 9b and %ecx,-0x65(%rcx) 5: fd std 6: 48 89 ef mov %rbp,%rdi 9: e8 59 b9 9b fd call 0xfffffffffd9bb967 e: 81 e3 00 02 00 00 and $0x200,%ebx 14: 75 1d jne 0x33 16: 9c pushf 17: 58 pop %rax 18: f6 c4 02 test $0x2,%ah 1b: 75 29 jne 0x46 1d: 48 85 db test %rbx,%rbx 20: 74 01 je 0x23 22: fb sti 23: 65 ff 0d 05 bf af 4f decl %gs:0x4fafbf05(%rip) # 0x4fafbf2f 2a:* 74 0e je 0x3a <-- trapping instruction 2c: 5b pop %rbx 2d: 5d pop %rbp 2e: c3 ret 2f: cc int3 30: cc int3 31: cc int3 32: cc int3 33: e8 4f b3 be fd call 0xfffffffffdbeb387 38: eb dc jmp 0x16 3a: 0f 1f 44 00 00 nopl 0x0(%rax,%rax,1) 3f: 5b pop %rbx Code starting with the faulting instruction =========================================== 0: 74 0e je 0x10 2: 5b pop %rbx 3: 5d pop %rbp 4: c3 ret 5: cc int3 6: cc int3 7: cc int3 8: cc int3 9: e8 4f b3 be fd call 0xfffffffffdbeb35d e: eb dc jmp 0xffffffffffffffec 10: 0f 1f 44 00 00 nopl 0x0(%rax,%rax,1) 15: 5b pop %rbx [ 46.533217][ C2] RSP: 0018:ffffc90000b6f528 EFLAGS: 00000286 [ 46.533422][ C2] RAX: 0000000000000006 RBX: 0000000000000200 RCX: 1ffffffff6424179 [ 46.533758][ C2] RDX: 0000000000000000 RSI: 0000000000000000 RDI: ffffffffb0540911 [ 46.533991][ C2] RBP: ffff888005392008 R08: 0000000000000001 R09: fffffbfff64249fa [ 46.534220][ C2] R10: ffffffffb2124fd7 R11: 0000000000000000 R12: dffffc0000000000 [ 46.534564][ C2] R13: 0000000000000001 R14: 0000000000000282 R15: ffff888005392078 [ 46.534817][ C2] ? _raw_spin_unlock_irqrestore (./include/linux/spinlock_api_smp.h:151 kernel/locking/spinlock.c:194) [ 46.535011][ C2] p9_virtio_request (net/9p/trans_virtio.c:305) [ 46.535167][ C2] ? trace_9p_client_req (./include/trace/events/9p.h:124 (discriminator 52)) [ 46.535413][ C2] ? __pfx_p9_virtio_request (net/9p/trans_virtio.c:256) [ 46.535564][ C2] ? p9_client_prepare_req (net/9p/client.c:625) [ 46.535716][ C2] ? __pfx_p9_client_prepare_req (net/9p/client.c:625) [ 46.535908][ C2] p9_client_rpc (net/9p/client.c:703) [ 46.536155][ C2] ? 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.536307][ C2] ? __pfx_p9_client_rpc (net/9p/client.c:672) [ 46.536462][ C2] ? v9fs_fid_find (fs/9p/fid.c:114) [ 46.536614][ C2] ? do_raw_spin_unlock (./arch/x86/include/asm/atomic.h:23 ./include/linux/atomic/atomic-arch-fallback.h:457 ./include/linux/atomic/atomic-instrumented.h:33 ./include/asm-generic/qspinlock.h:57 kernel/locking/spinlock_debug.c:101 kernel/locking/spinlock_debug.c:141) [ 46.536864][ C2] ? _raw_spin_unlock (./arch/x86/include/asm/preempt.h:94 ./include/linux/spinlock_api_smp.h:143 kernel/locking/spinlock.c:186) [ 46.537017][ C2] ? __pfx_v9fs_fid_find (fs/9p/fid.c:114) [ 46.537168][ C2] ? __pfx_make_vfsgid (fs/mnt_idmapping.c:110) [ 46.537318][ C2] ? v9fs_fid_add (fs/9p/fid.c:41) [ 46.537569][ C2] p9_client_readlink (net/9p/client.c:2238) [ 46.537727][ C2] v9fs_vfs_get_link_dotl (fs/9p/vfs_inode_dotl.c:822 fs/9p/vfs_inode_dotl.c:806) [ 46.537886][ C2] ? __pfx_v9fs_vfs_get_link_dotl (fs/9p/vfs_inode_dotl.c:809) [ 46.538077][ C2] ? __lookup_slow (fs/namei.c:1692) [ 46.538353][ C2] pick_link (fs/namei.c:1808) [ 46.538489][ C2] ? find_held_lock (kernel/locking/lockdep.c:5244) [ 46.538645][ C2] step_into (fs/namei.c:1874) [ 46.538800][ C2] ? __up_read (./arch/x86/include/asm/atomic64_64.h:79 ./include/linux/atomic/atomic-arch-fallback.h:2749 ./include/linux/atomic/atomic-long.h:184 ./include/linux/atomic/atomic-instrumented.h:3317 kernel/locking/rwsem.c:1347) [ 46.538953][ C2] ? __pfx_step_into (fs/namei.c:1839) [ 46.539202][ C2] ? walk_component (fs/namei.c:2005) [ 46.539357][ C2] link_path_walk.part.0.constprop.0 (fs/namei.c:2331) [ 46.539549][ C2] ? __pfx_link_path_walk.part.0.constprop.0 (fs/namei.c:2249) [ 46.539757][ C2] path_openat (fs/namei.c:3795) [ 46.540005][ C2] ? __pfx_path_openat (fs/namei.c:3781) [ 46.540187][ C2] ? __lock_acquire (kernel/locking/lockdep.c:5137) [ 46.540340][ C2] do_filp_open (fs/namei.c:3826) [ 46.540519][ C2] ? __pfx_do_filp_open (fs/namei.c:3820) [ 46.540776][ C2] ? find_held_lock (kernel/locking/lockdep.c:5244) [ 46.540932][ C2] ? __pfx_do_raw_spin_lock (kernel/locking/spinlock_debug.c:114) [ 46.541113][ C2] ? alloc_fd (fs/file.c:555 (discriminator 10)) [ 46.541235][ C2] ? do_raw_spin_unlock (./arch/x86/include/asm/atomic.h:23 ./include/linux/atomic/atomic-arch-fallback.h:457 ./include/linux/atomic/atomic-instrumented.h:33 ./include/asm-generic/qspinlock.h:57 kernel/locking/spinlock_debug.c:101 kernel/locking/spinlock_debug.c:141) [ 46.541504][ C2] ? _raw_spin_unlock (./arch/x86/include/asm/preempt.h:94 ./include/linux/spinlock_api_smp.h:143 kernel/locking/spinlock.c:186) [ 46.541692][ C2] ? alloc_fd (fs/file.c:555 (discriminator 10)) [ 46.541808][ C2] do_sys_openat2 (fs/open.c:1406) [ 46.541976][ C2] ? __pfx_do_sys_openat2 (fs/open.c:1392) [ 46.542138][ C2] ? __pfx___debug_check_no_obj_freed (lib/debugobjects.c:960) [ 46.542560][ C2] ? __virt_addr_valid (./arch/x86/include/asm/preempt.h:94 ./include/linux/rcupdate.h:896 ./include/linux/mmzone.h:2029 arch/x86/mm/physaddr.c:65) [ 46.542721][ C2] __x64_sys_openat (fs/open.c:1432) [ 46.542872][ C2] ? __pfx___x64_sys_openat (fs/open.c:1432) [ 46.543053][ C2] do_syscall_64 (arch/x86/entry/common.c:52 arch/x86/entry/common.c:83) [ 46.543301][ C2] entry_SYSCALL_64_after_hwframe (arch/x86/entry/entry_64.S:129) [ 46.543489][ C2] RIP: 0033:0x7f0cdb6a10e8 [ 46.543646][ C2] Code: f9 41 89 f0 41 83 e2 40 75 30 89 f0 25 00 00 41 00 3d 00 00 41 00 74 22 44 89 c2 4c 89 ce bf 9c ff ff ff b8 01 01 00 00 0f 05 <48> 3d 00 f0 ff ff 77 30 c3 0f 1f 80 00 00 00 00 48 8d 44 24 08 c7 All code ======== 0: f9 stc 1: 41 89 f0 mov %esi,%r8d 4: 41 83 e2 40 and $0x40,%r10d 8: 75 30 jne 0x3a a: 89 f0 mov %esi,%eax c: 25 00 00 41 00 and $0x410000,%eax 11: 3d 00 00 41 00 cmp $0x410000,%eax 16: 74 22 je 0x3a 18: 44 89 c2 mov %r8d,%edx 1b: 4c 89 ce mov %r9,%rsi 1e: bf 9c ff ff ff mov $0xffffff9c,%edi 23: b8 01 01 00 00 mov $0x101,%eax 28: 0f 05 syscall 2a:* 48 3d 00 f0 ff ff cmp $0xfffffffffffff000,%rax <-- trapping instruction 30: 77 30 ja 0x62 32: c3 ret 33: 0f 1f 80 00 00 00 00 nopl 0x0(%rax) 3a: 48 8d 44 24 08 lea 0x8(%rsp),%rax 3f: c7 .byte 0xc7 Code starting with the faulting instruction =========================================== 0: 48 3d 00 f0 ff ff cmp $0xfffffffffffff000,%rax 6: 77 30 ja 0x38 8: c3 ret 9: 0f 1f 80 00 00 00 00 nopl 0x0(%rax) 10: 48 8d 44 24 08 lea 0x8(%rsp),%rax 15: c7 .byte 0xc7 [ 46.544287][ C2] RSP: 002b:00007ffea35e2998 EFLAGS: 00000287 ORIG_RAX: 0000000000000101 [ 46.544546][ C2] RAX: ffffffffffffffda RBX: 00007ffea35e2c1f RCX: 00007f0cdb6a10e8 [ 46.544875][ C2] RDX: 0000000000080000 RSI: 00007ffea35e2a10 RDI: 00000000ffffff9c [ 46.545099][ C2] RBP: 00007ffea35e2a00 R08: 0000000000080000 R09: 00007ffea35e2a10 [ 46.545331][ C2] R10: 0000000000000000 R11: 0000000000000287 R12: 00007ffea35e2a17 Finger prints: dump_stack_lvl:mark_lock_irq:mark_lock:mark_usage