[ 10.400645][ T175] ip (175) used greatest stack depth: 24016 bytes left [ 10.400663][ T175] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 10.400665][ T175] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 175, name: ip [ 10.400667][ T175] preempt_count: 2, expected: 0 [ 10.400668][ T175] RCU nest depth: 0, expected: 0 [ 10.400669][ T175] locks held by ip/175: 5, last CPU#2: [ 10.400671][ T175] #0: ffffffffbac127b8 (low_water_lock){+.+.}-{3:3}, at: do_exit+0x887/0xdc0 [ 10.400683][ T175] #1: ffffffffbad79cc0 (console_lock){+.+.}-{0:0}, at: vprintk_emit+0x320/0x3e0 [ 10.400689][ T175] #2: ffffffffbad79d38 (console_srcu){....}-{0:0}, at: console_flush_one_record+0x106/0x710 [ 10.400693][ T175] #3: ffffffffbac99660 (console_owner){....}-{0:0}, at: console_lock_spinning_enable+0x40/0x60 [ 10.400697][ T175] #4: ffffffffbac99560 (printk_legacy_map-wait-type-override){....}-{3:3}, at: console_emit_next_record+0x1df/0x4c0 [ 10.400701][ T175] irq event stamp: 21310 [ 10.400702][ T175] hardirqs last enabled at (21309): [] __down_trylock_console_sem+0x86/0xa0 [ 10.400705][ T175] hardirqs last disabled at (21310): [] console_emit_next_record+0x3d4/0x4c0 [ 10.400707][ T175] softirqs last enabled at (20772): [] handle_softirqs+0x67c/0x900 [ 10.400709][ T175] softirqs last disabled at (20765): [] __irq_exit_rcu+0x145/0x1c0 [ 10.400711][ T175] Preemption disabled at: [ 10.400712][ T175] [<0000000000000000>] 0x0 [ 10.400719][ T175] CPU: 2 UID: 0 PID: 175 Comm: ip Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 10.400722][ T175] Tainted: [W]=WARN [ 10.400723][ T175] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 10.400725][ T175] Call Trace: [ 10.400727][ T175] [ 10.400728][ T175] dump_stack_lvl+0x6f/0xa0 [ 10.400735][ T175] __might_resched.cold+0x1fe/0x2c1 [ 10.400740][ T175] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 10.400744][ T175] ? __kmalloc_noprof+0xdb/0x760 [ 10.400749][ T175] __kmalloc_noprof+0x443/0x760 [ 10.400751][ T175] ? alloc_buf.isra.0+0x4b/0x260 [ 10.400757][ T175] ? do_raw_spin_unlock+0x59/0x250 [ 10.400760][ T175] alloc_buf.isra.0+0x4b/0x260 [ 10.400763][ T175] put_chars+0x1e1/0x2f0 [ 10.400766][ T175] ? __send_to_port+0x420/0x420 [ 10.400768][ T175] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 10.400773][ T175] ? validate_chain+0x38b/0xc20 [ 10.400778][ T175] hvc_console_print+0x292/0x780 [ 10.400785][ T175] ? hvc_write+0x3a0/0x3a0 [ 10.400787][ T175] ? rcu_is_watching+0x16/0xd0 [ 10.400790][ T175] ? lock_acquire+0x13c/0x160 [ 10.400794][ T175] console_emit_next_record+0x22f/0x4c0 [ 10.400798][ T175] ? devkmsg_read+0x4b0/0x4b0 [ 10.400799][ T175] ? console_flush_one_record+0x106/0x710 [ 10.400803][ T175] ? rcu_is_watching+0x16/0xd0 [ 10.400805][ T175] ? lock_acquire+0x13c/0x160 [ 10.400809][ T175] console_flush_one_record+0x46f/0x710 [ 10.400813][ T175] ? console_emit_next_record+0x4c0/0x4c0 [ 10.400815][ T175] ? __lock_acquire+0x518/0xc20 [ 10.400820][ T175] console_unlock+0xee/0x1f0 [ 10.400823][ T175] ? console_flush_one_record+0x710/0x710 [ 10.400825][ T175] ? rcu_is_watching+0x16/0xd0 [ 10.400827][ T175] ? lock_acquire+0x60/0x160 [ 10.400830][ T175] ? __down_trylock_console_sem+0x5e/0xa0 [ 10.400832][ T175] ? vprintk_emit+0x320/0x3e0 [ 10.400836][ T175] vprintk_emit+0x37c/0x3e0 [ 10.400839][ T175] ? wake_up_klogd_work_func+0x90/0x90 [ 10.400843][ T175] ? __lock_acquire+0x518/0xc20 [ 10.400846][ T175] _printk+0xc7/0x100 [ 10.400850][ T175] ? snapshot_read.cold+0x21/0x21 [ 10.400853][ T175] ? do_raw_spin_lock+0x131/0x280 [ 10.400855][ T175] ? __rwlock_init+0x150/0x150 [ 10.400859][ T175] ? do_raw_spin_lock+0x131/0x280 [ 10.400862][ T175] do_exit.cold+0x82/0x9c [ 10.400865][ T175] ? exit_notify+0x890/0x890 [ 10.400867][ T175] ? __lock_release.isra.0+0x69/0x1a0 [ 10.400869][ T175] ? rcu_is_watching+0x16/0xd0 [ 10.400873][ T175] do_group_exit+0xb8/0x370 [ 10.400876][ T175] __x64_sys_exit_group+0x3c/0x50 [ 10.400878][ T175] x64_sys_call+0x1567/0x1570 [ 10.400881][ T175] do_syscall_64+0xff/0x530 [ 10.400885][ T175] ? exc_page_fault+0xee/0x100 [ 10.400887][ T175] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 10.400890][ T175] RIP: 0033:0x7f1bb16061b8 [ 10.400892][ T175] Code: Unable to access opcode bytes at 0x7f1bb160618e. [ 10.400893][ T175] RSP: 002b:00007ffddbb4b798 EFLAGS: 00000246 ORIG_RAX: 00000000000000e7 [ 10.400896][ T175] RAX: ffffffffffffffda RBX: 00007f1bb1736f88 RCX: 00007f1bb16061b8 [ 10.400897][ T175] RDX: 00007f1bb1350fc8 RSI: fffffffffffffeb8 RDI: 0000000000000000 [ 10.400898][ T175] RBP: 00007ffddbb4b7f0 R08: 0000000000000000 R09: 0000000000000050 [ 10.400899][ T175] R10: 00007ffddbb4b5b0 R11: 0000000000000246 R12: 0000000000000001 [ 10.400900][ T175] R13: 0000000000000000 R14: 00007f1bb1735680 R15: 00007f1bb1736fa0 [ 10.400906][ T175] [ 10.561974][ T178] PPP generic driver version 2.4.2 [ 13.970925][ T200] PPP BSD Compression module registered [ 13.970942][ T200] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 13.970944][ T200] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 200, name: modprobe [ 13.970946][ T200] preempt_count: 1, expected: 0 [ 13.970947][ T200] RCU nest depth: 0, expected: 0 [ 13.970948][ T200] locks held by modprobe/200: 4, last CPU#1: [ 13.970950][ T200] #0: ffffffffbad79cc0 (console_lock){+.+.}-{0:0}, at: vprintk_emit+0x320/0x3e0 [ 13.970967][ T200] #1: ffffffffbad79d38 (console_srcu){....}-{0:0}, at: console_flush_one_record+0x106/0x710 [ 13.970972][ T200] #2: ffffffffbac99660 (console_owner){....}-{0:0}, at: console_lock_spinning_enable+0x40/0x60 [ 13.970975][ T200] #3: ffffffffbac99560 (printk_legacy_map-wait-type-override){....}-{3:3}, at: console_emit_next_record+0x1df/0x4c0 [ 13.970979][ T200] irq event stamp: 18542 [ 13.970980][ T200] hardirqs last enabled at (18541): [] __down_trylock_console_sem+0x86/0xa0 [ 13.970982][ T200] hardirqs last disabled at (18542): [] console_emit_next_record+0x3d4/0x4c0 [ 13.970984][ T200] softirqs last enabled at (17462): [] handle_softirqs+0x67c/0x900 [ 13.970987][ T200] softirqs last disabled at (16505): [] __irq_exit_rcu+0x145/0x1c0 [ 13.970990][ T200] Preemption disabled at: [ 13.970990][ T200] [] vprintk_emit+0x31b/0x3e0 [ 13.970997][ T200] CPU: 1 UID: 0 PID: 200 Comm: modprobe Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 13.971003][ T200] Tainted: [W]=WARN [ 13.971004][ T200] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 13.971006][ T200] Call Trace: [ 13.971008][ T200] [ 13.971009][ T200] dump_stack_lvl+0x6f/0xa0 [ 13.971015][ T200] ? vprintk_emit+0x31b/0x3e0 [ 13.971017][ T200] __might_resched.cold+0x1fe/0x2c1 [ 13.971022][ T200] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 13.971026][ T200] ? __kmalloc_noprof+0xdb/0x760 [ 13.971031][ T200] __kmalloc_noprof+0x443/0x760 [ 13.971033][ T200] ? alloc_buf.isra.0+0x4b/0x260 [ 13.971039][ T200] ? do_raw_spin_unlock+0x59/0x250 [ 13.971042][ T200] alloc_buf.isra.0+0x4b/0x260 [ 13.971045][ T200] put_chars+0x1e1/0x2f0 [ 13.971048][ T200] ? __send_to_port+0x420/0x420 [ 13.971050][ T200] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 13.971054][ T200] ? rcu_read_lock_any_held+0x3c/0x90 [ 13.971057][ T200] ? validate_chain+0x38b/0xc20 [ 13.971061][ T200] hvc_console_print+0x292/0x780 [ 13.971064][ T200] ? __lock_acquire+0x518/0xc20 [ 13.971069][ T200] ? hvc_write+0x3a0/0x3a0 [ 13.971072][ T200] ? rcu_is_watching+0x16/0xd0 [ 13.971076][ T200] console_emit_next_record+0x22f/0x4c0 [ 13.971080][ T200] ? devkmsg_read+0x4b0/0x4b0 [ 13.971082][ T200] ? console_flush_one_record+0x106/0x710 [ 13.971085][ T200] ? rcu_is_watching+0x16/0xd0 [ 13.971087][ T200] ? lock_acquire+0x13c/0x160 [ 13.971091][ T200] console_flush_one_record+0x46f/0x710 [ 13.971095][ T200] ? console_emit_next_record+0x4c0/0x4c0 [ 13.971097][ T200] ? __lock_acquire+0x518/0xc20 [ 13.971102][ T200] console_unlock+0xee/0x1f0 [ 13.971105][ T200] ? console_flush_one_record+0x710/0x710 [ 13.971107][ T200] ? rcu_is_watching+0x16/0xd0 [ 13.971109][ T200] ? lock_acquire+0x60/0x160 [ 13.971112][ T200] ? __down_trylock_console_sem+0x5e/0xa0 [ 13.971114][ T200] ? vprintk_emit+0x320/0x3e0 [ 13.971117][ T200] vprintk_emit+0x37c/0x3e0 [ 13.971121][ T200] ? wake_up_klogd_work_func+0x90/0x90 [ 13.971126][ T200] ? ppp_cleanup+0x920/0x920 [ppp_generic] [ 13.971130][ T200] _printk+0xc7/0x100 [ 13.971133][ T200] ? snapshot_read.cold+0x21/0x21 [ 13.971138][ T200] ? ppp_cleanup+0x920/0x920 [ppp_generic] [ 13.971140][ T200] ? do_raw_spin_unlock+0x59/0x250 [ 13.971142][ T200] ? ppp_cleanup+0x920/0x920 [ppp_generic] [ 13.971145][ T200] ? do_raw_spin_unlock+0x59/0x250 [ 13.971147][ T200] bsdcomp_init+0x28/0x1000 [bsd_comp] [ 13.971150][ T200] do_one_initcall+0x124/0x4f0 [ 13.971153][ T200] ? trace_event_raw_event_initcall_level+0x280/0x280 [ 13.971158][ T200] ? do_init_module+0xae/0x8a0 [ 13.971161][ T200] ? kasan_unpoison+0x44/0x70 [ 13.971165][ T200] do_init_module+0x2ad/0x8a0 [ 13.971169][ T200] ? lockdep_hardirqs_on+0x91/0x130 [ 13.971173][ T200] ? free_module+0x470/0x470 [ 13.971176][ T200] ? kfree+0x123/0x590 [ 13.971180][ T200] load_module+0x1424/0x1bb0 [ 13.971186][ T200] ? layout_and_allocate.isra.0+0x680/0x680 [ 13.971190][ T200] ? __ia32_sys_fsconfig+0x180/0x180 [ 13.971193][ T200] ? ovl_real_file+0x172/0x1e0 [ 13.971196][ T200] ? find_held_lock+0x2b/0x80 [ 13.971198][ T200] ? backing_file_read_iter+0x541/0x790 [ 13.971201][ T200] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 13.971205][ T200] init_module_from_file+0x11f/0x1a0 [ 13.971208][ T200] ? __do_sys_init_module+0x220/0x220 [ 13.971216][ T200] ? __rwlock_init+0x150/0x150 [ 13.971220][ T200] ? do_raw_spin_unlock+0x59/0x250 [ 13.971223][ T200] idempotent_init_module+0x37b/0x7c0 [ 13.971227][ T200] ? init_module_from_file+0x1a0/0x1a0 [ 13.971233][ T200] ? rcu_is_watching+0x16/0xd0 [ 13.971235][ T200] ? cap_capable+0x1d7/0x3d0 [ 13.971241][ T200] __x64_sys_finit_module+0xdf/0x190 [ 13.971243][ T200] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 13.971246][ T200] do_syscall_64+0xff/0x530 [ 13.971249][ T200] ? exc_page_fault+0xee/0x100 [ 13.971251][ T200] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 13.971253][ T200] RIP: 0033:0x7f7844efc37d [ 13.971257][ T200] 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.971258][ T200] RSP: 002b:00007ffd444c6dd8 EFLAGS: 00000246 ORIG_RAX: 0000000000000139 [ 13.971261][ T200] RAX: ffffffffffffffda RBX: 000055d178230810 RCX: 00007f7844efc37d [ 13.971262][ T200] RDX: 0000000000000000 RSI: 000055d16163bffd RDI: 0000000000000000 [ 13.971263][ T200] RBP: 00007ffd444c6e70 R08: 0000000000000000 R09: 0000000000000000 [ 13.971264][ T200] R10: 0000000000000000 R11: 0000000000000246 R12: 000055d16163bffd [ 13.971264][ T200] R13: 000055d1782309e0 R14: 0000000000040000 R15: 0000000000000000 [ 13.971271][ T200] [ 14.064468][ T201] PPP Deflate Compression module registered [ 18.622484][ T226] iperf3 (226) used greatest stack depth: 23264 bytes left [ 18.622505][ T226] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 18.622508][ T226] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 226, name: iperf3 [ 18.622509][ T226] preempt_count: 2, expected: 0 [ 18.622510][ T226] RCU nest depth: 0, expected: 0 [ 18.622511][ T226] locks held by iperf3/226: 5, last CPU#0: [ 18.622513][ T226] #0: ffffffffbac127b8 (low_water_lock){+.+.}-{3:3}, at: do_exit+0x887/0xdc0 [ 18.622525][ T226] #1: ffffffffbad79cc0 (console_lock){+.+.}-{0:0}, at: vprintk_emit+0x320/0x3e0 [ 18.622530][ T226] #2: ffffffffbad79d38 (console_srcu){....}-{0:0}, at: console_flush_one_record+0x106/0x710 [ 18.622534][ T226] #3: ffffffffbac99660 (console_owner){....}-{0:0}, at: console_lock_spinning_enable+0x40/0x60 [ 18.622538][ T226] #4: ffffffffbac99560 (printk_legacy_map-wait-type-override){....}-{3:3}, at: console_emit_next_record+0x1df/0x4c0 [ 18.622542][ T226] irq event stamp: 853444 [ 18.622543][ T226] hardirqs last enabled at (853443): [] __down_trylock_console_sem+0x86/0xa0 [ 18.622545][ T226] hardirqs last disabled at (853444): [] console_emit_next_record+0x3d4/0x4c0 [ 18.622547][ T226] softirqs last enabled at (851830): [] handle_softirqs+0x67c/0x900 [ 18.622550][ T226] softirqs last disabled at (851823): [] __irq_exit_rcu+0x145/0x1c0 [ 18.622552][ T226] Preemption disabled at: [ 18.622553][ T226] [<0000000000000000>] 0x0 [ 18.622560][ T226] CPU: 0 UID: 0 PID: 226 Comm: iperf3 Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 18.622563][ T226] Tainted: [W]=WARN [ 18.622564][ T226] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 18.622566][ T226] Call Trace: [ 18.622567][ T226] [ 18.622569][ T226] dump_stack_lvl+0x6f/0xa0 [ 18.622575][ T226] __might_resched.cold+0x1fe/0x2c1 [ 18.622580][ T226] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 18.622584][ T226] ? __kmalloc_noprof+0xdb/0x760 [ 18.622589][ T226] __kmalloc_noprof+0x443/0x760 [ 18.622591][ T226] ? alloc_buf.isra.0+0x4b/0x260 [ 18.622597][ T226] ? do_raw_spin_unlock+0x59/0x250 [ 18.622600][ T226] alloc_buf.isra.0+0x4b/0x260 [ 18.622603][ T226] put_chars+0x1e1/0x2f0 [ 18.622605][ T226] ? prb_final_commit+0x50/0x50 [ 18.622608][ T226] ? __send_to_port+0x420/0x420 [ 18.622611][ T226] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 18.622616][ T226] ? rcu_read_lock_any_held+0x3c/0x90 [ 18.622618][ T226] ? validate_chain+0x38b/0xc20 [ 18.622622][ T226] hvc_console_print+0x292/0x780 [ 18.622625][ T226] ? mark_usage+0x61/0x170 [ 18.622627][ T226] ? __lock_acquire+0x518/0xc20 [ 18.622628][ T226] ? __lock_acquire+0x518/0xc20 [ 18.622632][ T226] ? hvc_write+0x3a0/0x3a0 [ 18.622634][ T226] ? console_emit_next_record+0x1df/0x4c0 [ 18.622638][ T226] ? rcu_is_watching+0x16/0xd0 [ 18.622640][ T226] ? lock_acquire+0x13c/0x160 [ 18.622644][ T226] console_emit_next_record+0x22f/0x4c0 [ 18.622648][ T226] ? devkmsg_read+0x4b0/0x4b0 [ 18.622650][ T226] ? console_flush_one_record+0x106/0x710 [ 18.622653][ T226] ? rcu_is_watching+0x16/0xd0 [ 18.622655][ T226] ? lock_acquire+0x13c/0x160 [ 18.622659][ T226] console_flush_one_record+0x46f/0x710 [ 18.622663][ T226] ? console_emit_next_record+0x4c0/0x4c0 [ 18.622665][ T226] ? __lock_acquire+0x518/0xc20 [ 18.622670][ T226] console_unlock+0xee/0x1f0 [ 18.622673][ T226] ? console_flush_one_record+0x710/0x710 [ 18.622675][ T226] ? rcu_is_watching+0x16/0xd0 [ 18.622677][ T226] ? lock_acquire+0x60/0x160 [ 18.622681][ T226] ? __down_trylock_console_sem+0x5e/0xa0 [ 18.622682][ T226] ? vprintk_emit+0x320/0x3e0 [ 18.622686][ T226] vprintk_emit+0x37c/0x3e0 [ 18.622690][ T226] ? wake_up_klogd_work_func+0x90/0x90 [ 18.622693][ T226] ? __lock_acquire+0x518/0xc20 [ 18.622697][ T226] _printk+0xc7/0x100 [ 18.622700][ T226] ? snapshot_read.cold+0x21/0x21 [ 18.622703][ T226] ? do_raw_spin_lock+0x131/0x280 [ 18.622706][ T226] ? __rwlock_init+0x150/0x150 [ 18.622709][ T226] ? do_raw_spin_lock+0x131/0x280 [ 18.622712][ T226] do_exit.cold+0x82/0x9c [ 18.622716][ T226] ? exit_notify+0x890/0x890 [ 18.622721][ T226] __x64_sys_exit+0x42/0x50 [ 18.622723][ T226] x64_sys_call+0x156c/0x1570 [ 18.622726][ T226] do_syscall_64+0xff/0x530 [ 18.622730][ T226] ? exc_page_fault+0xee/0x100 [ 18.622733][ T226] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 18.622735][ T226] RIP: 0033:0x7f3c5f0c6c49 [ 18.622737][ T226] Code: Unable to access opcode bytes at 0x7f3c5f0c6c1f. [ 18.622738][ T226] RSP: 002b:00007f3c5e885e60 EFLAGS: 00000246 ORIG_RAX: 000000000000003c [ 18.622741][ T226] RAX: ffffffffffffffda RBX: 00007f3c5e8866c0 RCX: 00007f3c5f0c6c49 [ 18.622742][ T226] RDX: 0000000000000000 RSI: 0000000000801000 RDI: 0000000000000000 [ 18.622743][ T226] RBP: 00007f3c5e885f70 R08: 0000000000000001 R09: 00007f3c5e8866c0 [ 18.622744][ T226] R10: 0000000000000008 R11: 0000000000000246 R12: 00007f3c5e086000 [ 18.622745][ T226] R13: 00007ffd5e2f75f0 R14: 0000000000000002 R15: 00007ffd5e2f76f7 [ 18.622751][ T226]