[ 9.274090][ T187] ip (187) used greatest stack depth: 24032 bytes left [ 9.274106][ T187] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 9.274108][ T187] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 187, name: ip [ 9.274110][ T187] preempt_count: 2, expected: 0 [ 9.274110][ T187] RCU nest depth: 0, expected: 0 [ 9.274112][ T187] locks held by ip/187: 5, last CPU#1: [ 9.274114][ T187] #0: ffffffff9fa027b8 (low_water_lock){+.+.}-{3:3}, at: do_exit+0x887/0xdc0 [ 9.274126][ T187] #1: ffffffff9fb69cc0 (console_lock){+.+.}-{0:0}, at: vprintk_emit+0x320/0x3e0 [ 9.274132][ T187] #2: ffffffff9fb69d38 (console_srcu){....}-{0:0}, at: console_flush_one_record+0x106/0x710 [ 9.274135][ T187] #3: ffffffff9fa89660 (console_owner){....}-{0:0}, at: console_lock_spinning_enable+0x40/0x60 [ 9.274139][ T187] #4: ffffffff9fa89560 (printk_legacy_map-wait-type-override){....}-{3:3}, at: console_emit_next_record+0x1df/0x4c0 [ 9.274143][ T187] irq event stamp: 41180 [ 9.274144][ T187] hardirqs last enabled at (41179): [] __down_trylock_console_sem+0x86/0xa0 [ 9.274146][ T187] hardirqs last disabled at (41180): [] console_emit_next_record+0x3d4/0x4c0 [ 9.274148][ T187] softirqs last enabled at (39898): [] netlink_release+0x17b/0xcf0 [ 9.274152][ T187] softirqs last disabled at (39896): [] netlink_release+0xd2/0xcf0 [ 9.274154][ T187] Preemption disabled at: [ 9.274155][ T187] [<0000000000000000>] 0x0 [ 9.274161][ T187] CPU: 1 UID: 0 PID: 187 Comm: ip Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 9.274165][ T187] Tainted: [W]=WARN [ 9.274166][ T187] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 9.274167][ T187] Call Trace: [ 9.274169][ T187] [ 9.274171][ T187] dump_stack_lvl+0x6f/0xa0 [ 9.274177][ T187] __might_resched.cold+0x1fe/0x2c1 [ 9.274181][ T187] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 9.274186][ T187] ? __kmalloc_noprof+0xdb/0x760 [ 9.274191][ T187] __kmalloc_noprof+0x443/0x760 [ 9.274193][ T187] ? alloc_buf.isra.0+0x4b/0x260 [ 9.274198][ T187] ? do_raw_spin_unlock+0x59/0x250 [ 9.274201][ T187] alloc_buf.isra.0+0x4b/0x260 [ 9.274204][ T187] put_chars+0x1e1/0x2f0 [ 9.274207][ T187] ? __send_to_port+0x420/0x420 [ 9.274208][ T187] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 9.274213][ T187] ? validate_chain+0x38b/0xc20 [ 9.274218][ T187] hvc_console_print+0x292/0x780 [ 9.274224][ T187] ? hvc_write+0x3a0/0x3a0 [ 9.274227][ T187] ? rcu_is_watching+0x16/0xd0 [ 9.274229][ T187] ? lock_acquire+0x13c/0x160 [ 9.274233][ T187] console_emit_next_record+0x22f/0x4c0 [ 9.274237][ T187] ? devkmsg_read+0x4b0/0x4b0 [ 9.274238][ T187] ? console_flush_one_record+0x106/0x710 [ 9.274242][ T187] ? rcu_is_watching+0x16/0xd0 [ 9.274244][ T187] ? lock_acquire+0x13c/0x160 [ 9.274248][ T187] console_flush_one_record+0x46f/0x710 [ 9.274252][ T187] ? console_emit_next_record+0x4c0/0x4c0 [ 9.274254][ T187] ? __lock_acquire+0x518/0xc20 [ 9.274259][ T187] console_unlock+0xee/0x1f0 [ 9.274261][ T187] ? console_flush_one_record+0x710/0x710 [ 9.274263][ T187] ? rcu_is_watching+0x16/0xd0 [ 9.274265][ T187] ? lock_acquire+0x60/0x160 [ 9.274269][ T187] ? __down_trylock_console_sem+0x5e/0xa0 [ 9.274271][ T187] ? vprintk_emit+0x320/0x3e0 [ 9.274274][ T187] vprintk_emit+0x37c/0x3e0 [ 9.274277][ T187] ? wake_up_klogd_work_func+0x90/0x90 [ 9.274281][ T187] ? __lock_acquire+0x518/0xc20 [ 9.274284][ T187] _printk+0xc7/0x100 [ 9.274288][ T187] ? snapshot_read.cold+0x21/0x21 [ 9.274291][ T187] ? do_raw_spin_lock+0x131/0x280 [ 9.274293][ T187] ? __rwlock_init+0x150/0x150 [ 9.274297][ T187] ? do_raw_spin_lock+0x131/0x280 [ 9.274300][ T187] do_exit.cold+0x82/0x9c [ 9.274303][ T187] ? exit_notify+0x890/0x890 [ 9.274305][ T187] ? __lock_release.isra.0+0x69/0x1a0 [ 9.274308][ T187] ? rcu_is_watching+0x16/0xd0 [ 9.274312][ T187] do_group_exit+0xb8/0x370 [ 9.274315][ T187] __x64_sys_exit_group+0x3c/0x50 [ 9.274316][ T187] x64_sys_call+0x1567/0x1570 [ 9.274319][ T187] do_syscall_64+0xff/0x530 [ 9.274321][ T187] ? exc_page_fault+0xee/0x100 [ 9.274325][ T187] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 9.274327][ T187] RIP: 0033:0x7f74ab4781b8 [ 9.274329][ T187] Code: Unable to access opcode bytes at 0x7f74ab47818e. [ 9.274330][ T187] RSP: 002b:00007ffe8bf78da8 EFLAGS: 00000246 ORIG_RAX: 00000000000000e7 [ 9.274333][ T187] RAX: ffffffffffffffda RBX: 00007f74ab5a8f88 RCX: 00007f74ab4781b8 [ 9.274334][ T187] RDX: 00007f74ab1c2fc8 RSI: fffffffffffffeb8 RDI: 0000000000000000 [ 9.274335][ T187] RBP: 00007ffe8bf78e00 R08: 0000000000000000 R09: 0000000000008010 [ 9.274336][ T187] R10: 00007ffe8bf78bc0 R11: 0000000000000246 R12: 0000000000000001 [ 9.274337][ T187] R13: 0000000000000000 R14: 00007f74ab5a7680 R15: 00007f74ab5a8fa0 [ 9.274343][ T187] [ 9.427853][ T193] ip (193) used greatest stack depth: 23760 bytes left [ 10.661221][ T236] br0: port 1(veth1) entered blocking state [ 10.661322][ T236] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 10.661325][ T236] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 236, name: ip [ 10.661327][ T236] preempt_count: 1, expected: 0 [ 10.661328][ T236] RCU nest depth: 0, expected: 0 [ 10.661330][ T236] locks held by ip/236: 5, last CPU#1: [ 10.661333][ T236] #0: ffffffffa02d2c40 (rtnl_mutex){+.+.}-{4:4}, at: rtnl_newlink+0x9a8/0x11c0 [ 10.661348][ T236] #1: ffffffff9fb69cc0 (console_lock){+.+.}-{0:0}, at: vprintk_emit+0x320/0x3e0 [ 10.661357][ T236] #2: ffffffff9fb69d38 (console_srcu){....}-{0:0}, at: console_flush_one_record+0x106/0x710 [ 10.661363][ T236] #3: ffffffff9fa89660 (console_owner){....}-{0:0}, at: console_lock_spinning_enable+0x40/0x60 [ 10.661370][ T236] #4: ffffffff9fa89560 (printk_legacy_map-wait-type-override){....}-{3:3}, at: console_emit_next_record+0x1df/0x4c0 [ 10.661376][ T236] irq event stamp: 16432 [ 10.661377][ T236] hardirqs last enabled at (16431): [] __down_trylock_console_sem+0x86/0xa0 [ 10.661381][ T236] hardirqs last disabled at (16432): [] console_emit_next_record+0x3d4/0x4c0 [ 10.661384][ T236] softirqs last enabled at (16342): [] __alloc_skb+0x4c2/0x5f0 [ 10.661388][ T236] softirqs last disabled at (16340): [] __alloc_skb+0x4c2/0x5f0 [ 10.661392][ T236] Preemption disabled at: [ 10.661392][ T236] [] vprintk_emit+0x31b/0x3e0 [ 10.661400][ T236] CPU: 1 UID: 0 PID: 236 Comm: ip Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 10.661405][ T236] Tainted: [W]=WARN [ 10.661406][ T236] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 10.661408][ T236] Call Trace: [ 10.661410][ T236] [ 10.661413][ T236] dump_stack_lvl+0x6f/0xa0 [ 10.661420][ T236] ? vprintk_emit+0x31b/0x3e0 [ 10.661424][ T236] __might_resched.cold+0x1fe/0x2c1 [ 10.661430][ T236] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 10.661436][ T236] ? __kmalloc_noprof+0xdb/0x760 [ 10.661443][ T236] __kmalloc_noprof+0x443/0x760 [ 10.661447][ T236] ? alloc_buf.isra.0+0x4b/0x260 [ 10.661456][ T236] ? do_raw_spin_unlock+0x59/0x250 [ 10.661459][ T236] alloc_buf.isra.0+0x4b/0x260 [ 10.661465][ T236] put_chars+0x1e1/0x2f0 [ 10.661469][ T236] ? __send_to_port+0x420/0x420 [ 10.661477][ T236] ? validate_chain+0x34a/0xc20 [ 10.661484][ T236] hvc_console_print+0x292/0x780 [ 10.661488][ T236] ? mark_usage+0x61/0x170 [ 10.661491][ T236] ? __lock_acquire+0x518/0xc20 [ 10.661493][ T236] ? __lock_acquire+0x518/0xc20 [ 10.661501][ T236] ? hvc_write+0x3a0/0x3a0 [ 10.661505][ T236] ? console_emit_next_record+0x1df/0x4c0 [ 10.661511][ T236] ? rcu_is_watching+0x16/0xd0 [ 10.661516][ T236] ? lock_acquire+0x13c/0x160 [ 10.661523][ T236] console_emit_next_record+0x22f/0x4c0 [ 10.661529][ T236] ? devkmsg_read+0x4b0/0x4b0 [ 10.661532][ T236] ? console_flush_one_record+0x106/0x710 [ 10.661536][ T236] ? rcu_is_watching+0x16/0xd0 [ 10.661540][ T236] ? lock_acquire+0x13c/0x160 [ 10.661547][ T236] console_flush_one_record+0x46f/0x710 [ 10.661554][ T236] ? console_emit_next_record+0x4c0/0x4c0 [ 10.661557][ T236] ? __lock_acquire+0x518/0xc20 [ 10.661567][ T236] console_unlock+0xee/0x1f0 [ 10.661571][ T236] ? console_flush_one_record+0x710/0x710 [ 10.661574][ T236] ? rcu_is_watching+0x16/0xd0 [ 10.661578][ T236] ? lock_acquire+0x60/0x160 [ 10.661584][ T236] ? __down_trylock_console_sem+0x5e/0xa0 [ 10.661587][ T236] ? vprintk_emit+0x320/0x3e0 [ 10.661592][ T236] vprintk_emit+0x37c/0x3e0 [ 10.661599][ T236] ? wake_up_klogd_work_func+0x90/0x90 [ 10.661602][ T236] ? __lock_release.isra.0+0x69/0x1a0 [ 10.661605][ T236] ? _raw_spin_unlock_irqrestore+0x40/0x80 [ 10.661611][ T236] ? mark_held_locks+0x40/0x70 [ 10.661617][ T236] _printk+0xc7/0x100 [ 10.661622][ T236] ? snapshot_read.cold+0x21/0x21 [ 10.661629][ T236] ? br_multicast_flood+0xab0/0xab0 [bridge] [ 10.661650][ T236] ? do_setlink.isra.0+0xa31/0x2750 [ 10.661653][ T236] ? rtnl_newlink+0x9f1/0x11c0 [ 10.661655][ T236] ? rtnetlink_rcv_msg+0x6fd/0xbd0 [ 10.661663][ T236] br_set_state+0x22f/0x430 [bridge] [ 10.661681][ T236] br_init_port+0xc4/0x200 [bridge] [ 10.661695][ T236] new_nbp+0x39c/0x580 [bridge] [ 10.661712][ T236] br_add_if+0x212/0x1320 [bridge] [ 10.661730][ T236] ? is_bpf_text_address+0x72/0x110 [ 10.661736][ T236] ? kernel_text_address+0x149/0x170 [ 10.661740][ T236] ? __kernel_text_address+0x12/0x30 [ 10.661747][ T236] do_set_master+0x357/0x580 [ 10.661755][ T236] do_setlink.isra.0+0xa31/0x2750 [ 10.661760][ T236] ? stack_trace_save+0x93/0xc0 [ 10.661765][ T236] ? rtnl_link_get_size+0x350/0x350 [ 10.661768][ T236] ? rcu_read_lock_any_held+0x66/0x90 [ 10.661771][ T236] ? stack_depot_save_flags+0x38e/0x790 [ 10.661776][ T236] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 10.661780][ T236] ? rcu_read_lock_any_held+0x3c/0x90 [ 10.661783][ T236] ? validate_chain+0x38b/0xc20 [ 10.661788][ T236] ? kasan_save_stack+0x3d/0x50 [ 10.661792][ T236] ? kasan_save_stack+0x2f/0x50 [ 10.661795][ T236] ? kasan_save_track+0x14/0x30 [ 10.661799][ T236] ? __lock_acquire+0x518/0xc20 [ 10.661802][ T236] ? netlink_seq_next+0x4e/0x60 [ 10.661806][ T236] ? ___sys_sendmsg+0xb0/0x1d0 [ 10.661813][ T236] ? lock_acquire.part.0+0xd4/0x280 [ 10.661816][ T236] ? rtnl_newlink+0x9a8/0x11c0 [ 10.661821][ T236] ? rcu_is_watching+0x16/0xd0 [ 10.661825][ T236] ? lock_acquire+0x13c/0x160 [ 10.661827][ T236] ? rcu_is_watching+0x16/0xd0 [ 10.661830][ T236] ? rcu_is_watching+0x16/0xd0 [ 10.661833][ T236] ? trace_contention_end+0xb3/0x180 [ 10.661839][ T236] ? __mutex_lock+0x1db/0x1ea0 [ 10.661842][ T236] ? __mutex_lock+0x9a3/0x1ea0 [ 10.661845][ T236] ? rtnl_newlink+0x9a8/0x11c0 [ 10.661852][ T236] ? ww_mutex_lock+0x160/0x160 [ 10.661854][ T236] ? nla_get_range_signed+0x3d0/0x3d0 [ 10.661863][ T236] ? __rtnl_newlink+0x3fa/0xa50 [ 10.661873][ T236] rtnl_newlink+0x9f1/0x11c0 [ 10.661884][ T236] ? rtnl_bridge_getlink+0x850/0x850 [ 10.661887][ T236] ? __lock_acquire+0x518/0xc20 [ 10.661895][ T236] ? lock_acquire.part.0+0xd4/0x280 [ 10.661898][ T236] ? find_held_lock+0x2b/0x80 [ 10.661901][ T236] ? rtnl_bridge_getlink+0x850/0x850 [ 10.661904][ T236] ? __lock_release.isra.0+0x69/0x1a0 [ 10.661911][ T236] ? rtnl_bridge_getlink+0x850/0x850 [ 10.661915][ T236] rtnetlink_rcv_msg+0x6fd/0xbd0 [ 10.661920][ T236] ? rtnl_link_fill+0x920/0x920 [ 10.661922][ T236] ? __lock_acquire+0x518/0xc20 [ 10.661930][ T236] ? lock_acquire.part.0+0xd4/0x280 [ 10.661934][ T236] ? find_held_lock+0x2b/0x80 [ 10.661940][ T236] netlink_rcv_skb+0x14e/0x3a0 [ 10.661943][ T236] ? rtnl_link_fill+0x920/0x920 [ 10.661948][ T236] ? netlink_ack+0xcf0/0xcf0 [ 10.661960][ T236] ? netlink_deliver_tap+0xc5/0x330 [ 10.661962][ T236] ? netlink_deliver_tap+0x13c/0x330 [ 10.661970][ T236] netlink_unicast+0x486/0x750 [ 10.661977][ T236] ? netlink_attachskb+0x810/0x810 [ 10.661982][ T236] ? __lock_acquire+0x518/0xc20 [ 10.661989][ T236] netlink_sendmsg+0x735/0xc60 [ 10.661996][ T236] ? netlink_unicast+0x750/0x750 [ 10.662003][ T236] ? __might_fault+0x97/0x140 [ 10.662012][ T236] ____sys_sendmsg+0x415/0x880 [ 10.662016][ T236] ? copy_msghdr_from_user+0x279/0x420 [ 10.662019][ T236] ? get_timestamp.constprop.0+0x390/0x390 [ 10.662022][ T236] ? move_addr_to_kernel+0x40/0x40 [ 10.662035][ T236] ___sys_sendmsg+0x14e/0x1d0 [ 10.662040][ T236] ? copy_msghdr_from_user+0x420/0x420 [ 10.662071][ T236] __sys_sendmsg+0x12c/0x1d0 [ 10.662075][ T236] ? __sys_sendmsg_sock+0x20/0x20 [ 10.662087][ T236] ? rcu_is_watching+0x16/0xd0 [ 10.662093][ T236] do_syscall_64+0xff/0x530 [ 10.662097][ T236] ? exc_page_fault+0xee/0x100 [ 10.662102][ T236] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 10.662106][ T236] RIP: 0033:0x7fa1daa6654e [ 10.662110][ T236] 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 [ 10.662113][ T236] RSP: 002b:00007ffe04ecb850 EFLAGS: 00000202 ORIG_RAX: 000000000000002e [ 10.662117][ T236] RAX: ffffffffffffffda RBX: 0000000000000004 RCX: 00007fa1daa6654e [ 10.662119][ T236] RDX: 0000000000000000 RSI: 00007ffe04ecb900 RDI: 0000000000000005 [ 10.662121][ T236] RBP: 00007ffe04ecb860 R08: 0000000000000000 R09: 0000000000000000 [ 10.662122][ T236] R10: 0000000000000000 R11: 0000000000000202 R12: 000000006a90e57d [ 10.662124][ T236] R13: 00000000004a1620 R14: 0000000000000000 R15: 00007ffe04ecbfc0 [ 10.662137][ T236] [ 10.735003][ T236] br0: port 1(veth1) entered disabled state [ 10.735369][ T236] veth1: entered allmulticast mode [ 10.740628][ T236] veth1: entered promiscuous mode [ 10.753444][ T236] ip (236) used greatest stack depth: 23336 bytes left [ 10.773636][ T238] br0: port 2(veth2) entered blocking state [ 10.774495][ T238] br0: port 2(veth2) entered disabled state [ 10.774873][ T238] veth2: entered allmulticast mode [ 10.776475][ T238] veth2: entered promiscuous mode [ 10.846964][ T92] br0: port 1(veth1) entered blocking state [ 10.847443][ T92] br0: port 1(veth1) entered forwarding state [ 21.012097][ T36] br0: port 2(veth2) entered blocking state [ 21.012117][ T36] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 21.012119][ T36] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 36, name: kworker/u17:0 [ 21.012121][ T36] preempt_count: 202, expected: 0 [ 21.012122][ T36] RCU nest depth: 0, expected: 0 [ 21.012123][ T36] locks held by kworker/u17:0/36: 8, last CPU#0: [ 21.012125][ T36] #0: ff1100000114a940 ((wq_completion)events_unbound){+.+.}-{0:0}, at: process_one_work+0xd9a/0x1560 [ 21.012139][ T36] #1: ffa000000028fd10 ((linkwatch_work).work){+.+.}-{0:0}, at: process_one_work+0xdfc/0x1560 [ 21.012142][ T36] #2: ffffffffa02d2c40 (rtnl_mutex){+.+.}-{4:4}, at: linkwatch_event+0x4e/0xb0 [ 21.012148][ T36] #3: ff11000004eb2e58 (&br->lock){+...}-{3:3}, at: br_port_carrier_check+0x161/0x430 [bridge] [ 21.012163][ T36] #4: ffffffff9fb69cc0 (console_lock){+.+.}-{0:0}, at: vprintk_emit+0x320/0x3e0 [ 21.012168][ T36] #5: ffffffff9fb69d38 (console_srcu){....}-{0:0}, at: console_flush_one_record+0x106/0x710 [ 21.012172][ T36] #6: ffffffff9fa89660 (console_owner){....}-{0:0}, at: console_lock_spinning_enable+0x40/0x60 [ 21.012175][ T36] #7: ffffffff9fa89560 (printk_legacy_map-wait-type-override){....}-{3:3}, at: console_emit_next_record+0x1df/0x4c0 [ 21.012179][ T36] irq event stamp: 49025 [ 21.012180][ T36] hardirqs last enabled at (49024): [] __down_trylock_console_sem+0x86/0xa0 [ 21.012182][ T36] hardirqs last disabled at (49025): [] console_emit_next_record+0x3d4/0x4c0 [ 21.012184][ T36] softirqs last enabled at (48986): [] inet6_fill_ifla6_attrs+0x1b3e/0x21e0 [ 21.012188][ T36] softirqs last disabled at (49020): [] br_port_carrier_check+0x161/0x430 [bridge] [ 21.012196][ T36] Preemption disabled at: [ 21.012197][ T36] [<0000000000000000>] 0x0 [ 21.012203][ T36] CPU: 0 UID: 0 PID: 36 Comm: kworker/u17:0 Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 21.012207][ T36] Tainted: [W]=WARN [ 21.012208][ T36] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 21.012209][ T36] Workqueue: events_unbound linkwatch_event [ 21.012212][ T36] Call Trace: [ 21.012214][ T36] [ 21.012216][ T36] dump_stack_lvl+0x6f/0xa0 [ 21.012222][ T36] __might_resched.cold+0x1fe/0x2c1 [ 21.012227][ T36] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 21.012231][ T36] ? __kmalloc_noprof+0xdb/0x760 [ 21.012236][ T36] __kmalloc_noprof+0x443/0x760 [ 21.012239][ T36] ? alloc_buf.isra.0+0x4b/0x260 [ 21.012244][ T36] ? do_raw_spin_unlock+0x59/0x250 [ 21.012247][ T36] alloc_buf.isra.0+0x4b/0x260 [ 21.012250][ T36] put_chars+0x1e1/0x2f0 [ 21.012253][ T36] ? __send_to_port+0x420/0x420 [ 21.012255][ T36] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 21.012260][ T36] ? rcu_read_lock_any_held+0x3c/0x90 [ 21.012262][ T36] ? validate_chain+0x38b/0xc20 [ 21.012266][ T36] hvc_console_print+0x292/0x780 [ 21.012269][ T36] ? mark_usage+0x61/0x170 [ 21.012271][ T36] ? __lock_acquire+0x518/0xc20 [ 21.012272][ T36] ? __lock_acquire+0x518/0xc20 [ 21.012277][ T36] ? hvc_write+0x3a0/0x3a0 [ 21.012278][ T36] ? lock_acquire.part.0+0xd4/0x280 [ 21.012282][ T36] ? lock_acquire+0x13c/0x160 [ 21.012286][ T36] console_emit_next_record+0x22f/0x4c0 [ 21.012290][ T36] ? devkmsg_read+0x4b0/0x4b0 [ 21.012292][ T36] ? console_flush_one_record+0x106/0x710 [ 21.012295][ T36] ? rcu_is_watching+0x16/0xd0 [ 21.012297][ T36] ? lock_acquire+0x13c/0x160 [ 21.012302][ T36] console_flush_one_record+0x46f/0x710 [ 21.012306][ T36] ? console_emit_next_record+0x4c0/0x4c0 [ 21.012307][ T36] ? __lock_acquire+0x518/0xc20 [ 21.012313][ T36] console_unlock+0xee/0x1f0 [ 21.012315][ T36] ? console_flush_one_record+0x710/0x710 [ 21.012317][ T36] ? rcu_is_watching+0x16/0xd0 [ 21.012320][ T36] ? lock_acquire+0x60/0x160 [ 21.012323][ T36] ? __down_trylock_console_sem+0x5e/0xa0 [ 21.012325][ T36] ? vprintk_emit+0x320/0x3e0 [ 21.012328][ T36] vprintk_emit+0x37c/0x3e0 [ 21.012332][ T36] ? wake_up_klogd_work_func+0x90/0x90 [ 21.012335][ T36] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 21.012338][ T36] ? rcu_read_lock_any_held+0x3c/0x90 [ 21.012341][ T36] _printk+0xc7/0x100 [ 21.012345][ T36] ? snapshot_read.cold+0x21/0x21 [ 21.012350][ T36] ? lock_acquire.part.0+0xd4/0x280 [ 21.012356][ T36] br_set_state+0x22f/0x430 [bridge] [ 21.012372][ T36] br_init_port+0xc4/0x200 [bridge] [ 21.012380][ T36] br_stp_enable_port+0x12/0x50 [bridge] [ 21.012387][ T36] br_port_carrier_check+0x220/0x430 [bridge] [ 21.012396][ T36] br_device_event+0x52d/0x8f0 [bridge] [ 21.012404][ T36] ? _sub_I_65535_1+0x4d0/0x4d0 [stp] [ 21.012406][ T36] ? nlmsg_notify+0x62/0x250 [ 21.012413][ T36] notifier_call_chain+0xae/0x300 [ 21.012418][ T36] netif_state_change+0x139/0x340 [ 21.012423][ T36] ? call_netdevice_notifiers_info+0xd0/0xd0 [ 21.012428][ T36] ? linkwatch_do_dev+0xae/0xd0 [ 21.012430][ T36] __linkwatch_run_queue+0x34c/0x750 [ 21.012433][ T36] ? linkwatch_do_dev+0xd0/0xd0 [ 21.012435][ T36] ? lock_acquire.part.0+0xd4/0x280 [ 21.012440][ T36] linkwatch_event+0x7f/0xb0 [ 21.012442][ T36] ? __linkwatch_run_queue+0x750/0x750 [ 21.012445][ T36] process_one_work+0xe3e/0x1560 [ 21.012452][ T36] ? __queue_delayed_work+0x470/0x470 [ 21.012455][ T36] ? lock_acquire.part.0+0xd4/0x280 [ 21.012462][ T36] worker_thread+0x4f1/0xd60 [ 21.012469][ T36] ? rescuer_thread+0x1340/0x1340 [ 21.012471][ T36] kthread+0x367/0x460 [ 21.012473][ T36] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 21.012476][ T36] ? kthread_affine_preferred+0x4c0/0x4c0 [ 21.012479][ T36] ret_from_fork+0x474/0x6b0 [ 21.012483][ T36] ? arch_exit_to_user_mode_prepare.isra.0+0x120/0x120 [ 21.012487][ T36] ? __switch_to+0x5a3/0xe00 [ 21.012490][ T36] ? kthread_affine_preferred+0x4c0/0x4c0 [ 21.012493][ T36] ret_from_fork_asm+0x11/0x20 [ 21.012501][ T36] [ 21.040375][ T36] br0: port 2(veth2) entered forwarding state [ 25.972695][ C2] [ 25.972711][ C2] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 25.972714][ C2] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 0, name: swapper/2 [ 25.972715][ C2] preempt_count: 104, expected: 0 [ 25.972716][ C2] RCU nest depth: 0, expected: 0 [ 25.972717][ C2] INFO: lockdep is turned off. [ 25.972718][ C2] irq event stamp: 479818 [ 25.972719][ C2] hardirqs last enabled at (479818): [] _raw_spin_unlock_irq+0x28/0x50 [ 25.972728][ C2] hardirqs last disabled at (479817): [] _raw_spin_lock_irq+0x4a/0x50 [ 25.972730][ C2] softirqs last enabled at (479784): [] handle_softirqs+0x67c/0x900 [ 25.972733][ C2] softirqs last disabled at (479815): [] __irq_exit_rcu+0x145/0x1c0 [ 25.972735][ C2] Preemption disabled at: [ 25.972736][ C2] [<0000000000000000>] 0x0 [ 25.972742][ C2] CPU: 2 UID: 0 PID: 0 Comm: swapper/2 Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 25.972746][ C2] Tainted: [W]=WARN [ 25.972747][ C2] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 25.972749][ C2] Call Trace: [ 25.972750][ C2] [ 25.972752][ C2] dump_stack_lvl+0x6f/0xa0 [ 25.972757][ C2] __might_resched.cold+0x1fe/0x2c1 [ 25.972761][ C2] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 25.972770][ C2] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 25.972773][ C2] ? __asan_memcpy+0x3c/0x60 [ 25.972776][ C2] ? rcu_is_watching+0x16/0xd0 [ 25.972778][ C2] __kmalloc_noprof+0x443/0x760 [ 25.972782][ C2] ? __rwlock_init+0x150/0x150 [ 25.972785][ C2] ? alloc_buf.isra.0+0x4b/0x260 [ 25.972788][ C2] ? do_raw_spin_unlock+0x59/0x250 [ 25.972790][ C2] alloc_buf.isra.0+0x4b/0x260 [ 25.972792][ C2] put_chars+0x1e1/0x2f0 [ 25.972794][ C2] ? __send_to_port+0x420/0x420 [ 25.972795][ C2] ? console_prepend_replay+0x20/0x20 [ 25.972799][ C2] hvc_console_print+0x292/0x780 [ 25.972802][ C2] ? hvc_write+0x3a0/0x3a0 [ 25.972804][ C2] ? rcu_is_watching+0x16/0xd0 [ 25.972805][ C2] ? lock_acquire+0x13c/0x160 [ 25.972808][ C2] console_emit_next_record+0x22f/0x4c0 [ 25.972810][ C2] ? devkmsg_read+0x4b0/0x4b0 [ 25.972812][ C2] ? rcu_is_watching+0x16/0xd0 [ 25.972813][ C2] ? rcu_is_watching+0x16/0xd0 [ 25.972815][ C2] ? lock_acquire+0x13c/0x160 [ 25.972817][ C2] ? console_flush_one_record+0x111/0x710 [ 25.972819][ C2] console_flush_one_record+0x46f/0x710 [ 25.972821][ C2] ? console_emit_next_record+0x4c0/0x4c0 [ 25.972823][ C2] console_unlock+0xee/0x1f0 [ 25.972825][ C2] ? lock_acquire+0x13c/0x160 [ 25.972827][ C2] ? console_flush_one_record+0x710/0x710 [ 25.972828][ C2] ? rcu_is_watching+0x16/0xd0 [ 25.972830][ C2] ? lock_release+0x184/0x1f0 [ 25.972831][ C2] ? lock_acquire+0x60/0x160 [ 25.972833][ C2] ? __down_trylock_console_sem+0x5e/0xa0 [ 25.972835][ C2] ? vprintk_emit+0x320/0x3e0 [ 25.972837][ C2] vprintk_emit+0x37c/0x3e0 [ 25.972839][ C2] ? wake_up_klogd_work_func+0x90/0x90 [ 25.972841][ C2] ? br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 25.972853][ C2] ? lock_release+0x184/0x1f0 [ 25.972855][ C2] ? br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 25.972861][ C2] ? br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 25.972867][ C2] ? is_module_text_address+0x154/0x250 [ 25.972870][ C2] _printk+0xc7/0x100 [ 25.972874][ C2] ? snapshot_read.cold+0x21/0x21 [ 25.972875][ C2] ? arch_stack_walk+0xd7/0x130 [ 25.972879][ C2] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 25.972881][ C2] ? nbcon_cpu_emergency_enter+0x28/0x80 [ 25.972883][ C2] print_irq_inversion_bug.part.0+0x32/0xc0 [ 25.972885][ C2] mark_lock_irq+0x989/0x9c0 [ 25.972888][ C2] mark_lock+0x1d7/0xa00 [ 25.972890][ C2] mark_usage+0x42/0x170 [ 25.972891][ C2] __lock_acquire+0x388/0xc20 [ 25.972893][ C2] lock_acquire.part.0+0xd4/0x280 [ 25.972895][ C2] ? br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 25.972901][ C2] ? rcu_is_watching+0x16/0xd0 [ 25.972903][ C2] ? lock_acquire+0x13c/0x160 [ 25.972905][ C2] ? br_message_age_timer_expired+0x70/0x70 [bridge] [ 25.972911][ C2] _raw_spin_lock+0x33/0x40 [ 25.972912][ C2] ? br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 25.972918][ C2] br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 25.972924][ C2] ? br_message_age_timer_expired+0x70/0x70 [bridge] [ 25.972931][ C2] call_timer_fn+0x160/0x4d0 [ 25.972933][ C2] ? detach_if_pending+0x1d0/0x1d0 [ 25.972935][ C2] ? debug_object_active_state+0x430/0x430 [ 25.972939][ C2] ? find_held_lock+0x2b/0x80 [ 25.972940][ C2] ? __lock_release.isra.0+0x69/0x1a0 [ 25.972942][ C2] ? rcu_is_watching+0x16/0xd0 [ 25.972944][ C2] __run_timers+0x68f/0xaa0 [ 25.972946][ C2] ? br_message_age_timer_expired+0x70/0x70 [bridge] [ 25.972952][ C2] ? __bpf_trace_itimer_expire+0x10/0x10 [ 25.972954][ C2] ? __lock_acquire+0x518/0xc20 [ 25.972957][ C2] ? __rwlock_init+0x150/0x150 [ 25.972959][ C2] run_timer_softirq+0xf0/0x160 [ 25.972961][ C2] ? __run_timers+0xaa0/0xaa0 [ 25.972963][ C2] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 25.972965][ C2] ? rcu_is_watching+0x16/0xd0 [ 25.972967][ C2] handle_softirqs+0x1d3/0x900 [ 25.972968][ C2] ? __lock_release.isra.0+0x69/0x1a0 [ 25.972970][ C2] ? _local_bh_enable+0xc0/0xc0 [ 25.972972][ C2] __irq_exit_rcu+0x145/0x1c0 [ 25.972973][ C2] irq_exit_rcu+0xe/0x30 [ 25.972975][ C2] sysvec_apic_timer_interrupt+0x9d/0xe0 [ 25.972978][ C2] [ 25.972978][ C2] [ 25.972979][ C2] ? lockdep_hardirqs_on+0x91/0x130 [ 25.972981][ C2] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 25.972983][ C2] RIP: 0010:pv_native_safe_halt+0xf/0x10 [ 25.972985][ C2] Code: 48 8b 3d 94 f2 f5 01 e8 1f 00 00 00 48 2b 05 58 b3 95 00 c3 0f 1f 80 00 00 00 00 f3 0f 1e fa eb 07 0f 00 2d 13 a6 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 [ 25.972987][ C2] RSP: 0018:ffa0000000157e00 EFLAGS: 00000282 [ 25.972990][ C2] RAX: 0000000000075245 RBX: ff11000001bec6c0 RCX: ffffffff9c8f0307 [ 25.972992][ C2] RDX: ff11000001bec6c0 RSI: ffffffff9f638b1c RDI: ffffffff9f08d8e0 [ 25.972993][ C2] RBP: 0000000000000000 R08: 0000000000000000 R09: 0000000000000000 [ 25.972993][ C2] R10: 0000000000000002 R11: 0000000000000001 R12: 1ff400000002afc3 [ 25.972994][ C2] R13: 0000000000000000 R14: dffffc0000000000 R15: 0000000000000000 [ 25.972996][ C2] ? cpuidle_idle_call.constprop.0+0x237/0x410 [ 25.972999][ C2] default_idle+0x9/0x10 [ 25.973001][ C2] default_idle_call+0x6e/0xb0 [ 25.973003][ C2] cpuidle_idle_call.constprop.0+0x237/0x410 [ 25.973004][ C2] ? arch_cpu_idle_exit+0x40/0x40 [ 25.973006][ C2] ? mark_tsc_async_resets+0x30/0x30 [ 25.973008][ C2] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 25.973009][ C2] ? rcu_is_watching+0x16/0xd0 [ 25.973011][ C2] do_idle+0xd8/0x190 [ 25.973013][ C2] cpu_startup_entry+0x53/0x70 [ 25.973014][ C2] start_secondary+0x204/0x2b0 [ 25.973016][ C2] ? set_cpu_sibling_map+0x2130/0x2130 [ 25.973018][ C2] common_startup_64+0x13e/0x148 [ 25.973022][ C2] [ 25.991328][ C2] ======================================================== [ 25.991576][ C2] WARNING: possible irq lock inversion dependency detected [ 25.991778][ C2] 7.2.0-virtme #1 Tainted: G W [ 25.991987][ C2] -------------------------------------------------------- [ 25.992231][ C2] swapper/2/0 just changed the state of lock: [ 25.992394][ C2] ff11000004eb2e58 (&br->lock){+.-.}-{3:3}, at: br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 25.992713][ C2] but this lock took another, SOFTIRQ-unsafe lock in the past: [ 25.992961][ C2] (fs_reclaim){+.+.}-{0:0} [ 25.992963][ C2] [ 25.992963][ C2] [ 25.992963][ C2] and interrupts could create inverse lock ordering between them. [ 25.992963][ C2] [ 25.993536][ C2] [ 25.993536][ C2] other info that might help us debug this: [ 25.993787][ C2] Chain exists of: [ 25.993787][ C2] &br->lock --> console_owner --> fs_reclaim [ 25.993787][ C2] [ 25.994135][ C2] Possible interrupt unsafe locking scenario: [ 25.994135][ C2] [ 25.994377][ C2] CPU0 CPU1 [ 25.994513][ C2] ---- ---- [ 25.994651][ C2] lock(fs_reclaim); [ 25.994756][ C2] local_irq_disable(); [ 25.994925][ C2] lock(&br->lock); [ 25.995093][ C2] lock(console_owner); [ 25.995308][ C2] [ 25.995409][ C2] lock(&br->lock); [ 25.995558][ C2] [ 25.995558][ C2] *** DEADLOCK *** [ 25.995558][ C2] [ 25.995756][ C2] locks held by swapper/2/0: 1, last CPU#2: [ 25.995972][ C2] #0: ffa0000000228c90 ((&p->forward_delay_timer)){+.-.}-{0:0}, at: call_timer_fn+0x110/0x4d0 [ 25.996285][ C2] [ 25.996285][ C2] the shortest dependencies between 2nd lock and 1st lock: [ 25.996559][ C2] -> (fs_reclaim){+.+.}-{0:0} { [ 25.996697][ C2] HARDIRQ-ON-W at: [ 25.996852][ C2] __lock_acquire+0x388/0xc20 [ 25.997028][ C2] lock_acquire.part.0+0xd4/0x280 [ 25.997241][ C2] fs_reclaim_acquire+0xd5/0x120 [ 25.997456][ C2] __kmalloc_cache_noprof+0x6e/0x620 [ 25.997658][ C2] kthread_create_worker_on_node+0xea/0x210 [ 25.997915][ C2] workqueue_init+0x2a/0x680 [ 25.998129][ C2] kernel_init_freeable+0x2fe/0x630 [ 25.998330][ C2] kernel_init+0x21/0x150 [ 25.998541][ C2] ret_from_fork+0x474/0x6b0 [ 25.998756][ C2] ret_from_fork_asm+0x11/0x20 [ 25.998928][ C2] SOFTIRQ-ON-W at: [ 25.999074][ C2] __lock_acquire+0x388/0xc20 [ 25.999239][ C2] lock_acquire.part.0+0xd4/0x280 [ 25.999454][ C2] fs_reclaim_acquire+0xd5/0x120 [ 25.999670][ C2] __kmalloc_cache_noprof+0x6e/0x620 [ 25.999874][ C2] kthread_create_worker_on_node+0xea/0x210 [ 26.000123][ C2] workqueue_init+0x2a/0x680 [ 26.000339][ C2] kernel_init_freeable+0x2fe/0x630 [ 26.000570][ C2] kernel_init+0x21/0x150 [ 26.000791][ C2] ret_from_fork+0x474/0x6b0 [ 26.001007][ C2] ret_from_fork_asm+0x11/0x20 [ 26.001176][ C2] INITIAL USE at: [ 26.001321][ C2] __lock_acquire+0x388/0xc20 [ 26.001486][ C2] lock_acquire.part.0+0xd4/0x280 [ 26.001700][ C2] fs_reclaim_acquire+0xd5/0x120 [ 26.001918][ C2] __kmalloc_cache_noprof+0x6e/0x620 [ 26.002123][ C2] kthread_create_worker_on_node+0xea/0x210 [ 26.002371][ C2] workqueue_init+0x2a/0x680 [ 26.002583][ C2] kernel_init_freeable+0x2fe/0x630 [ 26.006806][ C2] kernel_init+0x21/0x150 [ 26.006976][ C2] ret_from_fork+0x474/0x6b0 [ 26.007190][ C2] ret_from_fork_asm+0x11/0x20 [ 26.007403][ C2] } [ 26.007474][ C2] ... key at: [] __fs_reclaim_map+0x0/0xbe0 [ 26.007673][ C2] ... acquired at: [ 26.007779][ C2] __lock_acquire+0x518/0xc20 [ 26.007919][ C2] lock_acquire.part.0+0xd4/0x280 [ 26.008096][ C2] fs_reclaim_acquire+0xd5/0x120 [ 26.008225][ C2] __kmalloc_noprof+0xd3/0x760 [ 26.008404][ C2] alloc_buf.isra.0+0x4b/0x260 [ 26.008535][ C2] put_chars+0x1e1/0x2f0 [ 26.008714][ C2] hvc_console_print+0x292/0x780 [ 26.008850][ C2] console_emit_next_record+0x22f/0x4c0 [ 26.009026][ C2] console_flush_one_record+0x46f/0x710 [ 26.009159][ C2] console_unlock+0xee/0x1f0 [ 26.009339][ C2] vprintk_emit+0x37c/0x3e0 [ 26.009467][ C2] dev_vprintk_emit+0x27f/0x2c0 [ 26.009644][ C2] dev_printk_emit+0xb9/0xee [ 26.009780][ C2] _dev_info+0xe2/0x116 [ 26.009923][ C2] __devm_rtc_register_device.cold+0xc3/0x3a8 [ 26.010089][ C2] cmos_do_probe+0x73b/0x98a [ 26.010267][ C2] platform_probe+0xfe/0x1f0 [ 26.010397][ C2] call_driver_probe+0x61/0x1c0 [ 26.010571][ C2] really_probe+0x199/0x760 [ 26.010700][ C2] __driver_probe_device+0x24f/0x440 [ 26.010881][ C2] driver_probe_device+0x4a/0xf0 [ 26.011009][ C2] __driver_attach+0x1b8/0x540 [ 26.011185][ C2] bus_for_each_dev+0x130/0x1e0 [ 26.011315][ C2] bus_add_driver+0x2c8/0x530 [ 26.011493][ C2] driver_register+0x1a3/0x390 [ 26.011622][ C2] __platform_driver_probe+0x13f/0x270 [ 26.011752][ C2] cmos_init+0x31/0x40 [ 26.011855][ C2] do_one_initcall+0x124/0x4f0 [ 26.011985][ C2] kernel_init_freeable+0x596/0x630 [ 26.012114][ C2] kernel_init+0x21/0x150 [ 26.012289][ C2] ret_from_fork+0x474/0x6b0 [ 26.012418][ C2] ret_from_fork_asm+0x11/0x20 [ 26.012591][ C2] [ 26.012658][ C2] -> (console_owner){....}-{0:0} { [ 26.012843][ C2] INITIAL USE at: [ 26.012940][ C2] } [ 26.013006][ C2] ... key at: [] console_owner_dep_map+0x0/0x60 [ 26.013244][ C2] ... acquired at: [ 26.013343][ C2] __lock_acquire+0x518/0xc20 [ 26.013519][ C2] lock_acquire.part.0+0xd4/0x280 [ 26.013650][ C2] console_lock_spinning_enable+0x5c/0x60 [ 26.013865][ C2] console_emit_next_record+0x1d1/0x4c0 [ 26.013995][ C2] console_flush_one_record+0x46f/0x710 [ 26.014168][ C2] console_unlock+0xee/0x1f0 [ 26.014298][ C2] vprintk_emit+0x37c/0x3e0 [ 26.014476][ C2] _printk+0xc7/0x100 [ 26.014575][ C2] br_set_state+0x22f/0x430 [bridge] [ 26.014755][ C2] br_init_port+0xc4/0x200 [bridge] [ 26.014895][ C2] br_stp_enable_port+0x12/0x50 [bridge] [ 26.015107][ C2] br_port_carrier_check+0x220/0x430 [bridge] [ 26.015318][ C2] br_device_event+0x52d/0x8f0 [bridge] [ 26.015455][ C2] notifier_call_chain+0xae/0x300 [ 26.015632][ C2] netif_state_change+0x139/0x340 [ 26.015778][ C2] __linkwatch_run_queue+0x34c/0x750 [ 26.015952][ C2] linkwatch_event+0x7f/0xb0 [ 26.016082][ C2] process_one_work+0xe3e/0x1560 [ 26.016257][ C2] worker_thread+0x4f1/0xd60 [ 26.016388][ C2] kthread+0x367/0x460 [ 26.016488][ C2] ret_from_fork+0x474/0x6b0 [ 26.016662][ C2] ret_from_fork_asm+0x11/0x20 [ 26.016799][ C2] [ 26.016907][ C2] -> (&br->lock){+.-.}-{3:3} { [ 26.017037][ C2] HARDIRQ-ON-W at: [ 26.017183][ C2] __lock_acquire+0x388/0xc20 [ 26.017349][ C2] lock_acquire.part.0+0xd4/0x280 [ 26.017560][ C2] _raw_spin_lock_bh+0x38/0x50 [ 26.017727][ C2] br_add_if+0x8c1/0x1320 [bridge] [ 26.017947][ C2] do_set_master+0x357/0x580 [ 26.018164][ C2] do_setlink.isra.0+0xa31/0x2750 [ 26.018329][ C2] rtnl_newlink+0x9f1/0x11c0 [ 26.018538][ C2] rtnetlink_rcv_msg+0x6fd/0xbd0 [ 26.018749][ C2] netlink_rcv_skb+0x14e/0x3a0 [ 26.018924][ C2] netlink_unicast+0x486/0x750 [ 26.019136][ C2] netlink_sendmsg+0x735/0xc60 [ 26.019301][ C2] ____sys_sendmsg+0x415/0x880 [ 26.019515][ C2] ___sys_sendmsg+0x14e/0x1d0 [ 26.019726][ C2] __sys_sendmsg+0x12c/0x1d0 [ 26.019896][ C2] do_syscall_64+0xff/0x530 [ 26.020109][ C2] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 26.020351][ C2] IN-SOFTIRQ-W at: [ 26.020451][ C2] __lock_acquire+0x388/0xc20 [ 26.020664][ C2] lock_acquire.part.0+0xd4/0x280 [ 26.020836][ C2] _raw_spin_lock+0x33/0x40 [ 26.021048][ C2] br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 26.021297][ C2] call_timer_fn+0x160/0x4d0 [ 26.021466][ C2] __run_timers+0x68f/0xaa0 [ 26.021678][ C2] run_timer_softirq+0xf0/0x160 [ 26.021897][ C2] handle_softirqs+0x1d3/0x900 [ 26.022066][ C2] __irq_exit_rcu+0x145/0x1c0 [ 26.022278][ C2] irq_exit_rcu+0xe/0x30 [ 26.022443][ C2] sysvec_apic_timer_interrupt+0x9d/0xe0 [ 26.022688][ C2] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 26.022937][ C2] pv_native_safe_halt+0xf/0x10 [ 26.023144][ C2] default_idle+0x9/0x10 [ 26.023313][ C2] default_idle_call+0x6e/0xb0 [ 26.023526][ C2] cpuidle_idle_call.constprop.0+0x237/0x410 [ 26.023770][ C2] do_idle+0xd8/0x190 [ 26.023904][ C2] cpu_startup_entry+0x53/0x70 [ 26.024114][ C2] start_secondary+0x204/0x2b0 [ 26.024279][ C2] common_startup_64+0x13e/0x148 [ 26.024495][ C2] INITIAL USE at: [ 26.024594][ C2] __lock_acquire+0x388/0xc20 [ 26.024759][ C2] lock_acquire.part.0+0xd4/0x280 [ 26.024926][ C2] _raw_spin_lock_bh+0x38/0x50 [ 26.025090][ C2] br_add_if+0x8c1/0x1320 [bridge] [ 26.025304][ C2] do_set_master+0x357/0x580 [ 26.025469][ C2] do_setlink.isra.0+0xa31/0x2750 [ 26.025679][ C2] rtnl_newlink+0x9f1/0x11c0 [ 26.025893][ C2] rtnetlink_rcv_msg+0x6fd/0xbd0 [ 26.026055][ C2] netlink_rcv_skb+0x14e/0x3a0 [ 26.026267][ C2] netlink_unicast+0x486/0x750 [ 26.026474][ C2] netlink_sendmsg+0x735/0xc60 [ 26.026641][ C2] ____sys_sendmsg+0x415/0x880 [ 26.026854][ C2] ___sys_sendmsg+0x14e/0x1d0 [ 26.027019][ C2] __sys_sendmsg+0x12c/0x1d0 [ 26.027230][ C2] do_syscall_64+0xff/0x530 [ 26.027441][ C2] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 26.027638][ C2] } [ 26.027705][ C2] ... key at: [] __key.7+0x0/0x40 [bridge] [ 26.027908][ C2] ... acquired at: [ 26.028052][ C2] mark_lock+0x1d7/0xa00 [ 26.028182][ C2] mark_usage+0x42/0x170 [ 26.028356][ C2] __lock_acquire+0x388/0xc20 [ 26.028486][ C2] lock_acquire.part.0+0xd4/0x280 [ 26.028661][ C2] _raw_spin_lock+0x33/0x40 [ 26.028797][ C2] br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 26.029009][ C2] call_timer_fn+0x160/0x4d0 [ 26.029137][ C2] __run_timers+0x68f/0xaa0 [ 26.029313][ C2] run_timer_softirq+0xf0/0x160 [ 26.029445][ C2] handle_softirqs+0x1d3/0x900 [ 26.029618][ C2] __irq_exit_rcu+0x145/0x1c0 [ 26.029747][ C2] irq_exit_rcu+0xe/0x30 [ 26.029930][ C2] sysvec_apic_timer_interrupt+0x9d/0xe0 [ 26.030138][ C2] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 26.030299][ C2] pv_native_safe_halt+0xf/0x10 [ 26.030473][ C2] default_idle+0x9/0x10 [ 26.030604][ C2] default_idle_call+0x6e/0xb0 [ 26.030786][ C2] cpuidle_idle_call.constprop.0+0x237/0x410 [ 26.030949][ C2] do_idle+0xd8/0x190 [ 26.031093][ C2] cpu_startup_entry+0x53/0x70 [ 26.031226][ C2] start_secondary+0x204/0x2b0 [ 26.031403][ C2] common_startup_64+0x13e/0x148 [ 26.031534][ C2] [ 26.031600][ C2] [ 26.031600][ C2] stack backtrace: [ 26.031814][ C2] CPU: 2 UID: 0 PID: 0 Comm: swapper/2 Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 26.031817][ C2] Tainted: [W]=WARN [ 26.031817][ C2] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 26.031818][ C2] Call Trace: [ 26.031819][ C2] [ 26.031820][ C2] dump_stack_lvl+0x6f/0xa0 [ 26.031822][ C2] print_irq_inversion_bug.part.0.cold+0xe6/0x143 [ 26.031825][ C2] mark_lock_irq+0x989/0x9c0 [ 26.031827][ C2] mark_lock+0x1d7/0xa00 [ 26.031829][ C2] mark_usage+0x42/0x170 [ 26.031831][ C2] __lock_acquire+0x388/0xc20 [ 26.031833][ C2] lock_acquire.part.0+0xd4/0x280 [ 26.031835][ C2] ? br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 26.031841][ C2] ? rcu_is_watching+0x16/0xd0 [ 26.031843][ C2] ? lock_acquire+0x13c/0x160 [ 26.031845][ C2] ? br_message_age_timer_expired+0x70/0x70 [bridge] [ 26.031851][ C2] _raw_spin_lock+0x33/0x40 [ 26.031853][ C2] ? br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 26.031859][ C2] br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 26.031865][ C2] ? br_message_age_timer_expired+0x70/0x70 [bridge] [ 26.031871][ C2] call_timer_fn+0x160/0x4d0 [ 26.031873][ C2] ? detach_if_pending+0x1d0/0x1d0 [ 26.031875][ C2] ? debug_object_active_state+0x430/0x430 [ 26.031877][ C2] ? find_held_lock+0x2b/0x80 [ 26.031878][ C2] ? __lock_release.isra.0+0x69/0x1a0 [ 26.031880][ C2] ? rcu_is_watching+0x16/0xd0 [ 26.031882][ C2] __run_timers+0x68f/0xaa0 [ 26.031884][ C2] ? br_message_age_timer_expired+0x70/0x70 [bridge] [ 26.031890][ C2] ? __bpf_trace_itimer_expire+0x10/0x10 [ 26.031892][ C2] ? __lock_acquire+0x518/0xc20 [ 26.031895][ C2] ? __rwlock_init+0x150/0x150 [ 26.031897][ C2] run_timer_softirq+0xf0/0x160 [ 26.031899][ C2] ? __run_timers+0xaa0/0xaa0 [ 26.031900][ C2] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 26.031902][ C2] ? rcu_is_watching+0x16/0xd0 [ 26.031903][ C2] handle_softirqs+0x1d3/0x900 [ 26.031905][ C2] ? __lock_release.isra.0+0x69/0x1a0 [ 26.031907][ C2] ? _local_bh_enable+0xc0/0xc0 [ 26.031909][ C2] __irq_exit_rcu+0x145/0x1c0 [ 26.031910][ C2] irq_exit_rcu+0xe/0x30 [ 26.031912][ C2] sysvec_apic_timer_interrupt+0x9d/0xe0 [ 26.031913][ C2] [ 26.031914][ C2] [ 26.031914][ C2] ? lockdep_hardirqs_on+0x91/0x130 [ 26.031916][ C2] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 26.031917][ C2] RIP: 0010:pv_native_safe_halt+0xf/0x10 [ 26.031919][ C2] Code: 48 8b 3d 94 f2 f5 01 e8 1f 00 00 00 48 2b 05 58 b3 95 00 c3 0f 1f 80 00 00 00 00 f3 0f 1e fa eb 07 0f 00 2d 13 a6 11 00 fb f4 0f 1f 40 d6 48 83 ec 20 8b 17 49 89 f8 83 e2 fe 41 89 d2 0f 01 [ 26.031920][ C2] RSP: 0018:ffa0000000157e00 EFLAGS: 00000282 [ 26.031922][ C2] RAX: 0000000000075245 RBX: ff11000001bec6c0 RCX: ffffffff9c8f0307 [ 26.031923][ C2] RDX: ff11000001bec6c0 RSI: ffffffff9f638b1c RDI: ffffffff9f08d8e0 [ 26.031923][ C2] RBP: 0000000000000000 R08: 0000000000000000 R09: 0000000000000000 [ 26.031924][ C2] R10: 0000000000000002 R11: 0000000000000001 R12: 1ff400000002afc3 [ 26.031925][ C2] R13: 0000000000000000 R14: dffffc0000000000 R15: 0000000000000000 [ 26.031927][ C2] ? cpuidle_idle_call.constprop.0+0x237/0x410 [ 26.031929][ C2] default_idle+0x9/0x10 [ 26.031930][ C2] default_idle_call+0x6e/0xb0 [ 26.031932][ C2] cpuidle_idle_call.constprop.0+0x237/0x410 [ 26.031933][ C2] ? arch_cpu_idle_exit+0x40/0x40 [ 26.031935][ C2] ? mark_tsc_async_resets+0x30/0x30 [ 26.031936][ C2] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 26.031938][ C2] ? rcu_is_watching+0x16/0xd0 [ 26.031939][ C2] do_idle+0xd8/0x190 [ 26.031941][ C2] cpu_startup_entry+0x53/0x70 [ 26.031942][ C2] start_secondary+0x204/0x2b0 [ 26.031944][ C2] ? set_cpu_sibling_map+0x2130/0x2130 [ 26.031946][ C2] common_startup_64+0x13e/0x148 [ 26.031948][ C2] [ 26.192753][ T257] GACT probability NOT on [ 27.321126][ T266] br0: port 2(veth2) entered disabled state [ 27.321142][ T266] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 27.321145][ T266] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 266, name: ip [ 27.321146][ T266] preempt_count: 202, expected: 0 [ 27.321147][ T266] RCU nest depth: 0, expected: 0 [ 27.321148][ T266] INFO: lockdep is turned off. [ 27.321149][ T266] irq event stamp: 0 [ 27.321150][ T266] hardirqs last enabled at (0): [<0000000000000000>] 0x0 [ 27.321155][ T266] hardirqs last disabled at (0): [] copy_process+0x1ccd/0x6240 [ 27.321162][ T266] softirqs last enabled at (0): [] copy_process+0x1d21/0x6240 [ 27.321163][ T266] softirqs last disabled at (0): [<0000000000000000>] 0x0 [ 27.321165][ T266] Preemption disabled at: [ 27.321166][ T266] [<0000000000000000>] 0x0 [ 27.321171][ T266] CPU: 0 UID: 0 PID: 266 Comm: ip Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 27.321174][ T266] Tainted: [W]=WARN [ 27.321175][ T266] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 27.321177][ T266] Call Trace: [ 27.321178][ T266] [ 27.321180][ T266] dump_stack_lvl+0x6f/0xa0 [ 27.321185][ T266] __might_resched.cold+0x1fe/0x2c1 [ 27.321189][ T266] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 27.321193][ T266] ? rcu_is_watching+0x16/0xd0 [ 27.321198][ T266] __kmalloc_noprof+0x443/0x760 [ 27.321201][ T266] ? __rwlock_init+0x150/0x150 [ 27.321204][ T266] ? alloc_buf.isra.0+0x4b/0x260 [ 27.321208][ T266] ? do_raw_spin_unlock+0x59/0x250 [ 27.321210][ T266] alloc_buf.isra.0+0x4b/0x260 [ 27.321211][ T266] put_chars+0x1e1/0x2f0 [ 27.321213][ T266] ? __send_to_port+0x420/0x420 [ 27.321215][ T266] ? printk_get_next_message+0x240/0x650 [ 27.321218][ T266] hvc_console_print+0x292/0x780 [ 27.321222][ T266] ? hvc_write+0x3a0/0x3a0 [ 27.321224][ T266] ? __rwlock_init+0x150/0x150 [ 27.321225][ T266] ? rcu_is_watching+0x16/0xd0 [ 27.321227][ T266] ? lock_acquire+0x13c/0x160 [ 27.321230][ T266] console_emit_next_record+0x22f/0x4c0 [ 27.321232][ T266] ? devkmsg_read+0x4b0/0x4b0 [ 27.321234][ T266] ? rcu_is_watching+0x16/0xd0 [ 27.321236][ T266] ? rcu_is_watching+0x16/0xd0 [ 27.321237][ T266] ? rcu_is_watching+0x16/0xd0 [ 27.321239][ T266] ? lock_acquire+0x13c/0x160 [ 27.321241][ T266] ? console_flush_one_record+0x111/0x710 [ 27.321243][ T266] console_flush_one_record+0x46f/0x710 [ 27.321245][ T266] ? console_emit_next_record+0x4c0/0x4c0 [ 27.321248][ T266] console_unlock+0xee/0x1f0 [ 27.321249][ T266] ? lock_acquire+0x13c/0x160 [ 27.321251][ T266] ? console_flush_one_record+0x710/0x710 [ 27.321252][ T266] ? rcu_is_watching+0x16/0xd0 [ 27.321254][ T266] ? lock_release+0x184/0x1f0 [ 27.321255][ T266] ? lock_acquire+0x60/0x160 [ 27.321257][ T266] ? __rcu_read_lock+0x30/0x70 [ 27.321259][ T266] ? __down_trylock_console_sem+0x5e/0xa0 [ 27.321261][ T266] ? vprintk_emit+0x320/0x3e0 [ 27.321263][ T266] vprintk_emit+0x37c/0x3e0 [ 27.321265][ T266] ? wake_up_klogd_work_func+0x90/0x90 [ 27.321267][ T266] ? rcu_is_watching+0x16/0xd0 [ 27.321269][ T266] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 27.321272][ T266] ? trace_hardirqs_on+0x36/0x40 [ 27.321273][ T266] _printk+0xc7/0x100 [ 27.321276][ T266] ? snapshot_read.cold+0x21/0x21 [ 27.321279][ T266] ? ipv6_mc_down+0x17e/0x2d0 [ 27.321283][ T266] br_set_state+0x22f/0x430 [bridge] [ 27.321297][ T266] br_stp_disable_port+0x11f/0x390 [bridge] [ 27.321306][ T266] br_device_event+0x7b5/0x8f0 [bridge] [ 27.321314][ T266] ? _raw_spin_unlock_irqrestore+0x40/0x80 [ 27.321318][ T266] ? _sub_I_65535_1+0x4d0/0x4d0 [stp] [ 27.321321][ T266] ? addrconf_notify+0x2c8/0xf30 [ 27.321324][ T266] notifier_call_chain+0xae/0x300 [ 27.321327][ T266] __dev_notify_flags+0x23c/0x3c0 [ 27.321332][ T266] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 27.321333][ T266] ? netif_change_name+0x8c0/0x8c0 [ 27.321335][ T266] ? netif_set_allmulti+0x250/0x250 [ 27.321337][ T266] ? __kernel_text_address+0x12/0x30 [ 27.321339][ T266] ? write_profile+0xf0/0xf0 [ 27.321342][ T266] ? unwind_get_return_address+0x67/0xd0 [ 27.321345][ T266] netif_change_flags+0xfe/0x190 [ 27.321347][ T266] do_setlink.isra.0+0x1cc3/0x2750 [ 27.321350][ T266] ? stack_trace_save+0x93/0xc0 [ 27.321351][ T266] ? rtnl_link_get_size+0x350/0x350 [ 27.321353][ T266] ? rcu_is_watching+0x16/0xd0 [ 27.321354][ T266] ? stack_depot_save_flags+0x1bc/0x790 [ 27.321358][ T266] ? kasan_save_stack+0x3d/0x50 [ 27.321361][ T266] ? kasan_save_stack+0x2f/0x50 [ 27.321362][ T266] ? kasan_save_track+0x14/0x30 [ 27.321364][ T266] ? __kasan_kmalloc+0x7b/0x90 [ 27.321365][ T266] ? __kmalloc_cache_noprof+0x29a/0x620 [ 27.321367][ T266] ? rtnl_newlink+0x124/0x11c0 [ 27.321368][ T266] ? rtnetlink_rcv_msg+0x6fd/0xbd0 [ 27.321369][ T266] ? netlink_rcv_skb+0x14e/0x3a0 [ 27.321372][ T266] ? netlink_unicast+0x486/0x750 [ 27.321373][ T266] ? netlink_sendmsg+0x735/0xc60 [ 27.321375][ T266] ? ____sys_sendmsg+0x415/0x880 [ 27.321377][ T266] ? ___sys_sendmsg+0x14e/0x1d0 [ 27.321379][ T266] ? __sys_sendmsg+0x12c/0x1d0 [ 27.321381][ T266] ? do_syscall_64+0xff/0x530 [ 27.321382][ T266] ? entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 27.321385][ T266] ? rcu_is_watching+0x16/0xd0 [ 27.321387][ T266] ? lock_acquire+0x13c/0x160 [ 27.321389][ T266] ? rcu_is_watching+0x16/0xd0 [ 27.321390][ T266] ? rcu_is_watching+0x16/0xd0 [ 27.321392][ T266] ? trace_contention_end+0xb3/0x180 [ 27.321395][ T266] ? __mutex_lock+0x1db/0x1ea0 [ 27.321397][ T266] ? __mutex_lock+0x9a3/0x1ea0 [ 27.321398][ T266] ? rtnl_newlink+0x9a8/0x11c0 [ 27.321400][ T266] ? ww_mutex_lock+0x160/0x160 [ 27.321402][ T266] ? __rtnl_newlink+0x3fa/0xa50 [ 27.321404][ T266] rtnl_newlink+0x9f1/0x11c0 [ 27.321406][ T266] ? rcu_is_watching+0x16/0xd0 [ 27.321408][ T266] ? rtnl_bridge_getlink+0x850/0x850 [ 27.321409][ T266] ? lock_acquire+0x13c/0x160 [ 27.321411][ T266] ? rcu_is_watching+0x16/0xd0 [ 27.321413][ T266] ? is_bpf_text_address+0x3e/0x110 [ 27.321416][ T266] ? is_bpf_text_address+0x72/0x110 [ 27.321418][ T266] ? kernel_text_address+0x149/0x170 [ 27.321419][ T266] ? __kernel_text_address+0x12/0x30 [ 27.321421][ T266] ? write_profile+0xf0/0xf0 [ 27.321422][ T266] ? unwind_get_return_address+0x67/0xd0 [ 27.321423][ T266] ? rcu_is_watching+0x16/0xd0 [ 27.321425][ T266] ? rcu_is_watching+0x16/0xd0 [ 27.321426][ T266] ? cap_capable+0x1d7/0x3d0 [ 27.321430][ T266] ? lock_acquire+0x13c/0x160 [ 27.321432][ T266] ? rcu_is_watching+0x16/0xd0 [ 27.321434][ T266] ? rtnl_bridge_getlink+0x850/0x850 [ 27.321435][ T266] rtnetlink_rcv_msg+0x6fd/0xbd0 [ 27.321437][ T266] ? rtnl_link_fill+0x920/0x920 [ 27.321438][ T266] ? filter_irq_stacks+0xd0/0xd0 [ 27.321439][ T266] ? stack_depot_save_flags+0x1bc/0x790 [ 27.321442][ T266] netlink_rcv_skb+0x14e/0x3a0 [ 27.321443][ T266] ? rtnl_link_fill+0x920/0x920 [ 27.321445][ T266] ? lock_release+0x184/0x1f0 [ 27.321446][ T266] ? netlink_ack+0xcf0/0xcf0 [ 27.321447][ T266] ? __netlink_lookup+0xb9/0x6b0 [ 27.321450][ T266] ? rcu_is_watching+0x16/0xd0 [ 27.321452][ T266] ? lock_release+0x184/0x1f0 [ 27.321453][ T266] netlink_unicast+0x486/0x750 [ 27.321455][ T266] ? netlink_attachskb+0x810/0x810 [ 27.321457][ T266] ? rcu_is_watching+0x16/0xd0 [ 27.321459][ T266] ? rcu_is_watching+0x16/0xd0 [ 27.321460][ T266] ? lock_acquire+0x13c/0x160 [ 27.321462][ T266] netlink_sendmsg+0x735/0xc60 [ 27.321464][ T266] ? netlink_unicast+0x750/0x750 [ 27.321466][ T266] ? rcu_is_watching+0x16/0xd0 [ 27.321468][ T266] ? lock_release+0x184/0x1f0 [ 27.321470][ T266] ____sys_sendmsg+0x415/0x880 [ 27.321471][ T266] ? copy_msghdr_from_user+0x279/0x420 [ 27.321473][ T266] ? get_timestamp.constprop.0+0x390/0x390 [ 27.321474][ T266] ? move_addr_to_kernel+0x40/0x40 [ 27.321476][ T266] ? filter_irq_stacks+0xd0/0xd0 [ 27.321478][ T266] ___sys_sendmsg+0x14e/0x1d0 [ 27.321480][ T266] ? copy_msghdr_from_user+0x420/0x420 [ 27.321485][ T266] __sys_sendmsg+0x12c/0x1d0 [ 27.321487][ T266] ? __sys_sendmsg_sock+0x20/0x20 [ 27.321489][ T266] ? rcu_is_watching+0x16/0xd0 [ 27.321492][ T266] do_syscall_64+0xff/0x530 [ 27.321493][ T266] ? exc_page_fault+0xee/0x100 [ 27.321495][ T266] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 27.321497][ T266] RIP: 0033:0x7fa22d65754e [ 27.321498][ T266] 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 [ 27.321500][ T266] RSP: 002b:00007ffd3f4a75a0 EFLAGS: 00000202 ORIG_RAX: 000000000000002e [ 27.321504][ T266] RAX: ffffffffffffffda RBX: 0000000000000003 RCX: 00007fa22d65754e [ 27.321505][ T266] RDX: 0000000000000000 RSI: 00007ffd3f4a7650 RDI: 0000000000000005 [ 27.321506][ T266] RBP: 00007ffd3f4a75b0 R08: 0000000000000000 R09: 0000000000000000 [ 27.321507][ T266] R10: 0000000000000000 R11: 0000000000000202 R12: 000000006a90e58d [ 27.321508][ T266] R13: 00000000004a1620 R14: 0000000000000000 R15: 00007ffd3f4a7d10 [ 27.321510][ T266] [ 27.354039][ T266] ip (266) used greatest stack depth: 23016 bytes left [ 27.401918][ T36] br0: port 2(veth2) entered blocking state [ 27.402117][ T36] br0: port 2(veth2) entered forwarding state [ 33.639478][ T290] br0: port 1(veth1) entered disabled state [ 33.639498][ T290] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 33.639501][ T290] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 290, name: ip [ 33.639503][ T290] preempt_count: 202, expected: 0 [ 33.639504][ T290] RCU nest depth: 0, expected: 0 [ 33.639506][ T290] INFO: lockdep is turned off. [ 33.639508][ T290] irq event stamp: 0 [ 33.639509][ T290] hardirqs last enabled at (0): [<0000000000000000>] 0x0 [ 33.639515][ T290] hardirqs last disabled at (0): [] copy_process+0x1ccd/0x6240 [ 33.639523][ T290] softirqs last enabled at (0): [] copy_process+0x1d21/0x6240 [ 33.639525][ T290] softirqs last disabled at (0): [<0000000000000000>] 0x0 [ 33.639528][ T290] Preemption disabled at: [ 33.639529][ T290] [<0000000000000000>] 0x0 [ 33.639535][ T290] CPU: 0 UID: 0 PID: 290 Comm: ip Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 33.639540][ T290] Tainted: [W]=WARN [ 33.639541][ T290] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 33.639543][ T290] Call Trace: [ 33.639545][ T290] [ 33.639546][ T290] dump_stack_lvl+0x6f/0xa0 [ 33.639553][ T290] __might_resched.cold+0x1fe/0x2c1 [ 33.639558][ T290] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 33.639562][ T290] ? rcu_is_watching+0x16/0xd0 [ 33.639567][ T290] __kmalloc_noprof+0x443/0x760 [ 33.639572][ T290] ? __rwlock_init+0x150/0x150 [ 33.639575][ T290] ? alloc_buf.isra.0+0x4b/0x260 [ 33.639580][ T290] ? do_raw_spin_unlock+0x59/0x250 [ 33.639583][ T290] alloc_buf.isra.0+0x4b/0x260 [ 33.639585][ T290] put_chars+0x1e1/0x2f0 [ 33.639589][ T290] ? __send_to_port+0x420/0x420 [ 33.639591][ T290] ? printk_get_next_message+0x240/0x650 [ 33.639596][ T290] hvc_console_print+0x292/0x780 [ 33.639601][ T290] ? hvc_write+0x3a0/0x3a0 [ 33.639605][ T290] ? __rwlock_init+0x150/0x150 [ 33.639607][ T290] ? rcu_is_watching+0x16/0xd0 [ 33.639610][ T290] ? lock_acquire+0x13c/0x160 [ 33.639613][ T290] console_emit_next_record+0x22f/0x4c0 [ 33.639617][ T290] ? devkmsg_read+0x4b0/0x4b0 [ 33.639620][ T290] ? rcu_is_watching+0x16/0xd0 [ 33.639622][ T290] ? rcu_is_watching+0x16/0xd0 [ 33.639624][ T290] ? rcu_is_watching+0x16/0xd0 [ 33.639627][ T290] ? lock_acquire+0x13c/0x160 [ 33.639630][ T290] ? console_flush_one_record+0x111/0x710 [ 33.639633][ T290] console_flush_one_record+0x46f/0x710 [ 33.639636][ T290] ? console_emit_next_record+0x4c0/0x4c0 [ 33.639643][ T290] console_unlock+0xee/0x1f0 [ 33.639646][ T290] ? lock_acquire+0x13c/0x160 [ 33.639648][ T290] ? console_flush_one_record+0x710/0x710 [ 33.639650][ T290] ? rcu_is_watching+0x16/0xd0 [ 33.639652][ T290] ? lock_release+0x184/0x1f0 [ 33.639654][ T290] ? lock_acquire+0x60/0x160 [ 33.639656][ T290] ? __rcu_read_lock+0x30/0x70 [ 33.639659][ T290] ? __down_trylock_console_sem+0x5e/0xa0 [ 33.639662][ T290] ? vprintk_emit+0x320/0x3e0 [ 33.639665][ T290] vprintk_emit+0x37c/0x3e0 [ 33.639668][ T290] ? wake_up_klogd_work_func+0x90/0x90 [ 33.639671][ T290] ? rcu_is_watching+0x16/0xd0 [ 33.639673][ T290] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 33.639677][ T290] ? trace_hardirqs_on+0x36/0x40 [ 33.639680][ T290] _printk+0xc7/0x100 [ 33.639684][ T290] ? snapshot_read.cold+0x21/0x21 [ 33.639687][ T290] ? ipv6_mc_down+0x17e/0x2d0 [ 33.639693][ T290] br_set_state+0x22f/0x430 [bridge] [ 33.639713][ T290] br_stp_disable_port+0x11f/0x390 [bridge] [ 33.639726][ T290] br_device_event+0x7b5/0x8f0 [bridge] [ 33.639740][ T290] ? _raw_spin_unlock_irqrestore+0x40/0x80 [ 33.639745][ T290] ? _sub_I_65535_1+0x4d0/0x4d0 [stp] [ 33.639749][ T290] ? addrconf_notify+0x2c8/0xf30 [ 33.639754][ T290] notifier_call_chain+0xae/0x300 [ 33.639758][ T290] __dev_notify_flags+0x23c/0x3c0 [ 33.639763][ T290] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 33.639766][ T290] ? netif_change_name+0x8c0/0x8c0 [ 33.639769][ T290] ? netif_set_allmulti+0x250/0x250 [ 33.639772][ T290] ? __kernel_text_address+0x12/0x30 [ 33.639775][ T290] ? write_profile+0xf0/0xf0 [ 33.639778][ T290] ? unwind_get_return_address+0x67/0xd0 [ 33.639788][ T290] netif_change_flags+0xfe/0x190 [ 33.639791][ T290] do_setlink.isra.0+0x1cc3/0x2750 [ 33.639796][ T290] ? stack_trace_save+0x93/0xc0 [ 33.639798][ T290] ? rtnl_link_get_size+0x350/0x350 [ 33.639800][ T290] ? rcu_is_watching+0x16/0xd0 [ 33.639803][ T290] ? stack_depot_save_flags+0x1bc/0x790 [ 33.639808][ T290] ? kasan_save_stack+0x3d/0x50 [ 33.639812][ T290] ? kasan_save_stack+0x2f/0x50 [ 33.639814][ T290] ? kasan_save_track+0x14/0x30 [ 33.639816][ T290] ? __kasan_kmalloc+0x7b/0x90 [ 33.639819][ T290] ? __kmalloc_cache_noprof+0x29a/0x620 [ 33.639821][ T290] ? rtnl_newlink+0x124/0x11c0 [ 33.639823][ T290] ? rtnetlink_rcv_msg+0x6fd/0xbd0 [ 33.639825][ T290] ? netlink_rcv_skb+0x14e/0x3a0 [ 33.639829][ T290] ? netlink_unicast+0x486/0x750 [ 33.639831][ T290] ? netlink_sendmsg+0x735/0xc60 [ 33.639833][ T290] ? ____sys_sendmsg+0x415/0x880 [ 33.639836][ T290] ? ___sys_sendmsg+0x14e/0x1d0 [ 33.639839][ T290] ? __sys_sendmsg+0x12c/0x1d0 [ 33.639841][ T290] ? do_syscall_64+0xff/0x530 [ 33.639844][ T290] ? entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 33.639848][ T290] ? rcu_is_watching+0x16/0xd0 [ 33.639851][ T290] ? lock_acquire+0x13c/0x160 [ 33.639853][ T290] ? rcu_is_watching+0x16/0xd0 [ 33.639855][ T290] ? rcu_is_watching+0x16/0xd0 [ 33.639858][ T290] ? trace_contention_end+0xb3/0x180 [ 33.639862][ T290] ? __mutex_lock+0x1db/0x1ea0 [ 33.639864][ T290] ? __mutex_lock+0x9a3/0x1ea0 [ 33.639866][ T290] ? rtnl_newlink+0x9a8/0x11c0 [ 33.639869][ T290] ? ww_mutex_lock+0x160/0x160 [ 33.639873][ T290] ? __rtnl_newlink+0x3fa/0xa50 [ 33.639876][ T290] rtnl_newlink+0x9f1/0x11c0 [ 33.639879][ T290] ? rcu_is_watching+0x16/0xd0 [ 33.639882][ T290] ? rtnl_bridge_getlink+0x850/0x850 [ 33.639884][ T290] ? lock_acquire+0x13c/0x160 [ 33.639886][ T290] ? rcu_is_watching+0x16/0xd0 [ 33.639889][ T290] ? is_bpf_text_address+0x3e/0x110 [ 33.639893][ T290] ? is_bpf_text_address+0x72/0x110 [ 33.639896][ T290] ? kernel_text_address+0x149/0x170 [ 33.639898][ T290] ? __kernel_text_address+0x12/0x30 [ 33.639900][ T290] ? write_profile+0xf0/0xf0 [ 33.639902][ T290] ? unwind_get_return_address+0x67/0xd0 [ 33.639904][ T290] ? rcu_is_watching+0x16/0xd0 [ 33.639906][ T290] ? rcu_is_watching+0x16/0xd0 [ 33.639908][ T290] ? cap_capable+0x1d7/0x3d0 [ 33.639913][ T290] ? lock_acquire+0x13c/0x160 [ 33.639915][ T290] ? rcu_is_watching+0x16/0xd0 [ 33.639918][ T290] ? rtnl_bridge_getlink+0x850/0x850 [ 33.639920][ T290] rtnetlink_rcv_msg+0x6fd/0xbd0 [ 33.639923][ T290] ? rtnl_link_fill+0x920/0x920 [ 33.639925][ T290] ? filter_irq_stacks+0xd0/0xd0 [ 33.639927][ T290] ? stack_depot_save_flags+0x1bc/0x790 [ 33.639931][ T290] netlink_rcv_skb+0x14e/0x3a0 [ 33.639933][ T290] ? rtnl_link_fill+0x920/0x920 [ 33.639935][ T290] ? lock_release+0x184/0x1f0 [ 33.639938][ T290] ? netlink_ack+0xcf0/0xcf0 [ 33.639940][ T290] ? __netlink_lookup+0xb9/0x6b0 [ 33.639944][ T290] ? rcu_is_watching+0x16/0xd0 [ 33.639946][ T290] ? lock_release+0x184/0x1f0 [ 33.639949][ T290] netlink_unicast+0x486/0x750 [ 33.639952][ T290] ? netlink_attachskb+0x810/0x810 [ 33.639955][ T290] ? rcu_is_watching+0x16/0xd0 [ 33.639957][ T290] ? rcu_is_watching+0x16/0xd0 [ 33.639960][ T290] ? lock_acquire+0x13c/0x160 [ 33.639963][ T290] netlink_sendmsg+0x735/0xc60 [ 33.639966][ T290] ? netlink_unicast+0x750/0x750 [ 33.639969][ T290] ? rcu_is_watching+0x16/0xd0 [ 33.639971][ T290] ? lock_release+0x184/0x1f0 [ 33.639974][ T290] ____sys_sendmsg+0x415/0x880 [ 33.639977][ T290] ? copy_msghdr_from_user+0x279/0x420 [ 33.639979][ T290] ? get_timestamp.constprop.0+0x390/0x390 [ 33.639982][ T290] ? move_addr_to_kernel+0x40/0x40 [ 33.639984][ T290] ? filter_irq_stacks+0xd0/0xd0 [ 33.639989][ T290] ___sys_sendmsg+0x14e/0x1d0 [ 33.639991][ T290] ? copy_msghdr_from_user+0x420/0x420 [ 33.639999][ T290] __sys_sendmsg+0x12c/0x1d0 [ 33.640002][ T290] ? __sys_sendmsg_sock+0x20/0x20 [ 33.640007][ T290] ? rcu_is_watching+0x16/0xd0 [ 33.640010][ T290] do_syscall_64+0xff/0x530 [ 33.640012][ T290] ? exc_page_fault+0xee/0x100 [ 33.640015][ T290] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 33.640018][ T290] RIP: 0033:0x7f144db4f54e [ 33.640021][ T290] 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 [ 33.640023][ T290] RSP: 002b:00007ffc9250daa0 EFLAGS: 00000202 ORIG_RAX: 000000000000002e [ 33.640028][ T290] RAX: ffffffffffffffda RBX: 0000000000000003 RCX: 00007f144db4f54e [ 33.640030][ T290] RDX: 0000000000000000 RSI: 00007ffc9250db50 RDI: 0000000000000005 [ 33.640031][ T290] RBP: 00007ffc9250dab0 R08: 0000000000000000 R09: 0000000000000000 [ 33.640033][ T290] R10: 0000000000000000 R11: 0000000000000202 R12: 000000006a90e594 [ 33.640035][ T290] R13: 00000000004a1620 R14: 0000000000000000 R15: 00007ffc9250e210 [ 33.640039][ T290] [ 33.705599][ T291] br0: port 2(veth2) entered disabled state [ 33.722568][ T292] veth2: left allmulticast mode [ 33.723268][ T292] veth2: left promiscuous mode [ 33.723536][ T292] br0: port 2(veth2) entered disabled state [ 33.724217][ T292] veth1: left allmulticast mode [ 33.724401][ T292] veth1: left promiscuous mode [ 33.724984][ T292] br0: port 1(veth1) entered disabled state