vm-test-run-systemd-initrd-simple
checks.x86_64-linux.systemd-initrd-simple
· build #51
· raw
1tribuchet: building on jamie2Machine state will be reset. To keep it, pass --keep-machine-state3start all VLans4(finished: start all VLans, in 0.01 seconds)5Test will time out and terminate in 3600.0 seconds6run the VM test script7subtest: testing initrd backdoor8machine: waiting for unit initrd.target9machine: waiting for the VM to finish booting10machine: starting vm11machine: QEMU running (pid 45)12machine # Disk image does not exist, creating the virtualisation disk image...13machine # Formatting '/build/vm-state-machine/tmp.BMPdZyeNp1', fmt=raw size=107374182414machine # mke2fs 1.47.4 (6-Mar-2025)15machine # Discarding device blocks: 0/262144 done16machine # Creating filesystem with 262144 4k blocks and 65536 inodes17machine # Filesystem UUID: 60cfc836-912d-4264-9e87-2fee5a628c7618machine # Superblock backups stored on blocks:19machine # 32768, 98304, 163840, 22937620machine # 21machine # Allocating group tables: 0/8 done22machine # Writing inode tables: 0/8 done23machine # Creating journal (8192 blocks): done24machine # Writing superblocks and filesystem accounting information: 0/8 done25machine # 26machine # Virtualisation disk image created.27machine # Starting virtiofs daemons...28machine # [2026-10-02T03:53:33Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)29machine # [2026-10-02T03:53:33Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether30machine # [2026-10-02T03:53:33Z INFO virtiofsd] Waiting for vhost-user socket connection...31machine # [2026-10-02T03:53:33Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)32machine # [2026-10-02T03:53:33Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether33machine # [2026-10-02T03:53:33Z INFO virtiofsd] Waiting for vhost-user socket connection...34machine # [2026-10-02T03:53:33Z INFO virtiofsd] Client connected, servicing requests35machine # [2026-10-02T03:53:33Z INFO virtiofsd] Client connected, servicing requests36machine # [2026-10-02T03:53:33Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)37machine # [2026-10-02T03:53:33Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether38machine # [2026-10-02T03:53:33Z INFO virtiofsd] Waiting for vhost-user socket connection...39machine # [2026-10-02T03:53:33Z INFO virtiofsd] Client connected, servicing requests40machine # SeaBIOS (version rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org)41machine # 42machine # 43machine # iPXE (http://ipxe.org) 00:02.0 CA00 PCI2.10 PnP PMM+3EFCC730+3EF2C730 CA0044machine # Press Ctrl-B to configure iPXE (PCI 00:02.0)...45machine # 46machine # 47machine # 48machine # 49machine # iPXE (http://ipxe.org) 00:05.0 CB00 PCI2.10 PnP PMM 3EFCC730 3EF2C730 CB0050machine # Press Ctrl-B to configure iPXE (PCI 00:05.0)...51machine # 52machine # 53machine # Booting from ROM...54machine # Probing EDD (edd=off to disable)... ok[ 0.000000] Linux version 6.18.54 (nixbld@localhost) (gcc (GCC) 16.2.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT_DYNAMIC Fri Sep 25 14:35:54 UTC 202655machine # [ 0.000000] Command line: console=ttyS0 console=tty0 panic=1 boot.panic_on_fail clocksource=acpi_pm root=fstab loglevel=7 net.ifnames=0 lsm=landlock,yama,bpf init=/nix/store/lh9zs34p9c1bvyavdq1mlk6pgr61pf8m-nixos-system-machine-test/init regInfo=/nix/.ro-store/zv32cw89qd71hd3phgx2h3gba7i00qhw-closure-info/registration console=ttyS0,115200n8 console=tty056machine # [ 0.000000] BIOS-provided physical RAM map:57machine # [ 0.000000] BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable58machine # [ 0.000000] BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved59machine # [ 0.000000] BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved60machine # [ 0.000000] BIOS-e820: [mem 0x0000000000100000-0x000000003ffd7fff] usable61machine # [ 0.000000] BIOS-e820: [mem 0x000000003ffd8000-0x000000003fffffff] reserved62machine # [ 0.000000] BIOS-e820: [mem 0x00000000b0000000-0x00000000bfffffff] reserved63machine # [ 0.000000] BIOS-e820: [mem 0x00000000fed1c000-0x00000000fed1ffff] reserved64machine # [ 0.000000] BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved65machine # [ 0.000000] BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved66machine # [ 0.000000] BIOS-e820: [mem 0x000000fd00000000-0x000000ffffffffff] reserved67machine # [ 0.000000] NX (Execute Disable) protection: active68machine # [ 0.000000] APIC: Static calls initialized69machine # [ 0.000000] SMBIOS 2.8 present.70machine # [ 0.000000] DMI: QEMU Standard PC (Q35 + ICH9, 2009), BIOS rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org 04/01/201471machine # [ 0.000000] DMI: Memory slots populated: 1/172machine # [ 0.000000] Hypervisor detected: KVM73machine # [ 0.000000] last_pfn = 0x3ffd8 max_arch_pfn = 0x1000000000074machine # [ 0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d0075machine # [ 0.000000] kvm-clock: using sched offset of 538465156 cycles76machine # [ 0.000002] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns77machine # [ 0.000005] tsc: Detected 2400.012 MHz processor78machine # [ 0.000765] last_pfn = 0x3ffd8 max_arch_pfn = 0x1000000000079machine # [ 0.000792] MTRR map: 4 entries (3 fixed + 1 variable; max 19), built from 8 variable MTRRs80machine # [ 0.000794] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT81machine # [ 0.002689] found SMP MP-table at [mem 0x000f5450-0x000f545f]82machine # [ 0.002700] Using GB pages for direct mapping83machine # [ 0.002811] RAMDISK: [mem 0x3e36a000-0x3ffcffff]84machine # [ 0.002818] ACPI: Early table checksum verification disabled85machine # [ 0.002821] ACPI: RSDP 0x00000000000F5270 000014 (v00 BOCHS )86machine # [ 0.002825] ACPI: RSDT 0x000000003FFE2422 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001)87machine # [ 0.002829] ACPI: FACP 0x000000003FFE221A 0000F4 (v03 BOCHS BXPC 00000001 BXPC 00000001)88machine # [ 0.002836] ACPI: DSDT 0x000000003FFE0040 0021DA (v01 BOCHS BXPC 00000001 BXPC 00000001)89machine # [ 0.002838] ACPI: FACS 0x000000003FFE0000 00004090machine # [ 0.002839] ACPI: APIC 0x000000003FFE230E 000078 (v03 BOCHS BXPC 00000001 BXPC 00000001)91machine # [ 0.002841] ACPI: HPET 0x000000003FFE2386 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001)92machine # [ 0.002842] ACPI: MCFG 0x000000003FFE23BE 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001)93machine # [ 0.002844] ACPI: WAET 0x000000003FFE23FA 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001)94machine # [ 0.002845] ACPI: Reserving FACP table memory at [mem 0x3ffe221a-0x3ffe230d]95machine # [ 0.002846] ACPI: Reserving DSDT table memory at [mem 0x3ffe0040-0x3ffe2219]96machine # [ 0.002847] ACPI: Reserving FACS table memory at [mem 0x3ffe0000-0x3ffe003f]97machine # [ 0.002847] ACPI: Reserving APIC table memory at [mem 0x3ffe230e-0x3ffe2385]98machine # [ 0.002848] ACPI: Reserving HPET table memory at [mem 0x3ffe2386-0x3ffe23bd]99machine # [ 0.002848] ACPI: Reserving MCFG table memory at [mem 0x3ffe23be-0x3ffe23f9]100machine # [ 0.002849] ACPI: Reserving WAET table memory at [mem 0x3ffe23fa-0x3ffe2421]101machine # [ 0.003078] No NUMA configuration found102machine # [ 0.003079] Faking a node at [mem 0x0000000000000000-0x000000003ffd7fff]103machine # [ 0.003081] NODE_DATA(0) allocated [mem 0x3ffd2780-0x3ffd7cff]104machine # [ 0.005414] Zone ranges:105machine # [ 0.005415] DMA [mem 0x0000000000001000-0x0000000000ffffff]106machine # [ 0.005417] DMA32 [mem 0x0000000001000000-0x000000003ffd7fff]107machine # [ 0.005418] Normal empty108machine # [ 0.005419] Device empty109machine # [ 0.005419] Movable zone start for each node110machine # [ 0.005420] Early memory node ranges111machine # [ 0.005420] node 0: [mem 0x0000000000001000-0x000000000009efff]112machine # [ 0.005421] node 0: [mem 0x0000000000100000-0x000000003ffd7fff]113machine # [ 0.005422] Initmem setup node 0 [mem 0x0000000000001000-0x000000003ffd7fff]114machine # [ 0.005440] On node 0, zone DMA: 1 pages in unavailable ranges115machine # [ 0.005707] On node 0, zone DMA: 97 pages in unavailable ranges116machine # [ 0.024106] On node 0, zone DMA32: 40 pages in unavailable ranges117machine # [ 0.024561] ACPI: PM-Timer IO Port: 0x608118machine # [ 0.024571] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1])119machine # [ 0.024595] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23120machine # [ 0.024597] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl)121machine # [ 0.024599] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level)122machine # [ 0.024600] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level)123machine # [ 0.024601] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level)124machine # [ 0.024602] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level)125machine # [ 0.024604] ACPI: Using ACPI (MADT) for SMP configuration information126machine # [ 0.024605] ACPI: HPET id: 0x8086a201 base: 0xfed00000127machine # [ 0.024609] TSC deadline timer available128machine # [ 0.024613] CPU topo: Max. logical packages: 1129machine # [ 0.024613] CPU topo: Max. logical dies: 1130machine # [ 0.024614] CPU topo: Max. dies per package: 1131machine # [ 0.024617] CPU topo: Max. threads per core: 1132machine # [ 0.024618] CPU topo: Num. cores per package: 1133machine # [ 0.024618] CPU topo: Num. threads per package: 1134machine # [ 0.024618] CPU topo: Allowing 1 present CPUs plus 0 hotplug CPUs135machine # [ 0.024634] kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write()136machine # [ 0.024663] PM: hibernation: Registered nosave memory: [mem 0x00000000-0x00000fff]137machine # [ 0.024664] PM: hibernation: Registered nosave memory: [mem 0x0009f000-0x000fffff]138machine # [ 0.024666] [mem 0x40000000-0xafffffff] available for PCI devices139machine # [ 0.024667] Booting paravirtualized kernel on KVM140machine # [ 0.024670] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns141machine # [ 0.029304] setup_percpu: NR_CPUS:384 nr_cpumask_bits:1 nr_cpu_ids:1 nr_node_ids:1142machine # [ 0.031554] percpu: Embedded 98 pages/cpu s278528 r8192 d114688 u2097152143machine # [ 0.031595] kvm-guest: PV spinlocks disabled, single CPU144machine # [ 0.031597] Kernel command line: console=ttyS0 console=tty0 panic=1 boot.panic_on_fail clocksource=acpi_pm root=fstab loglevel=7 net.ifnames=0 lsm=landlock,yama,bpf init=/nix/store/lh9zs34p9c1bvyavdq1mlk6pgr61pf8m-nixos-system-machine-test/init regInfo=/nix/.ro-store/zv32cw89qd71hd3phgx2h3gba7i00qhw-closure-info/registration console=ttyS0,115200n8 console=tty0145machine # [ 0.031690] Unknown kernel command line parameters "regInfo=/nix/.ro-store/zv32cw89qd71hd3phgx2h3gba7i00qhw-closure-info/registration", will be passed to user space.146machine # [ 0.031702] random: crng init done147machine # [ 0.031703] printk: log buffer data + meta data: 262144 + 917504 = 1179648 bytes148machine # [ 0.032810] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes, linear)149machine # [ 0.032822] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes, linear)150machine # [ 0.032853] Fallback order for Node 0: 0151machine # [ 0.032860] Built 1 zonelists, mobility grouping on. Total pages: 262006152machine # [ 0.032861] Policy zone: DMA32153machine # [ 0.035752] mem auto-init: stack:all(zero), heap alloc:on, heap free:off154machine # [ 0.038256] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1155machine # [ 0.040560] allocated 2097152 bytes of page_ext156machine # [ 0.050538] ftrace: allocating 48820 entries in 192 pages157machine # [ 0.050540] ftrace: allocated 192 pages with 2 groups158machine # [ 0.051392] Dynamic Preempt: lazy159machine # [ 0.051516] rcu: Preemptible hierarchical RCU implementation.160machine # [ 0.051517] rcu: RCU event tracing is enabled.161machine # [ 0.051517] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1.162machine # [ 0.051519] Trampoline variant of Tasks RCU enabled.163machine # [ 0.051519] Rude variant of Tasks RCU enabled.164machine # [ 0.051519] Tracing variant of Tasks RCU enabled.165machine # [ 0.051520] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies.166machine # [ 0.051521] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1167machine # [ 0.051578] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.168machine # [ 0.051580] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.169machine # [ 0.051581] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.170machine # [ 0.055924] NR_IRQS: 24832, nr_irqs: 256, preallocated irqs: 16171machine # [ 0.056196] rcu: srcu_init: Setting srcu_struct sizes based on contention.172machine # [ 0.056203] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns173machine # [ 0.056310] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)174machine # [ 0.059836] Console: colour VGA+ 80x25175machine # [ 0.059839] printk: legacy console [tty0] enabled176machine # [ 0.089391] printk: legacy console [ttyS0] enabled177machine # [ 0.191544] ACPI: Core revision 20250807178machine # [ 0.192483] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns179machine # [ 0.194087] APIC: Switch to symmetric I/O mode setup180machine # [ 0.195105] x2apic enabled181machine # [ 0.195896] APIC: Switched APIC routing to: physical x2apic182machine # [ 0.197785] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1183machine # [ 0.198834] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x229842dd0bd, max_idle_ns: 440795319571 ns184machine # [ 0.200578] Calibrating delay loop (skipped) preset value.. 4800.02 BogoMIPS (lpj=2400012)185machine # [ 0.202588] x86/cpu: User Mode Instruction Prevention (UMIP) activated186machine # [ 0.203716] Last level iTLB entries: 4KB 512, 2MB 255, 4MB 127187machine # [ 0.204576] Last level dTLB entries: 4KB 512, 2MB 255, 4MB 127, 1GB 0188machine # [ 0.205578] mitigations: Enabled attack vectors: user_kernel, user_user, guest_host, guest_guest, SMT mitigations: auto189machine # [ 0.206575] Speculative Store Bypass: Mitigation: Speculative Store Bypass disabled via prctl190machine # [ 0.207575] Transient Scheduler Attacks: Vulnerable: No microcode191machine # [ 0.208574] Spectre V2 : Mitigation: Enhanced / Automatic IBRS192machine # [ 0.209575] Speculative Return Stack Overflow: Mitigation: Safe RET193machine # [ 0.210575] Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization194machine # [ 0.212586] Spectre V2 : Enabling IBPB for BPF195machine # [ 0.213576] Spectre V2 : mitigation: Enabling conditional Indirect Branch Prediction Barrier196machine # [ 0.214575] active return thunk: srso_alias_return_thunk197machine # [ 0.216507] x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers'198machine # [ 0.217575] x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers'199machine # [ 0.218575] x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers'200machine # [ 0.219574] x86/fpu: Supporting XSAVE feature 0x020: 'AVX-512 opmask'201machine # [ 0.220575] x86/fpu: Supporting XSAVE feature 0x040: 'AVX-512 Hi256'202machine # [ 0.221575] x86/fpu: Supporting XSAVE feature 0x080: 'AVX-512 ZMM_Hi256'203machine # [ 0.222575] x86/fpu: Supporting XSAVE feature 0x200: 'Protection Keys User registers'204machine # [ 0.224575] x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256205machine # [ 0.225575] x86/fpu: xstate_offset[5]: 832, xstate_sizes[5]: 64206machine # [ 0.226575] x86/fpu: xstate_offset[6]: 896, xstate_sizes[6]: 512207machine # [ 0.227574] x86/fpu: xstate_offset[7]: 1408, xstate_sizes[7]: 1024208machine # [ 0.228575] x86/fpu: xstate_offset[9]: 2432, xstate_sizes[9]: 8209machine # [ 0.229575] x86/fpu: Enabled xstate features 0x2e7, context size is 2440 bytes, using 'compacted' format.210machine # [ 0.263824] Freeing SMP alternatives memory: 48K211machine # [ 0.264578] pid_max: default: 32768 minimum: 301212machine # [ 0.265447] LSM: initializing lsm=capability,landlock,yama,bpf,ima213machine # [ 0.266622] landlock: Up and running.214machine # [ 0.267269] Yama: becoming mindful.215machine # [ 0.267788] LSM support for eBPF active216machine # [ 0.268671] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)217machine # [ 0.269596] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)218machine # [ 0.271554] smpboot: CPU0: AMD EPYC 9654 96-Core Processor (family: 0x19, model: 0x11, stepping: 0x1)219machine # [ 0.272122] Performance Events: Fam17h+ core perfctr, AMD PMU driver.220machine # [ 0.272580] ... version: 2221machine # [ 0.273297] ... bit width: 48222machine # [ 0.273577] ... generic counters: 6223machine # [ 0.274337] ... generic bitmap: 000000000000003f224machine # [ 0.274624] ... fixed-purpose counters: 0225machine # [ 0.275387] ... fixed-purpose bitmap: 0000000000000000226machine # [ 0.276318] ... value mask: 0000ffffffffffff227machine # [ 0.276577] ... max period: 00007fffffffffff228machine # [ 0.277509] ... global_ctrl mask: 000000000000003f229machine # [ 0.278413] signal: max sigframe size: 3376230machine # [ 0.279180] rcu: Hierarchical SRCU implementation.231machine # [ 0.279580] rcu: Max phase no-delay instances is 400.232machine # [ 0.285045] smp: Bringing up secondary CPUs ...233machine # [ 0.285591] smp: Brought up 1 node, 1 CPU234machine # [ 0.286279] smpboot: Total of 1 processors activated (4800.02 BogoMIPS)235machine # [ 0.286744] Memory: 941044K/1048024K available (18120K kernel code, 2728K rwdata, 13640K rodata, 3656K init, 3632K bss, 99600K reserved, 0K cma-reserved)236machine # [ 0.288193] devtmpfs: initialized237machine # [ 0.288886] x86/mm: Memory block size: 128MB238machine # [ 0.290547] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear)239machine # [ 0.291553] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear).240machine # [ 0.292658] pinctrl core: initialized pinctrl subsystem241machine # [ 0.293817] PM: RTC time: 03:53:33, date: 2026-10-02242machine # [ 0.297372] NET: Registered PF_NETLINK/PF_ROUTE protocol family243machine # [ 0.298735] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations244machine # [ 0.299592] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations245machine # [ 0.300724] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations246machine # [ 0.301586] audit: initializing netlink subsys (disabled)247machine # [ 0.302750] thermal_sys: Registered thermal governor 'fair_share'248machine # [ 0.302753] thermal_sys: Registered thermal governor 'bang_bang'249machine # [ 0.303581] audit: type=2000 audit(1790913214.478:1): state=initialized audit_enabled=0 res=1250machine # [ 0.305578] thermal_sys: Registered thermal governor 'step_wise'251machine # [ 0.305580] thermal_sys: Registered thermal governor 'user_space'252machine # [ 0.306577] thermal_sys: Registered thermal governor 'power_allocator'253machine # [ 0.307607] cpuidle: using governor menu254machine # [ 0.309844] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5255machine # [ 0.310828] PCI: ECAM [mem 0xb0000000-0xbfffffff] (base 0xb0000000) for domain 0000 [bus 00-ff]256machine # [ 0.311580] PCI: ECAM [mem 0xb0000000-0xbfffffff] reserved as E820 entry257machine # [ 0.312589] PCI: Using configuration type 1 for base access258machine # [ 0.313738] kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible.259machine # [ 0.320601] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages260machine # [ 0.321577] HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page261machine # [ 0.326578] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages262machine # [ 0.327578] HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page263machine # [ 0.338882] ACPI: Added _OSI(Module Device)264machine # [ 0.339579] ACPI: Added _OSI(Processor Device)265machine # [ 0.340338] ACPI: Added _OSI(Processor Aggregator Device)266machine # [ 0.346207] ACPI: 1 ACPI AML tables successfully acquired and loaded267machine # [ 0.349995] ACPI: Interpreter enabled268machine # [ 0.350593] ACPI: PM: (supports S0 S3 S4 S5)269machine # [ 0.351351] ACPI: Using IOAPIC for interrupt routing270machine # [ 0.353618] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug271machine # [ 0.354578] PCI: Using E820 reservations for host bridge windows272machine # [ 0.357719] ACPI: Enabled 2 GPEs in block 00 to 3F273machine # [ 0.363701] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff])274machine # [ 0.364583] acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3]275machine # [ 0.365658] acpi PNP0A08:00: _OSC: platform does not support [PCIeHotplug LTR]276machine # [ 0.366701] acpi PNP0A08:00: _OSC: OS now controls [PME AER PCIeCapability]277machine # [ 0.367930] PCI host bridge to bus 0000:00278machine # [ 0.368582] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window]279machine # [ 0.369577] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window]280machine # [ 0.370577] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window]281machine # [ 0.371577] pci_bus 0000:00: root bus resource [mem 0x40000000-0xafffffff window]282machine # [ 0.372578] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window]283machine # [ 0.373577] pci_bus 0000:00: root bus resource [mem 0x100000000-0x8ffffffff window]284machine # [ 0.374577] pci_bus 0000:00: root bus resource [bus 00-ff]285machine # [ 0.375598] pci 0000:00:00.0: [8086:29c0] type 00 class 0x060000 conventional PCI endpoint286machine # [ 0.377009] pci 0000:00:01.0: [1234:1111] type 00 class 0x030000 conventional PCI endpoint287machine # [ 0.379706] pci 0000:00:01.0: BAR 0 [mem 0xfd000000-0xfdffffff pref]288machine # [ 0.380616] pci 0000:00:01.0: BAR 2 [mem 0xfebd0000-0xfebd0fff]289machine # [ 0.381641] pci 0000:00:01.0: ROM [mem 0xfebc0000-0xfebcffff pref]290machine # [ 0.382890] pci 0000:00:01.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff]291machine # [ 0.384292] pci 0000:00:02.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint292machine # [ 0.387618] pci 0000:00:02.0: BAR 0 [io 0xc100-0xc11f]293machine # [ 0.388483] pci 0000:00:02.0: BAR 1 [mem 0xfebd1000-0xfebd1fff]294machine # [ 0.389378] pci 0000:00:02.0: BAR 4 [mem 0xfe000000-0xfe003fff 64bit pref]295machine # [ 0.390476] pci 0000:00:02.0: ROM [mem 0xfeb40000-0xfeb7ffff pref]296machine # [ 0.392150] pci 0000:00:03.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint297machine # [ 0.394568] pci 0000:00:03.0: BAR 0 [io 0xc120-0xc13f]298machine # [ 0.395500] pci 0000:00:03.0: BAR 1 [mem 0xfebd2000-0xfebd2fff]299machine # [ 0.396409] pci 0000:00:03.0: BAR 4 [mem 0xfe004000-0xfe007fff 64bit pref]300machine # [ 0.398076] pci 0000:00:04.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint301machine # [ 0.401614] pci 0000:00:04.0: BAR 0 [io 0xc000-0xc07f]302machine # [ 0.402507] pci 0000:00:04.0: BAR 1 [mem 0xfebd3000-0xfebd3fff]303machine # [ 0.403384] pci 0000:00:04.0: BAR 4 [mem 0xfe008000-0xfe00bfff 64bit pref]304machine # [ 0.405016] pci 0000:00:05.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint305machine # [ 0.407578] pci 0000:00:05.0: BAR 0 [io 0xc140-0xc15f]306machine # [ 0.408488] pci 0000:00:05.0: BAR 1 [mem 0xfebd4000-0xfebd4fff]307machine # [ 0.409599] pci 0000:00:05.0: BAR 4 [mem 0xfe00c000-0xfe00ffff 64bit pref]308machine # [ 0.410583] pci 0000:00:05.0: ROM [mem 0xfeb80000-0xfebbffff pref]309machine # [ 0.412145] pci 0000:00:06.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint310machine # [ 0.413590] pci 0000:00:06.0: BAR 1 [mem 0xfebd5000-0xfebd5fff]311machine # [ 0.414599] pci 0000:00:06.0: BAR 4 [mem 0xfe010000-0xfe013fff 64bit pref]312machine # [ 0.416149] pci 0000:00:07.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint313machine # [ 0.418619] pci 0000:00:07.0: BAR 1 [mem 0xfebd6000-0xfebd6fff]314machine # [ 0.419599] pci 0000:00:07.0: BAR 4 [mem 0xfe014000-0xfe017fff 64bit pref]315machine # [ 0.421183] pci 0000:00:08.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint316machine # [ 0.422621] pci 0000:00:08.0: BAR 1 [mem 0xfebd7000-0xfebd7fff]317machine # [ 0.423599] pci 0000:00:08.0: BAR 4 [mem 0xfe018000-0xfe01bfff 64bit pref]318machine # [ 0.425144] pci 0000:00:09.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint319machine # [ 0.426590] pci 0000:00:09.0: BAR 1 [mem 0xfebd8000-0xfebd8fff]320machine # [ 0.427599] pci 0000:00:09.0: BAR 4 [mem 0xfe01c000-0xfe01ffff 64bit pref]321machine # [ 0.429152] pci 0000:00:0a.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint322machine # [ 0.431475] pci 0000:00:0a.0: BAR 0 [io 0xc080-0xc0bf]323machine # [ 0.432259] pci 0000:00:0a.0: BAR 1 [mem 0xfebd9000-0xfebd9fff]324machine # [ 0.432600] pci 0000:00:0a.0: BAR 4 [mem 0xfe020000-0xfe023fff 64bit pref]325machine # [ 0.434158] pci 0000:00:0b.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint326machine # [ 0.436314] pci 0000:00:0b.0: BAR 0 [io 0xc160-0xc17f]327machine # [ 0.436585] pci 0000:00:0b.0: BAR 1 [mem 0xfebda000-0xfebdafff]328machine # [ 0.437599] pci 0000:00:0b.0: BAR 4 [mem 0xfe024000-0xfe027fff 64bit pref]329machine # [ 0.439190] pci 0000:00:1d.0: [8086:2934] type 00 class 0x0c0300 conventional PCI endpoint330machine # [ 0.440936] pci 0000:00:1d.0: BAR 4 [io 0xc180-0xc19f]331machine # [ 0.441781] pci 0000:00:1d.1: [8086:2935] type 00 class 0x0c0300 conventional PCI endpoint332machine # [ 0.443317] pci 0000:00:1d.1: BAR 4 [io 0xc1a0-0xc1bf]333machine # [ 0.443771] pci 0000:00:1d.2: [8086:2936] type 00 class 0x0c0300 conventional PCI endpoint334machine # [ 0.445254] pci 0000:00:1d.2: BAR 4 [io 0xc1c0-0xc1df]335machine # [ 0.445828] pci 0000:00:1d.7: [8086:293a] type 00 class 0x0c0320 conventional PCI endpoint336machine # [ 0.448586] pci 0000:00:1d.7: BAR 0 [mem 0xfebdb000-0xfebdbfff]337machine # [ 0.449921] pci 0000:00:1f.0: [8086:2918] type 00 class 0x060100 conventional PCI endpoint338machine # [ 0.450869] pci 0000:00:1f.0: quirk: [io 0x0600-0x067f] claimed by ICH6 ACPI/GPIO/TCO339machine # [ 0.451839] pci 0000:00:1f.2: [8086:2922] type 00 class 0x010601 conventional PCI endpoint340machine # [ 0.454578] pci 0000:00:1f.2: BAR 4 [io 0xc1e0-0xc1ff]341machine # [ 0.455473] pci 0000:00:1f.2: BAR 5 [mem 0xfebdc000-0xfebdcfff]342machine # [ 0.456695] pci 0000:00:1f.3: [8086:2930] type 00 class 0x0c0500 conventional PCI endpoint343machine # [ 0.458605] pci 0000:00:1f.3: BAR 4 [io 0x0700-0x073f]344machine # [ 0.462615] ACPI: PCI: Interrupt link LNKA configured for IRQ 10345machine # [ 0.463687] ACPI: PCI: Interrupt link LNKB configured for IRQ 10346machine # [ 0.464674] ACPI: PCI: Interrupt link LNKC configured for IRQ 11347machine # [ 0.465691] ACPI: PCI: Interrupt link LNKD configured for IRQ 11348machine # [ 0.466675] ACPI: PCI: Interrupt link LNKE configured for IRQ 10349machine # [ 0.467678] ACPI: PCI: Interrupt link LNKF configured for IRQ 10350machine # [ 0.468678] ACPI: PCI: Interrupt link LNKG configured for IRQ 11351machine # [ 0.469683] ACPI: PCI: Interrupt link LNKH configured for IRQ 11352machine # [ 0.470615] ACPI: PCI: Interrupt link GSIA configured for IRQ 16353machine # [ 0.471594] ACPI: PCI: Interrupt link GSIB configured for IRQ 17354machine # [ 0.472591] ACPI: PCI: Interrupt link GSIC configured for IRQ 18355machine # [ 0.473595] ACPI: PCI: Interrupt link GSID configured for IRQ 19356machine # [ 0.474590] ACPI: PCI: Interrupt link GSIE configured for IRQ 20357machine # [ 0.475590] ACPI: PCI: Interrupt link GSIF configured for IRQ 21358machine # [ 0.476606] ACPI: PCI: Interrupt link GSIG configured for IRQ 22359machine # [ 0.477594] ACPI: PCI: Interrupt link GSIH configured for IRQ 23360machine # [ 0.479615] iommu: Default domain type: Translated361machine # [ 0.480477] iommu: DMA domain TLB invalidation policy: lazy mode362machine # [ 0.481670] ACPI: bus type USB registered363machine # [ 0.482487] usbcore: registered new interface driver usbfs364machine # [ 0.483317] usbcore: registered new interface driver hub365machine # [ 0.483592] usbcore: registered new device driver usb366machine # [ 0.485455] NetLabel: Initializing367machine # [ 0.486024] NetLabel: domain hash size = 128368machine # [ 0.486577] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO369machine # [ 0.487584] NetLabel: unlabeled traffic allowed by default370machine # [ 0.488536] PCI: Using ACPI for IRQ routing371machine # [ 0.532166] pci 0000:00:01.0: vgaarb: setting as boot VGA device372machine # [ 0.532573] pci 0000:00:01.0: vgaarb: bridge control possible373machine # [ 0.532573] pci 0000:00:01.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none374machine # [ 0.532582] vgaarb: loaded375machine # [ 0.533332] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0376machine # [ 0.533577] hpet0: 3 comparators, 64-bit 100.000000 MHz counter377machine # [ 0.539663] clocksource: Switched to clocksource kvm-clock378machine # [ 0.543153] VFS: Disk quotas dquot_6.6.0379machine # [ 0.543906] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)380machine # [ 0.545293] pnp: PnP ACPI init381machine # [ 0.546133] ACPI: IRQ 4 override to edge(!), high(!)382machine # [ 0.547137] system 00:04: [mem 0xb0000000-0xbfffffff window] has been reserved383machine # [ 0.548719] pnp: PnP ACPI: found 5 devices384machine # [ 0.556285] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns385machine # [ 0.557804] clocksource: Switched to clocksource acpi_pm386machine # [ 0.558791] NET: Registered PF_INET protocol family387machine # [ 0.559823] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear)388machine # [ 0.576730] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear)389machine # [ 0.578321] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)390machine # [ 0.579740] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear)391machine # [ 0.581133] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear)392machine # [ 0.582414] TCP: Hash tables configured (established 8192 bind 8192)393machine # [ 0.583561] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear)394machine # [ 0.584945] UDP hash table entries: 512 (order: 3, 32768 bytes, linear)395machine # [ 0.586105] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear)396machine # [ 0.587404] NET: Registered PF_UNIX/PF_LOCAL protocol family397machine # [ 0.588455] NET: Registered PF_XDP protocol family398machine # [ 0.589325] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window]399machine # [ 0.590404] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window]400machine # [ 0.591470] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window]401machine # [ 0.592620] pci_bus 0000:00: resource 7 [mem 0x40000000-0xafffffff window]402machine # [ 0.593742] pci_bus 0000:00: resource 8 [mem 0xc0000000-0xfebfffff window]403machine # [ 0.594932] pci_bus 0000:00: resource 9 [mem 0x100000000-0x8ffffffff window]404machine # [ 0.596758] ACPI: \_SB_.GSIA: Enabled at IRQ 16405machine # [ 0.598848] ACPI: \_SB_.GSIB: Enabled at IRQ 17406machine # [ 0.600922] ACPI: \_SB_.GSIC: Enabled at IRQ 18407machine # [ 0.603012] ACPI: \_SB_.GSID: Enabled at IRQ 19408machine # [ 0.604808] PCI: CLS 0 bytes, default 64409machine # [ 0.605823] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x229842dd0bd, max_idle_ns: 440795319571 ns410machine # [ 0.607607] Trying to unpack rootfs image as initramfs...411machine # [ 0.653792] Initialise system trusted keyrings412machine # [ 0.654751] workingset: timestamp_bits=40 max_order=18 bucket_order=0413machine # [ 0.676228] Key type asymmetric registered414machine # [ 0.678412] Asymmetric key parser 'x509' registered415machine # [ 0.679262] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 248)416machine # [ 0.682502] io scheduler mq-deadline registered417machine # [ 0.683295] io scheduler kyber registered418machine # [ 0.687008] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled419machine # [ 0.688308] 00:03: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A420machine # [ 0.693536] Linux agpgart interface v0.103421machine # [ 0.694329] ACPI: bus type drm_connector registered422machine # [ 0.696658] usbcore: registered new interface driver usbserial_generic423machine # [ 0.697761] usbserial: USB Serial support registered for generic424machine # [ 0.701403] amd_pstate: The CPPC feature is supported but currently disabled by the BIOS.425machine # [ 0.701403] Please enable it if your BIOS has the CPPC option.426machine # [ 0.703668] amd_pstate: the _CPC object is not present in SBIOS or ACPI disabled427machine # [ 0.707525] drop_monitor: Initializing network drop monitor service428machine # [ 0.708707] NET: Registered PF_INET6 protocol family429machine # [ 0.711933] Segment Routing with IPv6430machine # [ 0.714415] In-situ OAM (IOAM) with IPv6431machine # [ 0.715520] IPI shorthand broadcast: enabled432machine # [ 0.723915] sched_clock: Marking stable (584014875, 139370688)->(803692832, -80307269)433machine # [ 0.729646] registered taskstats version 1434machine # [ 0.730612] Loading compiled-in X.509 certificates435machine # [ 0.749393] Demotion targets for Node 0: null436machine # [ 0.750276] Key type .fscrypt registered437machine # [ 0.750981] Key type fscrypt-provisioning registered438machine # [ 0.751952] ima: No TPM chip found, activating TPM-bypass!439machine # [ 0.756400] ima: Allocated hash algorithm: sha1440machine # [ 0.757241] ima: No architecture policies found441machine # [ 0.759413] PM: Magic number: 14:827:865442machine # [ 0.760200] memory_tiering: hash matches443machine # [ 0.763841] RAS: Correctable Errors collector initialized.444machine # [ 0.772653] clk: Disabling unused clocks445machine # [ 0.773365] PM: genpd: Disabling unused power domains446machine # [ 0.939619] Freeing initrd memory: 29080K447machine # [ 0.942858] Freeing unused decrypted memory: 2028K448machine # [ 0.945652] Freeing unused kernel image (initmem) memory: 3656K449machine # [ 0.946737] Write protecting the kernel read-only data: 32768k450machine # [ 0.948112] Freeing unused kernel image (text/rodata gap) memory: 308K451machine # [ 0.949648] Freeing unused kernel image (rodata/data gap) memory: 696K452machine # [ 1.000714] x86/mm: Checked W+X mappings: passed, no W+X pages found.453machine # [ 1.001812] Run /init as init process454machine # [ 1.013007] systemd[1]: Inserted module 'autofs4'455machine # [ 1.032683] fuse: init (API version 7.45)456machine # [ 1.040038] ACPI: \_SB_.GSIG: Enabled at IRQ 22457machine # [ 1.042580] ACPI: \_SB_.GSIH: Enabled at IRQ 23458machine # [ 1.046914] ACPI: \_SB_.GSIE: Enabled at IRQ 20459machine # [ 1.049133] ACPI: \_SB_.GSIF: Enabled at IRQ 21460machine # [ 1.055231] virtiofs virtio5: discovered new tag: nix-store461machine # [ 1.056821] virtiofs virtio5: virtio_fs_setup_dax: No cache capability462machine # [ 1.064207] virtiofs virtio6: discovered new tag: shared463machine # [ 1.065727] virtiofs virtio6: virtio_fs_setup_dax: No cache capability464machine # [ 1.069126] virtiofs virtio7: discovered new tag: xchg465machine # [ 1.070561] virtiofs virtio7: virtio_fs_setup_dax: No cache capability466machine # [ 1.091502] systemd[1]: Successfully made /usr/ read-only.467machine # [ 1.093202] systemd[1]: systemd 263-b43fed8 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE)468machine # [ 1.098075] systemd[1]: Detected virtualization kvm.469machine # [ 1.098926] systemd[1]: Detected architecture x86-64.470machine # [ 1.099751] systemd[1]: Running in initrd.471machine # [ 1.100712] systemd[1]: Initializing machine ID from random generator.472machine # [ 1.101850] systemd[1]: Hostname set to <machine>.473machine # [ 1.175464] systemd[1]: bpf-restrict-fs: LSM BPF program attached474machine # [ 1.213968] systemd[1]: Queued start job for default target Initrd Default Target.475machine # [ 1.217795] systemd[1]: Created slice Slice /system/modprobe.476machine # [ 1.218913] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.477machine # [ 1.220245] systemd[1]: Expecting device /dev/disk/by-label/nixos...478machine # [ 1.221265] systemd[1]: Expecting device /dev/hvc0...479machine # [ 1.222118] systemd[1]: Expecting device /dev/ttyS0...480machine # [ 1.222998] systemd[1]: Reached target Path Units.481machine # [ 1.223824] systemd[1]: Reached target Slice Units.482machine # [ 1.224640] systemd[1]: Reached target Swaps.483machine # [ 1.225399] systemd[1]: Reached target Timer Units.484machine # [ 1.226296] systemd[1]: Listening on D-Bus System Message Bus Socket.485machine # [ 1.227513] systemd[1]: Listening on Journal Socket (/dev/log).486machine # [ 1.228606] systemd[1]: Listening on Journal Sockets.487machine # [ 1.229523] systemd[1]: Listening on udev Kernel Socket.488machine # [ 1.230425] systemd[1]: Reached target Socket Units.489machine # [ 1.232218] systemd[1]: Starting Create List of Static Device Nodes...490machine # [ 1.251636] systemd[1]: Starting Load Kernel Module configfs...491machine # [ 1.263051] systemd[1]: Starting Journal Service...492machine # [ 1.271476] systemd[1]: Starting Load Kernel Modules...493machine # [ 1.274439] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os494machine # [ 1.279499] systemd[1]: Starting Coldplug All udev Devices...495machine # [ 1.292883] systemd[1]: Finished Create List of Static Device Nodes.496machine # [ 1.299086] systemd[1]: modprobe@configfs.service: Deactivated successfully.497machine # [ 1.307785] systemd[1]: Finished Load Kernel Module configfs.498machine # [ 1.310922] systemd[1]: Kernel Configuration File System skipped, unmet condition check ConditionPathExists=/sys/kernel/config499machine # [ 1.315684] systemd-journald[65]: Collecting audit messages is disabled.500machine # [ 1.323474] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...501machine # [ 1.335600] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.502machine # [ 1.346604] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev503machine # [ 1.367970] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.504machine # [ 1.376605] systemd[1]: Starting Create Static Device Nodes in /dev...505machine # [ 1.389458] systemd[1]: Finished Load Kernel Modules.506machine # [ 1.399491] systemd[1]: Starting Apply Kernel Variables...507machine # [ 1.419506] systemd[1]: Finished Create Static Device Nodes in /dev.508machine # [ 1.425616] systemd[1]: Reached target Preparation for Local File Systems.509machine # [ 1.430507] systemd[1]: Reached target Local File Systems.510machine # [ 1.294885] systemd-modules-load[66]: Inserted module 'dm_mod'511machine # [ 1.297953] systemd-modules-load[66]: Inserted module 'virtio_balloon'512machine # [ 1.299854] systemd-modules-load[66]: Inserted module 'virtio_gpu'513machine # [ 1.440418] systemd[1]: Starting Rule-based Manager for Device Events and Files...514machine # [ 1.447679] systemd[1]: Started Journal Service.515machine # [ 1.314968] systemd[1]: Finished Apply Kernel Variables.516machine # [ 1.326146] systemd[1]: Starting Create System Files and Directories...517machine # [ 1.353226] systemd[1]: Finished Create System Files and Directories.518machine # [ 1.365255] systemd-udevd[72]: Using default interface naming scheme 'v261'.519machine # [ 1.388060] systemd[1]: Started Rule-based Manager for Device Events and Files.520machine # [ 1.441191] systemd[1]: Finished Coldplug All udev Devices.521machine # [ 1.442321] systemd[1]: Reached target System Initialization.522machine # [ 1.443202] systemd[1]: Reached target Basic System.523machine # [ 1.489445] systemd[1]: Found device /dev/hvc0.524machine # [ 1.506265] systemd[1]: Found device /dev/ttyS0.525machine # [ 1.508593] systemd[1]: Started backdoor.service.526machine # [ 1.529058] backdoor-start[97]: /nix/store/wih4sdpik4mw459vdf955q7qq1j10agf-unit-script-backdoor-start/bin/backdoor-start: line 10: grep: command not found527machine # connecting to host...528machine: Guest shell says: b'Spawning backdoor root shell...\n'529machine: connected to guest root shell530machine: (connecting took 2.29 seconds)531machine: (finished: waiting for the VM to finish booting, in 2.56 seconds)532machine # [ 1.819189] virtio_blk virtio2: 1/0/0 default/read/poll queues533machine # [ 1.829725] ehci-pci 0000:00:1d.7: EHCI Host Controller534machine # [ 1.830696] ehci-pci 0000:00:1d.7: new USB bus registered, assigned bus number 1535machine # [ 1.831968] ehci-pci 0000:00:1d.7: irq 19, io mem 0xfebdb000536machine # [ 1.836061] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12537machine # [ 1.838264] virtio_blk virtio2: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB)538machine # [ 1.839436] ehci-pci 0000:00:1d.7: USB 2.0 started, EHCI 1.00539machine # [ 1.841460] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 6.18540machine # [ 1.842595] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1541machine # [ 1.844983] serio: i8042 KBD port at 0x60,0x64 irq 1542machine # [ 1.845660] serio: i8042 AUX port at 0x60,0x64 irq 12543machine # [ 1.846545] usb usb1: Product: EHCI Host Controller544machine # [ 1.847243] usb usb1: Manufacturer: Linux 6.18.54 ehci_hcd545machine # [ 1.849395] usb usb1: SerialNumber: 0000:00:1d.7546machine # [ 1.851100] hub 1-0:1.0: USB hub found547machine # [ 1.852677] hub 1-0:1.0: 6 ports detected548machine # [ 1.864658] uhci_hcd 0000:00:1d.0: UHCI Host Controller549machine # [ 1.865354] uhci_hcd 0000:00:1d.0: new USB bus registered, assigned bus number 2550machine # [ 1.877651] uhci_hcd 0000:00:1d.0: detected 2 ports551machine # [ 1.885607] uhci_hcd 0000:00:1d.0: irq 16, io port 0x0000c180552machine # [ 1.890931] usb usb2: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.18553machine # [ 1.892092] usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=1554machine # [ 1.907579] usb usb2: Product: UHCI Host Controller555machine # [ 1.908255] usb usb2: Manufacturer: Linux 6.18.54 uhci_hcd556machine # [ 1.917810] usb usb2: SerialNumber: 0000:00:1d.0557machine # [ 1.927154] hub 2-0:1.0: USB hub found558machine # [ 1.931891] SCSI subsystem initialized559machine # [ 1.934502] hub 2-0:1.0: 2 ports detected560machine # [ 1.797346] systemd[1]: Starting Virtual Console Setup...561machine # [ 1.955259] uhci_hcd 0000:00:1d.1: UHCI Host Controller562machine # [ 1.956269] uhci_hcd 0000:00:1d.1: new USB bus registered, assigned bus number 3563machine # [ 1.973580] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input0564machine # [ 1.836853] systemd-vconsole-setup[111]: Configuration of first virtual console was skipped, ignoring remaining ones.565machine # [ 1.839979] systemd[1]: Finished Virtual Console Setup.566machine # [ 1.845798] (udev-worker)[85]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.567machine # [ 1.990330] uhci_hcd 0000:00:1d.1: detected 2 ports568machine # [ 1.991153] uhci_hcd 0000:00:1d.1: irq 17, io port 0x0000c1a0569machine # [ 1.853449] (udev-worker)[85]: Network interface NamePolicy= disabled on kernel command line.570machine # [ 2.006423] usb usb3: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.18571machine # [ 2.007578] usb usb3: New USB device strings: Mfr=3, Product=2, SerialNumber=1572machine # [ 1.870398] systemd[1]: Found device /dev/disk/by-label/nixos.573machine # [ 1.871963] systemd[1]: Reached target Initrd Root Device.574machine # [ 1.874064] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos...575machine # [ 2.020953] usb usb3: Product: UHCI Host Controller576machine # [ 2.027008] usb usb3: Manufacturer: Linux 6.18.54 uhci_hcd577machine # [ 2.028405] usb usb3: SerialNumber: 0000:00:1d.1578machine # [ 2.034407] hub 3-0:1.0: USB hub found579machine # [ 2.035337] hub 3-0:1.0: 2 ports detected580machine # [ 2.039305] uhci_hcd 0000:00:1d.2: UHCI Host Controller581machine # [ 2.040108] uhci_hcd 0000:00:1d.2: new USB bus registered, assigned bus number 4582machine # [ 2.045702] uhci_hcd 0000:00:1d.2: detected 2 ports583machine # [ 2.049181] uhci_hcd 0000:00:1d.2: irq 18, io port 0x0000c1c0584machine # [ 2.051610] usb usb4: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.18585machine # [ 1.915312] systemd-fsck[118]: nixos: clean, 12/65536 files, 13019/262144 blocks586machine # [ 2.055800] usb usb4: New USB device strings: Mfr=3, Product=2, SerialNumber=1587machine # [ 2.061053] usb usb4: Product: UHCI Host Controller588machine # [ 2.061912] usb usb4: Manufacturer: Linux 6.18.54 uhci_hcd589machine # [ 1.924436] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos.590machine # [ 2.065519] usb usb4: SerialNumber: 0000:00:1d.2591machine # [ 2.067976] hub 4-0:1.0: USB hub found592machine # [ 2.073947] hub 4-0:1.0: 2 ports detected593machine # [ 2.092416] usb 1-1: new high-speed USB device number 2 using ehci-pci594machine # [ 2.106677] ahci 0000:00:1f.2: AHCI vers 0001.0000, 32 command slots, 1.5 Gbps, SATA mode595machine # [ 2.110260] ahci 0000:00:1f.2: 6/6 ports implemented (port mask 0x3f)596machine # [ 2.111652] ahci 0000:00:1f.2: flags: 64bit ncq only597machine # [ 2.115492] scsi host0: ahci598machine # [ 2.117220] scsi host1: ahci599machine # [ 2.118885] scsi host2: ahci600machine # [ 2.120483] scsi host3: ahci601machine # [ 2.122090] scsi host4: ahci602machine # [ 2.123706] scsi host5: ahci603machine # [ 2.124235] ata1: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc100 irq 47 lpm-pol 1604machine # [ 2.126316] ata2: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc180 irq 47 lpm-pol 1605machine # [ 2.127530] ata3: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc200 irq 47 lpm-pol 1606machine # [ 2.128701] ata4: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc280 irq 47 lpm-pol 1607machine # [ 2.129821] ata5: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc300 irq 47 lpm-pol 1608machine # [ 2.130996] ata6: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc380 irq 47 lpm-pol 1609machine # [ 2.222632] usb 1-1: New USB device found, idVendor=0627, idProduct=0001, bcdDevice= 0.00610machine # [ 2.225545] usb 1-1: New USB device strings: Mfr=1, Product=3, SerialNumber=10611machine # [ 2.228708] usb 1-1: Product: QEMU USB Tablet612machine # [ 2.230581] usb 1-1: Manufacturer: QEMU613machine # [ 2.232314] usb 1-1: SerialNumber: 28754-0000:00:1d.7-1614machine # [ 2.267706] hid: raw HID events driver (C) Jiri Kosina615machine # [ 2.149906] systemd[1]: Mounting /sysroot...616machine # [ 2.443499] ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 300)617machine # [ 2.445806] ata3.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/100618machine # [ 2.448246] ata3.00: applying bridge limits619machine # [ 2.450194] ata3.00: configured for UDMA/100620machine # [ 2.452242] ata2: SATA link down (SStatus 0 SControl 300)621machine # [ 2.454652] ata6: SATA link down (SStatus 0 SControl 300)622machine # [ 2.456861] ata4: SATA link down (SStatus 0 SControl 300)623machine # [ 2.459276] ata5: SATA link down (SStatus 0 SControl 300)624machine # [ 2.461734] ata1: SATA link down (SStatus 0 SControl 300)625machine # [ 2.464602] scsi 2:0:0:0: CD-ROM QEMU QEMU DVD-ROM 2.5+ PQ: 0 ANSI: 5626machine # [ 2.543039] usbcore: registered new interface driver usbhid627machine # [ 2.543879] usbhid: USB HID core driver628machine # [ 2.562524] sr 2:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray629machine # [ 2.575600] input: QEMU QEMU USB Tablet as /devices/pci0000:00/0000:00:1d.7/usb1/1-1/1-1:1.0/0003:0627:0001.0001/input/input2630machine # [ 2.577324] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:1d.7-1/input0631machine # [ 2.581546] cdrom: Uniform CD-ROM driver Revision: 3.20632machine # [ 2.596819] EXT4-fs (vda): mounted filesystem 60cfc836-912d-4264-9e87-2fee5a628c76 r/w with ordered data mode. Quota mode: none.633machine # [ 2.463844] systemd[1]: Mounted /sysroot.634machine # [ 2.465415] systemd[1]: Reached target Initrd Root File System.635machine # [ 2.468294] systemd[1]: Starting Mountpoints Configured in the Real Root...636machine # [ 2.484046] systemd-sysroot-fstab-check[152]: /sysroot should be mounted in the initrd, will request daemon-reload.637machine # [ 2.487142] systemd[1]: Reload requested from client PID 152 ('systemd-sysroot') (unit initrd-parse-etc.service)...638machine # [ 2.488623] systemd[1]: Reloading...639machine # [ 2.565574] systemd[1]: Reloading finished in 75 ms.640machine # [ 2.573445] systemd-sysroot-fstab-check[152]: Requesting initrd-fs.target/start/replace...641machine # [ 2.576144] systemd-sysroot-fstab-check[152]: Requesting swap.target/start/replace...642machine # [ 2.582169] systemd[1]: initrd-parse-etc.service: Deactivated successfully.643machine # [ 2.583596] systemd[1]: Finished Mountpoints Configured in the Real Root.644machine # [ 2.584612] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies.645machine # [ 3.152357] systemd[1]: Mounting /sysroot/nix/.ro-store...646machine # [ 3.159202] systemd[1]: Mounting /sysroot/nix/.rw-store...647machine # [ 3.167332] systemd[1]: Mounting /sysroot/run...648machine # [ 3.178358] systemd[1]: Mounting /sysroot/tmp/shared...649machine # [ 3.191330] systemd[1]: Mounting /sysroot/tmp/xchg...650machine # [ 3.229894] systemd[1]: Mounted /sysroot/nix/.ro-store.651machine # [ 3.234096] systemd[1]: Mounted /sysroot/nix/.rw-store.652machine # [ 3.235253] systemd[1]: Mounted /sysroot/run.653machine # [ 3.236257] systemd[1]: Mounted /sysroot/tmp/shared.654machine # [ 3.240936] systemd[1]: Mounted /sysroot/tmp/xchg.655machine # [ 3.243772] systemd[1]: Starting rw-sysroot-nix-store.service...656machine # [ 3.254556] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.657machine # [ 3.255984] systemd[1]: Finished rw-sysroot-nix-store.service.658machine # [ 4.151448] systemd[1]: Mounting /sysroot/nix/store...659machine # [ 4.197610] systemd[1]: Mounted /sysroot/nix/store.660machine # [ 4.198874] systemd[1]: Reached target Initrd File Systems.661machine # [ 4.200787] systemd[1]: Starting Find NixOS closure...662machine # [ 4.203581] systemd[1]: Starting Create Volatile Files and Directories in the Real Root...663machine # [ 4.221795] systemd[1]: Finished Create Volatile Files and Directories in the Real Root.664machine # [ 4.224422] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully.665machine # [ 4.232739] systemd[1]: Finished Find NixOS closure.666machine # [ 4.233835] systemd[1]: Reached target Initrd Default Target.667machine # [ 4.235600] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...668machine # [ 4.244786] systemd[1]: initrd-cleanup.service: Deactivated successfully.669machine # [ 4.246189] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.670machine # [ 4.250637] systemd[1]: Startup finished in 865ms (kernel) + 0 (initrd) + 3.384s (userspace) = 4.250s.671machine: (finished: waiting for unit initrd.target, in 5.70 seconds)672machine: must succeed: systemctl status initrd-fs.target673machine: (finished: must succeed: systemctl status initrd-fs.target, in 0.02 seconds)674machine: waiting for unit initrd.target675machine: (finished: waiting for unit initrd.target, in 0.02 seconds)676machine: waiting for the VM to finish booting677machine # [ 4.740569] systemd[1]: Stopped target Initrd Default Target.678machine # [ 4.741749] systemd[1]: Stopped target Basic System.679machine # [ 4.743052] systemd[1]: Stopped target Initrd Root Device.680machine # [ 4.743822] systemd[1]: Stopped target Path Units.681machine # [ 4.744570] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.682machine # [ 4.745806] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.683machine # [ 4.747219] systemd[1]: Stopped target Slice Units.684machine # [ 4.748367] systemd[1]: Stopped target Socket Units.685machine # [ 4.749309] systemd[1]: Stopped target System Initialization.686machine # [ 4.751131] systemd[1]: Stopped target Swaps.687machine # [ 4.751803] systemd[1]: Stopped target Timer Units.688machine # [ 4.752552] systemd[1]: dbus.socket: Deactivated successfully.689machine # [ 4.753388] systemd[1]: Closed D-Bus System Message Bus Socket.690machine # [ 4.755136] systemd[1]: Stopping backdoor.service...691machine # [ 4.756810] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...692machine # [ 4.758200] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully.693machine # [ 4.759259] systemd[1]: Stopped Find NixOS closure.694machine # [ 4.761747] systemd[1]: Starting rw-sysroot-nix-store.service...695machine # [ 4.762737] systemd[1]: systemd-sysctl.service: Deactivated successfully.696machine # [ 4.764132] systemd[1]: Stopped Apply Kernel Variables.697machine # [ 4.764946] systemd[1]: systemd-modules-load.service: Deactivated successfully.698machine # [ 4.766148] systemd[1]: Stopped Load Kernel Modules.699machine # [ 4.767121] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully.700machine # [ 4.769118] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root.701machine # [ 4.770233] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.702machine # [ 4.771259] systemd[1]: Stopped Create System Files and Directories.703machine # [ 4.772979] systemd[1]: Stopped target Local File Systems.704machine # [ 4.774864] systemd[1]: Stopped target Preparation for Local File Systems.705machine # [ 4.775844] systemd[1]: systemd-udev-trigger.service: Deactivated successfully.706machine # [ 4.776841] systemd[1]: Stopped Coldplug All udev Devices.707machine # [ 4.779389] systemd[1]: Stopping Rule-based Manager for Device Events and Files...708machine # [ 4.780430] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.709machine # [ 4.781541] systemd[1]: Stopped Virtual Console Setup.710machine # [ 4.786744] systemd[1]: backdoor.service: Deactivated successfully.711machine # [ 4.788928] systemd[1]: Stopped backdoor.service.712machine # [ 4.791408] systemd[1]: systemd-udevd.service: Deactivated successfully.713machine # [ 4.796070] systemd[1]: Stopped Rule-based Manager for Device Events and Files.714machine # [ 4.807489] systemd[1]: Starting Cleanup udev Database...715machine # [ 4.808312] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.716machine # [ 4.810114] systemd[1]: Stopped Create Static Device Nodes in /dev.717machine # [ 4.810983] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.718machine # [ 4.812087] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.719machine # [ 4.814653] systemd[1]: kmod-static-nodes.service: Deactivated successfully.720machine # [ 4.815789] systemd[1]: Stopped Create List of Static Device Nodes.721machine # [ 4.817586] systemd[1]: initrd-cleanup.service: Deactivated successfully.722machine # [ 4.820827] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.723machine # [ 4.821817] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.724machine # [ 4.822901] systemd[1]: Finished rw-sysroot-nix-store.service.725machine # [ 4.838786] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.726machine # [ 4.840386] systemd[1]: Finished Cleanup udev Database.727machine # [ 4.842176] systemd[1]: Reached target Switch Root.728machine # [ 4.843226] systemd[1]: Starting NixOS Activation...729machine # [ 4.928731] initrd-nixos-activation-start[241]: booting system configuration /nix/store/lh9zs34p9c1bvyavdq1mlk6pgr61pf8m-nixos-system-machine-test730machine # [ 4.958092] initrd-nixos-activation-start[241]: running activation script...731machine # [ 5.148160] initrd-nixos-activation-start[264]: setting up /etc...732machine # [ 5.257482] systemd[1]: initrd-nixos-activation.service: Deactivated successfully.733machine # [ 5.258813] systemd[1]: Finished NixOS Activation.734machine # [ 5.261237] systemd[1]: Starting Switch Root...735machine # [ 5.277104] systemd[1]: Switching root.736machine # [ 5.537241] systemd-journald[65]: Received SIGTERM from PID 1 (systemd).737machine # [ 5.600701] NET: Registered PF_VSOCK protocol family738machine # [ 5.626220] systemd[1]: systemd 263-b43fed8 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE)739machine # [ 5.630058] systemd[1]: Detected virtualization kvm.740machine # [ 5.630757] systemd[1]: Detected architecture x86-64.741machine # [ 5.631495] systemd[1]: Detected first boot.742machine # [ 5.633177] systemd[1]: Initializing machine ID from random generator.743machine # [ 5.724284] systemd[1]: bpf-restrict-fs: LSM BPF program attached744machine # [ 5.823402] systemd[1]: Applying preset policy.745machine # [ 5.984723] systemd[1]: Populated /etc with preset unit settings.746machine # [ 6.162166] systemd[1]: initrd-switch-root.service: Deactivated successfully.747machine # [ 6.163627] systemd[1]: Stopped initrd-switch-root.service.748machine # [ 6.166243] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.749machine # [ 6.168739] systemd[1]: Created slice Slice /system/getty.750machine # [ 6.170149] systemd[1]: Created slice User and Session Slice.751machine # [ 6.171185] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.752machine # [ 6.172515] systemd[1]: Started Forward Password Requests to Wall Directory Watch.753machine # [ 6.173625] systemd[1]: Expecting device /dev/hvc0...754machine # [ 6.174332] systemd[1]: Expecting device /dev/ttyS0...755machine # [ 6.175166] systemd[1]: Reached target Local Encrypted Volumes.756machine # [ 6.176065] systemd[1]: Stopped target initrd-fs.target.757machine # [ 6.176845] systemd[1]: Stopped target initrd-root-fs.target.758machine # [ 6.177654] systemd[1]: Stopped target initrd-switch-root.target.759machine # [ 6.178487] systemd[1]: Reached target Virtual Machines and Containers.760machine # [ 6.179447] systemd[1]: Reached target Path Units.761machine # [ 6.180164] systemd[1]: Reached target Remote File Systems.762machine # [ 6.192452] systemd[1]: Reached target Slice Units.763machine # [ 6.193193] systemd[1]: Reached target Swaps.764machine # [ 6.195140] systemd[1]: Listening on Query the User Interactively for a Password.765machine # [ 6.197819] systemd[1]: Listening on Process Core Dump Socket.766machine # [ 6.199536] systemd[1]: Listening on Credential Encryption/Decryption.767machine # [ 6.201242] systemd[1]: Listening on Factory Reset Management.768machine # [ 6.202193] systemd[1]: Listening on Hostname Service Socket.769machine # [ 6.205295] systemd[1]: Starting Journal Log Access Socket...770machine # [ 6.206881] systemd[1]: Listening on Journal Audit Socket.771machine # [ 6.209776] systemd[1]: Listening on Console Output Muting Service Socket.772machine # [ 6.210897] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.773machine # [ 6.212061] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os774machine # [ 6.213462] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki775machine # [ 6.217281] systemd[1]: Listening on Disk Repartitioning Service Socket.776machine # [ 6.218405] systemd[1]: Listening on udev Varlink Socket.777machine # [ 6.220979] systemd[1]: Mounting Huge Pages File System...778machine # [ 6.224977] systemd[1]: Mounting POSIX Message Queue File System...779machine # [ 6.232909] systemd[1]: Mounting Kernel Debug File System...780machine # [ 6.240263] systemd[1]: Mounting Kernel Trace File System...781machine # [ 6.251756] systemd[1]: Starting Create List of Static Device Nodes...782machine # [ 6.263887] systemd[1]: Starting Load Kernel Module configfs...783machine # [ 6.271585] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm784machine # [ 6.282611] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore785machine # [ 6.296152] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse786machine # [ 6.310549] systemd[1]: Mounting FUSE Control File System...787machine # [ 6.318298] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67788machine # [ 6.332821] systemd[1]: Starting Journal Service...789machine # [ 6.337803] systemd[1]: Starting Load Kernel Modules...790machine # [ 6.348446] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...791machine # [ 6.364634] systemd[1]: Starting Remount Root and Kernel File Systems...792machine # [ 6.369479] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os793machine # [ 6.383766] systemd[1]: Starting Coldplug All udev Devices...794machine # [ 6.394761] systemd-journald[335]: Collecting audit messages is enabled.795machine # [ 6.404032] systemd[1]: Listening on Journal Log Access Socket.796machine # [ 6.411846] systemd[1]: Mounted Huge Pages File System.797machine # [ 6.275860] systemd[1]: Queued start job for default target Multi-User System.798machine # [ 6.282395] systemd[1]: systemd-journald.service: Deactivated successfully.799machine # [ 6.424029] systemd[1]: Started Journal Service.800machine # [ 6.297611] systemd[1]: Mounted POSIX Message Queue File System.801machine # [ 6.298633] systemd[1]: Mounted Kernel Debug File System.802machine # [ 6.299637] systemd[1]: Mounted Kernel Trace File System.803machine # [ 6.440427] loop: module loaded804machine # [ 6.305202] systemd[1]: Finished Create List of Static Device Nodes.805machine # [ 6.306341] systemd[1]: modprobe@configfs.service: Deactivated successfully.806machine # [ 6.309088] systemd-modules-load[336]: Inserted module 'loop'807machine # [ 6.311095] systemd[1]: Finished Load Kernel Module configfs.808machine # [ 6.311906] systemd[1]: Mounted FUSE Control File System.809machine # [ 6.323067] systemd[1]: Finished Load Kernel Modules.810machine # [ 6.337907] systemd[1]: Mounting Kernel Configuration File System...811machine # [ 6.346097] systemd[1]: Starting Firewall...812machine # [ 6.489701] EXT4-fs (vda): re-mounted 60cfc836-912d-4264-9e87-2fee5a628c76.813machine # [ 6.355026] systemd[1]: Starting Apply Kernel Variables...814machine # [ 6.363073] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...815machine # [ 6.373184] systemd[1]: Finished Remount Root and Kernel File Systems.816machine # [ 6.385206] systemd-oomd[337]: No swap; memory pressure usage will be degraded817machine # [ 6.389233] systemd[1]: Listening on Disk Image Download Service Socket.818machine # [ 6.406270] systemd[1]: Starting Grow Root File System...819machine # [ 6.418206] systemd[1]: Starting Flush Journal to Persistent Storage...820machine # [ 6.419262] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore821machine # [ 6.438115] systemd[1]: Starting Load/Save OS Random Seed...822machine # [ 6.438957] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os823machine # [ 6.443762] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.824machine # [ 6.671883] EXT4-fs (vda): resizing filesystem from 262144 to 262144 blocks825machine # [ 6.674057] systemd-journald[335]: Received client request to flush runtime journal.826machine # [ 6.647308] systemd[1]: Finished Apply Kernel Variables.827machine # [ 6.648536] systemd[1]: Mounted Kernel Configuration File System.828machine # [ 6.651444] systemd-growfs[356]: Successfully resized "/" to 1G bytes.829machine # [ 6.652466] systemd[1]: Finished Load/Save OS Random Seed.830machine # [ 6.654576] systemd[1]: Reached target First Boot Complete.831machine # [ 6.656839] systemd[1]: Finished Grow Root File System.832machine # [ 6.659205] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.833machine # [ 6.660982] systemd[1]: Starting Create Static Device Nodes in /dev...834machine # [ 6.663693] systemd[1]: Finished Flush Journal to Persistent Storage.835machine # [ 6.727039] systemd[1]: Finished Coldplug All udev Devices.836machine # [ 6.743043] systemd[1]: Finished Create Static Device Nodes in /dev.837machine # [ 6.744364] systemd[1]: Reached target Preparation for Local File Systems.838machine # [ 6.747438] systemd[1]: Starting Rule-based Manager for Device Events and Files...839machine # [ 6.801466] systemd-udevd[378]: Using default interface naming scheme 'v261'.840machine # [ 6.846227] systemd[1]: Started Rule-based Manager for Device Events and Files.841machine # [ 6.972661] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse842machine # [ 7.028679] systemd[1]: Mounting /run/wrappers...843machine # [ 7.081527] systemd[1]: Mounted /run/wrappers.844machine # [ 7.082339] systemd[1]: Reached target Local File Systems.845machine # [ 7.085357] systemd[1]: Listening on Boot Loader Control Service Socket.846machine # [ 7.091229] systemd[1]: Starting Create SUID/SGID Wrappers...847machine # [ 7.092238] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.848machine # [ 7.097567] systemd[1]: Starting Save Transient machine-id to Disk...849machine # [ 7.102137] systemd[1]: Starting Create System Files and Directories...850machine # [ 7.108253] systemd[1]: Found device /dev/hvc0.851machine # [ 7.127544] systemd[1]: Found device /dev/ttyS0.852machine # [ 7.230484] (udev-worker)[403]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.853machine # [ 7.244585] (udev-worker)[403]: Network interface NamePolicy= disabled on kernel command line.854machine # [ 7.255265] systemd[1]: Finished Create System Files and Directories.855machine # [ 7.267361] systemd[1]: Starting Rebuild Journal Catalog...856machine # [ 7.271711] systemd[1]: Starting Record System Boot/Shutdown in UTMP...857machine # [ 7.368343] systemd[1]: Finished Record System Boot/Shutdown in UTMP.858machine # [ 7.392537] systemd[1]: Finished Rebuild Journal Catalog.859machine # [ 7.401191] systemd[1]: Starting Update is Completed...860machine # [ 7.456652] systemd[1]: etc-machine\x2did.mount: Deactivated successfully.861machine # [ 7.463220] systemd[1]: Finished Save Transient machine-id to Disk.862machine # [ 7.479430] systemd[1]: Finished Update is Completed.863machine # [ 7.549133] systemd[1]: Condition check resulted in Virtio network device being skipped.864machine # [ 7.552360] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore865machine # [ 7.555155] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.866machine # [ 7.556410] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67867machine # [ 7.558473] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore868machine # [ 7.559997] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os869machine # [ 7.561427] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os870machine # [ 7.802634] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input3871machine # [ 7.680153] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.872machine # [ 7.683084] systemd[1]: Finished Create SUID/SGID Wrappers.873machine # [ 7.684208] systemd[1]: Reached target System Initialization.874machine # [ 7.686213] systemd[1]: Started Discard unused filesystem blocks once a week.875machine # [ 7.687728] systemd[1]: Started Daily Cleanup of Temporary Directories.876machine # [ 7.688669] systemd[1]: Reached target Timer Units.877machine # [ 7.690151] systemd[1]: Listening on D-Bus System Message Bus Socket.878machine # [ 7.691788] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.879machine # [ 7.692984] systemd[1]: Reached target Socket Units.880machine # [ 7.694543] systemd[1]: Reached target Basic System.881machine # [ 7.698158] systemd[1]: Started backdoor.service.882machine # [ 7.703085] systemd[1]: Starting Import lastlog data into lastlog2 database...883machine # [ 7.713724] systemd[1]: Starting Name Service Cache Daemon (nsncd)...884machine # [ 7.726151] systemd[1]: Starting Post-Boot Actions...885machine # [ 7.867486] ACPI: button: Power Button [PWRF]886machine # [ 7.744204] systemd[1]: Started Reset console on configuration changes.887machine # [ 7.889648] mousedev: PS/2 mouse device common for all mice888machine # [ 7.769411] systemd[1]: Starting resolvconf update...889machine # [ 7.816352] systemd[1]: Starting D-Bus System Message Bus...890machine # [ 7.876745] systemd[1]: Finished Post-Boot Actions.891machine # [ 7.883646] nsncd[544]: Oct 02 03:53:42.197 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"892machine # connecting to host...893machine # [ 7.890784] systemd[1]: Started Name Service Cache Daemon (nsncd).894machine # [ 7.898499] systemd[1]: Reached target Host and Network Name Lookups.895machine # [ 7.899532] systemd[1]: Reached target User and Group Name Lookups.896machine # [ 7.920493] systemd[1]: Starting User Login Management...897machine # [ 7.930586] systemd[1]: Finished Firewall.898machine # [ 7.939974] systemd[1]: Finished Import lastlog data into lastlog2 database.899machine: Guest shell says: b'Spawning backdoor root shell...\n'900machine: connected to guest root shell901machine: (connecting took 3.23 seconds)902machine: (finished: waiting for the VM to finish booting, in 3.23 seconds)903(finished: subtest: testing initrd backdoor, in 8.97 seconds)904subtest: handover to stage-2 systemd works905machine: waiting for unit multi-user.target906machine # [ 8.115325] bochs-drm 0000:00:01.0: vgaarb: deactivate vga console907machine # [ 8.121393] rtc_cmos PNP0B00:00: RTC can wake from S4908machine # [ 8.169627] rtc_cmos PNP0B00:00: registered as rtc0909machine # [ 8.043314] dbus-broker-launch[555]: Looking up NSS user entry for 'systemd-timesync'...910machine # [ 8.050881] dbus-broker-launch[555]: NSS returned no entry for 'systemd-timesync'911machine # [ 8.051988] dbus-broker-launch[555]: Invalid user-name in /nix/store/vk3s3krx177a04a28pvgha0ii5jal4g5-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"912machine # [ 8.209911] rtc_cmos PNP0B00:00: setting system clock to 2026-10-02T03:53:41 UTC (1790913221)913machine # [ 8.210049] rtc_cmos PNP0B00:00: alarms up to one day, y3k, 242 bytes nvram, hpet irqs914machine # [ 8.210975] systemd-journald[335]: Time jumped backwards, rotating.915machine # [ 8.221444] input: QEMU Virtio Keyboard as /devices/pci0000:00/0000:00:06.0/virtio4/input/input4916machine # [ 8.235704] parport_pc 00:02: reported by Plug and Play ACPI917machine # [ 8.235815] parport0: PC-style at 0x378, irq 7 [PCSPP(,...)]918machine # [ 8.262884] lpc_ich 0000:00:1f.0: I/O space for GPIO uninitialized919machine # [ 8.366138] Console: switching to colour dummy device 80x25920machine # [ 8.408617] i801_smbus 0000:00:1f.3: SMBus using PCI interrupt921machine # [ 8.408785] i2c i2c-0: Memory type 0x07 not supported yet, not instantiating SPD922machine # [ 8.467046] [drm] Found bochs VGA, ID 0xb0c5.923machine # [ 8.467049] [drm] Framebuffer size 16384 kB @ 0xfd000000, mmio @ 0xfebd0000.924machine # [ 8.140142] dbus-broker-launch[555]: Ready925machine # [ 8.332524] systemd[1]: Started D-Bus System Message Bus.926machine # [ 8.333803] systemd[1]: Stopped target Host and Network Name Lookups.927machine # [ 8.481728] bochs-drm 0000:00:01.0: [drm] Registered 1 planes with drm panic928machine # [ 8.481734] [drm] Initialized bochs-drm 1.0.0 for 0000:00:01.0 on minor 0929machine # [ 8.339620] nsncd[640]: Oct 02 03:53:41.721 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"930machine # [ 8.363196] systemd[1]: Stopping Host and Network Name Lookups...931machine # [ 8.367107] systemd[1]: Stopped target User and Group Name Lookups.932machine # [ 8.372408] systemd[1]: Stopping User and Group Name Lookups...933machine # [ 8.373592] systemd[1]: Stopping Name Service Cache Daemon (nsncd)...934machine # [ 8.376934] systemd[1]: nscd.service: Deactivated successfully.935machine # [ 8.379646] systemd[1]: Stopped Name Service Cache Daemon (nsncd).936machine # [ 8.381489] systemd[1]: Starting Name Service Cache Daemon (nsncd)...937machine # [ 8.384563] systemd[1]: Started Name Service Cache Daemon (nsncd).938machine # [ 8.387149] systemd[1]: Finished resolvconf update.939machine # [ 8.387865] systemd[1]: Reached target Preparation for Network.940machine # [ 8.389708] systemd[1]: Reached target Host and Network Name Lookups.941machine # [ 8.531129] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input6942machine # [ 8.392921] systemd[1]: Reached target User and Group Name Lookups.943machine # [ 8.394198] systemd[1]: Starting DHCP Client...944machine # [ 8.394916] systemd[1]: Starting Address configuration of eth1...945machine # [ 8.402149] systemd[1]: Starting Extra networking commands....946machine # [ 8.403146] systemd-logind[579]: New seat seat0.947machine # [ 8.403861] systemd[1]: Started User Login Management.948machine # [ 8.544180] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input5949machine # [ 8.407158] systemd[1]: Starting linger-users.service...950machine # [ 8.467161] network-addresses-eth1-start[664]: adding address 192.168.1.1/24... done951machine # [ 8.481215] systemd[1]: linger-users.service: Deactivated successfully.952machine # [ 8.485077] systemd[1]: Finished linger-users.service.953machine # [ 8.491101] network-addresses-eth1-start[664]: adding address 2001:db8:1::1/64... done954machine # [ 8.516280] systemd[1]: Finished Address configuration of eth1.955machine # [ 8.579915] systemd[1]: Starting Virtual Console Setup...956machine # [ 8.606120] dhcpcd[676]: dhcpcd-10.3.2 starting957machine # [ 8.619322] dhcpcd[731]: dev: loaded udev958machine # [ 8.632258] systemd-logind[579]: Watching system buttons on /dev/input/event2 (Power Button)959machine # [ 8.639833] systemd[1]: Finished Extra networking commands..960machine # [ 8.782433] Console: switching to colour frame buffer device 160x50961machine # [ 8.784034] bochs-drm 0000:00:01.0: [drm] fb0: bochs-drmdrmfb frame buffer device962machine # [ 8.646076] systemd[1]: Reached target Network.963machine # [ 8.648908] systemd[1]: Starting Permit User Sessions...964machine # [ 8.655357] systemd-logind[579]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard)965machine # [ 8.805400] 8021q: 802.1Q VLAN Support v1.8966machine # [ 8.805860] 8021q: adding VLAN 0 to HW filter on device eth1967machine # [ 8.713689] systemd[1]: Finished Permit User Sessions.968machine # [ 8.725517] systemd[1]: Started Getty on tty1.969machine # [ 8.726932] systemd[1]: Reached target Login Prompts.970machine # [ 8.806093] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.971machine # [ 8.808350] systemd[1]: Stopped Virtual Console Setup.972machine # [ 8.818264] systemd[1]: Starting Virtual Console Setup...973machine # [ 8.977339] ppdev: user-space parallel port driver974machine # [ 8.859416] systemd-logind[579]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard)975machine # [ 9.018324] cfg80211: Loading compiled-in X.509 certificates for regulatory database976machine # [ 9.065726] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'977machine # [ 8.928550] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.978machine # [ 9.070306] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'979machine # [ 9.072941] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -2980machine # [ 9.073809] cfg80211: failed to load regulatory.db981machine # [ 9.076893] iTCO_wdt iTCO_wdt.1.auto: Found a ICH9 TCO device (Version=2, TCOBASE=0x0660)982machine # [ 9.093136] iTCO_wdt iTCO_wdt.1.auto: initialized. heartbeat=30 sec (nowayout=0)983machine # [ 8.994085] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.984machine # [ 8.996263] systemd[1]: Stopped Virtual Console Setup.985machine # [ 9.013178] systemd[1]: Starting Virtual Console Setup...986machine # [ 9.186679] 8021q: adding VLAN 0 to HW filter on device eth0987machine # [ 9.049983] dhcpcd[731]: eth0: waiting for carrier988machine # [ 9.052159] dhcpcd[731]: libudev: received NULL device989machine # [ 9.052937] dhcpcd[731]: libudev: received NULL device990machine # [ 9.053870] dhcpcd[731]: eth0: carrier acquired991machine # [ 9.088689] dhcpcd[731]: DUID 00:01:00:01:32:51:e7:46:52:54:00:12:34:56992machine # [ 9.089671] dhcpcd[731]: eth0: IAID 00:12:34:56993machine # [ 9.090365] dhcpcd[731]: eth0: adding address fe80::5054:ff:fe12:3456994machine # [ 9.258151] kvm_amd: TSC scaling supported995machine # [ 9.258598] kvm_amd: Nested Virtualization enabled996machine # [ 9.259096] kvm_amd: Nested Paging enabled997machine # [ 9.259875] kvm_amd: LBR virtualization supported998machine # [ 9.260323] kvm_amd: Virtual VMLOAD VMSAVE supported999machine # [ 9.261075] kvm_amd: Virtual GIF supported1000machine # [ 9.261620] kvm_amd: Virtual NMI enabled1001machine # [ 9.291419] EDAC MC: Ver: 3.0.01002machine # [ 9.241222] systemd-vconsole-setup[757]: Configuration of first virtual console was skipped, ignoring remaining ones.1003machine # [ 9.245332] systemd[1]: Finished Virtual Console Setup.1004machine # [ 10.769451] dhcpcd[731]: eth0: soliciting a DHCP lease1005machine # [ 10.927050] NET: Registered PF_PACKET protocol family1006machine # [ 10.793746] dhcpcd[731]: eth0: offered 10.0.2.15 from 10.0.2.21007machine # [ 10.797369] dhcpcd[731]: eth0: probing address 10.0.2.15/241008machine # [ 11.285359] dhcpcd[731]: eth0: soliciting an IPv6 router1009machine # [ 11.286706] dhcpcd[731]: eth0: Router Advertisement from fe80::21010machine # [ 11.287573] dhcpcd[731]: eth0: adding address fec0::5054:ff:fe12:3456/641011machine # [ 11.288429] dhcpcd[731]: eth0: adding route to fec0::/641012machine # [ 11.289216] dhcpcd[731]: eth0: adding default route via fe80::21013machine # [ 15.892501] dhcpcd[731]: eth0: leased 10.0.2.15 for 86400 seconds1014machine # [ 15.893457] dhcpcd[731]: eth0: adding route to 10.0.2.0/241015machine # [ 15.894696] dhcpcd[731]: eth0: adding default route via 10.0.2.21016machine # [ 15.957374] systemd[1]: Started DHCP Client.1017machine # [ 15.959240] systemd[1]: Reached target Multi-User System.1018machine # [ 15.960480] systemd[1]: Startup finished in 865ms (kernel) + 4.573s (initrd) + 10.521s (userspace) = 15.960s.1019machine: (finished: waiting for unit multi-user.target, in 8.74 seconds)1020machine: must succeed: systemd-analyze | grep -q '(initrd)'1021machine: (finished: must succeed: systemd-analyze | grep -q '(initrd)', in 0.03 seconds)1022machine: must succeed: touch /testfile1023machine: (finished: must succeed: touch /testfile, in 0.01 seconds)1024machine: must fail: touch /nix/store/testfile1025machine # touch: cannot touch '/nix/store/testfile': Read-only file system1026machine: (finished: must fail: touch /nix/store/testfile, in 0.01 seconds)1027machine: must succeed: [ -e /run/booted-system ]1028machine: (finished: must succeed: [ -e /run/booted-system ], in 0.01 seconds)1029machine: must succeed: [ -e /sys/class ]1030machine: (finished: must succeed: [ -e /sys/class ], in 0.01 seconds)1031machine: must succeed: [ -e /dev/null ]1032machine: (finished: must succeed: [ -e /dev/null ], in 0.01 seconds)1033machine: must succeed: [ -e /proc/1 ]1034machine: (finished: must succeed: [ -e /proc/1 ], in 0.01 seconds)1035machine: must succeed: [ -e /dev/shm ]1036machine: (finished: must succeed: [ -e /dev/shm ], in 0.01 seconds)1037machine: must succeed: [ -e /dev/pts/ptmx ]1038machine: (finished: must succeed: [ -e /dev/pts/ptmx ], in 0.01 seconds)1039machine: must succeed: [ -e /run/keys ]1040machine: (finished: must succeed: [ -e /run/keys ], in 0.01 seconds)1041machine: must succeed: [ ! -e /nixos-closure ]1042machine: (finished: must succeed: [ ! -e /nixos-closure ], in 0.01 seconds)1043(finished: subtest: handover to stage-2 systemd works, in 8.87 seconds)1044subtest: groups work1045machine: must fail: journalctl -b 0 | grep 'systemd-udevd.*Unknown group.*ignoring'1046machine: (finished: must fail: journalctl -b 0 | grep 'systemd-udevd.*Unknown group.*ignoring', in 0.02 seconds)1047(finished: subtest: groups work, in 0.02 seconds)1048subtest: growfs works1049machine: must succeed: df --output=avail / | sed 1d1050machine: (finished: must succeed: df --output=avail / | sed 1d, in 0.02 seconds)1051machine: waiting for the VM to power off1052additionally exposed symbols:1053 machine,1054 vlan1,1055 start_all, test_script, machines, machines_qemu, machines_nspawn, vlans, driver, log, os, create_machine, subtest, run_tests, join_all, retry, serial_stdout_off, serial_stdout_on, polling_condition, BaseMachine, QemuMachine, NspawnMachine, t, debug, dump_machine_ssh1056machine # [ 16.862989] systemd-logind[579]: poweroff requested from client PID 938 ('poweroff') (unit backdoor.service)...1057machine # [ 16.865666] systemd-logind[579]: System is powering down.1058machine # [ 16.871491] systemd-logind[579]: The system will power off now!1059machine # [ 16.881217] systemd[1]: Removed slice Slice /system/modprobe.1060machine # [ 16.882643] systemd[1]: Stopped target Multi-User System.1061machine # [ 16.884300] systemd[1]: Stopped target Login Prompts.1062machine # [ 16.886070] systemd[1]: Stopped target Virtual Machines and Containers.1063machine # [ 16.887950] systemd[1]: Stopped target Host and Network Name Lookups.1064machine # [ 16.889985] systemd[1]: Stopped target Timer Units.1065machine # [ 16.890705] systemd[1]: fstrim.timer: Deactivated successfully.1066machine # [ 16.891498] systemd[1]: Stopped Discard unused filesystem blocks once a week.1067machine # [ 16.892412] systemd[1]: systemd-tmpfiles-clean.timer: Deactivated successfully.1068machine # [ 16.894353] systemd[1]: Stopped Daily Cleanup of Temporary Directories.1069machine # [ 16.895258] systemd[1]: systemd-rfkill.socket: Deactivated successfully.1070machine # [ 16.896167] systemd[1]: Closed Load/Save RF Kill Switch Status /dev/rfkill Watch.1071machine # [ 16.899863] systemd[1]: Mounting /run/initramfs...1072machine # [ 16.903610] systemd[1]: Stopping backdoor.service...1073machine # [ 16.904785] dhcpcd[731]: received SIGTERM, stopping1074machine # [ 16.905663] systemd[1]: Stopping DHCP Client...1075machine # [ 16.907823] dhcpcd[731]: eth0: removing interface1076machine # [ 16.909271] systemd[1]: Stopping Getty on tty1...1077machine # [ 16.909975] dhcpcd[731]: eth0: deleting address fec0::5054:ff:fe12:3456/641078machine # [ 16.911934] systemd[1]: lastlog2-import.service: Deactivated successfully.1079machine # [ 16.913274] dhcpcd[731]: eth0: deleting route to fec0::/641080machine # [ 16.914782] systemd[1]: Stopped Import lastlog data into lastlog2 database.1081machine # [ 16.915770] dhcpcd[731]: eth0: deleting default route via fe80::21082machine # [ 16.920115] systemd[1]: Stopping Address configuration of eth1...1083machine # [ 16.931097] systemd[1]: Stopping Post-Boot Actions...1084machine # [ 16.931880] systemd[1]: reload-systemd-vconsole-setup.service: Deactivated successfully.1085machine # [ 16.932958] systemd[1]: Stopped Reset console on configuration changes.1086machine # [ 16.941763] systemd[1]: Stopping User Login Management...1087machine # [ 16.942906] systemd[1]: systemd-machine-id-commit.service: Deactivated successfully.1088machine # [ 16.945129] systemd[1]: Stopped Save Transient machine-id to Disk.1089machine # [ 16.945989] systemd[1]: Stopped target First Boot Complete.1090machine # [ 16.951464] systemd[1]: Stopping Userspace Out-Of-Memory (OOM) Killer...1091machine # [ 16.959764] systemd[1]: Stopping Load/Save OS Random Seed...1092machine # [ 16.967678] dhcpcd[731]: eth0: deleting address fe80::5054:ff:fe12:34561093machine # [ 16.969490] dhcpcd[731]: eth0: deleting route to 10.0.2.0/241094machine # [ 16.971105] dhcpcd[731]: eth0: deleting default route via 10.0.2.21095machine # [ 16.992341] systemd[1]: systemd-oomd.service: Deactivated successfully.1096machine # [ 16.995514] dhcpcd[731]: dhcpcd exited1097machine # [ 16.996663] systemd[1]: Stopped Userspace Out-Of-Memory (OOM) Killer.1098machine # [ 17.002323] systemd[1]: backdoor.service: Deactivated successfully.1099machine # [ 17.005790] network-addresses-eth1-pre-stop[942]: deleting address 192.168.1.1/24... done1100machine # [ 17.009524] systemd[1]: Stopped backdoor.service.1101machine # [ 17.015130] systemd[1]: systemd-logind.service: Deactivated successfully.1102machine # [ 17.016773] systemd[1]: Stopped User Login Management.1103machine # [ 17.018707] network-addresses-eth1-pre-stop[942]: deleting address 2001:db8:1::1/64... done1104machine # [ 17.029082] systemd[1]: dhcpcd.service: Deactivated successfully.1105machine # [ 17.030183] systemd[1]: Stopped DHCP Client.1106machine # [ 17.031323] systemd[1]: dhcpcd.service: Consumed 183ms CPU time over 8.727s wall clock time, 5.7M memory peak, 8K written to disk, 96B incoming IP traffic, 56B outgoing IP traffic.1107machine # [ 17.036909] systemd[1]: getty@tty1.service: Deactivated successfully.1108machine # [ 17.039639] systemd[1]: Stopped Getty on tty1.1109machine # [ 17.047705] systemd[1]: Mounted /run/initramfs.1110machine # [ 17.049159] systemd[1]: network-addresses-eth1.service: Deactivated successfully.1111machine # [ 17.050631] systemd[1]: Stopped Address configuration of eth1.1112machine # [ 17.052143] systemd[1]: post-boot.service: Deactivated successfully.1113machine # [ 17.053655] systemd[1]: Stopped Post-Boot Actions.1114machine # [ 17.055357] systemd[1]: systemd-random-seed.service: Deactivated successfully.1115machine # [ 17.056959] systemd[1]: Stopped Load/Save OS Random Seed.1116machine # [ 17.063824] systemd[1]: Removed slice Slice /system/getty.1117machine # [ 17.066768] systemd[1]: Starting Generate shutdown ramfs...1118machine # [ 17.071672] systemd[1]: Stopping Permit User Sessions...1119machine # [ 17.104093] systemd[1]: systemd-user-sessions.service: Deactivated successfully.1120machine # [ 17.105416] systemd[1]: Stopped Permit User Sessions.1121machine # [ 17.107796] systemd[1]: Stopped target Network.1122machine # [ 17.109183] systemd[1]: Stopped target User and Group Name Lookups.1123machine # [ 17.111095] systemd[1]: Stopped target Remote File Systems.1124machine # [ 17.111878] systemd[1]: network-local-commands.service: Deactivated successfully.1125machine # [ 17.112906] systemd[1]: Stopped Extra networking commands..1126machine # [ 17.114208] systemd[1]: Stopped target Preparation for Network.1127machine # [ 17.118887] systemd[1]: Stopping Firewall...1128machine # [ 17.122073] systemd[1]: Stopping Name Service Cache Daemon (nsncd)...1129machine # [ 17.122987] systemd[1]: resolvconf.service: Deactivated successfully.1130machine # [ 17.123887] systemd[1]: Stopped resolvconf update.1131machine # [ 17.124548] systemd[1]: nscd.service: Deactivated successfully.1132machine # [ 17.127326] systemd[1]: Stopped Name Service Cache Daemon (nsncd).1133machine # [ 17.141225] systemd[1]: Stopped target Basic System.1134machine # [ 17.142041] systemd[1]: Stopped target Path Units.1135machine # [ 17.142767] systemd[1]: Stopped target Slice Units.1136machine # [ 17.147230] systemd[1]: Removed slice User and Session Slice.1137machine # [ 17.148168] systemd[1]: Stopped target Socket Units.1138machine # [ 17.148898] systemd[1]: systemd-hostnamed.socket: Deactivated successfully.1139machine # [ 17.150712] systemd[1]: Closed Hostname Service Socket.1140machine # [ 17.151461] systemd[1]: systemd-importd.socket: Deactivated successfully.1141machine # [ 17.152850] systemd[1]: Closed Disk Image Download Service Socket.1142machine # [ 17.153899] systemd[1]: systemd-machined.socket: Deactivated successfully.1143machine # [ 17.155304] systemd[1]: Closed Virtual Machine and Container Registration Service Socket.1144machine # [ 17.157487] systemd[1]: systemd-mute-console.socket: Deactivated successfully.1145machine # [ 17.159530] systemd[1]: Closed Console Output Muting Service Socket.1146machine # [ 17.162168] systemd[1]: systemd-oomd.socket: Deactivated successfully.1147machine # [ 17.163872] systemd[1]: Closed Userspace Out-Of-Memory (OOM) Killer Socket.1148machine # [ 17.166258] systemd[1]: systemd-repart.socket: Deactivated successfully.1149machine # [ 17.167192] systemd[1]: Closed Disk Repartitioning Service Socket.1150machine # [ 17.168236] dbus-broker[625]: Dispatched 818 messages @ 2(±3)μs / message.1151machine # [ 17.171221] systemd[1]: Stopping D-Bus System Message Bus...1152machine # [ 17.174219] systemd[1]: dbus-broker.service: Deactivated successfully.1153machine # [ 17.175669] systemd[1]: Stopped D-Bus System Message Bus.1154machine # [ 17.181331] systemd[1]: dbus.socket: Deactivated successfully.1155machine # [ 17.182995] systemd[1]: Closed D-Bus System Message Bus Socket.1156machine # [ 17.183909] systemd[1]: Stopped target System Initialization.1157machine # [ 17.185141] systemd[1]: Stopped target Local Encrypted Volumes.1158machine # [ 17.187154] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.1159machine # [ 17.188785] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.1160machine # [ 17.190130] systemd[1]: systemd-ask-password-wall.path: Deactivated successfully.1161machine # [ 17.191164] systemd[1]: Stopped Forward Password Requests to Wall Directory Watch.1162machine # [ 17.192674] systemd[1]: systemd-sysctl.service: Deactivated successfully.1163machine # [ 17.194131] systemd[1]: Stopped Apply Kernel Variables.1164machine # [ 17.194875] systemd[1]: systemd-coredump.socket: Deactivated successfully.1165machine # [ 17.195972] systemd[1]: Closed Process Core Dump Socket.1166machine # [ 17.197026] make-initrd-ng[970]: /etc/initrd-release -> /nix/store/7dkvhcvi4mri514gbvzzfwpl1ra73ps9-etc-os-release1167machine # [ 17.199760] systemd[1]: systemd-update-done.service: Deactivated successfully.1168machine # [ 17.200768] make-initrd-ng[970]: /etc/os-release -> /nix/store/7dkvhcvi4mri514gbvzzfwpl1ra73ps9-etc-os-release1169machine # [ 17.202019] make-initrd-ng[970]: /shutdown -> /nix/store/db7sjy6vdbb5wnl8ck2b4i6rfh38k3c6-systemd-263-b43fed8/lib/systemd/systemd-shutdown1170machine # [ 17.203498] systemd[1]: Stopped Update is Completed.1171machine # [ 17.206995] systemd[1]: systemd-journal-catalog-update.service: Deactivated successfully.1172machine # [ 17.208177] systemd[1]: Stopped Rebuild Journal Catalog.1173machine # [ 17.210082] systemd[1]: Stopping Record System Boot/Shutdown in UTMP...1174machine # [ 17.249344] systemd[1]: systemd-update-utmp.service: Deactivated successfully.1175machine # [ 17.252166] systemd[1]: Stopped Record System Boot/Shutdown in UTMP.1176machine # [ 17.253144] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.1177machine # [ 17.254419] systemd[1]: Stopped Create System Files and Directories.1178machine # [ 17.256144] systemd[1]: Stopped target Local File Systems.1179machine # [ 17.262234] systemd[1]: Unmounting /run/keys...1180machine # [ 17.264696] systemd[1]: Unmounting /run/wrappers...1181machine # [ 17.265646] systemd[1]: systemd-growfs-root.service: Deactivated successfully.1182machine # [ 17.267143] systemd[1]: Stopped Grow Root File System.1183machine # [ 17.308867] systemd[1]: firewall.service: Deactivated successfully.1184machine # [ 17.316866] systemd[1]: Stopped Firewall.1185machine # [ 17.317621] systemd[1]: systemd-modules-load.service: Deactivated successfully.1186machine # [ 17.320167] systemd[1]: Stopped Load Kernel Modules.1187machine # [ 17.336936] systemd[1]: run-keys.mount: Deactivated successfully.1188machine # [ 17.337907] systemd[1]: Unmounted /run/keys.1189machine # [ 17.339290] systemd[1]: generate-shutdown-ramfs.service: Deactivated successfully.1190machine # [ 17.340634] systemd[1]: Finished Generate shutdown ramfs.1191machine # [ 17.342072] systemd[1]: run-wrappers.mount: Deactivated successfully.1192machine # [ 17.344531] systemd[1]: Unmounted /run/wrappers.1193machine # [ 17.346772] systemd[1]: Stopped target Preparation for Local File Systems.1194machine # [ 17.347840] systemd[1]: Stopped target Swaps.1195machine # [ 17.348678] systemd[1]: Reached target Unmount All Filesystems.1196machine # [ 17.350144] systemd[1]: systemd-remount-fs.service: Deactivated successfully.1197machine # [ 17.351125] systemd[1]: Stopped Remount Root and Kernel File Systems.1198machine # [ 17.351990] systemd[1]: systemd-fsck-root.service: Deactivated successfully.1199machine # [ 17.353910] systemd[1]: Stopped File System Check on Root Device.1200machine # [ 17.354818] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.1201machine # [ 17.355836] systemd[1]: Stopped Create Static Device Nodes in /dev.1202machine # [ 17.356695] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.1203machine # [ 17.357744] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.1204machine # [ 17.358699] systemd[1]: Reached target System Shutdown.1205machine # [ 17.359725] systemd[1]: Reached target Late Shutdown Services.1206machine # [ 17.361329] systemd[1]: systemd-poweroff.service: Deactivated successfully.1207machine # [ 17.362343] systemd[1]: Finished System Power Off.1208machine # [ 17.363264] systemd[1]: Reached target System Power Off.1209machine # [ 17.364256] systemd[1]: Shutting down.1210machine # [ 17.537831] systemd-shutdown[1]: Syncing filesystems and block devices.1211machine # [ 17.895129] systemd-shutdown[1]: Sending SIGTERM to remaining processes...1212machine # [ 17.905227] systemd-journald[335]: Received SIGTERM from PID 1 (systemd-shutdow).1213machine # [ 17.922859] systemd-shutdown[1]: Sending SIGKILL to remaining processes...1214machine # [ 17.931000] systemd-shutdown[1]: Unmounting file systems.1215machine # [ 17.936140] (sd-umount)[1001]: Unmounting '/run/credentials/systemd-journald.service'.1216machine # [ 17.939973] (sd-remount)[1002]: Remounting '/nix/store' read-only with options 'lowerdir=/sysroot/nix/.ro-store,upperdir=/sysroot/nix/.rw-store/upper,workdir=/sysroot/nix/.rw-store/work,uuid=on'.1217machine # [ 17.955424] (sd-umount)[1003]: Unmounting '/nix/store'.1218machine # [ 17.956966] (sd-umount)[1003]: Failed to unmount /nix/store: Device or resource busy1219machine # [ 17.959021] systemd-shutdown[1]: Moving mount /nix/store to /run/shutdown/mounts/9398ea1c8ffb6ceb.1220machine # [ 17.961502] (sd-remount)[1004]: Remounting '/nix/store' read-only with options 'lowerdir=/sysroot/nix/.ro-store,upperdir=/sysroot/nix/.rw-store/upper,workdir=/sysroot/nix/.rw-store/work,uuid=on'.1221machine # [ 17.965830] (sd-umount)[1005]: Unmounting '/nix/store'.1222machine # [ 17.967917] (sd-remount)[1006]: Remounting '/tmp/xchg' read-only with options ''.1223machine # [ 17.969761] (sd-umount)[1007]: Unmounting '/tmp/xchg'.1224machine # [ 17.971023] (sd-remount)[1008]: Remounting '/tmp/shared' read-only with options ''.1225machine # [ 17.972263] (sd-umount)[1009]: Unmounting '/tmp/shared'.1226machine # [ 17.973545] (sd-umount)[1010]: Unmounting '/nix/.rw-store'.1227machine # [ 17.974634] (sd-umount)[1011]: Unmounting '/nix/.ro-store'.1228machine # [ 17.975737] (sd-remount)[1012]: Remounting '/' read-only with options ''.1229machine # [ 17.983288] EXT4-fs (vda): re-mounted 60cfc836-912d-4264-9e87-2fee5a628c76 ro.1230machine # [ 17.985155] (sd-umount)[1013]: Unmounting '/run/shutdown/mounts/9398ea1c8ffb6ceb'.1231machine # [ 17.986014] (sd-umount)[1013]: Failed to unmount /run/shutdown/mounts/9398ea1c8ffb6ceb: Device or resource busy1232machine # [ 17.987294] systemd-shutdown[1]: Not all file systems unmounted, 1 left.1233machine # [ 17.988047] systemd-shutdown[1]: Deactivating swaps.1234machine # [ 17.988599] systemd-shutdown[1]: All swaps deactivated.1235machine # [ 17.989172] systemd-shutdown[1]: Detaching loop devices.1236machine # [ 17.992905] systemd-shutdown[1]: All loop devices detached.1237machine # [ 17.993510] systemd-shutdown[1]: Stopping MD devices.1238machine # [ 17.994181] systemd-shutdown[1]: All MD devices stopped.1239machine # [ 17.994760] systemd-shutdown[1]: Detaching DM devices.1240machine # [ 17.995363] systemd-shutdown[1]: All DM devices detached.1241machine # [ 17.996013] systemd-shutdown[1]: Unmounting file systems.1242machine # [ 17.997105] (sd-umount)[1014]: Unmounting '/run/shutdown/mounts/9398ea1c8ffb6ceb'.1243machine # [ 17.997953] (sd-umount)[1014]: Failed to unmount /run/shutdown/mounts/9398ea1c8ffb6ceb: Device or resource busy1244machine # [ 17.999157] systemd-shutdown[1]: Not all file systems unmounted, 1 left.1245machine # [ 17.999925] systemd-shutdown[1]: Cannot finalize remaining file systems, continuing.1246machine # [ 18.002715] systemd-shutdown[1]: Successfully changed into root pivot.1247machine # [ 18.003398] systemd-shutdown[1]: Entering exitrd...1248machine # [ 18.008598] shutdown[1]: Syncing filesystems and block devices.1249machine # [ 18.009645] shutdown[1]: Sending SIGTERM to remaining processes...1250machine # [ 18.012146] shutdown[1]: Sending SIGKILL to remaining processes...1251machine # [ 18.014477] shutdown[1]: Unmounting file systems.1252machine # [ 18.016041] (sd-umoun[1016]: Unmounting '/run/credentials'.1253machine # [ 18.017142] (sd-umoun[1017]: Unmounting '/oldroot/sys/kernel/config'.1254machine # [ 18.018303] (sd-umoun[1018]: Unmounting '/oldroot/sys/fs/fuse/connections'.1255machine # [ 18.019525] (sd-umoun[1019]: Unmounting '/oldroot/sys/kernel/debug'.1256machine # [ 18.020649] (sd-umoun[1020]: Unmounting '/oldroot/sys/kernel/tracing'.1257machine # [ 18.021801] (sd-umoun[1021]: Unmounting '/oldroot/dev/hugepages'.1258machine # [ 18.023673] (sd-umoun[1022]: Unmounting '/oldroot/dev/mqueue'.1259machine # [ 18.025354] (sd-umoun[1023]: Unmounting '/oldroot/sys/fs/bpf'.1260machine # [ 18.026907] (sd-umoun[1024]: Unmounting '/oldroot/sys/fs/pstore'.1261machine # [ 18.028474] (sd-umoun[1025]: Unmounting '/oldroot/sys/fs/cgroup'.1262machine # [ 18.029930] (sd-umoun[1026]: Unmounting '/oldroot/sys/kernel/security'.1263machine # [ 18.031473] (sd-umoun[1027]: Unmounting '/oldroot/run/shutdown/mounts/9398ea1c8ffb6ceb'.1264machine # [ 18.052860] (sd-umoun[1028]: Unmounting '/oldroot/sys'.1265machine # [ 18.054516] (sd-umoun[1029]: Unmounting '/oldroot/proc'.1266machine # [ 18.055933] (sd-umoun[1030]: Unmounting '/oldroot/dev/shm'.1267machine # [ 18.057266] (sd-umoun[1031]: Unmounting '/oldroot/dev/pts'.1268machine # [ 18.058659] (sd-umoun[1032]: Unmounting '/oldroot/dev'.1269machine # [ 18.059940] (sd-umoun[1033]: Unmounting '/oldroot/run'.1270machine # [ 18.061223] (sd-umoun[1034]: Unmounting '/oldroot'.1271machine # [ 18.063585] EXT4-fs (vda): unmounting filesystem 60cfc836-912d-4264-9e87-2fee5a628c76.1272machine # [ 18.065288] shutdown[1]: All filesystems unmounted.1273machine # [ 18.066298] shutdown[1]: Deactivating swaps.1274machine # [ 18.067162] shutdown[1]: All swaps deactivated.1275machine # [ 18.067959] shutdown[1]: Detaching loop devices.1276machine # [ 18.069916] shutdown[1]: All loop devices detached.1277machine # [ 18.070792] shutdown[1]: Stopping MD devices.1278machine # [ 18.071614] shutdown[1]: All MD devices stopped.1279machine # [ 18.072356] shutdown[1]: Detaching DM devices.1280machine # [ 18.073159] shutdown[1]: All DM devices detached.1281machine # [ 18.073945] shutdown[1]: All filesystems, swaps, loop devices, MD devices and DM devices detached.1282machine # [ 18.075236] shutdown[1]: Syncing filesystems and block devices.1283machine # [ 18.076514] shutdown[1]: Powering off.1284machine # [ 18.086998] ACPI: PM: Preparing to enter system sleep state S51285machine # [ 18.087886] kvm: exiting hardware virtualization1286machine # [ 18.088547] reboot: Power down1287machine # [2026-10-02T03:53:52Z INFO virtiofsd] Client disconnected, shutting down1288machine # [2026-10-02T03:53:52Z INFO virtiofsd] Client disconnected, shutting down1289machine # [2026-10-02T03:53:52Z INFO virtiofsd] Client disconnected, shutting down1290machine: (finished: waiting for the VM to power off, in 1.28 seconds)1291Image resized.1292machine: starting vm1293machine # Starting virtiofs daemons...1294machine: QEMU running (pid 98)1295machine # [2026-10-02T03:53:52Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)1296machine: waiting for unit initrd.target1297machine # [2026-10-02T03:53:52Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether1298machine: waiting for the VM to finish booting1299machine # [2026-10-02T03:53:52Z INFO virtiofsd] Waiting for vhost-user socket connection...1300machine # [2026-10-02T03:53:52Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)1301machine # [2026-10-02T03:53:52Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether1302machine # [2026-10-02T03:53:52Z INFO virtiofsd] Waiting for vhost-user socket connection...1303machine # [2026-10-02T03:53:52Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)1304machine # [2026-10-02T03:53:52Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether1305machine # [2026-10-02T03:53:52Z INFO virtiofsd] Waiting for vhost-user socket connection...1306machine # [2026-10-02T03:53:52Z INFO virtiofsd] Client connected, servicing requests1307machine # [2026-10-02T03:53:52Z INFO virtiofsd] Client connected, servicing requests1308machine # [2026-10-02T03:53:52Z INFO virtiofsd] Client connected, servicing requests1309machine # SeaBIOS (version rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org)1310machine # 1311machine # 1312machine # iPXE (http://ipxe.org) 00:02.0 CA00 PCI2.10 PnP PMM+3EFCC730+3EF2C730 CA001313machine # Press Ctrl-B to configure iPXE (PCI 00:02.0)...1314machine # 1315machine # 1316machine # 1317machine # 1318machine # iPXE (http://ipxe.org) 00:05.0 CB00 PCI2.10 PnP PMM 3EFCC730 3EF2C730 CB001319machine # Press Ctrl-B to configure iPXE (PCI 00:05.0)...1320machine # 1321machine # 1322machine # Booting from ROM...1323machine # Probing EDD (edd=off to disable)... ok[ 0.000000] Linux version 6.18.54 (nixbld@localhost) (gcc (GCC) 16.2.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT_DYNAMIC Fri Sep 25 14:35:54 UTC 20261324machine # [ 0.000000] Command line: console=ttyS0 console=tty0 panic=1 boot.panic_on_fail clocksource=acpi_pm root=fstab loglevel=7 net.ifnames=0 lsm=landlock,yama,bpf init=/nix/store/lh9zs34p9c1bvyavdq1mlk6pgr61pf8m-nixos-system-machine-test/init regInfo=/nix/.ro-store/zv32cw89qd71hd3phgx2h3gba7i00qhw-closure-info/registration console=ttyS0,115200n8 console=tty01325machine # [ 0.000000] BIOS-provided physical RAM map:1326machine # [ 0.000000] BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable1327machine # [ 0.000000] BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved1328machine # [ 0.000000] BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved1329machine # [ 0.000000] BIOS-e820: [mem 0x0000000000100000-0x000000003ffd7fff] usable1330machine # [ 0.000000] BIOS-e820: [mem 0x000000003ffd8000-0x000000003fffffff] reserved1331machine # [ 0.000000] BIOS-e820: [mem 0x00000000b0000000-0x00000000bfffffff] reserved1332machine # [ 0.000000] BIOS-e820: [mem 0x00000000fed1c000-0x00000000fed1ffff] reserved1333machine # [ 0.000000] BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved1334machine # [ 0.000000] BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved1335machine # [ 0.000000] BIOS-e820: [mem 0x000000fd00000000-0x000000ffffffffff] reserved1336machine # [ 0.000000] NX (Execute Disable) protection: active1337machine # [ 0.000000] APIC: Static calls initialized1338machine # [ 0.000000] SMBIOS 2.8 present.1339machine # [ 0.000000] DMI: QEMU Standard PC (Q35 + ICH9, 2009), BIOS rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org 04/01/20141340machine # [ 0.000000] DMI: Memory slots populated: 1/11341machine # [ 0.000000] Hypervisor detected: KVM1342machine # [ 0.000000] last_pfn = 0x3ffd8 max_arch_pfn = 0x100000000001343machine # [ 0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d001344machine # [ 0.000000] kvm-clock: using sched offset of 509373824 cycles1345machine # [ 0.000002] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns1346machine # [ 0.000005] tsc: Detected 2400.012 MHz processor1347machine # [ 0.000764] last_pfn = 0x3ffd8 max_arch_pfn = 0x100000000001348machine # [ 0.000791] MTRR map: 4 entries (3 fixed + 1 variable; max 19), built from 8 variable MTRRs1349machine # [ 0.000793] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT1350machine # [ 0.002686] found SMP MP-table at [mem 0x000f5450-0x000f545f]1351machine # [ 0.002697] Using GB pages for direct mapping1352machine # [ 0.002759] RAMDISK: [mem 0x3e36a000-0x3ffcffff]1353machine # [ 0.002768] ACPI: Early table checksum verification disabled1354machine # [ 0.002770] ACPI: RSDP 0x00000000000F5270 000014 (v00 BOCHS )1355machine # [ 0.002774] ACPI: RSDT 0x000000003FFE2422 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001)1356machine # [ 0.002778] ACPI: FACP 0x000000003FFE221A 0000F4 (v03 BOCHS BXPC 00000001 BXPC 00000001)1357machine # [ 0.002785] ACPI: DSDT 0x000000003FFE0040 0021DA (v01 BOCHS BXPC 00000001 BXPC 00000001)1358machine # [ 0.002787] ACPI: FACS 0x000000003FFE0000 0000401359machine # [ 0.002789] ACPI: APIC 0x000000003FFE230E 000078 (v03 BOCHS BXPC 00000001 BXPC 00000001)1360machine # [ 0.002791] ACPI: HPET 0x000000003FFE2386 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001)1361machine # [ 0.002792] ACPI: MCFG 0x000000003FFE23BE 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001)1362machine # [ 0.002794] ACPI: WAET 0x000000003FFE23FA 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001)1363machine # [ 0.002795] ACPI: Reserving FACP table memory at [mem 0x3ffe221a-0x3ffe230d]1364machine # [ 0.002796] ACPI: Reserving DSDT table memory at [mem 0x3ffe0040-0x3ffe2219]1365machine # [ 0.002797] ACPI: Reserving FACS table memory at [mem 0x3ffe0000-0x3ffe003f]1366machine # [ 0.002797] ACPI: Reserving APIC table memory at [mem 0x3ffe230e-0x3ffe2385]1367machine # [ 0.002798] ACPI: Reserving HPET table memory at [mem 0x3ffe2386-0x3ffe23bd]1368machine # [ 0.002798] ACPI: Reserving MCFG table memory at [mem 0x3ffe23be-0x3ffe23f9]1369machine # [ 0.002798] ACPI: Reserving WAET table memory at [mem 0x3ffe23fa-0x3ffe2421]1370machine # [ 0.003024] No NUMA configuration found1371machine # [ 0.003025] Faking a node at [mem 0x0000000000000000-0x000000003ffd7fff]1372machine # [ 0.003028] NODE_DATA(0) allocated [mem 0x3ffd2780-0x3ffd7cff]1373machine # [ 0.005373] Zone ranges:1374machine # [ 0.005374] DMA [mem 0x0000000000001000-0x0000000000ffffff]1375machine # [ 0.005375] DMA32 [mem 0x0000000001000000-0x000000003ffd7fff]1376machine # [ 0.005376] Normal empty1377machine # [ 0.005377] Device empty1378machine # [ 0.005378] Movable zone start for each node1379machine # [ 0.005379] Early memory node ranges1380machine # [ 0.005379] node 0: [mem 0x0000000000001000-0x000000000009efff]1381machine # [ 0.005380] node 0: [mem 0x0000000000100000-0x000000003ffd7fff]1382machine # [ 0.005381] Initmem setup node 0 [mem 0x0000000000001000-0x000000003ffd7fff]1383machine # [ 0.005401] On node 0, zone DMA: 1 pages in unavailable ranges1384machine # [ 0.005667] On node 0, zone DMA: 97 pages in unavailable ranges1385machine # [ 0.023766] On node 0, zone DMA32: 40 pages in unavailable ranges1386machine # [ 0.024220] ACPI: PM-Timer IO Port: 0x6081387machine # [ 0.024230] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1])1388machine # [ 0.024255] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-231389machine # [ 0.024258] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl)1390machine # [ 0.024259] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level)1391machine # [ 0.024260] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level)1392machine # [ 0.024261] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level)1393machine # [ 0.024262] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level)1394machine # [ 0.024264] ACPI: Using ACPI (MADT) for SMP configuration information1395machine # [ 0.024265] ACPI: HPET id: 0x8086a201 base: 0xfed000001396machine # [ 0.024268] TSC deadline timer available1397machine # [ 0.024272] CPU topo: Max. logical packages: 11398machine # [ 0.024272] CPU topo: Max. logical dies: 11399machine # [ 0.024273] CPU topo: Max. dies per package: 11400machine # [ 0.024276] CPU topo: Max. threads per core: 11401machine # [ 0.024277] CPU topo: Num. cores per package: 11402machine # [ 0.024277] CPU topo: Num. threads per package: 11403machine # [ 0.024277] CPU topo: Allowing 1 present CPUs plus 0 hotplug CPUs1404machine # [ 0.024293] kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write()1405machine # [ 0.024321] PM: hibernation: Registered nosave memory: [mem 0x00000000-0x00000fff]1406machine # [ 0.024323] PM: hibernation: Registered nosave memory: [mem 0x0009f000-0x000fffff]1407machine # [ 0.024324] [mem 0x40000000-0xafffffff] available for PCI devices1408machine # [ 0.024325] Booting paravirtualized kernel on KVM1409machine # [ 0.024328] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns1410machine # [ 0.028956] setup_percpu: NR_CPUS:384 nr_cpumask_bits:1 nr_cpu_ids:1 nr_node_ids:11411machine # [ 0.031162] percpu: Embedded 98 pages/cpu s278528 r8192 d114688 u20971521412machine # [ 0.031205] kvm-guest: PV spinlocks disabled, single CPU1413machine # [ 0.031206] Kernel command line: console=ttyS0 console=tty0 panic=1 boot.panic_on_fail clocksource=acpi_pm root=fstab loglevel=7 net.ifnames=0 lsm=landlock,yama,bpf init=/nix/store/lh9zs34p9c1bvyavdq1mlk6pgr61pf8m-nixos-system-machine-test/init regInfo=/nix/.ro-store/zv32cw89qd71hd3phgx2h3gba7i00qhw-closure-info/registration console=ttyS0,115200n8 console=tty01414machine # [ 0.031304] Unknown kernel command line parameters "regInfo=/nix/.ro-store/zv32cw89qd71hd3phgx2h3gba7i00qhw-closure-info/registration", will be passed to user space.1415machine # [ 0.031317] random: crng init done1416machine # [ 0.031318] printk: log buffer data + meta data: 262144 + 917504 = 1179648 bytes1417machine # [ 0.032410] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes, linear)1418machine # [ 0.032422] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes, linear)1419machine # [ 0.032458] Fallback order for Node 0: 01420machine # [ 0.032460] Built 1 zonelists, mobility grouping on. Total pages: 2620061421machine # [ 0.032461] Policy zone: DMA321422machine # [ 0.035266] mem auto-init: stack:all(zero), heap alloc:on, heap free:off1423machine # [ 0.037752] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=11424machine # [ 0.040061] allocated 2097152 bytes of page_ext1425machine # [ 0.050004] ftrace: allocating 48820 entries in 192 pages1426machine # [ 0.050006] ftrace: allocated 192 pages with 2 groups1427machine # [ 0.050851] Dynamic Preempt: lazy1428machine # [ 0.050960] rcu: Preemptible hierarchical RCU implementation.1429machine # [ 0.050961] rcu: RCU event tracing is enabled.1430machine # [ 0.050961] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1.1431machine # [ 0.050963] Trampoline variant of Tasks RCU enabled.1432machine # [ 0.050963] Rude variant of Tasks RCU enabled.1433machine # [ 0.050963] Tracing variant of Tasks RCU enabled.1434machine # [ 0.050964] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies.1435machine # [ 0.050965] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=11436machine # [ 0.050987] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.1437machine # [ 0.050989] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.1438machine # [ 0.050990] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.1439machine # [ 0.055311] NR_IRQS: 24832, nr_irqs: 256, preallocated irqs: 161440machine # [ 0.055582] rcu: srcu_init: Setting srcu_struct sizes based on contention.1441machine # [ 0.055588] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns1442machine # [ 0.055689] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)1443machine # [ 0.059190] Console: colour VGA+ 80x251444machine # [ 0.059192] printk: legacy console [tty0] enabled1445machine # [ 0.088746] printk: legacy console [ttyS0] enabled1446machine # [ 0.193177] ACPI: Core revision 202508071447machine # [ 0.194134] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns1448machine # [ 0.195774] APIC: Switch to symmetric I/O mode setup1449machine # [ 0.196831] x2apic enabled1450machine # [ 0.197583] APIC: Switched APIC routing to: physical x2apic1451machine # [ 0.199662] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-11452machine # [ 0.200668] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x229842dd0bd, max_idle_ns: 440795319571 ns1453machine # [ 0.202403] Calibrating delay loop (skipped) preset value.. 4800.02 BogoMIPS (lpj=2400012)1454machine # [ 0.203491] x86/cpu: User Mode Instruction Prevention (UMIP) activated1455machine # [ 0.204535] Last level iTLB entries: 4KB 512, 2MB 255, 4MB 1271456machine # [ 0.205401] Last level dTLB entries: 4KB 512, 2MB 255, 4MB 127, 1GB 01457machine # [ 0.206404] mitigations: Enabled attack vectors: user_kernel, user_user, guest_host, guest_guest, SMT mitigations: auto1458machine # [ 0.207401] Speculative Store Bypass: Mitigation: Speculative Store Bypass disabled via prctl1459machine # [ 0.208401] Transient Scheduler Attacks: Vulnerable: No microcode1460machine # [ 0.209401] Spectre V2 : Mitigation: Enhanced / Automatic IBRS1461machine # [ 0.211151] Speculative Return Stack Overflow: Mitigation: Safe RET1462machine # [ 0.212194] Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization1463machine # [ 0.213409] Spectre V2 : Enabling IBPB for BPF1464machine # [ 0.214972] Spectre V2 : mitigation: Enabling conditional Indirect Branch Prediction Barrier1465machine # [ 0.215401] active return thunk: srso_alias_return_thunk1466machine # [ 0.216421] x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers'1467machine # [ 0.217400] x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers'1468machine # [ 0.218400] x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers'1469machine # [ 0.219400] x86/fpu: Supporting XSAVE feature 0x020: 'AVX-512 opmask'1470machine # [ 0.220400] x86/fpu: Supporting XSAVE feature 0x040: 'AVX-512 Hi256'1471machine # [ 0.221400] x86/fpu: Supporting XSAVE feature 0x080: 'AVX-512 ZMM_Hi256'1472machine # [ 0.222400] x86/fpu: Supporting XSAVE feature 0x200: 'Protection Keys User registers'1473machine # [ 0.224401] x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 2561474machine # [ 0.225400] x86/fpu: xstate_offset[5]: 832, xstate_sizes[5]: 641475machine # [ 0.226400] x86/fpu: xstate_offset[6]: 896, xstate_sizes[6]: 5121476machine # [ 0.227400] x86/fpu: xstate_offset[7]: 1408, xstate_sizes[7]: 10241477machine # [ 0.228400] x86/fpu: xstate_offset[9]: 2432, xstate_sizes[9]: 81478machine # [ 0.229400] x86/fpu: Enabled xstate features 0x2e7, context size is 2440 bytes, using 'compacted' format.1479machine # [ 0.263449] Freeing SMP alternatives memory: 48K1480machine # [ 0.264259] pid_max: default: 32768 minimum: 3011481machine # [ 0.265047] LSM: initializing lsm=capability,landlock,yama,bpf,ima1482machine # [ 0.265716] landlock: Up and running.1483machine # [ 0.266402] Yama: becoming mindful.1484machine # [ 0.267612] LSM support for eBPF active1485machine # [ 0.268372] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)1486machine # [ 0.269422] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)1487machine # [ 0.272138] smpboot: CPU0: AMD EPYC 9654 96-Core Processor (family: 0x19, model: 0x11, stepping: 0x1)1488machine # [ 0.272957] Performance Events: Fam17h+ core perfctr, AMD PMU driver.1489machine # [ 0.273406] ... version: 21490machine # [ 0.274110] ... bit width: 481491machine # [ 0.274403] ... generic counters: 61492machine # [ 0.275162] ... generic bitmap: 000000000000003f1493machine # [ 0.275448] ... fixed-purpose counters: 01494machine # [ 0.276180] ... fixed-purpose bitmap: 00000000000000001495machine # [ 0.276403] ... value mask: 0000ffffffffffff1496machine # [ 0.277320] ... max period: 00007fffffffffff1497machine # [ 0.278139] ... global_ctrl mask: 000000000000003f1498machine # [ 0.278530] signal: max sigframe size: 33761499machine # [ 0.279367] rcu: Hierarchical SRCU implementation.1500machine # [ 0.280052] rcu: Max phase no-delay instances is 400.1501machine # [ 0.285102] smp: Bringing up secondary CPUs ...1502machine # [ 0.285417] smp: Brought up 1 node, 1 CPU1503machine # [ 0.286108] smpboot: Total of 1 processors activated (4800.02 BogoMIPS)1504machine # [ 0.286578] Memory: 941072K/1048024K available (18120K kernel code, 2728K rwdata, 13640K rodata, 3656K init, 3632K bss, 99604K reserved, 0K cma-reserved)1505machine # [ 0.287618] devtmpfs: initialized1506machine # [ 0.288477] x86/mm: Memory block size: 128MB1507machine # [ 0.290172] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear)1508machine # [ 0.291388] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear).1509machine # [ 0.292495] pinctrl core: initialized pinctrl subsystem1510machine # [ 0.293721] PM: RTC time: 03:53:52, date: 2026-10-021511machine # [ 0.297311] NET: Registered PF_NETLINK/PF_ROUTE protocol family1512machine # [ 0.298749] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations1513machine # [ 0.299425] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations1514machine # [ 0.300548] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations1515machine # [ 0.301411] audit: initializing netlink subsys (disabled)1516machine # [ 0.302574] thermal_sys: Registered thermal governor 'fair_share'1517machine # [ 0.302576] thermal_sys: Registered thermal governor 'bang_bang'1518machine # [ 0.303406] audit: type=2000 audit(1790913233.506:1): state=initialized audit_enabled=0 res=11519machine # [ 0.305404] thermal_sys: Registered thermal governor 'step_wise'1520machine # [ 0.305405] thermal_sys: Registered thermal governor 'user_space'1521machine # [ 0.306389] thermal_sys: Registered thermal governor 'power_allocator'1522machine # [ 0.307197] cpuidle: using governor menu1523machine # [ 0.309496] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.51524machine # [ 0.310642] PCI: ECAM [mem 0xb0000000-0xbfffffff] (base 0xb0000000) for domain 0000 [bus 00-ff]1525machine # [ 0.311406] PCI: ECAM [mem 0xb0000000-0xbfffffff] reserved as E820 entry1526machine # [ 0.312415] PCI: Using configuration type 1 for base access1527machine # [ 0.313586] kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible.1528machine # [ 0.320425] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages1529machine # [ 0.321403] HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page1530machine # [ 0.326405] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages1531machine # [ 0.327404] HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page1532machine # [ 0.338705] ACPI: Added _OSI(Module Device)1533machine # [ 0.339404] ACPI: Added _OSI(Processor Device)1534machine # [ 0.340183] ACPI: Added _OSI(Processor Aggregator Device)1535machine # [ 0.344230] ACPI: 1 ACPI AML tables successfully acquired and loaded1536machine # [ 0.350333] ACPI: Interpreter enabled1537machine # [ 0.350931] ACPI: PM: (supports S0 S3 S4 S5)1538machine # [ 0.351404] ACPI: Using IOAPIC for interrupt routing1539machine # [ 0.352345] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug1540machine # [ 0.357404] PCI: Using E820 reservations for host bridge windows1541machine # [ 0.358549] ACPI: Enabled 2 GPEs in block 00 to 3F1542machine # [ 0.364945] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff])1543machine # [ 0.365409] acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3]1544machine # [ 0.366488] acpi PNP0A08:00: _OSC: platform does not support [PCIeHotplug LTR]1545machine # [ 0.367526] acpi PNP0A08:00: _OSC: OS now controls [PME AER PCIeCapability]1546machine # [ 0.368755] PCI host bridge to bus 0000:001547machine # [ 0.369408] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window]1548machine # [ 0.370403] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window]1549machine # [ 0.371403] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window]1550machine # [ 0.372403] pci_bus 0000:00: root bus resource [mem 0x40000000-0xafffffff window]1551machine # [ 0.373403] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window]1552machine # [ 0.374403] pci_bus 0000:00: root bus resource [mem 0x100000000-0x8ffffffff window]1553machine # [ 0.375403] pci_bus 0000:00: root bus resource [bus 00-ff]1554machine # [ 0.376477] pci 0000:00:00.0: [8086:29c0] type 00 class 0x060000 conventional PCI endpoint1555machine # [ 0.377846] pci 0000:00:01.0: [1234:1111] type 00 class 0x030000 conventional PCI endpoint1556machine # [ 0.380487] pci 0000:00:01.0: BAR 0 [mem 0xfd000000-0xfdffffff pref]1557machine # [ 0.381480] pci 0000:00:01.0: BAR 2 [mem 0xfebd0000-0xfebd0fff]1558machine # [ 0.382426] pci 0000:00:01.0: ROM [mem 0xfebc0000-0xfebcffff pref]1559machine # [ 0.383924] pci 0000:00:01.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff]1560machine # [ 0.385110] pci 0000:00:02.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint1561machine # [ 0.388444] pci 0000:00:02.0: BAR 0 [io 0xc100-0xc11f]1562machine # [ 0.389333] pci 0000:00:02.0: BAR 1 [mem 0xfebd1000-0xfebd1fff]1563machine # [ 0.390215] pci 0000:00:02.0: BAR 4 [mem 0xfe000000-0xfe003fff 64bit pref]1564machine # [ 0.391319] pci 0000:00:02.0: ROM [mem 0xfeb40000-0xfeb7ffff pref]1565machine # [ 0.392979] pci 0000:00:03.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint1566machine # [ 0.395447] pci 0000:00:03.0: BAR 0 [io 0xc120-0xc13f]1567machine # [ 0.396319] pci 0000:00:03.0: BAR 1 [mem 0xfebd2000-0xfebd2fff]1568machine # [ 0.397167] pci 0000:00:03.0: BAR 4 [mem 0xfe004000-0xfe007fff 64bit pref]1569machine # [ 0.397986] pci 0000:00:04.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint1570machine # [ 0.401447] pci 0000:00:04.0: BAR 0 [io 0xc000-0xc07f]1571machine # [ 0.402350] pci 0000:00:04.0: BAR 1 [mem 0xfebd3000-0xfebd3fff]1572machine # [ 0.403213] pci 0000:00:04.0: BAR 4 [mem 0xfe008000-0xfe00bfff 64bit pref]1573machine # [ 0.404856] pci 0000:00:05.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint1574machine # [ 0.407410] pci 0000:00:05.0: BAR 0 [io 0xc140-0xc15f]1575machine # [ 0.408409] pci 0000:00:05.0: BAR 1 [mem 0xfebd4000-0xfebd4fff]1576machine # [ 0.409430] pci 0000:00:05.0: BAR 4 [mem 0xfe00c000-0xfe00ffff 64bit pref]1577machine # [ 0.410409] pci 0000:00:05.0: ROM [mem 0xfeb80000-0xfebbffff pref]1578machine # [ 0.411981] pci 0000:00:06.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint1579machine # [ 0.413451] pci 0000:00:06.0: BAR 1 [mem 0xfebd5000-0xfebd5fff]1580machine # [ 0.414425] pci 0000:00:06.0: BAR 4 [mem 0xfe010000-0xfe013fff 64bit pref]1581machine # [ 0.415968] pci 0000:00:07.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint1582machine # [ 0.418416] pci 0000:00:07.0: BAR 1 [mem 0xfebd6000-0xfebd6fff]1583machine # [ 0.419426] pci 0000:00:07.0: BAR 4 [mem 0xfe014000-0xfe017fff 64bit pref]1584machine # [ 0.421036] pci 0000:00:08.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint1585machine # [ 0.422450] pci 0000:00:08.0: BAR 1 [mem 0xfebd7000-0xfebd7fff]1586machine # [ 0.423425] pci 0000:00:08.0: BAR 4 [mem 0xfe018000-0xfe01bfff 64bit pref]1587machine # [ 0.424970] pci 0000:00:09.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint1588machine # [ 0.426473] pci 0000:00:09.0: BAR 1 [mem 0xfebd8000-0xfebd8fff]1589machine # [ 0.427425] pci 0000:00:09.0: BAR 4 [mem 0xfe01c000-0xfe01ffff 64bit pref]1590machine # [ 0.428932] pci 0000:00:0a.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint1591machine # [ 0.431419] pci 0000:00:0a.0: BAR 0 [io 0xc080-0xc0bf]1592machine # [ 0.432308] pci 0000:00:0a.0: BAR 1 [mem 0xfebd9000-0xfebd9fff]1593machine # [ 0.433180] pci 0000:00:0a.0: BAR 4 [mem 0xfe020000-0xfe023fff 64bit pref]1594machine # [ 0.434959] pci 0000:00:0b.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint1595machine # [ 0.437272] pci 0000:00:0b.0: BAR 0 [io 0xc160-0xc17f]1596machine # [ 0.438078] pci 0000:00:0b.0: BAR 1 [mem 0xfebda000-0xfebdafff]1597machine # [ 0.438425] pci 0000:00:0b.0: BAR 4 [mem 0xfe024000-0xfe027fff 64bit pref]1598machine # [ 0.439980] pci 0000:00:1d.0: [8086:2934] type 00 class 0x0c0300 conventional PCI endpoint1599machine # [ 0.441963] pci 0000:00:1d.0: BAR 4 [io 0xc180-0xc19f]1600machine # [ 0.442622] pci 0000:00:1d.1: [8086:2935] type 00 class 0x0c0300 conventional PCI endpoint1601machine # [ 0.444266] pci 0000:00:1d.1: BAR 4 [io 0xc1a0-0xc1bf]1602machine # [ 0.445278] pci 0000:00:1d.2: [8086:2936] type 00 class 0x0c0300 conventional PCI endpoint1603machine # [ 0.447134] pci 0000:00:1d.2: BAR 4 [io 0xc1c0-0xc1df]1604machine # [ 0.447623] pci 0000:00:1d.7: [8086:293a] type 00 class 0x0c0320 conventional PCI endpoint1605machine # [ 0.450410] pci 0000:00:1d.7: BAR 0 [mem 0xfebdb000-0xfebdbfff]1606machine # [ 0.451673] pci 0000:00:1f.0: [8086:2918] type 00 class 0x060100 conventional PCI endpoint1607machine # [ 0.452689] pci 0000:00:1f.0: quirk: [io 0x0600-0x067f] claimed by ICH6 ACPI/GPIO/TCO1608machine # [ 0.453671] pci 0000:00:1f.2: [8086:2922] type 00 class 0x010601 conventional PCI endpoint1609machine # [ 0.455438] pci 0000:00:1f.2: BAR 4 [io 0xc1e0-0xc1ff]1610machine # [ 0.456337] pci 0000:00:1f.2: BAR 5 [mem 0xfebdc000-0xfebdcfff]1611machine # [ 0.457488] pci 0000:00:1f.3: [8086:2930] type 00 class 0x0c0500 conventional PCI endpoint1612machine # [ 0.459213] pci 0000:00:1f.3: BAR 4 [io 0x0700-0x073f]1613machine # [ 0.463116] ACPI: PCI: Interrupt link LNKA configured for IRQ 101614machine # [ 0.463510] ACPI: PCI: Interrupt link LNKB configured for IRQ 101615machine # [ 0.464504] ACPI: PCI: Interrupt link LNKC configured for IRQ 111616machine # [ 0.465503] ACPI: PCI: Interrupt link LNKD configured for IRQ 111617machine # [ 0.466504] ACPI: PCI: Interrupt link LNKE configured for IRQ 101618machine # [ 0.467499] ACPI: PCI: Interrupt link LNKF configured for IRQ 101619machine # [ 0.468517] ACPI: PCI: Interrupt link LNKG configured for IRQ 111620machine # [ 0.469501] ACPI: PCI: Interrupt link LNKH configured for IRQ 111621machine # [ 0.470441] ACPI: PCI: Interrupt link GSIA configured for IRQ 161622machine # [ 0.471419] ACPI: PCI: Interrupt link GSIB configured for IRQ 171623machine # [ 0.472416] ACPI: PCI: Interrupt link GSIC configured for IRQ 181624machine # [ 0.473418] ACPI: PCI: Interrupt link GSID configured for IRQ 191625machine # [ 0.474417] ACPI: PCI: Interrupt link GSIE configured for IRQ 201626machine # [ 0.475418] ACPI: PCI: Interrupt link GSIF configured for IRQ 211627machine # [ 0.476419] ACPI: PCI: Interrupt link GSIG configured for IRQ 221628machine # [ 0.477416] ACPI: PCI: Interrupt link GSIH configured for IRQ 231629machine # [ 0.479425] iommu: Default domain type: Translated1630machine # [ 0.480259] iommu: DMA domain TLB invalidation policy: lazy mode1631machine # [ 0.481487] ACPI: bus type USB registered1632machine # [ 0.482269] usbcore: registered new interface driver usbfs1633machine # [ 0.483152] usbcore: registered new interface driver hub1634machine # [ 0.483411] usbcore: registered new device driver usb1635machine # [ 0.485202] NetLabel: Initializing1636machine # [ 0.485903] NetLabel: domain hash size = 1281637machine # [ 0.486403] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO1638machine # [ 0.487448] NetLabel: unlabeled traffic allowed by default1639machine # [ 0.488416] PCI: Using ACPI for IRQ routing1640machine # [ 0.532533] pci 0000:00:01.0: vgaarb: setting as boot VGA device1641machine # [ 0.533399] pci 0000:00:01.0: vgaarb: bridge control possible1642machine # [ 0.533399] pci 0000:00:01.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none1643machine # [ 0.533407] vgaarb: loaded1644machine # [ 0.534163] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 01645machine # [ 0.534403] hpet0: 3 comparators, 64-bit 100.000000 MHz counter1646machine # [ 0.539486] clocksource: Switched to clocksource kvm-clock1647machine # [ 0.543068] VFS: Disk quotas dquot_6.6.01648machine # [ 0.543785] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)1649machine # [ 0.545191] pnp: PnP ACPI init1650machine # [ 0.546002] ACPI: IRQ 4 override to edge(!), high(!)1651machine # [ 0.546967] system 00:04: [mem 0xb0000000-0xbfffffff window] has been reserved1652machine # [ 0.548518] pnp: PnP ACPI: found 5 devices1653machine # [ 0.556070] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns1654machine # [ 0.557554] clocksource: Switched to clocksource acpi_pm1655machine # [ 0.558554] NET: Registered PF_INET protocol family1656machine # [ 0.559585] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear)1657machine # [ 0.576712] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear)1658machine # [ 0.578293] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)1659machine # [ 0.579631] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear)1660machine # [ 0.580982] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear)1661machine # [ 0.582253] TCP: Hash tables configured (established 8192 bind 8192)1662machine # [ 0.583378] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear)1663machine # [ 0.584670] UDP hash table entries: 512 (order: 3, 32768 bytes, linear)1664machine # [ 0.585841] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear)1665machine # [ 0.587056] NET: Registered PF_UNIX/PF_LOCAL protocol family1666machine # [ 0.588043] NET: Registered PF_XDP protocol family1667machine # [ 0.588909] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window]1668machine # [ 0.589948] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window]1669machine # [ 0.590998] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window]1670machine # [ 0.592120] pci_bus 0000:00: resource 7 [mem 0x40000000-0xafffffff window]1671machine # [ 0.593258] pci_bus 0000:00: resource 8 [mem 0xc0000000-0xfebfffff window]1672machine # [ 0.594395] pci_bus 0000:00: resource 9 [mem 0x100000000-0x8ffffffff window]1673machine # [ 0.596254] ACPI: \_SB_.GSIA: Enabled at IRQ 161674machine # [ 0.598953] ACPI: \_SB_.GSIB: Enabled at IRQ 171675machine # [ 0.600864] ACPI: \_SB_.GSIC: Enabled at IRQ 181676machine # [ 0.602774] ACPI: \_SB_.GSID: Enabled at IRQ 191677machine # [ 0.604722] PCI: CLS 0 bytes, default 641678machine # [ 0.605607] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x229842dd0bd, max_idle_ns: 440795319571 ns1679machine # [ 0.607404] Trying to unpack rootfs image as initramfs...1680machine # [ 0.652157] Initialise system trusted keyrings1681machine # [ 0.655989] workingset: timestamp_bits=40 max_order=18 bucket_order=01682machine # [ 0.676900] Key type asymmetric registered1683machine # [ 0.677650] Asymmetric key parser 'x509' registered1684machine # [ 0.679879] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 248)1685machine # [ 0.683881] io scheduler mq-deadline registered1686machine # [ 0.684663] io scheduler kyber registered1687machine # [ 0.687561] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled1688machine # [ 0.690946] 00:03: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A1689machine # [ 0.693147] Linux agpgart interface v0.1031690machine # [ 0.693953] ACPI: bus type drm_connector registered1691machine # [ 0.697341] usbcore: registered new interface driver usbserial_generic1692machine # [ 0.698465] usbserial: USB Serial support registered for generic1693machine # [ 0.701836] amd_pstate: The CPPC feature is supported but currently disabled by the BIOS.1694machine # [ 0.701836] Please enable it if your BIOS has the CPPC option.1695machine # [ 0.704291] amd_pstate: the _CPC object is not present in SBIOS or ACPI disabled1696machine # [ 0.708149] drop_monitor: Initializing network drop monitor service1697machine # [ 0.709452] NET: Registered PF_INET6 protocol family1698machine # [ 0.714433] Segment Routing with IPv61699machine # [ 0.716859] In-situ OAM (IOAM) with IPv61700machine # [ 0.718031] IPI shorthand broadcast: enabled1701machine # [ 0.726676] sched_clock: Marking stable (584015310, 141811456)->(803018275, -77191509)1702machine # [ 0.732164] registered taskstats version 11703machine # [ 0.733206] Loading compiled-in X.509 certificates1704machine # [ 0.753075] Demotion targets for Node 0: null1705machine # [ 0.755880] Key type .fscrypt registered1706machine # [ 0.756605] Key type fscrypt-provisioning registered1707machine # [ 0.757578] ima: No TPM chip found, activating TPM-bypass!1708machine # [ 0.761842] ima: Allocated hash algorithm: sha11709machine # [ 0.762697] ima: No architecture policies found1710machine # [ 0.763671] PM: Magic number: 14:827:8651711machine # [ 0.764470] memory_tiering: hash matches1712machine # [ 0.767847] RAS: Correctable Errors collector initialized.1713machine # [ 0.776595] clk: Disabling unused clocks1714machine # [ 0.779854] PM: genpd: Disabling unused power domains1715machine # [ 0.993304] Freeing initrd memory: 29080K1716machine # [ 0.996901] Freeing unused decrypted memory: 2028K1717machine # [ 1.000118] Freeing unused kernel image (initmem) memory: 3656K1718machine # [ 1.001393] Write protecting the kernel read-only data: 32768k1719machine # [ 1.002966] Freeing unused kernel image (text/rodata gap) memory: 308K1720machine # [ 1.004768] Freeing unused kernel image (rodata/data gap) memory: 696K1721machine # [ 1.058289] x86/mm: Checked W+X mappings: passed, no W+X pages found.1722machine # [ 1.059528] Run /init as init process1723machine # [ 1.071431] systemd[1]: Inserted module 'autofs4'1724machine # [ 1.091599] fuse: init (API version 7.45)1725machine # [ 1.099215] ACPI: \_SB_.GSIG: Enabled at IRQ 221726machine # [ 1.101783] ACPI: \_SB_.GSIH: Enabled at IRQ 231727machine # [ 1.105220] ACPI: \_SB_.GSIE: Enabled at IRQ 201728machine # [ 1.107303] ACPI: \_SB_.GSIF: Enabled at IRQ 211729machine # [ 1.112746] virtiofs virtio5: discovered new tag: nix-store1730machine # [ 1.114312] virtiofs virtio5: virtio_fs_setup_dax: No cache capability1731machine # [ 1.121338] virtiofs virtio6: discovered new tag: shared1732machine # [ 1.123055] virtiofs virtio6: virtio_fs_setup_dax: No cache capability1733machine # [ 1.126155] virtiofs virtio7: discovered new tag: xchg1734machine # [ 1.127611] virtiofs virtio7: virtio_fs_setup_dax: No cache capability1735machine # [ 1.148700] systemd[1]: Successfully made /usr/ read-only.1736machine # [ 1.150429] systemd[1]: systemd 263-b43fed8 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE)1737machine # [ 1.155428] systemd[1]: Detected virtualization kvm.1738machine # [ 1.156350] systemd[1]: Detected architecture x86-64.1739machine # [ 1.157226] systemd[1]: Running in initrd.1740machine # [ 1.158214] systemd[1]: Initializing machine ID from random generator.1741machine # [ 1.159369] systemd[1]: Hostname set to <machine>.1742machine # [ 1.231068] systemd[1]: bpf-restrict-fs: LSM BPF program attached1743machine # [ 1.268786] systemd[1]: Queued start job for default target Initrd Default Target.1744machine # [ 1.273191] systemd[1]: Created slice Slice /system/modprobe.1745machine # [ 1.274404] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.1746machine # [ 1.275875] systemd[1]: Expecting device /dev/disk/by-label/nixos...1747machine # [ 1.277044] systemd[1]: Expecting device /dev/hvc0...1748machine # [ 1.277972] systemd[1]: Expecting device /dev/ttyS0...1749machine # [ 1.278939] systemd[1]: Reached target Path Units.1750machine # [ 1.279853] systemd[1]: Reached target Slice Units.1751machine # [ 1.280755] systemd[1]: Reached target Swaps.1752machine # [ 1.281569] systemd[1]: Reached target Timer Units.1753machine # [ 1.282588] systemd[1]: Listening on D-Bus System Message Bus Socket.1754machine # [ 1.283910] systemd[1]: Listening on Journal Socket (/dev/log).1755machine # [ 1.285099] systemd[1]: Listening on Journal Sockets.1756machine # [ 1.286113] systemd[1]: Listening on udev Kernel Socket.1757machine # [ 1.287091] systemd[1]: Reached target Socket Units.1758machine # [ 1.288992] systemd[1]: Starting Create List of Static Device Nodes...1759machine # [ 1.308453] systemd[1]: Starting Load Kernel Module configfs...1760machine # [ 1.320452] systemd[1]: Starting Journal Service...1761machine # [ 1.328913] systemd[1]: Starting Load Kernel Modules...1762machine # [ 1.331909] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1763machine # [ 1.337596] systemd[1]: Starting Coldplug All udev Devices...1764machine # [ 1.350935] systemd[1]: Finished Create List of Static Device Nodes.1765machine # [ 1.357519] systemd[1]: modprobe@configfs.service: Deactivated successfully.1766machine # [ 1.366269] systemd[1]: Finished Load Kernel Module configfs.1767machine # [ 1.371326] systemd[1]: Kernel Configuration File System skipped, unmet condition check ConditionPathExists=/sys/kernel/config1768machine # [ 1.374721] systemd-journald[65]: Collecting audit messages is disabled.1769machine # [ 1.383369] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...1770machine # [ 1.392667] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.1771machine # [ 1.404198] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev1772machine # [ 1.427962] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.1773machine # [ 1.434912] systemd[1]: Starting Create Static Device Nodes in /dev...1774machine # [ 1.447910] systemd[1]: Finished Load Kernel Modules.1775machine # [ 1.456437] systemd[1]: Starting Apply Kernel Variables...1776machine # [ 1.478431] systemd[1]: Finished Create Static Device Nodes in /dev.1777machine # [ 1.483054] systemd[1]: Reached target Preparation for Local File Systems.1778machine # [ 1.488912] systemd[1]: Reached target Local File Systems.1779machine # [ 1.497037] systemd[1]: Starting Rule-based Manager for Device Events and Files...1780machine # [ 1.358075] systemd-modules-load[66]: Inserted module 'dm_mod'1781machine # [ 1.359425] systemd-modules-load[66]: Inserted module 'virtio_balloon'1782machine # [ 1.360490] systemd-modules-load[66]: Inserted module 'virtio_gpu'1783machine # [ 1.508144] systemd[1]: Started Journal Service.1784machine # [ 1.373344] systemd[1]: Finished Apply Kernel Variables.1785machine # [ 1.389089] systemd[1]: Starting Create System Files and Directories...1786machine # [ 1.414240] systemd[1]: Finished Create System Files and Directories.1787machine # [ 1.421339] systemd-udevd[72]: Using default interface naming scheme 'v261'.1788machine # [ 1.445121] systemd[1]: Started Rule-based Manager for Device Events and Files.1789machine # [ 1.502766] systemd[1]: Finished Coldplug All udev Devices.1790machine # [ 1.503709] systemd[1]: Reached target System Initialization.1791machine # [ 1.504730] systemd[1]: Reached target Basic System.1792machine # [ 1.549170] systemd[1]: Found device /dev/hvc0.1793machine # [ 1.563069] systemd[1]: Found device /dev/ttyS0.1794machine # [ 1.565446] systemd[1]: Started backdoor.service.1795machine # [ 1.587447] backdoor-start[96]: /nix/store/wih4sdpik4mw459vdf955q7qq1j10agf-unit-script-backdoor-start/bin/backdoor-start: line 10: grep: command not found1796machine # connecting to host...1797machine: Guest shell says: b'Spawning backdoor root shell...\n'1798machine: connected to guest root shell1799machine: (connecting took 2.29 seconds)1800machine: (finished: waiting for the VM to finish booting, in 2.29 seconds)1801machine # [ 1.863494] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,121802machine # [ 1.868407] virtio_blk virtio2: 1/0/0 default/read/poll queues1803machine # [ 1.875521] serio: i8042 KBD port at 0x60,0x64 irq 11804machine # [ 1.877844] virtio_blk virtio2: [vda] 4194304 512-byte logical blocks (2.15 GB/2.00 GiB)1805machine # [ 1.885845] serio: i8042 AUX port at 0x60,0x64 irq 121806machine # [ 1.907190] ehci-pci 0000:00:1d.7: EHCI Host Controller1807machine # [ 1.907987] ehci-pci 0000:00:1d.7: new USB bus registered, assigned bus number 11808machine # [ 1.909765] ehci-pci 0000:00:1d.7: irq 19, io mem 0xfebdb0001809machine # [ 1.916862] ehci-pci 0000:00:1d.7: USB 2.0 started, EHCI 1.001810machine # [ 1.918092] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 6.181811machine # [ 1.920449] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=11812machine # [ 1.923831] usb usb1: Product: EHCI Host Controller1813machine # [ 1.924485] usb usb1: Manufacturer: Linux 6.18.54 ehci_hcd1814machine # [ 1.925721] usb usb1: SerialNumber: 0000:00:1d.71815machine # [ 1.926930] hub 1-0:1.0: USB hub found1816machine # [ 1.928323] hub 1-0:1.0: 6 ports detected1817machine # [ 1.935884] uhci_hcd 0000:00:1d.0: UHCI Host Controller1818machine # [ 1.936631] uhci_hcd 0000:00:1d.0: new USB bus registered, assigned bus number 21819machine # [ 1.944660] uhci_hcd 0000:00:1d.0: detected 2 ports1820machine # [ 1.945447] uhci_hcd 0000:00:1d.0: irq 16, io port 0x0000c1801821machine # [ 1.958552] usb usb2: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.181822machine # [ 1.968358] usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=11823machine # [ 1.838250] systemd[1]: Starting Virtual Console Setup...1824machine # [ 1.981409] usb usb2: Product: UHCI Host Controller1825machine # [ 1.986601] SCSI subsystem initialized1826machine # [ 1.994188] usb usb2: Manufacturer: Linux 6.18.54 uhci_hcd1827machine # [ 1.855888] (udev-worker)[82]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.1828machine # [ 1.862547] (udev-worker)[82]: Network interface NamePolicy= disabled on kernel command line.1829machine # [ 2.011060] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input01830machine # [ 1.876294] systemd-vconsole-setup[110]: Configuration of first virtual console was skipped, ignoring remaining ones.1831machine # [ 1.880071] systemd[1]: Finished Virtual Console Setup.1832machine # [ 2.022879] usb usb2: SerialNumber: 0000:00:1d.01833machine # [ 2.028037] hub 2-0:1.0: USB hub found1834machine # [ 2.030286] hub 2-0:1.0: 2 ports detected1835machine # [ 2.042741] uhci_hcd 0000:00:1d.1: UHCI Host Controller1836machine # [ 2.054961] uhci_hcd 0000:00:1d.1: new USB bus registered, assigned bus number 31837machine # [ 1.915354] systemd[1]: Found device /dev/disk/by-label/nixos.1838machine # [ 1.917500] systemd[1]: Reached target Initrd Root Device.1839machine # [ 1.921074] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos...1840machine # [ 2.064860] uhci_hcd 0000:00:1d.1: detected 2 ports1841machine # [ 2.065645] uhci_hcd 0000:00:1d.1: irq 17, io port 0x0000c1a01842machine # [ 2.069985] usb usb3: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.181843machine # [ 2.071285] usb usb3: New USB device strings: Mfr=3, Product=2, SerialNumber=11844machine # [ 2.078845] usb usb3: Product: UHCI Host Controller1845machine # [ 2.079544] usb usb3: Manufacturer: Linux 6.18.54 uhci_hcd1846machine # [ 2.085300] usb usb3: SerialNumber: 0000:00:1d.11847machine # [ 2.086439] hub 3-0:1.0: USB hub found1848machine # [ 2.088895] hub 3-0:1.0: 2 ports detected1849machine # [ 2.093908] uhci_hcd 0000:00:1d.2: UHCI Host Controller1850machine # [ 2.094684] uhci_hcd 0000:00:1d.2: new USB bus registered, assigned bus number 41851machine # [ 2.099077] uhci_hcd 0000:00:1d.2: detected 2 ports1852machine # [ 2.102990] uhci_hcd 0000:00:1d.2: irq 18, io port 0x0000c1c01853machine # [ 1.964618] systemd-fsck[117]: nixos: clean, 226/65536 files, 15459/262144 blocks1854machine # [ 2.107537] usb usb4: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.181855machine # [ 2.108751] usb usb4: New USB device strings: Mfr=3, Product=2, SerialNumber=11856machine # [ 1.971051] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos.1857machine # [ 2.120838] usb usb4: Product: UHCI Host Controller1858machine # [ 2.121654] usb usb4: Manufacturer: Linux 6.18.54 uhci_hcd1859machine # [ 2.122698] usb usb4: SerialNumber: 0000:00:1d.21860machine # [ 2.124026] hub 4-0:1.0: USB hub found1861machine # [ 2.126761] hub 4-0:1.0: 2 ports detected1862machine # [ 2.144748] ahci 0000:00:1f.2: AHCI vers 0001.0000, 32 command slots, 1.5 Gbps, SATA mode1863machine # [ 2.156529] ahci 0000:00:1f.2: 6/6 ports implemented (port mask 0x3f)1864machine # [ 2.157979] ahci 0000:00:1f.2: flags: 64bit ncq only1865machine # [ 2.165847] usb 1-1: new high-speed USB device number 2 using ehci-pci1866machine # [ 2.167733] scsi host0: ahci1867machine # [ 2.169912] scsi host1: ahci1868machine # [ 2.172926] scsi host2: ahci1869machine # [ 2.174763] scsi host3: ahci1870machine # [ 2.176389] scsi host4: ahci1871machine # [ 2.177741] scsi host5: ahci1872machine # [ 2.178929] ata1: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc100 irq 47 lpm-pol 11873machine # [ 2.180636] ata2: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc180 irq 47 lpm-pol 11874machine # [ 2.181866] ata3: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc200 irq 47 lpm-pol 11875machine # [ 2.183031] ata4: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc280 irq 47 lpm-pol 11876machine # [ 2.184237] ata5: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc300 irq 47 lpm-pol 11877machine # [ 2.185404] ata6: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc380 irq 47 lpm-pol 11878machine # [ 2.295162] usb 1-1: New USB device found, idVendor=0627, idProduct=0001, bcdDevice= 0.001879machine # [ 2.298153] usb 1-1: New USB device strings: Mfr=1, Product=3, SerialNumber=101880machine # [ 2.301411] usb 1-1: Product: QEMU USB Tablet1881machine # [ 2.303227] usb 1-1: Manufacturer: QEMU1882machine # [ 2.304871] usb 1-1: SerialNumber: 28754-0000:00:1d.7-11883machine # [ 2.335572] hid: raw HID events driver (C) Jiri Kosina1884machine # [ 2.207279] systemd[1]: Mounting /sysroot...1885machine # [ 2.492793] ata2: SATA link down (SStatus 0 SControl 300)1886machine # [ 2.495223] ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 300)1887machine # [ 2.498042] ata3.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/1001888machine # [ 2.499985] ata3.00: applying bridge limits1889machine # [ 2.501991] ata1: SATA link down (SStatus 0 SControl 300)1890machine # [ 2.504308] ata4: SATA link down (SStatus 0 SControl 300)1891machine # [ 2.506536] ata5: SATA link down (SStatus 0 SControl 300)1892machine # [ 2.508924] ata6: SATA link down (SStatus 0 SControl 300)1893machine # [ 2.511182] ata3.00: configured for UDMA/1001894machine # [ 2.513736] scsi 2:0:0:0: CD-ROM QEMU QEMU DVD-ROM 2.5+ PQ: 0 ANSI: 51895machine # [ 2.594086] usbcore: registered new interface driver usbhid1896machine # [ 2.597182] usbhid: USB HID core driver1897machine # [ 2.607058] input: QEMU QEMU USB Tablet as /devices/pci0000:00/0000:00:1d.7/usb1/1-1/1-1:1.0/0003:0627:0001.0001/input/input21898machine # [ 2.611089] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:1d.7-1/input01899machine # [ 2.621631] sr 2:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray1900machine # [ 2.640946] cdrom: Uniform CD-ROM driver Revision: 3.201901machine # [ 2.657929] EXT4-fs (vda): mounted filesystem 60cfc836-912d-4264-9e87-2fee5a628c76 r/w with ordered data mode. Quota mode: none.1902machine # [ 2.520627] systemd[1]: Mounted /sysroot.1903machine # [ 2.522632] systemd[1]: Reached target Initrd Root File System.1904machine # [ 2.527078] systemd[1]: Mounting /sysroot/nix/.ro-store...1905machine # [ 2.528483] systemd[1]: Mounting /sysroot/nix/.rw-store...1906machine # [ 2.532140] systemd[1]: Mounting /sysroot/run...1907machine # [ 2.541082] systemd[1]: Mounting /sysroot/tmp/shared...1908machine # [ 2.551258] systemd[1]: Mounting /sysroot/tmp/xchg...1909machine # [ 2.564218] systemd[1]: Starting Mountpoints Configured in the Real Root...1910machine # [ 2.597171] systemd-sysroot-fstab-check[157]: /sysroot should be mounted in the initrd, will request daemon-reload.1911machine # [ 2.602068] systemd[1]: Mounted /sysroot/nix/.ro-store.1912machine # [ 2.602785] systemd[1]: Mounted /sysroot/nix/.rw-store.1913machine # [ 2.603516] systemd[1]: Mounted /sysroot/run.1914machine # [ 2.606692] systemd[1]: Mounted /sysroot/tmp/shared.1915machine # [ 2.608115] systemd[1]: Mounted /sysroot/tmp/xchg.1916machine # [ 2.615063] systemd[1]: Reload requested from client PID 157 ('systemd-sysroot') (unit initrd-parse-etc.service)...1917machine # [ 2.616489] systemd[1]: Reloading...1918machine # [ 2.681106] systemd[1]: Reloading finished in 66 ms.1919machine # [ 2.690039] systemd-sysroot-fstab-check[157]: Requesting initrd-fs.target/start/replace...1920machine # [ 2.693591] systemd-sysroot-fstab-check[157]: Requesting swap.target/start/replace...1921machine # [ 2.697405] systemd[1]: initrd-parse-etc.service: Deactivated successfully.1922machine # [ 2.700201] systemd[1]: Finished Mountpoints Configured in the Real Root.1923machine # [ 2.701205] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies.1924machine # [ 2.709085] systemd[1]: Starting rw-sysroot-nix-store.service...1925machine # [ 2.723505] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1926machine # [ 2.724927] systemd[1]: Finished rw-sysroot-nix-store.service.1927machine # [ 3.209791] systemd[1]: Mounting /sysroot/nix/store...1928machine # [ 3.257652] systemd[1]: Mounted /sysroot/nix/store.1929machine # [ 3.259258] systemd[1]: Reached target Initrd File Systems.1930machine # [ 3.261069] systemd[1]: Starting Find NixOS closure...1931machine # [ 3.263358] systemd[1]: Starting Create Volatile Files and Directories in the Real Root...1932machine # [ 3.283130] systemd[1]: Finished Create Volatile Files and Directories in the Real Root.1933machine # [ 3.285322] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully.1934machine # [ 3.293450] systemd[1]: Finished Find NixOS closure.1935machine # [ 3.294597] systemd[1]: Reached target Initrd Default Target.1936machine # [ 3.296366] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...1937machine # [ 3.306755] systemd[1]: initrd-cleanup.service: Deactivated successfully.1938machine # [ 3.307772] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.1939machine # [ 3.308747] systemd[1]: Startup finished in 921ms (kernel) + 0 (initrd) + 2.387s (userspace) = 3.308s.1940machine: (finished: waiting for unit initrd.target, in 4.44 seconds)1941machine: waiting for the VM to finish booting1942machine # [ 3.780648] systemd[1]: Stopped target Initrd Default Target.1943machine: Guest shell says: b'\n'1944machine # [ 3.782962] systemd[1]: Stopped target Basic System.1945machine # [ 3.786570] systemd[1]: Stopped target Initrd Root Device.1946machine # [ 3.788428] systemd[1]: Stopped target Path Units.1947machine # [ 3.790835] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.1948machine # [ 3.794307] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.1949machine # [ 3.796773] systemd[1]: Stopped target Slice Units.1950machine # [ 3.798447] systemd[1]: Stopped target Socket Units.1951machine # [ 3.800799] systemd[1]: Stopped target System Initialization.1952machine # [ 3.802931] systemd[1]: Stopped target Swaps.1953machine # [ 3.805237] systemd[1]: Stopped target Timer Units.1954machine # [ 3.806109] systemd[1]: dbus.socket: Deactivated successfully.1955machine # [ 3.807075] systemd[1]: Closed D-Bus System Message Bus Socket.1956machine # [ 3.808033] systemd[1]: Stopping backdoor.service...1957machine # [ 3.808821] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...1958machine # [ 3.810117] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully.1959machine # [ 3.812134] systemd[1]: Stopped Find NixOS closure.1960machine # [ 3.813342] systemd[1]: Starting rw-sysroot-nix-store.service...1961machine # [ 3.814400] systemd[1]: systemd-sysctl.service: Deactivated successfully.1962machine # [ 3.815532] systemd[1]: Stopped Apply Kernel Variables.1963machine # [ 3.816521] systemd[1]: systemd-modules-load.service: Deactivated successfully.1964machine # [ 3.818219] systemd[1]: Stopped Load Kernel Modules.1965machine # [ 3.819199] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully.1966machine # [ 3.820509] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root.1967machine # [ 3.822126] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.1968machine # [ 3.823283] systemd[1]: Stopped Create System Files and Directories.1969machine # [ 3.825110] systemd[1]: Stopped target Local File Systems.1970machine # [ 3.827507] systemd[1]: Stopped target Preparation for Local File Systems.1971machine # [ 3.828608] systemd[1]: systemd-udev-trigger.service: Deactivated successfully.1972machine # [ 3.829718] systemd[1]: Stopped Coldplug All udev Devices.1973machine # [ 3.830599] systemd[1]: Stopping Rule-based Manager for Device Events and Files...1974machine # [ 3.831740] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1975machine # [ 3.836942] systemd[1]: Stopped Virtual Console Setup.1976machine # [ 3.837824] systemd[1]: backdoor.service: Deactivated successfully.1977machine # [ 3.844373] systemd[1]: Stopped backdoor.service.1978machine # [ 3.847124] systemd[1]: systemd-udevd.service: Deactivated successfully.1979machine # [ 3.851090] systemd[1]: Stopped Rule-based Manager for Device Events and Files.1980machine # [ 3.857097] systemd[1]: Starting Cleanup udev Database...1981machine # [ 3.858090] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.1982machine # [ 3.860121] systemd[1]: Stopped Create Static Device Nodes in /dev.1983machine # [ 3.861143] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.1984machine # [ 3.864123] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.1985machine # [ 3.865286] systemd[1]: kmod-static-nodes.service: Deactivated successfully.1986machine # [ 3.868218] systemd[1]: Stopped Create List of Static Device Nodes.1987machine # [ 3.869249] systemd[1]: initrd-cleanup.service: Deactivated successfully.1988machine # [ 3.871147] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.1989machine # [ 3.872651] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1990machine # [ 3.874973] systemd[1]: Finished rw-sysroot-nix-store.service.1991machine # [ 3.888773] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.1992machine # [ 3.890572] systemd[1]: Finished Cleanup udev Database.1993machine # [ 3.892151] systemd[1]: Reached target Switch Root.1994machine # [ 3.893563] systemd[1]: Starting NixOS Activation...1995machine # [ 3.973235] initrd-nixos-activation-start[223]: booting system configuration /nix/store/lh9zs34p9c1bvyavdq1mlk6pgr61pf8m-nixos-system-machine-test1996machine # [ 4.003676] initrd-nixos-activation-start[223]: running activation script...1997machine # [ 4.214451] initrd-nixos-activation-start[246]: setting up /etc...1998machine # [ 4.373117] systemd[1]: initrd-nixos-activation.service: Deactivated successfully.1999machine # [ 4.374788] systemd[1]: Finished NixOS Activation.2000machine # [ 4.376741] systemd[1]: Starting Switch Root...2001machine # [ 4.389453] systemd[1]: Switching root.2002machine # [ 4.660180] systemd-journald[65]: Received SIGTERM from PID 1 (systemd).2003machine # [ 4.745729] NET: Registered PF_VSOCK protocol family2004machine # [ 4.771745] systemd[1]: systemd 263-b43fed8 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE)2005machine # [ 4.775629] systemd[1]: Detected virtualization kvm.2006machine # [ 4.776331] systemd[1]: Detected architecture x86-64.2007machine # [ 4.858715] systemd[1]: bpf-restrict-fs: LSM BPF program attached2008machine # [ 5.427360] systemd[1]: initrd-switch-root.service: Deactivated successfully.2009machine # [ 5.428777] systemd[1]: Stopped initrd-switch-root.service.2010machine # [ 5.431237] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.2011machine # [ 5.433281] systemd[1]: Created slice Slice /system/getty.2012machine # [ 5.434650] systemd[1]: Created slice User and Session Slice.2013machine # [ 5.435532] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.2014machine # [ 5.436789] systemd[1]: Started Forward Password Requests to Wall Directory Watch.2015machine # [ 5.437921] systemd[1]: Expecting device /dev/hvc0...2016machine # [ 5.438647] systemd[1]: Expecting device /dev/ttyS0...2017machine # [ 5.439388] systemd[1]: Reached target Local Encrypted Volumes.2018machine # [ 5.440258] systemd[1]: Stopped target initrd-fs.target.2019machine # [ 5.441055] systemd[1]: Stopped target initrd-root-fs.target.2020machine # [ 5.441907] systemd[1]: Stopped target initrd-switch-root.target.2021machine # [ 5.442761] systemd[1]: Reached target Virtual Machines and Containers.2022machine # [ 5.443689] systemd[1]: Reached target Path Units.2023machine # [ 5.444382] systemd[1]: Reached target Remote File Systems.2024machine # [ 5.445209] systemd[1]: Reached target Slice Units.2025machine # [ 5.445975] systemd[1]: Reached target Swaps.2026machine # [ 5.447583] systemd[1]: Listening on Query the User Interactively for a Password.2027machine # [ 5.461704] systemd[1]: Listening on Process Core Dump Socket.2028machine # [ 5.463317] systemd[1]: Listening on Credential Encryption/Decryption.2029machine # [ 5.465040] systemd[1]: Listening on Factory Reset Management.2030machine # [ 5.465982] systemd[1]: Listening on Hostname Service Socket.2031machine # [ 5.468648] systemd[1]: Starting Journal Log Access Socket...2032machine # [ 5.470141] systemd[1]: Listening on Journal Audit Socket.2033machine # [ 5.472619] systemd[1]: Listening on Console Output Muting Service Socket.2034machine # [ 5.473697] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.2035machine # [ 5.474868] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2036machine # [ 5.476151] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2037machine # [ 5.480011] systemd[1]: Listening on Disk Repartitioning Service Socket.2038machine # [ 5.481076] systemd[1]: Listening on udev Varlink Socket.2039machine # [ 5.483567] systemd[1]: Mounting Huge Pages File System...2040machine # [ 5.487171] systemd[1]: Mounting POSIX Message Queue File System...2041machine # [ 5.493071] systemd[1]: Mounting Kernel Debug File System...2042machine # [ 5.499873] systemd[1]: Mounting Kernel Trace File System...2043machine # [ 5.507374] systemd[1]: Starting Create List of Static Device Nodes...2044machine # [ 5.517956] systemd[1]: Starting Load Kernel Module configfs...2045machine # [ 5.523445] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm2046machine # [ 5.533308] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2047machine # [ 5.542922] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse2048machine # [ 5.562516] systemd[1]: Mounting FUSE Control File System...2049machine # [ 5.568747] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672050machine # [ 5.582916] systemd[1]: Starting Journal Service...2051machine # [ 5.585960] systemd[1]: Starting Load Kernel Modules...2052machine # [ 5.598051] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...2053machine # [ 5.609027] systemd[1]: Starting Remount Root and Kernel File Systems...2054machine # [ 5.612313] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2055machine # [ 5.622923] systemd[1]: Starting Coldplug All udev Devices...2056machine # [ 5.635736] systemd[1]: Listening on Journal Log Access Socket.2057machine # [ 5.639115] systemd[1]: Mounted Huge Pages File System.2058machine # [ 5.646181] systemd[1]: Mounted POSIX Message Queue File System.2059machine # [ 5.653178] systemd[1]: Mounted Kernel Debug File System.2060machine # [ 5.658945] systemd[1]: Mounted Kernel Trace File System.2061machine # [ 5.664968] systemd[1]: Finished Create List of Static Device Nodes.2062machine # [ 5.666451] systemd-journald[317]: Collecting audit messages is enabled.2063machine # [ 5.669233] loop: module loaded2064machine # [ 5.674163] systemd[1]: modprobe@configfs.service: Deactivated successfully.2065machine # [ 5.679050] systemd[1]: Finished Load Kernel Module configfs.2066machine # [ 5.685900] systemd[1]: Finished Load Kernel Modules.2067machine # [ 5.547478] systemd[1]: Queued start job for default target Multi-User System.2068machine # [ 5.692345] systemd[1]: Mounted FUSE Control File System.2069machine # [ 5.552417] systemd[1]: systemd-journald.service: Deactivated successfully.2070machine # [ 5.697647] systemd[1]: Started Journal Service.2071machine # [ 5.553994] systemd-modules-load[318]: Inserted module 'loop'2072machine # [ 5.706836] EXT4-fs (vda): re-mounted 60cfc836-912d-4264-9e87-2fee5a628c76.2073machine # [ 5.580088] systemd[1]: Mounting Kernel Configuration File System...2074machine # [ 5.582271] systemd[1]: Starting Firewall...2075machine # [ 5.587064] systemd[1]: Starting Apply Kernel Variables...2076machine # [ 5.590069] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...2077machine # [ 5.597883] systemd[1]: Finished Remount Root and Kernel File Systems.2078machine # [ 5.598791] systemd[1]: Listening on Disk Image Download Service Socket.2079machine # [ 5.599885] systemd-oomd[319]: No swap; memory pressure usage will be degraded2080machine # [ 5.622980] systemd[1]: Starting Grow Root File System...2081machine # [ 5.634161] systemd[1]: Starting Flush Journal to Persistent Storage...2082machine # [ 5.635165] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2083machine # [ 5.662383] systemd[1]: Starting Load/Save OS Random Seed...2084machine # [ 5.664150] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2085machine # [ 5.675325] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.2086machine # [ 5.874982] systemd-journald[317]: Received client request to flush runtime journal.2087machine # [ 5.878230] EXT4-fs (vda): resizing filesystem from 262144 to 524288 blocks2088machine # [ 5.919380] EXT4-fs (vda): resized filesystem to 5242882089machine # [ 5.868728] systemd[1]: Mounted Kernel Configuration File System.2090machine # [ 5.871706] systemd[1]: Finished Apply Kernel Variables.2091machine # [ 5.873889] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.2092machine # [ 5.876837] systemd[1]: Starting Create Static Device Nodes in /dev...2093machine # [ 5.877804] systemd-growfs[337]: Successfully resized "/" to 2G bytes.2094machine # [ 5.878686] systemd[1]: Finished Grow Root File System.2095machine # [ 5.879495] systemd[1]: Finished Load/Save OS Random Seed.2096machine # [ 5.880361] systemd[1]: First Boot Complete skipped, unmet condition check ConditionFirstBoot=yes2097machine # [ 5.881631] systemd[1]: Finished Flush Journal to Persistent Storage.2098machine # [ 5.939975] systemd[1]: Finished Create Static Device Nodes in /dev.2099machine # [ 5.942238] systemd[1]: Reached target Preparation for Local File Systems.2100machine # [ 5.947333] systemd[1]: Starting Rule-based Manager for Device Events and Files...2101machine # [ 5.963713] systemd[1]: Finished Coldplug All udev Devices.2102machine # [ 5.999399] systemd-udevd[358]: Using default interface naming scheme 'v261'.2103machine # [ 6.040331] systemd[1]: Started Rule-based Manager for Device Events and Files.2104machine # [ 6.156594] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse2105machine # [ 6.237979] systemd[1]: Found device /dev/hvc0.2106machine # [ 6.263436] systemd[1]: Found device /dev/ttyS0.2107machine # [ 6.290152] systemd[1]: Mounting /run/wrappers...2108machine # [ 6.302127] (udev-worker)[380]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.2109machine # [ 6.305457] (udev-worker)[380]: Network interface NamePolicy= disabled on kernel command line.2110machine # [ 6.336088] systemd[1]: Mounted /run/wrappers.2111machine # [ 6.337777] systemd[1]: Reached target Local File Systems.2112machine # [ 6.341120] systemd[1]: Listening on Boot Loader Control Service Socket.2113machine # [ 6.345330] systemd[1]: Starting Create SUID/SGID Wrappers...2114machine # [ 6.346203] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2115machine # [ 6.347988] systemd[1]: Save Transient machine-id to Disk skipped, unmet condition check ConditionPathIsMountPoint=/etc/machine-id2116machine # [ 6.352637] systemd[1]: Starting Create System Files and Directories...2117machine # [ 6.459817] systemd[1]: Finished Create System Files and Directories.2118machine # [ 6.464578] systemd[1]: Rebuild Journal Catalog skipped, unmet condition check ConditionNeedsUpdate=/var2119machine # [ 6.468346] systemd[1]: Update is Completed skipped, no trigger condition checks were met.2120machine # [ 6.475866] systemd[1]: Starting Record System Boot/Shutdown in UTMP...2121machine # [ 6.520574] systemd[1]: Condition check resulted in Virtio network device being skipped.2122machine # [ 6.524142] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2123machine # [ 6.525658] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2124machine # [ 6.528046] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672125machine # [ 6.530244] systemd[1]: Rebuild Journal Catalog skipped, unmet condition check ConditionNeedsUpdate=/var2126machine # [ 6.531509] systemd[1]: Save Transient machine-id to Disk skipped, unmet condition check ConditionPathIsMountPoint=/etc/machine-id2127machine # [ 6.533044] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2128machine # [ 6.534576] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2129machine # [ 6.535904] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2130machine # [ 6.538282] systemd[1]: Update is Completed skipped, no trigger condition checks were met.2131machine # [ 6.562122] systemd[1]: Finished Record System Boot/Shutdown in UTMP.2132machine # [ 6.843131] bochs-drm 0000:00:01.0: vgaarb: deactivate vga console2133machine # [ 6.822138] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2134machine # [ 6.826792] systemd[1]: Finished Create SUID/SGID Wrappers.2135machine # [ 6.828231] systemd[1]: Reached target System Initialization.2136machine # [ 6.830994] systemd[1]: Started Discard unused filesystem blocks once a week.2137machine # [ 6.832439] systemd[1]: Started Daily Cleanup of Temporary Directories.2138machine # [ 6.835665] systemd[1]: Reached target Timer Units.2139machine # [ 6.836467] systemd[1]: Listening on D-Bus System Message Bus Socket.2140machine # [ 6.837448] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.2141machine # [ 6.838785] systemd[1]: Reached target Socket Units.2142machine # [ 6.839605] systemd[1]: Reached target Basic System.2143machine # [ 6.842478] systemd[1]: Started backdoor.service.2144machine # [ 6.845119] systemd[1]: Import lastlog data into lastlog2 database skipped, unmet condition check ConditionPathExists=!/var/lib/lastlog/lastlog2.db2145machine # [ 6.849131] systemd[1]: Starting Name Service Cache Daemon (nsncd)...2146machine # [ 6.855133] systemd[1]: Starting Post-Boot Actions...2147machine # [ 6.867735] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input32148machine # [ 6.894711] mousedev: PS/2 mouse device common for all mice2149machine # [ 6.895745] ACPI: button: Power Button [PWRF]2150machine # [ 6.999264] rtc_cmos PNP0B00:00: RTC can wake from S42151machine # [ 7.002547] rtc_cmos PNP0B00:00: registered as rtc02152machine # [ 7.002629] rtc_cmos PNP0B00:00: setting system clock to 2026-10-02T03:53:59 UTC (1790913239)2153machine # [ 6.939136] systemd[1]: Started Reset console on configuration changes.2154machine # [ 6.940663] systemd[1]: Starting resolvconf update...2155machine # [ 6.942534] systemd[1]: Finished Firewall.2156machine # [ 7.002719] rtc_cmos PNP0B00:00: alarms up to one day, y3k, 242 bytes nvram, hpet irqs2157machine # [ 7.003081] systemd-journald[317]: Time jumped backwards, rotating.2158machine # [ 7.012770] parport_pc 00:02: reported by Plug and Play ACPI2159machine # [ 7.029660] Console: switching to colour dummy device 80x252160machine # [ 7.042913] parport0: PC-style at 0x378, irq 7 [PCSPP(,...)]2161machine # [ 6.974923] systemd[1]: Starting D-Bus System Message Bus...2162machine # [ 6.977557] systemd[1]: Finished Post-Boot Actions.2163machine # [ 6.991289] nsncd[527]: Oct 02 03:53:59.629 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"2164machine # [ 6.996166] systemd[1]: Started Name Service Cache Daemon (nsncd).2165machine # [ 6.997092] systemd[1]: Reached target Host and Network Name Lookups.2166machine # [ 6.999544] systemd[1]: Reached target User and Group Name Lookups.2167machine # [ 7.013484] systemd[1]: Starting User Login Management...2168machine # connecting to host...2169machine # [ 7.085496] input: QEMU Virtio Keyboard as /devices/pci0000:00/0000:00:06.0/virtio4/input/input42170machine # [ 7.153347] lpc_ich 0000:00:1f.0: I/O space for GPIO uninitialized2171machine # [ 7.170667] [drm] Found bochs VGA, ID 0xb0c5.2172machine # [ 7.170669] [drm] Framebuffer size 16384 kB @ 0xfd000000, mmio @ 0xfebd0000.2173machine: Guest shell says: b'Spawning backdoor root shell...\n'2174machine: connected to guest root shell2175machine: (connecting took 3.32 seconds)2176machine: (finished: waiting for the VM to finish booting, in 3.32 seconds)2177machine: must succeed: df --output=avail / | sed 1d2178machine # [ 7.222250] bochs-drm 0000:00:01.0: [drm] Registered 1 planes with drm panic2179machine # [ 7.222947] [drm] Initialized bochs-drm 1.0.0 for 0000:00:01.0 on minor 02180machine # [ 7.141123] dbus-broker-launch[535]: Looking up NSS user entry for 'systemd-timesync'...2181machine # [ 7.148140] dbus-broker-launch[535]: NSS returned no entry for 'systemd-timesync'2182machine # [ 7.149342] dbus-broker-launch[535]: Invalid user-name in /nix/store/vk3s3krx177a04a28pvgha0ii5jal4g5-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"2183machine: (finished: must succeed: df --output=avail / | sed 1d, in 0.09 seconds)2184(finished: subtest: growfs works, in 9.35 seconds)2185subtest: no warnings from systemd about write permissions2186machine: must fail: journalctl -b 0 | grep 'is marked world-writable, which is a security risk as it is executed with privileges'2187machine # [ 7.164259] systemd-logind[551]: New seat seat0.2188machine # [ 7.169471] systemd[1]: Started User Login Management.2189machine # [ 7.177111] systemd[1]: Starting linger-users.service...2190machine # [ 7.195240] systemd[1]: Started D-Bus System Message Bus.2191machine # [ 7.225563] dbus-broker-launch[535]: Ready2192machine # [ 7.228444] systemd[1]: Stopped target Host and Network Name Lookups.2193machine # [ 7.229378] systemd[1]: Stopping Host and Network Name Lookups...2194machine # [ 7.230282] systemd[1]: Stopped target User and Group Name Lookups.2195machine # [ 7.237226] systemd[1]: Stopping User and Group Name Lookups...2196machine # [ 7.238216] systemd[1]: Stopping Name Service Cache Daemon (nsncd)...2197machine # [ 7.243722] systemd[1]: nscd.service: Deactivated successfully.2198machine # [ 7.248515] systemd[1]: Stopped Name Service Cache Daemon (nsncd).2199machine # [ 7.281185] systemd[1]: Starting Name Service Cache Daemon (nsncd)...2200machine # [ 7.293070] systemd[1]: linger-users.service: Deactivated successfully.2201machine # [ 7.295920] systemd[1]: Finished linger-users.service.2202machine: (finished: must fail: journalctl -b 0 | grep 'is marked world-writable, which is a security risk as it is executed with privileges', in 0.16 seconds)2203(finished: subtest: no warnings from systemd about write permissions, in 0.16 seconds)2204(finished: run the VM test script, in 27.37 seconds)2205machine # [ 7.350448] nsncd[614]: Oct 02 03:53:59.988 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"2206machine # [ 7.353635] systemd[1]: Started Name Service Cache Daemon (nsncd).2207machine # [ 7.355792] systemd[1]: Reached target Host and Network Name Lookups.2208machine # [ 7.357438] systemd[1]: Reached target User and Group Name Lookups.2209machine # [ 7.369307] systemd[1]: Finished resolvconf update.2210machine # [ 7.370129] systemd[1]: Reached target Preparation for Network.2211machine # [ 7.377293] systemd[1]: Starting DHCP Client...2212machine # [ 7.380612] systemd[1]: Starting Address configuration of eth1...2213machine # [ 7.390652] systemd[1]: Starting Extra networking commands....2214machine # [ 7.407131] i801_smbus 0000:00:1f.3: SMBus using PCI interrupt2215machine # [ 7.407283] i2c i2c-0: Memory type 0x07 not supported yet, not instantiating SPD2216machine # [ 7.548218] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input62217machine # [ 7.548474] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input52218machine # [ 7.560411] Console: switching to colour frame buffer device 160x502219machine # [ 7.502256] systemd[1]: Starting Virtual Console Setup...2220machine # [ 7.534529] network-addresses-eth1-start[643]: adding address 192.168.1.1/24... done2221machine # [ 7.568258] network-addresses-eth1-start[643]: adding address 2001:db8:1::1/64... done2222machine # [ 7.715913] bochs-drm 0000:00:01.0: [drm] fb0: bochs-drmdrmfb frame buffer device2223machine # [ 7.592853] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.2224machine # [ 7.595562] systemd[1]: Stopped Virtual Console Setup.2225machine # [ 7.610896] systemd[1]: Starting Virtual Console Setup...2226machine # [ 7.620468] systemd[1]: Finished Address configuration of eth1.2227machine # [ 7.634813] systemd-logind[551]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard)2228machine # [ 7.638071] systemd-logind[551]: Watching system buttons on /dev/input/event2 (Power Button)2229machine # [ 7.689397] dhcpcd[653]: dhcpcd-10.3.2 starting2230machine # [ 7.698496] dhcpcd[714]: dev: loaded udev2231machine # [ 7.700271] dhcpcd[714]: DUID 00:01:00:01:32:51:e7:46:52:54:00:12:34:562232machine # [ 7.706245] systemd[1]: Finished Extra networking commands..2233machine # [ 7.707112] systemd[1]: Reached target Network.2234machine # [ 7.713417] systemd[1]: Starting Permit User Sessions...2235machine # [ 7.874857] ppdev: user-space parallel port driver2236machine # [ 7.759273] systemd-logind[551]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard)2237machine # [ 7.903634] 8021q: 802.1Q VLAN Support v1.82238machine # [ 7.904087] 8021q: adding VLAN 0 to HW filter on device eth12239machine # [ 7.782251] systemd[1]: Finished Permit User Sessions.2240machine # [ 7.788822] systemd[1]: Started Getty on tty1.2241machine # [ 7.791426] systemd[1]: Reached target Login Prompts.2242machine # [ 7.853582] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.2243machine # [ 7.864345] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.2244machine # [ 7.867070] systemd[1]: Stopped Virtual Console Setup.2245machine # [ 8.017322] iTCO_wdt iTCO_wdt.1.auto: Found a ICH9 TCO device (Version=2, TCOBASE=0x0660)2246machine # [ 7.878767] systemd[1]: Starting Virtual Console Setup...2247machine # [ 8.036816] iTCO_wdt iTCO_wdt.1.auto: initialized. heartbeat=30 sec (nowayout=0)2248machine # [ 8.093876] cfg80211: Loading compiled-in X.509 certificates for regulatory database2249machine # [ 8.160642] kvm_amd: TSC scaling supported2250machine # [ 8.161225] kvm_amd: Nested Virtualization enabled2251machine # [ 8.161736] kvm_amd: Nested Paging enabled2252machine # [ 8.162446] kvm_amd: LBR virtualization supported2253machine # [ 8.163091] kvm_amd: Virtual VMLOAD VMSAVE supported2254machine # [ 8.163587] kvm_amd: Virtual GIF supported2255machine # [ 8.164168] kvm_amd: Virtual NMI enabled2256machine # [ 8.173668] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'2257machine # [ 8.174343] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'2258machine # [ 8.177369] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -22259machine # [ 8.178241] cfg80211: failed to load regulatory.db2260machine # [ 8.203076] EDAC MC: Ver: 3.0.02261test script finished in 28.12s2262cleanup2263kill QemuMachine (pid 98)2264machine # qemu-system-x86_64: terminating on signal 15 from pid 39 (/nix/store/lb41b0anx1f98y9y5s9mdv97gjgsq740-python3-3.14.7/bin/python3.14)2265machine # [2026-10-02T03:54:01Z INFO virtiofsd] Client disconnected, shutting down2266machine # [2026-10-02T03:54:01Z INFO virtiofsd] Client disconnected, shutting down2267machine # [2026-10-02T03:54:01Z INFO virtiofsd] Client disconnected, shutting down2268(finished: cleanup, in 0.19 seconds)