[ 11.864943][ T237] 8021q: 802.1Q VLAN Support v1.8 [ 11.864962][ T237] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 11.864965][ T237] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 237, name: modprobe [ 11.864967][ T237] preempt_count: 1, expected: 0 [ 11.864968][ T237] RCU nest depth: 0, expected: 0 [ 11.864969][ T237] locks held by modprobe/237: 4, last CPU#3: [ 11.864971][ T237] #0: ffffffff85369cc0 (console_lock){+.+.}-{0:0}, at: vprintk_emit+0x320/0x3e0 [ 11.864984][ T237] #1: ffffffff85369d38 (console_srcu){....}-{0:0}, at: console_flush_one_record+0x106/0x710 [ 11.864988][ T237] #2: ffffffff85289660 (console_owner){....}-{0:0}, at: console_lock_spinning_enable+0x40/0x60 [ 11.864992][ T237] #3: ffffffff85289560 (printk_legacy_map-wait-type-override){....}-{3:3}, at: console_emit_next_record+0x1df/0x4c0 [ 11.864996][ T237] irq event stamp: 22296 [ 11.864997][ T237] hardirqs last enabled at (22295): [] __down_trylock_console_sem+0x86/0xa0 [ 11.864999][ T237] hardirqs last disabled at (22296): [] console_emit_next_record+0x3d4/0x4c0 [ 11.865002][ T237] softirqs last enabled at (18788): [] handle_softirqs+0x67c/0x900 [ 11.865005][ T237] softirqs last disabled at (17695): [] __irq_exit_rcu+0x145/0x1c0 [ 11.865007][ T237] Preemption disabled at: [ 11.865008][ T237] [] vprintk_emit+0x31b/0x3e0 [ 11.865013][ T237] CPU: 3 UID: 0 PID: 237 Comm: modprobe Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 11.865017][ T237] Tainted: [W]=WARN [ 11.865018][ T237] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 11.865020][ T237] Call Trace: [ 11.865021][ T237] [ 11.865023][ T237] dump_stack_lvl+0x6f/0xa0 [ 11.865028][ T237] ? vprintk_emit+0x31b/0x3e0 [ 11.865030][ T237] __might_resched.cold+0x1fe/0x2c1 [ 11.865034][ T237] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 11.865038][ T237] ? __kmalloc_noprof+0xdb/0x760 [ 11.865043][ T237] __kmalloc_noprof+0x443/0x760 [ 11.865045][ T237] ? alloc_buf.isra.0+0x4b/0x260 [ 11.865051][ T237] ? do_raw_spin_unlock+0x59/0x250 [ 11.865053][ T237] alloc_buf.isra.0+0x4b/0x260 [ 11.865057][ T237] put_chars+0x1e1/0x2f0 [ 11.865059][ T237] ? __send_to_port+0x420/0x420 [ 11.865061][ T237] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 11.865066][ T237] ? rcu_read_lock_any_held+0x3c/0x90 [ 11.865068][ T237] ? validate_chain+0x38b/0xc20 [ 11.865072][ T237] hvc_console_print+0x292/0x780 [ 11.865075][ T237] ? __lock_acquire+0x518/0xc20 [ 11.865080][ T237] ? hvc_write+0x3a0/0x3a0 [ 11.865082][ T237] ? rcu_is_watching+0x16/0xd0 [ 11.865087][ T237] console_emit_next_record+0x22f/0x4c0 [ 11.865091][ T237] ? devkmsg_read+0x4b0/0x4b0 [ 11.865092][ T237] ? console_flush_one_record+0x106/0x710 [ 11.865095][ T237] ? rcu_is_watching+0x16/0xd0 [ 11.865098][ T237] ? lock_acquire+0x13c/0x160 [ 11.865101][ T237] console_flush_one_record+0x46f/0x710 [ 11.865105][ T237] ? console_emit_next_record+0x4c0/0x4c0 [ 11.865107][ T237] ? __lock_acquire+0x518/0xc20 [ 11.865112][ T237] console_unlock+0xee/0x1f0 [ 11.865115][ T237] ? console_flush_one_record+0x710/0x710 [ 11.865116][ T237] ? rcu_is_watching+0x16/0xd0 [ 11.865119][ T237] ? lock_acquire+0x60/0x160 [ 11.865122][ T237] ? __down_trylock_console_sem+0x5e/0xa0 [ 11.865124][ T237] ? vprintk_emit+0x320/0x3e0 [ 11.865127][ T237] vprintk_emit+0x37c/0x3e0 [ 11.865131][ T237] ? wake_up_klogd_work_func+0x90/0x90 [ 11.865136][ T237] ? vlan_netlink_fini+0x960/0x960 [8021q] [ 11.865139][ T237] _printk+0xc7/0x100 [ 11.865143][ T237] ? snapshot_read.cold+0x21/0x21 [ 11.865149][ T237] ? do_one_initcall+0x113/0x4f0 [ 11.865152][ T237] vlan_proto_init+0x24/0x90 [8021q] [ 11.865155][ T237] do_one_initcall+0x124/0x4f0 [ 11.865157][ T237] ? trace_event_raw_event_initcall_level+0x280/0x280 [ 11.865162][ T237] ? do_init_module+0xae/0x8a0 [ 11.865165][ T237] ? kasan_unpoison+0x44/0x70 [ 11.865169][ T237] do_init_module+0x2ad/0x8a0 [ 11.865173][ T237] ? lockdep_hardirqs_on+0x91/0x130 [ 11.865177][ T237] ? free_module+0x470/0x470 [ 11.865180][ T237] ? kfree+0x123/0x590 [ 11.865184][ T237] load_module+0x1424/0x1bb0 [ 11.865191][ T237] ? layout_and_allocate.isra.0+0x680/0x680 [ 11.865194][ T237] ? __ia32_sys_fsconfig+0x180/0x180 [ 11.865197][ T237] ? ovl_real_file+0x172/0x1e0 [ 11.865201][ T237] ? backing_file_read_iter+0x541/0x790 [ 11.865204][ T237] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 11.865208][ T237] init_module_from_file+0x11f/0x1a0 [ 11.865211][ T237] ? __do_sys_init_module+0x220/0x220 [ 11.865219][ T237] ? __rwlock_init+0x150/0x150 [ 11.865225][ T237] ? do_raw_spin_unlock+0x59/0x250 [ 11.865228][ T237] idempotent_init_module+0x37b/0x7c0 [ 11.865231][ T237] ? init_module_from_file+0x1a0/0x1a0 [ 11.865237][ T237] ? rcu_is_watching+0x16/0xd0 [ 11.865239][ T237] ? cap_capable+0x1d7/0x3d0 [ 11.865245][ T237] __x64_sys_finit_module+0xdf/0x190 [ 11.865247][ T237] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 11.865251][ T237] do_syscall_64+0xff/0x530 [ 11.865253][ T237] ? exc_page_fault+0xee/0x100 [ 11.865255][ T237] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 11.865258][ T237] RIP: 0033:0x7f4e9dce137d [ 11.865261][ T237] Code: ff c3 66 2e 0f 1f 84 00 00 00 00 00 90 f3 0f 1e fa 48 89 f8 48 89 f7 48 89 d6 48 89 ca 4d 89 c2 4d 89 c8 4c 8b 4c 24 08 0f 05 <48> 3d 01 f0 ff ff 73 01 c3 48 8b 0d 4b aa 0f 00 f7 d8 64 89 01 48 [ 11.865263][ T237] RSP: 002b:00007ffc329ef4c8 EFLAGS: 00000246 ORIG_RAX: 0000000000000139 [ 11.865265][ T237] RAX: ffffffffffffffda RBX: 00005576acd11810 RCX: 00007f4e9dce137d [ 11.865267][ T237] RDX: 0000000000000000 RSI: 0000557679ddcffd RDI: 0000000000000000 [ 11.865268][ T237] RBP: 00007ffc329ef560 R08: 0000000000000000 R09: 0000000000000000 [ 11.865269][ T237] R10: 0000000000000000 R11: 0000000000000246 R12: 0000557679ddcffd [ 11.865269][ T237] R13: 00005576acd11960 R14: 0000000000040000 R15: 0000000000000000 [ 11.865276][ T237] [ 12.223965][ T248] ip (248) used greatest stack depth: 24576 bytes left [ 13.237052][ T285] br1: port 1(vx10) entered blocking state [ 13.237229][ T285] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 13.237231][ T285] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 285, name: ip [ 13.237233][ T285] preempt_count: 1, expected: 0 [ 13.237234][ T285] RCU nest depth: 0, expected: 0 [ 13.237235][ T285] locks held by ip/285: 5, last CPU#2: [ 13.237237][ T285] #0: ffffffff85ad2c40 (rtnl_mutex){+.+.}-{4:4}, at: rtnl_newlink+0x9a8/0x11c0 [ 13.237249][ T285] #1: ffffffff85369cc0 (console_lock){+.+.}-{0:0}, at: vprintk_emit+0x320/0x3e0 [ 13.237256][ T285] #2: ffffffff85369d38 (console_srcu){....}-{0:0}, at: console_flush_one_record+0x106/0x710 [ 13.237260][ T285] #3: ffffffff85289660 (console_owner){....}-{0:0}, at: console_lock_spinning_enable+0x40/0x60 [ 13.237264][ T285] #4: ffffffff85289560 (printk_legacy_map-wait-type-override){....}-{3:3}, at: console_emit_next_record+0x1df/0x4c0 [ 13.237268][ T285] irq event stamp: 18040 [ 13.237269][ T285] hardirqs last enabled at (18039): [] __down_trylock_console_sem+0x86/0xa0 [ 13.237272][ T285] hardirqs last disabled at (18040): [] console_emit_next_record+0x3d4/0x4c0 [ 13.237274][ T285] softirqs last enabled at (17950): [] __alloc_skb+0x4c2/0x5f0 [ 13.237277][ T285] softirqs last disabled at (17948): [] __alloc_skb+0x4c2/0x5f0 [ 13.237279][ T285] Preemption disabled at: [ 13.237280][ T285] [] vprintk_emit+0x31b/0x3e0 [ 13.237286][ T285] CPU: 2 UID: 0 PID: 285 Comm: ip Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 13.237290][ T285] Tainted: [W]=WARN [ 13.237291][ T285] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 13.237293][ T285] Call Trace: [ 13.237295][ T285] [ 13.237296][ T285] dump_stack_lvl+0x6f/0xa0 [ 13.237303][ T285] ? vprintk_emit+0x31b/0x3e0 [ 13.237305][ T285] __might_resched.cold+0x1fe/0x2c1 [ 13.237309][ T285] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 13.237314][ T285] ? __kmalloc_noprof+0xdb/0x760 [ 13.237319][ T285] __kmalloc_noprof+0x443/0x760 [ 13.237321][ T285] ? alloc_buf.isra.0+0x4b/0x260 [ 13.237327][ T285] ? do_raw_spin_unlock+0x59/0x250 [ 13.237329][ T285] alloc_buf.isra.0+0x4b/0x260 [ 13.237333][ T285] put_chars+0x1e1/0x2f0 [ 13.237336][ T285] ? __send_to_port+0x420/0x420 [ 13.237340][ T285] ? validate_chain+0x34a/0xc20 [ 13.237344][ T285] hvc_console_print+0x292/0x780 [ 13.237346][ T285] ? mark_usage+0x61/0x170 [ 13.237348][ T285] ? __lock_acquire+0x518/0xc20 [ 13.237350][ T285] ? __lock_acquire+0x518/0xc20 [ 13.237353][ T285] ? hvc_write+0x3a0/0x3a0 [ 13.237356][ T285] ? console_emit_next_record+0x1df/0x4c0 [ 13.237359][ T285] ? rcu_is_watching+0x16/0xd0 [ 13.237363][ T285] ? lock_acquire+0x13c/0x160 [ 13.237367][ T285] console_emit_next_record+0x22f/0x4c0 [ 13.237370][ T285] ? devkmsg_read+0x4b0/0x4b0 [ 13.237372][ T285] ? console_flush_one_record+0x106/0x710 [ 13.237375][ T285] ? rcu_is_watching+0x16/0xd0 [ 13.237378][ T285] ? lock_acquire+0x13c/0x160 [ 13.237381][ T285] console_flush_one_record+0x46f/0x710 [ 13.237386][ T285] ? console_emit_next_record+0x4c0/0x4c0 [ 13.237387][ T285] ? __lock_acquire+0x518/0xc20 [ 13.237393][ T285] console_unlock+0xee/0x1f0 [ 13.237397][ T285] ? console_flush_one_record+0x710/0x710 [ 13.237399][ T285] ? rcu_is_watching+0x16/0xd0 [ 13.237401][ T285] ? lock_acquire+0x60/0x160 [ 13.237405][ T285] ? __down_trylock_console_sem+0x5e/0xa0 [ 13.237406][ T285] ? vprintk_emit+0x320/0x3e0 [ 13.237410][ T285] vprintk_emit+0x37c/0x3e0 [ 13.237414][ T285] ? wake_up_klogd_work_func+0x90/0x90 [ 13.237416][ T285] ? __lock_release.isra.0+0x69/0x1a0 [ 13.237418][ T285] ? _raw_spin_unlock_irqrestore+0x40/0x80 [ 13.237422][ T285] ? mark_held_locks+0x40/0x70 [ 13.237425][ T285] _printk+0xc7/0x100 [ 13.237429][ T285] ? snapshot_read.cold+0x21/0x21 [ 13.237433][ T285] ? br_multicast_flood+0xab0/0xab0 [bridge] [ 13.237446][ T285] ? do_setlink.isra.0+0xa31/0x2750 [ 13.237447][ T285] ? rtnl_newlink+0x9f1/0x11c0 [ 13.237449][ T285] ? rtnetlink_rcv_msg+0x6fd/0xbd0 [ 13.237453][ T285] br_set_state+0x22f/0x430 [bridge] [ 13.237463][ T285] br_init_port+0xc4/0x200 [bridge] [ 13.237471][ T285] new_nbp+0x39c/0x580 [bridge] [ 13.237481][ T285] br_add_if+0x212/0x1320 [bridge] [ 13.237488][ T285] ? is_bpf_text_address+0x72/0x110 [ 13.237492][ T285] ? kernel_text_address+0x149/0x170 [ 13.237495][ T285] ? __kernel_text_address+0x12/0x30 [ 13.237499][ T285] do_set_master+0x357/0x580 [ 13.237504][ T285] do_setlink.isra.0+0xa31/0x2750 [ 13.237507][ T285] ? stack_trace_save+0x93/0xc0 [ 13.237510][ T285] ? rtnl_link_get_size+0x350/0x350 [ 13.237511][ T285] ? rcu_read_lock_any_held+0x66/0x90 [ 13.237513][ T285] ? stack_depot_save_flags+0x38e/0x790 [ 13.237517][ T285] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 13.237519][ T285] ? rcu_read_lock_any_held+0x3c/0x90 [ 13.237521][ T285] ? validate_chain+0x38b/0xc20 [ 13.237524][ T285] ? kasan_save_stack+0x3d/0x50 [ 13.237527][ T285] ? kasan_save_stack+0x2f/0x50 [ 13.237528][ T285] ? kasan_save_track+0x14/0x30 [ 13.237531][ T285] ? __lock_acquire+0x518/0xc20 [ 13.237533][ T285] ? netlink_seq_next+0x4e/0x60 [ 13.237536][ T285] ? ___sys_sendmsg+0xb0/0x1d0 [ 13.237540][ T285] ? lock_acquire.part.0+0xd4/0x280 [ 13.237542][ T285] ? rtnl_newlink+0x9a8/0x11c0 [ 13.237545][ T285] ? rcu_is_watching+0x16/0xd0 [ 13.237547][ T285] ? lock_acquire+0x13c/0x160 [ 13.237549][ T285] ? rcu_is_watching+0x16/0xd0 [ 13.237550][ T285] ? rcu_is_watching+0x16/0xd0 [ 13.237553][ T285] ? trace_contention_end+0xb3/0x180 [ 13.237557][ T285] ? __mutex_lock+0x1db/0x1ea0 [ 13.237558][ T285] ? __mutex_lock+0x9a3/0x1ea0 [ 13.237560][ T285] ? rtnl_newlink+0x9a8/0x11c0 [ 13.237563][ T285] ? ww_mutex_lock+0x160/0x160 [ 13.237571][ T285] ? nla_get_range_signed+0x3d0/0x3d0 [ 13.237579][ T285] ? __rtnl_newlink+0x3fa/0xa50 [ 13.237588][ T285] rtnl_newlink+0x9f1/0x11c0 [ 13.237597][ T285] ? rtnl_bridge_getlink+0x850/0x850 [ 13.237600][ T285] ? __lock_acquire+0x518/0xc20 [ 13.237605][ T285] ? lock_acquire.part.0+0xd4/0x280 [ 13.237607][ T285] ? find_held_lock+0x2b/0x80 [ 13.237609][ T285] ? rtnl_bridge_getlink+0x850/0x850 [ 13.237611][ T285] ? __lock_release.isra.0+0x69/0x1a0 [ 13.237614][ T285] ? rtnl_bridge_getlink+0x850/0x850 [ 13.237616][ T285] rtnetlink_rcv_msg+0x6fd/0xbd0 [ 13.237619][ T285] ? rtnl_link_fill+0x920/0x920 [ 13.237621][ T285] ? __lock_acquire+0x518/0xc20 [ 13.237625][ T285] ? lock_acquire.part.0+0xd4/0x280 [ 13.237627][ T285] ? find_held_lock+0x2b/0x80 [ 13.237630][ T285] netlink_rcv_skb+0x14e/0x3a0 [ 13.237632][ T285] ? rtnl_link_fill+0x920/0x920 [ 13.237635][ T285] ? netlink_ack+0xcf0/0xcf0 [ 13.237641][ T285] ? netlink_deliver_tap+0xc5/0x330 [ 13.237643][ T285] ? netlink_deliver_tap+0x13c/0x330 [ 13.237647][ T285] netlink_unicast+0x486/0x750 [ 13.237651][ T285] ? netlink_attachskb+0x810/0x810 [ 13.237653][ T285] ? __lock_acquire+0x518/0xc20 [ 13.237657][ T285] netlink_sendmsg+0x735/0xc60 [ 13.237661][ T285] ? netlink_unicast+0x750/0x750 [ 13.237665][ T285] ? __might_fault+0x97/0x140 [ 13.237670][ T285] ____sys_sendmsg+0x415/0x880 [ 13.237672][ T285] ? copy_msghdr_from_user+0x279/0x420 [ 13.237675][ T285] ? get_timestamp.constprop.0+0x390/0x390 [ 13.237676][ T285] ? move_addr_to_kernel+0x40/0x40 [ 13.237683][ T285] ___sys_sendmsg+0x14e/0x1d0 [ 13.237686][ T285] ? copy_msghdr_from_user+0x420/0x420 [ 13.237701][ T285] __sys_sendmsg+0x12c/0x1d0 [ 13.237704][ T285] ? __sys_sendmsg_sock+0x20/0x20 [ 13.237710][ T285] ? rcu_is_watching+0x16/0xd0 [ 13.237714][ T285] do_syscall_64+0xff/0x530 [ 13.237716][ T285] ? exc_page_fault+0xee/0x100 [ 13.237720][ T285] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 13.237722][ T285] RIP: 0033:0x7f7d783ea54e [ 13.237726][ T285] 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 [ 13.237728][ T285] RSP: 002b:00007ffd7eb70460 EFLAGS: 00000202 ORIG_RAX: 000000000000002e [ 13.237731][ T285] RAX: ffffffffffffffda RBX: 0000000000000004 RCX: 00007f7d783ea54e [ 13.237732][ T285] RDX: 0000000000000000 RSI: 00007ffd7eb70510 RDI: 0000000000000005 [ 13.237733][ T285] RBP: 00007ffd7eb70470 R08: 0000000000000000 R09: 0000000000000000 [ 13.237734][ T285] R10: 0000000000000000 R11: 0000000000000202 R12: 000000006a915823 [ 13.237735][ T285] R13: 00000000004a1620 R14: 0000000000000000 R15: 00007ffd7eb70bd0 [ 13.237741][ T285] [ 13.290436][ T285] br1: port 1(vx10) entered disabled state [ 13.291196][ T285] vx10: entered allmulticast mode [ 13.292851][ T285] vx10: entered promiscuous mode [ 13.293602][ T285] br1: port 1(vx10) entered blocking state [ 13.294326][ T285] br1: port 1(vx10) entered forwarding state [ 13.303590][ T285] ip (285) used greatest stack depth: 23336 bytes left [ 13.423350][ T290] br1: port 2(vx20) entered blocking state [ 13.423694][ T290] br1: port 2(vx20) entered disabled state [ 13.424012][ T290] vx20: entered allmulticast mode [ 13.425997][ T290] vx20: entered promiscuous mode [ 13.426473][ T290] br1: port 2(vx20) entered blocking state [ 13.426778][ T290] br1: port 2(vx20) entered forwarding state [ 13.491620][ T292] br1: port 3(veth1) entered blocking state [ 13.492013][ T292] br1: port 3(veth1) entered disabled state [ 13.492399][ T292] veth1: entered allmulticast mode [ 13.494022][ T292] veth1: entered promiscuous mode [ 13.527552][ T46] br1: port 3(veth1) entered blocking state [ 13.528031][ T46] br1: port 3(veth1) entered forwarding state [ 13.615384][ T296] br1: port 4(veth2) entered blocking state [ 13.615848][ T296] br1: port 4(veth2) entered disabled state [ 13.616315][ T296] veth2: entered allmulticast mode [ 13.618007][ T296] veth2: entered promiscuous mode [ 13.645554][ T46] br1: port 4(veth2) entered blocking state [ 13.645905][ T46] br1: port 4(veth2) entered forwarding state [ 14.989267][ T345] br2: port 1(w1) entered blocking state [ 14.989287][ T345] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 14.989290][ T345] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 345, name: ip [ 14.989291][ T345] preempt_count: 1, expected: 0 [ 14.989292][ T345] RCU nest depth: 0, expected: 0 [ 14.989293][ T345] locks held by ip/345: 5, last CPU#0: [ 14.989295][ T345] #0: ffffffff85ad2c40 (rtnl_mutex){+.+.}-{4:4}, at: rtnl_newlink+0x9a8/0x11c0 [ 14.989308][ T345] #1: ffffffff85369cc0 (console_lock){+.+.}-{0:0}, at: vprintk_emit+0x320/0x3e0 [ 14.989314][ T345] #2: ffffffff85369d38 (console_srcu){....}-{0:0}, at: console_flush_one_record+0x106/0x710 [ 14.989318][ T345] #3: ffffffff85289660 (console_owner){....}-{0:0}, at: console_lock_spinning_enable+0x40/0x60 [ 14.989322][ T345] #4: ffffffff85289560 (printk_legacy_map-wait-type-override){....}-{3:3}, at: console_emit_next_record+0x1df/0x4c0 [ 14.989325][ T345] irq event stamp: 11974 [ 14.989326][ T345] hardirqs last enabled at (11973): [] __down_trylock_console_sem+0x86/0xa0 [ 14.989329][ T345] hardirqs last disabled at (11974): [] console_emit_next_record+0x3d4/0x4c0 [ 14.989331][ T345] softirqs last enabled at (11914): [] __alloc_skb+0x4c2/0x5f0 [ 14.989334][ T345] softirqs last disabled at (11912): [] __alloc_skb+0x4c2/0x5f0 [ 14.989337][ T345] Preemption disabled at: [ 14.989337][ T345] [] vprintk_emit+0x31b/0x3e0 [ 14.989343][ T345] CPU: 0 UID: 0 PID: 345 Comm: ip Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 14.989346][ T345] Tainted: [W]=WARN [ 14.989347][ T345] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 14.989349][ T345] Call Trace: [ 14.989351][ T345] [ 14.989353][ T345] dump_stack_lvl+0x6f/0xa0 [ 14.989358][ T345] ? vprintk_emit+0x31b/0x3e0 [ 14.989361][ T345] __might_resched.cold+0x1fe/0x2c1 [ 14.989365][ T345] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 14.989369][ T345] ? __kmalloc_noprof+0xdb/0x760 [ 14.989374][ T345] __kmalloc_noprof+0x443/0x760 [ 14.989376][ T345] ? alloc_buf.isra.0+0x4b/0x260 [ 14.989382][ T345] ? do_raw_spin_unlock+0x59/0x250 [ 14.989385][ T345] alloc_buf.isra.0+0x4b/0x260 [ 14.989388][ T345] put_chars+0x1e1/0x2f0 [ 14.989390][ T345] ? prb_final_commit+0x50/0x50 [ 14.989392][ T345] ? __send_to_port+0x420/0x420 [ 14.989395][ T345] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 14.989399][ T345] ? rcu_read_lock_any_held+0x3c/0x90 [ 14.989401][ T345] ? validate_chain+0x38b/0xc20 [ 14.989405][ T345] hvc_console_print+0x292/0x780 [ 14.989408][ T345] ? mark_usage+0x61/0x170 [ 14.989410][ T345] ? __lock_acquire+0x518/0xc20 [ 14.989411][ T345] ? __lock_acquire+0x518/0xc20 [ 14.989415][ T345] ? hvc_write+0x3a0/0x3a0 [ 14.989417][ T345] ? console_emit_next_record+0x1df/0x4c0 [ 14.989420][ T345] ? rcu_is_watching+0x16/0xd0 [ 14.989422][ T345] ? lock_acquire+0x13c/0x160 [ 14.989426][ T345] console_emit_next_record+0x22f/0x4c0 [ 14.989430][ T345] ? devkmsg_read+0x4b0/0x4b0 [ 14.989432][ T345] ? console_flush_one_record+0x106/0x710 [ 14.989435][ T345] ? rcu_is_watching+0x16/0xd0 [ 14.989437][ T345] ? lock_acquire+0x13c/0x160 [ 14.989441][ T345] console_flush_one_record+0x46f/0x710 [ 14.989445][ T345] ? console_emit_next_record+0x4c0/0x4c0 [ 14.989447][ T345] ? __lock_acquire+0x518/0xc20 [ 14.989452][ T345] console_unlock+0xee/0x1f0 [ 14.989455][ T345] ? console_flush_one_record+0x710/0x710 [ 14.989457][ T345] ? rcu_is_watching+0x16/0xd0 [ 14.989459][ T345] ? lock_acquire+0x60/0x160 [ 14.989463][ T345] ? __down_trylock_console_sem+0x5e/0xa0 [ 14.989465][ T345] ? vprintk_emit+0x320/0x3e0 [ 14.989468][ T345] vprintk_emit+0x37c/0x3e0 [ 14.989472][ T345] ? wake_up_klogd_work_func+0x90/0x90 [ 14.989475][ T345] ? __lock_release.isra.0+0x69/0x1a0 [ 14.989477][ T345] ? mark_held_locks+0x40/0x70 [ 14.989481][ T345] _printk+0xc7/0x100 [ 14.989485][ T345] ? snapshot_read.cold+0x21/0x21 [ 14.989488][ T345] ? br_multicast_flood+0xab0/0xab0 [bridge] [ 14.989501][ T345] ? do_setlink.isra.0+0xa31/0x2750 [ 14.989502][ T345] ? rtnl_newlink+0x9f1/0x11c0 [ 14.989504][ T345] ? rtnetlink_rcv_msg+0x6fd/0xbd0 [ 14.989508][ T345] br_set_state+0x22f/0x430 [bridge] [ 14.989518][ T345] br_init_port+0xc4/0x200 [bridge] [ 14.989526][ T345] new_nbp+0x39c/0x580 [bridge] [ 14.989536][ T345] br_add_if+0x212/0x1320 [bridge] [ 14.989543][ T345] ? is_bpf_text_address+0x72/0x110 [ 14.989547][ T345] ? kernel_text_address+0x149/0x170 [ 14.989550][ T345] ? __kernel_text_address+0x12/0x30 [ 14.989553][ T345] do_set_master+0x357/0x580 [ 14.989558][ T345] do_setlink.isra.0+0xa31/0x2750 [ 14.989561][ T345] ? stack_trace_save+0x93/0xc0 [ 14.989564][ T345] ? rtnl_link_get_size+0x350/0x350 [ 14.989565][ T345] ? rcu_read_lock_any_held+0x66/0x90 [ 14.989567][ T345] ? stack_depot_save_flags+0x38e/0x790 [ 14.989570][ T345] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 14.989573][ T345] ? rcu_read_lock_any_held+0x3c/0x90 [ 14.989580][ T345] ? validate_chain+0x38b/0xc20 [ 14.989583][ T345] ? kasan_save_stack+0x3d/0x50 [ 14.989586][ T345] ? kasan_save_stack+0x2f/0x50 [ 14.989588][ T345] ? kasan_save_track+0x14/0x30 [ 14.989591][ T345] ? __lock_acquire+0x518/0xc20 [ 14.989593][ T345] ? netlink_seq_next+0x4e/0x60 [ 14.989595][ T345] ? ___sys_sendmsg+0xb0/0x1d0 [ 14.989600][ T345] ? lock_acquire.part.0+0xd4/0x280 [ 14.989602][ T345] ? rtnl_newlink+0x9a8/0x11c0 [ 14.989605][ T345] ? rcu_is_watching+0x16/0xd0 [ 14.989607][ T345] ? lock_acquire+0x13c/0x160 [ 14.989609][ T345] ? rcu_is_watching+0x16/0xd0 [ 14.989610][ T345] ? rcu_is_watching+0x16/0xd0 [ 14.989613][ T345] ? trace_contention_end+0xb3/0x180 [ 14.989616][ T345] ? __mutex_lock+0x1db/0x1ea0 [ 14.989619][ T345] ? __mutex_lock+0x9a3/0x1ea0 [ 14.989621][ T345] ? rtnl_newlink+0x9a8/0x11c0 [ 14.989625][ T345] ? ww_mutex_lock+0x160/0x160 [ 14.989626][ T345] ? nla_get_range_signed+0x3d0/0x3d0 [ 14.989631][ T345] ? __rtnl_newlink+0x3fa/0xa50 [ 14.989636][ T345] rtnl_newlink+0x9f1/0x11c0 [ 14.989641][ T345] ? rtnl_bridge_getlink+0x850/0x850 [ 14.989643][ T345] ? __lock_acquire+0x518/0xc20 [ 14.989647][ T345] ? lock_acquire.part.0+0xd4/0x280 [ 14.989649][ T345] ? find_held_lock+0x2b/0x80 [ 14.989651][ T345] ? rtnl_bridge_getlink+0x850/0x850 [ 14.989653][ T345] ? __lock_release.isra.0+0x69/0x1a0 [ 14.989656][ T345] ? rtnl_bridge_getlink+0x850/0x850 [ 14.989658][ T345] rtnetlink_rcv_msg+0x6fd/0xbd0 [ 14.989661][ T345] ? rtnl_link_fill+0x920/0x920 [ 14.989662][ T345] ? __lock_acquire+0x518/0xc20 [ 14.989667][ T345] ? lock_acquire.part.0+0xd4/0x280 [ 14.989669][ T345] ? find_held_lock+0x2b/0x80 [ 14.989672][ T345] netlink_rcv_skb+0x14e/0x3a0 [ 14.989674][ T345] ? rtnl_link_fill+0x920/0x920 [ 14.989676][ T345] ? netlink_ack+0xcf0/0xcf0 [ 14.989682][ T345] ? netlink_deliver_tap+0xc5/0x330 [ 14.989684][ T345] ? netlink_deliver_tap+0x13c/0x330 [ 14.989688][ T345] netlink_unicast+0x486/0x750 [ 14.989691][ T345] ? netlink_attachskb+0x810/0x810 [ 14.989694][ T345] ? __lock_acquire+0x518/0xc20 [ 14.989698][ T345] netlink_sendmsg+0x735/0xc60 [ 14.989702][ T345] ? netlink_unicast+0x750/0x750 [ 14.989705][ T345] ? __might_fault+0x97/0x140 [ 14.989710][ T345] ____sys_sendmsg+0x415/0x880 [ 14.989713][ T345] ? copy_msghdr_from_user+0x279/0x420 [ 14.989715][ T345] ? get_timestamp.constprop.0+0x390/0x390 [ 14.989717][ T345] ? move_addr_to_kernel+0x40/0x40 [ 14.989724][ T345] ___sys_sendmsg+0x14e/0x1d0 [ 14.989726][ T345] ? copy_msghdr_from_user+0x420/0x420 [ 14.989742][ T345] __sys_sendmsg+0x12c/0x1d0 [ 14.989744][ T345] ? __sys_sendmsg_sock+0x20/0x20 [ 14.989750][ T345] ? rcu_is_watching+0x16/0xd0 [ 14.989754][ T345] do_syscall_64+0xff/0x530 [ 14.989756][ T345] ? exc_page_fault+0xee/0x100 [ 14.989759][ T345] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 14.989762][ T345] RIP: 0033:0x7fcc4080454e [ 14.989765][ T345] Code: 4d 89 d8 e8 b4 bd 00 00 4c 8b 5d f8 41 8b 93 08 03 00 00 59 5e 48 83 f8 fc 74 11 c9 c3 0f 1f 80 00 00 00 00 48 8b 45 10 0f 05 c3 83 e2 39 83 fa 08 75 e7 e8 03 ff ff ff 0f 1f 00 f3 0f 1e fa [ 14.989767][ T345] RSP: 002b:00007ffd99da9d90 EFLAGS: 00000202 ORIG_RAX: 000000000000002e [ 14.989770][ T345] RAX: ffffffffffffffda RBX: 0000000000000004 RCX: 00007fcc4080454e [ 14.989771][ T345] RDX: 0000000000000000 RSI: 00007ffd99da9e40 RDI: 0000000000000005 [ 14.989772][ T345] RBP: 00007ffd99da9da0 R08: 0000000000000000 R09: 0000000000000000 [ 14.989773][ T345] R10: 0000000000000000 R11: 0000000000000202 R12: 000000006a915825 [ 14.989774][ T345] R13: 00000000004a1620 R14: 0000000000000000 R15: 00007ffd99daa500 [ 14.989780][ T345] [ 15.027591][ T345] br2: port 1(w1) entered disabled state [ 15.027964][ T345] w1: entered allmulticast mode [ 15.030358][ T345] w1: entered promiscuous mode [ 15.076823][ T346] br2: port 1(w1) entered blocking state [ 15.077342][ T346] br2: port 1(w1) entered forwarding state [ 15.299000][ T353] br2: port 2(vx10) entered blocking state [ 15.299350][ T353] br2: port 2(vx10) entered disabled state [ 15.299681][ T353] vx10: entered allmulticast mode [ 15.301220][ T353] vx10: entered promiscuous mode [ 15.302292][ T353] br2: port 2(vx10) entered blocking state [ 15.302608][ T353] br2: port 2(vx10) entered forwarding state [ 15.508300][ T360] br2: port 3(vx20) entered blocking state [ 15.508642][ T360] br2: port 3(vx20) entered disabled state [ 15.508964][ T360] vx20: entered allmulticast mode [ 15.510822][ T360] vx20: entered promiscuous mode [ 15.511354][ T360] br2: port 3(vx20) entered blocking state [ 15.511649][ T360] br2: port 3(vx20) entered forwarding state [ 15.602142][ T38] br2: port 1(w1) entered disabled state [ 15.759917][ T46] br2: port 1(w1) entered blocking state [ 15.760206][ T46] br2: port 1(w1) entered forwarding state [ 16.564054][ T399] br2: port 1(w1) entered blocking state [ 16.564075][ T399] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 16.564077][ T399] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 399, name: ip [ 16.564079][ T399] preempt_count: 1, expected: 0 [ 16.564080][ T399] RCU nest depth: 0, expected: 0 [ 16.564081][ T399] locks held by ip/399: 5, last CPU#0: [ 16.564083][ T399] #0: ffffffff85ad2c40 (rtnl_mutex){+.+.}-{4:4}, at: rtnl_newlink+0x9a8/0x11c0 [ 16.564095][ T399] #1: ffffffff85369cc0 (console_lock){+.+.}-{0:0}, at: vprintk_emit+0x320/0x3e0 [ 16.564101][ T399] #2: ffffffff85369d38 (console_srcu){....}-{0:0}, at: console_flush_one_record+0x106/0x710 [ 16.564105][ T399] #3: ffffffff85289660 (console_owner){....}-{0:0}, at: console_lock_spinning_enable+0x40/0x60 [ 16.564109][ T399] #4: ffffffff85289560 (printk_legacy_map-wait-type-override){....}-{3:3}, at: console_emit_next_record+0x1df/0x4c0 [ 16.564113][ T399] irq event stamp: 11038 [ 16.564114][ T399] hardirqs last enabled at (11037): [] __down_trylock_console_sem+0x86/0xa0 [ 16.564116][ T399] hardirqs last disabled at (11038): [] console_emit_next_record+0x3d4/0x4c0 [ 16.564118][ T399] softirqs last enabled at (10978): [] __alloc_skb+0x4c2/0x5f0 [ 16.564122][ T399] softirqs last disabled at (10976): [] __alloc_skb+0x4c2/0x5f0 [ 16.564124][ T399] Preemption disabled at: [ 16.564125][ T399] [] vprintk_emit+0x31b/0x3e0 [ 16.564131][ T399] CPU: 0 UID: 0 PID: 399 Comm: ip Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 16.564135][ T399] Tainted: [W]=WARN [ 16.564136][ T399] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 16.564137][ T399] Call Trace: [ 16.564139][ T399] [ 16.564140][ T399] dump_stack_lvl+0x6f/0xa0 [ 16.564146][ T399] ? vprintk_emit+0x31b/0x3e0 [ 16.564148][ T399] __might_resched.cold+0x1fe/0x2c1 [ 16.564153][ T399] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 16.564157][ T399] ? __kmalloc_noprof+0xdb/0x760 [ 16.564162][ T399] __kmalloc_noprof+0x443/0x760 [ 16.564165][ T399] ? alloc_buf.isra.0+0x4b/0x260 [ 16.564170][ T399] ? do_raw_spin_unlock+0x59/0x250 [ 16.564173][ T399] alloc_buf.isra.0+0x4b/0x260 [ 16.564176][ T399] put_chars+0x1e1/0x2f0 [ 16.564178][ T399] ? prb_final_commit+0x50/0x50 [ 16.564180][ T399] ? __send_to_port+0x420/0x420 [ 16.564183][ T399] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 16.564187][ T399] ? rcu_read_lock_any_held+0x3c/0x90 [ 16.564190][ T399] ? validate_chain+0x38b/0xc20 [ 16.564193][ T399] hvc_console_print+0x292/0x780 [ 16.564196][ T399] ? mark_usage+0x61/0x170 [ 16.564198][ T399] ? __lock_acquire+0x518/0xc20 [ 16.564199][ T399] ? __lock_acquire+0x518/0xc20 [ 16.564203][ T399] ? hvc_write+0x3a0/0x3a0 [ 16.564205][ T399] ? console_emit_next_record+0x1df/0x4c0 [ 16.564208][ T399] ? rcu_is_watching+0x16/0xd0 [ 16.564211][ T399] ? lock_acquire+0x13c/0x160 [ 16.564215][ T399] console_emit_next_record+0x22f/0x4c0 [ 16.564219][ T399] ? devkmsg_read+0x4b0/0x4b0 [ 16.564223][ T399] ? console_flush_one_record+0x106/0x710 [ 16.564226][ T399] ? rcu_is_watching+0x16/0xd0 [ 16.564229][ T399] ? lock_acquire+0x13c/0x160 [ 16.564232][ T399] console_flush_one_record+0x46f/0x710 [ 16.564237][ T399] ? console_emit_next_record+0x4c0/0x4c0 [ 16.564239][ T399] ? __lock_acquire+0x518/0xc20 [ 16.564244][ T399] console_unlock+0xee/0x1f0 [ 16.564247][ T399] ? console_flush_one_record+0x710/0x710 [ 16.564248][ T399] ? rcu_is_watching+0x16/0xd0 [ 16.564251][ T399] ? lock_acquire+0x60/0x160 [ 16.564254][ T399] ? __down_trylock_console_sem+0x5e/0xa0 [ 16.564256][ T399] ? vprintk_emit+0x320/0x3e0 [ 16.564259][ T399] vprintk_emit+0x37c/0x3e0 [ 16.564263][ T399] ? wake_up_klogd_work_func+0x90/0x90 [ 16.564266][ T399] ? __lock_release.isra.0+0x69/0x1a0 [ 16.564268][ T399] ? mark_held_locks+0x40/0x70 [ 16.564272][ T399] _printk+0xc7/0x100 [ 16.564275][ T399] ? snapshot_read.cold+0x21/0x21 [ 16.564279][ T399] ? br_multicast_flood+0xab0/0xab0 [bridge] [ 16.564292][ T399] ? do_setlink.isra.0+0xa31/0x2750 [ 16.564293][ T399] ? rtnl_newlink+0x9f1/0x11c0 [ 16.564295][ T399] ? rtnetlink_rcv_msg+0x6fd/0xbd0 [ 16.564300][ T399] br_set_state+0x22f/0x430 [bridge] [ 16.564310][ T399] br_init_port+0xc4/0x200 [bridge] [ 16.564318][ T399] new_nbp+0x39c/0x580 [bridge] [ 16.564328][ T399] br_add_if+0x212/0x1320 [bridge] [ 16.564335][ T399] ? is_bpf_text_address+0x72/0x110 [ 16.564339][ T399] ? kernel_text_address+0x149/0x170 [ 16.564342][ T399] ? __kernel_text_address+0x12/0x30 [ 16.564346][ T399] do_set_master+0x357/0x580 [ 16.564350][ T399] do_setlink.isra.0+0xa31/0x2750 [ 16.564353][ T399] ? stack_trace_save+0x93/0xc0 [ 16.564356][ T399] ? rtnl_link_get_size+0x350/0x350 [ 16.564358][ T399] ? rcu_read_lock_any_held+0x66/0x90 [ 16.564359][ T399] ? stack_depot_save_flags+0x38e/0x790 [ 16.564363][ T399] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 16.564365][ T399] ? rcu_read_lock_any_held+0x3c/0x90 [ 16.564367][ T399] ? validate_chain+0x38b/0xc20 [ 16.564370][ T399] ? kasan_save_stack+0x3d/0x50 [ 16.564373][ T399] ? kasan_save_stack+0x2f/0x50 [ 16.564374][ T399] ? kasan_save_track+0x14/0x30 [ 16.564377][ T399] ? __lock_acquire+0x518/0xc20 [ 16.564379][ T399] ? netlink_seq_next+0x4e/0x60 [ 16.564382][ T399] ? ___sys_sendmsg+0xb0/0x1d0 [ 16.564386][ T399] ? lock_acquire.part.0+0xd4/0x280 [ 16.564388][ T399] ? rtnl_newlink+0x9a8/0x11c0 [ 16.564391][ T399] ? rcu_is_watching+0x16/0xd0 [ 16.564393][ T399] ? lock_acquire+0x13c/0x160 [ 16.564394][ T399] ? rcu_is_watching+0x16/0xd0 [ 16.564396][ T399] ? rcu_is_watching+0x16/0xd0 [ 16.564398][ T399] ? trace_contention_end+0xb3/0x180 [ 16.564402][ T399] ? __mutex_lock+0x1db/0x1ea0 [ 16.564405][ T399] ? __mutex_lock+0x9a3/0x1ea0 [ 16.564407][ T399] ? rtnl_newlink+0x9a8/0x11c0 [ 16.564410][ T399] ? ww_mutex_lock+0x160/0x160 [ 16.564412][ T399] ? nla_get_range_signed+0x3d0/0x3d0 [ 16.564417][ T399] ? __rtnl_newlink+0x3fa/0xa50 [ 16.564422][ T399] rtnl_newlink+0x9f1/0x11c0 [ 16.564427][ T399] ? rtnl_bridge_getlink+0x850/0x850 [ 16.564429][ T399] ? __lock_acquire+0x518/0xc20 [ 16.564433][ T399] ? lock_acquire.part.0+0xd4/0x280 [ 16.564435][ T399] ? find_held_lock+0x2b/0x80 [ 16.564437][ T399] ? rtnl_bridge_getlink+0x850/0x850 [ 16.564439][ T399] ? __lock_release.isra.0+0x69/0x1a0 [ 16.564442][ T399] ? rtnl_bridge_getlink+0x850/0x850 [ 16.564444][ T399] rtnetlink_rcv_msg+0x6fd/0xbd0 [ 16.564447][ T399] ? rtnl_link_fill+0x920/0x920 [ 16.564448][ T399] ? __lock_acquire+0x518/0xc20 [ 16.564453][ T399] ? lock_acquire.part.0+0xd4/0x280 [ 16.564455][ T399] ? find_held_lock+0x2b/0x80 [ 16.564458][ T399] netlink_rcv_skb+0x14e/0x3a0 [ 16.564460][ T399] ? rtnl_link_fill+0x920/0x920 [ 16.564462][ T399] ? netlink_ack+0xcf0/0xcf0 [ 16.564468][ T399] ? netlink_deliver_tap+0xc5/0x330 [ 16.564470][ T399] ? netlink_deliver_tap+0x13c/0x330 [ 16.564474][ T399] netlink_unicast+0x486/0x750 [ 16.564477][ T399] ? netlink_attachskb+0x810/0x810 [ 16.564480][ T399] ? __lock_acquire+0x518/0xc20 [ 16.564484][ T399] netlink_sendmsg+0x735/0xc60 [ 16.564488][ T399] ? netlink_unicast+0x750/0x750 [ 16.564491][ T399] ? __might_fault+0x97/0x140 [ 16.564496][ T399] ____sys_sendmsg+0x415/0x880 [ 16.564499][ T399] ? copy_msghdr_from_user+0x279/0x420 [ 16.564501][ T399] ? get_timestamp.constprop.0+0x390/0x390 [ 16.564503][ T399] ? move_addr_to_kernel+0x40/0x40 [ 16.564510][ T399] ___sys_sendmsg+0x14e/0x1d0 [ 16.564512][ T399] ? copy_msghdr_from_user+0x420/0x420 [ 16.564527][ T399] __sys_sendmsg+0x12c/0x1d0 [ 16.564530][ T399] ? __sys_sendmsg_sock+0x20/0x20 [ 16.564536][ T399] ? rcu_is_watching+0x16/0xd0 [ 16.564540][ T399] do_syscall_64+0xff/0x530 [ 16.564542][ T399] ? exc_page_fault+0xee/0x100 [ 16.564545][ T399] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 16.564547][ T399] RIP: 0033:0x7fd2cd19e54e [ 16.564551][ T399] 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 [ 16.564552][ T399] RSP: 002b:00007fffc54fbd00 EFLAGS: 00000202 ORIG_RAX: 000000000000002e [ 16.564555][ T399] RAX: ffffffffffffffda RBX: 0000000000000004 RCX: 00007fd2cd19e54e [ 16.564557][ T399] RDX: 0000000000000000 RSI: 00007fffc54fbdb0 RDI: 0000000000000005 [ 16.564558][ T399] RBP: 00007fffc54fbd10 R08: 0000000000000000 R09: 0000000000000000 [ 16.564558][ T399] R10: 0000000000000000 R11: 0000000000000202 R12: 000000006a915826 [ 16.564559][ T399] R13: 00000000004a1620 R14: 0000000000000000 R15: 00007fffc54fc470 [ 16.564566][ T399] [ 16.612636][ T399] br2: port 1(w1) entered disabled state [ 16.613006][ T399] w1: entered allmulticast mode [ 16.614876][ T399] w1: entered promiscuous mode [ 16.852618][ T407] br2: port 2(vx10) entered blocking state [ 16.852973][ T407] br2: port 2(vx10) entered disabled state [ 16.860065][ T407] vx10: entered allmulticast mode [ 16.861655][ T407] vx10: entered promiscuous mode [ 16.862213][ T407] br2: port 2(vx10) entered blocking state [ 16.862516][ T407] br2: port 2(vx10) entered forwarding state [ 17.074951][ T414] br2: port 3(vx20) entered blocking state [ 17.075295][ T414] br2: port 3(vx20) entered disabled state [ 17.075617][ T414] vx20: entered allmulticast mode [ 17.077198][ T414] vx20: entered promiscuous mode [ 17.077659][ T414] br2: port 3(vx20) entered blocking state [ 17.077952][ T414] br2: port 3(vx20) entered forwarding state [ 17.323166][ T39] br2: port 1(w1) entered blocking state [ 17.323463][ T39] br2: port 1(w1) entered forwarding state [ 28.529334][ C0] [ 28.529356][ C0] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 28.529358][ C0] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 0, name: swapper/0 [ 28.529361][ C0] preempt_count: 104, expected: 0 [ 28.529362][ C0] RCU nest depth: 0, expected: 0 [ 28.529364][ C0] INFO: lockdep is turned off. [ 28.529365][ C0] irq event stamp: 1049896 [ 28.529366][ C0] hardirqs last enabled at (1049896): [] _raw_spin_unlock_irq+0x28/0x50 [ 28.529376][ C0] hardirqs last disabled at (1049895): [] _raw_spin_lock_irq+0x4a/0x50 [ 28.529379][ C0] softirqs last enabled at (1049880): [] handle_softirqs+0x67c/0x900 [ 28.529384][ C0] softirqs last disabled at (1049893): [] __irq_exit_rcu+0x145/0x1c0 [ 28.529387][ C0] Preemption disabled at: [ 28.529388][ C0] [] schedule_preempt_disabled+0x22/0x30 [ 28.529396][ C0] CPU: 0 UID: 0 PID: 0 Comm: swapper/0 Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 28.529401][ C0] Tainted: [W]=WARN [ 28.529402][ C0] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 28.529404][ C0] Call Trace: [ 28.529407][ C0] [ 28.529408][ C0] dump_stack_lvl+0x6f/0xa0 [ 28.529415][ C0] ? schedule_preempt_disabled+0x22/0x30 [ 28.529417][ C0] __might_resched.cold+0x1fe/0x2c1 [ 28.529421][ C0] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 28.529425][ C0] ? __asan_memcpy+0x3c/0x60 [ 28.529428][ C0] ? rcu_is_watching+0x16/0xd0 [ 28.529433][ C0] __kmalloc_noprof+0x443/0x760 [ 28.529437][ C0] ? __rwlock_init+0x150/0x150 [ 28.529441][ C0] ? alloc_buf.isra.0+0x4b/0x260 [ 28.529446][ C0] ? do_raw_spin_unlock+0x59/0x250 [ 28.529448][ C0] alloc_buf.isra.0+0x4b/0x260 [ 28.529451][ C0] put_chars+0x1e1/0x2f0 [ 28.529454][ C0] ? __send_to_port+0x420/0x420 [ 28.529457][ C0] ? console_prepend_replay+0x20/0x20 [ 28.529461][ C0] hvc_console_print+0x292/0x780 [ 28.529466][ C0] ? hvc_write+0x3a0/0x3a0 [ 28.529468][ C0] ? rcu_is_watching+0x16/0xd0 [ 28.529471][ C0] ? lock_acquire+0x13c/0x160 [ 28.529474][ C0] console_emit_next_record+0x22f/0x4c0 [ 28.529478][ C0] ? devkmsg_read+0x4b0/0x4b0 [ 28.529481][ C0] ? rcu_is_watching+0x16/0xd0 [ 28.529483][ C0] ? rcu_is_watching+0x16/0xd0 [ 28.529486][ C0] ? lock_acquire+0x13c/0x160 [ 28.529489][ C0] ? console_flush_one_record+0x111/0x710 [ 28.529491][ C0] console_flush_one_record+0x46f/0x710 [ 28.529495][ C0] ? console_emit_next_record+0x4c0/0x4c0 [ 28.529499][ C0] console_unlock+0xee/0x1f0 [ 28.529501][ C0] ? lock_acquire+0x13c/0x160 [ 28.529503][ C0] ? console_flush_one_record+0x710/0x710 [ 28.529506][ C0] ? rcu_is_watching+0x16/0xd0 [ 28.529508][ C0] ? lock_release+0x184/0x1f0 [ 28.529510][ C0] ? lock_acquire+0x60/0x160 [ 28.529513][ C0] ? __down_trylock_console_sem+0x5e/0xa0 [ 28.529515][ C0] ? vprintk_emit+0x320/0x3e0 [ 28.529518][ C0] vprintk_emit+0x37c/0x3e0 [ 28.529521][ C0] ? wake_up_klogd_work_func+0x90/0x90 [ 28.529524][ C0] ? rcu_is_watching+0x16/0xd0 [ 28.529526][ C0] ? lock_release+0x184/0x1f0 [ 28.529529][ C0] ? x86_64_start_kernel+0xe0/0x130 [ 28.529534][ C0] _printk+0xc7/0x100 [ 28.529538][ C0] ? snapshot_read.cold+0x21/0x21 [ 28.529540][ C0] ? arch_stack_walk+0xd7/0x130 [ 28.529546][ C0] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 28.529549][ C0] ? nbcon_cpu_emergency_enter+0x28/0x80 [ 28.529551][ C0] print_irq_inversion_bug.part.0+0x32/0xc0 [ 28.529555][ C0] mark_lock_irq+0x989/0x9c0 [ 28.529560][ C0] mark_lock+0x1d7/0xa00 [ 28.529562][ C0] mark_usage+0x42/0x170 [ 28.529565][ C0] __lock_acquire+0x388/0xc20 [ 28.529568][ C0] lock_acquire.part.0+0xd4/0x280 [ 28.529571][ C0] ? br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 28.529588][ C0] ? rcu_is_watching+0x16/0xd0 [ 28.529591][ C0] ? lock_acquire+0x13c/0x160 [ 28.529593][ C0] ? br_message_age_timer_expired+0x70/0x70 [bridge] [ 28.529604][ C0] _raw_spin_lock+0x33/0x40 [ 28.529607][ C0] ? br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 28.529618][ C0] br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 28.529629][ C0] ? br_message_age_timer_expired+0x70/0x70 [bridge] [ 28.529640][ C0] call_timer_fn+0x160/0x4d0 [ 28.529649][ C0] ? detach_if_pending+0x1d0/0x1d0 [ 28.529652][ C0] ? debug_object_active_state+0x430/0x430 [ 28.529656][ C0] ? find_held_lock+0x2b/0x80 [ 28.529659][ C0] ? __lock_release.isra.0+0x69/0x1a0 [ 28.529661][ C0] ? rcu_is_watching+0x16/0xd0 [ 28.529664][ C0] __run_timers+0x68f/0xaa0 [ 28.529667][ C0] ? br_message_age_timer_expired+0x70/0x70 [bridge] [ 28.529679][ C0] ? __bpf_trace_itimer_expire+0x10/0x10 [ 28.529681][ C0] ? __lock_acquire+0x518/0xc20 [ 28.529685][ C0] ? __rwlock_init+0x150/0x150 [ 28.529689][ C0] run_timer_softirq+0xf0/0x160 [ 28.529692][ C0] ? __run_timers+0xaa0/0xaa0 [ 28.529694][ C0] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 28.529698][ C0] ? rcu_is_watching+0x16/0xd0 [ 28.529700][ C0] handle_softirqs+0x1d3/0x900 [ 28.529703][ C0] ? __lock_release.isra.0+0x69/0x1a0 [ 28.529705][ C0] ? _local_bh_enable+0xc0/0xc0 [ 28.529709][ C0] __irq_exit_rcu+0x145/0x1c0 [ 28.529711][ C0] irq_exit_rcu+0xe/0x30 [ 28.529713][ C0] sysvec_apic_timer_interrupt+0x9d/0xe0 [ 28.529717][ C0] [ 28.529718][ C0] [ 28.529719][ C0] ? lockdep_hardirqs_on_prepare.part.0+0x9a/0x160 [ 28.529721][ C0] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 28.529725][ C0] RIP: 0010:pv_native_safe_halt+0xf/0x10 [ 28.529729][ C0] 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 [ 28.529731][ C0] RSP: 0018:ffffffff85007cf8 EFLAGS: 00000296 [ 28.529735][ C0] RAX: 0000000000100523 RBX: ffffffff8501c600 RCX: ffffffff820f0307 [ 28.529737][ C0] RDX: ffffffff8501c600 RSI: ffffffff84e38b01 RDI: ffffffff8488d8e0 [ 28.529738][ C0] RBP: 0000000000000000 R08: 0000000000000000 R09: 0000000000000000 [ 28.529740][ C0] R10: 0000000000000000 R11: 0000000000000001 R12: 1ffffffff0a00fa2 [ 28.529741][ C0] R13: 0000000000000000 R14: dffffc0000000000 R15: 0000000000014770 [ 28.529744][ C0] ? cpuidle_idle_call.constprop.0+0x237/0x410 [ 28.529748][ C0] ? lockdep_hardirqs_on+0x91/0x130 [ 28.529750][ C0] default_idle+0x9/0x10 [ 28.529753][ C0] default_idle_call+0x6e/0xb0 [ 28.529755][ C0] cpuidle_idle_call.constprop.0+0x237/0x410 [ 28.529758][ C0] ? arch_cpu_idle_exit+0x40/0x40 [ 28.529760][ C0] ? mark_tsc_async_resets+0x30/0x30 [ 28.529763][ C0] ? rcu_is_watching+0x16/0xd0 [ 28.529766][ C0] do_idle+0xd8/0x190 [ 28.529769][ C0] cpu_startup_entry+0x53/0x70 [ 28.529771][ C0] rest_init+0x279/0x280 [ 28.529774][ C0] ? __cpuidle_text_end+0x3b/0x3b [ 28.529778][ C0] ? rest_init+0x280/0x280 [ 28.529780][ C0] ? acpi_hw_set_mode+0x4a0/0x4a0 [ 28.529785][ C0] ? cpus_read_unlock+0x4f/0xc0 [ 28.529788][ C0] ? acpi_enable+0x1e4/0x330 [ 28.529792][ C0] start_kernel+0x3af/0x3b0 [ 28.529795][ C0] x86_64_start_reservations+0x24/0x30 [ 28.529798][ C0] x86_64_start_kernel+0x12b/0x130 [ 28.529801][ C0] common_startup_64+0x13e/0x148 [ 28.529807][ C0] [ 28.563056][ C0] ======================================================== [ 28.563466][ C0] WARNING: possible irq lock inversion dependency detected [ 28.563890][ C0] 7.2.0-virtme #1 Tainted: G W [ 28.564167][ C0] -------------------------------------------------------- [ 28.564492][ C0] swapper/0/0 just changed the state of lock: [ 28.564848][ C0] ff1100000d4eae58 (&br->lock){+.-.}-{3:3}, at: br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 28.565318][ C0] but this lock took another, SOFTIRQ-unsafe lock in the past: [ 28.565642][ C0] (fs_reclaim){+.+.}-{0:0} [ 28.565653][ C0] [ 28.565653][ C0] [ 28.565653][ C0] and interrupts could create inverse lock ordering between them. [ 28.565653][ C0] [ 28.566630][ C0] [ 28.566630][ C0] other info that might help us debug this: [ 28.567043][ C0] Chain exists of: [ 28.567043][ C0] &br->lock --> console_owner --> fs_reclaim [ 28.567043][ C0] [ 28.567545][ C0] Possible interrupt unsafe locking scenario: [ 28.567545][ C0] [ 28.567964][ C0] CPU0 CPU1 [ 28.568179][ C0] ---- ---- [ 28.568479][ C0] lock(fs_reclaim); [ 28.568654][ C0] local_irq_disable(); [ 28.569017][ C0] lock(&br->lock); [ 28.569377][ C0] lock(console_owner); [ 28.569657][ C0] [ 28.569911][ C0] lock(&br->lock); [ 28.570086][ C0] [ 28.570086][ C0] *** DEADLOCK *** [ 28.570086][ C0] [ 28.570490][ C0] locks held by swapper/0/0: 1, last CPU#0: [ 28.570769][ C0] #0: ffa0000000007c90 ((&p->forward_delay_timer)){+.-.}-{0:0}, at: call_timer_fn+0x110/0x4d0 [ 28.571301][ C0] [ 28.571301][ C0] the shortest dependencies between 2nd lock and 1st lock: [ 28.571772][ C0] -> (fs_reclaim){+.+.}-{0:0} { [ 28.572083][ C0] HARDIRQ-ON-W at: [ 28.572257][ C0] __lock_acquire+0x388/0xc20 [ 28.572632][ C0] lock_acquire.part.0+0xd4/0x280 [ 28.572916][ C0] fs_reclaim_acquire+0xd5/0x120 [ 28.573285][ C0] __kmalloc_cache_noprof+0x6e/0x620 [ 28.573714][ C0] kthread_create_worker_on_node+0xea/0x210 [ 28.574050][ C0] workqueue_init+0x2a/0x680 [ 28.574418][ C0] kernel_init_freeable+0x2fe/0x630 [ 28.574835][ C0] kernel_init+0x21/0x150 [ 28.575112][ C0] ret_from_fork+0x474/0x6b0 [ 28.575478][ C0] ret_from_fork_asm+0x11/0x20 [ 28.575843][ C0] SOFTIRQ-ON-W at: [ 28.576016][ C0] __lock_acquire+0x388/0xc20 [ 28.576377][ C0] lock_acquire.part.0+0xd4/0x280 [ 28.576660][ C0] fs_reclaim_acquire+0xd5/0x120 [ 28.577018][ C0] __kmalloc_cache_noprof+0x6e/0x620 [ 28.577433][ C0] kthread_create_worker_on_node+0xea/0x210 [ 28.577770][ C0] workqueue_init+0x2a/0x680 [ 28.578128][ C0] kernel_init_freeable+0x2fe/0x630 [ 28.578541][ C0] kernel_init+0x21/0x150 [ 28.578827][ C0] ret_from_fork+0x474/0x6b0 [ 28.579186][ C0] ret_from_fork_asm+0x11/0x20 [ 28.579565][ C0] INITIAL USE at: [ 28.579738][ C0] __lock_acquire+0x388/0xc20 [ 28.586254][ C0] lock_acquire.part.0+0xd4/0x280 [ 28.586534][ C0] fs_reclaim_acquire+0xd5/0x120 [ 28.586896][ C0] __kmalloc_cache_noprof+0x6e/0x620 [ 28.587324][ C0] kthread_create_worker_on_node+0xea/0x210 [ 28.587755][ C0] workqueue_init+0x2a/0x680 [ 28.588039][ C0] kernel_init_freeable+0x2fe/0x630 [ 28.588406][ C0] kernel_init+0x21/0x150 [ 28.588685][ C0] ret_from_fork+0x474/0x6b0 [ 28.589047][ C0] ret_from_fork_asm+0x11/0x20 [ 28.589312][ C0] } [ 28.589421][ C0] ... key at: [] __fs_reclaim_map+0x0/0xbe0 [ 28.589836][ C0] ... acquired at: [ 28.590003][ C0] __lock_acquire+0x518/0xc20 [ 28.590307][ C0] lock_acquire.part.0+0xd4/0x280 [ 28.590528][ C0] fs_reclaim_acquire+0xd5/0x120 [ 28.590841][ C0] __kmalloc_noprof+0xd3/0x760 [ 28.591061][ C0] alloc_buf.isra.0+0x4b/0x260 [ 28.591279][ C0] put_chars+0x1e1/0x2f0 [ 28.591490][ C0] hvc_console_print+0x292/0x780 [ 28.591788][ C0] console_emit_next_record+0x22f/0x4c0 [ 28.592013][ C0] console_flush_one_record+0x46f/0x710 [ 28.592314][ C0] console_unlock+0xee/0x1f0 [ 28.592534][ C0] vprintk_emit+0x37c/0x3e0 [ 28.592839][ C0] dev_vprintk_emit+0x27f/0x2c0 [ 28.593064][ C0] dev_printk_emit+0xb9/0xee [ 28.593282][ C0] _dev_info+0xe2/0x116 [ 28.593445][ C0] __devm_rtc_register_device.cold+0xc3/0x3a8 [ 28.593805][ C0] cmos_do_probe+0x73b/0x98a [ 28.594029][ C0] platform_probe+0xfe/0x1f0 [ 28.594250][ C0] call_driver_probe+0x61/0x1c0 [ 28.594476][ C0] really_probe+0x199/0x760 [ 28.594786][ C0] __driver_probe_device+0x24f/0x440 [ 28.595008][ C0] driver_probe_device+0x4a/0xf0 [ 28.595310][ C0] __driver_attach+0x1b8/0x540 [ 28.595529][ C0] bus_for_each_dev+0x130/0x1e0 [ 28.595837][ C0] bus_add_driver+0x2c8/0x530 [ 28.596057][ C0] driver_register+0x1a3/0x390 [ 28.596281][ C0] __platform_driver_probe+0x13f/0x270 [ 28.596503][ C0] cmos_init+0x31/0x40 [ 28.596676][ C0] do_one_initcall+0x124/0x4f0 [ 28.596986][ C0] kernel_init_freeable+0x596/0x630 [ 28.597212][ C0] kernel_init+0x21/0x150 [ 28.597435][ C0] ret_from_fork+0x474/0x6b0 [ 28.597661][ C0] ret_from_fork_asm+0x11/0x20 [ 28.597968][ C0] [ 28.598091][ C0] -> (console_owner){....}-{0:0} { [ 28.598317][ C0] INITIAL USE at: [ 28.598485][ C0] } [ 28.598596][ C0] ... key at: [] console_owner_dep_map+0x0/0x60 [ 28.599013][ C0] ... acquired at: [ 28.599176][ C0] __lock_acquire+0x518/0xc20 [ 28.599482][ C0] lock_acquire.part.0+0xd4/0x280 [ 28.599712][ C0] console_lock_spinning_enable+0x5c/0x60 [ 28.600071][ C0] console_emit_next_record+0x1d1/0x4c0 [ 28.600373][ C0] console_flush_one_record+0x46f/0x710 [ 28.600588][ C0] console_unlock+0xee/0x1f0 [ 28.600891][ C0] vprintk_emit+0x37c/0x3e0 [ 28.601115][ C0] _printk+0xc7/0x100 [ 28.601277][ C0] br_set_state+0x22f/0x430 [bridge] [ 28.601591][ C0] br_init_port+0xc4/0x200 [bridge] [ 28.601824][ C0] br_stp_enable_port+0x12/0x50 [bridge] [ 28.602195][ C0] br_add_if+0xde2/0x1320 [bridge] [ 28.602506][ C0] do_set_master+0x357/0x580 [ 28.602732][ C0] do_setlink.isra.0+0xa31/0x2750 [ 28.603037][ C0] rtnl_newlink+0x9f1/0x11c0 [ 28.603265][ C0] rtnetlink_rcv_msg+0x6fd/0xbd0 [ 28.603574][ C0] netlink_rcv_skb+0x14e/0x3a0 [ 28.603798][ C0] netlink_unicast+0x486/0x750 [ 28.604093][ C0] netlink_sendmsg+0x735/0xc60 [ 28.604311][ C0] ____sys_sendmsg+0x415/0x880 [ 28.604607][ C0] ___sys_sendmsg+0x14e/0x1d0 [ 28.604836][ C0] __sys_sendmsg+0x12c/0x1d0 [ 28.605139][ C0] do_syscall_64+0xff/0x530 [ 28.605359][ C0] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 28.605723][ C0] [ 28.605831][ C0] -> (&br->lock){+.-.}-{3:3} { [ 28.606059][ C0] HARDIRQ-ON-W at: [ 28.606312][ C0] __lock_acquire+0x388/0xc20 [ 28.606591][ C0] lock_acquire.part.0+0xd4/0x280 [ 28.606956][ C0] _raw_spin_lock_bh+0x38/0x50 [ 28.607315][ C0] recalculate_group_addr+0x51/0x120 [bridge] [ 28.607668][ C0] br_vlan_filter_toggle+0x85/0x110 [bridge] [ 28.608086][ C0] br_changelink+0x575/0x16e0 [bridge] [ 28.608372][ C0] br_dev_newlink+0xeb/0x160 [bridge] [ 28.608660][ C0] rtnl_newlink_create+0x2d0/0x750 [ 28.609026][ C0] __rtnl_newlink+0x22b/0xa50 [ 28.609306][ C0] rtnl_newlink+0x9f1/0x11c0 [ 28.609582][ C0] rtnetlink_rcv_msg+0x6fd/0xbd0 [ 28.609947][ C0] netlink_rcv_skb+0x14e/0x3a0 [ 28.610307][ C0] netlink_unicast+0x486/0x750 [ 28.610589][ C0] netlink_sendmsg+0x735/0xc60 [ 28.610955][ C0] ____sys_sendmsg+0x415/0x880 [ 28.611230][ C0] ___sys_sendmsg+0x14e/0x1d0 [ 28.611514][ C0] __sys_sendmsg+0x12c/0x1d0 [ 28.611882][ C0] do_syscall_64+0xff/0x530 [ 28.612156][ C0] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 28.612488][ C0] IN-SOFTIRQ-W at: [ 28.612661][ C0] __lock_acquire+0x388/0xc20 [ 28.613026][ C0] lock_acquire.part.0+0xd4/0x280 [ 28.613298][ C0] _raw_spin_lock+0x33/0x40 [ 28.613574][ C0] br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 28.614005][ C0] call_timer_fn+0x160/0x4d0 [ 28.614370][ C0] __run_timers+0x68f/0xaa0 [ 28.614651][ C0] run_timer_softirq+0xf0/0x160 [ 28.615015][ C0] handle_softirqs+0x1d3/0x900 [ 28.615289][ C0] __irq_exit_rcu+0x145/0x1c0 [ 28.615564][ C0] irq_exit_rcu+0xe/0x30 [ 28.615925][ C0] sysvec_apic_timer_interrupt+0x9d/0xe0 [ 28.616255][ C0] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 28.616597][ C0] pv_native_safe_halt+0xf/0x10 [ 28.616966][ C0] default_idle+0x9/0x10 [ 28.617317][ C0] default_idle_call+0x6e/0xb0 [ 28.617597][ C0] cpuidle_idle_call.constprop.0+0x237/0x410 [ 28.618017][ C0] do_idle+0xd8/0x190 [ 28.618234][ C0] cpu_startup_entry+0x53/0x70 [ 28.618522][ C0] rest_init+0x279/0x280 [ 28.618884][ C0] start_kernel+0x3af/0x3b0 [ 28.619154][ C0] x86_64_start_reservations+0x24/0x30 [ 28.619416][ C0] x86_64_start_kernel+0x12b/0x130 [ 28.619739][ C0] common_startup_64+0x13e/0x148 [ 28.620005][ C0] INITIAL USE at: [ 28.620260][ C0] __lock_acquire+0x388/0xc20 [ 28.620537][ C0] lock_acquire.part.0+0xd4/0x280 [ 28.620908][ C0] _raw_spin_lock_bh+0x38/0x50 [ 28.621184][ C0] recalculate_group_addr+0x51/0x120 [bridge] [ 28.621531][ C0] br_vlan_filter_toggle+0x85/0x110 [bridge] [ 28.621966][ C0] br_changelink+0x575/0x16e0 [bridge] [ 28.622252][ C0] br_dev_newlink+0xeb/0x160 [bridge] [ 28.622534][ C0] rtnl_newlink_create+0x2d0/0x750 [ 28.622898][ C0] __rtnl_newlink+0x22b/0xa50 [ 28.623174][ C0] rtnl_newlink+0x9f1/0x11c0 [ 28.623530][ C0] rtnetlink_rcv_msg+0x6fd/0xbd0 [ 28.623900][ C0] netlink_rcv_skb+0x14e/0x3a0 [ 28.624176][ C0] netlink_unicast+0x486/0x750 [ 28.624452][ C0] netlink_sendmsg+0x735/0xc60 [ 28.624823][ C0] ____sys_sendmsg+0x415/0x880 [ 28.625097][ C0] ___sys_sendmsg+0x14e/0x1d0 [ 28.625375][ C0] __sys_sendmsg+0x12c/0x1d0 [ 28.625665][ C0] do_syscall_64+0xff/0x530 [ 28.626026][ C0] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 28.626354][ C0] } [ 28.626470][ C0] ... key at: [] __key.7+0x0/0x40 [bridge] [ 28.626897][ C0] ... acquired at: [ 28.627064][ C0] mark_lock+0x1d7/0xa00 [ 28.627376][ C0] mark_usage+0x42/0x170 [ 28.627600][ C0] __lock_acquire+0x388/0xc20 [ 28.627910][ C0] lock_acquire.part.0+0xd4/0x280 [ 28.628133][ C0] _raw_spin_lock+0x33/0x40 [ 28.628437][ C0] br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 28.628732][ C0] call_timer_fn+0x160/0x4d0 [ 28.629035][ C0] __run_timers+0x68f/0xaa0 [ 28.629255][ C0] run_timer_softirq+0xf0/0x160 [ 28.629562][ C0] handle_softirqs+0x1d3/0x900 [ 28.629791][ C0] __irq_exit_rcu+0x145/0x1c0 [ 28.630094][ C0] irq_exit_rcu+0xe/0x30 [ 28.630313][ C0] sysvec_apic_timer_interrupt+0x9d/0xe0 [ 28.630667][ C0] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 28.631025][ C0] pv_native_safe_halt+0xf/0x10 [ 28.631246][ C0] default_idle+0x9/0x10 [ 28.631551][ C0] default_idle_call+0x6e/0xb0 [ 28.631779][ C0] cpuidle_idle_call.constprop.0+0x237/0x410 [ 28.632134][ C0] do_idle+0xd8/0x190 [ 28.632302][ C0] cpu_startup_entry+0x53/0x70 [ 28.632608][ C0] rest_init+0x279/0x280 [ 28.632833][ C0] start_kernel+0x3af/0x3b0 [ 28.633131][ C0] x86_64_start_reservations+0x24/0x30 [ 28.633350][ C0] x86_64_start_kernel+0x12b/0x130 [ 28.633656][ C0] common_startup_64+0x13e/0x148 [ 28.633872][ C0] [ 28.633979][ C0] [ 28.633979][ C0] stack backtrace: [ 28.634335][ C0] CPU: 0 UID: 0 PID: 0 Comm: swapper/0 Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 28.634340][ C0] Tainted: [W]=WARN [ 28.634341][ C0] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 28.634343][ C0] Call Trace: [ 28.634345][ C0] [ 28.634347][ C0] dump_stack_lvl+0x6f/0xa0 [ 28.634353][ C0] print_irq_inversion_bug.part.0.cold+0xe6/0x143 [ 28.634358][ C0] mark_lock_irq+0x989/0x9c0 [ 28.634363][ C0] mark_lock+0x1d7/0xa00 [ 28.634366][ C0] mark_usage+0x42/0x170 [ 28.634368][ C0] __lock_acquire+0x388/0xc20 [ 28.634372][ C0] lock_acquire.part.0+0xd4/0x280 [ 28.634374][ C0] ? br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 28.634389][ C0] ? rcu_is_watching+0x16/0xd0 [ 28.634393][ C0] ? lock_acquire+0x13c/0x160 [ 28.634396][ C0] ? br_message_age_timer_expired+0x70/0x70 [bridge] [ 28.634407][ C0] _raw_spin_lock+0x33/0x40 [ 28.634409][ C0] ? br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 28.634420][ C0] br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 28.634431][ C0] ? br_message_age_timer_expired+0x70/0x70 [bridge] [ 28.634442][ C0] call_timer_fn+0x160/0x4d0 [ 28.634445][ C0] ? detach_if_pending+0x1d0/0x1d0 [ 28.634448][ C0] ? debug_object_active_state+0x430/0x430 [ 28.634452][ C0] ? find_held_lock+0x2b/0x80 [ 28.634455][ C0] ? __lock_release.isra.0+0x69/0x1a0 [ 28.634458][ C0] ? rcu_is_watching+0x16/0xd0 [ 28.634462][ C0] __run_timers+0x68f/0xaa0 [ 28.634464][ C0] ? br_message_age_timer_expired+0x70/0x70 [bridge] [ 28.634476][ C0] ? __bpf_trace_itimer_expire+0x10/0x10 [ 28.634478][ C0] ? __lock_acquire+0x518/0xc20 [ 28.634482][ C0] ? __rwlock_init+0x150/0x150 [ 28.634486][ C0] run_timer_softirq+0xf0/0x160 [ 28.634489][ C0] ? __run_timers+0xaa0/0xaa0 [ 28.634492][ C0] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 28.634495][ C0] ? rcu_is_watching+0x16/0xd0 [ 28.634497][ C0] handle_softirqs+0x1d3/0x900 [ 28.634501][ C0] ? __lock_release.isra.0+0x69/0x1a0 [ 28.634503][ C0] ? _local_bh_enable+0xc0/0xc0 [ 28.634507][ C0] __irq_exit_rcu+0x145/0x1c0 [ 28.634509][ C0] irq_exit_rcu+0xe/0x30 [ 28.634511][ C0] sysvec_apic_timer_interrupt+0x9d/0xe0 [ 28.634514][ C0] [ 28.634514][ C0] [ 28.634515][ C0] ? lockdep_hardirqs_on_prepare.part.0+0x9a/0x160 [ 28.634518][ C0] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 28.634521][ C0] RIP: 0010:pv_native_safe_halt+0xf/0x10 [ 28.634524][ C0] 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 [ 28.634526][ C0] RSP: 0018:ffffffff85007cf8 EFLAGS: 00000296 [ 28.634530][ C0] RAX: 0000000000100523 RBX: ffffffff8501c600 RCX: ffffffff820f0307 [ 28.634532][ C0] RDX: ffffffff8501c600 RSI: ffffffff84e38b01 RDI: ffffffff8488d8e0 [ 28.634533][ C0] RBP: 0000000000000000 R08: 0000000000000000 R09: 0000000000000000 [ 28.634535][ C0] R10: 0000000000000000 R11: 0000000000000001 R12: 1ffffffff0a00fa2 [ 28.634536][ C0] R13: 0000000000000000 R14: dffffc0000000000 R15: 0000000000014770 [ 28.634538][ C0] ? cpuidle_idle_call.constprop.0+0x237/0x410 [ 28.634542][ C0] ? lockdep_hardirqs_on+0x91/0x130 [ 28.634544][ C0] default_idle+0x9/0x10 [ 28.634546][ C0] default_idle_call+0x6e/0xb0 [ 28.634549][ C0] cpuidle_idle_call.constprop.0+0x237/0x410 [ 28.634551][ C0] ? arch_cpu_idle_exit+0x40/0x40 [ 28.634554][ C0] ? mark_tsc_async_resets+0x30/0x30 [ 28.634557][ C0] ? rcu_is_watching+0x16/0xd0 [ 28.634560][ C0] do_idle+0xd8/0x190 [ 28.634562][ C0] cpu_startup_entry+0x53/0x70 [ 28.634565][ C0] rest_init+0x279/0x280 [ 28.634568][ C0] ? __cpuidle_text_end+0x3b/0x3b [ 28.634572][ C0] ? rest_init+0x280/0x280 [ 28.634574][ C0] ? acpi_hw_set_mode+0x4a0/0x4a0 [ 28.634579][ C0] ? cpus_read_unlock+0x4f/0xc0 [ 28.634583][ C0] ? acpi_enable+0x1e4/0x330 [ 28.634587][ C0] start_kernel+0x3af/0x3b0 [ 28.634589][ C0] x86_64_start_reservations+0x24/0x30 [ 28.634592][ C0] x86_64_start_kernel+0x12b/0x130 [ 28.634595][ C0] common_startup_64+0x13e/0x148 [ 28.634600][ C0] [ 30.118481][ T12] vx20: left allmulticast mode [ 30.118500][ T12] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 30.118502][ T12] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 12, name: kworker/u16:0 [ 30.118504][ T12] preempt_count: 1, expected: 0 [ 30.118505][ T12] RCU nest depth: 0, expected: 0 [ 30.118506][ T12] INFO: lockdep is turned off. [ 30.118508][ T12] irq event stamp: 33734 [ 30.118508][ T12] hardirqs last enabled at (33733): [] _raw_spin_unlock_irq+0x28/0x50 [ 30.118517][ T12] hardirqs last disabled at (33734): [] __schedule+0x1246/0x20e0 [ 30.118519][ T12] softirqs last enabled at (33730): [] __fib6_clean_all+0xff/0x290 [ 30.118523][ T12] softirqs last disabled at (33724): [] __fib6_clean_all+0xd9/0x290 [ 30.118525][ T12] Preemption disabled at: [ 30.118526][ T12] [] vprintk_emit+0x31b/0x3e0 [ 30.118534][ T12] CPU: 1 UID: 0 PID: 12 Comm: kworker/u16:0 Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 30.118537][ T12] Tainted: [W]=WARN [ 30.118538][ T12] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 30.118540][ T12] Workqueue: netns cleanup_net [ 30.118546][ T12] Call Trace: [ 30.118548][ T12] [ 30.118549][ T12] dump_stack_lvl+0x6f/0xa0 [ 30.118554][ T12] ? vprintk_emit+0x31b/0x3e0 [ 30.118556][ T12] __might_resched.cold+0x1fe/0x2c1 [ 30.118560][ T12] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 30.118563][ T12] ? rcu_is_watching+0x16/0xd0 [ 30.118567][ T12] __kmalloc_noprof+0x443/0x760 [ 30.118571][ T12] ? __rwlock_init+0x150/0x150 [ 30.118574][ T12] ? alloc_buf.isra.0+0x4b/0x260 [ 30.118577][ T12] ? do_raw_spin_unlock+0x59/0x250 [ 30.118579][ T12] alloc_buf.isra.0+0x4b/0x260 [ 30.118581][ T12] put_chars+0x1e1/0x2f0 [ 30.118583][ T12] ? desc_read_finalized_seq+0x79/0x120 [ 30.118585][ T12] ? __send_to_port+0x420/0x420 [ 30.118587][ T12] ? console_prepend_replay+0x20/0x20 [ 30.118589][ T12] hvc_console_print+0x292/0x780 [ 30.118593][ T12] ? hvc_write+0x3a0/0x3a0 [ 30.118594][ T12] ? do_raw_spin_lock+0x131/0x280 [ 30.118595][ T12] ? __rwlock_init+0x150/0x150 [ 30.118597][ T12] ? rcu_is_watching+0x16/0xd0 [ 30.118598][ T12] ? rcu_is_watching+0x16/0xd0 [ 30.118600][ T12] ? lock_acquire+0x13c/0x160 [ 30.118602][ T12] console_emit_next_record+0x22f/0x4c0 [ 30.118605][ T12] ? devkmsg_read+0x4b0/0x4b0 [ 30.118607][ T12] ? rcu_is_watching+0x16/0xd0 [ 30.118609][ T12] ? rcu_is_watching+0x16/0xd0 [ 30.118610][ T12] ? rcu_is_watching+0x16/0xd0 [ 30.118612][ T12] ? lock_acquire+0x13c/0x160 [ 30.118614][ T12] ? console_flush_one_record+0x111/0x710 [ 30.118615][ T12] console_flush_one_record+0x46f/0x710 [ 30.118618][ T12] ? console_emit_next_record+0x4c0/0x4c0 [ 30.118620][ T12] console_unlock+0xee/0x1f0 [ 30.118622][ T12] ? lock_acquire+0x13c/0x160 [ 30.118624][ T12] ? console_flush_one_record+0x710/0x710 [ 30.118625][ T12] ? rcu_is_watching+0x16/0xd0 [ 30.118627][ T12] ? lock_release+0x184/0x1f0 [ 30.118628][ T12] ? lock_acquire+0x60/0x160 [ 30.118630][ T12] ? __rcu_read_lock+0x30/0x70 [ 30.118632][ T12] ? __down_trylock_console_sem+0x5e/0xa0 [ 30.118634][ T12] ? vprintk_emit+0x320/0x3e0 [ 30.118636][ T12] vprintk_emit+0x37c/0x3e0 [ 30.118638][ T12] ? wake_up_klogd_work_func+0x90/0x90 [ 30.118640][ T12] ? process_one_work+0xe3e/0x1560 [ 30.118642][ T12] ? kthread+0x367/0x460 [ 30.118644][ T12] ? ret_from_fork+0x474/0x6b0 [ 30.118647][ T12] ? ret_from_fork_asm+0x11/0x20 [ 30.118649][ T12] _printk+0xc7/0x100 [ 30.118660][ T12] ? snapshot_read.cold+0x21/0x21 [ 30.118663][ T12] ? netdev_name+0x43/0x60 [ 30.118665][ T12] ? __netdev_printk+0x17f/0x1d0 [ 30.118667][ T12] netdev_info+0xe2/0x116 [ 30.118669][ T12] ? netdev_notice+0x120/0x120 [ 30.118671][ T12] ? rcu_is_watching+0x16/0xd0 [ 30.118673][ T12] ? __up_read+0x355/0x9e0 [ 30.118674][ T12] ? trace_hardirqs_on+0x36/0x40 [ 30.118677][ T12] ? down_write_nested+0x200/0x200 [ 30.118678][ T12] ? mutex_is_locked+0x1c/0x50 [ 30.118681][ T12] netif_set_allmulti.cold+0x7c/0x166 [ 30.118684][ T12] dev_set_allmulti+0xa2/0x150 [ 30.118687][ T12] del_nbp+0xb7/0xc10 [bridge] [ 30.118700][ T12] br_dev_delete+0x9d/0x1e0 [bridge] [ 30.118708][ T12] br_net_exit_rtnl+0xb8/0x110 [bridge] [ 30.118715][ T12] ops_undo_list+0x5be/0x8f0 [ 30.118717][ T12] ? rtnl_net_dumpid_one+0x2d0/0x2d0 [ 30.118719][ T12] ? idr_destroy+0x121/0x250 [ 30.118722][ T12] cleanup_net+0x431/0x890 [ 30.118724][ T12] ? net_passive_dec+0x230/0x230 [ 30.118726][ T12] ? update_load_avg+0x141/0xf00 [ 30.118728][ T12] ? lock_acquire+0x13c/0x160 [ 30.118730][ T12] ? rcu_is_watching+0x16/0xd0 [ 30.118732][ T12] process_one_work+0xe3e/0x1560 [ 30.118735][ T12] ? __queue_delayed_work+0x470/0x470 [ 30.118737][ T12] ? find_held_lock+0x2b/0x80 [ 30.118739][ T12] ? __rwlock_init+0x150/0x150 [ 30.118741][ T12] worker_thread+0x4f1/0xd60 [ 30.118744][ T12] ? rescuer_thread+0x1340/0x1340 [ 30.118746][ T12] kthread+0x367/0x460 [ 30.118747][ T12] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 30.118748][ T12] ? kthread_affine_preferred+0x4c0/0x4c0 [ 30.118750][ T12] ret_from_fork+0x474/0x6b0 [ 30.118752][ T12] ? arch_exit_to_user_mode_prepare.isra.0+0x120/0x120 [ 30.118753][ T12] ? __switch_to+0x5a3/0xe00 [ 30.118756][ T12] ? kthread_affine_preferred+0x4c0/0x4c0 [ 30.118758][ T12] ret_from_fork_asm+0x11/0x20 [ 30.118761][ T12] [ 30.137960][ T12] vx20: left promiscuous mode [ 30.138351][ T12] br2: port 3(vx20) entered disabled state [ 30.140120][ T12] vx10: left allmulticast mode [ 30.141480][ T12] vx10: left promiscuous mode [ 30.141859][ T12] br2: port 2(vx10) entered disabled state [ 30.143817][ T12] w1: left allmulticast mode [ 30.144028][ T12] w1: left promiscuous mode [ 30.144466][ T12] br2: port 1(w1) entered disabled state [ 30.224405][ T12] vx20: left allmulticast mode [ 30.224632][ T12] vx20: left promiscuous mode [ 30.224933][ T12] br2: port 3(vx20) entered disabled state [ 30.227019][ T12] vx10: left allmulticast mode [ 30.228139][ T12] vx10: left promiscuous mode [ 30.228406][ T12] br2: port 2(vx10) entered disabled state [ 30.229507][ T12] w1: left allmulticast mode [ 30.229700][ T12] w1: left promiscuous mode [ 30.230369][ T12] br2: port 1(w1) entered disabled state [ 30.725862][ T564] br1: port 4(veth2) entered disabled state [ 30.745544][ T565] veth2: left allmulticast mode [ 30.745730][ T565] veth2: left promiscuous mode [ 30.745941][ T565] br1: port 4(veth2) entered disabled state [ 30.806198][ T568] br1: port 3(veth1) entered disabled state [ 30.826318][ T569] veth1: left allmulticast mode [ 30.826493][ T569] veth1: left promiscuous mode [ 30.826704][ T569] br1: port 3(veth1) entered disabled state [ 30.863078][ T571] vx20: left allmulticast mode [ 30.863895][ T571] vx20: left promiscuous mode [ 30.864108][ T571] br1: port 2(vx20) entered disabled state [ 30.953139][ T575] vx10: left allmulticast mode [ 30.953323][ T575] vx10: left promiscuous mode [ 30.953541][ T575] br1: port 1(vx10) entered disabled state