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.iegyBOIbjf', 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: 1541240e-66ae-4f3d-ade5-f116a6086928 machine # Superblock backups stored on blocks: machine # 32768, 98304, 163840, 229376 machine # machine # Allocating group tables: 0/8 done machine # Writing inode tables: 0/8 done machine # Creating journal (8192 blocks): done machine # Writing superblocks and filesystem accounting information: 0/8 done machine # machine # Virtualisation disk image created. machine # SeaBIOS (version rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org) machine # machine # machine # iPXE (http://ipxe.org) 00:02.0 CA00 PCI2.10 PnP PMM+3EFCC730+3EF2C730 CA00 machine # Press Ctrl-B to configure iPXE (PCI 00:02.0)... machine # machine # machine # machine # machine # iPXE (http://ipxe.org) 00:08.0 CB00 PCI2.10 PnP PMM 3EFCC730 3EF2C730 CB00 machine # Press Ctrl-B to configure iPXE (PCI 00:08.0)... machine # machine # machine # Booting from ROM... machine # Probing EDD (edd=off to disable)... ok[ 0.000000] Linux version 6.18.49 (nixbld@localhost) (gcc (GCC) 15.3.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT_DYNAMIC Wed Sep 2 12:31:51 UTC 2026 machine # [ 0.000000] Command line: console=ttyS0 console=tty0 panic=1 boot.panic_on_fail clocksource=acpi_pm root=fstab loglevel=7 net.ifnames=0 lsm=landlock,yama,bpf init=/nix/store/yv0fgsc3a9pf40xia3yrhzply67kinx0-nixos-system-machine-test/init regInfo=/nix/store/g63xayvikkcyhkl844dnzvj3ihkhx8an-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 463219963 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.000804] last_pfn = 0x3ffd8 max_arch_pfn = 0x10000000000 machine # [ 0.000831] MTRR map: 4 entries (3 fixed + 1 variable; max 19), built from 8 variable MTRRs machine # [ 0.000833] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT machine # [ 0.002726] found SMP MP-table at [mem 0x000f5450-0x000f545f] machine # [ 0.002737] Using GB pages for direct mapping machine # [ 0.002819] RAMDISK: [mem 0x3e42b000-0x3ffcffff] machine # [ 0.002828] ACPI: Early table checksum verification disabled machine # [ 0.002831] ACPI: RSDP 0x00000000000F5270 000014 (v00 BOCHS ) machine # [ 0.002835] ACPI: RSDT 0x000000003FFE2422 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) machine # [ 0.002838] ACPI: FACP 0x000000003FFE221A 0000F4 (v03 BOCHS BXPC 00000001 BXPC 00000001) machine # [ 0.002845] ACPI: DSDT 0x000000003FFE0040 0021DA (v01 BOCHS BXPC 00000001 BXPC 00000001) machine # [ 0.002847] ACPI: FACS 0x000000003FFE0000 000040 machine # [ 0.002849] ACPI: APIC 0x000000003FFE230E 000078 (v03 BOCHS BXPC 00000001 BXPC 00000001) machine # [ 0.002850] ACPI: HPET 0x000000003FFE2386 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) machine # [ 0.002852] ACPI: MCFG 0x000000003FFE23BE 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001) machine # [ 0.002853] ACPI: WAET 0x000000003FFE23FA 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001) machine # [ 0.002855] ACPI: Reserving FACP table memory at [mem 0x3ffe221a-0x3ffe230d] machine # [ 0.002855] ACPI: Reserving DSDT table memory at [mem 0x3ffe0040-0x3ffe2219] machine # [ 0.002856] ACPI: Reserving FACS table memory at [mem 0x3ffe0000-0x3ffe003f] machine # [ 0.002856] ACPI: Reserving APIC table memory at [mem 0x3ffe230e-0x3ffe2385] machine # [ 0.002857] ACPI: Reserving HPET table memory at [mem 0x3ffe2386-0x3ffe23bd] machine # [ 0.002857] ACPI: Reserving MCFG table memory at [mem 0x3ffe23be-0x3ffe23f9] machine # [ 0.002858] ACPI: Reserving WAET table memory at [mem 0x3ffe23fa-0x3ffe2421] machine # [ 0.003085] No NUMA configuration found machine # [ 0.003086] Faking a node at [mem 0x0000000000000000-0x000000003ffd7fff] machine # [ 0.003088] NODE_DATA(0) allocated [mem 0x3ffd2780-0x3ffd7cff] machine # [ 0.005418] Zone ranges: machine # [ 0.005419] DMA [mem 0x0000000000001000-0x0000000000ffffff] machine # [ 0.005420] DMA32 [mem 0x0000000001000000-0x000000003ffd7fff] machine # [ 0.005421] Normal empty machine # [ 0.005422] Device empty machine # [ 0.005423] Movable zone start for each node machine # [ 0.005424] Early memory node ranges machine # [ 0.005424] node 0: [mem 0x0000000000001000-0x000000000009efff] machine # [ 0.005425] node 0: [mem 0x0000000000100000-0x000000003ffd7fff] machine # [ 0.005426] Initmem setup node 0 [mem 0x0000000000001000-0x000000003ffd7fff] machine # [ 0.005446] On node 0, zone DMA: 1 pages in unavailable ranges machine # [ 0.005717] On node 0, zone DMA: 97 pages in unavailable ranges machine # [ 0.023973] On node 0, zone DMA32: 40 pages in unavailable ranges machine # [ 0.024419] ACPI: PM-Timer IO Port: 0x608 machine # [ 0.024430] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) machine # [ 0.024457] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 machine # [ 0.024460] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) machine # [ 0.024462] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) machine # [ 0.024463] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) machine # [ 0.024463] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) machine # [ 0.024464] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) machine # [ 0.024467] ACPI: Using ACPI (MADT) for SMP configuration information machine # [ 0.024468] ACPI: HPET id: 0x8086a201 base: 0xfed00000 machine # [ 0.024471] TSC deadline timer available machine # [ 0.024476] CPU topo: Max. logical packages: 1 machine # [ 0.024476] CPU topo: Max. logical dies: 1 machine # [ 0.024477] CPU topo: Max. dies per package: 1 machine # [ 0.024480] CPU topo: Max. threads per core: 1 machine # [ 0.024481] CPU topo: Num. cores per package: 1 machine # [ 0.024481] CPU topo: Num. threads per package: 1 machine # [ 0.024481] CPU topo: Allowing 1 present CPUs plus 0 hotplug CPUs machine # [ 0.024500] kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write() machine # [ 0.024530] PM: hibernation: Registered nosave memory: [mem 0x00000000-0x00000fff] machine # [ 0.024531] PM: hibernation: Registered nosave memory: [mem 0x0009f000-0x000fffff] machine # [ 0.024533] [mem 0x40000000-0xafffffff] available for PCI devices machine # [ 0.024534] Booting paravirtualized kernel on KVM machine # [ 0.024537] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns machine # [ 0.029007] setup_percpu: NR_CPUS:384 nr_cpumask_bits:1 nr_cpu_ids:1 nr_node_ids:1 machine # [ 0.031253] percpu: Embedded 98 pages/cpu s278528 r8192 d114688 u2097152 machine # [ 0.031300] kvm-guest: PV spinlocks disabled, single CPU machine # [ 0.031302] 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/yv0fgsc3a9pf40xia3yrhzply67kinx0-nixos-system-machine-test/init regInfo=/nix/store/g63xayvikkcyhkl844dnzvj3ihkhx8an-closure-info/registration console=ttyS0,115200n8 console=tty0 machine # [ 0.031396] Unknown kernel command line parameters "regInfo=/nix/store/g63xayvikkcyhkl844dnzvj3ihkhx8an-closure-info/registration", will be passed to user space. machine # [ 0.031408] random: crng init done machine # [ 0.031408] printk: log buffer data + meta data: 262144 + 917504 = 1179648 bytes machine # [ 0.031430] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes, linear) machine # [ 0.031443] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes, linear) machine # [ 0.031473] Fallback order for Node 0: 0 machine # [ 0.031476] Built 1 zonelists, mobility grouping on. Total pages: 262006 machine # [ 0.031477] Policy zone: DMA32 machine # [ 0.034204] mem auto-init: stack:all(zero), heap alloc:on, heap free:off machine # [ 0.036765] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1 machine # [ 0.039084] allocated 2097152 bytes of page_ext machine # [ 0.048955] ftrace: allocating 48732 entries in 192 pages machine # [ 0.048957] ftrace: allocated 192 pages with 2 groups machine # [ 0.049823] Dynamic Preempt: lazy machine # [ 0.049985] rcu: Preemptible hierarchical RCU implementation. machine # [ 0.049986] rcu: RCU event tracing is enabled. machine # [ 0.049987] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1. machine # [ 0.049988] Trampoline variant of Tasks RCU enabled. machine # [ 0.049989] Rude variant of Tasks RCU enabled. machine # [ 0.049989] Tracing variant of Tasks RCU enabled. machine # [ 0.049990] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. machine # [ 0.049991] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1 machine # [ 0.050006] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. machine # [ 0.050008] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. machine # [ 0.050009] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. machine # [ 0.054405] NR_IRQS: 24832, nr_irqs: 256, preallocated irqs: 16 machine # [ 0.054682] rcu: srcu_init: Setting srcu_struct sizes based on contention. machine # [ 0.054689] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns machine # [ 0.054794] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____) machine # [ 0.058292] Console: colour VGA+ 80x25 machine # [ 0.058295] printk: legacy console [tty0] enabled machine # [ 0.087334] printk: legacy console [ttyS0] enabled machine # [ 0.192746] ACPI: Core revision 20250807 machine # [ 0.193672] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns machine # [ 0.195290] APIC: Switch to symmetric I/O mode setup machine # [ 0.196318] x2apic enabled machine # [ 0.197056] APIC: Switched APIC routing to: physical x2apic machine # [ 0.198953] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 machine # [ 0.199981] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x229842dd0bd, max_idle_ns: 440795319571 ns machine # [ 0.201717] Calibrating delay loop (skipped) preset value.. 4800.02 BogoMIPS (lpj=2400012) machine # [ 0.202801] x86/cpu: User Mode Instruction Prevention (UMIP) activated machine # [ 0.204824] Last level iTLB entries: 4KB 512, 2MB 255, 4MB 127 machine # [ 0.205713] Last level dTLB entries: 4KB 512, 2MB 255, 4MB 127, 1GB 0 machine # [ 0.206717] mitigations: Enabled attack vectors: user_kernel, user_user, guest_host, guest_guest, SMT mitigations: auto machine # [ 0.207714] Speculative Store Bypass: Mitigation: Speculative Store Bypass disabled via prctl machine # [ 0.209714] Transient Scheduler Attacks: Vulnerable: No microcode machine # [ 0.210713] Spectre V2 : Mitigation: Enhanced / Automatic IBRS machine # [ 0.211714] Speculative Return Stack Overflow: Mitigation: Safe RET machine # [ 0.212713] Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization machine # [ 0.214721] Spectre V2 : Enabling IBPB for BPF machine # [ 0.215714] Spectre V2 : mitigation: Enabling conditional Indirect Branch Prediction Barrier machine # [ 0.216715] active return thunk: srso_alias_return_thunk machine # [ 0.217735] x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers' machine # [ 0.218713] x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers' machine # [ 0.220529] x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers' machine # [ 0.221533] x86/fpu: Supporting XSAVE feature 0x020: 'AVX-512 opmask' machine # [ 0.222539] x86/fpu: Supporting XSAVE feature 0x040: 'AVX-512 Hi256' machine # [ 0.223505] x86/fpu: Supporting XSAVE feature 0x080: 'AVX-512 ZMM_Hi256' machine # [ 0.224511] x86/fpu: Supporting XSAVE feature 0x200: 'Protection Keys User registers' machine # [ 0.225714] x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256 machine # [ 0.226713] x86/fpu: xstate_offset[5]: 832, xstate_sizes[5]: 64 machine # [ 0.227713] x86/fpu: xstate_offset[6]: 896, xstate_sizes[6]: 512 machine # [ 0.228713] x86/fpu: xstate_offset[7]: 1408, xstate_sizes[7]: 1024 machine # [ 0.229713] x86/fpu: xstate_offset[9]: 2432, xstate_sizes[9]: 8 machine # [ 0.230713] x86/fpu: Enabled xstate features 0x2e7, context size is 2440 bytes, using 'compacted' format. machine # [ 0.264777] Freeing SMP alternatives memory: 44K machine # [ 0.265561] pid_max: default: 32768 minimum: 301 machine # [ 0.266390] LSM: initializing lsm=capability,landlock,yama,bpf,ima machine # [ 0.266798] landlock: Up and running. machine # [ 0.268181] Yama: becoming mindful. machine # [ 0.268929] LSM support for eBPF active machine # [ 0.269807] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear) machine # [ 0.270734] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear) machine # [ 0.273451] smpboot: CPU0: AMD EPYC 9654 96-Core Processor (family: 0x19, model: 0x11, stepping: 0x1) machine # [ 0.274260] Performance Events: Fam17h+ core perfctr, AMD PMU driver. machine # [ 0.274719] ... version: 2 machine # [ 0.275483] ... bit width: 48 machine # [ 0.275716] ... generic counters: 6 machine # [ 0.276475] ... generic bitmap: 000000000000003f machine # [ 0.276727] ... fixed-purpose counters: 0 machine # [ 0.277458] ... fixed-purpose bitmap: 0000000000000000 machine # [ 0.277716] ... value mask: 0000ffffffffffff machine # [ 0.278651] ... max period: 00007fffffffffff machine # [ 0.279455] ... global_ctrl mask: 000000000000003f machine # [ 0.279837] signal: max sigframe size: 3376 machine # [ 0.280655] rcu: Hierarchical SRCU implementation. machine # [ 0.281350] rcu: Max phase no-delay instances is 400. machine # [ 0.286213] smp: Bringing up secondary CPUs ... machine # [ 0.286730] smp: Brought up 1 node, 1 CPU machine # [ 0.287399] smpboot: Total of 1 processors activated (4800.02 BogoMIPS) machine # [ 0.287914] Memory: 941816K/1048024K available (17215K kernel code, 2726K rwdata, 13584K rodata, 3644K init, 2988K bss, 98832K reserved, 0K cma-reserved) machine # [ 0.288963] devtmpfs: initialized machine # [ 0.289816] x86/mm: Memory block size: 128MB machine # [ 0.291561] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear) machine # [ 0.292673] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear). machine # [ 0.293813] pinctrl core: initialized pinctrl subsystem machine # [ 0.294987] PM: RTC time: 18:01:09, date: 2026-09-06 machine # [ 0.298670] NET: Registered PF_NETLINK/PF_ROUTE protocol family machine # [ 0.299878] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations machine # [ 0.300734] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations machine # [ 0.301866] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations machine # [ 0.302727] audit: initializing netlink subsys (disabled) machine # [ 0.303945] thermal_sys: Registered thermal governor 'fair_share' machine # [ 0.303948] thermal_sys: Registered thermal governor 'bang_bang' machine # [ 0.304717] thermal_sys: Registered thermal governor 'step_wise' machine # [ 0.305671] thermal_sys: Registered thermal governor 'user_space' machine # [ 0.306513] audit: type=2000 audit(1788717670.458:1): state=initialized audit_enabled=0 res=1 machine # [ 0.308719] thermal_sys: Registered thermal governor 'power_allocator' machine # [ 0.308733] cpuidle: using governor menu machine # [ 0.310992] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 machine # [ 0.311946] PCI: ECAM [mem 0xb0000000-0xbfffffff] (base 0xb0000000) for domain 0000 [bus 00-ff] machine # [ 0.312719] PCI: ECAM [mem 0xb0000000-0xbfffffff] reserved as E820 entry machine # [ 0.313727] PCI: Using configuration type 1 for base access machine # [ 0.314899] kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible. machine # [ 0.322004] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages machine # [ 0.322718] HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page machine # [ 0.327717] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages machine # [ 0.328716] HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page machine # [ 0.337384] ACPI: Added _OSI(Module Device) machine # [ 0.337718] ACPI: Added _OSI(Processor Device) machine # [ 0.338500] ACPI: Added _OSI(Processor Aggregator Device) machine # [ 0.345272] ACPI: 1 ACPI AML tables successfully acquired and loaded machine # [ 0.348646] ACPI: Interpreter enabled machine # [ 0.349223] ACPI: PM: (supports S0 S3 S4 S5) machine # [ 0.349716] ACPI: Using IOAPIC for interrupt routing machine # [ 0.350566] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug machine # [ 0.355716] PCI: Using E820 reservations for host bridge windows machine # [ 0.356856] ACPI: Enabled 2 GPEs in block 00 to 3F machine # [ 0.365532] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) machine # [ 0.367232] acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] machine # [ 0.367795] acpi PNP0A08:00: _OSC: platform does not support [PCIeHotplug LTR] machine # [ 0.368839] acpi PNP0A08:00: _OSC: OS now controls [PME AER PCIeCapability] machine # [ 0.370057] PCI host bridge to bus 0000:00 machine # [ 0.370720] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] machine # [ 0.371717] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] machine # [ 0.372716] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] machine # [ 0.373716] pci_bus 0000:00: root bus resource [mem 0x40000000-0xafffffff window] machine # [ 0.374716] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window] machine # [ 0.375716] pci_bus 0000:00: root bus resource [mem 0x100000000-0x8ffffffff window] machine # [ 0.376717] pci_bus 0000:00: root bus resource [bus 00-ff] machine # [ 0.377735] pci 0000:00:00.0: [8086:29c0] type 00 class 0x060000 conventional PCI endpoint machine # [ 0.379146] pci 0000:00:01.0: [1234:1111] type 00 class 0x030000 conventional PCI endpoint machine # [ 0.381818] pci 0000:00:01.0: BAR 0 [mem 0xfd000000-0xfdffffff pref] machine # [ 0.382728] pci 0000:00:01.0: BAR 2 [mem 0xfebd0000-0xfebd0fff] machine # [ 0.383707] pci 0000:00:01.0: ROM [mem 0xfebc0000-0xfebcffff pref] machine # [ 0.385010] pci 0000:00:01.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff] machine # [ 0.386526] pci 0000:00:02.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint machine # [ 0.389749] pci 0000:00:02.0: BAR 0 [io 0xc140-0xc15f] machine # [ 0.390632] pci 0000:00:02.0: BAR 1 [mem 0xfebd1000-0xfebd1fff] machine # [ 0.391486] pci 0000:00:02.0: BAR 4 [mem 0xfe000000-0xfe003fff 64bit pref] machine # [ 0.392570] pci 0000:00:02.0: ROM [mem 0xfeb40000-0xfeb7ffff pref] machine # [ 0.394032] pci 0000:00:03.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint machine # [ 0.396724] pci 0000:00:03.0: BAR 0 [io 0xc160-0xc17f] machine # [ 0.398399] pci 0000:00:03.0: BAR 1 [mem 0xfebd2000-0xfebd2fff] machine # [ 0.398741] pci 0000:00:03.0: BAR 4 [mem 0xfe004000-0xfe007fff 64bit pref] machine # [ 0.400279] pci 0000:00:04.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint machine # [ 0.402749] pci 0000:00:04.0: BAR 0 [io 0xc080-0xc0bf] machine # [ 0.403585] pci 0000:00:04.0: BAR 1 [mem 0xfebd3000-0xfebd3fff] machine # [ 0.404499] pci 0000:00:04.0: BAR 4 [mem 0xfe008000-0xfe00bfff 64bit pref] machine # [ 0.406717] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint machine # [ 0.409646] pci 0000:00:05.0: BAR 0 [io 0xc180-0xc19f] machine # [ 0.410390] pci 0000:00:05.0: BAR 1 [mem 0xfebd4000-0xfebd4fff] machine # [ 0.410738] pci 0000:00:05.0: BAR 4 [mem 0xfe00c000-0xfe00ffff 64bit pref] machine # [ 0.412341] pci 0000:00:06.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint machine # [ 0.415068] pci 0000:00:06.0: BAR 0 [io 0xc1a0-0xc1bf] machine # [ 0.416390] pci 0000:00:06.0: BAR 1 [mem 0xfebd5000-0xfebd5fff] machine # [ 0.416737] pci 0000:00:06.0: BAR 4 [mem 0xfe010000-0xfe013fff 64bit pref] machine # [ 0.418256] pci 0000:00:07.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint machine # [ 0.420750] pci 0000:00:07.0: BAR 0 [io 0xc000-0xc07f] machine # [ 0.421664] pci 0000:00:07.0: BAR 1 [mem 0xfebd6000-0xfebd6fff] machine # [ 0.422503] pci 0000:00:07.0: BAR 4 [mem 0xfe014000-0xfe017fff 64bit pref] machine # [ 0.424308] pci 0000:00:08.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint machine # [ 0.426496] pci 0000:00:08.0: BAR 0 [io 0xc1c0-0xc1df] machine # [ 0.427374] pci 0000:00:08.0: BAR 1 [mem 0xfebd7000-0xfebd7fff] machine # [ 0.427738] pci 0000:00:08.0: BAR 4 [mem 0xfe018000-0xfe01bfff 64bit pref] machine # [ 0.428722] pci 0000:00:08.0: ROM [mem 0xfeb80000-0xfebbffff pref] machine # [ 0.430256] pci 0000:00:09.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint machine # [ 0.432753] pci 0000:00:09.0: BAR 1 [mem 0xfebd8000-0xfebd8fff] machine # [ 0.433738] pci 0000:00:09.0: BAR 4 [mem 0xfe01c000-0xfe01ffff 64bit pref] machine # [ 0.435246] pci 0000:00:0a.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint machine # [ 0.436751] pci 0000:00:0a.0: BAR 0 [io 0xc0c0-0xc0ff] machine # [ 0.437616] pci 0000:00:0a.0: BAR 1 [mem 0xfebd9000-0xfebd9fff] machine # [ 0.438489] pci 0000:00:0a.0: BAR 4 [mem 0xfe020000-0xfe023fff 64bit pref] machine # [ 0.439788] pci 0000:00:0b.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint machine # [ 0.442439] pci 0000:00:0b.0: BAR 0 [io 0xc1e0-0xc1ff] machine # [ 0.442723] pci 0000:00:0b.0: BAR 1 [mem 0xfebda000-0xfebdafff] machine # [ 0.443731] pci 0000:00:0b.0: BAR 4 [mem 0xfe024000-0xfe027fff 64bit pref] machine # [ 0.445265] pci 0000:00:1d.0: [8086:2934] type 00 class 0x0c0300 conventional PCI endpoint machine # [ 0.446400] pci 0000:00:1d.0: BAR 4 [io 0xc200-0xc21f] machine # [ 0.446923] pci 0000:00:1d.1: [8086:2935] type 00 class 0x0c0300 conventional PCI endpoint machine # [ 0.449553] pci 0000:00:1d.1: BAR 4 [io 0xc220-0xc23f] machine # [ 0.450651] pci 0000:00:1d.2: [8086:2936] type 00 class 0x0c0300 conventional PCI endpoint machine # [ 0.453203] pci 0000:00:1d.2: BAR 4 [io 0xc240-0xc25f] machine # [ 0.454063] pci 0000:00:1d.7: [8086:293a] type 00 class 0x0c0320 conventional PCI endpoint machine # [ 0.456088] pci 0000:00:1d.7: BAR 0 [mem 0xfebdb000-0xfebdbfff] machine # [ 0.456948] pci 0000:00:1f.0: [8086:2918] type 00 class 0x060100 conventional PCI endpoint machine # [ 0.458026] pci 0000:00:1f.0: quirk: [io 0x0600-0x067f] claimed by ICH6 ACPI/GPIO/TCO machine # [ 0.458968] pci 0000:00:1f.2: [8086:2922] type 00 class 0x010601 conventional PCI endpoint machine # [ 0.460769] pci 0000:00:1f.2: BAR 4 [io 0xc260-0xc27f] machine # [ 0.461657] pci 0000:00:1f.2: BAR 5 [mem 0xfebdc000-0xfebdcfff] machine # [ 0.462776] pci 0000:00:1f.3: [8086:2930] type 00 class 0x0c0500 conventional PCI endpoint machine # [ 0.464523] pci 0000:00:1f.3: BAR 4 [io 0x0700-0x073f] machine # [ 0.468327] ACPI: PCI: Interrupt link LNKA configured for IRQ 10 machine # [ 0.468822] ACPI: PCI: Interrupt link LNKB configured for IRQ 10 machine # [ 0.469817] ACPI: PCI: Interrupt link LNKC configured for IRQ 11 machine # [ 0.470816] ACPI: PCI: Interrupt link LNKD configured for IRQ 11 machine # [ 0.472089] ACPI: PCI: Interrupt link LNKE configured for IRQ 10 machine # [ 0.472813] ACPI: PCI: Interrupt link LNKF configured for IRQ 10 machine # [ 0.473814] ACPI: PCI: Interrupt link LNKG configured for IRQ 11 machine # [ 0.474816] ACPI: PCI: Interrupt link LNKH configured for IRQ 11 machine # [ 0.475764] ACPI: PCI: Interrupt link GSIA configured for IRQ 16 machine # [ 0.476731] ACPI: PCI: Interrupt link GSIB configured for IRQ 17 machine # [ 0.477730] ACPI: PCI: Interrupt link GSIC configured for IRQ 18 machine # [ 0.478728] ACPI: PCI: Interrupt link GSID configured for IRQ 19 machine # [ 0.479715] ACPI: PCI: Interrupt link GSIE configured for IRQ 20 machine # [ 0.480709] ACPI: PCI: Interrupt link GSIF configured for IRQ 21 machine # [ 0.481690] ACPI: PCI: Interrupt link GSIG configured for IRQ 22 machine # [ 0.482509] ACPI: PCI: Interrupt link GSIH configured for IRQ 23 machine # [ 0.484514] iommu: Default domain type: Translated machine # [ 0.484733] iommu: DMA domain TLB invalidation policy: lazy mode machine # [ 0.486034] ACPI: bus type USB registered machine # [ 0.486786] usbcore: registered new interface driver usbfs machine # [ 0.487717] usbcore: registered new interface driver hub machine # [ 0.488622] usbcore: registered new device driver usb machine # [ 0.490325] NetLabel: Initializing machine # [ 0.490718] NetLabel: domain hash size = 128 machine # [ 0.491556] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO machine # [ 0.492560] NetLabel: unlabeled traffic allowed by default machine # [ 0.493460] PCI: Using ACPI for IRQ routing machine # [ 0.536828] pci 0000:00:01.0: vgaarb: setting as boot VGA device machine # [ 0.537712] pci 0000:00:01.0: vgaarb: bridge control possible machine # [ 0.537712] pci 0000:00:01.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none machine # [ 0.537720] vgaarb: loaded machine # [ 0.538476] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 machine # [ 0.538718] hpet0: 3 comparators, 64-bit 100.000000 MHz counter machine # [ 0.542803] clocksource: Switched to clocksource kvm-clock machine # [ 0.546333] VFS: Disk quotas dquot_6.6.0 machine # [ 0.547053] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) machine # [ 0.548491] pnp: PnP ACPI init machine # [ 0.549282] ACPI: IRQ 4 override to edge(!), high(!) machine # [ 0.550283] system 00:05: [mem 0xb0000000-0xbfffffff window] has been reserved machine # [ 0.551868] pnp: PnP ACPI: found 6 devices machine # [ 0.559551] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns machine # [ 0.561041] clocksource: Switched to clocksource acpi_pm machine # [ 0.562073] NET: Registered PF_INET protocol family machine # [ 0.563127] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear) machine # [ 0.579990] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear) machine # [ 0.581568] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) machine # [ 0.582915] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear) machine # [ 0.584282] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear) machine # [ 0.585504] TCP: Hash tables configured (established 8192 bind 8192) machine # [ 0.586632] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear) machine # [ 0.587911] UDP hash table entries: 512 (order: 3, 32768 bytes, linear) machine # [ 0.589080] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear) machine # [ 0.590350] NET: Registered PF_UNIX/PF_LOCAL protocol family machine # [ 0.591350] NET: Registered PF_XDP protocol family machine # [ 0.592176] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] machine # [ 0.593209] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] machine # [ 0.594237] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] machine # [ 0.595358] pci_bus 0000:00: resource 7 [mem 0x40000000-0xafffffff window] machine # [ 0.596444] pci_bus 0000:00: resource 8 [mem 0xc0000000-0xfebfffff window] machine # [ 0.597559] pci_bus 0000:00: resource 9 [mem 0x100000000-0x8ffffffff window] machine # [ 0.599265] ACPI: \_SB_.GSIA: Enabled at IRQ 16 machine # [ 0.601655] ACPI: \_SB_.GSIB: Enabled at IRQ 17 machine # [ 0.603596] ACPI: \_SB_.GSIC: Enabled at IRQ 18 machine # [ 0.605544] ACPI: \_SB_.GSID: Enabled at IRQ 19 machine # [ 0.607194] PCI: CLS 0 bytes, default 64 machine # [ 0.608159] Trying to unpack rootfs image as initramfs... machine # [ 0.610109] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x229842dd0bd, max_idle_ns: 440795319571 ns machine # [ 0.653529] Initialise system trusted keyrings machine # [ 0.654447] workingset: timestamp_bits=40 max_order=18 bucket_order=0 machine # [ 0.674977] Key type asymmetric registered machine # [ 0.678056] Asymmetric key parser 'x509' registered machine # [ 0.678912] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 248) machine # [ 0.682243] io scheduler mq-deadline registered machine # [ 0.683055] io scheduler kyber registered machine # [ 0.687587] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled machine # [ 0.688831] 00:03: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A machine # [ 0.692849] Linux agpgart interface v0.103 machine # [ 0.693658] ACPI: bus type drm_connector registered machine # [ 0.698213] usbcore: registered new interface driver usbserial_generic machine # [ 0.699319] usbserial: USB Serial support registered for generic machine # [ 0.702081] amd_pstate: The CPPC feature is supported but currently disabled by the BIOS. machine # [ 0.702081] Please enable it if your BIOS has the CPPC option. machine # [ 0.704364] amd_pstate: the _CPC object is not present in SBIOS or ACPI disabled machine # [ 0.709172] drop_monitor: Initializing network drop monitor service machine # [ 0.710422] NET: Registered PF_INET6 protocol family machine # [ 0.713546] Segment Routing with IPv6 machine # [ 0.716080] In-situ OAM (IOAM) with IPv6 machine # [ 0.717153] IPI shorthand broadcast: enabled machine # [ 0.725456] sched_clock: Marking stable (583013792, 142023965)->(797859570, -72821813) machine # [ 0.730303] registered taskstats version 1 machine # [ 0.731267] Loading compiled-in X.509 certificates machine # [ 0.749056] Demotion targets for Node 0: null machine # [ 0.751115] Key type .fscrypt registered machine # [ 0.751813] Key type fscrypt-provisioning registered machine # [ 0.752786] ima: No TPM chip found, activating TPM-bypass! machine # [ 0.756056] ima: Allocated hash algorithm: sha1 machine # [ 0.756872] ima: No architecture policies found machine # [ 0.761051] PM: Magic number: 10:340:38 machine # [ 0.762698] RAS: Correctable Errors collector initialized. machine # [ 0.771696] clk: Disabling unused clocks machine # [ 0.775056] PM: genpd: Disabling unused power domains machine # [ 0.937554] Freeing initrd memory: 28308K machine # [ 0.940720] Freeing unused decrypted memory: 2028K machine # [ 0.943374] Freeing unused kernel image (initmem) memory: 3644K machine # [ 0.944460] Write protecting the kernel read-only data: 32768k machine # [ 0.946377] Freeing unused kernel image (text/rodata gap) memory: 1216K machine # [ 0.947857] Freeing unused kernel image (rodata/data gap) memory: 752K machine # [ 0.998743] x86/mm: Checked W+X mappings: passed, no W+X pages found. machine # [ 0.999813] Run /init as init process machine # [ 1.010161] systemd[1]: Inserted module 'autofs4' machine # [ 1.026428] fuse: init (API version 7.45) machine # [ 1.032217] ACPI: \_SB_.GSIG: Enabled at IRQ 22 machine # [ 1.034501] ACPI: \_SB_.GSIH: Enabled at IRQ 23 machine # [ 1.037447] ACPI: \_SB_.GSIE: Enabled at IRQ 20 machine # [ 1.039622] ACPI: \_SB_.GSIF: Enabled at IRQ 21 machine # [ 1.065835] systemd[1]: Successfully made /usr/ read-only. machine # [ 1.401336] systemd[1]: systemd 262-9457f81 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.406080] systemd[1]: Detected virtualization kvm. machine # [ 1.406891] systemd[1]: Detected architecture x86-64. machine # [ 1.407739] systemd[1]: Running in initrd. machine # [ 1.408753] systemd[1]: Initializing machine ID from random generator. machine # [ 1.409900] systemd[1]: Hostname set to . machine # [ 1.481197] systemd[1]: bpf-restrict-fs: LSM BPF program attached machine # [ 1.517163] systemd[1]: Queued start job for default target Initrd Default Target. machine # [ 1.520294] systemd[1]: Created slice Slice /system/modprobe. machine # [ 1.521429] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. machine # [ 1.522828] systemd[1]: Expecting device /dev/disk/by-label/nixos... machine # [ 1.523907] systemd[1]: Reached target Path Units. machine # [ 1.524748] systemd[1]: Reached target Slice Units. machine # [ 1.525621] systemd[1]: Reached target Swaps. machine # [ 1.526378] systemd[1]: Reached target Timer Units. machine # [ 1.527281] systemd[1]: Listening on D-Bus System Message Bus Socket. machine # [ 1.528398] systemd[1]: Listening on Journal Socket (/dev/log). machine # [ 1.529461] systemd[1]: Listening on Journal Sockets. machine # [ 1.530361] systemd[1]: Listening on udev Kernel Socket. machine # [ 1.531275] systemd[1]: Reached target Socket Units. machine # [ 1.532910] systemd[1]: Starting Create List of Static Device Nodes... machine # [ 1.537121] systemd[1]: Starting Load Kernel Module 9pnet_virtio... machine # [ 1.545230] systemd[1]: Starting Load Kernel Module configfs... machine # [ 1.559663] systemd[1]: Starting Journal Service... machine # [ 1.570583] systemd[1]: Starting Load Kernel Modules... machine # [ 1.578127] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 1.593952] netfs: FS-Cache loaded machine # [ 1.598838] 9pnet: Installing 9P2000 support machine # [ 1.607810] systemd[1]: Starting Coldplug All udev Devices... machine # [ 1.621560] systemd[1]: Finished Create List of Static Device Nodes. machine # [ 1.626669] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully. machine # [ 1.634448] systemd[1]: Finished Load Kernel Module 9pnet_virtio. machine # [ 1.641594] systemd[1]: modprobe@configfs.service: Deactivated successfully. machine # [ 1.643849] systemd-journald[67]: Collecting audit messages is disabled. machine # [ 1.646434] systemd[1]: Finished Load Kernel Module configfs. machine # [ 1.652888] systemd[1]: Kernel Configuration File System skipped, unmet condition check ConditionPathExists=/sys/kernel/config machine # [ 1.657701] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. machine # [ 1.662848] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... machine # [ 1.666188] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev machine # [ 1.694564] systemd[1]: Finished Load Kernel Modules. machine # [ 1.703235] systemd[1]: Starting Apply Kernel Variables... machine # [ 1.712197] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. machine # [ 1.721678] systemd[1]: Starting Create Static Device Nodes in /dev... machine # [ 1.742188] systemd[1]: Finished Apply Kernel Variables. machine # [ 1.755587] systemd[1]: Finished Create Static Device Nodes in /dev. machine # [ 1.616497] systemd-modules-load[68]: Inserted module 'dm_mod'[ 1.759833] systemd[1]: Started Journal Service. machine # machine # [ 1.618834] systemd-modules-load[68]: Inserted module 'virtio_balloon' machine # [ 1.619905] systemd-modules-load[68]: Inserted module 'virtio_gpu' machine # [ 1.629913] systemd[1]: Reached target Preparation for Local File Systems. machine # [ 1.631856] systemd[1]: Reached target Local File Systems. machine # [ 1.634991] systemd[1]: Starting Create System Files and Directories... machine # [ 1.642078] systemd[1]: Starting Rule-based Manager for Device Events and Files... machine # [ 1.665365] systemd[1]: Finished Create System Files and Directories. machine # [ 1.687353] systemd-udevd[83]: Using default interface naming scheme 'v261'. machine # [ 1.712079] systemd[1]: Started Rule-based Manager for Device Events and Files. machine # [ 1.750642] systemd[1]: Finished Coldplug All udev Devices. machine # [ 1.751521] systemd[1]: Reached target System Initialization. machine # [ 1.752316] systemd[1]: Reached target Basic System. machine # [ 2.075801] virtio_blk virtio5: 1/0/0 default/read/poll queues machine # [ 2.081188] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 machine # [ 2.100758] virtio_blk virtio5: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) machine # [ 2.104723] serio: i8042 KBD port at 0x60,0x64 irq 1 machine # [ 2.111053] serio: i8042 AUX port at 0x60,0x64 irq 12 machine # [ 2.122960] ehci-pci 0000:00:1d.7: EHCI Host Controller machine # [ 2.123826] ehci-pci 0000:00:1d.7: new USB bus registered, assigned bus number 1 machine # [ 2.125974] ehci-pci 0000:00:1d.7: irq 19, io mem 0xfebdb000 machine # [ 2.133528] ehci-pci 0000:00:1d.7: USB 2.0 started, EHCI 1.00 machine # [ 2.134665] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 6.18 machine # [ 2.136476] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 machine # [ 2.138167] usb usb1: Product: EHCI Host Controller machine # [ 2.138841] usb usb1: Manufacturer: Linux 6.18.49 ehci_hcd machine # [ 2.141069] usb usb1: SerialNumber: 0000:00:1d.7 machine # [ 2.143164] hub 1-0:1.0: USB hub found machine # [ 2.144526] hub 1-0:1.0: 6 ports detected machine # [ 2.147483] uhci_hcd 0000:00:1d.0: UHCI Host Controller machine # [ 2.148220] uhci_hcd 0000:00:1d.0: new USB bus registered, assigned bus number 2 machine # [ 2.163237] uhci_hcd 0000:00:1d.0: detected 2 ports machine # [ 2.168415] uhci_hcd 0000:00:1d.0: irq 16, io port 0x0000c200 machine # [ 2.176221] usb usb2: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.18 machine # [ 2.177332] usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=1 machine # [ 2.193197] usb usb2: Product: UHCI Host Controller machine # [ 2.193896] usb usb2: Manufacturer: Linux 6.18.49 uhci_hcd machine # [ 2.200396] usb usb2: SerialNumber: 0000:00:1d.0 machine # [ 2.204618] SCSI subsystem initialized machine # [ 2.064923] systemd[1]: Starting Virtual Console Setup... machine # [ 2.211462] hub 2-0:1.0: USB hub found machine # [ 2.215699] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input0 machine # [ 2.221174] hub 2-0:1.0: 2 ports detected machine # [ 2.084593] (udev-worker)[93]: Network interface NamePolicy= disabled on kernel command line. machine # [ 2.100264] (udev-worker)[91]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. machine # [ 2.103186] (udev-worker)[91]: Network interface NamePolicy= disabled on kernel command line. machine # [ 2.249730] uhci_hcd 0000:00:1d.1: UHCI Host Controller machine # [ 2.109965] systemd-vconsole-setup[99]: Configuration of first virtual console was skipped, ignoring remaining ones. machine # [ 2.111925] systemd[1]: Finished Virtual Console Setup. machine # [ 2.269489] uhci_hcd 0000:00:1d.1: new USB bus registered, assigned bus number 3 machine # [ 2.276776] uhci_hcd 0000:00:1d.1: detected 2 ports machine # [ 2.279312] uhci_hcd 0000:00:1d.1: irq 17, io port 0x0000c220 machine # [ 2.284092] usb usb3: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.18 machine # [ 2.285233] usb usb3: New USB device strings: Mfr=3, Product=2, SerialNumber=1 machine # [ 2.148821] systemd[1]: Found device /dev/disk/by-label/nixos. machine # [ 2.149849] systemd[1]: Reached target Initrd Root Device. machine # [ 2.294010] usb usb3: Product: UHCI Host Controller machine # [ 2.294994] usb usb3: Manufacturer: Linux 6.18.49 uhci_hcd machine # [ 2.153955] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos... machine # [ 2.302068] usb usb3: SerialNumber: 0000:00:1d.1 machine # [ 2.303475] hub 3-0:1.0: USB hub found machine # [ 2.304445] hub 3-0:1.0: 2 ports detected machine # [ 2.313513] uhci_hcd 0000:00:1d.2: UHCI Host Controller machine # [ 2.314233] uhci_hcd 0000:00:1d.2: new USB bus registered, assigned bus number 4 machine # [ 2.321251] uhci_hcd 0000:00:1d.2: detected 2 ports machine # [ 2.323100] uhci_hcd 0000:00:1d.2: irq 18, io port 0x0000c240 machine # [ 2.330996] usb usb4: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.18 machine # [ 2.192131] systemd-fsck[107]: nixos: clean, 12/65536 files, 13019/262144 blocks machine # [ 2.335334] usb usb4: New USB device strings: Mfr=3, Product=2, SerialNumber=1 machine # [ 2.197860] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos. machine # [ 2.342605] usb usb4: Product: UHCI Host Controller machine # [ 2.345115] usb usb4: Manufacturer: Linux 6.18.49 uhci_hcd machine # [ 2.345889] usb usb4: SerialNumber: 0000:00:1d.2 machine # [ 2.346901] hub 4-0:1.0: USB hub found machine # [ 2.348788] ahci 0000:00:1f.2: AHCI vers 0001.0000, 32 command slots, 1.5 Gbps, SATA mode machine # [ 2.350792] hub 4-0:1.0: 2 ports detected machine # [ 2.354353] ahci 0000:00:1f.2: 6/6 ports implemented (port mask 0x3f) machine # [ 2.364400] ahci 0000:00:1f.2: flags: 64bit ncq only machine # [ 2.375169] scsi host0: ahci machine # [ 2.376796] scsi host1: ahci machine # [ 2.380084] scsi host2: ahci machine # [ 2.381079] usb 1-1: new high-speed USB device number 2 using ehci-pci machine # [ 2.387363] scsi host3: ahci machine # [ 2.390339] scsi host4: ahci machine # [ 2.393104] scsi host5: ahci machine # [ 2.393705] ata1: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc100 irq 44 lpm-pol 1 machine # [ 2.399165] ata2: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc180 irq 44 lpm-pol 1 machine # [ 2.402351] ata3: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc200 irq 44 lpm-pol 1 machine # [ 2.404328] ata4: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc280 irq 44 lpm-pol 1 machine # [ 2.405481] ata5: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc300 irq 44 lpm-pol 1 machine # [ 2.406652] ata6: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc380 irq 44 lpm-pol 1 machine # [ 2.510308] usb 1-1: New USB device found, idVendor=0627, idProduct=0001, bcdDevice= 0.00 machine # [ 2.513160] usb 1-1: New USB device strings: Mfr=1, Product=3, SerialNumber=10 machine # [ 2.516314] usb 1-1: Product: QEMU USB Tablet machine # [ 2.518094] usb 1-1: Manufacturer: QEMU machine # [ 2.519605] usb 1-1: SerialNumber: 28754-0000:00:1d.7-1 machine # [ 2.551839] hid: raw HID events driver (C) Jiri Kosina machine # [ 2.476552] systemd[1]: Mounting /sysroot... machine # [ 2.718892] ata5: SATA link down (SStatus 0 SControl 300) machine # [ 2.721577] ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 300) machine # [ 2.723885] ata3.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/100 machine # [ 2.726217] ata3.00: applying bridge limits machine # [ 2.728100] ata4: SATA link down (SStatus 0 SControl 300) machine # [ 2.730318] ata2: SATA link down (SStatus 0 SControl 300) machine # [ 2.732359] ata6: SATA link down (SStatus 0 SControl 300) machine # [ 2.734662] ata1: SATA link down (SStatus 0 SControl 300) machine # [ 2.736909] ata3.00: configured for UDMA/100 machine # [ 2.739319] scsi 2:0:0:0: CD-ROM QEMU QEMU DVD-ROM 2.5+ PQ: 0 ANSI: 5 machine # [ 2.794903] usbcore: registered new interface driver usbhid machine # [ 2.799065] usbhid: USB HID core driver machine # [ 2.821409] 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.823278] 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.837192] sr 2:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray machine # [ 2.845689] EXT4-fs (vda): mounted filesystem 1541240e-66ae-4f3d-ade5-f116a6086928 r/w with ordered data mode. Quota mode: none. machine # [ 2.848941] cdrom: Uniform CD-ROM driver Revision: 3.20 machine # [ 2.709099] systemd[1]: Mounted /sysroot. machine # [ 2.711738] systemd[1]: Reached target Initrd Root File System. machine # [ 2.716090] systemd[1]: Starting Mountpoints Configured in the Real Root... machine # [ 2.730769] systemd-sysroot-fstab-check[140]: /sysroot should be mounted in the initrd, will request daemon-reload. machine # [ 2.733597] systemd[1]: Reload requested from client PID 140 ('systemd-sysroot') (unit initrd-parse-etc.service)... machine # [ 2.736591] systemd[1]: Reloading... machine # [ 2.814967] systemd[1]: Reloading finished in 79 ms. machine # [ 2.821739] systemd-sysroot-fstab-check[140]: Requesting initrd-fs.target/start/replace... machine # [ 2.826189] systemd-sysroot-fstab-check[140]: Requesting swap.target/start/replace... machine # [ 2.829330] systemd[1]: initrd-parse-etc.service: Deactivated successfully. machine # [ 2.830719] systemd[1]: Finished Mountpoints Configured in the Real Root. machine # [ 2.832240] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies. machine # [ 2.834635] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio machine # [ 3.477226] systemd[1]: Mounting /sysroot/nix/.ro-store... machine # [ 3.483218] systemd[1]: Mounting /sysroot/nix/.rw-store... machine # [ 3.489295] systemd[1]: Mounting /sysroot/run... machine # [ 3.501308] systemd[1]: Mounting /sysroot/tmp/shared... machine # [ 3.512335] systemd[1]: Mounting /sysroot/tmp/xchg... machine # [ 3.697908] 9p: Installing v9fs 9p2000 file system support machine # [ 3.559079] systemd[1]: Mounted /sysroot/nix/.rw-store. machine # [ 3.559922] systemd[1]: Mounted /sysroot/run. machine # [ 3.571885] systemd[1]: Starting rw-sysroot-nix-store.service... machine # [ 3.574668] systemd[1]: Mounted /sysroot/nix/.ro-store. machine # [ 3.575592] systemd[1]: Mounted /sysroot/tmp/shared. machine # [ 3.577243] systemd[1]: Mounted /sysroot/tmp/xchg. machine # [ 3.588256] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. machine # [ 3.590100] systemd[1]: Finished rw-sysroot-nix-store.service. machine # [ 3.591489] systemd[1]: Mounting /sysroot/nix/store... machine # [ 3.611694] systemd[1]: Mounted /sysroot/nix/store. machine # [ 3.613084] systemd[1]: Reached target Initrd File Systems. machine # [ 3.614417] systemd[1]: Starting Find NixOS closure... machine # [ 3.618141] systemd[1]: Starting Create Volatile Files and Directories in the Real Root... machine # [ 3.635055] systemd[1]: Finished Create Volatile Files and Directories in the Real Root. machine # [ 3.643606] systemd[1]: Finished Find NixOS closure. machine # [ 3.644694] systemd[1]: Reached target Initrd Default Target. machine # [ 3.646497] systemd[1]: Starting Cleaning Up and Shutting Down Daemons... machine # [ 3.659990] systemd[1]: Stopped target Initrd Default Target. machine # [ 3.662241] systemd[1]: Stopped target Basic System. machine # [ 3.663021] systemd[1]: Stopped target Initrd Root Device. machine # [ 3.663821] systemd[1]: Stopped target Path Units. machine # [ 3.664580] systemd[1]: systemd-ask-password-console.path: Deactivated successfully. machine # [ 3.665588] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch. machine # [ 3.666603] systemd[1]: Stopped target Slice Units. machine # [ 3.667297] systemd[1]: Stopped target Socket Units. machine # [ 3.668043] systemd[1]: Stopped target System Initialization. machine # [ 3.669136] systemd[1]: Stopped target Swaps. machine # [ 3.669953] systemd[1]: Stopped target Timer Units. machine # [ 3.670886] systemd[1]: dbus.socket: Deactivated successfully. machine # [ 3.672115] systemd[1]: Closed D-Bus System Message Bus Socket. machine # [ 3.673693] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully. machine # [ 3.674699] systemd[1]: Stopped Find NixOS closure. machine # [ 3.675455] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio machine # [ 3.677189] systemd[1]: Starting rw-sysroot-nix-store.service... machine # [ 3.678148] systemd[1]: systemd-sysctl.service: Deactivated successfully. machine # [ 3.680285] systemd[1]: Stopped Apply Kernel Variables. machine # [ 3.681318] systemd[1]: systemd-modules-load.service: Deactivated successfully. machine # [ 3.683181] systemd[1]: Stopped Load Kernel Modules. machine # [ 3.683974] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully. machine # [ 3.684984] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root. machine # [ 3.686045] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. machine # [ 3.687032] systemd[1]: Stopped Create System Files and Directories. machine # [ 3.688108] systemd[1]: Stopped target Local File Systems. machine # [ 3.689114] systemd[1]: Stopped target Preparation for Local File Systems. machine # [ 3.691131] systemd[1]: systemd-udev-trigger.service: Deactivated successfully. machine # [ 3.692179] systemd[1]: Stopped Coldplug All udev Devices. machine # [ 3.694772] systemd[1]: Stopping Rule-based Manager for Device Events and Files... machine # [ 3.695788] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. machine # [ 3.696751] systemd[1]: Stopped Virtual Console Setup. machine # [ 3.705805] systemd[1]: initrd-cleanup.service: Deactivated successfully. machine # [ 3.709860] systemd[1]: Finished Cleaning Up and Shutting Down Daemons. machine # [ 3.716804] systemd[1]: systemd-udevd.service: Deactivated successfully. machine # [ 3.718249] systemd[1]: Stopped Rule-based Manager for Device Events and Files. machine # [ 3.719612] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. machine # [ 3.721032] systemd[1]: Finished rw-sysroot-nix-store.service. machine # [ 3.724084] systemd[1]: Starting Cleanup udev Database... machine # [ 3.724848] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. machine # [ 3.725876] systemd[1]: Stopped Create Static Device Nodes in /dev. machine # [ 3.727149] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. machine # [ 3.728259] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully. machine # [ 3.730143] systemd[1]: kmod-static-nodes.service: Deactivated successfully. machine # [ 3.731098] systemd[1]: Stopped Create List of Static Device Nodes. machine # [ 3.746340] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. machine # [ 3.747918] systemd[1]: Finished Cleanup udev Database. machine # [ 3.749432] systemd[1]: Reached target Switch Root. machine # [ 3.752336] systemd[1]: Starting NixOS Activation... machine # [ 3.914900] initrd-nixos-activation-start[195]: booting system configuration /nix/store/yv0fgsc3a9pf40xia3yrhzply67kinx0-nixos-system-machine-test machine # [ 3.980169] initrd-nixos-activation-start[195]: running activation script... machine # [ 4.356365] initrd-nixos-activation-start[218]: setting up /etc... machine # [ 4.568396] systemd[1]: initrd-nixos-activation.service: Deactivated successfully. machine # [ 4.570169] systemd[1]: Finished NixOS Activation. machine # [ 4.571772] systemd[1]: Starting Switch Root... machine # [ 4.584178] systemd[1]: Switching root. machine # [ 4.861970] systemd-journald[67]: Received SIGTERM from PID 1 (systemd). machine # [ 5.009808] NET: Registered PF_VSOCK protocol family machine # [ 5.393336] systemd[1]: systemd 262-9457f81 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE) machine # [ 5.402721] systemd[1]: Detected virtualization kvm. machine # [ 5.404496] systemd[1]: Detected architecture x86-64. machine # [ 5.406336] systemd[1]: Detected first boot. machine # [ 5.413404] systemd[1]: Initializing machine ID from random generator. machine # [ 5.538438] systemd[1]: bpf-restrict-fs: LSM BPF program attached machine # [ 5.663480] systemd[1]: Applying preset policy. machine # [ 6.112495] systemd[1]: Populated /etc with preset unit settings. machine # [ 6.575395] systemd[1]: initrd-switch-root.service: Deactivated successfully. machine # [ 6.576881] systemd[1]: Stopped initrd-switch-root.service. machine # [ 6.579458] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. machine # [ 6.581623] systemd[1]: Created slice Slice /system/getty. machine # [ 6.582918] systemd[1]: Created slice User and Session Slice. machine # [ 6.584010] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. machine # [ 6.585261] systemd[1]: Started Forward Password Requests to Wall Directory Watch. machine # [ 6.586319] systemd[1]: Expecting device /dev/hvc0... machine # [ 6.586969] systemd[1]: Expecting device /dev/ttyS0... machine # [ 6.587730] systemd[1]: Reached target Local Encrypted Volumes. machine # [ 6.588560] systemd[1]: Stopped target initrd-fs.target. machine # [ 6.589283] systemd[1]: Stopped target initrd-root-fs.target. machine # [ 6.590039] systemd[1]: Stopped target initrd-switch-root.target. machine # [ 6.590872] systemd[1]: Reached target Virtual Machines and Containers. machine # [ 6.591780] systemd[1]: Reached target Path Units. machine # [ 6.592460] systemd[1]: Reached target Remote File Systems. machine # [ 6.593219] systemd[1]: Reached target Slice Units. machine # [ 6.593898] systemd[1]: Reached target Swaps. machine # [ 6.608926] systemd[1]: Listening on Query the User Interactively for a Password. machine # [ 6.613201] systemd[1]: Listening on Process Core Dump Socket. machine # [ 6.616405] systemd[1]: Listening on Credential Encryption/Decryption. machine # [ 6.619328] systemd[1]: Listening on Factory Reset Management. machine # [ 6.620214] systemd[1]: Listening on Hostname Service Socket. machine # [ 6.624378] systemd[1]: Starting Journal Log Access Socket... machine # [ 6.626333] systemd[1]: Listening on Journal Audit Socket. machine # [ 6.629657] systemd[1]: Listening on Console Output Muting Service Socket. machine # [ 6.630745] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket. machine # [ 6.632540] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 6.633846] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 6.644821] systemd[1]: Listening on Disk Repartitioning Service Socket. machine # [ 6.645877] systemd[1]: Listening on udev Varlink Socket. machine # [ 6.650502] systemd[1]: Mounting Huge Pages File System... machine # [ 6.653678] systemd[1]: Mounting POSIX Message Queue File System... machine # [ 6.660131] systemd[1]: Mounting Kernel Debug File System... machine # [ 6.664799] systemd[1]: Mounting Kernel Trace File System... machine # [ 6.670605] systemd[1]: Starting Create List of Static Device Nodes... machine # [ 6.672493] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio machine # [ 6.680259] systemd[1]: Starting Load Kernel Module configfs... machine # [ 6.682736] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm machine # [ 6.684557] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 6.687409] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse machine # [ 6.698198] systemd[1]: Mounting FUSE Control File System... machine # [ 6.699489] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 6.738692] systemd[1]: Starting Journal Service... machine # [ 6.760344] systemd[1]: Starting Load Kernel Modules... machine # [ 6.778461] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer... machine # [ 6.793397] systemd[1]: Starting Remount Root and Kernel File Systems... machine # [ 6.798435] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 6.813546] systemd[1]: Starting Coldplug All udev Devices... machine # [ 6.828470] systemd[1]: Listening on Journal Log Access Socket. machine # [ 6.830488] systemd-journald[289]: Collecting audit messages is enabled. machine # [ 6.833666] systemd[1]: Mounted Huge Pages File System. machine # [ 6.838510] systemd[1]: Mounted POSIX Message Queue File System. machine # [ 6.846152] systemd[1]: Mounted Kernel Debug File System. machine # [ 6.849164] systemd[1]: Mounted Kernel Trace File System. machine # [ 6.856126] systemd[1]: Finished Create List of Static Device Nodes. machine # [ 6.862269] systemd[1]: modprobe@configfs.service: Deactivated successfully. machine # [ 6.724718] systemd[1]: Queued start job for default target Multi-User System. machine # [ 6.727264] systemd[1]: systemd-journald.service: Deactivated successfully. machine # [ 6.873497] systemd[1]: Finished Load Kernel Module configfs. machine # [ 6.875094] EXT4-fs (vda): re-mounted 1541240e-66ae-4f3d-ade5-f116a6086928. machine # [ 6.877006] loop: module loaded machine # [ 6.878770] systemd[1]: Started Journal Service. machine # [ 6.738538] systemd-modules-load[290]: Inserted module 'loop' machine # [ 6.744080] systemd[1]: Mounted FUSE Control File System. machine # [ 6.747788] systemd[1]: Finished Load Kernel Modules. machine # [ 6.749177] systemd[1]: Finished Remount Root and Kernel File Systems. machine # [ 6.763966] systemd[1]: Listening on Disk Image Download Service Socket. machine # [ 6.772068] systemd[1]: Mounting Kernel Configuration File System... machine # [ 6.778143] systemd[1]: Starting Firewall... machine # [ 6.788415] systemd[1]: Starting Flush Journal to Persistent Storage... machine # [ 6.791299] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 6.799639] systemd-oomd[292]: No swap; memory pressure usage will be degraded machine # [ 6.806727] systemd[1]: Starting Load/Save OS Random Seed... machine # [ 6.816281] systemd[1]: Starting Apply Kernel Variables... machine # [ 6.831062] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... machine # [ 6.834306] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 6.835508] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer. machine # [ 7.006204] systemd-journald[289]: Received client request to flush runtime journal. machine # [ 7.012431] systemd[1]: Mounted Kernel Configuration File System. machine # [ 7.013374] systemd[1]: Finished Load/Save OS Random Seed. machine # [ 7.017134] systemd[1]: Reached target First Boot Complete. machine # [ 7.018101] systemd[1]: Finished Apply Kernel Variables. machine # [ 7.018856] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. machine # [ 7.020115] systemd[1]: Starting Create Static Device Nodes in /dev... machine # [ 7.023832] systemd[1]: Finished Flush Journal to Persistent Storage. machine # [ 7.090616] systemd[1]: Finished Create Static Device Nodes in /dev. machine # [ 7.091625] systemd[1]: Reached target Preparation for Local File Systems. machine # [ 7.097395] systemd[1]: Starting Rule-based Manager for Device Events and Files... machine # [ 7.155820] systemd[1]: Finished Coldplug All udev Devices. machine # [ 7.187532] systemd-udevd[331]: Using default interface naming scheme 'v261'. machine # [ 7.295660] systemd[1]: Started Rule-based Manager for Device Events and Files. machine # [ 7.423286] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse machine # [ 7.438870] systemd[1]: Mounting /run/wrappers... machine # [ 7.479513] systemd[1]: Mounted /run/wrappers. machine # [ 7.481698] systemd[1]: Reached target Local File Systems. machine # [ 7.484783] systemd[1]: Listening on Boot Loader Control Service Socket. machine # [ 7.489195] systemd[1]: Starting register-nix-paths.service... machine # [ 7.494197] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 7.495130] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 7.500200] systemd[1]: Starting Save Transient machine-id to Disk... machine # [ 7.518312] systemd[1]: Starting Create System Files and Directories... machine # [ 7.552882] systemd[1]: Condition check resulted in /dev/hvc0 being skipped. machine # [ 7.601320] systemd[1]: etc-machine\x2did.mount: Deactivated successfully. machine # [ 7.605290] systemd[1]: Finished Save Transient machine-id to Disk. machine # [ 7.650187] systemd[1]: Condition check resulted in /dev/ttyS0 being skipped. machine # [ 7.674212] systemd[1]: Finished Create System Files and Directories. machine # [ 7.679662] systemd[1]: Starting Rebuild Journal Catalog... machine # [ 7.687623] systemd[1]: Starting Record System Boot/Shutdown in UTMP... machine # [ 7.751455] (udev-worker)[366]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. machine # [ 7.758737] (udev-worker)[366]: Network interface NamePolicy= disabled on kernel command line. machine # [ 7.765498] (udev-worker)[368]: Network interface NamePolicy= disabled on kernel command line. machine # [ 7.782425] systemd[1]: Finished Record System Boot/Shutdown in UTMP. machine # [ 7.827367] systemd[1]: Finished Rebuild Journal Catalog. machine # [ 7.835476] systemd[1]: Starting Update is Completed... machine # [ 7.886606] systemd[1]: Finished Update is Completed. machine # [ 7.979240] systemd[1]: Condition check resulted in Virtio network device being skipped. machine # [ 7.981529] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 7.983885] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 7.986449] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 7.988358] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 7.989778] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 7.990971] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 8.115671] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 8.116928] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 8.326571] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input3 machine # [ 8.328699] bochs-drm 0000:00:01.0: vgaarb: deactivate vga console machine # [ 8.200888] systemd[1]: Finished Firewall. machine # [ 8.361193] mousedev: PS/2 mouse device common for all mice machine # [ 8.363187] ACPI: button: Power Button [PWRF] machine # [ 8.435127] rtc_cmos 00:04: RTC can wake from S4 machine # [ 8.452711] rtc_cmos 00:04: registered as rtc0 machine # [ 8.452778] rtc_cmos 00:04: setting system clock to 2026-09-06T18:01:18 UTC (1788717678) machine # [ 8.452852] rtc_cmos 00:04: alarms up to one day, y3k, 242 bytes nvram, hpet irqs machine # [ 8.453299] systemd-journald[289]: Time jumped backwards, rotating. machine # [ 8.465773] Console: switching to colour dummy device 80x25 machine # [ 8.480525] parport_pc 00:02: reported by Plug and Play ACPI machine # [ 8.480631] parport0: PC-style at 0x378, irq 7 [PCSPP(,...)] machine # [ 8.499925] input: QEMU Virtio Keyboard as /devices/pci0000:00/0000:00:09.0/virtio7/input/input4 machine # [ 8.504653] lpc_ich 0000:00:1f.0: I/O space for GPIO uninitialized machine # [ 8.615339] [drm] Found bochs VGA, ID 0xb0c5. machine # [ 8.615341] [drm] Framebuffer size 16384 kB @ 0xfd000000, mmio @ 0xfebd0000. machine # [ 8.628311] i801_smbus 0000:00:1f.3: SMBus using PCI interrupt machine # [ 8.628974] i2c i2c-0: Memory type 0x07 not supported yet, not instantiating SPD machine # [ 8.638145] bochs-drm 0000:00:01.0: [drm] Registered 1 planes with drm panic machine # [ 8.638808] [drm] Initialized bochs-drm 1.0.0 for 0000:00:01.0 on minor 0 machine # [ 8.678355] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input6 machine # [ 8.679409] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input5 machine # [ 8.550184] systemd[1]: Finished register-nix-paths.service. machine # [ 8.552188] systemd[1]: Reached target System Initialization. machine # [ 8.553518] systemd[1]: Started Discard unused filesystem blocks once a week. machine # [ 8.554941] systemd[1]: Started Daily Cleanup of Temporary Directories. machine # [ 8.556131] systemd[1]: Reached target Timer Units. machine # [ 8.558183] systemd[1]: Listening on D-Bus System Message Bus Socket. machine # [ 8.559276] systemd[1]: Listening on Nix Daemon Socket. machine # [ 8.561139] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket. machine # [ 8.562359] systemd[1]: Reached target Socket Units. machine # [ 8.563111] systemd[1]: Reached target Basic System. machine # [ 8.566908] systemd[1]: Started backdoor.service. machine # [ 8.571615] systemd[1]: Starting Import lastlog data into lastlog2 database... machine # [ 8.583536] systemd[1]: Starting Name Service Cache Daemon (nsncd)... machine # [ 8.592690] systemd[1]: Starting Post-Boot Actions... machine # [ 8.606573] systemd[1]: Started Reset console on configuration changes. machine # [ 8.623819] systemd[1]: Starting resolvconf update... machine # connecting to host... machine # [ 8.687868] systemd[1]: Finished Post-Boot Actions. machine # [ 8.696142] nsncd[508]: Sep 06 18:01:18.883 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" machine # [ 8.700093] systemd[1]: Started Name Service Cache Daemon (nsncd). machine # [ 8.846434] Console: switching to colour frame buffer device 160x50 machine # [ 8.708685] systemd[1]: Reached target Host and Network Name Lookups. machine # [ 8.710988] systemd[1]: Reached target User and Group Name Lookups. machine # [ 8.721261] systemd[1]: Starting D-Bus System Message Bus... machine: Guest shell says: b'Spawning backdoor root shell...\n' machine: connected to guest root shell machine: (connecting took 9.41 seconds) machine: (finished: waiting for the VM to finish booting, in 9.64 seconds) machine # [ 8.743630] systemd[1]: Starting User Login Management... machine # [ 8.896539] bochs-drm 0000:00:01.0: [drm] fb0: bochs-drmdrmfb frame buffer device machine # [ 8.757241] systemd[1]: Starting Virtual Console Setup... machine # [ 8.760229] systemd[1]: Finished Import lastlog data into lastlog2 database. machine # [ 8.900347] dbus-broker-launch[533]: Looking up NSS user entry for 'systemd-timesync'... machine # [ 8.936323] dbus-broker-launch[533]: NSS returned no entry for 'systemd-timesync' machine # [ 8.938590] dbus-broker-launch[533]: Invalid user-name in /nix/store/wvv8w41xz1ya3m77c3n7zq9mi8fszl1v-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" machine # [ 8.947901] systemd[1]: Stopped target Host and Network Name Lookups. machine # [ 8.950240] systemd[1]: Stopping Host and Network Name Lookups... machine # [ 8.951724] systemd[1]: Stopped target User and Group Name Lookups. machine # [ 8.954696] systemd[1]: Stopping User and Group Name Lookups... machine # [ 8.957287] systemd[1]: Stopping Name Service Cache Daemon (nsncd)... machine # [ 8.960502] systemd[1]: nscd.service: Deactivated successfully. machine # [ 8.964559] systemd[1]: Stopped Name Service Cache Daemon (nsncd). machine # [ 8.973473] systemd-logind[534]: Watching system buttons on /dev/input/event2 (Power Button) machine # [ 8.975984] systemd-logind[534]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard) machine # [ 8.977729] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. machine # [ 8.979763] systemd-logind[534]: New seat seat0. machine # [ 8.982112] systemd[1]: Stopped Virtual Console Setup. machine # [ 8.989071] systemd[1]: Started D-Bus System Message Bus. machine # [ 8.990334] systemd[1]: Started User Login Management. machine # [ 9.135845] ppdev: user-space parallel port driver machine # [ 9.008753] systemd[1]: Starting linger-users.service... machine # [ 9.015341] systemd[1]: Starting Name Service Cache Daemon (nsncd)... machine # [ 9.030945] dbus-broker-launch[533]: Ready machine # [ 9.033588] systemd[1]: Starting Virtual Console Setup... machine # [ 9.034836] systemd-logind[534]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard) machine # [ 9.215485] iTCO_wdt iTCO_wdt.1.auto: Found a ICH9 TCO device (Version=2, TCOBASE=0x0660) machine # [ 9.120316] nsncd[594]: Sep 06 18:01:19.307 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" machine # [ 9.128082] systemd[1]: Started Name Service Cache Daemon (nsncd). machine # [ 9.271193] iTCO_wdt iTCO_wdt.1.auto: initialized. heartbeat=30 sec (nowayout=0) machine # [ 9.131318] systemd[1]: Finished resolvconf update. machine # [ 9.155455] systemd[1]: Created slice Slice /user/1001. machine # [ 9.156288] systemd[1]: Reached target Preparation for Network. machine # [ 9.157094] systemd[1]: Reached target Host and Network Name Lookups. machine # [ 9.157919] systemd[1]: Reached target User and Group Name Lookups. machine # [ 9.166295] systemd[1]: Starting DHCP Client... machine # [ 9.172898] systemd[1]: Starting Address configuration of eth1... machine # [ 9.181941] systemd[1]: Starting Extra networking commands.... machine # [ 9.186166] systemd[1]: Starting User Runtime Directory /run/user/1001... machine # [ 9.202964] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 9.204882] systemd[1]: Finished linger-users.service. machine # [ 9.230093] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. machine # [ 9.231114] systemd[1]: Stopped Virtual Console Setup. machine # [ 9.239229] systemd[1]: Starting Virtual Console Setup... machine # [ 9.275659] systemd[1]: Finished User Runtime Directory /run/user/1001. machine # [ 9.280603] systemd[1]: Starting User Manager for UID 1001... machine # [ 9.357894] (systemd)[635]: pam_unix(systemd-user:session): session opened for user usertest(uid=1001) by (uid=0) machine # [ 9.377400] systemd-logind[534]: New session '1' of user 'usertest' with class 'manager' and type 'unspecified'. machine # [ 9.412807] systemd[635]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 9.504364] network-addresses-eth1-start[625]: adding address 192.168.1.1/24... done machine # [ 9.505736] network-addresses-eth1-start[625]: adding address 2001:db8:1::1/64... done machine # [ 9.516787] systemd[1]: Finished Address configuration of eth1. machine # [ 9.698440] kvm_amd: TSC scaling supported machine # [ 9.698843] kvm_amd: Nested Virtualization enabled machine # [ 9.701227] kvm_amd: Nested Paging enabled machine # [ 9.701683] kvm_amd: LBR virtualization supported machine # [ 9.703414] kvm_amd: Virtual VMLOAD VMSAVE supported machine # [ 9.703943] kvm_amd: Virtual GIF supported machine # [ 9.707684] kvm_amd: Virtual NMI enabled machine # [ 9.624615] systemd[635]: Queued start job for default target Main User Target. machine # [ 9.629110] systemd[635]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 9.631271] systemd[635]: Created slice User Application Slice. machine # [ 9.632739] systemd[635]: Started Daily Cleanup of User's Temporary Directories. machine # [ 9.634410] systemd[635]: Reached target Paths. machine # [ 9.636838] systemd[635]: Reached target Timers. machine # [ 9.638516] systemd[635]: Starting D-Bus User Message Bus Socket... machine # [ 9.642672] systemd[635]: Starting Create User Files and Directories... machine # [ 9.803496] EDAC MC: Ver: 3.0.0 machine # [ 9.673379] systemd[1]: Finished Extra networking commands.. machine # [ 9.675081] systemd[1]: Reached target Network. machine # [ 9.680555] systemd[1]: Starting Permit User Sessions... machine # [ 9.689444] dhcpcd[643]: dhcpcd-10.3.2 starting machine # [ 9.696971] systemd[635]: Finished Create User Files and Directories. machine # [ 9.702533] dhcpcd[708]: dev: loaded udev machine # [ 9.872903] 8021q: 802.1Q VLAN Support v1.8 machine # [ 9.731745] systemd[1]: Finished Permit User Sessions. machine # [ 9.875430] 8021q: adding VLAN 0 to HW filter on device eth1 machine # [ 9.740287] systemd[1]: Started Getty on tty1. machine # [ 9.743625] systemd[1]: Reached target Login Prompts. machine # [ 9.746922] systemd[635]: Listening on D-Bus User Message Bus Socket. machine # [ 9.747933] systemd[635]: Reached target Sockets. machine # [ 9.751535] systemd[635]: Reached target Basic System. machine # [ 9.752532] systemd[1]: Started User Manager for UID 1001. machine # [ 9.753975] systemd[635]: Starting Run user-specific NixOS activation... machine # [ 9.773383] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch. machine # [ 9.814078] systemd[635]: Finished Run user-specific NixOS activation. machine # [ 9.815189] systemd[635]: Reached target Main User Target. machine # [ 9.817083] systemd[635]: Startup finished in 416ms. machine # [ 9.993187] cfg80211: Loading compiled-in X.509 certificates for regulatory database machine # [ 10.020615] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' machine # [ 10.021406] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600' machine # [ 10.024663] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -2 machine # [ 10.025618] cfg80211: failed to load regulatory.db machine # [ 10.077272] 8021q: adding VLAN 0 to HW filter on device eth0 machine # [ 9.936503] dhcpcd[708]: eth0: waiting for carrier machine # [ 9.938339] dhcpcd[708]: libudev: received NULL device machine # [ 9.939302] dhcpcd[708]: libudev: received NULL device machine # [ 9.940377] dhcpcd[708]: eth0: carrier acquired machine # [ 9.949564] dhcpcd[708]: DUID 00:01:00:01:32:30:66:f0:52:54:00:12:34:56 machine # [ 9.950461] dhcpcd[708]: eth0: IAID 00:12:34:56 machine # [ 9.951087] dhcpcd[708]: eth0: adding address fe80::5054:ff:fe12:3456 machine # [ 9.971726] systemd-vconsole-setup[631]: Configuration of first virtual console was skipped, ignoring remaining ones. machine # [ 9.976585] systemd[1]: Finished Virtual Console Setup. machine # [ 11.463599] dhcpcd[708]: eth0: soliciting a DHCP lease machine # [ 11.634473] NET: Registered PF_PACKET protocol family machine # [ 11.499279] dhcpcd[708]: eth0: offered 10.0.2.15 from 10.0.2.2 machine # [ 11.502359] dhcpcd[708]: eth0: probing address 10.0.2.15/24 machine # [ 11.520114] dhcpcd[708]: eth0: soliciting an IPv6 router machine # [ 11.530584] dhcpcd[708]: eth0: Router Advertisement from fe80::2 machine # [ 11.532328] dhcpcd[708]: eth0: adding address fec0::5054:ff:fe12:3456/64 machine # [ 11.534195] dhcpcd[708]: eth0: adding route to fec0::/64 machine # [ 11.535885] dhcpcd[708]: eth0: adding default route via fe80::2 machine # [ 16.768942] dhcpcd[708]: eth0: leased 10.0.2.15 for 86400 seconds machine # [ 16.769981] dhcpcd[708]: eth0: adding route to 10.0.2.0/24 machine # [ 16.770907] dhcpcd[708]: eth0: adding default route via 10.0.2.2 machine # [ 16.862568] systemd[1]: Started DHCP Client. machine # [ 16.864538] systemd[1]: Reached target Multi-User System. machine # [ 16.865498] systemd[1]: Startup finished in 861ms (kernel) + 3.945s (initrd) + 12.057s (userspace) = 16.864s. machine: (finished: waiting for unit multi-user.target, in 18.63 seconds) machine: must succeed: /nix/store/w1psanxc52jqfm0knzrj6gw0pz8my68n-stderr-runner /nix/store/yv0fgsc3a9pf40xia3yrhzply67kinx0-nixos-system-machine-test/bin/switch-to-configuration test machine # Checking switch inhibitors... done machine # [ 18.283365] nixos[863]: switching to system configuration /nix/store/yv0fgsc3a9pf40xia3yrhzply67kinx0-nixos-system-machine-test machine # [ 18.285566] systemd[1]: Stopped target Local File Systems. machine # [ 18.287207] systemd[1]: Stopped target Remote File Systems. machine # activating the configuration... machine # setting up /etc... machine # [ 18.657617] systemd[1]: Reload requested from client PID 863 ('.switch-to-conf') (unit backdoor.service)... machine # [ 18.659241] systemd[1]: Reloading... machine # [ 19.181112] systemd[1]: Reloading finished in 520 ms. machine # reloading user units for usertest... machine # [ 19.214836] systemd[635]: Created slice User Core Session Slice. machine # [ 19.217871] systemd[635]: Starting D-Bus User Message Bus... machine # [ 19.275222] dbus-broker-launch[933]: Ignoring duplicate name 'org.freedesktop.import1' in service file '/nix/store/wvv8w41xz1ya3m77c3n7zq9mi8fszl1v-system-path/share/dbus-1/services/org.freedesktop.import1.service' machine # [ 19.278312] dbus-broker-launch[933]: Ignoring duplicate name 'org.freedesktop.machine1' in service file '/nix/store/wvv8w41xz1ya3m77c3n7zq9mi8fszl1v-system-path/share/dbus-1/services/org.freedesktop.machine1.service' machine # [ 19.281274] dbus-broker-launch[933]: Ignoring duplicate name 'org.freedesktop.portable1' in service file '/nix/store/wvv8w41xz1ya3m77c3n7zq9mi8fszl1v-system-path/share/dbus-1/services/org.freedesktop.portable1.service' machine # [ 19.284538] dbus-broker-launch[933]: Ignoring duplicate name 'org.freedesktop.systemd1' in service file '/nix/store/wvv8w41xz1ya3m77c3n7zq9mi8fszl1v-system-path/share/dbus-1/services/org.freedesktop.systemd1.service' machine # [ 19.287692] systemd[635]: Started D-Bus User Message Bus. machine # [ 19.288683] dbus-broker-launch[933]: Policy to allow eavesdropping in /etc/dbus-1/session.conf +27: Eavesdropping is deprecated and ignored machine # [ 19.290154] dbus-broker-launch[933]: Policy to allow eavesdropping in /etc/dbus-1/session.conf +29: Eavesdropping is deprecated and ignored machine # [ 19.299257] dbus-broker-launch[933]: Ready machine # [ 19.407934] systemd[635]: Reexecution requested from client PID 932 ('switch-to-confi')... machine # [ 19.409211] systemd[635]: Reexecuting. machine # [ 19.438723] systemd[635]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 19.603102] systemd[635]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 19.608917] systemd[635]: Reload requested from client PID 932 ('switch-to-confi')... machine # [ 19.610670] systemd[635]: Reloading... machine # [ 19.778597] systemd[635]: Reloading finished in 166 ms. machine # [ 19.782826] systemd[635]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # restarting the following user units: nixos-activation.service machine # [ 19.790087] systemd[635]: Stopped Run user-specific NixOS activation. machine # [ 19.790932] systemd[635]: Stopping Run user-specific NixOS activation... machine # [ 19.794219] systemd[635]: Starting Run user-specific NixOS activation... machine # [ 19.834648] systemd[635]: Finished Run user-specific NixOS activation. machine # restarting sysinit-reactivation.target machine # [ 19.850764] systemd[1]: Starting Re-setup tmpfiles on a system that is already running.... machine # [ 19.956953] systemd[1]: Finished Re-setup tmpfiles on a system that is already running.. machine # [ 19.959984] systemd[1]: Reached target Reactivate sysinit units. machine # [ 19.963724] systemd[1]: Reached target Remote File Systems. machine # [ 19.967904] systemd[1]: Starting linger-users.service... machine # [ 19.975788] systemd[1]: Reached target Local File Systems. machine # [ 19.979532] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 19.981470] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 19.985098] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 19.990357] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 19.992144] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 19.993906] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 19.995841] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 19.997260] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 19.998406] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 20.049761] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 20.051449] systemd[1]: Finished linger-users.service. machine # [ 20.361685] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 20.364479] systemd[1]: Finished Create SUID/SGID Wrappers. machine # the following new units were started: sysinit-reactivation.target, systemd-tmpfiles-resetup.service machine # [ 20.624757] nixos[863]: finished switching to system configuration /nix/store/yv0fgsc3a9pf40xia3yrhzply67kinx0-nixos-system-machine-test machine: (finished: must succeed: /nix/store/w1psanxc52jqfm0knzrj6gw0pz8my68n-stderr-runner /nix/store/yv0fgsc3a9pf40xia3yrhzply67kinx0-nixos-system-machine-test/bin/switch-to-configuration test, in 2.91 seconds) machine: must succeed: rm /etc/NIXOS machine: (finished: must succeed: rm /etc/NIXOS, in 0.05 seconds) machine: must succeed: /nix/store/w1psanxc52jqfm0knzrj6gw0pz8my68n-stderr-runner /nix/store/vzs54kdlsqiwmwb7xkynzgrx8j29jc7h-nixos-system-other-test/bin/switch-to-configuration test machine # this should succeed (config: /nix/store/vzs54kdlsqiwmwb7xkynzgrx8j29jc7h-nixos-system-other-test, action: test) machine # Checking switch inhibitors... done machine # [ 21.492464] nixos[1011]: switching to system configuration /nix/store/vzs54kdlsqiwmwb7xkynzgrx8j29jc7h-nixos-system-other-test machine # [ 21.494765] systemd[1]: Stopped target Local File Systems. machine # [ 21.496477] systemd[1]: Stopped target Remote File Systems. machine # activating the configuration... machine # removing user ‘usertest’ machine # setting up /etc... machine # [ 21.945048] systemd[1]: Reload requested from client PID 1011 ('.switch-to-conf') (unit backdoor.service)... machine # [ 21.946665] systemd[1]: Reloading... machine # [ 22.577120] systemd[1]: Reloading finished in 627 ms. machine # reloading user units for usertest... machine # [ 22.739571] systemd[635]: Reexecution requested from client PID 1082 ('switch-to-confi')... machine # [ 22.741994] systemd[635]: Reexecuting. machine # [ 22.770441] systemd[635]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 22.953865] systemd[635]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 22.959816] systemd[635]: Reload requested from client PID 1082 ('switch-to-confi')... machine # [ 22.961687] systemd[635]: Reloading... machine # [ 23.134156] systemd[635]: Reloading finished in 170 ms. machine # [ 23.139834] systemd[635]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # restarting the following user units: nixos-activation.service machine # [ 23.147851] systemd[635]: Stopped Run user-specific NixOS activation. machine # [ 23.148767] systemd[635]: Stopping Run user-specific NixOS activation... machine # [ 23.151512] systemd[635]: Starting Run user-specific NixOS activation... machine # [ 23.193263] systemd[635]: Finished Run user-specific NixOS activation. machine # restarting sysinit-reactivation.target machine # [ 23.197111] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 23.198567] systemd[1]: Stopping Reactivate sysinit units... machine # reloading the following units: dbus-broker.service machine # [ 23.200129] systemd[1]: Reached target Reactivate sysinit units. machine # [ 23.202464] dbus-broker-launch[533]: Caught SIGHUP, trigger reload. machine # [ 23.203744] systemd[1]: Reloading D-Bus System Message Bus... machine # [ 23.228918] dbus-broker-launch[533]: Looking up NSS user entry for 'systemd-timesync'... machine # [ 23.230971] dbus-broker-launch[533]: NSS returned no entry for 'systemd-timesync' machine # [ 23.231953] dbus-broker-launch[533]: Invalid user-name in /nix/store/yl6shlfxw95siygj3vrskihkygz4y1d6-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" machine # [ 23.261068] systemd[1]: Reloaded D-Bus System Message Bus. machine # restarting the following units: network-addresses-eth1.service machine # [ 23.267249] systemd[1]: Stopping Address configuration of eth1... machine # [ 23.313345] network-addresses-eth1-pre-stop[1095]: deleting address 192.168.1.1/24... done machine # [ 23.325071] network-addresses-eth1-pre-stop[1095]: deleting address 2001:db8:1::1/64... done machine # [ 23.334725] systemd[1]: network-addresses-eth1.service: Deactivated successfully. machine # [ 23.335820] systemd[1]: Stopped Address configuration of eth1. machine # [ 23.339926] systemd[1]: Starting Address configuration of eth1... machine # [ 23.409877] network-addresses-eth1-start[1100]: adding address 192.168.1.2/24... done machine # [ 23.422498] network-addresses-eth1-start[1100]: adding address 2001:db8:1::2/64... done machine # [ 23.437069] systemd[1]: Finished Address configuration of eth1. machine # [ 23.440962] systemd[1]: Reached target Local File Systems. machine # [ 23.442324] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 23.447386] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 23.448377] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 23.450076] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 23.451928] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 23.453273] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 23.454360] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 23.460930] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 23.462610] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 23.463783] systemd[1]: Reached target Remote File Systems. machine # [ 23.859928] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 23.861650] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 23.866377] systemd[1]: Starting linger-users.service... machine # [ 23.910714] linger-users-start[1172]: id: ‘usertest’: no such user machine # [ 23.912770] linger-users-start[1170]: Removing linger for missing user usertest machine # [ 23.921681] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 23.923278] systemd[1]: Finished linger-users.service. machine # [ 24.180617] nixos[1011]: finished switching to system configuration /nix/store/vzs54kdlsqiwmwb7xkynzgrx8j29jc7h-nixos-system-other-test machine: (finished: must succeed: /nix/store/w1psanxc52jqfm0knzrj6gw0pz8my68n-stderr-runner /nix/store/vzs54kdlsqiwmwb7xkynzgrx8j29jc7h-nixos-system-other-test/bin/switch-to-configuration test, in 3.51 seconds) subtest: services machine: must succeed: /nix/store/yv0fgsc3a9pf40xia3yrhzply67kinx0-nixos-system-machine-test/bin/switch-to-configuration test 2>&1 machine # [ 24.930208] nixos[1178]: switching to system configuration /nix/store/yv0fgsc3a9pf40xia3yrhzply67kinx0-nixos-system-machine-test machine # [ 24.933746] systemd[1]: Stopped target Local File Systems. machine # [ 24.934693] systemd[1]: Stopped target Remote File Systems. machine # [ 25.406476] systemd[1]: Reload requested from client PID 1178 ('.switch-to-conf') (unit backdoor.service)... machine # [ 25.408121] systemd[1]: Reloading... machine # [ 26.027194] systemd[1]: Reloading finished in 615 ms. machine # [ 26.151528] systemd[635]: Reexecution requested from client PID 1247 ('switch-to-confi')... machine # [ 26.153849] systemd[635]: Reexecuting. machine # [ 26.179642] systemd[635]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 26.331921] systemd[635]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 26.337081] systemd[635]: Reload requested from client PID 1247 ('switch-to-confi')... machine # [ 26.338258] systemd[635]: Reloading... machine # [ 26.508774] systemd[635]: Reloading finished in 168 ms. machine # [ 26.512824] systemd[635]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 26.520077] systemd[635]: Stopped Run user-specific NixOS activation. machine # [ 26.521086] systemd[635]: Stopping Run user-specific NixOS activation... machine # [ 26.523672] systemd[635]: Starting Run user-specific NixOS activation... machine # [ 26.560776] systemd[635]: Finished Run user-specific NixOS activation. machine # [ 26.563957] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 26.565458] systemd[1]: Stopping Reactivate sysinit units... machine # [ 26.566441] systemd[1]: Reached target Reactivate sysinit units. machine # [ 26.568502] dbus-broker-launch[533]: Caught SIGHUP, trigger reload. machine # [ 26.570084] systemd[1]: Reloading D-Bus System Message Bus... machine # [ 26.582795] dbus-broker-launch[533]: Looking up NSS user entry for 'systemd-timesync'... machine # [ 26.584642] dbus-broker-launch[533]: NSS returned no entry for 'systemd-timesync' machine # [ 26.585647] dbus-broker-launch[533]: Invalid user-name in /nix/store/wvv8w41xz1ya3m77c3n7zq9mi8fszl1v-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" machine # [ 26.603712] systemd[1]: Reloaded D-Bus System Message Bus. machine # [ 26.608732] systemd[1]: Stopping Address configuration of eth1... machine # [ 26.650793] network-addresses-eth1-pre-stop[1260]: deleting address 192.168.1.2/24... done machine # [ 26.663716] network-addresses-eth1-pre-stop[1260]: deleting address 2001:db8:1::2/64... done machine # [ 26.673579] systemd[1]: network-addresses-eth1.service: Deactivated successfully. machine # [ 26.674645] systemd[1]: Stopped Address configuration of eth1. machine # [ 26.678729] systemd[1]: Starting Address configuration of eth1... machine # [ 26.750375] network-addresses-eth1-start[1265]: adding address 192.168.1.1/24... done machine # [ 26.763575] network-addresses-eth1-start[1265]: adding address 2001:db8:1::1/64... done machine # [ 26.779246] systemd[1]: Finished Address configuration of eth1. machine # [ 26.783465] systemd[1]: Reached target Remote File Systems. machine # [ 26.787280] systemd[1]: Starting linger-users.service... machine # [ 26.790764] systemd[1]: Reached target Local File Systems. machine # [ 26.792834] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 26.798546] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 26.799581] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 26.801156] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 26.803100] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 26.804445] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 26.805570] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 26.817675] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 26.819442] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 26.855416] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 26.857160] systemd[1]: Finished linger-users.service. machine # [ 27.146882] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 27.148097] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 27.406086] nixos[1178]: finished switching to system configuration /nix/store/yv0fgsc3a9pf40xia3yrhzply67kinx0-nixos-system-machine-test machine: (finished: must succeed: /nix/store/yv0fgsc3a9pf40xia3yrhzply67kinx0-nixos-system-machine-test/bin/switch-to-configuration test 2>&1, in 3.22 seconds) machine: must succeed: /nix/store/yv0fgsc3a9pf40xia3yrhzply67kinx0-nixos-system-machine-test/bin/switch-to-configuration test 2>&1 machine # [ 28.032919] nixos[1334]: switching to system configuration /nix/store/yv0fgsc3a9pf40xia3yrhzply67kinx0-nixos-system-machine-test machine # [ 28.036101] systemd[1]: Stopped target Local File Systems. machine # [ 28.036860] systemd[1]: Stopped target Remote File Systems. machine # [ 28.452134] systemd[1]: Reload requested from client PID 1334 ('.switch-to-conf') (unit backdoor.service)... machine # [ 28.453732] systemd[1]: Reloading... machine # [ 28.903656] systemd[1]: Reloading finished in 446 ms. machine # [ 29.016212] systemd[635]: Reexecution requested from client PID 1403 ('switch-to-confi')... machine # [ 29.017437] systemd[635]: Reexecuting. machine # [ 29.047428] systemd[635]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 29.208373] systemd[635]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 29.213985] systemd[635]: Reload requested from client PID 1403 ('switch-to-confi')... machine # [ 29.215507] systemd[635]: Reloading... machine # [ 29.386801] systemd[635]: Reloading finished in 169 ms. machine # [ 29.391826] systemd[635]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 29.399072] systemd[635]: Stopped Run user-specific NixOS activation. machine # [ 29.399919] systemd[635]: Stopping Run user-specific NixOS activation... machine # [ 29.402727] systemd[635]: Starting Run user-specific NixOS activation... machine # [ 29.443960] systemd[635]: Finished Run user-specific NixOS activation. machine # [ 29.447454] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 29.448669] systemd[1]: Stopping Reactivate sysinit units... machine # [ 29.449636] systemd[1]: Reached target Reactivate sysinit units. machine # [ 29.453687] systemd[1]: Reached target Local File Systems. machine # [ 29.455398] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 29.459733] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 29.460491] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 29.461586] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 29.464929] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 29.466652] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 29.468307] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 29.476567] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 29.477783] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 29.481245] systemd[1]: Reached target Remote File Systems. machine # [ 29.828673] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 29.829970] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 29.834781] systemd[1]: Starting linger-users.service... machine # [ 29.889903] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 29.891436] systemd[1]: Finished linger-users.service. machine # [ 30.145849] nixos[1334]: finished switching to system configuration /nix/store/yv0fgsc3a9pf40xia3yrhzply67kinx0-nixos-system-machine-test machine: (finished: must succeed: /nix/store/yv0fgsc3a9pf40xia3yrhzply67kinx0-nixos-system-machine-test/bin/switch-to-configuration test 2>&1, in 2.74 seconds) machine: must succeed: /nix/store/yv0fgsc3a9pf40xia3yrhzply67kinx0-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration test 2>&1 machine # [ 30.853651] nixos[1475]: switching to system configuration /nix/store/ma8xw6s7qf2qq3d34d3yibp62qkz7x26-nixos-system-machine-test machine # [ 30.856063] systemd[1]: Stopped target Remote File Systems. machine # [ 30.857629] systemd[1]: Stopped target Local File Systems. machine # [ 31.382767] systemd[1]: Reload requested from client PID 1475 ('.switch-to-conf') (unit backdoor.service)... machine # [ 31.384538] systemd[1]: Reloading... machine # [ 31.985031] systemd[1]: Reloading finished in 598 ms. machine # [ 32.111545] systemd[635]: Reexecution requested from client PID 1544 ('switch-to-confi')... machine # [ 32.113789] systemd[635]: Reexecuting. machine # [ 32.142263] systemd[635]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 32.296626] systemd[635]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 32.302138] systemd[635]: Reload requested from client PID 1544 ('switch-to-confi')... machine # [ 32.303780] systemd[635]: Reloading... machine # [ 32.469925] systemd[635]: Reloading finished in 164 ms. machine # [ 32.474815] systemd[635]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 32.481073] systemd[635]: Stopped Run user-specific NixOS activation. machine # [ 32.481941] systemd[635]: Stopping Run user-specific NixOS activation... machine # [ 32.485124] systemd[635]: Starting Run user-specific NixOS activation... machine # [ 32.520452] systemd[635]: Finished Run user-specific NixOS activation. machine # [ 32.523650] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 32.524798] systemd[1]: Stopping Reactivate sysinit units... machine # [ 32.525818] systemd[1]: Reached target Reactivate sysinit units. machine # [ 32.530240] systemd[1]: Reached target Remote File Systems. machine # [ 32.533895] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 32.535661] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 32.539376] systemd[1]: Reached target Local File Systems. machine # [ 32.541305] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 32.545347] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 32.546183] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 32.547299] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 32.549969] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 32.552181] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 32.553366] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 32.839104] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 32.840397] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 32.845071] systemd[1]: Starting linger-users.service... machine # [ 32.847982] systemd[1]: Starting test.service... machine # [ 32.873079] systemd[1]: Finished test.service. machine # [ 32.894782] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 32.897359] systemd[1]: Finished linger-users.service. machine # [ 33.153932] nixos[1475]: finished switching to system configuration /nix/store/ma8xw6s7qf2qq3d34d3yibp62qkz7x26-nixos-system-machine-test machine: (finished: must succeed: /nix/store/yv0fgsc3a9pf40xia3yrhzply67kinx0-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration test 2>&1, in 3.01 seconds) machine: must succeed: /nix/store/yv0fgsc3a9pf40xia3yrhzply67kinx0-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration test 2>&1 machine # [ 33.779168] nixos[1618]: switching to system configuration /nix/store/ma8xw6s7qf2qq3d34d3yibp62qkz7x26-nixos-system-machine-test machine # [ 33.781663] systemd[1]: Stopped target Local File Systems. machine # [ 33.782875] systemd[1]: Stopped target Remote File Systems. machine # [ 34.202355] systemd[1]: Reload requested from client PID 1618 ('.switch-to-conf') (unit backdoor.service)... machine # [ 34.204079] systemd[1]: Reloading... machine # [ 34.763100] systemd[1]: Reloading finished in 556 ms. machine # [ 34.896028] systemd[635]: Reexecution requested from client PID 1687 ('switch-to-confi')... machine # [ 34.897247] systemd[635]: Reexecuting. machine # [ 34.925953] systemd[635]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 35.094399] systemd[635]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 35.099554] systemd[635]: Reload requested from client PID 1687 ('switch-to-confi')... machine # [ 35.100927] systemd[635]: Reloading... machine # [ 35.260696] systemd[635]: Reloading finished in 157 ms. machine # [ 35.265826] systemd[635]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 35.272292] systemd[635]: Stopped Run user-specific NixOS activation. machine # [ 35.274065] systemd[635]: Stopping Run user-specific NixOS activation... machine # [ 35.276923] systemd[635]: Starting Run user-specific NixOS activation... machine # [ 35.313563] systemd[635]: Finished Run user-specific NixOS activation. machine # [ 35.317090] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 35.318433] systemd[1]: Stopping Reactivate sysinit units... machine # [ 35.319396] systemd[1]: Reached target Reactivate sysinit units. machine # [ 35.320752] systemd[1]: Reached target Remote File Systems. machine # [ 35.324099] systemd[1]: Reached target Local File Systems. machine # [ 35.324914] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 35.329170] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 35.329993] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 35.331109] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 35.334346] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 35.336994] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 35.339588] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 35.344553] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 35.345732] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 35.641318] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 35.644740] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 35.646474] systemd[1]: Starting linger-users.service... machine # [ 35.687696] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 35.689227] systemd[1]: Finished linger-users.service. machine # [ 35.943969] nixos[1618]: finished switching to system configuration /nix/store/ma8xw6s7qf2qq3d34d3yibp62qkz7x26-nixos-system-machine-test machine: (finished: must succeed: /nix/store/yv0fgsc3a9pf40xia3yrhzply67kinx0-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration test 2>&1, in 2.79 seconds) machine: must succeed: /nix/store/yv0fgsc3a9pf40xia3yrhzply67kinx0-nixos-system-machine-test/specialisation/simpleServiceDifferentDescription/bin/switch-to-configuration test 2>&1 machine # [ 36.390492] nixos[1759]: switching to system configuration /nix/store/nrq9y9mvqdaa9sbvs4cymxh8r2kyd32i-nixos-system-machine-test machine # [ 36.392794] systemd[1]: Stopped target Local File Systems. machine # [ 36.394381] systemd[1]: Stopped target Remote File Systems. machine # [ 36.835592] systemd[1]: Reload requested from client PID 1759 ('.switch-to-conf') (unit backdoor.service)... machine # [ 36.837164] systemd[1]: Reloading... machine # [ 37.350778] systemd[1]: Reloading finished in 511 ms. machine # [ 37.465331] systemd[635]: Reexecution requested from client PID 1828 ('switch-to-confi')... machine # [ 37.467407] systemd[635]: Reexecuting. machine # [ 37.494718] systemd[635]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 37.634550] systemd[635]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 37.639923] systemd[635]: Reload requested from client PID 1828 ('switch-to-confi')... machine # [ 37.641694] systemd[635]: Reloading... machine # [ 37.777063] systemd[635]: Reloading finished in 134 ms. machine # [ 37.782821] systemd[635]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 37.790092] systemd[635]: Stopped Run user-specific NixOS activation. machine # [ 37.790917] systemd[635]: Stopping Run user-specific NixOS activation... machine # [ 37.792953] systemd[635]: Starting Run user-specific NixOS activation... machine # [ 37.821712] systemd[635]: Finished Run user-specific NixOS activation. machine # [ 37.824805] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 37.826548] systemd[1]: Stopping Reactivate sysinit units... machine # [ 37.827508] systemd[1]: Reached target Reactivate sysinit units. machine # [ 37.831520] systemd[1]: Reached target Local File Systems. machine # [ 37.833803] systemd[1]: Reached target Remote File Systems. machine # [ 37.837092] systemd[1]: Starting linger-users.service... machine # [ 37.844551] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 37.848327] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 37.849171] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 37.850262] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 37.852144] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 37.853456] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 37.854506] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 37.859850] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 37.861610] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 37.904504] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 37.906156] systemd[1]: Finished linger-users.service. machine # [ 38.145491] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 38.147152] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 38.402050] nixos[1759]: finished switching to system configuration /nix/store/nrq9y9mvqdaa9sbvs4cymxh8r2kyd32i-nixos-system-machine-test machine: (finished: must succeed: /nix/store/yv0fgsc3a9pf40xia3yrhzply67kinx0-nixos-system-machine-test/specialisation/simpleServiceDifferentDescription/bin/switch-to-configuration test 2>&1, in 2.46 seconds) machine: must succeed: /nix/store/yv0fgsc3a9pf40xia3yrhzply67kinx0-nixos-system-machine-test/specialisation/simpleServiceModified/bin/switch-to-configuration test 2>&1 machine # [ 38.964208] nixos[1899]: switching to system configuration /nix/store/9rksi58k287sbjnjcz2l6n81a4y3d0d8-nixos-system-machine-test machine # [ 38.966585] systemd[1]: test.service: Deactivated successfully. machine # [ 38.968252] systemd[1]: Stopped Test unit. machine # [ 38.969294] systemd[1]: Stopped target Local File Systems. machine # [ 38.970772] systemd[1]: Stopped target Remote File Systems. machine # [ 39.421658] systemd[1]: Reload requested from client PID 1899 ('.switch-to-conf') (unit backdoor.service)... machine # [ 39.423347] systemd[1]: Reloading... machine # [ 39.957186] systemd[1]: Reloading finished in 532 ms. machine # [ 40.072338] systemd[635]: Reexecution requested from client PID 1969 ('switch-to-confi')... machine # [ 40.074779] systemd[635]: Reexecuting. machine # [ 40.102081] systemd[635]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 40.238686] systemd[635]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 40.244564] systemd[635]: Reload requested from client PID 1969 ('switch-to-confi')... machine # [ 40.245809] systemd[635]: Reloading... machine # [ 40.383121] systemd[635]: Reloading finished in 135 ms. machine # [ 40.388843] systemd[635]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 40.395338] systemd[635]: Stopped Run user-specific NixOS activation. machine # [ 40.397170] systemd[635]: Stopping Run user-specific NixOS activation... machine # [ 40.399668] systemd[635]: Starting Run user-specific NixOS activation... machine # [ 40.434849] systemd[635]: Finished Run user-specific NixOS activation. machine # [ 40.438474] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 40.439612] systemd[1]: Stopping Reactivate sysinit units... machine # [ 40.440804] systemd[1]: Reached target Reactivate sysinit units. machine # [ 40.442997] systemd[1]: Reached target Remote File Systems. machine # [ 40.444593] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 40.445904] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 40.451261] systemd[1]: Starting linger-users.service... machine # [ 40.453716] systemd[1]: Starting test.service... machine # [ 40.465784] systemd[1]: Reached target Local File Systems. machine # [ 40.471302] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 40.474992] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 40.475907] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 40.478026] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 40.480364] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 40.482311] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 40.484191] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 40.507449] systemd[1]: Finished test.service. machine # [ 40.538855] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 40.540626] systemd[1]: Finished linger-users.service. machine # [ 40.780702] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 40.782602] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 41.040333] nixos[1899]: finished switching to system configuration /nix/store/9rksi58k287sbjnjcz2l6n81a4y3d0d8-nixos-system-machine-test machine: (finished: must succeed: /nix/store/yv0fgsc3a9pf40xia3yrhzply67kinx0-nixos-system-machine-test/specialisation/simpleServiceModified/bin/switch-to-configuration test 2>&1, in 2.64 seconds) machine: must succeed: /nix/store/yv0fgsc3a9pf40xia3yrhzply67kinx0-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1 machine # [ 41.618755] nixos[2042]: switching to system configuration /nix/store/zm2d8l415g7acy497dvl3hqcc05778kd-nixos-system-machine-test machine # [ 41.622234] systemd[1]: Stopped target Remote File Systems. machine # [ 41.623026] systemd[1]: Stopped target Local File Systems. machine # [ 42.070469] systemd[1]: Reload requested from client PID 2042 ('.switch-to-conf') (unit backdoor.service)... machine # [ 42.072146] systemd[1]: Reloading... machine # [ 42.627836] systemd[1]: Reloading finished in 553 ms. machine # [ 42.748026] systemd[635]: Reexecution requested from client PID 2112 ('switch-to-confi')... machine # [ 42.749284] systemd[635]: Reexecuting. machine # [ 42.773456] systemd[635]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 42.905124] systemd[635]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 42.911048] systemd[635]: Reload requested from client PID 2112 ('switch-to-confi')... machine # [ 42.912809] systemd[635]: Reloading... machine # [ 43.044636] systemd[635]: Reloading finished in 130 ms. machine # [ 43.048834] systemd[635]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 43.055186] systemd[635]: Stopped Run user-specific NixOS activation. machine # [ 43.057030] systemd[635]: Stopping Run user-specific NixOS activation... machine # [ 43.059050] systemd[635]: Starting Run user-specific NixOS activation... machine # [ 43.092095] systemd[635]: Finished Run user-specific NixOS activation. machine # [ 43.095361] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 43.096681] systemd[1]: Stopping Reactivate sysinit units... machine # [ 43.097666] systemd[1]: Reached target Reactivate sysinit units. machine # [ 43.099406] systemd[1]: test.service: Deactivated successfully. machine # [ 43.101103] systemd[1]: Stopped test.service. machine # [ 43.101726] systemd[1]: Stopping test.service... machine # [ 43.104427] systemd[1]: Starting test.service... machine # [ 43.131267] systemd[1]: Finished test.service. machine # [ 43.135791] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 43.137515] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 43.139460] systemd[1]: Reached target Remote File Systems. machine # [ 43.143064] systemd[1]: Reached target Local File Systems. machine # [ 43.143870] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 43.147654] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 43.148643] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 43.150458] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 43.152374] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 43.153728] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 43.154824] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 43.400302] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 43.401720] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 43.406115] systemd[1]: Starting linger-users.service... machine # [ 43.451547] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 43.452677] systemd[1]: Finished linger-users.service. machine # [ 43.710207] nixos[2042]: finished switching to system configuration /nix/store/zm2d8l415g7acy497dvl3hqcc05778kd-nixos-system-machine-test machine: (finished: must succeed: /nix/store/yv0fgsc3a9pf40xia3yrhzply67kinx0-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1, in 2.67 seconds) machine: must succeed: /nix/store/yv0fgsc3a9pf40xia3yrhzply67kinx0-nixos-system-machine-test/specialisation/simpleServiceReload/bin/switch-to-configuration test 2>&1 machine # [ 44.304681] nixos[2185]: switching to system configuration /nix/store/rdvlxldwr3p84rd5wdlvdcjz6wd2df7z-nixos-system-machine-test machine # [ 44.307052] systemd[1]: Stopped target Local File Systems. machine # [ 44.308764] systemd[1]: Stopped target Remote File Systems. machine # [ 44.760364] systemd[1]: Reload requested from client PID 2185 ('.switch-to-conf') (unit backdoor.service)... machine # [ 44.761787] systemd[1]: Reloading... machine # [ 45.318844] systemd[1]: Reloading finished in 554 ms. machine # [ 45.431587] systemd[635]: Reexecution requested from client PID 2254 ('switch-to-confi')... machine # [ 45.433496] systemd[635]: Reexecuting. machine # [ 45.460468] systemd[635]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 45.602563] systemd[635]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 45.607587] systemd[635]: Reload requested from client PID 2254 ('switch-to-confi')... machine # [ 45.608972] systemd[635]: Reloading... machine # [ 45.756778] systemd[635]: Reloading finished in 145 ms. machine # [ 45.760843] systemd[635]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 45.767272] systemd[635]: Stopped Run user-specific NixOS activation. machine # [ 45.769065] systemd[635]: Stopping Run user-specific NixOS activation... machine # [ 45.771465] systemd[635]: Starting Run user-specific NixOS activation... machine # [ 45.806536] systemd[635]: Finished Run user-specific NixOS activation. machine # [ 45.809707] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 45.810920] systemd[1]: Stopping Reactivate sysinit units... machine # [ 45.811933] systemd[1]: Reached target Reactivate sysinit units. machine # [ 45.815808] systemd[1]: Reloading test.service... machine # [ 45.840531] systemd[1]: Reloaded test.service. machine # [ 45.844686] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 45.846367] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 45.849082] systemd[1]: Reached target Remote File Systems. machine # [ 45.852774] systemd[1]: Starting linger-users.service... machine # [ 45.858777] systemd[1]: Reached target Local File Systems. machine # [ 45.859623] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 45.863408] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 45.864374] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 45.866775] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 45.868601] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 45.869995] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 45.871116] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 45.921264] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 45.922844] systemd[1]: Finished linger-users.service. machine # [ 46.111663] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 46.113498] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 46.371376] nixos[2185]: finished switching to system configuration /nix/store/rdvlxldwr3p84rd5wdlvdcjz6wd2df7z-nixos-system-machine-test machine: (finished: must succeed: /nix/store/yv0fgsc3a9pf40xia3yrhzply67kinx0-nixos-system-machine-test/specialisation/simpleServiceReload/bin/switch-to-configuration test 2>&1, in 2.66 seconds) machine: must succeed: /nix/store/yv0fgsc3a9pf40xia3yrhzply67kinx0-nixos-system-machine-test/specialisation/simpleServiceNorestart/bin/switch-to-configuration test 2>&1 machine # [ 46.966708] nixos[2327]: switching to system configuration /nix/store/j5isxs13vdzdggrp91dmni44as17vmyi-nixos-system-machine-test machine # [ 46.970164] systemd[1]: Stopped target Remote File Systems. machine # [ 46.971121] systemd[1]: Stopped target Local File Systems. machine # [ 47.388956] systemd[1]: Reload requested from client PID 2327 ('.switch-to-conf') (unit backdoor.service)... machine # [ 47.390609] systemd[1]: Reloading... machine # [ 47.919383] systemd[1]: Reloading finished in 526 ms. machine # [ 48.037960] systemd[635]: Reexecution requested from client PID 2396 ('switch-to-confi')... machine # [ 48.039257] systemd[635]: Reexecuting. machine # [ 48.066426] systemd[635]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 48.186972] systemd[635]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 48.192769] systemd[635]: Reload requested from client PID 2396 ('switch-to-confi')... machine # [ 48.194223] systemd[635]: Reloading... machine # [ 48.329752] systemd[635]: Reloading finished in 133 ms. machine # [ 48.333832] systemd[635]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 48.340846] systemd[635]: Stopped Run user-specific NixOS activation. machine # [ 48.341868] systemd[635]: Stopping Run user-specific NixOS activation... machine # [ 48.344110] systemd[635]: Starting Run user-specific NixOS activation... machine # [ 48.377887] systemd[635]: Finished Run user-specific NixOS activation. machine # [ 48.381513] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 48.382874] systemd[1]: Stopping Reactivate sysinit units... machine # [ 48.384197] systemd[1]: Reached target Reactivate sysinit units. machine # [ 48.384984] systemd[1]: Reached target Local File Systems. machine # [ 48.387421] systemd[1]: Reached target Remote File Systems. machine # [ 48.390658] systemd[1]: Starting linger-users.service... machine # [ 48.393068] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 48.396401] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 48.398533] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 48.401193] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 48.403836] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 48.405435] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 48.406615] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 48.411240] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 48.413255] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 48.469673] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 48.471394] systemd[1]: Finished linger-users.service. machine # [ 48.708917] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 48.710574] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 48.967697] nixos[2327]: finished switching to system configuration /nix/store/j5isxs13vdzdggrp91dmni44as17vmyi-nixos-system-machine-test machine: (finished: must succeed: /nix/store/yv0fgsc3a9pf40xia3yrhzply67kinx0-nixos-system-machine-test/specialisation/simpleServiceNorestart/bin/switch-to-configuration test 2>&1, in 2.60 seconds) machine: must succeed: /nix/store/yv0fgsc3a9pf40xia3yrhzply67kinx0-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration dry-activate 2>&1 machine: (finished: must succeed: /nix/store/yv0fgsc3a9pf40xia3yrhzply67kinx0-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration dry-activate 2>&1, in 0.67 seconds) machine: must succeed: /nix/store/yv0fgsc3a9pf40xia3yrhzply67kinx0-nixos-system-machine-test/bin/switch-to-configuration test 2>&1 machine # [ 50.164924] nixos[2477]: switching to system configuration /nix/store/yv0fgsc3a9pf40xia3yrhzply67kinx0-nixos-system-machine-test machine # [ 50.167982] systemd[1]: test.service: Deactivated successfully. machine # [ 50.168892] systemd[1]: Stopped test.service. machine # [ 50.170130] systemd[1]: Stopped target Local File Systems. machine # [ 50.171482] systemd[1]: Stopped target Remote File Systems. machine # [ 50.556917] systemd[1]: Reload requested from client PID 2477 ('.switch-to-conf') (unit backdoor.service)... machine # [ 50.558549] systemd[1]: Reloading... machine # [ 51.074103] systemd[1]: Reloading finished in 513 ms. machine # [ 51.191125] systemd[635]: Reexecution requested from client PID 2546 ('switch-to-confi')... machine # [ 51.192455] systemd[635]: Reexecuting. machine # [ 51.218846] systemd[635]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 51.358360] systemd[635]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 51.363399] systemd[635]: Reload requested from client PID 2546 ('switch-to-confi')... machine # [ 51.364580] systemd[635]: Reloading... machine # [ 51.502280] systemd[635]: Reloading finished in 135 ms. machine # [ 51.505828] systemd[635]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 51.511988] systemd[635]: Stopped Run user-specific NixOS activation. machine # [ 51.512991] systemd[635]: Stopping Run user-specific NixOS activation... machine # [ 51.516205] systemd[635]: Starting Run user-specific NixOS activation... machine # [ 51.550821] systemd[635]: Finished Run user-specific NixOS activation. machine # [ 51.554262] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 51.555664] systemd[1]: Stopping Reactivate sysinit units... machine # [ 51.557302] systemd[1]: Reached target Reactivate sysinit units. machine # [ 51.560074] systemd[1]: Reached target Local File Systems. machine # [ 51.562265] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 51.565253] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 51.566164] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 51.567277] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 51.570338] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 51.572550] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 51.575730] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 51.577780] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 51.578940] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 51.584876] systemd[1]: Reached target Remote File Systems. machine # [ 51.825120] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 51.826544] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 51.831264] systemd[1]: Starting linger-users.service... machine # [ 51.882658] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 51.884088] systemd[1]: Finished linger-users.service. machine # [ 52.141388] nixos[2477]: finished switching to system configuration /nix/store/yv0fgsc3a9pf40xia3yrhzply67kinx0-nixos-system-machine-test machine: (finished: must succeed: /nix/store/yv0fgsc3a9pf40xia3yrhzply67kinx0-nixos-system-machine-test/bin/switch-to-configuration test 2>&1, in 2.50 seconds) machine: must succeed: /nix/store/17rcy8dyvaamqv6ljynna6d7gj4pvbcl-separate-activation-script/bin/switch-to-configuration test 2>&1 machine # [ 52.712850] nixos[2617]: switching to system configuration /nix/store/c0wac96x01s4lgvqyi2kqw9vd6j0q6cf-nixos-system-machine-test machine # [ 52.715240] systemd[1]: Stopped target Local File Systems. machine # [ 52.716892] systemd[1]: Stopped target Remote File Systems. machine # [ 53.146746] systemd[1]: Reload requested from client PID 2617 ('.switch-to-conf') (unit backdoor.service)... machine # [ 53.148395] systemd[1]: Reloading... machine # [ 53.662942] systemd[1]: Reloading finished in 512 ms. machine # [ 53.783359] systemd[635]: Stopped Run user-specific NixOS activation. machine # [ 53.785076] systemd[635]: Reexecution requested from client PID 2686 ('switch-to-confi')... machine # [ 53.787559] systemd[635]: Reexecuting. machine # [ 53.813295] systemd[635]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 53.950272] systemd[635]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 53.954938] systemd[635]: Reload requested from client PID 2686 ('switch-to-confi')... machine # [ 53.956554] systemd[635]: Reloading... machine # [ 54.092367] systemd[635]: Reloading finished in 133 ms. machine # [ 54.096852] systemd[635]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 54.104310] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 54.105807] systemd[1]: Stopping Reactivate sysinit units... machine # [ 54.107118] systemd[1]: Reached target Reactivate sysinit units. machine # [ 54.109738] systemd[1]: Reached target Remote File Systems. machine # [ 54.114058] systemd[1]: Starting linger-users.service... machine # [ 54.116452] systemd[1]: Starting test.service... machine # [ 54.124379] systemd[1]: Reached target Local File Systems. machine # [ 54.125538] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 54.129559] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 54.130952] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 54.134128] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 54.136151] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 54.137631] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 54.138774] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 54.143137] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 54.144491] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 54.177437] systemd[1]: Finished test.service. machine # [ 54.201369] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 54.203261] systemd[1]: Finished linger-users.service. machine # [ 54.438790] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 54.441563] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 54.695344] nixos[2617]: finished switching to system configuration /nix/store/c0wac96x01s4lgvqyi2kqw9vd6j0q6cf-nixos-system-machine-test machine: (finished: must succeed: /nix/store/17rcy8dyvaamqv6ljynna6d7gj4pvbcl-separate-activation-script/bin/switch-to-configuration test 2>&1, in 2.55 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.01 seconds) machine: must succeed: ! test -e /run/current-system/bin/switch-to-configuration machine: (finished: must succeed: ! test -e /run/current-system/bin/switch-to-configuration, in 0.01 seconds) machine: must succeed: /nix/store/yv0fgsc3a9pf40xia3yrhzply67kinx0-nixos-system-machine-test/specialisation/unitWithMultilineValue/bin/switch-to-configuration test 2>&1 machine # [ 55.288417] nixos[2765]: switching to system configuration /nix/store/41q0272l9szqmq9hpp4fddcxcgra5vzm-nixos-system-machine-test machine # [ 55.290927] systemd[1]: Stopped target Local File Systems. machine # [ 55.292821] systemd[1]: test.service: Deactivated successfully. machine # [ 55.293610] systemd[1]: Stopped test.service. machine # [ 55.295173] systemd[1]: Stopped target Remote File Systems. machine # [ 55.702961] systemd[1]: Reload requested from client PID 2765 ('.switch-to-conf') (unit backdoor.service)... machine # [ 55.704708] systemd[1]: Reloading... machine # [ 56.241845] systemd[1]: Reloading finished in 535 ms. machine # [ 56.349326] systemd[635]: Reexecution requested from client PID 2834 ('switch-to-confi')... machine # [ 56.351633] systemd[635]: Reexecuting. machine # [ 56.381930] systemd[635]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 56.532072] systemd[635]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 56.537959] systemd[635]: Reload requested from client PID 2834 ('switch-to-confi')... machine # [ 56.539749] systemd[635]: Reloading... machine # [ 56.673642] systemd[635]: Reloading finished in 132 ms. machine # [ 56.677842] systemd[635]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 56.685512] systemd[635]: Starting Run user-specific NixOS activation... machine # [ 56.721282] systemd[635]: Finished Run user-specific NixOS activation. machine # [ 56.724333] systemd[635]: Stopped Run user-specific NixOS activation. machine # [ 56.725225] systemd[635]: Stopping Run user-specific NixOS activation... machine # [ 56.728784] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 56.730983] systemd[1]: Stopping Reactivate sysinit units... machine # [ 56.732620] systemd[1]: Reached target Reactivate sysinit units. machine # [ 56.733814] systemd[635]: Starting Run user-specific NixOS activation... machine # [ 56.736846] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 56.738050] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 56.742741] systemd[1]: Reached target Local File Systems. machine # [ 56.746210] systemd[1]: Reached target Remote File Systems. machine # [ 56.753477] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 56.757913] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 56.760323] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 56.763308] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 56.765748] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 56.767888] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 56.770677] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 56.794363] systemd[635]: Finished Run user-specific NixOS activation. machine # [ 57.028802] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 57.030548] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 57.035168] systemd[1]: Starting linger-users.service... machine # [ 57.039274] systemd[1]: Started test.service. machine # [ 57.063365] systemd[1]: test.service: Deactivated successfully. machine # [ 57.082641] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 57.084082] systemd[1]: Finished linger-users.service. machine # [ 57.341340] nixos[2765]: finished switching to system configuration /nix/store/41q0272l9szqmq9hpp4fddcxcgra5vzm-nixos-system-machine-test machine: (finished: must succeed: /nix/store/yv0fgsc3a9pf40xia3yrhzply67kinx0-nixos-system-machine-test/specialisation/unitWithMultilineValue/bin/switch-to-configuration test 2>&1, in 2.60 seconds) machine: must succeed: /nix/store/yv0fgsc3a9pf40xia3yrhzply67kinx0-nixos-system-machine-test/specialisation/unitWithBackslash/bin/switch-to-configuration test 2>&1 machine # [ 57.892179] nixos[2910]: switching to system configuration /nix/store/7hjrzjj7k67p2vmb50cqglds7adgxadr-nixos-system-machine-test machine # [ 57.895642] systemd[1]: Stopped target Remote File Systems. machine # [ 57.896534] systemd[1]: Stopped target Local File Systems. machine # [ 58.287507] systemd[1]: Reload requested from client PID 2910 ('.switch-to-conf') (unit backdoor.service)... machine # [ 58.289155] systemd[1]: Reloading... machine # [ 58.805878] systemd[1]: Reloading finished in 514 ms. machine # [ 58.919838] systemd[635]: Reexecution requested from client PID 2979 ('switch-to-confi')... machine # [ 58.922263] systemd[635]: Reexecuting. machine # [ 58.950786] systemd[635]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 59.091216] systemd[635]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 59.097065] systemd[635]: Reload requested from client PID 2979 ('switch-to-confi')... machine # [ 59.098509] systemd[635]: Reloading... machine # [ 59.233073] systemd[635]: Reloading finished in 132 ms. machine # [ 59.237868] systemd[635]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 59.244238] systemd[635]: Stopped Run user-specific NixOS activation. machine # [ 59.246094] systemd[635]: Stopping Run user-specific NixOS activation... machine # [ 59.248439] systemd[635]: Starting Run user-specific NixOS activation... machine # [ 59.281082] systemd[635]: Finished Run user-specific NixOS activation. machine # [ 59.284480] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 59.285656] systemd[1]: Stopping Reactivate sysinit units... machine # [ 59.286597] systemd[1]: Reached target Reactivate sysinit units. machine # [ 59.287862] systemd[1]: Reached target Local File Systems. machine # [ 59.292208] systemd[1]: Reached target Remote File Systems. machine # [ 59.295515] systemd[1]: Starting escaped\x2ddash.service... machine # [ 59.297921] systemd[1]: Starting linger-users.service... machine # [ 59.302097] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 59.304126] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 59.317964] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 59.321264] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 59.322666] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 59.324485] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 59.326365] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 59.327769] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 59.328878] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 59.352386] systemd[1]: Finished escaped\x2ddash.service. machine # [ 59.386971] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 59.388881] systemd[1]: Finished linger-users.service. machine # [ 59.627946] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 59.630090] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 59.884748] nixos[2910]: finished switching to system configuration /nix/store/7hjrzjj7k67p2vmb50cqglds7adgxadr-nixos-system-machine-test machine: (finished: must succeed: /nix/store/yv0fgsc3a9pf40xia3yrhzply67kinx0-nixos-system-machine-test/specialisation/unitWithBackslash/bin/switch-to-configuration test 2>&1, in 2.54 seconds) machine: must succeed: /nix/store/yv0fgsc3a9pf40xia3yrhzply67kinx0-nixos-system-machine-test/specialisation/unitWithBackslashModified/bin/switch-to-configuration test 2>&1 machine # [ 60.433605] nixos[3052]: switching to system configuration /nix/store/3p2nzp1alqdcx4vjzm9hrmr2y44km8sa-nixos-system-machine-test machine # [ 60.436121] systemd[1]: Stopped target Local File Systems. machine # [ 60.437807] systemd[1]: escaped\x2ddash.service: Deactivated successfully. machine # [ 60.439065] systemd[1]: Stopped escaped\x2ddash.service. machine # [ 60.440512] systemd[1]: Stopped target Remote File Systems. machine # [ 60.888665] systemd[1]: Reload requested from client PID 3052 ('.switch-to-conf') (unit backdoor.service)... machine # [ 60.890361] systemd[1]: Reloading... machine # [ 61.426791] systemd[1]: Reloading finished in 534 ms. machine # [ 61.537340] systemd[635]: Reexecution requested from client PID 3121 ('switch-to-confi')... machine # [ 61.539993] systemd[635]: Reexecuting. machine # [ 61.569688] systemd[635]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 61.705463] systemd[635]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 61.710769] systemd[635]: Reload requested from client PID 3121 ('switch-to-confi')... machine # [ 61.712235] systemd[635]: Reloading... machine # [ 61.850518] systemd[635]: Reloading finished in 137 ms. machine # [ 61.855835] systemd[635]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 61.862286] systemd[635]: Stopped Run user-specific NixOS activation. machine # [ 61.864134] systemd[635]: Stopping Run user-specific NixOS activation... machine # [ 61.866198] systemd[635]: Starting Run user-specific NixOS activation... machine # [ 61.900760] systemd[635]: Finished Run user-specific NixOS activation. machine # [ 61.904455] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 61.906092] systemd[1]: Stopping Reactivate sysinit units... machine # [ 61.906876] systemd[1]: Reached target Reactivate sysinit units. machine # [ 61.910961] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 61.912632] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 61.919136] systemd[1]: Reached target Local File Systems. machine # [ 61.919915] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 61.924045] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 61.924809] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 61.925912] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 61.927817] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 61.930732] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 61.932402] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 61.934738] systemd[1]: Reached target Remote File Systems. machine # [ 62.221603] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 62.225242] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 62.228638] systemd[1]: Starting escaped\x2ddash.service... machine # [ 62.230960] systemd[1]: Starting linger-users.service... machine # [ 62.262655] systemd[1]: Finished escaped\x2ddash.service. machine # [ 62.286090] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 62.287587] systemd[1]: Finished linger-users.service. machine # [ 62.544720] nixos[3052]: finished switching to system configuration /nix/store/3p2nzp1alqdcx4vjzm9hrmr2y44km8sa-nixos-system-machine-test machine: (finished: must succeed: /nix/store/yv0fgsc3a9pf40xia3yrhzply67kinx0-nixos-system-machine-test/specialisation/unitWithBackslashModified/bin/switch-to-configuration test 2>&1, in 2.66 seconds) machine: must succeed: /nix/store/yv0fgsc3a9pf40xia3yrhzply67kinx0-nixos-system-machine-test/specialisation/unitStartingWithDash/bin/switch-to-configuration test 2>&1 machine # [ 63.084377] nixos[3194]: switching to system configuration /nix/store/fp6bja0yq16wjjn08wp2nds3kaxga4cl-nixos-system-machine-test machine # [ 63.086849] systemd[1]: escaped\x2ddash.service: Deactivated successfully. machine # [ 63.088463] systemd[1]: Stopped escaped\x2ddash.service. machine # [ 63.089890] systemd[1]: Stopped target Local File Systems. machine # [ 63.091559] systemd[1]: Stopped target Remote File Systems. machine # [ 63.511733] systemd[1]: Reload requested from client PID 3194 ('.switch-to-conf') (unit backdoor.service)... machine # [ 63.513467] systemd[1]: Reloading... machine # [ 64.031162] systemd[1]: Reloading finished in 515 ms. machine # [ 64.124725] systemd[635]: Reexecution requested from client PID 3263 ('switch-to-confi')... machine # [ 64.127419] systemd[635]: Reexecuting. machine # [ 64.149798] systemd[635]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 64.279313] systemd[635]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 64.283603] systemd[635]: Reload requested from client PID 3263 ('switch-to-confi')... machine # [ 64.285432] systemd[635]: Reloading... machine # [ 64.411271] systemd[635]: Reloading finished in 123 ms. machine # [ 64.414843] systemd[635]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 64.421581] systemd[635]: Stopped Run user-specific NixOS activation. machine # [ 64.423131] systemd[635]: Stopping Run user-specific NixOS activation... machine # [ 64.425892] systemd[635]: Starting Run user-specific NixOS activation... machine # [ 64.457376] systemd[635]: Finished Run user-specific NixOS activation. machine # [ 64.460864] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 64.462478] systemd[1]: Stopping Reactivate sysinit units... machine # [ 64.463825] systemd[1]: Reached target Reactivate sysinit units. machine # [ 64.467994] systemd[1]: Reached target Remote File Systems. machine # [ 64.470380] systemd[1]: Reached target Local File Systems. machine # [ 64.474661] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 64.476633] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 64.482099] systemd[1]: Starting -.service... machine # [ 64.484417] systemd[1]: Starting linger-users.service... machine # [ 64.487894] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 64.493154] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 64.493915] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 64.496410] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 64.498351] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 64.499773] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 64.500932] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 64.538759] systemd[1]: Finished -.service. machine # [ 64.563978] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 64.565734] systemd[1]: Finished linger-users.service. machine # [ 64.778683] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 64.780704] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 65.038100] nixos[3194]: finished switching to system configuration /nix/store/fp6bja0yq16wjjn08wp2nds3kaxga4cl-nixos-system-machine-test machine: (finished: must succeed: /nix/store/yv0fgsc3a9pf40xia3yrhzply67kinx0-nixos-system-machine-test/specialisation/unitStartingWithDash/bin/switch-to-configuration test 2>&1, in 2.49 seconds) machine: must succeed: /nix/store/yv0fgsc3a9pf40xia3yrhzply67kinx0-nixos-system-machine-test/specialisation/unitStartingWithDashModified/bin/switch-to-configuration test 2>&1 machine # [ 65.734644] nixos[3336]: switching to system configuration /nix/store/y4bbkzhvb8yka34px008jgn5n4qqclvp-nixos-system-machine-test machine # [ 65.738158] systemd[1]: Stopped target Local File Systems. machine # [ 65.739224] systemd[1]: Stopped target Remote File Systems. machine # [ 66.168073] systemd[1]: Reload requested from client PID 3336 ('.switch-to-conf') (unit backdoor.service)... machine # [ 66.169661] systemd[1]: Reloading... machine # [ 66.690404] systemd[1]: Reloading finished in 518 ms. machine # [ 66.809096] systemd[635]: Reexecution requested from client PID 3405 ('switch-to-confi')... machine # [ 66.810356] systemd[635]: Reexecuting. machine # [ 66.839962] systemd[635]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 66.980479] systemd[635]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 66.984967] systemd[635]: Reload requested from client PID 3405 ('switch-to-confi')... machine # [ 66.986590] systemd[635]: Reloading... machine # [ 67.123525] systemd[635]: Reloading finished in 135 ms. machine # [ 67.127123] systemd[635]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 67.135072] systemd[635]: Stopped Run user-specific NixOS activation. machine # [ 67.135920] systemd[635]: Stopping Run user-specific NixOS activation... machine # [ 67.138259] systemd[635]: Starting Run user-specific NixOS activation... machine # [ 67.180697] systemd[635]: Finished Run user-specific NixOS activation. machine # [ 67.183983] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 67.185691] systemd[1]: Stopping Reactivate sysinit units... machine # [ 67.187863] systemd[1]: Reached target Reactivate sysinit units. machine # [ 67.190265] systemd[1]: Reloading -.service... machine # [ 67.217336] systemd[1]: Reloaded -.service. machine # [ 67.219717] systemd[1]: Reached target Remote File Systems. machine # [ 67.222277] systemd[1]: Reached target Local File Systems. machine # [ 67.226296] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 67.228260] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 67.230906] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 67.236244] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 67.237655] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 67.238784] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 67.240671] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 67.242051] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 67.243152] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 67.530851] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 67.532557] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 67.537354] systemd[1]: Starting linger-users.service... machine # [ 67.585273] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 67.587638] systemd[1]: Finished linger-users.service. machine # [ 67.841737] nixos[3336]: finished switching to system configuration /nix/store/y4bbkzhvb8yka34px008jgn5n4qqclvp-nixos-system-machine-test machine: (finished: must succeed: /nix/store/yv0fgsc3a9pf40xia3yrhzply67kinx0-nixos-system-machine-test/specialisation/unitStartingWithDashModified/bin/switch-to-configuration test 2>&1, in 2.80 seconds) machine: must succeed: /nix/store/yv0fgsc3a9pf40xia3yrhzply67kinx0-nixos-system-machine-test/specialisation/unitWithRequirement/bin/switch-to-configuration test 2>&1 machine # [ 68.429133] nixos[3478]: switching to system configuration /nix/store/r2wyg2cp8a2z2nkmycjzwp93yi36lzlk-nixos-system-machine-test machine # [ 68.432268] systemd[1]: -.service: Deactivated successfully. machine # [ 68.433231] systemd[1]: Stopped -.service. machine # [ 68.434259] systemd[1]: Stopped target Local File Systems. machine # [ 68.435698] systemd[1]: Stopped target Remote File Systems. machine # [ 68.878283] systemd[1]: Reload requested from client PID 3478 ('.switch-to-conf') (unit backdoor.service)... machine # [ 68.879947] systemd[1]: Reloading... machine # [ 69.432765] systemd[1]: Reloading finished in 550 ms. machine # [ 69.558380] systemd[635]: Reexecution requested from client PID 3547 ('switch-to-confi')... machine # [ 69.559650] systemd[635]: Reexecuting. machine # [ 69.586658] systemd[635]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 69.730181] systemd[635]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 69.735072] systemd[635]: Reload requested from client PID 3547 ('switch-to-confi')... machine # [ 69.736860] systemd[635]: Reloading... machine # [ 69.876831] systemd[635]: Reloading finished in 138 ms. machine # [ 69.881844] systemd[635]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 69.889117] systemd[635]: Stopped Run user-specific NixOS activation. machine # [ 69.889981] systemd[635]: Stopping Run user-specific NixOS activation... machine # [ 69.892516] systemd[635]: Starting Run user-specific NixOS activation... machine # [ 69.929977] systemd[635]: Finished Run user-specific NixOS activation. machine # [ 69.933147] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 69.934926] systemd[1]: Stopping Reactivate sysinit units... machine # [ 69.935801] systemd[1]: Reached target Reactivate sysinit units. machine # [ 69.937405] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 69.939944] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 69.943377] systemd[1]: Reached target Local File Systems. machine # [ 69.947899] systemd[1]: Reached target Remote File Systems. machine # [ 69.954141] systemd[1]: Starting linger-users.service... machine # [ 69.957181] systemd[1]: Starting required-service.service... machine # [ 69.958959] systemd[1]: Starting test-service.service... machine # [ 69.964733] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 69.968211] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 69.969075] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 69.971173] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 69.973096] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 69.974542] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 69.975670] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 70.018927] systemd[1]: Finished required-service.service. machine # [ 70.019910] systemd[1]: Finished test-service.service. machine # [ 70.045379] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 70.046803] systemd[1]: Finished linger-users.service. machine # [ 70.292591] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 70.295386] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 70.552260] nixos[3478]: finished switching to system configuration /nix/store/r2wyg2cp8a2z2nkmycjzwp93yi36lzlk-nixos-system-machine-test machine: (finished: must succeed: /nix/store/yv0fgsc3a9pf40xia3yrhzply67kinx0-nixos-system-machine-test/specialisation/unitWithRequirement/bin/switch-to-configuration test 2>&1, in 2.71 seconds) machine: must succeed: /nix/store/yv0fgsc3a9pf40xia3yrhzply67kinx0-nixos-system-machine-test/specialisation/unitWithRequirementModified/bin/switch-to-configuration test 2>&1 machine # [ 71.143736] nixos[3622]: switching to system configuration /nix/store/jd5x8gvrxbwgrapvwbbflm9y5x3aaajs-nixos-system-machine-test machine # [ 71.146844] systemd[1]: required-service.service: Deactivated successfully. machine # [ 71.147751] systemd[1]: Stopped required-service.service. machine # [ 71.148470] systemd[1]: test-service.service: Deactivated successfully. machine # [ 71.150728] systemd[1]: Stopped test-service.service. machine # [ 71.151492] systemd[1]: Stopped target Local File Systems. machine # [ 71.152813] systemd[1]: Stopped target Remote File Systems. machine # [ 71.520709] systemd[1]: Reload requested from client PID 3622 ('.switch-to-conf') (unit backdoor.service)... machine # [ 71.522366] systemd[1]: Reloading... machine # [ 72.076805] systemd[1]: Reloading finished in 552 ms. machine # [ 72.196319] systemd[635]: Reexecution requested from client PID 3691 ('switch-to-confi')... machine # [ 72.198472] systemd[635]: Reexecuting. machine # [ 72.226208] systemd[635]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 72.376413] systemd[635]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 72.381920] systemd[635]: Reload requested from client PID 3691 ('switch-to-confi')... machine # [ 72.383733] systemd[635]: Reloading... machine # [ 72.536910] systemd[635]: Reloading finished in 151 ms. machine # [ 72.541823] systemd[635]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 72.549084] systemd[635]: Stopped Run user-specific NixOS activation. machine # [ 72.549970] systemd[635]: Stopping Run user-specific NixOS activation... machine # [ 72.552909] systemd[635]: Starting Run user-specific NixOS activation... machine # [ 72.588545] systemd[635]: Finished Run user-specific NixOS activation. machine # [ 72.591593] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 72.593273] systemd[1]: Stopping Reactivate sysinit units... machine # [ 72.594124] systemd[1]: Reached target Reactivate sysinit units. machine # [ 72.600155] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 72.601925] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 72.606338] systemd[1]: Starting required-service.service... machine # [ 72.613572] systemd[1]: Starting test-service.service... machine # [ 72.616378] systemd[1]: Reached target Local File Systems. machine # [ 72.620618] systemd[1]: Reached target Remote File Systems. machine # [ 72.624934] systemd[1]: Starting linger-users.service... machine # [ 72.629082] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 72.633781] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 72.635086] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 72.636324] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 72.638329] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 72.639750] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 72.640868] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 72.673870] systemd[1]: Finished required-service.service. machine # [ 72.675930] systemd[1]: Finished test-service.service. machine # [ 72.704518] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 72.706335] systemd[1]: Finished linger-users.service. machine # [ 72.913395] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 72.915087] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 73.173362] nixos[3622]: finished switching to system configuration /nix/store/jd5x8gvrxbwgrapvwbbflm9y5x3aaajs-nixos-system-machine-test machine: (finished: must succeed: /nix/store/yv0fgsc3a9pf40xia3yrhzply67kinx0-nixos-system-machine-test/specialisation/unitWithRequirementModified/bin/switch-to-configuration test 2>&1, in 2.62 seconds) machine: must succeed: /nix/store/yv0fgsc3a9pf40xia3yrhzply67kinx0-nixos-system-machine-test/specialisation/unitWithRequirementModifiedNostart/bin/switch-to-configuration test 2>&1 machine # [ 73.743864] nixos[3766]: switching to system configuration /nix/store/pl1r73qdk3hs6hifqxwr02x81awaviwj-nixos-system-machine-test machine # [ 73.746361] systemd[1]: Stopped target Local File Systems. machine # [ 73.748299] systemd[1]: Stopped target Remote File Systems. machine # [ 73.750085] systemd[1]: required-service.service: Deactivated successfully. machine # [ 73.751209] systemd[1]: Stopped required-service.service. machine # [ 73.752022] systemd[1]: test-service.service: Deactivated successfully. machine # [ 73.753607] systemd[1]: Stopped test-service.service. machine # [ 74.181882] systemd[1]: Reload requested from client PID 3766 ('.switch-to-conf') (unit backdoor.service)... machine # [ 74.183542] systemd[1]: Reloading... machine # [ 74.700461] systemd[1]: Reloading finished in 515 ms. machine # [ 74.800189] systemd[635]: Reexecution requested from client PID 3835 ('switch-to-confi')... machine # [ 74.802907] systemd[635]: Reexecuting. machine # [ 74.829536] systemd[635]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 74.957820] systemd[635]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 74.963364] systemd[635]: Reload requested from client PID 3835 ('switch-to-confi')... machine # [ 74.964862] systemd[635]: Reloading... machine # [ 75.086569] systemd[635]: Reloading finished in 120 ms. machine # [ 75.091848] systemd[635]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 75.098791] systemd[635]: Stopped Run user-specific NixOS activation. machine # [ 75.099642] systemd[635]: Stopping Run user-specific NixOS activation... machine # [ 75.101848] systemd[635]: Starting Run user-specific NixOS activation... machine # [ 75.134884] systemd[635]: Finished Run user-specific NixOS activation. machine # [ 75.138552] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 75.139609] systemd[1]: Stopping Reactivate sysinit units... machine # [ 75.140860] systemd[1]: Reached target Reactivate sysinit units. machine # [ 75.143602] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 75.145302] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 75.147824] systemd[1]: Reached target Remote File Systems. machine # [ 75.152103] systemd[1]: Starting linger-users.service... machine # [ 75.154450] systemd[1]: Starting required-service.service... machine # [ 75.158794] systemd[1]: Starting test-service.service... machine # [ 75.167978] systemd[1]: Reached target Local File Systems. machine # [ 75.171719] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 75.178666] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 75.179801] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 75.181784] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 75.185657] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 75.188745] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 75.191112] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 75.217576] systemd[1]: Finished required-service.service. machine # [ 75.218743] systemd[1]: Finished test-service.service. machine # [ 75.242662] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 75.244581] systemd[1]: Finished linger-users.service. machine # [ 75.448895] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 75.450667] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 75.708886] nixos[3766]: finished switching to system configuration /nix/store/pl1r73qdk3hs6hifqxwr02x81awaviwj-nixos-system-machine-test machine: (finished: must succeed: /nix/store/yv0fgsc3a9pf40xia3yrhzply67kinx0-nixos-system-machine-test/specialisation/unitWithRequirementModifiedNostart/bin/switch-to-configuration test 2>&1, in 2.54 seconds) machine: must succeed: /nix/store/yv0fgsc3a9pf40xia3yrhzply67kinx0-nixos-system-machine-test/specialisation/unitWithTemplate/bin/switch-to-configuration test 2>&1 machine # [ 76.313268] nixos[3910]: switching to system configuration /nix/store/5lfmm4mpyc7i9jssxq4rg7x6w8xfdpns-nixos-system-machine-test machine # [ 76.315515] systemd[1]: Stopped target Remote File Systems. machine # [ 76.317438] systemd[1]: required-service.service: Deactivated successfully. machine # [ 76.319367] systemd[1]: Stopped required-service.service. machine # [ 76.320474] systemd[1]: test-service.service: Deactivated successfully. machine # [ 76.321523] systemd[1]: Stopped test-service.service. machine # [ 76.322593] systemd[1]: Stopped target Local File Systems. machine # [ 76.762987] systemd[1]: Reload requested from client PID 3910 ('.switch-to-conf') (unit backdoor.service)... machine # [ 76.764727] systemd[1]: Reloading... machine # [ 77.296046] systemd[1]: Reloading finished in 529 ms. machine # [ 77.409593] systemd[635]: Reexecution requested from client PID 3979 ('switch-to-confi')... machine # [ 77.411061] systemd[635]: Reexecuting. machine # [ 77.438685] systemd[635]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 77.582591] systemd[635]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 77.588574] systemd[635]: Reload requested from client PID 3979 ('switch-to-confi')... machine # [ 77.590003] systemd[635]: Reloading... machine # [ 77.722917] systemd[635]: Reloading finished in 130 ms. machine # [ 77.726859] systemd[635]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 77.734074] systemd[635]: Stopped Run user-specific NixOS activation. machine # [ 77.734939] systemd[635]: Stopping Run user-specific NixOS activation... machine # [ 77.737712] systemd[635]: Starting Run user-specific NixOS activation... machine # [ 77.773398] systemd[635]: Finished Run user-specific NixOS activation. machine # [ 77.776920] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 77.778083] systemd[1]: Stopping Reactivate sysinit units... machine # [ 77.778855] systemd[1]: Reached target Reactivate sysinit units. machine # [ 77.784504] systemd[1]: Reached target Local File Systems. machine # [ 77.786097] systemd[1]: Reached target Remote File Systems. machine # [ 77.790063] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 77.793789] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 77.794581] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 77.795698] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 77.797585] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 77.798988] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 77.803654] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 77.805142] systemd[1]: Created slice Slice /system/instantiated. machine # [ 77.808247] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 77.809407] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 78.099791] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 78.101403] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 78.106535] systemd[1]: Starting instantiated@one.service... machine # [ 78.108732] systemd[1]: Starting instantiated@two.service... machine # [ 78.112349] systemd[1]: Starting linger-users.service... machine # [ 78.146240] systemd[1]: Finished instantiated@one.service. machine # [ 78.149476] systemd[1]: Finished instantiated@two.service. machine # [ 78.170433] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 78.172639] systemd[1]: Finished linger-users.service. machine # [ 78.429535] nixos[3910]: finished switching to system configuration /nix/store/5lfmm4mpyc7i9jssxq4rg7x6w8xfdpns-nixos-system-machine-test machine: (finished: must succeed: /nix/store/yv0fgsc3a9pf40xia3yrhzply67kinx0-nixos-system-machine-test/specialisation/unitWithTemplate/bin/switch-to-configuration test 2>&1, in 2.72 seconds) machine: must succeed: /nix/store/yv0fgsc3a9pf40xia3yrhzply67kinx0-nixos-system-machine-test/specialisation/unitWithTemplateModified/bin/switch-to-configuration test 2>&1 machine # [ 79.066701] nixos[4054]: switching to system configuration /nix/store/ndr6jj9rv81381gcwp95z574w7znlpyr-nixos-system-machine-test machine # [ 79.069275] systemd[1]: Stopped target Remote File Systems. machine # [ 79.070983] systemd[1]: Stopped target Local File Systems. machine # [ 79.072687] systemd[1]: instantiated@one.service: Deactivated successfully. machine # [ 79.073912] systemd[1]: Stopped instantiated@one.service. machine # [ 79.074938] systemd[1]: instantiated@two.service: Deactivated successfully. machine # [ 79.076363] systemd[1]: Stopped instantiated@two.service. machine # [ 79.522073] systemd[1]: Reload requested from client PID 4054 ('.switch-to-conf') (unit backdoor.service)... machine # [ 79.523688] systemd[1]: Reloading... machine # [ 80.061941] systemd[1]: Reloading finished in 536 ms. machine # [ 80.177198] systemd[635]: Reexecution requested from client PID 4123 ('switch-to-confi')... machine # [ 80.179235] systemd[635]: Reexecuting. machine # [ 80.206918] systemd[635]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 80.345179] systemd[635]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 80.351236] systemd[635]: Reload requested from client PID 4123 ('switch-to-confi')... machine # [ 80.352424] systemd[635]: Reloading... machine # [ 80.480969] systemd[635]: Reloading finished in 126 ms. machine # [ 80.485837] systemd[635]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 80.492588] systemd[635]: Stopped Run user-specific NixOS activation. machine # [ 80.493606] systemd[635]: Stopping Run user-specific NixOS activation... machine # [ 80.496819] systemd[635]: Starting Run user-specific NixOS activation... machine # [ 80.530563] systemd[635]: Finished Run user-specific NixOS activation. machine # [ 80.534781] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 80.535889] systemd[1]: Stopping Reactivate sysinit units... machine # [ 80.536832] systemd[1]: Reached target Reactivate sysinit units. machine # [ 80.542356] systemd[1]: Starting instantiated@two.service... machine # [ 80.546512] systemd[1]: Reached target Remote File Systems. machine # [ 80.548182] systemd[1]: Reached target Local File Systems. machine # [ 80.554597] systemd[1]: Starting instantiated@one.service... machine # [ 80.558395] systemd[1]: Starting linger-users.service... machine # [ 80.563938] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 80.570601] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 80.571611] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 80.572751] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 80.574664] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 80.576074] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 80.577198] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 80.582800] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 80.584829] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 80.610094] systemd[1]: Finished instantiated@two.service. machine # [ 80.619487] systemd[1]: Finished instantiated@one.service. machine # [ 80.651687] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 80.653177] systemd[1]: Finished linger-users.service. machine # [ 80.899615] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 80.902525] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 81.157789] nixos[4054]: finished switching to system configuration /nix/store/ndr6jj9rv81381gcwp95z574w7znlpyr-nixos-system-machine-test machine: (finished: must succeed: /nix/store/yv0fgsc3a9pf40xia3yrhzply67kinx0-nixos-system-machine-test/specialisation/unitWithTemplateModified/bin/switch-to-configuration test 2>&1, in 2.73 seconds) (finished: subtest: services, in 56.98 seconds) subtest: failing units machine: must succeed: /nix/store/yv0fgsc3a9pf40xia3yrhzply67kinx0-nixos-system-machine-test/specialisation/simpleServiceModified/bin/switch-to-configuration test 2>&1 machine # [ 81.668790] nixos[4198]: switching to system configuration /nix/store/9rksi58k287sbjnjcz2l6n81a4y3d0d8-nixos-system-machine-test machine # [ 81.671571] systemd[1]: Stopped target Local File Systems. machine # [ 81.673338] systemd[1]: instantiated@one.service: Deactivated successfully. machine # [ 81.674289] systemd[1]: Stopped instantiated@one.service. machine # [ 81.676314] systemd[1]: instantiated@two.service: Deactivated successfully. machine # [ 81.677404] systemd[1]: Stopped instantiated@two.service. machine # [ 81.678630] systemd[1]: Stopped target Remote File Systems. machine # [ 82.035375] systemd[1]: Reload requested from client PID 4198 ('.switch-to-conf') (unit backdoor.service)... machine # [ 82.036889] systemd[1]: Reloading... machine # [ 82.534177] systemd[1]: Reloading finished in 494 ms. machine # [ 82.654699] systemd[635]: Reexecution requested from client PID 4267 ('switch-to-confi')... machine # [ 82.657460] systemd[635]: Reexecuting. machine # [ 82.684906] systemd[635]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 82.819503] systemd[635]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 82.824453] systemd[635]: Reload requested from client PID 4267 ('switch-to-confi')... machine # [ 82.825901] systemd[635]: Reloading... machine # [ 82.962796] systemd[635]: Reloading finished in 134 ms. machine # [ 82.968279] systemd[635]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 82.975113] systemd[635]: Stopped Run user-specific NixOS activation. machine # [ 82.975977] systemd[635]: Stopping Run user-specific NixOS activation... machine # [ 82.978936] systemd[635]: Starting Run user-specific NixOS activation... machine # [ 83.014994] systemd[635]: Finished Run user-specific NixOS activation. machine # [ 83.018487] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 83.020238] systemd[1]: Stopping Reactivate sysinit units... machine # [ 83.021909] systemd[1]: Reached target Reactivate sysinit units. machine # [ 83.025287] systemd[1]: Reached target Remote File Systems. machine # [ 83.027337] systemd[1]: Reached target Local File Systems. machine # [ 83.031117] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 83.035227] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 83.036729] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 83.038462] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 83.040351] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 83.041827] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 83.042981] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 83.051117] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 83.052565] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 83.341291] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 83.343573] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 83.348166] systemd[1]: Starting linger-users.service... machine # [ 83.350286] systemd[1]: Starting test.service... machine # [ 83.381462] systemd[1]: Finished test.service. machine # [ 83.402638] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 83.404860] systemd[1]: Finished linger-users.service. machine # [ 83.661522] nixos[4198]: finished switching to system configuration /nix/store/9rksi58k287sbjnjcz2l6n81a4y3d0d8-nixos-system-machine-test machine: (finished: must succeed: /nix/store/yv0fgsc3a9pf40xia3yrhzply67kinx0-nixos-system-machine-test/specialisation/simpleServiceModified/bin/switch-to-configuration test 2>&1, in 2.50 seconds) machine: must fail: /nix/store/yv0fgsc3a9pf40xia3yrhzply67kinx0-nixos-system-machine-test/specialisation/simpleServiceFailing/bin/switch-to-configuration test 2>&1 machine # [ 84.225199] nixos[4340]: switching to system configuration /nix/store/i5p3lm9wfcgm6r2bdj4vwq9cpckigll8-nixos-system-machine-test machine # [ 84.227574] systemd[1]: Stopped target Remote File Systems. machine # [ 84.229552] systemd[1]: test.service: Deactivated successfully. machine # [ 84.231460] systemd[1]: Stopped test.service. machine # [ 84.232099] systemd[1]: Stopped target Local File Systems. machine # [ 84.666673] systemd[1]: Reload requested from client PID 4340 ('.switch-to-conf') (unit backdoor.service)... machine # [ 84.668249] systemd[1]: Reloading... machine # [ 85.158421] systemd[1]: Reloading finished in 488 ms. machine # [ 85.249839] systemd[635]: Reexecution requested from client PID 4409 ('switch-to-confi')... machine # [ 85.251154] systemd[635]: Reexecuting. machine # [ 85.277343] systemd[635]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 85.399281] systemd[635]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 85.404347] systemd[635]: Reload requested from client PID 4409 ('switch-to-confi')... machine # [ 85.405780] systemd[635]: Reloading... machine # [ 85.517925] systemd[635]: Reloading finished in 110 ms. machine # [ 85.522874] systemd[635]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 85.529400] systemd[635]: Stopped Run user-specific NixOS activation. machine # [ 85.530239] systemd[635]: Stopping Run user-specific NixOS activation... machine # [ 85.532770] systemd[635]: Starting Run user-specific NixOS activation... machine # [ 85.562907] systemd[635]: Finished Run user-specific NixOS activation. machine # [ 85.566570] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 85.567593] systemd[1]: Stopping Reactivate sysinit units... machine # [ 85.568671] systemd[1]: Reached target Reactivate sysinit units. machine # [ 85.570676] systemd[1]: Reached target Local File Systems. machine # [ 85.573807] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 85.575662] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 85.580634] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 85.585294] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 85.586774] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 85.588706] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 85.591515] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 85.594396] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 85.595614] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 85.596740] systemd[1]: Reached target Remote File Systems. machine # [ 85.865730] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 85.867374] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 85.872141] systemd[1]: Starting linger-users.service... machine # [ 85.875320] systemd[1]: Starting test.service... machine # [ 85.906432] systemd[1]: test.service: Main process exited, code=exited, status=1/FAILURE machine # [ 85.908245] systemd[1]: test.service: Failed with result 'exit-code'. machine # [ 85.910416] systemd[1]: Failed to start test.service. machine # [ 85.926875] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 85.928372] systemd[1]: Finished linger-users.service. machine # [ 86.201557] nixos[4340]: switching to system configuration /nix/store/i5p3lm9wfcgm6r2bdj4vwq9cpckigll8-nixos-system-machine-test failed (status 4) machine: (finished: must fail: /nix/store/yv0fgsc3a9pf40xia3yrhzply67kinx0-nixos-system-machine-test/specialisation/simpleServiceFailing/bin/switch-to-configuration test 2>&1, in 2.53 seconds) machine: must succeed: /nix/store/yv0fgsc3a9pf40xia3yrhzply67kinx0-nixos-system-machine-test/specialisation/autorestartService/bin/switch-to-configuration test 2>&1 machine # [ 86.644312] nixos[4483]: switching to system configuration /nix/store/dgapli5kfm2bq68macqink1qsg85abrd-nixos-system-machine-test machine # [ 86.646839] systemd[1]: Stopped target Remote File Systems. machine # [ 86.648601] systemd[1]: Stopped target Local File Systems. machine # [ 87.115925] systemd[1]: Reload requested from client PID 4483 ('.switch-to-conf') (unit backdoor.service)... machine # [ 87.117592] systemd[1]: Reloading... machine # [ 87.655784] systemd[1]: Reloading finished in 536 ms. machine # [ 87.793319] systemd[635]: Reexecution requested from client PID 4552 ('switch-to-confi')... machine # [ 87.794616] systemd[635]: Reexecuting. machine # [ 87.823414] systemd[635]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 87.944788] systemd[635]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 87.950576] systemd[635]: Reload requested from client PID 4552 ('switch-to-confi')... machine # [ 87.952024] systemd[635]: Reloading... machine # [ 88.089767] systemd[635]: Reloading finished in 135 ms. machine # [ 88.093857] systemd[635]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 88.100232] systemd[635]: Stopped Run user-specific NixOS activation. machine # [ 88.102097] systemd[635]: Stopping Run user-specific NixOS activation... machine # [ 88.104386] systemd[635]: Starting Run user-specific NixOS activation... machine # [ 88.141295] systemd[635]: Finished Run user-specific NixOS activation. machine # [ 88.144805] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 88.145811] systemd[1]: Stopping Reactivate sysinit units... machine # [ 88.146990] systemd[1]: Reached target Reactivate sysinit units. machine # [ 88.150818] systemd[1]: Reached target Local File Systems. machine # [ 88.151588] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 88.155056] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 88.155820] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 88.157673] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 88.160327] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 88.162198] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 88.165273] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 88.170752] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 88.172170] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 88.178264] systemd[1]: Reached target Remote File Systems. machine # [ 88.460127] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 88.462163] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 88.466170] systemd[1]: Started autorestart.service. machine # [ 88.470090] systemd[1]: Starting linger-users.service... machine # [ 88.499357] systemd[1]: autorestart.service: Deactivated successfully. machine # [ 88.521988] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 88.524216] systemd[1]: Finished linger-users.service. machine # [ 88.781665] nixos[4483]: finished switching to system configuration /nix/store/dgapli5kfm2bq68macqink1qsg85abrd-nixos-system-machine-test machine: (finished: must succeed: /nix/store/yv0fgsc3a9pf40xia3yrhzply67kinx0-nixos-system-machine-test/specialisation/autorestartService/bin/switch-to-configuration test 2>&1, in 2.58 seconds) machine # [ 88.844144] systemd[1]: Stopped autorestart.service. machine: must succeed: /nix/store/yv0fgsc3a9pf40xia3yrhzply67kinx0-nixos-system-machine-test/specialisation/autorestartService/bin/switch-to-configuration test 2>&1 machine # [ 89.373743] nixos[4630]: switching to system configuration /nix/store/dgapli5kfm2bq68macqink1qsg85abrd-nixos-system-machine-test machine # [ 89.376967] systemd[1]: Stopped target Remote File Systems. machine # [ 89.378066] systemd[1]: Stopped target Local File Systems. machine # [ 89.744947] systemd[1]: Reload requested from client PID 4630 ('.switch-to-conf') (unit backdoor.service)... machine # [ 89.746937] systemd[1]: Reloading... machine # [ 90.256234] systemd[1]: Reloading finished in 506 ms. machine # [ 90.361925] systemd[635]: Reexecution requested from client PID 4699 ('switch-to-confi')... machine # [ 90.364658] systemd[635]: Reexecuting. machine # [ 90.391481] systemd[635]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 90.525414] systemd[635]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 90.529468] systemd[635]: Reload requested from client PID 4699 ('switch-to-confi')... machine # [ 90.531068] systemd[635]: Reloading... machine # [ 90.670211] systemd[635]: Reloading finished in 137 ms. machine # [ 90.674824] systemd[635]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 90.682119] systemd[635]: Stopped Run user-specific NixOS activation. machine # [ 90.682987] systemd[635]: Stopping Run user-specific NixOS activation... machine # [ 90.685193] systemd[635]: Starting Run user-specific NixOS activation... machine # [ 90.721927] systemd[635]: Finished Run user-specific NixOS activation. machine # [ 90.724903] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 90.726375] systemd[1]: Stopping Reactivate sysinit units... machine # [ 90.727695] systemd[1]: Reached target Reactivate sysinit units. machine # [ 90.734321] systemd[1]: Reached target Remote File Systems. machine # [ 90.739184] systemd[1]: Started autorestart.service. machine # [ 90.742444] systemd[1]: Starting linger-users.service... machine # [ 90.748573] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 90.749900] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 90.753551] systemd[1]: Reached target Local File Systems. machine # [ 90.757706] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 90.765391] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 90.767646] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 90.770253] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 90.773708] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 90.776181] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 90.777917] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 90.804629] systemd[1]: autorestart.service: Deactivated successfully. machine # [ 90.836482] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 90.838618] systemd[1]: Finished linger-users.service. machine # [ 91.085695] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 91.087104] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 91.345636] nixos[4630]: finished switching to system configuration /nix/store/dgapli5kfm2bq68macqink1qsg85abrd-nixos-system-machine-test machine: (finished: must succeed: /nix/store/yv0fgsc3a9pf40xia3yrhzply67kinx0-nixos-system-machine-test/specialisation/autorestartService/bin/switch-to-configuration test 2>&1, in 2.50 seconds) machine # [ 91.411452] systemd[1]: Stopped autorestart.service. machine: must fail: /nix/store/yv0fgsc3a9pf40xia3yrhzply67kinx0-nixos-system-machine-test/specialisation/autorestartServiceFailing/bin/switch-to-configuration test 2>&1 machine # [ 91.980536] nixos[4777]: switching to system configuration /nix/store/7r0zqh05z9gzixijvm72cgrqdz10fnyv-nixos-system-machine-test machine # [ 91.982655] systemd[1]: Stopped target Local File Systems. machine # [ 91.984234] systemd[1]: Stopped target Remote File Systems. machine # [ 92.427893] systemd[1]: Reload requested from client PID 4777 ('.switch-to-conf') (unit backdoor.service)... machine # [ 92.429515] systemd[1]: Reloading... machine # [ 92.977186] systemd[1]: Reloading finished in 545 ms. machine # [ 93.082491] systemd[635]: Reexecution requested from client PID 4846 ('switch-to-confi')... machine # [ 93.084981] systemd[635]: Reexecuting. machine # [ 93.108364] systemd[635]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 93.236863] systemd[635]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 93.243031] systemd[635]: Reload requested from client PID 4846 ('switch-to-confi')... machine # [ 93.244317] systemd[635]: Reloading... machine # [ 93.387988] systemd[635]: Reloading finished in 141 ms. machine # [ 93.392886] systemd[635]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 93.399492] systemd[635]: Stopped Run user-specific NixOS activation. machine # [ 93.401076] systemd[635]: Stopping Run user-specific NixOS activation... machine # [ 93.403916] systemd[635]: Starting Run user-specific NixOS activation... machine # [ 93.439497] systemd[635]: Finished Run user-specific NixOS activation. machine # [ 93.443736] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 93.444692] systemd[1]: Stopping Reactivate sysinit units... machine # [ 93.445871] systemd[1]: Reached target Reactivate sysinit units. machine # [ 93.448679] systemd[1]: Reached target Local File Systems. machine # [ 93.453079] systemd[1]: Reached target Remote File Systems. machine # [ 93.457151] systemd[1]: Started autorestart.service. machine # [ 93.459597] systemd[1]: Starting linger-users.service... machine # [ 93.469299] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 93.475071] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 93.476024] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 93.477184] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 93.479101] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 93.480554] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 93.481736] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 93.486427] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 93.488829] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 93.516702] systemd[1]: autorestart.service: Main process exited, code=exited, status=1/FAILURE machine # [ 93.518581] systemd[1]: autorestart.service: Failed with result 'exit-code'. machine # [ 93.546206] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 93.547834] systemd[1]: Finished linger-users.service. machine # [ 93.798490] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 93.800092] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 94.097377] nixos[4777]: switching to system configuration /nix/store/7r0zqh05z9gzixijvm72cgrqdz10fnyv-nixos-system-machine-test failed (status 4) machine: (finished: must fail: /nix/store/yv0fgsc3a9pf40xia3yrhzply67kinx0-nixos-system-machine-test/specialisation/autorestartServiceFailing/bin/switch-to-configuration test 2>&1, in 2.69 seconds) (finished: subtest: failing units, in 12.94 seconds) subtest: unit file parser machine: must succeed: /nix/store/yv0fgsc3a9pf40xia3yrhzply67kinx0-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1 machine # [ 94.633966] nixos[4920]: switching to system configuration /nix/store/zm2d8l415g7acy497dvl3hqcc05778kd-nixos-system-machine-test machine # [ 94.636540] systemd[1]: Stopped target Local File Systems. machine # [ 94.638433] systemd[1]: Stopped target Remote File Systems. machine # [ 94.639679] systemd[1]: Stopped autorestart.service. machine # [ 95.037936] systemd[1]: Reload requested from client PID 4920 ('.switch-to-conf') (unit backdoor.service)... machine # [ 95.039864] systemd[1]: Reloading... machine # [ 95.518610] systemd[1]: Reloading finished in 476 ms. machine # [ 95.635304] systemd[635]: Reexecution requested from client PID 4989 ('switch-to-confi')... machine # [ 95.636544] systemd[635]: Reexecuting. machine # [ 95.664076] systemd[635]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 95.806788] systemd[635]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 95.812544] systemd[635]: Reload requested from client PID 4989 ('switch-to-confi')... machine # [ 95.813960] systemd[635]: Reloading... machine # [ 95.943641] systemd[635]: Reloading finished in 126 ms. machine # [ 95.946846] systemd[635]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 95.953943] systemd[635]: Stopped Run user-specific NixOS activation. machine # [ 95.954863] systemd[635]: Stopping Run user-specific NixOS activation... machine # [ 95.956987] systemd[635]: Starting Run user-specific NixOS activation... machine # [ 95.990327] systemd[635]: Finished Run user-specific NixOS activation. machine # [ 95.993773] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 95.995363] systemd[1]: Stopping Reactivate sysinit units... machine # [ 95.996489] systemd[1]: Reached target Reactivate sysinit units. machine # [ 95.997976] systemd[1]: Reached target Local File Systems. machine # [ 96.002311] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 96.003703] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 96.007063] systemd[1]: Reached target Remote File Systems. machine # [ 96.011133] systemd[1]: Starting linger-users.service... machine # [ 96.013843] systemd[1]: Starting test.service... machine # [ 96.024195] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 96.028104] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 96.028993] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 96.031561] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 96.034399] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 96.036570] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 96.039138] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 96.064649] systemd[1]: Finished test.service. machine # [ 96.087796] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 96.089597] systemd[1]: Finished linger-users.service. machine # [ 96.318799] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 96.321233] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 96.578517] nixos[4920]: finished switching to system configuration /nix/store/zm2d8l415g7acy497dvl3hqcc05778kd-nixos-system-machine-test machine: (finished: must succeed: /nix/store/yv0fgsc3a9pf40xia3yrhzply67kinx0-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1, in 2.48 seconds) machine: must succeed: /nix/store/yv0fgsc3a9pf40xia3yrhzply67kinx0-nixos-system-machine-test/specialisation/simpleServiceWithExtraSection/bin/switch-to-configuration test 2>&1 machine # [ 97.145593] nixos[5062]: switching to system configuration /nix/store/iwsch045kx33qbyz6rqn50hkmji8l5rj-nixos-system-machine-test machine # [ 97.149488] systemd[1]: Stopped target Remote File Systems. machine # [ 97.150442] systemd[1]: Stopped target Local File Systems. machine # [ 97.597463] systemd[1]: Reload requested from client PID 5062 ('.switch-to-conf') (unit backdoor.service)... machine # [ 97.599142] systemd[1]: Reloading... machine # [ 98.152371] systemd[1]: Reloading finished in 550 ms. machine # [ 98.275328] systemd[635]: Reexecution requested from client PID 5131 ('switch-to-confi')... machine # [ 98.276613] systemd[635]: Reexecuting. machine # [ 98.302331] systemd[635]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 98.442995] systemd[635]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 98.448974] systemd[635]: Reload requested from client PID 5131 ('switch-to-confi')... machine # [ 98.450200] systemd[635]: Reloading... machine # [ 98.588173] systemd[635]: Reloading finished in 136 ms. machine # [ 98.592846] systemd[635]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 98.600078] systemd[635]: Stopped Run user-specific NixOS activation. machine # [ 98.600917] systemd[635]: Stopping Run user-specific NixOS activation... machine # [ 98.603580] systemd[635]: Starting Run user-specific NixOS activation... machine # [ 98.638299] systemd[635]: Finished Run user-specific NixOS activation. machine # [ 98.641470] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 98.642707] systemd[1]: Stopping Reactivate sysinit units... machine # [ 98.643681] systemd[1]: Reached target Reactivate sysinit units. machine # [ 98.645299] systemd[1]: test.service: Deactivated successfully. machine # [ 98.647245] systemd[1]: Stopped test.service. machine # [ 98.647869] systemd[1]: Stopping test.service... machine # [ 98.650272] systemd[1]: Starting test.service... machine # [ 98.676769] systemd[1]: Finished test.service. machine # [ 98.681700] systemd[1]: Reached target Local File Systems. machine # [ 98.683920] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 98.687257] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 98.688146] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 98.689263] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 98.692355] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 98.694598] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 98.696301] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 98.699925] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 98.701100] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 98.704101] systemd[1]: Reached target Remote File Systems. machine # [ 98.990287] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 98.992080] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 98.996379] systemd[1]: Starting linger-users.service... machine # [ 99.046424] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 99.047880] systemd[1]: Finished linger-users.service. machine # [ 99.305453] nixos[5062]: finished switching to system configuration /nix/store/iwsch045kx33qbyz6rqn50hkmji8l5rj-nixos-system-machine-test machine: (finished: must succeed: /nix/store/yv0fgsc3a9pf40xia3yrhzply67kinx0-nixos-system-machine-test/specialisation/simpleServiceWithExtraSection/bin/switch-to-configuration test 2>&1, in 2.73 seconds) machine: must succeed: /nix/store/yv0fgsc3a9pf40xia3yrhzply67kinx0-nixos-system-machine-test/specialisation/simpleServiceWithExtraSectionOtherName/bin/switch-to-configuration test 2>&1 machine # [ 99.814655] nixos[5204]: switching to system configuration /nix/store/8wk49qvdz1h2hhwrdicfwyibwd8w5zzz-nixos-system-machine-test machine # [ 99.817310] systemd[1]: Stopped target Remote File Systems. machine # [ 99.818756] systemd[1]: Stopped target Local File Systems. machine # [ 100.246741] systemd[1]: Reload requested from client PID 5204 ('.switch-to-conf') (unit backdoor.service)... machine # [ 100.248877] systemd[1]: Reloading... machine # [ 100.783114] systemd[1]: Reloading finished in 532 ms. machine # [ 100.882308] systemd[635]: Reexecution requested from client PID 5273 ('switch-to-confi')... machine # [ 100.883609] systemd[635]: Reexecuting. machine # [ 100.909631] systemd[635]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 101.025430] systemd[635]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 101.030789] systemd[635]: Reload requested from client PID 5273 ('switch-to-confi')... machine # [ 101.031987] systemd[635]: Reloading... machine # [ 101.160265] systemd[635]: Reloading finished in 126 ms. machine # [ 101.164831] systemd[635]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 101.171065] systemd[635]: Stopped Run user-specific NixOS activation. machine # [ 101.172982] systemd[635]: Stopping Run user-specific NixOS activation... machine # [ 101.175166] systemd[635]: Starting Run user-specific NixOS activation... machine # [ 101.206684] systemd[635]: Finished Run user-specific NixOS activation. machine # [ 101.210517] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 101.211935] systemd[1]: Stopping Reactivate sysinit units... machine # [ 101.213137] systemd[1]: Reached target Reactivate sysinit units. machine # [ 101.214560] systemd[1]: test.service: Deactivated successfully. machine # [ 101.216389] systemd[1]: Stopped test.service. machine # [ 101.217034] systemd[1]: Stopping test.service... machine # [ 101.219483] systemd[1]: Starting test.service... machine # [ 101.243561] systemd[1]: Finished test.service. machine # [ 101.245824] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 101.247550] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 101.253119] systemd[1]: Reached target Remote File Systems. machine # [ 101.255335] systemd[1]: Starting linger-users.service... machine # [ 101.259443] systemd[1]: Reached target Local File Systems. machine # [ 101.262413] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 101.266092] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 101.266866] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 101.269120] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 101.272479] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 101.275140] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 101.276515] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 101.329676] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 101.331451] systemd[1]: Finished linger-users.service. machine # [ 101.543723] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 101.545923] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 101.804268] nixos[5204]: finished switching to system configuration /nix/store/8wk49qvdz1h2hhwrdicfwyibwd8w5zzz-nixos-system-machine-test machine: (finished: must succeed: /nix/store/yv0fgsc3a9pf40xia3yrhzply67kinx0-nixos-system-machine-test/specialisation/simpleServiceWithExtraSectionOtherName/bin/switch-to-configuration test 2>&1, in 2.50 seconds) machine: must succeed: /nix/store/yv0fgsc3a9pf40xia3yrhzply67kinx0-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1 machine # [ 102.334324] nixos[5346]: switching to system configuration /nix/store/zm2d8l415g7acy497dvl3hqcc05778kd-nixos-system-machine-test machine # [ 102.336715] systemd[1]: Stopped target Local File Systems. machine # [ 102.338423] systemd[1]: Stopped target Remote File Systems. machine # [ 102.732738] systemd[1]: Reload requested from client PID 5346 ('.switch-to-conf') (unit backdoor.service)... machine # [ 102.734419] systemd[1]: Reloading... machine # [ 103.207942] systemd[1]: Reloading finished in 471 ms. machine # [ 103.303243] systemd[635]: Reexecution requested from client PID 5415 ('switch-to-confi')... machine # [ 103.304495] systemd[635]: Reexecuting. machine # [ 103.327131] systemd[635]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 103.451031] systemd[635]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 103.456908] systemd[635]: Reload requested from client PID 5415 ('switch-to-confi')... machine # [ 103.458671] systemd[635]: Reloading... machine # [ 103.605486] systemd[635]: Reloading finished in 145 ms. machine # [ 103.610843] systemd[635]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 103.617271] systemd[635]: Stopped Run user-specific NixOS activation. machine # [ 103.619068] systemd[635]: Stopping Run user-specific NixOS activation... machine # [ 103.621252] systemd[635]: Starting Run user-specific NixOS activation... machine # [ 103.656934] systemd[635]: Finished Run user-specific NixOS activation. machine # [ 103.660506] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 103.662093] systemd[1]: Stopping Reactivate sysinit units... machine # [ 103.662882] systemd[1]: Reached target Reactivate sysinit units. machine # [ 103.664562] systemd[1]: test.service: Deactivated successfully. machine # [ 103.666307] systemd[1]: Stopped test.service. machine # [ 103.666956] systemd[1]: Stopping test.service... machine # [ 103.669532] systemd[1]: Starting test.service... machine # [ 103.695295] systemd[1]: Finished test.service. machine # [ 103.698720] systemd[1]: Reached target Local File Systems. machine # [ 103.702977] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 103.706266] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 103.707200] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 103.708316] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 103.711570] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 103.713440] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 103.715357] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 103.719159] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 103.720401] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 103.724880] systemd[1]: Reached target Remote File Systems. machine # [ 104.002925] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 104.004756] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 104.009275] systemd[1]: Starting linger-users.service... machine # [ 104.061496] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 104.062495] systemd[1]: Finished linger-users.service. machine # [ 104.319725] nixos[5346]: finished switching to system configuration /nix/store/zm2d8l415g7acy497dvl3hqcc05778kd-nixos-system-machine-test machine: (finished: must succeed: /nix/store/yv0fgsc3a9pf40xia3yrhzply67kinx0-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1, in 2.52 seconds) machine: must succeed: /nix/store/yv0fgsc3a9pf40xia3yrhzply67kinx0-nixos-system-machine-test/specialisation/simpleServiceWithInstallSection/bin/switch-to-configuration test 2>&1 machine # [ 104.925173] nixos[5488]: switching to system configuration /nix/store/il7hvci2wffimfmzc7jl1dcwjjp55kh9-nixos-system-machine-test machine # [ 104.927779] systemd[1]: Stopped target Local File Systems. machine # [ 104.929078] systemd[1]: Stopped target Remote File Systems. machine # [ 105.371993] systemd[1]: Reload requested from client PID 5488 ('.switch-to-conf') (unit backdoor.service)... machine # [ 105.373669] systemd[1]: Reloading... machine # [ 105.904855] systemd[1]: Reloading finished in 529 ms. machine # [ 106.035454] systemd[635]: Reexecution requested from client PID 5557 ('switch-to-confi')... machine # [ 106.036899] systemd[635]: Reexecuting. machine # [ 106.064901] systemd[635]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 106.212122] systemd[635]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 106.218478] systemd[635]: Reload requested from client PID 5557 ('switch-to-confi')... machine # [ 106.220089] systemd[635]: Reloading... machine # [ 106.357054] systemd[635]: Reloading finished in 135 ms. machine # [ 106.361838] systemd[635]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 106.368270] systemd[635]: Stopped Run user-specific NixOS activation. machine # [ 106.370103] systemd[635]: Stopping Run user-specific NixOS activation... machine # [ 106.372307] systemd[635]: Starting Run user-specific NixOS activation... machine # [ 106.406762] systemd[635]: Finished Run user-specific NixOS activation. machine # [ 106.410812] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 106.411973] systemd[1]: Stopping Reactivate sysinit units... machine # [ 106.412930] systemd[1]: Reached target Reactivate sysinit units. machine # [ 106.415647] systemd[1]: Reached target Remote File Systems. machine # [ 106.419273] systemd[1]: Starting linger-users.service... machine # [ 106.427301] systemd[1]: Reached target Local File Systems. machine # [ 106.428142] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 106.431604] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 106.432454] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 106.434309] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 106.436281] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 106.437712] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 106.438850] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 106.443954] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 106.445339] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 106.496958] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 106.498747] systemd[1]: Finished linger-users.service. machine # [ 106.733887] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 106.735732] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 106.993303] nixos[5488]: finished switching to system configuration /nix/store/il7hvci2wffimfmzc7jl1dcwjjp55kh9-nixos-system-machine-test machine: (finished: must succeed: /nix/store/yv0fgsc3a9pf40xia3yrhzply67kinx0-nixos-system-machine-test/specialisation/simpleServiceWithInstallSection/bin/switch-to-configuration test 2>&1, in 2.67 seconds) machine: must succeed: /nix/store/yv0fgsc3a9pf40xia3yrhzply67kinx0-nixos-system-machine-test/specialisation/simpleServiceWithExtraKey/bin/switch-to-configuration test 2>&1 machine # [ 107.614933] nixos[5628]: switching to system configuration /nix/store/vb7xlvha2nk4h90wb4nnv4rslyfiigc6-nixos-system-machine-test machine # [ 107.617304] systemd[1]: Stopped target Local File Systems. machine # [ 107.619066] systemd[1]: Stopped target Remote File Systems. machine # [ 108.081685] systemd[1]: Reload requested from client PID 5628 ('.switch-to-conf') (unit backdoor.service)... machine # [ 108.083422] systemd[1]: Reloading... machine # [ 108.650105] systemd[1]: Reloading finished in 564 ms. machine # [ 108.757308] systemd[635]: Reexecution requested from client PID 5697 ('switch-to-confi')... machine # [ 108.760119] systemd[635]: Reexecuting. machine # [ 108.788758] systemd[635]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 108.915675] systemd[635]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 108.921949] systemd[635]: Reload requested from client PID 5697 ('switch-to-confi')... machine # [ 108.923200] systemd[635]: Reloading... machine # [ 109.047507] systemd[635]: Reloading finished in 122 ms. machine # [ 109.052848] systemd[635]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 109.060098] systemd[635]: Stopped Run user-specific NixOS activation. machine # [ 109.060958] systemd[635]: Stopping Run user-specific NixOS activation... machine # [ 109.063910] systemd[635]: Starting Run user-specific NixOS activation... machine # [ 109.095689] systemd[635]: Finished Run user-specific NixOS activation. machine # [ 109.098763] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 109.099971] systemd[1]: Stopping Reactivate sysinit units... machine # [ 109.101157] systemd[1]: Reached target Reactivate sysinit units. machine # [ 109.105681] systemd[1]: test.service: Deactivated successfully. machine # [ 109.107122] systemd[1]: Stopped test.service. machine # [ 109.107729] systemd[1]: Stopping test.service... machine # [ 109.110506] systemd[1]: Starting test.service... machine # [ 109.132864] systemd[1]: Finished test.service. machine # [ 109.135708] systemd[1]: Reached target Remote File Systems. machine # [ 109.138953] systemd[1]: Starting linger-users.service... machine # [ 109.140912] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 109.142463] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 109.147519] systemd[1]: Reached target Local File Systems. machine # [ 109.148337] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 109.152740] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 109.153762] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 109.155001] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 109.158110] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 109.159528] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 109.161607] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 109.213059] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 109.214193] systemd[1]: Finished linger-users.service. machine # [ 109.458673] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 109.461816] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 109.717637] nixos[5628]: finished switching to system configuration /nix/store/vb7xlvha2nk4h90wb4nnv4rslyfiigc6-nixos-system-machine-test machine: (finished: must succeed: /nix/store/yv0fgsc3a9pf40xia3yrhzply67kinx0-nixos-system-machine-test/specialisation/simpleServiceWithExtraKey/bin/switch-to-configuration test 2>&1, in 2.72 seconds) machine: must succeed: /nix/store/yv0fgsc3a9pf40xia3yrhzply67kinx0-nixos-system-machine-test/specialisation/simpleServiceWithExtraKeyOtherValue/bin/switch-to-configuration test 2>&1 machine # [ 110.149365] nixos[5770]: switching to system configuration /nix/store/0b5ncnrrbndvbqqy8sh24rhl3fmv120c-nixos-system-machine-test machine # [ 110.151633] systemd[1]: Stopped target Local File Systems. machine # [ 110.153538] systemd[1]: Stopped target Remote File Systems. machine # [ 110.600930] systemd[1]: Reload requested from client PID 5770 ('.switch-to-conf') (unit backdoor.service)... machine # [ 110.602641] systemd[1]: Reloading... machine # [ 111.071096] systemd[1]: Reloading finished in 465 ms. machine # [ 111.169646] systemd[635]: Reexecution requested from client PID 5839 ('switch-to-confi')... machine # [ 111.172766] systemd[635]: Reexecuting. machine # [ 111.193617] systemd[635]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 111.298156] systemd[635]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 111.303670] systemd[635]: Reload requested from client PID 5839 ('switch-to-confi')... machine # [ 111.304858] systemd[635]: Reloading... machine # [ 111.412462] systemd[635]: Reloading finished in 105 ms. machine # [ 111.417842] systemd[635]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 111.424108] systemd[635]: Stopped Run user-specific NixOS activation. machine # [ 111.424937] systemd[635]: Stopping Run user-specific NixOS activation... machine # [ 111.427899] systemd[635]: Starting Run user-specific NixOS activation... machine # [ 111.461943] systemd[635]: Finished Run user-specific NixOS activation. machine # [ 111.465361] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 111.466766] systemd[1]: Stopping Reactivate sysinit units... machine # [ 111.467713] systemd[1]: Reached target Reactivate sysinit units. machine # [ 111.469323] systemd[1]: test.service: Deactivated successfully. machine # [ 111.471223] systemd[1]: Stopped test.service. machine # [ 111.471835] systemd[1]: Stopping test.service... machine # [ 111.474398] systemd[1]: Starting test.service... machine # [ 111.499724] systemd[1]: Finished test.service. machine # [ 111.503783] systemd[1]: Reached target Remote File Systems. machine # [ 111.507116] systemd[1]: Starting linger-users.service... machine # [ 111.512327] systemd[1]: Reached target Local File Systems. machine # [ 111.513217] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 111.517467] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 111.518346] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 111.519632] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 111.522057] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 111.523476] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 111.524575] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 111.534395] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 111.535785] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 111.585640] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 111.587469] systemd[1]: Finished linger-users.service. machine # [ 111.798878] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 111.800757] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 112.055182] nixos[5770]: finished switching to system configuration /nix/store/0b5ncnrrbndvbqqy8sh24rhl3fmv120c-nixos-system-machine-test machine: (finished: must succeed: /nix/store/yv0fgsc3a9pf40xia3yrhzply67kinx0-nixos-system-machine-test/specialisation/simpleServiceWithExtraKeyOtherValue/bin/switch-to-configuration test 2>&1, in 2.33 seconds) machine: must succeed: /nix/store/yv0fgsc3a9pf40xia3yrhzply67kinx0-nixos-system-machine-test/specialisation/simpleServiceWithExtraKeyOtherName/bin/switch-to-configuration test 2>&1 machine # [ 112.614917] nixos[5912]: switching to system configuration /nix/store/rlpmzml628f0nhq79cvxhckd7n7d96jn-nixos-system-machine-test machine # [ 112.617394] systemd[1]: Stopped target Local File Systems. machine # [ 112.618964] systemd[1]: Stopped target Remote File Systems. machine # [ 113.054168] systemd[1]: Reload requested from client PID 5912 ('.switch-to-conf') (unit backdoor.service)... machine # [ 113.055968] systemd[1]: Reloading... machine # [ 113.626336] systemd[1]: Reloading finished in 567 ms. machine # [ 113.747324] systemd[635]: Reexecution requested from client PID 5981 ('switch-to-confi')... machine # [ 113.749408] systemd[635]: Reexecuting. machine # [ 113.775938] systemd[635]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 113.915538] systemd[635]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 113.920945] systemd[635]: Reload requested from client PID 5981 ('switch-to-confi')... machine # [ 113.922420] systemd[635]: Reloading... machine # [ 114.061636] systemd[635]: Reloading finished in 138 ms. machine # [ 114.066831] systemd[635]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 114.073254] systemd[635]: Stopped Run user-specific NixOS activation. machine # [ 114.075071] systemd[635]: Stopping Run user-specific NixOS activation... machine # [ 114.077278] systemd[635]: Starting Run user-specific NixOS activation... machine # [ 114.109116] systemd[635]: Finished Run user-specific NixOS activation. machine # [ 114.112265] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 114.113529] systemd[1]: Stopping Reactivate sysinit units... machine # [ 114.114517] systemd[1]: Reached target Reactivate sysinit units. machine # [ 114.116068] systemd[1]: test.service: Deactivated successfully. machine # [ 114.118216] systemd[1]: Stopped test.service. machine # [ 114.118957] systemd[1]: Stopping test.service... machine # [ 114.120779] systemd[1]: Starting test.service... machine # [ 114.141215] systemd[1]: Finished test.service. machine # [ 114.143329] systemd[1]: Reached target Remote File Systems. machine # [ 114.150187] systemd[1]: Starting linger-users.service... machine # [ 114.156928] systemd[1]: Reached target Local File Systems. machine # [ 114.157735] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 114.162852] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 114.163748] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 114.164906] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 114.166828] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 114.168215] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 114.169351] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 114.172371] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 114.176145] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 114.225796] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 114.227606] systemd[1]: Finished linger-users.service. machine # [ 114.424613] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 114.426366] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 114.684207] nixos[5912]: finished switching to system configuration /nix/store/rlpmzml628f0nhq79cvxhckd7n7d96jn-nixos-system-machine-test machine: (finished: must succeed: /nix/store/yv0fgsc3a9pf40xia3yrhzply67kinx0-nixos-system-machine-test/specialisation/simpleServiceWithExtraKeyOtherName/bin/switch-to-configuration test 2>&1, in 2.63 seconds) machine: must succeed: /nix/store/yv0fgsc3a9pf40xia3yrhzply67kinx0-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1 machine # [ 115.205249] nixos[6054]: switching to system configuration /nix/store/zm2d8l415g7acy497dvl3hqcc05778kd-nixos-system-machine-test machine # [ 115.207886] systemd[1]: Stopped target Local File Systems. machine # [ 115.209533] systemd[1]: Stopped target Remote File Systems. machine # [ 115.577647] systemd[1]: Reload requested from client PID 6054 ('.switch-to-conf') (unit backdoor.service)... machine # [ 115.579281] systemd[1]: Reloading... machine # [ 116.003945] systemd[1]: Reloading finished in 423 ms. machine # [ 116.098177] systemd[635]: Reexecution requested from client PID 6123 ('switch-to-confi')... machine # [ 116.100882] systemd[635]: Reexecuting. machine # [ 116.122588] systemd[635]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 116.234126] systemd[635]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 116.239499] systemd[635]: Reload requested from client PID 6123 ('switch-to-confi')... machine # [ 116.240729] systemd[635]: Reloading... machine # [ 116.384532] systemd[635]: Reloading finished in 141 ms. machine # [ 116.388845] systemd[635]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 116.396937] systemd[635]: Stopped Run user-specific NixOS activation. machine # [ 116.398879] systemd[635]: Stopping Run user-specific NixOS activation... machine # [ 116.401142] systemd[635]: Starting Run user-specific NixOS activation... machine # [ 116.434662] systemd[635]: Finished Run user-specific NixOS activation. machine # [ 116.437941] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 116.439457] systemd[1]: Stopping Reactivate sysinit units... machine # [ 116.440482] systemd[1]: Reached target Reactivate sysinit units. machine # [ 116.441981] systemd[1]: test.service: Deactivated successfully. machine # [ 116.443178] systemd[1]: Stopped test.service. machine # [ 116.443789] systemd[1]: Stopping test.service... machine # [ 116.446859] systemd[1]: Starting test.service... machine # [ 116.471454] systemd[1]: Finished test.service. machine # [ 116.477376] systemd[1]: Reached target Local File Systems. machine # [ 116.479809] systemd[1]: Reached target Remote File Systems. machine # [ 116.483477] systemd[1]: Starting linger-users.service... machine # [ 116.486076] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 116.487761] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 116.497128] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 116.501884] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 116.503207] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 116.504724] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 116.506811] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 116.508978] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 116.510490] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 116.555833] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 116.557431] systemd[1]: Finished linger-users.service. machine # [ 116.807200] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 116.808843] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 117.065641] nixos[6054]: finished switching to system configuration /nix/store/zm2d8l415g7acy497dvl3hqcc05778kd-nixos-system-machine-test machine: (finished: must succeed: /nix/store/yv0fgsc3a9pf40xia3yrhzply67kinx0-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1, in 2.38 seconds) machine: must succeed: /nix/store/yv0fgsc3a9pf40xia3yrhzply67kinx0-nixos-system-machine-test/specialisation/simpleServiceReloadTrigger/bin/switch-to-configuration test 2>&1 machine # [ 117.649511] nixos[6196]: switching to system configuration /nix/store/4d3cyyx4xi725jvhzvljx1hjm635qrxj-nixos-system-machine-test machine # [ 117.653080] systemd[1]: Stopped target Local File Systems. machine # [ 117.654060] systemd[1]: Stopped target Remote File Systems. machine # [ 118.092098] systemd[1]: Reload requested from client PID 6196 ('.switch-to-conf') (unit backdoor.service)... machine # [ 118.093729] systemd[1]: Reloading... machine # [ 118.602902] systemd[1]: Reloading finished in 506 ms. machine # [ 118.712815] systemd[635]: Reexecution requested from client PID 6265 ('switch-to-confi')... machine # [ 118.715594] systemd[635]: Reexecuting. machine # [ 118.745469] systemd[635]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 118.876490] systemd[635]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 118.881460] systemd[635]: Reload requested from client PID 6265 ('switch-to-confi')... machine # [ 118.883100] systemd[635]: Reloading... machine # [ 119.014143] systemd[635]: Reloading finished in 129 ms. machine # [ 119.017839] systemd[635]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 119.024504] systemd[635]: Stopped Run user-specific NixOS activation. machine # [ 119.025481] systemd[635]: Stopping Run user-specific NixOS activation... machine # [ 119.028627] systemd[635]: Starting Run user-specific NixOS activation... machine # [ 119.060318] systemd[635]: Finished Run user-specific NixOS activation. machine # [ 119.063638] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 119.065164] systemd[1]: Stopping Reactivate sysinit units... machine # [ 119.065895] systemd[1]: Reached target Reactivate sysinit units. machine # [ 119.069690] systemd[1]: Reloading test.service... machine # [ 119.093495] systemd[1]: Reloaded test.service. machine # [ 119.097595] systemd[1]: Reached target Local File Systems. machine # [ 119.102236] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 119.107422] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 119.108499] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 119.110334] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 119.112565] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 119.114670] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 119.116167] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 119.118938] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 119.120269] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 119.122535] systemd[1]: Reached target Remote File Systems. machine # [ 119.409094] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 119.410493] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 119.415082] systemd[1]: Starting linger-users.service... machine # [ 119.461436] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 119.462835] systemd[1]: Finished linger-users.service. machine # [ 119.720194] nixos[6196]: finished switching to system configuration /nix/store/4d3cyyx4xi725jvhzvljx1hjm635qrxj-nixos-system-machine-test machine: (finished: must succeed: /nix/store/yv0fgsc3a9pf40xia3yrhzply67kinx0-nixos-system-machine-test/specialisation/simpleServiceReloadTrigger/bin/switch-to-configuration test 2>&1, in 2.65 seconds) machine: must succeed: /nix/store/yv0fgsc3a9pf40xia3yrhzply67kinx0-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModified/bin/switch-to-configuration test 2>&1 machine # [ 120.261445] nixos[6338]: switching to system configuration /nix/store/si6aqaabksna0m65qcr72dvjly4rlk5f-nixos-system-machine-test machine # [ 120.263759] systemd[1]: Stopped target Local File Systems. machine # [ 120.265334] systemd[1]: Stopped target Remote File Systems. machine # [ 120.666438] systemd[1]: Reload requested from client PID 6338 ('.switch-to-conf') (unit backdoor.service)... machine # [ 120.667930] systemd[1]: Reloading... machine # [ 121.136988] systemd[1]: Reloading finished in 467 ms. machine # [ 121.235323] systemd[635]: Reexecution requested from client PID 6407 ('switch-to-confi')... machine # [ 121.237680] systemd[635]: Reexecuting. machine # [ 121.263896] systemd[635]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 121.398951] systemd[635]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 121.404072] systemd[635]: Reload requested from client PID 6407 ('switch-to-confi')... machine # [ 121.405444] systemd[635]: Reloading... machine # [ 121.549028] systemd[635]: Reloading finished in 142 ms. machine # [ 121.553837] systemd[635]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 121.560349] systemd[635]: Stopped Run user-specific NixOS activation. machine # [ 121.562070] systemd[635]: Stopping Run user-specific NixOS activation... machine # [ 121.564502] systemd[635]: Starting Run user-specific NixOS activation... machine # [ 121.606740] systemd[635]: Finished Run user-specific NixOS activation. machine # [ 121.610301] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 121.611964] systemd[1]: Stopping Reactivate sysinit units... machine # [ 121.614170] systemd[1]: Reached target Reactivate sysinit units. machine # [ 121.616880] systemd[1]: Reloading test.service... machine # [ 121.648462] systemd[1]: Reloaded test.service. machine # [ 121.652124] systemd[1]: Reached target Remote File Systems. machine # [ 121.654965] systemd[1]: Starting linger-users.service... machine # [ 121.658146] systemd[1]: Reached target Local File Systems. machine # [ 121.660980] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 121.665692] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 121.666483] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 121.667542] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 121.669374] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 121.670741] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 121.671831] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 121.676310] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 121.679126] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 121.734515] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 121.736528] systemd[1]: Finished linger-users.service. machine # [ 121.984493] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 121.987464] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 122.243970] nixos[6338]: finished switching to system configuration /nix/store/si6aqaabksna0m65qcr72dvjly4rlk5f-nixos-system-machine-test machine: (finished: must succeed: /nix/store/yv0fgsc3a9pf40xia3yrhzply67kinx0-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModified/bin/switch-to-configuration test 2>&1, in 2.52 seconds) machine: must succeed: /nix/store/yv0fgsc3a9pf40xia3yrhzply67kinx0-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModifiedAndSomethingElse/bin/switch-to-configuration test 2>&1 machine # [ 122.792844] nixos[6480]: switching to system configuration /nix/store/s5g13jpqpjnbzr9wnnajhzxi94ihsilg-nixos-system-machine-test machine # [ 122.796300] systemd[1]: Stopped target Remote File Systems. machine # [ 122.797246] systemd[1]: Stopped target Local File Systems. machine # [ 123.208665] systemd[1]: Reload requested from client PID 6480 ('.switch-to-conf') (unit backdoor.service)... machine # [ 123.210552] systemd[1]: Reloading... machine # [ 123.728974] systemd[1]: Reloading finished in 516 ms. machine # [ 123.864445] systemd[635]: Reexecution requested from client PID 6549 ('switch-to-confi')... machine # [ 123.868078] systemd[635]: Reexecuting. machine # [ 123.893544] systemd[635]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 124.038679] systemd[635]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 124.044727] systemd[635]: Reload requested from client PID 6549 ('switch-to-confi')... machine # [ 124.045931] systemd[635]: Reloading... machine # [ 124.175958] systemd[635]: Reloading finished in 128 ms. machine # [ 124.180897] systemd[635]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 124.188079] systemd[635]: Stopped Run user-specific NixOS activation. machine # [ 124.189085] systemd[635]: Stopping Run user-specific NixOS activation... machine # [ 124.191677] systemd[635]: Starting Run user-specific NixOS activation... machine # [ 124.218789] systemd[635]: Finished Run user-specific NixOS activation. machine # [ 124.222672] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 124.223744] systemd[1]: Stopping Reactivate sysinit units... machine # [ 124.225093] systemd[1]: Reached target Reactivate sysinit units. machine # [ 124.226383] systemd[1]: test.service: Deactivated successfully. machine # [ 124.228251] systemd[1]: Stopped test.service. machine # [ 124.229084] systemd[1]: Stopping test.service... machine # [ 124.233253] systemd[1]: Starting test.service... machine # [ 124.251601] systemd[1]: Finished test.service. machine # [ 124.255331] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 124.257411] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 124.259347] systemd[1]: Reached target Remote File Systems. machine # [ 124.263924] systemd[1]: Starting linger-users.service... machine # [ 124.273764] systemd[1]: Reached target Local File Systems. machine # [ 124.276160] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 124.279823] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 124.280706] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 124.281832] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 124.283688] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 124.285067] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 124.289152] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 124.335390] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 124.337337] systemd[1]: Finished linger-users.service. machine # [ 124.536361] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 124.538312] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 124.796689] nixos[6480]: finished switching to system configuration /nix/store/s5g13jpqpjnbzr9wnnajhzxi94ihsilg-nixos-system-machine-test machine: (finished: must succeed: /nix/store/yv0fgsc3a9pf40xia3yrhzply67kinx0-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModifiedAndSomethingElse/bin/switch-to-configuration test 2>&1, in 2.55 seconds) machine: must succeed: /nix/store/yv0fgsc3a9pf40xia3yrhzply67kinx0-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModifiedSomethingElse/bin/switch-to-configuration test 2>&1 machine # [ 125.325327] nixos[6622]: switching to system configuration /nix/store/vb7xlvha2nk4h90wb4nnv4rslyfiigc6-nixos-system-machine-test machine # [ 125.327593] systemd[1]: Stopped target Local File Systems. machine # [ 125.329739] systemd[1]: Stopped target Remote File Systems. machine # [ 125.703146] systemd[1]: Reload requested from client PID 6622 ('.switch-to-conf') (unit backdoor.service)... machine # [ 125.704803] systemd[1]: Reloading... machine # [ 126.175326] systemd[1]: Reloading finished in 468 ms. machine # [ 126.296394] systemd[635]: Reexecution requested from client PID 6691 ('switch-to-confi')... machine # [ 126.299074] systemd[635]: Reexecuting. machine # [ 126.330222] systemd[635]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 126.466335] systemd[635]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 126.472106] systemd[635]: Reload requested from client PID 6691 ('switch-to-confi')... machine # [ 126.473868] systemd[635]: Reloading... machine # [ 126.611727] systemd[635]: Reloading finished in 136 ms. machine # [ 126.617890] systemd[635]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 126.624515] systemd[635]: Stopped Run user-specific NixOS activation. machine # [ 126.625571] systemd[635]: Stopping Run user-specific NixOS activation... machine # [ 126.628910] systemd[635]: Starting Run user-specific NixOS activation... machine # [ 126.665981] systemd[635]: Finished Run user-specific NixOS activation. machine # [ 126.669900] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 126.671914] systemd[1]: Stopping Reactivate sysinit units... machine # [ 126.673157] systemd[1]: Reached target Reactivate sysinit units. machine # [ 126.674402] systemd[1]: Reached target Local File Systems. machine # [ 126.676939] systemd[1]: Reached target Remote File Systems. machine # [ 126.680848] systemd[1]: Starting linger-users.service... machine # [ 126.688869] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 126.691418] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 126.693186] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 126.695342] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 126.698216] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 126.701348] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 126.703417] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 126.709805] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 126.711203] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 126.759172] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 126.760524] systemd[1]: Finished linger-users.service. machine # [ 127.013464] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 127.015387] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 127.270750] nixos[6622]: finished switching to system configuration /nix/store/vb7xlvha2nk4h90wb4nnv4rslyfiigc6-nixos-system-machine-test machine: (finished: must succeed: /nix/store/yv0fgsc3a9pf40xia3yrhzply67kinx0-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModifiedSomethingElse/bin/switch-to-configuration test 2>&1, in 2.47 seconds) (finished: subtest: unit file parser, in 33.17 seconds) subtest: restart and reload by activation script machine: must succeed: /nix/store/yv0fgsc3a9pf40xia3yrhzply67kinx0-nixos-system-machine-test/specialisation/simpleServiceNorestart/bin/switch-to-configuration test 2>&1 machine # [ 127.718493] nixos[6762]: switching to system configuration /nix/store/j5isxs13vdzdggrp91dmni44as17vmyi-nixos-system-machine-test machine # [ 127.720950] systemd[1]: Stopped target Remote File Systems. machine # [ 127.723128] systemd[1]: Stopped target Local File Systems. machine # [ 128.118744] systemd[1]: Reload requested from client PID 6762 ('.switch-to-conf') (unit backdoor.service)... machine # [ 128.120455] systemd[1]: Reloading... machine # [ 128.612757] systemd[1]: Reloading finished in 490 ms. machine # [ 128.731181] systemd[635]: Reexecution requested from client PID 6831 ('switch-to-confi')... machine # [ 128.734314] systemd[635]: Reexecuting. machine # [ 128.760721] systemd[635]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 128.899641] systemd[635]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 128.905790] systemd[635]: Reload requested from client PID 6831 ('switch-to-confi')... machine # [ 128.906941] systemd[635]: Reloading... machine # [ 129.049133] systemd[635]: Reloading finished in 140 ms. machine # [ 129.053903] systemd[635]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 129.060634] systemd[635]: Stopped Run user-specific NixOS activation. machine # [ 129.061630] systemd[635]: Stopping Run user-specific NixOS activation... machine # [ 129.064914] systemd[635]: Starting Run user-specific NixOS activation... machine # [ 129.102967] systemd[635]: Finished Run user-specific NixOS activation. machine # [ 129.106582] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 129.108101] systemd[1]: Stopping Reactivate sysinit units... machine # [ 129.108880] systemd[1]: Reached target Reactivate sysinit units. machine # [ 129.112289] systemd[1]: Reached target Remote File Systems. machine # [ 129.114761] systemd[1]: Reached target Local File Systems. machine # [ 129.119944] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 129.121920] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 129.127168] systemd[1]: Starting linger-users.service... machine # [ 129.129246] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 129.133936] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 129.135540] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 129.137102] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 129.139043] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 129.140453] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 129.141588] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 129.199970] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 129.201635] systemd[1]: Finished linger-users.service. machine # [ 129.453190] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 129.456142] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 129.710329] nixos[6762]: finished switching to system configuration /nix/store/j5isxs13vdzdggrp91dmni44as17vmyi-nixos-system-machine-test machine: (finished: must succeed: /nix/store/yv0fgsc3a9pf40xia3yrhzply67kinx0-nixos-system-machine-test/specialisation/simpleServiceNorestart/bin/switch-to-configuration test 2>&1, in 2.44 seconds) machine: must succeed: /nix/store/yv0fgsc3a9pf40xia3yrhzply67kinx0-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration test 2>&1 machine # [ 130.338959] nixos[6902]: switching to system configuration /nix/store/60izimxxc3j6bqfmzq0xgvhzw876p5q9-nixos-system-machine-test machine # [ 130.342446] systemd[1]: test.service: Deactivated successfully. machine # [ 130.343855] systemd[1]: Stopped test.service. machine # [ 130.345228] systemd[1]: Stopped target Local File Systems. machine # [ 130.345985] systemd[1]: Stopped target Remote File Systems. machine # [ 130.840392] systemd[1]: Reload requested from client PID 6902 ('.switch-to-conf') (unit backdoor.service)... machine # [ 130.842234] systemd[1]: Reloading... machine # [ 131.442706] systemd[1]: Reloading finished in 598 ms. machine # [ 131.558454] systemd[635]: Reexecution requested from client PID 6973 ('switch-to-confi')... machine # [ 131.560456] systemd[635]: Reexecuting. machine # [ 131.587744] systemd[635]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 131.729034] systemd[635]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 131.735362] systemd[635]: Reload requested from client PID 6973 ('switch-to-confi')... machine # [ 131.736827] systemd[635]: Reloading... machine # [ 131.879845] systemd[635]: Reloading finished in 141 ms. machine # [ 131.885890] systemd[635]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 131.892872] systemd[635]: Stopped Run user-specific NixOS activation. machine # [ 131.894385] systemd[635]: Stopping Run user-specific NixOS activation... machine # [ 131.897204] systemd[635]: Starting Run user-specific NixOS activation... machine # [ 131.933366] systemd[635]: Finished Run user-specific NixOS activation. machine # [ 131.936851] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 131.938242] systemd[1]: Stopping Reactivate sysinit units... machine # [ 131.939045] systemd[1]: Reached target Reactivate sysinit units. machine # [ 131.942099] systemd[1]: Reached target Local File Systems. machine # [ 131.944364] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 131.948255] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 131.949903] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 131.951610] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 131.954777] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 131.956266] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 131.957786] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 131.964558] systemd[1]: Created slice Slice /system/templated-simple-restart-service. machine # [ 131.967431] systemd[1]: Reached target Remote File Systems. machine # [ 131.981922] systemd[1]: Created slice Slice /system/templated-simple-service. machine # [ 131.989235] systemd[1]: Created slice Slice /system/templated-reload-triggers. machine # [ 131.991332] systemd[1]: Created slice Slice /system/templated-reload-triggers-and-restart. machine # [ 132.012751] systemd[1]: Created slice Slice /system/templated-simple-reload-service. machine # [ 132.014151] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 132.015995] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 132.030193] systemd[1]: Created slice Slice /system/templated-no-restart-service. machine # [ 132.040053] systemd[1]: Created slice Slice /system/templated-reload-triggers-and-restart-by-as. machine # [ 132.276149] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 132.279234] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 132.283134] systemd[1]: Starting linger-users.service... machine # [ 132.286199] systemd[1]: Starting no-restart-service.service... machine # [ 132.290272] systemd[1]: Starting reload-triggers-and-restart-by-as.service... machine # [ 132.295057] systemd[1]: Starting reload-triggers-and-restart.service... machine # [ 132.297845] systemd[1]: Starting reload-triggers.service... machine # [ 132.304710] systemd[1]: Starting simple-reload-service.service... machine # [ 132.315390] systemd[1]: Starting simple-restart-service.service... machine # [ 132.319522] systemd[1]: Starting simple-service.service... machine # [ 132.325296] systemd[1]: Starting templated-no-restart-service@instance.service... machine # [ 132.331525] systemd[1]: Starting templated-reload-triggers-and-restart-by-as@instance.service... machine # [ 132.336194] systemd[1]: Starting templated-reload-triggers-and-restart@instance.service... machine # [ 132.345860] systemd[1]: Starting templated-reload-triggers@instance.service... machine # [ 132.353810] systemd[1]: Starting templated-simple-reload-service@instance.service... machine # [ 132.363542] systemd[1]: Starting templated-simple-restart-service@instance.service... machine # [ 132.374113] systemd[1]: Starting templated-simple-service@instance.service... machine # [ 132.433076] systemd[1]: Finished reload-triggers-and-restart-by-as.service. machine # [ 132.441181] systemd[1]: Finished no-restart-service.service. machine # [ 132.448314] systemd[1]: Finished reload-triggers-and-restart.service. machine # [ 132.457347] systemd[1]: Finished simple-reload-service.service. machine # [ 132.478422] systemd[1]: Finished reload-triggers.service. machine # [ 132.481121] systemd[1]: Finished simple-restart-service.service. machine # [ 132.498819] systemd[1]: Finished templated-simple-reload-service@instance.service. machine # [ 132.505480] systemd[1]: Finished templated-reload-triggers@instance.service. machine # [ 132.508261] systemd[1]: Finished templated-no-restart-service@instance.service. machine # [ 132.512420] systemd[1]: Finished templated-simple-restart-service@instance.service. machine # [ 132.514319] systemd[1]: Finished templated-simple-service@instance.service. machine # [ 132.516688] systemd[1]: Finished simple-service.service. machine # [ 132.519235] systemd[1]: Finished templated-reload-triggers-and-restart@instance.service. machine # [ 132.523844] systemd[1]: Finished templated-reload-triggers-and-restart-by-as@instance.service. machine # [ 132.541392] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 132.542484] systemd[1]: Finished linger-users.service. machine # [ 132.801634] nixos[6902]: finished switching to system configuration /nix/store/60izimxxc3j6bqfmzq0xgvhzw876p5q9-nixos-system-machine-test machine: (finished: must succeed: /nix/store/yv0fgsc3a9pf40xia3yrhzply67kinx0-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration test 2>&1, in 3.09 seconds) machine: must succeed: /nix/store/yv0fgsc3a9pf40xia3yrhzply67kinx0-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration test 2>&1 machine # [ 133.493813] nixos[7072]: switching to system configuration /nix/store/60izimxxc3j6bqfmzq0xgvhzw876p5q9-nixos-system-machine-test machine # [ 133.496359] systemd[1]: Stopped target Remote File Systems. machine # [ 133.498435] systemd[1]: Stopped target Local File Systems. machine # [ 133.923240] systemd[1]: Reload requested from client PID 7072 ('.switch-to-conf') (unit backdoor.service)... machine # [ 133.925062] systemd[1]: Reloading... machine # [ 134.497411] systemd[1]: Reloading finished in 569 ms. machine # [ 134.612303] systemd[635]: Reexecution requested from client PID 7143 ('switch-to-confi')... machine # [ 134.614922] systemd[635]: Reexecuting. machine # [ 134.642671] systemd[635]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 134.788169] systemd[635]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 134.793645] systemd[635]: Reload requested from client PID 7143 ('switch-to-confi')... machine # [ 134.795298] systemd[635]: Reloading... machine # [ 134.938807] systemd[635]: Reloading finished in 141 ms. machine # [ 134.943843] systemd[635]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 134.950303] systemd[635]: Stopped Run user-specific NixOS activation. machine # [ 134.952064] systemd[635]: Stopping Run user-specific NixOS activation... machine # [ 134.954463] systemd[635]: Starting Run user-specific NixOS activation... machine # [ 134.992127] systemd[635]: Finished Run user-specific NixOS activation. machine # [ 134.995323] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 134.996584] systemd[1]: Stopping Reactivate sysinit units... machine # [ 134.997552] systemd[1]: Reached target Reactivate sysinit units. machine # [ 135.002933] systemd[1]: Reloading reload-triggers-and-restart.service... machine # [ 135.007759] systemd[1]: Reloading reload-triggers.service... machine # [ 135.015391] systemd[1]: Reloading simple-reload-service.service... machine # [ 135.017681] systemd[1]: Reloading templated-reload-triggers-and-restart@instance.service... machine # [ 135.024812] systemd[1]: Reloading templated-reload-triggers@instance.service... machine # [ 135.032131] systemd[1]: Reloading templated-simple-reload-service@instance.service... machine # [ 135.070227] systemd[1]: Reloaded reload-triggers.service. machine # [ 135.074955] systemd[1]: Reloaded reload-triggers-and-restart.service. machine # [ 135.077168] systemd[1]: Reloaded simple-reload-service.service. machine # [ 135.088439] systemd[1]: Reloaded templated-reload-triggers-and-restart@instance.service. machine # [ 135.089571] systemd[1]: Reloaded templated-reload-triggers@instance.service. machine # [ 135.091585] systemd[1]: Reloaded templated-simple-reload-service@instance.service. machine # [ 135.095406] systemd[1]: reload-triggers-and-restart-by-as.service: Deactivated successfully. machine # [ 135.097329] systemd[1]: Stopped reload-triggers-and-restart-by-as.service. machine # [ 135.098275] systemd[1]: Stopping reload-triggers-and-restart-by-as.service... machine # [ 135.102023] systemd[1]: Starting reload-triggers-and-restart-by-as.service... machine # [ 135.103101] systemd[1]: simple-restart-service.service: Deactivated successfully. machine # [ 135.104060] systemd[1]: Stopped simple-restart-service.service. machine # [ 135.104804] systemd[1]: Stopping simple-restart-service.service... machine # [ 135.107204] systemd[1]: Starting simple-restart-service.service... machine # [ 135.109177] systemd[1]: simple-service.service: Deactivated successfully. machine # [ 135.110074] systemd[1]: Stopped simple-service.service. machine # [ 135.110821] systemd[1]: Stopping simple-service.service... machine # [ 135.115118] systemd[1]: Starting simple-service.service... machine # [ 135.119141] systemd[1]: templated-reload-triggers-and-restart-by-as@instance.service: Deactivated successfully. machine # [ 135.120512] systemd[1]: Stopped templated-reload-triggers-and-restart-by-as@instance.service. machine # [ 135.121551] systemd[1]: Stopping templated-reload-triggers-and-restart-by-as@instance.service... machine # [ 135.125694] systemd[1]: Starting templated-reload-triggers-and-restart-by-as@instance.service... machine # [ 135.127159] systemd[1]: templated-simple-restart-service@instance.service: Deactivated successfully. machine # [ 135.128237] systemd[1]: Stopped templated-simple-restart-service@instance.service. machine # [ 135.129176] systemd[1]: Stopping templated-simple-restart-service@instance.service... machine # [ 135.138214] systemd[1]: Starting templated-simple-restart-service@instance.service... machine # [ 135.139539] systemd[1]: templated-simple-service@instance.service: Deactivated successfully. machine # [ 135.142173] systemd[1]: Stopped templated-simple-service@instance.service. machine # [ 135.143381] systemd[1]: Stopping templated-simple-service@instance.service... machine # [ 135.147243] systemd[1]: Starting templated-simple-service@instance.service... machine # [ 135.186903] systemd[1]: Finished simple-restart-service.service. machine # [ 135.189918] systemd[1]: Finished reload-triggers-and-restart-by-as.service. machine # [ 135.193371] systemd[1]: Finished templated-reload-triggers-and-restart-by-as@instance.service. machine # [ 135.199090] systemd[1]: Finished simple-service.service. machine # [ 135.202172] systemd[1]: Finished templated-simple-restart-service@instance.service. machine # [ 135.208683] systemd[1]: Finished templated-simple-service@instance.service. machine # [ 135.214717] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 135.216404] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 135.220248] systemd[1]: Reached target Local File Systems. machine # [ 135.221269] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 135.225517] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 135.226413] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 135.227488] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 135.230586] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 135.232886] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 135.234336] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 135.238618] systemd[1]: Reached target Remote File Systems. machine # [ 135.529397] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 135.530653] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 135.535115] systemd[1]: Starting linger-users.service... machine # [ 135.582894] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 135.584567] systemd[1]: Finished linger-users.service. machine # [ 135.843166] nixos[7072]: finished switching to system configuration /nix/store/60izimxxc3j6bqfmzq0xgvhzw876p5q9-nixos-system-machine-test machine: (finished: must succeed: /nix/store/yv0fgsc3a9pf40xia3yrhzply67kinx0-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration test 2>&1, in 3.04 seconds) machine: must succeed: /nix/store/yv0fgsc3a9pf40xia3yrhzply67kinx0-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script-modified/bin/switch-to-configuration test 2>&1 machine # [ 136.600950] nixos[7238]: switching to system configuration /nix/store/l99cwf372r195snx18zm56vabxyclwkf-nixos-system-machine-test machine # [ 136.603345] systemd[1]: Stopped target Remote File Systems. machine # [ 136.604985] systemd[1]: Stopped target Local File Systems. machine # [ 137.097562] systemd[1]: Reload requested from client PID 7238 ('.switch-to-conf') (unit backdoor.service)... machine # [ 137.099249] systemd[1]: Reloading... machine # [ 137.686391] systemd[1]: Reloading finished in 585 ms. machine # [ 137.810293] systemd[635]: Reexecution requested from client PID 7309 ('switch-to-confi')... machine # [ 137.811579] systemd[635]: Reexecuting. machine # [ 137.838885] systemd[635]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 137.983148] systemd[635]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 137.988194] systemd[635]: Reload requested from client PID 7309 ('switch-to-confi')... machine # [ 137.989388] systemd[635]: Reloading... machine # [ 138.137873] systemd[635]: Reloading finished in 146 ms. machine # [ 138.142850] systemd[635]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 138.150078] systemd[635]: Stopped Run user-specific NixOS activation. machine # [ 138.150933] systemd[635]: Stopping Run user-specific NixOS activation... machine # [ 138.153703] systemd[635]: Starting Run user-specific NixOS activation... machine # [ 138.190647] systemd[635]: Finished Run user-specific NixOS activation. machine # [ 138.193885] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 138.195163] systemd[1]: Stopping Reactivate sysinit units... machine # [ 138.195904] systemd[1]: Reached target Reactivate sysinit units. machine # [ 138.200874] systemd[1]: Reloading reload-triggers.service... machine # [ 138.206275] systemd[1]: Reloading simple-reload-service.service... machine # [ 138.210145] systemd[1]: Reloading templated-reload-triggers@instance.service... machine # [ 138.215959] systemd[1]: Reloading templated-simple-reload-service@instance.service... machine # [ 138.252532] systemd[1]: Reloaded simple-reload-service.service. machine # [ 138.255505] systemd[1]: Reloaded reload-triggers.service. machine # [ 138.259204] systemd[1]: Reloaded templated-simple-reload-service@instance.service. machine # [ 138.261387] systemd[1]: Reloaded templated-reload-triggers@instance.service. machine # [ 138.265225] systemd[1]: reload-triggers-and-restart-by-as.service: Deactivated successfully. machine # [ 138.267341] systemd[1]: Stopped reload-triggers-and-restart-by-as.service. machine # [ 138.268242] systemd[1]: Stopping reload-triggers-and-restart-by-as.service... machine # [ 138.271685] systemd[1]: Starting reload-triggers-and-restart-by-as.service... machine # [ 138.272761] systemd[1]: reload-triggers-and-restart.service: Deactivated successfully. machine # [ 138.273742] systemd[1]: Stopped reload-triggers-and-restart.service. machine # [ 138.274591] systemd[1]: Stopping reload-triggers-and-restart.service... machine # [ 138.276942] systemd[1]: Starting reload-triggers-and-restart.service... machine # [ 138.278952] systemd[1]: simple-restart-service.service: Deactivated successfully. machine # [ 138.282103] systemd[1]: Stopped simple-restart-service.service. machine # [ 138.283267] systemd[1]: Stopping simple-restart-service.service... machine # [ 138.285329] systemd[1]: Starting simple-restart-service.service... machine # [ 138.288115] systemd[1]: simple-service.service: Deactivated successfully. machine # [ 138.289327] systemd[1]: Stopped simple-service.service. machine # [ 138.290181] systemd[1]: Stopping simple-service.service... machine # [ 138.295197] systemd[1]: Starting simple-service.service... machine # [ 138.296926] systemd[1]: templated-reload-triggers-and-restart-by-as@instance.service: Deactivated successfully. machine # [ 138.299186] systemd[1]: Stopped templated-reload-triggers-and-restart-by-as@instance.service. machine # [ 138.302110] systemd[1]: Stopping templated-reload-triggers-and-restart-by-as@instance.service... machine # [ 138.308442] systemd[1]: Starting templated-reload-triggers-and-restart-by-as@instance.service... machine # [ 138.310176] systemd[1]: templated-reload-triggers-and-restart@instance.service: Deactivated successfully. machine # [ 138.312633] systemd[1]: Stopped templated-reload-triggers-and-restart@instance.service. machine # [ 138.316142] systemd[1]: Stopping templated-reload-triggers-and-restart@instance.service... machine # [ 138.319646] systemd[1]: Starting templated-reload-triggers-and-restart@instance.service... machine # [ 138.321787] systemd[1]: templated-simple-restart-service@instance.service: Deactivated successfully. machine # [ 138.323371] systemd[1]: Stopped templated-simple-restart-service@instance.service. machine # [ 138.326982] systemd[1]: Stopping templated-simple-restart-service@instance.service... machine # [ 138.329941] systemd[1]: Starting templated-simple-restart-service@instance.service... machine # [ 138.334685] systemd[1]: templated-simple-service@instance.service: Deactivated successfully. machine # [ 138.339535] systemd[1]: Stopped templated-simple-service@instance.service. machine # [ 138.340746] systemd[1]: Stopping templated-simple-service@instance.service... machine # [ 138.345222] systemd[1]: Starting templated-simple-service@instance.service... machine # [ 138.383344] systemd[1]: Finished reload-triggers-and-restart.service. machine # [ 138.387455] systemd[1]: Finished reload-triggers-and-restart-by-as.service. machine # [ 138.392513] systemd[1]: Finished simple-restart-service.service. machine # [ 138.397115] systemd[1]: Finished simple-service.service. machine # [ 138.400743] systemd[1]: Finished templated-reload-triggers-and-restart-by-as@instance.service. machine # [ 138.406842] systemd[1]: Finished templated-reload-triggers-and-restart@instance.service. machine # [ 138.414923] systemd[1]: Finished templated-simple-restart-service@instance.service. machine # [ 138.416267] systemd[1]: Finished templated-simple-service@instance.service. machine # [ 138.420584] systemd[1]: Reached target Local File Systems. machine # [ 138.423296] systemd[1]: Reached target Remote File Systems. machine # [ 138.425677] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 138.430616] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 138.431543] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 138.433168] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 138.435221] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 138.436653] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 138.437741] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 138.445715] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 138.447684] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 138.736218] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 138.737752] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 138.742406] systemd[1]: Starting linger-users.service... machine # [ 138.788439] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 138.789913] systemd[1]: Finished linger-users.service. machine # [ 139.046664] nixos[7238]: finished switching to system configuration /nix/store/l99cwf372r195snx18zm56vabxyclwkf-nixos-system-machine-test machine: (finished: must succeed: /nix/store/yv0fgsc3a9pf40xia3yrhzply67kinx0-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script-modified/bin/switch-to-configuration test 2>&1, in 3.20 seconds) machine: must succeed: /nix/store/yv0fgsc3a9pf40xia3yrhzply67kinx0-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/yv0fgsc3a9pf40xia3yrhzply67kinx0-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration dry-activate 2>&1, in 0.87 seconds) (finished: subtest: restart and reload by activation script, in 12.65 seconds) (finished: run the VM test script, in 140.84 seconds) test script finished in 140.91s cleanup kill QemuMachine (pid 45) machine # qemu-system-x86_64: terminating on signal 15 from pid 39 (/nix/store/b5bpi6zfajzzrwwpgba2q6li3nnya4bs-python3-3.14.7/bin/python3.14) (finished: cleanup, in 0.18 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