[ 11.693649][ T200] netdevsim netdevsim296 eni296np1: renamed from eth0 [ 11.693726][ T200] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 11.693728][ T200] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 200, name: (udev-worker) [ 11.693730][ T200] preempt_count: 1, expected: 0 [ 11.693731][ T200] RCU nest depth: 0, expected: 0 [ 11.693732][ T200] locks held by (udev-worker)/200: 6, last CPU#2: [ 11.693734][ T200] #0: ffffffffaf31b740 (rtnl_mutex){+.+.}-{4:4}, at: rtnl_setlink+0x29d/0x920 [ 11.693746][ T200] #1: ff110000021fae10 (&dev_instance_lock_key#8){+.+.}-{4:4}, at: do_setlink.isra.0+0x27a/0x2a60 [ 11.693750][ T200] #2: ffffffffaeb7ddc0 (console_lock){+.+.}-{0:0}, at: vprintk_emit+0x320/0x3e0 [ 11.693755][ T200] #3: ffffffffaeb7de38 (console_srcu){....}-{0:0}, at: console_flush_one_record+0x106/0x710 [ 11.693759][ T200] #4: ffffffffaea9d760 (console_owner){....}-{0:0}, at: console_lock_spinning_enable+0x40/0x60 [ 11.693763][ T200] #5: ffffffffaea9d660 (printk_legacy_map-wait-type-override){....}-{3:3}, at: console_emit_next_record+0x1df/0x4c0 [ 11.693767][ T200] irq event stamp: 30164 [ 11.693768][ T200] hardirqs last enabled at (30163): [] __down_trylock_console_sem+0x86/0xa0 [ 11.693771][ T200] hardirqs last disabled at (30164): [] console_emit_next_record+0x3d4/0x4c0 [ 11.693773][ T200] softirqs last enabled at (30158): [] netif_change_name+0x216/0x8c0 [ 11.693776][ T200] softirqs last disabled at (30156): [] netif_change_name+0x1ad/0x8c0 [ 11.693779][ T200] Preemption disabled at: [ 11.693780][ T200] [] vprintk_emit+0x31b/0x3e0 [ 11.693785][ T200] CPU: 2 UID: 0 PID: 200 Comm: (udev-worker) Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 11.693788][ T200] Tainted: [W]=WARN [ 11.693789][ T200] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 11.693791][ T200] Call Trace: [ 11.693793][ T200] [ 11.693794][ T200] dump_stack_lvl+0x6f/0xa0 [ 11.693801][ T200] ? vprintk_emit+0x31b/0x3e0 [ 11.693802][ T200] __might_resched.cold+0x1fe/0x2c1 [ 11.693807][ T200] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 11.693811][ T200] ? __kmalloc_noprof+0xdb/0x760 [ 11.693816][ T200] __kmalloc_noprof+0x443/0x760 [ 11.693818][ T200] ? alloc_buf.isra.0+0x4b/0x260 [ 11.693825][ T200] ? do_raw_spin_unlock+0x59/0x250 [ 11.693827][ T200] alloc_buf.isra.0+0x4b/0x260 [ 11.693831][ T200] put_chars+0x1e1/0x2f0 [ 11.693834][ T200] ? __send_to_port+0x420/0x420 [ 11.693837][ T200] ? validate_chain+0x34a/0xc20 [ 11.693842][ T200] hvc_console_print+0x292/0x780 [ 11.693847][ T200] ? __lock_acquire+0x518/0xc20 [ 11.693852][ T200] ? hvc_write+0x3a0/0x3a0 [ 11.693856][ T200] ? rcu_is_watching+0x16/0xd0 [ 11.693861][ T200] console_emit_next_record+0x22f/0x4c0 [ 11.693865][ T200] ? devkmsg_read+0x4b0/0x4b0 [ 11.693867][ T200] ? console_flush_one_record+0x106/0x710 [ 11.693870][ T200] ? rcu_is_watching+0x16/0xd0 [ 11.693872][ T200] ? lock_acquire+0x13c/0x160 [ 11.693876][ T200] console_flush_one_record+0x46f/0x710 [ 11.693881][ T200] ? console_emit_next_record+0x4c0/0x4c0 [ 11.693883][ T200] ? __lock_acquire+0x518/0xc20 [ 11.693888][ T200] console_unlock+0xee/0x1f0 [ 11.693891][ T200] ? console_flush_one_record+0x710/0x710 [ 11.693893][ T200] ? rcu_is_watching+0x16/0xd0 [ 11.693895][ T200] ? lock_acquire+0xe0/0x160 [ 11.693899][ T200] ? __down_trylock_console_sem+0x5e/0xa0 [ 11.693900][ T200] ? vprintk_emit+0x320/0x3e0 [ 11.693903][ T200] vprintk_emit+0x37c/0x3e0 [ 11.693907][ T200] ? wake_up_klogd_work_func+0x90/0x90 [ 11.693908][ T200] ? __kernel_text_address+0x12/0x30 [ 11.693911][ T200] ? unwind_get_return_address+0x67/0xd0 [ 11.693915][ T200] ? arch_stack_walk+0xed/0x130 [ 11.693921][ T200] dev_vprintk_emit+0x27f/0x2c0 [ 11.693926][ T200] ? device_rename.cold+0xa/0xa [ 11.693934][ T200] dev_printk_emit+0xb9/0xee [ 11.693937][ T200] ? dev_vprintk_emit+0x2c0/0x2c0 [ 11.693941][ T200] ? check_prev_add+0x316/0xe90 [ 11.693946][ T200] __netdev_printk+0x160/0x1d0 [ 11.693953][ T200] netdev_info+0xe2/0x116 [ 11.693955][ T200] ? netdev_notice+0x120/0x120 [ 11.693958][ T200] ? find_held_lock+0x2b/0x80 [ 11.693962][ T200] ? __lock_release.isra.0+0x69/0x1a0 [ 11.693964][ T200] ? mark_held_locks+0x40/0x70 [ 11.693968][ T200] ? do_setlink.isra.0+0x1f7d/0x2a60 [ 11.693970][ T200] netif_change_name.cold+0x4f/0x89 [ 11.693973][ T200] ? lock_pin_lock+0x87/0x180 [ 11.693976][ T200] ? netdev_adjacent_rename_links+0x470/0x470 [ 11.693979][ T200] ? find_held_lock+0x2b/0x80 [ 11.693982][ T200] ? __asan_memset+0x27/0x50 [ 11.693988][ T200] do_setlink.isra.0+0x1f7d/0x2a60 [ 11.693991][ T200] ? __lock_acquire+0x518/0xc20 [ 11.693994][ T200] ? rtnl_link_get_size+0x350/0x350 [ 11.693995][ T200] ? mark_usage+0x61/0x170 [ 11.694000][ T200] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 11.694002][ T200] ? rcu_read_lock_any_held+0x3c/0x90 [ 11.694005][ T200] ? validate_chain+0x38b/0xc20 [ 11.694009][ T200] ? __lock_acquire+0x518/0xc20 [ 11.694011][ T200] ? lock_pin_lock+0xee/0x180 [ 11.694013][ T200] ? __lock_acquire+0x480/0xc20 [ 11.694017][ T200] ? lock_acquire.part.0+0xd4/0x280 [ 11.694019][ T200] ? rtnl_setlink+0x29d/0x920 [ 11.694021][ T200] ? rcu_is_watching+0x16/0xd0 [ 11.694023][ T200] ? lock_acquire+0x13c/0x160 [ 11.694025][ T200] ? rcu_is_watching+0x16/0xd0 [ 11.694026][ T200] ? rcu_is_watching+0x16/0xd0 [ 11.694027][ T200] ? trace_contention_end+0xb3/0x180 [ 11.694030][ T200] ? __mutex_lock+0x1db/0x1ea0 [ 11.694033][ T200] ? __mutex_lock+0x9a3/0x1ea0 [ 11.694035][ T200] ? rtnl_setlink+0x29d/0x920 [ 11.694036][ T200] ? mark_usage+0x61/0x170 [ 11.694040][ T200] ? ww_mutex_lock+0x160/0x160 [ 11.694041][ T200] ? nla_get_range_signed+0x3d0/0x3d0 [ 11.694045][ T200] ? __lock_acquire+0x518/0xc20 [ 11.694048][ T200] ? rcu_is_watching+0x16/0xd0 [ 11.694056][ T200] rtnl_setlink+0x527/0x920 [ 11.694060][ T200] ? __rtnl_newlink+0xa50/0xa50 [ 11.694061][ T200] ? __lock_acquire+0x518/0xc20 [ 11.694086][ T200] ? lock_acquire.part.0+0xd4/0x280 [ 11.694088][ T200] ? find_held_lock+0x2b/0x80 [ 11.694091][ T200] ? __lock_release.isra.0+0x69/0x1a0 [ 11.694093][ T200] ? mark_usage+0x61/0x170 [ 11.694095][ T200] ? __lock_acquire+0x518/0xc20 [ 11.694099][ T200] ? lock_acquire.part.0+0xd4/0x280 [ 11.694101][ T200] ? find_held_lock+0x2b/0x80 [ 11.694103][ T200] ? __rtnl_newlink+0xa50/0xa50 [ 11.694105][ T200] ? __lock_release.isra.0+0x69/0x1a0 [ 11.694109][ T200] ? __rtnl_newlink+0xa50/0xa50 [ 11.694111][ T200] rtnetlink_rcv_msg+0x6fd/0xbd0 [ 11.694115][ T200] ? rtnl_link_fill+0x920/0x920 [ 11.694116][ T200] ? __lock_acquire+0x518/0xc20 [ 11.694121][ T200] ? lock_acquire.part.0+0xd4/0x280 [ 11.694122][ T200] ? find_held_lock+0x2b/0x80 [ 11.694126][ T200] netlink_rcv_skb+0x14e/0x3a0 [ 11.694129][ T200] ? rtnl_link_fill+0x920/0x920 [ 11.694132][ T200] ? netlink_ack+0xcf0/0xcf0 [ 11.694139][ T200] ? netlink_deliver_tap+0xc5/0x330 [ 11.694141][ T200] ? netlink_deliver_tap+0x13c/0x330 [ 11.694146][ T200] netlink_unicast+0x486/0x750 [ 11.694150][ T200] ? netlink_attachskb+0x810/0x810 [ 11.694154][ T200] ? __lock_acquire+0x518/0xc20 [ 11.694158][ T200] netlink_sendmsg+0x75b/0xc90 [ 11.694162][ T200] ? netlink_unicast+0x750/0x750 [ 11.694164][ T200] ? find_held_lock+0x2b/0x80 [ 11.694167][ T200] ? __lock_release.isra.0+0x69/0x1a0 [ 11.694172][ T200] __sock_sendmsg+0xce/0x190 [ 11.694175][ T200] ? fdget+0x4f/0x1e0 [ 11.694178][ T200] __sys_sendto+0x260/0x320 [ 11.694181][ T200] ? __ia32_sys_getpeername+0xd0/0xd0 [ 11.694197][ T200] __x64_sys_sendto+0xe4/0x1f0 [ 11.694199][ T200] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 11.694203][ T200] ? lockdep_hardirqs_on+0x91/0x130 [ 11.694205][ T200] ? do_syscall_64+0xa6/0x530 [ 11.694208][ T200] do_syscall_64+0xff/0x530 [ 11.694210][ T200] ? exc_page_fault+0xee/0x100 [ 11.694213][ T200] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 11.694215][ T200] RIP: 0033:0x7f8d5fc2454e [ 11.694219][ T200] 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.694221][ T200] RSP: 002b:00007ffe8f924b00 EFLAGS: 00000202 ORIG_RAX: 000000000000002c [ 11.694223][ T200] RAX: ffffffffffffffda RBX: 0000558f5e0dd500 RCX: 00007f8d5fc2454e [ 11.694224][ T200] RDX: 0000000000000030 RSI: 0000558f5e0dfa70 RDI: 0000000000000014 [ 11.694225][ T200] RBP: 00007ffe8f924b10 R08: 00007ffe8f924b60 R09: 0000000000000080 [ 11.694226][ T200] R10: 0000000000000000 R11: 0000000000000202 R12: 0000558f5e256980 [ 11.694227][ T200] R13: 00007ffe8f924c44 R14: 0000000000000000 R15: 0000000000000000 [ 11.694235][ T200] [ 11.748068][ T199] netdevsim netdevsim724 eni724np1: renamed from eth1 [ 12.410367][ T218] 8021q: adding VLAN 0 to HW filter on device eni296np1 [ 12.476163][ T219] 8021q: adding VLAN 0 to HW filter on device eni724np1 [ 12.973804][ T232] socat (232) used greatest stack depth: 23880 bytes left [ 12.973827][ T232] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 12.973829][ T232] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 232, name: socat [ 12.973832][ T232] preempt_count: 2, expected: 0 [ 12.973833][ T232] RCU nest depth: 0, expected: 0 [ 12.973834][ T232] locks held by socat/232: 5, last CPU#0: [ 12.973837][ T232] #0: ffffffffaea167b8 (low_water_lock){+.+.}-{3:3}, at: do_exit+0x887/0xdc0 [ 12.973851][ T232] #1: ffffffffaeb7ddc0 (console_lock){+.+.}-{0:0}, at: vprintk_emit+0x320/0x3e0 [ 12.973858][ T232] #2: ffffffffaeb7de38 (console_srcu){....}-{0:0}, at: console_flush_one_record+0x106/0x710 [ 12.973865][ T232] #3: ffffffffaea9d760 (console_owner){....}-{0:0}, at: console_lock_spinning_enable+0x40/0x60 [ 12.973871][ T232] #4: ffffffffaea9d660 (printk_legacy_map-wait-type-override){....}-{3:3}, at: console_emit_next_record+0x1df/0x4c0 [ 12.973876][ T232] irq event stamp: 86182 [ 12.973878][ T232] hardirqs last enabled at (86181): [] __down_trylock_console_sem+0x86/0xa0 [ 12.973882][ T232] hardirqs last disabled at (86182): [] console_emit_next_record+0x3d4/0x4c0 [ 12.973885][ T232] softirqs last enabled at (85672): [] handle_softirqs+0x67c/0x900 [ 12.973888][ T232] softirqs last disabled at (85667): [] __irq_exit_rcu+0x145/0x1c0 [ 12.973892][ T232] Preemption disabled at: [ 12.973892][ T232] [<0000000000000000>] 0x0 [ 12.973901][ T232] CPU: 0 UID: 0 PID: 232 Comm: socat Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 12.973906][ T232] Tainted: [W]=WARN [ 12.973907][ T232] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 12.973910][ T232] Call Trace: [ 12.973912][ T232] [ 12.973914][ T232] dump_stack_lvl+0x6f/0xa0 [ 12.973922][ T232] __might_resched.cold+0x1fe/0x2c1 [ 12.973928][ T232] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 12.973934][ T232] ? __kmalloc_noprof+0xdb/0x760 [ 12.973940][ T232] __kmalloc_noprof+0x443/0x760 [ 12.973943][ T232] ? alloc_buf.isra.0+0x4b/0x260 [ 12.973953][ T232] ? do_raw_spin_unlock+0x59/0x250 [ 12.973957][ T232] alloc_buf.isra.0+0x4b/0x260 [ 12.973963][ T232] put_chars+0x1e1/0x2f0 [ 12.973967][ T232] ? __send_to_port+0x420/0x420 [ 12.973969][ T232] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 12.973974][ T232] ? validate_chain+0x38b/0xc20 [ 12.973984][ T232] hvc_console_print+0x292/0x780 [ 12.973996][ T232] ? hvc_write+0x3a0/0x3a0 [ 12.974003][ T232] ? rcu_is_watching+0x16/0xd0 [ 12.974006][ T232] ? lock_acquire+0x13c/0x160 [ 12.974013][ T232] console_emit_next_record+0x22f/0x4c0 [ 12.974020][ T232] ? devkmsg_read+0x4b0/0x4b0 [ 12.974023][ T232] ? console_flush_one_record+0x106/0x710 [ 12.974028][ T232] ? rcu_is_watching+0x16/0xd0 [ 12.974031][ T232] ? lock_acquire+0x13c/0x160 [ 12.974038][ T232] console_flush_one_record+0x46f/0x710 [ 12.974045][ T232] ? console_emit_next_record+0x4c0/0x4c0 [ 12.974048][ T232] ? __lock_acquire+0x518/0xc20 [ 12.974057][ T232] console_unlock+0xee/0x1f0 [ 12.974062][ T232] ? console_flush_one_record+0x710/0x710 [ 12.974065][ T232] ? rcu_is_watching+0x16/0xd0 [ 12.974068][ T232] ? lock_acquire+0xe0/0x160 [ 12.974074][ T232] ? __down_trylock_console_sem+0x5e/0xa0 [ 12.974077][ T232] ? vprintk_emit+0x320/0x3e0 [ 12.974082][ T232] vprintk_emit+0x37c/0x3e0 [ 12.974087][ T232] ? wake_up_klogd_work_func+0x90/0x90 [ 12.974089][ T232] ? do_raw_spin_unlock+0x59/0x250 [ 12.974095][ T232] ? __lock_acquire+0x518/0xc20 [ 12.974101][ T232] _printk+0xc7/0x100 [ 12.974106][ T232] ? snapshot_read.cold+0x21/0x21 [ 12.974111][ T232] ? do_raw_spin_lock+0x131/0x280 [ 12.974115][ T232] ? __rwlock_init+0x150/0x150 [ 12.974122][ T232] ? do_raw_spin_lock+0x131/0x280 [ 12.974126][ T232] do_exit.cold+0x82/0x9c [ 12.974132][ T232] ? exit_notify+0x890/0x890 [ 12.974134][ T232] ? __lock_release.isra.0+0x69/0x1a0 [ 12.974139][ T232] ? rcu_is_watching+0x16/0xd0 [ 12.974146][ T232] do_group_exit+0xb8/0x370 [ 12.974151][ T232] __x64_sys_exit_group+0x3c/0x50 [ 12.974154][ T232] x64_sys_call+0x1567/0x1570 [ 12.974157][ T232] do_syscall_64+0xff/0x530 [ 12.974163][ T232] ? exc_page_fault+0xee/0x100 [ 12.974167][ T232] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 12.974171][ T232] RIP: 0033:0x7fad9ff261b8 [ 12.974175][ T232] Code: Unable to access opcode bytes at 0x7fad9ff2618e. [ 12.974176][ T232] RSP: 002b:00007ffdb9f19898 EFLAGS: 00000246 ORIG_RAX: 00000000000000e7 [ 12.974180][ T232] RAX: ffffffffffffffda RBX: 00007fada0056f88 RCX: 00007fad9ff261b8 [ 12.974182][ T232] RDX: 00007fad9fe0be88 RSI: ffffffffffffffb0 RDI: 0000000000000000 [ 12.974183][ T232] RBP: 00007ffdb9f198f0 R08: 0000000000000000 R09: 0000000000004010 [ 12.974185][ T232] R10: 00007ffdb9f196f0 R11: 0000000000000246 R12: 0000000000000003 [ 12.974186][ T232] R13: 0000000000000000 R14: 00007fada0055680 R15: 00007fada0056fa0 [ 12.974199][ T232]