tribuchet: building on jamie Machine state will be reset. To keep it, pass --keep-machine-state start all VLans (finished: start all VLans, in 0.00 seconds) Test will time out and terminate in 3600.0 seconds run the VM test script machine: waiting for unit multi-user.target machine: waiting for the VM to finish booting machine: starting vm machine: QEMU running (pid 45) machine # Disk image does not exist, creating the virtualisation disk image... machine # Formatting '/build/vm-state-machine/tmp.LLRM8bIMlN', 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: 37788586-ec57-47ab-a659-733cac9c1e29 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-10-16T02:54:31Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1) machine # [2026-10-16T02:54:31Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether machine # [2026-10-16T02:54:31Z INFO virtiofsd] Waiting for vhost-user socket connection... machine # [2026-10-16T02:54:31Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1) machine # [2026-10-16T02:54:31Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether machine # [2026-10-16T02:54:31Z INFO virtiofsd] Waiting for vhost-user socket connection... machine # [2026-10-16T02:54:31Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1) machine # [2026-10-16T02:54:31Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether machine # [2026-10-16T02:54:31Z INFO virtiofsd] Waiting for vhost-user socket connection... machine # [2026-10-16T02:54:31Z INFO virtiofsd] Client connected, servicing requests machine # [2026-10-16T02:54:31Z INFO virtiofsd] Client connected, servicing requests machine # [2026-10-16T02:54:31Z 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.56 (nixbld@localhost) (gcc (GCC) 16.2.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT_DYNAMIC @1791725172 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/18jsxirzz9yhwgfqrm1ha69kkxv7fbqn-nixos-system-machine-test/init regInfo=/nix/.ro-store/f633rmflxs67mdsgpnzs4hlpnzdz5naw-closure-info/registration console=ttyS0,115200n8 console=tty0 machine # [ 0.000000] BIOS-provided physical RAM map: machine # [ 0.000000] BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable machine # [ 0.000000] BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved machine # [ 0.000000] BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved machine # [ 0.000000] BIOS-e820: [mem 0x0000000000100000-0x000000003ffd7fff] usable machine # [ 0.000000] BIOS-e820: [mem 0x000000003ffd8000-0x000000003fffffff] reserved machine # [ 0.000000] BIOS-e820: [mem 0x00000000b0000000-0x00000000bfffffff] reserved machine # [ 0.000000] BIOS-e820: [mem 0x00000000fed1c000-0x00000000fed1ffff] reserved machine # [ 0.000000] BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved machine # [ 0.000000] BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved machine # [ 0.000000] BIOS-e820: [mem 0x000000fd00000000-0x000000ffffffffff] reserved machine # [ 0.000000] NX (Execute Disable) protection: active machine # [ 0.000000] APIC: Static calls initialized machine # [ 0.000000] SMBIOS 2.8 present. machine # [ 0.000000] DMI: QEMU Standard PC (Q35 + ICH9, 2009), BIOS rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org 04/01/2014 machine # [ 0.000000] DMI: Memory slots populated: 1/1 machine # [ 0.000000] Hypervisor detected: KVM machine # [ 0.000000] last_pfn = 0x3ffd8 max_arch_pfn = 0x10000000000 machine # [ 0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d00 machine # [ 0.000001] kvm-clock: using sched offset of 451015888 cycles machine # [ 0.000002] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns machine # [ 0.000005] tsc: Detected 2400.008 MHz processor machine # [ 0.000783] last_pfn = 0x3ffd8 max_arch_pfn = 0x10000000000 machine # [ 0.000810] MTRR map: 4 entries (3 fixed + 1 variable; max 19), built from 8 variable MTRRs machine # [ 0.000813] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT machine # [ 0.002712] found SMP MP-table at [mem 0x000f5450-0x000f545f] machine # [ 0.002723] Using GB pages for direct mapping machine # [ 0.002823] RAMDISK: [mem 0x3e2b8000-0x3ffcffff] machine # [ 0.002831] ACPI: Early table checksum verification disabled machine # [ 0.002834] ACPI: RSDP 0x00000000000F5270 000014 (v00 BOCHS ) machine # [ 0.002838] ACPI: RSDT 0x000000003FFE2422 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) machine # [ 0.002843] ACPI: FACP 0x000000003FFE221A 0000F4 (v03 BOCHS BXPC 00000001 BXPC 00000001) machine # [ 0.002850] ACPI: DSDT 0x000000003FFE0040 0021DA (v01 BOCHS BXPC 00000001 BXPC 00000001) machine # [ 0.002852] ACPI: FACS 0x000000003FFE0000 000040 machine # [ 0.002854] ACPI: APIC 0x000000003FFE230E 000078 (v03 BOCHS BXPC 00000001 BXPC 00000001) machine # [ 0.002855] ACPI: HPET 0x000000003FFE2386 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) machine # [ 0.002857] ACPI: MCFG 0x000000003FFE23BE 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001) machine # [ 0.002858] ACPI: WAET 0x000000003FFE23FA 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001) machine # [ 0.002860] ACPI: Reserving FACP table memory at [mem 0x3ffe221a-0x3ffe230d] machine # [ 0.002861] ACPI: Reserving DSDT table memory at [mem 0x3ffe0040-0x3ffe2219] machine # [ 0.002861] ACPI: Reserving FACS table memory at [mem 0x3ffe0000-0x3ffe003f] machine # [ 0.002862] ACPI: Reserving APIC table memory at [mem 0x3ffe230e-0x3ffe2385] machine # [ 0.002862] ACPI: Reserving HPET table memory at [mem 0x3ffe2386-0x3ffe23bd] machine # [ 0.002863] ACPI: Reserving MCFG table memory at [mem 0x3ffe23be-0x3ffe23f9] machine # [ 0.002863] ACPI: Reserving WAET table memory at [mem 0x3ffe23fa-0x3ffe2421] machine # [ 0.003086] No NUMA configuration found machine # [ 0.003087] Faking a node at [mem 0x0000000000000000-0x000000003ffd7fff] machine # [ 0.003089] NODE_DATA(0) allocated [mem 0x3ffd2780-0x3ffd7cff] machine # [ 0.005471] Zone ranges: machine # [ 0.005472] DMA [mem 0x0000000000001000-0x0000000000ffffff] machine # [ 0.005474] DMA32 [mem 0x0000000001000000-0x000000003ffd7fff] machine # [ 0.005475] Normal empty machine # [ 0.005476] Device empty machine # [ 0.005477] Movable zone start for each node machine # [ 0.005477] Early memory node ranges machine # [ 0.005478] node 0: [mem 0x0000000000001000-0x000000000009efff] machine # [ 0.005479] node 0: [mem 0x0000000000100000-0x000000003ffd7fff] machine # [ 0.005480] Initmem setup node 0 [mem 0x0000000000001000-0x000000003ffd7fff] machine # [ 0.005500] On node 0, zone DMA: 1 pages in unavailable ranges machine # [ 0.005772] On node 0, zone DMA: 97 pages in unavailable ranges machine # [ 0.023847] On node 0, zone DMA32: 40 pages in unavailable ranges machine # [ 0.024297] ACPI: PM-Timer IO Port: 0x608 machine # [ 0.024309] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) machine # [ 0.024335] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 machine # [ 0.024337] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) machine # [ 0.024339] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) machine # [ 0.024340] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) machine # [ 0.024341] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) machine # [ 0.024342] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) machine # [ 0.024344] ACPI: Using ACPI (MADT) for SMP configuration information machine # [ 0.024345] ACPI: HPET id: 0x8086a201 base: 0xfed00000 machine # [ 0.024349] TSC deadline timer available machine # [ 0.024353] CPU topo: Max. logical packages: 1 machine # [ 0.024354] CPU topo: Max. logical dies: 1 machine # [ 0.024354] CPU topo: Max. dies per package: 1 machine # [ 0.024357] CPU topo: Max. threads per core: 1 machine # [ 0.024358] CPU topo: Num. cores per package: 1 machine # [ 0.024358] CPU topo: Num. threads per package: 1 machine # [ 0.024359] CPU topo: Allowing 1 present CPUs plus 0 hotplug CPUs machine # [ 0.024373] kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write() machine # [ 0.024401] PM: hibernation: Registered nosave memory: [mem 0x00000000-0x00000fff] machine # [ 0.024403] PM: hibernation: Registered nosave memory: [mem 0x0009f000-0x000fffff] machine # [ 0.024404] [mem 0x40000000-0xafffffff] available for PCI devices machine # [ 0.024406] Booting paravirtualized kernel on KVM machine # [ 0.024408] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns machine # [ 0.029051] setup_percpu: NR_CPUS:512 nr_cpumask_bits:1 nr_cpu_ids:1 nr_node_ids:1 machine # [ 0.031173] percpu: Embedded 98 pages/cpu s278528 r8192 d114688 u2097152 machine # [ 0.031214] kvm-guest: PV spinlocks disabled, single CPU machine # [ 0.031215] 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/18jsxirzz9yhwgfqrm1ha69kkxv7fbqn-nixos-system-machine-test/init regInfo=/nix/.ro-store/f633rmflxs67mdsgpnzs4hlpnzdz5naw-closure-info/registration console=ttyS0,115200n8 console=tty0 machine # [ 0.031306] Unknown kernel command line parameters "regInfo=/nix/.ro-store/f633rmflxs67mdsgpnzs4hlpnzdz5naw-closure-info/registration", will be passed to user space. machine # [ 0.031318] random: crng init done machine # [ 0.031319] printk: log buffer data + meta data: 262144 + 917504 = 1179648 bytes machine # [ 0.031340] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes, linear) machine # [ 0.031864] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes, linear) machine # [ 0.031892] Fallback order for Node 0: 0 machine # [ 0.031894] Built 1 zonelists, mobility grouping on. Total pages: 262006 machine # [ 0.031895] Policy zone: DMA32 machine # [ 0.034175] mem auto-init: stack:all(zero), heap alloc:on, heap free:off machine # [ 0.036582] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1 machine # [ 0.038743] allocated 2097152 bytes of page_ext machine # [ 0.048518] ftrace: allocating 48842 entries in 192 pages machine # [ 0.048520] ftrace: allocated 192 pages with 2 groups machine # [ 0.049336] Dynamic Preempt: lazy machine # [ 0.049448] rcu: Preemptible hierarchical RCU implementation. machine # [ 0.049449] rcu: RCU event tracing is enabled. machine # [ 0.049449] rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=1. machine # [ 0.049451] Trampoline variant of Tasks RCU enabled. machine # [ 0.049452] Rude variant of Tasks RCU enabled. machine # [ 0.049452] Tracing variant of Tasks RCU enabled. machine # [ 0.049453] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. machine # [ 0.049453] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1 machine # [ 0.049508] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. machine # [ 0.049510] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. machine # [ 0.049511] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. machine # [ 0.053774] NR_IRQS: 33024, nr_irqs: 256, preallocated irqs: 16 machine # [ 0.054056] rcu: srcu_init: Setting srcu_struct sizes based on contention. machine # [ 0.054062] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns machine # [ 0.054155] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____) machine # [ 0.057650] Console: colour VGA+ 80x25 machine # [ 0.057653] printk: legacy console [tty0] enabled machine # [ 0.086975] printk: legacy console [ttyS0] enabled machine # [ 0.195953] ACPI: Core revision 20250807 machine # [ 0.196811] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns machine # [ 0.198419] APIC: Switch to symmetric I/O mode setup machine # [ 0.199441] x2apic enabled machine # [ 0.200248] APIC: Switched APIC routing to: physical x2apic machine # [ 0.202087] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 machine # [ 0.203128] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x22983f10a64, max_idle_ns: 440795218721 ns machine # [ 0.204912] Calibrating delay loop (skipped) preset value.. 4800.01 BogoMIPS (lpj=2400008) machine # [ 0.206938] x86/cpu: User Mode Instruction Prevention (UMIP) activated machine # [ 0.208025] Last level iTLB entries: 4KB 512, 2MB 255, 4MB 127 machine # [ 0.208910] Last level dTLB entries: 4KB 512, 2MB 255, 4MB 127, 1GB 0 machine # [ 0.209913] mitigations: Enabled attack vectors: user_kernel, user_user, guest_host, guest_guest, SMT mitigations: auto machine # [ 0.210910] Speculative Store Bypass: Mitigation: Speculative Store Bypass disabled via prctl machine # [ 0.211910] Transient Scheduler Attacks: Vulnerable: No microcode machine # [ 0.212909] Spectre V2 : Mitigation: Enhanced / Automatic IBRS machine # [ 0.214672] Speculative Return Stack Overflow: Mitigation: Safe RET machine # [ 0.215722] Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization machine # [ 0.216916] Spectre V2 : Enabling IBPB for BPF machine # [ 0.218487] Spectre V2 : mitigation: Enabling conditional Indirect Branch Prediction Barrier machine # [ 0.219910] active return thunk: srso_alias_return_thunk machine # [ 0.220922] x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers' machine # [ 0.221910] x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers' machine # [ 0.222909] x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers' machine # [ 0.223910] x86/fpu: Supporting XSAVE feature 0x020: 'AVX-512 opmask' machine # [ 0.224909] x86/fpu: Supporting XSAVE feature 0x040: 'AVX-512 Hi256' machine # [ 0.226731] x86/fpu: Supporting XSAVE feature 0x080: 'AVX-512 ZMM_Hi256' machine # [ 0.227781] x86/fpu: Supporting XSAVE feature 0x200: 'Protection Keys User registers' machine # [ 0.228910] x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256 machine # [ 0.229908] x86/fpu: xstate_offset[5]: 832, xstate_sizes[5]: 64 machine # [ 0.230909] x86/fpu: xstate_offset[6]: 896, xstate_sizes[6]: 512 machine # [ 0.231909] x86/fpu: xstate_offset[7]: 1408, xstate_sizes[7]: 1024 machine # [ 0.232909] x86/fpu: xstate_offset[9]: 2432, xstate_sizes[9]: 8 machine # [ 0.233909] x86/fpu: Enabled xstate features 0x2e7, context size is 2440 bytes, using 'compacted' format. machine # [ 0.268313] Freeing SMP alternatives memory: 48K machine # [ 0.268912] pid_max: default: 32768 minimum: 301 machine # [ 0.270024] LSM: initializing lsm=capability,landlock,yama,bpf,ima machine # [ 0.271023] landlock: Up and running. machine # [ 0.271910] Yama: becoming mindful. machine # [ 0.272750] LSM support for eBPF active machine # [ 0.273506] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear) machine # [ 0.274923] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear) machine # [ 0.277314] smpboot: CPU0: AMD EPYC 9654 96-Core Processor (family: 0x19, model: 0x11, stepping: 0x1) machine # [ 0.278508] Performance Events: Fam17h+ core perfctr, AMD PMU driver. machine # [ 0.278919] ... version: 2 machine # [ 0.279685] ... bit width: 48 machine # [ 0.279912] ... generic counters: 6 machine # [ 0.280665] ... generic bitmap: 000000000000003f machine # [ 0.280911] ... fixed-purpose counters: 0 machine # [ 0.281692] ... fixed-purpose bitmap: 0000000000000000 machine # [ 0.281912] ... value mask: 0000ffffffffffff machine # [ 0.282907] ... max period: 00007fffffffffff machine # [ 0.283807] ... global_ctrl mask: 000000000000003f machine # [ 0.284701] signal: max sigframe size: 3376 machine # [ 0.285013] rcu: Hierarchical SRCU implementation. machine # [ 0.285797] rcu: Max phase no-delay instances is 400. machine # [ 0.291042] smp: Bringing up secondary CPUs ... machine # [ 0.291799] smp: Brought up 1 node, 1 CPU machine # [ 0.292401] smpboot: Total of 1 processors activated (4800.01 BogoMIPS) machine # [ 0.293123] Memory: 940316K/1048024K available (18132K kernel code, 2734K rwdata, 13652K rodata, 3660K init, 3620K bss, 100312K reserved, 0K cma-reserved) machine # [ 0.294123] devtmpfs: initialized machine # [ 0.294939] x86/mm: Memory block size: 128MB machine # [ 0.296565] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear) machine # [ 0.296939] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear). machine # [ 0.298015] pinctrl core: initialized pinctrl subsystem machine # [ 0.299204] PM: RTC time: 02:54:31, date: 2026-10-16 machine # [ 0.302946] NET: Registered PF_NETLINK/PF_ROUTE protocol family machine # [ 0.304319] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations machine # [ 0.304933] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations machine # [ 0.306080] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations machine # [ 0.306925] audit: initializing netlink subsys (disabled) machine # [ 0.308167] thermal_sys: Registered thermal governor 'fair_share' machine # [ 0.308169] thermal_sys: Registered thermal governor 'bang_bang' machine # [ 0.308915] thermal_sys: Registered thermal governor 'step_wise' machine # [ 0.309918] audit: type=2000 audit(1792119272.060:1): state=initialized audit_enabled=0 res=1 machine # [ 0.311916] thermal_sys: Registered thermal governor 'user_space' machine # [ 0.311918] thermal_sys: Registered thermal governor 'power_allocator' machine # [ 0.312931] cpuidle: using governor menu machine # [ 0.315328] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 machine # [ 0.316141] PCI: ECAM [mem 0xb0000000-0xbfffffff] (base 0xb0000000) for domain 0000 [bus 00-ff] machine # [ 0.316916] PCI: ECAM [mem 0xb0000000-0xbfffffff] reserved as E820 entry machine # [ 0.317924] PCI: Using configuration type 1 for base access machine # [ 0.319090] kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible. machine # [ 0.324039] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages machine # [ 0.324913] HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page machine # [ 0.329913] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages machine # [ 0.330912] HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page machine # [ 0.341302] ACPI: Added _OSI(Module Device) machine # [ 0.341914] ACPI: Added _OSI(Processor Device) machine # [ 0.342726] ACPI: Added _OSI(Processor Aggregator Device) machine # [ 0.352093] ACPI: 1 ACPI AML tables successfully acquired and loaded machine # [ 0.356308] ACPI: Interpreter enabled machine # [ 0.356927] ACPI: PM: (supports S0 S3 S4 S5) machine # [ 0.357676] ACPI: Using IOAPIC for interrupt routing machine # [ 0.359964] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug machine # [ 0.360913] PCI: Using E820 reservations for host bridge windows machine # [ 0.364083] ACPI: Enabled 2 GPEs in block 00 to 3F machine # [ 0.370101] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) machine # [ 0.370921] acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] machine # [ 0.371990] acpi PNP0A08:00: _OSC: platform does not support [PCIeHotplug LTR] machine # [ 0.373034] acpi PNP0A08:00: _OSC: OS now controls [PME AER PCIeCapability] machine # [ 0.374270] PCI host bridge to bus 0000:00 machine # [ 0.374917] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] machine # [ 0.375912] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] machine # [ 0.376913] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] machine # [ 0.377912] pci_bus 0000:00: root bus resource [mem 0x40000000-0xafffffff window] machine # [ 0.378912] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window] machine # [ 0.379913] pci_bus 0000:00: root bus resource [mem 0x100000000-0x8ffffffff window] machine # [ 0.380915] pci_bus 0000:00: root bus resource [bus 00-ff] machine # [ 0.381969] pci 0000:00:00.0: [8086:29c0] type 00 class 0x060000 conventional PCI endpoint machine # [ 0.383408] pci 0000:00:01.0: [1234:1111] type 00 class 0x030000 conventional PCI endpoint machine # [ 0.386043] pci 0000:00:01.0: BAR 0 [mem 0xfd000000-0xfdffffff pref] machine # [ 0.386925] pci 0000:00:01.0: BAR 2 [mem 0xfebd0000-0xfebd0fff] machine # [ 0.387935] pci 0000:00:01.0: ROM [mem 0xfebc0000-0xfebcffff pref] machine # [ 0.389265] pci 0000:00:01.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff] machine # [ 0.390693] pci 0000:00:02.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint machine # [ 0.393935] pci 0000:00:02.0: BAR 0 [io 0xc100-0xc11f] machine # [ 0.394825] pci 0000:00:02.0: BAR 1 [mem 0xfebd1000-0xfebd1fff] machine # [ 0.395701] pci 0000:00:02.0: BAR 4 [mem 0xfe000000-0xfe003fff 64bit pref] machine # [ 0.396879] pci 0000:00:02.0: ROM [mem 0xfeb40000-0xfeb7ffff pref] machine # [ 0.398843] pci 0000:00:03.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint machine # [ 0.401855] pci 0000:00:03.0: BAR 0 [io 0xc120-0xc13f] machine # [ 0.402615] pci 0000:00:03.0: BAR 1 [mem 0xfebd2000-0xfebd2fff] machine # [ 0.402934] pci 0000:00:03.0: BAR 4 [mem 0xfe004000-0xfe007fff 64bit pref] machine # [ 0.404466] pci 0000:00:04.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint machine # [ 0.407249] pci 0000:00:04.0: BAR 0 [io 0xc000-0xc07f] machine # [ 0.408598] pci 0000:00:04.0: BAR 1 [mem 0xfebd3000-0xfebd3fff] machine # [ 0.408934] pci 0000:00:04.0: BAR 4 [mem 0xfe008000-0xfe00bfff 64bit pref] machine # [ 0.410493] pci 0000:00:05.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint machine # [ 0.412718] pci 0000:00:05.0: BAR 0 [io 0xc140-0xc15f] machine # [ 0.413559] pci 0000:00:05.0: BAR 1 [mem 0xfebd4000-0xfebd4fff] machine # [ 0.413934] pci 0000:00:05.0: BAR 4 [mem 0xfe00c000-0xfe00ffff 64bit pref] machine # [ 0.414918] pci 0000:00:05.0: ROM [mem 0xfeb80000-0xfebbffff pref] machine # [ 0.416535] pci 0000:00:06.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint machine # [ 0.417925] pci 0000:00:06.0: BAR 1 [mem 0xfebd5000-0xfebd5fff] machine # [ 0.418890] pci 0000:00:06.0: BAR 4 [mem 0xfe010000-0xfe013fff 64bit pref] machine # [ 0.420311] pci 0000:00:07.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint machine # [ 0.421925] pci 0000:00:07.0: BAR 1 [mem 0xfebd6000-0xfebd6fff] machine # [ 0.422858] pci 0000:00:07.0: BAR 4 [mem 0xfe014000-0xfe017fff 64bit pref] machine # [ 0.424304] pci 0000:00:08.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint machine # [ 0.425924] pci 0000:00:08.0: BAR 1 [mem 0xfebd7000-0xfebd7fff] machine # [ 0.426869] pci 0000:00:08.0: BAR 4 [mem 0xfe018000-0xfe01bfff 64bit pref] machine # [ 0.428305] pci 0000:00:09.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint machine # [ 0.429925] pci 0000:00:09.0: BAR 1 [mem 0xfebd8000-0xfebd8fff] machine # [ 0.430865] pci 0000:00:09.0: BAR 4 [mem 0xfe01c000-0xfe01ffff 64bit pref] machine # [ 0.432267] pci 0000:00:0a.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint machine # [ 0.434630] pci 0000:00:0a.0: BAR 0 [io 0xc080-0xc0bf] machine # [ 0.434919] pci 0000:00:0a.0: BAR 1 [mem 0xfebd9000-0xfebd9fff] machine # [ 0.435858] pci 0000:00:0a.0: BAR 4 [mem 0xfe020000-0xfe023fff 64bit pref] machine # [ 0.437290] pci 0000:00:0b.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint machine # [ 0.439928] pci 0000:00:0b.0: BAR 0 [io 0xc160-0xc17f] machine # [ 0.440759] pci 0000:00:0b.0: BAR 1 [mem 0xfebda000-0xfebdafff] machine # [ 0.441638] pci 0000:00:0b.0: BAR 4 [mem 0xfe024000-0xfe027fff 64bit pref] machine # [ 0.442494] pci 0000:00:1d.0: [8086:2934] type 00 class 0x0c0300 conventional PCI endpoint machine # [ 0.443632] pci 0000:00:1d.0: BAR 4 [io 0xc180-0xc19f] machine # [ 0.444111] pci 0000:00:1d.1: [8086:2935] type 00 class 0x0c0300 conventional PCI endpoint machine # [ 0.445637] pci 0000:00:1d.1: BAR 4 [io 0xc1a0-0xc1bf] machine # [ 0.446161] pci 0000:00:1d.2: [8086:2936] type 00 class 0x0c0300 conventional PCI endpoint machine # [ 0.447719] pci 0000:00:1d.2: BAR 4 [io 0xc1c0-0xc1df] machine # [ 0.448753] pci 0000:00:1d.7: [8086:293a] type 00 class 0x0c0320 conventional PCI endpoint machine # [ 0.450645] pci 0000:00:1d.7: BAR 0 [mem 0xfebdb000-0xfebdbfff] machine # [ 0.451149] pci 0000:00:1f.0: [8086:2918] type 00 class 0x060100 conventional PCI endpoint machine # [ 0.452215] pci 0000:00:1f.0: quirk: [io 0x0600-0x067f] claimed by ICH6 ACPI/GPIO/TCO machine # [ 0.453189] pci 0000:00:1f.2: [8086:2922] type 00 class 0x010601 conventional PCI endpoint machine # [ 0.454949] pci 0000:00:1f.2: BAR 4 [io 0xc1e0-0xc1ff] machine # [ 0.455776] pci 0000:00:1f.2: BAR 5 [mem 0xfebdc000-0xfebdcfff] machine # [ 0.456947] pci 0000:00:1f.3: [8086:2930] type 00 class 0x0c0500 conventional PCI endpoint machine # [ 0.458609] pci 0000:00:1f.3: BAR 4 [io 0x0700-0x073f] machine # [ 0.462511] ACPI: PCI: Interrupt link LNKA configured for IRQ 10 machine # [ 0.463019] ACPI: PCI: Interrupt link LNKB configured for IRQ 10 machine # [ 0.464010] ACPI: PCI: Interrupt link LNKC configured for IRQ 11 machine # [ 0.465008] ACPI: PCI: Interrupt link LNKD configured for IRQ 11 machine # [ 0.466007] ACPI: PCI: Interrupt link LNKE configured for IRQ 10 machine # [ 0.467006] ACPI: PCI: Interrupt link LNKF configured for IRQ 10 machine # [ 0.468011] ACPI: PCI: Interrupt link LNKG configured for IRQ 11 machine # [ 0.469017] ACPI: PCI: Interrupt link LNKH configured for IRQ 11 machine # [ 0.469947] ACPI: PCI: Interrupt link GSIA configured for IRQ 16 machine # [ 0.470880] ACPI: PCI: Interrupt link GSIB configured for IRQ 17 machine # [ 0.471753] ACPI: PCI: Interrupt link GSIC configured for IRQ 18 machine # [ 0.472690] ACPI: PCI: Interrupt link GSID configured for IRQ 19 machine # [ 0.473651] ACPI: PCI: Interrupt link GSIE configured for IRQ 20 machine # [ 0.473925] ACPI: PCI: Interrupt link GSIF configured for IRQ 21 machine # [ 0.474869] ACPI: PCI: Interrupt link GSIG configured for IRQ 22 machine # [ 0.475622] ACPI: PCI: Interrupt link GSIH configured for IRQ 23 machine # [ 0.476992] iommu: Default domain type: Translated machine # [ 0.477779] iommu: DMA domain TLB invalidation policy: lazy mode machine # [ 0.478876] ACPI: bus type USB registered machine # [ 0.479442] usbcore: registered new interface driver usbfs machine # [ 0.479927] usbcore: registered new interface driver hub machine # [ 0.480765] usbcore: registered new device driver usb machine # [ 0.482525] NetLabel: Initializing machine # [ 0.482913] NetLabel: domain hash size = 128 machine # [ 0.483613] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO machine # [ 0.483966] NetLabel: unlabeled traffic allowed by default machine # [ 0.484852] PCI: Using ACPI for IRQ routing machine # [ 0.530135] pci 0000:00:01.0: vgaarb: setting as boot VGA device machine # [ 0.530908] pci 0000:00:01.0: vgaarb: bridge control possible machine # [ 0.530908] pci 0000:00:01.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none machine # [ 0.530916] vgaarb: loaded machine # [ 0.531650] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 machine # [ 0.531914] hpet0: 3 comparators, 64-bit 100.000000 MHz counter machine # [ 0.534133] clocksource: Switched to clocksource kvm-clock machine # [ 0.538079] VFS: Disk quotas dquot_6.6.0 machine # [ 0.538763] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) machine # [ 0.540183] pnp: PnP ACPI init machine # [ 0.541027] ACPI: IRQ 4 override to edge(!), high(!) machine # [ 0.542012] system 00:04: [mem 0xb0000000-0xbfffffff window] has been reserved machine # [ 0.543528] pnp: PnP ACPI: found 5 devices machine # [ 0.551168] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns machine # [ 0.552576] clocksource: Switched to clocksource acpi_pm machine # [ 0.553539] NET: Registered PF_INET protocol family machine # [ 0.554575] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear) machine # [ 0.572361] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear) machine # [ 0.573906] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) machine # [ 0.575195] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear) machine # [ 0.576493] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear) machine # [ 0.577619] TCP: Hash tables configured (established 8192 bind 8192) machine # [ 0.579020] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear) machine # [ 0.580332] UDP hash table entries: 512 (order: 3, 32768 bytes, linear) machine # [ 0.581397] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear) machine # [ 0.582528] NET: Registered PF_UNIX/PF_LOCAL protocol family machine # [ 0.583472] NET: Registered PF_XDP protocol family machine # [ 0.584313] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] machine # [ 0.585281] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] machine # [ 0.586265] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] machine # [ 0.587322] pci_bus 0000:00: resource 7 [mem 0x40000000-0xafffffff window] machine # [ 0.588381] pci_bus 0000:00: resource 8 [mem 0xc0000000-0xfebfffff window] machine # [ 0.589444] pci_bus 0000:00: resource 9 [mem 0x100000000-0x8ffffffff window] machine # [ 0.591239] ACPI: \_SB_.GSIA: Enabled at IRQ 16 machine # [ 0.594271] ACPI: \_SB_.GSIB: Enabled at IRQ 17 machine # [ 0.596333] ACPI: \_SB_.GSIC: Enabled at IRQ 18 machine # [ 0.598332] ACPI: \_SB_.GSID: Enabled at IRQ 19 machine # [ 0.600278] PCI: CLS 0 bytes, default 64 machine # [ 0.601221] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x22983f10a64, max_idle_ns: 440795218721 ns machine # [ 0.603028] Trying to unpack rootfs image as initramfs... machine # [ 0.650101] Initialise system trusted keyrings machine # [ 0.653080] workingset: timestamp_bits=40 max_order=18 bucket_order=0 machine # [ 0.676915] Key type asymmetric registered machine # [ 0.677679] Asymmetric key parser 'x509' registered machine # [ 0.678592] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 248) machine # [ 0.682008] io scheduler mq-deadline registered machine # [ 0.682774] io scheduler kyber registered machine # [ 0.686699] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled machine # [ 0.688188] 00:03: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A machine # [ 0.694760] Linux agpgart interface v0.103 machine # [ 0.695564] ACPI: bus type drm_connector registered machine # [ 0.700373] usbcore: registered new interface driver usbserial_generic machine # [ 0.701559] usbserial: USB Serial support registered for generic machine # [ 0.704888] amd_pstate: The CPPC feature is supported but currently disabled by the BIOS. machine # [ 0.704888] Please enable it if your BIOS has the CPPC option. machine # [ 0.707245] amd_pstate: the _CPC object is not present in SBIOS or ACPI disabled machine # [ 0.711062] drop_monitor: Initializing network drop monitor service machine # [ 0.712309] NET: Registered PF_INET6 protocol family machine # [ 0.715475] Segment Routing with IPv6 machine # [ 0.717909] In-situ OAM (IOAM) with IPv6 machine # [ 0.719017] IPI shorthand broadcast: enabled machine # [ 0.727566] sched_clock: Marking stable (581014899, 145847134)->(801445504, -74583471) machine # [ 0.732962] registered taskstats version 1 machine # [ 0.733965] Loading compiled-in X.509 certificates machine # [ 0.752911] Demotion targets for Node 0: null machine # [ 0.753900] Key type .fscrypt registered machine # [ 0.754631] Key type fscrypt-provisioning registered machine # [ 0.755734] ima: No TPM chip found, activating TPM-bypass! machine # [ 0.758877] ima: Allocated hash algorithm: sha1 machine # [ 0.759707] ima: No architecture policies found machine # [ 0.763884] PM: Magic number: 14:327:915 machine # [ 0.765788] RAS: Correctable Errors collector initialized. machine # [ 0.776907] clk: Disabling unused clocks machine # [ 0.777576] PM: genpd: Disabling unused power domains machine # [ 0.964441] Freeing initrd memory: 29792K machine # [ 0.967632] Freeing unused decrypted memory: 2028K machine # [ 0.970404] Freeing unused kernel image (initmem) memory: 3660K machine # [ 0.971521] Write protecting the kernel read-only data: 32768k machine # [ 0.972887] Freeing unused kernel image (text/rodata gap) memory: 296K machine # [ 0.974437] Freeing unused kernel image (rodata/data gap) memory: 684K machine # [ 1.025193] x86/mm: Checked W+X mappings: passed, no W+X pages found. machine # [ 1.026400] Run /init as init process machine # [ 1.038008] systemd[1]: Inserted module 'autofs4' machine # [ 1.057631] fuse: init (API version 7.45) machine # [ 1.065012] ACPI: \_SB_.GSIG: Enabled at IRQ 22 machine # [ 1.067777] ACPI: \_SB_.GSIH: Enabled at IRQ 23 machine # [ 1.071835] ACPI: \_SB_.GSIE: Enabled at IRQ 20 machine # [ 1.074401] ACPI: \_SB_.GSIF: Enabled at IRQ 21 machine # [ 1.079506] virtiofs virtio5: discovered new tag: nix-store machine # [ 1.081170] virtiofs virtio5: virtio_fs_setup_dax: No cache capability machine # [ 1.088436] virtiofs virtio6: discovered new tag: shared machine # [ 1.090008] virtiofs virtio6: virtio_fs_setup_dax: No cache capability machine # [ 1.093230] virtiofs virtio7: discovered new tag: xchg machine # [ 1.094654] virtiofs virtio7: virtio_fs_setup_dax: No cache capability machine # [ 1.115790] systemd[1]: Successfully made /usr/ read-only. machine # [ 1.117601] systemd[1]: systemd 263-78a159b running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE +EXPERIMENTAL-ENVVAR) machine # [ 1.123119] systemd[1]: Detected virtualization kvm. machine # [ 1.124057] systemd[1]: Detected architecture x86-64. machine # [ 1.125040] systemd[1]: Running in initrd. machine # [ 1.126053] systemd[1]: Initializing machine ID from random generator. machine # [ 1.127297] systemd[1]: Hostname set to . machine # [ 1.201953] systemd[1]: bpf-restrict-fs: LSM BPF program attached machine # [ 1.238499] systemd[1]: Queued start job for default target Initrd Default Target. machine # [ 1.243290] systemd[1]: Created slice Slice /system/modprobe. machine # [ 1.244504] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. machine # [ 1.246028] systemd[1]: Expecting device /dev/disk/by-label/nixos... machine # [ 1.247218] systemd[1]: Reached target Path Units. machine # [ 1.248196] systemd[1]: Reached target Slice Units. machine # [ 1.249147] systemd[1]: Reached target Swaps. machine # [ 1.249999] systemd[1]: Reached target Timer Units. machine # [ 1.251035] systemd[1]: Listening on D-Bus System Message Bus Socket. machine # [ 1.252353] systemd[1]: Listening on Journal Socket (/dev/log). machine # [ 1.253589] systemd[1]: Listening on Journal Sockets. machine # [ 1.254642] systemd[1]: Listening on udev Kernel Socket. machine # [ 1.255657] systemd[1]: Reached target Socket Units. machine # [ 1.257588] systemd[1]: Starting Create List of Static Device Nodes... machine # [ 1.261715] systemd[1]: Starting Load Kernel Module configfs... machine # [ 1.268543] systemd[1]: Starting Journal Service... machine # [ 1.282956] systemd[1]: Starting Load Kernel Modules... machine # [ 1.297254] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 1.307145] systemd[1]: Starting Coldplug All udev Devices... machine # [ 1.323944] systemd[1]: Finished Create List of Static Device Nodes. machine # [ 1.329616] systemd[1]: modprobe@configfs.service: Deactivated successfully. machine # [ 1.335785] systemd-journald[65]: Collecting audit messages is disabled. machine # [ 1.337426] systemd[1]: Finished Load Kernel Module configfs. machine # [ 1.342304] systemd[1]: Kernel Configuration File System skipped, unmet condition check ConditionPathExists=/sys/kernel/config machine # [ 1.354936] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... machine # [ 1.360495] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. machine # [ 1.372027] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev machine # [ 1.400440] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. machine # [ 1.409071] systemd[1]: Starting Create Static Device Nodes in /dev... machine # [ 1.420413] systemd[1]: Finished Load Kernel Modules. machine # [ 1.428553] systemd[1]: Starting Apply Kernel Variables... machine # [ 1.449165] systemd[1]: Finished Create Static Device Nodes in /dev. machine # [ 1.455078] systemd[1]: Reached target Preparation for Local File Systems. machine # [ 1.310736] systemd-modules-load[66]: Inserted module 'dm_mod' machine # [ 1.313305] systemd-modules-load[66]: Inserted module 'virtio_balloon' machine # [ 1.314388] systemd-modules-load[66]: Inserted module 'virtio_gpu' machine # [ 1.462562] systemd[1]: Reached target Local File Systems. machine # [ 1.468305] systemd[1]: Starting Rule-based Manager for Device Events and Files... machine # [ 1.475153] systemd[1]: Started Journal Service. machine # [ 1.336270] systemd[1]: Finished Apply Kernel Variables. machine # [ 1.346275] systemd[1]: Starting Create System Files and Directories... machine # [ 1.376546] systemd[1]: Finished Create System Files and Directories. machine # [ 1.383852] systemd-udevd[73]: Using default interface naming scheme 'v261'. machine # [ 1.408210] systemd[1]: Started Rule-based Manager for Device Events and Files. machine # [ 1.459869] systemd[1]: Finished Coldplug All udev Devices. machine # [ 1.462372] systemd[1]: Reached target System Initialization. machine # [ 1.463817] systemd[1]: Reached target Basic System. machine # [ 1.743888] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 machine # [ 1.753557] serio: i8042 KBD port at 0x60,0x64 irq 1 machine # [ 1.756369] virtio_blk virtio2: 1/0/0 default/read/poll queues machine # [ 1.762908] serio: i8042 AUX port at 0x60,0x64 irq 12 machine # [ 1.768010] virtio_blk virtio2: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) machine # [ 1.783542] ehci-pci 0000:00:1d.7: EHCI Host Controller machine # [ 1.784540] ehci-pci 0000:00:1d.7: new USB bus registered, assigned bus number 1 machine # [ 1.786288] ehci-pci 0000:00:1d.7: irq 19, io mem 0xfebdb000 machine # [ 1.792888] ehci-pci 0000:00:1d.7: USB 2.0 started, EHCI 1.00 machine # [ 1.794092] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 6.18 machine # [ 1.795836] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 machine # [ 1.796938] usb usb1: Product: EHCI Host Controller machine # [ 1.797576] usb usb1: Manufacturer: Linux 6.18.56 ehci_hcd machine # [ 1.801135] usb usb1: SerialNumber: 0000:00:1d.7 machine # [ 1.802202] hub 1-0:1.0: USB hub found machine # [ 1.804869] hub 1-0:1.0: 6 ports detected machine # [ 1.814332] uhci_hcd 0000:00:1d.0: UHCI Host Controller machine # [ 1.815138] uhci_hcd 0000:00:1d.0: new USB bus registered, assigned bus number 2 machine # [ 1.828411] uhci_hcd 0000:00:1d.0: detected 2 ports machine # [ 1.834139] uhci_hcd 0000:00:1d.0: irq 16, io port 0x0000c180 machine # [ 1.842894] usb usb2: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.18 machine # [ 1.844046] usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=1 machine # [ 1.854809] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input0 machine # [ 1.719210] systemd[1]: Starting Virtual Console Setup... machine # [ 1.871124] usb usb2: Product: UHCI Host Controller machine # [ 1.880144] usb usb2: Manufacturer: Linux 6.18.56 uhci_hcd machine # [ 1.741319] (udev-worker)[90]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. machine # [ 1.745294] (udev-worker)[90]: Network interface NamePolicy= disabled on kernel command line. machine # [ 1.901325] usb usb2: SerialNumber: 0000:00:1d.0 machine # [ 1.758320] systemd-vconsole-setup[96]: Configuration of first virtual console was skipped, ignoring remaining ones. machine # [ 1.761663] systemd[1]: Finished Virtual Console Setup. machine # [ 1.913512] hub 2-0:1.0: USB hub found machine # [ 1.916459] SCSI subsystem initialized machine # [ 1.920273] hub 2-0:1.0: 2 ports detected machine # [ 1.926065] uhci_hcd 0000:00:1d.1: UHCI Host Controller machine # [ 1.926763] uhci_hcd 0000:00:1d.1: new USB bus registered, assigned bus number 3 machine # [ 1.786931] systemd[1]: Found device /dev/disk/by-label/nixos. machine # [ 1.788913] systemd[1]: Reached target Initrd Root Device. machine # [ 1.794076] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos... machine # [ 1.941911] uhci_hcd 0000:00:1d.1: detected 2 ports machine # [ 1.942670] uhci_hcd 0000:00:1d.1: irq 17, io port 0x0000c1a0 machine # [ 1.947017] usb usb3: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.18 machine # [ 1.953899] usb usb3: New USB device strings: Mfr=3, Product=2, SerialNumber=1 machine # [ 1.955999] usb usb3: Product: UHCI Host Controller machine # [ 1.956672] usb usb3: Manufacturer: Linux 6.18.56 uhci_hcd machine # [ 1.962808] usb usb3: SerialNumber: 0000:00:1d.1 machine # [ 1.963940] hub 3-0:1.0: USB hub found machine # [ 1.964665] hub 3-0:1.0: 2 ports detected machine # [ 1.969192] uhci_hcd 0000:00:1d.2: UHCI Host Controller machine # [ 1.970917] uhci_hcd 0000:00:1d.2: new USB bus registered, assigned bus number 4 machine # [ 1.973959] uhci_hcd 0000:00:1d.2: detected 2 ports machine # [ 1.974708] uhci_hcd 0000:00:1d.2: irq 18, io port 0x0000c1c0 machine # [ 1.978145] usb usb4: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.18 machine # [ 1.981176] usb usb4: New USB device strings: Mfr=3, Product=2, SerialNumber=1 machine # [ 1.985961] usb usb4: Product: UHCI Host Controller machine # [ 1.986771] usb usb4: Manufacturer: Linux 6.18.56 uhci_hcd machine # [ 1.843344] systemd-fsck[103]: nixos: clean, 12/65536 files, 13019/262144 blocks machine # [ 1.990502] usb usb4: SerialNumber: 0000:00:1d.2 machine # [ 1.993165] hub 4-0:1.0: USB hub found machine # [ 1.850700] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos. machine # [ 1.998818] hub 4-0:1.0: 2 ports detected machine # [ 2.035978] ahci 0000:00:1f.2: AHCI vers 0001.0000, 32 command slots, 1.5 Gbps, SATA mode machine # [ 2.037226] ahci 0000:00:1f.2: 6/6 ports implemented (port mask 0x3f) machine # [ 2.039837] ahci 0000:00:1f.2: flags: 64bit ncq only machine # [ 2.040884] usb 1-1: new high-speed USB device number 2 using ehci-pci machine # [ 2.043721] scsi host0: ahci machine # [ 2.045284] scsi host1: ahci machine # [ 2.046652] scsi host2: ahci machine # [ 2.047813] scsi host3: ahci machine # [ 2.049447] scsi host4: ahci machine # [ 2.050777] scsi host5: ahci machine # [ 2.051999] ata1: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc100 irq 47 lpm-pol 1 machine # [ 2.053262] ata2: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc180 irq 47 lpm-pol 1 machine # [ 2.054520] ata3: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc200 irq 47 lpm-pol 1 machine # [ 2.055740] ata4: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc280 irq 47 lpm-pol 1 machine # [ 2.056925] ata5: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc300 irq 47 lpm-pol 1 machine # [ 2.058117] ata6: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc380 irq 47 lpm-pol 1 machine # [ 2.170944] usb 1-1: New USB device found, idVendor=0627, idProduct=0001, bcdDevice= 0.00 machine # [ 2.173730] usb 1-1: New USB device strings: Mfr=1, Product=3, SerialNumber=10 machine # [ 2.176945] usb 1-1: Product: QEMU USB Tablet machine # [ 2.178664] usb 1-1: Manufacturer: QEMU machine # [ 2.180342] usb 1-1: SerialNumber: 28754-0000:00:1d.7-1 machine # [ 2.213993] hid: raw HID events driver (C) Jiri Kosina machine # [ 2.171629] systemd[1]: Mounting /sysroot... machine # [ 2.368408] ata1: SATA link down (SStatus 0 SControl 300) machine # [ 2.370219] ata2: SATA link down (SStatus 0 SControl 300) machine # [ 2.372696] ata6: SATA link down (SStatus 0 SControl 300) machine # [ 2.375070] ata5: SATA link down (SStatus 0 SControl 300) machine # [ 2.377296] ata4: SATA link down (SStatus 0 SControl 300) machine # [ 2.379645] ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 300) machine # [ 2.382245] ata3.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/100 machine # [ 2.384550] ata3.00: applying bridge limits machine # [ 2.386384] ata3.00: configured for UDMA/100 machine # [ 2.388392] scsi 2:0:0:0: CD-ROM QEMU QEMU DVD-ROM 2.5+ PQ: 0 ANSI: 5 machine # [ 2.451352] usbcore: registered new interface driver usbhid machine # [ 2.456874] usbhid: USB HID core driver machine # [ 2.467799] 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.473004] sr 2:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray machine # [ 2.474028] 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.486953] cdrom: Uniform CD-ROM driver Revision: 3.20 machine # [ 2.668343] EXT4-fs (vda): mounted filesystem 37788586-ec57-47ab-a659-733cac9c1e29 r/w with ordered data mode. Quota mode: none. machine # [ 2.529305] systemd[1]: Mounted /sysroot. machine # [ 2.532775] systemd[1]: Reached target Initrd Root File System. machine # [ 2.537771] systemd[1]: Mounting /sysroot/nix/.ro-store... machine # [ 2.544315] systemd[1]: Mounting /sysroot/nix/.rw-store... machine # [ 2.553255] systemd[1]: Mounting /sysroot/run... machine # [ 2.561277] systemd[1]: Mounting /sysroot/tmp/shared... machine # [ 2.568399] systemd[1]: Mounting /sysroot/tmp/xchg... machine # [ 2.573160] systemd[1]: Starting Mountpoints Configured in the Real Root... machine # [ 2.600166] systemd-sysroot-fstab-check[147]: /sysroot should be mounted in the initrd, will request daemon-reload. machine # [ 2.611740] systemd[1]: Mounted /sysroot/nix/.ro-store. machine # [ 2.614319] systemd[1]: Mounted /sysroot/nix/.rw-store. machine # [ 2.616630] systemd[1]: Mounted /sysroot/run. machine # [ 2.618148] systemd[1]: Mounted /sysroot/tmp/shared. machine # [ 2.618856] systemd[1]: Mounted /sysroot/tmp/xchg. machine # [ 2.621068] systemd[1]: Reload requested from client PID 147 ('systemd-sysroot') (unit initrd-parse-etc.service)... machine # [ 2.622542] systemd[1]: Reloading... machine # [ 2.679482] systemd[1]: Reloading finished in 58 ms. machine # [ 2.689255] systemd-sysroot-fstab-check[147]: Requesting initrd-fs.target/start/replace... machine # [ 2.694134] systemd-sysroot-fstab-check[147]: Requesting swap.target/start/replace... machine # [ 2.697103] systemd[1]: Starting rw-sysroot-nix-store.service... machine # [ 2.701417] systemd[1]: initrd-parse-etc.service: Deactivated successfully. machine # [ 2.702862] systemd[1]: Finished Mountpoints Configured in the Real Root. machine # [ 2.703896] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies. machine # [ 2.713964] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. machine # [ 2.715446] systemd[1]: Finished rw-sysroot-nix-store.service. machine # [ 3.171165] systemd[1]: Mounting /sysroot/nix/store... machine # [ 3.220983] systemd[1]: Mounted /sysroot/nix/store. machine # [ 3.222479] systemd[1]: Reached target Initrd File Systems. machine # [ 3.224310] systemd[1]: Starting Find NixOS closure... machine # [ 3.227148] systemd[1]: Starting Create Volatile Files and Directories in the Real Root... machine # [ 3.248308] systemd[1]: Finished Create Volatile Files and Directories in the Real Root. machine # [ 3.252393] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully. machine # [ 3.258682] systemd[1]: Finished Find NixOS closure. machine # [ 3.260184] systemd[1]: Reached target Initrd Default Target. machine # [ 3.261658] systemd[1]: Starting Cleaning Up and Shutting Down Daemons... machine # [ 3.276325] systemd[1]: Stopped target Initrd Default Target. machine # [ 3.277335] systemd[1]: Stopped target Basic System. machine # [ 3.278271] systemd[1]: Stopped target Initrd Root Device. machine # [ 3.280178] systemd[1]: Stopped target Path Units. machine # [ 3.280875] systemd[1]: systemd-ask-password-console.path: Deactivated successfully. machine # [ 3.281912] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch. machine # [ 3.282952] systemd[1]: Stopped target Slice Units. machine # [ 3.283678] systemd[1]: Stopped target Socket Units. machine # [ 3.284426] systemd[1]: Stopped target System Initialization. machine # [ 3.285285] systemd[1]: Stopped target Swaps. machine # [ 3.286164] systemd[1]: Stopped target Timer Units. machine # [ 3.287115] systemd[1]: dbus.socket: Deactivated successfully. machine # [ 3.288905] systemd[1]: Closed D-Bus System Message Bus Socket. machine # [ 3.289791] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully. machine # [ 3.290913] systemd[1]: Stopped Find NixOS closure. machine # [ 3.292200] systemd[1]: Starting rw-sysroot-nix-store.service... machine # [ 3.293080] systemd[1]: systemd-sysctl.service: Deactivated successfully. machine # [ 3.295109] systemd[1]: Stopped Apply Kernel Variables. machine # [ 3.296096] systemd[1]: systemd-modules-load.service: Deactivated successfully. machine # [ 3.297376] systemd[1]: Stopped Load Kernel Modules. machine # [ 3.298348] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully. machine # [ 3.299609] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root. machine # [ 3.300848] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. machine # [ 3.302117] systemd[1]: Stopped Create System Files and Directories. machine # [ 3.303101] systemd[1]: Stopped target Local File Systems. machine # [ 3.305216] systemd[1]: Stopped target Preparation for Local File Systems. machine # [ 3.306273] systemd[1]: systemd-udev-trigger.service: Deactivated successfully. machine # [ 3.307486] systemd[1]: Stopped Coldplug All udev Devices. machine # [ 3.308744] systemd[1]: Stopping Rule-based Manager for Device Events and Files... machine # [ 3.311153] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. machine # [ 3.312138] systemd[1]: Stopped Virtual Console Setup. machine # [ 3.319643] systemd[1]: initrd-cleanup.service: Deactivated successfully. machine # [ 3.323130] systemd[1]: Finished Cleaning Up and Shutting Down Daemons. machine # [ 3.328818] systemd[1]: systemd-udevd.service: Deactivated successfully. machine # [ 3.329899] systemd[1]: Stopped Rule-based Manager for Device Events and Files. machine # [ 3.335145] systemd[1]: Starting Cleanup udev Database... machine # [ 3.335898] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. machine # [ 3.336980] systemd[1]: Stopped Create Static Device Nodes in /dev. machine # [ 3.337846] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. machine # [ 3.339118] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully. machine # [ 3.341135] systemd[1]: kmod-static-nodes.service: Deactivated successfully. machine # [ 3.342073] systemd[1]: Stopped Create List of Static Device Nodes. machine # [ 3.343325] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. machine # [ 3.345101] systemd[1]: Finished rw-sysroot-nix-store.service. machine # [ 3.361324] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. machine # [ 3.362874] systemd[1]: Finished Cleanup udev Database. machine # [ 3.364416] systemd[1]: Reached target Switch Root. machine # [ 3.366164] systemd[1]: Starting NixOS Activation... machine # [ 3.438363] initrd-nixos-activation-start[194]: booting system configuration /nix/store/18jsxirzz9yhwgfqrm1ha69kkxv7fbqn-nixos-system-machine-test machine # [ 3.471503] initrd-nixos-activation-start[194]: running activation script... machine # [ 3.661439] initrd-nixos-activation-start[217]: setting up /etc... machine # [ 3.766110] systemd[1]: initrd-nixos-activation.service: Deactivated successfully. machine # [ 3.768071] systemd[1]: Finished NixOS Activation. machine # [ 3.769693] systemd[1]: Starting Switch Root... machine # [ 3.786629] systemd[1]: Switching root. machine # [ 4.061946] systemd-journald[65]: Received SIGTERM from PID 1 (systemd). machine # [ 4.136055] NET: Registered PF_VSOCK protocol family machine # [ 4.161418] systemd[1]: systemd 263-78a159b running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE +EXPERIMENTAL-ENVVAR) machine # [ 4.165592] systemd[1]: Detected virtualization kvm. machine # [ 4.166324] systemd[1]: Detected architecture x86-64. machine # [ 4.167091] systemd[1]: Detected first boot. machine # [ 4.168711] systemd[1]: Initializing machine ID from random generator. machine # [ 4.271366] systemd[1]: bpf-restrict-fs: LSM BPF program attached machine # [ 4.369267] systemd[1]: Applying preset policy. machine # [ 4.541814] systemd[1]: Populated /etc with preset unit settings. machine # [ 4.689891] systemd[1]: initrd-switch-root.service: Deactivated successfully. machine # [ 4.691188] systemd[1]: Stopped initrd-switch-root.service. machine # [ 4.693258] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. machine # [ 4.695343] systemd[1]: Created slice Slice /system/getty. machine # [ 4.696688] systemd[1]: Created slice User and Session Slice. machine # [ 4.697593] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. machine # [ 4.698750] systemd[1]: Started Forward Password Requests to Wall Directory Watch. machine # [ 4.700436] systemd[1]: Expecting device /dev/hvc0... machine # [ 4.701260] systemd[1]: Expecting device /dev/ttyS0... machine # [ 4.702081] systemd[1]: Reached target Local Encrypted Volumes. machine # [ 4.702964] systemd[1]: Stopped target initrd-fs.target. machine # [ 4.703709] systemd[1]: Stopped target initrd-root-fs.target. machine # [ 4.704502] systemd[1]: Stopped target initrd-switch-root.target. machine # [ 4.705399] systemd[1]: Reached target Virtual Machines and Containers. machine # [ 4.706350] systemd[1]: Reached target Path Units. machine # [ 4.707099] systemd[1]: Reached target Remote File Systems. machine # [ 4.707863] systemd[1]: Reached target Slice Units. machine # [ 4.708557] systemd[1]: Reached target Swaps. machine # [ 4.710564] systemd[1]: Listening on Query the User Interactively for a Password. machine # [ 4.724634] systemd[1]: Listening on Process Core Dump Socket. machine # [ 4.726291] systemd[1]: Listening on Credential Encryption/Decryption. machine # [ 4.727992] systemd[1]: Listening on Factory Reset Management. machine # [ 4.728896] systemd[1]: Listening on Hostname Service Socket. machine # [ 4.732206] systemd[1]: Starting Journal Log Access Socket... machine # [ 4.733421] systemd[1]: Listening on Journal Audit Socket. machine # [ 4.739035] systemd[1]: Listening on Console Output Muting Service Socket. machine # [ 4.740515] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket. machine # [ 4.741651] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 4.742993] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 4.746721] systemd[1]: Listening on Disk Repartitioning Service Socket. machine # [ 4.747793] systemd[1]: Listening on udev Varlink Socket. machine # [ 4.750199] systemd[1]: Mounting Huge Pages File System... machine # [ 4.753099] systemd[1]: Mounting POSIX Message Queue File System... machine # [ 4.759937] systemd[1]: Mounting Kernel Debug File System... machine # [ 4.767490] systemd[1]: Mounting Kernel Trace File System... machine # [ 4.776422] systemd[1]: Starting Create List of Static Device Nodes... machine # [ 4.785941] systemd[1]: Starting Load Kernel Module configfs... machine # [ 4.786765] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm machine # [ 4.800644] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 4.812186] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse machine # [ 4.830497] systemd[1]: Mounting FUSE Control File System... machine # [ 4.833098] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 4.845972] systemd[1]: Starting Journal Service... machine # [ 4.855346] systemd[1]: Starting Load Kernel Modules... machine # [ 4.866874] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer... machine # [ 4.878182] systemd[1]: Starting Remount Root and Kernel File Systems... machine # [ 4.883995] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 4.892131] systemd[1]: Starting Coldplug All udev Devices... machine # [ 4.903735] systemd[1]: Listening on Journal Log Access Socket. machine # [ 4.912160] systemd[1]: Mounted Huge Pages File System. machine # [ 4.913865] systemd-journald[288]: Collecting audit messages is enabled. machine # [ 4.914927] systemd[1]: Mounted POSIX Message Queue File System. machine # [ 4.918777] systemd[1]: Mounted Kernel Debug File System. machine # [ 4.923059] systemd[1]: Mounted Kernel Trace File System. machine # [ 4.935374] systemd[1]: Finished Create List of Static Device Nodes. machine # [ 4.798892] systemd[1]: Queued start job for default target Multi-User System. machine # [ 4.948562] systemd[1]: Started Journal Service. machine # [ 4.804819] systemd[1]: Unnecessary job was removed for /sys/devices/virtual/tty/hvc0. machine # [ 4.807215] systemd[1]: Unnecessary job was removed for /sys/devices/pnp0/00:03/00:03:0/00:03:0.0/tty/ttyS0. machine # [ 4.954715] loop: module loaded machine # [ 4.809760] systemd[1]: systemd-journald.service: Deactivated successfully. machine # [ 4.813048] systemd[1]: modprobe@configfs.service: Deactivated successfully. machine # [ 4.814585] systemd-modules-load[289]: Inserted module 'loop' machine # [ 4.816317] systemd[1]: Finished Load Kernel Module configfs. machine # [ 4.832299] systemd[1]: Mounted FUSE Control File System. machine # [ 4.833866] systemd[1]: Finished Load Kernel Modules. machine # [ 4.987927] EXT4-fs (vda): re-mounted 37788586-ec57-47ab-a659-733cac9c1e29. machine # [ 4.848086] systemd[1]: Mounting Kernel Configuration File System... machine # [ 4.851781] systemd[1]: Starting Firewall... machine # [ 4.859115] systemd[1]: Starting Apply Kernel Variables... machine # [ 4.871065] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... machine # [ 4.883714] systemd[1]: Finished Remount Root and Kernel File Systems. machine # [ 4.893981] systemd-oomd[290]: No swap; memory pressure usage will be degraded machine # [ 4.899528] systemd[1]: Listening on Disk Image Download Service Socket. machine # [ 4.908531] systemd[1]: Starting Flush Journal to Persistent Storage... machine # [ 4.911079] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 4.922383] systemd[1]: Starting Load/Save OS Random Seed... machine # [ 4.923311] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 4.932162] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer. machine # [ 4.993899] systemd[1]: Mounted Kernel Configuration File System. machine # [ 5.146709] systemd-journald[288]: Received client request to flush runtime journal. machine # [ 5.097583] systemd[1]: Finished Load/Save OS Random Seed. machine # [ 5.101457] systemd[1]: Reached target First Boot Complete. machine # [ 5.103754] systemd[1]: Finished Apply Kernel Variables. machine # [ 5.104740] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. machine # [ 5.106324] systemd[1]: Starting Create Static Device Nodes in /dev... machine # [ 5.111164] systemd[1]: Finished Flush Journal to Persistent Storage. machine # [ 5.193608] systemd[1]: Finished Coldplug All udev Devices. machine # [ 5.212459] systemd[1]: Finished Create Static Device Nodes in /dev. machine # [ 5.213746] systemd[1]: Reached target Preparation for Local File Systems. machine # [ 5.217211] systemd[1]: Starting Rule-based Manager for Device Events and Files... machine # [ 5.261983] systemd-udevd[330]: Using default interface naming scheme 'v261'. machine # [ 5.306198] systemd[1]: Started Rule-based Manager for Device Events and Files. machine # [ 5.371136] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse machine # [ 5.445879] systemd[1]: Condition check resulted in /dev/hvc0 being skipped. machine # [ 5.475539] systemd[1]: Condition check resulted in /dev/ttyS0 being skipped. machine # [ 5.495101] (udev-worker)[349]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. machine # [ 5.497187] (udev-worker)[349]: Network interface NamePolicy= disabled on kernel command line. machine # [ 5.549754] systemd[1]: Mounting /run/wrappers... machine # [ 5.590965] systemd[1]: Mounted /run/wrappers. machine # [ 5.592514] systemd[1]: Reached target Local File Systems. machine # [ 5.595311] systemd[1]: Listening on Boot Loader Control Service Socket. machine # [ 5.600444] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 5.603036] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 5.607091] systemd[1]: Starting Save Transient machine-id to Disk... machine # [ 5.614110] systemd[1]: Starting Create System Files and Directories... machine # [ 5.633333] systemd[1]: Condition check resulted in Virtio network device being skipped. machine # [ 5.634534] systemd[1]: Condition check resulted in Virtio network device being skipped. machine # [ 5.637240] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 5.638655] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 5.641265] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 5.643247] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 5.644683] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 5.645880] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 5.738857] systemd[1]: etc-machine\x2did.mount: Deactivated successfully. machine # [ 5.747172] systemd[1]: Finished Save Transient machine-id to Disk. machine # [ 5.755239] systemd[1]: Finished Create System Files and Directories. machine # [ 5.765087] systemd[1]: Starting Rebuild Journal Catalog... machine # [ 5.772070] systemd[1]: Starting Record System Boot/Shutdown in UTMP... machine # [ 5.853370] systemd[1]: Finished Record System Boot/Shutdown in UTMP. machine # [ 5.884420] systemd[1]: Finished Rebuild Journal Catalog. machine # [ 5.891496] systemd[1]: Starting Update is Completed... machine # [ 6.084096] mousedev: PS/2 mouse device common for all mice machine # [ 5.947710] systemd[1]: Finished Update is Completed. machine # [ 6.109369] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input3 machine # [ 6.137498] bochs-drm 0000:00:01.0: vgaarb: deactivate vga console machine # [ 6.143912] ACPI: button: Power Button [PWRF] machine # [ 6.099435] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 6.103242] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 6.105242] systemd[1]: Reached target System Initialization. machine # [ 6.108170] systemd[1]: Started Discard unused filesystem blocks once a week. machine # [ 6.109203] systemd[1]: Started Daily Cleanup of Temporary Directories. machine # [ 6.111156] systemd[1]: Reached target Timer Units. machine # [ 6.111860] systemd[1]: Listening on D-Bus System Message Bus Socket. machine # [ 6.113160] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket. machine # [ 6.115203] systemd[1]: Reached target Socket Units. machine # [ 6.115928] systemd[1]: Reached target Basic System. machine # [ 6.122095] systemd[1]: Started backdoor.service. machine # [ 6.125120] systemd[1]: Starting Import lastlog data into lastlog2 database... machine # [ 6.127704] systemd[1]: Starting Name Service Cache Daemon (nsncd)... machine # [ 6.137954] systemd[1]: Starting Post-Boot Actions... machine # [ 6.246966] rtc_cmos PNP0B00:00: RTC can wake from S4 machine # [ 6.281740] parport_pc 00:02: reported by Plug and Play ACPI machine # [ 6.287777] rtc_cmos PNP0B00:00: registered as rtc0 machine # [ 6.288628] rtc_cmos PNP0B00:00: setting system clock to 2026-10-16T02:54:37 UTC (1792119277) machine # [ 6.275771] systemd[1]: Started Reset console on configuration changes. machine # [ 6.288761] rtc_cmos PNP0B00:00: alarms up to one day, y3k, 242 bytes nvram, hpet irqs machine # [ 6.289103] systemd-journald[288]: Time jumped backwards, rotating. machine # [ 6.280221] systemd[1]: Starting resolvconf update... machine # [ 6.282804] systemd[1]: Starting D-Bus System Message Bus... machine # [ 6.286073] systemd[1]: Finished Firewall. machine # [ 6.286931] systemd[1]: Finished Post-Boot Actions. machine # connecting to host... machine # [ 6.314518] nsncd[492]: Oct 16 02:54:37.671 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" machine # [ 6.318267] systemd[1]: Started Name Service Cache Daemon (nsncd). machine # [ 6.321542] systemd[1]: Reached target Host and Network Name Lookups. machine # [ 6.322894] systemd[1]: Reached target User and Group Name Lookups. machine # [ 6.317071] input: QEMU Virtio Keyboard as /devices/pci0000:00/0000:00:06.0/virtio4/input/input4 machine # [ 6.327558] parport0: PC-style at 0x378, irq 7 [PCSPP(,...)] machine: Guest shell says: b'Spawning backdoor root shell...\n' machine # [ 6.351874] systemd[1]: Starting User Login Management... machine: connected to guest root shell machine: (connecting took 7.02 seconds) machine: (finished: waiting for the VM to finish booting, in 7.33 seconds) machine # [ 6.342483] Console: switching to colour dummy device 80x25 machine # [ 6.466286] lpc_ich 0000:00:1f.0: I/O space for GPIO uninitialized machine # [ 6.538720] [drm] Found bochs VGA, ID 0xb0c5. machine # [ 6.538722] [drm] Framebuffer size 16384 kB @ 0xfd000000, mmio @ 0xfebd0000. machine # [ 6.409788] systemd[1]: Finished Import lastlog data into lastlog2 database. machine # [ 6.448373] dbus-broker-launch[504]: Looking up NSS user entry for 'systemd-timesync'... machine # [ 6.618477] bochs-drm 0000:00:01.0: [drm] Registered 1 planes with drm panic machine # [ 6.638320] [drm] Initialized bochs-drm 1.0.0 for 0000:00:01.0 on minor 0 machine # [ 6.500993] systemd-logind[526]: New seat seat0. machine # [ 6.570222] systemd[1]: Started User Login Management. machine # [ 6.581684] dbus-broker-launch[504]: NSS returned no entry for 'systemd-timesync' machine # [ 6.582779] dbus-broker-launch[504]: Invalid user-name in /nix/store/1fg2nsz5b3fs2bmiqn8b2fr6qmmz25v6-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" machine # [ 6.589075] systemd[1]: Stopped target Host and Network Name Lookups. machine # [ 6.589944] systemd[1]: Stopping Host and Network Name Lookups... machine # [ 6.590786] systemd[1]: Stopped target User and Group Name Lookups. machine # [ 6.591727] systemd[1]: Stopping User and Group Name Lookups... machine # [ 6.595713] systemd-logind[526]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard) machine # [ 6.602691] systemd[1]: Starting linger-users.service... machine # [ 6.603560] systemd[1]: Stopping Name Service Cache Daemon (nsncd)... machine # [ 6.610362] systemd[1]: Starting Virtual Console Setup... machine # [ 6.614076] systemd[1]: nscd.service: Deactivated successfully. machine # [ 6.620936] systemd[1]: Stopped Name Service Cache Daemon (nsncd). machine # [ 6.641154] systemd[1]: Started D-Bus System Message Bus. machine # [ 6.675917] i801_smbus 0000:00:1f.3: SMBus using PCI interrupt machine # [ 6.676073] i2c i2c-0: Memory type 0x07 not supported yet, not instantiating SPD machine # [ 6.698008] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input6 machine # [ 6.665646] systemd-logind[526]: Watching system buttons on /dev/input/event2 (Power Button) machine # [ 6.667024] dbus-broker-launch[504]: Ready machine # [ 6.706657] systemd[1]: Starting Name Service Cache Daemon (nsncd)... machine # [ 6.698316] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input5 machine # [ 6.765318] Console: switching to colour frame buffer device 160x50 machine # [ 6.876603] bochs-drm 0000:00:01.0: [drm] fb0: bochs-drmdrmfb frame buffer device machine # [ 6.744724] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. machine # [ 6.750107] systemd[1]: Stopped Virtual Console Setup. machine # [ 6.768997] systemd[1]: Starting Virtual Console Setup... machine # [ 6.781735] nsncd[592]: Oct 16 02:54:38.138 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" machine # [ 6.795301] systemd[1]: Started Name Service Cache Daemon (nsncd). machine # [ 6.799646] systemd[1]: Finished resolvconf update. machine # [ 6.826964] systemd[1]: Created slice Slice /user/1001. machine # [ 6.827765] systemd[1]: Reached target Preparation for Network. machine # [ 6.828616] systemd[1]: Reached target Host and Network Name Lookups. machine # [ 6.829504] systemd[1]: Reached target User and Group Name Lookups. machine # [ 6.830368] systemd[1]: Starting DHCP Client... machine # [ 6.981557] ppdev: user-space parallel port driver machine # [ 6.848075] systemd[1]: Starting Address configuration of eth1... machine # [ 6.848936] systemd[1]: Starting Extra networking commands.... machine # [ 6.849737] systemd[1]: Starting User Runtime Directory /run/user/1001... machine # [ 6.865786] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 6.872170] systemd[1]: Finished linger-users.service. machine # [ 6.889709] systemd-logind[526]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard) machine # [ 7.063052] iTCO_wdt iTCO_wdt.1.auto: Found a ICH9 TCO device (Version=2, TCOBASE=0x0660) machine # [ 6.931139] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. machine # [ 6.932200] systemd[1]: Stopped Virtual Console Setup. machine # [ 7.083916] iTCO_wdt iTCO_wdt.1.auto: initialized. heartbeat=30 sec (nowayout=0) machine # [ 6.940344] systemd[1]: Starting Virtual Console Setup... machine # [ 6.981096] systemd[1]: Finished User Runtime Directory /run/user/1001. machine # [ 6.983305] systemd[1]: Starting User Manager for UID 1001... machine # [ 7.036597] (systemd)[629]: pam_unix(systemd-user:session): session opened for user usertest(uid=1001) by (uid=0) machine # [ 7.047330] systemd-logind[526]: New session '1' of user 'usertest' with class 'manager' and type 'unspecified'. machine # [ 7.085829] systemd[629]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 7.201420] network-addresses-eth1-start[616]: adding address 192.168.1.1/24... done machine # [ 7.245140] network-addresses-eth1-start[616]: adding address 2001:db8:1::1/64... done machine # [ 7.290176] systemd[1]: Finished Address configuration of eth1. machine # [ 7.293370] systemd[629]: Queued start job for default target Main User Target. machine # [ 7.309117] systemd[629]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 7.310666] systemd[629]: Created slice User Application Slice. machine # [ 7.311624] systemd[629]: Started Daily Cleanup of User's Temporary Directories. machine # [ 7.312641] systemd[629]: Reached target Paths. machine # [ 7.315311] systemd[629]: Reached target Timers. machine # [ 7.315991] systemd[629]: Starting D-Bus User Message Bus Socket... machine # [ 7.318460] systemd[629]: Starting Create User Files and Directories... machine # [ 7.356308] systemd[629]: Finished Create User Files and Directories. machine # [ 7.518410] kvm_amd: TSC scaling supported machine # [ 7.518893] kvm_amd: Nested Virtualization enabled machine # [ 7.519354] kvm_amd: Nested Paging enabled machine # [ 7.519729] kvm_amd: LBR virtualization supported machine # [ 7.521685] kvm_amd: Virtual VMLOAD VMSAVE supported machine # [ 7.522491] kvm_amd: Virtual GIF supported machine # [ 7.529321] kvm_amd: Virtual NMI enabled machine # [ 7.387106] systemd[629]: Listening on D-Bus User Message Bus Socket. machine # [ 7.388555] systemd[629]: Reached target Sockets. machine # [ 7.389328] systemd[629]: Reached target Basic System. machine # [ 7.396059] systemd[1]: Started User Manager for UID 1001. machine # [ 7.396906] systemd[629]: Starting Run user-specific NixOS activation... machine # [ 7.437905] systemd[629]: Finished Run user-specific NixOS activation. machine # [ 7.440086] systemd[629]: Reached target Main User Target. machine # [ 7.442435] systemd[629]: Startup finished in 369ms. machine # [ 7.445662] dhcpcd[640]: dhcpcd-10.3.2 starting machine # [ 7.453310] dhcpcd[703]: dev: loaded udev machine # [ 7.608362] EDAC MC: Ver: 3.0.0 machine # [ 7.469332] systemd[1]: Finished Extra networking commands.. machine # [ 7.470257] systemd[1]: Reached target Network. machine # [ 7.474494] systemd[1]: Starting Permit User Sessions... machine # [ 7.628546] 8021q: 802.1Q VLAN Support v1.8 machine # [ 7.630114] 8021q: adding VLAN 0 to HW filter on device eth1 machine # [ 7.518842] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch. machine # [ 7.540762] systemd[1]: Finished Permit User Sessions. machine # [ 7.547718] systemd[1]: Started Getty on tty1. machine # [ 7.549239] systemd[1]: Reached target Login Prompts. machine # [ 7.726618] cfg80211: Loading compiled-in X.509 certificates for regulatory database machine # [ 7.740351] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' machine # [ 7.741114] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600' machine # [ 7.743104] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -2 machine # [ 7.743978] cfg80211: failed to load regulatory.db machine # [ 7.776572] 8021q: adding VLAN 0 to HW filter on device eth0 machine # [ 7.632102] dhcpcd[703]: eth0: waiting for carrier machine # [ 7.632862] dhcpcd[703]: eth0: carrier acquired machine # [ 7.638337] dhcpcd[703]: DUID 00:01:00:01:32:64:4e:6e:52:54:00:12:34:56 machine # [ 7.639463] dhcpcd[703]: eth0: IAID 00:12:34:56 machine # [ 7.640296] dhcpcd[703]: eth0: adding address fe80::5054:ff:fe12:3456 machine # [ 7.660742] systemd-vconsole-setup[625]: Configuration of first virtual console was skipped, ignoring remaining ones. machine # [ 7.665089] systemd[1]: Finished Virtual Console Setup. machine # [ 9.078981] dhcpcd[703]: eth0: soliciting a DHCP lease machine # [ 9.243709] NET: Registered PF_PACKET protocol family machine # [ 9.105950] dhcpcd[703]: eth0: offered 10.0.2.15 from 10.0.2.2 machine # [ 9.108352] dhcpcd[703]: eth0: probing address 10.0.2.15/24 machine # [ 9.278800] dhcpcd[703]: eth0: soliciting an IPv6 router machine # [ 9.281582] dhcpcd[703]: eth0: Router Advertisement from fe80::2 machine # [ 9.284292] dhcpcd[703]: eth0: adding address fec0::5054:ff:fe12:3456/64 machine # [ 9.286877] dhcpcd[703]: eth0: adding route to fec0::/64 machine # [ 9.288975] dhcpcd[703]: eth0: adding default route via fe80::2 machine # [ 14.544780] dhcpcd[703]: eth0: leased 10.0.2.15 for 86400 seconds machine # [ 14.548345] dhcpcd[703]: eth0: adding route to 10.0.2.0/24 machine # [ 14.550720] dhcpcd[703]: eth0: adding default route via 10.0.2.2 machine # [ 14.634703] systemd[1]: Started DHCP Client. machine # [ 14.636826] systemd[1]: Reached target Multi-User System. machine # [ 14.637912] systemd[1]: Startup finished in 884ms (kernel) + 3.078s (initrd) + 10.674s (userspace) = 14.637s. machine: (finished: waiting for unit multi-user.target, in 16.16 seconds) machine: must succeed: /nix/store/3vbcjh6yz1i6lp352svzp92f3jmjppg7-stderr-runner /nix/store/18jsxirzz9yhwgfqrm1ha69kkxv7fbqn-nixos-system-machine-test/bin/switch-to-configuration test machine # Checking switch inhibitors... done machine # [ 15.396447] nixos[857]: switching to system configuration /nix/store/18jsxirzz9yhwgfqrm1ha69kkxv7fbqn-nixos-system-machine-test machine # [ 15.398674] systemd[1]: Stopped target Remote File Systems. machine # [ 15.400438] systemd[1]: Stopped target Local File Systems. machine # activating the configuration... machine # setting up /etc... machine # [ 15.625704] systemd[1]: Reload requested from client PID 857 ('.switch-to-conf') (unit backdoor.service)... machine # [ 15.627413] systemd[1]: Reloading... machine # [ 15.872033] systemd[1]: Reloading finished in 242 ms. machine # reloading user units for usertest... machine # [ 15.902425] systemd[629]: Created slice User Core Session Slice. machine # [ 15.904756] systemd[629]: Starting D-Bus User Message Bus... machine # [ 15.926950] dbus-broker-launch[927]: Ignoring duplicate name 'org.freedesktop.import1' in service file '/nix/store/1fg2nsz5b3fs2bmiqn8b2fr6qmmz25v6-system-path/share/dbus-1/services/org.freedesktop.import1.service' machine # [ 15.929770] dbus-broker-launch[927]: Ignoring duplicate name 'org.freedesktop.machine1' in service file '/nix/store/1fg2nsz5b3fs2bmiqn8b2fr6qmmz25v6-system-path/share/dbus-1/services/org.freedesktop.machine1.service' machine # [ 15.932416] dbus-broker-launch[927]: Ignoring duplicate name 'org.freedesktop.portable1' in service file '/nix/store/1fg2nsz5b3fs2bmiqn8b2fr6qmmz25v6-system-path/share/dbus-1/services/org.freedesktop.portable1.service' machine # [ 15.934917] dbus-broker-launch[927]: Ignoring duplicate name 'org.freedesktop.systemd1' in service file '/nix/store/1fg2nsz5b3fs2bmiqn8b2fr6qmmz25v6-system-path/share/dbus-1/services/org.freedesktop.systemd1.service' machine # [ 15.937615] dbus-broker-launch[927]: Policy to allow eavesdropping in /etc/dbus-1/session.conf +27: Eavesdropping is deprecated and ignored machine # [ 15.939236] dbus-broker-launch[927]: Policy to allow eavesdropping in /etc/dbus-1/session.conf +29: Eavesdropping is deprecated and ignored machine # [ 15.941191] systemd[629]: Started D-Bus User Message Bus. machine # [ 15.944575] dbus-broker-launch[927]: Ready machine # [ 15.990509] systemd[629]: Reexecution requested from client PID 926 ('switch-to-confi')... machine # [ 15.992760] systemd[629]: Reexecuting. machine # [ 16.012507] systemd[629]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 16.085060] systemd[629]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 16.090705] systemd[629]: Reload requested from client PID 926 ('switch-to-confi')... machine # [ 16.091908] systemd[629]: Reloading... machine # [ 16.162853] systemd[629]: Reloading finished in 69 ms. machine # [ 16.168842] systemd[629]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # restarting the following user units: nixos-activation.service machine # [ 16.175718] systemd[629]: Stopped Run user-specific NixOS activation. machine # [ 16.176729] systemd[629]: Stopping Run user-specific NixOS activation... machine # [ 16.179200] systemd[629]: Starting Run user-specific NixOS activation... machine # [ 16.201373] systemd[629]: Finished Run user-specific NixOS activation. machine # restarting sysinit-reactivation.target machine # [ 16.209691] systemd[1]: Starting Re-setup tmpfiles on a system that is already running.... machine # [ 16.279941] systemd[1]: Finished Re-setup tmpfiles on a system that is already running.. machine # [ 16.281768] systemd[1]: Reached target Reactivate sysinit units. machine # [ 16.285727] systemd[1]: Reached target Remote File Systems. machine # [ 16.288826] systemd[1]: Starting linger-users.service... machine # [ 16.294491] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 16.295946] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 16.299280] systemd[1]: Reached target Local File Systems. machine # [ 16.301872] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 16.307330] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 16.309225] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 16.311299] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 16.314632] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 16.317368] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 16.319146] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 16.356747] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 16.358893] systemd[1]: Finished linger-users.service. machine # [ 16.471554] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 16.473369] systemd[1]: Finished Create SUID/SGID Wrappers. machine # the following new units were started: sysinit-reactivation.target, systemd-tmpfiles-resetup.service machine # [ 16.735885] nixos[857]: finished switching to system configuration /nix/store/18jsxirzz9yhwgfqrm1ha69kkxv7fbqn-nixos-system-machine-test machine: (finished: must succeed: /nix/store/3vbcjh6yz1i6lp352svzp92f3jmjppg7-stderr-runner /nix/store/18jsxirzz9yhwgfqrm1ha69kkxv7fbqn-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/3vbcjh6yz1i6lp352svzp92f3jmjppg7-stderr-runner /nix/store/4rl8hsp29bgksxzgydj6j6ks3hskk6ic-nixos-system-other-test/bin/switch-to-configuration test machine # this should succeed (config: /nix/store/4rl8hsp29bgksxzgydj6j6ks3hskk6ic-nixos-system-other-test, action: test) machine # Checking switch inhibitors... done machine # [ 17.002504] nixos[1004]: switching to system configuration /nix/store/4rl8hsp29bgksxzgydj6j6ks3hskk6ic-nixos-system-other-test machine # [ 17.004964] systemd[1]: Stopped target Remote File Systems. machine # [ 17.006568] systemd[1]: Stopped target Local File Systems. machine # activating the configuration... machine # removing user ‘usertest’ machine # setting up /etc... machine # [ 17.245256] systemd[1]: Reload requested from client PID 1004 ('.switch-to-conf') (unit backdoor.service)... machine # [ 17.246866] systemd[1]: Reloading... machine # [ 17.477298] systemd[1]: Reloading finished in 228 ms. machine # reloading user units for usertest... machine # [ 17.545910] systemd[629]: Reexecution requested from client PID 1076 ('switch-to-confi')... machine # [ 17.548674] systemd[629]: Reexecuting. machine # [ 17.570379] systemd[629]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 17.645882] systemd[629]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 17.651940] systemd[629]: Reload requested from client PID 1076 ('switch-to-confi')... machine # [ 17.653697] systemd[629]: Reloading... machine # [ 17.726637] systemd[629]: Reloading finished in 71 ms. machine # [ 17.731905] systemd[629]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # restarting the following user units: nixos-activation.service machine # [ 17.739771] systemd[629]: Stopped Run user-specific NixOS activation. machine # [ 17.741216] systemd[629]: Stopping Run user-specific NixOS activation... machine # [ 17.743193] systemd[629]: Starting Run user-specific NixOS activation... machine # [ 17.765663] systemd[629]: Finished Run user-specific NixOS activation. machine # restarting sysinit-reactivation.target machine # [ 17.769401] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 17.770652] systemd[1]: Stopping Reactivate sysinit units... machine # [ 17.771727] systemd[1]: Reached target Reactivate sysinit units. machine # reloading the following units: dbus-broker.service machine # [ 17.774616] dbus-broker-launch[504]: Caught SIGHUP, trigger reload. machine # [ 17.776388] systemd[1]: Reloading D-Bus System Message Bus... machine # [ 17.781477] dbus-broker-launch[504]: Looking up NSS user entry for 'systemd-timesync'... machine # [ 17.783359] dbus-broker-launch[504]: NSS returned no entry for 'systemd-timesync' machine # [ 17.784332] dbus-broker-launch[504]: Invalid user-name in /nix/store/ryfxrhgwhahvrzcy4gycp13darf5639i-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" machine # [ 17.794617] systemd[1]: Reloaded D-Bus System Message Bus. machine # restarting the following units: network-addresses-eth1.service machine # [ 17.799703] systemd[1]: Stopping Address configuration of eth1... machine # [ 17.819209] network-addresses-eth1-pre-stop[1088]: deleting address 192.168.1.1/24... done machine # [ 17.824462] network-addresses-eth1-pre-stop[1088]: deleting address 2001:db8:1::1/64... done machine # [ 17.829626] systemd[1]: network-addresses-eth1.service: Deactivated successfully. machine # [ 17.831214] systemd[1]: Stopped Address configuration of eth1. machine # [ 17.834647] systemd[1]: Starting Address configuration of eth1... machine # [ 17.862935] network-addresses-eth1-start[1093]: adding address 192.168.1.2/24... done machine # [ 17.868577] network-addresses-eth1-start[1093]: adding address 2001:db8:1::2/64... done machine # [ 17.875750] systemd[1]: Finished Address configuration of eth1. machine # [ 17.878399] systemd[1]: Reached target Local File Systems. machine # [ 17.882403] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 17.886352] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 17.887789] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 17.889096] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 17.891148] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 17.892548] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 17.893710] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 17.898259] systemd[1]: Reached target Remote File Systems. machine # [ 17.902686] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 17.904299] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 18.051339] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 18.053070] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 18.056731] systemd[1]: Starting linger-users.service... machine # [ 18.076322] linger-users-start[1165]: id: ‘usertest’: no such user machine # [ 18.077887] linger-users-start[1163]: Removing linger for missing user usertest machine # [ 18.082655] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 18.084195] systemd[1]: Finished linger-users.service. machine # [ 18.341655] nixos[1004]: finished switching to system configuration /nix/store/4rl8hsp29bgksxzgydj6j6ks3hskk6ic-nixos-system-other-test machine: (finished: must succeed: /nix/store/3vbcjh6yz1i6lp352svzp92f3jmjppg7-stderr-runner /nix/store/4rl8hsp29bgksxzgydj6j6ks3hskk6ic-nixos-system-other-test/bin/switch-to-configuration test, in 1.58 seconds) subtest: services machine: must succeed: /nix/store/18jsxirzz9yhwgfqrm1ha69kkxv7fbqn-nixos-system-machine-test/bin/switch-to-configuration test 2>&1 machine # [ 18.542912] nixos[1171]: switching to system configuration /nix/store/18jsxirzz9yhwgfqrm1ha69kkxv7fbqn-nixos-system-machine-test machine # [ 18.545333] systemd[1]: Stopped target Remote File Systems. machine # [ 18.546778] systemd[1]: Stopped target Local File Systems. machine # [ 18.778595] systemd[1]: Reload requested from client PID 1171 ('.switch-to-conf') (unit backdoor.service)... machine # [ 18.780415] systemd[1]: Reloading... machine # [ 19.027856] systemd[1]: Reloading finished in 246 ms. machine # [ 19.091841] systemd[629]: Reexecution requested from client PID 1240 ('switch-to-confi')... machine # [ 19.094429] systemd[629]: Reexecuting. machine # [ 19.118083] systemd[629]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 19.188505] systemd[629]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 19.193722] systemd[629]: Reload requested from client PID 1240 ('switch-to-confi')... machine # [ 19.195215] systemd[629]: Reloading... machine # [ 19.267823] systemd[629]: Reloading finished in 71 ms. machine # [ 19.273868] systemd[629]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 19.280256] systemd[629]: Stopped Run user-specific NixOS activation. machine # [ 19.281852] systemd[629]: Stopping Run user-specific NixOS activation... machine # [ 19.284097] systemd[629]: Starting Run user-specific NixOS activation... machine # [ 19.306324] systemd[629]: Finished Run user-specific NixOS activation. machine # [ 19.309613] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 19.311209] systemd[1]: Stopping Reactivate sysinit units... machine # [ 19.311939] systemd[1]: Reached target Reactivate sysinit units. machine # [ 19.315605] dbus-broker-launch[504]: Caught SIGHUP, trigger reload. machine # [ 19.316819] systemd[1]: Reloading D-Bus System Message Bus... machine # [ 19.319749] dbus-broker-launch[504]: Looking up NSS user entry for 'systemd-timesync'... machine # [ 19.321574] dbus-broker-launch[504]: NSS returned no entry for 'systemd-timesync' machine # [ 19.322594] dbus-broker-launch[504]: Invalid user-name in /nix/store/1fg2nsz5b3fs2bmiqn8b2fr6qmmz25v6-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" machine # [ 19.331790] systemd[1]: Reloaded D-Bus System Message Bus. machine # [ 19.335902] systemd[1]: Stopping Address configuration of eth1... machine # [ 19.355322] network-addresses-eth1-pre-stop[1252]: deleting address 192.168.1.2/24... done machine # [ 19.360348] network-addresses-eth1-pre-stop[1252]: deleting address 2001:db8:1::2/64... done machine # [ 19.365455] systemd[1]: network-addresses-eth1.service: Deactivated successfully. machine # [ 19.366987] systemd[1]: Stopped Address configuration of eth1. machine # [ 19.370224] systemd[1]: Starting Address configuration of eth1... machine # [ 19.400356] network-addresses-eth1-start[1257]: adding address 192.168.1.1/24... done machine # [ 19.405712] network-addresses-eth1-start[1257]: adding address 2001:db8:1::1/64... done machine # [ 19.413064] systemd[1]: Finished Address configuration of eth1. machine # [ 19.417436] systemd[1]: Reached target Remote File Systems. machine # [ 19.420548] systemd[1]: Starting linger-users.service... machine # [ 19.425176] systemd[1]: Reached target Local File Systems. machine # [ 19.429806] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 19.431178] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 19.436711] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 19.441263] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 19.442884] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 19.444118] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 19.446270] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 19.447725] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 19.448940] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 19.475571] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 19.477369] systemd[1]: Finished linger-users.service. machine # [ 19.590337] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 19.592052] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 19.850659] nixos[1171]: finished switching to system configuration /nix/store/18jsxirzz9yhwgfqrm1ha69kkxv7fbqn-nixos-system-machine-test machine: (finished: must succeed: /nix/store/18jsxirzz9yhwgfqrm1ha69kkxv7fbqn-nixos-system-machine-test/bin/switch-to-configuration test 2>&1, in 1.51 seconds) machine: must succeed: /nix/store/18jsxirzz9yhwgfqrm1ha69kkxv7fbqn-nixos-system-machine-test/bin/switch-to-configuration test 2>&1 machine # [ 20.065580] nixos[1326]: switching to system configuration /nix/store/18jsxirzz9yhwgfqrm1ha69kkxv7fbqn-nixos-system-machine-test machine # [ 20.067881] systemd[1]: Stopped target Remote File Systems. machine # [ 20.069545] systemd[1]: Stopped target Local File Systems. machine # [ 20.282450] systemd[1]: Reload requested from client PID 1326 ('.switch-to-conf') (unit backdoor.service)... machine # [ 20.284183] systemd[1]: Reloading... machine # [ 20.526940] systemd[1]: Reloading finished in 240 ms. machine # [ 20.602415] systemd[629]: Reexecution requested from client PID 1395 ('switch-to-confi')... machine # [ 20.603736] systemd[629]: Reexecuting. machine # [ 20.623203] systemd[629]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 20.695432] systemd[629]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 20.700788] systemd[629]: Reload requested from client PID 1395 ('switch-to-confi')... machine # [ 20.703294] systemd[629]: Reloading... machine # [ 20.773928] systemd[629]: Reloading finished in 71 ms. machine # [ 20.779884] systemd[629]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 20.786276] systemd[629]: Stopped Run user-specific NixOS activation. machine # [ 20.787377] systemd[629]: Stopping Run user-specific NixOS activation... machine # [ 20.789914] systemd[629]: Starting Run user-specific NixOS activation... machine # [ 20.811318] systemd[629]: Finished Run user-specific NixOS activation. machine # [ 20.814626] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 20.815937] systemd[1]: Stopping Reactivate sysinit units... machine # [ 20.816987] systemd[1]: Reached target Reactivate sysinit units. machine # [ 20.820087] systemd[1]: Reached target Local File Systems. machine # [ 20.822645] systemd[1]: Reached target Remote File Systems. machine # [ 20.825817] systemd[1]: Starting linger-users.service... machine # [ 20.830553] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 20.832201] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 20.838341] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 20.844644] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 20.845478] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 20.846699] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 20.848788] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 20.854111] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 20.855660] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 20.890901] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 20.893052] systemd[1]: Finished linger-users.service. machine # [ 21.004311] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 21.007091] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 21.261191] nixos[1326]: finished switching to system configuration /nix/store/18jsxirzz9yhwgfqrm1ha69kkxv7fbqn-nixos-system-machine-test machine: (finished: must succeed: /nix/store/18jsxirzz9yhwgfqrm1ha69kkxv7fbqn-nixos-system-machine-test/bin/switch-to-configuration test 2>&1, in 1.41 seconds) machine: must succeed: /nix/store/18jsxirzz9yhwgfqrm1ha69kkxv7fbqn-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration test 2>&1 machine # [ 21.472976] nixos[1467]: switching to system configuration /nix/store/fgrqssl9x6wvq9scn30jnmp5a691ily6-nixos-system-machine-test machine # [ 21.475232] systemd[1]: Stopped target Remote File Systems. machine # [ 21.476855] systemd[1]: Stopped target Local File Systems. machine # [ 21.695345] systemd[1]: Reload requested from client PID 1467 ('.switch-to-conf') (unit backdoor.service)... machine # [ 21.697080] systemd[1]: Reloading... machine # [ 21.949983] systemd[1]: Reloading finished in 251 ms. machine # [ 22.011487] systemd[629]: Reexecution requested from client PID 1536 ('switch-to-confi')... machine # [ 22.012729] systemd[629]: Reexecuting. machine # [ 22.033158] systemd[629]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 22.105798] systemd[629]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 22.111158] systemd[629]: Reload requested from client PID 1536 ('switch-to-confi')... machine # [ 22.112928] systemd[629]: Reloading... machine # [ 22.184442] systemd[629]: Reloading finished in 70 ms. machine # [ 22.188876] systemd[629]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 22.195166] systemd[629]: Stopped Run user-specific NixOS activation. machine # [ 22.196116] systemd[629]: Stopping Run user-specific NixOS activation... machine # [ 22.198809] systemd[629]: Starting Run user-specific NixOS activation... machine # [ 22.219601] systemd[629]: Finished Run user-specific NixOS activation. machine # [ 22.222813] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 22.224217] systemd[1]: Stopping Reactivate sysinit units... machine # [ 22.224983] systemd[1]: Reached target Reactivate sysinit units. machine # [ 22.229871] systemd[1]: Reached target Local File Systems. machine # [ 22.232255] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 22.234507] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 22.236350] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 22.238070] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 22.240101] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 22.241524] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 22.242690] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 22.247603] systemd[1]: Reached target Remote File Systems. machine # [ 22.251693] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 22.254137] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 22.386918] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 22.388789] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 22.393484] systemd[1]: Starting linger-users.service... machine # [ 22.395967] systemd[1]: Starting test.service... machine # [ 22.419129] systemd[1]: Finished test.service. machine # [ 22.435507] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 22.436953] systemd[1]: Finished linger-users.service. machine # [ 22.695422] nixos[1467]: finished switching to system configuration /nix/store/fgrqssl9x6wvq9scn30jnmp5a691ily6-nixos-system-machine-test machine: (finished: must succeed: /nix/store/18jsxirzz9yhwgfqrm1ha69kkxv7fbqn-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration test 2>&1, in 1.44 seconds) machine: must succeed: /nix/store/18jsxirzz9yhwgfqrm1ha69kkxv7fbqn-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration test 2>&1 machine # [ 22.908979] nixos[1609]: switching to system configuration /nix/store/fgrqssl9x6wvq9scn30jnmp5a691ily6-nixos-system-machine-test machine # [ 22.912835] systemd[1]: Stopped target Local File Systems. machine # [ 22.914229] systemd[1]: Stopped target Remote File Systems. machine # [ 23.125304] systemd[1]: Reload requested from client PID 1609 ('.switch-to-conf') (unit backdoor.service)... machine # [ 23.126982] systemd[1]: Reloading... machine # [ 23.372908] systemd[1]: Reloading finished in 244 ms. machine # [ 23.431854] systemd[629]: Reexecution requested from client PID 1678 ('switch-to-confi')... machine # [ 23.434392] systemd[629]: Reexecuting. machine # [ 23.455215] systemd[629]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 23.526250] systemd[629]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 23.531680] systemd[629]: Reload requested from client PID 1678 ('switch-to-confi')... machine # [ 23.532959] systemd[629]: Reloading... machine # [ 23.625545] systemd[629]: Reloading finished in 91 ms. machine # [ 23.629827] systemd[629]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 23.636232] systemd[629]: Stopped Run user-specific NixOS activation. machine # [ 23.637166] systemd[629]: Stopping Run user-specific NixOS activation... machine # [ 23.639311] systemd[629]: Starting Run user-specific NixOS activation... machine # [ 23.661142] systemd[629]: Finished Run user-specific NixOS activation. machine # [ 23.664516] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 23.665581] systemd[1]: Stopping Reactivate sysinit units... machine # [ 23.666587] systemd[1]: Reached target Reactivate sysinit units. machine # [ 23.669300] systemd[1]: Reached target Local File Systems. machine # [ 23.671907] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 23.673606] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 23.676929] systemd[1]: Reached target Remote File Systems. machine # [ 23.679902] systemd[1]: Starting linger-users.service... machine # [ 23.688755] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 23.692908] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 23.693785] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 23.694971] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 23.697027] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 23.700375] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 23.703132] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 23.738848] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 23.740930] systemd[1]: Finished linger-users.service. machine # [ 23.848985] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 23.851374] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 24.108769] nixos[1609]: finished switching to system configuration /nix/store/fgrqssl9x6wvq9scn30jnmp5a691ily6-nixos-system-machine-test machine: (finished: must succeed: /nix/store/18jsxirzz9yhwgfqrm1ha69kkxv7fbqn-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration test 2>&1, in 1.41 seconds) machine: must succeed: /nix/store/18jsxirzz9yhwgfqrm1ha69kkxv7fbqn-nixos-system-machine-test/specialisation/simpleServiceDifferentDescription/bin/switch-to-configuration test 2>&1 machine # [ 24.342345] nixos[1750]: switching to system configuration /nix/store/0b11anp3lgqlb6vmj5m2dzcqdakx931n-nixos-system-machine-test machine # [ 24.346136] systemd[1]: Stopped target Remote File Systems. machine # [ 24.346870] systemd[1]: Stopped target Local File Systems. machine # [ 24.572335] systemd[1]: Reload requested from client PID 1750 ('.switch-to-conf') (unit backdoor.service)... machine # [ 24.574086] systemd[1]: Reloading... machine # [ 25.034140] systemd[1]: Reloading finished in 458 ms. machine # [ 25.095454] systemd[629]: Reexecution requested from client PID 1819 ('switch-to-confi')... machine # [ 25.096843] systemd[629]: Reexecuting. machine # [ 25.116370] systemd[629]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 25.185776] systemd[629]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 25.191696] systemd[629]: Reload requested from client PID 1819 ('switch-to-confi')... machine # [ 25.193111] systemd[629]: Reloading... machine # [ 25.266278] systemd[629]: Reloading finished in 71 ms. machine # [ 25.271828] systemd[629]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 25.278848] systemd[629]: Stopped Run user-specific NixOS activation. machine # [ 25.279709] systemd[629]: Stopping Run user-specific NixOS activation... machine # [ 25.281236] systemd[629]: Starting Run user-specific NixOS activation... machine # [ 25.300293] systemd[629]: Finished Run user-specific NixOS activation. machine # [ 25.303383] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 25.304651] systemd[1]: Stopping Reactivate sysinit units... machine # [ 25.305697] systemd[1]: Reached target Reactivate sysinit units. machine # [ 25.310061] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 25.311792] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 25.314431] systemd[1]: Reached target Local File Systems. machine # [ 25.315994] systemd[1]: Reached target Remote File Systems. machine # [ 25.321712] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 25.325805] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 25.327092] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 25.328302] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 25.330318] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 25.331770] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 25.332934] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 25.462351] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 25.465204] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 25.468759] systemd[1]: Starting linger-users.service... machine # [ 25.496349] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 25.497841] systemd[1]: Finished linger-users.service. machine # [ 25.755529] nixos[1750]: finished switching to system configuration /nix/store/0b11anp3lgqlb6vmj5m2dzcqdakx931n-nixos-system-machine-test machine: (finished: must succeed: /nix/store/18jsxirzz9yhwgfqrm1ha69kkxv7fbqn-nixos-system-machine-test/specialisation/simpleServiceDifferentDescription/bin/switch-to-configuration test 2>&1, in 1.65 seconds) machine: must succeed: /nix/store/18jsxirzz9yhwgfqrm1ha69kkxv7fbqn-nixos-system-machine-test/specialisation/simpleServiceModified/bin/switch-to-configuration test 2>&1 machine # [ 25.984860] nixos[1890]: switching to system configuration /nix/store/i83dx9wqn8s2cpy0p0izf0bk0ki1p994-nixos-system-machine-test machine # [ 25.987252] systemd[1]: Stopped target Remote File Systems. machine # [ 25.989364] systemd[1]: test.service: Deactivated successfully. machine # [ 25.990313] systemd[1]: Stopped Test unit. machine # [ 25.991410] systemd[1]: Stopped target Local File Systems. machine # [ 26.224351] systemd[1]: Reload requested from client PID 1890 ('.switch-to-conf') (unit backdoor.service)... machine # [ 26.226281] systemd[1]: Reloading... machine # [ 26.480381] systemd[1]: Reloading finished in 252 ms. machine # [ 26.543591] systemd[629]: Reexecution requested from client PID 1959 ('switch-to-confi')... machine # [ 26.545393] systemd[629]: Reexecuting. machine # [ 26.564310] systemd[629]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 26.641097] systemd[629]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 26.647294] systemd[629]: Reload requested from client PID 1959 ('switch-to-confi')... machine # [ 26.648880] systemd[629]: Reloading... machine # [ 26.721874] systemd[629]: Reloading finished in 71 ms. machine # [ 26.726875] systemd[629]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 26.733414] systemd[629]: Stopped Run user-specific NixOS activation. machine # [ 26.735064] systemd[629]: Stopping Run user-specific NixOS activation... machine # [ 26.737094] systemd[629]: Starting Run user-specific NixOS activation... machine # [ 26.762624] systemd[629]: Finished Run user-specific NixOS activation. machine # [ 26.766367] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 26.767704] systemd[1]: Stopping Reactivate sysinit units... machine # [ 26.768832] systemd[1]: Reached target Reactivate sysinit units. machine # [ 26.771818] systemd[1]: Reached target Remote File Systems. machine # [ 26.775138] systemd[1]: Starting linger-users.service... machine # [ 26.779117] systemd[1]: Starting test.service... machine # [ 26.790849] systemd[1]: Reached target Local File Systems. machine # [ 26.794797] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 26.796918] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 26.801307] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 26.805422] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 26.807321] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 26.809247] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 26.812860] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 26.817684] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 26.818897] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 26.851186] systemd[1]: Finished test.service. machine # [ 26.883570] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 26.886724] systemd[1]: Finished linger-users.service. machine # [ 26.999320] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 27.001177] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 27.259424] nixos[1890]: finished switching to system configuration /nix/store/i83dx9wqn8s2cpy0p0izf0bk0ki1p994-nixos-system-machine-test machine: (finished: must succeed: /nix/store/18jsxirzz9yhwgfqrm1ha69kkxv7fbqn-nixos-system-machine-test/specialisation/simpleServiceModified/bin/switch-to-configuration test 2>&1, in 1.50 seconds) machine: must succeed: /nix/store/18jsxirzz9yhwgfqrm1ha69kkxv7fbqn-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1 machine # [ 27.489060] nixos[2033]: switching to system configuration /nix/store/8131w7sc2qqkqf77a82bfd6svi0ph4l0-nixos-system-machine-test machine # [ 27.492708] systemd[1]: Stopped target Remote File Systems. machine # [ 27.493602] systemd[1]: Stopped target Local File Systems. machine # [ 27.719303] systemd[1]: Reload requested from client PID 2033 ('.switch-to-conf') (unit backdoor.service)... machine # [ 27.720970] systemd[1]: Reloading... machine # [ 27.968738] systemd[1]: Reloading finished in 245 ms. machine # [ 28.029843] systemd[629]: Reexecution requested from client PID 2102 ('switch-to-confi')... machine # [ 28.032792] systemd[629]: Reexecuting. machine # [ 28.053277] systemd[629]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 28.125864] systemd[629]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 28.131994] systemd[629]: Reload requested from client PID 2102 ('switch-to-confi')... machine # [ 28.133254] systemd[629]: Reloading... machine # [ 28.206182] systemd[629]: Reloading finished in 71 ms. machine # [ 28.211888] systemd[629]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 28.219075] systemd[629]: Stopped Run user-specific NixOS activation. machine # [ 28.219912] systemd[629]: Stopping Run user-specific NixOS activation... machine # [ 28.221846] systemd[629]: Starting Run user-specific NixOS activation... machine # [ 28.244072] systemd[629]: Finished Run user-specific NixOS activation. machine # [ 28.247307] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 28.248602] systemd[1]: Stopping Reactivate sysinit units... machine # [ 28.249651] systemd[1]: Reached target Reactivate sysinit units. machine # [ 28.251468] systemd[1]: test.service: Deactivated successfully. machine # [ 28.253134] systemd[1]: Stopped test.service. machine # [ 28.253725] systemd[1]: Stopping test.service... machine # [ 28.255769] systemd[1]: Starting test.service... machine # [ 28.270838] systemd[1]: Finished test.service. machine # [ 28.273763] systemd[1]: Reached target Remote File Systems. machine # [ 28.276657] systemd[1]: Starting linger-users.service... machine # [ 28.282630] systemd[1]: Reached target Local File Systems. machine # [ 28.287116] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 28.291115] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 28.291991] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 28.293445] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 28.295462] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 28.296848] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 28.300099] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 28.307199] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 28.309114] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 28.345037] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 28.346221] systemd[1]: Finished linger-users.service. machine # [ 28.455842] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 28.457668] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 28.716402] nixos[2033]: finished switching to system configuration /nix/store/8131w7sc2qqkqf77a82bfd6svi0ph4l0-nixos-system-machine-test machine: (finished: must succeed: /nix/store/18jsxirzz9yhwgfqrm1ha69kkxv7fbqn-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1, in 1.46 seconds) machine: must succeed: /nix/store/18jsxirzz9yhwgfqrm1ha69kkxv7fbqn-nixos-system-machine-test/specialisation/simpleServiceReload/bin/switch-to-configuration test 2>&1 machine # [ 28.954139] nixos[2175]: switching to system configuration /nix/store/sq3jrcvhm9gnn441dnb7i8dscxqgxvc2-nixos-system-machine-test machine # [ 28.956636] systemd[1]: Stopped target Local File Systems. machine # [ 28.958341] systemd[1]: Stopped target Remote File Systems. machine # [ 29.201844] systemd[1]: Reload requested from client PID 2175 ('.switch-to-conf') (unit backdoor.service)... machine # [ 29.203517] systemd[1]: Reloading... machine # [ 29.456239] systemd[1]: Reloading finished in 250 ms. machine # [ 29.521314] systemd[629]: Reexecution requested from client PID 2244 ('switch-to-confi')... machine # [ 29.523359] systemd[629]: Reexecuting. machine # [ 29.544230] systemd[629]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 29.614875] systemd[629]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 29.620102] systemd[629]: Reload requested from client PID 2244 ('switch-to-confi')... machine # [ 29.621361] systemd[629]: Reloading... machine # [ 29.696234] systemd[629]: Reloading finished in 73 ms. machine # [ 29.701904] systemd[629]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 29.708322] systemd[629]: Stopped Run user-specific NixOS activation. machine # [ 29.710094] systemd[629]: Stopping Run user-specific NixOS activation... machine # [ 29.711842] systemd[629]: Starting Run user-specific NixOS activation... machine # [ 29.731790] systemd[629]: Finished Run user-specific NixOS activation. machine # [ 29.734962] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 29.736325] systemd[1]: Stopping Reactivate sysinit units... machine # [ 29.737290] systemd[1]: Reached target Reactivate sysinit units. machine # [ 29.740558] systemd[1]: Reloading test.service... machine # [ 29.754778] systemd[1]: Reloaded test.service. machine # [ 29.758881] systemd[1]: Reached target Remote File Systems. machine # [ 29.761711] systemd[1]: Starting linger-users.service... machine # [ 29.766353] systemd[1]: Reached target Local File Systems. machine # [ 29.768489] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 29.774072] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 29.774837] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 29.776222] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 29.778171] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 29.779569] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 29.780709] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 29.792730] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 29.793955] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 29.834692] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 29.836846] systemd[1]: Finished linger-users.service. machine # [ 29.951331] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 29.953170] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 30.210370] nixos[2175]: finished switching to system configuration /nix/store/sq3jrcvhm9gnn441dnb7i8dscxqgxvc2-nixos-system-machine-test machine: (finished: must succeed: /nix/store/18jsxirzz9yhwgfqrm1ha69kkxv7fbqn-nixos-system-machine-test/specialisation/simpleServiceReload/bin/switch-to-configuration test 2>&1, in 1.49 seconds) machine: must succeed: /nix/store/18jsxirzz9yhwgfqrm1ha69kkxv7fbqn-nixos-system-machine-test/specialisation/simpleServiceNorestart/bin/switch-to-configuration test 2>&1 machine # [ 30.431672] nixos[2318]: switching to system configuration /nix/store/5cjjk359dw7r00nqs2sdpjc4d9hgkj8s-nixos-system-machine-test machine # [ 30.434406] systemd[1]: Stopped target Local File Systems. machine # [ 30.435767] systemd[1]: Stopped target Remote File Systems. machine # [ 30.662901] systemd[1]: Reload requested from client PID 2318 ('.switch-to-conf') (unit backdoor.service)... machine # [ 30.664530] systemd[1]: Reloading... machine # [ 30.916169] systemd[1]: Reloading finished in 249 ms. machine # [ 30.980085] systemd[629]: Reexecution requested from client PID 2387 ('switch-to-confi')... machine # [ 30.982629] systemd[629]: Reexecuting. machine # [ 31.006464] systemd[629]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 31.078647] systemd[629]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 31.083829] systemd[629]: Reload requested from client PID 2387 ('switch-to-confi')... machine # [ 31.085142] systemd[629]: Reloading... machine # [ 31.156051] systemd[629]: Reloading finished in 69 ms. machine # [ 31.161292] systemd[629]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 31.169146] systemd[629]: Stopped Run user-specific NixOS activation. machine # [ 31.169988] systemd[629]: Stopping Run user-specific NixOS activation... machine # [ 31.172176] systemd[629]: Starting Run user-specific NixOS activation... machine # [ 31.190747] systemd[629]: Finished Run user-specific NixOS activation. machine # [ 31.193912] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 31.194928] systemd[1]: Stopping Reactivate sysinit units... machine # [ 31.196110] systemd[1]: Reached target Reactivate sysinit units. machine # [ 31.199894] systemd[1]: Reached target Local File Systems. machine # [ 31.202230] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 31.204906] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 31.206194] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 31.208136] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 31.210793] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 31.212237] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 31.213396] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 31.216475] systemd[1]: Reached target Remote File Systems. machine # [ 31.225465] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 31.226995] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 31.356830] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 31.358642] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 31.362894] systemd[1]: Starting linger-users.service... machine # [ 31.391095] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 31.392551] systemd[1]: Finished linger-users.service. machine # [ 31.650402] nixos[2318]: finished switching to system configuration /nix/store/5cjjk359dw7r00nqs2sdpjc4d9hgkj8s-nixos-system-machine-test machine: (finished: must succeed: /nix/store/18jsxirzz9yhwgfqrm1ha69kkxv7fbqn-nixos-system-machine-test/specialisation/simpleServiceNorestart/bin/switch-to-configuration test 2>&1, in 1.44 seconds) machine: must succeed: /nix/store/18jsxirzz9yhwgfqrm1ha69kkxv7fbqn-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration dry-activate 2>&1 machine: (finished: must succeed: /nix/store/18jsxirzz9yhwgfqrm1ha69kkxv7fbqn-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration dry-activate 2>&1, in 0.27 seconds) machine: must succeed: /nix/store/18jsxirzz9yhwgfqrm1ha69kkxv7fbqn-nixos-system-machine-test/bin/switch-to-configuration test 2>&1 machine # [ 32.108181] nixos[2468]: switching to system configuration /nix/store/18jsxirzz9yhwgfqrm1ha69kkxv7fbqn-nixos-system-machine-test machine # [ 32.110844] systemd[1]: Stopped target Local File Systems. machine # [ 32.112489] systemd[1]: test.service: Deactivated successfully. machine # [ 32.114097] systemd[1]: Stopped test.service. machine # [ 32.115050] systemd[1]: Stopped target Remote File Systems. machine # [ 32.322506] systemd[1]: Reload requested from client PID 2468 ('.switch-to-conf') (unit backdoor.service)... machine # [ 32.324165] systemd[1]: Reloading... machine # [ 32.549165] systemd[1]: Reloading finished in 222 ms. machine # [ 32.611589] systemd[629]: Reexecution requested from client PID 2537 ('switch-to-confi')... machine # [ 32.612856] systemd[629]: Reexecuting. machine # [ 32.635198] systemd[629]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 32.707422] systemd[629]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 32.712851] systemd[629]: Reload requested from client PID 2537 ('switch-to-confi')... machine # [ 32.714933] systemd[629]: Reloading... machine # [ 32.784316] systemd[629]: Reloading finished in 69 ms. machine # [ 32.789827] systemd[629]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 32.796488] systemd[629]: Stopped Run user-specific NixOS activation. machine # [ 32.797477] systemd[629]: Stopping Run user-specific NixOS activation... machine # [ 32.800114] systemd[629]: Starting Run user-specific NixOS activation... machine # [ 32.819775] systemd[629]: Finished Run user-specific NixOS activation. machine # [ 32.822898] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 32.824253] systemd[1]: Stopping Reactivate sysinit units... machine # [ 32.825292] systemd[1]: Reached target Reactivate sysinit units. machine # [ 32.829176] systemd[1]: Reached target Local File Systems. machine # [ 32.829941] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 32.832990] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 32.834840] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 32.836445] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 32.838549] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 32.840024] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 32.841182] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 32.846222] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 32.847472] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 32.853176] systemd[1]: Reached target Remote File Systems. machine # [ 32.980238] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 32.981911] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 32.986072] systemd[1]: Starting linger-users.service... machine # [ 33.013401] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 33.015079] systemd[1]: Finished linger-users.service. machine # [ 33.269046] nixos[2468]: finished switching to system configuration /nix/store/18jsxirzz9yhwgfqrm1ha69kkxv7fbqn-nixos-system-machine-test machine: (finished: must succeed: /nix/store/18jsxirzz9yhwgfqrm1ha69kkxv7fbqn-nixos-system-machine-test/bin/switch-to-configuration test 2>&1, in 1.34 seconds) machine: must succeed: /nix/store/lx9r65wwrcs9x0rlyghasjb1hk9hbnfj-separate-activation-script/bin/switch-to-configuration test 2>&1 machine # [ 33.429411] nixos[2609]: switching to system configuration /nix/store/798wlbhbma8k7d4d5pizfvcvpljszj7w-nixos-system-machine-test machine # [ 33.431739] systemd[1]: Stopped target Remote File Systems. machine # [ 33.433397] systemd[1]: Stopped target Local File Systems. machine # [ 33.654593] systemd[1]: Reload requested from client PID 2609 ('.switch-to-conf') (unit backdoor.service)... machine # [ 33.656316] systemd[1]: Reloading... machine # [ 33.890838] systemd[1]: Reloading finished in 232 ms. machine # [ 33.955918] systemd[629]: Stopped Run user-specific NixOS activation. machine # [ 33.958604] systemd[629]: Reexecution requested from client PID 2678 ('switch-to-confi')... machine # [ 33.959827] systemd[629]: Reexecuting. machine # [ 33.980170] systemd[629]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 34.052233] systemd[629]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 34.057262] systemd[629]: Reload requested from client PID 2678 ('switch-to-confi')... machine # [ 34.058785] systemd[629]: Reloading... machine # [ 34.127486] systemd[629]: Reloading finished in 67 ms. machine # [ 34.132840] systemd[629]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 34.139832] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 34.141266] systemd[1]: Stopping Reactivate sysinit units... machine # [ 34.142302] systemd[1]: Reached target Reactivate sysinit units. machine # [ 34.143987] systemd[1]: Reached target Remote File Systems. machine # [ 34.147153] systemd[1]: Starting linger-users.service... machine # [ 34.149706] systemd[1]: Starting test.service... machine # [ 34.155382] systemd[1]: Reached target Local File Systems. machine # [ 34.156198] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 34.160482] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 34.161519] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 34.163613] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 34.165599] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 34.166995] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 34.168210] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 34.181286] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 34.182780] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 34.208705] systemd[1]: Finished test.service. machine # [ 34.229768] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 34.231490] systemd[1]: Finished linger-users.service. machine # [ 34.334964] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 34.337202] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 34.595410] nixos[2609]: finished switching to system configuration /nix/store/798wlbhbma8k7d4d5pizfvcvpljszj7w-nixos-system-machine-test machine: (finished: must succeed: /nix/store/lx9r65wwrcs9x0rlyghasjb1hk9hbnfj-separate-activation-script/bin/switch-to-configuration test 2>&1, in 1.33 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.01 seconds) machine: must succeed: /nix/store/18jsxirzz9yhwgfqrm1ha69kkxv7fbqn-nixos-system-machine-test/specialisation/unitWithMultilineValue/bin/switch-to-configuration test 2>&1 machine # [ 34.866708] nixos[2757]: switching to system configuration /nix/store/qk37gp0wdnk61z5paa2z809hjnvc0bi4-nixos-system-machine-test machine # [ 34.869485] systemd[1]: test.service: Deactivated successfully. machine # [ 34.871351] systemd[1]: Stopped test.service. machine # [ 34.872445] systemd[1]: Stopped target Local File Systems. machine # [ 34.874065] systemd[1]: Stopped target Remote File Systems. machine # [ 35.095726] systemd[1]: Reload requested from client PID 2757 ('.switch-to-conf') (unit backdoor.service)... machine # [ 35.097407] systemd[1]: Reloading... machine # [ 35.405977] systemd[1]: Reloading finished in 306 ms. machine # [ 35.469449] systemd[629]: Reexecution requested from client PID 2826 ('switch-to-confi')... machine # [ 35.472206] systemd[629]: Reexecuting. machine # [ 35.497954] systemd[629]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 35.577897] systemd[629]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 35.583283] systemd[629]: Reload requested from client PID 2826 ('switch-to-confi')... machine # [ 35.585143] systemd[629]: Reloading... machine # [ 35.660105] systemd[629]: Reloading finished in 73 ms. machine # [ 35.665868] systemd[629]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 35.673164] systemd[629]: Starting Run user-specific NixOS activation... machine # [ 35.695272] systemd[629]: Finished Run user-specific NixOS activation. machine # [ 35.697938] systemd[629]: Stopped Run user-specific NixOS activation. machine # [ 35.699056] systemd[629]: Stopping Run user-specific NixOS activation... machine # [ 35.703881] systemd[629]: Starting Run user-specific NixOS activation... machine # [ 35.705526] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 35.708342] systemd[1]: Stopping Reactivate sysinit units... machine # [ 35.709160] systemd[1]: Reached target Reactivate sysinit units. machine # [ 35.709938] systemd[1]: Reached target Remote File Systems. machine # [ 35.721626] systemd[1]: Starting linger-users.service... machine # [ 35.726240] systemd[1]: Reached target Local File Systems. machine # [ 35.734142] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 35.741449] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 35.742354] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 35.743507] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 35.747184] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 35.750163] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 35.755164] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 35.765564] systemd[629]: Finished Run user-specific NixOS activation. machine # [ 35.770279] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 35.772504] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 35.809562] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 35.811224] systemd[1]: Finished linger-users.service. machine # [ 35.908837] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 35.910550] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 35.914905] systemd[1]: Started test.service. machine # [ 35.930102] systemd[1]: test.service: Deactivated successfully. machine # [ 36.172432] nixos[2757]: finished switching to system configuration /nix/store/qk37gp0wdnk61z5paa2z809hjnvc0bi4-nixos-system-machine-test machine: (finished: must succeed: /nix/store/18jsxirzz9yhwgfqrm1ha69kkxv7fbqn-nixos-system-machine-test/specialisation/unitWithMultilineValue/bin/switch-to-configuration test 2>&1, in 1.52 seconds) machine: must succeed: /nix/store/18jsxirzz9yhwgfqrm1ha69kkxv7fbqn-nixos-system-machine-test/specialisation/unitWithBackslash/bin/switch-to-configuration test 2>&1 machine # [ 36.426560] nixos[2902]: switching to system configuration /nix/store/2y52fb8h8a3aknd4ii31rnkvwvk8zhqp-nixos-system-machine-test machine # [ 36.429466] systemd[1]: Stopped target Remote File Systems. machine # [ 36.431661] systemd[1]: Stopped target Local File Systems. machine # [ 36.659712] systemd[1]: Reload requested from client PID 2902 ('.switch-to-conf') (unit backdoor.service)... machine # [ 36.661432] systemd[1]: Reloading... machine # [ 36.903766] systemd[1]: Reloading finished in 240 ms. machine # [ 36.965318] systemd[629]: Reexecution requested from client PID 2972 ('switch-to-confi')... machine # [ 36.967528] systemd[629]: Reexecuting. machine # [ 36.988361] systemd[629]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 37.054963] systemd[629]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 37.061062] systemd[629]: Reload requested from client PID 2972 ('switch-to-confi')... machine # [ 37.062518] systemd[629]: Reloading... machine # [ 37.128877] systemd[629]: Reloading finished in 65 ms. machine # [ 37.133820] systemd[629]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 37.139897] systemd[629]: Stopped Run user-specific NixOS activation. machine # [ 37.141375] systemd[629]: Stopping Run user-specific NixOS activation... machine # [ 37.143529] systemd[629]: Starting Run user-specific NixOS activation... machine # [ 37.162932] systemd[629]: Finished Run user-specific NixOS activation. machine # [ 37.166274] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 37.168421] systemd[1]: Stopping Reactivate sysinit units... machine # [ 37.169350] systemd[1]: Reached target Reactivate sysinit units. machine # [ 37.171080] systemd[1]: Reached target Local File Systems. machine # [ 37.173285] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 37.175671] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 37.177271] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 37.179132] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 37.182091] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 37.183538] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 37.184756] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 37.192796] systemd[1]: Reached target Remote File Systems. machine # [ 37.198916] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 37.200940] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 37.319457] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 37.321236] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 37.325108] systemd[1]: Starting escaped\x2ddash.service... machine # [ 37.328145] systemd[1]: Starting linger-users.service... machine # [ 37.352904] systemd[1]: Finished escaped\x2ddash.service. machine # [ 37.365811] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 37.367482] systemd[1]: Finished linger-users.service. machine # [ 37.625383] nixos[2902]: finished switching to system configuration /nix/store/2y52fb8h8a3aknd4ii31rnkvwvk8zhqp-nixos-system-machine-test machine: (finished: must succeed: /nix/store/18jsxirzz9yhwgfqrm1ha69kkxv7fbqn-nixos-system-machine-test/specialisation/unitWithBackslash/bin/switch-to-configuration test 2>&1, in 1.45 seconds) machine: must succeed: /nix/store/18jsxirzz9yhwgfqrm1ha69kkxv7fbqn-nixos-system-machine-test/specialisation/unitWithBackslashModified/bin/switch-to-configuration test 2>&1 machine # [ 37.840657] nixos[3045]: switching to system configuration /nix/store/bj9wx71g84ij1j4h8ckhcw4hdwhgai9m-nixos-system-machine-test machine # [ 37.842931] systemd[1]: Stopped target Remote File Systems. machine # [ 37.844684] systemd[1]: Stopped target Local File Systems. machine # [ 37.846263] systemd[1]: escaped\x2ddash.service: Deactivated successfully. machine # [ 37.847793] systemd[1]: Stopped escaped\x2ddash.service. machine # [ 38.086733] systemd[1]: Reload requested from client PID 3045 ('.switch-to-conf') (unit backdoor.service)... machine # [ 38.088434] systemd[1]: Reloading... machine # [ 38.334487] systemd[1]: Reloading finished in 244 ms. machine # [ 38.395375] systemd[629]: Reexecution requested from client PID 3114 ('switch-to-confi')... machine # [ 38.397092] systemd[629]: Reexecuting. machine # [ 38.421027] systemd[629]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 38.492435] systemd[629]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 38.497590] systemd[629]: Reload requested from client PID 3114 ('switch-to-confi')... machine # [ 38.499880] systemd[629]: Reloading... machine # [ 38.564158] systemd[629]: Reloading finished in 64 ms. machine # [ 38.569880] systemd[629]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 38.577066] systemd[629]: Stopped Run user-specific NixOS activation. machine # [ 38.577948] systemd[629]: Stopping Run user-specific NixOS activation... machine # [ 38.579746] systemd[629]: Starting Run user-specific NixOS activation... machine # [ 38.600260] systemd[629]: Finished Run user-specific NixOS activation. machine # [ 38.603372] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 38.604688] systemd[1]: Stopping Reactivate sysinit units... machine # [ 38.605763] systemd[1]: Reached target Reactivate sysinit units. machine # [ 38.608829] systemd[1]: Reached target Remote File Systems. machine # [ 38.612212] systemd[1]: Starting escaped\x2ddash.service... machine # [ 38.616776] systemd[1]: Reached target Local File Systems. machine # [ 38.618917] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 38.621239] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 38.621978] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 38.625805] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 38.628117] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 38.629681] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 38.630825] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 38.638926] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 38.640616] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 38.660049] systemd[1]: Finished escaped\x2ddash.service. machine # [ 38.774766] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 38.776457] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 38.780272] systemd[1]: Starting linger-users.service... machine # [ 38.807249] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 38.808708] systemd[1]: Finished linger-users.service. machine # [ 39.066670] nixos[3045]: finished switching to system configuration /nix/store/bj9wx71g84ij1j4h8ckhcw4hdwhgai9m-nixos-system-machine-test machine: (finished: must succeed: /nix/store/18jsxirzz9yhwgfqrm1ha69kkxv7fbqn-nixos-system-machine-test/specialisation/unitWithBackslashModified/bin/switch-to-configuration test 2>&1, in 1.44 seconds) machine: must succeed: /nix/store/18jsxirzz9yhwgfqrm1ha69kkxv7fbqn-nixos-system-machine-test/specialisation/unitStartingWithDash/bin/switch-to-configuration test 2>&1 machine # [ 39.320342] nixos[3187]: switching to system configuration /nix/store/jn44vjisymdnhg7xhjxia25jfiiyx8vd-nixos-system-machine-test machine # [ 39.322969] systemd[1]: escaped\x2ddash.service: Deactivated successfully. machine # [ 39.324499] systemd[1]: Stopped escaped\x2ddash.service. machine # [ 39.325565] systemd[1]: Stopped target Remote File Systems. machine # [ 39.327142] systemd[1]: Stopped target Local File Systems. machine # [ 39.549030] systemd[1]: Reload requested from client PID 3187 ('.switch-to-conf') (unit backdoor.service)... machine # [ 39.550631] systemd[1]: Reloading... machine # [ 39.798269] systemd[1]: Reloading finished in 246 ms. machine # [ 39.886432] systemd[629]: Reexecution requested from client PID 3256 ('switch-to-confi')... machine # [ 39.887684] systemd[629]: Reexecuting. machine # [ 39.908223] systemd[629]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 39.976742] systemd[629]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 39.982800] systemd[629]: Reload requested from client PID 3256 ('switch-to-confi')... machine # [ 39.984577] systemd[629]: Reloading... machine # [ 40.055388] systemd[629]: Reloading finished in 69 ms. machine # [ 40.060858] systemd[629]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 40.067941] systemd[629]: Stopped Run user-specific NixOS activation. machine # [ 40.068903] systemd[629]: Stopping Run user-specific NixOS activation... machine # [ 40.070596] systemd[629]: Starting Run user-specific NixOS activation... machine # [ 40.090405] systemd[629]: Finished Run user-specific NixOS activation. machine # [ 40.093503] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 40.094929] systemd[1]: Stopping Reactivate sysinit units... machine # [ 40.095963] systemd[1]: Reached target Reactivate sysinit units. machine # [ 40.098323] systemd[1]: Reached target Remote File Systems. machine # [ 40.099833] systemd[1]: Reached target Local File Systems. machine # [ 40.103616] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 40.105264] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 40.110143] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 40.114025] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 40.114810] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 40.116920] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 40.118886] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 40.120372] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 40.121591] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 40.248087] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 40.250534] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 40.254112] systemd[1]: Starting -.service... machine # [ 40.257730] systemd[1]: Starting linger-users.service... machine # [ 40.280459] systemd[1]: Finished -.service. machine # [ 40.293840] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 40.295361] systemd[1]: Finished linger-users.service. machine # [ 40.553424] nixos[3187]: finished switching to system configuration /nix/store/jn44vjisymdnhg7xhjxia25jfiiyx8vd-nixos-system-machine-test machine: (finished: must succeed: /nix/store/18jsxirzz9yhwgfqrm1ha69kkxv7fbqn-nixos-system-machine-test/specialisation/unitStartingWithDash/bin/switch-to-configuration test 2>&1, in 1.49 seconds) machine: must succeed: /nix/store/18jsxirzz9yhwgfqrm1ha69kkxv7fbqn-nixos-system-machine-test/specialisation/unitStartingWithDashModified/bin/switch-to-configuration test 2>&1 machine # [ 40.776822] nixos[3330]: switching to system configuration /nix/store/6mldi0zhvflmi3gq71rq4j1hba5sx5bd-nixos-system-machine-test machine # [ 40.780786] systemd[1]: Stopped target Remote File Systems. machine # [ 40.781849] systemd[1]: Stopped target Local File Systems. machine # [ 41.009314] systemd[1]: Reload requested from client PID 3330 ('.switch-to-conf') (unit backdoor.service)... machine # [ 41.011235] systemd[1]: Reloading... machine # [ 41.225105] systemd[1]: Reloading finished in 212 ms. machine # [ 41.282766] systemd[629]: Reexecution requested from client PID 3399 ('switch-to-confi')... machine # [ 41.284644] systemd[629]: Reexecuting. machine # [ 41.303907] systemd[629]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 41.370847] systemd[629]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 41.376107] systemd[629]: Reload requested from client PID 3399 ('switch-to-confi')... machine # [ 41.377548] systemd[629]: Reloading... machine # [ 41.440881] systemd[629]: Reloading finished in 62 ms. machine # [ 41.445900] systemd[629]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 41.451927] systemd[629]: Stopped Run user-specific NixOS activation. machine # [ 41.453070] systemd[629]: Stopping Run user-specific NixOS activation... machine # [ 41.455710] systemd[629]: Starting Run user-specific NixOS activation... machine # [ 41.476220] systemd[629]: Finished Run user-specific NixOS activation. machine # [ 41.479293] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 41.480711] systemd[1]: Stopping Reactivate sysinit units... machine # [ 41.481740] systemd[1]: Reached target Reactivate sysinit units. machine # [ 41.485063] systemd[1]: Reloading -.service... machine # [ 41.501306] systemd[1]: Reloaded -.service. machine # [ 41.504224] systemd[1]: Reached target Local File Systems. machine # [ 41.508205] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 41.510134] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 41.515195] systemd[1]: Reached target Remote File Systems. machine # [ 41.515911] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 41.519310] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 41.520790] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 41.521952] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 41.523890] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 41.525357] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 41.526500] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 41.659844] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 41.661615] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 41.665651] systemd[1]: Starting linger-users.service... machine # [ 41.694977] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 41.697076] systemd[1]: Finished linger-users.service. machine # [ 41.954432] nixos[3330]: finished switching to system configuration /nix/store/6mldi0zhvflmi3gq71rq4j1hba5sx5bd-nixos-system-machine-test machine: (finished: must succeed: /nix/store/18jsxirzz9yhwgfqrm1ha69kkxv7fbqn-nixos-system-machine-test/specialisation/unitStartingWithDashModified/bin/switch-to-configuration test 2>&1, in 1.40 seconds) machine: must succeed: /nix/store/18jsxirzz9yhwgfqrm1ha69kkxv7fbqn-nixos-system-machine-test/specialisation/unitWithRequirement/bin/switch-to-configuration test 2>&1 machine # [ 42.199243] nixos[3472]: switching to system configuration /nix/store/kr74ik1wvy7bv9c2h9rz9bnxjhlmsyir-nixos-system-machine-test machine # [ 42.201935] systemd[1]: Stopped target Remote File Systems. machine # [ 42.203814] systemd[1]: -.service: Deactivated successfully. machine # [ 42.205539] systemd[1]: Stopped -.service. machine # [ 42.206515] systemd[1]: Stopped target Local File Systems. machine # [ 42.429599] systemd[1]: Reload requested from client PID 3472 ('.switch-to-conf') (unit backdoor.service)... machine # [ 42.431325] systemd[1]: Reloading... machine # [ 42.674815] systemd[1]: Reloading finished in 241 ms. machine # [ 42.734529] systemd[629]: Reexecution requested from client PID 3541 ('switch-to-confi')... machine # [ 42.737278] systemd[629]: Reexecuting. machine # [ 42.758166] systemd[629]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 42.828454] systemd[629]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 42.833530] systemd[629]: Reload requested from client PID 3541 ('switch-to-confi')... machine # [ 42.836084] systemd[629]: Reloading... machine # [ 42.909227] systemd[629]: Reloading finished in 73 ms. machine # [ 42.914840] systemd[629]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 42.921164] systemd[629]: Stopped Run user-specific NixOS activation. machine # [ 42.923078] systemd[629]: Stopping Run user-specific NixOS activation... machine # [ 42.924673] systemd[629]: Starting Run user-specific NixOS activation... machine # [ 42.944968] systemd[629]: Finished Run user-specific NixOS activation. machine # [ 42.948251] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 42.949534] systemd[1]: Stopping Reactivate sysinit units... machine # [ 42.950562] systemd[1]: Reached target Reactivate sysinit units. machine # [ 42.951991] systemd[1]: Reached target Remote File Systems. machine # [ 42.955803] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 42.957611] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 42.960097] systemd[1]: Reached target Local File Systems. machine # [ 42.962115] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 42.964795] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 42.966810] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 42.968825] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 42.971658] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 42.973834] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 42.976283] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 43.106236] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 43.107909] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 43.112077] systemd[1]: Starting linger-users.service... machine # [ 43.115069] systemd[1]: Starting required-service.service... machine # [ 43.117476] systemd[1]: Starting test-service.service... machine # [ 43.152724] systemd[1]: Finished test-service.service. machine # [ 43.155636] systemd[1]: Finished required-service.service. machine # [ 43.168671] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 43.170186] systemd[1]: Finished linger-users.service. machine # [ 43.429351] nixos[3472]: finished switching to system configuration /nix/store/kr74ik1wvy7bv9c2h9rz9bnxjhlmsyir-nixos-system-machine-test machine: (finished: must succeed: /nix/store/18jsxirzz9yhwgfqrm1ha69kkxv7fbqn-nixos-system-machine-test/specialisation/unitWithRequirement/bin/switch-to-configuration test 2>&1, in 1.48 seconds) machine: must succeed: /nix/store/18jsxirzz9yhwgfqrm1ha69kkxv7fbqn-nixos-system-machine-test/specialisation/unitWithRequirementModified/bin/switch-to-configuration test 2>&1 machine # [ 43.661374] nixos[3616]: switching to system configuration /nix/store/amz4y06sr4lfls7wph79wfz82ig9v4gk-nixos-system-machine-test machine # [ 43.664252] systemd[1]: required-service.service: Deactivated successfully. machine # [ 43.665157] systemd[1]: Stopped required-service.service. machine # [ 43.666922] systemd[1]: test-service.service: Deactivated successfully. machine # [ 43.668557] systemd[1]: Stopped test-service.service. machine # [ 43.670181] systemd[1]: Stopped target Remote File Systems. machine # [ 43.670937] systemd[1]: Stopped target Local File Systems. machine # [ 43.905546] systemd[1]: Reload requested from client PID 3616 ('.switch-to-conf') (unit backdoor.service)... machine # [ 43.907373] systemd[1]: Reloading... machine # [ 44.150094] systemd[1]: Reloading finished in 241 ms. machine # [ 44.212345] systemd[629]: Reexecution requested from client PID 3685 ('switch-to-confi')... machine # [ 44.213619] systemd[629]: Reexecuting. machine # [ 44.236165] systemd[629]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 44.306470] systemd[629]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 44.311693] systemd[629]: Reload requested from client PID 3685 ('switch-to-confi')... machine # [ 44.313536] systemd[629]: Reloading... machine # [ 44.383957] systemd[629]: Reloading finished in 69 ms. machine # [ 44.389852] systemd[629]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 44.395959] systemd[629]: Stopped Run user-specific NixOS activation. machine # [ 44.397937] systemd[629]: Stopping Run user-specific NixOS activation... machine # [ 44.399594] systemd[629]: Starting Run user-specific NixOS activation... machine # [ 44.420854] systemd[629]: Finished Run user-specific NixOS activation. machine # [ 44.423980] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 44.425532] systemd[1]: Stopping Reactivate sysinit units... machine # [ 44.426664] systemd[1]: Reached target Reactivate sysinit units. machine # [ 44.432114] systemd[1]: Starting required-service.service... machine # [ 44.434225] systemd[1]: Starting test-service.service... machine # [ 44.442439] systemd[1]: Reached target Remote File Systems. machine # [ 44.448655] systemd[1]: Starting linger-users.service... machine # [ 44.451635] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 44.454620] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 44.460953] systemd[1]: Reached target Local File Systems. machine # [ 44.472682] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 44.476027] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 44.476879] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 44.479650] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 44.482436] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 44.483989] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 44.488784] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 44.497559] systemd[1]: Finished required-service.service. machine # [ 44.499861] systemd[1]: Finished test-service.service. machine # [ 44.532924] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 44.534853] systemd[1]: Finished linger-users.service. machine # [ 44.642792] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 44.644513] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 44.901517] nixos[3616]: finished switching to system configuration /nix/store/amz4y06sr4lfls7wph79wfz82ig9v4gk-nixos-system-machine-test machine: (finished: must succeed: /nix/store/18jsxirzz9yhwgfqrm1ha69kkxv7fbqn-nixos-system-machine-test/specialisation/unitWithRequirementModified/bin/switch-to-configuration test 2>&1, in 1.47 seconds) machine: must succeed: /nix/store/18jsxirzz9yhwgfqrm1ha69kkxv7fbqn-nixos-system-machine-test/specialisation/unitWithRequirementModifiedNostart/bin/switch-to-configuration test 2>&1 machine # [ 45.136627] nixos[3760]: switching to system configuration /nix/store/bq16rxp5r93fmzwj99jy3cipp3bykpz8-nixos-system-machine-test machine # [ 45.139236] systemd[1]: Stopped target Local File Systems. machine # [ 45.140863] systemd[1]: required-service.service: Deactivated successfully. machine # [ 45.142173] systemd[1]: Stopped required-service.service. machine # [ 45.143869] systemd[1]: test-service.service: Deactivated successfully. machine # [ 45.145100] systemd[1]: Stopped test-service.service. machine # [ 45.146439] systemd[1]: Stopped target Remote File Systems. machine # [ 45.376659] systemd[1]: Reload requested from client PID 3760 ('.switch-to-conf') (unit backdoor.service)... machine # [ 45.378430] systemd[1]: Reloading... machine # [ 45.624093] systemd[1]: Reloading finished in 244 ms. machine # [ 45.686671] systemd[629]: Reexecution requested from client PID 3829 ('switch-to-confi')... machine # [ 45.689291] systemd[629]: Reexecuting. machine # [ 45.710163] systemd[629]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 45.781926] systemd[629]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 45.787787] systemd[629]: Reload requested from client PID 3829 ('switch-to-confi')... machine # [ 45.789274] systemd[629]: Reloading... machine # [ 45.860848] systemd[629]: Reloading finished in 70 ms. machine # [ 45.865853] systemd[629]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 45.872830] systemd[629]: Stopped Run user-specific NixOS activation. machine # [ 45.873744] systemd[629]: Stopping Run user-specific NixOS activation... machine # [ 45.875504] systemd[629]: Starting Run user-specific NixOS activation... machine # [ 45.895695] systemd[629]: Finished Run user-specific NixOS activation. machine # [ 45.898799] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 45.900223] systemd[1]: Stopping Reactivate sysinit units... machine # [ 45.900943] systemd[1]: Reached target Reactivate sysinit units. machine # [ 45.906545] systemd[1]: Reached target Remote File Systems. machine # [ 45.910058] systemd[1]: Starting linger-users.service... machine # [ 45.912165] systemd[1]: Starting required-service.service... machine # [ 45.915984] systemd[1]: Starting test-service.service... machine # [ 45.920565] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 45.921830] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 45.928065] systemd[1]: Reached target Local File Systems. machine # [ 45.928822] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 45.933602] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 45.934669] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 45.937458] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 45.941157] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 45.944240] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 45.948440] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 45.976972] systemd[1]: Finished test-service.service. machine # [ 45.978838] systemd[1]: Finished required-service.service. machine # [ 45.997827] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 45.999661] systemd[1]: Finished linger-users.service. machine # [ 46.105342] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 46.106985] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 46.365242] nixos[3760]: finished switching to system configuration /nix/store/bq16rxp5r93fmzwj99jy3cipp3bykpz8-nixos-system-machine-test machine: (finished: must succeed: /nix/store/18jsxirzz9yhwgfqrm1ha69kkxv7fbqn-nixos-system-machine-test/specialisation/unitWithRequirementModifiedNostart/bin/switch-to-configuration test 2>&1, in 1.46 seconds) machine: must succeed: /nix/store/18jsxirzz9yhwgfqrm1ha69kkxv7fbqn-nixos-system-machine-test/specialisation/unitWithTemplate/bin/switch-to-configuration test 2>&1 machine # [ 46.590574] nixos[3904]: switching to system configuration /nix/store/1hwjy5lspcf7374l7bylwmk2dvhwx099-nixos-system-machine-test machine # [ 46.593078] systemd[1]: Stopped target Local File Systems. machine # [ 46.595276] systemd[1]: Stopped target Remote File Systems. machine # [ 46.597054] systemd[1]: required-service.service: Deactivated successfully. machine # [ 46.597994] systemd[1]: Stopped required-service.service. machine # [ 46.599794] systemd[1]: test-service.service: Deactivated successfully. machine # [ 46.601380] systemd[1]: Stopped test-service.service. machine # [ 46.829489] systemd[1]: Reload requested from client PID 3904 ('.switch-to-conf') (unit backdoor.service)... machine # [ 46.831229] systemd[1]: Reloading... machine # [ 47.081083] systemd[1]: Reloading finished in 247 ms. machine # [ 47.142800] systemd[629]: Reexecution requested from client PID 3973 ('switch-to-confi')... machine # [ 47.144784] systemd[629]: Reexecuting. machine # [ 47.166193] systemd[629]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 47.237944] systemd[629]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 47.243217] systemd[629]: Reload requested from client PID 3973 ('switch-to-confi')... machine # [ 47.244961] systemd[629]: Reloading... machine # [ 47.317164] systemd[629]: Reloading finished in 71 ms. machine # [ 47.321846] systemd[629]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 47.328871] systemd[629]: Stopped Run user-specific NixOS activation. machine # [ 47.329814] systemd[629]: Stopping Run user-specific NixOS activation... machine # [ 47.331591] systemd[629]: Starting Run user-specific NixOS activation... machine # [ 47.352141] systemd[629]: Finished Run user-specific NixOS activation. machine # [ 47.355255] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 47.356450] systemd[1]: Stopping Reactivate sysinit units... machine # [ 47.357515] systemd[1]: Reached target Reactivate sysinit units. machine # [ 47.361063] systemd[1]: Reached target Local File Systems. machine # [ 47.361802] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 47.365187] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 47.365933] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 47.368319] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 47.371184] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 47.374111] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 47.375611] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 47.379437] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 47.380710] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 47.386109] systemd[1]: Reached target Remote File Systems. machine # [ 47.392693] systemd[1]: Created slice Slice /system/instantiated. machine # [ 47.517841] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 47.521209] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 47.524131] systemd[1]: Starting instantiated@one.service... machine # [ 47.527185] systemd[1]: Starting instantiated@two.service... machine # [ 47.530376] systemd[1]: Starting linger-users.service... machine # [ 47.562254] systemd[1]: Finished instantiated@one.service. machine # [ 47.564145] systemd[1]: Finished instantiated@two.service. machine # [ 47.577933] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 47.580236] systemd[1]: Finished linger-users.service. machine # [ 47.833900] nixos[3904]: finished switching to system configuration /nix/store/1hwjy5lspcf7374l7bylwmk2dvhwx099-nixos-system-machine-test machine: (finished: must succeed: /nix/store/18jsxirzz9yhwgfqrm1ha69kkxv7fbqn-nixos-system-machine-test/specialisation/unitWithTemplate/bin/switch-to-configuration test 2>&1, in 1.46 seconds) machine: must succeed: /nix/store/18jsxirzz9yhwgfqrm1ha69kkxv7fbqn-nixos-system-machine-test/specialisation/unitWithTemplateModified/bin/switch-to-configuration test 2>&1 machine # [ 48.072468] nixos[4048]: switching to system configuration /nix/store/n6n72l13gv2ihahz9dqawrp673cfrnl5-nixos-system-machine-test machine # [ 48.074921] systemd[1]: Stopped target Remote File Systems. machine # [ 48.076614] systemd[1]: Stopped target Local File Systems. machine # [ 48.078225] systemd[1]: instantiated@two.service: Deactivated successfully. machine # [ 48.079838] systemd[1]: Stopped instantiated@two.service. machine # [ 48.081750] systemd[1]: instantiated@one.service: Deactivated successfully. machine # [ 48.082929] systemd[1]: Stopped instantiated@one.service. machine # [ 48.313813] systemd[1]: Reload requested from client PID 4048 ('.switch-to-conf') (unit backdoor.service)... machine # [ 48.315576] systemd[1]: Reloading... machine # [ 48.562343] systemd[1]: Reloading finished in 245 ms. machine # [ 48.625388] systemd[629]: Reexecution requested from client PID 4117 ('switch-to-confi')... machine # [ 48.627347] systemd[629]: Reexecuting. machine # [ 48.648218] systemd[629]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 48.721476] systemd[629]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 48.726587] systemd[629]: Reload requested from client PID 4117 ('switch-to-confi')... machine # [ 48.729104] systemd[629]: Reloading... machine # [ 48.798513] systemd[629]: Reloading finished in 69 ms. machine # [ 48.803861] systemd[629]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 48.809889] systemd[629]: Stopped Run user-specific NixOS activation. machine # [ 48.810903] systemd[629]: Stopping Run user-specific NixOS activation... machine # [ 48.813565] systemd[629]: Starting Run user-specific NixOS activation... machine # [ 48.834772] systemd[629]: Finished Run user-specific NixOS activation. machine # [ 48.837942] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 48.839451] systemd[1]: Stopping Reactivate sysinit units... machine # [ 48.840435] systemd[1]: Reached target Reactivate sysinit units. machine # [ 48.841978] systemd[1]: Reached target Remote File Systems. machine # [ 48.845679] systemd[1]: Starting instantiated@two.service... machine # [ 48.851278] systemd[1]: Starting instantiated@one.service... machine # [ 48.856355] systemd[1]: Reached target Local File Systems. machine # [ 48.858201] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 48.861562] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 48.864095] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 48.865242] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 48.869142] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 48.870653] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 48.871861] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 48.875491] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 48.878690] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 48.905185] systemd[1]: Finished instantiated@two.service. machine # [ 48.908432] systemd[1]: Finished instantiated@one.service. machine # [ 49.024801] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 49.026619] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 49.030530] systemd[1]: Starting linger-users.service... machine # [ 49.059545] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 49.061830] systemd[1]: Finished linger-users.service. machine # [ 49.318817] nixos[4048]: finished switching to system configuration /nix/store/n6n72l13gv2ihahz9dqawrp673cfrnl5-nixos-system-machine-test machine: (finished: must succeed: /nix/store/18jsxirzz9yhwgfqrm1ha69kkxv7fbqn-nixos-system-machine-test/specialisation/unitWithTemplateModified/bin/switch-to-configuration test 2>&1, in 1.49 seconds) (finished: subtest: services, in 30.98 seconds) subtest: failing units machine: must succeed: /nix/store/18jsxirzz9yhwgfqrm1ha69kkxv7fbqn-nixos-system-machine-test/specialisation/simpleServiceModified/bin/switch-to-configuration test 2>&1 machine # [ 49.528321] nixos[4192]: switching to system configuration /nix/store/i83dx9wqn8s2cpy0p0izf0bk0ki1p994-nixos-system-machine-test machine # [ 49.530817] systemd[1]: Stopped target Local File Systems. machine # [ 49.532576] systemd[1]: instantiated@one.service: Deactivated successfully. machine # [ 49.534244] systemd[1]: Stopped instantiated@one.service. machine # [ 49.535408] systemd[1]: Stopped target Remote File Systems. machine # [ 49.536824] systemd[1]: instantiated@two.service: Deactivated successfully. machine # [ 49.538372] systemd[1]: Stopped instantiated@two.service. machine # [ 49.745682] systemd[1]: Reload requested from client PID 4192 ('.switch-to-conf') (unit backdoor.service)... machine # [ 49.747402] systemd[1]: Reloading... machine # [ 49.975222] systemd[1]: Reloading finished in 226 ms. machine # [ 50.038368] systemd[629]: Reexecution requested from client PID 4261 ('switch-to-confi')... machine # [ 50.039650] systemd[629]: Reexecuting. machine # [ 50.061153] systemd[629]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 50.133818] systemd[629]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 50.139057] systemd[629]: Reload requested from client PID 4261 ('switch-to-confi')... machine # [ 50.140319] systemd[629]: Reloading... machine # [ 50.213461] systemd[629]: Reloading finished in 71 ms. machine # [ 50.218848] systemd[629]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 50.225098] systemd[629]: Stopped Run user-specific NixOS activation. machine # [ 50.227049] systemd[629]: Stopping Run user-specific NixOS activation... machine # [ 50.228565] systemd[629]: Starting Run user-specific NixOS activation... machine # [ 50.248701] systemd[629]: Finished Run user-specific NixOS activation. machine # [ 50.251988] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 50.253505] systemd[1]: Stopping Reactivate sysinit units... machine # [ 50.254662] systemd[1]: Reached target Reactivate sysinit units. machine # [ 50.257389] systemd[1]: Reached target Remote File Systems. machine # [ 50.260193] systemd[1]: Starting linger-users.service... machine # [ 50.263033] systemd[1]: Starting test.service... machine # [ 50.270065] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 50.271336] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 50.278273] systemd[1]: Reached target Local File Systems. machine # [ 50.280862] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 50.285327] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 50.286856] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 50.290083] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 50.293155] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 50.294576] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 50.295789] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 50.318311] systemd[1]: Finished test.service. machine # [ 50.337404] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 50.338641] systemd[1]: Finished linger-users.service. machine # [ 50.447807] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 50.450566] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 50.704476] nixos[4192]: finished switching to system configuration /nix/store/i83dx9wqn8s2cpy0p0izf0bk0ki1p994-nixos-system-machine-test machine: (finished: must succeed: /nix/store/18jsxirzz9yhwgfqrm1ha69kkxv7fbqn-nixos-system-machine-test/specialisation/simpleServiceModified/bin/switch-to-configuration test 2>&1, in 1.38 seconds) machine: must fail: /nix/store/18jsxirzz9yhwgfqrm1ha69kkxv7fbqn-nixos-system-machine-test/specialisation/simpleServiceFailing/bin/switch-to-configuration test 2>&1 machine # [ 50.891832] nixos[4334]: switching to system configuration /nix/store/h8vg4kgb88rh3zyy16lhadya1ik844jz-nixos-system-machine-test machine # [ 50.894565] systemd[1]: test.service: Deactivated successfully. machine # [ 50.896395] systemd[1]: Stopped test.service. machine # [ 50.897497] systemd[1]: Stopped target Local File Systems. machine # [ 50.898851] systemd[1]: Stopped target Remote File Systems. machine # [ 51.135333] systemd[1]: Reload requested from client PID 4334 ('.switch-to-conf') (unit backdoor.service)... machine # [ 51.136945] systemd[1]: Reloading... machine # [ 51.378860] systemd[1]: Reloading finished in 240 ms. machine # [ 51.437444] systemd[629]: Reexecution requested from client PID 4403 ('switch-to-confi')... machine # [ 51.438736] systemd[629]: Reexecuting. machine # [ 51.460168] systemd[629]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 51.527897] systemd[629]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 51.533764] systemd[629]: Reload requested from client PID 4403 ('switch-to-confi')... machine # [ 51.535061] systemd[629]: Reloading... machine # [ 51.605660] systemd[629]: Reloading finished in 68 ms. machine # [ 51.609864] systemd[629]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 51.616267] systemd[629]: Stopped Run user-specific NixOS activation. machine # [ 51.617251] systemd[629]: Stopping Run user-specific NixOS activation... machine # [ 51.619892] systemd[629]: Starting Run user-specific NixOS activation... machine # [ 51.641359] systemd[629]: Finished Run user-specific NixOS activation. machine # [ 51.644597] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 51.645860] systemd[1]: Stopping Reactivate sysinit units... machine # [ 51.646893] systemd[1]: Reached target Reactivate sysinit units. machine # [ 51.650995] systemd[1]: Starting test.service... machine # [ 51.657410] systemd[1]: Reached target Local File Systems. machine # [ 51.658243] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 51.663175] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 51.663981] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 51.665157] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 51.667210] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 51.668627] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 51.669818] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 51.673849] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 51.675699] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 51.681657] systemd[1]: Reached target Remote File Systems. machine # [ 51.700927] systemd[1]: test.service: Main process exited, code=exited, status=1/FAILURE machine # [ 51.702719] systemd[1]: test.service: Failed with result 'exit-code'. machine # [ 51.705282] systemd[1]: Failed to start test.service. machine # [ 51.822472] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 51.824213] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 51.827975] systemd[1]: Starting linger-users.service... machine # [ 51.855558] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 51.857807] systemd[1]: Finished linger-users.service. machine # [ 52.122588] nixos[4334]: switching to system configuration /nix/store/h8vg4kgb88rh3zyy16lhadya1ik844jz-nixos-system-machine-test failed (status 4) machine: (finished: must fail: /nix/store/18jsxirzz9yhwgfqrm1ha69kkxv7fbqn-nixos-system-machine-test/specialisation/simpleServiceFailing/bin/switch-to-configuration test 2>&1, in 1.42 seconds) machine: must succeed: /nix/store/18jsxirzz9yhwgfqrm1ha69kkxv7fbqn-nixos-system-machine-test/specialisation/autorestartService/bin/switch-to-configuration test 2>&1 machine # [ 52.319536] nixos[4477]: switching to system configuration /nix/store/mkiyl07hnqndk9y5kgpyyg4y1k412s00-nixos-system-machine-test machine # [ 52.322075] systemd[1]: Stopped target Local File Systems. machine # [ 52.324111] systemd[1]: Stopped target Remote File Systems. machine # [ 52.551232] systemd[1]: Reload requested from client PID 4477 ('.switch-to-conf') (unit backdoor.service)... machine # [ 52.552890] systemd[1]: Reloading... machine # [ 52.796971] systemd[1]: Reloading finished in 242 ms. machine # [ 52.858865] systemd[629]: Reexecution requested from client PID 4546 ('switch-to-confi')... machine # [ 52.861504] systemd[629]: Reexecuting. machine # [ 52.883183] systemd[629]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 52.957500] systemd[629]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 52.962806] systemd[629]: Reload requested from client PID 4546 ('switch-to-confi')... machine # [ 52.964132] systemd[629]: Reloading... machine # [ 53.033918] systemd[629]: Reloading finished in 68 ms. machine # [ 53.039857] systemd[629]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 53.046071] systemd[629]: Stopped Run user-specific NixOS activation. machine # [ 53.048039] systemd[629]: Stopping Run user-specific NixOS activation... machine # [ 53.049588] systemd[629]: Starting Run user-specific NixOS activation... machine # [ 53.070072] systemd[629]: Finished Run user-specific NixOS activation. machine # [ 53.073222] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 53.074837] systemd[1]: Stopping Reactivate sysinit units... machine # [ 53.076057] systemd[1]: Reached target Reactivate sysinit units. machine # [ 53.077469] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 53.079136] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 53.083568] systemd[1]: Reached target Local File Systems. machine # [ 53.085423] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 53.088248] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 53.090145] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 53.091288] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 53.093318] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 53.094798] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 53.098128] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 53.100821] systemd[1]: Reached target Remote File Systems. machine # [ 53.229189] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 53.230834] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 53.235947] systemd[1]: Started autorestart.service. machine # [ 53.237937] systemd[1]: Starting linger-users.service... machine # [ 53.260990] systemd[1]: autorestart.service: Deactivated successfully. machine # [ 53.275475] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 53.277737] systemd[1]: Finished linger-users.service. machine # [ 53.535256] nixos[4477]: finished switching to system configuration /nix/store/mkiyl07hnqndk9y5kgpyyg4y1k412s00-nixos-system-machine-test machine: (finished: must succeed: /nix/store/18jsxirzz9yhwgfqrm1ha69kkxv7fbqn-nixos-system-machine-test/specialisation/autorestartService/bin/switch-to-configuration test 2>&1, in 1.42 seconds) machine # [ 53.579572] systemd[1]: Stopped autorestart.service. machine: must succeed: /nix/store/18jsxirzz9yhwgfqrm1ha69kkxv7fbqn-nixos-system-machine-test/specialisation/autorestartService/bin/switch-to-configuration test 2>&1 machine # [ 53.767640] nixos[4624]: switching to system configuration /nix/store/mkiyl07hnqndk9y5kgpyyg4y1k412s00-nixos-system-machine-test machine # [ 53.769958] systemd[1]: Stopped target Local File Systems. machine # [ 53.771515] systemd[1]: Stopped target Remote File Systems. machine # [ 53.977416] systemd[1]: Reload requested from client PID 4624 ('.switch-to-conf') (unit backdoor.service)... machine # [ 53.979200] systemd[1]: Reloading... machine # [ 54.208912] systemd[1]: Reloading finished in 228 ms. machine # [ 54.271379] systemd[629]: Reexecution requested from client PID 4693 ('switch-to-confi')... machine # [ 54.273503] systemd[629]: Reexecuting. machine # [ 54.294166] systemd[629]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 54.366299] systemd[629]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 54.371882] systemd[629]: Reload requested from client PID 4693 ('switch-to-confi')... machine # [ 54.374069] systemd[629]: Reloading... machine # [ 54.444332] systemd[629]: Reloading finished in 70 ms. machine # [ 54.449859] systemd[629]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 54.456146] systemd[629]: Stopped Run user-specific NixOS activation. machine # [ 54.458035] systemd[629]: Stopping Run user-specific NixOS activation... machine # [ 54.459602] systemd[629]: Starting Run user-specific NixOS activation... machine # [ 54.480877] systemd[629]: Finished Run user-specific NixOS activation. machine # [ 54.483939] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 54.485290] systemd[1]: Stopping Reactivate sysinit units... machine # [ 54.485995] systemd[1]: Reached target Reactivate sysinit units. machine # [ 54.490079] systemd[1]: Reached target Local File Systems. machine # [ 54.492318] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 54.495231] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 54.495968] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 54.498541] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 54.500565] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 54.501963] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 54.503249] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 54.507332] systemd[1]: Reached target Remote File Systems. machine # [ 54.513882] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 54.515281] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 54.640790] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 54.642545] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 54.646599] systemd[1]: Started autorestart.service. machine # [ 54.649819] systemd[1]: Starting linger-users.service... machine # [ 54.673974] systemd[1]: autorestart.service: Deactivated successfully. machine # [ 54.688579] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 54.690079] systemd[1]: Finished linger-users.service. machine # [ 54.948437] nixos[4624]: finished switching to system configuration /nix/store/mkiyl07hnqndk9y5kgpyyg4y1k412s00-nixos-system-machine-test machine: (finished: must succeed: /nix/store/18jsxirzz9yhwgfqrm1ha69kkxv7fbqn-nixos-system-machine-test/specialisation/autorestartService/bin/switch-to-configuration test 2>&1, in 1.37 seconds) machine # [ 54.995396] systemd[1]: Stopped autorestart.service. machine: must fail: /nix/store/18jsxirzz9yhwgfqrm1ha69kkxv7fbqn-nixos-system-machine-test/specialisation/autorestartServiceFailing/bin/switch-to-configuration test 2>&1 machine # [ 55.206301] nixos[4771]: switching to system configuration /nix/store/lil6q54v9iay19gn5q777d0qnscd2w74-nixos-system-machine-test machine # [ 55.208402] systemd[1]: Stopped target Local File Systems. machine # [ 55.210064] systemd[1]: Stopped target Remote File Systems. machine # [ 55.440468] systemd[1]: Reload requested from client PID 4771 ('.switch-to-conf') (unit backdoor.service)... machine # [ 55.442112] systemd[1]: Reloading... machine # [ 55.690853] systemd[1]: Reloading finished in 246 ms. machine # [ 55.754425] systemd[629]: Reexecution requested from client PID 4840 ('switch-to-confi')... machine # [ 55.757255] systemd[629]: Reexecuting. machine # [ 55.777226] systemd[629]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 55.848256] systemd[629]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 55.853691] systemd[629]: Reload requested from client PID 4840 ('switch-to-confi')... machine # [ 55.855140] systemd[629]: Reloading... machine # [ 55.924594] systemd[629]: Reloading finished in 68 ms. machine # [ 55.929844] systemd[629]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 55.936317] systemd[629]: Stopped Run user-specific NixOS activation. machine # [ 55.938088] systemd[629]: Stopping Run user-specific NixOS activation... machine # [ 55.940246] systemd[629]: Starting Run user-specific NixOS activation... machine # [ 55.963558] systemd[629]: Finished Run user-specific NixOS activation. machine # [ 55.966967] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 55.968501] systemd[1]: Stopping Reactivate sysinit units... machine # [ 55.969860] systemd[1]: Reached target Reactivate sysinit units. machine # [ 55.973454] systemd[1]: Reached target Remote File Systems. machine # [ 55.976509] systemd[1]: Started autorestart.service. machine # [ 55.980903] systemd[1]: Starting linger-users.service... machine # [ 55.987699] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 55.989207] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 55.991968] systemd[1]: Reached target Local File Systems. machine # [ 55.997680] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 56.003057] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 56.003962] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 56.007750] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 56.010949] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 56.016656] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 56.017913] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 56.039890] systemd[1]: autorestart.service: Main process exited, code=exited, status=1/FAILURE machine # [ 56.041948] systemd[1]: autorestart.service: Failed with result 'exit-code'. machine # [ 56.066612] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 56.069273] systemd[1]: Finished linger-users.service. machine # [ 56.180215] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 56.182078] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 56.448667] nixos[4771]: switching to system configuration /nix/store/lil6q54v9iay19gn5q777d0qnscd2w74-nixos-system-machine-test failed (status 4) machine: (finished: must fail: /nix/store/18jsxirzz9yhwgfqrm1ha69kkxv7fbqn-nixos-system-machine-test/specialisation/autorestartServiceFailing/bin/switch-to-configuration test 2>&1, in 1.45 seconds) (finished: subtest: failing units, in 7.12 seconds) subtest: unit file parser machine: must succeed: /nix/store/18jsxirzz9yhwgfqrm1ha69kkxv7fbqn-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1 machine # [ 56.620216] nixos[4914]: switching to system configuration /nix/store/8131w7sc2qqkqf77a82bfd6svi0ph4l0-nixos-system-machine-test machine # [ 56.622896] systemd[1]: Stopped target Local File Systems. machine # [ 56.624947] systemd[1]: Stopped autorestart.service. machine # [ 56.626446] systemd[1]: Stopped target Remote File Systems. machine # [ 56.846591] systemd[1]: Reload requested from client PID 4914 ('.switch-to-conf') (unit backdoor.service)... machine # [ 56.848648] systemd[1]: Reloading... machine # [ 57.108331] systemd[1]: Reloading finished in 258 ms. machine # [ 57.179450] systemd[629]: Reexecution requested from client PID 4983 ('switch-to-confi')... machine # [ 57.182840] systemd[629]: Reexecuting. machine # [ 57.207398] systemd[629]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 57.278220] systemd[629]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 57.283877] systemd[629]: Reload requested from client PID 4983 ('switch-to-confi')... machine # [ 57.285108] systemd[629]: Reloading... machine # [ 57.360365] systemd[629]: Reloading finished in 74 ms. machine # [ 57.365873] systemd[629]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 57.372252] systemd[629]: Stopped Run user-specific NixOS activation. machine # [ 57.374055] systemd[629]: Stopping Run user-specific NixOS activation... machine # [ 57.375822] systemd[629]: Starting Run user-specific NixOS activation... machine # [ 57.396403] systemd[629]: Finished Run user-specific NixOS activation. machine # [ 57.399530] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 57.400796] systemd[1]: Stopping Reactivate sysinit units... machine # [ 57.401802] systemd[1]: Reached target Reactivate sysinit units. machine # [ 57.404057] systemd[1]: Reached target Remote File Systems. machine # [ 57.407115] systemd[1]: Starting linger-users.service... machine # [ 57.409669] systemd[1]: Starting test.service... machine # [ 57.417651] systemd[1]: Reached target Local File Systems. machine # [ 57.418490] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 57.419684] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 57.425274] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 57.428813] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 57.430395] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 57.431516] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 57.433429] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 57.434894] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 57.436108] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 57.463861] systemd[1]: Finished test.service. machine # [ 57.487684] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 57.489612] systemd[1]: Finished linger-users.service. machine # [ 57.595592] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 57.597559] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 57.852337] nixos[4914]: finished switching to system configuration /nix/store/8131w7sc2qqkqf77a82bfd6svi0ph4l0-nixos-system-machine-test machine: (finished: must succeed: /nix/store/18jsxirzz9yhwgfqrm1ha69kkxv7fbqn-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1, in 1.40 seconds) machine: must succeed: /nix/store/18jsxirzz9yhwgfqrm1ha69kkxv7fbqn-nixos-system-machine-test/specialisation/simpleServiceWithExtraSection/bin/switch-to-configuration test 2>&1 machine # [ 58.062728] nixos[5056]: switching to system configuration /nix/store/0x66byn44m33jhlv1k9fw486b50nhy11-nixos-system-machine-test machine # [ 58.065948] systemd[1]: Stopped target Local File Systems. machine # [ 58.068183] systemd[1]: Stopped target Remote File Systems. machine # [ 58.285467] systemd[1]: Reload requested from client PID 5056 ('.switch-to-conf') (unit backdoor.service)... machine # [ 58.287292] systemd[1]: Reloading... machine # [ 58.512221] systemd[1]: Reloading finished in 223 ms. machine # [ 58.582300] systemd[629]: Reexecution requested from client PID 5125 ('switch-to-confi')... machine # [ 58.584565] systemd[629]: Reexecuting. machine # [ 58.605159] systemd[629]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 58.683948] systemd[629]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 58.689299] systemd[629]: Reload requested from client PID 5125 ('switch-to-confi')... machine # [ 58.690794] systemd[629]: Reloading... machine # [ 58.766446] systemd[629]: Reloading finished in 74 ms. machine # [ 58.771846] systemd[629]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 58.779066] systemd[629]: Stopped Run user-specific NixOS activation. machine # [ 58.780023] systemd[629]: Stopping Run user-specific NixOS activation... machine # [ 58.781927] systemd[629]: Starting Run user-specific NixOS activation... machine # [ 58.802227] systemd[629]: Finished Run user-specific NixOS activation. machine # [ 58.805321] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 58.806608] systemd[1]: Stopping Reactivate sysinit units... machine # [ 58.807694] systemd[1]: Reached target Reactivate sysinit units. machine # [ 58.809372] systemd[1]: test.service: Deactivated successfully. machine # [ 58.811291] systemd[1]: Stopped test.service. machine # [ 58.811901] systemd[1]: Stopping test.service... machine # [ 58.813850] systemd[1]: Starting test.service... machine # [ 58.827725] systemd[1]: Finished test.service. machine # [ 58.831982] systemd[1]: Reached target Local File Systems. machine # [ 58.833992] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 58.836770] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 58.837611] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 58.838769] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 58.840779] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 58.844493] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 58.846391] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 58.849537] systemd[1]: Reached target Remote File Systems. machine # [ 58.850446] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 58.851649] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 58.982273] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 58.983932] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 58.987823] systemd[1]: Starting linger-users.service... machine # [ 59.019040] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 59.020495] systemd[1]: Finished linger-users.service. machine # [ 59.278136] nixos[5056]: finished switching to system configuration /nix/store/0x66byn44m33jhlv1k9fw486b50nhy11-nixos-system-machine-test machine: (finished: must succeed: /nix/store/18jsxirzz9yhwgfqrm1ha69kkxv7fbqn-nixos-system-machine-test/specialisation/simpleServiceWithExtraSection/bin/switch-to-configuration test 2>&1, in 1.43 seconds) machine: must succeed: /nix/store/18jsxirzz9yhwgfqrm1ha69kkxv7fbqn-nixos-system-machine-test/specialisation/simpleServiceWithExtraSectionOtherName/bin/switch-to-configuration test 2>&1 machine # [ 59.510503] nixos[5198]: switching to system configuration /nix/store/mcgj465z3dgwls6vgbyf08qlzaba5vb6-nixos-system-machine-test machine # [ 59.514205] systemd[1]: Stopped target Local File Systems. machine # [ 59.515192] systemd[1]: Stopped target Remote File Systems. machine # [ 59.749975] systemd[1]: Reload requested from client PID 5198 ('.switch-to-conf') (unit backdoor.service)... machine # [ 59.751694] systemd[1]: Reloading... machine # [ 60.003028] systemd[1]: Reloading finished in 249 ms. machine # [ 60.074591] systemd[629]: Reexecution requested from client PID 5267 ('switch-to-confi')... machine # [ 60.076116] systemd[629]: Reexecuting. machine # [ 60.097384] systemd[629]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 60.174497] systemd[629]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 60.179859] systemd[629]: Reload requested from client PID 5267 ('switch-to-confi')... machine # [ 60.181199] systemd[629]: Reloading... machine # [ 60.256847] systemd[629]: Reloading finished in 74 ms. machine # [ 60.261860] systemd[629]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 60.268775] systemd[629]: Stopped Run user-specific NixOS activation. machine # [ 60.269716] systemd[629]: Stopping Run user-specific NixOS activation... machine # [ 60.271484] systemd[629]: Starting Run user-specific NixOS activation... machine # [ 60.291269] systemd[629]: Finished Run user-specific NixOS activation. machine # [ 60.295092] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 60.295954] systemd[1]: Stopping Reactivate sysinit units... machine # [ 60.297150] systemd[1]: Reached target Reactivate sysinit units. machine # [ 60.298898] systemd[1]: test.service: Deactivated successfully. machine # [ 60.300203] systemd[1]: Stopped test.service. machine # [ 60.300818] systemd[1]: Stopping test.service... machine # [ 60.303139] systemd[1]: Starting test.service... machine # [ 60.317405] systemd[1]: Finished test.service. machine # [ 60.320362] systemd[1]: Reached target Local File Systems. machine # [ 60.322277] systemd[1]: Reached target Remote File Systems. machine # [ 60.327458] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 60.329613] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 60.333112] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 60.336748] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 60.337640] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 60.338872] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 60.340979] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 60.342517] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 60.343750] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 60.476639] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 60.479277] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 60.482232] systemd[1]: Starting linger-users.service... machine # [ 60.510382] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 60.511879] systemd[1]: Finished linger-users.service. machine # [ 60.769795] nixos[5198]: finished switching to system configuration /nix/store/mcgj465z3dgwls6vgbyf08qlzaba5vb6-nixos-system-machine-test machine: (finished: must succeed: /nix/store/18jsxirzz9yhwgfqrm1ha69kkxv7fbqn-nixos-system-machine-test/specialisation/simpleServiceWithExtraSectionOtherName/bin/switch-to-configuration test 2>&1, in 1.49 seconds) machine: must succeed: /nix/store/18jsxirzz9yhwgfqrm1ha69kkxv7fbqn-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1 machine # [ 60.987643] nixos[5340]: switching to system configuration /nix/store/8131w7sc2qqkqf77a82bfd6svi0ph4l0-nixos-system-machine-test machine # [ 60.990556] systemd[1]: Stopped target Remote File Systems. machine # [ 60.991807] systemd[1]: Stopped target Local File Systems. machine # [ 61.199334] systemd[1]: Reload requested from client PID 5340 ('.switch-to-conf') (unit backdoor.service)... machine # [ 61.200940] systemd[1]: Reloading... machine # [ 61.429742] systemd[1]: Reloading finished in 227 ms. machine # [ 61.496238] systemd[629]: Reexecution requested from client PID 5409 ('switch-to-confi')... machine # [ 61.497570] systemd[629]: Reexecuting. machine # [ 61.516980] systemd[629]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 61.597624] systemd[629]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 61.602741] systemd[629]: Reload requested from client PID 5409 ('switch-to-confi')... machine # [ 61.603970] systemd[629]: Reloading... machine # [ 61.675407] systemd[629]: Reloading finished in 69 ms. machine # [ 61.679860] systemd[629]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 61.685967] systemd[629]: Stopped Run user-specific NixOS activation. machine # [ 61.686914] systemd[629]: Stopping Run user-specific NixOS activation... machine # [ 61.689461] systemd[629]: Starting Run user-specific NixOS activation... machine # [ 61.709061] systemd[629]: Finished Run user-specific NixOS activation. machine # [ 61.712109] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 61.713364] systemd[1]: Stopping Reactivate sysinit units... machine # [ 61.714381] systemd[1]: Reached target Reactivate sysinit units. machine # [ 61.716186] systemd[1]: test.service: Deactivated successfully. machine # [ 61.718118] systemd[1]: Stopped test.service. machine # [ 61.718725] systemd[1]: Stopping test.service... machine # [ 61.720458] systemd[1]: Starting test.service... machine # [ 61.734560] systemd[1]: Finished test.service. machine # [ 61.738712] systemd[1]: Reached target Local File Systems. machine # [ 61.740349] systemd[1]: Reached target Remote File Systems. machine # [ 61.743316] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 61.747406] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 61.748876] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 61.750102] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 61.752019] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 61.753397] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 61.754628] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 61.760981] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 61.762518] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 61.886476] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 61.888220] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 61.891911] systemd[1]: Starting linger-users.service... machine # [ 61.919433] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 61.920911] systemd[1]: Finished linger-users.service. machine # [ 62.177597] nixos[5340]: finished switching to system configuration /nix/store/8131w7sc2qqkqf77a82bfd6svi0ph4l0-nixos-system-machine-test machine: (finished: must succeed: /nix/store/18jsxirzz9yhwgfqrm1ha69kkxv7fbqn-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1, in 1.41 seconds) machine: must succeed: /nix/store/18jsxirzz9yhwgfqrm1ha69kkxv7fbqn-nixos-system-machine-test/specialisation/simpleServiceWithInstallSection/bin/switch-to-configuration test 2>&1 machine # [ 62.409877] nixos[5482]: switching to system configuration /nix/store/k4va8s5vbnfazqgpyv05c5q3cpvxjnha-nixos-system-machine-test machine # [ 62.412385] systemd[1]: Stopped target Remote File Systems. machine # [ 62.414431] systemd[1]: Stopped target Local File Systems. machine # [ 62.643354] systemd[1]: Reload requested from client PID 5482 ('.switch-to-conf') (unit backdoor.service)... machine # [ 62.645147] systemd[1]: Reloading... machine # [ 62.882966] systemd[1]: Reloading finished in 236 ms. machine # [ 62.949564] systemd[629]: Reexecution requested from client PID 5551 ('switch-to-confi')... machine # [ 62.952060] systemd[629]: Reexecuting. machine # [ 62.973551] systemd[629]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 63.049074] systemd[629]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 63.054700] systemd[629]: Reload requested from client PID 5551 ('switch-to-confi')... machine # [ 63.056256] systemd[629]: Reloading... machine # [ 63.129977] systemd[629]: Reloading finished in 72 ms. machine # [ 63.135069] systemd[629]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 63.143208] systemd[629]: Stopped Run user-specific NixOS activation. machine # [ 63.145066] systemd[629]: Stopping Run user-specific NixOS activation... machine # [ 63.147902] systemd[629]: Starting Run user-specific NixOS activation... machine # [ 63.173720] systemd[629]: Finished Run user-specific NixOS activation. machine # [ 63.177096] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 63.178644] systemd[1]: Stopping Reactivate sysinit units... machine # [ 63.179777] systemd[1]: Reached target Reactivate sysinit units. machine # [ 63.181113] systemd[1]: Reached target Local File Systems. machine # [ 63.182507] systemd[1]: Reached target Remote File Systems. machine # [ 63.186922] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 63.188744] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 63.194060] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 63.196504] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 63.198277] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 63.200477] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 63.203374] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 63.207290] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 63.208527] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 63.335516] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 63.339268] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 63.341248] systemd[1]: Starting linger-users.service... machine # [ 63.368863] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 63.371260] systemd[1]: Finished linger-users.service. machine # [ 63.625030] nixos[5482]: finished switching to system configuration /nix/store/k4va8s5vbnfazqgpyv05c5q3cpvxjnha-nixos-system-machine-test machine: (finished: must succeed: /nix/store/18jsxirzz9yhwgfqrm1ha69kkxv7fbqn-nixos-system-machine-test/specialisation/simpleServiceWithInstallSection/bin/switch-to-configuration test 2>&1, in 1.44 seconds) machine: must succeed: /nix/store/18jsxirzz9yhwgfqrm1ha69kkxv7fbqn-nixos-system-machine-test/specialisation/simpleServiceWithExtraKey/bin/switch-to-configuration test 2>&1 machine # [ 63.823994] nixos[5622]: switching to system configuration /nix/store/lb8g2m1bz72m7kczpbrv6wlkdhcr0bfd-nixos-system-machine-test machine # [ 63.827588] systemd[1]: Stopped target Local File Systems. machine # [ 63.828637] systemd[1]: Stopped target Remote File Systems. machine # [ 64.050751] systemd[1]: Reload requested from client PID 5622 ('.switch-to-conf') (unit backdoor.service)... machine # [ 64.052439] systemd[1]: Reloading... machine # [ 64.298908] systemd[1]: Reloading finished in 245 ms. machine # [ 64.363260] systemd[629]: Reexecution requested from client PID 5691 ('switch-to-confi')... machine # [ 64.365893] systemd[629]: Reexecuting. machine # [ 64.389150] systemd[629]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 64.463489] systemd[629]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 64.468677] systemd[629]: Reload requested from client PID 5691 ('switch-to-confi')... machine # [ 64.469968] systemd[629]: Reloading... machine # [ 64.541323] systemd[629]: Reloading finished in 70 ms. machine # [ 64.546845] systemd[629]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 64.553537] systemd[629]: Stopped Run user-specific NixOS activation. machine # [ 64.554569] systemd[629]: Stopping Run user-specific NixOS activation... machine # [ 64.557036] systemd[629]: Starting Run user-specific NixOS activation... machine # [ 64.576187] systemd[629]: Finished Run user-specific NixOS activation. machine # [ 64.579385] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 64.580706] systemd[1]: Stopping Reactivate sysinit units... machine # [ 64.581783] systemd[1]: Reached target Reactivate sysinit units. machine # [ 64.583495] systemd[1]: test.service: Deactivated successfully. machine # [ 64.585329] systemd[1]: Stopped test.service. machine # [ 64.585926] systemd[1]: Stopping test.service... machine # [ 64.587803] systemd[1]: Starting test.service... machine # [ 64.601620] systemd[1]: Finished test.service. machine # [ 64.608295] systemd[1]: Reached target Local File Systems. machine # [ 64.611769] systemd[1]: Reached target Remote File Systems. machine # [ 64.613313] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 64.615394] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 64.617580] systemd[1]: Starting linger-users.service... machine # [ 64.619622] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 64.625613] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 64.626462] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 64.627622] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 64.629617] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 64.631106] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 64.632269] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 64.673847] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 64.675839] systemd[1]: Finished linger-users.service. machine # [ 64.781627] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 64.783297] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 65.041613] nixos[5622]: finished switching to system configuration /nix/store/lb8g2m1bz72m7kczpbrv6wlkdhcr0bfd-nixos-system-machine-test machine: (finished: must succeed: /nix/store/18jsxirzz9yhwgfqrm1ha69kkxv7fbqn-nixos-system-machine-test/specialisation/simpleServiceWithExtraKey/bin/switch-to-configuration test 2>&1, in 1.42 seconds) machine: must succeed: /nix/store/18jsxirzz9yhwgfqrm1ha69kkxv7fbqn-nixos-system-machine-test/specialisation/simpleServiceWithExtraKeyOtherValue/bin/switch-to-configuration test 2>&1 machine # [ 65.290451] nixos[5764]: switching to system configuration /nix/store/5xyf0xdlf0iaq5z25xj0jfqs7pzkqi5q-nixos-system-machine-test machine # [ 65.292792] systemd[1]: Stopped target Remote File Systems. machine # [ 65.294827] systemd[1]: Stopped target Local File Systems. machine # [ 65.520218] systemd[1]: Reload requested from client PID 5764 ('.switch-to-conf') (unit backdoor.service)... machine # [ 65.521848] systemd[1]: Reloading... machine # [ 65.764845] systemd[1]: Reloading finished in 241 ms. machine # [ 65.827269] systemd[629]: Reexecution requested from client PID 5833 ('switch-to-confi')... machine # [ 65.828478] systemd[629]: Reexecuting. machine # [ 65.849188] systemd[629]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 65.925649] systemd[629]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 65.931705] systemd[629]: Reload requested from client PID 5833 ('switch-to-confi')... machine # [ 65.933148] systemd[629]: Reloading... machine # [ 66.006228] systemd[629]: Reloading finished in 71 ms. machine # [ 66.011846] systemd[629]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 66.018087] systemd[629]: Stopped Run user-specific NixOS activation. machine # [ 66.019922] systemd[629]: Stopping Run user-specific NixOS activation... machine # [ 66.021525] systemd[629]: Starting Run user-specific NixOS activation... machine # [ 66.040719] systemd[629]: Finished Run user-specific NixOS activation. machine # [ 66.043800] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 66.045176] systemd[1]: Stopping Reactivate sysinit units... machine # [ 66.045917] systemd[1]: Reached target Reactivate sysinit units. machine # [ 66.047846] systemd[1]: test.service: Deactivated successfully. machine # [ 66.049297] systemd[1]: Stopped test.service. machine # [ 66.049894] systemd[1]: Stopping test.service... machine # [ 66.051957] systemd[1]: Starting test.service... machine # [ 66.065850] systemd[1]: Finished test.service. machine # [ 66.068139] systemd[1]: Reached target Remote File Systems. machine # [ 66.071500] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 66.073199] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 66.077415] systemd[1]: Reached target Local File Systems. machine # [ 66.079154] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 66.082346] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 66.083838] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 66.085028] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 66.086978] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 66.088510] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 66.089686] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 66.221955] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 66.223672] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 66.227650] systemd[1]: Starting linger-users.service... machine # [ 66.253433] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 66.255076] systemd[1]: Finished linger-users.service. machine # [ 66.512328] nixos[5764]: finished switching to system configuration /nix/store/5xyf0xdlf0iaq5z25xj0jfqs7pzkqi5q-nixos-system-machine-test machine: (finished: must succeed: /nix/store/18jsxirzz9yhwgfqrm1ha69kkxv7fbqn-nixos-system-machine-test/specialisation/simpleServiceWithExtraKeyOtherValue/bin/switch-to-configuration test 2>&1, in 1.47 seconds) machine: must succeed: /nix/store/18jsxirzz9yhwgfqrm1ha69kkxv7fbqn-nixos-system-machine-test/specialisation/simpleServiceWithExtraKeyOtherName/bin/switch-to-configuration test 2>&1 machine # [ 66.777677] nixos[5906]: switching to system configuration /nix/store/l2z49l0mf4lkkcq0sdrfvnpa0i7c09if-nixos-system-machine-test machine # [ 66.780140] systemd[1]: Stopped target Remote File Systems. machine # [ 66.782167] systemd[1]: Stopped target Local File Systems. machine # [ 67.006656] systemd[1]: Reload requested from client PID 5906 ('.switch-to-conf') (unit backdoor.service)... machine # [ 67.008365] systemd[1]: Reloading... machine # [ 67.252225] systemd[1]: Reloading finished in 242 ms. machine # [ 67.314541] systemd[629]: Reexecution requested from client PID 5975 ('switch-to-confi')... machine # [ 67.317179] systemd[629]: Reexecuting. machine # [ 67.337989] systemd[629]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 67.411294] systemd[629]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 67.416539] systemd[629]: Reload requested from client PID 5975 ('switch-to-confi')... machine # [ 67.417744] systemd[629]: Reloading... machine # [ 67.489395] systemd[629]: Reloading finished in 69 ms. machine # [ 67.493854] systemd[629]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 67.500318] systemd[629]: Stopped Run user-specific NixOS activation. machine # [ 67.501393] systemd[629]: Stopping Run user-specific NixOS activation... machine # [ 67.503859] systemd[629]: Starting Run user-specific NixOS activation... machine # [ 67.523267] systemd[629]: Finished Run user-specific NixOS activation. machine # [ 67.526361] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 67.527739] systemd[1]: Stopping Reactivate sysinit units... machine # [ 67.529385] systemd[1]: Reached target Reactivate sysinit units. machine # [ 67.530638] systemd[1]: test.service: Deactivated successfully. machine # [ 67.532287] systemd[1]: Stopped test.service. machine # [ 67.532944] systemd[1]: Stopping test.service... machine # [ 67.534981] systemd[1]: Starting test.service... machine # [ 67.549420] systemd[1]: Finished test.service. machine # [ 67.553758] systemd[1]: Reached target Local File Systems. machine # [ 67.555338] systemd[1]: Reached target Remote File Systems. machine # [ 67.556915] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 67.559236] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 67.561079] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 67.562727] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 67.566160] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 67.567678] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 67.570058] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 67.577587] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 67.579540] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 67.705437] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 67.707299] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 67.710952] systemd[1]: Starting linger-users.service... machine # [ 67.739220] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 67.740771] systemd[1]: Finished linger-users.service. machine # [ 67.998264] nixos[5906]: finished switching to system configuration /nix/store/l2z49l0mf4lkkcq0sdrfvnpa0i7c09if-nixos-system-machine-test machine: (finished: must succeed: /nix/store/18jsxirzz9yhwgfqrm1ha69kkxv7fbqn-nixos-system-machine-test/specialisation/simpleServiceWithExtraKeyOtherName/bin/switch-to-configuration test 2>&1, in 1.48 seconds) machine: must succeed: /nix/store/18jsxirzz9yhwgfqrm1ha69kkxv7fbqn-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1 machine # [ 68.210168] nixos[6048]: switching to system configuration /nix/store/8131w7sc2qqkqf77a82bfd6svi0ph4l0-nixos-system-machine-test machine # [ 68.212601] systemd[1]: Stopped target Local File Systems. machine # [ 68.214450] systemd[1]: Stopped target Remote File Systems. machine # [ 68.423478] systemd[1]: Reload requested from client PID 6048 ('.switch-to-conf') (unit backdoor.service)... machine # [ 68.425161] systemd[1]: Reloading... machine # [ 68.658679] systemd[1]: Reloading finished in 231 ms. machine # [ 68.719362] systemd[629]: Reexecution requested from client PID 6117 ('switch-to-confi')... machine # [ 68.720646] systemd[629]: Reexecuting. machine # [ 68.741353] systemd[629]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 68.811745] systemd[629]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 68.816958] systemd[629]: Reload requested from client PID 6117 ('switch-to-confi')... machine # [ 68.818349] systemd[629]: Reloading... machine # [ 68.888718] systemd[629]: Reloading finished in 69 ms. machine # [ 68.893891] systemd[629]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 68.899831] systemd[629]: Stopped Run user-specific NixOS activation. machine # [ 68.900879] systemd[629]: Stopping Run user-specific NixOS activation... machine # [ 68.903587] systemd[629]: Starting Run user-specific NixOS activation... machine # [ 68.922966] systemd[629]: Finished Run user-specific NixOS activation. machine # [ 68.925945] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 68.927361] systemd[1]: Stopping Reactivate sysinit units... machine # [ 68.928401] systemd[1]: Reached target Reactivate sysinit units. machine # [ 68.930239] systemd[1]: test.service: Deactivated successfully. machine # [ 68.932287] systemd[1]: Stopped test.service. machine # [ 68.932891] systemd[1]: Stopping test.service... machine # [ 68.934595] systemd[1]: Starting test.service... machine # [ 68.948312] systemd[1]: Finished test.service. machine # [ 68.952447] systemd[1]: Reached target Local File Systems. machine # [ 68.955260] systemd[1]: Reached target Remote File Systems. machine # [ 68.959191] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 68.962269] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 68.963766] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 68.965035] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 68.966934] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 68.968440] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 68.969684] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 68.975402] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 68.976646] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 69.103058] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 69.107176] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 69.109179] systemd[1]: Starting linger-users.service... machine # [ 69.136795] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 69.138919] systemd[1]: Finished linger-users.service. machine # [ 69.395952] nixos[6048]: finished switching to system configuration /nix/store/8131w7sc2qqkqf77a82bfd6svi0ph4l0-nixos-system-machine-test machine: (finished: must succeed: /nix/store/18jsxirzz9yhwgfqrm1ha69kkxv7fbqn-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1, in 1.40 seconds) machine: must succeed: /nix/store/18jsxirzz9yhwgfqrm1ha69kkxv7fbqn-nixos-system-machine-test/specialisation/simpleServiceReloadTrigger/bin/switch-to-configuration test 2>&1 machine # [ 69.621711] nixos[6190]: switching to system configuration /nix/store/wjqi2z5c6nk5lxviz7rrfvv53vy7lqr8-nixos-system-machine-test machine # [ 69.624434] systemd[1]: Stopped target Local File Systems. machine # [ 69.626231] systemd[1]: Stopped target Remote File Systems. machine # [ 69.854858] systemd[1]: Reload requested from client PID 6190 ('.switch-to-conf') (unit backdoor.service)... machine # [ 69.856570] systemd[1]: Reloading... machine # [ 70.097148] systemd[1]: Reloading finished in 238 ms. machine # [ 70.160370] systemd[629]: Reexecution requested from client PID 6259 ('switch-to-confi')... machine # [ 70.162622] systemd[629]: Reexecuting. machine # [ 70.184039] systemd[629]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 70.254303] systemd[629]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 70.259770] systemd[629]: Reload requested from client PID 6259 ('switch-to-confi')... machine # [ 70.261119] systemd[629]: Reloading... machine # [ 70.337897] systemd[629]: Reloading finished in 75 ms. machine # [ 70.342849] systemd[629]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 70.348962] systemd[629]: Stopped Run user-specific NixOS activation. machine # [ 70.349960] systemd[629]: Stopping Run user-specific NixOS activation... machine # [ 70.352669] systemd[629]: Starting Run user-specific NixOS activation... machine # [ 70.374800] systemd[629]: Finished Run user-specific NixOS activation. machine # [ 70.378081] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 70.379481] systemd[1]: Stopping Reactivate sysinit units... machine # [ 70.380596] systemd[1]: Reached target Reactivate sysinit units. machine # [ 70.383842] systemd[1]: Reloading test.service... machine # [ 70.400203] systemd[1]: Reloaded test.service. machine # [ 70.405536] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 70.407249] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 70.413146] systemd[1]: Reached target Remote File Systems. machine # [ 70.414791] systemd[1]: Starting linger-users.service... machine # [ 70.418399] systemd[1]: Reached target Local File Systems. machine # [ 70.423416] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 70.426310] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 70.427469] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 70.428656] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 70.430706] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 70.432174] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 70.433328] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 70.477120] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 70.478333] systemd[1]: Finished linger-users.service. machine # [ 70.590172] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 70.591879] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 70.850403] nixos[6190]: finished switching to system configuration /nix/store/wjqi2z5c6nk5lxviz7rrfvv53vy7lqr8-nixos-system-machine-test machine: (finished: must succeed: /nix/store/18jsxirzz9yhwgfqrm1ha69kkxv7fbqn-nixos-system-machine-test/specialisation/simpleServiceReloadTrigger/bin/switch-to-configuration test 2>&1, in 1.45 seconds) machine: must succeed: /nix/store/18jsxirzz9yhwgfqrm1ha69kkxv7fbqn-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModified/bin/switch-to-configuration test 2>&1 machine # [ 71.077892] nixos[6332]: switching to system configuration /nix/store/cwxmvr4zssizibdc2r9pz6z8690amgcs-nixos-system-machine-test machine # [ 71.081582] systemd[1]: Stopped target Remote File Systems. machine # [ 71.082798] systemd[1]: Stopped target Local File Systems. machine # [ 71.311367] systemd[1]: Reload requested from client PID 6332 ('.switch-to-conf') (unit backdoor.service)... machine # [ 71.313097] systemd[1]: Reloading... machine # [ 71.572810] systemd[1]: Reloading finished in 257 ms. machine # [ 71.636667] systemd[629]: Reexecution requested from client PID 6401 ('switch-to-confi')... machine # [ 71.638721] systemd[629]: Reexecuting. machine # [ 71.660219] systemd[629]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 71.732036] systemd[629]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 71.738116] systemd[629]: Reload requested from client PID 6401 ('switch-to-confi')... machine # [ 71.739927] systemd[629]: Reloading... machine # [ 71.813620] systemd[629]: Reloading finished in 72 ms. machine # [ 71.817849] systemd[629]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 71.824110] systemd[629]: Stopped Run user-specific NixOS activation. machine # [ 71.825171] systemd[629]: Stopping Run user-specific NixOS activation... machine # [ 71.827702] systemd[629]: Starting Run user-specific NixOS activation... machine # [ 71.849174] systemd[629]: Finished Run user-specific NixOS activation. machine # [ 71.852353] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 71.853626] systemd[1]: Stopping Reactivate sysinit units... machine # [ 71.854652] systemd[1]: Reached target Reactivate sysinit units. machine # [ 71.857936] systemd[1]: Reloading test.service... machine # [ 71.871632] systemd[1]: Reloaded test.service. machine # [ 71.875304] systemd[1]: Reached target Local File Systems. machine # [ 71.877392] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 71.879674] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 71.881505] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 71.883598] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 71.886384] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 71.887933] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 71.890318] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 71.892617] systemd[1]: Reached target Remote File Systems. machine # [ 71.901574] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 71.903417] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 72.028273] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 72.029920] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 72.033774] systemd[1]: Starting linger-users.service... machine # [ 72.061874] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 72.063456] systemd[1]: Finished linger-users.service. machine # [ 72.321387] nixos[6332]: finished switching to system configuration /nix/store/cwxmvr4zssizibdc2r9pz6z8690amgcs-nixos-system-machine-test machine: (finished: must succeed: /nix/store/18jsxirzz9yhwgfqrm1ha69kkxv7fbqn-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModified/bin/switch-to-configuration test 2>&1, in 1.47 seconds) machine: must succeed: /nix/store/18jsxirzz9yhwgfqrm1ha69kkxv7fbqn-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModifiedAndSomethingElse/bin/switch-to-configuration test 2>&1 machine # [ 72.549743] nixos[6474]: switching to system configuration /nix/store/7p79whpdzz8ci62z4gx0v729bxbvwsdh-nixos-system-machine-test machine # [ 72.552478] systemd[1]: Stopped target Local File Systems. machine # [ 72.554192] systemd[1]: Stopped target Remote File Systems. machine # [ 72.785656] systemd[1]: Reload requested from client PID 6474 ('.switch-to-conf') (unit backdoor.service)... machine # [ 72.787386] systemd[1]: Reloading... machine # [ 73.031099] systemd[1]: Reloading finished in 242 ms. machine # [ 73.090871] systemd[629]: Reexecution requested from client PID 6543 ('switch-to-confi')... machine # [ 73.093414] systemd[629]: Reexecuting. machine # [ 73.113983] systemd[629]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 73.180928] systemd[629]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 73.186283] systemd[629]: Reload requested from client PID 6543 ('switch-to-confi')... machine # [ 73.187760] systemd[629]: Reloading... machine # [ 73.254633] systemd[629]: Reloading finished in 65 ms. machine # [ 73.259866] systemd[629]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 73.266052] systemd[629]: Stopped Run user-specific NixOS activation. machine # [ 73.267119] systemd[629]: Stopping Run user-specific NixOS activation... machine # [ 73.269721] systemd[629]: Starting Run user-specific NixOS activation... machine # [ 73.290478] systemd[629]: Finished Run user-specific NixOS activation. machine # [ 73.293614] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 73.294915] systemd[1]: Stopping Reactivate sysinit units... machine # [ 73.296378] systemd[1]: Reached target Reactivate sysinit units. machine # [ 73.297809] systemd[1]: test.service: Deactivated successfully. machine # [ 73.299079] systemd[1]: Stopped test.service. machine # [ 73.299672] systemd[1]: Stopping test.service... machine # [ 73.301844] systemd[1]: Starting test.service... machine # [ 73.315631] systemd[1]: Finished test.service. machine # [ 73.318751] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 73.320613] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 73.323377] systemd[1]: Reached target Local File Systems. machine # [ 73.325158] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 73.328239] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 73.330258] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 73.331748] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 73.333748] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 73.335230] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 73.338879] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 73.342472] systemd[1]: Reached target Remote File Systems. machine # [ 73.478953] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 73.480924] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 73.485100] systemd[1]: Starting linger-users.service... machine # [ 73.514396] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 73.515875] systemd[1]: Finished linger-users.service. machine # [ 73.773588] nixos[6474]: finished switching to system configuration /nix/store/7p79whpdzz8ci62z4gx0v729bxbvwsdh-nixos-system-machine-test machine: (finished: must succeed: /nix/store/18jsxirzz9yhwgfqrm1ha69kkxv7fbqn-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModifiedAndSomethingElse/bin/switch-to-configuration test 2>&1, in 1.45 seconds) machine: must succeed: /nix/store/18jsxirzz9yhwgfqrm1ha69kkxv7fbqn-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModifiedSomethingElse/bin/switch-to-configuration test 2>&1 machine # [ 73.979689] nixos[6616]: switching to system configuration /nix/store/lb8g2m1bz72m7kczpbrv6wlkdhcr0bfd-nixos-system-machine-test machine # [ 73.982598] systemd[1]: Stopped target Local File Systems. machine # [ 73.984434] systemd[1]: Stopped target Remote File Systems. machine # [ 74.193796] systemd[1]: Reload requested from client PID 6616 ('.switch-to-conf') (unit backdoor.service)... machine # [ 74.195477] systemd[1]: Reloading... machine # [ 74.426103] systemd[1]: Reloading finished in 228 ms. machine # [ 74.490408] systemd[629]: Reexecution requested from client PID 6685 ('switch-to-confi')... machine # [ 74.491747] systemd[629]: Reexecuting. machine # [ 74.513166] systemd[629]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 74.584279] systemd[629]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 74.590064] systemd[629]: Reload requested from client PID 6685 ('switch-to-confi')... machine # [ 74.591420] systemd[629]: Reloading... machine # [ 74.661605] systemd[629]: Reloading finished in 69 ms. machine # [ 74.666856] systemd[629]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 74.673408] systemd[629]: Stopped Run user-specific NixOS activation. machine # [ 74.674470] systemd[629]: Stopping Run user-specific NixOS activation... machine # [ 74.677255] systemd[629]: Starting Run user-specific NixOS activation... machine # [ 74.698958] systemd[629]: Finished Run user-specific NixOS activation. machine # [ 74.702100] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 74.703628] systemd[1]: Stopping Reactivate sysinit units... machine # [ 74.704772] systemd[1]: Reached target Reactivate sysinit units. machine # [ 74.706458] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 74.708152] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 74.710206] systemd[1]: Reached target Local File Systems. machine # [ 74.714986] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 74.719067] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 74.719916] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 74.721174] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 74.723172] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 74.724622] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 74.725839] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 74.730251] systemd[1]: Reached target Remote File Systems. machine # [ 74.862791] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 74.865149] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 74.868740] systemd[1]: Starting linger-users.service... machine # [ 74.897662] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 74.900100] systemd[1]: Finished linger-users.service. machine # [ 75.155595] nixos[6616]: finished switching to system configuration /nix/store/lb8g2m1bz72m7kczpbrv6wlkdhcr0bfd-nixos-system-machine-test machine: (finished: must succeed: /nix/store/18jsxirzz9yhwgfqrm1ha69kkxv7fbqn-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModifiedSomethingElse/bin/switch-to-configuration test 2>&1, in 1.38 seconds) (finished: subtest: unit file parser, in 18.71 seconds) subtest: restart and reload by activation script machine: must succeed: /nix/store/18jsxirzz9yhwgfqrm1ha69kkxv7fbqn-nixos-system-machine-test/specialisation/simpleServiceNorestart/bin/switch-to-configuration test 2>&1 machine # [ 75.366473] nixos[6756]: switching to system configuration /nix/store/5cjjk359dw7r00nqs2sdpjc4d9hgkj8s-nixos-system-machine-test machine # [ 75.368916] systemd[1]: Stopped target Local File Systems. machine # [ 75.370770] systemd[1]: Stopped target Remote File Systems. machine # [ 75.575390] systemd[1]: Reload requested from client PID 6756 ('.switch-to-conf') (unit backdoor.service)... machine # [ 75.576873] systemd[1]: Reloading... machine # [ 75.810237] systemd[1]: Reloading finished in 231 ms. machine # [ 75.872380] systemd[629]: Reexecution requested from client PID 6825 ('switch-to-confi')... machine # [ 75.874273] systemd[629]: Reexecuting. machine # [ 75.895193] systemd[629]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 75.965705] systemd[629]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 75.970913] systemd[629]: Reload requested from client PID 6825 ('switch-to-confi')... machine # [ 75.972329] systemd[629]: Reloading... machine # [ 76.042785] systemd[629]: Reloading finished in 69 ms. machine # [ 76.048841] systemd[629]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 76.054994] systemd[629]: Stopped Run user-specific NixOS activation. machine # [ 76.057074] systemd[629]: Stopping Run user-specific NixOS activation... machine # [ 76.058611] systemd[629]: Starting Run user-specific NixOS activation... machine # [ 76.079242] systemd[629]: Finished Run user-specific NixOS activation. machine # [ 76.082905] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 76.084220] systemd[1]: Stopping Reactivate sysinit units... machine # [ 76.084933] systemd[1]: Reached target Reactivate sysinit units. machine # [ 76.087909] systemd[1]: Reached target Remote File Systems. machine # [ 76.090526] systemd[1]: Starting linger-users.service... machine # [ 76.097190] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 76.098592] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 76.102293] systemd[1]: Reached target Local File Systems. machine # [ 76.104864] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 76.108394] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 76.110369] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 76.112715] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 76.115357] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 76.116731] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 76.117856] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 76.153976] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 76.155853] systemd[1]: Finished linger-users.service. machine # [ 76.267387] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 76.269099] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 76.527815] nixos[6756]: finished switching to system configuration /nix/store/5cjjk359dw7r00nqs2sdpjc4d9hgkj8s-nixos-system-machine-test machine: (finished: must succeed: /nix/store/18jsxirzz9yhwgfqrm1ha69kkxv7fbqn-nixos-system-machine-test/specialisation/simpleServiceNorestart/bin/switch-to-configuration test 2>&1, in 1.37 seconds) machine: must succeed: /nix/store/18jsxirzz9yhwgfqrm1ha69kkxv7fbqn-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration test 2>&1 machine # [ 76.760514] nixos[6896]: switching to system configuration /nix/store/p3wcv05g83i8g3bw3ayg29i2vnz5bcb5-nixos-system-machine-test machine # [ 76.763272] systemd[1]: Stopped target Local File Systems. machine # [ 76.764584] systemd[1]: test.service: Deactivated successfully. machine # [ 76.765858] systemd[1]: Stopped test.service. machine # [ 76.767232] systemd[1]: Stopped target Remote File Systems. machine # [ 77.012380] systemd[1]: Reload requested from client PID 6896 ('.switch-to-conf') (unit backdoor.service)... machine # [ 77.014115] systemd[1]: Reloading... machine # [ 77.269914] systemd[1]: Reloading finished in 254 ms. machine # [ 77.331389] systemd[629]: Reexecution requested from client PID 6967 ('switch-to-confi')... machine # [ 77.333292] systemd[629]: Reexecuting. machine # [ 77.355306] systemd[629]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 77.426872] systemd[629]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 77.433025] systemd[629]: Reload requested from client PID 6967 ('switch-to-confi')... machine # [ 77.434821] systemd[629]: Reloading... machine # [ 77.505610] systemd[629]: Reloading finished in 69 ms. machine # [ 77.510852] systemd[629]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 77.518062] systemd[629]: Stopped Run user-specific NixOS activation. machine # [ 77.518933] systemd[629]: Stopping Run user-specific NixOS activation... machine # [ 77.521233] systemd[629]: Starting Run user-specific NixOS activation... machine # [ 77.543763] systemd[629]: Finished Run user-specific NixOS activation. machine # [ 77.546935] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 77.548304] systemd[1]: Stopping Reactivate sysinit units... machine # [ 77.549379] systemd[1]: Reached target Reactivate sysinit units. machine # [ 77.552339] systemd[1]: Reached target Local File Systems. machine # [ 77.554337] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 77.556109] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 77.561861] systemd[1]: Created slice Slice /system/templated-simple-restart-service. machine # [ 77.564741] systemd[1]: Starting templated-simple-restart-service@instance.service... machine # [ 77.575969] systemd[1]: Created slice Slice /system/templated-simple-service. machine # [ 77.578100] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 77.581792] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 77.582645] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 77.585872] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 77.587983] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 77.589574] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 77.591864] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 77.596160] systemd[1]: Created slice Slice /system/templated-reload-triggers. machine # [ 77.598594] systemd[1]: Created slice Slice /system/templated-reload-triggers-and-restart. machine # [ 77.599716] systemd[1]: Reached target Remote File Systems. machine # [ 77.619115] systemd[1]: Finished templated-simple-restart-service@instance.service. machine # [ 77.625198] systemd[1]: Created slice Slice /system/templated-reload-triggers-and-restart-by-as. machine # [ 77.634031] systemd[1]: Created slice Slice /system/templated-simple-reload-service. machine # [ 77.641135] systemd[1]: Created slice Slice /system/templated-no-restart-service. machine # [ 77.753909] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 77.755647] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 77.759691] systemd[1]: Starting linger-users.service... machine # [ 77.764278] systemd[1]: Starting no-restart-service.service... machine # [ 77.766316] systemd[1]: Starting reload-triggers-and-restart-by-as.service... machine # [ 77.770657] systemd[1]: Starting reload-triggers-and-restart.service... machine # [ 77.776551] systemd[1]: Starting reload-triggers.service... machine # [ 77.783471] systemd[1]: Starting simple-reload-service.service... machine # [ 77.788518] systemd[1]: Starting simple-restart-service.service... machine # [ 77.793969] systemd[1]: Starting simple-service.service... machine # [ 77.799293] systemd[1]: Starting templated-no-restart-service@instance.service... machine # [ 77.807315] systemd[1]: Starting templated-reload-triggers-and-restart-by-as@instance.service... machine # [ 77.813172] systemd[1]: Starting templated-reload-triggers-and-restart@instance.service... machine # [ 77.814300] systemd[1]: Starting templated-reload-triggers@instance.service... machine # [ 77.815393] systemd[1]: Starting templated-simple-reload-service@instance.service... machine # [ 77.830853] systemd[1]: Starting templated-simple-service@instance.service... machine # [ 77.914783] systemd[1]: Finished no-restart-service.service. machine # [ 77.918280] systemd[1]: Finished reload-triggers-and-restart-by-as.service. machine # [ 77.923935] systemd[1]: Finished reload-triggers-and-restart.service. machine # [ 77.930596] systemd[1]: Finished simple-reload-service.service. machine # [ 77.931471] systemd[1]: Finished reload-triggers.service. machine # [ 77.948264] systemd[1]: Finished simple-restart-service.service. machine # [ 77.962637] systemd[1]: Finished simple-service.service. machine # [ 77.965402] systemd[1]: Finished templated-no-restart-service@instance.service. machine # [ 77.967964] systemd[1]: Finished templated-reload-triggers-and-restart-by-as@instance.service. machine # [ 77.970210] systemd[1]: Finished templated-reload-triggers-and-restart@instance.service. machine # [ 77.972526] systemd[1]: Finished templated-reload-triggers@instance.service. machine # [ 77.974492] systemd[1]: Finished templated-simple-reload-service@instance.service. machine # [ 77.976633] systemd[1]: Finished templated-simple-service@instance.service. machine # [ 77.989212] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 77.990651] systemd[1]: Finished linger-users.service. machine # [ 78.247664] nixos[6896]: finished switching to system configuration /nix/store/p3wcv05g83i8g3bw3ayg29i2vnz5bcb5-nixos-system-machine-test machine: (finished: must succeed: /nix/store/18jsxirzz9yhwgfqrm1ha69kkxv7fbqn-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration test 2>&1, in 1.72 seconds) machine: must succeed: /nix/store/18jsxirzz9yhwgfqrm1ha69kkxv7fbqn-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration test 2>&1 machine # [ 78.497093] nixos[7066]: switching to system configuration /nix/store/p3wcv05g83i8g3bw3ayg29i2vnz5bcb5-nixos-system-machine-test machine # [ 78.499395] systemd[1]: Stopped target Local File Systems. machine # [ 78.501053] systemd[1]: Stopped target Remote File Systems. machine # [ 78.724719] systemd[1]: Reload requested from client PID 7066 ('.switch-to-conf') (unit backdoor.service)... machine # [ 78.726390] systemd[1]: Reloading... machine # [ 78.977480] systemd[1]: Reloading finished in 249 ms. machine # [ 79.043469] systemd[629]: Reexecution requested from client PID 7137 ('switch-to-confi')... machine # [ 79.045250] systemd[629]: Reexecuting. machine # [ 79.065181] systemd[629]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 79.135771] systemd[629]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 79.141782] systemd[629]: Reload requested from client PID 7137 ('switch-to-confi')... machine # [ 79.143913] systemd[629]: Reloading... machine # [ 79.213486] systemd[629]: Reloading finished in 70 ms. machine # [ 79.218859] systemd[629]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 79.225146] systemd[629]: Stopped Run user-specific NixOS activation. machine # [ 79.227056] systemd[629]: Stopping Run user-specific NixOS activation... machine # [ 79.228673] systemd[629]: Starting Run user-specific NixOS activation... machine # [ 79.249147] systemd[629]: Finished Run user-specific NixOS activation. machine # [ 79.252278] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 79.253591] systemd[1]: Stopping Reactivate sysinit units... machine # [ 79.254517] systemd[1]: Reached target Reactivate sysinit units. machine # [ 79.259061] systemd[1]: Reloading reload-triggers-and-restart.service... machine # [ 79.263767] systemd[1]: Reloading reload-triggers.service... machine # [ 79.269385] systemd[1]: Reloading simple-reload-service.service... machine # [ 79.276753] systemd[1]: Reloading templated-reload-triggers-and-restart@instance.service... machine # [ 79.284601] systemd[1]: Reloading templated-reload-triggers@instance.service... machine # [ 79.287850] systemd[1]: Reloading templated-simple-reload-service@instance.service... machine # [ 79.325203] systemd[1]: Reloaded reload-triggers-and-restart.service. machine # [ 79.327193] systemd[1]: Reloaded reload-triggers.service. machine # [ 79.331173] systemd[1]: Reloaded simple-reload-service.service. machine # [ 79.342339] systemd[1]: Reloaded templated-reload-triggers-and-restart@instance.service. machine # [ 79.344682] systemd[1]: Reloaded templated-reload-triggers@instance.service. machine # [ 79.346857] systemd[1]: Reloaded templated-simple-reload-service@instance.service. machine # [ 79.350761] systemd[1]: reload-triggers-and-restart-by-as.service: Deactivated successfully. machine # [ 79.353244] systemd[1]: Stopped reload-triggers-and-restart-by-as.service. machine # [ 79.354157] systemd[1]: Stopping reload-triggers-and-restart-by-as.service... machine # [ 79.355832] systemd[1]: Starting reload-triggers-and-restart-by-as.service... machine # [ 79.358182] systemd[1]: simple-restart-service.service: Deactivated successfully. machine # [ 79.359195] systemd[1]: Stopped simple-restart-service.service. machine # [ 79.359959] systemd[1]: Stopping simple-restart-service.service... machine # [ 79.361739] systemd[1]: Starting simple-restart-service.service... machine # [ 79.364145] systemd[1]: simple-service.service: Deactivated successfully. machine # [ 79.367657] systemd[1]: Stopped simple-service.service. machine # [ 79.368460] systemd[1]: Stopping simple-service.service... machine # [ 79.369292] systemd[1]: Starting simple-service.service... machine # [ 79.374165] systemd[1]: templated-reload-triggers-and-restart-by-as@instance.service: Deactivated successfully. machine # [ 79.375512] systemd[1]: Stopped templated-reload-triggers-and-restart-by-as@instance.service. machine # [ 79.376737] systemd[1]: Stopping templated-reload-triggers-and-restart-by-as@instance.service... machine # [ 79.379066] systemd[1]: Starting templated-reload-triggers-and-restart-by-as@instance.service... machine # [ 79.382168] systemd[1]: templated-simple-restart-service@instance.service: Deactivated successfully. machine # [ 79.386296] systemd[1]: Stopped templated-simple-restart-service@instance.service. machine # [ 79.387299] systemd[1]: Stopping templated-simple-restart-service@instance.service... machine # [ 79.388302] systemd[1]: Starting templated-simple-restart-service@instance.service... machine # [ 79.392262] systemd[1]: templated-simple-service@instance.service: Deactivated successfully. machine # [ 79.395059] systemd[1]: Stopped templated-simple-service@instance.service. machine # [ 79.395967] systemd[1]: Stopping templated-simple-service@instance.service... machine # [ 79.400220] systemd[1]: Starting templated-simple-service@instance.service... machine # [ 79.443133] systemd[1]: Finished reload-triggers-and-restart-by-as.service. machine # [ 79.447263] systemd[1]: Finished simple-restart-service.service. machine # [ 79.449833] systemd[1]: Finished simple-service.service. machine # [ 79.454792] systemd[1]: Finished templated-reload-triggers-and-restart-by-as@instance.service. machine # [ 79.457319] systemd[1]: Finished templated-simple-restart-service@instance.service. machine # [ 79.459556] systemd[1]: Finished templated-simple-service@instance.service. machine # [ 79.465339] systemd[1]: Reached target Remote File Systems. machine # [ 79.471068] systemd[1]: Reached target Local File Systems. machine # [ 79.471862] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 79.475226] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 79.476655] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 79.477840] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 79.479932] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 79.481447] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 79.482607] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 79.487751] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 79.489024] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 79.618611] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 79.620440] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 79.624280] systemd[1]: Starting linger-users.service... machine # [ 79.652066] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 79.653132] systemd[1]: Finished linger-users.service. machine # [ 79.911356] nixos[7066]: finished switching to system configuration /nix/store/p3wcv05g83i8g3bw3ayg29i2vnz5bcb5-nixos-system-machine-test machine: (finished: must succeed: /nix/store/18jsxirzz9yhwgfqrm1ha69kkxv7fbqn-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration test 2>&1, in 1.66 seconds) machine: must succeed: /nix/store/18jsxirzz9yhwgfqrm1ha69kkxv7fbqn-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script-modified/bin/switch-to-configuration test 2>&1 machine # [ 80.184082] nixos[7232]: switching to system configuration /nix/store/fjnqmjwi880h835xmb613fv5y2kpzysh-nixos-system-machine-test machine # [ 80.187705] systemd[1]: Stopped target Local File Systems. machine # [ 80.188796] systemd[1]: Stopped target Remote File Systems. machine # [ 80.437902] systemd[1]: Reload requested from client PID 7232 ('.switch-to-conf') (unit backdoor.service)... machine # [ 80.439544] systemd[1]: Reloading... machine # [ 80.716172] systemd[1]: Reloading finished in 275 ms. machine # [ 80.786320] systemd[629]: Reexecution requested from client PID 7303 ('switch-to-confi')... machine # [ 80.788463] systemd[629]: Reexecuting. machine # [ 80.810217] systemd[629]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 80.885097] systemd[629]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 80.890061] systemd[629]: Reload requested from client PID 7303 ('switch-to-confi')... machine # [ 80.891722] systemd[629]: Reloading... machine # [ 80.965546] systemd[629]: Reloading finished in 72 ms. machine # [ 80.969886] systemd[629]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 80.976312] systemd[629]: Stopped Run user-specific NixOS activation. machine # [ 80.978118] systemd[629]: Stopping Run user-specific NixOS activation... machine # [ 80.979776] systemd[629]: Starting Run user-specific NixOS activation... machine # [ 81.002498] systemd[629]: Finished Run user-specific NixOS activation. machine # [ 81.005656] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 81.007259] systemd[1]: Stopping Reactivate sysinit units... machine # [ 81.008258] systemd[1]: Reached target Reactivate sysinit units. machine # [ 81.012197] systemd[1]: Reloading reload-triggers.service... machine # [ 81.016253] systemd[1]: Reloading simple-reload-service.service... machine # [ 81.022230] systemd[1]: Reloading templated-reload-triggers@instance.service... machine # [ 81.026190] systemd[1]: Reloading templated-simple-reload-service@instance.service... machine # [ 81.060721] systemd[1]: Reloaded simple-reload-service.service. machine # [ 81.063111] systemd[1]: Reloaded reload-triggers.service. machine # [ 81.065527] systemd[1]: Reloaded templated-reload-triggers@instance.service. machine # [ 81.069994] systemd[1]: Reloaded templated-simple-reload-service@instance.service. machine # [ 81.073108] systemd[1]: reload-triggers-and-restart-by-as.service: Deactivated successfully. machine # [ 81.075208] systemd[1]: Stopped reload-triggers-and-restart-by-as.service. machine # [ 81.076108] systemd[1]: Stopping reload-triggers-and-restart-by-as.service... machine # [ 81.078428] systemd[1]: Starting reload-triggers-and-restart-by-as.service... machine # [ 81.081114] systemd[1]: reload-triggers-and-restart.service: Deactivated successfully. machine # [ 81.082240] systemd[1]: Stopped reload-triggers-and-restart.service. machine # [ 81.083156] systemd[1]: Stopping reload-triggers-and-restart.service... machine # [ 81.087533] systemd[1]: Starting reload-triggers-and-restart.service... machine # [ 81.089065] systemd[1]: simple-restart-service.service: Deactivated successfully. machine # [ 81.090045] systemd[1]: Stopped simple-restart-service.service. machine # [ 81.090801] systemd[1]: Stopping simple-restart-service.service... machine # [ 81.096397] systemd[1]: Starting simple-restart-service.service... machine # [ 81.097314] systemd[1]: simple-service.service: Deactivated successfully. machine # [ 81.100177] systemd[1]: Stopped simple-service.service. machine # [ 81.100869] systemd[1]: Stopping simple-service.service... machine # [ 81.105763] systemd[1]: Starting simple-service.service... machine # [ 81.106899] systemd[1]: templated-reload-triggers-and-restart-by-as@instance.service: Deactivated successfully. machine # [ 81.114226] systemd[1]: Stopped templated-reload-triggers-and-restart-by-as@instance.service. machine # [ 81.115305] systemd[1]: Stopping templated-reload-triggers-and-restart-by-as@instance.service... machine # [ 81.116447] systemd[1]: Starting templated-reload-triggers-and-restart-by-as@instance.service... machine # [ 81.117570] systemd[1]: templated-reload-triggers-and-restart@instance.service: Deactivated successfully. machine # [ 81.118791] systemd[1]: Stopped templated-reload-triggers-and-restart@instance.service. machine # [ 81.119916] systemd[1]: Stopping templated-reload-triggers-and-restart@instance.service... machine # [ 81.130060] systemd[1]: Starting templated-reload-triggers-and-restart@instance.service... machine # [ 81.131245] systemd[1]: templated-simple-restart-service@instance.service: Deactivated successfully. machine # [ 81.132484] systemd[1]: Stopped templated-simple-restart-service@instance.service. machine # [ 81.133527] systemd[1]: Stopping templated-simple-restart-service@instance.service... machine # [ 81.134565] systemd[1]: Starting templated-simple-restart-service@instance.service... machine # [ 81.135562] systemd[1]: templated-simple-service@instance.service: Deactivated successfully. machine # [ 81.142955] systemd[1]: Stopped templated-simple-service@instance.service. machine # [ 81.143918] systemd[1]: Stopping templated-simple-service@instance.service... machine # [ 81.146505] systemd[1]: Starting templated-simple-service@instance.service... machine # [ 81.198959] systemd[1]: Finished simple-restart-service.service. machine # [ 81.204172] systemd[1]: Finished reload-triggers-and-restart.service. machine # [ 81.208140] systemd[1]: Finished reload-triggers-and-restart-by-as.service. machine # [ 81.208993] systemd[1]: Finished simple-service.service. machine # [ 81.214738] systemd[1]: Finished templated-reload-triggers-and-restart-by-as@instance.service. machine # [ 81.217142] systemd[1]: Finished templated-reload-triggers-and-restart@instance.service. machine # [ 81.220171] systemd[1]: Finished templated-simple-restart-service@instance.service. machine # [ 81.224727] systemd[1]: Finished templated-simple-service@instance.service. machine # [ 81.228955] systemd[1]: Reached target Remote File Systems. machine # [ 81.231597] systemd[1]: Starting linger-users.service... machine # [ 81.234477] systemd[1]: Reached target Local File Systems. machine # [ 81.236624] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 81.238916] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 81.241482] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 81.243184] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 81.247090] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 81.248596] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 81.249794] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 81.256413] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 81.257645] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 81.301466] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 81.303110] systemd[1]: Finished linger-users.service. machine # [ 81.414243] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 81.415964] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 81.673522] nixos[7232]: finished switching to system configuration /nix/store/fjnqmjwi880h835xmb613fv5y2kpzysh-nixos-system-machine-test machine: (finished: must succeed: /nix/store/18jsxirzz9yhwgfqrm1ha69kkxv7fbqn-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script-modified/bin/switch-to-configuration test 2>&1, in 1.76 seconds) machine: must succeed: /nix/store/18jsxirzz9yhwgfqrm1ha69kkxv7fbqn-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/18jsxirzz9yhwgfqrm1ha69kkxv7fbqn-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration dry-activate 2>&1, in 0.35 seconds) (finished: subtest: restart and reload by activation script, in 6.87 seconds) (finished: run the VM test script, in 83.01 seconds) test script finished in 83.16s cleanup kill QemuMachine (pid 45) machine # qemu-system-x86_64: terminating on signal 15 from pid 39 (/nix/store/lb41b0anx1f98y9y5s9mdv97gjgsq740-python3-3.14.7/bin/python3.14) machine # [2026-10-16T02:55:54Z INFO virtiofsd] Client disconnected, shutting down machine # [2026-10-16T02:55:54Z INFO virtiofsd] Client disconnected, shutting down machine # [2026-10-16T02:55:54Z INFO virtiofsd] Client disconnected, shutting down (finished: cleanup, in 0.20 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