[ 9.747777][ T170] ip (170) used greatest stack depth: 23648 bytes left [ 9.747793][ T170] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 9.747795][ T170] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 170, name: ip [ 9.747797][ T170] preempt_count: 2, expected: 0 [ 9.747798][ T170] RCU nest depth: 0, expected: 0 [ 9.747799][ T170] locks held by ip/170: 5, last CPU#0: [ 9.747801][ T170] #0: ffffffffbc6127b8 (low_water_lock){+.+.}-{3:3}, at: do_exit+0x887/0xdc0 [ 9.747812][ T170] #1: ffffffffbc779cc0 (console_lock){+.+.}-{0:0}, at: vprintk_emit+0x320/0x3e0 [ 9.747818][ T170] #2: ffffffffbc779d38 (console_srcu){....}-{0:0}, at: console_flush_one_record+0x106/0x710 [ 9.747821][ T170] #3: ffffffffbc699660 (console_owner){....}-{0:0}, at: console_lock_spinning_enable+0x40/0x60 [ 9.747825][ T170] #4: ffffffffbc699560 (printk_legacy_map-wait-type-override){....}-{3:3}, at: console_emit_next_record+0x1df/0x4c0 [ 9.747829][ T170] irq event stamp: 21652 [ 9.747830][ T170] hardirqs last enabled at (21651): [] __down_trylock_console_sem+0x86/0xa0 [ 9.747832][ T170] hardirqs last disabled at (21652): [] console_emit_next_record+0x3d4/0x4c0 [ 9.747835][ T170] softirqs last enabled at (21108): [] handle_softirqs+0x67c/0x900 [ 9.747837][ T170] softirqs last disabled at (21103): [] __irq_exit_rcu+0x145/0x1c0 [ 9.747839][ T170] Preemption disabled at: [ 9.747840][ T170] [<0000000000000000>] 0x0 [ 9.747846][ T170] CPU: 0 UID: 0 PID: 170 Comm: ip Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 9.747850][ T170] Tainted: [W]=WARN [ 9.747851][ T170] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 9.747853][ T170] Call Trace: [ 9.747854][ T170] [ 9.747856][ T170] dump_stack_lvl+0x6f/0xa0 [ 9.747862][ T170] __might_resched.cold+0x1fe/0x2c1 [ 9.747866][ T170] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 9.747871][ T170] ? __kmalloc_noprof+0xdb/0x760 [ 9.747876][ T170] __kmalloc_noprof+0x443/0x760 [ 9.747878][ T170] ? alloc_buf.isra.0+0x4b/0x260 [ 9.747884][ T170] ? do_raw_spin_unlock+0x59/0x250 [ 9.747886][ T170] alloc_buf.isra.0+0x4b/0x260 [ 9.747890][ T170] put_chars+0x1e1/0x2f0 [ 9.747893][ T170] ? __send_to_port+0x420/0x420 [ 9.747894][ T170] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 9.747900][ T170] ? validate_chain+0x38b/0xc20 [ 9.747905][ T170] hvc_console_print+0x292/0x780 [ 9.747911][ T170] ? hvc_write+0x3a0/0x3a0 [ 9.747914][ T170] ? rcu_is_watching+0x16/0xd0 [ 9.747916][ T170] ? lock_acquire+0x13c/0x160 [ 9.747920][ T170] console_emit_next_record+0x22f/0x4c0 [ 9.747924][ T170] ? devkmsg_read+0x4b0/0x4b0 [ 9.747926][ T170] ? console_flush_one_record+0x106/0x710 [ 9.747929][ T170] ? rcu_is_watching+0x16/0xd0 [ 9.747931][ T170] ? lock_acquire+0x13c/0x160 [ 9.747935][ T170] console_flush_one_record+0x46f/0x710 [ 9.747944][ T170] ? console_emit_next_record+0x4c0/0x4c0 [ 9.747946][ T170] ? __lock_acquire+0x518/0xc20 [ 9.747951][ T170] console_unlock+0xee/0x1f0 [ 9.747954][ T170] ? console_flush_one_record+0x710/0x710 [ 9.747955][ T170] ? rcu_is_watching+0x16/0xd0 [ 9.747958][ T170] ? lock_acquire+0x60/0x160 [ 9.747961][ T170] ? __down_trylock_console_sem+0x5e/0xa0 [ 9.747963][ T170] ? vprintk_emit+0x320/0x3e0 [ 9.747966][ T170] vprintk_emit+0x37c/0x3e0 [ 9.747970][ T170] ? wake_up_klogd_work_func+0x90/0x90 [ 9.747975][ T170] ? __lock_acquire+0x518/0xc20 [ 9.747979][ T170] _printk+0xc7/0x100 [ 9.747983][ T170] ? snapshot_read.cold+0x21/0x21 [ 9.747985][ T170] ? do_raw_spin_lock+0x131/0x280 [ 9.747988][ T170] ? __rwlock_init+0x150/0x150 [ 9.747992][ T170] ? do_raw_spin_lock+0x131/0x280 [ 9.747994][ T170] do_exit.cold+0x82/0x9c [ 9.747998][ T170] ? exit_notify+0x890/0x890 [ 9.748000][ T170] ? __lock_release.isra.0+0x69/0x1a0 [ 9.748002][ T170] ? rcu_is_watching+0x16/0xd0 [ 9.748006][ T170] do_group_exit+0xb8/0x370 [ 9.748009][ T170] __x64_sys_exit_group+0x3c/0x50 [ 9.748011][ T170] x64_sys_call+0x1567/0x1570 [ 9.748014][ T170] do_syscall_64+0xff/0x530 [ 9.748018][ T170] ? exc_page_fault+0xee/0x100 [ 9.748020][ T170] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 9.748022][ T170] RIP: 0033:0x7f5b1c9491b8 [ 9.748025][ T170] Code: Unable to access opcode bytes at 0x7f5b1c94918e. [ 9.748026][ T170] RSP: 002b:00007ffe0c0c7918 EFLAGS: 00000246 ORIG_RAX: 00000000000000e7 [ 9.748028][ T170] RAX: ffffffffffffffda RBX: 00007f5b1ca79f88 RCX: 00007f5b1c9491b8 [ 9.748030][ T170] RDX: 00007f5b1c693fc8 RSI: fffffffffffffeb8 RDI: 0000000000000000 [ 9.748031][ T170] RBP: 00007ffe0c0c7970 R08: 0000000000000000 R09: 0000000000000050 [ 9.748032][ T170] R10: 00007ffe0c0c7730 R11: 0000000000000246 R12: 0000000000000001 [ 9.748033][ T170] R13: 0000000000000000 R14: 00007f5b1ca78680 R15: 00007f5b1ca79fa0 [ 9.748043][ T170] [ 10.086564][ T178] PPP generic driver version 2.4.2 [ 13.504541][ T197] PPP BSD Compression module registered [ 13.504557][ T197] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 13.504560][ T197] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 197, name: modprobe [ 13.504561][ T197] preempt_count: 1, expected: 0 [ 13.504562][ T197] RCU nest depth: 0, expected: 0 [ 13.504563][ T197] locks held by modprobe/197: 4, last CPU#2: [ 13.504566][ T197] #0: ffffffffbc779cc0 (console_lock){+.+.}-{0:0}, at: vprintk_emit+0x320/0x3e0 [ 13.504578][ T197] #1: ffffffffbc779d38 (console_srcu){....}-{0:0}, at: console_flush_one_record+0x106/0x710 [ 13.504583][ T197] #2: ffffffffbc699660 (console_owner){....}-{0:0}, at: console_lock_spinning_enable+0x40/0x60 [ 13.504587][ T197] #3: ffffffffbc699560 (printk_legacy_map-wait-type-override){....}-{3:3}, at: console_emit_next_record+0x1df/0x4c0 [ 13.504591][ T197] irq event stamp: 18178 [ 13.504592][ T197] hardirqs last enabled at (18177): [] __down_trylock_console_sem+0x86/0xa0 [ 13.504594][ T197] hardirqs last disabled at (18178): [] console_emit_next_record+0x3d4/0x4c0 [ 13.504596][ T197] softirqs last enabled at (17098): [] handle_softirqs+0x67c/0x900 [ 13.504600][ T197] softirqs last disabled at (17089): [] __irq_exit_rcu+0x145/0x1c0 [ 13.504602][ T197] Preemption disabled at: [ 13.504603][ T197] [] vprintk_emit+0x31b/0x3e0 [ 13.504608][ T197] CPU: 2 UID: 0 PID: 197 Comm: modprobe Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 13.504612][ T197] Tainted: [W]=WARN [ 13.504613][ T197] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 13.504615][ T197] Call Trace: [ 13.504616][ T197] [ 13.504618][ T197] dump_stack_lvl+0x6f/0xa0 [ 13.504623][ T197] ? vprintk_emit+0x31b/0x3e0 [ 13.504625][ T197] __might_resched.cold+0x1fe/0x2c1 [ 13.504630][ T197] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 13.504634][ T197] ? __kmalloc_noprof+0xdb/0x760 [ 13.504639][ T197] __kmalloc_noprof+0x443/0x760 [ 13.504641][ T197] ? alloc_buf.isra.0+0x4b/0x260 [ 13.504646][ T197] ? do_raw_spin_unlock+0x59/0x250 [ 13.504649][ T197] alloc_buf.isra.0+0x4b/0x260 [ 13.504652][ T197] put_chars+0x1e1/0x2f0 [ 13.504655][ T197] ? __send_to_port+0x420/0x420 [ 13.504657][ T197] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 13.504662][ T197] ? rcu_read_lock_any_held+0x3c/0x90 [ 13.504664][ T197] ? validate_chain+0x38b/0xc20 [ 13.504669][ T197] hvc_console_print+0x292/0x780 [ 13.504672][ T197] ? __lock_acquire+0x518/0xc20 [ 13.504677][ T197] ? hvc_write+0x3a0/0x3a0 [ 13.504679][ T197] ? rcu_is_watching+0x16/0xd0 [ 13.504684][ T197] console_emit_next_record+0x22f/0x4c0 [ 13.504689][ T197] ? devkmsg_read+0x4b0/0x4b0 [ 13.504691][ T197] ? console_flush_one_record+0x106/0x710 [ 13.504694][ T197] ? rcu_is_watching+0x16/0xd0 [ 13.504696][ T197] ? lock_acquire+0x13c/0x160 [ 13.504700][ T197] console_flush_one_record+0x46f/0x710 [ 13.504704][ T197] ? console_emit_next_record+0x4c0/0x4c0 [ 13.504706][ T197] ? __lock_acquire+0x518/0xc20 [ 13.504711][ T197] console_unlock+0xee/0x1f0 [ 13.504714][ T197] ? console_flush_one_record+0x710/0x710 [ 13.504715][ T197] ? rcu_is_watching+0x16/0xd0 [ 13.504718][ T197] ? lock_acquire+0x60/0x160 [ 13.504721][ T197] ? __down_trylock_console_sem+0x5e/0xa0 [ 13.504723][ T197] ? vprintk_emit+0x320/0x3e0 [ 13.504726][ T197] vprintk_emit+0x37c/0x3e0 [ 13.504730][ T197] ? wake_up_klogd_work_func+0x90/0x90 [ 13.504735][ T197] ? ppp_cleanup+0x920/0x920 [ppp_generic] [ 13.504739][ T197] _printk+0xc7/0x100 [ 13.504742][ T197] ? snapshot_read.cold+0x21/0x21 [ 13.504747][ T197] ? ppp_cleanup+0x920/0x920 [ppp_generic] [ 13.504749][ T197] ? do_raw_spin_unlock+0x59/0x250 [ 13.504751][ T197] ? ppp_cleanup+0x920/0x920 [ppp_generic] [ 13.504754][ T197] ? do_raw_spin_unlock+0x59/0x250 [ 13.504756][ T197] bsdcomp_init+0x28/0x1000 [bsd_comp] [ 13.504759][ T197] do_one_initcall+0x124/0x4f0 [ 13.504762][ T197] ? trace_event_raw_event_initcall_level+0x280/0x280 [ 13.504766][ T197] ? do_init_module+0xae/0x8a0 [ 13.504769][ T197] ? kasan_unpoison+0x44/0x70 [ 13.504774][ T197] do_init_module+0x2ad/0x8a0 [ 13.504777][ T197] ? lockdep_hardirqs_on+0x91/0x130 [ 13.504781][ T197] ? free_module+0x470/0x470 [ 13.504784][ T197] ? kfree+0x123/0x590 [ 13.504788][ T197] load_module+0x1424/0x1bb0 [ 13.504795][ T197] ? layout_and_allocate.isra.0+0x680/0x680 [ 13.504798][ T197] ? __ia32_sys_fsconfig+0x180/0x180 [ 13.504801][ T197] ? ovl_real_file+0x172/0x1e0 [ 13.504805][ T197] ? find_held_lock+0x2b/0x80 [ 13.504807][ T197] ? backing_file_read_iter+0x541/0x790 [ 13.504810][ T197] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 13.504814][ T197] init_module_from_file+0x11f/0x1a0 [ 13.504817][ T197] ? __do_sys_init_module+0x220/0x220 [ 13.504824][ T197] ? __rwlock_init+0x150/0x150 [ 13.504828][ T197] ? do_raw_spin_unlock+0x59/0x250 [ 13.504831][ T197] idempotent_init_module+0x37b/0x7c0 [ 13.504834][ T197] ? init_module_from_file+0x1a0/0x1a0 [ 13.504840][ T197] ? rcu_is_watching+0x16/0xd0 [ 13.504842][ T197] ? cap_capable+0x1d7/0x3d0 [ 13.504848][ T197] __x64_sys_finit_module+0xdf/0x190 [ 13.504850][ T197] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 13.504854][ T197] do_syscall_64+0xff/0x530 [ 13.504856][ T197] ? exc_page_fault+0xee/0x100 [ 13.504859][ T197] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 13.504861][ T197] RIP: 0033:0x7f584566b37d [ 13.504864][ T197] 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 [ 13.504866][ T197] RSP: 002b:00007ffd3943c198 EFLAGS: 00000246 ORIG_RAX: 0000000000000139 [ 13.504869][ T197] RAX: ffffffffffffffda RBX: 00005564888c1810 RCX: 00007f584566b37d [ 13.504870][ T197] RDX: 0000000000000000 RSI: 00005564624a5ffd RDI: 0000000000000000 [ 13.504871][ T197] RBP: 00007ffd3943c230 R08: 0000000000000000 R09: 0000000000000000 [ 13.504872][ T197] R10: 0000000000000000 R11: 0000000000000246 R12: 00005564624a5ffd [ 13.504873][ T197] R13: 00005564888c19e0 R14: 0000000000040000 R15: 0000000000000000 [ 13.504879][ T197] [ 13.600269][ T198] PPP Deflate Compression module registered [ 18.032273][ T226] iperf3 (226) used greatest stack depth: 22504 bytes left [ 18.032293][ T226] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 18.032295][ T226] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 226, name: iperf3 [ 18.032297][ T226] preempt_count: 2, expected: 0 [ 18.032298][ T226] RCU nest depth: 0, expected: 0 [ 18.032298][ T226] locks held by iperf3/226: 5, last CPU#3: [ 18.032301][ T226] #0: ffffffffbc6127b8 (low_water_lock){+.+.}-{3:3}, at: do_exit+0x887/0xdc0 [ 18.032312][ T226] #1: ffffffffbc779cc0 (console_lock){+.+.}-{0:0}, at: vprintk_emit+0x320/0x3e0 [ 18.032318][ T226] #2: ffffffffbc779d38 (console_srcu){....}-{0:0}, at: console_flush_one_record+0x106/0x710 [ 18.032322][ T226] #3: ffffffffbc699660 (console_owner){....}-{0:0}, at: console_lock_spinning_enable+0x40/0x60 [ 18.032326][ T226] #4: ffffffffbc699560 (printk_legacy_map-wait-type-override){....}-{3:3}, at: console_emit_next_record+0x1df/0x4c0 [ 18.032330][ T226] irq event stamp: 834316 [ 18.032331][ T226] hardirqs last enabled at (834315): [] __down_trylock_console_sem+0x86/0xa0 [ 18.032333][ T226] hardirqs last disabled at (834316): [] console_emit_next_record+0x3d4/0x4c0 [ 18.032336][ T226] softirqs last enabled at (833068): [] handle_softirqs+0x67c/0x900 [ 18.032338][ T226] softirqs last disabled at (832167): [] __irq_exit_rcu+0x145/0x1c0 [ 18.032340][ T226] Preemption disabled at: [ 18.032341][ T226] [<0000000000000000>] 0x0 [ 18.032348][ T226] CPU: 3 UID: 0 PID: 226 Comm: iperf3 Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 18.032351][ T226] Tainted: [W]=WARN [ 18.032352][ T226] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 18.032354][ T226] Call Trace: [ 18.032355][ T226] [ 18.032357][ T226] dump_stack_lvl+0x6f/0xa0 [ 18.032363][ T226] __might_resched.cold+0x1fe/0x2c1 [ 18.032368][ T226] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 18.032371][ T226] ? __kmalloc_noprof+0xdb/0x760 [ 18.032377][ T226] __kmalloc_noprof+0x443/0x760 [ 18.032379][ T226] ? alloc_buf.isra.0+0x4b/0x260 [ 18.032385][ T226] ? do_raw_spin_unlock+0x59/0x250 [ 18.032388][ T226] alloc_buf.isra.0+0x4b/0x260 [ 18.032391][ T226] put_chars+0x1e1/0x2f0 [ 18.032393][ T226] ? prb_final_commit+0x50/0x50 [ 18.032395][ T226] ? __send_to_port+0x420/0x420 [ 18.032398][ T226] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 18.032403][ T226] ? rcu_read_lock_any_held+0x3c/0x90 [ 18.032405][ T226] ? validate_chain+0x38b/0xc20 [ 18.032409][ T226] hvc_console_print+0x292/0x780 [ 18.032412][ T226] ? mark_usage+0x61/0x170 [ 18.032414][ T226] ? __lock_acquire+0x518/0xc20 [ 18.032416][ T226] ? __lock_acquire+0x518/0xc20 [ 18.032420][ T226] ? hvc_write+0x3a0/0x3a0 [ 18.032422][ T226] ? console_emit_next_record+0x1df/0x4c0 [ 18.032425][ T226] ? rcu_is_watching+0x16/0xd0 [ 18.032428][ T226] ? lock_acquire+0x13c/0x160 [ 18.032431][ T226] console_emit_next_record+0x22f/0x4c0 [ 18.032435][ T226] ? devkmsg_read+0x4b0/0x4b0 [ 18.032437][ T226] ? console_flush_one_record+0x106/0x710 [ 18.032440][ T226] ? rcu_is_watching+0x16/0xd0 [ 18.032443][ T226] ? lock_acquire+0x13c/0x160 [ 18.032447][ T226] console_flush_one_record+0x46f/0x710 [ 18.032451][ T226] ? console_emit_next_record+0x4c0/0x4c0 [ 18.032453][ T226] ? __lock_acquire+0x518/0xc20 [ 18.032458][ T226] console_unlock+0xee/0x1f0 [ 18.032461][ T226] ? console_flush_one_record+0x710/0x710 [ 18.032462][ T226] ? rcu_is_watching+0x16/0xd0 [ 18.032465][ T226] ? lock_acquire+0x60/0x160 [ 18.032468][ T226] ? __down_trylock_console_sem+0x5e/0xa0 [ 18.032470][ T226] ? vprintk_emit+0x320/0x3e0 [ 18.032474][ T226] vprintk_emit+0x37c/0x3e0 [ 18.032477][ T226] ? wake_up_klogd_work_func+0x90/0x90 [ 18.032481][ T226] ? __lock_acquire+0x518/0xc20 [ 18.032484][ T226] _printk+0xc7/0x100 [ 18.032488][ T226] ? snapshot_read.cold+0x21/0x21 [ 18.032491][ T226] ? do_raw_spin_lock+0x131/0x280 [ 18.032493][ T226] ? __rwlock_init+0x150/0x150 [ 18.032497][ T226] ? do_raw_spin_lock+0x131/0x280 [ 18.032500][ T226] do_exit.cold+0x82/0x9c [ 18.032504][ T226] ? exit_notify+0x890/0x890 [ 18.032509][ T226] __x64_sys_exit+0x42/0x50 [ 18.032511][ T226] x64_sys_call+0x156c/0x1570 [ 18.032513][ T226] do_syscall_64+0xff/0x530 [ 18.032517][ T226] ? exc_page_fault+0xee/0x100 [ 18.032520][ T226] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 18.032523][ T226] RIP: 0033:0x7fb352cf0c49 [ 18.032525][ T226] Code: Unable to access opcode bytes at 0x7fb352cf0c1f. [ 18.032526][ T226] RSP: 002b:00007fb3524afe60 EFLAGS: 00000246 ORIG_RAX: 000000000000003c [ 18.032529][ T226] RAX: ffffffffffffffda RBX: 00007fb3524b06c0 RCX: 00007fb352cf0c49 [ 18.032530][ T226] RDX: 0000000000000000 RSI: 0000000000801000 RDI: 0000000000000000 [ 18.032531][ T226] RBP: 00007fb3524aff70 R08: 0000000000000001 R09: 00007fb3524b06c0 [ 18.032532][ T226] R10: 0000000000000008 R11: 0000000000000246 R12: 00007fb351cb0000 [ 18.032533][ T226] R13: 00007ffcf1eca6b0 R14: 0000000000000002 R15: 00007ffcf1eca7b7 [ 18.032539][ T226]