[ 11.477999][ T204] ip (204) used greatest stack depth: 23864 bytes left [ 11.478021][ T204] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 11.478023][ T204] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 204, name: ip [ 11.478026][ T204] preempt_count: 2, expected: 0 [ 11.478027][ T204] RCU nest depth: 0, expected: 0 [ 11.478029][ T204] locks held by ip/204: 5, last CPU#3: [ 11.478031][ T204] #0: ffffffff988167b8 (low_water_lock){+.+.}-{3:3}, at: do_exit+0x887/0xdc0 [ 11.478046][ T204] #1: ffffffff9897ddc0 (console_lock){+.+.}-{0:0}, at: vprintk_emit+0x320/0x3e0 [ 11.478052][ T204] #2: ffffffff9897de38 (console_srcu){....}-{0:0}, at: console_flush_one_record+0x106/0x710 [ 11.478059][ T204] #3: ffffffff9889d760 (console_owner){....}-{0:0}, at: console_lock_spinning_enable+0x40/0x60 [ 11.478065][ T204] #4: ffffffff9889d660 (printk_legacy_map-wait-type-override){....}-{3:3}, at: console_emit_next_record+0x1df/0x4c0 [ 11.478071][ T204] irq event stamp: 30402 [ 11.478073][ T204] hardirqs last enabled at (30401): [] __down_trylock_console_sem+0x86/0xa0 [ 11.478077][ T204] hardirqs last disabled at (30402): [] console_emit_next_record+0x3d4/0x4c0 [ 11.478080][ T204] softirqs last enabled at (29184): [] handle_softirqs+0x67c/0x900 [ 11.478083][ T204] softirqs last disabled at (29175): [] __irq_exit_rcu+0x145/0x1c0 [ 11.478087][ T204] Preemption disabled at: [ 11.478088][ T204] [<0000000000000000>] 0x0 [ 11.478096][ T204] CPU: 3 UID: 0 PID: 204 Comm: ip Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 11.478101][ T204] Tainted: [W]=WARN [ 11.478102][ T204] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 11.478104][ T204] Call Trace: [ 11.478106][ T204] [ 11.478109][ T204] dump_stack_lvl+0x6f/0xa0 [ 11.478117][ T204] __might_resched.cold+0x1fe/0x2c1 [ 11.478123][ T204] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 11.478129][ T204] ? __kmalloc_noprof+0xdb/0x760 [ 11.478136][ T204] __kmalloc_noprof+0x443/0x760 [ 11.478139][ T204] ? alloc_buf.isra.0+0x4b/0x260 [ 11.478154][ T204] ? do_raw_spin_unlock+0x59/0x250 [ 11.478157][ T204] alloc_buf.isra.0+0x4b/0x260 [ 11.478164][ T204] put_chars+0x1e1/0x2f0 [ 11.478168][ T204] ? __send_to_port+0x420/0x420 [ 11.478170][ T204] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 11.478176][ T204] ? validate_chain+0x38b/0xc20 [ 11.478185][ T204] hvc_console_print+0x292/0x780 [ 11.478199][ T204] ? hvc_write+0x3a0/0x3a0 [ 11.478204][ T204] ? rcu_is_watching+0x16/0xd0 [ 11.478207][ T204] ? lock_acquire+0x13c/0x160 [ 11.478215][ T204] console_emit_next_record+0x22f/0x4c0 [ 11.478222][ T204] ? devkmsg_read+0x4b0/0x4b0 [ 11.478224][ T204] ? console_flush_one_record+0x106/0x710 [ 11.478230][ T204] ? rcu_is_watching+0x16/0xd0 [ 11.478233][ T204] ? lock_acquire+0x13c/0x160 [ 11.478240][ T204] console_flush_one_record+0x46f/0x710 [ 11.478247][ T204] ? console_emit_next_record+0x4c0/0x4c0 [ 11.478250][ T204] ? __lock_acquire+0x518/0xc20 [ 11.478259][ T204] console_unlock+0xee/0x1f0 [ 11.478264][ T204] ? console_flush_one_record+0x710/0x710 [ 11.478267][ T204] ? rcu_is_watching+0x16/0xd0 [ 11.478270][ T204] ? lock_acquire+0xe0/0x160 [ 11.478277][ T204] ? __down_trylock_console_sem+0x5e/0xa0 [ 11.478280][ T204] ? vprintk_emit+0x320/0x3e0 [ 11.478285][ T204] vprintk_emit+0x37c/0x3e0 [ 11.478290][ T204] ? wake_up_klogd_work_func+0x90/0x90 [ 11.478296][ T204] ? __lock_acquire+0x518/0xc20 [ 11.478302][ T204] _printk+0xc7/0x100 [ 11.478307][ T204] ? snapshot_read.cold+0x21/0x21 [ 11.478312][ T204] ? do_raw_spin_lock+0x131/0x280 [ 11.478316][ T204] ? __rwlock_init+0x150/0x150 [ 11.478323][ T204] ? do_raw_spin_lock+0x131/0x280 [ 11.478327][ T204] do_exit.cold+0x82/0x9c [ 11.478333][ T204] ? exit_notify+0x890/0x890 [ 11.478335][ T204] ? __lock_release.isra.0+0x69/0x1a0 [ 11.478339][ T204] ? rcu_is_watching+0x16/0xd0 [ 11.478346][ T204] do_group_exit+0xb8/0x370 [ 11.478351][ T204] __x64_sys_exit_group+0x3c/0x50 [ 11.478354][ T204] x64_sys_call+0x1567/0x1570 [ 11.478357][ T204] do_syscall_64+0xff/0x530 [ 11.478362][ T204] ? exc_page_fault+0xee/0x100 [ 11.478366][ T204] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 11.478370][ T204] RIP: 0033:0x7f4c10a811b8 [ 11.478373][ T204] Code: Unable to access opcode bytes at 0x7f4c10a8118e. [ 11.478374][ T204] RSP: 002b:00007ffe2cca7e28 EFLAGS: 00000246 ORIG_RAX: 00000000000000e7 [ 11.478377][ T204] RAX: ffffffffffffffda RBX: 00007f4c10bb1f88 RCX: 00007f4c10a811b8 [ 11.478379][ T204] RDX: 00007f4c107cbfc8 RSI: fffffffffffffeb8 RDI: 0000000000000000 [ 11.478381][ T204] RBP: 00007ffe2cca7e80 R08: 0000000000000000 R09: 0000000000000050 [ 11.478382][ T204] R10: 00007ffe2cca7c40 R11: 0000000000000246 R12: 0000000000000001 [ 11.478384][ T204] R13: 0000000000000000 R14: 00007f4c10bb0680 R15: 00007f4c10bb1fa0 [ 11.478397][ T204] [ 187.916079][ T9601] iperf3 (9601) used greatest stack depth: 23840 bytes left [ 187.916103][ T9601] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 187.916106][ T9601] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 9601, name: iperf3 [ 187.916108][ T9601] preempt_count: 2, expected: 0 [ 187.916110][ T9601] RCU nest depth: 0, expected: 0 [ 187.916111][ T9601] locks held by iperf3/9601: 5, last CPU#3: [ 187.916114][ T9601] #0: ffffffff988167b8 (low_water_lock){+.+.}-{3:3}, at: do_exit+0x887/0xdc0 [ 187.916129][ T9601] #1: ffffffff9897ddc0 (console_lock){+.+.}-{0:0}, at: vprintk_emit+0x320/0x3e0 [ 187.916137][ T9601] #2: ffffffff9897de38 (console_srcu){....}-{0:0}, at: console_flush_one_record+0x106/0x710 [ 187.916144][ T9601] #3: ffffffff9889d760 (console_owner){....}-{0:0}, at: console_lock_spinning_enable+0x40/0x60 [ 187.916150][ T9601] #4: ffffffff9889d660 (printk_legacy_map-wait-type-override){....}-{3:3}, at: console_emit_next_record+0x1df/0x4c0 [ 187.916157][ T9601] irq event stamp: 21098 [ 187.916158][ T9601] hardirqs last enabled at (21097): [] __down_trylock_console_sem+0x86/0xa0 [ 187.916162][ T9601] hardirqs last disabled at (21098): [] console_emit_next_record+0x3d4/0x4c0 [ 187.916165][ T9601] softirqs last enabled at (16868): [] handle_softirqs+0x67c/0x900 [ 187.916168][ T9601] softirqs last disabled at (16857): [] __irq_exit_rcu+0x145/0x1c0 [ 187.916172][ T9601] Preemption disabled at: [ 187.916173][ T9601] [<0000000000000000>] 0x0 [ 187.916181][ T9601] CPU: 3 UID: 0 PID: 9601 Comm: iperf3 Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 187.916186][ T9601] Tainted: [W]=WARN [ 187.916187][ T9601] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 187.916194][ T9601] Call Trace: [ 187.916196][ T9601] [ 187.916199][ T9601] dump_stack_lvl+0x6f/0xa0 [ 187.916207][ T9601] __might_resched.cold+0x1fe/0x2c1 [ 187.916214][ T9601] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 187.916220][ T9601] ? __kmalloc_noprof+0xdb/0x760 [ 187.916227][ T9601] __kmalloc_noprof+0x443/0x760 [ 187.916230][ T9601] ? alloc_buf.isra.0+0x4b/0x260 [ 187.916241][ T9601] ? do_raw_spin_unlock+0x59/0x250 [ 187.916245][ T9601] alloc_buf.isra.0+0x4b/0x260 [ 187.916251][ T9601] put_chars+0x1e1/0x2f0 [ 187.916255][ T9601] ? __send_to_port+0x420/0x420 [ 187.916257][ T9601] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 187.916263][ T9601] ? validate_chain+0x38b/0xc20 [ 187.916273][ T9601] hvc_console_print+0x292/0x780 [ 187.916285][ T9601] ? hvc_write+0x3a0/0x3a0 [ 187.916289][ T9601] ? rcu_is_watching+0x16/0xd0 [ 187.916292][ T9601] ? lock_acquire+0x13c/0x160 [ 187.916300][ T9601] console_emit_next_record+0x22f/0x4c0 [ 187.916306][ T9601] ? devkmsg_read+0x4b0/0x4b0 [ 187.916309][ T9601] ? console_flush_one_record+0x106/0x710 [ 187.916315][ T9601] ? rcu_is_watching+0x16/0xd0 [ 187.916318][ T9601] ? lock_acquire+0x13c/0x160 [ 187.916325][ T9601] console_flush_one_record+0x46f/0x710 [ 187.916332][ T9601] ? console_emit_next_record+0x4c0/0x4c0 [ 187.916335][ T9601] ? __lock_acquire+0x518/0xc20 [ 187.916345][ T9601] console_unlock+0xee/0x1f0 [ 187.916350][ T9601] ? console_flush_one_record+0x710/0x710 [ 187.916353][ T9601] ? rcu_is_watching+0x16/0xd0 [ 187.916356][ T9601] ? lock_acquire+0xe0/0x160 [ 187.916363][ T9601] ? __down_trylock_console_sem+0x5e/0xa0 [ 187.916366][ T9601] ? vprintk_emit+0x320/0x3e0 [ 187.916371][ T9601] vprintk_emit+0x37c/0x3e0 [ 187.916377][ T9601] ? wake_up_klogd_work_func+0x90/0x90 [ 187.916382][ T9601] ? __lock_acquire+0x518/0xc20 [ 187.916389][ T9601] _printk+0xc7/0x100 [ 187.916394][ T9601] ? snapshot_read.cold+0x21/0x21 [ 187.916398][ T9601] ? do_raw_spin_lock+0x131/0x280 [ 187.916403][ T9601] ? __rwlock_init+0x150/0x150 [ 187.916410][ T9601] ? do_raw_spin_lock+0x131/0x280 [ 187.916414][ T9601] do_exit.cold+0x82/0x9c [ 187.916420][ T9601] ? exit_notify+0x890/0x890 [ 187.916422][ T9601] ? __lock_release.isra.0+0x69/0x1a0 [ 187.916427][ T9601] ? rcu_is_watching+0x16/0xd0 [ 187.916434][ T9601] do_group_exit+0xb8/0x370 [ 187.916439][ T9601] __x64_sys_exit_group+0x3c/0x50 [ 187.916442][ T9601] x64_sys_call+0x1567/0x1570 [ 187.916446][ T9601] do_syscall_64+0xff/0x530 [ 187.916451][ T9601] ? exc_page_fault+0xee/0x100 [ 187.916456][ T9601] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 187.916459][ T9601] RIP: 0033:0x7f820d6581b8 [ 187.916462][ T9601] Code: Unable to access opcode bytes at 0x7f820d65818e. [ 187.916464][ T9601] RSP: 002b:00007ffed112bc08 EFLAGS: 00000246 ORIG_RAX: 00000000000000e7 [ 187.916468][ T9601] RAX: ffffffffffffffda RBX: 00007f820d788f88 RCX: 00007f820d6581b8 [ 187.916470][ T9601] RDX: 00007f820cdee3c8 RSI: ffffffffffffffb0 RDI: 0000000000000001 [ 187.916471][ T9601] RBP: 00007ffed112bc60 R08: 0000000000000000 R09: 0000000000000000 [ 187.916473][ T9601] R10: 00007ffed112ba40 R11: 0000000000000246 R12: 0000000000000001 [ 187.916474][ T9601] R13: 0000000000000001 R14: 00007f820d787680 R15: 00007f820d788fa0 [ 187.916487][ T9601]