[ 10.051326][ T194] ip (194) used greatest stack depth: 24304 bytes left [ 10.051346][ T194] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 10.051349][ T194] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 194, name: ip [ 10.051351][ T194] preempt_count: 2, expected: 0 [ 10.051353][ T194] RCU nest depth: 0, expected: 0 [ 10.051354][ T194] locks held by ip/194: 5, last CPU#1: [ 10.051357][ T194] #0: ffffffffa68027b8 (low_water_lock){+.+.}-{3:3}, at: do_exit+0x887/0xdc0 [ 10.051372][ T194] #1: ffffffffa6969cc0 (console_lock){+.+.}-{0:0}, at: vprintk_emit+0x320/0x3e0 [ 10.051380][ T194] #2: ffffffffa6969d38 (console_srcu){....}-{0:0}, at: console_flush_one_record+0x106/0x710 [ 10.051386][ T194] #3: ffffffffa6889660 (console_owner){....}-{0:0}, at: console_lock_spinning_enable+0x40/0x60 [ 10.051392][ T194] #4: ffffffffa6889560 (printk_legacy_map-wait-type-override){....}-{3:3}, at: console_emit_next_record+0x1df/0x4c0 [ 10.051398][ T194] irq event stamp: 33696 [ 10.051399][ T194] hardirqs last enabled at (33695): [] __down_trylock_console_sem+0x86/0xa0 [ 10.051403][ T194] hardirqs last disabled at (33696): [] console_emit_next_record+0x3d4/0x4c0 [ 10.051406][ T194] softirqs last enabled at (32728): [] handle_softirqs+0x67c/0x900 [ 10.051408][ T194] softirqs last disabled at (31527): [] __irq_exit_rcu+0x145/0x1c0 [ 10.051412][ T194] Preemption disabled at: [ 10.051413][ T194] [<0000000000000000>] 0x0 [ 10.051422][ T194] CPU: 1 UID: 0 PID: 194 Comm: ip Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 10.051426][ T194] Tainted: [W]=WARN [ 10.051427][ T194] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 10.051430][ T194] Call Trace: [ 10.051432][ T194] [ 10.051434][ T194] dump_stack_lvl+0x6f/0xa0 [ 10.051443][ T194] __might_resched.cold+0x1fe/0x2c1 [ 10.051449][ T194] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 10.051455][ T194] ? __kmalloc_noprof+0xdb/0x760 [ 10.051462][ T194] __kmalloc_noprof+0x443/0x760 [ 10.051466][ T194] ? alloc_buf.isra.0+0x4b/0x260 [ 10.051475][ T194] ? do_raw_spin_unlock+0x59/0x250 [ 10.051479][ T194] alloc_buf.isra.0+0x4b/0x260 [ 10.051484][ T194] put_chars+0x1e1/0x2f0 [ 10.051489][ T194] ? __send_to_port+0x420/0x420 [ 10.051491][ T194] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 10.051497][ T194] ? validate_chain+0x38b/0xc20 [ 10.051509][ T194] hvc_console_print+0x292/0x780 [ 10.051520][ T194] ? hvc_write+0x3a0/0x3a0 [ 10.051523][ T194] ? rcu_is_watching+0x16/0xd0 [ 10.051527][ T194] ? lock_acquire+0x13c/0x160 [ 10.051534][ T194] console_emit_next_record+0x22f/0x4c0 [ 10.051540][ T194] ? devkmsg_read+0x4b0/0x4b0 [ 10.051543][ T194] ? console_flush_one_record+0x106/0x710 [ 10.051548][ T194] ? rcu_is_watching+0x16/0xd0 [ 10.051551][ T194] ? lock_acquire+0x13c/0x160 [ 10.051557][ T194] console_flush_one_record+0x46f/0x710 [ 10.051563][ T194] ? console_emit_next_record+0x4c0/0x4c0 [ 10.051566][ T194] ? __lock_acquire+0x518/0xc20 [ 10.051573][ T194] console_unlock+0xee/0x1f0 [ 10.051577][ T194] ? console_flush_one_record+0x710/0x710 [ 10.051580][ T194] ? rcu_is_watching+0x16/0xd0 [ 10.051583][ T194] ? lock_acquire+0x60/0x160 [ 10.051589][ T194] ? __down_trylock_console_sem+0x5e/0xa0 [ 10.051592][ T194] ? vprintk_emit+0x320/0x3e0 [ 10.051597][ T194] vprintk_emit+0x37c/0x3e0 [ 10.051603][ T194] ? wake_up_klogd_work_func+0x90/0x90 [ 10.051609][ T194] ? __lock_acquire+0x518/0xc20 [ 10.051615][ T194] _printk+0xc7/0x100 [ 10.051620][ T194] ? snapshot_read.cold+0x21/0x21 [ 10.051625][ T194] ? do_raw_spin_lock+0x131/0x280 [ 10.051629][ T194] ? __rwlock_init+0x150/0x150 [ 10.051636][ T194] ? do_raw_spin_lock+0x131/0x280 [ 10.051640][ T194] do_exit.cold+0x82/0x9c [ 10.051646][ T194] ? exit_notify+0x890/0x890 [ 10.051648][ T194] ? __lock_release.isra.0+0x69/0x1a0 [ 10.051653][ T194] ? rcu_is_watching+0x16/0xd0 [ 10.051660][ T194] do_group_exit+0xb8/0x370 [ 10.051665][ T194] __x64_sys_exit_group+0x3c/0x50 [ 10.051668][ T194] x64_sys_call+0x1567/0x1570 [ 10.051671][ T194] do_syscall_64+0xff/0x530 [ 10.051676][ T194] ? exc_page_fault+0xee/0x100 [ 10.051680][ T194] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 10.051684][ T194] RIP: 0033:0x7fd605e571b8 [ 10.051687][ T194] Code: Unable to access opcode bytes at 0x7fd605e5718e. [ 10.051689][ T194] RSP: 002b:00007ffd2005eb18 EFLAGS: 00000246 ORIG_RAX: 00000000000000e7 [ 10.051692][ T194] RAX: ffffffffffffffda RBX: 00007fd605f87f88 RCX: 00007fd605e571b8 [ 10.051694][ T194] RDX: 00007fd605ba1fc8 RSI: fffffffffffffeb8 RDI: 0000000000000000 [ 10.051696][ T194] RBP: 00007ffd2005eb70 R08: 0000000000000000 R09: 0000000000008010 [ 10.051697][ T194] R10: 00007ffd2005e930 R11: 0000000000000246 R12: 0000000000000001 [ 10.051699][ T194] R13: 0000000000000000 R14: 00007fd605f86680 R15: 00007fd605f87fa0 [ 10.051712][ T194] [ 11.364164][ T237] br0: port 1(veth1) entered blocking state [ 11.364291][ T237] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 11.364293][ T237] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 237, name: ip [ 11.364295][ T237] preempt_count: 1, expected: 0 [ 11.364296][ T237] RCU nest depth: 0, expected: 0 [ 11.364297][ T237] locks held by ip/237: 5, last CPU#3: [ 11.364300][ T237] #0: ffffffffa70d2c40 (rtnl_mutex){+.+.}-{4:4}, at: rtnl_newlink+0x9a8/0x11c0 [ 11.364312][ T237] #1: ffffffffa6969cc0 (console_lock){+.+.}-{0:0}, at: vprintk_emit+0x320/0x3e0 [ 11.364318][ T237] #2: ffffffffa6969d38 (console_srcu){....}-{0:0}, at: console_flush_one_record+0x106/0x710 [ 11.364322][ T237] #3: ffffffffa6889660 (console_owner){....}-{0:0}, at: console_lock_spinning_enable+0x40/0x60 [ 11.364326][ T237] #4: ffffffffa6889560 (printk_legacy_map-wait-type-override){....}-{3:3}, at: console_emit_next_record+0x1df/0x4c0 [ 11.364330][ T237] irq event stamp: 14312 [ 11.364331][ T237] hardirqs last enabled at (14311): [] __down_trylock_console_sem+0x86/0xa0 [ 11.364333][ T237] hardirqs last disabled at (14312): [] console_emit_next_record+0x3d4/0x4c0 [ 11.364335][ T237] softirqs last enabled at (14222): [] __alloc_skb+0x4c2/0x5f0 [ 11.364339][ T237] softirqs last disabled at (14220): [] __alloc_skb+0x4c2/0x5f0 [ 11.364342][ T237] Preemption disabled at: [ 11.364342][ T237] [] vprintk_emit+0x31b/0x3e0 [ 11.364348][ T237] CPU: 3 UID: 0 PID: 237 Comm: ip Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 11.364352][ T237] Tainted: [W]=WARN [ 11.364352][ T237] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 11.364354][ T237] Call Trace: [ 11.364356][ T237] [ 11.364358][ T237] dump_stack_lvl+0x6f/0xa0 [ 11.364364][ T237] ? vprintk_emit+0x31b/0x3e0 [ 11.364366][ T237] __might_resched.cold+0x1fe/0x2c1 [ 11.364371][ T237] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 11.364375][ T237] ? __kmalloc_noprof+0xdb/0x760 [ 11.364381][ T237] __kmalloc_noprof+0x443/0x760 [ 11.364383][ T237] ? alloc_buf.isra.0+0x4b/0x260 [ 11.364388][ T237] ? do_raw_spin_unlock+0x59/0x250 [ 11.364391][ T237] alloc_buf.isra.0+0x4b/0x260 [ 11.364395][ T237] put_chars+0x1e1/0x2f0 [ 11.364398][ T237] ? __send_to_port+0x420/0x420 [ 11.364402][ T237] ? validate_chain+0x34a/0xc20 [ 11.364406][ T237] hvc_console_print+0x292/0x780 [ 11.364409][ T237] ? mark_usage+0x61/0x170 [ 11.364410][ T237] ? __lock_acquire+0x518/0xc20 [ 11.364412][ T237] ? __lock_acquire+0x518/0xc20 [ 11.364416][ T237] ? hvc_write+0x3a0/0x3a0 [ 11.364418][ T237] ? console_emit_next_record+0x1df/0x4c0 [ 11.364422][ T237] ? rcu_is_watching+0x16/0xd0 [ 11.364426][ T237] ? lock_acquire+0x13c/0x160 [ 11.364430][ T237] console_emit_next_record+0x22f/0x4c0 [ 11.364434][ T237] ? devkmsg_read+0x4b0/0x4b0 [ 11.364435][ T237] ? console_flush_one_record+0x106/0x710 [ 11.364439][ T237] ? rcu_is_watching+0x16/0xd0 [ 11.364441][ T237] ? lock_acquire+0x13c/0x160 [ 11.364445][ T237] console_flush_one_record+0x46f/0x710 [ 11.364449][ T237] ? console_emit_next_record+0x4c0/0x4c0 [ 11.364451][ T237] ? __lock_acquire+0x518/0xc20 [ 11.364456][ T237] console_unlock+0xee/0x1f0 [ 11.364459][ T237] ? console_flush_one_record+0x710/0x710 [ 11.364461][ T237] ? rcu_is_watching+0x16/0xd0 [ 11.364463][ T237] ? lock_acquire+0x60/0x160 [ 11.364467][ T237] ? __down_trylock_console_sem+0x5e/0xa0 [ 11.364469][ T237] ? vprintk_emit+0x320/0x3e0 [ 11.364472][ T237] vprintk_emit+0x37c/0x3e0 [ 11.364476][ T237] ? wake_up_klogd_work_func+0x90/0x90 [ 11.364479][ T237] ? __lock_release.isra.0+0x69/0x1a0 [ 11.364480][ T237] ? _raw_spin_unlock_irqrestore+0x40/0x80 [ 11.364485][ T237] ? mark_held_locks+0x40/0x70 [ 11.364488][ T237] _printk+0xc7/0x100 [ 11.364492][ T237] ? snapshot_read.cold+0x21/0x21 [ 11.364496][ T237] ? br_multicast_flood+0xab0/0xab0 [bridge] [ 11.364510][ T237] ? do_setlink.isra.0+0xa31/0x2750 [ 11.364511][ T237] ? rtnl_newlink+0x9f1/0x11c0 [ 11.364512][ T237] ? rtnetlink_rcv_msg+0x6fd/0xbd0 [ 11.364517][ T237] br_set_state+0x22f/0x430 [bridge] [ 11.364530][ T237] br_init_port+0xc4/0x200 [bridge] [ 11.364539][ T237] new_nbp+0x39c/0x580 [bridge] [ 11.364549][ T237] br_add_if+0x212/0x1320 [bridge] [ 11.364556][ T237] ? is_bpf_text_address+0x72/0x110 [ 11.364560][ T237] ? kernel_text_address+0x149/0x170 [ 11.364563][ T237] ? __kernel_text_address+0x12/0x30 [ 11.364567][ T237] do_set_master+0x357/0x580 [ 11.364572][ T237] do_setlink.isra.0+0xa31/0x2750 [ 11.364575][ T237] ? stack_trace_save+0x93/0xc0 [ 11.364579][ T237] ? rtnl_link_get_size+0x350/0x350 [ 11.364580][ T237] ? rcu_read_lock_any_held+0x66/0x90 [ 11.364582][ T237] ? stack_depot_save_flags+0x38e/0x790 [ 11.364586][ T237] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 11.364589][ T237] ? rcu_read_lock_any_held+0x3c/0x90 [ 11.364591][ T237] ? validate_chain+0x38b/0xc20 [ 11.364593][ T237] ? kasan_save_stack+0x3d/0x50 [ 11.364596][ T237] ? kasan_save_stack+0x2f/0x50 [ 11.364598][ T237] ? kasan_save_track+0x14/0x30 [ 11.364601][ T237] ? __lock_acquire+0x518/0xc20 [ 11.364603][ T237] ? netlink_seq_next+0x4e/0x60 [ 11.364606][ T237] ? ___sys_sendmsg+0xb0/0x1d0 [ 11.364610][ T237] ? lock_acquire.part.0+0xd4/0x280 [ 11.364612][ T237] ? rtnl_newlink+0x9a8/0x11c0 [ 11.364615][ T237] ? rcu_is_watching+0x16/0xd0 [ 11.364617][ T237] ? lock_acquire+0x13c/0x160 [ 11.364619][ T237] ? rcu_is_watching+0x16/0xd0 [ 11.364621][ T237] ? rcu_is_watching+0x16/0xd0 [ 11.364623][ T237] ? trace_contention_end+0xb3/0x180 [ 11.364627][ T237] ? __mutex_lock+0x1db/0x1ea0 [ 11.364629][ T237] ? __mutex_lock+0x9a3/0x1ea0 [ 11.364631][ T237] ? rtnl_newlink+0x9a8/0x11c0 [ 11.364634][ T237] ? ww_mutex_lock+0x160/0x160 [ 11.364636][ T237] ? nla_get_range_signed+0x3d0/0x3d0 [ 11.364641][ T237] ? __rtnl_newlink+0x3fa/0xa50 [ 11.364646][ T237] rtnl_newlink+0x9f1/0x11c0 [ 11.364651][ T237] ? rtnl_bridge_getlink+0x850/0x850 [ 11.364653][ T237] ? __lock_acquire+0x518/0xc20 [ 11.364658][ T237] ? lock_acquire.part.0+0xd4/0x280 [ 11.364660][ T237] ? find_held_lock+0x2b/0x80 [ 11.364662][ T237] ? rtnl_bridge_getlink+0x850/0x850 [ 11.364664][ T237] ? __lock_release.isra.0+0x69/0x1a0 [ 11.364667][ T237] ? rtnl_bridge_getlink+0x850/0x850 [ 11.364669][ T237] rtnetlink_rcv_msg+0x6fd/0xbd0 [ 11.364672][ T237] ? rtnl_link_fill+0x920/0x920 [ 11.364674][ T237] ? __lock_acquire+0x518/0xc20 [ 11.364678][ T237] ? lock_acquire.part.0+0xd4/0x280 [ 11.364680][ T237] ? find_held_lock+0x2b/0x80 [ 11.364684][ T237] netlink_rcv_skb+0x14e/0x3a0 [ 11.364685][ T237] ? rtnl_link_fill+0x920/0x920 [ 11.364688][ T237] ? netlink_ack+0xcf0/0xcf0 [ 11.364694][ T237] ? netlink_deliver_tap+0xc5/0x330 [ 11.364696][ T237] ? netlink_deliver_tap+0x13c/0x330 [ 11.364700][ T237] netlink_unicast+0x486/0x750 [ 11.364704][ T237] ? netlink_attachskb+0x810/0x810 [ 11.364707][ T237] ? __lock_acquire+0x518/0xc20 [ 11.364711][ T237] netlink_sendmsg+0x735/0xc60 [ 11.364714][ T237] ? netlink_unicast+0x750/0x750 [ 11.364718][ T237] ? __might_fault+0x97/0x140 [ 11.364724][ T237] ____sys_sendmsg+0x415/0x880 [ 11.364726][ T237] ? copy_msghdr_from_user+0x279/0x420 [ 11.364729][ T237] ? get_timestamp.constprop.0+0x390/0x390 [ 11.364730][ T237] ? move_addr_to_kernel+0x40/0x40 [ 11.364738][ T237] ___sys_sendmsg+0x14e/0x1d0 [ 11.364740][ T237] ? copy_msghdr_from_user+0x420/0x420 [ 11.364756][ T237] __sys_sendmsg+0x12c/0x1d0 [ 11.364759][ T237] ? __sys_sendmsg_sock+0x20/0x20 [ 11.364765][ T237] ? rcu_is_watching+0x16/0xd0 [ 11.364769][ T237] do_syscall_64+0xff/0x530 [ 11.364771][ T237] ? exc_page_fault+0xee/0x100 [ 11.364774][ T237] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 11.364777][ T237] RIP: 0033:0x7f3a21e1c54e [ 11.364780][ 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 [ 11.364782][ T237] RSP: 002b:00007ffe4e750880 EFLAGS: 00000202 ORIG_RAX: 000000000000002e [ 11.364785][ T237] RAX: ffffffffffffffda RBX: 0000000000000004 RCX: 00007f3a21e1c54e [ 11.364786][ T237] RDX: 0000000000000000 RSI: 00007ffe4e750930 RDI: 0000000000000005 [ 11.364787][ T237] RBP: 00007ffe4e750890 R08: 0000000000000000 R09: 0000000000000000 [ 11.364788][ T237] R10: 0000000000000000 R11: 0000000000000202 R12: 000000006a910d7a [ 11.364789][ T237] R13: 00000000004a1620 R14: 0000000000000000 R15: 00007ffe4e750ff0 [ 11.364795][ T237] [ 11.408972][ T237] br0: port 1(veth1) entered disabled state [ 11.409380][ T237] veth1: entered allmulticast mode [ 11.411005][ T237] veth1: entered promiscuous mode [ 11.420156][ T237] ip (237) used greatest stack depth: 23336 bytes left [ 11.440863][ T238] br0: port 2(veth2) entered blocking state [ 11.441175][ T238] br0: port 2(veth2) entered disabled state [ 11.441480][ T238] veth2: entered allmulticast mode [ 11.443357][ T238] veth2: entered promiscuous mode [ 11.521229][ T38] br0: port 1(veth1) entered blocking state [ 11.521764][ T38] br0: port 1(veth1) entered forwarding state [ 21.691895][ T189] br0: port 2(veth2) entered blocking state [ 21.691915][ T189] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 21.691917][ T189] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 189, name: kworker/u20:2 [ 21.691919][ T189] preempt_count: 202, expected: 0 [ 21.691920][ T189] RCU nest depth: 0, expected: 0 [ 21.691921][ T189] locks held by kworker/u20:2/189: 8, last CPU#0: [ 21.691924][ T189] #0: ff1100000114a940 ((wq_completion)events_unbound){+.+.}-{0:0}, at: process_one_work+0xd9a/0x1560 [ 21.691937][ T189] #1: ffa0000000557d10 ((linkwatch_work).work){+.+.}-{0:0}, at: process_one_work+0xdfc/0x1560 [ 21.691941][ T189] #2: ffffffffa70d2c40 (rtnl_mutex){+.+.}-{4:4}, at: linkwatch_event+0x4e/0xb0 [ 21.691947][ T189] #3: ff11000002692e58 (&br->lock){+...}-{3:3}, at: br_port_carrier_check+0x161/0x430 [bridge] [ 21.691962][ T189] #4: ffffffffa6969cc0 (console_lock){+.+.}-{0:0}, at: vprintk_emit+0x320/0x3e0 [ 21.691968][ T189] #5: ffffffffa6969d38 (console_srcu){....}-{0:0}, at: console_flush_one_record+0x106/0x710 [ 21.691971][ T189] #6: ffffffffa6889660 (console_owner){....}-{0:0}, at: console_lock_spinning_enable+0x40/0x60 [ 21.691975][ T189] #7: ffffffffa6889560 (printk_legacy_map-wait-type-override){....}-{3:3}, at: console_emit_next_record+0x1df/0x4c0 [ 21.691979][ T189] irq event stamp: 16241 [ 21.691980][ T189] hardirqs last enabled at (16240): [] __down_trylock_console_sem+0x86/0xa0 [ 21.691983][ T189] hardirqs last disabled at (16241): [] console_emit_next_record+0x3d4/0x4c0 [ 21.691985][ T189] softirqs last enabled at (16202): [] inet6_fill_ifla6_attrs+0x1b3e/0x21e0 [ 21.691989][ T189] softirqs last disabled at (16236): [] br_port_carrier_check+0x161/0x430 [bridge] [ 21.691997][ T189] Preemption disabled at: [ 21.691998][ T189] [<0000000000000000>] 0x0 [ 21.692004][ T189] CPU: 0 UID: 0 PID: 189 Comm: kworker/u20:2 Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 21.692008][ T189] Tainted: [W]=WARN [ 21.692009][ T189] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 21.692010][ T189] Workqueue: events_unbound linkwatch_event [ 21.692014][ T189] Call Trace: [ 21.692015][ T189] [ 21.692017][ T189] dump_stack_lvl+0x6f/0xa0 [ 21.692024][ T189] __might_resched.cold+0x1fe/0x2c1 [ 21.692029][ T189] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 21.692033][ T189] ? __kmalloc_noprof+0xdb/0x760 [ 21.692038][ T189] __kmalloc_noprof+0x443/0x760 [ 21.692040][ T189] ? alloc_buf.isra.0+0x4b/0x260 [ 21.692046][ T189] ? do_raw_spin_unlock+0x59/0x250 [ 21.692049][ T189] alloc_buf.isra.0+0x4b/0x260 [ 21.692052][ T189] put_chars+0x1e1/0x2f0 [ 21.692055][ T189] ? __send_to_port+0x420/0x420 [ 21.692058][ T189] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 21.692062][ T189] ? rcu_read_lock_any_held+0x3c/0x90 [ 21.692065][ T189] ? validate_chain+0x38b/0xc20 [ 21.692069][ T189] hvc_console_print+0x292/0x780 [ 21.692072][ T189] ? mark_usage+0x61/0x170 [ 21.692073][ T189] ? __lock_acquire+0x518/0xc20 [ 21.692075][ T189] ? __lock_acquire+0x518/0xc20 [ 21.692080][ T189] ? hvc_write+0x3a0/0x3a0 [ 21.692081][ T189] ? lock_acquire.part.0+0xd4/0x280 [ 21.692085][ T189] ? lock_acquire+0x13c/0x160 [ 21.692089][ T189] console_emit_next_record+0x22f/0x4c0 [ 21.692093][ T189] ? devkmsg_read+0x4b0/0x4b0 [ 21.692095][ T189] ? console_flush_one_record+0x106/0x710 [ 21.692099][ T189] ? rcu_is_watching+0x16/0xd0 [ 21.692101][ T189] ? lock_acquire+0x13c/0x160 [ 21.692105][ T189] console_flush_one_record+0x46f/0x710 [ 21.692110][ T189] ? console_emit_next_record+0x4c0/0x4c0 [ 21.692112][ T189] ? __lock_acquire+0x518/0xc20 [ 21.692117][ T189] console_unlock+0xee/0x1f0 [ 21.692120][ T189] ? console_flush_one_record+0x710/0x710 [ 21.692122][ T189] ? rcu_is_watching+0x16/0xd0 [ 21.692124][ T189] ? lock_acquire+0x60/0x160 [ 21.692128][ T189] ? __down_trylock_console_sem+0x5e/0xa0 [ 21.692130][ T189] ? vprintk_emit+0x320/0x3e0 [ 21.692133][ T189] vprintk_emit+0x37c/0x3e0 [ 21.692138][ T189] ? wake_up_klogd_work_func+0x90/0x90 [ 21.692141][ T189] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 21.692143][ T189] ? rcu_read_lock_any_held+0x3c/0x90 [ 21.692147][ T189] _printk+0xc7/0x100 [ 21.692151][ T189] ? snapshot_read.cold+0x21/0x21 [ 21.692157][ T189] ? lock_acquire.part.0+0xd4/0x280 [ 21.692161][ T189] br_set_state+0x22f/0x430 [bridge] [ 21.692171][ T189] br_init_port+0xc4/0x200 [bridge] [ 21.692180][ T189] br_stp_enable_port+0x12/0x50 [bridge] [ 21.692188][ T189] br_port_carrier_check+0x220/0x430 [bridge] [ 21.692197][ T189] br_device_event+0x52d/0x8f0 [bridge] [ 21.692206][ T189] ? _sub_I_65535_1+0x4d0/0x4d0 [stp] [ 21.692208][ T189] ? nlmsg_notify+0x62/0x250 [ 21.692215][ T189] notifier_call_chain+0xae/0x300 [ 21.692221][ T189] netif_state_change+0x139/0x340 [ 21.692226][ T189] ? call_netdevice_notifiers_info+0xd0/0xd0 [ 21.692231][ T189] ? linkwatch_do_dev+0xae/0xd0 [ 21.692233][ T189] __linkwatch_run_queue+0x34c/0x750 [ 21.692236][ T189] ? linkwatch_do_dev+0xd0/0xd0 [ 21.692239][ T189] ? lock_acquire.part.0+0xd4/0x280 [ 21.692243][ T189] linkwatch_event+0x7f/0xb0 [ 21.692245][ T189] ? __linkwatch_run_queue+0x750/0x750 [ 21.692249][ T189] process_one_work+0xe3e/0x1560 [ 21.692256][ T189] ? __queue_delayed_work+0x470/0x470 [ 21.692259][ T189] ? lock_acquire.part.0+0xd4/0x280 [ 21.692267][ T189] worker_thread+0x4f1/0xd60 [ 21.692271][ T189] ? rescuer_thread+0x1340/0x1340 [ 21.692273][ T189] ? __kthread_parkme+0xbd/0x210 [ 21.692276][ T189] ? rescuer_thread+0x1340/0x1340 [ 21.692279][ T189] ? rescuer_thread+0x1340/0x1340 [ 21.692281][ T189] kthread+0x367/0x460 [ 21.692283][ T189] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 21.692285][ T189] ? kthread_affine_preferred+0x4c0/0x4c0 [ 21.692288][ T189] ret_from_fork+0x474/0x6b0 [ 21.692292][ T189] ? arch_exit_to_user_mode_prepare.isra.0+0x120/0x120 [ 21.692297][ T189] ? __switch_to+0x5a3/0xe00 [ 21.692301][ T189] ? kthread_affine_preferred+0x4c0/0x4c0 [ 21.692304][ T189] ret_from_fork_asm+0x11/0x20 [ 21.692318][ T189] [ 21.720848][ T189] br0: port 2(veth2) entered forwarding state [ 26.580574][ C3] [ 26.580594][ C3] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 26.580597][ C3] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 0, name: swapper/3 [ 26.580598][ C3] preempt_count: 104, expected: 0 [ 26.580599][ C3] RCU nest depth: 0, expected: 0 [ 26.580600][ C3] INFO: lockdep is turned off. [ 26.580602][ C3] irq event stamp: 540358 [ 26.580602][ C3] hardirqs last enabled at (540358): [] _raw_spin_unlock_irq+0x28/0x50 [ 26.580612][ C3] hardirqs last disabled at (540357): [] _raw_spin_lock_irq+0x4a/0x50 [ 26.580614][ C3] softirqs last enabled at (540324): [] handle_softirqs+0x67c/0x900 [ 26.580618][ C3] softirqs last disabled at (540355): [] __irq_exit_rcu+0x145/0x1c0 [ 26.580620][ C3] Preemption disabled at: [ 26.580621][ C3] [<0000000000000000>] 0x0 [ 26.580628][ C3] CPU: 3 UID: 0 PID: 0 Comm: swapper/3 Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 26.580632][ C3] Tainted: [W]=WARN [ 26.580633][ C3] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 26.580635][ C3] Call Trace: [ 26.580637][ C3] [ 26.580639][ C3] dump_stack_lvl+0x6f/0xa0 [ 26.580645][ C3] __might_resched.cold+0x1fe/0x2c1 [ 26.580649][ C3] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 26.580653][ C3] ? __asan_memcpy+0x3c/0x60 [ 26.580656][ C3] ? rcu_is_watching+0x16/0xd0 [ 26.580660][ C3] __kmalloc_noprof+0x443/0x760 [ 26.580664][ C3] ? __rwlock_init+0x150/0x150 [ 26.580667][ C3] ? alloc_buf.isra.0+0x4b/0x260 [ 26.580670][ C3] ? do_raw_spin_unlock+0x59/0x250 [ 26.580672][ C3] alloc_buf.isra.0+0x4b/0x260 [ 26.580674][ C3] put_chars+0x1e1/0x2f0 [ 26.580676][ C3] ? __send_to_port+0x420/0x420 [ 26.580677][ C3] ? console_prepend_replay+0x20/0x20 [ 26.580681][ C3] hvc_console_print+0x292/0x780 [ 26.580684][ C3] ? hvc_write+0x3a0/0x3a0 [ 26.580686][ C3] ? rcu_is_watching+0x16/0xd0 [ 26.580687][ C3] ? lock_acquire+0x13c/0x160 [ 26.580689][ C3] console_emit_next_record+0x22f/0x4c0 [ 26.580692][ C3] ? devkmsg_read+0x4b0/0x4b0 [ 26.580694][ C3] ? rcu_is_watching+0x16/0xd0 [ 26.580696][ C3] ? rcu_is_watching+0x16/0xd0 [ 26.580697][ C3] ? lock_acquire+0x13c/0x160 [ 26.580699][ C3] ? console_flush_one_record+0x111/0x710 [ 26.580701][ C3] console_flush_one_record+0x46f/0x710 [ 26.580703][ C3] ? console_emit_next_record+0x4c0/0x4c0 [ 26.580706][ C3] console_unlock+0xee/0x1f0 [ 26.580708][ C3] ? lock_acquire+0x13c/0x160 [ 26.580709][ C3] ? console_flush_one_record+0x710/0x710 [ 26.580711][ C3] ? rcu_is_watching+0x16/0xd0 [ 26.580713][ C3] ? lock_release+0x184/0x1f0 [ 26.580714][ C3] ? lock_acquire+0x60/0x160 [ 26.580716][ C3] ? __down_trylock_console_sem+0x5e/0xa0 [ 26.580718][ C3] ? vprintk_emit+0x320/0x3e0 [ 26.580720][ C3] vprintk_emit+0x37c/0x3e0 [ 26.580722][ C3] ? wake_up_klogd_work_func+0x90/0x90 [ 26.580724][ C3] ? br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 26.580736][ C3] ? lock_release+0x184/0x1f0 [ 26.580737][ C3] ? br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 26.580744][ C3] ? br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 26.580750][ C3] ? is_module_text_address+0x154/0x250 [ 26.580754][ C3] _printk+0xc7/0x100 [ 26.580757][ C3] ? snapshot_read.cold+0x21/0x21 [ 26.580758][ C3] ? arch_stack_walk+0xd7/0x130 [ 26.580762][ C3] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 26.580765][ C3] ? nbcon_cpu_emergency_enter+0x28/0x80 [ 26.580766][ C3] print_irq_inversion_bug.part.0+0x32/0xc0 [ 26.580769][ C3] mark_lock_irq+0x989/0x9c0 [ 26.580771][ C3] mark_lock+0x1d7/0xa00 [ 26.580773][ C3] mark_usage+0x42/0x170 [ 26.580775][ C3] __lock_acquire+0x388/0xc20 [ 26.580777][ C3] lock_acquire.part.0+0xd4/0x280 [ 26.580779][ C3] ? br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 26.580786][ C3] ? rcu_is_watching+0x16/0xd0 [ 26.580788][ C3] ? lock_acquire+0x13c/0x160 [ 26.580789][ C3] ? br_message_age_timer_expired+0x70/0x70 [bridge] [ 26.580796][ C3] _raw_spin_lock+0x33/0x40 [ 26.580798][ C3] ? br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 26.580804][ C3] br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 26.580810][ C3] ? br_message_age_timer_expired+0x70/0x70 [bridge] [ 26.580816][ C3] call_timer_fn+0x160/0x4d0 [ 26.580819][ C3] ? detach_if_pending+0x1d0/0x1d0 [ 26.580820][ C3] ? debug_object_active_state+0x430/0x430 [ 26.580824][ C3] ? find_held_lock+0x2b/0x80 [ 26.580826][ C3] ? __lock_release.isra.0+0x69/0x1a0 [ 26.580828][ C3] ? rcu_is_watching+0x16/0xd0 [ 26.580830][ C3] __run_timers+0x68f/0xaa0 [ 26.580832][ C3] ? br_message_age_timer_expired+0x70/0x70 [bridge] [ 26.580838][ C3] ? __bpf_trace_itimer_expire+0x10/0x10 [ 26.580840][ C3] ? __lock_acquire+0x518/0xc20 [ 26.580843][ C3] ? __rwlock_init+0x150/0x150 [ 26.580845][ C3] run_timer_softirq+0xf0/0x160 [ 26.580847][ C3] ? __run_timers+0xaa0/0xaa0 [ 26.580849][ C3] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 26.580851][ C3] ? rcu_is_watching+0x16/0xd0 [ 26.580853][ C3] handle_softirqs+0x1d3/0x900 [ 26.580855][ C3] ? __lock_release.isra.0+0x69/0x1a0 [ 26.580856][ C3] ? _local_bh_enable+0xc0/0xc0 [ 26.580858][ C3] __irq_exit_rcu+0x145/0x1c0 [ 26.580860][ C3] irq_exit_rcu+0xe/0x30 [ 26.580861][ C3] sysvec_apic_timer_interrupt+0x9d/0xe0 [ 26.580864][ C3] [ 26.580865][ C3] [ 26.580865][ C3] ? lockdep_hardirqs_on+0x91/0x130 [ 26.580867][ C3] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 26.580870][ C3] RIP: 0010:pv_native_safe_halt+0xf/0x10 [ 26.580873][ C3] Code: 48 8b 3d 94 e2 f5 01 e8 1f 00 00 00 48 2b 05 58 a3 95 00 c3 0f 1f 80 00 00 00 00 f3 0f 1e fa eb 07 0f 00 2d 13 96 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.580874][ C3] RSP: 0018:ffa0000000167e00 EFLAGS: 00000282 [ 26.580878][ C3] RAX: 0000000000083ec1 RBX: ff11000001c88040 RCX: ffffffffa36f0307 [ 26.580879][ C3] RDX: ff11000001c88040 RSI: ffffffffa6438b01 RDI: ffffffffa5e8d8e0 [ 26.580880][ C3] RBP: 0000000000000000 R08: 0000000000000000 R09: 0000000000000000 [ 26.580881][ C3] R10: 0000000000000003 R11: 0000000000000001 R12: 1ff400000002cfc3 [ 26.580882][ C3] R13: 0000000000000000 R14: dffffc0000000000 R15: 0000000000000000 [ 26.580883][ C3] ? cpuidle_idle_call.constprop.0+0x237/0x410 [ 26.580886][ C3] default_idle+0x9/0x10 [ 26.580888][ C3] default_idle_call+0x6e/0xb0 [ 26.580890][ C3] cpuidle_idle_call.constprop.0+0x237/0x410 [ 26.580892][ C3] ? arch_cpu_idle_exit+0x40/0x40 [ 26.580893][ C3] ? mark_tsc_async_resets+0x30/0x30 [ 26.580896][ C3] ? rcu_is_watching+0x16/0xd0 [ 26.580898][ C3] do_idle+0xd8/0x190 [ 26.580899][ C3] cpu_startup_entry+0x53/0x70 [ 26.580901][ C3] start_secondary+0x204/0x2b0 [ 26.580902][ C3] ? set_cpu_sibling_map+0x2130/0x2130 [ 26.580904][ C3] common_startup_64+0x13e/0x148 [ 26.580909][ C3] [ 26.603678][ C3] ======================================================== [ 26.603880][ C3] WARNING: possible irq lock inversion dependency detected [ 26.604125][ C3] 7.2.0-virtme #1 Tainted: G W [ 26.604343][ C3] -------------------------------------------------------- [ 26.604541][ C3] swapper/3/0 just changed the state of lock: [ 26.604706][ C3] ff11000002692e58 (&br->lock){+.-.}-{3:3}, at: br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 26.605030][ C3] but this lock took another, SOFTIRQ-unsafe lock in the past: [ 26.605273][ C3] (fs_reclaim){+.+.}-{0:0} [ 26.605276][ C3] [ 26.605276][ C3] [ 26.605276][ C3] and interrupts could create inverse lock ordering between them. [ 26.605276][ C3] [ 26.605844][ C3] [ 26.605844][ C3] other info that might help us debug this: [ 26.606096][ C3] Chain exists of: [ 26.606096][ C3] &br->lock --> console_owner --> fs_reclaim [ 26.606096][ C3] [ 26.606446][ C3] Possible interrupt unsafe locking scenario: [ 26.606446][ C3] [ 26.606648][ C3] CPU0 CPU1 [ 26.606829][ C3] ---- ---- [ 26.606962][ C3] lock(fs_reclaim); [ 26.607119][ C3] local_irq_disable(); [ 26.607289][ C3] lock(&br->lock); [ 26.607505][ C3] lock(console_owner); [ 26.607716][ C3] [ 26.607818][ C3] lock(&br->lock); [ 26.607924][ C3] [ 26.607924][ C3] *** DEADLOCK *** [ 26.607924][ C3] [ 26.608163][ C3] locks held by swapper/3/0: 1, last CPU#3: [ 26.608378][ C3] #0: ffa0000000280c90 ((&p->forward_delay_timer)){+.-.}-{0:0}, at: call_timer_fn+0x110/0x4d0 [ 26.608695][ C3] [ 26.608695][ C3] the shortest dependencies between 2nd lock and 1st lock: [ 26.608967][ C3] -> (fs_reclaim){+.+.}-{0:0} { [ 26.609105][ C3] HARDIRQ-ON-W at: [ 26.609254][ C3] __lock_acquire+0x388/0xc20 [ 26.609431][ C3] lock_acquire.part.0+0xd4/0x280 [ 26.609644][ C3] fs_reclaim_acquire+0xd5/0x120 [ 26.609815][ C3] __kmalloc_cache_noprof+0x6e/0x620 [ 26.610059][ C3] kthread_create_worker_on_node+0xea/0x210 [ 26.610305][ C3] workqueue_init+0x2a/0x680 [ 26.610528][ C3] kernel_init_freeable+0x2fe/0x630 [ 26.610728][ C3] kernel_init+0x21/0x150 [ 26.610943][ C3] ret_from_fork+0x474/0x6b0 [ 26.611156][ C3] ret_from_fork_asm+0x11/0x20 [ 26.611333][ C3] SOFTIRQ-ON-W at: [ 26.611479][ C3] __lock_acquire+0x388/0xc20 [ 26.611650][ C3] lock_acquire.part.0+0xd4/0x280 [ 26.611867][ C3] fs_reclaim_acquire+0xd5/0x120 [ 26.612035][ C3] __kmalloc_cache_noprof+0x6e/0x620 [ 26.612278][ C3] kthread_create_worker_on_node+0xea/0x210 [ 26.612532][ C3] workqueue_init+0x2a/0x680 [ 26.612745][ C3] kernel_init_freeable+0x2fe/0x630 [ 26.612944][ C3] kernel_init+0x21/0x150 [ 26.613157][ C3] ret_from_fork+0x474/0x6b0 [ 26.613374][ C3] ret_from_fork_asm+0x11/0x20 [ 26.613541][ C3] INITIAL USE at: [ 26.613688][ C3] __lock_acquire+0x388/0xc20 [ 26.613854][ C3] lock_acquire.part.0+0xd4/0x280 [ 26.614061][ C3] fs_reclaim_acquire+0xd5/0x120 [ 26.614230][ C3] __kmalloc_cache_noprof+0x6e/0x620 [ 26.614507][ C3] kthread_create_worker_on_node+0xea/0x210 [ 26.614749][ C3] workqueue_init+0x2a/0x680 [ 26.614962][ C3] kernel_init_freeable+0x2fe/0x630 [ 26.615127][ C3] kernel_init+0x21/0x150 [ 26.615346][ C3] ret_from_fork+0x474/0x6b0 [ 26.615513][ C3] ret_from_fork_asm+0x11/0x20 [ 26.615723][ C3] } [ 26.615796][ C3] ... key at: [] __fs_reclaim_map+0x0/0xbe0 [ 26.616041][ C3] ... acquired at: [ 26.616144][ C3] __lock_acquire+0x518/0xc20 [ 26.616325][ C3] lock_acquire.part.0+0xd4/0x280 [ 26.616458][ C3] fs_reclaim_acquire+0xd5/0x120 [ 26.616633][ C3] __kmalloc_noprof+0xd3/0x760 [ 26.616765][ C3] alloc_buf.isra.0+0x4b/0x260 [ 26.616944][ C3] put_chars+0x1e1/0x2f0 [ 26.617075][ C3] hvc_console_print+0x292/0x780 [ 26.617251][ C3] console_emit_next_record+0x22f/0x4c0 [ 26.617395][ C3] console_flush_one_record+0x46f/0x710 [ 26.617571][ C3] console_unlock+0xee/0x1f0 [ 26.617704][ C3] vprintk_emit+0x37c/0x3e0 [ 26.617883][ C3] _printk+0xc7/0x100 [ 26.617986][ C3] print_ipi_mode+0x2e/0x40 [ 26.618164][ C3] do_one_initcall+0x124/0x4f0 [ 26.618295][ C3] kernel_init_freeable+0x596/0x630 [ 26.618472][ C3] kernel_init+0x21/0x150 [ 26.618604][ C3] ret_from_fork+0x474/0x6b0 [ 26.618785][ C3] ret_from_fork_asm+0x11/0x20 [ 26.618918][ C3] [ 26.619030][ C3] -> (console_owner){....}-{0:0} { [ 26.619172][ C3] INITIAL USE at: [ 26.619274][ C3] } [ 26.619387][ C3] ... key at: [] console_owner_dep_map+0x0/0x60 [ 26.619583][ C3] ... acquired at: [ 26.619725][ C3] __lock_acquire+0x518/0xc20 [ 26.619858][ C3] lock_acquire.part.0+0xd4/0x280 [ 26.620033][ C3] console_lock_spinning_enable+0x5c/0x60 [ 26.620202][ C3] console_emit_next_record+0x1d1/0x4c0 [ 26.620383][ C3] console_flush_one_record+0x46f/0x710 [ 26.620516][ C3] console_unlock+0xee/0x1f0 [ 26.620692][ C3] vprintk_emit+0x37c/0x3e0 [ 26.620824][ C3] _printk+0xc7/0x100 [ 26.620967][ C3] br_set_state+0x22f/0x430 [bridge] [ 26.621106][ C3] br_init_port+0xc4/0x200 [bridge] [ 26.621290][ C3] br_stp_enable_port+0x12/0x50 [bridge] [ 26.621465][ C3] br_port_carrier_check+0x220/0x430 [bridge] [ 26.621677][ C3] br_device_event+0x52d/0x8f0 [bridge] [ 26.621859][ C3] notifier_call_chain+0xae/0x300 [ 26.621993][ C3] netif_state_change+0x139/0x340 [ 26.622168][ C3] __linkwatch_run_queue+0x34c/0x750 [ 26.622305][ C3] linkwatch_event+0x7f/0xb0 [ 26.622486][ C3] process_one_work+0xe3e/0x1560 [ 26.622619][ C3] worker_thread+0x4f1/0xd60 [ 26.622791][ C3] kthread+0x367/0x460 [ 26.622889][ C3] ret_from_fork+0x474/0x6b0 [ 26.623021][ C3] ret_from_fork_asm+0x11/0x20 [ 26.623198][ C3] [ 26.623263][ C3] -> (&br->lock){+.-.}-{3:3} { [ 26.623448][ C3] HARDIRQ-ON-W at: [ 26.623550][ C3] __lock_acquire+0x388/0xc20 [ 26.623760][ C3] lock_acquire.part.0+0xd4/0x280 [ 26.623926][ C3] _raw_spin_lock_bh+0x38/0x50 [ 26.624141][ C3] br_add_if+0x8c1/0x1320 [bridge] [ 26.624380][ C3] do_set_master+0x357/0x580 [ 26.624548][ C3] do_setlink.isra.0+0xa31/0x2750 [ 26.624761][ C3] rtnl_newlink+0x9f1/0x11c0 [ 26.624929][ C3] rtnetlink_rcv_msg+0x6fd/0xbd0 [ 26.625137][ C3] netlink_rcv_skb+0x14e/0x3a0 [ 26.625355][ C3] netlink_unicast+0x486/0x750 [ 26.625518][ C3] netlink_sendmsg+0x735/0xc60 [ 26.625728][ C3] ____sys_sendmsg+0x415/0x880 [ 26.625941][ C3] ___sys_sendmsg+0x14e/0x1d0 [ 26.626109][ C3] __sys_sendmsg+0x12c/0x1d0 [ 26.626329][ C3] do_syscall_64+0xff/0x530 [ 26.626495][ C3] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 26.626692][ C3] IN-SOFTIRQ-W at: [ 26.626841][ C3] __lock_acquire+0x388/0xc20 [ 26.627008][ C3] lock_acquire.part.0+0xd4/0x280 [ 26.627215][ C3] _raw_spin_lock+0x33/0x40 [ 26.627390][ C3] br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 26.627643][ C3] call_timer_fn+0x160/0x4d0 [ 26.627856][ C3] __run_timers+0x68f/0xaa0 [ 26.628026][ C3] run_timer_softirq+0xf0/0x160 [ 26.628237][ C3] handle_softirqs+0x1d3/0x900 [ 26.628456][ C3] __irq_exit_rcu+0x145/0x1c0 [ 26.628624][ C3] irq_exit_rcu+0xe/0x30 [ 26.628837][ C3] sysvec_apic_timer_interrupt+0x9d/0xe0 [ 26.629081][ C3] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 26.629286][ C3] pv_native_safe_halt+0xf/0x10 [ 26.629509][ C3] default_idle+0x9/0x10 [ 26.629721][ C3] default_idle_call+0x6e/0xb0 [ 26.629888][ C3] cpuidle_idle_call.constprop.0+0x237/0x410 [ 26.630134][ C3] do_idle+0xd8/0x190 [ 26.630315][ C3] cpu_startup_entry+0x53/0x70 [ 26.630487][ C3] start_secondary+0x204/0x2b0 [ 26.630702][ C3] common_startup_64+0x13e/0x148 [ 26.630870][ C3] INITIAL USE at: [ 26.631015][ C3] __lock_acquire+0x388/0xc20 [ 26.631184][ C3] lock_acquire.part.0+0xd4/0x280 [ 26.631405][ C3] _raw_spin_lock_bh+0x38/0x50 [ 26.631617][ C3] br_add_if+0x8c1/0x1320 [bridge] [ 26.631791][ C3] do_set_master+0x357/0x580 [ 26.632005][ C3] do_setlink.isra.0+0xa31/0x2750 [ 26.632213][ C3] rtnl_newlink+0x9f1/0x11c0 [ 26.632385][ C3] rtnetlink_rcv_msg+0x6fd/0xbd0 [ 26.632598][ C3] netlink_rcv_skb+0x14e/0x3a0 [ 26.632765][ C3] netlink_unicast+0x486/0x750 [ 26.632975][ C3] netlink_sendmsg+0x735/0xc60 [ 26.633190][ C3] ____sys_sendmsg+0x415/0x880 [ 26.633363][ C3] ___sys_sendmsg+0x14e/0x1d0 [ 26.633573][ C3] __sys_sendmsg+0x12c/0x1d0 [ 26.633788][ C3] do_syscall_64+0xff/0x530 [ 26.633953][ C3] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 26.634198][ C3] } [ 26.634267][ C3] ... key at: [] __key.7+0x0/0x40 [bridge] [ 26.634515][ C3] ... acquired at: [ 26.634615][ C3] mark_lock+0x1d7/0xa00 [ 26.634790][ C3] mark_usage+0x42/0x170 [ 26.634923][ C3] __lock_acquire+0x388/0xc20 [ 26.635100][ C3] lock_acquire.part.0+0xd4/0x280 [ 26.635231][ C3] _raw_spin_lock+0x33/0x40 [ 26.635415][ C3] br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 26.635585][ C3] call_timer_fn+0x160/0x4d0 [ 26.635758][ C3] __run_timers+0x68f/0xaa0 [ 26.635892][ C3] run_timer_softirq+0xf0/0x160 [ 26.636070][ C3] handle_softirqs+0x1d3/0x900 [ 26.636204][ C3] __irq_exit_rcu+0x145/0x1c0 [ 26.636384][ C3] irq_exit_rcu+0xe/0x30 [ 26.636515][ C3] sysvec_apic_timer_interrupt+0x9d/0xe0 [ 26.636726][ C3] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 26.636938][ C3] pv_native_safe_halt+0xf/0x10 [ 26.637070][ C3] default_idle+0x9/0x10 [ 26.637243][ C3] default_idle_call+0x6e/0xb0 [ 26.637382][ C3] cpuidle_idle_call.constprop.0+0x237/0x410 [ 26.637591][ C3] do_idle+0xd8/0x190 [ 26.637688][ C3] cpu_startup_entry+0x53/0x70 [ 26.637863][ C3] start_secondary+0x204/0x2b0 [ 26.637998][ C3] common_startup_64+0x13e/0x148 [ 26.638179][ C3] [ 26.638247][ C3] [ 26.638247][ C3] stack backtrace: [ 26.638470][ C3] CPU: 3 UID: 0 PID: 0 Comm: swapper/3 Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 26.638473][ C3] Tainted: [W]=WARN [ 26.638474][ C3] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 26.638475][ C3] Call Trace: [ 26.638477][ C3] [ 26.638479][ C3] dump_stack_lvl+0x6f/0xa0 [ 26.638483][ C3] print_irq_inversion_bug.part.0.cold+0xe6/0x143 [ 26.638486][ C3] mark_lock_irq+0x989/0x9c0 [ 26.638489][ C3] mark_lock+0x1d7/0xa00 [ 26.638491][ C3] mark_usage+0x42/0x170 [ 26.638493][ C3] __lock_acquire+0x388/0xc20 [ 26.638495][ C3] lock_acquire.part.0+0xd4/0x280 [ 26.638497][ C3] ? br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 26.638503][ C3] ? rcu_is_watching+0x16/0xd0 [ 26.638507][ C3] ? lock_acquire+0x13c/0x160 [ 26.638508][ C3] ? br_message_age_timer_expired+0x70/0x70 [bridge] [ 26.638515][ C3] _raw_spin_lock+0x33/0x40 [ 26.638516][ C3] ? br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 26.638522][ C3] br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 26.638529][ C3] ? br_message_age_timer_expired+0x70/0x70 [bridge] [ 26.638535][ C3] call_timer_fn+0x160/0x4d0 [ 26.638537][ C3] ? detach_if_pending+0x1d0/0x1d0 [ 26.638539][ C3] ? debug_object_active_state+0x430/0x430 [ 26.638543][ C3] ? find_held_lock+0x2b/0x80 [ 26.638545][ C3] ? __lock_release.isra.0+0x69/0x1a0 [ 26.638547][ C3] ? rcu_is_watching+0x16/0xd0 [ 26.638549][ C3] __run_timers+0x68f/0xaa0 [ 26.638551][ C3] ? br_message_age_timer_expired+0x70/0x70 [bridge] [ 26.638558][ C3] ? __bpf_trace_itimer_expire+0x10/0x10 [ 26.638559][ C3] ? __lock_acquire+0x518/0xc20 [ 26.638562][ C3] ? __rwlock_init+0x150/0x150 [ 26.638564][ C3] run_timer_softirq+0xf0/0x160 [ 26.638566][ C3] ? __run_timers+0xaa0/0xaa0 [ 26.638568][ C3] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 26.638570][ C3] ? rcu_is_watching+0x16/0xd0 [ 26.638572][ C3] handle_softirqs+0x1d3/0x900 [ 26.638574][ C3] ? __lock_release.isra.0+0x69/0x1a0 [ 26.638576][ C3] ? _local_bh_enable+0xc0/0xc0 [ 26.638578][ C3] __irq_exit_rcu+0x145/0x1c0 [ 26.638579][ C3] irq_exit_rcu+0xe/0x30 [ 26.638580][ C3] sysvec_apic_timer_interrupt+0x9d/0xe0 [ 26.638582][ C3] [ 26.638583][ C3] [ 26.638583][ C3] ? lockdep_hardirqs_on+0x91/0x130 [ 26.638585][ C3] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 26.638587][ C3] RIP: 0010:pv_native_safe_halt+0xf/0x10 [ 26.638589][ C3] Code: 48 8b 3d 94 e2 f5 01 e8 1f 00 00 00 48 2b 05 58 a3 95 00 c3 0f 1f 80 00 00 00 00 f3 0f 1e fa eb 07 0f 00 2d 13 96 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.638591][ C3] RSP: 0018:ffa0000000167e00 EFLAGS: 00000282 [ 26.638593][ C3] RAX: 0000000000083ec1 RBX: ff11000001c88040 RCX: ffffffffa36f0307 [ 26.638594][ C3] RDX: ff11000001c88040 RSI: ffffffffa6438b01 RDI: ffffffffa5e8d8e0 [ 26.638595][ C3] RBP: 0000000000000000 R08: 0000000000000000 R09: 0000000000000000 [ 26.638596][ C3] R10: 0000000000000003 R11: 0000000000000001 R12: 1ff400000002cfc3 [ 26.638597][ C3] R13: 0000000000000000 R14: dffffc0000000000 R15: 0000000000000000 [ 26.638599][ C3] ? cpuidle_idle_call.constprop.0+0x237/0x410 [ 26.638601][ C3] default_idle+0x9/0x10 [ 26.638603][ C3] default_idle_call+0x6e/0xb0 [ 26.638604][ C3] cpuidle_idle_call.constprop.0+0x237/0x410 [ 26.638606][ C3] ? arch_cpu_idle_exit+0x40/0x40 [ 26.638607][ C3] ? mark_tsc_async_resets+0x30/0x30 [ 26.638609][ C3] ? rcu_is_watching+0x16/0xd0 [ 26.638611][ C3] do_idle+0xd8/0x190 [ 26.638613][ C3] cpu_startup_entry+0x53/0x70 [ 26.638614][ C3] start_secondary+0x204/0x2b0 [ 26.638616][ C3] ? set_cpu_sibling_map+0x2130/0x2130 [ 26.638618][ C3] common_startup_64+0x13e/0x148 [ 26.638620][ C3] [ 26.910273][ T258] GACT probability NOT on [ 28.063804][ T267] br0: port 2(veth2) entered disabled state [ 28.063820][ T267] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 28.063822][ T267] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 267, name: ip [ 28.063824][ T267] preempt_count: 202, expected: 0 [ 28.063824][ T267] RCU nest depth: 0, expected: 0 [ 28.063825][ T267] INFO: lockdep is turned off. [ 28.063827][ T267] irq event stamp: 0 [ 28.063827][ T267] hardirqs last enabled at (0): [<0000000000000000>] 0x0 [ 28.063832][ T267] hardirqs last disabled at (0): [] copy_process+0x1ccd/0x6240 [ 28.063838][ T267] softirqs last enabled at (0): [] copy_process+0x1d21/0x6240 [ 28.063840][ T267] softirqs last disabled at (0): [<0000000000000000>] 0x0 [ 28.063842][ T267] Preemption disabled at: [ 28.063842][ T267] [<0000000000000000>] 0x0 [ 28.063847][ T267] CPU: 3 UID: 0 PID: 267 Comm: ip Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 28.063850][ T267] Tainted: [W]=WARN [ 28.063851][ T267] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 28.063853][ T267] Call Trace: [ 28.063854][ T267] [ 28.063855][ T267] dump_stack_lvl+0x6f/0xa0 [ 28.063861][ T267] __might_resched.cold+0x1fe/0x2c1 [ 28.063864][ T267] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 28.063868][ T267] ? rcu_is_watching+0x16/0xd0 [ 28.063872][ T267] __kmalloc_noprof+0x443/0x760 [ 28.063875][ T267] ? __rwlock_init+0x150/0x150 [ 28.063878][ T267] ? alloc_buf.isra.0+0x4b/0x260 [ 28.063881][ T267] ? do_raw_spin_unlock+0x59/0x250 [ 28.063883][ T267] alloc_buf.isra.0+0x4b/0x260 [ 28.063885][ T267] put_chars+0x1e1/0x2f0 [ 28.063887][ T267] ? __send_to_port+0x420/0x420 [ 28.063888][ T267] ? printk_get_next_message+0x240/0x650 [ 28.063892][ T267] hvc_console_print+0x292/0x780 [ 28.063895][ T267] ? hvc_write+0x3a0/0x3a0 [ 28.063897][ T267] ? __rwlock_init+0x150/0x150 [ 28.063898][ T267] ? rcu_is_watching+0x16/0xd0 [ 28.063900][ T267] ? lock_acquire+0x13c/0x160 [ 28.063902][ T267] console_emit_next_record+0x22f/0x4c0 [ 28.063905][ T267] ? devkmsg_read+0x4b0/0x4b0 [ 28.063907][ T267] ? rcu_is_watching+0x16/0xd0 [ 28.063909][ T267] ? rcu_is_watching+0x16/0xd0 [ 28.063910][ T267] ? rcu_is_watching+0x16/0xd0 [ 28.063912][ T267] ? lock_acquire+0x13c/0x160 [ 28.063914][ T267] ? console_flush_one_record+0x111/0x710 [ 28.063915][ T267] console_flush_one_record+0x46f/0x710 [ 28.063917][ T267] ? console_emit_next_record+0x4c0/0x4c0 [ 28.063920][ T267] console_unlock+0xee/0x1f0 [ 28.063922][ T267] ? lock_acquire+0x13c/0x160 [ 28.063923][ T267] ? console_flush_one_record+0x710/0x710 [ 28.063925][ T267] ? rcu_is_watching+0x16/0xd0 [ 28.063926][ T267] ? lock_release+0x184/0x1f0 [ 28.063928][ T267] ? lock_acquire+0x60/0x160 [ 28.063929][ T267] ? __rcu_read_lock+0x30/0x70 [ 28.063931][ T267] ? __down_trylock_console_sem+0x5e/0xa0 [ 28.063933][ T267] ? vprintk_emit+0x320/0x3e0 [ 28.063935][ T267] vprintk_emit+0x37c/0x3e0 [ 28.063937][ T267] ? wake_up_klogd_work_func+0x90/0x90 [ 28.063939][ T267] ? rcu_is_watching+0x16/0xd0 [ 28.063941][ T267] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 28.063943][ T267] ? trace_hardirqs_on+0x36/0x40 [ 28.063945][ T267] _printk+0xc7/0x100 [ 28.063948][ T267] ? snapshot_read.cold+0x21/0x21 [ 28.063950][ T267] ? ipv6_mc_down+0x17e/0x2d0 [ 28.063955][ T267] br_set_state+0x22f/0x430 [bridge] [ 28.063967][ T267] br_stp_disable_port+0x11f/0x390 [bridge] [ 28.063975][ T267] br_device_event+0x7b5/0x8f0 [bridge] [ 28.063983][ T267] ? _raw_spin_unlock_irqrestore+0x40/0x80 [ 28.063987][ T267] ? _sub_I_65535_1+0x4d0/0x4d0 [stp] [ 28.063989][ T267] ? addrconf_notify+0x2c8/0xf30 [ 28.063992][ T267] notifier_call_chain+0xae/0x300 [ 28.063995][ T267] __dev_notify_flags+0x23c/0x3c0 [ 28.063999][ T267] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 28.064000][ T267] ? netif_change_name+0x8c0/0x8c0 [ 28.064002][ T267] ? netif_set_allmulti+0x250/0x250 [ 28.064004][ T267] ? __kernel_text_address+0x12/0x30 [ 28.064006][ T267] ? write_profile+0xf0/0xf0 [ 28.064009][ T267] ? unwind_get_return_address+0x67/0xd0 [ 28.064011][ T267] netif_change_flags+0xfe/0x190 [ 28.064014][ T267] do_setlink.isra.0+0x1cc3/0x2750 [ 28.064017][ T267] ? stack_trace_save+0x93/0xc0 [ 28.064018][ T267] ? rtnl_link_get_size+0x350/0x350 [ 28.064019][ T267] ? rcu_is_watching+0x16/0xd0 [ 28.064021][ T267] ? stack_depot_save_flags+0x1bc/0x790 [ 28.064024][ T267] ? kasan_save_stack+0x3d/0x50 [ 28.064027][ T267] ? kasan_save_stack+0x2f/0x50 [ 28.064029][ T267] ? kasan_save_track+0x14/0x30 [ 28.064030][ T267] ? __kasan_kmalloc+0x7b/0x90 [ 28.064032][ T267] ? __kmalloc_cache_noprof+0x29a/0x620 [ 28.064033][ T267] ? rtnl_newlink+0x124/0x11c0 [ 28.064034][ T267] ? rtnetlink_rcv_msg+0x6fd/0xbd0 [ 28.064036][ T267] ? netlink_rcv_skb+0x14e/0x3a0 [ 28.064038][ T267] ? netlink_unicast+0x486/0x750 [ 28.064039][ T267] ? netlink_sendmsg+0x735/0xc60 [ 28.064041][ T267] ? ____sys_sendmsg+0x415/0x880 [ 28.064043][ T267] ? ___sys_sendmsg+0x14e/0x1d0 [ 28.064044][ T267] ? __sys_sendmsg+0x12c/0x1d0 [ 28.064046][ T267] ? do_syscall_64+0xff/0x530 [ 28.064048][ T267] ? entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 28.064050][ T267] ? rcu_is_watching+0x16/0xd0 [ 28.064052][ T267] ? lock_acquire+0x13c/0x160 [ 28.064054][ T267] ? rcu_is_watching+0x16/0xd0 [ 28.064055][ T267] ? rcu_is_watching+0x16/0xd0 [ 28.064057][ T267] ? trace_contention_end+0xb3/0x180 [ 28.064060][ T267] ? __mutex_lock+0x1db/0x1ea0 [ 28.064062][ T267] ? __mutex_lock+0x9a3/0x1ea0 [ 28.064063][ T267] ? rtnl_newlink+0x9a8/0x11c0 [ 28.064064][ T267] ? ww_mutex_lock+0x160/0x160 [ 28.064066][ T267] ? __rtnl_newlink+0x3fa/0xa50 [ 28.064068][ T267] rtnl_newlink+0x9f1/0x11c0 [ 28.064070][ T267] ? rcu_is_watching+0x16/0xd0 [ 28.064072][ T267] ? rtnl_bridge_getlink+0x850/0x850 [ 28.064073][ T267] ? lock_acquire+0x13c/0x160 [ 28.064075][ T267] ? rcu_is_watching+0x16/0xd0 [ 28.064077][ T267] ? is_bpf_text_address+0x3e/0x110 [ 28.064080][ T267] ? is_bpf_text_address+0x72/0x110 [ 28.064082][ T267] ? kernel_text_address+0x149/0x170 [ 28.064083][ T267] ? __kernel_text_address+0x12/0x30 [ 28.064084][ T267] ? write_profile+0xf0/0xf0 [ 28.064085][ T267] ? unwind_get_return_address+0x67/0xd0 [ 28.064087][ T267] ? rcu_is_watching+0x16/0xd0 [ 28.064088][ T267] ? rcu_is_watching+0x16/0xd0 [ 28.064090][ T267] ? cap_capable+0x1d7/0x3d0 [ 28.064093][ T267] ? lock_acquire+0x13c/0x160 [ 28.064095][ T267] ? rcu_is_watching+0x16/0xd0 [ 28.064096][ T267] ? rtnl_bridge_getlink+0x850/0x850 [ 28.064098][ T267] rtnetlink_rcv_msg+0x6fd/0xbd0 [ 28.064099][ T267] ? rtnl_link_fill+0x920/0x920 [ 28.064101][ T267] ? filter_irq_stacks+0xd0/0xd0 [ 28.064102][ T267] ? stack_depot_save_flags+0x1bc/0x790 [ 28.064104][ T267] netlink_rcv_skb+0x14e/0x3a0 [ 28.064106][ T267] ? rtnl_link_fill+0x920/0x920 [ 28.064107][ T267] ? lock_release+0x184/0x1f0 [ 28.064108][ T267] ? netlink_ack+0xcf0/0xcf0 [ 28.064110][ T267] ? __netlink_lookup+0xb9/0x6b0 [ 28.064112][ T267] ? rcu_is_watching+0x16/0xd0 [ 28.064114][ T267] ? lock_release+0x184/0x1f0 [ 28.064116][ T267] netlink_unicast+0x486/0x750 [ 28.064118][ T267] ? netlink_attachskb+0x810/0x810 [ 28.064119][ T267] ? rcu_is_watching+0x16/0xd0 [ 28.064121][ T267] ? rcu_is_watching+0x16/0xd0 [ 28.064122][ T267] ? lock_acquire+0x13c/0x160 [ 28.064124][ T267] netlink_sendmsg+0x735/0xc60 [ 28.064126][ T267] ? netlink_unicast+0x750/0x750 [ 28.064128][ T267] ? rcu_is_watching+0x16/0xd0 [ 28.064129][ T267] ? lock_release+0x184/0x1f0 [ 28.064131][ T267] ____sys_sendmsg+0x415/0x880 [ 28.064133][ T267] ? copy_msghdr_from_user+0x279/0x420 [ 28.064134][ T267] ? get_timestamp.constprop.0+0x390/0x390 [ 28.064136][ T267] ? move_addr_to_kernel+0x40/0x40 [ 28.064137][ T267] ? filter_irq_stacks+0xd0/0xd0 [ 28.064140][ T267] ___sys_sendmsg+0x14e/0x1d0 [ 28.064141][ T267] ? copy_msghdr_from_user+0x420/0x420 [ 28.064146][ T267] __sys_sendmsg+0x12c/0x1d0 [ 28.064148][ T267] ? __sys_sendmsg_sock+0x20/0x20 [ 28.064151][ T267] ? rcu_is_watching+0x16/0xd0 [ 28.064153][ T267] do_syscall_64+0xff/0x530 [ 28.064154][ T267] ? exc_page_fault+0xee/0x100 [ 28.064156][ T267] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 28.064157][ T267] RIP: 0033:0x7eff7847054e [ 28.064159][ T267] 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.064161][ T267] RSP: 002b:00007ffedcc23430 EFLAGS: 00000202 ORIG_RAX: 000000000000002e [ 28.064165][ T267] RAX: ffffffffffffffda RBX: 0000000000000003 RCX: 00007eff7847054e [ 28.064166][ T267] RDX: 0000000000000000 RSI: 00007ffedcc234e0 RDI: 0000000000000005 [ 28.064167][ T267] RBP: 00007ffedcc23440 R08: 0000000000000000 R09: 0000000000000000 [ 28.064168][ T267] R10: 0000000000000000 R11: 0000000000000202 R12: 000000006a910d8b [ 28.064168][ T267] R13: 00000000004a1620 R14: 0000000000000000 R15: 00007ffedcc23ba0 [ 28.064171][ T267] [ 28.093138][ T267] ip (267) used greatest stack depth: 23016 bytes left [ 28.150442][ T36] br0: port 2(veth2) entered blocking state [ 28.150662][ T36] br0: port 2(veth2) entered forwarding state [ 34.378849][ T291] br0: port 1(veth1) entered disabled state [ 34.378866][ T291] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 34.378868][ T291] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 291, name: ip [ 34.378870][ T291] preempt_count: 202, expected: 0 [ 34.378871][ T291] RCU nest depth: 0, expected: 0 [ 34.378872][ T291] INFO: lockdep is turned off. [ 34.378873][ T291] irq event stamp: 0 [ 34.378874][ T291] hardirqs last enabled at (0): [<0000000000000000>] 0x0 [ 34.378878][ T291] hardirqs last disabled at (0): [] copy_process+0x1ccd/0x6240 [ 34.378885][ T291] softirqs last enabled at (0): [] copy_process+0x1d21/0x6240 [ 34.378886][ T291] softirqs last disabled at (0): [<0000000000000000>] 0x0 [ 34.378888][ T291] Preemption disabled at: [ 34.378888][ T291] [<0000000000000000>] 0x0 [ 34.378893][ T291] CPU: 3 UID: 0 PID: 291 Comm: ip Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 34.378896][ T291] Tainted: [W]=WARN [ 34.378897][ T291] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 34.378899][ T291] Call Trace: [ 34.378900][ T291] [ 34.378902][ T291] dump_stack_lvl+0x6f/0xa0 [ 34.378907][ T291] __might_resched.cold+0x1fe/0x2c1 [ 34.378911][ T291] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 34.378914][ T291] ? rcu_is_watching+0x16/0xd0 [ 34.378918][ T291] __kmalloc_noprof+0x443/0x760 [ 34.378922][ T291] ? __rwlock_init+0x150/0x150 [ 34.378924][ T291] ? alloc_buf.isra.0+0x4b/0x260 [ 34.378928][ T291] ? do_raw_spin_unlock+0x59/0x250 [ 34.378930][ T291] alloc_buf.isra.0+0x4b/0x260 [ 34.378932][ T291] put_chars+0x1e1/0x2f0 [ 34.378934][ T291] ? __send_to_port+0x420/0x420 [ 34.378936][ T291] ? printk_get_next_message+0x240/0x650 [ 34.378939][ T291] hvc_console_print+0x292/0x780 [ 34.378942][ T291] ? hvc_write+0x3a0/0x3a0 [ 34.378944][ T291] ? __rwlock_init+0x150/0x150 [ 34.378946][ T291] ? rcu_is_watching+0x16/0xd0 [ 34.378948][ T291] ? lock_acquire+0x13c/0x160 [ 34.378950][ T291] console_emit_next_record+0x22f/0x4c0 [ 34.378952][ T291] ? devkmsg_read+0x4b0/0x4b0 [ 34.378954][ T291] ? rcu_is_watching+0x16/0xd0 [ 34.378956][ T291] ? rcu_is_watching+0x16/0xd0 [ 34.378957][ T291] ? rcu_is_watching+0x16/0xd0 [ 34.378959][ T291] ? lock_acquire+0x13c/0x160 [ 34.378961][ T291] ? console_flush_one_record+0x111/0x710 [ 34.378963][ T291] console_flush_one_record+0x46f/0x710 [ 34.378965][ T291] ? console_emit_next_record+0x4c0/0x4c0 [ 34.378967][ T291] console_unlock+0xee/0x1f0 [ 34.378969][ T291] ? lock_acquire+0x13c/0x160 [ 34.378970][ T291] ? console_flush_one_record+0x710/0x710 [ 34.378972][ T291] ? rcu_is_watching+0x16/0xd0 [ 34.378974][ T291] ? lock_release+0x184/0x1f0 [ 34.378975][ T291] ? lock_acquire+0x60/0x160 [ 34.378976][ T291] ? __rcu_read_lock+0x30/0x70 [ 34.378978][ T291] ? __down_trylock_console_sem+0x5e/0xa0 [ 34.378980][ T291] ? vprintk_emit+0x320/0x3e0 [ 34.378982][ T291] vprintk_emit+0x37c/0x3e0 [ 34.378984][ T291] ? wake_up_klogd_work_func+0x90/0x90 [ 34.378986][ T291] ? rcu_is_watching+0x16/0xd0 [ 34.378988][ T291] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 34.378990][ T291] ? trace_hardirqs_on+0x36/0x40 [ 34.378992][ T291] _printk+0xc7/0x100 [ 34.378995][ T291] ? snapshot_read.cold+0x21/0x21 [ 34.378997][ T291] ? ipv6_mc_down+0x17e/0x2d0 [ 34.379002][ T291] br_set_state+0x22f/0x430 [bridge] [ 34.379014][ T291] br_stp_disable_port+0x11f/0x390 [bridge] [ 34.379022][ T291] br_device_event+0x7b5/0x8f0 [bridge] [ 34.379030][ T291] ? _raw_spin_unlock_irqrestore+0x40/0x80 [ 34.379033][ T291] ? _sub_I_65535_1+0x4d0/0x4d0 [stp] [ 34.379036][ T291] ? addrconf_notify+0x2c8/0xf30 [ 34.379039][ T291] notifier_call_chain+0xae/0x300 [ 34.379042][ T291] __dev_notify_flags+0x23c/0x3c0 [ 34.379046][ T291] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 34.379047][ T291] ? netif_change_name+0x8c0/0x8c0 [ 34.379049][ T291] ? netif_set_allmulti+0x250/0x250 [ 34.379051][ T291] ? __kernel_text_address+0x12/0x30 [ 34.379053][ T291] ? write_profile+0xf0/0xf0 [ 34.379055][ T291] ? unwind_get_return_address+0x67/0xd0 [ 34.379058][ T291] netif_change_flags+0xfe/0x190 [ 34.379061][ T291] do_setlink.isra.0+0x1cc3/0x2750 [ 34.379063][ T291] ? stack_trace_save+0x93/0xc0 [ 34.379065][ T291] ? rtnl_link_get_size+0x350/0x350 [ 34.379066][ T291] ? rcu_is_watching+0x16/0xd0 [ 34.379067][ T291] ? stack_depot_save_flags+0x1bc/0x790 [ 34.379071][ T291] ? kasan_save_stack+0x3d/0x50 [ 34.379074][ T291] ? kasan_save_stack+0x2f/0x50 [ 34.379076][ T291] ? kasan_save_track+0x14/0x30 [ 34.379077][ T291] ? __kasan_kmalloc+0x7b/0x90 [ 34.379078][ T291] ? __kmalloc_cache_noprof+0x29a/0x620 [ 34.379080][ T291] ? rtnl_newlink+0x124/0x11c0 [ 34.379081][ T291] ? rtnetlink_rcv_msg+0x6fd/0xbd0 [ 34.379082][ T291] ? netlink_rcv_skb+0x14e/0x3a0 [ 34.379085][ T291] ? netlink_unicast+0x486/0x750 [ 34.379086][ T291] ? netlink_sendmsg+0x735/0xc60 [ 34.379088][ T291] ? ____sys_sendmsg+0x415/0x880 [ 34.379090][ T291] ? ___sys_sendmsg+0x14e/0x1d0 [ 34.379091][ T291] ? __sys_sendmsg+0x12c/0x1d0 [ 34.379093][ T291] ? do_syscall_64+0xff/0x530 [ 34.379095][ T291] ? entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 34.379098][ T291] ? rcu_is_watching+0x16/0xd0 [ 34.379099][ T291] ? lock_acquire+0x13c/0x160 [ 34.379101][ T291] ? rcu_is_watching+0x16/0xd0 [ 34.379102][ T291] ? rcu_is_watching+0x16/0xd0 [ 34.379104][ T291] ? trace_contention_end+0xb3/0x180 [ 34.379107][ T291] ? __mutex_lock+0x1db/0x1ea0 [ 34.379108][ T291] ? __mutex_lock+0x9a3/0x1ea0 [ 34.379110][ T291] ? rtnl_newlink+0x9a8/0x11c0 [ 34.379111][ T291] ? ww_mutex_lock+0x160/0x160 [ 34.379113][ T291] ? __rtnl_newlink+0x3fa/0xa50 [ 34.379115][ T291] rtnl_newlink+0x9f1/0x11c0 [ 34.379117][ T291] ? rcu_is_watching+0x16/0xd0 [ 34.379119][ T291] ? rtnl_bridge_getlink+0x850/0x850 [ 34.379120][ T291] ? lock_acquire+0x13c/0x160 [ 34.379121][ T291] ? rcu_is_watching+0x16/0xd0 [ 34.379123][ T291] ? is_bpf_text_address+0x3e/0x110 [ 34.379126][ T291] ? is_bpf_text_address+0x72/0x110 [ 34.379128][ T291] ? kernel_text_address+0x149/0x170 [ 34.379129][ T291] ? __kernel_text_address+0x12/0x30 [ 34.379130][ T291] ? write_profile+0xf0/0xf0 [ 34.379131][ T291] ? unwind_get_return_address+0x67/0xd0 [ 34.379133][ T291] ? rcu_is_watching+0x16/0xd0 [ 34.379134][ T291] ? rcu_is_watching+0x16/0xd0 [ 34.379136][ T291] ? cap_capable+0x1d7/0x3d0 [ 34.379140][ T291] ? lock_acquire+0x13c/0x160 [ 34.379141][ T291] ? rcu_is_watching+0x16/0xd0 [ 34.379143][ T291] ? rtnl_bridge_getlink+0x850/0x850 [ 34.379144][ T291] rtnetlink_rcv_msg+0x6fd/0xbd0 [ 34.379145][ T291] ? rtnl_link_fill+0x920/0x920 [ 34.379147][ T291] ? filter_irq_stacks+0xd0/0xd0 [ 34.379148][ T291] ? stack_depot_save_flags+0x1bc/0x790 [ 34.379150][ T291] netlink_rcv_skb+0x14e/0x3a0 [ 34.379152][ T291] ? rtnl_link_fill+0x920/0x920 [ 34.379153][ T291] ? lock_release+0x184/0x1f0 [ 34.379155][ T291] ? netlink_ack+0xcf0/0xcf0 [ 34.379156][ T291] ? __netlink_lookup+0xb9/0x6b0 [ 34.379158][ T291] ? rcu_is_watching+0x16/0xd0 [ 34.379160][ T291] ? lock_release+0x184/0x1f0 [ 34.379162][ T291] netlink_unicast+0x486/0x750 [ 34.379164][ T291] ? netlink_attachskb+0x810/0x810 [ 34.379165][ T291] ? rcu_is_watching+0x16/0xd0 [ 34.379167][ T291] ? rcu_is_watching+0x16/0xd0 [ 34.379168][ T291] ? lock_acquire+0x13c/0x160 [ 34.379170][ T291] netlink_sendmsg+0x735/0xc60 [ 34.379172][ T291] ? netlink_unicast+0x750/0x750 [ 34.379174][ T291] ? rcu_is_watching+0x16/0xd0 [ 34.379175][ T291] ? lock_release+0x184/0x1f0 [ 34.379177][ T291] ____sys_sendmsg+0x415/0x880 [ 34.379179][ T291] ? copy_msghdr_from_user+0x279/0x420 [ 34.379180][ T291] ? get_timestamp.constprop.0+0x390/0x390 [ 34.379182][ T291] ? move_addr_to_kernel+0x40/0x40 [ 34.379183][ T291] ? filter_irq_stacks+0xd0/0xd0 [ 34.379185][ T291] ___sys_sendmsg+0x14e/0x1d0 [ 34.379187][ T291] ? copy_msghdr_from_user+0x420/0x420 [ 34.379192][ T291] __sys_sendmsg+0x12c/0x1d0 [ 34.379194][ T291] ? __sys_sendmsg_sock+0x20/0x20 [ 34.379196][ T291] ? rcu_is_watching+0x16/0xd0 [ 34.379198][ T291] do_syscall_64+0xff/0x530 [ 34.379199][ T291] ? exc_page_fault+0xee/0x100 [ 34.379202][ T291] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 34.379203][ T291] RIP: 0033:0x7fd1fb0dc54e [ 34.379205][ T291] 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 [ 34.379207][ T291] RSP: 002b:00007fff0a498300 EFLAGS: 00000202 ORIG_RAX: 000000000000002e [ 34.379210][ T291] RAX: ffffffffffffffda RBX: 0000000000000003 RCX: 00007fd1fb0dc54e [ 34.379212][ T291] RDX: 0000000000000000 RSI: 00007fff0a4983b0 RDI: 0000000000000005 [ 34.379213][ T291] RBP: 00007fff0a498310 R08: 0000000000000000 R09: 0000000000000000 [ 34.379213][ T291] R10: 0000000000000000 R11: 0000000000000202 R12: 000000006a910d91 [ 34.379214][ T291] R13: 00000000004a1620 R14: 0000000000000000 R15: 00007fff0a498a70 [ 34.379216][ T291] [ 34.431484][ T292] br0: port 2(veth2) entered disabled state [ 34.449389][ T293] veth2: left allmulticast mode [ 34.450290][ T293] veth2: left promiscuous mode [ 34.458636][ T293] br0: port 2(veth2) entered disabled state [ 34.459361][ T293] veth1: left allmulticast mode [ 34.460006][ T293] veth1: left promiscuous mode [ 34.460221][ T293] br0: port 1(veth1) entered disabled state