[ 9.546530][ T188] ip (188) used greatest stack depth: 23712 bytes left [ 9.546546][ T188] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 9.546548][ T188] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 188, name: ip [ 9.546549][ T188] preempt_count: 2, expected: 0 [ 9.546550][ T188] RCU nest depth: 0, expected: 0 [ 9.546551][ T188] locks held by ip/188: 5, last CPU#2: [ 9.546553][ T188] #0: ffffffff866027b8 (low_water_lock){+.+.}-{3:3}, at: do_exit+0x887/0xdc0 [ 9.546565][ T188] #1: ffffffff86769cc0 (console_lock){+.+.}-{0:0}, at: vprintk_emit+0x320/0x3e0 [ 9.546571][ T188] #2: ffffffff86769d38 (console_srcu){....}-{0:0}, at: console_flush_one_record+0x106/0x710 [ 9.546575][ T188] #3: ffffffff86689660 (console_owner){....}-{0:0}, at: console_lock_spinning_enable+0x40/0x60 [ 9.546579][ T188] #4: ffffffff86689560 (printk_legacy_map-wait-type-override){....}-{3:3}, at: console_emit_next_record+0x1df/0x4c0 [ 9.546583][ T188] irq event stamp: 31896 [ 9.546583][ T188] hardirqs last enabled at (31895): [] __down_trylock_console_sem+0x86/0xa0 [ 9.546586][ T188] hardirqs last disabled at (31896): [] console_emit_next_record+0x3d4/0x4c0 [ 9.546588][ T188] softirqs last enabled at (30978): [] handle_softirqs+0x67c/0x900 [ 9.546590][ T188] softirqs last disabled at (30967): [] __irq_exit_rcu+0x145/0x1c0 [ 9.546593][ T188] Preemption disabled at: [ 9.546593][ T188] [<0000000000000000>] 0x0 [ 9.546600][ T188] CPU: 2 UID: 0 PID: 188 Comm: ip Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 9.546604][ T188] Tainted: [W]=WARN [ 9.546605][ T188] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 9.546606][ T188] Call Trace: [ 9.546608][ T188] [ 9.546609][ T188] dump_stack_lvl+0x6f/0xa0 [ 9.546615][ T188] __might_resched.cold+0x1fe/0x2c1 [ 9.546620][ T188] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 9.546624][ T188] ? __kmalloc_noprof+0xdb/0x760 [ 9.546630][ T188] __kmalloc_noprof+0x443/0x760 [ 9.546632][ T188] ? alloc_buf.isra.0+0x4b/0x260 [ 9.546638][ T188] ? do_raw_spin_unlock+0x59/0x250 [ 9.546641][ T188] alloc_buf.isra.0+0x4b/0x260 [ 9.546644][ T188] put_chars+0x1e1/0x2f0 [ 9.546646][ T188] ? __send_to_port+0x420/0x420 [ 9.546648][ T188] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 9.546652][ T188] ? validate_chain+0x38b/0xc20 [ 9.546657][ T188] hvc_console_print+0x292/0x780 [ 9.546664][ T188] ? hvc_write+0x3a0/0x3a0 [ 9.546666][ T188] ? rcu_is_watching+0x16/0xd0 [ 9.546668][ T188] ? lock_acquire+0x13c/0x160 [ 9.546672][ T188] console_emit_next_record+0x22f/0x4c0 [ 9.546676][ T188] ? devkmsg_read+0x4b0/0x4b0 [ 9.546678][ T188] ? console_flush_one_record+0x106/0x710 [ 9.546681][ T188] ? rcu_is_watching+0x16/0xd0 [ 9.546683][ T188] ? lock_acquire+0x13c/0x160 [ 9.546687][ T188] console_flush_one_record+0x46f/0x710 [ 9.546691][ T188] ? console_emit_next_record+0x4c0/0x4c0 [ 9.546693][ T188] ? __lock_acquire+0x518/0xc20 [ 9.546698][ T188] console_unlock+0xee/0x1f0 [ 9.546701][ T188] ? console_flush_one_record+0x710/0x710 [ 9.546702][ T188] ? rcu_is_watching+0x16/0xd0 [ 9.546705][ T188] ? lock_acquire+0x60/0x160 [ 9.546708][ T188] ? __down_trylock_console_sem+0x5e/0xa0 [ 9.546710][ T188] ? vprintk_emit+0x320/0x3e0 [ 9.546713][ T188] vprintk_emit+0x37c/0x3e0 [ 9.546717][ T188] ? wake_up_klogd_work_func+0x90/0x90 [ 9.546720][ T188] ? __lock_acquire+0x518/0xc20 [ 9.546724][ T188] _printk+0xc7/0x100 [ 9.546728][ T188] ? snapshot_read.cold+0x21/0x21 [ 9.546731][ T188] ? do_raw_spin_lock+0x131/0x280 [ 9.546733][ T188] ? __rwlock_init+0x150/0x150 [ 9.546737][ T188] ? do_raw_spin_lock+0x131/0x280 [ 9.546739][ T188] do_exit.cold+0x82/0x9c [ 9.546743][ T188] ? exit_notify+0x890/0x890 [ 9.546745][ T188] ? __lock_release.isra.0+0x69/0x1a0 [ 9.546748][ T188] ? rcu_is_watching+0x16/0xd0 [ 9.546752][ T188] do_group_exit+0xb8/0x370 [ 9.546755][ T188] __x64_sys_exit_group+0x3c/0x50 [ 9.546756][ T188] x64_sys_call+0x1567/0x1570 [ 9.546759][ T188] do_syscall_64+0xff/0x530 [ 9.546762][ T188] ? exc_page_fault+0xee/0x100 [ 9.546765][ T188] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 9.546767][ T188] RIP: 0033:0x7f5e3545b1b8 [ 9.546769][ T188] Code: Unable to access opcode bytes at 0x7f5e3545b18e. [ 9.546771][ T188] RSP: 002b:00007ffda3b56b88 EFLAGS: 00000246 ORIG_RAX: 00000000000000e7 [ 9.546773][ T188] RAX: ffffffffffffffda RBX: 00007f5e3558bf88 RCX: 00007f5e3545b1b8 [ 9.546774][ T188] RDX: 00007f5e351a5fc8 RSI: fffffffffffffeb8 RDI: 0000000000000000 [ 9.546775][ T188] RBP: 00007ffda3b56be0 R08: 0000000000000000 R09: 0000000000008010 [ 9.546776][ T188] R10: 00007ffda3b569a0 R11: 0000000000000246 R12: 0000000000000001 [ 9.546777][ T188] R13: 0000000000000000 R14: 00007f5e3558a680 R15: 00007f5e3558bfa0 [ 9.546783][ T188] [ 10.430147][ T227] 8021q: 802.1Q VLAN Support v1.8 [ 11.104241][ T251] br0: port 1(veth1) entered blocking state [ 11.104357][ T251] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 11.104360][ T251] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 251, name: ip [ 11.104361][ T251] preempt_count: 1, expected: 0 [ 11.104362][ T251] RCU nest depth: 0, expected: 0 [ 11.104363][ T251] locks held by ip/251: 5, last CPU#0: [ 11.104365][ T251] #0: ffffffff86ed2c40 (rtnl_mutex){+.+.}-{4:4}, at: rtnl_newlink+0x9a8/0x11c0 [ 11.104377][ T251] #1: ffffffff86769cc0 (console_lock){+.+.}-{0:0}, at: vprintk_emit+0x320/0x3e0 [ 11.104384][ T251] #2: ffffffff86769d38 (console_srcu){....}-{0:0}, at: console_flush_one_record+0x106/0x710 [ 11.104387][ T251] #3: ffffffff86689660 (console_owner){....}-{0:0}, at: console_lock_spinning_enable+0x40/0x60 [ 11.104391][ T251] #4: ffffffff86689560 (printk_legacy_map-wait-type-override){....}-{3:3}, at: console_emit_next_record+0x1df/0x4c0 [ 11.104395][ T251] irq event stamp: 20796 [ 11.104396][ T251] hardirqs last enabled at (20795): [] __down_trylock_console_sem+0x86/0xa0 [ 11.104399][ T251] hardirqs last disabled at (20796): [] console_emit_next_record+0x3d4/0x4c0 [ 11.104401][ T251] softirqs last enabled at (19494): [] handle_softirqs+0x67c/0x900 [ 11.104404][ T251] softirqs last disabled at (19487): [] __irq_exit_rcu+0x145/0x1c0 [ 11.104407][ T251] Preemption disabled at: [ 11.104407][ T251] [] vprintk_emit+0x31b/0x3e0 [ 11.104413][ T251] CPU: 0 UID: 0 PID: 251 Comm: ip Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 11.104417][ T251] Tainted: [W]=WARN [ 11.104418][ T251] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 11.104420][ T251] Call Trace: [ 11.104421][ T251] [ 11.104423][ T251] dump_stack_lvl+0x6f/0xa0 [ 11.104429][ T251] ? vprintk_emit+0x31b/0x3e0 [ 11.104431][ T251] __might_resched.cold+0x1fe/0x2c1 [ 11.104435][ T251] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 11.104439][ T251] ? __kmalloc_noprof+0xdb/0x760 [ 11.104445][ T251] __kmalloc_noprof+0x443/0x760 [ 11.104447][ T251] ? alloc_buf.isra.0+0x4b/0x260 [ 11.104453][ T251] ? do_raw_spin_unlock+0x59/0x250 [ 11.104455][ T251] alloc_buf.isra.0+0x4b/0x260 [ 11.104458][ T251] put_chars+0x1e1/0x2f0 [ 11.104461][ T251] ? __send_to_port+0x420/0x420 [ 11.104466][ T251] ? validate_chain+0x34a/0xc20 [ 11.104469][ T251] hvc_console_print+0x292/0x780 [ 11.104472][ T251] ? mark_usage+0x61/0x170 [ 11.104474][ T251] ? __lock_acquire+0x518/0xc20 [ 11.104475][ T251] ? __lock_acquire+0x518/0xc20 [ 11.104479][ T251] ? hvc_write+0x3a0/0x3a0 [ 11.104481][ T251] ? console_emit_next_record+0x1df/0x4c0 [ 11.104484][ T251] ? rcu_is_watching+0x16/0xd0 [ 11.104489][ T251] ? lock_acquire+0x13c/0x160 [ 11.104497][ T251] console_emit_next_record+0x22f/0x4c0 [ 11.104500][ T251] ? devkmsg_read+0x4b0/0x4b0 [ 11.104502][ T251] ? console_flush_one_record+0x106/0x710 [ 11.104505][ T251] ? rcu_is_watching+0x16/0xd0 [ 11.104508][ T251] ? lock_acquire+0x13c/0x160 [ 11.104512][ T251] console_flush_one_record+0x46f/0x710 [ 11.104516][ T251] ? console_emit_next_record+0x4c0/0x4c0 [ 11.104518][ T251] ? __lock_acquire+0x518/0xc20 [ 11.104523][ T251] console_unlock+0xee/0x1f0 [ 11.104526][ T251] ? console_flush_one_record+0x710/0x710 [ 11.104527][ T251] ? rcu_is_watching+0x16/0xd0 [ 11.104530][ T251] ? lock_acquire+0x60/0x160 [ 11.104533][ T251] ? __down_trylock_console_sem+0x5e/0xa0 [ 11.104535][ T251] ? vprintk_emit+0x320/0x3e0 [ 11.104539][ T251] vprintk_emit+0x37c/0x3e0 [ 11.104543][ T251] ? wake_up_klogd_work_func+0x90/0x90 [ 11.104545][ T251] ? __lock_release.isra.0+0x69/0x1a0 [ 11.104547][ T251] ? _raw_spin_unlock_irqrestore+0x40/0x80 [ 11.104551][ T251] ? mark_held_locks+0x40/0x70 [ 11.104554][ T251] _printk+0xc7/0x100 [ 11.104558][ T251] ? snapshot_read.cold+0x21/0x21 [ 11.104562][ T251] ? br_multicast_flood+0xab0/0xab0 [bridge] [ 11.104574][ T251] ? do_setlink.isra.0+0xa31/0x2750 [ 11.104576][ T251] ? rtnl_newlink+0x9f1/0x11c0 [ 11.104577][ T251] ? rtnetlink_rcv_msg+0x6fd/0xbd0 [ 11.104581][ T251] br_set_state+0x22f/0x430 [bridge] [ 11.104591][ T251] br_init_port+0xc4/0x200 [bridge] [ 11.104599][ T251] new_nbp+0x39c/0x580 [bridge] [ 11.104608][ T251] br_add_if+0x212/0x1320 [bridge] [ 11.104615][ T251] ? is_bpf_text_address+0x72/0x110 [ 11.104619][ T251] ? kernel_text_address+0x149/0x170 [ 11.104622][ T251] ? __kernel_text_address+0x12/0x30 [ 11.104626][ T251] do_set_master+0x357/0x580 [ 11.104631][ T251] do_setlink.isra.0+0xa31/0x2750 [ 11.104634][ T251] ? stack_trace_save+0x93/0xc0 [ 11.104637][ T251] ? rtnl_link_get_size+0x350/0x350 [ 11.104638][ T251] ? rcu_read_lock_any_held+0x66/0x90 [ 11.104640][ T251] ? stack_depot_save_flags+0x38e/0x790 [ 11.104644][ T251] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 11.104647][ T251] ? rcu_read_lock_any_held+0x3c/0x90 [ 11.104648][ T251] ? validate_chain+0x38b/0xc20 [ 11.104651][ T251] ? kasan_save_stack+0x3d/0x50 [ 11.104654][ T251] ? kasan_save_stack+0x2f/0x50 [ 11.104655][ T251] ? kasan_save_track+0x14/0x30 [ 11.104658][ T251] ? __lock_acquire+0x518/0xc20 [ 11.104660][ T251] ? netlink_seq_next+0xe/0x60 [ 11.104663][ T251] ? ___sys_sendmsg+0xb0/0x1d0 [ 11.104668][ T251] ? lock_acquire.part.0+0xd4/0x280 [ 11.104670][ T251] ? rtnl_newlink+0x9a8/0x11c0 [ 11.104672][ T251] ? rcu_is_watching+0x16/0xd0 [ 11.104675][ T251] ? lock_acquire+0x13c/0x160 [ 11.104676][ T251] ? rcu_is_watching+0x16/0xd0 [ 11.104678][ T251] ? rcu_is_watching+0x16/0xd0 [ 11.104680][ T251] ? trace_contention_end+0xb3/0x180 [ 11.104684][ T251] ? __mutex_lock+0x1db/0x1ea0 [ 11.104686][ T251] ? __mutex_lock+0x9a3/0x1ea0 [ 11.104688][ T251] ? rtnl_newlink+0x9a8/0x11c0 [ 11.104691][ T251] ? ww_mutex_lock+0x160/0x160 [ 11.104693][ T251] ? nla_get_range_signed+0x3d0/0x3d0 [ 11.104698][ T251] ? __rtnl_newlink+0x3fa/0xa50 [ 11.104703][ T251] rtnl_newlink+0x9f1/0x11c0 [ 11.104708][ T251] ? rtnl_bridge_getlink+0x850/0x850 [ 11.104710][ T251] ? __lock_acquire+0x518/0xc20 [ 11.104714][ T251] ? lock_acquire.part.0+0xd4/0x280 [ 11.104716][ T251] ? find_held_lock+0x2b/0x80 [ 11.104718][ T251] ? rtnl_bridge_getlink+0x850/0x850 [ 11.104720][ T251] ? __lock_release.isra.0+0x69/0x1a0 [ 11.104723][ T251] ? rtnl_bridge_getlink+0x850/0x850 [ 11.104725][ T251] rtnetlink_rcv_msg+0x6fd/0xbd0 [ 11.104728][ T251] ? rtnl_link_fill+0x920/0x920 [ 11.104729][ T251] ? __lock_acquire+0x518/0xc20 [ 11.104734][ T251] ? lock_acquire.part.0+0xd4/0x280 [ 11.104736][ T251] ? find_held_lock+0x2b/0x80 [ 11.104739][ T251] netlink_rcv_skb+0x14e/0x3a0 [ 11.104741][ T251] ? rtnl_link_fill+0x920/0x920 [ 11.104744][ T251] ? netlink_ack+0xcf0/0xcf0 [ 11.104749][ T251] ? netlink_deliver_tap+0xc5/0x330 [ 11.104751][ T251] ? netlink_deliver_tap+0x13c/0x330 [ 11.104755][ T251] netlink_unicast+0x486/0x750 [ 11.104759][ T251] ? netlink_attachskb+0x810/0x810 [ 11.104761][ T251] ? __lock_acquire+0x518/0xc20 [ 11.104765][ T251] netlink_sendmsg+0x735/0xc60 [ 11.104769][ T251] ? netlink_unicast+0x750/0x750 [ 11.104773][ T251] ? __might_fault+0x97/0x140 [ 11.104778][ T251] ____sys_sendmsg+0x415/0x880 [ 11.104780][ T251] ? copy_msghdr_from_user+0x279/0x420 [ 11.104782][ T251] ? get_timestamp.constprop.0+0x390/0x390 [ 11.104784][ T251] ? move_addr_to_kernel+0x40/0x40 [ 11.104791][ T251] ___sys_sendmsg+0x14e/0x1d0 [ 11.104794][ T251] ? copy_msghdr_from_user+0x420/0x420 [ 11.104811][ T251] __sys_sendmsg+0x12c/0x1d0 [ 11.104813][ T251] ? __sys_sendmsg_sock+0x20/0x20 [ 11.104820][ T251] ? rcu_is_watching+0x16/0xd0 [ 11.104824][ T251] do_syscall_64+0xff/0x530 [ 11.104826][ T251] ? exc_page_fault+0xee/0x100 [ 11.104829][ T251] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 11.104831][ T251] RIP: 0033:0x7fa8ce31254e [ 11.104834][ T251] 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 [ 11.104836][ T251] RSP: 002b:00007ffc6d74b4d0 EFLAGS: 00000202 ORIG_RAX: 000000000000002e [ 11.104839][ T251] RAX: ffffffffffffffda RBX: 0000000000000004 RCX: 00007fa8ce31254e [ 11.104840][ T251] RDX: 0000000000000000 RSI: 00007ffc6d74b580 RDI: 0000000000000005 [ 11.104841][ T251] RBP: 00007ffc6d74b4e0 R08: 0000000000000000 R09: 0000000000000000 [ 11.104842][ T251] R10: 0000000000000000 R11: 0000000000000202 R12: 000000006a918b49 [ 11.104843][ T251] R13: 00000000004a1620 R14: 0000000000000000 R15: 00007ffc6d74bc40 [ 11.104850][ T251] [ 11.149990][ T251] br0: port 1(veth1) entered disabled state [ 11.150359][ T251] veth1: entered allmulticast mode [ 11.159027][ T251] veth1: entered promiscuous mode [ 11.166938][ T251] ip (251) used greatest stack depth: 23336 bytes left [ 11.187004][ T253] br0: port 2(veth2) entered blocking state [ 11.187325][ T253] br0: port 2(veth2) entered disabled state [ 11.187636][ T253] veth2: entered allmulticast mode [ 11.189538][ T253] veth2: entered promiscuous mode [ 11.256545][ T46] br0: port 1(veth1) entered blocking state [ 11.256931][ T46] br0: port 1(veth1) entered forwarding state [ 11.282367][ T109] br0: port 2(veth2) entered blocking state [ 11.282708][ T109] br0: port 2(veth2) entered forwarding state [ 26.483082][ C1] [ 26.483101][ C1] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 26.483104][ C1] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 0, name: swapper/1 [ 26.483106][ C1] preempt_count: 104, expected: 0 [ 26.483107][ C1] RCU nest depth: 0, expected: 0 [ 26.483109][ C1] INFO: lockdep is turned off. [ 26.483110][ C1] irq event stamp: 579294 [ 26.483111][ C1] hardirqs last enabled at (579294): [] _raw_spin_unlock_irq+0x28/0x50 [ 26.483120][ C1] hardirqs last disabled at (579293): [] _raw_spin_lock_irq+0x4a/0x50 [ 26.483123][ C1] softirqs last enabled at (579284): [] handle_softirqs+0x67c/0x900 [ 26.483127][ C1] softirqs last disabled at (579291): [] __irq_exit_rcu+0x145/0x1c0 [ 26.483129][ C1] Preemption disabled at: [ 26.483130][ C1] [<0000000000000000>] 0x0 [ 26.483139][ C1] CPU: 1 UID: 0 PID: 0 Comm: swapper/1 Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 26.483144][ C1] Tainted: [W]=WARN [ 26.483145][ C1] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 26.483147][ C1] Call Trace: [ 26.483149][ C1] [ 26.483152][ C1] dump_stack_lvl+0x6f/0xa0 [ 26.483159][ C1] __might_resched.cold+0x1fe/0x2c1 [ 26.483163][ C1] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 26.483167][ C1] ? __asan_memcpy+0x3c/0x60 [ 26.483171][ C1] ? rcu_is_watching+0x16/0xd0 [ 26.483176][ C1] __kmalloc_noprof+0x443/0x760 [ 26.483180][ C1] ? __rwlock_init+0x150/0x150 [ 26.483184][ C1] ? alloc_buf.isra.0+0x4b/0x260 [ 26.483188][ C1] ? do_raw_spin_unlock+0x59/0x250 [ 26.483190][ C1] alloc_buf.isra.0+0x4b/0x260 [ 26.483193][ C1] put_chars+0x1e1/0x2f0 [ 26.483196][ C1] ? __send_to_port+0x420/0x420 [ 26.483199][ C1] ? console_prepend_replay+0x20/0x20 [ 26.483203][ C1] hvc_console_print+0x292/0x780 [ 26.483207][ C1] ? hvc_write+0x3a0/0x3a0 [ 26.483209][ C1] ? rcu_is_watching+0x16/0xd0 [ 26.483212][ C1] ? lock_acquire+0x13c/0x160 [ 26.483215][ C1] console_emit_next_record+0x22f/0x4c0 [ 26.483219][ C1] ? devkmsg_read+0x4b0/0x4b0 [ 26.483221][ C1] ? rcu_is_watching+0x16/0xd0 [ 26.483224][ C1] ? rcu_is_watching+0x16/0xd0 [ 26.483226][ C1] ? lock_acquire+0x13c/0x160 [ 26.483229][ C1] ? console_flush_one_record+0x111/0x710 [ 26.483231][ C1] console_flush_one_record+0x46f/0x710 [ 26.483234][ C1] ? console_emit_next_record+0x4c0/0x4c0 [ 26.483238][ C1] console_unlock+0xee/0x1f0 [ 26.483241][ C1] ? lock_acquire+0x13c/0x160 [ 26.483243][ C1] ? console_flush_one_record+0x710/0x710 [ 26.483245][ C1] ? rcu_is_watching+0x16/0xd0 [ 26.483247][ C1] ? lock_release+0x184/0x1f0 [ 26.483249][ C1] ? lock_acquire+0x60/0x160 [ 26.483252][ C1] ? __down_trylock_console_sem+0x5e/0xa0 [ 26.483254][ C1] ? vprintk_emit+0x320/0x3e0 [ 26.483257][ C1] vprintk_emit+0x37c/0x3e0 [ 26.483260][ C1] ? wake_up_klogd_work_func+0x90/0x90 [ 26.483263][ C1] ? br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 26.483279][ C1] ? lock_release+0x184/0x1f0 [ 26.483281][ C1] ? br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 26.483292][ C1] ? br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 26.483303][ C1] ? is_module_text_address+0x154/0x250 [ 26.483308][ C1] _printk+0xc7/0x100 [ 26.483312][ C1] ? snapshot_read.cold+0x21/0x21 [ 26.483314][ C1] ? arch_stack_walk+0xd7/0x130 [ 26.483319][ C1] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 26.483322][ C1] ? nbcon_cpu_emergency_enter+0x28/0x80 [ 26.483325][ C1] print_irq_inversion_bug.part.0+0x32/0xc0 [ 26.483328][ C1] mark_lock_irq+0x989/0x9c0 [ 26.483332][ C1] mark_lock+0x1d7/0xa00 [ 26.483335][ C1] mark_usage+0x42/0x170 [ 26.483338][ C1] __lock_acquire+0x388/0xc20 [ 26.483341][ C1] lock_acquire.part.0+0xd4/0x280 [ 26.483343][ C1] ? br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 26.483354][ C1] ? rcu_is_watching+0x16/0xd0 [ 26.483357][ C1] ? lock_acquire+0x13c/0x160 [ 26.483360][ C1] ? br_message_age_timer_expired+0x70/0x70 [bridge] [ 26.483370][ C1] _raw_spin_lock+0x33/0x40 [ 26.483372][ C1] ? br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 26.483383][ C1] br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 26.483394][ C1] ? br_message_age_timer_expired+0x70/0x70 [bridge] [ 26.483405][ C1] call_timer_fn+0x160/0x4d0 [ 26.483408][ C1] ? detach_if_pending+0x1d0/0x1d0 [ 26.483411][ C1] ? debug_object_active_state+0x430/0x430 [ 26.483415][ C1] ? find_held_lock+0x2b/0x80 [ 26.483418][ C1] ? __lock_release.isra.0+0x69/0x1a0 [ 26.483420][ C1] ? rcu_is_watching+0x16/0xd0 [ 26.483423][ C1] __run_timers+0x68f/0xaa0 [ 26.483426][ C1] ? br_message_age_timer_expired+0x70/0x70 [bridge] [ 26.483437][ C1] ? __bpf_trace_itimer_expire+0x10/0x10 [ 26.483440][ C1] ? __lock_acquire+0x518/0xc20 [ 26.483444][ C1] ? __rwlock_init+0x150/0x150 [ 26.483447][ C1] run_timer_softirq+0xf0/0x160 [ 26.483450][ C1] ? __run_timers+0xaa0/0xaa0 [ 26.483452][ C1] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 26.483455][ C1] ? rcu_is_watching+0x16/0xd0 [ 26.483458][ C1] handle_softirqs+0x1d3/0x900 [ 26.483461][ C1] ? __lock_release.isra.0+0x69/0x1a0 [ 26.483463][ C1] ? _local_bh_enable+0xc0/0xc0 [ 26.483466][ C1] __irq_exit_rcu+0x145/0x1c0 [ 26.483468][ C1] irq_exit_rcu+0xe/0x30 [ 26.483471][ C1] sysvec_apic_timer_interrupt+0x9d/0xe0 [ 26.483474][ C1] [ 26.483475][ C1] [ 26.483476][ C1] ? lockdep_hardirqs_on+0x91/0x130 [ 26.483478][ C1] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 26.483481][ C1] RIP: 0010:pv_native_safe_halt+0xf/0x10 [ 26.483485][ C1] Code: 48 8b 3d 94 d2 f5 01 e8 1f 00 00 00 48 2b 05 58 93 95 00 c3 0f 1f 80 00 00 00 00 f3 0f 1e fa eb 07 0f 00 2d 13 86 11 00 fb f4 0f 1f 40 d6 48 83 ec 20 8b 17 49 89 f8 83 e2 fe 41 89 d2 0f 01 [ 26.483487][ C1] RSP: 0018:ffa0000000147e00 EFLAGS: 00000282 [ 26.483492][ C1] RAX: 000000000008d6d9 RBX: ff11000001bea380 RCX: ffffffff834f0307 [ 26.483493][ C1] RDX: ff11000001bea380 RSI: ffffffff86238af6 RDI: ffffffff85c8d8e0 [ 26.483495][ C1] RBP: 0000000000000000 R08: 0000000000000000 R09: 0000000000000000 [ 26.483496][ C1] R10: 0000000000000001 R11: 0000000000000001 R12: 1ff4000000028fc3 [ 26.483497][ C1] R13: 0000000000000000 R14: dffffc0000000000 R15: 0000000000000000 [ 26.483500][ C1] ? cpuidle_idle_call.constprop.0+0x237/0x410 [ 26.483504][ C1] default_idle+0x9/0x10 [ 26.483507][ C1] default_idle_call+0x6e/0xb0 [ 26.483509][ C1] cpuidle_idle_call.constprop.0+0x237/0x410 [ 26.483511][ C1] ? arch_cpu_idle_exit+0x40/0x40 [ 26.483514][ C1] ? mark_tsc_async_resets+0x30/0x30 [ 26.483517][ C1] ? rcu_is_watching+0x16/0xd0 [ 26.483520][ C1] do_idle+0xd8/0x190 [ 26.483522][ C1] cpu_startup_entry+0x53/0x70 [ 26.483524][ C1] start_secondary+0x204/0x2b0 [ 26.483527][ C1] ? set_cpu_sibling_map+0x2130/0x2130 [ 26.483530][ C1] common_startup_64+0x13e/0x148 [ 26.483535][ C1] [ 26.509349][ C1] ======================================================== [ 26.509650][ C1] WARNING: possible irq lock inversion dependency detected [ 26.509952][ C1] 7.2.0-virtme #1 Tainted: G W [ 26.510203][ C1] -------------------------------------------------------- [ 26.510644][ C1] swapper/1/0 just changed the state of lock: [ 26.510961][ C1] ff1100001215ae58 (&br->lock){+.-.}-{3:3}, at: br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 26.511444][ C1] but this lock took another, SOFTIRQ-unsafe lock in the past: [ 26.511807][ C1] (fs_reclaim){+.+.}-{0:0} [ 26.511811][ C1] [ 26.511811][ C1] [ 26.511811][ C1] and interrupts could create inverse lock ordering between them. [ 26.511811][ C1] [ 26.512668][ C1] [ 26.512668][ C1] other info that might help us debug this: [ 26.512951][ C1] Chain exists of: [ 26.512951][ C1] &br->lock --> console_owner --> fs_reclaim [ 26.512951][ C1] [ 26.513468][ C1] Possible interrupt unsafe locking scenario: [ 26.513468][ C1] [ 26.513832][ C1] CPU0 CPU1 [ 26.514099][ C1] ---- ---- [ 26.514293][ C1] lock(fs_reclaim); [ 26.514519][ C1] local_irq_disable(); [ 26.514768][ C1] lock(&br->lock); [ 26.515088][ C1] lock(console_owner); [ 26.515334][ C1] [ 26.515562][ C1] lock(&br->lock); [ 26.515713][ C1] [ 26.515713][ C1] *** DEADLOCK *** [ 26.515713][ C1] [ 26.516072][ C1] locks held by swapper/1/0: 1, last CPU#1: [ 26.516388][ C1] #0: ffa00000001d0c90 ((&p->forward_delay_timer)){+.-.}-{0:0}, at: call_timer_fn+0x110/0x4d0 [ 26.516868][ C1] [ 26.516868][ C1] the shortest dependencies between 2nd lock and 1st lock: [ 26.517202][ C1] -> (fs_reclaim){+.+.}-{0:0} { [ 26.517478][ C1] HARDIRQ-ON-W at: [ 26.517633][ C1] __lock_acquire+0x388/0xc20 [ 26.517966][ C1] lock_acquire.part.0+0xd4/0x280 [ 26.518290][ C1] fs_reclaim_acquire+0xd5/0x120 [ 26.518536][ C1] __kmalloc_cache_noprof+0x6e/0x620 [ 26.518914][ C1] kthread_create_worker_on_node+0xea/0x210 [ 26.519283][ C1] workqueue_init+0x2a/0x680 [ 26.519531][ C1] kernel_init_freeable+0x2fe/0x630 [ 26.519908][ C1] kernel_init+0x21/0x150 [ 26.520230][ C1] ret_from_fork+0x474/0x6b0 [ 26.520478][ C1] ret_from_fork_asm+0x11/0x20 [ 26.520809][ C1] SOFTIRQ-ON-W at: [ 26.520956][ C1] __lock_acquire+0x388/0xc20 [ 26.521283][ C1] lock_acquire.part.0+0xd4/0x280 [ 26.521613][ C1] fs_reclaim_acquire+0xd5/0x120 [ 26.521865][ C1] __kmalloc_cache_noprof+0x6e/0x620 [ 26.522162][ C1] kthread_create_worker_on_node+0xea/0x210 [ 26.522526][ C1] workqueue_init+0x2a/0x680 [ 26.522785][ C1] kernel_init_freeable+0x2fe/0x630 [ 26.523156][ C1] kernel_init+0x21/0x150 [ 26.523475][ C1] ret_from_fork+0x474/0x6b0 [ 26.523732][ C1] ret_from_fork_asm+0x11/0x20 [ 26.524057][ C1] INITIAL USE at: [ 26.524205][ C1] __lock_acquire+0x388/0xc20 [ 26.524534][ C1] lock_acquire.part.0+0xd4/0x280 [ 26.524858][ C1] fs_reclaim_acquire+0xd5/0x120 [ 26.525101][ C1] __kmalloc_cache_noprof+0x6e/0x620 [ 26.525471][ C1] kthread_create_worker_on_node+0xea/0x210 [ 26.525847][ C1] workqueue_init+0x2a/0x680 [ 26.526120][ C1] kernel_init_freeable+0x2fe/0x630 [ 26.526443][ C1] kernel_init+0x21/0x150 [ 26.526768][ C1] ret_from_fork+0x474/0x6b0 [ 26.527013][ C1] ret_from_fork_asm+0x11/0x20 [ 26.527337][ C1] } [ 26.527441][ C1] ... key at: [] __fs_reclaim_map+0x0/0xbe0 [ 26.527813][ C1] ... acquired at: [ 26.527960][ C1] __lock_acquire+0x518/0xc20 [ 26.528233][ C1] lock_acquire.part.0+0xd4/0x280 [ 26.528428][ C1] fs_reclaim_acquire+0xd5/0x120 [ 26.528702][ C1] __kmalloc_noprof+0xd3/0x760 [ 26.528905][ C1] alloc_buf.isra.0+0x4b/0x260 [ 26.529179][ C1] put_chars+0x1e1/0x2f0 [ 26.529375][ C1] hvc_console_print+0x292/0x780 [ 26.529652][ C1] console_emit_next_record+0x22f/0x4c0 [ 26.529848][ C1] console_flush_one_record+0x46f/0x710 [ 26.530121][ C1] console_unlock+0xee/0x1f0 [ 26.530316][ C1] vprintk_emit+0x37c/0x3e0 [ 26.530588][ C1] _printk+0xc7/0x100 [ 26.530757][ C1] dm_interface_init+0x50/0x60 [ 26.531027][ C1] dm_init+0x51/0xd0 [ 26.531176][ C1] do_one_initcall+0x124/0x4f0 [ 26.531368][ C1] kernel_init_freeable+0x596/0x630 [ 26.531643][ C1] kernel_init+0x21/0x150 [ 26.531836][ C1] ret_from_fork+0x474/0x6b0 [ 26.532109][ C1] ret_from_fork_asm+0x11/0x20 [ 26.532299][ C1] [ 26.532473][ C1] -> (console_owner){....}-{0:0} { [ 26.532680][ C1] INITIAL USE at: [ 26.532901][ C1] } [ 26.533005][ C1] ... key at: [] console_owner_dep_map+0x0/0x60 [ 26.533369][ C1] ... acquired at: [ 26.533515][ C1] __lock_acquire+0x518/0xc20 [ 26.533719][ C1] lock_acquire.part.0+0xd4/0x280 [ 26.533992][ C1] console_lock_spinning_enable+0x5c/0x60 [ 26.534310][ C1] console_emit_next_record+0x1d1/0x4c0 [ 26.534503][ C1] console_flush_one_record+0x46f/0x710 [ 26.534772][ C1] console_unlock+0xee/0x1f0 [ 26.534964][ C1] vprintk_emit+0x37c/0x3e0 [ 26.535236][ C1] _printk+0xc7/0x100 [ 26.535383][ C1] br_set_state+0x22f/0x430 [bridge] [ 26.535596][ C1] br_init_port+0xc4/0x200 [bridge] [ 26.535875][ C1] br_stp_enable_port+0x12/0x50 [bridge] [ 26.536205][ C1] br_port_carrier_check+0x220/0x430 [bridge] [ 26.536457][ C1] br_device_event+0x52d/0x8f0 [bridge] [ 26.536735][ C1] notifier_call_chain+0xae/0x300 [ 26.536933][ C1] netif_state_change+0x139/0x340 [ 26.537210][ C1] __linkwatch_run_queue+0x34c/0x750 [ 26.537406][ C1] linkwatch_event+0x7f/0xb0 [ 26.537679][ C1] process_one_work+0xe3e/0x1560 [ 26.537877][ C1] worker_thread+0x4f1/0xd60 [ 26.538073][ C1] kthread+0x367/0x460 [ 26.538213][ C1] ret_from_fork+0x474/0x6b0 [ 26.538477][ C1] ret_from_fork_asm+0x11/0x20 [ 26.538670][ C1] [ 26.538766][ C1] -> (&br->lock){+.-.}-{3:3} { [ 26.539034][ C1] HARDIRQ-ON-W at: [ 26.539178][ C1] __lock_acquire+0x388/0xc20 [ 26.539494][ C1] lock_acquire.part.0+0xd4/0x280 [ 26.539740][ C1] _raw_spin_lock_bh+0x38/0x50 [ 26.540050][ C1] recalculate_group_addr+0x51/0x120 [bridge] [ 26.540420][ C1] br_vlan_filter_toggle+0x85/0x110 [bridge] [ 26.540794][ C1] br_changelink+0x575/0x16e0 [bridge] [ 26.541040][ C1] br_dev_newlink+0xeb/0x160 [bridge] [ 26.541363][ C1] rtnl_newlink_create+0x2d0/0x750 [ 26.541607][ C1] __rtnl_newlink+0x22b/0xa50 [ 26.541918][ C1] rtnl_newlink+0x9f1/0x11c0 [ 26.542232][ C1] rtnetlink_rcv_msg+0x6fd/0xbd0 [ 26.542469][ C1] netlink_rcv_skb+0x14e/0x3a0 [ 26.542787][ C1] netlink_unicast+0x486/0x750 [ 26.543032][ C1] netlink_sendmsg+0x735/0xc60 [ 26.543278][ C1] ____sys_sendmsg+0x415/0x880 [ 26.543603][ C1] ___sys_sendmsg+0x14e/0x1d0 [ 26.543847][ C1] __sys_sendmsg+0x12c/0x1d0 [ 26.544170][ C1] do_syscall_64+0xff/0x530 [ 26.544486][ C1] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 26.544778][ C1] IN-SOFTIRQ-W at: [ 26.544994][ C1] __lock_acquire+0x388/0xc20 [ 26.545235][ C1] lock_acquire.part.0+0xd4/0x280 [ 26.545553][ C1] _raw_spin_lock+0x33/0x40 [ 26.545864][ C1] br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 26.546168][ C1] call_timer_fn+0x160/0x4d0 [ 26.546481][ C1] __run_timers+0x68f/0xaa0 [ 26.546797][ C1] run_timer_softirq+0xf0/0x160 [ 26.547044][ C1] handle_softirqs+0x1d3/0x900 [ 26.547356][ C1] __irq_exit_rcu+0x145/0x1c0 [ 26.547671][ C1] irq_exit_rcu+0xe/0x30 [ 26.547919][ C1] sysvec_apic_timer_interrupt+0x9d/0xe0 [ 26.548283][ C1] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 26.548654][ C1] pv_native_safe_halt+0xf/0x10 [ 26.548901][ C1] default_idle+0x9/0x10 [ 26.549218][ C1] default_idle_call+0x6e/0xb0 [ 26.549529][ C1] cpuidle_idle_call.constprop.0+0x237/0x410 [ 26.549826][ C1] do_idle+0xd8/0x190 [ 26.550094][ C1] cpu_startup_entry+0x53/0x70 [ 26.550332][ C1] start_secondary+0x204/0x2b0 [ 26.550659][ C1] common_startup_64+0x13e/0x148 [ 26.550971][ C1] INITIAL USE at: [ 26.551118][ C1] __lock_acquire+0x388/0xc20 [ 26.551434][ C1] lock_acquire.part.0+0xd4/0x280 [ 26.551682][ C1] _raw_spin_lock_bh+0x38/0x50 [ 26.551994][ C1] recalculate_group_addr+0x51/0x120 [bridge] [ 26.552360][ C1] br_vlan_filter_toggle+0x85/0x110 [bridge] [ 26.552658][ C1] br_changelink+0x575/0x16e0 [bridge] [ 26.552975][ C1] br_dev_newlink+0xeb/0x160 [bridge] [ 26.553290][ C1] rtnl_newlink_create+0x2d0/0x750 [ 26.553531][ C1] __rtnl_newlink+0x22b/0xa50 [ 26.553848][ C1] rtnl_newlink+0x9f1/0x11c0 [ 26.554152][ C1] rtnetlink_rcv_msg+0x6fd/0xbd0 [ 26.554392][ C1] netlink_rcv_skb+0x14e/0x3a0 [ 26.554707][ C1] netlink_unicast+0x486/0x750 [ 26.554943][ C1] netlink_sendmsg+0x735/0xc60 [ 26.555251][ C1] ____sys_sendmsg+0x415/0x880 [ 26.555559][ C1] ___sys_sendmsg+0x14e/0x1d0 [ 26.555790][ C1] __sys_sendmsg+0x12c/0x1d0 [ 26.556094][ C1] do_syscall_64+0xff/0x530 [ 26.556396][ C1] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 26.556686][ C1] } [ 26.556853][ C1] ... key at: [] __key.7+0x0/0x40 [bridge] [ 26.557144][ C1] ... acquired at: [ 26.557350][ C1] mark_lock+0x1d7/0xa00 [ 26.557537][ C1] mark_usage+0x42/0x170 [ 26.557794][ C1] __lock_acquire+0x388/0xc20 [ 26.557980][ C1] lock_acquire.part.0+0xd4/0x280 [ 26.558232][ C1] _raw_spin_lock+0x33/0x40 [ 26.558413][ C1] br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 26.558727][ C1] call_timer_fn+0x160/0x4d0 [ 26.558912][ C1] __run_timers+0x68f/0xaa0 [ 26.559167][ C1] run_timer_softirq+0xf0/0x160 [ 26.559353][ C1] handle_softirqs+0x1d3/0x900 [ 26.559615][ C1] __irq_exit_rcu+0x145/0x1c0 [ 26.559801][ C1] irq_exit_rcu+0xe/0x30 [ 26.560049][ C1] sysvec_apic_timer_interrupt+0x9d/0xe0 [ 26.560283][ C1] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 26.560599][ C1] pv_native_safe_halt+0xf/0x10 [ 26.560850][ C1] default_idle+0x9/0x10 [ 26.561033][ C1] default_idle_call+0x6e/0xb0 [ 26.561282][ C1] cpuidle_idle_call.constprop.0+0x237/0x410 [ 26.561518][ C1] do_idle+0xd8/0x190 [ 26.561730][ C1] cpu_startup_entry+0x53/0x70 [ 26.561916][ C1] start_secondary+0x204/0x2b0 [ 26.562171][ C1] common_startup_64+0x13e/0x148 [ 26.562361][ C1] [ 26.562455][ C1] [ 26.562455][ C1] stack backtrace: [ 26.562758][ C1] CPU: 1 UID: 0 PID: 0 Comm: swapper/1 Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 26.562763][ C1] Tainted: [W]=WARN [ 26.562764][ C1] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 26.562766][ C1] Call Trace: [ 26.562768][ C1] [ 26.562770][ C1] dump_stack_lvl+0x6f/0xa0 [ 26.562775][ C1] print_irq_inversion_bug.part.0.cold+0xe6/0x143 [ 26.562779][ C1] mark_lock_irq+0x989/0x9c0 [ 26.562783][ C1] mark_lock+0x1d7/0xa00 [ 26.562786][ C1] mark_usage+0x42/0x170 [ 26.562788][ C1] __lock_acquire+0x388/0xc20 [ 26.562791][ C1] lock_acquire.part.0+0xd4/0x280 [ 26.562794][ C1] ? br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 26.562806][ C1] ? rcu_is_watching+0x16/0xd0 [ 26.562810][ C1] ? lock_acquire+0x13c/0x160 [ 26.562812][ C1] ? br_message_age_timer_expired+0x70/0x70 [bridge] [ 26.562822][ C1] _raw_spin_lock+0x33/0x40 [ 26.562825][ C1] ? br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 26.562835][ C1] br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 26.562846][ C1] ? br_message_age_timer_expired+0x70/0x70 [bridge] [ 26.562856][ C1] call_timer_fn+0x160/0x4d0 [ 26.562860][ C1] ? detach_if_pending+0x1d0/0x1d0 [ 26.562862][ C1] ? debug_object_active_state+0x430/0x430 [ 26.562866][ C1] ? find_held_lock+0x2b/0x80 [ 26.562869][ C1] ? __lock_release.isra.0+0x69/0x1a0 [ 26.562871][ C1] ? rcu_is_watching+0x16/0xd0 [ 26.562875][ C1] __run_timers+0x68f/0xaa0 [ 26.562877][ C1] ? br_message_age_timer_expired+0x70/0x70 [bridge] [ 26.562888][ C1] ? __bpf_trace_itimer_expire+0x10/0x10 [ 26.562890][ C1] ? __lock_acquire+0x518/0xc20 [ 26.562894][ C1] ? __rwlock_init+0x150/0x150 [ 26.562898][ C1] run_timer_softirq+0xf0/0x160 [ 26.562901][ C1] ? __run_timers+0xaa0/0xaa0 [ 26.562903][ C1] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 26.562906][ C1] ? rcu_is_watching+0x16/0xd0 [ 26.562908][ C1] handle_softirqs+0x1d3/0x900 [ 26.562912][ C1] ? __lock_release.isra.0+0x69/0x1a0 [ 26.562914][ C1] ? _local_bh_enable+0xc0/0xc0 [ 26.562917][ C1] __irq_exit_rcu+0x145/0x1c0 [ 26.562919][ C1] irq_exit_rcu+0xe/0x30 [ 26.562921][ C1] sysvec_apic_timer_interrupt+0x9d/0xe0 [ 26.562924][ C1] [ 26.562924][ C1] [ 26.562925][ C1] ? lockdep_hardirqs_on+0x91/0x130 [ 26.562928][ C1] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 26.562930][ C1] RIP: 0010:pv_native_safe_halt+0xf/0x10 [ 26.562934][ C1] Code: 48 8b 3d 94 d2 f5 01 e8 1f 00 00 00 48 2b 05 58 93 95 00 c3 0f 1f 80 00 00 00 00 f3 0f 1e fa eb 07 0f 00 2d 13 86 11 00 fb f4 0f 1f 40 d6 48 83 ec 20 8b 17 49 89 f8 83 e2 fe 41 89 d2 0f 01 [ 26.562936][ C1] RSP: 0018:ffa0000000147e00 EFLAGS: 00000282 [ 26.562939][ C1] RAX: 000000000008d6d9 RBX: ff11000001bea380 RCX: ffffffff834f0307 [ 26.562940][ C1] RDX: ff11000001bea380 RSI: ffffffff86238af6 RDI: ffffffff85c8d8e0 [ 26.562942][ C1] RBP: 0000000000000000 R08: 0000000000000000 R09: 0000000000000000 [ 26.562943][ C1] R10: 0000000000000001 R11: 0000000000000001 R12: 1ff4000000028fc3 [ 26.562945][ C1] R13: 0000000000000000 R14: dffffc0000000000 R15: 0000000000000000 [ 26.562947][ C1] ? cpuidle_idle_call.constprop.0+0x237/0x410 [ 26.562950][ C1] default_idle+0x9/0x10 [ 26.562952][ C1] default_idle_call+0x6e/0xb0 [ 26.562955][ C1] cpuidle_idle_call.constprop.0+0x237/0x410 [ 26.562957][ C1] ? arch_cpu_idle_exit+0x40/0x40 [ 26.562959][ C1] ? mark_tsc_async_resets+0x30/0x30 [ 26.562962][ C1] ? rcu_is_watching+0x16/0xd0 [ 26.562964][ C1] do_idle+0xd8/0x190 [ 26.562967][ C1] cpu_startup_entry+0x53/0x70 [ 26.562969][ C1] start_secondary+0x204/0x2b0 [ 26.562971][ C1] ? set_cpu_sibling_map+0x2130/0x2130 [ 26.562974][ C1] common_startup_64+0x13e/0x148 [ 26.562979][ C1] [ 37.918650][ T350] br0: port 2(veth2) entered disabled state [ 37.918666][ T350] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 37.918669][ T350] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 350, name: ip [ 37.918670][ T350] preempt_count: 202, expected: 0 [ 37.918671][ T350] RCU nest depth: 0, expected: 0 [ 37.918672][ T350] INFO: lockdep is turned off. [ 37.918674][ T350] irq event stamp: 0 [ 37.918674][ T350] hardirqs last enabled at (0): [<0000000000000000>] 0x0 [ 37.918679][ T350] hardirqs last disabled at (0): [] copy_process+0x1ccd/0x6240 [ 37.918685][ T350] softirqs last enabled at (0): [] copy_process+0x1d21/0x6240 [ 37.918687][ T350] softirqs last disabled at (0): [<0000000000000000>] 0x0 [ 37.918689][ T350] Preemption disabled at: [ 37.918689][ T350] [<0000000000000000>] 0x0 [ 37.918694][ T350] CPU: 3 UID: 0 PID: 350 Comm: ip Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 37.918697][ T350] Tainted: [W]=WARN [ 37.918698][ T350] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 37.918700][ T350] Call Trace: [ 37.918701][ T350] [ 37.918702][ T350] dump_stack_lvl+0x6f/0xa0 [ 37.918708][ T350] __might_resched.cold+0x1fe/0x2c1 [ 37.918712][ T350] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 37.918715][ T350] ? rcu_is_watching+0x16/0xd0 [ 37.918719][ T350] __kmalloc_noprof+0x443/0x760 [ 37.918723][ T350] ? __rwlock_init+0x150/0x150 [ 37.918726][ T350] ? alloc_buf.isra.0+0x4b/0x260 [ 37.918730][ T350] ? do_raw_spin_unlock+0x59/0x250 [ 37.918731][ T350] alloc_buf.isra.0+0x4b/0x260 [ 37.918733][ T350] put_chars+0x1e1/0x2f0 [ 37.918735][ T350] ? __send_to_port+0x420/0x420 [ 37.918737][ T350] ? printk_get_next_message+0x240/0x650 [ 37.918740][ T350] hvc_console_print+0x292/0x780 [ 37.918744][ T350] ? hvc_write+0x3a0/0x3a0 [ 37.918746][ T350] ? __rwlock_init+0x150/0x150 [ 37.918747][ T350] ? rcu_is_watching+0x16/0xd0 [ 37.918749][ T350] ? lock_acquire+0x13c/0x160 [ 37.918751][ T350] console_emit_next_record+0x22f/0x4c0 [ 37.918754][ T350] ? devkmsg_read+0x4b0/0x4b0 [ 37.918755][ T350] ? rcu_is_watching+0x16/0xd0 [ 37.918757][ T350] ? rcu_is_watching+0x16/0xd0 [ 37.918759][ T350] ? rcu_is_watching+0x16/0xd0 [ 37.918760][ T350] ? lock_acquire+0x13c/0x160 [ 37.918762][ T350] ? console_flush_one_record+0x111/0x710 [ 37.918764][ T350] console_flush_one_record+0x46f/0x710 [ 37.918766][ T350] ? console_emit_next_record+0x4c0/0x4c0 [ 37.918769][ T350] console_unlock+0xee/0x1f0 [ 37.918770][ T350] ? lock_acquire+0x13c/0x160 [ 37.918772][ T350] ? console_flush_one_record+0x710/0x710 [ 37.918773][ T350] ? rcu_is_watching+0x16/0xd0 [ 37.918775][ T350] ? lock_release+0x184/0x1f0 [ 37.918776][ T350] ? lock_acquire+0x60/0x160 [ 37.918778][ T350] ? __rcu_read_lock+0x30/0x70 [ 37.918780][ T350] ? __down_trylock_console_sem+0x5e/0xa0 [ 37.918782][ T350] ? vprintk_emit+0x320/0x3e0 [ 37.918784][ T350] vprintk_emit+0x37c/0x3e0 [ 37.918786][ T350] ? wake_up_klogd_work_func+0x90/0x90 [ 37.918788][ T350] ? rcu_is_watching+0x16/0xd0 [ 37.918789][ T350] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 37.918792][ T350] ? trace_hardirqs_on+0x36/0x40 [ 37.918793][ T350] _printk+0xc7/0x100 [ 37.918796][ T350] ? snapshot_read.cold+0x21/0x21 [ 37.918799][ T350] ? ipv6_mc_down+0x17e/0x2d0 [ 37.918803][ T350] br_set_state+0x22f/0x430 [bridge] [ 37.918816][ T350] br_stp_disable_port+0x11f/0x390 [bridge] [ 37.918824][ T350] br_device_event+0x7b5/0x8f0 [bridge] [ 37.918833][ T350] ? _raw_spin_unlock_irqrestore+0x40/0x80 [ 37.918836][ T350] ? _sub_I_65535_1+0x4d0/0x4d0 [stp] [ 37.918838][ T350] ? addrconf_notify+0x2c8/0xf30 [ 37.918841][ T350] notifier_call_chain+0xae/0x300 [ 37.918844][ T350] __dev_notify_flags+0x23c/0x3c0 [ 37.918848][ T350] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 37.918850][ T350] ? netif_change_name+0x8c0/0x8c0 [ 37.918852][ T350] ? netif_set_allmulti+0x250/0x250 [ 37.918854][ T350] ? __kernel_text_address+0x12/0x30 [ 37.918856][ T350] ? write_profile+0xf0/0xf0 [ 37.918858][ T350] ? unwind_get_return_address+0x67/0xd0 [ 37.918861][ T350] netif_change_flags+0xfe/0x190 [ 37.918863][ T350] do_setlink.isra.0+0x1cc3/0x2750 [ 37.918866][ T350] ? stack_trace_save+0x93/0xc0 [ 37.918867][ T350] ? rtnl_link_get_size+0x350/0x350 [ 37.918869][ T350] ? rcu_is_watching+0x16/0xd0 [ 37.918870][ T350] ? stack_depot_save_flags+0x1bc/0x790 [ 37.918874][ T350] ? kasan_save_stack+0x3d/0x50 [ 37.918877][ T350] ? kasan_save_stack+0x2f/0x50 [ 37.918879][ T350] ? kasan_save_track+0x14/0x30 [ 37.918880][ T350] ? __kasan_kmalloc+0x7b/0x90 [ 37.918882][ T350] ? __kmalloc_cache_noprof+0x29a/0x620 [ 37.918883][ T350] ? rtnl_newlink+0x124/0x11c0 [ 37.918884][ T350] ? rtnetlink_rcv_msg+0x6fd/0xbd0 [ 37.918885][ T350] ? netlink_rcv_skb+0x14e/0x3a0 [ 37.918888][ T350] ? netlink_unicast+0x486/0x750 [ 37.918889][ T350] ? netlink_sendmsg+0x735/0xc60 [ 37.918890][ T350] ? ____sys_sendmsg+0x415/0x880 [ 37.918893][ T350] ? ___sys_sendmsg+0x14e/0x1d0 [ 37.918894][ T350] ? __sys_sendmsg+0x12c/0x1d0 [ 37.918896][ T350] ? do_syscall_64+0xff/0x530 [ 37.918898][ T350] ? entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 37.918901][ T350] ? rcu_is_watching+0x16/0xd0 [ 37.918902][ T350] ? lock_acquire+0x13c/0x160 [ 37.918904][ T350] ? rcu_is_watching+0x16/0xd0 [ 37.918906][ T350] ? rcu_is_watching+0x16/0xd0 [ 37.918907][ T350] ? trace_contention_end+0xb3/0x180 [ 37.918910][ T350] ? __mutex_lock+0x1db/0x1ea0 [ 37.918912][ T350] ? __mutex_lock+0x9a3/0x1ea0 [ 37.918913][ T350] ? rtnl_newlink+0x9a8/0x11c0 [ 37.918915][ T350] ? ww_mutex_lock+0x160/0x160 [ 37.918917][ T350] ? __rtnl_newlink+0x3fa/0xa50 [ 37.918919][ T350] rtnl_newlink+0x9f1/0x11c0 [ 37.918921][ T350] ? rcu_is_watching+0x16/0xd0 [ 37.918922][ T350] ? rtnl_bridge_getlink+0x850/0x850 [ 37.918924][ T350] ? lock_acquire+0x13c/0x160 [ 37.918925][ T350] ? rcu_is_watching+0x16/0xd0 [ 37.918927][ T350] ? is_bpf_text_address+0x3e/0x110 [ 37.918930][ T350] ? is_bpf_text_address+0x72/0x110 [ 37.918932][ T350] ? kernel_text_address+0x149/0x170 [ 37.918933][ T350] ? __kernel_text_address+0x12/0x30 [ 37.918934][ T350] ? write_profile+0xf0/0xf0 [ 37.918935][ T350] ? unwind_get_return_address+0x67/0xd0 [ 37.918937][ T350] ? rcu_is_watching+0x16/0xd0 [ 37.918938][ T350] ? rcu_is_watching+0x16/0xd0 [ 37.918940][ T350] ? cap_capable+0x1d7/0x3d0 [ 37.918944][ T350] ? lock_acquire+0x13c/0x160 [ 37.918945][ T350] ? rcu_is_watching+0x16/0xd0 [ 37.918947][ T350] ? rtnl_bridge_getlink+0x850/0x850 [ 37.918948][ T350] rtnetlink_rcv_msg+0x6fd/0xbd0 [ 37.918950][ T350] ? rtnl_link_fill+0x920/0x920 [ 37.918951][ T350] ? filter_irq_stacks+0xd0/0xd0 [ 37.918952][ T350] ? stack_depot_save_flags+0x1bc/0x790 [ 37.918955][ T350] netlink_rcv_skb+0x14e/0x3a0 [ 37.918956][ T350] ? rtnl_link_fill+0x920/0x920 [ 37.918957][ T350] ? lock_release+0x184/0x1f0 [ 37.918959][ T350] ? netlink_ack+0xcf0/0xcf0 [ 37.918960][ T350] ? __netlink_lookup+0xb9/0x6b0 [ 37.918962][ T350] ? rcu_is_watching+0x16/0xd0 [ 37.918964][ T350] ? lock_release+0x184/0x1f0 [ 37.918966][ T350] netlink_unicast+0x486/0x750 [ 37.918968][ T350] ? netlink_attachskb+0x810/0x810 [ 37.918970][ T350] ? rcu_is_watching+0x16/0xd0 [ 37.918971][ T350] ? rcu_is_watching+0x16/0xd0 [ 37.918973][ T350] ? lock_acquire+0x13c/0x160 [ 37.918975][ T350] netlink_sendmsg+0x735/0xc60 [ 37.918977][ T350] ? netlink_unicast+0x750/0x750 [ 37.918979][ T350] ? rcu_is_watching+0x16/0xd0 [ 37.918980][ T350] ? lock_release+0x184/0x1f0 [ 37.918982][ T350] ____sys_sendmsg+0x415/0x880 [ 37.918984][ T350] ? copy_msghdr_from_user+0x279/0x420 [ 37.918985][ T350] ? get_timestamp.constprop.0+0x390/0x390 [ 37.918987][ T350] ? move_addr_to_kernel+0x40/0x40 [ 37.918988][ T350] ? filter_irq_stacks+0xd0/0xd0 [ 37.918991][ T350] ___sys_sendmsg+0x14e/0x1d0 [ 37.918993][ T350] ? copy_msghdr_from_user+0x420/0x420 [ 37.919000][ T350] __sys_sendmsg+0x12c/0x1d0 [ 37.919002][ T350] ? __sys_sendmsg_sock+0x20/0x20 [ 37.919005][ T350] ? rcu_is_watching+0x16/0xd0 [ 37.919007][ T350] do_syscall_64+0xff/0x530 [ 37.919008][ T350] ? exc_page_fault+0xee/0x100 [ 37.919010][ T350] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 37.919012][ T350] RIP: 0033:0x7f091adaa54e [ 37.919014][ T350] 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 [ 37.919016][ T350] RSP: 002b:00007ffe1a4c5b60 EFLAGS: 00000202 ORIG_RAX: 000000000000002e [ 37.919019][ T350] RAX: ffffffffffffffda RBX: 0000000000000003 RCX: 00007f091adaa54e [ 37.919021][ T350] RDX: 0000000000000000 RSI: 00007ffe1a4c5c10 RDI: 0000000000000005 [ 37.919022][ T350] RBP: 00007ffe1a4c5b70 R08: 0000000000000000 R09: 0000000000000000 [ 37.919023][ T350] R10: 0000000000000000 R11: 0000000000000202 R12: 000000006a918b64 [ 37.919024][ T350] R13: 00000000004a1620 R14: 0000000000000000 R15: 00007ffe1a4c62d0 [ 37.919026][ T350] [ 37.947083][ T350] ip (350) used greatest stack depth: 23016 bytes left [ 37.969628][ T351] br0: port 1(veth1) entered disabled state [ 37.985307][ T352] veth2: left allmulticast mode [ 37.985473][ T352] veth2: left promiscuous mode [ 37.985690][ T352] br0: port 2(veth2) entered disabled state [ 37.986370][ T352] veth1: left allmulticast mode [ 37.986508][ T352] veth1: left promiscuous mode [ 37.986700][ T352] br0: port 1(veth1) entered disabled state