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 machine: waiting for unit multi-user.target machine: waiting for the VM to finish booting machine: starting vm machine: QEMU running (pid 45) machine # Disk image does not exist, creating the virtualisation disk image... machine # Formatting '/build/vm-state-machine/tmp.qdV1h3aBMk', fmt=raw size=1073741824 machine # mke2fs 1.47.4 (6-Mar-2025) machine # Discarding device blocks: 0/262144 done machine # Creating filesystem with 262144 4k blocks and 65536 inodes machine # Filesystem UUID: fea9d831-8ed2-495d-8b65-e7e93bacb6c7 machine # Superblock backups stored on blocks: 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 # 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 CA00Press Ctrl-B to configure iPXE (PCI 00:02.0)... machine # machine # machine # machine # machine # iPXE (http://ipxe.org) 00:08.0 CB00 PCI2.10 PnP PMM 3EFCC730 3EF2C730 CB00 machine # Press Ctrl-B to configure iPXE (PCI 00:08.0)... machine # machine # machine # Booting from ROM... machine # Probing EDD (edd=off to disable)... o[ 0.000000] Linux version 6.18.49 (nixbld@localhost) (gcc (GCC) 15.3.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT_DYNAMIC Wed Sep 2 12:31:51 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/2dxnd94gq2rrl2zizlyqygf5kr8skfrz-nixos-system-machine-test/init regInfo=/nix/store/0fkla85v6rii2kdbi72d9vdavk3jh24m-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 535550573 cycles machine # [ 0.000003] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns machine # [ 0.000006] tsc: Detected 2400.012 MHz processor machine # [ 0.000808] last_pfn = 0x3ffd8 max_arch_pfn = 0x10000000000 machine # [ 0.000846] MTRR map: 4 entries (3 fixed + 1 variable; max 19), built from 8 variable MTRRs machine # [ 0.000849] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT machine # [ 0.002785] found SMP MP-table at [mem 0x000f5450-0x000f545f] machine # [ 0.002799] Using GB pages for direct mapping machine # [ 0.002914] RAMDISK: [mem 0x3e42b000-0x3ffcffff] machine # [ 0.002924] ACPI: Early table checksum verification disabled machine # [ 0.002927] ACPI: RSDP 0x00000000000F5270 000014 (v00 BOCHS ) machine # [ 0.002932] ACPI: RSDT 0x000000003FFE2422 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) machine # [ 0.002936] ACPI: FACP 0x000000003FFE221A 0000F4 (v03 BOCHS BXPC 00000001 BXPC 00000001) machine # [ 0.002944] ACPI: DSDT 0x000000003FFE0040 0021DA (v01 BOCHS BXPC 00000001 BXPC 00000001) machine # [ 0.002946] ACPI: FACS 0x000000003FFE0000 000040 machine # [ 0.002948] ACPI: APIC 0x000000003FFE230E 000078 (v03 BOCHS BXPC 00000001 BXPC 00000001) machine # [ 0.002949] ACPI: HPET 0x000000003FFE2386 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) machine # [ 0.002951] ACPI: MCFG 0x000000003FFE23BE 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001) machine # [ 0.002952] ACPI: WAET 0x000000003FFE23FA 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001) machine # [ 0.002954] ACPI: Reserving FACP table memory at [mem 0x3ffe221a-0x3ffe230d] machine # [ 0.002955] ACPI: Reserving DSDT table memory at [mem 0x3ffe0040-0x3ffe2219] machine # [ 0.002955] ACPI: Reserving FACS table memory at [mem 0x3ffe0000-0x3ffe003f] machine # [ 0.002956] ACPI: Reserving APIC table memory at [mem 0x3ffe230e-0x3ffe2385] machine # [ 0.002956] ACPI: Reserving HPET table memory at [mem 0x3ffe2386-0x3ffe23bd] machine # [ 0.002957] ACPI: Reserving MCFG table memory at [mem 0x3ffe23be-0x3ffe23f9] machine # [ 0.002957] ACPI: Reserving WAET table memory at [mem 0x3ffe23fa-0x3ffe2421] machine # [ 0.003468] No NUMA configuration found machine # [ 0.003470] Faking a node at [mem 0x0000000000000000-0x000000003ffd7fff] machine # [ 0.003473] NODE_DATA(0) allocated [mem 0x3ffd2780-0x3ffd7cff] machine # [ 0.005837] Zone ranges: machine # [ 0.005838] DMA [mem 0x0000000000001000-0x0000000000ffffff] machine # [ 0.005840] DMA32 [mem 0x0000000001000000-0x000000003ffd7fff] machine # [ 0.005842] Normal empty machine # [ 0.005842] Device empty machine # [ 0.005843] Movable zone start for each node machine # [ 0.005844] Early memory node ranges machine # [ 0.005844] node 0: [mem 0x0000000000001000-0x000000000009efff] machine # [ 0.005845] node 0: [mem 0x0000000000100000-0x000000003ffd7fff] machine # [ 0.005846] Initmem setup node 0 [mem 0x0000000000001000-0x000000003ffd7fff] machine # [ 0.005867] On node 0, zone DMA: 1 pages in unavailable ranges machine # [ 0.006155] On node 0, zone DMA: 97 pages in unavailable ranges machine # [ 0.024852] On node 0, zone DMA32: 40 pages in unavailable ranges machine # [ 0.026001] ACPI: PM-Timer IO Port: 0x608 machine # [ 0.026016] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) machine # [ 0.026049] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 machine # [ 0.026052] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) machine # [ 0.026054] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) machine # [ 0.026055] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) machine # [ 0.026056] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) machine # [ 0.026057] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) machine # [ 0.026059] ACPI: Using ACPI (MADT) for SMP configuration information machine # [ 0.026060] ACPI: HPET id: 0x8086a201 base: 0xfed00000 machine # [ 0.026065] TSC deadline timer available machine # [ 0.026069] CPU topo: Max. logical packages: 1 machine # [ 0.026070] CPU topo: Max. logical dies: 1 machine # [ 0.026071] CPU topo: Max. dies per package: 1 machine # [ 0.026076] CPU topo: Max. threads per core: 1 machine # [ 0.026076] CPU topo: Num. cores per package: 1 machine # [ 0.026077] CPU topo: Num. threads per package: 1 machine # [ 0.026077] CPU topo: Allowing 1 present CPUs plus 0 hotplug CPUs machine # [ 0.026099] kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write() machine # [ 0.026138] PM: hibernation: Registered nosave memory: [mem 0x00000000-0x00000fff] machine # [ 0.026140] PM: hibernation: Registered nosave memory: [mem 0x0009f000-0x000fffff] machine # [ 0.026141] [mem 0x40000000-0xafffffff] available for PCI devices machine # [ 0.026143] Booting paravirtualized kernel on KVM machine # [ 0.026146] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns machine # [ 0.030651] setup_percpu: NR_CPUS:384 nr_cpumask_bits:1 nr_cpu_ids:1 nr_node_ids:1 machine # [ 0.032973] percpu: Embedded 98 pages/cpu s278528 r8192 d114688 u2097152 machine # [ 0.033028] kvm-guest: PV spinlocks disabled, single CPU machine # [ 0.033030] 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/2dxnd94gq2rrl2zizlyqygf5kr8skfrz-nixos-system-machine-test/init regInfo=/nix/store/0fkla85v6rii2kdbi72d9vdavk3jh24m-closure-info/registration console=ttyS0,115200n8 console=tty0 machine # [ 0.033131] Unknown kernel command line parameters "regInfo=/nix/store/0fkla85v6rii2kdbi72d9vdavk3jh24m-closure-info/registration", will be passed to user space. machine # [ 0.033143] random: crng init done machine # [ 0.033144] printk: log buffer data + meta data: 262144 + 917504 = 1179648 bytes machine # [ 0.033167] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes, linear) machine # [ 0.033181] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes, linear) machine # [ 0.033217] Fallback order for Node 0: 0 machine # [ 0.033220] Built 1 zonelists, mobility grouping on. Total pages: 262006 machine # [ 0.033222] Policy zone: DMA32 machine # [ 0.036008] mem auto-init: stack:all(zero), heap alloc:on, heap free:off machine # [ 0.038658] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1 machine # [ 0.041081] allocated 2097152 bytes of page_ext machine # [ 0.050896] ftrace: allocating 48732 entries in 192 pages machine # [ 0.050898] ftrace: allocated 192 pages with 2 groups machine # [ 0.051765] Dynamic Preempt: lazy machine # [ 0.051931] rcu: Preemptible hierarchical RCU implementation. machine # [ 0.051931] rcu: RCU event tracing is enabled. machine # [ 0.051932] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1. machine # [ 0.051934] Trampoline variant of Tasks RCU enabled. machine # [ 0.051934] Rude variant of Tasks RCU enabled. machine # [ 0.051934] Tracing variant of Tasks RCU enabled. machine # [ 0.051935] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. machine # [ 0.051936] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1 machine # [ 0.051951] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. machine # [ 0.051953] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. machine # [ 0.051954] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. machine # [ 0.056458] NR_IRQS: 24832, nr_irqs: 256, preallocated irqs: 16 machine # [ 0.056746] rcu: srcu_init: Setting srcu_struct sizes based on contention. machine # [ 0.056754] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns machine # [ 0.056864] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____) machine # [ 0.064366] Console: colour VGA+ 80x25 machine # [ 0.064371] printk: legacy console [tty0] enabled machine # [ 0.107711] printk: legacy console [ttyS0] enabled machine # [ 0.306825] ACPI: Core revision 20250807 machine # [ 0.308391] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns machine # [ 0.311192] APIC: Switch to symmetric I/O mode setup machine # [ 0.312943] x2apic enabled machine # [ 0.314213] APIC: Switched APIC routing to: physical x2apic machine # [ 0.317192] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 machine # [ 0.319048] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x229842dd0bd, max_idle_ns: 440795319571 ns machine # [ 0.322287] Calibrating delay loop (skipped) preset value.. 4800.02 BogoMIPS (lpj=2400012) machine # [ 0.323401] x86/cpu: User Mode Instruction Prevention (UMIP) activated machine # [ 0.325466] Last level iTLB entries: 4KB 512, 2MB 255, 4MB 127 machine # [ 0.327284] Last level dTLB entries: 4KB 512, 2MB 255, 4MB 127, 1GB 0 machine # [ 0.329290] mitigations: Enabled attack vectors: user_kernel, user_user, guest_host, guest_guest, SMT mitigations: auto machine # [ 0.331285] Speculative Store Bypass: Mitigation: Speculative Store Bypass disabled via prctl machine # [ 0.333285] Transient Scheduler Attacks: Mitigation: Clear CPU buffers machine # [ 0.335284] Spectre V2 : Mitigation: Enhanced / Automatic IBRS machine # [ 0.337285] Speculative Return Stack Overflow: Mitigation: Safe RET machine # [ 0.338284] Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization machine # [ 0.340295] Spectre V2 : Enabling IBPB for BPF machine # [ 0.341286] Spectre V2 : mitigation: Enabling conditional Indirect Branch Prediction Barrier machine # [ 0.343285] active return thunk: srso_alias_return_thunk machine # [ 0.344314] x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers' machine # [ 0.345285] x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers' machine # [ 0.346284] x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers' machine # [ 0.347289] x86/fpu: Supporting XSAVE feature 0x020: 'AVX-512 opmask' machine # [ 0.348284] x86/fpu: Supporting XSAVE feature 0x040: 'AVX-512 Hi256' machine # [ 0.349284] x86/fpu: Supporting XSAVE feature 0x080: 'AVX-512 ZMM_Hi256' machine # [ 0.350285] x86/fpu: Supporting XSAVE feature 0x200: 'Protection Keys User registers' machine # [ 0.351285] x86/fpu: Supporting XSAVE feature 0x800: 'Control-flow User registers' machine # [ 0.353284] x86/fpu: Supporting XSAVE feature 0x1000: 'Control-flow Kernel registers (KVM only)' machine # [ 0.355285] x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256 machine # [ 0.356284] x86/fpu: xstate_offset[5]: 832, xstate_sizes[5]: 64 machine # [ 0.357284] x86/fpu: xstate_offset[6]: 896, xstate_sizes[6]: 512 machine # [ 0.358284] x86/fpu: xstate_offset[7]: 1408, xstate_sizes[7]: 1024 machine # [ 0.359284] x86/fpu: xstate_offset[9]: 2432, xstate_sizes[9]: 8 machine # [ 0.361284] x86/fpu: xstate_offset[11]: 2440, xstate_sizes[11]: 16 machine # [ 0.363284] x86/fpu: xstate_offset[12]: 2456, xstate_sizes[12]: 24 machine # [ 0.365284] x86/fpu: Enabled xstate features 0x1ae7, context size is 2480 bytes, using 'compacted' format. machine # [ 0.401208] Freeing SMP alternatives memory: 44K machine # [ 0.402287] pid_max: default: 32768 minimum: 301 machine # [ 0.404302] LSM: initializing lsm=capability,landlock,yama,bpf,ima machine # [ 0.405403] landlock: Up and running. machine # [ 0.407284] Yama: becoming mindful. machine # [ 0.408501] LSM support for eBPF active machine # [ 0.409418] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear) machine # [ 0.411311] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear) machine # [ 0.413991] smpboot: CPU0: AMD EPYC 9654 96-Core Processor (family: 0x19, model: 0x11, stepping: 0x1) machine # [ 0.414868] Performance Events: Fam17h+ core perfctr, AMD PMU driver. machine # [ 0.415289] ... version: 2 machine # [ 0.416286] ... bit width: 48 machine # [ 0.417294] ... generic counters: 6 machine # [ 0.418286] ... generic bitmap: 000000000000003f machine # [ 0.419286] ... fixed-purpose counters: 0 machine # [ 0.420287] ... fixed-purpose bitmap: 0000000000000000 machine # [ 0.421286] ... value mask: 0000ffffffffffff machine # [ 0.422286] ... max period: 00007fffffffffff machine # [ 0.423286] ... global_ctrl mask: 000000000000003f machine # [ 0.424420] signal: max sigframe size: 3376 machine # [ 0.425394] rcu: Hierarchical SRCU implementation. machine # [ 0.426291] rcu: Max phase no-delay instances is 400. machine # [ 0.432030] smp: Bringing up secondary CPUs ... machine # [ 0.433300] smp: Brought up 1 node, 1 CPU machine # [ 0.434289] smpboot: Total of 1 processors activated (4800.02 BogoMIPS) machine # [ 0.435553] Memory: 941792K/1048024K available (17215K kernel code, 2726K rwdata, 13584K rodata, 3644K init, 2988K bss, 98832K reserved, 0K cma-reserved) machine # [ 0.436543] devtmpfs: initialized machine # [ 0.437519] x86/mm: Memory block size: 128MB machine # [ 0.439320] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear) machine # [ 0.440325] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear). machine # [ 0.441385] pinctrl core: initialized pinctrl subsystem machine # [ 0.442634] PM: RTC time: 06:55:03, date: 2026-09-06 machine # [ 0.446323] NET: Registered PF_NETLINK/PF_ROUTE protocol family machine # [ 0.447679] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations machine # [ 0.448309] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations machine # [ 0.449452] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations machine # [ 0.450298] audit: initializing netlink subsys (disabled) machine # [ 0.451629] thermal_sys: Registered thermal governor 'fair_share' machine # [ 0.451631] thermal_sys: Registered thermal governor 'bang_bang' machine # [ 0.452287] thermal_sys: Registered thermal governor 'step_wise' machine # [ 0.453292] audit: type=2000 audit(1788677702.944:1): state=initialized audit_enabled=0 res=1 machine # [ 0.455291] thermal_sys: Registered thermal governor 'user_space' machine # [ 0.455293] thermal_sys: Registered thermal governor 'power_allocator' machine # [ 0.456311] cpuidle: using governor menu machine # [ 0.459589] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 machine # [ 0.460609] PCI: ECAM [mem 0xb0000000-0xbfffffff] (base 0xb0000000) for domain 0000 [bus 00-ff] machine # [ 0.461290] PCI: ECAM [mem 0xb0000000-0xbfffffff] reserved as E820 entry machine # [ 0.462299] PCI: Using configuration type 1 for base access machine # [ 0.463487] kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible. machine # [ 0.470495] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages machine # [ 0.471287] HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page machine # [ 0.476286] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages machine # [ 0.477287] HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page machine # [ 0.487733] ACPI: Added _OSI(Module Device) machine # [ 0.488287] ACPI: Added _OSI(Processor Device) machine # [ 0.493286] ACPI: Added _OSI(Processor Aggregator Device) machine # [ 0.496868] ACPI: 1 ACPI AML tables successfully acquired and loaded machine # [ 0.502740] ACPI: Interpreter enabled machine # [ 0.503304] ACPI: PM: (supports S0 S3 S4 S5) machine # [ 0.506286] ACPI: Using IOAPIC for interrupt routing machine # [ 0.507326] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug machine # [ 0.510286] PCI: Using E820 reservations for host bridge windows machine # [ 0.511457] ACPI: Enabled 2 GPEs in block 00 to 3F machine # [ 0.517657] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) machine # [ 0.518294] acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] machine # [ 0.519368] acpi PNP0A08:00: _OSC: platform does not support [PCIeHotplug LTR] machine # [ 0.520417] acpi PNP0A08:00: _OSC: OS now controls [PME AER PCIeCapability] machine # [ 0.522250] PCI host bridge to bus 0000:00 machine # [ 0.523292] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] machine # [ 0.524289] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] machine # [ 0.525290] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] machine # [ 0.526294] pci_bus 0000:00: root bus resource [mem 0x40000000-0xafffffff window] machine # [ 0.527288] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window] machine # [ 0.528288] pci_bus 0000:00: root bus resource [mem 0x100000000-0x8ffffffff window] machine # [ 0.529289] pci_bus 0000:00: root bus resource [bus 00-ff] machine # [ 0.530429] pci 0000:00:00.0: [8086:29c0] type 00 class 0x060000 conventional PCI endpoint machine # [ 0.532287] pci 0000:00:01.0: [1234:1111] type 00 class 0x030000 conventional PCI endpoint machine # [ 0.535389] pci 0000:00:01.0: BAR 0 [mem 0xfd000000-0xfdffffff pref] machine # [ 0.536314] pci 0000:00:01.0: BAR 2 [mem 0xfebd0000-0xfebd0fff] machine # [ 0.537340] pci 0000:00:01.0: ROM [mem 0xfebc0000-0xfebcffff pref] machine # [ 0.538816] pci 0000:00:01.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff] machine # [ 0.540342] pci 0000:00:02.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint machine # [ 0.543326] pci 0000:00:02.0: BAR 0 [io 0xc140-0xc15f] machine # [ 0.544302] pci 0000:00:02.0: BAR 1 [mem 0xfebd1000-0xfebd1fff] machine # [ 0.545340] pci 0000:00:02.0: BAR 4 [mem 0xfe000000-0xfe003fff 64bit pref] machine # [ 0.546302] pci 0000:00:02.0: ROM [mem 0xfeb40000-0xfeb7ffff pref] machine # [ 0.548532] pci 0000:00:03.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint machine # [ 0.551325] pci 0000:00:03.0: BAR 0 [io 0xc160-0xc17f] machine # [ 0.552327] pci 0000:00:03.0: BAR 1 [mem 0xfebd2000-0xfebd2fff] machine # [ 0.553341] pci 0000:00:03.0: BAR 4 [mem 0xfe004000-0xfe007fff 64bit pref] machine # [ 0.555540] pci 0000:00:04.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint machine # [ 0.558301] pci 0000:00:04.0: BAR 0 [io 0xc080-0xc0bf] machine # [ 0.559301] pci 0000:00:04.0: BAR 1 [mem 0xfebd3000-0xfebd3fff] machine # [ 0.560342] pci 0000:00:04.0: BAR 4 [mem 0xfe008000-0xfe00bfff 64bit pref] machine # [ 0.562565] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint machine # [ 0.565084] pci 0000:00:05.0: BAR 0 [io 0xc180-0xc19f] machine # [ 0.566301] pci 0000:00:05.0: BAR 1 [mem 0xfebd4000-0xfebd4fff] machine # [ 0.567340] pci 0000:00:05.0: BAR 4 [mem 0xfe00c000-0xfe00ffff 64bit pref] machine # [ 0.569564] pci 0000:00:06.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint machine # [ 0.572259] pci 0000:00:06.0: BAR 0 [io 0xc1a0-0xc1bf] machine # [ 0.573301] pci 0000:00:06.0: BAR 1 [mem 0xfebd5000-0xfebd5fff] machine # [ 0.574350] pci 0000:00:06.0: BAR 4 [mem 0xfe010000-0xfe013fff 64bit pref] machine # [ 0.576651] pci 0000:00:07.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint machine # [ 0.579137] pci 0000:00:07.0: BAR 0 [io 0xc000-0xc07f] machine # [ 0.580301] pci 0000:00:07.0: BAR 1 [mem 0xfebd6000-0xfebd6fff] machine # [ 0.581346] pci 0000:00:07.0: BAR 4 [mem 0xfe014000-0xfe017fff 64bit pref] machine # [ 0.583546] pci 0000:00:08.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint machine # [ 0.585301] pci 0000:00:08.0: BAR 0 [io 0xc1c0-0xc1df] machine # [ 0.586301] pci 0000:00:08.0: BAR 1 [mem 0xfebd7000-0xfebd7fff] machine # [ 0.587340] pci 0000:00:08.0: BAR 4 [mem 0xfe018000-0xfe01bfff 64bit pref] machine # [ 0.588302] pci 0000:00:08.0: ROM [mem 0xfeb80000-0xfebbffff pref] machine # [ 0.590708] pci 0000:00:09.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint machine # [ 0.592332] pci 0000:00:09.0: BAR 1 [mem 0xfebd8000-0xfebd8fff] machine # [ 0.593368] pci 0000:00:09.0: BAR 4 [mem 0xfe01c000-0xfe01ffff 64bit pref] machine # [ 0.595556] pci 0000:00:0a.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint machine # [ 0.597986] pci 0000:00:0a.0: BAR 0 [io 0xc0c0-0xc0ff] machine # [ 0.599301] pci 0000:00:0a.0: BAR 1 [mem 0xfebd9000-0xfebd9fff] machine # [ 0.600340] pci 0000:00:0a.0: BAR 4 [mem 0xfe020000-0xfe023fff 64bit pref] machine # [ 0.602544] pci 0000:00:0b.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint machine # [ 0.604303] pci 0000:00:0b.0: BAR 0 [io 0xc1e0-0xc1ff] machine # [ 0.605301] pci 0000:00:0b.0: BAR 1 [mem 0xfebda000-0xfebdafff] machine # [ 0.606341] pci 0000:00:0b.0: BAR 4 [mem 0xfe024000-0xfe027fff 64bit pref] machine # [ 0.609191] pci 0000:00:1d.0: [8086:2934] type 00 class 0x0c0300 conventional PCI endpoint machine # [ 0.611907] pci 0000:00:1d.0: BAR 4 [io 0xc200-0xc21f] machine # [ 0.612677] pci 0000:00:1d.1: [8086:2935] type 00 class 0x0c0300 conventional PCI endpoint machine # [ 0.614872] pci 0000:00:1d.1: BAR 4 [io 0xc220-0xc23f] machine # [ 0.615687] pci 0000:00:1d.2: [8086:2936] type 00 class 0x0c0300 conventional PCI endpoint machine # [ 0.617313] pci 0000:00:1d.2: BAR 4 [io 0xc240-0xc25f] machine # [ 0.618737] pci 0000:00:1d.7: [8086:293a] type 00 class 0x0c0320 conventional PCI endpoint machine # [ 0.620354] pci 0000:00:1d.7: BAR 0 [mem 0xfebdb000-0xfebdbfff] machine # [ 0.622022] pci 0000:00:1f.0: [8086:2918] type 00 class 0x060100 conventional PCI endpoint machine # [ 0.623993] pci 0000:00:1f.0: quirk: [io 0x0600-0x067f] claimed by ICH6 ACPI/GPIO/TCO machine # [ 0.625760] pci 0000:00:1f.2: [8086:2922] type 00 class 0x010601 conventional PCI endpoint machine # [ 0.627628] pci 0000:00:1f.2: BAR 4 [io 0xc260-0xc27f] machine # [ 0.628301] pci 0000:00:1f.2: BAR 5 [mem 0xfebdc000-0xfebdcfff] machine # [ 0.629983] pci 0000:00:1f.3: [8086:2930] type 00 class 0x0c0500 conventional PCI endpoint machine # [ 0.632340] pci 0000:00:1f.3: BAR 4 [io 0x0700-0x073f] machine # [ 0.639789] ACPI: PCI: Interrupt link LNKA configured for IRQ 10 machine # [ 0.640482] ACPI: PCI: Interrupt link LNKB configured for IRQ 10 machine # [ 0.641454] ACPI: PCI: Interrupt link LNKC configured for IRQ 11 machine # [ 0.642454] ACPI: PCI: Interrupt link LNKD configured for IRQ 11 machine # [ 0.643443] ACPI: PCI: Interrupt link LNKE configured for IRQ 10 machine # [ 0.644439] ACPI: PCI: Interrupt link LNKF configured for IRQ 10 machine # [ 0.645444] ACPI: PCI: Interrupt link LNKG configured for IRQ 11 machine # [ 0.646439] ACPI: PCI: Interrupt link LNKH configured for IRQ 11 machine # [ 0.647356] ACPI: PCI: Interrupt link GSIA configured for IRQ 16 machine # [ 0.648309] ACPI: PCI: Interrupt link GSIB configured for IRQ 17 machine # [ 0.649304] ACPI: PCI: Interrupt link GSIC configured for IRQ 18 machine # [ 0.650309] ACPI: PCI: Interrupt link GSID configured for IRQ 19 machine # [ 0.651308] ACPI: PCI: Interrupt link GSIE configured for IRQ 20 machine # [ 0.652304] ACPI: PCI: Interrupt link GSIF configured for IRQ 21 machine # [ 0.653304] ACPI: PCI: Interrupt link GSIG configured for IRQ 22 machine # [ 0.654308] ACPI: PCI: Interrupt link GSIH configured for IRQ 23 machine # [ 0.656434] iommu: Default domain type: Translated machine # [ 0.657296] iommu: DMA domain TLB invalidation policy: lazy mode machine # [ 0.658587] ACPI: bus type USB registered machine # [ 0.659356] usbcore: registered new interface driver usbfs machine # [ 0.660309] usbcore: registered new interface driver hub machine # [ 0.661316] usbcore: registered new device driver usb machine # [ 0.663388] NetLabel: Initializing machine # [ 0.664286] NetLabel: domain hash size = 128 machine # [ 0.665286] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO machine # [ 0.666338] NetLabel: unlabeled traffic allowed by default machine # [ 0.667302] PCI: Using ACPI for IRQ routing machine # [ 0.780534] pci 0000:00:01.0: vgaarb: setting as boot VGA device machine # [ 0.781281] pci 0000:00:01.0: vgaarb: bridge control possible machine # [ 0.781281] pci 0000:00:01.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none machine # [ 0.781292] vgaarb: loaded machine # [ 0.782499] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 machine # [ 0.783286] hpet0: 3 comparators, 64-bit 100.000000 MHz counter machine # [ 0.787402] clocksource: Switched to clocksource kvm-clock machine # [ 0.791843] VFS: Disk quotas dquot_6.6.0 machine # [ 0.793139] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) machine # [ 0.795403] pnp: PnP ACPI init machine # [ 0.796721] ACPI: IRQ 4 override to edge(!), high(!) machine # [ 0.798418] system 00:05: [mem 0xb0000000-0xbfffffff window] has been reserved machine # [ 0.801055] pnp: PnP ACPI: found 6 devices machine # [ 0.809359] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns machine # [ 0.811971] clocksource: Switched to clocksource acpi_pm machine # [ 0.813713] NET: Registered PF_INET protocol family machine # [ 0.815620] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear) machine # [ 0.834873] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear) machine # [ 0.837625] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) machine # [ 0.839985] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear) machine # [ 0.842392] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear) machine # [ 0.844649] TCP: Hash tables configured (established 8192 bind 8192) machine # [ 0.846651] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear) machine # [ 0.848937] UDP hash table entries: 512 (order: 3, 32768 bytes, linear) machine # [ 0.850990] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear) machine # [ 0.853200] NET: Registered PF_UNIX/PF_LOCAL protocol family machine # [ 0.855011] NET: Registered PF_XDP protocol family machine # [ 0.856612] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] machine # [ 0.858507] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] machine # [ 0.860438] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] machine # [ 0.862570] pci_bus 0000:00: resource 7 [mem 0x40000000-0xafffffff window] machine # [ 0.864642] pci_bus 0000:00: resource 8 [mem 0xc0000000-0xfebfffff window] machine # [ 0.866720] pci_bus 0000:00: resource 9 [mem 0x100000000-0x8ffffffff window] machine # [ 0.869577] ACPI: \_SB_.GSIA: Enabled at IRQ 16 machine # [ 0.872486] ACPI: \_SB_.GSIB: Enabled at IRQ 17 machine # [ 0.875388] ACPI: \_SB_.GSIC: Enabled at IRQ 18 machine # [ 0.878246] ACPI: \_SB_.GSID: Enabled at IRQ 19 machine # [ 0.880897] PCI: CLS 0 bytes, default 64 machine # [ 0.882455] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x229842dd0bd, max_idle_ns: 440795319571 ns machine # [ 0.885685] Trying to unpack rootfs image as initramfs... machine # [ 0.933185] Initialise system trusted keyrings machine # [ 0.937627] workingset: timestamp_bits=40 max_order=18 bucket_order=0 machine # [ 0.962053] Key type asymmetric registered machine # [ 0.963440] Asymmetric key parser 'x509' registered machine # [ 0.969658] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 248) machine # [ 0.975639] io scheduler mq-deadline registered machine # [ 0.977075] io scheduler kyber registered machine # [ 0.981229] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled machine # [ 0.985592] 00:03: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A machine # [ 0.993948] Linux agpgart interface v0.103 machine # [ 0.995372] ACPI: bus type drm_connector registered machine # [ 1.000772] usbcore: registered new interface driver usbserial_generic machine # [ 1.002773] usbserial: USB Serial support registered for generic machine # [ 1.008577] amd_pstate: The CPPC feature is supported but currently disabled by the BIOS. machine # [ 1.008577] Please enable it if your BIOS has the CPPC option. machine # [ 1.012647] amd_pstate: the _CPC object is not present in SBIOS or ACPI disabled machine # [ 1.019745] drop_monitor: Initializing network drop monitor service machine # [ 1.021871] NET: Registered PF_INET6 protocol family machine # [ 1.029110] Segment Routing with IPv6 machine # [ 1.033610] In-situ OAM (IOAM) with IPv6 machine # [ 1.035306] IPI shorthand broadcast: enabled machine # [ 1.044016] sched_clock: Marking stable (785030233, 258527652)->(1259466552, -215908667) machine # [ 1.052885] registered taskstats version 1 machine # [ 1.054478] Loading compiled-in X.509 certificates machine # [ 1.076659] Demotion targets for Node 0: null machine # [ 1.078253] Key type .fscrypt registered machine # [ 1.081575] Key type fscrypt-provisioning registered machine # [ 1.083274] ima: No TPM chip found, activating TPM-bypass! machine # [ 1.087583] ima: Allocated hash algorithm: sha1 machine # [ 1.089051] ima: No architecture policies found machine # [ 1.094762] PM: Magic number: 10:992:922 machine # [ 1.099160] RAS: Correctable Errors collector initialized. machine # [ 1.108794] clk: Disabling unused clocks machine # [ 1.114586] PM: genpd: Disabling unused power domains machine # [ 1.256004] Freeing initrd memory: 28308K machine # [ 1.260049] Freeing unused decrypted memory: 2028K machine # [ 1.263648] Freeing unused kernel image (initmem) memory: 3644K machine # [ 1.265581] Write protecting the kernel read-only data: 32768k machine # [ 1.268357] Freeing unused kernel image (text/rodata gap) memory: 1216K machine # [ 1.270910] Freeing unused kernel image (rodata/data gap) memory: 752K machine # [ 1.324226] x86/mm: Checked W+X mappings: passed, no W+X pages found. machine # [ 1.326223] Run /init as init process machine # [ 1.337934] systemd[1]: Inserted module 'autofs4' machine # [ 1.355941] fuse: init (API version 7.45) machine # [ 1.362654] ACPI: \_SB_.GSIG: Enabled at IRQ 22 machine # [ 1.366731] ACPI: \_SB_.GSIH: Enabled at IRQ 23 machine # [ 1.371874] ACPI: \_SB_.GSIE: Enabled at IRQ 20 machine # [ 1.375763] ACPI: \_SB_.GSIF: Enabled at IRQ 21 machine # [ 1.414615] systemd[1]: Successfully made /usr/ read-only. machine # [ 1.754116] systemd[1]: systemd 262-726e17a 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.776447] systemd[1]: Detected virtualization kvm. machine # [ 1.780522] systemd[1]: Detected architecture x86-64. machine # [ 1.784666] systemd[1]: Running in initrd. machine # [ 1.788926] systemd[1]: Initializing machine ID from random generator. machine # [ 1.794256] systemd[1]: Hostname set to . machine # [ 1.881881] systemd[1]: bpf-restrict-fs: LSM BPF program attached machine # [ 1.924927] systemd[1]: Queued start job for default target Initrd Default Target. machine # [ 1.930232] systemd[1]: Created slice Slice /system/modprobe. machine # [ 1.932387] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. machine # [ 1.934929] systemd[1]: Expecting device /dev/disk/by-label/nixos... machine # [ 1.937016] systemd[1]: Reached target Path Units. machine # [ 1.938669] systemd[1]: Reached target Slice Units. machine # [ 1.940293] systemd[1]: Reached target Swaps. machine # [ 1.941816] systemd[1]: Reached target Timer Units. machine # [ 1.943645] systemd[1]: Listening on D-Bus System Message Bus Socket. machine # [ 1.945842] systemd[1]: Listening on Journal Socket (/dev/log). machine # [ 1.947995] systemd[1]: Listening on Journal Sockets. machine # [ 1.949790] systemd[1]: Listening on udev Kernel Socket. machine # [ 1.951590] systemd[1]: Reached target Socket Units. machine # [ 1.954298] systemd[1]: Starting Create List of Static Device Nodes... machine # [ 1.976834] systemd[1]: Starting Load Kernel Module 9pnet_virtio... machine # [ 1.989385] systemd[1]: Starting Load Kernel Module configfs... machine # [ 2.004669] systemd[1]: Starting Journal Service... machine # [ 2.020669] systemd[1]: Starting Load Kernel Modules... machine # [ 2.030677] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 2.033771] netfs: FS-Cache loaded machine # [ 2.043814] systemd[1]: Starting Coldplug All udev Devices... machine # [ 2.050017] 9pnet: Installing 9P2000 support machine # [ 2.071037] systemd[1]: Finished Create List of Static Device Nodes. machine # [ 2.075072] systemd-journald[67]: Collecting audit messages is disabled. machine # [ 2.086143] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully. machine # [ 2.098232] systemd[1]: Finished Load Kernel Module 9pnet_virtio. machine # [ 2.102030] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. machine # [ 2.110185] systemd[1]: modprobe@configfs.service: Deactivated successfully. machine # [ 2.119752] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev machine # [ 2.122614] systemd[1]: Finished Load Kernel Module configfs. machine # [ 2.130397] systemd[1]: Kernel Configuration File System skipped, unmet condition check ConditionPathExists=/sys/kernel/config machine # [ 2.150819] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... machine # [ 2.170766] systemd[1]: Finished Load Kernel Modules. machine # [ 2.183067] systemd[1]: Starting Apply Kernel Variables... machine # [ 2.202652] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. machine # [ 2.218157] systemd[1]: Starting Create Static Device Nodes in /dev... machine # [ 2.237773] systemd[1]: Finished Apply Kernel Variables. machine # [ 2.257461] systemd[1]: Finished Create Static Device Nodes in /dev. machine # [ 2.263962] systemd[1]: Reached target Preparation for Local File Systems. machine # [ 2.271680] systemd[1]: Reached target Local File Systems. machine # [ 2.280661] systemd[1]: Starting Rule-based Manager for Device Events and Files... machine # [ 2.030431] systemd-modules-load[68]: Inserted module 'dm_mod' machine # [ 2.034484] systemd-modules-load[68]: Inserted module 'virtio_balloon' machine # [ 2.037441] systemd-modules-load[68]: Inserted module 'virtio_gpu' machine # [ 2.300938] systemd[1]: Started Journal Service. machine # [ 2.067333] systemd[1]: Starting Create System Files and Directories... machine # [ 2.100183] systemd[1]: Finished Create System Files and Directories. machine # [ 2.105308] systemd-udevd[74]: Using default interface naming scheme 'v261'. machine # [ 2.139638] systemd[1]: Started Rule-based Manager for Device Events and Files. machine # [ 2.185167] systemd[1]: Finished Coldplug All udev Devices. machine # [ 2.186795] systemd[1]: Reached target System Initialization. machine # [ 2.189812] systemd[1]: Reached target Basic System. machine # [ 2.732698] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 machine # [ 2.740484] virtio_blk virtio5: 1/0/0 default/read/poll queues machine # [ 2.763775] serio: i8042 KBD port at 0x60,0x64 irq 1 machine # [ 2.765062] serio: i8042 AUX port at 0x60,0x64 irq 12 machine # [ 2.779040] virtio_blk virtio5: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) machine # [ 2.787903] ehci-pci 0000:00:1d.7: EHCI Host Controller machine # [ 2.789250] ehci-pci 0000:00:1d.7: new USB bus registered, assigned bus number 1 machine # [ 2.795138] ehci-pci 0000:00:1d.7: irq 19, io mem 0xfebdb000 machine # [ 2.802709] ehci-pci 0000:00:1d.7: USB 2.0 started, EHCI 1.00 machine # [ 2.805270] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 6.18 machine # [ 2.810570] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 machine # [ 2.814279] usb usb1: Product: EHCI Host Controller machine # [ 2.815703] usb usb1: Manufacturer: Linux 6.18.49 ehci_hcd machine # [ 2.817261] usb usb1: SerialNumber: 0000:00:1d.7 machine # [ 2.819089] hub 1-0:1.0: USB hub found machine # [ 2.820746] hub 1-0:1.0: 6 ports detected machine # [ 2.824792] uhci_hcd 0000:00:1d.0: UHCI Host Controller machine # [ 2.826106] uhci_hcd 0000:00:1d.0: new USB bus registered, assigned bus number 2 machine # [ 2.848601] uhci_hcd 0000:00:1d.0: detected 2 ports machine # [ 2.859007] uhci_hcd 0000:00:1d.0: irq 16, io port 0x0000c200 machine # [ 2.872635] usb usb2: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.18 machine # [ 2.874796] usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=1 machine # [ 2.890622] SCSI subsystem initialized machine # [ 2.903172] usb usb2: Product: UHCI Host Controller machine # [ 2.652189] systemd[1]: Starting Virtual Console Setup... machine # [ 2.927199] usb usb2: Manufacturer: Linux 6.18.49 uhci_hcd machine # [ 2.674311] (udev-worker)[91]: Network interface NamePolicy= disabled on kernel command line. machine # [ 2.940431] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input0 machine # [ 2.702086] systemd-vconsole-setup[98]: Configuration of first virtual console was skipped, ignoring remaining ones. machine # [ 2.705921] systemd[1]: Finished Virtual Console Setup. machine # [ 2.966695] usb usb2: SerialNumber: 0000:00:1d.0 machine # [ 2.710340] (udev-worker)[95]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. machine # [ 2.714827] (udev-worker)[95]: Network interface NamePolicy= disabled on kernel command line. machine # [ 2.980628] hub 2-0:1.0: USB hub found machine # [ 2.988721] hub 2-0:1.0: 2 ports detected machine # [ 3.009942] uhci_hcd 0000:00:1d.1: UHCI Host Controller machine # [ 3.011270] uhci_hcd 0000:00:1d.1: new USB bus registered, assigned bus number 3 machine # [ 2.763126] systemd[1]: Found device /dev/disk/by-label/nixos. machine # [ 2.764874] systemd[1]: Reached target Initrd Root Device. machine # [ 3.025222] uhci_hcd 0000:00:1d.1: detected 2 ports machine # [ 2.768862] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos... machine # [ 3.034719] uhci_hcd 0000:00:1d.1: irq 17, io port 0x0000c220 machine # [ 3.041646] usb usb3: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.18 machine # [ 3.043664] usb usb3: New USB device strings: Mfr=3, Product=2, SerialNumber=1 machine # [ 3.059586] usb 1-1: new high-speed USB device number 2 using ehci-pci machine # [ 3.064757] usb usb3: Product: UHCI Host Controller machine # [ 2.809580] systemd-fsck[107]: nixos: clean, 12/65536 files, 13019/262144 blocks machine # [ 3.071605] usb usb3: Manufacturer: Linux 6.18.49 uhci_hcd machine # [ 2.818331] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos. machine # [ 2.825114] systemd[1]: Mounting /sysroot... machine # [ 3.084915] usb usb3: SerialNumber: 0000:00:1d.1 machine # [ 3.091104] hub 3-0:1.0: USB hub found machine # [ 3.099404] hub 3-0:1.0: 2 ports detected machine # [ 3.104145] ahci 0000:00:1f.2: AHCI vers 0001.0000, 32 command slots, 1.5 Gbps, SATA mode machine # [ 3.111745] uhci_hcd 0000:00:1d.2: UHCI Host Controller machine # [ 3.118288] ahci 0000:00:1f.2: 6/6 ports implemented (port mask 0x3f) machine # [ 3.130954] uhci_hcd 0000:00:1d.2: new USB bus registered, assigned bus number 4 machine # [ 3.135563] ahci 0000:00:1f.2: flags: 64bit ncq only machine # [ 3.140724] uhci_hcd 0000:00:1d.2: detected 2 ports machine # [ 3.144809] uhci_hcd 0000:00:1d.2: irq 18, io port 0x0000c240 machine # [ 3.161671] scsi host0: ahci machine # [ 3.164826] usb usb4: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.18 machine # [ 3.173011] scsi host1: ahci machine # [ 3.178718] scsi host2: ahci machine # [ 3.185574] usb usb4: New USB device strings: Mfr=3, Product=2, SerialNumber=1 machine # [ 3.192379] scsi host3: ahci machine # [ 3.200993] usb usb4: Product: UHCI Host Controller machine # [ 3.202507] usb 1-1: New USB device found, idVendor=0627, idProduct=0001, bcdDevice= 0.00 machine # [ 3.204552] usb 1-1: New USB device strings: Mfr=1, Product=3, SerialNumber=10 machine # [ 3.209594] scsi host4: ahci machine # [ 3.210627] usb 1-1: Product: QEMU USB Tablet machine # [ 3.211777] usb 1-1: Manufacturer: QEMU machine # [ 3.212874] usb usb4: Manufacturer: Linux 6.18.49 uhci_hcd machine # [ 3.214244] usb usb4: SerialNumber: 0000:00:1d.2 machine # [ 3.217559] usb 1-1: SerialNumber: 28754-0000:00:1d.7-1 machine # [ 3.224442] scsi host5: ahci machine # [ 3.231259] hub 4-0:1.0: USB hub found machine # [ 3.234346] ata1: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc100 irq 44 lpm-pol 1 machine # [ 3.237660] hub 4-0:1.0: 2 ports detected machine # [ 3.245160] ata2: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc180 irq 44 lpm-pol 1 machine # [ 3.247917] EXT4-fs (vda): mounted filesystem fea9d831-8ed2-495d-8b65-e7e93bacb6c7 r/w with ordered data mode. Quota mode: none. machine # [ 2.995213] systemd[1]: Mounted /sysroot. machine # [ 2.998733] systemd[1]: Reached target Initrd Root File System. machine # [ 3.005068] systemd[1]: Mounting /sysroot/nix/.ro-store... machine # [ 3.012373] systemd[1]: Mounting /sysroot/nix/.rw-store... machine # [ 3.022107] systemd[1]: Mounting /sysroot/run... machine # [ 3.284595] ata3: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc200 irq 44 lpm-pol 1 machine # [ 3.030211] systemd[1]: Mounting /sysroot/tmp/shared... machine # [ 3.042932] systemd[1]: Mounting /sysroot/tmp/xchg... machine # [ 3.304028] ata4: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc280 irq 44 lpm-pol 1 machine # [ 3.053207] systemd[1]: Starting Mountpoints Configured in the Real Root... machine # [ 3.329568] ata5: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc300 irq 44 lpm-pol 1 machine # [ 3.342684] ata6: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc380 irq 44 lpm-pol 1 machine # [ 3.365820] 9p: Installing v9fs 9p2000 file system support machine # [ 3.110305] systemd-sysroot-fstab-check[133]: /sysroot should be mounted in the initrd, will request daemon-reload. machine # [ 3.121770] systemd[1]: Mounted /sysroot/nix/.rw-store. machine # [ 3.384017] hid: raw HID events driver (C) Jiri Kosina machine # [ 3.137146] systemd[1]: Mounted /sysroot/run. machine # [ 3.139739] systemd[1]: Mounted /sysroot/tmp/shared. machine # [ 3.142209] systemd[1]: Mounted /sysroot/tmp/xchg. machine # [ 3.145657] systemd[1]: Reload requested from client PID 133 ('systemd-sysroot') (unit initrd-parse-etc.service)... machine # [ 3.149280] systemd[1]: Reloading... machine # [ 3.216585] systemd[1]: Reloading finished in 67 ms. machine # [ 3.227137] systemd-sysroot-fstab-check[133]: Requesting initrd-fs.target/start/replace... machine # [ 3.231377] systemd-sysroot-fstab-check[133]: Requesting swap.target/start/replace... machine # [ 3.233937] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio machine # [ 3.239110] systemd[1]: Starting rw-sysroot-nix-store.service... machine # [ 3.240850] systemd[1]: initrd-parse-etc.service: Deactivated successfully. machine # [ 3.244761] systemd[1]: Finished Mountpoints Configured in the Real Root. machine # [ 3.247205] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies. machine # [ 3.260800] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. machine # [ 3.264149] systemd[1]: Finished rw-sysroot-nix-store.service. machine # [ 3.683006] ata4: SATA link down (SStatus 0 SControl 300) machine # [ 3.687637] ata5: SATA link down (SStatus 0 SControl 300) machine # [ 3.691695] ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 300) machine # [ 3.696369] ata3.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/100 machine # [ 3.699896] ata3.00: applying bridge limits machine # [ 3.703818] ata2: SATA link down (SStatus 0 SControl 300) machine # [ 3.708157] ata6: SATA link down (SStatus 0 SControl 300) machine # [ 3.712184] ata1: SATA link down (SStatus 0 SControl 300) machine # [ 3.716800] ata3.00: configured for UDMA/100 machine # [ 3.721236] scsi 2:0:0:0: CD-ROM QEMU QEMU DVD-ROM 2.5+ PQ: 0 ANSI: 5 machine # [ 3.483992] systemd[1]: Mounted /sysroot/nix/.ro-store. machine # [ 3.773409] usbcore: registered new interface driver usbhid machine # [ 3.777585] usbhid: USB HID core driver machine # [ 3.788069] 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 # [ 3.791020] 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 # [ 3.794799] sr 2:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray machine # [ 3.805710] cdrom: Uniform CD-ROM driver Revision: 3.20 machine # [ 3.806973] systemd[1]: Mounting /sysroot/nix/store... machine # [ 3.857390] systemd[1]: Mounted /sysroot/nix/store. machine # [ 3.859601] systemd[1]: Reached target Initrd File Systems. machine # [ 3.863101] systemd[1]: Starting Find NixOS closure... machine # [ 3.866466] systemd[1]: Starting Create Volatile Files and Directories in the Real Root... machine # [ 3.888652] systemd[1]: Finished Create Volatile Files and Directories in the Real Root. machine # [ 3.893855] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully. machine # [ 3.902683] systemd[1]: Finished Find NixOS closure. machine # [ 3.904819] systemd[1]: Reached target Initrd Default Target. machine # [ 3.907375] systemd[1]: Starting Cleaning Up and Shutting Down Daemons... machine # [ 3.923588] systemd[1]: Stopped target Initrd Default Target. machine # [ 3.925696] systemd[1]: Stopped target Basic System. machine # [ 3.928231] systemd[1]: Stopped target Initrd Root Device. machine # [ 3.929748] systemd[1]: Stopped target Path Units. machine # [ 3.931300] systemd[1]: systemd-ask-password-console.path: Deactivated successfully. machine # [ 3.933607] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch. machine # [ 3.936343] systemd[1]: Stopped target Slice Units. machine # [ 3.938258] systemd[1]: Stopped target Socket Units. machine # [ 3.940299] systemd[1]: Stopped target System Initialization. machine # [ 3.942190] systemd[1]: Stopped target Swaps. machine # [ 3.944432] systemd[1]: Stopped target Timer Units. machine # [ 3.945827] systemd[1]: dbus.socket: Deactivated successfully. machine # [ 3.947440] systemd[1]: Closed D-Bus System Message Bus Socket. machine # [ 3.950219] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully. machine # [ 3.952238] systemd[1]: Stopped Find NixOS closure. machine # [ 3.953759] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio machine # [ 3.957228] systemd[1]: Starting rw-sysroot-nix-store.service... machine # [ 3.958874] systemd[1]: systemd-sysctl.service: Deactivated successfully. machine # [ 3.961219] systemd[1]: Stopped Apply Kernel Variables. machine # [ 3.962697] systemd[1]: systemd-modules-load.service: Deactivated successfully. machine # [ 3.965213] systemd[1]: Stopped Load Kernel Modules. machine # [ 3.967342] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully. machine # [ 3.969392] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root. machine # [ 3.972203] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. machine # [ 3.974162] systemd[1]: Stopped Create System Files and Directories. machine # [ 3.975830] systemd[1]: Stopped target Local File Systems. machine # [ 3.978216] systemd[1]: Stopped target Preparation for Local File Systems. machine # [ 3.981259] systemd[1]: systemd-udev-trigger.service: Deactivated successfully. machine # [ 3.983234] systemd[1]: Stopped Coldplug All udev Devices. machine # [ 3.985766] systemd[1]: Stopping Rule-based Manager for Device Events and Files... machine # [ 3.988534] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. machine # [ 3.990449] systemd[1]: Stopped Virtual Console Setup. machine # [ 4.003534] systemd[1]: initrd-cleanup.service: Deactivated successfully. machine # [ 4.006381] systemd[1]: Finished Cleaning Up and Shutting Down Daemons. machine # [ 4.012284] systemd[1]: systemd-udevd.service: Deactivated successfully. machine # [ 4.014994] systemd[1]: Stopped Rule-based Manager for Device Events and Files. machine # [ 4.017886] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. machine # [ 4.020551] systemd[1]: Finished rw-sysroot-nix-store.service. machine # [ 4.027228] systemd[1]: Starting Cleanup udev Database... machine # [ 4.029260] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. machine # [ 4.031820] systemd[1]: Stopped Create Static Device Nodes in /dev. machine # [ 4.033507] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. machine # [ 4.037224] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully. machine # [ 4.039200] systemd[1]: kmod-static-nodes.service: Deactivated successfully. machine # [ 4.041075] systemd[1]: Stopped Create List of Static Device Nodes. machine # [ 4.056622] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. machine # [ 4.059562] systemd[1]: Finished Cleanup udev Database. machine # [ 4.061881] systemd[1]: Reached target Switch Root. machine # [ 4.064632] systemd[1]: Starting NixOS Activation... machine # [ 4.255364] initrd-nixos-activation-start[195]: booting system configuration /nix/store/2dxnd94gq2rrl2zizlyqygf5kr8skfrz-nixos-system-machine-test machine # [ 4.329241] initrd-nixos-activation-start[195]: running activation script... machine # [ 4.812685] initrd-nixos-activation-start[218]: setting up /etc... machine # [ 5.100258] systemd[1]: initrd-nixos-activation.service: Deactivated successfully. machine # [ 5.102307] systemd[1]: Finished NixOS Activation. machine # [ 5.104858] systemd[1]: Starting Switch Root... machine # [ 5.120581] systemd[1]: Switching root. machine # [ 5.505578] systemd-journald[67]: Received SIGTERM from PID 1 (systemd). machine # [ 5.648490] NET: Registered PF_VSOCK protocol family machine # [ 6.038698] systemd[1]: systemd 262-726e17a 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 # [ 6.057272] systemd[1]: Detected virtualization kvm. machine # [ 6.060695] systemd[1]: Detected architecture x86-64. machine # [ 6.064014] systemd[1]: Detected first boot. machine # [ 6.073693] systemd[1]: Initializing machine ID from random generator. machine # [ 6.200087] systemd[1]: bpf-restrict-fs: LSM BPF program attached machine # [ 6.351428] systemd[1]: Applying preset policy. machine # [ 6.912920] systemd[1]: Populated /etc with preset unit settings. machine # [ 7.477226] systemd[1]: initrd-switch-root.service: Deactivated successfully. machine # [ 7.479878] systemd[1]: Stopped initrd-switch-root.service. machine # [ 7.483616] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. machine # [ 7.487146] systemd[1]: Created slice Slice /system/getty. machine # [ 7.489284] systemd[1]: Created slice User and Session Slice. machine # [ 7.491119] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. machine # [ 7.493257] systemd[1]: Started Forward Password Requests to Wall Directory Watch. machine # [ 7.495182] systemd[1]: Expecting device /dev/hvc0... machine # [ 7.509049] systemd[1]: Expecting device /dev/ttyS0... machine # [ 7.510483] systemd[1]: Reached target Local Encrypted Volumes. machine # [ 7.512050] systemd[1]: Stopped target initrd-fs.target. machine # [ 7.513422] systemd[1]: Stopped target initrd-root-fs.target. machine # [ 7.514909] systemd[1]: Stopped target initrd-switch-root.target. machine # [ 7.516601] systemd[1]: Reached target Virtual Machines and Containers. machine # [ 7.518261] systemd[1]: Reached target Path Units. machine # [ 7.519600] systemd[1]: Reached target Remote File Systems. machine # [ 7.521103] systemd[1]: Reached target Slice Units. machine # [ 7.522456] systemd[1]: Reached target Swaps. machine # [ 7.526390] systemd[1]: Listening on Query the User Interactively for a Password. machine # [ 7.531267] systemd[1]: Listening on Process Core Dump Socket. machine # [ 7.534809] systemd[1]: Listening on Credential Encryption/Decryption. machine # [ 7.538490] systemd[1]: Listening on Factory Reset Management. machine # [ 7.540179] systemd[1]: Listening on Hostname Service Socket. machine # [ 7.544965] systemd[1]: Starting Journal Log Access Socket... machine # [ 7.547480] systemd[1]: Listening on Journal Audit Socket. machine # [ 7.551247] systemd[1]: Listening on Console Output Muting Service Socket. machine # [ 7.553634] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket. machine # [ 7.555923] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 7.558206] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 7.569914] systemd[1]: Listening on Disk Repartitioning Service Socket. machine # [ 7.571801] systemd[1]: Listening on udev Varlink Socket. machine # [ 7.576636] systemd[1]: Mounting Huge Pages File System... machine # [ 7.581214] systemd[1]: Mounting POSIX Message Queue File System... machine # [ 7.589323] systemd[1]: Mounting Kernel Debug File System... machine # [ 7.596729] systemd[1]: Mounting Kernel Trace File System... machine # [ 7.604362] systemd[1]: Starting Create List of Static Device Nodes... machine # [ 7.610142] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio machine # [ 7.622450] systemd[1]: Starting Load Kernel Module configfs... machine # [ 7.624656] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm machine # [ 7.627414] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 7.630560] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse machine # [ 7.669495] systemd[1]: Mounting FUSE Control File System... machine # [ 7.671750] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 7.708892] systemd[1]: Starting Journal Service... machine # [ 7.722286] systemd[1]: Starting Load Kernel Modules... machine # [ 7.738652] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer... machine # [ 7.752668] systemd[1]: Starting Remount Root and Kernel File Systems... machine # [ 7.762099] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 7.781427] systemd[1]: Starting Coldplug All udev Devices... machine # [ 7.786553] systemd-journald[289]: Collecting audit messages is enabled. machine # [ 7.811010] systemd[1]: Listening on Journal Log Access Socket. machine # [ 7.822840] systemd[1]: Mounted Huge Pages File System. machine # [ 7.830328] systemd[1]: Mounted POSIX Message Queue File System. machine # [ 7.839881] systemd[1]: Mounted Kernel Debug File System. machine # [ 7.842774] loop: module loaded machine # [ 7.846816] EXT4-fs (vda): re-mounted fea9d831-8ed2-495d-8b65-e7e93bacb6c7. machine # [ 7.849963] systemd[1]: Mounted Kernel Trace File System. machine # [ 7.593865] systemd[1]: Queued start job for default target Multi-User System. machine # [ 7.600819] systemd[1]: systemd-journald.service: Deactivated successfully. machine # [ 7.605779] systemd-modules-load[290]: Inserted module 'loop'[ 7.865973] systemd[1]: Started Journal Service. machine # machine # [ 7.618795] systemd[1]: Finished Create List of Static Device Nodes. machine # [ 7.624244] systemd[1]: modprobe@configfs.service: Deactivated successfully. machine # [ 7.630379] systemd[1]: Finished Load Kernel Module configfs. machine # [ 7.632175] systemd[1]: Mounted FUSE Control File System. machine # [ 7.636506] systemd[1]: Finished Load Kernel Modules. machine # [ 7.641124] systemd[1]: Finished Remount Root and Kernel File Systems. machine # [ 7.662317] systemd[1]: Listening on Disk Image Download Service Socket. machine # [ 7.671180] systemd[1]: Mounting Kernel Configuration File System... machine # [ 7.677321] systemd-oomd[292]: No swap; memory pressure usage will be degraded machine # [ 7.684150] systemd[1]: Starting Firewall... machine # [ 7.698113] systemd[1]: Starting Flush Journal to Persistent Storage... machine # [ 7.699918] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 7.709278] systemd[1]: Starting Load/Save OS Random Seed... machine # [ 7.722956] systemd[1]: Starting Apply Kernel Variables... machine # [ 7.738877] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... machine # [ 7.743962] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 7.747708] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer. machine # [ 8.056823] systemd-journald[289]: Received client request to flush runtime journal. machine # [ 8.061571] systemd[1]: Mounted Kernel Configuration File System. machine # [ 8.067206] systemd[1]: Finished Load/Save OS Random Seed. machine # [ 8.070448] systemd[1]: Reached target First Boot Complete. machine # [ 8.073874] systemd[1]: Finished Apply Kernel Variables. machine # [ 8.076700] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. machine # [ 8.079697] systemd[1]: Starting Create Static Device Nodes in /dev... machine # [ 8.082217] systemd[1]: Finished Create Static Device Nodes in /dev. machine # [ 8.085208] systemd[1]: Reached target Preparation for Local File Systems. machine # [ 8.089183] systemd[1]: Starting Rule-based Manager for Device Events and Files... machine # [ 8.091195] systemd[1]: Finished Flush Journal to Persistent Storage. machine # [ 8.187950] systemd[1]: Finished Coldplug All udev Devices. machine # [ 8.194476] systemd-udevd[328]: Using default interface naming scheme 'v261'. machine # [ 8.223245] systemd[1]: Mounting /run/wrappers... machine # [ 8.262184] systemd[1]: Mounted /run/wrappers. machine # [ 8.263633] systemd[1]: Reached target Local File Systems. machine # [ 8.268171] systemd[1]: Listening on Boot Loader Control Service Socket. machine # [ 8.274173] systemd[1]: Starting register-nix-paths.service... machine # [ 8.280111] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 8.282483] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 8.290524] systemd[1]: Starting Save Transient machine-id to Disk... machine # [ 8.302621] systemd[1]: Starting Create System Files and Directories... machine # [ 8.378142] systemd[1]: etc-machine\x2did.mount: Deactivated successfully. machine # [ 8.389937] systemd[1]: Finished Save Transient machine-id to Disk. machine # [ 8.446115] systemd[1]: Started Rule-based Manager for Device Events and Files. machine # [ 8.462657] systemd[1]: Finished Create System Files and Directories. machine # [ 8.477178] systemd[1]: Starting Rebuild Journal Catalog... machine # [ 8.483748] systemd[1]: Starting Record System Boot/Shutdown in UTMP... machine # [ 8.580948] systemd[1]: Finished Record System Boot/Shutdown in UTMP. machine # [ 8.639749] systemd[1]: Finished Rebuild Journal Catalog. machine # [ 8.649736] systemd[1]: Starting Update is Completed... machine # [ 8.707496] systemd[1]: Finished Update is Completed. machine # [ 8.934758] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 8.939107] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 8.989697] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse machine # [ 9.161868] systemd[1]: Condition check resulted in /dev/hvc0 being skipped. machine # [ 9.240741] systemd[1]: Condition check resulted in /dev/ttyS0 being skipped. machine # [ 9.301322] (udev-worker)[433]: Network interface NamePolicy= disabled on kernel command line. machine # [ 9.307175] (udev-worker)[435]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. machine # [ 9.312163] (udev-worker)[435]: Network interface NamePolicy= disabled on kernel command line. machine # [ 9.346675] systemd[1]: Finished register-nix-paths.service. machine # [ 9.356732] systemd[1]: Reached target System Initialization. machine # [ 9.360461] systemd[1]: Started Discard unused filesystem blocks once a week. machine # [ 9.362437] systemd[1]: Started Daily Cleanup of Temporary Directories. machine # [ 9.365279] systemd[1]: Reached target Timer Units. machine # [ 9.367358] systemd[1]: Listening on D-Bus System Message Bus Socket. machine # [ 9.370307] systemd[1]: Listening on Nix Daemon Socket. machine # [ 9.373793] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket. machine # [ 9.377129] systemd[1]: Reached target Socket Units. machine # [ 9.378695] systemd[1]: Reached target Basic System. machine # [ 9.383198] systemd[1]: Started backdoor.service. machine # [ 9.391455] systemd[1]: Starting Import lastlog data into lastlog2 database... machine # [ 9.408323] systemd[1]: Starting Name Service Cache Daemon (nsncd)... machine # [ 9.422138] systemd[1]: Starting Post-Boot Actions... machine # [ 9.448659] systemd[1]: Started Reset console on configuration changes. machine # [ 9.477901] systemd[1]: Starting resolvconf update... machine # [ 9.517253] systemd[1]: Finished Firewall. machine # connecting to host... machine # [ 9.562420] systemd[1]: Starting D-Bus System Message Bus... machine # [ 9.571510] systemd[1]: Finished Post-Boot Actions. machine: Guest shell says: b'Spawning backdoor root shell...\n' machine # [ 9.589921] nsncd[496]: Sep 06 06:55:12.334 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" machine: connected to guest root shell machine # [ 9.596828] systemd[1]: Started Name Service Cache Daemon (nsncd). machine: (connecting took 10.61 seconds) machine: (finished: waiting for the VM to finish booting, in 10.99 seconds) machine # [ 9.614766] systemd[1]: Finished Import lastlog data into lastlog2 database. machine # [ 9.625649] systemd[1]: Reached target Host and Network Name Lookups. machine # [ 9.627535] systemd[1]: Reached target User and Group Name Lookups. machine # [ 9.646246] systemd[1]: Starting User Login Management... machine # [ 9.653174] systemd[1]: Condition check resulted in Virtio network device being skipped. machine # [ 9.771274] dbus-broker-launch[514]: Looking up NSS user entry for 'systemd-timesync'... machine # [ 9.831275] systemd-logind[533]: New seat seat0. machine # [ 9.836099] systemd[1]: Started User Login Management. machine # [ 9.846263] dbus-broker-launch[514]: NSS returned no entry for 'systemd-timesync' machine # [ 9.850099] dbus-broker-launch[514]: Invalid user-name in /nix/store/x4zwiaf3w1x4nsqhilx4ijpmfcg95zha-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" machine # [ 9.854473] systemd[1]: Stopped target Host and Network Name Lookups. machine # [ 9.857928] systemd[1]: Stopping Host and Network Name Lookups... machine # [ 9.860588] systemd[1]: Stopped target User and Group Name Lookups. machine # [ 9.864231] systemd[1]: Stopping User and Group Name Lookups... machine # [ 9.869457] systemd[1]: Starting linger-users.service... machine # [ 9.872848] systemd[1]: Stopping Name Service Cache Daemon (nsncd)... machine # [ 9.882101] systemd[1]: nscd.service: Deactivated successfully. machine # [ 9.891722] systemd[1]: Stopped Name Service Cache Daemon (nsncd). machine # [ 9.917691] systemd[1]: Started D-Bus System Message Bus. machine # [ 9.942897] systemd[1]: Starting Name Service Cache Daemon (nsncd)... machine # [ 9.968520] dbus-broker-launch[514]: Ready machine # [ 10.023309] systemd[1]: Started Name Service Cache Daemon (nsncd). machine # [ 10.025942] nsncd[594]: Sep 06 06:55:12.776 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" machine # [ 10.032504] systemd[1]: Finished resolvconf update. machine # [ 10.058860] systemd[1]: Created slice Slice /user/1001. machine # [ 10.060988] systemd[1]: Reached target Preparation for Network. machine # [ 10.066395] systemd[1]: Reached target Host and Network Name Lookups. machine # [ 10.075425] systemd[1]: Reached target User and Group Name Lookups. machine # [ 10.080116] systemd[1]: Starting DHCP Client... machine # [ 10.345475] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input3 machine # [ 10.352380] bochs-drm 0000:00:01.0: vgaarb: deactivate vga console machine # [ 10.095990] systemd[1]: Starting Address configuration of eth1... machine # [ 10.102714] systemd[1]: Starting Extra networking commands.... machine # [ 10.124221] systemd[1]: Starting User Runtime Directory /run/user/1001... machine # [ 10.126682] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 10.142641] systemd[1]: Finished linger-users.service. machine # [ 10.403648] mousedev: PS/2 mouse device common for all mice machine # [ 10.283665] systemd[1]: Finished User Runtime Directory /run/user/1001. machine # [ 10.300137] systemd[1]: Starting User Manager for UID 1001... machine # [ 10.423941] ACPI: button: Power Button [PWRF] machine # [ 10.514980] rtc_cmos 00:04: RTC can wake from S4 machine # [ 10.557319] rtc_cmos 00:04: registered as rtc0 machine # [ 10.558000] rtc_cmos 00:04: setting system clock to 2026-09-06T06:55:13 UTC (1788677713) machine # [ 10.558181] rtc_cmos 00:04: alarms up to one day, y3k, 242 bytes nvram, hpet irqs machine # [ 10.564034] parport_pc 00:02: reported by Plug and Play ACPI machine # [ 10.564180] parport0: PC-style at 0x378, irq 7 [PCSPP(,...)] machine # [ 10.581692] input: QEMU Virtio Keyboard as /devices/pci0000:00/0000:00:09.0/virtio7/input/input4 machine # [ 10.582590] Console: switching to colour dummy device 80x25 machine # [ 10.434203] (systemd)[621]: pam_unix(systemd-user:session): session opened for user usertest(uid=1001) by (uid=0) machine # [ 10.653226] lpc_ich 0000:00:1f.0: I/O space for GPIO uninitialized machine # [ 10.714348] [drm] Found bochs VGA, ID 0xb0c5. machine # [ 10.714351] [drm] Framebuffer size 16384 kB @ 0xfd000000, mmio @ 0xfebd0000. machine # [ 10.464489] systemd-logind[533]: New session '1' of user 'usertest' with class 'manager' and type 'unspecified'. machine # [ 10.736943] bochs-drm 0000:00:01.0: [drm] Registered 1 planes with drm panic machine # [ 10.738373] [drm] Initialized bochs-drm 1.0.0 for 0000:00:01.0 on minor 0 machine # [ 10.781584] i801_smbus 0000:00:1f.3: SMBus using PCI interrupt machine # [ 10.782827] i2c i2c-0: Memory type 0x07 not supported yet, not instantiating SPD machine # [ 10.526390] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 10.863298] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input6 machine # [ 10.865357] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input5 machine # [ 11.003020] Console: switching to colour frame buffer device 160x50 machine # [ 11.040957] bochs-drm 0000:00:01.0: [drm] fb0: bochs-drmdrmfb frame buffer device machine # [ 10.786821] network-addresses-eth1-start[613]: adding address 192.168.1.1/24... done machine # [ 10.818621] network-addresses-eth1-start[613]: adding address 2001:db8:1::1/64... done machine # [ 10.861376] systemd[1]: Starting Virtual Console Setup... machine # [ 10.883343] systemd[621]: Queued start job for default target Main User Target. machine # [ 10.896251] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 10.912062] systemd[621]: Created slice User Application Slice. machine # [ 10.935458] systemd[621]: Started Daily Cleanup of User's Temporary Directories. machine # [ 10.971710] systemd[621]: Reached target Paths. machine # [ 10.998517] systemd[621]: Reached target Timers. machine # [ 11.016413] systemd[621]: Starting D-Bus User Message Bus Socket... machine # [ 11.023113] systemd[1]: Finished Address configuration of eth1. machine # [ 11.029229] systemd[621]: Starting Create User Files and Directories... machine # [ 11.034547] systemd[621]: Finished Create User Files and Directories. machine # [ 11.045762] systemd[621]: Listening on D-Bus User Message Bus Socket. machine # [ 11.052818] systemd[621]: Reached target Sockets. machine # [ 11.061550] systemd[621]: Reached target Basic System. machine # [ 11.063119] systemd[1]: Started User Manager for UID 1001. machine # [ 11.064623] systemd[621]: Starting Run user-specific NixOS activation... machine # [ 11.326543] ppdev: user-space parallel port driver machine # [ 11.080693] systemd-logind[533]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard) machine # [ 11.093172] systemd-logind[533]: Watching system buttons on /dev/input/event2 (Power Button) machine # [ 11.107494] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. machine # [ 11.111995] systemd[1]: Stopped Virtual Console Setup. machine # [ 11.116224] systemd[1]: Starting Virtual Console Setup... machine # [ 11.126294] systemd[621]: Finished Run user-specific NixOS activation. machine # [ 11.129810] systemd[621]: Reached target Main User Target. machine # [ 11.394783] iTCO_wdt iTCO_wdt.1.auto: Found a ICH9 TCO device (Version=2, TCOBASE=0x0660) machine # [ 11.143723] systemd[621]: Startup finished in 510ms. machine # [ 11.145285] systemd-logind[533]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard) machine # [ 11.434751] iTCO_wdt iTCO_wdt.1.auto: initialized. heartbeat=30 sec (nowayout=0) machine # [ 11.213242] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. machine # [ 11.218221] systemd[1]: Stopped Virtual Console Setup. machine # [ 11.227674] systemd[1]: Starting Virtual Console Setup... machine # [ 11.319433] systemd[1]: Finished Extra networking commands.. machine # [ 11.324254] systemd[1]: Reached target Network. machine # [ 11.332441] dhcpcd[629]: dhcpcd-10.3.2 starting machine # [ 11.337807] systemd[1]: Starting Permit User Sessions... machine # [ 11.377994] dhcpcd[717]: dev: loaded udev machine # [ 11.411228] systemd[1]: Finished Permit User Sessions. machine # [ 11.673274] 8021q: 802.1Q VLAN Support v1.8 machine # [ 11.675177] 8021q: adding VLAN 0 to HW filter on device eth1 machine # [ 11.420246] systemd[1]: Started Getty on tty1. machine # [ 11.424314] systemd[1]: Reached target Login Prompts. machine # [ 11.745156] kvm_amd: TSC scaling supported machine # [ 11.754891] kvm_amd: Nested Virtualization enabled machine # [ 11.759568] kvm_amd: Nested Paging enabled machine # [ 11.760464] kvm_amd: LBR virtualization supported machine # [ 11.508397] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch. machine # [ 11.770939] kvm_amd: Virtual VMLOAD VMSAVE supported machine # [ 11.773557] kvm_amd: Virtual GIF supported machine # [ 11.774414] kvm_amd: Virtual NMI enabled machine # [ 11.805241] cfg80211: Loading compiled-in X.509 certificates for regulatory database machine # [ 11.844291] EDAC MC: Ver: 3.0.0 machine # [ 11.846899] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' machine # [ 11.849093] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600' machine # [ 11.854574] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -2 machine # [ 11.856255] cfg80211: failed to load regulatory.db machine # [ 11.927640] 8021q: adding VLAN 0 to HW filter on device eth0 machine # [ 11.671521] dhcpcd[717]: eth0: waiting for carrier machine # [ 11.673434] dhcpcd[717]: eth0: carrier acquired machine # [ 11.687366] dhcpcd[717]: DUID 00:01:00:01:32:2f:ca:d2:52:54:00:12:34:56 machine # [ 11.689427] dhcpcd[717]: eth0: IAID 00:12:34:56 machine # [ 11.691185] dhcpcd[717]: eth0: adding address fe80::5054:ff:fe12:3456 machine # [ 11.962845] systemd-vconsole-setup[702]: Configuration of first virtual console was skipped, ignoring remaining ones. machine # [ 11.969968] systemd[1]: Finished Virtual Console Setup. machine # [ 13.353941] dhcpcd[717]: eth0: soliciting a DHCP lease machine # [ 13.644032] NET: Registered PF_PACKET protocol family machine # [ 13.395305] dhcpcd[717]: eth0: offered 10.0.2.15 from 10.0.2.2 machine # [ 13.402598] dhcpcd[717]: eth0: probing address 10.0.2.15/24 machine # [ 13.982549] dhcpcd[717]: eth0: soliciting an IPv6 router machine # [ 13.984420] dhcpcd[717]: eth0: Router Advertisement from fe80::2 machine # [ 13.986530] dhcpcd[717]: eth0: adding address fec0::5054:ff:fe12:3456/64 machine # [ 13.988284] dhcpcd[717]: eth0: adding route to fec0::/64 machine # [ 13.989871] dhcpcd[717]: eth0: adding default route via fe80::2 machine # [ 18.361940] dhcpcd[717]: eth0: leased 10.0.2.15 for 86400 seconds machine # [ 18.368187] dhcpcd[717]: eth0: adding route to 10.0.2.0/24 machine # [ 18.372543] dhcpcd[717]: eth0: adding default route via 10.0.2.2 machine # [ 18.503329] systemd[1]: Started DHCP Client. machine # [ 18.506533] systemd[1]: Reached target Multi-User System. machine # [ 18.508494] systemd[1]: Startup finished in 1.072s (kernel) + 4.248s (initrd) + 13.185s (userspace) = 18.506s. machine: (finished: waiting for unit multi-user.target, in 20.46 seconds) machine: must succeed: /nix/store/w1psanxc52jqfm0knzrj6gw0pz8my68n-stderr-runner /nix/store/2dxnd94gq2rrl2zizlyqygf5kr8skfrz-nixos-system-machine-test/bin/switch-to-configuration test machine # Checking switch inhibitors... done machine # [ 19.732378] nixos[868]: switching to system configuration /nix/store/2dxnd94gq2rrl2zizlyqygf5kr8skfrz-nixos-system-machine-test machine # [ 19.737393] systemd[1]: Stopped target Remote File Systems. machine # [ 19.739915] systemd[1]: Stopped target Local File Systems. machine # activating the configuration... machine # setting up /etc... machine # [ 20.145062] systemd[1]: Reload requested from client PID 868 ('.switch-to-conf') (unit backdoor.service)... machine # [ 20.147988] systemd[1]: Reloading... machine # [ 20.770073] systemd[1]: Reloading finished in 619 ms. machine # reloading user units for usertest... machine # [ 20.814375] systemd[621]: Created slice User Core Session Slice. machine # [ 20.818210] systemd[621]: Starting D-Bus User Message Bus... machine # [ 20.880942] dbus-broker-launch[938]: Ignoring duplicate name 'org.freedesktop.import1' in service file '/nix/store/x4zwiaf3w1x4nsqhilx4ijpmfcg95zha-system-path/share/dbus-1/services/org.freedesktop.import1.service' machine # [ 20.886083] dbus-broker-launch[938]: Ignoring duplicate name 'org.freedesktop.machine1' in service file '/nix/store/x4zwiaf3w1x4nsqhilx4ijpmfcg95zha-system-path/share/dbus-1/services/org.freedesktop.machine1.service' machine # [ 20.890959] dbus-broker-launch[938]: Ignoring duplicate name 'org.freedesktop.portable1' in service file '/nix/store/x4zwiaf3w1x4nsqhilx4ijpmfcg95zha-system-path/share/dbus-1/services/org.freedesktop.portable1.service' machine # [ 20.896405] dbus-broker-launch[938]: Ignoring duplicate name 'org.freedesktop.systemd1' in service file '/nix/store/x4zwiaf3w1x4nsqhilx4ijpmfcg95zha-system-path/share/dbus-1/services/org.freedesktop.systemd1.service' machine # [ 20.902257] dbus-broker-launch[938]: Policy to allow eavesdropping in /etc/dbus-1/session.conf +27: Eavesdropping is deprecated and ignored machine # [ 20.905900] dbus-broker-launch[938]: Policy to allow eavesdropping in /etc/dbus-1/session.conf +29: Eavesdropping is deprecated and ignored machine # [ 20.908873] systemd[621]: Started D-Bus User Message Bus. machine # [ 20.920936] dbus-broker-launch[938]: Ready machine # [ 21.043929] systemd[621]: Reexecution requested from client PID 937 ('switch-to-confi')... machine # [ 21.048145] systemd[621]: Reexecuting. machine # [ 21.075860] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 21.264350] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 21.273095] systemd[621]: Reload requested from client PID 937 ('switch-to-confi')... machine # [ 21.275904] systemd[621]: Reloading... machine # [ 21.447747] systemd[621]: Reloading finished in 169 ms. machine # [ 21.454042] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # restarting the following user units: nixos-activation.service machine # [ 21.466103] systemd[621]: Stopped Run user-specific NixOS activation. machine # [ 21.467868] systemd[621]: Stopping Run user-specific NixOS activation... machine # [ 21.472751] systemd[621]: Starting Run user-specific NixOS activation... machine # [ 21.514641] systemd[621]: Finished Run user-specific NixOS activation. machine # restarting sysinit-reactivation.target machine # [ 21.532764] systemd[1]: Starting Re-setup tmpfiles on a system that is already running.... machine # [ 21.676649] systemd[1]: Finished Re-setup tmpfiles on a system that is already running.. machine # [ 21.680336] systemd[1]: Reached target Reactivate sysinit units. machine # [ 21.690807] systemd[1]: Reached target Local File Systems. machine # [ 21.693521] systemd[1]: Reached target Remote File Systems. machine # [ 21.696158] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 21.701226] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 21.702886] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 21.707220] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 21.711841] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 21.717185] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 21.720528] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 21.727522] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 21.730462] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 22.036578] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 22.039399] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 22.045477] systemd[1]: Starting linger-users.service... machine # [ 22.100285] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 22.104471] systemd[1]: Finished linger-users.service. machine # the following new units were started: sysinit-reactivation.target, systemd-tmpfiles-resetup.service machine # [ 22.369911] nixos[868]: finished switching to system configuration /nix/store/2dxnd94gq2rrl2zizlyqygf5kr8skfrz-nixos-system-machine-test machine: (finished: must succeed: /nix/store/w1psanxc52jqfm0knzrj6gw0pz8my68n-stderr-runner /nix/store/2dxnd94gq2rrl2zizlyqygf5kr8skfrz-nixos-system-machine-test/bin/switch-to-configuration test, in 3.31 seconds) machine: must succeed: rm /etc/NIXOS machine: (finished: must succeed: rm /etc/NIXOS, in 0.05 seconds) machine: must succeed: /nix/store/w1psanxc52jqfm0knzrj6gw0pz8my68n-stderr-runner /nix/store/qmpapn8pprx3vf9jsmvnai79alk6wk18-nixos-system-other-test/bin/switch-to-configuration test machine # this should succeed (config: /nix/store/qmpapn8pprx3vf9jsmvnai79alk6wk18-nixos-system-other-test, action: test) machine # Checking switch inhibitors... done machine # [ 23.185418] nixos[1016]: switching to system configuration /nix/store/qmpapn8pprx3vf9jsmvnai79alk6wk18-nixos-system-other-test machine # [ 23.189731] systemd[1]: Stopped target Remote File Systems. machine # [ 23.192776] systemd[1]: Stopped target Local File Systems. machine # activating the configuration... machine # removing user ‘usertest’ machine # setting up /etc... machine # [ 23.702928] systemd[1]: Reload requested from client PID 1016 ('.switch-to-conf') (unit backdoor.service)... machine # [ 23.706181] systemd[1]: Reloading... machine # [ 24.320245] systemd[1]: Reloading finished in 611 ms. machine # reloading user units for usertest... machine # [ 24.502449] systemd[621]: Reexecution requested from client PID 1087 ('switch-to-confi')... machine # [ 24.506430] systemd[621]: Reexecuting. machine # [ 24.533864] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 24.702876] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 24.711147] systemd[621]: Reload requested from client PID 1087 ('switch-to-confi')... machine # [ 24.713704] systemd[621]: Reloading... machine # [ 24.884610] systemd[621]: Reloading finished in 168 ms. machine # [ 24.890063] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # restarting the following user units: nixos-activation.service machine # [ 24.902431] systemd[621]: Stopped Run user-specific NixOS activation. machine # [ 24.905308] systemd[621]: Stopping Run user-specific NixOS activation... machine # [ 24.909235] systemd[621]: Starting Run user-specific NixOS activation... machine # [ 24.953202] systemd[621]: Finished Run user-specific NixOS activation. machine # restarting sysinit-reactivation.target machine # [ 24.959520] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 24.961706] systemd[1]: Stopping Reactivate sysinit units... machine # reloading the following units: dbus-broker.service machine # [ 24.964987] systemd[1]: Reached target Reactivate sysinit units. machine # [ 24.968837] dbus-broker-launch[514]: Caught SIGHUP, trigger reload. machine # [ 24.971463] systemd[1]: Reloading D-Bus System Message Bus... machine # [ 24.996059] dbus-broker-launch[514]: Looking up NSS user entry for 'systemd-timesync'... machine # [ 24.999462] dbus-broker-launch[514]: NSS returned no entry for 'systemd-timesync' machine # [ 25.001526] dbus-broker-launch[514]: Invalid user-name in /nix/store/398bjg17dijf88n1242vy7g2abgrnfcp-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" machine # [ 25.029382] systemd[1]: Reloaded D-Bus System Message Bus. machine # restarting the following units: network-addresses-eth1.service machine # [ 25.038346] systemd[1]: Stopping Address configuration of eth1... machine # [ 25.084733] network-addresses-eth1-pre-stop[1100]: deleting address 192.168.1.1/24... done machine # [ 25.098491] network-addresses-eth1-pre-stop[1100]: deleting address 2001:db8:1::1/64... done machine # [ 25.109736] systemd[1]: network-addresses-eth1.service: Deactivated successfully. machine # [ 25.112614] systemd[1]: Stopped Address configuration of eth1. machine # [ 25.118589] systemd[1]: Starting Address configuration of eth1... machine # [ 25.193614] network-addresses-eth1-start[1105]: adding address 192.168.1.2/24... done machine # [ 25.208805] network-addresses-eth1-start[1105]: adding address 2001:db8:1::2/64... done machine # [ 25.225591] systemd[1]: Finished Address configuration of eth1. machine # [ 25.235648] systemd[1]: Reached target Local File Systems. machine # [ 25.239498] systemd[1]: Reached target Remote File Systems. machine # [ 25.244610] systemd[1]: Starting linger-users.service... machine # [ 25.250401] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 25.256340] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 25.259056] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 25.261329] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 25.267281] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 25.272329] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 25.274682] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 25.283847] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 25.286198] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 25.332982] linger-users-start[1120]: id: ‘usertest’: no such user machine # [ 25.335620] linger-users-start[1116]: Removing linger for missing user usertest machine # [ 25.348260] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 25.350465] systemd[1]: Finished linger-users.service. machine # [ 25.673857] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 25.676710] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 25.937883] nixos[1016]: finished switching to system configuration /nix/store/qmpapn8pprx3vf9jsmvnai79alk6wk18-nixos-system-other-test machine: (finished: must succeed: /nix/store/w1psanxc52jqfm0knzrj6gw0pz8my68n-stderr-runner /nix/store/qmpapn8pprx3vf9jsmvnai79alk6wk18-nixos-system-other-test/bin/switch-to-configuration test, in 3.52 seconds) subtest: pre-switch checks machine: must succeed: /nix/store/w1psanxc52jqfm0knzrj6gw0pz8my68n-stderr-runner /nix/store/qmpapn8pprx3vf9jsmvnai79alk6wk18-nixos-system-other-test/bin/switch-to-configuration check machine # this should succeed (config: /nix/store/qmpapn8pprx3vf9jsmvnai79alk6wk18-nixos-system-other-test, action: check) machine # Checking switch inhibitors... done machine: (finished: must succeed: /nix/store/w1psanxc52jqfm0knzrj6gw0pz8my68n-stderr-runner /nix/store/qmpapn8pprx3vf9jsmvnai79alk6wk18-nixos-system-other-test/bin/switch-to-configuration check, in 0.08 seconds) machine: must fail: /nix/store/qmpapn8pprx3vf9jsmvnai79alk6wk18-nixos-system-other-test/specialisation/failingCheck/bin/switch-to-configuration check 2>&1 machine: (finished: must fail: /nix/store/qmpapn8pprx3vf9jsmvnai79alk6wk18-nixos-system-other-test/specialisation/failingCheck/bin/switch-to-configuration check 2>&1, in 0.04 seconds) machine: must fail: /nix/store/qmpapn8pprx3vf9jsmvnai79alk6wk18-nixos-system-other-test/specialisation/failingMidCheck/bin/switch-to-configuration check 2>&1 machine: (finished: must fail: /nix/store/qmpapn8pprx3vf9jsmvnai79alk6wk18-nixos-system-other-test/specialisation/failingMidCheck/bin/switch-to-configuration check 2>&1, in 0.04 seconds) (finished: subtest: pre-switch checks, in 0.17 seconds) subtest: switch inhibitors machine: must succeed: /nix/store/2dxnd94gq2rrl2zizlyqygf5kr8skfrz-nixos-system-machine-test/specialisation/no_inhibitors/bin/switch-to-configuration switch 2>&1 machine # [ 26.703516] nixos[1205]: switching to system configuration /nix/store/is88s9b0a0rkmqprq8zmzww9n80q35by-nixos-system-machine-test machine # [ 26.707859] systemd[1]: Stopped target Remote File Systems. machine # [ 26.710905] systemd[1]: Stopped target Local File Systems. machine # [ 27.182360] systemd[1]: Reload requested from client PID 1205 ('.switch-to-conf') (unit backdoor.service)... machine # [ 27.185224] systemd[1]: Reloading... machine # [ 27.778868] systemd[1]: Reloading finished in 590 ms. machine # [ 27.942089] systemd[621]: Reexecution requested from client PID 1275 ('switch-to-confi')... machine # [ 27.945901] systemd[621]: Reexecuting. machine # [ 27.973920] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 28.134223] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 28.143182] systemd[621]: Reload requested from client PID 1275 ('switch-to-confi')... machine # [ 28.147050] systemd[621]: Reloading... machine # [ 28.288388] systemd[621]: Reloading finished in 141 ms. machine # [ 28.294054] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 28.304834] systemd[621]: Stopped Run user-specific NixOS activation. machine # [ 28.306609] systemd[621]: Stopping Run user-specific NixOS activation... machine # [ 28.311610] systemd[621]: Starting Run user-specific NixOS activation... machine # [ 28.355245] systemd[621]: Finished Run user-specific NixOS activation. machine # [ 28.360835] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 28.362685] systemd[1]: Stopping Reactivate sysinit units... machine # [ 28.365713] systemd[1]: Reached target Reactivate sysinit units. machine # [ 28.368965] dbus-broker-launch[514]: Caught SIGHUP, trigger reload. machine # [ 28.370829] systemd[1]: Reloading D-Bus System Message Bus... machine # [ 28.383495] dbus-broker-launch[514]: Looking up NSS user entry for 'systemd-timesync'... machine # [ 28.386680] dbus-broker-launch[514]: NSS returned no entry for 'systemd-timesync' machine # [ 28.388580] dbus-broker-launch[514]: Invalid user-name in /nix/store/x4zwiaf3w1x4nsqhilx4ijpmfcg95zha-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" machine # [ 28.407946] systemd[1]: Reloaded D-Bus System Message Bus. machine # [ 28.414845] systemd[1]: Stopping Address configuration of eth1... machine # [ 28.452425] network-addresses-eth1-pre-stop[1288]: deleting address 192.168.1.2/24... done machine # [ 28.463786] network-addresses-eth1-pre-stop[1288]: deleting address 2001:db8:1::2/64... done machine # [ 28.472807] systemd[1]: network-addresses-eth1.service: Deactivated successfully. machine # [ 28.475627] systemd[1]: Stopped Address configuration of eth1. machine # [ 28.481134] systemd[1]: Starting Address configuration of eth1... machine # [ 28.544578] network-addresses-eth1-start[1293]: adding address 192.168.1.1/24... done machine # [ 28.556080] network-addresses-eth1-start[1293]: adding address 2001:db8:1::1/64... done machine # [ 28.570792] systemd[1]: Finished Address configuration of eth1. machine # [ 28.579608] systemd[1]: Reached target Local File Systems. machine # [ 28.583463] systemd[1]: Reached target Remote File Systems. machine # [ 28.589690] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 28.596528] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 28.599778] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 28.602867] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 28.607472] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 28.610721] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 28.614934] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 28.620201] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 28.622767] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 28.931566] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 28.935125] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 28.940426] systemd[1]: Starting linger-users.service... machine # [ 28.977829] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 28.981704] systemd[1]: Finished linger-users.service. machine # [ 29.240437] nixos[1205]: finished switching to system configuration /nix/store/is88s9b0a0rkmqprq8zmzww9n80q35by-nixos-system-machine-test machine: (finished: must succeed: /nix/store/2dxnd94gq2rrl2zizlyqygf5kr8skfrz-nixos-system-machine-test/specialisation/no_inhibitors/bin/switch-to-configuration switch 2>&1, in 3.14 seconds) machine: must succeed: /nix/store/2dxnd94gq2rrl2zizlyqygf5kr8skfrz-nixos-system-machine-test/specialisation/inhibitors/bin/switch-to-configuration switch 2>&1 machine # [ 29.852927] nixos[1362]: switching to system configuration /nix/store/4maakjccvixpy2wxm7rf3in1h4yyjcf2-nixos-system-machine-test machine # [ 29.858308] systemd[1]: Stopped target Local File Systems. machine # [ 29.860274] systemd[1]: Stopped target Remote File Systems. machine # [ 30.312276] systemd[1]: Reload requested from client PID 1362 ('.switch-to-conf') (unit backdoor.service)... machine # [ 30.315292] systemd[1]: Reloading... machine # [ 30.925135] systemd[1]: Reloading finished in 606 ms. machine # [ 31.095077] systemd[621]: Reexecution requested from client PID 1432 ('switch-to-confi')... machine # [ 31.099297] systemd[621]: Reexecuting. machine # [ 31.125493] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 31.285146] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 31.294113] systemd[621]: Reload requested from client PID 1432 ('switch-to-confi')... machine # [ 31.297233] systemd[621]: Reloading... machine # [ 31.457109] systemd[621]: Reloading finished in 157 ms. machine # [ 31.462983] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 31.473416] systemd[621]: Stopped Run user-specific NixOS activation. machine # [ 31.476192] systemd[621]: Stopping Run user-specific NixOS activation... machine # [ 31.480100] systemd[621]: Starting Run user-specific NixOS activation... machine # [ 31.519223] systemd[621]: Finished Run user-specific NixOS activation. machine # [ 31.523883] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 31.526743] systemd[1]: Stopping Reactivate sysinit units... machine # [ 31.528963] systemd[1]: Reached target Reactivate sysinit units. machine # [ 31.538589] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 31.541620] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 31.547422] systemd[1]: Reached target Local File Systems. machine # [ 31.550500] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 31.556576] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 31.560109] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 31.562355] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 31.566806] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 31.572206] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 31.575677] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 31.579511] systemd[1]: Reached target Remote File Systems. machine # [ 31.925436] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 31.928316] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 31.934734] systemd[1]: Starting linger-users.service... machine # [ 31.995752] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 31.998532] systemd[1]: Finished linger-users.service. machine # [ 32.258497] nixos[1362]: finished switching to system configuration /nix/store/4maakjccvixpy2wxm7rf3in1h4yyjcf2-nixos-system-machine-test machine: (finished: must succeed: /nix/store/2dxnd94gq2rrl2zizlyqygf5kr8skfrz-nixos-system-machine-test/specialisation/inhibitors/bin/switch-to-configuration switch 2>&1, in 3.02 seconds) machine: must fail: /nix/store/2dxnd94gq2rrl2zizlyqygf5kr8skfrz-nixos-system-machine-test/specialisation/inhibitors_changed/bin/switch-to-configuration switch 2>&1 machine: (finished: must fail: /nix/store/2dxnd94gq2rrl2zizlyqygf5kr8skfrz-nixos-system-machine-test/specialisation/inhibitors_changed/bin/switch-to-configuration switch 2>&1, in 0.08 seconds) machine: must succeed: /nix/store/2dxnd94gq2rrl2zizlyqygf5kr8skfrz-nixos-system-machine-test/specialisation/inhibitors_changed/bin/switch-to-configuration boot 2>&1 machine: (finished: must succeed: /nix/store/2dxnd94gq2rrl2zizlyqygf5kr8skfrz-nixos-system-machine-test/specialisation/inhibitors_changed/bin/switch-to-configuration boot 2>&1, in 0.05 seconds) machine: must succeed: /nix/store/2dxnd94gq2rrl2zizlyqygf5kr8skfrz-nixos-system-machine-test/specialisation/inhibitors_changed/bin/switch-to-configuration dry-activate 2>&1 machine: (finished: must succeed: /nix/store/2dxnd94gq2rrl2zizlyqygf5kr8skfrz-nixos-system-machine-test/specialisation/inhibitors_changed/bin/switch-to-configuration dry-activate 2>&1, in 0.75 seconds) machine: must succeed: /nix/store/2dxnd94gq2rrl2zizlyqygf5kr8skfrz-nixos-system-machine-test/specialisation/inhibitors_new/bin/switch-to-configuration switch 2>&1 machine # [ 33.778749] nixos[1528]: switching to system configuration /nix/store/qi5h227l73fp1s2g3jvk911g7q6pcmam-nixos-system-machine-test machine # [ 33.782764] systemd[1]: Stopped target Local File Systems. machine # [ 33.786049] systemd[1]: Stopped target Remote File Systems. machine # [ 34.278327] systemd[1]: Reload requested from client PID 1528 ('.switch-to-conf') (unit backdoor.service)... machine # [ 34.281215] systemd[1]: Reloading... machine # [ 34.867150] systemd[1]: Reloading finished in 582 ms. machine # [ 35.013374] systemd[621]: Reexecution requested from client PID 1599 ('switch-to-confi')... machine # [ 35.016799] systemd[621]: Reexecuting. machine # [ 35.047475] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 35.191797] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 35.200693] systemd[621]: Reload requested from client PID 1599 ('switch-to-confi')... machine # [ 35.203600] systemd[621]: Reloading... machine # [ 35.353109] systemd[621]: Reloading finished in 147 ms. machine # [ 35.359054] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 35.370733] systemd[621]: Stopped Run user-specific NixOS activation. machine # [ 35.372376] systemd[621]: Stopping Run user-specific NixOS activation... machine # [ 35.376186] systemd[621]: Starting Run user-specific NixOS activation... machine # [ 35.410886] systemd[621]: Finished Run user-specific NixOS activation. machine # [ 35.415523] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 35.417932] systemd[1]: Stopping Reactivate sysinit units... machine # [ 35.419509] systemd[1]: Reached target Reactivate sysinit units. machine # [ 35.422890] systemd[1]: Reached target Remote File Systems. machine # [ 35.428582] systemd[1]: Starting linger-users.service... machine # [ 35.444108] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 35.447233] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 35.452268] systemd[1]: Reached target Local File Systems. machine # [ 35.456354] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 35.463327] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 35.466172] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 35.469862] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 35.474586] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 35.477678] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 35.479929] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 35.530339] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 35.533142] systemd[1]: Finished linger-users.service. machine # [ 35.807229] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 35.811171] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 36.070804] nixos[1528]: finished switching to system configuration /nix/store/qi5h227l73fp1s2g3jvk911g7q6pcmam-nixos-system-machine-test machine: (finished: must succeed: /nix/store/2dxnd94gq2rrl2zizlyqygf5kr8skfrz-nixos-system-machine-test/specialisation/inhibitors_new/bin/switch-to-configuration switch 2>&1, in 2.93 seconds) machine: must succeed: /nix/store/2dxnd94gq2rrl2zizlyqygf5kr8skfrz-nixos-system-machine-test/specialisation/no_inhibitors/bin/switch-to-configuration switch 2>&1 machine # [ 36.766716] nixos[1670]: switching to system configuration /nix/store/is88s9b0a0rkmqprq8zmzww9n80q35by-nixos-system-machine-test machine # [ 36.770664] systemd[1]: Stopped target Local File Systems. machine # [ 36.773483] systemd[1]: Stopped target Remote File Systems. machine # [ 37.262268] systemd[1]: Reload requested from client PID 1670 ('.switch-to-conf') (unit backdoor.service)... machine # [ 37.265292] systemd[1]: Reloading... machine # [ 37.896143] systemd[1]: Reloading finished in 627 ms. machine # [ 38.031360] systemd[621]: Reexecution requested from client PID 1741 ('switch-to-confi')... machine # [ 38.034211] systemd[621]: Reexecuting. machine # [ 38.070346] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 38.244377] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 38.252098] systemd[621]: Reload requested from client PID 1741 ('switch-to-confi')... machine # [ 38.254944] systemd[621]: Reloading... machine # [ 38.428669] systemd[621]: Reloading finished in 171 ms. machine # [ 38.434994] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 38.446663] systemd[621]: Stopped Run user-specific NixOS activation. machine # [ 38.448415] systemd[621]: Stopping Run user-specific NixOS activation... machine # [ 38.452638] systemd[621]: Starting Run user-specific NixOS activation... machine # [ 38.498904] systemd[621]: Finished Run user-specific NixOS activation. machine # [ 38.503795] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 38.506649] systemd[1]: Stopping Reactivate sysinit units... machine # [ 38.508657] systemd[1]: Reached target Reactivate sysinit units. machine # [ 38.515774] systemd[1]: Reached target Remote File Systems. machine # [ 38.520047] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 38.524099] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 38.528985] systemd[1]: Reached target Local File Systems. machine # [ 38.532518] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 38.539853] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 38.543227] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 38.546891] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 38.553544] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 38.557192] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 38.560217] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 38.902730] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 38.905619] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 38.912363] systemd[1]: Starting linger-users.service... machine # [ 38.966235] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 38.969841] systemd[1]: Finished linger-users.service. machine # [ 39.230534] nixos[1670]: finished switching to system configuration /nix/store/is88s9b0a0rkmqprq8zmzww9n80q35by-nixos-system-machine-test machine: (finished: must succeed: /nix/store/2dxnd94gq2rrl2zizlyqygf5kr8skfrz-nixos-system-machine-test/specialisation/no_inhibitors/bin/switch-to-configuration switch 2>&1, in 3.16 seconds) (finished: subtest: switch inhibitors, in 13.12 seconds) subtest: actions machine: must succeed: /nix/store/2dxnd94gq2rrl2zizlyqygf5kr8skfrz-nixos-system-machine-test/specialisation/modifiedSystemConf/bin/switch-to-configuration boot 2>&1 machine: (finished: must succeed: /nix/store/2dxnd94gq2rrl2zizlyqygf5kr8skfrz-nixos-system-machine-test/specialisation/modifiedSystemConf/bin/switch-to-configuration boot 2>&1, in 0.08 seconds) machine: must succeed: /nix/store/2dxnd94gq2rrl2zizlyqygf5kr8skfrz-nixos-system-machine-test/bin/switch-to-configuration switch 2>&1 machine # [ 39.852617] nixos[1819]: switching to system configuration /nix/store/2dxnd94gq2rrl2zizlyqygf5kr8skfrz-nixos-system-machine-test machine # [ 39.856524] systemd[1]: Stopped target Local File Systems. machine # [ 39.859513] systemd[1]: Stopped target Remote File Systems. machine # [ 40.298807] systemd[1]: Reload requested from client PID 1819 ('.switch-to-conf') (unit backdoor.service)... machine # [ 40.301719] systemd[1]: Reloading... machine # [ 40.941578] systemd[1]: Reloading finished in 637 ms. machine # [ 41.108164] systemd[621]: Reexecution requested from client PID 1889 ('switch-to-confi')... machine # [ 41.112301] systemd[621]: Reexecuting. machine # [ 41.140159] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 41.294440] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 41.303427] systemd[621]: Reload requested from client PID 1889 ('switch-to-confi')... machine # [ 41.305935] systemd[621]: Reloading... machine # [ 41.478865] systemd[621]: Reloading finished in 170 ms. machine # [ 41.485076] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 41.496064] systemd[621]: Stopped Run user-specific NixOS activation. machine # [ 41.497878] systemd[621]: Stopping Run user-specific NixOS activation... machine # [ 41.503046] systemd[621]: Starting Run user-specific NixOS activation... machine # [ 41.546644] systemd[621]: Finished Run user-specific NixOS activation. machine # [ 41.551918] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 41.554487] systemd[1]: Stopping Reactivate sysinit units... machine # [ 41.556053] systemd[1]: Reached target Reactivate sysinit units. machine # [ 41.559602] systemd[1]: Reached target Local File Systems. machine # [ 41.564204] systemd[1]: Reached target Remote File Systems. machine # [ 41.571946] systemd[1]: Starting linger-users.service... machine # [ 41.578637] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 41.581058] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 41.586121] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 41.594535] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 41.596181] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 41.598462] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 41.606772] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 41.611333] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 41.615791] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 41.668391] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 41.671254] systemd[1]: Finished linger-users.service. machine # [ 41.944253] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 41.947567] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 42.208620] nixos[1819]: finished switching to system configuration /nix/store/2dxnd94gq2rrl2zizlyqygf5kr8skfrz-nixos-system-machine-test machine: (finished: must succeed: /nix/store/2dxnd94gq2rrl2zizlyqygf5kr8skfrz-nixos-system-machine-test/bin/switch-to-configuration switch 2>&1, in 2.90 seconds) machine: must fail: /nix/store/2dxnd94gq2rrl2zizlyqygf5kr8skfrz-nixos-system-machine-test/bin/switch-to-configuration broken-action 2>&1 machine: (finished: must fail: /nix/store/2dxnd94gq2rrl2zizlyqygf5kr8skfrz-nixos-system-machine-test/bin/switch-to-configuration broken-action 2>&1, in 0.05 seconds) machine: must fail: /nix/store/2dxnd94gq2rrl2zizlyqygf5kr8skfrz-nixos-system-machine-test/bin/switch-to-configuration 2>&1 machine: (finished: must fail: /nix/store/2dxnd94gq2rrl2zizlyqygf5kr8skfrz-nixos-system-machine-test/bin/switch-to-configuration 2>&1, in 0.04 seconds) (finished: subtest: actions, in 3.07 seconds) subtest: init interface version machine: must fail: /nix/store/2dxnd94gq2rrl2zizlyqygf5kr8skfrz-nixos-system-machine-test/specialisation/brokenInitInterface/bin/switch-to-configuration test 2>&1 machine: (finished: must fail: /nix/store/2dxnd94gq2rrl2zizlyqygf5kr8skfrz-nixos-system-machine-test/specialisation/brokenInitInterface/bin/switch-to-configuration test 2>&1, in 0.06 seconds) (finished: subtest: init interface version, in 0.06 seconds) subtest: systemd restarts machine: must succeed: /nix/store/2dxnd94gq2rrl2zizlyqygf5kr8skfrz-nixos-system-machine-test/specialisation/modifiedSystemConf/bin/switch-to-configuration test 2>&1 machine # [ 42.968913] nixos[1976]: switching to system configuration /nix/store/n7azmi27izdgw0sq7fb7pgwlb1r2hf1v-nixos-system-machine-test machine # [ 42.973187] systemd[1]: Stopped target Local File Systems. machine # [ 42.975892] systemd[1]: Stopped target Remote File Systems. machine # [ 43.408147] systemd[1]: Reexecution requested from client PID 1976 ('.switch-to-conf') (unit backdoor.service)... machine # [ 43.413726] systemd[1]: Reexecuting. machine # [ 43.719892] systemd[1]: systemd 262-726e17a 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 # [ 43.725820] systemd[1]: Detected virtualization kvm. machine # [ 43.727150] systemd[1]: Detected architecture x86-64. machine # [ 43.821952] systemd[1]: bpf-restrict-fs: LSM BPF program attached machine # [ 44.158727] systemd[1]: Reload requested from client PID 1976 ('.switch-to-conf') (unit backdoor.service)... machine # [ 44.161804] systemd[1]: Reloading... machine # [ 44.760131] systemd[1]: Reloading finished in 595 ms. machine # [ 44.911291] systemd[621]: Reexecution requested from client PID 2079 ('switch-to-confi')... machine # [ 44.915337] systemd[621]: Reexecuting. machine # [ 44.943455] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 45.094734] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 45.103162] systemd[621]: Reload requested from client PID 2079 ('switch-to-confi')... machine # [ 45.105675] systemd[621]: Reloading... machine # [ 45.247371] systemd[621]: Reloading finished in 139 ms. machine # [ 45.253995] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 45.264919] systemd[621]: Stopped Run user-specific NixOS activation. machine # [ 45.266871] systemd[621]: Stopping Run user-specific NixOS activation... machine # [ 45.271649] systemd[621]: Starting Run user-specific NixOS activation... machine # [ 45.308742] systemd[621]: Finished Run user-specific NixOS activation. machine # [ 45.313699] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 45.316538] systemd[1]: Stopping Reactivate sysinit units... machine # [ 45.318895] systemd[1]: Reached target Reactivate sysinit units. machine # [ 45.325104] systemd[1]: Reached target Local File Systems. machine # [ 45.326586] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 45.333332] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 45.334916] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 45.340168] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 45.344902] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 45.347659] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 45.351208] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 45.356122] systemd[1]: Reached target Remote File Systems. machine # [ 45.358611] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 45.363327] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 45.706855] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 45.709104] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 45.716897] systemd[1]: Starting linger-users.service... machine # [ 45.771860] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 45.774540] systemd[1]: Finished linger-users.service. machine # [ 46.033952] nixos[1976]: finished switching to system configuration /nix/store/n7azmi27izdgw0sq7fb7pgwlb1r2hf1v-nixos-system-machine-test machine: (finished: must succeed: /nix/store/2dxnd94gq2rrl2zizlyqygf5kr8skfrz-nixos-system-machine-test/specialisation/modifiedSystemConf/bin/switch-to-configuration test 2>&1, in 3.67 seconds) (finished: subtest: systemd restarts, in 3.67 seconds) subtest: continuing from an aborted switch machine: must succeed: echo dbus-broker.service > /run/nixos/start-list machine: (finished: must succeed: echo dbus-broker.service > /run/nixos/start-list, in 0.03 seconds) machine: must succeed: /nix/store/2dxnd94gq2rrl2zizlyqygf5kr8skfrz-nixos-system-machine-test/specialisation/modifiedSystemConf/bin/switch-to-configuration test 2>&1 machine # [ 46.744382] nixos[2154]: switching to system configuration /nix/store/n7azmi27izdgw0sq7fb7pgwlb1r2hf1v-nixos-system-machine-test machine # [ 46.748749] systemd[1]: Stopped target Remote File Systems. machine # [ 46.752254] systemd[1]: Stopped target Local File Systems. machine # [ 47.223139] systemd[1]: Reload requested from client PID 2154 ('.switch-to-conf') (unit backdoor.service)... machine # [ 47.226340] systemd[1]: Reloading... machine # [ 48.788728] systemd[1]: Reloading finished in 1559 ms. machine # [ 48.941727] systemd[621]: Reexecution requested from client PID 2223 ('switch-to-confi')... machine # [ 48.946098] systemd[621]: Reexecuting. machine # [ 48.977196] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 49.154602] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 49.163381] systemd[621]: Reload requested from client PID 2223 ('switch-to-confi')... machine # [ 49.165677] systemd[621]: Reloading... machine # [ 49.349075] systemd[621]: Reloading finished in 180 ms. machine # [ 49.354107] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 49.365823] systemd[621]: Stopped Run user-specific NixOS activation. machine # [ 49.367551] systemd[621]: Stopping Run user-specific NixOS activation... machine # [ 49.371708] systemd[621]: Starting Run user-specific NixOS activation... machine # [ 49.410454] systemd[621]: Finished Run user-specific NixOS activation. machine # [ 49.415285] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 49.417549] systemd[1]: Stopping Reactivate sysinit units... machine # [ 49.419499] systemd[1]: Reached target Reactivate sysinit units. machine # [ 49.424977] systemd[1]: Reached target Local File Systems. machine # [ 49.434152] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 49.440055] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 49.442693] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 49.446859] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 49.451193] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 49.455088] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 49.458207] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 49.462331] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 49.464628] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 49.468465] systemd[1]: Reached target Remote File Systems. machine # [ 49.765294] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 49.768213] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 49.774987] systemd[1]: Starting linger-users.service... machine # [ 49.834194] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 49.837438] systemd[1]: Finished linger-users.service. machine # [ 50.092410] nixos[2154]: finished switching to system configuration /nix/store/n7azmi27izdgw0sq7fb7pgwlb1r2hf1v-nixos-system-machine-test machine: (finished: must succeed: /nix/store/2dxnd94gq2rrl2zizlyqygf5kr8skfrz-nixos-system-machine-test/specialisation/modifiedSystemConf/bin/switch-to-configuration test 2>&1, in 4.02 seconds) (finished: subtest: continuing from an aborted switch, in 4.05 seconds) subtest: aborts on already locked lock file ??? Warning (UserWarning): execute(): passing a bare int/float as a duration is deprecated. Use datetime.timedelta instead. File "/nix/store/wqwvv2w9ih8r1f0lsa0h3fqf91nblq7g-nixos-test-driver-1.1/lib/python3.14/site-packages/test_driver/duration.py", line 39 machine # Could not acquire lock (finished: subtest: aborts on already locked lock file, in 0.05 seconds) subtest: fstab mounts machine: must succeed: /nix/store/2dxnd94gq2rrl2zizlyqygf5kr8skfrz-nixos-system-machine-test/bin/switch-to-configuration test 2>&1 machine # [ 50.789318] nixos[2299]: switching to system configuration /nix/store/2dxnd94gq2rrl2zizlyqygf5kr8skfrz-nixos-system-machine-test machine # [ 50.793506] systemd[1]: Stopped target Remote File Systems. machine # [ 50.795621] systemd[1]: Stopped target Local File Systems. machine # [ 51.234270] systemd[1]: Reexecution requested from client PID 2299 ('.switch-to-conf') (unit backdoor.service)... machine # [ 51.239858] systemd[1]: Reexecuting. machine # [ 51.658157] systemd[1]: systemd 262-726e17a 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 # [ 51.672304] systemd[1]: Detected virtualization kvm. machine # [ 51.675586] systemd[1]: Detected architecture x86-64. machine # [ 51.775769] systemd[1]: bpf-restrict-fs: LSM BPF program attached machine # [ 53.000315] systemd[1]: Reload requested from client PID 2299 ('.switch-to-conf') (unit backdoor.service)... machine # [ 53.003373] systemd[1]: Reloading... machine # [ 54.504478] systemd[1]: Reloading finished in 1498 ms. machine # [ 54.661114] systemd[621]: Reexecution requested from client PID 2402 ('switch-to-confi')... machine # [ 54.665149] systemd[621]: Reexecuting. machine # [ 54.696769] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 54.871657] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 54.881185] systemd[621]: Reload requested from client PID 2402 ('switch-to-confi')... machine # [ 54.884212] systemd[621]: Reloading... machine # [ 55.061479] systemd[621]: Reloading finished in 173 ms. machine # [ 55.067059] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 55.078534] systemd[621]: Stopped Run user-specific NixOS activation. machine # [ 55.080326] systemd[621]: Stopping Run user-specific NixOS activation... machine # [ 55.084695] systemd[621]: Starting Run user-specific NixOS activation... machine # [ 55.130098] systemd[621]: Finished Run user-specific NixOS activation. machine # [ 55.134906] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 55.137884] systemd[1]: Stopping Reactivate sysinit units... machine # [ 55.139363] systemd[1]: Reached target Reactivate sysinit units. machine # [ 55.147105] systemd[1]: Reached target Local File Systems. machine # [ 55.150180] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 55.156393] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 55.157866] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 55.162613] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 55.167053] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 55.171817] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 55.173993] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 55.178936] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 55.181176] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 55.183381] systemd[1]: Reached target Remote File Systems. machine # [ 55.545353] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 55.547758] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 55.555552] systemd[1]: Starting linger-users.service... machine # [ 55.615477] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 55.618994] systemd[1]: Finished linger-users.service. machine # [ 55.878225] nixos[2299]: finished switching to system configuration /nix/store/2dxnd94gq2rrl2zizlyqygf5kr8skfrz-nixos-system-machine-test machine: (finished: must succeed: /nix/store/2dxnd94gq2rrl2zizlyqygf5kr8skfrz-nixos-system-machine-test/bin/switch-to-configuration test 2>&1, in 5.74 seconds) machine: must succeed: /nix/store/2dxnd94gq2rrl2zizlyqygf5kr8skfrz-nixos-system-machine-test/specialisation/addedMount/bin/switch-to-configuration test 2>&1 machine # [ 56.559853] nixos[2473]: switching to system configuration /nix/store/iv7n5csmk3mx04kjsnwz27qqikyb8c7w-nixos-system-machine-test machine # [ 56.563794] systemd[1]: Stopped target Local File Systems. machine # [ 56.567285] systemd[1]: Stopped target Remote File Systems. machine # [ 57.100135] systemd[1]: Reload requested from client PID 2473 ('.switch-to-conf') (unit backdoor.service)... machine # [ 57.103116] systemd[1]: Reloading... machine # [ 57.707439] systemd[1]: Reloading finished in 601 ms. machine # [ 57.860285] systemd[621]: Reexecution requested from client PID 2542 ('switch-to-confi')... machine # [ 57.864106] systemd[621]: Reexecuting. machine # [ 57.895163] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 58.065154] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 58.073859] systemd[621]: Reload requested from client PID 2542 ('switch-to-confi')... machine # [ 58.076652] systemd[621]: Reloading... machine # [ 58.240610] systemd[621]: Reloading finished in 161 ms. machine # [ 58.247087] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 58.258223] systemd[621]: Stopped Run user-specific NixOS activation. machine # [ 58.260105] systemd[621]: Stopping Run user-specific NixOS activation... machine # [ 58.264820] systemd[621]: Starting Run user-specific NixOS activation... machine # [ 58.301199] systemd[621]: Finished Run user-specific NixOS activation. machine # [ 58.306385] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 58.308260] systemd[1]: Stopping Reactivate sysinit units... machine # [ 58.310316] systemd[1]: Reached target Reactivate sysinit units. machine # [ 58.321227] systemd[1]: Mounting /test... machine # [ 58.324607] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 58.327827] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 58.333254] systemd[1]: Reached target Remote File Systems. machine # [ 58.338489] systemd[1]: Starting linger-users.service... machine # [ 58.346366] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 58.353121] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 58.354743] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 58.358429] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 58.366209] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 58.368463] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 58.404936] systemd[1]: Mounted /test. machine # [ 58.410865] systemd[1]: Reached target Local File Systems. machine # [ 58.412790] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 58.450547] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 58.453447] systemd[1]: Finished linger-users.service. machine # [ 58.714948] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 58.717958] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 58.975723] nixos[2473]: finished switching to system configuration /nix/store/iv7n5csmk3mx04kjsnwz27qqikyb8c7w-nixos-system-machine-test machine: (finished: must succeed: /nix/store/2dxnd94gq2rrl2zizlyqygf5kr8skfrz-nixos-system-machine-test/specialisation/addedMount/bin/switch-to-configuration test 2>&1, in 3.09 seconds) machine: must succeed: systemctl stop test.mount machine # [ 59.020812] systemd[1]: Stopped target Local File Systems. machine # [ 59.025280] systemd[1]: Unmounting /test... machine # [ 59.064564] systemd[1]: test.mount: Deactivated successfully. machine # [ 59.067211] systemd[1]: Unmounted /test. machine: (finished: must succeed: systemctl stop test.mount, in 0.09 seconds) machine: must succeed: /nix/store/2dxnd94gq2rrl2zizlyqygf5kr8skfrz-nixos-system-machine-test/specialisation/addedMount/bin/switch-to-configuration test 2>&1 machine # [ 59.670535] nixos[2621]: switching to system configuration /nix/store/iv7n5csmk3mx04kjsnwz27qqikyb8c7w-nixos-system-machine-test machine # [ 59.674500] systemd[1]: Stopped target Remote File Systems. machine # [ 60.131392] systemd[1]: Reload requested from client PID 2621 ('.switch-to-conf') (unit backdoor.service)... machine # [ 60.134389] systemd[1]: Reloading... machine # [ 60.874889] systemd[1]: Reloading finished in 737 ms. machine # [ 61.013622] systemd[621]: Reexecution requested from client PID 2690 ('switch-to-confi')... machine # [ 61.018757] systemd[621]: Reexecuting. machine # [ 61.045806] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 61.212345] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 61.221789] systemd[621]: Reload requested from client PID 2690 ('switch-to-confi')... machine # [ 61.224220] systemd[621]: Reloading... machine # [ 61.387071] systemd[621]: Reloading finished in 160 ms. machine # [ 61.393104] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 61.403988] systemd[621]: Stopped Run user-specific NixOS activation. machine # [ 61.405809] systemd[621]: Stopping Run user-specific NixOS activation... machine # [ 61.410614] systemd[621]: Starting Run user-specific NixOS activation... machine # [ 61.449231] systemd[621]: Finished Run user-specific NixOS activation. machine # [ 61.454446] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 61.458164] systemd[1]: Stopping Reactivate sysinit units... machine # [ 61.459778] systemd[1]: Reached target Reactivate sysinit units. machine # [ 61.463368] systemd[1]: Reached target Remote File Systems. machine # [ 61.477189] systemd[1]: Mounting /test... machine # [ 61.478409] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 61.485467] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 61.488654] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 61.493926] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 61.498294] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 61.500770] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 61.510196] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 61.514536] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 61.548552] systemd[1]: Mounted /test. machine # [ 61.551949] systemd[1]: Reached target Local File Systems. machine # [ 61.553839] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 61.854316] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 61.857360] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 61.863716] systemd[1]: Starting linger-users.service... machine # [ 61.923201] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 61.925178] systemd[1]: Finished linger-users.service. machine # [ 62.186619] nixos[2621]: finished switching to system configuration /nix/store/iv7n5csmk3mx04kjsnwz27qqikyb8c7w-nixos-system-machine-test machine: (finished: must succeed: /nix/store/2dxnd94gq2rrl2zizlyqygf5kr8skfrz-nixos-system-machine-test/specialisation/addedMount/bin/switch-to-configuration test 2>&1, in 3.12 seconds) machine: must succeed: /nix/store/2dxnd94gq2rrl2zizlyqygf5kr8skfrz-nixos-system-machine-test/specialisation/addedMountOptsModified/bin/switch-to-configuration test 2>&1 machine # [ 62.792426] nixos[2763]: switching to system configuration /nix/store/4zksfqa8xvqqq2vzjpvjb6rfpggn4ag7-nixos-system-machine-test machine # [ 62.796667] systemd[1]: Stopped target Remote File Systems. machine # [ 62.799377] systemd[1]: Stopped target Local File Systems. machine # [ 63.317241] systemd[1]: Reload requested from client PID 2763 ('.switch-to-conf') (unit backdoor.service)... machine # [ 63.320385] systemd[1]: Reloading... machine # [ 68.295290] systemd[1]: Reloading finished in 4972 ms. machine # [ 68.436572] systemd[621]: Reexecution requested from client PID 2832 ('switch-to-confi')... machine # [ 68.441301] systemd[621]: Reexecuting. machine # [ 68.471660] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 68.643378] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 68.651977] systemd[621]: Reload requested from client PID 2832 ('switch-to-confi')... machine # [ 68.654971] systemd[621]: Reloading... machine # [ 68.822722] systemd[621]: Reloading finished in 165 ms. machine # [ 68.829088] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 68.839897] systemd[621]: Stopped Run user-specific NixOS activation. machine # [ 68.841764] systemd[621]: Stopping Run user-specific NixOS activation... machine # [ 68.846629] systemd[621]: Starting Run user-specific NixOS activation... machine # [ 68.889149] systemd[621]: Finished Run user-specific NixOS activation. machine # [ 68.894127] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 68.896766] systemd[1]: Stopping Reactivate sysinit units... machine # [ 68.898768] systemd[1]: Reached target Reactivate sysinit units. machine # [ 68.902990] systemd[1]: Reloading /test... machine # [ 68.934418] systemd[1]: Reloaded /test. machine # [ 68.939177] systemd[1]: Reached target Local File Systems. machine # [ 68.942097] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 68.944394] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 68.953179] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 68.959295] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 68.961960] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 68.964281] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 68.970595] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 68.975528] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 68.979210] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 68.983267] systemd[1]: Reached target Remote File Systems. machine # [ 69.322852] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 69.328122] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 69.333105] systemd[1]: Starting linger-users.service... machine # [ 69.386813] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 69.390333] systemd[1]: Finished linger-users.service. machine # [ 69.650397] nixos[2763]: finished switching to system configuration /nix/store/4zksfqa8xvqqq2vzjpvjb6rfpggn4ag7-nixos-system-machine-test machine: (finished: must succeed: /nix/store/2dxnd94gq2rrl2zizlyqygf5kr8skfrz-nixos-system-machine-test/specialisation/addedMountOptsModified/bin/switch-to-configuration test 2>&1, in 7.46 seconds) machine: must succeed: /nix/store/2dxnd94gq2rrl2zizlyqygf5kr8skfrz-nixos-system-machine-test/specialisation/addedMountDevModified/bin/switch-to-configuration test 2>&1 machine # [ 70.301931] nixos[2905]: switching to system configuration /nix/store/fiz7r9ffjyfsb2c1jrzid0sjyc2pfivh-nixos-system-machine-test machine # [ 70.305961] systemd[1]: Stopped target Remote File Systems. machine # [ 70.309094] systemd[1]: Stopped target Local File Systems. machine # [ 70.818543] systemd[1]: Reload requested from client PID 2905 ('.switch-to-conf') (unit backdoor.service)... machine # [ 70.821294] systemd[1]: Reloading... machine # [ 71.400850] systemd[1]: Reloading finished in 576 ms. machine # [ 71.555664] systemd[621]: Reexecution requested from client PID 2974 ('switch-to-confi')... machine # [ 71.559520] systemd[621]: Reexecuting. machine # [ 71.588739] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 71.729144] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 71.736407] systemd[621]: Reload requested from client PID 2974 ('switch-to-confi')... machine # [ 71.739126] systemd[621]: Reloading... machine # [ 71.876960] systemd[621]: Reloading finished in 135 ms. machine # [ 71.882094] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 71.892912] systemd[621]: Stopped Run user-specific NixOS activation. machine # [ 71.895610] systemd[621]: Stopping Run user-specific NixOS activation... machine # [ 71.899579] systemd[621]: Starting Run user-specific NixOS activation... machine # [ 71.937163] systemd[621]: Finished Run user-specific NixOS activation. machine # [ 71.942517] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 71.944727] systemd[1]: Stopping Reactivate sysinit units... machine # [ 71.946634] systemd[1]: Reached target Reactivate sysinit units. machine # [ 71.950495] systemd[1]: Unmounting /test... machine # [ 71.985509] systemd[1]: test.mount: Deactivated successfully. machine # [ 71.988152] systemd[1]: Unmounted /test. machine # [ 71.993620] systemd[1]: Mounting /test... machine # [ 72.026964] systemd[1]: Mounted /test. machine # [ 72.036128] systemd[1]: Reached target Remote File Systems. machine # [ 72.038318] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 72.042382] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 72.046363] systemd[1]: Starting linger-users.service... machine # [ 72.054605] systemd[1]: Reached target Local File Systems. machine # [ 72.065478] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 72.073596] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 72.076919] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 72.079480] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 72.086398] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 72.089772] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 72.092125] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 72.150935] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 72.155211] systemd[1]: Finished linger-users.service. machine # [ 72.449337] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 72.453566] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 72.714772] nixos[2905]: finished switching to system configuration /nix/store/fiz7r9ffjyfsb2c1jrzid0sjyc2pfivh-nixos-system-machine-test machine: (finished: must succeed: /nix/store/2dxnd94gq2rrl2zizlyqygf5kr8skfrz-nixos-system-machine-test/specialisation/addedMountDevModified/bin/switch-to-configuration test 2>&1, in 3.06 seconds) machine: must succeed: /nix/store/2dxnd94gq2rrl2zizlyqygf5kr8skfrz-nixos-system-machine-test/specialisation/addedMount/bin/switch-to-configuration test 2>&1 machine # [ 73.350593] nixos[3049]: switching to system configuration /nix/store/iv7n5csmk3mx04kjsnwz27qqikyb8c7w-nixos-system-machine-test machine # [ 73.354716] systemd[1]: Stopped target Remote File Systems. machine # [ 73.358331] systemd[1]: Stopped target Local File Systems. machine # [ 73.810705] systemd[1]: Reload requested from client PID 3049 ('.switch-to-conf') (unit backdoor.service)... machine # [ 73.813810] systemd[1]: Reloading... machine # [ 74.409527] systemd[1]: Reloading finished in 592 ms. machine # [ 74.561476] systemd[621]: Reexecution requested from client PID 3118 ('switch-to-confi')... machine # [ 74.565200] systemd[621]: Reexecuting. machine # [ 74.596640] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 74.766208] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 74.775100] systemd[621]: Reload requested from client PID 3118 ('switch-to-confi')... machine # [ 74.777661] systemd[621]: Reloading... machine # [ 74.952602] systemd[621]: Reloading finished in 172 ms. machine # [ 74.957091] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 74.968107] systemd[621]: Stopped Run user-specific NixOS activation. machine # [ 74.971143] systemd[621]: Stopping Run user-specific NixOS activation... machine # [ 74.975261] systemd[621]: Starting Run user-specific NixOS activation... machine # [ 75.020651] systemd[621]: Finished Run user-specific NixOS activation. machine # [ 75.025722] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 75.028358] systemd[1]: Stopping Reactivate sysinit units... machine # [ 75.030221] systemd[1]: Reached target Reactivate sysinit units. machine # [ 75.034464] systemd[1]: Unmounting /test... machine # [ 75.069420] systemd[1]: test.mount: Deactivated successfully. machine # [ 75.072099] systemd[1]: Unmounted /test. machine # [ 75.077522] systemd[1]: Mounting /test... machine # [ 75.109193] systemd[1]: Mounted /test. machine # [ 75.118244] systemd[1]: Reached target Local File Systems. machine # [ 75.119828] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 75.126306] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 75.127982] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 75.132803] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 75.137857] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 75.142717] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 75.146258] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 75.150412] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 75.152702] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 75.156899] systemd[1]: Reached target Remote File Systems. machine # [ 75.503705] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 75.507133] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 75.513230] systemd[1]: Starting linger-users.service... machine # [ 75.569854] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 75.573351] systemd[1]: Finished linger-users.service. machine # [ 75.832332] nixos[3049]: finished switching to system configuration /nix/store/iv7n5csmk3mx04kjsnwz27qqikyb8c7w-nixos-system-machine-test machine: (finished: must succeed: /nix/store/2dxnd94gq2rrl2zizlyqygf5kr8skfrz-nixos-system-machine-test/specialisation/addedMount/bin/switch-to-configuration test 2>&1, in 3.12 seconds) machine: must succeed: /nix/store/2dxnd94gq2rrl2zizlyqygf5kr8skfrz-nixos-system-machine-test/bin/switch-to-configuration test 2>&1 machine # [ 76.394547] nixos[3193]: switching to system configuration /nix/store/2dxnd94gq2rrl2zizlyqygf5kr8skfrz-nixos-system-machine-test machine # [ 76.398547] systemd[1]: Stopped target Local File Systems. machine # [ 76.403118] systemd[1]: Unmounting /test... machine # [ 76.405756] systemd[1]: Stopped target Remote File Systems. machine # [ 76.433938] systemd[1]: test.mount: Deactivated successfully. machine # [ 76.436339] systemd[1]: Unmounted /test. machine # [ 76.830785] systemd[1]: Reload requested from client PID 3193 ('.switch-to-conf') (unit backdoor.service)... machine # [ 76.833666] systemd[1]: Reloading... machine # [ 77.383860] systemd[1]: Reloading finished in 547 ms. machine # [ 77.531313] systemd[621]: Reexecution requested from client PID 3264 ('switch-to-confi')... machine # [ 77.535787] systemd[621]: Reexecuting. machine # [ 77.564059] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 77.744375] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 77.752130] systemd[621]: Reload requested from client PID 3264 ('switch-to-confi')... machine # [ 77.755112] systemd[621]: Reloading... machine # [ 77.922323] systemd[621]: Reloading finished in 165 ms. machine # [ 77.928988] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 77.940664] systemd[621]: Stopped Run user-specific NixOS activation. machine # [ 77.942402] systemd[621]: Stopping Run user-specific NixOS activation... machine # [ 77.946695] systemd[621]: Starting Run user-specific NixOS activation... machine # [ 77.990663] systemd[621]: Finished Run user-specific NixOS activation. machine # [ 77.995536] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 77.998450] systemd[1]: Stopping Reactivate sysinit units... machine # [ 78.000963] systemd[1]: Reached target Reactivate sysinit units. machine # [ 78.006875] systemd[1]: Reached target Local File Systems. machine # [ 78.010501] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 78.015317] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 78.019069] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 78.021332] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 78.026315] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 78.030834] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 78.034270] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 78.038262] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 78.041207] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 78.051939] systemd[1]: Reached target Remote File Systems. machine # [ 78.393058] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 78.394992] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 78.401646] systemd[1]: Starting linger-users.service... machine # [ 78.460414] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 78.462329] systemd[1]: Finished linger-users.service. machine # [ 78.719465] nixos[3193]: finished switching to system configuration /nix/store/2dxnd94gq2rrl2zizlyqygf5kr8skfrz-nixos-system-machine-test machine: (finished: must succeed: /nix/store/2dxnd94gq2rrl2zizlyqygf5kr8skfrz-nixos-system-machine-test/bin/switch-to-configuration test 2>&1, in 2.88 seconds) machine: must succeed: /nix/store/2dxnd94gq2rrl2zizlyqygf5kr8skfrz-nixos-system-machine-test/specialisation/storeMountModified/bin/switch-to-configuration test 2>&1 machine # [ 79.316520] nixos[3335]: switching to system configuration /nix/store/qpcky14l18if4br2lnv0d0k4dvpmjxjg-nixos-system-machine-test machine # [ 79.320446] systemd[1]: Stopped target Remote File Systems. machine # [ 79.324226] systemd[1]: Stopped target Local File Systems. machine # [ 79.773862] systemd[1]: Reload requested from client PID 3335 ('.switch-to-conf') (unit backdoor.service)... machine # [ 79.776768] systemd[1]: Reloading... machine # [ 80.388088] systemd[1]: Reloading finished in 608 ms. machine # [ 80.541543] systemd[621]: Reexecution requested from client PID 3404 ('switch-to-confi')... machine # [ 80.545550] systemd[621]: Reexecuting. machine # [ 80.572803] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 80.742833] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 80.751138] systemd[621]: Reload requested from client PID 3404 ('switch-to-confi')... machine # [ 80.754465] systemd[621]: Reloading... machine # [ 80.926229] systemd[621]: Reloading finished in 169 ms. machine # [ 80.931991] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 80.942693] systemd[621]: Stopped Run user-specific NixOS activation. machine # [ 80.945368] systemd[621]: Stopping Run user-specific NixOS activation... machine # [ 80.949324] systemd[621]: Starting Run user-specific NixOS activation... machine # [ 80.992402] systemd[621]: Finished Run user-specific NixOS activation. machine # [ 80.997179] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 80.999831] systemd[1]: Stopping Reactivate sysinit units... machine # [ 81.001586] systemd[1]: Reached target Reactivate sysinit units. machine # [ 81.007582] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 81.010649] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 81.016205] systemd[1]: Reached target Local File Systems. machine # [ 81.020072] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 81.025404] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 81.028787] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 81.032187] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 81.036465] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 81.042187] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 81.044450] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 81.048967] systemd[1]: Reached target Remote File Systems. machine # [ 81.406550] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 81.409496] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 81.415966] systemd[1]: Starting linger-users.service... machine # [ 81.474449] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 81.476376] systemd[1]: Finished linger-users.service. machine # [ 81.736952] nixos[3335]: finished switching to system configuration /nix/store/qpcky14l18if4br2lnv0d0k4dvpmjxjg-nixos-system-machine-test machine: (finished: must succeed: /nix/store/2dxnd94gq2rrl2zizlyqygf5kr8skfrz-nixos-system-machine-test/specialisation/storeMountModified/bin/switch-to-configuration test 2>&1, in 3.02 seconds) machine: must succeed: /nix/store/2dxnd94gq2rrl2zizlyqygf5kr8skfrz-nixos-system-machine-test/specialisation/automount/bin/switch-to-configuration test 2>&1 machine # [ 82.422372] nixos[3475]: switching to system configuration /nix/store/5lcmwy8yrl7idvqrm2rw9kgm57667pwr-nixos-system-machine-test machine # [ 82.426654] systemd[1]: Stopped target Remote File Systems. machine # [ 82.429536] systemd[1]: Stopped target Local File Systems. machine # [ 82.935527] systemd[1]: Reload requested from client PID 3475 ('.switch-to-conf') (unit backdoor.service)... machine # [ 82.938664] systemd[1]: Reloading... machine # [ 83.537253] systemd[1]: Reloading finished in 595 ms. machine # [ 83.690362] systemd[621]: Reexecution requested from client PID 3544 ('switch-to-confi')... machine # [ 83.693669] systemd[621]: Reexecuting. machine # [ 83.722692] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 83.893569] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 83.901911] systemd[621]: Reload requested from client PID 3544 ('switch-to-confi')... machine # [ 83.904753] systemd[621]: Reloading... machine # [ 84.073635] systemd[621]: Reloading finished in 166 ms. machine # [ 84.077989] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 84.089737] systemd[621]: Stopped Run user-specific NixOS activation. machine # [ 84.091408] systemd[621]: Stopping Run user-specific NixOS activation... machine # [ 84.095350] systemd[621]: Starting Run user-specific NixOS activation... machine # [ 84.136372] systemd[621]: Finished Run user-specific NixOS activation. machine # [ 84.141143] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 84.143529] systemd[1]: Stopping Reactivate sysinit units... machine # [ 84.145077] systemd[1]: Reached target Reactivate sysinit units. machine # [ 84.151875] systemd[1]: Set up automount testauto.automount. machine # [ 84.153420] systemd[1]: Reached target Local File Systems. machine # [ 84.156863] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 84.162302] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 84.165205] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 84.168425] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 84.173983] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 84.177803] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 84.180080] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 84.185371] systemd[1]: Reached target Remote File Systems. machine # [ 84.191896] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 84.195604] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 84.533665] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 84.537465] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 84.543345] systemd[1]: Starting linger-users.service... machine # [ 84.600114] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 84.602786] systemd[1]: Finished linger-users.service. machine # [ 84.859271] nixos[3475]: finished switching to system configuration /nix/store/5lcmwy8yrl7idvqrm2rw9kgm57667pwr-nixos-system-machine-test machine: (finished: must succeed: /nix/store/2dxnd94gq2rrl2zizlyqygf5kr8skfrz-nixos-system-machine-test/specialisation/automount/bin/switch-to-configuration test 2>&1, in 3.12 seconds) machine: must succeed: /nix/store/2dxnd94gq2rrl2zizlyqygf5kr8skfrz-nixos-system-machine-test/bin/switch-to-configuration test 2>&1 machine # [ 85.501657] nixos[3615]: switching to system configuration /nix/store/2dxnd94gq2rrl2zizlyqygf5kr8skfrz-nixos-system-machine-test machine # [ 85.505488] systemd[1]: Stopped target Local File Systems. machine # [ 85.508414] systemd[1]: Stopped target Remote File Systems. machine # [ 85.510964] systemd[1]: testauto.automount: Deactivated successfully. machine # [ 85.515444] systemd[1]: Unset automount testauto.automount. machine # [ 85.950818] systemd[1]: Reload requested from client PID 3615 ('.switch-to-conf') (unit backdoor.service)... machine # [ 85.953719] systemd[1]: Reloading... machine # [ 86.568579] systemd[1]: Reloading finished in 612 ms. machine # [ 86.718344] systemd[621]: Reexecution requested from client PID 3684 ('switch-to-confi')... machine # [ 86.722685] systemd[621]: Reexecuting. machine # [ 86.753652] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 86.931133] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 86.938959] systemd[621]: Reload requested from client PID 3684 ('switch-to-confi')... machine # [ 86.941643] systemd[621]: Reloading... machine # [ 87.109118] systemd[621]: Reloading finished in 164 ms. machine # [ 87.115057] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 87.125703] systemd[621]: Stopped Run user-specific NixOS activation. machine # [ 87.128384] systemd[621]: Stopping Run user-specific NixOS activation... machine # [ 87.132281] systemd[621]: Starting Run user-specific NixOS activation... machine # [ 87.176120] systemd[621]: Finished Run user-specific NixOS activation. machine # [ 87.181975] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 87.183893] systemd[1]: Stopping Reactivate sysinit units... machine # [ 87.186297] systemd[1]: Reached target Reactivate sysinit units. machine # [ 87.188697] systemd[1]: Reached target Remote File Systems. machine # [ 87.191424] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 87.194203] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 87.199824] systemd[1]: Reached target Local File Systems. machine # [ 87.202370] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 87.208399] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 87.211094] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 87.213306] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 87.218983] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 87.225316] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 87.227614] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 87.579868] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 87.583104] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 87.589371] systemd[1]: Starting linger-users.service... machine # [ 87.647103] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 87.649771] systemd[1]: Finished linger-users.service. machine # [ 87.910204] nixos[3615]: finished switching to system configuration /nix/store/2dxnd94gq2rrl2zizlyqygf5kr8skfrz-nixos-system-machine-test machine: (finished: must succeed: /nix/store/2dxnd94gq2rrl2zizlyqygf5kr8skfrz-nixos-system-machine-test/bin/switch-to-configuration test 2>&1, in 3.06 seconds) (finished: subtest: fstab mounts, in 37.77 seconds) subtest: swaps machine: must succeed: /nix/store/2dxnd94gq2rrl2zizlyqygf5kr8skfrz-nixos-system-machine-test/specialisation/swap/bin/switch-to-configuration test 2>&1 machine # [ 88.655452] nixos[3755]: switching to system configuration /nix/store/63nhlld7gr5n0pnm0hx9k5kqpbbaqkki-nixos-system-machine-test machine # [ 88.659513] systemd[1]: Stopped target Remote File Systems. machine # [ 88.662908] systemd[1]: Stopped target Local File Systems. machine # [ 89.180352] systemd[1]: Reload requested from client PID 3755 ('.switch-to-conf') (unit backdoor.service)... machine # [ 89.183198] systemd[1]: Reloading... machine # [ 89.839410] systemd[1]: Reloading finished in 653 ms. machine # [ 89.987954] systemd[621]: Reexecution requested from client PID 3824 ('switch-to-confi')... machine # [ 89.992184] systemd[621]: Reexecuting. machine # [ 90.021496] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 90.186774] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 90.196105] systemd[621]: Reload requested from client PID 3824 ('switch-to-confi')... machine # [ 90.198726] systemd[621]: Reloading... machine # [ 90.366608] systemd[621]: Reloading finished in 164 ms. machine # [ 90.371987] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 90.383670] systemd[621]: Stopped Run user-specific NixOS activation. machine # [ 90.385368] systemd[621]: Stopping Run user-specific NixOS activation... machine # [ 90.389692] systemd[621]: Starting Run user-specific NixOS activation... machine # [ 90.433329] systemd[621]: Finished Run user-specific NixOS activation. machine # [ 90.437971] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 90.440248] systemd[1]: Stopping Reactivate sysinit units... machine # [ 90.442188] systemd[1]: Reached target Reactivate sysinit units. machine # [ 90.445596] systemd[1]: Reached target Remote File Systems. machine # [ 90.450439] systemd[1]: Starting linger-users.service... machine # [ 90.457238] systemd[1]: Starting Initialisation of swap device /swapfile... machine # [ 90.473676] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 90.476422] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 90.488108] systemd[1]: Reached target Local File Systems. machine # [ 90.489827] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 90.495286] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 90.496848] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 90.501228] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 90.505106] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 90.508334] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 90.511537] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 90.575713] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 90.578693] systemd[1]: Finished linger-users.service. machine # [ 90.608501] mkswap-swapfile-start[3837]: Creating swap file using dd and mkswap. machine # [ 90.641213] mkswap-swapfile-start[3859]: 1+0 records in machine # [ 90.642783] mkswap-swapfile-start[3859]: 1+0 records out machine # [ 90.644400] mkswap-swapfile-start[3859]: 1048576 bytes (1.0 MB, 1.0 MiB) copied, 0.00249724 s, 420 MB/s machine # [ 90.666536] mkswap-swapfile-start[3862]: Setting up swapspace version 1, size = 1020 KiB (1044480 bytes) machine # [ 90.669111] mkswap-swapfile-start[3862]: no label, UUID=d3235095-ba04-47a5-be0b-207473c293bb machine # [ 90.674239] systemd[1]: mkswap-swapfile.service: Deactivated successfully. machine # [ 90.677521] systemd[1]: Finished Initialisation of swap device /swapfile. machine # [ 90.681324] systemd[1]: mkswap-swapfile.service: Consumed 33ms CPU time over 220ms wall clock time, 3.2M memory peak, 1M written to disk. machine # [ 90.687232] systemd[1]: Activating swap /swapfile... machine # [ 90.988332] Adding 1020k swap on /swapfile. Priority:-2 extents:1 across:1020k machine # [ 90.734400] systemd[1]: Activated swap /swapfile. machine # [ 90.941638] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 90.945987] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 91.204754] nixos[3755]: finished switching to system configuration /nix/store/63nhlld7gr5n0pnm0hx9k5kqpbbaqkki-nixos-system-machine-test machine: (finished: must succeed: /nix/store/2dxnd94gq2rrl2zizlyqygf5kr8skfrz-nixos-system-machine-test/specialisation/swap/bin/switch-to-configuration test 2>&1, in 3.30 seconds) machine: must succeed: /nix/store/2dxnd94gq2rrl2zizlyqygf5kr8skfrz-nixos-system-machine-test/bin/switch-to-configuration test 2>&1 machine # [ 91.922749] systemd[1]: swapfile.swap: Deactivated successfully. machine # [ 91.925484] nixos[3909]: switching to system configuration /nix/store/2dxnd94gq2rrl2zizlyqygf5kr8skfrz-nixos-system-machine-test machine # [ 91.930584] systemd[1]: Stopped target Local File Systems. machine # [ 91.932839] systemd[1]: Stopped target Remote File Systems. machine # [ 92.384397] systemd[1]: Reload requested from client PID 3909 ('.switch-to-conf') (unit backdoor.service)... machine # [ 92.389173] systemd[1]: Reloading... machine # [ 93.006130] systemd[1]: Reloading finished in 614 ms. machine # [ 93.157381] systemd[621]: Reexecution requested from client PID 3978 ('switch-to-confi')... machine # [ 93.161094] systemd[621]: Reexecuting. machine # [ 93.188737] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 93.356650] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 93.364962] systemd[621]: Reload requested from client PID 3978 ('switch-to-confi')... machine # [ 93.367779] systemd[621]: Reloading... machine # [ 93.536440] systemd[621]: Reloading finished in 166 ms. machine # [ 93.542070] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 93.553531] systemd[621]: Stopped Run user-specific NixOS activation. machine # [ 93.555321] systemd[621]: Stopping Run user-specific NixOS activation... machine # [ 93.559410] systemd[621]: Starting Run user-specific NixOS activation... machine # [ 93.600724] systemd[621]: Finished Run user-specific NixOS activation. machine # [ 93.605682] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 93.609212] systemd[1]: Stopping Reactivate sysinit units... machine # [ 93.610836] systemd[1]: Reached target Reactivate sysinit units. machine # [ 93.613540] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 93.617196] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 93.622915] systemd[1]: Reached target Remote File Systems. machine # [ 93.627491] systemd[1]: Starting linger-users.service... machine # [ 93.635700] systemd[1]: Reached target Local File Systems. machine # [ 93.643658] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 93.651275] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 93.654685] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 93.657652] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 93.663265] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 93.668153] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 93.670862] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 93.725398] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 93.729301] systemd[1]: Finished linger-users.service. machine # [ 94.027416] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 94.031676] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 94.290607] nixos[3909]: finished switching to system configuration /nix/store/2dxnd94gq2rrl2zizlyqygf5kr8skfrz-nixos-system-machine-test machine: (finished: must succeed: /nix/store/2dxnd94gq2rrl2zizlyqygf5kr8skfrz-nixos-system-machine-test/bin/switch-to-configuration test 2>&1, in 3.09 seconds) (finished: subtest: swaps, in 6.38 seconds) (finished: run the VM test script, in 95.70 seconds) test script finished in 95.77s cleanup kill QemuMachine (pid 45) machine # qemu-system-x86_64: terminating on signal 15 from pid 39 (/nix/store/b5bpi6zfajzzrwwpgba2q6li3nnya4bs-python3-3.14.7/bin/python3.14) (finished: cleanup, in 0.14 seconds) additionally exposed symbols: machine, other, 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