virtme: waiting for virtiofsd to start virtme: use 'microvm' QEMU architecture [ 1.130580][ T1] rtc_cmos PNP0B00:00: registered as rtc0 [ 1.130608][ T1] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 1.130611][ T1] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 1, name: swapper/0 [ 1.130612][ T1] preempt_count: 1, expected: 0 [ 1.130613][ T1] RCU nest depth: 0, expected: 0 [ 1.130614][ T1] locks held by swapper/0/1: 5, last CPU#1: [ 1.130617][ T1] #0: ff110000028cb938 (&dev->mutex){....}-{4:4}, at: __driver_attach+0x1ad/0x540 [ 1.130629][ T1] #1: ffffffff8d369cc0 (console_lock){+.+.}-{0:0}, at: vprintk_emit+0x320/0x3e0 [ 1.130635][ T1] #2: ffffffff8d369d38 (console_srcu){....}-{0:0}, at: console_flush_one_record+0x106/0x710 [ 1.130638][ T1] #3: ffffffff8d289660 (console_owner){....}-{0:0}, at: console_lock_spinning_enable+0x40/0x60 [ 1.130642][ T1] #4: ffffffff8d289560 (printk_legacy_map-wait-type-override){....}-{3:3}, at: console_emit_next_record+0x1df/0x4c0 [ 1.130645][ T1] irq event stamp: 301948 [ 1.130646][ T1] hardirqs last enabled at (301947): [] __down_trylock_console_sem+0x86/0xa0 [ 1.130649][ T1] hardirqs last disabled at (301948): [] console_emit_next_record+0x3d4/0x4c0 [ 1.130651][ T1] softirqs last enabled at (301924): [] handle_softirqs+0x67c/0x900 [ 1.130655][ T1] softirqs last disabled at (301919): [] __irq_exit_rcu+0x145/0x1c0 [ 1.130657][ T1] Preemption disabled at: [ 1.130658][ T1] [] vprintk_emit+0x31b/0x3e0 [ 1.130663][ T1] CPU: 1 UID: 0 PID: 1 Comm: swapper/0 Not tainted 7.2.0-virtme #1 PREEMPT(full) [ 1.130666][ T1] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 1.130667][ T1] Call Trace: [ 1.130669][ T1] [ 1.130673][ T1] dump_stack_lvl+0x6f/0xa0 [ 1.130678][ T1] ? vprintk_emit+0x31b/0x3e0 [ 1.130679][ T1] __might_resched.cold+0x1fe/0x2c1 [ 1.130684][ T1] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 1.130687][ T1] ? __kmalloc_noprof+0xdb/0x760 [ 1.130693][ T1] __kmalloc_noprof+0x443/0x760 [ 1.130695][ T1] ? alloc_buf.isra.0+0x4b/0x260 [ 1.130701][ T1] ? do_raw_spin_unlock+0x59/0x250 [ 1.130704][ T1] alloc_buf.isra.0+0x4b/0x260 [ 1.130707][ T1] put_chars+0x1e1/0x2f0 [ 1.130710][ T1] ? __send_to_port+0x420/0x420 [ 1.130714][ T1] ? rcu_read_lock_any_held+0x3c/0x90 [ 1.130717][ T1] ? validate_chain+0x38b/0xc20 [ 1.130722][ T1] hvc_console_print+0x292/0x780 [ 1.130725][ T1] ? __lock_acquire+0x518/0xc20 [ 1.130727][ T1] ? __lock_acquire+0x518/0xc20 [ 1.130732][ T1] ? hvc_write+0x3a0/0x3a0 [ 1.130735][ T1] ? rcu_is_watching+0x16/0xd0 [ 1.130738][ T1] ? lock_acquire+0x13c/0x160 [ 1.130742][ T1] console_emit_next_record+0x22f/0x4c0 [ 1.130745][ T1] ? devkmsg_read+0x4b0/0x4b0 [ 1.130746][ T1] ? console_flush_one_record+0x106/0x710 [ 1.130749][ T1] ? rcu_is_watching+0x16/0xd0 [ 1.130751][ T1] ? lock_acquire+0x13c/0x160 [ 1.130755][ T1] console_flush_one_record+0x46f/0x710 [ 1.130759][ T1] ? console_emit_next_record+0x4c0/0x4c0 [ 1.130761][ T1] ? __lock_acquire+0x518/0xc20 [ 1.130766][ T1] console_unlock+0xee/0x1f0 [ 1.130768][ T1] ? console_flush_one_record+0x710/0x710 [ 1.130770][ T1] ? rcu_is_watching+0x16/0xd0 [ 1.130772][ T1] ? lock_acquire+0x60/0x160 [ 1.130775][ T1] ? __down_trylock_console_sem+0x5e/0xa0 [ 1.130777][ T1] ? vprintk_emit+0x320/0x3e0 [ 1.130780][ T1] vprintk_emit+0x37c/0x3e0 [ 1.130783][ T1] ? wake_up_klogd_work_func+0x90/0x90 [ 1.130785][ T1] ? find_held_lock+0x2b/0x80 [ 1.130788][ T1] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 1.130790][ T1] ? rcu_read_lock_any_held+0x3c/0x90 [ 1.130794][ T1] dev_vprintk_emit+0x27f/0x2c0 [ 1.130798][ T1] ? device_rename.cold+0xa/0xa [ 1.130800][ T1] ? __lock_acquire+0x518/0xc20 [ 1.130805][ T1] ? lock_acquire.part.0+0xd4/0x280 [ 1.130807][ T1] ? find_held_lock+0x2b/0x80 [ 1.130811][ T1] dev_printk_emit+0xb9/0xee [ 1.130814][ T1] ? dev_vprintk_emit+0x2c0/0x2c0 [ 1.130817][ T1] ? _raw_write_unlock+0x2d/0x50 [ 1.130821][ T1] ? proc_register+0x368/0x8b0 [ 1.130828][ T1] _dev_info+0xe2/0x116 [ 1.130831][ T1] ? _dev_notice+0x120/0x120 [ 1.130835][ T1] ? rtc_proc_add_device+0x106/0x120 [ 1.130839][ T1] ? rtc_proc_show+0x400/0x400 [ 1.130843][ T1] __devm_rtc_register_device.cold+0xc3/0x3a8 [ 1.130848][ T1] ? devm_rtc_unregister_device+0xd0/0xd0 [ 1.130854][ T1] ? __setup_irq+0xec4/0x1ee0 [ 1.130861][ T1] ? request_threaded_irq+0x1dd/0x330 [ 1.130865][ T1] cmos_do_probe+0x73b/0x98a [ 1.130867][ T1] ? cmos_platform_shutdown+0x370/0x370 [ 1.130870][ T1] ? cmos_irq_disable.cold+0x3a/0x3a [ 1.130872][ T1] ? acpi_dev_pm_attach+0x1f3/0x250 [ 1.130878][ T1] ? cmos_read_alarm_callback+0x340/0x340 [ 1.130879][ T1] ? mc146818_set_time+0x500/0x500 [ 1.130883][ T1] ? irq_get_irq_data+0xe/0x20 [ 1.130886][ T1] ? platform_get_irq_affinity+0x21f/0x450 [ 1.130896][ T1] platform_probe+0xfe/0x1f0 [ 1.130899][ T1] call_driver_probe+0x61/0x1c0 [ 1.130902][ T1] really_probe+0x199/0x760 [ 1.130905][ T1] ? __device_attach_driver+0x280/0x280 [ 1.130908][ T1] __driver_probe_device+0x24f/0x440 [ 1.130911][ T1] ? __device_attach_driver+0x280/0x280 [ 1.130913][ T1] ? __device_attach_driver+0x280/0x280 [ 1.130915][ T1] driver_probe_device+0x4a/0xf0 [ 1.130918][ T1] __driver_attach+0x1b8/0x540 [ 1.130921][ T1] ? do_raw_spin_lock+0x131/0x280 [ 1.130924][ T1] bus_for_each_dev+0x130/0x1e0 [ 1.130927][ T1] ? bus_remove_file+0x50/0x50 [ 1.130929][ T1] ? __lock_release.isra.0+0x69/0x1a0 [ 1.130932][ T1] ? rtc_dev_init+0x40/0x40 [ 1.130937][ T1] ? rtc_dev_init+0x40/0x40 [ 1.130939][ T1] bus_add_driver+0x2c8/0x530 [ 1.130943][ T1] driver_register+0x1a3/0x390 [ 1.130946][ T1] __platform_driver_probe+0x13f/0x270 [ 1.130949][ T1] cmos_init+0x31/0x40 [ 1.130951][ T1] do_one_initcall+0x124/0x4f0 [ 1.130954][ T1] ? trace_event_raw_event_initcall_level+0x280/0x280 [ 1.130956][ T1] ? parameq+0x110/0x110 [ 1.130962][ T1] ? kernel_init_freeable+0x3f1/0x630 [ 1.130966][ T1] ? rcu_is_watching+0x16/0xd0 [ 1.130969][ T1] kernel_init_freeable+0x596/0x630 [ 1.130972][ T1] ? rest_init+0x280/0x280 [ 1.130976][ T1] kernel_init+0x21/0x150 [ 1.130978][ T1] ? rest_init+0x280/0x280 [ 1.130980][ T1] ret_from_fork+0x474/0x6b0 [ 1.130984][ T1] ? arch_exit_to_user_mode_prepare.isra.0+0x120/0x120 [ 1.130988][ T1] ? __switch_to+0x5a3/0xe00 [ 1.130991][ T1] ? rest_init+0x280/0x280 [ 1.130994][ T1] ret_from_fork_asm+0x11/0x20 [ 1.131002][ T1] [ 1.164465][ T1] rtc_cmos PNP0B00:00: setting system clock to 2026-08-28T12:31:16 UTC (1787920276) [ 1.165578][ T1] rtc_cmos PNP0B00:00: alarms up to one day, 242 bytes nvram [ 1.169096][ T1] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev [ 1.179033][ T1] NET: Registered PF_INET6 protocol family [ 1.183375][ T1] Segment Routing with IPv6 [ 1.183887][ T1] In-situ OAM (IOAM) with IPv6 [ 1.184273][ T1] NET: Registered PF_PACKET protocol family [ 1.184555][ T1] 9pnet: Installing 9P2000 support [ 1.184930][ T1] Key type dns_resolver registered [ 1.185638][ T1] NET: Registered PF_VSOCK protocol family [ 1.190485][ T1] IPI shorthand broadcast: enabled [ 1.299122][ T1] sched_clock: Marking stable (1258001974, 40544422)->(1385167125, -86620729) [ 1.302711][ T1] registered taskstats version 1 [ 1.305227][ T1] Loading compiled-in X.509 certificates [ 1.412485][ T1] Demotion targets for Node 0: null [ 1.412803][ T1] kmemleak: Kernel memory leak detector initialized (mem pool available: 12240) [ 1.413122][ T1] page_owner is disabled [ 1.413777][ T1] PM: Magic number: 6:866:532 [ 1.414229][ T1] netconsole: network logging started [ 1.415717][ T1] ALSA device list: [ 1.416047][ T1] No soundcards found. [ 1.418296][ T1] md: Skipping autodetection of RAID arrays. (raid=autodetect will force) [ 1.421140][ T1] VFS: Mounted root (virtiofs filesystem) readonly on device 0:24. [ 1.422040][ T1] devtmpfs: mounted [ 1.422371][ T1] VFS: Pivoted into new rootfs [ 1.442282][ T71] kwatchdog (71) used greatest stack depth: 29688 bytes left [ 1.453628][ T1] Freeing unused kernel image (initmem) memory: 2536K [ 1.453917][ T1] Write protecting the kernel read-only data: 55296k [ 1.454585][ T1] Freeing unused kernel image (text/rodata gap) memory: 660K [ 1.455079][ T1] Freeing unused kernel image (rodata/data gap) memory: 624K [ 1.455370][ T1] Run /usr/lib/python3.14/site-packages/virtme/guest/bin/virtme-ng-init as init process [ 1.455719][ T1] with arguments: [ 1.455852][ T1] /usr/lib/python3.14/site-packages/virtme/guest/bin/virtme-ng-init [ 1.456107][ T1] with environment: [ 1.456240][ T1] HOME=/ [ 1.456377][ T1] TERM=dumb [ 1.456502][ T1] virtme_hostname=vmksft-packetdrill-dbg,debug-threads=on [ 1.456755][ T1] nr_open=2147483584 [ 1.456883][ T1] virtme_link_mods=/srv/vmksft/testing/wt-8/.virtme_mods/lib/modules/0.0.0 [ 1.457174][ T1] virtme_rw_overlay0=/etc [ 1.457339][ T1] virtme_rw_overlay1=/lib [ 1.457498][ T1] virtme_rw_overlay2=/home [ 1.457667][ T1] virtme_rw_overlay3=/opt [ 1.457836][ T1] virtme_rw_overlay4=/srv [ 1.458002][ T1] virtme_rw_overlay5=/usr [ 1.458164][ T1] virtme_rw_overlay6=/var [ 1.458333][ T1] virtme_rw_overlay7=/tmp [ 1.458492][ T1] virtme_console=ttyS0 [ 1.458657][ T1] virtme_chdir=srv/vmksft/testing/wt-8 [ 1.477410][ T1] virtme-ng-init: mount devtmpfs -> /dev: EBUSY: Device or resource busy [ 1.478791][ T1] virtme-ng-init: Setting hostname to vmksft-packetdrill-dbg,debug-threads=on... [ 1.490528][ T1] overlayfs: failed to set xattr on upper [ 1.490858][ T1] overlayfs: ...falling back to redirect_dir=nofollow. [ 1.491146][ T1] overlayfs: ...falling back to uuid=null. [ 1.493792][ T1] overlayfs: failed to set xattr on upper [ 1.494017][ T1] overlayfs: ...falling back to redirect_dir=nofollow. [ 1.494299][ T1] overlayfs: ...falling back to uuid=null. [ 1.496320][ T1] overlayfs: failed to set xattr on upper [ 1.496535][ T1] overlayfs: ...falling back to redirect_dir=nofollow. [ 1.496875][ T1] overlayfs: ...falling back to uuid=null. [ 1.498929][ T1] overlayfs: failed to set xattr on upper [ 1.499148][ T1] overlayfs: ...falling back to redirect_dir=nofollow. [ 1.499397][ T1] overlayfs: ...falling back to uuid=null. [ 1.501442][ T1] overlayfs: failed to set xattr on upper [ 1.502173][ T1] overlayfs: ...falling back to redirect_dir=nofollow. [ 1.502435][ T1] overlayfs: ...falling back to uuid=null. [ 1.504325][ T1] overlayfs: failed to set xattr on upper [ 1.504541][ T1] overlayfs: ...falling back to redirect_dir=nofollow. [ 1.505095][ T1] overlayfs: ...falling back to uuid=null. [ 1.507055][ T1] overlayfs: failed to set xattr on upper [ 1.507273][ T1] overlayfs: ...falling back to redirect_dir=nofollow. [ 1.507522][ T1] overlayfs: ...falling back to uuid=null. [ 1.509496][ T1] overlayfs: failed to set xattr on upper [ 1.510337][ T1] overlayfs: ...falling back to redirect_dir=nofollow. [ 1.510605][ T1] overlayfs: ...falling back to uuid=null. [ 1.522698][ T1] virtme-ng-init: running systemd-tmpfiles [ 4.142142][ T72] systemd-tmpfile (72) used greatest stack depth: 24784 bytes left [ 4.142160][ T72] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 4.142163][ T72] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 72, name: systemd-tmpfile [ 4.142164][ T72] preempt_count: 2, expected: 0 [ 4.142165][ T72] RCU nest depth: 0, expected: 0 [ 4.142166][ T72] locks held by systemd-tmpfile/72: 5, last CPU#0: [ 4.142168][ T72] #0: ffffffff8d2027b8 (low_water_lock){+.+.}-{3:3}, at: do_exit+0x887/0xdc0 [ 4.142182][ T72] #1: ffffffff8d369cc0 (console_lock){+.+.}-{0:0}, at: vprintk_emit+0x320/0x3e0 [ 4.142189][ T72] #2: ffffffff8d369d38 (console_srcu){....}-{0:0}, at: console_flush_one_record+0x106/0x710 [ 4.142195][ T72] #3: ffffffff8d289660 (console_owner){....}-{0:0}, at: console_lock_spinning_enable+0x40/0x60 [ 4.142201][ T72] #4: ffffffff8d289560 (printk_legacy_map-wait-type-override){....}-{3:3}, at: console_emit_next_record+0x1df/0x4c0 [ 4.142207][ T72] irq event stamp: 2437668 [ 4.142208][ T72] hardirqs last enabled at (2437667): [] __down_trylock_console_sem+0x86/0xa0 [ 4.142213][ T72] hardirqs last disabled at (2437668): [] console_emit_next_record+0x3d4/0x4c0 [ 4.142215][ T72] softirqs last enabled at (2437156): [] handle_softirqs+0x67c/0x900 [ 4.142217][ T72] softirqs last disabled at (2435769): [] __irq_exit_rcu+0x145/0x1c0 [ 4.142220][ T72] Preemption disabled at: [ 4.142221][ T72] [<0000000000000000>] 0x0 [ 4.142228][ T72] CPU: 0 UID: 0 PID: 72 Comm: systemd-tmpfile Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 4.142232][ T72] Tainted: [W]=WARN [ 4.142232][ T72] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 4.142235][ T72] Call Trace: [ 4.142236][ T72] [ 4.142238][ T72] dump_stack_lvl+0x6f/0xa0 [ 4.142244][ T72] __might_resched.cold+0x1fe/0x2c1 [ 4.142249][ T72] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 4.142252][ T72] ? __kmalloc_noprof+0xdb/0x760 [ 4.142258][ T72] __kmalloc_noprof+0x443/0x760 [ 4.142260][ T72] ? alloc_buf.isra.0+0x4b/0x260 [ 4.142267][ T72] ? do_raw_spin_unlock+0x59/0x250 [ 4.142270][ T72] alloc_buf.isra.0+0x4b/0x260 [ 4.142274][ T72] put_chars+0x1e1/0x2f0 [ 4.142277][ T72] ? __send_to_port+0x420/0x420 [ 4.142279][ T72] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 4.142283][ T72] ? validate_chain+0x38b/0xc20 [ 4.142289][ T72] hvc_console_print+0x292/0x780 [ 4.142295][ T72] ? hvc_write+0x3a0/0x3a0 [ 4.142298][ T72] ? rcu_is_watching+0x16/0xd0 [ 4.142300][ T72] ? lock_acquire+0x13c/0x160 [ 4.142304][ T72] console_emit_next_record+0x22f/0x4c0 [ 4.142308][ T72] ? devkmsg_read+0x4b0/0x4b0 [ 4.142309][ T72] ? console_flush_one_record+0x106/0x710 [ 4.142312][ T72] ? rcu_is_watching+0x16/0xd0 [ 4.142314][ T72] ? lock_acquire+0x13c/0x160 [ 4.142318][ T72] console_flush_one_record+0x46f/0x710 [ 4.142322][ T72] ? console_emit_next_record+0x4c0/0x4c0 [ 4.142323][ T72] ? __lock_acquire+0x518/0xc20 [ 4.142329][ T72] console_unlock+0xee/0x1f0 [ 4.142331][ T72] ? console_flush_one_record+0x710/0x710 [ 4.142333][ T72] ? rcu_is_watching+0x16/0xd0 [ 4.142334][ T72] ? lock_acquire+0x60/0x160 [ 4.142338][ T72] ? __down_trylock_console_sem+0x5e/0xa0 [ 4.142340][ T72] ? vprintk_emit+0x320/0x3e0 [ 4.142343][ T72] vprintk_emit+0x37c/0x3e0 [ 4.142347][ T72] ? wake_up_klogd_work_func+0x90/0x90 [ 4.142350][ T72] ? __lock_acquire+0x518/0xc20 [ 4.142354][ T72] _printk+0xc7/0x100 [ 4.142358][ T72] ? snapshot_read.cold+0x21/0x21 [ 4.142360][ T72] ? do_raw_spin_lock+0x131/0x280 [ 4.142363][ T72] ? __rwlock_init+0x150/0x150 [ 4.142367][ T72] ? do_raw_spin_lock+0x131/0x280 [ 4.142371][ T72] do_exit.cold+0x82/0x9c [ 4.142374][ T72] ? exit_notify+0x890/0x890 [ 4.142376][ T72] ? __lock_release.isra.0+0x69/0x1a0 [ 4.142379][ T72] ? rcu_is_watching+0x16/0xd0 [ 4.142383][ T72] do_group_exit+0xb8/0x370 [ 4.142386][ T72] __x64_sys_exit_group+0x3c/0x50 [ 4.142388][ T72] x64_sys_call+0x1567/0x1570 [ 4.142391][ T72] do_syscall_64+0xff/0x530 [ 4.142395][ T72] ? exc_page_fault+0xee/0x100 [ 4.142398][ T72] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 4.142401][ T72] RIP: 0033:0x7f28fa6de1b8 [ 4.142403][ T72] Code: Unable to access opcode bytes at 0x7f28fa6de18e. [ 4.142404][ T72] RSP: 002b:00007ffef190d288 EFLAGS: 00000246 ORIG_RAX: 00000000000000e7 [ 4.142407][ T72] RAX: ffffffffffffffda RBX: 00007f28fa80ef88 RCX: 00007f28fa6de1b8 [ 4.142408][ T72] RDX: 00007f28f9f3c4c8 RSI: fffffffffffffe90 RDI: 0000000000000049 [ 4.142409][ T72] RBP: 00007ffef190d2e0 R08: 0000000000000000 R09: 0000000000001000 [ 4.142410][ T72] R10: 00007ffef190d0a0 R11: 0000000000000246 R12: 0000000000000001 [ 4.142411][ T72] R13: 0000000000000049 R14: 00007f28fa80d680 R15: 00007f28fa80efa0 [ 4.142418][ T72] [ 4.142513][ T1] virtme-ng-init: Failed to read '/usr/lib/tmpfiles.d/audit.conf': Permission denied [ 4.142513][ T1] Failed to create directory or subvolume "/var/spool/at/spool": Permission denied [ 4.142513][ T1] Failed to create file /var/spool/at/.SEQ: Permission denied [ 4.142513][ T1] Failed to opendir() '/proc/self/fd/6': Permission denied [ 4.174163][ T1] virtme-ng-init: basic initialization done [ 4.226983][ T78] ip (78) used greatest stack depth: 24016 bytes left [ 4.246742][ T77] systemd-udevd (77) used greatest stack depth: 23856 bytes left [ 4.246944][ T74] virtme-ng-init: Starting systemd-udevd version 259.8-1.fc44 [ 4.247577][ T74] virtme-ng-init: triggering udev coldplug [ 7.135428][ T74] virtme-ng-init: waiting for udev to settle [ 7.135442][ T74] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 7.135445][ T74] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 74, name: virtme-ng-init [ 7.135447][ T74] preempt_count: 1, expected: 0 [ 7.135448][ T74] RCU nest depth: 0, expected: 0 [ 7.135449][ T74] locks held by virtme-ng-init/74: 4, last CPU#1: [ 7.135452][ T74] #0: ffffffff8d369cc0 (console_lock){+.+.}-{0:0}, at: vprintk_emit+0x320/0x3e0 [ 7.135464][ T74] #1: ffffffff8d369d38 (console_srcu){....}-{0:0}, at: console_flush_one_record+0x106/0x710 [ 7.135469][ T74] #2: ffffffff8d289660 (console_owner){....}-{0:0}, at: console_lock_spinning_enable+0x40/0x60 [ 7.135473][ T74] #3: ffffffff8d289560 (printk_legacy_map-wait-type-override){....}-{3:3}, at: console_emit_next_record+0x1df/0x4c0 [ 7.135477][ T74] irq event stamp: 3974 [ 7.135478][ T74] hardirqs last enabled at (3973): [] __down_trylock_console_sem+0x86/0xa0 [ 7.135481][ T74] hardirqs last disabled at (3974): [] console_emit_next_record+0x3d4/0x4c0 [ 7.135483][ T74] softirqs last enabled at (3830): [] handle_softirqs+0x67c/0x900 [ 7.135487][ T74] softirqs last disabled at (2667): [] __irq_exit_rcu+0x145/0x1c0 [ 7.135490][ T74] Preemption disabled at: [ 7.135491][ T74] [] vprintk_emit+0x31b/0x3e0 [ 7.135497][ T74] CPU: 1 UID: 0 PID: 74 Comm: virtme-ng-init Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 7.135500][ T74] Tainted: [W]=WARN [ 7.135501][ T74] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 7.135503][ T74] Call Trace: [ 7.135504][ T74] [ 7.135506][ T74] dump_stack_lvl+0x6f/0xa0 [ 7.135511][ T74] ? vprintk_emit+0x31b/0x3e0 [ 7.135513][ T74] __might_resched.cold+0x1fe/0x2c1 [ 7.135518][ T74] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 7.135522][ T74] ? __kmalloc_noprof+0xdb/0x760 [ 7.135528][ T74] __kmalloc_noprof+0x443/0x760 [ 7.135530][ T74] ? alloc_buf.isra.0+0x4b/0x260 [ 7.135537][ T74] ? do_raw_spin_unlock+0x59/0x250 [ 7.135540][ T74] alloc_buf.isra.0+0x4b/0x260 [ 7.135547][ T74] put_chars+0x1e1/0x2f0 [ 7.135550][ T74] ? __send_to_port+0x420/0x420 [ 7.135552][ T74] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 7.135557][ T74] ? validate_chain+0x38b/0xc20 [ 7.135563][ T74] hvc_console_print+0x292/0x780 [ 7.135570][ T74] ? hvc_write+0x3a0/0x3a0 [ 7.135573][ T74] ? rcu_is_watching+0x16/0xd0 [ 7.135575][ T74] ? lock_acquire+0x13c/0x160 [ 7.135580][ T74] console_emit_next_record+0x22f/0x4c0 [ 7.135584][ T74] ? devkmsg_read+0x4b0/0x4b0 [ 7.135585][ T74] ? console_flush_one_record+0x106/0x710 [ 7.135588][ T74] ? rcu_is_watching+0x16/0xd0 [ 7.135590][ T74] ? lock_acquire+0x13c/0x160 [ 7.135595][ T74] console_flush_one_record+0x46f/0x710 [ 7.135599][ T74] ? console_emit_next_record+0x4c0/0x4c0 [ 7.135601][ T74] ? __lock_acquire+0x518/0xc20 [ 7.135607][ T74] console_unlock+0xee/0x1f0 [ 7.135609][ T74] ? console_flush_one_record+0x710/0x710 [ 7.135611][ T74] ? rcu_is_watching+0x16/0xd0 [ 7.135613][ T74] ? lock_acquire+0x60/0x160 [ 7.135617][ T74] ? __down_trylock_console_sem+0x5e/0xa0 [ 7.135619][ T74] ? vprintk_emit+0x320/0x3e0 [ 7.135622][ T74] vprintk_emit+0x37c/0x3e0 [ 7.135625][ T74] ? wake_up_klogd_work_func+0x90/0x90 [ 7.135628][ T74] ? _copy_from_iter+0x1bb/0x1810 [ 7.135634][ T74] devkmsg_emit.constprop.0+0xbc/0xf1 [ 7.135639][ T74] ? vprintk_emit.cold+0x107/0x107 [ 7.135641][ T74] ? simple_strntoull+0x10f/0x140 [ 7.135646][ T74] ? date_str+0x1e0/0x1e0 [ 7.135649][ T74] ? devkmsg_write+0xd1/0x2c0 [ 7.135653][ T74] devkmsg_write.cold+0x5a/0x8b [ 7.135656][ T74] ? vprintk_default+0x20/0x20 [ 7.135661][ T74] ? vprintk_default+0x20/0x20 [ 7.135663][ T74] new_sync_write+0x33e/0x760 [ 7.135667][ T74] ? kasan_quarantine_put+0x42/0x2b0 [ 7.135672][ T74] ? new_sync_read+0x750/0x750 [ 7.135676][ T74] ? __lock_release.isra.0+0x69/0x1a0 [ 7.135682][ T74] ? __fget_files+0x1e3/0x460 [ 7.135686][ T74] vfs_write+0x6a2/0xbd0 [ 7.135690][ T74] ksys_write+0x116/0x250 [ 7.135693][ T74] ? __ia32_sys_read+0xc0/0xc0 [ 7.135696][ T74] ? rcu_is_watching+0x16/0xd0 [ 7.135699][ T74] do_syscall_64+0xff/0x530 [ 7.135702][ T74] ? exc_page_fault+0xee/0x100 [ 7.135706][ T74] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 7.135708][ T74] RIP: 0033:0x7f9df5fbbed2 [ 7.135712][ 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 [ 7.135714][ T74] RSP: 002b:00007f9df5f02c68 EFLAGS: 00000246 ORIG_RAX: 0000000000000001 [ 7.135716][ T74] RAX: ffffffffffffffda RBX: 000000000000002e RCX: 00007f9df5fbbed2 [ 7.135718][ T74] RDX: 000000000000002e RSI: 00007f9df0001090 RDI: 0000000000000003 [ 7.135719][ T74] RBP: 00007f9df5f02c90 R08: 0000000000000000 R09: 0000000000000000 [ 7.135720][ T74] R10: 0000000000000000 R11: 0000000000000246 R12: 00007f9df60460a0 [ 7.135721][ T74] R13: 00007f9df5f443e0 R14: 00007f9df0001090 R15: 00007f9df5f02da8 [ 7.135728][ T74] [ 7.441690][ C0] clocksource: Watchdog remote CPU 1 read timed out [ 7.441748][ C0] [ 7.441750][ C0] ======================================================== [ 7.441751][ C0] WARNING: possible irq lock inversion dependency detected [ 7.441753][ C0] 7.2.0-virtme #1 Tainted: G W [ 7.441755][ C0] -------------------------------------------------------- [ 7.441755][ C0] (udev-worker)/84 just changed the state of lock: [ 7.441757][ C0] ffffffff8d289660 (console_owner){..-.}-{0:0}, at: console_lock_spinning_enable+0x40/0x60 [ 7.441769][ C0] but this lock took another, SOFTIRQ-unsafe lock in the past: [ 7.441770][ C0] (fs_reclaim){+.+.}-{0:0} [ 7.441771][ C0] [ 7.441771][ C0] [ 7.441771][ C0] and interrupts could create inverse lock ordering between them. [ 7.441771][ C0] [ 7.441772][ C0] [ 7.441772][ C0] other info that might help us debug this: [ 7.441772][ C0] Possible interrupt unsafe locking scenario: [ 7.441772][ C0] [ 7.441773][ C0] CPU0 CPU1 [ 7.441774][ C0] ---- ---- [ 7.441774][ C0] lock(fs_reclaim); [ 7.441775][ C0] local_irq_disable(); [ 7.441776][ C0] lock(console_owner); [ 7.441777][ C0] lock(fs_reclaim); [ 7.441778][ C0] [ 7.441778][ C0] lock(console_owner); [ 7.441779][ C0] [ 7.441779][ C0] *** DEADLOCK *** [ 7.441779][ C0] [ 7.441779][ C0] locks held by (udev-worker)/84: 5, last CPU#0: [ 7.441781][ C0] #0: ffffffff8d5ae1b8 (remove_cache_srcu){.+.+}-{0:0}, at: kasan_quarantine_reduce+0x84/0x240 [ 7.441787][ C0] #1: ffa0000000007c90 ((&watchdog_timer)){+.-.}-{0:0}, at: call_timer_fn+0x110/0x4d0 [ 7.441791][ C0] #2: ffffffff8d3ce8b8 (watchdog_lock){+.-.}-{3:3}, at: clocksource_watchdog+0x15/0x30 [ 7.441795][ C0] #3: ffffffff8d369cc0 (console_lock){+.+.}-{0:0}, at: vprintk_emit+0x320/0x3e0 [ 7.441798][ C0] #4: ffffffff8d369d38 (console_srcu){....}-{0:0}, at: console_flush_one_record+0x106/0x710 [ 7.441801][ C0] [ 7.441801][ C0] the shortest dependencies between 2nd lock and 1st lock: [ 7.441805][ C0] -> (fs_reclaim){+.+.}-{0:0} { [ 7.441808][ C0] HARDIRQ-ON-W at: [ 7.441809][ C0] __lock_acquire+0x388/0xc20 [ 7.441813][ C0] lock_acquire.part.0+0xd4/0x280 [ 7.441814][ C0] fs_reclaim_acquire+0xd5/0x120 [ 7.441817][ C0] __kmalloc_cache_noprof+0x6e/0x620 [ 7.441820][ C0] kthread_create_worker_on_node+0xea/0x210 [ 7.441823][ C0] workqueue_init+0x2a/0x680 [ 7.441827][ C0] kernel_init_freeable+0x2fe/0x630 [ 7.441829][ C0] kernel_init+0x21/0x150 [ 7.441833][ C0] ret_from_fork+0x474/0x6b0 [ 7.441836][ C0] ret_from_fork_asm+0x11/0x20 [ 7.441840][ C0] SOFTIRQ-ON-W at: [ 7.441840][ C0] __lock_acquire+0x388/0xc20 [ 7.441842][ C0] lock_acquire.part.0+0xd4/0x280 [ 7.441844][ C0] fs_reclaim_acquire+0xd5/0x120 [ 7.441845][ C0] __kmalloc_cache_noprof+0x6e/0x620 [ 7.441847][ C0] kthread_create_worker_on_node+0xea/0x210 [ 7.441849][ C0] workqueue_init+0x2a/0x680 [ 7.441850][ C0] kernel_init_freeable+0x2fe/0x630 [ 7.441851][ C0] kernel_init+0x21/0x150 [ 7.441853][ C0] ret_from_fork+0x474/0x6b0 [ 7.441854][ C0] ret_from_fork_asm+0x11/0x20 [ 7.441856][ C0] INITIAL USE at: [ 7.441857][ C0] __lock_acquire+0x388/0xc20 [ 7.441858][ C0] lock_acquire.part.0+0xd4/0x280 [ 7.441860][ C0] fs_reclaim_acquire+0xd5/0x120 [ 7.441861][ C0] __kmalloc_cache_noprof+0x6e/0x620 [ 7.441863][ C0] kthread_create_worker_on_node+0xea/0x210 [ 7.441865][ C0] workqueue_init+0x2a/0x680 [ 7.441866][ C0] kernel_init_freeable+0x2fe/0x630 [ 7.441868][ C0] kernel_init+0x21/0x150 [ 7.441869][ C0] ret_from_fork+0x474/0x6b0 [ 7.441870][ C0] ret_from_fork_asm+0x11/0x20 [ 7.441872][ C0] } [ 7.441872][ C0] ... key at: [] __fs_reclaim_map+0x0/0xbe0 [ 7.441877][ C0] ... acquired at: [ 7.441878][ C0] __lock_acquire+0x518/0xc20 [ 7.441880][ C0] lock_acquire.part.0+0xd4/0x280 [ 7.441881][ C0] fs_reclaim_acquire+0xd5/0x120 [ 7.441883][ C0] __kmalloc_noprof+0xd3/0x760 [ 7.441884][ C0] alloc_buf.isra.0+0x4b/0x260 [ 7.441888][ C0] put_chars+0x1e1/0x2f0 [ 7.441889][ C0] hvc_console_print+0x292/0x780 [ 7.441892][ C0] console_emit_next_record+0x22f/0x4c0 [ 7.441893][ C0] console_flush_one_record+0x46f/0x710 [ 7.441894][ C0] console_unlock+0xee/0x1f0 [ 7.441895][ C0] vprintk_emit+0x37c/0x3e0 [ 7.441897][ C0] dev_vprintk_emit+0x27f/0x2c0 [ 7.441900][ C0] dev_printk_emit+0xb9/0xee [ 7.441902][ C0] _dev_info+0xe2/0x116 [ 7.441903][ C0] __devm_rtc_register_device.cold+0xc3/0x3a8 [ 7.441906][ C0] cmos_do_probe+0x73b/0x98a [ 7.441908][ C0] platform_probe+0xfe/0x1f0 [ 7.441910][ C0] call_driver_probe+0x61/0x1c0 [ 7.441912][ C0] really_probe+0x199/0x760 [ 7.441914][ C0] __driver_probe_device+0x24f/0x440 [ 7.441916][ C0] driver_probe_device+0x4a/0xf0 [ 7.441918][ C0] __driver_attach+0x1b8/0x540 [ 7.441919][ C0] bus_for_each_dev+0x130/0x1e0 [ 7.441921][ C0] bus_add_driver+0x2c8/0x530 [ 7.441923][ C0] driver_register+0x1a3/0x390 [ 7.441930][ C0] __platform_driver_probe+0x13f/0x270 [ 7.441932][ C0] cmos_init+0x31/0x40 [ 7.441934][ C0] do_one_initcall+0x124/0x4f0 [ 7.441936][ C0] kernel_init_freeable+0x596/0x630 [ 7.441937][ C0] kernel_init+0x21/0x150 [ 7.441938][ C0] ret_from_fork+0x474/0x6b0 [ 7.441940][ C0] ret_from_fork_asm+0x11/0x20 [ 7.441944][ C0] [ 7.441944][ C0] -> (console_owner){..-.}-{0:0} { [ 7.441946][ C0] IN-SOFTIRQ-W at: [ 7.441947][ C0] __lock_acquire+0x388/0xc20 [ 7.441949][ C0] lock_acquire.part.0+0xd4/0x280 [ 7.441950][ C0] console_lock_spinning_enable+0x5c/0x60 [ 7.441951][ C0] console_emit_next_record+0x1d1/0x4c0 [ 7.441953][ C0] console_flush_one_record+0x46f/0x710 [ 7.441954][ C0] console_unlock+0xee/0x1f0 [ 7.441955][ C0] vprintk_emit+0x37c/0x3e0 [ 7.441956][ C0] _printk+0xc7/0x100 [ 7.441959][ C0] clocksource_watchdog.part.0.cold+0x105/0x1dd [ 7.441961][ C0] call_timer_fn+0x160/0x4d0 [ 7.441962][ C0] __run_timers+0x68f/0xaa0 [ 7.441964][ C0] run_timer_softirq+0xf0/0x160 [ 7.441965][ C0] handle_softirqs+0x1d3/0x900 [ 7.441968][ C0] __irq_exit_rcu+0x145/0x1c0 [ 7.441969][ C0] irq_exit_rcu+0xe/0x30 [ 7.441971][ C0] sysvec_apic_timer_interrupt+0x9d/0xe0 [ 7.441973][ C0] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 7.441976][ C0] free_slab+0x83/0x130 [ 7.441979][ C0] qlist_free_all+0x5c/0x110 [ 7.441981][ C0] kasan_quarantine_reduce+0x196/0x240 [ 7.441983][ C0] __kasan_slab_alloc+0x4b/0x70 [ 7.441986][ C0] kmem_cache_alloc_noprof+0x21f/0x5c0 [ 7.441989][ C0] do_getname.isra.0+0x32/0x240 [ 7.441993][ C0] do_faccessat+0xe6/0x9a0 [ 7.441996][ C0] __x64_sys_faccessat2+0x96/0x120 [ 7.441998][ C0] do_syscall_64+0xff/0x530 [ 7.442002][ C0] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 7.442004][ C0] INITIAL USE at: [ 7.442005][ C0] } [ 7.442005][ C0] ... key at: [] console_owner_dep_map+0x0/0x60 [ 7.442009][ C0] ... acquired at: [ 7.442010][ C0] mark_lock+0x1d7/0xa00 [ 7.442011][ C0] mark_usage+0x42/0x170 [ 7.442013][ C0] __lock_acquire+0x388/0xc20 [ 7.442015][ C0] lock_acquire.part.0+0xd4/0x280 [ 7.442016][ C0] console_lock_spinning_enable+0x5c/0x60 [ 7.442017][ C0] console_emit_next_record+0x1d1/0x4c0 [ 7.442018][ C0] console_flush_one_record+0x46f/0x710 [ 7.442019][ C0] console_unlock+0xee/0x1f0 [ 7.442021][ C0] vprintk_emit+0x37c/0x3e0 [ 7.442022][ C0] _printk+0xc7/0x100 [ 7.442023][ C0] clocksource_watchdog.part.0.cold+0x105/0x1dd [ 7.442024][ C0] call_timer_fn+0x160/0x4d0 [ 7.442025][ C0] __run_timers+0x68f/0xaa0 [ 7.442026][ C0] run_timer_softirq+0xf0/0x160 [ 7.442028][ C0] handle_softirqs+0x1d3/0x900 [ 7.442029][ C0] __irq_exit_rcu+0x145/0x1c0 [ 7.442030][ C0] irq_exit_rcu+0xe/0x30 [ 7.442032][ C0] sysvec_apic_timer_interrupt+0x9d/0xe0 [ 7.442033][ C0] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 7.442034][ C0] free_slab+0x83/0x130 [ 7.442036][ C0] qlist_free_all+0x5c/0x110 [ 7.442037][ C0] kasan_quarantine_reduce+0x196/0x240 [ 7.442039][ C0] __kasan_slab_alloc+0x4b/0x70 [ 7.442040][ C0] kmem_cache_alloc_noprof+0x21f/0x5c0 [ 7.442042][ C0] do_getname.isra.0+0x32/0x240 [ 7.442043][ C0] do_faccessat+0xe6/0x9a0 [ 7.442045][ C0] __x64_sys_faccessat2+0x96/0x120 [ 7.442046][ C0] do_syscall_64+0xff/0x530 [ 7.442048][ C0] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 7.442049][ C0] [ 7.442050][ C0] [ 7.442050][ C0] stack backtrace: [ 7.442052][ C0] CPU: 0 UID: 0 PID: 84 Comm: (udev-worker) Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 7.442056][ C0] Tainted: [W]=WARN [ 7.442057][ C0] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 7.442059][ C0] Call Trace: [ 7.442060][ C0] [ 7.442061][ C0] dump_stack_lvl+0x6f/0xa0 [ 7.442064][ C0] print_irq_inversion_bug.part.0.cold+0xe6/0x143 [ 7.442067][ C0] mark_lock_irq+0x989/0x9c0 [ 7.442069][ C0] ? add_lock_to_list+0x2c/0x1a0 [ 7.442073][ C0] mark_lock+0x1d7/0xa00 [ 7.442075][ C0] mark_usage+0x42/0x170 [ 7.442077][ C0] __lock_acquire+0x388/0xc20 [ 7.442079][ C0] lock_acquire.part.0+0xd4/0x280 [ 7.442081][ C0] ? console_lock_spinning_enable+0x40/0x60 [ 7.442083][ C0] ? rcu_is_watching+0x16/0xd0 [ 7.442086][ C0] ? lock_acquire+0x13c/0x160 [ 7.442088][ C0] console_lock_spinning_enable+0x5c/0x60 [ 7.442089][ C0] ? console_lock_spinning_enable+0x40/0x60 [ 7.442090][ C0] console_emit_next_record+0x1d1/0x4c0 [ 7.442092][ C0] ? devkmsg_read+0x4b0/0x4b0 [ 7.442093][ C0] ? console_flush_one_record+0x106/0x710 [ 7.442095][ C0] ? rcu_is_watching+0x16/0xd0 [ 7.442096][ C0] ? lock_acquire+0x13c/0x160 [ 7.442099][ C0] console_flush_one_record+0x46f/0x710 [ 7.442100][ C0] ? console_emit_next_record+0x4c0/0x4c0 [ 7.442102][ C0] ? __lock_acquire+0x518/0xc20 [ 7.442104][ C0] console_unlock+0xee/0x1f0 [ 7.442106][ C0] ? console_flush_one_record+0x710/0x710 [ 7.442107][ C0] ? rcu_is_watching+0x16/0xd0 [ 7.442108][ C0] ? lock_acquire+0x60/0x160 [ 7.442110][ C0] ? __down_trylock_console_sem+0x5e/0xa0 [ 7.442113][ C0] ? vprintk_emit+0x320/0x3e0 [ 7.442114][ C0] vprintk_emit+0x37c/0x3e0 [ 7.442116][ C0] ? wake_up_klogd_work_func+0x90/0x90 [ 7.442118][ C0] ? clocksource_watchdog.part.0+0x450/0x540 [ 7.442120][ C0] _printk+0xc7/0x100 [ 7.442122][ C0] ? snapshot_read.cold+0x21/0x21 [ 7.442124][ C0] ? clocksource_watchdog.part.0+0x450/0x540 [ 7.442126][ C0] ? __lock_release.isra.0+0x69/0x1a0 [ 7.442129][ C0] clocksource_watchdog.part.0.cold+0x105/0x1dd [ 7.442130][ C0] ? clocksource_watchdog.part.0+0x540/0x540 [ 7.442132][ C0] ? clocksource_watchdog.part.0+0x540/0x540 [ 7.442134][ C0] call_timer_fn+0x160/0x4d0 [ 7.442136][ C0] ? detach_if_pending+0x1d0/0x1d0 [ 7.442137][ C0] ? debug_object_active_state+0x430/0x430 [ 7.442140][ C0] ? find_held_lock+0x2b/0x80 [ 7.442142][ C0] ? __lock_release.isra.0+0x69/0x1a0 [ 7.442144][ C0] ? mark_held_locks+0x40/0x70 [ 7.442146][ C0] __run_timers+0x68f/0xaa0 [ 7.442147][ C0] ? clocksource_watchdog.part.0+0x540/0x540 [ 7.442150][ C0] ? __bpf_trace_itimer_expire+0x10/0x10 [ 7.442151][ C0] ? __lock_acquire+0x518/0xc20 [ 7.442154][ C0] ? __rwlock_init+0x150/0x150 [ 7.442157][ C0] run_timer_softirq+0xf0/0x160 [ 7.442159][ C0] ? __run_timers+0xaa0/0xaa0 [ 7.442160][ C0] ? rcu_is_watching+0x16/0xd0 [ 7.442162][ C0] handle_softirqs+0x1d3/0x900 [ 7.442164][ C0] ? __lock_release.isra.0+0x69/0x1a0 [ 7.442166][ C0] ? _local_bh_enable+0xc0/0xc0 [ 7.442168][ C0] __irq_exit_rcu+0x145/0x1c0 [ 7.442170][ C0] irq_exit_rcu+0xe/0x30 [ 7.442172][ C0] sysvec_apic_timer_interrupt+0x9d/0xe0 [ 7.442173][ C0] [ 7.442174][ C0] [ 7.442175][ C0] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 7.442176][ C0] RIP: 0010:free_slab+0x83/0x130 [ 7.442179][ C0] Code: 23 b9 59 02 e9 96 00 00 00 48 89 c3 0f b7 56 2a 81 e2 ff 7f 00 00 0f af 57 18 48 01 d0 48 39 c3 73 56 48 89 da b9 bb 00 00 00 <48> 89 74 24 08 48 89 3c 24 e8 2f fc ff ff 48 8b 74 24 08 48 8b 3c [ 7.442182][ C0] RSP: 0018:ffa0000000537cf8 EFLAGS: 00000283 [ 7.442185][ C0] RAX: ff11000008fd7f00 RBX: ff11000008fd4280 RCX: 00000000000000bb [ 7.442187][ C0] RDX: ff11000008fd4280 RSI: ffd400000023f500 RDI: ff11000001981840 [ 7.442188][ C0] RBP: ff11000001981840 R08: 000000000000005a R09: ff11000008fd4240 [ 7.442190][ C0] R10: dffffc0000000000 R11: 0000000000000001 R12: ff110000056c5548 [ 7.442192][ C0] R13: 0000000000000000 R14: ffa0000000537d48 R15: ff1100000b3501c0 [ 7.442196][ C0] ? free_slab+0x91/0x130 [ 7.442198][ C0] qlist_free_all+0x5c/0x110 [ 7.442201][ C0] kasan_quarantine_reduce+0x196/0x240 [ 7.442204][ C0] __kasan_slab_alloc+0x4b/0x70 [ 7.442207][ C0] kmem_cache_alloc_noprof+0x21f/0x5c0 [ 7.442208][ C0] ? do_getname.isra.0+0x32/0x240 [ 7.442211][ C0] do_getname.isra.0+0x32/0x240 [ 7.442212][ C0] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 7.442215][ C0] do_faccessat+0xe6/0x9a0 [ 7.442217][ C0] ? generic_file_open+0xa0/0xa0 [ 7.442219][ C0] ? xfd_validate_state+0x2a/0x140 [ 7.442222][ C0] ? restore_fpregs_from_fpstate+0x44/0x130 [ 7.442224][ C0] __x64_sys_faccessat2+0x96/0x120 [ 7.442227][ C0] ? lockdep_hardirqs_on+0x91/0x130 [ 7.442228][ C0] ? do_syscall_64+0xa6/0x530 [ 7.442230][ C0] do_syscall_64+0xff/0x530 [ 7.442231][ C0] ? irq_exit_rcu+0x1a/0x30 [ 7.442233][ C0] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 7.442235][ C0] RIP: 0033:0x7ff61d1f27f9 [ 7.442237][ C0] Code: 00 f3 0f 1e fa 55 41 89 d0 b8 b7 01 00 00 48 89 e5 48 81 ec d0 00 00 00 64 4c 8b 14 25 28 00 00 00 4c 89 55 e8 41 89 ca 0f 05 <48> 3d 00 f0 ff ff 0f 87 3b 02 00 00 89 c2 85 c0 0f 84 21 01 00 00 [ 7.442238][ C0] RSP: 002b:00007ffe11cdcff0 EFLAGS: 00000206 ORIG_RAX: 00000000000001b7 [ 7.442240][ C0] RAX: ffffffffffffffda RBX: 000056242e5bb000 RCX: 00007ff61d1f27f9 [ 7.442241][ C0] RDX: 0000000000000000 RSI: 00007ff61d7087ae RDI: 0000000000000019 [ 7.442242][ C0] RBP: 00007ffe11cdd0c0 R08: 0000000000000000 R09: 0000000000000020 [ 7.442243][ C0] R10: 0000000000000000 R11: 0000000000000206 R12: 000056242e5b8a10 [ 7.442244][ C0] R13: 0000000000000019 R14: 00007ff61d6fd716 R15: 0000000000000019 [ 7.442246][ C0] [ 7.701327][ T74] virtme-ng-init: udev is done [ 7.703416][ T1] virtme-ng-init: initialization done