virtme: waiting for virtiofsd to start virtme: use 'microvm' QEMU architecture [ 1.109718][ T1] PPP generic driver version 2.4.2 [ 1.109755][ T1] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 1.109758][ T1] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 1, name: swapper/0 [ 1.109760][ T1] preempt_count: 1, expected: 0 [ 1.109761][ T1] RCU nest depth: 0, expected: 0 [ 1.109763][ T1] locks held by swapper/0/1: 4, last CPU#0: [ 1.109765][ T1] #0: ffffffffbc799dc0 (console_lock){+.+.}-{0:0}, at: vprintk_emit+0x320/0x3e0 [ 1.109779][ T1] #1: ffffffffbc799e38 (console_srcu){....}-{0:0}, at: console_flush_one_record+0x106/0x710 [ 1.109786][ T1] #2: ffffffffbc689760 (console_owner){....}-{0:0}, at: console_lock_spinning_enable+0x40/0x60 [ 1.109791][ T1] #3: ffffffffbc689660 (printk_legacy_map-wait-type-override){....}-{3:3}, at: console_emit_next_record+0x202/0x4f0 [ 1.109797][ T1] irq event stamp: 363954 [ 1.109799][ T1] hardirqs last enabled at (363953): [] __down_trylock_console_sem+0x86/0xa0 [ 1.109802][ T1] hardirqs last disabled at (363954): [] console_emit_next_record+0x3f8/0x4f0 [ 1.109805][ T1] softirqs last enabled at (363714): [] handle_softirqs+0x67c/0x900 [ 1.109809][ T1] softirqs last disabled at (363673): [] __irq_exit_rcu+0x145/0x1c0 [ 1.109812][ T1] Preemption disabled at: [ 1.109813][ T1] [] vprintk_emit+0x31b/0x3e0 [ 1.109820][ T1] CPU: 0 UID: 0 PID: 1 Comm: swapper/0 Not tainted 7.2.0-virtme #1 PREEMPT(full) [ 1.109824][ T1] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 1.109826][ T1] Call Trace: [ 1.109828][ T1] [ 1.109832][ T1] dump_stack_lvl+0x6f/0xa0 [ 1.109840][ T1] ? vprintk_emit+0x31b/0x3e0 [ 1.109843][ T1] __might_resched.cold+0x1fe/0x2c1 [ 1.109849][ T1] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 1.109854][ T1] ? __kmalloc_noprof+0xdb/0x760 [ 1.109861][ T1] __kmalloc_noprof+0x443/0x760 [ 1.109865][ T1] ? alloc_buf.isra.0+0x4b/0x260 [ 1.109874][ T1] ? do_raw_spin_unlock+0x59/0x250 [ 1.109878][ T1] alloc_buf.isra.0+0x4b/0x260 [ 1.109883][ T1] put_chars+0x1e1/0x2f0 [ 1.109886][ T1] ? printk_get_next_message+0x2fe/0x7d0 [ 1.109890][ T1] ? __send_to_port+0x420/0x420 [ 1.109892][ T1] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 1.109899][ T1] ? validate_chain+0x38b/0xc20 [ 1.109907][ T1] hvc_console_print+0x292/0x780 [ 1.109918][ T1] ? hvc_write+0x3a0/0x3a0 [ 1.109922][ T1] ? rcu_is_watching+0x16/0xd0 [ 1.109925][ T1] ? lock_acquire+0x13c/0x160 [ 1.109932][ T1] console_emit_next_record+0x252/0x4f0 [ 1.109937][ T1] ? devkmsg_read+0x4e0/0x4e0 [ 1.109944][ T1] ? rcu_is_watching+0x16/0xd0 [ 1.109948][ T1] ? lock_acquire+0x13c/0x160 [ 1.109954][ T1] console_flush_one_record+0x46f/0x710 [ 1.109961][ T1] ? console_emit_next_record+0x4f0/0x4f0 [ 1.109964][ T1] ? __lock_acquire+0x518/0xc20 [ 1.109972][ T1] console_unlock+0xee/0x1f0 [ 1.109977][ T1] ? console_flush_one_record+0x710/0x710 [ 1.109979][ T1] ? rcu_is_watching+0x16/0xd0 [ 1.109983][ T1] ? lock_acquire+0xa0/0x160 [ 1.109989][ T1] ? __down_trylock_console_sem+0x5e/0xa0 [ 1.109991][ T1] ? vprintk_emit+0x320/0x3e0 [ 1.109997][ T1] vprintk_emit+0x37c/0x3e0 [ 1.110002][ T1] ? wake_up_klogd_work_func+0x90/0x90 [ 1.110011][ T1] ? vxlan_init_module+0x80/0x80 [ 1.110016][ T1] _printk+0xc7/0x100 [ 1.110020][ T1] ? snapshot_read.cold+0x21/0x21 [ 1.110023][ T1] ? add_chain_block+0x1e0/0x5b0 [ 1.110027][ T1] ? _raw_spin_unlock_irqrestore+0x40/0x80 [ 1.110033][ T1] ? add_device_randomness+0xbb/0x100 [ 1.110036][ T1] ? random_write_iter+0x20/0x20 [ 1.110040][ T1] ? phy_module_init+0x20/0x20 [ 1.110044][ T1] ? do_one_initcall+0x113/0x4f0 [ 1.110048][ T1] ppp_init+0x16/0x100 [ 1.110051][ T1] do_one_initcall+0x124/0x4f0 [ 1.110054][ T1] ? trace_event_raw_event_initcall_level+0x280/0x280 [ 1.110057][ T1] ? parameq+0x110/0x110 [ 1.110062][ T1] ? kernel_init_freeable+0x3f1/0x630 [ 1.110065][ T1] ? rcu_is_watching+0x16/0xd0 [ 1.110069][ T1] kernel_init_freeable+0x596/0x630 [ 1.110072][ T1] ? rest_init+0x280/0x280 [ 1.110074][ T1] kernel_init+0x21/0x150 [ 1.110076][ T1] ? rest_init+0x280/0x280 [ 1.110077][ T1] ret_from_fork+0x474/0x6b0 [ 1.110081][ T1] ? arch_exit_to_user_mode_prepare.isra.0+0x120/0x120 [ 1.110084][ T1] ? __switch_to+0x5a3/0xe00 [ 1.110087][ T1] ? rest_init+0x280/0x280 [ 1.110089][ T1] ret_from_fork_asm+0x11/0x20 [ 1.110097][ T1] [ 1.126741][ T1] NET: Registered PF_PPPOX protocol family [ 1.127647][ T1] i8042: PNP: No PS/2 controller found. [ 1.136078][ T1] rtc_cmos PNP0B00:00: registered as rtc0 [ 1.136716][ T1] rtc_cmos PNP0B00:00: setting system clock to 2026-08-28T11:53:46 UTC (1787918026) [ 1.137609][ T1] rtc_cmos PNP0B00:00: alarms up to one day, 242 bytes nvram [ 1.140282][ T1] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev [ 1.146180][ T1] ipip: IPv4 and MPLS over IPv4 tunneling driver [ 1.149067][ T1] gre: GRE over IPv4 demultiplexer driver [ 1.149257][ T1] ip_gre: GRE over IPv4 tunneling driver [ 1.156905][ T1] Initializing XFRM netlink socket [ 1.157497][ T1] NET: Registered PF_INET6 protocol family [ 1.163727][ T1] Segment Routing with IPv6 [ 1.164181][ T1] In-situ OAM (IOAM) with IPv6 [ 1.164541][ T1] sit: IPv6, IPv4 and MPLS over IPv4 tunneling driver [ 1.171589][ T1] ip6_gre: GRE over IPv6 tunneling driver [ 1.174580][ T1] NET: Registered PF_PACKET protocol family [ 1.174838][ T1] 9pnet: Installing 9P2000 support [ 1.175196][ T1] Key type dns_resolver registered [ 1.175887][ T1] NET: Registered PF_VSOCK protocol family [ 1.180609][ T1] IPI shorthand broadcast: enabled [ 1.282906][ T1] sched_clock: Marking stable (1250003138, 32182905)->(1358196044, -76010001) [ 1.285286][ T1] registered taskstats version 1 [ 1.287338][ T1] Loading compiled-in X.509 certificates [ 1.386741][ T1] Demotion targets for Node 0: null [ 1.387051][ T1] kmemleak: Kernel memory leak detector initialized (mem pool available: 11962) [ 1.387359][ T1] page_owner is disabled [ 1.391602][ T70] kwatchdog (70) used greatest stack depth: 29688 bytes left [ 1.396320][ T1] PM: Magic number: 6:622:884 [ 1.398596][ T1] ALSA device list: [ 1.399213][ T1] No soundcards found. [ 1.400256][ T1] md: Skipping autodetection of RAID arrays. (raid=autodetect will force) [ 1.402904][ T1] VFS: Mounted root (virtiofs filesystem) readonly on device 0:24. [ 1.403710][ T1] devtmpfs: mounted [ 1.403985][ T1] VFS: Pivoted into new rootfs [ 1.434127][ T1] Freeing unused kernel image (initmem) memory: 2576K [ 1.434434][ T1] Write protecting the kernel read-only data: 63488k [ 1.435026][ T1] Freeing unused kernel image (text/rodata gap) memory: 864K [ 1.435610][ T1] Freeing unused kernel image (rodata/data gap) memory: 1116K [ 1.435912][ T1] Run /usr/lib/python3.14/site-packages/virtme/guest/bin/virtme-ng-init as init process [ 1.436222][ T1] with arguments: [ 1.436338][ T1] /usr/lib/python3.14/site-packages/virtme/guest/bin/virtme-ng-init [ 1.436644][ T1] with environment: [ 1.436774][ T1] HOME=/ [ 1.436935][ T1] TERM=dumb [ 1.437044][ T1] virtme_hostname=vmksft-drv-hw-dbg,debug-threads=on [ 1.437290][ T1] nr_open=2147483584 [ 1.437399][ T1] virtme_link_mods=/srv/vmksft/testing/wt-22/.virtme_mods/lib/modules/0.0.0 [ 1.437704][ T1] virtme_rw_overlay0=/etc [ 1.437856][ T1] virtme_rw_overlay1=/lib [ 1.438055][ T1] virtme_rw_overlay2=/home [ 1.438204][ T1] virtme_rw_overlay3=/opt [ 1.438406][ T1] virtme_rw_overlay4=/srv [ 1.438554][ T1] virtme_rw_overlay5=/usr [ 1.438750][ T1] virtme_rw_overlay6=/var [ 1.438899][ T1] virtme_rw_overlay7=/tmp [ 1.439092][ T1] virtme_console=ttyS0 [ 1.439241][ T1] virtme_chdir=srv/vmksft/testing/wt-22 [ 1.456191][ T1] virtme-ng-init: mount devtmpfs -> /dev: EBUSY: Device or resource busy [ 1.457625][ T1] virtme-ng-init: Setting hostname to vmksft-drv-hw-dbg,debug-threads=on... [ 1.468827][ T1] overlayfs: failed to set xattr on upper [ 1.469065][ T1] overlayfs: ...falling back to redirect_dir=nofollow. [ 1.469330][ T1] overlayfs: ...falling back to uuid=null. [ 1.471417][ T1] overlayfs: failed to set xattr on upper [ 1.471610][ T1] overlayfs: ...falling back to redirect_dir=nofollow. [ 1.471846][ T1] overlayfs: ...falling back to uuid=null. [ 1.473606][ T1] overlayfs: failed to set xattr on upper [ 1.473793][ T1] overlayfs: ...falling back to redirect_dir=nofollow. [ 1.474029][ T1] overlayfs: ...falling back to uuid=null. [ 1.476017][ T1] overlayfs: failed to set xattr on upper [ 1.476238][ T1] overlayfs: ...falling back to redirect_dir=nofollow. [ 1.476463][ T1] overlayfs: ...falling back to uuid=null. [ 1.478213][ T1] overlayfs: failed to set xattr on upper [ 1.478405][ T1] overlayfs: ...falling back to redirect_dir=nofollow. [ 1.478638][ T1] overlayfs: ...falling back to uuid=null. [ 1.480196][ T1] overlayfs: failed to set xattr on upper [ 1.480378][ T1] overlayfs: ...falling back to redirect_dir=nofollow. [ 1.480609][ T1] overlayfs: ...falling back to uuid=null. [ 1.482684][ T1] overlayfs: failed to set xattr on upper [ 1.482872][ T1] overlayfs: ...falling back to redirect_dir=nofollow. [ 1.483101][ T1] overlayfs: ...falling back to uuid=null. [ 1.484853][ T1] overlayfs: failed to set xattr on upper [ 1.485039][ T1] overlayfs: ...falling back to redirect_dir=nofollow. [ 1.485274][ T1] overlayfs: ...falling back to uuid=null. [ 1.495644][ T1] virtme-ng-init: running systemd-tmpfiles [ 3.382073][ T72] systemd-tmpfile (72) used greatest stack depth: 24752 bytes left [ 3.382089][ T72] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 3.382092][ T72] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 72, name: systemd-tmpfile [ 3.382093][ T72] preempt_count: 2, expected: 0 [ 3.382094][ T72] RCU nest depth: 0, expected: 0 [ 3.382095][ T72] locks held by systemd-tmpfile/72: 5, last CPU#2: [ 3.382097][ T72] #0: ffffffffbc6027b8 (low_water_lock){+.+.}-{3:3}, at: do_exit+0x887/0xdc0 [ 3.382110][ T72] #1: ffffffffbc799dc0 (console_lock){+.+.}-{0:0}, at: vprintk_emit+0x320/0x3e0 [ 3.382116][ T72] #2: ffffffffbc799e38 (console_srcu){....}-{0:0}, at: console_flush_one_record+0x106/0x710 [ 3.382120][ T72] #3: ffffffffbc689760 (console_owner){....}-{0:0}, at: console_lock_spinning_enable+0x40/0x60 [ 3.382124][ T72] #4: ffffffffbc689660 (printk_legacy_map-wait-type-override){....}-{3:3}, at: console_emit_next_record+0x202/0x4f0 [ 3.382128][ T72] irq event stamp: 2341938 [ 3.382128][ T72] hardirqs last enabled at (2341937): [] __down_trylock_console_sem+0x86/0xa0 [ 3.382131][ T72] hardirqs last disabled at (2341938): [] console_emit_next_record+0x3f8/0x4f0 [ 3.382133][ T72] softirqs last enabled at (2341320): [] handle_softirqs+0x67c/0x900 [ 3.382135][ T72] softirqs last disabled at (2341315): [] __irq_exit_rcu+0x145/0x1c0 [ 3.382138][ T72] Preemption disabled at: [ 3.382138][ T72] [<0000000000000000>] 0x0 [ 3.382145][ T72] CPU: 2 UID: 0 PID: 72 Comm: systemd-tmpfile Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 3.382149][ T72] Tainted: [W]=WARN [ 3.382150][ T72] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 3.382151][ T72] Call Trace: [ 3.382153][ T72] [ 3.382154][ T72] dump_stack_lvl+0x6f/0xa0 [ 3.382161][ T72] __might_resched.cold+0x1fe/0x2c1 [ 3.382166][ T72] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 3.382170][ T72] ? __kmalloc_noprof+0xdb/0x760 [ 3.382175][ T72] __kmalloc_noprof+0x443/0x760 [ 3.382177][ T72] ? alloc_buf.isra.0+0x4b/0x260 [ 3.382186][ T72] ? do_raw_spin_unlock+0x59/0x250 [ 3.382188][ T72] alloc_buf.isra.0+0x4b/0x260 [ 3.382192][ T72] put_chars+0x1e1/0x2f0 [ 3.382195][ T72] ? __send_to_port+0x420/0x420 [ 3.382197][ T72] ? printk_get_next_message+0x2fe/0x7d0 [ 3.382200][ T72] ? rcu_read_lock_any_held+0x3c/0x90 [ 3.382203][ T72] ? validate_chain+0x38b/0xc20 [ 3.382207][ T72] hvc_console_print+0x292/0x780 [ 3.382211][ T72] ? __lock_acquire+0x518/0xc20 [ 3.382213][ T72] ? __lock_acquire+0x518/0xc20 [ 3.382217][ T72] ? hvc_write+0x3a0/0x3a0 [ 3.382220][ T72] ? rcu_is_watching+0x16/0xd0 [ 3.382223][ T72] ? lock_acquire+0x13c/0x160 [ 3.382227][ T72] console_emit_next_record+0x252/0x4f0 [ 3.382231][ T72] ? devkmsg_read+0x4e0/0x4e0 [ 3.382235][ T72] ? rcu_is_watching+0x16/0xd0 [ 3.382237][ T72] ? lock_acquire+0x13c/0x160 [ 3.382241][ T72] console_flush_one_record+0x46f/0x710 [ 3.382245][ T72] ? console_emit_next_record+0x4f0/0x4f0 [ 3.382247][ T72] ? __lock_acquire+0x518/0xc20 [ 3.382251][ T72] console_unlock+0xee/0x1f0 [ 3.382254][ T72] ? console_flush_one_record+0x710/0x710 [ 3.382256][ T72] ? rcu_is_watching+0x16/0xd0 [ 3.382258][ T72] ? lock_acquire+0xa0/0x160 [ 3.382262][ T72] ? __down_trylock_console_sem+0x5e/0xa0 [ 3.382263][ T72] ? vprintk_emit+0x320/0x3e0 [ 3.382267][ T72] vprintk_emit+0x37c/0x3e0 [ 3.382270][ T72] ? wake_up_klogd_work_func+0x90/0x90 [ 3.382273][ T72] ? __lock_acquire+0x518/0xc20 [ 3.382275][ T1] virtme-ng-init: Failed to read '/usr/lib/tmpfiles.d/audit.conf': Permission denied [ 3.382275][ T1] Failed to create directory or subvolume "/var/spool/at/spool": Permission denied [ 3.382275][ T1] Failed to create file /var/spool/at/.SEQ: Permission denied [ 3.382275][ T1] Failed to opendir() '/proc/self/fd/6': Permission denied [ 3.382277][ T72] _printk+0xc7/0x100 [ 3.382280][ T72] ? snapshot_read.cold+0x21/0x21 [ 3.382283][ T72] ? do_raw_spin_lock+0x131/0x280 [ 3.382285][ T72] ? __rwlock_init+0x150/0x150 [ 3.382289][ T72] ? do_raw_spin_lock+0x131/0x280 [ 3.382291][ T72] do_exit.cold+0x82/0x9c [ 3.382295][ T72] ? exit_notify+0x890/0x890 [ 3.382296][ T72] ? __lock_release.isra.0+0x69/0x1a0 [ 3.382299][ T72] ? rcu_is_watching+0x16/0xd0 [ 3.382303][ T72] do_group_exit+0xb8/0x370 [ 3.382305][ T72] __x64_sys_exit_group+0x3c/0x50 [ 3.382307][ T72] x64_sys_call+0x1567/0x1570 [ 3.382309][ T72] do_syscall_64+0xff/0x530 [ 3.382313][ T72] ? exc_page_fault+0xee/0x100 [ 3.382316][ T72] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 3.382319][ T72] RIP: 0033:0x7f0b3d0451b8 [ 3.382321][ T72] Code: Unable to access opcode bytes at 0x7f0b3d04518e. [ 3.382322][ T72] RSP: 002b:00007ffdb3a5d248 EFLAGS: 00000246 ORIG_RAX: 00000000000000e7 [ 3.382324][ T72] RAX: ffffffffffffffda RBX: 00007f0b3d175f88 RCX: 00007f0b3d0451b8 [ 3.382326][ T72] RDX: 00007f0b3c8a34c8 RSI: fffffffffffffe90 RDI: 0000000000000049 [ 3.382327][ T72] RBP: 00007ffdb3a5d2a0 R08: 0000000000000000 R09: 0000000000001000 [ 3.382328][ T72] R10: 00007ffdb3a5d060 R11: 0000000000000246 R12: 0000000000000001 [ 3.382328][ T72] R13: 0000000000000049 R14: 00007f0b3d174680 R15: 00007f0b3d175fa0 [ 3.382335][ T72] [ 3.399250][ T1] virtme-ng-init: basic initialization done [ 3.471355][ T74] virtme-ng-init: Starting systemd-udevd version 259.8-1.fc44 [ 3.471717][ T74] virtme-ng-init: triggering udev coldplug [ 5.473870][ T74] virtme-ng-init: waiting for udev to settle [ 5.473885][ T74] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 5.473887][ T74] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 74, name: virtme-ng-init [ 5.473889][ T74] preempt_count: 1, expected: 0 [ 5.473890][ T74] RCU nest depth: 0, expected: 0 [ 5.473891][ T74] locks held by virtme-ng-init/74: 4, last CPU#2: [ 5.473893][ T74] #0: ffffffffbc799dc0 (console_lock){+.+.}-{0:0}, at: vprintk_emit+0x320/0x3e0 [ 5.473906][ T74] #1: ffffffffbc799e38 (console_srcu){....}-{0:0}, at: console_flush_one_record+0x106/0x710 [ 5.473911][ T74] #2: ffffffffbc689760 (console_owner){....}-{0:0}, at: console_lock_spinning_enable+0x40/0x60 [ 5.473915][ T74] #3: ffffffffbc689660 (printk_legacy_map-wait-type-override){....}-{3:3}, at: console_emit_next_record+0x202/0x4f0 [ 5.473919][ T74] irq event stamp: 4374 [ 5.473920][ T74] hardirqs last enabled at (4373): [] __down_trylock_console_sem+0x86/0xa0 [ 5.473922][ T74] hardirqs last disabled at (4374): [] console_emit_next_record+0x3f8/0x4f0 [ 5.473924][ T74] softirqs last enabled at (4140): [] handle_softirqs+0x67c/0x900 [ 5.473928][ T74] softirqs last disabled at (2801): [] __irq_exit_rcu+0x145/0x1c0 [ 5.473930][ T74] Preemption disabled at: [ 5.473931][ T74] [] vprintk_emit+0x31b/0x3e0 [ 5.473936][ T74] CPU: 2 UID: 0 PID: 74 Comm: virtme-ng-init Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 5.473940][ T74] Tainted: [W]=WARN [ 5.473941][ T74] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 5.473943][ T74] Call Trace: [ 5.473944][ T74] [ 5.473946][ T74] dump_stack_lvl+0x6f/0xa0 [ 5.473951][ T74] ? vprintk_emit+0x31b/0x3e0 [ 5.473954][ T74] __might_resched.cold+0x1fe/0x2c1 [ 5.473958][ T74] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 5.473962][ T74] ? __kmalloc_noprof+0xdb/0x760 [ 5.473967][ T74] __kmalloc_noprof+0x443/0x760 [ 5.473969][ T74] ? alloc_buf.isra.0+0x4b/0x260 [ 5.473975][ T74] ? do_raw_spin_unlock+0x59/0x250 [ 5.473978][ T74] alloc_buf.isra.0+0x4b/0x260 [ 5.473982][ T74] put_chars+0x1e1/0x2f0 [ 5.473985][ T74] ? __send_to_port+0x420/0x420 [ 5.473987][ T74] ? printk_get_next_message+0x2fe/0x7d0 [ 5.473990][ T74] ? rcu_read_lock_any_held+0x3c/0x90 [ 5.473993][ T74] ? validate_chain+0x38b/0xc20 [ 5.473997][ T74] hvc_console_print+0x292/0x780 [ 5.474000][ T74] ? __lock_acquire+0x518/0xc20 [ 5.474002][ T74] ? __lock_acquire+0x518/0xc20 [ 5.474006][ T74] ? hvc_write+0x3a0/0x3a0 [ 5.474009][ T74] ? rcu_is_watching+0x16/0xd0 [ 5.474012][ T74] ? lock_acquire+0x13c/0x160 [ 5.474016][ T74] console_emit_next_record+0x252/0x4f0 [ 5.474020][ T74] ? devkmsg_read+0x4e0/0x4e0 [ 5.474024][ T74] ? rcu_is_watching+0x16/0xd0 [ 5.474026][ T74] ? lock_acquire+0x13c/0x160 [ 5.474030][ T74] console_flush_one_record+0x46f/0x710 [ 5.474034][ T74] ? console_emit_next_record+0x4f0/0x4f0 [ 5.474035][ T74] ? __lock_acquire+0x518/0xc20 [ 5.474040][ T74] console_unlock+0xee/0x1f0 [ 5.474043][ T74] ? console_flush_one_record+0x710/0x710 [ 5.474045][ T74] ? rcu_is_watching+0x16/0xd0 [ 5.474047][ T74] ? lock_acquire+0xa0/0x160 [ 5.474050][ T74] ? __down_trylock_console_sem+0x5e/0xa0 [ 5.474052][ T74] ? vprintk_emit+0x320/0x3e0 [ 5.474055][ T74] vprintk_emit+0x37c/0x3e0 [ 5.474058][ T74] ? wake_up_klogd_work_func+0x90/0x90 [ 5.474061][ T74] ? _copy_from_iter+0x1bb/0x1810 [ 5.474067][ T74] devkmsg_emit.constprop.0+0xbc/0xf1 [ 5.474070][ T74] ? vprintk_emit.cold+0x107/0x107 [ 5.474072][ T74] ? simple_strntoull+0x10f/0x140 [ 5.474077][ T74] ? date_str+0x1e0/0x1e0 [ 5.474080][ T74] ? devkmsg_write+0xd1/0x2c0 [ 5.474084][ T74] devkmsg_write.cold+0x5a/0x8b [ 5.474086][ T74] ? vprintk_default+0x20/0x20 [ 5.474090][ T74] ? vprintk_default+0x20/0x20 [ 5.474093][ T74] new_sync_write+0x33e/0x760 [ 5.474096][ T74] ? kasan_quarantine_put+0x102/0x2b0 [ 5.474099][ T74] ? new_sync_read+0x750/0x750 [ 5.474103][ T74] ? __lock_release.isra.0+0x69/0x1a0 [ 5.474107][ T74] ? __fget_files+0x1e3/0x460 [ 5.474110][ T74] vfs_write+0x6a2/0xbd0 [ 5.474114][ T74] ksys_write+0x116/0x250 [ 5.474117][ T74] ? __ia32_sys_read+0xc0/0xc0 [ 5.474119][ T74] ? rcu_is_watching+0x16/0xd0 [ 5.474123][ T74] do_syscall_64+0xff/0x530 [ 5.474125][ T74] ? exc_page_fault+0xee/0x100 [ 5.474129][ T74] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 5.474131][ T74] RIP: 0033:0x7f73d823bed2 [ 5.474135][ T74] Code: 08 0f 85 51 ec ff ff 49 89 fb 48 89 f0 48 89 d7 48 89 ce 4c 89 c2 4d 89 ca 4c 8b 44 24 08 4c 8b 4c 24 10 4c 89 5c 24 08 0f 05 66 2e 0f 1f 84 00 00 00 00 00 0f 1f 00 f3 0f 1e fa 55 48 89 e5 [ 5.474137][ T74] RSP: 002b:00007f73d8182c68 EFLAGS: 00000246 ORIG_RAX: 0000000000000001 [ 5.474140][ T74] RAX: ffffffffffffffda RBX: 000000000000002e RCX: 00007f73d823bed2 [ 5.474141][ T74] RDX: 000000000000002e RSI: 00007f73d0001090 RDI: 0000000000000003 [ 5.474142][ T74] RBP: 00007f73d8182c90 R08: 0000000000000000 R09: 0000000000000000 [ 5.474143][ T74] R10: 0000000000000000 R11: 0000000000000246 R12: 00007f73d82c60a0 [ 5.474144][ T74] R13: 00007f73d81c43e0 R14: 00007f73d0001090 R15: 00007f73d8182da8 [ 5.474150][ T74] [ 5.587929][ T85] virtio_net virtio2 enp0s1: renamed from eth0 [ 5.601569][ T83] virtio_net virtio3 enp0s2: renamed from eth1 [ 6.128859][ T74] virtme-ng-init: udev is done [ 6.136695][ T1] virtme-ng-init: initialization done [ 7.701160][ T134] ethtool (134) used greatest stack depth: 24688 bytes left [ 7.701176][ T134] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 7.701178][ T134] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 134, name: ethtool [ 7.701180][ T134] preempt_count: 2, expected: 0 [ 7.701181][ T134] RCU nest depth: 0, expected: 0 [ 7.701184][ T134] locks held by ethtool/134: 5, last CPU#2: [ 7.701186][ T134] #0: ffffffffbc6027b8 (low_water_lock){+.+.}-{3:3}, at: do_exit+0x887/0xdc0 [ 7.701198][ T134] #1: ffffffffbc799dc0 (console_lock){+.+.}-{0:0}, at: vprintk_emit+0x320/0x3e0 [ 7.701203][ T134] #2: ffffffffbc799e38 (console_srcu){....}-{0:0}, at: console_flush_one_record+0x106/0x710 [ 7.701207][ T134] #3: ffffffffbc689760 (console_owner){....}-{0:0}, at: console_lock_spinning_enable+0x40/0x60 [ 7.701211][ T134] #4: ffffffffbc689660 (printk_legacy_map-wait-type-override){....}-{3:3}, at: console_emit_next_record+0x202/0x4f0 [ 7.701215][ T134] irq event stamp: 11620 [ 7.701216][ T134] hardirqs last enabled at (11619): [] __down_trylock_console_sem+0x86/0xa0 [ 7.701218][ T134] hardirqs last disabled at (11620): [] console_emit_next_record+0x3f8/0x4f0 [ 7.701220][ T134] softirqs last enabled at (10868): [] sk_common_release+0x16b/0x310 [ 7.701225][ T134] softirqs last disabled at (10866): [] sk_common_release+0xc2/0x310 [ 7.701227][ T134] Preemption disabled at: [ 7.701228][ T134] [<0000000000000000>] 0x0 [ 7.701235][ T134] CPU: 2 UID: 0 PID: 134 Comm: ethtool Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 7.701238][ T134] Tainted: [W]=WARN [ 7.701239][ T134] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 7.701241][ T134] Call Trace: [ 7.701242][ T134] [ 7.701244][ T134] dump_stack_lvl+0x6f/0xa0 [ 7.701250][ T134] __might_resched.cold+0x1fe/0x2c1 [ 7.701255][ T134] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 7.701258][ T134] ? __kmalloc_noprof+0xdb/0x760 [ 7.701263][ T134] __kmalloc_noprof+0x443/0x760 [ 7.701266][ T134] ? alloc_buf.isra.0+0x4b/0x260 [ 7.701272][ T134] ? do_raw_spin_unlock+0x59/0x250 [ 7.701274][ T134] alloc_buf.isra.0+0x4b/0x260 [ 7.701278][ T134] put_chars+0x1e1/0x2f0 [ 7.701281][ T134] ? __send_to_port+0x420/0x420 [ 7.701283][ T134] ? printk_get_next_message+0x2fe/0x7d0 [ 7.701287][ T134] ? rcu_read_lock_any_held+0x3c/0x90 [ 7.701289][ T134] ? validate_chain+0x38b/0xc20 [ 7.701293][ T134] hvc_console_print+0x292/0x780 [ 7.701297][ T134] ? __lock_acquire+0x518/0xc20 [ 7.701298][ T134] ? __lock_acquire+0x518/0xc20 [ 7.701303][ T134] ? hvc_write+0x3a0/0x3a0 [ 7.701306][ T134] ? rcu_is_watching+0x16/0xd0 [ 7.701309][ T134] ? lock_acquire+0x13c/0x160 [ 7.701313][ T134] console_emit_next_record+0x252/0x4f0 [ 7.701317][ T134] ? devkmsg_read+0x4e0/0x4e0 [ 7.701321][ T134] ? rcu_is_watching+0x16/0xd0 [ 7.701323][ T134] ? lock_acquire+0x13c/0x160 [ 7.701327][ T134] console_flush_one_record+0x46f/0x710 [ 7.701331][ T134] ? console_emit_next_record+0x4f0/0x4f0 [ 7.701332][ T134] ? __lock_acquire+0x518/0xc20 [ 7.701337][ T134] console_unlock+0xee/0x1f0 [ 7.701340][ T134] ? console_flush_one_record+0x710/0x710 [ 7.701342][ T134] ? rcu_is_watching+0x16/0xd0 [ 7.701344][ T134] ? lock_acquire+0xa0/0x160 [ 7.701347][ T134] ? __down_trylock_console_sem+0x5e/0xa0 [ 7.701349][ T134] ? vprintk_emit+0x320/0x3e0 [ 7.701352][ T134] vprintk_emit+0x37c/0x3e0 [ 7.701356][ T134] ? wake_up_klogd_work_func+0x90/0x90 [ 7.701359][ T134] ? __lock_acquire+0x518/0xc20 [ 7.701362][ T134] _printk+0xc7/0x100 [ 7.701366][ T134] ? snapshot_read.cold+0x21/0x21 [ 7.701368][ T134] ? do_raw_spin_lock+0x131/0x280 [ 7.701371][ T134] ? __rwlock_init+0x150/0x150 [ 7.701375][ T134] ? do_raw_spin_lock+0x131/0x280 [ 7.701377][ T134] do_exit.cold+0x82/0x9c [ 7.701381][ T134] ? exit_notify+0x890/0x890 [ 7.701382][ T134] ? __lock_release.isra.0+0x69/0x1a0 [ 7.701384][ T134] ? rcu_is_watching+0x16/0xd0 [ 7.701388][ T134] do_group_exit+0xb8/0x370 [ 7.701391][ T134] __x64_sys_exit_group+0x3c/0x50 [ 7.701393][ T134] x64_sys_call+0x1567/0x1570 [ 7.701395][ T134] do_syscall_64+0xff/0x530 [ 7.701398][ T134] ? exc_page_fault+0xee/0x100 [ 7.701402][ T134] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 7.701404][ T134] RIP: 0033:0x7f840dd6e1b8 [ 7.701406][ T134] Code: Unable to access opcode bytes at 0x7f840dd6e18e. [ 7.701407][ T134] RSP: 002b:00007ffd672a4ee8 EFLAGS: 00000246 ORIG_RAX: 00000000000000e7 [ 7.701410][ T134] RAX: ffffffffffffffda RBX: 00007f840de9ef88 RCX: 00007f840dd6e1b8 [ 7.701411][ T134] RDX: 00007f840dcace88 RSI: ffffffffffffffb0 RDI: 0000000000000000 [ 7.701412][ T134] RBP: 00007ffd672a4f40 R08: 0000000000000000 R09: 0000000000000000 [ 7.701413][ T134] R10: 0000000000000000 R11: 0000000000000246 R12: 0000000000000001 [ 7.701414][ T134] R13: 0000000000000000 R14: 00007f840de9d680 R15: 00007f840de9efa0 [ 7.701420][ T134] [ 7.760947][ T136] ip (136) used greatest stack depth: 24352 bytes left