[ 11.663520][ T251] br0: port 1(veth1) entered blocking state [ 11.663632][ T251] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 11.663634][ T251] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 251, name: ip [ 11.663636][ T251] preempt_count: 1, expected: 0 [ 11.663637][ T251] RCU nest depth: 0, expected: 0 [ 11.663638][ T251] locks held by ip/251: 5, last CPU#2: [ 11.663643][ T251] #0: ffffffff978d2c40 (rtnl_mutex){+.+.}-{4:4}, at: rtnl_newlink+0x9a8/0x11c0 [ 11.663655][ T251] #1: ffffffff97169cc0 (console_lock){+.+.}-{0:0}, at: vprintk_emit+0x320/0x3e0 [ 11.663661][ T251] #2: ffffffff97169d38 (console_srcu){....}-{0:0}, at: console_flush_one_record+0x106/0x710 [ 11.663665][ T251] #3: ffffffff97089660 (console_owner){....}-{0:0}, at: console_lock_spinning_enable+0x40/0x60 [ 11.663669][ T251] #4: ffffffff97089560 (printk_legacy_map-wait-type-override){....}-{3:3}, at: console_emit_next_record+0x1df/0x4c0 [ 11.663673][ T251] irq event stamp: 22438 [ 11.663674][ T251] hardirqs last enabled at (22437): [] __down_trylock_console_sem+0x86/0xa0 [ 11.663677][ T251] hardirqs last disabled at (22438): [] console_emit_next_record+0x3d4/0x4c0 [ 11.663679][ T251] softirqs last enabled at (22350): [] __alloc_skb+0x4c2/0x5f0 [ 11.663682][ T251] softirqs last disabled at (22348): [] __alloc_skb+0x4c2/0x5f0 [ 11.663684][ T251] Preemption disabled at: [ 11.663685][ T251] [] vprintk_emit+0x31b/0x3e0 [ 11.663691][ T251] CPU: 2 UID: 0 PID: 251 Comm: ip Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 11.663694][ T251] Tainted: [W]=WARN [ 11.663695][ T251] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 11.663697][ T251] Call Trace: [ 11.663699][ T251] [ 11.663700][ T251] dump_stack_lvl+0x6f/0xa0 [ 11.663706][ T251] ? vprintk_emit+0x31b/0x3e0 [ 11.663708][ T251] __might_resched.cold+0x1fe/0x2c1 [ 11.663713][ T251] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 11.663717][ T251] ? __kmalloc_noprof+0xdb/0x760 [ 11.663722][ T251] __kmalloc_noprof+0x443/0x760 [ 11.663724][ T251] ? alloc_buf.isra.0+0x4b/0x260 [ 11.663730][ T251] ? do_raw_spin_unlock+0x59/0x250 [ 11.663733][ T251] alloc_buf.isra.0+0x4b/0x260 [ 11.663736][ T251] put_chars+0x1e1/0x2f0 [ 11.663739][ T251] ? __send_to_port+0x420/0x420 [ 11.663744][ T251] ? validate_chain+0x34a/0xc20 [ 11.663747][ T251] hvc_console_print+0x292/0x780 [ 11.663750][ T251] ? mark_usage+0x61/0x170 [ 11.663752][ T251] ? __lock_acquire+0x518/0xc20 [ 11.663753][ T251] ? __lock_acquire+0x518/0xc20 [ 11.663757][ T251] ? hvc_write+0x3a0/0x3a0 [ 11.663759][ T251] ? console_emit_next_record+0x1df/0x4c0 [ 11.663762][ T251] ? rcu_is_watching+0x16/0xd0 [ 11.663767][ T251] ? lock_acquire+0x13c/0x160 [ 11.663771][ T251] console_emit_next_record+0x22f/0x4c0 [ 11.663774][ T251] ? devkmsg_read+0x4b0/0x4b0 [ 11.663776][ T251] ? console_flush_one_record+0x106/0x710 [ 11.663780][ T251] ? rcu_is_watching+0x16/0xd0 [ 11.663782][ T251] ? lock_acquire+0x13c/0x160 [ 11.663786][ T251] console_flush_one_record+0x46f/0x710 [ 11.663790][ T251] ? console_emit_next_record+0x4c0/0x4c0 [ 11.663792][ T251] ? __lock_acquire+0x518/0xc20 [ 11.663798][ T251] console_unlock+0xee/0x1f0 [ 11.663801][ T251] ? console_flush_one_record+0x710/0x710 [ 11.663802][ T251] ? rcu_is_watching+0x16/0xd0 [ 11.663805][ T251] ? lock_acquire+0x60/0x160 [ 11.663809][ T251] ? __down_trylock_console_sem+0x5e/0xa0 [ 11.663810][ T251] ? vprintk_emit+0x320/0x3e0 [ 11.663814][ T251] vprintk_emit+0x37c/0x3e0 [ 11.663818][ T251] ? wake_up_klogd_work_func+0x90/0x90 [ 11.663820][ T251] ? __lock_release.isra.0+0x69/0x1a0 [ 11.663822][ T251] ? _raw_spin_unlock_irqrestore+0x40/0x80 [ 11.663826][ T251] ? mark_held_locks+0x40/0x70 [ 11.663830][ T251] _printk+0xc7/0x100 [ 11.663833][ T251] ? snapshot_read.cold+0x21/0x21 [ 11.663837][ T251] ? br_multicast_flood+0xab0/0xab0 [bridge] [ 11.663850][ T251] ? do_setlink.isra.0+0xa31/0x2750 [ 11.663852][ T251] ? rtnl_newlink+0x9f1/0x11c0 [ 11.663853][ T251] ? rtnetlink_rcv_msg+0x6fd/0xbd0 [ 11.663858][ T251] br_set_state+0x22f/0x430 [bridge] [ 11.663868][ T251] br_init_port+0xc4/0x200 [bridge] [ 11.663876][ T251] new_nbp+0x39c/0x580 [bridge] [ 11.663885][ T251] br_add_if+0x212/0x1320 [bridge] [ 11.663892][ T251] ? is_bpf_text_address+0x72/0x110 [ 11.663896][ T251] ? kernel_text_address+0x149/0x170 [ 11.663900][ T251] ? __kernel_text_address+0x12/0x30 [ 11.663903][ T251] do_set_master+0x357/0x580 [ 11.663908][ T251] do_setlink.isra.0+0xa31/0x2750 [ 11.663911][ T251] ? stack_trace_save+0x93/0xc0 [ 11.663915][ T251] ? rtnl_link_get_size+0x350/0x350 [ 11.663916][ T251] ? rcu_read_lock_any_held+0x66/0x90 [ 11.663919][ T251] ? stack_depot_save_flags+0x38e/0x790 [ 11.663922][ T251] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 11.663925][ T251] ? rcu_read_lock_any_held+0x3c/0x90 [ 11.663927][ T251] ? validate_chain+0x38b/0xc20 [ 11.663929][ T251] ? kasan_save_stack+0x3d/0x50 [ 11.663932][ T251] ? kasan_save_stack+0x2f/0x50 [ 11.663934][ T251] ? kasan_save_track+0x14/0x30 [ 11.663937][ T251] ? __lock_acquire+0x518/0xc20 [ 11.663938][ T251] ? netlink_seq_next+0x4e/0x60 [ 11.663942][ T251] ? ___sys_sendmsg+0xb0/0x1d0 [ 11.663946][ T251] ? lock_acquire.part.0+0xd4/0x280 [ 11.663948][ T251] ? rtnl_newlink+0x9a8/0x11c0 [ 11.663951][ T251] ? rcu_is_watching+0x16/0xd0 [ 11.663953][ T251] ? lock_acquire+0x13c/0x160 [ 11.663955][ T251] ? rcu_is_watching+0x16/0xd0 [ 11.663956][ T251] ? rcu_is_watching+0x16/0xd0 [ 11.663959][ T251] ? trace_contention_end+0xb3/0x180 [ 11.663963][ T251] ? __mutex_lock+0x1db/0x1ea0 [ 11.663964][ T251] ? __mutex_lock+0x9a3/0x1ea0 [ 11.663966][ T251] ? rtnl_newlink+0x9a8/0x11c0 [ 11.663970][ T251] ? ww_mutex_lock+0x160/0x160 [ 11.663971][ T251] ? nla_get_range_signed+0x3d0/0x3d0 [ 11.663977][ T251] ? __rtnl_newlink+0x3fa/0xa50 [ 11.663982][ T251] rtnl_newlink+0x9f1/0x11c0 [ 11.663993][ T251] ? rtnl_bridge_getlink+0x850/0x850 [ 11.663996][ T251] ? __lock_acquire+0x518/0xc20 [ 11.664000][ T251] ? lock_acquire.part.0+0xd4/0x280 [ 11.664002][ T251] ? find_held_lock+0x2b/0x80 [ 11.664004][ T251] ? rtnl_bridge_getlink+0x850/0x850 [ 11.664006][ T251] ? __lock_release.isra.0+0x69/0x1a0 [ 11.664010][ T251] ? rtnl_bridge_getlink+0x850/0x850 [ 11.664012][ T251] rtnetlink_rcv_msg+0x6fd/0xbd0 [ 11.664015][ T251] ? rtnl_link_fill+0x920/0x920 [ 11.664017][ T251] ? __lock_acquire+0x518/0xc20 [ 11.664021][ T251] ? lock_acquire.part.0+0xd4/0x280 [ 11.664023][ T251] ? find_held_lock+0x2b/0x80 [ 11.664027][ T251] netlink_rcv_skb+0x14e/0x3a0 [ 11.664029][ T251] ? rtnl_link_fill+0x920/0x920 [ 11.664032][ T251] ? netlink_ack+0xcf0/0xcf0 [ 11.664038][ T251] ? netlink_deliver_tap+0xc5/0x330 [ 11.664040][ T251] ? netlink_deliver_tap+0x13c/0x330 [ 11.664044][ T251] netlink_unicast+0x486/0x750 [ 11.664048][ T251] ? netlink_attachskb+0x810/0x810 [ 11.664051][ T251] ? __lock_acquire+0x518/0xc20 [ 11.664055][ T251] netlink_sendmsg+0x735/0xc60 [ 11.664059][ T251] ? netlink_unicast+0x750/0x750 [ 11.664063][ T251] ? __might_fault+0x97/0x140 [ 11.664069][ T251] ____sys_sendmsg+0x415/0x880 [ 11.664071][ T251] ? copy_msghdr_from_user+0x279/0x420 [ 11.664073][ T251] ? get_timestamp.constprop.0+0x390/0x390 [ 11.664075][ T251] ? move_addr_to_kernel+0x40/0x40 [ 11.664082][ T251] ___sys_sendmsg+0x14e/0x1d0 [ 11.664085][ T251] ? copy_msghdr_from_user+0x420/0x420 [ 11.664101][ T251] __sys_sendmsg+0x12c/0x1d0 [ 11.664104][ T251] ? __sys_sendmsg_sock+0x20/0x20 [ 11.664110][ T251] ? rcu_is_watching+0x16/0xd0 [ 11.664114][ T251] do_syscall_64+0xff/0x530 [ 11.664116][ T251] ? exc_page_fault+0xee/0x100 [ 11.664119][ T251] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 11.664122][ T251] RIP: 0033:0x7f7cd306f54e [ 11.664125][ 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.664127][ T251] RSP: 002b:00007ffdb5de4010 EFLAGS: 00000202 ORIG_RAX: 000000000000002e [ 11.664130][ T251] RAX: ffffffffffffffda RBX: 0000000000000004 RCX: 00007f7cd306f54e [ 11.664131][ T251] RDX: 0000000000000000 RSI: 00007ffdb5de40c0 RDI: 0000000000000005 [ 11.664132][ T251] RBP: 00007ffdb5de4020 R08: 0000000000000000 R09: 0000000000000000 [ 11.664133][ T251] R10: 0000000000000000 R11: 0000000000000202 R12: 000000006a910da0 [ 11.664134][ T251] R13: 00000000004a1620 R14: 0000000000000000 R15: 00007ffdb5de4780 [ 11.664141][ T251] [ 11.719592][ T251] br0: port 1(veth1) entered disabled state [ 11.720070][ T251] veth1: entered allmulticast mode [ 11.721905][ T251] veth1: entered promiscuous mode [ 11.732501][ T251] ip (251) used greatest stack depth: 23336 bytes left [ 11.760021][ T253] br0: port 2(veth3) entered blocking state [ 11.760359][ T253] br0: port 2(veth3) entered disabled state [ 11.760686][ T253] veth3: entered allmulticast mode [ 11.762225][ T253] veth3: entered promiscuous mode [ 11.871064][ T100] br0: port 1(veth1) entered blocking state [ 11.871564][ T100] br0: port 1(veth1) entered forwarding state [ 11.898567][ T36] br0: port 2(veth3) entered blocking state [ 11.898882][ T36] br0: port 2(veth3) entered forwarding state [ 18.021666][ T495] br0: port 3(veth5) entered blocking state [ 18.021688][ T495] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 18.021691][ T495] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 495, name: ip [ 18.021693][ T495] preempt_count: 1, expected: 0 [ 18.021694][ T495] RCU nest depth: 0, expected: 0 [ 18.021695][ T495] locks held by ip/495: 5, last CPU#3: [ 18.021698][ T495] #0: ffffffff978d2c40 (rtnl_mutex){+.+.}-{4:4}, at: rtnl_newlink+0x9a8/0x11c0 [ 18.021712][ T495] #1: ffffffff97169cc0 (console_lock){+.+.}-{0:0}, at: vprintk_emit+0x320/0x3e0 [ 18.021720][ T495] #2: ffffffff97169d38 (console_srcu){....}-{0:0}, at: console_flush_one_record+0x106/0x710 [ 18.021725][ T495] #3: ffffffff97089660 (console_owner){....}-{0:0}, at: console_lock_spinning_enable+0x40/0x60 [ 18.021730][ T495] #4: ffffffff97089560 (printk_legacy_map-wait-type-override){....}-{3:3}, at: console_emit_next_record+0x1df/0x4c0 [ 18.021736][ T495] irq event stamp: 14448 [ 18.021737][ T495] hardirqs last enabled at (14447): [] __down_trylock_console_sem+0x86/0xa0 [ 18.021740][ T495] hardirqs last disabled at (14448): [] console_emit_next_record+0x3d4/0x4c0 [ 18.021743][ T495] softirqs last enabled at (14388): [] __alloc_skb+0x4c2/0x5f0 [ 18.021746][ T495] softirqs last disabled at (14386): [] __alloc_skb+0x4c2/0x5f0 [ 18.021749][ T495] Preemption disabled at: [ 18.021750][ T495] [] vprintk_emit+0x31b/0x3e0 [ 18.021757][ T495] CPU: 3 UID: 0 PID: 495 Comm: ip Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 18.021761][ T495] Tainted: [W]=WARN [ 18.021762][ T495] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 18.021764][ T495] Call Trace: [ 18.021766][ T495] [ 18.021768][ T495] dump_stack_lvl+0x6f/0xa0 [ 18.021775][ T495] ? vprintk_emit+0x31b/0x3e0 [ 18.021778][ T495] __might_resched.cold+0x1fe/0x2c1 [ 18.021784][ T495] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 18.021789][ T495] ? __kmalloc_noprof+0xdb/0x760 [ 18.021795][ T495] __kmalloc_noprof+0x443/0x760 [ 18.021798][ T495] ? alloc_buf.isra.0+0x4b/0x260 [ 18.021806][ T495] ? do_raw_spin_unlock+0x59/0x250 [ 18.021809][ T495] alloc_buf.isra.0+0x4b/0x260 [ 18.021814][ T495] put_chars+0x1e1/0x2f0 [ 18.021816][ T495] ? prb_final_commit+0x50/0x50 [ 18.021819][ T495] ? __send_to_port+0x420/0x420 [ 18.021824][ T495] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 18.021829][ T495] ? rcu_read_lock_any_held+0x3c/0x90 [ 18.021832][ T495] ? validate_chain+0x38b/0xc20 [ 18.021837][ T495] hvc_console_print+0x292/0x780 [ 18.021841][ T495] ? mark_usage+0x61/0x170 [ 18.021843][ T495] ? __lock_acquire+0x518/0xc20 [ 18.021846][ T495] ? __lock_acquire+0x518/0xc20 [ 18.021851][ T495] ? hvc_write+0x3a0/0x3a0 [ 18.021855][ T495] ? console_emit_next_record+0x1df/0x4c0 [ 18.021859][ T495] ? rcu_is_watching+0x16/0xd0 [ 18.021863][ T495] ? lock_acquire+0x13c/0x160 [ 18.021869][ T495] console_emit_next_record+0x22f/0x4c0 [ 18.021875][ T495] ? devkmsg_read+0x4b0/0x4b0 [ 18.021877][ T495] ? console_flush_one_record+0x106/0x710 [ 18.021882][ T495] ? rcu_is_watching+0x16/0xd0 [ 18.021885][ T495] ? lock_acquire+0x13c/0x160 [ 18.021892][ T495] console_flush_one_record+0x46f/0x710 [ 18.021898][ T495] ? console_emit_next_record+0x4c0/0x4c0 [ 18.021901][ T495] ? __lock_acquire+0x518/0xc20 [ 18.021910][ T495] console_unlock+0xee/0x1f0 [ 18.021914][ T495] ? console_flush_one_record+0x710/0x710 [ 18.021916][ T495] ? rcu_is_watching+0x16/0xd0 [ 18.021920][ T495] ? lock_acquire+0x60/0x160 [ 18.021926][ T495] ? __down_trylock_console_sem+0x5e/0xa0 [ 18.021928][ T495] ? vprintk_emit+0x320/0x3e0 [ 18.021933][ T495] vprintk_emit+0x37c/0x3e0 [ 18.021940][ T495] ? wake_up_klogd_work_func+0x90/0x90 [ 18.021943][ T495] ? __lock_release.isra.0+0x69/0x1a0 [ 18.021948][ T495] ? mark_held_locks+0x40/0x70 [ 18.021953][ T495] _printk+0xc7/0x100 [ 18.021958][ T495] ? snapshot_read.cold+0x21/0x21 [ 18.021964][ T495] ? br_multicast_flood+0xab0/0xab0 [bridge] [ 18.021982][ T495] ? do_setlink.isra.0+0xa31/0x2750 [ 18.021985][ T495] ? rtnl_newlink+0x9f1/0x11c0 [ 18.021987][ T495] ? rtnetlink_rcv_msg+0x6fd/0xbd0 [ 18.021994][ T495] br_set_state+0x22f/0x430 [bridge] [ 18.022015][ T495] br_init_port+0xc4/0x200 [bridge] [ 18.022028][ T495] new_nbp+0x39c/0x580 [bridge] [ 18.022044][ T495] br_add_if+0x212/0x1320 [bridge] [ 18.022055][ T495] ? is_bpf_text_address+0x72/0x110 [ 18.022060][ T495] ? kernel_text_address+0x149/0x170 [ 18.022064][ T495] ? __kernel_text_address+0x12/0x30 [ 18.022069][ T495] do_set_master+0x357/0x580 [ 18.022076][ T495] do_setlink.isra.0+0xa31/0x2750 [ 18.022080][ T495] ? stack_trace_save+0x93/0xc0 [ 18.022084][ T495] ? rtnl_link_get_size+0x350/0x350 [ 18.022086][ T495] ? rcu_read_lock_any_held+0x66/0x90 [ 18.022088][ T495] ? stack_depot_save_flags+0x38e/0x790 [ 18.022092][ T495] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 18.022096][ T495] ? rcu_read_lock_any_held+0x3c/0x90 [ 18.022098][ T495] ? validate_chain+0x38b/0xc20 [ 18.022101][ T495] ? kasan_save_stack+0x3d/0x50 [ 18.022105][ T495] ? kasan_save_stack+0x2f/0x50 [ 18.022107][ T495] ? kasan_save_track+0x14/0x30 [ 18.022111][ T495] ? __lock_acquire+0x518/0xc20 [ 18.022113][ T495] ? netlink_seq_next+0x4e/0x60 [ 18.022117][ T495] ? ___sys_sendmsg+0xb0/0x1d0 [ 18.022123][ T495] ? lock_acquire.part.0+0xd4/0x280 [ 18.022125][ T495] ? rtnl_newlink+0x9a8/0x11c0 [ 18.022129][ T495] ? rcu_is_watching+0x16/0xd0 [ 18.022132][ T495] ? lock_acquire+0x13c/0x160 [ 18.022134][ T495] ? rcu_is_watching+0x16/0xd0 [ 18.022136][ T495] ? rcu_is_watching+0x16/0xd0 [ 18.022139][ T495] ? trace_contention_end+0xb3/0x180 [ 18.022144][ T495] ? __mutex_lock+0x1db/0x1ea0 [ 18.022147][ T495] ? __mutex_lock+0x9a3/0x1ea0 [ 18.022150][ T495] ? rtnl_newlink+0x9a8/0x11c0 [ 18.022155][ T495] ? ww_mutex_lock+0x160/0x160 [ 18.022157][ T495] ? nla_get_range_signed+0x3d0/0x3d0 [ 18.022164][ T495] ? __rtnl_newlink+0x3fa/0xa50 [ 18.022171][ T495] rtnl_newlink+0x9f1/0x11c0 [ 18.022179][ T495] ? rtnl_bridge_getlink+0x850/0x850 [ 18.022181][ T495] ? __lock_acquire+0x518/0xc20 [ 18.022188][ T495] ? lock_acquire.part.0+0xd4/0x280 [ 18.022190][ T495] ? find_held_lock+0x2b/0x80 [ 18.022193][ T495] ? rtnl_bridge_getlink+0x850/0x850 [ 18.022196][ T495] ? __lock_release.isra.0+0x69/0x1a0 [ 18.022201][ T495] ? rtnl_bridge_getlink+0x850/0x850 [ 18.022204][ T495] rtnetlink_rcv_msg+0x6fd/0xbd0 [ 18.022209][ T495] ? rtnl_link_fill+0x920/0x920 [ 18.022211][ T495] ? __lock_acquire+0x518/0xc20 [ 18.022217][ T495] ? lock_acquire.part.0+0xd4/0x280 [ 18.022220][ T495] ? find_held_lock+0x2b/0x80 [ 18.022224][ T495] netlink_rcv_skb+0x14e/0x3a0 [ 18.022227][ T495] ? rtnl_link_fill+0x920/0x920 [ 18.022231][ T495] ? netlink_ack+0xcf0/0xcf0 [ 18.022241][ T495] ? netlink_deliver_tap+0xc5/0x330 [ 18.022243][ T495] ? netlink_deliver_tap+0x13c/0x330 [ 18.022249][ T495] netlink_unicast+0x486/0x750 [ 18.022255][ T495] ? netlink_attachskb+0x810/0x810 [ 18.022259][ T495] ? __lock_acquire+0x518/0xc20 [ 18.022265][ T495] netlink_sendmsg+0x735/0xc60 [ 18.022270][ T495] ? netlink_unicast+0x750/0x750 [ 18.022276][ T495] ? __might_fault+0x97/0x140 [ 18.022284][ T495] ____sys_sendmsg+0x415/0x880 [ 18.022287][ T495] ? copy_msghdr_from_user+0x279/0x420 [ 18.022290][ T495] ? get_timestamp.constprop.0+0x390/0x390 [ 18.022292][ T495] ? move_addr_to_kernel+0x40/0x40 [ 18.022303][ T495] ___sys_sendmsg+0x14e/0x1d0 [ 18.022307][ T495] ? copy_msghdr_from_user+0x420/0x420 [ 18.022332][ T495] __sys_sendmsg+0x12c/0x1d0 [ 18.022336][ T495] ? __sys_sendmsg_sock+0x20/0x20 [ 18.022346][ T495] ? rcu_is_watching+0x16/0xd0 [ 18.022351][ T495] do_syscall_64+0xff/0x530 [ 18.022354][ T495] ? exc_page_fault+0xee/0x100 [ 18.022358][ T495] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 18.022361][ T495] RIP: 0033:0x7ff22c43354e [ 18.022366][ T495] 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 [ 18.022368][ T495] RSP: 002b:00007ffd63455580 EFLAGS: 00000202 ORIG_RAX: 000000000000002e [ 18.022372][ T495] RAX: ffffffffffffffda RBX: 0000000000000003 RCX: 00007ff22c43354e [ 18.022374][ T495] RDX: 0000000000000000 RSI: 00007ffd63455630 RDI: 0000000000000005 [ 18.022375][ T495] RBP: 00007ffd63455590 R08: 0000000000000000 R09: 0000000000000000 [ 18.022376][ T495] R10: 0000000000000000 R11: 0000000000000202 R12: 000000006a910da6 [ 18.022377][ T495] R13: 00000000004a1620 R14: 0000000000000000 R15: 00007ffd63455cf0 [ 18.022388][ T495] [ 18.086908][ T495] br0: port 3(veth5) entered disabled state [ 18.087481][ T495] veth5: entered allmulticast mode [ 18.090685][ T495] veth5: entered promiscuous mode [ 18.174892][ T500] veth5: left allmulticast mode [ 18.175208][ T500] veth5: left promiscuous mode [ 18.175593][ T500] br0: port 3(veth5) entered disabled state [ 18.478883][ T515] br0: port 3(veth5) entered blocking state [ 18.479260][ T515] br0: port 3(veth5) entered disabled state [ 18.479616][ T515] veth5: entered allmulticast mode [ 18.481775][ T515] veth5: entered promiscuous mode [ 18.482162][ T515] br0: adding interface veth5 with same address as a received packet (addr:de:ad:be:ef:42:00, vlan:0) [ 18.482215][ T515] [ 18.482217][ T515] ===================================================== [ 18.482218][ T515] WARNING: SOFTIRQ-safe -> SOFTIRQ-unsafe lock order detected [ 18.482221][ T515] 7.2.0-virtme #1 Tainted: G W [ 18.482222][ T515] ----------------------------------------------------- [ 18.482223][ T515] ip/515 [HC0[0]:SC0[2]:HE0:SE0] is trying to acquire: [ 18.482225][ T515] ffffffff97089660 (console_owner){....}-{0:0}, at: console_lock_spinning_enable+0x40/0x60 [ 18.482236][ T515] [ 18.482236][ T515] and this task is already holding: [ 18.482236][ T515] ff11000004b72e98 (&br->hash_lock){+.-.}-{3:3}, at: br_fdb_add_local+0x2b/0x60 [bridge] [ 18.482250][ T515] which would create a new lock dependency: [ 18.482250][ T515] (&br->hash_lock){+.-.}-{3:3} -> (console_owner){....}-{0:0} [ 18.482253][ T515] [ 18.482253][ T515] but this new dependency connects a SOFTIRQ-irq-safe lock: [ 18.482254][ T515] (&br->hash_lock){+.-.}-{3:3} [ 18.482255][ T515] [ 18.482255][ T515] ... which became SOFTIRQ-irq-safe at: [ 18.482256][ T515] __lock_acquire+0x388/0xc20 [ 18.482259][ T515] lock_acquire.part.0+0xd4/0x280 [ 18.482261][ T515] _raw_spin_lock+0x33/0x40 [ 18.482265][ T515] br_fdb_update+0x342/0x670 [bridge] [ 18.482272][ T515] br_handle_frame_finish+0x801/0x1d20 [bridge] [ 18.482278][ T515] br_handle_frame+0x74d/0xf50 [bridge] [ 18.482284][ T515] __netif_receive_skb_core.constprop.0+0x536/0x2bb0 [ 18.482288][ T515] __netif_receive_skb_one_core+0xa2/0x180 [ 18.482289][ T515] process_backlog+0x431/0x14c0 [ 18.482291][ T515] __napi_poll+0xa7/0x3b0 [ 18.482293][ T515] net_rx_action+0x513/0xf50 [ 18.482294][ T515] handle_softirqs+0x1d3/0x900 [ 18.482297][ T515] do_softirq+0xac/0xe0 [ 18.482298][ T515] __local_bh_enable_ip+0x118/0x150 [ 18.482299][ T515] __dev_queue_xmit+0x979/0x1b80 [ 18.482301][ T515] ip6_finish_output2+0x423/0x1300 [ 18.482303][ T515] ip6_finish_output+0x646/0xda0 [ 18.482304][ T515] ip6_output+0x23f/0x7f0 [ 18.482305][ T515] mld_sendpack+0x9d6/0xec0 [ 18.482308][ T515] mld_ifc_work+0x36/0x190 [ 18.482309][ T515] process_one_work+0xe3e/0x1560 [ 18.482312][ T515] worker_thread+0x4f1/0xd60 [ 18.482313][ T515] kthread+0x367/0x460 [ 18.482315][ T515] ret_from_fork+0x474/0x6b0 [ 18.482318][ T515] ret_from_fork_asm+0x11/0x20 [ 18.482321][ T515] [ 18.482321][ T515] to a SOFTIRQ-irq-unsafe lock: [ 18.482321][ T515] (fs_reclaim){+.+.}-{0:0} [ 18.482323][ T515] [ 18.482323][ T515] ... which became SOFTIRQ-irq-unsafe at: [ 18.482323][ T515] ... [ 18.482324][ T515] __lock_acquire+0x388/0xc20 [ 18.482326][ T515] lock_acquire.part.0+0xd4/0x280 [ 18.482327][ T515] fs_reclaim_acquire+0xd5/0x120 [ 18.482330][ T515] __kmalloc_cache_noprof+0x6e/0x620 [ 18.482332][ T515] kthread_create_worker_on_node+0xea/0x210 [ 18.482333][ T515] workqueue_init+0x2a/0x680 [ 18.482337][ T515] kernel_init_freeable+0x2fe/0x630 [ 18.482338][ T515] kernel_init+0x21/0x150 [ 18.482341][ T515] ret_from_fork+0x474/0x6b0 [ 18.482342][ T515] ret_from_fork_asm+0x11/0x20 [ 18.482343][ T515] [ 18.482343][ T515] other info that might help us debug this: [ 18.482343][ T515] [ 18.482344][ T515] Chain exists of: [ 18.482344][ T515] &br->hash_lock --> console_owner --> fs_reclaim [ 18.482344][ T515] [ 18.482346][ T515] Possible interrupt unsafe locking scenario: [ 18.482346][ T515] [ 18.482346][ T515] CPU0 CPU1 [ 18.482347][ T515] ---- ---- [ 18.482347][ T515] lock(fs_reclaim); [ 18.482348][ T515] local_irq_disable(); [ 18.482349][ T515] lock(&br->hash_lock); [ 18.482350][ T515] lock(console_owner); [ 18.482350][ T515] [ 18.482351][ T515] lock(&br->hash_lock); [ 18.482351][ T515] [ 18.482351][ T515] *** DEADLOCK *** [ 18.482351][ T515] [ 18.482352][ T515] locks held by ip/515: 4, last CPU#2: [ 18.482353][ T515] #0: ffffffff978d2c40 (rtnl_mutex){+.+.}-{4:4}, at: rtnl_newlink+0x9a8/0x11c0 [ 18.482357][ T515] #1: ff11000004b72e98 (&br->hash_lock){+.-.}-{3:3}, at: br_fdb_add_local+0x2b/0x60 [bridge] [ 18.482365][ T515] #2: ffffffff97169cc0 (console_lock){+.+.}-{0:0}, at: vprintk_emit+0x320/0x3e0 [ 18.482369][ T515] #3: ffffffff97169d38 (console_srcu){....}-{0:0}, at: console_flush_one_record+0x106/0x710 [ 18.482372][ T515] [ 18.482372][ T515] the dependencies between SOFTIRQ-irq-safe lock and the holding lock: [ 18.482373][ T515] -> (&br->hash_lock){+.-.}-{3:3} { [ 18.482374][ T515] HARDIRQ-ON-W at: [ 18.482376][ T515] __lock_acquire+0x388/0xc20 [ 18.482377][ T515] lock_acquire.part.0+0xd4/0x280 [ 18.482378][ T515] _raw_spin_lock_bh+0x38/0x50 [ 18.482380][ T515] br_fdb_change_mac_address+0x6f/0x580 [bridge] [ 18.482386][ T515] br_device_event+0x44b/0x8f0 [bridge] [ 18.482392][ T515] notifier_call_chain+0xae/0x300 [ 18.482394][ T515] register_netdevice+0x1222/0x1af0 [ 18.482396][ T515] br_dev_newlink+0x70/0x160 [bridge] [ 18.482403][ T515] rtnl_newlink_create+0x2d0/0x750 [ 18.482404][ T515] __rtnl_newlink+0x22b/0xa50 [ 18.482405][ T515] rtnl_newlink+0x9f1/0x11c0 [ 18.482406][ T515] rtnetlink_rcv_msg+0x6fd/0xbd0 [ 18.482407][ T515] netlink_rcv_skb+0x14e/0x3a0 [ 18.482409][ T515] netlink_unicast+0x486/0x750 [ 18.482411][ T515] netlink_sendmsg+0x735/0xc60 [ 18.482412][ T515] ____sys_sendmsg+0x415/0x880 [ 18.482414][ T515] ___sys_sendmsg+0x14e/0x1d0 [ 18.482416][ T515] __sys_sendmsg+0x12c/0x1d0 [ 18.482417][ T515] do_syscall_64+0xff/0x530 [ 18.482419][ T515] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 18.482421][ T515] IN-SOFTIRQ-W at: [ 18.482422][ T515] __lock_acquire+0x388/0xc20 [ 18.482423][ T515] lock_acquire.part.0+0xd4/0x280 [ 18.482424][ T515] _raw_spin_lock+0x33/0x40 [ 18.482425][ T515] br_fdb_update+0x342/0x670 [bridge] [ 18.482432][ T515] br_handle_frame_finish+0x801/0x1d20 [bridge] [ 18.482438][ T515] br_handle_frame+0x74d/0xf50 [bridge] [ 18.482445][ T515] __netif_receive_skb_core.constprop.0+0x536/0x2bb0 [ 18.482446][ T515] __netif_receive_skb_one_core+0xa2/0x180 [ 18.482448][ T515] process_backlog+0x431/0x14c0 [ 18.482449][ T515] __napi_poll+0xa7/0x3b0 [ 18.482451][ T515] net_rx_action+0x513/0xf50 [ 18.482452][ T515] handle_softirqs+0x1d3/0x900 [ 18.482453][ T515] do_softirq+0xac/0xe0 [ 18.482454][ T515] __local_bh_enable_ip+0x118/0x150 [ 18.482456][ T515] __dev_queue_xmit+0x979/0x1b80 [ 18.482457][ T515] ip6_finish_output2+0x423/0x1300 [ 18.482458][ T515] ip6_finish_output+0x646/0xda0 [ 18.482459][ T515] ip6_output+0x23f/0x7f0 [ 18.482460][ T515] mld_sendpack+0x9d6/0xec0 [ 18.482462][ T515] mld_ifc_work+0x36/0x190 [ 18.482463][ T515] process_one_work+0xe3e/0x1560 [ 18.482465][ T515] worker_thread+0x4f1/0xd60 [ 18.482466][ T515] kthread+0x367/0x460 [ 18.482467][ T515] ret_from_fork+0x474/0x6b0 [ 18.482468][ T515] ret_from_fork_asm+0x11/0x20 [ 18.482469][ T515] INITIAL USE at: [ 18.482470][ T515] __lock_acquire+0x388/0xc20 [ 18.482471][ T515] lock_acquire.part.0+0xd4/0x280 [ 18.482473][ T515] _raw_spin_lock_bh+0x38/0x50 [ 18.482474][ T515] br_fdb_change_mac_address+0x6f/0x580 [bridge] [ 18.482480][ T515] br_device_event+0x44b/0x8f0 [bridge] [ 18.482486][ T515] notifier_call_chain+0xae/0x300 [ 18.482487][ T515] register_netdevice+0x1222/0x1af0 [ 18.482488][ T515] br_dev_newlink+0x70/0x160 [bridge] [ 18.482494][ T515] rtnl_newlink_create+0x2d0/0x750 [ 18.482495][ T515] __rtnl_newlink+0x22b/0xa50 [ 18.482496][ T515] rtnl_newlink+0x9f1/0x11c0 [ 18.482497][ T515] rtnetlink_rcv_msg+0x6fd/0xbd0 [ 18.482498][ T515] netlink_rcv_skb+0x14e/0x3a0 [ 18.482499][ T515] netlink_unicast+0x486/0x750 [ 18.482500][ T515] netlink_sendmsg+0x735/0xc60 [ 18.482501][ T515] ____sys_sendmsg+0x415/0x880 [ 18.482503][ T515] ___sys_sendmsg+0x14e/0x1d0 [ 18.482504][ T515] __sys_sendmsg+0x12c/0x1d0 [ 18.482505][ T515] do_syscall_64+0xff/0x530 [ 18.482506][ T515] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 18.482507][ T515] } [ 18.482508][ T515] ... key at: [] __key.6+0x0/0x40 [bridge] [ 18.482514][ T515] [ 18.482514][ T515] the dependencies between the lock to be acquired [ 18.482514][ T515] and SOFTIRQ-irq-unsafe lock: [ 18.482519][ T515] -> (fs_reclaim){+.+.}-{0:0} { [ 18.482520][ T515] HARDIRQ-ON-W at: [ 18.482521][ T515] __lock_acquire+0x388/0xc20 [ 18.482523][ T515] lock_acquire.part.0+0xd4/0x280 [ 18.482525][ T515] fs_reclaim_acquire+0xd5/0x120 [ 18.482526][ T515] __kmalloc_cache_noprof+0x6e/0x620 [ 18.482527][ T515] kthread_create_worker_on_node+0xea/0x210 [ 18.482529][ T515] workqueue_init+0x2a/0x680 [ 18.482530][ T515] kernel_init_freeable+0x2fe/0x630 [ 18.482531][ T515] kernel_init+0x21/0x150 [ 18.482532][ T515] ret_from_fork+0x474/0x6b0 [ 18.482534][ T515] ret_from_fork_asm+0x11/0x20 [ 18.482535][ T515] SOFTIRQ-ON-W at: [ 18.482536][ T515] __lock_acquire+0x388/0xc20 [ 18.482537][ T515] lock_acquire.part.0+0xd4/0x280 [ 18.482538][ T515] fs_reclaim_acquire+0xd5/0x120 [ 18.482539][ T515] __kmalloc_cache_noprof+0x6e/0x620 [ 18.482540][ T515] kthread_create_worker_on_node+0xea/0x210 [ 18.482542][ T515] workqueue_init+0x2a/0x680 [ 18.482543][ T515] kernel_init_freeable+0x2fe/0x630 [ 18.482544][ T515] kernel_init+0x21/0x150 [ 18.482545][ T515] ret_from_fork+0x474/0x6b0 [ 18.482546][ T515] ret_from_fork_asm+0x11/0x20 [ 18.482547][ T515] INITIAL USE at: [ 18.482548][ T515] __lock_acquire+0x388/0xc20 [ 18.482549][ T515] lock_acquire.part.0+0xd4/0x280 [ 18.482551][ T515] fs_reclaim_acquire+0xd5/0x120 [ 18.482552][ T515] __kmalloc_cache_noprof+0x6e/0x620 [ 18.482553][ T515] kthread_create_worker_on_node+0xea/0x210 [ 18.482554][ T515] workqueue_init+0x2a/0x680 [ 18.482555][ T515] kernel_init_freeable+0x2fe/0x630 [ 18.482556][ T515] kernel_init+0x21/0x150 [ 18.482558][ T515] ret_from_fork+0x474/0x6b0 [ 18.482559][ T515] ret_from_fork_asm+0x11/0x20 [ 18.482560][ T515] } [ 18.482561][ T515] ... key at: [] __fs_reclaim_map+0x0/0xbe0 [ 18.482565][ T515] ... acquired at: [ 18.482565][ T515] __lock_acquire+0x518/0xc20 [ 18.482567][ T515] lock_acquire.part.0+0xd4/0x280 [ 18.482568][ T515] fs_reclaim_acquire+0xd5/0x120 [ 18.482569][ T515] __kmalloc_noprof+0xd3/0x760 [ 18.482570][ T515] alloc_buf.isra.0+0x4b/0x260 [ 18.482573][ T515] put_chars+0x1e1/0x2f0 [ 18.482574][ T515] hvc_console_print+0x292/0x780 [ 18.482576][ T515] console_emit_next_record+0x22f/0x4c0 [ 18.482578][ T515] console_flush_one_record+0x46f/0x710 [ 18.482580][ T515] console_unlock+0xee/0x1f0 [ 18.482581][ T515] vprintk_emit+0x37c/0x3e0 [ 18.482582][ T515] dev_vprintk_emit+0x27f/0x2c0 [ 18.482586][ T515] dev_printk_emit+0xb9/0xee [ 18.482587][ T515] _dev_info+0xe2/0x116 [ 18.482589][ T515] cmos_do_probe+0x8be/0x98a [ 18.482591][ T515] platform_probe+0xfe/0x1f0 [ 18.482594][ T515] call_driver_probe+0x61/0x1c0 [ 18.482596][ T515] really_probe+0x199/0x760 [ 18.482598][ T515] __driver_probe_device+0x24f/0x440 [ 18.482599][ T515] driver_probe_device+0x4a/0xf0 [ 18.482601][ T515] __driver_attach+0x1b8/0x540 [ 18.482602][ T515] bus_for_each_dev+0x130/0x1e0 [ 18.482603][ T515] bus_add_driver+0x2c8/0x530 [ 18.482604][ T515] driver_register+0x1a3/0x390 [ 18.482606][ T515] __platform_driver_probe+0x13f/0x270 [ 18.482607][ T515] cmos_init+0x31/0x40 [ 18.482610][ T515] do_one_initcall+0x124/0x4f0 [ 18.482611][ T515] kernel_init_freeable+0x596/0x630 [ 18.482613][ T515] kernel_init+0x21/0x150 [ 18.482614][ T515] ret_from_fork+0x474/0x6b0 [ 18.482615][ T515] ret_from_fork_asm+0x11/0x20 [ 18.482616][ T515] [ 18.482617][ T515] -> (console_owner){....}-{0:0} { [ 18.482618][ T515] INITIAL USE at: [ 18.482619][ T515] } [ 18.482620][ T515] ... key at: [] console_owner_dep_map+0x0/0x60 [ 18.482623][ T515] ... acquired at: [ 18.482623][ T515] check_prev_add+0xef/0xe90 [ 18.482624][ T515] validate_chain+0x6b8/0xc20 [ 18.482626][ T515] __lock_acquire+0x518/0xc20 [ 18.482627][ T515] lock_acquire.part.0+0xd4/0x280 [ 18.482628][ T515] console_lock_spinning_enable+0x5c/0x60 [ 18.482630][ T515] console_emit_next_record+0x1d1/0x4c0 [ 18.482631][ T515] console_flush_one_record+0x46f/0x710 [ 18.482633][ T515] console_unlock+0xee/0x1f0 [ 18.482634][ T515] vprintk_emit+0x37c/0x3e0 [ 18.482636][ T515] _printk+0xc7/0x100 [ 18.482638][ T515] fdb_add_local.cold+0x78/0xd5 [bridge] [ 18.482651][ T515] br_fdb_add_local+0x3f/0x60 [bridge] [ 18.482657][ T515] br_add_if+0x803/0x1320 [bridge] [ 18.482663][ T515] do_set_master+0x357/0x580 [ 18.482665][ T515] do_setlink.isra.0+0xa31/0x2750 [ 18.482666][ T515] rtnl_newlink+0x9f1/0x11c0 [ 18.482667][ T515] rtnetlink_rcv_msg+0x6fd/0xbd0 [ 18.482668][ T515] netlink_rcv_skb+0x14e/0x3a0 [ 18.482669][ T515] netlink_unicast+0x486/0x750 [ 18.482671][ T515] netlink_sendmsg+0x735/0xc60 [ 18.482672][ T515] ____sys_sendmsg+0x415/0x880 [ 18.482673][ T515] ___sys_sendmsg+0x14e/0x1d0 [ 18.482674][ T515] __sys_sendmsg+0x12c/0x1d0 [ 18.482676][ T515] do_syscall_64+0xff/0x530 [ 18.482677][ T515] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 18.482678][ T515] [ 18.482678][ T515] [ 18.482678][ T515] stack backtrace: [ 18.482681][ T515] CPU: 2 UID: 0 PID: 515 Comm: ip Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 18.482684][ T515] Tainted: [W]=WARN [ 18.482685][ T515] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 18.482687][ T515] Call Trace: [ 18.482688][ T515] [ 18.482689][ T515] dump_stack_lvl+0x6f/0xa0 [ 18.482693][ T515] print_bad_irq_dependency+0x3e4/0x410 [ 18.482696][ T515] check_irq_usage+0x403/0x570 [ 18.482697][ T515] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 18.482701][ T515] ? rcu_read_lock_any_held+0x3c/0x90 [ 18.482704][ T515] ? check_path.constprop.0+0x24/0x50 [ 18.482706][ T515] ? check_prev_add+0xef/0xe90 [ 18.482708][ T515] check_prev_add+0xef/0xe90 [ 18.482710][ T515] validate_chain+0x6b8/0xc20 [ 18.482712][ T515] __lock_acquire+0x518/0xc20 [ 18.482714][ T515] lock_acquire.part.0+0xd4/0x280 [ 18.482716][ T515] ? console_lock_spinning_enable+0x40/0x60 [ 18.482718][ T515] ? rcu_is_watching+0x16/0xd0 [ 18.482719][ T515] ? lock_acquire+0x13c/0x160 [ 18.482721][ T515] console_lock_spinning_enable+0x5c/0x60 [ 18.482723][ T515] ? console_lock_spinning_enable+0x40/0x60 [ 18.482725][ T515] console_emit_next_record+0x1d1/0x4c0 [ 18.482727][ T515] ? devkmsg_read+0x4b0/0x4b0 [ 18.482728][ T515] ? console_flush_one_record+0x106/0x710 [ 18.482730][ T515] ? rcu_is_watching+0x16/0xd0 [ 18.482732][ T515] ? lock_acquire+0x13c/0x160 [ 18.482734][ T515] console_flush_one_record+0x46f/0x710 [ 18.482736][ T515] ? console_emit_next_record+0x4c0/0x4c0 [ 18.482738][ T515] ? __lock_acquire+0x518/0xc20 [ 18.482740][ T515] console_unlock+0xee/0x1f0 [ 18.482742][ T515] ? console_flush_one_record+0x710/0x710 [ 18.482744][ T515] ? rcu_is_watching+0x16/0xd0 [ 18.482745][ T515] ? lock_acquire+0x60/0x160 [ 18.482747][ T515] ? __down_trylock_console_sem+0x5e/0xa0 [ 18.482749][ T515] ? vprintk_emit+0x320/0x3e0 [ 18.482751][ T515] vprintk_emit+0x37c/0x3e0 [ 18.482753][ T515] ? wake_up_klogd_work_func+0x90/0x90 [ 18.482755][ T515] ? rcu_read_lock_any_held+0x3c/0x90 [ 18.482757][ T515] _printk+0xc7/0x100 [ 18.482759][ T515] ? snapshot_read.cold+0x21/0x21 [ 18.482761][ T515] ? __lock_release.isra.0+0x69/0x1a0 [ 18.482763][ T515] ? br_fdb_find+0xb5/0x1a0 [bridge] [ 18.482769][ T515] fdb_add_local.cold+0x78/0xd5 [bridge] [ 18.482776][ T515] br_fdb_add_local+0x3f/0x60 [bridge] [ 18.482783][ T515] br_add_if+0x803/0x1320 [bridge] [ 18.482791][ T515] do_set_master+0x357/0x580 [ 18.482794][ T515] do_setlink.isra.0+0xa31/0x2750 [ 18.482796][ T515] ? stack_trace_save+0x93/0xc0 [ 18.482798][ T515] ? rtnl_link_get_size+0x350/0x350 [ 18.482799][ T515] ? rcu_read_lock_any_held+0x66/0x90 [ 18.482801][ T515] ? stack_depot_save_flags+0x38e/0x790 [ 18.482804][ T515] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 18.482806][ T515] ? rcu_read_lock_any_held+0x3c/0x90 [ 18.482807][ T515] ? validate_chain+0x38b/0xc20 [ 18.482809][ T515] ? kasan_save_stack+0x3d/0x50 [ 18.482811][ T515] ? kasan_save_stack+0x2f/0x50 [ 18.482813][ T515] ? kasan_save_track+0x14/0x30 [ 18.482814][ T515] ? __lock_acquire+0x518/0xc20 [ 18.482816][ T515] ? netlink_seq_next+0x4e/0x60 [ 18.482817][ T515] ? ___sys_sendmsg+0xb0/0x1d0 [ 18.482819][ T515] ? lock_acquire.part.0+0xd4/0x280 [ 18.482820][ T515] ? rtnl_newlink+0x9a8/0x11c0 [ 18.482822][ T515] ? rcu_is_watching+0x16/0xd0 [ 18.482824][ T515] ? lock_acquire+0x13c/0x160 [ 18.482825][ T515] ? rcu_is_watching+0x16/0xd0 [ 18.482826][ T515] ? rcu_is_watching+0x16/0xd0 [ 18.482828][ T515] ? trace_contention_end+0xb3/0x180 [ 18.482831][ T515] ? __mutex_lock+0x1db/0x1ea0 [ 18.482833][ T515] ? __mutex_lock+0x9a3/0x1ea0 [ 18.482834][ T515] ? rtnl_newlink+0x9a8/0x11c0 [ 18.482835][ T515] ? ww_mutex_lock+0x160/0x160 [ 18.482837][ T515] ? nla_get_range_signed+0x3d0/0x3d0 [ 18.482839][ T515] ? __rtnl_newlink+0x3fa/0xa50 [ 18.482841][ T515] rtnl_newlink+0x9f1/0x11c0 [ 18.482843][ T515] ? rtnl_bridge_getlink+0x850/0x850 [ 18.482844][ T515] ? __lock_acquire+0x518/0xc20 [ 18.482847][ T515] ? lock_acquire.part.0+0xd4/0x280 [ 18.482848][ T515] ? find_held_lock+0x2b/0x80 [ 18.482849][ T515] ? rtnl_bridge_getlink+0x850/0x850 [ 18.482851][ T515] ? __lock_release.isra.0+0x69/0x1a0 [ 18.482853][ T515] ? rtnl_bridge_getlink+0x850/0x850 [ 18.482854][ T515] rtnetlink_rcv_msg+0x6fd/0xbd0 [ 18.482855][ T515] ? rtnl_link_fill+0x920/0x920 [ 18.482857][ T515] ? __lock_acquire+0x518/0xc20 [ 18.482859][ T515] ? lock_acquire.part.0+0xd4/0x280 [ 18.482860][ T515] ? find_held_lock+0x2b/0x80 [ 18.482862][ T515] netlink_rcv_skb+0x14e/0x3a0 [ 18.482863][ T515] ? rtnl_link_fill+0x920/0x920 [ 18.482865][ T515] ? netlink_ack+0xcf0/0xcf0 [ 18.482867][ T515] ? netlink_deliver_tap+0xc5/0x330 [ 18.482868][ T515] ? netlink_deliver_tap+0x13c/0x330 [ 18.482870][ T515] netlink_unicast+0x486/0x750 [ 18.482872][ T515] ? netlink_attachskb+0x810/0x810 [ 18.482874][ T515] ? __lock_acquire+0x518/0xc20 [ 18.482876][ T515] netlink_sendmsg+0x735/0xc60 [ 18.482877][ T515] ? netlink_unicast+0x750/0x750 [ 18.482879][ T515] ? __might_fault+0x97/0x140 [ 18.482883][ T515] ____sys_sendmsg+0x415/0x880 [ 18.482884][ T515] ? copy_msghdr_from_user+0x279/0x420 [ 18.482886][ T515] ? get_timestamp.constprop.0+0x390/0x390 [ 18.482887][ T515] ? move_addr_to_kernel+0x40/0x40 [ 18.482890][ T515] ___sys_sendmsg+0x14e/0x1d0 [ 18.482892][ T515] ? copy_msghdr_from_user+0x420/0x420 [ 18.482897][ T515] __sys_sendmsg+0x12c/0x1d0 [ 18.482899][ T515] ? __sys_sendmsg_sock+0x20/0x20 [ 18.482901][ T515] ? rcu_is_watching+0x16/0xd0 [ 18.482903][ T515] do_syscall_64+0xff/0x530 [ 18.482905][ T515] ? exc_page_fault+0xee/0x100 [ 18.482906][ T515] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 18.482908][ T515] RIP: 0033:0x7fa10424754e [ 18.482911][ T515] 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 [ 18.482913][ T515] RSP: 002b:00007ffe72342670 EFLAGS: 00000202 ORIG_RAX: 000000000000002e [ 18.482916][ T515] RAX: ffffffffffffffda RBX: 0000000000000003 RCX: 00007fa10424754e [ 18.482917][ T515] RDX: 0000000000000000 RSI: 00007ffe72342720 RDI: 0000000000000005 [ 18.482918][ T515] RBP: 00007ffe72342680 R08: 0000000000000000 R09: 0000000000000000 [ 18.482919][ T515] R10: 0000000000000000 R11: 0000000000000202 R12: 000000006a910da6 [ 18.482920][ T515] R13: 00000000004a1620 R14: 0000000000000000 R15: 00007ffe72342de0 [ 18.482922][ T515] [ 18.566123][ T515] ip (515) used greatest stack depth: 23304 bytes left [ 18.609430][ T520] veth5: left allmulticast mode [ 18.609613][ T520] veth5: left promiscuous mode [ 18.610565][ T520] br0: port 3(veth5) entered disabled state [ 29.319923][ T1261] br0: port 3(veth5) entered blocking state [ 29.319941][ T1261] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 29.319943][ T1261] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 1261, name: ip [ 29.319945][ T1261] preempt_count: 1, expected: 0 [ 29.319946][ T1261] RCU nest depth: 0, expected: 0 [ 29.319947][ T1261] INFO: lockdep is turned off. [ 29.319948][ T1261] irq event stamp: 0 [ 29.319948][ T1261] hardirqs last enabled at (0): [<0000000000000000>] 0x0 [ 29.319953][ T1261] hardirqs last disabled at (0): [] copy_process+0x1ccd/0x6240 [ 29.319959][ T1261] softirqs last enabled at (0): [] copy_process+0x1d21/0x6240 [ 29.319961][ T1261] softirqs last disabled at (0): [<0000000000000000>] 0x0 [ 29.319962][ T1261] Preemption disabled at: [ 29.319963][ T1261] [] vprintk_emit+0x31b/0x3e0 [ 29.319970][ T1261] CPU: 3 UID: 0 PID: 1261 Comm: ip Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 29.319973][ T1261] Tainted: [W]=WARN [ 29.319974][ T1261] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 29.319976][ T1261] Call Trace: [ 29.319977][ T1261] [ 29.319978][ T1261] dump_stack_lvl+0x6f/0xa0 [ 29.319983][ T1261] ? vprintk_emit+0x31b/0x3e0 [ 29.319985][ T1261] __might_resched.cold+0x1fe/0x2c1 [ 29.319989][ T1261] ? __module_address+0x36/0x330 [ 29.319992][ T1261] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 29.319995][ T1261] ? prb_next_reserve_seq+0x2d0/0x2d0 [ 29.319996][ T1261] ? rcu_is_watching+0x16/0xd0 [ 29.320000][ T1261] __kmalloc_noprof+0x443/0x760 [ 29.320003][ T1261] ? __rwlock_init+0x150/0x150 [ 29.320006][ T1261] ? alloc_buf.isra.0+0x4b/0x260 [ 29.320009][ T1261] ? do_raw_spin_unlock+0x59/0x250 [ 29.320011][ T1261] alloc_buf.isra.0+0x4b/0x260 [ 29.320013][ T1261] put_chars+0x1e1/0x2f0 [ 29.320015][ T1261] ? prb_final_commit+0x50/0x50 [ 29.320016][ T1261] ? __send_to_port+0x420/0x420 [ 29.320018][ T1261] ? printk_get_next_message+0x240/0x650 [ 29.320020][ T1261] hvc_console_print+0x292/0x780 [ 29.320023][ T1261] ? hvc_write+0x3a0/0x3a0 [ 29.320025][ T1261] ? do_raw_spin_lock+0x131/0x280 [ 29.320026][ T1261] ? vsnprintf+0x668/0x1700 [ 29.320029][ T1261] ? __rwlock_init+0x150/0x150 [ 29.320031][ T1261] ? rcu_is_watching+0x16/0xd0 [ 29.320033][ T1261] ? lock_acquire+0x13c/0x160 [ 29.320035][ T1261] console_emit_next_record+0x22f/0x4c0 [ 29.320037][ T1261] ? devkmsg_read+0x4b0/0x4b0 [ 29.320039][ T1261] ? rcu_is_watching+0x16/0xd0 [ 29.320041][ T1261] ? rcu_is_watching+0x16/0xd0 [ 29.320042][ T1261] ? rcu_is_watching+0x16/0xd0 [ 29.320050][ T1261] ? lock_acquire+0x13c/0x160 [ 29.320052][ T1261] ? console_flush_one_record+0x111/0x710 [ 29.320054][ T1261] console_flush_one_record+0x46f/0x710 [ 29.320056][ T1261] ? console_emit_next_record+0x4c0/0x4c0 [ 29.320058][ T1261] console_unlock+0xee/0x1f0 [ 29.320060][ T1261] ? lock_acquire+0x13c/0x160 [ 29.320062][ T1261] ? console_flush_one_record+0x710/0x710 [ 29.320063][ T1261] ? rcu_is_watching+0x16/0xd0 [ 29.320065][ T1261] ? lock_release+0x184/0x1f0 [ 29.320066][ T1261] ? lock_acquire+0x60/0x160 [ 29.320068][ T1261] ? __rcu_read_lock+0x30/0x70 [ 29.320070][ T1261] ? __down_trylock_console_sem+0x5e/0xa0 [ 29.320072][ T1261] ? vprintk_emit+0x320/0x3e0 [ 29.320074][ T1261] vprintk_emit+0x37c/0x3e0 [ 29.320076][ T1261] ? wake_up_klogd_work_func+0x90/0x90 [ 29.320078][ T1261] ? __rwlock_init+0x150/0x150 [ 29.320080][ T1261] ? filter_irq_stacks+0xd0/0xd0 [ 29.320082][ T1261] ? lock_acquire+0x13c/0x160 [ 29.320083][ T1261] ? rcu_is_watching+0x16/0xd0 [ 29.320085][ T1261] _printk+0xc7/0x100 [ 29.320088][ T1261] ? snapshot_read.cold+0x21/0x21 [ 29.320090][ T1261] ? br_multicast_flood+0xab0/0xab0 [bridge] [ 29.320102][ T1261] ? do_setlink.isra.0+0xa31/0x2750 [ 29.320105][ T1261] ? rtnl_newlink+0x9f1/0x11c0 [ 29.320106][ T1261] ? rtnetlink_rcv_msg+0x6fd/0xbd0 [ 29.320108][ T1261] br_set_state+0x22f/0x430 [bridge] [ 29.320116][ T1261] br_init_port+0xc4/0x200 [bridge] [ 29.320123][ T1261] new_nbp+0x39c/0x580 [bridge] [ 29.320130][ T1261] br_add_if+0x212/0x1320 [bridge] [ 29.320136][ T1261] ? bpf_address_lookup+0x250/0x290 [ 29.320140][ T1261] ? is_bpf_text_address+0x72/0x110 [ 29.320142][ T1261] ? kernel_text_address+0x149/0x170 [ 29.320144][ T1261] ? __kernel_text_address+0x12/0x30 [ 29.320146][ T1261] do_set_master+0x357/0x580 [ 29.320149][ T1261] do_setlink.isra.0+0xa31/0x2750 [ 29.320151][ T1261] ? stack_trace_save+0x93/0xc0 [ 29.320152][ T1261] ? rtnl_link_get_size+0x350/0x350 [ 29.320153][ T1261] ? rcu_is_watching+0x16/0xd0 [ 29.320155][ T1261] ? stack_depot_save_flags+0x1bc/0x790 [ 29.320159][ T1261] ? kasan_save_stack+0x3d/0x50 [ 29.320162][ T1261] ? kasan_save_stack+0x2f/0x50 [ 29.320163][ T1261] ? kasan_save_track+0x14/0x30 [ 29.320165][ T1261] ? __kasan_kmalloc+0x7b/0x90 [ 29.320166][ T1261] ? __kmalloc_cache_noprof+0x29a/0x620 [ 29.320168][ T1261] ? rtnl_newlink+0x124/0x11c0 [ 29.320169][ T1261] ? rtnetlink_rcv_msg+0x6fd/0xbd0 [ 29.320170][ T1261] ? netlink_rcv_skb+0x14e/0x3a0 [ 29.320173][ T1261] ? netlink_unicast+0x486/0x750 [ 29.320174][ T1261] ? netlink_sendmsg+0x735/0xc60 [ 29.320175][ T1261] ? ____sys_sendmsg+0x415/0x880 [ 29.320178][ T1261] ? ___sys_sendmsg+0x14e/0x1d0 [ 29.320179][ T1261] ? __sys_sendmsg+0x12c/0x1d0 [ 29.320180][ T1261] ? do_syscall_64+0xff/0x530 [ 29.320182][ T1261] ? entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 29.320185][ T1261] ? rcu_is_watching+0x16/0xd0 [ 29.320187][ T1261] ? lock_acquire+0x13c/0x160 [ 29.320188][ T1261] ? rcu_is_watching+0x16/0xd0 [ 29.320189][ T1261] ? rcu_is_watching+0x16/0xd0 [ 29.320191][ T1261] ? trace_contention_end+0xb3/0x180 [ 29.320194][ T1261] ? __mutex_lock+0x1db/0x1ea0 [ 29.320196][ T1261] ? __mutex_lock+0x9a3/0x1ea0 [ 29.320197][ T1261] ? rtnl_newlink+0x9a8/0x11c0 [ 29.320199][ T1261] ? ww_mutex_lock+0x160/0x160 [ 29.320200][ T1261] ? nla_get_range_signed+0x3d0/0x3d0 [ 29.320202][ T1261] ? __rtnl_newlink+0x3fa/0xa50 [ 29.320204][ T1261] rtnl_newlink+0x9f1/0x11c0 [ 29.320206][ T1261] ? rcu_is_watching+0x16/0xd0 [ 29.320208][ T1261] ? rtnl_bridge_getlink+0x850/0x850 [ 29.320209][ T1261] ? lock_acquire+0x13c/0x160 [ 29.320210][ T1261] ? rcu_is_watching+0x16/0xd0 [ 29.320212][ T1261] ? is_bpf_text_address+0x3e/0x110 [ 29.320214][ T1261] ? is_bpf_text_address+0x72/0x110 [ 29.320216][ T1261] ? kernel_text_address+0x149/0x170 [ 29.320217][ T1261] ? __kernel_text_address+0x12/0x30 [ 29.320218][ T1261] ? write_profile+0xf0/0xf0 [ 29.320219][ T1261] ? unwind_get_return_address+0x67/0xd0 [ 29.320222][ T1261] ? rcu_is_watching+0x16/0xd0 [ 29.320224][ T1261] ? rcu_is_watching+0x16/0xd0 [ 29.320225][ T1261] ? cap_capable+0x1d7/0x3d0 [ 29.320229][ T1261] ? lock_acquire+0x13c/0x160 [ 29.320230][ T1261] ? rcu_is_watching+0x16/0xd0 [ 29.320232][ T1261] ? rtnl_bridge_getlink+0x850/0x850 [ 29.320233][ T1261] rtnetlink_rcv_msg+0x6fd/0xbd0 [ 29.320235][ T1261] ? rtnl_link_fill+0x920/0x920 [ 29.320236][ T1261] ? filter_irq_stacks+0xd0/0xd0 [ 29.320237][ T1261] ? stack_depot_save_flags+0x1bc/0x790 [ 29.320240][ T1261] netlink_rcv_skb+0x14e/0x3a0 [ 29.320241][ T1261] ? rtnl_link_fill+0x920/0x920 [ 29.320242][ T1261] ? lock_release+0x184/0x1f0 [ 29.320244][ T1261] ? netlink_ack+0xcf0/0xcf0 [ 29.320245][ T1261] ? __netlink_lookup+0xb9/0x6b0 [ 29.320247][ T1261] ? rcu_is_watching+0x16/0xd0 [ 29.320249][ T1261] ? lock_release+0x184/0x1f0 [ 29.320251][ T1261] netlink_unicast+0x486/0x750 [ 29.320253][ T1261] ? netlink_attachskb+0x810/0x810 [ 29.320254][ T1261] ? rcu_is_watching+0x16/0xd0 [ 29.320256][ T1261] ? rcu_is_watching+0x16/0xd0 [ 29.320258][ T1261] ? lock_acquire+0x13c/0x160 [ 29.320260][ T1261] netlink_sendmsg+0x735/0xc60 [ 29.320261][ T1261] ? netlink_unicast+0x750/0x750 [ 29.320263][ T1261] ? rcu_is_watching+0x16/0xd0 [ 29.320265][ T1261] ? lock_release+0x184/0x1f0 [ 29.320267][ T1261] ____sys_sendmsg+0x415/0x880 [ 29.320268][ T1261] ? copy_msghdr_from_user+0x279/0x420 [ 29.320270][ T1261] ? get_timestamp.constprop.0+0x390/0x390 [ 29.320271][ T1261] ? move_addr_to_kernel+0x40/0x40 [ 29.320273][ T1261] ? filter_irq_stacks+0xd0/0xd0 [ 29.320275][ T1261] ___sys_sendmsg+0x14e/0x1d0 [ 29.320277][ T1261] ? copy_msghdr_from_user+0x420/0x420 [ 29.320282][ T1261] __sys_sendmsg+0x12c/0x1d0 [ 29.320283][ T1261] ? __sys_sendmsg_sock+0x20/0x20 [ 29.320286][ T1261] ? rcu_is_watching+0x16/0xd0 [ 29.320288][ T1261] do_syscall_64+0xff/0x530 [ 29.320289][ T1261] ? exc_page_fault+0xee/0x100 [ 29.320292][ T1261] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 29.320293][ T1261] RIP: 0033:0x7f5b369a254e [ 29.320295][ T1261] 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 [ 29.320297][ T1261] RSP: 002b:00007fff705dc5e0 EFLAGS: 00000202 ORIG_RAX: 000000000000002e [ 29.320300][ T1261] RAX: ffffffffffffffda RBX: 0000000000000003 RCX: 00007f5b369a254e [ 29.320302][ T1261] RDX: 0000000000000000 RSI: 00007fff705dc690 RDI: 0000000000000005 [ 29.320303][ T1261] RBP: 00007fff705dc5f0 R08: 0000000000000000 R09: 0000000000000000 [ 29.320303][ T1261] R10: 0000000000000000 R11: 0000000000000202 R12: 000000006a910db1 [ 29.320304][ T1261] R13: 00000000004a1620 R14: 0000000000000000 R15: 00007fff705dcd50 [ 29.320306][ T1261] [ 29.358896][ T1261] br0: port 3(veth5) entered disabled state [ 29.359123][ T1261] veth5: entered allmulticast mode [ 29.360056][ T1261] veth5: entered promiscuous mode [ 29.434718][ T1273] br0: port 3(veth5) entered disabled state [ 29.458210][ T1274] br0: port 2(veth3) entered disabled state [ 29.484873][ T1275] br0: port 1(veth1) entered disabled state [ 29.505526][ T1276] veth5: left allmulticast mode [ 29.505733][ T1276] veth5: left promiscuous mode [ 29.505989][ T1276] br0: port 3(veth5) entered disabled state [ 29.507168][ T1276] veth3: left allmulticast mode [ 29.507357][ T1276] veth3: left promiscuous mode [ 29.507604][ T1276] br0: port 2(veth3) entered disabled state [ 29.508192][ T1276] veth1: left allmulticast mode [ 29.508367][ T1276] veth1: left promiscuous mode [ 29.508603][ T1276] br0: port 1(veth1) entered disabled state