tribuchet: building on jamie Machine state will be reset. To keep it, pass --keep-machine-state start all VLans (finished: start all VLans, in 0.00 seconds) Test will time out and terminate in 3600.0 seconds run the VM test script machine: waiting for unit multi-user.target machine: waiting for the VM to finish booting machine: starting vm machine # Disk image does not exist, creating the virtualisation disk image... machine: QEMU running (pid 45) machine # Formatting '/build/vm-state-machine/tmp.H2we5OxZIz', 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: 30f53e26-f621-4423-a3b2-e32981db1c89 machine # Superblock backups stored on blocks: machine # 32768, 98304, 163840, 229376 machine # machine # Allocating group tables: 0/8 done machine # Writing inode tables: 0/8 done machine # Creating journal (8192 blocks): done machine # Writing superblocks and filesystem accounting information: 0/8 done machine # machine # Virtualisation disk image created. machine # SeaBIOS (version rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org) machine # machine # machine # iPXE (http://ipxe.org) 00:02.0 CA00 PCI2.10 PnP PMM+3EFCC730+3EF2C730 CA00 machine # Press Ctrl-B to configure iPXE (PCI 00:02.0)... machine # machine # machine # machine # machine # iPXE (http://ipxe.org) 00:08.0 CB00 PCI2.10 PnP PMM 3EFCC730 3EF2C730 CB00 machine # Press Ctrl-B to configure iPXE (PCI 00:08.0)... machine # machine # machine # Booting from ROM... machine # Probing EDD (edd=off to disable)... o[ 0.000000] Linux version 6.18.48 (nixbld@localhost) (gcc (GCC) 15.3.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT_DYNAMIC Fri Aug 28 06:22:54 UTC 2026 machine # [ 0.000000] Command line: console=ttyS0 console=tty0 panic=1 boot.panic_on_fail clocksource=acpi_pm root=fstab loglevel=7 net.ifnames=0 lsm=landlock,yama,bpf init=/nix/store/35s2igiaaj5g08gc3r9xqcrxf6sx5fyq-nixos-system-machine-test/init regInfo=/nix/store/nh121gwnqf9zcz5bqp5kf9nw52hm490f-closure-info/registration console=ttyS0,115200n8 console=tty0 machine # [ 0.000000] BIOS-provided physical RAM map: machine # [ 0.000000] BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable machine # [ 0.000000] BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved machine # [ 0.000000] BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved machine # [ 0.000000] BIOS-e820: [mem 0x0000000000100000-0x000000003ffd7fff] usable machine # [ 0.000000] BIOS-e820: [mem 0x000000003ffd8000-0x000000003fffffff] reserved machine # [ 0.000000] BIOS-e820: [mem 0x00000000b0000000-0x00000000bfffffff] reserved machine # [ 0.000000] BIOS-e820: [mem 0x00000000fed1c000-0x00000000fed1ffff] reserved machine # [ 0.000000] BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved machine # [ 0.000000] BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved machine # [ 0.000000] BIOS-e820: [mem 0x000000fd00000000-0x000000ffffffffff] reserved machine # [ 0.000000] NX (Execute Disable) protection: active machine # [ 0.000000] APIC: Static calls initialized machine # [ 0.000000] SMBIOS 2.8 present. machine # [ 0.000000] DMI: QEMU Standard PC (Q35 + ICH9, 2009), BIOS rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org 04/01/2014 machine # [ 0.000000] DMI: Memory slots populated: 1/1 machine # [ 0.000000] Hypervisor detected: KVM machine # [ 0.000000] last_pfn = 0x3ffd8 max_arch_pfn = 0x10000000000 machine # [ 0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d00 machine # [ 0.000000] kvm-clock: using sched offset of 450019486 cycles machine # [ 0.000002] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns machine # [ 0.000005] tsc: Detected 2400.010 MHz processor machine # [ 0.000812] last_pfn = 0x3ffd8 max_arch_pfn = 0x10000000000 machine # [ 0.000838] MTRR map: 4 entries (3 fixed + 1 variable; max 19), built from 8 variable MTRRs machine # [ 0.000841] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT machine # [ 0.002739] found SMP MP-table at [mem 0x000f5450-0x000f545f] machine # [ 0.002750] Using GB pages for direct mapping machine # [ 0.002811] RAMDISK: [mem 0x3e429000-0x3ffcffff] machine # [ 0.002820] ACPI: Early table checksum verification disabled machine # [ 0.002823] ACPI: RSDP 0x00000000000F5270 000014 (v00 BOCHS ) machine # [ 0.002827] ACPI: RSDT 0x000000003FFE2422 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) machine # [ 0.002831] ACPI: FACP 0x000000003FFE221A 0000F4 (v03 BOCHS BXPC 00000001 BXPC 00000001) machine # [ 0.002838] ACPI: DSDT 0x000000003FFE0040 0021DA (v01 BOCHS BXPC 00000001 BXPC 00000001) machine # [ 0.002841] ACPI: FACS 0x000000003FFE0000 000040 machine # [ 0.002842] ACPI: APIC 0x000000003FFE230E 000078 (v03 BOCHS BXPC 00000001 BXPC 00000001) machine # [ 0.002844] ACPI: HPET 0x000000003FFE2386 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) machine # [ 0.002845] ACPI: MCFG 0x000000003FFE23BE 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001) machine # [ 0.002847] ACPI: WAET 0x000000003FFE23FA 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001) machine # [ 0.002848] ACPI: Reserving FACP table memory at [mem 0x3ffe221a-0x3ffe230d] machine # [ 0.002849] ACPI: Reserving DSDT table memory at [mem 0x3ffe0040-0x3ffe2219] machine # [ 0.002850] ACPI: Reserving FACS table memory at [mem 0x3ffe0000-0x3ffe003f] machine # [ 0.002850] ACPI: Reserving APIC table memory at [mem 0x3ffe230e-0x3ffe2385] machine # [ 0.002851] ACPI: Reserving HPET table memory at [mem 0x3ffe2386-0x3ffe23bd] machine # [ 0.002851] ACPI: Reserving MCFG table memory at [mem 0x3ffe23be-0x3ffe23f9] machine # [ 0.002851] ACPI: Reserving WAET table memory at [mem 0x3ffe23fa-0x3ffe2421] machine # [ 0.003069] No NUMA configuration found machine # [ 0.003070] Faking a node at [mem 0x0000000000000000-0x000000003ffd7fff] machine # [ 0.003073] NODE_DATA(0) allocated [mem 0x3ffd2780-0x3ffd7cff] machine # [ 0.005109] Zone ranges: machine # [ 0.005109] DMA [mem 0x0000000000001000-0x0000000000ffffff] machine # [ 0.005111] DMA32 [mem 0x0000000001000000-0x000000003ffd7fff] machine # [ 0.005112] Normal empty machine # [ 0.005113] Device empty machine # [ 0.005113] Movable zone start for each node machine # [ 0.005114] Early memory node ranges machine # [ 0.005114] node 0: [mem 0x0000000000001000-0x000000000009efff] machine # [ 0.005115] node 0: [mem 0x0000000000100000-0x000000003ffd7fff] machine # [ 0.005116] Initmem setup node 0 [mem 0x0000000000001000-0x000000003ffd7fff] machine # [ 0.005134] On node 0, zone DMA: 1 pages in unavailable ranges machine # [ 0.005374] On node 0, zone DMA: 97 pages in unavailable ranges machine # [ 0.021595] On node 0, zone DMA32: 40 pages in unavailable ranges machine # [ 0.022044] ACPI: PM-Timer IO Port: 0x608 machine # [ 0.022055] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) machine # [ 0.022079] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 machine # [ 0.022082] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) machine # [ 0.022083] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) machine # [ 0.022085] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) machine # [ 0.022085] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) machine # [ 0.022086] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) machine # [ 0.022088] ACPI: Using ACPI (MADT) for SMP configuration information machine # [ 0.022089] ACPI: HPET id: 0x8086a201 base: 0xfed00000 machine # [ 0.022092] TSC deadline timer available machine # [ 0.022097] CPU topo: Max. logical packages: 1 machine # [ 0.022097] CPU topo: Max. logical dies: 1 machine # [ 0.022098] CPU topo: Max. dies per package: 1 machine # [ 0.022101] CPU topo: Max. threads per core: 1 machine # [ 0.022102] CPU topo: Num. cores per package: 1 machine # [ 0.022102] CPU topo: Num. threads per package: 1 machine # [ 0.022102] CPU topo: Allowing 1 present CPUs plus 0 hotplug CPUs machine # [ 0.022119] kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write() machine # [ 0.022146] PM: hibernation: Registered nosave memory: [mem 0x00000000-0x00000fff] machine # [ 0.022148] PM: hibernation: Registered nosave memory: [mem 0x0009f000-0x000fffff] machine # [ 0.022149] [mem 0x40000000-0xafffffff] available for PCI devices machine # [ 0.022150] Booting paravirtualized kernel on KVM machine # [ 0.022152] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns machine # [ 0.026603] setup_percpu: NR_CPUS:384 nr_cpumask_bits:1 nr_cpu_ids:1 nr_node_ids:1 machine # [ 0.028596] percpu: Embedded 98 pages/cpu s278528 r8192 d114688 u2097152 machine # [ 0.028637] kvm-guest: PV spinlocks disabled, single CPU machine # [ 0.028638] 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/35s2igiaaj5g08gc3r9xqcrxf6sx5fyq-nixos-system-machine-test/init regInfo=/nix/store/nh121gwnqf9zcz5bqp5kf9nw52hm490f-closure-info/registration console=ttyS0,115200n8 console=tty0 machine # [ 0.028731] Unknown kernel command line parameters "regInfo=/nix/store/nh121gwnqf9zcz5bqp5kf9nw52hm490f-closure-info/registration", will be passed to user space. machine # [ 0.028744] random: crng init done machine # [ 0.028745] printk: log buffer data + meta data: 262144 + 917504 = 1179648 bytes machine # [ 0.028765] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes, linear) machine # [ 0.028778] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes, linear) machine # [ 0.028807] Fallback order for Node 0: 0 machine # [ 0.028809] Built 1 zonelists, mobility grouping on. Total pages: 262006 machine # [ 0.028810] Policy zone: DMA32 machine # [ 0.031072] mem auto-init: stack:all(zero), heap alloc:on, heap free:off machine # [ 0.033275] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1 machine # [ 0.035451] allocated 2097152 bytes of page_ext machine # [ 0.044743] ftrace: allocating 48733 entries in 192 pages machine # [ 0.044745] ftrace: allocated 192 pages with 2 groups machine # [ 0.045525] Dynamic Preempt: lazy machine # [ 0.045684] rcu: Preemptible hierarchical RCU implementation. machine # [ 0.045684] rcu: RCU event tracing is enabled. machine # [ 0.045685] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1. machine # [ 0.045686] Trampoline variant of Tasks RCU enabled. machine # [ 0.045686] Rude variant of Tasks RCU enabled. machine # [ 0.045686] Tracing variant of Tasks RCU enabled. machine # [ 0.045687] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. machine # [ 0.045688] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1 machine # [ 0.045708] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. machine # [ 0.045709] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. machine # [ 0.045710] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. machine # [ 0.049960] NR_IRQS: 24832, nr_irqs: 256, preallocated irqs: 16 machine # [ 0.050238] rcu: srcu_init: Setting srcu_struct sizes based on contention. machine # [ 0.050245] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns machine # [ 0.050344] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____) machine # [ 0.053821] Console: colour VGA+ 80x25 machine # [ 0.053824] printk: legacy console [tty0] enabled machine # [ 0.082702] printk: legacy console [ttyS0] enabled machine # [ 0.189181] ACPI: Core revision 20250807 machine # [ 0.190126] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns machine # [ 0.191712] APIC: Switch to symmetric I/O mode setup machine # [ 0.192725] x2apic enabled machine # [ 0.193501] APIC: Switched APIC routing to: physical x2apic machine # [ 0.195365] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 machine # [ 0.196385] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x229840d1729, max_idle_ns: 440795276167 ns machine # [ 0.198167] Calibrating delay loop (skipped) preset value.. 4800.02 BogoMIPS (lpj=2400010) machine # [ 0.199255] x86/cpu: User Mode Instruction Prevention (UMIP) activated machine # [ 0.201290] Last level iTLB entries: 4KB 512, 2MB 255, 4MB 127 machine # [ 0.202165] Last level dTLB entries: 4KB 512, 2MB 255, 4MB 127, 1GB 0 machine # [ 0.203168] mitigations: Enabled attack vectors: user_kernel, user_user, guest_host, guest_guest, SMT mitigations: auto machine # [ 0.204165] Speculative Store Bypass: Mitigation: Speculative Store Bypass disabled via prctl machine # [ 0.206165] Transient Scheduler Attacks: Vulnerable: No microcode machine # [ 0.207165] Spectre V2 : Mitigation: Enhanced / Automatic IBRS machine # [ 0.208165] Speculative Return Stack Overflow: Mitigation: Safe RET machine # [ 0.209165] Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization machine # [ 0.211173] Spectre V2 : Enabling IBPB for BPF machine # [ 0.212165] Spectre V2 : mitigation: Enabling conditional Indirect Branch Prediction Barrier machine # [ 0.213165] active return thunk: srso_alias_return_thunk machine # [ 0.214866] x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers' machine # [ 0.216152] x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers' machine # [ 0.217165] x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers' machine # [ 0.218165] x86/fpu: Supporting XSAVE feature 0x020: 'AVX-512 opmask' machine # [ 0.219165] x86/fpu: Supporting XSAVE feature 0x040: 'AVX-512 Hi256' machine # [ 0.220165] x86/fpu: Supporting XSAVE feature 0x080: 'AVX-512 ZMM_Hi256' machine # [ 0.221165] x86/fpu: Supporting XSAVE feature 0x200: 'Protection Keys User registers' machine # [ 0.222165] x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256 machine # [ 0.223950] x86/fpu: xstate_offset[5]: 832, xstate_sizes[5]: 64 machine # [ 0.224959] x86/fpu: xstate_offset[6]: 896, xstate_sizes[6]: 512 machine # [ 0.225955] x86/fpu: xstate_offset[7]: 1408, xstate_sizes[7]: 1024 machine # [ 0.226954] x86/fpu: xstate_offset[9]: 2432, xstate_sizes[9]: 8 machine # [ 0.227957] x86/fpu: Enabled xstate features 0x2e7, context size is 2440 bytes, using 'compacted' format. machine # [ 0.261727] Freeing SMP alternatives memory: 44K machine # [ 0.262168] pid_max: default: 32768 minimum: 301 machine # [ 0.263257] LSM: initializing lsm=capability,landlock,yama,bpf,ima machine # [ 0.264255] landlock: Up and running. machine # [ 0.265165] Yama: becoming mindful. machine # [ 0.265987] LSM support for eBPF active machine # [ 0.266738] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear) machine # [ 0.267188] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear) machine # [ 0.270406] smpboot: CPU0: AMD EPYC 9654 96-Core Processor (family: 0x19, model: 0x11, stepping: 0x1) machine # [ 0.271689] Performance Events: Fam17h+ core perfctr, AMD PMU driver. machine # [ 0.272174] ... version: 2 machine # [ 0.272910] ... bit width: 48 machine # [ 0.273168] ... generic counters: 6 machine # [ 0.273924] ... generic bitmap: 000000000000003f machine # [ 0.274167] ... fixed-purpose counters: 0 machine # [ 0.274916] ... fixed-purpose bitmap: 0000000000000000 machine # [ 0.275167] ... value mask: 0000ffffffffffff machine # [ 0.276111] ... max period: 00007fffffffffff machine # [ 0.276900] ... global_ctrl mask: 000000000000003f machine # [ 0.277273] signal: max sigframe size: 3376 machine # [ 0.278073] rcu: Hierarchical SRCU implementation. machine # [ 0.278787] rcu: Max phase no-delay instances is 400. machine # [ 0.283629] smp: Bringing up secondary CPUs ... machine # [ 0.284182] smp: Brought up 1 node, 1 CPU machine # [ 0.284893] smpboot: Total of 1 processors activated (4800.02 BogoMIPS) machine # [ 0.285359] Memory: 941808K/1048024K available (17215K kernel code, 2726K rwdata, 13580K rodata, 3644K init, 2988K bss, 98840K reserved, 0K cma-reserved) machine # [ 0.286392] devtmpfs: initialized machine # [ 0.287151] x86/mm: Memory block size: 128MB machine # [ 0.288723] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear) machine # [ 0.289192] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear). machine # [ 0.290243] pinctrl core: initialized pinctrl subsystem machine # [ 0.291408] PM: RTC time: 02:41:40, date: 2026-09-03 machine # [ 0.294800] NET: Registered PF_NETLINK/PF_ROUTE protocol family machine # [ 0.295524] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations machine # [ 0.296183] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations machine # [ 0.297303] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations machine # [ 0.298178] audit: initializing netlink subsys (disabled) machine # [ 0.299465] thermal_sys: Registered thermal governor 'fair_share' machine # [ 0.299467] thermal_sys: Registered thermal governor 'bang_bang' machine # [ 0.300169] thermal_sys: Registered thermal governor 'step_wise' machine # [ 0.301146] thermal_sys: Registered thermal governor 'user_space' machine # [ 0.301947] audit: type=2000 audit(1788403300.927:1): state=initialized audit_enabled=0 res=1 machine # [ 0.304171] thermal_sys: Registered thermal governor 'power_allocator' machine # [ 0.304186] cpuidle: using governor menu machine # [ 0.306416] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 machine # [ 0.307402] PCI: ECAM [mem 0xb0000000-0xbfffffff] (base 0xb0000000) for domain 0000 [bus 00-ff] machine # [ 0.308170] PCI: ECAM [mem 0xb0000000-0xbfffffff] reserved as E820 entry machine # [ 0.309180] PCI: Using configuration type 1 for base access machine # [ 0.310324] kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible. machine # [ 0.315440] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages machine # [ 0.316169] HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page machine # [ 0.321169] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages machine # [ 0.322167] HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page machine # [ 0.332517] ACPI: Added _OSI(Module Device) machine # [ 0.333170] ACPI: Added _OSI(Processor Device) machine # [ 0.333936] ACPI: Added _OSI(Processor Aggregator Device) machine # [ 0.343442] ACPI: 1 ACPI AML tables successfully acquired and loaded machine # [ 0.347149] ACPI: Interpreter enabled machine # [ 0.347727] ACPI: PM: (supports S0 S3 S4 S5) machine # [ 0.348169] ACPI: Using IOAPIC for interrupt routing machine # [ 0.349120] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug machine # [ 0.354169] PCI: Using E820 reservations for host bridge windows machine # [ 0.355283] ACPI: Enabled 2 GPEs in block 00 to 3F machine # [ 0.363829] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) machine # [ 0.364179] acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] machine # [ 0.365271] acpi PNP0A08:00: _OSC: platform does not support [PCIeHotplug LTR] machine # [ 0.366307] acpi PNP0A08:00: _OSC: OS now controls [PME AER PCIeCapability] machine # [ 0.367552] PCI host bridge to bus 0000:00 machine # [ 0.368176] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] machine # [ 0.369170] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] machine # [ 0.370170] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] machine # [ 0.371170] pci_bus 0000:00: root bus resource [mem 0x40000000-0xafffffff window] machine # [ 0.372170] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window] machine # [ 0.373170] pci_bus 0000:00: root bus resource [mem 0x100000000-0x8ffffffff window] machine # [ 0.374170] pci_bus 0000:00: root bus resource [bus 00-ff] machine # [ 0.375306] pci 0000:00:00.0: [8086:29c0] type 00 class 0x060000 conventional PCI endpoint machine # [ 0.376613] pci 0000:00:01.0: [1234:1111] type 00 class 0x030000 conventional PCI endpoint machine # [ 0.379283] pci 0000:00:01.0: BAR 0 [mem 0xfd000000-0xfdffffff pref] machine # [ 0.380182] pci 0000:00:01.0: BAR 2 [mem 0xfebd0000-0xfebd0fff] machine # [ 0.381191] pci 0000:00:01.0: ROM [mem 0xfebc0000-0xfebcffff pref] machine # [ 0.382488] pci 0000:00:01.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff] machine # [ 0.383869] pci 0000:00:02.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint machine # [ 0.387206] pci 0000:00:02.0: BAR 0 [io 0xc140-0xc15f] machine # [ 0.388148] pci 0000:00:02.0: BAR 1 [mem 0xfebd1000-0xfebd1fff] machine # [ 0.388988] pci 0000:00:02.0: BAR 4 [mem 0xfe000000-0xfe003fff 64bit pref] machine # [ 0.390103] pci 0000:00:02.0: ROM [mem 0xfeb40000-0xfeb7ffff pref] machine # [ 0.391612] pci 0000:00:03.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint machine # [ 0.394176] pci 0000:00:03.0: BAR 0 [io 0xc160-0xc17f] machine # [ 0.395177] pci 0000:00:03.0: BAR 1 [mem 0xfebd2000-0xfebd2fff] machine # [ 0.396190] pci 0000:00:03.0: BAR 4 [mem 0xfe004000-0xfe007fff 64bit pref] machine # [ 0.397733] pci 0000:00:04.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint machine # [ 0.400195] pci 0000:00:04.0: BAR 0 [io 0xc080-0xc0bf] machine # [ 0.401147] pci 0000:00:04.0: BAR 1 [mem 0xfebd3000-0xfebd3fff] machine # [ 0.401917] pci 0000:00:04.0: BAR 4 [mem 0xfe008000-0xfe00bfff 64bit pref] machine # [ 0.402760] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint machine # [ 0.405072] pci 0000:00:05.0: BAR 0 [io 0xc180-0xc19f] machine # [ 0.406070] pci 0000:00:05.0: BAR 1 [mem 0xfebd4000-0xfebd4fff] machine # [ 0.407038] pci 0000:00:05.0: BAR 4 [mem 0xfe00c000-0xfe00ffff 64bit pref] machine # [ 0.408765] pci 0000:00:06.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint machine # [ 0.411109] pci 0000:00:06.0: BAR 0 [io 0xc1a0-0xc1bf] machine # [ 0.411795] pci 0000:00:06.0: BAR 1 [mem 0xfebd5000-0xfebd5fff] machine # [ 0.412197] pci 0000:00:06.0: BAR 4 [mem 0xfe010000-0xfe013fff 64bit pref] machine # [ 0.413760] pci 0000:00:07.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint machine # [ 0.416187] pci 0000:00:07.0: BAR 0 [io 0xc000-0xc07f] machine # [ 0.417198] pci 0000:00:07.0: BAR 1 [mem 0xfebd6000-0xfebd6fff] machine # [ 0.418190] pci 0000:00:07.0: BAR 4 [mem 0xfe014000-0xfe017fff 64bit pref] machine # [ 0.419763] pci 0000:00:08.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint machine # [ 0.421176] pci 0000:00:08.0: BAR 0 [io 0xc1c0-0xc1df] machine # [ 0.422092] pci 0000:00:08.0: BAR 1 [mem 0xfebd7000-0xfebd7fff] machine # [ 0.422989] pci 0000:00:08.0: BAR 4 [mem 0xfe018000-0xfe01bfff 64bit pref] machine # [ 0.424070] pci 0000:00:08.0: ROM [mem 0xfeb80000-0xfebbffff pref] machine # [ 0.425686] pci 0000:00:09.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint machine # [ 0.427182] pci 0000:00:09.0: BAR 1 [mem 0xfebd8000-0xfebd8fff] machine # [ 0.428192] pci 0000:00:09.0: BAR 4 [mem 0xfe01c000-0xfe01ffff 64bit pref] machine # [ 0.429754] pci 0000:00:0a.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint machine # [ 0.432030] pci 0000:00:0a.0: BAR 0 [io 0xc0c0-0xc0ff] machine # [ 0.433175] pci 0000:00:0a.0: BAR 1 [mem 0xfebd9000-0xfebd9fff] machine # [ 0.434184] pci 0000:00:0a.0: BAR 4 [mem 0xfe020000-0xfe023fff 64bit pref] machine # [ 0.435731] pci 0000:00:0b.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint machine # [ 0.437199] pci 0000:00:0b.0: BAR 0 [io 0xc1e0-0xc1ff] machine # [ 0.438136] pci 0000:00:0b.0: BAR 1 [mem 0xfebda000-0xfebdafff] machine # [ 0.438986] pci 0000:00:0b.0: BAR 4 [mem 0xfe024000-0xfe027fff 64bit pref] machine # [ 0.440715] pci 0000:00:1d.0: [8086:2934] type 00 class 0x0c0300 conventional PCI endpoint machine # [ 0.441830] pci 0000:00:1d.0: BAR 4 [io 0xc200-0xc21f] machine # [ 0.442390] pci 0000:00:1d.1: [8086:2935] type 00 class 0x0c0300 conventional PCI endpoint machine # [ 0.443797] pci 0000:00:1d.1: BAR 4 [io 0xc220-0xc23f] machine # [ 0.444375] pci 0000:00:1d.2: [8086:2936] type 00 class 0x0c0300 conventional PCI endpoint machine # [ 0.446876] pci 0000:00:1d.2: BAR 4 [io 0xc240-0xc25f] machine # [ 0.447446] pci 0000:00:1d.7: [8086:293a] type 00 class 0x0c0320 conventional PCI endpoint machine # [ 0.448753] pci 0000:00:1d.7: BAR 0 [mem 0xfebdb000-0xfebdbfff] machine # [ 0.449480] pci 0000:00:1f.0: [8086:2918] type 00 class 0x060100 conventional PCI endpoint machine # [ 0.450471] pci 0000:00:1f.0: quirk: [io 0x0600-0x067f] claimed by ICH6 ACPI/GPIO/TCO machine # [ 0.451431] pci 0000:00:1f.2: [8086:2922] type 00 class 0x010601 conventional PCI endpoint machine # [ 0.453197] pci 0000:00:1f.2: BAR 4 [io 0xc260-0xc27f] machine # [ 0.454119] pci 0000:00:1f.2: BAR 5 [mem 0xfebdc000-0xfebdcfff] machine # [ 0.455294] pci 0000:00:1f.3: [8086:2930] type 00 class 0x0c0500 conventional PCI endpoint machine # [ 0.456849] pci 0000:00:1f.3: BAR 4 [io 0x0700-0x073f] machine # [ 0.460249] ACPI: PCI: Interrupt link LNKA configured for IRQ 10 machine # [ 0.461286] ACPI: PCI: Interrupt link LNKB configured for IRQ 10 machine # [ 0.462293] ACPI: PCI: Interrupt link LNKC configured for IRQ 11 machine # [ 0.463275] ACPI: PCI: Interrupt link LNKD configured for IRQ 11 machine # [ 0.464273] ACPI: PCI: Interrupt link LNKE configured for IRQ 10 machine # [ 0.465269] ACPI: PCI: Interrupt link LNKF configured for IRQ 10 machine # [ 0.466273] ACPI: PCI: Interrupt link LNKG configured for IRQ 11 machine # [ 0.467289] ACPI: PCI: Interrupt link LNKH configured for IRQ 11 machine # [ 0.468209] ACPI: PCI: Interrupt link GSIA configured for IRQ 16 machine # [ 0.469186] ACPI: PCI: Interrupt link GSIB configured for IRQ 17 machine # [ 0.470184] ACPI: PCI: Interrupt link GSIC configured for IRQ 18 machine # [ 0.471182] ACPI: PCI: Interrupt link GSID configured for IRQ 19 machine # [ 0.472185] ACPI: PCI: Interrupt link GSIE configured for IRQ 20 machine # [ 0.473182] ACPI: PCI: Interrupt link GSIF configured for IRQ 21 machine # [ 0.474185] ACPI: PCI: Interrupt link GSIG configured for IRQ 22 machine # [ 0.475180] ACPI: PCI: Interrupt link GSIH configured for IRQ 23 machine # [ 0.477149] iommu: Default domain type: Translated machine # [ 0.477862] iommu: DMA domain TLB invalidation policy: lazy mode machine # [ 0.478417] ACPI: bus type USB registered machine # [ 0.479212] usbcore: registered new interface driver usbfs machine # [ 0.480186] usbcore: registered new interface driver hub machine # [ 0.481198] usbcore: registered new device driver usb machine # [ 0.483112] NetLabel: Initializing machine # [ 0.483664] NetLabel: domain hash size = 128 machine # [ 0.484167] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO machine # [ 0.485133] NetLabel: unlabeled traffic allowed by default machine # [ 0.485886] PCI: Using ACPI for IRQ routing machine # [ 0.531206] pci 0000:00:01.0: vgaarb: setting as boot VGA device machine # [ 0.532164] pci 0000:00:01.0: vgaarb: bridge control possible machine # [ 0.532164] pci 0000:00:01.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none machine # [ 0.532172] vgaarb: loaded machine # [ 0.532923] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 machine # [ 0.533171] hpet0: 3 comparators, 64-bit 100.000000 MHz counter machine # [ 0.540261] clocksource: Switched to clocksource kvm-clock machine # [ 0.543788] VFS: Disk quotas dquot_6.6.0 machine # [ 0.544582] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) machine # [ 0.546004] pnp: PnP ACPI init machine # [ 0.546764] ACPI: IRQ 4 override to edge(!), high(!) machine # [ 0.547796] system 00:05: [mem 0xb0000000-0xbfffffff window] has been reserved machine # [ 0.549442] pnp: PnP ACPI: found 6 devices machine # [ 0.557111] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns machine # [ 0.558648] clocksource: Switched to clocksource acpi_pm machine # [ 0.559681] NET: Registered PF_INET protocol family machine # [ 0.560781] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear) machine # [ 0.577665] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear) machine # [ 0.579272] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) machine # [ 0.580637] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear) machine # [ 0.582072] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear) machine # [ 0.583372] TCP: Hash tables configured (established 8192 bind 8192) machine # [ 0.584508] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear) machine # [ 0.585826] UDP hash table entries: 512 (order: 3, 32768 bytes, linear) machine # [ 0.587069] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear) machine # [ 0.588394] NET: Registered PF_UNIX/PF_LOCAL protocol family machine # [ 0.589433] NET: Registered PF_XDP protocol family machine # [ 0.590329] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] machine # [ 0.591396] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] machine # [ 0.592467] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] machine # [ 0.593621] pci_bus 0000:00: resource 7 [mem 0x40000000-0xafffffff window] machine # [ 0.594792] pci_bus 0000:00: resource 8 [mem 0xc0000000-0xfebfffff window] machine # [ 0.595957] pci_bus 0000:00: resource 9 [mem 0x100000000-0x8ffffffff window] machine # [ 0.597702] ACPI: \_SB_.GSIA: Enabled at IRQ 16 machine # [ 0.600046] ACPI: \_SB_.GSIB: Enabled at IRQ 17 machine # [ 0.602334] ACPI: \_SB_.GSIC: Enabled at IRQ 18 machine # [ 0.604418] ACPI: \_SB_.GSID: Enabled at IRQ 19 machine # [ 0.606188] PCI: CLS 0 bytes, default 64 machine # [ 0.607146] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x229840d1729, max_idle_ns: 440795276167 ns machine # [ 0.609002] Trying to unpack rootfs image as initramfs... machine # [ 0.653134] Initialise system trusted keyrings machine # [ 0.655986] workingset: timestamp_bits=40 max_order=18 bucket_order=0 machine # [ 0.678119] Key type asymmetric registered machine # [ 0.678858] Asymmetric key parser 'x509' registered machine # [ 0.679779] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 248) machine # [ 0.685105] io scheduler mq-deadline registered machine # [ 0.685886] io scheduler kyber registered machine # [ 0.688447] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled machine # [ 0.689780] 00:03: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A machine # [ 0.695681] Linux agpgart interface v0.103 machine # [ 0.696503] ACPI: bus type drm_connector registered machine # [ 0.699344] usbcore: registered new interface driver usbserial_generic machine # [ 0.700493] usbserial: USB Serial support registered for generic machine # [ 0.703952] amd_pstate: The CPPC feature is supported but currently disabled by the BIOS. machine # [ 0.703952] Please enable it if your BIOS has the CPPC option. machine # [ 0.706285] amd_pstate: the _CPC object is not present in SBIOS or ACPI disabled machine # [ 0.709067] drop_monitor: Initializing network drop monitor service machine # [ 0.710312] NET: Registered PF_INET6 protocol family machine # [ 0.714353] Segment Routing with IPv6 machine # [ 0.716983] In-situ OAM (IOAM) with IPv6 machine # [ 0.718057] IPI shorthand broadcast: enabled machine # [ 0.726367] sched_clock: Marking stable (583017199, 142919093)->(800687064, -74750772) machine # [ 0.732118] registered taskstats version 1 machine # [ 0.733087] Loading compiled-in X.509 certificates machine # [ 0.749461] Demotion targets for Node 0: null machine # [ 0.751989] Key type .fscrypt registered machine # [ 0.752678] Key type fscrypt-provisioning registered machine # [ 0.753688] ima: No TPM chip found, activating TPM-bypass! machine # [ 0.757978] ima: Allocated hash algorithm: sha1 machine # [ 0.758769] ima: No architecture policies found machine # [ 0.760952] PM: Magic number: 10:584:661 machine # [ 0.762549] RAS: Correctable Errors collector initialized. machine # [ 0.772634] clk: Disabling unused clocks machine # [ 0.774955] PM: genpd: Disabling unused power domains machine # [ 0.934810] Freeing initrd memory: 28316K machine # [ 0.937877] Freeing unused decrypted memory: 2028K machine # [ 0.940477] Freeing unused kernel image (initmem) memory: 3644K machine # [ 0.941616] Write protecting the kernel read-only data: 32768k machine # [ 0.943510] Freeing unused kernel image (text/rodata gap) memory: 1216K machine # [ 0.945091] Freeing unused kernel image (rodata/data gap) memory: 756K machine # [ 0.996392] x86/mm: Checked W+X mappings: passed, no W+X pages found. machine # [ 0.997504] Run /init as init process machine # [ 1.007419] systemd[1]: Inserted module 'autofs4' machine # [ 1.023540] fuse: init (API version 7.45) machine # [ 1.029347] ACPI: \_SB_.GSIG: Enabled at IRQ 22 machine # [ 1.031759] ACPI: \_SB_.GSIH: Enabled at IRQ 23 machine # [ 1.034614] ACPI: \_SB_.GSIE: Enabled at IRQ 20 machine # [ 1.036810] ACPI: \_SB_.GSIF: Enabled at IRQ 21 machine # [ 1.060552] systemd[1]: Successfully made /usr/ read-only. machine # [ 1.396087] systemd[1]: systemd 262-2451b1a running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE) machine # [ 1.401201] systemd[1]: Detected virtualization kvm. machine # [ 1.402103] systemd[1]: Detected architecture x86-64. machine # [ 1.402998] systemd[1]: Running in initrd. machine # [ 1.404096] systemd[1]: Initializing machine ID from random generator. machine # [ 1.405313] systemd[1]: Hostname set to . machine # [ 1.476313] systemd[1]: bpf-restrict-fs: LSM BPF program attached machine # [ 1.511741] systemd[1]: Queued start job for default target Initrd Default Target. machine # [ 1.516186] systemd[1]: Created slice Slice /system/modprobe. machine # [ 1.517363] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. machine # [ 1.518794] systemd[1]: Expecting device /dev/disk/by-label/nixos... machine # [ 1.519970] systemd[1]: Reached target Path Units. machine # [ 1.520823] systemd[1]: Reached target Slice Units. machine # [ 1.521706] systemd[1]: Reached target Swaps. machine # [ 1.522583] systemd[1]: Reached target Timer Units. machine # [ 1.523621] systemd[1]: Listening on D-Bus System Message Bus Socket. machine # [ 1.524871] systemd[1]: Listening on Journal Socket (/dev/log). machine # [ 1.526101] systemd[1]: Listening on Journal Sockets. machine # [ 1.527123] systemd[1]: Listening on udev Kernel Socket. machine # [ 1.528107] systemd[1]: Reached target Socket Units. machine # [ 1.529827] systemd[1]: Starting Create List of Static Device Nodes... machine # [ 1.533746] systemd[1]: Starting Load Kernel Module 9pnet_virtio... machine # [ 1.541119] systemd[1]: Starting Load Kernel Module configfs... machine # [ 1.553539] systemd[1]: Starting Journal Service... machine # [ 1.565026] systemd[1]: Starting Load Kernel Modules... machine # [ 1.573020] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 1.590737] netfs: FS-Cache loaded machine # [ 1.595380] 9pnet: Installing 9P2000 support machine # [ 1.604143] systemd[1]: Starting Coldplug All udev Devices... machine # [ 1.618010] systemd[1]: Finished Create List of Static Device Nodes. machine # [ 1.624623] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully. machine # [ 1.632310] systemd[1]: Finished Load Kernel Module 9pnet_virtio. machine # [ 1.636557] systemd-journald[67]: Collecting audit messages is disabled. machine # [ 1.638220] systemd[1]: modprobe@configfs.service: Deactivated successfully. machine # [ 1.644707] systemd[1]: Finished Load Kernel Module configfs. machine # [ 1.649497] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. machine # [ 1.653401] systemd[1]: Kernel Configuration File System skipped, unmet condition check ConditionPathExists=/sys/kernel/config machine # [ 1.661020] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... machine # [ 1.664075] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev machine # [ 1.692526] systemd[1]: Finished Load Kernel Modules. machine # [ 1.701047] systemd[1]: Starting Apply Kernel Variables... machine # [ 1.712329] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. machine # [ 1.723171] systemd[1]: Starting Create Static Device Nodes in /dev... machine # [ 1.735535] systemd[1]: Finished Apply Kernel Variables. machine # [ 1.750092] systemd[1]: Started Journal Service. machine # [ 1.610206] systemd-modules-load[68]: Inserted module 'dm_mod' machine # [ 1.611626] systemd-modules-load[68]: Inserted module 'virtio_balloon' machine # [ 1.614446] systemd-modules-load[68]: Inserted module 'virtio_gpu' machine # [ 1.620925] systemd[1]: Finished Create Static Device Nodes in /dev. machine # [ 1.625072] systemd[1]: Reached target Preparation for Local File Systems. machine # [ 1.627889] systemd[1]: Reached target Local File Systems. machine # [ 1.628926] systemd[1]: Starting Create System Files and Directories... machine # [ 1.636336] systemd[1]: Starting Rule-based Manager for Device Events and Files... machine # [ 1.659136] systemd[1]: Finished Create System Files and Directories. machine # [ 1.684305] systemd-udevd[83]: Using default interface naming scheme 'v261'. machine # [ 1.706237] systemd[1]: Started Rule-based Manager for Device Events and Files. machine # [ 1.749628] systemd[1]: Finished Coldplug All udev Devices. machine # [ 1.750539] systemd[1]: Reached target System Initialization. machine # [ 1.751401] systemd[1]: Reached target Basic System. machine # [ 2.092212] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 machine # [ 2.104187] virtio_blk virtio5: 1/0/0 default/read/poll queues machine # [ 2.114262] ehci-pci 0000:00:1d.7: EHCI Host Controller machine # [ 2.115019] ehci-pci 0000:00:1d.7: new USB bus registered, assigned bus number 1 machine # [ 2.116246] ehci-pci 0000:00:1d.7: irq 19, io mem 0xfebdb000 machine # [ 2.120640] virtio_blk virtio5: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) machine # [ 2.122972] ehci-pci 0000:00:1d.7: USB 2.0 started, EHCI 1.00 machine # [ 2.123904] serio: i8042 KBD port at 0x60,0x64 irq 1 machine # [ 2.125140] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 6.18 machine # [ 2.126261] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 machine # [ 2.129189] serio: i8042 AUX port at 0x60,0x64 irq 12 machine # [ 2.130045] usb usb1: Product: EHCI Host Controller machine # [ 2.130684] usb usb1: Manufacturer: Linux 6.18.48 ehci_hcd machine # [ 2.132945] usb usb1: SerialNumber: 0000:00:1d.7 machine # [ 2.134347] hub 1-0:1.0: USB hub found machine # [ 2.136233] hub 1-0:1.0: 6 ports detected machine # [ 2.138310] uhci_hcd 0000:00:1d.0: UHCI Host Controller machine # [ 2.139062] uhci_hcd 0000:00:1d.0: new USB bus registered, assigned bus number 2 machine # [ 2.153433] uhci_hcd 0000:00:1d.0: detected 2 ports machine # [ 2.159121] uhci_hcd 0000:00:1d.0: irq 16, io port 0x0000c200 machine # [ 2.165682] usb usb2: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.18 machine # [ 2.166780] usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=1 machine # [ 2.179401] usb usb2: Product: UHCI Host Controller machine # [ 2.183017] SCSI subsystem initialized machine # [ 2.188951] usb usb2: Manufacturer: Linux 6.18.48 uhci_hcd machine # [ 2.189685] usb usb2: SerialNumber: 0000:00:1d.0 machine # [ 2.053696] (udev-worker)[92]: Network interface NamePolicy= disabled on kernel command line. machine # [ 2.058052] systemd[1]: Starting Virtual Console Setup... machine # [ 2.062818] (udev-worker)[86]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. machine # [ 2.064833] (udev-worker)[86]: Network interface NamePolicy= disabled on kernel command line. machine # [ 2.210339] hub 2-0:1.0: USB hub found machine # [ 2.215961] hub 2-0:1.0: 2 ports detected machine # [ 2.231487] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input0 machine # [ 2.095284] systemd-vconsole-setup[99]: Configuration of first virtual console was skipped, ignoring remaining ones. machine # [ 2.099728] systemd[1]: Finished Virtual Console Setup. machine # [ 2.252058] uhci_hcd 0000:00:1d.1: UHCI Host Controller machine # [ 2.252746] uhci_hcd 0000:00:1d.1: new USB bus registered, assigned bus number 3 machine # [ 2.261970] uhci_hcd 0000:00:1d.1: detected 2 ports machine # [ 2.262715] uhci_hcd 0000:00:1d.1: irq 17, io port 0x0000c220 machine # [ 2.269188] usb usb3: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.18 machine # [ 2.270329] usb usb3: New USB device strings: Mfr=3, Product=2, SerialNumber=1 machine # [ 2.276941] usb usb3: Product: UHCI Host Controller machine # [ 2.277599] usb usb3: Manufacturer: Linux 6.18.48 uhci_hcd machine # [ 2.140104] systemd[1]: Found device /dev/disk/by-label/nixos. machine # [ 2.283950] usb usb3: SerialNumber: 0000:00:1d.1 machine # [ 2.142454] systemd[1]: Reached target Initrd Root Device. machine # [ 2.286972] hub 3-0:1.0: USB hub found machine # [ 2.145066] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos... machine # [ 2.293435] hub 3-0:1.0: 2 ports detected machine # [ 2.295882] uhci_hcd 0000:00:1d.2: UHCI Host Controller machine # [ 2.296705] uhci_hcd 0000:00:1d.2: new USB bus registered, assigned bus number 4 machine # [ 2.306265] uhci_hcd 0000:00:1d.2: detected 2 ports machine # [ 2.308044] uhci_hcd 0000:00:1d.2: irq 18, io port 0x0000c240 machine # [ 2.311079] usb usb4: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.18 machine # [ 2.318960] usb usb4: New USB device strings: Mfr=3, Product=2, SerialNumber=1 machine # [ 2.178369] systemd-fsck[107]: nixos: clean, 12/65536 files, 13019/262144 blocks machine # [ 2.322560] usb usb4: Product: UHCI Host Controller machine # [ 2.324590] usb usb4: Manufacturer: Linux 6.18.48 uhci_hcd machine # [ 2.184505] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos. machine # [ 2.331220] usb usb4: SerialNumber: 0000:00:1d.2 machine # [ 2.332711] hub 4-0:1.0: USB hub found machine # [ 2.334561] hub 4-0:1.0: 2 ports detected machine # [ 2.338507] ahci 0000:00:1f.2: AHCI vers 0001.0000, 32 command slots, 1.5 Gbps, SATA mode machine # [ 2.347877] ahci 0000:00:1f.2: 6/6 ports implemented (port mask 0x3f) machine # [ 2.349789] ahci 0000:00:1f.2: flags: 64bit ncq only machine # [ 2.359090] scsi host0: ahci machine # [ 2.362502] scsi host1: ahci machine # [ 2.366942] scsi host2: ahci machine # [ 2.369761] scsi host3: ahci machine # [ 2.374752] scsi host4: ahci machine # [ 2.376971] scsi host5: ahci machine # [ 2.377506] ata1: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc100 irq 44 lpm-pol 1 machine # [ 2.378616] usb 1-1: new high-speed USB device number 2 using ehci-pci machine # [ 2.384225] ata2: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc180 irq 44 lpm-pol 1 machine # [ 2.386546] ata3: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc200 irq 44 lpm-pol 1 machine # [ 2.387720] ata4: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc280 irq 44 lpm-pol 1 machine # [ 2.388847] ata5: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc300 irq 44 lpm-pol 1 machine # [ 2.390037] ata6: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc380 irq 44 lpm-pol 1 machine # [ 2.508226] usb 1-1: New USB device found, idVendor=0627, idProduct=0001, bcdDevice= 0.00 machine # [ 2.511176] usb 1-1: New USB device strings: Mfr=1, Product=3, SerialNumber=10 machine # [ 2.514373] usb 1-1: Product: QEMU USB Tablet machine # [ 2.516238] usb 1-1: Manufacturer: QEMU machine # [ 2.517863] usb 1-1: SerialNumber: 28754-0000:00:1d.7-1 machine # [ 2.545855] hid: raw HID events driver (C) Jiri Kosina machine # [ 2.473491] systemd[1]: Mounting /sysroot... machine # [ 2.699081] ata1: SATA link down (SStatus 0 SControl 300) machine # [ 2.706092] ata5: SATA link down (SStatus 0 SControl 300) machine # [ 2.708229] ata2: SATA link down (SStatus 0 SControl 300) machine # [ 2.710605] ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 300) machine # [ 2.713095] ata3.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/100 machine # [ 2.715130] ata3.00: applying bridge limits machine # [ 2.717123] ata6: SATA link down (SStatus 0 SControl 300) machine # [ 2.719328] ata4: SATA link down (SStatus 0 SControl 300) machine # [ 2.721486] ata3.00: configured for UDMA/100 machine # [ 2.723795] scsi 2:0:0:0: CD-ROM QEMU QEMU DVD-ROM 2.5+ PQ: 0 ANSI: 5 machine # [ 2.794308] usbcore: registered new interface driver usbhid machine # [ 2.797964] usbhid: USB HID core driver machine # [ 2.818342] 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.820118] 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.824131] sr 2:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray machine # [ 2.833109] cdrom: Uniform CD-ROM driver Revision: 3.20 machine # [ 2.839870] EXT4-fs (vda): mounted filesystem 30f53e26-f621-4423-a3b2-e32981db1c89 r/w with ordered data mode. Quota mode: none. machine # [ 2.702187] systemd[1]: Mounted /sysroot. machine # [ 2.704777] systemd[1]: Reached target Initrd Root File System. machine # [ 2.708852] systemd[1]: Mounting /sysroot/nix/.ro-store... machine # [ 2.714367] systemd[1]: Mounting /sysroot/nix/.rw-store... machine # [ 2.719295] systemd[1]: Mounting /sysroot/run... machine # [ 2.721125] systemd[1]: Mounting /sysroot/tmp/shared... machine # [ 2.731742] systemd[1]: Mounting /sysroot/tmp/xchg... machine # [ 2.744158] systemd[1]: Starting Mountpoints Configured in the Real Root... machine # [ 2.780303] systemd-sysroot-fstab-check[146]: /sysroot should be mounted in the initrd, will request daemon-reload. machine # [ 2.926733] 9p: Installing v9fs 9p2000 file system support machine # [ 2.788082] systemd[1]: Mounted /sysroot/nix/.rw-store. machine # [ 2.791069] systemd[1]: Mounted /sysroot/run. machine # [ 2.802116] systemd[1]: Mounted /sysroot/nix/.ro-store. machine # [ 2.804243] systemd[1]: Mounted /sysroot/tmp/shared. machine # [ 2.804926] systemd[1]: Mounted /sysroot/tmp/xchg. machine # [ 2.811116] systemd[1]: Reload requested from client PID 146 ('systemd-sysroot') (unit initrd-parse-etc.service)... machine # [ 2.812686] systemd[1]: Reloading... machine # [ 2.868226] systemd[1]: Reloading finished in 57 ms. machine # [ 2.876543] systemd-sysroot-fstab-check[146]: Requesting initrd-fs.target/start/replace... machine # [ 2.879114] systemd-sysroot-fstab-check[146]: Requesting swap.target/start/replace... machine # [ 2.880953] systemd[1]: Starting rw-sysroot-nix-store.service... machine # [ 2.883448] systemd[1]: initrd-parse-etc.service: Deactivated successfully. machine # [ 2.886114] systemd[1]: Finished Mountpoints Configured in the Real Root. machine # [ 2.887180] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies. machine # [ 2.897885] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. machine # [ 2.899809] systemd[1]: Finished rw-sysroot-nix-store.service. machine # [ 3.473892] systemd[1]: Mounting /sysroot/nix/store... machine # [ 3.519571] systemd[1]: Mounted /sysroot/nix/store. machine # [ 3.522118] systemd[1]: Reached target Initrd File Systems. machine # [ 3.527124] systemd[1]: Starting Find NixOS closure... machine # [ 3.531243] systemd[1]: Starting Create Volatile Files and Directories in the Real Root... machine # [ 3.559934] systemd[1]: Finished Create Volatile Files and Directories in the Real Root. machine # [ 3.562096] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully. machine # [ 3.569783] systemd[1]: Finished Find NixOS closure. machine # [ 3.570917] systemd[1]: Reached target Initrd Default Target. machine # [ 3.572654] systemd[1]: Starting Cleaning Up and Shutting Down Daemons... machine # [ 3.586149] systemd[1]: Stopped target Initrd Default Target. machine # [ 3.587463] systemd[1]: Stopped target Basic System. machine # [ 3.588410] systemd[1]: Stopped target Initrd Root Device. machine # [ 3.590117] systemd[1]: Stopped target Path Units. machine # [ 3.590781] systemd[1]: systemd-ask-password-console.path: Deactivated successfully. machine # [ 3.591926] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch. machine # [ 3.592995] systemd[1]: Stopped target Slice Units. machine # [ 3.593699] systemd[1]: Stopped target Socket Units. machine # [ 3.594482] systemd[1]: Stopped target System Initialization. machine # [ 3.595710] systemd[1]: Stopped target Swaps. machine # [ 3.596585] systemd[1]: Stopped target Timer Units. machine # [ 3.597618] systemd[1]: dbus.socket: Deactivated successfully. machine # [ 3.598640] systemd[1]: Closed D-Bus System Message Bus Socket. machine # [ 3.600130] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully. machine # [ 3.601135] systemd[1]: Stopped Find NixOS closure. machine # [ 3.601775] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio machine # [ 3.603688] systemd[1]: Starting rw-sysroot-nix-store.service... machine # [ 3.605135] systemd[1]: systemd-sysctl.service: Deactivated successfully. machine # [ 3.606203] systemd[1]: Stopped Apply Kernel Variables. machine # [ 3.607240] systemd[1]: systemd-modules-load.service: Deactivated successfully. machine # [ 3.609051] systemd[1]: Stopped Load Kernel Modules. machine # [ 3.609733] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully. machine # [ 3.610930] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root. machine # [ 3.612541] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. machine # [ 3.613916] systemd[1]: Stopped Create System Files and Directories. machine # [ 3.614824] systemd[1]: Stopped target Local File Systems. machine # [ 3.617132] systemd[1]: Stopped target Preparation for Local File Systems. machine # [ 3.617990] systemd[1]: systemd-udev-trigger.service: Deactivated successfully. machine # [ 3.619903] systemd[1]: Stopped Coldplug All udev Devices. machine # [ 3.622568] systemd[1]: Stopping Rule-based Manager for Device Events and Files... machine # [ 3.623585] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. machine # [ 3.624600] systemd[1]: Stopped Virtual Console Setup. machine # [ 3.632518] systemd[1]: systemd-udevd.service: Deactivated successfully. machine # [ 3.636148] systemd[1]: Stopped Rule-based Manager for Device Events and Files. machine # [ 3.637283] systemd[1]: initrd-cleanup.service: Deactivated successfully. machine # [ 3.638203] systemd[1]: Finished Cleaning Up and Shutting Down Daemons. machine # [ 3.642749] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. machine # [ 3.644221] systemd[1]: Finished rw-sysroot-nix-store.service. machine # [ 3.647068] systemd[1]: Starting Cleanup udev Database... machine # [ 3.647810] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. machine # [ 3.648856] systemd[1]: Stopped Create Static Device Nodes in /dev. machine # [ 3.650134] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. machine # [ 3.651273] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully. machine # [ 3.652304] systemd[1]: kmod-static-nodes.service: Deactivated successfully. machine # [ 3.654123] systemd[1]: Stopped Create List of Static Device Nodes. machine # [ 3.668813] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. machine # [ 3.671095] systemd[1]: Finished Cleanup udev Database. machine # [ 3.671838] systemd[1]: Reached target Switch Root. machine # [ 3.673177] systemd[1]: Starting NixOS Activation... machine # [ 3.810526] initrd-nixos-activation-start[195]: booting system configuration /nix/store/35s2igiaaj5g08gc3r9xqcrxf6sx5fyq-nixos-system-machine-test machine # [ 3.865655] initrd-nixos-activation-start[195]: running activation script... machine # [ 4.239874] initrd-nixos-activation-start[218]: setting up /etc... machine # [ 4.470559] systemd[1]: initrd-nixos-activation.service: Deactivated successfully. machine # [ 4.472156] systemd[1]: Finished NixOS Activation. machine # [ 4.475658] systemd[1]: Starting Switch Root... machine # [ 4.489123] systemd[1]: Switching root. machine # [ 4.759517] systemd-journald[67]: Received SIGTERM from PID 1 (systemd). machine # [ 4.885204] NET: Registered PF_VSOCK protocol family machine # [ 5.265014] systemd[1]: systemd 262-2451b1a running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE) machine # [ 5.274626] systemd[1]: Detected virtualization kvm. machine # [ 5.276472] systemd[1]: Detected architecture x86-64. machine # [ 5.278394] systemd[1]: Detected first boot. machine # [ 5.284279] systemd[1]: Initializing machine ID from random generator. machine # [ 5.405276] systemd[1]: bpf-restrict-fs: LSM BPF program attached machine # [ 5.516600] systemd[1]: Applying preset policy. machine # [ 5.870337] systemd[1]: Populated /etc with preset unit settings. machine # [ 6.226359] systemd[1]: initrd-switch-root.service: Deactivated successfully. machine # [ 6.227875] systemd[1]: Stopped initrd-switch-root.service. machine # [ 6.230364] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. machine # [ 6.232509] systemd[1]: Created slice Slice /system/getty. machine # [ 6.233820] systemd[1]: Created slice User and Session Slice. machine # [ 6.234866] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. machine # [ 6.236104] systemd[1]: Started Forward Password Requests to Wall Directory Watch. machine # [ 6.237190] systemd[1]: Expecting device /dev/hvc0... machine # [ 6.237860] systemd[1]: Expecting device /dev/ttyS0... machine # [ 6.238607] systemd[1]: Reached target Local Encrypted Volumes. machine # [ 6.239447] systemd[1]: Stopped target initrd-fs.target. machine # [ 6.240209] systemd[1]: Stopped target initrd-root-fs.target. machine # [ 6.241010] systemd[1]: Stopped target initrd-switch-root.target. machine # [ 6.241805] systemd[1]: Reached target Virtual Machines and Containers. machine # [ 6.242689] systemd[1]: Reached target Path Units. machine # [ 6.243405] systemd[1]: Reached target Remote File Systems. machine # [ 6.244184] systemd[1]: Reached target Slice Units. machine # [ 6.244862] systemd[1]: Reached target Swaps. machine # [ 6.247113] systemd[1]: Listening on Query the User Interactively for a Password. machine # [ 6.261572] systemd[1]: Listening on Process Core Dump Socket. machine # [ 6.263812] systemd[1]: Listening on Credential Encryption/Decryption. machine # [ 6.265966] systemd[1]: Listening on Factory Reset Management. machine # [ 6.266820] systemd[1]: Listening on Hostname Service Socket. machine # [ 6.269852] systemd[1]: Starting Journal Log Access Socket... machine # [ 6.271576] systemd[1]: Listening on Journal Audit Socket. machine # [ 6.273880] systemd[1]: Listening on Console Output Muting Service Socket. machine # [ 6.275374] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket. machine # [ 6.276795] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 6.278106] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 6.284598] systemd[1]: Listening on Disk Repartitioning Service Socket. machine # [ 6.285626] systemd[1]: Listening on udev Varlink Socket. machine # [ 6.289128] systemd[1]: Mounting Huge Pages File System... machine # [ 6.292000] systemd[1]: Mounting POSIX Message Queue File System... machine # [ 6.297772] systemd[1]: Mounting Kernel Debug File System... machine # [ 6.305877] systemd[1]: Mounting Kernel Trace File System... machine # [ 6.311312] systemd[1]: Starting Create List of Static Device Nodes... machine # [ 6.314080] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio machine # [ 6.324660] systemd[1]: Starting Load Kernel Module configfs... machine # [ 6.326683] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm machine # [ 6.328339] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 6.330553] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse machine # [ 6.339080] systemd[1]: Mounting FUSE Control File System... machine # [ 6.340150] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 6.383360] systemd[1]: Starting Journal Service... machine # [ 6.399611] systemd[1]: Starting Load Kernel Modules... machine # [ 6.420089] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer... machine # [ 6.430165] systemd[1]: Starting Remount Root and Kernel File Systems... machine # [ 6.441855] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 6.453321] systemd[1]: Starting Coldplug All udev Devices... machine # [ 6.471025] systemd[1]: Listening on Journal Log Access Socket. machine # [ 6.473378] systemd-journald[289]: Collecting audit messages is enabled. machine # [ 6.475190] systemd[1]: Mounted Huge Pages File System. machine # [ 6.479497] systemd[1]: Mounted POSIX Message Queue File System. machine # [ 6.485794] systemd[1]: Mounted Kernel Debug File System. machine # [ 6.490529] systemd[1]: Mounted Kernel Trace File System. machine # [ 6.498201] loop: module loaded machine # [ 6.498829] systemd[1]: Finished Create List of Static Device Nodes. machine # [ 6.361647] systemd[1]: Queued start job for default target Multi-User System. machine # [ 6.507600] systemd[1]: Started Journal Service. machine # [ 6.365854] systemd[1]: systemd-journald.service: Deactivated successfully. machine # [ 6.509955] EXT4-fs (vda): re-mounted 30f53e26-f621-4423-a3b2-e32981db1c89. machine # [ 6.369521] systemd-modules-load[290]: Inserted module 'loop' machine # [ 6.376511] systemd[1]: modprobe@configfs.service: Deactivated successfully. machine # [ 6.379360] systemd[1]: Finished Load Kernel Module configfs. machine # [ 6.380593] systemd[1]: Mounted FUSE Control File System. machine # [ 6.384077] systemd[1]: Finished Load Kernel Modules. machine # [ 6.387106] systemd[1]: Finished Remount Root and Kernel File Systems. machine # [ 6.404084] systemd[1]: Listening on Disk Image Download Service Socket. machine # [ 6.408991] systemd[1]: Mounting Kernel Configuration File System... machine # [ 6.413317] systemd[1]: Starting Firewall... machine # [ 6.424925] systemd[1]: Starting Flush Journal to Persistent Storage... machine # [ 6.428134] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 6.438087] systemd-oomd[291]: No swap; memory pressure usage will be degraded machine # [ 6.444752] systemd[1]: Starting Load/Save OS Random Seed... machine # [ 6.452327] systemd[1]: Starting Apply Kernel Variables... machine # [ 6.470119] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... machine # [ 6.471155] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 6.472279] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer. machine # [ 6.642279] systemd-journald[289]: Received client request to flush runtime journal. machine # [ 6.646551] systemd[1]: Mounted Kernel Configuration File System. machine # [ 6.647609] systemd[1]: Finished Load/Save OS Random Seed. machine # [ 6.651058] systemd[1]: Reached target First Boot Complete. machine # [ 6.652200] systemd[1]: Finished Apply Kernel Variables. machine # [ 6.653876] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. machine # [ 6.655224] systemd[1]: Starting Create Static Device Nodes in /dev... machine # [ 6.656858] systemd[1]: Finished Flush Journal to Persistent Storage. machine # [ 6.714774] systemd[1]: Finished Create Static Device Nodes in /dev. machine # [ 6.717144] systemd[1]: Reached target Preparation for Local File Systems. machine # [ 6.721851] systemd[1]: Starting Rule-based Manager for Device Events and Files... machine # [ 6.799512] systemd[1]: Finished Coldplug All udev Devices. machine # [ 6.809770] systemd-udevd[330]: Using default interface naming scheme 'v261'. machine # [ 6.916164] systemd[1]: Started Rule-based Manager for Device Events and Files. machine # [ 7.046420] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse machine # [ 7.088156] systemd[1]: Mounting /run/wrappers... machine # [ 7.129097] systemd[1]: Mounted /run/wrappers. machine # [ 7.132670] systemd[1]: Condition check resulted in /dev/hvc0 being skipped. machine # [ 7.133733] systemd[1]: Reached target Local File Systems. machine # [ 7.138470] systemd[1]: Listening on Boot Loader Control Service Socket. machine # [ 7.143906] systemd[1]: Starting register-nix-paths.service... machine # [ 7.147112] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 7.148321] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 7.157381] systemd[1]: Starting Save Transient machine-id to Disk... machine # [ 7.174087] systemd[1]: Starting Create System Files and Directories... machine # [ 7.175028] systemd[1]: Condition check resulted in /dev/ttyS0 being skipped. machine # [ 7.251683] systemd[1]: etc-machine\x2did.mount: Deactivated successfully. machine # [ 7.258591] systemd[1]: Finished Save Transient machine-id to Disk. machine # [ 7.300196] (udev-worker)[363]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. machine # [ 7.307241] (udev-worker)[369]: Network interface NamePolicy= disabled on kernel command line. machine # [ 7.313121] (udev-worker)[363]: Network interface NamePolicy= disabled on kernel command line. machine # [ 7.325614] systemd[1]: Finished Create System Files and Directories. machine # [ 7.336158] systemd[1]: Starting Rebuild Journal Catalog... machine # [ 7.344912] systemd[1]: Starting Record System Boot/Shutdown in UTMP... machine # [ 7.425394] systemd[1]: Finished Record System Boot/Shutdown in UTMP. machine # [ 7.474460] systemd[1]: Finished Rebuild Journal Catalog. machine # [ 7.480462] systemd[1]: Starting Update is Completed... machine # [ 7.534245] systemd[1]: Finished Update is Completed. machine # [ 7.580050] systemd[1]: Condition check resulted in Virtio network device being skipped. machine # [ 7.581181] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 7.582526] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 7.583729] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 7.585706] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 7.589702] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 7.591162] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 7.735258] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 7.738347] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 7.755390] systemd[1]: Finished Firewall. machine # [ 7.930589] bochs-drm 0000:00:01.0: vgaarb: deactivate vga console machine # [ 7.940167] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input3 machine # [ 7.972063] mousedev: PS/2 mouse device common for all mice machine # [ 7.977218] ACPI: button: Power Button [PWRF] machine # [ 7.978795] input: QEMU Virtio Keyboard as /devices/pci0000:00/0000:00:09.0/virtio7/input/input4 machine # [ 8.048060] rtc_cmos 00:04: RTC can wake from S4 machine # [ 8.068002] rtc_cmos 00:04: registered as rtc0 machine # [ 8.068068] rtc_cmos 00:04: setting system clock to 2026-09-03T02:41:48 UTC (1788403308) machine # [ 8.068143] rtc_cmos 00:04: alarms up to one day, y3k, 242 bytes nvram, hpet irqs machine # [ 8.069517] systemd-journald[289]: Time jumped backwards, rotating. machine # [ 8.080210] parport_pc 00:02: reported by Plug and Play ACPI machine # [ 8.080289] parport0: PC-style at 0x378, irq 7 [PCSPP(,...)] machine # [ 8.103982] Console: switching to colour dummy device 80x25 machine # [ 8.111769] lpc_ich 0000:00:1f.0: I/O space for GPIO uninitialized machine # [ 8.233888] [drm] Found bochs VGA, ID 0xb0c5. machine # [ 8.233890] [drm] Framebuffer size 16384 kB @ 0xfd000000, mmio @ 0xfebd0000. machine # [ 8.242861] i801_smbus 0000:00:1f.3: SMBus using PCI interrupt machine # [ 8.243567] i2c i2c-0: Memory type 0x07 not supported yet, not instantiating SPD machine # [ 8.248048] bochs-drm 0000:00:01.0: [drm] Registered 1 planes with drm panic machine # [ 8.248685] [drm] Initialized bochs-drm 1.0.0 for 0000:00:01.0 on minor 0 machine # [ 8.114973] systemd[1]: Finished register-nix-paths.service. machine # [ 8.116255] systemd[1]: Reached target System Initialization. machine # [ 8.119173] systemd[1]: Started Discard unused filesystem blocks once a week. machine # [ 8.120122] systemd[1]: Started Daily Cleanup of Temporary Directories. machine # [ 8.121489] systemd[1]: Reached target Timer Units. machine # [ 8.122235] systemd[1]: Listening on D-Bus System Message Bus Socket. machine # [ 8.124194] systemd[1]: Listening on Nix Daemon Socket. machine # [ 8.125488] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket. machine # [ 8.126633] systemd[1]: Reached target Socket Units. machine # [ 8.127458] systemd[1]: Reached target Basic System. machine # [ 8.129853] systemd[1]: Started backdoor.service. machine # [ 8.134181] systemd[1]: Starting Import lastlog data into lastlog2 database... machine # [ 8.145148] systemd[1]: Starting Name Service Cache Daemon (nsncd)... machine # [ 8.159189] systemd[1]: Starting Post-Boot Actions... machine # [ 8.164697] systemd[1]: Started Reset console on configuration changes. machine # [ 8.332348] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input6 machine # [ 8.335609] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input5 machine # [ 8.196970] systemd[1]: Starting resolvconf update... machine # [ 8.226947] systemd[1]: Starting D-Bus System Message Bus... machine # [ 8.245187] systemd[1]: Finished Post-Boot Actions. machine # connecting to host... machine # [ 8.276202] nsncd[506]: Sep 03 02:41:48.849 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" machine # [ 8.280267] systemd[1]: Started Name Service Cache Daemon (nsncd). machine # [ 8.281897] systemd[1]: Reached target Host and Network Name Lookups. machine # [ 8.284349] systemd[1]: Reached target User and Group Name Lookups. machine: Guest shell says: b'Spawning backdoor root shell...\n' machine: connected to guest root shell machine # [ 8.298700] systemd[1]: Starting User Login Management... machine: (connecting took 8.95 seconds) machine: (finished: waiting for the VM to finish booting, in 9.25 seconds) machine # [ 8.328390] systemd[1]: Finished Import lastlog data into lastlog2 database. machine # [ 8.356975] systemd[1]: Starting Virtual Console Setup... machine # [ 8.432521] dbus-broker-launch[514]: Looking up NSS user entry for 'systemd-timesync'... machine # [ 8.536752] Console: switching to colour frame buffer device 160x50 machine # [ 8.614337] bochs-drm 0000:00:01.0: [drm] fb0: bochs-drmdrmfb frame buffer device machine # [ 8.481458] systemd-logind[532]: New seat seat0. machine # [ 8.488899] systemd[1]: Started User Login Management. machine # [ 8.490782] systemd-logind[532]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard) machine # [ 8.496359] systemd-logind[532]: Watching system buttons on /dev/input/event2 (Power Button) machine # [ 8.507196] dbus-broker-launch[514]: NSS returned no entry for 'systemd-timesync' machine # [ 8.509213] dbus-broker-launch[514]: Invalid user-name in /nix/store/cbyfllapzm5ln1bq2va5ghalqcswmygw-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" machine # [ 8.516495] systemd[1]: Stopped target Host and Network Name Lookups. machine # [ 8.518127] systemd[1]: Stopping Host and Network Name Lookups... machine # [ 8.518951] systemd[1]: Stopped target User and Group Name Lookups. machine # [ 8.520906] systemd[1]: Stopping User and Group Name Lookups... machine # [ 8.526710] systemd[1]: Starting linger-users.service... machine # [ 8.527545] systemd[1]: Stopping Name Service Cache Daemon (nsncd)... machine # [ 8.533415] systemd[1]: nscd.service: Deactivated successfully. machine # [ 8.536285] systemd[1]: Stopped Name Service Cache Daemon (nsncd). machine # [ 8.554095] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. machine # [ 8.558359] systemd[1]: Stopped Virtual Console Setup. machine # [ 8.566967] systemd[1]: Started D-Bus System Message Bus. machine # [ 8.606150] systemd[1]: Starting Name Service Cache Daemon (nsncd)... machine # [ 8.612261] systemd[1]: Starting Virtual Console Setup... machine # [ 8.615881] dbus-broker-launch[514]: Ready machine # [ 8.649203] systemd[1]: Finished resolvconf update. machine # [ 8.678277] systemd-logind[532]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard) machine # [ 8.688099] systemd[1]: Created slice Slice /user/1001. machine # [ 8.688878] systemd[1]: Reached target Preparation for Network. machine # [ 8.702377] systemd[1]: Starting DHCP Client... machine # [ 8.707748] systemd[1]: Starting Address configuration of eth1... machine # [ 8.853425] ppdev: user-space parallel port driver machine # [ 8.718503] systemd[1]: Starting Extra networking commands.... machine # [ 8.720199] systemd[1]: Starting User Runtime Directory /run/user/1001... machine # [ 8.733733] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 8.747935] systemd[1]: Finished linger-users.service. machine # [ 8.753564] nsncd[602]: Sep 03 02:41:49.309 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" machine # [ 8.760152] systemd[1]: Started Name Service Cache Daemon (nsncd). machine # [ 8.760962] systemd[1]: Reached target Host and Network Name Lookups. machine # [ 8.910980] iTCO_wdt iTCO_wdt.1.auto: Found a ICH9 TCO device (Version=2, TCOBASE=0x0660) machine # [ 8.771690] systemd[1]: Reached target User and Group Name Lookups. machine # [ 8.936162] iTCO_wdt iTCO_wdt.1.auto: initialized. heartbeat=30 sec (nowayout=0) machine # [ 8.809873] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. machine # [ 8.811154] systemd[1]: Stopped Virtual Console Setup. machine # [ 8.821244] systemd[1]: Starting Virtual Console Setup... machine # [ 8.865356] systemd[1]: Finished User Runtime Directory /run/user/1001. machine # [ 8.869903] systemd[1]: Starting User Manager for UID 1001... machine # [ 8.959478] (systemd)[634]: pam_unix(systemd-user:session): session opened for user usertest(uid=1001) by (uid=0) machine # [ 8.977974] systemd-logind[532]: New session '1' of user 'usertest' with class 'manager' and type 'unspecified'. machine # [ 9.018163] network-addresses-eth1-start[612]: adding address 192.168.1.1/24... done machine # [ 9.020838] systemd[634]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 9.097475] systemd[1]: Finished Address configuration of eth1. machine # [ 9.100454] network-addresses-eth1-start[612]: adding address 2001:db8:1::1/64... done machine # [ 9.255310] kvm_amd: TSC scaling supported machine # [ 9.255791] kvm_amd: Nested Virtualization enabled machine # [ 9.262567] kvm_amd: Nested Paging enabled machine # [ 9.266375] kvm_amd: LBR virtualization supported machine # [ 9.269998] kvm_amd: Virtual VMLOAD VMSAVE supported machine # [ 9.270641] kvm_amd: Virtual GIF supported machine # [ 9.277328] kvm_amd: Virtual NMI enabled machine # [ 9.206493] systemd[1]: Finished Extra networking commands.. machine # [ 9.207654] systemd[1]: Reached target Network. machine # [ 9.210284] systemd[1]: Starting Permit User Sessions... machine # [ 9.363392] EDAC MC: Ver: 3.0.0 machine # [ 9.225429] dhcpcd[642]: dhcpcd-10.3.2 starting machine # [ 9.237652] dhcpcd[705]: dev: loaded udev machine # [ 9.257766] systemd[1]: Finished Permit User Sessions. machine # [ 9.260534] systemd[634]: Queued start job for default target Main User Target. machine # [ 9.408494] 8021q: 802.1Q VLAN Support v1.8 machine # [ 9.266458] systemd[634]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 9.269419] systemd[634]: Created slice User Application Slice. machine # [ 9.271079] systemd[1]: Started Getty on tty1. machine # [ 9.416344] 8021q: adding VLAN 0 to HW filter on device eth1 machine # [ 9.274800] systemd[1]: Reached target Login Prompts. machine # [ 9.275794] systemd[634]: Started Daily Cleanup of User's Temporary Directories. machine # [ 9.280091] systemd[634]: Reached target Paths. machine # [ 9.281845] systemd[634]: Reached target Timers. machine # [ 9.283438] systemd[634]: Starting D-Bus User Message Bus Socket... machine # [ 9.287093] systemd[634]: Starting Create User Files and Directories... machine # [ 9.315090] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch. machine # [ 9.341406] systemd[634]: Finished Create User Files and Directories. machine # [ 9.533624] cfg80211: Loading compiled-in X.509 certificates for regulatory database machine # [ 9.409658] systemd[634]: Listening on D-Bus User Message Bus Socket. machine # [ 9.411472] systemd[634]: Reached target Sockets. machine # [ 9.412630] systemd[634]: Reached target Basic System. machine # [ 9.416384] systemd[1]: Started User Manager for UID 1001. machine # [ 9.418401] systemd[634]: Starting Run user-specific NixOS activation... machine # [ 9.565516] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' machine # [ 9.567168] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600' machine # [ 9.571429] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -2 machine # [ 9.572436] cfg80211: failed to load regulatory.db machine # [ 9.461249] systemd[634]: Finished Run user-specific NixOS activation. machine # [ 9.463330] systemd[634]: Reached target Main User Target. machine # [ 9.464644] systemd[634]: Startup finished in 455ms. machine # [ 9.627601] 8021q: adding VLAN 0 to HW filter on device eth0 machine # [ 9.485915] dhcpcd[705]: eth0: waiting for carrier machine # [ 9.487474] dhcpcd[705]: eth0: carrier acquired machine # [ 9.496085] dhcpcd[705]: DUID 00:01:00:01:32:2b:9a:ee:52:54:00:12:34:56 machine # [ 9.497352] dhcpcd[705]: eth0: IAID 00:12:34:56 machine # [ 9.498189] dhcpcd[705]: eth0: adding address fe80::5054:ff:fe12:3456 machine # [ 9.554669] systemd-vconsole-setup[630]: Configuration of first virtual console was skipped, ignoring remaining ones. machine # [ 9.560308] systemd[1]: Finished Virtual Console Setup. machine # [ 10.843236] dhcpcd[705]: eth0: soliciting a DHCP lease machine # [ 11.005378] NET: Registered PF_PACKET protocol family machine # [ 10.866451] dhcpcd[705]: eth0: offered 10.0.2.15 from 10.0.2.2 machine # [ 10.869368] dhcpcd[705]: eth0: probing address 10.0.2.15/24 machine # [ 12.327757] dhcpcd[705]: eth0: soliciting an IPv6 router machine # [ 12.330594] dhcpcd[705]: eth0: Router Advertisement from fe80::2 machine # [ 12.332907] dhcpcd[705]: eth0: adding address fec0::5054:ff:fe12:3456/64 machine # [ 12.335447] dhcpcd[705]: eth0: adding route to fec0::/64 machine # [ 12.337583] dhcpcd[705]: eth0: adding default route via fe80::2 machine # [ 15.182191] dhcpcd[705]: eth0: leased 10.0.2.15 for 86400 seconds machine # [ 15.183377] dhcpcd[705]: eth0: adding route to 10.0.2.0/24 machine # [ 15.184421] dhcpcd[705]: eth0: adding default route via 10.0.2.2 machine # [ 15.269804] systemd[1]: Started DHCP Client. machine # [ 15.271745] systemd[1]: Reached target Multi-User System. machine # [ 15.272737] systemd[1]: Startup finished in 857ms (kernel) + 3.827s (initrd) + 10.586s (userspace) = 15.271s. machine: (finished: waiting for unit multi-user.target, in 17.03 seconds) machine: must succeed: /nix/store/w1psanxc52jqfm0knzrj6gw0pz8my68n-stderr-runner /nix/store/35s2igiaaj5g08gc3r9xqcrxf6sx5fyq-nixos-system-machine-test/bin/switch-to-configuration test machine # Checking switch inhibitors... done machine # [ 16.566331] nixos[853]: switching to system configuration /nix/store/35s2igiaaj5g08gc3r9xqcrxf6sx5fyq-nixos-system-machine-test machine # activating the configuration... machine # [ 16.570201] systemd[1]: Stopped target Remote File Systems. machine # [ 16.571139] systemd[1]: Stopped target Local File Systems. machine # setting up /etc... machine # [ 16.938074] systemd[1]: Reload requested from client PID 853 ('.switch-to-conf') (unit backdoor.service)... machine # [ 16.939758] systemd[1]: Reloading... machine # [ 17.452072] systemd[1]: Reloading finished in 509 ms. machine # reloading user units for usertest... machine # [ 17.483822] systemd[634]: Created slice User Core Session Slice. machine # [ 17.486913] systemd[634]: Starting D-Bus User Message Bus... machine # [ 17.542412] dbus-broker-launch[923]: Ignoring duplicate name 'org.freedesktop.import1' in service file '/nix/store/cbyfllapzm5ln1bq2va5ghalqcswmygw-system-path/share/dbus-1/services/org.freedesktop.import1.service' machine # [ 17.545080] dbus-broker-launch[923]: Ignoring duplicate name 'org.freedesktop.machine1' in service file '/nix/store/cbyfllapzm5ln1bq2va5ghalqcswmygw-system-path/share/dbus-1/services/org.freedesktop.machine1.service' machine # [ 17.547914] dbus-broker-launch[923]: Ignoring duplicate name 'org.freedesktop.portable1' in service file '/nix/store/cbyfllapzm5ln1bq2va5ghalqcswmygw-system-path/share/dbus-1/services/org.freedesktop.portable1.service' machine # [ 17.550841] dbus-broker-launch[923]: Ignoring duplicate name 'org.freedesktop.systemd1' in service file '/nix/store/cbyfllapzm5ln1bq2va5ghalqcswmygw-system-path/share/dbus-1/services/org.freedesktop.systemd1.service' machine # [ 17.554338] dbus-broker-launch[923]: Policy to allow eavesdropping in /etc/dbus-1/session.conf +27: Eavesdropping is deprecated and ignored machine # [ 17.555811] dbus-broker-launch[923]: Policy to allow eavesdropping in /etc/dbus-1/session.conf +29: Eavesdropping is deprecated and ignored machine # [ 17.557693] systemd[634]: Started D-Bus User Message Bus. machine # [ 17.565771] dbus-broker-launch[923]: Ready machine # [ 17.655505] systemd[634]: Reexecution requested from client PID 922 ('switch-to-confi')... machine # [ 17.656734] systemd[634]: Reexecuting. machine # [ 17.682430] systemd[634]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 17.808327] systemd[634]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 17.813581] systemd[634]: Reload requested from client PID 922 ('switch-to-confi')... machine # [ 17.815207] systemd[634]: Reloading... machine # [ 17.926836] systemd[634]: Reloading finished in 110 ms. machine # [ 17.932818] systemd[634]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # restarting the following user units: nixos-activation.service machine # [ 17.939815] systemd[634]: Stopped Run user-specific NixOS activation. machine # [ 17.940888] systemd[634]: Stopping Run user-specific NixOS activation... machine # [ 17.943771] systemd[634]: Starting Run user-specific NixOS activation... machine # [ 17.972266] systemd[634]: Finished Run user-specific NixOS activation. machine # restarting sysinit-reactivation.target machine # [ 17.986151] systemd[1]: Starting Re-setup tmpfiles on a system that is already running.... machine # [ 18.074072] systemd[1]: Finished Re-setup tmpfiles on a system that is already running.. machine # [ 18.076236] systemd[1]: Reached target Reactivate sysinit units. machine # [ 18.080660] systemd[1]: Reached target Remote File Systems. machine # [ 18.082637] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 18.084230] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 18.089959] systemd[1]: Starting linger-users.service... machine # [ 18.096262] systemd[1]: Reached target Local File Systems. machine # [ 18.099322] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 18.104172] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 18.104916] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 18.106099] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 18.108810] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 18.110660] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 18.112029] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 18.153695] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 18.155319] systemd[1]: Finished linger-users.service. machine # [ 18.365231] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 18.366798] systemd[1]: Finished Create SUID/SGID Wrappers. machine # the following new units were started: sysinit-reactivation.target, systemd-tmpfiles-resetup.service machine # [ 18.623333] nixos[853]: finished switching to system configuration /nix/store/35s2igiaaj5g08gc3r9xqcrxf6sx5fyq-nixos-system-machine-test machine: (finished: must succeed: /nix/store/w1psanxc52jqfm0knzrj6gw0pz8my68n-stderr-runner /nix/store/35s2igiaaj5g08gc3r9xqcrxf6sx5fyq-nixos-system-machine-test/bin/switch-to-configuration test, in 2.55 seconds) machine: must succeed: rm /etc/NIXOS machine: (finished: must succeed: rm /etc/NIXOS, in 0.02 seconds) machine: must succeed: /nix/store/w1psanxc52jqfm0knzrj6gw0pz8my68n-stderr-runner /nix/store/9w14g6ph6iqv67ndrh96m8j6md1xhxm9-nixos-system-other-test/bin/switch-to-configuration test machine # this should succeed (config: /nix/store/9w14g6ph6iqv67ndrh96m8j6md1xhxm9-nixos-system-other-test, action: test) machine # Checking switch inhibitors... done machine # [ 19.194652] nixos[1000]: switching to system configuration /nix/store/9w14g6ph6iqv67ndrh96m8j6md1xhxm9-nixos-system-other-test machine # activating the configuration... machine # [ 19.198407] systemd[1]: Stopped target Remote File Systems. machine # [ 19.199265] systemd[1]: Stopped target Local File Systems. machine # removing user ‘usertest’ machine # setting up /etc... machine # [ 19.610170] systemd[1]: Reload requested from client PID 1000 ('.switch-to-conf') (unit backdoor.service)... machine # [ 19.611834] systemd[1]: Reloading... machine # [ 20.121128] systemd[1]: Reloading finished in 507 ms. machine # reloading user units for usertest... machine # [ 20.242430] systemd[634]: Reexecution requested from client PID 1072 ('switch-to-confi')... machine # [ 20.243724] systemd[634]: Reexecuting. machine # [ 20.268421] systemd[634]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 20.411474] systemd[634]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 20.416269] systemd[634]: Reload requested from client PID 1072 ('switch-to-confi')... machine # [ 20.418024] systemd[634]: Reloading... machine # [ 20.541497] systemd[634]: Reloading finished in 120 ms. machine # [ 20.545804] systemd[634]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # restarting the following user units: nixos-activation.service machine # [ 20.552936] systemd[634]: Stopped Run user-specific NixOS activation. machine # [ 20.554370] systemd[634]: Stopping Run user-specific NixOS activation... machine # [ 20.557143] systemd[634]: Starting Run user-specific NixOS activation... machine # [ 20.591638] systemd[634]: Finished Run user-specific NixOS activation. machine # restarting sysinit-reactivation.target machine # [ 20.595576] systemd[1]: Stopped target Reactivate sysinit units. machine # reloading the following units: dbus-broker.service machine # [ 20.597913] systemd[1]: Stopping Reactivate sysinit units... machine # [ 20.598791] systemd[1]: Reached target Reactivate sysinit units. machine # [ 20.600776] dbus-broker-launch[514]: Caught SIGHUP, trigger reload. machine # [ 20.602458] systemd[1]: Reloading D-Bus System Message Bus... machine # [ 20.620768] dbus-broker-launch[514]: Looking up NSS user entry for 'systemd-timesync'... machine # [ 20.622717] dbus-broker-launch[514]: NSS returned no entry for 'systemd-timesync' machine # [ 20.623753] dbus-broker-launch[514]: Invalid user-name in /nix/store/h586j6zx3nwqd354pg3jzsx05yvfqlr4-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" machine # [ 20.646118] systemd[1]: Reloaded D-Bus System Message Bus. machine # restarting the following units: network-addresses-eth1.service machine # [ 20.651672] systemd[1]: Stopping Address configuration of eth1... machine # [ 20.690131] network-addresses-eth1-pre-stop[1084]: deleting address 192.168.1.1/24... done machine # [ 20.700305] network-addresses-eth1-pre-stop[1084]: deleting address 2001:db8:1::1/64... done machine # [ 20.708416] systemd[1]: network-addresses-eth1.service: Deactivated successfully. machine # [ 20.710081] systemd[1]: Stopped Address configuration of eth1. machine # [ 20.713836] systemd[1]: Starting Address configuration of eth1... machine # [ 20.772615] network-addresses-eth1-start[1089]: adding address 192.168.1.2/24... done machine # [ 20.783368] network-addresses-eth1-start[1089]: adding address 2001:db8:1::2/64... done machine # [ 20.796866] systemd[1]: Finished Address configuration of eth1. machine # [ 20.800949] systemd[1]: Reached target Remote File Systems. machine # [ 20.804282] systemd[1]: Starting linger-users.service... machine # [ 20.807602] systemd[1]: Reached target Local File Systems. machine # [ 20.809151] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 20.814644] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 20.815719] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 20.816950] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 20.818896] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 20.820537] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 20.822131] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 20.829134] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 20.830377] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 20.870831] linger-users-start[1103]: id: ‘usertest’: no such user machine # [ 20.872883] linger-users-start[1100]: Removing linger for missing user usertest machine # [ 20.882221] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 20.883224] systemd[1]: Finished linger-users.service. machine # [ 21.174553] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 21.176359] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 21.431487] nixos[1000]: finished switching to system configuration /nix/store/9w14g6ph6iqv67ndrh96m8j6md1xhxm9-nixos-system-other-test machine: (finished: must succeed: /nix/store/w1psanxc52jqfm0knzrj6gw0pz8my68n-stderr-runner /nix/store/9w14g6ph6iqv67ndrh96m8j6md1xhxm9-nixos-system-other-test/bin/switch-to-configuration test, in 2.79 seconds) subtest: services machine: must succeed: /nix/store/35s2igiaaj5g08gc3r9xqcrxf6sx5fyq-nixos-system-machine-test/bin/switch-to-configuration test 2>&1 machine # [ 21.878084] nixos[1167]: switching to system configuration /nix/store/35s2igiaaj5g08gc3r9xqcrxf6sx5fyq-nixos-system-machine-test machine # [ 21.881516] systemd[1]: Stopped target Local File Systems. machine # [ 21.882338] systemd[1]: Stopped target Remote File Systems. machine # [ 22.254795] systemd[1]: Reload requested from client PID 1167 ('.switch-to-conf') (unit backdoor.service)... machine # [ 22.256484] systemd[1]: Reloading... machine # [ 22.756151] systemd[1]: Reloading finished in 497 ms. machine # [ 22.861253] systemd[634]: Reexecution requested from client PID 1236 ('switch-to-confi')... machine # [ 22.862580] systemd[634]: Reexecuting. machine # [ 22.889028] systemd[634]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 23.028973] systemd[634]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 23.036730] systemd[634]: Reload requested from client PID 1236 ('switch-to-confi')... machine # [ 23.038477] systemd[634]: Reloading... machine # [ 23.164822] systemd[634]: Reloading finished in 124 ms. machine # [ 23.170837] systemd[634]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 23.177241] systemd[634]: Stopped Run user-specific NixOS activation. machine # [ 23.179063] systemd[634]: Stopping Run user-specific NixOS activation... machine # [ 23.181439] systemd[634]: Starting Run user-specific NixOS activation... machine # [ 23.212823] systemd[634]: Finished Run user-specific NixOS activation. machine # [ 23.216532] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 23.217953] systemd[1]: Stopping Reactivate sysinit units... machine # [ 23.219225] systemd[1]: Reached target Reactivate sysinit units. machine # [ 23.221966] dbus-broker-launch[514]: Caught SIGHUP, trigger reload. machine # [ 23.222916] systemd[1]: Reloading D-Bus System Message Bus... machine # [ 23.235183] dbus-broker-launch[514]: Looking up NSS user entry for 'systemd-timesync'... machine # [ 23.237084] dbus-broker-launch[514]: NSS returned no entry for 'systemd-timesync' machine # [ 23.237972] dbus-broker-launch[514]: Invalid user-name in /nix/store/cbyfllapzm5ln1bq2va5ghalqcswmygw-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" machine # [ 23.257939] systemd[1]: Reloaded D-Bus System Message Bus. machine # [ 23.263174] systemd[1]: Stopping Address configuration of eth1... machine # [ 23.302128] network-addresses-eth1-pre-stop[1249]: deleting address 192.168.1.2/24... done machine # [ 23.313559] network-addresses-eth1-pre-stop[1249]: deleting address 2001:db8:1::2/64... done machine # [ 23.321608] systemd[1]: network-addresses-eth1.service: Deactivated successfully. machine # [ 23.323239] systemd[1]: Stopped Address configuration of eth1. machine # [ 23.327486] systemd[1]: Starting Address configuration of eth1... machine # [ 23.387399] network-addresses-eth1-start[1254]: adding address 192.168.1.1/24... done machine # [ 23.398773] network-addresses-eth1-start[1254]: adding address 2001:db8:1::1/64... done machine # [ 23.412358] systemd[1]: Finished Address configuration of eth1. machine # [ 23.416514] systemd[1]: Reached target Remote File Systems. machine # [ 23.420174] systemd[1]: Reached target Local File Systems. machine # [ 23.420907] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 23.424370] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 23.426239] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 23.428562] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 23.430762] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 23.433260] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 23.434674] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 23.438059] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 23.439265] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 23.733439] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 23.735075] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 23.739816] systemd[1]: Starting linger-users.service... machine # [ 23.779667] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 23.781313] systemd[1]: Finished linger-users.service. machine # [ 24.035743] nixos[1167]: finished switching to system configuration /nix/store/35s2igiaaj5g08gc3r9xqcrxf6sx5fyq-nixos-system-machine-test machine: (finished: must succeed: /nix/store/35s2igiaaj5g08gc3r9xqcrxf6sx5fyq-nixos-system-machine-test/bin/switch-to-configuration test 2>&1, in 2.60 seconds) machine: must succeed: /nix/store/35s2igiaaj5g08gc3r9xqcrxf6sx5fyq-nixos-system-machine-test/bin/switch-to-configuration test 2>&1 machine # [ 24.563263] nixos[1323]: switching to system configuration /nix/store/35s2igiaaj5g08gc3r9xqcrxf6sx5fyq-nixos-system-machine-test machine # [ 24.565522] systemd[1]: Stopped target Remote File Systems. machine # [ 24.567226] systemd[1]: Stopped target Local File Systems. machine # [ 24.944599] systemd[1]: Reload requested from client PID 1323 ('.switch-to-conf') (unit backdoor.service)... machine # [ 24.946251] systemd[1]: Reloading... machine # [ 25.409840] systemd[1]: Reloading finished in 461 ms. machine # [ 25.531875] systemd[634]: Reexecution requested from client PID 1392 ('switch-to-confi')... machine # [ 25.533129] systemd[634]: Reexecuting. machine # [ 25.560628] systemd[634]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 25.703141] systemd[634]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 25.709030] systemd[634]: Reload requested from client PID 1392 ('switch-to-confi')... machine # [ 25.710817] systemd[634]: Reloading... machine # [ 25.854734] systemd[634]: Reloading finished in 142 ms. machine # [ 25.860803] systemd[634]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 25.867568] systemd[634]: Stopped Run user-specific NixOS activation. machine # [ 25.869125] systemd[634]: Stopping Run user-specific NixOS activation... machine # [ 25.872036] systemd[634]: Starting Run user-specific NixOS activation... machine # [ 25.908176] systemd[634]: Finished Run user-specific NixOS activation. machine # [ 25.911796] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 25.913617] systemd[1]: Stopping Reactivate sysinit units... machine # [ 25.915196] systemd[1]: Reached target Reactivate sysinit units. machine # [ 25.919059] systemd[1]: Reached target Local File Systems. machine # [ 25.921489] systemd[1]: Reached target Remote File Systems. machine # [ 25.925428] systemd[1]: Starting linger-users.service... machine # [ 25.928732] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 25.930390] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 25.935166] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 25.940334] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 25.941904] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 25.943285] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 25.945537] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 25.947206] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 25.948552] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 26.001849] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 26.004451] systemd[1]: Finished linger-users.service. machine # [ 26.260225] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 26.261781] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 26.519481] nixos[1323]: finished switching to system configuration /nix/store/35s2igiaaj5g08gc3r9xqcrxf6sx5fyq-nixos-system-machine-test machine: (finished: must succeed: /nix/store/35s2igiaaj5g08gc3r9xqcrxf6sx5fyq-nixos-system-machine-test/bin/switch-to-configuration test 2>&1, in 2.49 seconds) machine: must succeed: /nix/store/35s2igiaaj5g08gc3r9xqcrxf6sx5fyq-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration test 2>&1 machine # [ 27.054991] nixos[1464]: switching to system configuration /nix/store/n7gzcawn9xhb925pvdpgyc11irdv82jn-nixos-system-machine-test machine # [ 27.057236] systemd[1]: Stopped target Remote File Systems. machine # [ 27.058867] systemd[1]: Stopped target Local File Systems. machine # [ 27.453286] systemd[1]: Reload requested from client PID 1464 ('.switch-to-conf') (unit backdoor.service)... machine # [ 27.454886] systemd[1]: Reloading... machine # [ 27.969782] systemd[1]: Reloading finished in 512 ms. machine # [ 28.086313] systemd[634]: Reexecution requested from client PID 1533 ('switch-to-confi')... machine # [ 28.087562] systemd[634]: Reexecuting. machine # [ 28.115885] systemd[634]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 28.249643] systemd[634]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 28.254600] systemd[634]: Reload requested from client PID 1533 ('switch-to-confi')... machine # [ 28.255793] systemd[634]: Reloading... machine # [ 28.395593] systemd[634]: Reloading finished in 137 ms. machine # [ 28.400809] systemd[634]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 28.408068] systemd[634]: Stopped Run user-specific NixOS activation. machine # [ 28.408875] systemd[634]: Stopping Run user-specific NixOS activation... machine # [ 28.411479] systemd[634]: Starting Run user-specific NixOS activation... machine # [ 28.445641] systemd[634]: Finished Run user-specific NixOS activation. machine # [ 28.449925] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 28.450869] systemd[1]: Stopping Reactivate sysinit units... machine # [ 28.452060] systemd[1]: Reached target Reactivate sysinit units. machine # [ 28.456573] systemd[1]: Reached target Local File Systems. machine # [ 28.460103] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 28.463859] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 28.464710] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 28.465872] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 28.467826] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 28.469278] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 28.472771] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 28.474971] systemd[1]: Reached target Remote File Systems. machine # [ 28.480377] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 28.481580] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 28.771947] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 28.773536] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 28.778153] systemd[1]: Starting linger-users.service... machine # [ 28.781571] systemd[1]: Starting test.service... machine # [ 28.810711] systemd[1]: Finished test.service. machine # [ 28.833569] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 28.834620] systemd[1]: Finished linger-users.service. machine # [ 29.088997] nixos[1464]: finished switching to system configuration /nix/store/n7gzcawn9xhb925pvdpgyc11irdv82jn-nixos-system-machine-test machine: (finished: must succeed: /nix/store/35s2igiaaj5g08gc3r9xqcrxf6sx5fyq-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration test 2>&1, in 2.56 seconds) machine: must succeed: /nix/store/35s2igiaaj5g08gc3r9xqcrxf6sx5fyq-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration test 2>&1 machine # [ 29.586385] nixos[1607]: switching to system configuration /nix/store/n7gzcawn9xhb925pvdpgyc11irdv82jn-nixos-system-machine-test machine # [ 29.588759] systemd[1]: Stopped target Remote File Systems. machine # [ 29.590739] systemd[1]: Stopped target Local File Systems. machine # [ 29.971722] systemd[1]: Reload requested from client PID 1607 ('.switch-to-conf') (unit backdoor.service)... machine # [ 29.973395] systemd[1]: Reloading... machine # [ 30.489073] systemd[1]: Reloading finished in 513 ms. machine # [ 30.585388] systemd[634]: Reexecution requested from client PID 1676 ('switch-to-confi')... machine # [ 30.586760] systemd[634]: Reexecuting. machine # [ 30.611702] systemd[634]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 30.738821] systemd[634]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 30.744735] systemd[634]: Reload requested from client PID 1676 ('switch-to-confi')... machine # [ 30.746195] systemd[634]: Reloading... machine # [ 30.870198] systemd[634]: Reloading finished in 121 ms. machine # [ 30.874812] systemd[634]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 30.881062] systemd[634]: Stopped Run user-specific NixOS activation. machine # [ 30.881907] systemd[634]: Stopping Run user-specific NixOS activation... machine # [ 30.884913] systemd[634]: Starting Run user-specific NixOS activation... machine # [ 30.911875] systemd[634]: Finished Run user-specific NixOS activation. machine # [ 30.915601] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 30.916694] systemd[1]: Stopping Reactivate sysinit units... machine # [ 30.917682] systemd[1]: Reached target Reactivate sysinit units. machine # [ 30.919585] systemd[1]: Reached target Remote File Systems. machine # [ 30.923300] systemd[1]: Starting linger-users.service... machine # [ 30.928757] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 30.929979] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 30.938220] systemd[1]: Reached target Local File Systems. machine # [ 30.940117] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 30.943965] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 30.944760] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 30.945911] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 30.947813] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 30.949290] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 30.950412] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 30.993778] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 30.995856] systemd[1]: Finished linger-users.service. machine # [ 31.213552] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 31.215803] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 31.469729] nixos[1607]: finished switching to system configuration /nix/store/n7gzcawn9xhb925pvdpgyc11irdv82jn-nixos-system-machine-test machine: (finished: must succeed: /nix/store/35s2igiaaj5g08gc3r9xqcrxf6sx5fyq-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration test 2>&1, in 2.38 seconds) machine: must succeed: /nix/store/35s2igiaaj5g08gc3r9xqcrxf6sx5fyq-nixos-system-machine-test/specialisation/simpleServiceDifferentDescription/bin/switch-to-configuration test 2>&1 machine # [ 31.940110] nixos[1747]: switching to system configuration /nix/store/zwqj2553svxcl2jv7d7ypiqmb9yfrd6z-nixos-system-machine-test machine # [ 31.943715] systemd[1]: Stopped target Remote File Systems. machine # [ 31.944597] systemd[1]: Stopped target Local File Systems. machine # [ 32.368894] systemd[1]: Reload requested from client PID 1747 ('.switch-to-conf') (unit backdoor.service)... machine # [ 32.370589] systemd[1]: Reloading... machine # [ 32.873825] systemd[1]: Reloading finished in 501 ms. machine # [ 32.988254] systemd[634]: Reexecution requested from client PID 1817 ('switch-to-confi')... machine # [ 32.990105] systemd[634]: Reexecuting. machine # [ 33.016853] systemd[634]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 33.151407] systemd[634]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 33.156448] systemd[634]: Reload requested from client PID 1817 ('switch-to-confi')... machine # [ 33.157761] systemd[634]: Reloading... machine # [ 33.293872] systemd[634]: Reloading finished in 134 ms. machine # [ 33.298813] systemd[634]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 33.305253] systemd[634]: Stopped Run user-specific NixOS activation. machine # [ 33.307068] systemd[634]: Stopping Run user-specific NixOS activation... machine # [ 33.309252] systemd[634]: Starting Run user-specific NixOS activation... machine # [ 33.339598] systemd[634]: Finished Run user-specific NixOS activation. machine # [ 33.343610] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 33.345117] systemd[1]: Stopping Reactivate sysinit units... machine # [ 33.345868] systemd[1]: Reached target Reactivate sysinit units. machine # [ 33.348409] systemd[1]: Reached target Local File Systems. machine # [ 33.350336] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 33.354426] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 33.355420] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 33.357407] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 33.359717] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 33.361470] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 33.362929] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 33.365111] systemd[1]: Reached target Remote File Systems. machine # [ 33.373574] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 33.374932] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 33.651777] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 33.653616] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 33.658470] systemd[1]: Starting linger-users.service... machine # [ 33.704529] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 33.705615] systemd[1]: Finished linger-users.service. machine # [ 33.963182] nixos[1747]: finished switching to system configuration /nix/store/zwqj2553svxcl2jv7d7ypiqmb9yfrd6z-nixos-system-machine-test machine: (finished: must succeed: /nix/store/35s2igiaaj5g08gc3r9xqcrxf6sx5fyq-nixos-system-machine-test/specialisation/simpleServiceDifferentDescription/bin/switch-to-configuration test 2>&1, in 2.50 seconds) machine: must succeed: /nix/store/35s2igiaaj5g08gc3r9xqcrxf6sx5fyq-nixos-system-machine-test/specialisation/simpleServiceModified/bin/switch-to-configuration test 2>&1 machine # [ 34.496351] nixos[1888]: switching to system configuration /nix/store/n788mwmciq2xmsw9fmykq4h4nnvn0d8q-nixos-system-machine-test machine # [ 34.499377] systemd[1]: test.service: Deactivated successfully. machine # [ 34.500228] systemd[1]: Stopped Test unit. machine # [ 34.501324] systemd[1]: Stopped target Remote File Systems. machine # [ 34.502735] systemd[1]: Stopped target Local File Systems. machine # [ 34.910493] systemd[1]: Reload requested from client PID 1888 ('.switch-to-conf') (unit backdoor.service)... machine # [ 34.912160] systemd[1]: Reloading... machine # [ 35.396996] systemd[1]: Reloading finished in 483 ms. machine # [ 35.526226] systemd[634]: Reexecution requested from client PID 1957 ('switch-to-confi')... machine # [ 35.528770] systemd[634]: Reexecuting. machine # [ 35.554037] systemd[634]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 35.675807] systemd[634]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 35.681856] systemd[634]: Reload requested from client PID 1957 ('switch-to-confi')... machine # [ 35.683257] systemd[634]: Reloading... machine # [ 35.840737] systemd[634]: Reloading finished in 155 ms. machine # [ 35.845877] systemd[634]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 35.852597] systemd[634]: Stopped Run user-specific NixOS activation. machine # [ 35.853649] systemd[634]: Stopping Run user-specific NixOS activation... machine # [ 35.856908] systemd[634]: Starting Run user-specific NixOS activation... machine # [ 35.890251] systemd[634]: Finished Run user-specific NixOS activation. machine # [ 35.893637] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 35.895285] systemd[1]: Stopping Reactivate sysinit units... machine # [ 35.896809] systemd[1]: Reached target Reactivate sysinit units. machine # [ 35.897783] systemd[1]: Reached target Remote File Systems. machine # [ 35.903549] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 35.905553] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 35.912257] systemd[1]: Starting linger-users.service... machine # [ 35.915583] systemd[1]: Starting test.service... machine # [ 35.919853] systemd[1]: Reached target Local File Systems. machine # [ 35.926242] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 35.929338] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 35.930116] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 35.931248] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 35.933159] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 35.936184] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 35.937370] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 35.963975] systemd[1]: Finished test.service. machine # [ 35.988232] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 35.989357] systemd[1]: Finished linger-users.service. machine # [ 36.202125] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 36.203743] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 36.458670] nixos[1888]: finished switching to system configuration /nix/store/n788mwmciq2xmsw9fmykq4h4nnvn0d8q-nixos-system-machine-test machine: (finished: must succeed: /nix/store/35s2igiaaj5g08gc3r9xqcrxf6sx5fyq-nixos-system-machine-test/specialisation/simpleServiceModified/bin/switch-to-configuration test 2>&1, in 2.49 seconds) machine: must succeed: /nix/store/35s2igiaaj5g08gc3r9xqcrxf6sx5fyq-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1 machine # [ 36.985321] nixos[2031]: switching to system configuration /nix/store/4k7cgqppkbkw0s0q7qk0vaj4038bb70z-nixos-system-machine-test machine # [ 36.987787] systemd[1]: Stopped target Remote File Systems. machine # [ 36.989644] systemd[1]: Stopped target Local File Systems. machine # [ 37.375869] systemd[1]: Reload requested from client PID 2031 ('.switch-to-conf') (unit backdoor.service)... machine # [ 37.377529] systemd[1]: Reloading... machine # [ 37.916762] systemd[1]: Reloading finished in 537 ms. machine # [ 38.017074] systemd[634]: Reexecution requested from client PID 2100 ('switch-to-confi')... machine # [ 38.018362] systemd[634]: Reexecuting. machine # [ 38.041935] systemd[634]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 38.178067] systemd[634]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 38.184905] systemd[634]: Reload requested from client PID 2100 ('switch-to-confi')... machine # [ 38.186488] systemd[634]: Reloading... machine # [ 38.351241] systemd[634]: Reloading finished in 162 ms. machine # [ 38.355810] systemd[634]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 38.363827] systemd[634]: Stopped Run user-specific NixOS activation. machine # [ 38.364846] systemd[634]: Stopping Run user-specific NixOS activation... machine # [ 38.367385] systemd[634]: Starting Run user-specific NixOS activation... machine # [ 38.402805] systemd[634]: Finished Run user-specific NixOS activation. machine # [ 38.406480] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 38.408093] systemd[1]: Stopping Reactivate sysinit units... machine # [ 38.408901] systemd[1]: Reached target Reactivate sysinit units. machine # [ 38.411182] systemd[1]: test.service: Deactivated successfully. machine # [ 38.412048] systemd[1]: Stopped test.service. machine # [ 38.412677] systemd[1]: Stopping test.service... machine # [ 38.415401] systemd[1]: Starting test.service... machine # [ 38.439940] systemd[1]: Finished test.service. machine # [ 38.443234] systemd[1]: Reached target Local File Systems. machine # [ 38.444885] systemd[1]: Reached target Remote File Systems. machine # [ 38.451244] systemd[1]: Starting linger-users.service... machine # [ 38.456847] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 38.459766] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 38.460560] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 38.461696] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 38.463684] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 38.465139] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 38.466281] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 38.472290] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 38.473475] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 38.516794] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 38.518272] systemd[1]: Finished linger-users.service. machine # [ 38.737597] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 38.739275] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 38.997550] nixos[2031]: finished switching to system configuration /nix/store/4k7cgqppkbkw0s0q7qk0vaj4038bb70z-nixos-system-machine-test machine: (finished: must succeed: /nix/store/35s2igiaaj5g08gc3r9xqcrxf6sx5fyq-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1, in 2.54 seconds) machine: must succeed: /nix/store/35s2igiaaj5g08gc3r9xqcrxf6sx5fyq-nixos-system-machine-test/specialisation/simpleServiceReload/bin/switch-to-configuration test 2>&1 machine # [ 39.536910] nixos[2174]: switching to system configuration /nix/store/0vfc2l5qa1h2nl1ip1bbgz939l74yl4r-nixos-system-machine-test machine # [ 39.539181] systemd[1]: Stopped target Remote File Systems. machine # [ 39.541130] systemd[1]: Stopped target Local File Systems. machine # [ 39.954544] systemd[1]: Reload requested from client PID 2174 ('.switch-to-conf') (unit backdoor.service)... machine # [ 39.956261] systemd[1]: Reloading... machine # [ 40.480853] systemd[1]: Reloading finished in 522 ms. machine # [ 40.572628] systemd[634]: Reexecution requested from client PID 2243 ('switch-to-confi')... machine # [ 40.575069] systemd[634]: Reexecuting. machine # [ 40.600647] systemd[634]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 40.743732] systemd[634]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 40.749700] systemd[634]: Reload requested from client PID 2243 ('switch-to-confi')... machine # [ 40.751504] systemd[634]: Reloading... machine # [ 40.886130] systemd[634]: Reloading finished in 132 ms. machine # [ 40.891806] systemd[634]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 40.898161] systemd[634]: Stopped Run user-specific NixOS activation. machine # [ 40.899919] systemd[634]: Stopping Run user-specific NixOS activation... machine # [ 40.901968] systemd[634]: Starting Run user-specific NixOS activation... machine # [ 40.931928] systemd[634]: Finished Run user-specific NixOS activation. machine # [ 40.935294] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 40.936512] systemd[1]: Stopping Reactivate sysinit units... machine # [ 40.937548] systemd[1]: Reached target Reactivate sysinit units. machine # [ 40.941561] systemd[1]: Reloading test.service... machine # [ 40.969658] systemd[1]: Reloaded test.service. machine # [ 40.972429] systemd[1]: Reached target Local File Systems. machine # [ 40.974906] systemd[1]: Reached target Remote File Systems. machine # [ 40.981070] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 40.985238] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 40.986083] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 40.987216] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 40.990678] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 40.992879] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 40.994651] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 40.998303] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 40.999500] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 41.242678] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 41.244464] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 41.248981] systemd[1]: Starting linger-users.service... machine # [ 41.292204] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 41.293744] systemd[1]: Finished linger-users.service. machine # [ 41.548063] nixos[2174]: finished switching to system configuration /nix/store/0vfc2l5qa1h2nl1ip1bbgz939l74yl4r-nixos-system-machine-test machine: (finished: must succeed: /nix/store/35s2igiaaj5g08gc3r9xqcrxf6sx5fyq-nixos-system-machine-test/specialisation/simpleServiceReload/bin/switch-to-configuration test 2>&1, in 2.55 seconds) machine: must succeed: /nix/store/35s2igiaaj5g08gc3r9xqcrxf6sx5fyq-nixos-system-machine-test/specialisation/simpleServiceNorestart/bin/switch-to-configuration test 2>&1 machine # [ 42.083959] nixos[2317]: switching to system configuration /nix/store/y2w65nkh87l0bsf38ja39zqxbbpzqdjc-nixos-system-machine-test machine # [ 42.086204] systemd[1]: Stopped target Remote File Systems. machine # [ 42.087847] systemd[1]: Stopped target Local File Systems. machine # [ 42.537579] systemd[1]: Reload requested from client PID 2317 ('.switch-to-conf') (unit backdoor.service)... machine # [ 42.539174] systemd[1]: Reloading... machine # [ 43.035790] systemd[1]: Reloading finished in 494 ms. machine # [ 43.142900] systemd[634]: Reexecution requested from client PID 2386 ('switch-to-confi')... machine # [ 43.144277] systemd[634]: Reexecuting. machine # [ 43.171958] systemd[634]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 43.308472] systemd[634]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 43.313448] systemd[634]: Reload requested from client PID 2386 ('switch-to-confi')... machine # [ 43.314934] systemd[634]: Reloading... machine # [ 43.443623] systemd[634]: Reloading finished in 126 ms. machine # [ 43.447865] systemd[634]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 43.455221] systemd[634]: Stopped Run user-specific NixOS activation. machine # [ 43.456124] systemd[634]: Stopping Run user-specific NixOS activation... machine # [ 43.459164] systemd[634]: Starting Run user-specific NixOS activation... machine # [ 43.491463] systemd[634]: Finished Run user-specific NixOS activation. machine # [ 43.495394] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 43.496501] systemd[1]: Stopping Reactivate sysinit units... machine # [ 43.497793] systemd[1]: Reached target Reactivate sysinit units. machine # [ 43.505218] systemd[1]: Reached target Local File Systems. machine # [ 43.506138] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 43.509511] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 43.510332] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 43.511513] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 43.514824] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 43.517609] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 43.520288] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 43.525539] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 43.526797] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 43.529060] systemd[1]: Reached target Remote File Systems. machine # [ 43.820618] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 43.822406] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 43.827135] systemd[1]: Starting linger-users.service... machine # [ 43.872234] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 43.873964] systemd[1]: Finished linger-users.service. machine # [ 44.128550] nixos[2317]: finished switching to system configuration /nix/store/y2w65nkh87l0bsf38ja39zqxbbpzqdjc-nixos-system-machine-test machine: (finished: must succeed: /nix/store/35s2igiaaj5g08gc3r9xqcrxf6sx5fyq-nixos-system-machine-test/specialisation/simpleServiceNorestart/bin/switch-to-configuration test 2>&1, in 2.58 seconds) machine: must succeed: /nix/store/35s2igiaaj5g08gc3r9xqcrxf6sx5fyq-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration dry-activate 2>&1 machine: (finished: must succeed: /nix/store/35s2igiaaj5g08gc3r9xqcrxf6sx5fyq-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration dry-activate 2>&1, in 0.57 seconds) machine: must succeed: /nix/store/35s2igiaaj5g08gc3r9xqcrxf6sx5fyq-nixos-system-machine-test/bin/switch-to-configuration test 2>&1 machine # [ 45.192522] nixos[2467]: switching to system configuration /nix/store/35s2igiaaj5g08gc3r9xqcrxf6sx5fyq-nixos-system-machine-test machine # [ 45.195055] systemd[1]: Stopped target Remote File Systems. machine # [ 45.197469] systemd[1]: Stopped target Local File Systems. machine # [ 45.198270] systemd[1]: test.service: Deactivated successfully. machine # [ 45.199060] systemd[1]: Stopped test.service. machine # [ 45.574563] systemd[1]: Reload requested from client PID 2467 ('.switch-to-conf') (unit backdoor.service)... machine # [ 45.579238] systemd[1]: Reloading... machine # [ 46.046129] systemd[1]: Reloading finished in 463 ms. machine # [ 46.156165] systemd[634]: Reexecution requested from client PID 2536 ('switch-to-confi')... machine # [ 46.157435] systemd[634]: Reexecuting. machine # [ 46.185650] systemd[634]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 46.320408] systemd[634]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 46.325424] systemd[634]: Reload requested from client PID 2536 ('switch-to-confi')... machine # [ 46.327210] systemd[634]: Reloading... machine # [ 46.463423] systemd[634]: Reloading finished in 134 ms. machine # [ 46.467822] systemd[634]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 46.474298] systemd[634]: Stopped Run user-specific NixOS activation. machine # [ 46.476054] systemd[634]: Stopping Run user-specific NixOS activation... machine # [ 46.478274] systemd[634]: Starting Run user-specific NixOS activation... machine # [ 46.514166] systemd[634]: Finished Run user-specific NixOS activation. machine # [ 46.517520] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 46.519231] systemd[1]: Stopping Reactivate sysinit units... machine # [ 46.519978] systemd[1]: Reached target Reactivate sysinit units. machine # [ 46.521838] systemd[1]: Reached target Remote File Systems. machine # [ 46.527261] systemd[1]: Reached target Local File Systems. machine # [ 46.532098] systemd[1]: Starting linger-users.service... machine # [ 46.533901] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 46.535782] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 46.541970] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 46.546154] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 46.546919] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 46.548545] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 46.551423] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 46.553583] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 46.555113] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 46.606080] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 46.607662] systemd[1]: Finished linger-users.service. machine # [ 46.841752] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 46.843441] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 47.100845] nixos[2467]: finished switching to system configuration /nix/store/35s2igiaaj5g08gc3r9xqcrxf6sx5fyq-nixos-system-machine-test machine: (finished: must succeed: /nix/store/35s2igiaaj5g08gc3r9xqcrxf6sx5fyq-nixos-system-machine-test/bin/switch-to-configuration test 2>&1, in 2.40 seconds) machine: must succeed: /nix/store/mdcj7qx6cwp18gca26lnaa3xbpyv8vsp-separate-activation-script/bin/switch-to-configuration test 2>&1 machine # [ 47.532157] nixos[2607]: switching to system configuration /nix/store/3c06fr6h2pq39646invi39ifw6rkbdic-nixos-system-machine-test machine # [ 47.534296] systemd[1]: Stopped target Remote File Systems. machine # [ 47.536285] systemd[1]: Stopped target Local File Systems. machine # [ 47.954260] systemd[1]: Reload requested from client PID 2607 ('.switch-to-conf') (unit backdoor.service)... machine # [ 47.956124] systemd[1]: Reloading... machine # [ 48.364961] systemd[1]: Reloading finished in 406 ms. machine # [ 48.483412] systemd[634]: Stopped Run user-specific NixOS activation. machine # [ 48.484948] systemd[634]: Reexecution requested from client PID 2676 ('switch-to-confi')... machine # [ 48.487445] systemd[634]: Reexecuting. machine # [ 48.514611] systemd[634]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 48.641869] systemd[634]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 48.647258] systemd[634]: Reload requested from client PID 2676 ('switch-to-confi')... machine # [ 48.648536] systemd[634]: Reloading... machine # [ 48.748753] systemd[634]: Reloading finished in 98 ms. machine # [ 48.753827] systemd[634]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 48.761335] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 48.762848] systemd[1]: Stopping Reactivate sysinit units... machine # [ 48.764153] systemd[1]: Reached target Reactivate sysinit units. machine # [ 48.766819] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 48.768529] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 48.771678] systemd[1]: Reached target Remote File Systems. machine # [ 48.776605] systemd[1]: Reached target Local File Systems. machine # [ 48.781660] systemd[1]: Starting linger-users.service... machine # [ 48.783882] systemd[1]: Starting test.service... machine # [ 48.785954] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 48.792594] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 48.793470] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 48.794598] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 48.796720] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 48.799146] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 48.800381] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 48.832081] systemd[1]: Finished test.service. machine # [ 48.854359] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 48.855917] systemd[1]: Finished linger-users.service. machine # [ 49.095199] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 49.097718] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 49.353524] nixos[2607]: finished switching to system configuration /nix/store/3c06fr6h2pq39646invi39ifw6rkbdic-nixos-system-machine-test machine: (finished: must succeed: /nix/store/mdcj7qx6cwp18gca26lnaa3xbpyv8vsp-separate-activation-script/bin/switch-to-configuration test 2>&1, in 2.25 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/35s2igiaaj5g08gc3r9xqcrxf6sx5fyq-nixos-system-machine-test/specialisation/unitWithMultilineValue/bin/switch-to-configuration test 2>&1 machine # [ 49.871400] nixos[2755]: switching to system configuration /nix/store/04mzz7n0qhfjmfxaz6iazbhqdsg87x1b-nixos-system-machine-test machine # [ 49.874486] systemd[1]: Stopped target Local File Systems. machine # [ 49.875684] systemd[1]: Stopped target Remote File Systems. machine # [ 49.877056] systemd[1]: test.service: Deactivated successfully. machine # [ 49.878400] systemd[1]: Stopped test.service. machine # [ 50.238968] systemd[1]: Reload requested from client PID 2755 ('.switch-to-conf') (unit backdoor.service)... machine # [ 50.240889] systemd[1]: Reloading... machine # [ 50.696086] systemd[1]: Reloading finished in 453 ms. machine # [ 50.808293] systemd[634]: Reexecution requested from client PID 2824 ('switch-to-confi')... machine # [ 50.810903] systemd[634]: Reexecuting. machine # [ 50.837515] systemd[634]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 50.955844] systemd[634]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 50.961868] systemd[634]: Reload requested from client PID 2824 ('switch-to-confi')... machine # [ 50.963684] systemd[634]: Reloading... machine # [ 51.099124] systemd[634]: Reloading finished in 133 ms. machine # [ 51.104801] systemd[634]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 51.112179] systemd[634]: Starting Run user-specific NixOS activation... machine # [ 51.141863] systemd[634]: Finished Run user-specific NixOS activation. machine # [ 51.145071] systemd[634]: Stopped Run user-specific NixOS activation. machine # [ 51.145891] systemd[634]: Stopping Run user-specific NixOS activation... machine # [ 51.149530] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 51.151669] systemd[1]: Stopping Reactivate sysinit units... machine # [ 51.152971] systemd[1]: Reached target Reactivate sysinit units. machine # [ 51.155083] systemd[634]: Starting Run user-specific NixOS activation... machine # [ 51.161835] systemd[1]: Reached target Local File Systems. machine # [ 51.163333] systemd[1]: Reached target Remote File Systems. machine # [ 51.165132] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 51.168812] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 51.170857] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 51.173152] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 51.176563] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 51.180520] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 51.182354] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 51.188929] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 51.190770] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 51.210205] systemd[634]: Finished Run user-specific NixOS activation. machine # [ 51.455199] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 51.457222] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 51.462394] systemd[1]: Starting linger-users.service... machine # [ 51.464991] systemd[1]: Started test.service. machine # [ 51.496891] systemd[1]: test.service: Deactivated successfully. machine # [ 51.518720] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 51.520226] systemd[1]: Finished linger-users.service. machine # [ 51.777716] nixos[2755]: finished switching to system configuration /nix/store/04mzz7n0qhfjmfxaz6iazbhqdsg87x1b-nixos-system-machine-test machine: (finished: must succeed: /nix/store/35s2igiaaj5g08gc3r9xqcrxf6sx5fyq-nixos-system-machine-test/specialisation/unitWithMultilineValue/bin/switch-to-configuration test 2>&1, in 2.37 seconds) machine: must succeed: /nix/store/35s2igiaaj5g08gc3r9xqcrxf6sx5fyq-nixos-system-machine-test/specialisation/unitWithBackslash/bin/switch-to-configuration test 2>&1 machine # [ 52.281324] nixos[2900]: switching to system configuration /nix/store/5n54mnm6pi3xj01q7frlldhhc7xcvdam-nixos-system-machine-test machine # [ 52.283587] systemd[1]: Stopped target Remote File Systems. machine # [ 52.285560] systemd[1]: Stopped target Local File Systems. machine # [ 52.725799] systemd[1]: Reload requested from client PID 2900 ('.switch-to-conf') (unit backdoor.service)... machine # [ 52.727467] systemd[1]: Reloading... machine # [ 53.410332] systemd[1]: Reloading finished in 680 ms. machine # [ 53.518947] systemd[634]: Reexecution requested from client PID 2969 ('switch-to-confi')... machine # [ 53.520211] systemd[634]: Reexecuting. machine # [ 53.547374] systemd[634]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 53.677259] systemd[634]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 53.682620] systemd[634]: Reload requested from client PID 2969 ('switch-to-confi')... machine # [ 53.683766] systemd[634]: Reloading... machine # [ 53.813839] systemd[634]: Reloading finished in 128 ms. machine # [ 53.817802] systemd[634]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 53.824885] systemd[634]: Stopped Run user-specific NixOS activation. machine # [ 53.825769] systemd[634]: Stopping Run user-specific NixOS activation... machine # [ 53.828106] systemd[634]: Starting Run user-specific NixOS activation... machine # [ 53.860853] systemd[634]: Finished Run user-specific NixOS activation. machine # [ 53.863942] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 53.865263] systemd[1]: Stopping Reactivate sysinit units... machine # [ 53.865979] systemd[1]: Reached target Reactivate sysinit units. machine # [ 53.870802] systemd[1]: Reached target Local File Systems. machine # [ 53.872119] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 53.876720] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 53.877663] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 53.878810] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 53.881779] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 53.884252] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 53.886174] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 53.889147] systemd[1]: Reached target Remote File Systems. machine # [ 53.895651] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 53.896910] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 54.167605] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 54.169421] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 54.174130] systemd[1]: Starting escaped\x2ddash.service... machine # [ 54.177192] systemd[1]: Starting linger-users.service... machine # [ 54.207210] systemd[1]: Finished escaped\x2ddash.service. machine # [ 54.228685] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 54.230208] systemd[1]: Finished linger-users.service. machine # [ 54.484569] nixos[2900]: finished switching to system configuration /nix/store/5n54mnm6pi3xj01q7frlldhhc7xcvdam-nixos-system-machine-test machine: (finished: must succeed: /nix/store/35s2igiaaj5g08gc3r9xqcrxf6sx5fyq-nixos-system-machine-test/specialisation/unitWithBackslash/bin/switch-to-configuration test 2>&1, in 2.70 seconds) machine: must succeed: /nix/store/35s2igiaaj5g08gc3r9xqcrxf6sx5fyq-nixos-system-machine-test/specialisation/unitWithBackslashModified/bin/switch-to-configuration test 2>&1 machine # [ 55.028751] nixos[3042]: switching to system configuration /nix/store/nd39pfx12wch280f1km3by3pw70c4c89-nixos-system-machine-test machine # [ 55.031378] systemd[1]: Stopped target Local File Systems. machine # [ 55.033074] systemd[1]: Stopped target Remote File Systems. machine # [ 55.034705] systemd[1]: escaped\x2ddash.service: Deactivated successfully. machine # [ 55.036124] systemd[1]: Stopped escaped\x2ddash.service. machine # [ 55.481217] systemd[1]: Reload requested from client PID 3042 ('.switch-to-conf') (unit backdoor.service)... machine # [ 55.482833] systemd[1]: Reloading... machine # [ 55.992102] systemd[1]: Reloading finished in 507 ms. machine # [ 56.081941] systemd[634]: Reexecution requested from client PID 3111 ('switch-to-confi')... machine # [ 56.084435] systemd[634]: Reexecuting. machine # [ 56.108745] systemd[634]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 56.241256] systemd[634]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 56.246407] systemd[634]: Reload requested from client PID 3111 ('switch-to-confi')... machine # [ 56.248116] systemd[634]: Reloading... machine # [ 56.375499] systemd[634]: Reloading finished in 125 ms. machine # [ 56.379805] systemd[634]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 56.386117] systemd[634]: Stopped Run user-specific NixOS activation. machine # [ 56.387084] systemd[634]: Stopping Run user-specific NixOS activation... machine # [ 56.390070] systemd[634]: Starting Run user-specific NixOS activation... machine # [ 56.420721] systemd[634]: Finished Run user-specific NixOS activation. machine # [ 56.424696] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 56.425640] systemd[1]: Stopping Reactivate sysinit units... machine # [ 56.426969] systemd[1]: Reached target Reactivate sysinit units. machine # [ 56.428480] systemd[1]: Reached target Remote File Systems. machine # [ 56.431742] systemd[1]: Reached target Local File Systems. machine # [ 56.433942] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 56.437512] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 56.438389] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 56.439541] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 56.442528] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 56.444618] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 56.446297] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 56.453923] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 56.455572] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 56.713637] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 56.715287] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 56.720126] systemd[1]: Starting escaped\x2ddash.service... machine # [ 56.724225] systemd[1]: Starting linger-users.service... machine # [ 56.755360] systemd[1]: Finished escaped\x2ddash.service. machine # [ 56.775472] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 56.776966] systemd[1]: Finished linger-users.service. machine # [ 57.033620] nixos[3042]: finished switching to system configuration /nix/store/nd39pfx12wch280f1km3by3pw70c4c89-nixos-system-machine-test machine: (finished: must succeed: /nix/store/35s2igiaaj5g08gc3r9xqcrxf6sx5fyq-nixos-system-machine-test/specialisation/unitWithBackslashModified/bin/switch-to-configuration test 2>&1, in 2.55 seconds) machine: must succeed: /nix/store/35s2igiaaj5g08gc3r9xqcrxf6sx5fyq-nixos-system-machine-test/specialisation/unitStartingWithDash/bin/switch-to-configuration test 2>&1 machine # [ 57.572889] nixos[3184]: switching to system configuration /nix/store/mwcbrm4szmd435wlwix0zd9lsghizc9n-nixos-system-machine-test machine # [ 57.576129] systemd[1]: escaped\x2ddash.service: Deactivated successfully. machine # [ 57.577057] systemd[1]: Stopped escaped\x2ddash.service. machine # [ 57.578589] systemd[1]: Stopped target Remote File Systems. machine # [ 57.580264] systemd[1]: Stopped target Local File Systems. machine # [ 58.003554] systemd[1]: Reload requested from client PID 3184 ('.switch-to-conf') (unit backdoor.service)... machine # [ 58.005258] systemd[1]: Reloading... machine # [ 58.476158] systemd[1]: Reloading finished in 468 ms. machine # [ 58.572531] systemd[634]: Reexecution requested from client PID 3253 ('switch-to-confi')... machine # [ 58.573914] systemd[634]: Reexecuting. machine # [ 58.601797] systemd[634]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 58.727484] systemd[634]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 58.732838] systemd[634]: Reload requested from client PID 3253 ('switch-to-confi')... machine # [ 58.734411] systemd[634]: Reloading... machine # [ 58.862027] systemd[634]: Reloading finished in 125 ms. machine # [ 58.867837] systemd[634]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 58.874812] systemd[634]: Stopped Run user-specific NixOS activation. machine # [ 58.875683] systemd[634]: Stopping Run user-specific NixOS activation... machine # [ 58.877954] systemd[634]: Starting Run user-specific NixOS activation... machine # [ 58.913626] systemd[634]: Finished Run user-specific NixOS activation. machine # [ 58.917565] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 58.918690] systemd[1]: Stopping Reactivate sysinit units... machine # [ 58.919814] systemd[1]: Reached target Reactivate sysinit units. machine # [ 58.922940] systemd[1]: Reached target Local File Systems. machine # [ 58.925163] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 58.928415] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 58.929272] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 58.930394] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 58.932375] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 58.933809] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 58.935019] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 58.940155] systemd[1]: Reached target Remote File Systems. machine # [ 58.944511] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 58.945744] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 59.186124] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 59.187609] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 59.192895] systemd[1]: Starting -.service... machine # [ 59.195480] systemd[1]: Starting linger-users.service... machine # [ 59.221603] systemd[1]: Finished -.service. machine # [ 59.240466] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 59.242405] systemd[1]: Finished linger-users.service. machine # [ 59.496650] nixos[3184]: finished switching to system configuration /nix/store/mwcbrm4szmd435wlwix0zd9lsghizc9n-nixos-system-machine-test machine: (finished: must succeed: /nix/store/35s2igiaaj5g08gc3r9xqcrxf6sx5fyq-nixos-system-machine-test/specialisation/unitStartingWithDash/bin/switch-to-configuration test 2>&1, in 2.46 seconds) machine: must succeed: /nix/store/35s2igiaaj5g08gc3r9xqcrxf6sx5fyq-nixos-system-machine-test/specialisation/unitStartingWithDashModified/bin/switch-to-configuration test 2>&1 machine # [ 59.978285] nixos[3326]: switching to system configuration /nix/store/k0dv0kjgmjdc82q8sp0zszy5kvhm8l77-nixos-system-machine-test machine # [ 59.980563] systemd[1]: Stopped target Remote File Systems. machine # [ 59.982306] systemd[1]: Stopped target Local File Systems. machine # [ 60.467474] systemd[1]: Reload requested from client PID 3326 ('.switch-to-conf') (unit backdoor.service)... machine # [ 60.469156] systemd[1]: Reloading... machine # [ 61.120068] systemd[1]: Reloading finished in 648 ms. machine # [ 61.233975] systemd[634]: Reexecution requested from client PID 3395 ('switch-to-confi')... machine # [ 61.235513] systemd[634]: Reexecuting. machine # [ 61.262792] systemd[634]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 61.399818] systemd[634]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 61.405390] systemd[634]: Reload requested from client PID 3395 ('switch-to-confi')... machine # [ 61.406817] systemd[634]: Reloading... machine # [ 61.540810] systemd[634]: Reloading finished in 132 ms. machine # [ 61.545790] systemd[634]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 61.551941] systemd[634]: Stopped Run user-specific NixOS activation. machine # [ 61.552920] systemd[634]: Stopping Run user-specific NixOS activation... machine # [ 61.556106] systemd[634]: Starting Run user-specific NixOS activation... machine # [ 61.588360] systemd[634]: Finished Run user-specific NixOS activation. machine # [ 61.591501] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 61.592826] systemd[1]: Stopping Reactivate sysinit units... machine # [ 61.593873] systemd[1]: Reached target Reactivate sysinit units. machine # [ 61.597731] systemd[1]: Reloading -.service... machine # [ 61.621756] systemd[1]: Reloaded -.service. machine # [ 61.623698] systemd[1]: Reached target Remote File Systems. machine # [ 61.625481] systemd[1]: Reached target Local File Systems. machine # [ 61.627482] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 61.629191] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 61.637764] systemd[1]: Starting linger-users.service... machine # [ 61.641075] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 61.645071] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 61.647569] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 61.648778] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 61.650768] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 61.652208] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 61.653380] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 61.709336] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 61.711819] systemd[1]: Finished linger-users.service. machine # [ 61.936441] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 61.938080] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 62.194630] nixos[3326]: finished switching to system configuration /nix/store/k0dv0kjgmjdc82q8sp0zszy5kvhm8l77-nixos-system-machine-test machine: (finished: must succeed: /nix/store/35s2igiaaj5g08gc3r9xqcrxf6sx5fyq-nixos-system-machine-test/specialisation/unitStartingWithDashModified/bin/switch-to-configuration test 2>&1, in 2.70 seconds) machine: must succeed: /nix/store/35s2igiaaj5g08gc3r9xqcrxf6sx5fyq-nixos-system-machine-test/specialisation/unitWithRequirement/bin/switch-to-configuration test 2>&1 machine # [ 62.741334] nixos[3468]: switching to system configuration /nix/store/dns6hgmq33666cq14bcaa3fd2nrbi9ca-nixos-system-machine-test machine # [ 62.743913] systemd[1]: Stopped target Remote File Systems. machine # [ 62.745764] systemd[1]: -.service: Deactivated successfully. machine # [ 62.747219] systemd[1]: Stopped -.service. machine # [ 62.748552] systemd[1]: Stopped target Local File Systems. machine # [ 63.176481] systemd[1]: Reload requested from client PID 3468 ('.switch-to-conf') (unit backdoor.service)... machine # [ 63.178122] systemd[1]: Reloading... machine # [ 64.002901] systemd[1]: Reloading finished in 822 ms. machine # [ 64.098311] systemd[634]: Reexecution requested from client PID 3537 ('switch-to-confi')... machine # [ 64.100743] systemd[634]: Reexecuting. machine # [ 64.130065] systemd[634]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 64.254646] systemd[634]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 64.260129] systemd[634]: Reload requested from client PID 3537 ('switch-to-confi')... machine # [ 64.261858] systemd[634]: Reloading... machine # [ 64.390953] systemd[634]: Reloading finished in 127 ms. machine # [ 64.395848] systemd[634]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 64.402121] systemd[634]: Stopped Run user-specific NixOS activation. machine # [ 64.403131] systemd[634]: Stopping Run user-specific NixOS activation... machine # [ 64.406279] systemd[634]: Starting Run user-specific NixOS activation... machine # [ 64.439217] systemd[634]: Finished Run user-specific NixOS activation. machine # [ 64.442371] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 64.443656] systemd[1]: Stopping Reactivate sysinit units... machine # [ 64.444681] systemd[1]: Reached target Reactivate sysinit units. machine # [ 64.446057] systemd[1]: Reached target Local File Systems. machine # [ 64.450068] systemd[1]: Reached target Remote File Systems. machine # [ 64.451941] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 64.453652] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 64.456335] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 64.461250] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 64.462046] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 64.463160] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 64.466810] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 64.469547] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 64.471271] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 64.686420] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 64.689074] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 64.693292] systemd[1]: Starting linger-users.service... machine # [ 64.696051] systemd[1]: Starting required-service.service... machine # [ 64.699416] systemd[1]: Starting test-service.service... machine # [ 64.733444] systemd[1]: Finished required-service.service. machine # [ 64.735642] systemd[1]: Finished test-service.service. machine # [ 64.757353] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 64.758731] systemd[1]: Finished linger-users.service. machine # [ 65.017886] nixos[3468]: finished switching to system configuration /nix/store/dns6hgmq33666cq14bcaa3fd2nrbi9ca-nixos-system-machine-test machine: (finished: must succeed: /nix/store/35s2igiaaj5g08gc3r9xqcrxf6sx5fyq-nixos-system-machine-test/specialisation/unitWithRequirement/bin/switch-to-configuration test 2>&1, in 2.82 seconds) machine: must succeed: /nix/store/35s2igiaaj5g08gc3r9xqcrxf6sx5fyq-nixos-system-machine-test/specialisation/unitWithRequirementModified/bin/switch-to-configuration test 2>&1 machine # [ 65.543593] nixos[3612]: switching to system configuration /nix/store/7i40vqhdfacgvg7zj1gcci78fch6fzzq-nixos-system-machine-test machine # [ 65.545936] systemd[1]: Stopped target Local File Systems. machine # [ 65.547504] systemd[1]: Stopped target Remote File Systems. machine # [ 65.549673] systemd[1]: required-service.service: Deactivated successfully. machine # [ 65.550577] systemd[1]: Stopped required-service.service. machine # [ 65.551300] systemd[1]: test-service.service: Deactivated successfully. machine # [ 65.552135] systemd[1]: Stopped test-service.service. machine # [ 65.984068] systemd[1]: Reload requested from client PID 3612 ('.switch-to-conf') (unit backdoor.service)... machine # [ 65.985684] systemd[1]: Reloading... machine # [ 66.603401] systemd[1]: Reloading finished in 615 ms. machine # [ 66.713277] systemd[634]: Reexecution requested from client PID 3681 ('switch-to-confi')... machine # [ 66.715265] systemd[634]: Reexecuting. machine # [ 66.742824] systemd[634]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 66.874120] systemd[634]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 66.880346] systemd[634]: Reload requested from client PID 3681 ('switch-to-confi')... machine # [ 66.882149] systemd[634]: Reloading... machine # [ 67.016208] systemd[634]: Reloading finished in 132 ms. machine # [ 67.019811] systemd[634]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 67.026841] systemd[634]: Stopped Run user-specific NixOS activation. machine # [ 67.027744] systemd[634]: Stopping Run user-specific NixOS activation... machine # [ 67.030138] systemd[634]: Starting Run user-specific NixOS activation... machine # [ 67.064283] systemd[634]: Finished Run user-specific NixOS activation. machine # [ 67.067405] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 67.068785] systemd[1]: Stopping Reactivate sysinit units... machine # [ 67.069799] systemd[1]: Reached target Reactivate sysinit units. machine # [ 67.078837] systemd[1]: Starting required-service.service... machine # [ 67.081543] systemd[1]: Reached target Local File Systems. machine # [ 67.085384] systemd[1]: Reached target Remote File Systems. machine # [ 67.090267] systemd[1]: Starting linger-users.service... machine # [ 67.094671] systemd[1]: Starting test-service.service... machine # [ 67.100600] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 67.106105] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 67.106891] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 67.109176] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 67.111606] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 67.114451] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 67.117158] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 67.123235] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 67.124641] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 67.144411] systemd[1]: Finished required-service.service. machine # [ 67.158524] systemd[1]: Finished test-service.service. machine # [ 67.182866] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 67.184523] systemd[1]: Finished linger-users.service. machine # [ 67.392112] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 67.393612] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 67.651244] nixos[3612]: finished switching to system configuration /nix/store/7i40vqhdfacgvg7zj1gcci78fch6fzzq-nixos-system-machine-test machine: (finished: must succeed: /nix/store/35s2igiaaj5g08gc3r9xqcrxf6sx5fyq-nixos-system-machine-test/specialisation/unitWithRequirementModified/bin/switch-to-configuration test 2>&1, in 2.63 seconds) machine: must succeed: /nix/store/35s2igiaaj5g08gc3r9xqcrxf6sx5fyq-nixos-system-machine-test/specialisation/unitWithRequirementModifiedNostart/bin/switch-to-configuration test 2>&1 machine # [ 68.118415] nixos[3756]: switching to system configuration /nix/store/n63rjyrr8cyr6yxjys9nnyzxsg6dqcw6-nixos-system-machine-test machine # [ 68.120951] systemd[1]: Stopped target Remote File Systems. machine # [ 68.122632] systemd[1]: Stopped target Local File Systems. machine # [ 68.124371] systemd[1]: required-service.service: Deactivated successfully. machine # [ 68.125978] systemd[1]: Stopped required-service.service. machine # [ 68.127264] systemd[1]: test-service.service: Deactivated successfully. machine # [ 68.128199] systemd[1]: Stopped test-service.service. machine # [ 68.536241] systemd[1]: Reload requested from client PID 3756 ('.switch-to-conf') (unit backdoor.service)... machine # [ 68.537925] systemd[1]: Reloading... machine # [ 69.345163] systemd[1]: Reloading finished in 804 ms. machine # [ 69.453778] systemd[634]: Reexecution requested from client PID 3825 ('switch-to-confi')... machine # [ 69.456552] systemd[634]: Reexecuting. machine # [ 69.482301] systemd[634]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 69.616809] systemd[634]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 69.621955] systemd[634]: Reload requested from client PID 3825 ('switch-to-confi')... machine # [ 69.623904] systemd[634]: Reloading... machine # [ 69.746388] systemd[634]: Reloading finished in 120 ms. machine # [ 69.750846] systemd[634]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 69.758068] systemd[634]: Stopped Run user-specific NixOS activation. machine # [ 69.758926] systemd[634]: Stopping Run user-specific NixOS activation... machine # [ 69.761249] systemd[634]: Starting Run user-specific NixOS activation... machine # [ 69.789718] systemd[634]: Finished Run user-specific NixOS activation. machine # [ 69.792974] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 69.794435] systemd[1]: Stopping Reactivate sysinit units... machine # [ 69.795435] systemd[1]: Reached target Reactivate sysinit units. machine # [ 69.799700] systemd[1]: Starting required-service.service... machine # [ 69.802663] systemd[1]: Reached target Remote File Systems. machine # [ 69.808869] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 69.810665] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 69.813756] systemd[1]: Reached target Local File Systems. machine # [ 69.819203] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 69.823926] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 69.824946] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 69.826770] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 69.829301] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 69.830723] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 69.834496] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 69.850086] systemd[1]: Finished required-service.service. machine # [ 70.052110] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 70.053775] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 70.058130] systemd[1]: Starting linger-users.service... machine # [ 70.061793] systemd[1]: Starting test-service.service... machine # [ 70.090602] systemd[1]: Finished test-service.service. machine # [ 70.108851] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 70.110381] systemd[1]: Finished linger-users.service. machine # [ 70.367520] nixos[3756]: finished switching to system configuration /nix/store/n63rjyrr8cyr6yxjys9nnyzxsg6dqcw6-nixos-system-machine-test machine: (finished: must succeed: /nix/store/35s2igiaaj5g08gc3r9xqcrxf6sx5fyq-nixos-system-machine-test/specialisation/unitWithRequirementModifiedNostart/bin/switch-to-configuration test 2>&1, in 2.72 seconds) machine: must succeed: /nix/store/35s2igiaaj5g08gc3r9xqcrxf6sx5fyq-nixos-system-machine-test/specialisation/unitWithTemplate/bin/switch-to-configuration test 2>&1 machine # [ 70.826439] nixos[3900]: switching to system configuration /nix/store/w6qj2y9s5l4q5hy17fdh73djxs0326qh-nixos-system-machine-test machine # [ 70.828968] systemd[1]: Stopped target Remote File Systems. machine # [ 70.830661] systemd[1]: Stopped target Local File Systems. machine # [ 70.831919] systemd[1]: test-service.service: Deactivated successfully. machine # [ 70.833336] systemd[1]: Stopped test-service.service. machine # [ 70.834687] systemd[1]: required-service.service: Deactivated successfully. machine # [ 70.836261] systemd[1]: Stopped required-service.service. machine # [ 71.266430] systemd[1]: Reload requested from client PID 3900 ('.switch-to-conf') (unit backdoor.service)... machine # [ 71.268514] systemd[1]: Reloading... machine # [ 71.970976] systemd[1]: Reloading finished in 700 ms. machine # [ 72.072947] systemd[634]: Reexecution requested from client PID 3969 ('switch-to-confi')... machine # [ 72.074210] systemd[634]: Reexecuting. machine # [ 72.100351] systemd[634]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 72.219411] systemd[634]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 72.224525] systemd[634]: Reload requested from client PID 3969 ('switch-to-confi')... machine # [ 72.225885] systemd[634]: Reloading... machine # [ 72.351128] systemd[634]: Reloading finished in 123 ms. machine # [ 72.355807] systemd[634]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 72.362777] systemd[634]: Stopped Run user-specific NixOS activation. machine # [ 72.363656] systemd[634]: Stopping Run user-specific NixOS activation... machine # [ 72.365981] systemd[634]: Starting Run user-specific NixOS activation... machine # [ 72.398812] systemd[634]: Finished Run user-specific NixOS activation. machine # [ 72.401935] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 72.403354] systemd[1]: Stopping Reactivate sysinit units... machine # [ 72.404568] systemd[1]: Reached target Reactivate sysinit units. machine # [ 72.409722] systemd[1]: Created slice Slice /system/instantiated. machine # [ 72.411191] systemd[1]: Reached target Remote File Systems. machine # [ 72.414140] systemd[1]: Starting instantiated@one.service... machine # [ 72.417193] systemd[1]: Starting instantiated@two.service... machine # [ 72.421441] systemd[1]: Starting linger-users.service... machine # [ 72.423394] systemd[1]: Reached target Local File Systems. machine # [ 72.426485] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 72.430098] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 72.431345] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 72.439750] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 72.440806] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 72.444621] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 72.446616] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 72.449478] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 72.453126] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 72.480095] systemd[1]: Finished instantiated@one.service. machine # [ 72.486298] systemd[1]: Finished instantiated@two.service. machine # [ 72.514364] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 72.515776] systemd[1]: Finished linger-users.service. machine # [ 72.748453] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 72.750092] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 73.007678] nixos[3900]: finished switching to system configuration /nix/store/w6qj2y9s5l4q5hy17fdh73djxs0326qh-nixos-system-machine-test machine: (finished: must succeed: /nix/store/35s2igiaaj5g08gc3r9xqcrxf6sx5fyq-nixos-system-machine-test/specialisation/unitWithTemplate/bin/switch-to-configuration test 2>&1, in 2.64 seconds) machine: must succeed: /nix/store/35s2igiaaj5g08gc3r9xqcrxf6sx5fyq-nixos-system-machine-test/specialisation/unitWithTemplateModified/bin/switch-to-configuration test 2>&1 machine # [ 73.574688] nixos[4044]: switching to system configuration /nix/store/jgnfbd36y2q0p255hz1k0jrgfm5ymrkf-nixos-system-machine-test machine # [ 73.576977] systemd[1]: Stopped target Remote File Systems. machine # [ 73.579111] systemd[1]: instantiated@two.service: Deactivated successfully. machine # [ 73.579975] systemd[1]: Stopped instantiated@two.service. machine # [ 73.581757] systemd[1]: instantiated@one.service: Deactivated successfully. machine # [ 73.582968] systemd[1]: Stopped instantiated@one.service. machine # [ 73.584223] systemd[1]: Stopped target Local File Systems. machine # [ 74.020414] systemd[1]: Reload requested from client PID 4044 ('.switch-to-conf') (unit backdoor.service)... machine # [ 74.022147] systemd[1]: Reloading... machine # [ 74.506473] systemd[1]: Reloading finished in 482 ms. machine # [ 74.598467] systemd[634]: Reexecution requested from client PID 4113 ('switch-to-confi')... machine # [ 74.599821] systemd[634]: Reexecuting. machine # [ 74.623969] systemd[634]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 74.751631] systemd[634]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 74.757738] systemd[634]: Reload requested from client PID 4113 ('switch-to-confi')... machine # [ 74.759404] systemd[634]: Reloading... machine # [ 74.884031] systemd[634]: Reloading finished in 122 ms. machine # [ 74.888811] systemd[634]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 74.895172] systemd[634]: Stopped Run user-specific NixOS activation. machine # [ 74.897029] systemd[634]: Stopping Run user-specific NixOS activation... machine # [ 74.899216] systemd[634]: Starting Run user-specific NixOS activation... machine # [ 74.932224] systemd[634]: Finished Run user-specific NixOS activation. machine # [ 74.935518] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 74.937226] systemd[1]: Stopping Reactivate sysinit units... machine # [ 74.937928] systemd[1]: Reached target Reactivate sysinit units. machine # [ 74.941737] systemd[1]: Reached target Local File Systems. machine # [ 74.943378] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 74.947757] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 74.948702] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 74.950582] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 74.952504] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 74.953892] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 74.956112] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 74.959219] systemd[1]: Reached target Remote File Systems. machine # [ 74.971291] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 74.972667] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 75.231595] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 75.234405] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 75.238142] systemd[1]: Starting instantiated@one.service... machine # [ 75.241054] systemd[1]: Starting instantiated@two.service... machine # [ 75.243253] systemd[1]: Starting linger-users.service... machine # [ 75.277765] systemd[1]: Finished instantiated@one.service. machine # [ 75.281268] systemd[1]: Finished instantiated@two.service. machine # [ 75.300336] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 75.301783] systemd[1]: Finished linger-users.service. machine # [ 75.556254] nixos[4044]: finished switching to system configuration /nix/store/jgnfbd36y2q0p255hz1k0jrgfm5ymrkf-nixos-system-machine-test machine: (finished: must succeed: /nix/store/35s2igiaaj5g08gc3r9xqcrxf6sx5fyq-nixos-system-machine-test/specialisation/unitWithTemplateModified/bin/switch-to-configuration test 2>&1, in 2.55 seconds) (finished: subtest: services, in 54.12 seconds) subtest: failing units machine: must succeed: /nix/store/35s2igiaaj5g08gc3r9xqcrxf6sx5fyq-nixos-system-machine-test/specialisation/simpleServiceModified/bin/switch-to-configuration test 2>&1 machine # [ 75.928374] nixos[4188]: switching to system configuration /nix/store/n788mwmciq2xmsw9fmykq4h4nnvn0d8q-nixos-system-machine-test machine # [ 75.931440] systemd[1]: instantiated@one.service: Deactivated successfully. machine # [ 75.932516] systemd[1]: Stopped instantiated@one.service. machine # [ 75.934299] systemd[1]: instantiated@two.service: Deactivated successfully. machine # [ 75.936219] systemd[1]: Stopped instantiated@two.service. machine # [ 75.937424] systemd[1]: Stopped target Remote File Systems. machine # [ 75.939055] systemd[1]: Stopped target Local File Systems. machine # [ 76.276807] systemd[1]: Reload requested from client PID 4188 ('.switch-to-conf') (unit backdoor.service)... machine # [ 76.278679] systemd[1]: Reloading... machine # [ 76.941191] systemd[1]: Reloading finished in 660 ms. machine # [ 77.057562] systemd[634]: Reexecution requested from client PID 4257 ('switch-to-confi')... machine # [ 77.059636] systemd[634]: Reexecuting. machine # [ 77.085954] systemd[634]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 77.218318] systemd[634]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 77.223144] systemd[634]: Reload requested from client PID 4257 ('switch-to-confi')... machine # [ 77.224734] systemd[634]: Reloading... machine # [ 77.358462] systemd[634]: Reloading finished in 132 ms. machine # [ 77.362826] systemd[634]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 77.370064] systemd[634]: Stopped Run user-specific NixOS activation. machine # [ 77.370884] systemd[634]: Stopping Run user-specific NixOS activation... machine # [ 77.373188] systemd[634]: Starting Run user-specific NixOS activation... machine # [ 77.406741] systemd[634]: Finished Run user-specific NixOS activation. machine # [ 77.409952] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 77.411203] systemd[1]: Stopping Reactivate sysinit units... machine # [ 77.411914] systemd[1]: Reached target Reactivate sysinit units. machine # [ 77.418381] systemd[1]: Reached target Remote File Systems. machine # [ 77.420242] systemd[1]: Reached target Local File Systems. machine # [ 77.425099] systemd[1]: Starting linger-users.service... machine # [ 77.427610] systemd[1]: Starting test.service... machine # [ 77.433082] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 77.437271] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 77.438775] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 77.439911] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 77.441857] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 77.443331] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 77.447926] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 77.450114] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 77.451559] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 77.478133] systemd[1]: Finished test.service. machine # [ 77.502701] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 77.504306] systemd[1]: Finished linger-users.service. machine # [ 77.757183] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 77.759832] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 78.016886] nixos[4188]: finished switching to system configuration /nix/store/n788mwmciq2xmsw9fmykq4h4nnvn0d8q-nixos-system-machine-test machine: (finished: must succeed: /nix/store/35s2igiaaj5g08gc3r9xqcrxf6sx5fyq-nixos-system-machine-test/specialisation/simpleServiceModified/bin/switch-to-configuration test 2>&1, in 2.46 seconds) machine: must fail: /nix/store/35s2igiaaj5g08gc3r9xqcrxf6sx5fyq-nixos-system-machine-test/specialisation/simpleServiceFailing/bin/switch-to-configuration test 2>&1 machine # [ 78.579303] nixos[4330]: switching to system configuration /nix/store/8a0rrhpvxb7afgsl0vdm28n7p4nkqwvv-nixos-system-machine-test machine # [ 78.581853] systemd[1]: Stopped target Local File Systems. machine # [ 78.583373] systemd[1]: Stopped target Remote File Systems. machine # [ 78.584880] systemd[1]: test.service: Deactivated successfully. machine # [ 78.586173] systemd[1]: Stopped test.service. machine # [ 79.008589] systemd[1]: Reload requested from client PID 4330 ('.switch-to-conf') (unit backdoor.service)... machine # [ 79.010282] systemd[1]: Reloading... machine # [ 80.863704] systemd[1]: Reloading finished in 1851 ms. machine # [ 80.972258] systemd[634]: Reexecution requested from client PID 4399 ('switch-to-confi')... machine # [ 80.974936] systemd[634]: Reexecuting. machine # [ 81.001276] systemd[634]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 81.127402] systemd[634]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 81.132791] systemd[634]: Reload requested from client PID 4399 ('switch-to-confi')... machine # [ 81.134406] systemd[634]: Reloading... machine # [ 81.258801] systemd[634]: Reloading finished in 123 ms. machine # [ 81.262812] systemd[634]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 81.269898] systemd[634]: Stopped Run user-specific NixOS activation. machine # [ 81.270807] systemd[634]: Stopping Run user-specific NixOS activation... machine # [ 81.273104] systemd[634]: Starting Run user-specific NixOS activation... machine # [ 81.304344] systemd[634]: Finished Run user-specific NixOS activation. machine # [ 81.307448] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 81.308690] systemd[1]: Stopping Reactivate sysinit units... machine # [ 81.309714] systemd[1]: Reached target Reactivate sysinit units. machine # [ 81.314794] systemd[1]: Reached target Local File Systems. machine # [ 81.318053] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 81.320306] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 81.321442] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 81.325215] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 81.326158] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 81.327279] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 81.330578] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 81.332575] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 81.335273] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 81.337127] systemd[1]: Reached target Remote File Systems. machine # [ 81.585806] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 81.587345] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 81.592200] systemd[1]: Starting linger-users.service... machine # [ 81.594194] systemd[1]: Starting test.service... machine # [ 81.622710] systemd[1]: test.service: Main process exited, code=exited, status=1/FAILURE machine # [ 81.623977] systemd[1]: test.service: Failed with result 'exit-code'. machine # [ 81.625674] systemd[1]: Failed to start test.service. machine # [ 81.643368] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 81.645487] systemd[1]: Finished linger-users.service. machine # [ 81.930690] nixos[4330]: switching to system configuration /nix/store/8a0rrhpvxb7afgsl0vdm28n7p4nkqwvv-nixos-system-machine-test failed (status 4) machine: (finished: must fail: /nix/store/35s2igiaaj5g08gc3r9xqcrxf6sx5fyq-nixos-system-machine-test/specialisation/simpleServiceFailing/bin/switch-to-configuration test 2>&1, in 3.91 seconds) machine: must succeed: /nix/store/35s2igiaaj5g08gc3r9xqcrxf6sx5fyq-nixos-system-machine-test/specialisation/autorestartService/bin/switch-to-configuration test 2>&1 machine # [ 82.501293] nixos[4473]: switching to system configuration /nix/store/i9x99nm3m0vy24rq2cgfk426rrv4vq4m-nixos-system-machine-test machine # [ 82.503789] systemd[1]: Stopped target Local File Systems. machine # [ 82.505655] systemd[1]: Stopped target Remote File Systems. machine # [ 82.937153] systemd[1]: Reload requested from client PID 4473 ('.switch-to-conf') (unit backdoor.service)... machine # [ 82.938783] systemd[1]: Reloading... machine # [ 83.479699] systemd[1]: Reloading finished in 538 ms. machine # [ 83.574202] systemd[634]: Reexecution requested from client PID 4542 ('switch-to-confi')... machine # [ 83.576671] systemd[634]: Reexecuting. machine # [ 83.600962] systemd[634]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 83.736525] systemd[634]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 83.741630] systemd[634]: Reload requested from client PID 4542 ('switch-to-confi')... machine # [ 83.743239] systemd[634]: Reloading... machine # [ 83.861759] systemd[634]: Reloading finished in 116 ms. machine # [ 83.865778] systemd[634]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 83.871900] systemd[634]: Stopped Run user-specific NixOS activation. machine # [ 83.872880] systemd[634]: Stopping Run user-specific NixOS activation... machine # [ 83.876135] systemd[634]: Starting Run user-specific NixOS activation... machine # [ 83.905242] systemd[634]: Finished Run user-specific NixOS activation. machine # [ 83.908498] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 83.909968] systemd[1]: Stopping Reactivate sysinit units... machine # [ 83.911448] systemd[1]: Reached target Reactivate sysinit units. machine # [ 83.915071] systemd[1]: Reached target Remote File Systems. machine # [ 83.919101] systemd[1]: Started autorestart.service. machine # [ 83.921387] systemd[1]: Starting linger-users.service... machine # [ 83.923284] systemd[1]: Reached target Local File Systems. machine # [ 83.925811] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 83.927178] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 83.936362] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 83.940070] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 83.940843] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 83.943190] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 83.946153] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 83.950825] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 83.952291] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 83.975830] systemd[1]: autorestart.service: Deactivated successfully. machine # [ 84.003744] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 84.004852] systemd[1]: Finished linger-users.service. machine # [ 84.215543] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 84.217219] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 84.473694] nixos[4473]: finished switching to system configuration /nix/store/i9x99nm3m0vy24rq2cgfk426rrv4vq4m-nixos-system-machine-test machine: (finished: must succeed: /nix/store/35s2igiaaj5g08gc3r9xqcrxf6sx5fyq-nixos-system-machine-test/specialisation/autorestartService/bin/switch-to-configuration test 2>&1, in 2.54 seconds) machine # [ 84.510272] systemd[1]: Stopped autorestart.service. machine: must succeed: /nix/store/35s2igiaaj5g08gc3r9xqcrxf6sx5fyq-nixos-system-machine-test/specialisation/autorestartService/bin/switch-to-configuration test 2>&1 machine # [ 84.903189] nixos[4620]: switching to system configuration /nix/store/i9x99nm3m0vy24rq2cgfk426rrv4vq4m-nixos-system-machine-test machine # [ 84.906378] systemd[1]: Stopped target Remote File Systems. machine # [ 84.907336] systemd[1]: Stopped target Local File Systems. machine # [ 85.246473] systemd[1]: Reload requested from client PID 4620 ('.switch-to-conf') (unit backdoor.service)... machine # [ 85.248294] systemd[1]: Reloading... machine # [ 85.722311] systemd[1]: Reloading finished in 472 ms. machine # [ 85.826947] systemd[634]: Reexecution requested from client PID 4689 ('switch-to-confi')... machine # [ 85.829554] systemd[634]: Reexecuting. machine # [ 85.855320] systemd[634]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 85.975304] systemd[634]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 85.980619] systemd[634]: Reload requested from client PID 4689 ('switch-to-confi')... machine # [ 85.982082] systemd[634]: Reloading... machine # [ 86.112285] systemd[634]: Reloading finished in 128 ms. machine # [ 86.117798] systemd[634]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 86.125067] systemd[634]: Stopped Run user-specific NixOS activation. machine # [ 86.125897] systemd[634]: Stopping Run user-specific NixOS activation... machine # [ 86.128232] systemd[634]: Starting Run user-specific NixOS activation... machine # [ 86.156652] systemd[634]: Finished Run user-specific NixOS activation. machine # [ 86.159681] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 86.160731] systemd[1]: Stopping Reactivate sysinit units... machine # [ 86.162133] systemd[1]: Reached target Reactivate sysinit units. machine # [ 86.163723] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 86.165402] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 86.168066] systemd[1]: Reached target Remote File Systems. machine # [ 86.176291] systemd[1]: Started autorestart.service. machine # [ 86.177877] systemd[1]: Starting linger-users.service... machine # [ 86.182129] systemd[1]: Reached target Local File Systems. machine # [ 86.182877] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 86.187715] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 86.189123] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 86.190267] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 86.192312] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 86.193714] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 86.194837] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 86.229856] systemd[1]: autorestart.service: Deactivated successfully. machine # [ 86.255839] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 86.257837] systemd[1]: Finished linger-users.service. machine # [ 86.460177] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 86.461291] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 86.719810] nixos[4620]: finished switching to system configuration /nix/store/i9x99nm3m0vy24rq2cgfk426rrv4vq4m-nixos-system-machine-test machine: (finished: must succeed: /nix/store/35s2igiaaj5g08gc3r9xqcrxf6sx5fyq-nixos-system-machine-test/specialisation/autorestartService/bin/switch-to-configuration test 2>&1, in 2.21 seconds) machine # [ 86.778396] systemd[1]: Stopped autorestart.service. machine: must fail: /nix/store/35s2igiaaj5g08gc3r9xqcrxf6sx5fyq-nixos-system-machine-test/specialisation/autorestartServiceFailing/bin/switch-to-configuration test 2>&1 machine # [ 87.310842] nixos[4767]: switching to system configuration /nix/store/nxiisb4fiyrrppl29j3i3vvk184mbh2m-nixos-system-machine-test machine # [ 87.313150] systemd[1]: Stopped target Local File Systems. machine # [ 87.314760] systemd[1]: Stopped target Remote File Systems. machine # [ 87.686754] systemd[1]: Reload requested from client PID 4767 ('.switch-to-conf') (unit backdoor.service)... machine # [ 87.688376] systemd[1]: Reloading... machine # [ 90.926628] systemd[1]: Reloading finished in 3236 ms. machine # [ 91.038799] systemd[634]: Reexecution requested from client PID 4836 ('switch-to-confi')... machine # [ 91.040068] systemd[634]: Reexecuting. machine # [ 91.066580] systemd[634]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 91.206888] systemd[634]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 91.212201] systemd[634]: Reload requested from client PID 4836 ('switch-to-confi')... machine # [ 91.213843] systemd[634]: Reloading... machine # [ 91.352655] systemd[634]: Reloading finished in 137 ms. machine # [ 91.356820] systemd[634]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 91.363290] systemd[634]: Stopped Run user-specific NixOS activation. machine # [ 91.365054] systemd[634]: Stopping Run user-specific NixOS activation... machine # [ 91.367452] systemd[634]: Starting Run user-specific NixOS activation... machine # [ 91.402183] systemd[634]: Finished Run user-specific NixOS activation. machine # [ 91.405366] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 91.406634] systemd[1]: Stopping Reactivate sysinit units... machine # [ 91.407630] systemd[1]: Reached target Reactivate sysinit units. machine # [ 91.411778] systemd[1]: Reached target Remote File Systems. machine # [ 91.415980] systemd[1]: Reached target Local File Systems. machine # [ 91.417894] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 91.421222] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 91.422756] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 91.424431] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 91.427479] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 91.429608] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 91.431104] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 91.437478] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 91.438679] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 91.713116] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 91.714629] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 91.719980] systemd[1]: Started autorestart.service. machine # [ 91.722413] systemd[1]: Starting linger-users.service... machine # [ 91.751381] systemd[1]: autorestart.service: Main process exited, code=exited, status=1/FAILURE machine # [ 91.752674] systemd[1]: autorestart.service: Failed with result 'exit-code'. machine # [ 91.775776] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 91.776772] systemd[1]: Finished linger-users.service. machine # [ 92.082292] nixos[4767]: switching to system configuration /nix/store/nxiisb4fiyrrppl29j3i3vvk184mbh2m-nixos-system-machine-test failed (status 4) machine: (finished: must fail: /nix/store/35s2igiaaj5g08gc3r9xqcrxf6sx5fyq-nixos-system-machine-test/specialisation/autorestartServiceFailing/bin/switch-to-configuration test 2>&1, in 5.30 seconds) (finished: subtest: failing units, in 16.53 seconds) subtest: unit file parser machine: must succeed: /nix/store/35s2igiaaj5g08gc3r9xqcrxf6sx5fyq-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1 machine # [ 92.508148] nixos[4910]: switching to system configuration /nix/store/4k7cgqppkbkw0s0q7qk0vaj4038bb70z-nixos-system-machine-test machine # [ 92.510846] systemd[1]: Stopped autorestart.service. machine # [ 92.512514] systemd[1]: Stopped target Local File Systems. machine # [ 92.513900] systemd[1]: Stopped target Remote File Systems. machine # [ 92.854187] systemd[1]: Reload requested from client PID 4910 ('.switch-to-conf') (unit backdoor.service)... machine # [ 92.855816] systemd[1]: Reloading... machine # [ 93.300438] systemd[1]: Reloading finished in 442 ms. machine # [ 93.409031] systemd[634]: Reexecution requested from client PID 4979 ('switch-to-confi')... machine # [ 93.411129] systemd[634]: Reexecuting. machine # [ 93.437559] systemd[634]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 93.557210] systemd[634]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 93.562438] systemd[634]: Reload requested from client PID 4979 ('switch-to-confi')... machine # [ 93.563829] systemd[634]: Reloading... machine # [ 93.700895] systemd[634]: Reloading finished in 135 ms. machine # [ 93.706858] systemd[634]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 93.714067] systemd[634]: Stopped Run user-specific NixOS activation. machine # [ 93.714904] systemd[634]: Stopping Run user-specific NixOS activation... machine # [ 93.717741] systemd[634]: Starting Run user-specific NixOS activation... machine # [ 93.751678] systemd[634]: Finished Run user-specific NixOS activation. machine # [ 93.755563] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 93.756634] systemd[1]: Stopping Reactivate sysinit units... machine # [ 93.757774] systemd[1]: Reached target Reactivate sysinit units. machine # [ 93.761528] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 93.763399] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 93.765980] systemd[1]: Reached target Local File Systems. machine # [ 93.768600] systemd[1]: Reached target Remote File Systems. machine # [ 93.772833] systemd[1]: Starting linger-users.service... machine # [ 93.775812] systemd[1]: Starting test.service... machine # [ 93.785105] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 93.788299] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 93.789727] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 93.792123] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 93.794880] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 93.797108] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 93.801097] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 93.828718] systemd[1]: Finished test.service. machine # [ 93.855744] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 93.857688] systemd[1]: Finished linger-users.service. machine # [ 94.101600] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 94.103862] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 94.362184] nixos[4910]: finished switching to system configuration /nix/store/4k7cgqppkbkw0s0q7qk0vaj4038bb70z-nixos-system-machine-test machine: (finished: must succeed: /nix/store/35s2igiaaj5g08gc3r9xqcrxf6sx5fyq-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1, in 2.28 seconds) machine: must succeed: /nix/store/35s2igiaaj5g08gc3r9xqcrxf6sx5fyq-nixos-system-machine-test/specialisation/simpleServiceWithExtraSection/bin/switch-to-configuration test 2>&1 machine # [ 94.910832] nixos[5052]: switching to system configuration /nix/store/dk90ap03k3k3ldd6dvh54jqxvnf2pa49-nixos-system-machine-test machine # [ 94.914329] systemd[1]: Stopped target Local File Systems. machine # [ 94.915263] systemd[1]: Stopped target Remote File Systems. machine # [ 95.325253] systemd[1]: Reload requested from client PID 5052 ('.switch-to-conf') (unit backdoor.service)... machine # [ 95.326893] systemd[1]: Reloading... machine # [ 95.844977] systemd[1]: Reloading finished in 516 ms. machine # [ 95.959138] systemd[634]: Reexecution requested from client PID 5121 ('switch-to-confi')... machine # [ 95.960339] systemd[634]: Reexecuting. machine # [ 95.985562] systemd[634]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 96.104449] systemd[634]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 96.109565] systemd[634]: Reload requested from client PID 5121 ('switch-to-confi')... machine # [ 96.111545] systemd[634]: Reloading... machine # [ 96.228933] systemd[634]: Reloading finished in 116 ms. machine # [ 96.234834] systemd[634]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 96.242063] systemd[634]: Stopped Run user-specific NixOS activation. machine # [ 96.242947] systemd[634]: Stopping Run user-specific NixOS activation... machine # [ 96.245127] systemd[634]: Starting Run user-specific NixOS activation... machine # [ 96.274449] systemd[634]: Finished Run user-specific NixOS activation. machine # [ 96.277789] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 96.279494] systemd[1]: Stopping Reactivate sysinit units... machine # [ 96.280628] systemd[1]: Reached target Reactivate sysinit units. machine # [ 96.282113] systemd[1]: test.service: Deactivated successfully. machine # [ 96.282885] systemd[1]: Stopped test.service. machine # [ 96.283732] systemd[1]: Stopping test.service... machine # [ 96.286407] systemd[1]: Starting test.service... machine # [ 96.305627] systemd[1]: Finished test.service. machine # [ 96.309629] systemd[1]: Reached target Local File Systems. machine # [ 96.311385] systemd[1]: Reached target Remote File Systems. machine # [ 96.316494] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 96.318354] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 96.323600] systemd[1]: Starting linger-users.service... machine # [ 96.329334] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 96.332193] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 96.332938] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 96.335068] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 96.337042] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 96.338459] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 96.341119] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 96.390810] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 96.391818] systemd[1]: Finished linger-users.service. machine # [ 96.628523] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 96.630189] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 96.887811] nixos[5052]: finished switching to system configuration /nix/store/dk90ap03k3k3ldd6dvh54jqxvnf2pa49-nixos-system-machine-test machine: (finished: must succeed: /nix/store/35s2igiaaj5g08gc3r9xqcrxf6sx5fyq-nixos-system-machine-test/specialisation/simpleServiceWithExtraSection/bin/switch-to-configuration test 2>&1, in 2.52 seconds) machine: must succeed: /nix/store/35s2igiaaj5g08gc3r9xqcrxf6sx5fyq-nixos-system-machine-test/specialisation/simpleServiceWithExtraSectionOtherName/bin/switch-to-configuration test 2>&1 machine # [ 97.446971] nixos[5194]: switching to system configuration /nix/store/ilc3ff6lxqb4jh5saam3mmyg2z1cafb8-nixos-system-machine-test machine # [ 97.450382] systemd[1]: Stopped target Remote File Systems. machine # [ 97.451320] systemd[1]: Stopped target Local File Systems. machine # [ 97.831845] systemd[1]: Reload requested from client PID 5194 ('.switch-to-conf') (unit backdoor.service)... machine # [ 97.833433] systemd[1]: Reloading... machine # [ 98.348812] systemd[1]: Reloading finished in 513 ms. machine # [ 98.467530] systemd[634]: Reexecution requested from client PID 5263 ('switch-to-confi')... machine # [ 98.468779] systemd[634]: Reexecuting. machine # [ 98.493638] systemd[634]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 98.615872] systemd[634]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 98.621484] systemd[634]: Reload requested from client PID 5263 ('switch-to-confi')... machine # [ 98.622902] systemd[634]: Reloading... machine # [ 98.748839] systemd[634]: Reloading finished in 124 ms. machine # [ 98.753823] systemd[634]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 98.761062] systemd[634]: Stopped Run user-specific NixOS activation. machine # [ 98.761958] systemd[634]: Stopping Run user-specific NixOS activation... machine # [ 98.764979] systemd[634]: Starting Run user-specific NixOS activation... machine # [ 98.797815] systemd[634]: Finished Run user-specific NixOS activation. machine # [ 98.801553] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 98.802641] systemd[1]: Stopping Reactivate sysinit units... machine # [ 98.803771] systemd[1]: Reached target Reactivate sysinit units. machine # [ 98.805243] systemd[1]: test.service: Deactivated successfully. machine # [ 98.807229] systemd[1]: Stopped test.service. machine # [ 98.807845] systemd[1]: Stopping test.service... machine # [ 98.810106] systemd[1]: Starting test.service... machine # [ 98.833037] systemd[1]: Finished test.service. machine # [ 98.837290] systemd[1]: Reached target Remote File Systems. machine # [ 98.840648] systemd[1]: Reached target Local File Systems. machine # [ 98.842368] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 98.846426] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 98.848060] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 98.849207] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 98.851192] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 98.852626] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 98.853789] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 98.861972] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 98.863579] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 99.146939] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 99.148113] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 99.152596] systemd[1]: Starting linger-users.service... machine # [ 99.200056] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 99.202231] systemd[1]: Finished linger-users.service. machine # [ 99.458675] nixos[5194]: finished switching to system configuration /nix/store/ilc3ff6lxqb4jh5saam3mmyg2z1cafb8-nixos-system-machine-test machine: (finished: must succeed: /nix/store/35s2igiaaj5g08gc3r9xqcrxf6sx5fyq-nixos-system-machine-test/specialisation/simpleServiceWithExtraSectionOtherName/bin/switch-to-configuration test 2>&1, in 2.57 seconds) machine: must succeed: /nix/store/35s2igiaaj5g08gc3r9xqcrxf6sx5fyq-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1 machine # [ 99.980816] nixos[5336]: switching to system configuration /nix/store/4k7cgqppkbkw0s0q7qk0vaj4038bb70z-nixos-system-machine-test machine # [ 99.983489] systemd[1]: Stopped target Local File Systems. machine # [ 99.985222] systemd[1]: Stopped target Remote File Systems. machine # [ 100.373036] systemd[1]: Reload requested from client PID 5336 ('.switch-to-conf') (unit backdoor.service)... machine # [ 100.374717] systemd[1]: Reloading... machine # [ 100.895845] systemd[1]: Reloading finished in 518 ms. machine # [ 101.010114] systemd[634]: Reexecution requested from client PID 5405 ('switch-to-confi')... machine # [ 101.013219] systemd[634]: Reexecuting. machine # [ 101.035954] systemd[634]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 101.180407] systemd[634]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 101.185598] systemd[634]: Reload requested from client PID 5405 ('switch-to-confi')... machine # [ 101.187057] systemd[634]: Reloading... machine # [ 101.330934] systemd[634]: Reloading finished in 142 ms. machine # [ 101.334125] systemd[634]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 101.342179] systemd[634]: Stopped Run user-specific NixOS activation. machine # [ 101.344082] systemd[634]: Stopping Run user-specific NixOS activation... machine # [ 101.346511] systemd[634]: Starting Run user-specific NixOS activation... machine # [ 101.382746] systemd[634]: Finished Run user-specific NixOS activation. machine # [ 101.386419] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 101.387651] systemd[1]: Stopping Reactivate sysinit units... machine # [ 101.388720] systemd[1]: Reached target Reactivate sysinit units. machine # [ 101.390510] systemd[1]: test.service: Deactivated successfully. machine # [ 101.392205] systemd[1]: Stopped test.service. machine # [ 101.392815] systemd[1]: Stopping test.service... machine # [ 101.395447] systemd[1]: Starting test.service... machine # [ 101.422100] systemd[1]: Finished test.service. machine # [ 101.426526] systemd[1]: Reached target Remote File Systems. machine # [ 101.430234] systemd[1]: Starting linger-users.service... machine # [ 101.437596] systemd[1]: Reached target Local File Systems. machine # [ 101.440352] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 101.444216] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 101.446131] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 101.447502] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 101.450367] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 101.452891] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 101.456196] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 101.460366] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 101.461647] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 101.502467] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 101.503938] systemd[1]: Finished linger-users.service. machine # [ 101.744695] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 101.745792] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 102.003631] nixos[5336]: finished switching to system configuration /nix/store/4k7cgqppkbkw0s0q7qk0vaj4038bb70z-nixos-system-machine-test machine: (finished: must succeed: /nix/store/35s2igiaaj5g08gc3r9xqcrxf6sx5fyq-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1, in 2.55 seconds) machine: must succeed: /nix/store/35s2igiaaj5g08gc3r9xqcrxf6sx5fyq-nixos-system-machine-test/specialisation/simpleServiceWithInstallSection/bin/switch-to-configuration test 2>&1 machine # [ 102.563990] nixos[5478]: switching to system configuration /nix/store/j3mpns3hcw3gnp8shb76lp8wb5swyg9d-nixos-system-machine-test machine # [ 102.567478] systemd[1]: Stopped target Remote File Systems. machine # [ 102.568493] systemd[1]: Stopped target Local File Systems. machine # [ 102.931270] systemd[1]: Reload requested from client PID 5478 ('.switch-to-conf') (unit backdoor.service)... machine # [ 102.933073] systemd[1]: Reloading... machine # [ 103.400701] systemd[1]: Reloading finished in 465 ms. machine # [ 103.499810] systemd[634]: Reexecution requested from client PID 5547 ('switch-to-confi')... machine # [ 103.502601] systemd[634]: Reexecuting. machine # [ 103.528445] systemd[634]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 103.660955] systemd[634]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 103.666829] systemd[634]: Reload requested from client PID 5547 ('switch-to-confi')... machine # [ 103.668482] systemd[634]: Reloading... machine # [ 103.798836] systemd[634]: Reloading finished in 129 ms. machine # [ 103.803921] systemd[634]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 103.811308] systemd[634]: Stopped Run user-specific NixOS activation. machine # [ 103.813185] systemd[634]: Stopping Run user-specific NixOS activation... machine # [ 103.815195] systemd[634]: Starting Run user-specific NixOS activation... machine # [ 103.844150] systemd[634]: Finished Run user-specific NixOS activation. machine # [ 103.847541] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 103.849172] systemd[1]: Stopping Reactivate sysinit units... machine # [ 103.849945] systemd[1]: Reached target Reactivate sysinit units. machine # [ 103.851577] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 103.853159] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 103.857488] systemd[1]: Reached target Remote File Systems. machine # [ 103.860819] systemd[1]: Starting linger-users.service... machine # [ 103.864997] systemd[1]: Reached target Local File Systems. machine # [ 103.865753] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 103.869461] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 103.871703] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 103.874302] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 103.876250] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 103.877647] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 103.878780] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 103.926607] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 103.928786] systemd[1]: Finished linger-users.service. machine # [ 104.126953] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 104.129462] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 104.386708] nixos[5478]: finished switching to system configuration /nix/store/j3mpns3hcw3gnp8shb76lp8wb5swyg9d-nixos-system-machine-test machine: (finished: must succeed: /nix/store/35s2igiaaj5g08gc3r9xqcrxf6sx5fyq-nixos-system-machine-test/specialisation/simpleServiceWithInstallSection/bin/switch-to-configuration test 2>&1, in 2.38 seconds) machine: must succeed: /nix/store/35s2igiaaj5g08gc3r9xqcrxf6sx5fyq-nixos-system-machine-test/specialisation/simpleServiceWithExtraKey/bin/switch-to-configuration test 2>&1 machine # [ 104.885038] nixos[5618]: switching to system configuration /nix/store/rszwwdvnfw4rx0q8sj5ajq1sjm9pzqpw-nixos-system-machine-test machine # [ 104.887251] systemd[1]: Stopped target Remote File Systems. machine # [ 104.889264] systemd[1]: Stopped target Local File Systems. machine # [ 105.275245] systemd[1]: Reload requested from client PID 5618 ('.switch-to-conf') (unit backdoor.service)... machine # [ 105.276905] systemd[1]: Reloading... machine # [ 105.726230] systemd[1]: Reloading finished in 447 ms. machine # [ 105.820180] systemd[634]: Reexecution requested from client PID 5687 ('switch-to-confi')... machine # [ 105.823079] systemd[634]: Reexecuting. machine # [ 105.847777] systemd[634]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 105.959781] systemd[634]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 105.965221] systemd[634]: Reload requested from client PID 5687 ('switch-to-confi')... machine # [ 105.966687] systemd[634]: Reloading... machine # [ 106.096978] systemd[634]: Reloading finished in 128 ms. machine # [ 106.101842] systemd[634]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 106.109067] systemd[634]: Stopped Run user-specific NixOS activation. machine # [ 106.109943] systemd[634]: Stopping Run user-specific NixOS activation... machine # [ 106.112507] systemd[634]: Starting Run user-specific NixOS activation... machine # [ 106.145336] systemd[634]: Finished Run user-specific NixOS activation. machine # [ 106.148652] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 106.150412] systemd[1]: Stopping Reactivate sysinit units... machine # [ 106.151298] systemd[1]: Reached target Reactivate sysinit units. machine # [ 106.152637] systemd[1]: test.service: Deactivated successfully. machine # [ 106.154263] systemd[1]: Stopped test.service. machine # [ 106.154858] systemd[1]: Stopping test.service... machine # [ 106.157642] systemd[1]: Starting test.service... machine # [ 106.182310] systemd[1]: Finished test.service. machine # [ 106.186673] systemd[1]: Reached target Remote File Systems. machine # [ 106.190097] systemd[1]: Starting linger-users.service... machine # [ 106.196404] systemd[1]: Reached target Local File Systems. machine # [ 106.197336] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 106.200942] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 106.202132] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 106.203846] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 106.206950] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 106.208886] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 106.210439] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 106.213222] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 106.216152] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 106.265441] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 106.267067] systemd[1]: Finished linger-users.service. machine # [ 106.494310] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 106.495918] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 106.753841] nixos[5618]: finished switching to system configuration /nix/store/rszwwdvnfw4rx0q8sj5ajq1sjm9pzqpw-nixos-system-machine-test machine: (finished: must succeed: /nix/store/35s2igiaaj5g08gc3r9xqcrxf6sx5fyq-nixos-system-machine-test/specialisation/simpleServiceWithExtraKey/bin/switch-to-configuration test 2>&1, in 2.36 seconds) machine: must succeed: /nix/store/35s2igiaaj5g08gc3r9xqcrxf6sx5fyq-nixos-system-machine-test/specialisation/simpleServiceWithExtraKeyOtherValue/bin/switch-to-configuration test 2>&1 machine # [ 107.291637] nixos[5760]: switching to system configuration /nix/store/bwhmwm3j26nk5vgf6lfr7sarmwwqklcx-nixos-system-machine-test machine # [ 107.295165] systemd[1]: Stopped target Remote File Systems. machine # [ 107.296151] systemd[1]: Stopped target Local File Systems. machine # [ 107.735888] systemd[1]: Reload requested from client PID 5760 ('.switch-to-conf') (unit backdoor.service)... machine # [ 107.737566] systemd[1]: Reloading... machine # [ 108.286635] systemd[1]: Reloading finished in 547 ms. machine # [ 108.398637] systemd[634]: Reexecution requested from client PID 5829 ('switch-to-confi')... machine # [ 108.401384] systemd[634]: Reexecuting. machine # [ 108.428479] systemd[634]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 108.568430] systemd[634]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 108.572861] systemd[634]: Reload requested from client PID 5829 ('switch-to-confi')... machine # [ 108.574557] systemd[634]: Reloading... machine # [ 108.710418] systemd[634]: Reloading finished in 133 ms. machine # [ 108.713831] systemd[634]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 108.721169] systemd[634]: Stopped Run user-specific NixOS activation. machine # [ 108.722031] systemd[634]: Stopping Run user-specific NixOS activation... machine # [ 108.724773] systemd[634]: Starting Run user-specific NixOS activation... machine # [ 108.757895] systemd[634]: Finished Run user-specific NixOS activation. machine # [ 108.761194] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 108.762779] systemd[1]: Stopping Reactivate sysinit units... machine # [ 108.763931] systemd[1]: Reached target Reactivate sysinit units. machine # [ 108.765280] systemd[1]: test.service: Deactivated successfully. machine # [ 108.767239] systemd[1]: Stopped test.service. machine # [ 108.767838] systemd[1]: Stopping test.service... machine # [ 108.770216] systemd[1]: Starting test.service... machine # [ 108.795609] systemd[1]: Finished test.service. machine # [ 108.801275] systemd[1]: Reached target Local File Systems. machine # [ 108.804405] systemd[1]: Reached target Remote File Systems. machine # [ 108.807778] systemd[1]: Starting linger-users.service... machine # [ 108.809863] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 108.815401] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 108.816786] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 108.818476] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 108.821107] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 108.823409] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 108.825194] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 108.831412] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 108.832636] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 108.882333] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 108.883967] systemd[1]: Finished linger-users.service. machine # [ 109.126745] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 109.127806] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 109.384529] nixos[5760]: finished switching to system configuration /nix/store/bwhmwm3j26nk5vgf6lfr7sarmwwqklcx-nixos-system-machine-test machine: (finished: must succeed: /nix/store/35s2igiaaj5g08gc3r9xqcrxf6sx5fyq-nixos-system-machine-test/specialisation/simpleServiceWithExtraKeyOtherValue/bin/switch-to-configuration test 2>&1, in 2.63 seconds) machine: must succeed: /nix/store/35s2igiaaj5g08gc3r9xqcrxf6sx5fyq-nixos-system-machine-test/specialisation/simpleServiceWithExtraKeyOtherName/bin/switch-to-configuration test 2>&1 machine # [ 109.981948] nixos[5902]: switching to system configuration /nix/store/4xaxilln56r1lbd44b2hipil3vkcp2ch-nixos-system-machine-test machine # [ 109.985406] systemd[1]: Stopped target Local File Systems. machine # [ 109.986402] systemd[1]: Stopped target Remote File Systems. machine # [ 110.369852] systemd[1]: Reload requested from client PID 5902 ('.switch-to-conf') (unit backdoor.service)... machine # [ 110.371541] systemd[1]: Reloading... machine # [ 110.902087] systemd[1]: Reloading finished in 528 ms. machine # [ 111.002430] systemd[634]: Reexecution requested from client PID 5971 ('switch-to-confi')... machine # [ 111.005045] systemd[634]: Reexecuting. machine # [ 111.030086] systemd[634]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 111.150524] systemd[634]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 111.155624] systemd[634]: Reload requested from client PID 5971 ('switch-to-confi')... machine # [ 111.156827] systemd[634]: Reloading... machine # [ 111.273766] systemd[634]: Reloading finished in 115 ms. machine # [ 111.277813] systemd[634]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 111.284073] systemd[634]: Stopped Run user-specific NixOS activation. machine # [ 111.285898] systemd[634]: Stopping Run user-specific NixOS activation... machine # [ 111.288096] systemd[634]: Starting Run user-specific NixOS activation... machine # [ 111.324690] systemd[634]: Finished Run user-specific NixOS activation. machine # [ 111.328347] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 111.329929] systemd[1]: Stopping Reactivate sysinit units... machine # [ 111.330949] systemd[1]: Reached target Reactivate sysinit units. machine # [ 111.332557] systemd[1]: test.service: Deactivated successfully. machine # [ 111.334300] systemd[1]: Stopped test.service. machine # [ 111.334924] systemd[1]: Stopping test.service... machine # [ 111.337741] systemd[1]: Starting test.service... machine # [ 111.363834] systemd[1]: Finished test.service. machine # [ 111.365875] systemd[1]: Reached target Remote File Systems. machine # [ 111.368285] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 111.370342] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 111.374919] systemd[1]: Reached target Local File Systems. machine # [ 111.377146] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 111.380800] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 111.381680] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 111.382842] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 111.384711] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 111.388230] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 111.391128] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 111.675683] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 111.678380] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 111.681831] systemd[1]: Starting linger-users.service... machine # [ 111.731620] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 111.732673] systemd[1]: Finished linger-users.service. machine # [ 111.990345] nixos[5902]: finished switching to system configuration /nix/store/4xaxilln56r1lbd44b2hipil3vkcp2ch-nixos-system-machine-test machine: (finished: must succeed: /nix/store/35s2igiaaj5g08gc3r9xqcrxf6sx5fyq-nixos-system-machine-test/specialisation/simpleServiceWithExtraKeyOtherName/bin/switch-to-configuration test 2>&1, in 2.60 seconds) machine: must succeed: /nix/store/35s2igiaaj5g08gc3r9xqcrxf6sx5fyq-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1 machine # [ 112.516438] nixos[6044]: switching to system configuration /nix/store/4k7cgqppkbkw0s0q7qk0vaj4038bb70z-nixos-system-machine-test machine # [ 112.518785] systemd[1]: Stopped target Remote File Systems. machine # [ 112.520611] systemd[1]: Stopped target Local File Systems. machine # [ 112.878188] systemd[1]: Reload requested from client PID 6044 ('.switch-to-conf') (unit backdoor.service)... machine # [ 112.879792] systemd[1]: Reloading... machine # [ 113.333876] systemd[1]: Reloading finished in 451 ms. machine # [ 113.449100] systemd[634]: Reexecution requested from client PID 6113 ('switch-to-confi')... machine # [ 113.451708] systemd[634]: Reexecuting. machine # [ 113.478740] systemd[634]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 113.609895] systemd[634]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 113.615757] systemd[634]: Reload requested from client PID 6113 ('switch-to-confi')... machine # [ 113.617274] systemd[634]: Reloading... machine # [ 113.753679] systemd[634]: Reloading finished in 134 ms. machine # [ 113.758823] systemd[634]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 113.765293] systemd[634]: Stopped Run user-specific NixOS activation. machine # [ 113.767059] systemd[634]: Stopping Run user-specific NixOS activation... machine # [ 113.769289] systemd[634]: Starting Run user-specific NixOS activation... machine # [ 113.803615] systemd[634]: Finished Run user-specific NixOS activation. machine # [ 113.806911] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 113.808468] systemd[1]: Stopping Reactivate sysinit units... machine # [ 113.809435] systemd[1]: Reached target Reactivate sysinit units. machine # [ 113.811073] systemd[1]: test.service: Deactivated successfully. machine # [ 113.813130] systemd[1]: Stopped test.service. machine # [ 113.813797] systemd[1]: Stopping test.service... machine # [ 113.815903] systemd[1]: Starting test.service... machine # [ 113.842679] systemd[1]: Finished test.service. machine # [ 113.844651] systemd[1]: Reached target Local File Systems. machine # [ 113.846412] systemd[1]: Reached target Remote File Systems. machine # [ 113.849939] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 113.853239] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 113.854195] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 113.855349] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 113.858825] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 113.861268] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 113.862836] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 113.869899] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 113.871322] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 114.190317] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 114.191829] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 114.196687] systemd[1]: Starting linger-users.service... machine # [ 114.250148] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 114.251153] systemd[1]: Finished linger-users.service. machine # [ 114.507572] nixos[6044]: finished switching to system configuration /nix/store/4k7cgqppkbkw0s0q7qk0vaj4038bb70z-nixos-system-machine-test machine: (finished: must succeed: /nix/store/35s2igiaaj5g08gc3r9xqcrxf6sx5fyq-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1, in 2.52 seconds) machine: must succeed: /nix/store/35s2igiaaj5g08gc3r9xqcrxf6sx5fyq-nixos-system-machine-test/specialisation/simpleServiceReloadTrigger/bin/switch-to-configuration test 2>&1 machine # [ 115.224252] nixos[6186]: switching to system configuration /nix/store/1ri1ack8522p111jkl4sk6856gw3rr2s-nixos-system-machine-test machine # [ 115.226501] systemd[1]: Stopped target Remote File Systems. machine # [ 115.228307] systemd[1]: Stopped target Local File Systems. machine # [ 115.712088] systemd[1]: Reload requested from client PID 6186 ('.switch-to-conf') (unit backdoor.service)... machine # [ 115.713686] systemd[1]: Reloading... machine # [ 116.335654] systemd[1]: Reloading finished in 619 ms. machine # [ 116.464287] systemd[634]: Reexecution requested from client PID 6255 ('switch-to-confi')... machine # [ 116.466461] systemd[634]: Reexecuting. machine # [ 116.494048] systemd[634]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 116.616143] systemd[634]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 116.622624] systemd[634]: Reload requested from client PID 6255 ('switch-to-confi')... machine # [ 116.623965] systemd[634]: Reloading... machine # [ 116.750071] systemd[634]: Reloading finished in 123 ms. machine # [ 116.753847] systemd[634]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 116.760367] systemd[634]: Stopped Run user-specific NixOS activation. machine # [ 116.762088] systemd[634]: Stopping Run user-specific NixOS activation... machine # [ 116.764477] systemd[634]: Starting Run user-specific NixOS activation... machine # [ 116.796649] systemd[634]: Finished Run user-specific NixOS activation. machine # [ 116.799934] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 116.801185] systemd[1]: Stopping Reactivate sysinit units... machine # [ 116.801930] systemd[1]: Reached target Reactivate sysinit units. machine # [ 116.806399] systemd[1]: Reloading test.service... machine # [ 116.832184] systemd[1]: Reloaded test.service. machine # [ 116.834724] systemd[1]: Reached target Local File Systems. machine # [ 116.839076] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 116.842775] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 116.843636] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 116.844785] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 116.846756] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 116.848189] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 116.851810] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 116.853419] systemd[1]: Reached target Remote File Systems. machine # [ 116.859361] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 116.861126] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 117.144202] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 117.145433] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 117.149877] systemd[1]: Starting linger-users.service... machine # [ 117.199081] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 117.200133] systemd[1]: Finished linger-users.service. machine # [ 117.456670] nixos[6186]: finished switching to system configuration /nix/store/1ri1ack8522p111jkl4sk6856gw3rr2s-nixos-system-machine-test machine: (finished: must succeed: /nix/store/35s2igiaaj5g08gc3r9xqcrxf6sx5fyq-nixos-system-machine-test/specialisation/simpleServiceReloadTrigger/bin/switch-to-configuration test 2>&1, in 2.95 seconds) machine: must succeed: /nix/store/35s2igiaaj5g08gc3r9xqcrxf6sx5fyq-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModified/bin/switch-to-configuration test 2>&1 machine # [ 118.050935] nixos[6328]: switching to system configuration /nix/store/dn23zxc4mqjh1rdz3ylxll3yi29ahf9s-nixos-system-machine-test machine # [ 118.053373] systemd[1]: Stopped target Remote File Systems. machine # [ 118.055028] systemd[1]: Stopped target Local File Systems. machine # [ 118.497403] systemd[1]: Reload requested from client PID 6328 ('.switch-to-conf') (unit backdoor.service)... machine # [ 118.499203] systemd[1]: Reloading... machine # [ 119.077969] systemd[1]: Reloading finished in 576 ms. machine # [ 119.203041] systemd[634]: Reexecution requested from client PID 6397 ('switch-to-confi')... machine # [ 119.206059] systemd[634]: Reexecuting. machine # [ 119.232784] systemd[634]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 119.374275] systemd[634]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 119.379031] systemd[634]: Reload requested from client PID 6397 ('switch-to-confi')... machine # [ 119.380566] systemd[634]: Reloading... machine # [ 119.528563] systemd[634]: Reloading finished in 146 ms. machine # [ 119.532852] systemd[634]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 119.539275] systemd[634]: Stopped Run user-specific NixOS activation. machine # [ 119.541076] systemd[634]: Stopping Run user-specific NixOS activation... machine # [ 119.543483] systemd[634]: Starting Run user-specific NixOS activation... machine # [ 119.582707] systemd[634]: Finished Run user-specific NixOS activation. machine # [ 119.585960] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 119.587278] systemd[1]: Stopping Reactivate sysinit units... machine # [ 119.588230] systemd[1]: Reached target Reactivate sysinit units. machine # [ 119.592178] systemd[1]: Reloading test.service... machine # [ 119.619588] systemd[1]: Reloaded test.service. machine # [ 119.623430] systemd[1]: Reached target Remote File Systems. machine # [ 119.627099] systemd[1]: Starting linger-users.service... machine # [ 119.635341] systemd[1]: Reached target Local File Systems. machine # [ 119.636108] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 119.641252] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 119.642844] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 119.644605] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 119.647160] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 119.649587] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 119.651948] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 119.655054] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 119.656366] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 119.701283] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 119.702804] systemd[1]: Finished linger-users.service. machine # [ 119.974670] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 119.977525] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 120.233297] nixos[6328]: finished switching to system configuration /nix/store/dn23zxc4mqjh1rdz3ylxll3yi29ahf9s-nixos-system-machine-test machine: (finished: must succeed: /nix/store/35s2igiaaj5g08gc3r9xqcrxf6sx5fyq-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModified/bin/switch-to-configuration test 2>&1, in 2.78 seconds) machine: must succeed: /nix/store/35s2igiaaj5g08gc3r9xqcrxf6sx5fyq-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModifiedAndSomethingElse/bin/switch-to-configuration test 2>&1 machine # [ 120.822572] nixos[6470]: switching to system configuration /nix/store/4x1xg93bm9qfaxyav0jhd6kd8hrcsr2i-nixos-system-machine-test machine # [ 120.824844] systemd[1]: Stopped target Local File Systems. machine # [ 120.826678] systemd[1]: Stopped target Remote File Systems. machine # [ 121.229445] systemd[1]: Reload requested from client PID 6470 ('.switch-to-conf') (unit backdoor.service)... machine # [ 121.231139] systemd[1]: Reloading... machine # [ 121.747348] systemd[1]: Reloading finished in 514 ms. machine # [ 121.859796] systemd[634]: Reexecution requested from client PID 6539 ('switch-to-confi')... machine # [ 121.862813] systemd[634]: Reexecuting. machine # [ 121.885948] systemd[634]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 122.023376] systemd[634]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 122.028759] systemd[634]: Reload requested from client PID 6539 ('switch-to-confi')... machine # [ 122.030292] systemd[634]: Reloading... machine # [ 122.164784] systemd[634]: Reloading finished in 132 ms. machine # [ 122.169812] systemd[634]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 122.176233] systemd[634]: Stopped Run user-specific NixOS activation. machine # [ 122.178095] systemd[634]: Stopping Run user-specific NixOS activation... machine # [ 122.180267] systemd[634]: Starting Run user-specific NixOS activation... machine # [ 122.213940] systemd[634]: Finished Run user-specific NixOS activation. machine # [ 122.217680] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 122.218788] systemd[1]: Stopping Reactivate sysinit units... machine # [ 122.219805] systemd[1]: Reached target Reactivate sysinit units. machine # [ 122.221339] systemd[1]: test.service: Deactivated successfully. machine # [ 122.223227] systemd[1]: Stopped test.service. machine # [ 122.223808] systemd[1]: Stopping test.service... machine # [ 122.226108] systemd[1]: Starting test.service... machine # [ 122.250686] systemd[1]: Finished test.service. machine # [ 122.254565] systemd[1]: Reached target Local File Systems. machine # [ 122.256809] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 122.261772] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 122.262693] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 122.263836] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 122.266703] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 122.268837] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 122.271083] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 122.274967] systemd[1]: Reached target Remote File Systems. machine # [ 122.283081] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 122.284466] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 122.542386] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 122.543947] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 122.548590] systemd[1]: Starting linger-users.service... machine # [ 122.593133] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 122.594642] systemd[1]: Finished linger-users.service. machine # [ 122.851821] nixos[6470]: finished switching to system configuration /nix/store/4x1xg93bm9qfaxyav0jhd6kd8hrcsr2i-nixos-system-machine-test machine: (finished: must succeed: /nix/store/35s2igiaaj5g08gc3r9xqcrxf6sx5fyq-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModifiedAndSomethingElse/bin/switch-to-configuration test 2>&1, in 2.62 seconds) machine: must succeed: /nix/store/35s2igiaaj5g08gc3r9xqcrxf6sx5fyq-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModifiedSomethingElse/bin/switch-to-configuration test 2>&1 machine # [ 123.370293] nixos[6612]: switching to system configuration /nix/store/rszwwdvnfw4rx0q8sj5ajq1sjm9pzqpw-nixos-system-machine-test machine # [ 123.373669] systemd[1]: Stopped target Local File Systems. machine # [ 123.374580] systemd[1]: Stopped target Remote File Systems. machine # [ 123.722171] systemd[1]: Reload requested from client PID 6612 ('.switch-to-conf') (unit backdoor.service)... machine # [ 123.723839] systemd[1]: Reloading... machine # [ 124.183897] systemd[1]: Reloading finished in 458 ms. machine # [ 124.304274] systemd[634]: Reexecution requested from client PID 6681 ('switch-to-confi')... machine # [ 124.305525] systemd[634]: Reexecuting. machine # [ 124.333029] systemd[634]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 124.475062] systemd[634]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 124.479054] systemd[634]: Reload requested from client PID 6681 ('switch-to-confi')... machine # [ 124.480224] systemd[634]: Reloading... machine # [ 124.625542] systemd[634]: Reloading finished in 143 ms. machine # [ 124.629827] systemd[634]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 124.636228] systemd[634]: Stopped Run user-specific NixOS activation. machine # [ 124.637993] systemd[634]: Stopping Run user-specific NixOS activation... machine # [ 124.640248] systemd[634]: Starting Run user-specific NixOS activation... machine # [ 124.676345] systemd[634]: Finished Run user-specific NixOS activation. machine # [ 124.679708] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 124.681438] systemd[1]: Stopping Reactivate sysinit units... machine # [ 124.682527] systemd[1]: Reached target Reactivate sysinit units. machine # [ 124.688280] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 124.690288] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 124.692211] systemd[1]: Reached target Local File Systems. machine # [ 124.694053] systemd[1]: Reached target Remote File Systems. machine # [ 124.697613] systemd[1]: Starting linger-users.service... machine # [ 124.700726] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 124.706074] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 124.707223] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 124.710121] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 124.712072] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 124.713502] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 124.714722] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 124.770937] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 124.772066] systemd[1]: Finished linger-users.service. machine # [ 125.009728] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 125.012333] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 125.268825] nixos[6612]: finished switching to system configuration /nix/store/rszwwdvnfw4rx0q8sj5ajq1sjm9pzqpw-nixos-system-machine-test machine: (finished: must succeed: /nix/store/35s2igiaaj5g08gc3r9xqcrxf6sx5fyq-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModifiedSomethingElse/bin/switch-to-configuration test 2>&1, in 2.42 seconds) (finished: subtest: unit file parser, in 33.19 seconds) subtest: restart and reload by activation script machine: must succeed: /nix/store/35s2igiaaj5g08gc3r9xqcrxf6sx5fyq-nixos-system-machine-test/specialisation/simpleServiceNorestart/bin/switch-to-configuration test 2>&1 machine # [ 125.812875] nixos[6752]: switching to system configuration /nix/store/y2w65nkh87l0bsf38ja39zqxbbpzqdjc-nixos-system-machine-test machine # [ 125.815207] systemd[1]: Stopped target Remote File Systems. machine # [ 125.816872] systemd[1]: Stopped target Local File Systems. machine # [ 126.179053] systemd[1]: Reload requested from client PID 6752 ('.switch-to-conf') (unit backdoor.service)... machine # [ 126.180624] systemd[1]: Reloading... machine # [ 126.638899] systemd[1]: Reloading finished in 456 ms. machine # [ 126.748556] systemd[634]: Reexecution requested from client PID 6821 ('switch-to-confi')... machine # [ 126.750259] systemd[634]: Reexecuting. machine # [ 126.775149] systemd[634]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 126.899890] systemd[634]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 126.905410] systemd[634]: Reload requested from client PID 6821 ('switch-to-confi')... machine # [ 126.906796] systemd[634]: Reloading... machine # [ 127.039257] systemd[634]: Reloading finished in 130 ms. machine # [ 127.044813] systemd[634]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 127.051265] systemd[634]: Stopped Run user-specific NixOS activation. machine # [ 127.053085] systemd[634]: Stopping Run user-specific NixOS activation... machine # [ 127.055254] systemd[634]: Starting Run user-specific NixOS activation... machine # [ 127.087879] systemd[634]: Finished Run user-specific NixOS activation. machine # [ 127.091272] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 127.092817] systemd[1]: Stopping Reactivate sysinit units... machine # [ 127.094277] systemd[1]: Reached target Reactivate sysinit units. machine # [ 127.095241] systemd[1]: Reached target Remote File Systems. machine # [ 127.098499] systemd[1]: Reached target Local File Systems. machine # [ 127.100253] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 127.102208] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 127.103515] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 127.107432] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 127.108397] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 127.109535] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 127.112604] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 127.114458] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 127.117059] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 127.376915] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 127.378239] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 127.382351] systemd[1]: Starting linger-users.service... machine # [ 127.420740] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 127.421879] systemd[1]: Finished linger-users.service. machine # [ 127.676845] nixos[6752]: finished switching to system configuration /nix/store/y2w65nkh87l0bsf38ja39zqxbbpzqdjc-nixos-system-machine-test machine: (finished: must succeed: /nix/store/35s2igiaaj5g08gc3r9xqcrxf6sx5fyq-nixos-system-machine-test/specialisation/simpleServiceNorestart/bin/switch-to-configuration test 2>&1, in 2.40 seconds) machine: must succeed: /nix/store/35s2igiaaj5g08gc3r9xqcrxf6sx5fyq-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration test 2>&1 machine # [ 128.113607] nixos[6892]: switching to system configuration /nix/store/x2zqa32crq4fk9prpsnvghcz1i6hx7iy-nixos-system-machine-test machine # [ 128.116099] systemd[1]: Stopped target Local File Systems. machine # [ 128.117956] systemd[1]: Stopped target Remote File Systems. machine # [ 128.119675] systemd[1]: test.service: Deactivated successfully. machine # [ 128.120645] systemd[1]: Stopped test.service. machine # [ 128.558940] systemd[1]: Reload requested from client PID 6892 ('.switch-to-conf') (unit backdoor.service)... machine # [ 128.560757] systemd[1]: Reloading... machine # [ 129.114701] systemd[1]: Reloading finished in 551 ms. machine # [ 129.236299] systemd[634]: Reexecution requested from client PID 6963 ('switch-to-confi')... machine # [ 129.237560] systemd[634]: Reexecuting. machine # [ 129.265071] systemd[634]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 129.410156] systemd[634]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 129.416032] systemd[634]: Reload requested from client PID 6963 ('switch-to-confi')... machine # [ 129.417738] systemd[634]: Reloading... machine # [ 129.566942] systemd[634]: Reloading finished in 147 ms. machine # [ 129.571816] systemd[634]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 129.579082] systemd[634]: Stopped Run user-specific NixOS activation. machine # [ 129.579904] systemd[634]: Stopping Run user-specific NixOS activation... machine # [ 129.582222] systemd[634]: Starting Run user-specific NixOS activation... machine # [ 129.618611] systemd[634]: Finished Run user-specific NixOS activation. machine # [ 129.621965] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 129.623605] systemd[1]: Stopping Reactivate sysinit units... machine # [ 129.624528] systemd[1]: Reached target Reactivate sysinit units. machine # [ 129.629931] systemd[1]: Starting reload-triggers-and-restart-by-as.service... machine # [ 129.642592] systemd[1]: Created slice Slice /system/templated-simple-service. machine # [ 129.647267] systemd[1]: Starting no-restart-service.service... machine # [ 129.649597] systemd[1]: Starting templated-simple-service@instance.service... machine # [ 129.651976] systemd[1]: Reached target Local File Systems. machine # [ 129.661336] systemd[1]: Starting simple-reload-service.service... machine # [ 129.665900] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 129.674075] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 129.674905] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 129.677255] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 129.680595] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 129.684558] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 129.686462] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 129.687914] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 129.690191] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 129.697602] systemd[1]: Created slice Slice /system/templated-simple-reload-service. machine # [ 129.707291] systemd[1]: Created slice Slice /system/templated-no-restart-service. machine # [ 129.713279] systemd[1]: Finished reload-triggers-and-restart-by-as.service. machine # [ 129.726924] systemd[1]: Created slice Slice /system/templated-simple-restart-service. machine # [ 129.737079] systemd[1]: Finished no-restart-service.service. machine # [ 129.739723] systemd[1]: Finished templated-simple-service@instance.service. machine # [ 129.752758] systemd[1]: Finished simple-reload-service.service. machine # [ 129.758584] systemd[1]: Created slice Slice /system/templated-reload-triggers-and-restart-by-as. machine # [ 129.760554] systemd[1]: Reached target Remote File Systems. machine # [ 129.764887] systemd[1]: Created slice Slice /system/templated-reload-triggers. machine # [ 129.766995] systemd[1]: Created slice Slice /system/templated-reload-triggers-and-restart. machine # [ 129.998663] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 130.000449] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 130.005156] systemd[1]: Starting linger-users.service... machine # [ 130.011840] systemd[1]: Starting reload-triggers-and-restart.service... machine # [ 130.017260] systemd[1]: Starting reload-triggers.service... machine # [ 130.020104] systemd[1]: Starting simple-restart-service.service... machine # [ 130.022718] systemd[1]: Starting simple-service.service... machine # [ 130.029230] systemd[1]: Starting templated-no-restart-service@instance.service... machine # [ 130.034971] systemd[1]: Starting templated-reload-triggers-and-restart-by-as@instance.service... machine # [ 130.041206] systemd[1]: Starting templated-reload-triggers-and-restart@instance.service... machine # [ 130.045852] systemd[1]: Starting templated-reload-triggers@instance.service... machine # [ 130.053444] systemd[1]: Starting templated-simple-reload-service@instance.service... machine # [ 130.061081] systemd[1]: Starting templated-simple-restart-service@instance.service... machine # [ 130.118106] systemd[1]: Finished reload-triggers-and-restart.service. machine # [ 130.140212] systemd[1]: Finished reload-triggers.service. machine # [ 130.143172] systemd[1]: Finished templated-no-restart-service@instance.service. machine # [ 130.146839] systemd[1]: Finished templated-reload-triggers-and-restart-by-as@instance.service. machine # [ 130.149210] systemd[1]: Finished simple-restart-service.service. machine # [ 130.151613] systemd[1]: Finished simple-service.service. machine # [ 130.158854] systemd[1]: Finished templated-reload-triggers-and-restart@instance.service. machine # [ 130.167884] systemd[1]: Finished templated-reload-triggers@instance.service. machine # [ 130.175546] systemd[1]: Finished templated-simple-restart-service@instance.service. machine # [ 130.177649] systemd[1]: Finished templated-simple-reload-service@instance.service. machine # [ 130.182873] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 130.184344] systemd[1]: Finished linger-users.service. machine # [ 130.442399] nixos[6892]: finished switching to system configuration /nix/store/x2zqa32crq4fk9prpsnvghcz1i6hx7iy-nixos-system-machine-test machine: (finished: must succeed: /nix/store/35s2igiaaj5g08gc3r9xqcrxf6sx5fyq-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration test 2>&1, in 2.77 seconds) machine: must succeed: /nix/store/35s2igiaaj5g08gc3r9xqcrxf6sx5fyq-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration test 2>&1 machine # [ 131.055937] nixos[7062]: switching to system configuration /nix/store/x2zqa32crq4fk9prpsnvghcz1i6hx7iy-nixos-system-machine-test machine # [ 131.058237] systemd[1]: Stopped target Remote File Systems. machine # [ 131.059809] systemd[1]: Stopped target Local File Systems. machine # [ 131.464405] systemd[1]: Reload requested from client PID 7062 ('.switch-to-conf') (unit backdoor.service)... machine # [ 131.466053] systemd[1]: Reloading... machine # [ 131.967894] systemd[1]: Reloading finished in 500 ms. machine # [ 132.085370] systemd[634]: Reexecution requested from client PID 7133 ('switch-to-confi')... machine # [ 132.086699] systemd[634]: Reexecuting. machine # [ 132.113026] systemd[634]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 132.254769] systemd[634]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 132.260362] systemd[634]: Reload requested from client PID 7133 ('switch-to-confi')... machine # [ 132.261767] systemd[634]: Reloading... machine # [ 132.399425] systemd[634]: Reloading finished in 135 ms. machine # [ 132.403846] systemd[634]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 132.410686] systemd[634]: Stopped Run user-specific NixOS activation. machine # [ 132.411702] systemd[634]: Stopping Run user-specific NixOS activation... machine # [ 132.414644] systemd[634]: Starting Run user-specific NixOS activation... machine # [ 132.444149] systemd[634]: Finished Run user-specific NixOS activation. machine # [ 132.447269] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 132.448657] systemd[1]: Stopping Reactivate sysinit units... machine # [ 132.449762] systemd[1]: Reached target Reactivate sysinit units. machine # [ 132.454565] systemd[1]: Reloading reload-triggers-and-restart.service... machine # [ 132.459267] systemd[1]: Reloading reload-triggers.service... machine # [ 132.464185] systemd[1]: Reloading simple-reload-service.service... machine # [ 132.469547] systemd[1]: Reloading templated-reload-triggers-and-restart@instance.service... machine # [ 132.476423] systemd[1]: Reloading templated-reload-triggers@instance.service... machine # [ 132.483228] systemd[1]: Reloading templated-simple-reload-service@instance.service... machine # [ 132.517832] systemd[1]: Reloaded reload-triggers-and-restart.service. machine # [ 132.526282] systemd[1]: Reloaded reload-triggers.service. machine # [ 132.533326] systemd[1]: Reloaded simple-reload-service.service. machine # [ 132.535382] systemd[1]: Reloaded templated-reload-triggers-and-restart@instance.service. machine # [ 132.538276] systemd[1]: Reloaded templated-reload-triggers@instance.service. machine # [ 132.539753] systemd[1]: Reloaded templated-simple-reload-service@instance.service. machine # [ 132.542689] systemd[1]: reload-triggers-and-restart-by-as.service: Deactivated successfully. machine # [ 132.545122] systemd[1]: Stopped reload-triggers-and-restart-by-as.service. machine # [ 132.546284] systemd[1]: Stopping reload-triggers-and-restart-by-as.service... machine # [ 132.547826] systemd[1]: Starting reload-triggers-and-restart-by-as.service... machine # [ 132.550413] systemd[1]: simple-restart-service.service: Deactivated successfully. machine # [ 132.552212] systemd[1]: Stopped simple-restart-service.service. machine # [ 132.553093] systemd[1]: Stopping simple-restart-service.service... machine # [ 132.556441] systemd[1]: Starting simple-restart-service.service... machine # [ 132.559194] systemd[1]: simple-service.service: Deactivated successfully. machine # [ 132.560099] systemd[1]: Stopped simple-service.service. machine # [ 132.560790] systemd[1]: Stopping simple-service.service... machine # [ 132.564060] systemd[1]: Starting simple-service.service... machine # [ 132.567157] systemd[1]: templated-reload-triggers-and-restart-by-as@instance.service: Deactivated successfully. machine # [ 132.568532] systemd[1]: Stopped templated-reload-triggers-and-restart-by-as@instance.service. machine # [ 132.569803] systemd[1]: Stopping templated-reload-triggers-and-restart-by-as@instance.service... machine # [ 132.572528] systemd[1]: Starting templated-reload-triggers-and-restart-by-as@instance.service... machine # [ 132.575230] systemd[1]: templated-simple-restart-service@instance.service: Deactivated successfully. machine # [ 132.577507] systemd[1]: Stopped templated-simple-restart-service@instance.service. machine # [ 132.579608] systemd[1]: Stopping templated-simple-restart-service@instance.service... machine # [ 132.582224] systemd[1]: Starting templated-simple-restart-service@instance.service... machine # [ 132.586271] systemd[1]: templated-simple-service@instance.service: Deactivated successfully. machine # [ 132.588159] systemd[1]: Stopped templated-simple-service@instance.service. machine # [ 132.589823] systemd[1]: Stopping templated-simple-service@instance.service... machine # [ 132.593134] systemd[1]: Starting templated-simple-service@instance.service... machine # [ 132.629046] systemd[1]: Finished reload-triggers-and-restart-by-as.service. machine # [ 132.638370] systemd[1]: Finished simple-restart-service.service. machine # [ 132.641610] systemd[1]: Finished simple-service.service. machine # [ 132.644167] systemd[1]: Finished templated-reload-triggers-and-restart-by-as@instance.service. machine # [ 132.651485] systemd[1]: Finished templated-simple-restart-service@instance.service. machine # [ 132.653598] systemd[1]: Finished templated-simple-service@instance.service. machine # [ 132.656593] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 132.658171] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 132.661343] systemd[1]: Reached target Remote File Systems. machine # [ 132.665103] systemd[1]: Starting linger-users.service... machine # [ 132.672317] systemd[1]: Reached target Local File Systems. machine # [ 132.674886] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 132.680585] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 132.681593] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 132.683617] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 132.686439] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 132.688865] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 132.691069] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 132.738732] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 132.740340] systemd[1]: Finished linger-users.service. machine # [ 132.983796] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 132.985079] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 133.242863] nixos[7062]: finished switching to system configuration /nix/store/x2zqa32crq4fk9prpsnvghcz1i6hx7iy-nixos-system-machine-test machine: (finished: must succeed: /nix/store/35s2igiaaj5g08gc3r9xqcrxf6sx5fyq-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration test 2>&1, in 2.80 seconds) machine: must succeed: /nix/store/35s2igiaaj5g08gc3r9xqcrxf6sx5fyq-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script-modified/bin/switch-to-configuration test 2>&1 machine # [ 133.897836] nixos[7228]: switching to system configuration /nix/store/cpq7in7hn6gz0vmnjr1xj2r1mcamcv71-nixos-system-machine-test machine # [ 133.901322] systemd[1]: Stopped target Remote File Systems. machine # [ 133.902330] systemd[1]: Stopped target Local File Systems. machine # [ 134.374518] systemd[1]: Reload requested from client PID 7228 ('.switch-to-conf') (unit backdoor.service)... machine # [ 134.376140] systemd[1]: Reloading... machine # [ 134.937295] systemd[1]: Reloading finished in 558 ms. machine # [ 135.065236] systemd[634]: Reexecution requested from client PID 7299 ('switch-to-confi')... machine # [ 135.067687] systemd[634]: Reexecuting. machine # [ 135.094727] systemd[634]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 135.238453] systemd[634]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 135.243210] systemd[634]: Reload requested from client PID 7299 ('switch-to-confi')... machine # [ 135.244876] systemd[634]: Reloading... machine # [ 135.388575] systemd[634]: Reloading finished in 141 ms. machine # [ 135.391821] systemd[634]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 135.398483] systemd[634]: Stopped Run user-specific NixOS activation. machine # [ 135.400064] systemd[634]: Stopping Run user-specific NixOS activation... machine # [ 135.402780] systemd[634]: Starting Run user-specific NixOS activation... machine # [ 135.438456] systemd[634]: Finished Run user-specific NixOS activation. machine # [ 135.441801] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 135.443270] systemd[1]: Stopping Reactivate sysinit units... machine # [ 135.444147] systemd[1]: Reached target Reactivate sysinit units. machine # [ 135.448835] systemd[1]: Reloading reload-triggers.service... machine # [ 135.453086] systemd[1]: Reloading simple-reload-service.service... machine # [ 135.458330] systemd[1]: Reloading templated-reload-triggers@instance.service... machine # [ 135.463203] systemd[1]: Reloading templated-simple-reload-service@instance.service... machine # [ 135.501599] systemd[1]: Reloaded reload-triggers.service. machine # [ 135.502533] systemd[1]: Reloaded simple-reload-service.service. machine # [ 135.506556] systemd[1]: Reloaded templated-reload-triggers@instance.service. machine # [ 135.507639] systemd[1]: Reloaded templated-simple-reload-service@instance.service. machine # [ 135.511101] systemd[1]: reload-triggers-and-restart-by-as.service: Deactivated successfully. machine # [ 135.512300] systemd[1]: Stopped reload-triggers-and-restart-by-as.service. machine # [ 135.513299] systemd[1]: Stopping reload-triggers-and-restart-by-as.service... machine # [ 135.516438] systemd[1]: Starting reload-triggers-and-restart-by-as.service... machine # [ 135.518267] systemd[1]: reload-triggers-and-restart.service: Deactivated successfully. machine # [ 135.520387] systemd[1]: Stopped reload-triggers-and-restart.service. machine # [ 135.521264] systemd[1]: Stopping reload-triggers-and-restart.service... machine # [ 135.525253] systemd[1]: Starting reload-triggers-and-restart.service... machine # [ 135.526913] systemd[1]: simple-restart-service.service: Deactivated successfully. machine # [ 135.528337] systemd[1]: Stopped simple-restart-service.service. machine # [ 135.530388] systemd[1]: Stopping simple-restart-service.service... machine # [ 135.533058] systemd[1]: Starting simple-restart-service.service... machine # [ 135.536203] systemd[1]: simple-service.service: Deactivated successfully. machine # [ 135.537063] systemd[1]: Stopped simple-service.service. machine # [ 135.537719] systemd[1]: Stopping simple-service.service... machine # [ 135.542235] systemd[1]: Starting simple-service.service... machine # [ 135.545167] systemd[1]: templated-reload-triggers-and-restart-by-as@instance.service: Deactivated successfully. machine # [ 135.546723] systemd[1]: Stopped templated-reload-triggers-and-restart-by-as@instance.service. machine # [ 135.548331] systemd[1]: Stopping templated-reload-triggers-and-restart-by-as@instance.service... machine # [ 135.550872] systemd[1]: Starting templated-reload-triggers-and-restart-by-as@instance.service... machine # [ 135.554795] systemd[1]: templated-reload-triggers-and-restart@instance.service: Deactivated successfully. machine # [ 135.556994] systemd[1]: Stopped templated-reload-triggers-and-restart@instance.service. machine # [ 135.559893] systemd[1]: Stopping templated-reload-triggers-and-restart@instance.service... machine # [ 135.561939] systemd[1]: Starting templated-reload-triggers-and-restart@instance.service... machine # [ 135.564992] systemd[1]: templated-simple-restart-service@instance.service: Deactivated successfully. machine # [ 135.566169] systemd[1]: Stopped templated-simple-restart-service@instance.service. machine # [ 135.568510] systemd[1]: Stopping templated-simple-restart-service@instance.service... machine # [ 135.576707] systemd[1]: Starting templated-simple-restart-service@instance.service... machine # [ 135.579583] systemd[1]: templated-simple-service@instance.service: Deactivated successfully. machine # [ 135.582692] systemd[1]: Stopped templated-simple-service@instance.service. machine # [ 135.584322] systemd[1]: Stopping templated-simple-service@instance.service... machine # [ 135.590177] systemd[1]: Starting templated-simple-service@instance.service... machine # [ 135.625940] systemd[1]: Finished reload-triggers-and-restart.service. machine # [ 135.630975] systemd[1]: Finished reload-triggers-and-restart-by-as.service. machine # [ 135.635867] systemd[1]: Finished simple-restart-service.service. machine # [ 135.643683] systemd[1]: Finished simple-service.service. machine # [ 135.646381] systemd[1]: Finished templated-reload-triggers-and-restart-by-as@instance.service. machine # [ 135.651865] systemd[1]: Finished templated-reload-triggers-and-restart@instance.service. machine # [ 135.656974] systemd[1]: Finished templated-simple-service@instance.service. machine # [ 135.659298] systemd[1]: Finished templated-simple-restart-service@instance.service. machine # [ 135.662297] systemd[1]: Reached target Remote File Systems. machine # [ 135.663974] systemd[1]: Reached target Local File Systems. machine # [ 135.671108] systemd[1]: Starting linger-users.service... machine # [ 135.676915] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 135.679827] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 135.680661] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 135.681816] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 135.683736] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 135.685165] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 135.686322] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 135.694701] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 135.696023] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 135.746080] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 135.747153] systemd[1]: Finished linger-users.service. machine # [ 135.985972] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 135.987302] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 136.245211] nixos[7228]: finished switching to system configuration /nix/store/cpq7in7hn6gz0vmnjr1xj2r1mcamcv71-nixos-system-machine-test machine: (finished: must succeed: /nix/store/35s2igiaaj5g08gc3r9xqcrxf6sx5fyq-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script-modified/bin/switch-to-configuration test 2>&1, in 3.00 seconds) machine: must succeed: /nix/store/35s2igiaaj5g08gc3r9xqcrxf6sx5fyq-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/35s2igiaaj5g08gc3r9xqcrxf6sx5fyq-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration dry-activate 2>&1, in 0.84 seconds) (finished: subtest: restart and reload by activation script, in 11.82 seconds) (finished: run the VM test script, in 138.05 seconds) test script finished in 138.09s cleanup kill QemuMachine (pid 45) machine # qemu-system-x86_64: terminating on signal 15 from pid 39 (/nix/store/b5bpi6zfajzzrwwpgba2q6li3nnya4bs-python3-3.14.7/bin/python3.14) (finished: cleanup, in 0.17 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