====================================== | [ 79.633307][ C2] entry_SYSCALL_64_after_hwframe (arch/x86/entry/entry_64.S:129) | [ 79.633515][ C2] | [ 79.633600][ C2] | [ 79.633600][ C2] stack backtrace: [ 79.634182][ C2] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS rel-1.16.3-0-ga6ed6b701f0a-prebuilt.qemu.org 04/01/2014 [ 79.634571][ C2] Call Trace: [ 79.634820][ C2] [ 79.634908][ C2] dump_stack_lvl (lib/dump_stack.c:117) [ 79.635082][ C2] print_irq_inversion_bug.part.0 (kernel/locking/lockdep.c:4024) [ 79.635292][ C2] ? kernel_text_address (kernel/extable.c:97 kernel/extable.c:94) [ 79.635470][ C2] ? __pfx_print_irq_inversion_bug.part.0 (kernel/locking/lockdep.c:4024) [ 79.635919][ C2] ? __pfx_usage_skip (kernel/locking/lockdep.c:2264) [ 79.636108][ C2] ? __pfx_usage_match (kernel/locking/lockdep.c:2256) [ 79.636284][ C2] ? arch_stack_walk (arch/x86/kernel/stacktrace.c:26) [ 79.636458][ C2] mark_lock_irq (kernel/locking/lockdep.c:4244) [ 79.636748][ C2] ? __pfx_mark_lock_irq (kernel/locking/lockdep.c:4207) [ 79.636920][ C2] ? __pfx_stack_trace_save (kernel/stacktrace.c:114) [ 79.637093][ C2] ? save_trace (kernel/locking/lockdep.c:586) [ 79.637268][ C2] mark_lock (kernel/locking/lockdep.c:4678) [ 79.637511][ C2] ? __pfx_stack_trace_save (kernel/stacktrace.c:114) [ 79.637686][ C2] mark_usage (kernel/locking/lockdep.c:4567) [ 79.637825][ C2] __lock_acquire (kernel/locking/lockdep.c:5091) [ 79.638002][ C2] ? __pfx_validate_chain (kernel/locking/lockdep.c:3825) [ 79.638175][ C2] ? __pfx_addrconf_rs_timer (net/ipv6/addrconf.c:4016) [ 79.638467][ C2] lock_acquire.part.0 (kernel/locking/lockdep.c:467 kernel/locking/lockdep.c:5756) [ 79.638636][ C2] ? addrconf_rs_timer (net/ipv6/addrconf.c:4023) [ 79.638806][ C2] ? __pfx_lock_acquire.part.0 (kernel/locking/lockdep.c:5719) [ 79.638986][ C2] ? trace_lock_acquire (./include/trace/events/lock.h:24 (discriminator 52)) [ 79.639163][ C2] ? addrconf_rs_timer (net/ipv6/addrconf.c:4023) [ 79.639342][ C2] ? lock_acquire (kernel/locking/lockdep.c:5727) [ 79.639514][ C2] ? addrconf_rs_timer (net/ipv6/addrconf.c:4023) [ 79.639683][ C2] _raw_write_lock (./include/linux/rwlock_api_smp.h:210 kernel/locking/spinlock.c:300) [ 79.639966][ C2] ? addrconf_rs_timer (net/ipv6/addrconf.c:4023) [ 79.640134][ C2] addrconf_rs_timer (net/ipv6/addrconf.c:4023) [ 79.640304][ C2] ? __pfx_lock_acquire.part.0 (kernel/locking/lockdep.c:5719) [ 79.640474][ C2] ? __pfx_addrconf_rs_timer (net/ipv6/addrconf.c:4016) [ 79.640754][ C2] ? call_timer_fn (./include/linux/lockdep.h:31 kernel/time/timer.c:1783) [ 79.640927][ C2] ? lock_acquire (kernel/locking/lockdep.c:5727) [ 79.641094][ C2] ? call_timer_fn (./include/linux/lockdep.h:31 kernel/time/timer.c:1783) [ 79.641260][ C2] ? __pfx_addrconf_rs_timer (net/ipv6/addrconf.c:4016) [ 79.641428][ C2] call_timer_fn (kernel/time/timer.c:1793) [ 79.641704][ C2] ? call_timer_fn (./include/linux/lockdep.h:31 kernel/time/timer.c:1783) [ 79.641876][ C2] ? call_timer_fn (./include/linux/lockdep.h:31 kernel/time/timer.c:1783) [ 79.642049][ C2] ? __pfx_call_timer_fn (kernel/time/timer.c:1770) [ 79.642221][ 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) [ 79.642506][ C2] ? mark_held_locks (kernel/locking/lockdep.c:4274) [ 79.642680][ C2] __run_timers (kernel/time/timer.c:1845 kernel/time/timer.c:2418) [ 79.642856][ C2] ? __pfx_addrconf_rs_timer (net/ipv6/addrconf.c:4016) [ 79.643024][ C2] ? __pfx___run_timers (kernel/time/timer.c:2389) [ 79.643303][ C2] ? __lock_release (kernel/locking/lockdep.c:5430) [ 79.643481][ 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) [ 79.643654][ C2] ? __pfx_do_raw_spin_lock (kernel/locking/spinlock_debug.c:114) [ 79.643827][ C2] ? lock_acquire (kernel/locking/lockdep.c:5727) [ 79.644109][ C2] ? timer_expire_remote (kernel/time/timer.c:2429 kernel/time/timer.c:2422 kernel/time/timer.c:2181) [ 79.644291][ C2] timer_expire_remote (kernel/time/timer.c:2430 kernel/time/timer.c:2422 kernel/time/timer.c:2181) [ 79.644458][ 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) [ 79.644633][ C2] ? __pfx_tmigr_handle_remote_cpu (kernel/time/timer_migration.c:869) [ 79.644964][ 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) [ 79.645135][ C2] ? mark_lock (kernel/locking/lockdep.c:4656 (discriminator 3)) [ 79.645268][ C2] ? mark_held_locks (kernel/locking/lockdep.c:4274) [ 79.645441][ C2] tmigr_handle_remote_up (kernel/time/timer_migration.c:1003) [ 79.645617][ C2] tmigr_handle_remote (kernel/time/timer_migration.c:488 kernel/time/timer_migration.c:1061) [ 79.645906][ C2] ? __pfx_tmigr_handle_remote (kernel/time/timer_migration.c:1026) [ 79.646146][ C2] ? mark_held_locks (kernel/locking/lockdep.c:4274) [ 79.646323][ C2] __do_softirq (kernel/softirq.c:554) [ 79.646503][ C2] irq_exit_rcu (kernel/softirq.c:428 kernel/softirq.c:633 kernel/softirq.c:645) [ 79.646755][ C2] sysvec_apic_timer_interrupt (arch/x86/kernel/apic/apic.c:1043 arch/x86/kernel/apic/apic.c:1043) [ 79.646928][ C2] [ 79.647015][ C2] [ 79.647109][ C2] asm_sysvec_apic_timer_interrupt (./arch/x86/include/asm/idtentry.h:702) [ 79.647330][ C2] RIP: 0010:_raw_spin_unlock_irqrestore (./include/linux/spinlock_api_smp.h:152 kernel/locking/spinlock.c:194) [ 79.647683][ 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 8f 71 <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 8f 71 decl %gs:0x718fbf05(%rip) # 0x718fbf2f 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 [ 79.648276][ C2] RSP: 0018:ffffc9000073f100 EFLAGS: 00000282 [ 79.648614][ C2] RAX: 0000000000000006 RBX: 0000000000000200 RCX: 1ffffffff2327f20 [ 79.648865][ C2] RDX: 0000000000000000 RSI: 0000000000000000 RDI: ffffffff8e740911 [ 79.649124][ C2] RBP: ffff88800104f440 R08: 0000000000000001 R09: fffffbfff23238af [ 79.649505][ C2] R10: ffffffff9191c57f R11: 0000000000000008 R12: ffff88800104f440 [ 79.649768][ C2] R13: ffffea00000b5f00 R14: ffff88800104de40 R15: ffff888002d7de08 [ 79.650023][ C2] ? _raw_spin_unlock_irqrestore (./include/linux/spinlock_api_smp.h:151 kernel/locking/spinlock.c:194) [ 79.650242][ C2] get_partial_node.part.0 (mm/slub.c:2623) [ 79.650423][ C2] ___slab_alloc (mm/slub.c:2583 mm/slub.c:2701 mm/slub.c:3505) [ 79.650591][ C2] ? fs_reclaim_acquire (mm/page_alloc.c:3715 mm/page_alloc.c:3706) [ 79.650768][ C2] ? __alloc_object (mm/kmemleak.c:466 mm/kmemleak.c:645) [ 79.651049][ C2] ? __pfx___lock_release (kernel/locking/lockdep.c:5406) [ 79.651224][ C2] ? __alloc_object (mm/kmemleak.c:466 mm/kmemleak.c:645) [ 79.651398][ C2] ? kmem_cache_alloc (mm/slub.c:3610 mm/slub.c:3663 mm/slub.c:3835 mm/slub.c:3852) [ 79.651567][ C2] kmem_cache_alloc (mm/slub.c:3610 mm/slub.c:3663 mm/slub.c:3835 mm/slub.c:3852) [ 79.651862][ C2] ? p9_fcall_init (net/9p/client.c:232) [ 79.652037][ C2] __alloc_object (mm/kmemleak.c:466 mm/kmemleak.c:645) [ 79.652219][ C2] ? p9_fcall_init (net/9p/client.c:232) [ 79.652393][ C2] __create_object (mm/kmemleak.c:750) [ 79.652681][ C2] ? p9_fcall_init (net/9p/client.c:232) [ 79.652856][ C2] __kmalloc (./include/linux/kmemleak.h:42 mm/slub.c:3802 mm/slub.c:3845 mm/slub.c:3965 mm/slub.c:3979) [ 79.652987][ C2] p9_fcall_init (net/9p/client.c:232) [ 79.653158][ C2] p9_tag_alloc (net/9p/client.c:297) [ 79.653334][ C2] ? __pfx_p9_tag_alloc (net/9p/client.c:277) [ 79.653630][ C2] ? netfs_alloc_subrequest (./include/linux/slab.h:632 ./include/linux/slab.h:749 fs/netfs/objects.c:143) [ 79.653804][ C2] ? is_bpf_text_address (kernel/bpf/core.c:772) [ 79.653993][ C2] p9_client_prepare_req (net/9p/client.c:641) [ 79.654165][ 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) [ 79.654468][ C2] ? __pfx_p9_client_prepare_req (net/9p/client.c:625) [ 79.654685][ C2] ? __pfx_validate_chain (kernel/locking/lockdep.c:3825) [ 79.654857][ C2] p9_client_rpc (net/9p/client.c:688 (discriminator 4)) [ 79.655024][ C2] ? __pfx_p9_client_rpc (net/9p/client.c:672) [ 79.655202][ C2] ? __lock_release (kernel/locking/lockdep.c:5430) [ 79.655381][ C2] ? __debug_object_init (lib/debugobjects.c:622) [ 79.655557][ C2] ? __pfx___lock_release (kernel/locking/lockdep.c:5406) [ 79.655727][ C2] p9_client_read_once (net/9p/client.c:1562) [ 79.656009][ C2] ? mark_held_locks (kernel/locking/lockdep.c:4274) [ 79.656195][ C2] ? __pfx_p9_client_read_once (net/9p/client.c:1534) [ 79.656367][ C2] ? lockdep_hardirqs_on_prepare.part.0 (kernel/locking/lockdep.c:4300 kernel/locking/lockdep.c:4359) [ 79.656577][ C2] ? __debug_object_init (lib/debugobjects.c:622) [ 79.656862][ C2] p9_client_read (net/9p/client.c:1522) [ 79.657037][ C2] v9fs_issue_read (fs/9p/vfs_addr.c:76) [ 79.657211][ C2] ? __pfx_v9fs_issue_read (fs/9p/vfs_addr.c:66) [ 79.657380][ C2] ? netfs_rreq_prepare_read (fs/netfs/io.c:640) [ 79.657660][ C2] netfs_rreq_submit_slice (fs/netfs/io.c:694) [ 79.657827][ C2] netfs_begin_read (fs/netfs/io.c:741) [ 79.657997][ C2] ? netfs_extract_user_iter (fs/netfs/iterator.c:39) [ 79.658165][ C2] ? __pfx_netfs_begin_read (fs/netfs/io.c:708) [ 79.658343][ C2] ? __pfx_do_raw_spin_lock (kernel/locking/spinlock_debug.c:114) [ 79.658626][ C2] ? __pfx_netfs_extract_user_iter (fs/netfs/iterator.c:39) [ 79.658831][ C2] ? netfs_alloc_request (fs/netfs/objects.c:64) [ 79.658998][ 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) [ 79.659168][ C2] ? _raw_spin_unlock (./arch/x86/include/asm/preempt.h:94 ./include/linux/spinlock_api_smp.h:143 kernel/locking/spinlock.c:186) [ 79.659471][ C2] ? netfs_alloc_request (fs/netfs/objects.c:64) [ 79.659646][ C2] netfs_unbuffered_read_iter_locked (fs/netfs/direct_read.c:84) [ 79.659866][ C2] netfs_unbuffered_read_iter (fs/netfs/direct_read.c:121) [ 79.660041][ C2] do_iter_readv_writev (./include/linux/fs.h:2102 fs/read_write.c:739) [ 79.660214][ C2] ? __lock_acquire (kernel/locking/lockdep.c:5137) [ 79.660388][ C2] ? __pfx_do_iter_readv_writev (fs/read_write.c:728) [ 79.660559][ C2] ? find_held_lock (kernel/locking/lockdep.c:5244) [ 79.660733][ C2] vfs_iter_read (fs/read_write.c:830) [ 79.661025][ C2] backing_file_read_iter (fs/backing-file.c:160) [ 79.661199][ C2] ovl_read_iter (./include/linux/file.h:47 fs/overlayfs/file.c:283) [ 79.661378][ C2] ? __pfx_ovl_read_iter (fs/overlayfs/file.c:264) [ 79.661550][ C2] ? __pfx_ovl_file_accessed (fs/overlayfs/file.c:236) [ 79.661834][ C2] ? usage_skip (kernel/locking/lockdep.c:2295 kernel/locking/lockdep.c:2263) [ 79.662011][ C2] vfs_read (./include/linux/fs.h:2102 fs/read_write.c:395 fs/read_write.c:476) [ 79.662143][ C2] ? reacquire_held_locks (kernel/locking/lockdep.c:5279) [ 79.662311][ C2] ? do_user_addr_fault (./include/linux/rcupdate.h:329 ./include/linux/rcupdate.h:781 ./include/linux/mm.h:700 arch/x86/mm/fault.c:1364) [ 79.662485][ C2] ? __pfx_vfs_read (fs/read_write.c:457) [ 79.662889][ C2] ? find_held_lock (kernel/locking/lockdep.c:5244) [ 79.663064][ C2] ? __pfx___lock_release (kernel/locking/lockdep.c:5406) [ 79.663236][ C2] ? __fget_light (./include/linux/atomic/atomic-arch-fallback.h:479 ./include/linux/atomic/atomic-instrumented.h:50 fs/file.c:1145) [ 79.663417][ C2] ksys_read (fs/read_write.c:619) [ 79.663665][ C2] ? __pfx_ksys_read (fs/read_write.c:609) [ 79.663842][ C2] ? do_user_addr_fault (./include/linux/rcupdate.h:815 ./include/linux/mm.h:702 arch/x86/mm/fault.c:1364) [ 79.664010][ C2] do_syscall_64 (arch/x86/entry/common.c:52 arch/x86/entry/common.c:83) [ 79.664177][ C2] entry_SYSCALL_64_after_hwframe (arch/x86/entry/entry_64.S:129) [ 79.664502][ C2] RIP: 0033:0x7f657c7868b2 [ 79.664675][ C2] Code: c0 e9 b2 fe ff ff 50 48 8d 3d ea 0e 08 00 e8 65 ea 01 00 0f 1f 44 00 00 f3 0f 1e fa 64 8b 04 25 18 00 00 00 85 c0 75 10 0f 05 <48> 3d 00 f0 ff ff 77 56 c3 0f 1f 44 00 00 48 83 ec 28 48 89 54 24 All code ======== 0: c0 e9 b2 shr $0xb2,%cl 3: fe (bad) 4: ff (bad) 5: ff 50 48 call *0x48(%rax) 8: 8d 3d ea 0e 08 00 lea 0x80eea(%rip),%edi # 0x80ef8 e: e8 65 ea 01 00 call 0x1ea78 13: 0f 1f 44 00 00 nopl 0x0(%rax,%rax,1) 18: f3 0f 1e fa endbr64 1c: 64 8b 04 25 18 00 00 mov %fs:0x18,%eax 23: 00 24: 85 c0 test %eax,%eax 26: 75 10 jne 0x38 28: 0f 05 syscall 2a:* 48 3d 00 f0 ff ff cmp $0xfffffffffffff000,%rax <-- trapping instruction 30: 77 56 ja 0x88 32: c3 ret 33: 0f 1f 44 00 00 nopl 0x0(%rax,%rax,1) 38: 48 83 ec 28 sub $0x28,%rsp 3c: 48 rex.W 3d: 89 .byte 0x89 3e: 54 push %rsp 3f: 24 .byte 0x24 Code starting with the faulting instruction =========================================== 0: 48 3d 00 f0 ff ff cmp $0xfffffffffffff000,%rax 6: 77 56 ja 0x5e 8: c3 ret 9: 0f 1f 44 00 00 nopl 0x0(%rax,%rax,1) e: 48 83 ec 28 sub $0x28,%rsp 12: 48 rex.W 13: 89 .byte 0x89 14: 54 push %rsp 15: 24 .byte 0x24 [ 79.665394][ C2] RSP: 002b:00007ffe01ea3ee8 EFLAGS: 00000246 ORIG_RAX: 0000000000000000 [ 79.665648][ C2] RAX: ffffffffffffffda RBX: 00000000371c52a0 RCX: 00007f657c7868b2 [ 79.665898][ C2] RDX: 0000000000002000 RSI: 00000000371ce980 RDI: 0000000000000006 [ 79.666190][ C2] RBP: 00007f657c83e5c0 R08: 0000000000000006 R09: 0000000000000000 [ 79.666439][ C2] R10: 0000000000400000 R11: 0000000000000246 R12: 00000000371c52a0 Finger prints: dump_stack_lvl:mark_lock_irq:mark_lock:mark_usage