[ 10.790048][ T224] 8021q: 802.1Q VLAN Support v1.8 [ 10.790068][ T224] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 10.790070][ T224] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 224, name: modprobe [ 10.790072][ T224] preempt_count: 1, expected: 0 [ 10.790073][ T224] RCU nest depth: 0, expected: 0 [ 10.790074][ T224] locks held by modprobe/224: 4, last CPU#0: [ 10.790077][ T224] #0: ffffffffa6b69cc0 (console_lock){+.+.}-{0:0}, at: vprintk_emit+0x320/0x3e0 [ 10.790089][ T224] #1: ffffffffa6b69d38 (console_srcu){....}-{0:0}, at: console_flush_one_record+0x106/0x710 [ 10.790093][ T224] #2: ffffffffa6a89660 (console_owner){....}-{0:0}, at: console_lock_spinning_enable+0x40/0x60 [ 10.790098][ T224] #3: ffffffffa6a89560 (printk_legacy_map-wait-type-override){....}-{3:3}, at: console_emit_next_record+0x1df/0x4c0 [ 10.790102][ T224] irq event stamp: 29410 [ 10.790103][ T224] hardirqs last enabled at (29409): [] __down_trylock_console_sem+0x86/0xa0 [ 10.790105][ T224] hardirqs last disabled at (29410): [] console_emit_next_record+0x3d4/0x4c0 [ 10.790107][ T224] softirqs last enabled at (27084): [] handle_softirqs+0x67c/0x900 [ 10.790110][ T224] softirqs last disabled at (27077): [] __irq_exit_rcu+0x145/0x1c0 [ 10.790112][ T224] Preemption disabled at: [ 10.790113][ T224] [] vprintk_emit+0x31b/0x3e0 [ 10.790119][ T224] CPU: 0 UID: 0 PID: 224 Comm: modprobe Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 10.790122][ T224] Tainted: [W]=WARN [ 10.790123][ T224] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 10.790125][ T224] Call Trace: [ 10.790126][ T224] [ 10.790128][ T224] dump_stack_lvl+0x6f/0xa0 [ 10.790133][ T224] ? vprintk_emit+0x31b/0x3e0 [ 10.790136][ T224] __might_resched.cold+0x1fe/0x2c1 [ 10.790140][ T224] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 10.790144][ T224] ? __kmalloc_noprof+0xdb/0x760 [ 10.790150][ T224] __kmalloc_noprof+0x443/0x760 [ 10.790152][ T224] ? alloc_buf.isra.0+0x4b/0x260 [ 10.790159][ T224] ? do_raw_spin_unlock+0x59/0x250 [ 10.790162][ T224] alloc_buf.isra.0+0x4b/0x260 [ 10.790167][ T224] put_chars+0x1e1/0x2f0 [ 10.790171][ T224] ? __send_to_port+0x420/0x420 [ 10.790172][ T224] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 10.790177][ T224] ? rcu_read_lock_any_held+0x3c/0x90 [ 10.790180][ T224] ? validate_chain+0x38b/0xc20 [ 10.790184][ T224] hvc_console_print+0x292/0x780 [ 10.790187][ T224] ? __lock_acquire+0x518/0xc20 [ 10.790192][ T224] ? hvc_write+0x3a0/0x3a0 [ 10.790194][ T224] ? rcu_is_watching+0x16/0xd0 [ 10.790199][ T224] console_emit_next_record+0x22f/0x4c0 [ 10.790203][ T224] ? devkmsg_read+0x4b0/0x4b0 [ 10.790205][ T224] ? console_flush_one_record+0x106/0x710 [ 10.790208][ T224] ? rcu_is_watching+0x16/0xd0 [ 10.790210][ T224] ? lock_acquire+0x13c/0x160 [ 10.790214][ T224] console_flush_one_record+0x46f/0x710 [ 10.790218][ T224] ? console_emit_next_record+0x4c0/0x4c0 [ 10.790220][ T224] ? __lock_acquire+0x518/0xc20 [ 10.790225][ T224] console_unlock+0xee/0x1f0 [ 10.790228][ T224] ? console_flush_one_record+0x710/0x710 [ 10.790230][ T224] ? rcu_is_watching+0x16/0xd0 [ 10.790232][ T224] ? lock_acquire+0x60/0x160 [ 10.790236][ T224] ? __down_trylock_console_sem+0x5e/0xa0 [ 10.790238][ T224] ? vprintk_emit+0x320/0x3e0 [ 10.790241][ T224] vprintk_emit+0x37c/0x3e0 [ 10.790245][ T224] ? wake_up_klogd_work_func+0x90/0x90 [ 10.790250][ T224] ? vlan_netlink_fini+0x960/0x960 [8021q] [ 10.790255][ T224] _printk+0xc7/0x100 [ 10.790258][ T224] ? snapshot_read.cold+0x21/0x21 [ 10.790265][ T224] ? do_one_initcall+0x113/0x4f0 [ 10.790268][ T224] vlan_proto_init+0x24/0x90 [8021q] [ 10.790271][ T224] do_one_initcall+0x124/0x4f0 [ 10.790274][ T224] ? trace_event_raw_event_initcall_level+0x280/0x280 [ 10.790278][ T224] ? do_init_module+0xae/0x8a0 [ 10.790281][ T224] ? kasan_unpoison+0x44/0x70 [ 10.790286][ T224] do_init_module+0x2ad/0x8a0 [ 10.790290][ T224] ? lockdep_hardirqs_on+0x91/0x130 [ 10.790296][ T224] ? free_module+0x470/0x470 [ 10.790300][ T224] ? kfree+0x123/0x590 [ 10.790305][ T224] load_module+0x1424/0x1bb0 [ 10.790312][ T224] ? layout_and_allocate.isra.0+0x680/0x680 [ 10.790316][ T224] ? __ia32_sys_fsconfig+0x180/0x180 [ 10.790319][ T224] ? find_held_lock+0x2b/0x80 [ 10.790322][ T224] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 10.790326][ T224] init_module_from_file+0x11f/0x1a0 [ 10.790329][ T224] ? __do_sys_init_module+0x220/0x220 [ 10.790337][ T224] ? __rwlock_init+0x150/0x150 [ 10.790341][ T224] ? do_raw_spin_unlock+0x59/0x250 [ 10.790344][ T224] idempotent_init_module+0x37b/0x7c0 [ 10.790348][ T224] ? init_module_from_file+0x1a0/0x1a0 [ 10.790354][ T224] ? rcu_is_watching+0x16/0xd0 [ 10.790356][ T224] ? cap_capable+0x1d7/0x3d0 [ 10.790362][ T224] __x64_sys_finit_module+0xdf/0x190 [ 10.790365][ T224] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 10.790368][ T224] do_syscall_64+0xff/0x530 [ 10.790370][ T224] ? exc_page_fault+0xee/0x100 [ 10.790373][ T224] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 10.790375][ T224] RIP: 0033:0x7fb7b074937d [ 10.790378][ T224] 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 [ 10.790380][ T224] RSP: 002b:00007ffd95de7368 EFLAGS: 00000246 ORIG_RAX: 0000000000000139 [ 10.790383][ T224] RAX: ffffffffffffffda RBX: 0000555eac3cc810 RCX: 00007fb7b074937d [ 10.790384][ T224] RDX: 0000000000000000 RSI: 0000555e987e4ffd RDI: 0000000000000000 [ 10.790385][ T224] RBP: 00007ffd95de7400 R08: 0000000000000000 R09: 0000000000000000 [ 10.790386][ T224] R10: 0000000000000000 R11: 0000000000000246 R12: 0000555e987e4ffd [ 10.790387][ T224] R13: 0000555eac3cc960 R14: 0000000000040000 R15: 0000000000000000 [ 10.790394][ T224] [ 11.565658][ T252] br1: port 1(veth1) entered blocking state [ 11.566915][ T252] br1: port 1(veth1) entered disabled state [ 11.567432][ T252] veth1: entered allmulticast mode [ 11.570248][ T252] veth1: entered promiscuous mode [ 11.617501][ T38] br1: port 1(veth1) entered blocking state [ 11.617965][ T38] br1: port 1(veth1) entered forwarding state [ 26.252555][ T398] br1: port 1(veth1) entered disabled state [ 26.252613][ T398] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 26.252615][ T398] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 398, name: ip [ 26.252617][ T398] preempt_count: 202, expected: 0 [ 26.252618][ T398] RCU nest depth: 0, expected: 0 [ 26.252619][ T398] locks held by ip/398: 6, last CPU#2: [ 26.252622][ T398] #0: ffffffffa72d2c40 (rtnl_mutex){+.+.}-{4:4}, at: rtnl_newlink+0x9a8/0x11c0 [ 26.252634][ T398] #1: ff1100000cb3ae58 (&br->lock){+...}-{3:3}, at: br_device_event+0x1d7/0x8f0 [bridge] [ 26.252650][ T398] #2: ffffffffa6b69cc0 (console_lock){+.+.}-{0:0}, at: vprintk_emit+0x320/0x3e0 [ 26.252661][ T398] #3: ffffffffa6b69d38 (console_srcu){....}-{0:0}, at: console_flush_one_record+0x106/0x710 [ 26.252664][ T398] #4: ffffffffa6a89660 (console_owner){....}-{0:0}, at: console_lock_spinning_enable+0x40/0x60 [ 26.252668][ T398] #5: ffffffffa6a89560 (printk_legacy_map-wait-type-override){....}-{3:3}, at: console_emit_next_record+0x1df/0x4c0 [ 26.252672][ T398] irq event stamp: 19009 [ 26.252673][ T398] hardirqs last enabled at (19008): [] __down_trylock_console_sem+0x86/0xa0 [ 26.252676][ T398] hardirqs last disabled at (19009): [] console_emit_next_record+0x3d4/0x4c0 [ 26.252678][ T398] softirqs last enabled at (18992): [] ipv6_mc_down+0x134/0x2d0 [ 26.252682][ T398] softirqs last disabled at (19004): [] br_device_event+0x1d7/0x8f0 [bridge] [ 26.252689][ T398] Preemption disabled at: [ 26.252690][ T398] [<0000000000000000>] 0x0 [ 26.252697][ T398] CPU: 2 UID: 0 PID: 398 Comm: ip Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 26.252700][ T398] Tainted: [W]=WARN [ 26.252701][ T398] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 26.252703][ T398] Call Trace: [ 26.252704][ T398] [ 26.252706][ T398] dump_stack_lvl+0x6f/0xa0 [ 26.252712][ T398] __might_resched.cold+0x1fe/0x2c1 [ 26.252717][ T398] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 26.252721][ T398] ? __kmalloc_noprof+0xdb/0x760 [ 26.252726][ T398] __kmalloc_noprof+0x443/0x760 [ 26.252728][ T398] ? alloc_buf.isra.0+0x4b/0x260 [ 26.252734][ T398] ? do_raw_spin_unlock+0x59/0x250 [ 26.252737][ T398] alloc_buf.isra.0+0x4b/0x260 [ 26.252740][ T398] put_chars+0x1e1/0x2f0 [ 26.252743][ T398] ? __send_to_port+0x420/0x420 [ 26.252744][ T398] ? check_prev_add+0xef/0xe90 [ 26.252748][ T398] ? validate_chain+0x34a/0xc20 [ 26.252751][ T398] hvc_console_print+0x292/0x780 [ 26.252754][ T398] ? mark_usage+0x61/0x170 [ 26.252756][ T398] ? __lock_acquire+0x518/0xc20 [ 26.252757][ T398] ? __lock_acquire+0x518/0xc20 [ 26.252761][ T398] ? hvc_write+0x3a0/0x3a0 [ 26.252763][ T398] ? lock_acquire.part.0+0xd4/0x280 [ 26.252767][ T398] ? lock_acquire+0x13c/0x160 [ 26.252771][ T398] console_emit_next_record+0x22f/0x4c0 [ 26.252774][ T398] ? devkmsg_read+0x4b0/0x4b0 [ 26.252776][ T398] ? console_flush_one_record+0x106/0x710 [ 26.252779][ T398] ? rcu_is_watching+0x16/0xd0 [ 26.252784][ T398] ? lock_acquire+0x13c/0x160 [ 26.252788][ T398] console_flush_one_record+0x46f/0x710 [ 26.252792][ T398] ? console_emit_next_record+0x4c0/0x4c0 [ 26.252794][ T398] ? __lock_acquire+0x518/0xc20 [ 26.252799][ T398] console_unlock+0xee/0x1f0 [ 26.252802][ T398] ? console_flush_one_record+0x710/0x710 [ 26.252804][ T398] ? rcu_is_watching+0x16/0xd0 [ 26.252806][ T398] ? lock_acquire+0x60/0x160 [ 26.252809][ T398] ? __down_trylock_console_sem+0x5e/0xa0 [ 26.252811][ T398] ? vprintk_emit+0x320/0x3e0 [ 26.252814][ T398] vprintk_emit+0x37c/0x3e0 [ 26.252818][ T398] ? wake_up_klogd_work_func+0x90/0x90 [ 26.252820][ T398] ? mark_held_locks+0x40/0x70 [ 26.252823][ T398] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 26.252825][ T398] ? rcu_read_lock_any_held+0x3c/0x90 [ 26.252829][ T398] _printk+0xc7/0x100 [ 26.252833][ T398] ? snapshot_read.cold+0x21/0x21 [ 26.252841][ T398] br_set_state+0x22f/0x430 [bridge] [ 26.252852][ T398] br_stp_disable_port+0x11f/0x390 [bridge] [ 26.252861][ T398] br_device_event+0x7b5/0x8f0 [bridge] [ 26.252868][ T398] ? _raw_spin_unlock_irqrestore+0x40/0x80 [ 26.252872][ T398] ? _sub_I_65535_1+0x4d0/0x4d0 [stp] [ 26.252879][ T398] notifier_call_chain+0xae/0x300 [ 26.252884][ T398] __dev_notify_flags+0x23c/0x3c0 [ 26.252889][ T398] ? netif_change_name+0x8c0/0x8c0 [ 26.252893][ T398] ? netif_set_allmulti+0x250/0x250 [ 26.252896][ T398] ? __kernel_text_address+0x12/0x30 [ 26.252898][ T398] ? write_profile+0xf0/0xf0 [ 26.252901][ T398] ? unwind_get_return_address+0x67/0xd0 [ 26.252905][ T398] netif_change_flags+0xfe/0x190 [ 26.252909][ T398] do_setlink.isra.0+0x1cc3/0x2750 [ 26.252913][ T398] ? stack_trace_save+0x93/0xc0 [ 26.252915][ T398] ? rtnl_link_get_size+0x350/0x350 [ 26.252916][ T398] ? rcu_read_lock_any_held+0x66/0x90 [ 26.252918][ T398] ? stack_depot_save_flags+0x38e/0x790 [ 26.252922][ T398] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 26.252924][ T398] ? rcu_read_lock_any_held+0x3c/0x90 [ 26.252926][ T398] ? validate_chain+0x38b/0xc20 [ 26.252928][ T398] ? kasan_save_stack+0x3d/0x50 [ 26.252931][ T398] ? kasan_save_stack+0x2f/0x50 [ 26.252933][ T398] ? kasan_save_track+0x14/0x30 [ 26.252936][ T398] ? __lock_acquire+0x518/0xc20 [ 26.252937][ T398] ? netlink_seq_next+0x4e/0x60 [ 26.252940][ T398] ? ___sys_sendmsg+0xb0/0x1d0 [ 26.252945][ T398] ? lock_acquire.part.0+0xd4/0x280 [ 26.252947][ T398] ? rtnl_newlink+0x9a8/0x11c0 [ 26.252949][ T398] ? rcu_is_watching+0x16/0xd0 [ 26.252952][ T398] ? lock_acquire+0x13c/0x160 [ 26.252954][ T398] ? rcu_is_watching+0x16/0xd0 [ 26.252955][ T398] ? rcu_is_watching+0x16/0xd0 [ 26.252957][ T398] ? trace_contention_end+0xb3/0x180 [ 26.252961][ T398] ? __mutex_lock+0x1db/0x1ea0 [ 26.252963][ T398] ? __mutex_lock+0x9a3/0x1ea0 [ 26.252965][ T398] ? rtnl_newlink+0x9a8/0x11c0 [ 26.252968][ T398] ? ww_mutex_lock+0x160/0x160 [ 26.252974][ T398] ? __rtnl_newlink+0x3fa/0xa50 [ 26.252979][ T398] rtnl_newlink+0x9f1/0x11c0 [ 26.252984][ T398] ? rtnl_bridge_getlink+0x850/0x850 [ 26.252986][ T398] ? __lock_acquire+0x518/0xc20 [ 26.252990][ T398] ? lock_acquire.part.0+0xd4/0x280 [ 26.252992][ T398] ? find_held_lock+0x2b/0x80 [ 26.252994][ T398] ? rtnl_bridge_getlink+0x850/0x850 [ 26.252996][ T398] ? __lock_release.isra.0+0x69/0x1a0 [ 26.253000][ T398] ? rtnl_bridge_getlink+0x850/0x850 [ 26.253002][ T398] rtnetlink_rcv_msg+0x6fd/0xbd0 [ 26.253005][ T398] ? rtnl_link_fill+0x920/0x920 [ 26.253006][ T398] ? __lock_acquire+0x518/0xc20 [ 26.253010][ T398] ? lock_acquire.part.0+0xd4/0x280 [ 26.253012][ T398] ? find_held_lock+0x2b/0x80 [ 26.253015][ T398] netlink_rcv_skb+0x14e/0x3a0 [ 26.253017][ T398] ? rtnl_link_fill+0x920/0x920 [ 26.253020][ T398] ? netlink_ack+0xcf0/0xcf0 [ 26.253026][ T398] ? netlink_deliver_tap+0xc5/0x330 [ 26.253028][ T398] ? netlink_deliver_tap+0x13c/0x330 [ 26.253032][ T398] netlink_unicast+0x486/0x750 [ 26.253036][ T398] ? netlink_attachskb+0x810/0x810 [ 26.253038][ T398] ? __lock_acquire+0x518/0xc20 [ 26.253042][ T398] netlink_sendmsg+0x735/0xc60 [ 26.253046][ T398] ? netlink_unicast+0x750/0x750 [ 26.253050][ T398] ? __might_fault+0x97/0x140 [ 26.253055][ T398] ____sys_sendmsg+0x415/0x880 [ 26.253057][ T398] ? copy_msghdr_from_user+0x279/0x420 [ 26.253060][ T398] ? get_timestamp.constprop.0+0x390/0x390 [ 26.253061][ T398] ? move_addr_to_kernel+0x40/0x40 [ 26.253069][ T398] ___sys_sendmsg+0x14e/0x1d0 [ 26.253071][ T398] ? copy_msghdr_from_user+0x420/0x420 [ 26.253087][ T398] __sys_sendmsg+0x12c/0x1d0 [ 26.253089][ T398] ? __sys_sendmsg_sock+0x20/0x20 [ 26.253096][ T398] ? rcu_is_watching+0x16/0xd0 [ 26.253099][ T398] do_syscall_64+0xff/0x530 [ 26.253102][ T398] ? exc_page_fault+0xee/0x100 [ 26.253105][ T398] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 26.253107][ T398] RIP: 0033:0x7fb6887d454e [ 26.253109][ T398] 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 [ 26.253111][ T398] RSP: 002b:00007ffd69b48730 EFLAGS: 00000202 ORIG_RAX: 000000000000002e [ 26.253114][ T398] RAX: ffffffffffffffda RBX: 0000000000000003 RCX: 00007fb6887d454e [ 26.253115][ T398] RDX: 0000000000000000 RSI: 00007ffd69b487e0 RDI: 0000000000000005 [ 26.253116][ T398] RBP: 00007ffd69b48740 R08: 0000000000000000 R09: 0000000000000000 [ 26.253117][ T398] R10: 0000000000000000 R11: 0000000000000202 R12: 000000006a91053c [ 26.253118][ T398] R13: 00000000004a1620 R14: 0000000000000000 R15: 00007ffd69b48ea0 [ 26.253124][ T398] [ 26.311864][ T398] ip (398) used greatest stack depth: 23016 bytes left [ 26.330937][ T399] veth1: left allmulticast mode [ 26.331316][ T399] veth1: left promiscuous mode [ 26.332159][ T399] br1: port 1(veth1) entered disabled state