====================================== | [ 45.428474][ C0] entry_SYSCALL_64_after_hwframe (arch/x86/entry/entry_64.S:129) | [ 45.428684][ C0] | [ 45.428768][ C0] | [ 45.428768][ C0] stack backtrace: [ 45.429321][ C0] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS rel-1.16.3-0-ga6ed6b701f0a-prebuilt.qemu.org 04/01/2014 [ 45.429827][ C0] Call Trace: [ 45.429955][ C0] [ 45.430050][ C0] dump_stack_lvl (lib/dump_stack.c:117) [ 45.430219][ C0] print_irq_inversion_bug.part.0 (kernel/locking/lockdep.c:4024) [ 45.430431][ C0] ? __pfx_print_irq_inversion_bug.part.0 (kernel/locking/lockdep.c:4024) [ 45.430739][ C0] ? __pfx_usage_skip (kernel/locking/lockdep.c:2264) [ 45.430935][ C0] ? __pfx_usage_match (kernel/locking/lockdep.c:2256) [ 45.431104][ C0] ? arch_stack_walk (arch/x86/kernel/stacktrace.c:26) [ 45.431290][ C0] mark_lock_irq (kernel/locking/lockdep.c:4244) [ 45.431579][ C0] ? __pfx_mark_lock_irq (kernel/locking/lockdep.c:4207) [ 45.431762][ C0] ? stack_trace_save (kernel/stacktrace.c:123) [ 45.431929][ C0] ? add_chain_cache (kernel/locking/lockdep.c:3730) [ 45.432121][ C0] ? save_trace (kernel/locking/lockdep.c:586) [ 45.432297][ C0] mark_lock (kernel/locking/lockdep.c:4678) [ 45.432440][ C0] mark_usage (kernel/locking/lockdep.c:4567) [ 45.432566][ C0] __lock_acquire (kernel/locking/lockdep.c:5091) [ 45.432734][ C0] ? __lock_acquire (kernel/locking/lockdep.c:5137) [ 45.432903][ C0] ? __pfx_br_forward_delay_timer_expired (net/bridge/br_stp_timer.c:80) bridge [ 45.433309][ C0] lock_acquire.part.0 (kernel/locking/lockdep.c:467 kernel/locking/lockdep.c:5756) [ 45.433494][ C0] ? br_forward_delay_timer_expired (net/bridge/br_stp_timer.c:87) bridge [ 45.433765][ C0] ? __pfx_lock_acquire.part.0 (kernel/locking/lockdep.c:5719) [ 45.434047][ C0] ? trace_lock_acquire (./include/trace/events/lock.h:24 (discriminator 52)) [ 45.434235][ C0] ? br_forward_delay_timer_expired (net/bridge/br_stp_timer.c:87) bridge [ 45.434479][ C0] ? lock_acquire (kernel/locking/lockdep.c:5727) [ 45.434653][ C0] ? br_forward_delay_timer_expired (net/bridge/br_stp_timer.c:87) bridge [ 45.435150][ C0] _raw_spin_lock (./include/linux/spinlock_api_smp.h:134 kernel/locking/spinlock.c:154) [ 45.435330][ C0] ? br_forward_delay_timer_expired (net/bridge/br_stp_timer.c:87) bridge [ 45.435600][ C0] br_forward_delay_timer_expired (net/bridge/br_stp_timer.c:87) bridge [ 45.435864][ C0] ? __pfx_br_forward_delay_timer_expired (net/bridge/br_stp_timer.c:80) bridge [ 45.436284][ C0] call_timer_fn (kernel/time/timer.c:1793) [ 45.436453][ C0] ? call_timer_fn (./include/linux/lockdep.h:31 kernel/time/timer.c:1783) [ 45.436619][ C0] ? call_timer_fn (./include/linux/lockdep.h:31 kernel/time/timer.c:1783) [ 45.436909][ C0] ? __pfx_call_timer_fn (kernel/time/timer.c:1770) [ 45.437078][ C0] ? 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) [ 45.437263][ C0] ? mark_held_locks (kernel/locking/lockdep.c:4274) [ 45.437447][ C0] __run_timers (kernel/time/timer.c:1845 kernel/time/timer.c:2418) [ 45.437629][ C0] ? __pfx_br_forward_delay_timer_expired (net/bridge/br_stp_timer.c:80) bridge [ 45.438015][ C0] ? __pfx___run_timers (kernel/time/timer.c:2389) [ 45.438180][ C0] ? __lock_release (kernel/locking/lockdep.c:5430) [ 45.438350][ 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) [ 45.438614][ C0] ? __pfx_do_raw_spin_lock (kernel/locking/spinlock_debug.c:114) [ 45.438780][ C0] ? lock_acquire (kernel/locking/lockdep.c:5727) [ 45.438948][ C0] ? timer_expire_remote (kernel/time/timer.c:2429 kernel/time/timer.c:2422 kernel/time/timer.c:2181) [ 45.439127][ C0] timer_expire_remote (kernel/time/timer.c:2430 kernel/time/timer.c:2422 kernel/time/timer.c:2181) [ 45.439300][ 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) [ 45.439588][ C0] ? __pfx_tmigr_handle_remote_cpu (kernel/time/timer_migration.c:869) [ 45.439798][ C0] ? 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) [ 45.439964][ C0] ? mark_lock (kernel/locking/lockdep.c:4656 (discriminator 3)) [ 45.440089][ C0] ? mark_held_locks (kernel/locking/lockdep.c:4274) [ 45.440258][ C0] tmigr_handle_remote_up (kernel/time/timer_migration.c:1003) [ 45.440425][ C0] tmigr_handle_remote (kernel/time/timer_migration.c:488 kernel/time/timer_migration.c:1061) [ 45.440596][ 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) [ 45.440759][ C0] ? __pfx_tmigr_handle_remote (kernel/time/timer_migration.c:1026) [ 45.441027][ C0] ? lockdep_hardirqs_on_prepare.part.0 (kernel/locking/lockdep.c:4292 kernel/locking/lockdep.c:4359) [ 45.441236][ C0] __do_softirq (kernel/softirq.c:554) [ 45.441405][ C0] irq_exit_rcu (kernel/softirq.c:428 kernel/softirq.c:633 kernel/softirq.c:645) [ 45.441531][ C0] sysvec_apic_timer_interrupt (arch/x86/kernel/apic/apic.c:1043 arch/x86/kernel/apic/apic.c:1043) [ 45.441810][ C0] [ 45.441898][ C0] [ 45.441985][ C0] asm_sysvec_apic_timer_interrupt (./arch/x86/include/asm/idtentry.h:702) [ 45.442210][ C0] RIP: 0010:_raw_spin_unlock_irq (./include/linux/spinlock_api_smp.h:160 kernel/locking/spinlock.c:202) [ 45.442428][ C0] 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 ef 52 <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 ef 52 decl %gs:0x52efbf78(%rip) # 0x52efbfa2 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 [ 45.443118][ C0] RSP: 0018:ffffc90000bcf378 EFLAGS: 00000282 [ 45.443331][ C0] RAX: 0000000000006c53 RBX: 1ffff92000179e74 RCX: 1ffffffff6064456 [ 45.443698][ C0] RDX: 0000000000000000 RSI: 0000000000000000 RDI: ffffffffad140888 [ 45.443949][ C0] RBP: ffff888005bf2000 R08: 0000000000000001 R09: fffffbfff60638a5 [ 45.444202][ C0] R10: ffffffffb031c52f R11: ffffc90000bceec1 R12: ffff8880044fbe40 [ 45.444457][ C0] R13: 0000000000000000 R14: ffff8880044fbe38 R15: 0000000000000000 [ 45.444708][ C0] ? _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) [ 45.444884][ C0] ? _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) [ 45.445149][ C0] p9_tag_alloc (./include/linux/local_lock_internal.h:36 ./include/linux/idr.h:174 net/9p/client.c:321) [ 45.445314][ C0] ? __pfx_p9_tag_alloc (net/9p/client.c:277) [ 45.445482][ C0] ? validate_chain (./include/linux/hash.h:78 kernel/locking/lockdep.c:3759 kernel/locking/lockdep.c:3782 kernel/locking/lockdep.c:3837) [ 45.445673][ C0] ? 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) [ 45.445935][ C0] p9_client_prepare_req (net/9p/client.c:641) [ 45.446102][ C0] ? 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) [ 45.446267][ C0] ? __pfx_p9_client_prepare_req (net/9p/client.c:625) [ 45.446489][ C0] ? __lock_acquire (kernel/locking/lockdep.c:5137) [ 45.446754][ C0] p9_client_rpc (net/9p/client.c:688 (discriminator 4)) [ 45.446920][ C0] ? __pfx_p9_client_rpc (net/9p/client.c:672) [ 45.447086][ C0] ? __lock_release (kernel/locking/lockdep.c:5430) [ 45.447251][ C0] ? p9_fid_create (./include/linux/local_lock_internal.h:38 ./include/linux/idr.h:174 net/9p/client.c:867) [ 45.447525][ C0] ? __pfx___lock_release (kernel/locking/lockdep.c:5406) [ 45.447689][ C0] ? 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) [ 45.447855][ C0] ? mark_held_locks (kernel/locking/lockdep.c:4274) [ 45.448026][ C0] ? p9_fid_create (./include/linux/local_lock_internal.h:38 ./include/linux/idr.h:174 net/9p/client.c:867) [ 45.448288][ C0] p9_client_walk (net/9p/client.c:1169) [ 45.448458][ C0] ? __pfx_p9_client_walk (net/9p/client.c:1143) [ 45.448625][ C0] ? 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) [ 45.448793][ C0] ? v9fs_fid_lookup_with_uid (fs/9p/fid.c:181) [ 45.448963][ C0] ? v9fs_vfs_lookup.part.0 (fs/9p/vfs_inode.c:676) [ 45.449227][ C0] v9fs_vfs_lookup.part.0 (fs/9p/vfs_inode.c:676) [ 45.449392][ C0] ? __pfx_v9fs_vfs_lookup.part.0 (fs/9p/vfs_inode.c:649) [ 45.449627][ C0] ? lockdep_init_map_type (kernel/locking/lockdep.c:4892) [ 45.449800][ C0] __lookup_slow (fs/namei.c:1692) [ 45.450064][ C0] ? __pfx___lookup_slow (fs/namei.c:1668) [ 45.450242][ C0] ? walk_component (fs/namei.c:1709 fs/namei.c:2004) [ 45.450413][ C0] walk_component (./include/linux/fs.h:808 fs/namei.c:1710 fs/namei.c:2004) [ 45.450581][ C0] link_path_walk.part.0.constprop.0 (fs/namei.c:2331) [ 45.450885][ C0] ? __pfx_link_path_walk.part.0.constprop.0 (fs/namei.c:2249) [ 45.451091][ C0] ? validate_chain (./include/linux/hash.h:78 kernel/locking/lockdep.c:3759 kernel/locking/lockdep.c:3782 kernel/locking/lockdep.c:3837) [ 45.451265][ C0] ? 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) [ 45.451434][ C0] path_lookupat (fs/namei.c:2254 (discriminator 2) fs/namei.c:2484 (discriminator 2)) [ 45.451698][ C0] filename_lookup (fs/namei.c:2514) [ 45.451866][ C0] ? __pfx_filename_lookup (fs/namei.c:2508) [ 45.452046][ C0] ? find_held_lock (kernel/locking/lockdep.c:5244) [ 45.452214][ C0] ? __lock_release (kernel/locking/lockdep.c:5430) [ 45.452484][ C0] ? __might_fault (mm/memory.c:6216 mm/memory.c:6209) [ 45.452652][ C0] ? __pfx___lock_release (kernel/locking/lockdep.c:5406) [ 45.452826][ C0] ? trace_lock_acquire (./include/trace/events/lock.h:24 (discriminator 52)) [ 45.452993][ C0] vfs_statx (fs/stat.c:244) [ 45.453127][ C0] ? __pfx_vfs_statx (fs/stat.c:234) [ 45.453294][ C0] ? getname_flags (./arch/x86/include/asm/atomic.h:28 ./include/linux/atomic/atomic-arch-fallback.h:503 ./include/linux/atomic/atomic-instrumented.h:68 fs/namei.c:190) [ 45.453462][ C0] vfs_fstatat (fs/stat.c:305) [ 45.453588][ C0] __do_sys_newfstatat (fs/stat.c:469) [ 45.453754][ C0] ? __pfx___do_sys_newfstatat (fs/stat.c:464) [ 45.454025][ C0] ? __x64_sys_openat (fs/open.c:1432) [ 45.454193][ C0] ? __pfx___x64_sys_openat (fs/open.c:1432) [ 45.454364][ C0] ? __pfx_do_faccessat (fs/open.c:465) [ 45.454533][ C0] ? lockdep_hardirqs_on_prepare.part.0 (kernel/locking/lockdep.c:4300 kernel/locking/lockdep.c:4359) [ 45.454840][ C0] do_syscall_64 (arch/x86/entry/common.c:52 arch/x86/entry/common.c:83) [ 45.455008][ C0] entry_SYSCALL_64_after_hwframe (arch/x86/entry/entry_64.S:129) [ 45.455218][ C0] RIP: 0033:0x7f0b4e89deae [ 45.455394][ C0] Code: 48 89 f2 b9 00 01 00 00 48 89 fe bf 9c ff ff ff e9 07 00 00 00 0f 1f 80 00 00 00 00 f3 0f 1e fa 41 89 ca b8 06 01 00 00 0f 05 <3d> 00 f0 ff ff 77 0b 31 c0 c3 0f 1f 84 00 00 00 00 00 f7 d8 89 05 All code ======== 0: 48 89 f2 mov %rsi,%rdx 3: b9 00 01 00 00 mov $0x100,%ecx 8: 48 89 fe mov %rdi,%rsi b: bf 9c ff ff ff mov $0xffffff9c,%edi 10: e9 07 00 00 00 jmp 0x1c 15: 0f 1f 80 00 00 00 00 nopl 0x0(%rax) 1c: f3 0f 1e fa endbr64 20: 41 89 ca mov %ecx,%r10d 23: b8 06 01 00 00 mov $0x106,%eax 28: 0f 05 syscall 2a:* 3d 00 f0 ff ff cmp $0xfffff000,%eax <-- trapping instruction 2f: 77 0b ja 0x3c 31: 31 c0 xor %eax,%eax 33: c3 ret 34: 0f 1f 84 00 00 00 00 nopl 0x0(%rax,%rax,1) 3b: 00 3c: f7 d8 neg %eax 3e: 89 .byte 0x89 3f: 05 .byte 0x5 Code starting with the faulting instruction =========================================== 0: 3d 00 f0 ff ff cmp $0xfffff000,%eax 5: 77 0b ja 0x12 7: 31 c0 xor %eax,%eax 9: c3 ret a: 0f 1f 84 00 00 00 00 nopl 0x0(%rax,%rax,1) 11: 00 12: f7 d8 neg %eax 14: 89 .byte 0x89 15: 05 .byte 0x5 [ 45.456097][ C0] RSP: 002b:00007ffef6b09418 EFLAGS: 00000246 ORIG_RAX: 0000000000000106 [ 45.456457][ C0] RAX: ffffffffffffffda RBX: 0000000000000010 RCX: 00007f0b4e89deae [ 45.456708][ C0] RDX: 00007ffef6b094f0 RSI: 00007ffef6b09420 RDI: 00000000ffffff9c [ 45.456953][ C0] RBP: 00007ffef6b095b0 R08: 00000000ffffffff R09: 00007ffef6b09420 [ 45.457211][ C0] R10: 0000000000000000 R11: 0000000000000246 R12: 00007ffef6b09427 Finger prints: dump_stack_lvl:mark_lock_irq:mark_lock:mark_usage