[ 9.482652][ T198] ip (198) used greatest stack depth: 24096 bytes left [ 9.482668][ T198] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 9.482670][ T198] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 198, name: ip [ 9.482671][ T198] preempt_count: 2, expected: 0 [ 9.482672][ T198] RCU nest depth: 0, expected: 0 [ 9.482673][ T198] locks held by ip/198: 5, last CPU#3: [ 9.482675][ T198] #0: ffffffff8b0167b8 (low_water_lock){+.+.}-{3:3}, at: do_exit+0x887/0xdc0 [ 9.482686][ T198] #1: ffffffff8b17ddc0 (console_lock){+.+.}-{0:0}, at: vprintk_emit+0x320/0x3e0 [ 9.482691][ T198] #2: ffffffff8b17de38 (console_srcu){....}-{0:0}, at: console_flush_one_record+0x106/0x710 [ 9.482695][ T198] #3: ffffffff8b09d760 (console_owner){....}-{0:0}, at: console_lock_spinning_enable+0x40/0x60 [ 9.482699][ T198] #4: ffffffff8b09d660 (printk_legacy_map-wait-type-override){....}-{3:3}, at: console_emit_next_record+0x1df/0x4c0 [ 9.482703][ T198] irq event stamp: 29328 [ 9.482703][ T198] hardirqs last enabled at (29327): [] __down_trylock_console_sem+0x86/0xa0 [ 9.482706][ T198] hardirqs last disabled at (29328): [] console_emit_next_record+0x3d4/0x4c0 [ 9.482709][ T198] softirqs last enabled at (28412): [] handle_softirqs+0x67c/0x900 [ 9.482711][ T198] softirqs last disabled at (26847): [] __irq_exit_rcu+0x145/0x1c0 [ 9.482713][ T198] Preemption disabled at: [ 9.482714][ T198] [<0000000000000000>] 0x0 [ 9.482720][ T198] CPU: 3 UID: 0 PID: 198 Comm: ip Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 9.482723][ T198] Tainted: [W]=WARN [ 9.482724][ T198] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 9.482725][ T198] Call Trace: [ 9.482727][ T198] [ 9.482729][ T198] dump_stack_lvl+0x6f/0xa0 [ 9.482735][ T198] __might_resched.cold+0x1fe/0x2c1 [ 9.482740][ T198] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 9.482744][ T198] ? __kmalloc_noprof+0xdb/0x760 [ 9.482748][ T198] __kmalloc_noprof+0x443/0x760 [ 9.482750][ T198] ? alloc_buf.isra.0+0x4b/0x260 [ 9.482757][ T198] ? do_raw_spin_unlock+0x59/0x250 [ 9.482760][ T198] alloc_buf.isra.0+0x4b/0x260 [ 9.482763][ T198] put_chars+0x1e1/0x2f0 [ 9.482766][ T198] ? __send_to_port+0x420/0x420 [ 9.482767][ T198] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 9.482770][ T198] ? validate_chain+0x38b/0xc20 [ 9.482775][ T198] hvc_console_print+0x292/0x780 [ 9.482783][ T198] ? hvc_write+0x3a0/0x3a0 [ 9.482785][ T198] ? rcu_is_watching+0x16/0xd0 [ 9.482787][ T198] ? lock_acquire+0x13c/0x160 [ 9.482791][ T198] console_emit_next_record+0x22f/0x4c0 [ 9.482795][ T198] ? devkmsg_read+0x4b0/0x4b0 [ 9.482797][ T198] ? console_flush_one_record+0x106/0x710 [ 9.482800][ T198] ? rcu_is_watching+0x16/0xd0 [ 9.482802][ T198] ? lock_acquire+0x13c/0x160 [ 9.482806][ T198] console_flush_one_record+0x46f/0x710 [ 9.482810][ T198] ? console_emit_next_record+0x4c0/0x4c0 [ 9.482812][ T198] ? __lock_acquire+0x518/0xc20 [ 9.482817][ T198] console_unlock+0xee/0x1f0 [ 9.482820][ T198] ? console_flush_one_record+0x710/0x710 [ 9.482822][ T198] ? rcu_is_watching+0x16/0xd0 [ 9.482824][ T198] ? lock_acquire+0xe0/0x160 [ 9.482827][ T198] ? __down_trylock_console_sem+0x5e/0xa0 [ 9.482829][ T198] ? vprintk_emit+0x320/0x3e0 [ 9.482832][ T198] vprintk_emit+0x37c/0x3e0 [ 9.482835][ T198] ? wake_up_klogd_work_func+0x90/0x90 [ 9.482838][ T198] ? __lock_acquire+0x518/0xc20 [ 9.482841][ T198] _printk+0xc7/0x100 [ 9.482845][ T198] ? snapshot_read.cold+0x21/0x21 [ 9.482848][ T198] ? do_raw_spin_lock+0x131/0x280 [ 9.482850][ T198] ? __rwlock_init+0x150/0x150 [ 9.482854][ T198] ? do_raw_spin_lock+0x131/0x280 [ 9.482857][ T198] do_exit.cold+0x82/0x9c [ 9.482861][ T198] ? exit_notify+0x890/0x890 [ 9.482862][ T198] ? __lock_release.isra.0+0x69/0x1a0 [ 9.482865][ T198] ? rcu_is_watching+0x16/0xd0 [ 9.482868][ T198] do_group_exit+0xb8/0x370 [ 9.482871][ T198] __x64_sys_exit_group+0x3c/0x50 [ 9.482873][ T198] x64_sys_call+0x1567/0x1570 [ 9.482876][ T198] do_syscall_64+0xff/0x530 [ 9.482880][ T198] ? exc_page_fault+0xee/0x100 [ 9.482883][ T198] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 9.482885][ T198] RIP: 0033:0x7f7badba31b8 [ 9.482887][ T198] Code: Unable to access opcode bytes at 0x7f7badba318e. [ 9.482888][ T198] RSP: 002b:00007ffe129226c8 EFLAGS: 00000246 ORIG_RAX: 00000000000000e7 [ 9.482890][ T198] RAX: ffffffffffffffda RBX: 00007f7badcd3f88 RCX: 00007f7badba31b8 [ 9.482892][ T198] RDX: 00007f7bad8edfc8 RSI: fffffffffffffeb8 RDI: 0000000000000000 [ 9.482892][ T198] RBP: 00007ffe12922720 R08: 0000000000000000 R09: 0000000000000050 [ 9.482893][ T198] R10: 00007ffe129224e0 R11: 0000000000000246 R12: 0000000000000001 [ 9.482894][ T198] R13: 0000000000000000 R14: 00007f7badcd2680 R15: 00007f7badcd3fa0 [ 9.482901][ T198] [ 11.227471][ T264] ip (264) used greatest stack depth: 24016 bytes left [ 11.227486][ T264] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 11.227488][ T264] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 264, name: ip [ 11.227490][ T264] preempt_count: 2, expected: 0 [ 11.227491][ T264] RCU nest depth: 0, expected: 0 [ 11.227492][ T264] locks held by ip/264: 5, last CPU#2: [ 11.227494][ T264] #0: ffffffff8b0167b8 (low_water_lock){+.+.}-{3:3}, at: do_exit+0x887/0xdc0 [ 11.227505][ T264] #1: ffffffff8b17ddc0 (console_lock){+.+.}-{0:0}, at: vprintk_emit+0x320/0x3e0 [ 11.227509][ T264] #2: ffffffff8b17de38 (console_srcu){....}-{0:0}, at: console_flush_one_record+0x106/0x710 [ 11.227513][ T264] #3: ffffffff8b09d760 (console_owner){....}-{0:0}, at: console_lock_spinning_enable+0x40/0x60 [ 11.227517][ T264] #4: ffffffff8b09d660 (printk_legacy_map-wait-type-override){....}-{3:3}, at: console_emit_next_record+0x1df/0x4c0 [ 11.227521][ T264] irq event stamp: 32426 [ 11.227522][ T264] hardirqs last enabled at (32425): [] __down_trylock_console_sem+0x86/0xa0 [ 11.227525][ T264] hardirqs last disabled at (32426): [] console_emit_next_record+0x3d4/0x4c0 [ 11.227527][ T264] softirqs last enabled at (32264): [] handle_softirqs+0x67c/0x900 [ 11.227529][ T264] softirqs last disabled at (31805): [] __irq_exit_rcu+0x145/0x1c0 [ 11.227531][ T264] Preemption disabled at: [ 11.227532][ T264] [<0000000000000000>] 0x0 [ 11.227538][ T264] CPU: 2 UID: 0 PID: 264 Comm: ip Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 11.227541][ T264] Tainted: [W]=WARN [ 11.227543][ T264] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 11.227544][ T264] Call Trace: [ 11.227546][ T264] [ 11.227547][ T264] dump_stack_lvl+0x6f/0xa0 [ 11.227554][ T264] __might_resched.cold+0x1fe/0x2c1 [ 11.227558][ T264] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 11.227562][ T264] ? __kmalloc_noprof+0xdb/0x760 [ 11.227566][ T264] __kmalloc_noprof+0x443/0x760 [ 11.227568][ T264] ? alloc_buf.isra.0+0x4b/0x260 [ 11.227575][ T264] ? do_raw_spin_unlock+0x59/0x250 [ 11.227577][ T264] alloc_buf.isra.0+0x4b/0x260 [ 11.227581][ T264] put_chars+0x1e1/0x2f0 [ 11.227583][ T264] ? __send_to_port+0x420/0x420 [ 11.227585][ T264] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 11.227588][ T264] ? validate_chain+0x38b/0xc20 [ 11.227593][ T264] hvc_console_print+0x292/0x780 [ 11.227601][ T264] ? hvc_write+0x3a0/0x3a0 [ 11.227603][ T264] ? rcu_is_watching+0x16/0xd0 [ 11.227605][ T264] ? lock_acquire+0x13c/0x160 [ 11.227609][ T264] console_emit_next_record+0x22f/0x4c0 [ 11.227613][ T264] ? devkmsg_read+0x4b0/0x4b0 [ 11.227615][ T264] ? console_flush_one_record+0x106/0x710 [ 11.227618][ T264] ? rcu_is_watching+0x16/0xd0 [ 11.227620][ T264] ? lock_acquire+0x13c/0x160 [ 11.227624][ T264] console_flush_one_record+0x46f/0x710 [ 11.227628][ T264] ? console_emit_next_record+0x4c0/0x4c0 [ 11.227630][ T264] ? __lock_acquire+0x518/0xc20 [ 11.227635][ T264] console_unlock+0xee/0x1f0 [ 11.227638][ T264] ? console_flush_one_record+0x710/0x710 [ 11.227639][ T264] ? rcu_is_watching+0x16/0xd0 [ 11.227641][ T264] ? lock_acquire+0xe0/0x160 [ 11.227644][ T264] ? __down_trylock_console_sem+0x5e/0xa0 [ 11.227646][ T264] ? vprintk_emit+0x320/0x3e0 [ 11.227649][ T264] vprintk_emit+0x37c/0x3e0 [ 11.227652][ T264] ? wake_up_klogd_work_func+0x90/0x90 [ 11.227655][ T264] ? __lock_acquire+0x518/0xc20 [ 11.227658][ T264] _printk+0xc7/0x100 [ 11.227662][ T264] ? snapshot_read.cold+0x21/0x21 [ 11.227664][ T264] ? do_raw_spin_lock+0x131/0x280 [ 11.227667][ T264] ? __rwlock_init+0x150/0x150 [ 11.227671][ T264] ? do_raw_spin_lock+0x131/0x280 [ 11.227673][ T264] do_exit.cold+0x82/0x9c [ 11.227677][ T264] ? exit_notify+0x890/0x890 [ 11.227678][ T264] ? __lock_release.isra.0+0x69/0x1a0 [ 11.227681][ T264] ? rcu_is_watching+0x16/0xd0 [ 11.227684][ T264] do_group_exit+0xb8/0x370 [ 11.227687][ T264] __x64_sys_exit_group+0x3c/0x50 [ 11.227689][ T264] x64_sys_call+0x1567/0x1570 [ 11.227692][ T264] do_syscall_64+0xff/0x530 [ 11.227696][ T264] ? exc_page_fault+0xee/0x100 [ 11.227698][ T264] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 11.227701][ T264] RIP: 0033:0x7fd919b151b8 [ 11.227703][ T264] Code: Unable to access opcode bytes at 0x7fd919b1518e. [ 11.227704][ T264] RSP: 002b:00007fffc30ea388 EFLAGS: 00000246 ORIG_RAX: 00000000000000e7 [ 11.227706][ T264] RAX: ffffffffffffffda RBX: 00007fd919c45f88 RCX: 00007fd919b151b8 [ 11.227708][ T264] RDX: 00007fd91985ffc8 RSI: fffffffffffffeb8 RDI: 0000000000000000 [ 11.227708][ T264] RBP: 00007fffc30ea3e0 R08: 0000000000000000 R09: 0000000000008010 [ 11.227709][ T264] R10: 00007fffc30ea1a0 R11: 0000000000000246 R12: 0000000000000001 [ 11.227710][ T264] R13: 0000000000000000 R14: 00007fd919c44680 R15: 00007fd919c45fa0 [ 11.227717][ T264] [ 13.981184][ C0] clocksource: Watchdog remote CPU 2 read timed out [ 13.981346][ C0] [ 13.981348][ C0] ======================================================== [ 13.981349][ C0] WARNING: possible irq lock inversion dependency detected [ 13.981351][ C0] 7.2.0-virtme #1 Tainted: G W [ 13.981352][ C0] -------------------------------------------------------- [ 13.981353][ C0] swapper/0/0 just changed the state of lock: [ 13.981354][ C0] ffffffff8b09d760 (console_owner){..-.}-{0:0}, at: console_lock_spinning_enable+0x40/0x60 [ 13.981366][ C0] but this lock took another, SOFTIRQ-unsafe lock in the past: [ 13.981367][ C0] (fs_reclaim){+.+.}-{0:0} [ 13.981368][ C0] [ 13.981368][ C0] [ 13.981368][ C0] and interrupts could create inverse lock ordering between them. [ 13.981368][ C0] [ 13.981369][ C0] [ 13.981369][ C0] other info that might help us debug this: [ 13.981370][ C0] Possible interrupt unsafe locking scenario: [ 13.981370][ C0] [ 13.981370][ C0] CPU0 CPU1 [ 13.981371][ C0] ---- ---- [ 13.981371][ C0] lock(fs_reclaim); [ 13.981372][ C0] local_irq_disable(); [ 13.981373][ C0] lock(console_owner); [ 13.981373][ C0] lock(fs_reclaim); [ 13.981375][ C0] [ 13.981375][ C0] lock(console_owner); [ 13.981376][ C0] [ 13.981376][ C0] *** DEADLOCK *** [ 13.981376][ C0] [ 13.981376][ C0] locks held by swapper/0/0: 4, last CPU#0: [ 13.981377][ C0] #0: ffa0000000007c90 ((&watchdog_timer)){+.-.}-{0:0}, at: call_timer_fn+0x110/0x4d0 [ 13.981383][ C0] #1: ffffffff8b1e29f8 (watchdog_lock){+.-.}-{3:3}, at: clocksource_watchdog+0x15/0x30 [ 13.981386][ C0] #2: ffffffff8b17ddc0 (console_lock){+.+.}-{0:0}, at: vprintk_emit+0x320/0x3e0 [ 13.981389][ C0] #3: ffffffff8b17de38 (console_srcu){....}-{0:0}, at: console_flush_one_record+0x106/0x710 [ 13.981393][ C0] [ 13.981393][ C0] the shortest dependencies between 2nd lock and 1st lock: [ 13.981397][ C0] -> (fs_reclaim){+.+.}-{0:0} { [ 13.981400][ C0] HARDIRQ-ON-W at: [ 13.981401][ C0] __lock_acquire+0x388/0xc20 [ 13.981405][ C0] lock_acquire.part.0+0xd4/0x280 [ 13.981406][ C0] fs_reclaim_acquire+0xd5/0x120 [ 13.981410][ C0] __kmalloc_cache_noprof+0x6e/0x620 [ 13.981411][ C0] kthread_create_worker_on_node+0xea/0x210 [ 13.981414][ C0] workqueue_init+0x2a/0x680 [ 13.981418][ C0] kernel_init_freeable+0x2fe/0x630 [ 13.981421][ C0] kernel_init+0x21/0x150 [ 13.981425][ C0] ret_from_fork+0x474/0x6b0 [ 13.981428][ C0] ret_from_fork_asm+0x11/0x20 [ 13.981431][ C0] SOFTIRQ-ON-W at: [ 13.981432][ C0] __lock_acquire+0x388/0xc20 [ 13.981434][ C0] lock_acquire.part.0+0xd4/0x280 [ 13.981436][ C0] fs_reclaim_acquire+0xd5/0x120 [ 13.981437][ C0] __kmalloc_cache_noprof+0x6e/0x620 [ 13.981438][ C0] kthread_create_worker_on_node+0xea/0x210 [ 13.981440][ C0] workqueue_init+0x2a/0x680 [ 13.981441][ C0] kernel_init_freeable+0x2fe/0x630 [ 13.981443][ C0] kernel_init+0x21/0x150 [ 13.981444][ C0] ret_from_fork+0x474/0x6b0 [ 13.981446][ C0] ret_from_fork_asm+0x11/0x20 [ 13.981447][ C0] INITIAL USE at: [ 13.981448][ C0] __lock_acquire+0x388/0xc20 [ 13.981449][ C0] lock_acquire.part.0+0xd4/0x280 [ 13.981451][ C0] fs_reclaim_acquire+0xd5/0x120 [ 13.981452][ C0] __kmalloc_cache_noprof+0x6e/0x620 [ 13.981453][ C0] kthread_create_worker_on_node+0xea/0x210 [ 13.981455][ C0] workqueue_init+0x2a/0x680 [ 13.981456][ C0] kernel_init_freeable+0x2fe/0x630 [ 13.981458][ C0] kernel_init+0x21/0x150 [ 13.981459][ C0] ret_from_fork+0x474/0x6b0 [ 13.981460][ C0] ret_from_fork_asm+0x11/0x20 [ 13.981462][ C0] } [ 13.981462][ C0] ... key at: [] __fs_reclaim_map+0x0/0xbe0 [ 13.981466][ C0] ... acquired at: [ 13.981467][ C0] __lock_acquire+0x518/0xc20 [ 13.981468][ C0] lock_acquire.part.0+0xd4/0x280 [ 13.981470][ C0] fs_reclaim_acquire+0xd5/0x120 [ 13.981471][ C0] __kmalloc_noprof+0xd3/0x760 [ 13.981472][ C0] alloc_buf.isra.0+0x4b/0x260 [ 13.981476][ C0] put_chars+0x1e1/0x2f0 [ 13.981477][ C0] hvc_console_print+0x292/0x780 [ 13.981480][ C0] console_emit_next_record+0x22f/0x4c0 [ 13.981482][ C0] console_flush_one_record+0x46f/0x710 [ 13.981483][ C0] console_unlock+0xee/0x1f0 [ 13.981485][ C0] vprintk_emit+0x37c/0x3e0 [ 13.981486][ C0] _printk+0xc7/0x100 [ 13.981493][ C0] vti_init+0x17/0x110 [ 13.981496][ C0] do_one_initcall+0x124/0x4f0 [ 13.981498][ C0] kernel_init_freeable+0x596/0x630 [ 13.981499][ C0] kernel_init+0x21/0x150 [ 13.981500][ C0] ret_from_fork+0x474/0x6b0 [ 13.981502][ C0] ret_from_fork_asm+0x11/0x20 [ 13.981503][ C0] [ 13.981503][ C0] -> (console_owner){..-.}-{0:0} { [ 13.981505][ C0] IN-SOFTIRQ-W at: [ 13.981506][ C0] __lock_acquire+0x388/0xc20 [ 13.981507][ C0] lock_acquire.part.0+0xd4/0x280 [ 13.981509][ C0] console_lock_spinning_enable+0x5c/0x60 [ 13.981511][ C0] console_emit_next_record+0x1d1/0x4c0 [ 13.981512][ C0] console_flush_one_record+0x46f/0x710 [ 13.981514][ C0] console_unlock+0xee/0x1f0 [ 13.981515][ C0] vprintk_emit+0x37c/0x3e0 [ 13.981516][ C0] _printk+0xc7/0x100 [ 13.981518][ C0] clocksource_watchdog.part.0.cold+0x105/0x1dd [ 13.981520][ C0] call_timer_fn+0x160/0x4d0 [ 13.981522][ C0] __run_timers+0x68f/0xaa0 [ 13.981524][ C0] run_timer_softirq+0xf0/0x160 [ 13.981525][ C0] handle_softirqs+0x1d3/0x900 [ 13.981528][ C0] __irq_exit_rcu+0x145/0x1c0 [ 13.981529][ C0] irq_exit_rcu+0xe/0x30 [ 13.981531][ C0] sysvec_apic_timer_interrupt+0x9d/0xe0 [ 13.981532][ C0] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 13.981534][ C0] pv_native_safe_halt+0xf/0x10 [ 13.981535][ C0] default_idle+0x9/0x10 [ 13.981536][ C0] default_idle_call+0x6e/0xb0 [ 13.981538][ C0] cpuidle_idle_call.constprop.0+0x237/0x410 [ 13.981540][ C0] do_idle+0xd8/0x190 [ 13.981542][ C0] cpu_startup_entry+0x53/0x70 [ 13.981543][ C0] rest_init+0x279/0x280 [ 13.981544][ C0] start_kernel+0x3b9/0x3c0 [ 13.981546][ C0] x86_64_start_reservations+0x24/0x30 [ 13.981548][ C0] x86_64_start_kernel+0x12b/0x130 [ 13.981549][ C0] common_startup_64+0x13e/0x148 [ 13.981552][ C0] INITIAL USE at: [ 13.981553][ C0] } [ 13.981553][ C0] ... key at: [] console_owner_dep_map+0x0/0x60 [ 13.981555][ C0] ... acquired at: [ 13.981556][ C0] mark_lock+0x1d7/0xa00 [ 13.981557][ C0] mark_usage+0x42/0x170 [ 13.981559][ C0] __lock_acquire+0x388/0xc20 [ 13.981560][ C0] lock_acquire.part.0+0xd4/0x280 [ 13.981561][ C0] console_lock_spinning_enable+0x5c/0x60 [ 13.981563][ C0] console_emit_next_record+0x1d1/0x4c0 [ 13.981565][ C0] console_flush_one_record+0x46f/0x710 [ 13.981566][ C0] console_unlock+0xee/0x1f0 [ 13.981568][ C0] vprintk_emit+0x37c/0x3e0 [ 13.981569][ C0] _printk+0xc7/0x100 [ 13.981570][ C0] clocksource_watchdog.part.0.cold+0x105/0x1dd [ 13.981571][ C0] call_timer_fn+0x160/0x4d0 [ 13.981572][ C0] __run_timers+0x68f/0xaa0 [ 13.981574][ C0] run_timer_softirq+0xf0/0x160 [ 13.981576][ C0] handle_softirqs+0x1d3/0x900 [ 13.981577][ C0] __irq_exit_rcu+0x145/0x1c0 [ 13.981578][ C0] irq_exit_rcu+0xe/0x30 [ 13.981580][ C0] sysvec_apic_timer_interrupt+0x9d/0xe0 [ 13.981581][ C0] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 13.981582][ C0] pv_native_safe_halt+0xf/0x10 [ 13.981583][ C0] default_idle+0x9/0x10 [ 13.981585][ C0] default_idle_call+0x6e/0xb0 [ 13.981586][ C0] cpuidle_idle_call.constprop.0+0x237/0x410 [ 13.981587][ C0] do_idle+0xd8/0x190 [ 13.981588][ C0] cpu_startup_entry+0x53/0x70 [ 13.981590][ C0] rest_init+0x279/0x280 [ 13.981591][ C0] start_kernel+0x3b9/0x3c0 [ 13.981592][ C0] x86_64_start_reservations+0x24/0x30 [ 13.981594][ C0] x86_64_start_kernel+0x12b/0x130 [ 13.981595][ C0] common_startup_64+0x13e/0x148 [ 13.981596][ C0] [ 13.981596][ C0] [ 13.981596][ C0] stack backtrace: [ 13.981599][ C0] CPU: 0 UID: 0 PID: 0 Comm: swapper/0 Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 13.981603][ C0] Tainted: [W]=WARN [ 13.981604][ C0] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 13.981605][ C0] Call Trace: [ 13.981606][ C0] [ 13.981608][ C0] dump_stack_lvl+0x6f/0xa0 [ 13.981612][ C0] print_irq_inversion_bug.part.0.cold+0xe6/0x143 [ 13.981615][ C0] mark_lock_irq+0x989/0x9c0 [ 13.981616][ C0] ? add_lock_to_list+0x2c/0x1a0 [ 13.981619][ C0] mark_lock+0x1d7/0xa00 [ 13.981621][ C0] mark_usage+0x42/0x170 [ 13.981623][ C0] __lock_acquire+0x388/0xc20 [ 13.981625][ C0] lock_acquire.part.0+0xd4/0x280 [ 13.981627][ C0] ? console_lock_spinning_enable+0x40/0x60 [ 13.981629][ C0] ? rcu_is_watching+0x16/0xd0 [ 13.981631][ C0] ? lock_acquire+0x13c/0x160 [ 13.981633][ C0] console_lock_spinning_enable+0x5c/0x60 [ 13.981635][ C0] ? console_lock_spinning_enable+0x40/0x60 [ 13.981637][ C0] console_emit_next_record+0x1d1/0x4c0 [ 13.981639][ C0] ? devkmsg_read+0x4b0/0x4b0 [ 13.981641][ C0] ? console_flush_one_record+0x106/0x710 [ 13.981643][ C0] ? rcu_is_watching+0x16/0xd0 [ 13.981644][ C0] ? lock_acquire+0x13c/0x160 [ 13.981646][ C0] console_flush_one_record+0x46f/0x710 [ 13.981649][ C0] ? console_emit_next_record+0x4c0/0x4c0 [ 13.981650][ C0] ? __lock_acquire+0x518/0xc20 [ 13.981653][ C0] console_unlock+0xee/0x1f0 [ 13.981655][ C0] ? console_flush_one_record+0x710/0x710 [ 13.981657][ C0] ? rcu_is_watching+0x16/0xd0 [ 13.981658][ C0] ? lock_acquire+0xe0/0x160 [ 13.981660][ C0] ? __down_trylock_console_sem+0x5e/0xa0 [ 13.981662][ C0] ? vprintk_emit+0x320/0x3e0 [ 13.981663][ C0] vprintk_emit+0x37c/0x3e0 [ 13.981665][ C0] ? wake_up_klogd_work_func+0x90/0x90 [ 13.981667][ C0] ? clocksource_watchdog.part.0+0x450/0x540 [ 13.981669][ C0] _printk+0xc7/0x100 [ 13.981670][ C0] ? snapshot_read.cold+0x21/0x21 [ 13.981672][ C0] ? clocksource_watchdog.part.0+0x450/0x540 [ 13.981674][ C0] ? __lock_release.isra.0+0x69/0x1a0 [ 13.981676][ C0] clocksource_watchdog.part.0.cold+0x105/0x1dd [ 13.981678][ C0] ? clocksource_watchdog.part.0+0x540/0x540 [ 13.981679][ C0] ? clocksource_watchdog.part.0+0x540/0x540 [ 13.981681][ C0] call_timer_fn+0x160/0x4d0 [ 13.981683][ C0] ? detach_if_pending+0x1d0/0x1d0 [ 13.981685][ C0] ? debug_object_active_state+0x430/0x430 [ 13.981688][ C0] ? find_held_lock+0x2b/0x80 [ 13.981690][ C0] ? __lock_release.isra.0+0x69/0x1a0 [ 13.981691][ C0] ? rcu_is_watching+0x16/0xd0 [ 13.981693][ C0] __run_timers+0x68f/0xaa0 [ 13.981695][ C0] ? clocksource_watchdog.part.0+0x540/0x540 [ 13.981697][ C0] ? __bpf_trace_itimer_expire+0x10/0x10 [ 13.981699][ C0] ? __lock_acquire+0x518/0xc20 [ 13.981702][ C0] ? __rwlock_init+0x150/0x150 [ 13.981705][ C0] run_timer_softirq+0xf0/0x160 [ 13.981707][ C0] ? __run_timers+0xaa0/0xaa0 [ 13.981708][ C0] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 13.981711][ C0] ? rcu_is_watching+0x16/0xd0 [ 13.981712][ C0] handle_softirqs+0x1d3/0x900 [ 13.981714][ C0] ? __lock_release.isra.0+0x69/0x1a0 [ 13.981716][ C0] ? _local_bh_enable+0xc0/0xc0 [ 13.981718][ C0] __irq_exit_rcu+0x145/0x1c0 [ 13.981720][ C0] irq_exit_rcu+0xe/0x30 [ 13.981722][ C0] sysvec_apic_timer_interrupt+0x9d/0xe0 [ 13.981723][ C0] [ 13.981724][ C0] [ 13.981724][ C0] ? lockdep_hardirqs_on_prepare.part.0+0x9a/0x160 [ 13.981726][ C0] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 13.981728][ C0] RIP: 0010:pv_native_safe_halt+0xf/0x10 [ 13.981730][ C0] Code: 48 8b 3d 94 82 68 02 e8 1f 00 00 00 48 2b 05 58 d3 a0 00 c3 0f 1f 80 00 00 00 00 f3 0f 1e fa eb 07 0f 00 2d 13 06 0e 00 fb f4 0f 1f 40 d6 48 83 ec 20 8b 17 49 89 f8 83 e2 fe 41 89 d2 0f 01 [ 13.981732][ C0] RSP: 0018:ffffffff8ae07cf8 EFLAGS: 00000296 [ 13.981734][ C0] RAX: 00000000000958d7 RBX: ffffffff8ae30600 RCX: ffffffff87506247 [ 13.981735][ C0] RDX: ffffffff8ae30600 RSI: ffffffff8a711027 RDI: ffffffff8a0949e0 [ 13.981736][ C0] RBP: 0000000000000000 R08: 0000000000000000 R09: 0000000000000000 [ 13.981737][ C0] R10: 0000000000000000 R11: 0000000000000001 R12: 1ffffffff15c0fa2 [ 13.981737][ C0] R13: 0000000000000000 R14: dffffc0000000000 R15: 0000000000014770 [ 13.981739][ C0] ? cpuidle_idle_call.constprop.0+0x237/0x410 [ 13.981741][ C0] ? lockdep_hardirqs_on+0x91/0x130 [ 13.981743][ C0] default_idle+0x9/0x10 [ 13.981745][ C0] default_idle_call+0x6e/0xb0 [ 13.981746][ C0] cpuidle_idle_call.constprop.0+0x237/0x410 [ 13.981748][ C0] ? arch_cpu_idle_exit+0x40/0x40 [ 13.981750][ C0] ? mark_tsc_async_resets+0x30/0x30 [ 13.981752][ C0] ? rcu_is_watching+0x16/0xd0 [ 13.981754][ C0] do_idle+0xd8/0x190 [ 13.981755][ C0] cpu_startup_entry+0x53/0x70 [ 13.981757][ C0] rest_init+0x279/0x280 [ 13.981759][ C0] ? __cpuidle_text_end+0x3b/0x3b [ 13.981761][ C0] ? rest_init+0x280/0x280 [ 13.981763][ C0] ? acpi_hw_set_mode+0x4a0/0x4a0 [ 13.981766][ C0] ? cpus_read_unlock+0x4f/0xc0 [ 13.981768][ C0] ? acpi_enable+0x1e4/0x330 [ 13.981770][ C0] start_kernel+0x3b9/0x3c0 [ 13.981772][ C0] x86_64_start_reservations+0x24/0x30 [ 13.981773][ C0] x86_64_start_kernel+0x12b/0x130 [ 13.981775][ C0] common_startup_64+0x13e/0x148 [ 13.981778][ C0] [ 13.981782][ C0] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 13.981784][ C0] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 0, name: swapper/0 [ 13.981785][ C0] preempt_count: 103, expected: 0 [ 13.981786][ C0] RCU nest depth: 0, expected: 0 [ 13.981786][ C0] INFO: lockdep is turned off. [ 13.981787][ C0] irq event stamp: 612583 [ 13.981788][ C0] hardirqs last enabled at (612582): [] __down_trylock_console_sem+0x86/0xa0 [ 13.981790][ C0] hardirqs last disabled at (612583): [] console_emit_next_record+0x3d4/0x4c0 [ 13.981792][ C0] softirqs last enabled at (612534): [] handle_softirqs+0x67c/0x900 [ 13.981794][ C0] softirqs last disabled at (612569): [] __irq_exit_rcu+0x145/0x1c0 [ 13.981795][ C0] Preemption disabled at: [ 13.981796][ C0] [] schedule_preempt_disabled+0x22/0x30 [ 13.981800][ C0] CPU: 0 UID: 0 PID: 0 Comm: swapper/0 Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 13.981802][ C0] Tainted: [W]=WARN [ 13.981802][ C0] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 13.981803][ C0] Call Trace: [ 13.981803][ C0] [ 13.981804][ C0] dump_stack_lvl+0x6f/0xa0 [ 13.981806][ C0] ? schedule_preempt_disabled+0x22/0x30 [ 13.981808][ C0] __might_resched.cold+0x1fe/0x2c1 [ 13.981811][ C0] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 13.981814][ C0] ? rcu_is_watching+0x16/0xd0 [ 13.981815][ C0] __kmalloc_noprof+0x443/0x760 [ 13.981817][ C0] ? __rwlock_init+0x150/0x150 [ 13.981818][ C0] ? alloc_buf.isra.0+0x4b/0x260 [ 13.981821][ C0] ? do_raw_spin_unlock+0x59/0x250 [ 13.981822][ C0] alloc_buf.isra.0+0x4b/0x260 [ 13.981825][ C0] put_chars+0x1e1/0x2f0 [ 13.981826][ C0] ? __send_to_port+0x420/0x420 [ 13.981828][ C0] ? mark_lock+0x1d7/0xa00 [ 13.981830][ C0] hvc_console_print+0x292/0x780 [ 13.981833][ C0] ? hvc_write+0x3a0/0x3a0 [ 13.981835][ C0] ? rcu_is_watching+0x16/0xd0 [ 13.981836][ C0] ? rcu_is_watching+0x16/0xd0 [ 13.981838][ C0] console_emit_next_record+0x22f/0x4c0 [ 13.981841][ C0] ? devkmsg_read+0x4b0/0x4b0 [ 13.981842][ C0] ? console_flush_one_record+0x106/0x710 [ 13.981845][ C0] ? rcu_is_watching+0x16/0xd0 [ 13.981846][ C0] ? lock_acquire+0x13c/0x160 [ 13.981848][ C0] console_flush_one_record+0x46f/0x710 [ 13.981850][ C0] ? console_emit_next_record+0x4c0/0x4c0 [ 13.981852][ C0] ? __lock_acquire+0x518/0xc20 [ 13.981854][ C0] console_unlock+0xee/0x1f0 [ 13.981856][ C0] ? console_flush_one_record+0x710/0x710 [ 13.981858][ C0] ? rcu_is_watching+0x16/0xd0 [ 13.981859][ C0] ? lock_acquire+0xe0/0x160 [ 13.981861][ C0] ? __down_trylock_console_sem+0x5e/0xa0 [ 13.981863][ C0] ? vprintk_emit+0x320/0x3e0 [ 13.981864][ C0] vprintk_emit+0x37c/0x3e0 [ 13.981866][ C0] ? wake_up_klogd_work_func+0x90/0x90 [ 13.981868][ C0] ? clocksource_watchdog.part.0+0x450/0x540 [ 13.981869][ C0] _printk+0xc7/0x100 [ 13.981871][ C0] ? snapshot_read.cold+0x21/0x21 [ 13.981873][ C0] ? clocksource_watchdog.part.0+0x450/0x540 [ 13.981875][ C0] ? __lock_release.isra.0+0x69/0x1a0 [ 13.981877][ C0] clocksource_watchdog.part.0.cold+0x105/0x1dd [ 13.981879][ C0] ? clocksource_watchdog.part.0+0x540/0x540 [ 13.981880][ C0] ? clocksource_watchdog.part.0+0x540/0x540 [ 13.981882][ C0] call_timer_fn+0x160/0x4d0 [ 13.981884][ C0] ? detach_if_pending+0x1d0/0x1d0 [ 13.981886][ C0] ? debug_object_active_state+0x430/0x430 [ 13.981887][ C0] ? find_held_lock+0x2b/0x80 [ 13.981889][ C0] ? __lock_release.isra.0+0x69/0x1a0 [ 13.981891][ C0] ? rcu_is_watching+0x16/0xd0 [ 13.981893][ C0] __run_timers+0x68f/0xaa0 [ 13.981894][ C0] ? clocksource_watchdog.part.0+0x540/0x540 [ 13.981897][ C0] ? __bpf_trace_itimer_expire+0x10/0x10 [ 13.981898][ C0] ? __lock_acquire+0x518/0xc20 [ 13.981901][ C0] ? __rwlock_init+0x150/0x150 [ 13.981904][ C0] run_timer_softirq+0xf0/0x160 [ 13.981906][ C0] ? __run_timers+0xaa0/0xaa0 [ 13.981908][ C0] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 13.981909][ C0] ? rcu_is_watching+0x16/0xd0 [ 13.981910][ C0] handle_softirqs+0x1d3/0x900 [ 13.981912][ C0] ? __lock_release.isra.0+0x69/0x1a0 [ 13.981914][ C0] ? _local_bh_enable+0xc0/0xc0 [ 13.981916][ C0] __irq_exit_rcu+0x145/0x1c0 [ 13.981918][ C0] irq_exit_rcu+0xe/0x30 [ 13.981919][ C0] sysvec_apic_timer_interrupt+0x9d/0xe0 [ 13.981921][ C0] [ 13.981922][ C0] [ 13.981922][ C0] ? lockdep_hardirqs_on_prepare.part.0+0x9a/0x160 [ 13.981924][ C0] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 13.981925][ C0] RIP: 0010:pv_native_safe_halt+0xf/0x10 [ 13.981927][ C0] Code: 48 8b 3d 94 82 68 02 e8 1f 00 00 00 48 2b 05 58 d3 a0 00 c3 0f 1f 80 00 00 00 00 f3 0f 1e fa eb 07 0f 00 2d 13 06 0e 00 fb f4 0f 1f 40 d6 48 83 ec 20 8b 17 49 89 f8 83 e2 fe 41 89 d2 0f 01 [ 13.981928][ C0] RSP: 0018:ffffffff8ae07cf8 EFLAGS: 00000296 [ 13.981929][ C0] RAX: 00000000000958d7 RBX: ffffffff8ae30600 RCX: ffffffff87506247 [ 13.981930][ C0] RDX: ffffffff8ae30600 RSI: ffffffff8a711027 RDI: ffffffff8a0949e0 [ 13.981931][ C0] RBP: 0000000000000000 R08: 0000000000000000 R09: 0000000000000000 [ 13.981932][ C0] R10: 0000000000000000 R11: 0000000000000001 R12: 1ffffffff15c0fa2 [ 13.981932][ C0] R13: 0000000000000000 R14: dffffc0000000000 R15: 0000000000014770 [ 13.981934][ C0] ? cpuidle_idle_call.constprop.0+0x237/0x410 [ 13.981936][ C0] ? lockdep_hardirqs_on+0x91/0x130 [ 13.981938][ C0] default_idle+0x9/0x10 [ 13.981939][ C0] default_idle_call+0x6e/0xb0 [ 13.981941][ C0] cpuidle_idle_call.constprop.0+0x237/0x410 [ 13.981942][ C0] ? arch_cpu_idle_exit+0x40/0x40 [ 13.981944][ C0] ? mark_tsc_async_resets+0x30/0x30 [ 13.981946][ C0] ? rcu_is_watching+0x16/0xd0 [ 13.981947][ C0] do_idle+0xd8/0x190 [ 13.981949][ C0] cpu_startup_entry+0x53/0x70 [ 13.981950][ C0] rest_init+0x279/0x280 [ 13.981952][ C0] ? __cpuidle_text_end+0x3b/0x3b [ 13.981955][ C0] ? rest_init+0x280/0x280 [ 13.981956][ C0] ? acpi_hw_set_mode+0x4a0/0x4a0 [ 13.981958][ C0] ? cpus_read_unlock+0x4f/0xc0 [ 13.981960][ C0] ? acpi_enable+0x1e4/0x330 [ 13.981961][ C0] start_kernel+0x3b9/0x3c0 [ 13.981963][ C0] x86_64_start_reservations+0x24/0x30 [ 13.981965][ C0] x86_64_start_kernel+0x12b/0x130 [ 13.981966][ C0] common_startup_64+0x13e/0x148 [ 13.981970][ C0] [ 24.832911][ T618] br0: port 1(veth1) entered blocking state [ 24.832924][ T618] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 24.832927][ T618] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 618, name: ip [ 24.832928][ T618] preempt_count: 1, expected: 0 [ 24.832929][ T618] RCU nest depth: 0, expected: 0 [ 24.832930][ T618] INFO: lockdep is turned off. [ 24.832931][ T618] irq event stamp: 0 [ 24.832932][ T618] hardirqs last enabled at (0): [<0000000000000000>] 0x0 [ 24.832936][ T618] hardirqs last disabled at (0): [] copy_process+0x1d3b/0x62b0 [ 24.832942][ T618] softirqs last enabled at (0): [] copy_process+0x1d8f/0x62b0 [ 24.832943][ T618] softirqs last disabled at (0): [<0000000000000000>] 0x0 [ 24.832945][ T618] Preemption disabled at: [ 24.832946][ T618] [] vprintk_emit+0x31b/0x3e0 [ 24.832952][ T618] CPU: 2 UID: 0 PID: 618 Comm: ip Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 24.832955][ T618] Tainted: [W]=WARN [ 24.832956][ T618] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 24.832958][ T618] Call Trace: [ 24.832960][ T618] [ 24.832961][ T618] dump_stack_lvl+0x6f/0xa0 [ 24.832967][ T618] ? vprintk_emit+0x31b/0x3e0 [ 24.832968][ T618] __might_resched.cold+0x1fe/0x2c1 [ 24.832972][ T618] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 24.832975][ T618] ? __asan_memcpy+0x3c/0x60 [ 24.832978][ T618] ? rcu_is_watching+0x16/0xd0 [ 24.832981][ T618] __kmalloc_noprof+0x443/0x760 [ 24.832983][ T618] ? __rwlock_init+0x150/0x150 [ 24.832986][ T618] ? alloc_buf.isra.0+0x4b/0x260 [ 24.832991][ T618] ? do_raw_spin_unlock+0x59/0x250 [ 24.832992][ T618] alloc_buf.isra.0+0x4b/0x260 [ 24.832995][ T618] put_chars+0x1e1/0x2f0 [ 24.832996][ T618] ? __send_to_port+0x420/0x420 [ 24.832998][ T618] ? console_prepend_replay+0x20/0x20 [ 24.833000][ T618] hvc_console_print+0x292/0x780 [ 24.833005][ T618] ? hvc_write+0x3a0/0x3a0 [ 24.833007][ T618] ? rcu_is_watching+0x16/0xd0 [ 24.833008][ T618] ? lock_acquire+0x13c/0x160 [ 24.833010][ T618] console_emit_next_record+0x22f/0x4c0 [ 24.833013][ T618] ? devkmsg_read+0x4b0/0x4b0 [ 24.833015][ T618] ? rcu_is_watching+0x16/0xd0 [ 24.833016][ T618] ? rcu_is_watching+0x16/0xd0 [ 24.833017][ T618] ? rcu_is_watching+0x16/0xd0 [ 24.833018][ T618] ? lock_acquire+0x13c/0x160 [ 24.833020][ T618] ? console_flush_one_record+0x111/0x710 [ 24.833022][ T618] console_flush_one_record+0x46f/0x710 [ 24.833024][ T618] ? console_emit_next_record+0x4c0/0x4c0 [ 24.833027][ T618] console_unlock+0xee/0x1f0 [ 24.833028][ T618] ? lock_acquire+0x13c/0x160 [ 24.833030][ T618] ? console_flush_one_record+0x710/0x710 [ 24.833031][ T618] ? rcu_is_watching+0x16/0xd0 [ 24.833032][ T618] ? lock_release+0x184/0x1f0 [ 24.833034][ T618] ? lock_acquire+0xe0/0x160 [ 24.833035][ T618] ? __rcu_read_lock+0x70/0x70 [ 24.833037][ T618] ? __down_trylock_console_sem+0x5e/0xa0 [ 24.833039][ T618] ? vprintk_emit+0x320/0x3e0 [ 24.833040][ T618] vprintk_emit+0x37c/0x3e0 [ 24.833042][ T618] ? wake_up_klogd_work_func+0x90/0x90 [ 24.833043][ T618] ? __rwlock_init+0x150/0x150 [ 24.833044][ T618] ? _raw_spin_unlock_irqrestore+0x40/0x80 [ 24.833050][ T618] ? lock_acquire+0x13c/0x160 [ 24.833052][ T618] ? rcu_is_watching+0x16/0xd0 [ 24.833053][ T618] _printk+0xc7/0x100 [ 24.833056][ T618] ? snapshot_read.cold+0x21/0x21 [ 24.833058][ T618] ? br_multicast_flood+0x960/0x960 [ 24.833061][ T618] ? do_setlink.isra.0+0x9ec/0x2a60 [ 24.833064][ T618] ? rtnl_newlink+0x9f1/0x11b0 [ 24.833065][ T618] ? rtnetlink_rcv_msg+0x6fd/0xbd0 [ 24.833067][ T618] br_set_state+0x22f/0x430 [ 24.833070][ T618] br_init_port+0xc4/0x200 [ 24.833072][ T618] new_nbp+0x3a0/0x650 [ 24.833074][ T618] br_add_if+0x212/0x1320 [ 24.833075][ T618] ? is_bpf_text_address+0x3e/0x110 [ 24.833078][ T618] ? is_bpf_text_address+0x72/0x110 [ 24.833079][ T618] ? kernel_text_address+0x149/0x170 [ 24.833082][ T618] do_set_master+0x3b2/0x780 [ 24.833084][ T618] do_setlink.isra.0+0x9ec/0x2a60 [ 24.833086][ T618] ? stack_trace_save+0x93/0xc0 [ 24.833089][ T618] ? rtnl_link_get_size+0x350/0x350 [ 24.833090][ T618] ? rcu_is_watching+0x16/0xd0 [ 24.833091][ T618] ? stack_depot_save_flags+0x1bc/0x790 [ 24.833094][ T618] ? kasan_save_stack+0x3d/0x50 [ 24.833096][ T618] ? kasan_save_stack+0x2f/0x50 [ 24.833097][ T618] ? kasan_save_track+0x14/0x30 [ 24.833098][ T618] ? __kasan_kmalloc+0x7b/0x90 [ 24.833099][ T618] ? __kmalloc_cache_noprof+0x29a/0x620 [ 24.833100][ T618] ? rtnl_newlink+0x124/0x11b0 [ 24.833101][ T618] ? rtnetlink_rcv_msg+0x6fd/0xbd0 [ 24.833102][ T618] ? netlink_rcv_skb+0x14e/0x3a0 [ 24.833105][ T618] ? netlink_unicast+0x486/0x750 [ 24.833106][ T618] ? netlink_sendmsg+0x75b/0xc90 [ 24.833107][ T618] ? __sock_sendmsg+0xce/0x190 [ 24.833110][ T618] ? ____sys_sendmsg+0x61a/0x860 [ 24.833111][ T618] ? ___sys_sendmsg+0x14e/0x1d0 [ 24.833113][ T618] ? __sys_sendmsg+0x12c/0x1d0 [ 24.833114][ T618] ? do_syscall_64+0xff/0x530 [ 24.833117][ T618] ? entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 24.833119][ T618] ? rcu_is_watching+0x16/0xd0 [ 24.833120][ T618] ? lock_acquire+0x13c/0x160 [ 24.833122][ T618] ? rcu_is_watching+0x16/0xd0 [ 24.833123][ T618] ? rcu_is_watching+0x16/0xd0 [ 24.833124][ T618] ? trace_contention_end+0xb3/0x180 [ 24.833125][ T618] ? __mutex_lock+0x1db/0x1ea0 [ 24.833127][ T618] ? __mutex_lock+0x9a3/0x1ea0 [ 24.833128][ T618] ? rtnl_newlink+0x9a8/0x11b0 [ 24.833129][ T618] ? ww_mutex_lock+0x160/0x160 [ 24.833130][ T618] ? nla_get_range_signed+0x3d0/0x3d0 [ 24.833133][ T618] ? rcu_is_watching+0x16/0xd0 [ 24.833135][ T618] ? __rtnl_newlink+0x3fa/0xa50 [ 24.833137][ T618] rtnl_newlink+0x9f1/0x11b0 [ 24.833139][ T618] ? rcu_is_watching+0x16/0xd0 [ 24.833140][ T618] ? rtnl_bridge_getlink+0x850/0x850 [ 24.833141][ T618] ? lock_acquire+0x13c/0x160 [ 24.833142][ T618] ? rcu_is_watching+0x16/0xd0 [ 24.833144][ T618] ? is_bpf_text_address+0x3e/0x110 [ 24.833145][ T618] ? is_bpf_text_address+0x72/0x110 [ 24.833146][ T618] ? kernel_text_address+0x149/0x170 [ 24.833147][ T618] ? rcu_is_watching+0x16/0xd0 [ 24.833148][ T618] ? cap_capable+0x1d7/0x3d0 [ 24.833152][ T618] ? arch_stack_walk+0xed/0x130 [ 24.833154][ T618] ? rcu_is_watching+0x16/0xd0 [ 24.833155][ T618] ? lock_acquire+0x13c/0x160 [ 24.833156][ T618] ? rcu_is_watching+0x16/0xd0 [ 24.833158][ T618] ? rtnl_bridge_getlink+0x850/0x850 [ 24.833159][ T618] rtnetlink_rcv_msg+0x6fd/0xbd0 [ 24.833160][ T618] ? rtnl_link_fill+0x920/0x920 [ 24.833162][ T618] ? filter_irq_stacks+0xd0/0xd0 [ 24.833163][ T618] ? stack_depot_save_flags+0x1bc/0x790 [ 24.833165][ T618] netlink_rcv_skb+0x14e/0x3a0 [ 24.833167][ T618] ? rtnl_link_fill+0x920/0x920 [ 24.833168][ T618] ? lock_release+0x184/0x1f0 [ 24.833170][ T618] ? netlink_ack+0xcf0/0xcf0 [ 24.833171][ T618] ? __netlink_lookup+0xb9/0x6b0 [ 24.833174][ T618] ? rcu_is_watching+0x16/0xd0 [ 24.833175][ T618] ? lock_release+0x184/0x1f0 [ 24.833177][ T618] netlink_unicast+0x486/0x750 [ 24.833179][ T618] ? netlink_attachskb+0x810/0x810 [ 24.833181][ T618] ? entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 24.833183][ T618] netlink_sendmsg+0x75b/0xc90 [ 24.833185][ T618] ? netlink_unicast+0x750/0x750 [ 24.833187][ T618] ? kernel_text_address+0x149/0x170 [ 24.833188][ T618] ? lock_acquire+0x13c/0x160 [ 24.833190][ T618] ? __import_iovec+0x36c/0x620 [ 24.833193][ T618] __sock_sendmsg+0xce/0x190 [ 24.833194][ T618] ____sys_sendmsg+0x61a/0x860 [ 24.833196][ T618] ? copy_msghdr_from_user+0x279/0x420 [ 24.833198][ T618] ? sock_write_iter+0x400/0x400 [ 24.833199][ T618] ? move_addr_to_kernel+0x40/0x40 [ 24.833200][ T618] ? filter_irq_stacks+0xd0/0xd0 [ 24.833203][ T618] ___sys_sendmsg+0x14e/0x1d0 [ 24.833205][ T618] ? copy_msghdr_from_user+0x420/0x420 [ 24.833210][ T618] __sys_sendmsg+0x12c/0x1d0 [ 24.833211][ T618] ? __sys_sendmsg_sock+0x20/0x20 [ 24.833214][ T618] ? rcu_is_watching+0x16/0xd0 [ 24.833216][ T618] do_syscall_64+0xff/0x530 [ 24.833217][ T618] ? exc_page_fault+0xee/0x100 [ 24.833219][ T618] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 24.833221][ T618] RIP: 0033:0x7f1e4250654e [ 24.833223][ T618] 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 [ 24.833224][ T618] RSP: 002b:00007ffeb027ee90 EFLAGS: 00000202 ORIG_RAX: 000000000000002e [ 24.833228][ T618] RAX: ffffffffffffffda RBX: 0000000000000004 RCX: 00007f1e4250654e [ 24.833230][ T618] RDX: 0000000000000000 RSI: 00007ffeb027ef40 RDI: 0000000000000005 [ 24.833230][ T618] RBP: 00007ffeb027eea0 R08: 0000000000000000 R09: 0000000000000000 [ 24.833231][ T618] R10: 0000000000000000 R11: 0000000000000202 R12: 000000006a916ff2 [ 24.833232][ T618] R13: 00000000004a1620 R14: 0000000000000000 R15: 00007ffeb027f610 [ 24.833234][ T618] [ 24.861406][ T618] br0: port 1(veth1) entered disabled state [ 24.861619][ T618] veth1: entered allmulticast mode [ 24.862230][ T618] veth1: entered promiscuous mode [ 24.870179][ T618] ip (618) used greatest stack depth: 23336 bytes left [ 24.984383][ T623] br0: port 2(veth_segment) entered blocking state [ 24.984567][ T623] br0: port 2(veth_segment) entered disabled state [ 24.984730][ T623] veth_segment: entered allmulticast mode [ 24.985276][ T623] veth_segment: entered promiscuous mode [ 25.005757][ T624] br0: port 2(veth_segment) entered blocking state [ 25.005968][ T624] br0: port 2(veth_segment) entered forwarding state [ 25.006283][ T624] br0: port 1(veth1) entered blocking state [ 25.006480][ T624] br0: port 1(veth1) entered forwarding state [ 27.208854][ T637] iperf3 (637) used greatest stack depth: 22848 bytes left [ 27.208872][ T637] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 27.208874][ T637] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 637, name: iperf3 [ 27.208875][ T637] preempt_count: 2, expected: 0 [ 27.208876][ T637] RCU nest depth: 0, expected: 0 [ 27.208877][ T637] INFO: lockdep is turned off. [ 27.208878][ T637] irq event stamp: 0 [ 27.208879][ T637] hardirqs last enabled at (0): [<0000000000000000>] 0x0 [ 27.208883][ T637] hardirqs last disabled at (0): [] copy_process+0x1d3b/0x62b0 [ 27.208890][ T637] softirqs last enabled at (0): [] copy_process+0x1d8f/0x62b0 [ 27.208891][ T637] softirqs last disabled at (0): [<0000000000000000>] 0x0 [ 27.208893][ T637] Preemption disabled at: [ 27.208894][ T637] [<0000000000000000>] 0x0 [ 27.208898][ T637] CPU: 0 UID: 0 PID: 637 Comm: iperf3 Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 27.208902][ T637] Tainted: [W]=WARN [ 27.208903][ T637] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 27.208905][ T637] Call Trace: [ 27.208907][ T637] [ 27.208908][ T637] dump_stack_lvl+0x6f/0xa0 [ 27.208913][ T637] __might_resched.cold+0x1fe/0x2c1 [ 27.208917][ T637] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 27.208920][ T637] ? prb_next_reserve_seq+0x2d0/0x2d0 [ 27.208923][ T637] ? rcu_is_watching+0x16/0xd0 [ 27.208926][ T637] __kmalloc_noprof+0x443/0x760 [ 27.208928][ T637] ? __rwlock_init+0x150/0x150 [ 27.208931][ T637] ? alloc_buf.isra.0+0x4b/0x260 [ 27.208936][ T637] ? do_raw_spin_unlock+0x59/0x250 [ 27.208938][ T637] alloc_buf.isra.0+0x4b/0x260 [ 27.208940][ T637] put_chars+0x1e1/0x2f0 [ 27.208941][ T637] ? prb_final_commit+0x50/0x50 [ 27.208943][ T637] ? __send_to_port+0x420/0x420 [ 27.208944][ T637] ? printk_get_next_message+0x240/0x650 [ 27.208947][ T637] hvc_console_print+0x292/0x780 [ 27.208951][ T637] ? hvc_write+0x3a0/0x3a0 [ 27.208953][ T637] ? do_raw_spin_lock+0x131/0x280 [ 27.208955][ T637] ? vsnprintf+0x668/0x1700 [ 27.208958][ T637] ? __rwlock_init+0x150/0x150 [ 27.208959][ T637] ? rcu_is_watching+0x16/0xd0 [ 27.208961][ T637] ? lock_acquire+0x13c/0x160 [ 27.208963][ T637] console_emit_next_record+0x22f/0x4c0 [ 27.208966][ T637] ? devkmsg_read+0x4b0/0x4b0 [ 27.208968][ T637] ? rcu_is_watching+0x16/0xd0 [ 27.208969][ T637] ? rcu_is_watching+0x16/0xd0 [ 27.208970][ T637] ? rcu_is_watching+0x16/0xd0 [ 27.208971][ T637] ? lock_acquire+0x13c/0x160 [ 27.208972][ T637] ? console_flush_one_record+0x111/0x710 [ 27.208974][ T637] console_flush_one_record+0x46f/0x710 [ 27.208976][ T637] ? console_emit_next_record+0x4c0/0x4c0 [ 27.208979][ T637] console_unlock+0xee/0x1f0 [ 27.208981][ T637] ? lock_acquire+0x13c/0x160 [ 27.208982][ T637] ? console_flush_one_record+0x710/0x710 [ 27.208984][ T637] ? rcu_is_watching+0x16/0xd0 [ 27.208985][ T637] ? lock_release+0x184/0x1f0 [ 27.208986][ T637] ? lock_acquire+0xe0/0x160 [ 27.208988][ T637] ? __rcu_read_lock+0x70/0x70 [ 27.208989][ T637] ? __down_trylock_console_sem+0x5e/0xa0 [ 27.208991][ T637] ? vprintk_emit+0x320/0x3e0 [ 27.208992][ T637] vprintk_emit+0x37c/0x3e0 [ 27.208994][ T637] ? wake_up_klogd_work_func+0x90/0x90 [ 27.208995][ T637] ? do_raw_spin_unlock+0x59/0x250 [ 27.208997][ T637] ? _raw_spin_unlock+0x2d/0x50 [ 27.208999][ T637] ? __free_frozen_pages+0x6ab/0xfc0 [ 27.209002][ T637] _printk+0xc7/0x100 [ 27.209005][ T637] ? snapshot_read.cold+0x21/0x21 [ 27.209007][ T637] ? do_raw_spin_lock+0x131/0x280 [ 27.209009][ T637] ? __rwlock_init+0x150/0x150 [ 27.209011][ T637] ? do_raw_spin_lock+0x131/0x280 [ 27.209012][ T637] do_exit.cold+0x82/0x9c [ 27.209015][ T637] ? exit_notify+0x890/0x890 [ 27.209018][ T637] __x64_sys_exit+0x42/0x50 [ 27.209019][ T637] x64_sys_call+0x156c/0x1570 [ 27.209022][ T637] do_syscall_64+0xff/0x530 [ 27.209024][ T637] ? exc_page_fault+0xee/0x100 [ 27.209026][ T637] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 27.209028][ T637] RIP: 0033:0x7f720a78bc49 [ 27.209029][ T637] Code: Unable to access opcode bytes at 0x7f720a78bc1f. [ 27.209031][ T637] RSP: 002b:00007f7209f4ae60 EFLAGS: 00000246 ORIG_RAX: 000000000000003c [ 27.209034][ T637] RAX: ffffffffffffffda RBX: 00007f7209f4b6c0 RCX: 00007f720a78bc49 [ 27.209035][ T637] RDX: 0000000000000000 RSI: 0000000000801000 RDI: 0000000000000000 [ 27.209036][ T637] RBP: 00007f7209f4af70 R08: 0000000000000001 R09: 00007f7209f4b6c0 [ 27.209037][ T637] R10: 0000000000000008 R11: 0000000000000246 R12: 00007f720974b000 [ 27.209038][ T637] R13: 00007ffc424ba8f0 R14: 0000000000000002 R15: 00007ffc424ba9f7 [ 27.209040][ T637] [ 27.309017][ T72] br0: port 1(veth1) entered disabled state [ 27.314278][ T72] veth1 (unregistering): left allmulticast mode [ 27.314452][ T72] veth1 (unregistering): left promiscuous mode [ 27.314604][ T72] br0: port 1(veth1) entered disabled state [ 27.346882][ T72] veth_segment: left allmulticast mode [ 27.347032][ T72] veth_segment: left promiscuous mode [ 27.347334][ T72] br0: port 2(veth_segment) entered disabled state [ 41.072917][ T1042] br0: port 1(veth1) entered blocking state [ 41.072934][ T1042] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 41.072936][ T1042] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 1042, name: ip [ 41.072937][ T1042] preempt_count: 1, expected: 0 [ 41.072938][ T1042] RCU nest depth: 0, expected: 0 [ 41.072939][ T1042] INFO: lockdep is turned off. [ 41.072940][ T1042] irq event stamp: 0 [ 41.072941][ T1042] hardirqs last enabled at (0): [<0000000000000000>] 0x0 [ 41.072945][ T1042] hardirqs last disabled at (0): [] copy_process+0x1d3b/0x62b0 [ 41.072952][ T1042] softirqs last enabled at (0): [] copy_process+0x1d8f/0x62b0 [ 41.072953][ T1042] softirqs last disabled at (0): [<0000000000000000>] 0x0 [ 41.072955][ T1042] Preemption disabled at: [ 41.072956][ T1042] [] vprintk_emit+0x31b/0x3e0 [ 41.072962][ T1042] CPU: 0 UID: 0 PID: 1042 Comm: ip Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 41.072965][ T1042] Tainted: [W]=WARN [ 41.072966][ T1042] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 41.072968][ T1042] Call Trace: [ 41.072969][ T1042] [ 41.072971][ T1042] dump_stack_lvl+0x6f/0xa0 [ 41.072976][ T1042] ? vprintk_emit+0x31b/0x3e0 [ 41.072977][ T1042] __might_resched.cold+0x1fe/0x2c1 [ 41.072981][ T1042] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 41.072984][ T1042] ? __asan_memcpy+0x3c/0x60 [ 41.072987][ T1042] ? rcu_is_watching+0x16/0xd0 [ 41.072990][ T1042] __kmalloc_noprof+0x443/0x760 [ 41.072992][ T1042] ? __rwlock_init+0x150/0x150 [ 41.072995][ T1042] ? alloc_buf.isra.0+0x4b/0x260 [ 41.073000][ T1042] ? do_raw_spin_unlock+0x59/0x250 [ 41.073002][ T1042] alloc_buf.isra.0+0x4b/0x260 [ 41.073004][ T1042] put_chars+0x1e1/0x2f0 [ 41.073006][ T1042] ? __send_to_port+0x420/0x420 [ 41.073007][ T1042] ? console_prepend_replay+0x20/0x20 [ 41.073010][ T1042] hvc_console_print+0x292/0x780 [ 41.073015][ T1042] ? hvc_write+0x3a0/0x3a0 [ 41.073016][ T1042] ? rcu_is_watching+0x16/0xd0 [ 41.073018][ T1042] ? lock_acquire+0x13c/0x160 [ 41.073020][ T1042] console_emit_next_record+0x22f/0x4c0 [ 41.073023][ T1042] ? devkmsg_read+0x4b0/0x4b0 [ 41.073025][ T1042] ? rcu_is_watching+0x16/0xd0 [ 41.073026][ T1042] ? rcu_is_watching+0x16/0xd0 [ 41.073026][ T1042] ? rcu_is_watching+0x16/0xd0 [ 41.073027][ T1042] ? lock_acquire+0x13c/0x160 [ 41.073029][ T1042] ? console_flush_one_record+0x111/0x710 [ 41.073031][ T1042] console_flush_one_record+0x46f/0x710 [ 41.073033][ T1042] ? console_emit_next_record+0x4c0/0x4c0 [ 41.073036][ T1042] console_unlock+0xee/0x1f0 [ 41.073038][ T1042] ? lock_acquire+0x13c/0x160 [ 41.073039][ T1042] ? console_flush_one_record+0x710/0x710 [ 41.073041][ T1042] ? rcu_is_watching+0x16/0xd0 [ 41.073042][ T1042] ? lock_release+0x184/0x1f0 [ 41.073043][ T1042] ? lock_acquire+0xe0/0x160 [ 41.073044][ T1042] ? __rcu_read_lock+0x70/0x70 [ 41.073046][ T1042] ? __down_trylock_console_sem+0x5e/0xa0 [ 41.073050][ T1042] ? vprintk_emit+0x320/0x3e0 [ 41.073052][ T1042] vprintk_emit+0x37c/0x3e0 [ 41.073054][ T1042] ? wake_up_klogd_work_func+0x90/0x90 [ 41.073055][ T1042] ? __rwlock_init+0x150/0x150 [ 41.073056][ T1042] ? filter_irq_stacks+0xd0/0xd0 [ 41.073059][ T1042] ? lock_acquire+0x13c/0x160 [ 41.073060][ T1042] ? rcu_is_watching+0x16/0xd0 [ 41.073062][ T1042] _printk+0xc7/0x100 [ 41.073065][ T1042] ? snapshot_read.cold+0x21/0x21 [ 41.073067][ T1042] ? br_multicast_flood+0x960/0x960 [ 41.073070][ T1042] ? do_setlink.isra.0+0x9ec/0x2a60 [ 41.073073][ T1042] ? rtnl_newlink+0x9f1/0x11b0 [ 41.073074][ T1042] ? rtnetlink_rcv_msg+0x6fd/0xbd0 [ 41.073076][ T1042] br_set_state+0x22f/0x430 [ 41.073078][ T1042] br_init_port+0xc4/0x200 [ 41.073080][ T1042] new_nbp+0x3a0/0x650 [ 41.073082][ T1042] br_add_if+0x212/0x1320 [ 41.073084][ T1042] ? is_bpf_text_address+0x3e/0x110 [ 41.073087][ T1042] ? is_bpf_text_address+0x72/0x110 [ 41.073088][ T1042] ? kernel_text_address+0x149/0x170 [ 41.073091][ T1042] do_set_master+0x3b2/0x780 [ 41.073092][ T1042] do_setlink.isra.0+0x9ec/0x2a60 [ 41.073094][ T1042] ? stack_trace_save+0x93/0xc0 [ 41.073095][ T1042] ? rtnl_link_get_size+0x350/0x350 [ 41.073097][ T1042] ? rcu_is_watching+0x16/0xd0 [ 41.073098][ T1042] ? stack_depot_save_flags+0x1bc/0x790 [ 41.073101][ T1042] ? kasan_save_stack+0x3d/0x50 [ 41.073103][ T1042] ? kasan_save_stack+0x2f/0x50 [ 41.073104][ T1042] ? kasan_save_track+0x14/0x30 [ 41.073105][ T1042] ? __kasan_kmalloc+0x7b/0x90 [ 41.073106][ T1042] ? __kmalloc_cache_noprof+0x29a/0x620 [ 41.073107][ T1042] ? rtnl_newlink+0x124/0x11b0 [ 41.073108][ T1042] ? rtnetlink_rcv_msg+0x6fd/0xbd0 [ 41.073109][ T1042] ? netlink_rcv_skb+0x14e/0x3a0 [ 41.073111][ T1042] ? netlink_unicast+0x486/0x750 [ 41.073113][ T1042] ? netlink_sendmsg+0x75b/0xc90 [ 41.073114][ T1042] ? __sock_sendmsg+0xce/0x190 [ 41.073117][ T1042] ? ____sys_sendmsg+0x61a/0x860 [ 41.073118][ T1042] ? ___sys_sendmsg+0x14e/0x1d0 [ 41.073119][ T1042] ? __sys_sendmsg+0x12c/0x1d0 [ 41.073121][ T1042] ? do_syscall_64+0xff/0x530 [ 41.073124][ T1042] ? entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 41.073127][ T1042] ? rcu_is_watching+0x16/0xd0 [ 41.073128][ T1042] ? lock_acquire+0x13c/0x160 [ 41.073129][ T1042] ? rcu_is_watching+0x16/0xd0 [ 41.073130][ T1042] ? rcu_is_watching+0x16/0xd0 [ 41.073131][ T1042] ? trace_contention_end+0xb3/0x180 [ 41.073132][ T1042] ? __mutex_lock+0x1db/0x1ea0 [ 41.073134][ T1042] ? __mutex_lock+0x9a3/0x1ea0 [ 41.073135][ T1042] ? rtnl_newlink+0x9a8/0x11b0 [ 41.073137][ T1042] ? ww_mutex_lock+0x160/0x160 [ 41.073138][ T1042] ? nla_get_range_signed+0x3d0/0x3d0 [ 41.073141][ T1042] ? rcu_is_watching+0x16/0xd0 [ 41.073142][ T1042] ? __rtnl_newlink+0x3fa/0xa50 [ 41.073144][ T1042] rtnl_newlink+0x9f1/0x11b0 [ 41.073146][ T1042] ? rcu_is_watching+0x16/0xd0 [ 41.073147][ T1042] ? rtnl_bridge_getlink+0x850/0x850 [ 41.073148][ T1042] ? lock_acquire+0x13c/0x160 [ 41.073150][ T1042] ? rcu_is_watching+0x16/0xd0 [ 41.073151][ T1042] ? is_bpf_text_address+0x3e/0x110 [ 41.073152][ T1042] ? is_bpf_text_address+0x72/0x110 [ 41.073153][ T1042] ? kernel_text_address+0x149/0x170 [ 41.073155][ T1042] ? rcu_is_watching+0x16/0xd0 [ 41.073156][ T1042] ? cap_capable+0x1d7/0x3d0 [ 41.073159][ T1042] ? arch_stack_walk+0xed/0x130 [ 41.073161][ T1042] ? rcu_is_watching+0x16/0xd0 [ 41.073162][ T1042] ? lock_acquire+0x13c/0x160 [ 41.073164][ T1042] ? rcu_is_watching+0x16/0xd0 [ 41.073165][ T1042] ? rtnl_bridge_getlink+0x850/0x850 [ 41.073166][ T1042] rtnetlink_rcv_msg+0x6fd/0xbd0 [ 41.073168][ T1042] ? rtnl_link_fill+0x920/0x920 [ 41.073169][ T1042] ? filter_irq_stacks+0xd0/0xd0 [ 41.073170][ T1042] ? stack_depot_save_flags+0x1bc/0x790 [ 41.073173][ T1042] netlink_rcv_skb+0x14e/0x3a0 [ 41.073174][ T1042] ? rtnl_link_fill+0x920/0x920 [ 41.073176][ T1042] ? lock_release+0x184/0x1f0 [ 41.073177][ T1042] ? netlink_ack+0xcf0/0xcf0 [ 41.073179][ T1042] ? __netlink_lookup+0xb9/0x6b0 [ 41.073182][ T1042] ? rcu_is_watching+0x16/0xd0 [ 41.073183][ T1042] ? lock_release+0x184/0x1f0 [ 41.073185][ T1042] netlink_unicast+0x486/0x750 [ 41.073187][ T1042] ? netlink_attachskb+0x810/0x810 [ 41.073188][ T1042] ? entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 41.073190][ T1042] netlink_sendmsg+0x75b/0xc90 [ 41.073192][ T1042] ? netlink_unicast+0x750/0x750 [ 41.073194][ T1042] ? kernel_text_address+0x149/0x170 [ 41.073195][ T1042] ? lock_acquire+0x13c/0x160 [ 41.073197][ T1042] ? __import_iovec+0x36c/0x620 [ 41.073200][ T1042] __sock_sendmsg+0xce/0x190 [ 41.073202][ T1042] ____sys_sendmsg+0x61a/0x860 [ 41.073203][ T1042] ? copy_msghdr_from_user+0x279/0x420 [ 41.073205][ T1042] ? sock_write_iter+0x400/0x400 [ 41.073206][ T1042] ? move_addr_to_kernel+0x40/0x40 [ 41.073208][ T1042] ? filter_irq_stacks+0xd0/0xd0 [ 41.073210][ T1042] ___sys_sendmsg+0x14e/0x1d0 [ 41.073212][ T1042] ? copy_msghdr_from_user+0x420/0x420 [ 41.073216][ T1042] __sys_sendmsg+0x12c/0x1d0 [ 41.073218][ T1042] ? __sys_sendmsg_sock+0x20/0x20 [ 41.073221][ T1042] ? rcu_is_watching+0x16/0xd0 [ 41.073222][ T1042] do_syscall_64+0xff/0x530 [ 41.073224][ T1042] ? exc_page_fault+0xee/0x100 [ 41.073226][ T1042] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 41.073227][ T1042] RIP: 0033:0x7f8479bbe54e [ 41.073229][ T1042] 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 [ 41.073231][ T1042] RSP: 002b:00007ffe4304eb50 EFLAGS: 00000202 ORIG_RAX: 000000000000002e [ 41.073234][ T1042] RAX: ffffffffffffffda RBX: 0000000000000004 RCX: 00007f8479bbe54e [ 41.073235][ T1042] RDX: 0000000000000000 RSI: 00007ffe4304ec00 RDI: 0000000000000005 [ 41.073236][ T1042] RBP: 00007ffe4304eb60 R08: 0000000000000000 R09: 0000000000000000 [ 41.073237][ T1042] R10: 0000000000000000 R11: 0000000000000202 R12: 000000006a917002 [ 41.073238][ T1042] R13: 00000000004a1620 R14: 0000000000000000 R15: 00007ffe4304f2d0 [ 41.073240][ T1042] [ 41.095329][ T1042] br0: port 1(veth1) entered disabled state [ 41.095527][ T1042] veth1: entered allmulticast mode [ 41.096112][ T1042] veth1: entered promiscuous mode [ 41.225368][ T1047] br0: port 2(veth_segment) entered blocking state [ 41.225552][ T1047] br0: port 2(veth_segment) entered disabled state [ 41.225721][ T1047] veth_segment: entered allmulticast mode [ 41.226301][ T1047] veth_segment: entered promiscuous mode [ 41.245724][ T1048] br0: port 2(veth_segment) entered blocking state [ 41.245965][ T1048] br0: port 2(veth_segment) entered forwarding state [ 41.246282][ T1048] br0: port 1(veth1) entered blocking state [ 41.246481][ T1048] br0: port 1(veth1) entered forwarding state [ 43.441114][ T1061] iperf3 (1061) used greatest stack depth: 21576 bytes left [ 43.441132][ T1061] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 43.441134][ T1061] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 1061, name: iperf3 [ 43.441136][ T1061] preempt_count: 2, expected: 0 [ 43.441137][ T1061] RCU nest depth: 0, expected: 0 [ 43.441137][ T1061] INFO: lockdep is turned off. [ 43.441139][ T1061] irq event stamp: 0 [ 43.441139][ T1061] hardirqs last enabled at (0): [<0000000000000000>] 0x0 [ 43.441144][ T1061] hardirqs last disabled at (0): [] copy_process+0x1d3b/0x62b0 [ 43.441150][ T1061] softirqs last enabled at (0): [] copy_process+0x1d8f/0x62b0 [ 43.441152][ T1061] softirqs last disabled at (0): [<0000000000000000>] 0x0 [ 43.441153][ T1061] Preemption disabled at: [ 43.441154][ T1061] [<0000000000000000>] 0x0 [ 43.441159][ T1061] CPU: 2 UID: 0 PID: 1061 Comm: iperf3 Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 43.441162][ T1061] Tainted: [W]=WARN [ 43.441163][ T1061] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 43.441165][ T1061] Call Trace: [ 43.441167][ T1061] [ 43.441168][ T1061] dump_stack_lvl+0x6f/0xa0 [ 43.441174][ T1061] __might_resched.cold+0x1fe/0x2c1 [ 43.441178][ T1061] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 43.441181][ T1061] ? prb_next_reserve_seq+0x2d0/0x2d0 [ 43.441184][ T1061] ? rcu_is_watching+0x16/0xd0 [ 43.441186][ T1061] __kmalloc_noprof+0x443/0x760 [ 43.441189][ T1061] ? __rwlock_init+0x150/0x150 [ 43.441192][ T1061] ? alloc_buf.isra.0+0x4b/0x260 [ 43.441197][ T1061] ? do_raw_spin_unlock+0x59/0x250 [ 43.441199][ T1061] alloc_buf.isra.0+0x4b/0x260 [ 43.441201][ T1061] put_chars+0x1e1/0x2f0 [ 43.441203][ T1061] ? prb_final_commit+0x50/0x50 [ 43.441204][ T1061] ? __send_to_port+0x420/0x420 [ 43.441206][ T1061] ? printk_get_next_message+0x240/0x650 [ 43.441209][ T1061] hvc_console_print+0x292/0x780 [ 43.441213][ T1061] ? hvc_write+0x3a0/0x3a0 [ 43.441215][ T1061] ? do_raw_spin_lock+0x131/0x280 [ 43.441217][ T1061] ? vsnprintf+0x668/0x1700 [ 43.441220][ T1061] ? __rwlock_init+0x150/0x150 [ 43.441222][ T1061] ? rcu_is_watching+0x16/0xd0 [ 43.441223][ T1061] ? lock_acquire+0x13c/0x160 [ 43.441226][ T1061] console_emit_next_record+0x22f/0x4c0 [ 43.441229][ T1061] ? devkmsg_read+0x4b0/0x4b0 [ 43.441231][ T1061] ? rcu_is_watching+0x16/0xd0 [ 43.441231][ T1061] ? rcu_is_watching+0x16/0xd0 [ 43.441232][ T1061] ? rcu_is_watching+0x16/0xd0 [ 43.441233][ T1061] ? lock_acquire+0x13c/0x160 [ 43.441235][ T1061] ? console_flush_one_record+0x111/0x710 [ 43.441237][ T1061] console_flush_one_record+0x46f/0x710 [ 43.441239][ T1061] ? console_emit_next_record+0x4c0/0x4c0 [ 43.441242][ T1061] console_unlock+0xee/0x1f0 [ 43.441244][ T1061] ? lock_acquire+0x13c/0x160 [ 43.441245][ T1061] ? console_flush_one_record+0x710/0x710 [ 43.441247][ T1061] ? rcu_is_watching+0x16/0xd0 [ 43.441248][ T1061] ? lock_release+0x184/0x1f0 [ 43.441249][ T1061] ? lock_acquire+0xe0/0x160 [ 43.441251][ T1061] ? __rcu_read_lock+0x70/0x70 [ 43.441252][ T1061] ? __down_trylock_console_sem+0x5e/0xa0 [ 43.441254][ T1061] ? vprintk_emit+0x320/0x3e0 [ 43.441255][ T1061] vprintk_emit+0x37c/0x3e0 [ 43.441257][ T1061] ? wake_up_klogd_work_func+0x90/0x90 [ 43.441258][ T1061] ? do_raw_spin_unlock+0x59/0x250 [ 43.441260][ T1061] ? _raw_spin_unlock+0x2d/0x50 [ 43.441262][ T1061] ? __free_frozen_pages+0x6ab/0xfc0 [ 43.441265][ T1061] _printk+0xc7/0x100 [ 43.441268][ T1061] ? snapshot_read.cold+0x21/0x21 [ 43.441270][ T1061] ? do_raw_spin_lock+0x131/0x280 [ 43.441272][ T1061] ? __rwlock_init+0x150/0x150 [ 43.441274][ T1061] ? do_raw_spin_lock+0x131/0x280 [ 43.441276][ T1061] do_exit.cold+0x82/0x9c [ 43.441279][ T1061] ? exit_notify+0x890/0x890 [ 43.441281][ T1061] ? rcu_is_watching+0x16/0xd0 [ 43.441282][ T1061] __x64_sys_exit+0x42/0x50 [ 43.441284][ T1061] x64_sys_call+0x156c/0x1570 [ 43.441286][ T1061] do_syscall_64+0xff/0x530 [ 43.441288][ T1061] ? irq_exit_rcu+0x1a/0x30 [ 43.441290][ T1061] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 43.441292][ T1061] RIP: 0033:0x7fefea468c49 [ 43.441294][ T1061] Code: Unable to access opcode bytes at 0x7fefea468c1f. [ 43.441295][ T1061] RSP: 002b:00007fefe9c27e60 EFLAGS: 00000246 ORIG_RAX: 000000000000003c [ 43.441298][ T1061] RAX: ffffffffffffffda RBX: 00007fefe9c286c0 RCX: 00007fefea468c49 [ 43.441299][ T1061] RDX: 0000000000000000 RSI: 0000000000801000 RDI: 0000000000000000 [ 43.441300][ T1061] RBP: 00007fefe9c27f70 R08: 0000000000000001 R09: 00007fefe9c286c0 [ 43.441301][ T1061] R10: 0000000000000008 R11: 0000000000000246 R12: 00007fefe9428000 [ 43.441302][ T1061] R13: 00007ffe83153bd0 R14: 0000000000000002 R15: 00007ffe83153cd7 [ 43.441304][ T1061] [ 43.527922][ T72] br0: port 1(veth1) entered disabled state [ 43.537262][ T72] veth1 (unregistering): left allmulticast mode [ 43.537432][ T72] veth1 (unregistering): left promiscuous mode [ 43.537584][ T72] br0: port 1(veth1) entered disabled state [ 43.560819][ T72] veth_segment: left allmulticast mode [ 43.560973][ T72] veth_segment: left promiscuous mode [ 43.561163][ T72] br0: port 2(veth_segment) entered disabled state