[ 11.248275][ T233] 8021q: 802.1Q VLAN Support v1.8 [ 11.248296][ T233] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 11.248298][ T233] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 233, name: modprobe [ 11.248300][ T233] preempt_count: 1, expected: 0 [ 11.248301][ T233] RCU nest depth: 0, expected: 0 [ 11.248302][ T233] locks held by modprobe/233: 4, last CPU#2: [ 11.248305][ T233] #0: ffffffff93969cc0 (console_lock){+.+.}-{0:0}, at: vprintk_emit+0x320/0x3e0 [ 11.248317][ T233] #1: ffffffff93969d38 (console_srcu){....}-{0:0}, at: console_flush_one_record+0x106/0x710 [ 11.248321][ T233] #2: ffffffff93889660 (console_owner){....}-{0:0}, at: console_lock_spinning_enable+0x40/0x60 [ 11.248325][ T233] #3: ffffffff93889560 (printk_legacy_map-wait-type-override){....}-{3:3}, at: console_emit_next_record+0x1df/0x4c0 [ 11.248329][ T233] irq event stamp: 23216 [ 11.248330][ T233] hardirqs last enabled at (23215): [] __down_trylock_console_sem+0x86/0xa0 [ 11.248333][ T233] hardirqs last disabled at (23216): [] console_emit_next_record+0x3d4/0x4c0 [ 11.248335][ T233] softirqs last enabled at (19668): [] handle_softirqs+0x67c/0x900 [ 11.248338][ T233] softirqs last disabled at (19659): [] __irq_exit_rcu+0x145/0x1c0 [ 11.248341][ T233] Preemption disabled at: [ 11.248341][ T233] [] vprintk_emit+0x31b/0x3e0 [ 11.248347][ T233] CPU: 2 UID: 0 PID: 233 Comm: modprobe Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 11.248351][ T233] Tainted: [W]=WARN [ 11.248352][ T233] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 11.248354][ T233] Call Trace: [ 11.248356][ T233] [ 11.248357][ T233] dump_stack_lvl+0x6f/0xa0 [ 11.248363][ T233] ? vprintk_emit+0x31b/0x3e0 [ 11.248365][ T233] __might_resched.cold+0x1fe/0x2c1 [ 11.248370][ T233] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 11.248374][ T233] ? __kmalloc_noprof+0xdb/0x760 [ 11.248379][ T233] __kmalloc_noprof+0x443/0x760 [ 11.248381][ T233] ? alloc_buf.isra.0+0x4b/0x260 [ 11.248387][ T233] ? do_raw_spin_unlock+0x59/0x250 [ 11.248390][ T233] alloc_buf.isra.0+0x4b/0x260 [ 11.248393][ T233] put_chars+0x1e1/0x2f0 [ 11.248395][ T233] ? __send_to_port+0x420/0x420 [ 11.248397][ T233] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 11.248402][ T233] ? rcu_read_lock_any_held+0x3c/0x90 [ 11.248404][ T233] ? validate_chain+0x38b/0xc20 [ 11.248408][ T233] hvc_console_print+0x292/0x780 [ 11.248411][ T233] ? __lock_acquire+0x518/0xc20 [ 11.248416][ T233] ? hvc_write+0x3a0/0x3a0 [ 11.248418][ T233] ? rcu_is_watching+0x16/0xd0 [ 11.248423][ T233] console_emit_next_record+0x22f/0x4c0 [ 11.248427][ T233] ? devkmsg_read+0x4b0/0x4b0 [ 11.248429][ T233] ? console_flush_one_record+0x106/0x710 [ 11.248432][ T233] ? rcu_is_watching+0x16/0xd0 [ 11.248434][ T233] ? lock_acquire+0x13c/0x160 [ 11.248438][ T233] console_flush_one_record+0x46f/0x710 [ 11.248441][ T233] ? console_emit_next_record+0x4c0/0x4c0 [ 11.248443][ T233] ? __lock_acquire+0x518/0xc20 [ 11.248448][ T233] console_unlock+0xee/0x1f0 [ 11.248451][ T233] ? console_flush_one_record+0x710/0x710 [ 11.248453][ T233] ? rcu_is_watching+0x16/0xd0 [ 11.248455][ T233] ? lock_acquire+0x60/0x160 [ 11.248458][ T233] ? __down_trylock_console_sem+0x5e/0xa0 [ 11.248460][ T233] ? vprintk_emit+0x320/0x3e0 [ 11.248463][ T233] vprintk_emit+0x37c/0x3e0 [ 11.248467][ T233] ? wake_up_klogd_work_func+0x90/0x90 [ 11.248473][ T233] ? vlan_netlink_fini+0x960/0x960 [8021q] [ 11.248476][ T233] _printk+0xc7/0x100 [ 11.248480][ T233] ? snapshot_read.cold+0x21/0x21 [ 11.248486][ T233] ? do_one_initcall+0x113/0x4f0 [ 11.248489][ T233] vlan_proto_init+0x24/0x90 [8021q] [ 11.248492][ T233] do_one_initcall+0x124/0x4f0 [ 11.248494][ T233] ? trace_event_raw_event_initcall_level+0x280/0x280 [ 11.248499][ T233] ? do_init_module+0xae/0x8a0 [ 11.248502][ T233] ? kasan_unpoison+0x44/0x70 [ 11.248507][ T233] do_init_module+0x2ad/0x8a0 [ 11.248510][ T233] ? lockdep_hardirqs_on+0x91/0x130 [ 11.248515][ T233] ? free_module+0x470/0x470 [ 11.248518][ T233] ? kfree+0x123/0x590 [ 11.248522][ T233] load_module+0x1424/0x1bb0 [ 11.248529][ T233] ? layout_and_allocate.isra.0+0x680/0x680 [ 11.248532][ T233] ? __ia32_sys_fsconfig+0x180/0x180 [ 11.248535][ T233] ? ovl_real_file+0x172/0x1e0 [ 11.248539][ T233] ? find_held_lock+0x2b/0x80 [ 11.248541][ T233] ? backing_file_read_iter+0x541/0x790 [ 11.248544][ T233] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 11.248547][ T233] init_module_from_file+0x11f/0x1a0 [ 11.248550][ T233] ? __do_sys_init_module+0x220/0x220 [ 11.248558][ T233] ? __rwlock_init+0x150/0x150 [ 11.248562][ T233] ? do_raw_spin_unlock+0x59/0x250 [ 11.248565][ T233] idempotent_init_module+0x37b/0x7c0 [ 11.248568][ T233] ? init_module_from_file+0x1a0/0x1a0 [ 11.248574][ T233] ? rcu_is_watching+0x16/0xd0 [ 11.248576][ T233] ? cap_capable+0x1d7/0x3d0 [ 11.248582][ T233] __x64_sys_finit_module+0xdf/0x190 [ 11.248584][ T233] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 11.248588][ T233] do_syscall_64+0xff/0x530 [ 11.248589][ T233] ? exc_page_fault+0xee/0x100 [ 11.248592][ T233] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 11.248595][ T233] RIP: 0033:0x7f108c4cc37d [ 11.248598][ T233] 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.248600][ T233] RSP: 002b:00007ffd47219c78 EFLAGS: 00000246 ORIG_RAX: 0000000000000139 [ 11.248603][ T233] RAX: ffffffffffffffda RBX: 000055becdc16810 RCX: 00007f108c4cc37d [ 11.248604][ T233] RDX: 0000000000000000 RSI: 000055bebaf3affd RDI: 0000000000000000 [ 11.248605][ T233] RBP: 00007ffd47219d10 R08: 0000000000000000 R09: 0000000000000000 [ 11.248606][ T233] R10: 0000000000000000 R11: 0000000000000246 R12: 000055bebaf3affd [ 11.248607][ T233] R13: 000055becdc16960 R14: 0000000000040000 R15: 0000000000000000 [ 11.248613][ T233] [ 12.742100][ T281] gre: GRE over IPv4 demultiplexer driver [ 12.742117][ T281] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 12.742120][ T281] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 281, name: modprobe [ 12.742121][ T281] preempt_count: 1, expected: 0 [ 12.742122][ T281] RCU nest depth: 0, expected: 0 [ 12.742123][ T281] locks held by modprobe/281: 4, last CPU#2: [ 12.742126][ T281] #0: ffffffff93969cc0 (console_lock){+.+.}-{0:0}, at: vprintk_emit+0x320/0x3e0 [ 12.742138][ T281] #1: ffffffff93969d38 (console_srcu){....}-{0:0}, at: console_flush_one_record+0x106/0x710 [ 12.742142][ T281] #2: ffffffff93889660 (console_owner){....}-{0:0}, at: console_lock_spinning_enable+0x40/0x60 [ 12.742146][ T281] #3: ffffffff93889560 (printk_legacy_map-wait-type-override){....}-{3:3}, at: console_emit_next_record+0x1df/0x4c0 [ 12.742150][ T281] irq event stamp: 28074 [ 12.742151][ T281] hardirqs last enabled at (28073): [] __down_trylock_console_sem+0x86/0xa0 [ 12.742154][ T281] hardirqs last disabled at (28074): [] console_emit_next_record+0x3d4/0x4c0 [ 12.742156][ T281] softirqs last enabled at (26432): [] handle_softirqs+0x67c/0x900 [ 12.742159][ T281] softirqs last disabled at (26423): [] __irq_exit_rcu+0x145/0x1c0 [ 12.742161][ T281] Preemption disabled at: [ 12.742162][ T281] [] vprintk_emit+0x31b/0x3e0 [ 12.742168][ T281] CPU: 2 UID: 0 PID: 281 Comm: modprobe Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 12.742172][ T281] Tainted: [W]=WARN [ 12.742172][ T281] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 12.742175][ T281] Call Trace: [ 12.742177][ T281] [ 12.742178][ T281] dump_stack_lvl+0x6f/0xa0 [ 12.742184][ T281] ? vprintk_emit+0x31b/0x3e0 [ 12.742186][ T281] __might_resched.cold+0x1fe/0x2c1 [ 12.742190][ T281] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 12.742194][ T281] ? __kmalloc_noprof+0xdb/0x760 [ 12.742199][ T281] __kmalloc_noprof+0x443/0x760 [ 12.742201][ T281] ? alloc_buf.isra.0+0x4b/0x260 [ 12.742207][ T281] ? do_raw_spin_unlock+0x59/0x250 [ 12.742209][ T281] alloc_buf.isra.0+0x4b/0x260 [ 12.742212][ T281] put_chars+0x1e1/0x2f0 [ 12.742214][ T281] ? desc_read_finalized_seq+0x79/0x120 [ 12.742216][ T281] ? __send_to_port+0x420/0x420 [ 12.742219][ T281] ? rcu_read_lock_any_held+0x3c/0x90 [ 12.742223][ T281] ? validate_chain+0x38b/0xc20 [ 12.742227][ T281] hvc_console_print+0x292/0x780 [ 12.742229][ T281] ? __lock_acquire+0x518/0xc20 [ 12.742231][ T281] ? __lock_acquire+0x518/0xc20 [ 12.742235][ T281] ? hvc_write+0x3a0/0x3a0 [ 12.742237][ T281] ? console_emit_next_record+0x1df/0x4c0 [ 12.742240][ T281] ? rcu_is_watching+0x16/0xd0 [ 12.742243][ T281] ? lock_acquire+0x13c/0x160 [ 12.742247][ T281] console_emit_next_record+0x22f/0x4c0 [ 12.742250][ T281] ? devkmsg_read+0x4b0/0x4b0 [ 12.742252][ T281] ? console_flush_one_record+0x106/0x710 [ 12.742255][ T281] ? rcu_is_watching+0x16/0xd0 [ 12.742258][ T281] ? lock_acquire+0x13c/0x160 [ 12.742261][ T281] console_flush_one_record+0x46f/0x710 [ 12.742265][ T281] ? console_emit_next_record+0x4c0/0x4c0 [ 12.742267][ T281] ? __lock_acquire+0x518/0xc20 [ 12.742272][ T281] console_unlock+0xee/0x1f0 [ 12.742275][ T281] ? console_flush_one_record+0x710/0x710 [ 12.742277][ T281] ? rcu_is_watching+0x16/0xd0 [ 12.742279][ T281] ? lock_acquire+0x60/0x160 [ 12.742282][ T281] ? __down_trylock_console_sem+0x5e/0xa0 [ 12.742284][ T281] ? vprintk_emit+0x320/0x3e0 [ 12.742287][ T281] vprintk_emit+0x37c/0x3e0 [ 12.742292][ T281] ? wake_up_klogd_work_func+0x90/0x90 [ 12.742297][ T281] ? gre_exit+0x3f0/0x3f0 [gre] [ 12.742300][ T281] _printk+0xc7/0x100 [ 12.742304][ T281] ? snapshot_read.cold+0x21/0x21 [ 12.742310][ T281] ? do_one_initcall+0x113/0x4f0 [ 12.742313][ T281] gre_init+0x15/0x1000 [gre] [ 12.742315][ T281] do_one_initcall+0x124/0x4f0 [ 12.742318][ T281] ? trace_event_raw_event_initcall_level+0x280/0x280 [ 12.742323][ T281] ? do_init_module+0xae/0x8a0 [ 12.742326][ T281] ? kasan_unpoison+0x44/0x70 [ 12.742330][ T281] do_init_module+0x2ad/0x8a0 [ 12.742334][ T281] ? lockdep_hardirqs_on+0x91/0x130 [ 12.742338][ T281] ? free_module+0x470/0x470 [ 12.742341][ T281] ? kfree+0x123/0x590 [ 12.742345][ T281] load_module+0x1424/0x1bb0 [ 12.742352][ T281] ? layout_and_allocate.isra.0+0x680/0x680 [ 12.742357][ T281] ? backing_file_read_iter+0x541/0x790 [ 12.742361][ T281] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 12.742364][ T281] init_module_from_file+0x11f/0x1a0 [ 12.742368][ T281] ? __do_sys_init_module+0x220/0x220 [ 12.742376][ T281] ? __rwlock_init+0x150/0x150 [ 12.742379][ T281] ? do_raw_spin_unlock+0x59/0x250 [ 12.742382][ T281] idempotent_init_module+0x37b/0x7c0 [ 12.742385][ T281] ? init_module_from_file+0x1a0/0x1a0 [ 12.742392][ T281] ? rcu_is_watching+0x16/0xd0 [ 12.742394][ T281] ? cap_capable+0x1d7/0x3d0 [ 12.742400][ T281] __x64_sys_finit_module+0xdf/0x190 [ 12.742402][ T281] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 12.742405][ T281] do_syscall_64+0xff/0x530 [ 12.742407][ T281] ? exc_page_fault+0xee/0x100 [ 12.742410][ T281] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 12.742412][ T281] RIP: 0033:0x7f65f995537d [ 12.742415][ T281] 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 [ 12.742417][ T281] RSP: 002b:00007ffe6dd3bd48 EFLAGS: 00000246 ORIG_RAX: 0000000000000139 [ 12.742420][ T281] RAX: ffffffffffffffda RBX: 00005569f9d72a40 RCX: 00007f65f995537d [ 12.742421][ T281] RDX: 0000000000000000 RSI: 00005569c73ceffd RDI: 0000000000000001 [ 12.742422][ T281] RBP: 00007ffe6dd3bde0 R08: 0000000000000000 R09: 0000000000000000 [ 12.742423][ T281] R10: 0000000000000000 R11: 0000000000000246 R12: 00005569c73ceffd [ 12.742424][ T281] R13: 00005569f9d72a00 R14: 0000000000040000 R15: 0000000000000000 [ 12.742430][ T281] [ 12.792907][ T281] ip_gre: GRE over IPv4 tunneling driver [ 13.308829][ T299] lag: Mode changed to "loadbalance" [ 13.428425][ T303] lag: Port device veth2 added [ 13.539474][ T307] lag: Port device veth4 added [ 13.616057][ T309] 8021q: adding VLAN 0 to HW filter on device lag [ 13.649374][ T310] br1: port 1(lag) entered blocking state [ 13.649778][ T310] br1: port 1(lag) entered disabled state [ 13.650105][ T310] lag: entered allmulticast mode [ 13.650356][ T310] veth2: entered allmulticast mode [ 13.650619][ T310] veth4: entered allmulticast mode [ 13.654075][ T310] veth2: entered promiscuous mode [ 13.654478][ T310] veth4: entered promiscuous mode [ 13.679612][ T312] br1: port 1(lag) entered blocking state [ 13.680088][ T312] br1: port 1(lag) entered forwarding state [ 13.942042][ T321] GACT probability NOT on [ 13.942062][ T321] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 13.942065][ T321] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 321, name: modprobe [ 13.942067][ T321] preempt_count: 1, expected: 0 [ 13.942068][ T321] RCU nest depth: 0, expected: 0 [ 13.942069][ T321] locks held by modprobe/321: 4, last CPU#2: [ 13.942072][ T321] #0: ffffffff93969cc0 (console_lock){+.+.}-{0:0}, at: vprintk_emit+0x320/0x3e0 [ 13.942084][ T321] #1: ffffffff93969d38 (console_srcu){....}-{0:0}, at: console_flush_one_record+0x106/0x710 [ 13.942088][ T321] #2: ffffffff93889660 (console_owner){....}-{0:0}, at: console_lock_spinning_enable+0x40/0x60 [ 13.942093][ T321] #3: ffffffff93889560 (printk_legacy_map-wait-type-override){....}-{3:3}, at: console_emit_next_record+0x1df/0x4c0 [ 13.942097][ T321] irq event stamp: 19238 [ 13.942098][ T321] hardirqs last enabled at (19237): [] __down_trylock_console_sem+0x86/0xa0 [ 13.942100][ T321] hardirqs last disabled at (19238): [] console_emit_next_record+0x3d4/0x4c0 [ 13.942102][ T321] softirqs last enabled at (18766): [] handle_softirqs+0x67c/0x900 [ 13.942106][ T321] softirqs last disabled at (18761): [] __irq_exit_rcu+0x145/0x1c0 [ 13.942108][ T321] Preemption disabled at: [ 13.942109][ T321] [] vprintk_emit+0x31b/0x3e0 [ 13.942115][ T321] CPU: 2 UID: 0 PID: 321 Comm: modprobe Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 13.942119][ T321] Tainted: [W]=WARN [ 13.942120][ T321] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 13.942122][ T321] Call Trace: [ 13.942124][ T321] [ 13.942125][ T321] dump_stack_lvl+0x6f/0xa0 [ 13.942131][ T321] ? vprintk_emit+0x31b/0x3e0 [ 13.942134][ T321] __might_resched.cold+0x1fe/0x2c1 [ 13.942138][ T321] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 13.942142][ T321] ? __kmalloc_noprof+0xdb/0x760 [ 13.942147][ T321] __kmalloc_noprof+0x443/0x760 [ 13.942150][ T321] ? alloc_buf.isra.0+0x4b/0x260 [ 13.942155][ T321] ? do_raw_spin_unlock+0x59/0x250 [ 13.942158][ T321] alloc_buf.isra.0+0x4b/0x260 [ 13.942161][ T321] put_chars+0x1e1/0x2f0 [ 13.942163][ T321] ? desc_read_finalized_seq+0x79/0x120 [ 13.942165][ T321] ? __send_to_port+0x420/0x420 [ 13.942168][ T321] ? rcu_read_lock_any_held+0x3c/0x90 [ 13.942171][ T321] ? validate_chain+0x38b/0xc20 [ 13.942176][ T321] hvc_console_print+0x292/0x780 [ 13.942178][ T321] ? __lock_acquire+0x518/0xc20 [ 13.942180][ T321] ? __lock_acquire+0x518/0xc20 [ 13.942184][ T321] ? hvc_write+0x3a0/0x3a0 [ 13.942186][ T321] ? console_emit_next_record+0x1df/0x4c0 [ 13.942189][ T321] ? rcu_is_watching+0x16/0xd0 [ 13.942192][ T321] ? lock_acquire+0x13c/0x160 [ 13.942196][ T321] console_emit_next_record+0x22f/0x4c0 [ 13.942199][ T321] ? devkmsg_read+0x4b0/0x4b0 [ 13.942201][ T321] ? console_flush_one_record+0x106/0x710 [ 13.942204][ T321] ? rcu_is_watching+0x16/0xd0 [ 13.942207][ T321] ? lock_acquire+0x13c/0x160 [ 13.942210][ T321] console_flush_one_record+0x46f/0x710 [ 13.942214][ T321] ? console_emit_next_record+0x4c0/0x4c0 [ 13.942216][ T321] ? __lock_acquire+0x518/0xc20 [ 13.942221][ T321] console_unlock+0xee/0x1f0 [ 13.942224][ T321] ? console_flush_one_record+0x710/0x710 [ 13.942226][ T321] ? rcu_is_watching+0x16/0xd0 [ 13.942228][ T321] ? lock_acquire+0x60/0x160 [ 13.942232][ T321] ? __down_trylock_console_sem+0x5e/0xa0 [ 13.942233][ T321] ? vprintk_emit+0x320/0x3e0 [ 13.942236][ T321] vprintk_emit+0x37c/0x3e0 [ 13.942241][ T321] ? wake_up_klogd_work_func+0x90/0x90 [ 13.942247][ T321] ? gre_exit+0x3f0/0x3f0 [gre] [ 13.942250][ T321] _printk+0xc7/0x100 [ 13.942254][ T321] ? snapshot_read.cold+0x21/0x21 [ 13.942260][ T321] ? do_one_initcall+0x113/0x4f0 [ 13.942263][ T321] gact_init_module+0x15/0x1000 [act_gact] [ 13.942266][ T321] do_one_initcall+0x124/0x4f0 [ 13.942268][ T321] ? trace_event_raw_event_initcall_level+0x280/0x280 [ 13.942273][ T321] ? do_init_module+0xae/0x8a0 [ 13.942276][ T321] ? kasan_unpoison+0x44/0x70 [ 13.942281][ T321] do_init_module+0x2ad/0x8a0 [ 13.942284][ T321] ? lockdep_hardirqs_on+0x91/0x130 [ 13.942289][ T321] ? free_module+0x470/0x470 [ 13.942292][ T321] ? kfree+0x123/0x590 [ 13.942296][ T321] load_module+0x1424/0x1bb0 [ 13.942303][ T321] ? layout_and_allocate.isra.0+0x680/0x680 [ 13.942307][ T321] ? __ia32_sys_fsconfig+0x180/0x180 [ 13.942309][ T321] ? ovl_real_file+0x172/0x1e0 [ 13.942314][ T321] ? backing_file_read_iter+0x541/0x790 [ 13.942317][ T321] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 13.942321][ T321] init_module_from_file+0x11f/0x1a0 [ 13.942324][ T321] ? __do_sys_init_module+0x220/0x220 [ 13.942332][ T321] ? __rwlock_init+0x150/0x150 [ 13.942335][ T321] ? do_raw_spin_unlock+0x59/0x250 [ 13.942338][ T321] idempotent_init_module+0x37b/0x7c0 [ 13.942342][ T321] ? init_module_from_file+0x1a0/0x1a0 [ 13.942348][ T321] ? rcu_is_watching+0x16/0xd0 [ 13.942350][ T321] ? cap_capable+0x1d7/0x3d0 [ 13.942356][ T321] __x64_sys_finit_module+0xdf/0x190 [ 13.942358][ T321] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 13.942362][ T321] do_syscall_64+0xff/0x530 [ 13.942363][ T321] ? exc_page_fault+0xee/0x100 [ 13.942366][ T321] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 13.942369][ T321] RIP: 0033:0x7f0878eb637d [ 13.942373][ T321] 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 [ 13.942375][ T321] RSP: 002b:00007fffabcfd6c8 EFLAGS: 00000246 ORIG_RAX: 0000000000000139 [ 13.942378][ T321] RAX: ffffffffffffffda RBX: 000055c3c7604810 RCX: 00007f0878eb637d [ 13.942379][ T321] RDX: 0000000000000000 RSI: 000055c3a813effd RDI: 0000000000000000 [ 13.942380][ T321] RBP: 00007fffabcfd760 R08: 0000000000000000 R09: 0000000000000000 [ 13.942381][ T321] R10: 0000000000000000 R11: 0000000000000246 R12: 000055c3a813effd [ 13.942382][ T321] R13: 000055c3c7604960 R14: 0000000000040000 R15: 0000000000000000 [ 13.942388][ T321] [ 13.985942][ T319] tc (319) used greatest stack depth: 23768 bytes left [ 19.563447][ T354] Mirror/redirect action on [ 19.563468][ T354] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 19.563470][ T354] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 354, name: modprobe [ 19.563472][ T354] preempt_count: 1, expected: 0 [ 19.563473][ T354] RCU nest depth: 0, expected: 0 [ 19.563474][ T354] locks held by modprobe/354: 4, last CPU#3: [ 19.563477][ T354] #0: ffffffff93969cc0 (console_lock){+.+.}-{0:0}, at: vprintk_emit+0x320/0x3e0 [ 19.563490][ T354] #1: ffffffff93969d38 (console_srcu){....}-{0:0}, at: console_flush_one_record+0x106/0x710 [ 19.563494][ T354] #2: ffffffff93889660 (console_owner){....}-{0:0}, at: console_lock_spinning_enable+0x40/0x60 [ 19.563498][ T354] #3: ffffffff93889560 (printk_legacy_map-wait-type-override){....}-{3:3}, at: console_emit_next_record+0x1df/0x4c0 [ 19.563502][ T354] irq event stamp: 25836 [ 19.563503][ T354] hardirqs last enabled at (25835): [] __down_trylock_console_sem+0x86/0xa0 [ 19.563506][ T354] hardirqs last disabled at (25836): [] console_emit_next_record+0x3d4/0x4c0 [ 19.563508][ T354] softirqs last enabled at (24380): [] handle_softirqs+0x67c/0x900 [ 19.563511][ T354] softirqs last disabled at (24373): [] __irq_exit_rcu+0x145/0x1c0 [ 19.563514][ T354] Preemption disabled at: [ 19.563514][ T354] [] vprintk_emit+0x31b/0x3e0 [ 19.563520][ T354] CPU: 3 UID: 0 PID: 354 Comm: modprobe Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 19.563524][ T354] Tainted: [W]=WARN [ 19.563525][ T354] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 19.563528][ T354] Call Trace: [ 19.563529][ T354] [ 19.563531][ T354] dump_stack_lvl+0x6f/0xa0 [ 19.563537][ T354] ? vprintk_emit+0x31b/0x3e0 [ 19.563539][ T354] __might_resched.cold+0x1fe/0x2c1 [ 19.563544][ T354] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 19.563548][ T354] ? __kmalloc_noprof+0xdb/0x760 [ 19.563553][ T354] __kmalloc_noprof+0x443/0x760 [ 19.563556][ T354] ? alloc_buf.isra.0+0x4b/0x260 [ 19.563561][ T354] ? do_raw_spin_unlock+0x59/0x250 [ 19.563564][ T354] alloc_buf.isra.0+0x4b/0x260 [ 19.563567][ T354] put_chars+0x1e1/0x2f0 [ 19.563570][ T354] ? __send_to_port+0x420/0x420 [ 19.563572][ T354] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 19.563577][ T354] ? rcu_read_lock_any_held+0x3c/0x90 [ 19.563579][ T354] ? validate_chain+0x38b/0xc20 [ 19.563583][ T354] hvc_console_print+0x292/0x780 [ 19.563586][ T354] ? __lock_acquire+0x518/0xc20 [ 19.563591][ T354] ? hvc_write+0x3a0/0x3a0 [ 19.563593][ T354] ? rcu_is_watching+0x16/0xd0 [ 19.563598][ T354] console_emit_next_record+0x22f/0x4c0 [ 19.563602][ T354] ? devkmsg_read+0x4b0/0x4b0 [ 19.563604][ T354] ? console_flush_one_record+0x106/0x710 [ 19.563607][ T354] ? rcu_is_watching+0x16/0xd0 [ 19.563609][ T354] ? lock_acquire+0x13c/0x160 [ 19.563613][ T354] console_flush_one_record+0x46f/0x710 [ 19.563617][ T354] ? console_emit_next_record+0x4c0/0x4c0 [ 19.563619][ T354] ? __lock_acquire+0x518/0xc20 [ 19.563624][ T354] console_unlock+0xee/0x1f0 [ 19.563626][ T354] ? console_flush_one_record+0x710/0x710 [ 19.563628][ T354] ? rcu_is_watching+0x16/0xd0 [ 19.563630][ T354] ? lock_acquire+0x60/0x160 [ 19.563634][ T354] ? __down_trylock_console_sem+0x5e/0xa0 [ 19.563635][ T354] ? vprintk_emit+0x320/0x3e0 [ 19.563639][ T354] vprintk_emit+0x37c/0x3e0 [ 19.563643][ T354] ? wake_up_klogd_work_func+0x90/0x90 [ 19.563646][ T354] ? netdev_run_todo+0x2a8/0xfd0 [ 19.563650][ T354] ? mirred_device_event+0x3d/0x1d0 [act_mirred] [ 19.563653][ T354] ? rcu_is_watching+0x16/0xd0 [ 19.563657][ T354] ? gre_exit+0x3f0/0x3f0 [gre] [ 19.563659][ T354] _printk+0xc7/0x100 [ 19.563663][ T354] ? snapshot_read.cold+0x21/0x21 [ 19.563665][ T354] ? __lock_release.isra.0+0x69/0x1a0 [ 19.563668][ T354] ? gre_exit+0x3f0/0x3f0 [gre] [ 19.563669][ T354] ? __up_write+0x23d/0x5f0 [ 19.563671][ T354] ? __up_write+0x2e5/0x5f0 [ 19.563674][ T354] ? __up_write+0x2c7/0x5f0 [ 19.563676][ T354] mirred_init_module+0x28/0x1000 [act_mirred] [ 19.563679][ T354] do_one_initcall+0x124/0x4f0 [ 19.563682][ T354] ? trace_event_raw_event_initcall_level+0x280/0x280 [ 19.563686][ T354] ? do_init_module+0xae/0x8a0 [ 19.563690][ T354] ? kasan_unpoison+0x44/0x70 [ 19.563694][ T354] do_init_module+0x2ad/0x8a0 [ 19.563698][ T354] ? lockdep_hardirqs_on+0x91/0x130 [ 19.563702][ T354] ? free_module+0x470/0x470 [ 19.563705][ T354] ? kfree+0x123/0x590 [ 19.563709][ T354] load_module+0x1424/0x1bb0 [ 19.563716][ T354] ? layout_and_allocate.isra.0+0x680/0x680 [ 19.563720][ T354] ? __ia32_sys_fsconfig+0x180/0x180 [ 19.563723][ T354] ? ovl_real_file+0x172/0x1e0 [ 19.563727][ T354] ? backing_file_read_iter+0x541/0x790 [ 19.563730][ T354] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 19.563733][ T354] init_module_from_file+0x11f/0x1a0 [ 19.563737][ T354] ? __do_sys_init_module+0x220/0x220 [ 19.563744][ T354] ? __rwlock_init+0x150/0x150 [ 19.563748][ T354] ? do_raw_spin_unlock+0x59/0x250 [ 19.563751][ T354] idempotent_init_module+0x37b/0x7c0 [ 19.563754][ T354] ? init_module_from_file+0x1a0/0x1a0 [ 19.563760][ T354] ? rcu_is_watching+0x16/0xd0 [ 19.563763][ T354] ? cap_capable+0x1d7/0x3d0 [ 19.563769][ T354] __x64_sys_finit_module+0xdf/0x190 [ 19.563771][ T354] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 19.563774][ T354] do_syscall_64+0xff/0x530 [ 19.563776][ T354] ? exc_page_fault+0xee/0x100 [ 19.563779][ T354] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 19.563781][ T354] RIP: 0033:0x7ff30daf437d [ 19.563785][ T354] 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 [ 19.563786][ T354] RSP: 002b:00007ffc28156048 EFLAGS: 00000246 ORIG_RAX: 0000000000000139 [ 19.563789][ T354] RAX: ffffffffffffffda RBX: 000056149dbf0810 RCX: 00007ff30daf437d [ 19.563790][ T354] RDX: 0000000000000000 RSI: 0000561465dbeffd RDI: 0000000000000000 [ 19.563791][ T354] RBP: 00007ffc281560e0 R08: 0000000000000000 R09: 0000000000000000 [ 19.563792][ T354] R10: 0000000000000000 R11: 0000000000000246 R12: 0000561465dbeffd [ 19.563793][ T354] R13: 000056149dbf0960 R14: 0000000000040000 R15: 0000000000000000 [ 19.563799][ T354] [ 29.046002][ C3] [ 29.046022][ C3] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 29.046025][ C3] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 0, name: swapper/3 [ 29.046026][ C3] preempt_count: 104, expected: 0 [ 29.046028][ C3] RCU nest depth: 0, expected: 0 [ 29.046029][ C3] INFO: lockdep is turned off. [ 29.046030][ C3] irq event stamp: 709942 [ 29.046031][ C3] hardirqs last enabled at (709942): [] _raw_spin_unlock_irq+0x28/0x50 [ 29.046040][ C3] hardirqs last disabled at (709941): [] _raw_spin_lock_irq+0x4a/0x50 [ 29.046042][ C3] softirqs last enabled at (709908): [] handle_softirqs+0x67c/0x900 [ 29.046046][ C3] softirqs last disabled at (709939): [] __irq_exit_rcu+0x145/0x1c0 [ 29.046047][ C3] Preemption disabled at: [ 29.046048][ C3] [<0000000000000000>] 0x0 [ 29.046055][ C3] CPU: 3 UID: 0 PID: 0 Comm: swapper/3 Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 29.046059][ C3] Tainted: [W]=WARN [ 29.046060][ C3] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 29.046062][ C3] Call Trace: [ 29.046064][ C3] [ 29.046067][ C3] dump_stack_lvl+0x6f/0xa0 [ 29.046072][ C3] __might_resched.cold+0x1fe/0x2c1 [ 29.046076][ C3] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 29.046079][ C3] ? __asan_memcpy+0x3c/0x60 [ 29.046082][ C3] ? rcu_is_watching+0x16/0xd0 [ 29.046086][ C3] __kmalloc_noprof+0x443/0x760 [ 29.046090][ C3] ? __rwlock_init+0x150/0x150 [ 29.046092][ C3] ? alloc_buf.isra.0+0x4b/0x260 [ 29.046096][ C3] ? do_raw_spin_unlock+0x59/0x250 [ 29.046097][ C3] alloc_buf.isra.0+0x4b/0x260 [ 29.046099][ C3] put_chars+0x1e1/0x2f0 [ 29.046102][ C3] ? __send_to_port+0x420/0x420 [ 29.046103][ C3] ? console_prepend_replay+0x20/0x20 [ 29.046106][ C3] hvc_console_print+0x292/0x780 [ 29.046110][ C3] ? hvc_write+0x3a0/0x3a0 [ 29.046111][ C3] ? rcu_is_watching+0x16/0xd0 [ 29.046113][ C3] ? lock_acquire+0x13c/0x160 [ 29.046115][ C3] console_emit_next_record+0x22f/0x4c0 [ 29.046118][ C3] ? devkmsg_read+0x4b0/0x4b0 [ 29.046120][ C3] ? rcu_is_watching+0x16/0xd0 [ 29.046121][ C3] ? rcu_is_watching+0x16/0xd0 [ 29.046123][ C3] ? lock_acquire+0x13c/0x160 [ 29.046125][ C3] ? console_flush_one_record+0x111/0x710 [ 29.046126][ C3] console_flush_one_record+0x46f/0x710 [ 29.046129][ C3] ? console_emit_next_record+0x4c0/0x4c0 [ 29.046131][ C3] console_unlock+0xee/0x1f0 [ 29.046133][ C3] ? lock_acquire+0x13c/0x160 [ 29.046134][ C3] ? console_flush_one_record+0x710/0x710 [ 29.046136][ C3] ? rcu_is_watching+0x16/0xd0 [ 29.046138][ C3] ? lock_release+0x184/0x1f0 [ 29.046139][ C3] ? lock_acquire+0x60/0x160 [ 29.046141][ C3] ? __down_trylock_console_sem+0x5e/0xa0 [ 29.046143][ C3] ? vprintk_emit+0x320/0x3e0 [ 29.046145][ C3] vprintk_emit+0x37c/0x3e0 [ 29.046147][ C3] ? wake_up_klogd_work_func+0x90/0x90 [ 29.046149][ C3] ? br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 29.046161][ C3] ? lock_release+0x184/0x1f0 [ 29.046162][ C3] ? br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 29.046169][ C3] ? br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 29.046175][ C3] ? is_module_text_address+0x154/0x250 [ 29.046178][ C3] _printk+0xc7/0x100 [ 29.046181][ C3] ? snapshot_read.cold+0x21/0x21 [ 29.046183][ C3] ? arch_stack_walk+0xd7/0x130 [ 29.046187][ C3] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 29.046189][ C3] ? nbcon_cpu_emergency_enter+0x28/0x80 [ 29.046191][ C3] print_irq_inversion_bug.part.0+0x32/0xc0 [ 29.046193][ C3] mark_lock_irq+0x989/0x9c0 [ 29.046196][ C3] mark_lock+0x1d7/0xa00 [ 29.046198][ C3] mark_usage+0x42/0x170 [ 29.046199][ C3] __lock_acquire+0x388/0xc20 [ 29.046201][ C3] lock_acquire.part.0+0xd4/0x280 [ 29.046203][ C3] ? br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 29.046209][ C3] ? rcu_is_watching+0x16/0xd0 [ 29.046211][ C3] ? lock_acquire+0x13c/0x160 [ 29.046213][ C3] ? br_message_age_timer_expired+0x70/0x70 [bridge] [ 29.046219][ C3] _raw_spin_lock+0x33/0x40 [ 29.046221][ C3] ? br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 29.046227][ C3] br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 29.046233][ C3] ? br_message_age_timer_expired+0x70/0x70 [bridge] [ 29.046239][ C3] call_timer_fn+0x160/0x4d0 [ 29.046242][ C3] ? detach_if_pending+0x1d0/0x1d0 [ 29.046244][ C3] ? debug_object_active_state+0x430/0x430 [ 29.046247][ C3] ? find_held_lock+0x2b/0x80 [ 29.046249][ C3] ? __lock_release.isra.0+0x69/0x1a0 [ 29.046251][ C3] ? rcu_is_watching+0x16/0xd0 [ 29.046253][ C3] __run_timers+0x68f/0xaa0 [ 29.046255][ C3] ? br_message_age_timer_expired+0x70/0x70 [bridge] [ 29.046261][ C3] ? __bpf_trace_itimer_expire+0x10/0x10 [ 29.046263][ C3] ? __lock_acquire+0x518/0xc20 [ 29.046266][ C3] ? __rwlock_init+0x150/0x150 [ 29.046268][ C3] run_timer_softirq+0xf0/0x160 [ 29.046270][ C3] ? __run_timers+0xaa0/0xaa0 [ 29.046271][ C3] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 29.046274][ C3] ? rcu_is_watching+0x16/0xd0 [ 29.046275][ C3] handle_softirqs+0x1d3/0x900 [ 29.046277][ C3] ? __lock_release.isra.0+0x69/0x1a0 [ 29.046279][ C3] ? _local_bh_enable+0xc0/0xc0 [ 29.046281][ C3] __irq_exit_rcu+0x145/0x1c0 [ 29.046282][ C3] irq_exit_rcu+0xe/0x30 [ 29.046283][ C3] sysvec_apic_timer_interrupt+0x9d/0xe0 [ 29.046286][ C3] [ 29.046287][ C3] [ 29.046287][ C3] ? lockdep_hardirqs_on+0x91/0x130 [ 29.046289][ C3] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 29.046292][ C3] RIP: 0010:pv_native_safe_halt+0xf/0x10 [ 29.046294][ C3] Code: 48 8b 3d 94 f2 f5 01 e8 1f 00 00 00 48 2b 05 58 b3 95 00 c3 0f 1f 80 00 00 00 00 f3 0f 1e fa eb 07 0f 00 2d 13 a6 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 [ 29.046296][ C3] RSP: 0018:ffa0000000167e00 EFLAGS: 00000282 [ 29.046300][ C3] RAX: 00000000000ad531 RBX: ff11000001c88040 RCX: ffffffff906f0307 [ 29.046301][ C3] RDX: ff11000001c88040 RSI: ffffffff93438b1c RDI: ffffffff92e8d8e0 [ 29.046302][ C3] RBP: 0000000000000000 R08: 0000000000000000 R09: 0000000000000000 [ 29.046302][ C3] R10: 0000000000000003 R11: 0000000000000001 R12: 1ff400000002cfc3 [ 29.046303][ C3] R13: 0000000000000000 R14: dffffc0000000000 R15: 0000000000000000 [ 29.046305][ C3] ? cpuidle_idle_call.constprop.0+0x237/0x410 [ 29.046308][ C3] default_idle+0x9/0x10 [ 29.046310][ C3] default_idle_call+0x6e/0xb0 [ 29.046311][ C3] cpuidle_idle_call.constprop.0+0x237/0x410 [ 29.046313][ C3] ? arch_cpu_idle_exit+0x40/0x40 [ 29.046314][ C3] ? mark_tsc_async_resets+0x30/0x30 [ 29.046317][ C3] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 29.046318][ C3] ? rcu_is_watching+0x16/0xd0 [ 29.046320][ C3] do_idle+0xd8/0x190 [ 29.046321][ C3] cpu_startup_entry+0x53/0x70 [ 29.046323][ C3] start_secondary+0x204/0x2b0 [ 29.046325][ C3] ? set_cpu_sibling_map+0x2130/0x2130 [ 29.046327][ C3] common_startup_64+0x13e/0x148 [ 29.046331][ C3] [ 29.070104][ C3] ======================================================== [ 29.070346][ C3] WARNING: possible irq lock inversion dependency detected [ 29.070587][ C3] 7.2.0-virtme #1 Tainted: G W [ 29.070802][ C3] -------------------------------------------------------- [ 29.071008][ C3] swapper/3/0 just changed the state of lock: [ 29.071225][ C3] ff1100000b7c2e58 (&br->lock){+.-.}-{3:3}, at: br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 29.071543][ C3] but this lock took another, SOFTIRQ-unsafe lock in the past: [ 29.071786][ C3] (fs_reclaim){+.+.}-{0:0} [ 29.071789][ C3] [ 29.071789][ C3] [ 29.071789][ C3] and interrupts could create inverse lock ordering between them. [ 29.071789][ C3] [ 29.072374][ C3] [ 29.072374][ C3] other info that might help us debug this: [ 29.072571][ C3] Chain exists of: [ 29.072571][ C3] &br->lock --> console_owner --> fs_reclaim [ 29.072571][ C3] [ 29.072929][ C3] Possible interrupt unsafe locking scenario: [ 29.072929][ C3] [ 29.073134][ C3] CPU0 CPU1 [ 29.073326][ C3] ---- ---- [ 29.073457][ C3] lock(fs_reclaim); [ 29.073607][ C3] local_irq_disable(); [ 29.073778][ C3] lock(&br->lock); [ 29.074005][ C3] lock(console_owner); [ 29.074172][ C3] [ 29.074322][ C3] lock(&br->lock); [ 29.074421][ C3] [ 29.074421][ C3] *** DEADLOCK *** [ 29.074421][ C3] [ 29.074656][ C3] locks held by swapper/3/0: 1, last CPU#3: [ 29.074864][ C3] #0: ffa0000000280c90 ((&p->forward_delay_timer)){+.-.}-{0:0}, at: call_timer_fn+0x110/0x4d0 [ 29.075189][ C3] [ 29.075189][ C3] the shortest dependencies between 2nd lock and 1st lock: [ 29.075423][ C3] -> (fs_reclaim){+.+.}-{0:0} { [ 29.075616][ C3] HARDIRQ-ON-W at: [ 29.075718][ C3] __lock_acquire+0x388/0xc20 [ 29.075945][ C3] lock_acquire.part.0+0xd4/0x280 [ 29.076159][ C3] fs_reclaim_acquire+0xd5/0x120 [ 29.076329][ C3] __kmalloc_cache_noprof+0x6e/0x620 [ 29.076580][ C3] kthread_create_worker_on_node+0xea/0x210 [ 29.076831][ C3] workqueue_init+0x2a/0x680 [ 29.077002][ C3] kernel_init_freeable+0x2fe/0x630 [ 29.077248][ C3] kernel_init+0x21/0x150 [ 29.077474][ C3] ret_from_fork+0x474/0x6b0 [ 29.077646][ C3] ret_from_fork_asm+0x11/0x20 [ 29.077864][ C3] SOFTIRQ-ON-W at: [ 29.077969][ C3] __lock_acquire+0x388/0xc20 [ 29.078192][ C3] lock_acquire.part.0+0xd4/0x280 [ 29.078401][ C3] fs_reclaim_acquire+0xd5/0x120 [ 29.078570][ C3] __kmalloc_cache_noprof+0x6e/0x620 [ 29.078819][ C3] kthread_create_worker_on_node+0xea/0x210 [ 29.079025][ C3] workqueue_init+0x2a/0x680 [ 29.079193][ C3] kernel_init_freeable+0x2fe/0x630 [ 29.079467][ C3] kernel_init+0x21/0x150 [ 29.079681][ C3] ret_from_fork+0x474/0x6b0 [ 29.079845][ C3] ret_from_fork_asm+0x11/0x20 [ 29.080072][ C3] INITIAL USE at: [ 29.080169][ C3] __lock_acquire+0x388/0xc20 [ 29.080407][ C3] lock_acquire.part.0+0xd4/0x280 [ 29.080627][ C3] fs_reclaim_acquire+0xd5/0x120 [ 29.080801][ C3] __kmalloc_cache_noprof+0x6e/0x620 [ 29.081069][ C3] kthread_create_worker_on_node+0xea/0x210 [ 29.081317][ C3] workqueue_init+0x2a/0x680 [ 29.081486][ C3] kernel_init_freeable+0x2fe/0x630 [ 29.081705][ C3] kernel_init+0x21/0x150 [ 29.081931][ C3] ret_from_fork+0x474/0x6b0 [ 29.082103][ C3] ret_from_fork_asm+0x11/0x20 [ 29.082315][ C3] } [ 29.082385][ C3] ... key at: [] __fs_reclaim_map+0x0/0xbe0 [ 29.082627][ C3] ... acquired at: [ 29.082730][ C3] __lock_acquire+0x518/0xc20 [ 29.082927][ C3] lock_acquire.part.0+0xd4/0x280 [ 29.083061][ C3] fs_reclaim_acquire+0xd5/0x120 [ 29.083249][ C3] __kmalloc_noprof+0xd3/0x760 [ 29.083382][ C3] alloc_buf.isra.0+0x4b/0x260 [ 29.083564][ C3] put_chars+0x1e1/0x2f0 [ 29.083697][ C3] hvc_console_print+0x292/0x780 [ 29.083880][ C3] console_emit_next_record+0x22f/0x4c0 [ 29.084026][ C3] console_flush_one_record+0x46f/0x710 [ 29.084206][ C3] console_unlock+0xee/0x1f0 [ 29.084336][ C3] vprintk_emit+0x37c/0x3e0 [ 29.084516][ C3] _printk+0xc7/0x100 [ 29.084618][ C3] dm_interface_init+0x50/0x60 [ 29.084799][ C3] dm_init+0x51/0xd0 [ 29.084906][ C3] do_one_initcall+0x124/0x4f0 [ 29.085040][ C3] kernel_init_freeable+0x596/0x630 [ 29.085222][ C3] kernel_init+0x21/0x150 [ 29.085354][ C3] ret_from_fork+0x474/0x6b0 [ 29.085536][ C3] ret_from_fork_asm+0x11/0x20 [ 29.085669][ C3] [ 29.085788][ C3] -> (console_owner){....}-{0:0} { [ 29.085938][ C3] INITIAL USE at: [ 29.086085][ C3] } [ 29.086152][ C3] ... key at: [] console_owner_dep_map+0x0/0x60 [ 29.086399][ C3] ... acquired at: [ 29.086500][ C3] __lock_acquire+0x518/0xc20 [ 29.086631][ C3] lock_acquire.part.0+0xd4/0x280 [ 29.086807][ C3] console_lock_spinning_enable+0x5c/0x60 [ 29.087022][ C3] console_emit_next_record+0x1d1/0x4c0 [ 29.087157][ C3] console_flush_one_record+0x46f/0x710 [ 29.087341][ C3] console_unlock+0xee/0x1f0 [ 29.087471][ C3] vprintk_emit+0x37c/0x3e0 [ 29.087648][ C3] _printk+0xc7/0x100 [ 29.087753][ C3] br_set_state+0x22f/0x430 [bridge] [ 29.087903][ C3] br_init_port+0xc4/0x200 [bridge] [ 29.088053][ C3] br_stp_enable_bridge+0x1fc/0x340 [bridge] [ 29.088278][ C3] br_dev_open+0x94/0x120 [bridge] [ 29.088424][ C3] __dev_open+0x2f3/0x610 [ 29.088611][ C3] __dev_change_flags+0x4a4/0x660 [ 29.088744][ C3] netif_change_flags+0x87/0x190 [ 29.088931][ C3] do_setlink.isra.0+0x1cc3/0x2750 [ 29.089068][ C3] rtnl_newlink+0x9f1/0x11c0 [ 29.089251][ C3] rtnetlink_rcv_msg+0x6fd/0xbd0 [ 29.089382][ C3] netlink_rcv_skb+0x14e/0x3a0 [ 29.089571][ C3] netlink_unicast+0x486/0x750 [ 29.089710][ C3] netlink_sendmsg+0x735/0xc60 [ 29.089900][ C3] ____sys_sendmsg+0x415/0x880 [ 29.090036][ C3] ___sys_sendmsg+0x14e/0x1d0 [ 29.090215][ C3] __sys_sendmsg+0x12c/0x1d0 [ 29.090348][ C3] do_syscall_64+0xff/0x530 [ 29.090526][ C3] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 29.090691][ C3] [ 29.090759][ C3] -> (&br->lock){+.-.}-{3:3} { [ 29.090960][ C3] HARDIRQ-ON-W at: [ 29.091060][ C3] __lock_acquire+0x388/0xc20 [ 29.091279][ C3] lock_acquire.part.0+0xd4/0x280 [ 29.091493][ C3] _raw_spin_lock_bh+0x38/0x50 [ 29.091665][ C3] br_dev_newlink+0xa6/0x160 [bridge] [ 29.091897][ C3] rtnl_newlink_create+0x2d0/0x750 [ 29.092075][ C3] __rtnl_newlink+0x22b/0xa50 [ 29.092291][ C3] rtnl_newlink+0x9f1/0x11c0 [ 29.092518][ C3] rtnetlink_rcv_msg+0x6fd/0xbd0 [ 29.092681][ C3] netlink_rcv_skb+0x14e/0x3a0 [ 29.092904][ C3] netlink_unicast+0x486/0x750 [ 29.093117][ C3] netlink_sendmsg+0x735/0xc60 [ 29.093288][ C3] ____sys_sendmsg+0x415/0x880 [ 29.093508][ C3] ___sys_sendmsg+0x14e/0x1d0 [ 29.093675][ C3] __sys_sendmsg+0x12c/0x1d0 [ 29.093898][ C3] do_syscall_64+0xff/0x530 [ 29.094117][ C3] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 29.094311][ C3] IN-SOFTIRQ-W at: [ 29.094459][ C3] __lock_acquire+0x388/0xc20 [ 29.094625][ C3] lock_acquire.part.0+0xd4/0x280 [ 29.094845][ C3] _raw_spin_lock+0x33/0x40 [ 29.095019][ C3] br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 29.095224][ C3] call_timer_fn+0x160/0x4d0 [ 29.095449][ C3] __run_timers+0x68f/0xaa0 [ 29.095662][ C3] run_timer_softirq+0xf0/0x160 [ 29.095826][ C3] handle_softirqs+0x1d3/0x900 [ 29.096054][ C3] __irq_exit_rcu+0x145/0x1c0 [ 29.096267][ C3] irq_exit_rcu+0xe/0x30 [ 29.096433][ C3] sysvec_apic_timer_interrupt+0x9d/0xe0 [ 29.096686][ C3] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 29.096934][ C3] pv_native_safe_halt+0xf/0x10 [ 29.097100][ C3] default_idle+0x9/0x10 [ 29.097313][ C3] default_idle_call+0x6e/0xb0 [ 29.097526][ C3] cpuidle_idle_call.constprop.0+0x237/0x410 [ 29.097723][ C3] do_idle+0xd8/0x190 [ 29.097929][ C3] cpu_startup_entry+0x53/0x70 [ 29.098099][ C3] start_secondary+0x204/0x2b0 [ 29.098312][ C3] common_startup_64+0x13e/0x148 [ 29.098528][ C3] INITIAL USE at: [ 29.098628][ C3] __lock_acquire+0x388/0xc20 [ 29.098842][ C3] lock_acquire.part.0+0xd4/0x280 [ 29.099014][ C3] _raw_spin_lock_bh+0x38/0x50 [ 29.099230][ C3] br_dev_newlink+0xa6/0x160 [bridge] [ 29.099448][ C3] rtnl_newlink_create+0x2d0/0x750 [ 29.099614][ C3] __rtnl_newlink+0x22b/0xa50 [ 29.099826][ C3] rtnl_newlink+0x9f1/0x11c0 [ 29.099996][ C3] rtnetlink_rcv_msg+0x6fd/0xbd0 [ 29.100210][ C3] netlink_rcv_skb+0x14e/0x3a0 [ 29.100432][ C3] netlink_unicast+0x486/0x750 [ 29.100599][ C3] netlink_sendmsg+0x735/0xc60 [ 29.100810][ C3] ____sys_sendmsg+0x415/0x880 [ 29.100992][ C3] ___sys_sendmsg+0x14e/0x1d0 [ 29.101169][ C3] __sys_sendmsg+0x12c/0x1d0 [ 29.101380][ C3] do_syscall_64+0xff/0x530 [ 29.101544][ C3] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 29.101791][ C3] } [ 29.101859][ C3] ... key at: [] __key.7+0x0/0x40 [bridge] [ 29.102114][ C3] ... acquired at: [ 29.102255][ C3] mark_lock+0x1d7/0xa00 [ 29.102391][ C3] mark_usage+0x42/0x170 [ 29.102567][ C3] __lock_acquire+0x388/0xc20 [ 29.102696][ C3] lock_acquire.part.0+0xd4/0x280 [ 29.102870][ C3] _raw_spin_lock+0x33/0x40 [ 29.103021][ C3] br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 29.103235][ C3] call_timer_fn+0x160/0x4d0 [ 29.103364][ C3] __run_timers+0x68f/0xaa0 [ 29.103545][ C3] run_timer_softirq+0xf0/0x160 [ 29.103676][ C3] handle_softirqs+0x1d3/0x900 [ 29.103854][ C3] __irq_exit_rcu+0x145/0x1c0 [ 29.103999][ C3] irq_exit_rcu+0xe/0x30 [ 29.104182][ C3] sysvec_apic_timer_interrupt+0x9d/0xe0 [ 29.104348][ C3] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 29.104558][ C3] pv_native_safe_halt+0xf/0x10 [ 29.104688][ C3] default_idle+0x9/0x10 [ 29.104872][ C3] default_idle_call+0x6e/0xb0 [ 29.105014][ C3] cpuidle_idle_call.constprop.0+0x237/0x410 [ 29.105220][ C3] do_idle+0xd8/0x190 [ 29.105317][ C3] cpu_startup_entry+0x53/0x70 [ 29.105499][ C3] start_secondary+0x204/0x2b0 [ 29.105631][ C3] common_startup_64+0x13e/0x148 [ 29.105813][ C3] [ 29.105880][ C3] [ 29.105880][ C3] stack backtrace: [ 29.106108][ C3] CPU: 3 UID: 0 PID: 0 Comm: swapper/3 Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 29.106111][ C3] Tainted: [W]=WARN [ 29.106112][ C3] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 29.106114][ C3] Call Trace: [ 29.106115][ C3] [ 29.106117][ C3] dump_stack_lvl+0x6f/0xa0 [ 29.106122][ C3] print_irq_inversion_bug.part.0.cold+0xe6/0x143 [ 29.106125][ C3] mark_lock_irq+0x989/0x9c0 [ 29.106128][ C3] mark_lock+0x1d7/0xa00 [ 29.106130][ C3] mark_usage+0x42/0x170 [ 29.106132][ C3] __lock_acquire+0x388/0xc20 [ 29.106134][ C3] lock_acquire.part.0+0xd4/0x280 [ 29.106136][ C3] ? br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 29.106145][ C3] ? rcu_is_watching+0x16/0xd0 [ 29.106148][ C3] ? lock_acquire+0x13c/0x160 [ 29.106150][ C3] ? br_message_age_timer_expired+0x70/0x70 [bridge] [ 29.106156][ C3] _raw_spin_lock+0x33/0x40 [ 29.106158][ C3] ? br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 29.106164][ C3] br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 29.106171][ C3] ? br_message_age_timer_expired+0x70/0x70 [bridge] [ 29.106177][ C3] call_timer_fn+0x160/0x4d0 [ 29.106180][ C3] ? detach_if_pending+0x1d0/0x1d0 [ 29.106182][ C3] ? debug_object_active_state+0x430/0x430 [ 29.106186][ C3] ? find_held_lock+0x2b/0x80 [ 29.106188][ C3] ? __lock_release.isra.0+0x69/0x1a0 [ 29.106190][ C3] ? rcu_is_watching+0x16/0xd0 [ 29.106192][ C3] __run_timers+0x68f/0xaa0 [ 29.106194][ C3] ? br_message_age_timer_expired+0x70/0x70 [bridge] [ 29.106201][ C3] ? __bpf_trace_itimer_expire+0x10/0x10 [ 29.106203][ C3] ? __lock_acquire+0x518/0xc20 [ 29.106206][ C3] ? __rwlock_init+0x150/0x150 [ 29.106208][ C3] run_timer_softirq+0xf0/0x160 [ 29.106210][ C3] ? __run_timers+0xaa0/0xaa0 [ 29.106212][ C3] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 29.106214][ C3] ? rcu_is_watching+0x16/0xd0 [ 29.106216][ C3] handle_softirqs+0x1d3/0x900 [ 29.106218][ C3] ? __lock_release.isra.0+0x69/0x1a0 [ 29.106220][ C3] ? _local_bh_enable+0xc0/0xc0 [ 29.106222][ C3] __irq_exit_rcu+0x145/0x1c0 [ 29.106223][ C3] irq_exit_rcu+0xe/0x30 [ 29.106224][ C3] sysvec_apic_timer_interrupt+0x9d/0xe0 [ 29.106226][ C3] [ 29.106227][ C3] [ 29.106228][ C3] ? lockdep_hardirqs_on+0x91/0x130 [ 29.106229][ C3] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 29.106231][ C3] RIP: 0010:pv_native_safe_halt+0xf/0x10 [ 29.106233][ C3] Code: 48 8b 3d 94 f2 f5 01 e8 1f 00 00 00 48 2b 05 58 b3 95 00 c3 0f 1f 80 00 00 00 00 f3 0f 1e fa eb 07 0f 00 2d 13 a6 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 [ 29.106235][ C3] RSP: 0018:ffa0000000167e00 EFLAGS: 00000282 [ 29.106238][ C3] RAX: 00000000000ad531 RBX: ff11000001c88040 RCX: ffffffff906f0307 [ 29.106239][ C3] RDX: ff11000001c88040 RSI: ffffffff93438b1c RDI: ffffffff92e8d8e0 [ 29.106240][ C3] RBP: 0000000000000000 R08: 0000000000000000 R09: 0000000000000000 [ 29.106241][ C3] R10: 0000000000000003 R11: 0000000000000001 R12: 1ff400000002cfc3 [ 29.106242][ C3] R13: 0000000000000000 R14: dffffc0000000000 R15: 0000000000000000 [ 29.106244][ C3] ? cpuidle_idle_call.constprop.0+0x237/0x410 [ 29.106246][ C3] default_idle+0x9/0x10 [ 29.106248][ C3] default_idle_call+0x6e/0xb0 [ 29.106249][ C3] cpuidle_idle_call.constprop.0+0x237/0x410 [ 29.106251][ C3] ? arch_cpu_idle_exit+0x40/0x40 [ 29.106253][ C3] ? mark_tsc_async_resets+0x30/0x30 [ 29.106254][ C3] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 29.106256][ C3] ? rcu_is_watching+0x16/0xd0 [ 29.106258][ C3] do_idle+0xd8/0x190 [ 29.106259][ C3] cpu_startup_entry+0x53/0x70 [ 29.106261][ C3] start_secondary+0x204/0x2b0 [ 29.106262][ C3] ? set_cpu_sibling_map+0x2130/0x2130 [ 29.106264][ C3] common_startup_64+0x13e/0x148 [ 29.106267][ C3] [ 33.463527][ T38] br1: port 1(lag) entered disabled state [ 33.463547][ T38] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 33.463550][ T38] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 38, name: kworker/u19:0 [ 33.463553][ T38] preempt_count: 202, expected: 0 [ 33.463554][ T38] RCU nest depth: 0, expected: 0 [ 33.463555][ T38] INFO: lockdep is turned off. [ 33.463557][ T38] irq event stamp: 139116 [ 33.463558][ T38] hardirqs last enabled at (139115): [] _raw_spin_unlock_irq+0x28/0x50 [ 33.463569][ T38] hardirqs last disabled at (139116): [] __schedule+0x1246/0x20e0 [ 33.463571][ T38] softirqs last enabled at (137740): [] handle_softirqs+0x67c/0x900 [ 33.463576][ T38] softirqs last disabled at (137731): [] __irq_exit_rcu+0x145/0x1c0 [ 33.463579][ T38] Preemption disabled at: [ 33.463580][ T38] [<0000000000000000>] 0x0 [ 33.463588][ T38] CPU: 2 UID: 0 PID: 38 Comm: kworker/u19:0 Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 33.463593][ T38] Tainted: [W]=WARN [ 33.463594][ T38] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 33.463597][ T38] Workqueue: events_unbound linkwatch_event [ 33.463603][ T38] Call Trace: [ 33.463605][ T38] [ 33.463607][ T38] dump_stack_lvl+0x6f/0xa0 [ 33.463613][ T38] __might_resched.cold+0x1fe/0x2c1 [ 33.463618][ T38] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 33.463623][ T38] ? rcu_is_watching+0x16/0xd0 [ 33.463627][ T38] __kmalloc_noprof+0x443/0x760 [ 33.463631][ T38] ? __rwlock_init+0x150/0x150 [ 33.463635][ T38] ? alloc_buf.isra.0+0x4b/0x260 [ 33.463639][ T38] ? do_raw_spin_unlock+0x59/0x250 [ 33.463642][ T38] alloc_buf.isra.0+0x4b/0x260 [ 33.463644][ T38] put_chars+0x1e1/0x2f0 [ 33.463647][ T38] ? __send_to_port+0x420/0x420 [ 33.463649][ T38] ? printk_get_next_message+0x240/0x650 [ 33.463653][ T38] ? console_prepend_replay+0x20/0x20 [ 33.463656][ T38] hvc_console_print+0x292/0x780 [ 33.463661][ T38] ? hvc_write+0x3a0/0x3a0 [ 33.463663][ T38] ? __rwlock_init+0x150/0x150 [ 33.463665][ T38] ? rcu_is_watching+0x16/0xd0 [ 33.463667][ T38] ? rcu_is_watching+0x16/0xd0 [ 33.463669][ T38] ? lock_acquire+0x13c/0x160 [ 33.463672][ T38] console_emit_next_record+0x22f/0x4c0 [ 33.463676][ T38] ? devkmsg_read+0x4b0/0x4b0 [ 33.463679][ T38] ? rcu_is_watching+0x16/0xd0 [ 33.463681][ T38] ? rcu_is_watching+0x16/0xd0 [ 33.463683][ T38] ? rcu_is_watching+0x16/0xd0 [ 33.463685][ T38] ? lock_acquire+0x13c/0x160 [ 33.463688][ T38] ? console_flush_one_record+0x111/0x710 [ 33.463690][ T38] console_flush_one_record+0x46f/0x710 [ 33.463694][ T38] ? console_emit_next_record+0x4c0/0x4c0 [ 33.463697][ T38] console_unlock+0xee/0x1f0 [ 33.463700][ T38] ? lock_acquire+0x13c/0x160 [ 33.463702][ T38] ? console_flush_one_record+0x710/0x710 [ 33.463704][ T38] ? rcu_is_watching+0x16/0xd0 [ 33.463706][ T38] ? lock_release+0x184/0x1f0 [ 33.463708][ T38] ? lock_acquire+0x60/0x160 [ 33.463710][ T38] ? __rcu_read_lock+0x30/0x70 [ 33.463713][ T38] ? __down_trylock_console_sem+0x5e/0xa0 [ 33.463716][ T38] ? vprintk_emit+0x320/0x3e0 [ 33.463718][ T38] vprintk_emit+0x37c/0x3e0 [ 33.463722][ T38] ? wake_up_klogd_work_func+0x90/0x90 [ 33.463725][ T38] ? rcu_is_watching+0x16/0xd0 [ 33.463728][ T38] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 33.463732][ T38] _printk+0xc7/0x100 [ 33.463736][ T38] ? snapshot_read.cold+0x21/0x21 [ 33.463738][ T38] ? lock_acquire+0x13c/0x160 [ 33.463741][ T38] ? fib6_del+0x320/0x320 [ 33.463746][ T38] br_set_state+0x22f/0x430 [bridge] [ 33.463765][ T38] br_stp_disable_port+0x11f/0x390 [bridge] [ 33.463778][ T38] br_port_carrier_check+0x365/0x430 [bridge] [ 33.463793][ T38] br_device_event+0x52d/0x8f0 [bridge] [ 33.463807][ T38] ? _sub_I_65535_1+0x4d0/0x4d0 [stp] [ 33.463810][ T38] ? addrconf_notify+0x500/0xf30 [ 33.463814][ T38] notifier_call_chain+0xae/0x300 [ 33.463818][ T38] netif_state_change+0x139/0x340 [ 33.463822][ T38] ? dev_deactivate+0xc1/0x210 [ 33.463825][ T38] ? call_netdevice_notifiers_info+0xd0/0xd0 [ 33.463829][ T38] ? rfc2863_policy+0x1a0/0x310 [ 33.463831][ T38] ? linkwatch_do_dev+0x9c/0xd0 [ 33.463833][ T38] __linkwatch_run_queue+0x34c/0x750 [ 33.463836][ T38] ? linkwatch_do_dev+0xd0/0xd0 [ 33.463838][ T38] ? debug_object_active_state+0x430/0x430 [ 33.463844][ T38] linkwatch_event+0x7f/0xb0 [ 33.463846][ T38] ? __linkwatch_run_queue+0x750/0x750 [ 33.463848][ T38] process_one_work+0xe3e/0x1560 [ 33.463854][ T38] ? __queue_delayed_work+0x470/0x470 [ 33.463856][ T38] ? find_held_lock+0x2b/0x80 [ 33.463859][ T38] ? __rwlock_init+0x150/0x150 [ 33.463862][ T38] worker_thread+0x4f1/0xd60 [ 33.463867][ T38] ? rescuer_thread+0x1340/0x1340 [ 33.463869][ T38] kthread+0x367/0x460 [ 33.463871][ T38] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 33.463873][ T38] ? kthread_affine_preferred+0x4c0/0x4c0 [ 33.463876][ T38] ret_from_fork+0x474/0x6b0 [ 33.463880][ T38] ? arch_exit_to_user_mode_prepare.isra.0+0x120/0x120 [ 33.463883][ T38] ? __switch_to+0x5a3/0xe00 [ 33.463886][ T38] ? kthread_affine_preferred+0x4c0/0x4c0 [ 33.463889][ T38] ret_from_fork_asm+0x11/0x20 [ 33.463894][ T38] [ 38.793852][ T38] br1: port 1(lag) entered blocking state [ 38.793871][ T38] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 38.793874][ T38] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 38, name: kworker/u19:0 [ 38.793876][ T38] preempt_count: 202, expected: 0 [ 38.793877][ T38] RCU nest depth: 0, expected: 0 [ 38.793878][ T38] INFO: lockdep is turned off. [ 38.793879][ T38] irq event stamp: 139116 [ 38.793880][ T38] hardirqs last enabled at (139115): [] _raw_spin_unlock_irq+0x28/0x50 [ 38.793890][ T38] hardirqs last disabled at (139116): [] __schedule+0x1246/0x20e0 [ 38.793892][ T38] softirqs last enabled at (137740): [] handle_softirqs+0x67c/0x900 [ 38.793897][ T38] softirqs last disabled at (137731): [] __irq_exit_rcu+0x145/0x1c0 [ 38.793900][ T38] Preemption disabled at: [ 38.793901][ T38] [<0000000000000000>] 0x0 [ 38.793908][ T38] CPU: 3 UID: 0 PID: 38 Comm: kworker/u19:0 Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 38.793918][ T38] Tainted: [W]=WARN [ 38.793919][ T38] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 38.793926][ T38] Workqueue: events_unbound linkwatch_event [ 38.793933][ T38] Call Trace: [ 38.793934][ T38] [ 38.793937][ T38] dump_stack_lvl+0x6f/0xa0 [ 38.793943][ T38] __might_resched.cold+0x1fe/0x2c1 [ 38.793947][ T38] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 38.793951][ T38] ? rcu_is_watching+0x16/0xd0 [ 38.793956][ T38] __kmalloc_noprof+0x443/0x760 [ 38.793960][ T38] ? __rwlock_init+0x150/0x150 [ 38.793963][ T38] ? alloc_buf.isra.0+0x4b/0x260 [ 38.793968][ T38] ? do_raw_spin_unlock+0x59/0x250 [ 38.793970][ T38] alloc_buf.isra.0+0x4b/0x260 [ 38.793972][ T38] put_chars+0x1e1/0x2f0 [ 38.793975][ T38] ? __send_to_port+0x420/0x420 [ 38.793977][ T38] ? printk_get_next_message+0x240/0x650 [ 38.793981][ T38] hvc_console_print+0x292/0x780 [ 38.793985][ T38] ? hvc_write+0x3a0/0x3a0 [ 38.793988][ T38] ? __rwlock_init+0x150/0x150 [ 38.793990][ T38] ? rcu_is_watching+0x16/0xd0 [ 38.793993][ T38] ? lock_acquire+0x13c/0x160 [ 38.793996][ T38] console_emit_next_record+0x22f/0x4c0 [ 38.793999][ T38] ? devkmsg_read+0x4b0/0x4b0 [ 38.794002][ T38] ? rcu_is_watching+0x16/0xd0 [ 38.794004][ T38] ? rcu_is_watching+0x16/0xd0 [ 38.794006][ T38] ? rcu_is_watching+0x16/0xd0 [ 38.794008][ T38] ? lock_acquire+0x13c/0x160 [ 38.794011][ T38] ? console_flush_one_record+0x111/0x710 [ 38.794013][ T38] console_flush_one_record+0x46f/0x710 [ 38.794016][ T38] ? console_emit_next_record+0x4c0/0x4c0 [ 38.794020][ T38] console_unlock+0xee/0x1f0 [ 38.794022][ T38] ? lock_acquire+0x13c/0x160 [ 38.794024][ T38] ? console_flush_one_record+0x710/0x710 [ 38.794026][ T38] ? rcu_is_watching+0x16/0xd0 [ 38.794028][ T38] ? lock_release+0x184/0x1f0 [ 38.794030][ T38] ? lock_acquire+0x60/0x160 [ 38.794032][ T38] ? __rcu_read_lock+0x30/0x70 [ 38.794034][ T38] ? __down_trylock_console_sem+0x5e/0xa0 [ 38.794037][ T38] ? vprintk_emit+0x320/0x3e0 [ 38.794039][ T38] vprintk_emit+0x37c/0x3e0 [ 38.794042][ T38] ? wake_up_klogd_work_func+0x90/0x90 [ 38.794045][ T38] ? do_raw_read_unlock+0x70/0x70 [ 38.794047][ T38] ? rcu_is_watching+0x16/0xd0 [ 38.794049][ T38] ? lock_acquire+0x13c/0x160 [ 38.794052][ T38] _printk+0xc7/0x100 [ 38.794056][ T38] ? snapshot_read.cold+0x21/0x21 [ 38.794058][ T38] ? netif_get_link_ksettings+0x170/0x290 [ 38.794062][ T38] ? port_cost+0xaf/0x1c0 [bridge] [ 38.794076][ T38] ? br_multicast_flood+0xab0/0xab0 [bridge] [ 38.794088][ T38] br_set_state+0x22f/0x430 [bridge] [ 38.794099][ T38] br_init_port+0xc4/0x200 [bridge] [ 38.794109][ T38] br_stp_enable_port+0x12/0x50 [bridge] [ 38.794119][ T38] br_port_carrier_check+0x220/0x430 [bridge] [ 38.794129][ T38] br_device_event+0x52d/0x8f0 [bridge] [ 38.794140][ T38] ? fib6_ifdown+0x870/0x870 [ 38.794144][ T38] ? _sub_I_65535_1+0x4d0/0x4d0 [stp] [ 38.794147][ T38] ? addrconf_notify+0xc55/0xf30 [ 38.794151][ T38] notifier_call_chain+0xae/0x300 [ 38.794155][ T38] netif_state_change+0x139/0x340 [ 38.794159][ T38] ? call_netdevice_notifiers_info+0xd0/0xd0 [ 38.794163][ T38] ? linkwatch_do_dev+0xae/0xd0 [ 38.794165][ T38] __linkwatch_run_queue+0x34c/0x750 [ 38.794167][ T38] ? linkwatch_do_dev+0xd0/0xd0 [ 38.794169][ T38] ? debug_object_active_state+0x430/0x430 [ 38.794174][ T38] linkwatch_event+0x7f/0xb0 [ 38.794176][ T38] ? __linkwatch_run_queue+0x750/0x750 [ 38.794179][ T38] process_one_work+0xe3e/0x1560 [ 38.794184][ T38] ? __queue_delayed_work+0x470/0x470 [ 38.794187][ T38] ? find_held_lock+0x2b/0x80 [ 38.794189][ T38] ? __rwlock_init+0x150/0x150 [ 38.794193][ T38] worker_thread+0x4f1/0xd60 [ 38.794197][ T38] ? rescuer_thread+0x1340/0x1340 [ 38.794199][ T38] kthread+0x367/0x460 [ 38.794201][ T38] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 38.794204][ T38] ? kthread_affine_preferred+0x4c0/0x4c0 [ 38.794207][ T38] ret_from_fork+0x474/0x6b0 [ 38.794210][ T38] ? arch_exit_to_user_mode_prepare.isra.0+0x120/0x120 [ 38.794213][ T38] ? __switch_to+0x5a3/0xe00 [ 38.794216][ T38] ? kthread_affine_preferred+0x4c0/0x4c0 [ 38.794219][ T38] ret_from_fork_asm+0x11/0x20 [ 38.794223][ T38] [ 38.814052][ T38] br1: port 1(lag) entered forwarding state [ 52.769736][ T46] br1: port 1(lag) entered disabled state [ 52.769756][ T46] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 52.769760][ T46] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 46, name: kworker/u17:1 [ 52.769762][ T46] preempt_count: 202, expected: 0 [ 52.769764][ T46] RCU nest depth: 0, expected: 0 [ 52.769765][ T46] INFO: lockdep is turned off. [ 52.769767][ T46] irq event stamp: 105778 [ 52.769768][ T46] hardirqs last enabled at (105777): [] _raw_spin_unlock_irq+0x28/0x50 [ 52.769778][ T46] hardirqs last disabled at (105778): [] __schedule+0x1246/0x20e0 [ 52.769781][ T46] softirqs last enabled at (105772): [] kernel_fpu_end+0x45/0x50 [ 52.769786][ T46] softirqs last disabled at (105770): [] kernel_fpu_begin_mask+0x143/0x250 [ 52.769789][ T46] Preemption disabled at: [ 52.769790][ T46] [<0000000000000000>] 0x0 [ 52.769798][ T46] CPU: 0 UID: 0 PID: 46 Comm: kworker/u17:1 Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 52.769803][ T46] Tainted: [W]=WARN [ 52.769804][ T46] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 52.769807][ T46] Workqueue: events_unbound linkwatch_event [ 52.769814][ T46] Call Trace: [ 52.769816][ T46] [ 52.769818][ T46] dump_stack_lvl+0x6f/0xa0 [ 52.769824][ T46] __might_resched.cold+0x1fe/0x2c1 [ 52.769829][ T46] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 52.769834][ T46] ? rcu_is_watching+0x16/0xd0 [ 52.769839][ T46] __kmalloc_noprof+0x443/0x760 [ 52.769843][ T46] ? __rwlock_init+0x150/0x150 [ 52.769847][ T46] ? alloc_buf.isra.0+0x4b/0x260 [ 52.769852][ T46] ? do_raw_spin_unlock+0x59/0x250 [ 52.769854][ T46] alloc_buf.isra.0+0x4b/0x260 [ 52.769857][ T46] put_chars+0x1e1/0x2f0 [ 52.769860][ T46] ? __send_to_port+0x420/0x420 [ 52.769862][ T46] ? printk_get_next_message+0x240/0x650 [ 52.769866][ T46] ? console_prepend_replay+0x20/0x20 [ 52.769869][ T46] hvc_console_print+0x292/0x780 [ 52.769874][ T46] ? hvc_write+0x3a0/0x3a0 [ 52.769876][ T46] ? __rwlock_init+0x150/0x150 [ 52.769878][ T46] ? rcu_is_watching+0x16/0xd0 [ 52.769881][ T46] ? rcu_is_watching+0x16/0xd0 [ 52.769883][ T46] ? lock_acquire+0x13c/0x160 [ 52.769886][ T46] console_emit_next_record+0x22f/0x4c0 [ 52.769890][ T46] ? devkmsg_read+0x4b0/0x4b0 [ 52.769893][ T46] ? rcu_is_watching+0x16/0xd0 [ 52.769895][ T46] ? rcu_is_watching+0x16/0xd0 [ 52.769897][ T46] ? rcu_is_watching+0x16/0xd0 [ 52.769900][ T46] ? lock_acquire+0x13c/0x160 [ 52.769903][ T46] ? console_flush_one_record+0x111/0x710 [ 52.769905][ T46] console_flush_one_record+0x46f/0x710 [ 52.769909][ T46] ? console_emit_next_record+0x4c0/0x4c0 [ 52.769913][ T46] console_unlock+0xee/0x1f0 [ 52.769915][ T46] ? lock_acquire+0x13c/0x160 [ 52.769917][ T46] ? console_flush_one_record+0x710/0x710 [ 52.769920][ T46] ? rcu_is_watching+0x16/0xd0 [ 52.769922][ T46] ? lock_release+0x184/0x1f0 [ 52.769927][ T46] ? lock_acquire+0x60/0x160 [ 52.769929][ T46] ? __rcu_read_lock+0x30/0x70 [ 52.769932][ T46] ? __down_trylock_console_sem+0x5e/0xa0 [ 52.769935][ T46] ? vprintk_emit+0x320/0x3e0 [ 52.769938][ T46] vprintk_emit+0x37c/0x3e0 [ 52.769942][ T46] ? wake_up_klogd_work_func+0x90/0x90 [ 52.769945][ T46] ? rcu_is_watching+0x16/0xd0 [ 52.769948][ T46] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 52.769952][ T46] _printk+0xc7/0x100 [ 52.769960][ T46] ? snapshot_read.cold+0x21/0x21 [ 52.769963][ T46] ? lock_acquire+0x13c/0x160 [ 52.769966][ T46] ? fib6_del+0x320/0x320 [ 52.769972][ T46] br_set_state+0x22f/0x430 [bridge] [ 52.769991][ T46] br_stp_disable_port+0x11f/0x390 [bridge] [ 52.770004][ T46] br_port_carrier_check+0x365/0x430 [bridge] [ 52.770018][ T46] br_device_event+0x52d/0x8f0 [bridge] [ 52.770031][ T46] ? _sub_I_65535_1+0x4d0/0x4d0 [stp] [ 52.770035][ T46] ? addrconf_notify+0x500/0xf30 [ 52.770040][ T46] notifier_call_chain+0xae/0x300 [ 52.770044][ T46] netif_state_change+0x139/0x340 [ 52.770048][ T46] ? dev_deactivate+0xc1/0x210 [ 52.770052][ T46] ? call_netdevice_notifiers_info+0xd0/0xd0 [ 52.770055][ T46] ? rfc2863_policy+0x1a0/0x310 [ 52.770058][ T46] ? linkwatch_do_dev+0x9c/0xd0 [ 52.770060][ T46] __linkwatch_run_queue+0x34c/0x750 [ 52.770063][ T46] ? linkwatch_do_dev+0xd0/0xd0 [ 52.770065][ T46] ? debug_object_active_state+0x430/0x430 [ 52.770071][ T46] linkwatch_event+0x7f/0xb0 [ 52.770073][ T46] ? __linkwatch_run_queue+0x750/0x750 [ 52.770076][ T46] process_one_work+0xe3e/0x1560 [ 52.770081][ T46] ? __queue_delayed_work+0x470/0x470 [ 52.770084][ T46] ? find_held_lock+0x2b/0x80 [ 52.770087][ T46] ? __rwlock_init+0x150/0x150 [ 52.770091][ T46] worker_thread+0x4f1/0xd60 [ 52.770096][ T46] ? rescuer_thread+0x1340/0x1340 [ 52.770098][ T46] kthread+0x367/0x460 [ 52.770101][ T46] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 52.770103][ T46] ? kthread_affine_preferred+0x4c0/0x4c0 [ 52.770105][ T46] ret_from_fork+0x474/0x6b0 [ 52.770108][ T46] ? arch_exit_to_user_mode_prepare.isra.0+0x120/0x120 [ 52.770111][ T46] ? __switch_to+0x5a3/0xe00 [ 52.770114][ T46] ? kthread_affine_preferred+0x4c0/0x4c0 [ 52.770117][ T46] ret_from_fork_asm+0x11/0x20 [ 52.770122][ T46] [ 58.054062][ T46] br1: port 1(lag) entered blocking state [ 58.054080][ T46] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 58.054083][ T46] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 46, name: kworker/u17:1 [ 58.054085][ T46] preempt_count: 202, expected: 0 [ 58.054086][ T46] RCU nest depth: 0, expected: 0 [ 58.054087][ T46] INFO: lockdep is turned off. [ 58.054088][ T46] irq event stamp: 105778 [ 58.054089][ T46] hardirqs last enabled at (105777): [] _raw_spin_unlock_irq+0x28/0x50 [ 58.054097][ T46] hardirqs last disabled at (105778): [] __schedule+0x1246/0x20e0 [ 58.054099][ T46] softirqs last enabled at (105772): [] kernel_fpu_end+0x45/0x50 [ 58.054103][ T46] softirqs last disabled at (105770): [] kernel_fpu_begin_mask+0x143/0x250 [ 58.054106][ T46] Preemption disabled at: [ 58.054106][ T46] [<0000000000000000>] 0x0 [ 58.054113][ T46] CPU: 0 UID: 0 PID: 46 Comm: kworker/u17:1 Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 58.054116][ T46] Tainted: [W]=WARN [ 58.054117][ T46] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 58.054119][ T46] Workqueue: events_unbound linkwatch_event [ 58.054126][ T46] Call Trace: [ 58.054127][ T46] [ 58.054129][ T46] dump_stack_lvl+0x6f/0xa0 [ 58.054134][ T46] __might_resched.cold+0x1fe/0x2c1 [ 58.054138][ T46] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 58.054142][ T46] ? rcu_is_watching+0x16/0xd0 [ 58.054146][ T46] __kmalloc_noprof+0x443/0x760 [ 58.054149][ T46] ? __rwlock_init+0x150/0x150 [ 58.054152][ T46] ? alloc_buf.isra.0+0x4b/0x260 [ 58.054156][ T46] ? do_raw_spin_unlock+0x59/0x250 [ 58.054157][ T46] alloc_buf.isra.0+0x4b/0x260 [ 58.054159][ T46] put_chars+0x1e1/0x2f0 [ 58.054161][ T46] ? __send_to_port+0x420/0x420 [ 58.054163][ T46] ? printk_get_next_message+0x240/0x650 [ 58.054166][ T46] hvc_console_print+0x292/0x780 [ 58.054170][ T46] ? hvc_write+0x3a0/0x3a0 [ 58.054173][ T46] ? __rwlock_init+0x150/0x150 [ 58.054174][ T46] ? rcu_is_watching+0x16/0xd0 [ 58.054176][ T46] ? lock_acquire+0x13c/0x160 [ 58.054179][ T46] console_emit_next_record+0x22f/0x4c0 [ 58.054181][ T46] ? devkmsg_read+0x4b0/0x4b0 [ 58.054183][ T46] ? rcu_is_watching+0x16/0xd0 [ 58.054185][ T46] ? rcu_is_watching+0x16/0xd0 [ 58.054186][ T46] ? rcu_is_watching+0x16/0xd0 [ 58.054188][ T46] ? lock_acquire+0x13c/0x160 [ 58.054190][ T46] ? console_flush_one_record+0x111/0x710 [ 58.054191][ T46] console_flush_one_record+0x46f/0x710 [ 58.054194][ T46] ? console_emit_next_record+0x4c0/0x4c0 [ 58.054196][ T46] console_unlock+0xee/0x1f0 [ 58.054198][ T46] ? lock_acquire+0x13c/0x160 [ 58.054200][ T46] ? console_flush_one_record+0x710/0x710 [ 58.054201][ T46] ? rcu_is_watching+0x16/0xd0 [ 58.054203][ T46] ? lock_release+0x184/0x1f0 [ 58.054204][ T46] ? lock_acquire+0x60/0x160 [ 58.054206][ T46] ? __rcu_read_lock+0x30/0x70 [ 58.054208][ T46] ? __down_trylock_console_sem+0x5e/0xa0 [ 58.054210][ T46] ? vprintk_emit+0x320/0x3e0 [ 58.054212][ T46] vprintk_emit+0x37c/0x3e0 [ 58.054214][ T46] ? wake_up_klogd_work_func+0x90/0x90 [ 58.054216][ T46] ? do_raw_read_unlock+0x70/0x70 [ 58.054218][ T46] ? rcu_is_watching+0x16/0xd0 [ 58.054220][ T46] ? lock_acquire+0x13c/0x160 [ 58.054222][ T46] _printk+0xc7/0x100 [ 58.054225][ T46] ? snapshot_read.cold+0x21/0x21 [ 58.054226][ T46] ? netif_get_link_ksettings+0x170/0x290 [ 58.054229][ T46] ? port_cost+0xaf/0x1c0 [bridge] [ 58.054242][ T46] ? br_multicast_flood+0xab0/0xab0 [bridge] [ 58.054250][ T46] br_set_state+0x22f/0x430 [bridge] [ 58.054259][ T46] br_init_port+0xc4/0x200 [bridge] [ 58.054266][ T46] br_stp_enable_port+0x12/0x50 [bridge] [ 58.054273][ T46] br_port_carrier_check+0x220/0x430 [bridge] [ 58.054280][ T46] br_device_event+0x52d/0x8f0 [bridge] [ 58.054287][ T46] ? fib6_ifdown+0x870/0x870 [ 58.054291][ T46] ? _sub_I_65535_1+0x4d0/0x4d0 [stp] [ 58.054293][ T46] ? addrconf_notify+0xc55/0xf30 [ 58.054297][ T46] notifier_call_chain+0xae/0x300 [ 58.054300][ T46] netif_state_change+0x139/0x340 [ 58.054303][ T46] ? call_netdevice_notifiers_info+0xd0/0xd0 [ 58.054306][ T46] ? linkwatch_do_dev+0xae/0xd0 [ 58.054307][ T46] __linkwatch_run_queue+0x34c/0x750 [ 58.054309][ T46] ? linkwatch_do_dev+0xd0/0xd0 [ 58.054311][ T46] ? debug_object_active_state+0x430/0x430 [ 58.054315][ T46] linkwatch_event+0x7f/0xb0 [ 58.054316][ T46] ? __linkwatch_run_queue+0x750/0x750 [ 58.054318][ T46] process_one_work+0xe3e/0x1560 [ 58.054322][ T46] ? __queue_delayed_work+0x470/0x470 [ 58.054324][ T46] ? find_held_lock+0x2b/0x80 [ 58.054326][ T46] ? __rwlock_init+0x150/0x150 [ 58.054328][ T46] worker_thread+0x4f1/0xd60 [ 58.054331][ T46] ? rescuer_thread+0x1340/0x1340 [ 58.054332][ T46] kthread+0x367/0x460 [ 58.054334][ T46] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 58.054337][ T46] ? kthread_affine_preferred+0x4c0/0x4c0 [ 58.054339][ T46] ret_from_fork+0x474/0x6b0 [ 58.054340][ T46] ? arch_exit_to_user_mode_prepare.isra.0+0x120/0x120 [ 58.054342][ T46] ? __switch_to+0x5a3/0xe00 [ 58.054345][ T46] ? kthread_affine_preferred+0x4c0/0x4c0 [ 58.054346][ T46] ret_from_fork_asm+0x11/0x20 [ 58.054350][ T46] [ 58.070293][ T46] br1: port 1(lag) entered forwarding state [ 58.258019][ T462] lag: left allmulticast mode [ 58.258263][ T462] veth2: left allmulticast mode [ 58.258466][ T462] veth4: left allmulticast mode [ 58.258715][ T462] br1: port 1(lag) entered disabled state [ 58.268572][ T462] veth2: left promiscuous mode [ 58.268788][ T462] veth4: left promiscuous mode [ 58.293817][ T299] lag: Port device veth4 removed [ 58.296279][ T299] lag: Port device veth2 removed