[ 9.501833][ T188] ip (188) used greatest stack depth: 24112 bytes left [ 9.501849][ T188] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 9.501851][ T188] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 188, name: ip [ 9.501852][ T188] preempt_count: 2, expected: 0 [ 9.501853][ T188] RCU nest depth: 0, expected: 0 [ 9.501854][ T188] locks held by ip/188: 5, last CPU#0: [ 9.501856][ T188] #0: ffffffffa42027b8 (low_water_lock){+.+.}-{3:3}, at: do_exit+0x887/0xdc0 [ 9.501870][ T188] #1: ffffffffa4369cc0 (console_lock){+.+.}-{0:0}, at: vprintk_emit+0x320/0x3e0 [ 9.501875][ T188] #2: ffffffffa4369d38 (console_srcu){....}-{0:0}, at: console_flush_one_record+0x106/0x710 [ 9.501879][ T188] #3: ffffffffa4289660 (console_owner){....}-{0:0}, at: console_lock_spinning_enable+0x40/0x60 [ 9.501883][ T188] #4: ffffffffa4289560 (printk_legacy_map-wait-type-override){....}-{3:3}, at: console_emit_next_record+0x1df/0x4c0 [ 9.501887][ T188] irq event stamp: 38220 [ 9.501888][ T188] hardirqs last enabled at (38219): [] __down_trylock_console_sem+0x86/0xa0 [ 9.501890][ T188] hardirqs last disabled at (38220): [] console_emit_next_record+0x3d4/0x4c0 [ 9.501892][ T188] softirqs last enabled at (37416): [] handle_softirqs+0x67c/0x900 [ 9.501894][ T188] softirqs last disabled at (37411): [] __irq_exit_rcu+0x145/0x1c0 [ 9.501896][ T188] Preemption disabled at: [ 9.501897][ T188] [<0000000000000000>] 0x0 [ 9.501904][ T188] CPU: 0 UID: 0 PID: 188 Comm: ip Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 9.501908][ T188] Tainted: [W]=WARN [ 9.501909][ T188] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 9.501910][ T188] Call Trace: [ 9.501912][ T188] [ 9.501913][ T188] dump_stack_lvl+0x6f/0xa0 [ 9.501920][ T188] __might_resched.cold+0x1fe/0x2c1 [ 9.501924][ T188] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 9.501929][ T188] ? __kmalloc_noprof+0xdb/0x760 [ 9.501934][ T188] __kmalloc_noprof+0x443/0x760 [ 9.501936][ T188] ? alloc_buf.isra.0+0x4b/0x260 [ 9.501942][ T188] ? do_raw_spin_unlock+0x59/0x250 [ 9.501945][ T188] alloc_buf.isra.0+0x4b/0x260 [ 9.501948][ T188] put_chars+0x1e1/0x2f0 [ 9.501951][ T188] ? __send_to_port+0x420/0x420 [ 9.501952][ T188] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 9.501957][ T188] ? validate_chain+0x38b/0xc20 [ 9.501963][ T188] hvc_console_print+0x292/0x780 [ 9.501969][ T188] ? hvc_write+0x3a0/0x3a0 [ 9.501971][ T188] ? rcu_is_watching+0x16/0xd0 [ 9.501974][ T188] ? lock_acquire+0x13c/0x160 [ 9.501978][ T188] console_emit_next_record+0x22f/0x4c0 [ 9.501982][ T188] ? devkmsg_read+0x4b0/0x4b0 [ 9.501984][ T188] ? console_flush_one_record+0x106/0x710 [ 9.501987][ T188] ? rcu_is_watching+0x16/0xd0 [ 9.501990][ T188] ? lock_acquire+0x13c/0x160 [ 9.501994][ T188] console_flush_one_record+0x46f/0x710 [ 9.501998][ T188] ? console_emit_next_record+0x4c0/0x4c0 [ 9.502000][ T188] ? __lock_acquire+0x518/0xc20 [ 9.502006][ T188] console_unlock+0xee/0x1f0 [ 9.502009][ T188] ? console_flush_one_record+0x710/0x710 [ 9.502011][ T188] ? rcu_is_watching+0x16/0xd0 [ 9.502013][ T188] ? lock_acquire+0x60/0x160 [ 9.502017][ T188] ? __down_trylock_console_sem+0x5e/0xa0 [ 9.502019][ T188] ? vprintk_emit+0x320/0x3e0 [ 9.502022][ T188] vprintk_emit+0x37c/0x3e0 [ 9.502026][ T188] ? wake_up_klogd_work_func+0x90/0x90 [ 9.502030][ T188] ? __lock_acquire+0x518/0xc20 [ 9.502034][ T188] _printk+0xc7/0x100 [ 9.502037][ T188] ? snapshot_read.cold+0x21/0x21 [ 9.502040][ T188] ? do_raw_spin_lock+0x131/0x280 [ 9.502043][ T188] ? __rwlock_init+0x150/0x150 [ 9.502047][ T188] ? do_raw_spin_lock+0x131/0x280 [ 9.502050][ T188] do_exit.cold+0x82/0x9c [ 9.502053][ T188] ? exit_notify+0x890/0x890 [ 9.502056][ T188] ? __lock_release.isra.0+0x69/0x1a0 [ 9.502058][ T188] ? rcu_is_watching+0x16/0xd0 [ 9.502063][ T188] do_group_exit+0xb8/0x370 [ 9.502066][ T188] __x64_sys_exit_group+0x3c/0x50 [ 9.502068][ T188] x64_sys_call+0x1567/0x1570 [ 9.502070][ T188] do_syscall_64+0xff/0x530 [ 9.502073][ T188] ? exc_page_fault+0xee/0x100 [ 9.502076][ T188] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 9.502078][ T188] RIP: 0033:0x7f7c308ec1b8 [ 9.502081][ T188] Code: Unable to access opcode bytes at 0x7f7c308ec18e. [ 9.502082][ T188] RSP: 002b:00007ffef04597a8 EFLAGS: 00000246 ORIG_RAX: 00000000000000e7 [ 9.502084][ T188] RAX: ffffffffffffffda RBX: 00007f7c30a1cf88 RCX: 00007f7c308ec1b8 [ 9.502085][ T188] RDX: 00007f7c30636fc8 RSI: fffffffffffffeb8 RDI: 0000000000000000 [ 9.502086][ T188] RBP: 00007ffef0459800 R08: 0000000000000000 R09: 0000000000008010 [ 9.502087][ T188] R10: 00007ffef04595c0 R11: 0000000000000246 R12: 0000000000000001 [ 9.502088][ T188] R13: 0000000000000000 R14: 00007f7c30a1b680 R15: 00007f7c30a1cfa0 [ 9.502095][ T188] [ 10.698378][ T238] 8021q: 802.1Q VLAN Support v1.8 [ 10.698395][ T238] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 10.698398][ T238] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 238, name: modprobe [ 10.698399][ T238] preempt_count: 1, expected: 0 [ 10.698400][ T238] RCU nest depth: 0, expected: 0 [ 10.698401][ T238] locks held by modprobe/238: 4, last CPU#2: [ 10.698406][ T238] #0: ffffffffa4369cc0 (console_lock){+.+.}-{0:0}, at: vprintk_emit+0x320/0x3e0 [ 10.698417][ T238] #1: ffffffffa4369d38 (console_srcu){....}-{0:0}, at: console_flush_one_record+0x106/0x710 [ 10.698422][ T238] #2: ffffffffa4289660 (console_owner){....}-{0:0}, at: console_lock_spinning_enable+0x40/0x60 [ 10.698426][ T238] #3: ffffffffa4289560 (printk_legacy_map-wait-type-override){....}-{3:3}, at: console_emit_next_record+0x1df/0x4c0 [ 10.698430][ T238] irq event stamp: 26652 [ 10.698431][ T238] hardirqs last enabled at (26651): [] __down_trylock_console_sem+0x86/0xa0 [ 10.698433][ T238] hardirqs last disabled at (26652): [] console_emit_next_record+0x3d4/0x4c0 [ 10.698435][ T238] softirqs last enabled at (23156): [] handle_softirqs+0x67c/0x900 [ 10.698438][ T238] softirqs last disabled at (23149): [] __irq_exit_rcu+0x145/0x1c0 [ 10.698441][ T238] Preemption disabled at: [ 10.698441][ T238] [] vprintk_emit+0x31b/0x3e0 [ 10.698447][ T238] CPU: 2 UID: 0 PID: 238 Comm: modprobe Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 10.698450][ T238] Tainted: [W]=WARN [ 10.698451][ T238] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 10.698453][ T238] Call Trace: [ 10.698454][ T238] [ 10.698456][ T238] dump_stack_lvl+0x6f/0xa0 [ 10.698461][ T238] ? vprintk_emit+0x31b/0x3e0 [ 10.698464][ T238] __might_resched.cold+0x1fe/0x2c1 [ 10.698468][ T238] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 10.698472][ T238] ? __kmalloc_noprof+0xdb/0x760 [ 10.698478][ T238] __kmalloc_noprof+0x443/0x760 [ 10.698480][ T238] ? alloc_buf.isra.0+0x4b/0x260 [ 10.698486][ T238] ? do_raw_spin_unlock+0x59/0x250 [ 10.698488][ T238] alloc_buf.isra.0+0x4b/0x260 [ 10.698492][ T238] put_chars+0x1e1/0x2f0 [ 10.698495][ T238] ? __send_to_port+0x420/0x420 [ 10.698496][ T238] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 10.698500][ T238] ? rcu_read_lock_any_held+0x3c/0x90 [ 10.698503][ T238] ? validate_chain+0x38b/0xc20 [ 10.698507][ T238] hvc_console_print+0x292/0x780 [ 10.698509][ T238] ? __lock_acquire+0x518/0xc20 [ 10.698514][ T238] ? hvc_write+0x3a0/0x3a0 [ 10.698516][ T238] ? rcu_is_watching+0x16/0xd0 [ 10.698521][ T238] console_emit_next_record+0x22f/0x4c0 [ 10.698525][ T238] ? devkmsg_read+0x4b0/0x4b0 [ 10.698526][ T238] ? console_flush_one_record+0x106/0x710 [ 10.698529][ T238] ? rcu_is_watching+0x16/0xd0 [ 10.698532][ T238] ? lock_acquire+0x13c/0x160 [ 10.698535][ T238] console_flush_one_record+0x46f/0x710 [ 10.698539][ T238] ? console_emit_next_record+0x4c0/0x4c0 [ 10.698541][ T238] ? __lock_acquire+0x518/0xc20 [ 10.698546][ T238] console_unlock+0xee/0x1f0 [ 10.698549][ T238] ? console_flush_one_record+0x710/0x710 [ 10.698550][ T238] ? rcu_is_watching+0x16/0xd0 [ 10.698553][ T238] ? lock_acquire+0x60/0x160 [ 10.698556][ T238] ? __down_trylock_console_sem+0x5e/0xa0 [ 10.698558][ T238] ? vprintk_emit+0x320/0x3e0 [ 10.698561][ T238] vprintk_emit+0x37c/0x3e0 [ 10.698565][ T238] ? wake_up_klogd_work_func+0x90/0x90 [ 10.698570][ T238] ? vlan_netlink_fini+0x960/0x960 [8021q] [ 10.698574][ T238] _printk+0xc7/0x100 [ 10.698578][ T238] ? snapshot_read.cold+0x21/0x21 [ 10.698584][ T238] ? do_one_initcall+0x113/0x4f0 [ 10.698586][ T238] vlan_proto_init+0x24/0x90 [8021q] [ 10.698589][ T238] do_one_initcall+0x124/0x4f0 [ 10.698592][ T238] ? trace_event_raw_event_initcall_level+0x280/0x280 [ 10.698596][ T238] ? do_init_module+0xae/0x8a0 [ 10.698599][ T238] ? kasan_unpoison+0x44/0x70 [ 10.698612][ T238] do_init_module+0x2ad/0x8a0 [ 10.698616][ T238] ? lockdep_hardirqs_on+0x91/0x130 [ 10.698620][ T238] ? free_module+0x470/0x470 [ 10.698623][ T238] ? kfree+0x123/0x590 [ 10.698627][ T238] load_module+0x1424/0x1bb0 [ 10.698634][ T238] ? layout_and_allocate.isra.0+0x680/0x680 [ 10.698637][ T238] ? __ia32_sys_fsconfig+0x180/0x180 [ 10.698641][ T238] ? find_held_lock+0x2b/0x80 [ 10.698643][ T238] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 10.698647][ T238] init_module_from_file+0x11f/0x1a0 [ 10.698650][ T238] ? __do_sys_init_module+0x220/0x220 [ 10.698658][ T238] ? __rwlock_init+0x150/0x150 [ 10.698661][ T238] ? do_raw_spin_unlock+0x59/0x250 [ 10.698664][ T238] idempotent_init_module+0x37b/0x7c0 [ 10.698667][ T238] ? init_module_from_file+0x1a0/0x1a0 [ 10.698673][ T238] ? rcu_is_watching+0x16/0xd0 [ 10.698676][ T238] ? cap_capable+0x1d7/0x3d0 [ 10.698682][ T238] __x64_sys_finit_module+0xdf/0x190 [ 10.698684][ T238] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 10.698687][ T238] do_syscall_64+0xff/0x530 [ 10.698689][ T238] ? exc_page_fault+0xee/0x100 [ 10.698692][ T238] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 10.698694][ T238] RIP: 0033:0x7f985e41837d [ 10.698697][ T238] 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.698699][ T238] RSP: 002b:00007fff23bda048 EFLAGS: 00000246 ORIG_RAX: 0000000000000139 [ 10.698702][ T238] RAX: ffffffffffffffda RBX: 00005587b5a0f810 RCX: 00007f985e41837d [ 10.698703][ T238] RDX: 0000000000000000 RSI: 0000558795e07ffd RDI: 0000000000000000 [ 10.698704][ T238] RBP: 00007fff23bda0e0 R08: 0000000000000000 R09: 0000000000000000 [ 10.698705][ T238] R10: 0000000000000000 R11: 0000000000000246 R12: 0000558795e07ffd [ 10.698706][ T238] R13: 00005587b5a0f960 R14: 0000000000040000 R15: 0000000000000000 [ 10.698712][ T238] [ 12.150662][ T290] br1: port 1(vx10) entered blocking state [ 12.150781][ T290] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 12.150784][ T290] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 290, name: ip [ 12.150785][ T290] preempt_count: 1, expected: 0 [ 12.150786][ T290] RCU nest depth: 0, expected: 0 [ 12.150787][ T290] locks held by ip/290: 5, last CPU#3: [ 12.150789][ T290] #0: ffffffffa4ad2c40 (rtnl_mutex){+.+.}-{4:4}, at: rtnl_newlink+0x9a8/0x11c0 [ 12.150801][ T290] #1: ffffffffa4369cc0 (console_lock){+.+.}-{0:0}, at: vprintk_emit+0x320/0x3e0 [ 12.150807][ T290] #2: ffffffffa4369d38 (console_srcu){....}-{0:0}, at: console_flush_one_record+0x106/0x710 [ 12.150811][ T290] #3: ffffffffa4289660 (console_owner){....}-{0:0}, at: console_lock_spinning_enable+0x40/0x60 [ 12.150815][ T290] #4: ffffffffa4289560 (printk_legacy_map-wait-type-override){....}-{3:3}, at: console_emit_next_record+0x1df/0x4c0 [ 12.150819][ T290] irq event stamp: 11944 [ 12.150820][ T290] hardirqs last enabled at (11943): [] __down_trylock_console_sem+0x86/0xa0 [ 12.150822][ T290] hardirqs last disabled at (11944): [] console_emit_next_record+0x3d4/0x4c0 [ 12.150825][ T290] softirqs last enabled at (11850): [] __alloc_skb+0x4c2/0x5f0 [ 12.150828][ T290] softirqs last disabled at (11848): [] __alloc_skb+0x4c2/0x5f0 [ 12.150830][ T290] Preemption disabled at: [ 12.150831][ T290] [] vprintk_emit+0x31b/0x3e0 [ 12.150837][ T290] CPU: 3 UID: 0 PID: 290 Comm: ip Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 12.150840][ T290] Tainted: [W]=WARN [ 12.150841][ T290] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 12.150843][ T290] Call Trace: [ 12.150844][ T290] [ 12.150846][ T290] dump_stack_lvl+0x6f/0xa0 [ 12.150852][ T290] ? vprintk_emit+0x31b/0x3e0 [ 12.150854][ T290] __might_resched.cold+0x1fe/0x2c1 [ 12.150859][ T290] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 12.150863][ T290] ? __kmalloc_noprof+0xdb/0x760 [ 12.150869][ T290] __kmalloc_noprof+0x443/0x760 [ 12.150871][ T290] ? alloc_buf.isra.0+0x4b/0x260 [ 12.150877][ T290] ? do_raw_spin_unlock+0x59/0x250 [ 12.150879][ T290] alloc_buf.isra.0+0x4b/0x260 [ 12.150883][ T290] put_chars+0x1e1/0x2f0 [ 12.150886][ T290] ? __send_to_port+0x420/0x420 [ 12.150890][ T290] ? validate_chain+0x34a/0xc20 [ 12.150894][ T290] hvc_console_print+0x292/0x780 [ 12.150896][ T290] ? mark_usage+0x61/0x170 [ 12.150898][ T290] ? __lock_acquire+0x518/0xc20 [ 12.150900][ T290] ? __lock_acquire+0x518/0xc20 [ 12.150904][ T290] ? hvc_write+0x3a0/0x3a0 [ 12.150906][ T290] ? console_emit_next_record+0x1df/0x4c0 [ 12.150909][ T290] ? rcu_is_watching+0x16/0xd0 [ 12.150913][ T290] ? lock_acquire+0x13c/0x160 [ 12.150917][ T290] console_emit_next_record+0x22f/0x4c0 [ 12.150921][ T290] ? devkmsg_read+0x4b0/0x4b0 [ 12.150923][ T290] ? console_flush_one_record+0x106/0x710 [ 12.150926][ T290] ? rcu_is_watching+0x16/0xd0 [ 12.150928][ T290] ? lock_acquire+0x13c/0x160 [ 12.150932][ T290] console_flush_one_record+0x46f/0x710 [ 12.150936][ T290] ? console_emit_next_record+0x4c0/0x4c0 [ 12.150938][ T290] ? __lock_acquire+0x518/0xc20 [ 12.150944][ T290] console_unlock+0xee/0x1f0 [ 12.150946][ T290] ? console_flush_one_record+0x710/0x710 [ 12.150948][ T290] ? rcu_is_watching+0x16/0xd0 [ 12.150951][ T290] ? lock_acquire+0x60/0x160 [ 12.150955][ T290] ? __down_trylock_console_sem+0x5e/0xa0 [ 12.150956][ T290] ? vprintk_emit+0x320/0x3e0 [ 12.150960][ T290] vprintk_emit+0x37c/0x3e0 [ 12.150964][ T290] ? wake_up_klogd_work_func+0x90/0x90 [ 12.150966][ T290] ? __lock_release.isra.0+0x69/0x1a0 [ 12.150968][ T290] ? _raw_spin_unlock_irqrestore+0x40/0x80 [ 12.150973][ T290] ? mark_held_locks+0x40/0x70 [ 12.150976][ T290] _printk+0xc7/0x100 [ 12.150980][ T290] ? snapshot_read.cold+0x21/0x21 [ 12.150984][ T290] ? br_multicast_flood+0xab0/0xab0 [bridge] [ 12.150997][ T290] ? do_setlink.isra.0+0xa31/0x2750 [ 12.150998][ T290] ? rtnl_newlink+0x9f1/0x11c0 [ 12.150999][ T290] ? rtnetlink_rcv_msg+0x6fd/0xbd0 [ 12.151004][ T290] br_set_state+0x22f/0x430 [bridge] [ 12.151014][ T290] br_init_port+0xc4/0x200 [bridge] [ 12.151023][ T290] new_nbp+0x39c/0x580 [bridge] [ 12.151033][ T290] br_add_if+0x212/0x1320 [bridge] [ 12.151040][ T290] ? is_bpf_text_address+0x72/0x110 [ 12.151044][ T290] ? kernel_text_address+0x149/0x170 [ 12.151047][ T290] ? __kernel_text_address+0x12/0x30 [ 12.151051][ T290] do_set_master+0x357/0x580 [ 12.151055][ T290] do_setlink.isra.0+0xa31/0x2750 [ 12.151058][ T290] ? stack_trace_save+0x93/0xc0 [ 12.151061][ T290] ? rtnl_link_get_size+0x350/0x350 [ 12.151063][ T290] ? rcu_read_lock_any_held+0x66/0x90 [ 12.151065][ T290] ? stack_depot_save_flags+0x38e/0x790 [ 12.151069][ T290] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 12.151072][ T290] ? rcu_read_lock_any_held+0x3c/0x90 [ 12.151073][ T290] ? validate_chain+0x38b/0xc20 [ 12.151076][ T290] ? kasan_save_stack+0x3d/0x50 [ 12.151079][ T290] ? kasan_save_stack+0x2f/0x50 [ 12.151081][ T290] ? kasan_save_track+0x14/0x30 [ 12.151084][ T290] ? __lock_acquire+0x518/0xc20 [ 12.151085][ T290] ? netlink_seq_next+0x4e/0x60 [ 12.151088][ T290] ? ___sys_sendmsg+0xb0/0x1d0 [ 12.151093][ T290] ? lock_acquire.part.0+0xd4/0x280 [ 12.151095][ T290] ? rtnl_newlink+0x9a8/0x11c0 [ 12.151097][ T290] ? rcu_is_watching+0x16/0xd0 [ 12.151100][ T290] ? lock_acquire+0x13c/0x160 [ 12.151101][ T290] ? rcu_is_watching+0x16/0xd0 [ 12.151103][ T290] ? rcu_is_watching+0x16/0xd0 [ 12.151106][ T290] ? trace_contention_end+0xb3/0x180 [ 12.151109][ T290] ? __mutex_lock+0x1db/0x1ea0 [ 12.151111][ T290] ? __mutex_lock+0x9a3/0x1ea0 [ 12.151113][ T290] ? rtnl_newlink+0x9a8/0x11c0 [ 12.151117][ T290] ? ww_mutex_lock+0x160/0x160 [ 12.151118][ T290] ? nla_get_range_signed+0x3d0/0x3d0 [ 12.151123][ T290] ? __rtnl_newlink+0x3fa/0xa50 [ 12.151128][ T290] rtnl_newlink+0x9f1/0x11c0 [ 12.151134][ T290] ? rtnl_bridge_getlink+0x850/0x850 [ 12.151136][ T290] ? __lock_acquire+0x518/0xc20 [ 12.151140][ T290] ? lock_acquire.part.0+0xd4/0x280 [ 12.151142][ T290] ? find_held_lock+0x2b/0x80 [ 12.151144][ T290] ? rtnl_bridge_getlink+0x850/0x850 [ 12.151146][ T290] ? __lock_release.isra.0+0x69/0x1a0 [ 12.151150][ T290] ? rtnl_bridge_getlink+0x850/0x850 [ 12.151152][ T290] rtnetlink_rcv_msg+0x6fd/0xbd0 [ 12.151155][ T290] ? rtnl_link_fill+0x920/0x920 [ 12.151156][ T290] ? __lock_acquire+0x518/0xc20 [ 12.151160][ T290] ? lock_acquire.part.0+0xd4/0x280 [ 12.151162][ T290] ? find_held_lock+0x2b/0x80 [ 12.151166][ T290] netlink_rcv_skb+0x14e/0x3a0 [ 12.151168][ T290] ? rtnl_link_fill+0x920/0x920 [ 12.151171][ T290] ? netlink_ack+0xcf0/0xcf0 [ 12.151177][ T290] ? netlink_deliver_tap+0xc5/0x330 [ 12.151178][ T290] ? netlink_deliver_tap+0x13c/0x330 [ 12.151182][ T290] netlink_unicast+0x486/0x750 [ 12.151186][ T290] ? netlink_attachskb+0x810/0x810 [ 12.151189][ T290] ? __lock_acquire+0x518/0xc20 [ 12.151193][ T290] netlink_sendmsg+0x735/0xc60 [ 12.151197][ T290] ? netlink_unicast+0x750/0x750 [ 12.151201][ T290] ? __might_fault+0x97/0x140 [ 12.151206][ T290] ____sys_sendmsg+0x415/0x880 [ 12.151208][ T290] ? copy_msghdr_from_user+0x279/0x420 [ 12.151211][ T290] ? get_timestamp.constprop.0+0x390/0x390 [ 12.151212][ T290] ? move_addr_to_kernel+0x40/0x40 [ 12.151220][ T290] ___sys_sendmsg+0x14e/0x1d0 [ 12.151222][ T290] ? copy_msghdr_from_user+0x420/0x420 [ 12.151238][ T290] __sys_sendmsg+0x12c/0x1d0 [ 12.151241][ T290] ? __sys_sendmsg_sock+0x20/0x20 [ 12.151247][ T290] ? rcu_is_watching+0x16/0xd0 [ 12.151251][ T290] do_syscall_64+0xff/0x530 [ 12.151253][ T290] ? exc_page_fault+0xee/0x100 [ 12.151257][ T290] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 12.151259][ T290] RIP: 0033:0x7f720fcd954e [ 12.151262][ T290] 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.151264][ T290] RSP: 002b:00007ffdfac3bfe0 EFLAGS: 00000202 ORIG_RAX: 000000000000002e [ 12.151267][ T290] RAX: ffffffffffffffda RBX: 0000000000000004 RCX: 00007f720fcd954e [ 12.151269][ T290] RDX: 0000000000000000 RSI: 00007ffdfac3c090 RDI: 0000000000000005 [ 12.151270][ T290] RBP: 00007ffdfac3bff0 R08: 0000000000000000 R09: 0000000000000000 [ 12.151271][ T290] R10: 0000000000000000 R11: 0000000000000202 R12: 000000006a910a04 [ 12.151272][ T290] R13: 00000000004a1620 R14: 0000000000000000 R15: 00007ffdfac3c750 [ 12.151278][ T290] [ 12.200082][ T290] br1: port 1(vx10) entered disabled state [ 12.200484][ T290] vx10: entered allmulticast mode [ 12.202249][ T290] vx10: entered promiscuous mode [ 12.202832][ T290] br1: port 1(vx10) entered blocking state [ 12.203328][ T290] br1: port 1(vx10) entered forwarding state [ 12.212823][ T290] ip (290) used greatest stack depth: 23336 bytes left [ 12.330963][ T295] br1: port 2(vx20) entered blocking state [ 12.331315][ T295] br1: port 2(vx20) entered disabled state [ 12.332205][ T295] vx20: entered allmulticast mode [ 12.334011][ T295] vx20: entered promiscuous mode [ 12.334735][ T295] br1: port 2(vx20) entered blocking state [ 12.335040][ T295] br1: port 2(vx20) entered forwarding state [ 12.402546][ T297] br1: port 3(veth1) entered blocking state [ 12.402886][ T297] br1: port 3(veth1) entered disabled state [ 12.403202][ T297] veth1: entered allmulticast mode [ 12.404810][ T297] veth1: entered promiscuous mode [ 12.440007][ T46] br1: port 3(veth1) entered blocking state [ 12.440585][ T46] br1: port 3(veth1) entered forwarding state [ 12.560861][ T302] br1: port 4(veth2) entered blocking state [ 12.561192][ T302] br1: port 4(veth2) entered disabled state [ 12.561836][ T302] veth2: entered allmulticast mode [ 12.563378][ T302] veth2: entered promiscuous mode [ 12.590427][ T46] br1: port 4(veth2) entered blocking state [ 12.590771][ T46] br1: port 4(veth2) entered forwarding state [ 13.900652][ T351] br2: port 1(w1) entered blocking state [ 13.900669][ T351] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 13.900671][ T351] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 351, name: ip [ 13.900673][ T351] preempt_count: 1, expected: 0 [ 13.900674][ T351] RCU nest depth: 0, expected: 0 [ 13.900675][ T351] locks held by ip/351: 5, last CPU#0: [ 13.900677][ T351] #0: ffffffffa4ad2c40 (rtnl_mutex){+.+.}-{4:4}, at: rtnl_newlink+0x9a8/0x11c0 [ 13.900688][ T351] #1: ffffffffa4369cc0 (console_lock){+.+.}-{0:0}, at: vprintk_emit+0x320/0x3e0 [ 13.900694][ T351] #2: ffffffffa4369d38 (console_srcu){....}-{0:0}, at: console_flush_one_record+0x106/0x710 [ 13.900698][ T351] #3: ffffffffa4289660 (console_owner){....}-{0:0}, at: console_lock_spinning_enable+0x40/0x60 [ 13.900702][ T351] #4: ffffffffa4289560 (printk_legacy_map-wait-type-override){....}-{3:3}, at: console_emit_next_record+0x1df/0x4c0 [ 13.900706][ T351] irq event stamp: 20164 [ 13.900707][ T351] hardirqs last enabled at (20163): [] __down_trylock_console_sem+0x86/0xa0 [ 13.900709][ T351] hardirqs last disabled at (20164): [] console_emit_next_record+0x3d4/0x4c0 [ 13.900711][ T351] softirqs last enabled at (20104): [] __alloc_skb+0x4c2/0x5f0 [ 13.900714][ T351] softirqs last disabled at (20102): [] __alloc_skb+0x4c2/0x5f0 [ 13.900717][ T351] Preemption disabled at: [ 13.900717][ T351] [] vprintk_emit+0x31b/0x3e0 [ 13.900723][ T351] CPU: 0 UID: 0 PID: 351 Comm: ip Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 13.900727][ T351] Tainted: [W]=WARN [ 13.900727][ T351] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 13.900729][ T351] Call Trace: [ 13.900731][ T351] [ 13.900732][ T351] dump_stack_lvl+0x6f/0xa0 [ 13.900738][ T351] ? vprintk_emit+0x31b/0x3e0 [ 13.900740][ T351] __might_resched.cold+0x1fe/0x2c1 [ 13.900745][ T351] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 13.900749][ T351] ? __kmalloc_noprof+0xdb/0x760 [ 13.900754][ T351] __kmalloc_noprof+0x443/0x760 [ 13.900756][ T351] ? alloc_buf.isra.0+0x4b/0x260 [ 13.900762][ T351] ? do_raw_spin_unlock+0x59/0x250 [ 13.900764][ T351] alloc_buf.isra.0+0x4b/0x260 [ 13.900767][ T351] put_chars+0x1e1/0x2f0 [ 13.900769][ T351] ? prb_final_commit+0x50/0x50 [ 13.900771][ T351] ? __send_to_port+0x420/0x420 [ 13.900774][ T351] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 13.900779][ T351] ? rcu_read_lock_any_held+0x3c/0x90 [ 13.900781][ T351] ? validate_chain+0x38b/0xc20 [ 13.900785][ T351] hvc_console_print+0x292/0x780 [ 13.900788][ T351] ? mark_usage+0x61/0x170 [ 13.900790][ T351] ? __lock_acquire+0x518/0xc20 [ 13.900791][ T351] ? __lock_acquire+0x518/0xc20 [ 13.900795][ T351] ? hvc_write+0x3a0/0x3a0 [ 13.900797][ T351] ? console_emit_next_record+0x1df/0x4c0 [ 13.900800][ T351] ? rcu_is_watching+0x16/0xd0 [ 13.900803][ T351] ? lock_acquire+0x13c/0x160 [ 13.900807][ T351] console_emit_next_record+0x22f/0x4c0 [ 13.900810][ T351] ? devkmsg_read+0x4b0/0x4b0 [ 13.900812][ T351] ? console_flush_one_record+0x106/0x710 [ 13.900815][ T351] ? rcu_is_watching+0x16/0xd0 [ 13.900818][ T351] ? lock_acquire+0x13c/0x160 [ 13.900821][ T351] console_flush_one_record+0x46f/0x710 [ 13.900826][ T351] ? console_emit_next_record+0x4c0/0x4c0 [ 13.900827][ T351] ? __lock_acquire+0x518/0xc20 [ 13.900832][ T351] console_unlock+0xee/0x1f0 [ 13.900835][ T351] ? console_flush_one_record+0x710/0x710 [ 13.900837][ T351] ? rcu_is_watching+0x16/0xd0 [ 13.900839][ T351] ? lock_acquire+0x60/0x160 [ 13.900843][ T351] ? __down_trylock_console_sem+0x5e/0xa0 [ 13.900845][ T351] ? vprintk_emit+0x320/0x3e0 [ 13.900848][ T351] vprintk_emit+0x37c/0x3e0 [ 13.900852][ T351] ? wake_up_klogd_work_func+0x90/0x90 [ 13.900855][ T351] ? __lock_release.isra.0+0x69/0x1a0 [ 13.900857][ T351] ? mark_held_locks+0x40/0x70 [ 13.900861][ T351] _printk+0xc7/0x100 [ 13.900865][ T351] ? snapshot_read.cold+0x21/0x21 [ 13.900868][ T351] ? br_multicast_flood+0xab0/0xab0 [bridge] [ 13.900881][ T351] ? do_setlink.isra.0+0xa31/0x2750 [ 13.900883][ T351] ? rtnl_newlink+0x9f1/0x11c0 [ 13.900884][ T351] ? rtnetlink_rcv_msg+0x6fd/0xbd0 [ 13.900888][ T351] br_set_state+0x22f/0x430 [bridge] [ 13.900898][ T351] br_init_port+0xc4/0x200 [bridge] [ 13.900906][ T351] new_nbp+0x39c/0x580 [bridge] [ 13.900915][ T351] br_add_if+0x212/0x1320 [bridge] [ 13.900922][ T351] ? is_bpf_text_address+0x72/0x110 [ 13.900926][ T351] ? kernel_text_address+0x149/0x170 [ 13.900929][ T351] ? __kernel_text_address+0x12/0x30 [ 13.900933][ T351] do_set_master+0x357/0x580 [ 13.900937][ T351] do_setlink.isra.0+0xa31/0x2750 [ 13.900940][ T351] ? stack_trace_save+0x93/0xc0 [ 13.900944][ T351] ? rtnl_link_get_size+0x350/0x350 [ 13.900945][ T351] ? rcu_read_lock_any_held+0x66/0x90 [ 13.900947][ T351] ? stack_depot_save_flags+0x38e/0x790 [ 13.900950][ T351] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 13.900953][ T351] ? rcu_read_lock_any_held+0x3c/0x90 [ 13.900955][ T351] ? validate_chain+0x38b/0xc20 [ 13.900957][ T351] ? kasan_save_stack+0x3d/0x50 [ 13.900960][ T351] ? kasan_save_stack+0x2f/0x50 [ 13.900962][ T351] ? kasan_save_track+0x14/0x30 [ 13.900964][ T351] ? __lock_acquire+0x518/0xc20 [ 13.900966][ T351] ? netlink_seq_next+0x4e/0x60 [ 13.900969][ T351] ? ___sys_sendmsg+0xb0/0x1d0 [ 13.900974][ T351] ? lock_acquire.part.0+0xd4/0x280 [ 13.900975][ T351] ? rtnl_newlink+0x9a8/0x11c0 [ 13.900978][ T351] ? rcu_is_watching+0x16/0xd0 [ 13.900980][ T351] ? lock_acquire+0x13c/0x160 [ 13.900982][ T351] ? rcu_is_watching+0x16/0xd0 [ 13.900984][ T351] ? rcu_is_watching+0x16/0xd0 [ 13.900986][ T351] ? trace_contention_end+0xb3/0x180 [ 13.900990][ T351] ? __mutex_lock+0x1db/0x1ea0 [ 13.900993][ T351] ? __mutex_lock+0x9a3/0x1ea0 [ 13.900995][ T351] ? rtnl_newlink+0x9a8/0x11c0 [ 13.900998][ T351] ? ww_mutex_lock+0x160/0x160 [ 13.901000][ T351] ? nla_get_range_signed+0x3d0/0x3d0 [ 13.901005][ T351] ? __rtnl_newlink+0x3fa/0xa50 [ 13.901010][ T351] rtnl_newlink+0x9f1/0x11c0 [ 13.901015][ T351] ? rtnl_bridge_getlink+0x850/0x850 [ 13.901017][ T351] ? __lock_acquire+0x518/0xc20 [ 13.901021][ T351] ? lock_acquire.part.0+0xd4/0x280 [ 13.901023][ T351] ? find_held_lock+0x2b/0x80 [ 13.901025][ T351] ? rtnl_bridge_getlink+0x850/0x850 [ 13.901027][ T351] ? __lock_release.isra.0+0x69/0x1a0 [ 13.901031][ T351] ? rtnl_bridge_getlink+0x850/0x850 [ 13.901033][ T351] rtnetlink_rcv_msg+0x6fd/0xbd0 [ 13.901036][ T351] ? rtnl_link_fill+0x920/0x920 [ 13.901037][ T351] ? __lock_acquire+0x518/0xc20 [ 13.901041][ T351] ? lock_acquire.part.0+0xd4/0x280 [ 13.901043][ T351] ? find_held_lock+0x2b/0x80 [ 13.901047][ T351] netlink_rcv_skb+0x14e/0x3a0 [ 13.901048][ T351] ? rtnl_link_fill+0x920/0x920 [ 13.901051][ T351] ? netlink_ack+0xcf0/0xcf0 [ 13.901057][ T351] ? netlink_deliver_tap+0xc5/0x330 [ 13.901059][ T351] ? netlink_deliver_tap+0x13c/0x330 [ 13.901063][ T351] netlink_unicast+0x486/0x750 [ 13.901066][ T351] ? netlink_attachskb+0x810/0x810 [ 13.901069][ T351] ? __lock_acquire+0x518/0xc20 [ 13.901073][ T351] netlink_sendmsg+0x735/0xc60 [ 13.901077][ T351] ? netlink_unicast+0x750/0x750 [ 13.901080][ T351] ? __might_fault+0x97/0x140 [ 13.901085][ T351] ____sys_sendmsg+0x415/0x880 [ 13.901088][ T351] ? copy_msghdr_from_user+0x279/0x420 [ 13.901090][ T351] ? get_timestamp.constprop.0+0x390/0x390 [ 13.901092][ T351] ? move_addr_to_kernel+0x40/0x40 [ 13.901099][ T351] ___sys_sendmsg+0x14e/0x1d0 [ 13.901102][ T351] ? copy_msghdr_from_user+0x420/0x420 [ 13.901117][ T351] __sys_sendmsg+0x12c/0x1d0 [ 13.901120][ T351] ? __sys_sendmsg_sock+0x20/0x20 [ 13.901126][ T351] ? rcu_is_watching+0x16/0xd0 [ 13.901129][ T351] do_syscall_64+0xff/0x530 [ 13.901132][ T351] ? exc_page_fault+0xee/0x100 [ 13.901135][ T351] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 13.901137][ T351] RIP: 0033:0x7f91943fd54e [ 13.901140][ T351] 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.901143][ T351] RSP: 002b:00007ffdfd3c7b30 EFLAGS: 00000202 ORIG_RAX: 000000000000002e [ 13.901146][ T351] RAX: ffffffffffffffda RBX: 0000000000000004 RCX: 00007f91943fd54e [ 13.901147][ T351] RDX: 0000000000000000 RSI: 00007ffdfd3c7be0 RDI: 0000000000000005 [ 13.901148][ T351] RBP: 00007ffdfd3c7b40 R08: 0000000000000000 R09: 0000000000000000 [ 13.901149][ T351] R10: 0000000000000000 R11: 0000000000000202 R12: 000000006a910a06 [ 13.901149][ T351] R13: 00000000004a1620 R14: 0000000000000000 R15: 00007ffdfd3c82a0 [ 13.901156][ T351] [ 13.940370][ T351] br2: port 1(w1) entered disabled state [ 13.940738][ T351] w1: entered allmulticast mode [ 13.942853][ T351] w1: entered promiscuous mode [ 13.982291][ T352] br2: port 1(w1) entered blocking state [ 13.982571][ T352] br2: port 1(w1) entered forwarding state [ 14.194648][ T359] br2: port 2(vx10) entered blocking state [ 14.194971][ T359] br2: port 2(vx10) entered disabled state [ 14.195275][ T359] vx10: entered allmulticast mode [ 14.197016][ T359] vx10: entered promiscuous mode [ 14.197523][ T359] br2: port 2(vx10) entered blocking state [ 14.197822][ T359] br2: port 2(vx10) entered forwarding state [ 14.416065][ T366] br2: port 3(vx20) entered blocking state [ 14.416740][ T366] br2: port 3(vx20) entered disabled state [ 14.417057][ T366] vx20: entered allmulticast mode [ 14.418562][ C0] clocksource: Watchdog remote CPU 3 read timed out [ 14.418705][ C0] [ 14.418706][ C0] ======================================================== [ 14.418707][ C0] WARNING: possible irq lock inversion dependency detected [ 14.418710][ C0] 7.2.0-virtme #1 Tainted: G W [ 14.418712][ C0] -------------------------------------------------------- [ 14.418713][ C0] swapper/0/0 just changed the state of lock: [ 14.418714][ C0] ffffffffa4289660 (console_owner){..-.}-{0:0}, at: console_lock_spinning_enable+0x40/0x60 [ 14.418728][ C0] but this lock took another, SOFTIRQ-unsafe lock in the past: [ 14.418730][ C0] (fs_reclaim){+.+.}-{0:0} [ 14.418732][ C0] [ 14.418732][ C0] [ 14.418732][ C0] and interrupts could create inverse lock ordering between them. [ 14.418732][ C0] [ 14.418733][ C0] [ 14.418733][ C0] other info that might help us debug this: [ 14.418734][ C0] Possible interrupt unsafe locking scenario: [ 14.418734][ C0] [ 14.418735][ C0] CPU0 CPU1 [ 14.418736][ C0] ---- ---- [ 14.418736][ C0] lock(fs_reclaim); [ 14.418738][ C0] local_irq_disable(); [ 14.418739][ C0] lock(console_owner); [ 14.418740][ C0] lock(fs_reclaim); [ 14.418742][ C0] [ 14.418742][ C0] lock(console_owner); [ 14.418744][ C0] [ 14.418744][ C0] *** DEADLOCK *** [ 14.418744][ C0] [ 14.418744][ C0] locks held by swapper/0/0: 4, last CPU#0: [ 14.418746][ C0] #0: ffa0000000007c90 ((&watchdog_timer)){+.-.}-{0:0}, at: call_timer_fn+0x110/0x4d0 [ 14.418753][ C0] #1: ffffffffa43ce8b8 (watchdog_lock){+.-.}-{3:3}, at: clocksource_watchdog+0x15/0x30 [ 14.418759][ C0] #2: ffffffffa4369cc0 (console_lock){+.+.}-{0:0}, at: vprintk_emit+0x320/0x3e0 [ 14.418764][ C0] #3: ffffffffa4369d38 (console_srcu){....}-{0:0}, at: console_flush_one_record+0x106/0x710 [ 14.418769][ C0] [ 14.418769][ C0] the shortest dependencies between 2nd lock and 1st lock: [ 14.418774][ C0] -> (fs_reclaim){+.+.}-{0:0} { [ 14.418778][ C0] HARDIRQ-ON-W at: [ 14.418780][ C0] __lock_acquire+0x388/0xc20 [ 14.418783][ C0] lock_acquire.part.0+0xd4/0x280 [ 14.418785][ C0] fs_reclaim_acquire+0xd5/0x120 [ 14.418789][ C0] __kmalloc_cache_noprof+0x6e/0x620 [ 14.418792][ C0] kthread_create_worker_on_node+0xea/0x210 [ 14.418795][ C0] workqueue_init+0x2a/0x680 [ 14.418799][ C0] kernel_init_freeable+0x2fe/0x630 [ 14.418801][ C0] kernel_init+0x21/0x150 [ 14.418806][ C0] ret_from_fork+0x474/0x6b0 [ 14.418809][ C0] ret_from_fork_asm+0x11/0x20 [ 14.418812][ C0] SOFTIRQ-ON-W at: [ 14.418814][ C0] __lock_acquire+0x388/0xc20 [ 14.418816][ C0] lock_acquire.part.0+0xd4/0x280 [ 14.418817][ C0] fs_reclaim_acquire+0xd5/0x120 [ 14.418819][ C0] __kmalloc_cache_noprof+0x6e/0x620 [ 14.418821][ C0] kthread_create_worker_on_node+0xea/0x210 [ 14.418823][ C0] workqueue_init+0x2a/0x680 [ 14.418825][ C0] kernel_init_freeable+0x2fe/0x630 [ 14.418826][ C0] kernel_init+0x21/0x150 [ 14.418827][ T366] vx20: entered promiscuous mode [ 14.418828][ C0] ret_from_fork+0x474/0x6b0 [ 14.418830][ C0] ret_from_fork_asm+0x11/0x20 [ 14.418832][ C0] INITIAL USE at: [ 14.418833][ C0] __lock_acquire+0x388/0xc20 [ 14.418835][ C0] lock_acquire.part.0+0xd4/0x280 [ 14.418836][ C0] fs_reclaim_acquire+0xd5/0x120 [ 14.418838][ C0] __kmalloc_cache_noprof+0x6e/0x620 [ 14.418840][ C0] kthread_create_worker_on_node+0xea/0x210 [ 14.418842][ C0] workqueue_init+0x2a/0x680 [ 14.418843][ C0] kernel_init_freeable+0x2fe/0x630 [ 14.418845][ C0] kernel_init+0x21/0x150 [ 14.418847][ C0] ret_from_fork+0x474/0x6b0 [ 14.418849][ C0] ret_from_fork_asm+0x11/0x20 [ 14.418850][ C0] } [ 14.418851][ C0] ... key at: [] __fs_reclaim_map+0x0/0xbe0 [ 14.418856][ C0] ... acquired at: [ 14.418857][ C0] __lock_acquire+0x518/0xc20 [ 14.418859][ C0] lock_acquire.part.0+0xd4/0x280 [ 14.418861][ C0] fs_reclaim_acquire+0xd5/0x120 [ 14.418862][ C0] __kmalloc_noprof+0xd3/0x760 [ 14.418864][ C0] alloc_buf.isra.0+0x4b/0x260 [ 14.418867][ C0] put_chars+0x1e1/0x2f0 [ 14.418869][ C0] hvc_console_print+0x292/0x780 [ 14.418871][ C0] console_emit_next_record+0x22f/0x4c0 [ 14.418874][ C0] console_flush_one_record+0x46f/0x710 [ 14.418876][ C0] console_unlock+0xee/0x1f0 [ 14.418878][ C0] vprintk_emit+0x37c/0x3e0 [ 14.418880][ C0] _printk+0xc7/0x100 [ 14.418884][ C0] loop_init+0x12a/0x130 [ 14.418887][ C0] do_one_initcall+0x124/0x4f0 [ 14.418889][ C0] kernel_init_freeable+0x596/0x630 [ 14.418891][ C0] kernel_init+0x21/0x150 [ 14.418893][ C0] ret_from_fork+0x474/0x6b0 [ 14.418894][ C0] ret_from_fork_asm+0x11/0x20 [ 14.418896][ C0] [ 14.418897][ C0] -> (console_owner){..-.}-{0:0} { [ 14.418899][ C0] IN-SOFTIRQ-W at: [ 14.418900][ C0] __lock_acquire+0x388/0xc20 [ 14.418902][ C0] lock_acquire.part.0+0xd4/0x280 [ 14.418904][ C0] console_lock_spinning_enable+0x5c/0x60 [ 14.418906][ C0] console_emit_next_record+0x1d1/0x4c0 [ 14.418908][ C0] console_flush_one_record+0x46f/0x710 [ 14.418911][ C0] console_unlock+0xee/0x1f0 [ 14.418913][ C0] vprintk_emit+0x37c/0x3e0 [ 14.418915][ C0] _printk+0xc7/0x100 [ 14.418916][ C0] clocksource_watchdog.part.0.cold+0x105/0x1dd [ 14.418919][ C0] call_timer_fn+0x160/0x4d0 [ 14.418921][ C0] __run_timers+0x68f/0xaa0 [ 14.418923][ C0] run_timer_softirq+0xf0/0x160 [ 14.418925][ C0] handle_softirqs+0x1d3/0x900 [ 14.418928][ C0] __irq_exit_rcu+0x145/0x1c0 [ 14.418930][ C0] irq_exit_rcu+0xe/0x30 [ 14.418932][ C0] sysvec_apic_timer_interrupt+0x9d/0xe0 [ 14.418934][ C0] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 14.418937][ C0] pv_native_safe_halt+0xf/0x10 [ 14.418939][ C0] default_idle+0x9/0x10 [ 14.418941][ C0] default_idle_call+0x6e/0xb0 [ 14.418943][ C0] cpuidle_idle_call.constprop.0+0x237/0x410 [ 14.418946][ C0] do_idle+0xd8/0x190 [ 14.418948][ C0] cpu_startup_entry+0x53/0x70 [ 14.418949][ C0] rest_init+0x279/0x280 [ 14.418951][ C0] start_kernel+0x3af/0x3b0 [ 14.418953][ C0] x86_64_start_reservations+0x24/0x30 [ 14.418956][ C0] x86_64_start_kernel+0x12b/0x130 [ 14.418958][ C0] common_startup_64+0x13e/0x148 [ 14.418961][ C0] INITIAL USE at: [ 14.418962][ C0] } [ 14.418963][ C0] ... key at: [] console_owner_dep_map+0x0/0x60 [ 14.418966][ C0] ... acquired at: [ 14.418967][ C0] mark_lock+0x1d7/0xa00 [ 14.418969][ C0] mark_usage+0x42/0x170 [ 14.418970][ C0] __lock_acquire+0x388/0xc20 [ 14.418972][ C0] lock_acquire.part.0+0xd4/0x280 [ 14.418974][ C0] console_lock_spinning_enable+0x5c/0x60 [ 14.418976][ C0] console_emit_next_record+0x1d1/0x4c0 [ 14.418978][ C0] console_flush_one_record+0x46f/0x710 [ 14.418981][ C0] console_unlock+0xee/0x1f0 [ 14.418983][ C0] vprintk_emit+0x37c/0x3e0 [ 14.418985][ C0] _printk+0xc7/0x100 [ 14.418986][ C0] clocksource_watchdog.part.0.cold+0x105/0x1dd [ 14.418988][ C0] call_timer_fn+0x160/0x4d0 [ 14.418990][ C0] __run_timers+0x68f/0xaa0 [ 14.418992][ C0] run_timer_softirq+0xf0/0x160 [ 14.418994][ C0] handle_softirqs+0x1d3/0x900 [ 14.418996][ C0] __irq_exit_rcu+0x145/0x1c0 [ 14.418997][ C0] irq_exit_rcu+0xe/0x30 [ 14.418999][ C0] sysvec_apic_timer_interrupt+0x9d/0xe0 [ 14.419001][ C0] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 14.419003][ C0] pv_native_safe_halt+0xf/0x10 [ 14.419005][ C0] default_idle+0x9/0x10 [ 14.419007][ C0] default_idle_call+0x6e/0xb0 [ 14.419009][ C0] cpuidle_idle_call.constprop.0+0x237/0x410 [ 14.419010][ C0] do_idle+0xd8/0x190 [ 14.419012][ C0] cpu_startup_entry+0x53/0x70 [ 14.419014][ C0] rest_init+0x279/0x280 [ 14.419016][ C0] start_kernel+0x3af/0x3b0 [ 14.419017][ C0] x86_64_start_reservations+0x24/0x30 [ 14.419019][ C0] x86_64_start_kernel+0x12b/0x130 [ 14.419021][ C0] common_startup_64+0x13e/0x148 [ 14.419023][ C0] [ 14.419023][ C0] [ 14.419023][ C0] stack backtrace: [ 14.419027][ C0] CPU: 0 UID: 0 PID: 0 Comm: swapper/0 Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 14.419031][ C0] Tainted: [W]=WARN [ 14.419032][ C0] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 14.419034][ C0] Call Trace: [ 14.419036][ C0] [ 14.419037][ C0] dump_stack_lvl+0x6f/0xa0 [ 14.419042][ C0] print_irq_inversion_bug.part.0.cold+0xe6/0x143 [ 14.419045][ C0] mark_lock_irq+0x989/0x9c0 [ 14.419047][ C0] ? add_lock_to_list+0x2c/0x1a0 [ 14.419052][ C0] mark_lock+0x1d7/0xa00 [ 14.419054][ C0] mark_usage+0x42/0x170 [ 14.419057][ C0] __lock_acquire+0x388/0xc20 [ 14.419060][ C0] lock_acquire.part.0+0xd4/0x280 [ 14.419062][ C0] ? console_lock_spinning_enable+0x40/0x60 [ 14.419065][ C0] ? rcu_is_watching+0x16/0xd0 [ 14.419069][ C0] ? lock_acquire+0x13c/0x160 [ 14.419072][ C0] console_lock_spinning_enable+0x5c/0x60 [ 14.419074][ C0] ? console_lock_spinning_enable+0x40/0x60 [ 14.419076][ C0] console_emit_next_record+0x1d1/0x4c0 [ 14.419079][ C0] ? devkmsg_read+0x4b0/0x4b0 [ 14.419082][ C0] ? console_flush_one_record+0x106/0x710 [ 14.419084][ C0] ? rcu_is_watching+0x16/0xd0 [ 14.419087][ C0] ? lock_acquire+0x13c/0x160 [ 14.419090][ C0] console_flush_one_record+0x46f/0x710 [ 14.419093][ C0] ? console_emit_next_record+0x4c0/0x4c0 [ 14.419095][ C0] ? __lock_acquire+0x518/0xc20 [ 14.419099][ C0] console_unlock+0xee/0x1f0 [ 14.419101][ C0] ? console_flush_one_record+0x710/0x710 [ 14.419104][ C0] ? rcu_is_watching+0x16/0xd0 [ 14.419106][ C0] ? lock_acquire+0x60/0x160 [ 14.419109][ C0] ? __down_trylock_console_sem+0x5e/0xa0 [ 14.419111][ C0] ? vprintk_emit+0x320/0x3e0 [ 14.419114][ C0] vprintk_emit+0x37c/0x3e0 [ 14.419117][ C0] ? wake_up_klogd_work_func+0x90/0x90 [ 14.419121][ C0] ? clocksource_watchdog.part.0+0x450/0x540 [ 14.419123][ C0] _printk+0xc7/0x100 [ 14.419126][ C0] ? snapshot_read.cold+0x21/0x21 [ 14.419128][ C0] ? clocksource_watchdog.part.0+0x450/0x540 [ 14.419131][ C0] ? __lock_release.isra.0+0x69/0x1a0 [ 14.419134][ C0] clocksource_watchdog.part.0.cold+0x105/0x1dd [ 14.419136][ C0] ? clocksource_watchdog.part.0+0x540/0x540 [ 14.419139][ C0] ? clocksource_watchdog.part.0+0x540/0x540 [ 14.419141][ C0] call_timer_fn+0x160/0x4d0 [ 14.419144][ C0] ? detach_if_pending+0x1d0/0x1d0 [ 14.419146][ C0] ? debug_object_active_state+0x430/0x430 [ 14.419150][ C0] ? find_held_lock+0x2b/0x80 [ 14.419153][ C0] ? __lock_release.isra.0+0x69/0x1a0 [ 14.419155][ C0] ? rcu_is_watching+0x16/0xd0 [ 14.419158][ C0] __run_timers+0x68f/0xaa0 [ 14.419161][ C0] ? clocksource_watchdog.part.0+0x540/0x540 [ 14.419164][ C0] ? __bpf_trace_itimer_expire+0x10/0x10 [ 14.419166][ C0] ? __lock_acquire+0x518/0xc20 [ 14.419171][ C0] ? __rwlock_init+0x150/0x150 [ 14.419174][ C0] run_timer_softirq+0xf0/0x160 [ 14.419177][ C0] ? __run_timers+0xaa0/0xaa0 [ 14.419179][ C0] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 14.419182][ C0] ? rcu_is_watching+0x16/0xd0 [ 14.419185][ C0] handle_softirqs+0x1d3/0x900 [ 14.419187][ C0] ? __lock_release.isra.0+0x69/0x1a0 [ 14.419190][ C0] ? _local_bh_enable+0xc0/0xc0 [ 14.419193][ C0] __irq_exit_rcu+0x145/0x1c0 [ 14.419195][ C0] irq_exit_rcu+0xe/0x30 [ 14.419197][ C0] sysvec_apic_timer_interrupt+0x9d/0xe0 [ 14.419199][ C0] [ 14.419200][ C0] [ 14.419201][ C0] ? lockdep_hardirqs_on_prepare.part.0+0x9a/0x160 [ 14.419203][ C0] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 14.419206][ C0] RIP: 0010:pv_native_safe_halt+0xf/0x10 [ 14.419209][ C0] Code: 48 8b 3d 94 e2 f5 01 e8 1f 00 00 00 48 2b 05 58 a3 95 00 c3 0f 1f 80 00 00 00 00 f3 0f 1e fa eb 07 0f 00 2d 13 96 11 00 fb f4 0f 1f 40 d6 48 83 ec 20 8b 17 49 89 f8 83 e2 fe 41 89 d2 0f 01 [ 14.419212][ C0] RSP: 0018:ffffffffa4007cf8 EFLAGS: 00000296 [ 14.419215][ C0] RAX: 00000000000b78cb RBX: ffffffffa401c600 RCX: ffffffffa10f0307 [ 14.419216][ C0] RDX: ffffffffa401c600 RSI: ffffffffa3e38b01 RDI: ffffffffa388d8e0 [ 14.419218][ C0] RBP: 0000000000000000 R08: 0000000000000000 R09: 0000000000000000 [ 14.419219][ C0] R10: 0000000000000000 R11: 0000000000000001 R12: 1ffffffff4800fa2 [ 14.419220][ C0] R13: 0000000000000000 R14: dffffc0000000000 R15: 0000000000014770 [ 14.419223][ C0] ? cpuidle_idle_call.constprop.0+0x237/0x410 [ 14.419226][ C0] ? lockdep_hardirqs_on+0x91/0x130 [ 14.419228][ C0] default_idle+0x9/0x10 [ 14.419230][ C0] default_idle_call+0x6e/0xb0 [ 14.419233][ C0] cpuidle_idle_call.constprop.0+0x237/0x410 [ 14.419235][ C0] ? arch_cpu_idle_exit+0x40/0x40 [ 14.419237][ C0] ? mark_tsc_async_resets+0x30/0x30 [ 14.419240][ C0] ? rcu_is_watching+0x16/0xd0 [ 14.419243][ C0] do_idle+0xd8/0x190 [ 14.419245][ C0] cpu_startup_entry+0x53/0x70 [ 14.419247][ C0] rest_init+0x279/0x280 [ 14.419250][ C0] ? __cpuidle_text_end+0x3b/0x3b [ 14.419254][ C0] ? rest_init+0x280/0x280 [ 14.419256][ C0] ? acpi_hw_set_mode+0x4a0/0x4a0 [ 14.419261][ C0] ? cpus_read_unlock+0x4f/0xc0 [ 14.419264][ C0] ? acpi_enable+0x1e4/0x330 [ 14.419267][ C0] start_kernel+0x3af/0x3b0 [ 14.419270][ C0] x86_64_start_reservations+0x24/0x30 [ 14.419272][ C0] x86_64_start_kernel+0x12b/0x130 [ 14.419275][ C0] common_startup_64+0x13e/0x148 [ 14.419279][ C0] [ 14.462789][ T366] br2: port 3(vx20) entered blocking state [ 14.463114][ T366] br2: port 3(vx20) entered forwarding state [ 15.202237][ T407] br2: port 1(w1) entered blocking state [ 15.202254][ T407] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 15.202257][ T407] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 407, name: ip [ 15.202259][ T407] preempt_count: 1, expected: 0 [ 15.202260][ T407] RCU nest depth: 0, expected: 0 [ 15.202262][ T407] INFO: lockdep is turned off. [ 15.202263][ T407] irq event stamp: 0 [ 15.202264][ T407] hardirqs last enabled at (0): [<0000000000000000>] 0x0 [ 15.202270][ T407] hardirqs last disabled at (0): [] copy_process+0x1ccd/0x6240 [ 15.202277][ T407] softirqs last enabled at (0): [] copy_process+0x1d21/0x6240 [ 15.202280][ T407] softirqs last disabled at (0): [<0000000000000000>] 0x0 [ 15.202282][ T407] Preemption disabled at: [ 15.202283][ T407] [] vprintk_emit+0x31b/0x3e0 [ 15.202292][ T407] CPU: 3 UID: 0 PID: 407 Comm: ip Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 15.202296][ T407] Tainted: [W]=WARN [ 15.202298][ T407] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 15.202300][ T407] Call Trace: [ 15.202302][ T407] [ 15.202303][ T407] dump_stack_lvl+0x6f/0xa0 [ 15.202310][ T407] ? vprintk_emit+0x31b/0x3e0 [ 15.202312][ T407] __might_resched.cold+0x1fe/0x2c1 [ 15.202316][ T407] ? __module_address+0x36/0x330 [ 15.202320][ T407] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 15.202324][ T407] ? prb_next_reserve_seq+0x2d0/0x2d0 [ 15.202326][ T407] ? rcu_is_watching+0x16/0xd0 [ 15.202331][ T407] __kmalloc_noprof+0x443/0x760 [ 15.202335][ T407] ? __rwlock_init+0x150/0x150 [ 15.202338][ T407] ? alloc_buf.isra.0+0x4b/0x260 [ 15.202343][ T407] ? do_raw_spin_unlock+0x59/0x250 [ 15.202345][ T407] alloc_buf.isra.0+0x4b/0x260 [ 15.202348][ T407] put_chars+0x1e1/0x2f0 [ 15.202351][ T407] ? prb_final_commit+0x50/0x50 [ 15.202353][ T407] ? __send_to_port+0x420/0x420 [ 15.202356][ T407] ? printk_get_next_message+0x240/0x650 [ 15.202360][ T407] hvc_console_print+0x292/0x780 [ 15.202364][ T407] ? hvc_write+0x3a0/0x3a0 [ 15.202366][ T407] ? do_raw_spin_lock+0x131/0x280 [ 15.202368][ T407] ? vsnprintf+0x668/0x1700 [ 15.202372][ T407] ? __rwlock_init+0x150/0x150 [ 15.202375][ T407] ? rcu_is_watching+0x16/0xd0 [ 15.202377][ T407] ? lock_acquire+0x13c/0x160 [ 15.202380][ T407] console_emit_next_record+0x22f/0x4c0 [ 15.202384][ T407] ? devkmsg_read+0x4b0/0x4b0 [ 15.202387][ T407] ? rcu_is_watching+0x16/0xd0 [ 15.202389][ T407] ? rcu_is_watching+0x16/0xd0 [ 15.202392][ T407] ? rcu_is_watching+0x16/0xd0 [ 15.202394][ T407] ? lock_acquire+0x13c/0x160 [ 15.202397][ T407] ? console_flush_one_record+0x111/0x710 [ 15.202400][ T407] console_flush_one_record+0x46f/0x710 [ 15.202406][ T407] ? console_emit_next_record+0x4c0/0x4c0 [ 15.202410][ T407] console_unlock+0xee/0x1f0 [ 15.202413][ T407] ? lock_acquire+0x13c/0x160 [ 15.202415][ T407] ? console_flush_one_record+0x710/0x710 [ 15.202417][ T407] ? rcu_is_watching+0x16/0xd0 [ 15.202420][ T407] ? lock_release+0x184/0x1f0 [ 15.202422][ T407] ? lock_acquire+0x60/0x160 [ 15.202424][ T407] ? __rcu_read_lock+0x30/0x70 [ 15.202427][ T407] ? __down_trylock_console_sem+0x5e/0xa0 [ 15.202430][ T407] ? vprintk_emit+0x320/0x3e0 [ 15.202433][ T407] vprintk_emit+0x37c/0x3e0 [ 15.202437][ T407] ? wake_up_klogd_work_func+0x90/0x90 [ 15.202439][ T407] ? __rwlock_init+0x150/0x150 [ 15.202441][ T407] ? filter_irq_stacks+0xd0/0xd0 [ 15.202444][ T407] ? lock_acquire+0x13c/0x160 [ 15.202446][ T407] ? rcu_is_watching+0x16/0xd0 [ 15.202449][ T407] _printk+0xc7/0x100 [ 15.202454][ T407] ? snapshot_read.cold+0x21/0x21 [ 15.202457][ T407] ? br_multicast_flood+0xab0/0xab0 [bridge] [ 15.202473][ T407] ? do_setlink.isra.0+0xa31/0x2750 [ 15.202476][ T407] ? rtnl_newlink+0x9f1/0x11c0 [ 15.202478][ T407] ? rtnetlink_rcv_msg+0x6fd/0xbd0 [ 15.202482][ T407] br_set_state+0x22f/0x430 [bridge] [ 15.202495][ T407] br_init_port+0xc4/0x200 [bridge] [ 15.202507][ T407] new_nbp+0x39c/0x580 [bridge] [ 15.202520][ T407] br_add_if+0x212/0x1320 [bridge] [ 15.202531][ T407] ? bpf_address_lookup+0x250/0x290 [ 15.202535][ T407] ? is_bpf_text_address+0x72/0x110 [ 15.202538][ T407] ? kernel_text_address+0x149/0x170 [ 15.202541][ T407] ? __kernel_text_address+0x12/0x30 [ 15.202544][ T407] do_set_master+0x357/0x580 [ 15.202548][ T407] do_setlink.isra.0+0xa31/0x2750 [ 15.202551][ T407] ? stack_trace_save+0x93/0xc0 [ 15.202553][ T407] ? rtnl_link_get_size+0x350/0x350 [ 15.202555][ T407] ? rcu_is_watching+0x16/0xd0 [ 15.202557][ T407] ? stack_depot_save_flags+0x1bc/0x790 [ 15.202562][ T407] ? kasan_save_stack+0x3d/0x50 [ 15.202566][ T407] ? kasan_save_stack+0x2f/0x50 [ 15.202568][ T407] ? kasan_save_track+0x14/0x30 [ 15.202570][ T407] ? __kasan_kmalloc+0x7b/0x90 [ 15.202572][ T407] ? __kmalloc_cache_noprof+0x29a/0x620 [ 15.202575][ T407] ? rtnl_newlink+0x124/0x11c0 [ 15.202576][ T407] ? rtnetlink_rcv_msg+0x6fd/0xbd0 [ 15.202578][ T407] ? netlink_rcv_skb+0x14e/0x3a0 [ 15.202582][ T407] ? netlink_unicast+0x486/0x750 [ 15.202584][ T407] ? netlink_sendmsg+0x735/0xc60 [ 15.202585][ T407] ? ____sys_sendmsg+0x415/0x880 [ 15.202589][ T407] ? ___sys_sendmsg+0x14e/0x1d0 [ 15.202591][ T407] ? __sys_sendmsg+0x12c/0x1d0 [ 15.202593][ T407] ? do_syscall_64+0xff/0x530 [ 15.202596][ T407] ? entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 15.202600][ T407] ? rcu_is_watching+0x16/0xd0 [ 15.202602][ T407] ? lock_acquire+0x13c/0x160 [ 15.202604][ T407] ? rcu_is_watching+0x16/0xd0 [ 15.202607][ T407] ? rcu_is_watching+0x16/0xd0 [ 15.202609][ T407] ? trace_contention_end+0xb3/0x180 [ 15.202613][ T407] ? __mutex_lock+0x1db/0x1ea0 [ 15.202621][ T407] ? __mutex_lock+0x9a3/0x1ea0 [ 15.202623][ T407] ? rtnl_newlink+0x9a8/0x11c0 [ 15.202626][ T407] ? ww_mutex_lock+0x160/0x160 [ 15.202628][ T407] ? nla_get_range_signed+0x3d0/0x3d0 [ 15.202632][ T407] ? __rtnl_newlink+0x3fa/0xa50 [ 15.202635][ T407] rtnl_newlink+0x9f1/0x11c0 [ 15.202638][ T407] ? rcu_is_watching+0x16/0xd0 [ 15.202641][ T407] ? rtnl_bridge_getlink+0x850/0x850 [ 15.202643][ T407] ? lock_acquire+0x13c/0x160 [ 15.202645][ T407] ? rcu_is_watching+0x16/0xd0 [ 15.202648][ T407] ? is_bpf_text_address+0x3e/0x110 [ 15.202650][ T407] ? is_bpf_text_address+0x72/0x110 [ 15.202653][ T407] ? kernel_text_address+0x149/0x170 [ 15.202655][ T407] ? __kernel_text_address+0x12/0x30 [ 15.202657][ T407] ? write_profile+0xf0/0xf0 [ 15.202659][ T407] ? unwind_get_return_address+0x67/0xd0 [ 15.202662][ T407] ? rcu_is_watching+0x16/0xd0 [ 15.202664][ T407] ? rcu_is_watching+0x16/0xd0 [ 15.202667][ T407] ? cap_capable+0x1d7/0x3d0 [ 15.202671][ T407] ? lock_acquire+0x13c/0x160 [ 15.202673][ T407] ? rcu_is_watching+0x16/0xd0 [ 15.202675][ T407] ? rtnl_bridge_getlink+0x850/0x850 [ 15.202678][ T407] rtnetlink_rcv_msg+0x6fd/0xbd0 [ 15.202680][ T407] ? rtnl_link_fill+0x920/0x920 [ 15.202682][ T407] ? filter_irq_stacks+0xd0/0xd0 [ 15.202684][ T407] ? stack_depot_save_flags+0x1bc/0x790 [ 15.202688][ T407] netlink_rcv_skb+0x14e/0x3a0 [ 15.202690][ T407] ? rtnl_link_fill+0x920/0x920 [ 15.202692][ T407] ? lock_release+0x184/0x1f0 [ 15.202695][ T407] ? netlink_ack+0xcf0/0xcf0 [ 15.202697][ T407] ? __netlink_lookup+0xb9/0x6b0 [ 15.202700][ T407] ? rcu_is_watching+0x16/0xd0 [ 15.202703][ T407] ? lock_release+0x184/0x1f0 [ 15.202706][ T407] netlink_unicast+0x486/0x750 [ 15.202709][ T407] ? netlink_attachskb+0x810/0x810 [ 15.202711][ T407] ? rcu_is_watching+0x16/0xd0 [ 15.202714][ T407] ? rcu_is_watching+0x16/0xd0 [ 15.202716][ T407] ? lock_acquire+0x13c/0x160 [ 15.202719][ T407] netlink_sendmsg+0x735/0xc60 [ 15.202722][ T407] ? netlink_unicast+0x750/0x750 [ 15.202724][ T407] ? rcu_is_watching+0x16/0xd0 [ 15.202727][ T407] ? lock_release+0x184/0x1f0 [ 15.202730][ T407] ____sys_sendmsg+0x415/0x880 [ 15.202732][ T407] ? copy_msghdr_from_user+0x279/0x420 [ 15.202734][ T407] ? get_timestamp.constprop.0+0x390/0x390 [ 15.202736][ T407] ? move_addr_to_kernel+0x40/0x40 [ 15.202739][ T407] ? filter_irq_stacks+0xd0/0xd0 [ 15.202743][ T407] ___sys_sendmsg+0x14e/0x1d0 [ 15.202745][ T407] ? copy_msghdr_from_user+0x420/0x420 [ 15.202753][ T407] __sys_sendmsg+0x12c/0x1d0 [ 15.202756][ T407] ? __sys_sendmsg_sock+0x20/0x20 [ 15.202760][ T407] ? rcu_is_watching+0x16/0xd0 [ 15.202763][ T407] do_syscall_64+0xff/0x530 [ 15.202765][ T407] ? exc_page_fault+0xee/0x100 [ 15.202769][ T407] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 15.202771][ T407] RIP: 0033:0x7fe12eb3354e [ 15.202774][ T407] 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 [ 15.202777][ T407] RSP: 002b:00007ffd63f73010 EFLAGS: 00000202 ORIG_RAX: 000000000000002e [ 15.202781][ T407] RAX: ffffffffffffffda RBX: 0000000000000004 RCX: 00007fe12eb3354e [ 15.202783][ T407] RDX: 0000000000000000 RSI: 00007ffd63f730c0 RDI: 0000000000000005 [ 15.202784][ T407] RBP: 00007ffd63f73020 R08: 0000000000000000 R09: 0000000000000000 [ 15.202786][ T407] R10: 0000000000000000 R11: 0000000000000202 R12: 000000006a910a07 [ 15.202787][ T407] R13: 00000000004a1620 R14: 0000000000000000 R15: 00007ffd63f73780 [ 15.202791][ T407] [ 15.236166][ T407] br2: port 1(w1) entered disabled state [ 15.236451][ T407] w1: entered allmulticast mode [ 15.238011][ T407] w1: entered promiscuous mode [ 15.262004][ T408] br2: port 1(w1) entered blocking state [ 15.262179][ T408] br2: port 1(w1) entered forwarding state [ 15.396597][ T415] br2: port 2(vx10) entered blocking state [ 15.396856][ T415] br2: port 2(vx10) entered disabled state [ 15.397098][ T415] vx10: entered allmulticast mode [ 15.398495][ T415] vx10: entered promiscuous mode [ 15.398883][ T415] br2: port 2(vx10) entered blocking state [ 15.399100][ T415] br2: port 2(vx10) entered forwarding state [ 15.529913][ T422] br2: port 3(vx20) entered blocking state [ 15.530178][ T422] br2: port 3(vx20) entered disabled state [ 15.530689][ T422] vx20: entered allmulticast mode [ 15.531700][ T422] vx20: entered promiscuous mode [ 15.532051][ T422] br2: port 3(vx20) entered blocking state [ 15.532267][ T422] br2: port 3(vx20) entered forwarding state [ 23.529987][ T518] GACT probability NOT on [ 23.530004][ T518] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 23.530006][ T518] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 518, name: modprobe [ 23.530008][ T518] preempt_count: 1, expected: 0 [ 23.530009][ T518] RCU nest depth: 0, expected: 0 [ 23.530010][ T518] INFO: lockdep is turned off. [ 23.530011][ T518] irq event stamp: 0 [ 23.530012][ T518] hardirqs last enabled at (0): [<0000000000000000>] 0x0 [ 23.530016][ T518] hardirqs last disabled at (0): [] copy_process+0x1ccd/0x6240 [ 23.530022][ T518] softirqs last enabled at (0): [] copy_process+0x1d21/0x6240 [ 23.530023][ T518] softirqs last disabled at (0): [<0000000000000000>] 0x0 [ 23.530025][ T518] Preemption disabled at: [ 23.530026][ T518] [] vprintk_emit+0x31b/0x3e0 [ 23.530033][ T518] CPU: 1 UID: 0 PID: 518 Comm: modprobe Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 23.530037][ T518] Tainted: [W]=WARN [ 23.530038][ T518] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 23.530040][ T518] Call Trace: [ 23.530041][ T518] [ 23.530042][ T518] dump_stack_lvl+0x6f/0xa0 [ 23.530047][ T518] ? vprintk_emit+0x31b/0x3e0 [ 23.530049][ T518] __might_resched.cold+0x1fe/0x2c1 [ 23.530053][ T518] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 23.530056][ T518] ? rcu_is_watching+0x16/0xd0 [ 23.530060][ T518] __kmalloc_noprof+0x443/0x760 [ 23.530063][ T518] ? __rwlock_init+0x150/0x150 [ 23.530066][ T518] ? alloc_buf.isra.0+0x4b/0x260 [ 23.530070][ T518] ? do_raw_spin_unlock+0x59/0x250 [ 23.530071][ T518] alloc_buf.isra.0+0x4b/0x260 [ 23.530073][ T518] put_chars+0x1e1/0x2f0 [ 23.530075][ T518] ? desc_read_finalized_seq+0x79/0x120 [ 23.530077][ T518] ? __send_to_port+0x420/0x420 [ 23.530079][ T518] ? console_prepend_replay+0x20/0x20 [ 23.530081][ T518] hvc_console_print+0x292/0x780 [ 23.530084][ T518] ? hvc_write+0x3a0/0x3a0 [ 23.530085][ T518] ? do_raw_spin_lock+0x131/0x280 [ 23.530087][ T518] ? __rwlock_init+0x150/0x150 [ 23.530088][ T518] ? rcu_is_watching+0x16/0xd0 [ 23.530090][ T518] ? rcu_is_watching+0x16/0xd0 [ 23.530092][ T518] ? lock_acquire+0x13c/0x160 [ 23.530094][ T518] console_emit_next_record+0x22f/0x4c0 [ 23.530096][ T518] ? devkmsg_read+0x4b0/0x4b0 [ 23.530098][ T518] ? rcu_is_watching+0x16/0xd0 [ 23.530100][ T518] ? rcu_is_watching+0x16/0xd0 [ 23.530102][ T518] ? rcu_is_watching+0x16/0xd0 [ 23.530103][ T518] ? lock_acquire+0x13c/0x160 [ 23.530105][ T518] ? console_flush_one_record+0x111/0x710 [ 23.530107][ T518] console_flush_one_record+0x46f/0x710 [ 23.530109][ T518] ? console_emit_next_record+0x4c0/0x4c0 [ 23.530112][ T518] console_unlock+0xee/0x1f0 [ 23.530113][ T518] ? lock_acquire+0x13c/0x160 [ 23.530115][ T518] ? console_flush_one_record+0x710/0x710 [ 23.530117][ T518] ? rcu_is_watching+0x16/0xd0 [ 23.530118][ T518] ? lock_release+0x184/0x1f0 [ 23.530120][ T518] ? lock_acquire+0x60/0x160 [ 23.530121][ T518] ? __rcu_read_lock+0x30/0x70 [ 23.530123][ T518] ? __down_trylock_console_sem+0x5e/0xa0 [ 23.530125][ T518] ? vprintk_emit+0x320/0x3e0 [ 23.530127][ T518] vprintk_emit+0x37c/0x3e0 [ 23.530130][ T518] ? wake_up_klogd_work_func+0x90/0x90 [ 23.530133][ T518] ? llc_exit+0x3e0/0x3e0 [llc] [ 23.530135][ T518] _printk+0xc7/0x100 [ 23.530139][ T518] ? snapshot_read.cold+0x21/0x21 [ 23.530141][ T518] ? do_one_initcall+0x113/0x4f0 [ 23.530144][ T518] gact_init_module+0x15/0x1000 [act_gact] [ 23.530146][ T518] do_one_initcall+0x124/0x4f0 [ 23.530148][ T518] ? trace_event_raw_event_initcall_level+0x280/0x280 [ 23.530150][ T518] ? do_init_module+0xae/0x8a0 [ 23.530153][ T518] ? kasan_unpoison+0x44/0x70 [ 23.530156][ T518] do_init_module+0x2ad/0x8a0 [ 23.530158][ T518] ? free_module+0x470/0x470 [ 23.530160][ T518] ? kfree+0x123/0x590 [ 23.530162][ T518] load_module+0x1424/0x1bb0 [ 23.530166][ T518] ? layout_and_allocate.isra.0+0x680/0x680 [ 23.530168][ T518] ? __ia32_sys_fsconfig+0x180/0x180 [ 23.530170][ T518] ? ovl_real_file+0x172/0x1e0 [ 23.530174][ T518] ? backing_file_read_iter+0x541/0x790 [ 23.530177][ T518] init_module_from_file+0x11f/0x1a0 [ 23.530179][ T518] ? __do_sys_init_module+0x220/0x220 [ 23.530181][ T518] ? ovl_mmap+0x270/0x270 [ 23.530184][ T518] ? __rwlock_init+0x150/0x150 [ 23.530186][ T518] ? rcu_is_watching+0x16/0xd0 [ 23.530187][ T518] ? lock_release+0x184/0x1f0 [ 23.530189][ T518] ? do_raw_spin_unlock+0x59/0x250 [ 23.530191][ T518] idempotent_init_module+0x37b/0x7c0 [ 23.530193][ T518] ? init_module_from_file+0x1a0/0x1a0 [ 23.530196][ T518] ? rcu_is_watching+0x16/0xd0 [ 23.530198][ T518] ? cap_capable+0x1d7/0x3d0 [ 23.530201][ T518] __x64_sys_finit_module+0xdf/0x190 [ 23.530203][ T518] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 23.530206][ T518] do_syscall_64+0xff/0x530 [ 23.530209][ T518] ? exc_page_fault+0xee/0x100 [ 23.530211][ T518] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 23.530213][ T518] RIP: 0033:0x7f95d751337d [ 23.530216][ T518] 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 [ 23.530218][ T518] RSP: 002b:00007ffd54c9f348 EFLAGS: 00000246 ORIG_RAX: 0000000000000139 [ 23.530222][ T518] RAX: ffffffffffffffda RBX: 000055feb5849810 RCX: 00007f95d751337d [ 23.530223][ T518] RDX: 0000000000000000 RSI: 000055fea2bd8ffd RDI: 0000000000000000 [ 23.530224][ T518] RBP: 00007ffd54c9f3e0 R08: 0000000000000000 R09: 0000000000000000 [ 23.530225][ T518] R10: 0000000000000000 R11: 0000000000000246 R12: 000055fea2bd8ffd [ 23.530226][ T518] R13: 000055feb5849960 R14: 0000000000040000 R15: 0000000000000000 [ 23.530228][ T518] [ 109.935730][ T70] vx20: left allmulticast mode [ 109.935746][ T70] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 109.935749][ T70] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 70, name: kworker/u16:1 [ 109.935751][ T70] preempt_count: 1, expected: 0 [ 109.935752][ T70] RCU nest depth: 0, expected: 0 [ 109.935753][ T70] INFO: lockdep is turned off. [ 109.935754][ T70] irq event stamp: 23010 [ 109.935755][ T70] hardirqs last enabled at (23009): [] _raw_spin_unlock_irq+0x28/0x50 [ 109.935764][ T70] hardirqs last disabled at (23010): [] __schedule+0x1246/0x20e0 [ 109.935766][ T70] softirqs last enabled at (23006): [] handle_softirqs+0x67c/0x900 [ 109.935770][ T70] softirqs last disabled at (22937): [] do_softirq+0xac/0xe0 [ 109.935772][ T70] Preemption disabled at: [ 109.935773][ T70] [] vprintk_emit+0x31b/0x3e0 [ 109.935781][ T70] CPU: 1 UID: 0 PID: 70 Comm: kworker/u16:1 Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 109.935784][ T70] Tainted: [W]=WARN [ 109.935785][ T70] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 109.935787][ T70] Workqueue: netns cleanup_net [ 109.935793][ T70] Call Trace: [ 109.935795][ T70] [ 109.935797][ T70] dump_stack_lvl+0x6f/0xa0 [ 109.935802][ T70] ? vprintk_emit+0x31b/0x3e0 [ 109.935804][ T70] __might_resched.cold+0x1fe/0x2c1 [ 109.935808][ T70] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 109.935811][ T70] ? rcu_is_watching+0x16/0xd0 [ 109.935816][ T70] __kmalloc_noprof+0x443/0x760 [ 109.935820][ T70] ? __rwlock_init+0x150/0x150 [ 109.935822][ T70] ? alloc_buf.isra.0+0x4b/0x260 [ 109.935826][ T70] ? do_raw_spin_unlock+0x59/0x250 [ 109.935828][ T70] alloc_buf.isra.0+0x4b/0x260 [ 109.935831][ T70] put_chars+0x1e1/0x2f0 [ 109.935832][ T70] ? desc_read_finalized_seq+0x79/0x120 [ 109.935834][ T70] ? __send_to_port+0x420/0x420 [ 109.935836][ T70] ? console_prepend_replay+0x20/0x20 [ 109.935839][ T70] hvc_console_print+0x292/0x780 [ 109.935842][ T70] ? hvc_write+0x3a0/0x3a0 [ 109.935844][ T70] ? do_raw_spin_lock+0x131/0x280 [ 109.935846][ T70] ? __rwlock_init+0x150/0x150 [ 109.935847][ T70] ? rcu_is_watching+0x16/0xd0 [ 109.935849][ T70] ? rcu_is_watching+0x16/0xd0 [ 109.935852][ T70] ? lock_acquire+0x13c/0x160 [ 109.935854][ T70] console_emit_next_record+0x22f/0x4c0 [ 109.935857][ T70] ? devkmsg_read+0x4b0/0x4b0 [ 109.935860][ T70] ? rcu_is_watching+0x16/0xd0 [ 109.935862][ T70] ? rcu_is_watching+0x16/0xd0 [ 109.935864][ T70] ? rcu_is_watching+0x16/0xd0 [ 109.935866][ T70] ? lock_acquire+0x13c/0x160 [ 109.935868][ T70] ? console_flush_one_record+0x111/0x710 [ 109.935870][ T70] console_flush_one_record+0x46f/0x710 [ 109.935872][ T70] ? console_emit_next_record+0x4c0/0x4c0 [ 109.935875][ T70] console_unlock+0xee/0x1f0 [ 109.935877][ T70] ? lock_acquire+0x13c/0x160 [ 109.935879][ T70] ? console_flush_one_record+0x710/0x710 [ 109.935881][ T70] ? rcu_is_watching+0x16/0xd0 [ 109.935883][ T70] ? lock_release+0x184/0x1f0 [ 109.935884][ T70] ? lock_acquire+0x60/0x160 [ 109.935886][ T70] ? __rcu_read_lock+0x30/0x70 [ 109.935888][ T70] ? __down_trylock_console_sem+0x5e/0xa0 [ 109.935890][ T70] ? vprintk_emit+0x320/0x3e0 [ 109.935892][ T70] vprintk_emit+0x37c/0x3e0 [ 109.935895][ T70] ? wake_up_klogd_work_func+0x90/0x90 [ 109.935897][ T70] ? process_one_work+0xe3e/0x1560 [ 109.935900][ T70] ? kthread+0x367/0x460 [ 109.935902][ T70] ? ret_from_fork+0x474/0x6b0 [ 109.935911][ T70] ? ret_from_fork_asm+0x11/0x20 [ 109.935914][ T70] _printk+0xc7/0x100 [ 109.935917][ T70] ? snapshot_read.cold+0x21/0x21 [ 109.935920][ T70] ? netdev_name+0x43/0x60 [ 109.935923][ T70] ? __netdev_printk+0x17f/0x1d0 [ 109.935925][ T70] netdev_info+0xe2/0x116 [ 109.935927][ T70] ? netdev_notice+0x120/0x120 [ 109.935929][ T70] ? rcu_is_watching+0x16/0xd0 [ 109.935931][ T70] ? __up_read+0x355/0x9e0 [ 109.935933][ T70] ? trace_hardirqs_on+0x36/0x40 [ 109.935936][ T70] ? down_write_nested+0x200/0x200 [ 109.935937][ T70] ? mutex_is_locked+0x1c/0x50 [ 109.935940][ T70] netif_set_allmulti.cold+0x7c/0x166 [ 109.935943][ T70] dev_set_allmulti+0xa2/0x150 [ 109.935946][ T70] del_nbp+0xb7/0xc10 [bridge] [ 109.935960][ T70] br_dev_delete+0x9d/0x1e0 [bridge] [ 109.935968][ T70] br_net_exit_rtnl+0xb8/0x110 [bridge] [ 109.935976][ T70] ops_undo_list+0x5be/0x8f0 [ 109.935978][ T70] ? rtnl_net_dumpid_one+0x2d0/0x2d0 [ 109.935980][ T70] ? idr_destroy+0x121/0x250 [ 109.935983][ T70] cleanup_net+0x431/0x890 [ 109.935985][ T70] ? net_passive_dec+0x230/0x230 [ 109.935987][ T70] ? lock_acquire+0x13c/0x160 [ 109.935989][ T70] ? rcu_is_watching+0x16/0xd0 [ 109.935991][ T70] process_one_work+0xe3e/0x1560 [ 109.935994][ T70] ? __queue_delayed_work+0x470/0x470 [ 109.935996][ T70] ? __rwlock_init+0x150/0x150 [ 109.935999][ T70] worker_thread+0x4f1/0xd60 [ 109.936001][ T70] ? rescuer_thread+0x1340/0x1340 [ 109.936003][ T70] ? __kthread_parkme+0xbd/0x210 [ 109.936004][ T70] ? rescuer_thread+0x1340/0x1340 [ 109.936006][ T70] ? rescuer_thread+0x1340/0x1340 [ 109.936008][ T70] kthread+0x367/0x460 [ 109.936010][ T70] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 109.936011][ T70] ? kthread_affine_preferred+0x4c0/0x4c0 [ 109.936013][ T70] ret_from_fork+0x474/0x6b0 [ 109.936015][ T70] ? arch_exit_to_user_mode_prepare.isra.0+0x120/0x120 [ 109.936017][ T70] ? __switch_to+0x5a3/0xe00 [ 109.936019][ T70] ? kthread_affine_preferred+0x4c0/0x4c0 [ 109.936021][ T70] ret_from_fork_asm+0x11/0x20 [ 109.936024][ T70] [ 109.955662][ T70] vx20: left promiscuous mode [ 109.955972][ T70] br2: port 3(vx20) entered disabled state [ 109.957034][ T70] vx10: left allmulticast mode [ 109.957184][ T70] vx10: left promiscuous mode [ 109.958567][ T70] br2: port 2(vx10) entered disabled state [ 109.959955][ T70] w1: left allmulticast mode [ 109.960105][ T70] w1: left promiscuous mode [ 109.960308][ T70] br2: port 1(w1) entered disabled state [ 110.051129][ T70] vx20: left allmulticast mode [ 110.051307][ T70] vx20: left promiscuous mode [ 110.051539][ T70] br2: port 3(vx20) entered disabled state [ 110.053038][ T70] vx10: left allmulticast mode [ 110.053205][ T70] vx10: left promiscuous mode [ 110.053785][ T70] br2: port 2(vx10) entered disabled state [ 110.055871][ T70] w1: left allmulticast mode [ 110.056048][ T70] w1: left promiscuous mode [ 110.056248][ T70] br2: port 1(w1) entered disabled state [ 110.533512][ T744] br1: port 4(veth2) entered disabled state [ 110.553201][ T745] veth2: left allmulticast mode [ 110.553423][ T745] veth2: left promiscuous mode [ 110.553680][ T745] br1: port 4(veth2) entered disabled state [ 110.624334][ T749] br1: port 3(veth1) entered disabled state [ 110.648424][ T751] veth1: left allmulticast mode [ 110.648636][ T751] veth1: left promiscuous mode [ 110.648900][ T751] br1: port 3(veth1) entered disabled state [ 110.687268][ T753] vx20: left allmulticast mode [ 110.687484][ T753] vx20: left promiscuous mode [ 110.687756][ T753] br1: port 2(vx20) entered disabled state [ 110.765075][ T757] vx10: left allmulticast mode [ 110.765249][ T757] vx10: left promiscuous mode [ 110.765461][ T757] br1: port 1(vx10) entered disabled state