====================================== | [ 10.726545][ T247] softirqs last disabled at (19231): __irq_exit_rcu (kernel/softirq.c:679 kernel/softirq.c:519 kernel/softirq.c:767) | [ 10.726548][ T247] Preemption disabled at: | [ 10.726548][ T247] vprintk_emit (kernel/printk/printk.c:2471) | [ 10.726558][ T247] Tainted: [W]=WARN [ 10.726558][ T247] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 10.726560][ T247] Call Trace: [ 10.726561][ T247] [ 10.726563][ T247] dump_stack_lvl (lib/dump_stack.c:94 lib/dump_stack.c:120) [ 10.726568][ T247] ? vprintk_emit (kernel/printk/printk.c:2471) [ 10.726571][ T247] __might_resched.cold (kernel/sched/core.c:9234) [ 10.726575][ T247] ? perf_trace_sched_switch (./include/linux/list.h:1037 (discriminator 3)) [ 10.726579][ T247] ? __kmalloc_noprof (./include/linux/sched/mm.h:317 mm/slub.c:4636 mm/slub.c:4974 mm/slub.c:5413 mm/slub.c:5439) [ 10.726584][ T247] __kmalloc_noprof (./include/linux/sched/mm.h:322 (discriminator 2) mm/slub.c:4636 (discriminator 2) mm/slub.c:4974 (discriminator 2) mm/slub.c:5413 (discriminator 2) mm/slub.c:5439 (discriminator 2)) [ 10.726586][ T247] ? alloc_buf.isra.0 (./include/linux/slab.h:995 drivers/char/virtio_console.c:429) [ 10.726592][ T247] ? do_raw_spin_unlock (./include/linux/instrumented.h:82 ./include/linux/atomic/atomic-instrumented.h:32 ./include/asm-generic/qspinlock.h:58 kernel/locking/spinlock_debug.c:101 kernel/locking/spinlock_debug.c:141) [ 10.726595][ T247] alloc_buf.isra.0 (./include/linux/slab.h:995 drivers/char/virtio_console.c:429) [ 10.726598][ T247] put_chars (drivers/char/virtio_console.c:1176) [ 10.726601][ T247] ? __send_to_port (drivers/char/virtio_console.c:654) [ 10.726602][ T247] ? rcu_lockdep_current_cpu_online (kernel/rcu/tree.c:4116 (discriminator 3) kernel/rcu/tree.c:4108 (discriminator 3)) [ 10.726606][ T247] ? rcu_read_lock_any_held (./include/linux/lockdep.h:249 kernel/rcu/update.c:386 kernel/rcu/update.c:380) [ 10.726609][ T247] ? validate_chain (kernel/locking/lockdep.c:3817 (discriminator 2) kernel/locking/lockdep.c:3837 (discriminator 2) kernel/locking/lockdep.c:3892 (discriminator 2)) [ 10.726613][ T247] hvc_console_print (drivers/tty/hvc/hvc_console.c:177 (discriminator 2)) [ 10.726616][ T247] ? __lock_acquire (kernel/locking/lockdep.c:5254) [ 10.726620][ T247] ? hvc_write (drivers/tty/hvc/hvc_console.c:501) [ 10.726623][ T247] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 10.726627][ T247] console_emit_next_record (kernel/printk/printk.c:3183) [ 10.726631][ T247] ? devkmsg_read (./arch/x86/include/asm/atomic64_64.h:20) [ 10.726633][ T247] ? console_flush_one_record (./include/linux/rcupdate.h:314 (discriminator 2) ./include/linux/srcu.h:439 (discriminator 2) kernel/printk/printk.c:291 (discriminator 2) kernel/printk/printk.c:3246 (discriminator 2)) [ 10.726636][ T247] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 10.726638][ T247] ? lock_acquire (./include/trace/events/lock.h:23 (discriminator 22) kernel/locking/lockdep.c:5871 (discriminator 22)) [ 10.726642][ T247] console_flush_one_record (kernel/printk/printk.c:3268) [ 10.726646][ T247] ? console_emit_next_record (kernel/printk/printk.c:3150) [ 10.726647][ T247] ? __lock_acquire (kernel/locking/lockdep.c:5254) [ 10.726652][ T247] console_unlock (kernel/printk/printk.c:3350 kernel/printk/printk.c:3380 kernel/printk/printk.c:3420) [ 10.726655][ T247] ? console_flush_one_record (kernel/printk/printk.c:3316) [ 10.726657][ T247] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 10.726659][ T247] ? lock_acquire (kernel/locking/lockdep.c:5913) [ 10.726662][ T247] ? __down_trylock_console_sem (kernel/printk/printk.c:334) [ 10.726664][ T247] ? vprintk_emit (kernel/printk/printk.c:2478) [ 10.726667][ T247] vprintk_emit (kernel/printk/printk.c:2479) [ 10.726671][ T247] ? wake_up_klogd_work_func (kernel/printk/printk.c:4603 (discriminator 126)) [ 10.726676][ T247] ? vlan_netlink_fini (./include/linux/etherdevice.h:306 net/8021q/vlan.c:316 net/8021q/vlan.c:416) 8021q [ 10.726680][ T247] _printk (kernel/printk/printk.c:2504) [ 10.726684][ T247] ? snapshot_read.cold (user.c:?) [ 10.726690][ T247] ? do_one_initcall (./include/linux/instrumented.h:82 ./include/asm-generic/bitops/instrumented-non-atomic.h:141 ./include/linux/cpumask.h:650 ./include/linux/cpumask.h:1232 ./include/trace/events/initcall.h:27 init/main.c:1356) [ 10.726693][ T247] vlan_proto_init (./include/linux/rcupdate.h:309 (discriminator 2) ./include/linux/rcupdate.h:849 (discriminator 2) ./include/net/netns/generic.h:45 (discriminator 2)) 8021q [ 10.726696][ T247] do_one_initcall (init/main.c:1357) [ 10.726699][ T247] ? trace_event_raw_event_initcall_level (./include/trace/events/initcall.h:10) [ 10.726703][ T247] ? do_init_module (./include/linux/slab.h:991 (discriminator 1) kernel/module/main.c:3105 (discriminator 1)) [ 10.726706][ T247] ? kasan_unpoison (mm/kasan/shadow.c:146 mm/kasan/shadow.c:178) [ 10.726711][ T247] do_init_module (kernel/module/main.c:3117) [ 10.726714][ T247] ? lockdep_hardirqs_on (kernel/locking/lockdep.c:4488) [ 10.726718][ T247] ? free_module (./include/trace/events/module.h:50 (discriminator 19)) [ 10.726721][ T247] ? kfree (./include/linux/kasan.h:235 mm/slub.c:2748 mm/slub.c:6499 mm/slub.c:6792) [ 10.726725][ T247] load_module (kernel/module/main.c:3593) [ 10.726732][ T247] ? layout_and_allocate.isra.0 (kernel/module/main.c:3016) [ 10.726736][ T247] ? __ia32_sys_fsconfig (??:?) [ 10.726739][ T247] ? ovl_real_file (fs/overlayfs/file.c:195) [ 10.726743][ T247] ? backing_file_read_iter (fs/backing-file.c:211) [ 10.726746][ T247] ? rcu_lockdep_current_cpu_online (kernel/rcu/tree.c:4116 (discriminator 3) kernel/rcu/tree.c:4108 (discriminator 3)) [ 10.726749][ T247] init_module_from_file (kernel/module/main.c:3790) [ 10.726752][ T247] ? __do_sys_init_module (kernel/module/main.c:3664) [ 10.726760][ T247] ? __rwlock_init (kernel/locking/spinlock_debug.c:48) [ 10.726763][ T247] ? do_raw_spin_unlock (./include/linux/instrumented.h:82 ./include/linux/atomic/atomic-instrumented.h:32 ./include/asm-generic/qspinlock.h:58 kernel/locking/spinlock_debug.c:101 kernel/locking/spinlock_debug.c:141) [ 10.726766][ T247] idempotent_init_module (kernel/module/main.c:3802) [ 10.726770][ T247] ? init_module_from_file (kernel/module/main.c:3791) [ 10.726776][ T247] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 10.726778][ T247] ? cap_capable (./include/trace/events/capability.h:26 (discriminator 22) security/commoncap.c:130 (discriminator 22)) [ 10.726784][ T247] __x64_sys_finit_module (kernel/module/main.c:3828 kernel/module/main.c:3812 kernel/module/main.c:3812) [ 10.726786][ T247] ? trace_irq_enable.constprop.0 (./include/trace/events/preemptirq.h:40 (discriminator 22)) [ 10.726789][ T247] do_syscall_64 (arch/x86/entry/syscall_64.c:61 arch/x86/entry/syscall_64.c:84) [ 10.726791][ T247] ? exc_page_fault (arch/x86/mm/fault.c:1489 (discriminator 3) arch/x86/mm/fault.c:1536 (discriminator 3)) [ 10.726793][ T247] entry_SYSCALL_64_after_hwframe (arch/x86/entry/entry_64.S:121) [ 10.726796][ T247] RIP: 0033:0x7f8c7b38f37d [ 10.726799][ T247] Code: ff c3 66 2e 0f 1f 84 00 00 00 00 00 90 f3 0f 1e fa 48 89 f8 48 89 f7 48 89 d6 48 89 ca 4d 89 c2 4d 89 c8 4c 8b 4c 24 08 0f 05 <48> 3d 01 f0 ff ff 73 01 c3 48 8b 0d 4b aa 0f 00 f7 d8 64 89 01 48 All code ======== 0: ff c3 inc %ebx 2: 66 2e 0f 1f 84 00 00 cs nopw 0x0(%rax,%rax,1) 9: 00 00 00 c: 90 nop d: f3 0f 1e fa endbr64 11: 48 89 f8 mov %rdi,%rax 14: 48 89 f7 mov %rsi,%rdi 17: 48 89 d6 mov %rdx,%rsi 1a: 48 89 ca mov %rcx,%rdx 1d: 4d 89 c2 mov %r8,%r10 20: 4d 89 c8 mov %r9,%r8 23: 4c 8b 4c 24 08 mov 0x8(%rsp),%r9 28: 0f 05 syscall 2a:* 48 3d 01 f0 ff ff cmp $0xfffffffffffff001,%rax <-- trapping instruction 30: 73 01 jae 0x33 32: c3 ret 33: 48 8b 0d 4b aa 0f 00 mov 0xfaa4b(%rip),%rcx # 0xfaa85 3a: f7 d8 neg %eax 3c: 64 89 01 mov %eax,%fs:(%rcx) 3f: 48 rex.W Code starting with the faulting instruction =========================================== 0: 48 3d 01 f0 ff ff cmp $0xfffffffffffff001,%rax 6: 73 01 jae 0x9 8: c3 ret 9: 48 8b 0d 4b aa 0f 00 mov 0xfaa4b(%rip),%rcx # 0xfaa5b 10: f7 d8 neg %eax 12: 64 89 01 mov %eax,%fs:(%rcx) 15: 48 rex.W [ 10.726801][ T247] RSP: 002b:00007ffeb7894e98 EFLAGS: 00000246 ORIG_RAX: 0000000000000139 [ 10.726803][ T247] RAX: ffffffffffffffda RBX: 0000559cb10a4810 RCX: 00007f8c7b38f37d [ 10.726805][ T247] RDX: 0000000000000000 RSI: 0000559c7a165ffd RDI: 0000000000000000 [ 10.726805][ T247] RBP: 00007ffeb7894f30 R08: 0000000000000000 R09: 0000000000000000 [ 10.726806][ T247] R10: 0000000000000000 R11: 0000000000000246 R12: 0000559c7a165ffd [ 10.726807][ T247] R13: 0000559cb10a4960 R14: 0000000000040000 R15: 0000000000000000 | [ 11.910185][ T317] softirqs last disabled at (27575): __irq_exit_rcu (kernel/softirq.c:679 kernel/softirq.c:519 kernel/softirq.c:767) | [ 11.910188][ T317] Preemption disabled at: | [ 11.910188][ T317] vprintk_emit (kernel/printk/printk.c:2471) | [ 11.910200][ T317] Tainted: [W]=WARN [ 11.910201][ T317] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 11.910204][ T317] Call Trace: [ 11.910205][ T317] [ 11.910207][ T317] dump_stack_lvl (lib/dump_stack.c:94 lib/dump_stack.c:120) [ 11.910213][ T317] ? vprintk_emit (kernel/printk/printk.c:2471) [ 11.910215][ T317] __might_resched.cold (kernel/sched/core.c:9234) [ 11.910219][ T317] ? perf_trace_sched_switch (./include/linux/list.h:1037 (discriminator 3)) [ 11.910223][ T317] ? __kmalloc_noprof (./include/linux/sched/mm.h:317 mm/slub.c:4636 mm/slub.c:4974 mm/slub.c:5413 mm/slub.c:5439) [ 11.910231][ T317] __kmalloc_noprof (./include/linux/sched/mm.h:322 (discriminator 2) mm/slub.c:4636 (discriminator 2) mm/slub.c:4974 (discriminator 2) mm/slub.c:5413 (discriminator 2) mm/slub.c:5439 (discriminator 2)) [ 11.910235][ T317] ? alloc_buf.isra.0 (./include/linux/slab.h:995 drivers/char/virtio_console.c:429) [ 11.910241][ T317] ? do_raw_spin_unlock (./include/linux/instrumented.h:82 ./include/linux/atomic/atomic-instrumented.h:32 ./include/asm-generic/qspinlock.h:58 kernel/locking/spinlock_debug.c:101 kernel/locking/spinlock_debug.c:141) [ 11.910245][ T317] alloc_buf.isra.0 (./include/linux/slab.h:995 drivers/char/virtio_console.c:429) [ 11.910248][ T317] put_chars (drivers/char/virtio_console.c:1176) [ 11.910250][ T317] ? desc_read_finalized_seq (kernel/printk/printk_ringbuffer.c:1934) [ 11.910252][ T317] ? __send_to_port (drivers/char/virtio_console.c:654) [ 11.910256][ T317] ? rcu_read_lock_any_held (./include/linux/lockdep.h:249 kernel/rcu/update.c:386 kernel/rcu/update.c:380) [ 11.910261][ T317] ? validate_chain (kernel/locking/lockdep.c:3817 (discriminator 2) kernel/locking/lockdep.c:3837 (discriminator 2) kernel/locking/lockdep.c:3892 (discriminator 2)) [ 11.910267][ T317] hvc_console_print (drivers/tty/hvc/hvc_console.c:177 (discriminator 2)) [ 11.910269][ T317] ? __lock_acquire (kernel/locking/lockdep.c:5254) [ 11.910271][ T317] ? __lock_acquire (kernel/locking/lockdep.c:5254) [ 11.910276][ T317] ? hvc_write (drivers/tty/hvc/hvc_console.c:501) [ 11.910277][ T317] ? console_emit_next_record (kernel/printk/printk.c:3095 (discriminator 2) kernel/printk/printk.c:3182 (discriminator 2)) [ 11.910280][ T317] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 11.910283][ T317] ? lock_acquire (./include/trace/events/lock.h:23 (discriminator 22) kernel/locking/lockdep.c:5871 (discriminator 22)) [ 11.910289][ T317] console_emit_next_record (kernel/printk/printk.c:3183) [ 11.910295][ T317] ? devkmsg_read (./arch/x86/include/asm/atomic64_64.h:20) [ 11.910298][ T317] ? console_flush_one_record (./include/linux/rcupdate.h:314 (discriminator 2) ./include/linux/srcu.h:439 (discriminator 2) kernel/printk/printk.c:291 (discriminator 2) kernel/printk/printk.c:3246 (discriminator 2)) [ 11.910301][ T317] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 11.910303][ T317] ? lock_acquire (./include/trace/events/lock.h:23 (discriminator 22) kernel/locking/lockdep.c:5871 (discriminator 22)) [ 11.910307][ T317] console_flush_one_record (kernel/printk/printk.c:3268) [ 11.910312][ T317] ? console_emit_next_record (kernel/printk/printk.c:3150) [ 11.910313][ T317] ? __lock_acquire (kernel/locking/lockdep.c:5254) [ 11.910320][ T317] console_unlock (kernel/printk/printk.c:3350 kernel/printk/printk.c:3380 kernel/printk/printk.c:3420) [ 11.910324][ T317] ? console_flush_one_record (kernel/printk/printk.c:3316) [ 11.910327][ T317] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 11.910330][ T317] ? lock_acquire (kernel/locking/lockdep.c:5913) [ 11.910333][ T317] ? __down_trylock_console_sem (kernel/printk/printk.c:334) [ 11.910335][ T317] ? vprintk_emit (kernel/printk/printk.c:2478) [ 11.910338][ T317] vprintk_emit (kernel/printk/printk.c:2479) [ 11.910343][ T317] ? wake_up_klogd_work_func (kernel/printk/printk.c:4603 (discriminator 126)) [ 11.910348][ T317] ? gact_cleanup_module (net/sched/act_gact.c:192) act_gact [ 11.910353][ T317] _printk (kernel/printk/printk.c:2504) [ 11.910358][ T317] ? snapshot_read.cold (user.c:?) [ 11.910364][ T317] ? do_one_initcall (./include/linux/instrumented.h:82 ./include/asm-generic/bitops/instrumented-non-atomic.h:141 ./include/linux/cpumask.h:650 ./include/linux/cpumask.h:1232 ./include/trace/events/initcall.h:27 init/main.c:1356) [ 11.910367][ T317] gact_init_module (net/sched/act_gact.c:180) act_gact [ 11.910370][ T317] do_one_initcall (init/main.c:1357) [ 11.910372][ T317] ? trace_event_raw_event_initcall_level (./include/trace/events/initcall.h:10) [ 11.910377][ T317] ? do_init_module (./include/linux/slab.h:991 (discriminator 1) kernel/module/main.c:3105 (discriminator 1)) [ 11.910381][ T317] ? kasan_unpoison (mm/kasan/shadow.c:146 mm/kasan/shadow.c:178) [ 11.910389][ T317] do_init_module (kernel/module/main.c:3117) [ 11.910393][ T317] ? lockdep_hardirqs_on (kernel/locking/lockdep.c:4488) [ 11.910397][ T317] ? free_module (./include/trace/events/module.h:50 (discriminator 19)) [ 11.910401][ T317] ? kfree (./include/linux/kasan.h:235 mm/slub.c:2748 mm/slub.c:6499 mm/slub.c:6792) [ 11.910405][ T317] load_module (kernel/module/main.c:3593) [ 11.910414][ T317] ? layout_and_allocate.isra.0 (kernel/module/main.c:3016) [ 11.910420][ T317] ? __ia32_sys_fsconfig (??:?) [ 11.910423][ T317] ? ovl_real_file (fs/overlayfs/file.c:195) [ 11.910427][ T317] ? backing_file_read_iter (fs/backing-file.c:211) [ 11.910430][ T317] ? rcu_lockdep_current_cpu_online (kernel/rcu/tree.c:4116 (discriminator 3) kernel/rcu/tree.c:4108 (discriminator 3)) [ 11.910434][ T317] init_module_from_file (kernel/module/main.c:3790) [ 11.910438][ T317] ? __do_sys_init_module (kernel/module/main.c:3664) [ 11.910450][ T317] ? __rwlock_init (kernel/locking/spinlock_debug.c:48) [ 11.910454][ T317] ? do_raw_spin_unlock (./include/linux/instrumented.h:82 ./include/linux/atomic/atomic-instrumented.h:32 ./include/asm-generic/qspinlock.h:58 kernel/locking/spinlock_debug.c:101 kernel/locking/spinlock_debug.c:141) [ 11.910458][ T317] idempotent_init_module (kernel/module/main.c:3802) [ 11.910461][ T317] ? init_module_from_file (kernel/module/main.c:3791) [ 11.910467][ T317] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 11.910470][ T317] ? cap_capable (./include/trace/events/capability.h:26 (discriminator 22) security/commoncap.c:130 (discriminator 22)) [ 11.910479][ T317] __x64_sys_finit_module (kernel/module/main.c:3828 kernel/module/main.c:3812 kernel/module/main.c:3812) [ 11.910482][ T317] ? trace_irq_enable.constprop.0 (./include/trace/events/preemptirq.h:40 (discriminator 22)) [ 11.910486][ T317] do_syscall_64 (arch/x86/entry/syscall_64.c:61 arch/x86/entry/syscall_64.c:84) [ 11.910488][ T317] ? exc_page_fault (arch/x86/mm/fault.c:1489 (discriminator 3) arch/x86/mm/fault.c:1536 (discriminator 3)) [ 11.910491][ T317] entry_SYSCALL_64_after_hwframe (arch/x86/entry/entry_64.S:121) [ 11.910493][ T317] RIP: 0033:0x7fae7c4cd37d [ 11.910496][ T317] Code: ff c3 66 2e 0f 1f 84 00 00 00 00 00 90 f3 0f 1e fa 48 89 f8 48 89 f7 48 89 d6 48 89 ca 4d 89 c2 4d 89 c8 4c 8b 4c 24 08 0f 05 <48> 3d 01 f0 ff ff 73 01 c3 48 8b 0d 4b aa 0f 00 f7 d8 64 89 01 48 All code ======== 0: ff c3 inc %ebx 2: 66 2e 0f 1f 84 00 00 cs nopw 0x0(%rax,%rax,1) 9: 00 00 00 c: 90 nop d: f3 0f 1e fa endbr64 11: 48 89 f8 mov %rdi,%rax 14: 48 89 f7 mov %rsi,%rdi 17: 48 89 d6 mov %rdx,%rsi 1a: 48 89 ca mov %rcx,%rdx 1d: 4d 89 c2 mov %r8,%r10 20: 4d 89 c8 mov %r9,%r8 23: 4c 8b 4c 24 08 mov 0x8(%rsp),%r9 28: 0f 05 syscall 2a:* 48 3d 01 f0 ff ff cmp $0xfffffffffffff001,%rax <-- trapping instruction 30: 73 01 jae 0x33 32: c3 ret 33: 48 8b 0d 4b aa 0f 00 mov 0xfaa4b(%rip),%rcx # 0xfaa85 3a: f7 d8 neg %eax 3c: 64 89 01 mov %eax,%fs:(%rcx) 3f: 48 rex.W Code starting with the faulting instruction =========================================== 0: 48 3d 01 f0 ff ff cmp $0xfffffffffffff001,%rax 6: 73 01 jae 0x9 8: c3 ret 9: 48 8b 0d 4b aa 0f 00 mov 0xfaa4b(%rip),%rcx # 0xfaa5b 10: f7 d8 neg %eax 12: 64 89 01 mov %eax,%fs:(%rcx) 15: 48 rex.W [ 11.910498][ T317] RSP: 002b:00007ffca44ee2e8 EFLAGS: 00000246 ORIG_RAX: 0000000000000139 [ 11.910501][ T317] RAX: ffffffffffffffda RBX: 0000557e6d2e3810 RCX: 00007fae7c4cd37d [ 11.910503][ T317] RDX: 0000000000000000 RSI: 0000557e6011effd RDI: 0000000000000000 [ 11.910504][ T317] RBP: 00007ffca44ee380 R08: 0000000000000000 R09: 0000000000000000 [ 11.910506][ T317] R10: 0000000000000000 R11: 0000000000000246 R12: 0000557e6011effd [ 11.910508][ T317] R13: 0000557e6d2e3960 R14: 0000000000040000 R15: 0000000000000000 | [ 12.941700][ T400] softirqs last disabled at (11587): __irq_exit_rcu (kernel/softirq.c:679 kernel/softirq.c:519 kernel/softirq.c:767) | [ 12.941703][ T400] Preemption disabled at: | [ 12.941704][ T400] vprintk_emit (kernel/printk/printk.c:2471) | [ 12.941713][ T400] Tainted: [W]=WARN [ 12.941714][ T400] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 12.941716][ T400] Call Trace: [ 12.941717][ T400] [ 12.941719][ T400] dump_stack_lvl (lib/dump_stack.c:94 lib/dump_stack.c:120) [ 12.941725][ T400] ? vprintk_emit (kernel/printk/printk.c:2471) [ 12.941727][ T400] __might_resched.cold (kernel/sched/core.c:9234) [ 12.941732][ T400] ? perf_trace_sched_switch (./include/linux/list.h:1037 (discriminator 3)) [ 12.941736][ T400] ? __kmalloc_noprof (./include/linux/sched/mm.h:317 mm/slub.c:4636 mm/slub.c:4974 mm/slub.c:5413 mm/slub.c:5439) [ 12.941741][ T400] __kmalloc_noprof (./include/linux/sched/mm.h:322 (discriminator 2) mm/slub.c:4636 (discriminator 2) mm/slub.c:4974 (discriminator 2) mm/slub.c:5413 (discriminator 2) mm/slub.c:5439 (discriminator 2)) [ 12.941743][ T400] ? alloc_buf.isra.0 (./include/linux/slab.h:995 drivers/char/virtio_console.c:429) [ 12.941749][ T400] ? do_raw_spin_unlock (./include/linux/instrumented.h:82 ./include/linux/atomic/atomic-instrumented.h:32 ./include/asm-generic/qspinlock.h:58 kernel/locking/spinlock_debug.c:101 kernel/locking/spinlock_debug.c:141) [ 12.941752][ T400] alloc_buf.isra.0 (./include/linux/slab.h:995 drivers/char/virtio_console.c:429) [ 12.941755][ T400] put_chars (drivers/char/virtio_console.c:1176) [ 12.941757][ T400] ? prb_final_commit (kernel/printk/printk_ringbuffer.c:1842) [ 12.941760][ T400] ? __send_to_port (drivers/char/virtio_console.c:654) [ 12.941763][ T400] ? rcu_lockdep_current_cpu_online (kernel/rcu/tree.c:4116 (discriminator 3) kernel/rcu/tree.c:4108 (discriminator 3)) [ 12.941767][ T400] ? rcu_read_lock_any_held (./include/linux/lockdep.h:249 kernel/rcu/update.c:386 kernel/rcu/update.c:380) [ 12.941770][ T400] ? validate_chain (kernel/locking/lockdep.c:3817 (discriminator 2) kernel/locking/lockdep.c:3837 (discriminator 2) kernel/locking/lockdep.c:3892 (discriminator 2)) [ 12.941773][ T400] hvc_console_print (drivers/tty/hvc/hvc_console.c:177 (discriminator 2)) [ 12.941777][ T400] ? mark_usage (kernel/locking/lockdep.c:4690) [ 12.941778][ T400] ? __lock_acquire (kernel/locking/lockdep.c:5254) [ 12.941780][ T400] ? __lock_acquire (kernel/locking/lockdep.c:5254) [ 12.941784][ T400] ? hvc_write (drivers/tty/hvc/hvc_console.c:501) [ 12.941786][ T400] ? console_emit_next_record (kernel/printk/printk.c:3095 (discriminator 2) kernel/printk/printk.c:3182 (discriminator 2)) [ 12.941790][ T400] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 12.941792][ T400] ? lock_acquire (./include/trace/events/lock.h:23 (discriminator 22) kernel/locking/lockdep.c:5871 (discriminator 22)) [ 12.941796][ T400] console_emit_next_record (kernel/printk/printk.c:3183) [ 12.941800][ T400] ? devkmsg_read (./arch/x86/include/asm/atomic64_64.h:20) [ 12.941802][ T400] ? console_flush_one_record (./include/linux/rcupdate.h:314 (discriminator 2) ./include/linux/srcu.h:439 (discriminator 2) kernel/printk/printk.c:291 (discriminator 2) kernel/printk/printk.c:3246 (discriminator 2)) [ 12.941805][ T400] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 12.941808][ T400] ? lock_acquire (./include/trace/events/lock.h:23 (discriminator 22) kernel/locking/lockdep.c:5871 (discriminator 22)) [ 12.941812][ T400] console_flush_one_record (kernel/printk/printk.c:3268) [ 12.941816][ T400] ? console_emit_next_record (kernel/printk/printk.c:3150) [ 12.941818][ T400] ? __lock_acquire (kernel/locking/lockdep.c:5254) [ 12.941823][ T400] console_unlock (kernel/printk/printk.c:3350 kernel/printk/printk.c:3380 kernel/printk/printk.c:3420) [ 12.941826][ T400] ? console_flush_one_record (kernel/printk/printk.c:3316) [ 12.941828][ T400] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 12.941831][ T400] ? lock_acquire (kernel/locking/lockdep.c:5913) [ 12.941834][ T400] ? __down_trylock_console_sem (kernel/printk/printk.c:334) [ 12.941836][ T400] ? vprintk_emit (kernel/printk/printk.c:2478) [ 12.941840][ T400] vprintk_emit (kernel/printk/printk.c:2479) [ 12.941844][ T400] ? wake_up_klogd_work_func (kernel/printk/printk.c:4603 (discriminator 126)) [ 12.941846][ T400] ? __lock_release.isra.0 (kernel/locking/lockdep.c:5554) [ 12.941851][ T400] _printk (kernel/printk/printk.c:2504) [ 12.941855][ T400] ? snapshot_read.cold (user.c:?) [ 12.941859][ T400] ? br_multicast_flood (??:?) bridge [ 12.941872][ T400] ? do_setlink.isra.0 (net/core/rtnetlink.c:3273 (discriminator 1)) [ 12.941874][ T400] ? rtnl_newlink (net/core/rtnetlink.c:4215) [ 12.941875][ T400] ? rtnetlink_rcv_msg (net/core/rtnetlink.c:7132) [ 12.941879][ T400] br_set_state (net/bridge/br_stp.c:57 (discriminator 2)) bridge [ 12.941891][ T400] br_init_port (net/bridge/br_stp_if.c:39) bridge [ 12.941900][ T400] new_nbp (net/bridge/br_if.c:449) bridge [ 12.941909][ T400] br_add_if (net/bridge/br_if.c:592) bridge [ 12.941917][ T400] ? is_bpf_text_address (./include/linux/rcupdate.h:882 kernel/bpf/core.c:751) [ 12.941921][ T400] ? kernel_text_address (kernel/extable.c:125 kernel/extable.c:94) [ 12.941924][ T400] ? __kernel_text_address (kernel/extable.c:79) [ 12.941928][ T400] do_set_master (net/core/rtnetlink.c:3071) [ 12.941932][ T400] do_setlink.isra.0 (net/core/rtnetlink.c:3273 (discriminator 1)) [ 12.941936][ T400] ? stack_trace_save (kernel/stacktrace.c:122 (discriminator 1)) [ 12.941939][ T400] ? rtnl_link_get_size (net/core/rtnetlink.c:747) [ 12.941940][ T400] ? rcu_read_lock_any_held (./include/linux/lockdep.h:249 kernel/rcu/update.c:388 kernel/rcu/update.c:380) [ 12.941942][ T400] ? stack_depot_save_flags (lib/stackdepot.c:609 (discriminator 2) lib/stackdepot.c:676 (discriminator 2)) [ 12.941946][ T400] ? rcu_lockdep_current_cpu_online (kernel/rcu/tree.c:4116 (discriminator 3) kernel/rcu/tree.c:4108 (discriminator 3)) [ 12.941948][ T400] ? rcu_read_lock_any_held (./include/linux/lockdep.h:249 kernel/rcu/update.c:386 kernel/rcu/update.c:380) [ 12.941950][ T400] ? validate_chain (kernel/locking/lockdep.c:3817 (discriminator 2) kernel/locking/lockdep.c:3837 (discriminator 2) kernel/locking/lockdep.c:3892 (discriminator 2)) [ 12.941953][ T400] ? kasan_save_stack (mm/kasan/common.c:58) [ 12.941956][ T400] ? kasan_save_stack (mm/kasan/common.c:57) [ 12.941957][ T400] ? kasan_save_track (mm/kasan/common.c:78) [ 12.941960][ T400] ? __lock_acquire (kernel/locking/lockdep.c:5254) [ 12.941962][ T400] ? netlink_seq_next (net/netlink/af_netlink.c:2685) [ 12.941965][ T400] ? ___sys_sendmsg (net/socket.c:2757) [ 12.941970][ T400] ? lock_acquire.part.0 (kernel/locking/lockdep.c:5908 (discriminator 2)) [ 12.941972][ T400] ? rtnl_newlink (net/core/rtnetlink.c:80 net/core/rtnetlink.c:366 net/core/rtnetlink.c:4214) [ 12.941974][ T400] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 12.941977][ T400] ? lock_acquire (./include/trace/events/lock.h:23 (discriminator 22) kernel/locking/lockdep.c:5871 (discriminator 22)) [ 12.941978][ T400] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 12.941980][ T400] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 12.941983][ T400] ? trace_contention_end (./include/trace/events/lock.h:121 (discriminator 22)) [ 12.941987][ T400] ? __mutex_lock (./include/linux/instrumented.h:82 ./include/linux/atomic/atomic-instrumented.h:3188 kernel/locking/mutex.c:89 kernel/locking/mutex.c:134 kernel/locking/mutex.c:649 kernel/locking/mutex.c:821) [ 12.941990][ T400] ? __mutex_lock (kernel/locking/mutex.c:656 (discriminator 1) kernel/locking/mutex.c:821 (discriminator 1)) [ 12.941992][ T400] ? rtnl_newlink (net/core/rtnetlink.c:80 net/core/rtnetlink.c:366 net/core/rtnetlink.c:4214) [ 12.941995][ T400] ? ww_mutex_lock (kernel/locking/mutex.c:934) [ 12.941997][ T400] ? nla_get_range_signed (lib/nlattr.c:270) [ 12.942002][ T400] ? __rtnl_newlink (net/core/rtnetlink.c:4063) [ 12.942007][ T400] rtnl_newlink (net/core/rtnetlink.c:4215) [ 12.942013][ T400] ? rtnl_bridge_getlink (net/core/rtnetlink.c:5558) [ 12.942015][ T400] ? __lock_acquire (kernel/locking/lockdep.c:5254) [ 12.942019][ T400] ? lock_acquire.part.0 (kernel/locking/lockdep.c:5908 (discriminator 2)) [ 12.942021][ T400] ? find_held_lock (kernel/locking/lockdep.c:5367) [ 12.942023][ T400] ? rtnl_bridge_getlink (net/core/rtnetlink.c:5558) [ 12.942025][ T400] ? __lock_release.isra.0 (kernel/locking/lockdep.c:5554) [ 12.942029][ T400] ? rtnl_bridge_getlink (net/core/rtnetlink.c:5558) [ 12.942031][ T400] rtnetlink_rcv_msg (net/core/rtnetlink.c:7132) [ 12.942034][ T400] ? rtnl_link_fill (./include/net/netlink.h:1107 (discriminator 1)) [ 12.942035][ T400] ? __lock_acquire (kernel/locking/lockdep.c:5254) [ 12.942040][ T400] ? lock_acquire.part.0 (kernel/locking/lockdep.c:5908 (discriminator 2)) [ 12.942042][ T400] ? find_held_lock (kernel/locking/lockdep.c:5367) [ 12.942045][ T400] netlink_rcv_skb (net/netlink/af_netlink.c:2556) [ 12.942047][ T400] ? rtnl_link_fill (./include/net/netlink.h:1107 (discriminator 1)) [ 12.942050][ T400] ? netlink_ack (./include/linux/skbuff.h:2718) [ 12.942061][ T400] ? netlink_deliver_tap (./include/linux/rcupdate.h:319 (discriminator 2) ./include/linux/rcupdate.h:880 (discriminator 2) ./include/net/netns/generic.h:48 (discriminator 2) net/netlink/af_netlink.c:334 (discriminator 2)) [ 12.942062][ T400] ? netlink_deliver_tap (./include/linux/rcupdate.h:319 (discriminator 2) ./include/linux/rcupdate.h:880 (discriminator 2) net/netlink/af_netlink.c:341 (discriminator 2)) [ 12.942067][ T400] netlink_unicast (net/netlink/af_netlink.c:1319 net/netlink/af_netlink.c:1345) [ 12.942071][ T400] ? netlink_attachskb (./arch/x86/include/asm/bitops.h:202 (discriminator 1)) [ 12.942073][ T400] ? __lock_acquire (kernel/locking/lockdep.c:5254) [ 12.942077][ T400] netlink_sendmsg (net/netlink/af_netlink.c:1900) [ 12.942081][ T400] ? netlink_unicast (./include/net/net_namespace.h:422 (discriminator 7)) [ 12.942085][ T400] ? __might_fault (mm/memory.c:7482 (discriminator 5)) [ 12.942091][ T400] ____sys_sendmsg (net/socket.c:800 (discriminator 4) net/socket.c:815 (discriminator 4) net/socket.c:2713 (discriminator 4)) [ 12.942093][ T400] ? copy_msghdr_from_user (net/socket.c:2650) [ 12.942095][ T400] ? get_timestamp.constprop.0 (./include/linux/netdevice.h:5399) [ 12.942097][ T400] ? move_addr_to_kernel (net/socket.c:258) [ 12.942104][ T400] ___sys_sendmsg (net/socket.c:2767) [ 12.942107][ T400] ? copy_msghdr_from_user (net/socket.c:2619) [ 12.942123][ T400] __sys_sendmsg (net/socket.c:2799) [ 12.942126][ T400] ? __sys_sendmsg_sock (net/socket.c:2780) [ 12.942132][ T400] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 12.942136][ T400] do_syscall_64 (arch/x86/entry/syscall_64.c:61 arch/x86/entry/syscall_64.c:84) [ 12.942138][ T400] ? exc_page_fault (arch/x86/mm/fault.c:1489 (discriminator 3) arch/x86/mm/fault.c:1536 (discriminator 3)) [ 12.942142][ T400] entry_SYSCALL_64_after_hwframe (arch/x86/entry/entry_64.S:121) [ 12.942144][ T400] RIP: 0033:0x7f96558b054e [ 12.942147][ T400] Code: 4d 89 d8 e8 b4 bd 00 00 4c 8b 5d f8 41 8b 93 08 03 00 00 59 5e 48 83 f8 fc 74 11 c9 c3 0f 1f 80 00 00 00 00 48 8b 45 10 0f 05 c3 83 e2 39 83 fa 08 75 e7 e8 03 ff ff ff 0f 1f 00 f3 0f 1e fa All code ======== 0: 4d 89 d8 mov %r11,%r8 3: e8 b4 bd 00 00 call 0xbdbc 8: 4c 8b 5d f8 mov -0x8(%rbp),%r11 c: 41 8b 93 08 03 00 00 mov 0x308(%r11),%edx 13: 59 pop %rcx 14: 5e pop %rsi 15: 48 83 f8 fc cmp $0xfffffffffffffffc,%rax 19: 74 11 je 0x2c 1b: c9 leave 1c: c3 ret 1d: 0f 1f 80 00 00 00 00 nopl 0x0(%rax) 24: 48 8b 45 10 mov 0x10(%rbp),%rax 28: 0f 05 syscall 2a:* c9 leave <-- trapping instruction 2b: c3 ret 2c: 83 e2 39 and $0x39,%edx 2f: 83 fa 08 cmp $0x8,%edx 32: 75 e7 jne 0x1b 34: e8 03 ff ff ff call 0xffffffffffffff3c 39: 0f 1f 00 nopl (%rax) 3c: f3 0f 1e fa endbr64 Code starting with the faulting instruction =========================================== 0: c9 leave 1: c3 ret 2: 83 e2 39 and $0x39,%edx 5: 83 fa 08 cmp $0x8,%edx 8: 75 e7 jne 0xfffffffffffffff1 a: e8 03 ff ff ff call 0xffffffffffffff12 f: 0f 1f 00 nopl (%rax) 12: f3 0f 1e fa endbr64 [ 12.942149][ T400] RSP: 002b:00007ffc3b9b8070 EFLAGS: 00000202 ORIG_RAX: 000000000000002e [ 12.942152][ T400] RAX: ffffffffffffffda RBX: 0000000000000004 RCX: 00007f96558b054e [ 12.942154][ T400] RDX: 0000000000000000 RSI: 00007ffc3b9b8120 RDI: 0000000000000005 [ 12.942155][ T400] RBP: 00007ffc3b9b8080 R08: 0000000000000000 R09: 0000000000000000 [ 12.942156][ T400] R10: 0000000000000000 R11: 0000000000000202 R12: 000000006a910a53 [ 12.942156][ T400] R13: 00000000004a1620 R14: 0000000000000000 R15: 00007ffc3b9b87e0 | [ 28.539356][ C0] softirqs last disabled at (2282181): __irq_exit_rcu (kernel/softirq.c:679 kernel/softirq.c:519 kernel/softirq.c:767) | [ 28.539357][ C0] Preemption disabled at: | [ 28.539358][ C0] schedule_preempt_disabled (kernel/sched/core.c:7420) | [ 28.539368][ C0] Tainted: [W]=WARN [ 28.539369][ C0] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 28.539371][ C0] Call Trace: [ 28.539372][ C0] [ 28.539374][ C0] dump_stack_lvl (lib/dump_stack.c:94 lib/dump_stack.c:120) [ 28.539379][ C0] ? schedule_preempt_disabled (kernel/sched/core.c:7420) [ 28.539381][ C0] __might_resched.cold (kernel/sched/core.c:9234) [ 28.539384][ C0] ? validate_chain (kernel/locking/lockdep.c:157 kernel/locking/lockdep.c:202 kernel/locking/lockdep.c:3329 kernel/locking/lockdep.c:3924) [ 28.539387][ C0] ? perf_trace_sched_switch (./include/linux/list.h:1037 (discriminator 3)) [ 28.539390][ C0] ? __asan_memcpy (mm/kasan/shadow.c:106 (discriminator 1)) [ 28.539393][ C0] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 28.539397][ C0] __kmalloc_noprof (./include/linux/sched/mm.h:322 (discriminator 2) mm/slub.c:4636 (discriminator 2) mm/slub.c:4974 (discriminator 2) mm/slub.c:5413 (discriminator 2) mm/slub.c:5439 (discriminator 2)) [ 28.539400][ C0] ? __rwlock_init (kernel/locking/spinlock_debug.c:48) [ 28.539401][ C0] ? alloc_buf.isra.0 (./include/linux/slab.h:995 drivers/char/virtio_console.c:429) [ 28.539405][ C0] ? do_raw_spin_unlock (./include/linux/instrumented.h:82 ./include/linux/atomic/atomic-instrumented.h:32 ./include/asm-generic/qspinlock.h:58 kernel/locking/spinlock_debug.c:101 kernel/locking/spinlock_debug.c:141) [ 28.539406][ C0] alloc_buf.isra.0 (./include/linux/slab.h:995 drivers/char/virtio_console.c:429) [ 28.539409][ C0] put_chars (drivers/char/virtio_console.c:1176) [ 28.539411][ C0] ? __send_to_port (drivers/char/virtio_console.c:654) [ 28.539412][ C0] ? console_prepend_replay (kernel/printk/printk.c:3005) [ 28.539416][ C0] hvc_console_print (drivers/tty/hvc/hvc_console.c:177 (discriminator 2)) [ 28.539420][ C0] ? hvc_write (drivers/tty/hvc/hvc_console.c:501) [ 28.539422][ C0] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 28.539425][ C0] ? lock_acquire (./include/trace/events/lock.h:23 (discriminator 22) kernel/locking/lockdep.c:5871 (discriminator 22)) [ 28.539428][ C0] console_emit_next_record (kernel/printk/printk.c:3183) [ 28.539431][ C0] ? devkmsg_read (./arch/x86/include/asm/atomic64_64.h:20) [ 28.539433][ C0] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 28.539434][ C0] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 28.539436][ C0] ? lock_acquire (./include/trace/events/lock.h:23 (discriminator 22) kernel/locking/lockdep.c:5871 (discriminator 22)) [ 28.539438][ C0] ? console_flush_one_record (kernel/printk/printk.c:3247) [ 28.539440][ C0] console_flush_one_record (kernel/printk/printk.c:3268) [ 28.539442][ C0] ? console_emit_next_record (kernel/printk/printk.c:3150) [ 28.539444][ C0] console_unlock (kernel/printk/printk.c:3350 kernel/printk/printk.c:3380 kernel/printk/printk.c:3420) [ 28.539446][ C0] ? lock_acquire (./include/trace/events/lock.h:23 (discriminator 22) kernel/locking/lockdep.c:5871 (discriminator 22)) [ 28.539448][ C0] ? console_flush_one_record (kernel/printk/printk.c:3316) [ 28.539449][ C0] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 28.539451][ C0] ? lock_release (./include/trace/events/lock.h:68 (discriminator 22) kernel/locking/lockdep.c:5920 (discriminator 22)) [ 28.539452][ C0] ? lock_acquire (kernel/locking/lockdep.c:5913) [ 28.539454][ C0] ? __down_trylock_console_sem (kernel/printk/printk.c:334) [ 28.539456][ C0] ? vprintk_emit (kernel/printk/printk.c:2478) [ 28.539457][ C0] vprintk_emit (kernel/printk/printk.c:2479) [ 28.539460][ C0] ? wake_up_klogd_work_func (kernel/printk/printk.c:4603 (discriminator 126)) [ 28.539461][ C0] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 28.539463][ C0] ? lock_release (./include/trace/events/lock.h:68 (discriminator 22) kernel/locking/lockdep.c:5920 (discriminator 22)) [ 28.539465][ C0] ? x86_64_start_kernel (arch/x86/kernel/head64.c:264) [ 28.539469][ C0] _printk (kernel/printk/printk.c:2504) [ 28.539472][ C0] ? snapshot_read.cold (user.c:?) [ 28.539474][ C0] ? arch_stack_walk (arch/x86/kernel/stacktrace.c:25) [ 28.539478][ C0] ? rcu_lockdep_current_cpu_online (kernel/rcu/tree.c:4116 (discriminator 3) kernel/rcu/tree.c:4108 (discriminator 3)) [ 28.539480][ C0] ? nbcon_cpu_emergency_enter (./include/linux/instrumented.h:112 ./include/linux/atomic/atomic-instrumented.h:435 kernel/printk/nbcon.c:1723) [ 28.539482][ C0] print_irq_inversion_bug.part.0 (kernel/locking/lockdep.c:4097 (discriminator 1)) [ 28.539484][ C0] mark_lock_irq (kernel/locking/lockdep.c:4095 kernel/locking/lockdep.c:4174 kernel/locking/lockdep.c:4310) [ 28.539487][ C0] mark_lock (kernel/locking/lockdep.c:4769) [ 28.539489][ C0] mark_usage (kernel/locking/lockdep.c:4658) [ 28.539490][ C0] __lock_acquire (kernel/locking/lockdep.c:5208) [ 28.539493][ C0] lock_acquire.part.0 (kernel/locking/lockdep.c:5908 (discriminator 2)) [ 28.539494][ C0] ? br_forward_delay_timer_expired (./include/linux/spinlock.h:347 net/bridge/br_stp_timer.c:88) bridge [ 28.539507][ C0] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 28.539509][ C0] ? lock_acquire (./include/trace/events/lock.h:23 (discriminator 22) kernel/locking/lockdep.c:5871 (discriminator 22)) [ 28.539510][ C0] ? br_message_age_timer_expired (net/bridge/br_stp_timer.c:54) bridge [ 28.539517][ C0] _raw_spin_lock (./include/linux/spinlock_api_smp.h:190 (discriminator 1) kernel/locking/spinlock.c:173 (discriminator 1)) [ 28.539519][ C0] ? br_forward_delay_timer_expired (./include/linux/spinlock.h:347 net/bridge/br_stp_timer.c:88) bridge [ 28.539526][ C0] br_forward_delay_timer_expired (./include/linux/spinlock.h:347 net/bridge/br_stp_timer.c:88) bridge [ 28.539532][ C0] ? br_message_age_timer_expired (net/bridge/br_stp_timer.c:54) bridge [ 28.539540][ C0] call_timer_fn (kernel/time/timer.c:1748) [ 28.539543][ C0] ? detach_if_pending (./include/linux/list.h:1159) [ 28.539545][ C0] ? debug_object_active_state (lib/debugobjects.c:1122) [ 28.539548][ C0] ? find_held_lock (kernel/locking/lockdep.c:5367) [ 28.539550][ C0] ? __lock_release.isra.0 (kernel/locking/lockdep.c:5554) [ 28.539551][ C0] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 28.539554][ C0] __run_timers (kernel/time/timer.c:1799 kernel/time/timer.c:2374) [ 28.539555][ C0] ? br_message_age_timer_expired (net/bridge/br_stp_timer.c:54) bridge [ 28.539562][ C0] ? __bpf_trace_itimer_expire (./include/trace/events/timer.h:407) [ 28.539564][ C0] ? __lock_acquire (kernel/locking/lockdep.c:5254) [ 28.539566][ C0] ? __rwlock_init (kernel/locking/spinlock_debug.c:48) [ 28.539569][ C0] run_timer_softirq (kernel/time/timer.c:2386 kernel/time/timer.c:2395 kernel/time/timer.c:2403) [ 28.539571][ C0] ? __run_timers (./include/trace/events/timer.h:138 (discriminator 19)) [ 28.539572][ C0] ? trace_irq_enable.constprop.0 (./include/trace/events/preemptirq.h:40 (discriminator 22)) [ 28.539574][ C0] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 28.539576][ C0] handle_softirqs (kernel/softirq.c:645) [ 28.539578][ C0] ? __lock_release.isra.0 (kernel/locking/lockdep.c:5554) [ 28.539579][ C0] ? _local_bh_enable (kernel/softirq.c:428 (discriminator 1)) [ 28.539581][ C0] __irq_exit_rcu (kernel/softirq.c:679 kernel/softirq.c:519 kernel/softirq.c:767) [ 28.539583][ C0] irq_exit_rcu (kernel/softirq.c:784) [ 28.539584][ C0] sysvec_apic_timer_interrupt (arch/x86/kernel/apic/apic.c:1062 (discriminator 37) arch/x86/kernel/apic/apic.c:1062 (discriminator 37)) [ 28.539587][ C0] [ 28.539588][ C0] [ 28.539588][ C0] ? lockdep_hardirqs_on_prepare.part.0 (kernel/locking/lockdep.c:470 (discriminator 2) kernel/locking/lockdep.c:4427 (discriminator 2)) [ 28.539590][ C0] asm_sysvec_apic_timer_interrupt (./arch/x86/include/asm/idtentry.h:674) [ 28.539593][ C0] RIP: 0010:pv_native_safe_halt (./arch/x86/include/asm/irqflags.h:48 arch/x86/kernel/paravirt.c:63) [ 28.539595][ C0] Code: 48 8b 3d 94 e2 f5 01 e8 1f 00 00 00 48 2b 05 58 a3 95 00 c3 0f 1f 80 00 00 00 00 f3 0f 1e fa eb 07 0f 00 2d 13 96 11 00 fb f4 0f 1f 40 d6 48 83 ec 20 8b 17 49 89 f8 83 e2 fe 41 89 d2 0f 01 All code ======== 0: 48 8b 3d 94 e2 f5 01 mov 0x1f5e294(%rip),%rdi # 0x1f5e29b 7: e8 1f 00 00 00 call 0x2b c: 48 2b 05 58 a3 95 00 sub 0x95a358(%rip),%rax # 0x95a36b 13: c3 ret 14: 0f 1f 80 00 00 00 00 nopl 0x0(%rax) 1b: f3 0f 1e fa endbr64 1f: eb 07 jmp 0x28 21: 0f 00 2d 13 96 11 00 verw 0x119613(%rip) # 0x11963b 28: fb sti 29: f4 hlt 2a:* c3 ret <-- trapping instruction 2b: 0f 1f 40 d6 nopl -0x2a(%rax) 2f: 48 83 ec 20 sub $0x20,%rsp 33: 8b 17 mov (%rdi),%edx 35: 49 89 f8 mov %rdi,%r8 38: 83 e2 fe and $0xfffffffe,%edx 3b: 41 89 d2 mov %edx,%r10d 3e: 0f .byte 0xf 3f: 01 .byte 0x1 Code starting with the faulting instruction =========================================== 0: c3 ret 1: 0f 1f 40 d6 nopl -0x2a(%rax) 5: 48 83 ec 20 sub $0x20,%rsp 9: 8b 17 mov (%rdi),%edx b: 49 89 f8 mov %rdi,%r8 e: 83 e2 fe and $0xfffffffe,%edx 11: 41 89 d2 mov %edx,%r10d 14: 0f .byte 0xf 15: 01 .byte 0x1 [ 28.539597][ C0] RSP: 0018:ffffffff8f607cf8 EFLAGS: 00000296 [ 28.539600][ C0] RAX: 000000000022d2c3 RBX: ffffffff8f61c600 RCX: ffffffff8c6f0307 [ 28.539601][ C0] RDX: ffffffff8f61c600 RSI: ffffffff8f438b01 RDI: ffffffff8ee8d8e0 [ 28.539602][ C0] RBP: 0000000000000000 R08: 0000000000000000 R09: 0000000000000000 [ 28.539603][ C0] R10: 0000000000000000 R11: 0000000000000001 R12: 1ffffffff1ec0fa2 [ 28.539604][ C0] R13: 0000000000000000 R14: dffffc0000000000 R15: 0000000000014770 [ 28.539605][ C0] ? cpuidle_idle_call.constprop.0 (kernel/sched/idle.c:199) [ 28.539609][ C0] ? lockdep_hardirqs_on (kernel/locking/lockdep.c:4488) [ 28.539610][ C0] default_idle (./arch/x86/include/asm/paravirt.h:62 arch/x86/kernel/process.c:768) [ 28.539612][ C0] default_idle_call (kernel/sched/idle.c:122) [ 28.539614][ C0] cpuidle_idle_call.constprop.0 (kernel/sched/idle.c:199) [ 28.539615][ C0] ? arch_cpu_idle_exit+0x40/0x40 [ 28.539617][ C0] ? mark_tsc_async_resets (arch/x86/kernel/tsc_sync.c:49) [ 28.539619][ C0] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 28.539621][ C0] do_idle (kernel/sched/idle.c:355) [ 28.539623][ C0] cpu_startup_entry (kernel/sched/idle.c:454) [ 28.539624][ C0] rest_init (init/main.c:727) [ 28.539626][ C0] ? __cpuidle_text_end (??:?) [ 28.539629][ C0] ? rest_init (init/main.c:727) [ 28.539630][ C0] ? acpi_hw_set_mode (drivers/acpi/acpica/hwacpi.c:72 (discriminator 1)) [ 28.539634][ C0] ? cpus_read_unlock (./include/linux/percpu-rwsem.h:125 (discriminator 1) kernel/cpu.c:502 (discriminator 1)) [ 28.539637][ C0] ? acpi_enable (drivers/acpi/acpica/evxfevnt.c:47) [ 28.539639][ C0] start_kernel (init/main.c:1185) [ 28.539641][ C0] x86_64_start_reservations (arch/x86/kernel/head64.c:310) [ 28.539643][ C0] x86_64_start_kernel (arch/x86/kernel/head64.c:291) [ 28.539645][ C0] common_startup_64 (arch/x86/kernel/head_64.S:418) | [ 28.608508][ C0] | [ 28.608581][ C0] | [ 28.608581][ C0] stack backtrace: | [ 28.608826][ C0] Tainted: [W]=WARN [ 28.608827][ C0] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 28.608829][ C0] Call Trace: [ 28.608830][ C0] [ 28.608832][ C0] dump_stack_lvl (lib/dump_stack.c:94 lib/dump_stack.c:120) [ 28.608836][ C0] print_irq_inversion_bug.part.0.cold (kernel/locking/lockdep.c:4141) [ 28.608838][ C0] mark_lock_irq (kernel/locking/lockdep.c:4095 kernel/locking/lockdep.c:4174 kernel/locking/lockdep.c:4310) [ 28.608841][ C0] mark_lock (kernel/locking/lockdep.c:4769) [ 28.608843][ C0] mark_usage (kernel/locking/lockdep.c:4658) [ 28.608845][ C0] __lock_acquire (kernel/locking/lockdep.c:5208) [ 28.608847][ C0] lock_acquire.part.0 (kernel/locking/lockdep.c:5908 (discriminator 2)) [ 28.608849][ C0] ? br_forward_delay_timer_expired (./include/linux/spinlock.h:347 net/bridge/br_stp_timer.c:88) bridge [ 28.608856][ C0] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 28.608859][ C0] ? lock_acquire (./include/trace/events/lock.h:23 (discriminator 22) kernel/locking/lockdep.c:5871 (discriminator 22)) [ 28.608861][ C0] ? br_message_age_timer_expired (net/bridge/br_stp_timer.c:54) bridge [ 28.608867][ C0] _raw_spin_lock (./include/linux/spinlock_api_smp.h:190 (discriminator 1) kernel/locking/spinlock.c:173 (discriminator 1)) [ 28.608868][ C0] ? br_forward_delay_timer_expired (./include/linux/spinlock.h:347 net/bridge/br_stp_timer.c:88) bridge [ 28.608874][ C0] br_forward_delay_timer_expired (./include/linux/spinlock.h:347 net/bridge/br_stp_timer.c:88) bridge [ 28.608880][ C0] ? br_message_age_timer_expired (net/bridge/br_stp_timer.c:54) bridge [ 28.608886][ C0] call_timer_fn (kernel/time/timer.c:1748) [ 28.608889][ C0] ? detach_if_pending (./include/linux/list.h:1159) [ 28.608890][ C0] ? debug_object_active_state (lib/debugobjects.c:1122) [ 28.608894][ C0] ? find_held_lock (kernel/locking/lockdep.c:5367) [ 28.608896][ C0] ? __lock_release.isra.0 (kernel/locking/lockdep.c:5554) [ 28.608898][ C0] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 28.608900][ C0] __run_timers (kernel/time/timer.c:1799 kernel/time/timer.c:2374) [ 28.608902][ C0] ? br_message_age_timer_expired (net/bridge/br_stp_timer.c:54) bridge [ 28.608908][ C0] ? __bpf_trace_itimer_expire (./include/trace/events/timer.h:407) [ 28.608910][ C0] ? __lock_acquire (kernel/locking/lockdep.c:5254) [ 28.608914][ C0] ? __rwlock_init (kernel/locking/spinlock_debug.c:48) [ 28.608917][ C0] run_timer_softirq (kernel/time/timer.c:2386 kernel/time/timer.c:2395 kernel/time/timer.c:2403) [ 28.608919][ C0] ? __run_timers (./include/trace/events/timer.h:138 (discriminator 19)) [ 28.608921][ C0] ? trace_irq_enable.constprop.0 (./include/trace/events/preemptirq.h:40 (discriminator 22)) [ 28.608923][ C0] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 28.608925][ C0] handle_softirqs (kernel/softirq.c:645) [ 28.608927][ C0] ? __lock_release.isra.0 (kernel/locking/lockdep.c:5554) [ 28.608928][ C0] ? _local_bh_enable (kernel/softirq.c:428 (discriminator 1)) [ 28.608930][ C0] __irq_exit_rcu (kernel/softirq.c:679 kernel/softirq.c:519 kernel/softirq.c:767) [ 28.608932][ C0] irq_exit_rcu (kernel/softirq.c:784) [ 28.608933][ C0] sysvec_apic_timer_interrupt (arch/x86/kernel/apic/apic.c:1062 (discriminator 37) arch/x86/kernel/apic/apic.c:1062 (discriminator 37)) [ 28.608935][ C0] [ 28.608935][ C0] [ 28.608936][ C0] ? lockdep_hardirqs_on_prepare.part.0 (kernel/locking/lockdep.c:470 (discriminator 2) kernel/locking/lockdep.c:4427 (discriminator 2)) [ 28.608938][ C0] asm_sysvec_apic_timer_interrupt (./arch/x86/include/asm/idtentry.h:674) [ 28.608939][ C0] RIP: 0010:pv_native_safe_halt (./arch/x86/include/asm/irqflags.h:48 arch/x86/kernel/paravirt.c:63) [ 28.608942][ C0] Code: 48 8b 3d 94 e2 f5 01 e8 1f 00 00 00 48 2b 05 58 a3 95 00 c3 0f 1f 80 00 00 00 00 f3 0f 1e fa eb 07 0f 00 2d 13 96 11 00 fb f4 0f 1f 40 d6 48 83 ec 20 8b 17 49 89 f8 83 e2 fe 41 89 d2 0f 01 All code ======== 0: 48 8b 3d 94 e2 f5 01 mov 0x1f5e294(%rip),%rdi # 0x1f5e29b 7: e8 1f 00 00 00 call 0x2b c: 48 2b 05 58 a3 95 00 sub 0x95a358(%rip),%rax # 0x95a36b 13: c3 ret 14: 0f 1f 80 00 00 00 00 nopl 0x0(%rax) 1b: f3 0f 1e fa endbr64 1f: eb 07 jmp 0x28 21: 0f 00 2d 13 96 11 00 verw 0x119613(%rip) # 0x11963b 28: fb sti 29: f4 hlt 2a:* c3 ret <-- trapping instruction 2b: 0f 1f 40 d6 nopl -0x2a(%rax) 2f: 48 83 ec 20 sub $0x20,%rsp 33: 8b 17 mov (%rdi),%edx 35: 49 89 f8 mov %rdi,%r8 38: 83 e2 fe and $0xfffffffe,%edx 3b: 41 89 d2 mov %edx,%r10d 3e: 0f .byte 0xf 3f: 01 .byte 0x1 Code starting with the faulting instruction =========================================== 0: c3 ret 1: 0f 1f 40 d6 nopl -0x2a(%rax) 5: 48 83 ec 20 sub $0x20,%rsp 9: 8b 17 mov (%rdi),%edx b: 49 89 f8 mov %rdi,%r8 e: 83 e2 fe and $0xfffffffe,%edx 11: 41 89 d2 mov %edx,%r10d 14: 0f .byte 0xf 15: 01 .byte 0x1 [ 28.608944][ C0] RSP: 0018:ffffffff8f607cf8 EFLAGS: 00000296 [ 28.608946][ C0] RAX: 000000000022d2c3 RBX: ffffffff8f61c600 RCX: ffffffff8c6f0307 [ 28.608947][ C0] RDX: ffffffff8f61c600 RSI: ffffffff8f438b01 RDI: ffffffff8ee8d8e0 [ 28.608948][ C0] RBP: 0000000000000000 R08: 0000000000000000 R09: 0000000000000000 [ 28.608948][ C0] R10: 0000000000000000 R11: 0000000000000001 R12: 1ffffffff1ec0fa2 [ 28.608949][ C0] R13: 0000000000000000 R14: dffffc0000000000 R15: 0000000000014770 [ 28.608951][ C0] ? cpuidle_idle_call.constprop.0 (kernel/sched/idle.c:199) [ 28.608953][ C0] ? lockdep_hardirqs_on (kernel/locking/lockdep.c:4488) [ 28.608954][ C0] default_idle (./arch/x86/include/asm/paravirt.h:62 arch/x86/kernel/process.c:768) [ 28.608956][ C0] default_idle_call (kernel/sched/idle.c:122) [ 28.608958][ C0] cpuidle_idle_call.constprop.0 (kernel/sched/idle.c:199) [ 28.608959][ C0] ? arch_cpu_idle_exit+0x40/0x40 [ 28.608961][ C0] ? mark_tsc_async_resets (arch/x86/kernel/tsc_sync.c:49) [ 28.608963][ C0] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 28.608965][ C0] do_idle (kernel/sched/idle.c:355) [ 28.608967][ C0] cpu_startup_entry (kernel/sched/idle.c:454) [ 28.608968][ C0] rest_init (init/main.c:727) [ 28.608970][ C0] ? __cpuidle_text_end (??:?) [ 28.608973][ C0] ? rest_init (init/main.c:727) [ 28.608975][ C0] ? acpi_hw_set_mode (drivers/acpi/acpica/hwacpi.c:72 (discriminator 1)) [ 28.608978][ C0] ? cpus_read_unlock (./include/linux/percpu-rwsem.h:125 (discriminator 1) kernel/cpu.c:502 (discriminator 1)) [ 28.608981][ C0] ? acpi_enable (drivers/acpi/acpica/evxfevnt.c:47) [ 28.608983][ C0] start_kernel (init/main.c:1185) [ 28.608985][ C0] x86_64_start_reservations (arch/x86/kernel/head64.c:310) [ 28.608987][ C0] x86_64_start_kernel (arch/x86/kernel/head64.c:291) [ 28.608988][ C0] common_startup_64 (arch/x86/kernel/head_64.S:418) | [ 86.684613][ T787] softirqs last disabled at (0): 0x0 | [ 86.684615][ T787] Preemption disabled at: | [ 86.684616][ T787] 0x0 | [ 86.684624][ T787] Tainted: [W]=WARN [ 86.684625][ T787] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 86.684626][ T787] Call Trace: [ 86.684628][ T787] [ 86.684629][ T787] dump_stack_lvl (lib/dump_stack.c:94 lib/dump_stack.c:120) [ 86.684634][ T787] __might_resched.cold (kernel/sched/core.c:9234) [ 86.684638][ T787] ? perf_trace_sched_switch (./include/linux/list.h:1037 (discriminator 3)) [ 86.684641][ T787] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 86.684645][ T787] __kmalloc_noprof (./include/linux/sched/mm.h:322 (discriminator 2) mm/slub.c:4636 (discriminator 2) mm/slub.c:4974 (discriminator 2) mm/slub.c:5413 (discriminator 2) mm/slub.c:5439 (discriminator 2)) [ 86.684649][ T787] ? __rwlock_init (kernel/locking/spinlock_debug.c:48) [ 86.684651][ T787] ? alloc_buf.isra.0 (./include/linux/slab.h:995 drivers/char/virtio_console.c:429) [ 86.684655][ T787] ? do_raw_spin_unlock (./include/linux/instrumented.h:82 ./include/linux/atomic/atomic-instrumented.h:32 ./include/asm-generic/qspinlock.h:58 kernel/locking/spinlock_debug.c:101 kernel/locking/spinlock_debug.c:141) [ 86.684656][ T787] alloc_buf.isra.0 (./include/linux/slab.h:995 drivers/char/virtio_console.c:429) [ 86.684658][ T787] put_chars (drivers/char/virtio_console.c:1176) [ 86.684660][ T787] ? desc_read_finalized_seq (kernel/printk/printk_ringbuffer.c:1934) [ 86.684662][ T787] ? __send_to_port (drivers/char/virtio_console.c:654) [ 86.684664][ T787] ? console_prepend_replay (kernel/printk/printk.c:3005) [ 86.684667][ T787] hvc_console_print (drivers/tty/hvc/hvc_console.c:177 (discriminator 2)) [ 86.684670][ T787] ? hvc_write (drivers/tty/hvc/hvc_console.c:501) [ 86.684671][ T787] ? do_raw_spin_lock (./include/linux/instrumented.h:55 ./include/linux/atomic/atomic-instrumented.h:1301 ./include/asm-generic/qspinlock.h:112 kernel/locking/spinlock_debug.c:116) [ 86.684673][ T787] ? __rwlock_init (kernel/locking/spinlock_debug.c:48) [ 86.684674][ T787] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 86.684676][ T787] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 86.684678][ T787] ? lock_acquire (./include/trace/events/lock.h:23 (discriminator 22) kernel/locking/lockdep.c:5871 (discriminator 22)) [ 86.684680][ T787] console_emit_next_record (kernel/printk/printk.c:3183) [ 86.684682][ T787] ? devkmsg_read (./arch/x86/include/asm/atomic64_64.h:20) [ 86.684684][ T787] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 86.684686][ T787] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 86.684687][ T787] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 86.684689][ T787] ? lock_acquire (./include/trace/events/lock.h:23 (discriminator 22) kernel/locking/lockdep.c:5871 (discriminator 22)) [ 86.684691][ T787] ? console_flush_one_record (kernel/printk/printk.c:3247) [ 86.684692][ T787] console_flush_one_record (kernel/printk/printk.c:3268) [ 86.684694][ T787] ? console_emit_next_record (kernel/printk/printk.c:3150) [ 86.684697][ T787] console_unlock (kernel/printk/printk.c:3350 kernel/printk/printk.c:3380 kernel/printk/printk.c:3420) [ 86.684698][ T787] ? lock_acquire (./include/trace/events/lock.h:23 (discriminator 22) kernel/locking/lockdep.c:5871 (discriminator 22)) [ 86.684700][ T787] ? console_flush_one_record (kernel/printk/printk.c:3316) [ 86.684701][ T787] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 86.684703][ T787] ? lock_release (./include/trace/events/lock.h:68 (discriminator 22) kernel/locking/lockdep.c:5920 (discriminator 22)) [ 86.684704][ T787] ? lock_acquire (kernel/locking/lockdep.c:5913) [ 86.684705][ T787] ? __rcu_read_lock (kernel/rcu/tree_plugin.h:391 (discriminator 6) kernel/rcu/tree_plugin.h:414 (discriminator 6)) [ 86.684707][ T787] ? __down_trylock_console_sem (kernel/printk/printk.c:334) [ 86.684709][ T787] ? vprintk_emit (kernel/printk/printk.c:2478) [ 86.684711][ T787] vprintk_emit (kernel/printk/printk.c:2479) [ 86.684715][ T787] ? wake_up_klogd_work_func (kernel/printk/printk.c:4603 (discriminator 126)) [ 86.684717][ T787] ? debug_object_assert_init (lib/debugobjects.c:1072 (discriminator 3)) [ 86.684720][ T787] ? debug_object_activate (lib/debugobjects.c:884) [ 86.684722][ T787] _printk (kernel/printk/printk.c:2504) [ 86.684726][ T787] ? snapshot_read.cold (user.c:?) [ 86.684728][ T787] ? __rwlock_init (kernel/locking/spinlock_debug.c:48) [ 86.684729][ T787] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 86.684731][ T787] ? trace_irq_enable.constprop.0 (./include/trace/events/preemptirq.h:40 (discriminator 22)) [ 86.684734][ T787] br_set_state (net/bridge/br_stp.c:57 (discriminator 2)) bridge [ 86.684747][ T787] br_stp_disable_port (net/bridge/br_stp_if.c:106) bridge [ 86.684755][ T787] br_stp_disable_bridge (net/bridge/br_stp_if.c:76) bridge [ 86.684761][ T787] br_dev_stop (net/bridge/br_device.c:193) bridge [ 86.684770][ T787] ? rtnl_is_locked (net/core/rtnetlink.c:169) [ 86.684773][ T787] __dev_close_many (net/core/dev.c:1798) [ 86.684776][ T787] ? netif_open (net/core/dev.c:1755) [ 86.684778][ T787] ? trace_irq_enable.constprop.0 (./include/linux/instrumented.h:82 ./include/asm-generic/bitops/instrumented-non-atomic.h:141 ./include/linux/cpumask.h:650 ./include/linux/cpumask.h:1232 ./include/trace/events/preemptirq.h:40) [ 86.684780][ T787] __dev_change_flags (net/core/dev.c:1811 net/core/dev.c:9810) [ 86.684782][ T787] ? netif_set_allmulti (./include/net/netdev_lock.h:30 (discriminator 1)) [ 86.684784][ T787] ? __kernel_text_address (kernel/extable.c:79) [ 86.684786][ T787] ? write_profile (profile.c:?) [ 86.684789][ T787] ? unwind_get_return_address (arch/x86/kernel/unwind_orc.c:385 arch/x86/kernel/unwind_orc.c:380) [ 86.684791][ T787] netif_change_flags (net/core/dev.c:9877) [ 86.684794][ T787] do_setlink.isra.0 (net/core/rtnetlink.c:3266 (discriminator 1)) [ 86.684795][ T787] ? stack_trace_save (kernel/stacktrace.c:122 (discriminator 1)) [ 86.684797][ T787] ? rtnl_link_get_size (net/core/rtnetlink.c:747) [ 86.684798][ T787] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 86.684800][ T787] ? stack_depot_save_flags (lib/stackdepot.c:609 lib/stackdepot.c:676) [ 86.684803][ T787] ? kasan_save_stack (mm/kasan/common.c:58) [ 86.684805][ T787] ? kasan_save_stack (mm/kasan/common.c:57) [ 86.684807][ T787] ? kasan_save_track (mm/kasan/common.c:78) [ 86.684808][ T787] ? __kasan_kmalloc (mm/kasan/common.c:398 mm/kasan/common.c:415) [ 86.684810][ T787] ? __kmalloc_cache_noprof (./include/linux/kasan.h:263 mm/slub.c:5563) [ 86.684811][ T787] ? rtnl_newlink (./include/linux/slab.h:991 (discriminator 1) net/core/rtnetlink.c:4113 (discriminator 1)) [ 86.684812][ T787] ? rtnetlink_rcv_msg (net/core/rtnetlink.c:7132) [ 86.684813][ T787] ? netlink_rcv_skb (net/netlink/af_netlink.c:2556) [ 86.684816][ T787] ? netlink_unicast (net/netlink/af_netlink.c:1319 net/netlink/af_netlink.c:1345) [ 86.684817][ T787] ? netlink_sendmsg (net/netlink/af_netlink.c:1900) [ 86.684818][ T787] ? ____sys_sendmsg (net/socket.c:800 (discriminator 4) net/socket.c:815 (discriminator 4) net/socket.c:2713 (discriminator 4)) [ 86.684821][ T787] ? ___sys_sendmsg (net/socket.c:2767) [ 86.684822][ T787] ? __sys_sendmsg (net/socket.c:2799) [ 86.684824][ T787] ? do_syscall_64 (arch/x86/entry/syscall_64.c:61 arch/x86/entry/syscall_64.c:84) [ 86.684826][ T787] ? entry_SYSCALL_64_after_hwframe (arch/x86/entry/entry_64.S:121) [ 86.684829][ T787] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 86.684830][ T787] ? lock_acquire (./include/trace/events/lock.h:23 (discriminator 22) kernel/locking/lockdep.c:5871 (discriminator 22)) [ 86.684832][ T787] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 86.684833][ T787] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 86.684835][ T787] ? trace_contention_end (./include/trace/events/lock.h:121 (discriminator 22)) [ 86.684838][ T787] ? __mutex_lock (./include/linux/instrumented.h:82 ./include/linux/atomic/atomic-instrumented.h:3188 kernel/locking/mutex.c:89 kernel/locking/mutex.c:134 kernel/locking/mutex.c:649 kernel/locking/mutex.c:821) [ 86.684840][ T787] ? __mutex_lock (kernel/locking/mutex.c:656 (discriminator 1) kernel/locking/mutex.c:821 (discriminator 1)) [ 86.684841][ T787] ? rtnl_newlink (net/core/rtnetlink.c:80 net/core/rtnetlink.c:366 net/core/rtnetlink.c:4214) [ 86.684843][ T787] ? ww_mutex_lock (kernel/locking/mutex.c:934) [ 86.684845][ T787] ? __rtnl_newlink (net/core/rtnetlink.c:4063) [ 86.684847][ T787] rtnl_newlink (net/core/rtnetlink.c:4215) [ 86.684849][ T787] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 86.684850][ T787] ? rtnl_bridge_getlink (net/core/rtnetlink.c:5558) [ 86.684852][ T787] ? lock_acquire (./include/trace/events/lock.h:23 (discriminator 22) kernel/locking/lockdep.c:5871 (discriminator 22)) [ 86.684853][ T787] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 86.684855][ T787] ? is_bpf_text_address (./include/linux/rcupdate.h:850 kernel/bpf/core.c:749) [ 86.684858][ T787] ? is_bpf_text_address (./include/linux/rcupdate.h:882 kernel/bpf/core.c:751) [ 86.684860][ T787] ? kernel_text_address (kernel/extable.c:125 kernel/extable.c:94) [ 86.684861][ T787] ? __kernel_text_address (kernel/extable.c:79) [ 86.684862][ T787] ? write_profile (profile.c:?) [ 86.684863][ T787] ? unwind_get_return_address (arch/x86/kernel/unwind_orc.c:385 arch/x86/kernel/unwind_orc.c:380) [ 86.684864][ T787] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 86.684866][ T787] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 86.684868][ T787] ? cap_capable (./include/trace/events/capability.h:26 (discriminator 22) security/commoncap.c:130 (discriminator 22)) [ 86.684871][ T787] ? lock_acquire (./include/trace/events/lock.h:23 (discriminator 22) kernel/locking/lockdep.c:5871 (discriminator 22)) [ 86.684872][ T787] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 86.684874][ T787] ? rtnl_bridge_getlink (net/core/rtnetlink.c:5558) [ 86.684875][ T787] rtnetlink_rcv_msg (net/core/rtnetlink.c:7132) [ 86.684877][ T787] ? rtnl_link_fill (./include/net/netlink.h:1107 (discriminator 1)) [ 86.684878][ T787] ? filter_irq_stacks (kernel/stacktrace.c:402) [ 86.684879][ T787] ? stack_depot_save_flags (lib/stackdepot.c:609 lib/stackdepot.c:676) [ 86.684882][ T787] netlink_rcv_skb (net/netlink/af_netlink.c:2556) [ 86.684883][ T787] ? rtnl_link_fill (./include/net/netlink.h:1107 (discriminator 1)) [ 86.684884][ T787] ? lock_release (./include/trace/events/lock.h:68 (discriminator 22) kernel/locking/lockdep.c:5920 (discriminator 22)) [ 86.684886][ T787] ? netlink_ack (./include/linux/skbuff.h:2718) [ 86.684887][ T787] ? __netlink_lookup (./include/linux/rcupdate.h:850 ./include/linux/rhashtable.h:709 net/netlink/af_netlink.c:499) [ 86.684890][ T787] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 86.684891][ T787] ? lock_release (./include/trace/events/lock.h:68 (discriminator 22) kernel/locking/lockdep.c:5920 (discriminator 22)) [ 86.684893][ T787] netlink_unicast (net/netlink/af_netlink.c:1319 net/netlink/af_netlink.c:1345) [ 86.684895][ T787] ? netlink_attachskb (./arch/x86/include/asm/bitops.h:202 (discriminator 1)) [ 86.684897][ T787] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 86.684898][ T787] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 86.684900][ T787] ? lock_acquire (./include/trace/events/lock.h:23 (discriminator 22) kernel/locking/lockdep.c:5871 (discriminator 22)) [ 86.684902][ T787] netlink_sendmsg (net/netlink/af_netlink.c:1900) [ 86.684903][ T787] ? netlink_unicast (./include/net/net_namespace.h:422 (discriminator 7)) [ 86.684905][ T787] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 86.684907][ T787] ? lock_release (./include/trace/events/lock.h:68 (discriminator 22) kernel/locking/lockdep.c:5920 (discriminator 22)) [ 86.684909][ T787] ____sys_sendmsg (net/socket.c:800 (discriminator 4) net/socket.c:815 (discriminator 4) net/socket.c:2713 (discriminator 4)) [ 86.684910][ T787] ? copy_msghdr_from_user (net/socket.c:2650) [ 86.684912][ T787] ? get_timestamp.constprop.0 (./include/linux/netdevice.h:5399) [ 86.684913][ T787] ? move_addr_to_kernel (net/socket.c:258) [ 86.684915][ T787] ? filter_irq_stacks (kernel/stacktrace.c:402) [ 86.684917][ T787] ___sys_sendmsg (net/socket.c:2767) [ 86.684919][ T787] ? copy_msghdr_from_user (net/socket.c:2619) [ 86.684924][ T787] __sys_sendmsg (net/socket.c:2799) [ 86.684925][ T787] ? __sys_sendmsg_sock (net/socket.c:2780) [ 86.684928][ T787] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 3) kernel/rcu/tree.c:753 (discriminator 3)) [ 86.684930][ T787] do_syscall_64 (arch/x86/entry/syscall_64.c:61 arch/x86/entry/syscall_64.c:84) [ 86.684931][ T787] ? exc_page_fault (arch/x86/mm/fault.c:1489 (discriminator 3) arch/x86/mm/fault.c:1536 (discriminator 3)) [ 86.684933][ T787] entry_SYSCALL_64_after_hwframe (arch/x86/entry/entry_64.S:121) [ 86.684935][ T787] RIP: 0033:0x7efecf2f454e [ 86.684936][ T787] Code: 4d 89 d8 e8 b4 bd 00 00 4c 8b 5d f8 41 8b 93 08 03 00 00 59 5e 48 83 f8 fc 74 11 c9 c3 0f 1f 80 00 00 00 00 48 8b 45 10 0f 05 c3 83 e2 39 83 fa 08 75 e7 e8 03 ff ff ff 0f 1f 00 f3 0f 1e fa All code ======== 0: 4d 89 d8 mov %r11,%r8 3: e8 b4 bd 00 00 call 0xbdbc 8: 4c 8b 5d f8 mov -0x8(%rbp),%r11 c: 41 8b 93 08 03 00 00 mov 0x308(%r11),%edx 13: 59 pop %rcx 14: 5e pop %rsi 15: 48 83 f8 fc cmp $0xfffffffffffffffc,%rax 19: 74 11 je 0x2c 1b: c9 leave 1c: c3 ret 1d: 0f 1f 80 00 00 00 00 nopl 0x0(%rax) 24: 48 8b 45 10 mov 0x10(%rbp),%rax 28: 0f 05 syscall 2a:* c9 leave <-- trapping instruction 2b: c3 ret 2c: 83 e2 39 and $0x39,%edx 2f: 83 fa 08 cmp $0x8,%edx 32: 75 e7 jne 0x1b 34: e8 03 ff ff ff call 0xffffffffffffff3c 39: 0f 1f 00 nopl (%rax) 3c: f3 0f 1e fa endbr64 Code starting with the faulting instruction =========================================== 0: c9 leave 1: c3 ret 2: 83 e2 39 and $0x39,%edx 5: 83 fa 08 cmp $0x8,%edx 8: 75 e7 jne 0xfffffffffffffff1 a: e8 03 ff ff ff call 0xffffffffffffff12 f: 0f 1f 00 nopl (%rax) 12: f3 0f 1e fa endbr64 [ 86.684938][ T787] RSP: 002b:00007ffc61a56f90 EFLAGS: 00000202 ORIG_RAX: 000000000000002e [ 86.684942][ T787] RAX: ffffffffffffffda RBX: 0000000000000003 RCX: 00007efecf2f454e [ 86.684943][ T787] RDX: 0000000000000000 RSI: 00007ffc61a57040 RDI: 0000000000000005 [ 86.684944][ T787] RBP: 00007ffc61a56fa0 R08: 0000000000000000 R09: 0000000000000000 [ 86.684945][ T787] R10: 0000000000000000 R11: 0000000000000202 R12: 000000006a910a9d Finger prints: mark_lock_irq:mark_lock:mark_usage:__lock_acquire:_raw_spin_lock __irq_exit_rcu:schedule_preempt_disabled:dump_stack_lvl:__kmalloc_noprof:put_chars __irq_exit_rcu:vprintk_emit:dump_stack_lvl:__kmalloc_noprof:put_chars __kmalloc_noprof:put_chars:hvc_console_print:console_emit_next_record:console_flush_one_record