tribuchet: building on jamie Machine state will be reset. To keep it, pass --keep-machine-state start all VLans (finished: start all VLans, in 0.00 seconds) Test will time out and terminate in 3600.0 seconds run the VM test script machine: waiting for unit multi-user.target machine: waiting for the VM to finish booting machine: starting vm machine: QEMU running (pid 45) machine # Disk image does not exist, creating the virtualisation disk image... machine # Formatting '/build/vm-state-machine/tmp.jOvaK0sEvq', 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: 7edbc775-d923-46d0-ad5b-f74c60eda9a1 machine # Superblock backups stored on blocks: machine # 32768, 98304, 163840, 229376 machine # machine # Allocating group tables: 0/8 done machine # Writing inode tables: 0/8 done machine # Creating journal (8192 blocks): done machine # Writing superblocks and filesystem accounting information: 0/8 done machine # machine # Virtualisation disk image created. machine # Starting virtiofs daemons... machine # [2026-10-01T03:48:50Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1) machine # [2026-10-01T03:48:50Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether machine # [2026-10-01T03:48:50Z INFO virtiofsd] Waiting for vhost-user socket connection... machine # [2026-10-01T03:48:50Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1) machine # [2026-10-01T03:48:50Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether machine # [2026-10-01T03:48:50Z INFO virtiofsd] Waiting for vhost-user socket connection... machine # [2026-10-01T03:48:50Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1) machine # [2026-10-01T03:48:50Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether machine # [2026-10-01T03:48:50Z INFO virtiofsd] Waiting for vhost-user socket connection... machine # [2026-10-01T03:48:51Z INFO virtiofsd] Client connected, servicing requests machine # [2026-10-01T03:48:51Z INFO virtiofsd] Client connected, servicing requests machine # [2026-10-01T03:48:51Z INFO virtiofsd] Client connected, servicing requests machine # SeaBIOS (version rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org) machine # machine # machine # iPXE (http://ipxe.org) 00:02.0 CA00 PCI2.10 PnP PMM+3EFCC730+3EF2C730 CA00 machine # Press Ctrl-B to configure iPXE (PCI 00:02.0)... machine # machine # machine # machine # machine # iPXE (http://ipxe.org) 00:05.0 CB00 PCI2.10 PnP PMM 3EFCC730 3EF2C730 CB00 machine # Press Ctrl-B to configure iPXE (PCI 00:05.0)... machine # machine # machine # Booting from ROM... machine # Probing EDD (edd=off to disable)... ok[ 0.000000] Linux version 6.18.54 (nixbld@localhost) (gcc (GCC) 16.2.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT_DYNAMIC Fri Sep 25 14:35: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/jl59xgshkm15yy4qkh11f2517r2vlwz8-nixos-system-machine-test/init regInfo=/nix/.ro-store/8y0phvs7fqr16kqdsl1w2jckilmgf4wy-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 512077560 cycles machine # [ 0.000002] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns machine # [ 0.000005] tsc: Detected 2400.012 MHz processor machine # [ 0.000763] last_pfn = 0x3ffd8 max_arch_pfn = 0x10000000000 machine # [ 0.000790] MTRR map: 4 entries (3 fixed + 1 variable; max 19), built from 8 variable MTRRs machine # [ 0.000792] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT machine # [ 0.002687] found SMP MP-table at [mem 0x000f5450-0x000f545f] machine # [ 0.002698] Using GB pages for direct mapping machine # [ 0.002749] RAMDISK: [mem 0x3e34a000-0x3ffcffff] machine # [ 0.002756] ACPI: Early table checksum verification disabled machine # [ 0.002759] ACPI: RSDP 0x00000000000F5270 000014 (v00 BOCHS ) machine # [ 0.002763] ACPI: RSDT 0x000000003FFE2422 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) machine # [ 0.002767] ACPI: FACP 0x000000003FFE221A 0000F4 (v03 BOCHS BXPC 00000001 BXPC 00000001) machine # [ 0.002774] ACPI: DSDT 0x000000003FFE0040 0021DA (v01 BOCHS BXPC 00000001 BXPC 00000001) machine # [ 0.002776] ACPI: FACS 0x000000003FFE0000 000040 machine # [ 0.002778] ACPI: APIC 0x000000003FFE230E 000078 (v03 BOCHS BXPC 00000001 BXPC 00000001) machine # [ 0.002779] ACPI: HPET 0x000000003FFE2386 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) machine # [ 0.002781] ACPI: MCFG 0x000000003FFE23BE 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001) machine # [ 0.002782] ACPI: WAET 0x000000003FFE23FA 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001) machine # [ 0.002784] ACPI: Reserving FACP table memory at [mem 0x3ffe221a-0x3ffe230d] machine # [ 0.002785] ACPI: Reserving DSDT table memory at [mem 0x3ffe0040-0x3ffe2219] machine # [ 0.002785] ACPI: Reserving FACS table memory at [mem 0x3ffe0000-0x3ffe003f] machine # [ 0.002786] ACPI: Reserving APIC table memory at [mem 0x3ffe230e-0x3ffe2385] machine # [ 0.002786] ACPI: Reserving HPET table memory at [mem 0x3ffe2386-0x3ffe23bd] machine # [ 0.002787] ACPI: Reserving MCFG table memory at [mem 0x3ffe23be-0x3ffe23f9] machine # [ 0.002787] ACPI: Reserving WAET table memory at [mem 0x3ffe23fa-0x3ffe2421] machine # [ 0.003011] No NUMA configuration found machine # [ 0.003012] Faking a node at [mem 0x0000000000000000-0x000000003ffd7fff] machine # [ 0.003014] NODE_DATA(0) allocated [mem 0x3ffd2780-0x3ffd7cff] machine # [ 0.005378] Zone ranges: machine # [ 0.005379] DMA [mem 0x0000000000001000-0x0000000000ffffff] machine # [ 0.005381] DMA32 [mem 0x0000000001000000-0x000000003ffd7fff] machine # [ 0.005382] Normal empty machine # [ 0.005383] Device empty machine # [ 0.005383] Movable zone start for each node machine # [ 0.005384] Early memory node ranges machine # [ 0.005384] node 0: [mem 0x0000000000001000-0x000000000009efff] machine # [ 0.005385] node 0: [mem 0x0000000000100000-0x000000003ffd7fff] machine # [ 0.005386] Initmem setup node 0 [mem 0x0000000000001000-0x000000003ffd7fff] machine # [ 0.005405] On node 0, zone DMA: 1 pages in unavailable ranges machine # [ 0.005670] On node 0, zone DMA: 97 pages in unavailable ranges machine # [ 0.026304] On node 0, zone DMA32: 40 pages in unavailable ranges machine # [ 0.026896] ACPI: PM-Timer IO Port: 0x608 machine # [ 0.026910] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) machine # [ 0.026943] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 machine # [ 0.026947] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) machine # [ 0.026948] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) machine # [ 0.026950] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) machine # [ 0.026951] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) machine # [ 0.026952] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) machine # [ 0.026955] ACPI: Using ACPI (MADT) for SMP configuration information machine # [ 0.026956] ACPI: HPET id: 0x8086a201 base: 0xfed00000 machine # [ 0.026961] TSC deadline timer available machine # [ 0.026966] CPU topo: Max. logical packages: 1 machine # [ 0.026967] CPU topo: Max. logical dies: 1 machine # [ 0.026967] CPU topo: Max. dies per package: 1 machine # [ 0.026971] CPU topo: Max. threads per core: 1 machine # [ 0.026972] CPU topo: Num. cores per package: 1 machine # [ 0.026972] CPU topo: Num. threads per package: 1 machine # [ 0.026973] CPU topo: Allowing 1 present CPUs plus 0 hotplug CPUs machine # [ 0.026993] kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write() machine # [ 0.027031] PM: hibernation: Registered nosave memory: [mem 0x00000000-0x00000fff] machine # [ 0.027033] PM: hibernation: Registered nosave memory: [mem 0x0009f000-0x000fffff] machine # [ 0.027035] [mem 0x40000000-0xafffffff] available for PCI devices machine # [ 0.027037] Booting paravirtualized kernel on KVM machine # [ 0.027039] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns machine # [ 0.031922] setup_percpu: NR_CPUS:384 nr_cpumask_bits:1 nr_cpu_ids:1 nr_node_ids:1 machine # [ 0.034718] percpu: Embedded 98 pages/cpu s278528 r8192 d114688 u2097152 machine # [ 0.034780] kvm-guest: PV spinlocks disabled, single CPU machine # [ 0.034782] 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/jl59xgshkm15yy4qkh11f2517r2vlwz8-nixos-system-machine-test/init regInfo=/nix/.ro-store/8y0phvs7fqr16kqdsl1w2jckilmgf4wy-closure-info/registration console=ttyS0,115200n8 console=tty0 machine # [ 0.034898] Unknown kernel command line parameters "regInfo=/nix/.ro-store/8y0phvs7fqr16kqdsl1w2jckilmgf4wy-closure-info/registration", will be passed to user space. machine # [ 0.034912] random: crng init done machine # [ 0.034913] printk: log buffer data + meta data: 262144 + 917504 = 1179648 bytes machine # [ 0.036284] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes, linear) machine # [ 0.036306] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes, linear) machine # [ 0.036345] Fallback order for Node 0: 0 machine # [ 0.036348] Built 1 zonelists, mobility grouping on. Total pages: 262006 machine # [ 0.036350] Policy zone: DMA32 machine # [ 0.039407] mem auto-init: stack:all(zero), heap alloc:on, heap free:off machine # [ 0.042453] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1 machine # [ 0.045283] allocated 2097152 bytes of page_ext machine # [ 0.056171] ftrace: allocating 48820 entries in 192 pages machine # [ 0.056174] ftrace: allocated 192 pages with 2 groups machine # [ 0.057240] Dynamic Preempt: lazy machine # [ 0.057430] rcu: Preemptible hierarchical RCU implementation. machine # [ 0.057431] rcu: RCU event tracing is enabled. machine # [ 0.057432] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1. machine # [ 0.057433] Trampoline variant of Tasks RCU enabled. machine # [ 0.057434] Rude variant of Tasks RCU enabled. machine # [ 0.057434] Tracing variant of Tasks RCU enabled. machine # [ 0.057435] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. machine # [ 0.057436] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1 machine # [ 0.057503] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. machine # [ 0.057505] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. machine # [ 0.057506] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. machine # [ 0.063321] NR_IRQS: 24832, nr_irqs: 256, preallocated irqs: 16 machine # [ 0.063631] rcu: srcu_init: Setting srcu_struct sizes based on contention. machine # [ 0.063639] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns machine # [ 0.063757] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____) machine # [ 0.067472] Console: colour VGA+ 80x25 machine # [ 0.067475] printk: legacy console [tty0] enabled machine # [ 0.098396] printk: legacy console [ttyS0] enabled machine # [ 0.203657] ACPI: Core revision 20250807 machine # [ 0.204571] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns machine # [ 0.206212] APIC: Switch to symmetric I/O mode setup machine # [ 0.207272] x2apic enabled machine # [ 0.208021] APIC: Switched APIC routing to: physical x2apic machine # [ 0.209931] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 machine # [ 0.210977] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x229842dd0bd, max_idle_ns: 440795319571 ns machine # [ 0.212722] Calibrating delay loop (skipped) preset value.. 4800.02 BogoMIPS (lpj=2400012) machine # [ 0.214736] x86/cpu: User Mode Instruction Prevention (UMIP) activated machine # [ 0.215866] Last level iTLB entries: 4KB 512, 2MB 255, 4MB 127 machine # [ 0.216719] Last level dTLB entries: 4KB 512, 2MB 255, 4MB 127, 1GB 0 machine # [ 0.217721] mitigations: Enabled attack vectors: user_kernel, user_user, guest_host, guest_guest, SMT mitigations: auto machine # [ 0.218718] Speculative Store Bypass: Mitigation: Speculative Store Bypass disabled via prctl machine # [ 0.219719] Transient Scheduler Attacks: Vulnerable: No microcode machine # [ 0.220718] Spectre V2 : Mitigation: Enhanced / Automatic IBRS machine # [ 0.221718] Speculative Return Stack Overflow: Mitigation: Safe RET machine # [ 0.222718] Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization machine # [ 0.224725] Spectre V2 : Enabling IBPB for BPF machine # [ 0.225719] Spectre V2 : mitigation: Enabling conditional Indirect Branch Prediction Barrier machine # [ 0.226719] active return thunk: srso_alias_return_thunk machine # [ 0.228643] x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers' machine # [ 0.229718] x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers' machine # [ 0.230718] x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers' machine # [ 0.231718] x86/fpu: Supporting XSAVE feature 0x020: 'AVX-512 opmask' machine # [ 0.232718] x86/fpu: Supporting XSAVE feature 0x040: 'AVX-512 Hi256' machine # [ 0.233718] x86/fpu: Supporting XSAVE feature 0x080: 'AVX-512 ZMM_Hi256' machine # [ 0.234718] x86/fpu: Supporting XSAVE feature 0x200: 'Protection Keys User registers' machine # [ 0.235718] x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256 machine # [ 0.236718] x86/fpu: xstate_offset[5]: 832, xstate_sizes[5]: 64 machine # [ 0.237718] x86/fpu: xstate_offset[6]: 896, xstate_sizes[6]: 512 machine # [ 0.238718] x86/fpu: xstate_offset[7]: 1408, xstate_sizes[7]: 1024 machine # [ 0.239718] x86/fpu: xstate_offset[9]: 2432, xstate_sizes[9]: 8 machine # [ 0.240718] x86/fpu: Enabled xstate features 0x2e7, context size is 2440 bytes, using 'compacted' format. machine # [ 0.274787] Freeing SMP alternatives memory: 48K machine # [ 0.275580] pid_max: default: 32768 minimum: 301 machine # [ 0.276381] LSM: initializing lsm=capability,landlock,yama,bpf,ima machine # [ 0.276820] landlock: Up and running. machine # [ 0.278184] Yama: becoming mindful. machine # [ 0.278929] LSM support for eBPF active machine # [ 0.279828] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear) machine # [ 0.280740] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear) machine # [ 0.283717] smpboot: CPU0: AMD EPYC 9654 96-Core Processor (family: 0x19, model: 0x11, stepping: 0x1) machine # [ 0.284389] Performance Events: Fam17h+ core perfctr, AMD PMU driver. machine # [ 0.284723] ... version: 2 machine # [ 0.285420] ... bit width: 48 machine # [ 0.285721] ... generic counters: 6 machine # [ 0.286440] ... generic bitmap: 000000000000003f machine # [ 0.286730] ... fixed-purpose counters: 0 machine # [ 0.287471] ... fixed-purpose bitmap: 0000000000000000 machine # [ 0.287721] ... value mask: 0000ffffffffffff machine # [ 0.288644] ... max period: 00007fffffffffff machine # [ 0.289412] ... global_ctrl mask: 000000000000003f machine # [ 0.289843] signal: max sigframe size: 3376 machine # [ 0.290637] rcu: Hierarchical SRCU implementation. machine # [ 0.291338] rcu: Max phase no-delay instances is 400. machine # [ 0.296306] smp: Bringing up secondary CPUs ... machine # [ 0.296734] smp: Brought up 1 node, 1 CPU machine # [ 0.297387] smpboot: Total of 1 processors activated (4800.02 BogoMIPS) machine # [ 0.297870] Memory: 940920K/1048024K available (18120K kernel code, 2728K rwdata, 13640K rodata, 3656K init, 3632K bss, 99728K reserved, 0K cma-reserved) machine # [ 0.298947] devtmpfs: initialized machine # [ 0.299771] x86/mm: Memory block size: 128MB machine # [ 0.301597] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear) machine # [ 0.302670] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear). machine # [ 0.303815] pinctrl core: initialized pinctrl subsystem machine # [ 0.304958] PM: RTC time: 03:48:51, date: 2026-10-01 machine # [ 0.308682] NET: Registered PF_NETLINK/PF_ROUTE protocol family machine # [ 0.309856] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations machine # [ 0.310740] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations machine # [ 0.311869] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations machine # [ 0.312730] audit: initializing netlink subsys (disabled) machine # [ 0.313916] thermal_sys: Registered thermal governor 'fair_share' machine # [ 0.313918] thermal_sys: Registered thermal governor 'bang_bang' machine # [ 0.314722] thermal_sys: Registered thermal governor 'step_wise' machine # [ 0.315692] thermal_sys: Registered thermal governor 'user_space' machine # [ 0.316469] audit: type=2000 audit(1790826531.739:1): state=initialized audit_enabled=0 res=1 machine # [ 0.317725] thermal_sys: Registered thermal governor 'power_allocator' machine # [ 0.317739] cpuidle: using governor menu machine # [ 0.319947] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 machine # [ 0.320956] PCI: ECAM [mem 0xb0000000-0xbfffffff] (base 0xb0000000) for domain 0000 [bus 00-ff] machine # [ 0.321723] PCI: ECAM [mem 0xb0000000-0xbfffffff] reserved as E820 entry machine # [ 0.322733] PCI: Using configuration type 1 for base access machine # [ 0.323838] kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible. machine # [ 0.330969] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages machine # [ 0.331721] HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page machine # [ 0.336724] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages machine # [ 0.337722] HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page machine # [ 0.346332] ACPI: Added _OSI(Module Device) machine # [ 0.346722] ACPI: Added _OSI(Processor Device) machine # [ 0.347477] ACPI: Added _OSI(Processor Aggregator Device) machine # [ 0.354307] ACPI: 1 ACPI AML tables successfully acquired and loaded machine # [ 0.357623] ACPI: Interpreter enabled machine # [ 0.358203] ACPI: PM: (supports S0 S3 S4 S5) machine # [ 0.358721] ACPI: Using IOAPIC for interrupt routing machine # [ 0.359591] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug machine # [ 0.364721] PCI: Using E820 reservations for host bridge windows machine # [ 0.365849] ACPI: Enabled 2 GPEs in block 00 to 3F machine # [ 0.373822] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) machine # [ 0.374727] acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] machine # [ 0.375809] acpi PNP0A08:00: _OSC: platform does not support [PCIeHotplug LTR] machine # [ 0.376844] acpi PNP0A08:00: _OSC: OS now controls [PME AER PCIeCapability] machine # [ 0.378071] PCI host bridge to bus 0000:00 machine # [ 0.378725] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] machine # [ 0.379721] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] machine # [ 0.380720] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] machine # [ 0.381720] pci_bus 0000:00: root bus resource [mem 0x40000000-0xafffffff window] machine # [ 0.382721] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window] machine # [ 0.383721] pci_bus 0000:00: root bus resource [mem 0x100000000-0x8ffffffff window] machine # [ 0.384721] pci_bus 0000:00: root bus resource [bus 00-ff] machine # [ 0.385674] pci 0000:00:00.0: [8086:29c0] type 00 class 0x060000 conventional PCI endpoint machine # [ 0.387158] pci 0000:00:01.0: [1234:1111] type 00 class 0x030000 conventional PCI endpoint machine # [ 0.389776] pci 0000:00:01.0: BAR 0 [mem 0xfd000000-0xfdffffff pref] machine # [ 0.390733] pci 0000:00:01.0: BAR 2 [mem 0xfebd0000-0xfebd0fff] machine # [ 0.391787] pci 0000:00:01.0: ROM [mem 0xfebc0000-0xfebcffff pref] machine # [ 0.392890] pci 0000:00:01.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff] machine # [ 0.394619] pci 0000:00:02.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint machine # [ 0.397729] pci 0000:00:02.0: BAR 0 [io 0xc100-0xc11f] machine # [ 0.398598] pci 0000:00:02.0: BAR 1 [mem 0xfebd1000-0xfebd1fff] machine # [ 0.399487] pci 0000:00:02.0: BAR 4 [mem 0xfe000000-0xfe003fff 64bit pref] machine # [ 0.399727] pci 0000:00:02.0: ROM [mem 0xfeb40000-0xfeb7ffff pref] machine # [ 0.401839] pci 0000:00:03.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint machine # [ 0.404638] pci 0000:00:03.0: BAR 0 [io 0xc120-0xc13f] machine # [ 0.405397] pci 0000:00:03.0: BAR 1 [mem 0xfebd2000-0xfebd2fff] machine # [ 0.405743] pci 0000:00:03.0: BAR 4 [mem 0xfe004000-0xfe007fff 64bit pref] machine # [ 0.407280] pci 0000:00:04.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint machine # [ 0.410024] pci 0000:00:04.0: BAR 0 [io 0xc000-0xc07f] machine # [ 0.411401] pci 0000:00:04.0: BAR 1 [mem 0xfebd3000-0xfebd3fff] machine # [ 0.411742] pci 0000:00:04.0: BAR 4 [mem 0xfe008000-0xfe00bfff 64bit pref] machine # [ 0.413282] pci 0000:00:05.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint machine # [ 0.415569] pci 0000:00:05.0: BAR 0 [io 0xc140-0xc15f] machine # [ 0.416399] pci 0000:00:05.0: BAR 1 [mem 0xfebd4000-0xfebd4fff] machine # [ 0.416742] pci 0000:00:05.0: BAR 4 [mem 0xfe00c000-0xfe00ffff 64bit pref] machine # [ 0.417727] pci 0000:00:05.0: ROM [mem 0xfeb80000-0xfebbffff pref] machine # [ 0.419259] pci 0000:00:06.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint machine # [ 0.420733] pci 0000:00:06.0: BAR 1 [mem 0xfebd5000-0xfebd5fff] machine # [ 0.421746] pci 0000:00:06.0: BAR 4 [mem 0xfe010000-0xfe013fff 64bit pref] machine # [ 0.423332] pci 0000:00:07.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint machine # [ 0.424742] pci 0000:00:07.0: BAR 1 [mem 0xfebd6000-0xfebd6fff] machine # [ 0.425747] pci 0000:00:07.0: BAR 4 [mem 0xfe014000-0xfe017fff 64bit pref] machine # [ 0.427292] pci 0000:00:08.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint machine # [ 0.428733] pci 0000:00:08.0: BAR 1 [mem 0xfebd7000-0xfebd7fff] machine # [ 0.429731] pci 0000:00:08.0: BAR 4 [mem 0xfe018000-0xfe01bfff 64bit pref] machine # [ 0.431253] pci 0000:00:09.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint machine # [ 0.432734] pci 0000:00:09.0: BAR 1 [mem 0xfebd8000-0xfebd8fff] machine # [ 0.434474] pci 0000:00:09.0: BAR 4 [mem 0xfe01c000-0xfe01ffff 64bit pref] machine # [ 0.435249] pci 0000:00:0a.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint machine # [ 0.437482] pci 0000:00:0a.0: BAR 0 [io 0xc080-0xc0bf] machine # [ 0.437728] pci 0000:00:0a.0: BAR 1 [mem 0xfebd9000-0xfebd9fff] machine # [ 0.438699] pci 0000:00:0a.0: BAR 4 [mem 0xfe020000-0xfe023fff 64bit pref] machine # [ 0.440135] pci 0000:00:0b.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint machine # [ 0.441729] pci 0000:00:0b.0: BAR 0 [io 0xc160-0xc17f] machine # [ 0.442609] pci 0000:00:0b.0: BAR 1 [mem 0xfebda000-0xfebdafff] machine # [ 0.443494] pci 0000:00:0b.0: BAR 4 [mem 0xfe024000-0xfe027fff 64bit pref] machine # [ 0.445144] pci 0000:00:1d.0: [8086:2934] type 00 class 0x0c0300 conventional PCI endpoint machine # [ 0.446507] pci 0000:00:1d.0: BAR 4 [io 0xc180-0xc19f] machine # [ 0.446919] pci 0000:00:1d.1: [8086:2935] type 00 class 0x0c0300 conventional PCI endpoint machine # [ 0.448553] pci 0000:00:1d.1: BAR 4 [io 0xc1a0-0xc1bf] machine # [ 0.449579] pci 0000:00:1d.2: [8086:2936] type 00 class 0x0c0300 conventional PCI endpoint machine # [ 0.451429] pci 0000:00:1d.2: BAR 4 [io 0xc1c0-0xc1df] machine # [ 0.451979] pci 0000:00:1d.7: [8086:293a] type 00 class 0x0c0320 conventional PCI endpoint machine # [ 0.454497] pci 0000:00:1d.7: BAR 0 [mem 0xfebdb000-0xfebdbfff] machine # [ 0.454954] pci 0000:00:1f.0: [8086:2918] type 00 class 0x060100 conventional PCI endpoint machine # [ 0.456006] pci 0000:00:1f.0: quirk: [io 0x0600-0x067f] claimed by ICH6 ACPI/GPIO/TCO machine # [ 0.456976] pci 0000:00:1f.2: [8086:2922] type 00 class 0x010601 conventional PCI endpoint machine # [ 0.458750] pci 0000:00:1f.2: BAR 4 [io 0xc1e0-0xc1ff] machine # [ 0.459628] pci 0000:00:1f.2: BAR 5 [mem 0xfebdc000-0xfebdcfff] machine # [ 0.460779] pci 0000:00:1f.3: [8086:2930] type 00 class 0x0c0500 conventional PCI endpoint machine # [ 0.462393] pci 0000:00:1f.3: BAR 4 [io 0x0700-0x073f] machine # [ 0.466467] ACPI: PCI: Interrupt link LNKA configured for IRQ 10 machine # [ 0.466826] ACPI: PCI: Interrupt link LNKB configured for IRQ 10 machine # [ 0.468126] ACPI: PCI: Interrupt link LNKC configured for IRQ 11 machine # [ 0.468826] ACPI: PCI: Interrupt link LNKD configured for IRQ 11 machine # [ 0.469817] ACPI: PCI: Interrupt link LNKE configured for IRQ 10 machine # [ 0.470816] ACPI: PCI: Interrupt link LNKF configured for IRQ 10 machine # [ 0.471830] ACPI: PCI: Interrupt link LNKG configured for IRQ 11 machine # [ 0.472828] ACPI: PCI: Interrupt link LNKH configured for IRQ 11 machine # [ 0.473763] ACPI: PCI: Interrupt link GSIA configured for IRQ 16 machine # [ 0.474735] ACPI: PCI: Interrupt link GSIB configured for IRQ 17 machine # [ 0.475736] ACPI: PCI: Interrupt link GSIC configured for IRQ 18 machine # [ 0.476739] ACPI: PCI: Interrupt link GSID configured for IRQ 19 machine # [ 0.477738] ACPI: PCI: Interrupt link GSIE configured for IRQ 20 machine # [ 0.478728] ACPI: PCI: Interrupt link GSIF configured for IRQ 21 machine # [ 0.479700] ACPI: PCI: Interrupt link GSIG configured for IRQ 22 machine # [ 0.480496] ACPI: PCI: Interrupt link GSIH configured for IRQ 23 machine # [ 0.481917] iommu: Default domain type: Translated machine # [ 0.482728] iommu: DMA domain TLB invalidation policy: lazy mode machine # [ 0.483985] ACPI: bus type USB registered machine # [ 0.484760] usbcore: registered new interface driver usbfs machine # [ 0.485674] usbcore: registered new interface driver hub machine # [ 0.486398] usbcore: registered new device driver usb machine # [ 0.487612] NetLabel: Initializing machine # [ 0.488166] NetLabel: domain hash size = 128 machine # [ 0.488720] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO machine # [ 0.489696] NetLabel: unlabeled traffic allowed by default machine # [ 0.490432] PCI: Using ACPI for IRQ routing machine # [ 0.532922] pci 0000:00:01.0: vgaarb: setting as boot VGA device machine # [ 0.533717] pci 0000:00:01.0: vgaarb: bridge control possible machine # [ 0.533717] pci 0000:00:01.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none machine # [ 0.533725] vgaarb: loaded machine # [ 0.534470] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 machine # [ 0.534722] hpet0: 3 comparators, 64-bit 100.000000 MHz counter machine # [ 0.538813] clocksource: Switched to clocksource kvm-clock machine # [ 0.542353] VFS: Disk quotas dquot_6.6.0 machine # [ 0.543066] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) machine # [ 0.544420] pnp: PnP ACPI init machine # [ 0.545213] ACPI: IRQ 4 override to edge(!), high(!) machine # [ 0.546175] system 00:04: [mem 0xb0000000-0xbfffffff window] has been reserved machine # [ 0.547721] pnp: PnP ACPI: found 5 devices machine # [ 0.555356] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns machine # [ 0.556830] clocksource: Switched to clocksource acpi_pm machine # [ 0.557790] NET: Registered PF_INET protocol family machine # [ 0.558829] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear) machine # [ 0.576008] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear) machine # [ 0.577552] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) machine # [ 0.578885] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear) machine # [ 0.580222] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear) machine # [ 0.581454] TCP: Hash tables configured (established 8192 bind 8192) machine # [ 0.582555] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear) machine # [ 0.583818] UDP hash table entries: 512 (order: 3, 32768 bytes, linear) machine # [ 0.584950] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear) machine # [ 0.586160] NET: Registered PF_UNIX/PF_LOCAL protocol family machine # [ 0.587134] NET: Registered PF_XDP protocol family machine # [ 0.587977] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] machine # [ 0.589020] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] machine # [ 0.590054] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] machine # [ 0.591196] pci_bus 0000:00: resource 7 [mem 0x40000000-0xafffffff window] machine # [ 0.592312] pci_bus 0000:00: resource 8 [mem 0xc0000000-0xfebfffff window] machine # [ 0.593432] pci_bus 0000:00: resource 9 [mem 0x100000000-0x8ffffffff window] machine # [ 0.595135] ACPI: \_SB_.GSIA: Enabled at IRQ 16 machine # [ 0.597725] ACPI: \_SB_.GSIB: Enabled at IRQ 17 machine # [ 0.599635] ACPI: \_SB_.GSIC: Enabled at IRQ 18 machine # [ 0.601627] ACPI: \_SB_.GSID: Enabled at IRQ 19 machine # [ 0.603283] PCI: CLS 0 bytes, default 64 machine # [ 0.604207] Trying to unpack rootfs image as initramfs... machine # [ 0.608348] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x229842dd0bd, max_idle_ns: 440795319571 ns machine # [ 0.649509] Initialise system trusted keyrings machine # [ 0.652147] workingset: timestamp_bits=40 max_order=18 bucket_order=0 machine # [ 0.671026] Key type asymmetric registered machine # [ 0.674104] Asymmetric key parser 'x509' registered machine # [ 0.674963] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 248) machine # [ 0.678209] io scheduler mq-deadline registered machine # [ 0.678985] io scheduler kyber registered machine # [ 0.682652] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled machine # [ 0.683945] 00:03: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A machine # [ 0.687862] Linux agpgart interface v0.103 machine # [ 0.688646] ACPI: bus type drm_connector registered machine # [ 0.691518] usbcore: registered new interface driver usbserial_generic machine # [ 0.692621] usbserial: USB Serial support registered for generic machine # [ 0.696105] amd_pstate: The CPPC feature is supported but currently disabled by the BIOS. machine # [ 0.696105] Please enable it if your BIOS has the CPPC option. machine # [ 0.698355] amd_pstate: the _CPC object is not present in SBIOS or ACPI disabled machine # [ 0.702214] drop_monitor: Initializing network drop monitor service machine # [ 0.703403] NET: Registered PF_INET6 protocol family machine # [ 0.706591] Segment Routing with IPv6 machine # [ 0.709128] In-situ OAM (IOAM) with IPv6 machine # [ 0.710180] IPI shorthand broadcast: enabled machine # [ 0.718362] sched_clock: Marking stable (574013733, 144078604)->(797675691, -79583354) machine # [ 0.723352] registered taskstats version 1 machine # [ 0.724323] Loading compiled-in X.509 certificates machine # [ 0.743109] Demotion targets for Node 0: null machine # [ 0.743964] Key type .fscrypt registered machine # [ 0.744666] Key type fscrypt-provisioning registered machine # [ 0.748207] ima: No TPM chip found, activating TPM-bypass! machine # [ 0.749156] ima: Allocated hash algorithm: sha1 machine # [ 0.749941] ima: No architecture policies found machine # [ 0.752268] PM: Magic number: 14:202:815 machine # [ 0.753848] RAS: Correctable Errors collector initialized. machine # [ 0.762832] clk: Disabling unused clocks machine # [ 0.766104] PM: genpd: Disabling unused power domains machine # [ 0.933928] Freeing initrd memory: 29208K machine # [ 0.937176] Freeing unused decrypted memory: 2028K machine # [ 0.939880] Freeing unused kernel image (initmem) memory: 3656K machine # [ 0.940970] Write protecting the kernel read-only data: 32768k machine # [ 0.942287] Freeing unused kernel image (text/rodata gap) memory: 308K machine # [ 0.943771] Freeing unused kernel image (rodata/data gap) memory: 696K machine # [ 0.994407] x86/mm: Checked W+X mappings: passed, no W+X pages found. machine # [ 0.995487] Run /init as init process machine # [ 1.006467] systemd[1]: Inserted module 'autofs4' machine # [ 1.026167] fuse: init (API version 7.45) machine # [ 1.033418] ACPI: \_SB_.GSIG: Enabled at IRQ 22 machine # [ 1.036209] ACPI: \_SB_.GSIH: Enabled at IRQ 23 machine # [ 1.039649] ACPI: \_SB_.GSIE: Enabled at IRQ 20 machine # [ 1.041873] ACPI: \_SB_.GSIF: Enabled at IRQ 21 machine # [ 1.047147] virtiofs virtio5: discovered new tag: nix-store machine # [ 1.048609] virtiofs virtio5: virtio_fs_setup_dax: No cache capability machine # [ 1.055791] virtiofs virtio6: discovered new tag: shared machine # [ 1.057380] virtiofs virtio6: virtio_fs_setup_dax: No cache capability machine # [ 1.060892] virtiofs virtio7: discovered new tag: xchg machine # [ 1.062327] virtiofs virtio7: virtio_fs_setup_dax: No cache capability machine # [ 1.085228] systemd[1]: Successfully made /usr/ read-only. machine # [ 1.087000] systemd[1]: systemd 263-889bc48 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.091961] systemd[1]: Detected virtualization kvm. machine # [ 1.092839] systemd[1]: Detected architecture x86-64. machine # [ 1.093710] systemd[1]: Running in initrd. machine # [ 1.094717] systemd[1]: Initializing machine ID from random generator. machine # [ 1.095895] systemd[1]: Hostname set to . machine # [ 1.168796] systemd[1]: bpf-restrict-fs: LSM BPF program attached machine # [ 1.206334] systemd[1]: Queued start job for default target Initrd Default Target. machine # [ 1.210434] systemd[1]: Created slice Slice /system/modprobe. machine # [ 1.211593] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. machine # [ 1.212995] systemd[1]: Expecting device /dev/disk/by-label/nixos... machine # [ 1.214130] systemd[1]: Reached target Path Units. machine # [ 1.215014] systemd[1]: Reached target Slice Units. machine # [ 1.215899] systemd[1]: Reached target Swaps. machine # [ 1.216689] systemd[1]: Reached target Timer Units. machine # [ 1.217664] systemd[1]: Listening on D-Bus System Message Bus Socket. machine # [ 1.218904] systemd[1]: Listening on Journal Socket (/dev/log). machine # [ 1.220057] systemd[1]: Listening on Journal Sockets. machine # [ 1.221037] systemd[1]: Listening on udev Kernel Socket. machine # [ 1.221980] systemd[1]: Reached target Socket Units. machine # [ 1.223774] systemd[1]: Starting Create List of Static Device Nodes... machine # [ 1.228166] systemd[1]: Starting Load Kernel Module configfs... machine # [ 1.237759] systemd[1]: Starting Journal Service... machine # [ 1.248195] systemd[1]: Starting Load Kernel Modules... machine # [ 1.264262] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 1.268995] systemd[1]: Starting Coldplug All udev Devices... machine # [ 1.286194] systemd[1]: Finished Create List of Static Device Nodes. machine # [ 1.292255] systemd[1]: modprobe@configfs.service: Deactivated successfully. machine # [ 1.297414] systemd[1]: Finished Load Kernel Module configfs. machine # [ 1.303842] systemd[1]: Kernel Configuration File System skipped, unmet condition check ConditionPathExists=/sys/kernel/config machine # [ 1.306789] systemd-journald[65]: Collecting audit messages is disabled. machine # [ 1.315189] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... machine # [ 1.326992] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. machine # [ 1.337496] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev machine # [ 1.366753] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. machine # [ 1.376400] systemd[1]: Starting Create Static Device Nodes in /dev... machine # [ 1.386231] systemd[1]: Finished Load Kernel Modules. machine # [ 1.398192] systemd[1]: Starting Apply Kernel Variables... machine # [ 1.422667] systemd[1]: Finished Create Static Device Nodes in /dev. machine # [ 1.427359] systemd[1]: Reached target Preparation for Local File Systems. machine # [ 1.432897] systemd[1]: Reached target Local File Systems. machine # [ 1.286643] systemd-modules-load[66]: Inserted module 'dm_mod' machine # [ 1.292048] systemd-modules-load[66]: Inserted module 'virtio_balloon' machine # [ 1.293118] systemd-modules-load[66]: Inserted module 'virtio_gpu' machine # [ 1.440309] systemd[1]: Starting Rule-based Manager for Device Events and Files... machine # [ 1.447364] systemd[1]: Started Journal Service. machine # [ 1.309846] systemd[1]: Finished Apply Kernel Variables. machine # [ 1.323463] systemd[1]: Starting Create System Files and Directories... machine # [ 1.353828] systemd[1]: Finished Create System Files and Directories. machine # [ 1.365377] systemd-udevd[72]: Using default interface naming scheme 'v261'. machine # [ 1.388157] systemd[1]: Started Rule-based Manager for Device Events and Files. machine # [ 1.438202] systemd[1]: Finished Coldplug All udev Devices. machine # [ 1.439046] systemd[1]: Reached target System Initialization. machine # [ 1.439811] systemd[1]: Reached target Basic System. machine # [ 1.776316] virtio_blk virtio2: 1/0/0 default/read/poll queues machine # [ 1.778018] virtio_blk virtio2: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) machine # [ 1.780262] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 machine # [ 1.786814] serio: i8042 KBD port at 0x60,0x64 irq 1 machine # [ 1.792358] ehci-pci 0000:00:1d.7: EHCI Host Controller machine # [ 1.793061] ehci-pci 0000:00:1d.7: new USB bus registered, assigned bus number 1 machine # [ 1.794824] ehci-pci 0000:00:1d.7: irq 19, io mem 0xfebdb000 machine # [ 1.801127] serio: i8042 AUX port at 0x60,0x64 irq 12 machine # [ 1.804121] ehci-pci 0000:00:1d.7: USB 2.0 started, EHCI 1.00 machine # [ 1.804970] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 6.18 machine # [ 1.806108] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 machine # [ 1.807054] usb usb1: Product: EHCI Host Controller machine # [ 1.808690] usb usb1: Manufacturer: Linux 6.18.54 ehci_hcd machine # [ 1.810568] usb usb1: SerialNumber: 0000:00:1d.7 machine # [ 1.813260] hub 1-0:1.0: USB hub found machine # [ 1.813814] hub 1-0:1.0: 6 ports detected machine # [ 1.817923] uhci_hcd 0000:00:1d.0: UHCI Host Controller machine # [ 1.818644] uhci_hcd 0000:00:1d.0: new USB bus registered, assigned bus number 2 machine # [ 1.830126] uhci_hcd 0000:00:1d.0: detected 2 ports machine # [ 1.830891] uhci_hcd 0000:00:1d.0: irq 16, io port 0x0000c180 machine # [ 1.841699] usb usb2: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.18 machine # [ 1.852612] usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=1 machine # [ 1.860848] usb usb2: Product: UHCI Host Controller machine # [ 1.861963] usb usb2: Manufacturer: Linux 6.18.54 uhci_hcd machine # [ 1.864097] usb usb2: SerialNumber: 0000:00:1d.0 machine # [ 1.873502] hub 2-0:1.0: USB hub found machine # [ 1.877411] hub 2-0:1.0: 2 ports detected machine # [ 1.741085] systemd[1]: Starting Virtual Console Setup... machine # [ 1.907155] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input0 machine # [ 1.912228] uhci_hcd 0000:00:1d.1: UHCI Host Controller machine # [ 1.912934] uhci_hcd 0000:00:1d.1: new USB bus registered, assigned bus number 3 machine # [ 1.917518] SCSI subsystem initialized machine # [ 1.778314] systemd-vconsole-setup[96]: Configuration of first virtual console was skipped, ignoring remaining ones. machine # [ 1.781273] systemd[1]: Finished Virtual Console Setup. machine # [ 1.782717] (udev-worker)[86]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. machine # [ 1.785217] (udev-worker)[86]: Network interface NamePolicy= disabled on kernel command line. machine # [ 1.936424] uhci_hcd 0000:00:1d.1: detected 2 ports machine # [ 1.941229] uhci_hcd 0000:00:1d.1: irq 17, io port 0x0000c1a0 machine # [ 1.950298] usb usb3: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.18 machine # [ 1.951506] usb usb3: New USB device strings: Mfr=3, Product=2, SerialNumber=1 machine # [ 1.821419] systemd[1]: Found device /dev/disk/by-label/nixos. machine # [ 1.822517] systemd[1]: Reached target Initrd Root Device. machine # [ 1.968155] usb usb3: Product: UHCI Host Controller machine # [ 1.968852] usb usb3: Manufacturer: Linux 6.18.54 uhci_hcd machine # [ 1.826146] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos... machine # [ 1.972274] usb usb3: SerialNumber: 0000:00:1d.1 machine # [ 1.977261] hub 3-0:1.0: USB hub found machine # [ 1.977953] hub 3-0:1.0: 2 ports detected machine # [ 1.988198] uhci_hcd 0000:00:1d.2: UHCI Host Controller machine # [ 1.988903] uhci_hcd 0000:00:1d.2: new USB bus registered, assigned bus number 4 machine # [ 1.995337] uhci_hcd 0000:00:1d.2: detected 2 ports machine # [ 1.996670] uhci_hcd 0000:00:1d.2: irq 18, io port 0x0000c1c0 machine # [ 1.999377] usb usb4: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.18 machine # [ 2.002126] usb usb4: New USB device strings: Mfr=3, Product=2, SerialNumber=1 machine # [ 2.004130] usb usb4: Product: UHCI Host Controller machine # [ 2.004863] usb usb4: Manufacturer: Linux 6.18.54 uhci_hcd machine # [ 2.007160] usb usb4: SerialNumber: 0000:00:1d.2 machine # [ 2.009374] hub 4-0:1.0: USB hub found machine # [ 2.011393] hub 4-0:1.0: 2 ports detected machine # [ 1.872769] systemd-fsck[103]: nixos: clean, 12/65536 files, 13019/262144 blocks machine # [ 1.878477] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos. machine # [ 2.056117] usb 1-1: new high-speed USB device number 2 using ehci-pci machine # [ 2.058276] ahci 0000:00:1f.2: AHCI vers 0001.0000, 32 command slots, 1.5 Gbps, SATA mode machine # [ 2.059351] ahci 0000:00:1f.2: 6/6 ports implemented (port mask 0x3f) machine # [ 2.060754] ahci 0000:00:1f.2: flags: 64bit ncq only machine # [ 2.064732] scsi host0: ahci machine # [ 2.066614] scsi host1: ahci machine # [ 2.068004] scsi host2: ahci machine # [ 2.069931] scsi host3: ahci machine # [ 2.071513] scsi host4: ahci machine # [ 2.073262] scsi host5: ahci machine # [ 2.073839] ata1: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc100 irq 47 lpm-pol 1 machine # [ 2.076122] ata2: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc180 irq 47 lpm-pol 1 machine # [ 2.077356] ata3: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc200 irq 47 lpm-pol 1 machine # [ 2.078637] ata4: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc280 irq 47 lpm-pol 1 machine # [ 2.080176] ata5: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc300 irq 47 lpm-pol 1 machine # [ 2.081447] ata6: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc380 irq 47 lpm-pol 1 machine # [ 2.185667] usb 1-1: New USB device found, idVendor=0627, idProduct=0001, bcdDevice= 0.00 machine # [ 2.188571] usb 1-1: New USB device strings: Mfr=1, Product=3, SerialNumber=10 machine # [ 2.191813] usb 1-1: Product: QEMU USB Tablet machine # [ 2.193599] usb 1-1: Manufacturer: QEMU machine # [ 2.195214] usb 1-1: SerialNumber: 28754-0000:00:1d.7-1 machine # [ 2.228915] hid: raw HID events driver (C) Jiri Kosina machine # [ 2.135322] systemd[1]: Mounting /sysroot... machine # [ 2.393158] ata1: SATA link down (SStatus 0 SControl 300) machine # [ 2.395450] ata5: SATA link down (SStatus 0 SControl 300) machine # [ 2.397917] ata2: SATA link down (SStatus 0 SControl 300) machine # [ 2.400272] ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 300) machine # [ 2.402446] ata3.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/100 machine # [ 2.404613] ata3.00: applying bridge limits machine # [ 2.406609] ata4: SATA link down (SStatus 0 SControl 300) machine # [ 2.408944] ata6: SATA link down (SStatus 0 SControl 300) machine # [ 2.411166] ata3.00: configured for UDMA/100 machine # [ 2.413527] scsi 2:0:0:0: CD-ROM QEMU QEMU DVD-ROM 2.5+ PQ: 0 ANSI: 5 machine # [ 2.486391] usbcore: registered new interface driver usbhid machine # [ 2.491554] usbhid: USB HID core driver machine # [ 2.511251] sr 2:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray machine # [ 2.519331] 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.522389] 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.526643] cdrom: Uniform CD-ROM driver Revision: 3.20 machine # [ 2.540757] EXT4-fs (vda): mounted filesystem 7edbc775-d923-46d0-ad5b-f74c60eda9a1 r/w with ordered data mode. Quota mode: none. machine # [ 2.403297] systemd[1]: Mounted /sysroot. machine # [ 2.405527] systemd[1]: Reached target Initrd Root File System. machine # [ 2.410054] systemd[1]: Mounting /sysroot/nix/.ro-store... machine # [ 2.415840] systemd[1]: Mounting /sysroot/nix/.rw-store... machine # [ 2.423137] systemd[1]: Mounting /sysroot/run... machine # [ 2.425731] systemd[1]: Mounting /sysroot/tmp/shared... machine # [ 2.437137] systemd[1]: Mounting /sysroot/tmp/xchg... machine # [ 2.446064] systemd[1]: Starting Mountpoints Configured in the Real Root... machine # [ 2.474468] systemd-sysroot-fstab-check[145]: /sysroot should be mounted in the initrd, will request daemon-reload. machine # [ 2.489799] systemd[1]: Mounted /sysroot/nix/.ro-store. machine # [ 2.496161] systemd[1]: Mounted /sysroot/nix/.rw-store. machine # [ 2.496972] systemd[1]: Mounted /sysroot/run. machine # [ 2.498109] systemd[1]: Mounted /sysroot/tmp/shared. machine # [ 2.501256] systemd[1]: Mounted /sysroot/tmp/xchg. machine # [ 2.505933] systemd[1]: Reload requested from client PID 145 ('systemd-sysroot') (unit initrd-parse-etc.service)... machine # [ 2.507423] systemd[1]: Reloading... machine # [ 2.566661] systemd[1]: Reloading finished in 58 ms. machine # [ 2.574992] systemd-sysroot-fstab-check[145]: Requesting initrd-fs.target/start/replace... machine # [ 2.578076] systemd-sysroot-fstab-check[145]: Requesting swap.target/start/replace... machine # [ 2.579500] systemd[1]: Starting rw-sysroot-nix-store.service... machine # [ 2.582665] systemd[1]: initrd-parse-etc.service: Deactivated successfully. machine # [ 2.585482] systemd[1]: Finished Mountpoints Configured in the Real Root. machine # [ 2.587141] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies. machine # [ 2.597645] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. machine # [ 2.599190] systemd[1]: Finished rw-sysroot-nix-store.service. machine # [ 3.136532] systemd[1]: Mounting /sysroot/nix/store... machine # [ 3.186190] systemd[1]: Mounted /sysroot/nix/store. machine # [ 3.187597] systemd[1]: Reached target Initrd File Systems. machine # [ 3.190073] systemd[1]: Starting Find NixOS closure... machine # [ 3.192509] systemd[1]: Starting Create Volatile Files and Directories in the Real Root... machine # [ 3.213066] systemd[1]: Finished Create Volatile Files and Directories in the Real Root. machine # [ 3.216744] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully. machine # [ 3.222893] systemd[1]: Finished Find NixOS closure. machine # [ 3.224174] systemd[1]: Reached target Initrd Default Target. machine # [ 3.225767] systemd[1]: Starting Cleaning Up and Shutting Down Daemons... machine # [ 3.238860] systemd[1]: Stopped target Initrd Default Target. machine # [ 3.240184] systemd[1]: Stopped target Basic System. machine # [ 3.242267] systemd[1]: Stopped target Initrd Root Device. machine # [ 3.243041] systemd[1]: Stopped target Path Units. machine # [ 3.243731] systemd[1]: systemd-ask-password-console.path: Deactivated successfully. machine # [ 3.244690] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch. machine # [ 3.245724] systemd[1]: Stopped target Slice Units. machine # [ 3.246467] systemd[1]: Stopped target Socket Units. machine # [ 3.247159] systemd[1]: Stopped target System Initialization. machine # [ 3.247915] systemd[1]: Stopped target Swaps. machine # [ 3.248733] systemd[1]: Stopped target Timer Units. machine # [ 3.250141] systemd[1]: dbus.socket: Deactivated successfully. machine # [ 3.250918] systemd[1]: Closed D-Bus System Message Bus Socket. machine # [ 3.251717] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully. machine # [ 3.252857] systemd[1]: Stopped Find NixOS closure. machine # [ 3.255108] systemd[1]: Starting rw-sysroot-nix-store.service... machine # [ 3.255990] systemd[1]: systemd-sysctl.service: Deactivated successfully. machine # [ 3.257205] systemd[1]: Stopped Apply Kernel Variables. machine # [ 3.258945] systemd[1]: systemd-modules-load.service: Deactivated successfully. machine # [ 3.259891] systemd[1]: Stopped Load Kernel Modules. machine # [ 3.261290] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully. machine # [ 3.262894] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root. machine # [ 3.263948] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. machine # [ 3.264966] systemd[1]: Stopped Create System Files and Directories. machine # [ 3.267111] systemd[1]: Stopped target Local File Systems. machine # [ 3.267839] systemd[1]: Stopped target Preparation for Local File Systems. machine # [ 3.269767] systemd[1]: systemd-udev-trigger.service: Deactivated successfully. machine # [ 3.270768] systemd[1]: Stopped Coldplug All udev Devices. machine # [ 3.273506] systemd[1]: Stopping Rule-based Manager for Device Events and Files... machine # [ 3.274505] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. machine # [ 3.275502] systemd[1]: Stopped Virtual Console Setup. machine # [ 3.283491] systemd[1]: initrd-cleanup.service: Deactivated successfully. machine # [ 3.287108] systemd[1]: Finished Cleaning Up and Shutting Down Daemons. machine # [ 3.289961] systemd[1]: systemd-udevd.service: Deactivated successfully. machine # [ 3.293148] systemd[1]: Stopped Rule-based Manager for Device Events and Files. machine # [ 3.296972] systemd[1]: Starting Cleanup udev Database... machine # [ 3.297841] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. machine # [ 3.298946] systemd[1]: Stopped Create Static Device Nodes in /dev. machine # [ 3.300159] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. machine # [ 3.302157] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully. machine # [ 3.303199] systemd[1]: kmod-static-nodes.service: Deactivated successfully. machine # [ 3.304204] systemd[1]: Stopped Create List of Static Device Nodes. machine # [ 3.305042] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. machine # [ 3.307119] systemd[1]: Finished rw-sysroot-nix-store.service. machine # [ 3.322930] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. machine # [ 3.324158] systemd[1]: Finished Cleanup udev Database. machine # [ 3.325477] systemd[1]: Reached target Switch Root. machine # [ 3.327091] systemd[1]: Starting NixOS Activation... machine # [ 3.399701] initrd-nixos-activation-start[190]: booting system configuration /nix/store/jl59xgshkm15yy4qkh11f2517r2vlwz8-nixos-system-machine-test machine # [ 3.427542] initrd-nixos-activation-start[190]: running activation script... machine # [ 3.633982] initrd-nixos-activation-start[213]: setting up /etc... machine # [ 3.741295] systemd[1]: initrd-nixos-activation.service: Deactivated successfully. machine # [ 3.743136] systemd[1]: Finished NixOS Activation. machine # [ 3.745328] systemd[1]: Starting Switch Root... machine # [ 3.760728] systemd[1]: Switching root. machine # [ 4.031735] systemd-journald[65]: Received SIGTERM from PID 1 (systemd). machine # [ 4.113559] NET: Registered PF_VSOCK protocol family machine # [ 4.138384] systemd[1]: systemd 263-889bc48 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 # [ 4.142410] systemd[1]: Detected virtualization kvm. machine # [ 4.143172] systemd[1]: Detected architecture x86-64. machine # [ 4.143923] systemd[1]: Detected first boot. machine # [ 4.145467] systemd[1]: Initializing machine ID from random generator. machine # [ 4.233193] systemd[1]: bpf-restrict-fs: LSM BPF program attached machine # [ 4.323329] systemd[1]: Applying preset policy. machine # [ 4.497784] systemd[1]: Populated /etc with preset unit settings. machine # [ 4.646832] systemd[1]: initrd-switch-root.service: Deactivated successfully. machine # [ 4.648199] systemd[1]: Stopped initrd-switch-root.service. machine # [ 4.650488] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. machine # [ 4.652522] systemd[1]: Created slice Slice /system/getty. machine # [ 4.653840] systemd[1]: Created slice User and Session Slice. machine # [ 4.654737] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. machine # [ 4.655907] systemd[1]: Started Forward Password Requests to Wall Directory Watch. machine # [ 4.657263] systemd[1]: Expecting device /dev/hvc0... machine # [ 4.657961] systemd[1]: Expecting device /dev/ttyS0... machine # [ 4.658727] systemd[1]: Reached target Local Encrypted Volumes. machine # [ 4.659531] systemd[1]: Stopped target initrd-fs.target. machine # [ 4.660266] systemd[1]: Stopped target initrd-root-fs.target. machine # [ 4.661019] systemd[1]: Stopped target initrd-switch-root.target. machine # [ 4.661847] systemd[1]: Reached target Virtual Machines and Containers. machine # [ 4.662734] systemd[1]: Reached target Path Units. machine # [ 4.663419] systemd[1]: Reached target Remote File Systems. machine # [ 4.664184] systemd[1]: Reached target Slice Units. machine # [ 4.664868] systemd[1]: Reached target Swaps. machine # [ 4.666328] systemd[1]: Listening on Query the User Interactively for a Password. machine # [ 4.679767] systemd[1]: Listening on Process Core Dump Socket. machine # [ 4.681297] systemd[1]: Listening on Credential Encryption/Decryption. machine # [ 4.682831] systemd[1]: Listening on Factory Reset Management. machine # [ 4.683747] systemd[1]: Listening on Hostname Service Socket. machine # [ 4.686365] systemd[1]: Starting Journal Log Access Socket... machine # [ 4.687521] systemd[1]: Listening on Journal Audit Socket. machine # [ 4.689952] systemd[1]: Listening on Console Output Muting Service Socket. machine # [ 4.691038] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket. machine # [ 4.692144] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 4.693411] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 4.696724] systemd[1]: Listening on Disk Repartitioning Service Socket. machine # [ 4.697747] systemd[1]: Listening on udev Varlink Socket. machine # [ 4.699970] systemd[1]: Mounting Huge Pages File System... machine # [ 4.703312] systemd[1]: Mounting POSIX Message Queue File System... machine # [ 4.709355] systemd[1]: Mounting Kernel Debug File System... machine # [ 4.716778] systemd[1]: Mounting Kernel Trace File System... machine # [ 4.725329] systemd[1]: Starting Create List of Static Device Nodes... machine # [ 4.735498] systemd[1]: Starting Load Kernel Module configfs... machine # [ 4.740265] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm machine # [ 4.752453] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 4.762564] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse machine # [ 4.778056] systemd[1]: Mounting FUSE Control File System... machine # [ 4.779798] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 4.795405] systemd[1]: Starting Journal Service... machine # [ 4.802777] systemd[1]: Starting Load Kernel Modules... machine # [ 4.813452] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer... machine # [ 4.826256] systemd[1]: Starting Remount Root and Kernel File Systems... machine # [ 4.830187] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 4.837911] systemd[1]: Starting Coldplug All udev Devices... machine # [ 4.851824] systemd-journald[284]: Collecting audit messages is enabled. machine # [ 4.854181] systemd[1]: Listening on Journal Log Access Socket. machine # [ 4.859143] systemd[1]: Mounted Huge Pages File System. machine # [ 4.860052] systemd[1]: Mounted POSIX Message Queue File System. machine # [ 4.866277] systemd[1]: Mounted Kernel Debug File System. machine # [ 4.870767] systemd[1]: Mounted Kernel Trace File System. machine # [ 4.731857] systemd[1]: Queued start job for default target Multi-User System. machine # [ 4.736390] systemd[1]: systemd-journald.service: Deactivated successfully. machine # [ 4.885328] systemd[1]: Started Journal Service. machine # [ 4.893268] loop: module loaded machine # [ 4.750544] systemd-modules-load[285]: Inserted module 'loop' machine # [ 4.752113] systemd[1]: Finished Create List of Static Device Nodes. machine # [ 4.755134] systemd[1]: modprobe@configfs.service: Deactivated successfully. machine # [ 4.757108] systemd[1]: Finished Load Kernel Module configfs. machine # [ 4.757944] systemd[1]: Mounted FUSE Control File System. machine # [ 4.769926] systemd[1]: Finished Load Kernel Modules. machine # [ 4.775290] systemd[1]: Mounting Kernel Configuration File System... machine # [ 4.783487] systemd[1]: Starting Firewall... machine # [ 4.928165] EXT4-fs (vda): re-mounted 7edbc775-d923-46d0-ad5b-f74c60eda9a1. machine # [ 4.792646] systemd[1]: Starting Apply Kernel Variables... machine # [ 4.809100] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... machine # [ 4.819075] systemd[1]: Finished Remount Root and Kernel File Systems. machine # [ 4.825470] systemd[1]: Listening on Disk Image Download Service Socket. machine # [ 4.829336] systemd-oomd[286]: No swap; memory pressure usage will be degraded machine # [ 4.842104] systemd[1]: Starting Flush Journal to Persistent Storage... machine # [ 4.843116] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 4.860140] systemd[1]: Starting Load/Save OS Random Seed... machine # [ 4.860972] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 4.868253] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer. machine # [ 4.917758] systemd[1]: Mounted Kernel Configuration File System. machine # [ 5.065145] systemd-journald[284]: Received client request to flush runtime journal. machine # [ 5.003894] systemd[1]: Finished Apply Kernel Variables. machine # [ 5.006799] systemd[1]: Finished Load/Save OS Random Seed. machine # [ 5.009751] systemd[1]: Reached target First Boot Complete. machine # [ 5.011342] systemd[1]: Finished Flush Journal to Persistent Storage. machine # [ 5.023115] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. machine # [ 5.030548] systemd[1]: Starting Create Static Device Nodes in /dev... machine # [ 5.115449] systemd[1]: Finished Coldplug All udev Devices. machine # [ 5.125192] systemd[1]: Finished Create Static Device Nodes in /dev. machine # [ 5.127248] systemd[1]: Reached target Preparation for Local File Systems. machine # [ 5.129569] systemd[1]: Starting Rule-based Manager for Device Events and Files... machine # [ 5.173253] systemd-udevd[326]: Using default interface naming scheme 'v261'. machine # [ 5.213188] systemd[1]: Started Rule-based Manager for Device Events and Files. machine # [ 5.326096] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse machine # [ 5.407492] systemd[1]: Condition check resulted in /dev/hvc0 being skipped. machine # [ 5.421070] systemd[1]: Condition check resulted in /dev/ttyS0 being skipped. machine # [ 5.471368] (udev-worker)[348]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. machine # [ 5.473677] (udev-worker)[348]: Network interface NamePolicy= disabled on kernel command line. machine # [ 5.507368] systemd[1]: Mounting /run/wrappers... machine # [ 5.545981] systemd[1]: Mounted /run/wrappers. machine # [ 5.546718] systemd[1]: Reached target Local File Systems. machine # [ 5.551111] systemd[1]: Listening on Boot Loader Control Service Socket. machine # [ 5.556079] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 5.556863] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 5.559733] systemd[1]: Starting Save Transient machine-id to Disk... machine # [ 5.569033] systemd[1]: Starting Create System Files and Directories... machine # [ 5.692493] systemd[1]: Finished Create System Files and Directories. machine # [ 5.701416] systemd[1]: Starting Rebuild Journal Catalog... machine # [ 5.708759] systemd[1]: Starting Record System Boot/Shutdown in UTMP... machine # [ 5.716892] systemd[1]: Condition check resulted in Virtio network device being skipped. machine # [ 5.718255] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 5.719814] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 5.722625] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 5.724639] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 5.726249] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 5.727399] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 5.791884] systemd[1]: etc-machine\x2did.mount: Deactivated successfully. machine # [ 5.799891] systemd[1]: Finished Save Transient machine-id to Disk. machine # [ 5.812530] systemd[1]: Finished Record System Boot/Shutdown in UTMP. machine # [ 5.828133] systemd[1]: Finished Rebuild Journal Catalog. machine # [ 5.833175] systemd[1]: Starting Update is Completed... machine # [ 5.876096] systemd[1]: Finished Update is Completed. machine # [ 6.064248] bochs-drm 0000:00:01.0: vgaarb: deactivate vga console machine # [ 6.007446] systemd[1]: Finished Firewall. machine # [ 6.010100] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 6.012153] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 6.013064] systemd[1]: Reached target System Initialization. machine # [ 6.016181] systemd[1]: Started Discard unused filesystem blocks once a week. machine # [ 6.017239] systemd[1]: Started Daily Cleanup of Temporary Directories. machine # [ 6.018271] systemd[1]: Reached target Timer Units. machine # [ 6.019030] systemd[1]: Listening on D-Bus System Message Bus Socket. machine # [ 6.020345] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket. machine # [ 6.023163] systemd[1]: Reached target Socket Units. machine # [ 6.023867] systemd[1]: Reached target Basic System. machine # [ 6.024910] systemd[1]: Started backdoor.service. machine # [ 6.028092] systemd[1]: Starting Import lastlog data into lastlog2 database... machine # [ 6.040036] systemd[1]: Starting Name Service Cache Daemon (nsncd)... machine # [ 6.046180] systemd[1]: Starting Post-Boot Actions... machine # [ 6.059787] systemd[1]: Started Reset console on configuration changes. machine # [ 6.072281] systemd[1]: Starting resolvconf update... machine # [ 6.105223] systemd[1]: Starting D-Bus System Message Bus... machine # [ 6.075481] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input3 machine # [ 6.088927] ACPI: button: Power Button [PWRF] machine # connecting to host... machine # [ 6.219965] systemd[1]: Finished Post-Boot Actions. machine: Guest shell says: b'Spawning backdoor root shell...\n' machine: connected to guest root shell machine: (connecting took 6.95 seconds) machine # [ 6.224505] nsncd[494]: Oct 01 03:48:57.516 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" machine: (finished: waiting for the VM to finish booting, in 7.39 seconds) machine # [ 6.230687] systemd[1]: Started Name Service Cache Daemon (nsncd). machine # [ 6.239982] systemd[1]: Reached target Host and Network Name Lookups. machine # [ 6.250729] systemd[1]: Reached target User and Group Name Lookups. machine # [ 6.253056] systemd[1]: Starting User Login Management... machine # [ 6.255311] systemd[1]: Finished Import lastlog data into lastlog2 database. machine # [ 6.106965] mousedev: PS/2 mouse device common for all mice machine # [ 6.123673] input: QEMU Virtio Keyboard as /devices/pci0000:00/0000:00:06.0/virtio4/input/input4 machine # [ 6.233570] rtc_cmos PNP0B00:00: RTC can wake from S4 machine # [ 6.312644] dbus-broker-launch[499]: Looking up NSS user entry for 'systemd-timesync'... machine # [ 6.318097] dbus-broker-launch[499]: NSS returned no entry for 'systemd-timesync' machine # [ 6.319106] dbus-broker-launch[499]: Invalid user-name in /nix/store/9nyy88lg4rwaal5mgwzsncpdv4j6ng88-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" machine # [ 6.284324] Console: switching to colour dummy device 80x25 machine # [ 6.312287] rtc_cmos PNP0B00:00: registered as rtc0 machine # [ 6.312358] rtc_cmos PNP0B00:00: setting system clock to 2026-10-01T03:48:57 UTC (1790826537) machine # [ 6.312439] rtc_cmos PNP0B00:00: alarms up to one day, y3k, 242 bytes nvram, hpet irqs machine # [ 6.313353] systemd-journald[284]: Time jumped backwards, rotating. machine # [ 6.367451] lpc_ich 0000:00:1f.0: I/O space for GPIO uninitialized machine # [ 6.390966] parport_pc 00:02: reported by Plug and Play ACPI machine # [ 6.391115] parport0: PC-style at 0x378, irq 7 [PCSPP(,...)] machine # [ 6.552536] [drm] Found bochs VGA, ID 0xb0c5. machine # [ 6.552538] [drm] Framebuffer size 16384 kB @ 0xfd000000, mmio @ 0xfebd0000. machine # [ 6.387516] dbus-broker-launch[499]: Ready machine # [ 6.411570] systemd-logind[519]: New seat seat0. machine # [ 6.561387] i801_smbus 0000:00:1f.3: SMBus using PCI interrupt machine # [ 6.562034] i2c i2c-0: Memory type 0x07 not supported yet, not instantiating SPD machine # [ 6.564412] bochs-drm 0000:00:01.0: [drm] Registered 1 planes with drm panic machine # [ 6.568276] [drm] Initialized bochs-drm 1.0.0 for 0000:00:01.0 on minor 0 machine # [ 6.447619] systemd[1]: Started D-Bus System Message Bus. machine # [ 6.448513] systemd[1]: Started User Login Management. machine # [ 6.604644] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input6 machine # [ 6.472453] systemd[1]: Stopped target Host and Network Name Lookups. machine # [ 6.474331] systemd[1]: Stopping Host and Network Name Lookups... machine # [ 6.475954] systemd[1]: Stopped target User and Group Name Lookups. machine # [ 6.476783] systemd[1]: Stopping User and Group Name Lookups... machine # [ 6.481651] systemd[1]: Starting linger-users.service... machine # [ 6.483744] systemd[1]: Stopping Name Service Cache Daemon (nsncd)... machine # [ 6.491299] systemd[1]: nscd.service: Deactivated successfully. machine # [ 6.494755] systemd[1]: Stopped Name Service Cache Daemon (nsncd). machine # [ 6.523205] systemd[1]: Starting Name Service Cache Daemon (nsncd)... machine # [ 6.579221] nsncd[587]: Oct 01 03:48:57.910 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" machine # [ 6.587838] systemd[1]: Started Name Service Cache Daemon (nsncd). machine # [ 6.588952] systemd[1]: Finished resolvconf update. machine # [ 6.614681] systemd[1]: Created slice Slice /user/1001. machine # [ 6.615628] systemd[1]: Reached target Preparation for Network. machine # [ 6.616840] systemd[1]: Reached target Host and Network Name Lookups. machine # [ 6.620119] systemd[1]: Reached target User and Group Name Lookups. machine # [ 6.611638] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input5 machine # [ 6.750567] Console: switching to colour frame buffer device 160x50 machine # [ 6.628350] systemd[1]: Starting DHCP Client... machine # [ 6.633637] systemd[1]: Starting Address configuration of eth1... machine # [ 6.638247] systemd[1]: Starting Extra networking commands.... machine # [ 6.785099] bochs-drm 0000:00:01.0: [drm] fb0: bochs-drmdrmfb frame buffer device machine # [ 6.653373] systemd[1]: Starting Virtual Console Setup... machine # [ 6.654144] systemd[1]: Starting User Runtime Directory /run/user/1001... machine # [ 6.671324] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 6.674173] systemd[1]: Finished linger-users.service. machine # [ 6.693185] systemd-logind[519]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard) machine # [ 6.694472] systemd-logind[519]: Watching system buttons on /dev/input/event2 (Power Button) machine # [ 6.742090] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. machine # [ 6.743119] systemd[1]: Stopped Virtual Console Setup. machine # [ 6.743777] systemd[1]: Starting Virtual Console Setup... machine # [ 6.753734] systemd-logind[519]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard) machine # [ 6.921884] ppdev: user-space parallel port driver machine # [ 6.935899] iTCO_wdt iTCO_wdt.1.auto: Found a ICH9 TCO device (Version=2, TCOBASE=0x0660) machine # [ 6.963795] iTCO_wdt iTCO_wdt.1.auto: initialized. heartbeat=30 sec (nowayout=0) machine # [ 6.851098] systemd[1]: Finished User Runtime Directory /run/user/1001. machine # [ 6.855236] systemd[1]: Starting User Manager for UID 1001... machine # [ 6.889076] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. machine # [ 6.891917] systemd[1]: Stopped Virtual Console Setup. machine # [ 6.901493] systemd[1]: Starting Virtual Console Setup... machine # [ 6.934426] (systemd)[621]: pam_unix(systemd-user:session): session opened for user usertest(uid=1001) by (uid=0) machine # [ 6.951569] systemd-logind[519]: New session '1' of user 'usertest' with class 'manager' and type 'unspecified'. machine # [ 6.989326] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 7.056307] network-addresses-eth1-start[608]: adding address 192.168.1.1/24... done machine # [ 7.074115] network-addresses-eth1-start[608]: adding address 2001:db8:1::1/64... done machine # [ 7.118296] systemd[1]: Finished Address configuration of eth1. machine # [ 7.187154] systemd[621]: Queued start job for default target Main User Target. machine # [ 7.191282] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 7.195143] systemd[621]: Created slice User Application Slice. machine # [ 7.195970] systemd[621]: Started Daily Cleanup of User's Temporary Directories. machine # [ 7.201171] systemd[621]: Reached target Paths. machine # [ 7.205245] systemd[621]: Reached target Timers. machine # [ 7.205934] systemd[621]: Starting D-Bus User Message Bus Socket... machine # [ 7.206790] systemd[621]: Starting Create User Files and Directories... machine # [ 7.226279] dhcpcd[629]: dhcpcd-10.3.2 starting machine # [ 7.240934] systemd[621]: Finished Create User Files and Directories. machine # [ 7.251304] dhcpcd[690]: dev: loaded udev machine # [ 7.408960] kvm_amd: TSC scaling supported machine # [ 7.409388] kvm_amd: Nested Virtualization enabled machine # [ 7.409832] kvm_amd: Nested Paging enabled machine # [ 7.410776] kvm_amd: LBR virtualization supported machine # [ 7.270120] systemd[621]: Listening on D-Bus User Message Bus Socket. machine # [ 7.270957] systemd[621]: Reached target Sockets. machine # [ 7.415688] kvm_amd: Virtual VMLOAD VMSAVE supported machine # [ 7.273785] systemd[621]: Reached target Basic System. machine # [ 7.276217] systemd[1]: Started User Manager for UID 1001. machine # [ 7.422390] kvm_amd: Virtual GIF supported machine # [ 7.422788] kvm_amd: Virtual NMI enabled machine # [ 7.282088] systemd[621]: Starting Run user-specific NixOS activation... machine # [ 7.432046] 8021q: 802.1Q VLAN Support v1.8 machine # [ 7.434241] 8021q: adding VLAN 0 to HW filter on device eth1 machine # [ 7.316838] systemd[1]: Finished Extra networking commands.. machine # [ 7.317936] systemd[1]: Reached target Network. machine # [ 7.331248] systemd[1]: Starting Permit User Sessions... machine # [ 7.332103] systemd[621]: Finished Run user-specific NixOS activation. machine # [ 7.336070] systemd[621]: Reached target Main User Target. machine # [ 7.336796] systemd[621]: Startup finished in 352ms. machine # [ 7.355366] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch. machine # [ 7.517473] EDAC MC: Ver: 3.0.0 machine # [ 7.408770] systemd[1]: Finished Permit User Sessions. machine # [ 7.421658] systemd[1]: Started Getty on tty1. machine # [ 7.422634] systemd[1]: Reached target Login Prompts. machine # [ 7.574537] cfg80211: Loading compiled-in X.509 certificates for regulatory database machine # [ 7.585452] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' machine # [ 7.586213] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600' machine # [ 7.588037] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -2 machine # [ 7.588867] cfg80211: failed to load regulatory.db machine # [ 7.616744] 8021q: adding VLAN 0 to HW filter on device eth0 machine # [ 7.473871] dhcpcd[690]: eth0: waiting for carrier machine # [ 7.476491] dhcpcd[690]: eth0: carrier acquired machine # [ 7.481519] dhcpcd[690]: DUID 00:01:00:01:32:50:94:aa:52:54:00:12:34:56 machine # [ 7.482685] dhcpcd[690]: eth0: IAID 00:12:34:56 machine # [ 7.483542] dhcpcd[690]: eth0: adding address fe80::5054:ff:fe12:3456 machine # [ 7.508322] systemd-vconsole-setup[625]: Configuration of first virtual console was skipped, ignoring remaining ones. machine # [ 7.512380] systemd[1]: Finished Virtual Console Setup. machine # [ 9.149988] dhcpcd[690]: eth0: soliciting a DHCP lease machine # [ 9.311209] NET: Registered PF_PACKET protocol family machine # [ 9.174196] dhcpcd[690]: eth0: offered 10.0.2.15 from 10.0.2.2 machine # [ 9.176440] dhcpcd[690]: eth0: probing address 10.0.2.15/24 machine # [ 9.204759] dhcpcd[690]: eth0: soliciting an IPv6 router machine # [ 9.206073] dhcpcd[690]: eth0: Router Advertisement from fe80::2 machine # [ 9.206900] dhcpcd[690]: eth0: adding address fec0::5054:ff:fe12:3456/64 machine # [ 9.208332] dhcpcd[690]: eth0: adding route to fec0::/64 machine # [ 9.209386] dhcpcd[690]: eth0: adding default route via fe80::2 machine # [ 13.859394] dhcpcd[690]: eth0: leased 10.0.2.15 for 86400 seconds machine # [ 13.861052] dhcpcd[690]: eth0: adding route to 10.0.2.0/24 machine # [ 13.861884] dhcpcd[690]: eth0: adding default route via 10.0.2.2 machine # [ 13.925285] systemd[1]: Started DHCP Client. machine # [ 13.927443] systemd[1]: Reached target Multi-User System. machine # [ 13.928844] systemd[1]: Startup finished in 854ms (kernel) + 3.091s (initrd) + 9.982s (userspace) = 13.928s. machine: (finished: waiting for unit multi-user.target, in 15.10 seconds) machine: must succeed: /nix/store/3vbcjh6yz1i6lp352svzp92f3jmjppg7-stderr-runner /nix/store/jl59xgshkm15yy4qkh11f2517r2vlwz8-nixos-system-machine-test/bin/switch-to-configuration test machine # Checking switch inhibitors... done machine # [ 14.095775] nixos[841]: switching to system configuration /nix/store/jl59xgshkm15yy4qkh11f2517r2vlwz8-nixos-system-machine-test machine # [ 14.098093] systemd[1]: Stopped target Local File Systems. machine # [ 14.099972] systemd[1]: Stopped target Remote File Systems. machine # activating the configuration... machine # setting up /etc... machine # [ 14.317708] systemd[1]: Reload requested from client PID 841 ('.switch-to-conf') (unit backdoor.service)... machine # [ 14.319361] systemd[1]: Reloading... machine # [ 14.553171] systemd[1]: Reloading finished in 232 ms. machine # reloading user units for usertest... machine # [ 14.583490] systemd[621]: Created slice User Core Session Slice. machine # [ 14.586066] systemd[621]: Starting D-Bus User Message Bus... machine # [ 14.609338] dbus-broker-launch[911]: Ignoring duplicate name 'org.freedesktop.import1' in service file '/nix/store/9nyy88lg4rwaal5mgwzsncpdv4j6ng88-system-path/share/dbus-1/services/org.freedesktop.import1.service' machine # [ 14.611962] dbus-broker-launch[911]: Ignoring duplicate name 'org.freedesktop.machine1' in service file '/nix/store/9nyy88lg4rwaal5mgwzsncpdv4j6ng88-system-path/share/dbus-1/services/org.freedesktop.machine1.service' machine # [ 14.614493] dbus-broker-launch[911]: Ignoring duplicate name 'org.freedesktop.portable1' in service file '/nix/store/9nyy88lg4rwaal5mgwzsncpdv4j6ng88-system-path/share/dbus-1/services/org.freedesktop.portable1.service' machine # [ 14.617066] dbus-broker-launch[911]: Ignoring duplicate name 'org.freedesktop.systemd1' in service file '/nix/store/9nyy88lg4rwaal5mgwzsncpdv4j6ng88-system-path/share/dbus-1/services/org.freedesktop.systemd1.service' machine # [ 14.619692] dbus-broker-launch[911]: Policy to allow eavesdropping in /etc/dbus-1/session.conf +27: Eavesdropping is deprecated and ignored machine # [ 14.621214] dbus-broker-launch[911]: Policy to allow eavesdropping in /etc/dbus-1/session.conf +29: Eavesdropping is deprecated and ignored machine # [ 14.623237] systemd[621]: Started D-Bus User Message Bus. machine # [ 14.626616] dbus-broker-launch[911]: Ready machine # [ 14.664553] systemd[621]: Reexecution requested from client PID 910 ('switch-to-confi')... machine # [ 14.666391] systemd[621]: Reexecuting. machine # [ 14.684054] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 14.755427] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 14.760705] systemd[621]: Reload requested from client PID 910 ('switch-to-confi')... machine # [ 14.761864] systemd[621]: Reloading... machine # [ 14.832453] systemd[621]: Reloading finished in 69 ms. machine # [ 14.837847] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # restarting the following user units: nixos-activation.service machine # [ 14.844765] systemd[621]: Stopped Run user-specific NixOS activation. machine # [ 14.846672] systemd[621]: Stopping Run user-specific NixOS activation... machine # [ 14.848184] systemd[621]: Starting Run user-specific NixOS activation... machine # [ 14.866895] systemd[621]: Finished Run user-specific NixOS activation. machine # restarting sysinit-reactivation.target machine # [ 14.874783] systemd[1]: Starting Re-setup tmpfiles on a system that is already running.... machine # [ 14.940703] systemd[1]: Finished Re-setup tmpfiles on a system that is already running.. machine # [ 14.942255] systemd[1]: Reached target Reactivate sysinit units. machine # [ 14.945844] systemd[1]: Reached target Local File Systems. machine # [ 14.948025] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 14.950246] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 14.952346] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 14.954103] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 14.956136] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 14.957549] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 14.960235] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 14.964079] systemd[1]: Reached target Remote File Systems. machine # [ 14.969482] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 14.971343] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 15.093204] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 15.094835] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 15.099065] systemd[1]: Starting linger-users.service... machine # [ 15.126706] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 15.128145] systemd[1]: Finished linger-users.service. machine # the following new units were started: sysinit-reactivation.target, systemd-tmpfiles-resetup.service machine # [ 15.388422] nixos[841]: finished switching to system configuration /nix/store/jl59xgshkm15yy4qkh11f2517r2vlwz8-nixos-system-machine-test machine: (finished: must succeed: /nix/store/3vbcjh6yz1i6lp352svzp92f3jmjppg7-stderr-runner /nix/store/jl59xgshkm15yy4qkh11f2517r2vlwz8-nixos-system-machine-test/bin/switch-to-configuration test, in 1.46 seconds) machine: must succeed: rm /etc/NIXOS machine: (finished: must succeed: rm /etc/NIXOS, in 0.03 seconds) machine: must succeed: /nix/store/3vbcjh6yz1i6lp352svzp92f3jmjppg7-stderr-runner /nix/store/zb7hd2kzkp9j7iqfd3wqgibynccwxiji-nixos-system-other-test/bin/switch-to-configuration test machine # this should succeed (config: /nix/store/zb7hd2kzkp9j7iqfd3wqgibynccwxiji-nixos-system-other-test, action: test) machine # Checking switch inhibitors... done machine # [ 15.638380] nixos[988]: switching to system configuration /nix/store/zb7hd2kzkp9j7iqfd3wqgibynccwxiji-nixos-system-other-test machine # [ 15.640544] systemd[1]: Stopped target Remote File Systems. machine # [ 15.642051] systemd[1]: Stopped target Local File Systems. machine # activating the configuration... machine # removing user ‘usertest’ machine # setting up /etc... machine # [ 15.860620] systemd[1]: Reload requested from client PID 988 ('.switch-to-conf') (unit backdoor.service)... machine # [ 15.862167] systemd[1]: Reloading... machine # [ 16.101747] systemd[1]: Reloading finished in 237 ms. machine # reloading user units for usertest... machine # [ 16.163671] systemd[621]: Reexecution requested from client PID 1059 ('switch-to-confi')... machine # [ 16.166152] systemd[621]: Reexecuting. machine # [ 16.186063] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 16.262403] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 16.267948] systemd[621]: Reload requested from client PID 1059 ('switch-to-confi')... machine # [ 16.269637] systemd[621]: Reloading... machine # [ 16.341598] systemd[621]: Reloading finished in 70 ms. machine # [ 16.346835] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # restarting the following user units: nixos-activation.service machine # [ 16.354347] systemd[621]: Stopped Run user-specific NixOS activation. machine # [ 16.355217] systemd[621]: Stopping Run user-specific NixOS activation... machine # [ 16.357436] systemd[621]: Starting Run user-specific NixOS activation... machine # [ 16.376540] systemd[621]: Finished Run user-specific NixOS activation. machine # restarting sysinit-reactivation.target machine # [ 16.380077] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 16.381561] systemd[1]: Stopping Reactivate sysinit units... machine # reloading the following units: dbus-broker.service[ 16.383116] systemd[1]: Reached target Reactivate sysinit units. machine # machine # [ 16.385286] dbus-broker-launch[499]: Caught SIGHUP, trigger reload. machine # [ 16.386943] systemd[1]: Reloading D-Bus System Message Bus... machine # [ 16.391807] dbus-broker-launch[499]: Looking up NSS user entry for 'systemd-timesync'... machine # [ 16.393653] dbus-broker-launch[499]: NSS returned no entry for 'systemd-timesync' machine # [ 16.394712] dbus-broker-launch[499]: Invalid user-name in /nix/store/slcmi1r1x7j8wfl1wq1cpqqi5gh4k55l-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" machine # [ 16.403042] systemd[1]: Reloaded D-Bus System Message Bus. machine # restarting the following units: network-addresses-eth1.service machine # [ 16.407759] systemd[1]: Stopping Address configuration of eth1... machine # [ 16.426236] network-addresses-eth1-pre-stop[1071]: deleting address 192.168.1.1/24... done machine # [ 16.431440] network-addresses-eth1-pre-stop[1071]: deleting address 2001:db8:1::1/64... done machine # [ 16.436416] systemd[1]: network-addresses-eth1.service: Deactivated successfully. machine # [ 16.437957] systemd[1]: Stopped Address configuration of eth1. machine # [ 16.441431] systemd[1]: Starting Address configuration of eth1... machine # [ 16.469563] network-addresses-eth1-start[1076]: adding address 192.168.1.2/24... done machine # [ 16.475359] network-addresses-eth1-start[1076]: adding address 2001:db8:1::2/64... done machine # [ 16.482820] systemd[1]: Finished Address configuration of eth1. machine # [ 16.486387] systemd[1]: Reached target Local File Systems. machine # [ 16.489105] systemd[1]: Reached target Remote File Systems. machine # [ 16.491709] systemd[1]: Starting linger-users.service... machine # [ 16.500773] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 16.505500] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 16.507130] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 16.508934] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 16.511885] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 16.514137] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 16.516509] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 16.519591] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 16.520830] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 16.540286] linger-users-start[1090]: id: ‘usertest’: no such user machine # [ 16.542791] linger-users-start[1087]: Removing linger for missing user usertest machine # [ 16.549565] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 16.551326] systemd[1]: Finished linger-users.service. machine # [ 16.681496] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 16.684572] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 16.939467] nixos[988]: finished switching to system configuration /nix/store/zb7hd2kzkp9j7iqfd3wqgibynccwxiji-nixos-system-other-test machine: (finished: must succeed: /nix/store/3vbcjh6yz1i6lp352svzp92f3jmjppg7-stderr-runner /nix/store/zb7hd2kzkp9j7iqfd3wqgibynccwxiji-nixos-system-other-test/bin/switch-to-configuration test, in 1.52 seconds) subtest: services machine: must succeed: /nix/store/jl59xgshkm15yy4qkh11f2517r2vlwz8-nixos-system-machine-test/bin/switch-to-configuration test 2>&1 machine # [ 17.159894] nixos[1154]: switching to system configuration /nix/store/jl59xgshkm15yy4qkh11f2517r2vlwz8-nixos-system-machine-test machine # [ 17.162272] systemd[1]: Stopped target Remote File Systems. machine # [ 17.164059] systemd[1]: Stopped target Local File Systems. machine # [ 17.370562] systemd[1]: Reload requested from client PID 1154 ('.switch-to-conf') (unit backdoor.service)... machine # [ 17.372157] systemd[1]: Reloading... machine # [ 17.608350] systemd[1]: Reloading finished in 234 ms. machine # [ 17.671264] systemd[621]: Reexecution requested from client PID 1224 ('switch-to-confi')... machine # [ 17.672481] systemd[621]: Reexecuting. machine # [ 17.692079] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 17.764295] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 17.769791] systemd[621]: Reload requested from client PID 1224 ('switch-to-confi')... machine # [ 17.771204] systemd[621]: Reloading... machine # [ 17.843781] systemd[621]: Reloading finished in 71 ms. machine # [ 17.848838] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 17.855041] systemd[621]: Stopped Run user-specific NixOS activation. machine # [ 17.856932] systemd[621]: Stopping Run user-specific NixOS activation... machine # [ 17.858452] systemd[621]: Starting Run user-specific NixOS activation... machine # [ 17.877278] systemd[621]: Finished Run user-specific NixOS activation. machine # [ 17.880354] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 17.881599] systemd[1]: Stopping Reactivate sysinit units... machine # [ 17.882653] systemd[1]: Reached target Reactivate sysinit units. machine # [ 17.885424] dbus-broker-launch[499]: Caught SIGHUP, trigger reload. machine # [ 17.887095] systemd[1]: Reloading D-Bus System Message Bus... machine # [ 17.890672] dbus-broker-launch[499]: Looking up NSS user entry for 'systemd-timesync'... machine # [ 17.892411] dbus-broker-launch[499]: NSS returned no entry for 'systemd-timesync' machine # [ 17.893450] dbus-broker-launch[499]: Invalid user-name in /nix/store/9nyy88lg4rwaal5mgwzsncpdv4j6ng88-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" machine # [ 17.900772] systemd[1]: Reloaded D-Bus System Message Bus. machine # [ 17.904704] systemd[1]: Stopping Address configuration of eth1... machine # [ 17.923486] network-addresses-eth1-pre-stop[1236]: deleting address 192.168.1.2/24... done machine # [ 17.928609] network-addresses-eth1-pre-stop[1236]: deleting address 2001:db8:1::2/64... done machine # [ 17.933285] systemd[1]: network-addresses-eth1.service: Deactivated successfully. machine # [ 17.934814] systemd[1]: Stopped Address configuration of eth1. machine # [ 17.938226] systemd[1]: Starting Address configuration of eth1... machine # [ 17.964865] network-addresses-eth1-start[1241]: adding address 192.168.1.1/24... done machine # [ 17.970292] network-addresses-eth1-start[1241]: adding address 2001:db8:1::1/64... done machine # [ 17.977109] systemd[1]: Finished Address configuration of eth1. machine # [ 17.980228] systemd[1]: Reached target Local File Systems. machine # [ 17.984823] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 17.988931] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 17.990124] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 17.991208] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 17.993105] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 17.994543] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 17.995675] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 17.999356] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 18.001326] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 18.006242] systemd[1]: Reached target Remote File Systems. machine # [ 18.127486] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 18.129665] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 18.133060] systemd[1]: Starting linger-users.service... machine # [ 18.154526] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 18.155977] systemd[1]: Finished linger-users.service. machine # [ 18.412646] nixos[1154]: finished switching to system configuration /nix/store/jl59xgshkm15yy4qkh11f2517r2vlwz8-nixos-system-machine-test machine: (finished: must succeed: /nix/store/jl59xgshkm15yy4qkh11f2517r2vlwz8-nixos-system-machine-test/bin/switch-to-configuration test 2>&1, in 1.47 seconds) machine: must succeed: /nix/store/jl59xgshkm15yy4qkh11f2517r2vlwz8-nixos-system-machine-test/bin/switch-to-configuration test 2>&1 machine # [ 18.618894] nixos[1310]: switching to system configuration /nix/store/jl59xgshkm15yy4qkh11f2517r2vlwz8-nixos-system-machine-test machine # [ 18.621511] systemd[1]: Stopped target Local File Systems. machine # [ 18.622939] systemd[1]: Stopped target Remote File Systems. machine # [ 18.824240] systemd[1]: Reload requested from client PID 1310 ('.switch-to-conf') (unit backdoor.service)... machine # [ 18.825814] systemd[1]: Reloading... machine # [ 19.053787] systemd[1]: Reloading finished in 226 ms. machine # [ 19.113552] systemd[621]: Reexecution requested from client PID 1379 ('switch-to-confi')... machine # [ 19.115088] systemd[621]: Reexecuting. machine # [ 19.134975] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 19.207525] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 19.212796] systemd[621]: Reload requested from client PID 1379 ('switch-to-confi')... machine # [ 19.214285] systemd[621]: Reloading... machine # [ 19.285754] systemd[621]: Reloading finished in 70 ms. machine # [ 19.290811] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 19.296772] systemd[621]: Stopped Run user-specific NixOS activation. machine # [ 19.297770] systemd[621]: Stopping Run user-specific NixOS activation... machine # [ 19.300189] systemd[621]: Starting Run user-specific NixOS activation... machine # [ 19.321552] systemd[621]: Finished Run user-specific NixOS activation. machine # [ 19.324745] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 19.325968] systemd[1]: Stopping Reactivate sysinit units... machine # [ 19.327231] systemd[1]: Reached target Reactivate sysinit units. machine # [ 19.328819] systemd[1]: Reached target Remote File Systems. machine # [ 19.334433] systemd[1]: Reached target Local File Systems. machine # [ 19.336166] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 19.339225] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 19.341114] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 19.342221] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 19.344748] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 19.347110] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 19.348261] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 19.352920] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 19.354077] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 19.484416] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 19.486139] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 19.489699] systemd[1]: Starting linger-users.service... machine # [ 19.517409] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 19.519637] systemd[1]: Finished linger-users.service. machine # [ 19.775796] nixos[1310]: finished switching to system configuration /nix/store/jl59xgshkm15yy4qkh11f2517r2vlwz8-nixos-system-machine-test machine: (finished: must succeed: /nix/store/jl59xgshkm15yy4qkh11f2517r2vlwz8-nixos-system-machine-test/bin/switch-to-configuration test 2>&1, in 1.36 seconds) machine: must succeed: /nix/store/jl59xgshkm15yy4qkh11f2517r2vlwz8-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration test 2>&1 machine # [ 19.994890] nixos[1450]: switching to system configuration /nix/store/xzyllshl9y4ibddriwzs5xl03nx9jaxl-nixos-system-machine-test machine # [ 19.997233] systemd[1]: Stopped target Local File Systems. machine # [ 19.998785] systemd[1]: Stopped target Remote File Systems. machine # [ 20.238221] systemd[1]: Reload requested from client PID 1450 ('.switch-to-conf') (unit backdoor.service)... machine # [ 20.239833] systemd[1]: Reloading... machine # [ 20.466991] systemd[1]: Reloading finished in 226 ms. machine # [ 20.528744] systemd[621]: Reexecution requested from client PID 1520 ('switch-to-confi')... machine # [ 20.530503] systemd[621]: Reexecuting. machine # [ 20.550966] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 20.622373] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 20.627567] systemd[621]: Reload requested from client PID 1520 ('switch-to-confi')... machine # [ 20.628860] systemd[621]: Reloading... machine # [ 20.699774] systemd[621]: Reloading finished in 69 ms. machine # [ 20.704830] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 20.710840] systemd[621]: Stopped Run user-specific NixOS activation. machine # [ 20.711844] systemd[621]: Stopping Run user-specific NixOS activation... machine # [ 20.714324] systemd[621]: Starting Run user-specific NixOS activation... machine # [ 20.733784] systemd[621]: Finished Run user-specific NixOS activation. machine # [ 20.736854] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 20.738158] systemd[1]: Stopping Reactivate sysinit units... machine # [ 20.738948] systemd[1]: Reached target Reactivate sysinit units. machine # [ 20.741076] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 20.742759] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 20.749224] systemd[1]: Reached target Local File Systems. machine # [ 20.749939] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 20.752985] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 20.753835] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 20.756111] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 20.758702] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 20.760063] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 20.761160] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 20.764170] systemd[1]: Reached target Remote File Systems. machine # [ 20.891513] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 20.893280] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 20.896698] systemd[1]: Starting linger-users.service... machine # [ 20.899714] systemd[1]: Starting test.service... machine # [ 20.925788] systemd[1]: Finished test.service. machine # [ 20.938812] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 20.940294] systemd[1]: Finished linger-users.service. machine # [ 21.197508] nixos[1450]: finished switching to system configuration /nix/store/xzyllshl9y4ibddriwzs5xl03nx9jaxl-nixos-system-machine-test machine: (finished: must succeed: /nix/store/jl59xgshkm15yy4qkh11f2517r2vlwz8-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration test 2>&1, in 1.42 seconds) machine: must succeed: /nix/store/jl59xgshkm15yy4qkh11f2517r2vlwz8-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration test 2>&1 machine # [ 21.414407] nixos[1593]: switching to system configuration /nix/store/xzyllshl9y4ibddriwzs5xl03nx9jaxl-nixos-system-machine-test machine # [ 21.416750] systemd[1]: Stopped target Remote File Systems. machine # [ 21.418618] systemd[1]: Stopped target Local File Systems. machine # [ 21.619655] systemd[1]: Reload requested from client PID 1593 ('.switch-to-conf') (unit backdoor.service)... machine # [ 21.621253] systemd[1]: Reloading... machine # [ 21.849950] systemd[1]: Reloading finished in 227 ms. machine # [ 21.918850] systemd[621]: Reexecution requested from client PID 1662 ('switch-to-confi')... machine # [ 21.921314] systemd[621]: Reexecuting. machine # [ 21.941045] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 22.012528] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 22.017538] systemd[621]: Reload requested from client PID 1662 ('switch-to-confi')... machine # [ 22.019030] systemd[621]: Reloading... machine # [ 22.090847] systemd[621]: Reloading finished in 70 ms. machine # [ 22.095821] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 22.101733] systemd[621]: Stopped Run user-specific NixOS activation. machine # [ 22.103149] systemd[621]: Stopping Run user-specific NixOS activation... machine # [ 22.105155] systemd[621]: Starting Run user-specific NixOS activation... machine # [ 22.125068] systemd[621]: Finished Run user-specific NixOS activation. machine # [ 22.127980] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 22.129312] systemd[1]: Stopping Reactivate sysinit units... machine # [ 22.130285] systemd[1]: Reached target Reactivate sysinit units. machine # [ 22.132691] systemd[1]: Reached target Local File Systems. machine # [ 22.136490] systemd[1]: Reached target Remote File Systems. machine # [ 22.139161] systemd[1]: Starting linger-users.service... machine # [ 22.142163] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 22.143398] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 22.150497] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 22.154531] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 22.155561] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 22.157585] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 22.160814] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 22.163124] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 22.165383] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 22.197044] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 22.200173] systemd[1]: Finished linger-users.service. machine # [ 22.306818] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 22.308461] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 22.563331] nixos[1593]: finished switching to system configuration /nix/store/xzyllshl9y4ibddriwzs5xl03nx9jaxl-nixos-system-machine-test machine: (finished: must succeed: /nix/store/jl59xgshkm15yy4qkh11f2517r2vlwz8-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration test 2>&1, in 1.36 seconds) machine: must succeed: /nix/store/jl59xgshkm15yy4qkh11f2517r2vlwz8-nixos-system-machine-test/specialisation/simpleServiceDifferentDescription/bin/switch-to-configuration test 2>&1 machine # [ 22.759819] nixos[1733]: switching to system configuration /nix/store/bmyqadbjbjbh8ddyik8zqmmpmflrjvmy-nixos-system-machine-test machine # [ 22.762407] systemd[1]: Stopped target Remote File Systems. machine # [ 22.764370] systemd[1]: Stopped target Local File Systems. machine # [ 22.983866] systemd[1]: Reload requested from client PID 1733 ('.switch-to-conf') (unit backdoor.service)... machine # [ 22.985509] systemd[1]: Reloading... machine # [ 23.243703] systemd[1]: Reloading finished in 256 ms. machine # [ 23.300976] systemd[621]: Reexecution requested from client PID 1802 ('switch-to-confi')... machine # [ 23.303222] systemd[621]: Reexecuting. machine # [ 23.323985] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 23.398122] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 23.405780] systemd[621]: Reload requested from client PID 1802 ('switch-to-confi')... machine # [ 23.407057] systemd[621]: Reloading... machine # [ 23.495397] systemd[621]: Reloading finished in 86 ms. machine # [ 23.499819] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 23.505877] systemd[621]: Stopped Run user-specific NixOS activation. machine # [ 23.507822] systemd[621]: Stopping Run user-specific NixOS activation... machine # [ 23.509176] systemd[621]: Starting Run user-specific NixOS activation... machine # [ 23.528890] systemd[621]: Finished Run user-specific NixOS activation. machine # [ 23.531706] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 23.532964] systemd[1]: Stopping Reactivate sysinit units... machine # [ 23.533956] systemd[1]: Reached target Reactivate sysinit units. machine # [ 23.536579] systemd[1]: Reached target Remote File Systems. machine # [ 23.542209] systemd[1]: Starting linger-users.service... machine # [ 23.544243] systemd[1]: Reached target Local File Systems. machine # [ 23.548907] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 23.550436] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 23.555108] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 23.560087] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 23.560878] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 23.562989] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 23.565601] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 23.568093] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 23.569401] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 23.600588] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 23.602790] systemd[1]: Finished linger-users.service. machine # [ 23.711105] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 23.712746] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 23.970286] nixos[1733]: finished switching to system configuration /nix/store/bmyqadbjbjbh8ddyik8zqmmpmflrjvmy-nixos-system-machine-test machine: (finished: must succeed: /nix/store/jl59xgshkm15yy4qkh11f2517r2vlwz8-nixos-system-machine-test/specialisation/simpleServiceDifferentDescription/bin/switch-to-configuration test 2>&1, in 1.41 seconds) machine: must succeed: /nix/store/jl59xgshkm15yy4qkh11f2517r2vlwz8-nixos-system-machine-test/specialisation/simpleServiceModified/bin/switch-to-configuration test 2>&1 machine # [ 24.188253] nixos[1874]: switching to system configuration /nix/store/dsbfkayms7kjwm8s50wppvwm1jl0g899-nixos-system-machine-test machine # [ 24.190762] systemd[1]: Stopped target Local File Systems. machine # [ 24.192690] systemd[1]: test.service: Deactivated successfully. machine # [ 24.193795] systemd[1]: Stopped Test unit. machine # [ 24.194881] systemd[1]: Stopped target Remote File Systems. machine # [ 24.416273] systemd[1]: Reload requested from client PID 1874 ('.switch-to-conf') (unit backdoor.service)... machine # [ 24.418063] systemd[1]: Reloading... machine # [ 24.664952] systemd[1]: Reloading finished in 246 ms. machine # [ 24.729382] systemd[621]: Reexecution requested from client PID 1943 ('switch-to-confi')... machine # [ 24.731762] systemd[621]: Reexecuting. machine # [ 24.751889] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 24.818797] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 24.824030] systemd[621]: Reload requested from client PID 1943 ('switch-to-confi')... machine # [ 24.825458] systemd[621]: Reloading... machine # [ 24.894461] systemd[621]: Reloading finished in 67 ms. machine # [ 24.899863] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 24.905981] systemd[621]: Stopped Run user-specific NixOS activation. machine # [ 24.907940] systemd[621]: Stopping Run user-specific NixOS activation... machine # [ 24.909471] systemd[621]: Starting Run user-specific NixOS activation... machine # [ 24.929977] systemd[621]: Finished Run user-specific NixOS activation. machine # [ 24.933097] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 24.934598] systemd[1]: Stopping Reactivate sysinit units... machine # [ 24.935541] systemd[1]: Reached target Reactivate sysinit units. machine # [ 24.937475] systemd[1]: Reached target Local File Systems. machine # [ 24.939914] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 24.941642] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 24.949445] systemd[1]: Starting test.service... machine # [ 24.952315] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 24.955830] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 24.956615] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 24.957694] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 24.961625] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 24.963024] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 24.964126] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 24.966930] systemd[1]: Reached target Remote File Systems. machine # [ 24.989292] systemd[1]: Finished test.service. machine # [ 25.087774] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 25.089419] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 25.093081] systemd[1]: Starting linger-users.service... machine # [ 25.118376] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 25.119847] systemd[1]: Finished linger-users.service. machine # [ 25.377371] nixos[1874]: finished switching to system configuration /nix/store/dsbfkayms7kjwm8s50wppvwm1jl0g899-nixos-system-machine-test machine: (finished: must succeed: /nix/store/jl59xgshkm15yy4qkh11f2517r2vlwz8-nixos-system-machine-test/specialisation/simpleServiceModified/bin/switch-to-configuration test 2>&1, in 1.41 seconds) machine: must succeed: /nix/store/jl59xgshkm15yy4qkh11f2517r2vlwz8-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1 machine # [ 25.586242] nixos[2016]: switching to system configuration /nix/store/asab2pibn678qzl68y0jh6br6655cynf-nixos-system-machine-test machine # [ 25.588490] systemd[1]: Stopped target Local File Systems. machine # [ 25.590313] systemd[1]: Stopped target Remote File Systems. machine # [ 25.796817] systemd[1]: Reload requested from client PID 2016 ('.switch-to-conf') (unit backdoor.service)... machine # [ 25.798397] systemd[1]: Reloading... machine # [ 26.035912] systemd[1]: Reloading finished in 236 ms. machine # [ 26.096760] systemd[621]: Reexecution requested from client PID 2085 ('switch-to-confi')... machine # [ 26.099329] systemd[621]: Reexecuting. machine # [ 26.119033] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 26.191352] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 26.196463] systemd[621]: Reload requested from client PID 2085 ('switch-to-confi')... machine # [ 26.198657] systemd[621]: Reloading... machine # [ 26.268449] systemd[621]: Reloading finished in 70 ms. machine # [ 26.273843] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 26.279693] systemd[621]: Stopped Run user-specific NixOS activation. machine # [ 26.280669] systemd[621]: Stopping Run user-specific NixOS activation... machine # [ 26.283232] systemd[621]: Starting Run user-specific NixOS activation... machine # [ 26.302026] systemd[621]: Finished Run user-specific NixOS activation. machine # [ 26.304871] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 26.306170] systemd[1]: Stopping Reactivate sysinit units... machine # [ 26.306879] systemd[1]: Reached target Reactivate sysinit units. machine # [ 26.308745] systemd[1]: test.service: Deactivated successfully. machine # [ 26.310227] systemd[1]: Stopped test.service. machine # [ 26.310840] systemd[1]: Stopping test.service... machine # [ 26.312533] systemd[1]: Starting test.service... machine # [ 26.327157] systemd[1]: Finished test.service. machine # [ 26.332081] systemd[1]: Reached target Remote File Systems. machine # [ 26.334732] systemd[1]: Starting linger-users.service... machine # [ 26.338693] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 26.340194] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 26.344270] systemd[1]: Reached target Local File Systems. machine # [ 26.350182] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 26.354157] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 26.355866] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 26.357302] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 26.359171] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 26.360502] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 26.361665] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 26.393867] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 26.396223] systemd[1]: Finished linger-users.service. machine # [ 26.503048] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 26.504594] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 26.762588] nixos[2016]: finished switching to system configuration /nix/store/asab2pibn678qzl68y0jh6br6655cynf-nixos-system-machine-test machine: (finished: must succeed: /nix/store/jl59xgshkm15yy4qkh11f2517r2vlwz8-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1, in 1.39 seconds) machine: must succeed: /nix/store/jl59xgshkm15yy4qkh11f2517r2vlwz8-nixos-system-machine-test/specialisation/simpleServiceReload/bin/switch-to-configuration test 2>&1 machine # [ 26.988275] nixos[2159]: switching to system configuration /nix/store/nrlc63wriif3rx7ww2qccv0ssl4wdrvc-nixos-system-machine-test machine # [ 26.990587] systemd[1]: Stopped target Remote File Systems. machine # [ 26.992208] systemd[1]: Stopped target Local File Systems. machine # [ 27.211418] systemd[1]: Reload requested from client PID 2159 ('.switch-to-conf') (unit backdoor.service)... machine # [ 27.213072] systemd[1]: Reloading... machine # [ 27.449904] systemd[1]: Reloading finished in 235 ms. machine # [ 27.509548] systemd[621]: Reexecution requested from client PID 2228 ('switch-to-confi')... machine # [ 27.510963] systemd[621]: Reexecuting. machine # [ 27.531983] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 27.602811] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 27.607756] systemd[621]: Reload requested from client PID 2228 ('switch-to-confi')... machine # [ 27.608981] systemd[621]: Reloading... machine # [ 27.679209] systemd[621]: Reloading finished in 68 ms. machine # [ 27.684815] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 27.690742] systemd[621]: Stopped Run user-specific NixOS activation. machine # [ 27.691740] systemd[621]: Stopping Run user-specific NixOS activation... machine # [ 27.694144] systemd[621]: Starting Run user-specific NixOS activation... machine # [ 27.712900] systemd[621]: Finished Run user-specific NixOS activation. machine # [ 27.715804] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 27.717157] systemd[1]: Stopping Reactivate sysinit units... machine # [ 27.717883] systemd[1]: Reached target Reactivate sysinit units. machine # [ 27.721209] systemd[1]: Reloading test.service... machine # [ 27.734064] systemd[1]: Reloaded test.service. machine # [ 27.736573] systemd[1]: Reached target Remote File Systems. machine # [ 27.739496] systemd[1]: Starting linger-users.service... machine # [ 27.748086] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 27.749303] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 27.752184] systemd[1]: Reached target Local File Systems. machine # [ 27.752918] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 27.756680] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 27.759240] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 27.760365] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 27.763804] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 27.766582] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 27.768404] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 27.801913] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 27.803623] systemd[1]: Finished linger-users.service. machine # [ 27.908125] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 27.909725] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 28.167597] nixos[2159]: finished switching to system configuration /nix/store/nrlc63wriif3rx7ww2qccv0ssl4wdrvc-nixos-system-machine-test machine: (finished: must succeed: /nix/store/jl59xgshkm15yy4qkh11f2517r2vlwz8-nixos-system-machine-test/specialisation/simpleServiceReload/bin/switch-to-configuration test 2>&1, in 1.40 seconds) machine: must succeed: /nix/store/jl59xgshkm15yy4qkh11f2517r2vlwz8-nixos-system-machine-test/specialisation/simpleServiceNorestart/bin/switch-to-configuration test 2>&1 machine # [ 28.414491] nixos[2301]: switching to system configuration /nix/store/ymb9214cy0vcv9lwcm90pczcqwj1x37g-nixos-system-machine-test machine # [ 28.416797] systemd[1]: Stopped target Remote File Systems. machine # [ 28.418519] systemd[1]: Stopped target Local File Systems. machine # [ 28.635986] systemd[1]: Reload requested from client PID 2301 ('.switch-to-conf') (unit backdoor.service)... machine # [ 28.637588] systemd[1]: Reloading... machine # [ 28.873907] systemd[1]: Reloading finished in 234 ms. machine # [ 28.936783] systemd[621]: Reexecution requested from client PID 2370 ('switch-to-confi')... machine # [ 28.938555] systemd[621]: Reexecuting. machine # [ 28.960104] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 29.035384] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 29.040330] systemd[621]: Reload requested from client PID 2370 ('switch-to-confi')... machine # [ 29.042545] systemd[621]: Reloading... machine # [ 29.113537] systemd[621]: Reloading finished in 71 ms. machine # [ 29.118822] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 29.125243] systemd[621]: Stopped Run user-specific NixOS activation. machine # [ 29.127054] systemd[621]: Stopping Run user-specific NixOS activation... machine # [ 29.128635] systemd[621]: Starting Run user-specific NixOS activation... machine # [ 29.147092] systemd[621]: Finished Run user-specific NixOS activation. machine # [ 29.149930] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 29.151161] systemd[1]: Stopping Reactivate sysinit units... machine # [ 29.151871] systemd[1]: Reached target Reactivate sysinit units. machine # [ 29.156303] systemd[1]: Reached target Local File Systems. machine # [ 29.158530] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 29.162747] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 29.163589] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 29.164723] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 29.166577] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 29.167943] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 29.169037] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 29.178627] systemd[1]: Reached target Remote File Systems. machine # [ 29.182728] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 29.184085] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 29.317675] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 29.319613] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 29.323797] systemd[1]: Starting linger-users.service... machine # [ 29.353720] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 29.356150] systemd[1]: Finished linger-users.service. machine # [ 29.610322] nixos[2301]: finished switching to system configuration /nix/store/ymb9214cy0vcv9lwcm90pczcqwj1x37g-nixos-system-machine-test machine: (finished: must succeed: /nix/store/jl59xgshkm15yy4qkh11f2517r2vlwz8-nixos-system-machine-test/specialisation/simpleServiceNorestart/bin/switch-to-configuration test 2>&1, in 1.44 seconds) machine: must succeed: /nix/store/jl59xgshkm15yy4qkh11f2517r2vlwz8-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration dry-activate 2>&1 machine: (finished: must succeed: /nix/store/jl59xgshkm15yy4qkh11f2517r2vlwz8-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration dry-activate 2>&1, in 0.31 seconds) machine: must succeed: /nix/store/jl59xgshkm15yy4qkh11f2517r2vlwz8-nixos-system-machine-test/bin/switch-to-configuration test 2>&1 machine # [ 30.122110] nixos[2452]: switching to system configuration /nix/store/jl59xgshkm15yy4qkh11f2517r2vlwz8-nixos-system-machine-test machine # [ 30.125966] systemd[1]: Stopped target Remote File Systems. machine # [ 30.127241] systemd[1]: test.service: Deactivated successfully. machine # [ 30.127988] systemd[1]: Stopped test.service. machine # [ 30.128936] systemd[1]: Stopped target Local File Systems. machine # [ 30.352170] systemd[1]: Reload requested from client PID 2452 ('.switch-to-conf') (unit backdoor.service)... machine # [ 30.353982] systemd[1]: Reloading... machine # [ 30.605812] systemd[1]: Reloading finished in 249 ms. machine # [ 30.671345] systemd[621]: Reexecution requested from client PID 2521 ('switch-to-confi')... machine # [ 30.673672] systemd[621]: Reexecuting. machine # [ 30.695418] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 30.772930] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 30.778472] systemd[621]: Reload requested from client PID 2521 ('switch-to-confi')... machine # [ 30.779951] systemd[621]: Reloading... machine # [ 30.858504] systemd[621]: Reloading finished in 77 ms. machine # [ 30.863896] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 30.870631] systemd[621]: Stopped Run user-specific NixOS activation. machine # [ 30.871664] systemd[621]: Stopping Run user-specific NixOS activation... machine # [ 30.874337] systemd[621]: Starting Run user-specific NixOS activation... machine # [ 30.896538] systemd[621]: Finished Run user-specific NixOS activation. machine # [ 30.899853] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 30.901224] systemd[1]: Stopping Reactivate sysinit units... machine # [ 30.901979] systemd[1]: Reached target Reactivate sysinit units. machine # [ 30.908913] systemd[1]: Reached target Local File Systems. machine # [ 30.910331] systemd[1]: Reached target Remote File Systems. machine # [ 30.912704] systemd[1]: Starting linger-users.service... machine # [ 30.920097] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 30.921314] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 30.925416] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 30.929065] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 30.929805] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 30.931925] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 30.934858] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 30.937123] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 30.939340] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 30.976529] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 30.978154] systemd[1]: Finished linger-users.service. machine # [ 31.097115] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 31.098819] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 31.356771] nixos[2452]: finished switching to system configuration /nix/store/jl59xgshkm15yy4qkh11f2517r2vlwz8-nixos-system-machine-test machine: (finished: must succeed: /nix/store/jl59xgshkm15yy4qkh11f2517r2vlwz8-nixos-system-machine-test/bin/switch-to-configuration test 2>&1, in 1.43 seconds) machine: must succeed: /nix/store/wky4jfwxg6i51pnvxaq885hfnf7swnxs-separate-activation-script/bin/switch-to-configuration test 2>&1 machine # [ 31.555361] nixos[2592]: switching to system configuration /nix/store/2hwwbzx38wca7vxxpnm0d6zi605adf5k-nixos-system-machine-test machine # [ 31.557757] systemd[1]: Stopped target Local File Systems. machine # [ 31.559664] systemd[1]: Stopped target Remote File Systems. machine # [ 31.780053] systemd[1]: Reload requested from client PID 2592 ('.switch-to-conf') (unit backdoor.service)... machine # [ 31.781592] systemd[1]: Reloading... machine # [ 32.008810] systemd[1]: Reloading finished in 226 ms. machine # [ 32.073317] systemd[621]: Stopped Run user-specific NixOS activation. machine # [ 32.074654] systemd[621]: Reexecution requested from client PID 2661 ('switch-to-confi')... machine # [ 32.076977] systemd[621]: Reexecuting. machine # [ 32.096232] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 32.168443] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 32.173338] systemd[621]: Reload requested from client PID 2661 ('switch-to-confi')... machine # [ 32.174877] systemd[621]: Reloading... machine # [ 32.246064] systemd[621]: Reloading finished in 70 ms. machine # [ 32.251808] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 32.258565] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 32.259682] systemd[1]: Stopping Reactivate sysinit units... machine # [ 32.260646] systemd[1]: Reached target Reactivate sysinit units. machine # [ 32.262633] systemd[1]: Reached target Local File Systems. machine # [ 32.264584] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 32.266330] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 32.269256] systemd[1]: Reached target Remote File Systems. machine # [ 32.273108] systemd[1]: Starting linger-users.service... machine # [ 32.275589] systemd[1]: Starting test.service... machine # [ 32.287269] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 32.291116] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 32.293911] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 32.295954] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 32.299107] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 32.300539] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 32.301709] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 32.320498] systemd[1]: Finished test.service. machine # [ 32.339524] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 32.341448] systemd[1]: Finished linger-users.service. machine # [ 32.448190] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 32.450806] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 32.707811] nixos[2592]: finished switching to system configuration /nix/store/2hwwbzx38wca7vxxpnm0d6zi605adf5k-nixos-system-machine-test machine: (finished: must succeed: /nix/store/wky4jfwxg6i51pnvxaq885hfnf7swnxs-separate-activation-script/bin/switch-to-configuration test 2>&1, in 1.35 seconds) machine: must succeed: ! test -e /run/current-system/activate machine: (finished: must succeed: ! test -e /run/current-system/activate, in 0.02 seconds) machine: must succeed: ! test -e /run/current-system/dry-activate machine: (finished: must succeed: ! test -e /run/current-system/dry-activate, in 0.02 seconds) machine: must succeed: ! test -e /run/current-system/bin/switch-to-configuration machine: (finished: must succeed: ! test -e /run/current-system/bin/switch-to-configuration, in 0.02 seconds) machine: must succeed: /nix/store/jl59xgshkm15yy4qkh11f2517r2vlwz8-nixos-system-machine-test/specialisation/unitWithMultilineValue/bin/switch-to-configuration test 2>&1 machine # [ 32.965781] nixos[2740]: switching to system configuration /nix/store/x2w61a3kycclcl2wvzmxkff95d1i1r3v-nixos-system-machine-test machine # [ 32.968497] systemd[1]: Stopped target Local File Systems. machine # [ 32.970332] systemd[1]: test.service: Deactivated successfully. machine # [ 32.971627] systemd[1]: Stopped test.service. machine # [ 32.973142] systemd[1]: Stopped target Remote File Systems. machine # [ 33.230324] systemd[1]: Reload requested from client PID 2740 ('.switch-to-conf') (unit backdoor.service)... machine # [ 33.231966] systemd[1]: Reloading... machine # [ 33.470838] systemd[1]: Reloading finished in 237 ms. machine # [ 33.531829] systemd[621]: Reexecution requested from client PID 2810 ('switch-to-confi')... machine # [ 33.534251] systemd[621]: Reexecuting. machine # [ 33.554990] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 33.626514] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 33.631640] systemd[621]: Reload requested from client PID 2810 ('switch-to-confi')... machine # [ 33.633431] systemd[621]: Reloading... machine # [ 33.705358] systemd[621]: Reloading finished in 71 ms. machine # [ 33.710823] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 33.717673] systemd[621]: Starting Run user-specific NixOS activation... machine # [ 33.738144] systemd[621]: Finished Run user-specific NixOS activation. machine # [ 33.741066] systemd[621]: Stopped Run user-specific NixOS activation. machine # [ 33.741913] systemd[621]: Stopping Run user-specific NixOS activation... machine # [ 33.744757] systemd[621]: Starting Run user-specific NixOS activation... machine # [ 33.746249] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 33.748207] systemd[1]: Stopping Reactivate sysinit units... machine # [ 33.748965] systemd[1]: Reached target Reactivate sysinit units. machine # [ 33.751681] systemd[1]: Reached target Remote File Systems. machine # [ 33.758066] systemd[1]: Reached target Local File Systems. machine # [ 33.761113] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 33.764161] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 33.764977] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 33.766143] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 33.768067] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 33.769442] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 33.776711] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 33.785523] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 33.787106] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 33.800217] systemd[621]: Finished Run user-specific NixOS activation. machine # [ 33.924545] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 33.926352] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 33.930291] systemd[1]: Starting linger-users.service... machine # [ 33.933213] systemd[1]: Started test.service. machine # [ 33.958168] systemd[1]: test.service: Deactivated successfully. machine # [ 33.970984] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 33.972421] systemd[1]: Finished linger-users.service. machine # [ 34.229896] nixos[2740]: finished switching to system configuration /nix/store/x2w61a3kycclcl2wvzmxkff95d1i1r3v-nixos-system-machine-test machine: (finished: must succeed: /nix/store/jl59xgshkm15yy4qkh11f2517r2vlwz8-nixos-system-machine-test/specialisation/unitWithMultilineValue/bin/switch-to-configuration test 2>&1, in 1.47 seconds) machine: must succeed: /nix/store/jl59xgshkm15yy4qkh11f2517r2vlwz8-nixos-system-machine-test/specialisation/unitWithBackslash/bin/switch-to-configuration test 2>&1 machine # [ 34.441230] nixos[2886]: switching to system configuration /nix/store/w56i3ngbhj44dccpsiw7nf93xvbqajs3-nixos-system-machine-test machine # [ 34.444609] systemd[1]: Stopped target Local File Systems. machine # [ 34.445497] systemd[1]: Stopped target Remote File Systems. machine # [ 34.669521] systemd[1]: Reload requested from client PID 2886 ('.switch-to-conf') (unit backdoor.service)... machine # [ 34.671157] systemd[1]: Reloading... machine # [ 34.902089] systemd[1]: Reloading finished in 229 ms. machine # [ 34.959894] systemd[621]: Reexecution requested from client PID 2955 ('switch-to-confi')... machine # [ 34.961167] systemd[621]: Reexecuting. machine # [ 34.981325] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 35.049832] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 35.054836] systemd[621]: Reload requested from client PID 2955 ('switch-to-confi')... machine # [ 35.056230] systemd[621]: Reloading... machine # [ 35.124363] systemd[621]: Reloading finished in 66 ms. machine # [ 35.129839] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 35.136299] systemd[621]: Stopped Run user-specific NixOS activation. machine # [ 35.138170] systemd[621]: Stopping Run user-specific NixOS activation... machine # [ 35.139705] systemd[621]: Starting Run user-specific NixOS activation... machine # [ 35.157886] systemd[621]: Finished Run user-specific NixOS activation. machine # [ 35.161828] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 35.162706] systemd[1]: Stopping Reactivate sysinit units... machine # [ 35.163814] systemd[1]: Reached target Reactivate sysinit units. machine # [ 35.166261] systemd[1]: Reached target Local File Systems. machine # [ 35.167112] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 35.170484] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 35.173122] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 35.174301] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 35.176177] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 35.177662] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 35.178781] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 35.185224] systemd[1]: Reached target Remote File Systems. machine # [ 35.185994] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 35.187330] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 35.311891] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 35.315282] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 35.317186] systemd[1]: Starting escaped\x2ddash.service... machine # [ 35.319437] systemd[1]: Starting linger-users.service... machine # [ 35.342742] systemd[1]: Finished escaped\x2ddash.service. machine # [ 35.355424] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 35.356776] systemd[1]: Finished linger-users.service. machine # [ 35.614209] nixos[2886]: finished switching to system configuration /nix/store/w56i3ngbhj44dccpsiw7nf93xvbqajs3-nixos-system-machine-test machine: (finished: must succeed: /nix/store/jl59xgshkm15yy4qkh11f2517r2vlwz8-nixos-system-machine-test/specialisation/unitWithBackslash/bin/switch-to-configuration test 2>&1, in 1.38 seconds) machine: must succeed: /nix/store/jl59xgshkm15yy4qkh11f2517r2vlwz8-nixos-system-machine-test/specialisation/unitWithBackslashModified/bin/switch-to-configuration test 2>&1 machine # [ 35.840399] nixos[3028]: switching to system configuration /nix/store/65mg2zz4ik3bscp6vmiws4y6bkmkljwx-nixos-system-machine-test machine # [ 35.843092] systemd[1]: Stopped target Local File Systems. machine # [ 35.844165] systemd[1]: escaped\x2ddash.service: Deactivated successfully. machine # [ 35.845599] systemd[1]: Stopped escaped\x2ddash.service. machine # [ 35.846876] systemd[1]: Stopped target Remote File Systems. machine # [ 36.064937] systemd[1]: Reload requested from client PID 3028 ('.switch-to-conf') (unit backdoor.service)... machine # [ 36.066573] systemd[1]: Reloading... machine # [ 36.308462] systemd[1]: Reloading finished in 240 ms. machine # [ 36.395411] systemd[621]: Reexecution requested from client PID 3097 ('switch-to-confi')... machine # [ 36.398436] systemd[621]: Reexecuting. machine # [ 36.420616] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 36.493809] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 36.499644] systemd[621]: Reload requested from client PID 3097 ('switch-to-confi')... machine # [ 36.500874] systemd[621]: Reloading... machine # [ 36.572820] systemd[621]: Reloading finished in 70 ms. machine # [ 36.577818] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 36.583833] systemd[621]: Stopped Run user-specific NixOS activation. machine # [ 36.584851] systemd[621]: Stopping Run user-specific NixOS activation... machine # [ 36.587328] systemd[621]: Starting Run user-specific NixOS activation... machine # [ 36.631819] systemd[621]: Finished Run user-specific NixOS activation. machine # [ 36.635327] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 36.636486] systemd[1]: Stopping Reactivate sysinit units... machine # [ 36.637471] systemd[1]: Reached target Reactivate sysinit units. machine # [ 36.639622] systemd[1]: Reached target Remote File Systems. machine # [ 36.643114] systemd[1]: Starting escaped\x2ddash.service... machine # [ 36.646844] systemd[1]: Starting linger-users.service... machine # [ 36.657672] systemd[1]: Reached target Local File Systems. machine # [ 36.662794] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 36.666985] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 36.668735] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 36.671118] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 36.675095] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 36.676624] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 36.679805] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 36.681267] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 36.682443] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 36.697882] systemd[1]: Finished escaped\x2ddash.service. machine # [ 36.719469] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 36.721153] systemd[1]: Finished linger-users.service. machine # [ 36.827249] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 36.828859] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 37.084115] nixos[3028]: finished switching to system configuration /nix/store/65mg2zz4ik3bscp6vmiws4y6bkmkljwx-nixos-system-machine-test machine: (finished: must succeed: /nix/store/jl59xgshkm15yy4qkh11f2517r2vlwz8-nixos-system-machine-test/specialisation/unitWithBackslashModified/bin/switch-to-configuration test 2>&1, in 1.47 seconds) machine: must succeed: /nix/store/jl59xgshkm15yy4qkh11f2517r2vlwz8-nixos-system-machine-test/specialisation/unitStartingWithDash/bin/switch-to-configuration test 2>&1 machine # [ 37.278551] nixos[3171]: switching to system configuration /nix/store/szi09s0gsgrbmip1xy7aghxyfgskrr6b-nixos-system-machine-test machine # [ 37.281260] systemd[1]: escaped\x2ddash.service: Deactivated successfully. machine # [ 37.282442] systemd[1]: Stopped escaped\x2ddash.service. machine # [ 37.283853] systemd[1]: Stopped target Remote File Systems. machine # [ 37.285196] systemd[1]: Stopped target Local File Systems. machine # [ 37.505764] systemd[1]: Reload requested from client PID 3171 ('.switch-to-conf') (unit backdoor.service)... machine # [ 37.507370] systemd[1]: Reloading... machine # [ 37.752403] systemd[1]: Reloading finished in 243 ms. machine # [ 37.817391] systemd[621]: Reexecution requested from client PID 3240 ('switch-to-confi')... machine # [ 37.818807] systemd[621]: Reexecuting. machine # [ 37.839343] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 37.912439] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 37.917694] systemd[621]: Reload requested from client PID 3240 ('switch-to-confi')... machine # [ 37.919680] systemd[621]: Reloading... machine # [ 37.991073] systemd[621]: Reloading finished in 71 ms. machine # [ 37.996812] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 38.003565] systemd[621]: Stopped Run user-specific NixOS activation. machine # [ 38.005081] systemd[621]: Stopping Run user-specific NixOS activation... machine # [ 38.007091] systemd[621]: Starting Run user-specific NixOS activation... machine # [ 38.026365] systemd[621]: Finished Run user-specific NixOS activation. machine # [ 38.029332] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 38.030614] systemd[1]: Stopping Reactivate sysinit units... machine # [ 38.031676] systemd[1]: Reached target Reactivate sysinit units. machine # [ 38.036654] systemd[1]: Reached target Remote File Systems. machine # [ 38.041059] systemd[1]: Reached target Local File Systems. machine # [ 38.043031] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 38.045117] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 38.045894] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 38.048903] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 38.051642] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 38.053124] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 38.056311] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 38.057900] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 38.059070] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 38.183163] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 38.186272] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 38.189200] systemd[1]: Starting -.service... machine # [ 38.191213] systemd[1]: Starting linger-users.service... machine # [ 38.214144] systemd[1]: Finished -.service. machine # [ 38.227889] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 38.230185] systemd[1]: Finished linger-users.service. machine # [ 38.486523] nixos[3171]: finished switching to system configuration /nix/store/szi09s0gsgrbmip1xy7aghxyfgskrr6b-nixos-system-machine-test machine: (finished: must succeed: /nix/store/jl59xgshkm15yy4qkh11f2517r2vlwz8-nixos-system-machine-test/specialisation/unitStartingWithDash/bin/switch-to-configuration test 2>&1, in 1.41 seconds) machine: must succeed: /nix/store/jl59xgshkm15yy4qkh11f2517r2vlwz8-nixos-system-machine-test/specialisation/unitStartingWithDashModified/bin/switch-to-configuration test 2>&1 machine # [ 38.705599] nixos[3313]: switching to system configuration /nix/store/2szp15sv2hqmwm0dyya60krq3z0hxzc9-nixos-system-machine-test machine # [ 38.708462] systemd[1]: Stopped target Local File Systems. machine # [ 38.710556] systemd[1]: Stopped target Remote File Systems. machine # [ 38.921833] systemd[1]: Reload requested from client PID 3313 ('.switch-to-conf') (unit backdoor.service)... machine # [ 38.923374] systemd[1]: Reloading... machine # [ 39.148133] systemd[1]: Reloading finished in 223 ms. machine # [ 39.210865] systemd[621]: Reexecution requested from client PID 3382 ('switch-to-confi')... machine # [ 39.212747] systemd[621]: Reexecuting. machine # [ 39.234034] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 39.303661] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 39.309033] systemd[621]: Reload requested from client PID 3382 ('switch-to-confi')... machine # [ 39.310847] systemd[621]: Reloading... machine # [ 39.382382] systemd[621]: Reloading finished in 70 ms. machine # [ 39.387809] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 39.397450] systemd[621]: Stopped Run user-specific NixOS activation. machine # [ 39.398684] systemd[621]: Stopping Run user-specific NixOS activation... machine # [ 39.401323] systemd[621]: Starting Run user-specific NixOS activation... machine # [ 39.438145] systemd[621]: Finished Run user-specific NixOS activation. machine # [ 39.443340] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 39.444671] systemd[1]: Stopping Reactivate sysinit units... machine # [ 39.446336] systemd[1]: Reached target Reactivate sysinit units. machine # [ 39.450422] systemd[1]: Reloading -.service... machine # [ 39.472364] systemd[1]: Reloaded -.service. machine # [ 39.481510] systemd[1]: Reached target Local File Systems. machine # [ 39.485095] systemd[1]: Reached target Remote File Systems. machine # [ 39.486631] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 39.488333] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 39.491055] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 39.494453] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 39.496511] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 39.498743] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 39.501500] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 39.503068] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 39.505076] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 39.631556] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 39.633300] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 39.636933] systemd[1]: Starting linger-users.service... machine # [ 39.663658] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 39.665152] systemd[1]: Finished linger-users.service. machine # [ 39.921572] nixos[3313]: finished switching to system configuration /nix/store/2szp15sv2hqmwm0dyya60krq3z0hxzc9-nixos-system-machine-test machine: (finished: must succeed: /nix/store/jl59xgshkm15yy4qkh11f2517r2vlwz8-nixos-system-machine-test/specialisation/unitStartingWithDashModified/bin/switch-to-configuration test 2>&1, in 1.44 seconds) machine: must succeed: /nix/store/jl59xgshkm15yy4qkh11f2517r2vlwz8-nixos-system-machine-test/specialisation/unitWithRequirement/bin/switch-to-configuration test 2>&1 machine # [ 40.116361] nixos[3456]: switching to system configuration /nix/store/hvj39jyj8i0ipxxizgq5r9v4wx0pr6bc-nixos-system-machine-test machine # [ 40.119100] systemd[1]: Stopped target Remote File Systems. machine # [ 40.121201] systemd[1]: Stopped target Local File Systems. machine # [ 40.122634] systemd[1]: -.service: Deactivated successfully. machine # [ 40.123506] systemd[1]: Stopped -.service. machine # [ 40.351411] systemd[1]: Reload requested from client PID 3456 ('.switch-to-conf') (unit backdoor.service)... machine # [ 40.353135] systemd[1]: Reloading... machine # [ 40.594913] systemd[1]: Reloading finished in 240 ms. machine # [ 40.658338] systemd[621]: Reexecution requested from client PID 3525 ('switch-to-confi')... machine # [ 40.660299] systemd[621]: Reexecuting. machine # [ 40.681278] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 40.752820] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 40.758057] systemd[621]: Reload requested from client PID 3525 ('switch-to-confi')... machine # [ 40.759923] systemd[621]: Reloading... machine # [ 40.831778] systemd[621]: Reloading finished in 71 ms. machine # [ 40.837825] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 40.844752] systemd[621]: Stopped Run user-specific NixOS activation. machine # [ 40.845613] systemd[621]: Stopping Run user-specific NixOS activation... machine # [ 40.847238] systemd[621]: Starting Run user-specific NixOS activation... machine # [ 40.866097] systemd[621]: Finished Run user-specific NixOS activation. machine # [ 40.868967] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 40.870361] systemd[1]: Stopping Reactivate sysinit units... machine # [ 40.871473] systemd[1]: Reached target Reactivate sysinit units. machine # [ 40.872763] systemd[1]: Reached target Remote File Systems. machine # [ 40.877902] systemd[1]: Reached target Local File Systems. machine # [ 40.880133] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 40.881313] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 40.882508] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 40.885210] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 40.885985] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 40.888265] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 40.890192] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 40.891534] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 40.892667] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 41.022161] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 41.023868] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 41.027541] systemd[1]: Starting linger-users.service... machine # [ 41.030173] systemd[1]: Starting required-service.service... machine # [ 41.033667] systemd[1]: Starting test-service.service... machine # [ 41.063628] systemd[1]: Finished required-service.service. machine # [ 41.066191] systemd[1]: Finished test-service.service. machine # [ 41.078501] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 41.079908] systemd[1]: Finished linger-users.service. machine # [ 41.337937] nixos[3456]: finished switching to system configuration /nix/store/hvj39jyj8i0ipxxizgq5r9v4wx0pr6bc-nixos-system-machine-test machine: (finished: must succeed: /nix/store/jl59xgshkm15yy4qkh11f2517r2vlwz8-nixos-system-machine-test/specialisation/unitWithRequirement/bin/switch-to-configuration test 2>&1, in 1.42 seconds) machine: must succeed: /nix/store/jl59xgshkm15yy4qkh11f2517r2vlwz8-nixos-system-machine-test/specialisation/unitWithRequirementModified/bin/switch-to-configuration test 2>&1 machine # [ 41.571526] nixos[3600]: switching to system configuration /nix/store/2yjargpsa662hml15b1wmfwnqyw6l34q-nixos-system-machine-test machine # [ 41.573966] systemd[1]: required-service.service: Deactivated successfully. machine # [ 41.575963] systemd[1]: Stopped required-service.service. machine # [ 41.577489] systemd[1]: test-service.service: Deactivated successfully. machine # [ 41.579203] systemd[1]: Stopped test-service.service. machine # [ 41.579866] systemd[1]: Stopped target Local File Systems. machine # [ 41.580722] systemd[1]: Stopped target Remote File Systems. machine # [ 41.799364] systemd[1]: Reload requested from client PID 3600 ('.switch-to-conf') (unit backdoor.service)... machine # [ 41.800982] systemd[1]: Reloading... machine # [ 42.042200] systemd[1]: Reloading finished in 240 ms. machine # [ 42.104540] systemd[621]: Reexecution requested from client PID 3669 ('switch-to-confi')... machine # [ 42.106133] systemd[621]: Reexecuting. machine # [ 42.126041] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 42.199169] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 42.204245] systemd[621]: Reload requested from client PID 3669 ('switch-to-confi')... machine # [ 42.206144] systemd[621]: Reloading... machine # [ 42.276983] systemd[621]: Reloading finished in 70 ms. machine # [ 42.282814] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 42.289744] systemd[621]: Stopped Run user-specific NixOS activation. machine # [ 42.290626] systemd[621]: Stopping Run user-specific NixOS activation... machine # [ 42.292222] systemd[621]: Starting Run user-specific NixOS activation... machine # [ 42.312148] systemd[621]: Finished Run user-specific NixOS activation. machine # [ 42.315097] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 42.316529] systemd[1]: Stopping Reactivate sysinit units... machine # [ 42.317468] systemd[1]: Reached target Reactivate sysinit units. machine # [ 42.321626] systemd[1]: Reached target Local File Systems. machine # [ 42.323395] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 42.325710] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 42.327437] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 42.329446] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 42.331376] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 42.332731] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 42.333879] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 42.340330] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 42.341643] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 42.345898] systemd[1]: Reached target Remote File Systems. machine # [ 42.471982] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 42.473595] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 42.478122] systemd[1]: Starting linger-users.service... machine # [ 42.480160] systemd[1]: Starting required-service.service... machine # [ 42.483558] systemd[1]: Starting test-service.service... machine # [ 42.514523] systemd[1]: Finished required-service.service. machine # [ 42.516162] systemd[1]: Finished test-service.service. machine # [ 42.529809] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 42.532223] systemd[1]: Finished linger-users.service. machine # [ 42.786491] nixos[3600]: finished switching to system configuration /nix/store/2yjargpsa662hml15b1wmfwnqyw6l34q-nixos-system-machine-test machine: (finished: must succeed: /nix/store/jl59xgshkm15yy4qkh11f2517r2vlwz8-nixos-system-machine-test/specialisation/unitWithRequirementModified/bin/switch-to-configuration test 2>&1, in 1.44 seconds) machine: must succeed: /nix/store/jl59xgshkm15yy4qkh11f2517r2vlwz8-nixos-system-machine-test/specialisation/unitWithRequirementModifiedNostart/bin/switch-to-configuration test 2>&1 machine # [ 42.990502] nixos[3744]: switching to system configuration /nix/store/i3lcqjm2ndbxgdx5zjg06bv2s7ij4f1g-nixos-system-machine-test machine # [ 42.994033] systemd[1]: required-service.service: Deactivated successfully. machine # [ 42.994926] systemd[1]: Stopped required-service.service. machine # [ 42.996785] systemd[1]: test-service.service: Deactivated successfully. machine # [ 42.998473] systemd[1]: Stopped test-service.service. machine # [ 42.999274] systemd[1]: Stopped target Remote File Systems. machine # [ 43.000027] systemd[1]: Stopped target Local File Systems. machine # [ 43.223555] systemd[1]: Reload requested from client PID 3744 ('.switch-to-conf') (unit backdoor.service)... machine # [ 43.225163] systemd[1]: Reloading... machine # [ 43.471810] systemd[1]: Reloading finished in 244 ms. machine # [ 43.532326] systemd[621]: Reexecution requested from client PID 3813 ('switch-to-confi')... machine # [ 43.534757] systemd[621]: Reexecuting. machine # [ 43.556974] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 43.629375] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 43.635165] systemd[621]: Reload requested from client PID 3813 ('switch-to-confi')... machine # [ 43.637125] systemd[621]: Reloading... machine # [ 43.708633] systemd[621]: Reloading finished in 71 ms. machine # [ 43.713824] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 43.719900] systemd[621]: Stopped Run user-specific NixOS activation. machine # [ 43.720932] systemd[621]: Stopping Run user-specific NixOS activation... machine # [ 43.723461] systemd[621]: Starting Run user-specific NixOS activation... machine # [ 43.743523] systemd[621]: Finished Run user-specific NixOS activation. machine # [ 43.746924] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 43.748263] systemd[1]: Stopping Reactivate sysinit units... machine # [ 43.749346] systemd[1]: Reached target Reactivate sysinit units. machine # [ 43.752536] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 43.754720] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 43.757249] systemd[1]: Reached target Remote File Systems. machine # [ 43.762995] systemd[1]: Starting linger-users.service... machine # [ 43.765167] systemd[1]: Starting required-service.service... machine # [ 43.770258] systemd[1]: Starting test-service.service... machine # [ 43.770984] systemd[1]: Reached target Local File Systems. machine # [ 43.780389] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 43.784542] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 43.785467] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 43.786666] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 43.788649] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 43.793085] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 43.796655] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 43.830183] systemd[1]: Finished required-service.service. machine # [ 43.833079] systemd[1]: Finished test-service.service. machine # [ 43.855103] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 43.857650] systemd[1]: Finished linger-users.service. machine # [ 43.963961] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 43.966255] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 44.223784] nixos[3744]: finished switching to system configuration /nix/store/i3lcqjm2ndbxgdx5zjg06bv2s7ij4f1g-nixos-system-machine-test machine: (finished: must succeed: /nix/store/jl59xgshkm15yy4qkh11f2517r2vlwz8-nixos-system-machine-test/specialisation/unitWithRequirementModifiedNostart/bin/switch-to-configuration test 2>&1, in 1.44 seconds) machine: must succeed: /nix/store/jl59xgshkm15yy4qkh11f2517r2vlwz8-nixos-system-machine-test/specialisation/unitWithTemplate/bin/switch-to-configuration test 2>&1 machine # [ 44.449522] nixos[3888]: switching to system configuration /nix/store/nnfnz8ald43hrkkg4sf0i4piiyz4gpay-nixos-system-machine-test machine # [ 44.452051] systemd[1]: Stopped target Local File Systems. machine # [ 44.454068] systemd[1]: Stopped target Remote File Systems. machine # [ 44.455630] systemd[1]: test-service.service: Deactivated successfully. machine # [ 44.456613] systemd[1]: Stopped test-service.service. machine # [ 44.458100] systemd[1]: required-service.service: Deactivated successfully. machine # [ 44.459518] systemd[1]: Stopped required-service.service. machine # [ 44.680458] systemd[1]: Reload requested from client PID 3888 ('.switch-to-conf') (unit backdoor.service)... machine # [ 44.682082] systemd[1]: Reloading... machine # [ 44.931684] systemd[1]: Reloading finished in 247 ms. machine # [ 44.992289] systemd[621]: Reexecution requested from client PID 3957 ('switch-to-confi')... machine # [ 44.993563] systemd[621]: Reexecuting. machine # [ 45.013198] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 45.082781] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 45.087867] systemd[621]: Reload requested from client PID 3957 ('switch-to-confi')... machine # [ 45.089276] systemd[621]: Reloading... machine # [ 45.159075] systemd[621]: Reloading finished in 68 ms. machine # [ 45.164819] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 45.170842] systemd[621]: Stopped Run user-specific NixOS activation. machine # [ 45.171917] systemd[621]: Stopping Run user-specific NixOS activation... machine # [ 45.174634] systemd[621]: Starting Run user-specific NixOS activation... machine # [ 45.193243] systemd[621]: Finished Run user-specific NixOS activation. machine # [ 45.196273] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 45.197614] systemd[1]: Stopping Reactivate sysinit units... machine # [ 45.198442] systemd[1]: Reached target Reactivate sysinit units. machine # [ 45.199855] systemd[1]: Reached target Local File Systems. machine # [ 45.202894] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 45.206344] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 45.208124] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 45.209723] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 45.211813] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 45.213259] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 45.214436] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 45.223059] systemd[1]: Created slice Slice /system/instantiated. machine # [ 45.224706] systemd[1]: Reached target Remote File Systems. machine # [ 45.232640] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 45.234426] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 45.352368] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 45.354047] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 45.357887] systemd[1]: Starting instantiated@one.service... machine # [ 45.363480] systemd[1]: Starting instantiated@two.service... machine # [ 45.365126] systemd[1]: Starting linger-users.service... machine # [ 45.391436] systemd[1]: Finished instantiated@one.service. machine # [ 45.393632] systemd[1]: Finished instantiated@two.service. machine # [ 45.409683] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 45.412180] systemd[1]: Finished linger-users.service. machine # [ 45.668819] nixos[3888]: finished switching to system configuration /nix/store/nnfnz8ald43hrkkg4sf0i4piiyz4gpay-nixos-system-machine-test machine: (finished: must succeed: /nix/store/jl59xgshkm15yy4qkh11f2517r2vlwz8-nixos-system-machine-test/specialisation/unitWithTemplate/bin/switch-to-configuration test 2>&1, in 1.44 seconds) machine: must succeed: /nix/store/jl59xgshkm15yy4qkh11f2517r2vlwz8-nixos-system-machine-test/specialisation/unitWithTemplateModified/bin/switch-to-configuration test 2>&1 machine # [ 45.922100] nixos[4032]: switching to system configuration /nix/store/frn3r4d96wq6x4fk2njs93yk7mf1ji2n-nixos-system-machine-test machine # [ 45.924750] systemd[1]: Stopped target Remote File Systems. machine # [ 45.926406] systemd[1]: Stopped target Local File Systems. machine # [ 45.927732] systemd[1]: instantiated@two.service: Deactivated successfully. machine # [ 45.929303] systemd[1]: Stopped instantiated@two.service. machine # [ 45.930831] systemd[1]: instantiated@one.service: Deactivated successfully. machine # [ 45.932107] systemd[1]: Stopped instantiated@one.service. machine # [ 46.143783] systemd[1]: Reload requested from client PID 4032 ('.switch-to-conf') (unit backdoor.service)... machine # [ 46.145443] systemd[1]: Reloading... machine # [ 46.369971] systemd[1]: Reloading finished in 223 ms. machine # [ 46.427928] systemd[621]: Reexecution requested from client PID 4101 ('switch-to-confi')... machine # [ 46.429253] systemd[621]: Reexecuting. machine # [ 46.449074] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 46.516833] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 46.521925] systemd[621]: Reload requested from client PID 4101 ('switch-to-confi')... machine # [ 46.523391] systemd[621]: Reloading... machine # [ 46.590141] systemd[621]: Reloading finished in 65 ms. machine # [ 46.595823] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 46.602439] systemd[621]: Stopped Run user-specific NixOS activation. machine # [ 46.603485] systemd[621]: Stopping Run user-specific NixOS activation... machine # [ 46.605890] systemd[621]: Starting Run user-specific NixOS activation... machine # [ 46.624424] systemd[621]: Finished Run user-specific NixOS activation. machine # [ 46.627368] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 46.628314] systemd[1]: Stopping Reactivate sysinit units... machine # [ 46.629362] systemd[1]: Reached target Reactivate sysinit units. machine # [ 46.634779] systemd[1]: Starting instantiated@two.service... machine # [ 46.636662] systemd[1]: Reached target Remote File Systems. machine # [ 46.640400] systemd[1]: Reached target Local File Systems. machine # [ 46.643888] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 46.645772] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 46.651328] systemd[1]: Starting instantiated@one.service... machine # [ 46.657548] systemd[1]: Starting linger-users.service... machine # [ 46.659342] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 46.667952] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 46.668776] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 46.669934] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 46.671866] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 46.673332] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 46.674518] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 46.693072] systemd[1]: Finished instantiated@two.service. machine # [ 46.705968] systemd[1]: Finished instantiated@one.service. machine # [ 46.730079] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 46.731616] systemd[1]: Finished linger-users.service. machine # [ 46.827622] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 46.829298] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 47.087291] nixos[4032]: finished switching to system configuration /nix/store/frn3r4d96wq6x4fk2njs93yk7mf1ji2n-nixos-system-machine-test machine: (finished: must succeed: /nix/store/jl59xgshkm15yy4qkh11f2517r2vlwz8-nixos-system-machine-test/specialisation/unitWithTemplateModified/bin/switch-to-configuration test 2>&1, in 1.42 seconds) (finished: subtest: services, in 30.15 seconds) subtest: failing units machine: must succeed: /nix/store/jl59xgshkm15yy4qkh11f2517r2vlwz8-nixos-system-machine-test/specialisation/simpleServiceModified/bin/switch-to-configuration test 2>&1 machine # [ 47.311810] nixos[4176]: switching to system configuration /nix/store/dsbfkayms7kjwm8s50wppvwm1jl0g899-nixos-system-machine-test machine # [ 47.314391] systemd[1]: instantiated@two.service: Deactivated successfully. machine # [ 47.316624] systemd[1]: Stopped instantiated@two.service. machine # [ 47.317836] systemd[1]: instantiated@one.service: Deactivated successfully. machine # [ 47.319497] systemd[1]: Stopped instantiated@one.service. machine # [ 47.320295] systemd[1]: Stopped target Local File Systems. machine # [ 47.321440] systemd[1]: Stopped target Remote File Systems. machine # [ 47.532954] systemd[1]: Reload requested from client PID 4176 ('.switch-to-conf') (unit backdoor.service)... machine # [ 47.534660] systemd[1]: Reloading... machine # [ 47.767089] systemd[1]: Reloading finished in 230 ms. machine # [ 47.826339] systemd[621]: Reexecution requested from client PID 4245 ('switch-to-confi')... machine # [ 47.828461] systemd[621]: Reexecuting. machine # [ 47.847755] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 47.919875] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 47.925053] systemd[621]: Reload requested from client PID 4245 ('switch-to-confi')... machine # [ 47.926506] systemd[621]: Reloading... machine # [ 47.997091] systemd[621]: Reloading finished in 69 ms. machine # [ 48.002810] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 48.008971] systemd[621]: Stopped Run user-specific NixOS activation. machine # [ 48.010108] systemd[621]: Stopping Run user-specific NixOS activation... machine # [ 48.012694] systemd[621]: Starting Run user-specific NixOS activation... machine # [ 48.031029] systemd[621]: Finished Run user-specific NixOS activation. machine # [ 48.033956] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 48.035231] systemd[1]: Stopping Reactivate sysinit units... machine # [ 48.036599] systemd[1]: Reached target Reactivate sysinit units. machine # [ 48.038622] systemd[1]: Reached target Local File Systems. machine # [ 48.041105] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 48.043412] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 48.045233] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 48.047523] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 48.049914] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 48.051376] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 48.052561] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 48.056409] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 48.057893] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 48.065754] systemd[1]: Reached target Remote File Systems. machine # [ 48.188806] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 48.190638] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 48.194705] systemd[1]: Starting linger-users.service... machine # [ 48.197694] systemd[1]: Starting test.service... machine # [ 48.220876] systemd[1]: Finished test.service. machine # [ 48.234173] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 48.235614] systemd[1]: Finished linger-users.service. machine # [ 48.489634] nixos[4176]: finished switching to system configuration /nix/store/dsbfkayms7kjwm8s50wppvwm1jl0g899-nixos-system-machine-test machine: (finished: must succeed: /nix/store/jl59xgshkm15yy4qkh11f2517r2vlwz8-nixos-system-machine-test/specialisation/simpleServiceModified/bin/switch-to-configuration test 2>&1, in 1.40 seconds) machine: must fail: /nix/store/jl59xgshkm15yy4qkh11f2517r2vlwz8-nixos-system-machine-test/specialisation/simpleServiceFailing/bin/switch-to-configuration test 2>&1 machine # [ 48.689557] nixos[4318]: switching to system configuration /nix/store/1myzjnggd6ddc8qrmm3rdhy1aj602cvx-nixos-system-machine-test machine # [ 48.691913] systemd[1]: Stopped target Remote File Systems. machine # [ 48.694248] systemd[1]: test.service: Deactivated successfully. machine # [ 48.695204] systemd[1]: Stopped test.service. machine # [ 48.696226] systemd[1]: Stopped target Local File Systems. machine # [ 48.917547] systemd[1]: Reload requested from client PID 4318 ('.switch-to-conf') (unit backdoor.service)... machine # [ 48.919235] systemd[1]: Reloading... machine # [ 49.163111] systemd[1]: Reloading finished in 242 ms. machine # [ 49.226198] systemd[621]: Reexecution requested from client PID 4387 ('switch-to-confi')... machine # [ 49.228664] systemd[621]: Reexecuting. machine # [ 49.249084] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 49.321640] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 49.326931] systemd[621]: Reload requested from client PID 4387 ('switch-to-confi')... machine # [ 49.328662] systemd[621]: Reloading... machine # [ 49.401376] systemd[621]: Reloading finished in 71 ms. machine # [ 49.405855] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 49.413063] systemd[621]: Stopped Run user-specific NixOS activation. machine # [ 49.413970] systemd[621]: Stopping Run user-specific NixOS activation... machine # [ 49.416907] systemd[621]: Starting Run user-specific NixOS activation... machine # [ 49.437060] systemd[621]: Finished Run user-specific NixOS activation. machine # [ 49.439923] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 49.441258] systemd[1]: Stopping Reactivate sysinit units... machine # [ 49.442250] systemd[1]: Reached target Reactivate sysinit units. machine # [ 49.445877] systemd[1]: Reached target Local File Systems. machine # [ 49.448623] systemd[1]: Reached target Remote File Systems. machine # [ 49.451989] systemd[1]: Starting linger-users.service... machine # [ 49.454327] systemd[1]: Starting test.service... machine # [ 49.463105] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 49.468195] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 49.468958] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 49.470366] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 49.472248] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 49.473713] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 49.474913] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 49.481621] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 49.483431] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 49.502414] systemd[1]: test.service: Main process exited, code=exited, status=1/FAILURE machine # [ 49.504167] systemd[1]: test.service: Failed with result 'exit-code'. machine # [ 49.507104] systemd[1]: Failed to start test.service. machine # [ 49.528536] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 49.530523] systemd[1]: Finished linger-users.service. machine # [ 49.639039] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 49.640750] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 49.920767] nixos[4318]: switching to system configuration /nix/store/1myzjnggd6ddc8qrmm3rdhy1aj602cvx-nixos-system-machine-test failed (status 4) machine: (finished: must fail: /nix/store/jl59xgshkm15yy4qkh11f2517r2vlwz8-nixos-system-machine-test/specialisation/simpleServiceFailing/bin/switch-to-configuration test 2>&1, in 1.43 seconds) machine: must succeed: /nix/store/jl59xgshkm15yy4qkh11f2517r2vlwz8-nixos-system-machine-test/specialisation/autorestartService/bin/switch-to-configuration test 2>&1 machine # [ 50.153937] nixos[4461]: switching to system configuration /nix/store/xhdfhiqadvgg7mpyjj1annfrak1whbh8-nixos-system-machine-test machine # [ 50.157288] systemd[1]: Stopped target Local File Systems. machine # [ 50.158255] systemd[1]: Stopped target Remote File Systems. machine # [ 50.367255] systemd[1]: Reload requested from client PID 4461 ('.switch-to-conf') (unit backdoor.service)... machine # [ 50.368852] systemd[1]: Reloading... machine # [ 50.604856] systemd[1]: Reloading finished in 235 ms. machine # [ 50.666357] systemd[621]: Reexecution requested from client PID 4530 ('switch-to-confi')... machine # [ 50.668954] systemd[621]: Reexecuting. machine # [ 50.690301] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 50.762934] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 50.768318] systemd[621]: Reload requested from client PID 4530 ('switch-to-confi')... machine # [ 50.769554] systemd[621]: Reloading... machine # [ 50.840873] systemd[621]: Reloading finished in 69 ms. machine # [ 50.845834] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 50.851991] systemd[621]: Stopped Run user-specific NixOS activation. machine # [ 50.853831] systemd[621]: Stopping Run user-specific NixOS activation... machine # [ 50.855184] systemd[621]: Starting Run user-specific NixOS activation... machine # [ 50.875323] systemd[621]: Finished Run user-specific NixOS activation. machine # [ 50.878250] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 50.879593] systemd[1]: Stopping Reactivate sysinit units... machine # [ 50.880797] systemd[1]: Reached target Reactivate sysinit units. machine # [ 50.882651] systemd[1]: Reached target Remote File Systems. machine # [ 50.886146] systemd[1]: Started autorestart.service. machine # [ 50.889611] systemd[1]: Starting linger-users.service... machine # [ 50.898460] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 50.900621] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 50.909041] systemd[1]: Reached target Local File Systems. machine # [ 50.911680] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 50.914090] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 50.914884] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 50.917599] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 50.921207] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 50.924295] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 50.925469] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 50.940433] systemd[1]: autorestart.service: Deactivated successfully. machine # [ 50.963534] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 50.965657] systemd[1]: Finished linger-users.service. machine # [ 51.076053] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 51.078319] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 51.336266] nixos[4461]: finished switching to system configuration /nix/store/xhdfhiqadvgg7mpyjj1annfrak1whbh8-nixos-system-machine-test machine: (finished: must succeed: /nix/store/jl59xgshkm15yy4qkh11f2517r2vlwz8-nixos-system-machine-test/specialisation/autorestartService/bin/switch-to-configuration test 2>&1, in 1.41 seconds) machine # [ 51.379463] systemd[1]: Stopped autorestart.service. machine: must succeed: /nix/store/jl59xgshkm15yy4qkh11f2517r2vlwz8-nixos-system-machine-test/specialisation/autorestartService/bin/switch-to-configuration test 2>&1 machine # [ 51.576514] nixos[4608]: switching to system configuration /nix/store/xhdfhiqadvgg7mpyjj1annfrak1whbh8-nixos-system-machine-test machine # [ 51.578867] systemd[1]: Stopped target Local File Systems. machine # [ 51.580572] systemd[1]: Stopped target Remote File Systems. machine # [ 51.805246] systemd[1]: Reload requested from client PID 4608 ('.switch-to-conf') (unit backdoor.service)... machine # [ 51.806933] systemd[1]: Reloading... machine # [ 52.049177] systemd[1]: Reloading finished in 241 ms. machine # [ 52.113899] systemd[621]: Reexecution requested from client PID 4677 ('switch-to-confi')... machine # [ 52.116893] systemd[621]: Reexecuting. machine # [ 52.141261] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 52.216321] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 52.221818] systemd[621]: Reload requested from client PID 4677 ('switch-to-confi')... machine # [ 52.223324] systemd[621]: Reloading... machine # [ 52.299130] systemd[621]: Reloading finished in 74 ms. machine # [ 52.304914] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 52.311509] systemd[621]: Stopped Run user-specific NixOS activation. machine # [ 52.312558] systemd[621]: Stopping Run user-specific NixOS activation... machine # [ 52.315343] systemd[621]: Starting Run user-specific NixOS activation... machine # [ 52.337325] systemd[621]: Finished Run user-specific NixOS activation. machine # [ 52.340846] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 52.342181] systemd[1]: Stopping Reactivate sysinit units... machine # [ 52.342934] systemd[1]: Reached target Reactivate sysinit units. machine # [ 52.345899] systemd[1]: Reached target Local File Systems. machine # [ 52.349626] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 52.351522] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 52.354615] systemd[1]: Reached target Remote File Systems. machine # [ 52.358069] systemd[1]: Started autorestart.service. machine # [ 52.360944] systemd[1]: Starting linger-users.service... machine # [ 52.365119] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 52.370539] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 52.371481] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 52.372621] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 52.374548] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 52.376029] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 52.377137] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 52.414575] systemd[1]: autorestart.service: Deactivated successfully. machine # [ 52.438841] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 52.440698] systemd[1]: Finished linger-users.service. machine # [ 52.545749] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 52.547477] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 52.803992] nixos[4608]: finished switching to system configuration /nix/store/xhdfhiqadvgg7mpyjj1annfrak1whbh8-nixos-system-machine-test machine: (finished: must succeed: /nix/store/jl59xgshkm15yy4qkh11f2517r2vlwz8-nixos-system-machine-test/specialisation/autorestartService/bin/switch-to-configuration test 2>&1, in 1.42 seconds) machine # [ 52.828931] systemd[1]: Stopped autorestart.service. machine: must fail: /nix/store/jl59xgshkm15yy4qkh11f2517r2vlwz8-nixos-system-machine-test/specialisation/autorestartServiceFailing/bin/switch-to-configuration test 2>&1 machine # [ 53.036360] nixos[4755]: switching to system configuration /nix/store/qs735x1zd5bcxi7vry6ra0h8wmnqq2bh-nixos-system-machine-test machine # [ 53.038776] systemd[1]: Stopped target Remote File Systems. machine # [ 53.040357] systemd[1]: Stopped target Local File Systems. machine # [ 53.283556] systemd[1]: Reload requested from client PID 4755 ('.switch-to-conf') (unit backdoor.service)... machine # [ 53.285378] systemd[1]: Reloading... machine # [ 53.556944] systemd[1]: Reloading finished in 269 ms. machine # [ 53.621299] systemd[621]: Reexecution requested from client PID 4824 ('switch-to-confi')... machine # [ 53.623682] systemd[621]: Reexecuting. machine # [ 53.644300] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 53.717709] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 53.722779] systemd[621]: Reload requested from client PID 4824 ('switch-to-confi')... machine # [ 53.724054] systemd[621]: Reloading... machine # [ 53.796713] systemd[621]: Reloading finished in 71 ms. machine # [ 53.802078] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 53.808362] systemd[621]: Stopped Run user-specific NixOS activation. machine # [ 53.810097] systemd[621]: Stopping Run user-specific NixOS activation... machine # [ 53.812070] systemd[621]: Starting Run user-specific NixOS activation... machine # [ 53.831446] systemd[621]: Finished Run user-specific NixOS activation. machine # [ 53.834774] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 53.835819] systemd[1]: Stopping Reactivate sysinit units... machine # [ 53.836888] systemd[1]: Reached target Reactivate sysinit units. machine # [ 53.840379] systemd[1]: Reached target Local File Systems. machine # [ 53.842291] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 53.844831] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 53.846294] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 53.848484] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 53.850488] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 53.851888] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 53.853129] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 53.859551] systemd[1]: Reached target Remote File Systems. machine # [ 53.864305] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 53.866519] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 53.992744] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 53.994413] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 53.998090] systemd[1]: Started autorestart.service. machine # [ 54.000671] systemd[1]: Starting linger-users.service... machine # [ 54.025122] systemd[1]: autorestart.service: Main process exited, code=exited, status=1/FAILURE machine # [ 54.027662] systemd[1]: autorestart.service: Failed with result 'exit-code'. machine # [ 54.042443] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 54.043826] systemd[1]: Finished linger-users.service. machine # [ 54.309923] nixos[4755]: switching to system configuration /nix/store/qs735x1zd5bcxi7vry6ra0h8wmnqq2bh-nixos-system-machine-test failed (status 4) machine: (finished: must fail: /nix/store/jl59xgshkm15yy4qkh11f2517r2vlwz8-nixos-system-machine-test/specialisation/autorestartServiceFailing/bin/switch-to-configuration test 2>&1, in 1.48 seconds) (finished: subtest: failing units, in 7.22 seconds) subtest: unit file parser machine: must succeed: /nix/store/jl59xgshkm15yy4qkh11f2517r2vlwz8-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1 machine # [ 54.478833] nixos[4898]: switching to system configuration /nix/store/asab2pibn678qzl68y0jh6br6655cynf-nixos-system-machine-test machine # [ 54.481053] systemd[1]: Stopped autorestart.service. machine # [ 54.482821] systemd[1]: Stopped target Local File Systems. machine # [ 54.484369] systemd[1]: Stopped target Remote File Systems. machine # [ 54.694757] systemd[1]: Reload requested from client PID 4898 ('.switch-to-conf') (unit backdoor.service)... machine # [ 54.696377] systemd[1]: Reloading... machine # [ 54.940910] systemd[1]: Reloading finished in 242 ms. machine # [ 54.998431] systemd[621]: Reexecution requested from client PID 4967 ('switch-to-confi')... machine # [ 55.000961] systemd[621]: Reexecuting. machine # [ 55.022200] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 55.093535] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 55.098960] systemd[621]: Reload requested from client PID 4967 ('switch-to-confi')... machine # [ 55.100375] systemd[621]: Reloading... machine # [ 55.173215] systemd[621]: Reloading finished in 71 ms. machine # [ 55.178837] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 55.185155] systemd[621]: Stopped Run user-specific NixOS activation. machine # [ 55.186958] systemd[621]: Stopping Run user-specific NixOS activation... machine # [ 55.188456] systemd[621]: Starting Run user-specific NixOS activation... machine # [ 55.205917] systemd[621]: Finished Run user-specific NixOS activation. machine # [ 55.208907] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 55.210233] systemd[1]: Stopping Reactivate sysinit units... machine # [ 55.210955] systemd[1]: Reached target Reactivate sysinit units. machine # [ 55.214845] systemd[1]: Reached target Local File Systems. machine # [ 55.217513] systemd[1]: Reached target Remote File Systems. machine # [ 55.220988] systemd[1]: Starting linger-users.service... machine # [ 55.223131] systemd[1]: Starting test.service... machine # [ 55.228446] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 55.233822] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 55.234643] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 55.235769] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 55.237664] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 55.239049] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 55.240164] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 55.247719] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 55.250438] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 55.272591] systemd[1]: Finished test.service. machine # [ 55.293445] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 55.295377] systemd[1]: Finished linger-users.service. machine # [ 55.390491] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 55.392220] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 55.650184] nixos[4898]: finished switching to system configuration /nix/store/asab2pibn678qzl68y0jh6br6655cynf-nixos-system-machine-test machine: (finished: must succeed: /nix/store/jl59xgshkm15yy4qkh11f2517r2vlwz8-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1, in 1.34 seconds) machine: must succeed: /nix/store/jl59xgshkm15yy4qkh11f2517r2vlwz8-nixos-system-machine-test/specialisation/simpleServiceWithExtraSection/bin/switch-to-configuration test 2>&1 machine # [ 55.878223] nixos[5040]: switching to system configuration /nix/store/lhdb8yqpymzjisp8j80rqyrmmqzr2jrq-nixos-system-machine-test machine # [ 55.881775] systemd[1]: Stopped target Remote File Systems. machine # [ 55.882860] systemd[1]: Stopped target Local File Systems. machine # [ 56.110369] systemd[1]: Reload requested from client PID 5040 ('.switch-to-conf') (unit backdoor.service)... machine # [ 56.112368] systemd[1]: Reloading... machine # [ 56.352519] systemd[1]: Reloading finished in 238 ms. machine # [ 56.418044] systemd[621]: Reexecution requested from client PID 5109 ('switch-to-confi')... machine # [ 56.419274] systemd[621]: Reexecuting. machine # [ 56.440046] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 56.518053] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 56.523208] systemd[621]: Reload requested from client PID 5109 ('switch-to-confi')... machine # [ 56.525050] systemd[621]: Reloading... machine # [ 56.594983] systemd[621]: Reloading finished in 69 ms. machine # [ 56.600891] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 56.607219] systemd[621]: Stopped Run user-specific NixOS activation. machine # [ 56.608055] systemd[621]: Stopping Run user-specific NixOS activation... machine # [ 56.610237] systemd[621]: Starting Run user-specific NixOS activation... machine # [ 56.629742] systemd[621]: Finished Run user-specific NixOS activation. machine # [ 56.632843] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 56.634212] systemd[1]: Stopping Reactivate sysinit units... machine # [ 56.634931] systemd[1]: Reached target Reactivate sysinit units. machine # [ 56.636949] systemd[1]: test.service: Deactivated successfully. machine # [ 56.638167] systemd[1]: Stopped test.service. machine # [ 56.638819] systemd[1]: Stopping test.service... machine # [ 56.641239] systemd[1]: Starting test.service... machine # [ 56.654614] systemd[1]: Finished test.service. machine # [ 56.658664] systemd[1]: Reached target Remote File Systems. machine # [ 56.660315] systemd[1]: Reached target Local File Systems. machine # [ 56.665216] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 56.669694] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 56.671169] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 56.672377] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 56.674371] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 56.675794] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 56.676939] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 56.683960] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 56.685177] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 56.808956] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 56.810570] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 56.814479] systemd[1]: Starting linger-users.service... machine # [ 56.841425] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 56.842867] systemd[1]: Finished linger-users.service. machine # [ 57.099098] nixos[5040]: finished switching to system configuration /nix/store/lhdb8yqpymzjisp8j80rqyrmmqzr2jrq-nixos-system-machine-test machine: (finished: must succeed: /nix/store/jl59xgshkm15yy4qkh11f2517r2vlwz8-nixos-system-machine-test/specialisation/simpleServiceWithExtraSection/bin/switch-to-configuration test 2>&1, in 1.45 seconds) machine: must succeed: /nix/store/jl59xgshkm15yy4qkh11f2517r2vlwz8-nixos-system-machine-test/specialisation/simpleServiceWithExtraSectionOtherName/bin/switch-to-configuration test 2>&1 machine # [ 57.297119] nixos[5182]: switching to system configuration /nix/store/dw12qn7hqfr19bcwrvx9w2jq19isjn1c-nixos-system-machine-test machine # [ 57.300869] systemd[1]: Stopped target Remote File Systems. machine # [ 57.301872] systemd[1]: Stopped target Local File Systems. machine # [ 57.525441] systemd[1]: Reload requested from client PID 5182 ('.switch-to-conf') (unit backdoor.service)... machine # [ 57.527120] systemd[1]: Reloading... machine # [ 57.773919] systemd[1]: Reloading finished in 243 ms. machine # [ 57.839329] systemd[621]: Reexecution requested from client PID 5251 ('switch-to-confi')... machine # [ 57.841957] systemd[621]: Reexecuting. machine # [ 57.861977] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 57.938073] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 57.943552] systemd[621]: Reload requested from client PID 5251 ('switch-to-confi')... machine # [ 57.945188] systemd[621]: Reloading... machine # [ 58.018912] systemd[621]: Reloading finished in 72 ms. machine # [ 58.024890] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 58.031903] systemd[621]: Stopped Run user-specific NixOS activation. machine # [ 58.032811] systemd[621]: Stopping Run user-specific NixOS activation... machine # [ 58.034487] systemd[621]: Starting Run user-specific NixOS activation... machine # [ 58.053291] systemd[621]: Finished Run user-specific NixOS activation. machine # [ 58.056315] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 58.057618] systemd[1]: Stopping Reactivate sysinit units... machine # [ 58.058554] systemd[1]: Reached target Reactivate sysinit units. machine # [ 58.060260] systemd[1]: test.service: Deactivated successfully. machine # [ 58.062247] systemd[1]: Stopped test.service. machine # [ 58.062889] systemd[1]: Stopping test.service... machine # [ 58.064272] systemd[1]: Starting test.service... machine # [ 58.077572] systemd[1]: Finished test.service. machine # [ 58.080504] systemd[1]: Reached target Local File Systems. machine # [ 58.082590] systemd[1]: Reached target Remote File Systems. machine # [ 58.085432] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 58.087135] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 58.091235] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 58.095061] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 58.095939] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 58.098128] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 58.100361] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 58.102785] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 58.106235] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 58.232658] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 58.236354] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 58.238255] systemd[1]: Starting linger-users.service... machine # [ 58.266339] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 58.267821] systemd[1]: Finished linger-users.service. machine # [ 58.525337] nixos[5182]: finished switching to system configuration /nix/store/dw12qn7hqfr19bcwrvx9w2jq19isjn1c-nixos-system-machine-test machine: (finished: must succeed: /nix/store/jl59xgshkm15yy4qkh11f2517r2vlwz8-nixos-system-machine-test/specialisation/simpleServiceWithExtraSectionOtherName/bin/switch-to-configuration test 2>&1, in 1.43 seconds) machine: must succeed: /nix/store/jl59xgshkm15yy4qkh11f2517r2vlwz8-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1 machine # [ 58.744250] nixos[5324]: switching to system configuration /nix/store/asab2pibn678qzl68y0jh6br6655cynf-nixos-system-machine-test machine # [ 58.746593] systemd[1]: Stopped target Remote File Systems. machine # [ 58.748647] systemd[1]: Stopped target Local File Systems. machine # [ 58.951302] systemd[1]: Reload requested from client PID 5324 ('.switch-to-conf') (unit backdoor.service)... machine # [ 58.952928] systemd[1]: Reloading... machine # [ 59.189726] systemd[1]: Reloading finished in 235 ms. machine # [ 59.253673] systemd[621]: Reexecution requested from client PID 5393 ('switch-to-confi')... machine # [ 59.255139] systemd[621]: Reexecuting. machine # [ 59.276026] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 59.347889] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 59.353620] systemd[621]: Reload requested from client PID 5393 ('switch-to-confi')... machine # [ 59.355917] systemd[621]: Reloading... machine # [ 59.429312] systemd[621]: Reloading finished in 73 ms. machine # [ 59.434834] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 59.441275] systemd[621]: Stopped Run user-specific NixOS activation. machine # [ 59.443057] systemd[621]: Stopping Run user-specific NixOS activation... machine # [ 59.444742] systemd[621]: Starting Run user-specific NixOS activation... machine # [ 59.465779] systemd[621]: Finished Run user-specific NixOS activation. machine # [ 59.468912] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 59.470283] systemd[1]: Stopping Reactivate sysinit units... machine # [ 59.471294] systemd[1]: Reached target Reactivate sysinit units. machine # [ 59.472932] systemd[1]: test.service: Deactivated successfully. machine # [ 59.474247] systemd[1]: Stopped test.service. machine # [ 59.474842] systemd[1]: Stopping test.service... machine # [ 59.477726] systemd[1]: Starting test.service... machine # [ 59.491195] systemd[1]: Finished test.service. machine # [ 59.494949] systemd[1]: Reached target Local File Systems. machine # [ 59.497334] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 59.499511] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 59.501324] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 59.503477] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 59.507110] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 59.508624] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 59.510275] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 59.512700] systemd[1]: Reached target Remote File Systems. machine # [ 59.518243] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 59.519509] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 59.654075] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 59.656408] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 59.660185] systemd[1]: Starting linger-users.service... machine # [ 59.687989] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 59.689457] systemd[1]: Finished linger-users.service. machine # [ 59.946591] nixos[5324]: finished switching to system configuration /nix/store/asab2pibn678qzl68y0jh6br6655cynf-nixos-system-machine-test machine: (finished: must succeed: /nix/store/jl59xgshkm15yy4qkh11f2517r2vlwz8-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1, in 1.42 seconds) machine: must succeed: /nix/store/jl59xgshkm15yy4qkh11f2517r2vlwz8-nixos-system-machine-test/specialisation/simpleServiceWithInstallSection/bin/switch-to-configuration test 2>&1 machine # [ 60.134352] nixos[5466]: switching to system configuration /nix/store/wfp32c9mcn93nvgvmmajxjsifc4gl51y-nixos-system-machine-test machine # [ 60.136714] systemd[1]: Stopped target Local File Systems. machine # [ 60.138824] systemd[1]: Stopped target Remote File Systems. machine # [ 60.367421] systemd[1]: Reload requested from client PID 5466 ('.switch-to-conf') (unit backdoor.service)... machine # [ 60.369106] systemd[1]: Reloading... machine # [ 60.615902] systemd[1]: Reloading finished in 245 ms. machine # [ 60.693670] systemd[621]: Reexecution requested from client PID 5535 ('switch-to-confi')... machine # [ 60.695521] systemd[621]: Reexecuting. machine # [ 60.717495] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 60.801244] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 60.805832] systemd[621]: Reload requested from client PID 5535 ('switch-to-confi')... machine # [ 60.807898] systemd[621]: Reloading... machine # [ 60.886518] systemd[621]: Reloading finished in 77 ms. machine # [ 60.892910] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 60.899443] systemd[621]: Stopped Run user-specific NixOS activation. machine # [ 60.901066] systemd[621]: Stopping Run user-specific NixOS activation... machine # [ 60.903115] systemd[621]: Starting Run user-specific NixOS activation... machine # [ 60.926563] systemd[621]: Finished Run user-specific NixOS activation. machine # [ 60.930202] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 60.931540] systemd[1]: Stopping Reactivate sysinit units... machine # [ 60.933301] systemd[1]: Reached target Reactivate sysinit units. machine # [ 60.935715] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 60.937719] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 60.939629] systemd[1]: Reached target Local File Systems. machine # [ 60.944486] systemd[1]: Reached target Remote File Systems. machine # [ 60.947865] systemd[1]: Starting linger-users.service... machine # [ 60.955633] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 60.959775] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 60.960567] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 60.961715] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 60.963650] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 60.965084] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 60.966302] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 61.007630] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 61.010076] systemd[1]: Finished linger-users.service. machine # [ 61.102301] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 61.104064] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 61.361659] nixos[5466]: finished switching to system configuration /nix/store/wfp32c9mcn93nvgvmmajxjsifc4gl51y-nixos-system-machine-test machine: (finished: must succeed: /nix/store/jl59xgshkm15yy4qkh11f2517r2vlwz8-nixos-system-machine-test/specialisation/simpleServiceWithInstallSection/bin/switch-to-configuration test 2>&1, in 1.42 seconds) machine: must succeed: /nix/store/jl59xgshkm15yy4qkh11f2517r2vlwz8-nixos-system-machine-test/specialisation/simpleServiceWithExtraKey/bin/switch-to-configuration test 2>&1 machine # [ 61.588360] nixos[5606]: switching to system configuration /nix/store/cpfhbgfbqnm4v7gsgavibx3hjfbvxq4i-nixos-system-machine-test machine # [ 61.590951] systemd[1]: Stopped target Remote File Systems. machine # [ 61.592550] systemd[1]: Stopped target Local File Systems. machine # [ 61.810826] systemd[1]: Reload requested from client PID 5606 ('.switch-to-conf') (unit backdoor.service)... machine # [ 61.812449] systemd[1]: Reloading... machine # [ 62.047847] systemd[1]: Reloading finished in 234 ms. machine # [ 62.110498] systemd[621]: Reexecution requested from client PID 5675 ('switch-to-confi')... machine # [ 62.113338] systemd[621]: Reexecuting. machine # [ 62.135574] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 62.209419] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 62.215244] systemd[621]: Reload requested from client PID 5675 ('switch-to-confi')... machine # [ 62.217057] systemd[621]: Reloading... machine # [ 62.287261] systemd[621]: Reloading finished in 69 ms. machine # [ 62.292912] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 62.299707] systemd[621]: Stopped Run user-specific NixOS activation. machine # [ 62.301234] systemd[621]: Stopping Run user-specific NixOS activation... machine # [ 62.303271] systemd[621]: Starting Run user-specific NixOS activation... machine # [ 62.323977] systemd[621]: Finished Run user-specific NixOS activation. machine # [ 62.327304] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 62.328611] systemd[1]: Stopping Reactivate sysinit units... machine # [ 62.329648] systemd[1]: Reached target Reactivate sysinit units. machine # [ 62.331412] systemd[1]: test.service: Deactivated successfully. machine # [ 62.333320] systemd[1]: Stopped test.service. machine # [ 62.333929] systemd[1]: Stopping test.service... machine # [ 62.335721] systemd[1]: Starting test.service... machine # [ 62.350569] systemd[1]: Finished test.service. machine # [ 62.355868] systemd[1]: Reached target Local File Systems. machine # [ 62.358803] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 62.360600] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 62.363944] systemd[1]: Reached target Remote File Systems. machine # [ 62.368134] systemd[1]: Starting linger-users.service... machine # [ 62.374788] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 62.377138] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 62.378052] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 62.379266] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 62.381178] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 62.384875] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 62.386147] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 62.430772] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 62.432848] systemd[1]: Finished linger-users.service. machine # [ 62.539835] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 62.541692] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 62.796697] nixos[5606]: finished switching to system configuration /nix/store/cpfhbgfbqnm4v7gsgavibx3hjfbvxq4i-nixos-system-machine-test machine: (finished: must succeed: /nix/store/jl59xgshkm15yy4qkh11f2517r2vlwz8-nixos-system-machine-test/specialisation/simpleServiceWithExtraKey/bin/switch-to-configuration test 2>&1, in 1.43 seconds) machine: must succeed: /nix/store/jl59xgshkm15yy4qkh11f2517r2vlwz8-nixos-system-machine-test/specialisation/simpleServiceWithExtraKeyOtherValue/bin/switch-to-configuration test 2>&1 machine # [ 62.977934] nixos[5748]: switching to system configuration /nix/store/922a53iq8bmy4ka1f1nc9k1v7ldd8507-nixos-system-machine-test machine # [ 62.980419] systemd[1]: Stopped target Local File Systems. machine # [ 62.982639] systemd[1]: Stopped target Remote File Systems. machine # [ 63.205875] systemd[1]: Reload requested from client PID 5748 ('.switch-to-conf') (unit backdoor.service)... machine # [ 63.207462] systemd[1]: Reloading... machine # [ 63.447121] systemd[1]: Reloading finished in 237 ms. machine # [ 63.512939] systemd[621]: Reexecution requested from client PID 5817 ('switch-to-confi')... machine # [ 63.515514] systemd[621]: Reexecuting. machine # [ 63.536055] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 63.607973] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 63.613389] systemd[621]: Reload requested from client PID 5817 ('switch-to-confi')... machine # [ 63.614724] systemd[621]: Reloading... machine # [ 63.679128] systemd[621]: Reloading finished in 63 ms. machine # [ 63.684800] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 63.691969] systemd[621]: Stopped Run user-specific NixOS activation. machine # [ 63.692876] systemd[621]: Stopping Run user-specific NixOS activation... machine # [ 63.694455] systemd[621]: Starting Run user-specific NixOS activation... machine # [ 63.734635] systemd[621]: Finished Run user-specific NixOS activation. machine # [ 63.737635] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 63.738902] systemd[1]: Stopping Reactivate sysinit units... machine # [ 63.739926] systemd[1]: Reached target Reactivate sysinit units. machine # [ 63.741717] systemd[1]: test.service: Deactivated successfully. machine # [ 63.743087] systemd[1]: Stopped test.service. machine # [ 63.743728] systemd[1]: Stopping test.service... machine # [ 63.745943] systemd[1]: Starting test.service... machine # [ 63.758901] systemd[1]: Finished test.service. machine # [ 63.763878] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 63.765616] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 63.770617] systemd[1]: Reached target Local File Systems. machine # [ 63.772401] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 63.774471] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 63.776460] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 63.778339] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 63.780232] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 63.781611] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 63.782729] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 63.786298] systemd[1]: Reached target Remote File Systems. machine # [ 63.912413] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 63.913994] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 63.917935] systemd[1]: Starting linger-users.service... machine # [ 63.945315] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 63.946774] systemd[1]: Finished linger-users.service. machine # [ 64.200907] nixos[5748]: finished switching to system configuration /nix/store/922a53iq8bmy4ka1f1nc9k1v7ldd8507-nixos-system-machine-test machine: (finished: must succeed: /nix/store/jl59xgshkm15yy4qkh11f2517r2vlwz8-nixos-system-machine-test/specialisation/simpleServiceWithExtraKeyOtherValue/bin/switch-to-configuration test 2>&1, in 1.40 seconds) machine: must succeed: /nix/store/jl59xgshkm15yy4qkh11f2517r2vlwz8-nixos-system-machine-test/specialisation/simpleServiceWithExtraKeyOtherName/bin/switch-to-configuration test 2>&1 machine # [ 64.424709] nixos[5890]: switching to system configuration /nix/store/5x9i00jq7qak0h6yh7lb1virmmi1r49h-nixos-system-machine-test machine # [ 64.428264] systemd[1]: Stopped target Remote File Systems. machine # [ 64.429224] systemd[1]: Stopped target Local File Systems. machine # [ 64.644617] systemd[1]: Reload requested from client PID 5890 ('.switch-to-conf') (unit backdoor.service)... machine # [ 64.646313] systemd[1]: Reloading... machine # [ 64.884157] systemd[1]: Reloading finished in 236 ms. machine # [ 64.944266] systemd[621]: Reexecution requested from client PID 5959 ('switch-to-confi')... machine # [ 64.946145] systemd[621]: Reexecuting. machine # [ 64.967083] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 65.042529] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 65.047949] systemd[621]: Reload requested from client PID 5959 ('switch-to-confi')... machine # [ 65.049157] systemd[621]: Reloading... machine # [ 65.121354] systemd[621]: Reloading finished in 70 ms. machine # [ 65.126836] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 65.133033] systemd[621]: Stopped Run user-specific NixOS activation. machine # [ 65.133973] systemd[621]: Stopping Run user-specific NixOS activation... machine # [ 65.136419] systemd[621]: Starting Run user-specific NixOS activation... machine # [ 65.157340] systemd[621]: Finished Run user-specific NixOS activation. machine # [ 65.160273] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 65.161615] systemd[1]: Stopping Reactivate sysinit units... machine # [ 65.163056] systemd[1]: Reached target Reactivate sysinit units. machine # [ 65.164244] systemd[1]: test.service: Deactivated successfully. machine # [ 65.166169] systemd[1]: Stopped test.service. machine # [ 65.166796] systemd[1]: Stopping test.service... machine # [ 65.168404] systemd[1]: Starting test.service... machine # [ 65.184765] systemd[1]: Finished test.service. machine # [ 65.189505] systemd[1]: Reached target Remote File Systems. machine # [ 65.192153] systemd[1]: Starting linger-users.service... machine # [ 65.197319] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 65.198588] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 65.202054] systemd[1]: Reached target Local File Systems. machine # [ 65.204810] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 65.208315] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 65.209428] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 65.211168] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 65.213948] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 65.216569] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 65.219464] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 65.254084] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 65.255592] systemd[1]: Finished linger-users.service. machine # [ 65.360975] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 65.362833] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 65.620928] nixos[5890]: finished switching to system configuration /nix/store/5x9i00jq7qak0h6yh7lb1virmmi1r49h-nixos-system-machine-test machine: (finished: must succeed: /nix/store/jl59xgshkm15yy4qkh11f2517r2vlwz8-nixos-system-machine-test/specialisation/simpleServiceWithExtraKeyOtherName/bin/switch-to-configuration test 2>&1, in 1.42 seconds) machine: must succeed: /nix/store/jl59xgshkm15yy4qkh11f2517r2vlwz8-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1 machine # [ 65.836265] nixos[6032]: switching to system configuration /nix/store/asab2pibn678qzl68y0jh6br6655cynf-nixos-system-machine-test machine # [ 65.839594] systemd[1]: Stopped target Local File Systems. machine # [ 65.840731] systemd[1]: Stopped target Remote File Systems. machine # [ 66.040783] systemd[1]: Reload requested from client PID 6032 ('.switch-to-conf') (unit backdoor.service)... machine # [ 66.042447] systemd[1]: Reloading... machine # [ 66.269747] systemd[1]: Reloading finished in 226 ms. machine # [ 66.330539] systemd[621]: Reexecution requested from client PID 6101 ('switch-to-confi')... machine # [ 66.332243] systemd[621]: Reexecuting. machine # [ 66.352034] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 66.423084] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 66.428178] systemd[621]: Reload requested from client PID 6101 ('switch-to-confi')... machine # [ 66.429794] systemd[621]: Reloading... machine # [ 66.502638] systemd[621]: Reloading finished in 71 ms. machine # [ 66.506823] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 66.512760] systemd[621]: Stopped Run user-specific NixOS activation. machine # [ 66.514223] systemd[621]: Stopping Run user-specific NixOS activation... machine # [ 66.516325] systemd[621]: Starting Run user-specific NixOS activation... machine # [ 66.536044] systemd[621]: Finished Run user-specific NixOS activation. machine # [ 66.539062] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 66.540265] systemd[1]: Stopping Reactivate sysinit units... machine # [ 66.541335] systemd[1]: Reached target Reactivate sysinit units. machine # [ 66.543053] systemd[1]: test.service: Deactivated successfully. machine # [ 66.545056] systemd[1]: Stopped test.service. machine # [ 66.545712] systemd[1]: Stopping test.service... machine # [ 66.546971] systemd[1]: Starting test.service... machine # [ 66.561304] systemd[1]: Finished test.service. machine # [ 66.568899] systemd[1]: Reached target Local File Systems. machine # [ 66.571103] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 66.574305] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 66.575107] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 66.576938] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 66.578994] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 66.580536] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 66.581747] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 66.586527] systemd[1]: Reached target Remote File Systems. machine # [ 66.590409] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 66.591667] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 66.710949] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 66.712737] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 66.716549] systemd[1]: Starting linger-users.service... machine # [ 66.741741] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 66.743219] systemd[1]: Finished linger-users.service. machine # [ 66.999501] nixos[6032]: finished switching to system configuration /nix/store/asab2pibn678qzl68y0jh6br6655cynf-nixos-system-machine-test machine: (finished: must succeed: /nix/store/jl59xgshkm15yy4qkh11f2517r2vlwz8-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1, in 1.38 seconds) machine: must succeed: /nix/store/jl59xgshkm15yy4qkh11f2517r2vlwz8-nixos-system-machine-test/specialisation/simpleServiceReloadTrigger/bin/switch-to-configuration test 2>&1 machine # [ 67.231336] nixos[6174]: switching to system configuration /nix/store/scw2b9filnwwdylysi2cb9adnfd655q3-nixos-system-machine-test machine # [ 67.233649] systemd[1]: Stopped target Local File Systems. machine # [ 67.235344] systemd[1]: Stopped target Remote File Systems. machine # [ 67.455357] systemd[1]: Reload requested from client PID 6174 ('.switch-to-conf') (unit backdoor.service)... machine # [ 67.457106] systemd[1]: Reloading... machine # [ 67.698824] systemd[1]: Reloading finished in 240 ms. machine # [ 67.764464] systemd[621]: Reexecution requested from client PID 6243 ('switch-to-confi')... machine # [ 67.765769] systemd[621]: Reexecuting. machine # [ 67.785977] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 67.856798] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 67.862743] systemd[621]: Reload requested from client PID 6243 ('switch-to-confi')... machine # [ 67.863975] systemd[621]: Reloading... machine # [ 67.937396] systemd[621]: Reloading finished in 71 ms. machine # [ 67.942845] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 67.948912] systemd[621]: Stopped Run user-specific NixOS activation. machine # [ 67.949907] systemd[621]: Stopping Run user-specific NixOS activation... machine # [ 67.952349] systemd[621]: Starting Run user-specific NixOS activation... machine # [ 67.970773] systemd[621]: Finished Run user-specific NixOS activation. machine # [ 67.973741] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 67.975378] systemd[1]: Stopping Reactivate sysinit units... machine # [ 67.976463] systemd[1]: Reached target Reactivate sysinit units. machine # [ 67.979451] systemd[1]: Reloading test.service... machine # [ 67.991770] systemd[1]: Reloaded test.service. machine # [ 67.996044] systemd[1]: Reached target Remote File Systems. machine # [ 67.998686] systemd[1]: Starting linger-users.service... machine # [ 68.002474] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 68.003739] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 68.010304] systemd[1]: Reached target Local File Systems. machine # [ 68.011092] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 68.014597] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 68.015981] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 68.018524] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 68.022132] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 68.024427] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 68.025970] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 68.061416] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 68.062919] systemd[1]: Finished linger-users.service. machine # [ 68.169978] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 68.171777] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 68.427490] nixos[6174]: finished switching to system configuration /nix/store/scw2b9filnwwdylysi2cb9adnfd655q3-nixos-system-machine-test machine: (finished: must succeed: /nix/store/jl59xgshkm15yy4qkh11f2517r2vlwz8-nixos-system-machine-test/specialisation/simpleServiceReloadTrigger/bin/switch-to-configuration test 2>&1, in 1.42 seconds) machine: must succeed: /nix/store/jl59xgshkm15yy4qkh11f2517r2vlwz8-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModified/bin/switch-to-configuration test 2>&1 machine # [ 68.625424] nixos[6316]: switching to system configuration /nix/store/rf70qplhzs0yi39x23kzlxij93511dpf-nixos-system-machine-test machine # [ 68.628945] systemd[1]: Stopped target Local File Systems. machine # [ 68.629943] systemd[1]: Stopped target Remote File Systems. machine # [ 68.850910] systemd[1]: Reload requested from client PID 6316 ('.switch-to-conf') (unit backdoor.service)... machine # [ 68.852610] systemd[1]: Reloading... machine # [ 69.092117] systemd[1]: Reloading finished in 237 ms. machine # [ 69.153362] systemd[621]: Reexecution requested from client PID 6385 ('switch-to-confi')... machine # [ 69.155935] systemd[621]: Reexecuting. machine # [ 69.172973] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 69.245695] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 69.251052] systemd[621]: Reload requested from client PID 6385 ('switch-to-confi')... machine # [ 69.252899] systemd[621]: Reloading... machine # [ 69.324830] systemd[621]: Reloading finished in 71 ms. machine # [ 69.330823] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 69.336990] systemd[621]: Stopped Run user-specific NixOS activation. machine # [ 69.338918] systemd[621]: Stopping Run user-specific NixOS activation... machine # [ 69.340531] systemd[621]: Starting Run user-specific NixOS activation... machine # [ 69.359427] systemd[621]: Finished Run user-specific NixOS activation. machine # [ 69.362332] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 69.363854] systemd[1]: Stopping Reactivate sysinit units... machine # [ 69.366112] systemd[1]: Reached target Reactivate sysinit units. machine # [ 69.367847] systemd[1]: Reloading test.service... machine # [ 69.381667] systemd[1]: Reloaded test.service. machine # [ 69.387174] systemd[1]: Reached target Local File Systems. machine # [ 69.387980] systemd[1]: Reached target Remote File Systems. machine # [ 69.389645] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 69.392208] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 69.392987] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 69.395310] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 69.397960] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 69.401325] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 69.402585] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 69.407732] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 69.409209] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 69.534395] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 69.535966] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 69.540304] systemd[1]: Starting linger-users.service... machine # [ 69.568878] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 69.570390] systemd[1]: Finished linger-users.service. machine # [ 69.827829] nixos[6316]: finished switching to system configuration /nix/store/rf70qplhzs0yi39x23kzlxij93511dpf-nixos-system-machine-test machine: (finished: must succeed: /nix/store/jl59xgshkm15yy4qkh11f2517r2vlwz8-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModified/bin/switch-to-configuration test 2>&1, in 1.40 seconds) machine: must succeed: /nix/store/jl59xgshkm15yy4qkh11f2517r2vlwz8-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModifiedAndSomethingElse/bin/switch-to-configuration test 2>&1 machine # [ 70.061227] nixos[6458]: switching to system configuration /nix/store/jsyav48wk1b9bg6rii8g4wxqld702ck6-nixos-system-machine-test machine # [ 70.064771] systemd[1]: Stopped target Remote File Systems. machine # [ 70.065752] systemd[1]: Stopped target Local File Systems. machine # [ 70.286901] systemd[1]: Reload requested from client PID 6458 ('.switch-to-conf') (unit backdoor.service)... machine # [ 70.288628] systemd[1]: Reloading... machine # [ 70.529989] systemd[1]: Reloading finished in 240 ms. machine # [ 70.590317] systemd[621]: Reexecution requested from client PID 6527 ('switch-to-confi')... machine # [ 70.592411] systemd[621]: Reexecuting. machine # [ 70.613035] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 70.684578] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 70.689812] systemd[621]: Reload requested from client PID 6527 ('switch-to-confi')... machine # [ 70.691287] systemd[621]: Reloading... machine # [ 70.762448] systemd[621]: Reloading finished in 70 ms. machine # [ 70.767820] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 70.773966] systemd[621]: Stopped Run user-specific NixOS activation. machine # [ 70.775054] systemd[621]: Stopping Run user-specific NixOS activation... machine # [ 70.777677] systemd[621]: Starting Run user-specific NixOS activation... machine # [ 70.796059] systemd[621]: Finished Run user-specific NixOS activation. machine # [ 70.798953] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 70.800362] systemd[1]: Stopping Reactivate sysinit units... machine # [ 70.801393] systemd[1]: Reached target Reactivate sysinit units. machine # [ 70.802981] systemd[1]: test.service: Deactivated successfully. machine # [ 70.804188] systemd[1]: Stopped test.service. machine # [ 70.804800] systemd[1]: Stopping test.service... machine # [ 70.807191] systemd[1]: Starting test.service... machine # [ 70.821256] systemd[1]: Finished test.service. machine # [ 70.823725] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 70.825755] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 70.831935] systemd[1]: Reached target Local File Systems. machine # [ 70.833227] systemd[1]: Reached target Remote File Systems. machine # [ 70.833986] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 70.837209] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 70.837984] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 70.840745] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 70.844151] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 70.845622] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 70.847385] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 70.973701] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 70.975374] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 70.979233] systemd[1]: Starting linger-users.service... machine # [ 71.006357] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 71.007775] systemd[1]: Finished linger-users.service. machine # [ 71.264969] nixos[6458]: finished switching to system configuration /nix/store/jsyav48wk1b9bg6rii8g4wxqld702ck6-nixos-system-machine-test machine: (finished: must succeed: /nix/store/jl59xgshkm15yy4qkh11f2517r2vlwz8-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModifiedAndSomethingElse/bin/switch-to-configuration test 2>&1, in 1.44 seconds) machine: must succeed: /nix/store/jl59xgshkm15yy4qkh11f2517r2vlwz8-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModifiedSomethingElse/bin/switch-to-configuration test 2>&1 machine # [ 71.442084] nixos[6600]: switching to system configuration /nix/store/cpfhbgfbqnm4v7gsgavibx3hjfbvxq4i-nixos-system-machine-test machine # [ 71.444702] systemd[1]: Stopped target Remote File Systems. machine # [ 71.446583] systemd[1]: Stopped target Local File Systems. machine # [ 71.647371] systemd[1]: Reload requested from client PID 6600 ('.switch-to-conf') (unit backdoor.service)... machine # [ 71.649202] systemd[1]: Reloading... machine # [ 71.881148] systemd[1]: Reloading finished in 230 ms. machine # [ 71.945179] systemd[621]: Reexecution requested from client PID 6669 ('switch-to-confi')... machine # [ 71.946724] systemd[621]: Reexecuting. machine # [ 71.966218] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 72.037361] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 72.042806] systemd[621]: Reload requested from client PID 6669 ('switch-to-confi')... machine # [ 72.044437] systemd[621]: Reloading... machine # [ 72.118456] systemd[621]: Reloading finished in 72 ms. machine # [ 72.123819] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 72.130109] systemd[621]: Stopped Run user-specific NixOS activation. machine # [ 72.132064] systemd[621]: Stopping Run user-specific NixOS activation... machine # [ 72.133835] systemd[621]: Starting Run user-specific NixOS activation... machine # [ 72.153095] systemd[621]: Finished Run user-specific NixOS activation. machine # [ 72.156067] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 72.157524] systemd[1]: Stopping Reactivate sysinit units... machine # [ 72.158478] systemd[1]: Reached target Reactivate sysinit units. machine # [ 72.165479] systemd[1]: Reached target Local File Systems. machine # [ 72.167533] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 72.168843] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 72.170045] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 72.172230] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 72.175446] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 72.176719] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 72.179212] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 72.180648] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 72.181822] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 72.186226] systemd[1]: Reached target Remote File Systems. machine # [ 72.302431] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 72.304067] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 72.307483] systemd[1]: Starting linger-users.service... machine # [ 72.333281] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 72.334741] systemd[1]: Finished linger-users.service. machine # [ 72.592202] nixos[6600]: finished switching to system configuration /nix/store/cpfhbgfbqnm4v7gsgavibx3hjfbvxq4i-nixos-system-machine-test machine: (finished: must succeed: /nix/store/jl59xgshkm15yy4qkh11f2517r2vlwz8-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModifiedSomethingElse/bin/switch-to-configuration test 2>&1, in 1.33 seconds) (finished: subtest: unit file parser, in 18.29 seconds) subtest: restart and reload by activation script machine: must succeed: /nix/store/jl59xgshkm15yy4qkh11f2517r2vlwz8-nixos-system-machine-test/specialisation/simpleServiceNorestart/bin/switch-to-configuration test 2>&1 machine # [ 72.768941] nixos[6740]: switching to system configuration /nix/store/ymb9214cy0vcv9lwcm90pczcqwj1x37g-nixos-system-machine-test machine # [ 72.772452] systemd[1]: Stopped target Remote File Systems. machine # [ 72.773546] systemd[1]: Stopped target Local File Systems. machine # [ 72.960258] systemd[1]: Reload requested from client PID 6740 ('.switch-to-conf') (unit backdoor.service)... machine # [ 72.961847] systemd[1]: Reloading... machine # [ 73.200076] systemd[1]: Reloading finished in 236 ms. machine # [ 73.258313] systemd[621]: Reexecution requested from client PID 6809 ('switch-to-confi')... machine # [ 73.260361] systemd[621]: Reexecuting. machine # [ 73.281329] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 73.346748] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 73.352052] systemd[621]: Reload requested from client PID 6809 ('switch-to-confi')... machine # [ 73.353566] systemd[621]: Reloading... machine # [ 73.423626] systemd[621]: Reloading finished in 69 ms. machine # [ 73.428823] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 73.435364] systemd[621]: Stopped Run user-specific NixOS activation. machine # [ 73.437158] systemd[621]: Stopping Run user-specific NixOS activation... machine # [ 73.438846] systemd[621]: Starting Run user-specific NixOS activation... machine # [ 73.457901] systemd[621]: Finished Run user-specific NixOS activation. machine # [ 73.460957] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 73.462235] systemd[1]: Stopping Reactivate sysinit units... machine # [ 73.463886] systemd[1]: Reached target Reactivate sysinit units. machine # [ 73.465408] systemd[1]: Reached target Remote File Systems. machine # [ 73.467438] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 73.469261] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 73.471836] systemd[1]: Reached target Local File Systems. machine # [ 73.474252] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 73.477426] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 73.478261] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 73.479468] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 73.481410] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 73.482866] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 73.484169] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 73.612578] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 73.614216] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 73.617860] systemd[1]: Starting linger-users.service... machine # [ 73.645512] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 73.647073] systemd[1]: Finished linger-users.service. machine # [ 73.904594] nixos[6740]: finished switching to system configuration /nix/store/ymb9214cy0vcv9lwcm90pczcqwj1x37g-nixos-system-machine-test machine: (finished: must succeed: /nix/store/jl59xgshkm15yy4qkh11f2517r2vlwz8-nixos-system-machine-test/specialisation/simpleServiceNorestart/bin/switch-to-configuration test 2>&1, in 1.31 seconds) machine: must succeed: /nix/store/jl59xgshkm15yy4qkh11f2517r2vlwz8-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration test 2>&1 machine # [ 74.129156] nixos[6880]: switching to system configuration /nix/store/0l7hzrhj0j9l93kcyq6cs3bmyqpf7mh3-nixos-system-machine-test machine # [ 74.131825] systemd[1]: test.service: Deactivated successfully. machine # [ 74.132928] systemd[1]: Stopped test.service. machine # [ 74.134114] systemd[1]: Stopped target Remote File Systems. machine # [ 74.135598] systemd[1]: Stopped target Local File Systems. machine # [ 74.354857] systemd[1]: Reload requested from client PID 6880 ('.switch-to-conf') (unit backdoor.service)... machine # [ 74.356642] systemd[1]: Reloading... machine # [ 74.607537] systemd[1]: Reloading finished in 249 ms. machine # [ 74.667713] systemd[621]: Reexecution requested from client PID 6951 ('switch-to-confi')... machine # [ 74.670263] systemd[621]: Reexecuting. machine # [ 74.690978] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 74.761790] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 74.767642] systemd[621]: Reload requested from client PID 6951 ('switch-to-confi')... machine # [ 74.768874] systemd[621]: Reloading... machine # [ 74.840739] systemd[621]: Reloading finished in 70 ms. machine # [ 74.845829] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 74.851903] systemd[621]: Stopped Run user-specific NixOS activation. machine # [ 74.852967] systemd[621]: Stopping Run user-specific NixOS activation... machine # [ 74.855600] systemd[621]: Starting Run user-specific NixOS activation... machine # [ 74.873983] systemd[621]: Finished Run user-specific NixOS activation. machine # [ 74.876874] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 74.878227] systemd[1]: Stopping Reactivate sysinit units... machine # [ 74.878968] systemd[1]: Reached target Reactivate sysinit units. machine # [ 74.886925] systemd[1]: Created slice Slice /system/templated-no-restart-service. machine # [ 74.888834] systemd[1]: Created slice Slice /system/templated-simple-reload-service. machine # [ 74.891558] systemd[1]: Starting templated-no-restart-service@instance.service... machine # [ 74.894108] systemd[1]: Starting templated-simple-reload-service@instance.service... machine # [ 74.897487] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 74.898826] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 74.907966] systemd[1]: Starting simple-reload-service.service... machine # [ 74.913894] systemd[1]: Starting reload-triggers-and-restart-by-as.service... machine # [ 74.918947] systemd[1]: Reached target Remote File Systems. machine # [ 74.926494] systemd[1]: Created slice Slice /system/templated-reload-triggers-and-restart-by-as. machine # [ 74.928840] systemd[1]: Starting templated-reload-triggers-and-restart-by-as@instance.service... machine # [ 74.932427] systemd[1]: Reached target Local File Systems. machine # [ 74.942559] systemd[1]: Starting no-restart-service.service... machine # [ 74.952130] systemd[1]: Created slice Slice /system/templated-simple-service. machine # [ 74.955467] systemd[1]: Starting templated-simple-service@instance.service... machine # [ 74.966100] systemd[1]: Created slice Slice /system/templated-reload-triggers. machine # [ 74.969142] systemd[1]: Created slice Slice /system/templated-reload-triggers-and-restart. machine # [ 74.973166] systemd[1]: Starting linger-users.service... machine # [ 74.977898] systemd[1]: Starting reload-triggers-and-restart.service... machine # [ 74.980811] systemd[1]: Starting reload-triggers.service... machine # [ 74.986873] systemd[1]: Starting templated-reload-triggers-and-restart@instance.service... machine # [ 74.992361] systemd[1]: Starting templated-reload-triggers@instance.service... machine # [ 75.011644] systemd[1]: Starting simple-restart-service.service... machine # [ 75.012582] systemd[1]: Finished templated-no-restart-service@instance.service. machine # [ 75.015356] systemd[1]: Finished templated-simple-reload-service@instance.service. machine # [ 75.032223] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 75.033753] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 75.034595] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 75.035745] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 75.037754] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 75.039242] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 75.049235] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 75.054506] systemd[1]: Finished simple-reload-service.service. machine # [ 75.058449] systemd[1]: Created slice Slice /system/templated-simple-restart-service. machine # [ 75.071543] systemd[1]: Finished reload-triggers-and-restart-by-as.service. machine # [ 75.095321] systemd[1]: Finished templated-reload-triggers-and-restart-by-as@instance.service. machine # [ 75.099504] systemd[1]: Finished no-restart-service.service. machine # [ 75.113189] systemd[1]: Finished templated-simple-service@instance.service. machine # [ 75.126234] systemd[1]: Finished reload-triggers.service. machine # [ 75.130597] systemd[1]: Finished reload-triggers-and-restart.service. machine # [ 75.131637] systemd[1]: Finished templated-reload-triggers@instance.service. machine # [ 75.138876] systemd[1]: Finished templated-reload-triggers-and-restart@instance.service. machine # [ 75.147777] systemd[1]: Finished simple-restart-service.service. machine # [ 75.165072] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 75.168097] systemd[1]: Finished linger-users.service. machine # [ 75.272258] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 75.273965] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 75.278134] systemd[1]: Starting simple-service.service... machine # [ 75.280637] systemd[1]: Starting templated-simple-restart-service@instance.service... machine # [ 75.303478] systemd[1]: Finished simple-service.service. machine # [ 75.305441] systemd[1]: Finished templated-simple-restart-service@instance.service. machine # [ 75.563215] nixos[6880]: finished switching to system configuration /nix/store/0l7hzrhj0j9l93kcyq6cs3bmyqpf7mh3-nixos-system-machine-test machine: (finished: must succeed: /nix/store/jl59xgshkm15yy4qkh11f2517r2vlwz8-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration test 2>&1, in 1.66 seconds) machine: must succeed: /nix/store/jl59xgshkm15yy4qkh11f2517r2vlwz8-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration test 2>&1 machine # [ 75.812207] nixos[7050]: switching to system configuration /nix/store/0l7hzrhj0j9l93kcyq6cs3bmyqpf7mh3-nixos-system-machine-test machine # [ 75.814418] systemd[1]: Stopped target Local File Systems. machine # [ 75.815986] systemd[1]: Stopped target Remote File Systems. machine # [ 76.032663] systemd[1]: Reload requested from client PID 7050 ('.switch-to-conf') (unit backdoor.service)... machine # [ 76.034290] systemd[1]: Reloading... machine # [ 76.278193] systemd[1]: Reloading finished in 241 ms. machine # [ 76.339661] systemd[621]: Reexecution requested from client PID 7121 ('switch-to-confi')... machine # [ 76.341980] systemd[621]: Reexecuting. machine # [ 76.362944] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 76.434179] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 76.439074] systemd[621]: Reload requested from client PID 7121 ('switch-to-confi')... machine # [ 76.440664] systemd[621]: Reloading... machine # [ 76.511815] systemd[621]: Reloading finished in 69 ms. machine # [ 76.517826] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 76.524221] systemd[621]: Stopped Run user-specific NixOS activation. machine # [ 76.526058] systemd[621]: Stopping Run user-specific NixOS activation... machine # [ 76.527556] systemd[621]: Starting Run user-specific NixOS activation... machine # [ 76.545944] systemd[621]: Finished Run user-specific NixOS activation. machine # [ 76.548875] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 76.550287] systemd[1]: Stopping Reactivate sysinit units... machine # [ 76.551289] systemd[1]: Reached target Reactivate sysinit units. machine # [ 76.555791] systemd[1]: Reloading reload-triggers-and-restart.service... machine # [ 76.561865] systemd[1]: Reloading reload-triggers.service... machine # [ 76.569079] systemd[1]: Reloading simple-reload-service.service... machine # [ 76.573261] systemd[1]: Reloading templated-reload-triggers-and-restart@instance.service... machine # [ 76.577351] systemd[1]: Reloading templated-reload-triggers@instance.service... machine # [ 76.582196] systemd[1]: Reloading templated-simple-reload-service@instance.service... machine # [ 76.611139] systemd[1]: Reloaded reload-triggers-and-restart.service. machine # [ 76.626115] systemd[1]: Reloaded reload-triggers.service. machine # [ 76.634621] systemd[1]: Reloaded simple-reload-service.service. machine # [ 76.636707] systemd[1]: Reloaded templated-reload-triggers-and-restart@instance.service. machine # [ 76.638840] systemd[1]: Reloaded templated-reload-triggers@instance.service. machine # [ 76.640950] systemd[1]: Reloaded templated-simple-reload-service@instance.service. machine # [ 76.644774] systemd[1]: reload-triggers-and-restart-by-as.service: Deactivated successfully. machine # [ 76.647210] systemd[1]: Stopped reload-triggers-and-restart-by-as.service. machine # [ 76.648195] systemd[1]: Stopping reload-triggers-and-restart-by-as.service... machine # [ 76.650072] systemd[1]: Starting reload-triggers-and-restart-by-as.service... machine # [ 76.650981] systemd[1]: simple-restart-service.service: Deactivated successfully. machine # [ 76.653081] systemd[1]: Stopped simple-restart-service.service. machine # [ 76.653941] systemd[1]: Stopping simple-restart-service.service... machine # [ 76.656277] systemd[1]: Starting simple-restart-service.service... machine # [ 76.658324] systemd[1]: simple-service.service: Deactivated successfully. machine # [ 76.659237] systemd[1]: Stopped simple-service.service. machine # [ 76.659986] systemd[1]: Stopping simple-service.service... machine # [ 76.663293] systemd[1]: Starting simple-service.service... machine # [ 76.668139] systemd[1]: templated-reload-triggers-and-restart-by-as@instance.service: Deactivated successfully. machine # [ 76.669444] systemd[1]: Stopped templated-reload-triggers-and-restart-by-as@instance.service. machine # [ 76.670569] systemd[1]: Stopping templated-reload-triggers-and-restart-by-as@instance.service... machine # [ 76.671661] systemd[1]: Starting templated-reload-triggers-and-restart-by-as@instance.service... machine # [ 76.674412] systemd[1]: templated-simple-restart-service@instance.service: Deactivated successfully. machine # [ 76.676470] systemd[1]: Stopped templated-simple-restart-service@instance.service. machine # [ 76.681636] systemd[1]: Stopping templated-simple-restart-service@instance.service... machine # [ 76.682725] systemd[1]: Starting templated-simple-restart-service@instance.service... machine # [ 76.688769] systemd[1]: templated-simple-service@instance.service: Deactivated successfully. machine # [ 76.689917] systemd[1]: Stopped templated-simple-service@instance.service. machine # [ 76.690850] systemd[1]: Stopping templated-simple-service@instance.service... machine # [ 76.693065] systemd[1]: Starting templated-simple-service@instance.service... machine # [ 76.735252] systemd[1]: Finished reload-triggers-and-restart-by-as.service. machine # [ 76.736973] systemd[1]: Finished simple-service.service. machine # [ 76.739480] systemd[1]: Finished simple-restart-service.service. machine # [ 76.745278] systemd[1]: Finished templated-reload-triggers-and-restart-by-as@instance.service. machine # [ 76.749464] systemd[1]: Finished templated-simple-restart-service@instance.service. machine # [ 76.756109] systemd[1]: Finished templated-simple-service@instance.service. machine # [ 76.758806] systemd[1]: Reached target Remote File Systems. machine # [ 76.765532] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 76.767330] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 76.770683] systemd[1]: Reached target Local File Systems. machine # [ 76.773134] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 76.776518] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 76.777669] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 76.779566] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 76.782410] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 76.783844] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 76.787427] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 76.919854] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 76.921719] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 76.926261] systemd[1]: Starting linger-users.service... machine # [ 76.956265] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 76.958701] systemd[1]: Finished linger-users.service. machine # [ 77.216419] nixos[7050]: finished switching to system configuration /nix/store/0l7hzrhj0j9l93kcyq6cs3bmyqpf7mh3-nixos-system-machine-test machine: (finished: must succeed: /nix/store/jl59xgshkm15yy4qkh11f2517r2vlwz8-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration test 2>&1, in 1.65 seconds) machine: must succeed: /nix/store/jl59xgshkm15yy4qkh11f2517r2vlwz8-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script-modified/bin/switch-to-configuration test 2>&1 machine # [ 77.524913] nixos[7216]: switching to system configuration /nix/store/jgpi4dwqxjbbn6nfq91a2kk4g995k8yf-nixos-system-machine-test machine # [ 77.528880] systemd[1]: Stopped target Local File Systems. machine # [ 77.529841] systemd[1]: Stopped target Remote File Systems. machine # [ 77.792892] systemd[1]: Reload requested from client PID 7216 ('.switch-to-conf') (unit backdoor.service)... machine # [ 77.794551] systemd[1]: Reloading... machine # [ 78.084186] systemd[1]: Reloading finished in 287 ms. machine # [ 78.157413] systemd[621]: Reexecution requested from client PID 7287 ('switch-to-confi')... machine # [ 78.158886] systemd[621]: Reexecuting. machine # [ 78.181435] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 78.262460] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 78.268784] systemd[621]: Reload requested from client PID 7287 ('switch-to-confi')... machine # [ 78.270130] systemd[621]: Reloading... machine # [ 78.345458] systemd[621]: Reloading finished in 73 ms. machine # [ 78.350904] systemd[621]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 78.358250] systemd[621]: Stopped Run user-specific NixOS activation. machine # [ 78.359137] systemd[621]: Stopping Run user-specific NixOS activation... machine # [ 78.361578] systemd[621]: Starting Run user-specific NixOS activation... machine # [ 78.382160] systemd[621]: Finished Run user-specific NixOS activation. machine # [ 78.385440] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 78.386755] systemd[1]: Stopping Reactivate sysinit units... machine # [ 78.387809] systemd[1]: Reached target Reactivate sysinit units. machine # [ 78.391885] systemd[1]: Reloading reload-triggers.service... machine # [ 78.398096] systemd[1]: Reloading simple-reload-service.service... machine # [ 78.403148] systemd[1]: Reloading templated-reload-triggers@instance.service... machine # [ 78.409380] systemd[1]: Reloading templated-simple-reload-service@instance.service... machine # [ 78.433950] systemd[1]: Reloaded reload-triggers.service. machine # [ 78.443228] systemd[1]: Reloaded templated-reload-triggers@instance.service. machine # [ 78.445561] systemd[1]: Reloaded simple-reload-service.service. machine # [ 78.450431] systemd[1]: Reloaded templated-simple-reload-service@instance.service. machine # [ 78.454233] systemd[1]: reload-triggers-and-restart-by-as.service: Deactivated successfully. machine # [ 78.456321] systemd[1]: Stopped reload-triggers-and-restart-by-as.service. machine # [ 78.457311] systemd[1]: Stopping reload-triggers-and-restart-by-as.service... machine # [ 78.459327] systemd[1]: Starting reload-triggers-and-restart-by-as.service... machine # [ 78.461308] systemd[1]: reload-triggers-and-restart.service: Deactivated successfully. machine # [ 78.462601] systemd[1]: Stopped reload-triggers-and-restart.service. machine # [ 78.464246] systemd[1]: Stopping reload-triggers-and-restart.service... machine # [ 78.465868] systemd[1]: Starting reload-triggers-and-restart.service... machine # [ 78.468313] systemd[1]: simple-restart-service.service: Deactivated successfully. machine # [ 78.471509] systemd[1]: Stopped simple-restart-service.service. machine # [ 78.472489] systemd[1]: Stopping simple-restart-service.service... machine # [ 78.476268] systemd[1]: Starting simple-restart-service.service... machine # [ 78.477133] systemd[1]: simple-service.service: Deactivated successfully. machine # [ 78.477986] systemd[1]: Stopped simple-service.service. machine # [ 78.478761] systemd[1]: Stopping simple-service.service... machine # [ 78.485904] systemd[1]: Starting simple-service.service... machine # [ 78.486726] systemd[1]: templated-reload-triggers-and-restart-by-as@instance.service: Deactivated successfully. machine # [ 78.488076] systemd[1]: Stopped templated-reload-triggers-and-restart-by-as@instance.service. machine # [ 78.489160] systemd[1]: Stopping templated-reload-triggers-and-restart-by-as@instance.service... machine # [ 78.492589] systemd[1]: Starting templated-reload-triggers-and-restart-by-as@instance.service... machine # [ 78.494180] systemd[1]: templated-reload-triggers-and-restart@instance.service: Deactivated successfully. machine # [ 78.497486] systemd[1]: Stopped templated-reload-triggers-and-restart@instance.service. machine # [ 78.501882] systemd[1]: Stopping templated-reload-triggers-and-restart@instance.service... machine # [ 78.504148] systemd[1]: Starting templated-reload-triggers-and-restart@instance.service... machine # [ 78.509375] systemd[1]: templated-simple-restart-service@instance.service: Deactivated successfully. machine # [ 78.510593] systemd[1]: Stopped templated-simple-restart-service@instance.service. machine # [ 78.512413] systemd[1]: Stopping templated-simple-restart-service@instance.service... machine # [ 78.515106] systemd[1]: Starting templated-simple-restart-service@instance.service... machine # [ 78.516131] systemd[1]: templated-simple-service@instance.service: Deactivated successfully. machine # [ 78.521481] systemd[1]: Stopped templated-simple-service@instance.service. machine # [ 78.522453] systemd[1]: Stopping templated-simple-service@instance.service... machine # [ 78.527082] systemd[1]: Starting templated-simple-service@instance.service... machine # [ 78.577458] systemd[1]: Finished reload-triggers-and-restart-by-as.service. machine # [ 78.585192] systemd[1]: Finished reload-triggers-and-restart.service. machine # [ 78.588233] systemd[1]: Finished simple-restart-service.service. machine # [ 78.589212] systemd[1]: Finished simple-service.service. machine # [ 78.598189] systemd[1]: Finished templated-reload-triggers-and-restart-by-as@instance.service. machine # [ 78.601167] systemd[1]: Finished templated-reload-triggers-and-restart@instance.service. machine # [ 78.603537] systemd[1]: Finished templated-simple-restart-service@instance.service. machine # [ 78.605757] systemd[1]: Finished templated-simple-service@instance.service. machine # [ 78.612539] systemd[1]: Reached target Local File Systems. machine # [ 78.614271] systemd[1]: Reached target Remote File Systems. machine # [ 78.615956] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 78.618182] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 78.618986] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 78.621625] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 78.624551] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 78.627128] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 78.629339] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 78.633533] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 78.635086] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 78.765312] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 78.767133] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 78.771653] systemd[1]: Starting linger-users.service... machine # [ 78.801541] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 78.803097] systemd[1]: Finished linger-users.service. machine # [ 79.060766] nixos[7216]: finished switching to system configuration /nix/store/jgpi4dwqxjbbn6nfq91a2kk4g995k8yf-nixos-system-machine-test machine: (finished: must succeed: /nix/store/jl59xgshkm15yy4qkh11f2517r2vlwz8-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script-modified/bin/switch-to-configuration test 2>&1, in 1.84 seconds) machine: must succeed: /nix/store/jl59xgshkm15yy4qkh11f2517r2vlwz8-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/jl59xgshkm15yy4qkh11f2517r2vlwz8-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration dry-activate 2>&1, in 0.33 seconds) (finished: subtest: restart and reload by activation script, in 6.80 seconds) (finished: run the VM test script, in 80.57 seconds) test script finished in 80.60s cleanup kill QemuMachine (pid 45) machine # qemu-system-x86_64: terminating on signal 15 from pid 39 (/nix/store/lb41b0anx1f98y9y5s9mdv97gjgsq740-python3-3.14.7/bin/python3.14) machine # [2026-10-01T03:50:11Z INFO virtiofsd] Client disconnected, shutting down machine # [2026-10-01T03:50:11Z INFO virtiofsd] Client disconnected, shutting down machine # [2026-10-01T03:50:11Z INFO virtiofsd] Client disconnected, shutting down (finished: cleanup, in 0.19 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