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 # Disk image does not exist, creating the virtualisation disk image... machine: QEMU running (pid 45) machine # Formatting '/build/vm-state-machine/tmp.AjrwuQErZL', 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: 32355387-bda8-4296-bbcd-b0318f4a296c 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 # Starting virtiofs daemons... machine # [2026-09-27T03:18:36Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1) machine # [2026-09-27T03:18:36Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether machine # [2026-09-27T03:18:36Z INFO virtiofsd] Waiting for vhost-user socket connection... machine # [2026-09-27T03:18:36Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1) machine # [2026-09-27T03:18:36Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether machine # [2026-09-27T03:18:36Z INFO virtiofsd] Waiting for vhost-user socket connection... machine # [2026-09-27T03:18:36Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1) machine # [2026-09-27T03:18:36Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether machine # [2026-09-27T03:18:36Z INFO virtiofsd] Waiting for vhost-user socket connection... machine # [2026-09-27T03:18:36Z INFO virtiofsd] Client connected, servicing requests machine # [2026-09-27T03:18:36Z INFO virtiofsd] Client connected, servicing requests machine # [2026-09-27T03:18:36Z INFO virtiofsd] Client connected, servicing requests machine # SeaBIOS (version rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org) machine # machine # machine # iPXE (http://ipxe.org) 00:02.0 CA00 PCI2.10 PnP PMM+3EFCC730+3EF2C730 CA00 machine # Press Ctrl-B to configure iPXE (PCI 00:02.0)... machine # machine # machine # machine # machine # iPXE (http://ipxe.org) 00:05.0 CB00 PCI2.10 PnP PMM 3EFCC730 3EF2C730 CB00 machine # Press Ctrl-B to configure iPXE (PCI 00:05.0)... machine # machine # machine # Booting from ROM... machine # Probing EDD (edd=off to disable)... ok[ 0.000000] Linux version 6.18.53 (nixbld@localhost) (gcc (GCC) 15.3.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT_DYNAMIC Mon Sep 21 13:06:06 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/bjj1c5xdq9j21a84h34012nm3dspv0yf-nixos-system-machine-test/init regInfo=/nix/.ro-store/jhqmv2g525mr1yw1fjq1hy3cbqi6zzk1-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.000000] kvm-clock: using sched offset of 496048140 cycles machine # [ 0.000002] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns machine # [ 0.000004] tsc: Detected 2400.012 MHz processor machine # [ 0.000804] last_pfn = 0x3ffd8 max_arch_pfn = 0x10000000000 machine # [ 0.000832] MTRR map: 4 entries (3 fixed + 1 variable; max 19), built from 8 variable MTRRs machine # [ 0.000835] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT machine # [ 0.002727] found SMP MP-table at [mem 0x000f5450-0x000f545f] machine # [ 0.002739] Using GB pages for direct mapping machine # [ 0.002802] RAMDISK: [mem 0x3e428000-0x3ffcffff] machine # [ 0.002809] ACPI: Early table checksum verification disabled machine # [ 0.002813] ACPI: RSDP 0x00000000000F5270 000014 (v00 BOCHS ) machine # [ 0.002817] ACPI: RSDT 0x000000003FFE2422 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) machine # [ 0.002821] ACPI: FACP 0x000000003FFE221A 0000F4 (v03 BOCHS BXPC 00000001 BXPC 00000001) machine # [ 0.002828] ACPI: DSDT 0x000000003FFE0040 0021DA (v01 BOCHS BXPC 00000001 BXPC 00000001) machine # [ 0.002830] ACPI: FACS 0x000000003FFE0000 000040 machine # [ 0.002831] ACPI: APIC 0x000000003FFE230E 000078 (v03 BOCHS BXPC 00000001 BXPC 00000001) machine # [ 0.002833] ACPI: HPET 0x000000003FFE2386 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) machine # [ 0.002834] ACPI: MCFG 0x000000003FFE23BE 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001) machine # [ 0.002836] ACPI: WAET 0x000000003FFE23FA 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001) machine # [ 0.002837] ACPI: Reserving FACP table memory at [mem 0x3ffe221a-0x3ffe230d] machine # [ 0.002838] ACPI: Reserving DSDT table memory at [mem 0x3ffe0040-0x3ffe2219] machine # [ 0.002839] ACPI: Reserving FACS table memory at [mem 0x3ffe0000-0x3ffe003f] machine # [ 0.002839] ACPI: Reserving APIC table memory at [mem 0x3ffe230e-0x3ffe2385] machine # [ 0.002840] ACPI: Reserving HPET table memory at [mem 0x3ffe2386-0x3ffe23bd] machine # [ 0.002840] ACPI: Reserving MCFG table memory at [mem 0x3ffe23be-0x3ffe23f9] machine # [ 0.002841] ACPI: Reserving WAET table memory at [mem 0x3ffe23fa-0x3ffe2421] machine # [ 0.003093] No NUMA configuration found machine # [ 0.003094] Faking a node at [mem 0x0000000000000000-0x000000003ffd7fff] machine # [ 0.003096] NODE_DATA(0) allocated [mem 0x3ffd2780-0x3ffd7cff] machine # [ 0.005889] Zone ranges: machine # [ 0.005890] DMA [mem 0x0000000000001000-0x0000000000ffffff] machine # [ 0.005891] DMA32 [mem 0x0000000001000000-0x000000003ffd7fff] machine # [ 0.005892] Normal empty machine # [ 0.005893] Device empty machine # [ 0.005894] Movable zone start for each node machine # [ 0.005895] Early memory node ranges machine # [ 0.005895] node 0: [mem 0x0000000000001000-0x000000000009efff] machine # [ 0.005896] node 0: [mem 0x0000000000100000-0x000000003ffd7fff] machine # [ 0.005897] Initmem setup node 0 [mem 0x0000000000001000-0x000000003ffd7fff] machine # [ 0.005917] On node 0, zone DMA: 1 pages in unavailable ranges machine # [ 0.006196] On node 0, zone DMA: 97 pages in unavailable ranges machine # [ 0.024992] On node 0, zone DMA32: 40 pages in unavailable ranges machine # [ 0.025455] ACPI: PM-Timer IO Port: 0x608 machine # [ 0.025466] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) machine # [ 0.025493] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 machine # [ 0.025496] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) machine # [ 0.025498] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) machine # [ 0.025499] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) machine # [ 0.025500] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) machine # [ 0.025501] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) machine # [ 0.025503] ACPI: Using ACPI (MADT) for SMP configuration information machine # [ 0.025504] ACPI: HPET id: 0x8086a201 base: 0xfed00000 machine # [ 0.025507] TSC deadline timer available machine # [ 0.025512] CPU topo: Max. logical packages: 1 machine # [ 0.025512] CPU topo: Max. logical dies: 1 machine # [ 0.025513] CPU topo: Max. dies per package: 1 machine # [ 0.025516] CPU topo: Max. threads per core: 1 machine # [ 0.025517] CPU topo: Num. cores per package: 1 machine # [ 0.025517] CPU topo: Num. threads per package: 1 machine # [ 0.025518] CPU topo: Allowing 1 present CPUs plus 0 hotplug CPUs machine # [ 0.025536] kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write() machine # [ 0.025564] PM: hibernation: Registered nosave memory: [mem 0x00000000-0x00000fff] machine # [ 0.025566] PM: hibernation: Registered nosave memory: [mem 0x0009f000-0x000fffff] machine # [ 0.025567] [mem 0x40000000-0xafffffff] available for PCI devices machine # [ 0.025568] Booting paravirtualized kernel on KVM machine # [ 0.025571] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns machine # [ 0.030024] setup_percpu: NR_CPUS:384 nr_cpumask_bits:1 nr_cpu_ids:1 nr_node_ids:1 machine # [ 0.032311] percpu: Embedded 98 pages/cpu s278528 r8192 d114688 u2097152 machine # [ 0.032356] kvm-guest: PV spinlocks disabled, single CPU machine # [ 0.032357] 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/bjj1c5xdq9j21a84h34012nm3dspv0yf-nixos-system-machine-test/init regInfo=/nix/.ro-store/jhqmv2g525mr1yw1fjq1hy3cbqi6zzk1-closure-info/registration console=ttyS0,115200n8 console=tty0 machine # [ 0.032451] Unknown kernel command line parameters "regInfo=/nix/.ro-store/jhqmv2g525mr1yw1fjq1hy3cbqi6zzk1-closure-info/registration", will be passed to user space. machine # [ 0.032463] random: crng init done machine # [ 0.032464] printk: log buffer data + meta data: 262144 + 917504 = 1179648 bytes machine # [ 0.032485] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes, linear) machine # [ 0.032498] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes, linear) machine # [ 0.032528] Fallback order for Node 0: 0 machine # [ 0.032531] Built 1 zonelists, mobility grouping on. Total pages: 262006 machine # [ 0.032532] Policy zone: DMA32 machine # [ 0.035117] mem auto-init: stack:all(zero), heap alloc:on, heap free:off machine # [ 0.037627] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1 machine # [ 0.040235] allocated 2097152 bytes of page_ext machine # [ 0.050135] ftrace: allocating 48798 entries in 192 pages machine # [ 0.050137] ftrace: allocated 192 pages with 2 groups machine # [ 0.051012] Dynamic Preempt: lazy machine # [ 0.051191] rcu: Preemptible hierarchical RCU implementation. machine # [ 0.051191] rcu: RCU event tracing is enabled. machine # [ 0.051192] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1. machine # [ 0.051194] Trampoline variant of Tasks RCU enabled. machine # [ 0.051195] Rude variant of Tasks RCU enabled. machine # [ 0.051195] Tracing variant of Tasks RCU enabled. machine # [ 0.051196] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. machine # [ 0.051197] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1 machine # [ 0.051211] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. machine # [ 0.051213] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. machine # [ 0.051213] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. machine # [ 0.055636] NR_IRQS: 24832, nr_irqs: 256, preallocated irqs: 16 machine # [ 0.055908] rcu: srcu_init: Setting srcu_struct sizes based on contention. machine # [ 0.055914] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns machine # [ 0.056029] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____) machine # [ 0.059566] Console: colour VGA+ 80x25 machine # [ 0.059569] printk: legacy console [tty0] enabled machine # [ 0.089265] printk: legacy console [ttyS0] enabled machine # [ 0.195721] ACPI: Core revision 20250807 machine # [ 0.196673] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns machine # [ 0.198338] APIC: Switch to symmetric I/O mode setup machine # [ 0.199389] x2apic enabled machine # [ 0.200152] APIC: Switched APIC routing to: physical x2apic machine # [ 0.202037] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 machine # [ 0.203076] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x229842dd0bd, max_idle_ns: 440795319571 ns machine # [ 0.204827] Calibrating delay loop (skipped) preset value.. 4800.02 BogoMIPS (lpj=2400012) machine # [ 0.206860] x86/cpu: User Mode Instruction Prevention (UMIP) activated machine # [ 0.207960] Last level iTLB entries: 4KB 512, 2MB 255, 4MB 127 machine # [ 0.208824] Last level dTLB entries: 4KB 512, 2MB 255, 4MB 127, 1GB 0 machine # [ 0.209827] mitigations: Enabled attack vectors: user_kernel, user_user, guest_host, guest_guest, SMT mitigations: auto machine # [ 0.210824] Speculative Store Bypass: Mitigation: Speculative Store Bypass disabled via prctl machine # [ 0.211824] Transient Scheduler Attacks: Vulnerable: No microcode machine # [ 0.212823] Spectre V2 : Mitigation: Enhanced / Automatic IBRS machine # [ 0.214573] Speculative Return Stack Overflow: Mitigation: Safe RET machine # [ 0.215633] Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization machine # [ 0.216832] Spectre V2 : Enabling IBPB for BPF machine # [ 0.218405] Spectre V2 : mitigation: Enabling conditional Indirect Branch Prediction Barrier machine # [ 0.219824] active return thunk: srso_alias_return_thunk machine # [ 0.220846] x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers' machine # [ 0.221824] x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers' machine # [ 0.222824] x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers' machine # [ 0.223823] x86/fpu: Supporting XSAVE feature 0x020: 'AVX-512 opmask' machine # [ 0.224824] x86/fpu: Supporting XSAVE feature 0x040: 'AVX-512 Hi256' machine # [ 0.225823] x86/fpu: Supporting XSAVE feature 0x080: 'AVX-512 ZMM_Hi256' machine # [ 0.226824] x86/fpu: Supporting XSAVE feature 0x200: 'Protection Keys User registers' machine # [ 0.228824] x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256 machine # [ 0.229824] x86/fpu: xstate_offset[5]: 832, xstate_sizes[5]: 64 machine # [ 0.230823] x86/fpu: xstate_offset[6]: 896, xstate_sizes[6]: 512 machine # [ 0.231824] x86/fpu: xstate_offset[7]: 1408, xstate_sizes[7]: 1024 machine # [ 0.232824] x86/fpu: xstate_offset[9]: 2432, xstate_sizes[9]: 8 machine # [ 0.233824] x86/fpu: Enabled xstate features 0x2e7, context size is 2440 bytes, using 'compacted' format. machine # [ 0.268082] Freeing SMP alternatives memory: 44K machine # [ 0.268827] pid_max: default: 32768 minimum: 301 machine # [ 0.269901] LSM: initializing lsm=capability,landlock,yama,bpf,ima machine # [ 0.270938] landlock: Up and running. machine # [ 0.271586] Yama: becoming mindful. machine # [ 0.272495] LSM support for eBPF active machine # [ 0.272937] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear) machine # [ 0.273847] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear) machine # [ 0.277164] smpboot: CPU0: AMD EPYC 9654 96-Core Processor (family: 0x19, model: 0x11, stepping: 0x1) machine # [ 0.278392] Performance Events: Fam17h+ core perfctr, AMD PMU driver. machine # [ 0.278833] ... version: 2 machine # [ 0.279596] ... bit width: 48 machine # [ 0.279826] ... generic counters: 6 machine # [ 0.280561] ... generic bitmap: 000000000000003f machine # [ 0.280826] ... fixed-purpose counters: 0 machine # [ 0.281588] ... fixed-purpose bitmap: 0000000000000000 machine # [ 0.281826] ... value mask: 0000ffffffffffff machine # [ 0.282785] ... max period: 00007fffffffffff machine # [ 0.283566] ... global_ctrl mask: 000000000000003f machine # [ 0.283923] signal: max sigframe size: 3376 machine # [ 0.284857] rcu: Hierarchical SRCU implementation. machine # [ 0.285750] rcu: Max phase no-delay instances is 400. machine # [ 0.291185] smp: Bringing up secondary CPUs ... machine # [ 0.291841] smp: Brought up 1 node, 1 CPU machine # [ 0.292565] smpboot: Total of 1 processors activated (4800.02 BogoMIPS) machine # [ 0.293020] Memory: 941804K/1048024K available (17259K kernel code, 2728K rwdata, 13652K rodata, 3656K init, 2968K bss, 98844K reserved, 0K cma-reserved) machine # [ 0.294061] devtmpfs: initialized machine # [ 0.294909] x86/mm: Memory block size: 128MB machine # [ 0.296637] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear) machine # [ 0.297806] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear). machine # [ 0.298917] pinctrl core: initialized pinctrl subsystem machine # [ 0.300205] PM: RTC time: 03:18:36, date: 2026-09-27 machine # [ 0.303663] NET: Registered PF_NETLINK/PF_ROUTE protocol family machine # [ 0.304937] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations machine # [ 0.305843] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations machine # [ 0.306973] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations machine # [ 0.307836] audit: initializing netlink subsys (disabled) machine # [ 0.309060] thermal_sys: Registered thermal governor 'fair_share' machine # [ 0.309063] thermal_sys: Registered thermal governor 'bang_bang' machine # [ 0.309828] thermal_sys: Registered thermal governor 'step_wise' machine # [ 0.310830] audit: type=2000 audit(1790479117.242:1): state=initialized audit_enabled=0 res=1 machine # [ 0.312829] thermal_sys: Registered thermal governor 'user_space' machine # [ 0.312830] thermal_sys: Registered thermal governor 'power_allocator' machine # [ 0.313840] cpuidle: using governor menu machine # [ 0.316111] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 machine # [ 0.317059] PCI: ECAM [mem 0xb0000000-0xbfffffff] (base 0xb0000000) for domain 0000 [bus 00-ff] machine # [ 0.317829] PCI: ECAM [mem 0xb0000000-0xbfffffff] reserved as E820 entry machine # [ 0.318840] PCI: Using configuration type 1 for base access machine # [ 0.320005] kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible. machine # [ 0.325073] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages machine # [ 0.325827] HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page machine # [ 0.330827] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages machine # [ 0.331827] HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page machine # [ 0.342174] ACPI: Added _OSI(Module Device) machine # [ 0.342828] ACPI: Added _OSI(Processor Device) machine # [ 0.343627] ACPI: Added _OSI(Processor Aggregator Device) machine # [ 0.350728] ACPI: 1 ACPI AML tables successfully acquired and loaded machine # [ 0.356716] ACPI: Interpreter enabled machine # [ 0.357308] ACPI: PM: (supports S0 S3 S4 S5) machine # [ 0.357827] ACPI: Using IOAPIC for interrupt routing machine # [ 0.358765] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug machine # [ 0.363827] PCI: Using E820 reservations for host bridge windows machine # [ 0.364965] ACPI: Enabled 2 GPEs in block 00 to 3F machine # [ 0.372575] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) machine # [ 0.372834] acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] machine # [ 0.373921] acpi PNP0A08:00: _OSC: platform does not support [PCIeHotplug LTR] machine # [ 0.374952] acpi PNP0A08:00: _OSC: OS now controls [PME AER PCIeCapability] machine # [ 0.376170] PCI host bridge to bus 0000:00 machine # [ 0.376831] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] machine # [ 0.377827] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] machine # [ 0.378827] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] machine # [ 0.379827] pci_bus 0000:00: root bus resource [mem 0x40000000-0xafffffff window] machine # [ 0.380826] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window] machine # [ 0.381826] pci_bus 0000:00: root bus resource [mem 0x100000000-0x8ffffffff window] machine # [ 0.382828] pci_bus 0000:00: root bus resource [bus 00-ff] machine # [ 0.383916] pci 0000:00:00.0: [8086:29c0] type 00 class 0x060000 conventional PCI endpoint machine # [ 0.385273] pci 0000:00:01.0: [1234:1111] type 00 class 0x030000 conventional PCI endpoint machine # [ 0.387922] pci 0000:00:01.0: BAR 0 [mem 0xfd000000-0xfdffffff pref] machine # [ 0.388839] pci 0000:00:01.0: BAR 2 [mem 0xfebd0000-0xfebd0fff] machine # [ 0.389848] pci 0000:00:01.0: ROM [mem 0xfebc0000-0xfebcffff pref] machine # [ 0.391434] pci 0000:00:01.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff] machine # [ 0.392565] pci 0000:00:02.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint machine # [ 0.395864] pci 0000:00:02.0: BAR 0 [io 0xc100-0xc11f] machine # [ 0.396785] pci 0000:00:02.0: BAR 1 [mem 0xfebd1000-0xfebd1fff] machine # [ 0.397624] pci 0000:00:02.0: BAR 4 [mem 0xfe000000-0xfe003fff 64bit pref] machine # [ 0.398761] pci 0000:00:02.0: ROM [mem 0xfeb40000-0xfeb7ffff pref] machine # [ 0.400469] pci 0000:00:03.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint machine # [ 0.402788] pci 0000:00:03.0: BAR 0 [io 0xc120-0xc13f] machine # [ 0.403532] pci 0000:00:03.0: BAR 1 [mem 0xfebd2000-0xfebd2fff] machine # [ 0.403849] pci 0000:00:03.0: BAR 4 [mem 0xfe004000-0xfe007fff 64bit pref] machine # [ 0.405377] pci 0000:00:04.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint machine # [ 0.408815] pci 0000:00:04.0: BAR 0 [io 0xc000-0xc07f] machine # [ 0.409528] pci 0000:00:04.0: BAR 1 [mem 0xfebd3000-0xfebd3fff] machine # [ 0.409856] pci 0000:00:04.0: BAR 4 [mem 0xfe008000-0xfe00bfff 64bit pref] machine # [ 0.411412] pci 0000:00:05.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint machine # [ 0.413667] pci 0000:00:05.0: BAR 0 [io 0xc140-0xc15f] machine # [ 0.414543] pci 0000:00:05.0: BAR 1 [mem 0xfebd4000-0xfebd4fff] machine # [ 0.414850] pci 0000:00:05.0: BAR 4 [mem 0xfe00c000-0xfe00ffff 64bit pref] machine # [ 0.415833] pci 0000:00:05.0: ROM [mem 0xfeb80000-0xfebbffff pref] machine # [ 0.417403] pci 0000:00:06.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint machine # [ 0.418871] pci 0000:00:06.0: BAR 1 [mem 0xfebd5000-0xfebd5fff] machine # [ 0.419848] pci 0000:00:06.0: BAR 4 [mem 0xfe010000-0xfe013fff 64bit pref] machine # [ 0.421413] pci 0000:00:07.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint machine # [ 0.423839] pci 0000:00:07.0: BAR 1 [mem 0xfebd6000-0xfebd6fff] machine # [ 0.424848] pci 0000:00:07.0: BAR 4 [mem 0xfe014000-0xfe017fff 64bit pref] machine # [ 0.426456] pci 0000:00:08.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint machine # [ 0.427873] pci 0000:00:08.0: BAR 1 [mem 0xfebd7000-0xfebd7fff] machine # [ 0.428849] pci 0000:00:08.0: BAR 4 [mem 0xfe018000-0xfe01bfff 64bit pref] machine # [ 0.430368] pci 0000:00:09.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint machine # [ 0.431872] pci 0000:00:09.0: BAR 1 [mem 0xfebd8000-0xfebd8fff] machine # [ 0.432848] pci 0000:00:09.0: BAR 4 [mem 0xfe01c000-0xfe01ffff 64bit pref] machine # [ 0.434402] pci 0000:00:0a.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint machine # [ 0.436703] pci 0000:00:0a.0: BAR 0 [io 0xc080-0xc0bf] machine # [ 0.437537] pci 0000:00:0a.0: BAR 1 [mem 0xfebd9000-0xfebd9fff] machine # [ 0.437849] pci 0000:00:0a.0: BAR 4 [mem 0xfe020000-0xfe023fff 64bit pref] machine # [ 0.439420] pci 0000:00:0b.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint machine # [ 0.441597] pci 0000:00:0b.0: BAR 0 [io 0xc160-0xc17f] machine # [ 0.441834] pci 0000:00:0b.0: BAR 1 [mem 0xfebda000-0xfebdafff] machine # [ 0.442848] pci 0000:00:0b.0: BAR 4 [mem 0xfe024000-0xfe027fff 64bit pref] machine # [ 0.444420] pci 0000:00:1d.0: [8086:2934] type 00 class 0x0c0300 conventional PCI endpoint machine # [ 0.446351] pci 0000:00:1d.0: BAR 4 [io 0xc180-0xc19f] machine # [ 0.447028] pci 0000:00:1d.1: [8086:2935] type 00 class 0x0c0300 conventional PCI endpoint machine # [ 0.448633] pci 0000:00:1d.1: BAR 4 [io 0xc1a0-0xc1bf] machine # [ 0.449782] pci 0000:00:1d.2: [8086:2936] type 00 class 0x0c0300 conventional PCI endpoint machine # [ 0.451521] pci 0000:00:1d.2: BAR 4 [io 0xc1c0-0xc1df] machine # [ 0.452053] pci 0000:00:1d.7: [8086:293a] type 00 class 0x0c0320 conventional PCI endpoint machine # [ 0.455835] pci 0000:00:1d.7: BAR 0 [mem 0xfebdb000-0xfebdbfff] machine # [ 0.457137] pci 0000:00:1f.0: [8086:2918] type 00 class 0x060100 conventional PCI endpoint machine # [ 0.458123] pci 0000:00:1f.0: quirk: [io 0x0600-0x067f] claimed by ICH6 ACPI/GPIO/TCO machine # [ 0.459073] pci 0000:00:1f.2: [8086:2922] type 00 class 0x010601 conventional PCI endpoint machine # [ 0.461751] pci 0000:00:1f.2: BAR 4 [io 0xc1e0-0xc1ff] machine # [ 0.462509] pci 0000:00:1f.2: BAR 5 [mem 0xfebdc000-0xfebdcfff] machine # [ 0.463942] pci 0000:00:1f.3: [8086:2930] type 00 class 0x0c0500 conventional PCI endpoint machine # [ 0.465715] pci 0000:00:1f.3: BAR 4 [io 0x0700-0x073f] machine # [ 0.469665] ACPI: PCI: Interrupt link LNKA configured for IRQ 10 machine # [ 0.470747] ACPI: PCI: Interrupt link LNKB configured for IRQ 10 machine # [ 0.471731] ACPI: PCI: Interrupt link LNKC configured for IRQ 11 machine # [ 0.472929] ACPI: PCI: Interrupt link LNKD configured for IRQ 11 machine # [ 0.473926] ACPI: PCI: Interrupt link LNKE configured for IRQ 10 machine # [ 0.474924] ACPI: PCI: Interrupt link LNKF configured for IRQ 10 machine # [ 0.475927] ACPI: PCI: Interrupt link LNKG configured for IRQ 11 machine # [ 0.476924] ACPI: PCI: Interrupt link LNKH configured for IRQ 11 machine # [ 0.477864] ACPI: PCI: Interrupt link GSIA configured for IRQ 16 machine # [ 0.478842] ACPI: PCI: Interrupt link GSIB configured for IRQ 17 machine # [ 0.479841] ACPI: PCI: Interrupt link GSIC configured for IRQ 18 machine # [ 0.480839] ACPI: PCI: Interrupt link GSID configured for IRQ 19 machine # [ 0.481838] ACPI: PCI: Interrupt link GSIE configured for IRQ 20 machine # [ 0.482838] ACPI: PCI: Interrupt link GSIF configured for IRQ 21 machine # [ 0.483848] ACPI: PCI: Interrupt link GSIG configured for IRQ 22 machine # [ 0.484839] ACPI: PCI: Interrupt link GSIH configured for IRQ 23 machine # [ 0.487027] iommu: Default domain type: Translated machine # [ 0.487867] iommu: DMA domain TLB invalidation policy: lazy mode machine # [ 0.489116] ACPI: bus type USB registered machine # [ 0.490454] usbcore: registered new interface driver usbfs machine # [ 0.490844] usbcore: registered new interface driver hub machine # [ 0.491848] usbcore: registered new device driver usb machine # [ 0.493612] NetLabel: Initializing machine # [ 0.493833] NetLabel: domain hash size = 128 machine # [ 0.494624] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO machine # [ 0.495641] NetLabel: unlabeled traffic allowed by default machine # [ 0.496587] PCI: Using ACPI for IRQ routing machine # [ 0.540340] pci 0000:00:01.0: vgaarb: setting as boot VGA device machine # [ 0.540823] pci 0000:00:01.0: vgaarb: bridge control possible machine # [ 0.540823] pci 0000:00:01.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none machine # [ 0.540831] vgaarb: loaded machine # [ 0.541604] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 machine # [ 0.542463] hpet0: 3 comparators, 64-bit 100.000000 MHz counter machine # [ 0.545922] clocksource: Switched to clocksource kvm-clock machine # [ 0.547702] VFS: Disk quotas dquot_6.6.0 machine # [ 0.550250] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) machine # [ 0.551699] pnp: PnP ACPI init machine # [ 0.552555] ACPI: IRQ 4 override to edge(!), high(!) machine # [ 0.553661] system 00:04: [mem 0xb0000000-0xbfffffff window] has been reserved machine # [ 0.555253] pnp: PnP ACPI: found 5 devices machine # [ 0.563182] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns machine # [ 0.564720] clocksource: Switched to clocksource acpi_pm machine # [ 0.565734] NET: Registered PF_INET protocol family machine # [ 0.566823] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear) machine # [ 0.583861] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear) machine # [ 0.585488] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) machine # [ 0.586847] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear) machine # [ 0.588238] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear) machine # [ 0.589513] TCP: Hash tables configured (established 8192 bind 8192) machine # [ 0.590668] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear) machine # [ 0.592027] UDP hash table entries: 512 (order: 3, 32768 bytes, linear) machine # [ 0.593243] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear) machine # [ 0.594518] NET: Registered PF_UNIX/PF_LOCAL protocol family machine # [ 0.595538] NET: Registered PF_XDP protocol family machine # [ 0.596453] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] machine # [ 0.597520] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] machine # [ 0.598625] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] machine # [ 0.599781] pci_bus 0000:00: resource 7 [mem 0x40000000-0xafffffff window] machine # [ 0.600933] pci_bus 0000:00: resource 8 [mem 0xc0000000-0xfebfffff window] machine # [ 0.602117] pci_bus 0000:00: resource 9 [mem 0x100000000-0x8ffffffff window] machine # [ 0.603950] ACPI: \_SB_.GSIA: Enabled at IRQ 16 machine # [ 0.606402] ACPI: \_SB_.GSIB: Enabled at IRQ 17 machine # [ 0.608353] ACPI: \_SB_.GSIC: Enabled at IRQ 18 machine # [ 0.610321] ACPI: \_SB_.GSID: Enabled at IRQ 19 machine # [ 0.612035] PCI: CLS 0 bytes, default 64 machine # [ 0.613038] Trying to unpack rootfs image as initramfs... machine # [ 0.617459] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x229842dd0bd, max_idle_ns: 440795319571 ns machine # [ 0.658374] Initialise system trusted keyrings machine # [ 0.660984] workingset: timestamp_bits=40 max_order=18 bucket_order=0 machine # [ 0.681882] Key type asymmetric registered machine # [ 0.684943] Asymmetric key parser 'x509' registered machine # [ 0.685823] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 248) machine # [ 0.689042] io scheduler mq-deadline registered machine # [ 0.689945] io scheduler kyber registered machine # [ 0.694138] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled machine # [ 0.695483] 00:03: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A machine # [ 0.700722] Linux agpgart interface v0.103 machine # [ 0.701523] ACPI: bus type drm_connector registered machine # [ 0.706442] usbcore: registered new interface driver usbserial_generic machine # [ 0.707599] usbserial: USB Serial support registered for generic machine # [ 0.710945] amd_pstate: The CPPC feature is supported but currently disabled by the BIOS. machine # [ 0.710945] Please enable it if your BIOS has the CPPC option. machine # [ 0.713413] amd_pstate: the _CPC object is not present in SBIOS or ACPI disabled machine # [ 0.717074] drop_monitor: Initializing network drop monitor service machine # [ 0.718334] NET: Registered PF_INET6 protocol family machine # [ 0.722423] Segment Routing with IPv6 machine # [ 0.725943] In-situ OAM (IOAM) with IPv6 machine # [ 0.727017] IPI shorthand broadcast: enabled machine # [ 0.735374] sched_clock: Marking stable (591015866, 143908805)->(815414883, -80490212) machine # [ 0.739047] registered taskstats version 1 machine # [ 0.740036] Loading compiled-in X.509 certificates machine # [ 0.759939] Demotion targets for Node 0: null machine # [ 0.760803] Key type .fscrypt registered machine # [ 0.761551] Key type fscrypt-provisioning registered machine # [ 0.762539] ima: No TPM chip found, activating TPM-bypass! machine # [ 0.765940] ima: Allocated hash algorithm: sha1 machine # [ 0.766771] ima: No architecture policies found machine # [ 0.769937] PM: Magic number: 10:634:311 machine # [ 0.771603] RAS: Correctable Errors collector initialized. machine # [ 0.781611] clk: Disabling unused clocks machine # [ 0.784946] PM: genpd: Disabling unused power domains machine # [ 0.935966] Freeing initrd memory: 28320K machine # [ 0.939256] Freeing unused decrypted memory: 2028K machine # [ 0.942057] Freeing unused kernel image (initmem) memory: 3656K machine # [ 0.943169] Write protecting the kernel read-only data: 32768k machine # [ 0.945118] Freeing unused kernel image (text/rodata gap) memory: 1172K machine # [ 0.946742] Freeing unused kernel image (rodata/data gap) memory: 684K machine # [ 0.997720] x86/mm: Checked W+X mappings: passed, no W+X pages found. machine # [ 0.998825] Run /init as init process machine # [ 1.009877] systemd[1]: Inserted module 'autofs4' machine # [ 1.029732] fuse: init (API version 7.45) machine # [ 1.037197] ACPI: \_SB_.GSIG: Enabled at IRQ 22 machine # [ 1.040072] ACPI: \_SB_.GSIH: Enabled at IRQ 23 machine # [ 1.043411] ACPI: \_SB_.GSIE: Enabled at IRQ 20 machine # [ 1.046150] ACPI: \_SB_.GSIF: Enabled at IRQ 21 machine # [ 1.051468] virtiofs virtio5: discovered new tag: nix-store machine # [ 1.053171] virtiofs virtio5: virtio_fs_setup_dax: No cache capability machine # [ 1.060674] virtiofs virtio6: discovered new tag: shared machine # [ 1.062207] virtiofs virtio6: virtio_fs_setup_dax: No cache capability machine # [ 1.065619] virtiofs virtio7: discovered new tag: xchg machine # [ 1.067240] virtiofs virtio7: virtio_fs_setup_dax: No cache capability machine # [ 1.088900] systemd[1]: Successfully made /usr/ read-only. machine # [ 1.090710] systemd[1]: systemd 263-885fe07 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.095738] systemd[1]: Detected virtualization kvm. machine # [ 1.096614] systemd[1]: Detected architecture x86-64. machine # [ 1.097516] systemd[1]: Running in initrd. machine # [ 1.098535] systemd[1]: Initializing machine ID from random generator. machine # [ 1.099739] systemd[1]: Hostname set to . machine # [ 1.172646] systemd[1]: bpf-restrict-fs: LSM BPF program attached machine # [ 1.209384] systemd[1]: Queued start job for default target Initrd Default Target. machine # [ 1.213281] systemd[1]: Created slice Slice /system/modprobe. machine # [ 1.214509] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. machine # [ 1.216025] systemd[1]: Expecting device /dev/disk/by-label/nixos... machine # [ 1.217152] systemd[1]: Reached target Path Units. machine # [ 1.218083] systemd[1]: Reached target Slice Units. machine # [ 1.218979] systemd[1]: Reached target Swaps. machine # [ 1.219760] systemd[1]: Reached target Timer Units. machine # [ 1.220740] systemd[1]: Listening on D-Bus System Message Bus Socket. machine # [ 1.221970] systemd[1]: Listening on Journal Socket (/dev/log). machine # [ 1.223146] systemd[1]: Listening on Journal Sockets. machine # [ 1.224143] systemd[1]: Listening on udev Kernel Socket. machine # [ 1.225114] systemd[1]: Reached target Socket Units. machine # [ 1.226931] systemd[1]: Starting Create List of Static Device Nodes... machine # [ 1.230780] systemd[1]: Starting Load Kernel Module configfs... machine # [ 1.240998] systemd[1]: Starting Journal Service... machine # [ 1.253017] systemd[1]: Starting Load Kernel Modules... machine # [ 1.267842] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 1.275001] systemd[1]: Starting Coldplug All udev Devices... machine # [ 1.288479] systemd[1]: Finished Create List of Static Device Nodes. machine # [ 1.294653] systemd[1]: modprobe@configfs.service: Deactivated successfully. machine # [ 1.300992] systemd[1]: Finished Load Kernel Module configfs. machine # [ 1.303151] systemd-journald[65]: Collecting audit messages is disabled. machine # [ 1.307386] systemd[1]: Kernel Configuration File System skipped, unmet condition check ConditionPathExists=/sys/kernel/config machine # [ 1.321040] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... machine # [ 1.324637] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. machine # [ 1.336116] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev machine # [ 1.364007] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. machine # [ 1.373153] systemd[1]: Starting Create Static Device Nodes in /dev... machine # [ 1.383996] systemd[1]: Finished Load Kernel Modules. machine # [ 1.394638] systemd[1]: Starting Apply Kernel Variables... machine # [ 1.415544] systemd[1]: Finished Create Static Device Nodes in /dev. machine # [ 1.420154] systemd[1]: Reached target Preparation for Local File Systems. machine # [ 1.427222] systemd[1]: Reached target Local File Systems. machine # [ 1.282871] systemd-modules-load[66]: Inserted module 'dm_mod' machine # [ 1.287927] systemd-modules-load[66]: Inserted module 'virtio_balloon' machine # [ 1.435124] systemd[1]: Starting Rule-based Manager for Device Events and Files... machine # [ 1.288995] systemd-modules-load[66]: Inserted module 'virtio_gpu' machine # [ 1.443227] systemd[1]: Started Journal Service. machine # [ 1.306167] systemd[1]: Finished Apply Kernel Variables. machine # [ 1.317556] systemd[1]: Starting Create System Files and Directories... machine # [ 1.350076] systemd[1]: Finished Create System Files and Directories. machine # [ 1.354811] systemd-udevd[73]: Using default interface naming scheme 'v261'. machine # [ 1.378843] systemd[1]: Started Rule-based Manager for Device Events and Files. machine # [ 1.434847] systemd[1]: Finished Coldplug All udev Devices. machine # [ 1.436196] systemd[1]: Reached target System Initialization. machine # [ 1.437494] systemd[1]: Reached target Basic System. machine # [ 1.775980] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 machine # [ 1.778563] virtio_blk virtio2: 1/0/0 default/read/poll queues machine # [ 1.786754] virtio_blk virtio2: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) machine # [ 1.789233] serio: i8042 KBD port at 0x60,0x64 irq 1 machine # [ 1.789953] serio: i8042 AUX port at 0x60,0x64 irq 12 machine # [ 1.797188] ehci-pci 0000:00:1d.7: EHCI Host Controller machine # [ 1.797967] ehci-pci 0000:00:1d.7: new USB bus registered, assigned bus number 1 machine # [ 1.799688] ehci-pci 0000:00:1d.7: irq 19, io mem 0xfebdb000 machine # [ 1.806951] ehci-pci 0000:00:1d.7: USB 2.0 started, EHCI 1.00 machine # [ 1.808031] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 6.18 machine # [ 1.809230] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 machine # [ 1.810819] usb usb1: Product: EHCI Host Controller machine # [ 1.811970] usb usb1: Manufacturer: Linux 6.18.53 ehci_hcd machine # [ 1.812692] usb usb1: SerialNumber: 0000:00:1d.7 machine # [ 1.815094] hub 1-0:1.0: USB hub found machine # [ 1.817928] hub 1-0:1.0: 6 ports detected machine # [ 1.824154] uhci_hcd 0000:00:1d.0: UHCI Host Controller machine # [ 1.824874] uhci_hcd 0000:00:1d.0: new USB bus registered, assigned bus number 2 machine # [ 1.840958] uhci_hcd 0000:00:1d.0: detected 2 ports machine # [ 1.841725] uhci_hcd 0000:00:1d.0: irq 16, io port 0x0000c180 machine # [ 1.852687] usb usb2: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.18 machine # [ 1.856942] usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=1 machine # [ 1.864774] usb usb2: Product: UHCI Host Controller machine # [ 1.867275] usb usb2: Manufacturer: Linux 6.18.53 uhci_hcd machine # [ 1.875310] usb usb2: SerialNumber: 0000:00:1d.0 machine # [ 1.877765] SCSI subsystem initialized machine # [ 1.884851] hub 2-0:1.0: USB hub found machine # [ 1.885862] hub 2-0:1.0: 2 ports detected machine # [ 1.895081] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input0 machine # [ 1.899614] uhci_hcd 0000:00:1d.1: UHCI Host Controller machine # [ 1.900498] uhci_hcd 0000:00:1d.1: new USB bus registered, assigned bus number 3 machine # [ 1.760870] systemd[1]: Starting Virtual Console Setup... machine # [ 1.792911] (udev-worker)[93]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. machine # [ 1.795431] (udev-worker)[93]: Network interface NamePolicy= disabled on kernel command line. machine # [ 1.804744] systemd-vconsole-setup[97]: Configuration of first virtual console was skipped, ignoring remaining ones. machine # [ 1.806308] systemd[1]: Finished Virtual Console Setup. machine # [ 1.950970] uhci_hcd 0000:00:1d.1: detected 2 ports machine # [ 1.951745] uhci_hcd 0000:00:1d.1: irq 17, io port 0x0000c1a0 machine # [ 1.959000] usb usb3: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.18 machine # [ 1.960151] usb usb3: New USB device strings: Mfr=3, Product=2, SerialNumber=1 machine # [ 1.822758] systemd[1]: Found device /dev/disk/by-label/nixos. machine # [ 1.825291] systemd[1]: Reached target Initrd Root Device. machine # [ 1.827887] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos... machine # [ 1.977947] usb usb3: Product: UHCI Host Controller machine # [ 1.978635] usb usb3: Manufacturer: Linux 6.18.53 uhci_hcd machine # [ 1.986941] usb usb3: SerialNumber: 0000:00:1d.1 machine # [ 1.989208] hub 3-0:1.0: USB hub found machine # [ 1.991082] hub 3-0:1.0: 2 ports detected machine # [ 1.998025] uhci_hcd 0000:00:1d.2: UHCI Host Controller machine # [ 1.998728] uhci_hcd 0000:00:1d.2: new USB bus registered, assigned bus number 4 machine # [ 2.002009] uhci_hcd 0000:00:1d.2: detected 2 ports machine # [ 2.002762] uhci_hcd 0000:00:1d.2: irq 18, io port 0x0000c1c0 machine # [ 2.007387] usb usb4: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.18 machine # [ 2.010409] usb usb4: New USB device strings: Mfr=3, Product=2, SerialNumber=1 machine # [ 2.015047] usb usb4: Product: UHCI Host Controller machine # [ 2.015769] usb usb4: Manufacturer: Linux 6.18.53 uhci_hcd machine # [ 1.873363] systemd-fsck[104]: nixos: clean, 12/65536 files, 13019/262144 blocks machine # [ 1.878590] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos. machine # [ 2.026949] usb usb4: SerialNumber: 0000:00:1d.2 machine # [ 2.028535] hub 4-0:1.0: USB hub found machine # [ 2.029322] hub 4-0:1.0: 2 ports detected machine # [ 2.053285] ahci 0000:00:1f.2: AHCI vers 0001.0000, 32 command slots, 1.5 Gbps, SATA mode machine # [ 2.055945] usb 1-1: new high-speed USB device number 2 using ehci-pci machine # [ 2.065958] ahci 0000:00:1f.2: 6/6 ports implemented (port mask 0x3f) machine # [ 2.066838] ahci 0000:00:1f.2: flags: 64bit ncq only machine # [ 2.075011] scsi host0: ahci machine # [ 2.076934] scsi host1: ahci machine # [ 2.078246] scsi host2: ahci machine # [ 2.080224] scsi host3: ahci machine # [ 2.081838] scsi host4: ahci machine # [ 2.083474] scsi host5: ahci machine # [ 2.084543] ata1: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc100 irq 47 lpm-pol 1 machine # [ 2.086216] ata2: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc180 irq 47 lpm-pol 1 machine # [ 2.087452] ata3: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc200 irq 47 lpm-pol 1 machine # [ 2.088665] ata4: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc280 irq 47 lpm-pol 1 machine # [ 2.089797] ata5: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc300 irq 47 lpm-pol 1 machine # [ 2.091046] ata6: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc380 irq 47 lpm-pol 1 machine # [ 2.185214] usb 1-1: New USB device found, idVendor=0627, idProduct=0001, bcdDevice= 0.00 machine # [ 2.188089] usb 1-1: New USB device strings: Mfr=1, Product=3, SerialNumber=10 machine # [ 2.191375] usb 1-1: Product: QEMU USB Tablet machine # [ 2.193230] usb 1-1: Manufacturer: QEMU machine # [ 2.195046] usb 1-1: SerialNumber: 28754-0000:00:1d.7-1 machine # [ 2.227597] hid: raw HID events driver (C) Jiri Kosina machine # [ 2.143303] systemd[1]: Mounting /sysroot... machine # [ 2.400515] ata2: SATA link down (SStatus 0 SControl 300) machine # [ 2.403084] ata4: SATA link down (SStatus 0 SControl 300) machine # [ 2.405474] ata1: SATA link down (SStatus 0 SControl 300) machine # [ 2.408343] ata5: SATA link down (SStatus 0 SControl 300) machine # [ 2.411052] ata6: SATA link down (SStatus 0 SControl 300) machine # [ 2.413567] ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 300) machine # [ 2.416316] ata3.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/100 machine # [ 2.418631] ata3.00: applying bridge limits machine # [ 2.420627] ata3.00: configured for UDMA/100 machine # [ 2.423297] scsi 2:0:0:0: CD-ROM QEMU QEMU DVD-ROM 2.5+ PQ: 0 ANSI: 5 machine # [ 2.496950] usbcore: registered new interface driver usbhid machine # [ 2.497704] usbhid: USB HID core driver machine # [ 2.514262] input: QEMU QEMU USB Tablet as /devices/pci0000:00/0000:00:1d.7/usb1/1-1/1-1:1.0/0003:0627:0001.0001/input/input2 machine # [ 2.524037] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:1d.7-1/input0 machine # [ 2.538076] sr 2:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray machine # [ 2.556048] cdrom: Uniform CD-ROM driver Revision: 3.20 machine # [ 2.566853] EXT4-fs (vda): mounted filesystem 32355387-bda8-4296-bbcd-b0318f4a296c r/w with ordered data mode. Quota mode: none. machine # [ 2.427448] systemd[1]: Mounted /sysroot. machine # [ 2.428746] systemd[1]: Reached target Initrd Root File System. machine # [ 2.430880] systemd[1]: Starting Mountpoints Configured in the Real Root... machine # [ 2.445784] systemd-sysroot-fstab-check[137]: /sysroot should be mounted in the initrd, will request daemon-reload. machine # [ 2.453069] systemd[1]: Reload requested from client PID 137 ('systemd-sysroot') (unit initrd-parse-etc.service)... machine # [ 2.454515] systemd[1]: Reloading... machine # [ 2.525907] systemd[1]: Reloading finished in 74 ms. machine # [ 2.534547] systemd-sysroot-fstab-check[137]: Requesting initrd-fs.target/start/replace... machine # [ 2.538264] systemd-sysroot-fstab-check[137]: Requesting swap.target/start/replace... machine # [ 2.541890] systemd[1]: initrd-parse-etc.service: Deactivated successfully. machine # [ 2.543248] systemd[1]: Finished Mountpoints Configured in the Real Root. machine # [ 2.545198] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies. machine # [ 3.146188] systemd[1]: Mounting /sysroot/nix/.ro-store... machine # [ 3.152182] systemd[1]: Mounting /sysroot/nix/.rw-store... machine # [ 3.162174] systemd[1]: Mounting /sysroot/run... machine # [ 3.173179] systemd[1]: Mounting /sysroot/tmp/shared... machine # [ 3.183720] systemd[1]: Mounting /sysroot/tmp/xchg... machine # [ 3.222712] systemd[1]: Mounted /sysroot/nix/.ro-store. machine # [ 3.226160] systemd[1]: Mounted /sysroot/nix/.rw-store. machine # [ 3.226913] systemd[1]: Mounted /sysroot/run. machine # [ 3.230237] systemd[1]: Mounted /sysroot/tmp/shared. machine # [ 3.232352] systemd[1]: Mounted /sysroot/tmp/xchg. machine # [ 3.236140] systemd[1]: Starting rw-sysroot-nix-store.service... machine # [ 3.246769] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. machine # [ 3.248281] systemd[1]: Finished rw-sysroot-nix-store.service. machine # [ 4.145393] systemd[1]: Mounting /sysroot/nix/store... machine # [ 4.195399] systemd[1]: Mounted /sysroot/nix/store. machine # [ 4.196982] systemd[1]: Reached target Initrd File Systems. machine # [ 4.198901] systemd[1]: Starting Find NixOS closure... machine # [ 4.201490] systemd[1]: Starting Create Volatile Files and Directories in the Real Root... machine # [ 4.227084] systemd[1]: Finished Create Volatile Files and Directories in the Real Root. machine # [ 4.229384] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully. machine # [ 4.234158] systemd[1]: Finished Find NixOS closure. machine # [ 4.235201] systemd[1]: Reached target Initrd Default Target. machine # [ 4.236904] systemd[1]: Starting Cleaning Up and Shutting Down Daemons... machine # [ 4.250931] systemd[1]: Stopped target Initrd Default Target. machine # [ 4.252237] systemd[1]: Stopped target Basic System. machine # [ 4.253224] systemd[1]: Stopped target Initrd Root Device. machine # [ 4.255114] systemd[1]: Stopped target Path Units. machine # [ 4.255796] systemd[1]: systemd-ask-password-console.path: Deactivated successfully. machine # [ 4.256992] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch. machine # [ 4.258059] systemd[1]: Stopped target Slice Units. machine # [ 4.258748] systemd[1]: Stopped target Socket Units. machine # [ 4.259473] systemd[1]: Stopped target System Initialization. machine # [ 4.260371] systemd[1]: Stopped target Swaps. machine # [ 4.261385] systemd[1]: Stopped target Timer Units. machine # [ 4.262338] systemd[1]: dbus.socket: Deactivated successfully. machine # [ 4.264115] systemd[1]: Closed D-Bus System Message Bus Socket. machine # [ 4.264912] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully. machine # [ 4.265991] systemd[1]: Stopped Find NixOS closure. machine # [ 4.267052] systemd[1]: Starting rw-sysroot-nix-store.service... machine # [ 4.268171] systemd[1]: systemd-sysctl.service: Deactivated successfully. machine # [ 4.269265] systemd[1]: Stopped Apply Kernel Variables. machine # [ 4.271060] systemd[1]: systemd-modules-load.service: Deactivated successfully. machine # [ 4.271976] systemd[1]: Stopped Load Kernel Modules. machine # [ 4.273698] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully. machine # [ 4.274976] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root. machine # [ 4.275976] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. machine # [ 4.277337] systemd[1]: Stopped Create System Files and Directories. machine # [ 4.279133] systemd[1]: Stopped target Local File Systems. machine # [ 4.279875] systemd[1]: Stopped target Preparation for Local File Systems. machine # [ 4.281505] systemd[1]: systemd-udev-trigger.service: Deactivated successfully. machine # [ 4.282537] systemd[1]: Stopped Coldplug All udev Devices. machine # [ 4.284717] systemd[1]: Stopping Rule-based Manager for Device Events and Files... machine # [ 4.285868] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. machine # [ 4.288330] systemd[1]: Stopped Virtual Console Setup. machine # [ 4.295602] systemd[1]: systemd-udevd.service: Deactivated successfully. machine # [ 4.299055] systemd[1]: Stopped Rule-based Manager for Device Events and Files. machine # [ 4.300096] systemd[1]: initrd-cleanup.service: Deactivated successfully. machine # [ 4.303120] systemd[1]: Finished Cleaning Up and Shutting Down Daemons. machine # [ 4.310150] systemd[1]: Starting Cleanup udev Database... machine # [ 4.310905] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. machine # [ 4.311932] systemd[1]: Stopped Create Static Device Nodes in /dev. machine # [ 4.313141] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. machine # [ 4.315112] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully. machine # [ 4.316213] systemd[1]: kmod-static-nodes.service: Deactivated successfully. machine # [ 4.317200] systemd[1]: Stopped Create List of Static Device Nodes. machine # [ 4.318504] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. machine # [ 4.320471] systemd[1]: Finished rw-sysroot-nix-store.service. machine # [ 4.336683] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. machine # [ 4.337864] systemd[1]: Finished Cleanup udev Database. machine # [ 4.339240] systemd[1]: Reached target Switch Root. machine # [ 4.340784] systemd[1]: Starting NixOS Activation... machine # [ 4.400191] initrd-nixos-activation-start[189]: booting system configuration /nix/store/bjj1c5xdq9j21a84h34012nm3dspv0yf-nixos-system-machine-test machine # [ 4.424257] initrd-nixos-activation-start[189]: running activation script... machine # [ 4.584560] initrd-nixos-activation-start[212]: setting up /etc... machine # [ 4.676976] systemd[1]: initrd-nixos-activation.service: Deactivated successfully. machine # [ 4.679077] systemd[1]: Finished NixOS Activation. machine # [ 4.680634] systemd[1]: Starting Switch Root... machine # [ 4.694651] systemd[1]: Switching root. machine # [ 4.964157] systemd-journald[65]: Received SIGTERM from PID 1 (systemd). machine # [ 5.017831] NET: Registered PF_VSOCK protocol family machine # [ 5.037940] systemd[1]: systemd 263-885fe07 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE) machine # [ 5.041824] systemd[1]: Detected virtualization kvm. machine # [ 5.042527] systemd[1]: Detected architecture x86-64. machine # [ 5.043362] systemd[1]: Detected first boot. machine # [ 5.044739] systemd[1]: Initializing machine ID from random generator. machine # [ 5.131106] systemd[1]: bpf-restrict-fs: LSM BPF program attached machine # [ 5.221248] systemd[1]: Applying preset policy. machine # [ 5.376388] systemd[1]: Populated /etc with preset unit settings. machine # [ 5.566081] systemd[1]: initrd-switch-root.service: Deactivated successfully. machine # [ 5.567449] systemd[1]: Stopped initrd-switch-root.service. machine # [ 5.569521] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. machine # [ 5.571696] systemd[1]: Created slice Slice /system/getty. machine # [ 5.573056] systemd[1]: Created slice User and Session Slice. machine # [ 5.574012] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. machine # [ 5.575208] systemd[1]: Started Forward Password Requests to Wall Directory Watch. machine # [ 5.576365] systemd[1]: Expecting device /dev/hvc0... machine # [ 5.577114] systemd[1]: Expecting device /dev/ttyS0... machine # [ 5.577838] systemd[1]: Reached target Local Encrypted Volumes. machine # [ 5.578663] systemd[1]: Stopped target initrd-fs.target. machine # [ 5.579428] systemd[1]: Stopped target initrd-root-fs.target. machine # [ 5.580260] systemd[1]: Stopped target initrd-switch-root.target. machine # [ 5.581122] systemd[1]: Reached target Virtual Machines and Containers. machine # [ 5.582059] systemd[1]: Reached target Path Units. machine # [ 5.582744] systemd[1]: Reached target Remote File Systems. machine # [ 5.583539] systemd[1]: Reached target Slice Units. machine # [ 5.584313] systemd[1]: Reached target Swaps. machine # [ 5.586216] systemd[1]: Listening on Query the User Interactively for a Password. machine # [ 5.600374] systemd[1]: Listening on Process Core Dump Socket. machine # [ 5.602209] systemd[1]: Listening on Credential Encryption/Decryption. machine # [ 5.603996] systemd[1]: Listening on Factory Reset Management. machine # [ 5.604868] systemd[1]: Listening on Hostname Service Socket. machine # [ 5.607708] systemd[1]: Starting Journal Log Access Socket... machine # [ 5.609235] systemd[1]: Listening on Journal Audit Socket. machine # [ 5.612084] systemd[1]: Listening on Console Output Muting Service Socket. machine # [ 5.613180] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket. machine # [ 5.614350] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 5.615669] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 5.619704] systemd[1]: Listening on Disk Repartitioning Service Socket. machine # [ 5.620740] systemd[1]: Listening on udev Varlink Socket. machine # [ 5.623034] systemd[1]: Mounting Huge Pages File System... machine # [ 5.625271] systemd[1]: Mounting POSIX Message Queue File System... machine # [ 5.632071] systemd[1]: Mounting Kernel Debug File System... machine # [ 5.638696] systemd[1]: Mounting Kernel Trace File System... machine # [ 5.644277] systemd[1]: Starting Create List of Static Device Nodes... machine # [ 5.655194] systemd[1]: Starting Load Kernel Module configfs... machine # [ 5.659535] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm machine # [ 5.665653] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 5.670986] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse machine # [ 5.688633] systemd[1]: Mounting FUSE Control File System... machine # [ 5.697240] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 5.717862] systemd[1]: Starting Journal Service... machine # [ 5.724637] systemd[1]: Starting Load Kernel Modules... machine # [ 5.733632] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer... machine # [ 5.743509] systemd[1]: Starting Remount Root and Kernel File Systems... machine # [ 5.749018] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 5.761713] systemd[1]: Starting Coldplug All udev Devices... machine # [ 5.767755] systemd[1]: Listening on Journal Log Access Socket. machine # [ 5.771720] systemd[1]: Mounted Huge Pages File System. machine # [ 5.775111] systemd[1]: Mounted POSIX Message Queue File System. machine # [ 5.784004] systemd[1]: Mounted Kernel Debug File System. machine # [ 5.785956] systemd-journald[283]: Collecting audit messages is enabled. machine # [ 5.790447] systemd[1]: Mounted Kernel Trace File System. machine # [ 5.795966] systemd[1]: Finished Create List of Static Device Nodes. machine # [ 5.801282] systemd[1]: modprobe@configfs.service: Deactivated successfully. machine # [ 5.810623] systemd[1]: Finished Load Kernel Module configfs. machine # [ 5.669240] systemd[1]: Queued start job for default target Multi-User System. machine # [ 5.670503] systemd[1]: systemd-journald.service: Deactivated successfully. machine # [ 5.816249] systemd[1]: Started Journal Service. machine # [ 5.677130] systemd[1]: Mounted FUSE Control File System. machine # [ 5.826978] EXT4-fs (vda): re-mounted 32355387-bda8-4296-bbcd-b0318f4a296c. machine # [ 5.828242] loop: module loaded machine # [ 5.687981] systemd-modules-load[284]: Inserted module 'loop' machine # [ 5.696902] systemd[1]: Finished Remount Root and Kernel File Systems. machine # [ 5.703073] systemd[1]: Finished Load Kernel Modules. machine # [ 5.704556] systemd[1]: Listening on Disk Image Download Service Socket. machine # [ 5.711072] systemd[1]: Mounting Kernel Configuration File System... machine # [ 5.715179] systemd[1]: Starting Firewall... machine # [ 5.725887] systemd[1]: Starting Flush Journal to Persistent Storage... machine # [ 5.727985] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 5.737699] systemd[1]: Starting Load/Save OS Random Seed... machine # [ 5.744606] systemd-oomd[285]: No swap; memory pressure usage will be degraded machine # [ 5.752955] systemd[1]: Starting Apply Kernel Variables... machine # [ 5.767092] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... machine # [ 5.768179] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 5.770350] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer. machine # [ 5.973678] systemd-journald[283]: Received client request to flush runtime journal. machine # [ 5.921053] systemd[1]: Finished Load/Save OS Random Seed. machine # [ 5.923069] systemd[1]: Mounted Kernel Configuration File System. machine # [ 5.923920] systemd[1]: Reached target First Boot Complete. machine # [ 5.924891] systemd[1]: Finished Apply Kernel Variables. machine # [ 5.928447] systemd[1]: Finished Flush Journal to Persistent Storage. machine # [ 5.998269] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. machine # [ 6.002553] systemd[1]: Starting Create Static Device Nodes in /dev... machine # [ 6.037270] systemd[1]: Finished Coldplug All udev Devices. machine # [ 6.057744] systemd[1]: Finished Create Static Device Nodes in /dev. machine # [ 6.059218] systemd[1]: Reached target Preparation for Local File Systems. machine # [ 6.061749] systemd[1]: Starting Rule-based Manager for Device Events and Files... machine # [ 6.107409] systemd-udevd[326]: Using default interface naming scheme 'v261'. machine # [ 6.150571] systemd[1]: Started Rule-based Manager for Device Events and Files. machine # [ 6.269377] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse machine # [ 6.369130] systemd[1]: Condition check resulted in /dev/hvc0 being skipped. machine # [ 6.375294] systemd[1]: Condition check resulted in /dev/ttyS0 being skipped. machine # [ 6.415925] (udev-worker)[347]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. machine # [ 6.417934] (udev-worker)[347]: Network interface NamePolicy= disabled on kernel command line. machine # [ 6.428206] systemd[1]: Mounting /run/wrappers... machine # [ 6.471987] systemd[1]: Mounted /run/wrappers. machine # [ 6.474071] systemd[1]: Reached target Local File Systems. machine # [ 6.477062] systemd[1]: Listening on Boot Loader Control Service Socket. machine # [ 6.482072] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 6.482828] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 6.487138] systemd[1]: Starting Save Transient machine-id to Disk... machine # [ 6.492085] systemd[1]: Starting Create System Files and Directories... machine # [ 6.582074] systemd[1]: etc-machine\x2did.mount: Deactivated successfully. machine # [ 6.588791] systemd[1]: Finished Save Transient machine-id to Disk. machine # [ 6.628780] systemd[1]: Finished Create System Files and Directories. machine # [ 6.638235] systemd[1]: Starting Rebuild Journal Catalog... machine # [ 6.643861] systemd[1]: Starting Record System Boot/Shutdown in UTMP... machine # [ 6.648627] systemd[1]: Condition check resulted in Virtio network device being skipped. machine # [ 6.649724] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 6.651911] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 6.654156] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 6.657625] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 6.659146] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 6.660441] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 6.726224] systemd[1]: Finished Record System Boot/Shutdown in UTMP. machine # [ 6.757377] systemd[1]: Finished Rebuild Journal Catalog. machine # [ 6.764194] systemd[1]: Starting Update is Completed... machine # [ 6.814103] systemd[1]: Finished Update is Completed. machine # [ 7.002808] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input3 machine # [ 7.051978] ACPI: button: Power Button [PWRF] machine # [ 7.068623] mousedev: PS/2 mouse device common for all mice machine # [ 6.959743] systemd[1]: Finished Firewall. machine # [ 6.966795] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 6.969601] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 6.970445] systemd[1]: Reached target System Initialization. machine # [ 6.973257] systemd[1]: Started Discard unused filesystem blocks once a week. machine # [ 6.974233] systemd[1]: Started Daily Cleanup of Temporary Directories. machine # [ 6.975675] systemd[1]: Reached target Timer Units. machine # [ 6.976443] systemd[1]: Listening on D-Bus System Message Bus Socket. machine # [ 6.977340] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket. machine # [ 6.978951] systemd[1]: Reached target Socket Units. machine # [ 6.979759] systemd[1]: Reached target Basic System. machine # [ 6.982144] systemd[1]: Started backdoor.service. machine # [ 6.988101] systemd[1]: Starting Import lastlog data into lastlog2 database... machine # [ 7.133595] rtc_cmos PNP0B00:00: RTC can wake from S4 machine # [ 6.996069] systemd[1]: Starting Name Service Cache Daemon (nsncd)... machine # [ 7.009995] systemd[1]: Starting Post-Boot Actions... machine # [ 7.161110] rtc_cmos PNP0B00:00: registered as rtc0 machine # [ 7.162214] systemd-journald[283]: Time jumped backwards, rotating. machine # [ 7.181159] bochs-drm 0000:00:01.0: vgaarb: deactivate vga console machine # [ 7.196291] parport_pc 00:02: reported by Plug and Play ACPI machine # [ 7.204056] rtc_cmos PNP0B00:00: setting system clock to 2026-09-27T03:18:43 UTC (1790479123) machine # [ 7.205348] rtc_cmos PNP0B00:00: alarms up to one day, y3k, 242 bytes nvram, hpet irqs machine # [ 7.077575] systemd[1]: Started Reset console on configuration changes. machine # [ 7.091494] systemd[1]: Starting resolvconf update... machine # [ 7.101734] systemd[1]: Starting D-Bus System Message Bus... machine # [ 7.138199] nsncd[493]: Sep 27 03:18:43.611 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" machine # [ 7.143898] systemd[1]: Started Name Service Cache Daemon (nsncd). machine # [ 7.144812] systemd[1]: Reached target Host and Network Name Lookups. machine # [ 7.145729] systemd[1]: Reached target User and Group Name Lookups. machine # [ 7.156517] systemd[1]: Starting User Login Management... machine # connecting to host... machine # [ 7.164594] systemd[1]: Finished Post-Boot Actions. machine: Guest shell says: b'Spawning backdoor root shell...\n' machine: connected to guest root shell machine # [ 7.208634] systemd[1]: Finished Import lastlog data into lastlog2 database. machine: (connecting took 7.91 seconds) machine: (finished: waiting for the VM to finish booting, in 8.15 seconds) machine # [ 7.259459] dbus-broker-launch[498]: Looking up NSS user entry for 'systemd-timesync'... machine # [ 7.263204] dbus-broker-launch[498]: NSS returned no entry for 'systemd-timesync' machine # [ 7.264312] dbus-broker-launch[498]: Invalid user-name in /nix/store/mvyffb3y17ijfnb0xcf0lyfs9p3sxar1-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" machine # [ 7.310875] parport0: PC-style at 0x378, irq 7 [PCSPP(,...)] machine # [ 7.330787] input: QEMU Virtio Keyboard as /devices/pci0000:00/0000:00:06.0/virtio4/input/input4 machine # [ 7.382329] lpc_ich 0000:00:1f.0: I/O space for GPIO uninitialized machine # [ 7.528799] Console: switching to colour dummy device 80x25 machine # [ 7.532837] i801_smbus 0000:00:1f.3: SMBus using PCI interrupt machine # [ 7.533015] i2c i2c-0: Memory type 0x07 not supported yet, not instantiating SPD machine # [ 7.578224] [drm] Found bochs VGA, ID 0xb0c5. machine # [ 7.578227] [drm] Framebuffer size 16384 kB @ 0xfd000000, mmio @ 0xfebd0000. machine # [ 7.348742] dbus-broker-launch[498]: Ready machine # [ 7.438352] systemd[1]: Started D-Bus System Message Bus. machine # [ 7.439258] systemd[1]: Stopped target Host and Network Name Lookups. machine # [ 7.440443] systemd[1]: Stopping Host and Network Name Lookups... machine # [ 7.443967] systemd[1]: Stopped target User and Group Name Lookups. machine # [ 7.448915] systemd[1]: Stopping User and Group Name Lookups... machine # [ 7.449827] systemd[1]: Stopping Name Service Cache Daemon (nsncd)... machine # [ 7.450881] systemd-logind[514]: New seat seat0. machine # [ 7.454542] systemd[1]: nscd.service: Deactivated successfully. machine # [ 7.455383] systemd[1]: Stopped Name Service Cache Daemon (nsncd). machine # [ 7.605216] bochs-drm 0000:00:01.0: [drm] Registered 1 planes with drm panic machine # [ 7.605933] [drm] Initialized bochs-drm 1.0.0 for 0000:00:01.0 on minor 0 machine # [ 7.464146] systemd[1]: Started User Login Management. machine # [ 7.471382] systemd[1]: Starting linger-users.service... machine # [ 7.481356] systemd[1]: Starting Name Service Cache Daemon (nsncd)... machine # [ 7.627849] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input6 machine # [ 7.633060] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input5 machine # [ 7.553421] systemd[1]: Started Name Service Cache Daemon (nsncd). machine # [ 7.554680] nsncd[582]: Sep 27 03:18:44.033 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" machine # [ 7.556873] systemd[1]: Reached target Host and Network Name Lookups. machine # [ 7.558476] systemd[1]: Reached target User and Group Name Lookups. machine # [ 7.571600] systemd[1]: Starting Virtual Console Setup... machine # [ 7.580313] systemd[1]: Finished resolvconf update. machine # [ 7.835690] Console: switching to colour frame buffer device 160x50 machine # [ 7.841877] bochs-drm 0000:00:01.0: [drm] fb0: bochs-drmdrmfb frame buffer device machine # [ 7.630582] systemd[1]: Created slice Slice /user/1001. machine # [ 7.715442] systemd[1]: Reached target Preparation for Network. machine # [ 7.733129] systemd[1]: Starting DHCP Client... machine # [ 7.734993] systemd[1]: Starting Address configuration of eth1... machine # [ 7.888994] ppdev: user-space parallel port driver machine # [ 7.747488] systemd[1]: Starting Extra networking commands.... machine # [ 7.749369] systemd[1]: Starting User Runtime Directory /run/user/1001... machine # [ 7.758552] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 7.759549] systemd[1]: Finished linger-users.service. machine # [ 7.764100] systemd-logind[514]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard) machine # [ 7.765396] systemd-logind[514]: Watching system buttons on /dev/input/event2 (Power Button) machine # [ 7.777152] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. machine # [ 7.778180] systemd[1]: Stopped Virtual Console Setup. machine # [ 7.778848] systemd[1]: Starting Virtual Console Setup... machine # [ 7.801668] systemd[1]: Finished User Runtime Directory /run/user/1001. machine # [ 7.803148] systemd[1]: Starting User Manager for UID 1001... machine # [ 7.960644] iTCO_wdt iTCO_wdt.1.auto: Found a ICH9 TCO device (Version=2, TCOBASE=0x0660) machine # [ 7.824125] systemd-logind[514]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard) machine # [ 7.998239] iTCO_wdt iTCO_wdt.1.auto: initialized. heartbeat=30 sec (nowayout=0) machine # [ 7.875329] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. machine # [ 7.876367] systemd[1]: Stopped Virtual Console Setup. machine # [ 7.886269] systemd[1]: Starting Virtual Console Setup... machine # [ 7.892975] (systemd)[619]: pam_unix(systemd-user:session): session opened for user usertest(uid=1001) by (uid=0) machine # [ 7.912560] systemd-logind[514]: New session '1' of user 'usertest' with class 'manager' and type 'unspecified'. machine # [ 7.949317] systemd[619]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 8.035978] network-addresses-eth1-start[607]: adding address 192.168.1.1/24... done machine # [ 8.083464] network-addresses-eth1-start[607]: adding address 2001:db8:1::1/64... done machine # [ 8.128859] systemd[1]: Finished Address configuration of eth1. machine # [ 8.178218] systemd[619]: Queued start job for default target Main User Target. machine # [ 8.179503] systemd[619]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 8.188147] systemd[619]: Created slice User Application Slice. machine # [ 8.188965] systemd[619]: Started Daily Cleanup of User's Temporary Directories. machine # [ 8.193714] systemd[619]: Reached target Paths. machine # [ 8.194540] systemd[619]: Reached target Timers. machine # [ 8.195240] systemd[619]: Starting D-Bus User Message Bus Socket... machine # [ 8.196099] systemd[619]: Starting Create User Files and Directories... machine # [ 8.238870] systemd[619]: Finished Create User Files and Directories. machine # [ 8.386557] kvm_amd: TSC scaling supported machine # [ 8.387573] kvm_amd: Nested Virtualization enabled machine # [ 8.390195] kvm_amd: Nested Paging enabled machine # [ 8.390610] kvm_amd: LBR virtualization supported machine # [ 8.394426] kvm_amd: Virtual VMLOAD VMSAVE supported machine # [ 8.398551] kvm_amd: Virtual GIF supported machine # [ 8.400186] kvm_amd: Virtual NMI enabled machine # [ 8.259854] systemd[619]: Listening on D-Bus User Message Bus Socket. machine # [ 8.260760] systemd[619]: Reached target Sockets. machine # [ 8.261489] systemd[619]: Reached target Basic System. machine # [ 8.262422] systemd[1]: Started User Manager for UID 1001. machine # [ 8.269150] systemd[619]: Starting Run user-specific NixOS activation... machine # [ 8.303323] dhcpcd[635]: dhcpcd-10.3.2 starting machine # [ 8.305119] systemd[619]: Finished Run user-specific NixOS activation. machine # [ 8.310557] systemd[619]: Reached target Main User Target. machine # [ 8.311419] systemd[619]: Startup finished in 365ms. machine # [ 8.316231] systemd[1]: Finished Extra networking commands.. machine # [ 8.317734] systemd[1]: Reached target Network. machine # [ 8.318774] systemd[1]: Starting Permit User Sessions... machine # [ 8.322565] dhcpcd[697]: dev: loaded udev machine # [ 8.477543] EDAC MC: Ver: 3.0.0 machine # [ 8.483940] 8021q: 802.1Q VLAN Support v1.8 machine # [ 8.484355] 8021q: adding VLAN 0 to HW filter on device eth1 machine # [ 8.357185] systemd[1]: Finished Permit User Sessions. machine # [ 8.365747] systemd[1]: Started Getty on tty1. machine # [ 8.368292] systemd[1]: Reached target Login Prompts. machine # [ 8.390960] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch. machine # [ 8.576846] cfg80211: Loading compiled-in X.509 certificates for regulatory database machine # [ 8.588444] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' machine # [ 8.589149] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600' machine # [ 8.591170] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -2 machine # [ 8.592032] cfg80211: failed to load regulatory.db machine # [ 8.620362] 8021q: adding VLAN 0 to HW filter on device eth0 machine # [ 8.477986] dhcpcd[697]: eth0: waiting for carrier machine # [ 8.479448] dhcpcd[697]: eth0: carrier acquired machine # [ 8.484728] dhcpcd[697]: DUID 00:01:00:01:32:4b:47:94:52:54:00:12:34:56 machine # [ 8.485955] dhcpcd[697]: eth0: IAID 00:12:34:56 machine # [ 8.486740] dhcpcd[697]: eth0: adding address fe80::5054:ff:fe12:3456 machine # [ 8.516586] systemd-vconsole-setup[625]: Configuration of first virtual console was skipped, ignoring remaining ones. machine # [ 8.521680] systemd[1]: Finished Virtual Console Setup. machine # [ 8.948249] dhcpcd[697]: eth0: soliciting a DHCP lease machine # [ 9.109955] NET: Registered PF_PACKET protocol family machine # [ 8.972980] dhcpcd[697]: eth0: offered 10.0.2.15 from 10.0.2.2 machine # [ 8.977427] dhcpcd[697]: eth0: probing address 10.0.2.15/24 machine # [ 10.506111] dhcpcd[697]: eth0: soliciting an IPv6 router machine # [ 10.508355] dhcpcd[697]: eth0: Router Advertisement from fe80::2 machine # [ 10.510507] dhcpcd[697]: eth0: adding address fec0::5054:ff:fe12:3456/64 machine # [ 10.512698] dhcpcd[697]: eth0: adding route to fec0::/64 machine # [ 10.514607] dhcpcd[697]: eth0: adding default route via fe80::2 machine # [ 13.417511] dhcpcd[697]: eth0: leased 10.0.2.15 for 86400 seconds machine # [ 13.419635] dhcpcd[697]: eth0: adding route to 10.0.2.0/24 machine # [ 13.420968] dhcpcd[697]: eth0: adding default route via 10.0.2.2 machine # [ 13.482920] systemd[1]: Started DHCP Client. machine # [ 13.485217] systemd[1]: Reached target Multi-User System. machine # [ 13.485952] systemd[1]: Startup finished in 858ms (kernel) + 3.998s (initrd) + 8.628s (userspace) = 13.485s. machine: (finished: waiting for unit multi-user.target, in 14.79 seconds) machine: must succeed: /nix/store/yidcpw0fsqryxdbi00sgaskaw7wb9pps-stderr-runner /nix/store/bjj1c5xdq9j21a84h34012nm3dspv0yf-nixos-system-machine-test/bin/switch-to-configuration test machine # Checking switch inhibitors... done machine # [ 14.049379] nixos[831]: switching to system configuration /nix/store/bjj1c5xdq9j21a84h34012nm3dspv0yf-nixos-system-machine-test machine # activating the configuration... machine # [ 14.053331] systemd[1]: Stopped target Local File Systems. machine # [ 14.054343] systemd[1]: Stopped target Remote File Systems. machine # setting up /etc... machine # [ 14.279989] systemd[1]: Reload requested from client PID 831 ('.switch-to-conf') (unit backdoor.service)... machine # [ 14.281770] systemd[1]: Reloading... machine # [ 14.518171] systemd[1]: Reloading finished in 234 ms. machine # reloading user units for usertest... machine # [ 14.548284] systemd[619]: Created slice User Core Session Slice. machine # [ 14.550561] systemd[619]: Starting D-Bus User Message Bus... machine # [ 14.573621] dbus-broker-launch[901]: Ignoring duplicate name 'org.freedesktop.import1' in service file '/nix/store/mvyffb3y17ijfnb0xcf0lyfs9p3sxar1-system-path/share/dbus-1/services/org.freedesktop.import1.service' machine # [ 14.576340] dbus-broker-launch[901]: Ignoring duplicate name 'org.freedesktop.machine1' in service file '/nix/store/mvyffb3y17ijfnb0xcf0lyfs9p3sxar1-system-path/share/dbus-1/services/org.freedesktop.machine1.service' machine # [ 14.578927] dbus-broker-launch[901]: Ignoring duplicate name 'org.freedesktop.portable1' in service file '/nix/store/mvyffb3y17ijfnb0xcf0lyfs9p3sxar1-system-path/share/dbus-1/services/org.freedesktop.portable1.service' machine # [ 14.581638] dbus-broker-launch[901]: Ignoring duplicate name 'org.freedesktop.systemd1' in service file '/nix/store/mvyffb3y17ijfnb0xcf0lyfs9p3sxar1-system-path/share/dbus-1/services/org.freedesktop.systemd1.service' machine # [ 14.584263] dbus-broker-launch[901]: Policy to allow eavesdropping in /etc/dbus-1/session.conf +27: Eavesdropping is deprecated and ignored machine # [ 14.585723] dbus-broker-launch[901]: Policy to allow eavesdropping in /etc/dbus-1/session.conf +29: Eavesdropping is deprecated and ignored machine # [ 14.587600] systemd[619]: Started D-Bus User Message Bus. machine # [ 14.591412] dbus-broker-launch[901]: Ready machine # [ 14.629416] systemd[619]: Reexecution requested from client PID 900 ('switch-to-confi')... machine # [ 14.632449] systemd[619]: Reexecuting. machine # [ 14.652884] systemd[619]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 14.726576] systemd[619]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 14.732114] systemd[619]: Reload requested from client PID 900 ('switch-to-confi')... machine # [ 14.733494] systemd[619]: Reloading... machine # [ 14.805116] systemd[619]: Reloading finished in 70 ms. machine # [ 14.813057] systemd[619]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # restarting the following user units: nixos-activation.service machine # [ 14.823490] systemd[619]: Stopped Run user-specific NixOS activation. machine # [ 14.825383] systemd[619]: Stopping Run user-specific NixOS activation... machine # [ 14.828114] systemd[619]: Starting Run user-specific NixOS activation... machine # [ 14.859297] systemd[619]: Finished Run user-specific NixOS activation. machine # restarting sysinit-reactivation.target machine # [ 14.870657] systemd[1]: Starting Re-setup tmpfiles on a system that is already running.... machine # [ 14.937806] systemd[1]: Finished Re-setup tmpfiles on a system that is already running.. machine # [ 14.941168] systemd[1]: Reached target Reactivate sysinit units. machine # [ 14.944577] systemd[1]: Reached target Remote File Systems. machine # [ 14.946128] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 14.948100] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 14.951563] systemd[1]: Reached target Local File Systems. machine # [ 14.953325] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 14.956294] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 14.958410] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 14.960561] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 14.962965] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 14.964414] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 14.967132] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 15.099545] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 15.101321] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 15.105127] systemd[1]: Starting linger-users.service... machine # [ 15.133376] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 15.134939] systemd[1]: Finished linger-users.service. machine # the following new units were started: sysinit-reactivation.target, systemd-tmpfiles-resetup.service machine # [ 15.394849] nixos[831]: finished switching to system configuration /nix/store/bjj1c5xdq9j21a84h34012nm3dspv0yf-nixos-system-machine-test machine: (finished: must succeed: /nix/store/yidcpw0fsqryxdbi00sgaskaw7wb9pps-stderr-runner /nix/store/bjj1c5xdq9j21a84h34012nm3dspv0yf-nixos-system-machine-test/bin/switch-to-configuration test, in 1.56 seconds) machine: must succeed: rm /etc/NIXOS machine: (finished: must succeed: rm /etc/NIXOS, in 0.03 seconds) machine: must succeed: /nix/store/yidcpw0fsqryxdbi00sgaskaw7wb9pps-stderr-runner /nix/store/k2j2d9gd1n8yggn5lv605pgjjnpy8706-nixos-system-other-test/bin/switch-to-configuration test machine # this should succeed (config: /nix/store/k2j2d9gd1n8yggn5lv605pgjjnpy8706-nixos-system-other-test, action: test) machine # Checking switch inhibitors... done machine # [ 15.665335] nixos[979]: switching to system configuration /nix/store/k2j2d9gd1n8yggn5lv605pgjjnpy8706-nixos-system-other-test machine # [ 15.667882] systemd[1]: Stopped target Local File Systems. machine # activating the configuration... machine # [ 15.670261] systemd[1]: Stopped target Remote File Systems. machine # removing user ‘usertest’ machine # setting up /etc... machine # [ 15.906893] systemd[1]: Reload requested from client PID 979 ('.switch-to-conf') (unit backdoor.service)... machine # [ 15.908623] systemd[1]: Reloading... machine # [ 16.173221] systemd[1]: Reloading finished in 263 ms. machine # reloading user units for usertest... machine # [ 16.237326] systemd[619]: Reexecution requested from client PID 1050 ('switch-to-confi')... machine # [ 16.239328] systemd[619]: Reexecuting. machine # [ 16.260058] systemd[619]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 16.334460] systemd[619]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 16.340066] systemd[619]: Reload requested from client PID 1050 ('switch-to-confi')... machine # [ 16.341590] systemd[619]: Reloading... machine # [ 16.416105] systemd[619]: Reloading finished in 73 ms. machine # [ 16.421865] systemd[619]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # restarting the following user units: nixos-activation.service machine # [ 16.429411] systemd[619]: Stopped Run user-specific NixOS activation. machine # [ 16.430334] systemd[619]: Stopping Run user-specific NixOS activation... machine # [ 16.432692] systemd[619]: Starting Run user-specific NixOS activation... machine # [ 16.456499] systemd[619]: Finished Run user-specific NixOS activation. machine # restarting sysinit-reactivation.target machine # [ 16.460469] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 16.461869] systemd[1]: Stopping Reactivate sysinit units... machine # [ 16.462869] systemd[1]: Reached target Reactivate sysinit units. machine # reloading the following units: dbus-broker.service machine # [ 16.466300] dbus-broker-launch[498]: Caught SIGHUP, trigger reload. machine # [ 16.468124] systemd[1]: Reloading D-Bus System Message Bus... machine # [ 16.473331] dbus-broker-launch[498]: Looking up NSS user entry for 'systemd-timesync'... machine # [ 16.475294] dbus-broker-launch[498]: NSS returned no entry for 'systemd-timesync' machine # [ 16.476361] dbus-broker-launch[498]: Invalid user-name in /nix/store/v6w3nff97x3lpkjp6wckgb5f1jqdpwvx-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" machine # [ 16.485245] systemd[1]: Reloaded D-Bus System Message Bus. machine # restarting the following units: network-addresses-eth1.service machine # [ 16.490741] systemd[1]: Stopping Address configuration of eth1... machine # [ 16.512323] network-addresses-eth1-pre-stop[1062]: deleting address 192.168.1.1/24... done machine # [ 16.517669] network-addresses-eth1-pre-stop[1062]: deleting address 2001:db8:1::1/64... done machine # [ 16.522994] systemd[1]: network-addresses-eth1.service: Deactivated successfully. machine # [ 16.524905] systemd[1]: Stopped Address configuration of eth1. machine # [ 16.528152] systemd[1]: Starting Address configuration of eth1... machine # [ 16.563371] network-addresses-eth1-start[1067]: adding address 192.168.1.2/24... done machine # [ 16.569069] network-addresses-eth1-start[1067]: adding address 2001:db8:1::2/64... done machine # [ 16.576289] systemd[1]: Finished Address configuration of eth1. machine # [ 16.584827] systemd[1]: Reached target Local File Systems. machine # [ 16.587178] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 16.588417] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 16.589598] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 16.593768] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 16.594757] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 16.597151] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 16.599275] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 16.602487] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 16.603981] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 16.605339] systemd[1]: Reached target Remote File Systems. machine # [ 16.766424] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 16.768302] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 16.773542] systemd[1]: Starting linger-users.service... machine # [ 16.795667] linger-users-start[1139]: id: ‘usertest’: no such user machine # [ 16.797361] linger-users-start[1137]: Removing linger for missing user usertest machine # [ 16.802327] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 16.803940] systemd[1]: Finished linger-users.service. machine # [ 17.059486] nixos[979]: finished switching to system configuration /nix/store/k2j2d9gd1n8yggn5lv605pgjjnpy8706-nixos-system-other-test machine: (finished: must succeed: /nix/store/yidcpw0fsqryxdbi00sgaskaw7wb9pps-stderr-runner /nix/store/k2j2d9gd1n8yggn5lv605pgjjnpy8706-nixos-system-other-test/bin/switch-to-configuration test, in 1.64 seconds) subtest: services machine: must succeed: /nix/store/bjj1c5xdq9j21a84h34012nm3dspv0yf-nixos-system-machine-test/bin/switch-to-configuration test 2>&1 machine # [ 17.270664] nixos[1145]: switching to system configuration /nix/store/bjj1c5xdq9j21a84h34012nm3dspv0yf-nixos-system-machine-test machine # [ 17.272916] systemd[1]: Stopped target Remote File Systems. machine # [ 17.274493] systemd[1]: Stopped target Local File Systems. machine # [ 17.474256] systemd[1]: Reload requested from client PID 1145 ('.switch-to-conf') (unit backdoor.service)... machine # [ 17.475877] systemd[1]: Reloading... machine # [ 17.697920] systemd[1]: Reloading finished in 220 ms. machine # [ 17.761629] systemd[619]: Reexecution requested from client PID 1214 ('switch-to-confi')... machine # [ 17.763262] systemd[619]: Reexecuting. machine # [ 17.784268] systemd[619]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 17.856462] systemd[619]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 17.861758] systemd[619]: Reload requested from client PID 1214 ('switch-to-confi')... machine # [ 17.863544] systemd[619]: Reloading... machine # [ 17.935878] systemd[619]: Reloading finished in 71 ms. machine # [ 17.942852] systemd[619]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 17.949924] systemd[619]: Stopped Run user-specific NixOS activation. machine # [ 17.950857] systemd[619]: Stopping Run user-specific NixOS activation... machine # [ 17.952566] systemd[619]: Starting Run user-specific NixOS activation... machine # [ 17.972785] systemd[619]: Finished Run user-specific NixOS activation. machine # [ 17.976796] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 17.979400] systemd[1]: Stopping Reactivate sysinit units... machine # [ 17.980692] systemd[1]: Reached target Reactivate sysinit units. machine # [ 17.981945] dbus-broker-launch[498]: Caught SIGHUP, trigger reload. machine # [ 17.982982] systemd[1]: Reloading D-Bus System Message Bus... machine # [ 17.986264] dbus-broker-launch[498]: Looking up NSS user entry for 'systemd-timesync'... machine # [ 17.988045] dbus-broker-launch[498]: NSS returned no entry for 'systemd-timesync' machine # [ 17.989065] dbus-broker-launch[498]: Invalid user-name in /nix/store/mvyffb3y17ijfnb0xcf0lyfs9p3sxar1-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" machine # [ 17.998609] systemd[1]: Reloaded D-Bus System Message Bus. machine # [ 18.002449] systemd[1]: Stopping Address configuration of eth1... machine # [ 18.036816] network-addresses-eth1-pre-stop[1226]: deleting address 192.168.1.2/24... done machine # [ 18.043950] network-addresses-eth1-pre-stop[1226]: deleting address 2001:db8:1::2/64... done machine # [ 18.049845] systemd[1]: network-addresses-eth1.service: Deactivated successfully. machine # [ 18.051973] systemd[1]: Stopped Address configuration of eth1. machine # [ 18.057198] systemd[1]: Starting Address configuration of eth1... machine # [ 18.082674] network-addresses-eth1-start[1231]: adding address 192.168.1.1/24... done machine # [ 18.087636] network-addresses-eth1-start[1231]: adding address 2001:db8:1::1/64... done machine # [ 18.094094] systemd[1]: Finished Address configuration of eth1. machine # [ 18.098090] systemd[1]: Reached target Local File Systems. machine # [ 18.100331] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 18.102292] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 18.104426] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 18.106413] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 18.109080] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 18.111355] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 18.114408] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 18.116207] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 18.117417] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 18.121690] systemd[1]: Reached target Remote File Systems. machine # [ 18.257119] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 18.258337] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 18.262631] systemd[1]: Starting linger-users.service... machine # [ 18.286130] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 18.287656] systemd[1]: Finished linger-users.service. machine # [ 18.543670] nixos[1145]: finished switching to system configuration /nix/store/bjj1c5xdq9j21a84h34012nm3dspv0yf-nixos-system-machine-test machine: (finished: must succeed: /nix/store/bjj1c5xdq9j21a84h34012nm3dspv0yf-nixos-system-machine-test/bin/switch-to-configuration test 2>&1, in 1.48 seconds) machine: must succeed: /nix/store/bjj1c5xdq9j21a84h34012nm3dspv0yf-nixos-system-machine-test/bin/switch-to-configuration test 2>&1 machine # [ 18.714323] nixos[1301]: switching to system configuration /nix/store/bjj1c5xdq9j21a84h34012nm3dspv0yf-nixos-system-machine-test machine # [ 18.717648] systemd[1]: Stopped target Local File Systems. machine # [ 18.718779] systemd[1]: Stopped target Remote File Systems. machine # [ 18.927342] systemd[1]: Reload requested from client PID 1301 ('.switch-to-conf') (unit backdoor.service)... machine # [ 18.929119] systemd[1]: Reloading... machine # [ 19.166906] systemd[1]: Reloading finished in 235 ms. machine # [ 19.229362] systemd[619]: Reexecution requested from client PID 1370 ('switch-to-confi')... machine # [ 19.230794] systemd[619]: Reexecuting. machine # [ 19.251129] systemd[619]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 19.325092] systemd[619]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 19.330650] systemd[619]: Reload requested from client PID 1370 ('switch-to-confi')... machine # [ 19.332308] systemd[619]: Reloading... machine # [ 19.405599] systemd[619]: Reloading finished in 71 ms. machine # [ 19.409848] systemd[619]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 19.417080] systemd[619]: Stopped Run user-specific NixOS activation. machine # [ 19.418110] systemd[619]: Stopping Run user-specific NixOS activation... machine # [ 19.420129] systemd[619]: Starting Run user-specific NixOS activation... machine # [ 19.442329] systemd[619]: Finished Run user-specific NixOS activation. machine # [ 19.445759] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 19.446921] systemd[1]: Stopping Reactivate sysinit units... machine # [ 19.448143] systemd[1]: Reached target Reactivate sysinit units. machine # [ 19.449923] systemd[1]: Reached target Remote File Systems. machine # [ 19.452856] systemd[1]: Reached target Local File Systems. machine # [ 19.457788] systemd[1]: Starting linger-users.service... machine # [ 19.462719] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 19.464131] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 19.469108] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 19.472434] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 19.474091] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 19.475471] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 19.477755] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 19.479465] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 19.485263] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 19.519374] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 19.521165] systemd[1]: Finished linger-users.service. machine # [ 19.630297] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 19.633375] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 19.889691] nixos[1301]: finished switching to system configuration /nix/store/bjj1c5xdq9j21a84h34012nm3dspv0yf-nixos-system-machine-test machine: (finished: must succeed: /nix/store/bjj1c5xdq9j21a84h34012nm3dspv0yf-nixos-system-machine-test/bin/switch-to-configuration test 2>&1, in 1.35 seconds) machine: must succeed: /nix/store/bjj1c5xdq9j21a84h34012nm3dspv0yf-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration test 2>&1 machine # [ 20.119931] nixos[1441]: switching to system configuration /nix/store/3yvpjwccrvbsl4ar45z6w1j4myfmww06-nixos-system-machine-test machine # [ 20.122298] systemd[1]: Stopped target Local File Systems. machine # [ 20.123833] systemd[1]: Stopped target Remote File Systems. machine # [ 20.354228] systemd[1]: Reload requested from client PID 1441 ('.switch-to-conf') (unit backdoor.service)... machine # [ 20.355896] systemd[1]: Reloading... machine # [ 20.597139] systemd[1]: Reloading finished in 239 ms. machine # [ 20.659613] systemd[619]: Reexecution requested from client PID 1510 ('switch-to-confi')... machine # [ 20.661132] systemd[619]: Reexecuting. machine # [ 20.681210] systemd[619]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 20.757393] systemd[619]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 20.762498] systemd[619]: Reload requested from client PID 1510 ('switch-to-confi')... machine # [ 20.764398] systemd[619]: Reloading... machine # [ 20.840707] systemd[619]: Reloading finished in 75 ms. machine # [ 20.845853] systemd[619]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 20.851982] systemd[619]: Stopped Run user-specific NixOS activation. machine # [ 20.852993] systemd[619]: Stopping Run user-specific NixOS activation... machine # [ 20.855498] systemd[619]: Starting Run user-specific NixOS activation... machine # [ 20.876589] systemd[619]: Finished Run user-specific NixOS activation. machine # [ 20.879865] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 20.881157] systemd[1]: Stopping Reactivate sysinit units... machine # [ 20.881908] systemd[1]: Reached target Reactivate sysinit units. machine # [ 20.884829] systemd[1]: Reached target Local File Systems. machine # [ 20.886941] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 20.888840] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 20.891841] systemd[1]: Reached target Remote File Systems. machine # [ 20.897060] systemd[1]: Starting linger-users.service... machine # [ 20.899097] systemd[1]: Starting test.service... machine # [ 20.902770] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 20.910252] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 20.912246] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 20.915107] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 20.917055] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 20.918454] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 20.921181] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 20.948188] systemd[1]: Finished test.service. machine # [ 20.968501] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 20.970664] systemd[1]: Finished linger-users.service. machine # [ 21.079892] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 21.081762] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 21.337949] nixos[1441]: finished switching to system configuration /nix/store/3yvpjwccrvbsl4ar45z6w1j4myfmww06-nixos-system-machine-test machine: (finished: must succeed: /nix/store/bjj1c5xdq9j21a84h34012nm3dspv0yf-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration test 2>&1, in 1.45 seconds) machine: must succeed: /nix/store/bjj1c5xdq9j21a84h34012nm3dspv0yf-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration test 2>&1 machine # [ 21.566096] nixos[1584]: switching to system configuration /nix/store/3yvpjwccrvbsl4ar45z6w1j4myfmww06-nixos-system-machine-test machine # [ 21.568701] systemd[1]: Stopped target Local File Systems. machine # [ 21.570570] systemd[1]: Stopped target Remote File Systems. machine # [ 21.785417] systemd[1]: Reload requested from client PID 1584 ('.switch-to-conf') (unit backdoor.service)... machine # [ 21.787422] systemd[1]: Reloading... machine # [ 22.044410] systemd[1]: Reloading finished in 255 ms. machine # [ 22.111877] systemd[619]: Reexecution requested from client PID 1653 ('switch-to-confi')... machine # [ 22.114611] systemd[619]: Reexecuting. machine # [ 22.136429] systemd[619]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 22.212835] systemd[619]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 22.218346] systemd[619]: Reload requested from client PID 1653 ('switch-to-confi')... machine # [ 22.219741] systemd[619]: Reloading... machine # [ 22.296436] systemd[619]: Reloading finished in 74 ms. machine # [ 22.300850] systemd[619]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 22.307258] systemd[619]: Stopped Run user-specific NixOS activation. machine # [ 22.308412] systemd[619]: Stopping Run user-specific NixOS activation... machine # [ 22.311163] systemd[619]: Starting Run user-specific NixOS activation... machine # [ 22.332339] systemd[619]: Finished Run user-specific NixOS activation. machine # [ 22.335754] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 22.337255] systemd[1]: Stopping Reactivate sysinit units... machine # [ 22.338839] systemd[1]: Reached target Reactivate sysinit units. machine # [ 22.340547] systemd[1]: Reached target Remote File Systems. machine # [ 22.344161] systemd[1]: Starting linger-users.service... machine # [ 22.352626] systemd[1]: Reached target Local File Systems. machine # [ 22.353579] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 22.356060] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 22.358746] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 22.360153] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 22.362374] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 22.363849] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 22.368720] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 22.377063] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 22.378337] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 22.411085] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 22.412646] systemd[1]: Finished linger-users.service. machine # [ 22.527598] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 22.530707] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 22.787187] nixos[1584]: finished switching to system configuration /nix/store/3yvpjwccrvbsl4ar45z6w1j4myfmww06-nixos-system-machine-test machine: (finished: must succeed: /nix/store/bjj1c5xdq9j21a84h34012nm3dspv0yf-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration test 2>&1, in 1.45 seconds) machine: must succeed: /nix/store/bjj1c5xdq9j21a84h34012nm3dspv0yf-nixos-system-machine-test/specialisation/simpleServiceDifferentDescription/bin/switch-to-configuration test 2>&1 machine # [ 23.043611] nixos[1724]: switching to system configuration /nix/store/lij69s3cxr3i7z7rv2ca2v1nkws5wp6y-nixos-system-machine-test machine # [ 23.047393] systemd[1]: Stopped target Local File Systems. machine # [ 23.048607] systemd[1]: Stopped target Remote File Systems. machine # [ 23.284671] systemd[1]: Reload requested from client PID 1724 ('.switch-to-conf') (unit backdoor.service)... machine # [ 23.286330] systemd[1]: Reloading... machine # [ 23.561767] systemd[1]: Reloading finished in 274 ms. machine # [ 23.627318] systemd[619]: Reexecution requested from client PID 1793 ('switch-to-confi')... machine # [ 23.629706] systemd[619]: Reexecuting. machine # [ 23.651235] systemd[619]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 23.727440] systemd[619]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 23.732690] systemd[619]: Reload requested from client PID 1793 ('switch-to-confi')... machine # [ 23.734951] systemd[619]: Reloading... machine # [ 23.809764] systemd[619]: Reloading finished in 75 ms. machine # [ 23.815922] systemd[619]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 23.822257] systemd[619]: Stopped Run user-specific NixOS activation. machine # [ 23.824063] systemd[619]: Stopping Run user-specific NixOS activation... machine # [ 23.825697] systemd[619]: Starting Run user-specific NixOS activation... machine # [ 23.846398] systemd[619]: Finished Run user-specific NixOS activation. machine # [ 23.849687] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 23.850987] systemd[1]: Stopping Reactivate sysinit units... machine # [ 23.851957] systemd[1]: Reached target Reactivate sysinit units. machine # [ 23.854278] systemd[1]: Reached target Remote File Systems. machine # [ 23.858297] systemd[1]: Reached target Local File Systems. machine # [ 23.860154] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 23.863263] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 23.864890] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 23.866854] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 23.869717] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 23.872280] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 23.873598] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 23.880231] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 23.881486] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 24.011894] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 24.013840] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 24.018146] systemd[1]: Starting linger-users.service... machine # [ 24.046281] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 24.048960] systemd[1]: Finished linger-users.service. machine # [ 24.306108] nixos[1724]: finished switching to system configuration /nix/store/lij69s3cxr3i7z7rv2ca2v1nkws5wp6y-nixos-system-machine-test machine: (finished: must succeed: /nix/store/bjj1c5xdq9j21a84h34012nm3dspv0yf-nixos-system-machine-test/specialisation/simpleServiceDifferentDescription/bin/switch-to-configuration test 2>&1, in 1.52 seconds) machine: must succeed: /nix/store/bjj1c5xdq9j21a84h34012nm3dspv0yf-nixos-system-machine-test/specialisation/simpleServiceModified/bin/switch-to-configuration test 2>&1 machine # [ 24.573704] nixos[1864]: switching to system configuration /nix/store/7xqyrn89hvicmsrsmdvar5k2pzlh51c2-nixos-system-machine-test machine # [ 24.576383] systemd[1]: test.service: Deactivated successfully. machine # [ 24.578193] systemd[1]: Stopped Test unit. machine # [ 24.579596] systemd[1]: Stopped target Remote File Systems. machine # [ 24.581242] systemd[1]: Stopped target Local File Systems. machine # [ 24.813449] systemd[1]: Reload requested from client PID 1864 ('.switch-to-conf') (unit backdoor.service)... machine # [ 24.815134] systemd[1]: Reloading... machine # [ 25.070739] systemd[1]: Reloading finished in 253 ms. machine # [ 25.136227] systemd[619]: Reexecution requested from client PID 1934 ('switch-to-confi')... machine # [ 25.138113] systemd[619]: Reexecuting. machine # [ 25.163315] systemd[619]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 25.239867] systemd[619]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 25.245246] systemd[619]: Reload requested from client PID 1934 ('switch-to-confi')... machine # [ 25.246694] systemd[619]: Reloading... machine # [ 25.322751] systemd[619]: Reloading finished in 74 ms. machine # [ 25.327855] systemd[619]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 25.334038] systemd[619]: Stopped Run user-specific NixOS activation. machine # [ 25.335975] systemd[619]: Stopping Run user-specific NixOS activation... machine # [ 25.337572] systemd[619]: Starting Run user-specific NixOS activation... machine # [ 25.358445] systemd[619]: Finished Run user-specific NixOS activation. machine # [ 25.361602] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 25.362898] systemd[1]: Stopping Reactivate sysinit units... machine # [ 25.363924] systemd[1]: Reached target Reactivate sysinit units. machine # [ 25.369459] systemd[1]: Reached target Local File Systems. machine # [ 25.370860] systemd[1]: Reached target Remote File Systems. machine # [ 25.375385] systemd[1]: Starting test.service... machine # [ 25.377650] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 25.379293] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 25.386298] systemd[1]: Starting linger-users.service... machine # [ 25.393320] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 25.395133] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 25.397055] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 25.398203] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 25.400203] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 25.404882] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 25.406118] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 25.429218] systemd[1]: Finished test.service. machine # [ 25.450477] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 25.452528] systemd[1]: Finished linger-users.service. machine # [ 25.564163] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 25.565801] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 25.824751] nixos[1864]: finished switching to system configuration /nix/store/7xqyrn89hvicmsrsmdvar5k2pzlh51c2-nixos-system-machine-test machine: (finished: must succeed: /nix/store/bjj1c5xdq9j21a84h34012nm3dspv0yf-nixos-system-machine-test/specialisation/simpleServiceModified/bin/switch-to-configuration test 2>&1, in 1.52 seconds) machine: must succeed: /nix/store/bjj1c5xdq9j21a84h34012nm3dspv0yf-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1 machine # [ 26.071613] nixos[2007]: switching to system configuration /nix/store/01y880ynwcg44b8zrcwzdvsfdsra5d9s-nixos-system-machine-test machine # [ 26.075406] systemd[1]: Stopped target Local File Systems. machine # [ 26.076388] systemd[1]: Stopped target Remote File Systems. machine # [ 26.308902] systemd[1]: Reload requested from client PID 2007 ('.switch-to-conf') (unit backdoor.service)... machine # [ 26.310653] systemd[1]: Reloading... machine # [ 26.564921] systemd[1]: Reloading finished in 253 ms. machine # [ 26.630724] systemd[619]: Reexecution requested from client PID 2076 ('switch-to-confi')... machine # [ 26.632628] systemd[619]: Reexecuting. machine # [ 26.654247] systemd[619]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 26.729931] systemd[619]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 26.735336] systemd[619]: Reload requested from client PID 2076 ('switch-to-confi')... machine # [ 26.736564] systemd[619]: Reloading... machine # [ 26.813129] systemd[619]: Reloading finished in 74 ms. machine # [ 26.818915] systemd[619]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 26.826074] systemd[619]: Stopped Run user-specific NixOS activation. machine # [ 26.826912] systemd[619]: Stopping Run user-specific NixOS activation... machine # [ 26.828750] systemd[619]: Starting Run user-specific NixOS activation... machine # [ 26.849266] systemd[619]: Finished Run user-specific NixOS activation. machine # [ 26.852334] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 26.853613] systemd[1]: Stopping Reactivate sysinit units... machine # [ 26.854645] systemd[1]: Reached target Reactivate sysinit units. machine # [ 26.856300] systemd[1]: test.service: Deactivated successfully. machine # [ 26.858231] systemd[1]: Stopped test.service. machine # [ 26.858846] systemd[1]: Stopping test.service... machine # [ 26.860296] systemd[1]: Starting test.service... machine # [ 26.875137] systemd[1]: Finished test.service. machine # [ 26.877738] systemd[1]: Reached target Remote File Systems. machine # [ 26.879551] systemd[1]: Reached target Local File Systems. machine # [ 26.886598] systemd[1]: Starting linger-users.service... machine # [ 26.892798] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 26.894204] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 26.898554] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 26.901450] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 26.903064] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 26.904230] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 26.906846] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 26.908305] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 26.909848] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 26.948081] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 26.949755] systemd[1]: Finished linger-users.service. machine # [ 27.062165] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 27.064082] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 27.320738] nixos[2007]: finished switching to system configuration /nix/store/01y880ynwcg44b8zrcwzdvsfdsra5d9s-nixos-system-machine-test machine: (finished: must succeed: /nix/store/bjj1c5xdq9j21a84h34012nm3dspv0yf-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1, in 1.50 seconds) machine: must succeed: /nix/store/bjj1c5xdq9j21a84h34012nm3dspv0yf-nixos-system-machine-test/specialisation/simpleServiceReload/bin/switch-to-configuration test 2>&1 machine # [ 27.576478] nixos[2149]: switching to system configuration /nix/store/a4kwvpz75g44sf5ayw26919gncwx4743-nixos-system-machine-test machine # [ 27.578900] systemd[1]: Stopped target Remote File Systems. machine # [ 27.580793] systemd[1]: Stopped target Local File Systems. machine # [ 27.838671] systemd[1]: Reload requested from client PID 2149 ('.switch-to-conf') (unit backdoor.service)... machine # [ 27.840389] systemd[1]: Reloading... machine # [ 28.096237] systemd[1]: Reloading finished in 253 ms. machine # [ 28.161801] systemd[619]: Reexecution requested from client PID 2219 ('switch-to-confi')... machine # [ 28.164377] systemd[619]: Reexecuting. machine # [ 28.185272] systemd[619]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 28.261746] systemd[619]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 28.266925] systemd[619]: Reload requested from client PID 2219 ('switch-to-confi')... machine # [ 28.268701] systemd[619]: Reloading... machine # [ 28.343845] systemd[619]: Reloading finished in 74 ms. machine # [ 28.349909] systemd[619]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 28.356167] systemd[619]: Stopped Run user-specific NixOS activation. machine # [ 28.358058] systemd[619]: Stopping Run user-specific NixOS activation... machine # [ 28.359748] systemd[619]: Starting Run user-specific NixOS activation... machine # [ 28.380559] systemd[619]: Finished Run user-specific NixOS activation. machine # [ 28.383702] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 28.384909] systemd[1]: Stopping Reactivate sysinit units... machine # [ 28.385915] systemd[1]: Reached target Reactivate sysinit units. machine # [ 28.389227] systemd[1]: Reloading test.service... machine # [ 28.404200] systemd[1]: Reloaded test.service. machine # [ 28.409809] systemd[1]: Reached target Local File Systems. machine # [ 28.412192] systemd[1]: Reached target Remote File Systems. machine # [ 28.415201] systemd[1]: Starting linger-users.service... machine # [ 28.420042] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 28.423595] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 28.424589] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 28.425738] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 28.427655] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 28.429093] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 28.430330] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 28.439373] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 28.441117] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 28.476842] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 28.478618] systemd[1]: Finished linger-users.service. machine # [ 28.592157] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 28.594070] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 28.852574] nixos[2149]: finished switching to system configuration /nix/store/a4kwvpz75g44sf5ayw26919gncwx4743-nixos-system-machine-test machine: (finished: must succeed: /nix/store/bjj1c5xdq9j21a84h34012nm3dspv0yf-nixos-system-machine-test/specialisation/simpleServiceReload/bin/switch-to-configuration test 2>&1, in 1.53 seconds) machine: must succeed: /nix/store/bjj1c5xdq9j21a84h34012nm3dspv0yf-nixos-system-machine-test/specialisation/simpleServiceNorestart/bin/switch-to-configuration test 2>&1 machine # [ 29.106262] nixos[2292]: switching to system configuration /nix/store/xwy9p44k04060m4ryvk8p1r28l1si72r-nixos-system-machine-test machine # [ 29.108358] systemd[1]: Stopped target Local File Systems. machine # [ 29.110052] systemd[1]: Stopped target Remote File Systems. machine # [ 29.344934] systemd[1]: Reload requested from client PID 2292 ('.switch-to-conf') (unit backdoor.service)... machine # [ 29.346669] systemd[1]: Reloading... machine # [ 29.609814] systemd[1]: Reloading finished in 261 ms. machine # [ 29.671439] systemd[619]: Reexecution requested from client PID 2361 ('switch-to-confi')... machine # [ 29.672800] systemd[619]: Reexecuting. machine # [ 29.694174] systemd[619]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 29.765983] systemd[619]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 29.771345] systemd[619]: Reload requested from client PID 2361 ('switch-to-confi')... machine # [ 29.772795] systemd[619]: Reloading... machine # [ 29.844271] systemd[619]: Reloading finished in 70 ms. machine # [ 29.849911] systemd[619]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 29.856323] systemd[619]: Stopped Run user-specific NixOS activation. machine # [ 29.858120] systemd[619]: Stopping Run user-specific NixOS activation... machine # [ 29.859936] systemd[619]: Starting Run user-specific NixOS activation... machine # [ 29.879662] systemd[619]: Finished Run user-specific NixOS activation. machine # [ 29.882769] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 29.884212] systemd[1]: Stopping Reactivate sysinit units... machine # [ 29.885389] systemd[1]: Reached target Reactivate sysinit units. machine # [ 29.888162] systemd[1]: Reached target Local File Systems. machine # [ 29.891286] systemd[1]: Reached target Remote File Systems. machine # [ 29.895120] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 29.898174] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 29.898980] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 29.901940] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 29.904680] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 29.907121] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 29.908384] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 29.911309] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 29.912613] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 30.044836] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 30.046589] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 30.050500] systemd[1]: Starting linger-users.service... machine # [ 30.078688] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 30.080246] systemd[1]: Finished linger-users.service. machine # [ 30.339223] nixos[2292]: finished switching to system configuration /nix/store/xwy9p44k04060m4ryvk8p1r28l1si72r-nixos-system-machine-test machine: (finished: must succeed: /nix/store/bjj1c5xdq9j21a84h34012nm3dspv0yf-nixos-system-machine-test/specialisation/simpleServiceNorestart/bin/switch-to-configuration test 2>&1, in 1.49 seconds) machine: must succeed: /nix/store/bjj1c5xdq9j21a84h34012nm3dspv0yf-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration dry-activate 2>&1 machine: (finished: must succeed: /nix/store/bjj1c5xdq9j21a84h34012nm3dspv0yf-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration dry-activate 2>&1, in 0.27 seconds) machine: must succeed: /nix/store/bjj1c5xdq9j21a84h34012nm3dspv0yf-nixos-system-machine-test/bin/switch-to-configuration test 2>&1 machine # [ 30.800617] nixos[2442]: switching to system configuration /nix/store/bjj1c5xdq9j21a84h34012nm3dspv0yf-nixos-system-machine-test machine # [ 30.803217] systemd[1]: Stopped target Local File Systems. machine # [ 30.805485] systemd[1]: test.service: Deactivated successfully. machine # [ 30.806515] systemd[1]: Stopped test.service. machine # [ 30.807778] systemd[1]: Stopped target Remote File Systems. machine # [ 31.052193] systemd[1]: Reload requested from client PID 2442 ('.switch-to-conf') (unit backdoor.service)... machine # [ 31.053839] systemd[1]: Reloading... machine # [ 31.283921] systemd[1]: Reloading finished in 228 ms. machine # [ 31.347361] systemd[619]: Reexecution requested from client PID 2512 ('switch-to-confi')... machine # [ 31.349597] systemd[619]: Reexecuting. machine # [ 31.370131] systemd[619]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 31.444667] systemd[619]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 31.450060] systemd[619]: Reload requested from client PID 2512 ('switch-to-confi')... machine # [ 31.451283] systemd[619]: Reloading... machine # [ 31.527482] systemd[619]: Reloading finished in 74 ms. machine # [ 31.532848] systemd[619]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 31.538941] systemd[619]: Stopped Run user-specific NixOS activation. machine # [ 31.539910] systemd[619]: Stopping Run user-specific NixOS activation... machine # [ 31.542649] systemd[619]: Starting Run user-specific NixOS activation... machine # [ 31.563335] systemd[619]: Finished Run user-specific NixOS activation. machine # [ 31.566398] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 31.567833] systemd[1]: Stopping Reactivate sysinit units... machine # [ 31.569125] systemd[1]: Reached target Reactivate sysinit units. machine # [ 31.571138] systemd[1]: Reached target Remote File Systems. machine # [ 31.573740] systemd[1]: Starting linger-users.service... machine # [ 31.584816] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 31.586558] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 31.589937] systemd[1]: Reached target Local File Systems. machine # [ 31.592244] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 31.595315] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 31.597238] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 31.599587] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 31.601607] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 31.603099] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 31.604261] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 31.641100] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 31.642798] systemd[1]: Finished linger-users.service. machine # [ 31.763885] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 31.765627] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 32.023781] nixos[2442]: finished switching to system configuration /nix/store/bjj1c5xdq9j21a84h34012nm3dspv0yf-nixos-system-machine-test machine: (finished: must succeed: /nix/store/bjj1c5xdq9j21a84h34012nm3dspv0yf-nixos-system-machine-test/bin/switch-to-configuration test 2>&1, in 1.41 seconds) machine: must succeed: /nix/store/ckqyqvyhywrgy4ddqqn2qwwbd2pnl2xj-separate-activation-script/bin/switch-to-configuration test 2>&1 machine # [ 32.253498] nixos[2583]: switching to system configuration /nix/store/5py7c3gdxbajvfkkrkjfnjc79prn50fc-nixos-system-machine-test machine # [ 32.257068] systemd[1]: Stopped target Remote File Systems. machine # [ 32.257974] systemd[1]: Stopped target Local File Systems. machine # [ 32.491270] systemd[1]: Reload requested from client PID 2583 ('.switch-to-conf') (unit backdoor.service)... machine # [ 32.492922] systemd[1]: Reloading... machine # [ 32.740951] systemd[1]: Reloading finished in 246 ms. machine # [ 32.811650] systemd[619]: Stopped Run user-specific NixOS activation. machine # [ 32.813246] systemd[619]: Reexecution requested from client PID 2652 ('switch-to-confi')... machine # [ 32.815723] systemd[619]: Reexecuting. machine # [ 32.837286] systemd[619]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 32.914177] systemd[619]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 32.919661] systemd[619]: Reload requested from client PID 2652 ('switch-to-confi')... machine # [ 32.921356] systemd[619]: Reloading... machine # [ 32.996704] systemd[619]: Reloading finished in 74 ms. machine # [ 33.001854] systemd[619]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 33.009236] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 33.010557] systemd[1]: Stopping Reactivate sysinit units... machine # [ 33.011438] systemd[1]: Reached target Reactivate sysinit units. machine # [ 33.016740] systemd[1]: Reached target Remote File Systems. machine # [ 33.020205] systemd[1]: Starting linger-users.service... machine # [ 33.022471] systemd[1]: Starting test.service... machine # [ 33.026095] systemd[1]: Reached target Local File Systems. machine # [ 33.026844] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 33.033229] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 33.033969] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 33.035094] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 33.037063] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 33.038436] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 33.039587] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 33.046784] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 33.048093] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 33.079547] systemd[1]: Finished test.service. machine # [ 33.101138] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 33.102381] systemd[1]: Finished linger-users.service. machine # [ 33.213725] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 33.215473] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 33.474589] nixos[2583]: finished switching to system configuration /nix/store/5py7c3gdxbajvfkkrkjfnjc79prn50fc-nixos-system-machine-test machine: (finished: must succeed: /nix/store/ckqyqvyhywrgy4ddqqn2qwwbd2pnl2xj-separate-activation-script/bin/switch-to-configuration test 2>&1, in 1.45 seconds) machine: must succeed: ! test -e /run/current-system/activate machine: (finished: must succeed: ! test -e /run/current-system/activate, in 0.02 seconds) machine: must succeed: ! test -e /run/current-system/dry-activate machine: (finished: must succeed: ! test -e /run/current-system/dry-activate, in 0.02 seconds) machine: must succeed: ! test -e /run/current-system/bin/switch-to-configuration machine: (finished: must succeed: ! test -e /run/current-system/bin/switch-to-configuration, in 0.02 seconds) machine: must succeed: /nix/store/bjj1c5xdq9j21a84h34012nm3dspv0yf-nixos-system-machine-test/specialisation/unitWithMultilineValue/bin/switch-to-configuration test 2>&1 machine # [ 33.764622] nixos[2731]: switching to system configuration /nix/store/r7lpj9j2hkx3l02x84d4jibzsq3hfq2c-nixos-system-machine-test machine # [ 33.767803] systemd[1]: test.service: Deactivated successfully. machine # [ 33.768742] systemd[1]: Stopped test.service. machine # [ 33.769956] systemd[1]: Stopped target Remote File Systems. machine # [ 33.771609] systemd[1]: Stopped target Local File Systems. machine # [ 34.007761] systemd[1]: Reload requested from client PID 2731 ('.switch-to-conf') (unit backdoor.service)... machine # [ 34.010580] systemd[1]: Reloading... machine # [ 34.262984] systemd[1]: Reloading finished in 249 ms. machine # [ 34.348409] systemd[619]: Reexecution requested from client PID 2800 ('switch-to-confi')... machine # [ 34.349732] systemd[619]: Reexecuting. machine # [ 34.370183] systemd[619]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 34.442429] systemd[619]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 34.447398] systemd[619]: Reload requested from client PID 2800 ('switch-to-confi')... machine # [ 34.448789] systemd[619]: Reloading... machine # [ 34.522083] systemd[619]: Reloading finished in 71 ms. machine # [ 34.527870] systemd[619]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 34.534545] systemd[619]: Starting Run user-specific NixOS activation... machine # [ 34.557056] systemd[619]: Finished Run user-specific NixOS activation. machine # [ 34.560395] systemd[619]: Stopped Run user-specific NixOS activation. machine # [ 34.561331] systemd[619]: Stopping Run user-specific NixOS activation... machine # [ 34.564061] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 34.565714] systemd[619]: Starting Run user-specific NixOS activation... machine # [ 34.567302] systemd[1]: Stopping Reactivate sysinit units... machine # [ 34.571272] systemd[1]: Reached target Reactivate sysinit units. machine # [ 34.572887] systemd[1]: Reached target Remote File Systems. machine # [ 34.575594] systemd[1]: Reached target Local File Systems. machine # [ 34.579862] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 34.587664] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 34.588528] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 34.590849] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 34.593570] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 34.596167] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 34.599536] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 34.603166] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 34.604360] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 34.629773] systemd[619]: Finished Run user-specific NixOS activation. machine # [ 34.747196] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 34.748917] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 34.752730] systemd[1]: Starting linger-users.service... machine # [ 34.756063] systemd[1]: Started test.service. machine # [ 34.780805] systemd[1]: test.service: Deactivated successfully. machine # [ 34.796974] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 34.798530] systemd[1]: Finished linger-users.service. machine # [ 35.056563] nixos[2731]: finished switching to system configuration /nix/store/r7lpj9j2hkx3l02x84d4jibzsq3hfq2c-nixos-system-machine-test machine: (finished: must succeed: /nix/store/bjj1c5xdq9j21a84h34012nm3dspv0yf-nixos-system-machine-test/specialisation/unitWithMultilineValue/bin/switch-to-configuration test 2>&1, in 1.52 seconds) machine: must succeed: /nix/store/bjj1c5xdq9j21a84h34012nm3dspv0yf-nixos-system-machine-test/specialisation/unitWithBackslash/bin/switch-to-configuration test 2>&1 machine # [ 35.291718] nixos[2877]: switching to system configuration /nix/store/d3afj3llj4lkf1mb8m4c3pvx23rj31ns-nixos-system-machine-test machine # [ 35.293921] systemd[1]: Stopped target Remote File Systems. machine # [ 35.295604] systemd[1]: Stopped target Local File Systems. machine # [ 35.535176] systemd[1]: Reload requested from client PID 2877 ('.switch-to-conf') (unit backdoor.service)... machine # [ 35.536831] systemd[1]: Reloading... machine # [ 35.777652] systemd[1]: Reloading finished in 239 ms. machine # [ 35.840116] systemd[619]: Reexecution requested from client PID 2946 ('switch-to-confi')... machine # [ 35.842634] systemd[619]: Reexecuting. machine # [ 35.864172] systemd[619]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 35.937861] systemd[619]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 35.943303] systemd[619]: Reload requested from client PID 2946 ('switch-to-confi')... machine # [ 35.944682] systemd[619]: Reloading... machine # [ 36.016592] systemd[619]: Reloading finished in 70 ms. machine # [ 36.021842] systemd[619]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 36.028321] systemd[619]: Stopped Run user-specific NixOS activation. machine # [ 36.030064] systemd[619]: Stopping Run user-specific NixOS activation... machine # [ 36.031744] systemd[619]: Starting Run user-specific NixOS activation... machine # [ 36.051816] systemd[619]: Finished Run user-specific NixOS activation. machine # [ 36.055564] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 36.056903] systemd[1]: Stopping Reactivate sysinit units... machine # [ 36.057829] systemd[1]: Reached target Reactivate sysinit units. machine # [ 36.063547] systemd[1]: Reached target Remote File Systems. machine # [ 36.066058] systemd[1]: Reached target Local File Systems. machine # [ 36.068147] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 36.071594] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 36.072680] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 36.073862] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 36.075824] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 36.077246] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 36.078370] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 36.083192] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 36.084407] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 36.212128] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 36.213881] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 36.217506] systemd[1]: Starting escaped\x2ddash.service... machine # [ 36.221464] systemd[1]: Starting linger-users.service... machine # [ 36.243505] systemd[1]: Finished escaped\x2ddash.service. machine # [ 36.257549] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 36.259070] systemd[1]: Finished linger-users.service. machine # [ 36.516182] nixos[2877]: finished switching to system configuration /nix/store/d3afj3llj4lkf1mb8m4c3pvx23rj31ns-nixos-system-machine-test machine: (finished: must succeed: /nix/store/bjj1c5xdq9j21a84h34012nm3dspv0yf-nixos-system-machine-test/specialisation/unitWithBackslash/bin/switch-to-configuration test 2>&1, in 1.46 seconds) machine: must succeed: /nix/store/bjj1c5xdq9j21a84h34012nm3dspv0yf-nixos-system-machine-test/specialisation/unitWithBackslashModified/bin/switch-to-configuration test 2>&1 machine # [ 36.709837] nixos[3019]: switching to system configuration /nix/store/ppzrsyvx4qfgw9ng6dj4zazfm53xh5pw-nixos-system-machine-test machine # [ 36.712600] systemd[1]: Stopped target Local File Systems. machine # [ 36.714226] systemd[1]: escaped\x2ddash.service: Deactivated successfully. machine # [ 36.715492] systemd[1]: Stopped escaped\x2ddash.service. machine # [ 36.716930] systemd[1]: Stopped target Remote File Systems. machine # [ 36.943855] systemd[1]: Reload requested from client PID 3019 ('.switch-to-conf') (unit backdoor.service)... machine # [ 36.945589] systemd[1]: Reloading... machine # [ 37.190186] systemd[1]: Reloading finished in 242 ms. machine # [ 37.282309] systemd[619]: Reexecution requested from client PID 3088 ('switch-to-confi')... machine # [ 37.283568] systemd[619]: Reexecuting. machine # [ 37.303091] systemd[619]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 37.374585] systemd[619]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 37.379826] systemd[619]: Reload requested from client PID 3088 ('switch-to-confi')... machine # [ 37.381442] systemd[619]: Reloading... machine # [ 37.453703] systemd[619]: Reloading finished in 71 ms. machine # [ 37.458851] systemd[619]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 37.465182] systemd[619]: Stopped Run user-specific NixOS activation. machine # [ 37.467145] systemd[619]: Stopping Run user-specific NixOS activation... machine # [ 37.468727] systemd[619]: Starting Run user-specific NixOS activation... machine # [ 37.489149] systemd[619]: Finished Run user-specific NixOS activation. machine # [ 37.492318] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 37.493770] systemd[1]: Stopping Reactivate sysinit units... machine # [ 37.494900] systemd[1]: Reached target Reactivate sysinit units. machine # [ 37.499742] systemd[1]: Starting escaped\x2ddash.service... machine # [ 37.502378] systemd[1]: Reached target Local File Systems. machine # [ 37.508366] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 37.510579] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 37.513647] systemd[1]: Reached target Remote File Systems. machine # [ 37.519133] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 37.522355] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 37.523190] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 37.524351] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 37.527902] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 37.531317] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 37.534228] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 37.544921] systemd[1]: Finished escaped\x2ddash.service. machine # [ 37.664312] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 37.666091] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 37.670228] systemd[1]: Starting linger-users.service... machine # [ 37.697346] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 37.698806] systemd[1]: Finished linger-users.service. machine # [ 37.955655] nixos[3019]: finished switching to system configuration /nix/store/ppzrsyvx4qfgw9ng6dj4zazfm53xh5pw-nixos-system-machine-test machine: (finished: must succeed: /nix/store/bjj1c5xdq9j21a84h34012nm3dspv0yf-nixos-system-machine-test/specialisation/unitWithBackslashModified/bin/switch-to-configuration test 2>&1, in 1.44 seconds) machine: must succeed: /nix/store/bjj1c5xdq9j21a84h34012nm3dspv0yf-nixos-system-machine-test/specialisation/unitStartingWithDash/bin/switch-to-configuration test 2>&1 machine # [ 38.222547] nixos[3162]: switching to system configuration /nix/store/imm8l74cqnkvl9zpwxsv1d7arjvkwf9i-nixos-system-machine-test machine # [ 38.225138] systemd[1]: Stopped target Local File Systems. machine # [ 38.227133] systemd[1]: Stopped target Remote File Systems. machine # [ 38.228949] systemd[1]: escaped\x2ddash.service: Deactivated successfully. machine # [ 38.230157] systemd[1]: Stopped escaped\x2ddash.service. machine # [ 38.460674] systemd[1]: Reload requested from client PID 3162 ('.switch-to-conf') (unit backdoor.service)... machine # [ 38.462503] systemd[1]: Reloading... machine # [ 38.704773] systemd[1]: Reloading finished in 240 ms. machine # [ 38.768316] systemd[619]: Reexecution requested from client PID 3231 ('switch-to-confi')... machine # [ 38.770413] systemd[619]: Reexecuting. machine # [ 38.791104] systemd[619]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 38.867249] systemd[619]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 38.872810] systemd[619]: Reload requested from client PID 3231 ('switch-to-confi')... machine # [ 38.874580] systemd[619]: Reloading... machine # [ 38.948650] systemd[619]: Reloading finished in 72 ms. machine # [ 38.953852] systemd[619]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 38.961139] systemd[619]: Stopped Run user-specific NixOS activation. machine # [ 38.962080] systemd[619]: Stopping Run user-specific NixOS activation... machine # [ 38.964289] systemd[619]: Starting Run user-specific NixOS activation... machine # [ 38.985133] systemd[619]: Finished Run user-specific NixOS activation. machine # [ 38.988263] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 38.989697] systemd[1]: Stopping Reactivate sysinit units... machine # [ 38.990782] systemd[1]: Reached target Reactivate sysinit units. machine # [ 38.993385] systemd[1]: Reached target Remote File Systems. machine # [ 38.995274] systemd[1]: Reached target Local File Systems. machine # [ 38.998033] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 38.999737] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 39.005354] systemd[1]: Starting -.service... machine # [ 39.008090] systemd[1]: Starting linger-users.service... machine # [ 39.018452] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 39.024445] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 39.025350] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 39.027113] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 39.029529] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 39.032154] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 39.033396] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 39.053229] systemd[1]: Finished -.service. machine # [ 39.075056] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 39.077336] systemd[1]: Finished linger-users.service. machine # [ 39.183689] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 39.185446] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 39.443650] nixos[3162]: finished switching to system configuration /nix/store/imm8l74cqnkvl9zpwxsv1d7arjvkwf9i-nixos-system-machine-test machine: (finished: must succeed: /nix/store/bjj1c5xdq9j21a84h34012nm3dspv0yf-nixos-system-machine-test/specialisation/unitStartingWithDash/bin/switch-to-configuration test 2>&1, in 1.49 seconds) machine: must succeed: /nix/store/bjj1c5xdq9j21a84h34012nm3dspv0yf-nixos-system-machine-test/specialisation/unitStartingWithDashModified/bin/switch-to-configuration test 2>&1 machine # [ 39.679408] nixos[3304]: switching to system configuration /nix/store/g3kcvrjqwzdkgi2p4ilkqyi71rjswkah-nixos-system-machine-test machine # [ 39.681849] systemd[1]: Stopped target Remote File Systems. machine # [ 39.683507] systemd[1]: Stopped target Local File Systems. machine # [ 39.918956] systemd[1]: Reload requested from client PID 3304 ('.switch-to-conf') (unit backdoor.service)... machine # [ 39.920816] systemd[1]: Reloading... machine # [ 40.165740] systemd[1]: Reloading finished in 243 ms. machine # [ 40.228501] systemd[619]: Reexecution requested from client PID 3373 ('switch-to-confi')... machine # [ 40.231118] systemd[619]: Reexecuting. machine # [ 40.252152] systemd[619]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 40.329879] systemd[619]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 40.335043] systemd[619]: Reload requested from client PID 3373 ('switch-to-confi')... machine # [ 40.336393] systemd[619]: Reloading... machine # [ 40.415360] systemd[619]: Reloading finished in 77 ms. machine # [ 40.419862] systemd[619]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 40.432654] systemd[619]: Stopped Run user-specific NixOS activation. machine # [ 40.434326] systemd[619]: Stopping Run user-specific NixOS activation... machine # [ 40.439437] systemd[619]: Starting Run user-specific NixOS activation... machine # [ 40.476575] systemd[619]: Finished Run user-specific NixOS activation. machine # [ 40.480405] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 40.481910] systemd[1]: Stopping Reactivate sysinit units... machine # [ 40.483297] systemd[1]: Reached target Reactivate sysinit units. machine # [ 40.487052] systemd[1]: Reloading -.service... machine # [ 40.505943] systemd[1]: Reloaded -.service. machine # [ 40.511563] systemd[1]: Reached target Remote File Systems. machine # [ 40.514464] systemd[1]: Starting linger-users.service... machine # [ 40.516421] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 40.518264] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 40.527062] systemd[1]: Reached target Local File Systems. machine # [ 40.529252] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 40.533169] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 40.533979] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 40.536230] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 40.538878] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 40.541139] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 40.542347] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 40.575362] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 40.578284] systemd[1]: Finished linger-users.service. machine # [ 40.688486] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 40.691409] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 40.948540] nixos[3304]: finished switching to system configuration /nix/store/g3kcvrjqwzdkgi2p4ilkqyi71rjswkah-nixos-system-machine-test machine: (finished: must succeed: /nix/store/bjj1c5xdq9j21a84h34012nm3dspv0yf-nixos-system-machine-test/specialisation/unitStartingWithDashModified/bin/switch-to-configuration test 2>&1, in 1.51 seconds) machine: must succeed: /nix/store/bjj1c5xdq9j21a84h34012nm3dspv0yf-nixos-system-machine-test/specialisation/unitWithRequirement/bin/switch-to-configuration test 2>&1 machine # [ 41.181542] nixos[3447]: switching to system configuration /nix/store/k8fgqxr5wr4ygp8lkw47n5f3ilpvk70y-nixos-system-machine-test machine # [ 41.183866] systemd[1]: Stopped target Local File Systems. machine # [ 41.185472] systemd[1]: Stopped target Remote File Systems. machine # [ 41.187487] systemd[1]: -.service: Deactivated successfully. machine # [ 41.188544] systemd[1]: Stopped -.service. machine # [ 41.416720] systemd[1]: Reload requested from client PID 3447 ('.switch-to-conf') (unit backdoor.service)... machine # [ 41.418418] systemd[1]: Reloading... machine # [ 41.665710] systemd[1]: Reloading finished in 245 ms. machine # [ 41.727697] systemd[619]: Reexecution requested from client PID 3516 ('switch-to-confi')... machine # [ 41.730243] systemd[619]: Reexecuting. machine # [ 41.750332] systemd[619]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 41.825052] systemd[619]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 41.830614] systemd[619]: Reload requested from client PID 3516 ('switch-to-confi')... machine # [ 41.831916] systemd[619]: Reloading... machine # [ 41.903402] systemd[619]: Reloading finished in 70 ms. machine # [ 41.908875] systemd[619]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 41.914927] systemd[619]: Stopped Run user-specific NixOS activation. machine # [ 41.916423] systemd[619]: Stopping Run user-specific NixOS activation... machine # [ 41.918465] systemd[619]: Starting Run user-specific NixOS activation... machine # [ 41.940358] systemd[619]: Finished Run user-specific NixOS activation. machine # [ 41.943759] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 41.945549] systemd[1]: Stopping Reactivate sysinit units... machine # [ 41.946362] systemd[1]: Reached target Reactivate sysinit units. machine # [ 41.949648] systemd[1]: Reached target Local File Systems. machine # [ 41.951316] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 41.953717] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 41.954913] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 41.957876] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 41.958666] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 41.959846] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 41.964310] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 41.965841] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 41.968445] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 41.974664] systemd[1]: Reached target Remote File Systems. machine # [ 42.106773] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 42.109269] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 42.113113] systemd[1]: Starting linger-users.service... machine # [ 42.115153] systemd[1]: Starting required-service.service... machine # [ 42.120140] systemd[1]: Starting test-service.service... machine # [ 42.150543] systemd[1]: Finished required-service.service. machine # [ 42.153353] systemd[1]: Finished test-service.service. machine # [ 42.166690] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 42.168228] systemd[1]: Finished linger-users.service. machine # [ 42.425916] nixos[3447]: finished switching to system configuration /nix/store/k8fgqxr5wr4ygp8lkw47n5f3ilpvk70y-nixos-system-machine-test machine: (finished: must succeed: /nix/store/bjj1c5xdq9j21a84h34012nm3dspv0yf-nixos-system-machine-test/specialisation/unitWithRequirement/bin/switch-to-configuration test 2>&1, in 1.48 seconds) machine: must succeed: /nix/store/bjj1c5xdq9j21a84h34012nm3dspv0yf-nixos-system-machine-test/specialisation/unitWithRequirementModified/bin/switch-to-configuration test 2>&1 machine # [ 42.674771] nixos[3591]: switching to system configuration /nix/store/wlahf37vhr99bnpry2vxcj2s0m6brnq2-nixos-system-machine-test machine # [ 42.677233] systemd[1]: Stopped target Remote File Systems. machine # [ 42.678818] systemd[1]: Stopped target Local File Systems. machine # [ 42.680685] systemd[1]: required-service.service: Deactivated successfully. machine # [ 42.682379] systemd[1]: Stopped required-service.service. machine # [ 42.683164] systemd[1]: test-service.service: Deactivated successfully. machine # [ 42.683997] systemd[1]: Stopped test-service.service. machine # [ 42.911286] systemd[1]: Reload requested from client PID 3591 ('.switch-to-conf') (unit backdoor.service)... machine # [ 42.913193] systemd[1]: Reloading... machine # [ 43.157885] systemd[1]: Reloading finished in 243 ms. machine # [ 43.221278] systemd[619]: Reexecution requested from client PID 3660 ('switch-to-confi')... machine # [ 43.222650] systemd[619]: Reexecuting. machine # [ 43.244151] systemd[619]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 43.315937] systemd[619]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 43.321188] systemd[619]: Reload requested from client PID 3660 ('switch-to-confi')... machine # [ 43.322426] systemd[619]: Reloading... machine # [ 43.394480] systemd[619]: Reloading finished in 70 ms. machine # [ 43.398847] systemd[619]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 43.404791] systemd[619]: Stopped Run user-specific NixOS activation. machine # [ 43.406332] systemd[619]: Stopping Run user-specific NixOS activation... machine # [ 43.408597] systemd[619]: Starting Run user-specific NixOS activation... machine # [ 43.428777] systemd[619]: Finished Run user-specific NixOS activation. machine # [ 43.431843] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 43.433250] systemd[1]: Stopping Reactivate sysinit units... machine # [ 43.433969] systemd[1]: Reached target Reactivate sysinit units. machine # [ 43.437306] systemd[1]: Reached target Local File Systems. machine # [ 43.438932] systemd[1]: Reached target Remote File Systems. machine # [ 43.443765] systemd[1]: Starting required-service.service... machine # [ 43.447331] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 43.452638] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 43.453607] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 43.455694] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 43.457650] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 43.459115] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 43.460314] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 43.465145] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 43.466329] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 43.488156] systemd[1]: Finished required-service.service. machine # [ 43.602542] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 43.604477] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 43.608282] systemd[1]: Starting linger-users.service... machine # [ 43.613213] systemd[1]: Starting test-service.service... machine # [ 43.634947] systemd[1]: Finished test-service.service. machine # [ 43.648318] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 43.649755] systemd[1]: Finished linger-users.service. machine # [ 43.906202] nixos[3591]: finished switching to system configuration /nix/store/wlahf37vhr99bnpry2vxcj2s0m6brnq2-nixos-system-machine-test machine: (finished: must succeed: /nix/store/bjj1c5xdq9j21a84h34012nm3dspv0yf-nixos-system-machine-test/specialisation/unitWithRequirementModified/bin/switch-to-configuration test 2>&1, in 1.48 seconds) machine: must succeed: /nix/store/bjj1c5xdq9j21a84h34012nm3dspv0yf-nixos-system-machine-test/specialisation/unitWithRequirementModifiedNostart/bin/switch-to-configuration test 2>&1 machine # [ 44.137435] nixos[3735]: switching to system configuration /nix/store/p6vm69yk9by2ydh5pf8mk29km6xzpw5z-nixos-system-machine-test machine # [ 44.139845] systemd[1]: Stopped target Remote File Systems. machine # [ 44.141680] systemd[1]: Stopped target Local File Systems. machine # [ 44.144280] systemd[1]: required-service.service: Deactivated successfully. machine # [ 44.145279] systemd[1]: Stopped required-service.service. machine # [ 44.146085] systemd[1]: test-service.service: Deactivated successfully. machine # [ 44.147662] systemd[1]: Stopped test-service.service. machine # [ 44.373375] systemd[1]: Reload requested from client PID 3735 ('.switch-to-conf') (unit backdoor.service)... machine # [ 44.375069] systemd[1]: Reloading... machine # [ 44.619653] systemd[1]: Reloading finished in 243 ms. machine # [ 44.682193] systemd[619]: Reexecution requested from client PID 3804 ('switch-to-confi')... machine # [ 44.684120] systemd[619]: Reexecuting. machine # [ 44.706166] systemd[619]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 44.778382] systemd[619]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 44.783719] systemd[619]: Reload requested from client PID 3804 ('switch-to-confi')... machine # [ 44.785923] systemd[619]: Reloading... machine # [ 44.857484] systemd[619]: Reloading finished in 70 ms. machine # [ 44.862849] systemd[619]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 44.869390] systemd[619]: Stopped Run user-specific NixOS activation. machine # [ 44.870501] systemd[619]: Stopping Run user-specific NixOS activation... machine # [ 44.873104] systemd[619]: Starting Run user-specific NixOS activation... machine # [ 44.893899] systemd[619]: Finished Run user-specific NixOS activation. machine # [ 44.897062] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 44.898554] systemd[1]: Stopping Reactivate sysinit units... machine # [ 44.899608] systemd[1]: Reached target Reactivate sysinit units. machine # [ 44.904067] systemd[1]: Reached target Remote File Systems. machine # [ 44.906259] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 44.907447] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 44.910156] systemd[1]: Starting linger-users.service... machine # [ 44.912093] systemd[1]: Starting required-service.service... machine # [ 44.916334] systemd[1]: Starting test-service.service... machine # [ 44.928686] systemd[1]: Reached target Local File Systems. machine # [ 44.929488] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 44.933468] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 44.935802] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 44.940225] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 44.944214] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 44.948200] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 44.952251] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 44.975481] systemd[1]: Finished required-service.service. machine # [ 44.978246] systemd[1]: Finished test-service.service. machine # [ 44.998712] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 45.000639] systemd[1]: Finished linger-users.service. machine # [ 45.107105] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 45.108768] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 45.367478] nixos[3735]: finished switching to system configuration /nix/store/p6vm69yk9by2ydh5pf8mk29km6xzpw5z-nixos-system-machine-test machine: (finished: must succeed: /nix/store/bjj1c5xdq9j21a84h34012nm3dspv0yf-nixos-system-machine-test/specialisation/unitWithRequirementModifiedNostart/bin/switch-to-configuration test 2>&1, in 1.46 seconds) machine: must succeed: /nix/store/bjj1c5xdq9j21a84h34012nm3dspv0yf-nixos-system-machine-test/specialisation/unitWithTemplate/bin/switch-to-configuration test 2>&1 machine # [ 45.596773] nixos[3879]: switching to system configuration /nix/store/64m0s9jvm880ljv007q5301qw4i8z2x1-nixos-system-machine-test machine # [ 45.599442] systemd[1]: required-service.service: Deactivated successfully. machine # [ 45.601284] systemd[1]: Stopped required-service.service. machine # [ 45.602442] systemd[1]: test-service.service: Deactivated successfully. machine # [ 45.603351] systemd[1]: Stopped test-service.service. machine # [ 45.605274] systemd[1]: Stopped target Local File Systems. machine # [ 45.606655] systemd[1]: Stopped target Remote File Systems. machine # [ 45.831304] systemd[1]: Reload requested from client PID 3879 ('.switch-to-conf') (unit backdoor.service)... machine # [ 45.832969] systemd[1]: Reloading... machine # [ 46.075718] systemd[1]: Reloading finished in 241 ms. machine # [ 46.138545] systemd[619]: Reexecution requested from client PID 3948 ('switch-to-confi')... machine # [ 46.140372] systemd[619]: Reexecuting. machine # [ 46.161115] systemd[619]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 46.232993] systemd[619]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 46.238312] systemd[619]: Reload requested from client PID 3948 ('switch-to-confi')... machine # [ 46.239504] systemd[619]: Reloading... machine # [ 46.310948] systemd[619]: Reloading finished in 69 ms. machine # [ 46.315852] systemd[619]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 46.322420] systemd[619]: Stopped Run user-specific NixOS activation. machine # [ 46.323323] systemd[619]: Stopping Run user-specific NixOS activation... machine # [ 46.325344] systemd[619]: Starting Run user-specific NixOS activation... machine # [ 46.345763] systemd[619]: Finished Run user-specific NixOS activation. machine # [ 46.348883] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 46.350262] systemd[1]: Stopping Reactivate sysinit units... machine # [ 46.350981] systemd[1]: Reached target Reactivate sysinit units. machine # [ 46.355851] systemd[1]: Created slice Slice /system/instantiated. machine # [ 46.357283] systemd[1]: Reached target Remote File Systems. machine # [ 46.360151] systemd[1]: Starting instantiated@one.service... machine # [ 46.362436] systemd[1]: Starting instantiated@two.service... machine # [ 46.364699] systemd[1]: Starting linger-users.service... machine # [ 46.372416] systemd[1]: Reached target Local File Systems. machine # [ 46.373243] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 46.377170] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 46.377914] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 46.379053] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 46.381042] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 46.382439] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 46.383590] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 46.398633] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 46.401133] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 46.428946] systemd[1]: Finished instantiated@one.service. machine # [ 46.432861] systemd[1]: Finished instantiated@two.service. machine # [ 46.452511] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 46.454506] systemd[1]: Finished linger-users.service. machine # [ 46.558780] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 46.560542] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 46.818977] nixos[3879]: finished switching to system configuration /nix/store/64m0s9jvm880ljv007q5301qw4i8z2x1-nixos-system-machine-test machine: (finished: must succeed: /nix/store/bjj1c5xdq9j21a84h34012nm3dspv0yf-nixos-system-machine-test/specialisation/unitWithTemplate/bin/switch-to-configuration test 2>&1, in 1.45 seconds) machine: must succeed: /nix/store/bjj1c5xdq9j21a84h34012nm3dspv0yf-nixos-system-machine-test/specialisation/unitWithTemplateModified/bin/switch-to-configuration test 2>&1 machine # [ 47.057880] nixos[4023]: switching to system configuration /nix/store/f3icq8cwi505ng3zlkv0myaj3qvnjif0-nixos-system-machine-test machine # [ 47.060453] systemd[1]: Stopped target Local File Systems. machine # [ 47.062137] systemd[1]: Stopped target Remote File Systems. machine # [ 47.063487] systemd[1]: instantiated@one.service: Deactivated successfully. machine # [ 47.065053] systemd[1]: Stopped instantiated@one.service. machine # [ 47.066748] systemd[1]: instantiated@two.service: Deactivated successfully. machine # [ 47.068129] systemd[1]: Stopped instantiated@two.service. machine # [ 47.291961] systemd[1]: Reload requested from client PID 4023 ('.switch-to-conf') (unit backdoor.service)... machine # [ 47.293694] systemd[1]: Reloading... machine # [ 47.536132] systemd[1]: Reloading finished in 240 ms. machine # [ 47.598610] systemd[619]: Reexecution requested from client PID 4092 ('switch-to-confi')... machine # [ 47.599909] systemd[619]: Reexecuting. machine # [ 47.622134] systemd[619]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 47.693827] systemd[619]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 47.699068] systemd[619]: Reload requested from client PID 4092 ('switch-to-confi')... machine # [ 47.700308] systemd[619]: Reloading... machine # [ 47.771725] systemd[619]: Reloading finished in 69 ms. machine # [ 47.776862] systemd[619]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 47.783604] systemd[619]: Stopped Run user-specific NixOS activation. machine # [ 47.784708] systemd[619]: Stopping Run user-specific NixOS activation... machine # [ 47.787180] systemd[619]: Starting Run user-specific NixOS activation... machine # [ 47.807749] systemd[619]: Finished Run user-specific NixOS activation. machine # [ 47.810963] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 47.812285] systemd[1]: Stopping Reactivate sysinit units... machine # [ 47.813551] systemd[1]: Reached target Reactivate sysinit units. machine # [ 47.817477] systemd[1]: Starting instantiated@one.service... machine # [ 47.824829] systemd[1]: Starting instantiated@two.service... machine # [ 47.825775] systemd[1]: Reached target Remote File Systems. machine # [ 47.835906] systemd[1]: Starting linger-users.service... machine # [ 47.836723] systemd[1]: Reached target Local File Systems. machine # [ 47.842197] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 47.843416] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 47.847463] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 47.850927] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 47.853098] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 47.855271] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 47.858795] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 47.861341] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 47.862622] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 47.884385] systemd[1]: Finished instantiated@one.service. machine # [ 47.889666] systemd[1]: Finished instantiated@two.service. machine # [ 47.917700] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 47.919949] systemd[1]: Finished linger-users.service. machine # [ 48.021876] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 48.023606] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 48.280702] nixos[4023]: finished switching to system configuration /nix/store/f3icq8cwi505ng3zlkv0myaj3qvnjif0-nixos-system-machine-test machine: (finished: must succeed: /nix/store/bjj1c5xdq9j21a84h34012nm3dspv0yf-nixos-system-machine-test/specialisation/unitWithTemplateModified/bin/switch-to-configuration test 2>&1, in 1.46 seconds) (finished: subtest: services, in 31.22 seconds) subtest: failing units machine: must succeed: /nix/store/bjj1c5xdq9j21a84h34012nm3dspv0yf-nixos-system-machine-test/specialisation/simpleServiceModified/bin/switch-to-configuration test 2>&1 machine # [ 48.498471] nixos[4167]: switching to system configuration /nix/store/7xqyrn89hvicmsrsmdvar5k2pzlh51c2-nixos-system-machine-test machine # [ 48.501558] systemd[1]: Stopped target Local File Systems. machine # [ 48.502792] systemd[1]: Stopped target Remote File Systems. machine # [ 48.504279] systemd[1]: instantiated@one.service: Deactivated successfully. machine # [ 48.505948] systemd[1]: Stopped instantiated@one.service. machine # [ 48.507235] systemd[1]: instantiated@two.service: Deactivated successfully. machine # [ 48.508808] systemd[1]: Stopped instantiated@two.service. machine # [ 48.712936] systemd[1]: Reload requested from client PID 4167 ('.switch-to-conf') (unit backdoor.service)... machine # [ 48.714697] systemd[1]: Reloading... machine # [ 48.945222] systemd[1]: Reloading finished in 229 ms. machine # [ 49.007845] systemd[619]: Reexecution requested from client PID 4236 ('switch-to-confi')... machine # [ 49.009786] systemd[619]: Reexecuting. machine # [ 49.031166] systemd[619]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 49.102462] systemd[619]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 49.108197] systemd[619]: Reload requested from client PID 4236 ('switch-to-confi')... machine # [ 49.110203] systemd[619]: Reloading... machine # [ 49.181636] systemd[619]: Reloading finished in 71 ms. machine # [ 49.186402] systemd[619]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 49.194122] systemd[619]: Stopped Run user-specific NixOS activation. machine # [ 49.194989] systemd[619]: Stopping Run user-specific NixOS activation... machine # [ 49.197188] systemd[619]: Starting Run user-specific NixOS activation... machine # [ 49.218739] systemd[619]: Finished Run user-specific NixOS activation. machine # [ 49.221942] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 49.222978] systemd[1]: Stopping Reactivate sysinit units... machine # [ 49.224107] systemd[1]: Reached target Reactivate sysinit units. machine # [ 49.226328] systemd[1]: Reached target Remote File Systems. machine # [ 49.230909] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 49.232678] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 49.238953] systemd[1]: Starting linger-users.service... machine # [ 49.240703] systemd[1]: Starting test.service... machine # [ 49.248154] systemd[1]: Reached target Local File Systems. machine # [ 49.248932] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 49.255036] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 49.255855] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 49.260037] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 49.261987] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 49.263895] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 49.265178] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 49.288143] systemd[1]: Finished test.service. machine # [ 49.312859] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 49.314449] systemd[1]: Finished linger-users.service. machine # [ 49.417230] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 49.418923] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 49.677412] nixos[4167]: finished switching to system configuration /nix/store/7xqyrn89hvicmsrsmdvar5k2pzlh51c2-nixos-system-machine-test machine: (finished: must succeed: /nix/store/bjj1c5xdq9j21a84h34012nm3dspv0yf-nixos-system-machine-test/specialisation/simpleServiceModified/bin/switch-to-configuration test 2>&1, in 1.39 seconds) machine: must fail: /nix/store/bjj1c5xdq9j21a84h34012nm3dspv0yf-nixos-system-machine-test/specialisation/simpleServiceFailing/bin/switch-to-configuration test 2>&1 machine # [ 49.906200] nixos[4309]: switching to system configuration /nix/store/klhqk36zvwsm2f0m1lzf489lmgdsj175-nixos-system-machine-test machine # [ 49.908452] systemd[1]: Stopped target Local File Systems. machine # [ 49.910293] systemd[1]: test.service: Deactivated successfully. machine # [ 49.911775] systemd[1]: Stopped test.service. machine # [ 49.913129] systemd[1]: Stopped target Remote File Systems. machine # [ 50.136273] systemd[1]: Reload requested from client PID 4309 ('.switch-to-conf') (unit backdoor.service)... machine # [ 50.137969] systemd[1]: Reloading... machine # [ 50.378657] systemd[1]: Reloading finished in 239 ms. machine # [ 50.443617] systemd[619]: Reexecution requested from client PID 4378 ('switch-to-confi')... machine # [ 50.445065] systemd[619]: Reexecuting. machine # [ 50.465146] systemd[619]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 50.537618] systemd[619]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 50.542782] systemd[619]: Reload requested from client PID 4378 ('switch-to-confi')... machine # [ 50.544069] systemd[619]: Reloading... machine # [ 50.615788] systemd[619]: Reloading finished in 69 ms. machine # [ 50.619859] systemd[619]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 50.626142] systemd[619]: Stopped Run user-specific NixOS activation. machine # [ 50.628107] systemd[619]: Stopping Run user-specific NixOS activation... machine # [ 50.629698] systemd[619]: Starting Run user-specific NixOS activation... machine # [ 50.650749] systemd[619]: Finished Run user-specific NixOS activation. machine # [ 50.653885] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 50.655275] systemd[1]: Stopping Reactivate sysinit units... machine # [ 50.656333] systemd[1]: Reached target Reactivate sysinit units. machine # [ 50.659640] systemd[1]: Reached target Remote File Systems. machine # [ 50.663150] systemd[1]: Starting linger-users.service... machine # [ 50.665483] systemd[1]: Starting test.service... machine # [ 50.670116] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 50.671352] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 50.676360] systemd[1]: Reached target Local File Systems. machine # [ 50.677241] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 50.680558] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 50.682659] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 50.683899] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 50.687341] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 50.690276] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 50.692841] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 50.719893] systemd[1]: test.service: Main process exited, code=exited, status=1/FAILURE machine # [ 50.721186] systemd[1]: test.service: Failed with result 'exit-code'. machine # [ 50.722505] systemd[1]: Failed to start test.service. machine # [ 50.744802] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 50.746636] systemd[1]: Finished linger-users.service. machine # [ 50.851864] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 50.853606] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 51.133727] nixos[4309]: switching to system configuration /nix/store/klhqk36zvwsm2f0m1lzf489lmgdsj175-nixos-system-machine-test failed (status 4) machine: (finished: must fail: /nix/store/bjj1c5xdq9j21a84h34012nm3dspv0yf-nixos-system-machine-test/specialisation/simpleServiceFailing/bin/switch-to-configuration test 2>&1, in 1.46 seconds) machine: must succeed: /nix/store/bjj1c5xdq9j21a84h34012nm3dspv0yf-nixos-system-machine-test/specialisation/autorestartService/bin/switch-to-configuration test 2>&1 machine # [ 51.348026] nixos[4452]: switching to system configuration /nix/store/4a8kqk9pbschvjhv5f8gyplwc113d72j-nixos-system-machine-test machine # [ 51.351707] systemd[1]: Stopped target Local File Systems. machine # [ 51.352865] systemd[1]: Stopped target Remote File Systems. machine # [ 51.577794] systemd[1]: Reload requested from client PID 4452 ('.switch-to-conf') (unit backdoor.service)... machine # [ 51.579483] systemd[1]: Reloading... machine # [ 51.822637] systemd[1]: Reloading finished in 241 ms. machine # [ 51.886293] systemd[619]: Reexecution requested from client PID 4521 ('switch-to-confi')... machine # [ 51.887574] systemd[619]: Reexecuting. machine # [ 51.908179] systemd[619]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 51.979964] systemd[619]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 51.985416] systemd[619]: Reload requested from client PID 4521 ('switch-to-confi')... machine # [ 51.987146] systemd[619]: Reloading... machine # [ 52.057880] systemd[619]: Reloading finished in 69 ms. machine # [ 52.063853] systemd[619]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 52.070030] systemd[619]: Stopped Run user-specific NixOS activation. machine # [ 52.071086] systemd[619]: Stopping Run user-specific NixOS activation... machine # [ 52.073544] systemd[619]: Starting Run user-specific NixOS activation... machine # [ 52.094848] systemd[619]: Finished Run user-specific NixOS activation. machine # [ 52.097889] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 52.099327] systemd[1]: Stopping Reactivate sysinit units... machine # [ 52.100425] systemd[1]: Reached target Reactivate sysinit units. machine # [ 52.101761] systemd[1]: Reached target Remote File Systems. machine # [ 52.104058] systemd[1]: Reached target Local File Systems. machine # [ 52.106060] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 52.108674] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 52.110254] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 52.112266] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 52.114256] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 52.115678] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 52.116841] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 52.120344] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 52.123296] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 52.250380] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 52.252193] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 52.256202] systemd[1]: Started autorestart.service. machine # [ 52.258828] systemd[1]: Starting linger-users.service... machine # [ 52.280754] systemd[1]: autorestart.service: Deactivated successfully. machine # [ 52.296527] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 52.298076] systemd[1]: Finished linger-users.service. machine # [ 52.556431] nixos[4452]: finished switching to system configuration /nix/store/4a8kqk9pbschvjhv5f8gyplwc113d72j-nixos-system-machine-test machine: (finished: must succeed: /nix/store/bjj1c5xdq9j21a84h34012nm3dspv0yf-nixos-system-machine-test/specialisation/autorestartService/bin/switch-to-configuration test 2>&1, in 1.42 seconds) machine # [ 52.602934] systemd[1]: Stopped autorestart.service. machine: must succeed: /nix/store/bjj1c5xdq9j21a84h34012nm3dspv0yf-nixos-system-machine-test/specialisation/autorestartService/bin/switch-to-configuration test 2>&1 machine # [ 52.791289] nixos[4599]: switching to system configuration /nix/store/4a8kqk9pbschvjhv5f8gyplwc113d72j-nixos-system-machine-test machine # [ 52.793497] systemd[1]: Stopped target Remote File Systems. machine # [ 52.795118] systemd[1]: Stopped target Local File Systems. machine # [ 53.000433] systemd[1]: Reload requested from client PID 4599 ('.switch-to-conf') (unit backdoor.service)... machine # [ 53.002151] systemd[1]: Reloading... machine # [ 53.232578] systemd[1]: Reloading finished in 229 ms. machine # [ 53.296464] systemd[619]: Reexecution requested from client PID 4668 ('switch-to-confi')... machine # [ 53.297745] systemd[619]: Reexecuting. machine # [ 53.318293] systemd[619]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 53.388954] systemd[619]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 53.395066] systemd[619]: Reload requested from client PID 4668 ('switch-to-confi')... machine # [ 53.396575] systemd[619]: Reloading... machine # [ 53.468561] systemd[619]: Reloading finished in 70 ms. machine # [ 53.472870] systemd[619]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 53.480068] systemd[619]: Stopped Run user-specific NixOS activation. machine # [ 53.480938] systemd[619]: Stopping Run user-specific NixOS activation... machine # [ 53.482853] systemd[619]: Starting Run user-specific NixOS activation... machine # [ 53.502624] systemd[619]: Finished Run user-specific NixOS activation. machine # [ 53.505688] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 53.506943] systemd[1]: Stopping Reactivate sysinit units... machine # [ 53.507953] systemd[1]: Reached target Reactivate sysinit units. machine # [ 53.513864] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 53.515672] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 53.517562] systemd[1]: Reached target Local File Systems. machine # [ 53.519135] systemd[1]: Reached target Remote File Systems. machine # [ 53.523180] systemd[1]: Started autorestart.service. machine # [ 53.525597] systemd[1]: Starting linger-users.service... machine # [ 53.533165] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 53.536455] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 53.537271] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 53.538449] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 53.540422] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 53.541830] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 53.542970] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 53.571836] systemd[1]: autorestart.service: Deactivated successfully. machine # [ 53.593800] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 53.595225] systemd[1]: Finished linger-users.service. machine # [ 53.700812] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 53.703085] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 53.962092] nixos[4599]: finished switching to system configuration /nix/store/4a8kqk9pbschvjhv5f8gyplwc113d72j-nixos-system-machine-test machine: (finished: must succeed: /nix/store/bjj1c5xdq9j21a84h34012nm3dspv0yf-nixos-system-machine-test/specialisation/autorestartService/bin/switch-to-configuration test 2>&1, in 1.36 seconds) machine # [ 54.008979] systemd[1]: Stopped autorestart.service. machine: must fail: /nix/store/bjj1c5xdq9j21a84h34012nm3dspv0yf-nixos-system-machine-test/specialisation/autorestartServiceFailing/bin/switch-to-configuration test 2>&1 machine # [ 54.216537] nixos[4746]: switching to system configuration /nix/store/1vh29qrmbql7syvxcb5v69b4q49h5v8n-nixos-system-machine-test machine # [ 54.218592] systemd[1]: Stopped target Remote File Systems. machine # [ 54.220272] systemd[1]: Stopped target Local File Systems. machine # [ 54.445540] systemd[1]: Reload requested from client PID 4746 ('.switch-to-conf') (unit backdoor.service)... machine # [ 54.447176] systemd[1]: Reloading... machine # [ 54.687818] systemd[1]: Reloading finished in 239 ms. machine # [ 54.752478] systemd[619]: Reexecution requested from client PID 4815 ('switch-to-confi')... machine # [ 54.753820] systemd[619]: Reexecuting. machine # [ 54.775138] systemd[619]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 54.846669] systemd[619]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 54.852898] systemd[619]: Reload requested from client PID 4815 ('switch-to-confi')... machine # [ 54.855047] systemd[619]: Reloading... machine # [ 54.925846] systemd[619]: Reloading finished in 71 ms. machine # [ 54.931878] systemd[619]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 54.938211] systemd[619]: Stopped Run user-specific NixOS activation. machine # [ 54.940057] systemd[619]: Stopping Run user-specific NixOS activation... machine # [ 54.941822] systemd[619]: Starting Run user-specific NixOS activation... machine # [ 54.961705] systemd[619]: Finished Run user-specific NixOS activation. machine # [ 54.965566] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 54.967186] systemd[1]: Stopping Reactivate sysinit units... machine # [ 54.967917] systemd[1]: Reached target Reactivate sysinit units. machine # [ 54.970418] systemd[1]: Reached target Local File Systems. machine # [ 54.972249] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 54.974468] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 54.976185] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 54.977904] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 54.979829] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 54.981262] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 54.982398] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 54.987317] systemd[1]: Reached target Remote File Systems. machine # [ 54.995328] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 54.997049] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 55.119704] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 55.121408] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 55.125309] systemd[1]: Started autorestart.service. machine # [ 55.131164] systemd[1]: Starting linger-users.service... machine # [ 55.151702] systemd[1]: autorestart.service: Main process exited, code=exited, status=1/FAILURE machine # [ 55.152977] systemd[1]: autorestart.service: Failed with result 'exit-code'. machine # [ 55.167963] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 55.170300] systemd[1]: Finished linger-users.service. machine # [ 55.451311] nixos[4746]: switching to system configuration /nix/store/1vh29qrmbql7syvxcb5v69b4q49h5v8n-nixos-system-machine-test failed (status 4) machine: (finished: must fail: /nix/store/bjj1c5xdq9j21a84h34012nm3dspv0yf-nixos-system-machine-test/specialisation/autorestartServiceFailing/bin/switch-to-configuration test 2>&1, in 1.44 seconds) (finished: subtest: failing units, in 7.17 seconds) subtest: unit file parser machine: must succeed: /nix/store/bjj1c5xdq9j21a84h34012nm3dspv0yf-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1 machine # [ 55.648392] nixos[4889]: switching to system configuration /nix/store/01y880ynwcg44b8zrcwzdvsfdsra5d9s-nixos-system-machine-test machine # [ 55.650758] systemd[1]: Stopped target Remote File Systems. machine # [ 55.652374] systemd[1]: Stopped target Local File Systems. machine # [ 55.654072] systemd[1]: Stopped autorestart.service. machine # [ 55.859960] systemd[1]: Reload requested from client PID 4889 ('.switch-to-conf') (unit backdoor.service)... machine # [ 55.861744] systemd[1]: Reloading... machine # [ 56.092380] systemd[1]: Reloading finished in 229 ms. machine # [ 56.154296] systemd[619]: Reexecution requested from client PID 4958 ('switch-to-confi')... machine # [ 56.156848] systemd[619]: Reexecuting. machine # [ 56.179090] systemd[619]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 56.251089] systemd[619]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 56.256538] systemd[619]: Reload requested from client PID 4958 ('switch-to-confi')... machine # [ 56.258309] systemd[619]: Reloading... machine # [ 56.329638] systemd[619]: Reloading finished in 70 ms. machine # [ 56.335856] systemd[619]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 56.341965] systemd[619]: Stopped Run user-specific NixOS activation. machine # [ 56.343878] systemd[619]: Stopping Run user-specific NixOS activation... machine # [ 56.345505] systemd[619]: Starting Run user-specific NixOS activation... machine # [ 56.365766] systemd[619]: Finished Run user-specific NixOS activation. machine # [ 56.368900] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 56.370308] systemd[1]: Stopping Reactivate sysinit units... machine # [ 56.371433] systemd[1]: Reached target Reactivate sysinit units. machine # [ 56.374060] systemd[1]: Reached target Remote File Systems. machine # [ 56.376648] systemd[1]: Starting linger-users.service... machine # [ 56.379152] systemd[1]: Starting test.service... machine # [ 56.389108] systemd[1]: Reached target Local File Systems. machine # [ 56.389863] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 56.392114] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 56.392877] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 56.394790] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 56.396773] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 56.401409] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 56.404879] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 56.406115] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 56.407698] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 56.433286] systemd[1]: Finished test.service. machine # [ 56.453326] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 56.455261] systemd[1]: Finished linger-users.service. machine # [ 56.563729] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 56.565557] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 56.823381] nixos[4889]: finished switching to system configuration /nix/store/01y880ynwcg44b8zrcwzdvsfdsra5d9s-nixos-system-machine-test machine: (finished: must succeed: /nix/store/bjj1c5xdq9j21a84h34012nm3dspv0yf-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1, in 1.37 seconds) machine: must succeed: /nix/store/bjj1c5xdq9j21a84h34012nm3dspv0yf-nixos-system-machine-test/specialisation/simpleServiceWithExtraSection/bin/switch-to-configuration test 2>&1 machine # [ 57.053389] nixos[5031]: switching to system configuration /nix/store/8h1biqrqpgzik7n488q7bhiammd95g5s-nixos-system-machine-test machine # [ 57.055483] systemd[1]: Stopped target Remote File Systems. machine # [ 57.057271] systemd[1]: Stopped target Local File Systems. machine # [ 57.281976] systemd[1]: Reload requested from client PID 5031 ('.switch-to-conf') (unit backdoor.service)... machine # [ 57.283676] systemd[1]: Reloading... machine # [ 57.525867] systemd[1]: Reloading finished in 240 ms. machine # [ 57.593626] systemd[619]: Reexecution requested from client PID 5100 ('switch-to-confi')... machine # [ 57.595396] systemd[619]: Reexecuting. machine # [ 57.615093] systemd[619]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 57.689418] systemd[619]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 57.694300] systemd[619]: Reload requested from client PID 5100 ('switch-to-confi')... machine # [ 57.696060] systemd[619]: Reloading... machine # [ 57.768655] systemd[619]: Reloading finished in 71 ms. machine # [ 57.773855] systemd[619]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 57.779856] systemd[619]: Stopped Run user-specific NixOS activation. machine # [ 57.781357] systemd[619]: Stopping Run user-specific NixOS activation... machine # [ 57.783498] systemd[619]: Starting Run user-specific NixOS activation... machine # [ 57.803811] systemd[619]: Finished Run user-specific NixOS activation. machine # [ 57.806897] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 57.808222] systemd[1]: Stopping Reactivate sysinit units... machine # [ 57.808978] systemd[1]: Reached target Reactivate sysinit units. machine # [ 57.810918] systemd[1]: test.service: Deactivated successfully. machine # [ 57.812082] systemd[1]: Stopped test.service. machine # [ 57.813068] systemd[1]: Stopping test.service... machine # [ 57.815310] systemd[1]: Starting test.service... machine # [ 57.828679] systemd[1]: Finished test.service. machine # [ 57.830776] systemd[1]: Reached target Local File Systems. machine # [ 57.835803] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 57.839297] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 57.841354] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 57.842546] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 57.845683] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 57.848113] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 57.849312] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 57.850466] systemd[1]: Reached target Remote File Systems. machine # [ 57.854585] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 57.855806] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 57.992172] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 57.993851] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 57.998403] systemd[1]: Starting linger-users.service... machine # [ 58.026877] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 58.028387] systemd[1]: Finished linger-users.service. machine # [ 58.282896] nixos[5031]: finished switching to system configuration /nix/store/8h1biqrqpgzik7n488q7bhiammd95g5s-nixos-system-machine-test machine: (finished: must succeed: /nix/store/bjj1c5xdq9j21a84h34012nm3dspv0yf-nixos-system-machine-test/specialisation/simpleServiceWithExtraSection/bin/switch-to-configuration test 2>&1, in 1.46 seconds) machine: must succeed: /nix/store/bjj1c5xdq9j21a84h34012nm3dspv0yf-nixos-system-machine-test/specialisation/simpleServiceWithExtraSectionOtherName/bin/switch-to-configuration test 2>&1 machine # [ 58.515307] nixos[5173]: switching to system configuration /nix/store/7kmpd0vh6a9641hy3s2dcv2vl9ak51ls-nixos-system-machine-test machine # [ 58.518958] systemd[1]: Stopped target Remote File Systems. machine # [ 58.519922] systemd[1]: Stopped target Local File Systems. machine # [ 58.762844] systemd[1]: Reload requested from client PID 5173 ('.switch-to-conf') (unit backdoor.service)... machine # [ 58.764460] systemd[1]: Reloading... machine # [ 59.030987] systemd[1]: Reloading finished in 265 ms. machine # [ 59.103407] systemd[619]: Reexecution requested from client PID 5242 ('switch-to-confi')... machine # [ 59.104799] systemd[619]: Reexecuting. machine # [ 59.125268] systemd[619]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 59.204795] systemd[619]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 59.210137] systemd[619]: Reload requested from client PID 5242 ('switch-to-confi')... machine # [ 59.212087] systemd[619]: Reloading... machine # [ 59.287837] systemd[619]: Reloading finished in 74 ms. machine # [ 59.293866] systemd[619]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 59.301059] systemd[619]: Stopped Run user-specific NixOS activation. machine # [ 59.301907] systemd[619]: Stopping Run user-specific NixOS activation... machine # [ 59.303829] systemd[619]: Starting Run user-specific NixOS activation... machine # [ 59.324101] systemd[619]: Finished Run user-specific NixOS activation. machine # [ 59.327273] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 59.328653] systemd[1]: Stopping Reactivate sysinit units... machine # [ 59.329653] systemd[1]: Reached target Reactivate sysinit units. machine # [ 59.331392] systemd[1]: test.service: Deactivated successfully. machine # [ 59.333291] systemd[1]: Stopped test.service. machine # [ 59.333910] systemd[1]: Stopping test.service... machine # [ 59.335633] systemd[1]: Starting test.service... machine # [ 59.350061] systemd[1]: Finished test.service. machine # [ 59.354634] systemd[1]: Reached target Local File Systems. machine # [ 59.357631] systemd[1]: Reached target Remote File Systems. machine # [ 59.359563] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 59.361394] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 59.365591] systemd[1]: Starting linger-users.service... machine # [ 59.367765] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 59.373304] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 59.374446] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 59.376283] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 59.378275] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 59.379690] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 59.380853] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 59.425079] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 59.427103] systemd[1]: Finished linger-users.service. machine # [ 59.537887] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 59.539794] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 59.796503] nixos[5173]: finished switching to system configuration /nix/store/7kmpd0vh6a9641hy3s2dcv2vl9ak51ls-nixos-system-machine-test machine: (finished: must succeed: /nix/store/bjj1c5xdq9j21a84h34012nm3dspv0yf-nixos-system-machine-test/specialisation/simpleServiceWithExtraSectionOtherName/bin/switch-to-configuration test 2>&1, in 1.52 seconds) machine: must succeed: /nix/store/bjj1c5xdq9j21a84h34012nm3dspv0yf-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1 machine # [ 60.040804] nixos[5315]: switching to system configuration /nix/store/01y880ynwcg44b8zrcwzdvsfdsra5d9s-nixos-system-machine-test machine # [ 60.044346] systemd[1]: Stopped target Remote File Systems. machine # [ 60.045237] systemd[1]: Stopped target Local File Systems. machine # [ 60.259477] systemd[1]: Reload requested from client PID 5315 ('.switch-to-conf') (unit backdoor.service)... machine # [ 60.261185] systemd[1]: Reloading... machine # [ 60.510836] systemd[1]: Reloading finished in 247 ms. machine # [ 60.577471] systemd[619]: Reexecution requested from client PID 5384 ('switch-to-confi')... machine # [ 60.578811] systemd[619]: Reexecuting. machine # [ 60.601181] systemd[619]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 60.677934] systemd[619]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 60.683311] systemd[619]: Reload requested from client PID 5384 ('switch-to-confi')... machine # [ 60.684726] systemd[619]: Reloading... machine # [ 60.761243] systemd[619]: Reloading finished in 75 ms. machine # [ 60.766865] systemd[619]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 60.773066] systemd[619]: Stopped Run user-specific NixOS activation. machine # [ 60.774056] systemd[619]: Stopping Run user-specific NixOS activation... machine # [ 60.776557] systemd[619]: Starting Run user-specific NixOS activation... machine # [ 60.798050] systemd[619]: Finished Run user-specific NixOS activation. machine # [ 60.801286] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 60.803352] systemd[1]: Stopping Reactivate sysinit units... machine # [ 60.804187] systemd[1]: Reached target Reactivate sysinit units. machine # [ 60.806172] systemd[1]: test.service: Deactivated successfully. machine # [ 60.806932] systemd[1]: Stopped test.service. machine # [ 60.807714] systemd[1]: Stopping test.service... machine # [ 60.809655] systemd[1]: Starting test.service... machine # [ 60.824451] systemd[1]: Finished test.service. machine # [ 60.829217] systemd[1]: Reached target Remote File Systems. machine # [ 60.831643] systemd[1]: Starting linger-users.service... machine # [ 60.838632] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 60.840168] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 60.845215] systemd[1]: Reached target Local File Systems. machine # [ 60.846072] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 60.850311] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 60.852140] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 60.853769] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 60.856478] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 60.857935] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 60.861180] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 60.895852] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 60.897869] systemd[1]: Finished linger-users.service. machine # [ 61.013185] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 61.014823] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 61.272885] nixos[5315]: finished switching to system configuration /nix/store/01y880ynwcg44b8zrcwzdvsfdsra5d9s-nixos-system-machine-test machine: (finished: must succeed: /nix/store/bjj1c5xdq9j21a84h34012nm3dspv0yf-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1, in 1.48 seconds) machine: must succeed: /nix/store/bjj1c5xdq9j21a84h34012nm3dspv0yf-nixos-system-machine-test/specialisation/simpleServiceWithInstallSection/bin/switch-to-configuration test 2>&1 machine # [ 61.530708] nixos[5457]: switching to system configuration /nix/store/4akad21ljw233654f1kj7w3gl10p713x-nixos-system-machine-test machine # [ 61.534151] systemd[1]: Stopped target Local File Systems. machine # [ 61.534995] systemd[1]: Stopped target Remote File Systems. machine # [ 61.768703] systemd[1]: Reload requested from client PID 5457 ('.switch-to-conf') (unit backdoor.service)... machine # [ 61.770415] systemd[1]: Reloading... machine # [ 62.029993] systemd[1]: Reloading finished in 258 ms. machine # [ 62.100664] systemd[619]: Reexecution requested from client PID 5526 ('switch-to-confi')... machine # [ 62.103309] systemd[619]: Reexecuting. machine # [ 62.124199] systemd[619]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 62.203826] systemd[619]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 62.209823] systemd[619]: Reload requested from client PID 5526 ('switch-to-confi')... machine # [ 62.211687] systemd[619]: Reloading... machine # [ 62.288027] systemd[619]: Reloading finished in 75 ms. machine # [ 62.293093] systemd[619]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 62.300421] systemd[619]: Stopped Run user-specific NixOS activation. machine # [ 62.301423] systemd[619]: Stopping Run user-specific NixOS activation... machine # [ 62.304071] systemd[619]: Starting Run user-specific NixOS activation... machine # [ 62.324065] systemd[619]: Finished Run user-specific NixOS activation. machine # [ 62.327171] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 62.328160] systemd[1]: Stopping Reactivate sysinit units... machine # [ 62.329249] systemd[1]: Reached target Reactivate sysinit units. machine # [ 62.330804] systemd[1]: Reached target Local File Systems. machine # [ 62.335381] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 62.339300] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 62.340804] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 62.341987] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 62.343878] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 62.345298] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 62.346439] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 62.351358] systemd[1]: Reached target Remote File Systems. machine # [ 62.356648] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 62.358102] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 62.490410] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 62.492304] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 62.495944] systemd[1]: Starting linger-users.service... machine # [ 62.523756] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 62.525248] systemd[1]: Finished linger-users.service. machine # [ 62.781699] nixos[5457]: finished switching to system configuration /nix/store/4akad21ljw233654f1kj7w3gl10p713x-nixos-system-machine-test machine: (finished: must succeed: /nix/store/bjj1c5xdq9j21a84h34012nm3dspv0yf-nixos-system-machine-test/specialisation/simpleServiceWithInstallSection/bin/switch-to-configuration test 2>&1, in 1.51 seconds) machine: must succeed: /nix/store/bjj1c5xdq9j21a84h34012nm3dspv0yf-nixos-system-machine-test/specialisation/simpleServiceWithExtraKey/bin/switch-to-configuration test 2>&1 machine # [ 63.040266] nixos[5597]: switching to system configuration /nix/store/6vqp4kx8n8b8dg2ri19xanjh1yk23jgz-nixos-system-machine-test machine # [ 63.042791] systemd[1]: Stopped target Remote File Systems. machine # [ 63.044860] systemd[1]: Stopped target Local File Systems. machine # [ 63.283262] systemd[1]: Reload requested from client PID 5597 ('.switch-to-conf') (unit backdoor.service)... machine # [ 63.284959] systemd[1]: Reloading... machine # [ 63.544970] systemd[1]: Reloading finished in 258 ms. machine # [ 63.609329] systemd[619]: Reexecution requested from client PID 5666 ('switch-to-confi')... machine # [ 63.612027] systemd[619]: Reexecuting. machine # [ 63.629167] systemd[619]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 63.705418] systemd[619]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 63.710875] systemd[619]: Reload requested from client PID 5666 ('switch-to-confi')... machine # [ 63.712206] systemd[619]: Reloading... machine # [ 63.788929] systemd[619]: Reloading finished in 75 ms. machine # [ 63.793900] systemd[619]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 63.799996] systemd[619]: Stopped Run user-specific NixOS activation. machine # [ 63.801971] systemd[619]: Stopping Run user-specific NixOS activation... machine # [ 63.803504] systemd[619]: Starting Run user-specific NixOS activation... machine # [ 63.824064] systemd[619]: Finished Run user-specific NixOS activation. machine # [ 63.827137] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 63.828434] systemd[1]: Stopping Reactivate sysinit units... machine # [ 63.829464] systemd[1]: Reached target Reactivate sysinit units. machine # [ 63.831273] systemd[1]: test.service: Deactivated successfully. machine # [ 63.833123] systemd[1]: Stopped test.service. machine # [ 63.833761] systemd[1]: Stopping test.service... machine # [ 63.836563] systemd[1]: Starting test.service... machine # [ 63.851424] systemd[1]: Finished test.service. machine # [ 63.855424] systemd[1]: Reached target Local File Systems. machine # [ 63.857187] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 63.859451] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 63.862042] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 63.863415] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 63.864222] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 63.867179] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 63.869112] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 63.870570] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 63.871747] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 63.876735] systemd[1]: Reached target Remote File Systems. machine # [ 64.011147] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 64.012783] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 64.016740] systemd[1]: Starting linger-users.service... machine # [ 64.046482] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 64.047955] systemd[1]: Finished linger-users.service. machine # [ 64.304692] nixos[5597]: finished switching to system configuration /nix/store/6vqp4kx8n8b8dg2ri19xanjh1yk23jgz-nixos-system-machine-test machine: (finished: must succeed: /nix/store/bjj1c5xdq9j21a84h34012nm3dspv0yf-nixos-system-machine-test/specialisation/simpleServiceWithExtraKey/bin/switch-to-configuration test 2>&1, in 1.52 seconds) machine: must succeed: /nix/store/bjj1c5xdq9j21a84h34012nm3dspv0yf-nixos-system-machine-test/specialisation/simpleServiceWithExtraKeyOtherValue/bin/switch-to-configuration test 2>&1 machine # [ 64.567421] nixos[5739]: switching to system configuration /nix/store/grx64ap2knlv1lpr6m1579plj3lmkkwz-nixos-system-machine-test machine # [ 64.569726] systemd[1]: Stopped target Remote File Systems. machine # [ 64.571444] systemd[1]: Stopped target Local File Systems. machine # [ 64.809278] systemd[1]: Reload requested from client PID 5739 ('.switch-to-conf') (unit backdoor.service)... machine # [ 64.810812] systemd[1]: Reloading... machine # [ 65.071751] systemd[1]: Reloading finished in 258 ms. machine # [ 65.136795] systemd[619]: Reexecution requested from client PID 5808 ('switch-to-confi')... machine # [ 65.138935] systemd[619]: Reexecuting. machine # [ 65.158180] systemd[619]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 65.235256] systemd[619]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 65.240981] systemd[619]: Reload requested from client PID 5808 ('switch-to-confi')... machine # [ 65.242239] systemd[619]: Reloading... machine # [ 65.320206] systemd[619]: Reloading finished in 76 ms. machine # [ 65.324973] systemd[619]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 65.331326] systemd[619]: Stopped Run user-specific NixOS activation. machine # [ 65.333064] systemd[619]: Stopping Run user-specific NixOS activation... machine # [ 65.334890] systemd[619]: Starting Run user-specific NixOS activation... machine # [ 65.355248] systemd[619]: Finished Run user-specific NixOS activation. machine # [ 65.358298] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 65.359669] systemd[1]: Stopping Reactivate sysinit units... machine # [ 65.360977] systemd[1]: Reached target Reactivate sysinit units. machine # [ 65.362591] systemd[1]: test.service: Deactivated successfully. machine # [ 65.364762] systemd[1]: Stopped test.service. machine # [ 65.365445] systemd[1]: Stopping test.service... machine # [ 65.367212] systemd[1]: Starting test.service... machine # [ 65.387244] systemd[1]: Finished test.service. machine # [ 65.392667] systemd[1]: Reached target Local File Systems. machine # [ 65.393974] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 65.395913] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 65.398758] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 65.401735] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 65.403286] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 65.405276] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 65.407257] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 65.408632] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 65.409755] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 65.418160] systemd[1]: Reached target Remote File Systems. machine # [ 65.551434] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 65.553165] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 65.557248] systemd[1]: Starting linger-users.service... machine # [ 65.587670] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 65.589255] systemd[1]: Finished linger-users.service. machine # [ 65.845615] nixos[5739]: finished switching to system configuration /nix/store/grx64ap2knlv1lpr6m1579plj3lmkkwz-nixos-system-machine-test machine: (finished: must succeed: /nix/store/bjj1c5xdq9j21a84h34012nm3dspv0yf-nixos-system-machine-test/specialisation/simpleServiceWithExtraKeyOtherValue/bin/switch-to-configuration test 2>&1, in 1.54 seconds) machine: must succeed: /nix/store/bjj1c5xdq9j21a84h34012nm3dspv0yf-nixos-system-machine-test/specialisation/simpleServiceWithExtraKeyOtherName/bin/switch-to-configuration test 2>&1 machine # [ 66.107875] nixos[5881]: switching to system configuration /nix/store/y4bvh5acsd82fxdsrld73l9jli3didcs-nixos-system-machine-test machine # [ 66.111485] systemd[1]: Stopped target Remote File Systems. machine # [ 66.112348] systemd[1]: Stopped target Local File Systems. machine # [ 66.339336] systemd[1]: Reload requested from client PID 5881 ('.switch-to-conf') (unit backdoor.service)... machine # [ 66.341093] systemd[1]: Reloading... machine # [ 66.593042] systemd[1]: Reloading finished in 249 ms. machine # [ 66.654865] systemd[619]: Reexecution requested from client PID 5950 ('switch-to-confi')... machine # [ 66.656870] systemd[619]: Reexecuting. machine # [ 66.675120] systemd[619]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 66.747080] systemd[619]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 66.752336] systemd[619]: Reload requested from client PID 5950 ('switch-to-confi')... machine # [ 66.753786] systemd[619]: Reloading... machine # [ 66.825111] systemd[619]: Reloading finished in 70 ms. machine # [ 66.830104] systemd[619]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 66.838065] systemd[619]: Stopped Run user-specific NixOS activation. machine # [ 66.838926] systemd[619]: Stopping Run user-specific NixOS activation... machine # [ 66.840832] systemd[619]: Starting Run user-specific NixOS activation... machine # [ 66.860849] systemd[619]: Finished Run user-specific NixOS activation. machine # [ 66.864117] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 66.865609] systemd[1]: Stopping Reactivate sysinit units... machine # [ 66.866616] systemd[1]: Reached target Reactivate sysinit units. machine # [ 66.868204] systemd[1]: test.service: Deactivated successfully. machine # [ 66.870149] systemd[1]: Stopped test.service. machine # [ 66.870759] systemd[1]: Stopping test.service... machine # [ 66.872320] systemd[1]: Starting test.service... machine # [ 66.886634] systemd[1]: Finished test.service. machine # [ 66.889861] systemd[1]: Reached target Local File Systems. machine # [ 66.891251] systemd[1]: Reached target Remote File Systems. machine # [ 66.893652] systemd[1]: Starting linger-users.service... machine # [ 66.906368] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 66.909901] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 66.911116] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 66.912761] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 66.914700] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 66.916168] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 66.917341] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 66.922130] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 66.923341] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 66.957811] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 66.960131] systemd[1]: Finished linger-users.service. machine # [ 67.064987] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 67.066649] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 67.323713] nixos[5881]: finished switching to system configuration /nix/store/y4bvh5acsd82fxdsrld73l9jli3didcs-nixos-system-machine-test machine: (finished: must succeed: /nix/store/bjj1c5xdq9j21a84h34012nm3dspv0yf-nixos-system-machine-test/specialisation/simpleServiceWithExtraKeyOtherName/bin/switch-to-configuration test 2>&1, in 1.48 seconds) machine: must succeed: /nix/store/bjj1c5xdq9j21a84h34012nm3dspv0yf-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1 machine # [ 67.559575] nixos[6023]: switching to system configuration /nix/store/01y880ynwcg44b8zrcwzdvsfdsra5d9s-nixos-system-machine-test machine # [ 67.563408] systemd[1]: Stopped target Remote File Systems. machine # [ 67.564393] systemd[1]: Stopped target Local File Systems. machine # [ 67.775635] systemd[1]: Reload requested from client PID 6023 ('.switch-to-conf') (unit backdoor.service)... machine # [ 67.777347] systemd[1]: Reloading... machine # [ 68.021299] systemd[1]: Reloading finished in 242 ms. machine # [ 68.087911] systemd[619]: Reexecution requested from client PID 6092 ('switch-to-confi')... machine # [ 68.089793] systemd[619]: Reexecuting. machine # [ 68.112241] systemd[619]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 68.189374] systemd[619]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 68.194863] systemd[619]: Reload requested from client PID 6092 ('switch-to-confi')... machine # [ 68.196548] systemd[619]: Reloading... machine # [ 68.273294] systemd[619]: Reloading finished in 75 ms. machine # [ 68.278854] systemd[619]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 68.285195] systemd[619]: Stopped Run user-specific NixOS activation. machine # [ 68.287100] systemd[619]: Stopping Run user-specific NixOS activation... machine # [ 68.288583] systemd[619]: Starting Run user-specific NixOS activation... machine # [ 68.309837] systemd[619]: Finished Run user-specific NixOS activation. machine # [ 68.313125] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 68.314586] systemd[1]: Stopping Reactivate sysinit units... machine # [ 68.315588] systemd[1]: Reached target Reactivate sysinit units. machine # [ 68.317341] systemd[1]: test.service: Deactivated successfully. machine # [ 68.319228] systemd[1]: Stopped test.service. machine # [ 68.319891] systemd[1]: Stopping test.service... machine # [ 68.321615] systemd[1]: Starting test.service... machine # [ 68.336240] systemd[1]: Finished test.service. machine # [ 68.339642] systemd[1]: Reached target Remote File Systems. machine # [ 68.342460] systemd[1]: Starting linger-users.service... machine # [ 68.348370] systemd[1]: Reached target Local File Systems. machine # [ 68.349220] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 68.353354] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 68.354252] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 68.356705] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 68.358696] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 68.360166] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 68.361355] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 68.376408] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 68.379123] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 68.408733] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 68.410951] systemd[1]: Finished linger-users.service. machine # [ 68.523249] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 68.524961] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 68.783320] nixos[6023]: finished switching to system configuration /nix/store/01y880ynwcg44b8zrcwzdvsfdsra5d9s-nixos-system-machine-test machine: (finished: must succeed: /nix/store/bjj1c5xdq9j21a84h34012nm3dspv0yf-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1, in 1.46 seconds) machine: must succeed: /nix/store/bjj1c5xdq9j21a84h34012nm3dspv0yf-nixos-system-machine-test/specialisation/simpleServiceReloadTrigger/bin/switch-to-configuration test 2>&1 machine # [ 69.033213] nixos[6165]: switching to system configuration /nix/store/08p3j9293p3g0qxizyjxxvfd6wvigig6-nixos-system-machine-test machine # [ 69.036295] systemd[1]: Stopped target Remote File Systems. machine # [ 69.037900] systemd[1]: Stopped target Local File Systems. machine # [ 69.266767] systemd[1]: Reload requested from client PID 6165 ('.switch-to-conf') (unit backdoor.service)... machine # [ 69.268489] systemd[1]: Reloading... machine # [ 69.510926] systemd[1]: Reloading finished in 240 ms. machine # [ 69.571810] systemd[619]: Reexecution requested from client PID 6234 ('switch-to-confi')... machine # [ 69.573614] systemd[619]: Reexecuting. machine # [ 69.595220] systemd[619]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 69.665801] systemd[619]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 69.671938] systemd[619]: Reload requested from client PID 6234 ('switch-to-confi')... machine # [ 69.673437] systemd[619]: Reloading... machine # [ 69.744876] systemd[619]: Reloading finished in 70 ms. machine # [ 69.749862] systemd[619]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 69.755879] systemd[619]: Stopped Run user-specific NixOS activation. machine # [ 69.756878] systemd[619]: Stopping Run user-specific NixOS activation... machine # [ 69.759300] systemd[619]: Starting Run user-specific NixOS activation... machine # [ 69.779956] systemd[619]: Finished Run user-specific NixOS activation. machine # [ 69.782978] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 69.784321] systemd[1]: Stopping Reactivate sysinit units... machine # [ 69.785410] systemd[1]: Reached target Reactivate sysinit units. machine # [ 69.788808] systemd[1]: Reloading test.service... machine # [ 69.802589] systemd[1]: Reloaded test.service. machine # [ 69.806912] systemd[1]: Reached target Remote File Systems. machine # [ 69.812604] systemd[1]: Starting linger-users.service... machine # [ 69.814596] systemd[1]: Reached target Local File Systems. machine # [ 69.817080] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 69.820141] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 69.820936] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 69.823957] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 69.825984] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 69.827451] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 69.828625] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 69.837940] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 69.839221] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 69.875419] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 69.876984] systemd[1]: Finished linger-users.service. machine # [ 69.979784] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 69.981638] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 70.239608] nixos[6165]: finished switching to system configuration /nix/store/08p3j9293p3g0qxizyjxxvfd6wvigig6-nixos-system-machine-test machine: (finished: must succeed: /nix/store/bjj1c5xdq9j21a84h34012nm3dspv0yf-nixos-system-machine-test/specialisation/simpleServiceReloadTrigger/bin/switch-to-configuration test 2>&1, in 1.46 seconds) machine: must succeed: /nix/store/bjj1c5xdq9j21a84h34012nm3dspv0yf-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModified/bin/switch-to-configuration test 2>&1 machine # [ 70.467876] nixos[6307]: switching to system configuration /nix/store/297sdf64wwid45bsrmv0zi0q21l20wgj-nixos-system-machine-test machine # [ 70.470530] systemd[1]: Stopped target Local File Systems. machine # [ 70.472413] systemd[1]: Stopped target Remote File Systems. machine # [ 70.699365] systemd[1]: Reload requested from client PID 6307 ('.switch-to-conf') (unit backdoor.service)... machine # [ 70.701107] systemd[1]: Reloading... machine # [ 70.943893] systemd[1]: Reloading finished in 241 ms. machine # [ 71.008374] systemd[619]: Reexecution requested from client PID 6376 ('switch-to-confi')... machine # [ 71.011095] systemd[619]: Reexecuting. machine # [ 71.032154] systemd[619]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 71.104340] systemd[619]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 71.109856] systemd[619]: Reload requested from client PID 6376 ('switch-to-confi')... machine # [ 71.112038] systemd[619]: Reloading... machine # [ 71.183730] systemd[619]: Reloading finished in 71 ms. machine # [ 71.188884] systemd[619]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 71.195220] systemd[619]: Stopped Run user-specific NixOS activation. machine # [ 71.197138] systemd[619]: Stopping Run user-specific NixOS activation... machine # [ 71.198659] systemd[619]: Starting Run user-specific NixOS activation... machine # [ 71.218781] systemd[619]: Finished Run user-specific NixOS activation. machine # [ 71.221847] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 71.223310] systemd[1]: Stopping Reactivate sysinit units... machine # [ 71.224792] systemd[1]: Reached target Reactivate sysinit units. machine # [ 71.227590] systemd[1]: Reloading test.service... machine # [ 71.241653] systemd[1]: Reloaded test.service. machine # [ 71.244723] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 71.246555] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 71.251944] systemd[1]: Reached target Remote File Systems. machine # [ 71.255225] systemd[1]: Reached target Local File Systems. machine # [ 71.258913] systemd[1]: Starting linger-users.service... machine # [ 71.261380] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 71.265208] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 71.267147] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 71.269193] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 71.271181] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 71.272583] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 71.273789] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 71.315615] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 71.317468] systemd[1]: Finished linger-users.service. machine # [ 71.420830] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 71.422766] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 71.680656] nixos[6307]: finished switching to system configuration /nix/store/297sdf64wwid45bsrmv0zi0q21l20wgj-nixos-system-machine-test machine: (finished: must succeed: /nix/store/bjj1c5xdq9j21a84h34012nm3dspv0yf-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModified/bin/switch-to-configuration test 2>&1, in 1.44 seconds) machine: must succeed: /nix/store/bjj1c5xdq9j21a84h34012nm3dspv0yf-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModifiedAndSomethingElse/bin/switch-to-configuration test 2>&1 machine # [ 71.910580] nixos[6449]: switching to system configuration /nix/store/01ibhglahbmqxlyiwdhd2qvnbcy51xa3-nixos-system-machine-test machine # [ 71.914239] systemd[1]: Stopped target Local File Systems. machine # [ 71.915429] systemd[1]: Stopped target Remote File Systems. machine # [ 72.138618] systemd[1]: Reload requested from client PID 6449 ('.switch-to-conf') (unit backdoor.service)... machine # [ 72.140378] systemd[1]: Reloading... machine # [ 72.363164] systemd[1]: Reloading finished in 220 ms. machine # [ 72.421794] systemd[619]: Reexecution requested from client PID 6518 ('switch-to-confi')... machine # [ 72.423657] systemd[619]: Reexecuting. machine # [ 72.445298] systemd[619]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 72.511830] systemd[619]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 72.517141] systemd[619]: Reload requested from client PID 6518 ('switch-to-confi')... machine # [ 72.518560] systemd[619]: Reloading... machine # [ 72.583803] systemd[619]: Reloading finished in 64 ms. machine # [ 72.589848] systemd[619]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 72.596249] systemd[619]: Stopped Run user-specific NixOS activation. machine # [ 72.598094] systemd[619]: Stopping Run user-specific NixOS activation... machine # [ 72.599870] systemd[619]: Starting Run user-specific NixOS activation... machine # [ 72.618526] systemd[619]: Finished Run user-specific NixOS activation. machine # [ 72.621583] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 72.622844] systemd[1]: Stopping Reactivate sysinit units... machine # [ 72.623884] systemd[1]: Reached target Reactivate sysinit units. machine # [ 72.625544] systemd[1]: test.service: Deactivated successfully. machine # [ 72.627357] systemd[1]: Stopped test.service. machine # [ 72.627954] systemd[1]: Stopping test.service... machine # [ 72.629615] systemd[1]: Starting test.service... machine # [ 72.642838] systemd[1]: Finished test.service. machine # [ 72.646829] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 72.648611] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 72.651219] systemd[1]: Reached target Local File Systems. machine # [ 72.653093] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 72.656423] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 72.657555] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 72.659451] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 72.661371] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 72.662804] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 72.663974] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 72.668927] systemd[1]: Reached target Remote File Systems. machine # [ 72.784178] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 72.785840] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 72.790061] systemd[1]: Starting linger-users.service... machine # [ 72.816622] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 72.818792] systemd[1]: Finished linger-users.service. machine # [ 73.074660] nixos[6449]: finished switching to system configuration /nix/store/01ibhglahbmqxlyiwdhd2qvnbcy51xa3-nixos-system-machine-test machine: (finished: must succeed: /nix/store/bjj1c5xdq9j21a84h34012nm3dspv0yf-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModifiedAndSomethingElse/bin/switch-to-configuration test 2>&1, in 1.39 seconds) machine: must succeed: /nix/store/bjj1c5xdq9j21a84h34012nm3dspv0yf-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModifiedSomethingElse/bin/switch-to-configuration test 2>&1 machine # [ 73.300060] nixos[6591]: switching to system configuration /nix/store/6vqp4kx8n8b8dg2ri19xanjh1yk23jgz-nixos-system-machine-test machine # [ 73.303618] systemd[1]: Stopped target Local File Systems. machine # [ 73.304842] systemd[1]: Stopped target Remote File Systems. machine # [ 73.509545] systemd[1]: Reload requested from client PID 6591 ('.switch-to-conf') (unit backdoor.service)... machine # [ 73.511329] systemd[1]: Reloading... machine # [ 73.737742] systemd[1]: Reloading finished in 222 ms. machine # [ 73.803619] systemd[619]: Reexecution requested from client PID 6660 ('switch-to-confi')... machine # [ 73.805191] systemd[619]: Reexecuting. machine # [ 73.827180] systemd[619]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 73.902302] systemd[619]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 73.907926] systemd[619]: Reload requested from client PID 6660 ('switch-to-confi')... machine # [ 73.909681] systemd[619]: Reloading... machine # [ 73.981859] systemd[619]: Reloading finished in 70 ms. machine # [ 73.985915] systemd[619]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 73.992330] systemd[619]: Stopped Run user-specific NixOS activation. machine # [ 73.994059] systemd[619]: Stopping Run user-specific NixOS activation... machine # [ 73.995829] systemd[619]: Starting Run user-specific NixOS activation... machine # [ 74.015878] systemd[619]: Finished Run user-specific NixOS activation. machine # [ 74.019354] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 74.020447] systemd[1]: Stopping Reactivate sysinit units... machine # [ 74.021826] systemd[1]: Reached target Reactivate sysinit units. machine # [ 74.024896] systemd[1]: Reached target Local File Systems. machine # [ 74.026334] systemd[1]: Reached target Remote File Systems. machine # [ 74.028278] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 74.032031] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 74.032807] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 74.033948] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 74.035879] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 74.037310] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 74.038448] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 74.040754] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 74.043118] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 74.186717] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 74.188574] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 74.192735] systemd[1]: Starting linger-users.service... machine # [ 74.221812] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 74.223317] systemd[1]: Finished linger-users.service. machine # [ 74.481218] nixos[6591]: finished switching to system configuration /nix/store/6vqp4kx8n8b8dg2ri19xanjh1yk23jgz-nixos-system-machine-test machine: (finished: must succeed: /nix/store/bjj1c5xdq9j21a84h34012nm3dspv0yf-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModifiedSomethingElse/bin/switch-to-configuration test 2>&1, in 1.41 seconds) (finished: subtest: unit file parser, in 19.03 seconds) subtest: restart and reload by activation script machine: must succeed: /nix/store/bjj1c5xdq9j21a84h34012nm3dspv0yf-nixos-system-machine-test/specialisation/simpleServiceNorestart/bin/switch-to-configuration test 2>&1 machine # [ 74.671517] nixos[6731]: switching to system configuration /nix/store/xwy9p44k04060m4ryvk8p1r28l1si72r-nixos-system-machine-test machine # [ 74.675652] systemd[1]: Stopped target Remote File Systems. machine # [ 74.676767] systemd[1]: Stopped target Local File Systems. machine # [ 74.883132] systemd[1]: Reload requested from client PID 6731 ('.switch-to-conf') (unit backdoor.service)... machine # [ 74.884809] systemd[1]: Reloading... machine # [ 75.110986] systemd[1]: Reloading finished in 224 ms. machine # [ 75.169612] systemd[619]: Reexecution requested from client PID 6800 ('switch-to-confi')... machine # [ 75.171484] systemd[619]: Reexecuting. machine # [ 75.193119] systemd[619]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 75.259849] systemd[619]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 75.265395] systemd[619]: Reload requested from client PID 6800 ('switch-to-confi')... machine # [ 75.267152] systemd[619]: Reloading... machine # [ 75.331364] systemd[619]: Reloading finished in 62 ms. machine # [ 75.335865] systemd[619]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 75.343066] systemd[619]: Stopped Run user-specific NixOS activation. machine # [ 75.343965] systemd[619]: Stopping Run user-specific NixOS activation... machine # [ 75.345846] systemd[619]: Starting Run user-specific NixOS activation... machine # [ 75.364726] systemd[619]: Finished Run user-specific NixOS activation. machine # [ 75.367780] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 75.369168] systemd[1]: Stopping Reactivate sysinit units... machine # [ 75.369885] systemd[1]: Reached target Reactivate sysinit units. machine # [ 75.374320] systemd[1]: Reached target Remote File Systems. machine # [ 75.378575] systemd[1]: Reached target Local File Systems. machine # [ 75.382485] systemd[1]: Starting linger-users.service... machine # [ 75.384929] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 75.391309] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 75.392141] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 75.393319] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 75.395349] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 75.396841] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 75.397997] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 75.403554] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 75.404758] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 75.442373] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 75.444453] systemd[1]: Finished linger-users.service. machine # [ 75.533345] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 75.535965] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 75.793325] nixos[6731]: finished switching to system configuration /nix/store/xwy9p44k04060m4ryvk8p1r28l1si72r-nixos-system-machine-test machine: (finished: must succeed: /nix/store/bjj1c5xdq9j21a84h34012nm3dspv0yf-nixos-system-machine-test/specialisation/simpleServiceNorestart/bin/switch-to-configuration test 2>&1, in 1.31 seconds) machine: must succeed: /nix/store/bjj1c5xdq9j21a84h34012nm3dspv0yf-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration test 2>&1 machine # [ 75.986416] nixos[6871]: switching to system configuration /nix/store/bg03bq7784hhp4qhx875x1shz05da16d-nixos-system-machine-test machine # [ 75.989483] systemd[1]: test.service: Deactivated successfully. machine # [ 75.991180] systemd[1]: Stopped test.service. machine # [ 75.991823] systemd[1]: Stopped target Local File Systems. machine # [ 75.993621] systemd[1]: Stopped target Remote File Systems. machine # [ 76.220236] systemd[1]: Reload requested from client PID 6871 ('.switch-to-conf') (unit backdoor.service)... machine # [ 76.221903] systemd[1]: Reloading... machine # [ 76.472950] systemd[1]: Reloading finished in 249 ms. machine # [ 76.535317] systemd[619]: Reexecution requested from client PID 6942 ('switch-to-confi')... machine # [ 76.537808] systemd[619]: Reexecuting. machine # [ 76.559133] systemd[619]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 76.631498] systemd[619]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 76.636909] systemd[619]: Reload requested from client PID 6942 ('switch-to-confi')... machine # [ 76.639122] systemd[619]: Reloading... machine # [ 76.708878] systemd[619]: Reloading finished in 70 ms. machine # [ 76.713841] systemd[619]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 76.720783] systemd[619]: Stopped Run user-specific NixOS activation. machine # [ 76.721721] systemd[619]: Stopping Run user-specific NixOS activation... machine # [ 76.723295] systemd[619]: Starting Run user-specific NixOS activation... machine # [ 76.743617] systemd[619]: Finished Run user-specific NixOS activation. machine # [ 76.746668] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 76.747944] systemd[1]: Stopping Reactivate sysinit units... machine # [ 76.748952] systemd[1]: Reached target Reactivate sysinit units. machine # [ 76.752973] systemd[1]: Starting no-restart-service.service... machine # [ 76.761457] systemd[1]: Created slice Slice /system/templated-simple-restart-service. machine # [ 76.764373] systemd[1]: Starting templated-simple-restart-service@instance.service... machine # [ 76.767220] systemd[1]: Reached target Local File Systems. machine # [ 76.775927] systemd[1]: Created slice Slice /system/templated-reload-triggers. machine # [ 76.779204] systemd[1]: Created slice Slice /system/templated-reload-triggers-and-restart. machine # [ 76.780377] systemd[1]: Reached target Remote File Systems. machine # [ 76.783093] systemd[1]: Starting linger-users.service... machine # [ 76.787178] systemd[1]: Starting reload-triggers-and-restart.service... machine # [ 76.793071] systemd[1]: Starting reload-triggers.service... machine # [ 76.793881] systemd[1]: Starting templated-reload-triggers-and-restart@instance.service... machine # [ 76.798576] systemd[1]: Starting templated-reload-triggers@instance.service... machine # [ 76.811676] systemd[1]: Starting simple-service.service... machine # [ 76.817363] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 76.819533] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 76.831716] systemd[1]: Created slice Slice /system/templated-no-restart-service. machine # [ 76.835562] systemd[1]: Starting templated-no-restart-service@instance.service... machine # [ 76.846605] systemd[1]: Created slice Slice /system/templated-reload-triggers-and-restart-by-as. machine # [ 76.852086] systemd[1]: Starting templated-reload-triggers-and-restart-by-as@instance.service... machine # [ 76.855460] systemd[1]: Finished no-restart-service.service. machine # [ 76.872135] systemd[1]: Starting reload-triggers-and-restart-by-as.service... machine # [ 76.880104] systemd[1]: Created slice Slice /system/templated-simple-reload-service. machine # [ 76.889239] systemd[1]: Starting templated-simple-reload-service@instance.service... machine # [ 76.901251] systemd[1]: Starting simple-restart-service.service... machine # [ 76.907910] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 76.917064] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 76.917845] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 76.919109] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 76.924277] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 76.929144] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 76.936813] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 76.938098] systemd[1]: Finished templated-simple-restart-service@instance.service. machine # [ 76.939088] systemd[1]: Created slice Slice /system/templated-simple-service. machine # [ 76.961284] systemd[1]: Finished reload-triggers.service. machine # [ 76.963779] systemd[1]: Finished reload-triggers-and-restart.service. machine # [ 76.977074] systemd[1]: Finished templated-reload-triggers-and-restart@instance.service. machine # [ 76.979693] systemd[1]: Finished templated-reload-triggers@instance.service. machine # [ 76.986157] systemd[1]: Finished simple-service.service. machine # [ 77.004286] systemd[1]: Finished templated-no-restart-service@instance.service. machine # [ 77.014374] systemd[1]: Finished templated-reload-triggers-and-restart-by-as@instance.service. machine # [ 77.025681] systemd[1]: Finished simple-restart-service.service. machine # [ 77.028808] systemd[1]: Finished reload-triggers-and-restart-by-as.service. machine # [ 77.032620] systemd[1]: Finished templated-simple-reload-service@instance.service. machine # [ 77.040852] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 77.042862] systemd[1]: Finished linger-users.service. machine # [ 77.150869] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 77.152619] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 77.157215] systemd[1]: Starting simple-reload-service.service... machine # [ 77.159427] systemd[1]: Starting templated-simple-service@instance.service... machine # [ 77.183221] systemd[1]: Finished simple-reload-service.service. machine # [ 77.185262] systemd[1]: Finished templated-simple-service@instance.service. machine # [ 77.442900] nixos[6871]: finished switching to system configuration /nix/store/bg03bq7784hhp4qhx875x1shz05da16d-nixos-system-machine-test machine: (finished: must succeed: /nix/store/bjj1c5xdq9j21a84h34012nm3dspv0yf-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration test 2>&1, in 1.65 seconds) machine: must succeed: /nix/store/bjj1c5xdq9j21a84h34012nm3dspv0yf-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration test 2>&1 machine # [ 77.697703] nixos[7041]: switching to system configuration /nix/store/bg03bq7784hhp4qhx875x1shz05da16d-nixos-system-machine-test machine # [ 77.699950] systemd[1]: Stopped target Remote File Systems. machine # [ 77.701605] systemd[1]: Stopped target Local File Systems. machine # [ 77.924375] systemd[1]: Reload requested from client PID 7041 ('.switch-to-conf') (unit backdoor.service)... machine # [ 77.926076] systemd[1]: Reloading... machine # [ 78.175298] systemd[1]: Reloading finished in 247 ms. machine # [ 78.239639] systemd[619]: Reexecution requested from client PID 7112 ('switch-to-confi')... machine # [ 78.242378] systemd[619]: Reexecuting. machine # [ 78.264132] systemd[619]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 78.336288] systemd[619]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 78.341287] systemd[619]: Reload requested from client PID 7112 ('switch-to-confi')... machine # [ 78.343116] systemd[619]: Reloading... machine # [ 78.414383] systemd[619]: Reloading finished in 70 ms. machine # [ 78.419871] systemd[619]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 78.426215] systemd[619]: Stopped Run user-specific NixOS activation. machine # [ 78.428130] systemd[619]: Stopping Run user-specific NixOS activation... machine # [ 78.429619] systemd[619]: Starting Run user-specific NixOS activation... machine # [ 78.449834] systemd[619]: Finished Run user-specific NixOS activation. machine # [ 78.452973] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 78.454225] systemd[1]: Stopping Reactivate sysinit units... machine # [ 78.454948] systemd[1]: Reached target Reactivate sysinit units. machine # [ 78.459732] systemd[1]: Reloading reload-triggers-and-restart.service... machine # [ 78.467202] systemd[1]: Reloading reload-triggers.service... machine # [ 78.469317] systemd[1]: Reloading simple-reload-service.service... machine # [ 78.473846] systemd[1]: Reloading templated-reload-triggers-and-restart@instance.service... machine # [ 78.479880] systemd[1]: Reloading templated-reload-triggers@instance.service... machine # [ 78.488144] systemd[1]: Reloading templated-simple-reload-service@instance.service... machine # [ 78.522985] systemd[1]: Reloaded reload-triggers-and-restart.service. machine # [ 78.532466] systemd[1]: Reloaded reload-triggers.service. machine # [ 78.539048] systemd[1]: Reloaded simple-reload-service.service. machine # [ 78.542758] systemd[1]: Reloaded templated-reload-triggers-and-restart@instance.service. machine # [ 78.545094] systemd[1]: Reloaded templated-reload-triggers@instance.service. machine # [ 78.547253] systemd[1]: Reloaded templated-simple-reload-service@instance.service. machine # [ 78.551915] systemd[1]: reload-triggers-and-restart-by-as.service: Deactivated successfully. machine # [ 78.554292] systemd[1]: Stopped reload-triggers-and-restart-by-as.service. machine # [ 78.555256] systemd[1]: Stopping reload-triggers-and-restart-by-as.service... machine # [ 78.557290] systemd[1]: Starting reload-triggers-and-restart-by-as.service... machine # [ 78.559358] systemd[1]: simple-restart-service.service: Deactivated successfully. machine # [ 78.560533] systemd[1]: Stopped simple-restart-service.service. machine # [ 78.561819] systemd[1]: Stopping simple-restart-service.service... machine # [ 78.563461] systemd[1]: Starting simple-restart-service.service... machine # [ 78.567105] systemd[1]: simple-service.service: Deactivated successfully. machine # [ 78.567976] systemd[1]: Stopped simple-service.service. machine # [ 78.568904] systemd[1]: Stopping simple-service.service... machine # [ 78.572691] systemd[1]: Starting simple-service.service... machine # [ 78.577406] systemd[1]: templated-reload-triggers-and-restart-by-as@instance.service: Deactivated successfully. machine # [ 78.578766] systemd[1]: Stopped templated-reload-triggers-and-restart-by-as@instance.service. machine # [ 78.579955] systemd[1]: Stopping templated-reload-triggers-and-restart-by-as@instance.service... machine # [ 78.583157] systemd[1]: Starting templated-reload-triggers-and-restart-by-as@instance.service... machine # [ 78.587328] systemd[1]: templated-simple-restart-service@instance.service: Deactivated successfully. machine # [ 78.588917] systemd[1]: Stopped templated-simple-restart-service@instance.service. machine # [ 78.589971] systemd[1]: Stopping templated-simple-restart-service@instance.service... machine # [ 78.593306] systemd[1]: Starting templated-simple-restart-service@instance.service... machine # [ 78.594346] systemd[1]: templated-simple-service@instance.service: Deactivated successfully. machine # [ 78.595390] systemd[1]: Stopped templated-simple-service@instance.service. machine # [ 78.599580] systemd[1]: Stopping templated-simple-service@instance.service... machine # [ 78.601302] systemd[1]: Starting templated-simple-service@instance.service... machine # [ 78.644103] systemd[1]: Finished simple-service.service. machine # [ 78.646949] systemd[1]: Finished simple-restart-service.service. machine # [ 78.648245] systemd[1]: Finished reload-triggers-and-restart-by-as.service. machine # [ 78.656799] systemd[1]: Finished templated-reload-triggers-and-restart-by-as@instance.service. machine # [ 78.659377] systemd[1]: Finished templated-simple-restart-service@instance.service. machine # [ 78.661404] systemd[1]: Finished templated-simple-service@instance.service. machine # [ 78.666829] systemd[1]: Reached target Remote File Systems. machine # [ 78.669946] systemd[1]: Starting linger-users.service... machine # [ 78.675935] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 78.677127] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 78.681061] systemd[1]: Reached target Local File Systems. machine # [ 78.682247] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 78.687207] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 78.687987] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 78.689167] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 78.691099] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 78.692551] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 78.693697] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 78.735516] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 78.737817] systemd[1]: Finished linger-users.service. machine # [ 78.831772] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 78.833480] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 79.089336] nixos[7041]: finished switching to system configuration /nix/store/bg03bq7784hhp4qhx875x1shz05da16d-nixos-system-machine-test machine: (finished: must succeed: /nix/store/bjj1c5xdq9j21a84h34012nm3dspv0yf-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration test 2>&1, in 1.64 seconds) machine: must succeed: /nix/store/bjj1c5xdq9j21a84h34012nm3dspv0yf-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script-modified/bin/switch-to-configuration test 2>&1 machine # [ 79.329273] nixos[7207]: switching to system configuration /nix/store/fizq20pwv9g9h2q9p535dzc5k45a9n0c-nixos-system-machine-test machine # [ 79.331777] systemd[1]: Stopped target Remote File Systems. machine # [ 79.333884] systemd[1]: Stopped target Local File Systems. machine # [ 79.576840] systemd[1]: Reload requested from client PID 7207 ('.switch-to-conf') (unit backdoor.service)... machine # [ 79.578626] systemd[1]: Reloading... machine # [ 79.832379] systemd[1]: Reloading finished in 252 ms. machine # [ 79.897375] systemd[619]: Reexecution requested from client PID 7278 ('switch-to-confi')... machine # [ 79.898814] systemd[619]: Reexecuting. machine # [ 79.920151] systemd[619]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 79.987477] systemd[619]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 79.992751] systemd[619]: Reload requested from client PID 7278 ('switch-to-confi')... machine # [ 79.994390] systemd[619]: Reloading... machine # [ 80.064116] systemd[619]: Reloading finished in 68 ms. machine # [ 80.069857] systemd[619]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 80.077061] systemd[619]: Stopped Run user-specific NixOS activation. machine # [ 80.077932] systemd[619]: Stopping Run user-specific NixOS activation... machine # [ 80.080058] systemd[619]: Starting Run user-specific NixOS activation... machine # [ 80.102177] systemd[619]: Finished Run user-specific NixOS activation. machine # [ 80.105306] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 80.106651] systemd[1]: Stopping Reactivate sysinit units... machine # [ 80.107728] systemd[1]: Reached target Reactivate sysinit units. machine # [ 80.111711] systemd[1]: Reloading reload-triggers.service... machine # [ 80.117851] systemd[1]: Reloading simple-reload-service.service... machine # [ 80.125361] systemd[1]: Reloading templated-reload-triggers@instance.service... machine # [ 80.127280] systemd[1]: Reloading templated-simple-reload-service@instance.service... machine # [ 80.159443] systemd[1]: Reloaded reload-triggers.service. machine # [ 80.161382] systemd[1]: Reloaded templated-reload-triggers@instance.service. machine # [ 80.163600] systemd[1]: Reloaded simple-reload-service.service. machine # [ 80.167984] systemd[1]: Reloaded templated-simple-reload-service@instance.service. machine # [ 80.171794] systemd[1]: reload-triggers-and-restart-by-as.service: Deactivated successfully. machine # [ 80.174069] systemd[1]: Stopped reload-triggers-and-restart-by-as.service. machine # [ 80.174965] systemd[1]: Stopping reload-triggers-and-restart-by-as.service... machine # [ 80.177674] systemd[1]: Starting reload-triggers-and-restart-by-as.service... machine # [ 80.178636] systemd[1]: reload-triggers-and-restart.service: Deactivated successfully. machine # [ 80.179704] systemd[1]: Stopped reload-triggers-and-restart.service. machine # [ 80.182472] systemd[1]: Stopping reload-triggers-and-restart.service... machine # [ 80.184945] systemd[1]: Starting reload-triggers-and-restart.service... machine # [ 80.187717] systemd[1]: simple-restart-service.service: Deactivated successfully. machine # [ 80.188749] systemd[1]: Stopped simple-restart-service.service. machine # [ 80.189566] systemd[1]: Stopping simple-restart-service.service... machine # [ 80.190419] systemd[1]: Starting simple-restart-service.service... machine # [ 80.194091] systemd[1]: simple-service.service: Deactivated successfully. machine # [ 80.197183] systemd[1]: Stopped simple-service.service. machine # [ 80.197912] systemd[1]: Stopping simple-service.service... machine # [ 80.200726] systemd[1]: Starting simple-service.service... machine # [ 80.202191] systemd[1]: templated-reload-triggers-and-restart-by-as@instance.service: Deactivated successfully. machine # [ 80.203466] systemd[1]: Stopped templated-reload-triggers-and-restart-by-as@instance.service. machine # [ 80.205150] systemd[1]: Stopping templated-reload-triggers-and-restart-by-as@instance.service... machine # [ 80.213305] systemd[1]: Starting templated-reload-triggers-and-restart-by-as@instance.service... machine # [ 80.214485] systemd[1]: templated-reload-triggers-and-restart@instance.service: Deactivated successfully. machine # [ 80.215707] systemd[1]: Stopped templated-reload-triggers-and-restart@instance.service. machine # [ 80.216771] systemd[1]: Stopping templated-reload-triggers-and-restart@instance.service... machine # [ 80.222704] systemd[1]: Starting templated-reload-triggers-and-restart@instance.service... machine # [ 80.223923] systemd[1]: templated-simple-restart-service@instance.service: Deactivated successfully. machine # [ 80.225902] systemd[1]: Stopped templated-simple-restart-service@instance.service. machine # [ 80.232512] systemd[1]: Stopping templated-simple-restart-service@instance.service... machine # [ 80.233608] systemd[1]: Starting templated-simple-restart-service@instance.service... machine # [ 80.236301] systemd[1]: templated-simple-service@instance.service: Deactivated successfully. machine # [ 80.243204] systemd[1]: Stopped templated-simple-service@instance.service. machine # [ 80.246593] systemd[1]: Stopping templated-simple-service@instance.service... machine # [ 80.249473] systemd[1]: Starting templated-simple-service@instance.service... machine # [ 80.291481] systemd[1]: Finished reload-triggers-and-restart.service. machine # [ 80.294411] systemd[1]: Finished simple-service.service. machine # [ 80.295654] systemd[1]: Finished simple-restart-service.service. machine # [ 80.299345] systemd[1]: Finished reload-triggers-and-restart-by-as.service. machine # [ 80.308640] systemd[1]: Finished templated-reload-triggers-and-restart-by-as@instance.service. machine # [ 80.317558] systemd[1]: Finished templated-reload-triggers-and-restart@instance.service. machine # [ 80.319798] systemd[1]: Finished templated-simple-restart-service@instance.service. machine # [ 80.321954] systemd[1]: Finished templated-simple-service@instance.service. machine # [ 80.326488] systemd[1]: Reached target Local File Systems. machine # [ 80.330943] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 80.336695] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 80.337718] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 80.342174] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 80.344889] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 80.346665] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 80.348147] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 80.352329] systemd[1]: Reached target Remote File Systems. machine # [ 80.359079] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 80.360541] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 80.500121] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 80.501909] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 80.506978] systemd[1]: Starting linger-users.service... machine # [ 80.537203] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 80.538707] systemd[1]: Finished linger-users.service. machine # [ 80.797389] nixos[7207]: finished switching to system configuration /nix/store/fizq20pwv9g9h2q9p535dzc5k45a9n0c-nixos-system-machine-test machine: (finished: must succeed: /nix/store/bjj1c5xdq9j21a84h34012nm3dspv0yf-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script-modified/bin/switch-to-configuration test 2>&1, in 1.71 seconds) machine: must succeed: /nix/store/bjj1c5xdq9j21a84h34012nm3dspv0yf-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration dry-activate 2>&1 machine: (finished: must succeed: /nix/store/bjj1c5xdq9j21a84h34012nm3dspv0yf-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration dry-activate 2>&1, in 0.29 seconds) (finished: subtest: restart and reload by activation script, in 6.61 seconds) (finished: run the VM test script, in 82.05 seconds) test script finished in 82.31s cleanup kill QemuMachine (pid 45) machine # qemu-system-x86_64: terminating on signal 15 from pid 39 (/nix/store/d64q19q1xjdwfhqx6czvrjgrhq0n3lcc-python3-3.14.7/bin/python3.14) machine # [2026-09-27T03:19:58Z INFO virtiofsd] Client disconnected, shutting down machine # [2026-09-27T03:19:58Z INFO virtiofsd] Client disconnected, shutting down machine # [2026-09-27T03:19:58Z INFO virtiofsd] Client disconnected, shutting down (finished: cleanup, in 0.15 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