[ 9.829420][ T186] ip (186) used greatest stack depth: 24352 bytes left [ 9.829435][ T186] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 9.829437][ T186] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 186, name: ip [ 9.829438][ T186] preempt_count: 2, expected: 0 [ 9.829439][ T186] RCU nest depth: 0, expected: 0 [ 9.829440][ T186] locks held by ip/186: 5, last CPU#3: [ 9.829442][ T186] #0: ffffffff8fc027b8 (low_water_lock){+.+.}-{3:3}, at: do_exit+0x887/0xdc0 [ 9.829455][ T186] #1: ffffffff8fd69cc0 (console_lock){+.+.}-{0:0}, at: vprintk_emit+0x320/0x3e0 [ 9.829460][ T186] #2: ffffffff8fd69d38 (console_srcu){....}-{0:0}, at: console_flush_one_record+0x106/0x710 [ 9.829464][ T186] #3: ffffffff8fc89660 (console_owner){....}-{0:0}, at: console_lock_spinning_enable+0x40/0x60 [ 9.829468][ T186] #4: ffffffff8fc89560 (printk_legacy_map-wait-type-override){....}-{3:3}, at: console_emit_next_record+0x1df/0x4c0 [ 9.829472][ T186] irq event stamp: 46508 [ 9.829473][ T186] hardirqs last enabled at (46507): [] __down_trylock_console_sem+0x86/0xa0 [ 9.829475][ T186] hardirqs last disabled at (46508): [] console_emit_next_record+0x3d4/0x4c0 [ 9.829477][ T186] softirqs last enabled at (45226): [] netlink_release+0x17b/0xcf0 [ 9.829481][ T186] softirqs last disabled at (45224): [] netlink_release+0xd2/0xcf0 [ 9.829483][ T186] Preemption disabled at: [ 9.829484][ T186] [<0000000000000000>] 0x0 [ 9.829490][ T186] CPU: 3 UID: 0 PID: 186 Comm: ip Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 9.829494][ T186] Tainted: [W]=WARN [ 9.829494][ T186] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 9.829496][ T186] Call Trace: [ 9.829498][ T186] [ 9.829499][ T186] dump_stack_lvl+0x6f/0xa0 [ 9.829506][ T186] __might_resched.cold+0x1fe/0x2c1 [ 9.829510][ T186] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 9.829514][ T186] ? __kmalloc_noprof+0xdb/0x760 [ 9.829520][ T186] __kmalloc_noprof+0x443/0x760 [ 9.829522][ T186] ? alloc_buf.isra.0+0x4b/0x260 [ 9.829527][ T186] ? do_raw_spin_unlock+0x59/0x250 [ 9.829530][ T186] alloc_buf.isra.0+0x4b/0x260 [ 9.829533][ T186] put_chars+0x1e1/0x2f0 [ 9.829536][ T186] ? __send_to_port+0x420/0x420 [ 9.829537][ T186] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 9.829542][ T186] ? validate_chain+0x38b/0xc20 [ 9.829547][ T186] hvc_console_print+0x292/0x780 [ 9.829553][ T186] ? hvc_write+0x3a0/0x3a0 [ 9.829555][ T186] ? rcu_is_watching+0x16/0xd0 [ 9.829557][ T186] ? lock_acquire+0x13c/0x160 [ 9.829561][ T186] console_emit_next_record+0x22f/0x4c0 [ 9.829565][ T186] ? devkmsg_read+0x4b0/0x4b0 [ 9.829567][ T186] ? console_flush_one_record+0x106/0x710 [ 9.829570][ T186] ? rcu_is_watching+0x16/0xd0 [ 9.829572][ T186] ? lock_acquire+0x13c/0x160 [ 9.829576][ T186] console_flush_one_record+0x46f/0x710 [ 9.829580][ T186] ? console_emit_next_record+0x4c0/0x4c0 [ 9.829582][ T186] ? __lock_acquire+0x518/0xc20 [ 9.829587][ T186] console_unlock+0xee/0x1f0 [ 9.829590][ T186] ? console_flush_one_record+0x710/0x710 [ 9.829591][ T186] ? rcu_is_watching+0x16/0xd0 [ 9.829594][ T186] ? lock_acquire+0x60/0x160 [ 9.829597][ T186] ? __down_trylock_console_sem+0x5e/0xa0 [ 9.829599][ T186] ? vprintk_emit+0x320/0x3e0 [ 9.829602][ T186] vprintk_emit+0x37c/0x3e0 [ 9.829606][ T186] ? wake_up_klogd_work_func+0x90/0x90 [ 9.829609][ T186] ? __lock_acquire+0x518/0xc20 [ 9.829613][ T186] _printk+0xc7/0x100 [ 9.829617][ T186] ? snapshot_read.cold+0x21/0x21 [ 9.829619][ T186] ? do_raw_spin_lock+0x131/0x280 [ 9.829622][ T186] ? __rwlock_init+0x150/0x150 [ 9.829626][ T186] ? do_raw_spin_lock+0x131/0x280 [ 9.829628][ T186] do_exit.cold+0x82/0x9c [ 9.829632][ T186] ? exit_notify+0x890/0x890 [ 9.829634][ T186] ? __lock_release.isra.0+0x69/0x1a0 [ 9.829636][ T186] ? rcu_is_watching+0x16/0xd0 [ 9.829640][ T186] do_group_exit+0xb8/0x370 [ 9.829643][ T186] __x64_sys_exit_group+0x3c/0x50 [ 9.829645][ T186] x64_sys_call+0x1567/0x1570 [ 9.829647][ T186] do_syscall_64+0xff/0x530 [ 9.829650][ T186] ? exc_page_fault+0xee/0x100 [ 9.829653][ T186] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 9.829655][ T186] RIP: 0033:0x7f07ebfa21b8 [ 9.829657][ T186] Code: Unable to access opcode bytes at 0x7f07ebfa218e. [ 9.829659][ T186] RSP: 002b:00007ffcd0207348 EFLAGS: 00000246 ORIG_RAX: 00000000000000e7 [ 9.829661][ T186] RAX: ffffffffffffffda RBX: 00007f07ec0d2f88 RCX: 00007f07ebfa21b8 [ 9.829662][ T186] RDX: 00007f07ebcecfc8 RSI: fffffffffffffeb8 RDI: 0000000000000000 [ 9.829663][ T186] RBP: 00007ffcd02073a0 R08: 0000000000000000 R09: 0000000000008010 [ 9.829664][ T186] R10: 00007ffcd0207160 R11: 0000000000000246 R12: 0000000000000001 [ 9.829665][ T186] R13: 0000000000000000 R14: 00007f07ec0d1680 R15: 00007f07ec0d2fa0 [ 9.829671][ T186] [ 10.624306][ T222] ip (222) used greatest stack depth: 23952 bytes left [ 11.217248][ T242] br1: port 1(veth1) entered blocking state [ 11.217411][ T242] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 11.217414][ T242] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 242, name: ip [ 11.217416][ T242] preempt_count: 1, expected: 0 [ 11.217417][ T242] RCU nest depth: 0, expected: 0 [ 11.217419][ T242] locks held by ip/242: 5, last CPU#2: [ 11.217422][ T242] #0: ffffffff904d2c40 (rtnl_mutex){+.+.}-{4:4}, at: rtnl_newlink+0x9a8/0x11c0 [ 11.217436][ T242] #1: ffffffff8fd69cc0 (console_lock){+.+.}-{0:0}, at: vprintk_emit+0x320/0x3e0 [ 11.217444][ T242] #2: ffffffff8fd69d38 (console_srcu){....}-{0:0}, at: console_flush_one_record+0x106/0x710 [ 11.217450][ T242] #3: ffffffff8fc89660 (console_owner){....}-{0:0}, at: console_lock_spinning_enable+0x40/0x60 [ 11.217456][ T242] #4: ffffffff8fc89560 (printk_legacy_map-wait-type-override){....}-{3:3}, at: console_emit_next_record+0x1df/0x4c0 [ 11.217462][ T242] irq event stamp: 14512 [ 11.217463][ T242] hardirqs last enabled at (14511): [] __down_trylock_console_sem+0x86/0xa0 [ 11.217466][ T242] hardirqs last disabled at (14512): [] console_emit_next_record+0x3d4/0x4c0 [ 11.217469][ T242] softirqs last enabled at (14424): [] __alloc_skb+0x4c2/0x5f0 [ 11.217473][ T242] softirqs last disabled at (14422): [] __alloc_skb+0x4c2/0x5f0 [ 11.217476][ T242] Preemption disabled at: [ 11.217477][ T242] [] vprintk_emit+0x31b/0x3e0 [ 11.217485][ T242] CPU: 2 UID: 0 PID: 242 Comm: ip Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 11.217489][ T242] Tainted: [W]=WARN [ 11.217490][ T242] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 11.217492][ T242] Call Trace: [ 11.217494][ T242] [ 11.217496][ T242] dump_stack_lvl+0x6f/0xa0 [ 11.217504][ T242] ? vprintk_emit+0x31b/0x3e0 [ 11.217507][ T242] __might_resched.cold+0x1fe/0x2c1 [ 11.217513][ T242] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 11.217518][ T242] ? __kmalloc_noprof+0xdb/0x760 [ 11.217526][ T242] __kmalloc_noprof+0x443/0x760 [ 11.217529][ T242] ? alloc_buf.isra.0+0x4b/0x260 [ 11.217538][ T242] ? do_raw_spin_unlock+0x59/0x250 [ 11.217541][ T242] alloc_buf.isra.0+0x4b/0x260 [ 11.217546][ T242] put_chars+0x1e1/0x2f0 [ 11.217550][ T242] ? __send_to_port+0x420/0x420 [ 11.217557][ T242] ? validate_chain+0x34a/0xc20 [ 11.217563][ T242] hvc_console_print+0x292/0x780 [ 11.217567][ T242] ? mark_usage+0x61/0x170 [ 11.217570][ T242] ? __lock_acquire+0x518/0xc20 [ 11.217572][ T242] ? __lock_acquire+0x518/0xc20 [ 11.217579][ T242] ? hvc_write+0x3a0/0x3a0 [ 11.217582][ T242] ? console_emit_next_record+0x1df/0x4c0 [ 11.217587][ T242] ? rcu_is_watching+0x16/0xd0 [ 11.217592][ T242] ? lock_acquire+0x13c/0x160 [ 11.217598][ T242] console_emit_next_record+0x22f/0x4c0 [ 11.217604][ T242] ? devkmsg_read+0x4b0/0x4b0 [ 11.217606][ T242] ? console_flush_one_record+0x106/0x710 [ 11.217611][ T242] ? rcu_is_watching+0x16/0xd0 [ 11.217615][ T242] ? lock_acquire+0x13c/0x160 [ 11.217621][ T242] console_flush_one_record+0x46f/0x710 [ 11.217628][ T242] ? console_emit_next_record+0x4c0/0x4c0 [ 11.217630][ T242] ? __lock_acquire+0x518/0xc20 [ 11.217639][ T242] console_unlock+0xee/0x1f0 [ 11.217643][ T242] ? console_flush_one_record+0x710/0x710 [ 11.217646][ T242] ? rcu_is_watching+0x16/0xd0 [ 11.217649][ T242] ? lock_acquire+0x60/0x160 [ 11.217655][ T242] ? __down_trylock_console_sem+0x5e/0xa0 [ 11.217658][ T242] ? vprintk_emit+0x320/0x3e0 [ 11.217663][ T242] vprintk_emit+0x37c/0x3e0 [ 11.217669][ T242] ? wake_up_klogd_work_func+0x90/0x90 [ 11.217672][ T242] ? __lock_release.isra.0+0x69/0x1a0 [ 11.217675][ T242] ? _raw_spin_unlock_irqrestore+0x40/0x80 [ 11.217680][ T242] ? mark_held_locks+0x40/0x70 [ 11.217686][ T242] _printk+0xc7/0x100 [ 11.217691][ T242] ? snapshot_read.cold+0x21/0x21 [ 11.217697][ T242] ? br_multicast_flood+0xab0/0xab0 [bridge] [ 11.217715][ T242] ? do_setlink.isra.0+0xa31/0x2750 [ 11.217717][ T242] ? rtnl_newlink+0x9f1/0x11c0 [ 11.217719][ T242] ? rtnetlink_rcv_msg+0x6fd/0xbd0 [ 11.217727][ T242] br_set_state+0x22f/0x430 [bridge] [ 11.217744][ T242] br_init_port+0xc4/0x200 [bridge] [ 11.217758][ T242] new_nbp+0x39c/0x580 [bridge] [ 11.217774][ T242] br_add_if+0x212/0x1320 [bridge] [ 11.217786][ T242] ? is_bpf_text_address+0x72/0x110 [ 11.217791][ T242] ? kernel_text_address+0x149/0x170 [ 11.217795][ T242] ? __kernel_text_address+0x12/0x30 [ 11.217801][ T242] do_set_master+0x357/0x580 [ 11.217808][ T242] do_setlink.isra.0+0xa31/0x2750 [ 11.217812][ T242] ? stack_trace_save+0x93/0xc0 [ 11.217816][ T242] ? rtnl_link_get_size+0x350/0x350 [ 11.217818][ T242] ? rcu_read_lock_any_held+0x66/0x90 [ 11.217821][ T242] ? stack_depot_save_flags+0x38e/0x790 [ 11.217826][ T242] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 11.217830][ T242] ? rcu_read_lock_any_held+0x3c/0x90 [ 11.217833][ T242] ? validate_chain+0x38b/0xc20 [ 11.217837][ T242] ? kasan_save_stack+0x3d/0x50 [ 11.217841][ T242] ? kasan_save_stack+0x2f/0x50 [ 11.217843][ T242] ? kasan_save_track+0x14/0x30 [ 11.217847][ T242] ? __lock_acquire+0x518/0xc20 [ 11.217850][ T242] ? netlink_seq_next+0x4e/0x60 [ 11.217854][ T242] ? ___sys_sendmsg+0xb0/0x1d0 [ 11.217861][ T242] ? lock_acquire.part.0+0xd4/0x280 [ 11.217864][ T242] ? rtnl_newlink+0x9a8/0x11c0 [ 11.217868][ T242] ? rcu_is_watching+0x16/0xd0 [ 11.217871][ T242] ? lock_acquire+0x13c/0x160 [ 11.217874][ T242] ? rcu_is_watching+0x16/0xd0 [ 11.217876][ T242] ? rcu_is_watching+0x16/0xd0 [ 11.217879][ T242] ? trace_contention_end+0xb3/0x180 [ 11.217884][ T242] ? __mutex_lock+0x1db/0x1ea0 [ 11.217887][ T242] ? __mutex_lock+0x9a3/0x1ea0 [ 11.217890][ T242] ? rtnl_newlink+0x9a8/0x11c0 [ 11.217896][ T242] ? ww_mutex_lock+0x160/0x160 [ 11.217899][ T242] ? nla_get_range_signed+0x3d0/0x3d0 [ 11.217907][ T242] ? __rtnl_newlink+0x3fa/0xa50 [ 11.217917][ T242] rtnl_newlink+0x9f1/0x11c0 [ 11.217926][ T242] ? rtnl_bridge_getlink+0x850/0x850 [ 11.217929][ T242] ? __lock_acquire+0x518/0xc20 [ 11.217937][ T242] ? lock_acquire.part.0+0xd4/0x280 [ 11.217939][ T242] ? find_held_lock+0x2b/0x80 [ 11.217943][ T242] ? rtnl_bridge_getlink+0x850/0x850 [ 11.217946][ T242] ? __lock_release.isra.0+0x69/0x1a0 [ 11.217952][ T242] ? rtnl_bridge_getlink+0x850/0x850 [ 11.217955][ T242] rtnetlink_rcv_msg+0x6fd/0xbd0 [ 11.217960][ T242] ? rtnl_link_fill+0x920/0x920 [ 11.217962][ T242] ? __lock_acquire+0x518/0xc20 [ 11.217969][ T242] ? lock_acquire.part.0+0xd4/0x280 [ 11.217972][ T242] ? find_held_lock+0x2b/0x80 [ 11.217978][ T242] netlink_rcv_skb+0x14e/0x3a0 [ 11.217981][ T242] ? rtnl_link_fill+0x920/0x920 [ 11.217986][ T242] ? netlink_ack+0xcf0/0xcf0 [ 11.217997][ T242] ? netlink_deliver_tap+0xc5/0x330 [ 11.217999][ T242] ? netlink_deliver_tap+0x13c/0x330 [ 11.218006][ T242] netlink_unicast+0x486/0x750 [ 11.218013][ T242] ? netlink_attachskb+0x810/0x810 [ 11.218017][ T242] ? __lock_acquire+0x518/0xc20 [ 11.218024][ T242] netlink_sendmsg+0x735/0xc60 [ 11.218031][ T242] ? netlink_unicast+0x750/0x750 [ 11.218037][ T242] ? __might_fault+0x97/0x140 [ 11.218045][ T242] ____sys_sendmsg+0x415/0x880 [ 11.218089][ T242] ? copy_msghdr_from_user+0x279/0x420 [ 11.218093][ T242] ? get_timestamp.constprop.0+0x390/0x390 [ 11.218095][ T242] ? move_addr_to_kernel+0x40/0x40 [ 11.218108][ T242] ___sys_sendmsg+0x14e/0x1d0 [ 11.218113][ T242] ? copy_msghdr_from_user+0x420/0x420 [ 11.218142][ T242] __sys_sendmsg+0x12c/0x1d0 [ 11.218147][ T242] ? __sys_sendmsg_sock+0x20/0x20 [ 11.218157][ T242] ? rcu_is_watching+0x16/0xd0 [ 11.218163][ T242] do_syscall_64+0xff/0x530 [ 11.218166][ T242] ? exc_page_fault+0xee/0x100 [ 11.218171][ T242] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 11.218174][ T242] RIP: 0033:0x7f0360d5254e [ 11.218179][ T242] 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 [ 11.218181][ T242] RSP: 002b:00007fff24e1f5d0 EFLAGS: 00000202 ORIG_RAX: 000000000000002e [ 11.218185][ T242] RAX: ffffffffffffffda RBX: 0000000000000004 RCX: 00007f0360d5254e [ 11.218187][ T242] RDX: 0000000000000000 RSI: 00007fff24e1f680 RDI: 0000000000000005 [ 11.218189][ T242] RBP: 00007fff24e1f5e0 R08: 0000000000000000 R09: 0000000000000000 [ 11.218190][ T242] R10: 0000000000000000 R11: 0000000000000202 R12: 000000006a9138ac [ 11.218191][ T242] R13: 00000000004a1620 R14: 0000000000000000 R15: 00007fff24e1fd40 [ 11.218204][ T242] [ 11.292470][ T242] br1: port 1(veth1) entered disabled state [ 11.293129][ T242] veth1: entered allmulticast mode [ 11.296234][ T242] veth1: entered promiscuous mode [ 11.313819][ T242] ip (242) used greatest stack depth: 23336 bytes left [ 11.339525][ T46] br1: port 1(veth1) entered blocking state [ 11.339952][ T46] br1: port 1(veth1) entered forwarding state [ 11.365576][ T244] br1: port 2(veth2) entered blocking state [ 11.365876][ T244] br1: port 2(veth2) entered disabled state [ 11.366165][ T244] veth2: entered allmulticast mode [ 11.367635][ T244] veth2: entered promiscuous mode [ 11.398191][ T94] br1: port 2(veth2) entered blocking state [ 11.398582][ T94] br1: port 2(veth2) entered forwarding state [ 17.925426][ C0] clocksource: Watchdog remote CPU 2 read timed out [ 17.925517][ C0] [ 17.925519][ C0] ======================================================== [ 17.925520][ C0] WARNING: possible irq lock inversion dependency detected [ 17.925523][ C0] 7.2.0-virtme #1 Tainted: G W [ 17.925524][ C0] -------------------------------------------------------- [ 17.925525][ C0] swapper/0/0 just changed the state of lock: [ 17.925526][ C0] ffffffff8fc89660 (console_owner){..-.}-{0:0}, at: console_lock_spinning_enable+0x40/0x60 [ 17.925538][ C0] but this lock took another, SOFTIRQ-unsafe lock in the past: [ 17.925540][ C0] (fs_reclaim){+.+.}-{0:0} [ 17.925541][ C0] [ 17.925541][ C0] [ 17.925541][ C0] and interrupts could create inverse lock ordering between them. [ 17.925541][ C0] [ 17.925542][ C0] [ 17.925542][ C0] other info that might help us debug this: [ 17.925543][ C0] Possible interrupt unsafe locking scenario: [ 17.925543][ C0] [ 17.925543][ C0] CPU0 CPU1 [ 17.925544][ C0] ---- ---- [ 17.925544][ C0] lock(fs_reclaim); [ 17.925545][ C0] local_irq_disable(); [ 17.925546][ C0] lock(console_owner); [ 17.925546][ C0] lock(fs_reclaim); [ 17.925547][ C0] [ 17.925548][ C0] lock(console_owner); [ 17.925548][ C0] [ 17.925548][ C0] *** DEADLOCK *** [ 17.925548][ C0] [ 17.925549][ C0] locks held by swapper/0/0: 4, last CPU#0: [ 17.925550][ C0] #0: ffa0000000007c90 ((&watchdog_timer)){+.-.}-{0:0}, at: call_timer_fn+0x110/0x4d0 [ 17.925556][ C0] #1: ffffffff8fdce8b8 (watchdog_lock){+.-.}-{3:3}, at: clocksource_watchdog+0x15/0x30 [ 17.925560][ C0] #2: ffffffff8fd69cc0 (console_lock){+.+.}-{0:0}, at: vprintk_emit+0x320/0x3e0 [ 17.925563][ C0] #3: ffffffff8fd69d38 (console_srcu){....}-{0:0}, at: console_flush_one_record+0x106/0x710 [ 17.925567][ C0] [ 17.925567][ C0] the shortest dependencies between 2nd lock and 1st lock: [ 17.925571][ C0] -> (fs_reclaim){+.+.}-{0:0} { [ 17.925573][ C0] HARDIRQ-ON-W at: [ 17.925575][ C0] __lock_acquire+0x388/0xc20 [ 17.925577][ C0] lock_acquire.part.0+0xd4/0x280 [ 17.925579][ C0] fs_reclaim_acquire+0xd5/0x120 [ 17.925582][ C0] __kmalloc_cache_noprof+0x6e/0x620 [ 17.925584][ C0] kthread_create_worker_on_node+0xea/0x210 [ 17.925587][ C0] workqueue_init+0x2a/0x680 [ 17.925590][ C0] kernel_init_freeable+0x2fe/0x630 [ 17.925592][ C0] kernel_init+0x21/0x150 [ 17.925596][ C0] ret_from_fork+0x474/0x6b0 [ 17.925598][ C0] ret_from_fork_asm+0x11/0x20 [ 17.925601][ C0] SOFTIRQ-ON-W at: [ 17.925602][ C0] __lock_acquire+0x388/0xc20 [ 17.925603][ C0] lock_acquire.part.0+0xd4/0x280 [ 17.925605][ C0] fs_reclaim_acquire+0xd5/0x120 [ 17.925606][ C0] __kmalloc_cache_noprof+0x6e/0x620 [ 17.925607][ C0] kthread_create_worker_on_node+0xea/0x210 [ 17.925609][ C0] workqueue_init+0x2a/0x680 [ 17.925610][ C0] kernel_init_freeable+0x2fe/0x630 [ 17.925611][ C0] kernel_init+0x21/0x150 [ 17.925612][ C0] ret_from_fork+0x474/0x6b0 [ 17.925613][ C0] ret_from_fork_asm+0x11/0x20 [ 17.925614][ C0] INITIAL USE at: [ 17.925615][ C0] __lock_acquire+0x388/0xc20 [ 17.925617][ C0] lock_acquire.part.0+0xd4/0x280 [ 17.925618][ C0] fs_reclaim_acquire+0xd5/0x120 [ 17.925619][ C0] __kmalloc_cache_noprof+0x6e/0x620 [ 17.925620][ C0] kthread_create_worker_on_node+0xea/0x210 [ 17.925621][ C0] workqueue_init+0x2a/0x680 [ 17.925623][ C0] kernel_init_freeable+0x2fe/0x630 [ 17.925624][ C0] kernel_init+0x21/0x150 [ 17.925625][ C0] ret_from_fork+0x474/0x6b0 [ 17.925626][ C0] ret_from_fork_asm+0x11/0x20 [ 17.925627][ C0] } [ 17.925628][ C0] ... key at: [] __fs_reclaim_map+0x0/0xbe0 [ 17.925631][ C0] ... acquired at: [ 17.925632][ C0] __lock_acquire+0x518/0xc20 [ 17.925634][ C0] lock_acquire.part.0+0xd4/0x280 [ 17.925635][ C0] fs_reclaim_acquire+0xd5/0x120 [ 17.925636][ C0] __kmalloc_noprof+0xd3/0x760 [ 17.925637][ C0] alloc_buf.isra.0+0x4b/0x260 [ 17.925640][ C0] put_chars+0x1e1/0x2f0 [ 17.925641][ C0] hvc_console_print+0x292/0x780 [ 17.925643][ C0] console_emit_next_record+0x22f/0x4c0 [ 17.925645][ C0] console_flush_one_record+0x46f/0x710 [ 17.925646][ C0] console_unlock+0xee/0x1f0 [ 17.925648][ C0] vprintk_emit+0x37c/0x3e0 [ 17.925649][ C0] dev_vprintk_emit+0x27f/0x2c0 [ 17.925653][ C0] dev_printk_emit+0xb9/0xee [ 17.925654][ C0] _dev_info+0xe2/0x116 [ 17.925656][ C0] __devm_rtc_register_device.cold+0xc3/0x3a8 [ 17.925658][ C0] cmos_do_probe+0x73b/0x98a [ 17.925660][ C0] platform_probe+0xfe/0x1f0 [ 17.925663][ C0] call_driver_probe+0x61/0x1c0 [ 17.925665][ C0] really_probe+0x199/0x760 [ 17.925666][ C0] __driver_probe_device+0x24f/0x440 [ 17.925668][ C0] driver_probe_device+0x4a/0xf0 [ 17.925669][ C0] __driver_attach+0x1b8/0x540 [ 17.925670][ C0] bus_for_each_dev+0x130/0x1e0 [ 17.925671][ C0] bus_add_driver+0x2c8/0x530 [ 17.925673][ C0] driver_register+0x1a3/0x390 [ 17.925674][ C0] __platform_driver_probe+0x13f/0x270 [ 17.925676][ C0] cmos_init+0x31/0x40 [ 17.925679][ C0] do_one_initcall+0x124/0x4f0 [ 17.925680][ C0] kernel_init_freeable+0x596/0x630 [ 17.925681][ C0] kernel_init+0x21/0x150 [ 17.925682][ C0] ret_from_fork+0x474/0x6b0 [ 17.925683][ C0] ret_from_fork_asm+0x11/0x20 [ 17.925685][ C0] [ 17.925685][ C0] -> (console_owner){..-.}-{0:0} { [ 17.925687][ C0] IN-SOFTIRQ-W at: [ 17.925687][ C0] __lock_acquire+0x388/0xc20 [ 17.925689][ C0] lock_acquire.part.0+0xd4/0x280 [ 17.925690][ C0] console_lock_spinning_enable+0x5c/0x60 [ 17.925692][ C0] console_emit_next_record+0x1d1/0x4c0 [ 17.925693][ C0] console_flush_one_record+0x46f/0x710 [ 17.925695][ C0] console_unlock+0xee/0x1f0 [ 17.925696][ C0] vprintk_emit+0x37c/0x3e0 [ 17.925698][ C0] _printk+0xc7/0x100 [ 17.925701][ C0] clocksource_watchdog.part.0.cold+0x105/0x1dd [ 17.925703][ C0] call_timer_fn+0x160/0x4d0 [ 17.925705][ C0] __run_timers+0x68f/0xaa0 [ 17.925706][ C0] run_timer_softirq+0xf0/0x160 [ 17.925707][ C0] handle_softirqs+0x1d3/0x900 [ 17.925710][ C0] __irq_exit_rcu+0x145/0x1c0 [ 17.925711][ C0] irq_exit_rcu+0xe/0x30 [ 17.925712][ C0] sysvec_apic_timer_interrupt+0x9d/0xe0 [ 17.925714][ C0] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 17.925716][ C0] pv_native_safe_halt+0xf/0x10 [ 17.925717][ C0] default_idle+0x9/0x10 [ 17.925719][ C0] default_idle_call+0x6e/0xb0 [ 17.925720][ C0] cpuidle_idle_call.constprop.0+0x237/0x410 [ 17.925722][ C0] do_idle+0xd8/0x190 [ 17.925723][ C0] cpu_startup_entry+0x53/0x70 [ 17.925725][ C0] rest_init+0x279/0x280 [ 17.925726][ C0] start_kernel+0x3af/0x3b0 [ 17.925727][ C0] x86_64_start_reservations+0x24/0x30 [ 17.925730][ C0] x86_64_start_kernel+0x12b/0x130 [ 17.925731][ C0] common_startup_64+0x13e/0x148 [ 17.925733][ C0] INITIAL USE at: [ 17.925734][ C0] } [ 17.925735][ C0] ... key at: [] console_owner_dep_map+0x0/0x60 [ 17.925738][ C0] ... acquired at: [ 17.925738][ C0] mark_lock+0x1d7/0xa00 [ 17.925739][ C0] mark_usage+0x42/0x170 [ 17.925741][ C0] __lock_acquire+0x388/0xc20 [ 17.925742][ C0] lock_acquire.part.0+0xd4/0x280 [ 17.925743][ C0] console_lock_spinning_enable+0x5c/0x60 [ 17.925745][ C0] console_emit_next_record+0x1d1/0x4c0 [ 17.925746][ C0] console_flush_one_record+0x46f/0x710 [ 17.925748][ C0] console_unlock+0xee/0x1f0 [ 17.925749][ C0] vprintk_emit+0x37c/0x3e0 [ 17.925750][ C0] _printk+0xc7/0x100 [ 17.925752][ C0] clocksource_watchdog.part.0.cold+0x105/0x1dd [ 17.925753][ C0] call_timer_fn+0x160/0x4d0 [ 17.925754][ C0] __run_timers+0x68f/0xaa0 [ 17.925756][ C0] run_timer_softirq+0xf0/0x160 [ 17.925757][ C0] handle_softirqs+0x1d3/0x900 [ 17.925758][ C0] __irq_exit_rcu+0x145/0x1c0 [ 17.925759][ C0] irq_exit_rcu+0xe/0x30 [ 17.925761][ C0] sysvec_apic_timer_interrupt+0x9d/0xe0 [ 17.925762][ C0] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 17.925763][ C0] pv_native_safe_halt+0xf/0x10 [ 17.925764][ C0] default_idle+0x9/0x10 [ 17.925766][ C0] default_idle_call+0x6e/0xb0 [ 17.925767][ C0] cpuidle_idle_call.constprop.0+0x237/0x410 [ 17.925768][ C0] do_idle+0xd8/0x190 [ 17.925770][ C0] cpu_startup_entry+0x53/0x70 [ 17.925771][ C0] rest_init+0x279/0x280 [ 17.925772][ C0] start_kernel+0x3af/0x3b0 [ 17.925773][ C0] x86_64_start_reservations+0x24/0x30 [ 17.925775][ C0] x86_64_start_kernel+0x12b/0x130 [ 17.925776][ C0] common_startup_64+0x13e/0x148 [ 17.925777][ C0] [ 17.925778][ C0] [ 17.925778][ C0] stack backtrace: [ 17.925780][ C0] CPU: 0 UID: 0 PID: 0 Comm: swapper/0 Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 17.925783][ C0] Tainted: [W]=WARN [ 17.925784][ C0] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 17.925786][ C0] Call Trace: [ 17.925787][ C0] [ 17.925788][ C0] dump_stack_lvl+0x6f/0xa0 [ 17.925792][ C0] print_irq_inversion_bug.part.0.cold+0xe6/0x143 [ 17.925794][ C0] mark_lock_irq+0x989/0x9c0 [ 17.925796][ C0] ? add_lock_to_list+0x2c/0x1a0 [ 17.925798][ C0] mark_lock+0x1d7/0xa00 [ 17.925800][ C0] mark_usage+0x42/0x170 [ 17.925802][ C0] __lock_acquire+0x388/0xc20 [ 17.925804][ C0] lock_acquire.part.0+0xd4/0x280 [ 17.925806][ C0] ? console_lock_spinning_enable+0x40/0x60 [ 17.925808][ C0] ? rcu_is_watching+0x16/0xd0 [ 17.925811][ C0] ? lock_acquire+0x13c/0x160 [ 17.925813][ C0] console_lock_spinning_enable+0x5c/0x60 [ 17.925814][ C0] ? console_lock_spinning_enable+0x40/0x60 [ 17.925816][ C0] console_emit_next_record+0x1d1/0x4c0 [ 17.925818][ C0] ? devkmsg_read+0x4b0/0x4b0 [ 17.925820][ C0] ? console_flush_one_record+0x106/0x710 [ 17.925821][ C0] ? rcu_is_watching+0x16/0xd0 [ 17.925823][ C0] ? lock_acquire+0x13c/0x160 [ 17.925825][ C0] console_flush_one_record+0x46f/0x710 [ 17.925827][ C0] ? console_emit_next_record+0x4c0/0x4c0 [ 17.925829][ C0] ? __lock_acquire+0x518/0xc20 [ 17.925832][ C0] console_unlock+0xee/0x1f0 [ 17.925833][ C0] ? console_flush_one_record+0x710/0x710 [ 17.925835][ C0] ? rcu_is_watching+0x16/0xd0 [ 17.925837][ C0] ? lock_acquire+0x60/0x160 [ 17.925838][ C0] ? __down_trylock_console_sem+0x5e/0xa0 [ 17.925840][ C0] ? vprintk_emit+0x320/0x3e0 [ 17.925842][ C0] vprintk_emit+0x37c/0x3e0 [ 17.925844][ C0] ? wake_up_klogd_work_func+0x90/0x90 [ 17.925846][ C0] ? clocksource_watchdog.part.0+0x450/0x540 [ 17.925848][ C0] _printk+0xc7/0x100 [ 17.925850][ C0] ? snapshot_read.cold+0x21/0x21 [ 17.925852][ C0] ? clocksource_watchdog.part.0+0x450/0x540 [ 17.925853][ C0] ? __lock_release.isra.0+0x69/0x1a0 [ 17.925855][ C0] clocksource_watchdog.part.0.cold+0x105/0x1dd [ 17.925857][ C0] ? clocksource_watchdog.part.0+0x540/0x540 [ 17.925858][ C0] ? clocksource_watchdog.part.0+0x540/0x540 [ 17.925860][ C0] call_timer_fn+0x160/0x4d0 [ 17.925862][ C0] ? detach_if_pending+0x1d0/0x1d0 [ 17.925863][ C0] ? debug_object_active_state+0x430/0x430 [ 17.925867][ C0] ? find_held_lock+0x2b/0x80 [ 17.925869][ C0] ? __lock_release.isra.0+0x69/0x1a0 [ 17.925870][ C0] ? rcu_is_watching+0x16/0xd0 [ 17.925873][ C0] __run_timers+0x68f/0xaa0 [ 17.925874][ C0] ? clocksource_watchdog.part.0+0x540/0x540 [ 17.925876][ C0] ? __bpf_trace_itimer_expire+0x10/0x10 [ 17.925878][ C0] ? __lock_acquire+0x518/0xc20 [ 17.925881][ C0] ? __rwlock_init+0x150/0x150 [ 17.925883][ C0] run_timer_softirq+0xf0/0x160 [ 17.925885][ C0] ? __run_timers+0xaa0/0xaa0 [ 17.925887][ C0] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 17.925889][ C0] ? rcu_is_watching+0x16/0xd0 [ 17.925891][ C0] handle_softirqs+0x1d3/0x900 [ 17.925892][ C0] ? __lock_release.isra.0+0x69/0x1a0 [ 17.925894][ C0] ? _local_bh_enable+0xc0/0xc0 [ 17.925896][ C0] __irq_exit_rcu+0x145/0x1c0 [ 17.925897][ C0] irq_exit_rcu+0xe/0x30 [ 17.925899][ C0] sysvec_apic_timer_interrupt+0x9d/0xe0 [ 17.925900][ C0] [ 17.925901][ C0] [ 17.925901][ C0] ? lockdep_hardirqs_on_prepare.part.0+0x9a/0x160 [ 17.925903][ C0] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 17.925904][ C0] RIP: 0010:pv_native_safe_halt+0xf/0x10 [ 17.925907][ 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 [ 17.925908][ C0] RSP: 0018:ffffffff8fa07cf8 EFLAGS: 00000296 [ 17.925911][ C0] RAX: 0000000000085c71 RBX: ffffffff8fa1c600 RCX: ffffffff8caf0307 [ 17.925912][ C0] RDX: ffffffff8fa1c600 RSI: ffffffff8f838b01 RDI: ffffffff8f28d8e0 [ 17.925913][ C0] RBP: 0000000000000000 R08: 0000000000000000 R09: 0000000000000000 [ 17.925914][ C0] R10: 0000000000000000 R11: 0000000000000001 R12: 1ffffffff1f40fa2 [ 17.925915][ C0] R13: 0000000000000000 R14: dffffc0000000000 R15: 0000000000014770 [ 17.925916][ C0] ? cpuidle_idle_call.constprop.0+0x237/0x410 [ 17.925918][ C0] ? lockdep_hardirqs_on+0x91/0x130 [ 17.925920][ C0] default_idle+0x9/0x10 [ 17.925921][ C0] default_idle_call+0x6e/0xb0 [ 17.925923][ C0] cpuidle_idle_call.constprop.0+0x237/0x410 [ 17.925924][ C0] ? arch_cpu_idle_exit+0x40/0x40 [ 17.925926][ C0] ? mark_tsc_async_resets+0x30/0x30 [ 17.925928][ C0] ? rcu_is_watching+0x16/0xd0 [ 17.925930][ C0] do_idle+0xd8/0x190 [ 17.925932][ C0] cpu_startup_entry+0x53/0x70 [ 17.925933][ C0] rest_init+0x279/0x280 [ 17.925935][ C0] ? __cpuidle_text_end+0x3b/0x3b [ 17.925937][ C0] ? rest_init+0x280/0x280 [ 17.925939][ C0] ? acpi_hw_set_mode+0x4a0/0x4a0 [ 17.925943][ C0] ? cpus_read_unlock+0x4f/0xc0 [ 17.925945][ C0] ? acpi_enable+0x1e4/0x330 [ 17.925947][ C0] start_kernel+0x3af/0x3b0 [ 17.925949][ C0] x86_64_start_reservations+0x24/0x30 [ 17.925951][ C0] x86_64_start_kernel+0x12b/0x130 [ 17.925952][ C0] common_startup_64+0x13e/0x148 [ 17.925955][ C0] [ 17.925959][ C0] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 17.925961][ C0] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 0, name: swapper/0 [ 17.925962][ C0] preempt_count: 103, expected: 0 [ 17.925963][ C0] RCU nest depth: 0, expected: 0 [ 17.925963][ C0] INFO: lockdep is turned off. [ 17.925964][ C0] irq event stamp: 547969 [ 17.925965][ C0] hardirqs last enabled at (547968): [] __down_trylock_console_sem+0x86/0xa0 [ 17.925967][ C0] hardirqs last disabled at (547969): [] console_emit_next_record+0x3d4/0x4c0 [ 17.925969][ C0] softirqs last enabled at (547948): [] handle_softirqs+0x67c/0x900 [ 17.925970][ C0] softirqs last disabled at (547955): [] __irq_exit_rcu+0x145/0x1c0 [ 17.925971][ C0] Preemption disabled at: [ 17.925972][ C0] [] schedule_preempt_disabled+0x22/0x30 [ 17.925975][ C0] CPU: 0 UID: 0 PID: 0 Comm: swapper/0 Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 17.925976][ C0] Tainted: [W]=WARN [ 17.925977][ C0] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 17.925978][ C0] Call Trace: [ 17.925978][ C0] [ 17.925979][ C0] dump_stack_lvl+0x6f/0xa0 [ 17.925981][ C0] ? schedule_preempt_disabled+0x22/0x30 [ 17.925982][ C0] __might_resched.cold+0x1fe/0x2c1 [ 17.925985][ C0] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 17.925988][ C0] ? rcu_is_watching+0x16/0xd0 [ 17.925991][ C0] __kmalloc_noprof+0x443/0x760 [ 17.925992][ C0] ? __rwlock_init+0x150/0x150 [ 17.925994][ C0] ? alloc_buf.isra.0+0x4b/0x260 [ 17.925995][ C0] ? do_raw_spin_unlock+0x59/0x250 [ 17.925997][ C0] alloc_buf.isra.0+0x4b/0x260 [ 17.925999][ C0] put_chars+0x1e1/0x2f0 [ 17.926000][ C0] ? __send_to_port+0x420/0x420 [ 17.926002][ C0] ? mark_lock+0x1d7/0xa00 [ 17.926004][ C0] hvc_console_print+0x292/0x780 [ 17.926006][ C0] ? hvc_write+0x3a0/0x3a0 [ 17.926008][ C0] ? rcu_is_watching+0x16/0xd0 [ 17.926009][ C0] ? rcu_is_watching+0x16/0xd0 [ 17.926012][ C0] console_emit_next_record+0x22f/0x4c0 [ 17.926014][ C0] ? devkmsg_read+0x4b0/0x4b0 [ 17.926015][ C0] ? console_flush_one_record+0x106/0x710 [ 17.926017][ C0] ? rcu_is_watching+0x16/0xd0 [ 17.926019][ C0] ? lock_acquire+0x13c/0x160 [ 17.926020][ C0] console_flush_one_record+0x46f/0x710 [ 17.926023][ C0] ? console_emit_next_record+0x4c0/0x4c0 [ 17.926024][ C0] ? __lock_acquire+0x518/0xc20 [ 17.926026][ C0] console_unlock+0xee/0x1f0 [ 17.926028][ C0] ? console_flush_one_record+0x710/0x710 [ 17.926030][ C0] ? rcu_is_watching+0x16/0xd0 [ 17.926031][ C0] ? lock_acquire+0x60/0x160 [ 17.926033][ C0] ? __down_trylock_console_sem+0x5e/0xa0 [ 17.926035][ C0] ? vprintk_emit+0x320/0x3e0 [ 17.926037][ C0] vprintk_emit+0x37c/0x3e0 [ 17.926039][ C0] ? wake_up_klogd_work_func+0x90/0x90 [ 17.926041][ C0] ? clocksource_watchdog.part.0+0x450/0x540 [ 17.926043][ C0] _printk+0xc7/0x100 [ 17.926045][ C0] ? snapshot_read.cold+0x21/0x21 [ 17.926046][ C0] ? clocksource_watchdog.part.0+0x450/0x540 [ 17.926048][ C0] ? __lock_release.isra.0+0x69/0x1a0 [ 17.926050][ C0] clocksource_watchdog.part.0.cold+0x105/0x1dd [ 17.926051][ C0] ? clocksource_watchdog.part.0+0x540/0x540 [ 17.926053][ C0] ? clocksource_watchdog.part.0+0x540/0x540 [ 17.926054][ C0] call_timer_fn+0x160/0x4d0 [ 17.926056][ C0] ? detach_if_pending+0x1d0/0x1d0 [ 17.926058][ C0] ? debug_object_active_state+0x430/0x430 [ 17.926059][ C0] ? find_held_lock+0x2b/0x80 [ 17.926061][ C0] ? __lock_release.isra.0+0x69/0x1a0 [ 17.926062][ C0] ? rcu_is_watching+0x16/0xd0 [ 17.926065][ C0] __run_timers+0x68f/0xaa0 [ 17.926067][ C0] ? clocksource_watchdog.part.0+0x540/0x540 [ 17.926069][ C0] ? __bpf_trace_itimer_expire+0x10/0x10 [ 17.926076][ C0] ? __lock_acquire+0x518/0xc20 [ 17.926079][ C0] ? __rwlock_init+0x150/0x150 [ 17.926081][ C0] run_timer_softirq+0xf0/0x160 [ 17.926083][ C0] ? __run_timers+0xaa0/0xaa0 [ 17.926084][ C0] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 17.926086][ C0] ? rcu_is_watching+0x16/0xd0 [ 17.926087][ C0] handle_softirqs+0x1d3/0x900 [ 17.926089][ C0] ? __lock_release.isra.0+0x69/0x1a0 [ 17.926091][ C0] ? _local_bh_enable+0xc0/0xc0 [ 17.926093][ C0] __irq_exit_rcu+0x145/0x1c0 [ 17.926094][ C0] irq_exit_rcu+0xe/0x30 [ 17.926095][ C0] sysvec_apic_timer_interrupt+0x9d/0xe0 [ 17.926097][ C0] [ 17.926098][ C0] [ 17.926098][ C0] ? lockdep_hardirqs_on_prepare.part.0+0x9a/0x160 [ 17.926100][ C0] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 17.926101][ C0] RIP: 0010:pv_native_safe_halt+0xf/0x10 [ 17.926103][ 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 [ 17.926104][ C0] RSP: 0018:ffffffff8fa07cf8 EFLAGS: 00000296 [ 17.926105][ C0] RAX: 0000000000085c71 RBX: ffffffff8fa1c600 RCX: ffffffff8caf0307 [ 17.926106][ C0] RDX: ffffffff8fa1c600 RSI: ffffffff8f838b01 RDI: ffffffff8f28d8e0 [ 17.926106][ C0] RBP: 0000000000000000 R08: 0000000000000000 R09: 0000000000000000 [ 17.926107][ C0] R10: 0000000000000000 R11: 0000000000000001 R12: 1ffffffff1f40fa2 [ 17.926108][ C0] R13: 0000000000000000 R14: dffffc0000000000 R15: 0000000000014770 [ 17.926109][ C0] ? cpuidle_idle_call.constprop.0+0x237/0x410 [ 17.926111][ C0] ? lockdep_hardirqs_on+0x91/0x130 [ 17.926113][ C0] default_idle+0x9/0x10 [ 17.926114][ C0] default_idle_call+0x6e/0xb0 [ 17.926116][ C0] cpuidle_idle_call.constprop.0+0x237/0x410 [ 17.926118][ C0] ? arch_cpu_idle_exit+0x40/0x40 [ 17.926119][ C0] ? mark_tsc_async_resets+0x30/0x30 [ 17.926120][ C0] ? rcu_is_watching+0x16/0xd0 [ 17.926122][ C0] do_idle+0xd8/0x190 [ 17.926124][ C0] cpu_startup_entry+0x53/0x70 [ 17.926125][ C0] rest_init+0x279/0x280 [ 17.926127][ C0] ? __cpuidle_text_end+0x3b/0x3b [ 17.926130][ C0] ? rest_init+0x280/0x280 [ 17.926132][ C0] ? acpi_hw_set_mode+0x4a0/0x4a0 [ 17.926134][ C0] ? cpus_read_unlock+0x4f/0xc0 [ 17.926135][ C0] ? acpi_enable+0x1e4/0x330 [ 17.926137][ C0] start_kernel+0x3af/0x3b0 [ 17.926139][ C0] x86_64_start_reservations+0x24/0x30 [ 17.926140][ C0] x86_64_start_kernel+0x12b/0x130 [ 17.926142][ C0] common_startup_64+0x13e/0x148 [ 17.926145][ C0] [ 24.287010][ T625] br1: port 2(veth2) entered disabled state [ 24.287025][ T625] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 24.287027][ T625] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 625, name: ip [ 24.287029][ T625] preempt_count: 202, expected: 0 [ 24.287030][ T625] RCU nest depth: 0, expected: 0 [ 24.287031][ T625] INFO: lockdep is turned off. [ 24.287032][ T625] irq event stamp: 0 [ 24.287033][ T625] hardirqs last enabled at (0): [<0000000000000000>] 0x0 [ 24.287038][ T625] hardirqs last disabled at (0): [] copy_process+0x1ccd/0x6240 [ 24.287044][ T625] softirqs last enabled at (0): [] copy_process+0x1d21/0x6240 [ 24.287046][ T625] softirqs last disabled at (0): [<0000000000000000>] 0x0 [ 24.287048][ T625] Preemption disabled at: [ 24.287049][ T625] [<0000000000000000>] 0x0 [ 24.287053][ T625] CPU: 3 UID: 0 PID: 625 Comm: ip Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 24.287056][ T625] Tainted: [W]=WARN [ 24.287057][ T625] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 24.287059][ T625] Call Trace: [ 24.287060][ T625] [ 24.287062][ T625] dump_stack_lvl+0x6f/0xa0 [ 24.287067][ T625] __might_resched.cold+0x1fe/0x2c1 [ 24.287072][ T625] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 24.287075][ T625] ? rcu_is_watching+0x16/0xd0 [ 24.287079][ T625] __kmalloc_noprof+0x443/0x760 [ 24.287083][ T625] ? __rwlock_init+0x150/0x150 [ 24.287086][ T625] ? alloc_buf.isra.0+0x4b/0x260 [ 24.287090][ T625] ? do_raw_spin_unlock+0x59/0x250 [ 24.287091][ T625] alloc_buf.isra.0+0x4b/0x260 [ 24.287101][ T625] put_chars+0x1e1/0x2f0 [ 24.287103][ T625] ? __send_to_port+0x420/0x420 [ 24.287105][ T625] ? printk_get_next_message+0x240/0x650 [ 24.287108][ T625] hvc_console_print+0x292/0x780 [ 24.287111][ T625] ? hvc_write+0x3a0/0x3a0 [ 24.287113][ T625] ? __rwlock_init+0x150/0x150 [ 24.287115][ T625] ? rcu_is_watching+0x16/0xd0 [ 24.287117][ T625] ? lock_acquire+0x13c/0x160 [ 24.287119][ T625] console_emit_next_record+0x22f/0x4c0 [ 24.287122][ T625] ? devkmsg_read+0x4b0/0x4b0 [ 24.287124][ T625] ? rcu_is_watching+0x16/0xd0 [ 24.287125][ T625] ? rcu_is_watching+0x16/0xd0 [ 24.287127][ T625] ? rcu_is_watching+0x16/0xd0 [ 24.287129][ T625] ? lock_acquire+0x13c/0x160 [ 24.287131][ T625] ? console_flush_one_record+0x111/0x710 [ 24.287132][ T625] console_flush_one_record+0x46f/0x710 [ 24.287135][ T625] ? console_emit_next_record+0x4c0/0x4c0 [ 24.287137][ T625] console_unlock+0xee/0x1f0 [ 24.287139][ T625] ? lock_acquire+0x13c/0x160 [ 24.287140][ T625] ? console_flush_one_record+0x710/0x710 [ 24.287142][ T625] ? rcu_is_watching+0x16/0xd0 [ 24.287144][ T625] ? lock_release+0x184/0x1f0 [ 24.287145][ T625] ? lock_acquire+0x60/0x160 [ 24.287147][ T625] ? __rcu_read_lock+0x30/0x70 [ 24.287149][ T625] ? __down_trylock_console_sem+0x5e/0xa0 [ 24.287151][ T625] ? vprintk_emit+0x320/0x3e0 [ 24.287153][ T625] vprintk_emit+0x37c/0x3e0 [ 24.287155][ T625] ? wake_up_klogd_work_func+0x90/0x90 [ 24.287157][ T625] ? rcu_is_watching+0x16/0xd0 [ 24.287159][ T625] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 24.287161][ T625] ? trace_hardirqs_on+0x36/0x40 [ 24.287163][ T625] _printk+0xc7/0x100 [ 24.287166][ T625] ? snapshot_read.cold+0x21/0x21 [ 24.287168][ T625] ? ipv6_mc_down+0x17e/0x2d0 [ 24.287172][ T625] br_set_state+0x22f/0x430 [bridge] [ 24.287186][ T625] br_stp_disable_port+0x11f/0x390 [bridge] [ 24.287194][ T625] br_device_event+0x7b5/0x8f0 [bridge] [ 24.287202][ T625] ? _raw_spin_unlock_irqrestore+0x40/0x80 [ 24.287205][ T625] ? _sub_I_65535_1+0x4d0/0x4d0 [stp] [ 24.287208][ T625] ? addrconf_notify+0x2c8/0xf30 [ 24.287212][ T625] notifier_call_chain+0xae/0x300 [ 24.287215][ T625] __dev_notify_flags+0x23c/0x3c0 [ 24.287218][ T625] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 24.287220][ T625] ? netif_change_name+0x8c0/0x8c0 [ 24.287222][ T625] ? netif_set_allmulti+0x250/0x250 [ 24.287224][ T625] ? __kernel_text_address+0x12/0x30 [ 24.287226][ T625] ? write_profile+0xf0/0xf0 [ 24.287229][ T625] ? unwind_get_return_address+0x67/0xd0 [ 24.287232][ T625] netif_change_flags+0xfe/0x190 [ 24.287234][ T625] do_setlink.isra.0+0x1cc3/0x2750 [ 24.287237][ T625] ? stack_trace_save+0x93/0xc0 [ 24.287239][ T625] ? rtnl_link_get_size+0x350/0x350 [ 24.287240][ T625] ? rcu_is_watching+0x16/0xd0 [ 24.287241][ T625] ? stack_depot_save_flags+0x1bc/0x790 [ 24.287245][ T625] ? kasan_save_stack+0x3d/0x50 [ 24.287248][ T625] ? kasan_save_stack+0x2f/0x50 [ 24.287250][ T625] ? kasan_save_track+0x14/0x30 [ 24.287251][ T625] ? __kasan_kmalloc+0x7b/0x90 [ 24.287253][ T625] ? __kmalloc_cache_noprof+0x29a/0x620 [ 24.287254][ T625] ? rtnl_newlink+0x124/0x11c0 [ 24.287255][ T625] ? rtnetlink_rcv_msg+0x6fd/0xbd0 [ 24.287256][ T625] ? netlink_rcv_skb+0x14e/0x3a0 [ 24.287259][ T625] ? netlink_unicast+0x486/0x750 [ 24.287260][ T625] ? netlink_sendmsg+0x735/0xc60 [ 24.287262][ T625] ? ____sys_sendmsg+0x415/0x880 [ 24.287264][ T625] ? ___sys_sendmsg+0x14e/0x1d0 [ 24.287266][ T625] ? __sys_sendmsg+0x12c/0x1d0 [ 24.287267][ T625] ? do_syscall_64+0xff/0x530 [ 24.287269][ T625] ? entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 24.287272][ T625] ? rcu_is_watching+0x16/0xd0 [ 24.287274][ T625] ? lock_acquire+0x13c/0x160 [ 24.287275][ T625] ? rcu_is_watching+0x16/0xd0 [ 24.287277][ T625] ? rcu_is_watching+0x16/0xd0 [ 24.287278][ T625] ? trace_contention_end+0xb3/0x180 [ 24.287281][ T625] ? __mutex_lock+0x1db/0x1ea0 [ 24.287283][ T625] ? __mutex_lock+0x9a3/0x1ea0 [ 24.287284][ T625] ? rtnl_newlink+0x9a8/0x11c0 [ 24.287286][ T625] ? ww_mutex_lock+0x160/0x160 [ 24.287288][ T625] ? __rtnl_newlink+0x3fa/0xa50 [ 24.287290][ T625] rtnl_newlink+0x9f1/0x11c0 [ 24.287294][ T625] ? rcu_is_watching+0x16/0xd0 [ 24.287296][ T625] ? rtnl_bridge_getlink+0x850/0x850 [ 24.287297][ T625] ? lock_acquire+0x13c/0x160 [ 24.287299][ T625] ? rcu_is_watching+0x16/0xd0 [ 24.287301][ T625] ? is_bpf_text_address+0x3e/0x110 [ 24.287304][ T625] ? is_bpf_text_address+0x72/0x110 [ 24.287306][ T625] ? kernel_text_address+0x149/0x170 [ 24.287307][ T625] ? __kernel_text_address+0x12/0x30 [ 24.287309][ T625] ? write_profile+0xf0/0xf0 [ 24.287310][ T625] ? unwind_get_return_address+0x67/0xd0 [ 24.287311][ T625] ? rcu_is_watching+0x16/0xd0 [ 24.287313][ T625] ? rcu_is_watching+0x16/0xd0 [ 24.287314][ T625] ? cap_capable+0x1d7/0x3d0 [ 24.287318][ T625] ? lock_acquire+0x13c/0x160 [ 24.287320][ T625] ? rcu_is_watching+0x16/0xd0 [ 24.287322][ T625] ? rtnl_bridge_getlink+0x850/0x850 [ 24.287323][ T625] rtnetlink_rcv_msg+0x6fd/0xbd0 [ 24.287325][ T625] ? rtnl_link_fill+0x920/0x920 [ 24.287326][ T625] ? filter_irq_stacks+0xd0/0xd0 [ 24.287327][ T625] ? stack_depot_save_flags+0x1bc/0x790 [ 24.287330][ T625] netlink_rcv_skb+0x14e/0x3a0 [ 24.287331][ T625] ? rtnl_link_fill+0x920/0x920 [ 24.287333][ T625] ? lock_release+0x184/0x1f0 [ 24.287334][ T625] ? netlink_ack+0xcf0/0xcf0 [ 24.287335][ T625] ? __netlink_lookup+0xb9/0x6b0 [ 24.287338][ T625] ? rcu_is_watching+0x16/0xd0 [ 24.287340][ T625] ? lock_release+0x184/0x1f0 [ 24.287342][ T625] netlink_unicast+0x486/0x750 [ 24.287344][ T625] ? netlink_attachskb+0x810/0x810 [ 24.287345][ T625] ? rcu_is_watching+0x16/0xd0 [ 24.287347][ T625] ? rcu_is_watching+0x16/0xd0 [ 24.287349][ T625] ? lock_acquire+0x13c/0x160 [ 24.287350][ T625] netlink_sendmsg+0x735/0xc60 [ 24.287352][ T625] ? netlink_unicast+0x750/0x750 [ 24.287354][ T625] ? rcu_is_watching+0x16/0xd0 [ 24.287356][ T625] ? lock_release+0x184/0x1f0 [ 24.287358][ T625] ____sys_sendmsg+0x415/0x880 [ 24.287359][ T625] ? copy_msghdr_from_user+0x279/0x420 [ 24.287361][ T625] ? get_timestamp.constprop.0+0x390/0x390 [ 24.287363][ T625] ? move_addr_to_kernel+0x40/0x40 [ 24.287364][ T625] ? filter_irq_stacks+0xd0/0xd0 [ 24.287367][ T625] ___sys_sendmsg+0x14e/0x1d0 [ 24.287368][ T625] ? copy_msghdr_from_user+0x420/0x420 [ 24.287373][ T625] __sys_sendmsg+0x12c/0x1d0 [ 24.287375][ T625] ? __sys_sendmsg_sock+0x20/0x20 [ 24.287378][ T625] ? rcu_is_watching+0x16/0xd0 [ 24.287380][ T625] do_syscall_64+0xff/0x530 [ 24.287381][ T625] ? exc_page_fault+0xee/0x100 [ 24.287384][ T625] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 24.287385][ T625] RIP: 0033:0x7f77b0f4854e [ 24.287387][ T625] 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 [ 24.287389][ T625] RSP: 002b:00007ffc988a9030 EFLAGS: 00000202 ORIG_RAX: 000000000000002e [ 24.287393][ T625] RAX: ffffffffffffffda RBX: 0000000000000003 RCX: 00007f77b0f4854e [ 24.287394][ T625] RDX: 0000000000000000 RSI: 00007ffc988a90e0 RDI: 0000000000000005 [ 24.287395][ T625] RBP: 00007ffc988a9040 R08: 0000000000000000 R09: 0000000000000000 [ 24.287396][ T625] R10: 0000000000000000 R11: 0000000000000202 R12: 000000006a9138b9 [ 24.287397][ T625] R13: 00000000004a1620 R14: 0000000000000000 R15: 00007ffc988a97a0 [ 24.287399][ T625] [ 24.316695][ T625] ip (625) used greatest stack depth: 23016 bytes left [ 24.344315][ T626] veth2: left allmulticast mode [ 24.344579][ T626] veth2: left promiscuous mode [ 24.344946][ T626] br1: port 2(veth2) entered disabled state [ 24.370234][ T627] br1: port 1(veth1) entered disabled state [ 24.390755][ T628] veth1: left allmulticast mode [ 24.391019][ T628] veth1: left promiscuous mode [ 24.391405][ T628] br1: port 1(veth1) entered disabled state