[ 10.942562][ T244] 8021q: 802.1Q VLAN Support v1.8 [ 10.942578][ T244] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 10.942580][ T244] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 244, name: modprobe [ 10.942582][ T244] preempt_count: 1, expected: 0 [ 10.942583][ T244] RCU nest depth: 0, expected: 0 [ 10.942584][ T244] locks held by modprobe/244: 4, last CPU#0: [ 10.942586][ T244] #0: ffffffff94769cc0 (console_lock){+.+.}-{0:0}, at: vprintk_emit+0x320/0x3e0 [ 10.942599][ T244] #1: ffffffff94769d38 (console_srcu){....}-{0:0}, at: console_flush_one_record+0x106/0x710 [ 10.942603][ T244] #2: ffffffff94689660 (console_owner){....}-{0:0}, at: console_lock_spinning_enable+0x40/0x60 [ 10.942607][ T244] #3: ffffffff94689560 (printk_legacy_map-wait-type-override){....}-{3:3}, at: console_emit_next_record+0x1df/0x4c0 [ 10.942611][ T244] irq event stamp: 29084 [ 10.942612][ T244] hardirqs last enabled at (29083): [] __down_trylock_console_sem+0x86/0xa0 [ 10.942615][ T244] hardirqs last disabled at (29084): [] console_emit_next_record+0x3d4/0x4c0 [ 10.942617][ T244] softirqs last enabled at (26718): [] handle_softirqs+0x67c/0x900 [ 10.942620][ T244] softirqs last disabled at (26245): [] __irq_exit_rcu+0x145/0x1c0 [ 10.942622][ T244] Preemption disabled at: [ 10.942623][ T244] [] vprintk_emit+0x31b/0x3e0 [ 10.942629][ T244] CPU: 0 UID: 0 PID: 244 Comm: modprobe Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 10.942632][ T244] Tainted: [W]=WARN [ 10.942633][ T244] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 10.942635][ T244] Call Trace: [ 10.942637][ T244] [ 10.942639][ T244] dump_stack_lvl+0x6f/0xa0 [ 10.942644][ T244] ? vprintk_emit+0x31b/0x3e0 [ 10.942646][ T244] __might_resched.cold+0x1fe/0x2c1 [ 10.942651][ T244] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 10.942655][ T244] ? __kmalloc_noprof+0xdb/0x760 [ 10.942660][ T244] __kmalloc_noprof+0x443/0x760 [ 10.942662][ T244] ? alloc_buf.isra.0+0x4b/0x260 [ 10.942668][ T244] ? do_raw_spin_unlock+0x59/0x250 [ 10.942671][ T244] alloc_buf.isra.0+0x4b/0x260 [ 10.942674][ T244] put_chars+0x1e1/0x2f0 [ 10.942677][ T244] ? __send_to_port+0x420/0x420 [ 10.942678][ T244] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 10.942683][ T244] ? rcu_read_lock_any_held+0x3c/0x90 [ 10.942685][ T244] ? validate_chain+0x38b/0xc20 [ 10.942690][ T244] hvc_console_print+0x292/0x780 [ 10.942692][ T244] ? __lock_acquire+0x518/0xc20 [ 10.942697][ T244] ? hvc_write+0x3a0/0x3a0 [ 10.942700][ T244] ? rcu_is_watching+0x16/0xd0 [ 10.942705][ T244] console_emit_next_record+0x22f/0x4c0 [ 10.942708][ T244] ? devkmsg_read+0x4b0/0x4b0 [ 10.942710][ T244] ? console_flush_one_record+0x106/0x710 [ 10.942713][ T244] ? rcu_is_watching+0x16/0xd0 [ 10.942716][ T244] ? lock_acquire+0x13c/0x160 [ 10.942719][ T244] console_flush_one_record+0x46f/0x710 [ 10.942726][ T244] ? console_emit_next_record+0x4c0/0x4c0 [ 10.942728][ T244] ? __lock_acquire+0x518/0xc20 [ 10.942733][ T244] console_unlock+0xee/0x1f0 [ 10.942736][ T244] ? console_flush_one_record+0x710/0x710 [ 10.942738][ T244] ? rcu_is_watching+0x16/0xd0 [ 10.942740][ T244] ? lock_acquire+0x60/0x160 [ 10.942743][ T244] ? __down_trylock_console_sem+0x5e/0xa0 [ 10.942745][ T244] ? vprintk_emit+0x320/0x3e0 [ 10.942748][ T244] vprintk_emit+0x37c/0x3e0 [ 10.942752][ T244] ? wake_up_klogd_work_func+0x90/0x90 [ 10.942758][ T244] ? vlan_netlink_fini+0x960/0x960 [8021q] [ 10.942761][ T244] _printk+0xc7/0x100 [ 10.942765][ T244] ? snapshot_read.cold+0x21/0x21 [ 10.942771][ T244] ? do_one_initcall+0x113/0x4f0 [ 10.942774][ T244] vlan_proto_init+0x24/0x90 [8021q] [ 10.942777][ T244] do_one_initcall+0x124/0x4f0 [ 10.942780][ T244] ? trace_event_raw_event_initcall_level+0x280/0x280 [ 10.942784][ T244] ? do_init_module+0xae/0x8a0 [ 10.942787][ T244] ? kasan_unpoison+0x44/0x70 [ 10.942792][ T244] do_init_module+0x2ad/0x8a0 [ 10.942795][ T244] ? lockdep_hardirqs_on+0x91/0x130 [ 10.942800][ T244] ? free_module+0x470/0x470 [ 10.942803][ T244] ? kfree+0x123/0x590 [ 10.942807][ T244] load_module+0x1424/0x1bb0 [ 10.942814][ T244] ? layout_and_allocate.isra.0+0x680/0x680 [ 10.942818][ T244] ? __ia32_sys_fsconfig+0x180/0x180 [ 10.942820][ T244] ? ovl_real_file+0x172/0x1e0 [ 10.942824][ T244] ? backing_file_read_iter+0x541/0x790 [ 10.942827][ T244] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 10.942831][ T244] init_module_from_file+0x11f/0x1a0 [ 10.942834][ T244] ? __do_sys_init_module+0x220/0x220 [ 10.942842][ T244] ? __rwlock_init+0x150/0x150 [ 10.942845][ T244] ? do_raw_spin_unlock+0x59/0x250 [ 10.942848][ T244] idempotent_init_module+0x37b/0x7c0 [ 10.942852][ T244] ? init_module_from_file+0x1a0/0x1a0 [ 10.942858][ T244] ? rcu_is_watching+0x16/0xd0 [ 10.942860][ T244] ? cap_capable+0x1d7/0x3d0 [ 10.942866][ T244] __x64_sys_finit_module+0xdf/0x190 [ 10.942868][ T244] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 10.942871][ T244] do_syscall_64+0xff/0x530 [ 10.942873][ T244] ? exc_page_fault+0xee/0x100 [ 10.942876][ T244] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 10.942878][ T244] RIP: 0033:0x7f0a313de37d [ 10.942881][ T244] 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.942883][ T244] RSP: 002b:00007ffe0df9bd38 EFLAGS: 00000246 ORIG_RAX: 0000000000000139 [ 10.942886][ T244] RAX: ffffffffffffffda RBX: 000055c18d720810 RCX: 00007f0a313de37d [ 10.942887][ T244] RDX: 0000000000000000 RSI: 000055c1527cbffd RDI: 0000000000000000 [ 10.942888][ T244] RBP: 00007ffe0df9bdd0 R08: 0000000000000000 R09: 0000000000000000 [ 10.942889][ T244] R10: 0000000000000000 R11: 0000000000000246 R12: 000055c1527cbffd [ 10.942890][ T244] R13: 000055c18d720960 R14: 0000000000040000 R15: 0000000000000000 [ 10.942896][ T244] [ 12.226681][ T315] GACT probability NOT on [ 12.226699][ T315] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 12.226702][ T315] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 315, name: modprobe [ 12.226704][ T315] preempt_count: 1, expected: 0 [ 12.226704][ T315] RCU nest depth: 0, expected: 0 [ 12.226705][ T315] locks held by modprobe/315: 4, last CPU#0: [ 12.226708][ T315] #0: ffffffff94769cc0 (console_lock){+.+.}-{0:0}, at: vprintk_emit+0x320/0x3e0 [ 12.226720][ T315] #1: ffffffff94769d38 (console_srcu){....}-{0:0}, at: console_flush_one_record+0x106/0x710 [ 12.226726][ T315] #2: ffffffff94689660 (console_owner){....}-{0:0}, at: console_lock_spinning_enable+0x40/0x60 [ 12.226731][ T315] #3: ffffffff94689560 (printk_legacy_map-wait-type-override){....}-{3:3}, at: console_emit_next_record+0x1df/0x4c0 [ 12.226735][ T315] irq event stamp: 21216 [ 12.226735][ T315] hardirqs last enabled at (21215): [] __down_trylock_console_sem+0x86/0xa0 [ 12.226738][ T315] hardirqs last disabled at (21216): [] console_emit_next_record+0x3d4/0x4c0 [ 12.226740][ T315] softirqs last enabled at (19890): [] handle_softirqs+0x67c/0x900 [ 12.226743][ T315] softirqs last disabled at (18751): [] __irq_exit_rcu+0x145/0x1c0 [ 12.226746][ T315] Preemption disabled at: [ 12.226746][ T315] [] vprintk_emit+0x31b/0x3e0 [ 12.226752][ T315] CPU: 0 UID: 0 PID: 315 Comm: modprobe Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 12.226755][ T315] Tainted: [W]=WARN [ 12.226756][ T315] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 12.226758][ T315] Call Trace: [ 12.226760][ T315] [ 12.226761][ T315] dump_stack_lvl+0x6f/0xa0 [ 12.226767][ T315] ? vprintk_emit+0x31b/0x3e0 [ 12.226769][ T315] __might_resched.cold+0x1fe/0x2c1 [ 12.226774][ T315] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 12.226778][ T315] ? __kmalloc_noprof+0xdb/0x760 [ 12.226783][ T315] __kmalloc_noprof+0x443/0x760 [ 12.226786][ T315] ? alloc_buf.isra.0+0x4b/0x260 [ 12.226792][ T315] ? do_raw_spin_unlock+0x59/0x250 [ 12.226795][ T315] alloc_buf.isra.0+0x4b/0x260 [ 12.226798][ T315] put_chars+0x1e1/0x2f0 [ 12.226800][ T315] ? desc_read_finalized_seq+0x79/0x120 [ 12.226802][ T315] ? __send_to_port+0x420/0x420 [ 12.226805][ T315] ? rcu_read_lock_any_held+0x3c/0x90 [ 12.226808][ T315] ? validate_chain+0x38b/0xc20 [ 12.226812][ T315] hvc_console_print+0x292/0x780 [ 12.226815][ T315] ? __lock_acquire+0x518/0xc20 [ 12.226816][ T315] ? __lock_acquire+0x518/0xc20 [ 12.226821][ T315] ? hvc_write+0x3a0/0x3a0 [ 12.226822][ T315] ? console_emit_next_record+0x1df/0x4c0 [ 12.226825][ T315] ? rcu_is_watching+0x16/0xd0 [ 12.226828][ T315] ? lock_acquire+0x13c/0x160 [ 12.226832][ T315] console_emit_next_record+0x22f/0x4c0 [ 12.226836][ T315] ? devkmsg_read+0x4b0/0x4b0 [ 12.226837][ T315] ? console_flush_one_record+0x106/0x710 [ 12.226840][ T315] ? rcu_is_watching+0x16/0xd0 [ 12.226843][ T315] ? lock_acquire+0x13c/0x160 [ 12.226846][ T315] console_flush_one_record+0x46f/0x710 [ 12.226851][ T315] ? console_emit_next_record+0x4c0/0x4c0 [ 12.226853][ T315] ? __lock_acquire+0x518/0xc20 [ 12.226857][ T315] console_unlock+0xee/0x1f0 [ 12.226860][ T315] ? console_flush_one_record+0x710/0x710 [ 12.226862][ T315] ? rcu_is_watching+0x16/0xd0 [ 12.226864][ T315] ? lock_acquire+0x60/0x160 [ 12.226868][ T315] ? __down_trylock_console_sem+0x5e/0xa0 [ 12.226869][ T315] ? vprintk_emit+0x320/0x3e0 [ 12.226872][ T315] vprintk_emit+0x37c/0x3e0 [ 12.226877][ T315] ? wake_up_klogd_work_func+0x90/0x90 [ 12.226882][ T315] ? gact_cleanup_module+0xf0/0xf0 [act_gact] [ 12.226885][ T315] _printk+0xc7/0x100 [ 12.226889][ T315] ? snapshot_read.cold+0x21/0x21 [ 12.226895][ T315] ? do_one_initcall+0x113/0x4f0 [ 12.226897][ T315] gact_init_module+0x15/0x1000 [act_gact] [ 12.226900][ T315] do_one_initcall+0x124/0x4f0 [ 12.226902][ T315] ? trace_event_raw_event_initcall_level+0x280/0x280 [ 12.226907][ T315] ? do_init_module+0xae/0x8a0 [ 12.226910][ T315] ? kasan_unpoison+0x44/0x70 [ 12.226915][ T315] do_init_module+0x2ad/0x8a0 [ 12.226919][ T315] ? lockdep_hardirqs_on+0x91/0x130 [ 12.226923][ T315] ? free_module+0x470/0x470 [ 12.226926][ T315] ? kfree+0x123/0x590 [ 12.226930][ T315] load_module+0x1424/0x1bb0 [ 12.226937][ T315] ? layout_and_allocate.isra.0+0x680/0x680 [ 12.226941][ T315] ? __ia32_sys_fsconfig+0x180/0x180 [ 12.226943][ T315] ? ovl_real_file+0x172/0x1e0 [ 12.226948][ T315] ? find_held_lock+0x2b/0x80 [ 12.226949][ T315] ? backing_file_read_iter+0x541/0x790 [ 12.226952][ T315] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 12.226956][ T315] init_module_from_file+0x11f/0x1a0 [ 12.226959][ T315] ? __do_sys_init_module+0x220/0x220 [ 12.226967][ T315] ? __rwlock_init+0x150/0x150 [ 12.226970][ T315] ? do_raw_spin_unlock+0x59/0x250 [ 12.226973][ T315] idempotent_init_module+0x37b/0x7c0 [ 12.226977][ T315] ? init_module_from_file+0x1a0/0x1a0 [ 12.226983][ T315] ? rcu_is_watching+0x16/0xd0 [ 12.226985][ T315] ? cap_capable+0x1d7/0x3d0 [ 12.226991][ T315] __x64_sys_finit_module+0xdf/0x190 [ 12.226993][ T315] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 12.226996][ T315] do_syscall_64+0xff/0x530 [ 12.226998][ T315] ? exc_page_fault+0xee/0x100 [ 12.227001][ T315] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 12.227003][ T315] RIP: 0033:0x7f8094a1c37d [ 12.227007][ T315] 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.227008][ T315] RSP: 002b:00007fff098094d8 EFLAGS: 00000246 ORIG_RAX: 0000000000000139 [ 12.227011][ T315] RAX: ffffffffffffffda RBX: 000055fe3728d810 RCX: 00007f8094a1c37d [ 12.227013][ T315] RDX: 0000000000000000 RSI: 000055fe0d993ffd RDI: 0000000000000000 [ 12.227014][ T315] RBP: 00007fff09809570 R08: 0000000000000000 R09: 0000000000000000 [ 12.227014][ T315] R10: 0000000000000000 R11: 0000000000000246 R12: 000055fe0d993ffd [ 12.227015][ T315] R13: 000055fe3728d960 R14: 0000000000040000 R15: 0000000000000000 [ 12.227022][ T315] [ 12.827583][ T352] br10: port 1(veth1.10) entered blocking state [ 12.828362][ T352] br10: port 1(veth1.10) entered disabled state [ 12.828688][ T352] veth1.10: entered allmulticast mode [ 12.828931][ T352] veth1: entered allmulticast mode [ 12.830565][ T352] veth1.10: entered promiscuous mode [ 12.830822][ T352] veth1: entered promiscuous mode [ 13.024596][ T368] br11: port 1(veth1.11) entered blocking state [ 13.025408][ T368] br11: port 1(veth1.11) entered disabled state [ 13.025734][ T368] veth1.11: entered allmulticast mode [ 13.027658][ T368] veth1.11: entered promiscuous mode [ 13.333281][ T394] ip (394) used greatest stack depth: 24048 bytes left [ 13.333298][ T394] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 13.333300][ T394] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 394, name: ip [ 13.333302][ T394] preempt_count: 2, expected: 0 [ 13.333303][ T394] RCU nest depth: 0, expected: 0 [ 13.333304][ T394] locks held by ip/394: 5, last CPU#3: [ 13.333306][ T394] #0: ffffffff946027b8 (low_water_lock){+.+.}-{3:3}, at: do_exit+0x887/0xdc0 [ 13.333318][ T394] #1: ffffffff94769cc0 (console_lock){+.+.}-{0:0}, at: vprintk_emit+0x320/0x3e0 [ 13.333324][ T394] #2: ffffffff94769d38 (console_srcu){....}-{0:0}, at: console_flush_one_record+0x106/0x710 [ 13.333328][ T394] #3: ffffffff94689660 (console_owner){....}-{0:0}, at: console_lock_spinning_enable+0x40/0x60 [ 13.333332][ T394] #4: ffffffff94689560 (printk_legacy_map-wait-type-override){....}-{3:3}, at: console_emit_next_record+0x1df/0x4c0 [ 13.333336][ T394] irq event stamp: 23526 [ 13.333337][ T394] hardirqs last enabled at (23525): [] __down_trylock_console_sem+0x86/0xa0 [ 13.333340][ T394] hardirqs last disabled at (23526): [] console_emit_next_record+0x3d4/0x4c0 [ 13.333342][ T394] softirqs last enabled at (23166): [] handle_softirqs+0x67c/0x900 [ 13.333343][ T394] softirqs last disabled at (23157): [] __irq_exit_rcu+0x145/0x1c0 [ 13.333346][ T394] Preemption disabled at: [ 13.333346][ T394] [<0000000000000000>] 0x0 [ 13.333353][ T394] CPU: 3 UID: 0 PID: 394 Comm: ip Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 13.333357][ T394] Tainted: [W]=WARN [ 13.333357][ T394] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 13.333359][ T394] Call Trace: [ 13.333361][ T394] [ 13.333362][ T394] dump_stack_lvl+0x6f/0xa0 [ 13.333368][ T394] __might_resched.cold+0x1fe/0x2c1 [ 13.333373][ T394] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 13.333377][ T394] ? __kmalloc_noprof+0xdb/0x760 [ 13.333382][ T394] __kmalloc_noprof+0x443/0x760 [ 13.333384][ T394] ? alloc_buf.isra.0+0x4b/0x260 [ 13.333390][ T394] ? do_raw_spin_unlock+0x59/0x250 [ 13.333393][ T394] alloc_buf.isra.0+0x4b/0x260 [ 13.333396][ T394] put_chars+0x1e1/0x2f0 [ 13.333399][ T394] ? __send_to_port+0x420/0x420 [ 13.333400][ T394] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 13.333405][ T394] ? validate_chain+0x38b/0xc20 [ 13.333410][ T394] hvc_console_print+0x292/0x780 [ 13.333417][ T394] ? hvc_write+0x3a0/0x3a0 [ 13.333419][ T394] ? rcu_is_watching+0x16/0xd0 [ 13.333427][ T394] ? lock_acquire+0x13c/0x160 [ 13.333431][ T394] console_emit_next_record+0x22f/0x4c0 [ 13.333436][ T394] ? devkmsg_read+0x4b0/0x4b0 [ 13.333437][ T394] ? console_flush_one_record+0x106/0x710 [ 13.333441][ T394] ? rcu_is_watching+0x16/0xd0 [ 13.333443][ T394] ? lock_acquire+0x13c/0x160 [ 13.333447][ T394] console_flush_one_record+0x46f/0x710 [ 13.333451][ T394] ? console_emit_next_record+0x4c0/0x4c0 [ 13.333453][ T394] ? __lock_acquire+0x518/0xc20 [ 13.333458][ T394] console_unlock+0xee/0x1f0 [ 13.333461][ T394] ? console_flush_one_record+0x710/0x710 [ 13.333463][ T394] ? rcu_is_watching+0x16/0xd0 [ 13.333465][ T394] ? lock_acquire+0x60/0x160 [ 13.333469][ T394] ? __down_trylock_console_sem+0x5e/0xa0 [ 13.333470][ T394] ? vprintk_emit+0x320/0x3e0 [ 13.333474][ T394] vprintk_emit+0x37c/0x3e0 [ 13.333477][ T394] ? wake_up_klogd_work_func+0x90/0x90 [ 13.333481][ T394] ? __lock_acquire+0x518/0xc20 [ 13.333485][ T394] _printk+0xc7/0x100 [ 13.333488][ T394] ? snapshot_read.cold+0x21/0x21 [ 13.333491][ T394] ? do_raw_spin_lock+0x131/0x280 [ 13.333494][ T394] ? __rwlock_init+0x150/0x150 [ 13.333497][ T394] ? do_raw_spin_lock+0x131/0x280 [ 13.333500][ T394] do_exit.cold+0x82/0x9c [ 13.333504][ T394] ? exit_notify+0x890/0x890 [ 13.333506][ T394] ? __lock_release.isra.0+0x69/0x1a0 [ 13.333509][ T394] ? rcu_is_watching+0x16/0xd0 [ 13.333513][ T394] do_group_exit+0xb8/0x370 [ 13.333515][ T394] __x64_sys_exit_group+0x3c/0x50 [ 13.333517][ T394] x64_sys_call+0x1567/0x1570 [ 13.333519][ T394] do_syscall_64+0xff/0x530 [ 13.333523][ T394] ? exc_page_fault+0xee/0x100 [ 13.333526][ T394] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 13.333528][ T394] RIP: 0033:0x7fe0b85271b8 [ 13.333530][ T394] Code: Unable to access opcode bytes at 0x7fe0b852718e. [ 13.333531][ T394] RSP: 002b:00007ffca9da8b68 EFLAGS: 00000246 ORIG_RAX: 00000000000000e7 [ 13.333534][ T394] RAX: ffffffffffffffda RBX: 00007fe0b8657f88 RCX: 00007fe0b85271b8 [ 13.333535][ T394] RDX: 00007fe0b8271fc8 RSI: fffffffffffffeb8 RDI: 0000000000000000 [ 13.333536][ T394] RBP: 00007ffca9da8bc0 R08: 0000000000000000 R09: 0000000000000060 [ 13.333537][ T394] R10: 00007ffca9da8980 R11: 0000000000000246 R12: 0000000000000001 [ 13.333538][ T394] R13: 0000000000000000 R14: 00007fe0b8656680 R15: 00007fe0b8657fa0 [ 13.333545][ T394] [ 13.380937][ T400] br10: port 2(veth2.10) entered blocking state [ 13.381259][ T400] br10: port 2(veth2.10) entered disabled state [ 13.381570][ T400] veth2.10: entered allmulticast mode [ 13.381792][ T400] veth2: entered allmulticast mode [ 13.383495][ T400] veth2.10: entered promiscuous mode [ 13.384155][ T400] veth2: entered promiscuous mode [ 13.584470][ T418] br11: port 2(veth2.11) entered blocking state [ 13.584830][ T418] br11: port 2(veth2.11) entered disabled state [ 13.585149][ T418] veth2.11: entered allmulticast mode [ 13.586743][ T418] veth2.11: entered promiscuous mode [ 13.794005][ T430] br10: port 2(veth2.10) entered blocking state [ 13.794840][ T430] br10: port 2(veth2.10) entered forwarding state [ 13.795905][ T430] br10: port 1(veth1.10) entered blocking state [ 13.796464][ T430] br10: port 1(veth1.10) entered forwarding state [ 13.852500][ T435] br11: port 2(veth2.11) entered blocking state [ 13.852856][ T435] br11: port 2(veth2.11) entered forwarding state [ 13.853276][ T435] br11: port 1(veth1.11) entered blocking state [ 13.853567][ T435] br11: port 1(veth1.11) entered forwarding state [ 21.911021][ C0] clocksource: Watchdog remote CPU 2 read timed out [ 21.911058][ C0] [ 21.911060][ C0] ======================================================== [ 21.911061][ C0] WARNING: possible irq lock inversion dependency detected [ 21.911063][ C0] 7.2.0-virtme #1 Tainted: G W [ 21.911065][ C0] -------------------------------------------------------- [ 21.911066][ C0] swapper/0/0 just changed the state of lock: [ 21.911067][ C0] ffffffff94689660 (console_owner){..-.}-{0:0}, at: console_lock_spinning_enable+0x40/0x60 [ 21.911079][ C0] but this lock took another, SOFTIRQ-unsafe lock in the past: [ 21.911080][ C0] (fs_reclaim){+.+.}-{0:0} [ 21.911082][ C0] [ 21.911082][ C0] [ 21.911082][ C0] and interrupts could create inverse lock ordering between them. [ 21.911082][ C0] [ 21.911082][ C0] [ 21.911082][ C0] other info that might help us debug this: [ 21.911083][ C0] Possible interrupt unsafe locking scenario: [ 21.911083][ C0] [ 21.911084][ C0] CPU0 CPU1 [ 21.911084][ C0] ---- ---- [ 21.911084][ C0] lock(fs_reclaim); [ 21.911085][ C0] local_irq_disable(); [ 21.911086][ C0] lock(console_owner); [ 21.911087][ C0] lock(fs_reclaim); [ 21.911088][ C0] [ 21.911088][ C0] lock(console_owner); [ 21.911089][ C0] [ 21.911089][ C0] *** DEADLOCK *** [ 21.911089][ C0] [ 21.911089][ C0] locks held by swapper/0/0: 4, last CPU#0: [ 21.911090][ C0] #0: ffa0000000007c90 ((&watchdog_timer)){+.-.}-{0:0}, at: call_timer_fn+0x110/0x4d0 [ 21.911096][ C0] #1: ffffffff947ce8b8 (watchdog_lock){+.-.}-{3:3}, at: clocksource_watchdog+0x15/0x30 [ 21.911100][ C0] #2: ffffffff94769cc0 (console_lock){+.+.}-{0:0}, at: vprintk_emit+0x320/0x3e0 [ 21.911104][ C0] #3: ffffffff94769d38 (console_srcu){....}-{0:0}, at: console_flush_one_record+0x106/0x710 [ 21.911107][ C0] [ 21.911107][ C0] the shortest dependencies between 2nd lock and 1st lock: [ 21.911111][ C0] -> (fs_reclaim){+.+.}-{0:0} { [ 21.911114][ C0] HARDIRQ-ON-W at: [ 21.911115][ C0] __lock_acquire+0x388/0xc20 [ 21.911118][ C0] lock_acquire.part.0+0xd4/0x280 [ 21.911120][ C0] fs_reclaim_acquire+0xd5/0x120 [ 21.911123][ C0] __kmalloc_cache_noprof+0x6e/0x620 [ 21.911125][ C0] kthread_create_worker_on_node+0xea/0x210 [ 21.911128][ C0] workqueue_init+0x2a/0x680 [ 21.911132][ C0] kernel_init_freeable+0x2fe/0x630 [ 21.911134][ C0] kernel_init+0x21/0x150 [ 21.911137][ C0] ret_from_fork+0x474/0x6b0 [ 21.911140][ C0] ret_from_fork_asm+0x11/0x20 [ 21.911143][ C0] SOFTIRQ-ON-W at: [ 21.911144][ C0] __lock_acquire+0x388/0xc20 [ 21.911145][ C0] lock_acquire.part.0+0xd4/0x280 [ 21.911147][ C0] fs_reclaim_acquire+0xd5/0x120 [ 21.911148][ C0] __kmalloc_cache_noprof+0x6e/0x620 [ 21.911149][ C0] kthread_create_worker_on_node+0xea/0x210 [ 21.911151][ C0] workqueue_init+0x2a/0x680 [ 21.911152][ C0] kernel_init_freeable+0x2fe/0x630 [ 21.911153][ C0] kernel_init+0x21/0x150 [ 21.911154][ C0] ret_from_fork+0x474/0x6b0 [ 21.911156][ C0] ret_from_fork_asm+0x11/0x20 [ 21.911157][ C0] INITIAL USE at: [ 21.911158][ C0] __lock_acquire+0x388/0xc20 [ 21.911159][ C0] lock_acquire.part.0+0xd4/0x280 [ 21.911160][ C0] fs_reclaim_acquire+0xd5/0x120 [ 21.911162][ C0] __kmalloc_cache_noprof+0x6e/0x620 [ 21.911164][ C0] kthread_create_worker_on_node+0xea/0x210 [ 21.911165][ C0] workqueue_init+0x2a/0x680 [ 21.911166][ C0] kernel_init_freeable+0x2fe/0x630 [ 21.911167][ C0] kernel_init+0x21/0x150 [ 21.911169][ C0] ret_from_fork+0x474/0x6b0 [ 21.911170][ C0] ret_from_fork_asm+0x11/0x20 [ 21.911171][ C0] } [ 21.911171][ C0] ... key at: [] __fs_reclaim_map+0x0/0xbe0 [ 21.911175][ C0] ... acquired at: [ 21.911176][ C0] __lock_acquire+0x518/0xc20 [ 21.911177][ C0] lock_acquire.part.0+0xd4/0x280 [ 21.911179][ C0] fs_reclaim_acquire+0xd5/0x120 [ 21.911180][ C0] __kmalloc_noprof+0xd3/0x760 [ 21.911181][ C0] alloc_buf.isra.0+0x4b/0x260 [ 21.911184][ C0] put_chars+0x1e1/0x2f0 [ 21.911185][ C0] hvc_console_print+0x292/0x780 [ 21.911187][ C0] console_emit_next_record+0x22f/0x4c0 [ 21.911189][ C0] console_flush_one_record+0x46f/0x710 [ 21.911191][ C0] console_unlock+0xee/0x1f0 [ 21.911192][ C0] vprintk_emit+0x37c/0x3e0 [ 21.911194][ C0] _printk+0xc7/0x100 [ 21.911197][ C0] print_ipi_mode+0x2e/0x40 [ 21.911199][ C0] do_one_initcall+0x124/0x4f0 [ 21.911200][ C0] kernel_init_freeable+0x596/0x630 [ 21.911201][ C0] kernel_init+0x21/0x150 [ 21.911202][ C0] ret_from_fork+0x474/0x6b0 [ 21.911203][ C0] ret_from_fork_asm+0x11/0x20 [ 21.911205][ C0] [ 21.911205][ C0] -> (console_owner){..-.}-{0:0} { [ 21.911207][ C0] IN-SOFTIRQ-W at: [ 21.911208][ C0] __lock_acquire+0x388/0xc20 [ 21.911209][ C0] lock_acquire.part.0+0xd4/0x280 [ 21.911210][ C0] console_lock_spinning_enable+0x5c/0x60 [ 21.911212][ C0] console_emit_next_record+0x1d1/0x4c0 [ 21.911214][ C0] console_flush_one_record+0x46f/0x710 [ 21.911215][ C0] console_unlock+0xee/0x1f0 [ 21.911216][ C0] vprintk_emit+0x37c/0x3e0 [ 21.911218][ C0] _printk+0xc7/0x100 [ 21.911219][ C0] clocksource_watchdog.part.0.cold+0x105/0x1dd [ 21.911222][ C0] call_timer_fn+0x160/0x4d0 [ 21.911223][ C0] __run_timers+0x68f/0xaa0 [ 21.911225][ C0] run_timer_softirq+0xf0/0x160 [ 21.911226][ C0] handle_softirqs+0x1d3/0x900 [ 21.911229][ C0] __irq_exit_rcu+0x145/0x1c0 [ 21.911230][ C0] irq_exit_rcu+0xe/0x30 [ 21.911231][ C0] sysvec_apic_timer_interrupt+0x9d/0xe0 [ 21.911233][ C0] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 21.911235][ C0] pv_native_safe_halt+0xf/0x10 [ 21.911236][ C0] default_idle+0x9/0x10 [ 21.911238][ C0] default_idle_call+0x6e/0xb0 [ 21.911239][ C0] cpuidle_idle_call.constprop.0+0x237/0x410 [ 21.911241][ C0] do_idle+0xd8/0x190 [ 21.911243][ C0] cpu_startup_entry+0x53/0x70 [ 21.911244][ C0] rest_init+0x279/0x280 [ 21.911245][ C0] start_kernel+0x3af/0x3b0 [ 21.911246][ C0] x86_64_start_reservations+0x24/0x30 [ 21.911249][ C0] x86_64_start_kernel+0x12b/0x130 [ 21.911250][ C0] common_startup_64+0x13e/0x148 [ 21.911252][ C0] INITIAL USE at: [ 21.911253][ C0] } [ 21.911254][ C0] ... key at: [] console_owner_dep_map+0x0/0x60 [ 21.911257][ C0] ... acquired at: [ 21.911257][ C0] mark_lock+0x1d7/0xa00 [ 21.911258][ C0] mark_usage+0x42/0x170 [ 21.911260][ C0] __lock_acquire+0x388/0xc20 [ 21.911261][ C0] lock_acquire.part.0+0xd4/0x280 [ 21.911262][ C0] console_lock_spinning_enable+0x5c/0x60 [ 21.911264][ C0] console_emit_next_record+0x1d1/0x4c0 [ 21.911265][ C0] console_flush_one_record+0x46f/0x710 [ 21.911267][ C0] console_unlock+0xee/0x1f0 [ 21.911268][ C0] vprintk_emit+0x37c/0x3e0 [ 21.911270][ C0] _printk+0xc7/0x100 [ 21.911271][ C0] clocksource_watchdog.part.0.cold+0x105/0x1dd [ 21.911272][ C0] call_timer_fn+0x160/0x4d0 [ 21.911274][ C0] __run_timers+0x68f/0xaa0 [ 21.911275][ C0] run_timer_softirq+0xf0/0x160 [ 21.911276][ C0] handle_softirqs+0x1d3/0x900 [ 21.911278][ C0] __irq_exit_rcu+0x145/0x1c0 [ 21.911279][ C0] irq_exit_rcu+0xe/0x30 [ 21.911280][ C0] sysvec_apic_timer_interrupt+0x9d/0xe0 [ 21.911281][ C0] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 21.911282][ C0] pv_native_safe_halt+0xf/0x10 [ 21.911284][ C0] default_idle+0x9/0x10 [ 21.911285][ C0] default_idle_call+0x6e/0xb0 [ 21.911287][ C0] cpuidle_idle_call.constprop.0+0x237/0x410 [ 21.911288][ C0] do_idle+0xd8/0x190 [ 21.911289][ C0] cpu_startup_entry+0x53/0x70 [ 21.911290][ C0] rest_init+0x279/0x280 [ 21.911292][ C0] start_kernel+0x3af/0x3b0 [ 21.911292][ C0] x86_64_start_reservations+0x24/0x30 [ 21.911294][ C0] x86_64_start_kernel+0x12b/0x130 [ 21.911295][ C0] common_startup_64+0x13e/0x148 [ 21.911297][ C0] [ 21.911297][ C0] [ 21.911297][ C0] stack backtrace: [ 21.911300][ C0] CPU: 0 UID: 0 PID: 0 Comm: swapper/0 Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 21.911303][ C0] Tainted: [W]=WARN [ 21.911303][ C0] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 21.911305][ C0] Call Trace: [ 21.911306][ C0] [ 21.911308][ C0] dump_stack_lvl+0x6f/0xa0 [ 21.911312][ C0] print_irq_inversion_bug.part.0.cold+0xe6/0x143 [ 21.911314][ C0] mark_lock_irq+0x989/0x9c0 [ 21.911316][ C0] ? add_lock_to_list+0x2c/0x1a0 [ 21.911318][ C0] mark_lock+0x1d7/0xa00 [ 21.911320][ C0] mark_usage+0x42/0x170 [ 21.911322][ C0] __lock_acquire+0x388/0xc20 [ 21.911324][ C0] lock_acquire.part.0+0xd4/0x280 [ 21.911326][ C0] ? console_lock_spinning_enable+0x40/0x60 [ 21.911328][ C0] ? rcu_is_watching+0x16/0xd0 [ 21.911331][ C0] ? lock_acquire+0x13c/0x160 [ 21.911333][ C0] console_lock_spinning_enable+0x5c/0x60 [ 21.911335][ C0] ? console_lock_spinning_enable+0x40/0x60 [ 21.911336][ C0] console_emit_next_record+0x1d1/0x4c0 [ 21.911338][ C0] ? devkmsg_read+0x4b0/0x4b0 [ 21.911340][ C0] ? console_flush_one_record+0x106/0x710 [ 21.911342][ C0] ? rcu_is_watching+0x16/0xd0 [ 21.911344][ C0] ? lock_acquire+0x13c/0x160 [ 21.911346][ C0] console_flush_one_record+0x46f/0x710 [ 21.911348][ C0] ? console_emit_next_record+0x4c0/0x4c0 [ 21.911350][ C0] ? __lock_acquire+0x518/0xc20 [ 21.911352][ C0] console_unlock+0xee/0x1f0 [ 21.911354][ C0] ? console_flush_one_record+0x710/0x710 [ 21.911355][ C0] ? rcu_is_watching+0x16/0xd0 [ 21.911357][ C0] ? lock_acquire+0x60/0x160 [ 21.911359][ C0] ? __down_trylock_console_sem+0x5e/0xa0 [ 21.911361][ C0] ? vprintk_emit+0x320/0x3e0 [ 21.911363][ C0] vprintk_emit+0x37c/0x3e0 [ 21.911365][ C0] ? wake_up_klogd_work_func+0x90/0x90 [ 21.911367][ C0] ? clocksource_watchdog.part.0+0x450/0x540 [ 21.911369][ C0] _printk+0xc7/0x100 [ 21.911370][ C0] ? snapshot_read.cold+0x21/0x21 [ 21.911372][ C0] ? clocksource_watchdog.part.0+0x450/0x540 [ 21.911374][ C0] ? __lock_release.isra.0+0x69/0x1a0 [ 21.911376][ C0] clocksource_watchdog.part.0.cold+0x105/0x1dd [ 21.911378][ C0] ? clocksource_watchdog.part.0+0x540/0x540 [ 21.911379][ C0] ? clocksource_watchdog.part.0+0x540/0x540 [ 21.911381][ C0] call_timer_fn+0x160/0x4d0 [ 21.911383][ C0] ? detach_if_pending+0x1d0/0x1d0 [ 21.911385][ C0] ? debug_object_active_state+0x430/0x430 [ 21.911388][ C0] ? find_held_lock+0x2b/0x80 [ 21.911390][ C0] ? __lock_release.isra.0+0x69/0x1a0 [ 21.911391][ C0] ? rcu_is_watching+0x16/0xd0 [ 21.911394][ C0] __run_timers+0x68f/0xaa0 [ 21.911395][ C0] ? clocksource_watchdog.part.0+0x540/0x540 [ 21.911398][ C0] ? __bpf_trace_itimer_expire+0x10/0x10 [ 21.911399][ C0] ? __lock_acquire+0x518/0xc20 [ 21.911402][ C0] ? __rwlock_init+0x150/0x150 [ 21.911404][ C0] run_timer_softirq+0xf0/0x160 [ 21.911406][ C0] ? __run_timers+0xaa0/0xaa0 [ 21.911408][ C0] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 21.911410][ C0] ? rcu_is_watching+0x16/0xd0 [ 21.911412][ C0] handle_softirqs+0x1d3/0x900 [ 21.911414][ C0] ? __lock_release.isra.0+0x69/0x1a0 [ 21.911416][ C0] ? _local_bh_enable+0xc0/0xc0 [ 21.911418][ C0] __irq_exit_rcu+0x145/0x1c0 [ 21.911419][ C0] irq_exit_rcu+0xe/0x30 [ 21.911420][ C0] sysvec_apic_timer_interrupt+0x9d/0xe0 [ 21.911422][ C0] [ 21.911423][ C0] [ 21.911423][ C0] ? lockdep_hardirqs_on_prepare.part.0+0x9a/0x160 [ 21.911425][ C0] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 21.911427][ C0] RIP: 0010:pv_native_safe_halt+0xf/0x10 [ 21.911430][ 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 [ 21.911431][ C0] RSP: 0018:ffffffff94407cf8 EFLAGS: 00000296 [ 21.911434][ C0] RAX: 00000000000bf41f RBX: ffffffff9441c600 RCX: ffffffff914f0307 [ 21.911435][ C0] RDX: ffffffff9441c600 RSI: ffffffff94238b01 RDI: ffffffff93c8d8e0 [ 21.911436][ C0] RBP: 0000000000000000 R08: 0000000000000000 R09: 0000000000000000 [ 21.911437][ C0] R10: 0000000000000000 R11: 0000000000000001 R12: 1ffffffff2880fa2 [ 21.911438][ C0] R13: 0000000000000000 R14: dffffc0000000000 R15: 0000000000014770 [ 21.911439][ C0] ? cpuidle_idle_call.constprop.0+0x237/0x410 [ 21.911442][ C0] ? lockdep_hardirqs_on+0x91/0x130 [ 21.911443][ C0] default_idle+0x9/0x10 [ 21.911445][ C0] default_idle_call+0x6e/0xb0 [ 21.911446][ C0] cpuidle_idle_call.constprop.0+0x237/0x410 [ 21.911448][ C0] ? arch_cpu_idle_exit+0x40/0x40 [ 21.911449][ C0] ? mark_tsc_async_resets+0x30/0x30 [ 21.911452][ C0] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 21.911453][ C0] ? rcu_is_watching+0x16/0xd0 [ 21.911455][ C0] do_idle+0xd8/0x190 [ 21.911457][ C0] cpu_startup_entry+0x53/0x70 [ 21.911463][ C0] rest_init+0x279/0x280 [ 21.911465][ C0] ? __cpuidle_text_end+0x3b/0x3b [ 21.911468][ C0] ? rest_init+0x280/0x280 [ 21.911470][ C0] ? acpi_hw_set_mode+0x4a0/0x4a0 [ 21.911473][ C0] ? cpus_read_unlock+0x4f/0xc0 [ 21.911476][ C0] ? acpi_enable+0x1e4/0x330 [ 21.911478][ C0] start_kernel+0x3af/0x3b0 [ 21.911480][ C0] x86_64_start_reservations+0x24/0x30 [ 21.911482][ C0] x86_64_start_kernel+0x12b/0x130 [ 21.911484][ C0] common_startup_64+0x13e/0x148 [ 21.911487][ C0] [ 21.911491][ C0] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 21.911492][ C0] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 0, name: swapper/0 [ 21.911494][ C0] preempt_count: 103, expected: 0 [ 21.911494][ C0] RCU nest depth: 0, expected: 0 [ 21.911495][ C0] INFO: lockdep is turned off. [ 21.911496][ C0] irq event stamp: 783409 [ 21.911496][ C0] hardirqs last enabled at (783408): [] __down_trylock_console_sem+0x86/0xa0 [ 21.911498][ C0] hardirqs last disabled at (783409): [] console_emit_next_record+0x3d4/0x4c0 [ 21.911500][ C0] softirqs last enabled at (783384): [] handle_softirqs+0x67c/0x900 [ 21.911502][ C0] softirqs last disabled at (783393): [] __irq_exit_rcu+0x145/0x1c0 [ 21.911503][ C0] Preemption disabled at: [ 21.911504][ C0] [] schedule_preempt_disabled+0x22/0x30 [ 21.911507][ C0] CPU: 0 UID: 0 PID: 0 Comm: swapper/0 Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 21.911509][ C0] Tainted: [W]=WARN [ 21.911509][ C0] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 21.911510][ C0] Call Trace: [ 21.911510][ C0] [ 21.911511][ C0] dump_stack_lvl+0x6f/0xa0 [ 21.911513][ C0] ? schedule_preempt_disabled+0x22/0x30 [ 21.911514][ C0] __might_resched.cold+0x1fe/0x2c1 [ 21.911517][ C0] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 21.911520][ C0] ? rcu_is_watching+0x16/0xd0 [ 21.911523][ C0] __kmalloc_noprof+0x443/0x760 [ 21.911524][ C0] ? __rwlock_init+0x150/0x150 [ 21.911526][ C0] ? alloc_buf.isra.0+0x4b/0x260 [ 21.911528][ C0] ? do_raw_spin_unlock+0x59/0x250 [ 21.911529][ C0] alloc_buf.isra.0+0x4b/0x260 [ 21.911531][ C0] put_chars+0x1e1/0x2f0 [ 21.911533][ C0] ? __send_to_port+0x420/0x420 [ 21.911535][ C0] ? mark_lock+0x1d7/0xa00 [ 21.911537][ C0] hvc_console_print+0x292/0x780 [ 21.911540][ C0] ? hvc_write+0x3a0/0x3a0 [ 21.911541][ C0] ? rcu_is_watching+0x16/0xd0 [ 21.911543][ C0] ? rcu_is_watching+0x16/0xd0 [ 21.911545][ C0] console_emit_next_record+0x22f/0x4c0 [ 21.911547][ C0] ? devkmsg_read+0x4b0/0x4b0 [ 21.911549][ C0] ? console_flush_one_record+0x106/0x710 [ 21.911551][ C0] ? rcu_is_watching+0x16/0xd0 [ 21.911553][ C0] ? lock_acquire+0x13c/0x160 [ 21.911555][ C0] console_flush_one_record+0x46f/0x710 [ 21.911557][ C0] ? console_emit_next_record+0x4c0/0x4c0 [ 21.911559][ C0] ? __lock_acquire+0x518/0xc20 [ 21.911561][ C0] console_unlock+0xee/0x1f0 [ 21.911563][ C0] ? console_flush_one_record+0x710/0x710 [ 21.911565][ C0] ? rcu_is_watching+0x16/0xd0 [ 21.911566][ C0] ? lock_acquire+0x60/0x160 [ 21.911568][ C0] ? __down_trylock_console_sem+0x5e/0xa0 [ 21.911570][ C0] ? vprintk_emit+0x320/0x3e0 [ 21.911572][ C0] vprintk_emit+0x37c/0x3e0 [ 21.911574][ C0] ? wake_up_klogd_work_func+0x90/0x90 [ 21.911576][ C0] ? clocksource_watchdog.part.0+0x450/0x540 [ 21.911578][ C0] _printk+0xc7/0x100 [ 21.911580][ C0] ? snapshot_read.cold+0x21/0x21 [ 21.911582][ C0] ? clocksource_watchdog.part.0+0x450/0x540 [ 21.911583][ C0] ? __lock_release.isra.0+0x69/0x1a0 [ 21.911586][ C0] clocksource_watchdog.part.0.cold+0x105/0x1dd [ 21.911587][ C0] ? clocksource_watchdog.part.0+0x540/0x540 [ 21.911589][ C0] ? clocksource_watchdog.part.0+0x540/0x540 [ 21.911590][ C0] call_timer_fn+0x160/0x4d0 [ 21.911592][ C0] ? detach_if_pending+0x1d0/0x1d0 [ 21.911594][ C0] ? debug_object_active_state+0x430/0x430 [ 21.911596][ C0] ? find_held_lock+0x2b/0x80 [ 21.911597][ C0] ? __lock_release.isra.0+0x69/0x1a0 [ 21.911599][ C0] ? rcu_is_watching+0x16/0xd0 [ 21.911601][ C0] __run_timers+0x68f/0xaa0 [ 21.911603][ C0] ? clocksource_watchdog.part.0+0x540/0x540 [ 21.911605][ C0] ? __bpf_trace_itimer_expire+0x10/0x10 [ 21.911607][ C0] ? __lock_acquire+0x518/0xc20 [ 21.911609][ C0] ? __rwlock_init+0x150/0x150 [ 21.911612][ C0] run_timer_softirq+0xf0/0x160 [ 21.911614][ C0] ? __run_timers+0xaa0/0xaa0 [ 21.911615][ C0] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 21.911617][ C0] ? rcu_is_watching+0x16/0xd0 [ 21.911618][ C0] handle_softirqs+0x1d3/0x900 [ 21.911620][ C0] ? __lock_release.isra.0+0x69/0x1a0 [ 21.911622][ C0] ? _local_bh_enable+0xc0/0xc0 [ 21.911624][ C0] __irq_exit_rcu+0x145/0x1c0 [ 21.911625][ C0] irq_exit_rcu+0xe/0x30 [ 21.911627][ C0] sysvec_apic_timer_interrupt+0x9d/0xe0 [ 21.911628][ C0] [ 21.911629][ C0] [ 21.911629][ C0] ? lockdep_hardirqs_on_prepare.part.0+0x9a/0x160 [ 21.911631][ C0] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 21.911632][ C0] RIP: 0010:pv_native_safe_halt+0xf/0x10 [ 21.911634][ 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 [ 21.911635][ C0] RSP: 0018:ffffffff94407cf8 EFLAGS: 00000296 [ 21.911636][ C0] RAX: 00000000000bf41f RBX: ffffffff9441c600 RCX: ffffffff914f0307 [ 21.911637][ C0] RDX: ffffffff9441c600 RSI: ffffffff94238b01 RDI: ffffffff93c8d8e0 [ 21.911638][ C0] RBP: 0000000000000000 R08: 0000000000000000 R09: 0000000000000000 [ 21.911639][ C0] R10: 0000000000000000 R11: 0000000000000001 R12: 1ffffffff2880fa2 [ 21.911639][ C0] R13: 0000000000000000 R14: dffffc0000000000 R15: 0000000000014770 [ 21.911641][ C0] ? cpuidle_idle_call.constprop.0+0x237/0x410 [ 21.911643][ C0] ? lockdep_hardirqs_on+0x91/0x130 [ 21.911645][ C0] default_idle+0x9/0x10 [ 21.911646][ C0] default_idle_call+0x6e/0xb0 [ 21.911648][ C0] cpuidle_idle_call.constprop.0+0x237/0x410 [ 21.911650][ C0] ? arch_cpu_idle_exit+0x40/0x40 [ 21.911651][ C0] ? mark_tsc_async_resets+0x30/0x30 [ 21.911653][ C0] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 21.911654][ C0] ? rcu_is_watching+0x16/0xd0 [ 21.911656][ C0] do_idle+0xd8/0x190 [ 21.911657][ C0] cpu_startup_entry+0x53/0x70 [ 21.911659][ C0] rest_init+0x279/0x280 [ 21.911661][ C0] ? __cpuidle_text_end+0x3b/0x3b [ 21.911663][ C0] ? rest_init+0x280/0x280 [ 21.911665][ C0] ? acpi_hw_set_mode+0x4a0/0x4a0 [ 21.911667][ C0] ? cpus_read_unlock+0x4f/0xc0 [ 21.911669][ C0] ? acpi_enable+0x1e4/0x330 [ 21.911671][ C0] start_kernel+0x3af/0x3b0 [ 21.911673][ C0] x86_64_start_reservations+0x24/0x30 [ 21.911674][ C0] x86_64_start_kernel+0x12b/0x130 [ 21.911676][ C0] common_startup_64+0x13e/0x148 [ 21.911679][ C0] [ 37.922177][ T565] br11: port 2(veth2.11) entered disabled state [ 37.922195][ T565] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 37.922197][ T565] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 565, name: ip [ 37.922199][ T565] preempt_count: 202, expected: 0 [ 37.922200][ T565] RCU nest depth: 0, expected: 0 [ 37.922201][ T565] INFO: lockdep is turned off. [ 37.922202][ T565] irq event stamp: 0 [ 37.922203][ T565] hardirqs last enabled at (0): [<0000000000000000>] 0x0 [ 37.922208][ T565] hardirqs last disabled at (0): [] copy_process+0x1ccd/0x6240 [ 37.922214][ T565] softirqs last enabled at (0): [] copy_process+0x1d21/0x6240 [ 37.922215][ T565] softirqs last disabled at (0): [<0000000000000000>] 0x0 [ 37.922217][ T565] Preemption disabled at: [ 37.922218][ T565] [<0000000000000000>] 0x0 [ 37.922223][ T565] CPU: 2 UID: 0 PID: 565 Comm: ip Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 37.922226][ T565] Tainted: [W]=WARN [ 37.922227][ T565] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 37.922229][ T565] Call Trace: [ 37.922230][ T565] [ 37.922231][ T565] dump_stack_lvl+0x6f/0xa0 [ 37.922237][ T565] __might_resched.cold+0x1fe/0x2c1 [ 37.922241][ T565] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 37.922244][ T565] ? rcu_is_watching+0x16/0xd0 [ 37.922248][ T565] __kmalloc_noprof+0x443/0x760 [ 37.922252][ T565] ? __rwlock_init+0x150/0x150 [ 37.922254][ T565] ? alloc_buf.isra.0+0x4b/0x260 [ 37.922258][ T565] ? do_raw_spin_unlock+0x59/0x250 [ 37.922260][ T565] alloc_buf.isra.0+0x4b/0x260 [ 37.922262][ T565] put_chars+0x1e1/0x2f0 [ 37.922263][ T565] ? desc_read_finalized_seq+0x79/0x120 [ 37.922265][ T565] ? __send_to_port+0x420/0x420 [ 37.922267][ T565] ? console_prepend_replay+0x20/0x20 [ 37.922270][ T565] hvc_console_print+0x292/0x780 [ 37.922273][ T565] ? hvc_write+0x3a0/0x3a0 [ 37.922274][ T565] ? do_raw_spin_lock+0x131/0x280 [ 37.922276][ T565] ? __rwlock_init+0x150/0x150 [ 37.922278][ T565] ? rcu_is_watching+0x16/0xd0 [ 37.922279][ T565] ? rcu_is_watching+0x16/0xd0 [ 37.922281][ T565] ? lock_acquire+0x13c/0x160 [ 37.922283][ T565] console_emit_next_record+0x22f/0x4c0 [ 37.922286][ T565] ? devkmsg_read+0x4b0/0x4b0 [ 37.922288][ T565] ? rcu_is_watching+0x16/0xd0 [ 37.922289][ T565] ? rcu_is_watching+0x16/0xd0 [ 37.922291][ T565] ? rcu_is_watching+0x16/0xd0 [ 37.922292][ T565] ? lock_acquire+0x13c/0x160 [ 37.922294][ T565] ? console_flush_one_record+0x111/0x710 [ 37.922296][ T565] console_flush_one_record+0x46f/0x710 [ 37.922298][ T565] ? console_emit_next_record+0x4c0/0x4c0 [ 37.922301][ T565] console_unlock+0xee/0x1f0 [ 37.922303][ T565] ? lock_acquire+0x13c/0x160 [ 37.922304][ T565] ? console_flush_one_record+0x710/0x710 [ 37.922306][ T565] ? rcu_is_watching+0x16/0xd0 [ 37.922307][ T565] ? lock_release+0x184/0x1f0 [ 37.922309][ T565] ? lock_acquire+0x60/0x160 [ 37.922310][ T565] ? __rcu_read_lock+0x30/0x70 [ 37.922312][ T565] ? __down_trylock_console_sem+0x5e/0xa0 [ 37.922314][ T565] ? vprintk_emit+0x320/0x3e0 [ 37.922316][ T565] vprintk_emit+0x37c/0x3e0 [ 37.922321][ T565] ? wake_up_klogd_work_func+0x90/0x90 [ 37.922322][ T565] ? debug_object_assert_init+0x1d9/0x360 [ 37.922326][ T565] ? debug_object_activate+0x4a0/0x4a0 [ 37.922329][ T565] _printk+0xc7/0x100 [ 37.922332][ T565] ? snapshot_read.cold+0x21/0x21 [ 37.922334][ T565] ? __rwlock_init+0x150/0x150 [ 37.922336][ T565] ? rcu_is_watching+0x16/0xd0 [ 37.922337][ T565] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 37.922341][ T565] br_set_state+0x22f/0x430 [bridge] [ 37.922354][ T565] br_stp_disable_port+0x11f/0x390 [bridge] [ 37.922362][ T565] br_stp_disable_bridge+0xb9/0x180 [bridge] [ 37.922368][ T565] br_dev_stop+0x28/0x1a0 [bridge] [ 37.922377][ T565] ? rtnl_is_locked+0x15/0x20 [ 37.922381][ T565] __dev_close_many+0x1c8/0x530 [ 37.922384][ T565] ? netif_open+0x120/0x120 [ 37.922385][ T565] ? rcu_is_watching+0x16/0xd0 [ 37.922387][ T565] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 37.922389][ T565] __dev_change_flags+0x288/0x660 [ 37.922391][ T565] ? netif_set_allmulti+0x250/0x250 [ 37.922393][ T565] ? __kernel_text_address+0x12/0x30 [ 37.922396][ T565] ? write_profile+0xf0/0xf0 [ 37.922398][ T565] ? unwind_get_return_address+0x67/0xd0 [ 37.922401][ T565] netif_change_flags+0x87/0x190 [ 37.922403][ T565] do_setlink.isra.0+0x1cc3/0x2750 [ 37.922405][ T565] ? stack_trace_save+0x93/0xc0 [ 37.922406][ T565] ? rtnl_link_get_size+0x350/0x350 [ 37.922408][ T565] ? rcu_is_watching+0x16/0xd0 [ 37.922409][ T565] ? stack_depot_save_flags+0x1bc/0x790 [ 37.922413][ T565] ? kasan_save_stack+0x3d/0x50 [ 37.922416][ T565] ? kasan_save_stack+0x2f/0x50 [ 37.922417][ T565] ? kasan_save_track+0x14/0x30 [ 37.922419][ T565] ? __kasan_kmalloc+0x7b/0x90 [ 37.922420][ T565] ? __kmalloc_cache_noprof+0x29a/0x620 [ 37.922422][ T565] ? rtnl_newlink+0x124/0x11c0 [ 37.922423][ T565] ? rtnetlink_rcv_msg+0x6fd/0xbd0 [ 37.922424][ T565] ? netlink_rcv_skb+0x14e/0x3a0 [ 37.922427][ T565] ? netlink_unicast+0x486/0x750 [ 37.922428][ T565] ? netlink_sendmsg+0x735/0xc60 [ 37.922429][ T565] ? ____sys_sendmsg+0x415/0x880 [ 37.922432][ T565] ? ___sys_sendmsg+0x14e/0x1d0 [ 37.922434][ T565] ? __sys_sendmsg+0x12c/0x1d0 [ 37.922435][ T565] ? do_syscall_64+0xff/0x530 [ 37.922438][ T565] ? entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 37.922440][ T565] ? rcu_is_watching+0x16/0xd0 [ 37.922442][ T565] ? lock_acquire+0x13c/0x160 [ 37.922444][ T565] ? rcu_is_watching+0x16/0xd0 [ 37.922445][ T565] ? rcu_is_watching+0x16/0xd0 [ 37.922447][ T565] ? trace_contention_end+0xb3/0x180 [ 37.922450][ T565] ? __mutex_lock+0x1db/0x1ea0 [ 37.922452][ T565] ? __mutex_lock+0x9a3/0x1ea0 [ 37.922454][ T565] ? rtnl_newlink+0x9a8/0x11c0 [ 37.922455][ T565] ? ww_mutex_lock+0x160/0x160 [ 37.922457][ T565] ? __rtnl_newlink+0x3fa/0xa50 [ 37.922459][ T565] rtnl_newlink+0x9f1/0x11c0 [ 37.922461][ T565] ? rcu_is_watching+0x16/0xd0 [ 37.922463][ T565] ? rtnl_bridge_getlink+0x850/0x850 [ 37.922464][ T565] ? lock_acquire+0x13c/0x160 [ 37.922466][ T565] ? rcu_is_watching+0x16/0xd0 [ 37.922468][ T565] ? is_bpf_text_address+0x3e/0x110 [ 37.922471][ T565] ? is_bpf_text_address+0x72/0x110 [ 37.922473][ T565] ? kernel_text_address+0x149/0x170 [ 37.922474][ T565] ? __kernel_text_address+0x12/0x30 [ 37.922475][ T565] ? write_profile+0xf0/0xf0 [ 37.922476][ T565] ? unwind_get_return_address+0x67/0xd0 [ 37.922478][ T565] ? rcu_is_watching+0x16/0xd0 [ 37.922479][ T565] ? rcu_is_watching+0x16/0xd0 [ 37.922481][ T565] ? cap_capable+0x1d7/0x3d0 [ 37.922484][ T565] ? lock_acquire+0x13c/0x160 [ 37.922486][ T565] ? rcu_is_watching+0x16/0xd0 [ 37.922488][ T565] ? rtnl_bridge_getlink+0x850/0x850 [ 37.922489][ T565] rtnetlink_rcv_msg+0x6fd/0xbd0 [ 37.922490][ T565] ? rtnl_link_fill+0x920/0x920 [ 37.922492][ T565] ? filter_irq_stacks+0xd0/0xd0 [ 37.922493][ T565] ? stack_depot_save_flags+0x1bc/0x790 [ 37.922495][ T565] netlink_rcv_skb+0x14e/0x3a0 [ 37.922497][ T565] ? rtnl_link_fill+0x920/0x920 [ 37.922498][ T565] ? lock_release+0x184/0x1f0 [ 37.922500][ T565] ? netlink_ack+0xcf0/0xcf0 [ 37.922501][ T565] ? __netlink_lookup+0xb9/0x6b0 [ 37.922504][ T565] ? rcu_is_watching+0x16/0xd0 [ 37.922505][ T565] ? lock_release+0x184/0x1f0 [ 37.922507][ T565] netlink_unicast+0x486/0x750 [ 37.922509][ T565] ? netlink_attachskb+0x810/0x810 [ 37.922511][ T565] ? rcu_is_watching+0x16/0xd0 [ 37.922512][ T565] ? rcu_is_watching+0x16/0xd0 [ 37.922514][ T565] ? lock_acquire+0x13c/0x160 [ 37.922516][ T565] netlink_sendmsg+0x735/0xc60 [ 37.922518][ T565] ? netlink_unicast+0x750/0x750 [ 37.922520][ T565] ? rcu_is_watching+0x16/0xd0 [ 37.922521][ T565] ? lock_release+0x184/0x1f0 [ 37.922523][ T565] ____sys_sendmsg+0x415/0x880 [ 37.922525][ T565] ? copy_msghdr_from_user+0x279/0x420 [ 37.922532][ T565] ? get_timestamp.constprop.0+0x390/0x390 [ 37.922533][ T565] ? move_addr_to_kernel+0x40/0x40 [ 37.922535][ T565] ? filter_irq_stacks+0xd0/0xd0 [ 37.922537][ T565] ___sys_sendmsg+0x14e/0x1d0 [ 37.922539][ T565] ? copy_msghdr_from_user+0x420/0x420 [ 37.922544][ T565] __sys_sendmsg+0x12c/0x1d0 [ 37.922546][ T565] ? __sys_sendmsg_sock+0x20/0x20 [ 37.922549][ T565] ? rcu_is_watching+0x16/0xd0 [ 37.922551][ T565] do_syscall_64+0xff/0x530 [ 37.922552][ T565] ? exc_page_fault+0xee/0x100 [ 37.922554][ T565] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 37.922556][ T565] RIP: 0033:0x7f76589b254e [ 37.922558][ T565] 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 [ 37.922560][ T565] RSP: 002b:00007ffd033d4790 EFLAGS: 00000202 ORIG_RAX: 000000000000002e [ 37.922563][ T565] RAX: ffffffffffffffda RBX: 0000000000000003 RCX: 00007f76589b254e [ 37.922565][ T565] RDX: 0000000000000000 RSI: 00007ffd033d4840 RDI: 0000000000000005 [ 37.922566][ T565] RBP: 00007ffd033d47a0 R08: 0000000000000000 R09: 0000000000000000 [ 37.922566][ T565] R10: 0000000000000000 R11: 0000000000000202 R12: 000000006a912cb7 [ 37.922567][ T565] R13: 00000000004a1620 R14: 0000000000000000 R15: 00007ffd033d4f00 [ 37.922570][ T565] [ 37.957668][ T565] br11: port 1(veth1.11) entered disabled state [ 37.963959][ T565] ip (565) used greatest stack depth: 23144 bytes left [ 37.992451][ T567] br10: port 2(veth2.10) entered disabled state [ 37.992977][ T567] br10: port 1(veth1.10) entered disabled state [ 38.041072][ T571] veth2.11: left allmulticast mode [ 38.041293][ T571] veth2.11: left promiscuous mode [ 38.041661][ T571] br11: port 2(veth2.11) entered disabled state [ 38.142495][ T577] veth2.10: left allmulticast mode [ 38.142757][ T577] veth2: left allmulticast mode [ 38.142976][ T577] veth2.10: left promiscuous mode [ 38.143179][ T577] veth2: left promiscuous mode [ 38.143632][ T577] br10: port 2(veth2.10) entered disabled state [ 38.301417][ T589] veth1.11: left allmulticast mode [ 38.301656][ T589] veth1.11: left promiscuous mode [ 38.302739][ T589] br11: port 1(veth1.11) entered disabled state [ 38.398661][ T595] veth1.10: left allmulticast mode [ 38.399077][ T595] veth1: left allmulticast mode [ 38.399280][ T595] veth1.10: left promiscuous mode [ 38.399514][ T595] veth1: left promiscuous mode [ 38.399922][ T595] br10: port 1(veth1.10) entered disabled state