[ 30.160591][ T826] mptcp_connect (826) used greatest stack depth: 23160 bytes left [ 30.160612][ T826] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 30.160614][ T826] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 826, name: mptcp_connect [ 30.160616][ T826] preempt_count: 2, expected: 0 [ 30.160617][ T826] RCU nest depth: 0, expected: 0 [ 30.160618][ T826] locks held by mptcp_connect/826: 5, last CPU#0: [ 30.160620][ T826] #0: ffffffff962267b8 (low_water_lock){+.+.}-{3:3}, at: do_exit+0x887/0xdc0 [ 30.160632][ T826] #1: ffffffff9638dcc0 (console_lock){+.+.}-{0:0}, at: vprintk_emit+0x320/0x3e0 [ 30.160638][ T826] #2: ffffffff9638dd38 (console_srcu){....}-{0:0}, at: console_flush_one_record+0x106/0x710 [ 30.160642][ T826] #3: ffffffff962ad660 (console_owner){....}-{0:0}, at: console_lock_spinning_enable+0x40/0x60 [ 30.160645][ T826] #4: ffffffff962ad560 (printk_legacy_map-wait-type-override){....}-{3:3}, at: console_emit_next_record+0x1df/0x4c0 [ 30.160649][ T826] irq event stamp: 165436 [ 30.160650][ T826] hardirqs last enabled at (165435): [] __down_trylock_console_sem+0x86/0xa0 [ 30.160652][ T826] hardirqs last disabled at (165436): [] console_emit_next_record+0x3d4/0x4c0 [ 30.160654][ T826] softirqs last enabled at (165134): [] handle_softirqs+0x67c/0x900 [ 30.160655][ T826] softirqs last disabled at (165035): [] __irq_exit_rcu+0x145/0x1c0 [ 30.160658][ T826] Preemption disabled at: [ 30.160658][ T826] [<0000000000000000>] 0x0 [ 30.160665][ T826] CPU: 0 UID: 0 PID: 826 Comm: mptcp_connect Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 30.160668][ T826] Tainted: [W]=WARN [ 30.160669][ T826] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 30.160671][ T826] Call Trace: [ 30.160673][ T826] [ 30.160674][ T826] dump_stack_lvl+0x6f/0xa0 [ 30.160680][ T826] __might_resched.cold+0x1fe/0x2c1 [ 30.160685][ T826] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 30.160688][ T826] ? __kmalloc_noprof+0xdb/0x760 [ 30.160693][ T826] __kmalloc_noprof+0x443/0x760 [ 30.160695][ T826] ? alloc_buf.isra.0+0x4b/0x260 [ 30.160702][ T826] ? do_raw_spin_unlock+0x59/0x250 [ 30.160704][ T826] alloc_buf.isra.0+0x4b/0x260 [ 30.160708][ T826] put_chars+0x1e1/0x2f0 [ 30.160711][ T826] ? __send_to_port+0x420/0x420 [ 30.160713][ T826] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 30.160717][ T826] ? validate_chain+0x38b/0xc20 [ 30.160722][ T826] hvc_console_print+0x292/0x780 [ 30.160730][ T826] ? hvc_write+0x3a0/0x3a0 [ 30.160732][ T826] ? rcu_is_watching+0x16/0xd0 [ 30.160734][ T826] ? lock_acquire+0x13c/0x160 [ 30.160738][ T826] console_emit_next_record+0x22f/0x4c0 [ 30.160742][ T826] ? devkmsg_read+0x4b0/0x4b0 [ 30.160743][ T826] ? console_flush_one_record+0x106/0x710 [ 30.160746][ T826] ? rcu_is_watching+0x16/0xd0 [ 30.160748][ T826] ? lock_acquire+0x13c/0x160 [ 30.160752][ T826] console_flush_one_record+0x46f/0x710 [ 30.160756][ T826] ? console_emit_next_record+0x4c0/0x4c0 [ 30.160757][ T826] ? __lock_acquire+0x518/0xc20 [ 30.160763][ T826] console_unlock+0xee/0x1f0 [ 30.160765][ T826] ? console_flush_one_record+0x710/0x710 [ 30.160767][ T826] ? rcu_is_watching+0x16/0xd0 [ 30.160769][ T826] ? lock_acquire+0x60/0x160 [ 30.160772][ T826] ? __down_trylock_console_sem+0x5e/0xa0 [ 30.160774][ T826] ? vprintk_emit+0x320/0x3e0 [ 30.160777][ T826] vprintk_emit+0x37c/0x3e0 [ 30.160780][ T826] ? wake_up_klogd_work_func+0x90/0x90 [ 30.160783][ T826] ? __lock_acquire+0x518/0xc20 [ 30.160787][ T826] _printk+0xc7/0x100 [ 30.160791][ T826] ? snapshot_read.cold+0x21/0x21 [ 30.160793][ T826] ? do_raw_spin_lock+0x131/0x280 [ 30.160796][ T826] ? __rwlock_init+0x150/0x150 [ 30.160799][ T826] ? do_raw_spin_lock+0x131/0x280 [ 30.160802][ T826] do_exit.cold+0x82/0x9c [ 30.160805][ T826] ? exit_notify+0x890/0x890 [ 30.160807][ T826] ? __lock_release.isra.0+0x69/0x1a0 [ 30.160809][ T826] ? rcu_is_watching+0x16/0xd0 [ 30.160813][ T826] do_group_exit+0xb8/0x370 [ 30.160816][ T826] __x64_sys_exit_group+0x3c/0x50 [ 30.160819][ T826] x64_sys_call+0x1567/0x1570 [ 30.160820][ T826] do_syscall_64+0xff/0x530 [ 30.160824][ T826] ? exc_page_fault+0xee/0x100 [ 30.160827][ T826] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 30.160830][ T826] RIP: 0033:0x7fa8dce051b8 [ 30.160832][ T826] Code: Unable to access opcode bytes at 0x7fa8dce0518e. [ 30.160833][ T826] RSP: 002b:00007ffe93add088 EFLAGS: 00000246 ORIG_RAX: 00000000000000e7 [ 30.160836][ T826] RAX: ffffffffffffffda RBX: 00007fa8dcf35f88 RCX: 00007fa8dce051b8 [ 30.160837][ T826] RDX: 00007fa8dcd42a48 RSI: ffffffffffffffb0 RDI: 0000000000000000 [ 30.160838][ T826] RBP: 00007ffe93add0e0 R08: 0000000000000000 R09: 0000000000000000 [ 30.160839][ T826] R10: 00007ffe93adcf20 R11: 0000000000000246 R12: 0000000000000001 [ 30.160840][ T826] R13: 0000000000000000 R14: 00007fa8dcf34680 R15: 00007fa8dcf35fa0 [ 30.160846][ T826] [ 73.037238][ T1587] mptcp_connect (1587) used greatest stack depth: 22856 bytes left [ 73.037272][ T1587] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 73.037277][ T1587] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 1587, name: mptcp_connect [ 73.037281][ T1587] preempt_count: 2, expected: 0 [ 73.037283][ T1587] RCU nest depth: 0, expected: 0 [ 73.037286][ T1587] locks held by mptcp_connect/1587: 5, last CPU#1: [ 73.037290][ T1587] #0: ffffffff962267b8 (low_water_lock){+.+.}-{3:3}, at: do_exit+0x887/0xdc0 [ 73.037306][ T1587] #1: ffffffff9638dcc0 (console_lock){+.+.}-{0:0}, at: vprintk_emit+0x320/0x3e0 [ 73.037318][ T1587] #2: ffffffff9638dd38 (console_srcu){....}-{0:0}, at: console_flush_one_record+0x106/0x710 [ 73.037330][ T1587] #3: ffffffff962ad660 (console_owner){....}-{0:0}, at: console_lock_spinning_enable+0x40/0x60 [ 73.037343][ T1587] #4: ffffffff962ad560 (printk_legacy_map-wait-type-override){....}-{3:3}, at: console_emit_next_record+0x1df/0x4c0 [ 73.037355][ T1587] irq event stamp: 327774 [ 73.037359][ T1587] hardirqs last enabled at (327773): [] __down_trylock_console_sem+0x86/0xa0 [ 73.037364][ T1587] hardirqs last disabled at (327774): [] console_emit_next_record+0x3d4/0x4c0 [ 73.037367][ T1587] softirqs last enabled at (327428): [] handle_softirqs+0x67c/0x900 [ 73.037374][ T1587] softirqs last disabled at (327423): [] __irq_exit_rcu+0x145/0x1c0 [ 73.037381][ T1587] Preemption disabled at: [ 73.037383][ T1587] [<0000000000000000>] 0x0 [ 73.037397][ T1587] CPU: 1 UID: 0 PID: 1587 Comm: mptcp_connect Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 73.037403][ T1587] Tainted: [W]=WARN [ 73.037405][ T1587] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 73.037409][ T1587] Call Trace: [ 73.037414][ T1587] [ 73.037419][ T1587] dump_stack_lvl+0x6f/0xa0 [ 73.037432][ T1587] __might_resched.cold+0x1fe/0x2c1 [ 73.037444][ T1587] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 73.037455][ T1587] ? __kmalloc_noprof+0xdb/0x760 [ 73.037467][ T1587] __kmalloc_noprof+0x443/0x760 [ 73.037477][ T1587] ? alloc_buf.isra.0+0x4b/0x260 [ 73.037493][ T1587] ? do_raw_spin_unlock+0x59/0x250 [ 73.037499][ T1587] alloc_buf.isra.0+0x4b/0x260 [ 73.037511][ T1587] put_chars+0x1e1/0x2f0 [ 73.037520][ T1587] ? __send_to_port+0x420/0x420 [ 73.037526][ T1587] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 73.037538][ T1587] ? validate_chain+0x38b/0xc20 [ 73.037553][ T1587] hvc_console_print+0x292/0x780 [ 73.037573][ T1587] ? hvc_write+0x3a0/0x3a0 [ 73.037582][ T1587] ? rcu_is_watching+0x16/0xd0 [ 73.037592][ T1587] ? lock_acquire+0x13c/0x160 [ 73.037601][ T1587] console_emit_next_record+0x22f/0x4c0 [ 73.037614][ T1587] ? devkmsg_read+0x4b0/0x4b0 [ 73.037620][ T1587] ? console_flush_one_record+0x106/0x710 [ 73.037629][ T1587] ? rcu_is_watching+0x16/0xd0 [ 73.037635][ T1587] ? lock_acquire+0x13c/0x160 [ 73.037648][ T1587] console_flush_one_record+0x46f/0x710 [ 73.037660][ T1587] ? console_emit_next_record+0x4c0/0x4c0 [ 73.037667][ T1587] ? __lock_acquire+0x518/0xc20 [ 73.037679][ T1587] console_unlock+0xee/0x1f0 [ 73.037689][ T1587] ? console_flush_one_record+0x710/0x710 [ 73.037694][ T1587] ? rcu_is_watching+0x16/0xd0 [ 73.037702][ T1587] ? lock_acquire+0x60/0x160 [ 73.037712][ T1587] ? __down_trylock_console_sem+0x5e/0xa0 [ 73.037718][ T1587] ? vprintk_emit+0x320/0x3e0 [ 73.037728][ T1587] vprintk_emit+0x37c/0x3e0 [ 73.037740][ T1587] ? wake_up_klogd_work_func+0x90/0x90 [ 73.037745][ T1587] ? do_raw_spin_unlock+0x59/0x250 [ 73.037753][ T1587] ? __lock_acquire+0x518/0xc20 [ 73.037764][ T1587] _printk+0xc7/0x100 [ 73.037776][ T1587] ? snapshot_read.cold+0x21/0x21 [ 73.037786][ T1587] ? do_raw_spin_lock+0x131/0x280 [ 73.037794][ T1587] ? __rwlock_init+0x150/0x150 [ 73.037806][ T1587] ? do_raw_spin_lock+0x131/0x280 [ 73.037816][ T1587] do_exit.cold+0x82/0x9c [ 73.037825][ T1587] ? exit_notify+0x890/0x890 [ 73.037832][ T1587] ? __lock_release.isra.0+0x69/0x1a0 [ 73.037841][ T1587] ? rcu_is_watching+0x16/0xd0 [ 73.037850][ T1587] do_group_exit+0xb8/0x370 [ 73.037862][ T1587] __x64_sys_exit_group+0x3c/0x50 [ 73.037870][ T1587] x64_sys_call+0x1567/0x1570 [ 73.037877][ T1587] do_syscall_64+0xff/0x530 [ 73.037883][ T1587] ? exc_page_fault+0xee/0x100 [ 73.037894][ T1587] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 73.037901][ T1587] RIP: 0033:0x7f6d8215e1b8 [ 73.037909][ T1587] Code: Unable to access opcode bytes at 0x7f6d8215e18e. [ 73.037913][ T1587] RSP: 002b:00007fffb5cd3528 EFLAGS: 00000246 ORIG_RAX: 00000000000000e7 [ 73.037917][ T1587] RAX: ffffffffffffffda RBX: 00007f6d8228ef88 RCX: 00007f6d8215e1b8 [ 73.037919][ T1587] RDX: 00007f6d8209ba48 RSI: ffffffffffffffb0 RDI: 0000000000000000 [ 73.037923][ T1587] RBP: 00007fffb5cd3580 R08: 0000000000000000 R09: 0000000000000000 [ 73.037926][ T1587] R10: 00007fffb5cd33c0 R11: 0000000000000246 R12: 0000000000000001 [ 73.037928][ T1587] R13: 0000000000000000 R14: 00007f6d8228d680 R15: 00007f6d8228efa0 [ 73.037945][ T1587]