[ 11.734005][ T268] br1: port 1(vx10) entered blocking state [ 11.734090][ T268] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 11.734092][ T268] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 268, name: ip [ 11.734094][ T268] preempt_count: 1, expected: 0 [ 11.734095][ T268] RCU nest depth: 0, expected: 0 [ 11.734096][ T268] locks held by ip/268: 5, last CPU#3: [ 11.734098][ T268] #0: ffffffffa4ad2c40 (rtnl_mutex){+.+.}-{4:4}, at: rtnl_newlink+0x9a8/0x11c0 [ 11.734110][ T268] #1: ffffffffa4369cc0 (console_lock){+.+.}-{0:0}, at: vprintk_emit+0x320/0x3e0 [ 11.734116][ T268] #2: ffffffffa4369d38 (console_srcu){....}-{0:0}, at: console_flush_one_record+0x106/0x710 [ 11.734120][ T268] #3: ffffffffa4289660 (console_owner){....}-{0:0}, at: console_lock_spinning_enable+0x40/0x60 [ 11.734124][ T268] #4: ffffffffa4289560 (printk_legacy_map-wait-type-override){....}-{3:3}, at: console_emit_next_record+0x1df/0x4c0 [ 11.734128][ T268] irq event stamp: 13652 [ 11.734128][ T268] hardirqs last enabled at (13651): [] __down_trylock_console_sem+0x86/0xa0 [ 11.734131][ T268] hardirqs last disabled at (13652): [] console_emit_next_record+0x3d4/0x4c0 [ 11.734133][ T268] softirqs last enabled at (13562): [] __alloc_skb+0x4c2/0x5f0 [ 11.734136][ T268] softirqs last disabled at (13560): [] __alloc_skb+0x4c2/0x5f0 [ 11.734138][ T268] Preemption disabled at: [ 11.734139][ T268] [] vprintk_emit+0x31b/0x3e0 [ 11.734145][ T268] CPU: 3 UID: 0 PID: 268 Comm: ip Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 11.734148][ T268] Tainted: [W]=WARN [ 11.734149][ T268] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 11.734151][ T268] Call Trace: [ 11.734153][ T268] [ 11.734154][ T268] dump_stack_lvl+0x6f/0xa0 [ 11.734160][ T268] ? vprintk_emit+0x31b/0x3e0 [ 11.734163][ T268] __might_resched.cold+0x1fe/0x2c1 [ 11.734167][ T268] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 11.734172][ T268] ? __kmalloc_noprof+0xdb/0x760 [ 11.734177][ T268] __kmalloc_noprof+0x443/0x760 [ 11.734179][ T268] ? alloc_buf.isra.0+0x4b/0x260 [ 11.734185][ T268] ? do_raw_spin_unlock+0x59/0x250 [ 11.734187][ T268] alloc_buf.isra.0+0x4b/0x260 [ 11.734191][ T268] put_chars+0x1e1/0x2f0 [ 11.734193][ T268] ? __send_to_port+0x420/0x420 [ 11.734198][ T268] ? validate_chain+0x34a/0xc20 [ 11.734201][ T268] hvc_console_print+0x292/0x780 [ 11.734204][ T268] ? mark_usage+0x61/0x170 [ 11.734206][ T268] ? __lock_acquire+0x518/0xc20 [ 11.734208][ T268] ? __lock_acquire+0x518/0xc20 [ 11.734212][ T268] ? hvc_write+0x3a0/0x3a0 [ 11.734214][ T268] ? console_emit_next_record+0x1df/0x4c0 [ 11.734217][ T268] ? rcu_is_watching+0x16/0xd0 [ 11.734221][ T268] ? lock_acquire+0x13c/0x160 [ 11.734225][ T268] console_emit_next_record+0x22f/0x4c0 [ 11.734229][ T268] ? devkmsg_read+0x4b0/0x4b0 [ 11.734230][ T268] ? console_flush_one_record+0x106/0x710 [ 11.734233][ T268] ? rcu_is_watching+0x16/0xd0 [ 11.734236][ T268] ? lock_acquire+0x13c/0x160 [ 11.734240][ T268] console_flush_one_record+0x46f/0x710 [ 11.734244][ T268] ? console_emit_next_record+0x4c0/0x4c0 [ 11.734246][ T268] ? __lock_acquire+0x518/0xc20 [ 11.734251][ T268] console_unlock+0xee/0x1f0 [ 11.734254][ T268] ? console_flush_one_record+0x710/0x710 [ 11.734258][ T268] ? rcu_is_watching+0x16/0xd0 [ 11.734261][ T268] ? lock_acquire+0x60/0x160 [ 11.734265][ T268] ? __down_trylock_console_sem+0x5e/0xa0 [ 11.734266][ T268] ? vprintk_emit+0x320/0x3e0 [ 11.734275][ T268] vprintk_emit+0x37c/0x3e0 [ 11.734279][ T268] ? wake_up_klogd_work_func+0x90/0x90 [ 11.734282][ T268] ? __lock_release.isra.0+0x69/0x1a0 [ 11.734283][ T268] ? _raw_spin_unlock_irqrestore+0x40/0x80 [ 11.734288][ T268] ? mark_held_locks+0x40/0x70 [ 11.734291][ T268] _printk+0xc7/0x100 [ 11.734294][ T268] ? snapshot_read.cold+0x21/0x21 [ 11.734299][ T268] ? br_multicast_flood+0xab0/0xab0 [bridge] [ 11.734312][ T268] ? do_setlink.isra.0+0xa31/0x2750 [ 11.734314][ T268] ? rtnl_newlink+0x9f1/0x11c0 [ 11.734315][ T268] ? rtnetlink_rcv_msg+0x6fd/0xbd0 [ 11.734319][ T268] br_set_state+0x22f/0x430 [bridge] [ 11.734329][ T268] br_init_port+0xc4/0x200 [bridge] [ 11.734337][ T268] new_nbp+0x39c/0x580 [bridge] [ 11.734346][ T268] br_add_if+0x212/0x1320 [bridge] [ 11.734353][ T268] ? is_bpf_text_address+0x72/0x110 [ 11.734357][ T268] ? kernel_text_address+0x149/0x170 [ 11.734360][ T268] ? __kernel_text_address+0x12/0x30 [ 11.734364][ T268] do_set_master+0x357/0x580 [ 11.734368][ T268] do_setlink.isra.0+0xa31/0x2750 [ 11.734372][ T268] ? stack_trace_save+0x93/0xc0 [ 11.734375][ T268] ? rtnl_link_get_size+0x350/0x350 [ 11.734376][ T268] ? rcu_read_lock_any_held+0x66/0x90 [ 11.734379][ T268] ? stack_depot_save_flags+0x38e/0x790 [ 11.734382][ T268] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 11.734385][ T268] ? rcu_read_lock_any_held+0x3c/0x90 [ 11.734387][ T268] ? validate_chain+0x38b/0xc20 [ 11.734389][ T268] ? kasan_save_stack+0x3d/0x50 [ 11.734392][ T268] ? kasan_save_stack+0x2f/0x50 [ 11.734394][ T268] ? kasan_save_track+0x14/0x30 [ 11.734397][ T268] ? __lock_acquire+0x518/0xc20 [ 11.734399][ T268] ? netlink_seq_next+0xe/0x60 [ 11.734402][ T268] ? ___sys_sendmsg+0xb0/0x1d0 [ 11.734406][ T268] ? lock_acquire.part.0+0xd4/0x280 [ 11.734408][ T268] ? rtnl_newlink+0x9a8/0x11c0 [ 11.734411][ T268] ? rcu_is_watching+0x16/0xd0 [ 11.734413][ T268] ? lock_acquire+0x13c/0x160 [ 11.734415][ T268] ? rcu_is_watching+0x16/0xd0 [ 11.734416][ T268] ? rcu_is_watching+0x16/0xd0 [ 11.734419][ T268] ? trace_contention_end+0xb3/0x180 [ 11.734422][ T268] ? __mutex_lock+0x1db/0x1ea0 [ 11.734424][ T268] ? __mutex_lock+0x9a3/0x1ea0 [ 11.734426][ T268] ? rtnl_newlink+0x9a8/0x11c0 [ 11.734430][ T268] ? ww_mutex_lock+0x160/0x160 [ 11.734431][ T268] ? nla_get_range_signed+0x3d0/0x3d0 [ 11.734436][ T268] ? __rtnl_newlink+0x3fa/0xa50 [ 11.734441][ T268] rtnl_newlink+0x9f1/0x11c0 [ 11.734447][ T268] ? rtnl_bridge_getlink+0x850/0x850 [ 11.734448][ T268] ? __lock_acquire+0x518/0xc20 [ 11.734453][ T268] ? lock_acquire.part.0+0xd4/0x280 [ 11.734455][ T268] ? find_held_lock+0x2b/0x80 [ 11.734457][ T268] ? rtnl_bridge_getlink+0x850/0x850 [ 11.734459][ T268] ? __lock_release.isra.0+0x69/0x1a0 [ 11.734462][ T268] ? rtnl_bridge_getlink+0x850/0x850 [ 11.734464][ T268] rtnetlink_rcv_msg+0x6fd/0xbd0 [ 11.734467][ T268] ? rtnl_link_fill+0x920/0x920 [ 11.734469][ T268] ? __lock_acquire+0x518/0xc20 [ 11.734473][ T268] ? lock_acquire.part.0+0xd4/0x280 [ 11.734475][ T268] ? find_held_lock+0x2b/0x80 [ 11.734478][ T268] netlink_rcv_skb+0x14e/0x3a0 [ 11.734480][ T268] ? rtnl_link_fill+0x920/0x920 [ 11.734483][ T268] ? netlink_ack+0xcf0/0xcf0 [ 11.734489][ T268] ? netlink_deliver_tap+0xc5/0x330 [ 11.734491][ T268] ? netlink_deliver_tap+0x13c/0x330 [ 11.734495][ T268] netlink_unicast+0x486/0x750 [ 11.734498][ T268] ? netlink_attachskb+0x810/0x810 [ 11.734501][ T268] ? __lock_acquire+0x518/0xc20 [ 11.734505][ T268] netlink_sendmsg+0x735/0xc60 [ 11.734509][ T268] ? netlink_unicast+0x750/0x750 [ 11.734513][ T268] ? __might_fault+0x97/0x140 [ 11.734518][ T268] ____sys_sendmsg+0x415/0x880 [ 11.734520][ T268] ? copy_msghdr_from_user+0x279/0x420 [ 11.734522][ T268] ? get_timestamp.constprop.0+0x390/0x390 [ 11.734524][ T268] ? move_addr_to_kernel+0x40/0x40 [ 11.734531][ T268] ___sys_sendmsg+0x14e/0x1d0 [ 11.734534][ T268] ? copy_msghdr_from_user+0x420/0x420 [ 11.734550][ T268] __sys_sendmsg+0x12c/0x1d0 [ 11.734553][ T268] ? __sys_sendmsg_sock+0x20/0x20 [ 11.734560][ T268] ? rcu_is_watching+0x16/0xd0 [ 11.734565][ T268] do_syscall_64+0xff/0x530 [ 11.734568][ T268] ? exc_page_fault+0xee/0x100 [ 11.734573][ T268] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 11.734575][ T268] RIP: 0033:0x7ff3c073c54e [ 11.734579][ T268] 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.734581][ T268] RSP: 002b:00007fff4777cc80 EFLAGS: 00000202 ORIG_RAX: 000000000000002e [ 11.734585][ T268] RAX: ffffffffffffffda RBX: 0000000000000004 RCX: 00007ff3c073c54e [ 11.734587][ T268] RDX: 0000000000000000 RSI: 00007fff4777cd30 RDI: 0000000000000005 [ 11.734588][ T268] RBP: 00007fff4777cc90 R08: 0000000000000000 R09: 0000000000000000 [ 11.734589][ T268] R10: 0000000000000000 R11: 0000000000000202 R12: 000000006a91ac34 [ 11.734590][ T268] R13: 00000000004a1620 R14: 0000000000000000 R15: 00007fff4777d3f0 [ 11.734601][ T268] [ 11.774717][ T268] br1: port 1(vx10) entered disabled state [ 11.775401][ T268] vx10: entered allmulticast mode [ 11.778416][ T268] vx10: entered promiscuous mode [ 11.779277][ T268] br1: port 1(vx10) entered blocking state [ 11.779863][ T268] br1: port 1(vx10) entered forwarding state [ 11.799284][ T268] ip (268) used greatest stack depth: 23336 bytes left [ 11.928206][ T273] br1: port 2(vx20) entered blocking state [ 11.928562][ T273] br1: port 2(vx20) entered disabled state [ 11.928875][ T273] vx20: entered allmulticast mode [ 11.931005][ T273] vx20: entered promiscuous mode [ 11.936990][ T273] br1: port 2(vx20) entered blocking state [ 11.937578][ T273] br1: port 2(vx20) entered forwarding state [ 12.007692][ T275] br1: port 3(veth1) entered blocking state [ 12.008236][ T275] br1: port 3(veth1) entered disabled state [ 12.008762][ T275] veth1: entered allmulticast mode [ 12.011353][ T275] veth1: entered promiscuous mode [ 12.049912][ T39] br1: port 3(veth1) entered blocking state [ 12.050813][ T39] br1: port 3(veth1) entered forwarding state [ 12.105683][ T278] br1: port 4(veth2) entered blocking state [ 12.106036][ T278] br1: port 4(veth2) entered disabled state [ 12.106911][ T278] veth2: entered allmulticast mode [ 12.108458][ T278] veth2: entered promiscuous mode [ 12.145533][ T39] br1: port 4(veth2) entered blocking state [ 12.145866][ T39] br1: port 4(veth2) entered forwarding state [ 12.379178][ T288] 8021q: 802.1Q VLAN Support v1.8 [ 12.528534][ T64] br1: entered promiscuous mode [ 14.462268][ T363] br1: port 1(vx10) entered blocking state [ 14.462294][ T363] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 14.462297][ T363] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 363, name: ip [ 14.462298][ T363] preempt_count: 1, expected: 0 [ 14.462299][ T363] RCU nest depth: 0, expected: 0 [ 14.462300][ T363] locks held by ip/363: 5, last CPU#2: [ 14.462303][ T363] #0: ffffffffa4ad2c40 (rtnl_mutex){+.+.}-{4:4}, at: rtnl_newlink+0x9a8/0x11c0 [ 14.462315][ T363] #1: ffffffffa4369cc0 (console_lock){+.+.}-{0:0}, at: vprintk_emit+0x320/0x3e0 [ 14.462321][ T363] #2: ffffffffa4369d38 (console_srcu){....}-{0:0}, at: console_flush_one_record+0x106/0x710 [ 14.462325][ T363] #3: ffffffffa4289660 (console_owner){....}-{0:0}, at: console_lock_spinning_enable+0x40/0x60 [ 14.462328][ T363] #4: ffffffffa4289560 (printk_legacy_map-wait-type-override){....}-{3:3}, at: console_emit_next_record+0x1df/0x4c0 [ 14.462332][ T363] irq event stamp: 13404 [ 14.462333][ T363] hardirqs last enabled at (13403): [] __down_trylock_console_sem+0x86/0xa0 [ 14.462336][ T363] hardirqs last disabled at (13404): [] console_emit_next_record+0x3d4/0x4c0 [ 14.462338][ T363] softirqs last enabled at (13398): [] handle_softirqs+0x67c/0x900 [ 14.462341][ T363] softirqs last disabled at (13393): [] __irq_exit_rcu+0x145/0x1c0 [ 14.462343][ T363] Preemption disabled at: [ 14.462344][ T363] [] vprintk_emit+0x31b/0x3e0 [ 14.462350][ T363] CPU: 2 UID: 0 PID: 363 Comm: ip Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 14.462353][ T363] Tainted: [W]=WARN [ 14.462354][ T363] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 14.462356][ T363] Call Trace: [ 14.462357][ T363] [ 14.462359][ T363] dump_stack_lvl+0x6f/0xa0 [ 14.462364][ T363] ? vprintk_emit+0x31b/0x3e0 [ 14.462367][ T363] __might_resched.cold+0x1fe/0x2c1 [ 14.462371][ T363] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 14.462376][ T363] ? __kmalloc_noprof+0xdb/0x760 [ 14.462381][ T363] __kmalloc_noprof+0x443/0x760 [ 14.462383][ T363] ? alloc_buf.isra.0+0x4b/0x260 [ 14.462388][ T363] ? do_raw_spin_unlock+0x59/0x250 [ 14.462391][ T363] alloc_buf.isra.0+0x4b/0x260 [ 14.462394][ T363] put_chars+0x1e1/0x2f0 [ 14.462396][ T363] ? prb_final_commit+0x50/0x50 [ 14.462398][ T363] ? __send_to_port+0x420/0x420 [ 14.462401][ T363] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 14.462405][ T363] ? rcu_read_lock_any_held+0x3c/0x90 [ 14.462408][ T363] ? validate_chain+0x38b/0xc20 [ 14.462411][ T363] hvc_console_print+0x292/0x780 [ 14.462414][ T363] ? mark_usage+0x61/0x170 [ 14.462416][ T363] ? __lock_acquire+0x518/0xc20 [ 14.462417][ T363] ? __lock_acquire+0x518/0xc20 [ 14.462421][ T363] ? hvc_write+0x3a0/0x3a0 [ 14.462423][ T363] ? console_emit_next_record+0x1df/0x4c0 [ 14.462426][ T363] ? rcu_is_watching+0x16/0xd0 [ 14.462429][ T363] ? lock_acquire+0x13c/0x160 [ 14.462433][ T363] console_emit_next_record+0x22f/0x4c0 [ 14.462437][ T363] ? devkmsg_read+0x4b0/0x4b0 [ 14.462438][ T363] ? console_flush_one_record+0x106/0x710 [ 14.462442][ T363] ? rcu_is_watching+0x16/0xd0 [ 14.462444][ T363] ? lock_acquire+0x13c/0x160 [ 14.462448][ T363] console_flush_one_record+0x46f/0x710 [ 14.462452][ T363] ? console_emit_next_record+0x4c0/0x4c0 [ 14.462454][ T363] ? __lock_acquire+0x518/0xc20 [ 14.462459][ T363] console_unlock+0xee/0x1f0 [ 14.462462][ T363] ? console_flush_one_record+0x710/0x710 [ 14.462463][ T363] ? rcu_is_watching+0x16/0xd0 [ 14.462466][ T363] ? lock_acquire+0x60/0x160 [ 14.462469][ T363] ? __down_trylock_console_sem+0x5e/0xa0 [ 14.462471][ T363] ? vprintk_emit+0x320/0x3e0 [ 14.462474][ T363] vprintk_emit+0x37c/0x3e0 [ 14.462478][ T363] ? wake_up_klogd_work_func+0x90/0x90 [ 14.462481][ T363] ? netif_get_link_ksettings+0x170/0x290 [ 14.462487][ T363] _printk+0xc7/0x100 [ 14.462490][ T363] ? snapshot_read.cold+0x21/0x21 [ 14.462494][ T363] ? br_multicast_flood+0xab0/0xab0 [bridge] [ 14.462507][ T363] ? do_setlink.isra.0+0xa31/0x2750 [ 14.462508][ T363] ? rtnl_newlink+0x9f1/0x11c0 [ 14.462509][ T363] ? rtnetlink_rcv_msg+0x6fd/0xbd0 [ 14.462514][ T363] br_set_state+0x22f/0x430 [bridge] [ 14.462524][ T363] br_init_port+0xc4/0x200 [bridge] [ 14.462533][ T363] new_nbp+0x39c/0x580 [bridge] [ 14.462541][ T363] br_add_if+0x212/0x1320 [bridge] [ 14.462548][ T363] ? is_bpf_text_address+0x72/0x110 [ 14.462552][ T363] ? kernel_text_address+0x149/0x170 [ 14.462555][ T363] ? __kernel_text_address+0x12/0x30 [ 14.462559][ T363] do_set_master+0x357/0x580 [ 14.462564][ T363] do_setlink.isra.0+0xa31/0x2750 [ 14.462567][ T363] ? stack_trace_save+0x93/0xc0 [ 14.462570][ T363] ? rtnl_link_get_size+0x350/0x350 [ 14.462571][ T363] ? rcu_read_lock_any_held+0x66/0x90 [ 14.462573][ T363] ? stack_depot_save_flags+0x38e/0x790 [ 14.462576][ T363] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 14.462579][ T363] ? rcu_read_lock_any_held+0x3c/0x90 [ 14.462581][ T363] ? validate_chain+0x38b/0xc20 [ 14.462583][ T363] ? kasan_save_stack+0x3d/0x50 [ 14.462586][ T363] ? kasan_save_stack+0x2f/0x50 [ 14.462588][ T363] ? kasan_save_track+0x14/0x30 [ 14.462590][ T363] ? __lock_acquire+0x518/0xc20 [ 14.462592][ T363] ? netlink_seq_next+0xe/0x60 [ 14.462595][ T363] ? ___sys_sendmsg+0xb0/0x1d0 [ 14.462599][ T363] ? lock_acquire.part.0+0xd4/0x280 [ 14.462601][ T363] ? rtnl_newlink+0x9a8/0x11c0 [ 14.462604][ T363] ? rcu_is_watching+0x16/0xd0 [ 14.462606][ T363] ? lock_acquire+0x13c/0x160 [ 14.462608][ T363] ? rcu_is_watching+0x16/0xd0 [ 14.462610][ T363] ? rcu_is_watching+0x16/0xd0 [ 14.462612][ T363] ? trace_contention_end+0xb3/0x180 [ 14.462616][ T363] ? __mutex_lock+0x1db/0x1ea0 [ 14.462618][ T363] ? __mutex_lock+0x9a3/0x1ea0 [ 14.462620][ T363] ? rtnl_newlink+0x9a8/0x11c0 [ 14.462624][ T363] ? ww_mutex_lock+0x160/0x160 [ 14.462625][ T363] ? nla_get_range_signed+0x3d0/0x3d0 [ 14.462630][ T363] ? __rtnl_newlink+0x3fa/0xa50 [ 14.462635][ T363] rtnl_newlink+0x9f1/0x11c0 [ 14.462641][ T363] ? rtnl_bridge_getlink+0x850/0x850 [ 14.462643][ T363] ? __lock_acquire+0x518/0xc20 [ 14.462647][ T363] ? lock_acquire.part.0+0xd4/0x280 [ 14.462649][ T363] ? find_held_lock+0x2b/0x80 [ 14.462651][ T363] ? rtnl_bridge_getlink+0x850/0x850 [ 14.462652][ T363] ? __lock_release.isra.0+0x69/0x1a0 [ 14.462656][ T363] ? rtnl_bridge_getlink+0x850/0x850 [ 14.462658][ T363] rtnetlink_rcv_msg+0x6fd/0xbd0 [ 14.462661][ T363] ? rtnl_link_fill+0x920/0x920 [ 14.462662][ T363] ? __lock_acquire+0x518/0xc20 [ 14.462667][ T363] ? lock_acquire.part.0+0xd4/0x280 [ 14.462669][ T363] ? find_held_lock+0x2b/0x80 [ 14.462672][ T363] netlink_rcv_skb+0x14e/0x3a0 [ 14.462674][ T363] ? rtnl_link_fill+0x920/0x920 [ 14.462676][ T363] ? netlink_ack+0xcf0/0xcf0 [ 14.462683][ T363] ? netlink_deliver_tap+0xc5/0x330 [ 14.462684][ T363] ? netlink_deliver_tap+0x13c/0x330 [ 14.462688][ T363] netlink_unicast+0x486/0x750 [ 14.462692][ T363] ? netlink_attachskb+0x810/0x810 [ 14.462695][ T363] ? __lock_acquire+0x518/0xc20 [ 14.462699][ T363] netlink_sendmsg+0x735/0xc60 [ 14.462702][ T363] ? netlink_unicast+0x750/0x750 [ 14.462706][ T363] ? __might_fault+0x97/0x140 [ 14.462711][ T363] ____sys_sendmsg+0x415/0x880 [ 14.462713][ T363] ? copy_msghdr_from_user+0x279/0x420 [ 14.462716][ T363] ? get_timestamp.constprop.0+0x390/0x390 [ 14.462717][ T363] ? move_addr_to_kernel+0x40/0x40 [ 14.462725][ T363] ___sys_sendmsg+0x14e/0x1d0 [ 14.462727][ T363] ? copy_msghdr_from_user+0x420/0x420 [ 14.462743][ T363] __sys_sendmsg+0x12c/0x1d0 [ 14.462746][ T363] ? __sys_sendmsg_sock+0x20/0x20 [ 14.462752][ T363] ? rcu_is_watching+0x16/0xd0 [ 14.462755][ T363] do_syscall_64+0xff/0x530 [ 14.462758][ T363] ? exc_page_fault+0xee/0x100 [ 14.462761][ T363] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 14.462763][ T363] RIP: 0033:0x7fd35007554e [ 14.462766][ T363] 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 [ 14.462768][ T363] RSP: 002b:00007ffc0ed41cd0 EFLAGS: 00000202 ORIG_RAX: 000000000000002e [ 14.462771][ T363] RAX: ffffffffffffffda RBX: 0000000000000004 RCX: 00007fd35007554e [ 14.462773][ T363] RDX: 0000000000000000 RSI: 00007ffc0ed41d80 RDI: 0000000000000005 [ 14.462774][ T363] RBP: 00007ffc0ed41ce0 R08: 0000000000000000 R09: 0000000000000000 [ 14.462774][ T363] R10: 0000000000000000 R11: 0000000000000202 R12: 000000006a91ac36 [ 14.462775][ T363] R13: 00000000004a1620 R14: 0000000000000000 R15: 00007ffc0ed42440 [ 14.462782][ T363] [ 14.510088][ T363] br1: port 1(vx10) entered disabled state [ 14.510543][ T363] vx10: entered allmulticast mode [ 14.512182][ T363] vx10: entered promiscuous mode [ 14.513334][ T363] br1: port 1(vx10) entered blocking state [ 14.513667][ T363] br1: port 1(vx10) entered forwarding state [ 14.633799][ T367] br1: port 2(vx20) entered blocking state [ 14.634186][ T367] br1: port 2(vx20) entered disabled state [ 14.634561][ T367] vx20: entered allmulticast mode [ 14.636206][ T367] vx20: entered promiscuous mode [ 14.636722][ T367] br1: port 2(vx20) entered blocking state [ 14.637058][ T367] br1: port 2(vx20) entered forwarding state [ 14.692594][ T369] br1: port 3(w1) entered blocking state [ 14.692859][ T369] br1: port 3(w1) entered disabled state [ 14.693118][ T369] w1: entered allmulticast mode [ 14.694665][ T369] w1: entered promiscuous mode [ 14.726872][ T60] br1: port 3(w1) entered blocking state [ 14.727186][ T60] br1: port 3(w1) entered forwarding state [ 14.792844][ T372] br1: port 4(w3) entered blocking state [ 14.793160][ T372] br1: port 4(w3) entered disabled state [ 14.794011][ T372] w3: entered allmulticast mode [ 14.795670][ T372] w3: entered promiscuous mode [ 14.839766][ T36] br1: port 4(w3) entered blocking state [ 14.840046][ T36] br1: port 4(w3) entered forwarding state [ 15.116957][ T64] br1: entered promiscuous mode [ 16.485787][ C0] br1: received packet on vx20 with own address as source address (addr:00:00:5e:00:01:01, vlan:20) [ 16.485823][ C0] [ 16.485824][ C0] ======================================================== [ 16.485825][ C0] WARNING: possible irq lock inversion dependency detected [ 16.485827][ C0] 7.2.0-virtme #1 Tainted: G W [ 16.485829][ C0] -------------------------------------------------------- [ 16.485829][ C0] ksoftirqd/0/14 just changed the state of lock: [ 16.485830][ C0] ffffffffa4289660 (console_owner){..-.}-{0:0}, at: console_lock_spinning_enable+0x40/0x60 [ 16.485842][ C0] but this lock took another, SOFTIRQ-unsafe lock in the past: [ 16.485844][ C0] (fs_reclaim){+.+.}-{0:0} [ 16.485845][ C0] [ 16.485845][ C0] [ 16.485845][ C0] and interrupts could create inverse lock ordering between them. [ 16.485845][ C0] [ 16.485846][ C0] [ 16.485846][ C0] other info that might help us debug this: [ 16.485847][ C0] Possible interrupt unsafe locking scenario: [ 16.485847][ C0] [ 16.485847][ C0] CPU0 CPU1 [ 16.485848][ C0] ---- ---- [ 16.485848][ C0] lock(fs_reclaim); [ 16.485849][ C0] local_irq_disable(); [ 16.485850][ C0] lock(console_owner); [ 16.485851][ C0] lock(fs_reclaim); [ 16.485852][ C0] [ 16.485852][ C0] lock(console_owner); [ 16.485853][ C0] [ 16.485853][ C0] *** DEADLOCK *** [ 16.485853][ C0] [ 16.485853][ C0] locks held by ksoftirqd/0/14: 3, last CPU#0: [ 16.485854][ C0] #0: ffffffffa4380b00 (rcu_read_lock){....}-{1:3}, at: netif_receive_skb_list_internal+0x2f8/0xe20 [ 16.485861][ C0] #1: ffffffffa4369cc0 (console_lock){+.+.}-{0:0}, at: vprintk_emit+0x320/0x3e0 [ 16.485864][ C0] #2: ffffffffa4369d38 (console_srcu){....}-{0:0}, at: console_flush_one_record+0x106/0x710 [ 16.485868][ C0] [ 16.485868][ C0] the shortest dependencies between 2nd lock and 1st lock: [ 16.485872][ C0] -> (fs_reclaim){+.+.}-{0:0} { [ 16.485874][ C0] HARDIRQ-ON-W at: [ 16.485875][ C0] __lock_acquire+0x388/0xc20 [ 16.485878][ C0] lock_acquire.part.0+0xd4/0x280 [ 16.485880][ C0] fs_reclaim_acquire+0xd5/0x120 [ 16.485883][ C0] __kmalloc_cache_noprof+0x6e/0x620 [ 16.485885][ C0] kthread_create_worker_on_node+0xea/0x210 [ 16.485888][ C0] workqueue_init+0x2a/0x680 [ 16.485892][ C0] kernel_init_freeable+0x2fe/0x630 [ 16.485894][ C0] kernel_init+0x21/0x150 [ 16.485897][ C0] ret_from_fork+0x474/0x6b0 [ 16.485900][ C0] ret_from_fork_asm+0x11/0x20 [ 16.485903][ C0] SOFTIRQ-ON-W at: [ 16.485904][ C0] __lock_acquire+0x388/0xc20 [ 16.485906][ C0] lock_acquire.part.0+0xd4/0x280 [ 16.485907][ C0] fs_reclaim_acquire+0xd5/0x120 [ 16.485908][ C0] __kmalloc_cache_noprof+0x6e/0x620 [ 16.485909][ C0] kthread_create_worker_on_node+0xea/0x210 [ 16.485911][ C0] workqueue_init+0x2a/0x680 [ 16.485912][ C0] kernel_init_freeable+0x2fe/0x630 [ 16.485913][ C0] kernel_init+0x21/0x150 [ 16.485915][ C0] ret_from_fork+0x474/0x6b0 [ 16.485916][ C0] ret_from_fork_asm+0x11/0x20 [ 16.485917][ C0] INITIAL USE at: [ 16.485918][ C0] __lock_acquire+0x388/0xc20 [ 16.485919][ C0] lock_acquire.part.0+0xd4/0x280 [ 16.485921][ C0] fs_reclaim_acquire+0xd5/0x120 [ 16.485922][ C0] __kmalloc_cache_noprof+0x6e/0x620 [ 16.485923][ C0] kthread_create_worker_on_node+0xea/0x210 [ 16.485925][ C0] workqueue_init+0x2a/0x680 [ 16.485926][ C0] kernel_init_freeable+0x2fe/0x630 [ 16.485927][ C0] kernel_init+0x21/0x150 [ 16.485929][ C0] ret_from_fork+0x474/0x6b0 [ 16.485930][ C0] ret_from_fork_asm+0x11/0x20 [ 16.485932][ C0] } [ 16.485932][ C0] ... key at: [] __fs_reclaim_map+0x0/0xbe0 [ 16.485936][ C0] ... acquired at: [ 16.485937][ C0] __lock_acquire+0x518/0xc20 [ 16.485939][ C0] lock_acquire.part.0+0xd4/0x280 [ 16.485940][ C0] fs_reclaim_acquire+0xd5/0x120 [ 16.485941][ C0] __kmalloc_noprof+0xd3/0x760 [ 16.485942][ C0] alloc_buf.isra.0+0x4b/0x260 [ 16.485946][ C0] put_chars+0x1e1/0x2f0 [ 16.485947][ C0] hvc_console_print+0x292/0x780 [ 16.485949][ C0] console_emit_next_record+0x22f/0x4c0 [ 16.485951][ C0] console_flush_one_record+0x46f/0x710 [ 16.485952][ C0] console_unlock+0xee/0x1f0 [ 16.485954][ C0] vprintk_emit+0x37c/0x3e0 [ 16.485955][ C0] dev_vprintk_emit+0x27f/0x2c0 [ 16.485959][ C0] dev_printk_emit+0xb9/0xee [ 16.485960][ C0] _dev_info+0xe2/0x116 [ 16.485962][ C0] __devm_rtc_register_device.cold+0xc3/0x3a8 [ 16.485965][ C0] cmos_do_probe+0x73b/0x98a [ 16.485966][ C0] platform_probe+0xfe/0x1f0 [ 16.485970][ C0] call_driver_probe+0x61/0x1c0 [ 16.485972][ C0] really_probe+0x199/0x760 [ 16.485973][ C0] __driver_probe_device+0x24f/0x440 [ 16.485975][ C0] driver_probe_device+0x4a/0xf0 [ 16.485976][ C0] __driver_attach+0x1b8/0x540 [ 16.485977][ C0] bus_for_each_dev+0x130/0x1e0 [ 16.485979][ C0] bus_add_driver+0x2c8/0x530 [ 16.485980][ C0] driver_register+0x1a3/0x390 [ 16.485982][ C0] __platform_driver_probe+0x13f/0x270 [ 16.485983][ C0] cmos_init+0x31/0x40 [ 16.485986][ C0] do_one_initcall+0x124/0x4f0 [ 16.485988][ C0] kernel_init_freeable+0x596/0x630 [ 16.485989][ C0] kernel_init+0x21/0x150 [ 16.485990][ C0] ret_from_fork+0x474/0x6b0 [ 16.485991][ C0] ret_from_fork_asm+0x11/0x20 [ 16.485993][ C0] [ 16.485993][ C0] -> (console_owner){..-.}-{0:0} { [ 16.485995][ C0] IN-SOFTIRQ-W at: [ 16.485996][ C0] __lock_acquire+0x388/0xc20 [ 16.485997][ C0] lock_acquire.part.0+0xd4/0x280 [ 16.485998][ C0] console_lock_spinning_enable+0x5c/0x60 [ 16.486000][ C0] console_emit_next_record+0x1d1/0x4c0 [ 16.486002][ C0] console_flush_one_record+0x46f/0x710 [ 16.486003][ C0] console_unlock+0xee/0x1f0 [ 16.486005][ C0] vprintk_emit+0x37c/0x3e0 [ 16.486006][ C0] _printk+0xc7/0x100 [ 16.486009][ C0] br_fdb_update.cold+0x74/0x90 [bridge] [ 16.486020][ C0] br_handle_frame_finish+0x801/0x1d20 [bridge] [ 16.486031][ C0] br_handle_frame+0x74d/0xf50 [bridge] [ 16.486037][ C0] __netif_receive_skb_core.constprop.0+0x536/0x2bb0 [ 16.486039][ C0] __netif_receive_skb_list_core+0x2fc/0x9e0 [ 16.486041][ C0] netif_receive_skb_list_internal+0x5f8/0xe20 [ 16.486043][ C0] gro_receive_skb+0x52f/0xbb0 [ 16.486045][ C0] gro_cell_poll+0x275/0x550 [ 16.486048][ C0] __napi_poll+0xd4/0x3b0 [ 16.486050][ C0] net_rx_action+0x513/0xf50 [ 16.486051][ C0] handle_softirqs+0x1d3/0x900 [ 16.486054][ C0] run_ksoftirqd+0x39/0x60 [ 16.486055][ C0] smpboot_thread_fn+0x2fb/0x9b0 [ 16.486057][ C0] kthread+0x367/0x460 [ 16.486058][ C0] ret_from_fork+0x474/0x6b0 [ 16.486060][ C0] ret_from_fork_asm+0x11/0x20 [ 16.486061][ C0] INITIAL USE at: [ 16.486062][ C0] } [ 16.486062][ C0] ... key at: [] console_owner_dep_map+0x0/0x60 [ 16.486066][ C0] ... acquired at: [ 16.486066][ C0] mark_lock+0x1d7/0xa00 [ 16.486067][ C0] mark_usage+0x42/0x170 [ 16.486069][ C0] __lock_acquire+0x388/0xc20 [ 16.486070][ C0] lock_acquire.part.0+0xd4/0x280 [ 16.486071][ C0] console_lock_spinning_enable+0x5c/0x60 [ 16.486073][ C0] console_emit_next_record+0x1d1/0x4c0 [ 16.486075][ C0] console_flush_one_record+0x46f/0x710 [ 16.486076][ C0] console_unlock+0xee/0x1f0 [ 16.486078][ C0] vprintk_emit+0x37c/0x3e0 [ 16.486079][ C0] _printk+0xc7/0x100 [ 16.486081][ C0] br_fdb_update.cold+0x74/0x90 [bridge] [ 16.486088][ C0] br_handle_frame_finish+0x801/0x1d20 [bridge] [ 16.486094][ C0] br_handle_frame+0x74d/0xf50 [bridge] [ 16.486100][ C0] __netif_receive_skb_core.constprop.0+0x536/0x2bb0 [ 16.486102][ C0] __netif_receive_skb_list_core+0x2fc/0x9e0 [ 16.486103][ C0] netif_receive_skb_list_internal+0x5f8/0xe20 [ 16.486105][ C0] gro_receive_skb+0x52f/0xbb0 [ 16.486106][ C0] gro_cell_poll+0x275/0x550 [ 16.486108][ C0] __napi_poll+0xd4/0x3b0 [ 16.486109][ C0] net_rx_action+0x513/0xf50 [ 16.486111][ C0] handle_softirqs+0x1d3/0x900 [ 16.486112][ C0] run_ksoftirqd+0x39/0x60 [ 16.486113][ C0] smpboot_thread_fn+0x2fb/0x9b0 [ 16.486115][ C0] kthread+0x367/0x460 [ 16.486116][ C0] ret_from_fork+0x474/0x6b0 [ 16.486117][ C0] ret_from_fork_asm+0x11/0x20 [ 16.486118][ C0] [ 16.486119][ C0] [ 16.486119][ C0] stack backtrace: [ 16.486122][ C0] CPU: 0 UID: 0 PID: 14 Comm: ksoftirqd/0 Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 16.486125][ C0] Tainted: [W]=WARN [ 16.486126][ C0] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 16.486127][ C0] Call Trace: [ 16.486129][ C0] [ 16.486130][ C0] dump_stack_lvl+0x6f/0xa0 [ 16.486134][ C0] print_irq_inversion_bug.part.0.cold+0xe6/0x143 [ 16.486136][ C0] mark_lock_irq+0x989/0x9c0 [ 16.486139][ C0] mark_lock+0x1d7/0xa00 [ 16.486141][ C0] mark_usage+0x42/0x170 [ 16.486143][ C0] __lock_acquire+0x388/0xc20 [ 16.486145][ C0] lock_acquire.part.0+0xd4/0x280 [ 16.486147][ C0] ? console_lock_spinning_enable+0x40/0x60 [ 16.486149][ C0] ? rcu_is_watching+0x16/0xd0 [ 16.486152][ C0] ? lock_acquire+0x13c/0x160 [ 16.486154][ C0] console_lock_spinning_enable+0x5c/0x60 [ 16.486156][ C0] ? console_lock_spinning_enable+0x40/0x60 [ 16.486158][ C0] console_emit_next_record+0x1d1/0x4c0 [ 16.486160][ C0] ? devkmsg_read+0x4b0/0x4b0 [ 16.486161][ C0] ? console_flush_one_record+0x106/0x710 [ 16.486163][ C0] ? rcu_is_watching+0x16/0xd0 [ 16.486165][ C0] ? lock_acquire+0x13c/0x160 [ 16.486167][ C0] console_flush_one_record+0x46f/0x710 [ 16.486169][ C0] ? console_emit_next_record+0x4c0/0x4c0 [ 16.486171][ C0] ? __lock_acquire+0x518/0xc20 [ 16.486173][ C0] console_unlock+0xee/0x1f0 [ 16.486175][ C0] ? console_flush_one_record+0x710/0x710 [ 16.486177][ C0] ? rcu_is_watching+0x16/0xd0 [ 16.486178][ C0] ? lock_acquire+0x60/0x160 [ 16.486180][ C0] ? __down_trylock_console_sem+0x5e/0xa0 [ 16.486182][ C0] ? vprintk_emit+0x320/0x3e0 [ 16.486184][ C0] vprintk_emit+0x37c/0x3e0 [ 16.486187][ C0] ? wake_up_klogd_work_func+0x90/0x90 [ 16.486189][ C0] ? __lock_release.isra.0+0x69/0x1a0 [ 16.486191][ C0] _printk+0xc7/0x100 [ 16.486192][ C0] ? snapshot_read.cold+0x21/0x21 [ 16.486194][ C0] ? ___ratelimit+0x4e7/0xa00 [ 16.486197][ C0] ? fdb_notify.isra.0+0x120/0x120 [bridge] [ 16.486204][ C0] ? idr_get_free+0x830/0x830 [ 16.486207][ C0] br_fdb_update.cold+0x74/0x90 [bridge] [ 16.486214][ C0] ? br_fdb_add_local+0x60/0x60 [bridge] [ 16.486220][ C0] ? __allowed_ingress+0x58c/0xcc0 [bridge] [ 16.486229][ C0] ? br_allowed_ingress+0x6c/0x150 [bridge] [ 16.486235][ C0] br_handle_frame_finish+0x801/0x1d20 [bridge] [ 16.486242][ C0] ? br_handle_local_finish+0x20/0x20 [bridge] [ 16.486249][ C0] ? rcu_read_lock_any_held+0x3c/0x90 [ 16.486251][ C0] ? stack_depot_save_flags+0x38e/0x790 [ 16.486256][ C0] ? validate_chain+0x38b/0xc20 [ 16.486259][ C0] br_handle_frame+0x74d/0xf50 [bridge] [ 16.486265][ C0] ? br_handle_frame_finish+0x1d20/0x1d20 [bridge] [ 16.486271][ C0] __netif_receive_skb_core.constprop.0+0x536/0x2bb0 [ 16.486274][ C0] ? kthread+0x330/0x460 [ 16.486275][ C0] ? ret_from_fork+0x474/0x6b0 [ 16.486276][ C0] ? ret_from_fork_asm+0x11/0x20 [ 16.486279][ C0] ? do_xdp_generic+0x4a0/0x4a0 [ 16.486282][ C0] ? rcu_is_watching+0x16/0xd0 [ 16.486284][ C0] ? lockdep_hardirqs_on_prepare.part.0+0x9a/0x160 [ 16.486285][ C0] ? lockdep_hardirqs_on+0x91/0x130 [ 16.486287][ C0] ? kasan_quarantine_put+0x13e/0x2b0 [ 16.486290][ C0] ? kmem_cache_free+0xf8/0x550 [ 16.486296][ C0] __netif_receive_skb_list_core+0x2fc/0x9e0 [ 16.486299][ C0] ? __netif_receive_skb_core.constprop.0+0x2bb0/0x2bb0 [ 16.486301][ C0] ? lock_acquire.part.0+0xd4/0x280 [ 16.486303][ C0] ? netif_receive_skb_list_internal+0x2f8/0xe20 [ 16.486305][ C0] ? lock_acquire+0x13c/0x160 [ 16.486307][ C0] netif_receive_skb_list_internal+0x5f8/0xe20 [ 16.486309][ C0] ? find_held_lock+0x2b/0x80 [ 16.486311][ C0] ? process_backlog+0x14c0/0x14c0 [ 16.486313][ C0] ? __lock_release.isra.0+0x69/0x1a0 [ 16.486314][ C0] ? validate_chain+0x731/0xc20 [ 16.486316][ C0] ? dev_gro_receive+0x8a5/0x1740 [ 16.486317][ C0] ? dev_gro_receive+0x1f8/0x1740 [ 16.486319][ C0] gro_receive_skb+0x52f/0xbb0 [ 16.486321][ C0] gro_cell_poll+0x275/0x550 [ 16.486323][ C0] __napi_poll+0xd4/0x3b0 [ 16.486326][ C0] net_rx_action+0x513/0xf50 [ 16.486328][ C0] ? __napi_poll+0x3b0/0x3b0 [ 16.486331][ C0] ? rcu_is_watching+0x16/0xd0 [ 16.486334][ C0] ? rcu_is_watching+0x16/0xd0 [ 16.486336][ C0] handle_softirqs+0x1d3/0x900 [ 16.486338][ C0] ? _local_bh_enable+0xc0/0xc0 [ 16.486339][ C0] ? rcu_is_watching+0x16/0xd0 [ 16.486341][ C0] run_ksoftirqd+0x39/0x60 [ 16.486343][ C0] smpboot_thread_fn+0x2fb/0x9b0 [ 16.486345][ C0] ? sort_range+0x20/0x20 [ 16.486346][ C0] kthread+0x367/0x460 [ 16.486348][ C0] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 16.486350][ C0] ? kthread_affine_preferred+0x4c0/0x4c0 [ 16.486352][ C0] ret_from_fork+0x474/0x6b0 [ 16.486354][ C0] ? arch_exit_to_user_mode_prepare.isra.0+0x120/0x120 [ 16.486355][ C0] ? __switch_to+0x5a3/0xe00 [ 16.486358][ C0] ? kthread_affine_preferred+0x4c0/0x4c0 [ 16.486360][ C0] ret_from_fork_asm+0x11/0x20 [ 16.486363][ C0] [ 16.486367][ C0] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 16.486368][ C0] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 14, name: ksoftirqd/0 [ 16.486369][ C0] preempt_count: 101, expected: 0 [ 16.486370][ C0] RCU nest depth: 1, expected: 0 [ 16.486371][ C0] INFO: lockdep is turned off. [ 16.486372][ C0] irq event stamp: 1317793 [ 16.486372][ C0] hardirqs last enabled at (1317792): [] __down_trylock_console_sem+0x86/0xa0 [ 16.486375][ C0] hardirqs last disabled at (1317793): [] console_emit_next_record+0x3d4/0x4c0 [ 16.486377][ C0] softirqs last enabled at (1314430): [] handle_softirqs+0x67c/0x900 [ 16.486378][ C0] softirqs last disabled at (1314435): [] run_ksoftirqd+0x39/0x60 [ 16.486380][ C0] Preemption disabled at: [ 16.486381][ C0] [] handle_softirqs+0xf6/0x900 [ 16.486383][ C0] CPU: 0 UID: 0 PID: 14 Comm: ksoftirqd/0 Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 16.486385][ C0] Tainted: [W]=WARN [ 16.486386][ C0] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 16.486386][ C0] Call Trace: [ 16.486387][ C0] [ 16.486387][ C0] dump_stack_lvl+0x6f/0xa0 [ 16.486390][ C0] ? handle_softirqs+0xf6/0x900 [ 16.486391][ C0] __might_resched.cold+0x1fe/0x2c1 [ 16.486394][ C0] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 16.486397][ C0] ? rcu_is_watching+0x16/0xd0 [ 16.486399][ C0] __kmalloc_noprof+0x443/0x760 [ 16.486401][ C0] ? __rwlock_init+0x150/0x150 [ 16.486402][ C0] ? alloc_buf.isra.0+0x4b/0x260 [ 16.486404][ C0] ? do_raw_spin_unlock+0x59/0x250 [ 16.486406][ C0] alloc_buf.isra.0+0x4b/0x260 [ 16.486408][ C0] put_chars+0x1e1/0x2f0 [ 16.486409][ C0] ? __send_to_port+0x420/0x420 [ 16.486411][ C0] ? mark_lock+0x1d7/0xa00 [ 16.486413][ C0] hvc_console_print+0x292/0x780 [ 16.486416][ C0] ? hvc_write+0x3a0/0x3a0 [ 16.486417][ C0] ? rcu_is_watching+0x16/0xd0 [ 16.486419][ C0] ? rcu_is_watching+0x16/0xd0 [ 16.486420][ C0] ? lock_acquire+0x13c/0x160 [ 16.486422][ C0] console_emit_next_record+0x22f/0x4c0 [ 16.486424][ C0] ? devkmsg_read+0x4b0/0x4b0 [ 16.486426][ C0] ? console_flush_one_record+0x106/0x710 [ 16.486428][ C0] ? rcu_is_watching+0x16/0xd0 [ 16.486430][ C0] ? lock_acquire+0x13c/0x160 [ 16.486432][ C0] console_flush_one_record+0x46f/0x710 [ 16.486434][ C0] ? console_emit_next_record+0x4c0/0x4c0 [ 16.486436][ C0] ? __lock_acquire+0x518/0xc20 [ 16.486438][ C0] console_unlock+0xee/0x1f0 [ 16.486440][ C0] ? console_flush_one_record+0x710/0x710 [ 16.486442][ C0] ? rcu_is_watching+0x16/0xd0 [ 16.486443][ C0] ? lock_acquire+0x60/0x160 [ 16.486445][ C0] ? __down_trylock_console_sem+0x5e/0xa0 [ 16.486447][ C0] ? vprintk_emit+0x320/0x3e0 [ 16.486449][ C0] vprintk_emit+0x37c/0x3e0 [ 16.486451][ C0] ? wake_up_klogd_work_func+0x90/0x90 [ 16.486453][ C0] ? __lock_release.isra.0+0x69/0x1a0 [ 16.486455][ C0] _printk+0xc7/0x100 [ 16.486457][ C0] ? snapshot_read.cold+0x21/0x21 [ 16.486458][ C0] ? ___ratelimit+0x4e7/0xa00 [ 16.486460][ C0] ? fdb_notify.isra.0+0x120/0x120 [bridge] [ 16.486467][ C0] ? idr_get_free+0x830/0x830 [ 16.486469][ C0] br_fdb_update.cold+0x74/0x90 [bridge] [ 16.486476][ C0] ? br_fdb_add_local+0x60/0x60 [bridge] [ 16.486483][ C0] ? __allowed_ingress+0x58c/0xcc0 [bridge] [ 16.486489][ C0] ? br_allowed_ingress+0x6c/0x150 [bridge] [ 16.486495][ C0] br_handle_frame_finish+0x801/0x1d20 [bridge] [ 16.486502][ C0] ? br_handle_local_finish+0x20/0x20 [bridge] [ 16.486509][ C0] ? rcu_read_lock_any_held+0x3c/0x90 [ 16.486510][ C0] ? stack_depot_save_flags+0x38e/0x790 [ 16.486512][ C0] ? validate_chain+0x38b/0xc20 [ 16.486514][ C0] br_handle_frame+0x74d/0xf50 [bridge] [ 16.486520][ C0] ? br_handle_frame_finish+0x1d20/0x1d20 [bridge] [ 16.486526][ C0] __netif_receive_skb_core.constprop.0+0x536/0x2bb0 [ 16.486528][ C0] ? kthread+0x330/0x460 [ 16.486530][ C0] ? ret_from_fork+0x474/0x6b0 [ 16.486531][ C0] ? ret_from_fork_asm+0x11/0x20 [ 16.486533][ C0] ? do_xdp_generic+0x4a0/0x4a0 [ 16.486536][ C0] ? rcu_is_watching+0x16/0xd0 [ 16.486538][ C0] ? lockdep_hardirqs_on_prepare.part.0+0x9a/0x160 [ 16.486540][ C0] ? lockdep_hardirqs_on+0x91/0x130 [ 16.486541][ C0] ? kasan_quarantine_put+0x13e/0x2b0 [ 16.486543][ C0] ? kmem_cache_free+0xf8/0x550 [ 16.486545][ C0] __netif_receive_skb_list_core+0x2fc/0x9e0 [ 16.486547][ C0] ? __netif_receive_skb_core.constprop.0+0x2bb0/0x2bb0 [ 16.486549][ C0] ? lock_acquire.part.0+0xd4/0x280 [ 16.486551][ C0] ? netif_receive_skb_list_internal+0x2f8/0xe20 [ 16.486553][ C0] ? lock_acquire+0x13c/0x160 [ 16.486555][ C0] netif_receive_skb_list_internal+0x5f8/0xe20 [ 16.486557][ C0] ? find_held_lock+0x2b/0x80 [ 16.486558][ C0] ? process_backlog+0x14c0/0x14c0 [ 16.486560][ C0] ? __lock_release.isra.0+0x69/0x1a0 [ 16.486561][ C0] ? validate_chain+0x731/0xc20 [ 16.486563][ C0] ? dev_gro_receive+0x8a5/0x1740 [ 16.486564][ C0] ? dev_gro_receive+0x1f8/0x1740 [ 16.486566][ C0] gro_receive_skb+0x52f/0xbb0 [ 16.486568][ C0] gro_cell_poll+0x275/0x550 [ 16.486571][ C0] __napi_poll+0xd4/0x3b0 [ 16.486573][ C0] net_rx_action+0x513/0xf50 [ 16.486575][ C0] ? __napi_poll+0x3b0/0x3b0 [ 16.486578][ C0] ? rcu_is_watching+0x16/0xd0 [ 16.486581][ C0] ? rcu_is_watching+0x16/0xd0 [ 16.486583][ C0] handle_softirqs+0x1d3/0x900 [ 16.486585][ C0] ? _local_bh_enable+0xc0/0xc0 [ 16.486586][ C0] ? rcu_is_watching+0x16/0xd0 [ 16.486588][ C0] run_ksoftirqd+0x39/0x60 [ 16.486590][ C0] smpboot_thread_fn+0x2fb/0x9b0 [ 16.486592][ C0] ? sort_range+0x20/0x20 [ 16.486593][ C0] kthread+0x367/0x460 [ 16.486595][ C0] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 16.486596][ C0] ? kthread_affine_preferred+0x4c0/0x4c0 [ 16.486598][ C0] ret_from_fork+0x474/0x6b0 [ 16.486599][ C0] ? arch_exit_to_user_mode_prepare.isra.0+0x120/0x120 [ 16.486601][ C0] ? __switch_to+0x5a3/0xe00 [ 16.486603][ C0] ? kthread_affine_preferred+0x4c0/0x4c0 [ 16.486604][ C0] ret_from_fork_asm+0x11/0x20 [ 16.486607][ C0] [ 16.541489][ C0] br1: received packet on vx20 with own address as source address (addr:00:00:5e:00:01:01, vlan:20) [ 16.541884][ C0] br1: received packet on vx20 with own address as source address (addr:00:00:5e:00:01:01, vlan:20) [ 16.542149][ C0] br1: received packet on vx20 with own address as source address (addr:00:00:5e:00:01:01, vlan:20) [ 16.542409][ C0] br1: received packet on vx20 with own address as source address (addr:00:00:5e:00:01:01, vlan:20) [ 16.542665][ C0] br1: received packet on vx20 with own address as source address (addr:00:00:5e:00:01:01, vlan:20) [ 16.543012][ C0] br1: received packet on vx10 with own address as source address (addr:00:00:5e:00:01:01, vlan:10) [ 16.543298][ C0] br1: received packet on vx10 with own address as source address (addr:00:00:5e:00:01:01, vlan:10) [ 16.543591][ C0] br1: received packet on vx10 with own address as source address (addr:00:00:5e:00:01:01, vlan:10) [ 16.543843][ C0] br1: received packet on vx10 with own address as source address (addr:00:00:5e:00:01:01, vlan:10) [ 32.518123][ T12] w3: left allmulticast mode [ 32.518139][ T12] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 32.518141][ T12] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 12, name: kworker/u16:0 [ 32.518143][ T12] preempt_count: 1, expected: 0 [ 32.518144][ T12] RCU nest depth: 0, expected: 0 [ 32.518145][ T12] INFO: lockdep is turned off. [ 32.518146][ T12] irq event stamp: 33252 [ 32.518147][ T12] hardirqs last enabled at (33251): [] _raw_spin_unlock_irq+0x28/0x50 [ 32.518156][ T12] hardirqs last disabled at (33252): [] __schedule+0x1246/0x20e0 [ 32.518158][ T12] softirqs last enabled at (33248): [] __fib6_clean_all+0xff/0x290 [ 32.518162][ T12] softirqs last disabled at (33242): [] __fib6_clean_all+0xd9/0x290 [ 32.518164][ T12] Preemption disabled at: [ 32.518165][ T12] [] vprintk_emit+0x31b/0x3e0 [ 32.518173][ T12] CPU: 2 UID: 0 PID: 12 Comm: kworker/u16:0 Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 32.518177][ T12] Tainted: [W]=WARN [ 32.518178][ T12] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 32.518180][ T12] Workqueue: netns cleanup_net [ 32.518186][ T12] Call Trace: [ 32.518187][ T12] [ 32.518189][ T12] dump_stack_lvl+0x6f/0xa0 [ 32.518194][ T12] ? vprintk_emit+0x31b/0x3e0 [ 32.518196][ T12] __might_resched.cold+0x1fe/0x2c1 [ 32.518200][ T12] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 32.518203][ T12] ? rcu_is_watching+0x16/0xd0 [ 32.518207][ T12] __kmalloc_noprof+0x443/0x760 [ 32.518211][ T12] ? __rwlock_init+0x150/0x150 [ 32.518214][ T12] ? alloc_buf.isra.0+0x4b/0x260 [ 32.518217][ T12] ? do_raw_spin_unlock+0x59/0x250 [ 32.518219][ T12] alloc_buf.isra.0+0x4b/0x260 [ 32.518221][ T12] put_chars+0x1e1/0x2f0 [ 32.518222][ T12] ? desc_read_finalized_seq+0x79/0x120 [ 32.518224][ T12] ? __send_to_port+0x420/0x420 [ 32.518226][ T12] ? console_prepend_replay+0x20/0x20 [ 32.518229][ T12] hvc_console_print+0x292/0x780 [ 32.518232][ T12] ? hvc_write+0x3a0/0x3a0 [ 32.518234][ T12] ? do_raw_spin_lock+0x131/0x280 [ 32.518235][ T12] ? __rwlock_init+0x150/0x150 [ 32.518237][ T12] ? rcu_is_watching+0x16/0xd0 [ 32.518239][ T12] ? rcu_is_watching+0x16/0xd0 [ 32.518240][ T12] ? lock_acquire+0x13c/0x160 [ 32.518243][ T12] console_emit_next_record+0x22f/0x4c0 [ 32.518245][ T12] ? devkmsg_read+0x4b0/0x4b0 [ 32.518247][ T12] ? rcu_is_watching+0x16/0xd0 [ 32.518249][ T12] ? rcu_is_watching+0x16/0xd0 [ 32.518250][ T12] ? rcu_is_watching+0x16/0xd0 [ 32.518252][ T12] ? lock_acquire+0x13c/0x160 [ 32.518254][ T12] ? console_flush_one_record+0x111/0x710 [ 32.518258][ T12] console_flush_one_record+0x46f/0x710 [ 32.518260][ T12] ? console_emit_next_record+0x4c0/0x4c0 [ 32.518263][ T12] console_unlock+0xee/0x1f0 [ 32.518265][ T12] ? lock_acquire+0x13c/0x160 [ 32.518266][ T12] ? console_flush_one_record+0x710/0x710 [ 32.518268][ T12] ? rcu_is_watching+0x16/0xd0 [ 32.518270][ T12] ? lock_release+0x184/0x1f0 [ 32.518271][ T12] ? lock_acquire+0x60/0x160 [ 32.518273][ T12] ? __rcu_read_lock+0x30/0x70 [ 32.518275][ T12] ? __down_trylock_console_sem+0x5e/0xa0 [ 32.518277][ T12] ? vprintk_emit+0x320/0x3e0 [ 32.518279][ T12] vprintk_emit+0x37c/0x3e0 [ 32.518281][ T12] ? wake_up_klogd_work_func+0x90/0x90 [ 32.518283][ T12] ? process_one_work+0xe3e/0x1560 [ 32.518286][ T12] ? kthread+0x367/0x460 [ 32.518288][ T12] ? ret_from_fork+0x474/0x6b0 [ 32.518291][ T12] ? ret_from_fork_asm+0x11/0x20 [ 32.518293][ T12] _printk+0xc7/0x100 [ 32.518296][ T12] ? snapshot_read.cold+0x21/0x21 [ 32.518299][ T12] ? netdev_name+0x43/0x60 [ 32.518302][ T12] ? __netdev_printk+0x17f/0x1d0 [ 32.518304][ T12] netdev_info+0xe2/0x116 [ 32.518306][ T12] ? netdev_notice+0x120/0x120 [ 32.518307][ T12] ? rcu_is_watching+0x16/0xd0 [ 32.518309][ T12] ? __up_read+0x355/0x9e0 [ 32.518311][ T12] ? trace_hardirqs_on+0x36/0x40 [ 32.518313][ T12] ? down_write_nested+0x200/0x200 [ 32.518314][ T12] ? mutex_is_locked+0x1c/0x50 [ 32.518317][ T12] netif_set_allmulti.cold+0x7c/0x166 [ 32.518320][ T12] dev_set_allmulti+0xa2/0x150 [ 32.518323][ T12] del_nbp+0xb7/0xc10 [bridge] [ 32.518336][ T12] br_dev_delete+0x9d/0x1e0 [bridge] [ 32.518344][ T12] br_net_exit_rtnl+0xb8/0x110 [bridge] [ 32.518351][ T12] ops_undo_list+0x5be/0x8f0 [ 32.518353][ T12] ? rtnl_net_dumpid_one+0x2d0/0x2d0 [ 32.518355][ T12] ? idr_destroy+0x121/0x250 [ 32.518358][ T12] cleanup_net+0x431/0x890 [ 32.518360][ T12] ? net_passive_dec+0x230/0x230 [ 32.518367][ T12] ? lock_acquire+0x13c/0x160 [ 32.518369][ T12] ? rcu_is_watching+0x16/0xd0 [ 32.518371][ T12] process_one_work+0xe3e/0x1560 [ 32.518374][ T12] ? __queue_delayed_work+0x470/0x470 [ 32.518376][ T12] ? find_held_lock+0x2b/0x80 [ 32.518377][ T12] ? __rwlock_init+0x150/0x150 [ 32.518380][ T12] worker_thread+0x4f1/0xd60 [ 32.518383][ T12] ? rescuer_thread+0x1340/0x1340 [ 32.518384][ T12] kthread+0x367/0x460 [ 32.518386][ T12] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 32.518387][ T12] ? kthread_affine_preferred+0x4c0/0x4c0 [ 32.518389][ T12] ret_from_fork+0x474/0x6b0 [ 32.518391][ T12] ? arch_exit_to_user_mode_prepare.isra.0+0x120/0x120 [ 32.518393][ T12] ? __switch_to+0x5a3/0xe00 [ 32.518395][ T12] ? kthread_affine_preferred+0x4c0/0x4c0 [ 32.518397][ T12] ret_from_fork_asm+0x11/0x20 [ 32.518400][ T12] [ 32.538795][ T12] w3: left promiscuous mode [ 32.539029][ T12] br1: port 4(w3) entered disabled state [ 32.539833][ T12] w1: left allmulticast mode [ 32.539967][ T12] w1: left promiscuous mode [ 32.540326][ T12] br1: port 3(w1) entered disabled state [ 32.545126][ T12] vx20: left allmulticast mode [ 32.545273][ T12] vx20: left promiscuous mode [ 32.545470][ T12] br1: port 2(vx20) entered disabled state [ 32.546166][ T12] vx10: left allmulticast mode [ 32.547507][ T12] vx10: left promiscuous mode [ 32.551617][ T12] br1: port 1(vx10) entered disabled state [ 32.944842][ T190] br1: left promiscuous mode [ 33.109636][ T623] br1: port 4(veth2) entered disabled state [ 33.128522][ T624] veth2: left allmulticast mode [ 33.128752][ T624] veth2: left promiscuous mode [ 33.129054][ T624] br1: port 4(veth2) entered disabled state [ 33.173938][ T626] br1: port 3(veth1) entered disabled state [ 33.190076][ T627] veth1: left allmulticast mode [ 33.190288][ T627] veth1: left promiscuous mode [ 33.190550][ T627] br1: port 3(veth1) entered disabled state [ 33.219693][ T629] vx20: left allmulticast mode [ 33.219885][ T629] vx20: left promiscuous mode [ 33.220133][ T629] br1: port 2(vx20) entered disabled state [ 33.336354][ T633] vx10: left allmulticast mode [ 33.336554][ T633] vx10: left promiscuous mode [ 33.336763][ T633] br1: port 1(vx10) entered disabled state