[ 9.265678][ T175] ip (175) used greatest stack depth: 24088 bytes left [ 9.265696][ T175] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 9.265699][ T175] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 175, name: ip [ 9.265700][ T175] preempt_count: 2, expected: 0 [ 9.265701][ T175] RCU nest depth: 0, expected: 0 [ 9.265702][ T175] locks held by ip/175: 5, last CPU#3: [ 9.265704][ T175] #0: ffffffffa2a127b8 (low_water_lock){+.+.}-{3:3}, at: do_exit+0x887/0xdc0 [ 9.265715][ T175] #1: ffffffffa2b79cc0 (console_lock){+.+.}-{0:0}, at: vprintk_emit+0x320/0x3e0 [ 9.265721][ T175] #2: ffffffffa2b79d38 (console_srcu){....}-{0:0}, at: console_flush_one_record+0x106/0x710 [ 9.265724][ T175] #3: ffffffffa2a99660 (console_owner){....}-{0:0}, at: console_lock_spinning_enable+0x40/0x60 [ 9.265728][ T175] #4: ffffffffa2a99560 (printk_legacy_map-wait-type-override){....}-{3:3}, at: console_emit_next_record+0x1df/0x4c0 [ 9.265732][ T175] irq event stamp: 34450 [ 9.265733][ T175] hardirqs last enabled at (34449): [] __down_trylock_console_sem+0x86/0xa0 [ 9.265735][ T175] hardirqs last disabled at (34450): [] console_emit_next_record+0x3d4/0x4c0 [ 9.265737][ T175] softirqs last enabled at (33072): [] handle_softirqs+0x67c/0x900 [ 9.265740][ T175] softirqs last disabled at (32875): [] __irq_exit_rcu+0x145/0x1c0 [ 9.265742][ T175] Preemption disabled at: [ 9.265742][ T175] [<0000000000000000>] 0x0 [ 9.265749][ T175] CPU: 3 UID: 0 PID: 175 Comm: ip Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 9.265753][ T175] Tainted: [W]=WARN [ 9.265754][ T175] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 9.265755][ T175] Call Trace: [ 9.265757][ T175] [ 9.265758][ T175] dump_stack_lvl+0x6f/0xa0 [ 9.265764][ T175] __might_resched.cold+0x1fe/0x2c1 [ 9.265769][ T175] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 9.265773][ T175] ? __kmalloc_noprof+0xdb/0x760 [ 9.265777][ T175] __kmalloc_noprof+0x443/0x760 [ 9.265780][ T175] ? alloc_buf.isra.0+0x4b/0x260 [ 9.265786][ T175] ? do_raw_spin_unlock+0x59/0x250 [ 9.265788][ T175] alloc_buf.isra.0+0x4b/0x260 [ 9.265792][ T175] put_chars+0x1e1/0x2f0 [ 9.265795][ T175] ? __send_to_port+0x420/0x420 [ 9.265796][ T175] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 9.265801][ T175] ? validate_chain+0x38b/0xc20 [ 9.265806][ T175] hvc_console_print+0x292/0x780 [ 9.265813][ T175] ? hvc_write+0x3a0/0x3a0 [ 9.265815][ T175] ? rcu_is_watching+0x16/0xd0 [ 9.265817][ T175] ? lock_acquire+0x13c/0x160 [ 9.265821][ T175] console_emit_next_record+0x22f/0x4c0 [ 9.265825][ T175] ? devkmsg_read+0x4b0/0x4b0 [ 9.265827][ T175] ? console_flush_one_record+0x106/0x710 [ 9.265830][ T175] ? rcu_is_watching+0x16/0xd0 [ 9.265832][ T175] ? lock_acquire+0x13c/0x160 [ 9.265836][ T175] console_flush_one_record+0x46f/0x710 [ 9.265840][ T175] ? console_emit_next_record+0x4c0/0x4c0 [ 9.265842][ T175] ? __lock_acquire+0x518/0xc20 [ 9.265847][ T175] console_unlock+0xee/0x1f0 [ 9.265849][ T175] ? console_flush_one_record+0x710/0x710 [ 9.265851][ T175] ? rcu_is_watching+0x16/0xd0 [ 9.265853][ T175] ? lock_acquire+0x60/0x160 [ 9.265857][ T175] ? __down_trylock_console_sem+0x5e/0xa0 [ 9.265859][ T175] ? vprintk_emit+0x320/0x3e0 [ 9.265862][ T175] vprintk_emit+0x37c/0x3e0 [ 9.265865][ T175] ? wake_up_klogd_work_func+0x90/0x90 [ 9.265869][ T175] ? __lock_acquire+0x518/0xc20 [ 9.265872][ T175] _printk+0xc7/0x100 [ 9.265876][ T175] ? snapshot_read.cold+0x21/0x21 [ 9.265878][ T175] ? do_raw_spin_lock+0x131/0x280 [ 9.265881][ T175] ? __rwlock_init+0x150/0x150 [ 9.265885][ T175] ? do_raw_spin_lock+0x131/0x280 [ 9.265887][ T175] do_exit.cold+0x82/0x9c [ 9.265891][ T175] ? exit_notify+0x890/0x890 [ 9.265892][ T175] ? __lock_release.isra.0+0x69/0x1a0 [ 9.265895][ T175] ? rcu_is_watching+0x16/0xd0 [ 9.265899][ T175] do_group_exit+0xb8/0x370 [ 9.265902][ T175] __x64_sys_exit_group+0x3c/0x50 [ 9.265903][ T175] x64_sys_call+0x1567/0x1570 [ 9.265906][ T175] do_syscall_64+0xff/0x530 [ 9.265910][ T175] ? exc_page_fault+0xee/0x100 [ 9.265912][ T175] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 9.265915][ T175] RIP: 0033:0x7f92866181b8 [ 9.265917][ T175] Code: Unable to access opcode bytes at 0x7f928661818e. [ 9.265918][ T175] RSP: 002b:00007ffcda930f88 EFLAGS: 00000246 ORIG_RAX: 00000000000000e7 [ 9.265920][ T175] RAX: ffffffffffffffda RBX: 00007f9286748f88 RCX: 00007f92866181b8 [ 9.265922][ T175] RDX: 00007f9286362fc8 RSI: fffffffffffffeb8 RDI: 0000000000000000 [ 9.265923][ T175] RBP: 00007ffcda930fe0 R08: 0000000000000000 R09: 0000000000000050 [ 9.265923][ T175] R10: 00007ffcda930da0 R11: 0000000000000246 R12: 0000000000000001 [ 9.265924][ T175] R13: 0000000000000000 R14: 00007f9286747680 R15: 00007f9286748fa0 [ 9.265931][ T175] [ 11.593406][ T215] ns3br1: port 1(ns3eth1) entered blocking state [ 11.593530][ T215] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 11.593533][ T215] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 215, name: ip [ 11.593535][ T215] preempt_count: 1, expected: 0 [ 11.593536][ T215] RCU nest depth: 0, expected: 0 [ 11.593538][ T215] locks held by ip/215: 5, last CPU#3: [ 11.593541][ T215] #0: ffffffffa32e3740 (rtnl_mutex){+.+.}-{4:4}, at: rtnl_newlink+0x9a8/0x11c0 [ 11.593556][ T215] #1: ffffffffa2b79cc0 (console_lock){+.+.}-{0:0}, at: vprintk_emit+0x320/0x3e0 [ 11.593565][ T215] #2: ffffffffa2b79d38 (console_srcu){....}-{0:0}, at: console_flush_one_record+0x106/0x710 [ 11.593570][ T215] #3: ffffffffa2a99660 (console_owner){....}-{0:0}, at: console_lock_spinning_enable+0x40/0x60 [ 11.593576][ T215] #4: ffffffffa2a99560 (printk_legacy_map-wait-type-override){....}-{3:3}, at: console_emit_next_record+0x1df/0x4c0 [ 11.593582][ T215] irq event stamp: 21730 [ 11.593583][ T215] hardirqs last enabled at (21729): [] __down_trylock_console_sem+0x86/0xa0 [ 11.593587][ T215] hardirqs last disabled at (21730): [] console_emit_next_record+0x3d4/0x4c0 [ 11.593590][ T215] softirqs last enabled at (21656): [] addrconf_permanent_addr+0x2b1/0x9c0 [ 11.593595][ T215] softirqs last disabled at (21654): [] addrconf_permanent_addr+0x108/0x9c0 [ 11.593598][ T215] Preemption disabled at: [ 11.593599][ T215] [] vprintk_emit+0x31b/0x3e0 [ 11.593607][ T215] CPU: 3 UID: 0 PID: 215 Comm: ip Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 11.593611][ T215] Tainted: [W]=WARN [ 11.593613][ T215] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 11.593615][ T215] Call Trace: [ 11.593617][ T215] [ 11.593620][ T215] dump_stack_lvl+0x6f/0xa0 [ 11.593627][ T215] ? vprintk_emit+0x31b/0x3e0 [ 11.593630][ T215] __might_resched.cold+0x1fe/0x2c1 [ 11.593636][ T215] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 11.593642][ T215] ? __kmalloc_noprof+0xdb/0x760 [ 11.593650][ T215] __kmalloc_noprof+0x443/0x760 [ 11.593653][ T215] ? alloc_buf.isra.0+0x4b/0x260 [ 11.593662][ T215] ? do_raw_spin_unlock+0x59/0x250 [ 11.593665][ T215] alloc_buf.isra.0+0x4b/0x260 [ 11.593670][ T215] put_chars+0x1e1/0x2f0 [ 11.593675][ T215] ? __send_to_port+0x420/0x420 [ 11.593677][ T215] ? check_prev_add+0x316/0xe90 [ 11.593684][ T215] ? validate_chain+0x34a/0xc20 [ 11.593690][ T215] hvc_console_print+0x292/0x780 [ 11.593694][ T215] ? mark_usage+0x61/0x170 [ 11.593697][ T215] ? __lock_acquire+0x518/0xc20 [ 11.593699][ T215] ? __lock_acquire+0x518/0xc20 [ 11.593707][ T215] ? hvc_write+0x3a0/0x3a0 [ 11.593709][ T215] ? lock_acquire.part.0+0xd4/0x280 [ 11.593716][ T215] ? lock_acquire+0x13c/0x160 [ 11.593723][ T215] console_emit_next_record+0x22f/0x4c0 [ 11.593729][ T215] ? devkmsg_read+0x4b0/0x4b0 [ 11.593732][ T215] ? console_flush_one_record+0x106/0x710 [ 11.593737][ T215] ? rcu_is_watching+0x16/0xd0 [ 11.593742][ T215] ? lock_acquire+0x13c/0x160 [ 11.593749][ T215] console_flush_one_record+0x46f/0x710 [ 11.593755][ T215] ? console_emit_next_record+0x4c0/0x4c0 [ 11.593758][ T215] ? __lock_acquire+0x518/0xc20 [ 11.593767][ T215] console_unlock+0xee/0x1f0 [ 11.593771][ T215] ? console_flush_one_record+0x710/0x710 [ 11.593774][ T215] ? rcu_is_watching+0x16/0xd0 [ 11.593777][ T215] ? lock_acquire+0x60/0x160 [ 11.593783][ T215] ? __down_trylock_console_sem+0x5e/0xa0 [ 11.593786][ T215] ? vprintk_emit+0x320/0x3e0 [ 11.593791][ T215] vprintk_emit+0x37c/0x3e0 [ 11.593797][ T215] ? wake_up_klogd_work_func+0x90/0x90 [ 11.593801][ T215] ? __lock_release.isra.0+0x69/0x1a0 [ 11.593803][ T215] ? _raw_spin_unlock_irqrestore+0x40/0x80 [ 11.593808][ T215] ? mark_held_locks+0x40/0x70 [ 11.593814][ T215] _printk+0xc7/0x100 [ 11.593818][ T215] ? snapshot_read.cold+0x21/0x21 [ 11.593824][ T215] ? br_multicast_flood+0x960/0x960 [ 11.593827][ T215] ? do_setlink.isra.0+0xa31/0x2750 [ 11.593830][ T215] ? rtnl_newlink+0x9f1/0x11c0 [ 11.593832][ T215] ? rtnetlink_rcv_msg+0x6fd/0xbd0 [ 11.593839][ T215] br_set_state+0x22f/0x410 [ 11.593845][ T215] br_init_port+0xc4/0x200 [ 11.593850][ T215] new_nbp+0x39c/0x580 [ 11.593856][ T215] br_add_if+0x212/0x1360 [ 11.593860][ T215] ? kernel_text_address+0x149/0x170 [ 11.593865][ T215] ? __kernel_text_address+0x12/0x30 [ 11.593871][ T215] do_set_master+0x357/0x580 [ 11.593874][ T215] ? netif_change_flags+0xfe/0x190 [ 11.593880][ T215] do_setlink.isra.0+0xa31/0x2750 [ 11.593885][ T215] ? stack_trace_save+0x93/0xc0 [ 11.593889][ T215] ? rtnl_link_get_size+0x350/0x350 [ 11.593891][ T215] ? rcu_read_lock_any_held+0x66/0x90 [ 11.593895][ T215] ? stack_depot_save_flags+0x38e/0x790 [ 11.593900][ T215] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 11.593904][ T215] ? rcu_read_lock_any_held+0x3c/0x90 [ 11.593906][ T215] ? validate_chain+0x38b/0xc20 [ 11.593911][ T215] ? kasan_save_stack+0x3d/0x50 [ 11.593914][ T215] ? kasan_save_stack+0x2f/0x50 [ 11.593916][ T215] ? kasan_save_track+0x14/0x30 [ 11.593921][ T215] ? __lock_acquire+0x518/0xc20 [ 11.593924][ T215] ? __netlink_deliver_tap+0x24e/0x9b0 [ 11.593928][ T215] ? ___sys_sendmsg+0x70/0x1d0 [ 11.593936][ T215] ? lock_acquire.part.0+0xd4/0x280 [ 11.593939][ T215] ? rtnl_newlink+0x9a8/0x11c0 [ 11.593943][ T215] ? rcu_is_watching+0x16/0xd0 [ 11.593947][ T215] ? lock_acquire+0x13c/0x160 [ 11.593949][ T215] ? rcu_is_watching+0x16/0xd0 [ 11.593952][ T215] ? rcu_is_watching+0x16/0xd0 [ 11.593955][ T215] ? trace_contention_end+0xb3/0x180 [ 11.593960][ T215] ? __mutex_lock+0x1db/0x1ea0 [ 11.593963][ T215] ? __mutex_lock+0x9a3/0x1ea0 [ 11.593967][ T215] ? rtnl_newlink+0x9a8/0x11c0 [ 11.593973][ T215] ? ww_mutex_lock+0x160/0x160 [ 11.593976][ T215] ? nla_get_range_signed+0x3d0/0x3d0 [ 11.593985][ T215] ? __rtnl_newlink+0x3fa/0xa50 [ 11.593995][ T215] rtnl_newlink+0x9f1/0x11c0 [ 11.594004][ T215] ? rtnl_bridge_getlink+0x850/0x850 [ 11.594007][ T215] ? __lock_acquire+0x518/0xc20 [ 11.594015][ T215] ? lock_acquire.part.0+0xd4/0x280 [ 11.594018][ T215] ? find_held_lock+0x2b/0x80 [ 11.594021][ T215] ? rtnl_bridge_getlink+0x850/0x850 [ 11.594024][ T215] ? __lock_release.isra.0+0x69/0x1a0 [ 11.594031][ T215] ? rtnl_bridge_getlink+0x850/0x850 [ 11.594034][ T215] rtnetlink_rcv_msg+0x6fd/0xbd0 [ 11.594040][ T215] ? rtnl_link_fill+0x920/0x920 [ 11.594042][ T215] ? __lock_acquire+0x518/0xc20 [ 11.594050][ T215] ? lock_acquire.part.0+0xd4/0x280 [ 11.594052][ T215] ? find_held_lock+0x2b/0x80 [ 11.594058][ T215] netlink_rcv_skb+0x14e/0x3a0 [ 11.594062][ T215] ? rtnl_link_fill+0x920/0x920 [ 11.594067][ T215] ? netlink_ack+0xcf0/0xcf0 [ 11.594078][ T215] ? netlink_deliver_tap+0xc5/0x330 [ 11.594080][ T215] ? netlink_deliver_tap+0x13c/0x330 [ 11.594088][ T215] netlink_unicast+0x486/0x750 [ 11.594095][ T215] ? netlink_attachskb+0x810/0x810 [ 11.594099][ T215] ? __lock_acquire+0x518/0xc20 [ 11.594107][ T215] netlink_sendmsg+0x735/0xc60 [ 11.594113][ T215] ? netlink_unicast+0x750/0x750 [ 11.594120][ T215] ? __might_fault+0x97/0x140 [ 11.594128][ T215] ____sys_sendmsg+0x415/0x880 [ 11.594132][ T215] ? copy_msghdr_from_user+0x279/0x420 [ 11.594136][ T215] ? get_timestamp.constprop.0+0x390/0x390 [ 11.594138][ T215] ? move_addr_to_kernel+0x40/0x40 [ 11.594151][ T215] ___sys_sendmsg+0x14e/0x1d0 [ 11.594156][ T215] ? copy_msghdr_from_user+0x420/0x420 [ 11.594185][ T215] __sys_sendmsg+0x12c/0x1d0 [ 11.594190][ T215] ? __sys_sendmsg_sock+0x20/0x20 [ 11.594201][ T215] ? rcu_is_watching+0x16/0xd0 [ 11.594207][ T215] do_syscall_64+0xff/0x530 [ 11.594211][ T215] ? exc_page_fault+0xee/0x100 [ 11.594215][ T215] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 11.594219][ T215] RIP: 0033:0x7f233744954e [ 11.594224][ T215] 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.594226][ T215] RSP: 002b:00007ffcab0af200 EFLAGS: 00000202 ORIG_RAX: 000000000000002e [ 11.594229][ T215] RAX: ffffffffffffffda RBX: 0000000000000004 RCX: 00007f233744954e [ 11.594231][ T215] RDX: 0000000000000000 RSI: 00007ffcab0af2b0 RDI: 0000000000000005 [ 11.594233][ T215] RBP: 00007ffcab0af210 R08: 0000000000000000 R09: 0000000000000000 [ 11.594234][ T215] R10: 0000000000000000 R11: 0000000000000202 R12: 000000006a90dffd [ 11.594236][ T215] R13: 00000000004a1620 R14: 0000000000000000 R15: 00007ffcab0af980 [ 11.594249][ T215] [ 11.649978][ T215] ns3br1: port 1(ns3eth1) entered disabled state [ 11.650583][ T215] ns3eth1: entered allmulticast mode [ 11.652547][ T215] ns3eth1: entered promiscuous mode [ 11.655471][ T59] ns3br1: port 1(ns3eth1) entered blocking state [ 11.655864][ T59] ns3br1: port 1(ns3eth1) entered forwarding state [ 11.671238][ T215] ip (215) used greatest stack depth: 23336 bytes left [ 11.693389][ T216] ns3br1: port 2(ns3eth2) entered blocking state [ 11.693717][ T216] ns3br1: port 2(ns3eth2) entered disabled state [ 11.694032][ T216] ns3eth2: entered allmulticast mode [ 11.695115][ T216] ns3eth2: entered promiscuous mode [ 11.727065][ T217] ns3br1: port 3(ns3eth3) entered blocking state [ 11.727361][ T217] ns3br1: port 3(ns3eth3) entered disabled state [ 11.727635][ T217] ns3eth3: entered allmulticast mode [ 11.728589][ T217] ns3eth3: entered promiscuous mode [ 11.765576][ T46] ns3br1: port 2(ns3eth2) entered blocking state [ 11.765943][ T46] ns3br1: port 2(ns3eth2) entered forwarding state [ 11.808905][ T59] ns3br1: port 3(ns3eth3) entered blocking state [ 11.809405][ T59] ns3br1: port 3(ns3eth3) entered forwarding state [ 12.252845][ T231] ns1eth1: entered promiscuous mode [ 12.253793][ T231] ns1eth2: entered promiscuous mode [ 12.299304][ T232] ns2eth1: entered promiscuous mode [ 12.300434][ T232] ns2eth2: entered promiscuous mode [ 12.301072][ T232] ns2eth3: entered promiscuous mode [ 13.400648][ C0] clocksource: Watchdog remote CPU 1 read timed out [ 13.400697][ C0] [ 13.400699][ C0] ======================================================== [ 13.400700][ C0] WARNING: possible irq lock inversion dependency detected [ 13.400702][ C0] 7.2.0-virtme #1 Tainted: G W [ 13.400704][ C0] -------------------------------------------------------- [ 13.400704][ C0] swapper/0/0 just changed the state of lock: [ 13.400705][ C0] ffffffffa2a99660 (console_owner){..-.}-{0:0}, at: console_lock_spinning_enable+0x40/0x60 [ 13.400718][ C0] but this lock took another, SOFTIRQ-unsafe lock in the past: [ 13.400720][ C0] (fs_reclaim){+.+.}-{0:0} [ 13.400721][ C0] [ 13.400721][ C0] [ 13.400721][ C0] and interrupts could create inverse lock ordering between them. [ 13.400721][ C0] [ 13.400722][ C0] [ 13.400722][ C0] other info that might help us debug this: [ 13.400722][ C0] Possible interrupt unsafe locking scenario: [ 13.400722][ C0] [ 13.400723][ C0] CPU0 CPU1 [ 13.400724][ C0] ---- ---- [ 13.400724][ C0] lock(fs_reclaim); [ 13.400725][ C0] local_irq_disable(); [ 13.400726][ C0] lock(console_owner); [ 13.400726][ C0] lock(fs_reclaim); [ 13.400727][ C0] [ 13.400727][ C0] lock(console_owner); [ 13.400728][ C0] [ 13.400728][ C0] *** DEADLOCK *** [ 13.400728][ C0] [ 13.400729][ C0] locks held by swapper/0/0: 4, last CPU#0: [ 13.400730][ C0] #0: ffa0000000007c90 ((&watchdog_timer)){+.-.}-{0:0}, at: call_timer_fn+0x110/0x4d0 [ 13.400736][ C0] #1: ffffffffa2bde8b8 (watchdog_lock){+.-.}-{3:3}, at: clocksource_watchdog+0x15/0x30 [ 13.400739][ C0] #2: ffffffffa2b79cc0 (console_lock){+.+.}-{0:0}, at: vprintk_emit+0x320/0x3e0 [ 13.400743][ C0] #3: ffffffffa2b79d38 (console_srcu){....}-{0:0}, at: console_flush_one_record+0x106/0x710 [ 13.400746][ C0] [ 13.400746][ C0] the shortest dependencies between 2nd lock and 1st lock: [ 13.400750][ C0] -> (fs_reclaim){+.+.}-{0:0} { [ 13.400753][ C0] HARDIRQ-ON-W at: [ 13.400754][ C0] __lock_acquire+0x388/0xc20 [ 13.400758][ C0] lock_acquire.part.0+0xd4/0x280 [ 13.400759][ C0] fs_reclaim_acquire+0xd5/0x120 [ 13.400762][ C0] __kmalloc_cache_noprof+0x6e/0x620 [ 13.400764][ C0] kthread_create_worker_on_node+0xea/0x210 [ 13.400767][ C0] workqueue_init+0x2a/0x680 [ 13.400771][ C0] kernel_init_freeable+0x2fe/0x630 [ 13.400774][ C0] kernel_init+0x21/0x150 [ 13.400777][ C0] ret_from_fork+0x474/0x6b0 [ 13.400780][ C0] ret_from_fork_asm+0x11/0x20 [ 13.400783][ C0] SOFTIRQ-ON-W at: [ 13.400784][ C0] __lock_acquire+0x388/0xc20 [ 13.400786][ C0] lock_acquire.part.0+0xd4/0x280 [ 13.400787][ C0] fs_reclaim_acquire+0xd5/0x120 [ 13.400788][ C0] __kmalloc_cache_noprof+0x6e/0x620 [ 13.400789][ C0] kthread_create_worker_on_node+0xea/0x210 [ 13.400791][ C0] workqueue_init+0x2a/0x680 [ 13.400792][ C0] kernel_init_freeable+0x2fe/0x630 [ 13.400793][ C0] kernel_init+0x21/0x150 [ 13.400795][ C0] ret_from_fork+0x474/0x6b0 [ 13.400796][ C0] ret_from_fork_asm+0x11/0x20 [ 13.400797][ C0] INITIAL USE at: [ 13.400798][ C0] __lock_acquire+0x388/0xc20 [ 13.400799][ C0] lock_acquire.part.0+0xd4/0x280 [ 13.400801][ C0] fs_reclaim_acquire+0xd5/0x120 [ 13.400802][ C0] __kmalloc_cache_noprof+0x6e/0x620 [ 13.400803][ C0] kthread_create_worker_on_node+0xea/0x210 [ 13.400804][ C0] workqueue_init+0x2a/0x680 [ 13.400806][ C0] kernel_init_freeable+0x2fe/0x630 [ 13.400807][ C0] kernel_init+0x21/0x150 [ 13.400808][ C0] ret_from_fork+0x474/0x6b0 [ 13.400810][ C0] ret_from_fork_asm+0x11/0x20 [ 13.400811][ C0] } [ 13.400811][ C0] ... key at: [] __fs_reclaim_map+0x0/0xbe0 [ 13.400815][ C0] ... acquired at: [ 13.400816][ C0] __lock_acquire+0x518/0xc20 [ 13.400817][ C0] lock_acquire.part.0+0xd4/0x280 [ 13.400818][ C0] fs_reclaim_acquire+0xd5/0x120 [ 13.400819][ C0] __kmalloc_noprof+0xd3/0x760 [ 13.400821][ C0] alloc_buf.isra.0+0x4b/0x260 [ 13.400824][ C0] put_chars+0x1e1/0x2f0 [ 13.400826][ C0] hvc_console_print+0x292/0x780 [ 13.400828][ C0] console_emit_next_record+0x22f/0x4c0 [ 13.400830][ C0] console_flush_one_record+0x46f/0x710 [ 13.400831][ C0] console_unlock+0xee/0x1f0 [ 13.400833][ C0] vprintk_emit+0x37c/0x3e0 [ 13.400834][ C0] dev_vprintk_emit+0x27f/0x2c0 [ 13.400838][ C0] dev_printk_emit+0xb9/0xee [ 13.400839][ C0] _dev_info+0xe2/0x116 [ 13.400841][ C0] __devm_rtc_register_device.cold+0xc3/0x3a8 [ 13.400844][ C0] cmos_do_probe+0x73b/0x98a [ 13.400845][ C0] platform_probe+0xfe/0x1f0 [ 13.400847][ C0] call_driver_probe+0x61/0x1c0 [ 13.400850][ C0] really_probe+0x199/0x760 [ 13.400851][ C0] __driver_probe_device+0x24f/0x440 [ 13.400853][ C0] driver_probe_device+0x4a/0xf0 [ 13.400854][ C0] __driver_attach+0x1b8/0x540 [ 13.400856][ C0] bus_for_each_dev+0x130/0x1e0 [ 13.400857][ C0] bus_add_driver+0x2c8/0x530 [ 13.400859][ C0] driver_register+0x1a3/0x390 [ 13.400860][ C0] __platform_driver_probe+0x13f/0x270 [ 13.400861][ C0] cmos_init+0x31/0x40 [ 13.400864][ C0] do_one_initcall+0x124/0x4f0 [ 13.400866][ C0] kernel_init_freeable+0x596/0x630 [ 13.400867][ C0] kernel_init+0x21/0x150 [ 13.400868][ C0] ret_from_fork+0x474/0x6b0 [ 13.400869][ C0] ret_from_fork_asm+0x11/0x20 [ 13.400871][ C0] [ 13.400871][ C0] -> (console_owner){..-.}-{0:0} { [ 13.400873][ C0] IN-SOFTIRQ-W at: [ 13.400873][ C0] __lock_acquire+0x388/0xc20 [ 13.400875][ C0] lock_acquire.part.0+0xd4/0x280 [ 13.400876][ C0] console_lock_spinning_enable+0x5c/0x60 [ 13.400878][ C0] console_emit_next_record+0x1d1/0x4c0 [ 13.400879][ C0] console_flush_one_record+0x46f/0x710 [ 13.400881][ C0] console_unlock+0xee/0x1f0 [ 13.400882][ C0] vprintk_emit+0x37c/0x3e0 [ 13.400884][ C0] _printk+0xc7/0x100 [ 13.400887][ C0] clocksource_watchdog.part.0.cold+0x105/0x1dd [ 13.400890][ C0] call_timer_fn+0x160/0x4d0 [ 13.400891][ C0] __run_timers+0x68f/0xaa0 [ 13.400893][ C0] run_timer_softirq+0xf0/0x160 [ 13.400894][ C0] handle_softirqs+0x1d3/0x900 [ 13.400897][ C0] __irq_exit_rcu+0x145/0x1c0 [ 13.400898][ C0] irq_exit_rcu+0xe/0x30 [ 13.400899][ C0] sysvec_apic_timer_interrupt+0x9d/0xe0 [ 13.400901][ C0] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 13.400903][ C0] pv_native_safe_halt+0xf/0x10 [ 13.400904][ C0] default_idle+0x9/0x10 [ 13.400906][ C0] default_idle_call+0x6e/0xb0 [ 13.400907][ C0] cpuidle_idle_call.constprop.0+0x237/0x410 [ 13.400909][ C0] do_idle+0xd8/0x190 [ 13.400911][ C0] cpu_startup_entry+0x53/0x70 [ 13.400912][ C0] rest_init+0x279/0x280 [ 13.400913][ C0] start_kernel+0x3af/0x3b0 [ 13.400915][ C0] x86_64_start_reservations+0x24/0x30 [ 13.400917][ C0] x86_64_start_kernel+0x12b/0x130 [ 13.400918][ C0] common_startup_64+0x13e/0x148 [ 13.400921][ C0] INITIAL USE at: [ 13.400922][ C0] } [ 13.400922][ C0] ... key at: [] console_owner_dep_map+0x0/0x60 [ 13.400926][ C0] ... acquired at: [ 13.400926][ C0] mark_lock+0x1d7/0xa00 [ 13.400927][ C0] mark_usage+0x42/0x170 [ 13.400929][ C0] __lock_acquire+0x388/0xc20 [ 13.400930][ C0] lock_acquire.part.0+0xd4/0x280 [ 13.400931][ C0] console_lock_spinning_enable+0x5c/0x60 [ 13.400933][ C0] console_emit_next_record+0x1d1/0x4c0 [ 13.400934][ C0] console_flush_one_record+0x46f/0x710 [ 13.400936][ C0] console_unlock+0xee/0x1f0 [ 13.400937][ C0] vprintk_emit+0x37c/0x3e0 [ 13.400939][ C0] _printk+0xc7/0x100 [ 13.400940][ C0] clocksource_watchdog.part.0.cold+0x105/0x1dd [ 13.400941][ C0] call_timer_fn+0x160/0x4d0 [ 13.400943][ C0] __run_timers+0x68f/0xaa0 [ 13.400944][ C0] run_timer_softirq+0xf0/0x160 [ 13.400946][ C0] handle_softirqs+0x1d3/0x900 [ 13.400947][ C0] __irq_exit_rcu+0x145/0x1c0 [ 13.400948][ C0] irq_exit_rcu+0xe/0x30 [ 13.400949][ C0] sysvec_apic_timer_interrupt+0x9d/0xe0 [ 13.400950][ C0] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 13.400951][ C0] pv_native_safe_halt+0xf/0x10 [ 13.400952][ C0] default_idle+0x9/0x10 [ 13.400954][ C0] default_idle_call+0x6e/0xb0 [ 13.400955][ C0] cpuidle_idle_call.constprop.0+0x237/0x410 [ 13.400956][ C0] do_idle+0xd8/0x190 [ 13.400957][ C0] cpu_startup_entry+0x53/0x70 [ 13.400958][ C0] rest_init+0x279/0x280 [ 13.400959][ C0] start_kernel+0x3af/0x3b0 [ 13.400961][ C0] x86_64_start_reservations+0x24/0x30 [ 13.400962][ C0] x86_64_start_kernel+0x12b/0x130 [ 13.400964][ C0] common_startup_64+0x13e/0x148 [ 13.400965][ C0] [ 13.400965][ C0] [ 13.400965][ C0] stack backtrace: [ 13.400969][ C0] CPU: 0 UID: 0 PID: 0 Comm: swapper/0 Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 13.400972][ C0] Tainted: [W]=WARN [ 13.400973][ C0] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 13.400974][ C0] Call Trace: [ 13.400975][ C0] [ 13.400977][ C0] dump_stack_lvl+0x6f/0xa0 [ 13.400981][ C0] print_irq_inversion_bug.part.0.cold+0xe6/0x143 [ 13.400983][ C0] mark_lock_irq+0x989/0x9c0 [ 13.400985][ C0] ? add_lock_to_list+0x2c/0x1a0 [ 13.400988][ C0] mark_lock+0x1d7/0xa00 [ 13.400989][ C0] mark_usage+0x42/0x170 [ 13.400991][ C0] __lock_acquire+0x388/0xc20 [ 13.400993][ C0] lock_acquire.part.0+0xd4/0x280 [ 13.400995][ C0] ? console_lock_spinning_enable+0x40/0x60 [ 13.400997][ C0] ? rcu_is_watching+0x16/0xd0 [ 13.401000][ C0] ? lock_acquire+0x13c/0x160 [ 13.401002][ C0] console_lock_spinning_enable+0x5c/0x60 [ 13.401004][ C0] ? console_lock_spinning_enable+0x40/0x60 [ 13.401005][ C0] console_emit_next_record+0x1d1/0x4c0 [ 13.401007][ C0] ? devkmsg_read+0x4b0/0x4b0 [ 13.401009][ C0] ? console_flush_one_record+0x106/0x710 [ 13.401011][ C0] ? rcu_is_watching+0x16/0xd0 [ 13.401013][ C0] ? lock_acquire+0x13c/0x160 [ 13.401014][ C0] console_flush_one_record+0x46f/0x710 [ 13.401017][ C0] ? console_emit_next_record+0x4c0/0x4c0 [ 13.401018][ C0] ? __lock_acquire+0x518/0xc20 [ 13.401020][ C0] console_unlock+0xee/0x1f0 [ 13.401022][ C0] ? console_flush_one_record+0x710/0x710 [ 13.401024][ C0] ? rcu_is_watching+0x16/0xd0 [ 13.401026][ C0] ? lock_acquire+0x60/0x160 [ 13.401027][ C0] ? __down_trylock_console_sem+0x5e/0xa0 [ 13.401029][ C0] ? vprintk_emit+0x320/0x3e0 [ 13.401031][ C0] vprintk_emit+0x37c/0x3e0 [ 13.401033][ C0] ? wake_up_klogd_work_func+0x90/0x90 [ 13.401035][ C0] ? clocksource_watchdog.part.0+0x450/0x540 [ 13.401037][ C0] _printk+0xc7/0x100 [ 13.401039][ C0] ? snapshot_read.cold+0x21/0x21 [ 13.401041][ C0] ? clocksource_watchdog.part.0+0x450/0x540 [ 13.401042][ C0] ? __lock_release.isra.0+0x69/0x1a0 [ 13.401045][ C0] clocksource_watchdog.part.0.cold+0x105/0x1dd [ 13.401046][ C0] ? clocksource_watchdog.part.0+0x540/0x540 [ 13.401048][ C0] ? clocksource_watchdog.part.0+0x540/0x540 [ 13.401049][ C0] call_timer_fn+0x160/0x4d0 [ 13.401051][ C0] ? detach_if_pending+0x1d0/0x1d0 [ 13.401053][ C0] ? debug_object_active_state+0x430/0x430 [ 13.401056][ C0] ? find_held_lock+0x2b/0x80 [ 13.401058][ C0] ? __lock_release.isra.0+0x69/0x1a0 [ 13.401060][ C0] ? rcu_is_watching+0x16/0xd0 [ 13.401062][ C0] __run_timers+0x68f/0xaa0 [ 13.401064][ C0] ? clocksource_watchdog.part.0+0x540/0x540 [ 13.401066][ C0] ? __bpf_trace_itimer_expire+0x10/0x10 [ 13.401068][ C0] ? __lock_acquire+0x518/0xc20 [ 13.401070][ C0] ? __rwlock_init+0x150/0x150 [ 13.401073][ C0] run_timer_softirq+0xf0/0x160 [ 13.401074][ C0] ? __run_timers+0xaa0/0xaa0 [ 13.401076][ C0] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 13.401078][ C0] ? rcu_is_watching+0x16/0xd0 [ 13.401080][ C0] handle_softirqs+0x1d3/0x900 [ 13.401082][ C0] ? __lock_release.isra.0+0x69/0x1a0 [ 13.401084][ C0] ? _local_bh_enable+0xc0/0xc0 [ 13.401086][ C0] __irq_exit_rcu+0x145/0x1c0 [ 13.401087][ C0] irq_exit_rcu+0xe/0x30 [ 13.401088][ C0] sysvec_apic_timer_interrupt+0x9d/0xe0 [ 13.401090][ C0] [ 13.401090][ C0] [ 13.401091][ C0] ? lockdep_hardirqs_on_prepare.part.0+0x9a/0x160 [ 13.401092][ C0] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 13.401094][ C0] RIP: 0010:pv_native_safe_halt+0xf/0x10 [ 13.401096][ C0] Code: 48 8b 3d 94 12 06 02 e8 1f 00 00 00 48 2b 05 58 13 a0 00 c3 0f 1f 80 00 00 00 00 f3 0f 1e fa eb 07 0f 00 2d 13 b6 17 00 fb f4 0f 1f 40 d6 48 83 ec 20 8b 17 49 89 f8 83 e2 fe 41 89 d2 0f 01 [ 13.401098][ C0] RSP: 0018:ffffffffa2807cf8 EFLAGS: 00000296 [ 13.401100][ C0] RAX: 0000000000065de3 RBX: ffffffffa282c600 RCX: ffffffff9f6fa307 [ 13.401102][ C0] RDX: ffffffffa282c600 RSI: ffffffffa2678e9d RDI: ffffffffa208dce0 [ 13.401102][ C0] RBP: 0000000000000000 R08: 0000000000000000 R09: 0000000000000000 [ 13.401103][ C0] R10: 0000000000000000 R11: 0000000000000001 R12: 1ffffffff4500fa2 [ 13.401104][ C0] R13: 0000000000000000 R14: dffffc0000000000 R15: 0000000000014770 [ 13.401106][ C0] ? cpuidle_idle_call.constprop.0+0x237/0x410 [ 13.401108][ C0] ? lockdep_hardirqs_on+0x91/0x130 [ 13.401109][ C0] default_idle+0x9/0x10 [ 13.401110][ C0] default_idle_call+0x6e/0xb0 [ 13.401112][ C0] cpuidle_idle_call.constprop.0+0x237/0x410 [ 13.401113][ C0] ? arch_cpu_idle_exit+0x40/0x40 [ 13.401115][ C0] ? mark_tsc_async_resets+0x30/0x30 [ 13.401117][ C0] ? rcu_is_watching+0x16/0xd0 [ 13.401119][ C0] do_idle+0xd8/0x190 [ 13.401121][ C0] cpu_startup_entry+0x53/0x70 [ 13.401122][ C0] rest_init+0x279/0x280 [ 13.401124][ C0] ? __cpuidle_text_end+0x3b/0x3b [ 13.401126][ C0] ? rest_init+0x280/0x280 [ 13.401128][ C0] ? acpi_hw_set_mode+0x4a0/0x4a0 [ 13.401130][ C0] ? cpus_read_unlock+0x4f/0xc0 [ 13.401133][ C0] ? acpi_enable+0x1e4/0x330 [ 13.401136][ C0] start_kernel+0x3af/0x3b0 [ 13.401138][ C0] x86_64_start_reservations+0x24/0x30 [ 13.401139][ C0] x86_64_start_kernel+0x12b/0x130 [ 13.401141][ C0] common_startup_64+0x13e/0x148 [ 13.401144][ C0] [ 13.401148][ C0] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 13.401150][ C0] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 0, name: swapper/0 [ 13.401151][ C0] preempt_count: 103, expected: 0 [ 13.401152][ C0] RCU nest depth: 0, expected: 0 [ 13.401153][ C0] INFO: lockdep is turned off. [ 13.401153][ C0] irq event stamp: 417267 [ 13.401154][ C0] hardirqs last enabled at (417266): [] __down_trylock_console_sem+0x86/0xa0 [ 13.401156][ C0] hardirqs last disabled at (417267): [] console_emit_next_record+0x3d4/0x4c0 [ 13.401158][ C0] softirqs last enabled at (417228): [] handle_softirqs+0x67c/0x900 [ 13.401159][ C0] softirqs last disabled at (417253): [] __irq_exit_rcu+0x145/0x1c0 [ 13.401161][ C0] Preemption disabled at: [ 13.401161][ C0] [] schedule_preempt_disabled+0x22/0x30 [ 13.401164][ C0] CPU: 0 UID: 0 PID: 0 Comm: swapper/0 Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 13.401166][ C0] Tainted: [W]=WARN [ 13.401166][ C0] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 13.401167][ C0] Call Trace: [ 13.401168][ C0] [ 13.401168][ C0] dump_stack_lvl+0x6f/0xa0 [ 13.401170][ C0] ? schedule_preempt_disabled+0x22/0x30 [ 13.401172][ C0] __might_resched.cold+0x1fe/0x2c1 [ 13.401175][ C0] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 13.401177][ C0] ? rcu_is_watching+0x16/0xd0 [ 13.401180][ C0] __kmalloc_noprof+0x443/0x760 [ 13.401181][ C0] ? __rwlock_init+0x150/0x150 [ 13.401183][ C0] ? alloc_buf.isra.0+0x4b/0x260 [ 13.401185][ C0] ? do_raw_spin_unlock+0x59/0x250 [ 13.401186][ C0] alloc_buf.isra.0+0x4b/0x260 [ 13.401188][ C0] put_chars+0x1e1/0x2f0 [ 13.401190][ C0] ? __send_to_port+0x420/0x420 [ 13.401192][ C0] ? mark_lock+0x1d7/0xa00 [ 13.401194][ C0] hvc_console_print+0x292/0x780 [ 13.401197][ C0] ? hvc_write+0x3a0/0x3a0 [ 13.401198][ C0] ? rcu_is_watching+0x16/0xd0 [ 13.401200][ C0] ? rcu_is_watching+0x16/0xd0 [ 13.401202][ C0] console_emit_next_record+0x22f/0x4c0 [ 13.401204][ C0] ? devkmsg_read+0x4b0/0x4b0 [ 13.401206][ C0] ? console_flush_one_record+0x106/0x710 [ 13.401208][ C0] ? rcu_is_watching+0x16/0xd0 [ 13.401210][ C0] ? lock_acquire+0x13c/0x160 [ 13.401212][ C0] console_flush_one_record+0x46f/0x710 [ 13.401214][ C0] ? console_emit_next_record+0x4c0/0x4c0 [ 13.401215][ C0] ? __lock_acquire+0x518/0xc20 [ 13.401218][ C0] console_unlock+0xee/0x1f0 [ 13.401220][ C0] ? console_flush_one_record+0x710/0x710 [ 13.401221][ C0] ? rcu_is_watching+0x16/0xd0 [ 13.401223][ C0] ? lock_acquire+0x60/0x160 [ 13.401225][ C0] ? __down_trylock_console_sem+0x5e/0xa0 [ 13.401226][ C0] ? vprintk_emit+0x320/0x3e0 [ 13.401228][ C0] vprintk_emit+0x37c/0x3e0 [ 13.401230][ C0] ? wake_up_klogd_work_func+0x90/0x90 [ 13.401233][ C0] ? clocksource_watchdog.part.0+0x450/0x540 [ 13.401234][ C0] _printk+0xc7/0x100 [ 13.401236][ C0] ? snapshot_read.cold+0x21/0x21 [ 13.401238][ C0] ? clocksource_watchdog.part.0+0x450/0x540 [ 13.401239][ C0] ? __lock_release.isra.0+0x69/0x1a0 [ 13.401242][ C0] clocksource_watchdog.part.0.cold+0x105/0x1dd [ 13.401243][ C0] ? clocksource_watchdog.part.0+0x540/0x540 [ 13.401245][ C0] ? clocksource_watchdog.part.0+0x540/0x540 [ 13.401246][ C0] call_timer_fn+0x160/0x4d0 [ 13.401248][ C0] ? detach_if_pending+0x1d0/0x1d0 [ 13.401250][ C0] ? debug_object_active_state+0x430/0x430 [ 13.401251][ C0] ? find_held_lock+0x2b/0x80 [ 13.401253][ C0] ? __lock_release.isra.0+0x69/0x1a0 [ 13.401255][ C0] ? rcu_is_watching+0x16/0xd0 [ 13.401257][ C0] __run_timers+0x68f/0xaa0 [ 13.401258][ C0] ? clocksource_watchdog.part.0+0x540/0x540 [ 13.401261][ C0] ? __bpf_trace_itimer_expire+0x10/0x10 [ 13.401262][ C0] ? __lock_acquire+0x518/0xc20 [ 13.401265][ C0] ? __rwlock_init+0x150/0x150 [ 13.401267][ C0] run_timer_softirq+0xf0/0x160 [ 13.401269][ C0] ? __run_timers+0xaa0/0xaa0 [ 13.401270][ C0] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 13.401272][ C0] ? rcu_is_watching+0x16/0xd0 [ 13.401273][ C0] handle_softirqs+0x1d3/0x900 [ 13.401275][ C0] ? __lock_release.isra.0+0x69/0x1a0 [ 13.401277][ C0] ? _local_bh_enable+0xc0/0xc0 [ 13.401278][ C0] __irq_exit_rcu+0x145/0x1c0 [ 13.401280][ C0] irq_exit_rcu+0xe/0x30 [ 13.401281][ C0] sysvec_apic_timer_interrupt+0x9d/0xe0 [ 13.401283][ C0] [ 13.401283][ C0] [ 13.401284][ C0] ? lockdep_hardirqs_on_prepare.part.0+0x9a/0x160 [ 13.401285][ C0] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 13.401287][ C0] RIP: 0010:pv_native_safe_halt+0xf/0x10 [ 13.401288][ C0] Code: 48 8b 3d 94 12 06 02 e8 1f 00 00 00 48 2b 05 58 13 a0 00 c3 0f 1f 80 00 00 00 00 f3 0f 1e fa eb 07 0f 00 2d 13 b6 17 00 fb f4 0f 1f 40 d6 48 83 ec 20 8b 17 49 89 f8 83 e2 fe 41 89 d2 0f 01 [ 13.401289][ C0] RSP: 0018:ffffffffa2807cf8 EFLAGS: 00000296 [ 13.401290][ C0] RAX: 0000000000065de3 RBX: ffffffffa282c600 RCX: ffffffff9f6fa307 [ 13.401291][ C0] RDX: ffffffffa282c600 RSI: ffffffffa2678e9d RDI: ffffffffa208dce0 [ 13.401292][ C0] RBP: 0000000000000000 R08: 0000000000000000 R09: 0000000000000000 [ 13.401292][ C0] R10: 0000000000000000 R11: 0000000000000001 R12: 1ffffffff4500fa2 [ 13.401293][ C0] R13: 0000000000000000 R14: dffffc0000000000 R15: 0000000000014770 [ 13.401294][ C0] ? cpuidle_idle_call.constprop.0+0x237/0x410 [ 13.401296][ C0] ? lockdep_hardirqs_on+0x91/0x130 [ 13.401298][ C0] default_idle+0x9/0x10 [ 13.401299][ C0] default_idle_call+0x6e/0xb0 [ 13.401300][ C0] cpuidle_idle_call.constprop.0+0x237/0x410 [ 13.401302][ C0] ? arch_cpu_idle_exit+0x40/0x40 [ 13.401303][ C0] ? mark_tsc_async_resets+0x30/0x30 [ 13.401305][ C0] ? rcu_is_watching+0x16/0xd0 [ 13.401307][ C0] do_idle+0xd8/0x190 [ 13.401308][ C0] cpu_startup_entry+0x53/0x70 [ 13.401309][ C0] rest_init+0x279/0x280 [ 13.401311][ C0] ? __cpuidle_text_end+0x3b/0x3b [ 13.401313][ C0] ? rest_init+0x280/0x280 [ 13.401315][ C0] ? acpi_hw_set_mode+0x4a0/0x4a0 [ 13.401316][ C0] ? cpus_read_unlock+0x4f/0xc0 [ 13.401318][ C0] ? acpi_enable+0x1e4/0x330 [ 13.401320][ C0] start_kernel+0x3af/0x3b0 [ 13.401322][ C0] x86_64_start_reservations+0x24/0x30 [ 13.401324][ C0] x86_64_start_kernel+0x12b/0x130 [ 13.401325][ C0] common_startup_64+0x13e/0x148 [ 13.401335][ C0] [ 25.061839][ T12] ns1eth1: left promiscuous mode [ 25.061859][ T12] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 25.061862][ T12] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 12, name: kworker/u16:0 [ 25.061864][ T12] preempt_count: 1, expected: 0 [ 25.061866][ T12] RCU nest depth: 0, expected: 0 [ 25.061867][ T12] INFO: lockdep is turned off. [ 25.061868][ T12] irq event stamp: 22664 [ 25.061869][ T12] hardirqs last enabled at (22663): [] _raw_spin_unlock_irq+0x28/0x50 [ 25.061879][ T12] hardirqs last disabled at (22664): [] __schedule+0x1246/0x20e0 [ 25.061883][ T12] softirqs last enabled at (22660): [] __fib6_clean_all+0xff/0x290 [ 25.061887][ T12] softirqs last disabled at (22654): [] __fib6_clean_all+0xd9/0x290 [ 25.061890][ T12] Preemption disabled at: [ 25.061892][ T12] [] vprintk_emit+0x31b/0x3e0 [ 25.061901][ T12] CPU: 0 UID: 0 PID: 12 Comm: kworker/u16:0 Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 25.061906][ T12] Tainted: [W]=WARN [ 25.061907][ T12] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 25.061909][ T12] Workqueue: netns cleanup_net [ 25.061916][ T12] Call Trace: [ 25.061918][ T12] [ 25.061920][ T12] dump_stack_lvl+0x6f/0xa0 [ 25.061926][ T12] ? vprintk_emit+0x31b/0x3e0 [ 25.061929][ T12] __might_resched.cold+0x1fe/0x2c1 [ 25.061934][ T12] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 25.061938][ T12] ? rcu_is_watching+0x16/0xd0 [ 25.061942][ T12] __kmalloc_noprof+0x443/0x760 [ 25.061946][ T12] ? __rwlock_init+0x150/0x150 [ 25.061949][ T12] ? alloc_buf.isra.0+0x4b/0x260 [ 25.061954][ T12] ? do_raw_spin_unlock+0x59/0x250 [ 25.061956][ T12] alloc_buf.isra.0+0x4b/0x260 [ 25.061959][ T12] put_chars+0x1e1/0x2f0 [ 25.061962][ T12] ? __send_to_port+0x420/0x420 [ 25.061964][ T12] ? console_prepend_replay+0x20/0x20 [ 25.061968][ T12] hvc_console_print+0x292/0x780 [ 25.061973][ T12] ? hvc_write+0x3a0/0x3a0 [ 25.061975][ T12] ? rcu_is_watching+0x16/0xd0 [ 25.061977][ T12] ? rcu_is_watching+0x16/0xd0 [ 25.061979][ T12] ? lock_acquire+0x13c/0x160 [ 25.061982][ T12] console_emit_next_record+0x22f/0x4c0 [ 25.061985][ T12] ? devkmsg_read+0x4b0/0x4b0 [ 25.061988][ T12] ? rcu_is_watching+0x16/0xd0 [ 25.061990][ T12] ? rcu_is_watching+0x16/0xd0 [ 25.061992][ T12] ? rcu_is_watching+0x16/0xd0 [ 25.061994][ T12] ? lock_acquire+0x13c/0x160 [ 25.061997][ T12] ? console_flush_one_record+0x111/0x710 [ 25.061999][ T12] console_flush_one_record+0x46f/0x710 [ 25.062002][ T12] ? console_emit_next_record+0x4c0/0x4c0 [ 25.062005][ T12] console_unlock+0xee/0x1f0 [ 25.062008][ T12] ? lock_acquire+0x13c/0x160 [ 25.062009][ T12] ? console_flush_one_record+0x710/0x710 [ 25.062012][ T12] ? rcu_is_watching+0x16/0xd0 [ 25.062014][ T12] ? lock_release+0x184/0x1f0 [ 25.062015][ T12] ? lock_acquire+0x60/0x160 [ 25.062017][ T12] ? __rcu_read_lock+0x30/0x70 [ 25.062020][ T12] ? __down_trylock_console_sem+0x5e/0xa0 [ 25.062022][ T12] ? vprintk_emit+0x320/0x3e0 [ 25.062025][ T12] vprintk_emit+0x37c/0x3e0 [ 25.062028][ T12] ? wake_up_klogd_work_func+0x90/0x90 [ 25.062030][ T12] ? _raw_spin_unlock+0x2d/0x50 [ 25.062032][ T12] ? trace_hardirqs_on+0x36/0x40 [ 25.062035][ T12] ? finish_task_switch.isra.0+0x209/0xa70 [ 25.062038][ T12] _printk+0xc7/0x100 [ 25.062041][ T12] ? snapshot_read.cold+0x21/0x21 [ 25.062044][ T12] ? rcu_is_watching+0x16/0xd0 [ 25.062046][ T12] ? lock_release+0x184/0x1f0 [ 25.062048][ T12] ? netdev_name+0x43/0x60 [ 25.062051][ T12] ? __netdev_printk+0x17f/0x1d0 [ 25.062054][ T12] netdev_info+0xe2/0x116 [ 25.062056][ T12] ? netdev_notice+0x120/0x120 [ 25.062058][ T12] ? synchronize_rcu_expedited+0x440/0x510 [ 25.062060][ T12] ? netif_set_mtu_ext+0x5f0/0x5f0 [ 25.062063][ T12] ? synchronize_rcu_normal+0x340/0x340 [ 25.062065][ T12] ? mutex_is_locked+0x1c/0x50 [ 25.062069][ T12] __dev_set_promiscuity.cold+0x95/0x104 [ 25.062072][ T12] ? sync_rcu_exp_select_cpus+0x700/0x700 [ 25.062074][ T12] ? netdev_sync_lower_features+0x550/0x550 [ 25.062076][ T12] netif_set_promiscuity+0x4c/0xc0 [ 25.062080][ T12] dev_set_promiscuity+0x9d/0x150 [ 25.062083][ T12] hsr_del_port+0x39d/0x540 [ 25.062088][ T12] hsr_del_ports+0x24/0x80 [ 25.062091][ T12] hsr_dellink+0x5d/0x90 [ 25.062094][ T12] default_device_exit_batch+0x19d/0x600 [ 25.062096][ T12] ? generic_xdp_install+0x470/0x470 [ 25.062099][ T12] ? unregister_netdevice_queue+0x470/0x470 [ 25.062101][ T12] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 25.062104][ T12] ? mutex_is_locked+0x1c/0x50 [ 25.062107][ T12] ops_undo_list+0x2ce/0x8f0 [ 25.062111][ T12] ? rtnl_net_dumpid_one+0x2d0/0x2d0 [ 25.062114][ T12] ? idr_destroy+0x121/0x250 [ 25.062118][ T12] cleanup_net+0x431/0x890 [ 25.062121][ T12] ? net_passive_dec+0x230/0x230 [ 25.062123][ T12] ? rcu_is_watching+0x16/0xd0 [ 25.062126][ T12] ? lock_acquire+0x13c/0x160 [ 25.062128][ T12] ? rcu_is_watching+0x16/0xd0 [ 25.062131][ T12] process_one_work+0xe3e/0x1560 [ 25.062137][ T12] ? __queue_delayed_work+0x470/0x470 [ 25.062140][ T12] ? find_held_lock+0x2b/0x80 [ 25.062143][ T12] ? __rwlock_init+0x150/0x150 [ 25.062146][ T12] worker_thread+0x4f1/0xd60 [ 25.062151][ T12] ? rescuer_thread+0x1340/0x1340 [ 25.062153][ T12] kthread+0x367/0x460 [ 25.062156][ T12] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 25.062159][ T12] ? kthread_affine_preferred+0x4c0/0x4c0 [ 25.062161][ T12] ret_from_fork+0x474/0x6b0 [ 25.062165][ T12] ? arch_exit_to_user_mode_prepare.isra.0+0x120/0x120 [ 25.062168][ T12] ? __switch_to+0x5a3/0xe00 [ 25.062172][ T12] ? kthread_affine_preferred+0x4c0/0x4c0 [ 25.062174][ T12] ret_from_fork_asm+0x11/0x20 [ 25.062180][ T12] [ 25.082829][ T12] ns1eth2: left promiscuous mode [ 25.095536][ T12] ns2eth2 (unregistering): left promiscuous mode [ 25.097908][ T12] ns2eth1 (unregistering): left promiscuous mode [ 25.167161][ T12] ns2eth3: left promiscuous mode [ 25.169561][ T12] ns3br1: port 1(ns3eth1) entered disabled state [ 25.173162][ T12] ns3eth1 (unregistering): left allmulticast mode [ 25.173426][ T12] ns3eth1 (unregistering): left promiscuous mode [ 25.173665][ T12] ns3br1: port 1(ns3eth1) entered disabled state [ 25.243537][ T12] ns3eth3: left allmulticast mode [ 25.243702][ T12] ns3eth3: left promiscuous mode [ 25.243897][ T12] ns3br1: port 3(ns3eth3) entered disabled state [ 25.244426][ T12] ns3eth2: left allmulticast mode [ 25.244565][ T12] ns3eth2: left promiscuous mode [ 25.244730][ T12] ns3br1: port 2(ns3eth2) entered disabled state