[ 11.002715][ T186] ip (186) used greatest stack depth: 24240 bytes left [ 11.002731][ T186] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 11.002733][ T186] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 186, name: ip [ 11.002735][ T186] preempt_count: 2, expected: 0 [ 11.002736][ T186] RCU nest depth: 0, expected: 0 [ 11.002737][ T186] locks held by ip/186: 5, last CPU#1: [ 11.002739][ T186] #0: ffffffffae0027b8 (low_water_lock){+.+.}-{3:3}, at: do_exit+0x887/0xdc0 [ 11.002751][ T186] #1: ffffffffae169cc0 (console_lock){+.+.}-{0:0}, at: vprintk_emit+0x320/0x3e0 [ 11.002757][ T186] #2: ffffffffae169d38 (console_srcu){....}-{0:0}, at: console_flush_one_record+0x106/0x710 [ 11.002761][ T186] #3: ffffffffae089660 (console_owner){....}-{0:0}, at: console_lock_spinning_enable+0x40/0x60 [ 11.002765][ T186] #4: ffffffffae089560 (printk_legacy_map-wait-type-override){....}-{3:3}, at: console_emit_next_record+0x1df/0x4c0 [ 11.002768][ T186] irq event stamp: 46778 [ 11.002769][ T186] hardirqs last enabled at (46777): [] __down_trylock_console_sem+0x86/0xa0 [ 11.002772][ T186] hardirqs last disabled at (46778): [] console_emit_next_record+0x3d4/0x4c0 [ 11.002774][ T186] softirqs last enabled at (45496): [] netlink_release+0x17b/0xcf0 [ 11.002778][ T186] softirqs last disabled at (45494): [] netlink_release+0xd2/0xcf0 [ 11.002781][ T186] Preemption disabled at: [ 11.002781][ T186] [<0000000000000000>] 0x0 [ 11.002788][ T186] CPU: 1 UID: 0 PID: 186 Comm: ip Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 11.002791][ T186] Tainted: [W]=WARN [ 11.002792][ T186] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 11.002794][ T186] Call Trace: [ 11.002795][ T186] [ 11.002797][ T186] dump_stack_lvl+0x6f/0xa0 [ 11.002803][ T186] __might_resched.cold+0x1fe/0x2c1 [ 11.002807][ T186] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 11.002812][ T186] ? __kmalloc_noprof+0xdb/0x760 [ 11.002817][ T186] __kmalloc_noprof+0x443/0x760 [ 11.002819][ T186] ? alloc_buf.isra.0+0x4b/0x260 [ 11.002825][ T186] ? do_raw_spin_unlock+0x59/0x250 [ 11.002828][ T186] alloc_buf.isra.0+0x4b/0x260 [ 11.002831][ T186] put_chars+0x1e1/0x2f0 [ 11.002834][ T186] ? __send_to_port+0x420/0x420 [ 11.002835][ T186] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 11.002840][ T186] ? validate_chain+0x38b/0xc20 [ 11.002845][ T186] hvc_console_print+0x292/0x780 [ 11.002852][ T186] ? hvc_write+0x3a0/0x3a0 [ 11.002854][ T186] ? rcu_is_watching+0x16/0xd0 [ 11.002856][ T186] ? lock_acquire+0x13c/0x160 [ 11.002860][ T186] console_emit_next_record+0x22f/0x4c0 [ 11.002864][ T186] ? devkmsg_read+0x4b0/0x4b0 [ 11.002866][ T186] ? console_flush_one_record+0x106/0x710 [ 11.002869][ T186] ? rcu_is_watching+0x16/0xd0 [ 11.002872][ T186] ? lock_acquire+0x13c/0x160 [ 11.002876][ T186] console_flush_one_record+0x46f/0x710 [ 11.002880][ T186] ? console_emit_next_record+0x4c0/0x4c0 [ 11.002882][ T186] ? __lock_acquire+0x518/0xc20 [ 11.002887][ T186] console_unlock+0xee/0x1f0 [ 11.002890][ T186] ? console_flush_one_record+0x710/0x710 [ 11.002891][ T186] ? rcu_is_watching+0x16/0xd0 [ 11.002894][ T186] ? lock_acquire+0x60/0x160 [ 11.002897][ T186] ? __down_trylock_console_sem+0x5e/0xa0 [ 11.002899][ T186] ? vprintk_emit+0x320/0x3e0 [ 11.002902][ T186] vprintk_emit+0x37c/0x3e0 [ 11.002906][ T186] ? wake_up_klogd_work_func+0x90/0x90 [ 11.002910][ T186] ? __lock_acquire+0x518/0xc20 [ 11.002913][ T186] _printk+0xc7/0x100 [ 11.002917][ T186] ? snapshot_read.cold+0x21/0x21 [ 11.002920][ T186] ? do_raw_spin_lock+0x131/0x280 [ 11.002923][ T186] ? __rwlock_init+0x150/0x150 [ 11.002927][ T186] ? do_raw_spin_lock+0x131/0x280 [ 11.002929][ T186] do_exit.cold+0x82/0x9c [ 11.002933][ T186] ? exit_notify+0x890/0x890 [ 11.002935][ T186] ? __lock_release.isra.0+0x69/0x1a0 [ 11.002938][ T186] ? rcu_is_watching+0x16/0xd0 [ 11.002942][ T186] do_group_exit+0xb8/0x370 [ 11.002945][ T186] __x64_sys_exit_group+0x3c/0x50 [ 11.002947][ T186] x64_sys_call+0x1567/0x1570 [ 11.002949][ T186] do_syscall_64+0xff/0x530 [ 11.002952][ T186] ? exc_page_fault+0xee/0x100 [ 11.002955][ T186] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 11.002957][ T186] RIP: 0033:0x7faa435421b8 [ 11.002960][ T186] Code: Unable to access opcode bytes at 0x7faa4354218e. [ 11.002961][ T186] RSP: 002b:00007ffd3763b3a8 EFLAGS: 00000246 ORIG_RAX: 00000000000000e7 [ 11.002963][ T186] RAX: ffffffffffffffda RBX: 00007faa43672f88 RCX: 00007faa435421b8 [ 11.002964][ T186] RDX: 00007faa4328cfc8 RSI: fffffffffffffeb8 RDI: 0000000000000000 [ 11.002965][ T186] RBP: 00007ffd3763b400 R08: 0000000000000000 R09: 0000000000008010 [ 11.002966][ T186] R10: 00007ffd3763b1c0 R11: 0000000000000246 R12: 0000000000000001 [ 11.002967][ T186] R13: 0000000000000000 R14: 00007faa43671680 R15: 00007faa43672fa0 [ 11.002974][ T186] [ 12.211772][ T237] br0: port 1(veth1) entered blocking state [ 12.211855][ T237] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 12.211857][ T237] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 237, name: ip [ 12.211859][ T237] preempt_count: 1, expected: 0 [ 12.211860][ T237] RCU nest depth: 0, expected: 0 [ 12.211861][ T237] locks held by ip/237: 5, last CPU#2: [ 12.211863][ T237] #0: ffffffffae8d2c40 (rtnl_mutex){+.+.}-{4:4}, at: rtnl_newlink+0x9a8/0x11c0 [ 12.211875][ T237] #1: ffffffffae169cc0 (console_lock){+.+.}-{0:0}, at: vprintk_emit+0x320/0x3e0 [ 12.211882][ T237] #2: ffffffffae169d38 (console_srcu){....}-{0:0}, at: console_flush_one_record+0x106/0x710 [ 12.211885][ T237] #3: ffffffffae089660 (console_owner){....}-{0:0}, at: console_lock_spinning_enable+0x40/0x60 [ 12.211889][ T237] #4: ffffffffae089560 (printk_legacy_map-wait-type-override){....}-{3:3}, at: console_emit_next_record+0x1df/0x4c0 [ 12.211894][ T237] irq event stamp: 16742 [ 12.211894][ T237] hardirqs last enabled at (16741): [] __down_trylock_console_sem+0x86/0xa0 [ 12.211897][ T237] hardirqs last disabled at (16742): [] console_emit_next_record+0x3d4/0x4c0 [ 12.211899][ T237] softirqs last enabled at (16654): [] __alloc_skb+0x4c2/0x5f0 [ 12.211902][ T237] softirqs last disabled at (16652): [] __alloc_skb+0x4c2/0x5f0 [ 12.211904][ T237] Preemption disabled at: [ 12.211905][ T237] [] vprintk_emit+0x31b/0x3e0 [ 12.211911][ T237] CPU: 2 UID: 0 PID: 237 Comm: ip Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 12.211915][ T237] Tainted: [W]=WARN [ 12.211915][ T237] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 12.211917][ T237] Call Trace: [ 12.211919][ T237] [ 12.211920][ T237] dump_stack_lvl+0x6f/0xa0 [ 12.211926][ T237] ? vprintk_emit+0x31b/0x3e0 [ 12.211929][ T237] __might_resched.cold+0x1fe/0x2c1 [ 12.211933][ T237] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 12.211938][ T237] ? __kmalloc_noprof+0xdb/0x760 [ 12.211943][ T237] __kmalloc_noprof+0x443/0x760 [ 12.211945][ T237] ? alloc_buf.isra.0+0x4b/0x260 [ 12.211951][ T237] ? do_raw_spin_unlock+0x59/0x250 [ 12.211954][ T237] alloc_buf.isra.0+0x4b/0x260 [ 12.211957][ T237] put_chars+0x1e1/0x2f0 [ 12.211960][ T237] ? __send_to_port+0x420/0x420 [ 12.211964][ T237] ? validate_chain+0x34a/0xc20 [ 12.211968][ T237] hvc_console_print+0x292/0x780 [ 12.211971][ T237] ? mark_usage+0x61/0x170 [ 12.211973][ T237] ? __lock_acquire+0x518/0xc20 [ 12.211974][ T237] ? __lock_acquire+0x518/0xc20 [ 12.211978][ T237] ? hvc_write+0x3a0/0x3a0 [ 12.211980][ T237] ? console_emit_next_record+0x1df/0x4c0 [ 12.211983][ T237] ? rcu_is_watching+0x16/0xd0 [ 12.211987][ T237] ? lock_acquire+0x13c/0x160 [ 12.211991][ T237] console_emit_next_record+0x22f/0x4c0 [ 12.211995][ T237] ? devkmsg_read+0x4b0/0x4b0 [ 12.211997][ T237] ? console_flush_one_record+0x106/0x710 [ 12.212000][ T237] ? rcu_is_watching+0x16/0xd0 [ 12.212003][ T237] ? lock_acquire+0x13c/0x160 [ 12.212007][ T237] console_flush_one_record+0x46f/0x710 [ 12.212011][ T237] ? console_emit_next_record+0x4c0/0x4c0 [ 12.212013][ T237] ? __lock_acquire+0x518/0xc20 [ 12.212018][ T237] console_unlock+0xee/0x1f0 [ 12.212021][ T237] ? console_flush_one_record+0x710/0x710 [ 12.212023][ T237] ? rcu_is_watching+0x16/0xd0 [ 12.212025][ T237] ? lock_acquire+0x60/0x160 [ 12.212029][ T237] ? __down_trylock_console_sem+0x5e/0xa0 [ 12.212031][ T237] ? vprintk_emit+0x320/0x3e0 [ 12.212034][ T237] vprintk_emit+0x37c/0x3e0 [ 12.212038][ T237] ? wake_up_klogd_work_func+0x90/0x90 [ 12.212040][ T237] ? __lock_release.isra.0+0x69/0x1a0 [ 12.212042][ T237] ? _raw_spin_unlock_irqrestore+0x40/0x80 [ 12.212047][ T237] ? mark_held_locks+0x40/0x70 [ 12.212050][ T237] _printk+0xc7/0x100 [ 12.212054][ T237] ? snapshot_read.cold+0x21/0x21 [ 12.212057][ T237] ? br_multicast_flood+0xab0/0xab0 [bridge] [ 12.212070][ T237] ? do_setlink.isra.0+0xa31/0x2750 [ 12.212072][ T237] ? rtnl_newlink+0x9f1/0x11c0 [ 12.212073][ T237] ? rtnetlink_rcv_msg+0x6fd/0xbd0 [ 12.212077][ T237] br_set_state+0x22f/0x430 [bridge] [ 12.212088][ T237] br_init_port+0xc4/0x200 [bridge] [ 12.212096][ T237] new_nbp+0x39c/0x580 [bridge] [ 12.212105][ T237] br_add_if+0x212/0x1320 [bridge] [ 12.212113][ T237] ? is_bpf_text_address+0x72/0x110 [ 12.212117][ T237] ? kernel_text_address+0x149/0x170 [ 12.212120][ T237] ? __kernel_text_address+0x12/0x30 [ 12.212123][ T237] do_set_master+0x357/0x580 [ 12.212128][ T237] do_setlink.isra.0+0xa31/0x2750 [ 12.212131][ T237] ? stack_trace_save+0x93/0xc0 [ 12.212134][ T237] ? rtnl_link_get_size+0x350/0x350 [ 12.212136][ T237] ? rcu_read_lock_any_held+0x66/0x90 [ 12.212138][ T237] ? stack_depot_save_flags+0x38e/0x790 [ 12.212142][ T237] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 12.212144][ T237] ? rcu_read_lock_any_held+0x3c/0x90 [ 12.212146][ T237] ? validate_chain+0x38b/0xc20 [ 12.212149][ T237] ? kasan_save_stack+0x3d/0x50 [ 12.212152][ T237] ? kasan_save_stack+0x2f/0x50 [ 12.212153][ T237] ? kasan_save_track+0x14/0x30 [ 12.212156][ T237] ? __lock_acquire+0x518/0xc20 [ 12.212158][ T237] ? netlink_seq_next+0xe/0x60 [ 12.212161][ T237] ? ___sys_sendmsg+0xb0/0x1d0 [ 12.212166][ T237] ? lock_acquire.part.0+0xd4/0x280 [ 12.212168][ T237] ? rtnl_newlink+0x9a8/0x11c0 [ 12.212171][ T237] ? rcu_is_watching+0x16/0xd0 [ 12.212173][ T237] ? lock_acquire+0x13c/0x160 [ 12.212175][ T237] ? rcu_is_watching+0x16/0xd0 [ 12.212176][ T237] ? rcu_is_watching+0x16/0xd0 [ 12.212179][ T237] ? trace_contention_end+0xb3/0x180 [ 12.212183][ T237] ? __mutex_lock+0x1db/0x1ea0 [ 12.212185][ T237] ? __mutex_lock+0x9a3/0x1ea0 [ 12.212187][ T237] ? rtnl_newlink+0x9a8/0x11c0 [ 12.212190][ T237] ? ww_mutex_lock+0x160/0x160 [ 12.212192][ T237] ? nla_get_range_signed+0x3d0/0x3d0 [ 12.212197][ T237] ? __rtnl_newlink+0x3fa/0xa50 [ 12.212202][ T237] rtnl_newlink+0x9f1/0x11c0 [ 12.212207][ T237] ? rtnl_bridge_getlink+0x850/0x850 [ 12.212209][ T237] ? __lock_acquire+0x518/0xc20 [ 12.212214][ T237] ? lock_acquire.part.0+0xd4/0x280 [ 12.212215][ T237] ? find_held_lock+0x2b/0x80 [ 12.212217][ T237] ? rtnl_bridge_getlink+0x850/0x850 [ 12.212219][ T237] ? __lock_release.isra.0+0x69/0x1a0 [ 12.212223][ T237] ? rtnl_bridge_getlink+0x850/0x850 [ 12.212225][ T237] rtnetlink_rcv_msg+0x6fd/0xbd0 [ 12.212228][ T237] ? rtnl_link_fill+0x920/0x920 [ 12.212229][ T237] ? __lock_acquire+0x518/0xc20 [ 12.212234][ T237] ? lock_acquire.part.0+0xd4/0x280 [ 12.212236][ T237] ? find_held_lock+0x2b/0x80 [ 12.212239][ T237] netlink_rcv_skb+0x14e/0x3a0 [ 12.212241][ T237] ? rtnl_link_fill+0x920/0x920 [ 12.212244][ T237] ? netlink_ack+0xcf0/0xcf0 [ 12.212250][ T237] ? netlink_deliver_tap+0xc5/0x330 [ 12.212251][ T237] ? netlink_deliver_tap+0x13c/0x330 [ 12.212256][ T237] netlink_unicast+0x486/0x750 [ 12.212259][ T237] ? netlink_attachskb+0x810/0x810 [ 12.212262][ T237] ? __lock_acquire+0x518/0xc20 [ 12.212266][ T237] netlink_sendmsg+0x735/0xc60 [ 12.212270][ T237] ? netlink_unicast+0x750/0x750 [ 12.212274][ T237] ? __might_fault+0x97/0x140 [ 12.212279][ T237] ____sys_sendmsg+0x415/0x880 [ 12.212281][ T237] ? copy_msghdr_from_user+0x279/0x420 [ 12.212283][ T237] ? get_timestamp.constprop.0+0x390/0x390 [ 12.212285][ T237] ? move_addr_to_kernel+0x40/0x40 [ 12.212292][ T237] ___sys_sendmsg+0x14e/0x1d0 [ 12.212295][ T237] ? copy_msghdr_from_user+0x420/0x420 [ 12.212311][ T237] __sys_sendmsg+0x12c/0x1d0 [ 12.212314][ T237] ? __sys_sendmsg_sock+0x20/0x20 [ 12.212321][ T237] ? rcu_is_watching+0x16/0xd0 [ 12.212324][ T237] do_syscall_64+0xff/0x530 [ 12.212327][ T237] ? exc_page_fault+0xee/0x100 [ 12.212330][ T237] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 12.212332][ T237] RIP: 0033:0x7f28a468054e [ 12.212335][ T237] 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 [ 12.212337][ T237] RSP: 002b:00007ffe56130230 EFLAGS: 00000202 ORIG_RAX: 000000000000002e [ 12.212340][ T237] RAX: ffffffffffffffda RBX: 0000000000000004 RCX: 00007f28a468054e [ 12.212341][ T237] RDX: 0000000000000000 RSI: 00007ffe561302e0 RDI: 0000000000000005 [ 12.212342][ T237] RBP: 00007ffe56130240 R08: 0000000000000000 R09: 0000000000000000 [ 12.212343][ T237] R10: 0000000000000000 R11: 0000000000000202 R12: 000000006a918223 [ 12.212344][ T237] R13: 00000000004a1620 R14: 0000000000000000 R15: 00007ffe561309a0 [ 12.212351][ T237] [ 12.261554][ T237] br0: port 1(veth1) entered disabled state [ 12.261989][ T237] veth1: entered allmulticast mode [ 12.264057][ T237] veth1: entered promiscuous mode [ 12.291502][ T237] ip (237) used greatest stack depth: 23336 bytes left [ 12.311524][ T239] br0: port 2(veth2) entered blocking state [ 12.311901][ T239] br0: port 2(veth2) entered disabled state [ 12.312281][ T239] veth2: entered allmulticast mode [ 12.314233][ T239] veth2: entered promiscuous mode [ 12.382010][ T93] br0: port 1(veth1) entered blocking state [ 12.382543][ T93] br0: port 1(veth1) entered forwarding state [ 22.522100][ T221] br0: port 2(veth2) entered blocking state [ 22.522120][ T221] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 22.522123][ T221] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 221, name: kworker/u20:2 [ 22.522124][ T221] preempt_count: 202, expected: 0 [ 22.522125][ T221] RCU nest depth: 0, expected: 0 [ 22.522126][ T221] locks held by kworker/u20:2/221: 8, last CPU#2: [ 22.522129][ T221] #0: ff1100000114a940 ((wq_completion)events_unbound){+.+.}-{0:0}, at: process_one_work+0xd9a/0x1560 [ 22.522141][ T221] #1: ffa00000004e7d10 ((linkwatch_work).work){+.+.}-{0:0}, at: process_one_work+0xdfc/0x1560 [ 22.522145][ T221] #2: ffffffffae8d2c40 (rtnl_mutex){+.+.}-{4:4}, at: linkwatch_event+0x4e/0xb0 [ 22.522151][ T221] #3: ff1100000e8c2e58 (&br->lock){+...}-{3:3}, at: br_port_carrier_check+0x161/0x430 [bridge] [ 22.522168][ T221] #4: ffffffffae169cc0 (console_lock){+.+.}-{0:0}, at: vprintk_emit+0x320/0x3e0 [ 22.522173][ T221] #5: ffffffffae169d38 (console_srcu){....}-{0:0}, at: console_flush_one_record+0x106/0x710 [ 22.522177][ T221] #6: ffffffffae089660 (console_owner){....}-{0:0}, at: console_lock_spinning_enable+0x40/0x60 [ 22.522181][ T221] #7: ffffffffae089560 (printk_legacy_map-wait-type-override){....}-{3:3}, at: console_emit_next_record+0x1df/0x4c0 [ 22.522185][ T221] irq event stamp: 15477 [ 22.522186][ T221] hardirqs last enabled at (15476): [] __down_trylock_console_sem+0x86/0xa0 [ 22.522188][ T221] hardirqs last disabled at (15477): [] console_emit_next_record+0x3d4/0x4c0 [ 22.522191][ T221] softirqs last enabled at (15438): [] inet6_fill_ifla6_attrs+0x1b3e/0x21e0 [ 22.522194][ T221] softirqs last disabled at (15472): [] br_port_carrier_check+0x161/0x430 [bridge] [ 22.522203][ T221] Preemption disabled at: [ 22.522203][ T221] [<0000000000000000>] 0x0 [ 22.522210][ T221] CPU: 2 UID: 0 PID: 221 Comm: kworker/u20:2 Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 22.522214][ T221] Tainted: [W]=WARN [ 22.522215][ T221] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 22.522217][ T221] Workqueue: events_unbound linkwatch_event [ 22.522220][ T221] Call Trace: [ 22.522222][ T221] [ 22.522224][ T221] dump_stack_lvl+0x6f/0xa0 [ 22.522231][ T221] __might_resched.cold+0x1fe/0x2c1 [ 22.522236][ T221] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 22.522240][ T221] ? __kmalloc_noprof+0xdb/0x760 [ 22.522245][ T221] __kmalloc_noprof+0x443/0x760 [ 22.522248][ T221] ? alloc_buf.isra.0+0x4b/0x260 [ 22.522254][ T221] ? do_raw_spin_unlock+0x59/0x250 [ 22.522257][ T221] alloc_buf.isra.0+0x4b/0x260 [ 22.522260][ T221] put_chars+0x1e1/0x2f0 [ 22.522263][ T221] ? __send_to_port+0x420/0x420 [ 22.522266][ T221] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 22.522270][ T221] ? rcu_read_lock_any_held+0x3c/0x90 [ 22.522273][ T221] ? validate_chain+0x38b/0xc20 [ 22.522277][ T221] hvc_console_print+0x292/0x780 [ 22.522280][ T221] ? mark_usage+0x61/0x170 [ 22.522282][ T221] ? __lock_acquire+0x518/0xc20 [ 22.522283][ T221] ? __lock_acquire+0x518/0xc20 [ 22.522288][ T221] ? hvc_write+0x3a0/0x3a0 [ 22.522289][ T221] ? lock_acquire.part.0+0xd4/0x280 [ 22.522294][ T221] ? lock_acquire+0x13c/0x160 [ 22.522298][ T221] console_emit_next_record+0x22f/0x4c0 [ 22.522302][ T221] ? devkmsg_read+0x4b0/0x4b0 [ 22.522304][ T221] ? console_flush_one_record+0x106/0x710 [ 22.522307][ T221] ? rcu_is_watching+0x16/0xd0 [ 22.522310][ T221] ? lock_acquire+0x13c/0x160 [ 22.522314][ T221] console_flush_one_record+0x46f/0x710 [ 22.522319][ T221] ? console_emit_next_record+0x4c0/0x4c0 [ 22.522320][ T221] ? __lock_acquire+0x518/0xc20 [ 22.522326][ T221] console_unlock+0xee/0x1f0 [ 22.522329][ T221] ? console_flush_one_record+0x710/0x710 [ 22.522331][ T221] ? rcu_is_watching+0x16/0xd0 [ 22.522333][ T221] ? lock_acquire+0x60/0x160 [ 22.522337][ T221] ? __down_trylock_console_sem+0x5e/0xa0 [ 22.522339][ T221] ? vprintk_emit+0x320/0x3e0 [ 22.522343][ T221] vprintk_emit+0x37c/0x3e0 [ 22.522347][ T221] ? wake_up_klogd_work_func+0x90/0x90 [ 22.522350][ T221] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 22.522353][ T221] ? rcu_read_lock_any_held+0x3c/0x90 [ 22.522357][ T221] _printk+0xc7/0x100 [ 22.522361][ T221] ? snapshot_read.cold+0x21/0x21 [ 22.522366][ T221] ? lock_acquire.part.0+0xd4/0x280 [ 22.522371][ T221] br_set_state+0x22f/0x430 [bridge] [ 22.522381][ T221] br_init_port+0xc4/0x200 [bridge] [ 22.522390][ T221] br_stp_enable_port+0x12/0x50 [bridge] [ 22.522398][ T221] br_port_carrier_check+0x220/0x430 [bridge] [ 22.522407][ T221] br_device_event+0x52d/0x8f0 [bridge] [ 22.522417][ T221] ? _sub_I_65535_1+0x4d0/0x4d0 [stp] [ 22.522422][ T221] ? nlmsg_notify+0x62/0x250 [ 22.522430][ T221] notifier_call_chain+0xae/0x300 [ 22.522437][ T221] netif_state_change+0x139/0x340 [ 22.522442][ T221] ? call_netdevice_notifiers_info+0xd0/0xd0 [ 22.522448][ T221] ? linkwatch_do_dev+0xae/0xd0 [ 22.522450][ T221] __linkwatch_run_queue+0x34c/0x750 [ 22.522454][ T221] ? linkwatch_do_dev+0xd0/0xd0 [ 22.522456][ T221] ? lock_acquire.part.0+0xd4/0x280 [ 22.522462][ T221] linkwatch_event+0x7f/0xb0 [ 22.522464][ T221] ? __linkwatch_run_queue+0x750/0x750 [ 22.522468][ T221] process_one_work+0xe3e/0x1560 [ 22.522481][ T221] ? __queue_delayed_work+0x470/0x470 [ 22.522484][ T221] ? lock_acquire.part.0+0xd4/0x280 [ 22.522493][ T221] worker_thread+0x4f1/0xd60 [ 22.522498][ T221] ? rescuer_thread+0x1340/0x1340 [ 22.522500][ T221] ? __kthread_parkme+0xbd/0x210 [ 22.522503][ T221] ? rescuer_thread+0x1340/0x1340 [ 22.522506][ T221] ? rescuer_thread+0x1340/0x1340 [ 22.522509][ T221] kthread+0x367/0x460 [ 22.522511][ T221] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 22.522514][ T221] ? kthread_affine_preferred+0x4c0/0x4c0 [ 22.522517][ T221] ret_from_fork+0x474/0x6b0 [ 22.522522][ T221] ? arch_exit_to_user_mode_prepare.isra.0+0x120/0x120 [ 22.522525][ T221] ? __switch_to+0x5a3/0xe00 [ 22.522529][ T221] ? kthread_affine_preferred+0x4c0/0x4c0 [ 22.522532][ T221] ret_from_fork_asm+0x11/0x20 [ 22.522541][ T221] [ 22.559340][ T221] br0: port 2(veth2) entered forwarding state [ 27.583655][ C2] [ 27.583673][ C2] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 27.583675][ C2] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 0, name: swapper/2 [ 27.583677][ C2] preempt_count: 104, expected: 0 [ 27.583678][ C2] RCU nest depth: 0, expected: 0 [ 27.583679][ C2] INFO: lockdep is turned off. [ 27.583680][ C2] irq event stamp: 471316 [ 27.583681][ C2] hardirqs last enabled at (471316): [] _raw_spin_unlock_irq+0x28/0x50 [ 27.583690][ C2] hardirqs last disabled at (471315): [] _raw_spin_lock_irq+0x4a/0x50 [ 27.583692][ C2] softirqs last enabled at (471246): [] handle_softirqs+0x67c/0x900 [ 27.583696][ C2] softirqs last disabled at (471253): [] __irq_exit_rcu+0x145/0x1c0 [ 27.583697][ C2] Preemption disabled at: [ 27.583698][ C2] [<0000000000000000>] 0x0 [ 27.583706][ C2] CPU: 2 UID: 0 PID: 0 Comm: swapper/2 Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 27.583710][ C2] Tainted: [W]=WARN [ 27.583710][ C2] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 27.583712][ C2] Call Trace: [ 27.583714][ C2] [ 27.583716][ C2] dump_stack_lvl+0x6f/0xa0 [ 27.583722][ C2] __might_resched.cold+0x1fe/0x2c1 [ 27.583726][ C2] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 27.583730][ C2] ? __asan_memcpy+0x3c/0x60 [ 27.583733][ C2] ? rcu_is_watching+0x16/0xd0 [ 27.583737][ C2] __kmalloc_noprof+0x443/0x760 [ 27.583740][ C2] ? __rwlock_init+0x150/0x150 [ 27.583743][ C2] ? alloc_buf.isra.0+0x4b/0x260 [ 27.583747][ C2] ? do_raw_spin_unlock+0x59/0x250 [ 27.583748][ C2] alloc_buf.isra.0+0x4b/0x260 [ 27.583750][ C2] put_chars+0x1e1/0x2f0 [ 27.583752][ C2] ? __send_to_port+0x420/0x420 [ 27.583754][ C2] ? console_prepend_replay+0x20/0x20 [ 27.583757][ C2] hvc_console_print+0x292/0x780 [ 27.583761][ C2] ? hvc_write+0x3a0/0x3a0 [ 27.583762][ C2] ? rcu_is_watching+0x16/0xd0 [ 27.583764][ C2] ? lock_acquire+0x13c/0x160 [ 27.583766][ C2] console_emit_next_record+0x22f/0x4c0 [ 27.583769][ C2] ? devkmsg_read+0x4b0/0x4b0 [ 27.583771][ C2] ? rcu_is_watching+0x16/0xd0 [ 27.583772][ C2] ? rcu_is_watching+0x16/0xd0 [ 27.583774][ C2] ? lock_acquire+0x13c/0x160 [ 27.583776][ C2] ? console_flush_one_record+0x111/0x710 [ 27.583778][ C2] console_flush_one_record+0x46f/0x710 [ 27.583780][ C2] ? console_emit_next_record+0x4c0/0x4c0 [ 27.583783][ C2] console_unlock+0xee/0x1f0 [ 27.583784][ C2] ? lock_acquire+0x13c/0x160 [ 27.583786][ C2] ? console_flush_one_record+0x710/0x710 [ 27.583788][ C2] ? rcu_is_watching+0x16/0xd0 [ 27.583789][ C2] ? lock_release+0x184/0x1f0 [ 27.583791][ C2] ? lock_acquire+0x60/0x160 [ 27.583793][ C2] ? __down_trylock_console_sem+0x5e/0xa0 [ 27.583795][ C2] ? vprintk_emit+0x320/0x3e0 [ 27.583797][ C2] vprintk_emit+0x37c/0x3e0 [ 27.583799][ C2] ? wake_up_klogd_work_func+0x90/0x90 [ 27.583801][ C2] ? br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 27.583813][ C2] ? lock_release+0x184/0x1f0 [ 27.583814][ C2] ? br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 27.583821][ C2] ? br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 27.583827][ C2] ? is_module_text_address+0x154/0x250 [ 27.583830][ C2] _printk+0xc7/0x100 [ 27.583833][ C2] ? snapshot_read.cold+0x21/0x21 [ 27.583835][ C2] ? arch_stack_walk+0xd7/0x130 [ 27.583839][ C2] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 27.583841][ C2] ? nbcon_cpu_emergency_enter+0x28/0x80 [ 27.583843][ C2] print_irq_inversion_bug.part.0+0x32/0xc0 [ 27.583846][ C2] mark_lock_irq+0x989/0x9c0 [ 27.583848][ C2] mark_lock+0x1d7/0xa00 [ 27.583850][ C2] mark_usage+0x42/0x170 [ 27.583852][ C2] __lock_acquire+0x388/0xc20 [ 27.583854][ C2] lock_acquire.part.0+0xd4/0x280 [ 27.583856][ C2] ? br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 27.583862][ C2] ? rcu_is_watching+0x16/0xd0 [ 27.583864][ C2] ? lock_acquire+0x13c/0x160 [ 27.583866][ C2] ? br_message_age_timer_expired+0x70/0x70 [bridge] [ 27.583872][ C2] _raw_spin_lock+0x33/0x40 [ 27.583874][ C2] ? br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 27.583880][ C2] br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 27.583887][ C2] ? br_message_age_timer_expired+0x70/0x70 [bridge] [ 27.583893][ C2] call_timer_fn+0x160/0x4d0 [ 27.583896][ C2] ? detach_if_pending+0x1d0/0x1d0 [ 27.583898][ C2] ? debug_object_active_state+0x430/0x430 [ 27.583901][ C2] ? find_held_lock+0x2b/0x80 [ 27.583903][ C2] ? __lock_release.isra.0+0x69/0x1a0 [ 27.583905][ C2] ? rcu_is_watching+0x16/0xd0 [ 27.583907][ C2] __run_timers+0x68f/0xaa0 [ 27.583909][ C2] ? br_message_age_timer_expired+0x70/0x70 [bridge] [ 27.583916][ C2] ? __bpf_trace_itimer_expire+0x10/0x10 [ 27.583918][ C2] ? __lock_acquire+0x518/0xc20 [ 27.583920][ C2] ? __rwlock_init+0x150/0x150 [ 27.583923][ C2] run_timer_softirq+0xf0/0x160 [ 27.583925][ C2] ? __run_timers+0xaa0/0xaa0 [ 27.583927][ C2] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 27.583929][ C2] ? rcu_is_watching+0x16/0xd0 [ 27.583931][ C2] handle_softirqs+0x1d3/0x900 [ 27.583933][ C2] ? __lock_release.isra.0+0x69/0x1a0 [ 27.583934][ C2] ? _local_bh_enable+0xc0/0xc0 [ 27.583936][ C2] __irq_exit_rcu+0x145/0x1c0 [ 27.583938][ C2] irq_exit_rcu+0xe/0x30 [ 27.583939][ C2] sysvec_apic_timer_interrupt+0x9d/0xe0 [ 27.583942][ C2] [ 27.583943][ C2] [ 27.583943][ C2] ? lockdep_hardirqs_on+0x91/0x130 [ 27.583945][ C2] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 27.583947][ C2] RIP: 0010:pv_native_safe_halt+0xf/0x10 [ 27.583950][ C2] Code: 48 8b 3d 94 d2 f5 01 e8 1f 00 00 00 48 2b 05 58 93 95 00 c3 0f 1f 80 00 00 00 00 f3 0f 1e fa eb 07 0f 00 2d 13 86 11 00 fb f4 0f 1f 40 d6 48 83 ec 20 8b 17 49 89 f8 83 e2 fe 41 89 d2 0f 01 [ 27.583952][ C2] RSP: 0018:ffa0000000157e00 EFLAGS: 00000282 [ 27.583955][ C2] RAX: 00000000000730d3 RBX: ff11000001bec6c0 RCX: ffffffffaaef0307 [ 27.583957][ C2] RDX: ff11000001bec6c0 RSI: ffffffffadc38af6 RDI: ffffffffad68d8e0 [ 27.583958][ C2] RBP: 0000000000000000 R08: 0000000000000000 R09: 0000000000000000 [ 27.583958][ C2] R10: 0000000000000002 R11: 0000000000000001 R12: 1ff400000002afc3 [ 27.583959][ C2] R13: 0000000000000000 R14: dffffc0000000000 R15: 0000000000000000 [ 27.583961][ C2] ? cpuidle_idle_call.constprop.0+0x237/0x410 [ 27.583964][ C2] default_idle+0x9/0x10 [ 27.583966][ C2] default_idle_call+0x6e/0xb0 [ 27.583968][ C2] cpuidle_idle_call.constprop.0+0x237/0x410 [ 27.583969][ C2] ? arch_cpu_idle_exit+0x40/0x40 [ 27.583971][ C2] ? mark_tsc_async_resets+0x30/0x30 [ 27.583973][ C2] ? rcu_is_watching+0x16/0xd0 [ 27.583975][ C2] do_idle+0xd8/0x190 [ 27.583977][ C2] cpu_startup_entry+0x53/0x70 [ 27.583979][ C2] start_secondary+0x204/0x2b0 [ 27.583980][ C2] ? set_cpu_sibling_map+0x2130/0x2130 [ 27.583982][ C2] common_startup_64+0x13e/0x148 [ 27.583986][ C2] [ 27.602314][ C2] ======================================================== [ 27.602568][ C2] WARNING: possible irq lock inversion dependency detected [ 27.602822][ C2] 7.2.0-virtme #1 Tainted: G W [ 27.602992][ C2] -------------------------------------------------------- [ 27.603237][ C2] swapper/2/0 just changed the state of lock: [ 27.603454][ C2] ff1100000e8c2e58 (&br->lock){+.-.}-{3:3}, at: br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 27.603785][ C2] but this lock took another, SOFTIRQ-unsafe lock in the past: [ 27.603988][ C2] (fs_reclaim){+.+.}-{0:0} [ 27.603991][ C2] [ 27.603991][ C2] [ 27.603991][ C2] and interrupts could create inverse lock ordering between them. [ 27.603991][ C2] [ 27.604586][ C2] [ 27.604586][ C2] other info that might help us debug this: [ 27.604833][ C2] Chain exists of: [ 27.604833][ C2] &br->lock --> console_owner --> fs_reclaim [ 27.604833][ C2] [ 27.605189][ C2] Possible interrupt unsafe locking scenario: [ 27.605189][ C2] [ 27.605445][ C2] CPU0 CPU1 [ 27.605591][ C2] ---- ---- [ 27.605776][ C2] lock(fs_reclaim); [ 27.605883][ C2] local_irq_disable(); [ 27.606097][ C2] lock(&br->lock); [ 27.606316][ C2] lock(console_owner); [ 27.606487][ C2] [ 27.606646][ C2] lock(&br->lock); [ 27.606751][ C2] [ 27.606751][ C2] *** DEADLOCK *** [ 27.606751][ C2] [ 27.606994][ C2] locks held by swapper/2/0: 1, last CPU#2: [ 27.607161][ C2] #0: ffa0000000228c90 ((&p->forward_delay_timer)){+.-.}-{0:0}, at: call_timer_fn+0x110/0x4d0 [ 27.607480][ C2] [ 27.607480][ C2] the shortest dependencies between 2nd lock and 1st lock: [ 27.607762][ C2] -> (fs_reclaim){+.+.}-{0:0} { [ 27.607951][ C2] HARDIRQ-ON-W at: [ 27.608058][ C2] __lock_acquire+0x388/0xc20 [ 27.608279][ C2] lock_acquire.part.0+0xd4/0x280 [ 27.608453][ C2] fs_reclaim_acquire+0xd5/0x120 [ 27.608676][ C2] __kmalloc_cache_noprof+0x6e/0x620 [ 27.608926][ C2] kthread_create_worker_on_node+0xea/0x210 [ 27.609134][ C2] workqueue_init+0x2a/0x680 [ 27.609352][ C2] kernel_init_freeable+0x2fe/0x630 [ 27.609612][ C2] kernel_init+0x21/0x150 [ 27.609786][ C2] ret_from_fork+0x474/0x6b0 [ 27.610001][ C2] ret_from_fork_asm+0x11/0x20 [ 27.610219][ C2] SOFTIRQ-ON-W at: [ 27.610320][ C2] __lock_acquire+0x388/0xc20 [ 27.610495][ C2] lock_acquire.part.0+0xd4/0x280 [ 27.610681][ C2] fs_reclaim_acquire+0xd5/0x120 [ 27.610896][ C2] __kmalloc_cache_noprof+0x6e/0x620 [ 27.611149][ C2] kthread_create_worker_on_node+0xea/0x210 [ 27.611357][ C2] workqueue_init+0x2a/0x680 [ 27.611576][ C2] kernel_init_freeable+0x2fe/0x630 [ 27.611829][ C2] kernel_init+0x21/0x150 [ 27.611995][ C2] ret_from_fork+0x474/0x6b0 [ 27.612209][ C2] ret_from_fork_asm+0x11/0x20 [ 27.612430][ C2] INITIAL USE at: [ 27.612569][ C2] __lock_acquire+0x388/0xc20 [ 27.612860][ C2] lock_acquire.part.0+0xd4/0x280 [ 27.613036][ C2] fs_reclaim_acquire+0xd5/0x120 [ 27.613251][ C2] __kmalloc_cache_noprof+0x6e/0x620 [ 27.613510][ C2] kthread_create_worker_on_node+0xea/0x210 [ 27.613719][ C2] workqueue_init+0x2a/0x680 [ 27.613939][ C2] kernel_init_freeable+0x2fe/0x630 [ 27.614155][ C2] kernel_init+0x21/0x150 [ 27.614327][ C2] ret_from_fork+0x474/0x6b0 [ 27.614546][ C2] ret_from_fork_asm+0x11/0x20 [ 27.614764][ C2] } [ 27.614837][ C2] ... key at: [] __fs_reclaim_map+0x0/0xbe0 [ 27.615095][ C2] ... acquired at: [ 27.615199][ C2] __lock_acquire+0x518/0xc20 [ 27.615340][ C2] lock_acquire.part.0+0xd4/0x280 [ 27.615525][ C2] fs_reclaim_acquire+0xd5/0x120 [ 27.615659][ C2] __kmalloc_noprof+0xd3/0x760 [ 27.615837][ C2] alloc_buf.isra.0+0x4b/0x260 [ 27.615970][ C2] put_chars+0x1e1/0x2f0 [ 27.616153][ C2] hvc_console_print+0x292/0x780 [ 27.616288][ C2] console_emit_next_record+0x22f/0x4c0 [ 27.616466][ C2] console_flush_one_record+0x46f/0x710 [ 27.616605][ C2] console_unlock+0xee/0x1f0 [ 27.616783][ C2] vprintk_emit+0x37c/0x3e0 [ 27.616918][ C2] dev_vprintk_emit+0x27f/0x2c0 [ 27.617099][ C2] dev_printk_emit+0xb9/0xee [ 27.617236][ C2] _dev_info+0xe2/0x116 [ 27.617382][ C2] __devm_rtc_register_device.cold+0xc3/0x3a8 [ 27.617557][ C2] cmos_do_probe+0x73b/0x98a [ 27.617737][ C2] platform_probe+0xfe/0x1f0 [ 27.617872][ C2] call_driver_probe+0x61/0x1c0 [ 27.618051][ C2] really_probe+0x199/0x760 [ 27.618185][ C2] __driver_probe_device+0x24f/0x440 [ 27.618364][ C2] driver_probe_device+0x4a/0xf0 [ 27.618505][ C2] __driver_attach+0x1b8/0x540 [ 27.618687][ C2] bus_for_each_dev+0x130/0x1e0 [ 27.618824][ C2] bus_add_driver+0x2c8/0x530 [ 27.619003][ C2] driver_register+0x1a3/0x390 [ 27.619140][ C2] __platform_driver_probe+0x13f/0x270 [ 27.619318][ C2] cmos_init+0x31/0x40 [ 27.619421][ C2] do_one_initcall+0x124/0x4f0 [ 27.619608][ C2] kernel_init_freeable+0x596/0x630 [ 27.619742][ C2] kernel_init+0x21/0x150 [ 27.619917][ C2] ret_from_fork+0x474/0x6b0 [ 27.620055][ C2] ret_from_fork_asm+0x11/0x20 [ 27.620232][ C2] [ 27.620302][ C2] -> (console_owner){....}-{0:0} { [ 27.620439][ C2] INITIAL USE at: [ 27.620550][ C2] } [ 27.620617][ C2] ... key at: [] console_owner_dep_map+0x0/0x60 [ 27.620863][ C2] ... acquired at: [ 27.620960][ C2] __lock_acquire+0x518/0xc20 [ 27.621138][ C2] lock_acquire.part.0+0xd4/0x280 [ 27.621271][ C2] console_lock_spinning_enable+0x5c/0x60 [ 27.621486][ C2] console_emit_next_record+0x1d1/0x4c0 [ 27.621624][ C2] console_flush_one_record+0x46f/0x710 [ 27.621804][ C2] console_unlock+0xee/0x1f0 [ 27.621941][ C2] vprintk_emit+0x37c/0x3e0 [ 27.622118][ C2] _printk+0xc7/0x100 [ 27.622220][ C2] br_set_state+0x22f/0x430 [bridge] [ 27.622407][ C2] br_init_port+0xc4/0x200 [bridge] [ 27.622554][ C2] br_stp_enable_port+0x12/0x50 [bridge] [ 27.622772][ C2] br_port_carrier_check+0x220/0x430 [bridge] [ 27.622996][ C2] br_device_event+0x52d/0x8f0 [bridge] [ 27.623135][ C2] notifier_call_chain+0xae/0x300 [ 27.623320][ C2] netif_state_change+0x139/0x340 [ 27.623457][ C2] __linkwatch_run_queue+0x34c/0x750 [ 27.623642][ C2] linkwatch_event+0x7f/0xb0 [ 27.623777][ C2] process_one_work+0xe3e/0x1560 [ 27.623960][ C2] worker_thread+0x4f1/0xd60 [ 27.624097][ C2] kthread+0x367/0x460 [ 27.624199][ C2] ret_from_fork+0x474/0x6b0 [ 27.624381][ C2] ret_from_fork_asm+0x11/0x20 [ 27.624524][ C2] [ 27.624636][ C2] -> (&br->lock){+.-.}-{3:3} { [ 27.624774][ C2] HARDIRQ-ON-W at: [ 27.624922][ C2] __lock_acquire+0x388/0xc20 [ 27.625093][ C2] lock_acquire.part.0+0xd4/0x280 [ 27.625309][ C2] _raw_spin_lock_bh+0x38/0x50 [ 27.625478][ C2] br_add_if+0x8c1/0x1320 [bridge] [ 27.625701][ C2] do_set_master+0x357/0x580 [ 27.625925][ C2] do_setlink.isra.0+0xa31/0x2750 [ 27.626096][ C2] rtnl_newlink+0x9f1/0x11c0 [ 27.626313][ C2] rtnetlink_rcv_msg+0x6fd/0xbd0 [ 27.626532][ C2] netlink_rcv_skb+0x14e/0x3a0 [ 27.626701][ C2] netlink_unicast+0x486/0x750 [ 27.626916][ C2] netlink_sendmsg+0x735/0xc60 [ 27.627086][ C2] ____sys_sendmsg+0x415/0x880 [ 27.627299][ C2] ___sys_sendmsg+0x14e/0x1d0 [ 27.627472][ C2] __sys_sendmsg+0x12c/0x1d0 [ 27.627649][ C2] do_syscall_64+0xff/0x530 [ 27.627862][ C2] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 27.628110][ C2] IN-SOFTIRQ-W at: [ 27.628211][ C2] __lock_acquire+0x388/0xc20 [ 27.628426][ C2] lock_acquire.part.0+0xd4/0x280 [ 27.628601][ C2] _raw_spin_lock+0x33/0x40 [ 27.628811][ C2] br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 27.629064][ C2] call_timer_fn+0x160/0x4d0 [ 27.629233][ C2] __run_timers+0x68f/0xaa0 [ 27.633713][ C2] run_timer_softirq+0xf0/0x160 [ 27.633943][ C2] handle_softirqs+0x1d3/0x900 [ 27.634126][ C2] __irq_exit_rcu+0x145/0x1c0 [ 27.634346][ C2] irq_exit_rcu+0xe/0x30 [ 27.634564][ C2] sysvec_apic_timer_interrupt+0x9d/0xe0 [ 27.634772][ C2] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 27.635024][ C2] pv_native_safe_halt+0xf/0x10 [ 27.635239][ C2] default_idle+0x9/0x10 [ 27.635410][ C2] default_idle_call+0x6e/0xb0 [ 27.635631][ C2] cpuidle_idle_call.constprop.0+0x237/0x410 [ 27.635881][ C2] do_idle+0xd8/0x190 [ 27.636018][ C2] cpu_startup_entry+0x53/0x70 [ 27.636235][ C2] start_secondary+0x204/0x2b0 [ 27.636403][ C2] common_startup_64+0x13e/0x148 [ 27.636580][ C2] INITIAL USE at: [ 27.636683][ C2] __lock_acquire+0x388/0xc20 [ 27.636897][ C2] lock_acquire.part.0+0xd4/0x280 [ 27.637108][ C2] _raw_spin_lock_bh+0x38/0x50 [ 27.637281][ C2] br_add_if+0x8c1/0x1320 [bridge] [ 27.637509][ C2] do_set_master+0x357/0x580 [ 27.637726][ C2] do_setlink.isra.0+0xa31/0x2750 [ 27.637897][ C2] rtnl_newlink+0x9f1/0x11c0 [ 27.638113][ C2] rtnetlink_rcv_msg+0x6fd/0xbd0 [ 27.638283][ C2] netlink_rcv_skb+0x14e/0x3a0 [ 27.638504][ C2] netlink_unicast+0x486/0x750 [ 27.638723][ C2] netlink_sendmsg+0x735/0xc60 [ 27.638893][ C2] ____sys_sendmsg+0x415/0x880 [ 27.639106][ C2] ___sys_sendmsg+0x14e/0x1d0 [ 27.639327][ C2] __sys_sendmsg+0x12c/0x1d0 [ 27.639503][ C2] do_syscall_64+0xff/0x530 [ 27.639723][ C2] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 27.639971][ C2] } [ 27.640043][ C2] ... key at: [] __key.7+0x0/0x40 [bridge] [ 27.640292][ C2] ... acquired at: [ 27.640392][ C2] mark_lock+0x1d7/0xa00 [ 27.640538][ C2] mark_usage+0x42/0x170 [ 27.640717][ C2] __lock_acquire+0x388/0xc20 [ 27.640850][ C2] lock_acquire.part.0+0xd4/0x280 [ 27.641028][ C2] _raw_spin_lock+0x33/0x40 [ 27.641164][ C2] br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 27.641380][ C2] call_timer_fn+0x160/0x4d0 [ 27.641564][ C2] __run_timers+0x68f/0xaa0 [ 27.641699][ C2] run_timer_softirq+0xf0/0x160 [ 27.641878][ C2] handle_softirqs+0x1d3/0x900 [ 27.642014][ C2] __irq_exit_rcu+0x145/0x1c0 [ 27.642193][ C2] irq_exit_rcu+0xe/0x30 [ 27.642328][ C2] sysvec_apic_timer_interrupt+0x9d/0xe0 [ 27.642549][ C2] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 27.642711][ C2] pv_native_safe_halt+0xf/0x10 [ 27.642887][ C2] default_idle+0x9/0x10 [ 27.643018][ C2] default_idle_call+0x6e/0xb0 [ 27.643196][ C2] cpuidle_idle_call.constprop.0+0x237/0x410 [ 27.643360][ C2] do_idle+0xd8/0x190 [ 27.643508][ C2] cpu_startup_entry+0x53/0x70 [ 27.643641][ C2] start_secondary+0x204/0x2b0 [ 27.643818][ C2] common_startup_64+0x13e/0x148 [ 27.643952][ C2] [ 27.644065][ C2] [ 27.644065][ C2] stack backtrace: [ 27.644238][ C2] CPU: 2 UID: 0 PID: 0 Comm: swapper/2 Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 27.644242][ C2] Tainted: [W]=WARN [ 27.644243][ C2] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 27.644244][ C2] Call Trace: [ 27.644246][ C2] [ 27.644247][ C2] dump_stack_lvl+0x6f/0xa0 [ 27.644252][ C2] print_irq_inversion_bug.part.0.cold+0xe6/0x143 [ 27.644255][ C2] mark_lock_irq+0x989/0x9c0 [ 27.644258][ C2] mark_lock+0x1d7/0xa00 [ 27.644260][ C2] mark_usage+0x42/0x170 [ 27.644262][ C2] __lock_acquire+0x388/0xc20 [ 27.644264][ C2] lock_acquire.part.0+0xd4/0x280 [ 27.644266][ C2] ? br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 27.644273][ C2] ? rcu_is_watching+0x16/0xd0 [ 27.644276][ C2] ? lock_acquire+0x13c/0x160 [ 27.644278][ C2] ? br_message_age_timer_expired+0x70/0x70 [bridge] [ 27.644284][ C2] _raw_spin_lock+0x33/0x40 [ 27.644286][ C2] ? br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 27.644292][ C2] br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 27.644298][ C2] ? br_message_age_timer_expired+0x70/0x70 [bridge] [ 27.644305][ C2] call_timer_fn+0x160/0x4d0 [ 27.644307][ C2] ? detach_if_pending+0x1d0/0x1d0 [ 27.644308][ C2] ? debug_object_active_state+0x430/0x430 [ 27.644312][ C2] ? find_held_lock+0x2b/0x80 [ 27.644314][ C2] ? __lock_release.isra.0+0x69/0x1a0 [ 27.644316][ C2] ? rcu_is_watching+0x16/0xd0 [ 27.644318][ C2] __run_timers+0x68f/0xaa0 [ 27.644320][ C2] ? br_message_age_timer_expired+0x70/0x70 [bridge] [ 27.644327][ C2] ? __bpf_trace_itimer_expire+0x10/0x10 [ 27.644329][ C2] ? __lock_acquire+0x518/0xc20 [ 27.644331][ C2] ? __rwlock_init+0x150/0x150 [ 27.644334][ C2] run_timer_softirq+0xf0/0x160 [ 27.644336][ C2] ? __run_timers+0xaa0/0xaa0 [ 27.644337][ C2] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 27.644340][ C2] ? rcu_is_watching+0x16/0xd0 [ 27.644342][ C2] handle_softirqs+0x1d3/0x900 [ 27.644344][ C2] ? __lock_release.isra.0+0x69/0x1a0 [ 27.644345][ C2] ? _local_bh_enable+0xc0/0xc0 [ 27.644347][ C2] __irq_exit_rcu+0x145/0x1c0 [ 27.644349][ C2] irq_exit_rcu+0xe/0x30 [ 27.644350][ C2] sysvec_apic_timer_interrupt+0x9d/0xe0 [ 27.644352][ C2] [ 27.644352][ C2] [ 27.644353][ C2] ? lockdep_hardirqs_on+0x91/0x130 [ 27.644355][ C2] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 27.644356][ C2] RIP: 0010:pv_native_safe_halt+0xf/0x10 [ 27.644359][ C2] Code: 48 8b 3d 94 d2 f5 01 e8 1f 00 00 00 48 2b 05 58 93 95 00 c3 0f 1f 80 00 00 00 00 f3 0f 1e fa eb 07 0f 00 2d 13 86 11 00 fb f4 0f 1f 40 d6 48 83 ec 20 8b 17 49 89 f8 83 e2 fe 41 89 d2 0f 01 [ 27.644361][ C2] RSP: 0018:ffa0000000157e00 EFLAGS: 00000282 [ 27.644363][ C2] RAX: 00000000000730d3 RBX: ff11000001bec6c0 RCX: ffffffffaaef0307 [ 27.644365][ C2] RDX: ff11000001bec6c0 RSI: ffffffffadc38af6 RDI: ffffffffad68d8e0 [ 27.644365][ C2] RBP: 0000000000000000 R08: 0000000000000000 R09: 0000000000000000 [ 27.644366][ C2] R10: 0000000000000002 R11: 0000000000000001 R12: 1ff400000002afc3 [ 27.644367][ C2] R13: 0000000000000000 R14: dffffc0000000000 R15: 0000000000000000 [ 27.644368][ C2] ? cpuidle_idle_call.constprop.0+0x237/0x410 [ 27.644371][ C2] default_idle+0x9/0x10 [ 27.644372][ C2] default_idle_call+0x6e/0xb0 [ 27.644374][ C2] cpuidle_idle_call.constprop.0+0x237/0x410 [ 27.644376][ C2] ? arch_cpu_idle_exit+0x40/0x40 [ 27.644377][ C2] ? mark_tsc_async_resets+0x30/0x30 [ 27.644379][ C2] ? rcu_is_watching+0x16/0xd0 [ 27.644381][ C2] do_idle+0xd8/0x190 [ 27.644383][ C2] cpu_startup_entry+0x53/0x70 [ 27.644384][ C2] start_secondary+0x204/0x2b0 [ 27.644386][ C2] ? set_cpu_sibling_map+0x2130/0x2130 [ 27.644388][ C2] common_startup_64+0x13e/0x148 [ 27.644391][ C2] [ 27.791746][ T259] GACT probability NOT on [ 28.973480][ T268] br0: port 2(veth2) entered disabled state [ 28.973501][ T268] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 28.973503][ T268] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 268, name: ip [ 28.973505][ T268] preempt_count: 202, expected: 0 [ 28.973506][ T268] RCU nest depth: 0, expected: 0 [ 28.973507][ T268] INFO: lockdep is turned off. [ 28.973509][ T268] irq event stamp: 0 [ 28.973509][ T268] hardirqs last enabled at (0): [<0000000000000000>] 0x0 [ 28.973514][ T268] hardirqs last disabled at (0): [] copy_process+0x1ccd/0x6240 [ 28.973520][ T268] softirqs last enabled at (0): [] copy_process+0x1d21/0x6240 [ 28.973522][ T268] softirqs last disabled at (0): [<0000000000000000>] 0x0 [ 28.973523][ T268] Preemption disabled at: [ 28.973524][ T268] [<0000000000000000>] 0x0 [ 28.973529][ T268] CPU: 0 UID: 0 PID: 268 Comm: ip Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 28.973533][ T268] Tainted: [W]=WARN [ 28.973534][ T268] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 28.973535][ T268] Call Trace: [ 28.973537][ T268] [ 28.973538][ T268] dump_stack_lvl+0x6f/0xa0 [ 28.973544][ T268] __might_resched.cold+0x1fe/0x2c1 [ 28.973548][ T268] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 28.973551][ T268] ? rcu_is_watching+0x16/0xd0 [ 28.973555][ T268] __kmalloc_noprof+0x443/0x760 [ 28.973559][ T268] ? __rwlock_init+0x150/0x150 [ 28.973561][ T268] ? alloc_buf.isra.0+0x4b/0x260 [ 28.973565][ T268] ? do_raw_spin_unlock+0x59/0x250 [ 28.973567][ T268] alloc_buf.isra.0+0x4b/0x260 [ 28.973569][ T268] put_chars+0x1e1/0x2f0 [ 28.973571][ T268] ? __send_to_port+0x420/0x420 [ 28.973572][ T268] ? printk_get_next_message+0x240/0x650 [ 28.973576][ T268] hvc_console_print+0x292/0x780 [ 28.973579][ T268] ? hvc_write+0x3a0/0x3a0 [ 28.973581][ T268] ? __rwlock_init+0x150/0x150 [ 28.973583][ T268] ? rcu_is_watching+0x16/0xd0 [ 28.973585][ T268] ? lock_acquire+0x13c/0x160 [ 28.973587][ T268] console_emit_next_record+0x22f/0x4c0 [ 28.973589][ T268] ? devkmsg_read+0x4b0/0x4b0 [ 28.973591][ T268] ? rcu_is_watching+0x16/0xd0 [ 28.973593][ T268] ? rcu_is_watching+0x16/0xd0 [ 28.973594][ T268] ? rcu_is_watching+0x16/0xd0 [ 28.973596][ T268] ? lock_acquire+0x13c/0x160 [ 28.973598][ T268] ? console_flush_one_record+0x111/0x710 [ 28.973600][ T268] console_flush_one_record+0x46f/0x710 [ 28.973602][ T268] ? console_emit_next_record+0x4c0/0x4c0 [ 28.973605][ T268] console_unlock+0xee/0x1f0 [ 28.973606][ T268] ? lock_acquire+0x13c/0x160 [ 28.973608][ T268] ? console_flush_one_record+0x710/0x710 [ 28.973610][ T268] ? rcu_is_watching+0x16/0xd0 [ 28.973611][ T268] ? lock_release+0x184/0x1f0 [ 28.973613][ T268] ? lock_acquire+0x60/0x160 [ 28.973614][ T268] ? __rcu_read_lock+0x30/0x70 [ 28.973616][ T268] ? __down_trylock_console_sem+0x5e/0xa0 [ 28.973618][ T268] ? vprintk_emit+0x320/0x3e0 [ 28.973620][ T268] vprintk_emit+0x37c/0x3e0 [ 28.973622][ T268] ? wake_up_klogd_work_func+0x90/0x90 [ 28.973624][ T268] ? rcu_is_watching+0x16/0xd0 [ 28.973626][ T268] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 28.973628][ T268] ? trace_hardirqs_on+0x36/0x40 [ 28.973630][ T268] _printk+0xc7/0x100 [ 28.973633][ T268] ? snapshot_read.cold+0x21/0x21 [ 28.973635][ T268] ? ipv6_mc_down+0x17e/0x2d0 [ 28.973640][ T268] br_set_state+0x22f/0x430 [bridge] [ 28.973653][ T268] br_stp_disable_port+0x11f/0x390 [bridge] [ 28.973661][ T268] br_device_event+0x7b5/0x8f0 [bridge] [ 28.973670][ T268] ? _raw_spin_unlock_irqrestore+0x40/0x80 [ 28.973673][ T268] ? _sub_I_65535_1+0x4d0/0x4d0 [stp] [ 28.973675][ T268] ? addrconf_notify+0x2c8/0xf30 [ 28.973679][ T268] notifier_call_chain+0xae/0x300 [ 28.973682][ T268] __dev_notify_flags+0x23c/0x3c0 [ 28.973686][ T268] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 28.973687][ T268] ? netif_change_name+0x8c0/0x8c0 [ 28.973689][ T268] ? netif_set_allmulti+0x250/0x250 [ 28.973691][ T268] ? __kernel_text_address+0x12/0x30 [ 28.973694][ T268] ? write_profile+0xf0/0xf0 [ 28.973696][ T268] ? unwind_get_return_address+0x67/0xd0 [ 28.973699][ T268] netif_change_flags+0xfe/0x190 [ 28.973701][ T268] do_setlink.isra.0+0x1cc3/0x2750 [ 28.973704][ T268] ? stack_trace_save+0x93/0xc0 [ 28.973705][ T268] ? rtnl_link_get_size+0x350/0x350 [ 28.973707][ T268] ? rcu_is_watching+0x16/0xd0 [ 28.973708][ T268] ? stack_depot_save_flags+0x1bc/0x790 [ 28.973712][ T268] ? kasan_save_stack+0x3d/0x50 [ 28.973715][ T268] ? kasan_save_stack+0x2f/0x50 [ 28.973717][ T268] ? kasan_save_track+0x14/0x30 [ 28.973718][ T268] ? __kasan_kmalloc+0x7b/0x90 [ 28.973720][ T268] ? __kmalloc_cache_noprof+0x29a/0x620 [ 28.973721][ T268] ? rtnl_newlink+0x124/0x11c0 [ 28.973722][ T268] ? rtnetlink_rcv_msg+0x6fd/0xbd0 [ 28.973723][ T268] ? netlink_rcv_skb+0x14e/0x3a0 [ 28.973726][ T268] ? netlink_unicast+0x486/0x750 [ 28.973727][ T268] ? netlink_sendmsg+0x735/0xc60 [ 28.973729][ T268] ? ____sys_sendmsg+0x415/0x880 [ 28.973731][ T268] ? ___sys_sendmsg+0x14e/0x1d0 [ 28.973733][ T268] ? __sys_sendmsg+0x12c/0x1d0 [ 28.973734][ T268] ? do_syscall_64+0xff/0x530 [ 28.973736][ T268] ? entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 28.973739][ T268] ? rcu_is_watching+0x16/0xd0 [ 28.973740][ T268] ? lock_acquire+0x13c/0x160 [ 28.973742][ T268] ? rcu_is_watching+0x16/0xd0 [ 28.973743][ T268] ? rcu_is_watching+0x16/0xd0 [ 28.973745][ T268] ? trace_contention_end+0xb3/0x180 [ 28.973748][ T268] ? __mutex_lock+0x1db/0x1ea0 [ 28.973750][ T268] ? __mutex_lock+0x9a3/0x1ea0 [ 28.973751][ T268] ? rtnl_newlink+0x9a8/0x11c0 [ 28.973753][ T268] ? ww_mutex_lock+0x160/0x160 [ 28.973755][ T268] ? __rtnl_newlink+0x3fa/0xa50 [ 28.973757][ T268] rtnl_newlink+0x9f1/0x11c0 [ 28.973759][ T268] ? rcu_is_watching+0x16/0xd0 [ 28.973761][ T268] ? rtnl_bridge_getlink+0x850/0x850 [ 28.973762][ T268] ? lock_acquire+0x13c/0x160 [ 28.973763][ T268] ? rcu_is_watching+0x16/0xd0 [ 28.973765][ T268] ? is_bpf_text_address+0x3e/0x110 [ 28.973768][ T268] ? is_bpf_text_address+0x72/0x110 [ 28.973770][ T268] ? kernel_text_address+0x149/0x170 [ 28.973771][ T268] ? __kernel_text_address+0x12/0x30 [ 28.973773][ T268] ? write_profile+0xf0/0xf0 [ 28.973774][ T268] ? unwind_get_return_address+0x67/0xd0 [ 28.973775][ T268] ? rcu_is_watching+0x16/0xd0 [ 28.973777][ T268] ? rcu_is_watching+0x16/0xd0 [ 28.973779][ T268] ? cap_capable+0x1d7/0x3d0 [ 28.973782][ T268] ? lock_acquire+0x13c/0x160 [ 28.973783][ T268] ? rcu_is_watching+0x16/0xd0 [ 28.973785][ T268] ? rtnl_bridge_getlink+0x850/0x850 [ 28.973787][ T268] rtnetlink_rcv_msg+0x6fd/0xbd0 [ 28.973788][ T268] ? rtnl_link_fill+0x920/0x920 [ 28.973790][ T268] ? filter_irq_stacks+0xd0/0xd0 [ 28.973791][ T268] ? stack_depot_save_flags+0x1bc/0x790 [ 28.973793][ T268] netlink_rcv_skb+0x14e/0x3a0 [ 28.973795][ T268] ? rtnl_link_fill+0x920/0x920 [ 28.973796][ T268] ? lock_release+0x184/0x1f0 [ 28.973798][ T268] ? netlink_ack+0xcf0/0xcf0 [ 28.973799][ T268] ? __netlink_lookup+0xb9/0x6b0 [ 28.973801][ T268] ? rcu_is_watching+0x16/0xd0 [ 28.973803][ T268] ? lock_release+0x184/0x1f0 [ 28.973805][ T268] netlink_unicast+0x486/0x750 [ 28.973807][ T268] ? netlink_attachskb+0x810/0x810 [ 28.973809][ T268] ? rcu_is_watching+0x16/0xd0 [ 28.973810][ T268] ? rcu_is_watching+0x16/0xd0 [ 28.973812][ T268] ? lock_acquire+0x13c/0x160 [ 28.973814][ T268] netlink_sendmsg+0x735/0xc60 [ 28.973816][ T268] ? netlink_unicast+0x750/0x750 [ 28.973817][ T268] ? rcu_is_watching+0x16/0xd0 [ 28.973819][ T268] ? lock_release+0x184/0x1f0 [ 28.973821][ T268] ____sys_sendmsg+0x415/0x880 [ 28.973823][ T268] ? copy_msghdr_from_user+0x279/0x420 [ 28.973824][ T268] ? get_timestamp.constprop.0+0x390/0x390 [ 28.973826][ T268] ? move_addr_to_kernel+0x40/0x40 [ 28.973827][ T268] ? filter_irq_stacks+0xd0/0xd0 [ 28.973830][ T268] ___sys_sendmsg+0x14e/0x1d0 [ 28.973831][ T268] ? copy_msghdr_from_user+0x420/0x420 [ 28.973836][ T268] __sys_sendmsg+0x12c/0x1d0 [ 28.973838][ T268] ? __sys_sendmsg_sock+0x20/0x20 [ 28.973841][ T268] ? rcu_is_watching+0x16/0xd0 [ 28.973843][ T268] do_syscall_64+0xff/0x530 [ 28.973844][ T268] ? exc_page_fault+0xee/0x100 [ 28.973846][ T268] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 28.973848][ T268] RIP: 0033:0x7fdc2ea6e54e [ 28.973850][ 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 [ 28.973852][ T268] RSP: 002b:00007fff58d006f0 EFLAGS: 00000202 ORIG_RAX: 000000000000002e [ 28.973855][ T268] RAX: ffffffffffffffda RBX: 0000000000000003 RCX: 00007fdc2ea6e54e [ 28.973857][ T268] RDX: 0000000000000000 RSI: 00007fff58d007a0 RDI: 0000000000000005 [ 28.973858][ T268] RBP: 00007fff58d00700 R08: 0000000000000000 R09: 0000000000000000 [ 28.973858][ T268] R10: 0000000000000000 R11: 0000000000000202 R12: 000000006a918234 [ 28.973859][ T268] R13: 00000000004a1620 R14: 0000000000000000 R15: 00007fff58d00e60 [ 28.973862][ T268] [ 29.001888][ T268] ip (268) used greatest stack depth: 23016 bytes left [ 29.061727][ T93] br0: port 2(veth2) entered blocking state [ 29.061979][ T93] br0: port 2(veth2) entered forwarding state [ 35.290898][ T292] br0: port 1(veth1) entered disabled state [ 35.290914][ T292] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 35.290916][ T292] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 292, name: ip [ 35.290918][ T292] preempt_count: 202, expected: 0 [ 35.290919][ T292] RCU nest depth: 0, expected: 0 [ 35.290920][ T292] INFO: lockdep is turned off. [ 35.290921][ T292] irq event stamp: 0 [ 35.290922][ T292] hardirqs last enabled at (0): [<0000000000000000>] 0x0 [ 35.290926][ T292] hardirqs last disabled at (0): [] copy_process+0x1ccd/0x6240 [ 35.290932][ T292] softirqs last enabled at (0): [] copy_process+0x1d21/0x6240 [ 35.290934][ T292] softirqs last disabled at (0): [<0000000000000000>] 0x0 [ 35.290936][ T292] Preemption disabled at: [ 35.290936][ T292] [<0000000000000000>] 0x0 [ 35.290941][ T292] CPU: 1 UID: 0 PID: 292 Comm: ip Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 35.290945][ T292] Tainted: [W]=WARN [ 35.290946][ T292] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 35.290947][ T292] Call Trace: [ 35.290949][ T292] [ 35.290950][ T292] dump_stack_lvl+0x6f/0xa0 [ 35.290955][ T292] __might_resched.cold+0x1fe/0x2c1 [ 35.290959][ T292] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 35.290963][ T292] ? rcu_is_watching+0x16/0xd0 [ 35.290968][ T292] __kmalloc_noprof+0x443/0x760 [ 35.290973][ T292] ? __rwlock_init+0x150/0x150 [ 35.290976][ T292] ? alloc_buf.isra.0+0x4b/0x260 [ 35.290981][ T292] ? do_raw_spin_unlock+0x59/0x250 [ 35.290983][ T292] alloc_buf.isra.0+0x4b/0x260 [ 35.290986][ T292] put_chars+0x1e1/0x2f0 [ 35.290988][ T292] ? __send_to_port+0x420/0x420 [ 35.290991][ T292] ? printk_get_next_message+0x240/0x650 [ 35.290995][ T292] hvc_console_print+0x292/0x780 [ 35.291000][ T292] ? hvc_write+0x3a0/0x3a0 [ 35.291003][ T292] ? __rwlock_init+0x150/0x150 [ 35.291005][ T292] ? rcu_is_watching+0x16/0xd0 [ 35.291007][ T292] ? lock_acquire+0x13c/0x160 [ 35.291010][ T292] console_emit_next_record+0x22f/0x4c0 [ 35.291014][ T292] ? devkmsg_read+0x4b0/0x4b0 [ 35.291017][ T292] ? rcu_is_watching+0x16/0xd0 [ 35.291019][ T292] ? rcu_is_watching+0x16/0xd0 [ 35.291021][ T292] ? rcu_is_watching+0x16/0xd0 [ 35.291023][ T292] ? lock_acquire+0x13c/0x160 [ 35.291026][ T292] ? console_flush_one_record+0x111/0x710 [ 35.291028][ T292] console_flush_one_record+0x46f/0x710 [ 35.291032][ T292] ? console_emit_next_record+0x4c0/0x4c0 [ 35.291035][ T292] console_unlock+0xee/0x1f0 [ 35.291038][ T292] ? lock_acquire+0x13c/0x160 [ 35.291040][ T292] ? console_flush_one_record+0x710/0x710 [ 35.291042][ T292] ? rcu_is_watching+0x16/0xd0 [ 35.291045][ T292] ? lock_release+0x184/0x1f0 [ 35.291047][ T292] ? lock_acquire+0x60/0x160 [ 35.291049][ T292] ? __rcu_read_lock+0x30/0x70 [ 35.291052][ T292] ? __down_trylock_console_sem+0x5e/0xa0 [ 35.291054][ T292] ? vprintk_emit+0x320/0x3e0 [ 35.291057][ T292] vprintk_emit+0x37c/0x3e0 [ 35.291060][ T292] ? wake_up_klogd_work_func+0x90/0x90 [ 35.291063][ T292] ? rcu_is_watching+0x16/0xd0 [ 35.291065][ T292] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 35.291068][ T292] ? trace_hardirqs_on+0x36/0x40 [ 35.291071][ T292] _printk+0xc7/0x100 [ 35.291075][ T292] ? snapshot_read.cold+0x21/0x21 [ 35.291078][ T292] ? ipv6_mc_down+0x17e/0x2d0 [ 35.291083][ T292] br_set_state+0x22f/0x430 [bridge] [ 35.291101][ T292] br_stp_disable_port+0x11f/0x390 [bridge] [ 35.291113][ T292] br_device_event+0x7b5/0x8f0 [bridge] [ 35.291125][ T292] ? _raw_spin_unlock_irqrestore+0x40/0x80 [ 35.291130][ T292] ? _sub_I_65535_1+0x4d0/0x4d0 [stp] [ 35.291133][ T292] ? addrconf_notify+0x2c8/0xf30 [ 35.291138][ T292] notifier_call_chain+0xae/0x300 [ 35.291142][ T292] __dev_notify_flags+0x23c/0x3c0 [ 35.291147][ T292] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 35.291149][ T292] ? netif_change_name+0x8c0/0x8c0 [ 35.291152][ T292] ? netif_set_allmulti+0x250/0x250 [ 35.291155][ T292] ? __kernel_text_address+0x12/0x30 [ 35.291157][ T292] ? write_profile+0xf0/0xf0 [ 35.291160][ T292] ? unwind_get_return_address+0x67/0xd0 [ 35.291164][ T292] netif_change_flags+0xfe/0x190 [ 35.291167][ T292] do_setlink.isra.0+0x1cc3/0x2750 [ 35.291171][ T292] ? stack_trace_save+0x93/0xc0 [ 35.291173][ T292] ? rtnl_link_get_size+0x350/0x350 [ 35.291175][ T292] ? rcu_is_watching+0x16/0xd0 [ 35.291178][ T292] ? stack_depot_save_flags+0x1bc/0x790 [ 35.291182][ T292] ? kasan_save_stack+0x3d/0x50 [ 35.291186][ T292] ? kasan_save_stack+0x2f/0x50 [ 35.291188][ T292] ? kasan_save_track+0x14/0x30 [ 35.291190][ T292] ? __kasan_kmalloc+0x7b/0x90 [ 35.291192][ T292] ? __kmalloc_cache_noprof+0x29a/0x620 [ 35.291194][ T292] ? rtnl_newlink+0x124/0x11c0 [ 35.291196][ T292] ? rtnetlink_rcv_msg+0x6fd/0xbd0 [ 35.291198][ T292] ? netlink_rcv_skb+0x14e/0x3a0 [ 35.291201][ T292] ? netlink_unicast+0x486/0x750 [ 35.291203][ T292] ? netlink_sendmsg+0x735/0xc60 [ 35.291205][ T292] ? ____sys_sendmsg+0x415/0x880 [ 35.291208][ T292] ? ___sys_sendmsg+0x14e/0x1d0 [ 35.291210][ T292] ? __sys_sendmsg+0x12c/0x1d0 [ 35.291213][ T292] ? do_syscall_64+0xff/0x530 [ 35.291216][ T292] ? entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 35.291219][ T292] ? rcu_is_watching+0x16/0xd0 [ 35.291222][ T292] ? lock_acquire+0x13c/0x160 [ 35.291224][ T292] ? rcu_is_watching+0x16/0xd0 [ 35.291226][ T292] ? rcu_is_watching+0x16/0xd0 [ 35.291228][ T292] ? trace_contention_end+0xb3/0x180 [ 35.291232][ T292] ? __mutex_lock+0x1db/0x1ea0 [ 35.291234][ T292] ? __mutex_lock+0x9a3/0x1ea0 [ 35.291236][ T292] ? rtnl_newlink+0x9a8/0x11c0 [ 35.291238][ T292] ? ww_mutex_lock+0x160/0x160 [ 35.291242][ T292] ? __rtnl_newlink+0x3fa/0xa50 [ 35.291245][ T292] rtnl_newlink+0x9f1/0x11c0 [ 35.291248][ T292] ? rcu_is_watching+0x16/0xd0 [ 35.291251][ T292] ? rtnl_bridge_getlink+0x850/0x850 [ 35.291252][ T292] ? lock_acquire+0x13c/0x160 [ 35.291255][ T292] ? rcu_is_watching+0x16/0xd0 [ 35.291257][ T292] ? is_bpf_text_address+0x3e/0x110 [ 35.291261][ T292] ? is_bpf_text_address+0x72/0x110 [ 35.291264][ T292] ? kernel_text_address+0x149/0x170 [ 35.291266][ T292] ? __kernel_text_address+0x12/0x30 [ 35.291268][ T292] ? write_profile+0xf0/0xf0 [ 35.291270][ T292] ? unwind_get_return_address+0x67/0xd0 [ 35.291272][ T292] ? rcu_is_watching+0x16/0xd0 [ 35.291274][ T292] ? rcu_is_watching+0x16/0xd0 [ 35.291276][ T292] ? cap_capable+0x1d7/0x3d0 [ 35.291281][ T292] ? lock_acquire+0x13c/0x160 [ 35.291283][ T292] ? rcu_is_watching+0x16/0xd0 [ 35.291285][ T292] ? rtnl_bridge_getlink+0x850/0x850 [ 35.291287][ T292] rtnetlink_rcv_msg+0x6fd/0xbd0 [ 35.291290][ T292] ? rtnl_link_fill+0x920/0x920 [ 35.291292][ T292] ? filter_irq_stacks+0xd0/0xd0 [ 35.291294][ T292] ? stack_depot_save_flags+0x1bc/0x790 [ 35.291298][ T292] netlink_rcv_skb+0x14e/0x3a0 [ 35.291300][ T292] ? rtnl_link_fill+0x920/0x920 [ 35.291302][ T292] ? lock_release+0x184/0x1f0 [ 35.291305][ T292] ? netlink_ack+0xcf0/0xcf0 [ 35.291307][ T292] ? __netlink_lookup+0xb9/0x6b0 [ 35.291310][ T292] ? rcu_is_watching+0x16/0xd0 [ 35.291313][ T292] ? lock_release+0x184/0x1f0 [ 35.291316][ T292] netlink_unicast+0x486/0x750 [ 35.291318][ T292] ? netlink_attachskb+0x810/0x810 [ 35.291321][ T292] ? rcu_is_watching+0x16/0xd0 [ 35.291323][ T292] ? rcu_is_watching+0x16/0xd0 [ 35.291325][ T292] ? lock_acquire+0x13c/0x160 [ 35.291328][ T292] netlink_sendmsg+0x735/0xc60 [ 35.291331][ T292] ? netlink_unicast+0x750/0x750 [ 35.291334][ T292] ? rcu_is_watching+0x16/0xd0 [ 35.291336][ T292] ? lock_release+0x184/0x1f0 [ 35.291339][ T292] ____sys_sendmsg+0x415/0x880 [ 35.291341][ T292] ? copy_msghdr_from_user+0x279/0x420 [ 35.291343][ T292] ? get_timestamp.constprop.0+0x390/0x390 [ 35.291346][ T292] ? move_addr_to_kernel+0x40/0x40 [ 35.291348][ T292] ? filter_irq_stacks+0xd0/0xd0 [ 35.291352][ T292] ___sys_sendmsg+0x14e/0x1d0 [ 35.291354][ T292] ? copy_msghdr_from_user+0x420/0x420 [ 35.291362][ T292] __sys_sendmsg+0x12c/0x1d0 [ 35.291365][ T292] ? __sys_sendmsg_sock+0x20/0x20 [ 35.291369][ T292] ? rcu_is_watching+0x16/0xd0 [ 35.291372][ T292] do_syscall_64+0xff/0x530 [ 35.291373][ T292] ? exc_page_fault+0xee/0x100 [ 35.291377][ T292] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 35.291379][ T292] RIP: 0033:0x7fba1ab3454e [ 35.291382][ T292] 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 [ 35.291384][ T292] RSP: 002b:00007ffeb16dac80 EFLAGS: 00000202 ORIG_RAX: 000000000000002e [ 35.291389][ T292] RAX: ffffffffffffffda RBX: 0000000000000003 RCX: 00007fba1ab3454e [ 35.291391][ T292] RDX: 0000000000000000 RSI: 00007ffeb16dad30 RDI: 0000000000000005 [ 35.291392][ T292] RBP: 00007ffeb16dac90 R08: 0000000000000000 R09: 0000000000000000 [ 35.291393][ T292] R10: 0000000000000000 R11: 0000000000000202 R12: 000000006a91823a [ 35.291395][ T292] R13: 00000000004a1620 R14: 0000000000000000 R15: 00007ffeb16db3f0 [ 35.291398][ T292] [ 35.342014][ T293] br0: port 2(veth2) entered disabled state [ 35.360789][ T294] veth2: left allmulticast mode [ 35.360962][ T294] veth2: left promiscuous mode [ 35.361171][ T294] br0: port 2(veth2) entered disabled state [ 35.361748][ T294] veth1: left allmulticast mode [ 35.361886][ T294] veth1: left promiscuous mode [ 35.362076][ T294] br0: port 1(veth1) entered disabled state