====================================== | [ 43.862798][ C2] entry_SYSCALL_64_after_hwframe (arch/x86/entry/entry_64.S:129) | [ 43.862983][ C2] | [ 43.863058][ C2] | [ 43.863058][ C2] stack backtrace: [ 43.863564][ C2] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS rel-1.16.3-0-ga6ed6b701f0a-prebuilt.qemu.org 04/01/2014 [ 43.863896][ C2] Call Trace: [ 43.864010][ C2] [ 43.864272][ C2] dump_stack_lvl (lib/dump_stack.c:117) [ 43.864426][ C2] print_irq_inversion_bug.part.0 (kernel/locking/lockdep.c:4024) [ 43.864612][ C2] ? kernel_text_address (kernel/extable.c:97 kernel/extable.c:94) [ 43.864771][ C2] ? __pfx_print_irq_inversion_bug.part.0 (kernel/locking/lockdep.c:4024) [ 43.865054][ C2] ? __pfx_usage_skip (kernel/locking/lockdep.c:2264) [ 43.865204][ C2] ? __pfx_usage_match (kernel/locking/lockdep.c:2256) [ 43.865354][ C2] ? arch_stack_walk (arch/x86/kernel/stacktrace.c:26) [ 43.865511][ C2] mark_lock_irq (kernel/locking/lockdep.c:4244) [ 43.865766][ C2] ? __pfx_mark_lock_irq (kernel/locking/lockdep.c:4207) [ 43.865919][ C2] ? __pfx_stack_trace_save (kernel/stacktrace.c:114) [ 43.866072][ C2] ? save_trace (kernel/locking/lockdep.c:586) [ 43.866224][ C2] mark_lock (kernel/locking/lockdep.c:4678) [ 43.866342][ C2] ? __pfx_stack_trace_save (kernel/stacktrace.c:114) [ 43.866582][ C2] mark_usage (kernel/locking/lockdep.c:4567) [ 43.866696][ C2] __lock_acquire (kernel/locking/lockdep.c:5091) [ 43.866858][ C2] ? __pfx_validate_chain (kernel/locking/lockdep.c:3825) [ 43.867010][ C2] ? __pfx_addrconf_rs_timer (net/ipv6/addrconf.c:4016) [ 43.867249][ C2] lock_acquire.part.0 (kernel/locking/lockdep.c:467 kernel/locking/lockdep.c:5756) [ 43.867403][ C2] ? addrconf_rs_timer (net/ipv6/addrconf.c:4023) [ 43.867553][ C2] ? __pfx_lock_acquire.part.0 (kernel/locking/lockdep.c:5719) [ 43.867708][ C2] ? trace_lock_acquire (./include/trace/events/lock.h:24 (discriminator 52)) [ 43.867948][ C2] ? addrconf_rs_timer (net/ipv6/addrconf.c:4023) [ 43.868102][ C2] ? lock_acquire (kernel/locking/lockdep.c:5727) [ 43.868252][ C2] ? addrconf_rs_timer (net/ipv6/addrconf.c:4023) [ 43.868401][ C2] _raw_write_lock (./include/linux/rwlock_api_smp.h:210 kernel/locking/spinlock.c:300) [ 43.868552][ C2] ? addrconf_rs_timer (net/ipv6/addrconf.c:4023) [ 43.868792][ C2] addrconf_rs_timer (net/ipv6/addrconf.c:4023) [ 43.868942][ C2] ? __pfx_lock_acquire.part.0 (kernel/locking/lockdep.c:5719) [ 43.869093][ C2] ? __pfx_addrconf_rs_timer (net/ipv6/addrconf.c:4016) [ 43.869246][ C2] ? call_timer_fn (./include/linux/lockdep.h:31 kernel/time/timer.c:1783) [ 43.869486][ C2] ? lock_acquire (kernel/locking/lockdep.c:5727) [ 43.869635][ C2] ? call_timer_fn (./include/linux/lockdep.h:31 kernel/time/timer.c:1783) [ 43.869786][ C2] ? __pfx_addrconf_rs_timer (net/ipv6/addrconf.c:4016) [ 43.869935][ C2] call_timer_fn (kernel/time/timer.c:1793) [ 43.870176][ C2] ? call_timer_fn (./include/linux/lockdep.h:31 kernel/time/timer.c:1783) [ 43.870326][ C2] ? call_timer_fn (./include/linux/lockdep.h:31 kernel/time/timer.c:1783) [ 43.870476][ C2] ? __pfx_call_timer_fn (kernel/time/timer.c:1770) [ 43.870630][ C2] ? hlock_class (./arch/x86/include/asm/bitops.h:227 ./arch/x86/include/asm/bitops.h:239 ./include/asm-generic/bitops/instrumented-non-atomic.h:142 kernel/locking/lockdep.c:228) [ 43.870883][ C2] ? mark_held_locks (kernel/locking/lockdep.c:4274) [ 43.871035][ C2] __run_timers (kernel/time/timer.c:1845 kernel/time/timer.c:2418) [ 43.871185][ C2] ? __pfx_addrconf_rs_timer (net/ipv6/addrconf.c:4016) [ 43.871337][ C2] ? __pfx___run_timers (kernel/time/timer.c:2389) [ 43.871488][ 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) [ 43.871637][ C2] ? __pfx_do_raw_spin_lock (kernel/locking/spinlock_debug.c:114) [ 43.871793][ C2] ? lock_acquire (kernel/locking/lockdep.c:5727) [ 43.871943][ C2] ? run_timer_softirq (kernel/time/timer.c:2429 kernel/time/timer.c:2422 kernel/time/timer.c:2438 kernel/time/timer.c:2448) [ 43.872100][ C2] run_timer_softirq (kernel/time/timer.c:2430 kernel/time/timer.c:2422 kernel/time/timer.c:2438 kernel/time/timer.c:2448) [ 43.872341][ C2] __do_softirq (kernel/softirq.c:554) [ 43.872493][ C2] irq_exit_rcu (kernel/softirq.c:428 kernel/softirq.c:633 kernel/softirq.c:645) [ 43.872614][ C2] sysvec_apic_timer_interrupt (arch/x86/kernel/apic/apic.c:1043 arch/x86/kernel/apic/apic.c:1043) [ 43.872769][ C2] [ 43.872848][ C2] [ 43.873012][ C2] asm_sysvec_apic_timer_interrupt (./arch/x86/include/asm/idtentry.h:702) [ 43.873200][ C2] RIP: 0010:_raw_spin_unlock_irq (./include/linux/spinlock_api_smp.h:160 kernel/locking/spinlock.c:202) [ 43.873402][ C2] Code: 44 00 00 55 48 8b 74 24 08 48 89 fd 48 83 c7 18 e8 85 49 9b fd 48 89 ef e8 bd b9 9b fd e8 d8 b3 be fd fb 65 ff 0d 78 bf af 5f <74> 06 5d c3 cc cc cc cc 0f 1f 44 00 00 5d c3 cc cc cc cc 66 66 2e All code ======== 0: 44 00 00 add %r8b,(%rax) 3: 55 push %rbp 4: 48 8b 74 24 08 mov 0x8(%rsp),%rsi 9: 48 89 fd mov %rdi,%rbp c: 48 83 c7 18 add $0x18,%rdi 10: e8 85 49 9b fd call 0xfffffffffd9b499a 15: 48 89 ef mov %rbp,%rdi 18: e8 bd b9 9b fd call 0xfffffffffd9bb9da 1d: e8 d8 b3 be fd call 0xfffffffffdbeb3fa 22: fb sti 23: 65 ff 0d 78 bf af 5f decl %gs:0x5fafbf78(%rip) # 0x5fafbfa2 2a:* 74 06 je 0x32 <-- trapping instruction 2c: 5d pop %rbp 2d: c3 ret 2e: cc int3 2f: cc int3 30: cc int3 31: cc int3 32: 0f 1f 44 00 00 nopl 0x0(%rax,%rax,1) 37: 5d pop %rbp 38: c3 ret 39: cc int3 3a: cc int3 3b: cc int3 3c: cc int3 3d: 66 data16 3e: 66 data16 3f: 2e cs Code starting with the faulting instruction =========================================== 0: 74 06 je 0x8 2: 5d pop %rbp 3: c3 ret 4: cc int3 5: cc int3 6: cc int3 7: cc int3 8: 0f 1f 44 00 00 nopl 0x0(%rax,%rax,1) d: 5d pop %rbp e: c3 ret f: cc int3 10: cc int3 11: cc int3 12: cc int3 13: 66 data16 14: 66 data16 15: 2e cs [ 43.874033][ C2] RSP: 0018:ffffc90000bff3d8 EFLAGS: 00000282 [ 43.874223][ C2] RAX: 000000000000680d RBX: 1ffff9200017fe80 RCX: 1ffffffff46e4456 [ 43.874541][ C2] RDX: 0000000000000000 RSI: 0000000000000000 RDI: ffffffffa0540888 [ 43.874776][ C2] RBP: ffff888005b72000 R08: 0000000000000001 R09: fffffbfff46e38a5 [ 43.874999][ C2] R10: ffffffffa371c52f R11: ffffc90000bfef21 R12: ffff888004f16940 [ 43.875313][ C2] R13: 0000000000000000 R14: ffff888004f16938 R15: 0000000000000000 [ 43.875551][ 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) [ 43.875703][ 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) [ 43.875860][ C2] p9_tag_alloc (./include/linux/local_lock_internal.h:36 ./include/linux/idr.h:174 net/9p/client.c:321) [ 43.876193][ C2] ? __pfx_p9_tag_alloc (net/9p/client.c:277) [ 43.876344][ C2] ? validate_chain (./include/linux/hash.h:78 kernel/locking/lockdep.c:3759 kernel/locking/lockdep.c:3782 kernel/locking/lockdep.c:3837) [ 43.876496][ C2] ? hlock_class (./arch/x86/include/asm/bitops.h:227 ./arch/x86/include/asm/bitops.h:239 ./include/asm-generic/bitops/instrumented-non-atomic.h:142 kernel/locking/lockdep.c:228) [ 43.876648][ C2] p9_client_prepare_req (net/9p/client.c:641) [ 43.876893][ C2] ? hlock_class (./arch/x86/include/asm/bitops.h:227 ./arch/x86/include/asm/bitops.h:239 ./include/asm-generic/bitops/instrumented-non-atomic.h:142 kernel/locking/lockdep.c:228) [ 43.877046][ C2] ? __pfx_p9_client_prepare_req (net/9p/client.c:625) [ 43.877236][ C2] ? __lock_acquire (kernel/locking/lockdep.c:5137) [ 43.877389][ C2] p9_client_rpc (net/9p/client.c:688 (discriminator 4)) [ 43.877632][ C2] ? __pfx_p9_client_rpc (net/9p/client.c:672) [ 43.877786][ C2] ? __lock_release (kernel/locking/lockdep.c:5430) [ 43.877937][ C2] ? p9_fid_create (./include/linux/local_lock_internal.h:38 ./include/linux/idr.h:174 net/9p/client.c:867) [ 43.878087][ C2] ? __pfx___lock_release (kernel/locking/lockdep.c:5406) [ 43.878326][ C2] ? hlock_class (./arch/x86/include/asm/bitops.h:227 ./arch/x86/include/asm/bitops.h:239 ./include/asm-generic/bitops/instrumented-non-atomic.h:142 kernel/locking/lockdep.c:228) [ 43.878480][ C2] ? mark_held_locks (kernel/locking/lockdep.c:4274) [ 43.878631][ C2] ? p9_fid_create (./include/linux/local_lock_internal.h:38 ./include/linux/idr.h:174 net/9p/client.c:867) [ 43.878782][ C2] p9_client_walk (net/9p/client.c:1169) [ 43.879022][ C2] ? __pfx_p9_client_walk (net/9p/client.c:1143) [ 43.879179][ C2] ? d_alloc_parallel (./arch/x86/include/asm/bitops.h:94 ./arch/x86/include/asm/bitops.h:112 ./include/asm-generic/bitops/instrumented-lock.h:43 ./include/linux/bit_spinlock.h:80 ./include/linux/list_bl.h:153 fs/dcache.c:2556) [ 43.879332][ C2] ? v9fs_fid_lookup_with_uid (fs/9p/fid.c:181) [ 43.879484][ C2] ? v9fs_vfs_lookup.part.0 (fs/9p/vfs_inode.c:676) [ 43.879635][ C2] v9fs_vfs_lookup.part.0 (fs/9p/vfs_inode.c:676) [ 43.879876][ C2] ? __pfx_v9fs_vfs_lookup.part.0 (fs/9p/vfs_inode.c:649) [ 43.880063][ C2] ? lockdep_init_map_type (kernel/locking/lockdep.c:4892) [ 43.880216][ C2] __lookup_slow (fs/namei.c:1692) [ 43.880370][ C2] ? __pfx___lookup_slow (fs/namei.c:1668) [ 43.880611][ C2] ? walk_component (fs/namei.c:1709 fs/namei.c:2004) [ 43.880764][ C2] walk_component (./include/linux/fs.h:808 fs/namei.c:1710 fs/namei.c:2004) [ 43.880914][ C2] link_path_walk.part.0.constprop.0 (fs/namei.c:2331) [ 43.881102][ C2] ? __pfx_link_path_walk.part.0.constprop.0 (fs/namei.c:2249) [ 43.881379][ C2] path_openat (fs/namei.c:3795) [ 43.881534][ C2] ? __pfx_path_openat (fs/namei.c:3781) [ 43.881684][ C2] ? __lock_acquire (kernel/locking/lockdep.c:5137) [ 43.881840][ C2] do_filp_open (fs/namei.c:3826) [ 43.882078][ C2] ? __pfx_do_filp_open (fs/namei.c:3820) [ 43.882227][ C2] ? find_held_lock (kernel/locking/lockdep.c:5244) [ 43.882378][ 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) [ 43.882528][ C2] ? __pfx_do_raw_spin_lock (kernel/locking/spinlock_debug.c:114) [ 43.882766][ C2] ? alloc_fd (fs/file.c:555 (discriminator 10)) [ 43.882880][ 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) [ 43.883030][ C2] ? _raw_spin_unlock (./arch/x86/include/asm/preempt.h:94 ./include/linux/spinlock_api_smp.h:143 kernel/locking/spinlock.c:186) [ 43.883183][ C2] ? alloc_fd (fs/file.c:555 (discriminator 10)) [ 43.883304][ C2] do_sys_openat2 (fs/open.c:1406) [ 43.883545][ C2] ? vfs_fstatat (fs/stat.c:308) [ 43.883699][ C2] ? __pfx_do_sys_openat2 (fs/open.c:1392) [ 43.883856][ C2] ? __pfx___do_sys_newfstatat (fs/stat.c:464) [ 43.884011][ C2] __x64_sys_openat (fs/open.c:1432) [ 43.884250][ C2] ? __pfx___x64_sys_openat (fs/open.c:1432) [ 43.884399][ C2] ? __pfx_do_faccessat (fs/open.c:465) [ 43.884551][ C2] do_syscall_64 (arch/x86/entry/common.c:52 arch/x86/entry/common.c:83) [ 43.884711][ C2] entry_SYSCALL_64_after_hwframe (arch/x86/entry/entry_64.S:129) [ 43.884992][ C2] RIP: 0033:0x7f88180370e8 [ 43.885146][ 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 [ 43.885681][ C2] RSP: 002b:00007ffcf118f078 EFLAGS: 00000287 ORIG_RAX: 0000000000000101 [ 43.885910][ C2] RAX: ffffffffffffffda RBX: 00007ffcf118f30f RCX: 00007f88180370e8 [ 43.886135][ C2] RDX: 0000000000080000 RSI: 00007ffcf118f0f0 RDI: 00000000ffffff9c [ 43.886449][ C2] RBP: 00007ffcf118f0e0 R08: 0000000000080000 R09: 00007ffcf118f0f0 [ 43.886672][ C2] R10: 0000000000000000 R11: 0000000000000287 R12: 00007ffcf118f0f7 Finger prints: dump_stack_lvl:mark_lock_irq:mark_lock:mark_usage