======================================
| [ 26.003007][ C3] #0: ffffffffbc577d20 (rcu_read_lock){....}-{1:3}, at: unwind_next_frame (./include/linux/rcupdate.h:300 (discriminator 2) ./include/linux/rcupdate.h:838 (discriminator 2) ./include/linux/rcupdate.h:1181 (discriminator 2) arch/x86/kernel/unwind_orc.c:495 (discriminator 2))
| [ 26.003299][ C3] #1: ffffffffbc577c00 (rcu_callback){....}-{0:0}, at: rcu_do_batch (./include/linux/rcupdate.h:300 (discriminator 2) kernel/rcu/tree.c:2611 (discriminator 2))
| [ 26.003664][ C3]
| [ 26.003664][ C3] stack backtrace:
[ 26.003849][ C3] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011
[ 26.003852][ C3] Call Trace:
[ 26.003854][ C3]
[ 26.003855][ C3] dump_stack_lvl (lib/dump_stack.c:94 lib/dump_stack.c:120)
[ 26.003861][ C3] print_usage_bug.part.0.cold (kernel/locking/lockdep.c:4042)
[ 26.003865][ C3] ? filter_irq_stacks (kernel/stacktrace.c:402)
[ 26.003869][ C3] mark_lock_irq (kernel/locking/lockdep.c:4013 kernel/locking/lockdep.c:4056 kernel/locking/lockdep.c:4267)
[ 26.003871][ C3] ? sysvec_apic_timer_interrupt (arch/x86/kernel/apic/apic.c:1061 (discriminator 37) arch/x86/kernel/apic/apic.c:1061 (discriminator 37))
[ 26.003874][ C3] ? asm_sysvec_apic_timer_interrupt (./arch/x86/include/asm/idtentry.h:697)
[ 26.003877][ C3] ? save_trace (kernel/locking/lockdep.c:589)
[ 26.003879][ C3] ? migrate_vma_insert_page.isra.0 (mm/migrate_device.c:1055)
[ 26.003885][ C3] mark_lock (kernel/locking/lockdep.c:4753)
[ 26.003887][ C3] mark_usage (kernel/locking/lockdep.c:4642)
[ 26.003889][ C3] __lock_acquire (kernel/locking/lockdep.c:5191)
[ 26.003891][ C3] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:752 (discriminator 3))
[ 26.003894][ C3] ? rcu_do_batch (./include/linux/rcupdate.h:310 (discriminator 2) kernel/rcu/tree.c:2619 (discriminator 2))
[ 26.003897][ C3] lock_acquire.part.0 (kernel/locking/lockdep.c:5868 (discriminator 1))
[ 26.003900][ C3] ? tcf_mirred_release (./include/linux/spinlock.h:342 net/sched/act_mirred.c:78) act_mirred
[ 26.003903][ C3] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:752 (discriminator 3))
[ 26.003905][ C3] ? lock_acquire (./include/trace/events/lock.h:24 (discriminator 22) kernel/locking/lockdep.c:5831 (discriminator 22))
[ 26.003908][ C3] _raw_spin_lock (./include/linux/spinlock_api_smp.h:158 (discriminator 1) kernel/locking/spinlock.c:158 (discriminator 1))
[ 26.003911][ C3] ? tcf_mirred_release (./include/linux/spinlock.h:342 net/sched/act_mirred.c:78) act_mirred
[ 26.003913][ C3] tcf_mirred_release (./include/linux/spinlock.h:342 net/sched/act_mirred.c:78) act_mirred
[ 26.003916][ C3] tcf_action_rcu_free (net/sched/act_api.c:367 net/sched/act_api.c:378)
[ 26.003918][ C3] ? rcu_do_batch (./include/linux/rcupdate.h:310 (discriminator 2) kernel/rcu/tree.c:2619 (discriminator 2))
[ 26.003920][ C3] rcu_do_batch (kernel/rcu/tree.c:2617)
[ 26.003924][ C3] ? trace_rcu_batch_end (./include/trace/events/rcu.h:714 (discriminator 19))
[ 26.003928][ C3] ? lockdep_hardirqs_on_prepare.part.0 (kernel/locking/lockdep.c:470 (discriminator 2) kernel/locking/lockdep.c:4411 (discriminator 2))
[ 26.003930][ C3] ? lockdep_hardirqs_on (kernel/locking/lockdep.c:4472)
[ 26.003932][ C3] ? _raw_spin_unlock_irqrestore (./include/linux/spinlock_api_smp.h:178 (discriminator 6) kernel/locking/spinlock.c:198 (discriminator 6))
[ 26.003934][ C3] ? _raw_spin_unlock_irqrestore (./include/linux/spinlock_api_smp.h:179 (discriminator 1) kernel/locking/spinlock.c:198 (discriminator 1))
[ 26.003937][ C3] rcu_core (kernel/rcu/tree.c:2869)
[ 26.003940][ C3] handle_softirqs (kernel/softirq.c:622)
[ 26.003942][ C3] ? find_held_lock (kernel/locking/lockdep.c:5350)
[ 26.003946][ C3] ? __lock_release.isra.0 (kernel/locking/lockdep.c:5535)
[ 26.003948][ C3] ? _local_bh_enable (kernel/softirq.c:405 (discriminator 1))
[ 26.003951][ C3] __irq_exit_rcu (kernel/softirq.c:656 kernel/softirq.c:496 kernel/softirq.c:735)
[ 26.003953][ C3] irq_exit_rcu (kernel/softirq.c:752)
[ 26.003955][ C3] sysvec_apic_timer_interrupt (arch/x86/kernel/apic/apic.c:1061 (discriminator 37) arch/x86/kernel/apic/apic.c:1061 (discriminator 37))
[ 26.003958][ C3]
[ 26.003959][ C3]
[ 26.003960][ C3] asm_sysvec_apic_timer_interrupt (./arch/x86/include/asm/idtentry.h:697)
[ 26.003963][ C3] RIP: 0010:debug_lockdep_rcu_enabled (kernel/rcu/update.c:320)
[ 26.003966][ C3] Code: 2a fa ff ff 8b 44 24 04 eb 82 31 c0 e9 4e ff ff ff 66 2e 0f 1f 84 00 00 00 00 00 0f 1f 00 f3 0f 1e fa 8b 05 b2 60 7d 01 85 c0 <74> 20 8b 05 c0 71 7d 01 85 c0 74 16 65 48 8b 05 10 87 00 02 8b 80
All code
========
0: 2a fa sub %dl,%bh
2: ff (bad)
3: ff 8b 44 24 04 eb decl -0x14fbdbbc(%rbx)
9: 82 (bad)
a: 31 c0 xor %eax,%eax
c: e9 4e ff ff ff jmp 0xffffffffffffff5f
11: 66 2e 0f 1f 84 00 00 cs nopw 0x0(%rax,%rax,1)
18: 00 00 00
1b: 0f 1f 00 nopl (%rax)
1e: f3 0f 1e fa endbr64
22: 8b 05 b2 60 7d 01 mov 0x17d60b2(%rip),%eax # 0x17d60da
28: 85 c0 test %eax,%eax
2a:* 74 20 je 0x4c <-- trapping instruction
2c: 8b 05 c0 71 7d 01 mov 0x17d71c0(%rip),%eax # 0x17d71f2
32: 85 c0 test %eax,%eax
34: 74 16 je 0x4c
36: 65 48 8b 05 10 87 00 mov %gs:0x2008710(%rip),%rax # 0x200874e
3d: 02
3e: 8b .byte 0x8b
3f: 80 .byte 0x80
Code starting with the faulting instruction
===========================================
0: 74 20 je 0x22
2: 8b 05 c0 71 7d 01 mov 0x17d71c0(%rip),%eax # 0x17d71c8
8: 85 c0 test %eax,%eax
a: 74 16 je 0x22
c: 65 48 8b 05 10 87 00 mov %gs:0x2008710(%rip),%rax # 0x2008724
13: 02
14: 8b .byte 0x8b
15: 80 .byte 0x80
[ 26.003969][ C3] RSP: 0018:ffa00000007a71f0 EFLAGS: 00000202
[ 26.003972][ C3] RAX: 0000000000000002 RBX: 1ff40000000f4e48 RCX: ffa00000007a0001
[ 26.003973][ C3] RDX: ffa00000007a8000 RSI: ffa00000007a7a68 RDI: ffa00000007a7308
[ 26.003975][ C3] RBP: ffa00000007a7a98 R08: ffffffffbd190ba0 R09: ffffffffbcf4b42c
[ 26.003976][ C3] R10: ffffffffb9b878aa R11: 0000000000000000 R12: ffa00000007a7a01
[ 26.003977][ C3] R13: ffa00000007a72f8 R14: ff11000010462340 R15: 0000000000000000
[ 26.003980][ C3] ? vfs_open (fs/open.c:1079)
[ 26.003985][ C3] unwind_next_frame (./include/linux/rcupdate.h:867 ./include/linux/rcupdate.h:1181 arch/x86/kernel/unwind_orc.c:495)
[ 26.003987][ C3] ? do_dentry_open (fs/open.c:947)
[ 26.003990][ C3] ? stack_access_ok (./arch/x86/include/asm/stacktrace.h:55)
[ 26.003993][ C3] ? __unwind_start (arch/x86/kernel/unwind_orc.c:787)
[ 26.003996][ C3] ? write_profile (profile.c:?)
[ 26.003998][ C3] arch_stack_walk (arch/x86/kernel/stacktrace.c:25)
[ 26.004004][ C3] ? vfs_open (fs/open.c:1079)
[ 26.004007][ C3] stack_trace_save (kernel/stacktrace.c:122 (discriminator 1))
[ 26.004010][ C3] ? filter_irq_stacks (kernel/stacktrace.c:402)
[ 26.004014][ C3] kasan_save_stack (mm/kasan/common.c:57)
[ 26.004018][ C3] ? kasan_save_stack (mm/kasan/common.c:57)
[ 26.004020][ C3] ? kasan_save_track (mm/kasan/common.c:78)
[ 26.004022][ C3] ? __kasan_slab_alloc (mm/kasan/common.c:340 mm/kasan/common.c:366)
[ 26.004024][ C3] ? kmem_cache_alloc_noprof (./include/linux/kasan.h:253 mm/slub.c:4570 mm/slub.c:4899 mm/slub.c:4906)
[ 26.004028][ C3] ? __alloc_object (mm/kmemleak.c:483 (discriminator 1) mm/kmemleak.c:665 (discriminator 1))
[ 26.004030][ C3] ? __create_object (mm/kmemleak.c:779)
[ 26.004031][ C3] ? __kmalloc_cache_noprof (./include/linux/kmemleak.h:44 mm/slub.c:4575 mm/slub.c:4899 mm/slub.c:5415)
[ 26.004034][ C3] ? fuse_file_alloc (./include/linux/slab.h:950 (discriminator 1) ./include/linux/slab.h:1188 (discriminator 1) fs/fuse/file.c:59 (discriminator 1))
[ 26.004038][ C3] ? fuse_file_open (fs/fuse/file.c:152)
[ 26.004040][ C3] ? fuse_open (fs/fuse/file.c:194 fs/fuse/file.c:283)
[ 26.004042][ C3] ? do_dentry_open (fs/open.c:947)
[ 26.004044][ C3] ? vfs_open (fs/open.c:1079)
[ 26.004046][ C3] ? backing_file_open (fs/backing-file.c:47)
[ 26.004049][ C3] ? ovl_open_realfile (fs/overlayfs/file.c:51 (discriminator 1))
[ 26.004052][ C3] ? ovl_open (fs/overlayfs/file.c:222)
[ 26.004054][ C3] ? do_dentry_open (fs/open.c:947)
[ 26.004062][ C3] kasan_save_track (mm/kasan/common.c:78)
[ 26.004064][ C3] __kasan_slab_alloc (mm/kasan/common.c:340 mm/kasan/common.c:366)
[ 26.004067][ C3] kmem_cache_alloc_noprof (./include/linux/kasan.h:253 mm/slub.c:4570 mm/slub.c:4899 mm/slub.c:4906)
[ 26.004069][ C3] ? do_file_open (fs/namei.c:771 fs/namei.c:4886)
[ 26.004073][ C3] ? __x64_sys_openat (fs/open.c:1370 fs/open.c:1386 fs/open.c:1381 fs/open.c:1381)
[ 26.004076][ C3] __alloc_object (mm/kmemleak.c:483 (discriminator 1) mm/kmemleak.c:665 (discriminator 1))
[ 26.004078][ C3] __create_object (mm/kmemleak.c:779)
[ 26.004081][ C3] __kmalloc_cache_noprof (./include/linux/kmemleak.h:44 mm/slub.c:4575 mm/slub.c:4899 mm/slub.c:5415)
[ 26.004085][ C3] fuse_file_alloc (./include/linux/slab.h:950 (discriminator 1) ./include/linux/slab.h:1188 (discriminator 1) fs/fuse/file.c:59 (discriminator 1))
[ 26.004087][ C3] fuse_file_open (fs/fuse/file.c:152)
[ 26.004090][ C3] ? static_obj (kernel/locking/lockdep.c:859)
[ 26.004093][ C3] fuse_open (fs/fuse/file.c:194 fs/fuse/file.c:283)
[ 26.004096][ C3] ? fuse_finish_open (fs/fuse/file.c:234)
[ 26.004099][ C3] do_dentry_open (fs/open.c:947)
[ 26.004103][ C3] vfs_open (fs/open.c:1079)
[ 26.004106][ C3] ? do_raw_spin_unlock (./include/linux/instrumented.h:82 ./include/linux/atomic/atomic-instrumented.h:32 ./include/asm-generic/qspinlock.h:57 kernel/locking/spinlock_debug.c:101 kernel/locking/spinlock_debug.c:141)
[ 26.004109][ C3] backing_file_open (fs/backing-file.c:47)
[ 26.004111][ C3] ovl_open_realfile (fs/overlayfs/file.c:51 (discriminator 1))
[ 26.004114][ C3] ovl_open (fs/overlayfs/file.c:222)
[ 26.004117][ C3] ? ovl_llseek (fs/overlayfs/file.c:255)
[ 26.004120][ C3] ? do_raw_spin_unlock (./include/linux/instrumented.h:82 ./include/linux/atomic/atomic-instrumented.h:32 ./include/asm-generic/qspinlock.h:57 kernel/locking/spinlock_debug.c:101 kernel/locking/spinlock_debug.c:141)
[ 26.004122][ C3] ? ovl_llseek (fs/overlayfs/file.c:255)
[ 26.004124][ C3] do_dentry_open (fs/open.c:947)
[ 26.004128][ C3] vfs_open (fs/open.c:1079)
[ 26.004131][ C3] ? may_open (fs/namei.c:4276)
[ 26.004133][ C3] ? lookup_open.isra.0 (fs/namei.c:4504)
[ 26.004136][ C3] do_open (fs/namei.c:4699)
[ 26.004138][ C3] ? init_file.isra.0 (./include/linux/instrumented.h:97 ./include/linux/atomic/atomic-instrumented.h:3223 ./include/linux/file_ref.h:61 fs/file_table.c:229)
[ 26.004141][ C3] path_openat (fs/namei.c:4858)
[ 26.004144][ C3] ? rcu_lockdep_current_cpu_online (kernel/rcu/tree.c:4040 (discriminator 3) kernel/rcu/tree.c:4032 (discriminator 3))
[ 26.004146][ C3] ? kernel_tmpfile_open (fs/namei.c:4800)
[ 26.004149][ C3] ? validate_chain (kernel/locking/lockdep.c:3801 (discriminator 2) kernel/locking/lockdep.c:3821 (discriminator 2) kernel/locking/lockdep.c:3876 (discriminator 2))
[ 26.004151][ C3] ? rcu_lockdep_current_cpu_online (kernel/rcu/tree.c:4040 (discriminator 3) kernel/rcu/tree.c:4032 (discriminator 3))
[ 26.004154][ C3] do_file_open (fs/namei.c:4887)
[ 26.004157][ C3] ? path_openat (./include/linux/mount.h:68 (discriminator 3))
[ 26.004161][ C3] ? page_get_link_raw (fs/namei.c:6328)
[ 26.004165][ C3] ? do_raw_spin_unlock (./include/linux/instrumented.h:82 ./include/linux/atomic/atomic-instrumented.h:32 ./include/asm-generic/qspinlock.h:57 kernel/locking/spinlock_debug.c:101 kernel/locking/spinlock_debug.c:141)
[ 26.004167][ C3] ? _raw_spin_unlock (./include/linux/spinlock_api_smp.h:169 (discriminator 1) kernel/locking/spinlock.c:190 (discriminator 1))
[ 26.004170][ C3] ? alloc_fd (./include/linux/spinlock.h:390 fs/file.c:611)
[ 26.004173][ C3] do_sys_openat2 (fs/open.c:1364 (discriminator 5))
[ 26.004176][ C3] ? build_open_flags (fs/open.c:1212)
[ 26.004179][ C3] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:752 (discriminator 3))
[ 26.004182][ C3] ? trace_irq_enable.constprop.0 (./include/trace/events/preemptirq.h:40 (discriminator 22))
[ 26.004185][ C3] ? lockdep_hardirqs_on (kernel/locking/lockdep.c:4472)
[ 26.004188][ C3] __x64_sys_openat (fs/open.c:1370 fs/open.c:1386 fs/open.c:1381 fs/open.c:1381)
[ 26.004191][ C3] ? fput_close_sync (fs/file_table.c:615)
[ 26.004193][ C3] ? __ia32_sys_open (fs/open.c:1374)
[ 26.004196][ C3] ? fpregs_restore_userregs (./include/linux/instrumented.h:97 ./include/asm-generic/bitops/instrumented-atomic.h:41 ./include/linux/thread_info.h:109 arch/x86/kernel/fpu/context.h:79)
[ 26.004199][ C3] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:752 (discriminator 3))
[ 26.004201][ C3] ? trace_irq_enable.constprop.0 (./include/trace/events/preemptirq.h:40 (discriminator 22))
[ 26.004204][ C3] do_syscall_64 (arch/x86/entry/syscall_64.c:63 arch/x86/entry/syscall_64.c:94)
[ 26.004206][ C3] ? trace_hardirqs_off (kernel/trace/trace_preemptirq.c:104 (discriminator 1))
[ 26.004208][ C3] ? exc_page_fault (arch/x86/mm/fault.c:1480 (discriminator 3) arch/x86/mm/fault.c:1527 (discriminator 3))
[ 26.004211][ C3] entry_SYSCALL_64_after_hwframe (arch/x86/entry/entry_64.S:121)
[ 26.004213][ C3] RIP: 0033:0x7fd444319625
[ 26.004216][ C3] Code: 48 89 e5 48 89 55 e0 41 83 e2 40 75 28 89 f2 f7 d2 81 e2 00 00 41 00 74 1c 89 f2 bf 9c ff ff ff 48 89 c6 b8 01 01 00 00 0f 05 <48> 3d 00 f0 ff ff 77 23 5d c3 90 48 8d 4d 10 c7 45 b8 10 00 00 00
All code
========
0: 48 89 e5 mov %rsp,%rbp
3: 48 89 55 e0 mov %rdx,-0x20(%rbp)
7: 41 83 e2 40 and $0x40,%r10d
b: 75 28 jne 0x35
d: 89 f2 mov %esi,%edx
f: f7 d2 not %edx
11: 81 e2 00 00 41 00 and $0x410000,%edx
17: 74 1c je 0x35
19: 89 f2 mov %esi,%edx
1b: bf 9c ff ff ff mov $0xffffff9c,%edi
20: 48 89 c6 mov %rax,%rsi
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 23 ja 0x55
32: 5d pop %rbp
33: c3 ret
34: 90 nop
35: 48 8d 4d 10 lea 0x10(%rbp),%rcx
39: c7 45 b8 10 00 00 00 movl $0x10,-0x48(%rbp)
Code starting with the faulting instruction
===========================================
0: 48 3d 00 f0 ff ff cmp $0xfffffffffffff000,%rax
6: 77 23 ja 0x2b
8: 5d pop %rbp
9: c3 ret
a: 90 nop
b: 48 8d 4d 10 lea 0x10(%rbp),%rcx
f: c7 45 b8 10 00 00 00 movl $0x10,-0x48(%rbp)
[ 26.004217][ C3] RSP: 002b:00007ffdde442500 EFLAGS: 00000206 ORIG_RAX: 0000000000000101
[ 26.004220][ C3] RAX: ffffffffffffffda RBX: 00007ffdde442790 RCX: 00007fd444319625
[ 26.004221][ C3] RDX: 0000000000080000 RSI: 00007ffdde442580 RDI: 00000000ffffff9c
[ 26.004223][ C3] RBP: 00007ffdde442500 R08: 00007ffdde442777 R09: 0000000000000000
[ 26.004224][ C3] R10: 0000000000000000 R11: 0000000000000206 R12: 00007ffdde442580
Finger prints:
mark_lock_irq:mark_lock:mark_usage:__lock_acquire:_raw_spin_lock