[ 10.260104][ T194] ip (194) used greatest stack depth: 24416 bytes left [ 10.260121][ T194] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 10.260123][ T194] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 194, name: ip [ 10.260125][ T194] preempt_count: 2, expected: 0 [ 10.260126][ T194] RCU nest depth: 0, expected: 0 [ 10.260127][ T194] locks held by ip/194: 5, last CPU#3: [ 10.260129][ T194] #0: ffffffff97c027b8 (low_water_lock){+.+.}-{3:3}, at: do_exit+0x887/0xdc0 [ 10.260142][ T194] #1: ffffffff97d69cc0 (console_lock){+.+.}-{0:0}, at: vprintk_emit+0x320/0x3e0 [ 10.260148][ T194] #2: ffffffff97d69d38 (console_srcu){....}-{0:0}, at: console_flush_one_record+0x106/0x710 [ 10.260152][ T194] #3: ffffffff97c89660 (console_owner){....}-{0:0}, at: console_lock_spinning_enable+0x40/0x60 [ 10.260156][ T194] #4: ffffffff97c89560 (printk_legacy_map-wait-type-override){....}-{3:3}, at: console_emit_next_record+0x1df/0x4c0 [ 10.260160][ T194] irq event stamp: 33472 [ 10.260161][ T194] hardirqs last enabled at (33471): [] __down_trylock_console_sem+0x86/0xa0 [ 10.260163][ T194] hardirqs last disabled at (33472): [] console_emit_next_record+0x3d4/0x4c0 [ 10.260166][ T194] softirqs last enabled at (33008): [] handle_softirqs+0x67c/0x900 [ 10.260168][ T194] softirqs last disabled at (32997): [] __irq_exit_rcu+0x145/0x1c0 [ 10.260170][ T194] Preemption disabled at: [ 10.260170][ T194] [<0000000000000000>] 0x0 [ 10.260178][ T194] CPU: 3 UID: 0 PID: 194 Comm: ip Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 10.260181][ T194] Tainted: [W]=WARN [ 10.260182][ T194] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 10.260184][ T194] Call Trace: [ 10.260186][ T194] [ 10.260187][ T194] dump_stack_lvl+0x6f/0xa0 [ 10.260194][ T194] __might_resched.cold+0x1fe/0x2c1 [ 10.260199][ T194] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 10.260203][ T194] ? __kmalloc_noprof+0xdb/0x760 [ 10.260208][ T194] __kmalloc_noprof+0x443/0x760 [ 10.260211][ T194] ? alloc_buf.isra.0+0x4b/0x260 [ 10.260216][ T194] ? do_raw_spin_unlock+0x59/0x250 [ 10.260219][ T194] alloc_buf.isra.0+0x4b/0x260 [ 10.260224][ T194] put_chars+0x1e1/0x2f0 [ 10.260227][ T194] ? __send_to_port+0x420/0x420 [ 10.260229][ T194] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 10.260234][ T194] ? validate_chain+0x38b/0xc20 [ 10.260239][ T194] hvc_console_print+0x292/0x780 [ 10.260246][ T194] ? hvc_write+0x3a0/0x3a0 [ 10.260248][ T194] ? rcu_is_watching+0x16/0xd0 [ 10.260251][ T194] ? lock_acquire+0x13c/0x160 [ 10.260255][ T194] console_emit_next_record+0x22f/0x4c0 [ 10.260259][ T194] ? devkmsg_read+0x4b0/0x4b0 [ 10.260261][ T194] ? console_flush_one_record+0x106/0x710 [ 10.260265][ T194] ? rcu_is_watching+0x16/0xd0 [ 10.260267][ T194] ? lock_acquire+0x13c/0x160 [ 10.260271][ T194] console_flush_one_record+0x46f/0x710 [ 10.260276][ T194] ? console_emit_next_record+0x4c0/0x4c0 [ 10.260278][ T194] ? __lock_acquire+0x518/0xc20 [ 10.260284][ T194] console_unlock+0xee/0x1f0 [ 10.260287][ T194] ? console_flush_one_record+0x710/0x710 [ 10.260289][ T194] ? rcu_is_watching+0x16/0xd0 [ 10.260291][ T194] ? lock_acquire+0x60/0x160 [ 10.260295][ T194] ? __down_trylock_console_sem+0x5e/0xa0 [ 10.260297][ T194] ? vprintk_emit+0x320/0x3e0 [ 10.260301][ T194] vprintk_emit+0x37c/0x3e0 [ 10.260305][ T194] ? wake_up_klogd_work_func+0x90/0x90 [ 10.260309][ T194] ? __lock_acquire+0x518/0xc20 [ 10.260313][ T194] _printk+0xc7/0x100 [ 10.260316][ T194] ? snapshot_read.cold+0x21/0x21 [ 10.260319][ T194] ? do_raw_spin_lock+0x131/0x280 [ 10.260322][ T194] ? __rwlock_init+0x150/0x150 [ 10.260326][ T194] ? do_raw_spin_lock+0x131/0x280 [ 10.260329][ T194] do_exit.cold+0x82/0x9c [ 10.260332][ T194] ? exit_notify+0x890/0x890 [ 10.260334][ T194] ? __lock_release.isra.0+0x69/0x1a0 [ 10.260337][ T194] ? rcu_is_watching+0x16/0xd0 [ 10.260341][ T194] do_group_exit+0xb8/0x370 [ 10.260344][ T194] __x64_sys_exit_group+0x3c/0x50 [ 10.260346][ T194] x64_sys_call+0x1567/0x1570 [ 10.260348][ T194] do_syscall_64+0xff/0x530 [ 10.260351][ T194] ? exc_page_fault+0xee/0x100 [ 10.260355][ T194] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 10.260357][ T194] RIP: 0033:0x7f47068d01b8 [ 10.260359][ T194] Code: Unable to access opcode bytes at 0x7f47068d018e. [ 10.260361][ T194] RSP: 002b:00007fffef2daf98 EFLAGS: 00000246 ORIG_RAX: 00000000000000e7 [ 10.260363][ T194] RAX: ffffffffffffffda RBX: 00007f4706a00f88 RCX: 00007f47068d01b8 [ 10.260365][ T194] RDX: 00007f470661afc8 RSI: fffffffffffffeb8 RDI: 0000000000000000 [ 10.260366][ T194] RBP: 00007fffef2daff0 R08: 0000000000000000 R09: 0000000000008010 [ 10.260367][ T194] R10: 00007fffef2dadb0 R11: 0000000000000246 R12: 0000000000000001 [ 10.260367][ T194] R13: 0000000000000000 R14: 00007f47069ff680 R15: 00007f4706a00fa0 [ 10.260374][ T194] [ 10.987208][ T225] 8021q: 802.1Q VLAN Support v1.8 [ 12.153212][ T260] br1: port 1(veth1) entered blocking state [ 12.153338][ T260] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 12.153340][ T260] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 260, name: ip [ 12.153342][ T260] preempt_count: 1, expected: 0 [ 12.153343][ T260] RCU nest depth: 0, expected: 0 [ 12.153344][ T260] locks held by ip/260: 5, last CPU#3: [ 12.153347][ T260] #0: ffffffff984d2c40 (rtnl_mutex){+.+.}-{4:4}, at: rtnl_newlink+0x9a8/0x11c0 [ 12.153359][ T260] #1: ffffffff97d69cc0 (console_lock){+.+.}-{0:0}, at: vprintk_emit+0x320/0x3e0 [ 12.153366][ T260] #2: ffffffff97d69d38 (console_srcu){....}-{0:0}, at: console_flush_one_record+0x106/0x710 [ 12.153370][ T260] #3: ffffffff97c89660 (console_owner){....}-{0:0}, at: console_lock_spinning_enable+0x40/0x60 [ 12.153374][ T260] #4: ffffffff97c89560 (printk_legacy_map-wait-type-override){....}-{3:3}, at: console_emit_next_record+0x1df/0x4c0 [ 12.153378][ T260] irq event stamp: 26604 [ 12.153379][ T260] hardirqs last enabled at (26603): [] __down_trylock_console_sem+0x86/0xa0 [ 12.153382][ T260] hardirqs last disabled at (26604): [] console_emit_next_record+0x3d4/0x4c0 [ 12.153384][ T260] softirqs last enabled at (26514): [] __alloc_skb+0x4c2/0x5f0 [ 12.153387][ T260] softirqs last disabled at (26512): [] __alloc_skb+0x4c2/0x5f0 [ 12.153389][ T260] Preemption disabled at: [ 12.153390][ T260] [] vprintk_emit+0x31b/0x3e0 [ 12.153396][ T260] CPU: 3 UID: 0 PID: 260 Comm: ip Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 12.153400][ T260] Tainted: [W]=WARN [ 12.153401][ T260] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 12.153402][ T260] Call Trace: [ 12.153404][ T260] [ 12.153406][ T260] dump_stack_lvl+0x6f/0xa0 [ 12.153411][ T260] ? vprintk_emit+0x31b/0x3e0 [ 12.153414][ T260] __might_resched.cold+0x1fe/0x2c1 [ 12.153418][ T260] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 12.153422][ T260] ? __kmalloc_noprof+0xdb/0x760 [ 12.153428][ T260] __kmalloc_noprof+0x443/0x760 [ 12.153430][ T260] ? alloc_buf.isra.0+0x4b/0x260 [ 12.153436][ T260] ? do_raw_spin_unlock+0x59/0x250 [ 12.153439][ T260] alloc_buf.isra.0+0x4b/0x260 [ 12.153442][ T260] put_chars+0x1e1/0x2f0 [ 12.153445][ T260] ? __send_to_port+0x420/0x420 [ 12.153449][ T260] ? validate_chain+0x34a/0xc20 [ 12.153453][ T260] hvc_console_print+0x292/0x780 [ 12.153456][ T260] ? mark_usage+0x61/0x170 [ 12.153458][ T260] ? __lock_acquire+0x518/0xc20 [ 12.153460][ T260] ? __lock_acquire+0x518/0xc20 [ 12.153464][ T260] ? hvc_write+0x3a0/0x3a0 [ 12.153466][ T260] ? console_emit_next_record+0x1df/0x4c0 [ 12.153469][ T260] ? rcu_is_watching+0x16/0xd0 [ 12.153473][ T260] ? lock_acquire+0x13c/0x160 [ 12.153477][ T260] console_emit_next_record+0x22f/0x4c0 [ 12.153481][ T260] ? devkmsg_read+0x4b0/0x4b0 [ 12.153483][ T260] ? console_flush_one_record+0x106/0x710 [ 12.153486][ T260] ? rcu_is_watching+0x16/0xd0 [ 12.153488][ T260] ? lock_acquire+0x13c/0x160 [ 12.153493][ T260] console_flush_one_record+0x46f/0x710 [ 12.153499][ T260] ? console_emit_next_record+0x4c0/0x4c0 [ 12.153502][ T260] ? __lock_acquire+0x518/0xc20 [ 12.153511][ T260] console_unlock+0xee/0x1f0 [ 12.153515][ T260] ? console_flush_one_record+0x710/0x710 [ 12.153518][ T260] ? rcu_is_watching+0x16/0xd0 [ 12.153521][ T260] ? lock_acquire+0x60/0x160 [ 12.153527][ T260] ? __down_trylock_console_sem+0x5e/0xa0 [ 12.153530][ T260] ? vprintk_emit+0x320/0x3e0 [ 12.153535][ T260] vprintk_emit+0x37c/0x3e0 [ 12.153541][ T260] ? wake_up_klogd_work_func+0x90/0x90 [ 12.153544][ T260] ? __lock_release.isra.0+0x69/0x1a0 [ 12.153547][ T260] ? _raw_spin_unlock_irqrestore+0x40/0x80 [ 12.153551][ T260] ? mark_held_locks+0x40/0x70 [ 12.153555][ T260] _printk+0xc7/0x100 [ 12.153559][ T260] ? snapshot_read.cold+0x21/0x21 [ 12.153563][ T260] ? br_multicast_flood+0xab0/0xab0 [bridge] [ 12.153577][ T260] ? do_setlink.isra.0+0xa31/0x2750 [ 12.153578][ T260] ? rtnl_newlink+0x9f1/0x11c0 [ 12.153579][ T260] ? rtnetlink_rcv_msg+0x6fd/0xbd0 [ 12.153584][ T260] br_set_state+0x22f/0x430 [bridge] [ 12.153594][ T260] br_init_port+0xc4/0x200 [bridge] [ 12.153603][ T260] new_nbp+0x39c/0x580 [bridge] [ 12.153613][ T260] br_add_if+0x212/0x1320 [bridge] [ 12.153620][ T260] ? is_bpf_text_address+0x72/0x110 [ 12.153624][ T260] ? kernel_text_address+0x149/0x170 [ 12.153627][ T260] ? __kernel_text_address+0x12/0x30 [ 12.153631][ T260] do_set_master+0x357/0x580 [ 12.153636][ T260] do_setlink.isra.0+0xa31/0x2750 [ 12.153639][ T260] ? stack_trace_save+0x93/0xc0 [ 12.153643][ T260] ? rtnl_link_get_size+0x350/0x350 [ 12.153644][ T260] ? rcu_read_lock_any_held+0x66/0x90 [ 12.153646][ T260] ? stack_depot_save_flags+0x38e/0x790 [ 12.153650][ T260] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 12.153653][ T260] ? rcu_read_lock_any_held+0x3c/0x90 [ 12.153654][ T260] ? validate_chain+0x38b/0xc20 [ 12.153657][ T260] ? kasan_save_stack+0x3d/0x50 [ 12.153660][ T260] ? kasan_save_stack+0x2f/0x50 [ 12.153662][ T260] ? kasan_save_track+0x14/0x30 [ 12.153665][ T260] ? __lock_acquire+0x518/0xc20 [ 12.153667][ T260] ? netlink_seq_next+0x4e/0x60 [ 12.153670][ T260] ? ___sys_sendmsg+0xb0/0x1d0 [ 12.153674][ T260] ? lock_acquire.part.0+0xd4/0x280 [ 12.153676][ T260] ? rtnl_newlink+0x9a8/0x11c0 [ 12.153679][ T260] ? rcu_is_watching+0x16/0xd0 [ 12.153682][ T260] ? lock_acquire+0x13c/0x160 [ 12.153683][ T260] ? rcu_is_watching+0x16/0xd0 [ 12.153685][ T260] ? rcu_is_watching+0x16/0xd0 [ 12.153687][ T260] ? trace_contention_end+0xb3/0x180 [ 12.153691][ T260] ? __mutex_lock+0x1db/0x1ea0 [ 12.153693][ T260] ? __mutex_lock+0x9a3/0x1ea0 [ 12.153695][ T260] ? rtnl_newlink+0x9a8/0x11c0 [ 12.153699][ T260] ? ww_mutex_lock+0x160/0x160 [ 12.153700][ T260] ? nla_get_range_signed+0x3d0/0x3d0 [ 12.153705][ T260] ? __rtnl_newlink+0x3fa/0xa50 [ 12.153711][ T260] rtnl_newlink+0x9f1/0x11c0 [ 12.153716][ T260] ? rtnl_bridge_getlink+0x850/0x850 [ 12.153718][ T260] ? __lock_acquire+0x518/0xc20 [ 12.153723][ T260] ? lock_acquire.part.0+0xd4/0x280 [ 12.153724][ T260] ? find_held_lock+0x2b/0x80 [ 12.153727][ T260] ? rtnl_bridge_getlink+0x850/0x850 [ 12.153729][ T260] ? __lock_release.isra.0+0x69/0x1a0 [ 12.153732][ T260] ? rtnl_bridge_getlink+0x850/0x850 [ 12.153734][ T260] rtnetlink_rcv_msg+0x6fd/0xbd0 [ 12.153738][ T260] ? rtnl_link_fill+0x920/0x920 [ 12.153739][ T260] ? __lock_acquire+0x518/0xc20 [ 12.153749][ T260] ? lock_acquire.part.0+0xd4/0x280 [ 12.153751][ T260] ? find_held_lock+0x2b/0x80 [ 12.153755][ T260] netlink_rcv_skb+0x14e/0x3a0 [ 12.153757][ T260] ? rtnl_link_fill+0x920/0x920 [ 12.153760][ T260] ? netlink_ack+0xcf0/0xcf0 [ 12.153766][ T260] ? netlink_deliver_tap+0xc5/0x330 [ 12.153768][ T260] ? netlink_deliver_tap+0x13c/0x330 [ 12.153772][ T260] netlink_unicast+0x486/0x750 [ 12.153776][ T260] ? netlink_attachskb+0x810/0x810 [ 12.153779][ T260] ? __lock_acquire+0x518/0xc20 [ 12.153783][ T260] netlink_sendmsg+0x735/0xc60 [ 12.153787][ T260] ? netlink_unicast+0x750/0x750 [ 12.153791][ T260] ? __might_fault+0x97/0x140 [ 12.153796][ T260] ____sys_sendmsg+0x415/0x880 [ 12.153799][ T260] ? copy_msghdr_from_user+0x279/0x420 [ 12.153801][ T260] ? get_timestamp.constprop.0+0x390/0x390 [ 12.153803][ T260] ? move_addr_to_kernel+0x40/0x40 [ 12.153810][ T260] ___sys_sendmsg+0x14e/0x1d0 [ 12.153813][ T260] ? copy_msghdr_from_user+0x420/0x420 [ 12.153829][ T260] __sys_sendmsg+0x12c/0x1d0 [ 12.153832][ T260] ? __sys_sendmsg_sock+0x20/0x20 [ 12.153839][ T260] ? rcu_is_watching+0x16/0xd0 [ 12.153842][ T260] do_syscall_64+0xff/0x530 [ 12.153845][ T260] ? exc_page_fault+0xee/0x100 [ 12.153848][ T260] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 12.153851][ T260] RIP: 0033:0x7f3bf74e754e [ 12.153855][ T260] Code: 4d 89 d8 e8 b4 bd 00 00 4c 8b 5d f8 41 8b 93 08 03 00 00 59 5e 48 83 f8 fc 74 11 c9 c3 0f 1f 80 00 00 00 00 48 8b 45 10 0f 05 c3 83 e2 39 83 fa 08 75 e7 e8 03 ff ff ff 0f 1f 00 f3 0f 1e fa [ 12.153858][ T260] RSP: 002b:00007ffcbcb02f40 EFLAGS: 00000202 ORIG_RAX: 000000000000002e [ 12.153862][ T260] RAX: ffffffffffffffda RBX: 0000000000000004 RCX: 00007f3bf74e754e [ 12.153863][ T260] RDX: 0000000000000000 RSI: 00007ffcbcb02ff0 RDI: 0000000000000005 [ 12.153864][ T260] RBP: 00007ffcbcb02f50 R08: 0000000000000000 R09: 0000000000000000 [ 12.153865][ T260] R10: 0000000000000000 R11: 0000000000000202 R12: 000000006a9160c5 [ 12.153866][ T260] R13: 00000000004a1620 R14: 0000000000000000 R15: 00007ffcbcb036b0 [ 12.153873][ T260] [ 12.197467][ T260] br1: port 1(veth1) entered disabled state [ 12.197911][ T260] veth1: entered allmulticast mode [ 12.199897][ T260] veth1: entered promiscuous mode [ 12.210849][ T260] ip (260) used greatest stack depth: 23336 bytes left [ 12.237957][ T190] br1: port 1(veth1) entered blocking state [ 12.238555][ T190] br1: port 1(veth1) entered forwarding state [ 27.494278][ C2] [ 27.494293][ C2] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 27.494296][ C2] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 0, name: swapper/2 [ 27.494298][ C2] preempt_count: 104, expected: 0 [ 27.494299][ C2] RCU nest depth: 0, expected: 0 [ 27.494301][ C2] INFO: lockdep is turned off. [ 27.494302][ C2] irq event stamp: 705768 [ 27.494303][ C2] hardirqs last enabled at (705768): [] _raw_spin_unlock_irq+0x28/0x50 [ 27.494314][ C2] hardirqs last disabled at (705767): [] _raw_spin_lock_irq+0x4a/0x50 [ 27.494316][ C2] softirqs last enabled at (705752): [] handle_softirqs+0x67c/0x900 [ 27.494321][ C2] softirqs last disabled at (705765): [] __irq_exit_rcu+0x145/0x1c0 [ 27.494324][ C2] Preemption disabled at: [ 27.494325][ C2] [<0000000000000000>] 0x0 [ 27.494333][ C2] CPU: 2 UID: 0 PID: 0 Comm: swapper/2 Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 27.494337][ C2] Tainted: [W]=WARN [ 27.494339][ C2] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 27.494341][ C2] Call Trace: [ 27.494343][ C2] [ 27.494345][ C2] dump_stack_lvl+0x6f/0xa0 [ 27.494352][ C2] __might_resched.cold+0x1fe/0x2c1 [ 27.494357][ C2] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 27.494361][ C2] ? __asan_memcpy+0x3c/0x60 [ 27.494365][ C2] ? rcu_is_watching+0x16/0xd0 [ 27.494369][ C2] __kmalloc_noprof+0x443/0x760 [ 27.494373][ C2] ? __rwlock_init+0x150/0x150 [ 27.494377][ C2] ? alloc_buf.isra.0+0x4b/0x260 [ 27.494382][ C2] ? do_raw_spin_unlock+0x59/0x250 [ 27.494384][ C2] alloc_buf.isra.0+0x4b/0x260 [ 27.494387][ C2] put_chars+0x1e1/0x2f0 [ 27.494390][ C2] ? __send_to_port+0x420/0x420 [ 27.494393][ C2] ? console_prepend_replay+0x20/0x20 [ 27.494397][ C2] hvc_console_print+0x292/0x780 [ 27.494402][ C2] ? hvc_write+0x3a0/0x3a0 [ 27.494404][ C2] ? rcu_is_watching+0x16/0xd0 [ 27.494407][ C2] ? lock_acquire+0x13c/0x160 [ 27.494410][ C2] console_emit_next_record+0x22f/0x4c0 [ 27.494414][ C2] ? devkmsg_read+0x4b0/0x4b0 [ 27.494416][ C2] ? rcu_is_watching+0x16/0xd0 [ 27.494419][ C2] ? rcu_is_watching+0x16/0xd0 [ 27.494421][ C2] ? lock_acquire+0x13c/0x160 [ 27.494424][ C2] ? console_flush_one_record+0x111/0x710 [ 27.494427][ C2] console_flush_one_record+0x46f/0x710 [ 27.494430][ C2] ? console_emit_next_record+0x4c0/0x4c0 [ 27.494434][ C2] console_unlock+0xee/0x1f0 [ 27.494437][ C2] ? lock_acquire+0x13c/0x160 [ 27.494439][ C2] ? console_flush_one_record+0x710/0x710 [ 27.494441][ C2] ? rcu_is_watching+0x16/0xd0 [ 27.494444][ C2] ? lock_release+0x184/0x1f0 [ 27.494445][ C2] ? lock_acquire+0x60/0x160 [ 27.494448][ C2] ? __down_trylock_console_sem+0x5e/0xa0 [ 27.494451][ C2] ? vprintk_emit+0x320/0x3e0 [ 27.494454][ C2] vprintk_emit+0x37c/0x3e0 [ 27.494457][ C2] ? wake_up_klogd_work_func+0x90/0x90 [ 27.494460][ C2] ? br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 27.494475][ C2] ? lock_release+0x184/0x1f0 [ 27.494477][ C2] ? br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 27.494487][ C2] ? br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 27.494496][ C2] ? is_module_text_address+0x154/0x250 [ 27.494501][ C2] _printk+0xc7/0x100 [ 27.494505][ C2] ? snapshot_read.cold+0x21/0x21 [ 27.494507][ C2] ? arch_stack_walk+0xd7/0x130 [ 27.494513][ C2] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 27.494516][ C2] ? nbcon_cpu_emergency_enter+0x28/0x80 [ 27.494518][ C2] print_irq_inversion_bug.part.0+0x32/0xc0 [ 27.494522][ C2] mark_lock_irq+0x989/0x9c0 [ 27.494526][ C2] mark_lock+0x1d7/0xa00 [ 27.494529][ C2] mark_usage+0x42/0x170 [ 27.494531][ C2] __lock_acquire+0x388/0xc20 [ 27.494535][ C2] lock_acquire.part.0+0xd4/0x280 [ 27.494537][ C2] ? br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 27.494548][ C2] ? rcu_is_watching+0x16/0xd0 [ 27.494551][ C2] ? lock_acquire+0x13c/0x160 [ 27.494553][ C2] ? br_message_age_timer_expired+0x70/0x70 [bridge] [ 27.494564][ C2] _raw_spin_lock+0x33/0x40 [ 27.494567][ C2] ? br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 27.494578][ C2] br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 27.494589][ C2] ? br_message_age_timer_expired+0x70/0x70 [bridge] [ 27.494599][ C2] call_timer_fn+0x160/0x4d0 [ 27.494603][ C2] ? detach_if_pending+0x1d0/0x1d0 [ 27.494605][ C2] ? debug_object_active_state+0x430/0x430 [ 27.494610][ C2] ? find_held_lock+0x2b/0x80 [ 27.494613][ C2] ? __lock_release.isra.0+0x69/0x1a0 [ 27.494615][ C2] ? rcu_is_watching+0x16/0xd0 [ 27.494619][ C2] __run_timers+0x68f/0xaa0 [ 27.494621][ C2] ? br_message_age_timer_expired+0x70/0x70 [bridge] [ 27.494632][ C2] ? __bpf_trace_itimer_expire+0x10/0x10 [ 27.494634][ C2] ? __lock_acquire+0x518/0xc20 [ 27.494639][ C2] ? __rwlock_init+0x150/0x150 [ 27.494642][ C2] run_timer_softirq+0xf0/0x160 [ 27.494645][ C2] ? __run_timers+0xaa0/0xaa0 [ 27.494648][ C2] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 27.494651][ C2] ? rcu_is_watching+0x16/0xd0 [ 27.494653][ C2] handle_softirqs+0x1d3/0x900 [ 27.494656][ C2] ? __lock_release.isra.0+0x69/0x1a0 [ 27.494658][ C2] ? _local_bh_enable+0xc0/0xc0 [ 27.494662][ C2] __irq_exit_rcu+0x145/0x1c0 [ 27.494664][ C2] irq_exit_rcu+0xe/0x30 [ 27.494666][ C2] sysvec_apic_timer_interrupt+0x9d/0xe0 [ 27.494670][ C2] [ 27.494671][ C2] [ 27.494672][ C2] ? lockdep_hardirqs_on+0x91/0x130 [ 27.494674][ C2] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 27.494677][ C2] RIP: 0010:pv_native_safe_halt+0xf/0x10 [ 27.494681][ C2] 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 [ 27.494683][ C2] RSP: 0018:ffa0000000157e00 EFLAGS: 00000282 [ 27.494688][ C2] RAX: 00000000000ac4e3 RBX: ff11000001bec6c0 RCX: ffffffff94af0307 [ 27.494690][ C2] RDX: ff11000001bec6c0 RSI: ffffffff97838b01 RDI: ffffffff9728d8e0 [ 27.494692][ C2] RBP: 0000000000000000 R08: 0000000000000000 R09: 0000000000000000 [ 27.494693][ C2] R10: 0000000000000002 R11: 0000000000000001 R12: 1ff400000002afc3 [ 27.494694][ C2] R13: 0000000000000000 R14: dffffc0000000000 R15: 0000000000000000 [ 27.494697][ C2] ? cpuidle_idle_call.constprop.0+0x237/0x410 [ 27.494701][ C2] default_idle+0x9/0x10 [ 27.494704][ C2] default_idle_call+0x6e/0xb0 [ 27.494706][ C2] cpuidle_idle_call.constprop.0+0x237/0x410 [ 27.494709][ C2] ? arch_cpu_idle_exit+0x40/0x40 [ 27.494711][ C2] ? mark_tsc_async_resets+0x30/0x30 [ 27.494715][ C2] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 27.494717][ C2] ? rcu_is_watching+0x16/0xd0 [ 27.494720][ C2] do_idle+0xd8/0x190 [ 27.494722][ C2] cpu_startup_entry+0x53/0x70 [ 27.494725][ C2] start_secondary+0x204/0x2b0 [ 27.494728][ C2] ? set_cpu_sibling_map+0x2130/0x2130 [ 27.494731][ C2] common_startup_64+0x13e/0x148 [ 27.494737][ C2] [ 27.514386][ C2] ======================================================== [ 27.514631][ C2] WARNING: possible irq lock inversion dependency detected [ 27.514889][ C2] 7.2.0-virtme #1 Tainted: G W [ 27.515059][ C2] -------------------------------------------------------- [ 27.515301][ C2] swapper/2/0 just changed the state of lock: [ 27.515517][ C2] ff11000009dfae58 (&br->lock){+.-.}-{3:3}, at: br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 27.515840][ C2] but this lock took another, SOFTIRQ-unsafe lock in the past: [ 27.516084][ C2] (fs_reclaim){+.+.}-{0:0} [ 27.516087][ C2] [ 27.516087][ C2] [ 27.516087][ C2] and interrupts could create inverse lock ordering between them. [ 27.516087][ C2] [ 27.516634][ C2] [ 27.516634][ C2] other info that might help us debug this: [ 27.516880][ C2] Chain exists of: [ 27.516880][ C2] &br->lock --> console_owner --> fs_reclaim [ 27.516880][ C2] [ 27.517225][ C2] Possible interrupt unsafe locking scenario: [ 27.517225][ C2] [ 27.517475][ C2] CPU0 CPU1 [ 27.517656][ C2] ---- ---- [ 27.517789][ C2] lock(fs_reclaim); [ 27.517911][ C2] local_irq_disable(); [ 27.518122][ C2] lock(&br->lock); [ 27.518297][ C2] lock(console_owner); [ 27.518465][ C2] [ 27.518610][ C2] lock(&br->lock); [ 27.518711][ C2] [ 27.518711][ C2] *** DEADLOCK *** [ 27.518711][ C2] [ 27.518961][ C2] locks held by swapper/2/0: 1, last CPU#2: [ 27.519134][ C2] #0: ffa0000000228c90 ((&p->forward_delay_timer)){+.-.}-{0:0}, at: call_timer_fn+0x110/0x4d0 [ 27.519544][ C2] [ 27.519544][ C2] the shortest dependencies between 2nd lock and 1st lock: [ 27.519844][ C2] -> (fs_reclaim){+.+.}-{0:0} { [ 27.520027][ C2] HARDIRQ-ON-W at: [ 27.520130][ C2] __lock_acquire+0x388/0xc20 [ 27.520303][ C2] lock_acquire.part.0+0xd4/0x280 [ 27.520472][ C2] fs_reclaim_acquire+0xd5/0x120 [ 27.520688][ C2] __kmalloc_cache_noprof+0x6e/0x620 [ 27.520946][ C2] kthread_create_worker_on_node+0xea/0x210 [ 27.521190][ C2] workqueue_init+0x2a/0x680 [ 27.521357][ C2] kernel_init_freeable+0x2fe/0x630 [ 27.521601][ C2] kernel_init+0x21/0x150 [ 27.521826][ C2] ret_from_fork+0x474/0x6b0 [ 27.521995][ C2] ret_from_fork_asm+0x11/0x20 [ 27.522210][ C2] SOFTIRQ-ON-W at: [ 27.522315][ C2] __lock_acquire+0x388/0xc20 [ 27.522529][ C2] lock_acquire.part.0+0xd4/0x280 [ 27.522696][ C2] fs_reclaim_acquire+0xd5/0x120 [ 27.522915][ C2] __kmalloc_cache_noprof+0x6e/0x620 [ 27.523162][ C2] kthread_create_worker_on_node+0xea/0x210 [ 27.523406][ C2] workqueue_init+0x2a/0x680 [ 27.523569][ C2] kernel_init_freeable+0x2fe/0x630 [ 27.523820][ C2] kernel_init+0x21/0x150 [ 27.524029][ C2] ret_from_fork+0x474/0x6b0 [ 27.524193][ C2] ret_from_fork_asm+0x11/0x20 [ 27.524406][ C2] INITIAL USE at: [ 27.524504][ C2] __lock_acquire+0x388/0xc20 [ 27.524712][ C2] lock_acquire.part.0+0xd4/0x280 [ 27.524884][ C2] fs_reclaim_acquire+0xd5/0x120 [ 27.525095][ C2] __kmalloc_cache_noprof+0x6e/0x620 [ 27.525340][ C2] kthread_create_worker_on_node+0xea/0x210 [ 27.525582][ C2] workqueue_init+0x2a/0x680 [ 27.525746][ C2] kernel_init_freeable+0x2fe/0x630 [ 27.525966][ C2] kernel_init+0x21/0x150 [ 27.526132][ C2] ret_from_fork+0x474/0x6b0 [ 27.526343][ C2] ret_from_fork_asm+0x11/0x20 [ 27.526555][ C2] } [ 27.526626][ C2] ... key at: [] __fs_reclaim_map+0x0/0xbe0 [ 27.526883][ C2] ... acquired at: [ 27.526986][ C2] __lock_acquire+0x518/0xc20 [ 27.527165][ C2] lock_acquire.part.0+0xd4/0x280 [ 27.527298][ C2] fs_reclaim_acquire+0xd5/0x120 [ 27.527473][ C2] __kmalloc_noprof+0xd3/0x760 [ 27.527602][ C2] alloc_buf.isra.0+0x4b/0x260 [ 27.527779][ C2] put_chars+0x1e1/0x2f0 [ 27.527915][ C2] hvc_console_print+0x292/0x780 [ 27.528095][ C2] console_emit_next_record+0x22f/0x4c0 [ 27.528226][ C2] console_flush_one_record+0x46f/0x710 [ 27.528402][ C2] console_unlock+0xee/0x1f0 [ 27.528533][ C2] vprintk_emit+0x37c/0x3e0 [ 27.528712][ C2] dev_vprintk_emit+0x27f/0x2c0 [ 27.528851][ C2] dev_printk_emit+0xb9/0xee [ 27.529027][ C2] _dev_info+0xe2/0x116 [ 27.529126][ C2] __devm_rtc_register_device.cold+0xc3/0x3a8 [ 27.529341][ C2] cmos_do_probe+0x73b/0x98a [ 27.529470][ C2] platform_probe+0xfe/0x1f0 [ 27.529647][ C2] call_driver_probe+0x61/0x1c0 [ 27.529778][ C2] really_probe+0x199/0x760 [ 27.529958][ C2] __driver_probe_device+0x24f/0x440 [ 27.530088][ C2] driver_probe_device+0x4a/0xf0 [ 27.530263][ C2] __driver_attach+0x1b8/0x540 [ 27.530400][ C2] bus_for_each_dev+0x130/0x1e0 [ 27.530577][ C2] bus_add_driver+0x2c8/0x530 [ 27.530710][ C2] driver_register+0x1a3/0x390 [ 27.530892][ C2] __platform_driver_probe+0x13f/0x270 [ 27.531026][ C2] cmos_init+0x31/0x40 [ 27.531133][ C2] do_one_initcall+0x124/0x4f0 [ 27.531312][ C2] kernel_init_freeable+0x596/0x630 [ 27.531445][ C2] kernel_init+0x21/0x150 [ 27.531628][ C2] ret_from_fork+0x474/0x6b0 [ 27.531762][ C2] ret_from_fork_asm+0x11/0x20 [ 27.531944][ C2] [ 27.532012][ C2] -> (console_owner){....}-{0:0} { [ 27.532193][ C2] INITIAL USE at: [ 27.532296][ C2] } [ 27.532363][ C2] ... key at: [] console_owner_dep_map+0x0/0x60 [ 27.532607][ C2] ... acquired at: [ 27.532704][ C2] __lock_acquire+0x518/0xc20 [ 27.532890][ C2] lock_acquire.part.0+0xd4/0x280 [ 27.533022][ C2] console_lock_spinning_enable+0x5c/0x60 [ 27.533230][ C2] console_emit_next_record+0x1d1/0x4c0 [ 27.533410][ C2] console_flush_one_record+0x46f/0x710 [ 27.533542][ C2] console_unlock+0xee/0x1f0 [ 27.533723][ C2] vprintk_emit+0x37c/0x3e0 [ 27.533861][ C2] _printk+0xc7/0x100 [ 27.533962][ C2] br_set_state+0x22f/0x430 [bridge] [ 27.534147][ C2] br_init_port+0xc4/0x200 [bridge] [ 27.534287][ C2] br_stp_enable_port+0x12/0x50 [bridge] [ 27.534500][ C2] br_port_carrier_check+0x220/0x430 [bridge] [ 27.534716][ C2] br_device_event+0x52d/0x8f0 [bridge] [ 27.534864][ C2] notifier_call_chain+0xae/0x300 [ 27.535041][ C2] netif_state_change+0x139/0x340 [ 27.535176][ C2] __linkwatch_run_queue+0x34c/0x750 [ 27.535357][ C2] linkwatch_event+0x7f/0xb0 [ 27.535489][ C2] process_one_work+0xe3e/0x1560 [ 27.535669][ C2] worker_thread+0x4f1/0xd60 [ 27.535810][ C2] kthread+0x367/0x460 [ 27.535956][ C2] ret_from_fork+0x474/0x6b0 [ 27.536087][ C2] ret_from_fork_asm+0x11/0x20 [ 27.536264][ C2] [ 27.536330][ C2] -> (&br->lock){+.-.}-{3:3} { [ 27.536463][ C2] HARDIRQ-ON-W at: [ 27.536607][ C2] __lock_acquire+0x388/0xc20 [ 27.536776][ C2] lock_acquire.part.0+0xd4/0x280 [ 27.536995][ C2] _raw_spin_lock_bh+0x38/0x50 [ 27.537209][ C2] recalculate_group_addr+0x51/0x120 [bridge] [ 27.537415][ C2] br_vlan_filter_toggle+0x85/0x110 [bridge] [ 27.537665][ C2] br_changelink+0x575/0x16e0 [bridge] [ 27.537889][ C2] br_dev_newlink+0xeb/0x160 [bridge] [ 27.538061][ C2] rtnl_newlink_create+0x2d0/0x750 [ 27.538275][ C2] __rtnl_newlink+0x22b/0xa50 [ 27.538488][ C2] rtnl_newlink+0x9f1/0x11c0 [ 27.538658][ C2] rtnetlink_rcv_msg+0x6fd/0xbd0 [ 27.538879][ C2] netlink_rcv_skb+0x14e/0x3a0 [ 27.539048][ C2] netlink_unicast+0x486/0x750 [ 27.539262][ C2] netlink_sendmsg+0x735/0xc60 [ 27.539493][ C2] ____sys_sendmsg+0x415/0x880 [ 27.539659][ C2] ___sys_sendmsg+0x14e/0x1d0 [ 27.539873][ C2] __sys_sendmsg+0x12c/0x1d0 [ 27.540089][ C2] do_syscall_64+0xff/0x530 [ 27.540257][ C2] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 27.540506][ C2] IN-SOFTIRQ-W at: [ 27.540609][ C2] __lock_acquire+0x388/0xc20 [ 27.540828][ C2] lock_acquire.part.0+0xd4/0x280 [ 27.541043][ C2] _raw_spin_lock+0x33/0x40 [ 27.541211][ C2] br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 27.541462][ C2] call_timer_fn+0x160/0x4d0 [ 27.541677][ C2] __run_timers+0x68f/0xaa0 [ 27.541850][ C2] run_timer_softirq+0xf0/0x160 [ 27.542066][ C2] handle_softirqs+0x1d3/0x900 [ 27.542234][ C2] __irq_exit_rcu+0x145/0x1c0 [ 27.542463][ C2] irq_exit_rcu+0xe/0x30 [ 27.542680][ C2] sysvec_apic_timer_interrupt+0x9d/0xe0 [ 27.542891][ C2] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 27.543139][ C2] pv_native_safe_halt+0xf/0x10 [ 27.543307][ C2] default_idle+0x9/0x10 [ 27.543472][ C2] default_idle_call+0x6e/0xb0 [ 27.543653][ C2] cpuidle_idle_call.constprop.0+0x237/0x410 [ 27.543909][ C2] do_idle+0xd8/0x190 [ 27.544043][ C2] cpu_startup_entry+0x53/0x70 [ 27.544258][ C2] start_secondary+0x204/0x2b0 [ 27.544476][ C2] common_startup_64+0x13e/0x148 [ 27.544644][ C2] INITIAL USE at: [ 27.544788][ C2] __lock_acquire+0x388/0xc20 [ 27.544960][ C2] lock_acquire.part.0+0xd4/0x280 [ 27.545174][ C2] _raw_spin_lock_bh+0x38/0x50 [ 27.545341][ C2] recalculate_group_addr+0x51/0x120 [bridge] [ 27.545595][ C2] br_vlan_filter_toggle+0x85/0x110 [bridge] [ 27.545854][ C2] br_changelink+0x575/0x16e0 [bridge] [ 27.546071][ C2] br_dev_newlink+0xeb/0x160 [bridge] [ 27.546243][ C2] rtnl_newlink_create+0x2d0/0x750 [ 27.546455][ C2] __rtnl_newlink+0x22b/0xa50 [ 27.546623][ C2] rtnl_newlink+0x9f1/0x11c0 [ 27.546842][ C2] rtnetlink_rcv_msg+0x6fd/0xbd0 [ 27.547056][ C2] netlink_rcv_skb+0x14e/0x3a0 [ 27.547225][ C2] netlink_unicast+0x486/0x750 [ 27.547441][ C2] netlink_sendmsg+0x735/0xc60 [ 27.547655][ C2] ____sys_sendmsg+0x415/0x880 [ 27.547823][ C2] ___sys_sendmsg+0x14e/0x1d0 [ 27.548035][ C2] __sys_sendmsg+0x12c/0x1d0 [ 27.548202][ C2] do_syscall_64+0xff/0x530 [ 27.548369][ C2] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 27.548615][ C2] } [ 27.548683][ C2] ... key at: [] __key.7+0x0/0x40 [bridge] [ 27.548935][ C2] ... acquired at: [ 27.549034][ C2] mark_lock+0x1d7/0xa00 [ 27.549212][ C2] mark_usage+0x42/0x170 [ 27.549345][ C2] __lock_acquire+0x388/0xc20 [ 27.549521][ C2] lock_acquire.part.0+0xd4/0x280 [ 27.549652][ C2] _raw_spin_lock+0x33/0x40 [ 27.549835][ C2] br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 27.550003][ C2] call_timer_fn+0x160/0x4d0 [ 27.550183][ C2] __run_timers+0x68f/0xaa0 [ 27.550312][ C2] run_timer_softirq+0xf0/0x160 [ 27.550491][ C2] handle_softirqs+0x1d3/0x900 [ 27.550624][ C2] __irq_exit_rcu+0x145/0x1c0 [ 27.550805][ C2] irq_exit_rcu+0xe/0x30 [ 27.550935][ C2] sysvec_apic_timer_interrupt+0x9d/0xe0 [ 27.551144][ C2] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 27.551359][ C2] pv_native_safe_halt+0xf/0x10 [ 27.551491][ C2] default_idle+0x9/0x10 [ 27.551668][ C2] default_idle_call+0x6e/0xb0 [ 27.551805][ C2] cpuidle_idle_call.constprop.0+0x237/0x410 [ 27.552015][ C2] do_idle+0xd8/0x190 [ 27.552116][ C2] cpu_startup_entry+0x53/0x70 [ 27.552250][ C2] start_secondary+0x204/0x2b0 [ 27.552381][ C2] common_startup_64+0x13e/0x148 [ 27.552561][ C2] [ 27.552630][ C2] [ 27.552630][ C2] stack backtrace: [ 27.552802][ C2] CPU: 2 UID: 0 PID: 0 Comm: swapper/2 Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 27.552805][ C2] Tainted: [W]=WARN [ 27.552806][ C2] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 27.552808][ C2] Call Trace: [ 27.552810][ C2] [ 27.552812][ C2] dump_stack_lvl+0x6f/0xa0 [ 27.552816][ C2] print_irq_inversion_bug.part.0.cold+0xe6/0x143 [ 27.552819][ C2] mark_lock_irq+0x989/0x9c0 [ 27.552822][ C2] mark_lock+0x1d7/0xa00 [ 27.552824][ C2] mark_usage+0x42/0x170 [ 27.552826][ C2] __lock_acquire+0x388/0xc20 [ 27.552828][ C2] lock_acquire.part.0+0xd4/0x280 [ 27.552830][ C2] ? br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 27.552837][ C2] ? rcu_is_watching+0x16/0xd0 [ 27.552840][ C2] ? lock_acquire+0x13c/0x160 [ 27.552841][ C2] ? br_message_age_timer_expired+0x70/0x70 [bridge] [ 27.552847][ C2] _raw_spin_lock+0x33/0x40 [ 27.552849][ C2] ? br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 27.552856][ C2] br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 27.552862][ C2] ? br_message_age_timer_expired+0x70/0x70 [bridge] [ 27.552869][ C2] call_timer_fn+0x160/0x4d0 [ 27.552872][ C2] ? detach_if_pending+0x1d0/0x1d0 [ 27.552873][ C2] ? debug_object_active_state+0x430/0x430 [ 27.552877][ C2] ? find_held_lock+0x2b/0x80 [ 27.552879][ C2] ? __lock_release.isra.0+0x69/0x1a0 [ 27.552880][ C2] ? rcu_is_watching+0x16/0xd0 [ 27.552883][ C2] __run_timers+0x68f/0xaa0 [ 27.552884][ C2] ? br_message_age_timer_expired+0x70/0x70 [bridge] [ 27.552891][ C2] ? __bpf_trace_itimer_expire+0x10/0x10 [ 27.552893][ C2] ? __lock_acquire+0x518/0xc20 [ 27.552895][ C2] ? __rwlock_init+0x150/0x150 [ 27.552898][ C2] run_timer_softirq+0xf0/0x160 [ 27.552900][ C2] ? __run_timers+0xaa0/0xaa0 [ 27.552901][ C2] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 27.552904][ C2] ? rcu_is_watching+0x16/0xd0 [ 27.552906][ C2] handle_softirqs+0x1d3/0x900 [ 27.552908][ C2] ? __lock_release.isra.0+0x69/0x1a0 [ 27.552909][ C2] ? _local_bh_enable+0xc0/0xc0 [ 27.552911][ C2] __irq_exit_rcu+0x145/0x1c0 [ 27.552912][ C2] irq_exit_rcu+0xe/0x30 [ 27.552914][ C2] sysvec_apic_timer_interrupt+0x9d/0xe0 [ 27.552916][ C2] [ 27.552916][ C2] [ 27.552917][ C2] ? lockdep_hardirqs_on+0x91/0x130 [ 27.552918][ C2] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 27.552920][ C2] RIP: 0010:pv_native_safe_halt+0xf/0x10 [ 27.552923][ C2] 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 [ 27.552925][ C2] RSP: 0018:ffa0000000157e00 EFLAGS: 00000282 [ 27.552927][ C2] RAX: 00000000000ac4e3 RBX: ff11000001bec6c0 RCX: ffffffff94af0307 [ 27.552929][ C2] RDX: ff11000001bec6c0 RSI: ffffffff97838b01 RDI: ffffffff9728d8e0 [ 27.552929][ C2] RBP: 0000000000000000 R08: 0000000000000000 R09: 0000000000000000 [ 27.552931][ C2] R10: 0000000000000002 R11: 0000000000000001 R12: 1ff400000002afc3 [ 27.552931][ C2] R13: 0000000000000000 R14: dffffc0000000000 R15: 0000000000000000 [ 27.552933][ C2] ? cpuidle_idle_call.constprop.0+0x237/0x410 [ 27.552935][ C2] default_idle+0x9/0x10 [ 27.552936][ C2] default_idle_call+0x6e/0xb0 [ 27.552938][ C2] cpuidle_idle_call.constprop.0+0x237/0x410 [ 27.552940][ C2] ? arch_cpu_idle_exit+0x40/0x40 [ 27.552941][ C2] ? mark_tsc_async_resets+0x30/0x30 [ 27.552943][ C2] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 27.552944][ C2] ? rcu_is_watching+0x16/0xd0 [ 27.552946][ C2] do_idle+0xd8/0x190 [ 27.552948][ C2] cpu_startup_entry+0x53/0x70 [ 27.552949][ C2] start_secondary+0x204/0x2b0 [ 27.552951][ C2] ? set_cpu_sibling_map+0x2130/0x2130 [ 27.552952][ C2] common_startup_64+0x13e/0x148 [ 27.552955][ C2] [ 39.063935][ T445] br1: port 1(veth1) entered disabled state [ 39.063952][ T445] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 39.063955][ T445] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 445, name: ip [ 39.063956][ T445] preempt_count: 202, expected: 0 [ 39.063958][ T445] RCU nest depth: 0, expected: 0 [ 39.063959][ T445] INFO: lockdep is turned off. [ 39.063960][ T445] irq event stamp: 0 [ 39.063961][ T445] hardirqs last enabled at (0): [<0000000000000000>] 0x0 [ 39.063966][ T445] hardirqs last disabled at (0): [] copy_process+0x1ccd/0x6240 [ 39.063972][ T445] softirqs last enabled at (0): [] copy_process+0x1d21/0x6240 [ 39.063973][ T445] softirqs last disabled at (0): [<0000000000000000>] 0x0 [ 39.063975][ T445] Preemption disabled at: [ 39.063976][ T445] [<0000000000000000>] 0x0 [ 39.063981][ T445] CPU: 2 UID: 0 PID: 445 Comm: ip Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 39.063984][ T445] Tainted: [W]=WARN [ 39.063985][ T445] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 39.063987][ T445] Call Trace: [ 39.063989][ T445] [ 39.063990][ T445] dump_stack_lvl+0x6f/0xa0 [ 39.063995][ T445] __might_resched.cold+0x1fe/0x2c1 [ 39.063999][ T445] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 39.064003][ T445] ? rcu_is_watching+0x16/0xd0 [ 39.064007][ T445] __kmalloc_noprof+0x443/0x760 [ 39.064011][ T445] ? __rwlock_init+0x150/0x150 [ 39.064014][ T445] ? alloc_buf.isra.0+0x4b/0x260 [ 39.064018][ T445] ? do_raw_spin_unlock+0x59/0x250 [ 39.064019][ T445] alloc_buf.isra.0+0x4b/0x260 [ 39.064021][ T445] put_chars+0x1e1/0x2f0 [ 39.064023][ T445] ? __send_to_port+0x420/0x420 [ 39.064025][ T445] ? printk_get_next_message+0x240/0x650 [ 39.064028][ T445] hvc_console_print+0x292/0x780 [ 39.064031][ T445] ? hvc_write+0x3a0/0x3a0 [ 39.064034][ T445] ? __rwlock_init+0x150/0x150 [ 39.064035][ T445] ? rcu_is_watching+0x16/0xd0 [ 39.064037][ T445] ? lock_acquire+0x13c/0x160 [ 39.064039][ T445] console_emit_next_record+0x22f/0x4c0 [ 39.064041][ T445] ? devkmsg_read+0x4b0/0x4b0 [ 39.064043][ T445] ? rcu_is_watching+0x16/0xd0 [ 39.064045][ T445] ? rcu_is_watching+0x16/0xd0 [ 39.064046][ T445] ? rcu_is_watching+0x16/0xd0 [ 39.064048][ T445] ? lock_acquire+0x13c/0x160 [ 39.064050][ T445] ? console_flush_one_record+0x111/0x710 [ 39.064052][ T445] console_flush_one_record+0x46f/0x710 [ 39.064054][ T445] ? console_emit_next_record+0x4c0/0x4c0 [ 39.064057][ T445] console_unlock+0xee/0x1f0 [ 39.064058][ T445] ? lock_acquire+0x13c/0x160 [ 39.064060][ T445] ? console_flush_one_record+0x710/0x710 [ 39.064062][ T445] ? rcu_is_watching+0x16/0xd0 [ 39.064063][ T445] ? lock_release+0x184/0x1f0 [ 39.064065][ T445] ? lock_acquire+0x60/0x160 [ 39.064066][ T445] ? __rcu_read_lock+0x30/0x70 [ 39.064068][ T445] ? __down_trylock_console_sem+0x5e/0xa0 [ 39.064070][ T445] ? vprintk_emit+0x320/0x3e0 [ 39.064072][ T445] vprintk_emit+0x37c/0x3e0 [ 39.064074][ T445] ? wake_up_klogd_work_func+0x90/0x90 [ 39.064076][ T445] ? rcu_is_watching+0x16/0xd0 [ 39.064078][ T445] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 39.064080][ T445] ? trace_hardirqs_on+0x36/0x40 [ 39.064082][ T445] _printk+0xc7/0x100 [ 39.064085][ T445] ? snapshot_read.cold+0x21/0x21 [ 39.064087][ T445] ? ipv6_mc_down+0x17e/0x2d0 [ 39.064092][ T445] br_set_state+0x22f/0x430 [bridge] [ 39.064105][ T445] br_stp_disable_port+0x11f/0x390 [bridge] [ 39.064113][ T445] br_device_event+0x7b5/0x8f0 [bridge] [ 39.064122][ T445] ? _raw_spin_unlock_irqrestore+0x40/0x80 [ 39.064125][ T445] ? _sub_I_65535_1+0x4d0/0x4d0 [stp] [ 39.064127][ T445] ? addrconf_notify+0x2c8/0xf30 [ 39.064130][ T445] notifier_call_chain+0xae/0x300 [ 39.064133][ T445] __dev_notify_flags+0x23c/0x3c0 [ 39.064137][ T445] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 39.064138][ T445] ? netif_change_name+0x8c0/0x8c0 [ 39.064140][ T445] ? netif_set_allmulti+0x250/0x250 [ 39.064142][ T445] ? __kernel_text_address+0x12/0x30 [ 39.064144][ T445] ? write_profile+0xf0/0xf0 [ 39.064146][ T445] ? unwind_get_return_address+0x67/0xd0 [ 39.064149][ T445] netif_change_flags+0xfe/0x190 [ 39.064152][ T445] do_setlink.isra.0+0x1cc3/0x2750 [ 39.064154][ T445] ? stack_trace_save+0x93/0xc0 [ 39.064156][ T445] ? rtnl_link_get_size+0x350/0x350 [ 39.064157][ T445] ? rcu_is_watching+0x16/0xd0 [ 39.064159][ T445] ? stack_depot_save_flags+0x1bc/0x790 [ 39.064162][ T445] ? kasan_save_stack+0x3d/0x50 [ 39.064165][ T445] ? kasan_save_stack+0x2f/0x50 [ 39.064166][ T445] ? kasan_save_track+0x14/0x30 [ 39.064168][ T445] ? __kasan_kmalloc+0x7b/0x90 [ 39.064169][ T445] ? __kmalloc_cache_noprof+0x29a/0x620 [ 39.064171][ T445] ? rtnl_newlink+0x124/0x11c0 [ 39.064172][ T445] ? rtnetlink_rcv_msg+0x6fd/0xbd0 [ 39.064173][ T445] ? netlink_rcv_skb+0x14e/0x3a0 [ 39.064176][ T445] ? netlink_unicast+0x486/0x750 [ 39.064177][ T445] ? netlink_sendmsg+0x735/0xc60 [ 39.064178][ T445] ? ____sys_sendmsg+0x415/0x880 [ 39.064181][ T445] ? ___sys_sendmsg+0x14e/0x1d0 [ 39.064182][ T445] ? __sys_sendmsg+0x12c/0x1d0 [ 39.064184][ T445] ? do_syscall_64+0xff/0x530 [ 39.064186][ T445] ? entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 39.064188][ T445] ? rcu_is_watching+0x16/0xd0 [ 39.064190][ T445] ? lock_acquire+0x13c/0x160 [ 39.064191][ T445] ? rcu_is_watching+0x16/0xd0 [ 39.064193][ T445] ? rcu_is_watching+0x16/0xd0 [ 39.064195][ T445] ? trace_contention_end+0xb3/0x180 [ 39.064198][ T445] ? __mutex_lock+0x1db/0x1ea0 [ 39.064199][ T445] ? __mutex_lock+0x9a3/0x1ea0 [ 39.064200][ T445] ? rtnl_newlink+0x9a8/0x11c0 [ 39.064202][ T445] ? ww_mutex_lock+0x160/0x160 [ 39.064204][ T445] ? __rtnl_newlink+0x3fa/0xa50 [ 39.064206][ T445] rtnl_newlink+0x9f1/0x11c0 [ 39.064208][ T445] ? rcu_is_watching+0x16/0xd0 [ 39.064210][ T445] ? rtnl_bridge_getlink+0x850/0x850 [ 39.064211][ T445] ? lock_acquire+0x13c/0x160 [ 39.064212][ T445] ? rcu_is_watching+0x16/0xd0 [ 39.064214][ T445] ? is_bpf_text_address+0x3e/0x110 [ 39.064217][ T445] ? is_bpf_text_address+0x72/0x110 [ 39.064219][ T445] ? kernel_text_address+0x149/0x170 [ 39.064220][ T445] ? __kernel_text_address+0x12/0x30 [ 39.064223][ T445] ? write_profile+0xf0/0xf0 [ 39.064225][ T445] ? unwind_get_return_address+0x67/0xd0 [ 39.064226][ T445] ? rcu_is_watching+0x16/0xd0 [ 39.064228][ T445] ? rcu_is_watching+0x16/0xd0 [ 39.064230][ T445] ? cap_capable+0x1d7/0x3d0 [ 39.064233][ T445] ? lock_acquire+0x13c/0x160 [ 39.064235][ T445] ? rcu_is_watching+0x16/0xd0 [ 39.064237][ T445] ? rtnl_bridge_getlink+0x850/0x850 [ 39.064238][ T445] rtnetlink_rcv_msg+0x6fd/0xbd0 [ 39.064240][ T445] ? rtnl_link_fill+0x920/0x920 [ 39.064241][ T445] ? filter_irq_stacks+0xd0/0xd0 [ 39.064243][ T445] ? stack_depot_save_flags+0x1bc/0x790 [ 39.064245][ T445] netlink_rcv_skb+0x14e/0x3a0 [ 39.064247][ T445] ? rtnl_link_fill+0x920/0x920 [ 39.064248][ T445] ? lock_release+0x184/0x1f0 [ 39.064250][ T445] ? netlink_ack+0xcf0/0xcf0 [ 39.064252][ T445] ? __netlink_lookup+0xb9/0x6b0 [ 39.064254][ T445] ? rcu_is_watching+0x16/0xd0 [ 39.064256][ T445] ? lock_release+0x184/0x1f0 [ 39.064259][ T445] netlink_unicast+0x486/0x750 [ 39.064261][ T445] ? netlink_attachskb+0x810/0x810 [ 39.064263][ T445] ? rcu_is_watching+0x16/0xd0 [ 39.064264][ T445] ? rcu_is_watching+0x16/0xd0 [ 39.064266][ T445] ? lock_acquire+0x13c/0x160 [ 39.064268][ T445] netlink_sendmsg+0x735/0xc60 [ 39.064270][ T445] ? netlink_unicast+0x750/0x750 [ 39.064272][ T445] ? rcu_is_watching+0x16/0xd0 [ 39.064274][ T445] ? lock_release+0x184/0x1f0 [ 39.064276][ T445] ____sys_sendmsg+0x415/0x880 [ 39.064277][ T445] ? copy_msghdr_from_user+0x279/0x420 [ 39.064279][ T445] ? get_timestamp.constprop.0+0x390/0x390 [ 39.064280][ T445] ? move_addr_to_kernel+0x40/0x40 [ 39.064282][ T445] ? filter_irq_stacks+0xd0/0xd0 [ 39.064284][ T445] ___sys_sendmsg+0x14e/0x1d0 [ 39.064286][ T445] ? copy_msghdr_from_user+0x420/0x420 [ 39.064291][ T445] __sys_sendmsg+0x12c/0x1d0 [ 39.064293][ T445] ? __sys_sendmsg_sock+0x20/0x20 [ 39.064296][ T445] ? rcu_is_watching+0x16/0xd0 [ 39.064298][ T445] do_syscall_64+0xff/0x530 [ 39.064299][ T445] ? exc_page_fault+0xee/0x100 [ 39.064301][ T445] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 39.064303][ T445] RIP: 0033:0x7fbeee3a454e [ 39.064305][ T445] 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 [ 39.064306][ T445] RSP: 002b:00007fff54d45870 EFLAGS: 00000202 ORIG_RAX: 000000000000002e [ 39.064310][ T445] RAX: ffffffffffffffda RBX: 0000000000000003 RCX: 00007fbeee3a454e [ 39.064311][ T445] RDX: 0000000000000000 RSI: 00007fff54d45920 RDI: 0000000000000005 [ 39.064312][ T445] RBP: 00007fff54d45880 R08: 0000000000000000 R09: 0000000000000000 [ 39.064313][ T445] R10: 0000000000000000 R11: 0000000000000202 R12: 000000006a9160e0 [ 39.064314][ T445] R13: 00000000004a1620 R14: 0000000000000000 R15: 00007fff54d45fe0 [ 39.064316][ T445] [ 39.111521][ T445] ip (445) used greatest stack depth: 23016 bytes left [ 39.129213][ T446] veth1: left allmulticast mode [ 39.129758][ T446] veth1: left promiscuous mode [ 39.129997][ T446] br1: port 1(veth1) entered disabled state