[ 10.350749][ T242] 8021q: 802.1Q VLAN Support v1.8 [ 10.350768][ T242] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 10.350770][ T242] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 242, name: modprobe [ 10.350772][ T242] preempt_count: 1, expected: 0 [ 10.350773][ T242] RCU nest depth: 0, expected: 0 [ 10.350774][ T242] locks held by modprobe/242: 4, last CPU#3: [ 10.350776][ T242] #0: ffffffff97d69cc0 (console_lock){+.+.}-{0:0}, at: vprintk_emit+0x320/0x3e0 [ 10.350789][ T242] #1: ffffffff97d69d38 (console_srcu){....}-{0:0}, at: console_flush_one_record+0x106/0x710 [ 10.350793][ T242] #2: ffffffff97c89660 (console_owner){....}-{0:0}, at: console_lock_spinning_enable+0x40/0x60 [ 10.350797][ T242] #3: ffffffff97c89560 (printk_legacy_map-wait-type-override){....}-{3:3}, at: console_emit_next_record+0x1df/0x4c0 [ 10.350801][ T242] irq event stamp: 28962 [ 10.350801][ T242] hardirqs last enabled at (28961): [] __down_trylock_console_sem+0x86/0xa0 [ 10.350804][ T242] hardirqs last disabled at (28962): [] console_emit_next_record+0x3d4/0x4c0 [ 10.350806][ T242] softirqs last enabled at (26140): [] handle_softirqs+0x67c/0x900 [ 10.350809][ T242] softirqs last disabled at (25781): [] __irq_exit_rcu+0x145/0x1c0 [ 10.350811][ T242] Preemption disabled at: [ 10.350812][ T242] [] vprintk_emit+0x31b/0x3e0 [ 10.350817][ T242] CPU: 3 UID: 0 PID: 242 Comm: modprobe Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 10.350821][ T242] Tainted: [W]=WARN [ 10.350822][ T242] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 10.350824][ T242] Call Trace: [ 10.350826][ T242] [ 10.350827][ T242] dump_stack_lvl+0x6f/0xa0 [ 10.350833][ T242] ? vprintk_emit+0x31b/0x3e0 [ 10.350835][ T242] __might_resched.cold+0x1fe/0x2c1 [ 10.350839][ T242] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 10.350843][ T242] ? __kmalloc_noprof+0xdb/0x760 [ 10.350848][ T242] __kmalloc_noprof+0x443/0x760 [ 10.350851][ T242] ? alloc_buf.isra.0+0x4b/0x260 [ 10.350856][ T242] ? do_raw_spin_unlock+0x59/0x250 [ 10.350859][ T242] alloc_buf.isra.0+0x4b/0x260 [ 10.350862][ T242] put_chars+0x1e1/0x2f0 [ 10.350864][ T242] ? __send_to_port+0x420/0x420 [ 10.350866][ T242] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 10.350870][ T242] ? rcu_read_lock_any_held+0x3c/0x90 [ 10.350873][ T242] ? validate_chain+0x38b/0xc20 [ 10.350877][ T242] hvc_console_print+0x292/0x780 [ 10.350880][ T242] ? __lock_acquire+0x518/0xc20 [ 10.350884][ T242] ? hvc_write+0x3a0/0x3a0 [ 10.350887][ T242] ? rcu_is_watching+0x16/0xd0 [ 10.350892][ T242] console_emit_next_record+0x22f/0x4c0 [ 10.350895][ T242] ? devkmsg_read+0x4b0/0x4b0 [ 10.350897][ T242] ? console_flush_one_record+0x106/0x710 [ 10.350900][ T242] ? rcu_is_watching+0x16/0xd0 [ 10.350902][ T242] ? lock_acquire+0x13c/0x160 [ 10.350906][ T242] console_flush_one_record+0x46f/0x710 [ 10.350910][ T242] ? console_emit_next_record+0x4c0/0x4c0 [ 10.350912][ T242] ? __lock_acquire+0x518/0xc20 [ 10.350916][ T242] console_unlock+0xee/0x1f0 [ 10.350919][ T242] ? console_flush_one_record+0x710/0x710 [ 10.350921][ T242] ? rcu_is_watching+0x16/0xd0 [ 10.350923][ T242] ? lock_acquire+0x60/0x160 [ 10.350927][ T242] ? __down_trylock_console_sem+0x5e/0xa0 [ 10.350928][ T242] ? vprintk_emit+0x320/0x3e0 [ 10.350931][ T242] vprintk_emit+0x37c/0x3e0 [ 10.350935][ T242] ? wake_up_klogd_work_func+0x90/0x90 [ 10.350940][ T242] ? vlan_netlink_fini+0x960/0x960 [8021q] [ 10.350944][ T242] _printk+0xc7/0x100 [ 10.350947][ T242] ? snapshot_read.cold+0x21/0x21 [ 10.350953][ T242] ? do_one_initcall+0x113/0x4f0 [ 10.350956][ T242] vlan_proto_init+0x24/0x90 [8021q] [ 10.350959][ T242] do_one_initcall+0x124/0x4f0 [ 10.350962][ T242] ? trace_event_raw_event_initcall_level+0x280/0x280 [ 10.350966][ T242] ? do_init_module+0xae/0x8a0 [ 10.350969][ T242] ? kasan_unpoison+0x44/0x70 [ 10.350974][ T242] do_init_module+0x2ad/0x8a0 [ 10.350977][ T242] ? lockdep_hardirqs_on+0x91/0x130 [ 10.350981][ T242] ? free_module+0x470/0x470 [ 10.350984][ T242] ? kfree+0x123/0x590 [ 10.350988][ T242] load_module+0x1424/0x1bb0 [ 10.350995][ T242] ? layout_and_allocate.isra.0+0x680/0x680 [ 10.350999][ T242] ? __ia32_sys_fsconfig+0x180/0x180 [ 10.351001][ T242] ? ovl_real_file+0x172/0x1e0 [ 10.351005][ T242] ? find_held_lock+0x2b/0x80 [ 10.351007][ T242] ? backing_file_read_iter+0x541/0x790 [ 10.351010][ T242] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 10.351014][ T242] init_module_from_file+0x11f/0x1a0 [ 10.351017][ T242] ? __do_sys_init_module+0x220/0x220 [ 10.351025][ T242] ? __rwlock_init+0x150/0x150 [ 10.351028][ T242] ? do_raw_spin_unlock+0x59/0x250 [ 10.351031][ T242] idempotent_init_module+0x37b/0x7c0 [ 10.351034][ T242] ? init_module_from_file+0x1a0/0x1a0 [ 10.351040][ T242] ? rcu_is_watching+0x16/0xd0 [ 10.351043][ T242] ? cap_capable+0x1d7/0x3d0 [ 10.351048][ T242] __x64_sys_finit_module+0xdf/0x190 [ 10.351050][ T242] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 10.351054][ T242] do_syscall_64+0xff/0x530 [ 10.351056][ T242] ? exc_page_fault+0xee/0x100 [ 10.351058][ T242] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 10.351060][ T242] RIP: 0033:0x7f687ae0b37d [ 10.351064][ T242] 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.351065][ T242] RSP: 002b:00007fffca8c85a8 EFLAGS: 00000246 ORIG_RAX: 0000000000000139 [ 10.351068][ T242] RAX: ffffffffffffffda RBX: 0000560bf1ea6810 RCX: 00007f687ae0b37d [ 10.351070][ T242] RDX: 0000000000000000 RSI: 0000560bb46a3ffd RDI: 0000000000000000 [ 10.351071][ T242] RBP: 00007fffca8c8640 R08: 0000000000000000 R09: 0000000000000000 [ 10.351071][ T242] R10: 0000000000000000 R11: 0000000000000246 R12: 0000560bb46a3ffd [ 10.351072][ T242] R13: 0000560bf1ea6960 R14: 0000000000040000 R15: 0000000000000000 [ 10.351079][ T242] [ 12.215843][ T372] br10: port 1(veth1.10) entered blocking state [ 12.216006][ T372] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 12.216008][ T372] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 372, name: ip [ 12.216010][ T372] preempt_count: 1, expected: 0 [ 12.216011][ T372] RCU nest depth: 0, expected: 0 [ 12.216012][ T372] locks held by ip/372: 5, last CPU#1: [ 12.216015][ T372] #0: ffffffff984d2c40 (rtnl_mutex){+.+.}-{4:4}, at: rtnl_newlink+0x9a8/0x11c0 [ 12.216026][ T372] #1: ffffffff97d69cc0 (console_lock){+.+.}-{0:0}, at: vprintk_emit+0x320/0x3e0 [ 12.216032][ T372] #2: ffffffff97d69d38 (console_srcu){....}-{0:0}, at: console_flush_one_record+0x106/0x710 [ 12.216036][ T372] #3: ffffffff97c89660 (console_owner){....}-{0:0}, at: console_lock_spinning_enable+0x40/0x60 [ 12.216041][ T372] #4: ffffffff97c89560 (printk_legacy_map-wait-type-override){....}-{3:3}, at: console_emit_next_record+0x1df/0x4c0 [ 12.216044][ T372] irq event stamp: 15046 [ 12.216045][ T372] hardirqs last enabled at (15045): [] __down_trylock_console_sem+0x86/0xa0 [ 12.216048][ T372] hardirqs last disabled at (15046): [] console_emit_next_record+0x3d4/0x4c0 [ 12.216050][ T372] softirqs last enabled at (14956): [] __alloc_skb+0x4c2/0x5f0 [ 12.216053][ T372] softirqs last disabled at (14954): [] __alloc_skb+0x4c2/0x5f0 [ 12.216056][ T372] Preemption disabled at: [ 12.216056][ T372] [] vprintk_emit+0x31b/0x3e0 [ 12.216063][ T372] CPU: 1 UID: 0 PID: 372 Comm: ip Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 12.216066][ T372] Tainted: [W]=WARN [ 12.216067][ T372] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 12.216069][ T372] Call Trace: [ 12.216071][ T372] [ 12.216073][ T372] dump_stack_lvl+0x6f/0xa0 [ 12.216085][ T372] ? vprintk_emit+0x31b/0x3e0 [ 12.216087][ T372] __might_resched.cold+0x1fe/0x2c1 [ 12.216092][ T372] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 12.216096][ T372] ? __kmalloc_noprof+0xdb/0x760 [ 12.216101][ T372] __kmalloc_noprof+0x443/0x760 [ 12.216104][ T372] ? alloc_buf.isra.0+0x4b/0x260 [ 12.216110][ T372] ? do_raw_spin_unlock+0x59/0x250 [ 12.216112][ T372] alloc_buf.isra.0+0x4b/0x260 [ 12.216115][ T372] put_chars+0x1e1/0x2f0 [ 12.216118][ T372] ? __send_to_port+0x420/0x420 [ 12.216122][ T372] ? validate_chain+0x34a/0xc20 [ 12.216126][ T372] hvc_console_print+0x292/0x780 [ 12.216129][ T372] ? mark_usage+0x61/0x170 [ 12.216130][ T372] ? __lock_acquire+0x518/0xc20 [ 12.216132][ T372] ? __lock_acquire+0x518/0xc20 [ 12.216136][ T372] ? hvc_write+0x3a0/0x3a0 [ 12.216138][ T372] ? console_emit_next_record+0x1df/0x4c0 [ 12.216141][ T372] ? rcu_is_watching+0x16/0xd0 [ 12.216145][ T372] ? lock_acquire+0x13c/0x160 [ 12.216149][ T372] console_emit_next_record+0x22f/0x4c0 [ 12.216152][ T372] ? devkmsg_read+0x4b0/0x4b0 [ 12.216154][ T372] ? console_flush_one_record+0x106/0x710 [ 12.216157][ T372] ? rcu_is_watching+0x16/0xd0 [ 12.216166][ T372] ? lock_acquire+0x13c/0x160 [ 12.216170][ T372] console_flush_one_record+0x46f/0x710 [ 12.216174][ T372] ? console_emit_next_record+0x4c0/0x4c0 [ 12.216176][ T372] ? __lock_acquire+0x518/0xc20 [ 12.216181][ T372] console_unlock+0xee/0x1f0 [ 12.216184][ T372] ? console_flush_one_record+0x710/0x710 [ 12.216186][ T372] ? rcu_is_watching+0x16/0xd0 [ 12.216188][ T372] ? lock_acquire+0x60/0x160 [ 12.216192][ T372] ? __down_trylock_console_sem+0x5e/0xa0 [ 12.216193][ T372] ? vprintk_emit+0x320/0x3e0 [ 12.216197][ T372] vprintk_emit+0x37c/0x3e0 [ 12.216201][ T372] ? wake_up_klogd_work_func+0x90/0x90 [ 12.216203][ T372] ? __lock_release.isra.0+0x69/0x1a0 [ 12.216205][ T372] ? _raw_spin_unlock_irqrestore+0x40/0x80 [ 12.216211][ T372] _printk+0xc7/0x100 [ 12.216214][ T372] ? snapshot_read.cold+0x21/0x21 [ 12.216218][ T372] ? br_multicast_flood+0xab0/0xab0 [bridge] [ 12.216232][ T372] ? do_setlink.isra.0+0xa31/0x2750 [ 12.216233][ T372] ? rtnl_newlink+0x9f1/0x11c0 [ 12.216234][ T372] ? rtnetlink_rcv_msg+0x6fd/0xbd0 [ 12.216239][ T372] br_set_state+0x22f/0x430 [bridge] [ 12.216249][ T372] br_init_port+0xc4/0x200 [bridge] [ 12.216258][ T372] new_nbp+0x39c/0x580 [bridge] [ 12.216267][ T372] br_add_if+0x212/0x1320 [bridge] [ 12.216274][ T372] ? is_bpf_text_address+0x72/0x110 [ 12.216278][ T372] ? kernel_text_address+0x149/0x170 [ 12.216281][ T372] ? __kernel_text_address+0x12/0x30 [ 12.216285][ T372] do_set_master+0x357/0x580 [ 12.216289][ T372] do_setlink.isra.0+0xa31/0x2750 [ 12.216292][ T372] ? stack_trace_save+0x93/0xc0 [ 12.216295][ T372] ? rtnl_link_get_size+0x350/0x350 [ 12.216297][ T372] ? rcu_read_lock_any_held+0x66/0x90 [ 12.216299][ T372] ? stack_depot_save_flags+0x38e/0x790 [ 12.216302][ T372] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 12.216305][ T372] ? rcu_read_lock_any_held+0x3c/0x90 [ 12.216307][ T372] ? validate_chain+0x38b/0xc20 [ 12.216309][ T372] ? kasan_save_stack+0x3d/0x50 [ 12.216312][ T372] ? kasan_save_stack+0x2f/0x50 [ 12.216314][ T372] ? kasan_save_track+0x14/0x30 [ 12.216316][ T372] ? __lock_acquire+0x518/0xc20 [ 12.216318][ T372] ? netlink_seq_next+0x4e/0x60 [ 12.216321][ T372] ? ___sys_sendmsg+0xb0/0x1d0 [ 12.216326][ T372] ? lock_acquire.part.0+0xd4/0x280 [ 12.216328][ T372] ? rtnl_newlink+0x9a8/0x11c0 [ 12.216330][ T372] ? rcu_is_watching+0x16/0xd0 [ 12.216333][ T372] ? lock_acquire+0x13c/0x160 [ 12.216334][ T372] ? rcu_is_watching+0x16/0xd0 [ 12.216336][ T372] ? rcu_is_watching+0x16/0xd0 [ 12.216338][ T372] ? trace_contention_end+0xb3/0x180 [ 12.216342][ T372] ? __mutex_lock+0x1db/0x1ea0 [ 12.216344][ T372] ? __mutex_lock+0x9a3/0x1ea0 [ 12.216346][ T372] ? rtnl_newlink+0x9a8/0x11c0 [ 12.216349][ T372] ? ww_mutex_lock+0x160/0x160 [ 12.216351][ T372] ? nla_get_range_signed+0x3d0/0x3d0 [ 12.216356][ T372] ? __rtnl_newlink+0x3fa/0xa50 [ 12.216361][ T372] rtnl_newlink+0x9f1/0x11c0 [ 12.216366][ T372] ? rtnl_bridge_getlink+0x850/0x850 [ 12.216368][ T372] ? __lock_acquire+0x518/0xc20 [ 12.216373][ T372] ? lock_acquire.part.0+0xd4/0x280 [ 12.216374][ T372] ? find_held_lock+0x2b/0x80 [ 12.216377][ T372] ? rtnl_bridge_getlink+0x850/0x850 [ 12.216378][ T372] ? __lock_release.isra.0+0x69/0x1a0 [ 12.216382][ T372] ? rtnl_bridge_getlink+0x850/0x850 [ 12.216384][ T372] rtnetlink_rcv_msg+0x6fd/0xbd0 [ 12.216387][ T372] ? rtnl_link_fill+0x920/0x920 [ 12.216388][ T372] ? __lock_acquire+0x518/0xc20 [ 12.216393][ T372] ? lock_acquire.part.0+0xd4/0x280 [ 12.216395][ T372] ? find_held_lock+0x2b/0x80 [ 12.216398][ T372] netlink_rcv_skb+0x14e/0x3a0 [ 12.216400][ T372] ? rtnl_link_fill+0x920/0x920 [ 12.216403][ T372] ? netlink_ack+0xcf0/0xcf0 [ 12.216409][ T372] ? netlink_deliver_tap+0xc5/0x330 [ 12.216410][ T372] ? netlink_deliver_tap+0x13c/0x330 [ 12.216415][ T372] netlink_unicast+0x486/0x750 [ 12.216418][ T372] ? netlink_attachskb+0x810/0x810 [ 12.216421][ T372] ? __lock_acquire+0x518/0xc20 [ 12.216425][ T372] netlink_sendmsg+0x735/0xc60 [ 12.216429][ T372] ? netlink_unicast+0x750/0x750 [ 12.216432][ T372] ? __might_fault+0x97/0x140 [ 12.216438][ T372] ____sys_sendmsg+0x415/0x880 [ 12.216440][ T372] ? copy_msghdr_from_user+0x279/0x420 [ 12.216442][ T372] ? get_timestamp.constprop.0+0x390/0x390 [ 12.216444][ T372] ? move_addr_to_kernel+0x40/0x40 [ 12.216451][ T372] ___sys_sendmsg+0x14e/0x1d0 [ 12.216454][ T372] ? copy_msghdr_from_user+0x420/0x420 [ 12.216470][ T372] __sys_sendmsg+0x12c/0x1d0 [ 12.216473][ T372] ? __sys_sendmsg_sock+0x20/0x20 [ 12.216479][ T372] ? rcu_is_watching+0x16/0xd0 [ 12.216483][ T372] do_syscall_64+0xff/0x530 [ 12.216485][ T372] ? exc_page_fault+0xee/0x100 [ 12.216488][ T372] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 12.216491][ T372] RIP: 0033:0x7f6b7947054e [ 12.216495][ T372] 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.216496][ T372] RSP: 002b:00007fff6b40f970 EFLAGS: 00000202 ORIG_RAX: 000000000000002e [ 12.216499][ T372] RAX: ffffffffffffffda RBX: 0000000000000004 RCX: 00007f6b7947054e [ 12.216501][ T372] RDX: 0000000000000000 RSI: 00007fff6b40fa20 RDI: 0000000000000005 [ 12.216501][ T372] RBP: 00007fff6b40f980 R08: 0000000000000000 R09: 0000000000000000 [ 12.216502][ T372] R10: 0000000000000000 R11: 0000000000000202 R12: 000000006a90fc29 [ 12.216503][ T372] R13: 00000000004a1620 R14: 0000000000000000 R15: 00007fff6b4100e0 [ 12.216510][ T372] [ 12.260955][ T372] br10: port 1(veth1.10) entered disabled state [ 12.261321][ T372] veth1.10: entered allmulticast mode [ 12.261540][ T372] veth1: entered allmulticast mode [ 12.263385][ T372] veth1.10: entered promiscuous mode [ 12.263625][ T372] veth1: entered promiscuous mode [ 12.272274][ T372] ip (372) used greatest stack depth: 23336 bytes left [ 12.310951][ T378] br10: port 2(veth2.10) entered blocking state [ 12.311729][ T378] br10: port 2(veth2.10) entered disabled state [ 12.312031][ T378] veth2.10: entered allmulticast mode [ 12.312263][ T378] veth2: entered allmulticast mode [ 12.313878][ T378] veth2.10: entered promiscuous mode [ 12.314119][ T378] veth2: entered promiscuous mode [ 12.370355][ T383] br10: port 2(veth2.10) entered blocking state [ 12.370820][ T383] br10: port 2(veth2.10) entered forwarding state [ 12.371448][ T383] br10: port 1(veth1.10) entered blocking state [ 12.371741][ T383] br10: port 1(veth1.10) entered forwarding state [ 12.839383][ T420] br11: port 1(veth1.11) entered blocking state [ 12.839758][ T420] br11: port 1(veth1.11) entered disabled state [ 12.840135][ T420] veth1.11: entered allmulticast mode [ 12.841809][ T420] veth1.11: entered promiscuous mode [ 12.891997][ T425] br11: port 2(veth2.11) entered blocking state [ 12.892356][ T425] br11: port 2(veth2.11) entered disabled state [ 12.892657][ T425] veth2.11: entered allmulticast mode [ 12.894224][ T425] veth2.11: entered promiscuous mode [ 12.942292][ T430] br11: port 2(veth2.11) entered blocking state [ 12.942622][ T430] br11: port 2(veth2.11) entered forwarding state [ 12.943031][ T430] br11: port 1(veth1.11) entered blocking state [ 12.943336][ T430] br11: port 1(veth1.11) entered forwarding state [ 13.338266][ T466] br12: port 1(veth1.12) entered blocking state [ 13.338282][ T466] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 13.338284][ T466] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 466, name: ip [ 13.338286][ T466] preempt_count: 1, expected: 0 [ 13.338287][ T466] RCU nest depth: 0, expected: 0 [ 13.338288][ T466] locks held by ip/466: 5, last CPU#0: [ 13.338290][ T466] #0: ffffffff984d2c40 (rtnl_mutex){+.+.}-{4:4}, at: rtnl_newlink+0x9a8/0x11c0 [ 13.338302][ T466] #1: ffffffff97d69cc0 (console_lock){+.+.}-{0:0}, at: vprintk_emit+0x320/0x3e0 [ 13.338308][ T466] #2: ffffffff97d69d38 (console_srcu){....}-{0:0}, at: console_flush_one_record+0x106/0x710 [ 13.338312][ T466] #3: ffffffff97c89660 (console_owner){....}-{0:0}, at: console_lock_spinning_enable+0x40/0x60 [ 13.338316][ T466] #4: ffffffff97c89560 (printk_legacy_map-wait-type-override){....}-{3:3}, at: console_emit_next_record+0x1df/0x4c0 [ 13.338320][ T466] irq event stamp: 21092 [ 13.338320][ T466] hardirqs last enabled at (21091): [] __down_trylock_console_sem+0x86/0xa0 [ 13.338323][ T466] hardirqs last disabled at (21092): [] console_emit_next_record+0x3d4/0x4c0 [ 13.338325][ T466] softirqs last enabled at (21034): [] __alloc_skb+0x4c2/0x5f0 [ 13.338328][ T466] softirqs last disabled at (21032): [] __alloc_skb+0x4c2/0x5f0 [ 13.338330][ T466] Preemption disabled at: [ 13.338331][ T466] [] vprintk_emit+0x31b/0x3e0 [ 13.338337][ T466] CPU: 0 UID: 0 PID: 466 Comm: ip Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 13.338340][ T466] Tainted: [W]=WARN [ 13.338341][ T466] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 13.338343][ T466] Call Trace: [ 13.338345][ T466] [ 13.338346][ T466] dump_stack_lvl+0x6f/0xa0 [ 13.338352][ T466] ? vprintk_emit+0x31b/0x3e0 [ 13.338354][ T466] __might_resched.cold+0x1fe/0x2c1 [ 13.338359][ T466] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 13.338363][ T466] ? __kmalloc_noprof+0xdb/0x760 [ 13.338368][ T466] __kmalloc_noprof+0x443/0x760 [ 13.338370][ T466] ? alloc_buf.isra.0+0x4b/0x260 [ 13.338376][ T466] ? do_raw_spin_unlock+0x59/0x250 [ 13.338379][ T466] alloc_buf.isra.0+0x4b/0x260 [ 13.338382][ T466] put_chars+0x1e1/0x2f0 [ 13.338384][ T466] ? prb_final_commit+0x50/0x50 [ 13.338386][ T466] ? __send_to_port+0x420/0x420 [ 13.338389][ T466] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 13.338393][ T466] ? rcu_read_lock_any_held+0x3c/0x90 [ 13.338395][ T466] ? validate_chain+0x38b/0xc20 [ 13.338399][ T466] hvc_console_print+0x292/0x780 [ 13.338402][ T466] ? mark_usage+0x61/0x170 [ 13.338404][ T466] ? __lock_acquire+0x518/0xc20 [ 13.338405][ T466] ? __lock_acquire+0x518/0xc20 [ 13.338409][ T466] ? hvc_write+0x3a0/0x3a0 [ 13.338411][ T466] ? console_emit_next_record+0x1df/0x4c0 [ 13.338414][ T466] ? rcu_is_watching+0x16/0xd0 [ 13.338416][ T466] ? lock_acquire+0x13c/0x160 [ 13.338420][ T466] console_emit_next_record+0x22f/0x4c0 [ 13.338424][ T466] ? devkmsg_read+0x4b0/0x4b0 [ 13.338426][ T466] ? console_flush_one_record+0x106/0x710 [ 13.338429][ T466] ? rcu_is_watching+0x16/0xd0 [ 13.338431][ T466] ? lock_acquire+0x13c/0x160 [ 13.338435][ T466] console_flush_one_record+0x46f/0x710 [ 13.338439][ T466] ? console_emit_next_record+0x4c0/0x4c0 [ 13.338441][ T466] ? __lock_acquire+0x518/0xc20 [ 13.338446][ T466] console_unlock+0xee/0x1f0 [ 13.338449][ T466] ? console_flush_one_record+0x710/0x710 [ 13.338451][ T466] ? rcu_is_watching+0x16/0xd0 [ 13.338453][ T466] ? lock_acquire+0x60/0x160 [ 13.338457][ T466] ? __down_trylock_console_sem+0x5e/0xa0 [ 13.338458][ T466] ? vprintk_emit+0x320/0x3e0 [ 13.338462][ T466] vprintk_emit+0x37c/0x3e0 [ 13.338466][ T466] ? wake_up_klogd_work_func+0x90/0x90 [ 13.338468][ T466] ? __lock_release.isra.0+0x69/0x1a0 [ 13.338473][ T466] _printk+0xc7/0x100 [ 13.338477][ T466] ? snapshot_read.cold+0x21/0x21 [ 13.338480][ T466] ? br_multicast_flood+0xab0/0xab0 [bridge] [ 13.338493][ T466] ? do_setlink.isra.0+0xa31/0x2750 [ 13.338495][ T466] ? rtnl_newlink+0x9f1/0x11c0 [ 13.338496][ T466] ? rtnetlink_rcv_msg+0x6fd/0xbd0 [ 13.338500][ T466] br_set_state+0x22f/0x430 [bridge] [ 13.338510][ T466] br_init_port+0xc4/0x200 [bridge] [ 13.338519][ T466] new_nbp+0x39c/0x580 [bridge] [ 13.338527][ T466] br_add_if+0x212/0x1320 [bridge] [ 13.338535][ T466] ? is_bpf_text_address+0x72/0x110 [ 13.338538][ T466] ? kernel_text_address+0x149/0x170 [ 13.338541][ T466] ? __kernel_text_address+0x12/0x30 [ 13.338545][ T466] do_set_master+0x357/0x580 [ 13.338549][ T466] do_setlink.isra.0+0xa31/0x2750 [ 13.338552][ T466] ? stack_trace_save+0x93/0xc0 [ 13.338555][ T466] ? rtnl_link_get_size+0x350/0x350 [ 13.338557][ T466] ? rcu_read_lock_any_held+0x66/0x90 [ 13.338559][ T466] ? stack_depot_save_flags+0x38e/0x790 [ 13.338562][ T466] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 13.338565][ T466] ? rcu_read_lock_any_held+0x3c/0x90 [ 13.338566][ T466] ? validate_chain+0x38b/0xc20 [ 13.338569][ T466] ? kasan_save_stack+0x3d/0x50 [ 13.338572][ T466] ? kasan_save_stack+0x2f/0x50 [ 13.338573][ T466] ? kasan_save_track+0x14/0x30 [ 13.338576][ T466] ? __lock_acquire+0x518/0xc20 [ 13.338578][ T466] ? netlink_seq_next+0x4e/0x60 [ 13.338581][ T466] ? ___sys_sendmsg+0xb0/0x1d0 [ 13.338585][ T466] ? lock_acquire.part.0+0xd4/0x280 [ 13.338587][ T466] ? rtnl_newlink+0x9a8/0x11c0 [ 13.338589][ T466] ? rcu_is_watching+0x16/0xd0 [ 13.338592][ T466] ? lock_acquire+0x13c/0x160 [ 13.338593][ T466] ? rcu_is_watching+0x16/0xd0 [ 13.338595][ T466] ? rcu_is_watching+0x16/0xd0 [ 13.338597][ T466] ? trace_contention_end+0xb3/0x180 [ 13.338601][ T466] ? __mutex_lock+0x1db/0x1ea0 [ 13.338604][ T466] ? __mutex_lock+0x9a3/0x1ea0 [ 13.338606][ T466] ? rtnl_newlink+0x9a8/0x11c0 [ 13.338609][ T466] ? ww_mutex_lock+0x160/0x160 [ 13.338610][ T466] ? nla_get_range_signed+0x3d0/0x3d0 [ 13.338615][ T466] ? __rtnl_newlink+0x3fa/0xa50 [ 13.338620][ T466] rtnl_newlink+0x9f1/0x11c0 [ 13.338626][ T466] ? rtnl_bridge_getlink+0x850/0x850 [ 13.338628][ T466] ? __lock_acquire+0x518/0xc20 [ 13.338632][ T466] ? lock_acquire.part.0+0xd4/0x280 [ 13.338634][ T466] ? find_held_lock+0x2b/0x80 [ 13.338636][ T466] ? rtnl_bridge_getlink+0x850/0x850 [ 13.338637][ T466] ? __lock_release.isra.0+0x69/0x1a0 [ 13.338641][ T466] ? rtnl_bridge_getlink+0x850/0x850 [ 13.338643][ T466] rtnetlink_rcv_msg+0x6fd/0xbd0 [ 13.338646][ T466] ? rtnl_link_fill+0x920/0x920 [ 13.338647][ T466] ? __lock_acquire+0x518/0xc20 [ 13.338652][ T466] ? lock_acquire.part.0+0xd4/0x280 [ 13.338653][ T466] ? find_held_lock+0x2b/0x80 [ 13.338657][ T466] netlink_rcv_skb+0x14e/0x3a0 [ 13.338659][ T466] ? rtnl_link_fill+0x920/0x920 [ 13.338661][ T466] ? netlink_ack+0xcf0/0xcf0 [ 13.338667][ T466] ? netlink_deliver_tap+0xc5/0x330 [ 13.338669][ T466] ? netlink_deliver_tap+0x13c/0x330 [ 13.338673][ T466] netlink_unicast+0x486/0x750 [ 13.338677][ T466] ? netlink_attachskb+0x810/0x810 [ 13.338679][ T466] ? __lock_acquire+0x518/0xc20 [ 13.338683][ T466] netlink_sendmsg+0x735/0xc60 [ 13.338687][ T466] ? netlink_unicast+0x750/0x750 [ 13.338691][ T466] ? __might_fault+0x97/0x140 [ 13.338696][ T466] ____sys_sendmsg+0x415/0x880 [ 13.338698][ T466] ? copy_msghdr_from_user+0x279/0x420 [ 13.338700][ T466] ? get_timestamp.constprop.0+0x390/0x390 [ 13.338702][ T466] ? move_addr_to_kernel+0x40/0x40 [ 13.338709][ T466] ___sys_sendmsg+0x14e/0x1d0 [ 13.338711][ T466] ? copy_msghdr_from_user+0x420/0x420 [ 13.338727][ T466] __sys_sendmsg+0x12c/0x1d0 [ 13.338730][ T466] ? __sys_sendmsg_sock+0x20/0x20 [ 13.338736][ T466] ? rcu_is_watching+0x16/0xd0 [ 13.338739][ T466] do_syscall_64+0xff/0x530 [ 13.338741][ T466] ? exc_page_fault+0xee/0x100 [ 13.338744][ T466] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 13.338746][ T466] RIP: 0033:0x7fb7551b654e [ 13.338750][ T466] 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.338752][ T466] RSP: 002b:00007ffc9ba3b360 EFLAGS: 00000202 ORIG_RAX: 000000000000002e [ 13.338755][ T466] RAX: ffffffffffffffda RBX: 0000000000000004 RCX: 00007fb7551b654e [ 13.338756][ T466] RDX: 0000000000000000 RSI: 00007ffc9ba3b410 RDI: 0000000000000005 [ 13.338757][ T466] RBP: 00007ffc9ba3b370 R08: 0000000000000000 R09: 0000000000000000 [ 13.338758][ T466] R10: 0000000000000000 R11: 0000000000000202 R12: 000000006a90fc2a [ 13.338759][ T466] R13: 00000000004a1620 R14: 0000000000000000 R15: 00007ffc9ba3bad0 [ 13.338765][ T466] [ 13.377358][ T466] br12: port 1(veth1.12) entered disabled state [ 13.377678][ T466] veth1.12: entered allmulticast mode [ 13.379242][ T466] veth1.12: entered promiscuous mode [ 13.424562][ T471] br12: port 2(veth2.12) entered blocking state [ 13.424896][ T471] br12: port 2(veth2.12) entered disabled state [ 13.425684][ T471] veth2.12: entered allmulticast mode [ 13.427247][ T471] veth2.12: entered promiscuous mode [ 13.477642][ T476] br12: port 2(veth2.12) entered blocking state [ 13.477993][ T476] br12: port 2(veth2.12) entered forwarding state [ 13.478486][ T476] br12: port 1(veth1.12) entered blocking state [ 13.478807][ T476] br12: port 1(veth1.12) entered forwarding state [ 27.521132][ C1] [ 27.521148][ C1] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 27.521150][ C1] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 584, name: mausezahn [ 27.521152][ C1] preempt_count: 104, expected: 0 [ 27.521153][ C1] RCU nest depth: 1, expected: 0 [ 27.521154][ C1] INFO: lockdep is turned off. [ 27.521155][ C1] irq event stamp: 4916166 [ 27.521156][ C1] hardirqs last enabled at (4916166): [] irqentry_exit+0x21c/0x790 [ 27.521164][ C1] hardirqs last disabled at (4916165): [] sysvec_apic_timer_interrupt+0x12/0xe0 [ 27.521166][ C1] softirqs last enabled at (4915774): [] __alloc_skb+0x4c2/0x5f0 [ 27.521170][ C1] softirqs last disabled at (4915785): [] __irq_exit_rcu+0x145/0x1c0 [ 27.521174][ C1] Preemption disabled at: [ 27.521174][ C1] [<0000000000000000>] 0x0 [ 27.521181][ C1] CPU: 1 UID: 0 PID: 584 Comm: mausezahn Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 27.521187][ C1] Tainted: [W]=WARN [ 27.521188][ C1] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 27.521190][ C1] Call Trace: [ 27.521192][ C1] [ 27.521193][ C1] dump_stack_lvl+0x6f/0xa0 [ 27.521199][ C1] __might_resched.cold+0x1fe/0x2c1 [ 27.521202][ C1] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 27.521206][ C1] ? __asan_memcpy+0x3c/0x60 [ 27.521208][ C1] ? rcu_is_watching+0x16/0xd0 [ 27.521212][ C1] __kmalloc_noprof+0x443/0x760 [ 27.521215][ C1] ? __rwlock_init+0x150/0x150 [ 27.521218][ C1] ? alloc_buf.isra.0+0x4b/0x260 [ 27.521221][ C1] ? do_raw_spin_unlock+0x59/0x250 [ 27.521223][ C1] alloc_buf.isra.0+0x4b/0x260 [ 27.521225][ C1] put_chars+0x1e1/0x2f0 [ 27.521227][ C1] ? __send_to_port+0x420/0x420 [ 27.521229][ C1] ? console_prepend_replay+0x20/0x20 [ 27.521232][ C1] hvc_console_print+0x292/0x780 [ 27.521236][ C1] ? hvc_write+0x3a0/0x3a0 [ 27.521237][ C1] ? rcu_is_watching+0x16/0xd0 [ 27.521239][ C1] ? lock_acquire+0x13c/0x160 [ 27.521241][ C1] console_emit_next_record+0x22f/0x4c0 [ 27.521243][ C1] ? devkmsg_read+0x4b0/0x4b0 [ 27.521245][ C1] ? rcu_is_watching+0x16/0xd0 [ 27.521247][ C1] ? rcu_is_watching+0x16/0xd0 [ 27.521249][ C1] ? lock_acquire+0x13c/0x160 [ 27.521250][ C1] ? console_flush_one_record+0x111/0x710 [ 27.521252][ C1] console_flush_one_record+0x46f/0x710 [ 27.521254][ C1] ? console_emit_next_record+0x4c0/0x4c0 [ 27.521257][ C1] console_unlock+0xee/0x1f0 [ 27.521259][ C1] ? lock_acquire+0x13c/0x160 [ 27.521260][ C1] ? console_flush_one_record+0x710/0x710 [ 27.521262][ C1] ? rcu_is_watching+0x16/0xd0 [ 27.521264][ C1] ? lock_release+0x184/0x1f0 [ 27.521265][ C1] ? lock_acquire+0x60/0x160 [ 27.521267][ C1] ? __down_trylock_console_sem+0x5e/0xa0 [ 27.521269][ C1] ? vprintk_emit+0x320/0x3e0 [ 27.521271][ C1] vprintk_emit+0x37c/0x3e0 [ 27.521273][ C1] ? wake_up_klogd_work_func+0x90/0x90 [ 27.521275][ C1] ? rcu_is_watching+0x16/0xd0 [ 27.521277][ C1] ? lock_release+0x184/0x1f0 [ 27.521279][ C1] _printk+0xc7/0x100 [ 27.521282][ C1] ? snapshot_read.cold+0x21/0x21 [ 27.521284][ C1] ? arch_stack_walk+0xed/0x130 [ 27.521288][ C1] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 27.521295][ C1] ? nbcon_cpu_emergency_enter+0x28/0x80 [ 27.521296][ C1] print_irq_inversion_bug.part.0+0x32/0xc0 [ 27.521298][ C1] mark_lock_irq+0x989/0x9c0 [ 27.521301][ C1] mark_lock+0x1d7/0xa00 [ 27.521303][ C1] mark_usage+0x42/0x170 [ 27.521305][ C1] __lock_acquire+0x388/0xc20 [ 27.521307][ C1] lock_acquire.part.0+0xd4/0x280 [ 27.521309][ C1] ? br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 27.521322][ C1] ? rcu_is_watching+0x16/0xd0 [ 27.521323][ C1] ? lock_acquire+0x13c/0x160 [ 27.521325][ C1] ? br_message_age_timer_expired+0x70/0x70 [bridge] [ 27.521332][ C1] _raw_spin_lock+0x33/0x40 [ 27.521335][ C1] ? br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 27.521341][ C1] br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 27.521348][ C1] ? br_message_age_timer_expired+0x70/0x70 [bridge] [ 27.521355][ C1] call_timer_fn+0x160/0x4d0 [ 27.521358][ C1] ? sysvec_apic_timer_interrupt+0x4c/0xe0 [ 27.521360][ C1] ? detach_if_pending+0x1d0/0x1d0 [ 27.521362][ C1] ? _raw_spin_unlock_irq+0x28/0x50 [ 27.521365][ C1] __run_timers+0x68f/0xaa0 [ 27.521367][ C1] ? br_message_age_timer_expired+0x70/0x70 [bridge] [ 27.521374][ C1] ? __bpf_trace_itimer_expire+0x10/0x10 [ 27.521376][ C1] ? __lock_acquire+0x518/0xc20 [ 27.521379][ C1] ? __rwlock_init+0x150/0x150 [ 27.521381][ C1] run_timer_softirq+0xf0/0x160 [ 27.521383][ C1] ? __run_timers+0xaa0/0xaa0 [ 27.521385][ C1] ? rcu_is_watching+0x16/0xd0 [ 27.521387][ C1] handle_softirqs+0x1d3/0x900 [ 27.521389][ C1] ? __lock_release.isra.0+0x69/0x1a0 [ 27.521390][ C1] ? _local_bh_enable+0xc0/0xc0 [ 27.521392][ C1] __irq_exit_rcu+0x145/0x1c0 [ 27.521394][ C1] irq_exit_rcu+0xe/0x30 [ 27.521395][ C1] sysvec_apic_timer_interrupt+0x9d/0xe0 [ 27.521397][ C1] [ 27.521398][ C1] [ 27.521398][ C1] ? find_held_lock+0x2/0x80 [ 27.521400][ C1] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 27.521402][ C1] RIP: 0010:check_preemption_disabled+0xf/0xe0 [ 27.521405][ C1] Code: 85 d2 75 0f 65 8b 05 84 c9 f5 01 85 c0 74 04 90 0f 0b 90 e9 93 fb ff ff 0f 1f 00 65 8b 15 21 87 f5 01 65 44 8b 15 29 87 f5 01 <85> d2 74 04 44 89 d0 c3 9c 58 f6 c4 02 74 f5 65 48 8b 15 fa 86 f5 [ 27.521407][ C1] RSP: 0018:ffa00000006474f8 EFLAGS: 00000282 [ 27.521410][ C1] RAX: 0000000000000001 RBX: 1ff40000000c8eac RCX: ffa0000000640000 [ 27.521412][ C1] RDX: 0000000000000001 RSI: ffffffff9728d860 RDI: ffffffff9728d8a0 [ 27.521413][ C1] RBP: 00007fff740663f0 R08: ffa0000000647678 R09: ffa00000006475a0 [ 27.521414][ C1] R10: 0000000000000001 R11: 0000000000000001 R12: 0000000000000001 [ 27.521415][ C1] R13: ffa0000000647618 R14: ff1100000a17a380 R15: 0000000000082cc0 [ 27.521417][ C1] rcu_is_watching+0x16/0xd0 [ 27.521419][ C1] unwind_next_frame+0x6e9/0x1ea0 [ 27.521422][ C1] ? entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 27.521424][ C1] ? __lock_acquire+0x518/0xc20 [ 27.521425][ C1] ? stack_access_ok+0x1e0/0x1e0 [ 27.521427][ C1] ? find_held_lock+0x2/0x80 [ 27.521428][ C1] ? __unwind_start+0x42e/0x900 [ 27.521430][ C1] ? write_profile+0xf0/0xf0 [ 27.521432][ C1] arch_stack_walk+0xd7/0x130 [ 27.521435][ C1] stack_trace_save+0x93/0xc0 [ 27.521437][ C1] ? filter_irq_stacks+0xd0/0xd0 [ 27.521438][ C1] ? is_bpf_text_address+0x72/0x110 [ 27.521442][ C1] ? kernel_text_address+0x149/0x170 [ 27.521444][ C1] kasan_save_stack+0x2f/0x50 [ 27.521447][ C1] ? kasan_save_stack+0x2f/0x50 [ 27.521448][ C1] ? kasan_save_track+0x14/0x30 [ 27.521450][ C1] ? __kasan_slab_alloc+0x60/0x70 [ 27.521452][ C1] ? kmem_cache_alloc_node_noprof+0x25c/0x660 [ 27.521453][ C1] ? kmalloc_reserve+0x103/0x2d0 [ 27.521455][ C1] ? __alloc_skb+0x11e/0x5f0 [ 27.521456][ C1] ? alloc_skb_with_frags+0xcc/0x6c0 [ 27.521458][ C1] ? sock_alloc_send_pskb+0x327/0x3f0 [ 27.521460][ C1] ? packet_snd+0x5dd/0x1840 [ 27.521463][ C1] ? __sys_sendto+0x2aa/0x400 [ 27.521465][ C1] ? __x64_sys_sendto+0xe4/0x1f0 [ 27.521467][ C1] ? do_syscall_64+0xff/0x530 [ 27.521468][ C1] ? entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 27.521473][ C1] kasan_save_track+0x14/0x30 [ 27.521475][ C1] __kasan_slab_alloc+0x60/0x70 [ 27.521476][ C1] kmem_cache_alloc_node_noprof+0x25c/0x660 [ 27.521478][ C1] ? kmalloc_reserve+0x103/0x2d0 [ 27.521481][ C1] kmalloc_reserve+0x103/0x2d0 [ 27.521482][ C1] __alloc_skb+0x11e/0x5f0 [ 27.521484][ C1] ? __alloc_skb+0x4c2/0x5f0 [ 27.521486][ C1] ? napi_skb_cache_get+0x830/0x830 [ 27.521488][ C1] ? mark_usage+0x61/0x170 [ 27.521489][ C1] ? ref_tracker_alloc+0x2e7/0x430 [ 27.521492][ C1] ? ref_tracker_dir_print+0x100/0x100 [ 27.521494][ C1] alloc_skb_with_frags+0xcc/0x6c0 [ 27.521496][ C1] ? find_held_lock+0x2b/0x80 [ 27.521498][ C1] sock_alloc_send_pskb+0x327/0x3f0 [ 27.521500][ C1] packet_snd+0x5dd/0x1840 [ 27.521503][ C1] ? tpacket_snd+0x1990/0x1990 [ 27.521506][ C1] ? __might_fault+0x97/0x140 [ 27.521508][ C1] ? __might_fault+0x97/0x140 [ 27.521510][ C1] __sys_sendto+0x2aa/0x400 [ 27.521512][ C1] ? __ia32_sys_getpeername+0xd0/0xd0 [ 27.521515][ C1] ? sock_ioctl+0x3cb/0x5f0 [ 27.521518][ C1] ? __lock_release.isra.0+0x69/0x1a0 [ 27.521520][ C1] __x64_sys_sendto+0xe4/0x1f0 [ 27.521522][ C1] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 27.521524][ C1] ? lockdep_hardirqs_on+0x91/0x130 [ 27.521526][ C1] ? do_syscall_64+0xa6/0x530 [ 27.521527][ C1] do_syscall_64+0xff/0x530 [ 27.521528][ C1] ? irq_exit_rcu+0x1a/0x30 [ 27.521530][ C1] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 27.521531][ C1] RIP: 0033:0x7fbef4a5054e [ 27.521533][ C1] Code: 4d 89 d8 e8 b4 bd 00 00 4c 8b 5d f8 41 8b 93 08 03 00 00 59 5e 48 83 f8 fc 74 11 c9 c3 0f 1f 80 00 00 00 00 48 8b 45 10 0f 05 c3 83 e2 39 83 fa 08 75 e7 e8 03 ff ff ff 0f 1f 00 f3 0f 1e fa [ 27.521534][ C1] RSP: 002b:00007fff740663f0 EFLAGS: 00000202 ORIG_RAX: 000000000000002c [ 27.521535][ C1] RAX: ffffffffffffffda RBX: 00005595f5c005e2 RCX: 00007fbef4a5054e [ 27.521536][ C1] RDX: 0000000000001f6a RSI: 00005595f5c005e2 RDI: 0000000000000005 [ 27.521537][ C1] RBP: 00007fff74066400 R08: 00007fff74066450 R09: 0000000000000014 [ 27.521538][ C1] R10: 0000000000000000 R11: 0000000000000202 R12: 00005595f5bfd830 [ 27.521539][ C1] R13: 0000000000001f6a R14: 0000000000000005 R15: 00005595f5bfd830 [ 27.521541][ C1] [ 27.551113][ C1] ======================================================== [ 27.551408][ C1] WARNING: possible irq lock inversion dependency detected [ 27.551639][ C1] 7.2.0-virtme #1 Tainted: G W [ 27.551832][ C1] -------------------------------------------------------- [ 27.552121][ C1] mausezahn/584 just changed the state of lock: [ 27.552317][ C1] ff11000002192e58 (&br->lock){+.-.}-{3:3}, at: br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 27.552640][ C1] but this lock took another, SOFTIRQ-unsafe lock in the past: [ 27.552873][ C1] (fs_reclaim){+.+.}-{0:0} [ 27.552875][ C1] [ 27.552875][ C1] [ 27.552875][ C1] and interrupts could create inverse lock ordering between them. [ 27.552875][ C1] [ 27.553583][ C1] [ 27.553583][ C1] other info that might help us debug this: [ 27.553814][ C1] Chain exists of: [ 27.553814][ C1] &br->lock --> console_owner --> fs_reclaim [ 27.553814][ C1] [ 27.554276][ C1] Possible interrupt unsafe locking scenario: [ 27.554276][ C1] [ 27.554511][ C1] CPU0 CPU1 [ 27.554666][ C1] ---- ---- [ 27.554824][ C1] lock(fs_reclaim); [ 27.554942][ C1] local_irq_disable(); [ 27.555136][ C1] lock(&br->lock); [ 27.555448][ C1] lock(console_owner); [ 27.555703][ C1] [ 27.555819][ C1] lock(&br->lock); [ 27.555937][ C1] [ 27.555937][ C1] *** DEADLOCK *** [ 27.555937][ C1] [ 27.556175][ C1] locks held by mausezahn/584: 2, last CPU#1: [ 27.556432][ C1] #0: ffffffff97d80b00 (rcu_read_lock){....}-{1:3}, at: unwind_next_frame+0x17e/0x1ea0 [ 27.556763][ C1] #1: ffa00000001d0c90 ((&p->forward_delay_timer)){+.-.}-{0:0}, at: call_timer_fn+0x110/0x4d0 [ 27.557161][ C1] [ 27.557161][ C1] the shortest dependencies between 2nd lock and 1st lock: [ 27.560560][ C1] -> (fs_reclaim){+.+.}-{0:0} { [ 27.560742][ C1] HARDIRQ-ON-W at: [ 27.560866][ C1] __lock_acquire+0x388/0xc20 [ 27.561068][ C1] lock_acquire.part.0+0xd4/0x280 [ 27.561267][ C1] fs_reclaim_acquire+0xd5/0x120 [ 27.561526][ C1] __kmalloc_cache_noprof+0x6e/0x620 [ 27.561760][ C1] kthread_create_worker_on_node+0xea/0x210 [ 27.561994][ C1] workqueue_init+0x2a/0x680 [ 27.562255][ C1] kernel_init_freeable+0x2fe/0x630 [ 27.562492][ C1] kernel_init+0x21/0x150 [ 27.562690][ C1] ret_from_fork+0x474/0x6b0 [ 27.562888][ C1] ret_from_fork_asm+0x11/0x20 [ 27.563087][ C1] SOFTIRQ-ON-W at: [ 27.563205][ C1] __lock_acquire+0x388/0xc20 [ 27.563404][ C1] lock_acquire.part.0+0xd4/0x280 [ 27.563600][ C1] fs_reclaim_acquire+0xd5/0x120 [ 27.563808][ C1] __kmalloc_cache_noprof+0x6e/0x620 [ 27.564103][ C1] kthread_create_worker_on_node+0xea/0x210 [ 27.564361][ C1] workqueue_init+0x2a/0x680 [ 27.564611][ C1] kernel_init_freeable+0x2fe/0x630 [ 27.564901][ C1] kernel_init+0x21/0x150 [ 27.565105][ C1] ret_from_fork+0x474/0x6b0 [ 27.565350][ C1] ret_from_fork_asm+0x11/0x20 [ 27.565582][ C1] INITIAL USE at: [ 27.565769][ C1] __lock_acquire+0x388/0xc20 [ 27.566026][ C1] lock_acquire.part.0+0xd4/0x280 [ 27.566228][ C1] fs_reclaim_acquire+0xd5/0x120 [ 27.566482][ C1] __kmalloc_cache_noprof+0x6e/0x620 [ 27.566716][ C1] kthread_create_worker_on_node+0xea/0x210 [ 27.566949][ C1] workqueue_init+0x2a/0x680 [ 27.567161][ C1] kernel_init_freeable+0x2fe/0x630 [ 27.567399][ C1] kernel_init+0x21/0x150 [ 27.567627][ C1] ret_from_fork+0x474/0x6b0 [ 27.567880][ C1] ret_from_fork_asm+0x11/0x20 [ 27.568076][ C1] } [ 27.568160][ C1] ... key at: [] __fs_reclaim_map+0x0/0xbe0 [ 27.568402][ C1] ... acquired at: [ 27.568523][ C1] __lock_acquire+0x518/0xc20 [ 27.568682][ C1] lock_acquire.part.0+0xd4/0x280 [ 27.568836][ C1] fs_reclaim_acquire+0xd5/0x120 [ 27.568990][ C1] __kmalloc_noprof+0xd3/0x760 [ 27.569207][ C1] alloc_buf.isra.0+0x4b/0x260 [ 27.569422][ C1] put_chars+0x1e1/0x2f0 [ 27.569579][ C1] hvc_console_print+0x292/0x780 [ 27.569734][ C1] console_emit_next_record+0x22f/0x4c0 [ 27.569888][ C1] console_flush_one_record+0x46f/0x710 [ 27.570043][ C1] console_unlock+0xee/0x1f0 [ 27.570303][ C1] vprintk_emit+0x37c/0x3e0 [ 27.570466][ C1] _printk+0xc7/0x100 [ 27.570586][ C1] sock_register+0x12d/0x290 [ 27.570744][ C1] inet6_init+0x1a6/0x3e0 [ 27.570954][ C1] do_one_initcall+0x124/0x4f0 [ 27.571115][ C1] kernel_init_freeable+0x596/0x630 [ 27.571268][ C1] kernel_init+0x21/0x150 [ 27.571482][ C1] ret_from_fork+0x474/0x6b0 [ 27.571638][ C1] ret_from_fork_asm+0x11/0x20 [ 27.571792][ C1] [ 27.571873][ C1] -> (console_owner){....}-{0:0} { [ 27.572033][ C1] INITIAL USE at: [ 27.572155][ C1] } [ 27.572234][ C1] ... key at: [] console_owner_dep_map+0x0/0x60 [ 27.572469][ C1] ... acquired at: [ 27.572583][ C1] __lock_acquire+0x518/0xc20 [ 27.572794][ C1] lock_acquire.part.0+0xd4/0x280 [ 27.573001][ C1] console_lock_spinning_enable+0x5c/0x60 [ 27.573196][ C1] console_emit_next_record+0x1d1/0x4c0 [ 27.573354][ C1] console_flush_one_record+0x46f/0x710 [ 27.573511][ C1] console_unlock+0xee/0x1f0 [ 27.573665][ C1] vprintk_emit+0x37c/0x3e0 [ 27.573818][ C1] _printk+0xc7/0x100 [ 27.573988][ C1] br_set_state+0x22f/0x430 [bridge] [ 27.574154][ C1] br_init_port+0xc4/0x200 [bridge] [ 27.574316][ C1] br_stp_enable_bridge+0x1fc/0x340 [bridge] [ 27.574517][ C1] br_dev_open+0x94/0x120 [bridge] [ 27.574677][ C1] __dev_open+0x2f3/0x610 [ 27.574834][ C1] __dev_change_flags+0x4a4/0x660 [ 27.575045][ C1] netif_change_flags+0x87/0x190 [ 27.575323][ C1] do_setlink.isra.0+0x1cc3/0x2750 [ 27.575509][ C1] rtnl_newlink+0x9f1/0x11c0 [ 27.575693][ C1] rtnetlink_rcv_msg+0x6fd/0xbd0 [ 27.575903][ C1] netlink_rcv_skb+0x14e/0x3a0 [ 27.576119][ C1] netlink_unicast+0x486/0x750 [ 27.576272][ C1] netlink_sendmsg+0x735/0xc60 [ 27.576489][ C1] ____sys_sendmsg+0x415/0x880 [ 27.576644][ C1] ___sys_sendmsg+0x14e/0x1d0 [ 27.576798][ C1] __sys_sendmsg+0x12c/0x1d0 [ 27.577005][ C1] do_syscall_64+0xff/0x530 [ 27.577172][ C1] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 27.577382][ C1] [ 27.577460][ C1] -> (&br->lock){+.-.}-{3:3} { [ 27.577616][ C1] HARDIRQ-ON-W at: [ 27.577735][ C1] __lock_acquire+0x388/0xc20 [ 27.577928][ C1] lock_acquire.part.0+0xd4/0x280 [ 27.578122][ C1] _raw_spin_lock_bh+0x38/0x50 [ 27.578377][ C1] br_add_if+0x8c1/0x1320 [bridge] [ 27.578579][ C1] do_set_master+0x357/0x580 [ 27.578772][ C1] do_setlink.isra.0+0xa31/0x2750 [ 27.579019][ C1] rtnl_newlink+0x9f1/0x11c0 [ 27.579271][ C1] rtnetlink_rcv_msg+0x6fd/0xbd0 [ 27.579468][ C1] netlink_rcv_skb+0x14e/0x3a0 [ 27.579717][ C1] netlink_unicast+0x486/0x750 [ 27.579967][ C1] netlink_sendmsg+0x735/0xc60 [ 27.580202][ C1] ____sys_sendmsg+0x415/0x880 [ 27.580494][ C1] ___sys_sendmsg+0x14e/0x1d0 [ 27.580700][ C1] __sys_sendmsg+0x12c/0x1d0 [ 27.580894][ C1] do_syscall_64+0xff/0x530 [ 27.581146][ C1] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 27.581382][ C1] IN-SOFTIRQ-W at: [ 27.581497][ C1] __lock_acquire+0x388/0xc20 [ 27.581745][ C1] lock_acquire.part.0+0xd4/0x280 [ 27.581936][ C1] _raw_spin_lock+0x33/0x40 [ 27.582132][ C1] br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 27.582376][ C1] call_timer_fn+0x160/0x4d0 [ 27.582570][ C1] __run_timers+0x68f/0xaa0 [ 27.582765][ C1] run_timer_softirq+0xf0/0x160 [ 27.583016][ C1] handle_softirqs+0x1d3/0x900 [ 27.583214][ C1] __irq_exit_rcu+0x145/0x1c0 [ 27.583412][ C1] irq_exit_rcu+0xe/0x30 [ 27.583607][ C1] sysvec_apic_timer_interrupt+0x9d/0xe0 [ 27.583837][ C1] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 27.584067][ C1] check_preemption_disabled+0xf/0xe0 [ 27.584302][ C1] rcu_is_watching+0x16/0xd0 [ 27.584498][ C1] unwind_next_frame+0x6e9/0x1ea0 [ 27.584691][ C1] arch_stack_walk+0xd7/0x130 [ 27.584941][ C1] stack_trace_save+0x93/0xc0 [ 27.585138][ C1] kasan_save_stack+0x2f/0x50 [ 27.585347][ C1] kasan_save_track+0x14/0x30 [ 27.585546][ C1] __kasan_slab_alloc+0x60/0x70 [ 27.585737][ C1] kmem_cache_alloc_node_noprof+0x25c/0x660 [ 27.586025][ C1] kmalloc_reserve+0x103/0x2d0 [ 27.586222][ C1] __alloc_skb+0x11e/0x5f0 [ 27.586417][ C1] alloc_skb_with_frags+0xcc/0x6c0 [ 27.586611][ C1] sock_alloc_send_pskb+0x327/0x3f0 [ 27.586802][ C1] packet_snd+0x5dd/0x1840 [ 27.587055][ C1] __sys_sendto+0x2aa/0x400 [ 27.587255][ C1] __x64_sys_sendto+0xe4/0x1f0 [ 27.587451][ C1] do_syscall_64+0xff/0x530 [ 27.587641][ C1] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 27.587872][ C1] INITIAL USE at: [ 27.587987][ C1] __lock_acquire+0x388/0xc20 [ 27.588237][ C1] lock_acquire.part.0+0xd4/0x280 [ 27.588459][ C1] _raw_spin_lock_bh+0x38/0x50 [ 27.588653][ C1] br_add_if+0x8c1/0x1320 [bridge] [ 27.588848][ C1] do_set_master+0x357/0x580 [ 27.589039][ C1] do_setlink.isra.0+0xa31/0x2750 [ 27.592776][ C1] rtnl_newlink+0x9f1/0x11c0 [ 27.592983][ C1] rtnetlink_rcv_msg+0x6fd/0xbd0 [ 27.593181][ C1] netlink_rcv_skb+0x14e/0x3a0 [ 27.593382][ C1] netlink_unicast+0x486/0x750 [ 27.593630][ C1] netlink_sendmsg+0x735/0xc60 [ 27.593822][ C1] ____sys_sendmsg+0x415/0x880 [ 27.594013][ C1] ___sys_sendmsg+0x14e/0x1d0 [ 27.594262][ C1] __sys_sendmsg+0x12c/0x1d0 [ 27.594497][ C1] do_syscall_64+0xff/0x530 [ 27.594721][ C1] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 27.594960][ C1] } [ 27.595096][ C1] ... key at: [] __key.7+0x0/0x40 [bridge] [ 27.595337][ C1] ... acquired at: [ 27.595452][ C1] mark_lock+0x1d7/0xa00 [ 27.595665][ C1] mark_usage+0x42/0x170 [ 27.595875][ C1] __lock_acquire+0x388/0xc20 [ 27.596030][ C1] lock_acquire.part.0+0xd4/0x280 [ 27.596191][ C1] _raw_spin_lock+0x33/0x40 [ 27.596356][ C1] br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 27.596553][ C1] call_timer_fn+0x160/0x4d0 [ 27.596708][ C1] __run_timers+0x68f/0xaa0 [ 27.596862][ C1] run_timer_softirq+0xf0/0x160 [ 27.597019][ C1] handle_softirqs+0x1d3/0x900 [ 27.597178][ C1] __irq_exit_rcu+0x145/0x1c0 [ 27.597335][ C1] irq_exit_rcu+0xe/0x30 [ 27.597490][ C1] sysvec_apic_timer_interrupt+0x9d/0xe0 [ 27.597681][ C1] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 27.597927][ C1] check_preemption_disabled+0xf/0xe0 [ 27.598081][ C1] rcu_is_watching+0x16/0xd0 [ 27.598334][ C1] unwind_next_frame+0x6e9/0x1ea0 [ 27.598488][ C1] arch_stack_walk+0xd7/0x130 [ 27.598641][ C1] stack_trace_save+0x93/0xc0 [ 27.598792][ C1] kasan_save_stack+0x2f/0x50 [ 27.598947][ C1] kasan_save_track+0x14/0x30 [ 27.599100][ C1] __kasan_slab_alloc+0x60/0x70 [ 27.599311][ C1] kmem_cache_alloc_node_noprof+0x25c/0x660 [ 27.599503][ C1] kmalloc_reserve+0x103/0x2d0 [ 27.599661][ C1] __alloc_skb+0x11e/0x5f0 [ 27.599814][ C1] alloc_skb_with_frags+0xcc/0x6c0 [ 27.600019][ C1] sock_alloc_send_pskb+0x327/0x3f0 [ 27.600228][ C1] packet_snd+0x5dd/0x1840 [ 27.600391][ C1] __sys_sendto+0x2aa/0x400 [ 27.600545][ C1] __x64_sys_sendto+0xe4/0x1f0 [ 27.600698][ C1] do_syscall_64+0xff/0x530 [ 27.600852][ C1] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 27.601100][ C1] [ 27.601176][ C1] [ 27.601176][ C1] stack backtrace: [ 27.601375][ C1] CPU: 1 UID: 0 PID: 584 Comm: mausezahn Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 27.601378][ C1] Tainted: [W]=WARN [ 27.601379][ C1] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 27.601380][ C1] Call Trace: [ 27.601382][ C1] [ 27.601383][ C1] dump_stack_lvl+0x6f/0xa0 [ 27.601388][ C1] print_irq_inversion_bug.part.0.cold+0xe6/0x143 [ 27.601391][ C1] mark_lock_irq+0x989/0x9c0 [ 27.601394][ C1] mark_lock+0x1d7/0xa00 [ 27.601396][ C1] mark_usage+0x42/0x170 [ 27.601397][ C1] __lock_acquire+0x388/0xc20 [ 27.601399][ C1] lock_acquire.part.0+0xd4/0x280 [ 27.601401][ C1] ? br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 27.601408][ C1] ? rcu_is_watching+0x16/0xd0 [ 27.601410][ C1] ? lock_acquire+0x13c/0x160 [ 27.601412][ C1] ? br_message_age_timer_expired+0x70/0x70 [bridge] [ 27.601418][ C1] _raw_spin_lock+0x33/0x40 [ 27.601420][ C1] ? br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 27.601426][ C1] br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 27.601433][ C1] ? br_message_age_timer_expired+0x70/0x70 [bridge] [ 27.601439][ C1] call_timer_fn+0x160/0x4d0 [ 27.601441][ C1] ? sysvec_apic_timer_interrupt+0x4c/0xe0 [ 27.601443][ C1] ? detach_if_pending+0x1d0/0x1d0 [ 27.601445][ C1] ? _raw_spin_unlock_irq+0x28/0x50 [ 27.601447][ C1] __run_timers+0x68f/0xaa0 [ 27.601449][ C1] ? br_message_age_timer_expired+0x70/0x70 [bridge] [ 27.601456][ C1] ? __bpf_trace_itimer_expire+0x10/0x10 [ 27.601458][ C1] ? __lock_acquire+0x518/0xc20 [ 27.601460][ C1] ? __rwlock_init+0x150/0x150 [ 27.601463][ C1] run_timer_softirq+0xf0/0x160 [ 27.601465][ C1] ? __run_timers+0xaa0/0xaa0 [ 27.601467][ C1] ? rcu_is_watching+0x16/0xd0 [ 27.601468][ C1] handle_softirqs+0x1d3/0x900 [ 27.601470][ C1] ? __lock_release.isra.0+0x69/0x1a0 [ 27.601472][ C1] ? _local_bh_enable+0xc0/0xc0 [ 27.601474][ C1] __irq_exit_rcu+0x145/0x1c0 [ 27.601475][ C1] irq_exit_rcu+0xe/0x30 [ 27.601477][ C1] sysvec_apic_timer_interrupt+0x9d/0xe0 [ 27.601479][ C1] [ 27.601479][ C1] [ 27.601480][ C1] ? find_held_lock+0x2/0x80 [ 27.601481][ C1] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 27.601483][ C1] RIP: 0010:check_preemption_disabled+0xf/0xe0 [ 27.601485][ C1] Code: 85 d2 75 0f 65 8b 05 84 c9 f5 01 85 c0 74 04 90 0f 0b 90 e9 93 fb ff ff 0f 1f 00 65 8b 15 21 87 f5 01 65 44 8b 15 29 87 f5 01 <85> d2 74 04 44 89 d0 c3 9c 58 f6 c4 02 74 f5 65 48 8b 15 fa 86 f5 [ 27.601487][ C1] RSP: 0018:ffa00000006474f8 EFLAGS: 00000282 [ 27.601489][ C1] RAX: 0000000000000001 RBX: 1ff40000000c8eac RCX: ffa0000000640000 [ 27.601490][ C1] RDX: 0000000000000001 RSI: ffffffff9728d860 RDI: ffffffff9728d8a0 [ 27.601491][ C1] RBP: 00007fff740663f0 R08: ffa0000000647678 R09: ffa00000006475a0 [ 27.601492][ C1] R10: 0000000000000001 R11: 0000000000000001 R12: 0000000000000001 [ 27.601493][ C1] R13: ffa0000000647618 R14: ff1100000a17a380 R15: 0000000000082cc0 [ 27.601495][ C1] rcu_is_watching+0x16/0xd0 [ 27.601497][ C1] unwind_next_frame+0x6e9/0x1ea0 [ 27.601499][ C1] ? entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 27.601501][ C1] ? __lock_acquire+0x518/0xc20 [ 27.601502][ C1] ? stack_access_ok+0x1e0/0x1e0 [ 27.601503][ C1] ? find_held_lock+0x2/0x80 [ 27.601505][ C1] ? __unwind_start+0x42e/0x900 [ 27.601506][ C1] ? write_profile+0xf0/0xf0 [ 27.601508][ C1] arch_stack_walk+0xd7/0x130 [ 27.601511][ C1] stack_trace_save+0x93/0xc0 [ 27.601512][ C1] ? filter_irq_stacks+0xd0/0xd0 [ 27.601514][ C1] ? is_bpf_text_address+0x72/0x110 [ 27.601517][ C1] ? kernel_text_address+0x149/0x170 [ 27.601520][ C1] kasan_save_stack+0x2f/0x50 [ 27.601521][ C1] ? kasan_save_stack+0x2f/0x50 [ 27.601523][ C1] ? kasan_save_track+0x14/0x30 [ 27.601524][ C1] ? __kasan_slab_alloc+0x60/0x70 [ 27.601526][ C1] ? kmem_cache_alloc_node_noprof+0x25c/0x660 [ 27.601527][ C1] ? kmalloc_reserve+0x103/0x2d0 [ 27.601528][ C1] ? __alloc_skb+0x11e/0x5f0 [ 27.601530][ C1] ? alloc_skb_with_frags+0xcc/0x6c0 [ 27.601532][ C1] ? sock_alloc_send_pskb+0x327/0x3f0 [ 27.601533][ C1] ? packet_snd+0x5dd/0x1840 [ 27.601534][ C1] ? __sys_sendto+0x2aa/0x400 [ 27.601536][ C1] ? __x64_sys_sendto+0xe4/0x1f0 [ 27.601537][ C1] ? do_syscall_64+0xff/0x530 [ 27.601538][ C1] ? entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 27.601543][ C1] kasan_save_track+0x14/0x30 [ 27.601544][ C1] __kasan_slab_alloc+0x60/0x70 [ 27.601546][ C1] kmem_cache_alloc_node_noprof+0x25c/0x660 [ 27.601548][ C1] ? kmalloc_reserve+0x103/0x2d0 [ 27.601550][ C1] kmalloc_reserve+0x103/0x2d0 [ 27.601552][ C1] __alloc_skb+0x11e/0x5f0 [ 27.601554][ C1] ? __alloc_skb+0x4c2/0x5f0 [ 27.601555][ C1] ? napi_skb_cache_get+0x830/0x830 [ 27.601557][ C1] ? mark_usage+0x61/0x170 [ 27.601558][ C1] ? ref_tracker_alloc+0x2e7/0x430 [ 27.601562][ C1] ? ref_tracker_dir_print+0x100/0x100 [ 27.601563][ C1] alloc_skb_with_frags+0xcc/0x6c0 [ 27.601565][ C1] ? find_held_lock+0x2b/0x80 [ 27.601567][ C1] sock_alloc_send_pskb+0x327/0x3f0 [ 27.601569][ C1] packet_snd+0x5dd/0x1840 [ 27.601572][ C1] ? tpacket_snd+0x1990/0x1990 [ 27.601575][ C1] ? __might_fault+0x97/0x140 [ 27.601578][ C1] ? __might_fault+0x97/0x140 [ 27.601580][ C1] __sys_sendto+0x2aa/0x400 [ 27.601582][ C1] ? __ia32_sys_getpeername+0xd0/0xd0 [ 27.601584][ C1] ? sock_ioctl+0x3cb/0x5f0 [ 27.601587][ C1] ? __lock_release.isra.0+0x69/0x1a0 [ 27.601589][ C1] __x64_sys_sendto+0xe4/0x1f0 [ 27.601591][ C1] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 27.601593][ C1] ? lockdep_hardirqs_on+0x91/0x130 [ 27.601594][ C1] ? do_syscall_64+0xa6/0x530 [ 27.601595][ C1] do_syscall_64+0xff/0x530 [ 27.601597][ C1] ? irq_exit_rcu+0x1a/0x30 [ 27.601598][ C1] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 27.601599][ C1] RIP: 0033:0x7fbef4a5054e [ 27.601601][ C1] Code: 4d 89 d8 e8 b4 bd 00 00 4c 8b 5d f8 41 8b 93 08 03 00 00 59 5e 48 83 f8 fc 74 11 c9 c3 0f 1f 80 00 00 00 00 48 8b 45 10 0f 05 c3 83 e2 39 83 fa 08 75 e7 e8 03 ff ff ff 0f 1f 00 f3 0f 1e fa [ 27.601602][ C1] RSP: 002b:00007fff740663f0 EFLAGS: 00000202 ORIG_RAX: 000000000000002c [ 27.601604][ C1] RAX: ffffffffffffffda RBX: 00005595f5c005e2 RCX: 00007fbef4a5054e [ 27.601605][ C1] RDX: 0000000000001f6a RSI: 00005595f5c005e2 RDI: 0000000000000005 [ 27.601605][ C1] RBP: 00007fff74066400 R08: 00007fff74066450 R09: 0000000000000014 [ 27.601606][ C1] R10: 0000000000000000 R11: 0000000000000202 R12: 00005595f5bfd830 [ 27.601607][ C1] R13: 0000000000001f6a R14: 0000000000000005 R15: 00005595f5bfd830 [ 27.601609][ C1] [ 391.304312][ T1970] br12: port 2(veth2.12) entered disabled state [ 391.304329][ T1970] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 391.304331][ T1970] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 1970, name: ip [ 391.304333][ T1970] preempt_count: 202, expected: 0 [ 391.304334][ T1970] RCU nest depth: 0, expected: 0 [ 391.304335][ T1970] INFO: lockdep is turned off. [ 391.304336][ T1970] irq event stamp: 0 [ 391.304337][ T1970] hardirqs last enabled at (0): [<0000000000000000>] 0x0 [ 391.304341][ T1970] hardirqs last disabled at (0): [] copy_process+0x1ccd/0x6240 [ 391.304347][ T1970] softirqs last enabled at (0): [] copy_process+0x1d21/0x6240 [ 391.304349][ T1970] softirqs last disabled at (0): [<0000000000000000>] 0x0 [ 391.304351][ T1970] Preemption disabled at: [ 391.304351][ T1970] [<0000000000000000>] 0x0 [ 391.304356][ T1970] CPU: 0 UID: 0 PID: 1970 Comm: ip Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 391.304359][ T1970] Tainted: [W]=WARN [ 391.304360][ T1970] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 391.304362][ T1970] Call Trace: [ 391.304364][ T1970] [ 391.304365][ T1970] dump_stack_lvl+0x6f/0xa0 [ 391.304370][ T1970] __might_resched.cold+0x1fe/0x2c1 [ 391.304374][ T1970] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 391.304378][ T1970] ? rcu_is_watching+0x16/0xd0 [ 391.304381][ T1970] __kmalloc_noprof+0x443/0x760 [ 391.304385][ T1970] ? __rwlock_init+0x150/0x150 [ 391.304388][ T1970] ? alloc_buf.isra.0+0x4b/0x260 [ 391.304391][ T1970] ? do_raw_spin_unlock+0x59/0x250 [ 391.304393][ T1970] alloc_buf.isra.0+0x4b/0x260 [ 391.304395][ T1970] put_chars+0x1e1/0x2f0 [ 391.304397][ T1970] ? __send_to_port+0x420/0x420 [ 391.304398][ T1970] ? printk_get_next_message+0x240/0x650 [ 391.304402][ T1970] hvc_console_print+0x292/0x780 [ 391.304405][ T1970] ? hvc_write+0x3a0/0x3a0 [ 391.304407][ T1970] ? __rwlock_init+0x150/0x150 [ 391.304408][ T1970] ? rcu_is_watching+0x16/0xd0 [ 391.304410][ T1970] ? lock_acquire+0x13c/0x160 [ 391.304412][ T1970] console_emit_next_record+0x22f/0x4c0 [ 391.304415][ T1970] ? devkmsg_read+0x4b0/0x4b0 [ 391.304417][ T1970] ? rcu_is_watching+0x16/0xd0 [ 391.304419][ T1970] ? rcu_is_watching+0x16/0xd0 [ 391.304420][ T1970] ? rcu_is_watching+0x16/0xd0 [ 391.304422][ T1970] ? lock_acquire+0x13c/0x160 [ 391.304424][ T1970] ? console_flush_one_record+0x111/0x710 [ 391.304425][ T1970] console_flush_one_record+0x46f/0x710 [ 391.304428][ T1970] ? console_emit_next_record+0x4c0/0x4c0 [ 391.304430][ T1970] console_unlock+0xee/0x1f0 [ 391.304432][ T1970] ? lock_acquire+0x13c/0x160 [ 391.304434][ T1970] ? console_flush_one_record+0x710/0x710 [ 391.304435][ T1970] ? rcu_is_watching+0x16/0xd0 [ 391.304437][ T1970] ? lock_release+0x184/0x1f0 [ 391.304438][ T1970] ? lock_acquire+0x60/0x160 [ 391.304440][ T1970] ? __rcu_read_lock+0x30/0x70 [ 391.304442][ T1970] ? __down_trylock_console_sem+0x5e/0xa0 [ 391.304443][ T1970] ? vprintk_emit+0x320/0x3e0 [ 391.304445][ T1970] vprintk_emit+0x37c/0x3e0 [ 391.304448][ T1970] ? wake_up_klogd_work_func+0x90/0x90 [ 391.304450][ T1970] ? rcu_is_watching+0x16/0xd0 [ 391.304451][ T1970] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 391.304454][ T1970] ? trace_hardirqs_on+0x36/0x40 [ 391.304456][ T1970] _printk+0xc7/0x100 [ 391.304459][ T1970] ? snapshot_read.cold+0x21/0x21 [ 391.304461][ T1970] ? ipv6_mc_down+0x17e/0x2d0 [ 391.304465][ T1970] br_set_state+0x22f/0x430 [bridge] [ 391.304478][ T1970] br_stp_disable_port+0x11f/0x390 [bridge] [ 391.304488][ T1970] br_device_event+0x7b5/0x8f0 [bridge] [ 391.304500][ T1970] ? _raw_spin_unlock_irqrestore+0x40/0x80 [ 391.304504][ T1970] ? _sub_I_65535_1+0x4d0/0x4d0 [stp] [ 391.304506][ T1970] ? addrconf_notify+0x2c8/0xf30 [ 391.304509][ T1970] notifier_call_chain+0xae/0x300 [ 391.304512][ T1970] __dev_notify_flags+0x23c/0x3c0 [ 391.304516][ T1970] ? netif_change_name+0x8c0/0x8c0 [ 391.304518][ T1970] ? netif_set_allmulti+0x250/0x250 [ 391.304520][ T1970] ? __kernel_text_address+0x12/0x30 [ 391.304522][ T1970] ? write_profile+0xf0/0xf0 [ 391.304525][ T1970] ? unwind_get_return_address+0x67/0xd0 [ 391.304527][ T1970] netif_change_flags+0xfe/0x190 [ 391.304530][ T1970] do_setlink.isra.0+0x1cc3/0x2750 [ 391.304532][ T1970] ? stack_trace_save+0x93/0xc0 [ 391.304534][ T1970] ? rtnl_link_get_size+0x350/0x350 [ 391.304535][ T1970] ? rcu_is_watching+0x16/0xd0 [ 391.304537][ T1970] ? stack_depot_save_flags+0x1bc/0x790 [ 391.304540][ T1970] ? kasan_save_stack+0x3d/0x50 [ 391.304544][ T1970] ? kasan_save_stack+0x2f/0x50 [ 391.304545][ T1970] ? kasan_save_track+0x14/0x30 [ 391.304546][ T1970] ? __kasan_kmalloc+0x7b/0x90 [ 391.304548][ T1970] ? __kmalloc_cache_noprof+0x29a/0x620 [ 391.304550][ T1970] ? rtnl_newlink+0x124/0x11c0 [ 391.304551][ T1970] ? rtnetlink_rcv_msg+0x6fd/0xbd0 [ 391.304552][ T1970] ? netlink_rcv_skb+0x14e/0x3a0 [ 391.304554][ T1970] ? netlink_unicast+0x486/0x750 [ 391.304556][ T1970] ? netlink_sendmsg+0x735/0xc60 [ 391.304557][ T1970] ? ____sys_sendmsg+0x415/0x880 [ 391.304559][ T1970] ? ___sys_sendmsg+0x14e/0x1d0 [ 391.304561][ T1970] ? __sys_sendmsg+0x12c/0x1d0 [ 391.304562][ T1970] ? do_syscall_64+0xff/0x530 [ 391.304564][ T1970] ? entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 391.304567][ T1970] ? rcu_is_watching+0x16/0xd0 [ 391.304568][ T1970] ? lock_acquire+0x13c/0x160 [ 391.304570][ T1970] ? rcu_is_watching+0x16/0xd0 [ 391.304571][ T1970] ? rcu_is_watching+0x16/0xd0 [ 391.304573][ T1970] ? trace_contention_end+0xb3/0x180 [ 391.304576][ T1970] ? __mutex_lock+0x1db/0x1ea0 [ 391.304577][ T1970] ? __mutex_lock+0x9a3/0x1ea0 [ 391.304579][ T1970] ? rtnl_newlink+0x9a8/0x11c0 [ 391.304580][ T1970] ? ww_mutex_lock+0x160/0x160 [ 391.304582][ T1970] ? __rtnl_newlink+0x3fa/0xa50 [ 391.304585][ T1970] rtnl_newlink+0x9f1/0x11c0 [ 391.304587][ T1970] ? rcu_is_watching+0x16/0xd0 [ 391.304588][ T1970] ? rtnl_bridge_getlink+0x850/0x850 [ 391.304589][ T1970] ? lock_acquire+0x13c/0x160 [ 391.304591][ T1970] ? rcu_is_watching+0x16/0xd0 [ 391.304593][ T1970] ? is_bpf_text_address+0x3e/0x110 [ 391.304596][ T1970] ? is_bpf_text_address+0x72/0x110 [ 391.304598][ T1970] ? kernel_text_address+0x149/0x170 [ 391.304599][ T1970] ? __kernel_text_address+0x12/0x30 [ 391.304600][ T1970] ? write_profile+0xf0/0xf0 [ 391.304601][ T1970] ? unwind_get_return_address+0x67/0xd0 [ 391.304603][ T1970] ? rcu_is_watching+0x16/0xd0 [ 391.304605][ T1970] ? rcu_is_watching+0x16/0xd0 [ 391.304606][ T1970] ? cap_capable+0x1d7/0x3d0 [ 391.304610][ T1970] ? lock_acquire+0x13c/0x160 [ 391.304611][ T1970] ? rcu_is_watching+0x16/0xd0 [ 391.304613][ T1970] ? rtnl_bridge_getlink+0x850/0x850 [ 391.304614][ T1970] rtnetlink_rcv_msg+0x6fd/0xbd0 [ 391.304616][ T1970] ? rtnl_link_fill+0x920/0x920 [ 391.304617][ T1970] ? filter_irq_stacks+0xd0/0xd0 [ 391.304619][ T1970] ? stack_depot_save_flags+0x1bc/0x790 [ 391.304621][ T1970] netlink_rcv_skb+0x14e/0x3a0 [ 391.304622][ T1970] ? rtnl_link_fill+0x920/0x920 [ 391.304624][ T1970] ? lock_release+0x184/0x1f0 [ 391.304625][ T1970] ? netlink_ack+0xcf0/0xcf0 [ 391.304626][ T1970] ? __netlink_lookup+0xb9/0x6b0 [ 391.304629][ T1970] ? rcu_is_watching+0x16/0xd0 [ 391.304631][ T1970] ? lock_release+0x184/0x1f0 [ 391.304633][ T1970] netlink_unicast+0x486/0x750 [ 391.304635][ T1970] ? netlink_attachskb+0x810/0x810 [ 391.304636][ T1970] ? rcu_is_watching+0x16/0xd0 [ 391.304638][ T1970] ? rcu_is_watching+0x16/0xd0 [ 391.304639][ T1970] ? lock_acquire+0x13c/0x160 [ 391.304641][ T1970] netlink_sendmsg+0x735/0xc60 [ 391.304643][ T1970] ? netlink_unicast+0x750/0x750 [ 391.304645][ T1970] ? rcu_is_watching+0x16/0xd0 [ 391.304647][ T1970] ? lock_release+0x184/0x1f0 [ 391.304649][ T1970] ____sys_sendmsg+0x415/0x880 [ 391.304650][ T1970] ? copy_msghdr_from_user+0x279/0x420 [ 391.304652][ T1970] ? get_timestamp.constprop.0+0x390/0x390 [ 391.304653][ T1970] ? move_addr_to_kernel+0x40/0x40 [ 391.304655][ T1970] ? filter_irq_stacks+0xd0/0xd0 [ 391.304657][ T1970] ___sys_sendmsg+0x14e/0x1d0 [ 391.304659][ T1970] ? copy_msghdr_from_user+0x420/0x420 [ 391.304664][ T1970] __sys_sendmsg+0x12c/0x1d0 [ 391.304666][ T1970] ? __sys_sendmsg_sock+0x20/0x20 [ 391.304669][ T1970] ? rcu_is_watching+0x16/0xd0 [ 391.304671][ T1970] do_syscall_64+0xff/0x530 [ 391.304672][ T1970] ? exc_page_fault+0xee/0x100 [ 391.304674][ T1970] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 391.304676][ T1970] RIP: 0033:0x7f89b00a154e [ 391.304678][ T1970] 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 [ 391.304679][ T1970] RSP: 002b:00007ffc42629d30 EFLAGS: 00000202 ORIG_RAX: 000000000000002e [ 391.304683][ T1970] RAX: ffffffffffffffda RBX: 0000000000000003 RCX: 00007f89b00a154e [ 391.304685][ T1970] RDX: 0000000000000000 RSI: 00007ffc42629de0 RDI: 0000000000000005 [ 391.304685][ T1970] RBP: 00007ffc42629d40 R08: 0000000000000000 R09: 0000000000000000 [ 391.304686][ T1970] R10: 0000000000000000 R11: 0000000000000202 R12: 000000006a90fda4 [ 391.304687][ T1970] R13: 00000000004a1620 R14: 0000000000000000 R15: 00007ffc4262a4a0 [ 391.304689][ T1970] [ 391.344077][ T1970] ip (1970) used greatest stack depth: 23016 bytes left [ 391.360011][ T1973] br12: port 1(veth1.12) entered disabled state [ 391.411275][ T1977] veth2.12: left allmulticast mode [ 391.411451][ T1977] veth2.12: left promiscuous mode [ 391.411762][ T1977] br12: port 2(veth2.12) entered disabled state [ 391.429801][ T1979] veth1.12: left allmulticast mode [ 391.429971][ T1979] veth1.12: left promiscuous mode [ 391.430277][ T1979] br12: port 1(veth1.12) entered disabled state [ 391.565451][ T1990] br11: port 2(veth2.11) entered disabled state [ 391.583267][ T1992] br11: port 1(veth1.11) entered disabled state [ 391.628386][ T1996] veth2.11: left allmulticast mode [ 391.628572][ T1996] veth2.11: left promiscuous mode [ 391.628860][ T1996] br11: port 2(veth2.11) entered disabled state [ 391.652401][ T1998] veth1.11: left allmulticast mode [ 391.652608][ T1998] veth1.11: left promiscuous mode [ 391.652946][ T1998] br11: port 1(veth1.11) entered disabled state [ 391.783465][ T2006] br10: port 2(veth2.10) entered disabled state [ 391.801897][ T2008] br10: port 1(veth1.10) entered disabled state [ 391.850661][ T2013] veth2.10: left allmulticast mode [ 391.850847][ T2013] veth2: left allmulticast mode [ 391.851002][ T2013] veth2.10: left promiscuous mode [ 391.851155][ T2013] veth2: left promiscuous mode [ 391.851439][ T2013] br10: port 2(veth2.10) entered disabled state [ 391.870764][ T2015] veth1.10: left allmulticast mode [ 391.870933][ T2015] veth1: left allmulticast mode [ 391.871113][ T2015] veth1.10: left promiscuous mode [ 391.871257][ T2015] veth1: left promiscuous mode [ 391.871562][ T2015] br10: port 1(veth1.10) entered disabled state