tribuchet: building on jamie Machine state will be reset. To keep it, pass --keep-machine-state start all VLans (finished: start all VLans, in 0.00 seconds) Test will time out and terminate in 3600.0 seconds run the VM test script start all VMs machine: starting vm machine # Disk image does not exist, creating the virtualisation disk image... machine: QEMU running (pid 46) machine # Formatting '/build/vm-state-machine/tmp.w8S16OmmeK', fmt=raw size=1073741824 machine # mke2fs 1.47.4 (6-Mar-2025) machine # Discarding device blocks: 0/262144 done (finished: start all VMs, in 0.34 seconds) machine # Creating filesystem with 262144 4k blocks and 65536 inodes machine # Filesystem UUID: 372c99e0-324a-4da2-b90d-2250d85955fc machine: waiting for unit multi-user.target machine # Superblock backups stored on blocks: machine: waiting for the VM to finish booting machine # 32768, 98304, 163840, 229376 machine # machine # Allocating group tables: 0/8 done machine # Writing inode tables: 0/8 done machine # Creating journal (8192 blocks): done machine # Writing superblocks and filesystem accounting information: 0/8 done machine # machine # Virtualisation disk image created. machine # Starting virtiofs daemons... machine # [2026-09-21T12:46:53Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1) machine # [2026-09-21T12:46:53Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether machine # [2026-09-21T12:46:53Z INFO virtiofsd] Waiting for vhost-user socket connection... machine # [2026-09-21T12:46:53Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1) machine # [2026-09-21T12:46:53Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether machine # [2026-09-21T12:46:53Z INFO virtiofsd] Waiting for vhost-user socket connection... machine # [2026-09-21T12:46:53Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1) machine # [2026-09-21T12:46:53Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether machine # [2026-09-21T12:46:53Z INFO virtiofsd] Waiting for vhost-user socket connection... machine # [2026-09-21T12:46:53Z INFO virtiofsd] Client connected, servicing requests machine # [2026-09-21T12:46:53Z INFO virtiofsd] Client connected, servicing requests machine # [2026-09-21T12:46:54Z INFO virtiofsd] Client connected, servicing requests machine # SeaBIOS (version rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org) machine # machine # machine # iPXE (http://ipxe.org) 00:02.0 CA00 PCI2.10 PnP PMM+3EFCC730+3EF2C730 CA00 machine # Press Ctrl-B to configure iPXE (PCI 00:02.0)... machine # machine # machine # machine # machine # iPXE (http://ipxe.org) 00:05.0 CB00 PCI2.10 PnP PMM 3EFCC730 3EF2C730 CB00 machine # Press Ctrl-B to configure iPXE (PCI 00:05.0)... machine # machine # machine # Booting from ROM... machine # Probing EDD (edd=off to disable)... ok[ 0.000000] Linux version 6.18.52 (nixbld@localhost) (gcc (GCC) 15.3.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT_DYNAMIC Mon Sep 14 11:36:19 UTC 2026 machine # [ 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/ljf1yfxd2y3hvnj1bh7wmwy81yi8ha6v-nixos-system-machine-test/init regInfo=/nix/.ro-store/s94x93g1ysrdm2hf5pp3ps1varvn50s9-closure-info/registration console=ttyS0,115200n8 console=tty0 machine # [ 0.000000] BIOS-provided physical RAM map: machine # [ 0.000000] BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable machine # [ 0.000000] BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved machine # [ 0.000000] BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved machine # [ 0.000000] BIOS-e820: [mem 0x0000000000100000-0x000000003ffd7fff] usable machine # [ 0.000000] BIOS-e820: [mem 0x000000003ffd8000-0x000000003fffffff] reserved machine # [ 0.000000] BIOS-e820: [mem 0x00000000b0000000-0x00000000bfffffff] reserved machine # [ 0.000000] BIOS-e820: [mem 0x00000000fed1c000-0x00000000fed1ffff] reserved machine # [ 0.000000] BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved machine # [ 0.000000] BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved machine # [ 0.000000] BIOS-e820: [mem 0x000000fd00000000-0x000000ffffffffff] reserved machine # [ 0.000000] NX (Execute Disable) protection: active machine # [ 0.000000] APIC: Static calls initialized machine # [ 0.000000] SMBIOS 2.8 present. machine # [ 0.000000] DMI: QEMU Standard PC (Q35 + ICH9, 2009), BIOS rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org 04/01/2014 machine # [ 0.000000] DMI: Memory slots populated: 1/1 machine # [ 0.000000] Hypervisor detected: KVM machine # [ 0.000000] last_pfn = 0x3ffd8 max_arch_pfn = 0x10000000000 machine # [ 0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d00 machine # [ 0.000001] kvm-clock: using sched offset of 502911055 cycles machine # [ 0.000002] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns machine # [ 0.000005] tsc: Detected 2400.012 MHz processor machine # [ 0.000808] last_pfn = 0x3ffd8 max_arch_pfn = 0x10000000000 machine # [ 0.000835] MTRR map: 4 entries (3 fixed + 1 variable; max 19), built from 8 variable MTRRs machine # [ 0.000838] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT machine # [ 0.002732] found SMP MP-table at [mem 0x000f5450-0x000f545f] machine # [ 0.002743] Using GB pages for direct mapping machine # [ 0.002816] RAMDISK: [mem 0x3e421000-0x3ffcffff] machine # [ 0.002824] ACPI: Early table checksum verification disabled machine # [ 0.002827] ACPI: RSDP 0x00000000000F5270 000014 (v00 BOCHS ) machine # [ 0.002831] ACPI: RSDT 0x000000003FFE2422 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) machine # [ 0.002835] ACPI: FACP 0x000000003FFE221A 0000F4 (v03 BOCHS BXPC 00000001 BXPC 00000001) machine # [ 0.002842] ACPI: DSDT 0x000000003FFE0040 0021DA (v01 BOCHS BXPC 00000001 BXPC 00000001) machine # [ 0.002844] ACPI: FACS 0x000000003FFE0000 000040 machine # [ 0.002845] ACPI: APIC 0x000000003FFE230E 000078 (v03 BOCHS BXPC 00000001 BXPC 00000001) machine # [ 0.002847] ACPI: HPET 0x000000003FFE2386 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) machine # [ 0.002849] ACPI: MCFG 0x000000003FFE23BE 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001) machine # [ 0.002850] ACPI: WAET 0x000000003FFE23FA 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001) machine # [ 0.002851] ACPI: Reserving FACP table memory at [mem 0x3ffe221a-0x3ffe230d] machine # [ 0.002852] ACPI: Reserving DSDT table memory at [mem 0x3ffe0040-0x3ffe2219] machine # [ 0.002853] ACPI: Reserving FACS table memory at [mem 0x3ffe0000-0x3ffe003f] machine # [ 0.002853] ACPI: Reserving APIC table memory at [mem 0x3ffe230e-0x3ffe2385] machine # [ 0.002854] ACPI: Reserving HPET table memory at [mem 0x3ffe2386-0x3ffe23bd] machine # [ 0.002854] ACPI: Reserving MCFG table memory at [mem 0x3ffe23be-0x3ffe23f9] machine # [ 0.002855] ACPI: Reserving WAET table memory at [mem 0x3ffe23fa-0x3ffe2421] machine # [ 0.003087] No NUMA configuration found machine # [ 0.003088] Faking a node at [mem 0x0000000000000000-0x000000003ffd7fff] machine # [ 0.003091] NODE_DATA(0) allocated [mem 0x3ffd2780-0x3ffd7cff] machine # [ 0.005503] Zone ranges: machine # [ 0.005503] DMA [mem 0x0000000000001000-0x0000000000ffffff] machine # [ 0.005505] DMA32 [mem 0x0000000001000000-0x000000003ffd7fff] machine # [ 0.005506] Normal empty machine # [ 0.005507] Device empty machine # [ 0.005507] Movable zone start for each node machine # [ 0.005508] Early memory node ranges machine # [ 0.005509] node 0: [mem 0x0000000000001000-0x000000000009efff] machine # [ 0.005510] node 0: [mem 0x0000000000100000-0x000000003ffd7fff] machine # [ 0.005511] Initmem setup node 0 [mem 0x0000000000001000-0x000000003ffd7fff] machine # [ 0.005531] On node 0, zone DMA: 1 pages in unavailable ranges machine # [ 0.005807] On node 0, zone DMA: 97 pages in unavailable ranges machine # [ 0.023922] On node 0, zone DMA32: 40 pages in unavailable ranges machine # [ 0.024374] ACPI: PM-Timer IO Port: 0x608 machine # [ 0.024385] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) machine # [ 0.024412] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 machine # [ 0.024415] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) machine # [ 0.024417] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) machine # [ 0.024418] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) machine # [ 0.024419] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) machine # [ 0.024419] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) machine # [ 0.024422] ACPI: Using ACPI (MADT) for SMP configuration information machine # [ 0.024423] ACPI: HPET id: 0x8086a201 base: 0xfed00000 machine # [ 0.024426] TSC deadline timer available machine # [ 0.024430] CPU topo: Max. logical packages: 1 machine # [ 0.024431] CPU topo: Max. logical dies: 1 machine # [ 0.024431] CPU topo: Max. dies per package: 1 machine # [ 0.024435] CPU topo: Max. threads per core: 1 machine # [ 0.024435] CPU topo: Num. cores per package: 1 machine # [ 0.024436] CPU topo: Num. threads per package: 1 machine # [ 0.024436] CPU topo: Allowing 1 present CPUs plus 0 hotplug CPUs machine # [ 0.024451] kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write() machine # [ 0.024481] PM: hibernation: Registered nosave memory: [mem 0x00000000-0x00000fff] machine # [ 0.024482] PM: hibernation: Registered nosave memory: [mem 0x0009f000-0x000fffff] machine # [ 0.024484] [mem 0x40000000-0xafffffff] available for PCI devices machine # [ 0.024485] Booting paravirtualized kernel on KVM machine # [ 0.024488] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns machine # [ 0.029010] setup_percpu: NR_CPUS:384 nr_cpumask_bits:1 nr_cpu_ids:1 nr_node_ids:1 machine # [ 0.031155] percpu: Embedded 98 pages/cpu s278528 r8192 d114688 u2097152 machine # [ 0.031199] kvm-guest: PV spinlocks disabled, single CPU machine # [ 0.031201] 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/ljf1yfxd2y3hvnj1bh7wmwy81yi8ha6v-nixos-system-machine-test/init regInfo=/nix/.ro-store/s94x93g1ysrdm2hf5pp3ps1varvn50s9-closure-info/registration console=ttyS0,115200n8 console=tty0 machine # [ 0.031294] Unknown kernel command line parameters "regInfo=/nix/.ro-store/s94x93g1ysrdm2hf5pp3ps1varvn50s9-closure-info/registration", will be passed to user space. machine # [ 0.031307] random: crng init done machine # [ 0.031307] printk: log buffer data + meta data: 262144 + 917504 = 1179648 bytes machine # [ 0.031329] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes, linear) machine # [ 0.031341] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes, linear) machine # [ 0.031372] Fallback order for Node 0: 0 machine # [ 0.031375] Built 1 zonelists, mobility grouping on. Total pages: 262006 machine # [ 0.031376] Policy zone: DMA32 machine # [ 0.034109] mem auto-init: stack:all(zero), heap alloc:on, heap free:off machine # [ 0.036557] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1 machine # [ 0.038814] allocated 2097152 bytes of page_ext machine # [ 0.048410] ftrace: allocating 48787 entries in 192 pages machine # [ 0.048412] ftrace: allocated 192 pages with 2 groups machine # [ 0.049233] Dynamic Preempt: lazy machine # [ 0.049399] rcu: Preemptible hierarchical RCU implementation. machine # [ 0.049400] rcu: RCU event tracing is enabled. machine # [ 0.049400] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1. machine # [ 0.049402] Trampoline variant of Tasks RCU enabled. machine # [ 0.049402] Rude variant of Tasks RCU enabled. machine # [ 0.049403] Tracing variant of Tasks RCU enabled. machine # [ 0.049403] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. machine # [ 0.049404] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1 machine # [ 0.049425] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. machine # [ 0.049426] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. machine # [ 0.049427] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. machine # [ 0.053803] NR_IRQS: 24832, nr_irqs: 256, preallocated irqs: 16 machine # [ 0.054093] rcu: srcu_init: Setting srcu_struct sizes based on contention. machine # [ 0.054101] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns machine # [ 0.054201] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____) machine # [ 0.057730] Console: colour VGA+ 80x25 machine # [ 0.057733] printk: legacy console [tty0] enabled machine # [ 0.087186] printk: legacy console [ttyS0] enabled machine # [ 0.194399] ACPI: Core revision 20250807 machine # [ 0.195342] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns machine # [ 0.196962] APIC: Switch to symmetric I/O mode setup machine # [ 0.197990] x2apic enabled machine # [ 0.198735] APIC: Switched APIC routing to: physical x2apic machine # [ 0.200667] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 machine # [ 0.201690] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x229842dd0bd, max_idle_ns: 440795319571 ns machine # [ 0.203424] Calibrating delay loop (skipped) preset value.. 4800.02 BogoMIPS (lpj=2400012) machine # [ 0.205439] x86/cpu: User Mode Instruction Prevention (UMIP) activated machine # [ 0.206580] Last level iTLB entries: 4KB 512, 2MB 255, 4MB 127 machine # [ 0.207423] Last level dTLB entries: 4KB 512, 2MB 255, 4MB 127, 1GB 0 machine # [ 0.208426] mitigations: Enabled attack vectors: user_kernel, user_user, guest_host, guest_guest, SMT mitigations: auto machine # [ 0.209422] Speculative Store Bypass: Mitigation: Speculative Store Bypass disabled via prctl machine # [ 0.210422] Transient Scheduler Attacks: Vulnerable: No microcode machine # [ 0.211422] Spectre V2 : Mitigation: Enhanced / Automatic IBRS machine # [ 0.212422] Speculative Return Stack Overflow: Mitigation: Safe RET machine # [ 0.213422] Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization machine # [ 0.215429] Spectre V2 : Enabling IBPB for BPF machine # [ 0.216422] Spectre V2 : mitigation: Enabling conditional Indirect Branch Prediction Barrier machine # [ 0.217422] active return thunk: srso_alias_return_thunk machine # [ 0.219120] x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers' machine # [ 0.220422] x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers' machine # [ 0.221422] x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers' machine # [ 0.222422] x86/fpu: Supporting XSAVE feature 0x020: 'AVX-512 opmask' machine # [ 0.223422] x86/fpu: Supporting XSAVE feature 0x040: 'AVX-512 Hi256' machine # [ 0.224422] x86/fpu: Supporting XSAVE feature 0x080: 'AVX-512 ZMM_Hi256' machine # [ 0.225422] x86/fpu: Supporting XSAVE feature 0x200: 'Protection Keys User registers' machine # [ 0.226422] x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256 machine # [ 0.228209] x86/fpu: xstate_offset[5]: 832, xstate_sizes[5]: 64 machine # [ 0.229207] x86/fpu: xstate_offset[6]: 896, xstate_sizes[6]: 512 machine # [ 0.230206] x86/fpu: xstate_offset[7]: 1408, xstate_sizes[7]: 1024 machine # [ 0.231210] x86/fpu: xstate_offset[9]: 2432, xstate_sizes[9]: 8 machine # [ 0.232201] x86/fpu: Enabled xstate features 0x2e7, context size is 2440 bytes, using 'compacted' format. machine # [ 0.266242] Freeing SMP alternatives memory: 44K machine # [ 0.267016] pid_max: default: 32768 minimum: 301 machine # [ 0.267520] LSM: initializing lsm=capability,landlock,yama,bpf,ima machine # [ 0.268533] landlock: Up and running. machine # [ 0.269422] Yama: becoming mindful. machine # [ 0.270588] LSM support for eBPF active machine # [ 0.271353] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear) machine # [ 0.272442] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear) machine # [ 0.274935] smpboot: CPU0: AMD EPYC 9654 96-Core Processor (family: 0x19, model: 0x11, stepping: 0x1) machine # [ 0.275924] Performance Events: Fam17h+ core perfctr, AMD PMU driver. machine # [ 0.276427] ... version: 2 machine # [ 0.277188] ... bit width: 48 machine # [ 0.277424] ... generic counters: 6 machine # [ 0.278171] ... generic bitmap: 000000000000003f machine # [ 0.278482] ... fixed-purpose counters: 0 machine # [ 0.279214] ... fixed-purpose bitmap: 0000000000000000 machine # [ 0.279425] ... value mask: 0000ffffffffffff machine # [ 0.280359] ... max period: 00007fffffffffff machine # [ 0.281169] ... global_ctrl mask: 000000000000003f machine # [ 0.281545] signal: max sigframe size: 3376 machine # [ 0.282383] rcu: Hierarchical SRCU implementation. machine # [ 0.283065] rcu: Max phase no-delay instances is 400. machine # [ 0.287949] smp: Bringing up secondary CPUs ... machine # [ 0.288437] smp: Brought up 1 node, 1 CPU machine # [ 0.289138] smpboot: Total of 1 processors activated (4800.02 BogoMIPS) machine # [ 0.289638] Memory: 941764K/1048024K available (17247K kernel code, 2727K rwdata, 13616K rodata, 3652K init, 2976K bss, 98872K reserved, 0K cma-reserved) machine # [ 0.290711] devtmpfs: initialized machine # [ 0.291555] x86/mm: Memory block size: 128MB machine # [ 0.293245] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear) machine # [ 0.294367] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear). machine # [ 0.295501] pinctrl core: initialized pinctrl subsystem machine # [ 0.296665] PM: RTC time: 12:46:54, date: 2026-09-21 machine # [ 0.300160] NET: Registered PF_NETLINK/PF_ROUTE protocol family machine # [ 0.300781] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations machine # [ 0.301444] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations machine # [ 0.302573] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations machine # [ 0.303435] audit: initializing netlink subsys (disabled) machine # [ 0.304665] thermal_sys: Registered thermal governor 'fair_share' machine # [ 0.304667] thermal_sys: Registered thermal governor 'bang_bang' machine # [ 0.305427] audit: type=2000 audit(1789994814.711:1): state=initialized audit_enabled=0 res=1 machine # [ 0.307428] thermal_sys: Registered thermal governor 'step_wise' machine # [ 0.307429] thermal_sys: Registered thermal governor 'user_space' machine # [ 0.308424] thermal_sys: Registered thermal governor 'power_allocator' machine # [ 0.309438] cpuidle: using governor menu machine # [ 0.311668] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 machine # [ 0.312683] PCI: ECAM [mem 0xb0000000-0xbfffffff] (base 0xb0000000) for domain 0000 [bus 00-ff] machine # [ 0.313427] PCI: ECAM [mem 0xb0000000-0xbfffffff] reserved as E820 entry machine # [ 0.314436] PCI: Using configuration type 1 for base access machine # [ 0.315612] kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible. machine # [ 0.322447] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages machine # [ 0.323425] HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page machine # [ 0.328426] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages machine # [ 0.329425] HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page machine # [ 0.340692] ACPI: Added _OSI(Module Device) machine # [ 0.341426] ACPI: Added _OSI(Processor Device) machine # [ 0.342202] ACPI: Added _OSI(Processor Aggregator Device) machine # [ 0.347794] ACPI: 1 ACPI AML tables successfully acquired and loaded machine # [ 0.351836] ACPI: Interpreter enabled machine # [ 0.352439] ACPI: PM: (supports S0 S3 S4 S5) machine # [ 0.353168] ACPI: Using IOAPIC for interrupt routing machine # [ 0.355460] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug machine # [ 0.356425] PCI: Using E820 reservations for host bridge windows machine # [ 0.359559] ACPI: Enabled 2 GPEs in block 00 to 3F machine # [ 0.367135] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) machine # [ 0.367432] acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] machine # [ 0.368503] acpi PNP0A08:00: _OSC: platform does not support [PCIeHotplug LTR] machine # [ 0.369547] acpi PNP0A08:00: _OSC: OS now controls [PME AER PCIeCapability] machine # [ 0.370792] PCI host bridge to bus 0000:00 machine # [ 0.371429] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] machine # [ 0.372425] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] machine # [ 0.373424] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] machine # [ 0.374424] pci_bus 0000:00: root bus resource [mem 0x40000000-0xafffffff window] machine # [ 0.375425] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window] machine # [ 0.376426] pci_bus 0000:00: root bus resource [mem 0x100000000-0x8ffffffff window] machine # [ 0.377425] pci_bus 0000:00: root bus resource [bus 00-ff] machine # [ 0.378448] pci 0000:00:00.0: [8086:29c0] type 00 class 0x060000 conventional PCI endpoint machine # [ 0.379858] pci 0000:00:01.0: [1234:1111] type 00 class 0x030000 conventional PCI endpoint machine # [ 0.382554] pci 0000:00:01.0: BAR 0 [mem 0xfd000000-0xfdffffff pref] machine # [ 0.383452] pci 0000:00:01.0: BAR 2 [mem 0xfebd0000-0xfebd0fff] machine # [ 0.384535] pci 0000:00:01.0: ROM [mem 0xfebc0000-0xfebcffff pref] machine # [ 0.385736] pci 0000:00:01.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff] machine # [ 0.387154] pci 0000:00:02.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint machine # [ 0.389434] pci 0000:00:02.0: BAR 0 [io 0xc100-0xc11f] machine # [ 0.390332] pci 0000:00:02.0: BAR 1 [mem 0xfebd1000-0xfebd1fff] machine # [ 0.391233] pci 0000:00:02.0: BAR 4 [mem 0xfe000000-0xfe003fff 64bit pref] machine # [ 0.392333] pci 0000:00:02.0: ROM [mem 0xfeb40000-0xfeb7ffff pref] machine # [ 0.393795] pci 0000:00:03.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint machine # [ 0.396442] pci 0000:00:03.0: BAR 0 [io 0xc120-0xc13f] machine # [ 0.397331] pci 0000:00:03.0: BAR 1 [mem 0xfebd2000-0xfebd2fff] machine # [ 0.398209] pci 0000:00:03.0: BAR 4 [mem 0xfe004000-0xfe007fff 64bit pref] machine # [ 0.399901] pci 0000:00:04.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint machine # [ 0.402432] pci 0000:00:04.0: BAR 0 [io 0xc000-0xc07f] machine # [ 0.404108] pci 0000:00:04.0: BAR 1 [mem 0xfebd3000-0xfebd3fff] machine # [ 0.404446] pci 0000:00:04.0: BAR 4 [mem 0xfe008000-0xfe00bfff 64bit pref] machine # [ 0.405969] pci 0000:00:05.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint machine # [ 0.407432] pci 0000:00:05.0: BAR 0 [io 0xc140-0xc15f] machine # [ 0.408325] pci 0000:00:05.0: BAR 1 [mem 0xfebd4000-0xfebd4fff] machine # [ 0.409183] pci 0000:00:05.0: BAR 4 [mem 0xfe00c000-0xfe00ffff 64bit pref] machine # [ 0.410272] pci 0000:00:05.0: ROM [mem 0xfeb80000-0xfebbffff pref] machine # [ 0.411966] pci 0000:00:06.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint machine # [ 0.413437] pci 0000:00:06.0: BAR 1 [mem 0xfebd5000-0xfebd5fff] machine # [ 0.414446] pci 0000:00:06.0: BAR 4 [mem 0xfe010000-0xfe013fff 64bit pref] machine # [ 0.415977] pci 0000:00:07.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint machine # [ 0.417437] pci 0000:00:07.0: BAR 1 [mem 0xfebd6000-0xfebd6fff] machine # [ 0.418381] pci 0000:00:07.0: BAR 4 [mem 0xfe014000-0xfe017fff 64bit pref] machine # [ 0.420045] pci 0000:00:08.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint machine # [ 0.421438] pci 0000:00:08.0: BAR 1 [mem 0xfebd7000-0xfebd7fff] machine # [ 0.422447] pci 0000:00:08.0: BAR 4 [mem 0xfe018000-0xfe01bfff 64bit pref] machine # [ 0.423985] pci 0000:00:09.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint machine # [ 0.425437] pci 0000:00:09.0: BAR 1 [mem 0xfebd8000-0xfebd8fff] machine # [ 0.426430] pci 0000:00:09.0: BAR 4 [mem 0xfe01c000-0xfe01ffff 64bit pref] machine # [ 0.427979] pci 0000:00:0a.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint machine # [ 0.429442] pci 0000:00:0a.0: BAR 0 [io 0xc080-0xc0bf] machine # [ 0.430324] pci 0000:00:0a.0: BAR 1 [mem 0xfebd9000-0xfebd9fff] machine # [ 0.431209] pci 0000:00:0a.0: BAR 4 [mem 0xfe020000-0xfe023fff 64bit pref] machine # [ 0.432838] pci 0000:00:0b.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint machine # [ 0.435083] pci 0000:00:0b.0: BAR 0 [io 0xc160-0xc17f] machine # [ 0.435431] pci 0000:00:0b.0: BAR 1 [mem 0xfebda000-0xfebdafff] machine # [ 0.436441] pci 0000:00:0b.0: BAR 4 [mem 0xfe024000-0xfe027fff 64bit pref] machine # [ 0.437971] pci 0000:00:1d.0: [8086:2934] type 00 class 0x0c0300 conventional PCI endpoint machine # [ 0.439047] pci 0000:00:1d.0: BAR 4 [io 0xc180-0xc19f] machine # [ 0.439630] pci 0000:00:1d.1: [8086:2935] type 00 class 0x0c0300 conventional PCI endpoint machine # [ 0.441059] pci 0000:00:1d.1: BAR 4 [io 0xc1a0-0xc1bf] machine # [ 0.441617] pci 0000:00:1d.2: [8086:2936] type 00 class 0x0c0300 conventional PCI endpoint machine # [ 0.443087] pci 0000:00:1d.2: BAR 4 [io 0xc1c0-0xc1df] machine # [ 0.443640] pci 0000:00:1d.7: [8086:293a] type 00 class 0x0c0320 conventional PCI endpoint machine # [ 0.446031] pci 0000:00:1d.7: BAR 0 [mem 0xfebdb000-0xfebdbfff] machine # [ 0.446718] pci 0000:00:1f.0: [8086:2918] type 00 class 0x060100 conventional PCI endpoint machine # [ 0.447713] pci 0000:00:1f.0: quirk: [io 0x0600-0x067f] claimed by ICH6 ACPI/GPIO/TCO machine # [ 0.448690] pci 0000:00:1f.2: [8086:2922] type 00 class 0x010601 conventional PCI endpoint machine # [ 0.450408] pci 0000:00:1f.2: BAR 4 [io 0xc1e0-0xc1ff] machine # [ 0.451108] pci 0000:00:1f.2: BAR 5 [mem 0xfebdc000-0xfebdcfff] machine # [ 0.451755] pci 0000:00:1f.3: [8086:2930] type 00 class 0x0c0500 conventional PCI endpoint machine # [ 0.453056] pci 0000:00:1f.3: BAR 4 [io 0x0700-0x073f] machine # [ 0.456596] ACPI: PCI: Interrupt link LNKA configured for IRQ 10 machine # [ 0.457536] ACPI: PCI: Interrupt link LNKB configured for IRQ 10 machine # [ 0.458543] ACPI: PCI: Interrupt link LNKC configured for IRQ 11 machine # [ 0.459522] ACPI: PCI: Interrupt link LNKD configured for IRQ 11 machine # [ 0.460524] ACPI: PCI: Interrupt link LNKE configured for IRQ 10 machine # [ 0.461522] ACPI: PCI: Interrupt link LNKF configured for IRQ 10 machine # [ 0.462526] ACPI: PCI: Interrupt link LNKG configured for IRQ 11 machine # [ 0.463559] ACPI: PCI: Interrupt link LNKH configured for IRQ 11 machine # [ 0.464466] ACPI: PCI: Interrupt link GSIA configured for IRQ 16 machine # [ 0.465438] ACPI: PCI: Interrupt link GSIB configured for IRQ 17 machine # [ 0.466441] ACPI: PCI: Interrupt link GSIC configured for IRQ 18 machine # [ 0.467438] ACPI: PCI: Interrupt link GSID configured for IRQ 19 machine # [ 0.468436] ACPI: PCI: Interrupt link GSIE configured for IRQ 20 machine # [ 0.469436] ACPI: PCI: Interrupt link GSIF configured for IRQ 21 machine # [ 0.470438] ACPI: PCI: Interrupt link GSIG configured for IRQ 22 machine # [ 0.471440] ACPI: PCI: Interrupt link GSIH configured for IRQ 23 machine # [ 0.473444] iommu: Default domain type: Translated machine # [ 0.474243] iommu: DMA domain TLB invalidation policy: lazy mode machine # [ 0.475486] ACPI: bus type USB registered machine # [ 0.476283] usbcore: registered new interface driver usbfs machine # [ 0.477162] usbcore: registered new interface driver hub machine # [ 0.477447] usbcore: registered new device driver usb machine # [ 0.479236] NetLabel: Initializing machine # [ 0.479430] NetLabel: domain hash size = 128 machine # [ 0.480193] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO machine # [ 0.480468] NetLabel: unlabeled traffic allowed by default machine # [ 0.481424] PCI: Using ACPI for IRQ routing machine # [ 0.524847] pci 0000:00:01.0: vgaarb: setting as boot VGA device machine # [ 0.525421] pci 0000:00:01.0: vgaarb: bridge control possible machine # [ 0.525421] pci 0000:00:01.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none machine # [ 0.525429] vgaarb: loaded machine # [ 0.526205] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 machine # [ 0.526425] hpet0: 3 comparators, 64-bit 100.000000 MHz counter machine # [ 0.530506] clocksource: Switched to clocksource kvm-clock machine # [ 0.532206] VFS: Disk quotas dquot_6.6.0 machine # [ 0.534695] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) machine # [ 0.536043] pnp: PnP ACPI init machine # [ 0.536852] ACPI: IRQ 4 override to edge(!), high(!) machine # [ 0.537825] system 00:04: [mem 0xb0000000-0xbfffffff window] has been reserved machine # [ 0.539391] pnp: PnP ACPI: found 5 devices machine # [ 0.546999] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns machine # [ 0.548457] clocksource: Switched to clocksource acpi_pm machine # [ 0.549456] NET: Registered PF_INET protocol family machine # [ 0.550523] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear) machine # [ 0.567506] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear) machine # [ 0.568973] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) machine # [ 0.570345] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear) machine # [ 0.571700] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear) machine # [ 0.572958] TCP: Hash tables configured (established 8192 bind 8192) machine # [ 0.574100] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear) machine # [ 0.575459] UDP hash table entries: 512 (order: 3, 32768 bytes, linear) machine # [ 0.576620] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear) machine # [ 0.577874] NET: Registered PF_UNIX/PF_LOCAL protocol family machine # [ 0.578890] NET: Registered PF_XDP protocol family machine # [ 0.579746] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] machine # [ 0.580770] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] machine # [ 0.581786] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] machine # [ 0.582936] pci_bus 0000:00: resource 7 [mem 0x40000000-0xafffffff window] machine # [ 0.584060] pci_bus 0000:00: resource 8 [mem 0xc0000000-0xfebfffff window] machine # [ 0.585203] pci_bus 0000:00: resource 9 [mem 0x100000000-0x8ffffffff window] machine # [ 0.586967] ACPI: \_SB_.GSIA: Enabled at IRQ 16 machine # [ 0.589161] ACPI: \_SB_.GSIB: Enabled at IRQ 17 machine # [ 0.591160] ACPI: \_SB_.GSIC: Enabled at IRQ 18 machine # [ 0.593226] ACPI: \_SB_.GSID: Enabled at IRQ 19 machine # [ 0.594920] PCI: CLS 0 bytes, default 64 machine # [ 0.595863] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x229842dd0bd, max_idle_ns: 440795319571 ns machine # [ 0.597623] Trying to unpack rootfs image as initramfs... machine # [ 0.643355] Initialise system trusted keyrings machine # [ 0.646361] workingset: timestamp_bits=40 max_order=18 bucket_order=0 machine # [ 0.665608] Key type asymmetric registered machine # [ 0.668346] Asymmetric key parser 'x509' registered machine # [ 0.669237] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 248) machine # [ 0.674450] io scheduler mq-deadline registered machine # [ 0.675272] io scheduler kyber registered machine # [ 0.678879] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled machine # [ 0.680249] 00:03: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A machine # [ 0.684118] Linux agpgart interface v0.103 machine # [ 0.684906] ACPI: bus type drm_connector registered machine # [ 0.687753] usbcore: registered new interface driver usbserial_generic machine # [ 0.688858] usbserial: USB Serial support registered for generic machine # [ 0.692355] amd_pstate: The CPPC feature is supported but currently disabled by the BIOS. machine # [ 0.692355] Please enable it if your BIOS has the CPPC option. machine # [ 0.694694] amd_pstate: the _CPC object is not present in SBIOS or ACPI disabled machine # [ 0.699503] drop_monitor: Initializing network drop monitor service machine # [ 0.700727] NET: Registered PF_INET6 protocol family machine # [ 0.703770] Segment Routing with IPv6 machine # [ 0.704482] In-situ OAM (IOAM) with IPv6 machine # [ 0.707628] IPI shorthand broadcast: enabled machine # [ 0.716012] sched_clock: Marking stable (571015727, 144320543)->(792404818, -77068548) machine # [ 0.719528] registered taskstats version 1 machine # [ 0.720565] Loading compiled-in X.509 certificates machine # [ 0.739343] Demotion targets for Node 0: null machine # [ 0.740219] Key type .fscrypt registered machine # [ 0.743340] Key type fscrypt-provisioning registered machine # [ 0.744307] ima: No TPM chip found, activating TPM-bypass! machine # [ 0.745260] ima: Allocated hash algorithm: sha1 machine # [ 0.747367] ima: No architecture policies found machine # [ 0.750347] PM: Magic number: 10:106:785 machine # [ 0.751969] RAS: Correctable Errors collector initialized. machine # [ 0.761045] clk: Disabling unused clocks machine # [ 0.763353] PM: genpd: Disabling unused power domains machine # [ 0.914061] Freeing initrd memory: 28348K machine # [ 0.917296] Freeing unused decrypted memory: 2028K machine # [ 0.919919] Freeing unused kernel image (initmem) memory: 3652K machine # [ 0.920975] Write protecting the kernel read-only data: 32768k machine # [ 0.922776] Freeing unused kernel image (text/rodata gap) memory: 1184K machine # [ 0.924205] Freeing unused kernel image (rodata/data gap) memory: 720K machine # [ 0.975097] x86/mm: Checked W+X mappings: passed, no W+X pages found. machine # [ 0.976179] Run /init as init process machine # [ 0.986912] systemd[1]: Inserted module 'autofs4' machine # [ 1.006793] fuse: init (API version 7.45) machine # [ 1.014179] ACPI: \_SB_.GSIG: Enabled at IRQ 22 machine # [ 1.016798] ACPI: \_SB_.GSIH: Enabled at IRQ 23 machine # [ 1.019723] ACPI: \_SB_.GSIE: Enabled at IRQ 20 machine # [ 1.021645] ACPI: \_SB_.GSIF: Enabled at IRQ 21 machine # [ 1.026848] virtiofs virtio5: discovered new tag: nix-store machine # [ 1.028362] virtiofs virtio5: virtio_fs_setup_dax: No cache capability machine # [ 1.035509] virtiofs virtio6: discovered new tag: shared machine # [ 1.037084] virtiofs virtio6: virtio_fs_setup_dax: No cache capability machine # [ 1.040115] virtiofs virtio7: discovered new tag: xchg machine # [ 1.041586] virtiofs virtio7: virtio_fs_setup_dax: No cache capability machine # [ 1.065160] systemd[1]: Successfully made /usr/ read-only. machine # [ 1.401895] systemd[1]: systemd 262-e355960 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) machine # [ 1.413887] systemd[1]: Detected virtualization kvm. machine # [ 1.416057] systemd[1]: Detected architecture x86-64. machine # [ 1.418242] systemd[1]: Running in initrd. machine # [ 1.420926] systemd[1]: Initializing machine ID from random generator. machine # [ 1.424472] systemd[1]: Hostname set to . machine # [ 1.515182] systemd[1]: bpf-restrict-fs: LSM BPF program attached machine # [ 1.550515] systemd[1]: Queued start job for default target Initrd Default Target. machine # [ 1.553621] systemd[1]: Created slice Slice /system/modprobe. machine # [ 1.554858] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. machine # [ 1.556299] systemd[1]: Expecting device /dev/disk/by-label/nixos... machine # [ 1.557444] systemd[1]: Reached target Path Units. machine # [ 1.558363] systemd[1]: Reached target Slice Units. machine # [ 1.559250] systemd[1]: Reached target Swaps. machine # [ 1.560096] systemd[1]: Reached target Timer Units. machine # [ 1.561093] systemd[1]: Listening on D-Bus System Message Bus Socket. machine # [ 1.562356] systemd[1]: Listening on Journal Socket (/dev/log). machine # [ 1.563559] systemd[1]: Listening on Journal Sockets. machine # [ 1.564564] systemd[1]: Listening on udev Kernel Socket. machine # [ 1.565551] systemd[1]: Reached target Socket Units. machine # [ 1.567310] systemd[1]: Starting Create List of Static Device Nodes... machine # [ 1.571166] systemd[1]: Starting Load Kernel Module configfs... machine # [ 1.577954] systemd[1]: Starting Journal Service... machine # [ 1.589199] systemd[1]: Starting Load Kernel Modules... machine # [ 1.605206] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 1.613537] systemd[1]: Starting Coldplug All udev Devices... machine # [ 1.626572] systemd[1]: Finished Create List of Static Device Nodes. machine # [ 1.632108] systemd[1]: modprobe@configfs.service: Deactivated successfully. machine # [ 1.638922] systemd-journald[65]: Collecting audit messages is disabled. machine # [ 1.641800] systemd[1]: Finished Load Kernel Module configfs. machine # [ 1.645783] systemd[1]: Kernel Configuration File System skipped, unmet condition check ConditionPathExists=/sys/kernel/config machine # [ 1.656403] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... machine # [ 1.659491] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. machine # [ 1.670952] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev machine # [ 1.697914] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. machine # [ 1.706848] systemd[1]: Starting Create Static Device Nodes in /dev... machine # [ 1.717409] systemd[1]: Finished Load Kernel Modules. machine # [ 1.726558] systemd[1]: Starting Apply Kernel Variables... machine # [ 1.744534] systemd[1]: Finished Create Static Device Nodes in /dev. machine # [ 1.752540] systemd[1]: Reached target Preparation for Local File Systems. machine # [ 1.757418] systemd[1]: Reached target Local File Systems. machine # [ 1.615529] systemd-modules-load[66]: Inserted module 'dm_mod' machine # [ 1.619385] systemd-modules-load[66]: Inserted module 'virtio_balloon' machine # [ 1.620460] systemd-modules-load[66]: Inserted module 'virtio_gpu' machine # [ 1.765989] systemd[1]: Starting Rule-based Manager for Device Events and Files... machine # [ 1.773615] systemd[1]: Started Journal Service. machine # [ 1.633960] systemd[1]: Finished Apply Kernel Variables. machine # [ 1.645321] systemd[1]: Starting Create System Files and Directories... machine # [ 1.672516] systemd[1]: Finished Create System Files and Directories. machine # [ 1.682386] systemd-udevd[73]: Using default interface naming scheme 'v261'. machine # [ 1.704824] systemd[1]: Started Rule-based Manager for Device Events and Files. machine # [ 1.758176] systemd[1]: Finished Coldplug All udev Devices. machine # [ 1.759651] systemd[1]: Reached target System Initialization. machine # [ 1.760546] systemd[1]: Reached target Basic System. machine # [ 2.063873] virtio_blk virtio2: 1/0/0 default/read/poll queues machine # [ 2.068426] virtio_blk virtio2: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) machine # [ 2.100707] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 machine # [ 2.112534] serio: i8042 KBD port at 0x60,0x64 irq 1 machine # [ 2.113266] serio: i8042 AUX port at 0x60,0x64 irq 12 machine # [ 2.123956] ehci-pci 0000:00:1d.7: EHCI Host Controller machine # [ 2.124711] ehci-pci 0000:00:1d.7: new USB bus registered, assigned bus number 1 machine # [ 2.126449] ehci-pci 0000:00:1d.7: irq 19, io mem 0xfebdb000 machine # [ 2.133627] ehci-pci 0000:00:1d.7: USB 2.0 started, EHCI 1.00 machine # [ 2.134737] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 6.18 machine # [ 2.136196] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 machine # [ 2.138344] usb usb1: Product: EHCI Host Controller machine # [ 2.139024] usb usb1: Manufacturer: Linux 6.18.52 ehci_hcd machine # [ 2.141461] usb usb1: SerialNumber: 0000:00:1d.7 machine # [ 2.143422] hub 1-0:1.0: USB hub found machine # [ 2.146338] hub 1-0:1.0: 6 ports detected machine # [ 2.153754] uhci_hcd 0000:00:1d.0: UHCI Host Controller machine # [ 2.154496] uhci_hcd 0000:00:1d.0: new USB bus registered, assigned bus number 2 machine # [ 2.168066] uhci_hcd 0000:00:1d.0: detected 2 ports machine # [ 2.173288] uhci_hcd 0000:00:1d.0: irq 16, io port 0x0000c180 machine # [ 2.180791] usb usb2: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.18 machine # [ 2.181982] usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=1 machine # [ 2.055214] systemd[1]: Starting Virtual Console Setup... machine # [ 2.205967] usb usb2: Product: UHCI Host Controller machine # [ 2.068093] (udev-worker)[92]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. machine # [ 2.214369] usb usb2: Manufacturer: Linux 6.18.52 uhci_hcd machine # [ 2.215113] usb usb2: SerialNumber: 0000:00:1d.0 machine # [ 2.075429] (udev-worker)[92]: Network interface NamePolicy= disabled on kernel command line. machine # [ 2.221443] SCSI subsystem initialized machine # [ 2.227399] hub 2-0:1.0: USB hub found machine # [ 2.233032] hub 2-0:1.0: 2 ports detected machine # [ 2.103373] systemd-vconsole-setup[96]: Configuration of first virtual console was skipped, ignoring remaining ones. machine # [ 2.105637] systemd[1]: Finished Virtual Console Setup. machine # [ 2.259529] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input0 machine # [ 2.124971] systemd[1]: Found device /dev/disk/by-label/nixos. machine # [ 2.125916] systemd[1]: Reached target Initrd Root Device. machine # [ 2.127121] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos... machine # [ 2.273452] uhci_hcd 0000:00:1d.1: UHCI Host Controller machine # [ 2.274225] uhci_hcd 0000:00:1d.1: new USB bus registered, assigned bus number 3 machine # [ 2.280393] uhci_hcd 0000:00:1d.1: detected 2 ports machine # [ 2.281191] uhci_hcd 0000:00:1d.1: irq 17, io port 0x0000c1a0 machine # [ 2.289964] usb usb3: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.18 machine # [ 2.292497] usb usb3: New USB device strings: Mfr=3, Product=2, SerialNumber=1 machine # [ 2.296375] usb usb3: Product: UHCI Host Controller machine # [ 2.297144] usb usb3: Manufacturer: Linux 6.18.52 uhci_hcd machine # [ 2.299363] usb usb3: SerialNumber: 0000:00:1d.1 machine # [ 2.301788] hub 3-0:1.0: USB hub found machine # [ 2.303382] hub 3-0:1.0: 2 ports detected machine # [ 2.308786] uhci_hcd 0000:00:1d.2: UHCI Host Controller machine # [ 2.311463] uhci_hcd 0000:00:1d.2: new USB bus registered, assigned bus number 4 machine # [ 2.316429] uhci_hcd 0000:00:1d.2: detected 2 ports machine # [ 2.173677] systemd-fsck[103]: nixos: clean, 12/65536 files, 13019/262144 blocks machine # [ 2.178504] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos. machine # [ 2.324494] uhci_hcd 0000:00:1d.2: irq 18, io port 0x0000c1c0 machine # [ 2.325874] usb usb4: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.18 machine # [ 2.328375] usb usb4: New USB device strings: Mfr=3, Product=2, SerialNumber=1 machine # [ 2.331399] usb usb4: Product: UHCI Host Controller machine # [ 2.332189] usb usb4: Manufacturer: Linux 6.18.52 uhci_hcd machine # [ 2.333782] usb usb4: SerialNumber: 0000:00:1d.2 machine # [ 2.341865] hub 4-0:1.0: USB hub found machine # [ 2.343437] hub 4-0:1.0: 2 ports detected machine # [ 2.373402] ahci 0000:00:1f.2: AHCI vers 0001.0000, 32 command slots, 1.5 Gbps, SATA mode machine # [ 2.374586] ahci 0000:00:1f.2: 6/6 ports implemented (port mask 0x3f) machine # [ 2.377839] ahci 0000:00:1f.2: flags: 64bit ncq only machine # [ 2.381698] scsi host0: ahci machine # [ 2.383368] usb 1-1: new high-speed USB device number 2 using ehci-pci machine # [ 2.384299] scsi host1: ahci machine # [ 2.386041] scsi host2: ahci machine # [ 2.387537] scsi host3: ahci machine # [ 2.389279] scsi host4: ahci machine # [ 2.391031] scsi host5: ahci machine # [ 2.392252] ata1: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc100 irq 47 lpm-pol 1 machine # [ 2.394172] ata2: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc180 irq 47 lpm-pol 1 machine # [ 2.395494] ata3: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc200 irq 47 lpm-pol 1 machine # [ 2.396700] ata4: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc280 irq 47 lpm-pol 1 machine # [ 2.397833] ata5: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc300 irq 47 lpm-pol 1 machine # [ 2.399060] ata6: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc380 irq 47 lpm-pol 1 machine # [ 2.514458] usb 1-1: New USB device found, idVendor=0627, idProduct=0001, bcdDevice= 0.00 machine # [ 2.517306] usb 1-1: New USB device strings: Mfr=1, Product=3, SerialNumber=10 machine # [ 2.520473] usb 1-1: Product: QEMU USB Tablet machine # [ 2.522202] usb 1-1: Manufacturer: QEMU machine # [ 2.523797] usb 1-1: SerialNumber: 28754-0000:00:1d.7-1 machine # [ 2.561592] hid: raw HID events driver (C) Jiri Kosina machine # [ 2.479731] systemd[1]: Mounting /sysroot... machine # [ 2.712072] ata2: SATA link down (SStatus 0 SControl 300) machine # [ 2.714400] ata6: SATA link down (SStatus 0 SControl 300) machine # [ 2.716966] ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 300) machine # [ 2.719507] ata3.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/100 machine # [ 2.721431] ata3.00: applying bridge limits machine # [ 2.723508] ata4: SATA link down (SStatus 0 SControl 300) machine # [ 2.725783] ata1: SATA link down (SStatus 0 SControl 300) machine # [ 2.728133] ata5: SATA link down (SStatus 0 SControl 300) machine # [ 2.730483] ata3.00: configured for UDMA/100 machine # [ 2.732952] scsi 2:0:0:0: CD-ROM QEMU QEMU DVD-ROM 2.5+ PQ: 0 ANSI: 5 machine # [ 2.805561] usbcore: registered new interface driver usbhid machine # [ 2.813335] usbhid: USB HID core driver machine # [ 2.831460] sr 2:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray machine # [ 2.838561] 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/input2 machine # [ 2.840445] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:1d.7-1/input0 machine # [ 2.845426] cdrom: Uniform CD-ROM driver Revision: 3.20 machine # [ 2.862796] EXT4-fs (vda): mounted filesystem 372c99e0-324a-4da2-b90d-2250d85955fc r/w with ordered data mode. Quota mode: none. machine # [ 2.725215] systemd[1]: Mounted /sysroot. machine # [ 2.726512] systemd[1]: Reached target Initrd Root File System. machine # [ 2.729260] systemd[1]: Starting Mountpoints Configured in the Real Root... machine # [ 2.743092] systemd-sysroot-fstab-check[138]: /sysroot should be mounted in the initrd, will request daemon-reload. machine # [ 2.745815] systemd[1]: Reload requested from client PID 138 ('systemd-sysroot') (unit initrd-parse-etc.service)... machine # [ 2.748233] systemd[1]: Reloading... machine # [ 2.820079] systemd[1]: Reloading finished in 72 ms. machine # [ 2.829636] systemd-sysroot-fstab-check[138]: Requesting initrd-fs.target/start/replace... machine # [ 2.834172] systemd-sysroot-fstab-check[138]: Requesting swap.target/start/replace... machine # [ 2.837158] systemd[1]: initrd-parse-etc.service: Deactivated successfully. machine # [ 2.838522] systemd[1]: Finished Mountpoints Configured in the Real Root. machine # [ 2.840173] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies. machine # [ 3.481170] systemd[1]: Mounting /sysroot/nix/.ro-store... machine # [ 3.487155] systemd[1]: Mounting /sysroot/nix/.rw-store... machine # [ 3.494310] systemd[1]: Mounting /sysroot/run... machine # [ 3.503148] systemd[1]: Mounting /sysroot/tmp/shared... machine # [ 3.517313] systemd[1]: Mounting /sysroot/tmp/xchg... machine # [ 3.554721] systemd[1]: Mounted /sysroot/nix/.ro-store. machine # [ 3.562037] systemd[1]: Mounted /sysroot/nix/.rw-store. machine # [ 3.563069] systemd[1]: Mounted /sysroot/run. machine # [ 3.564220] systemd[1]: Mounted /sysroot/tmp/shared. machine # [ 3.565978] systemd[1]: Mounted /sysroot/tmp/xchg. machine # [ 3.569911] systemd[1]: Starting rw-sysroot-nix-store.service... machine # [ 3.580549] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. machine # [ 3.581949] systemd[1]: Finished rw-sysroot-nix-store.service. machine # [ 4.478895] systemd[1]: Mounting /sysroot/nix/store... machine # [ 4.500602] systemd[1]: Mounted /sysroot/nix/store. machine # [ 4.501809] systemd[1]: Reached target Initrd File Systems. machine # [ 4.503673] systemd[1]: Starting Find NixOS closure... machine # [ 4.507335] systemd[1]: Starting Create Volatile Files and Directories in the Real Root... machine # [ 4.525886] systemd[1]: Finished Create Volatile Files and Directories in the Real Root. machine # [ 4.529377] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully. machine # [ 4.535472] systemd[1]: Finished Find NixOS closure. machine # [ 4.537155] systemd[1]: Reached target Initrd Default Target. machine # [ 4.538335] systemd[1]: Starting Cleaning Up and Shutting Down Daemons... machine # [ 4.551277] systemd[1]: Stopped target Initrd Default Target. machine # [ 4.552293] systemd[1]: Stopped target Basic System. machine # [ 4.553264] systemd[1]: Stopped target Initrd Root Device. machine # [ 4.555112] systemd[1]: Stopped target Path Units. machine # [ 4.555816] systemd[1]: systemd-ask-password-console.path: Deactivated successfully. machine # [ 4.556856] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch. machine # [ 4.557878] systemd[1]: Stopped target Slice Units. machine # [ 4.558582] systemd[1]: Stopped target Socket Units. machine # [ 4.559444] systemd[1]: Stopped target System Initialization. machine # [ 4.560319] systemd[1]: Stopped target Swaps. machine # [ 4.561290] systemd[1]: Stopped target Timer Units. machine # [ 4.562296] systemd[1]: dbus.socket: Deactivated successfully. machine # [ 4.563834] systemd[1]: Closed D-Bus System Message Bus Socket. machine # [ 4.564709] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully. machine # [ 4.565703] systemd[1]: Stopped Find NixOS closure. machine # [ 4.566701] systemd[1]: Starting rw-sysroot-nix-store.service... machine # [ 4.568253] systemd[1]: systemd-sysctl.service: Deactivated successfully. machine # [ 4.569334] systemd[1]: Stopped Apply Kernel Variables. machine # [ 4.570340] systemd[1]: systemd-modules-load.service: Deactivated successfully. machine # [ 4.571697] systemd[1]: Stopped Load Kernel Modules. machine # [ 4.573129] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully. machine # [ 4.574284] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root. machine # [ 4.575571] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. machine # [ 4.576712] systemd[1]: Stopped Create System Files and Directories. machine # [ 4.578055] systemd[1]: Stopped target Local File Systems. machine # [ 4.578837] systemd[1]: Stopped target Preparation for Local File Systems. machine # [ 4.579866] systemd[1]: systemd-udev-trigger.service: Deactivated successfully. machine # [ 4.581097] systemd[1]: Stopped Coldplug All udev Devices. machine # [ 4.582339] systemd[1]: Stopping Rule-based Manager for Device Events and Files... machine # [ 4.584768] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. machine # [ 4.586261] systemd[1]: Stopped Virtual Console Setup. machine # [ 4.592499] systemd[1]: initrd-cleanup.service: Deactivated successfully. machine # [ 4.597092] systemd[1]: Finished Cleaning Up and Shutting Down Daemons. machine # [ 4.601081] systemd[1]: systemd-udevd.service: Deactivated successfully. machine # [ 4.604133] systemd[1]: Stopped Rule-based Manager for Device Events and Files. machine # [ 4.607848] systemd[1]: Starting Cleanup udev Database... machine # [ 4.608687] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. machine # [ 4.609777] systemd[1]: Stopped Create Static Device Nodes in /dev. machine # [ 4.611150] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. machine # [ 4.612331] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully. machine # [ 4.613423] systemd[1]: kmod-static-nodes.service: Deactivated successfully. machine # [ 4.615187] systemd[1]: Stopped Create List of Static Device Nodes. machine # [ 4.616065] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. machine # [ 4.618135] systemd[1]: Finished rw-sysroot-nix-store.service. machine # [ 4.633380] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. machine # [ 4.634693] systemd[1]: Finished Cleanup udev Database. machine # [ 4.635899] systemd[1]: Reached target Switch Root. machine # [ 4.637813] systemd[1]: Starting NixOS Activation... machine # [ 4.707773] initrd-nixos-activation-start[189]: booting system configuration /nix/store/ljf1yfxd2y3hvnj1bh7wmwy81yi8ha6v-nixos-system-machine-test machine # [ 4.733662] initrd-nixos-activation-start[189]: running activation script... machine # [ 4.933272] initrd-nixos-activation-start[212]: setting up /etc... machine # [ 5.039439] systemd[1]: initrd-nixos-activation.service: Deactivated successfully. machine # [ 5.041918] systemd[1]: Finished NixOS Activation. machine # [ 5.043061] systemd[1]: Starting Switch Root... machine # [ 5.055832] systemd[1]: Switching root. machine # [ 5.323555] systemd-journald[65]: Received SIGTERM from PID 1 (systemd). machine # [ 5.380085] NET: Registered PF_VSOCK protocol family machine # [ 5.733684] systemd[1]: systemd 262-e355960 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) machine # [ 5.737647] systemd[1]: Detected virtualization kvm. machine # [ 5.738393] systemd[1]: Detected architecture x86-64. machine # [ 5.739210] systemd[1]: Detected first boot. machine # [ 5.741935] systemd[1]: Initializing machine ID from random generator. machine # [ 5.854494] systemd[1]: bpf-restrict-fs: LSM BPF program attached machine # [ 5.948699] systemd[1]: Applying preset policy. machine # [ 6.109978] systemd[1]: Populated /etc with preset unit settings. machine # [ 6.271776] systemd[1]: initrd-switch-root.service: Deactivated successfully. machine # [ 6.273068] systemd[1]: Stopped initrd-switch-root.service. machine # [ 6.275279] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. machine # [ 6.277636] systemd[1]: Created slice Slice /system/getty. machine # [ 6.278954] systemd[1]: Created slice User and Session Slice. machine # [ 6.279876] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. machine # [ 6.281075] systemd[1]: Started Forward Password Requests to Wall Directory Watch. machine # [ 6.282202] systemd[1]: Expecting device /dev/hvc0... machine # [ 6.282987] systemd[1]: Expecting device /dev/ttyS0... machine # [ 6.283728] systemd[1]: Reached target Local Encrypted Volumes. machine # [ 6.284563] systemd[1]: Stopped target initrd-fs.target. machine # [ 6.285377] systemd[1]: Stopped target initrd-root-fs.target. machine # [ 6.286174] systemd[1]: Stopped target initrd-switch-root.target. machine # [ 6.287047] systemd[1]: Reached target Virtual Machines and Containers. machine # [ 6.287977] systemd[1]: Reached target Path Units. machine # [ 6.288666] systemd[1]: Reached target Remote File Systems. machine # [ 6.289464] systemd[1]: Reached target Slice Units. machine # [ 6.290226] systemd[1]: Reached target Swaps. machine # [ 6.291911] systemd[1]: Listening on Query the User Interactively for a Password. machine # [ 6.305968] systemd[1]: Listening on Process Core Dump Socket. machine # [ 6.309100] systemd[1]: Listening on Credential Encryption/Decryption. machine # [ 6.310933] systemd[1]: Listening on Factory Reset Management. machine # [ 6.311895] systemd[1]: Listening on Hostname Service Socket. machine # [ 6.314723] systemd[1]: Starting Journal Log Access Socket... machine # [ 6.315980] systemd[1]: Listening on Journal Audit Socket. machine # [ 6.318242] systemd[1]: Listening on Console Output Muting Service Socket. machine # [ 6.319799] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket. machine # [ 6.320902] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 6.322287] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 6.326537] systemd[1]: Listening on Disk Repartitioning Service Socket. machine # [ 6.327624] systemd[1]: Listening on udev Varlink Socket. machine # [ 6.329907] systemd[1]: Mounting Huge Pages File System... machine # [ 6.333881] systemd[1]: Mounting POSIX Message Queue File System... machine # [ 6.340454] systemd[1]: Mounting Kernel Debug File System... machine # [ 6.347670] systemd[1]: Mounting Kernel Trace File System... machine # [ 6.355397] systemd[1]: Starting Create List of Static Device Nodes... machine # [ 6.366149] systemd[1]: Starting Load Kernel Module configfs... machine # [ 6.371207] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm machine # [ 6.383007] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 6.393631] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse machine # [ 6.400472] systemd[1]: Mounting FUSE Control File System... machine # [ 6.401841] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 6.409192] systemd[1]: Starting Journal Service... machine # [ 6.416960] systemd[1]: Starting Load Kernel Modules... machine # [ 6.434682] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer... machine # [ 6.449616] systemd[1]: Starting Remount Root and Kernel File Systems... machine # [ 6.457615] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 6.474272] systemd[1]: Starting Coldplug All udev Devices... machine # [ 6.479033] systemd-journald[283]: Collecting audit messages is enabled. machine # [ 6.487902] systemd[1]: Listening on Journal Log Access Socket. machine # [ 6.491766] systemd[1]: Mounted Huge Pages File System. machine # [ 6.498635] systemd[1]: Mounted POSIX Message Queue File System. machine # [ 6.356598] systemd[1]: Queued start job for default target Multi-User System. machine # [ 6.358318] systemd[1]: systemd-journald.service: Deactivated successfully. machine # [ 6.509677] systemd[1]: Started Journal Service. machine # [ 6.376377] systemd[1]: Mounted Kernel Debug File System. machine # [ 6.522696] loop: module loaded machine # [ 6.381331] systemd-modules-load[284]: Inserted module 'loop' machine # [ 6.383036] systemd[1]: Mounted Kernel Trace File System. machine # [ 6.386089] systemd[1]: Finished Create List of Static Device Nodes. machine # [ 6.386985] systemd[1]: modprobe@configfs.service: Deactivated successfully. machine # [ 6.391315] systemd[1]: Finished Load Kernel Module configfs. machine # [ 6.397693] systemd[1]: Finished Load Kernel Modules. machine # [ 6.555540] EXT4-fs (vda): re-mounted 372c99e0-324a-4da2-b90d-2250d85955fc. machine # [ 6.417362] systemd[1]: Mounting Kernel Configuration File System... machine # [ 6.424887] systemd[1]: Starting Firewall... machine # [ 6.428097] systemd[1]: Starting Apply Kernel Variables... machine # [ 6.437088] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... machine # [ 6.443221] systemd[1]: Finished Remount Root and Kernel File Systems. machine # [ 6.446245] systemd-oomd[285]: No swap; memory pressure usage will be degraded machine # [ 6.455909] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer. machine # [ 6.462448] systemd[1]: Listening on Disk Image Download Service Socket. machine # [ 6.475091] systemd[1]: Starting Flush Journal to Persistent Storage... machine # [ 6.476166] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 6.492364] systemd[1]: Starting Load/Save OS Random Seed... machine # [ 6.493403] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 6.505892] systemd[1]: Mounted FUSE Control File System. machine # [ 6.703090] systemd-journald[283]: Received client request to flush runtime journal. machine # [ 6.670300] systemd[1]: Mounted Kernel Configuration File System. machine # [ 6.672454] systemd[1]: Finished Apply Kernel Variables. machine # [ 6.675763] systemd[1]: Finished Load/Save OS Random Seed. machine # [ 6.676563] systemd[1]: Reached target First Boot Complete. machine # [ 6.678134] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. machine # [ 6.679136] systemd[1]: Starting Create Static Device Nodes in /dev... machine # [ 6.688067] systemd[1]: Finished Flush Journal to Persistent Storage. machine # [ 6.758195] systemd[1]: Finished Create Static Device Nodes in /dev. machine # [ 6.760078] systemd[1]: Reached target Preparation for Local File Systems. machine # [ 6.763508] systemd[1]: Starting Rule-based Manager for Device Events and Files... machine # [ 6.771273] systemd[1]: Finished Coldplug All udev Devices. machine # [ 6.813792] systemd-udevd[321]: Using default interface naming scheme 'v261'. machine # [ 6.855656] systemd[1]: Started Rule-based Manager for Device Events and Files. machine # [ 6.971136] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse machine # [ 7.057920] systemd[1]: Condition check resulted in /dev/hvc0 being skipped. machine # [ 7.091224] systemd[1]: Condition check resulted in /dev/ttyS0 being skipped. machine # [ 7.115149] (udev-worker)[353]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. machine # [ 7.117420] (udev-worker)[353]: Network interface NamePolicy= disabled on kernel command line. machine # [ 7.132101] systemd[1]: Mounting /run/wrappers... machine # [ 7.175560] systemd[1]: Mounted /run/wrappers. machine # [ 7.176728] systemd[1]: Reached target Local File Systems. machine # [ 7.180633] systemd[1]: Listening on Boot Loader Control Service Socket. machine # [ 7.183132] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 7.185418] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 7.190404] systemd[1]: Starting Save Transient machine-id to Disk... machine # [ 7.200084] systemd[1]: Starting Create System Files and Directories... machine # [ 7.305790] systemd[1]: Finished Create System Files and Directories. machine # [ 7.314141] systemd[1]: Starting Rebuild Journal Catalog... machine # [ 7.318754] systemd[1]: Starting Record System Boot/Shutdown in UTMP... machine # [ 7.375272] systemd[1]: Condition check resulted in Virtio network device being skipped. machine # [ 7.376446] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 7.378733] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 7.382282] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 7.384369] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 7.385852] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 7.387038] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 7.408510] systemd[1]: Finished Record System Boot/Shutdown in UTMP. machine # [ 7.439514] systemd[1]: Finished Rebuild Journal Catalog. machine # [ 7.447098] systemd[1]: Starting Update is Completed... machine # [ 7.492684] systemd[1]: Finished Update is Completed. machine # [ 7.714836] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input3 machine # [ 7.734254] input: QEMU Virtio Keyboard as /devices/pci0000:00/0000:00:06.0/virtio4/input/input4 machine # [ 7.742232] ACPI: button: Power Button [PWRF] machine # [ 7.752488] mousedev: PS/2 mouse device common for all mice machine # [ 7.774054] bochs-drm 0000:00:01.0: vgaarb: deactivate vga console machine # [ 7.678411] systemd[1]: Finished Firewall. machine # [ 7.687089] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 7.689467] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 7.690755] systemd[1]: Reached target System Initialization. machine # [ 7.693106] systemd[1]: Started Discard unused filesystem blocks once a week. machine # [ 7.694113] systemd[1]: Started Daily Cleanup of Temporary Directories. machine # [ 7.695082] systemd[1]: Reached target Timer Units. machine # [ 7.695801] systemd[1]: Listening on D-Bus System Message Bus Socket. machine # [ 7.696822] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket. machine # [ 7.698758] systemd[1]: Reached target Socket Units. machine # [ 7.699764] systemd[1]: Reached target Basic System. machine # [ 7.702924] systemd[1]: Started backdoor.service. machine # [ 7.711128] systemd[1]: Starting Import lastlog data into lastlog2 database... machine # [ 7.713645] systemd[1]: Starting Name Service Cache Daemon (nsncd)... machine # [ 7.715890] systemd[1]: Starting Post-Boot Actions... machine # [ 7.729380] systemd[1]: Started Reset console on configuration changes. machine # [ 7.748646] systemd[1]: Starting resolvconf update... machine # [ 7.780694] systemd[1]: Starting D-Bus System Message Bus... machine # [ 7.844920] systemd[1]: Finished Post-Boot Actions. machine # [ 7.855415] nsncd[500]: Sep 21 12:47:02.589 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" machine # [ 7.857360] systemd[1]: Started Name Service Cache Daemon (nsncd). machine # [ 7.858952] systemd[1]: Reached target Host and Network Name Lookups. machine # [ 7.861309] systemd[1]: Reached target User and Group Name Lookups. machine # [ 7.875754] systemd[1]: Starting User Login Management... machine # connecting to host... machine: Guest shell says: b'Spawning backdoor root shell...\n' machine: connected to guest root shell machine # [ 7.929778] systemd[1]: Finished Import lastlog data into lastlog2 database. machine: (connecting took 8.65 seconds) machine: (finished: waiting for the VM to finish booting, in 8.65 seconds) machine # [ 7.956268] dbus-broker-launch[505]: Looking up NSS user entry for 'systemd-timesync'... machine # [ 7.962698] dbus-broker-launch[505]: NSS returned no entry for 'systemd-timesync' machine # [ 7.963776] dbus-broker-launch[505]: Invalid user-name in /nix/store/kq37mmz302xmsmy936dba0rv8h2xapq0-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" machine # [ 7.871930] rtc_cmos PNP0B00:00: RTC can wake from S4 machine # [ 7.906986] rtc_cmos PNP0B00:00: registered as rtc0 machine # [ 8.011748] systemd[1]: Started D-Bus System Message Bus. machine # [ 7.907056] rtc_cmos PNP0B00:00: setting system clock to 2026-09-21T12:47:02 UTC (1789994822) machine # [ 7.907137] rtc_cmos PNP0B00:00: alarms up to one day, y3k, 242 bytes nvram, hpet irqs machine # [ 7.945952] parport_pc 00:02: reported by Plug and Play ACPI machine # [ 7.946043] parport0: PC-style at 0x378, irq 7 [PCSPP(,...)] machine # [ 8.052036] lpc_ich 0000:00:1f.0: I/O space for GPIO uninitialized machine # [ 8.140419] Console: switching to colour dummy device 80x25 machine # [ 8.219331] i801_smbus 0000:00:1f.3: SMBus using PCI interrupt machine # [ 8.219443] i2c i2c-0: Memory type 0x07 not supported yet, not instantiating SPD machine # [ 8.223192] [drm] Found bochs VGA, ID 0xb0c5. machine # [ 8.223194] [drm] Framebuffer size 16384 kB @ 0xfd000000, mmio @ 0xfebd0000. machine # [ 8.049463] dbus-broker-launch[505]: Ready machine # [ 8.082071] systemd-logind[523]: New seat seat0. machine # [ 8.235456] bochs-drm 0000:00:01.0: [drm] Registered 1 planes with drm panic machine # [ 8.236125] [drm] Initialized bochs-drm 1.0.0 for 0000:00:01.0 on minor 0 machine # [ 8.250992] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input6 machine # [ 8.253161] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input5 machine # [ 8.133078] systemd[1]: Started User Login Management. machine # [ 8.153118] systemd[1]: Stopped target Host and Network Name Lookups. machine # [ 8.154948] systemd[1]: Stopping Host and Network Name Lookups... machine # [ 8.156187] systemd[1]: Stopped target User and Group Name Lookups. machine # [ 8.158756] systemd[1]: Stopping User and Group Name Lookups... machine # [ 8.165066] systemd[1]: Starting linger-users.service... machine # [ 8.165863] systemd[1]: Stopping Name Service Cache Daemon (nsncd)... machine # [ 8.171710] systemd[1]: nscd.service: Deactivated successfully. machine # [ 8.173331] systemd[1]: Stopped Name Service Cache Daemon (nsncd). machine # [ 8.192278] systemd[1]: Starting Name Service Cache Daemon (nsncd)... machine # [ 8.230456] systemd[1]: Starting Virtual Console Setup... machine # [ 8.253610] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 8.257164] systemd[1]: Finished linger-users.service. machine # [ 8.276982] systemd[1]: Finished resolvconf update. machine # [ 8.277797] systemd[1]: Reached target Preparation for Network. machine # [ 8.283430] nsncd[589]: Sep 21 12:47:03.019 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" machine # [ 8.289205] systemd[1]: Starting DHCP Client... machine # [ 8.293102] systemd[1]: Starting Address configuration of eth1... machine # [ 8.294350] systemd-logind[523]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard) machine # [ 8.298800] systemd[1]: Starting Extra networking commands.... machine # [ 8.456935] Console: switching to colour frame buffer device 160x50 machine # [ 8.492256] bochs-drm 0000:00:01.0: [drm] fb0: bochs-drmdrmfb frame buffer device machine # [ 8.302923] systemd-logind[523]: Watching system buttons on /dev/input/event2 (Power Button) machine # [ 8.350661] systemd[1]: Started Name Service Cache Daemon (nsncd). machine # [ 8.353966] systemd[1]: Reached target Host and Network Name Lookups. machine # [ 8.357945] systemd[1]: Reached target User and Group Name Lookups. machine # [ 8.368545] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. machine # [ 8.373304] systemd[1]: Stopped Virtual Console Setup. machine # [ 8.395129] systemd[1]: Starting Virtual Console Setup... machine # [ 8.419642] systemd-logind[523]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard) machine # [ 8.432506] network-addresses-eth1-start[614]: adding address 192.168.1.1/24... done machine # [ 8.456068] network-addresses-eth1-start[614]: adding address 2001:db8:1::1/64... done machine # [ 8.486655] systemd[1]: Finished Address configuration of eth1. machine # [ 8.667098] ppdev: user-space parallel port driver machine # [ 8.563699] dhcpcd[626]: dhcpcd-10.3.2 starting machine # [ 8.573768] dhcpcd[681]: dev: loaded udev machine # [ 8.617065] systemd[1]: Finished Extra networking commands.. machine # [ 8.621197] systemd[1]: Reached target Network. machine # [ 8.767395] iTCO_wdt iTCO_wdt.1.auto: Found a ICH9 TCO device (Version=2, TCOBASE=0x0660) machine # [ 8.625462] systemd[1]: Starting Permit User Sessions... machine # [ 8.778174] 8021q: 802.1Q VLAN Support v1.8 machine # [ 8.780519] iTCO_wdt iTCO_wdt.1.auto: initialized. heartbeat=30 sec (nowayout=0) machine # [ 8.781821] 8021q: adding VLAN 0 to HW filter on device eth1 machine # [ 8.644835] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. machine # [ 8.647116] systemd[1]: Stopped Virtual Console Setup. machine # [ 8.659170] systemd[1]: Starting Virtual Console Setup... machine # [ 8.703145] systemd[1]: Finished Permit User Sessions. machine # [ 8.713734] systemd[1]: Started Getty on tty1. machine # [ 8.718461] systemd[1]: Reached target Login Prompts. machine # [ 8.730743] systemd[1]: Finished Save Transient machine-id to Disk. machine # [ 8.758793] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch. machine # [ 8.931619] kvm_amd: TSC scaling supported machine # [ 8.932073] kvm_amd: Nested Virtualization enabled machine # [ 8.935513] kvm_amd: Nested Paging enabled machine # [ 8.935953] kvm_amd: LBR virtualization supported machine # [ 8.936560] kvm_amd: Virtual VMLOAD VMSAVE supported machine # [ 8.937065] kvm_amd: Virtual GIF supported machine # [ 8.940316] kvm_amd: Virtual NMI enabled machine # [ 8.967235] cfg80211: Loading compiled-in X.509 certificates for regulatory database machine # [ 8.983316] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' machine # [ 8.983996] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600' machine # [ 8.985840] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -2 machine # [ 8.986646] cfg80211: failed to load regulatory.db machine # [ 9.005130] EDAC MC: Ver: 3.0.0 machine # [ 9.027674] 8021q: adding VLAN 0 to HW filter on device eth0 machine # [ 8.884630] dhcpcd[681]: eth0: waiting for carrier machine # [ 8.885745] dhcpcd[681]: libudev: received NULL device machine # [ 8.886517] dhcpcd[681]: libudev: received NULL device machine # [ 8.887509] dhcpcd[681]: eth0: carrier acquired machine # [ 8.893026] dhcpcd[681]: DUID 00:01:00:01:32:43:e3:c7:52:54:00:12:34:56 machine # [ 8.894447] dhcpcd[681]: eth0: IAID 00:12:34:56 machine # [ 8.895240] dhcpcd[681]: eth0: adding address fe80::5054:ff:fe12:3456 machine # [ 8.947808] systemd-vconsole-setup[690]: Configuration of first virtual console was skipped, ignoring remaining ones. machine # [ 8.950829] systemd[1]: Finished Virtual Console Setup. machine # [ 9.249936] systemd[1]: etc-machine\x2did.mount: Deactivated successfully. machine # [ 9.660279] dhcpcd[681]: eth0: soliciting a DHCP lease machine # [ 9.824155] NET: Registered PF_PACKET protocol family machine # [ 9.686923] dhcpcd[681]: eth0: offered 10.0.2.15 from 10.0.2.2 machine # [ 9.691395] dhcpcd[681]: eth0: probing address 10.0.2.15/24 machine # [ 11.243975] dhcpcd[681]: eth0: soliciting an IPv6 router machine # [ 11.245258] dhcpcd[681]: eth0: Router Advertisement from fe80::2 machine # [ 11.246106] dhcpcd[681]: eth0: adding address fec0::5054:ff:fe12:3456/64 machine # [ 11.246993] dhcpcd[681]: eth0: adding route to fec0::/64 machine # [ 11.247721] dhcpcd[681]: eth0: adding default route via fe80::2 machine # [ 13.764478] dhcpcd[681]: eth0: leased 10.0.2.15 for 86400 seconds machine # [ 13.766797] dhcpcd[681]: eth0: adding route to 10.0.2.0/24 machine # [ 13.769439] dhcpcd[681]: eth0: adding default route via 10.0.2.2 machine # [ 13.840986] systemd[1]: Started DHCP Client. machine # [ 13.843591] systemd[1]: Reached target Multi-User System. machine # [ 13.844545] systemd[1]: Startup finished in 835ms (kernel) + 4.380s (initrd) + 8.628s (userspace) = 13.844s. machine: (finished: waiting for unit multi-user.target, in 15.21 seconds) machine: waiting for the VM to power off additionally exposed symbols: machine, vlan1, 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_ssh machine # [ 14.495998] systemd-logind[523]: poweroff requested from client PID 819 ('poweroff') (unit backdoor.service)... machine # [ 14.502140] systemd-logind[523]: System is powering down. machine # [ 14.514645] systemd-logind[523]: The system will power off now! machine # [ 14.527684] systemd[1]: Removed slice Slice /system/modprobe. machine # [ 14.529093] systemd[1]: Stopped target Multi-User System. machine # [ 14.530311] systemd[1]: Stopped target Login Prompts. machine # [ 14.532150] systemd[1]: Stopped target Virtual Machines and Containers. machine # [ 14.533695] systemd[1]: Stopped target Host and Network Name Lookups. machine # [ 14.534577] systemd[1]: Stopped target Timer Units. machine # [ 14.535286] systemd[1]: fstrim.timer: Deactivated successfully. machine # [ 14.536123] systemd[1]: Stopped Discard unused filesystem blocks once a week. machine # [ 14.537102] systemd[1]: systemd-tmpfiles-clean.timer: Deactivated successfully. machine # [ 14.538801] systemd[1]: Stopped Daily Cleanup of Temporary Directories. machine # [ 14.539710] systemd[1]: systemd-rfkill.socket: Deactivated successfully. machine # [ 14.540571] systemd[1]: Closed Load/Save RF Kill Switch Status /dev/rfkill Watch. machine # [ 14.542805] systemd[1]: Mounting /run/initramfs... machine # [ 14.543876] systemd[1]: Stopping backdoor.service... machine # [ 14.545424] dhcpcd[681]: received SIGTERM, stopping machine # [ 14.546805] dhcpcd[681]: eth0: removing interface machine # [ 14.547874] dhcpcd[681]: eth0: deleting address fec0::5054:ff:fe12:3456/64 machine # [ 14.549772] systemd[1]: Stopping DHCP Client... machine # [ 14.551390] dhcpcd[681]: eth0: deleting route to fec0::/64 machine # [ 14.553126] systemd[1]: Stopping Getty on tty1... machine # [ 14.554132] dhcpcd[681]: eth0: deleting default route via fe80::2 machine # [ 14.554972] systemd[1]: lastlog2-import.service: Deactivated successfully. machine # [ 14.556777] dhcpcd[681]: script_status: /nix/store/h9xgfc6qs6n851k91ss2jdwiibfcap49-dhcpcd-10.3.2/libexec/dhcpcd-run-hooks: Terminated machine # [ 14.558404] systemd[1]: Stopped Import lastlog data into lastlog2 database. machine # [ 14.559422] dhcpcd[681]: eth0: deleting address fe80::5054:ff:fe12:3456 machine # [ 14.561115] dhcpcd[681]: eth0: deleting route to 10.0.2.0/24 machine # [ 14.562249] dhcpcd[681]: eth0: deleting default route via 10.0.2.2 machine # [ 14.566208] systemd[1]: Stopping Address configuration of eth1... machine # [ 14.574725] systemd[1]: Stopping Post-Boot Actions... machine # [ 14.575831] systemd[1]: reload-systemd-vconsole-setup.service: Deactivated successfully. machine # [ 14.578130] systemd[1]: Stopped Reset console on configuration changes. machine # [ 14.579080] dhcpcd[681]: dhcpcd exited machine # [ 14.580202] systemd[1]: Stopping User Login Management... machine # [ 14.580958] systemd[1]: systemd-machine-id-commit.service: Deactivated successfully. machine # [ 14.584044] systemd[1]: Stopped Save Transient machine-id to Disk. machine # [ 14.588130] systemd[1]: Stopped target First Boot Complete. machine # [ 14.591538] systemd[1]: Stopping Userspace Out-Of-Memory (OOM) Killer... machine # [ 14.600582] systemd[1]: Stopping Load/Save OS Random Seed... machine # [ 14.616566] systemd[1]: systemd-oomd.service: Deactivated successfully. machine # [ 14.619986] systemd[1]: Stopped Userspace Out-Of-Memory (OOM) Killer. machine # [ 14.622216] systemd[1]: backdoor.service: Deactivated successfully. machine # [ 14.625903] systemd[1]: Stopped backdoor.service. machine # [ 14.629923] systemd[1]: systemd-logind.service: Deactivated successfully. machine # [ 14.634110] systemd[1]: Stopped User Login Management. machine # [ 14.643421] systemd[1]: dhcpcd.service: Deactivated successfully. machine # [ 14.645139] systemd[1]: Stopped DHCP Client. machine # [ 14.646611] systemd[1]: dhcpcd.service: Consumed 145ms CPU time over 6.356s wall clock time, 5.9M memory peak, 8K written to disk, 96B incoming IP traffic, 56B outgoing IP traffic. machine # [ 14.650326] network-addresses-eth1-pre-stop[824]: deleting address 192.168.1.1/24... done machine # [ 14.657336] systemd[1]: getty@tty1.service: Deactivated successfully. machine # [ 14.658907] systemd[1]: Stopped Getty on tty1. machine # [ 14.664244] systemd[1]: Mounted /run/initramfs. machine # [ 14.665778] systemd[1]: post-boot.service: Deactivated successfully. machine # [ 14.666913] network-addresses-eth1-pre-stop[824]: deleting address 2001:db8:1::1/64... done machine # [ 14.668226] systemd[1]: Stopped Post-Boot Actions. machine # [ 14.677228] systemd[1]: Removed slice Slice /system/getty. machine # [ 14.680053] systemd[1]: Starting Generate shutdown ramfs... machine # [ 14.683335] systemd[1]: Stopping Permit User Sessions... machine # [ 14.685652] systemd[1]: network-addresses-eth1.service: Deactivated successfully. machine # [ 14.689572] systemd[1]: Stopped Address configuration of eth1. machine # [ 14.716402] systemd[1]: systemd-user-sessions.service: Deactivated successfully. machine # [ 14.720361] systemd[1]: Stopped Permit User Sessions. machine # [ 14.721265] systemd[1]: Stopped target Network. machine # [ 14.722059] systemd[1]: Stopped target User and Group Name Lookups. machine # [ 14.722911] systemd[1]: Stopped target Remote File Systems. machine # [ 14.725109] systemd[1]: network-local-commands.service: Deactivated successfully. machine # [ 14.726115] systemd[1]: Stopped Extra networking commands.. machine # [ 14.726880] systemd[1]: Stopped target Preparation for Network. machine # [ 14.730184] systemd[1]: Stopping Firewall... machine # [ 14.730863] systemd[1]: Stopping Name Service Cache Daemon (nsncd)... machine # [ 14.732247] systemd[1]: resolvconf.service: Deactivated successfully. machine # [ 14.734088] systemd[1]: Stopped resolvconf update. machine # [ 14.738774] systemd[1]: nscd.service: Deactivated successfully. machine # [ 14.742171] systemd[1]: Stopped Name Service Cache Daemon (nsncd). machine # [ 14.749149] systemd[1]: systemd-random-seed.service: Deactivated successfully. machine # [ 14.753622] systemd[1]: Stopped Load/Save OS Random Seed. machine # [ 14.758174] systemd[1]: Stopped target Basic System. machine # [ 14.759754] systemd[1]: Stopped target Path Units. machine # [ 14.760483] systemd[1]: Stopped target Slice Units. machine # [ 14.762568] systemd[1]: Removed slice User and Session Slice. machine # [ 14.763591] systemd[1]: Stopped target Socket Units. machine # [ 14.764805] systemd[1]: systemd-hostnamed.socket: Deactivated successfully. machine # [ 14.766229] systemd[1]: Closed Hostname Service Socket. machine # [ 14.767809] systemd[1]: systemd-importd.socket: Deactivated successfully. machine # [ 14.769403] systemd[1]: Closed Disk Image Download Service Socket. machine # [ 14.771155] systemd[1]: systemd-machined.socket: Deactivated successfully. machine # [ 14.773202] systemd[1]: Closed Virtual Machine and Container Registration Service Socket. machine # [ 14.775915] systemd[1]: systemd-mute-console.socket: Deactivated successfully. machine # [ 14.776883] systemd[1]: Closed Console Output Muting Service Socket. machine # [ 14.777758] systemd[1]: systemd-oomd.socket: Deactivated successfully. machine # [ 14.778692] systemd[1]: Closed Userspace Out-Of-Memory (OOM) Killer Socket. machine # [ 14.779566] systemd[1]: systemd-repart.socket: Deactivated successfully. machine # [ 14.782212] systemd[1]: Closed Disk Repartitioning Service Socket. machine # [ 14.784413] dbus-broker[562]: Dispatched 809 messages @ 2(±4)μs / message. machine # [ 14.785484] systemd[1]: Stopping D-Bus System Message Bus... machine # [ 14.789101] systemd[1]: dbus-broker.service: Deactivated successfully. machine # [ 14.790653] systemd[1]: Stopped D-Bus System Message Bus. machine # [ 14.794449] systemd[1]: dbus.socket: Deactivated successfully. machine # [ 14.795553] systemd[1]: Closed D-Bus System Message Bus Socket. machine # [ 14.799287] systemd[1]: Stopped target System Initialization. machine # [ 14.800222] systemd[1]: Stopped target Local Encrypted Volumes. machine # [ 14.801531] systemd[1]: systemd-ask-password-console.path: Deactivated successfully. machine # [ 14.803122] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch. machine # [ 14.804684] make-initrd-ng[846]: /etc/initrd-release -> /nix/store/r7x5295b4xi78nyq8hxb0fm4f7cmafv8-etc-os-release machine # [ 14.807163] make-initrd-ng[846]: /etc/os-release -> /nix/store/r7x5295b4xi78nyq8hxb0fm4f7cmafv8-etc-os-release machine # [ 14.808732] make-initrd-ng[846]: /shutdown -> /nix/store/9yk66g2m0w7xh4rhqffsnkfn3qzzajfc-systemd-262-e355960/lib/systemd/systemd-shutdown machine # [ 14.810351] systemd[1]: systemd-ask-password-wall.path: Deactivated successfully. machine # [ 14.811367] systemd[1]: Stopped Forward Password Requests to Wall Directory Watch. machine # [ 14.812413] systemd[1]: systemd-sysctl.service: Deactivated successfully. machine # [ 14.813374] systemd[1]: Stopped Apply Kernel Variables. machine # [ 14.814127] systemd[1]: systemd-coredump.socket: Deactivated successfully. machine # [ 14.816643] systemd[1]: Closed Process Core Dump Socket. machine # [ 14.817419] systemd[1]: systemd-update-done.service: Deactivated successfully. machine # [ 14.818407] systemd[1]: Stopped Update is Completed. machine # [ 14.819137] systemd[1]: systemd-journal-catalog-update.service: Deactivated successfully. machine # [ 14.820171] systemd[1]: Stopped Rebuild Journal Catalog. machine # [ 14.822859] systemd[1]: Stopping Record System Boot/Shutdown in UTMP... machine # [ 14.857231] systemd[1]: systemd-update-utmp.service: Deactivated successfully. machine # [ 14.860137] systemd[1]: Stopped Record System Boot/Shutdown in UTMP. machine # [ 14.861556] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. machine # [ 14.864138] systemd[1]: Stopped Create System Files and Directories. machine # [ 14.865041] systemd[1]: Stopped target Local File Systems. machine # [ 14.867036] systemd[1]: Unmounting /run/keys... machine # [ 14.870866] systemd[1]: Unmounting /run/wrappers... machine # [ 14.906589] systemd[1]: firewall.service: Deactivated successfully. machine # [ 14.911115] systemd[1]: Stopped Firewall. machine # [ 14.911736] systemd[1]: systemd-modules-load.service: Deactivated successfully. machine # [ 14.912789] systemd[1]: Stopped Load Kernel Modules. machine # [ 14.930582] systemd[1]: run-keys.mount: Deactivated successfully. machine # [ 14.931707] systemd[1]: Unmounted /run/keys. machine # [ 14.935234] systemd[1]: run-wrappers.mount: Deactivated successfully. machine # [ 14.937119] systemd[1]: Unmounted /run/wrappers. machine # [ 14.937959] systemd[1]: generate-shutdown-ramfs.service: Deactivated successfully. machine # [ 14.939908] systemd[1]: Finished Generate shutdown ramfs. machine # [ 14.942369] systemd[1]: Stopped target Preparation for Local File Systems. machine # [ 14.943380] systemd[1]: Stopped target Swaps. machine # [ 14.944138] systemd[1]: Reached target Unmount All Filesystems. machine # [ 14.944972] systemd[1]: systemd-remount-fs.service: Deactivated successfully. machine # [ 14.946210] systemd[1]: Stopped Remount Root and Kernel File Systems. machine # [ 14.948144] systemd[1]: systemd-fsck-root.service: Deactivated successfully. machine # [ 14.949155] systemd[1]: Stopped File System Check on Root Device. machine # [ 14.949982] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. machine # [ 14.950994] systemd[1]: Stopped Create Static Device Nodes in /dev. machine # [ 14.951911] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. machine # [ 14.953038] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully. machine # [ 14.954247] systemd[1]: Reached target System Shutdown. machine # [ 14.955534] systemd[1]: Reached target Late Shutdown Services. machine # [ 14.956393] systemd[1]: systemd-poweroff.service: Deactivated successfully. machine # [ 14.957645] systemd[1]: Finished System Power Off. machine # [ 14.958689] systemd[1]: Reached target System Power Off. machine # [ 14.959689] systemd[1]: Shutting down. machine # [ 15.242669] systemd-shutdown[1]: Syncing filesystems and block devices. machine # [ 15.229914] systemd-udevd[321]: Failed to send readiness notification, ignoring: Connection refused machine # [ 15.563537] systemd-shutdown[1]: Sending SIGTERM to remaining processes... machine # [ 15.573485] systemd-journald[283]: Received SIGTERM from PID 1 (systemd-shutdow). machine # [ 15.627545] systemd-shutdown[1]: Sending SIGKILL to remaining processes... machine # [ 15.633987] systemd-shutdown[1]: Unmounting file systems. machine # [ 15.638133] (sd-umount)[880]: Unmounting '/run/credentials/systemd-journald.service'. machine # [ 15.640693] (sd-remount)[881]: 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'. machine # [ 15.647026] (sd-umount)[882]: Unmounting '/nix/store'. machine # [ 15.649314] (sd-umount)[882]: Failed to unmount /nix/store: Device or resource busy machine # [ 15.650377] systemd-shutdown[1]: Moving mount /nix/store to /run/shutdown/mounts/33cdc13c2229ae68. machine # [ 15.651642] (sd-remount)[883]: 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'. machine # [ 15.653839] (sd-umount)[884]: Unmounting '/nix/store'. machine # [ 15.654815] (sd-remount)[885]: Remounting '/tmp/xchg' read-only with options ''. machine # [ 15.656027] (sd-umount)[886]: Unmounting '/tmp/xchg'. machine # [ 15.657238] (sd-remount)[887]: Remounting '/tmp/shared' read-only with options ''. machine # [ 15.658491] (sd-umount)[888]: Unmounting '/tmp/shared'. machine # [ 15.659715] (sd-umount)[889]: Unmounting '/nix/.ro-store'. machine # [ 15.660770] (sd-umount)[890]: Unmounting '/nix/.rw-store'. machine # [ 15.661836] (sd-remount)[891]: Remounting '/' read-only with options ''. machine # [ 15.668223] EXT4-fs (vda): re-mounted 372c99e0-324a-4da2-b90d-2250d85955fc ro. machine # [ 15.669855] (sd-umount)[892]: Unmounting '/run/shutdown/mounts/33cdc13c2229ae68'. machine # [ 15.670649] (sd-umount)[892]: Failed to unmount /run/shutdown/mounts/33cdc13c2229ae68: Device or resource busy machine # [ 15.671950] systemd-shutdown[1]: Not all file systems unmounted, 1 left. machine # [ 15.672633] systemd-shutdown[1]: Deactivating swaps. machine # [ 15.673202] systemd-shutdown[1]: All swaps deactivated. machine # [ 15.673752] systemd-shutdown[1]: Detaching loop devices. machine # [ 15.677359] systemd-shutdown[1]: All loop devices detached. machine # [ 15.677965] systemd-shutdown[1]: Stopping MD devices. machine # [ 15.678577] systemd-shutdown[1]: All MD devices stopped. machine # [ 15.679152] systemd-shutdown[1]: Detaching DM devices. machine # [ 15.679734] systemd-shutdown[1]: All DM devices detached. machine # [ 15.680391] systemd-shutdown[1]: Unmounting file systems. machine # [ 15.681421] (sd-umount)[893]: Unmounting '/run/shutdown/mounts/33cdc13c2229ae68'. machine # [ 15.682208] (sd-umount)[893]: Failed to unmount /run/shutdown/mounts/33cdc13c2229ae68: Device or resource busy machine # [ 15.683402] systemd-shutdown[1]: Not all file systems unmounted, 1 left. machine # [ 15.684093] systemd-shutdown[1]: Cannot finalize remaining file systems, continuing. machine # [ 16.020942] systemd-shutdown[1]: Successfully changed into root pivot. machine # [ 16.022736] systemd-shutdown[1]: Entering exitrd... machine # [ 16.033839] shutdown[1]: Syncing filesystems and block devices. machine # [ 16.035786] shutdown[1]: Sending SIGTERM to remaining processes... machine # [ 16.041505] shutdown[1]: Sending SIGKILL to remaining processes... machine # [ 16.047035] shutdown[1]: Unmounting file systems. machine # [ 16.050563] (sd-umoun[895]: Unmounting '/run/credentials'. machine # [ 16.053185] (sd-umoun[896]: Unmounting '/oldroot/sys/kernel/config'. machine # [ 16.055879] (sd-umoun[897]: Unmounting '/oldroot/sys/fs/fuse/connections'. machine # [ 16.058775] (sd-umoun[898]: Unmounting '/oldroot/sys/kernel/tracing'. machine # [ 16.061689] (sd-umoun[899]: Unmounting '/oldroot/sys/kernel/debug'. machine # [ 16.064524] (sd-umoun[900]: Unmounting '/oldroot/dev/hugepages'. machine # [ 16.068182] (sd-umoun[901]: Unmounting '/oldroot/dev/mqueue'. machine # [ 16.071759] (sd-umoun[902]: Unmounting '/oldroot/sys/fs/bpf'. machine # [ 16.074702] (sd-umoun[903]: Unmounting '/oldroot/sys/fs/pstore'. machine # [ 16.077509] (sd-umoun[904]: Unmounting '/oldroot/sys/fs/cgroup'. machine # [ 16.080239] (sd-umoun[905]: Unmounting '/oldroot/sys/kernel/security'. machine # [ 16.083109] (sd-umoun[906]: Unmounting '/oldroot/run/shutdown/mounts/33cdc13c2229ae68'. machine # [ 16.105818] (sd-umoun[907]: Unmounting '/oldroot/sys'. machine # [ 16.107463] (sd-umoun[908]: Unmounting '/oldroot/proc'. machine # [ 16.108905] (sd-umoun[909]: Unmounting '/oldroot/dev/shm'. machine # [ 16.110337] (sd-umoun[910]: Unmounting '/oldroot/dev/pts'. machine # [ 16.111681] (sd-umoun[911]: Unmounting '/oldroot/dev'. machine # [ 16.112987] (sd-umoun[912]: Unmounting '/oldroot/run'. machine # [ 16.114285] (sd-umoun[913]: Unmounting '/oldroot'. machine # [ 16.116449] EXT4-fs (vda): unmounting filesystem 372c99e0-324a-4da2-b90d-2250d85955fc. machine # [ 16.118040] shutdown[1]: All filesystems unmounted. machine # [ 16.118971] shutdown[1]: Deactivating swaps. machine # [ 16.119769] shutdown[1]: All swaps deactivated. machine # [ 16.120565] shutdown[1]: Detaching loop devices. machine # [ 16.122587] shutdown[1]: All loop devices detached. machine # [ 16.123443] shutdown[1]: Stopping MD devices. machine # [ 16.124305] shutdown[1]: All MD devices stopped. machine # [ 16.125076] shutdown[1]: Detaching DM devices. machine # [ 16.125927] shutdown[1]: All DM devices detached. machine # [ 16.126668] shutdown[1]: All filesystems, swaps, loop devices, MD devices and DM devices detached. machine # [ 16.127950] shutdown[1]: Syncing filesystems and block devices. machine # [ 16.129145] shutdown[1]: Powering off. machine # [ 16.140043] ACPI: PM: Preparing to enter system sleep state S5 machine # [ 16.141115] kvm: exiting hardware virtualization machine # [ 16.141761] reboot: Power down machine # [2026-09-21T12:47:10Z INFO virtiofsd] Client disconnected, shutting down machine # [2026-09-21T12:47:10Z INFO virtiofsd] Client disconnected, shutting down machine # [2026-09-21T12:47:10Z INFO virtiofsd] Client disconnected, shutting down machine: (finished: waiting for the VM to power off, in 1.65 seconds) (finished: run the VM test script, in 17.20 seconds) test script finished in 17.20s cleanup (finished: cleanup, in 0.00 seconds)