vm-test-run-systemd-initrd-simple
checks.x86_64-linux.systemd-initrd-simple
· build #66
· raw
1tribuchet: building on jamie2Machine state will be reset. To keep it, pass --keep-machine-state3start all VLans4(finished: start all VLans, in 0.00 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.nGhnCcoI4J', 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: 1614790b-031f-4d6a-bb61-20cad1f026f618machine # 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-24T03:07:14Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)29machine # [2026-10-24T03:07:14Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether30machine # [2026-10-24T03:07:14Z INFO virtiofsd] Waiting for vhost-user socket connection...31machine # [2026-10-24T03:07:14Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)32machine # [2026-10-24T03:07:14Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether33machine # [2026-10-24T03:07:14Z INFO virtiofsd] Waiting for vhost-user socket connection...34machine # [2026-10-24T03:07:14Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)35machine # [2026-10-24T03:07:14Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether36machine # [2026-10-24T03:07:14Z INFO virtiofsd] Waiting for vhost-user socket connection...37machine # [2026-10-24T03:07:14Z INFO virtiofsd] Client connected, servicing requests38machine # [2026-10-24T03:07:14Z INFO virtiofsd] Client connected, servicing requests39machine # [2026-10-24T03:07:14Z 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.57 (nixbld@localhost) (gcc (GCC) 16.2.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT_DYNAMIC @179205830055machine # [ 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/l8fq20sqvpsln2vdy6rxiw4iaqx43q34-nixos-system-machine-test/init regInfo=/nix/.ro-store/5vy3rydbln1k23ra00dmxdif43vm5jg3-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.000001] kvm-clock: using sched offset of 544771006 cycles76machine # [ 0.000002] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns77machine # [ 0.000005] tsc: Detected 2400.008 MHz processor78machine # [ 0.000801] last_pfn = 0x3ffd8 max_arch_pfn = 0x1000000000079machine # [ 0.000828] MTRR map: 4 entries (3 fixed + 1 variable; max 19), built from 8 variable MTRRs80machine # [ 0.000831] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT81machine # [ 0.002828] found SMP MP-table at [mem 0x000f5450-0x000f545f]82machine # [ 0.002841] Using GB pages for direct mapping83machine # [ 0.002954] RAMDISK: [mem 0x3e33a000-0x3ffcffff]84machine # [ 0.002964] ACPI: Early table checksum verification disabled85machine # [ 0.002968] ACPI: RSDP 0x00000000000F5270 000014 (v00 BOCHS )86machine # [ 0.002972] ACPI: RSDT 0x000000003FFE2422 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001)87machine # [ 0.002977] ACPI: FACP 0x000000003FFE221A 0000F4 (v03 BOCHS BXPC 00000001 BXPC 00000001)88machine # [ 0.002985] ACPI: DSDT 0x000000003FFE0040 0021DA (v01 BOCHS BXPC 00000001 BXPC 00000001)89machine # [ 0.002989] ACPI: FACS 0x000000003FFE0000 00004090machine # [ 0.002991] ACPI: APIC 0x000000003FFE230E 000078 (v03 BOCHS BXPC 00000001 BXPC 00000001)91machine # [ 0.002992] ACPI: HPET 0x000000003FFE2386 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001)92machine # [ 0.002994] ACPI: MCFG 0x000000003FFE23BE 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001)93machine # [ 0.002995] ACPI: WAET 0x000000003FFE23FA 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001)94machine # [ 0.002997] ACPI: Reserving FACP table memory at [mem 0x3ffe221a-0x3ffe230d]95machine # [ 0.002997] ACPI: Reserving DSDT table memory at [mem 0x3ffe0040-0x3ffe2219]96machine # [ 0.002998] ACPI: Reserving FACS table memory at [mem 0x3ffe0000-0x3ffe003f]97machine # [ 0.002998] ACPI: Reserving APIC table memory at [mem 0x3ffe230e-0x3ffe2385]98machine # [ 0.002999] ACPI: Reserving HPET table memory at [mem 0x3ffe2386-0x3ffe23bd]99machine # [ 0.002999] ACPI: Reserving MCFG table memory at [mem 0x3ffe23be-0x3ffe23f9]100machine # [ 0.003000] ACPI: Reserving WAET table memory at [mem 0x3ffe23fa-0x3ffe2421]101machine # [ 0.003241] No NUMA configuration found102machine # [ 0.003242] Faking a node at [mem 0x0000000000000000-0x000000003ffd7fff]103machine # [ 0.003244] NODE_DATA(0) allocated [mem 0x3ffd2780-0x3ffd7cff]104machine # [ 0.005808] Zone ranges:105machine # [ 0.005809] DMA [mem 0x0000000000001000-0x0000000000ffffff]106machine # [ 0.005810] DMA32 [mem 0x0000000001000000-0x000000003ffd7fff]107machine # [ 0.005812] Normal empty108machine # [ 0.005812] Device empty109machine # [ 0.005813] Movable zone start for each node110machine # [ 0.005814] Early memory node ranges111machine # [ 0.005814] node 0: [mem 0x0000000000001000-0x000000000009efff]112machine # [ 0.005815] node 0: [mem 0x0000000000100000-0x000000003ffd7fff]113machine # [ 0.005816] Initmem setup node 0 [mem 0x0000000000001000-0x000000003ffd7fff]114machine # [ 0.005838] On node 0, zone DMA: 1 pages in unavailable ranges115machine # [ 0.006127] On node 0, zone DMA: 97 pages in unavailable ranges116machine # [ 0.026077] On node 0, zone DMA32: 40 pages in unavailable ranges117machine # [ 0.026553] ACPI: PM-Timer IO Port: 0x608118machine # [ 0.026565] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1])119machine # [ 0.026595] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23120machine # [ 0.026597] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl)121machine # [ 0.026599] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level)122machine # [ 0.026600] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level)123machine # [ 0.026601] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level)124machine # [ 0.026602] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level)125machine # [ 0.026605] ACPI: Using ACPI (MADT) for SMP configuration information126machine # [ 0.026606] ACPI: HPET id: 0x8086a201 base: 0xfed00000127machine # [ 0.026609] TSC deadline timer available128machine # [ 0.026613] CPU topo: Max. logical packages: 1129machine # [ 0.026614] CPU topo: Max. logical dies: 1130machine # [ 0.026614] CPU topo: Max. dies per package: 1131machine # [ 0.026618] CPU topo: Max. threads per core: 1132machine # [ 0.026619] CPU topo: Num. cores per package: 1133machine # [ 0.026619] CPU topo: Num. threads per package: 1134machine # [ 0.026619] CPU topo: Allowing 1 present CPUs plus 0 hotplug CPUs135machine # [ 0.026638] kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write()136machine # [ 0.026671] PM: hibernation: Registered nosave memory: [mem 0x00000000-0x00000fff]137machine # [ 0.026673] PM: hibernation: Registered nosave memory: [mem 0x0009f000-0x000fffff]138machine # [ 0.026675] [mem 0x40000000-0xafffffff] available for PCI devices139machine # [ 0.026676] Booting paravirtualized kernel on KVM140machine # [ 0.026679] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns141machine # [ 0.031426] setup_percpu: NR_CPUS:512 nr_cpumask_bits:1 nr_cpu_ids:1 nr_node_ids:1142machine # [ 0.033809] percpu: Embedded 98 pages/cpu s278528 r8192 d114688 u2097152143machine # [ 0.033855] kvm-guest: PV spinlocks disabled, single CPU144machine # [ 0.033856] 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/l8fq20sqvpsln2vdy6rxiw4iaqx43q34-nixos-system-machine-test/init regInfo=/nix/.ro-store/5vy3rydbln1k23ra00dmxdif43vm5jg3-closure-info/registration console=ttyS0,115200n8 console=tty0145machine # [ 0.033954] Unknown kernel command line parameters "regInfo=/nix/.ro-store/5vy3rydbln1k23ra00dmxdif43vm5jg3-closure-info/registration", will be passed to user space.146machine # [ 0.033968] random: crng init done147machine # [ 0.033969] printk: log buffer data + meta data: 1048576 + 3670016 = 4718592 bytes148machine # [ 0.035146] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes, linear)149machine # [ 0.035162] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes, linear)150machine # [ 0.035193] Fallback order for Node 0: 0151machine # [ 0.035196] Built 1 zonelists, mobility grouping on. Total pages: 262006152machine # [ 0.035197] Policy zone: DMA32153machine # [ 0.037885] mem auto-init: stack:all(zero), heap alloc:on, heap free:off154machine # [ 0.040688] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1155machine # [ 0.043103] allocated 2097152 bytes of page_ext156machine # [ 0.053654] ftrace: allocating 48987 entries in 192 pages157machine # [ 0.053656] ftrace: allocated 192 pages with 2 groups158machine # [ 0.054585] Dynamic Preempt: lazy159machine # [ 0.054716] rcu: Preemptible hierarchical RCU implementation.160machine # [ 0.054717] rcu: RCU event tracing is enabled.161machine # [ 0.054718] rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=1.162machine # [ 0.054720] Trampoline variant of Tasks RCU enabled.163machine # [ 0.054720] Rude variant of Tasks RCU enabled.164machine # [ 0.054720] Tracing variant of Tasks RCU enabled.165machine # [ 0.054721] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies.166machine # [ 0.054722] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1167machine # [ 0.054732] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.168machine # [ 0.054734] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.169machine # [ 0.054735] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.170machine # [ 0.059384] NR_IRQS: 33024, nr_irqs: 256, preallocated irqs: 16171machine # [ 0.059675] rcu: srcu_init: Setting srcu_struct sizes based on contention.172machine # [ 0.059682] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns173machine # [ 0.059793] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)174machine # [ 0.063432] Console: colour VGA+ 80x25175machine # [ 0.063439] printk: legacy console [tty0] enabled176machine # [ 0.094580] printk: legacy console [ttyS0] enabled177machine # [ 0.202874] ACPI: Core revision 20250807178machine # [ 0.203797] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns179machine # [ 0.205457] APIC: Switch to symmetric I/O mode setup180machine # [ 0.206458] x2apic enabled181machine # [ 0.207204] APIC: Switched APIC routing to: physical x2apic182machine # [ 0.209139] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1183machine # [ 0.210181] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x22983f10a64, max_idle_ns: 440795218721 ns184machine # [ 0.211887] Calibrating delay loop (skipped) preset value.. 4800.01 BogoMIPS (lpj=2400008)185machine # [ 0.212982] x86/cpu: User Mode Instruction Prevention (UMIP) activated186machine # [ 0.215051] Last level iTLB entries: 4KB 512, 2MB 255, 4MB 127187machine # [ 0.215884] Last level dTLB entries: 4KB 512, 2MB 255, 4MB 127, 1GB 0188machine # [ 0.216887] mitigations: Enabled attack vectors: user_kernel, user_user, guest_host, guest_guest, SMT mitigations: auto189machine # [ 0.217885] Speculative Store Bypass: Mitigation: Speculative Store Bypass disabled via prctl190machine # [ 0.219885] Transient Scheduler Attacks: Vulnerable: No microcode191machine # [ 0.220884] Spectre V2 : Mitigation: Enhanced / Automatic IBRS192machine # [ 0.221884] Speculative Return Stack Overflow: Mitigation: Safe RET193machine # [ 0.222885] Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization194machine # [ 0.224892] Spectre V2 : Enabling IBPB for BPF195machine # [ 0.225636] Spectre V2 : mitigation: Enabling conditional Indirect Branch Prediction Barrier196machine # [ 0.226884] active return thunk: srso_alias_return_thunk197machine # [ 0.227907] x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers'198machine # [ 0.228884] x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers'199machine # [ 0.229884] x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers'200machine # [ 0.230884] x86/fpu: Supporting XSAVE feature 0x020: 'AVX-512 opmask'201machine # [ 0.231884] x86/fpu: Supporting XSAVE feature 0x040: 'AVX-512 Hi256'202machine # [ 0.232885] x86/fpu: Supporting XSAVE feature 0x080: 'AVX-512 ZMM_Hi256'203machine # [ 0.233884] x86/fpu: Supporting XSAVE feature 0x200: 'Protection Keys User registers'204machine # [ 0.234884] x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256205machine # [ 0.236619] x86/fpu: xstate_offset[5]: 832, xstate_sizes[5]: 64206machine # [ 0.237623] x86/fpu: xstate_offset[6]: 896, xstate_sizes[6]: 512207machine # [ 0.238637] x86/fpu: xstate_offset[7]: 1408, xstate_sizes[7]: 1024208machine # [ 0.239633] x86/fpu: xstate_offset[9]: 2432, xstate_sizes[9]: 8209machine # [ 0.240664] x86/fpu: Enabled xstate features 0x2e7, context size is 2440 bytes, using 'compacted' format.210machine # [ 0.276832] Freeing SMP alternatives memory: 48K211machine # [ 0.277491] pid_max: default: 32768 minimum: 301212machine # [ 0.278549] LSM: initializing lsm=lockdown,capability,landlock,yama,bpf,ima213machine # [ 0.279966] landlock: Up and running.214machine # [ 0.280651] Yama: becoming mindful.215machine # [ 0.281132] LSM support for eBPF active216machine # [ 0.281991] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)217machine # [ 0.282905] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)218machine # [ 0.286055] smpboot: CPU0: AMD EPYC 9654 96-Core Processor (family: 0x19, model: 0x11, stepping: 0x1)219machine # [ 0.287524] Performance Events: Fam17h+ core perfctr, AMD PMU driver.220machine # [ 0.287894] ... version: 2221machine # [ 0.288647] ... bit width: 48222machine # [ 0.288887] ... generic counters: 6223machine # [ 0.289593] ... generic bitmap: 000000000000003f224machine # [ 0.289887] ... fixed-purpose counters: 0225machine # [ 0.290666] ... fixed-purpose bitmap: 0000000000000000226machine # [ 0.290887] ... value mask: 0000ffffffffffff227machine # [ 0.291815] ... max period: 00007fffffffffff228machine # [ 0.292605] ... global_ctrl mask: 000000000000003f229machine # [ 0.293019] signal: max sigframe size: 3376230machine # [ 0.293865] rcu: Hierarchical SRCU implementation.231machine # [ 0.294452] rcu: Max phase no-delay instances is 400.232machine # [ 0.300168] smp: Bringing up secondary CPUs ...233machine # [ 0.300900] smp: Brought up 1 node, 1 CPU234machine # [ 0.301576] smpboot: Total of 1 processors activated (4800.01 BogoMIPS)235machine # [ 0.302099] Memory: 934720K/1048024K available (18186K kernel code, 5431K rwdata, 13716K rodata, 6720K init, 3992K bss, 105936K reserved, 0K cma-reserved)236machine # [ 0.303205] devtmpfs: initialized237machine # [ 0.304006] x86/mm: Memory block size: 128MB238machine # [ 0.305744] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear)239machine # [ 0.306786] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear).240machine # [ 0.307976] pinctrl core: initialized pinctrl subsystem241machine # [ 0.309128] PM: RTC time: 03:07:14, date: 2026-10-24242machine # [ 0.312775] NET: Registered PF_NETLINK/PF_ROUTE protocol family243machine # [ 0.314037] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations244machine # [ 0.314909] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations245machine # [ 0.316046] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations246machine # [ 0.316898] audit: initializing netlink subsys (disabled)247machine # [ 0.318043] thermal_sys: Registered thermal governor 'fair_share'248machine # [ 0.318045] thermal_sys: Registered thermal governor 'bang_bang'249machine # [ 0.318888] thermal_sys: Registered thermal governor 'step_wise'250machine # [ 0.319836] thermal_sys: Registered thermal governor 'user_space'251machine # [ 0.320629] audit: type=2000 audit(1792811235.669:1): state=initialized audit_enabled=0 res=1252machine # [ 0.321890] thermal_sys: Registered thermal governor 'power_allocator'253machine # [ 0.321915] cpuidle: using governor menu254machine # [ 0.324102] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5255machine # [ 0.325119] PCI: ECAM [mem 0xb0000000-0xbfffffff] (base 0xb0000000) for domain 0000 [bus 00-ff]256machine # [ 0.325889] PCI: ECAM [mem 0xb0000000-0xbfffffff] reserved as E820 entry257machine # [ 0.326899] PCI: Using configuration type 1 for base access258machine # [ 0.328020] kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible.259machine # [ 0.333140] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages260machine # [ 0.333888] HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page261machine # [ 0.338888] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages262machine # [ 0.339887] HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page263machine # [ 0.351303] ACPI: Added _OSI(Module Device)264machine # [ 0.351888] ACPI: Added _OSI(Processor Device)265machine # [ 0.352601] ACPI: Added _OSI(Processor Aggregator Device)266machine # [ 0.360487] ACPI: 1 ACPI AML tables successfully acquired and loaded267machine # [ 0.364304] ACPI: Interpreter enabled268machine # [ 0.364908] ACPI: PM: (supports S0 S3 S4 S5)269machine # [ 0.365628] ACPI: Using IOAPIC for interrupt routing270machine # [ 0.365952] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug271machine # [ 0.366890] PCI: Using E820 reservations for host bridge windows272machine # [ 0.370005] ACPI: Enabled 2 GPEs in block 00 to 3F273machine # [ 0.378236] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff])274machine # [ 0.378893] acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3]275machine # [ 0.379982] acpi PNP0A08:00: _OSC: platform does not support [PCIeHotplug LTR]276machine # [ 0.381012] acpi PNP0A08:00: _OSC: OS now controls [PME AER PCIeCapability]277machine # [ 0.382293] PCI host bridge to bus 0000:00278machine # [ 0.382891] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window]279machine # [ 0.383887] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window]280machine # [ 0.384887] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window]281machine # [ 0.385887] pci_bus 0000:00: root bus resource [mem 0x40000000-0xafffffff window]282machine # [ 0.386886] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window]283machine # [ 0.387887] pci_bus 0000:00: root bus resource [mem 0x100000000-0x8ffffffff window]284machine # [ 0.388887] pci_bus 0000:00: root bus resource [bus 00-ff]285machine # [ 0.389888] pci 0000:00:00.0: [8086:29c0] type 00 class 0x060000 conventional PCI endpoint286machine # [ 0.391366] pci 0000:00:01.0: [1234:1111] type 00 class 0x030000 conventional PCI endpoint287machine # [ 0.393971] pci 0000:00:01.0: BAR 0 [mem 0xfd000000-0xfdffffff pref]288machine # [ 0.394899] pci 0000:00:01.0: BAR 2 [mem 0xfebd0000-0xfebd0fff]289machine # [ 0.395875] pci 0000:00:01.0: ROM [mem 0xfebc0000-0xfebcffff pref]290machine # [ 0.397156] pci 0000:00:01.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff]291machine # [ 0.398651] pci 0000:00:02.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint292machine # [ 0.400915] pci 0000:00:02.0: BAR 0 [io 0xc100-0xc11f]293machine # [ 0.401757] pci 0000:00:02.0: BAR 1 [mem 0xfebd1000-0xfebd1fff]294machine # [ 0.402643] pci 0000:00:02.0: BAR 4 [mem 0xfe000000-0xfe003fff 64bit pref]295machine # [ 0.402893] pci 0000:00:02.0: ROM [mem 0xfeb40000-0xfeb7ffff pref]296machine # [ 0.404619] pci 0000:00:03.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint297machine # [ 0.406894] pci 0000:00:03.0: BAR 0 [io 0xc120-0xc13f]298machine # [ 0.407709] pci 0000:00:03.0: BAR 1 [mem 0xfebd2000-0xfebd2fff]299machine # [ 0.408618] pci 0000:00:03.0: BAR 4 [mem 0xfe004000-0xfe007fff 64bit pref]300machine # [ 0.409465] pci 0000:00:04.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint301machine # [ 0.412086] pci 0000:00:04.0: BAR 0 [io 0xc000-0xc07f]302machine # [ 0.412894] pci 0000:00:04.0: BAR 1 [mem 0xfebd3000-0xfebd3fff]303machine # [ 0.413837] pci 0000:00:04.0: BAR 4 [mem 0xfe008000-0xfe00bfff 64bit pref]304machine # [ 0.415318] pci 0000:00:05.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint305machine # [ 0.416922] pci 0000:00:05.0: BAR 0 [io 0xc140-0xc15f]306machine # [ 0.417886] pci 0000:00:05.0: BAR 1 [mem 0xfebd4000-0xfebd4fff]307machine # [ 0.418849] pci 0000:00:05.0: BAR 4 [mem 0xfe00c000-0xfe00ffff 64bit pref]308machine # [ 0.419726] pci 0000:00:05.0: ROM [mem 0xfeb80000-0xfebbffff pref]309machine # [ 0.421481] pci 0000:00:06.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint310machine # [ 0.422776] pci 0000:00:06.0: BAR 1 [mem 0xfebd5000-0xfebd5fff]311machine # [ 0.423639] pci 0000:00:06.0: BAR 4 [mem 0xfe010000-0xfe013fff 64bit pref]312machine # [ 0.424466] pci 0000:00:07.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint313machine # [ 0.425932] pci 0000:00:07.0: BAR 1 [mem 0xfebd6000-0xfebd6fff]314machine # [ 0.426909] pci 0000:00:07.0: BAR 4 [mem 0xfe014000-0xfe017fff 64bit pref]315machine # [ 0.428502] pci 0000:00:08.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint316machine # [ 0.429849] pci 0000:00:08.0: BAR 1 [mem 0xfebd7000-0xfebd7fff]317machine # [ 0.430641] pci 0000:00:08.0: BAR 4 [mem 0xfe018000-0xfe01bfff 64bit pref]318machine # [ 0.431450] pci 0000:00:09.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint319machine # [ 0.432859] pci 0000:00:09.0: BAR 1 [mem 0xfebd8000-0xfebd8fff]320machine # [ 0.433655] pci 0000:00:09.0: BAR 4 [mem 0xfe01c000-0xfe01ffff 64bit pref]321machine # [ 0.435473] pci 0000:00:0a.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint322machine # [ 0.436932] pci 0000:00:0a.0: BAR 0 [io 0xc080-0xc0bf]323machine # [ 0.437804] pci 0000:00:0a.0: BAR 1 [mem 0xfebd9000-0xfebd9fff]324machine # [ 0.438652] pci 0000:00:0a.0: BAR 4 [mem 0xfe020000-0xfe023fff 64bit pref]325machine # [ 0.439465] pci 0000:00:0b.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint326machine # [ 0.442110] pci 0000:00:0b.0: BAR 0 [io 0xc160-0xc17f]327machine # [ 0.442893] pci 0000:00:0b.0: BAR 1 [mem 0xfebda000-0xfebdafff]328machine # [ 0.443848] pci 0000:00:0b.0: BAR 4 [mem 0xfe024000-0xfe027fff 64bit pref]329machine # [ 0.445350] pci 0000:00:1d.0: [8086:2934] type 00 class 0x0c0300 conventional PCI endpoint330machine # [ 0.447502] pci 0000:00:1d.0: BAR 4 [io 0xc180-0xc19f]331machine # [ 0.448105] pci 0000:00:1d.1: [8086:2935] type 00 class 0x0c0300 conventional PCI endpoint332machine # [ 0.450772] pci 0000:00:1d.1: BAR 4 [io 0xc1a0-0xc1bf]333machine # [ 0.451791] pci 0000:00:1d.2: [8086:2936] type 00 class 0x0c0300 conventional PCI endpoint334machine # [ 0.453629] pci 0000:00:1d.2: BAR 4 [io 0xc1c0-0xc1df]335machine # [ 0.454217] pci 0000:00:1d.7: [8086:293a] type 00 class 0x0c0320 conventional PCI endpoint336machine # [ 0.456581] pci 0000:00:1d.7: BAR 0 [mem 0xfebdb000-0xfebdbfff]337machine # [ 0.457993] pci 0000:00:1f.0: [8086:2918] type 00 class 0x060100 conventional PCI endpoint338machine # [ 0.459191] pci 0000:00:1f.0: quirk: [io 0x0600-0x067f] claimed by ICH6 ACPI/GPIO/TCO339machine # [ 0.460159] pci 0000:00:1f.2: [8086:2922] type 00 class 0x010601 conventional PCI endpoint340machine # [ 0.461914] pci 0000:00:1f.2: BAR 4 [io 0xc1e0-0xc1ff]341machine # [ 0.462711] pci 0000:00:1f.2: BAR 5 [mem 0xfebdc000-0xfebdcfff]342machine # [ 0.463921] pci 0000:00:1f.3: [8086:2930] type 00 class 0x0c0500 conventional PCI endpoint343machine # [ 0.465457] pci 0000:00:1f.3: BAR 4 [io 0x0700-0x073f]344machine # [ 0.469100] ACPI: PCI: Interrupt link LNKA configured for IRQ 10345machine # [ 0.469990] ACPI: PCI: Interrupt link LNKB configured for IRQ 10346machine # [ 0.470989] ACPI: PCI: Interrupt link LNKC configured for IRQ 11347machine # [ 0.471987] ACPI: PCI: Interrupt link LNKD configured for IRQ 11348machine # [ 0.472985] ACPI: PCI: Interrupt link LNKE configured for IRQ 10349machine # [ 0.473984] ACPI: PCI: Interrupt link LNKF configured for IRQ 10350machine # [ 0.474986] ACPI: PCI: Interrupt link LNKG configured for IRQ 11351machine # [ 0.475987] ACPI: PCI: Interrupt link LNKH configured for IRQ 11352machine # [ 0.476925] ACPI: PCI: Interrupt link GSIA configured for IRQ 16353machine # [ 0.477900] ACPI: PCI: Interrupt link GSIB configured for IRQ 17354machine # [ 0.478902] ACPI: PCI: Interrupt link GSIC configured for IRQ 18355machine # [ 0.479901] ACPI: PCI: Interrupt link GSID configured for IRQ 19356machine # [ 0.480898] ACPI: PCI: Interrupt link GSIE configured for IRQ 20357machine # [ 0.481898] ACPI: PCI: Interrupt link GSIF configured for IRQ 21358machine # [ 0.482903] ACPI: PCI: Interrupt link GSIG configured for IRQ 22359machine # [ 0.483906] ACPI: PCI: Interrupt link GSIH configured for IRQ 23360machine # [ 0.486070] iommu: Default domain type: Translated361machine # [ 0.486899] iommu: DMA domain TLB invalidation policy: lazy mode362machine # [ 0.488176] ACPI: bus type USB registered363machine # [ 0.488953] usbcore: registered new interface driver usbfs364machine # [ 0.489859] usbcore: registered new interface driver hub365machine # [ 0.490585] usbcore: registered new device driver usb366machine # [ 0.491778] NetLabel: Initializing367machine # [ 0.492379] NetLabel: domain hash size = 128368machine # [ 0.492886] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO369machine # [ 0.493865] NetLabel: unlabeled traffic allowed by default370machine # [ 0.494635] PCI: Using ACPI for IRQ routing371machine # [ 0.540435] pci 0000:00:01.0: vgaarb: setting as boot VGA device372machine # [ 0.540883] pci 0000:00:01.0: vgaarb: bridge control possible373machine # [ 0.540883] pci 0000:00:01.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none374machine # [ 0.540891] vgaarb: loaded375machine # [ 0.541642] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0376machine # [ 0.542462] hpet0: 3 comparators, 64-bit 100.000000 MHz counter377machine # [ 0.550025] clocksource: Switched to clocksource kvm-clock378machine # [ 0.553571] VFS: Disk quotas dquot_6.6.0379machine # [ 0.554338] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)380machine # [ 0.555765] pnp: PnP ACPI init381machine # [ 0.556586] ACPI: IRQ 4 override to edge(!), high(!)382machine # [ 0.557597] system 00:04: [mem 0xb0000000-0xbfffffff window] has been reserved383machine # [ 0.559238] pnp: PnP ACPI: found 5 devices384machine # [ 0.566803] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns385machine # [ 0.568246] clocksource: Switched to clocksource acpi_pm386machine # [ 0.569224] NET: Registered PF_INET protocol family387machine # [ 0.570339] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear)388machine # [ 0.588111] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear)389machine # [ 0.589689] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)390machine # [ 0.591030] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear)391machine # [ 0.592563] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear)392machine # [ 0.593775] TCP: Hash tables configured (established 8192 bind 8192)393machine # [ 0.594895] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear)394machine # [ 0.596147] UDP hash table entries: 512 (order: 3, 32768 bytes, linear)395machine # [ 0.597306] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear)396machine # [ 0.598526] NET: Registered PF_UNIX/PF_LOCAL protocol family397machine # [ 0.599495] NET: Registered PF_XDP protocol family398machine # [ 0.600396] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window]399machine # [ 0.601466] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window]400machine # [ 0.602493] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window]401machine # [ 0.603613] pci_bus 0000:00: resource 7 [mem 0x40000000-0xafffffff window]402machine # [ 0.604732] pci_bus 0000:00: resource 8 [mem 0xc0000000-0xfebfffff window]403machine # [ 0.605865] pci_bus 0000:00: resource 9 [mem 0x100000000-0x8ffffffff window]404machine # [ 0.607671] ACPI: \_SB_.GSIA: Enabled at IRQ 16405machine # [ 0.609795] ACPI: \_SB_.GSIB: Enabled at IRQ 17406machine # [ 0.611798] ACPI: \_SB_.GSIC: Enabled at IRQ 18407machine # [ 0.613857] ACPI: \_SB_.GSID: Enabled at IRQ 19408machine # [ 0.615643] PCI: CLS 0 bytes, default 64409machine # [ 0.616622] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x22983f10a64, max_idle_ns: 440795218721 ns410machine # [ 0.618479] Trying to unpack rootfs image as initramfs...411machine # [ 0.664017] Initialise system trusted keyrings412machine # [ 0.664851] Key type blacklist registered413machine # [ 0.667400] workingset: timestamp_bits=40 max_order=18 bucket_order=0414machine # [ 0.670557] integrity: Platform Keyring initialized415machine # [ 0.671392] integrity: Machine keyring initialized416machine # [ 0.691824] Key type asymmetric registered417machine # [ 0.695243] Asymmetric key parser 'x509' registered418machine # [ 0.696095] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 248)419machine # [ 0.699337] io scheduler mq-deadline registered420machine # [ 0.700095] io scheduler kyber registered421machine # [ 0.703938] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled422machine # [ 0.707354] 00:03: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A423machine # [ 0.712404] Linux agpgart interface v0.103424machine # [ 0.713253] ACPI: bus type drm_connector registered425machine # [ 0.716568] usbcore: registered new interface driver usbserial_generic426machine # [ 0.717659] usbserial: USB Serial support registered for generic427machine # [ 0.720231] amd_pstate: The CPPC feature is supported but currently disabled by the BIOS.428machine # [ 0.720231] Please enable it if your BIOS has the CPPC option.429machine # [ 0.722491] amd_pstate: the _CPC object is not present in SBIOS or ACPI disabled430machine # [ 0.727364] drop_monitor: Initializing network drop monitor service431machine # [ 0.728653] NET: Registered PF_INET6 protocol family432machine # [ 0.732794] Segment Routing with IPv6433machine # [ 0.733533] In-situ OAM (IOAM) with IPv6434machine # [ 0.736633] IPI shorthand broadcast: enabled435machine # [ 0.745401] sched_clock: Marking stable (598021534, 147201570)->(819685806, -74462702)436machine # [ 0.750502] registered taskstats version 1437machine # [ 0.751515] Loading compiled-in X.509 certificates438machine # [ 0.770553] Demotion targets for Node 0: null439machine # [ 0.771486] Key type .fscrypt registered440machine # [ 0.772184] Key type fscrypt-provisioning registered441machine # [ 0.775365] ima: No TPM chip found, activating TPM-bypass!442machine # [ 0.776419] ima: Allocated hash algorithm: sha1443machine # [ 0.779249] ima: No architecture policies found444machine # [ 0.782245] PM: Magic number: 14:209:109445machine # [ 0.784143] RAS: Correctable Errors collector initialized.446machine # [ 0.795489] clk: Disabling unused clocks447machine # [ 0.796239] PM: genpd: Disabling unused power domains448machine # [ 1.016599] Freeing initrd memory: 29272K449machine # [ 1.020160] Freeing unused decrypted memory: 2028K450machine # [ 1.025342] Freeing unused kernel image (initmem) memory: 6720K451machine # [ 1.026473] Write protecting the kernel read-only data: 32768k452machine # [ 1.027890] Freeing unused kernel image (text/rodata gap) memory: 244K453machine # [ 1.029523] Freeing unused kernel image (rodata/data gap) memory: 620K454machine # [ 1.081935] x86/mm: Checked W+X mappings: passed, no W+X pages found.455machine # [ 1.083484] Run /init as init process456machine # [ 1.094588] autofs4: module verification failed: signature and/or required key missing - tainting kernel457machine # [ 1.097352] systemd[1]: Inserted module 'autofs4'458machine # [ 1.118012] fuse: init (API version 7.45)459machine # [ 1.125543] ACPI: \_SB_.GSIG: Enabled at IRQ 22460machine # [ 1.128178] ACPI: \_SB_.GSIH: Enabled at IRQ 23461machine # [ 1.132169] ACPI: \_SB_.GSIE: Enabled at IRQ 20462machine # [ 1.134726] ACPI: \_SB_.GSIF: Enabled at IRQ 21463machine # [ 1.140880] virtiofs virtio5: discovered new tag: nix-store464machine # [ 1.142526] virtiofs virtio5: virtio_fs_setup_dax: No cache capability465machine # [ 1.150944] virtiofs virtio6: discovered new tag: shared466machine # [ 1.152610] virtiofs virtio6: virtio_fs_setup_dax: No cache capability467machine # [ 1.157651] virtiofs virtio7: discovered new tag: xchg468machine # [ 1.159515] virtiofs virtio7: virtio_fs_setup_dax: No cache capability469machine # [ 1.186985] systemd[1]: Successfully made /usr/ read-only.470machine # [ 1.189286] systemd[1]: systemd 263-0f0682b 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 +EXPERIMENTAL-ENVVAR)471machine # [ 1.195818] systemd[1]: Detected virtualization kvm.472machine # [ 1.196889] systemd[1]: Detected architecture x86-64.473machine # [ 1.197923] systemd[1]: Running in initrd.474machine # [ 1.199329] systemd[1]: Initializing machine ID from random generator.475machine # [ 1.200779] systemd[1]: Hostname set to <machine>.476machine # [ 1.303988] systemd[1]: bpf-restrict-fs: LSM BPF program attached477machine # [ 1.355623] systemd[1]: Queued start job for default target Initrd Default Target.478machine # [ 1.360533] systemd[1]: Created slice Slice /system/modprobe.479machine # [ 1.361732] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.480machine # [ 1.363135] systemd[1]: Expecting device /dev/disk/by-label/nixos...481machine # [ 1.364263] systemd[1]: Expecting device /dev/hvc0...482machine # [ 1.365131] systemd[1]: Expecting device /dev/ttyS0...483machine # [ 1.366047] systemd[1]: Reached target Path Units.484machine # [ 1.366906] systemd[1]: Reached target Slice Units.485machine # [ 1.367750] systemd[1]: Reached target Swaps.486machine # [ 1.368548] systemd[1]: Reached target Timer Units.487machine # [ 1.369546] systemd[1]: Listening on D-Bus System Message Bus Socket.488machine # [ 1.370813] systemd[1]: Listening on Journal Socket (/dev/log).489machine # [ 1.383712] systemd[1]: Listening on Journal Sockets.490machine # [ 1.384710] systemd[1]: Listening on udev Kernel Socket.491machine # [ 1.385812] systemd[1]: Listening on udev Varlink Socket.492machine # [ 1.386775] systemd[1]: Reached target Socket Units.493machine # [ 1.388720] systemd[1]: Starting Create List of Static Device Nodes...494machine # [ 1.394310] systemd[1]: Starting Load Kernel Module configfs...495machine # [ 1.403446] systemd[1]: Starting Journal Service...496machine # [ 1.413299] systemd[1]: Starting Load Kernel Modules...497machine # [ 1.416121] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os498machine # [ 1.421941] systemd[1]: Starting Coldplug All udev Devices...499machine # [ 1.437379] systemd[1]: Finished Create List of Static Device Nodes.500machine # [ 1.443988] systemd[1]: modprobe@configfs.service: Deactivated successfully.501machine # [ 1.452632] systemd[1]: Finished Load Kernel Module configfs.502machine # [ 1.457161] systemd-journald[65]: Collecting audit messages is disabled.503machine # [ 1.458803] systemd[1]: Kernel Configuration File System skipped, unmet condition check ConditionPathExists=/sys/kernel/config504machine # [ 1.470298] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...505machine # [ 1.481259] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.506machine # [ 1.490450] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev507machine # [ 1.518822] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.508machine # [ 1.528419] systemd[1]: Starting Create Static Device Nodes in /dev...509machine # [ 1.539780] systemd[1]: Finished Load Kernel Modules.510machine # [ 1.548299] systemd[1]: Starting Apply Kernel Variables...511machine # [ 1.571142] systemd[1]: Finished Create Static Device Nodes in /dev.512machine # [ 1.576443] systemd[1]: Reached target Preparation for Local File Systems.513machine # [ 1.582529] systemd[1]: Reached target Local File Systems.514machine # [ 1.437526] systemd-modules-load[66]: Inserted module 'dm_mod'515machine # [ 1.441416] systemd-modules-load[66]: Inserted module 'virtio_balloon'516machine # [ 1.442577] systemd-modules-load[66]: Inserted module 'virtio_gpu'517machine # [ 1.596312] systemd[1]: Starting Rule-based Manager for Device Events and Files...518machine # [ 1.600527] systemd[1]: Started Journal Service.519machine # [ 1.461918] systemd[1]: Finished Apply Kernel Variables.520machine # [ 1.476780] systemd[1]: Starting Create System Files and Directories...521machine # [ 1.506227] systemd[1]: Finished Create System Files and Directories.522machine # [ 1.515277] systemd-udevd[73]: Using default interface naming scheme 'v261'.523machine # [ 1.541122] systemd[1]: Started Rule-based Manager for Device Events and Files.524machine # [ 1.599156] systemd[1]: Finished Coldplug All udev Devices.525machine # [ 1.600102] systemd[1]: Reached target System Initialization.526machine # [ 1.600965] systemd[1]: Reached target Basic System.527machine # [ 1.621143] systemd[1]: Found device /dev/hvc0.528machine # [ 1.631248] systemd[1]: Found device /dev/ttyS0.529machine # [ 1.635080] systemd[1]: Started backdoor.service.530machine # [ 1.654851] backdoor-start[96]: /nix/store/cy0g856jmz5k0chql2vcv1zpinvvyn2a-unit-script-backdoor-start/bin/backdoor-start: line 10: grep: command not found531machine # connecting to host...532machine: Guest shell says: b'Spawning backdoor root shell...\n'533machine: connected to guest root shell534machine: (connecting took 2.43 seconds)535machine: (finished: waiting for the VM to finish booting, in 4.22 seconds)536machine # [ 1.937693] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12537machine # [ 1.958689] serio: i8042 KBD port at 0x60,0x64 irq 1538machine # [ 1.965734] virtio_blk virtio2: 1/0/0 default/read/poll queues539machine # [ 1.968250] serio: i8042 AUX port at 0x60,0x64 irq 12540machine # [ 1.983598] virtio_blk virtio2: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB)541machine # [ 2.016798] ehci-pci 0000:00:1d.7: EHCI Host Controller542machine # [ 2.017590] ehci-pci 0000:00:1d.7: new USB bus registered, assigned bus number 1543machine # [ 2.019579] ehci-pci 0000:00:1d.7: irq 19, io mem 0xfebdb000544machine # [ 2.028258] ehci-pci 0000:00:1d.7: USB 2.0 started, EHCI 1.00545machine # [ 2.030289] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 6.18546machine # [ 2.031511] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1547machine # [ 2.035661] usb usb1: Product: EHCI Host Controller548machine # [ 2.036481] usb usb1: Manufacturer: Linux 6.18.57 ehci_hcd549machine # [ 2.038234] usb usb1: SerialNumber: 0000:00:1d.7550machine # [ 2.041107] hub 1-0:1.0: USB hub found551machine # [ 2.041699] hub 1-0:1.0: 6 ports detected552machine # [ 2.046688] uhci_hcd 0000:00:1d.0: UHCI Host Controller553machine # [ 2.047515] uhci_hcd 0000:00:1d.0: new USB bus registered, assigned bus number 2554machine # [ 2.064071] uhci_hcd 0000:00:1d.0: detected 2 ports555machine # [ 2.065333] uhci_hcd 0000:00:1d.0: irq 16, io port 0x0000c180556machine # [ 2.075511] usb usb2: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.18557machine # [ 2.076717] usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=1558machine # [ 1.936295] (udev-worker)[83]: Network interface NamePolicy= disabled on kernel command line.559machine # [ 1.937480] systemd[1]: Starting Virtual Console Setup...560machine # [ 1.948759] (udev-worker)[89]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.561machine # [ 1.953656] (udev-worker)[89]: Network interface NamePolicy= disabled on kernel command line.562machine # [ 2.105145] usb usb2: Product: UHCI Host Controller563machine # [ 2.105876] usb usb2: Manufacturer: Linux 6.18.57 uhci_hcd564machine # [ 2.108423] SCSI subsystem initialized565machine # [ 1.979504] systemd-vconsole-setup[110]: Configuration of first virtual console was skipped, ignoring remaining ones.566machine # [ 1.982237] systemd[1]: Finished Virtual Console Setup.567machine # [ 2.131756] usb usb2: SerialNumber: 0000:00:1d.0568machine # [ 2.137355] hub 2-0:1.0: USB hub found569machine # [ 2.140538] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input0570machine # [ 2.144220] hub 2-0:1.0: 2 ports detected571machine # [ 2.002869] systemd[1]: Found device /dev/disk/by-label/nixos.572machine # [ 2.003742] systemd[1]: Reached target Initrd Root Device.573machine # [ 2.007067] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos...574machine # [ 2.171561] uhci_hcd 0000:00:1d.1: UHCI Host Controller575machine # [ 2.172348] uhci_hcd 0000:00:1d.1: new USB bus registered, assigned bus number 3576machine # [ 2.179307] uhci_hcd 0000:00:1d.1: detected 2 ports577machine # [ 2.180121] uhci_hcd 0000:00:1d.1: irq 17, io port 0x0000c1a0578machine # [ 2.183421] usb usb3: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.18579machine # [ 2.185247] usb usb3: New USB device strings: Mfr=3, Product=2, SerialNumber=1580machine # [ 2.188243] usb usb3: Product: UHCI Host Controller581machine # [ 2.188982] usb usb3: Manufacturer: Linux 6.18.57 uhci_hcd582machine # [ 2.191574] usb usb3: SerialNumber: 0000:00:1d.1583machine # [ 2.193576] hub 3-0:1.0: USB hub found584machine # [ 2.205322] hub 3-0:1.0: 2 ports detected585machine # [ 2.060335] systemd-fsck[117]: nixos: clean, 12/65536 files, 13019/262144 blocks586machine # [ 2.211096] uhci_hcd 0000:00:1d.2: UHCI Host Controller587machine # [ 2.212113] uhci_hcd 0000:00:1d.2: new USB bus registered, assigned bus number 4588machine # [ 2.069804] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos.589machine # [ 2.225294] uhci_hcd 0000:00:1d.2: detected 2 ports590machine # [ 2.226092] uhci_hcd 0000:00:1d.2: irq 18, io port 0x0000c1c0591machine # [ 2.229511] usb usb4: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.18592machine # [ 2.231006] usb usb4: New USB device strings: Mfr=3, Product=2, SerialNumber=1593machine # [ 2.232286] usb usb4: Product: UHCI Host Controller594machine # [ 2.232997] usb usb4: Manufacturer: Linux 6.18.57 uhci_hcd595machine # [ 2.236271] usb usb4: SerialNumber: 0000:00:1d.2596machine # [ 2.237739] hub 4-0:1.0: USB hub found597machine # [ 2.239551] ahci 0000:00:1f.2: AHCI vers 0001.0000, 32 command slots, 1.5 Gbps, SATA mode598machine # [ 2.240920] hub 4-0:1.0: 2 ports detected599machine # [ 2.245822] ahci 0000:00:1f.2: 6/6 ports implemented (port mask 0x3f)600machine # [ 2.255236] ahci 0000:00:1f.2: flags: 64bit ncq only601machine # [ 2.273239] scsi host0: ahci602machine # [ 2.275551] scsi host1: ahci603machine # [ 2.278261] scsi host2: ahci604machine # [ 2.279246] usb 1-1: new high-speed USB device number 2 using ehci-pci605machine # [ 2.280953] scsi host3: ahci606machine # [ 2.282103] scsi host4: ahci607machine # [ 2.283666] scsi host5: ahci608machine # [ 2.284812] ata1: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc100 irq 47 lpm-pol 1609machine # [ 2.286049] ata2: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc180 irq 47 lpm-pol 1610machine # [ 2.287452] ata3: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc200 irq 47 lpm-pol 1611machine # [ 2.288626] ata4: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc280 irq 47 lpm-pol 1612machine # [ 2.289824] ata5: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc300 irq 47 lpm-pol 1613machine # [ 2.290983] ata6: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc380 irq 47 lpm-pol 1614machine # [ 2.409391] usb 1-1: New USB device found, idVendor=0627, idProduct=0001, bcdDevice= 0.00615machine # [ 2.410641] usb 1-1: New USB device strings: Mfr=1, Product=3, SerialNumber=10616machine # [ 2.412020] usb 1-1: Product: QEMU USB Tablet617machine # [ 2.412733] usb 1-1: Manufacturer: QEMU618machine # [ 2.413425] usb 1-1: SerialNumber: 28754-0000:00:1d.7-1619machine # [ 2.430610] hid: raw HID events driver (C) Jiri Kosina620machine # [ 2.284868] systemd[1]: Mounting /sysroot...621machine # [ 2.605781] ata5: SATA link down (SStatus 0 SControl 300)622machine # [ 2.606773] ata6: SATA link down (SStatus 0 SControl 300)623machine # [ 2.607981] ata1: SATA link down (SStatus 0 SControl 300)624machine # [ 2.608994] ata4: SATA link down (SStatus 0 SControl 300)625machine # [ 2.610086] ata2: SATA link down (SStatus 0 SControl 300)626machine # [ 2.611074] ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 300)627machine # [ 2.612222] ata3.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/100628machine # [ 2.613055] ata3.00: applying bridge limits629machine # [ 2.613877] ata3.00: configured for UDMA/100630machine # [ 2.614935] scsi 2:0:0:0: CD-ROM QEMU QEMU DVD-ROM 2.5+ PQ: 0 ANSI: 5631machine # [ 2.676004] usbcore: registered new interface driver usbhid632machine # [ 2.676838] usbhid: USB HID core driver633machine # [ 2.696383] sr 2:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray634machine # [ 2.706456] 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/input2635machine # [ 2.708078] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:1d.7-1/input0636machine # [ 2.712414] cdrom: Uniform CD-ROM driver Revision: 3.20637machine # [ 2.725916] EXT4-fs (vda): mounted filesystem 1614790b-031f-4d6a-bb61-20cad1f026f6 r/w with ordered data mode. Quota mode: none.638machine # [ 2.586261] systemd[1]: Mounted /sysroot.639machine # [ 2.586917] systemd[1]: Reached target Initrd Root File System.640machine # [ 2.591089] systemd[1]: Starting Mountpoints Configured in the Real Root...641machine # [ 2.609082] systemd-sysroot-fstab-check[152]: /sysroot should be mounted in the initrd, will request daemon-reload.642machine # [ 2.613085] systemd[1]: Reload requested from client PID 152 ('systemd-sysroot') (unit initrd-parse-etc.service)...643machine # [ 2.614493] systemd[1]: Reloading...644machine # [ 2.694236] systemd[1]: Reloading finished in 81 ms.645machine # [ 2.702927] systemd-sysroot-fstab-check[152]: Requesting initrd-fs.target/start/replace...646machine # [ 2.707180] systemd-sysroot-fstab-check[152]: Requesting swap.target/start/replace...647machine # [ 2.711787] systemd[1]: initrd-parse-etc.service: Deactivated successfully.648machine # [ 2.715078] systemd[1]: Finished Mountpoints Configured in the Real Root.649machine # [ 2.715982] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies.650machine # [ 3.285114] systemd[1]: Mounting /sysroot/nix/.ro-store...651machine # [ 3.288141] systemd[1]: Mounting /sysroot/nix/.rw-store...652machine # [ 3.293156] systemd[1]: Mounting /sysroot/run...653machine # [ 3.297155] systemd[1]: Mounting /sysroot/tmp/shared...654machine # [ 3.303077] systemd[1]: Mounting /sysroot/tmp/xchg...655machine # [ 3.340894] systemd[1]: Mounted /sysroot/nix/.ro-store.656machine # [ 3.342948] systemd[1]: Mounted /sysroot/nix/.rw-store.657machine # [ 3.343973] systemd[1]: Mounted /sysroot/run.658machine # [ 3.345156] systemd[1]: Mounted /sysroot/tmp/shared.659machine # [ 3.345870] systemd[1]: Mounted /sysroot/tmp/xchg.660machine # [ 3.349990] systemd[1]: Starting rw-sysroot-nix-store.service...661machine # [ 3.362290] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.662machine # [ 3.363821] systemd[1]: Finished rw-sysroot-nix-store.service.663machine # [ 3.366399] systemd[1]: Mounting /sysroot/nix/store...664machine # [ 3.390083] systemd[1]: Mounted /sysroot/nix/store.665machine # [ 3.391548] systemd[1]: Reached target Initrd File Systems.666machine # [ 3.393764] systemd[1]: Starting Find NixOS closure...667machine # [ 3.396491] systemd[1]: Starting Create Volatile Files and Directories in the Real Root...668machine # [ 3.420061] systemd[1]: Finished Create Volatile Files and Directories in the Real Root.669machine # [ 3.427507] systemd[1]: Finished Find NixOS closure.670machine # [ 3.428739] systemd[1]: Reached target Initrd Default Target.671machine # [ 3.430665] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...672machine # [ 3.441412] systemd[1]: initrd-cleanup.service: Deactivated successfully.673machine # [ 3.442747] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.674machine # [ 3.444164] systemd[1]: Startup finished in 940ms (kernel) + 0 (initrd) + 2.503s (userspace) = 3.443s.675machine: (finished: waiting for unit initrd.target, in 6.31 seconds)676machine: must succeed: systemctl status initrd-fs.target677machine: (finished: must succeed: systemctl status initrd-fs.target, in 0.02 seconds)678machine: waiting for unit initrd.target679machine: (finished: waiting for unit initrd.target, in 0.02 seconds)680machine: waiting for the VM to finish booting681machine # [ 3.817724] systemd[1]: Stopped target Initrd Default Target.682machine # [ 3.819083] systemd[1]: Stopped target Basic System.683machine # [ 3.819860] systemd[1]: Stopped target Initrd Root Device.684machine # [ 3.820812] systemd[1]: Stopped target Path Units.685machine # [ 3.822091] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.686machine # [ 3.823120] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.687machine # [ 3.824467] systemd[1]: Stopped target Slice Units.688machine # [ 3.825435] systemd[1]: Stopped target Socket Units.689machine # [ 3.826573] systemd[1]: Stopped target System Initialization.690machine # [ 3.827877] systemd[1]: Stopped target Swaps.691machine # [ 3.828553] systemd[1]: Stopped target Timer Units.692machine # [ 3.829687] systemd[1]: dbus.socket: Deactivated successfully.693machine # [ 3.830757] systemd[1]: Closed D-Bus System Message Bus Socket.694machine # [ 3.832309] systemd[1]: Stopping backdoor.service...695machine # [ 3.834452] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...696machine # [ 3.835520] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully.697machine # [ 3.837145] systemd[1]: Stopped Find NixOS closure.698machine # [ 3.840133] systemd[1]: Starting rw-sysroot-nix-store.service...699machine # [ 3.841120] systemd[1]: systemd-sysctl.service: Deactivated successfully.700machine # [ 3.843110] systemd[1]: Stopped Apply Kernel Variables.701machine # [ 3.843928] systemd[1]: systemd-modules-load.service: Deactivated successfully.702machine # [ 3.845076] systemd[1]: Stopped Load Kernel Modules.703machine # [ 3.846869] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully.704machine # [ 3.847943] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root.705machine # [ 3.849094] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.706machine # [ 3.851099] systemd[1]: Stopped Create System Files and Directories.707machine # [ 3.851971] systemd[1]: Stopped target Local File Systems.708machine # [ 3.853728] systemd[1]: Stopped target Preparation for Local File Systems.709machine # [ 3.854660] systemd[1]: systemd-udev-trigger.service: Deactivated successfully.710machine # [ 3.855614] systemd[1]: Stopped Coldplug All udev Devices.711machine # [ 3.856405] systemd[1]: Stopping Rule-based Manager for Device Events and Files...712machine # [ 3.857452] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.713machine # [ 3.859756] systemd[1]: Stopped Virtual Console Setup.714machine # [ 3.860517] systemd[1]: backdoor.service: Deactivated successfully.715machine # [ 3.864273] systemd[1]: Stopped backdoor.service.716machine # [ 3.870256] systemd[1]: systemd-udevd.service: Deactivated successfully.717machine # [ 3.876152] systemd[1]: Stopped Rule-based Manager for Device Events and Files.718machine # [ 3.877276] systemd[1]: systemd-udevd-varlink.socket: Deactivated successfully.719machine # [ 3.878288] systemd[1]: Closed udev Varlink Socket.720machine # [ 3.885095] systemd[1]: Starting Cleanup udev Database...721machine # [ 3.885908] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.722machine # [ 3.886987] systemd[1]: Stopped Create Static Device Nodes in /dev.723machine # [ 3.887898] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.724machine # [ 3.890136] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.725machine # [ 3.892149] systemd[1]: kmod-static-nodes.service: Deactivated successfully.726machine # [ 3.893205] systemd[1]: Stopped Create List of Static Device Nodes.727machine # [ 3.895651] systemd[1]: initrd-cleanup.service: Deactivated successfully.728machine # [ 3.898135] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.729machine # [ 3.899557] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.730machine # [ 3.901086] systemd[1]: Finished rw-sysroot-nix-store.service.731machine # [ 3.916675] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.732machine # [ 3.918259] systemd[1]: Finished Cleanup udev Database.733machine # [ 3.920219] systemd[1]: Reached target Switch Root.734machine # [ 3.921805] systemd[1]: Starting NixOS Activation...735machine # [ 3.991300] initrd-nixos-activation-start[232]: booting system configuration /nix/store/l8fq20sqvpsln2vdy6rxiw4iaqx43q34-nixos-system-machine-test736machine # [ 4.018476] initrd-nixos-activation-start[232]: running activation script...737machine # [ 4.414986] initrd-nixos-activation-start[255]: setting up /etc...738machine # [ 4.512117] systemd[1]: initrd-nixos-activation.service: Deactivated successfully.739machine # [ 4.514082] systemd[1]: Finished NixOS Activation.740machine # [ 4.515766] systemd[1]: Starting Switch Root...741machine # [ 4.531278] systemd[1]: Switching root.742machine # [ 4.803339] systemd-journald[65]: Received SIGTERM from PID 1 (systemd).743machine # [ 4.864430] NET: Registered PF_VSOCK protocol family744machine # [ 4.887935] systemd[1]: systemd 263-0f0682b 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 +EXPERIMENTAL-ENVVAR)745machine # [ 4.891884] systemd[1]: Detected virtualization kvm.746machine # [ 4.892566] systemd[1]: Detected architecture x86-64.747machine # [ 4.893360] systemd[1]: Detected first boot.748machine # [ 4.894962] systemd[1]: Initializing machine ID from random generator.749machine # [ 4.985471] systemd[1]: bpf-restrict-fs: LSM BPF program attached750machine # [ 5.230560] systemd[1]: Applying preset policy.751machine # [ 5.443495] systemd[1]: Populated /etc with preset unit settings.752machine # [ 5.594644] systemd[1]: initrd-switch-root.service: Deactivated successfully.753machine # [ 5.596018] systemd[1]: Stopped initrd-switch-root.service.754machine # [ 5.598561] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.755machine # [ 5.600640] systemd[1]: Created slice Slice /system/getty.756machine # [ 5.602052] systemd[1]: Created slice User and Session Slice.757machine # [ 5.602981] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.758machine # [ 5.604266] systemd[1]: Started Forward Password Requests to Wall Directory Watch.759machine # [ 5.605427] systemd[1]: Expecting device /dev/hvc0...760machine # [ 5.606151] systemd[1]: Expecting device /dev/ttyS0...761machine # [ 5.606942] systemd[1]: Reached target Local Encrypted Volumes.762machine # [ 5.607781] systemd[1]: Stopped target initrd-fs.target.763machine # [ 5.620344] systemd[1]: Stopped target initrd-root-fs.target.764machine # [ 5.621142] systemd[1]: Stopped target initrd-switch-root.target.765machine # [ 5.621995] systemd[1]: Reached target Virtual Machines and Containers.766machine # [ 5.622898] systemd[1]: Reached target Path Units.767machine # [ 5.623608] systemd[1]: Reached target Remote File Systems.768machine # [ 5.624414] systemd[1]: Reached target Slice Units.769machine # [ 5.625119] systemd[1]: Reached target Swaps.770machine # [ 5.626704] systemd[1]: Listening on Query the User Interactively for a Password.771machine # [ 5.629234] systemd[1]: Listening on Process Core Dump Socket.772machine # [ 5.630953] systemd[1]: Listening on Credential Encryption/Decryption.773machine # [ 5.632951] systemd[1]: Listening on Factory Reset Management.774machine # [ 5.634088] systemd[1]: Listening on Hostname Service Socket.775machine # [ 5.636759] systemd[1]: Starting Journal Log Access Socket...776machine # [ 5.638138] systemd[1]: Listening on Journal Audit Socket.777machine # [ 5.640653] systemd[1]: Listening on Console Output Muting Service Socket.778machine # [ 5.641802] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.779machine # [ 5.642926] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os780machine # [ 5.644244] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki781machine # [ 5.647554] systemd[1]: Listening on Disk Repartitioning Service Socket.782machine # [ 5.648609] systemd[1]: Listening on udev Varlink Socket.783machine # [ 5.650838] systemd[1]: Mounting Huge Pages File System...784machine # [ 5.654764] systemd[1]: Mounting POSIX Message Queue File System...785machine # [ 5.661858] systemd[1]: Mounting Kernel Debug File System...786machine # [ 5.670249] systemd[1]: Mounting Kernel Trace File System...787machine # [ 5.678989] systemd[1]: Starting Create List of Static Device Nodes...788machine # [ 5.695267] systemd[1]: Starting Load Kernel Module configfs...789machine # [ 5.702679] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm790machine # [ 5.710368] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore791machine # [ 5.724099] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse792machine # [ 5.737664] systemd[1]: Mounting FUSE Control File System...793machine # [ 5.739497] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67794machine # [ 5.750295] systemd[1]: Starting Journal Service...795machine # [ 5.756283] systemd[1]: Starting Load Kernel Modules...796machine # [ 5.766976] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...797machine # [ 5.783510] systemd[1]: Starting Remount Root and Kernel File Systems...798machine # [ 5.790922] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os799machine # [ 5.798876] systemd-journald[326]: Collecting audit messages is enabled.800machine # [ 5.804262] systemd[1]: Starting Coldplug All udev Devices...801machine # [ 5.816963] systemd[1]: Listening on Journal Log Access Socket.802machine # [ 5.672173] systemd[1]: Queued start job for default target Multi-User System.803machine # [ 5.673381] systemd[1]: Unnecessary job was removed for /sys/devices/virtual/tty/hvc0.804machine # [ 5.822480] systemd[1]: Started Journal Service.805machine # [ 5.676349] systemd[1]: Unnecessary job was removed for /sys/devices/pnp0/00:03/00:03:0/00:03:0.0/tty/ttyS0.806machine # [ 5.678334] systemd[1]: systemd-journald.service: Deactivated successfully.807machine # [ 5.684400] systemd[1]: Mounted Huge Pages File System.808machine # [ 5.686149] systemd[1]: Mounted POSIX Message Queue File System.809machine # [ 5.688139] systemd[1]: Mounted Kernel Debug File System.810machine # [ 5.688911] systemd[1]: Mounted Kernel Trace File System.811machine # [ 5.694779] systemd[1]: Finished Create List of Static Device Nodes.812machine # [ 5.699765] systemd[1]: modprobe@configfs.service: Deactivated successfully.813machine # [ 5.850672] loop: module loaded814machine # [ 5.704212] systemd[1]: Finished Load Kernel Module configfs.815machine # [ 5.705049] systemd[1]: Mounted FUSE Control File System.816machine # [ 5.707744] systemd-modules-load[327]: Inserted module 'loop'817machine # [ 5.720288] systemd[1]: Finished Load Kernel Modules.818machine # [ 5.729964] systemd[1]: Mounting Kernel Configuration File System...819machine # [ 5.737516] systemd[1]: Starting Firewall...820machine # [ 5.742164] systemd[1]: Starting Apply Kernel Variables...821machine # [ 5.898276] EXT4-fs (vda): re-mounted 1614790b-031f-4d6a-bb61-20cad1f026f6.822machine # [ 5.761072] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...823machine # [ 5.772501] systemd-oomd[329]: No swap; memory pressure usage will be degraded824machine # [ 5.782891] systemd[1]: Finished Remount Root and Kernel File Systems.825machine # [ 5.786220] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.826machine # [ 5.802128] systemd[1]: Listening on Disk Image Download Service Socket.827machine # [ 5.807164] systemd[1]: Starting Grow Root File System...828machine # [ 5.815735] systemd[1]: Starting Flush Journal to Persistent Storage...829machine # [ 5.819677] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore830machine # [ 5.835157] systemd[1]: Starting Load/Save OS Random Seed...831machine # [ 5.836132] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os832machine # [ 5.896653] systemd[1]: Finished Apply Kernel Variables.833machine # [ 6.061492] EXT4-fs (vda): resizing filesystem from 262144 to 262144 blocks834machine # [ 5.928378] systemd[1]: Mounted Kernel Configuration File System.835machine # [ 6.083818] systemd-journald[326]: Received client request to flush runtime journal.836machine # [ 6.307362] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.837machine # [ 6.308708] systemd[1]: Starting Create Static Device Nodes in /dev...838machine # [ 6.310791] systemd[1]: Finished Coldplug All udev Devices.839machine # [ 6.313324] systemd[1]: Finished Create Static Device Nodes in /dev.840machine # [ 6.314614] systemd[1]: Reached target Preparation for Local File Systems.841machine # [ 6.315935] systemd[1]: Starting Rule-based Manager for Device Events and Files...842machine # [ 6.318072] systemd-growfs[347]: Successfully resized "/" to 1G bytes.843machine # [ 6.318933] systemd[1]: Finished Grow Root File System.844machine # [ 6.320455] systemd-udevd[365]: Using default interface naming scheme 'v261'.845machine # [ 6.322469] systemd[1]: Started Rule-based Manager for Device Events and Files.846machine # [ 6.323624] systemd[1]: Finished Load/Save OS Random Seed.847machine # [ 6.325129] systemd[1]: Reached target First Boot Complete.848machine # [ 6.325888] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse849machine # [ 6.327632] systemd[1]: Finished Flush Journal to Persistent Storage.850machine # [ 6.373886] systemd[1]: Found device /dev/hvc0.851machine # [ 6.406988] systemd[1]: Found device /dev/ttyS0.852machine # [ 6.423645] (udev-worker)[394]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.853machine # [ 6.425967] (udev-worker)[394]: Network interface NamePolicy= disabled on kernel command line.854machine # [ 6.428314] (udev-worker)[385]: Network interface NamePolicy= disabled on kernel command line.855machine # [ 6.453210] systemd[1]: Mounting /run/wrappers...856machine # [ 6.491356] systemd[1]: Mounted /run/wrappers.857machine # [ 6.493518] systemd[1]: Reached target Local File Systems.858machine # [ 6.496204] systemd[1]: Listening on Boot Loader Control Service Socket.859machine # [ 6.501153] systemd[1]: Starting Create SUID/SGID Wrappers...860machine # [ 6.503106] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.861machine # [ 6.509289] systemd[1]: Starting Save Transient machine-id to Disk...862machine # [ 6.518075] systemd[1]: Starting Create System Files and Directories...863machine # [ 6.623878] systemd[1]: Condition check resulted in Virtio network device being skipped.864machine # [ 6.627931] systemd[1]: Condition check resulted in Virtio network device being skipped.865machine # [ 6.629418] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore866machine # [ 6.632134] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.867machine # [ 6.633857] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67868machine # [ 6.636913] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore869machine # [ 6.640070] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os870machine # [ 6.641264] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os871machine # [ 6.665382] systemd[1]: Finished Create System Files and Directories.872machine # [ 6.676453] systemd[1]: Starting Rebuild Journal Catalog...873machine # [ 6.684898] systemd[1]: Starting Record System Boot/Shutdown in UTMP...874machine # [ 6.780465] systemd[1]: Finished Record System Boot/Shutdown in UTMP.875machine # [ 6.808505] systemd[1]: Finished Rebuild Journal Catalog.876machine # [ 6.813268] systemd[1]: Starting Update is Completed...877machine # [ 6.865149] systemd[1]: Finished Update is Completed.878machine # [ 7.073984] mousedev: PS/2 mouse device common for all mice879machine # [ 7.082950] bochs-drm 0000:00:01.0: vgaarb: deactivate vga console880machine # [ 7.079896] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.881machine # [ 7.083182] systemd[1]: Finished Create SUID/SGID Wrappers.882machine # [ 7.085583] systemd[1]: Reached target System Initialization.883machine # [ 7.183749] rtc_cmos PNP0B00:00: RTC can wake from S4884machine # [ 7.218653] parport_pc 00:02: reported by Plug and Play ACPI885machine # [ 7.218750] parport0: PC-style at 0x378, irq 7 [PCSPP(,...)]886machine # [ 7.232161] rtc_cmos PNP0B00:00: registered as rtc0887machine # [ 7.233594] rtc_cmos PNP0B00:00: setting system clock to 2026-10-24T03:07:21 UTC (1792811241)888machine # [ 7.233687] rtc_cmos PNP0B00:00: alarms up to one day, y3k, 242 bytes nvram, hpet irqs889machine # [ 7.234458] systemd-journald[326]: Time jumped backwards, rotating.890machine # [ 7.251306] Console: switching to colour dummy device 80x25891machine # [ 7.280580] input: QEMU Virtio Keyboard as /devices/pci0000:00/0000:00:06.0/virtio4/input/input3892machine # [ 7.325074] lpc_ich 0000:00:1f.0: I/O space for GPIO uninitialized893machine # connecting to host...894machine: Guest shell says: b'Spawning backdoor root shell...\n'895machine: connected to guest root shell896machine: (connecting took 3.50 seconds)897machine: (finished: waiting for the VM to finish booting, in 3.50 seconds)898(finished: subtest: testing initrd backdoor, in 9.85 seconds)899subtest: handover to stage-2 systemd works900machine: waiting for unit multi-user.target901machine # [ 7.466691] [drm] Found bochs VGA, ID 0xb0c5.902machine # [ 7.466694] [drm] Framebuffer size 16384 kB @ 0xfd000000, mmio @ 0xfebd0000.903machine # [ 7.496314] bochs-drm 0000:00:01.0: [drm] Registered 1 planes with drm panic904machine # [ 7.497050] [drm] Initialized bochs-drm 1.0.0 for 0000:00:01.0 on minor 0905machine # [ 7.500877] systemd[1]: Started Discard unused filesystem blocks once a week.906machine # [ 7.506044] systemd[1]: Started Daily Cleanup of Temporary Directories.907machine # [ 7.508439] systemd[1]: Reached target Timer Units.908machine # [ 7.509427] systemd[1]: Listening on D-Bus System Message Bus Socket.909machine # [ 7.513580] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.910machine # [ 7.517171] nsncd[544]: Oct 24 03:07:21.647 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"911machine # [ 7.520577] systemd[1]: Reached target Socket Units.912machine # [ 7.521723] systemd[1]: Reached target Basic System.913machine # [ 7.523476] systemd[1]: Started backdoor.service.914machine # [ 7.526552] dbus-broker-launch[551]: Looking up NSS user entry for 'systemd-timesync'...915machine # [ 7.527683] dbus-broker-launch[551]: NSS returned no entry for 'systemd-timesync'916machine # [ 7.528690] dbus-broker-launch[551]: Invalid user-name in /nix/store/vsgk3swqdm3r6cy8rjzppghng954avzi-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"917machine # [ 7.530984] systemd[1]: Starting Import lastlog data into lastlog2 database...918machine # [ 7.532231] systemd[1]: Starting Name Service Cache Daemon (nsncd)...919machine # [ 7.533557] systemd[1]: Starting Post-Boot Actions...920machine # [ 7.535289] systemd[1]: Started Reset console on configuration changes.921machine # [ 7.536873] systemd[1]: Starting resolvconf update...922machine # [ 7.537573] systemd[1]: Finished Firewall.923machine # [ 7.538750] systemd[1]: Starting D-Bus System Message Bus...924machine # [ 7.539607] systemd[1]: Finished Post-Boot Actions.925machine # [ 7.540530] systemd[1]: Started Name Service Cache Daemon (nsncd).926machine # [ 7.541492] systemd[1]: Reached target Host and Network Name Lookups.927machine # [ 7.542390] systemd[1]: Reached target User and Group Name Lookups.928machine # [ 7.544049] systemd[1]: Starting User Login Management...929machine # [ 7.544814] systemd[1]: Finished Import lastlog data into lastlog2 database.930machine # [ 7.546028] systemd-logind[567]: New seat seat0.931machine # [ 7.546932] dbus-broker-launch[551]: Ready932machine # [ 7.585156] systemd[1]: Started User Login Management.933machine # [ 7.586076] systemd[1]: Started D-Bus System Message Bus.934machine # [ 7.617619] i801_smbus 0000:00:1f.3: SMBus using PCI interrupt935machine # [ 7.617744] i2c i2c-0: Memory type 0x07 not supported yet, not instantiating SPD936machine # [ 7.698557] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input5937machine # [ 7.626353] systemd[1]: Stopped target Host and Network Name Lookups.938machine # [ 7.627336] systemd[1]: Stopping Host and Network Name Lookups...939machine # [ 7.628844] systemd[1]: Stopped target User and Group Name Lookups.940machine # [ 7.630200] systemd[1]: Stopping User and Group Name Lookups...941machine # [ 7.637054] systemd[1]: Starting linger-users.service...942machine # [ 7.638892] systemd[1]: Stopping Name Service Cache Daemon (nsncd)...943machine # [ 7.644673] systemd[1]: nscd.service: Deactivated successfully.944machine # [ 7.648181] systemd[1]: Stopped Name Service Cache Daemon (nsncd).945machine # [ 7.663356] systemd-logind[567]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard)946machine # [ 7.698889] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input4947machine # [ 7.722544] Console: switching to colour frame buffer device 160x50948machine # [ 7.814910] bochs-drm 0000:00:01.0: [drm] fb0: bochs-drmdrmfb frame buffer device949machine # [ 7.681103] systemd[1]: Starting Name Service Cache Daemon (nsncd)...950machine # [ 7.691959] systemd[1]: Starting Virtual Console Setup...951machine # [ 7.726801] systemd[1]: linger-users.service: Deactivated successfully.952machine # [ 7.730764] systemd[1]: Finished linger-users.service.953machine # [ 7.741690] systemd[1]: Finished resolvconf update.954machine # [ 7.749114] systemd[1]: Reached target Preparation for Network.955machine # [ 7.758363] systemd[1]: Starting DHCP Client...956machine # [ 7.763282] systemd[1]: Starting Address configuration of eth1...957machine # [ 7.772947] nsncd[640]: Oct 24 03:07:22.185 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"958machine # [ 7.782455] systemd[1]: Starting Extra networking commands....959machine # [ 7.790196] systemd[1]: Started Name Service Cache Daemon (nsncd).960machine # [ 7.796769] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.961machine # [ 7.802305] systemd[1]: Stopped Virtual Console Setup.962machine # [ 7.950655] ppdev: user-space parallel port driver963machine # [ 7.816659] systemd[1]: Reached target Host and Network Name Lookups.964machine # [ 7.818696] systemd[1]: Reached target User and Group Name Lookups.965machine # [ 7.848080] systemd-logind[567]: Watching system buttons on /dev/input/event2 (QEMU Virtio Keyboard)966machine # [ 7.883934] systemd[1]: Starting Virtual Console Setup...967machine # [ 8.073415] iTCO_wdt iTCO_wdt.1.auto: Found a ICH9 TCO device (Version=2, TCOBASE=0x0660)968machine # [ 8.096948] iTCO_wdt iTCO_wdt.1.auto: initialized. heartbeat=30 sec (nowayout=0)969machine # [ 7.958665] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.970machine # [ 7.962204] systemd[1]: Stopped Virtual Console Setup.971machine # [ 7.981897] systemd[1]: Starting Virtual Console Setup...972machine # [ 8.023436] network-addresses-eth1-start[650]: adding address 192.168.1.1/24... done973machine # [ 8.051924] network-addresses-eth1-start[650]: adding address 2001:db8:1::1/64... done974machine # [ 8.087836] systemd[1]: Finished Address configuration of eth1.975machine # [ 8.096499] systemd[1]: Finished Save Transient machine-id to Disk.976machine # [ 8.320009] kvm_amd: TSC scaling supported977machine # [ 8.320490] kvm_amd: Nested Virtualization enabled978machine # [ 8.320972] kvm_amd: Nested Paging enabled979machine # [ 8.321831] kvm_amd: LBR virtualization supported980machine # [ 8.322535] kvm_amd: Virtual VMLOAD VMSAVE supported981machine # [ 8.323071] kvm_amd: Virtual GIF supported982machine # [ 8.323791] kvm_amd: Virtual NMI enabled983machine # [ 8.184790] dhcpcd[676]: dhcpcd-10.3.2 starting984machine # [ 8.192333] dhcpcd[732]: dev: loaded udev985machine # [ 8.210232] systemd[1]: Finished Extra networking commands..986machine # [ 8.215352] systemd[1]: Reached target Network.987machine # [ 8.217278] systemd[1]: Starting Permit User Sessions...988machine # [ 8.368726] 8021q: 802.1Q VLAN Support v1.8989machine # [ 8.369445] 8021q: adding VLAN 0 to HW filter on device eth1990machine # [ 8.379756] EDAC MC: Ver: 3.0.0991machine # [ 8.266090] systemd[1]: Finished Permit User Sessions.992machine # [ 8.266892] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.993machine # [ 8.272971] systemd[1]: Started Getty on tty1.994machine # [ 8.273732] systemd[1]: Reached target Login Prompts.995machine # [ 8.473552] cfg80211: Loading compiled-in X.509 certificates for regulatory database996machine # [ 8.476210] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'997machine # [ 8.476840] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'998machine # [ 8.478945] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -2999machine # [ 8.479757] cfg80211: failed to load regulatory.db1000machine # [ 8.508906] 8021q: adding VLAN 0 to HW filter on device eth01001machine # [ 8.362745] dhcpcd[732]: eth0: waiting for carrier1002machine # [ 8.363612] dhcpcd[732]: eth0: carrier acquired1003machine # [ 8.368831] dhcpcd[732]: DUID 00:01:00:01:32:6e:dd:6a:52:54:00:12:34:561004machine # [ 8.369929] dhcpcd[732]: eth0: IAID 00:12:34:561005machine # [ 8.370786] dhcpcd[732]: eth0: adding address fe80::5054:ff:fe12:34561006machine # [ 8.415163] systemd-vconsole-setup[675]: Configuration of first virtual console was skipped, ignoring remaining ones.1007machine # [ 8.418402] systemd[1]: Finished Virtual Console Setup.1008machine # [ 8.428282] dhcpcd[732]: eth0: soliciting a DHCP lease1009machine # [ 8.583897] NET: Registered PF_PACKET protocol family1010machine # [ 8.441533] dhcpcd[732]: eth0: offered 10.0.2.15 from 10.0.2.21011machine # [ 8.443156] dhcpcd[732]: eth0: probing address 10.0.2.15/241012machine # [ 8.720859] systemd[1]: etc-machine\x2did.mount: Deactivated successfully.1013machine # [ 9.844402] dhcpcd[732]: eth0: soliciting an IPv6 router1014machine # [ 9.846105] dhcpcd[732]: eth0: Router Advertisement from fe80::21015machine # [ 9.846926] dhcpcd[732]: eth0: adding address fec0::5054:ff:fe12:3456/641016machine # [ 9.847804] dhcpcd[732]: eth0: adding route to fec0::/641017machine # [ 9.848624] dhcpcd[732]: eth0: adding default route via fe80::21018machine # [ 13.417700] dhcpcd[732]: eth0: leased 10.0.2.15 for 86400 seconds1019machine # [ 13.420685] dhcpcd[732]: eth0: adding route to 10.0.2.0/241020machine # [ 13.423711] dhcpcd[732]: eth0: adding default route via 10.0.2.21021machine # [ 13.502818] systemd[1]: Started DHCP Client.1022machine # [ 13.505278] systemd[1]: Reached target Multi-User System.1023machine # [ 13.506433] systemd[1]: Startup finished in 940ms (kernel) + 3.755s (initrd) + 8.810s (userspace) = 13.506s.1024machine: (finished: waiting for unit multi-user.target, in 6.70 seconds)1025machine: must succeed: systemd-analyze | grep -q '(initrd)'1026machine: (finished: must succeed: systemd-analyze | grep -q '(initrd)', in 0.03 seconds)1027machine: must succeed: touch /testfile1028machine: (finished: must succeed: touch /testfile, in 0.01 seconds)1029machine: must fail: touch /nix/store/testfile1030machine # touch: cannot touch '/nix/store/testfile': Read-only file system1031machine: (finished: must fail: touch /nix/store/testfile, in 0.01 seconds)1032machine: must succeed: [ -e /run/booted-system ]1033machine: (finished: must succeed: [ -e /run/booted-system ], in 0.01 seconds)1034machine: must succeed: [ -e /sys/class ]1035machine: (finished: must succeed: [ -e /sys/class ], in 0.01 seconds)1036machine: must succeed: [ -e /dev/null ]1037machine: (finished: must succeed: [ -e /dev/null ], in 0.01 seconds)1038machine: must succeed: [ -e /proc/1 ]1039machine: (finished: must succeed: [ -e /proc/1 ], in 0.01 seconds)1040machine: must succeed: [ -e /dev/shm ]1041machine: (finished: must succeed: [ -e /dev/shm ], in 0.01 seconds)1042machine: must succeed: [ -e /dev/pts/ptmx ]1043machine: (finished: must succeed: [ -e /dev/pts/ptmx ], in 0.01 seconds)1044machine: must succeed: [ -e /run/keys ]1045machine: (finished: must succeed: [ -e /run/keys ], in 0.01 seconds)1046machine: must succeed: [ ! -e /nixos-closure ]1047machine: (finished: must succeed: [ ! -e /nixos-closure ], in 0.01 seconds)1048(finished: subtest: handover to stage-2 systemd works, in 6.82 seconds)1049subtest: groups work1050machine: must fail: journalctl -b 0 | grep 'systemd-udevd.*Unknown group.*ignoring'1051machine: (finished: must fail: journalctl -b 0 | grep 'systemd-udevd.*Unknown group.*ignoring', in 0.02 seconds)1052(finished: subtest: groups work, in 0.02 seconds)1053subtest: growfs works1054machine: must succeed: df --output=avail / | sed 1d1055machine: (finished: must succeed: df --output=avail / | sed 1d, in 0.02 seconds)1056machine: waiting for the VM to power off1057additionally exposed symbols:1058 machine,1059 vlan1,1060 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_ssh1061machine # [ 14.156364] systemd-logind[567]: poweroff requested from client PID 907 ('poweroff') (unit backdoor.service)...1062machine # [ 14.158845] systemd-logind[567]: System is powering down.1063machine # [ 14.165722] systemd-logind[567]: The system will power off now!1064machine # [ 14.172890] systemd[1]: Removed slice Slice /system/modprobe.1065machine # [ 14.174217] systemd[1]: Stopped target Multi-User System.1066machine # [ 14.175344] systemd[1]: Stopped target Login Prompts.1067machine # [ 14.176426] systemd[1]: Stopped target Virtual Machines and Containers.1068machine # [ 14.178148] systemd[1]: Stopped target Host and Network Name Lookups.1069machine # [ 14.179630] systemd[1]: Stopped target Timer Units.1070machine # [ 14.180446] systemd[1]: fstrim.timer: Deactivated successfully.1071machine # [ 14.181336] systemd[1]: Stopped Discard unused filesystem blocks once a week.1072machine # [ 14.183070] systemd[1]: systemd-tmpfiles-clean.timer: Deactivated successfully.1073machine # [ 14.184120] systemd[1]: Stopped Daily Cleanup of Temporary Directories.1074machine # [ 14.185048] systemd[1]: systemd-rfkill.socket: Deactivated successfully.1075machine # [ 14.185921] systemd[1]: Closed Load/Save RF Kill Switch Status /dev/rfkill Watch.1076machine # [ 14.187602] systemd[1]: Mounting /run/initramfs...1077machine # [ 14.189238] systemd[1]: Stopping backdoor.service...1078machine # [ 14.190847] dhcpcd[732]: received SIGTERM, stopping1079machine # [ 14.191762] dhcpcd[732]: eth0: removing interface1080machine # [ 14.193207] dhcpcd[732]: eth0: deleting address fec0::5054:ff:fe12:3456/641081machine # [ 14.194745] systemd[1]: Stopping DHCP Client...1082machine # [ 14.196265] dhcpcd[732]: eth0: deleting route to fec0::/641083machine # [ 14.197886] systemd[1]: Stopping Getty on tty1...1084machine # [ 14.198705] dhcpcd[732]: eth0: deleting default route via fe80::21085machine # [ 14.200150] systemd[1]: lastlog2-import.service: Deactivated successfully.1086machine # [ 14.201319] dhcpcd[732]: script_status: /nix/store/7vffryhnghns5izj11k35dmnc06avddj-dhcpcd-10.3.2/libexec/dhcpcd-run-hooks: Terminated1087machine # [ 14.203047] systemd[1]: Stopped Import lastlog data into lastlog2 database.1088machine # [ 14.204068] dhcpcd[732]: eth0: deleting address fe80::5054:ff:fe12:34561089machine # [ 14.204974] dhcpcd[732]: eth0: deleting route to 10.0.2.0/241090machine # [ 14.208170] dhcpcd[732]: eth0: deleting default route via 10.0.2.21091machine # [ 14.209087] systemd[1]: Stopping Address configuration of eth1...1092machine # [ 14.216116] systemd[1]: Stopping Post-Boot Actions...1093machine # [ 14.216904] systemd[1]: reload-systemd-vconsole-setup.service: Deactivated successfully.1094machine # [ 14.218935] systemd[1]: Stopped Reset console on configuration changes.1095machine # [ 14.223280] systemd[1]: Stopping User Login Management...1096machine # [ 14.224315] systemd[1]: systemd-machine-id-commit.service: Deactivated successfully.1097machine # [ 14.227346] dhcpcd[732]: dhcpcd exited1098machine # [ 14.229233] systemd[1]: Stopped Save Transient machine-id to Disk.1099machine # [ 14.231418] systemd[1]: Stopped target First Boot Complete.1100machine # [ 14.232689] systemd[1]: Stopping Userspace Out-Of-Memory (OOM) Killer...1101machine # [ 14.246329] systemd[1]: Stopping Load/Save OS Random Seed...1102machine # [ 14.259274] systemd[1]: systemd-oomd.service: Deactivated successfully.1103machine # [ 14.264879] systemd[1]: Stopped Userspace Out-Of-Memory (OOM) Killer.1104machine # [ 14.272930] systemd[1]: backdoor.service: Deactivated successfully.1105machine # [ 14.273968] systemd[1]: Stopped backdoor.service.1106machine # [ 14.275939] network-addresses-eth1-pre-stop[912]: deleting address 192.168.1.1/24... done1107machine # [ 14.280693] systemd[1]: systemd-logind.service: Deactivated successfully.1108machine # [ 14.283234] systemd[1]: Stopped User Login Management.1109machine # [ 14.290375] systemd[1]: dhcpcd.service: Deactivated successfully.1110machine # [ 14.291608] systemd[1]: Stopped DHCP Client.1111machine # [ 14.293203] systemd[1]: dhcpcd.service: Consumed 164ms CPU time over 6.531s wall clock time, 5M memory peak, 8K written to disk, 96B incoming IP traffic, 56B outgoing IP traffic.1112machine # [ 14.295343] network-addresses-eth1-pre-stop[912]: deleting address 2001:db8:1::1/64... done1113machine # [ 14.301064] systemd[1]: getty@tty1.service: Deactivated successfully.1114machine # [ 14.304128] systemd[1]: Stopped Getty on tty1.1115machine # [ 14.311287] systemd[1]: Mounted /run/initramfs.1116machine # [ 14.312582] systemd[1]: network-addresses-eth1.service: Deactivated successfully.1117machine # [ 14.314179] systemd[1]: Stopped Address configuration of eth1.1118machine # [ 14.315744] systemd[1]: post-boot.service: Deactivated successfully.1119machine # [ 14.317240] systemd[1]: Stopped Post-Boot Actions.1120machine # [ 14.323068] systemd[1]: Removed slice Slice /system/getty.1121machine # [ 14.325680] systemd[1]: Starting Generate shutdown ramfs...1122machine # [ 14.328194] systemd[1]: Stopping Permit User Sessions...1123machine # [ 14.355961] systemd[1]: systemd-user-sessions.service: Deactivated successfully.1124machine # [ 14.359230] systemd[1]: Stopped Permit User Sessions.1125machine # [ 14.360046] systemd[1]: Stopped target Network.1126machine # [ 14.360713] systemd[1]: Stopped target User and Group Name Lookups.1127machine # [ 14.361560] systemd[1]: Stopped target Remote File Systems.1128machine # [ 14.362334] systemd[1]: network-local-commands.service: Deactivated successfully.1129machine # [ 14.363363] systemd[1]: Stopped Extra networking commands..1130machine # [ 14.366187] systemd[1]: Stopped target Preparation for Network.1131machine # [ 14.369188] systemd[1]: Stopping Firewall...1132machine # [ 14.369900] systemd[1]: Stopping Name Service Cache Daemon (nsncd)...1133machine # [ 14.371425] systemd[1]: resolvconf.service: Deactivated successfully.1134machine # [ 14.373158] systemd[1]: Stopped resolvconf update.1135machine # [ 14.376147] systemd[1]: nscd.service: Deactivated successfully.1136machine # [ 14.381102] systemd[1]: Stopped Name Service Cache Daemon (nsncd).1137machine # [ 14.389814] systemd[1]: Stopped target Basic System.1138machine # [ 14.390893] systemd[1]: Stopped target Path Units.1139machine # [ 14.392568] systemd[1]: Stopped target Slice Units.1140machine # [ 14.395534] systemd[1]: Removed slice User and Session Slice.1141machine # [ 14.396536] systemd[1]: Stopped target Socket Units.1142machine # [ 14.398398] systemd[1]: systemd-hostnamed.socket: Deactivated successfully.1143machine # [ 14.399521] systemd[1]: Closed Hostname Service Socket.1144machine # [ 14.400388] systemd[1]: systemd-importd.socket: Deactivated successfully.1145machine # [ 14.402284] systemd[1]: Closed Disk Image Download Service Socket.1146machine # [ 14.403293] systemd[1]: systemd-machined.socket: Deactivated successfully.1147machine # [ 14.405265] systemd[1]: Closed Virtual Machine and Container Registration Service Socket.1148machine # [ 14.406439] systemd[1]: systemd-mute-console.socket: Deactivated successfully.1149machine # [ 14.408820] systemd[1]: Closed Console Output Muting Service Socket.1150machine # [ 14.411156] systemd[1]: systemd-oomd.socket: Deactivated successfully.1151machine # [ 14.412080] systemd[1]: Closed Userspace Out-Of-Memory (OOM) Killer Socket.1152machine # [ 14.412989] systemd[1]: systemd-repart.socket: Deactivated successfully.1153machine # [ 14.413890] systemd[1]: Closed Disk Repartitioning Service Socket.1154machine # [ 14.416802] dbus-broker[611]: Dispatched 840 messages @ 2(±3)μs / message.1155machine # [ 14.419253] systemd[1]: Stopping D-Bus System Message Bus...1156machine # [ 14.421526] systemd[1]: dbus-broker.service: Deactivated successfully.1157machine # [ 14.424926] systemd[1]: Stopped D-Bus System Message Bus.1158machine # [ 14.429918] systemd[1]: dbus.socket: Deactivated successfully.1159machine # [ 14.431764] systemd[1]: Closed D-Bus System Message Bus Socket.1160machine # [ 14.434132] systemd[1]: Stopped target System Initialization.1161machine # [ 14.434995] systemd[1]: Stopped target Local Encrypted Volumes.1162machine # [ 14.435920] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.1163machine # [ 14.437160] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.1164machine # [ 14.438778] systemd[1]: systemd-ask-password-wall.path: Deactivated successfully.1165machine # [ 14.440190] systemd[1]: Stopped Forward Password Requests to Wall Directory Watch.1166machine # [ 14.441296] systemd[1]: systemd-sysctl.service: Deactivated successfully.1167machine # [ 14.442229] systemd[1]: Stopped Apply Kernel Variables.1168machine # [ 14.444273] systemd[1]: systemd-coredump.socket: Deactivated successfully.1169machine # [ 14.445243] systemd[1]: Closed Process Core Dump Socket.1170machine # [ 14.446082] systemd[1]: systemd-update-done.service: Deactivated successfully.1171machine # [ 14.447031] systemd[1]: Stopped Update is Completed.1172machine # [ 14.447761] systemd[1]: systemd-journal-catalog-update.service: Deactivated successfully.1173machine # [ 14.448824] systemd[1]: Stopped Rebuild Journal Catalog.1174machine # [ 14.454058] systemd[1]: Stopping Record System Boot/Shutdown in UTMP...1175machine # [ 14.458797] make-initrd-ng[932]: /etc/initrd-release -> /nix/store/5q8nz4dp0xczsan1plj0vvm2awvsq94s-etc-os-release1176machine # [ 14.460596] make-initrd-ng[932]: /etc/os-release -> /nix/store/5q8nz4dp0xczsan1plj0vvm2awvsq94s-etc-os-release1177machine # [ 14.462799] make-initrd-ng[932]: /shutdown -> /nix/store/m2hgm6qr9m0wzz7rq7p9q48pz50gnyxj-systemd-263-0f0682b/lib/systemd/systemd-shutdown1178machine # [ 14.491566] systemd[1]: systemd-update-utmp.service: Deactivated successfully.1179machine # [ 14.494158] systemd[1]: Stopped Record System Boot/Shutdown in UTMP.1180machine # [ 14.496292] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.1181machine # [ 14.497302] systemd[1]: Stopped Create System Files and Directories.1182machine # [ 14.498261] systemd[1]: Stopped target Local File Systems.1183machine # [ 14.504390] systemd[1]: Unmounting /nix/.ro-store...1184machine # [ 14.510327] systemd[1]: Unmounting /nix/.rw-store...1185machine # [ 14.514566] systemd[1]: Unmounting /run/keys...1186machine # [ 14.519382] systemd[1]: Unmounting /run/wrappers...1187machine # [ 14.541440] systemd[1]: Unmounting /tmp/shared...1188machine # [ 14.563144] systemd[1]: Unmounting /tmp/xchg...1189machine # [ 14.563942] systemd[1]: systemd-growfs-root.service: Deactivated successfully.1190machine # [ 14.565083] systemd[1]: Stopped Grow Root File System.1191machine # [ 14.574436] systemd[1]: firewall.service: Deactivated successfully.1192machine # [ 14.584788] systemd[1]: Stopped Firewall.1193machine # [ 14.585845] systemd[1]: systemd-modules-load.service: Deactivated successfully.1194machine # [ 14.590842] systemd[1]: Stopped Load Kernel Modules.1195machine # [ 14.591597] systemd[1]: generate-shutdown-ramfs.service: Deactivated successfully.1196machine # [ 14.598496] systemd[1]: Finished Generate shutdown ramfs.1197machine # [ 14.628039] systemd[1]: nix-.ro\x2dstore.mount: Deactivated successfully.1198machine # [ 14.630250] systemd[1]: Unmounted /nix/.ro-store.1199machine # [ 14.634541] systemd[1]: nix-.rw\x2dstore.mount: Deactivated successfully.1200machine # [ 14.638085] systemd[1]: Unmounted /nix/.rw-store.1201machine # [ 14.640359] systemd[1]: run-keys.mount: Deactivated successfully.1202machine # [ 14.644180] systemd[1]: Unmounted /run/keys.1203machine # [ 14.646422] systemd[1]: run-wrappers.mount: Deactivated successfully.1204machine # [ 14.648201] systemd[1]: Unmounted /run/wrappers.1205machine # [ 14.649710] systemd[1]: tmp-shared.mount: Deactivated successfully.1206machine # [ 14.651079] systemd[1]: Unmounted /tmp/shared.1207machine # [ 14.651737] systemd[1]: tmp-xchg.mount: Deactivated successfully.1208machine # [ 14.654120] systemd[1]: Unmounted /tmp/xchg.1209machine # [ 14.659410] systemd[1]: Stopped target Preparation for Local File Systems.1210machine # [ 14.661327] systemd[1]: Stopped target Swaps.1211machine # [ 14.662026] systemd[1]: Reached target Unmount All Filesystems.1212machine # [ 14.662779] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.1213machine # [ 14.663736] systemd[1]: Stopped Create Static Device Nodes in /dev.1214machine # [ 14.664549] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.1215machine # [ 14.665588] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.1216machine # [ 15.113099] systemd[1]: systemd-random-seed.service: Deactivated successfully.1217machine # [ 15.117136] systemd[1]: Stopped Load/Save OS Random Seed.1218machine # [ 15.121148] systemd[1]: systemd-remount-fs.service: Deactivated successfully.1219machine # [ 15.123565] systemd[1]: Stopped Remount Root and Kernel File Systems.1220machine # [ 15.125730] systemd[1]: systemd-fsck-root.service: Deactivated successfully.1221machine # [ 15.129360] systemd[1]: Stopped File System Check on Root Device.1222machine # [ 15.131521] systemd[1]: Reached target System Shutdown.1223machine # [ 15.134246] systemd[1]: Reached target Late Shutdown Services.1224machine # [ 15.136771] systemd[1]: systemd-poweroff.service: Deactivated successfully.1225machine # [ 15.139870] systemd[1]: Finished System Power Off.1226machine # [ 15.142581] systemd[1]: Reached target System Power Off.1227machine # [ 15.144535] systemd[1]: Shutting down.1228machine # [ 15.337749] systemd-shutdown[1]: Syncing filesystems and block devices.1229machine # [ 15.419228] systemd-shutdown[1]: Sending SIGTERM to remaining processes...1230machine # [ 15.427534] systemd-journald[326]: Received SIGTERM from PID 1 (systemd-shutdow).1231machine # [ 15.448815] systemd-shutdown[1]: Sending SIGKILL to remaining processes...1232machine # [ 15.452095] systemd-shutdown[1]: Unmounting file systems.1233machine # [ 15.453929] (sd-umount)[974]: Unmounting '/run/credentials/systemd-journald.service'.1234machine # [ 15.455452] (sd-remount)[975]: 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'.1235machine # [ 15.460783] (sd-umount)[976]: Unmounting '/nix/store'.1236machine # [ 15.461986] (sd-umount)[976]: Failed to unmount /nix/store: Device or resource busy1237machine # [ 15.464208] systemd-shutdown[1]: Moving mount /nix/store to /run/shutdown/mounts/82c5de1ea968e125.1238machine # [ 15.465388] (sd-remount)[977]: 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'.1239machine # [ 15.467536] (sd-umount)[978]: Unmounting '/nix/store'.1240machine # [ 15.468543] (sd-remount)[979]: Remounting '/' read-only with options ''.1241machine # [ 15.474753] EXT4-fs (vda): re-mounted 1614790b-031f-4d6a-bb61-20cad1f026f6 ro.1242machine # [ 15.476385] (sd-umount)[980]: Unmounting '/run/shutdown/mounts/82c5de1ea968e125'.1243machine # [ 15.477246] (sd-umount)[980]: Failed to unmount /run/shutdown/mounts/82c5de1ea968e125: Device or resource busy1244machine # [ 15.478460] systemd-shutdown[1]: Not all file systems unmounted, 1 left.1245machine # [ 15.479159] systemd-shutdown[1]: Deactivating swaps.1246machine # [ 15.479674] systemd-shutdown[1]: All swaps deactivated.1247machine # [ 15.480281] systemd-shutdown[1]: Detaching loop devices.1248machine # [ 15.483648] systemd-shutdown[1]: All loop devices detached.1249machine # [ 15.484269] systemd-shutdown[1]: Stopping MD devices.1250machine # [ 15.484866] systemd-shutdown[1]: All MD devices stopped.1251machine # [ 15.485427] systemd-shutdown[1]: Detaching DM devices.1252machine # [ 15.486018] systemd-shutdown[1]: All DM devices detached.1253machine # [ 15.486625] systemd-shutdown[1]: Unmounting file systems.1254machine # [ 15.487650] (sd-umount)[981]: Unmounting '/run/shutdown/mounts/82c5de1ea968e125'.1255machine # [ 15.488471] (sd-umount)[981]: Failed to unmount /run/shutdown/mounts/82c5de1ea968e125: Device or resource busy1256machine # [ 15.489635] systemd-shutdown[1]: Not all file systems unmounted, 1 left.1257machine # [ 15.490343] systemd-shutdown[1]: Cannot finalize remaining file systems, continuing.1258machine # [ 15.493081] systemd-shutdown[1]: Successfully changed into root pivot.1259machine # [ 15.493752] systemd-shutdown[1]: Entering exitrd...1260machine # [ 15.498541] shutdown[1]: Syncing filesystems and block devices.1261machine # [ 15.499519] shutdown[1]: Sending SIGTERM to remaining processes...1262machine # [ 15.501779] shutdown[1]: Sending SIGKILL to remaining processes...1263machine # [ 15.504035] shutdown[1]: Unmounting file systems.1264machine # [ 15.505518] (sd-umoun[983]: Unmounting '/run/credentials'.1265machine # [ 15.506574] (sd-umoun[984]: Unmounting '/oldroot/sys/kernel/config'.1266machine # [ 15.507690] (sd-umoun[985]: Unmounting '/oldroot/sys/fs/fuse/connections'.1267machine # [ 15.508857] (sd-umoun[986]: Unmounting '/oldroot/sys/kernel/tracing'.1268machine # [ 15.509973] (sd-umoun[987]: Unmounting '/oldroot/dev/hugepages'.1269machine # [ 15.511039] (sd-umoun[988]: Unmounting '/oldroot/dev/mqueue'.1270machine # [ 15.512068] (sd-umoun[989]: Unmounting '/oldroot/sys/kernel/debug'.1271machine # [ 15.513189] (sd-umoun[990]: Unmounting '/oldroot/sys/fs/bpf'.1272machine # [ 15.514224] (sd-umoun[991]: Unmounting '/oldroot/sys/fs/pstore'.1273machine # [ 15.515283] (sd-umoun[992]: Unmounting '/oldroot/sys/fs/cgroup'.1274machine # [ 15.516331] (sd-umoun[993]: Unmounting '/oldroot/sys/kernel/security'.1275machine # [ 15.517482] (sd-umoun[994]: Unmounting '/oldroot/run/shutdown/mounts/82c5de1ea968e125'.1276machine # [ 15.534888] (sd-umoun[995]: Unmounting '/oldroot/sys'.1277machine # [ 15.536562] (sd-umoun[996]: Unmounting '/oldroot/proc'.1278machine # [ 15.538154] (sd-umoun[997]: Unmounting '/oldroot/dev/shm'.1279machine # [ 15.539495] (sd-umoun[998]: Unmounting '/oldroot/dev/pts'.1280machine # [ 15.540890] (sd-umoun[999]: Unmounting '/oldroot/dev'.1281machine # [ 15.542222] (sd-umoun[1000]: Unmounting '/oldroot/run'.1282machine # [ 15.543552] (sd-umoun[1001]: Unmounting '/oldroot'.1283machine # [ 15.545844] EXT4-fs (vda): unmounting filesystem 1614790b-031f-4d6a-bb61-20cad1f026f6.1284machine # [ 15.547571] shutdown[1]: All filesystems unmounted.1285machine # [ 15.548512] shutdown[1]: Deactivating swaps.1286machine # [ 15.549366] shutdown[1]: All swaps deactivated.1287machine # [ 15.550177] shutdown[1]: Detaching loop devices.1288machine # [ 15.552099] shutdown[1]: All loop devices detached.1289machine # [ 15.552942] shutdown[1]: Stopping MD devices.1290machine # [ 15.553784] shutdown[1]: All MD devices stopped.1291machine # [ 15.554536] shutdown[1]: Detaching DM devices.1292machine # [ 15.555360] shutdown[1]: All DM devices detached.1293machine # [ 15.556121] shutdown[1]: All filesystems, swaps, loop devices, MD devices and DM devices detached.1294machine # [ 15.557450] shutdown[1]: Syncing filesystems and block devices.1295machine # [ 15.558690] shutdown[1]: Powering off.1296machine # [ 15.568970] ACPI: PM: Preparing to enter system sleep state S51297machine # [ 15.569844] kvm: exiting hardware virtualization1298machine # [ 15.570496] reboot: Power down1299machine # [2026-10-24T03:07:31Z INFO virtiofsd] Client disconnected, shutting down1300machine # [2026-10-24T03:07:31Z INFO virtiofsd] Client disconnected, shutting down1301machine # [2026-10-24T03:07:31Z INFO virtiofsd] Client disconnected, shutting down1302machine: (finished: waiting for the VM to power off, in 1.60 seconds)1303Image resized.1304machine: starting vm1305machine # Starting virtiofs daemons...1306machine: QEMU running (pid 107)1307machine # [2026-10-24T03:07:31Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)1308machine: waiting for unit initrd.target1309machine # [2026-10-24T03:07:31Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether1310machine: waiting for the VM to finish booting1311machine # [2026-10-24T03:07:31Z INFO virtiofsd] Waiting for vhost-user socket connection...1312machine # [2026-10-24T03:07:31Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)1313machine # [2026-10-24T03:07:31Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether1314machine # [2026-10-24T03:07:31Z INFO virtiofsd] Waiting for vhost-user socket connection...1315machine # [2026-10-24T03:07:31Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)1316machine # [2026-10-24T03:07:31Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether1317machine # [2026-10-24T03:07:31Z INFO virtiofsd] Waiting for vhost-user socket connection...1318machine # [2026-10-24T03:07:31Z INFO virtiofsd] Client connected, servicing requests1319machine # [2026-10-24T03:07:31Z INFO virtiofsd] Client connected, servicing requests1320machine # [2026-10-24T03:07:31Z INFO virtiofsd] Client connected, servicing requests1321machine # SeaBIOS (version rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org)1322machine # 1323machine # 1324machine # iPXE (http://ipxe.org) 00:02.0 CA00 PCI2.10 PnP PMM+3EFCC730+3EF2C730 CA001325machine # Press Ctrl-B to configure iPXE (PCI 00:02.0)...1326machine # 1327machine # 1328machine # 1329machine # 1330machine # iPXE (http://ipxe.org) 00:05.0 CB00 PCI2.10 PnP PMM 3EFCC730 3EF2C730 CB001331machine # Press Ctrl-B to configure iPXE (PCI 00:05.0)...1332machine # 1333machine # 1334machine # Booting from ROM...1335machine # Probing EDD (edd=off to disable)... ok[ 0.000000] Linux version 6.18.57 (nixbld@localhost) (gcc (GCC) 16.2.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT_DYNAMIC @17920583001336machine # [ 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/l8fq20sqvpsln2vdy6rxiw4iaqx43q34-nixos-system-machine-test/init regInfo=/nix/.ro-store/5vy3rydbln1k23ra00dmxdif43vm5jg3-closure-info/registration console=ttyS0,115200n8 console=tty01337machine # [ 0.000000] BIOS-provided physical RAM map:1338machine # [ 0.000000] BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable1339machine # [ 0.000000] BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved1340machine # [ 0.000000] BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved1341machine # [ 0.000000] BIOS-e820: [mem 0x0000000000100000-0x000000003ffd7fff] usable1342machine # [ 0.000000] BIOS-e820: [mem 0x000000003ffd8000-0x000000003fffffff] reserved1343machine # [ 0.000000] BIOS-e820: [mem 0x00000000b0000000-0x00000000bfffffff] reserved1344machine # [ 0.000000] BIOS-e820: [mem 0x00000000fed1c000-0x00000000fed1ffff] reserved1345machine # [ 0.000000] BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved1346machine # [ 0.000000] BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved1347machine # [ 0.000000] BIOS-e820: [mem 0x000000fd00000000-0x000000ffffffffff] reserved1348machine # [ 0.000000] NX (Execute Disable) protection: active1349machine # [ 0.000000] APIC: Static calls initialized1350machine # [ 0.000000] SMBIOS 2.8 present.1351machine # [ 0.000000] DMI: QEMU Standard PC (Q35 + ICH9, 2009), BIOS rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org 04/01/20141352machine # [ 0.000000] DMI: Memory slots populated: 1/11353machine # [ 0.000000] Hypervisor detected: KVM1354machine # [ 0.000000] last_pfn = 0x3ffd8 max_arch_pfn = 0x100000000001355machine # [ 0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d001356machine # [ 0.000001] kvm-clock: using sched offset of 496925784 cycles1357machine # [ 0.000002] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns1358machine # [ 0.000005] tsc: Detected 2400.008 MHz processor1359machine # [ 0.000765] last_pfn = 0x3ffd8 max_arch_pfn = 0x100000000001360machine # [ 0.000793] MTRR map: 4 entries (3 fixed + 1 variable; max 19), built from 8 variable MTRRs1361machine # [ 0.000796] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT1362machine # [ 0.002694] found SMP MP-table at [mem 0x000f5450-0x000f545f]1363machine # [ 0.002707] Using GB pages for direct mapping1364machine # [ 0.002831] RAMDISK: [mem 0x3e33a000-0x3ffcffff]1365machine # [ 0.002839] ACPI: Early table checksum verification disabled1366machine # [ 0.002842] ACPI: RSDP 0x00000000000F5270 000014 (v00 BOCHS )1367machine # [ 0.002846] ACPI: RSDT 0x000000003FFE2422 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001)1368machine # [ 0.002850] ACPI: FACP 0x000000003FFE221A 0000F4 (v03 BOCHS BXPC 00000001 BXPC 00000001)1369machine # [ 0.002857] ACPI: DSDT 0x000000003FFE0040 0021DA (v01 BOCHS BXPC 00000001 BXPC 00000001)1370machine # [ 0.002859] ACPI: FACS 0x000000003FFE0000 0000401371machine # [ 0.002861] ACPI: APIC 0x000000003FFE230E 000078 (v03 BOCHS BXPC 00000001 BXPC 00000001)1372machine # [ 0.002862] ACPI: HPET 0x000000003FFE2386 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001)1373machine # [ 0.002864] ACPI: MCFG 0x000000003FFE23BE 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001)1374machine # [ 0.002866] ACPI: WAET 0x000000003FFE23FA 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001)1375machine # [ 0.002867] ACPI: Reserving FACP table memory at [mem 0x3ffe221a-0x3ffe230d]1376machine # [ 0.002868] ACPI: Reserving DSDT table memory at [mem 0x3ffe0040-0x3ffe2219]1377machine # [ 0.002869] ACPI: Reserving FACS table memory at [mem 0x3ffe0000-0x3ffe003f]1378machine # [ 0.002869] ACPI: Reserving APIC table memory at [mem 0x3ffe230e-0x3ffe2385]1379machine # [ 0.002870] ACPI: Reserving HPET table memory at [mem 0x3ffe2386-0x3ffe23bd]1380machine # [ 0.002870] ACPI: Reserving MCFG table memory at [mem 0x3ffe23be-0x3ffe23f9]1381machine # [ 0.002870] ACPI: Reserving WAET table memory at [mem 0x3ffe23fa-0x3ffe2421]1382machine # [ 0.003106] No NUMA configuration found1383machine # [ 0.003107] Faking a node at [mem 0x0000000000000000-0x000000003ffd7fff]1384machine # [ 0.003110] NODE_DATA(0) allocated [mem 0x3ffd2780-0x3ffd7cff]1385machine # [ 0.005822] Zone ranges:1386machine # [ 0.005822] DMA [mem 0x0000000000001000-0x0000000000ffffff]1387machine # [ 0.005824] DMA32 [mem 0x0000000001000000-0x000000003ffd7fff]1388machine # [ 0.005825] Normal empty1389machine # [ 0.005826] Device empty1390machine # [ 0.005827] Movable zone start for each node1391machine # [ 0.005828] Early memory node ranges1392machine # [ 0.005828] node 0: [mem 0x0000000000001000-0x000000000009efff]1393machine # [ 0.005829] node 0: [mem 0x0000000000100000-0x000000003ffd7fff]1394machine # [ 0.005830] Initmem setup node 0 [mem 0x0000000000001000-0x000000003ffd7fff]1395machine # [ 0.005851] On node 0, zone DMA: 1 pages in unavailable ranges1396machine # [ 0.006118] On node 0, zone DMA: 97 pages in unavailable ranges1397machine # [ 0.024613] On node 0, zone DMA32: 40 pages in unavailable ranges1398machine # [ 0.025075] ACPI: PM-Timer IO Port: 0x6081399machine # [ 0.025086] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1])1400machine # [ 0.025114] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-231401machine # [ 0.025116] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl)1402machine # [ 0.025118] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level)1403machine # [ 0.025119] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level)1404machine # [ 0.025120] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level)1405machine # [ 0.025121] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level)1406machine # [ 0.025124] ACPI: Using ACPI (MADT) for SMP configuration information1407machine # [ 0.025125] ACPI: HPET id: 0x8086a201 base: 0xfed000001408machine # [ 0.025128] TSC deadline timer available1409machine # [ 0.025132] CPU topo: Max. logical packages: 11410machine # [ 0.025133] CPU topo: Max. logical dies: 11411machine # [ 0.025134] CPU topo: Max. dies per package: 11412machine # [ 0.025137] CPU topo: Max. threads per core: 11413machine # [ 0.025138] CPU topo: Num. cores per package: 11414machine # [ 0.025138] CPU topo: Num. threads per package: 11415machine # [ 0.025138] CPU topo: Allowing 1 present CPUs plus 0 hotplug CPUs1416machine # [ 0.025158] kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write()1417machine # [ 0.025189] PM: hibernation: Registered nosave memory: [mem 0x00000000-0x00000fff]1418machine # [ 0.025191] PM: hibernation: Registered nosave memory: [mem 0x0009f000-0x000fffff]1419machine # [ 0.025193] [mem 0x40000000-0xafffffff] available for PCI devices1420machine # [ 0.025194] Booting paravirtualized kernel on KVM1421machine # [ 0.025197] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns1422machine # [ 0.029864] setup_percpu: NR_CPUS:512 nr_cpumask_bits:1 nr_cpu_ids:1 nr_node_ids:11423machine # [ 0.032112] percpu: Embedded 98 pages/cpu s278528 r8192 d114688 u20971521424machine # [ 0.032159] kvm-guest: PV spinlocks disabled, single CPU1425machine # [ 0.032160] 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/l8fq20sqvpsln2vdy6rxiw4iaqx43q34-nixos-system-machine-test/init regInfo=/nix/.ro-store/5vy3rydbln1k23ra00dmxdif43vm5jg3-closure-info/registration console=ttyS0,115200n8 console=tty01426machine # [ 0.032257] Unknown kernel command line parameters "regInfo=/nix/.ro-store/5vy3rydbln1k23ra00dmxdif43vm5jg3-closure-info/registration", will be passed to user space.1427machine # [ 0.032269] random: crng init done1428machine # [ 0.032270] printk: log buffer data + meta data: 1048576 + 3670016 = 4718592 bytes1429machine # [ 0.033375] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes, linear)1430machine # [ 0.033388] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes, linear)1431machine # [ 0.033420] Fallback order for Node 0: 01432machine # [ 0.033423] Built 1 zonelists, mobility grouping on. Total pages: 2620061433machine # [ 0.033424] Policy zone: DMA321434machine # [ 0.035653] mem auto-init: stack:all(zero), heap alloc:on, heap free:off1435machine # [ 0.038225] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=11436machine # [ 0.040824] allocated 2097152 bytes of page_ext1437machine # [ 0.050861] ftrace: allocating 48987 entries in 192 pages1438machine # [ 0.050863] ftrace: allocated 192 pages with 2 groups1439machine # [ 0.051707] Dynamic Preempt: lazy1440machine # [ 0.051831] rcu: Preemptible hierarchical RCU implementation.1441machine # [ 0.051832] rcu: RCU event tracing is enabled.1442machine # [ 0.051832] rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=1.1443machine # [ 0.051834] Trampoline variant of Tasks RCU enabled.1444machine # [ 0.051834] Rude variant of Tasks RCU enabled.1445machine # [ 0.051834] Tracing variant of Tasks RCU enabled.1446machine # [ 0.051835] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies.1447machine # [ 0.051836] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=11448machine # [ 0.051852] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.1449machine # [ 0.051854] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.1450machine # [ 0.051854] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.1451machine # [ 0.056309] NR_IRQS: 33024, nr_irqs: 256, preallocated irqs: 161452machine # [ 0.056600] rcu: srcu_init: Setting srcu_struct sizes based on contention.1453machine # [ 0.056608] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns1454machine # [ 0.056708] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)1455machine # [ 0.060245] Console: colour VGA+ 80x251456machine # [ 0.060247] printk: legacy console [tty0] enabled1457machine # [ 0.089771] printk: legacy console [ttyS0] enabled1458machine # [ 0.195908] ACPI: Core revision 202508071459machine # [ 0.196801] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns1460machine # [ 0.198497] APIC: Switch to symmetric I/O mode setup1461machine # [ 0.199508] x2apic enabled1462machine # [ 0.200310] APIC: Switched APIC routing to: physical x2apic1463machine # [ 0.202458] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-11464machine # [ 0.203724] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x22983f10a64, max_idle_ns: 440795218721 ns1465machine # [ 0.205793] Calibrating delay loop (skipped) preset value.. 4800.01 BogoMIPS (lpj=2400008)1466machine # [ 0.207887] x86/cpu: User Mode Instruction Prevention (UMIP) activated1467machine # [ 0.208914] Last level iTLB entries: 4KB 512, 2MB 255, 4MB 1271468machine # [ 0.209790] Last level dTLB entries: 4KB 512, 2MB 255, 4MB 127, 1GB 01469machine # [ 0.210793] mitigations: Enabled attack vectors: user_kernel, user_user, guest_host, guest_guest, SMT mitigations: auto1470machine # [ 0.211790] Speculative Store Bypass: Mitigation: Speculative Store Bypass disabled via prctl1471machine # [ 0.212790] Transient Scheduler Attacks: Vulnerable: No microcode1472machine # [ 0.214575] Spectre V2 : Mitigation: Enhanced / Automatic IBRS1473machine # [ 0.215547] Speculative Return Stack Overflow: Mitigation: Safe RET1474machine # [ 0.216600] Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization1475machine # [ 0.217798] Spectre V2 : Enabling IBPB for BPF1476machine # [ 0.219369] Spectre V2 : mitigation: Enabling conditional Indirect Branch Prediction Barrier1477machine # [ 0.220790] active return thunk: srso_alias_return_thunk1478machine # [ 0.221810] x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers'1479machine # [ 0.222789] x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers'1480machine # [ 0.223790] x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers'1481machine # [ 0.224789] x86/fpu: Supporting XSAVE feature 0x020: 'AVX-512 opmask'1482machine # [ 0.225789] x86/fpu: Supporting XSAVE feature 0x040: 'AVX-512 Hi256'1483machine # [ 0.226790] x86/fpu: Supporting XSAVE feature 0x080: 'AVX-512 ZMM_Hi256'1484machine # [ 0.227789] x86/fpu: Supporting XSAVE feature 0x200: 'Protection Keys User registers'1485machine # [ 0.229790] x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 2561486machine # [ 0.230789] x86/fpu: xstate_offset[5]: 832, xstate_sizes[5]: 641487machine # [ 0.231789] x86/fpu: xstate_offset[6]: 896, xstate_sizes[6]: 5121488machine # [ 0.232790] x86/fpu: xstate_offset[7]: 1408, xstate_sizes[7]: 10241489machine # [ 0.233789] x86/fpu: xstate_offset[9]: 2432, xstate_sizes[9]: 81490machine # [ 0.234789] x86/fpu: Enabled xstate features 0x2e7, context size is 2440 bytes, using 'compacted' format.1491machine # [ 0.270430] Freeing SMP alternatives memory: 48K1492machine # [ 0.270794] pid_max: default: 32768 minimum: 3011493machine # [ 0.271898] LSM: initializing lsm=lockdown,capability,landlock,yama,bpf,ima1494machine # [ 0.272881] landlock: Up and running.1495machine # [ 0.273790] Yama: becoming mindful.1496machine # [ 0.275005] LSM support for eBPF active1497machine # [ 0.275795] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)1498machine # [ 0.276818] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)1499machine # [ 0.279432] smpboot: CPU0: AMD EPYC 9654 96-Core Processor (family: 0x19, model: 0x11, stepping: 0x1)1500machine # [ 0.280834] Performance Events: Fam17h+ core perfctr, AMD PMU driver.1501machine # [ 0.281794] ... version: 21502machine # [ 0.282543] ... bit width: 481503machine # [ 0.282843] ... generic counters: 61504machine # [ 0.283607] ... generic bitmap: 000000000000003f1505machine # [ 0.284525] ... fixed-purpose counters: 01506machine # [ 0.284792] ... fixed-purpose bitmap: 00000000000000001507machine # [ 0.285720] ... value mask: 0000ffffffffffff1508machine # [ 0.286517] ... max period: 00007fffffffffff1509machine # [ 0.286792] ... global_ctrl mask: 000000000000003f1510machine # [ 0.287858] signal: max sigframe size: 33761511machine # [ 0.288702] rcu: Hierarchical SRCU implementation.1512machine # [ 0.289396] rcu: Max phase no-delay instances is 400.1513machine # [ 0.294595] smp: Bringing up secondary CPUs ...1514machine # [ 0.295420] smp: Brought up 1 node, 1 CPU1515machine # [ 0.295794] smpboot: Total of 1 processors activated (4800.01 BogoMIPS)1516machine # [ 0.297026] Memory: 934724K/1048024K available (18186K kernel code, 5431K rwdata, 13716K rodata, 6720K init, 3992K bss, 105936K reserved, 0K cma-reserved)1517machine # [ 0.298031] devtmpfs: initialized1518machine # [ 0.298841] x86/mm: Memory block size: 128MB1519machine # [ 0.300605] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear)1520machine # [ 0.301795] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear).1521machine # [ 0.302893] pinctrl core: initialized pinctrl subsystem1522machine # [ 0.304032] PM: RTC time: 03:07:31, date: 2026-10-241523machine # [ 0.307650] NET: Registered PF_NETLINK/PF_ROUTE protocol family1524machine # [ 0.308957] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations1525machine # [ 0.309810] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations1526machine # [ 0.310957] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations1527machine # [ 0.311802] audit: initializing netlink subsys (disabled)1528machine # [ 0.312794] audit: type=2000 audit(1792811252.247:1): state=initialized audit_enabled=0 res=11529machine # [ 0.314318] thermal_sys: Registered thermal governor 'fair_share'1530machine # [ 0.314320] thermal_sys: Registered thermal governor 'bang_bang'1531machine # [ 0.314793] thermal_sys: Registered thermal governor 'step_wise'1532machine # [ 0.315793] thermal_sys: Registered thermal governor 'user_space'1533machine # [ 0.316792] thermal_sys: Registered thermal governor 'power_allocator'1534machine # [ 0.317805] cpuidle: using governor menu1535machine # [ 0.320070] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.51536machine # [ 0.321029] PCI: ECAM [mem 0xb0000000-0xbfffffff] (base 0xb0000000) for domain 0000 [bus 00-ff]1537machine # [ 0.321800] PCI: ECAM [mem 0xb0000000-0xbfffffff] reserved as E820 entry1538machine # [ 0.322803] PCI: Using configuration type 1 for base access1539machine # [ 0.323882] kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible.1540machine # [ 0.329073] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages1541machine # [ 0.329793] HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page1542machine # [ 0.334793] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages1543machine # [ 0.335791] HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page1544machine # [ 0.344030] ACPI: Added _OSI(Module Device)1545machine # [ 0.344756] ACPI: Added _OSI(Processor Device)1546machine # [ 0.345323] ACPI: Added _OSI(Processor Aggregator Device)1547machine # [ 0.354348] ACPI: 1 ACPI AML tables successfully acquired and loaded1548machine # [ 0.358279] ACPI: Interpreter enabled1549machine # [ 0.358808] ACPI: PM: (supports S0 S3 S4 S5)1550machine # [ 0.359498] ACPI: Using IOAPIC for interrupt routing1551machine # [ 0.361842] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug1552machine # [ 0.362793] PCI: Using E820 reservations for host bridge windows1553machine # [ 0.365884] ACPI: Enabled 2 GPEs in block 00 to 3F1554machine # [ 0.374012] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff])1555machine # [ 0.374800] acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3]1556machine # [ 0.375880] acpi PNP0A08:00: _OSC: platform does not support [PCIeHotplug LTR]1557machine # [ 0.376916] acpi PNP0A08:00: _OSC: OS now controls [PME AER PCIeCapability]1558machine # [ 0.378187] PCI host bridge to bus 0000:001559machine # [ 0.378797] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window]1560machine # [ 0.379792] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window]1561machine # [ 0.380793] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window]1562machine # [ 0.381792] pci_bus 0000:00: root bus resource [mem 0x40000000-0xafffffff window]1563machine # [ 0.382792] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window]1564machine # [ 0.383792] pci_bus 0000:00: root bus resource [mem 0x100000000-0x8ffffffff window]1565machine # [ 0.384793] pci_bus 0000:00: root bus resource [bus 00-ff]1566machine # [ 0.385835] pci 0000:00:00.0: [8086:29c0] type 00 class 0x060000 conventional PCI endpoint1567machine # [ 0.387315] pci 0000:00:01.0: [1234:1111] type 00 class 0x030000 conventional PCI endpoint1568machine # [ 0.389857] pci 0000:00:01.0: BAR 0 [mem 0xfd000000-0xfdffffff pref]1569machine # [ 0.390804] pci 0000:00:01.0: BAR 2 [mem 0xfebd0000-0xfebd0fff]1570machine # [ 0.391831] pci 0000:00:01.0: ROM [mem 0xfebc0000-0xfebcffff pref]1571machine # [ 0.393146] pci 0000:00:01.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff]1572machine # [ 0.394608] pci 0000:00:02.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint1573machine # [ 0.396812] pci 0000:00:02.0: BAR 0 [io 0xc100-0xc11f]1574machine # [ 0.397716] pci 0000:00:02.0: BAR 1 [mem 0xfebd1000-0xfebd1fff]1575machine # [ 0.398600] pci 0000:00:02.0: BAR 4 [mem 0xfe000000-0xfe003fff 64bit pref]1576machine # [ 0.399716] pci 0000:00:02.0: ROM [mem 0xfeb40000-0xfeb7ffff pref]1577machine # [ 0.401308] pci 0000:00:03.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint1578machine # [ 0.402812] pci 0000:00:03.0: BAR 0 [io 0xc120-0xc13f]1579machine # [ 0.403696] pci 0000:00:03.0: BAR 1 [mem 0xfebd2000-0xfebd2fff]1580machine # [ 0.404560] pci 0000:00:03.0: BAR 4 [mem 0xfe004000-0xfe007fff 64bit pref]1581machine # [ 0.406271] pci 0000:00:04.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint1582machine # [ 0.408748] pci 0000:00:04.0: BAR 0 [io 0xc000-0xc07f]1583machine # [ 0.409435] pci 0000:00:04.0: BAR 1 [mem 0xfebd3000-0xfebd3fff]1584machine # [ 0.409814] pci 0000:00:04.0: BAR 4 [mem 0xfe008000-0xfe00bfff 64bit pref]1585machine # [ 0.411342] pci 0000:00:05.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint1586machine # [ 0.412801] pci 0000:00:05.0: BAR 0 [io 0xc140-0xc15f]1587machine # [ 0.413644] pci 0000:00:05.0: BAR 1 [mem 0xfebd4000-0xfebd4fff]1588machine # [ 0.414528] pci 0000:00:05.0: BAR 4 [mem 0xfe00c000-0xfe00ffff 64bit pref]1589machine # [ 0.414799] pci 0000:00:05.0: ROM [mem 0xfeb80000-0xfebbffff pref]1590machine # [ 0.416361] pci 0000:00:06.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint1591machine # [ 0.417682] pci 0000:00:06.0: BAR 1 [mem 0xfebd5000-0xfebd5fff]1592machine # [ 0.418520] pci 0000:00:06.0: BAR 4 [mem 0xfe010000-0xfe013fff 64bit pref]1593machine # [ 0.419403] pci 0000:00:07.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint1594machine # [ 0.420805] pci 0000:00:07.0: BAR 1 [mem 0xfebd6000-0xfebd6fff]1595machine # [ 0.421761] pci 0000:00:07.0: BAR 4 [mem 0xfe014000-0xfe017fff 64bit pref]1596machine # [ 0.423406] pci 0000:00:08.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint1597machine # [ 0.424580] pci 0000:00:08.0: BAR 1 [mem 0xfebd7000-0xfebd7fff]1598machine # [ 0.425521] pci 0000:00:08.0: BAR 4 [mem 0xfe018000-0xfe01bfff 64bit pref]1599machine # [ 0.426336] pci 0000:00:09.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint1600machine # [ 0.427774] pci 0000:00:09.0: BAR 1 [mem 0xfebd8000-0xfebd8fff]1601machine # [ 0.428534] pci 0000:00:09.0: BAR 4 [mem 0xfe01c000-0xfe01ffff 64bit pref]1602machine # [ 0.429332] pci 0000:00:0a.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint1603machine # [ 0.430831] pci 0000:00:0a.0: BAR 0 [io 0xc080-0xc0bf]1604machine # [ 0.431679] pci 0000:00:0a.0: BAR 1 [mem 0xfebd9000-0xfebd9fff]1605machine # [ 0.432541] pci 0000:00:0a.0: BAR 4 [mem 0xfe020000-0xfe023fff 64bit pref]1606machine # [ 0.433369] pci 0000:00:0b.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint1607machine # [ 0.434920] pci 0000:00:0b.0: BAR 0 [io 0xc160-0xc17f]1608machine # [ 0.435799] pci 0000:00:0b.0: BAR 1 [mem 0xfebda000-0xfebdafff]1609machine # [ 0.436804] pci 0000:00:0b.0: BAR 4 [mem 0xfe024000-0xfe027fff 64bit pref]1610machine # [ 0.438416] pci 0000:00:1d.0: [8086:2934] type 00 class 0x0c0300 conventional PCI endpoint1611machine # [ 0.439367] pci 0000:00:1d.0: BAR 4 [io 0xc180-0xc19f]1612machine # [ 0.439994] pci 0000:00:1d.1: [8086:2935] type 00 class 0x0c0300 conventional PCI endpoint1613machine # [ 0.441365] pci 0000:00:1d.1: BAR 4 [io 0xc1a0-0xc1bf]1614machine # [ 0.441987] pci 0000:00:1d.2: [8086:2936] type 00 class 0x0c0300 conventional PCI endpoint1615machine # [ 0.443316] pci 0000:00:1d.2: BAR 4 [io 0xc1c0-0xc1df]1616machine # [ 0.444033] pci 0000:00:1d.7: [8086:293a] type 00 class 0x0c0320 conventional PCI endpoint1617machine # [ 0.446371] pci 0000:00:1d.7: BAR 0 [mem 0xfebdb000-0xfebdbfff]1618machine # [ 0.447071] pci 0000:00:1f.0: [8086:2918] type 00 class 0x060100 conventional PCI endpoint1619machine # [ 0.448100] pci 0000:00:1f.0: quirk: [io 0x0600-0x067f] claimed by ICH6 ACPI/GPIO/TCO1620machine # [ 0.449050] pci 0000:00:1f.2: [8086:2922] type 00 class 0x010601 conventional PCI endpoint1621machine # [ 0.450810] pci 0000:00:1f.2: BAR 4 [io 0xc1e0-0xc1ff]1622machine # [ 0.451662] pci 0000:00:1f.2: BAR 5 [mem 0xfebdc000-0xfebdcfff]1623machine # [ 0.452864] pci 0000:00:1f.3: [8086:2930] type 00 class 0x0c0500 conventional PCI endpoint1624machine # [ 0.454446] pci 0000:00:1f.3: BAR 4 [io 0x0700-0x073f]1625machine # [ 0.457905] ACPI: PCI: Interrupt link LNKA configured for IRQ 101626machine # [ 0.458900] ACPI: PCI: Interrupt link LNKB configured for IRQ 101627machine # [ 0.459890] ACPI: PCI: Interrupt link LNKC configured for IRQ 111628machine # [ 0.460893] ACPI: PCI: Interrupt link LNKD configured for IRQ 111629machine # [ 0.461888] ACPI: PCI: Interrupt link LNKE configured for IRQ 101630machine # [ 0.462890] ACPI: PCI: Interrupt link LNKF configured for IRQ 101631machine # [ 0.463895] ACPI: PCI: Interrupt link LNKG configured for IRQ 111632machine # [ 0.464887] ACPI: PCI: Interrupt link LNKH configured for IRQ 111633machine # [ 0.465827] ACPI: PCI: Interrupt link GSIA configured for IRQ 161634machine # [ 0.466777] ACPI: PCI: Interrupt link GSIB configured for IRQ 171635machine # [ 0.467532] ACPI: PCI: Interrupt link GSIC configured for IRQ 181636machine # [ 0.467809] ACPI: PCI: Interrupt link GSID configured for IRQ 191637machine # [ 0.468809] ACPI: PCI: Interrupt link GSIE configured for IRQ 201638machine # [ 0.469757] ACPI: PCI: Interrupt link GSIF configured for IRQ 211639machine # [ 0.470558] ACPI: PCI: Interrupt link GSIG configured for IRQ 221640machine # [ 0.470809] ACPI: PCI: Interrupt link GSIH configured for IRQ 231641machine # [ 0.472864] iommu: Default domain type: Translated1642machine # [ 0.473663] iommu: DMA domain TLB invalidation policy: lazy mode1643machine # [ 0.474817] ACPI: bus type USB registered1644machine # [ 0.475570] usbcore: registered new interface driver usbfs1645machine # [ 0.475807] usbcore: registered new interface driver hub1646machine # [ 0.476669] usbcore: registered new device driver usb1647machine # [ 0.478289] NetLabel: Initializing1648machine # [ 0.478793] NetLabel: domain hash size = 1281649machine # [ 0.479516] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO1650machine # [ 0.479853] NetLabel: unlabeled traffic allowed by default1651machine # [ 0.480759] PCI: Using ACPI for IRQ routing1652machine # [ 0.524895] pci 0000:00:01.0: vgaarb: setting as boot VGA device1653machine # [ 0.525788] pci 0000:00:01.0: vgaarb: bridge control possible1654machine # [ 0.525788] pci 0000:00:01.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none1655machine # [ 0.525797] vgaarb: loaded1656machine # [ 0.526556] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 01657machine # [ 0.526792] hpet0: 3 comparators, 64-bit 100.000000 MHz counter1658machine # [ 0.529890] clocksource: Switched to clocksource kvm-clock1659machine # [ 0.533509] VFS: Disk quotas dquot_6.6.01660machine # [ 0.534212] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)1661machine # [ 0.535556] pnp: PnP ACPI init1662machine # [ 0.536331] ACPI: IRQ 4 override to edge(!), high(!)1663machine # [ 0.537278] system 00:04: [mem 0xb0000000-0xbfffffff window] has been reserved1664machine # [ 0.538782] pnp: PnP ACPI: found 5 devices1665machine # [ 0.546341] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns1666machine # [ 0.547767] clocksource: Switched to clocksource acpi_pm1667machine # [ 0.548755] NET: Registered PF_INET protocol family1668machine # [ 0.549778] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear)1669machine # [ 0.567407] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear)1670machine # [ 0.568926] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)1671machine # [ 0.570220] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear)1672machine # [ 0.571489] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear)1673machine # [ 0.572684] TCP: Hash tables configured (established 8192 bind 8192)1674machine # [ 0.573760] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear)1675machine # [ 0.575014] UDP hash table entries: 512 (order: 3, 32768 bytes, linear)1676machine # [ 0.576093] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear)1677machine # [ 0.577288] NET: Registered PF_UNIX/PF_LOCAL protocol family1678machine # [ 0.578275] NET: Registered PF_XDP protocol family1679machine # [ 0.579075] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window]1680machine # [ 0.580051] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window]1681machine # [ 0.581032] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window]1682machine # [ 0.582102] pci_bus 0000:00: resource 7 [mem 0x40000000-0xafffffff window]1683machine # [ 0.583154] pci_bus 0000:00: resource 8 [mem 0xc0000000-0xfebfffff window]1684machine # [ 0.584235] pci_bus 0000:00: resource 9 [mem 0x100000000-0x8ffffffff window]1685machine # [ 0.585916] ACPI: \_SB_.GSIA: Enabled at IRQ 161686machine # [ 0.588755] ACPI: \_SB_.GSIB: Enabled at IRQ 171687machine # [ 0.590676] ACPI: \_SB_.GSIC: Enabled at IRQ 181688machine # [ 0.592559] ACPI: \_SB_.GSID: Enabled at IRQ 191689machine # [ 0.594237] PCI: CLS 0 bytes, default 641690machine # [ 0.595109] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x22983f10a64, max_idle_ns: 440795218721 ns1691machine # [ 0.596826] Trying to unpack rootfs image as initramfs...1692machine # [ 0.642639] Initialise system trusted keyrings1693machine # [ 0.643473] Key type blacklist registered1694machine # [ 0.644304] workingset: timestamp_bits=40 max_order=18 bucket_order=01695machine # [ 0.647501] integrity: Platform Keyring initialized1696machine # [ 0.648331] integrity: Machine keyring initialized1697machine # [ 0.668835] Key type asymmetric registered1698machine # [ 0.672218] Asymmetric key parser 'x509' registered1699machine # [ 0.673051] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 248)1700machine # [ 0.676313] io scheduler mq-deadline registered1701machine # [ 0.677072] io scheduler kyber registered1702machine # [ 0.680792] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled1703machine # [ 0.682064] 00:03: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A1704machine # [ 0.686008] Linux agpgart interface v0.1031705machine # [ 0.686792] ACPI: bus type drm_connector registered1706machine # [ 0.691625] usbcore: registered new interface driver usbserial_generic1707machine # [ 0.692695] usbserial: USB Serial support registered for generic1708machine # [ 0.695216] amd_pstate: The CPPC feature is supported but currently disabled by the BIOS.1709machine # [ 0.695216] Please enable it if your BIOS has the CPPC option.1710machine # [ 0.697363] amd_pstate: the _CPC object is not present in SBIOS or ACPI disabled1711machine # [ 0.700372] drop_monitor: Initializing network drop monitor service1712machine # [ 0.701521] NET: Registered PF_INET6 protocol family1713machine # [ 0.704865] Segment Routing with IPv61714machine # [ 0.707221] In-situ OAM (IOAM) with IPv61715machine # [ 0.709360] IPI shorthand broadcast: enabled1716machine # [ 0.717570] sched_clock: Marking stable (572015102, 145181030)->(792308359, -75112227)1717machine # [ 0.722308] registered taskstats version 11718machine # [ 0.723282] Loading compiled-in X.509 certificates1719machine # [ 0.742440] Demotion targets for Node 0: null1720machine # [ 0.743297] Key type .fscrypt registered1721machine # [ 0.743945] Key type fscrypt-provisioning registered1722machine # [ 0.746327] ima: No TPM chip found, activating TPM-bypass!1723machine # [ 0.747235] ima: Allocated hash algorithm: sha11724machine # [ 0.747994] ima: No architecture policies found1725machine # [ 0.751366] PM: Magic number: 14:209:1091726machine # [ 0.753019] RAS: Correctable Errors collector initialized.1727machine # [ 0.764031] clk: Disabling unused clocks1728machine # [ 0.766207] PM: genpd: Disabling unused power domains1729machine # [ 0.935283] Freeing initrd memory: 29272K1730machine # [ 0.938843] Freeing unused decrypted memory: 2028K1731machine # [ 0.943574] Freeing unused kernel image (initmem) memory: 6720K1732machine # [ 0.944756] Write protecting the kernel read-only data: 32768k1733machine # [ 0.946094] Freeing unused kernel image (text/rodata gap) memory: 244K1734machine # [ 0.947677] Freeing unused kernel image (rodata/data gap) memory: 620K1735machine # [ 0.999051] x86/mm: Checked W+X mappings: passed, no W+X pages found.1736machine # [ 1.000215] Run /init as init process1737machine # [ 1.010947] autofs4: module verification failed: signature and/or required key missing - tainting kernel1738machine # [ 1.013738] systemd[1]: Inserted module 'autofs4'1739machine # [ 1.033698] fuse: init (API version 7.45)1740machine # [ 1.040917] ACPI: \_SB_.GSIG: Enabled at IRQ 221741machine # [ 1.043737] ACPI: \_SB_.GSIH: Enabled at IRQ 231742machine # [ 1.047112] ACPI: \_SB_.GSIE: Enabled at IRQ 201743machine # [ 1.049451] ACPI: \_SB_.GSIF: Enabled at IRQ 211744machine # [ 1.054928] virtiofs virtio5: discovered new tag: nix-store1745machine # [ 1.056524] virtiofs virtio5: virtio_fs_setup_dax: No cache capability1746machine # [ 1.063783] virtiofs virtio6: discovered new tag: shared1747machine # [ 1.065315] virtiofs virtio6: virtio_fs_setup_dax: No cache capability1748machine # [ 1.068640] virtiofs virtio7: discovered new tag: xchg1749machine # [ 1.070134] virtiofs virtio7: virtio_fs_setup_dax: No cache capability1750machine # [ 1.094369] systemd[1]: Successfully made /usr/ read-only.1751machine # [ 1.096127] systemd[1]: systemd 263-0f0682b 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 +EXPERIMENTAL-ENVVAR)1752machine # [ 1.101240] systemd[1]: Detected virtualization kvm.1753machine # [ 1.102056] systemd[1]: Detected architecture x86-64.1754machine # [ 1.102943] systemd[1]: Running in initrd.1755machine # [ 1.103946] systemd[1]: Initializing machine ID from random generator.1756machine # [ 1.105119] systemd[1]: Hostname set to <machine>.1757machine # [ 1.180361] systemd[1]: bpf-restrict-fs: LSM BPF program attached1758machine # [ 1.219918] systemd[1]: Queued start job for default target Initrd Default Target.1759machine # [ 1.224589] systemd[1]: Created slice Slice /system/modprobe.1760machine # [ 1.225776] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.1761machine # [ 1.227133] systemd[1]: Expecting device /dev/disk/by-label/nixos...1762machine # [ 1.228204] systemd[1]: Expecting device /dev/hvc0...1763machine # [ 1.229059] systemd[1]: Expecting device /dev/ttyS0...1764machine # [ 1.229977] systemd[1]: Reached target Path Units.1765machine # [ 1.230845] systemd[1]: Reached target Slice Units.1766machine # [ 1.231710] systemd[1]: Reached target Swaps.1767machine # [ 1.232496] systemd[1]: Reached target Timer Units.1768machine # [ 1.233424] systemd[1]: Listening on D-Bus System Message Bus Socket.1769machine # [ 1.234609] systemd[1]: Listening on Journal Socket (/dev/log).1770machine # [ 1.247229] systemd[1]: Listening on Journal Sockets.1771machine # [ 1.248153] systemd[1]: Listening on udev Kernel Socket.1772machine # [ 1.249264] systemd[1]: Listening on udev Varlink Socket.1773machine # [ 1.250162] systemd[1]: Reached target Socket Units.1774machine # [ 1.252030] systemd[1]: Starting Create List of Static Device Nodes...1775machine # [ 1.256271] systemd[1]: Starting Load Kernel Module configfs...1776machine # [ 1.265395] systemd[1]: Starting Journal Service...1777machine # [ 1.277331] systemd[1]: Starting Load Kernel Modules...1778machine # [ 1.280286] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1779machine # [ 1.285480] systemd[1]: Starting Coldplug All udev Devices...1780machine # [ 1.300350] systemd[1]: Finished Create List of Static Device Nodes.1781machine # [ 1.305917] systemd[1]: modprobe@configfs.service: Deactivated successfully.1782machine # [ 1.313751] systemd[1]: Finished Load Kernel Module configfs.1783machine # [ 1.319700] systemd[1]: Kernel Configuration File System skipped, unmet condition check ConditionPathExists=/sys/kernel/config1784machine # [ 1.324766] systemd-journald[65]: Collecting audit messages is disabled.1785machine # [ 1.333279] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...1786machine # [ 1.346323] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.1787machine # [ 1.352278] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev1788machine # [ 1.377978] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.1789machine # [ 1.387410] systemd[1]: Starting Create Static Device Nodes in /dev...1790machine # [ 1.400310] systemd[1]: Finished Load Kernel Modules.1791machine # [ 1.411584] systemd[1]: Starting Apply Kernel Variables...1792machine # [ 1.441325] systemd[1]: Finished Create Static Device Nodes in /dev.1793machine # [ 1.445558] systemd[1]: Started Journal Service.1794machine # [ 1.298865] systemd-modules-load[66]: Inserted module 'dm_mod'1795machine # [ 1.304074] systemd-modules-load[66]: Inserted module 'virtio_balloon'1796machine # [ 1.305196] systemd-modules-load[66]: Inserted module 'virtio_gpu'1797machine # [ 1.307808] systemd[1]: Reached target Preparation for Local File Systems.1798machine # [ 1.310112] systemd[1]: Reached target Local File Systems.1799machine # [ 1.314064] systemd[1]: Starting Create System Files and Directories...1800machine # [ 1.319064] systemd[1]: Starting Rule-based Manager for Device Events and Files...1801machine # [ 1.329896] systemd[1]: Finished Apply Kernel Variables.1802machine # [ 1.351682] systemd[1]: Finished Create System Files and Directories.1803machine # [ 1.383283] systemd-udevd[76]: Using default interface naming scheme 'v261'.1804machine # [ 1.406697] systemd[1]: Started Rule-based Manager for Device Events and Files.1805machine # [ 1.449164] systemd[1]: Finished Coldplug All udev Devices.1806machine # [ 1.450223] systemd[1]: Reached target System Initialization.1807machine # [ 1.451198] systemd[1]: Reached target Basic System.1808machine # [ 1.477676] systemd[1]: Found device /dev/hvc0.1809machine # [ 1.488070] systemd[1]: Found device /dev/ttyS0.1810machine # [ 1.490084] systemd[1]: Started backdoor.service.1811machine # [ 1.513435] backdoor-start[97]: /nix/store/cy0g856jmz5k0chql2vcv1zpinvvyn2a-unit-script-backdoor-start/bin/backdoor-start: line 10: grep: command not found1812machine # connecting to host...1813machine: Guest shell says: b'Spawning backdoor root shell...\n'1814machine: connected to guest root shell1815machine: (connecting took 2.21 seconds)1816machine: (finished: waiting for the VM to finish booting, in 2.21 seconds)1817machine # [ 1.792093] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,121818machine # [ 1.800802] virtio_blk virtio2: 1/0/0 default/read/poll queues1819machine # [ 1.803974] serio: i8042 KBD port at 0x60,0x64 irq 11820machine # [ 1.804674] serio: i8042 AUX port at 0x60,0x64 irq 121821machine # [ 1.813027] virtio_blk virtio2: [vda] 4194304 512-byte logical blocks (2.15 GB/2.00 GiB)1822machine # [ 1.822069] ehci-pci 0000:00:1d.7: EHCI Host Controller1823machine # [ 1.822862] ehci-pci 0000:00:1d.7: new USB bus registered, assigned bus number 11824machine # [ 1.824697] ehci-pci 0000:00:1d.7: irq 19, io mem 0xfebdb0001825machine # [ 1.831211] ehci-pci 0000:00:1d.7: USB 2.0 started, EHCI 1.001826machine # [ 1.832090] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 6.181827machine # [ 1.834728] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=11828machine # [ 1.836907] usb usb1: Product: EHCI Host Controller1829machine # [ 1.839150] usb usb1: Manufacturer: Linux 6.18.57 ehci_hcd1830machine # [ 1.840339] usb usb1: SerialNumber: 0000:00:1d.71831machine # [ 1.842350] hub 1-0:1.0: USB hub found1832machine # [ 1.843716] hub 1-0:1.0: 6 ports detected1833machine # [ 1.848473] uhci_hcd 0000:00:1d.0: UHCI Host Controller1834machine # [ 1.864220] uhci_hcd 0000:00:1d.0: new USB bus registered, assigned bus number 21835machine # [ 1.876238] uhci_hcd 0000:00:1d.0: detected 2 ports1836machine # [ 1.883607] uhci_hcd 0000:00:1d.0: irq 16, io port 0x0000c1801837machine # [ 1.894742] usb usb2: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.181838machine # [ 1.906212] usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=11839machine # [ 1.770848] systemd[1]: Starting Virtual Console Setup...1840machine # [ 1.926749] usb usb2: Product: UHCI Host Controller1841machine # [ 1.785168] (udev-worker)[94]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.1842machine # [ 1.789136] (udev-worker)[88]: Network interface NamePolicy= disabled on kernel command line.1843machine # [ 1.945217] usb usb2: Manufacturer: Linux 6.18.57 uhci_hcd1844machine # [ 1.945993] usb usb2: SerialNumber: 0000:00:1d.01845machine # [ 1.804073] (udev-worker)[94]: Network interface NamePolicy= disabled on kernel command line.1846machine # [ 1.952060] SCSI subsystem initialized1847machine # [ 1.810915] systemd-vconsole-setup[111]: Configuration of first virtual console was skipped, ignoring remaining ones.1848machine # [ 1.959117] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input01849machine # [ 1.816684] systemd[1]: Finished Virtual Console Setup.1850machine # [ 1.964544] hub 2-0:1.0: USB hub found1851machine # [ 1.969322] hub 2-0:1.0: 2 ports detected1852machine # [ 1.841322] systemd[1]: Found device /dev/disk/by-label/nixos.1853machine # [ 1.844355] systemd[1]: Reached target Initrd Root Device.1854machine # [ 1.990386] uhci_hcd 0000:00:1d.1: UHCI Host Controller1855machine # [ 1.991105] uhci_hcd 0000:00:1d.1: new USB bus registered, assigned bus number 31856machine # [ 1.848445] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos...1857machine # [ 1.999111] uhci_hcd 0000:00:1d.1: detected 2 ports1858machine # [ 2.000335] uhci_hcd 0000:00:1d.1: irq 17, io port 0x0000c1a01859machine # [ 2.005346] usb usb3: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.181860machine # [ 2.006541] usb usb3: New USB device strings: Mfr=3, Product=2, SerialNumber=11861machine # [ 2.014214] usb usb3: Product: UHCI Host Controller1862machine # [ 2.014926] usb usb3: Manufacturer: Linux 6.18.57 uhci_hcd1863machine # [ 2.018239] usb usb3: SerialNumber: 0000:00:1d.11864machine # [ 2.020426] hub 3-0:1.0: USB hub found1865machine # [ 2.023480] hub 3-0:1.0: 2 ports detected1866machine # [ 2.030349] uhci_hcd 0000:00:1d.2: UHCI Host Controller1867machine # [ 2.031073] uhci_hcd 0000:00:1d.2: new USB bus registered, assigned bus number 41868machine # [ 1.887613] systemd-fsck[118]: nixos: clean, 226/65536 files, 15455/262144 blocks1869machine # [ 2.035212] uhci_hcd 0000:00:1d.2: detected 2 ports1870machine # [ 2.035971] uhci_hcd 0000:00:1d.2: irq 18, io port 0x0000c1c01871machine # [ 2.039296] usb usb4: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.181872machine # [ 2.043195] usb usb4: New USB device strings: Mfr=3, Product=2, SerialNumber=11873machine # [ 2.044303] usb usb4: Product: UHCI Host Controller1874machine # [ 2.044979] usb usb4: Manufacturer: Linux 6.18.57 uhci_hcd1875machine # [ 2.050206] usb usb4: SerialNumber: 0000:00:1d.21876machine # [ 2.051124] hub 4-0:1.0: USB hub found1877machine # [ 2.052386] hub 4-0:1.0: 2 ports detected1878machine # [ 2.076888] ahci 0000:00:1f.2: AHCI vers 0001.0000, 32 command slots, 1.5 Gbps, SATA mode1879machine # [ 2.078106] ahci 0000:00:1f.2: 6/6 ports implemented (port mask 0x3f)1880machine # [ 2.079615] ahci 0000:00:1f.2: flags: 64bit ncq only1881machine # [ 2.082672] scsi host0: ahci1882machine # [ 2.083206] usb 1-1: new high-speed USB device number 2 using ehci-pci1883machine # [ 2.085215] scsi host1: ahci1884machine # [ 2.086718] scsi host2: ahci1885machine # [ 2.087932] scsi host3: ahci1886machine # [ 2.089557] scsi host4: ahci1887machine # [ 2.091108] scsi host5: ahci1888machine # [ 2.092575] ata1: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc100 irq 47 lpm-pol 11889machine # [ 2.093728] ata2: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc180 irq 47 lpm-pol 11890machine # [ 2.094968] ata3: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc200 irq 47 lpm-pol 11891machine # [ 2.096157] ata4: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc280 irq 47 lpm-pol 11892machine # [ 2.097306] ata5: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc300 irq 47 lpm-pol 11893machine # [ 2.098491] ata6: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc380 irq 47 lpm-pol 11894machine # [ 2.212840] usb 1-1: New USB device found, idVendor=0627, idProduct=0001, bcdDevice= 0.001895machine # [ 2.215756] usb 1-1: New USB device strings: Mfr=1, Product=3, SerialNumber=101896machine # [ 2.218959] usb 1-1: Product: QEMU USB Tablet1897machine # [ 2.220833] usb 1-1: Manufacturer: QEMU1898machine # [ 2.222513] usb 1-1: SerialNumber: 28754-0000:00:1d.7-11899machine # [ 2.257057] hid: raw HID events driver (C) Jiri Kosina1900machine # [ 2.410092] ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 300)1901machine # [ 2.412563] ata3.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/1001902machine # [ 2.415101] ata3.00: applying bridge limits1903machine # [ 2.417114] ata1: SATA link down (SStatus 0 SControl 300)1904machine # [ 2.419563] ata4: SATA link down (SStatus 0 SControl 300)1905machine # [ 2.421982] ata6: SATA link down (SStatus 0 SControl 300)1906machine # [ 2.424481] ata2: SATA link down (SStatus 0 SControl 300)1907machine # [ 2.426698] ata5: SATA link down (SStatus 0 SControl 300)1908machine # [ 2.429123] ata3.00: configured for UDMA/1001909machine # [ 2.431897] scsi 2:0:0:0: CD-ROM QEMU QEMU DVD-ROM 2.5+ PQ: 0 ANSI: 51910machine # [ 2.481783] usbcore: registered new interface driver usbhid1911machine # [ 2.483257] usbhid: USB HID core driver1912machine # [ 2.487269] sr 2:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray1913machine # [ 2.488267] 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/input21914machine # [ 2.490390] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:1d.7-1/input01915machine # [ 2.498301] cdrom: Uniform CD-ROM driver Revision: 3.201916machine # [ 3.173111] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos.1917machine # [ 3.176080] systemd[1]: Mounting /sysroot...1918machine # [ 3.608500] EXT4-fs (vda): mounted filesystem 1614790b-031f-4d6a-bb61-20cad1f026f6 r/w with ordered data mode. Quota mode: none.1919machine # [ 3.471794] systemd[1]: Mounted /sysroot.1920machine # [ 3.475327] systemd[1]: Reached target Initrd Root File System.1921machine # [ 3.479933] systemd[1]: Mounting /sysroot/nix/.ro-store...1922machine # [ 3.486483] systemd[1]: Mounting /sysroot/nix/.rw-store...1923machine # [ 3.495499] systemd[1]: Mounting /sysroot/run...1924machine # [ 3.505258] systemd[1]: Mounting /sysroot/tmp/shared...1925machine # [ 3.516267] systemd[1]: Mounting /sysroot/tmp/xchg...1926machine # [ 3.527358] systemd[1]: Starting Mountpoints Configured in the Real Root...1927machine # [ 3.553712] systemd-sysroot-fstab-check[168]: /sysroot should be mounted in the initrd, will request daemon-reload.1928machine # [ 3.568857] systemd[1]: Mounted /sysroot/nix/.ro-store.1929machine # [ 3.571362] systemd[1]: Mounted /sysroot/nix/.rw-store.1930machine # [ 3.573448] systemd[1]: Mounted /sysroot/run.1931machine # [ 3.574681] systemd[1]: Mounted /sysroot/tmp/shared.1932machine # [ 3.575663] systemd[1]: Mounted /sysroot/tmp/xchg.1933machine # [ 3.579986] systemd[1]: Reload requested from client PID 168 ('systemd-sysroot') (unit initrd-parse-etc.service)...1934machine # [ 3.581904] systemd[1]: Reloading...1935machine # [ 3.647985] systemd[1]: Reloading finished in 65 ms.1936machine # [ 3.657486] systemd-sysroot-fstab-check[168]: Requesting initrd-fs.target/start/replace...1937machine # [ 3.661839] systemd-sysroot-fstab-check[168]: Requesting swap.target/start/replace...1938machine # [ 3.663355] systemd[1]: Starting rw-sysroot-nix-store.service...1939machine # [ 3.673426] systemd[1]: initrd-parse-etc.service: Deactivated successfully.1940machine # [ 3.676255] systemd[1]: Finished Mountpoints Configured in the Real Root.1941machine # [ 3.679160] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies.1942machine # [ 3.692442] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1943machine # [ 3.693995] systemd[1]: Finished rw-sysroot-nix-store.service.1944machine # [ 4.176653] systemd[1]: Mounting /sysroot/nix/store...1945machine # [ 4.226143] systemd[1]: Mounted /sysroot/nix/store.1946machine # [ 4.228983] systemd[1]: Reached target Initrd File Systems.1947machine # [ 4.233120] systemd[1]: Starting Find NixOS closure...1948machine # [ 4.236880] systemd[1]: Starting Create Volatile Files and Directories in the Real Root...1949machine # [ 4.262541] systemd[1]: Finished Create Volatile Files and Directories in the Real Root.1950machine # [ 4.264824] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully.1951machine # [ 4.272676] systemd[1]: Finished Find NixOS closure.1952machine # [ 4.273857] systemd[1]: Reached target Initrd Default Target.1953machine # [ 4.275714] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...1954machine # [ 4.286331] systemd[1]: initrd-cleanup.service: Deactivated successfully.1955machine # [ 4.287669] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.1956machine # [ 4.291672] systemd[1]: Startup finished in 858ms (kernel) + 0 (initrd) + 3.432s (userspace) = 4.291s.1957machine: (finished: waiting for unit initrd.target, in 5.40 seconds)1958machine: waiting for the VM to finish booting1959machine # [ 4.731491] systemd[1]: Stopped target Initrd Default Target.1960machine # [ 4.732618] systemd[1]: Stopped target Basic System.1961machine # [ 4.733537] systemd[1]: Stopped target Initrd Root Device.1962machine # [ 4.734465] systemd[1]: Stopped target Path Units.1963machine: Guest shell says: b'\n'1964machine # [ 4.736523] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.1965machine # [ 4.737897] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.1966machine # [ 4.739534] systemd[1]: Stopped target Slice Units.1967machine # [ 4.740819] systemd[1]: Stopped target Socket Units.1968machine # [ 4.742161] systemd[1]: Stopped target System Initialization.1969machine # [ 4.743131] systemd[1]: Stopped target Swaps.1970machine # [ 4.744138] systemd[1]: Stopped target Timer Units.1971machine # [ 4.745707] systemd[1]: dbus.socket: Deactivated successfully.1972machine # [ 4.746755] systemd[1]: Closed D-Bus System Message Bus Socket.1973machine # [ 4.747931] systemd[1]: Stopping backdoor.service...1974machine # [ 4.749936] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...1975machine # [ 4.751176] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully.1976machine # [ 4.752391] systemd[1]: Stopped Find NixOS closure.1977machine # [ 4.755174] systemd[1]: Starting rw-sysroot-nix-store.service...1978machine # [ 4.756232] systemd[1]: systemd-sysctl.service: Deactivated successfully.1979machine # [ 4.757982] systemd[1]: Stopped Apply Kernel Variables.1980machine # [ 4.758910] systemd[1]: systemd-modules-load.service: Deactivated successfully.1981machine # [ 4.760412] systemd[1]: Stopped Load Kernel Modules.1982machine # [ 4.763168] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully.1983machine # [ 4.764409] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root.1984machine # [ 4.765635] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.1985machine # [ 4.766755] systemd[1]: Stopped Create System Files and Directories.1986machine # [ 4.767751] systemd[1]: Stopped target Local File Systems.1987machine # [ 4.769658] systemd[1]: Stopped target Preparation for Local File Systems.1988machine # [ 4.770743] systemd[1]: systemd-udev-trigger.service: Deactivated successfully.1989machine # [ 4.771872] systemd[1]: Stopped Coldplug All udev Devices.1990machine # [ 4.776434] systemd[1]: Stopping Rule-based Manager for Device Events and Files...1991machine # [ 4.777686] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1992machine # [ 4.778926] systemd[1]: Stopped Virtual Console Setup.1993machine # [ 4.782937] systemd[1]: backdoor.service: Deactivated successfully.1994machine # [ 4.787777] systemd[1]: Stopped backdoor.service.1995machine # [ 4.790714] systemd[1]: systemd-udevd.service: Deactivated successfully.1996machine # [ 4.795099] systemd[1]: Stopped Rule-based Manager for Device Events and Files.1997machine # [ 4.799096] systemd[1]: systemd-udevd-varlink.socket: Deactivated successfully.1998machine # [ 4.803088] systemd[1]: Closed udev Varlink Socket.1999machine # [ 4.807724] systemd[1]: Starting Cleanup udev Database...2000machine # [ 4.808706] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.2001machine # [ 4.809897] systemd[1]: Stopped Create Static Device Nodes in /dev.2002machine # [ 4.810879] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.2003machine # [ 4.812111] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.2004machine # [ 4.815554] systemd[1]: kmod-static-nodes.service: Deactivated successfully.2005machine # [ 4.816706] systemd[1]: Stopped Create List of Static Device Nodes.2006machine # [ 4.821628] systemd[1]: initrd-cleanup.service: Deactivated successfully.2007machine # [ 4.823313] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.2008machine # [ 4.824857] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.2009machine # [ 4.827551] systemd[1]: Finished rw-sysroot-nix-store.service.2010machine # [ 4.847842] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.2011machine # [ 4.849715] systemd[1]: Finished Cleanup udev Database.2012machine # [ 4.851978] systemd[1]: Reached target Switch Root.2013machine # [ 4.853228] systemd[1]: Starting NixOS Activation...2014machine # [ 4.922481] initrd-nixos-activation-start[232]: booting system configuration /nix/store/l8fq20sqvpsln2vdy6rxiw4iaqx43q34-nixos-system-machine-test2015machine # [ 4.947729] initrd-nixos-activation-start[232]: running activation script...2016machine # [ 5.265851] initrd-nixos-activation-start[255]: setting up /etc...2017machine # [ 5.430984] systemd[1]: initrd-nixos-activation.service: Deactivated successfully.2018machine # [ 5.433121] systemd[1]: Finished NixOS Activation.2019machine # [ 5.434761] systemd[1]: Starting Switch Root...2020machine # [ 5.448754] systemd[1]: Switching root.2021machine # [ 5.718315] systemd-journald[65]: Received SIGTERM from PID 1 (systemd).2022machine # [ 5.775668] NET: Registered PF_VSOCK protocol family2023machine # [ 5.796028] systemd[1]: systemd 263-0f0682b 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 +EXPERIMENTAL-ENVVAR)2024machine # [ 5.800399] systemd[1]: Detected virtualization kvm.2025machine # [ 5.801111] systemd[1]: Detected architecture x86-64.2026machine # [ 5.886506] systemd[1]: bpf-restrict-fs: LSM BPF program attached2027machine # [ 6.209096] systemd[1]: initrd-switch-root.service: Deactivated successfully.2028machine # [ 6.210545] systemd[1]: Stopped initrd-switch-root.service.2029machine # [ 6.212669] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.2030machine # [ 6.214826] systemd[1]: Created slice Slice /system/getty.2031machine # [ 6.216256] systemd[1]: Created slice User and Session Slice.2032machine # [ 6.217116] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.2033machine # [ 6.218300] systemd[1]: Started Forward Password Requests to Wall Directory Watch.2034machine # [ 6.219514] systemd[1]: Expecting device /dev/hvc0...2035machine # [ 6.220248] systemd[1]: Expecting device /dev/ttyS0...2036machine # [ 6.220971] systemd[1]: Reached target Local Encrypted Volumes.2037machine # [ 6.221848] systemd[1]: Stopped target initrd-fs.target.2038machine # [ 6.222635] systemd[1]: Stopped target initrd-root-fs.target.2039machine # [ 6.223433] systemd[1]: Stopped target initrd-switch-root.target.2040machine # [ 6.224287] systemd[1]: Reached target Virtual Machines and Containers.2041machine # [ 6.225209] systemd[1]: Reached target Path Units.2042machine # [ 6.225896] systemd[1]: Reached target Remote File Systems.2043machine # [ 6.226697] systemd[1]: Reached target Slice Units.2044machine # [ 6.227424] systemd[1]: Reached target Swaps.2045machine # [ 6.229070] systemd[1]: Listening on Query the User Interactively for a Password.2046machine # [ 6.245889] systemd[1]: Listening on Process Core Dump Socket.2047machine # [ 6.247778] systemd[1]: Listening on Credential Encryption/Decryption.2048machine # [ 6.249843] systemd[1]: Listening on Factory Reset Management.2049machine # [ 6.250929] systemd[1]: Listening on Hostname Service Socket.2050machine # [ 6.253848] systemd[1]: Starting Journal Log Access Socket...2051machine # [ 6.256175] systemd[1]: Listening on Journal Audit Socket.2052machine # [ 6.257882] systemd[1]: Listening on Console Output Muting Service Socket.2053machine # [ 6.259039] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.2054machine # [ 6.260212] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2055machine # [ 6.261506] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2056machine # [ 6.264984] systemd[1]: Listening on Disk Repartitioning Service Socket.2057machine # [ 6.266067] systemd[1]: Listening on udev Varlink Socket.2058machine # [ 6.268315] systemd[1]: Mounting Huge Pages File System...2059machine # [ 6.271125] systemd[1]: Mounting POSIX Message Queue File System...2060machine # [ 6.278253] systemd[1]: Mounting Kernel Debug File System...2061machine # [ 6.286720] systemd[1]: Mounting Kernel Trace File System...2062machine # [ 6.297493] systemd[1]: Starting Create List of Static Device Nodes...2063machine # [ 6.308475] systemd[1]: Starting Load Kernel Module configfs...2064machine # [ 6.319551] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm2065machine # [ 6.330658] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2066machine # [ 6.342837] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse2067machine # [ 6.359521] systemd[1]: Mounting FUSE Control File System...2068machine # [ 6.362414] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672069machine # [ 6.373580] systemd[1]: Starting Journal Service...2070machine # [ 6.379990] systemd[1]: Starting Load Kernel Modules...2071machine # [ 6.390820] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...2072machine # [ 6.410636] systemd[1]: Starting Remount Root and Kernel File Systems...2073machine # [ 6.415979] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2074machine # [ 6.427586] systemd[1]: Starting Coldplug All udev Devices...2075machine # [ 6.433948] systemd-journald[326]: Collecting audit messages is enabled.2076machine # [ 6.452764] systemd[1]: Listening on Journal Log Access Socket.2077machine # [ 6.461843] systemd[1]: Mounted Huge Pages File System.2078machine # [ 6.318317] systemd[1]: Queued start job for default target Multi-User System.2079machine # [ 6.320700] systemd[1]: Unnecessary job was removed for /sys/devices/pnp0/00:03/00:03:0/00:03:0.0/tty/ttyS0.2080machine # [ 6.324371] systemd[1]: Unnecessary job was removed for /sys/devices/virtual/tty/hvc0.2081machine # [ 6.470982] systemd[1]: Started Journal Service.2082machine # [ 6.328610] systemd[1]: systemd-journald.service: Deactivated successfully.2083machine # [ 6.484895] loop: module loaded2084machine # [ 6.340509] systemd[1]: Mounted POSIX Message Queue File System.2085machine # [ 6.342163] systemd[1]: Mounted Kernel Debug File System.2086machine # [ 6.342960] systemd[1]: Mounted Kernel Trace File System.2087machine # [ 6.347485] systemd-modules-load[327]: Inserted module 'loop'2088machine # [ 6.348390] systemd[1]: Finished Create List of Static Device Nodes.2089machine # [ 6.351186] systemd[1]: modprobe@configfs.service: Deactivated successfully.2090machine # [ 6.354286] systemd[1]: Finished Load Kernel Module configfs.2091machine # [ 6.366039] systemd[1]: Finished Load Kernel Modules.2092machine # [ 6.517269] EXT4-fs (vda): re-mounted 1614790b-031f-4d6a-bb61-20cad1f026f6.2093machine # [ 6.377910] systemd[1]: Mounted FUSE Control File System.2094machine # [ 6.389140] systemd[1]: Mounting Kernel Configuration File System...2095machine # [ 6.393208] systemd[1]: Starting Firewall...2096machine # [ 6.405114] systemd[1]: Starting Apply Kernel Variables...2097machine # [ 6.415767] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...2098machine # [ 6.419133] systemd[1]: Finished Remount Root and Kernel File Systems.2099machine # [ 6.423969] systemd[1]: Listening on Disk Image Download Service Socket.2100machine # [ 6.430211] systemd-oomd[329]: No swap; memory pressure usage will be degraded2101machine # [ 6.449177] systemd[1]: Starting Grow Root File System...2102machine # [ 6.461081] systemd[1]: Starting Flush Journal to Persistent Storage...2103machine # [ 6.462106] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2104machine # [ 6.470263] systemd[1]: Starting Load/Save OS Random Seed...2105machine # [ 6.472402] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2106machine # [ 6.494673] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.2107machine # [ 6.559367] systemd[1]: Finished Apply Kernel Variables.2108machine # [ 6.715115] EXT4-fs (vda): resizing filesystem from 262144 to 524288 blocks2109machine # [ 6.720123] systemd-journald[326]: Received client request to flush runtime journal.2110machine # [ 7.160368] EXT4-fs (vda): resized filesystem to 5242882111machine # [ 7.423827] mousedev: PS/2 mouse device common for all mice2112machine # [ 7.442079] bochs-drm 0000:00:01.0: vgaarb: deactivate vga console2113machine # [ 7.545249] rtc_cmos PNP0B00:00: RTC can wake from S42114machine # [ 7.555524] rtc_cmos PNP0B00:00: registered as rtc02115machine # [ 7.555595] rtc_cmos PNP0B00:00: setting system clock to 2026-10-24T03:07:39 UTC (1792811259)2116machine # [ 7.555701] rtc_cmos PNP0B00:00: alarms up to one day, y3k, 242 bytes nvram, hpet irqs2117machine # [ 7.573615] input: QEMU Virtio Keyboard as /devices/pci0000:00/0000:00:06.0/virtio4/input/input32118machine # [ 7.580945] parport_pc 00:02: reported by Plug and Play ACPI2119machine # [ 7.581038] parport0: PC-style at 0x378, irq 7 [PCSPP(,...)]2120machine # [ 7.589350] lpc_ich 0000:00:1f.0: I/O space for GPIO uninitialized2121machine # [ 7.605910] Console: switching to colour dummy device 80x252122machine # [ 7.669219] i801_smbus 0000:00:1f.3: SMBus using PCI interrupt2123machine # [ 7.669339] i2c i2c-0: Memory type 0x07 not supported yet, not instantiating SPD2124machine # [ 7.693333] [drm] Found bochs VGA, ID 0xb0c5.2125machine # [ 7.693335] [drm] Framebuffer size 16384 kB @ 0xfd000000, mmio @ 0xfebd0000.2126machine # [ 7.700692] bochs-drm 0000:00:01.0: [drm] Registered 1 planes with drm panic2127machine # [ 7.701458] [drm] Initialized bochs-drm 1.0.0 for 0000:00:01.0 on minor 02128machine # [ 7.717557] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input52129machine # [ 7.718719] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input42130machine # [ 7.825594] Console: switching to colour frame buffer device 160x502131machine # [ 7.833499] ppdev: user-space parallel port driver2132machine # [ 7.839957] bochs-drm 0000:00:01.0: [drm] fb0: bochs-drmdrmfb frame buffer device2133machine # [ 7.907397] iTCO_wdt iTCO_wdt.1.auto: Found a ICH9 TCO device (Version=2, TCOBASE=0x0660)2134machine # [ 7.931075] iTCO_wdt iTCO_wdt.1.auto: initialized. heartbeat=30 sec (nowayout=0)2135machine # [ 8.080659] kvm_amd: TSC scaling supported2136machine # [ 8.081108] kvm_amd: Nested Virtualization enabled2137machine # [ 8.084227] kvm_amd: Nested Paging enabled2138machine # [ 8.084666] kvm_amd: LBR virtualization supported2139machine # [ 8.085099] kvm_amd: Virtual VMLOAD VMSAVE supported2140machine # [ 8.087222] kvm_amd: Virtual GIF supported2141machine # [ 8.087652] kvm_amd: Virtual NMI enabled2142machine # [ 8.006225] systemd[1]: Mounted Kernel Configuration File System.2143machine # [ 8.008525] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.2144machine # [ 8.010149] systemd[1]: Starting Create Static Device Nodes in /dev...2145machine # [ 8.011402] systemd[1]: Finished Create Static Device Nodes in /dev.2146machine # [ 8.012867] systemd[1]: Reached target Preparation for Local File Systems.2147machine # [ 8.015785] systemd[1]: Starting Rule-based Manager for Device Events and Files...2148machine # [ 8.017889] systemd[1]: Finished Coldplug All udev Devices.2149machine # [ 8.020566] systemd-udevd[363]: Using default interface naming scheme 'v261'.2150machine # [ 8.022534] systemd[1]: Started Rule-based Manager for Device Events and Files.2151machine # [ 8.023653] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse2152machine # [ 8.025343] systemd[1]: Found device /dev/hvc0.2153machine # [ 8.026162] systemd[1]: Found device /dev/ttyS0.2154machine # [ 8.027364] (udev-worker)[390]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.2155machine # [ 8.029470] (udev-worker)[390]: Network interface NamePolicy= disabled on kernel command line.2156machine # [ 8.031140] (udev-worker)[384]: Network interface NamePolicy= disabled on kernel command line.2157machine # [ 8.032626] systemd[1]: Mounting /run/wrappers...2158machine # [ 8.033447] systemd[1]: Mounted /run/wrappers.2159machine # [ 8.034204] systemd[1]: Starting Create SUID/SGID Wrappers...2160machine # [ 8.035315] systemd[1]: Condition check resulted in Virtio network device being skipped.2161machine # [ 8.036474] systemd[1]: Condition check resulted in Virtio network device being skipped.2162machine # [ 8.037679] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2163machine # [ 8.039166] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672164machine # [ 8.041315] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2165machine # [ 8.042911] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2166machine # [ 8.044405] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2167machine # [ 8.045908] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2168machine # [ 8.047179] systemd[1]: Finished Create SUID/SGID Wrappers.2169machine # [ 8.048060] systemd[1]: Starting Virtual Console Setup...2170machine # [ 8.048939] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.2171machine # [ 8.050097] systemd-growfs[347]: Successfully resized "/" to 2G bytes.2172machine # [ 8.051151] systemd[1]: Stopped Virtual Console Setup.2173machine # [ 8.051984] systemd[1]: Finished Grow Root File System.2174machine # [ 8.054745] systemd[1]: Reached target Local File Systems.2175machine # [ 8.055660] systemd[1]: Listening on Boot Loader Control Service Socket.2176machine # [ 8.058179] systemd[1]: Starting Virtual Console Setup...2177machine # [ 8.058990] systemd[1]: Finished Load/Save OS Random Seed.2178machine # [ 8.059939] systemd[1]: First Boot Complete skipped, unmet condition check ConditionFirstBoot=yes2179machine # [ 8.062478] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2180machine # [ 8.064619] systemd[1]: Save Transient machine-id to Disk skipped, unmet condition check ConditionPathIsMountPoint=/etc/machine-id2181machine # [ 8.067171] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.2182machine # [ 8.069126] systemd[1]: Stopped Virtual Console Setup.2183machine # [ 8.069878] systemd[1]: Starting Virtual Console Setup...2184machine # [ 8.071178] systemd[1]: Finished Flush Journal to Persistent Storage.2185machine # [ 8.074608] systemd[1]: Starting Create System Files and Directories...2186machine # [ 8.246629] EDAC MC: Ver: 3.0.02187machine # [ 8.150377] systemd[1]: Finished Create System Files and Directories.2188machine # [ 8.154235] systemd[1]: Rebuild Journal Catalog skipped, unmet condition check ConditionNeedsUpdate=/var2189machine # [ 8.157265] systemd[1]: Update is Completed skipped, no trigger condition checks were met.2190machine # [ 8.161352] systemd[1]: Starting Record System Boot/Shutdown in UTMP...2191machine # [ 8.199197] systemd[1]: Finished Record System Boot/Shutdown in UTMP.2192machine # [ 8.235119] systemd[1]: Finished Firewall.2193machine # [ 8.239105] systemd-vconsole-setup[502]: Configuration of first virtual console was skipped, ignoring remaining ones.2194machine # [ 8.241982] systemd[1]: Finished Virtual Console Setup.2195machine # [ 8.243865] systemd[1]: Reached target System Initialization.2196machine # [ 8.245441] systemd[1]: Started Discard unused filesystem blocks once a week.2197machine # [ 8.246853] systemd[1]: Started Daily Cleanup of Temporary Directories.2198machine # [ 8.248134] systemd[1]: Reached target Timer Units.2199machine # [ 8.249195] systemd[1]: Listening on D-Bus System Message Bus Socket.2200machine # [ 8.250405] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.2201machine # [ 8.252158] systemd[1]: Reached target Socket Units.2202machine # [ 8.252926] systemd[1]: Reached target Basic System.2203machine # [ 8.254615] systemd[1]: Started backdoor.service.2204machine # [ 8.256104] systemd[1]: Import lastlog data into lastlog2 database skipped, unmet condition check ConditionPathExists=!/var/lib/lastlog/lastlog2.db2205machine # [ 8.261066] systemd[1]: Starting Name Service Cache Daemon (nsncd)...2206machine # [ 8.266158] systemd[1]: Starting Post-Boot Actions...2207machine # [ 8.270405] systemd[1]: Started Reset console on configuration changes.2208machine # [ 8.283055] systemd[1]: Starting resolvconf update...2209machine # [ 8.306840] systemd[1]: Starting D-Bus System Message Bus...2210machine # [ 8.338192] systemd[1]: Started Name Service Cache Daemon (nsncd).2211machine # [ 8.340324] nsncd[554]: Oct 24 03:07:40.428 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"2212machine # connecting to host...2213machine # [ 8.347206] systemd[1]: Finished Post-Boot Actions.2214machine # [ 8.351289] systemd[1]: Reached target Host and Network Name Lookups.2215machine # [ 8.352218] systemd[1]: Reached target User and Group Name Lookups.2216machine # [ 8.363727] systemd[1]: Starting User Login Management...2217machine: Guest shell says: b'Spawning backdoor root shell...\n'2218machine: connected to guest root shell2219machine: (connecting took 3.67 seconds)2220machine: (finished: waiting for the VM to finish booting, in 3.67 seconds)2221machine: must succeed: df --output=avail / | sed 1d2222machine # [ 8.433691] dbus-broker-launch[559]: Looking up NSS user entry for 'systemd-timesync'...2223machine # [ 8.439340] dbus-broker-launch[559]: NSS returned no entry for 'systemd-timesync'2224machine # [ 8.440506] dbus-broker-launch[559]: Invalid user-name in /nix/store/vsgk3swqdm3r6cy8rjzppghng954avzi-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"2225machine: (finished: must succeed: df --output=avail / | sed 1d, in 0.08 seconds)2226(finished: subtest: growfs works, in 10.91 seconds)2227subtest: no warnings from systemd about write permissions2228machine: must fail: journalctl -b 0 | grep 'is marked world-writable, which is a security risk as it is executed with privileges'2229machine # [ 8.477971] systemd[1]: Started D-Bus System Message Bus.2230machine # [ 8.494881] systemd-logind[576]: New seat seat0.2231machine # [ 8.504523] systemd-logind[576]: Watching system buttons on /dev/input/event2 (QEMU Virtio Keyboard)2232machine # [ 8.505807] systemd-logind[576]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard)2233machine # [ 8.507106] systemd[1]: Started User Login Management.2234machine # [ 8.514721] systemd[1]: Starting linger-users.service...2235machine # [ 8.520606] dbus-broker-launch[559]: Ready2236machine # [ 8.547580] systemd[1]: Stopped target Host and Network Name Lookups.2237machine # [ 8.549426] systemd[1]: Stopping Host and Network Name Lookups...2238machine # [ 8.550337] systemd[1]: Stopped target User and Group Name Lookups.2239machine # [ 8.551761] systemd[1]: Stopping User and Group Name Lookups...2240machine # [ 8.552946] systemd[1]: Stopping Name Service Cache Daemon (nsncd)...2241machine # [ 8.558434] systemd[1]: nscd.service: Deactivated successfully.2242machine # [ 8.559367] systemd[1]: Stopped Name Service Cache Daemon (nsncd).2243machine # [ 8.577882] systemd[1]: Starting Name Service Cache Daemon (nsncd)...2244machine # [ 8.599560] systemd[1]: linger-users.service: Deactivated successfully.2245machine # [ 8.604404] systemd[1]: Finished linger-users.service.2246machine: (finished: must fail: journalctl -b 0 | grep 'is marked world-writable, which is a security risk as it is executed with privileges', in 0.15 seconds)2247(finished: subtest: no warnings from systemd about write permissions, in 0.15 seconds)2248(finished: run the VM test script, in 27.75 seconds)2249machine # [ 8.643634] systemd[1]: Started Name Service Cache Daemon (nsncd).2250machine # [ 8.644810] nsncd[637]: Oct 24 03:07:40.732 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"2251machine # [ 8.647821] systemd[1]: Reached target Host and Network Name Lookups.2252machine # [ 8.649889] systemd[1]: Reached target User and Group Name Lookups.2253machine # [ 8.655905] systemd[1]: Finished resolvconf update.2254machine # [ 8.658234] systemd[1]: Reached target Preparation for Network.2255machine # [ 8.662408] systemd[1]: Starting DHCP Client...2256machine # [ 8.667154] systemd[1]: Starting Address configuration of eth1...2257machine # [ 8.673320] systemd[1]: Starting Extra networking commands....2258machine # [ 8.748350] network-addresses-eth1-start[665]: adding address 192.168.1.1/24... done2259machine # [ 8.761440] network-addresses-eth1-start[665]: adding address 2001:db8:1::1/64... done2260machine # [ 8.778603] systemd[1]: Finished Address configuration of eth1.2261test script finished in 27.94s2262cleanup2263kill QemuMachine (pid 107)2264machine # qemu-system-x86_64: terminating on signal 15 from pid 39 (/nix/store/xahxrjs30p3mw0a42bqg9ikgkikskw8m-python3-3.14.8/bin/python3.14)2265machine # [2026-10-24T03:07:41Z INFO virtiofsd] Client disconnected, shutting down2266machine # [2026-10-24T03:07:41Z INFO virtiofsd] Client disconnected, shutting down2267machine # [2026-10-24T03:07:41Z INFO virtiofsd] Client disconnected, shutting down2268(finished: cleanup, in 0.56 seconds)