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.01 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.B3JkYDEEvj', 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: 37b065f2-1ea0-4f3e-923b-46305818f754 machine # Superblock backups stored on blocks: machine # 32768, 98304, 163840, 229376 machine # machine # Allocating group tables: 0/8 done machine # Writing inode tables: 0/8 done machine # Creating journal (8192 blocks): done machine # Writing superblocks and filesystem accounting information: 0/8 done machine # machine # Virtualisation disk image created. machine # Starting virtiofs daemons... machine # [2026-10-15T02:51:53Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1) machine # [2026-10-15T02:51:53Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether machine # [2026-10-15T02:51:53Z INFO virtiofsd] Waiting for vhost-user socket connection... machine # [2026-10-15T02:51:53Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1) machine # [2026-10-15T02:51:53Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether machine # [2026-10-15T02:51:53Z INFO virtiofsd] Waiting for vhost-user socket connection... machine # [2026-10-15T02:51:53Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1) machine # [2026-10-15T02:51:53Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether machine # [2026-10-15T02:51:53Z INFO virtiofsd] Waiting for vhost-user socket connection... machine # [2026-10-15T02:51:53Z INFO virtiofsd] Client connected, servicing requests machine # [2026-10-15T02:51:53Z INFO virtiofsd] Client connected, servicing requests machine # [2026-10-15T02:51:53Z INFO virtiofsd] Client connected, servicing requests machine # SeaBIOS (version rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org) machine # machine # machine # iPXE (http://ipxe.org) 00:02.0 CA00 PCI2.10 PnP PMM+3EFCC730+3EF2C730 CA00 machine # Press Ctrl-B to configure iPXE (PCI 00:02.0)... machine # machine # machine # machine # machine # iPXE (http://ipxe.org) 00:05.0 CB00 PCI2.10 PnP PMM 3EFCC730 3EF2C730 CB00 machine # Press Ctrl-B to configure iPXE (PCI 00:05.0)... machine # machine # machine # Booting from ROM... machine # Probing EDD (edd=off to disable)... ok[ 0.000000] Linux version 6.18.55 (nixbld@localhost) (gcc (GCC) 16.2.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT_DYNAMIC Sat Oct 3 10:39:03 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/68vy4glkqv6dl08fwnd37a5r9s71a7b0-nixos-system-machine-test/init regInfo=/nix/.ro-store/ivs1zngcsib7pr39chrqjfya7p1dcl7r-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 497932740 cycles machine # [ 0.000002] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns machine # [ 0.000005] tsc: Detected 2400.008 MHz processor machine # [ 0.000757] last_pfn = 0x3ffd8 max_arch_pfn = 0x10000000000 machine # [ 0.000783] MTRR map: 4 entries (3 fixed + 1 variable; max 19), built from 8 variable MTRRs machine # [ 0.000786] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT machine # [ 0.002678] found SMP MP-table at [mem 0x000f5450-0x000f545f] machine # [ 0.002689] Using GB pages for direct mapping machine # [ 0.002809] RAMDISK: [mem 0x3e2b5000-0x3ffcffff] machine # [ 0.002817] ACPI: Early table checksum verification disabled machine # [ 0.002820] ACPI: RSDP 0x00000000000F5270 000014 (v00 BOCHS ) machine # [ 0.002824] ACPI: RSDT 0x000000003FFE2422 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) machine # [ 0.002827] ACPI: FACP 0x000000003FFE221A 0000F4 (v03 BOCHS BXPC 00000001 BXPC 00000001) machine # [ 0.002834] ACPI: DSDT 0x000000003FFE0040 0021DA (v01 BOCHS BXPC 00000001 BXPC 00000001) machine # [ 0.002836] ACPI: FACS 0x000000003FFE0000 000040 machine # [ 0.002838] ACPI: APIC 0x000000003FFE230E 000078 (v03 BOCHS BXPC 00000001 BXPC 00000001) machine # [ 0.002840] ACPI: HPET 0x000000003FFE2386 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) machine # [ 0.002841] ACPI: MCFG 0x000000003FFE23BE 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001) machine # [ 0.002843] ACPI: WAET 0x000000003FFE23FA 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001) machine # [ 0.002844] ACPI: Reserving FACP table memory at [mem 0x3ffe221a-0x3ffe230d] machine # [ 0.002845] ACPI: Reserving DSDT table memory at [mem 0x3ffe0040-0x3ffe2219] machine # [ 0.002846] ACPI: Reserving FACS table memory at [mem 0x3ffe0000-0x3ffe003f] machine # [ 0.002846] ACPI: Reserving APIC table memory at [mem 0x3ffe230e-0x3ffe2385] machine # [ 0.002847] ACPI: Reserving HPET table memory at [mem 0x3ffe2386-0x3ffe23bd] machine # [ 0.002847] ACPI: Reserving MCFG table memory at [mem 0x3ffe23be-0x3ffe23f9] machine # [ 0.002848] ACPI: Reserving WAET table memory at [mem 0x3ffe23fa-0x3ffe2421] machine # [ 0.003077] No NUMA configuration found machine # [ 0.003078] Faking a node at [mem 0x0000000000000000-0x000000003ffd7fff] machine # [ 0.003080] NODE_DATA(0) allocated [mem 0x3ffd2780-0x3ffd7cff] machine # [ 0.005142] Zone ranges: machine # [ 0.005143] DMA [mem 0x0000000000001000-0x0000000000ffffff] machine # [ 0.005144] DMA32 [mem 0x0000000001000000-0x000000003ffd7fff] machine # [ 0.005146] Normal empty machine # [ 0.005146] Device empty machine # [ 0.005147] Movable zone start for each node machine # [ 0.005148] Early memory node ranges machine # [ 0.005148] node 0: [mem 0x0000000000001000-0x000000000009efff] machine # [ 0.005149] node 0: [mem 0x0000000000100000-0x000000003ffd7fff] machine # [ 0.005150] Initmem setup node 0 [mem 0x0000000000001000-0x000000003ffd7fff] machine # [ 0.005169] On node 0, zone DMA: 1 pages in unavailable ranges machine # [ 0.005413] On node 0, zone DMA: 97 pages in unavailable ranges machine # [ 0.021699] On node 0, zone DMA32: 40 pages in unavailable ranges machine # [ 0.022145] ACPI: PM-Timer IO Port: 0x608 machine # [ 0.022155] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) machine # [ 0.022180] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 machine # [ 0.022183] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) machine # [ 0.022184] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) machine # [ 0.022186] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) machine # [ 0.022186] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) machine # [ 0.022187] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) machine # [ 0.022190] ACPI: Using ACPI (MADT) for SMP configuration information machine # [ 0.022190] ACPI: HPET id: 0x8086a201 base: 0xfed00000 machine # [ 0.022194] TSC deadline timer available machine # [ 0.022197] CPU topo: Max. logical packages: 1 machine # [ 0.022198] CPU topo: Max. logical dies: 1 machine # [ 0.022198] CPU topo: Max. dies per package: 1 machine # [ 0.022202] CPU topo: Max. threads per core: 1 machine # [ 0.022202] CPU topo: Num. cores per package: 1 machine # [ 0.022203] CPU topo: Num. threads per package: 1 machine # [ 0.022203] CPU topo: Allowing 1 present CPUs plus 0 hotplug CPUs machine # [ 0.022220] kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write() machine # [ 0.022249] PM: hibernation: Registered nosave memory: [mem 0x00000000-0x00000fff] machine # [ 0.022251] PM: hibernation: Registered nosave memory: [mem 0x0009f000-0x000fffff] machine # [ 0.022252] [mem 0x40000000-0xafffffff] available for PCI devices machine # [ 0.022253] Booting paravirtualized kernel on KVM machine # [ 0.022255] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns machine # [ 0.026852] setup_percpu: NR_CPUS:384 nr_cpumask_bits:1 nr_cpu_ids:1 nr_node_ids:1 machine # [ 0.028919] percpu: Embedded 98 pages/cpu s278528 r8192 d114688 u2097152 machine # [ 0.028960] kvm-guest: PV spinlocks disabled, single CPU machine # [ 0.028961] 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/68vy4glkqv6dl08fwnd37a5r9s71a7b0-nixos-system-machine-test/init regInfo=/nix/.ro-store/ivs1zngcsib7pr39chrqjfya7p1dcl7r-closure-info/registration console=ttyS0,115200n8 console=tty0 machine # [ 0.029049] Unknown kernel command line parameters "regInfo=/nix/.ro-store/ivs1zngcsib7pr39chrqjfya7p1dcl7r-closure-info/registration", will be passed to user space. machine # [ 0.029062] random: crng init done machine # [ 0.029062] printk: log buffer data + meta data: 262144 + 917504 = 1179648 bytes machine # [ 0.029084] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes, linear) machine # [ 0.029583] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes, linear) machine # [ 0.029613] Fallback order for Node 0: 0 machine # [ 0.029615] Built 1 zonelists, mobility grouping on. Total pages: 262006 machine # [ 0.029615] Policy zone: DMA32 machine # [ 0.031745] mem auto-init: stack:all(zero), heap alloc:on, heap free:off machine # [ 0.034092] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1 machine # [ 0.036167] allocated 2097152 bytes of page_ext machine # [ 0.045552] ftrace: allocating 48837 entries in 192 pages machine # [ 0.045554] ftrace: allocated 192 pages with 2 groups machine # [ 0.046358] Dynamic Preempt: lazy machine # [ 0.046479] rcu: Preemptible hierarchical RCU implementation. machine # [ 0.046480] rcu: RCU event tracing is enabled. machine # [ 0.046481] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1. machine # [ 0.046482] Trampoline variant of Tasks RCU enabled. machine # [ 0.046482] Rude variant of Tasks RCU enabled. machine # [ 0.046482] Tracing variant of Tasks RCU enabled. machine # [ 0.046483] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. machine # [ 0.046484] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1 machine # [ 0.046497] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. machine # [ 0.046499] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. machine # [ 0.046500] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. machine # [ 0.050805] NR_IRQS: 24832, nr_irqs: 256, preallocated irqs: 16 machine # [ 0.051076] rcu: srcu_init: Setting srcu_struct sizes based on contention. machine # [ 0.051082] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns machine # [ 0.051175] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____) machine # [ 0.054670] Console: colour VGA+ 80x25 machine # [ 0.054673] printk: legacy console [tty0] enabled machine # [ 0.084166] printk: legacy console [ttyS0] enabled machine # [ 0.189986] ACPI: Core revision 20250807 machine # [ 0.190895] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns machine # [ 0.192578] APIC: Switch to symmetric I/O mode setup machine # [ 0.193625] x2apic enabled machine # [ 0.194384] APIC: Switched APIC routing to: physical x2apic machine # [ 0.196285] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 machine # [ 0.197333] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x22983f10a64, max_idle_ns: 440795218721 ns machine # [ 0.199090] Calibrating delay loop (skipped) preset value.. 4800.01 BogoMIPS (lpj=2400008) machine # [ 0.201121] x86/cpu: User Mode Instruction Prevention (UMIP) activated machine # [ 0.202203] Last level iTLB entries: 4KB 512, 2MB 255, 4MB 127 machine # [ 0.203087] Last level dTLB entries: 4KB 512, 2MB 255, 4MB 127, 1GB 0 machine # [ 0.204091] mitigations: Enabled attack vectors: user_kernel, user_user, guest_host, guest_guest, SMT mitigations: auto machine # [ 0.205087] Speculative Store Bypass: Mitigation: Speculative Store Bypass disabled via prctl machine # [ 0.206087] Transient Scheduler Attacks: Vulnerable: No microcode machine # [ 0.207086] Spectre V2 : Mitigation: Enhanced / Automatic IBRS machine # [ 0.208087] Speculative Return Stack Overflow: Mitigation: Safe RET machine # [ 0.209086] Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization machine # [ 0.211094] Spectre V2 : Enabling IBPB for BPF machine # [ 0.212088] Spectre V2 : mitigation: Enabling conditional Indirect Branch Prediction Barrier machine # [ 0.213087] active return thunk: srso_alias_return_thunk machine # [ 0.215012] x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers' machine # [ 0.216087] x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers' machine # [ 0.217087] x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers' machine # [ 0.218086] x86/fpu: Supporting XSAVE feature 0x020: 'AVX-512 opmask' machine # [ 0.219087] x86/fpu: Supporting XSAVE feature 0x040: 'AVX-512 Hi256' machine # [ 0.220087] x86/fpu: Supporting XSAVE feature 0x080: 'AVX-512 ZMM_Hi256' machine # [ 0.221087] x86/fpu: Supporting XSAVE feature 0x200: 'Protection Keys User registers' machine # [ 0.223087] x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256 machine # [ 0.224087] x86/fpu: xstate_offset[5]: 832, xstate_sizes[5]: 64 machine # [ 0.225087] x86/fpu: xstate_offset[6]: 896, xstate_sizes[6]: 512 machine # [ 0.226086] x86/fpu: xstate_offset[7]: 1408, xstate_sizes[7]: 1024 machine # [ 0.227086] x86/fpu: xstate_offset[9]: 2432, xstate_sizes[9]: 8 machine # [ 0.228087] x86/fpu: Enabled xstate features 0x2e7, context size is 2440 bytes, using 'compacted' format. machine # [ 0.261801] Freeing SMP alternatives memory: 48K machine # [ 0.262090] pid_max: default: 32768 minimum: 301 machine # [ 0.263185] LSM: initializing lsm=capability,landlock,yama,bpf,ima machine # [ 0.264190] landlock: Up and running. machine # [ 0.265087] Yama: becoming mindful. machine # [ 0.266290] LSM support for eBPF active machine # [ 0.267092] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear) machine # [ 0.268106] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear) machine # [ 0.270678] smpboot: CPU0: AMD EPYC 9654 96-Core Processor (family: 0x19, model: 0x11, stepping: 0x1) machine # [ 0.271646] Performance Events: Fam17h+ core perfctr, AMD PMU driver. machine # [ 0.272092] ... version: 2 machine # [ 0.272842] ... bit width: 48 machine # [ 0.273090] ... generic counters: 6 machine # [ 0.273855] ... generic bitmap: 000000000000003f machine # [ 0.274099] ... fixed-purpose counters: 0 machine # [ 0.274836] ... fixed-purpose bitmap: 0000000000000000 machine # [ 0.275090] ... value mask: 0000ffffffffffff machine # [ 0.276053] ... max period: 00007fffffffffff machine # [ 0.276848] ... global_ctrl mask: 000000000000003f machine # [ 0.277199] signal: max sigframe size: 3376 machine # [ 0.278046] rcu: Hierarchical SRCU implementation. machine # [ 0.278738] rcu: Max phase no-delay instances is 400. machine # [ 0.283582] smp: Bringing up secondary CPUs ... machine # [ 0.284105] smp: Brought up 1 node, 1 CPU machine # [ 0.284817] smpboot: Total of 1 processors activated (4800.01 BogoMIPS) machine # [ 0.285308] Memory: 940308K/1048024K available (18124K kernel code, 2728K rwdata, 13644K rodata, 3656K init, 3632K bss, 100324K reserved, 0K cma-reserved) machine # [ 0.286335] devtmpfs: initialized machine # [ 0.287162] x86/mm: Memory block size: 128MB machine # [ 0.288813] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear) machine # [ 0.290072] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear). machine # [ 0.291183] pinctrl core: initialized pinctrl subsystem machine # [ 0.292336] PM: RTC time: 02:51:53, date: 2026-10-15 machine # [ 0.295756] NET: Registered PF_NETLINK/PF_ROUTE protocol family machine # [ 0.296449] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations machine # [ 0.297105] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations machine # [ 0.298226] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations machine # [ 0.299099] audit: initializing netlink subsys (disabled) machine # [ 0.300285] thermal_sys: Registered thermal governor 'fair_share' machine # [ 0.300288] thermal_sys: Registered thermal governor 'bang_bang' machine # [ 0.301091] thermal_sys: Registered thermal governor 'step_wise' machine # [ 0.302093] audit: type=2000 audit(1792032714.059:1): state=initialized audit_enabled=0 res=1 machine # [ 0.304092] thermal_sys: Registered thermal governor 'user_space' machine # [ 0.304094] thermal_sys: Registered thermal governor 'power_allocator' machine # [ 0.305103] cpuidle: using governor menu machine # [ 0.307387] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 machine # [ 0.308330] PCI: ECAM [mem 0xb0000000-0xbfffffff] (base 0xb0000000) for domain 0000 [bus 00-ff] machine # [ 0.309093] PCI: ECAM [mem 0xb0000000-0xbfffffff] reserved as E820 entry machine # [ 0.310101] PCI: Using configuration type 1 for base access machine # [ 0.311265] kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible. machine # [ 0.318336] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages machine # [ 0.319091] HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page machine # [ 0.324090] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages machine # [ 0.325090] HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page machine # [ 0.333703] ACPI: Added _OSI(Module Device) machine # [ 0.334091] ACPI: Added _OSI(Processor Device) machine # [ 0.334874] ACPI: Added _OSI(Processor Aggregator Device) machine # [ 0.341601] ACPI: 1 ACPI AML tables successfully acquired and loaded machine # [ 0.345036] ACPI: Interpreter enabled machine # [ 0.345589] ACPI: PM: (supports S0 S3 S4 S5) machine # [ 0.346091] ACPI: Using IOAPIC for interrupt routing machine # [ 0.346997] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug machine # [ 0.352090] PCI: Using E820 reservations for host bridge windows machine # [ 0.353225] ACPI: Enabled 2 GPEs in block 00 to 3F machine # [ 0.361064] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) machine # [ 0.361935] acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] machine # [ 0.363167] acpi PNP0A08:00: _OSC: platform does not support [PCIeHotplug LTR] machine # [ 0.364217] acpi PNP0A08:00: _OSC: OS now controls [PME AER PCIeCapability] machine # [ 0.365441] PCI host bridge to bus 0000:00 machine # [ 0.366094] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] machine # [ 0.367090] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] machine # [ 0.368090] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] machine # [ 0.369089] pci_bus 0000:00: root bus resource [mem 0x40000000-0xafffffff window] machine # [ 0.370089] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window] machine # [ 0.371090] pci_bus 0000:00: root bus resource [mem 0x100000000-0x8ffffffff window] machine # [ 0.372099] pci_bus 0000:00: root bus resource [bus 00-ff] machine # [ 0.373180] pci 0000:00:00.0: [8086:29c0] type 00 class 0x060000 conventional PCI endpoint machine # [ 0.374557] pci 0000:00:01.0: [1234:1111] type 00 class 0x030000 conventional PCI endpoint machine # [ 0.377086] pci 0000:00:01.0: BAR 0 [mem 0xfd000000-0xfdffffff pref] machine # [ 0.378184] pci 0000:00:01.0: BAR 2 [mem 0xfebd0000-0xfebd0fff] machine # [ 0.379118] pci 0000:00:01.0: ROM [mem 0xfebc0000-0xfebcffff pref] machine # [ 0.380462] pci 0000:00:01.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff] machine # [ 0.381955] pci 0000:00:02.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint machine # [ 0.385131] pci 0000:00:02.0: BAR 0 [io 0xc100-0xc11f] machine # [ 0.386053] pci 0000:00:02.0: BAR 1 [mem 0xfebd1000-0xfebd1fff] machine # [ 0.386917] pci 0000:00:02.0: BAR 4 [mem 0xfe000000-0xfe003fff 64bit pref] machine # [ 0.388059] pci 0000:00:02.0: ROM [mem 0xfeb40000-0xfeb7ffff pref] machine # [ 0.389547] pci 0000:00:03.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint machine # [ 0.392216] pci 0000:00:03.0: BAR 0 [io 0xc120-0xc13f] machine # [ 0.393840] pci 0000:00:03.0: BAR 1 [mem 0xfebd2000-0xfebd2fff] machine # [ 0.394117] pci 0000:00:03.0: BAR 4 [mem 0xfe004000-0xfe007fff 64bit pref] machine # [ 0.395683] pci 0000:00:04.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint machine # [ 0.398081] pci 0000:00:04.0: BAR 0 [io 0xc000-0xc07f] machine # [ 0.399058] pci 0000:00:04.0: BAR 1 [mem 0xfebd3000-0xfebd3fff] machine # [ 0.399943] pci 0000:00:04.0: BAR 4 [mem 0xfe008000-0xfe00bfff 64bit pref] machine # [ 0.401686] pci 0000:00:05.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint machine # [ 0.403128] pci 0000:00:05.0: BAR 0 [io 0xc140-0xc15f] machine # [ 0.404091] pci 0000:00:05.0: BAR 1 [mem 0xfebd4000-0xfebd4fff] machine # [ 0.405117] pci 0000:00:05.0: BAR 4 [mem 0xfe00c000-0xfe00ffff 64bit pref] machine # [ 0.406099] pci 0000:00:05.0: ROM [mem 0xfeb80000-0xfebbffff pref] machine # [ 0.407681] pci 0000:00:06.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint machine # [ 0.409103] pci 0000:00:06.0: BAR 1 [mem 0xfebd5000-0xfebd5fff] machine # [ 0.410118] pci 0000:00:06.0: BAR 4 [mem 0xfe010000-0xfe013fff 64bit pref] machine # [ 0.411701] pci 0000:00:07.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint machine # [ 0.413134] pci 0000:00:07.0: BAR 1 [mem 0xfebd6000-0xfebd6fff] machine # [ 0.414117] pci 0000:00:07.0: BAR 4 [mem 0xfe014000-0xfe017fff 64bit pref] machine # [ 0.416345] pci 0000:00:08.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint machine # [ 0.418103] pci 0000:00:08.0: BAR 1 [mem 0xfebd7000-0xfebd7fff] machine # [ 0.419118] pci 0000:00:08.0: BAR 4 [mem 0xfe018000-0xfe01bfff 64bit pref] machine # [ 0.420681] pci 0000:00:09.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint machine # [ 0.422132] pci 0000:00:09.0: BAR 1 [mem 0xfebd8000-0xfebd8fff] machine # [ 0.423117] pci 0000:00:09.0: BAR 4 [mem 0xfe01c000-0xfe01ffff 64bit pref] machine # [ 0.424646] pci 0000:00:0a.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint machine # [ 0.426715] pci 0000:00:0a.0: BAR 0 [io 0xc080-0xc0bf] machine # [ 0.427100] pci 0000:00:0a.0: BAR 1 [mem 0xfebd9000-0xfebd9fff] machine # [ 0.428117] pci 0000:00:0a.0: BAR 4 [mem 0xfe020000-0xfe023fff 64bit pref] machine # [ 0.429672] pci 0000:00:0b.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint machine # [ 0.432128] pci 0000:00:0b.0: BAR 0 [io 0xc160-0xc17f] machine # [ 0.433091] pci 0000:00:0b.0: BAR 1 [mem 0xfebda000-0xfebdafff] machine # [ 0.434117] pci 0000:00:0b.0: BAR 4 [mem 0xfe024000-0xfe027fff 64bit pref] machine # [ 0.435707] pci 0000:00:1d.0: [8086:2934] type 00 class 0x0c0300 conventional PCI endpoint machine # [ 0.436787] pci 0000:00:1d.0: BAR 4 [io 0xc180-0xc19f] machine # [ 0.437301] pci 0000:00:1d.1: [8086:2935] type 00 class 0x0c0300 conventional PCI endpoint machine # [ 0.439430] pci 0000:00:1d.1: BAR 4 [io 0xc1a0-0xc1bf] machine # [ 0.440302] pci 0000:00:1d.2: [8086:2936] type 00 class 0x0c0300 conventional PCI endpoint machine # [ 0.441834] pci 0000:00:1d.2: BAR 4 [io 0xc1c0-0xc1df] machine # [ 0.442383] pci 0000:00:1d.7: [8086:293a] type 00 class 0x0c0320 conventional PCI endpoint machine # [ 0.444770] pci 0000:00:1d.7: BAR 0 [mem 0xfebdb000-0xfebdbfff] machine # [ 0.445355] pci 0000:00:1f.0: [8086:2918] type 00 class 0x060100 conventional PCI endpoint machine # [ 0.446427] pci 0000:00:1f.0: quirk: [io 0x0600-0x067f] claimed by ICH6 ACPI/GPIO/TCO machine # [ 0.447363] pci 0000:00:1f.2: [8086:2922] type 00 class 0x010601 conventional PCI endpoint machine # [ 0.449160] pci 0000:00:1f.2: BAR 4 [io 0xc1e0-0xc1ff] machine # [ 0.450100] pci 0000:00:1f.2: BAR 5 [mem 0xfebdc000-0xfebdcfff] machine # [ 0.451421] pci 0000:00:1f.3: [8086:2930] type 00 class 0x0c0500 conventional PCI endpoint machine # [ 0.452734] pci 0000:00:1f.3: BAR 4 [io 0x0700-0x073f] machine # [ 0.456191] ACPI: PCI: Interrupt link LNKA configured for IRQ 10 machine # [ 0.457219] ACPI: PCI: Interrupt link LNKB configured for IRQ 10 machine # [ 0.458208] ACPI: PCI: Interrupt link LNKC configured for IRQ 11 machine # [ 0.459230] ACPI: PCI: Interrupt link LNKD configured for IRQ 11 machine # [ 0.460206] ACPI: PCI: Interrupt link LNKE configured for IRQ 10 machine # [ 0.461203] ACPI: PCI: Interrupt link LNKF configured for IRQ 10 machine # [ 0.462215] ACPI: PCI: Interrupt link LNKG configured for IRQ 11 machine # [ 0.463256] ACPI: PCI: Interrupt link LNKH configured for IRQ 11 machine # [ 0.464139] ACPI: PCI: Interrupt link GSIA configured for IRQ 16 machine # [ 0.465113] ACPI: PCI: Interrupt link GSIB configured for IRQ 17 machine # [ 0.466108] ACPI: PCI: Interrupt link GSIC configured for IRQ 18 machine # [ 0.467112] ACPI: PCI: Interrupt link GSID configured for IRQ 19 machine # [ 0.468109] ACPI: PCI: Interrupt link GSIE configured for IRQ 20 machine # [ 0.469112] ACPI: PCI: Interrupt link GSIF configured for IRQ 21 machine # [ 0.470113] ACPI: PCI: Interrupt link GSIG configured for IRQ 22 machine # [ 0.471108] ACPI: PCI: Interrupt link GSIH configured for IRQ 23 machine # [ 0.473165] iommu: Default domain type: Translated machine # [ 0.474027] iommu: DMA domain TLB invalidation policy: lazy mode machine # [ 0.475194] ACPI: bus type USB registered machine # [ 0.476048] usbcore: registered new interface driver usbfs machine # [ 0.476882] usbcore: registered new interface driver hub machine # [ 0.477850] usbcore: registered new device driver usb machine # [ 0.479739] NetLabel: Initializing machine # [ 0.480092] NetLabel: domain hash size = 128 machine # [ 0.480929] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO machine # [ 0.481946] NetLabel: unlabeled traffic allowed by default machine # [ 0.482922] PCI: Using ACPI for IRQ routing machine # [ 0.527753] pci 0000:00:01.0: vgaarb: setting as boot VGA device machine # [ 0.528086] pci 0000:00:01.0: vgaarb: bridge control possible machine # [ 0.528086] pci 0000:00:01.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none machine # [ 0.528104] vgaarb: loaded machine # [ 0.528922] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 machine # [ 0.529791] hpet0: 3 comparators, 64-bit 100.000000 MHz counter machine # [ 0.534187] clocksource: Switched to clocksource kvm-clock machine # [ 0.535929] VFS: Disk quotas dquot_6.6.0 machine # [ 0.538444] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) machine # [ 0.539987] pnp: PnP ACPI init machine # [ 0.540872] ACPI: IRQ 4 override to edge(!), high(!) machine # [ 0.541980] system 00:04: [mem 0xb0000000-0xbfffffff window] has been reserved machine # [ 0.543757] pnp: PnP ACPI: found 5 devices machine # [ 0.551383] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns machine # [ 0.552985] clocksource: Switched to clocksource acpi_pm machine # [ 0.554103] NET: Registered PF_INET protocol family machine # [ 0.555205] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear) machine # [ 0.572370] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear) machine # [ 0.574142] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) machine # [ 0.575624] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear) machine # [ 0.577065] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear) machine # [ 0.578413] TCP: Hash tables configured (established 8192 bind 8192) machine # [ 0.579647] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear) machine # [ 0.581056] UDP hash table entries: 512 (order: 3, 32768 bytes, linear) machine # [ 0.582294] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear) machine # [ 0.583642] NET: Registered PF_UNIX/PF_LOCAL protocol family machine # [ 0.584740] NET: Registered PF_XDP protocol family machine # [ 0.585687] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] machine # [ 0.586814] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] machine # [ 0.587935] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] machine # [ 0.589187] pci_bus 0000:00: resource 7 [mem 0x40000000-0xafffffff window] machine # [ 0.590404] pci_bus 0000:00: resource 8 [mem 0xc0000000-0xfebfffff window] machine # [ 0.591636] pci_bus 0000:00: resource 9 [mem 0x100000000-0x8ffffffff window] machine # [ 0.593526] ACPI: \_SB_.GSIA: Enabled at IRQ 16 machine # [ 0.595842] ACPI: \_SB_.GSIB: Enabled at IRQ 17 machine # [ 0.598297] ACPI: \_SB_.GSIC: Enabled at IRQ 18 machine # [ 0.600407] ACPI: \_SB_.GSID: Enabled at IRQ 19 machine # [ 0.602235] PCI: CLS 0 bytes, default 64 machine # [ 0.603268] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x22983f10a64, max_idle_ns: 440795218721 ns machine # [ 0.605155] Trying to unpack rootfs image as initramfs... machine # [ 0.650432] Initialise system trusted keyrings machine # [ 0.654077] workingset: timestamp_bits=40 max_order=18 bucket_order=0 machine # [ 0.674124] Key type asymmetric registered machine # [ 0.674903] Asymmetric key parser 'x509' registered machine # [ 0.678069] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 248) machine # [ 0.682078] io scheduler mq-deadline registered machine # [ 0.682905] io scheduler kyber registered machine # [ 0.686560] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled machine # [ 0.687946] 00:03: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A machine # [ 0.691835] Linux agpgart interface v0.103 machine # [ 0.692700] ACPI: bus type drm_connector registered machine # [ 0.698154] usbcore: registered new interface driver usbserial_generic machine # [ 0.699383] usbserial: USB Serial support registered for generic machine # [ 0.703041] amd_pstate: The CPPC feature is supported but currently disabled by the BIOS. machine # [ 0.703041] Please enable it if your BIOS has the CPPC option. machine # [ 0.705500] amd_pstate: the _CPC object is not present in SBIOS or ACPI disabled machine # [ 0.709160] drop_monitor: Initializing network drop monitor service machine # [ 0.710461] NET: Registered PF_INET6 protocol family machine # [ 0.713460] Segment Routing with IPv6 machine # [ 0.716050] In-situ OAM (IOAM) with IPv6 machine # [ 0.717213] IPI shorthand broadcast: enabled machine # [ 0.725412] sched_clock: Marking stable (582014727, 143003725)->(802409091, -77390639) machine # [ 0.731125] registered taskstats version 1 machine # [ 0.732164] Loading compiled-in X.509 certificates machine # [ 0.748471] Demotion targets for Node 0: null machine # [ 0.752077] Key type .fscrypt registered machine # [ 0.752802] Key type fscrypt-provisioning registered machine # [ 0.753887] ima: No TPM chip found, activating TPM-bypass! machine # [ 0.758036] ima: Allocated hash algorithm: sha1 machine # [ 0.758896] ima: No architecture policies found machine # [ 0.759960] PM: Magic number: 14:699:864 machine # [ 0.763698] RAS: Correctable Errors collector initialized. machine # [ 0.772610] clk: Disabling unused clocks machine # [ 0.776045] PM: genpd: Disabling unused power domains machine # [ 0.932327] Freeing initrd memory: 29804K machine # [ 0.935687] Freeing unused decrypted memory: 2028K machine # [ 0.938440] Freeing unused kernel image (initmem) memory: 3656K machine # [ 0.939644] Write protecting the kernel read-only data: 32768k machine # [ 0.941071] Freeing unused kernel image (text/rodata gap) memory: 304K machine # [ 0.942670] Freeing unused kernel image (rodata/data gap) memory: 692K machine # [ 0.993650] x86/mm: Checked W+X mappings: passed, no W+X pages found. machine # [ 0.994867] Run /init as init process machine # [ 1.005582] systemd[1]: Inserted module 'autofs4' machine # [ 1.025554] fuse: init (API version 7.45) machine # [ 1.033051] ACPI: \_SB_.GSIG: Enabled at IRQ 22 machine # [ 1.035538] ACPI: \_SB_.GSIH: Enabled at IRQ 23 machine # [ 1.038642] ACPI: \_SB_.GSIE: Enabled at IRQ 20 machine # [ 1.040719] ACPI: \_SB_.GSIF: Enabled at IRQ 21 machine # [ 1.045721] virtiofs virtio5: discovered new tag: nix-store machine # [ 1.047430] virtiofs virtio5: virtio_fs_setup_dax: No cache capability machine # [ 1.054381] virtiofs virtio6: discovered new tag: shared machine # [ 1.056142] virtiofs virtio6: virtio_fs_setup_dax: No cache capability machine # [ 1.059453] virtiofs virtio7: discovered new tag: xchg machine # [ 1.061063] virtiofs virtio7: virtio_fs_setup_dax: No cache capability machine # [ 1.080690] systemd[1]: Successfully made /usr/ read-only. machine # [ 1.082538] systemd[1]: systemd 263-7f073ff running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE +EXPERIMENTAL-ENVVAR) machine # [ 1.088254] systemd[1]: Detected virtualization kvm. machine # [ 1.089210] systemd[1]: Detected architecture x86-64. machine # [ 1.090158] systemd[1]: Running in initrd. machine # [ 1.091238] systemd[1]: Initializing machine ID from random generator. machine # [ 1.092536] systemd[1]: Hostname set to . machine # [ 1.161687] systemd[1]: bpf-restrict-fs: LSM BPF program attached machine # [ 1.197160] systemd[1]: Queued start job for default target Initrd Default Target. machine # [ 1.200255] systemd[1]: Created slice Slice /system/modprobe. machine # [ 1.201455] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. machine # [ 1.202899] systemd[1]: Expecting device /dev/disk/by-label/nixos... machine # [ 1.204066] systemd[1]: Reached target Path Units. machine # [ 1.204943] systemd[1]: Reached target Slice Units. machine # [ 1.205851] systemd[1]: Reached target Swaps. machine # [ 1.206698] systemd[1]: Reached target Timer Units. machine # [ 1.207720] systemd[1]: Listening on D-Bus System Message Bus Socket. machine # [ 1.208994] systemd[1]: Listening on Journal Socket (/dev/log). machine # [ 1.210163] systemd[1]: Listening on Journal Sockets. machine # [ 1.211198] systemd[1]: Listening on udev Kernel Socket. machine # [ 1.212168] systemd[1]: Reached target Socket Units. machine # [ 1.213892] systemd[1]: Starting Create List of Static Device Nodes... machine # [ 1.217826] systemd[1]: Starting Load Kernel Module configfs... machine # [ 1.224641] systemd[1]: Starting Journal Service... machine # [ 1.235764] systemd[1]: Starting Load Kernel Modules... machine # [ 1.251913] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 1.260219] systemd[1]: Starting Coldplug All udev Devices... machine # [ 1.273254] systemd[1]: Finished Create List of Static Device Nodes. machine # [ 1.278713] systemd[1]: modprobe@configfs.service: Deactivated successfully. machine # [ 1.285698] systemd-journald[65]: Collecting audit messages is disabled. machine # [ 1.288514] systemd[1]: Finished Load Kernel Module configfs. machine # [ 1.290504] systemd[1]: Kernel Configuration File System skipped, unmet condition check ConditionPathExists=/sys/kernel/config machine # [ 1.304086] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... machine # [ 1.308654] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. machine # [ 1.318051] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev machine # [ 1.348109] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. machine # [ 1.355090] systemd[1]: Starting Create Static Device Nodes in /dev... machine # [ 1.365544] systemd[1]: Finished Load Kernel Modules. machine # [ 1.373275] systemd[1]: Starting Apply Kernel Variables... machine # [ 1.392568] systemd[1]: Finished Create Static Device Nodes in /dev. machine # [ 1.398236] systemd[1]: Reached target Preparation for Local File Systems. machine # [ 1.260172] systemd-modules-load[66]: Inserted module 'dm_mod' machine # [ 1.261602] systemd-modules-load[66]: Inserted module 'virtio_balloon' machine # [ 1.405471] systemd[1]: Reached target Local File Systems. machine # [ 1.264311] systemd-modules-load[66]: Inserted module 'virtio_gpu' machine # [ 1.412250] systemd[1]: Starting Rule-based Manager for Device Events and Files... machine # [ 1.419337] systemd[1]: Started Journal Service. machine # [ 1.280974] systemd[1]: Finished Apply Kernel Variables. machine # [ 1.291878] systemd[1]: Starting Create System Files and Directories... machine # [ 1.323413] systemd[1]: Finished Create System Files and Directories. machine # [ 1.329425] systemd-udevd[73]: Using default interface naming scheme 'v261'. machine # [ 1.354069] systemd[1]: Started Rule-based Manager for Device Events and Files. machine # [ 1.408736] systemd[1]: Finished Coldplug All udev Devices. machine # [ 1.409637] systemd[1]: Reached target System Initialization. machine # [ 1.410573] systemd[1]: Reached target Basic System. machine # [ 1.702109] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 machine # [ 1.704610] virtio_blk virtio2: 1/0/0 default/read/poll queues machine # [ 1.711865] serio: i8042 KBD port at 0x60,0x64 irq 1 machine # [ 1.712596] serio: i8042 AUX port at 0x60,0x64 irq 12 machine # [ 1.715834] virtio_blk virtio2: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) machine # [ 1.732676] uhci_hcd 0000:00:1d.0: UHCI Host Controller machine # [ 1.741764] uhci_hcd 0000:00:1d.0: new USB bus registered, assigned bus number 1 machine # [ 1.745205] uhci_hcd 0000:00:1d.0: detected 2 ports machine # [ 1.745967] uhci_hcd 0000:00:1d.0: irq 16, io port 0x0000c180 machine # [ 1.752099] usb usb1: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.18 machine # [ 1.753243] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 machine # [ 1.760982] usb usb1: Product: UHCI Host Controller machine # [ 1.764192] usb usb1: Manufacturer: Linux 6.18.55 uhci_hcd machine # [ 1.764940] usb usb1: SerialNumber: 0000:00:1d.0 machine # [ 1.769256] hub 1-0:1.0: USB hub found machine # [ 1.770713] hub 1-0:1.0: 2 ports detected machine # [ 1.776336] ehci-pci 0000:00:1d.7: EHCI Host Controller machine # [ 1.777168] ehci-pci 0000:00:1d.7: new USB bus registered, assigned bus number 2 machine # [ 1.778893] ehci-pci 0000:00:1d.7: irq 19, io mem 0xfebdb000 machine # [ 1.784170] SCSI subsystem initialized machine # [ 1.786063] ehci-pci 0000:00:1d.7: USB 2.0 started, EHCI 1.00 machine # [ 1.788084] usb usb2: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 6.18 machine # [ 1.789170] usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=1 machine # [ 1.793498] usb usb2: Product: EHCI Host Controller machine # [ 1.795032] usb usb2: Manufacturer: Linux 6.18.55 ehci_hcd machine # [ 1.795751] usb usb2: SerialNumber: 0000:00:1d.7 machine # [ 1.656091] systemd[1]: Starting Virtual Console Setup... machine # [ 1.801159] hub 2-0:1.0: USB hub found machine # [ 1.801924] hub 2-0:1.0: 6 ports detected machine # [ 1.679747] systemd-vconsole-setup[97]: Configuration of first virtual console was skipped, ignoring remaining ones. machine # [ 1.682212] systemd[1]: Finished Virtual Console Setup. machine # [ 1.826128] hub 1-0:1.0: USB hub found machine # [ 1.826720] hub 1-0:1.0: 2 ports detected machine # [ 1.828454] uhci_hcd 0000:00:1d.1: UHCI Host Controller machine # [ 1.834727] uhci_hcd 0000:00:1d.1: new USB bus registered, assigned bus number 3 machine # [ 1.836181] uhci_hcd 0000:00:1d.1: detected 2 ports machine # [ 1.836934] uhci_hcd 0000:00:1d.1: irq 17, io port 0x0000c1a0 machine # [ 1.843019] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input0 machine # [ 1.708175] (udev-worker)[84]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. machine # [ 1.710390] (udev-worker)[84]: Network interface NamePolicy= disabled on kernel command line. machine # [ 1.856076] usb usb3: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.18 machine # [ 1.857214] usb usb3: New USB device strings: Mfr=3, Product=2, SerialNumber=1 machine # [ 1.869436] usb usb3: Product: UHCI Host Controller machine # [ 1.874044] usb usb3: Manufacturer: Linux 6.18.55 uhci_hcd machine # [ 1.874794] usb usb3: SerialNumber: 0000:00:1d.1 machine # [ 1.739791] systemd[1]: Found device /dev/disk/by-label/nixos. machine # [ 1.741648] systemd[1]: Reached target Initrd Root Device. machine # [ 1.747098] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos... machine # [ 1.893131] hub 3-0:1.0: USB hub found machine # [ 1.894067] hub 3-0:1.0: 2 ports detected machine # [ 1.899186] uhci_hcd 0000:00:1d.2: UHCI Host Controller machine # [ 1.899928] uhci_hcd 0000:00:1d.2: new USB bus registered, assigned bus number 4 machine # [ 1.906064] uhci_hcd 0000:00:1d.2: detected 2 ports machine # [ 1.906860] uhci_hcd 0000:00:1d.2: irq 18, io port 0x0000c1c0 machine # [ 1.911096] usb usb4: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.18 machine # [ 1.912243] usb usb4: New USB device strings: Mfr=3, Product=2, SerialNumber=1 machine # [ 1.917072] usb usb4: Product: UHCI Host Controller machine # [ 1.917814] usb usb4: Manufacturer: Linux 6.18.55 uhci_hcd machine # [ 1.921060] usb usb4: SerialNumber: 0000:00:1d.2 machine # [ 1.922633] hub 4-0:1.0: USB hub found machine # [ 1.924070] hub 4-0:1.0: 2 ports detected machine # [ 1.790108] systemd-fsck[106]: nixos: clean, 12/65536 files, 13019/262144 blocks machine # [ 1.795125] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos. machine # [ 1.971415] ahci 0000:00:1f.2: AHCI vers 0001.0000, 32 command slots, 1.5 Gbps, SATA mode machine # [ 1.976304] ahci 0000:00:1f.2: 6/6 ports implemented (port mask 0x3f) machine # [ 1.978307] ahci 0000:00:1f.2: flags: 64bit ncq only machine # [ 1.980992] scsi host0: ahci machine # [ 1.982551] scsi host1: ahci machine # [ 1.983651] scsi host2: ahci machine # [ 1.985146] scsi host3: ahci machine # [ 1.986547] scsi host4: ahci machine # [ 1.987769] scsi host5: ahci machine # [ 1.988775] ata1: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc100 irq 47 lpm-pol 1 machine # [ 1.990324] ata2: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc180 irq 47 lpm-pol 1 machine # [ 1.991517] ata3: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc200 irq 47 lpm-pol 1 machine # [ 1.992899] ata4: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc280 irq 47 lpm-pol 1 machine # [ 1.994205] ata5: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc300 irq 47 lpm-pol 1 machine # [ 1.995425] ata6: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc380 irq 47 lpm-pol 1 machine # [ 2.043102] usb 2-1: new high-speed USB device number 2 using ehci-pci machine # [ 2.172617] usb 2-1: New USB device found, idVendor=0627, idProduct=0001, bcdDevice= 0.00 machine # [ 2.175508] usb 2-1: New USB device strings: Mfr=1, Product=3, SerialNumber=10 machine # [ 2.178630] usb 2-1: Product: QEMU USB Tablet machine # [ 2.180431] usb 2-1: Manufacturer: QEMU machine # [ 2.182099] usb 2-1: SerialNumber: 28754-0000:00:1d.7-1 machine # [ 2.217369] hid: raw HID events driver (C) Jiri Kosina machine # [ 2.129496] systemd[1]: Mounting /sysroot... machine # [ 2.306223] ata5: SATA link down (SStatus 0 SControl 300) machine # [ 2.307940] ata6: SATA link down (SStatus 0 SControl 300) machine # [ 2.309666] ata2: SATA link down (SStatus 0 SControl 300) machine # [ 2.311393] ata1: SATA link down (SStatus 0 SControl 300) machine # [ 2.313120] ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 300) machine # [ 2.314894] ata3.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/100 machine # [ 2.319045] ata3.00: applying bridge limits machine # [ 2.323209] ata3.00: configured for UDMA/100 machine # [ 2.324770] ata4: SATA link down (SStatus 0 SControl 300) machine # [ 2.326850] scsi 2:0:0:0: CD-ROM QEMU QEMU DVD-ROM 2.5+ PQ: 0 ANSI: 5 machine # [ 2.381224] usbcore: registered new interface driver usbhid machine # [ 2.381978] usbhid: USB HID core driver machine # [ 2.393745] input: QEMU QEMU USB Tablet as /devices/pci0000:00/0000:00:1d.7/usb2/2-1/2-1:1.0/0003:0627:0001.0001/input/input2 machine # [ 2.397226] sr 2:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray machine # [ 2.401080] 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.411026] cdrom: Uniform CD-ROM driver Revision: 3.20 machine # [ 2.446978] EXT4-fs (vda): mounted filesystem 37b065f2-1ea0-4f3e-923b-46305818f754 r/w with ordered data mode. Quota mode: none. machine # [ 2.307509] systemd[1]: Mounted /sysroot. machine # [ 2.308664] systemd[1]: Reached target Initrd Root File System. machine # [ 2.311573] systemd[1]: Mounting /sysroot/nix/.ro-store... machine # [ 2.315132] systemd[1]: Mounting /sysroot/nix/.rw-store... machine # [ 2.324294] systemd[1]: Mounting /sysroot/run... machine # [ 2.333549] systemd[1]: Mounting /sysroot/tmp/shared... machine # [ 2.338153] systemd[1]: Mounting /sysroot/tmp/xchg... machine # [ 2.347363] systemd[1]: Starting Mountpoints Configured in the Real Root... machine # [ 2.378178] systemd[1]: Mounted /sysroot/nix/.rw-store. machine # [ 2.379383] systemd[1]: Mounted /sysroot/nix/.ro-store. machine # [ 2.381875] systemd-sysroot-fstab-check[144]: /sysroot should be mounted in the initrd, will request daemon-reload. machine # [ 2.385548] systemd[1]: Mounted /sysroot/run. machine # [ 2.389276] systemd[1]: Mounted /sysroot/tmp/shared. machine # [ 2.391610] systemd[1]: Mounted /sysroot/tmp/xchg. machine # [ 2.397129] systemd[1]: Starting rw-sysroot-nix-store.service... machine # [ 2.398304] systemd[1]: Reload requested from client PID 144 ('systemd-sysroot') (unit initrd-parse-etc.service)... machine # [ 2.400121] systemd[1]: Reloading... machine # [ 2.461262] systemd[1]: Reloading finished in 61 ms. machine # [ 2.470129] systemd-sysroot-fstab-check[144]: Requesting initrd-fs.target/start/replace... machine # [ 2.472591] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. machine # [ 2.473724] systemd[1]: Finished rw-sysroot-nix-store.service. machine # [ 2.475811] systemd-sysroot-fstab-check[144]: Requesting swap.target/start/replace... machine # [ 2.478596] systemd[1]: initrd-parse-etc.service: Deactivated successfully. machine # [ 2.479976] systemd[1]: Finished Mountpoints Configured in the Real Root. machine # [ 2.481141] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies. machine # [ 2.484604] systemd[1]: Starting rw-sysroot-nix-store.service... machine # [ 2.495468] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. machine # [ 2.496921] systemd[1]: Finished rw-sysroot-nix-store.service. machine # [ 3.130066] systemd[1]: Mounting /sysroot/nix/store... machine # [ 3.176780] systemd[1]: Mounted /sysroot/nix/store. machine # [ 3.180134] systemd[1]: Reached target Initrd File Systems. machine # [ 3.182774] systemd[1]: Starting Find NixOS closure... machine # [ 3.188672] systemd[1]: Starting Create Volatile Files and Directories in the Real Root... machine # [ 3.216055] systemd[1]: Finished Create Volatile Files and Directories in the Real Root. machine # [ 3.217239] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully. machine # [ 3.224453] systemd[1]: Finished Find NixOS closure. machine # [ 3.226167] systemd[1]: Reached target Initrd Default Target. machine # [ 3.227407] systemd[1]: Starting Cleaning Up and Shutting Down Daemons... machine # [ 3.241227] systemd[1]: Stopped target Initrd Default Target. machine # [ 3.242036] systemd[1]: Stopped target Basic System. machine # [ 3.242769] systemd[1]: Stopped target Initrd Root Device. machine # [ 3.243646] systemd[1]: Stopped target Path Units. machine # [ 3.244350] systemd[1]: systemd-ask-password-console.path: Deactivated successfully. machine # [ 3.245334] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch. machine # [ 3.246615] systemd[1]: Stopped target Slice Units. machine # [ 3.247562] systemd[1]: Stopped target Socket Units. machine # [ 3.249139] systemd[1]: Stopped target System Initialization. machine # [ 3.249965] systemd[1]: Stopped target Swaps. machine # [ 3.250737] systemd[1]: Stopped target Timer Units. machine # [ 3.251511] systemd[1]: dbus.socket: Deactivated successfully. machine # [ 3.253035] systemd[1]: Closed D-Bus System Message Bus Socket. machine # [ 3.253879] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully. machine # [ 3.254966] systemd[1]: Stopped Find NixOS closure. machine # [ 3.256055] systemd[1]: Starting rw-sysroot-nix-store.service... machine # [ 3.257160] systemd[1]: systemd-sysctl.service: Deactivated successfully. machine # [ 3.258251] systemd[1]: Stopped Apply Kernel Variables. machine # [ 3.260226] systemd[1]: systemd-modules-load.service: Deactivated successfully. machine # [ 3.261463] systemd[1]: Stopped Load Kernel Modules. machine # [ 3.262956] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully. machine # [ 3.264177] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root. machine # [ 3.265699] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. machine # [ 3.267043] systemd[1]: Stopped Create System Files and Directories. machine # [ 3.267937] systemd[1]: Stopped target Local File Systems. machine # [ 3.270134] systemd[1]: Stopped target Preparation for Local File Systems. machine # [ 3.271103] systemd[1]: systemd-udev-trigger.service: Deactivated successfully. machine # [ 3.272134] systemd[1]: Stopped Coldplug All udev Devices. machine # [ 3.274326] systemd[1]: Stopping Rule-based Manager for Device Events and Files... machine # [ 3.275438] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. machine # [ 3.278269] systemd[1]: Stopped Virtual Console Setup. machine # [ 3.286142] systemd[1]: systemd-udevd.service: Deactivated successfully. machine # [ 3.288859] systemd[1]: Stopped Rule-based Manager for Device Events and Files. machine # [ 3.289866] systemd[1]: initrd-cleanup.service: Deactivated successfully. machine # [ 3.293080] systemd[1]: Finished Cleaning Up and Shutting Down Daemons. machine # [ 3.295579] systemd[1]: Starting Cleanup udev Database... machine # [ 3.296545] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. machine # [ 3.298197] systemd[1]: Stopped Create Static Device Nodes in /dev. machine # [ 3.299173] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. machine # [ 3.300433] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully. machine # [ 3.302290] systemd[1]: kmod-static-nodes.service: Deactivated successfully. machine # [ 3.303202] systemd[1]: Stopped Create List of Static Device Nodes. machine # [ 3.304041] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. machine # [ 3.306139] systemd[1]: Finished rw-sysroot-nix-store.service. machine # [ 3.321134] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. machine # [ 3.322697] systemd[1]: Finished Cleanup udev Database. machine # [ 3.324117] systemd[1]: Reached target Switch Root. machine # [ 3.325541] systemd[1]: Starting NixOS Activation... machine # [ 3.393185] initrd-nixos-activation-start[191]: booting system configuration /nix/store/68vy4glkqv6dl08fwnd37a5r9s71a7b0-nixos-system-machine-test machine # [ 3.419360] initrd-nixos-activation-start[191]: running activation script... machine # [ 3.593382] initrd-nixos-activation-start[214]: setting up /etc... machine # [ 3.689481] systemd[1]: initrd-nixos-activation.service: Deactivated successfully. machine # [ 3.691905] systemd[1]: Finished NixOS Activation. machine # [ 3.692872] systemd[1]: Starting Switch Root... machine # [ 3.705858] systemd[1]: Switching root. machine # [ 3.974925] systemd-journald[65]: Received SIGTERM from PID 1 (systemd). machine # [ 4.050024] NET: Registered PF_VSOCK protocol family machine # [ 4.068963] systemd[1]: systemd 263-7f073ff running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE +EXPERIMENTAL-ENVVAR) machine # [ 4.073023] systemd[1]: Detected virtualization kvm. machine # [ 4.073739] systemd[1]: Detected architecture x86-64. machine # [ 4.074514] systemd[1]: Detected first boot. machine # [ 4.075877] systemd[1]: Initializing machine ID from random generator. machine # [ 4.160678] systemd[1]: bpf-restrict-fs: LSM BPF program attached machine # [ 4.257740] systemd[1]: Applying preset policy. machine # [ 4.421803] systemd[1]: Populated /etc with preset unit settings. machine # [ 4.589441] systemd[1]: initrd-switch-root.service: Deactivated successfully. machine # [ 4.590761] systemd[1]: Stopped initrd-switch-root.service. machine # [ 4.593285] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. machine # [ 4.595310] systemd[1]: Created slice Slice /system/getty. machine # [ 4.596648] systemd[1]: Created slice User and Session Slice. machine # [ 4.597580] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. machine # [ 4.598794] systemd[1]: Started Forward Password Requests to Wall Directory Watch. machine # [ 4.599894] systemd[1]: Expecting device /dev/hvc0... machine # [ 4.600661] systemd[1]: Expecting device /dev/ttyS0... machine # [ 4.601441] systemd[1]: Reached target Local Encrypted Volumes. machine # [ 4.602273] systemd[1]: Stopped target initrd-fs.target. machine # [ 4.602982] systemd[1]: Stopped target initrd-root-fs.target. machine # [ 4.603774] systemd[1]: Stopped target initrd-switch-root.target. machine # [ 4.604631] systemd[1]: Reached target Virtual Machines and Containers. machine # [ 4.605544] systemd[1]: Reached target Path Units. machine # [ 4.606265] systemd[1]: Reached target Remote File Systems. machine # [ 4.607031] systemd[1]: Reached target Slice Units. machine # [ 4.619339] systemd[1]: Reached target Swaps. machine # [ 4.621068] systemd[1]: Listening on Query the User Interactively for a Password. machine # [ 4.623268] systemd[1]: Listening on Process Core Dump Socket. machine # [ 4.624859] systemd[1]: Listening on Credential Encryption/Decryption. machine # [ 4.626560] systemd[1]: Listening on Factory Reset Management. machine # [ 4.627507] systemd[1]: Listening on Hostname Service Socket. machine # [ 4.630299] systemd[1]: Starting Journal Log Access Socket... machine # [ 4.631374] systemd[1]: Listening on Journal Audit Socket. machine # [ 4.633694] systemd[1]: Listening on Console Output Muting Service Socket. machine # [ 4.635113] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket. machine # [ 4.636204] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 4.637509] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 4.641213] systemd[1]: Listening on Disk Repartitioning Service Socket. machine # [ 4.642222] systemd[1]: Listening on udev Varlink Socket. machine # [ 4.644473] systemd[1]: Mounting Huge Pages File System... machine # [ 4.646685] systemd[1]: Mounting POSIX Message Queue File System... machine # [ 4.653091] systemd[1]: Mounting Kernel Debug File System... machine # [ 4.661033] systemd[1]: Mounting Kernel Trace File System... machine # [ 4.668065] systemd[1]: Starting Create List of Static Device Nodes... machine # [ 4.678421] systemd[1]: Starting Load Kernel Module configfs... machine # [ 4.683651] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm machine # [ 4.696288] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 4.707874] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse machine # [ 4.719493] systemd[1]: Mounting FUSE Control File System... machine # [ 4.724745] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 4.737808] systemd[1]: Starting Journal Service... machine # [ 4.742486] systemd[1]: Starting Load Kernel Modules... machine # [ 4.752145] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer... machine # [ 4.761699] systemd[1]: Starting Remount Root and Kernel File Systems... machine # [ 4.765967] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 4.775871] systemd[1]: Starting Coldplug All udev Devices... machine # [ 4.788587] systemd[1]: Listening on Journal Log Access Socket. machine # [ 4.799786] systemd[1]: Mounted Huge Pages File System. machine # [ 4.802384] systemd[1]: Mounted POSIX Message Queue File System. machine # [ 4.805241] systemd-journald[285]: Collecting audit messages is enabled. machine # [ 4.806475] systemd[1]: Mounted Kernel Debug File System. machine # [ 4.810142] systemd[1]: Mounted Kernel Trace File System. machine # [ 4.817527] systemd[1]: Finished Create List of Static Device Nodes. machine # [ 4.822544] systemd[1]: modprobe@configfs.service: Deactivated successfully. machine # [ 4.831099] systemd[1]: Finished Load Kernel Module configfs. machine # [ 4.833578] loop: module loaded machine # [ 4.692860] systemd[1]: Queued start job for default target Multi-User System. machine # [ 4.837191] EXT4-fs (vda): re-mounted 37b065f2-1ea0-4f3e-923b-46305818f754. machine # [ 4.838525] systemd[1]: Started Journal Service. machine # [ 4.698784] systemd[1]: Unnecessary job was removed for /sys/devices/virtual/tty/hvc0. machine # [ 4.700616] systemd[1]: Unnecessary job was removed for /sys/devices/pnp0/00:03/00:03:0/00:03:0.0/tty/ttyS0. machine # [ 4.704345] systemd[1]: systemd-journald.service: Deactivated successfully. machine # [ 4.705763] systemd-modules-load[286]: Inserted module 'loop' machine # [ 4.708959] systemd[1]: Mounted FUSE Control File System. machine # [ 4.709982] systemd[1]: Finished Load Kernel Modules. machine # [ 4.713220] systemd[1]: Finished Remount Root and Kernel File Systems. machine # [ 4.728077] systemd[1]: Listening on Disk Image Download Service Socket. machine # [ 4.731490] systemd[1]: Mounting Kernel Configuration File System... machine # [ 4.740885] systemd[1]: Starting Firewall... machine # [ 4.746400] systemd[1]: Starting Flush Journal to Persistent Storage... machine # [ 4.748062] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 4.756093] systemd[1]: Starting Load/Save OS Random Seed... machine # [ 4.766338] systemd-oomd[287]: No swap; memory pressure usage will be degraded machine # [ 4.772408] systemd[1]: Starting Apply Kernel Variables... machine # [ 4.784937] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... machine # [ 4.786038] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 4.787296] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer. machine # [ 4.979363] systemd-journald[285]: Received client request to flush runtime journal. machine # [ 4.931660] systemd[1]: Mounted Kernel Configuration File System. machine # [ 4.932724] systemd[1]: Finished Load/Save OS Random Seed. machine # [ 4.934272] systemd[1]: Reached target First Boot Complete. machine # [ 4.940486] systemd[1]: Finished Flush Journal to Persistent Storage. machine # [ 4.943382] systemd[1]: Finished Apply Kernel Variables. machine # [ 5.022073] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. machine # [ 5.028667] systemd[1]: Starting Create Static Device Nodes in /dev... machine # [ 5.031962] systemd[1]: Finished Coldplug All udev Devices. machine # [ 5.069769] systemd[1]: Finished Create Static Device Nodes in /dev. machine # [ 5.071589] systemd[1]: Reached target Preparation for Local File Systems. machine # [ 5.074452] systemd[1]: Starting Rule-based Manager for Device Events and Files... machine # [ 5.117351] systemd-udevd[326]: Using default interface naming scheme 'v261'. machine # [ 5.158355] systemd[1]: Started Rule-based Manager for Device Events and Files. machine # [ 5.221050] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse machine # [ 5.287595] systemd[1]: Condition check resulted in /dev/hvc0 being skipped. machine # [ 5.318652] systemd[1]: Condition check resulted in /dev/ttyS0 being skipped. machine # [ 5.343318] (udev-worker)[350]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. machine # [ 5.345643] (udev-worker)[350]: Network interface NamePolicy= disabled on kernel command line. machine # [ 5.419128] systemd[1]: Condition check resulted in Virtio network device being skipped. machine # [ 5.420995] systemd[1]: Condition check resulted in Virtio network device being skipped. machine # [ 5.422617] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 5.424047] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 5.426019] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 5.427463] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 5.428635] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 5.450566] systemd[1]: Mounting /run/wrappers... machine # [ 5.493526] systemd[1]: Mounted /run/wrappers. machine # [ 5.494258] systemd[1]: Reached target Local File Systems. machine # [ 5.499065] systemd[1]: Listening on Boot Loader Control Service Socket. machine # [ 5.502064] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 5.502897] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 5.507083] systemd[1]: Starting Save Transient machine-id to Disk... machine # [ 5.509975] systemd[1]: Starting Create System Files and Directories... machine # [ 5.756296] mousedev: PS/2 mouse device common for all mice machine # [ 5.614250] systemd[1]: etc-machine\x2did.mount: Deactivated successfully. machine # [ 5.621672] systemd[1]: Finished Save Transient machine-id to Disk. machine # [ 5.636487] systemd[1]: Finished Create System Files and Directories. machine # [ 5.644304] systemd[1]: Starting Rebuild Journal Catalog... machine # [ 5.652075] systemd[1]: Starting Record System Boot/Shutdown in UTMP... machine # [ 5.810181] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input3 machine # [ 5.718379] systemd[1]: Finished Record System Boot/Shutdown in UTMP. machine # [ 5.865120] ACPI: button: Power Button [PWRF] machine # [ 5.747751] systemd[1]: Finished Rebuild Journal Catalog. machine # [ 5.754817] systemd[1]: Starting Update is Completed... machine # [ 5.792384] systemd[1]: Finished Update is Completed. machine # [ 5.959909] rtc_cmos PNP0B00:00: RTC can wake from S4 machine # [ 5.978267] rtc_cmos PNP0B00:00: registered as rtc0 machine # [ 5.986165] rtc_cmos PNP0B00:00: setting system clock to 2026-10-15T02:51:59 UTC (1792032719) machine # [ 5.994200] rtc_cmos PNP0B00:00: alarms up to one day, y3k, 242 bytes nvram, hpet irqs machine # [ 5.998684] bochs-drm 0000:00:01.0: vgaarb: deactivate vga console machine # [ 5.999898] systemd-journald[285]: Time jumped backwards, rotating. machine # [ 6.025209] parport_pc 00:02: reported by Plug and Play ACPI machine # [ 5.981128] systemd[1]: Finished Firewall. machine # [ 5.981956] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 5.984423] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 5.985523] systemd[1]: Reached target System Initialization. machine # [ 5.989175] systemd[1]: Started Discard unused filesystem blocks once a week. machine # [ 5.990194] systemd[1]: Started Daily Cleanup of Temporary Directories. machine # [ 5.991281] systemd[1]: Reached target Timer Units. machine # [ 5.992122] systemd[1]: Listening on D-Bus System Message Bus Socket. machine # [ 5.994128] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket. machine # [ 5.995259] systemd[1]: Reached target Socket Units. machine # [ 5.995971] systemd[1]: Reached target Basic System. machine # [ 5.998467] systemd[1]: Started backdoor.service. machine # [ 6.000134] systemd[1]: Starting Import lastlog data into lastlog2 database... machine # [ 6.007393] systemd[1]: Starting Name Service Cache Daemon (nsncd)... machine # [ 6.020112] systemd[1]: Starting Post-Boot Actions... machine # [ 6.026812] systemd[1]: Started Reset console on configuration changes. machine # [ 6.040119] systemd[1]: Starting resolvconf update... machine # [ 6.069633] systemd[1]: Starting D-Bus System Message Bus... machine # [ 6.111601] nsncd[496]: Oct 15 02:51:59.766 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" machine # [ 6.114575] systemd[1]: Started Name Service Cache Daemon (nsncd). machine # [ 6.117608] systemd[1]: Reached target Host and Network Name Lookups. machine # [ 6.119241] systemd[1]: Reached target User and Group Name Lookups. machine # connecting to host... machine # [ 6.142567] systemd[1]: Starting User Login Management... machine # [ 6.147171] systemd[1]: Finished Post-Boot Actions. machine: Guest shell says: b'Spawning backdoor root shell...\n' machine: connected to guest root shell machine: (connecting took 6.87 seconds) machine: (finished: waiting for the VM to finish booting, in 7.11 seconds) machine # [ 6.189864] systemd[1]: Finished Import lastlog data into lastlog2 database. machine # [ 6.220497] dbus-broker-launch[501]: Looking up NSS user entry for 'systemd-timesync'... machine # [ 6.227234] dbus-broker-launch[501]: NSS returned no entry for 'systemd-timesync' machine # [ 6.228331] dbus-broker-launch[501]: Invalid user-name in /nix/store/j7qdzgxgsqkgi5r521awlydac1mf9v8h-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" machine # [ 6.056176] parport0: PC-style at 0x378, irq 7 [PCSPP(,...)] machine # [ 6.069509] input: QEMU Virtio Keyboard as /devices/pci0000:00/0000:00:06.0/virtio4/input/input4 machine # [ 6.072782] lpc_ich 0000:00:1f.0: I/O space for GPIO uninitialized machine # [ 6.308676] i801_smbus 0000:00:1f.3: SMBus using PCI interrupt machine # [ 6.308781] i2c i2c-0: Memory type 0x07 not supported yet, not instantiating SPD machine # [ 6.377015] Console: switching to colour dummy device 80x25 machine # [ 6.389262] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input6 machine # [ 6.389557] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input5 machine # [ 6.491202] [drm] Found bochs VGA, ID 0xb0c5. machine # [ 6.491204] [drm] Framebuffer size 16384 kB @ 0xfd000000, mmio @ 0xfebd0000. machine # [ 6.325621] dbus-broker-launch[501]: Ready machine # [ 6.350716] systemd-logind[516]: New seat seat0. machine # [ 6.497141] bochs-drm 0000:00:01.0: [drm] Registered 1 planes with drm panic machine # [ 6.497805] [drm] Initialized bochs-drm 1.0.0 for 0000:00:01.0 on minor 0 machine # [ 6.357765] systemd-logind[516]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard) machine # [ 6.364523] systemd-logind[516]: Watching system buttons on /dev/input/event2 (Power Button) machine # [ 6.406111] systemd[1]: Started D-Bus System Message Bus. machine # [ 6.406901] systemd[1]: Started User Login Management. machine # [ 6.441640] systemd[1]: Stopped target Host and Network Name Lookups. machine # [ 6.442577] systemd[1]: Stopping Host and Network Name Lookups... machine # [ 6.444105] systemd[1]: Stopped target User and Group Name Lookups. machine # [ 6.446054] systemd[1]: Stopping User and Group Name Lookups... machine # [ 6.451170] systemd[1]: Starting linger-users.service... machine # [ 6.455161] systemd[1]: Stopping Name Service Cache Daemon (nsncd)... machine # [ 6.465752] systemd[1]: Starting Virtual Console Setup... machine # [ 6.468217] systemd[1]: nscd.service: Deactivated successfully. machine # [ 6.475558] systemd[1]: Stopped Name Service Cache Daemon (nsncd). machine # [ 6.526338] systemd[1]: Starting Name Service Cache Daemon (nsncd)... machine # [ 6.531604] systemd-logind[516]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard) machine # [ 6.565116] ppdev: user-space parallel port driver machine # [ 6.648576] iTCO_wdt iTCO_wdt.1.auto: Found a ICH9 TCO device (Version=2, TCOBASE=0x0660) machine # [ 6.654735] Console: switching to colour frame buffer device 160x50 machine # [ 6.690724] iTCO_wdt iTCO_wdt.1.auto: initialized. heartbeat=30 sec (nowayout=0) machine # [ 6.777717] bochs-drm 0000:00:01.0: [drm] fb0: bochs-drmdrmfb frame buffer device machine # [ 6.545294] systemd[1]: Finished resolvconf update. machine # [ 6.648932] systemd[1]: Reached target Preparation for Network. machine # [ 6.655688] systemd[1]: Starting DHCP Client... machine # [ 6.664353] systemd[1]: Starting Address configuration of eth1... machine # [ 6.671322] nsncd[596]: Oct 15 02:52:00.253 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" machine # [ 6.680388] systemd[1]: Starting Extra networking commands.... machine # [ 6.681379] systemd[1]: Started Name Service Cache Daemon (nsncd). machine # [ 6.686164] systemd[1]: Created slice Slice /user/1001. machine # [ 6.687125] systemd[1]: Reached target Host and Network Name Lookups. machine # [ 6.687975] systemd[1]: Reached target User and Group Name Lookups. machine # [ 6.690871] systemd[1]: Starting User Runtime Directory /run/user/1001... machine # [ 6.693492] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 6.696218] systemd[1]: Finished linger-users.service. machine # [ 6.696911] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. machine # [ 6.700110] systemd[1]: Stopped Virtual Console Setup. machine # [ 6.700906] systemd[1]: Starting Virtual Console Setup... machine # [ 6.720382] systemd[1]: Finished User Runtime Directory /run/user/1001. machine # [ 6.727265] systemd[1]: Starting User Manager for UID 1001... machine # [ 6.787486] (systemd)[625]: pam_unix(systemd-user:session): session opened for user usertest(uid=1001) by (uid=0) machine # [ 6.792270] network-addresses-eth1-start[600]: adding address 192.168.1.1/24... done machine # [ 6.802395] systemd-logind[516]: New session '1' of user 'usertest' with class 'manager' and type 'unspecified'. machine # [ 6.834762] network-addresses-eth1-start[600]: adding address 2001:db8:1::1/64... done machine # [ 6.843237] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 6.906791] systemd[1]: Finished Address configuration of eth1. machine # [ 7.004684] dhcpcd[626]: dhcpcd-10.3.2 starting machine # [ 7.160695] kvm_amd: TSC scaling supported machine # [ 7.163799] kvm_amd: Nested Virtualization enabled machine # [ 7.166043] kvm_amd: Nested Paging enabled machine # [ 7.166465] kvm_amd: LBR virtualization supported machine # [ 7.166901] kvm_amd: Virtual VMLOAD VMSAVE supported machine # [ 7.026195] systemd[1]: Finished Extra networking commands.. machine # [ 7.026990] systemd[1]: Reached target Network. machine # [ 7.032806] dhcpcd[689]: dev: loaded udev machine # [ 7.033643] systemd[1]: Starting Permit User Sessions... machine # [ 7.180083] kvm_amd: Virtual GIF supported machine # [ 7.180514] kvm_amd: Virtual NMI enabled machine # [ 7.201558] 8021q: 802.1Q VLAN Support v1.8 machine # [ 7.201977] 8021q: adding VLAN 0 to HW filter on device eth1 machine # [ 7.090048] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch. machine # [ 7.253435] EDAC MC: Ver: 3.0.0 machine # [ 7.125199] systemd[1]: Finished Permit User Sessions. machine # [ 7.132188] systemd[1]: Started Getty on tty1. machine # [ 7.132849] systemd[1]: Reached target Login Prompts. machine # [ 7.314765] cfg80211: Loading compiled-in X.509 certificates for regulatory database machine # [ 7.179549] systemd[625]: Queued start job for default target Main User Target. machine # [ 7.181921] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 7.186532] systemd[625]: Created slice User Application Slice. machine # [ 7.187786] systemd[625]: Started Daily Cleanup of User's Temporary Directories. machine # [ 7.188986] systemd[625]: Reached target Paths. machine # [ 7.190808] systemd[625]: Reached target Timers. machine # [ 7.192861] systemd[625]: Starting D-Bus User Message Bus Socket... machine # [ 7.195701] systemd[625]: Starting Create User Files and Directories... machine # [ 7.346259] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' machine # [ 7.346913] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600' machine # [ 7.350222] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -2 machine # [ 7.351032] cfg80211: failed to load regulatory.db machine # [ 7.240942] systemd[625]: Finished Create User Files and Directories. machine # [ 7.262049] systemd[625]: Listening on D-Bus User Message Bus Socket. machine # [ 7.262973] systemd[625]: Reached target Sockets. machine # [ 7.263661] systemd[625]: Reached target Basic System. machine # [ 7.264833] systemd[1]: Started User Manager for UID 1001. machine # [ 7.267888] systemd[625]: Starting Run user-specific NixOS activation... machine # [ 7.419878] 8021q: adding VLAN 0 to HW filter on device eth0 machine # [ 7.278090] dhcpcd[689]: eth0: waiting for carrier machine # [ 7.278850] dhcpcd[689]: eth0: carrier acquired machine # [ 7.288823] dhcpcd[689]: DUID 00:01:00:01:32:62:fc:50:52:54:00:12:34:56 machine # [ 7.289974] dhcpcd[689]: eth0: IAID 00:12:34:56 machine # [ 7.291417] dhcpcd[689]: eth0: adding address fe80::5054:ff:fe12:3456 machine # [ 7.301534] systemd[625]: Finished Run user-specific NixOS activation. machine # [ 7.302971] systemd[625]: Reached target Main User Target. machine # [ 7.304430] systemd[625]: Startup finished in 474ms. machine # [ 7.321994] systemd-vconsole-setup[619]: Configuration of first virtual console was skipped, ignoring remaining ones. machine # [ 7.326573] systemd[1]: Finished Virtual Console Setup. machine # [ 8.115959] dhcpcd[689]: eth0: soliciting a DHCP lease machine # [ 8.276829] NET: Registered PF_PACKET protocol family machine # [ 8.141166] dhcpcd[689]: eth0: offered 10.0.2.15 from 10.0.2.2 machine # [ 8.143451] dhcpcd[689]: eth0: probing address 10.0.2.15/24 machine # [ 8.678876] dhcpcd[689]: eth0: soliciting an IPv6 router machine # [ 8.680316] dhcpcd[689]: eth0: Router Advertisement from fe80::2 machine # [ 8.681156] dhcpcd[689]: eth0: adding address fec0::5054:ff:fe12:3456/64 machine # [ 8.682211] dhcpcd[689]: eth0: adding route to fec0::/64 machine # [ 8.682949] dhcpcd[689]: eth0: adding default route via fe80::2 machine # [ 12.777727] dhcpcd[689]: eth0: leased 10.0.2.15 for 86400 seconds machine # [ 12.780950] dhcpcd[689]: eth0: adding route to 10.0.2.0/24 machine # [ 12.783252] dhcpcd[689]: eth0: adding default route via 10.0.2.2 machine # [ 12.863696] systemd[1]: Started DHCP Client. machine # [ 12.865742] systemd[1]: Reached target Multi-User System. machine # [ 12.866653] systemd[1]: Startup finished in 855ms (kernel) + 3.031s (initrd) + 8.978s (userspace) = 12.865s. machine: (finished: waiting for unit multi-user.target, in 13.84 seconds) machine: must succeed: /nix/store/3vbcjh6yz1i6lp352svzp92f3jmjppg7-stderr-runner /nix/store/68vy4glkqv6dl08fwnd37a5r9s71a7b0-nixos-system-machine-test/bin/switch-to-configuration test machine # Checking switch inhibitors... done machine # [ 13.109714] nixos[830]: switching to system configuration /nix/store/68vy4glkqv6dl08fwnd37a5r9s71a7b0-nixos-system-machine-test machine # activating the configuration... machine # [ 13.113481] systemd[1]: Stopped target Remote File Systems. machine # [ 13.114364] systemd[1]: Stopped target Local File Systems. machine # setting up /etc... machine # [ 13.327201] systemd[1]: Reload requested from client PID 830 ('.switch-to-conf') (unit backdoor.service)... machine # [ 13.328849] systemd[1]: Reloading... machine # [ 13.557981] systemd[1]: Reloading finished in 227 ms. machine # reloading user units for usertest... machine # [ 13.586737] systemd[625]: Created slice User Core Session Slice. machine # [ 13.591614] systemd[625]: Starting D-Bus User Message Bus... machine # [ 13.625457] dbus-broker-launch[900]: Ignoring duplicate name 'org.freedesktop.import1' in service file '/nix/store/j7qdzgxgsqkgi5r521awlydac1mf9v8h-system-path/share/dbus-1/services/org.freedesktop.import1.service' machine # [ 13.628199] dbus-broker-launch[900]: Ignoring duplicate name 'org.freedesktop.machine1' in service file '/nix/store/j7qdzgxgsqkgi5r521awlydac1mf9v8h-system-path/share/dbus-1/services/org.freedesktop.machine1.service' machine # [ 13.630846] dbus-broker-launch[900]: Ignoring duplicate name 'org.freedesktop.portable1' in service file '/nix/store/j7qdzgxgsqkgi5r521awlydac1mf9v8h-system-path/share/dbus-1/services/org.freedesktop.portable1.service' machine # [ 13.633428] dbus-broker-launch[900]: Ignoring duplicate name 'org.freedesktop.systemd1' in service file '/nix/store/j7qdzgxgsqkgi5r521awlydac1mf9v8h-system-path/share/dbus-1/services/org.freedesktop.systemd1.service' machine # [ 13.636095] dbus-broker-launch[900]: Policy to allow eavesdropping in /etc/dbus-1/session.conf +27: Eavesdropping is deprecated and ignored machine # [ 13.638147] dbus-broker-launch[900]: Policy to allow eavesdropping in /etc/dbus-1/session.conf +29: Eavesdropping is deprecated and ignored machine # [ 13.639846] systemd[625]: Started D-Bus User Message Bus. machine # [ 13.646230] dbus-broker-launch[900]: Ready machine # [ 13.688303] systemd[625]: Reexecution requested from client PID 899 ('switch-to-confi')... machine # [ 13.689764] systemd[625]: Reexecuting. machine # [ 13.711074] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 13.782356] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 13.787776] systemd[625]: Reload requested from client PID 899 ('switch-to-confi')... machine # [ 13.789319] systemd[625]: Reloading... machine # [ 13.859725] systemd[625]: Reloading finished in 69 ms. machine # [ 13.864807] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # restarting the following user units: nixos-activation.service machine # [ 13.871952] systemd[625]: Stopped Run user-specific NixOS activation. machine # [ 13.872907] systemd[625]: Stopping Run user-specific NixOS activation... machine # [ 13.875164] systemd[625]: Starting Run user-specific NixOS activation... machine # [ 13.894239] systemd[625]: Finished Run user-specific NixOS activation. machine # restarting sysinit-reactivation.target machine # [ 13.902406] systemd[1]: Starting Re-setup tmpfiles on a system that is already running.... machine # [ 13.967190] systemd[1]: Finished Re-setup tmpfiles on a system that is already running.. machine # [ 13.969700] systemd[1]: Reached target Reactivate sysinit units. machine # [ 13.971729] systemd[1]: Reached target Remote File Systems. machine # [ 13.976112] systemd[1]: Starting linger-users.service... machine # [ 13.977969] systemd[1]: Reached target Local File Systems. machine # [ 13.982948] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 13.984210] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 13.989077] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 13.993667] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 13.994554] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 13.995811] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 14.000202] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 14.003797] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 14.005080] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 14.037667] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 14.039986] systemd[1]: Finished linger-users.service. machine # [ 14.150405] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 14.152135] systemd[1]: Finished Create SUID/SGID Wrappers. machine # the following new units were started: sysinit-reactivation.target, systemd-tmpfiles-resetup.service machine # [ 14.411347] nixos[830]: finished switching to system configuration /nix/store/68vy4glkqv6dl08fwnd37a5r9s71a7b0-nixos-system-machine-test machine: (finished: must succeed: /nix/store/3vbcjh6yz1i6lp352svzp92f3jmjppg7-stderr-runner /nix/store/68vy4glkqv6dl08fwnd37a5r9s71a7b0-nixos-system-machine-test/bin/switch-to-configuration test, in 1.52 seconds) machine: must succeed: rm /etc/NIXOS machine: (finished: must succeed: rm /etc/NIXOS, in 0.03 seconds) machine: must succeed: /nix/store/3vbcjh6yz1i6lp352svzp92f3jmjppg7-stderr-runner /nix/store/8nmddslwk5zcf3lkv6zihhwv5ssxa57r-nixos-system-other-test/bin/switch-to-configuration test machine # this should succeed (config: /nix/store/8nmddslwk5zcf3lkv6zihhwv5ssxa57r-nixos-system-other-test, action: test) machine # Checking switch inhibitors... done machine # [ 14.672388] nixos[978]: switching to system configuration /nix/store/8nmddslwk5zcf3lkv6zihhwv5ssxa57r-nixos-system-other-test machine # activating the configuration... machine # [ 14.675923] systemd[1]: Stopped target Local File Systems. machine # [ 14.676919] systemd[1]: Stopped target Remote File Systems. machine # removing user ‘usertest’ machine # setting up /etc... machine # [ 14.894711] systemd[1]: Reload requested from client PID 978 ('.switch-to-conf') (unit backdoor.service)... machine # [ 14.896397] systemd[1]: Reloading... machine # [ 15.138837] systemd[1]: Reloading finished in 240 ms. machine # reloading user units for usertest... machine # [ 15.205919] systemd[625]: Reexecution requested from client PID 1049 ('switch-to-confi')... machine # [ 15.208491] systemd[625]: Reexecuting. machine # [ 15.229115] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 15.304366] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 15.309163] systemd[625]: Reload requested from client PID 1049 ('switch-to-confi')... machine # [ 15.311086] systemd[625]: Reloading... machine # [ 15.381776] systemd[625]: Reloading finished in 70 ms. machine # [ 15.386840] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # restarting the following user units: nixos-activation.service machine # [ 15.393730] systemd[625]: Stopped Run user-specific NixOS activation. machine # [ 15.395177] systemd[625]: Stopping Run user-specific NixOS activation... machine # [ 15.397275] systemd[625]: Starting Run user-specific NixOS activation... machine # [ 15.416302] systemd[625]: Finished Run user-specific NixOS activation. machine # restarting sysinit-reactivation.target machine # [ 15.419745] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 15.420908] systemd[1]: Stopping Reactivate sysinit units... machine # [ 15.421975] systemd[1]: Reached target Reactivate sysinit units. machine # reloading the following units: dbus-broker.service machine # [ 15.425280] dbus-broker-launch[501]: Caught SIGHUP, trigger reload. machine # [ 15.426919] systemd[1]: Reloading D-Bus System Message Bus... machine # [ 15.431899] dbus-broker-launch[501]: Looking up NSS user entry for 'systemd-timesync'... machine # [ 15.433678] dbus-broker-launch[501]: NSS returned no entry for 'systemd-timesync' machine # [ 15.434750] dbus-broker-launch[501]: Invalid user-name in /nix/store/z3c11nhbd8nsbnvkrf8pj2yz4h4xfi2j-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" machine # [ 15.443449] systemd[1]: Reloaded D-Bus System Message Bus. machine # restarting the following units: network-addresses-eth1.service machine # [ 15.448057] systemd[1]: Stopping Address configuration of eth1... machine # [ 15.466404] network-addresses-eth1-pre-stop[1061]: deleting address 192.168.1.1/24... done machine # [ 15.471666] network-addresses-eth1-pre-stop[1061]: deleting address 2001:db8:1::1/64... done machine # [ 15.476737] systemd[1]: network-addresses-eth1.service: Deactivated successfully. machine # [ 15.478312] systemd[1]: Stopped Address configuration of eth1. machine # [ 15.481501] systemd[1]: Starting Address configuration of eth1... machine # [ 15.510340] network-addresses-eth1-start[1066]: adding address 192.168.1.2/24... done machine # [ 15.515506] network-addresses-eth1-start[1066]: adding address 2001:db8:1::2/64... done machine # [ 15.522823] systemd[1]: Finished Address configuration of eth1. machine # [ 15.526202] systemd[1]: Reached target Local File Systems. machine # [ 15.528152] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 15.530668] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 15.532330] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 15.534320] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 15.536359] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 15.537845] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 15.541271] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 15.542481] systemd[1]: Reached target Remote File Systems. machine # [ 15.545293] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 15.546509] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 15.698628] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 15.700390] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 15.704196] systemd[1]: Starting linger-users.service... machine # [ 15.724238] linger-users-start[1138]: id: ‘usertest’: no such user machine # [ 15.725775] linger-users-start[1136]: Removing linger for missing user usertest machine # [ 15.730520] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 15.731910] systemd[1]: Finished linger-users.service. machine # [ 15.988712] nixos[978]: finished switching to system configuration /nix/store/8nmddslwk5zcf3lkv6zihhwv5ssxa57r-nixos-system-other-test machine: (finished: must succeed: /nix/store/3vbcjh6yz1i6lp352svzp92f3jmjppg7-stderr-runner /nix/store/8nmddslwk5zcf3lkv6zihhwv5ssxa57r-nixos-system-other-test/bin/switch-to-configuration test, in 1.55 seconds) subtest: services machine: must succeed: /nix/store/68vy4glkqv6dl08fwnd37a5r9s71a7b0-nixos-system-machine-test/bin/switch-to-configuration test 2>&1 machine # [ 16.213341] nixos[1144]: switching to system configuration /nix/store/68vy4glkqv6dl08fwnd37a5r9s71a7b0-nixos-system-machine-test machine # [ 16.215710] systemd[1]: Stopped target Remote File Systems. machine # [ 16.217543] systemd[1]: Stopped target Local File Systems. machine # [ 16.421858] systemd[1]: Reload requested from client PID 1144 ('.switch-to-conf') (unit backdoor.service)... machine # [ 16.423492] systemd[1]: Reloading... machine # [ 16.656366] systemd[1]: Reloading finished in 231 ms. machine # [ 16.719555] systemd[625]: Reexecution requested from client PID 1213 ('switch-to-confi')... machine # [ 16.721301] systemd[625]: Reexecuting. machine # [ 16.741143] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 16.829062] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 16.839587] systemd[625]: Reload requested from client PID 1213 ('switch-to-confi')... machine # [ 16.840927] systemd[625]: Reloading... machine # [ 16.912187] systemd[625]: Reloading finished in 73 ms. machine # [ 16.917809] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 16.923872] systemd[625]: Stopped Run user-specific NixOS activation. machine # [ 16.924865] systemd[625]: Stopping Run user-specific NixOS activation... machine # [ 16.927224] systemd[625]: Starting Run user-specific NixOS activation... machine # [ 16.946229] systemd[625]: Finished Run user-specific NixOS activation. machine # [ 16.949308] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 16.950582] systemd[1]: Stopping Reactivate sysinit units... machine # [ 16.951563] systemd[1]: Reached target Reactivate sysinit units. machine # [ 16.954950] dbus-broker-launch[501]: Caught SIGHUP, trigger reload. machine # [ 16.956142] systemd[1]: Reloading D-Bus System Message Bus... machine # [ 16.959448] dbus-broker-launch[501]: Looking up NSS user entry for 'systemd-timesync'... machine # [ 16.961230] dbus-broker-launch[501]: NSS returned no entry for 'systemd-timesync' machine # [ 16.962275] dbus-broker-launch[501]: Invalid user-name in /nix/store/j7qdzgxgsqkgi5r521awlydac1mf9v8h-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" machine # [ 16.969846] systemd[1]: Reloaded D-Bus System Message Bus. machine # [ 16.973661] systemd[1]: Stopping Address configuration of eth1... machine # [ 16.992192] network-addresses-eth1-pre-stop[1226]: deleting address 192.168.1.2/24... done machine # [ 16.997396] network-addresses-eth1-pre-stop[1226]: deleting address 2001:db8:1::2/64... done machine # [ 17.002786] systemd[1]: network-addresses-eth1.service: Deactivated successfully. machine # [ 17.003878] systemd[1]: Stopped Address configuration of eth1. machine # [ 17.006899] systemd[1]: Starting Address configuration of eth1... machine # [ 17.034701] network-addresses-eth1-start[1231]: adding address 192.168.1.1/24... done machine # [ 17.040361] network-addresses-eth1-start[1231]: adding address 2001:db8:1::1/64... done machine # [ 17.047463] systemd[1]: Finished Address configuration of eth1. machine # [ 17.051850] systemd[1]: Reached target Local File Systems. machine # [ 17.053331] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 17.055204] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 17.056835] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 17.059216] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 17.061059] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 17.062223] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 17.064195] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 17.065663] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 17.066869] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 17.073044] systemd[1]: Reached target Remote File Systems. machine # [ 17.202988] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 17.204903] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 17.208776] systemd[1]: Starting linger-users.service... machine # [ 17.231082] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 17.233358] systemd[1]: Finished linger-users.service. machine # [ 17.489987] nixos[1144]: finished switching to system configuration /nix/store/68vy4glkqv6dl08fwnd37a5r9s71a7b0-nixos-system-machine-test machine: (finished: must succeed: /nix/store/68vy4glkqv6dl08fwnd37a5r9s71a7b0-nixos-system-machine-test/bin/switch-to-configuration test 2>&1, in 1.50 seconds) machine: must succeed: /nix/store/68vy4glkqv6dl08fwnd37a5r9s71a7b0-nixos-system-machine-test/bin/switch-to-configuration test 2>&1 machine # [ 17.711935] nixos[1300]: switching to system configuration /nix/store/68vy4glkqv6dl08fwnd37a5r9s71a7b0-nixos-system-machine-test machine # [ 17.714307] systemd[1]: Stopped target Local File Systems. machine # [ 17.715812] systemd[1]: Stopped target Remote File Systems. machine # [ 17.919744] systemd[1]: Reload requested from client PID 1300 ('.switch-to-conf') (unit backdoor.service)... machine # [ 17.921347] systemd[1]: Reloading... machine # [ 18.153779] systemd[1]: Reloading finished in 230 ms. machine # [ 18.215569] systemd[625]: Reexecution requested from client PID 1369 ('switch-to-confi')... machine # [ 18.217110] systemd[625]: Reexecuting. machine # [ 18.238302] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 18.310753] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 18.316350] systemd[625]: Reload requested from client PID 1369 ('switch-to-confi')... machine # [ 18.318601] systemd[625]: Reloading... machine # [ 18.388714] systemd[625]: Reloading finished in 70 ms. machine # [ 18.394092] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 18.401260] systemd[625]: Stopped Run user-specific NixOS activation. machine # [ 18.403095] systemd[625]: Stopping Run user-specific NixOS activation... machine # [ 18.404664] systemd[625]: Starting Run user-specific NixOS activation... machine # [ 18.423171] systemd[625]: Finished Run user-specific NixOS activation. machine # [ 18.426615] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 18.427716] systemd[1]: Stopping Reactivate sysinit units... machine # [ 18.428837] systemd[1]: Reached target Reactivate sysinit units. machine # [ 18.430676] systemd[1]: Reached target Local File Systems. machine # [ 18.433042] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 18.435286] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 18.437339] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 18.438920] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 18.441539] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 18.443884] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 18.446280] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 18.450237] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 18.451481] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 18.455551] systemd[1]: Reached target Remote File Systems. machine # [ 18.583115] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 18.586167] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 18.588915] systemd[1]: Starting linger-users.service... machine # [ 18.615801] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 18.618357] systemd[1]: Finished linger-users.service. machine # [ 18.874816] nixos[1300]: finished switching to system configuration /nix/store/68vy4glkqv6dl08fwnd37a5r9s71a7b0-nixos-system-machine-test machine: (finished: must succeed: /nix/store/68vy4glkqv6dl08fwnd37a5r9s71a7b0-nixos-system-machine-test/bin/switch-to-configuration test 2>&1, in 1.38 seconds) machine: must succeed: /nix/store/68vy4glkqv6dl08fwnd37a5r9s71a7b0-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration test 2>&1 machine # [ 19.112427] nixos[1440]: switching to system configuration /nix/store/nbryj79iphx14n1lblf2cm8s3sc137ln-nixos-system-machine-test machine # [ 19.114891] systemd[1]: Stopped target Local File Systems. machine # [ 19.116539] systemd[1]: Stopped target Remote File Systems. machine # [ 19.340846] systemd[1]: Reload requested from client PID 1440 ('.switch-to-conf') (unit backdoor.service)... machine # [ 19.342613] systemd[1]: Reloading... machine # [ 19.585952] systemd[1]: Reloading finished in 242 ms. machine # [ 19.647822] systemd[625]: Reexecution requested from client PID 1509 ('switch-to-confi')... machine # [ 19.650189] systemd[625]: Reexecuting. machine # [ 19.670126] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 19.740462] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 19.745839] systemd[625]: Reload requested from client PID 1509 ('switch-to-confi')... machine # [ 19.747934] systemd[625]: Reloading... machine # [ 19.815901] systemd[625]: Reloading finished in 68 ms. machine # [ 19.820812] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 19.827252] systemd[625]: Stopped Run user-specific NixOS activation. machine # [ 19.829090] systemd[625]: Stopping Run user-specific NixOS activation... machine # [ 19.830594] systemd[625]: Starting Run user-specific NixOS activation... machine # [ 19.848927] systemd[625]: Finished Run user-specific NixOS activation. machine # [ 19.851837] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 19.853183] systemd[1]: Stopping Reactivate sysinit units... machine # [ 19.853970] systemd[1]: Reached target Reactivate sysinit units. machine # [ 19.856767] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 19.858504] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 19.861582] systemd[1]: Reached target Remote File Systems. machine # [ 19.864956] systemd[1]: Starting linger-users.service... machine # [ 19.868814] systemd[1]: Starting test.service... machine # [ 19.869595] systemd[1]: Reached target Local File Systems. machine # [ 19.879119] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 19.884051] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 19.884842] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 19.887332] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 19.890389] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 19.893171] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 19.894391] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 19.912941] systemd[1]: Finished test.service. machine # [ 19.932858] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 19.935389] systemd[1]: Finished linger-users.service. machine # [ 20.061128] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 20.063391] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 20.320712] nixos[1440]: finished switching to system configuration /nix/store/nbryj79iphx14n1lblf2cm8s3sc137ln-nixos-system-machine-test machine: (finished: must succeed: /nix/store/68vy4glkqv6dl08fwnd37a5r9s71a7b0-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration test 2>&1, in 1.45 seconds) machine: must succeed: /nix/store/68vy4glkqv6dl08fwnd37a5r9s71a7b0-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration test 2>&1 machine # [ 20.524316] nixos[1583]: switching to system configuration /nix/store/nbryj79iphx14n1lblf2cm8s3sc137ln-nixos-system-machine-test machine # [ 20.526511] systemd[1]: Stopped target Local File Systems. machine # [ 20.528210] systemd[1]: Stopped target Remote File Systems. machine # [ 20.729525] systemd[1]: Reload requested from client PID 1583 ('.switch-to-conf') (unit backdoor.service)... machine # [ 20.731349] systemd[1]: Reloading... machine # [ 20.954643] systemd[1]: Reloading finished in 222 ms. machine # [ 21.015614] systemd[625]: Reexecution requested from client PID 1652 ('switch-to-confi')... machine # [ 21.017304] systemd[625]: Reexecuting. machine # [ 21.038153] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 21.106995] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 21.112193] systemd[625]: Reload requested from client PID 1652 ('switch-to-confi')... machine # [ 21.113419] systemd[625]: Reloading... machine # [ 21.182705] systemd[625]: Reloading finished in 67 ms. machine # [ 21.187827] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 21.194283] systemd[625]: Stopped Run user-specific NixOS activation. machine # [ 21.196081] systemd[625]: Stopping Run user-specific NixOS activation... machine # [ 21.197706] systemd[625]: Starting Run user-specific NixOS activation... machine # [ 21.217144] systemd[625]: Finished Run user-specific NixOS activation. machine # [ 21.219882] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 21.221212] systemd[1]: Stopping Reactivate sysinit units... machine # [ 21.221929] systemd[1]: Reached target Reactivate sysinit units. machine # [ 21.229181] systemd[1]: Reached target Local File Systems. machine # [ 21.229982] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 21.232903] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 21.234634] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 21.237102] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 21.239817] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 21.242199] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 21.244531] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 21.247113] systemd[1]: Reached target Remote File Systems. machine # [ 21.249493] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 21.250746] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 21.372577] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 21.374278] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 21.377992] systemd[1]: Starting linger-users.service... machine # [ 21.405062] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 21.407271] systemd[1]: Finished linger-users.service. machine # [ 21.664448] nixos[1583]: finished switching to system configuration /nix/store/nbryj79iphx14n1lblf2cm8s3sc137ln-nixos-system-machine-test machine: (finished: must succeed: /nix/store/68vy4glkqv6dl08fwnd37a5r9s71a7b0-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration test 2>&1, in 1.34 seconds) machine: must succeed: /nix/store/68vy4glkqv6dl08fwnd37a5r9s71a7b0-nixos-system-machine-test/specialisation/simpleServiceDifferentDescription/bin/switch-to-configuration test 2>&1 machine # [ 21.890632] nixos[1723]: switching to system configuration /nix/store/09fkr0mhf8798zbbrnzq0arb1x5bvaj8-nixos-system-machine-test machine # [ 21.893554] systemd[1]: Stopped target Local File Systems. machine # [ 21.894931] systemd[1]: Stopped target Remote File Systems. machine # [ 22.111249] systemd[1]: Reload requested from client PID 1723 ('.switch-to-conf') (unit backdoor.service)... machine # [ 22.112903] systemd[1]: Reloading... machine # [ 22.361951] systemd[1]: Reloading finished in 247 ms. machine # [ 22.423100] systemd[625]: Reexecution requested from client PID 1792 ('switch-to-confi')... machine # [ 22.425097] systemd[625]: Reexecuting. machine # [ 22.445387] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 22.520341] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 22.526626] systemd[625]: Reload requested from client PID 1792 ('switch-to-confi')... machine # [ 22.528894] systemd[625]: Reloading... machine # [ 22.600569] systemd[625]: Reloading finished in 72 ms. machine # [ 22.605811] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 22.611880] systemd[625]: Stopped Run user-specific NixOS activation. machine # [ 22.613392] systemd[625]: Stopping Run user-specific NixOS activation... machine # [ 22.615597] systemd[625]: Starting Run user-specific NixOS activation... machine # [ 22.635387] systemd[625]: Finished Run user-specific NixOS activation. machine # [ 22.638374] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 22.639636] systemd[1]: Stopping Reactivate sysinit units... machine # [ 22.640656] systemd[1]: Reached target Reactivate sysinit units. machine # [ 22.643718] systemd[1]: Reached target Remote File Systems. machine # [ 22.646598] systemd[1]: Starting linger-users.service... machine # [ 22.651280] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 22.652843] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 22.660284] systemd[1]: Reached target Local File Systems. machine # [ 22.661123] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 22.665816] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 22.667228] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 22.669624] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 22.671836] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 22.675301] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 22.677195] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 22.708135] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 22.709307] systemd[1]: Finished linger-users.service. machine # [ 22.820641] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 22.822359] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 23.080236] nixos[1723]: finished switching to system configuration /nix/store/09fkr0mhf8798zbbrnzq0arb1x5bvaj8-nixos-system-machine-test machine: (finished: must succeed: /nix/store/68vy4glkqv6dl08fwnd37a5r9s71a7b0-nixos-system-machine-test/specialisation/simpleServiceDifferentDescription/bin/switch-to-configuration test 2>&1, in 1.41 seconds) machine: must succeed: /nix/store/68vy4glkqv6dl08fwnd37a5r9s71a7b0-nixos-system-machine-test/specialisation/simpleServiceModified/bin/switch-to-configuration test 2>&1 machine # [ 23.334333] nixos[1863]: switching to system configuration /nix/store/swxd0473ybx39g3sfm4dqs0w78x6m9ck-nixos-system-machine-test machine # [ 23.336940] systemd[1]: Stopped target Remote File Systems. machine # [ 23.338858] systemd[1]: test.service: Deactivated successfully. machine # [ 23.339789] systemd[1]: Stopped Test unit. machine # [ 23.341266] systemd[1]: Stopped target Local File Systems. machine # [ 23.574385] systemd[1]: Reload requested from client PID 1863 ('.switch-to-conf') (unit backdoor.service)... machine # [ 23.576090] systemd[1]: Reloading... machine # [ 23.825884] systemd[1]: Reloading finished in 247 ms. machine # [ 23.888574] systemd[625]: Reexecution requested from client PID 1933 ('switch-to-confi')... machine # [ 23.891078] systemd[625]: Reexecuting. machine # [ 23.911085] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 23.984522] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 23.989558] systemd[625]: Reload requested from client PID 1933 ('switch-to-confi')... machine # [ 23.991054] systemd[625]: Reloading... machine # [ 24.063244] systemd[625]: Reloading finished in 70 ms. machine # [ 24.068818] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 24.075847] systemd[625]: Stopped Run user-specific NixOS activation. machine # [ 24.076849] systemd[625]: Stopping Run user-specific NixOS activation... machine # [ 24.078601] systemd[625]: Starting Run user-specific NixOS activation... machine # [ 24.099548] systemd[625]: Finished Run user-specific NixOS activation. machine # [ 24.102557] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 24.103879] systemd[1]: Stopping Reactivate sysinit units... machine # [ 24.104943] systemd[1]: Reached target Reactivate sysinit units. machine # [ 24.108608] systemd[1]: Reached target Remote File Systems. machine # [ 24.112673] systemd[1]: Starting test.service... machine # [ 24.116246] systemd[1]: Starting linger-users.service... machine # [ 24.121108] systemd[1]: Reached target Local File Systems. machine # [ 24.121863] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 24.126063] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 24.126841] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 24.128037] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 24.130020] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 24.131525] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 24.132729] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 24.139285] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 24.140767] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 24.164995] systemd[1]: Finished test.service. machine # [ 24.191124] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 24.193381] systemd[1]: Finished linger-users.service. machine # [ 24.298916] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 24.300587] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 24.557708] nixos[1863]: finished switching to system configuration /nix/store/swxd0473ybx39g3sfm4dqs0w78x6m9ck-nixos-system-machine-test machine: (finished: must succeed: /nix/store/68vy4glkqv6dl08fwnd37a5r9s71a7b0-nixos-system-machine-test/specialisation/simpleServiceModified/bin/switch-to-configuration test 2>&1, in 1.48 seconds) machine: must succeed: /nix/store/68vy4glkqv6dl08fwnd37a5r9s71a7b0-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1 machine # [ 24.790338] nixos[2006]: switching to system configuration /nix/store/8ckl6vqxr6vzfc7hm964qzy7h0rfp9yq-nixos-system-machine-test machine # [ 24.792638] systemd[1]: Stopped target Local File Systems. machine # [ 24.794496] systemd[1]: Stopped target Remote File Systems. machine # [ 25.012160] systemd[1]: Reload requested from client PID 2006 ('.switch-to-conf') (unit backdoor.service)... machine # [ 25.013913] systemd[1]: Reloading... machine # [ 25.247782] systemd[1]: Reloading finished in 232 ms. machine # [ 25.310352] systemd[625]: Reexecution requested from client PID 2075 ('switch-to-confi')... machine # [ 25.312448] systemd[625]: Reexecuting. machine # [ 25.333294] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 25.403906] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 25.410033] systemd[625]: Reload requested from client PID 2075 ('switch-to-confi')... machine # [ 25.411845] systemd[625]: Reloading... machine # [ 25.482124] systemd[625]: Reloading finished in 69 ms. machine # [ 25.487811] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 25.494195] systemd[625]: Stopped Run user-specific NixOS activation. machine # [ 25.495103] systemd[625]: Stopping Run user-specific NixOS activation... machine # [ 25.497229] systemd[625]: Starting Run user-specific NixOS activation... machine # [ 25.516339] systemd[625]: Finished Run user-specific NixOS activation. machine # [ 25.519376] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 25.520732] systemd[1]: Stopping Reactivate sysinit units... machine # [ 25.521684] systemd[1]: Reached target Reactivate sysinit units. machine # [ 25.523392] systemd[1]: test.service: Deactivated successfully. machine # [ 25.525125] systemd[1]: Stopped test.service. machine # [ 25.525764] systemd[1]: Stopping test.service... machine # [ 25.527612] systemd[1]: Starting test.service... machine # [ 25.540401] systemd[1]: Finished test.service. machine # [ 25.543918] systemd[1]: Reached target Local File Systems. machine # [ 25.545901] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 25.548977] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 25.549907] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 25.551139] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 25.553150] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 25.556607] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 25.559165] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 25.565624] systemd[1]: Reached target Remote File Systems. machine # [ 25.571062] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 25.572343] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 25.694492] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 25.696227] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 25.699709] systemd[1]: Starting linger-users.service... machine # [ 25.727832] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 25.729405] systemd[1]: Finished linger-users.service. machine # [ 25.985741] nixos[2006]: finished switching to system configuration /nix/store/8ckl6vqxr6vzfc7hm964qzy7h0rfp9yq-nixos-system-machine-test machine: (finished: must succeed: /nix/store/68vy4glkqv6dl08fwnd37a5r9s71a7b0-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1, in 1.43 seconds) machine: must succeed: /nix/store/68vy4glkqv6dl08fwnd37a5r9s71a7b0-nixos-system-machine-test/specialisation/simpleServiceReload/bin/switch-to-configuration test 2>&1 machine # [ 26.231753] nixos[2148]: switching to system configuration /nix/store/vj25yryswl716ig7m6l90f32c89iznax-nixos-system-machine-test machine # [ 26.234096] systemd[1]: Stopped target Local File Systems. machine # [ 26.235820] systemd[1]: Stopped target Remote File Systems. machine # [ 26.484526] systemd[1]: Reload requested from client PID 2148 ('.switch-to-conf') (unit backdoor.service)... machine # [ 26.486391] systemd[1]: Reloading... machine # [ 26.731725] systemd[1]: Reloading finished in 244 ms. machine # [ 26.796119] systemd[625]: Reexecution requested from client PID 2218 ('switch-to-confi')... machine # [ 26.797426] systemd[625]: Reexecuting. machine # [ 26.814327] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 26.887449] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 26.892377] systemd[625]: Reload requested from client PID 2218 ('switch-to-confi')... machine # [ 26.894632] systemd[625]: Reloading... machine # [ 26.964387] systemd[625]: Reloading finished in 70 ms. machine # [ 26.969813] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 26.976797] systemd[625]: Stopped Run user-specific NixOS activation. machine # [ 26.977701] systemd[625]: Stopping Run user-specific NixOS activation... machine # [ 26.979217] systemd[625]: Starting Run user-specific NixOS activation... machine # [ 26.999537] systemd[625]: Finished Run user-specific NixOS activation. machine # [ 27.002506] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 27.003796] systemd[1]: Stopping Reactivate sysinit units... machine # [ 27.004872] systemd[1]: Reached target Reactivate sysinit units. machine # [ 27.007967] systemd[1]: Reloading test.service... machine # [ 27.021712] systemd[1]: Reloaded test.service. machine # [ 27.026240] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 27.027898] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 27.031249] systemd[1]: Reached target Local File Systems. machine # [ 27.035931] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 27.038662] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 27.040353] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 27.042489] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 27.045223] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 27.046935] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 27.049224] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 27.051789] systemd[1]: Reached target Remote File Systems. machine # [ 27.178634] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 27.180291] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 27.183981] systemd[1]: Starting linger-users.service... machine # [ 27.210789] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 27.213390] systemd[1]: Finished linger-users.service. machine # [ 27.469249] nixos[2148]: finished switching to system configuration /nix/store/vj25yryswl716ig7m6l90f32c89iznax-nixos-system-machine-test machine: (finished: must succeed: /nix/store/68vy4glkqv6dl08fwnd37a5r9s71a7b0-nixos-system-machine-test/specialisation/simpleServiceReload/bin/switch-to-configuration test 2>&1, in 1.48 seconds) machine: must succeed: /nix/store/68vy4glkqv6dl08fwnd37a5r9s71a7b0-nixos-system-machine-test/specialisation/simpleServiceNorestart/bin/switch-to-configuration test 2>&1 machine # [ 27.712127] nixos[2291]: switching to system configuration /nix/store/d4l5928gq4qk04dz90ps5sx2y9ynckfy-nixos-system-machine-test machine # [ 27.714586] systemd[1]: Stopped target Local File Systems. machine # [ 27.716556] systemd[1]: Stopped target Remote File Systems. machine # [ 27.942713] systemd[1]: Reload requested from client PID 2291 ('.switch-to-conf') (unit backdoor.service)... machine # [ 27.944339] systemd[1]: Reloading... machine # [ 28.189712] systemd[1]: Reloading finished in 244 ms. machine # [ 28.253326] systemd[625]: Reexecution requested from client PID 2360 ('switch-to-confi')... machine # [ 28.255562] systemd[625]: Reexecuting. machine # [ 28.276067] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 28.347701] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 28.353975] systemd[625]: Reload requested from client PID 2360 ('switch-to-confi')... machine # [ 28.356074] systemd[625]: Reloading... machine # [ 28.426487] systemd[625]: Reloading finished in 70 ms. machine # [ 28.431815] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 28.437938] systemd[625]: Stopped Run user-specific NixOS activation. machine # [ 28.439908] systemd[625]: Stopping Run user-specific NixOS activation... machine # [ 28.441461] systemd[625]: Starting Run user-specific NixOS activation... machine # [ 28.460500] systemd[625]: Finished Run user-specific NixOS activation. machine # [ 28.463388] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 28.464693] systemd[1]: Stopping Reactivate sysinit units... machine # [ 28.465625] systemd[1]: Reached target Reactivate sysinit units. machine # [ 28.468252] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 28.469893] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 28.473949] systemd[1]: Reached target Remote File Systems. machine # [ 28.476944] systemd[1]: Starting linger-users.service... machine # [ 28.484382] systemd[1]: Reached target Local File Systems. machine # [ 28.485223] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 28.488059] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 28.488854] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 28.490895] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 28.493772] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 28.496536] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 28.499342] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 28.532518] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 28.534139] systemd[1]: Finished linger-users.service. machine # [ 28.646419] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 28.648283] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 28.906329] nixos[2291]: finished switching to system configuration /nix/store/d4l5928gq4qk04dz90ps5sx2y9ynckfy-nixos-system-machine-test machine: (finished: must succeed: /nix/store/68vy4glkqv6dl08fwnd37a5r9s71a7b0-nixos-system-machine-test/specialisation/simpleServiceNorestart/bin/switch-to-configuration test 2>&1, in 1.43 seconds) machine: must succeed: /nix/store/68vy4glkqv6dl08fwnd37a5r9s71a7b0-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration dry-activate 2>&1 machine: (finished: must succeed: /nix/store/68vy4glkqv6dl08fwnd37a5r9s71a7b0-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration dry-activate 2>&1, in 0.28 seconds) machine: must succeed: /nix/store/68vy4glkqv6dl08fwnd37a5r9s71a7b0-nixos-system-machine-test/bin/switch-to-configuration test 2>&1 machine # [ 29.382219] nixos[2441]: switching to system configuration /nix/store/68vy4glkqv6dl08fwnd37a5r9s71a7b0-nixos-system-machine-test machine # [ 29.384661] systemd[1]: Stopped target Local File Systems. machine # [ 29.386685] systemd[1]: test.service: Deactivated successfully. machine # [ 29.388109] systemd[1]: Stopped test.service. machine # [ 29.388775] systemd[1]: Stopped target Remote File Systems. machine # [ 29.597601] systemd[1]: Reload requested from client PID 2441 ('.switch-to-conf') (unit backdoor.service)... machine # [ 29.601048] systemd[1]: Reloading... machine # [ 29.835776] systemd[1]: Reloading finished in 234 ms. machine # [ 29.921077] systemd[625]: Reexecution requested from client PID 2510 ('switch-to-confi')... machine # [ 29.922441] systemd[625]: Reexecuting. machine # [ 29.942068] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 30.014300] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 30.019373] systemd[625]: Reload requested from client PID 2510 ('switch-to-confi')... machine # [ 30.021742] systemd[625]: Reloading... machine # [ 30.092248] systemd[625]: Reloading finished in 70 ms. machine # [ 30.097819] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 30.103825] systemd[625]: Stopped Run user-specific NixOS activation. machine # [ 30.105325] systemd[625]: Stopping Run user-specific NixOS activation... machine # [ 30.107416] systemd[625]: Starting Run user-specific NixOS activation... machine # [ 30.126321] systemd[625]: Finished Run user-specific NixOS activation. machine # [ 30.129291] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 30.130602] systemd[1]: Stopping Reactivate sysinit units... machine # [ 30.131581] systemd[1]: Reached target Reactivate sysinit units. machine # [ 30.136264] systemd[1]: Reached target Local File Systems. machine # [ 30.137129] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 30.140486] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 30.141398] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 30.142586] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 30.144602] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 30.146109] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 30.147308] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 30.152275] systemd[1]: Reached target Remote File Systems. machine # [ 30.155836] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 30.157041] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 30.286591] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 30.288282] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 30.291986] systemd[1]: Starting linger-users.service... machine # [ 30.319641] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 30.321208] systemd[1]: Finished linger-users.service. machine # [ 30.577575] nixos[2441]: finished switching to system configuration /nix/store/68vy4glkqv6dl08fwnd37a5r9s71a7b0-nixos-system-machine-test machine: (finished: must succeed: /nix/store/68vy4glkqv6dl08fwnd37a5r9s71a7b0-nixos-system-machine-test/bin/switch-to-configuration test 2>&1, in 1.39 seconds) machine: must succeed: /nix/store/b3sz7dwi62lkab2qhwvjv4zkpmak8bn0-separate-activation-script/bin/switch-to-configuration test 2>&1 machine # [ 30.796707] nixos[2582]: switching to system configuration /nix/store/127g75ngjz4a6rg7n7pd315c4jpzv5a4-nixos-system-machine-test machine # [ 30.799879] systemd[1]: Stopped target Local File Systems. machine # [ 30.800953] systemd[1]: Stopped target Remote File Systems. machine # [ 31.025234] systemd[1]: Reload requested from client PID 2582 ('.switch-to-conf') (unit backdoor.service)... machine # [ 31.026770] systemd[1]: Reloading... machine # [ 31.261957] systemd[1]: Reloading finished in 233 ms. machine # [ 31.327231] systemd[625]: Stopped Run user-specific NixOS activation. machine # [ 31.328416] systemd[625]: Reexecution requested from client PID 2651 ('switch-to-confi')... machine # [ 31.330633] systemd[625]: Reexecuting. machine # [ 31.350182] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 31.425749] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 31.431053] systemd[625]: Reload requested from client PID 2651 ('switch-to-confi')... machine # [ 31.432496] systemd[625]: Reloading... machine # [ 31.503816] systemd[625]: Reloading finished in 70 ms. machine # [ 31.508835] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 31.515733] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 31.517337] systemd[1]: Stopping Reactivate sysinit units... machine # [ 31.518335] systemd[1]: Reached target Reactivate sysinit units. machine # [ 31.520083] systemd[1]: Reached target Remote File Systems. machine # [ 31.523109] systemd[1]: Starting linger-users.service... machine # [ 31.527303] systemd[1]: Starting test.service... machine # [ 31.529384] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 31.531114] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 31.539057] systemd[1]: Reached target Local File Systems. machine # [ 31.539818] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 31.543673] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 31.544491] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 31.546576] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 31.549397] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 31.552188] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 31.553462] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 31.581269] systemd[1]: Finished test.service. machine # [ 31.599483] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 31.601109] systemd[1]: Finished linger-users.service. machine # [ 31.707427] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 31.709260] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 31.966994] nixos[2582]: finished switching to system configuration /nix/store/127g75ngjz4a6rg7n7pd315c4jpzv5a4-nixos-system-machine-test machine: (finished: must succeed: /nix/store/b3sz7dwi62lkab2qhwvjv4zkpmak8bn0-separate-activation-script/bin/switch-to-configuration test 2>&1, in 1.39 seconds) machine: must succeed: ! test -e /run/current-system/activate machine: (finished: must succeed: ! test -e /run/current-system/activate, in 0.02 seconds) machine: must succeed: ! test -e /run/current-system/dry-activate machine: (finished: must succeed: ! test -e /run/current-system/dry-activate, in 0.02 seconds) machine: must succeed: ! test -e /run/current-system/bin/switch-to-configuration machine: (finished: must succeed: ! test -e /run/current-system/bin/switch-to-configuration, in 0.01 seconds) machine: must succeed: /nix/store/68vy4glkqv6dl08fwnd37a5r9s71a7b0-nixos-system-machine-test/specialisation/unitWithMultilineValue/bin/switch-to-configuration test 2>&1 machine # [ 32.223495] nixos[2730]: switching to system configuration /nix/store/iajy1v1840bqhk6gfghn9399bhv3352x-nixos-system-machine-test machine # [ 32.226053] systemd[1]: Stopped target Local File Systems. machine # [ 32.228564] systemd[1]: Stopped target Remote File Systems. machine # [ 32.229707] systemd[1]: test.service: Deactivated successfully. machine # [ 32.230785] systemd[1]: Stopped test.service. machine # [ 32.448767] systemd[1]: Reload requested from client PID 2730 ('.switch-to-conf') (unit backdoor.service)... machine # [ 32.450422] systemd[1]: Reloading... machine # [ 32.685130] systemd[1]: Reloading finished in 232 ms. machine # [ 32.742157] systemd[625]: Reexecution requested from client PID 2799 ('switch-to-confi')... machine # [ 32.743907] systemd[625]: Reexecuting. machine # [ 32.764256] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 32.863899] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 32.869648] systemd[625]: Reload requested from client PID 2799 ('switch-to-confi')... machine # [ 32.871134] systemd[625]: Reloading... machine # [ 32.940383] systemd[625]: Reloading finished in 67 ms. machine # [ 32.944816] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 32.951613] systemd[625]: Starting Run user-specific NixOS activation... machine # [ 32.971111] systemd[625]: Finished Run user-specific NixOS activation. machine # [ 32.973530] systemd[625]: Stopped Run user-specific NixOS activation. machine # [ 32.975358] systemd[625]: Stopping Run user-specific NixOS activation... machine # [ 32.978419] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 32.979820] systemd[625]: Starting Run user-specific NixOS activation... machine # [ 32.982231] systemd[1]: Stopping Reactivate sysinit units... machine # [ 32.983126] systemd[1]: Reached target Reactivate sysinit units. machine # [ 32.988690] systemd[1]: Started test.service. machine # [ 32.994253] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 32.995545] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 33.001642] systemd[1]: Reached target Local File Systems. machine # [ 33.007024] systemd[1]: Reached target Remote File Systems. machine # [ 33.017773] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 33.025547] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 33.026639] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 33.028973] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 33.031937] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 33.036138] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 33.037446] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 33.038614] systemd[625]: Finished Run user-specific NixOS activation. machine # [ 33.046077] systemd[1]: test.service: Deactivated successfully. machine # [ 33.168040] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 33.169684] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 33.173809] systemd[1]: Starting linger-users.service... machine # [ 33.199852] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 33.202079] systemd[1]: Finished linger-users.service. machine # [ 33.459131] nixos[2730]: finished switching to system configuration /nix/store/iajy1v1840bqhk6gfghn9399bhv3352x-nixos-system-machine-test machine: (finished: must succeed: /nix/store/68vy4glkqv6dl08fwnd37a5r9s71a7b0-nixos-system-machine-test/specialisation/unitWithMultilineValue/bin/switch-to-configuration test 2>&1, in 1.44 seconds) machine: must succeed: /nix/store/68vy4glkqv6dl08fwnd37a5r9s71a7b0-nixos-system-machine-test/specialisation/unitWithBackslash/bin/switch-to-configuration test 2>&1 machine # [ 33.680875] nixos[2876]: switching to system configuration /nix/store/qzx9hpq0awnbqpyk20pxwc18v7f2q40c-nixos-system-machine-test machine # [ 33.683548] systemd[1]: Stopped target Remote File Systems. machine # [ 33.685269] systemd[1]: Stopped target Local File Systems. machine # [ 33.904206] systemd[1]: Reload requested from client PID 2876 ('.switch-to-conf') (unit backdoor.service)... machine # [ 33.905675] systemd[1]: Reloading... machine # [ 34.149708] systemd[1]: Reloading finished in 242 ms. machine # [ 34.208359] systemd[625]: Reexecution requested from client PID 2945 ('switch-to-confi')... machine # [ 34.210776] systemd[625]: Reexecuting. machine # [ 34.231061] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 34.300301] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 34.305391] systemd[625]: Reload requested from client PID 2945 ('switch-to-confi')... machine # [ 34.307933] systemd[625]: Reloading... machine # [ 34.376483] systemd[625]: Reloading finished in 68 ms. machine # [ 34.380824] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 34.387228] systemd[625]: Stopped Run user-specific NixOS activation. machine # [ 34.388074] systemd[625]: Stopping Run user-specific NixOS activation... machine # [ 34.390232] systemd[625]: Starting Run user-specific NixOS activation... machine # [ 34.409121] systemd[625]: Finished Run user-specific NixOS activation. machine # [ 34.412369] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 34.413729] systemd[1]: Stopping Reactivate sysinit units... machine # [ 34.414725] systemd[1]: Reached target Reactivate sysinit units. machine # [ 34.417860] systemd[1]: Reached target Remote File Systems. machine # [ 34.419261] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 34.420850] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 34.425290] systemd[1]: Reached target Local File Systems. machine # [ 34.427361] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 34.429499] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 34.431516] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 34.433706] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 34.437308] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 34.439287] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 34.442460] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 34.565718] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 34.567418] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 34.571948] systemd[1]: Starting escaped\x2ddash.service... machine # [ 34.573782] systemd[1]: Starting linger-users.service... machine # [ 34.595941] systemd[1]: Finished escaped\x2ddash.service. machine # [ 34.609448] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 34.611074] systemd[1]: Finished linger-users.service. machine # [ 34.868551] nixos[2876]: finished switching to system configuration /nix/store/qzx9hpq0awnbqpyk20pxwc18v7f2q40c-nixos-system-machine-test machine: (finished: must succeed: /nix/store/68vy4glkqv6dl08fwnd37a5r9s71a7b0-nixos-system-machine-test/specialisation/unitWithBackslash/bin/switch-to-configuration test 2>&1, in 1.41 seconds) machine: must succeed: /nix/store/68vy4glkqv6dl08fwnd37a5r9s71a7b0-nixos-system-machine-test/specialisation/unitWithBackslashModified/bin/switch-to-configuration test 2>&1 machine # [ 35.093941] nixos[3018]: switching to system configuration /nix/store/a3nhqh6rqzh79h9yj1cwaw1kl5v3in7i-nixos-system-machine-test machine # [ 35.096435] systemd[1]: escaped\x2ddash.service: Deactivated successfully. machine # [ 35.098783] systemd[1]: Stopped escaped\x2ddash.service. machine # [ 35.099930] systemd[1]: Stopped target Remote File Systems. machine # [ 35.101133] systemd[1]: Stopped target Local File Systems. machine # [ 35.320176] systemd[1]: Reload requested from client PID 3018 ('.switch-to-conf') (unit backdoor.service)... machine # [ 35.321876] systemd[1]: Reloading... machine # [ 35.556409] systemd[1]: Reloading finished in 233 ms. machine # [ 35.617172] systemd[625]: Reexecution requested from client PID 3087 ('switch-to-confi')... machine # [ 35.618992] systemd[625]: Reexecuting. machine # [ 35.640064] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 35.711537] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 35.716533] systemd[625]: Reload requested from client PID 3087 ('switch-to-confi')... machine # [ 35.717962] systemd[625]: Reloading... machine # [ 35.790500] systemd[625]: Reloading finished in 71 ms. machine # [ 35.795846] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 35.801876] systemd[625]: Stopped Run user-specific NixOS activation. machine # [ 35.802907] systemd[625]: Stopping Run user-specific NixOS activation... machine # [ 35.805252] systemd[625]: Starting Run user-specific NixOS activation... machine # [ 35.824282] systemd[625]: Finished Run user-specific NixOS activation. machine # [ 35.827305] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 35.828432] systemd[1]: Stopping Reactivate sysinit units... machine # [ 35.829421] systemd[1]: Reached target Reactivate sysinit units. machine # [ 35.834547] systemd[1]: Reached target Local File Systems. machine # [ 35.836366] systemd[1]: Reached target Remote File Systems. machine # [ 35.839052] systemd[1]: Starting escaped\x2ddash.service... machine # [ 35.840921] systemd[1]: Starting linger-users.service... machine # [ 35.847379] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 35.850513] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 35.851507] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 35.854266] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 35.856399] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 35.858448] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 35.859590] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 35.868630] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 35.869880] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 35.914697] systemd[1]: Finished escaped\x2ddash.service. machine # [ 35.934963] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 35.936791] systemd[1]: Finished linger-users.service. machine # [ 36.074960] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 36.076844] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 36.333691] nixos[3018]: finished switching to system configuration /nix/store/a3nhqh6rqzh79h9yj1cwaw1kl5v3in7i-nixos-system-machine-test machine: (finished: must succeed: /nix/store/68vy4glkqv6dl08fwnd37a5r9s71a7b0-nixos-system-machine-test/specialisation/unitWithBackslashModified/bin/switch-to-configuration test 2>&1, in 1.47 seconds) machine: must succeed: /nix/store/68vy4glkqv6dl08fwnd37a5r9s71a7b0-nixos-system-machine-test/specialisation/unitStartingWithDash/bin/switch-to-configuration test 2>&1 machine # [ 36.588719] nixos[3161]: switching to system configuration /nix/store/br2wlzzq9f56zc2xigdmjwdbzg8wsn65-nixos-system-machine-test machine # [ 36.591690] systemd[1]: escaped\x2ddash.service: Deactivated successfully. machine # [ 36.593545] systemd[1]: Stopped escaped\x2ddash.service. machine # [ 36.595211] systemd[1]: Stopped target Local File Systems. machine # [ 36.595964] systemd[1]: Stopped target Remote File Systems. machine # [ 36.824292] systemd[1]: Reload requested from client PID 3161 ('.switch-to-conf') (unit backdoor.service)... machine # [ 36.825871] systemd[1]: Reloading... machine # [ 37.075487] systemd[1]: Reloading finished in 248 ms. machine # [ 37.137402] systemd[625]: Reexecution requested from client PID 3230 ('switch-to-confi')... machine # [ 37.138699] systemd[625]: Reexecuting. machine # [ 37.154959] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 37.224372] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 37.229456] systemd[625]: Reload requested from client PID 3230 ('switch-to-confi')... machine # [ 37.230894] systemd[625]: Reloading... machine # [ 37.300454] systemd[625]: Reloading finished in 68 ms. machine # [ 37.305809] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 37.311768] systemd[625]: Stopped Run user-specific NixOS activation. machine # [ 37.313263] systemd[625]: Stopping Run user-specific NixOS activation... machine # [ 37.315184] systemd[625]: Starting Run user-specific NixOS activation... machine # [ 37.333863] systemd[625]: Finished Run user-specific NixOS activation. machine # [ 37.336736] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 37.338348] systemd[1]: Stopping Reactivate sysinit units... machine # [ 37.339375] systemd[1]: Reached target Reactivate sysinit units. machine # [ 37.340631] systemd[1]: Reached target Remote File Systems. machine # [ 37.342850] systemd[1]: Reached target Local File Systems. machine # [ 37.344893] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 37.346645] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 37.350904] systemd[1]: Starting -.service... machine # [ 37.354980] systemd[1]: Starting linger-users.service... machine # [ 37.360713] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 37.366882] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 37.367743] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 37.369653] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 37.371700] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 37.376139] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 37.377430] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 37.395820] systemd[1]: Finished -.service. machine # [ 37.421307] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 37.423137] systemd[1]: Finished linger-users.service. machine # [ 37.525825] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 37.527730] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 37.786518] nixos[3161]: finished switching to system configuration /nix/store/br2wlzzq9f56zc2xigdmjwdbzg8wsn65-nixos-system-machine-test machine: (finished: must succeed: /nix/store/68vy4glkqv6dl08fwnd37a5r9s71a7b0-nixos-system-machine-test/specialisation/unitStartingWithDash/bin/switch-to-configuration test 2>&1, in 1.45 seconds) machine: must succeed: /nix/store/68vy4glkqv6dl08fwnd37a5r9s71a7b0-nixos-system-machine-test/specialisation/unitStartingWithDashModified/bin/switch-to-configuration test 2>&1 machine # [ 38.012501] nixos[3303]: switching to system configuration /nix/store/df331gl9v1q4s6jb7yshb5f9fmrxqqpn-nixos-system-machine-test machine # [ 38.014690] systemd[1]: Stopped target Remote File Systems. machine # [ 38.016190] systemd[1]: Stopped target Local File Systems. machine # [ 38.236559] systemd[1]: Reload requested from client PID 3303 ('.switch-to-conf') (unit backdoor.service)... machine # [ 38.238171] systemd[1]: Reloading... machine # [ 38.474844] systemd[1]: Reloading finished in 234 ms. machine # [ 38.534331] systemd[625]: Reexecution requested from client PID 3372 ('switch-to-confi')... machine # [ 38.535579] systemd[625]: Reexecuting. machine # [ 38.554942] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 38.623677] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 38.629189] systemd[625]: Reload requested from client PID 3372 ('switch-to-confi')... machine # [ 38.631135] systemd[625]: Reloading... machine # [ 38.699981] systemd[625]: Reloading finished in 68 ms. machine # [ 38.705827] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 38.712807] systemd[625]: Stopped Run user-specific NixOS activation. machine # [ 38.713728] systemd[625]: Stopping Run user-specific NixOS activation... machine # [ 38.715220] systemd[625]: Starting Run user-specific NixOS activation... machine # [ 38.733884] systemd[625]: Finished Run user-specific NixOS activation. machine # [ 38.736734] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 38.738159] systemd[1]: Stopping Reactivate sysinit units... machine # [ 38.738945] systemd[1]: Reached target Reactivate sysinit units. machine # [ 38.742688] systemd[1]: Reloading -.service... machine # [ 38.757158] systemd[1]: Reloaded -.service. machine # [ 38.762061] systemd[1]: Reached target Local File Systems. machine # [ 38.762856] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 38.768241] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 38.769354] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 38.770545] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 38.773400] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 38.774873] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 38.776103] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 38.780765] systemd[1]: Reached target Remote File Systems. machine # [ 38.783258] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 38.785453] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 38.909126] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 38.910740] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 38.914724] systemd[1]: Starting linger-users.service... machine # [ 38.941780] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 38.943359] systemd[1]: Finished linger-users.service. machine # [ 39.202795] nixos[3303]: finished switching to system configuration /nix/store/df331gl9v1q4s6jb7yshb5f9fmrxqqpn-nixos-system-machine-test machine: (finished: must succeed: /nix/store/68vy4glkqv6dl08fwnd37a5r9s71a7b0-nixos-system-machine-test/specialisation/unitStartingWithDashModified/bin/switch-to-configuration test 2>&1, in 1.42 seconds) machine: must succeed: /nix/store/68vy4glkqv6dl08fwnd37a5r9s71a7b0-nixos-system-machine-test/specialisation/unitWithRequirement/bin/switch-to-configuration test 2>&1 machine # [ 39.460230] nixos[3445]: switching to system configuration /nix/store/4bam5a5lbz65fzb51yjrcgli1zxwd3vg-nixos-system-machine-test machine # [ 39.462570] systemd[1]: -.service: Deactivated successfully. machine # [ 39.464837] systemd[1]: Stopped -.service. machine # [ 39.465666] systemd[1]: Stopped target Local File Systems. machine # [ 39.466826] systemd[1]: Stopped target Remote File Systems. machine # [ 39.690170] systemd[1]: Reload requested from client PID 3445 ('.switch-to-conf') (unit backdoor.service)... machine # [ 39.691817] systemd[1]: Reloading... machine # [ 39.952199] systemd[1]: Reloading finished in 258 ms. machine # [ 40.015291] systemd[625]: Reexecution requested from client PID 3515 ('switch-to-confi')... machine # [ 40.017903] systemd[625]: Reexecuting. machine # [ 40.040266] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 40.112367] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 40.117378] systemd[625]: Reload requested from client PID 3515 ('switch-to-confi')... machine # [ 40.119594] systemd[625]: Reloading... machine # [ 40.189717] systemd[625]: Reloading finished in 70 ms. machine # [ 40.195824] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 40.201885] systemd[625]: Stopped Run user-specific NixOS activation. machine # [ 40.202958] systemd[625]: Stopping Run user-specific NixOS activation... machine # [ 40.205607] systemd[625]: Starting Run user-specific NixOS activation... machine # [ 40.224324] systemd[625]: Finished Run user-specific NixOS activation. machine # [ 40.227256] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 40.228532] systemd[1]: Stopping Reactivate sysinit units... machine # [ 40.229460] systemd[1]: Reached target Reactivate sysinit units. machine # [ 40.233697] systemd[1]: Reached target Remote File Systems. machine # [ 40.237084] systemd[1]: Starting linger-users.service... machine # [ 40.239063] systemd[1]: Starting required-service.service... machine # [ 40.244123] systemd[1]: Starting test-service.service... machine # [ 40.251405] systemd[1]: Reached target Local File Systems. machine # [ 40.255561] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 40.256812] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 40.263088] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 40.267675] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 40.268510] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 40.270675] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 40.273830] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 40.276240] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 40.279158] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 40.299409] systemd[1]: Finished test-service.service. machine # [ 40.302413] systemd[1]: Finished required-service.service. machine # [ 40.322634] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 40.324567] systemd[1]: Finished linger-users.service. machine # [ 40.435084] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 40.436732] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 40.694789] nixos[3445]: finished switching to system configuration /nix/store/4bam5a5lbz65fzb51yjrcgli1zxwd3vg-nixos-system-machine-test machine: (finished: must succeed: /nix/store/68vy4glkqv6dl08fwnd37a5r9s71a7b0-nixos-system-machine-test/specialisation/unitWithRequirement/bin/switch-to-configuration test 2>&1, in 1.49 seconds) machine: must succeed: /nix/store/68vy4glkqv6dl08fwnd37a5r9s71a7b0-nixos-system-machine-test/specialisation/unitWithRequirementModified/bin/switch-to-configuration test 2>&1 machine # [ 40.933762] nixos[3590]: switching to system configuration /nix/store/wyijarsv7qcz0mnk77ii2f54zq9phci6-nixos-system-machine-test machine # [ 40.936314] systemd[1]: Stopped target Remote File Systems. machine # [ 40.938863] systemd[1]: required-service.service: Deactivated successfully. machine # [ 40.939927] systemd[1]: Stopped required-service.service. machine # [ 40.940733] systemd[1]: test-service.service: Deactivated successfully. machine # [ 40.941729] systemd[1]: Stopped test-service.service. machine # [ 40.942832] systemd[1]: Stopped target Local File Systems. machine # [ 41.166655] systemd[1]: Reload requested from client PID 3590 ('.switch-to-conf') (unit backdoor.service)... machine # [ 41.168423] systemd[1]: Reloading... machine # [ 41.412829] systemd[1]: Reloading finished in 243 ms. machine # [ 41.476324] systemd[625]: Reexecution requested from client PID 3659 ('switch-to-confi')... machine # [ 41.478404] systemd[625]: Reexecuting. machine # [ 41.499100] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 41.571313] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 41.576538] systemd[625]: Reload requested from client PID 3659 ('switch-to-confi')... machine # [ 41.578888] systemd[625]: Reloading... machine # [ 41.649106] systemd[625]: Reloading finished in 70 ms. machine # [ 41.654093] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 41.661408] systemd[625]: Stopped Run user-specific NixOS activation. machine # [ 41.662412] systemd[625]: Stopping Run user-specific NixOS activation... machine # [ 41.664881] systemd[625]: Starting Run user-specific NixOS activation... machine # [ 41.684512] systemd[625]: Finished Run user-specific NixOS activation. machine # [ 41.687559] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 41.688827] systemd[1]: Stopping Reactivate sysinit units... machine # [ 41.689917] systemd[1]: Reached target Reactivate sysinit units. machine # [ 41.697079] systemd[1]: Reached target Local File Systems. machine # [ 41.699297] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 41.701646] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 41.703218] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 41.705211] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 41.707160] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 41.708702] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 41.709911] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 41.716880] systemd[1]: Reached target Remote File Systems. machine # [ 41.719321] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 41.720507] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 41.848144] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 41.849829] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 41.854112] systemd[1]: Starting linger-users.service... machine # [ 41.856166] systemd[1]: Starting required-service.service... machine # [ 41.859961] systemd[1]: Starting test-service.service... machine # [ 41.890055] systemd[1]: Finished required-service.service. machine # [ 41.892372] systemd[1]: Finished test-service.service. machine # [ 41.904899] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 41.906346] systemd[1]: Finished linger-users.service. machine # [ 42.164550] nixos[3590]: finished switching to system configuration /nix/store/wyijarsv7qcz0mnk77ii2f54zq9phci6-nixos-system-machine-test machine: (finished: must succeed: /nix/store/68vy4glkqv6dl08fwnd37a5r9s71a7b0-nixos-system-machine-test/specialisation/unitWithRequirementModified/bin/switch-to-configuration test 2>&1, in 1.47 seconds) machine: must succeed: /nix/store/68vy4glkqv6dl08fwnd37a5r9s71a7b0-nixos-system-machine-test/specialisation/unitWithRequirementModifiedNostart/bin/switch-to-configuration test 2>&1 machine # [ 42.413986] nixos[3734]: switching to system configuration /nix/store/ll03mblkv7qsd7gidcipjsy1a1lpbdgm-nixos-system-machine-test machine # [ 42.416452] systemd[1]: Stopped target Local File Systems. machine # [ 42.418390] systemd[1]: required-service.service: Deactivated successfully. machine # [ 42.420108] systemd[1]: Stopped required-service.service. machine # [ 42.420870] systemd[1]: test-service.service: Deactivated successfully. machine # [ 42.422654] systemd[1]: Stopped test-service.service. machine # [ 42.423454] systemd[1]: Stopped target Remote File Systems. machine # [ 42.648327] systemd[1]: Reload requested from client PID 3734 ('.switch-to-conf') (unit backdoor.service)... machine # [ 42.649920] systemd[1]: Reloading... machine # [ 42.896851] systemd[1]: Reloading finished in 245 ms. machine # [ 42.959724] systemd[625]: Reexecution requested from client PID 3803 ('switch-to-confi')... machine # [ 42.961761] systemd[625]: Reexecuting. machine # [ 42.984233] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 43.056245] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 43.061596] systemd[625]: Reload requested from client PID 3803 ('switch-to-confi')... machine # [ 43.062944] systemd[625]: Reloading... machine # [ 43.135457] systemd[625]: Reloading finished in 70 ms. machine # [ 43.139815] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 43.146894] systemd[625]: Stopped Run user-specific NixOS activation. machine # [ 43.147812] systemd[625]: Stopping Run user-specific NixOS activation... machine # [ 43.149513] systemd[625]: Starting Run user-specific NixOS activation... machine # [ 43.168550] systemd[625]: Finished Run user-specific NixOS activation. machine # [ 43.171529] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 43.172858] systemd[1]: Stopping Reactivate sysinit units... machine # [ 43.173881] systemd[1]: Reached target Reactivate sysinit units. machine # [ 43.178895] systemd[1]: Reached target Remote File Systems. machine # [ 43.181890] systemd[1]: Reached target Local File Systems. machine # [ 43.183351] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 43.186756] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 43.187598] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 43.188785] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 43.190830] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 43.192386] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 43.193576] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 43.200753] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 43.202408] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 43.333097] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 43.334715] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 43.339233] systemd[1]: Starting linger-users.service... machine # [ 43.340586] systemd[1]: Starting required-service.service... machine # [ 43.347066] systemd[1]: Starting test-service.service... machine # [ 43.373894] systemd[1]: Finished test-service.service. machine # [ 43.376073] systemd[1]: Finished required-service.service. machine # [ 43.389170] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 43.390572] systemd[1]: Finished linger-users.service. machine # [ 43.647954] nixos[3734]: finished switching to system configuration /nix/store/ll03mblkv7qsd7gidcipjsy1a1lpbdgm-nixos-system-machine-test machine: (finished: must succeed: /nix/store/68vy4glkqv6dl08fwnd37a5r9s71a7b0-nixos-system-machine-test/specialisation/unitWithRequirementModifiedNostart/bin/switch-to-configuration test 2>&1, in 1.48 seconds) machine: must succeed: /nix/store/68vy4glkqv6dl08fwnd37a5r9s71a7b0-nixos-system-machine-test/specialisation/unitWithTemplate/bin/switch-to-configuration test 2>&1 machine # [ 43.887992] nixos[3878]: switching to system configuration /nix/store/jyry74srnyxanms6zld4qibbqv8m8nif-nixos-system-machine-test machine # [ 43.890560] systemd[1]: Stopped target Remote File Systems. machine # [ 43.893082] systemd[1]: required-service.service: Deactivated successfully. machine # [ 43.894062] systemd[1]: Stopped required-service.service. machine # [ 43.894834] systemd[1]: test-service.service: Deactivated successfully. machine # [ 43.896702] systemd[1]: Stopped test-service.service. machine # [ 43.898156] systemd[1]: Stopped target Local File Systems. machine # [ 44.104657] systemd[1]: Reload requested from client PID 3878 ('.switch-to-conf') (unit backdoor.service)... machine # [ 44.106169] systemd[1]: Reloading... machine # [ 44.360918] systemd[1]: Reloading finished in 252 ms. machine # [ 44.421495] systemd[625]: Reexecution requested from client PID 3947 ('switch-to-confi')... machine # [ 44.423960] systemd[625]: Reexecuting. machine # [ 44.443030] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 44.515779] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 44.521272] systemd[625]: Reload requested from client PID 3947 ('switch-to-confi')... machine # [ 44.522683] systemd[625]: Reloading... machine # [ 44.594812] systemd[625]: Reloading finished in 70 ms. machine # [ 44.600827] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 44.607224] systemd[625]: Stopped Run user-specific NixOS activation. machine # [ 44.608096] systemd[625]: Stopping Run user-specific NixOS activation... machine # [ 44.610220] systemd[625]: Starting Run user-specific NixOS activation... machine # [ 44.629432] systemd[625]: Finished Run user-specific NixOS activation. machine # [ 44.632501] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 44.633704] systemd[1]: Stopping Reactivate sysinit units... machine # [ 44.634752] systemd[1]: Reached target Reactivate sysinit units. machine # [ 44.636182] systemd[1]: Reached target Remote File Systems. machine # [ 44.639268] systemd[1]: Reached target Local File Systems. machine # [ 44.641350] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 44.644117] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 44.644948] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 44.646544] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 44.649375] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 44.650880] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 44.654202] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 44.658277] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 44.659761] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 44.666979] systemd[1]: Created slice Slice /system/instantiated. machine # [ 44.791709] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 44.793355] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 44.796990] systemd[1]: Starting instantiated@one.service... machine # [ 44.799384] systemd[1]: Starting instantiated@two.service... machine # [ 44.803376] systemd[1]: Starting linger-users.service... machine # [ 44.831369] systemd[1]: Finished instantiated@two.service. machine # [ 44.834157] systemd[1]: Finished instantiated@one.service. machine # [ 44.849873] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 44.852208] systemd[1]: Finished linger-users.service. machine # [ 45.109417] nixos[3878]: finished switching to system configuration /nix/store/jyry74srnyxanms6zld4qibbqv8m8nif-nixos-system-machine-test machine: (finished: must succeed: /nix/store/68vy4glkqv6dl08fwnd37a5r9s71a7b0-nixos-system-machine-test/specialisation/unitWithTemplate/bin/switch-to-configuration test 2>&1, in 1.46 seconds) machine: must succeed: /nix/store/68vy4glkqv6dl08fwnd37a5r9s71a7b0-nixos-system-machine-test/specialisation/unitWithTemplateModified/bin/switch-to-configuration test 2>&1 machine # [ 45.370314] nixos[4022]: switching to system configuration /nix/store/2r37y6hra2hkcfgkn21mybidrq3y8ma3-nixos-system-machine-test machine # [ 45.372710] systemd[1]: Stopped target Local File Systems. machine # [ 45.374310] systemd[1]: Stopped target Remote File Systems. machine # [ 45.375885] systemd[1]: instantiated@two.service: Deactivated successfully. machine # [ 45.377482] systemd[1]: Stopped instantiated@two.service. machine # [ 45.378926] systemd[1]: instantiated@one.service: Deactivated successfully. machine # [ 45.380317] systemd[1]: Stopped instantiated@one.service. machine # [ 45.604097] systemd[1]: Reload requested from client PID 4022 ('.switch-to-conf') (unit backdoor.service)... machine # [ 45.605809] systemd[1]: Reloading... machine # [ 45.853098] systemd[1]: Reloading finished in 245 ms. machine # [ 45.915272] systemd[625]: Reexecution requested from client PID 4091 ('switch-to-confi')... machine # [ 45.917394] systemd[625]: Reexecuting. machine # [ 45.937045] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 46.009372] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 46.014066] systemd[625]: Reload requested from client PID 4091 ('switch-to-confi')... machine # [ 46.015875] systemd[625]: Reloading... machine # [ 46.086705] systemd[625]: Reloading finished in 69 ms. machine # [ 46.091830] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 46.099068] systemd[625]: Stopped Run user-specific NixOS activation. machine # [ 46.100067] systemd[625]: Stopping Run user-specific NixOS activation... machine # [ 46.101901] systemd[625]: Starting Run user-specific NixOS activation... machine # [ 46.121487] systemd[625]: Finished Run user-specific NixOS activation. machine # [ 46.124523] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 46.125775] systemd[1]: Stopping Reactivate sysinit units... machine # [ 46.126962] systemd[1]: Reached target Reactivate sysinit units. machine # [ 46.128913] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 46.130646] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 46.136915] systemd[1]: Reached target Local File Systems. machine # [ 46.138449] systemd[1]: Reached target Remote File Systems. machine # [ 46.142906] systemd[1]: Starting instantiated@two.service... machine # [ 46.146064] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 46.150326] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 46.152412] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 46.153606] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 46.155579] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 46.159422] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 46.160701] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 46.181732] systemd[1]: Finished instantiated@two.service. machine # [ 46.296446] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 46.298233] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 46.302122] systemd[1]: Starting instantiated@one.service... machine # [ 46.305958] systemd[1]: Starting linger-users.service... machine # [ 46.328109] systemd[1]: Finished instantiated@one.service. machine # [ 46.341708] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 46.343160] systemd[1]: Finished linger-users.service. machine # [ 46.599648] nixos[4022]: finished switching to system configuration /nix/store/2r37y6hra2hkcfgkn21mybidrq3y8ma3-nixos-system-machine-test machine: (finished: must succeed: /nix/store/68vy4glkqv6dl08fwnd37a5r9s71a7b0-nixos-system-machine-test/specialisation/unitWithTemplateModified/bin/switch-to-configuration test 2>&1, in 1.49 seconds) (finished: subtest: services, in 30.61 seconds) subtest: failing units machine: must succeed: /nix/store/68vy4glkqv6dl08fwnd37a5r9s71a7b0-nixos-system-machine-test/specialisation/simpleServiceModified/bin/switch-to-configuration test 2>&1 machine # [ 46.825922] nixos[4166]: switching to system configuration /nix/store/swxd0473ybx39g3sfm4dqs0w78x6m9ck-nixos-system-machine-test machine # [ 46.828396] systemd[1]: instantiated@one.service: Deactivated successfully. machine # [ 46.830118] systemd[1]: Stopped instantiated@one.service. machine # [ 46.831336] systemd[1]: Stopped target Remote File Systems. machine # [ 46.832803] systemd[1]: instantiated@two.service: Deactivated successfully. machine # [ 46.834240] systemd[1]: Stopped instantiated@two.service. machine # [ 46.835629] systemd[1]: Stopped target Local File Systems. machine # [ 47.039824] systemd[1]: Reload requested from client PID 4166 ('.switch-to-conf') (unit backdoor.service)... machine # [ 47.041411] systemd[1]: Reloading... machine # [ 47.274668] systemd[1]: Reloading finished in 232 ms. machine # [ 47.338684] systemd[625]: Reexecution requested from client PID 4235 ('switch-to-confi')... machine # [ 47.340558] systemd[625]: Reexecuting. machine # [ 47.361075] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 47.432611] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 47.438638] systemd[625]: Reload requested from client PID 4235 ('switch-to-confi')... machine # [ 47.440219] systemd[625]: Reloading... machine # [ 47.511301] systemd[625]: Reloading finished in 70 ms. machine # [ 47.516821] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 47.523784] systemd[625]: Stopped Run user-specific NixOS activation. machine # [ 47.524714] systemd[625]: Stopping Run user-specific NixOS activation... machine # [ 47.526238] systemd[625]: Starting Run user-specific NixOS activation... machine # [ 47.545382] systemd[625]: Finished Run user-specific NixOS activation. machine # [ 47.548339] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 47.549618] systemd[1]: Stopping Reactivate sysinit units... machine # [ 47.550903] systemd[1]: Reached target Reactivate sysinit units. machine # [ 47.554672] systemd[1]: Reached target Remote File Systems. machine # [ 47.559096] systemd[1]: Reached target Local File Systems. machine # [ 47.559886] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 47.563375] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 47.564462] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 47.565601] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 47.567603] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 47.569073] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 47.570266] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 47.574578] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 47.575798] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 47.706448] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 47.708169] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 47.712117] systemd[1]: Starting linger-users.service... machine # [ 47.714602] systemd[1]: Starting test.service... machine # [ 47.737699] systemd[1]: Finished test.service. machine # [ 47.750811] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 47.752287] systemd[1]: Finished linger-users.service. machine # [ 48.009855] nixos[4166]: finished switching to system configuration /nix/store/swxd0473ybx39g3sfm4dqs0w78x6m9ck-nixos-system-machine-test machine: (finished: must succeed: /nix/store/68vy4glkqv6dl08fwnd37a5r9s71a7b0-nixos-system-machine-test/specialisation/simpleServiceModified/bin/switch-to-configuration test 2>&1, in 1.41 seconds) machine: must fail: /nix/store/68vy4glkqv6dl08fwnd37a5r9s71a7b0-nixos-system-machine-test/specialisation/simpleServiceFailing/bin/switch-to-configuration test 2>&1 machine # [ 48.248443] nixos[4308]: switching to system configuration /nix/store/7lv1rixrfk0758lidlv66vg2b0jp7ihc-nixos-system-machine-test machine # [ 48.250812] systemd[1]: Stopped target Remote File Systems. machine # [ 48.253056] systemd[1]: Stopped target Local File Systems. machine # [ 48.254567] systemd[1]: test.service: Deactivated successfully. machine # [ 48.255772] systemd[1]: Stopped test.service. machine # [ 48.480286] systemd[1]: Reload requested from client PID 4308 ('.switch-to-conf') (unit backdoor.service)... machine # [ 48.481939] systemd[1]: Reloading... machine # [ 48.729103] systemd[1]: Reloading finished in 245 ms. machine # [ 48.792324] systemd[625]: Reexecution requested from client PID 4377 ('switch-to-confi')... machine # [ 48.794358] systemd[625]: Reexecuting. machine # [ 48.815278] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 48.887470] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 48.892530] systemd[625]: Reload requested from client PID 4377 ('switch-to-confi')... machine # [ 48.894075] systemd[625]: Reloading... machine # [ 48.966994] systemd[625]: Reloading finished in 71 ms. machine # [ 48.972827] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 48.979171] systemd[625]: Stopped Run user-specific NixOS activation. machine # [ 48.980037] systemd[625]: Stopping Run user-specific NixOS activation... machine # [ 48.982199] systemd[625]: Starting Run user-specific NixOS activation... machine # [ 49.002355] systemd[625]: Finished Run user-specific NixOS activation. machine # [ 49.005340] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 49.006606] systemd[1]: Stopping Reactivate sysinit units... machine # [ 49.007684] systemd[1]: Reached target Reactivate sysinit units. machine # [ 49.010768] systemd[1]: Starting test.service... machine # [ 49.018255] systemd[1]: Reached target Remote File Systems. machine # [ 49.022198] systemd[1]: Reached target Local File Systems. machine # [ 49.022952] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 49.026137] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 49.026901] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 49.029714] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 49.032854] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 49.036150] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 49.038112] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 49.041640] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 49.043195] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 49.055251] systemd[1]: test.service: Main process exited, code=exited, status=1/FAILURE machine # [ 49.057511] systemd[1]: test.service: Failed with result 'exit-code'. machine # [ 49.059924] systemd[1]: Failed to start test.service. machine # [ 49.179365] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 49.182083] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 49.184698] systemd[1]: Starting linger-users.service... machine # [ 49.211909] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 49.213415] systemd[1]: Finished linger-users.service. machine # [ 49.495321] nixos[4308]: switching to system configuration /nix/store/7lv1rixrfk0758lidlv66vg2b0jp7ihc-nixos-system-machine-test failed (status 4) machine: (finished: must fail: /nix/store/68vy4glkqv6dl08fwnd37a5r9s71a7b0-nixos-system-machine-test/specialisation/simpleServiceFailing/bin/switch-to-configuration test 2>&1, in 1.49 seconds) machine: must succeed: /nix/store/68vy4glkqv6dl08fwnd37a5r9s71a7b0-nixos-system-machine-test/specialisation/autorestartService/bin/switch-to-configuration test 2>&1 machine # [ 49.724663] nixos[4451]: switching to system configuration /nix/store/2ds7fqmv072vwwzaja6py4jqyvjxk0qf-nixos-system-machine-test machine # [ 49.727559] systemd[1]: Stopped target Local File Systems. machine # [ 49.728748] systemd[1]: Stopped target Remote File Systems. machine # [ 49.953676] systemd[1]: Reload requested from client PID 4451 ('.switch-to-conf') (unit backdoor.service)... machine # [ 49.955258] systemd[1]: Reloading... machine # [ 50.202088] systemd[1]: Reloading finished in 245 ms. machine # [ 50.264554] systemd[625]: Reexecution requested from client PID 4520 ('switch-to-confi')... machine # [ 50.265795] systemd[625]: Reexecuting. machine # [ 50.287245] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 50.358907] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 50.364827] systemd[625]: Reload requested from client PID 4520 ('switch-to-confi')... machine # [ 50.366133] systemd[625]: Reloading... machine # [ 50.438579] systemd[625]: Reloading finished in 70 ms. machine # [ 50.443818] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 50.450799] systemd[625]: Stopped Run user-specific NixOS activation. machine # [ 50.451688] systemd[625]: Stopping Run user-specific NixOS activation... machine # [ 50.453220] systemd[625]: Starting Run user-specific NixOS activation... machine # [ 50.472489] systemd[625]: Finished Run user-specific NixOS activation. machine # [ 50.475465] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 50.476777] systemd[1]: Stopping Reactivate sysinit units... machine # [ 50.477851] systemd[1]: Reached target Reactivate sysinit units. machine # [ 50.479206] systemd[1]: Reached target Remote File Systems. machine # [ 50.482103] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 50.483782] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 50.489172] systemd[1]: Started autorestart.service. machine # [ 50.490833] systemd[1]: Starting linger-users.service... machine # [ 50.494228] systemd[1]: Reached target Local File Systems. machine # [ 50.500684] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 50.505116] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 50.505930] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 50.507106] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 50.509071] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 50.510571] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 50.511740] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 50.539853] systemd[1]: autorestart.service: Deactivated successfully. machine # [ 50.561923] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 50.564882] systemd[1]: Finished linger-users.service. machine # [ 50.670499] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 50.672146] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 50.930540] nixos[4451]: finished switching to system configuration /nix/store/2ds7fqmv072vwwzaja6py4jqyvjxk0qf-nixos-system-machine-test machine: (finished: must succeed: /nix/store/68vy4glkqv6dl08fwnd37a5r9s71a7b0-nixos-system-machine-test/specialisation/autorestartService/bin/switch-to-configuration test 2>&1, in 1.43 seconds) machine # [ 50.975827] systemd[1]: Stopped autorestart.service. machine: must succeed: /nix/store/68vy4glkqv6dl08fwnd37a5r9s71a7b0-nixos-system-machine-test/specialisation/autorestartService/bin/switch-to-configuration test 2>&1 machine # [ 51.176824] nixos[4598]: switching to system configuration /nix/store/2ds7fqmv072vwwzaja6py4jqyvjxk0qf-nixos-system-machine-test machine # [ 51.179065] systemd[1]: Stopped target Remote File Systems. machine # [ 51.180733] systemd[1]: Stopped target Local File Systems. machine # [ 51.385199] systemd[1]: Reload requested from client PID 4598 ('.switch-to-conf') (unit backdoor.service)... machine # [ 51.386834] systemd[1]: Reloading... machine # [ 51.618467] systemd[1]: Reloading finished in 230 ms. machine # [ 51.681280] systemd[625]: Reexecution requested from client PID 4667 ('switch-to-confi')... machine # [ 51.683506] systemd[625]: Reexecuting. machine # [ 51.703989] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 51.776669] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 51.781684] systemd[625]: Reload requested from client PID 4667 ('switch-to-confi')... machine # [ 51.783551] systemd[625]: Reloading... machine # [ 51.854383] systemd[625]: Reloading finished in 70 ms. machine # [ 51.859826] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 51.866165] systemd[625]: Stopped Run user-specific NixOS activation. machine # [ 51.867087] systemd[625]: Stopping Run user-specific NixOS activation... machine # [ 51.869270] systemd[625]: Starting Run user-specific NixOS activation... machine # [ 51.888408] systemd[625]: Finished Run user-specific NixOS activation. machine # [ 51.891347] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 51.892639] systemd[1]: Stopping Reactivate sysinit units... machine # [ 51.893665] systemd[1]: Reached target Reactivate sysinit units. machine # [ 51.895055] systemd[1]: Reached target Local File Systems. machine # [ 51.898062] systemd[1]: Reached target Remote File Systems. machine # [ 51.900987] systemd[1]: Started autorestart.service. machine # [ 51.902890] systemd[1]: Starting linger-users.service... machine # [ 51.911866] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 51.916119] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 51.917740] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 51.919635] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 51.922585] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 51.925284] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 51.928246] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 51.938868] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 51.940508] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 51.955470] systemd[1]: autorestart.service: Deactivated successfully. machine # [ 51.977624] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 51.979175] systemd[1]: Finished linger-users.service. machine # [ 52.088504] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 52.090317] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 52.348675] nixos[4598]: finished switching to system configuration /nix/store/2ds7fqmv072vwwzaja6py4jqyvjxk0qf-nixos-system-machine-test machine: (finished: must succeed: /nix/store/68vy4glkqv6dl08fwnd37a5r9s71a7b0-nixos-system-machine-test/specialisation/autorestartService/bin/switch-to-configuration test 2>&1, in 1.37 seconds) machine # [ 52.394398] systemd[1]: Stopped autorestart.service. machine: must fail: /nix/store/68vy4glkqv6dl08fwnd37a5r9s71a7b0-nixos-system-machine-test/specialisation/autorestartServiceFailing/bin/switch-to-configuration test 2>&1 machine # [ 52.617980] nixos[4745]: switching to system configuration /nix/store/gk2lz0bbyd7kif3yfrj839xbg9np2kl5-nixos-system-machine-test machine # [ 52.620089] systemd[1]: Stopped target Local File Systems. machine # [ 52.621770] systemd[1]: Stopped target Remote File Systems. machine # [ 52.848601] systemd[1]: Reload requested from client PID 4745 ('.switch-to-conf') (unit backdoor.service)... machine # [ 52.850154] systemd[1]: Reloading... machine # [ 53.096413] systemd[1]: Reloading finished in 244 ms. machine # [ 53.158982] systemd[625]: Reexecution requested from client PID 4814 ('switch-to-confi')... machine # [ 53.161460] systemd[625]: Reexecuting. machine # [ 53.182149] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 53.254693] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 53.259649] systemd[625]: Reload requested from client PID 4814 ('switch-to-confi')... machine # [ 53.261089] systemd[625]: Reloading... machine # [ 53.334058] systemd[625]: Reloading finished in 71 ms. machine # [ 53.339819] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 53.347111] systemd[625]: Stopped Run user-specific NixOS activation. machine # [ 53.348054] systemd[625]: Stopping Run user-specific NixOS activation... machine # [ 53.349881] systemd[625]: Starting Run user-specific NixOS activation... machine # [ 53.370435] systemd[625]: Finished Run user-specific NixOS activation. machine # [ 53.373335] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 53.374619] systemd[1]: Stopping Reactivate sysinit units... machine # [ 53.375580] systemd[1]: Reached target Reactivate sysinit units. machine # [ 53.378997] systemd[1]: Reached target Remote File Systems. machine # [ 53.381595] systemd[1]: Started autorestart.service. machine # [ 53.384511] systemd[1]: Starting linger-users.service... machine # [ 53.392780] systemd[1]: Reached target Local File Systems. machine # [ 53.395695] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 53.397324] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 53.404460] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 53.409287] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 53.410797] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 53.412771] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 53.415522] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 53.418105] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 53.419519] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 53.433442] systemd[1]: autorestart.service: Main process exited, code=exited, status=1/FAILURE machine # [ 53.435035] systemd[1]: autorestart.service: Failed with result 'exit-code'. machine # [ 53.458423] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 53.460345] systemd[1]: Finished linger-users.service. machine # [ 53.572679] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 53.574361] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 53.852956] nixos[4745]: switching to system configuration /nix/store/gk2lz0bbyd7kif3yfrj839xbg9np2kl5-nixos-system-machine-test failed (status 4) machine: (finished: must fail: /nix/store/68vy4glkqv6dl08fwnd37a5r9s71a7b0-nixos-system-machine-test/specialisation/autorestartServiceFailing/bin/switch-to-configuration test 2>&1, in 1.46 seconds) (finished: subtest: failing units, in 7.25 seconds) subtest: unit file parser machine: must succeed: /nix/store/68vy4glkqv6dl08fwnd37a5r9s71a7b0-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1 machine # [ 54.063755] nixos[4888]: switching to system configuration /nix/store/8ckl6vqxr6vzfc7hm964qzy7h0rfp9yq-nixos-system-machine-test machine # [ 54.065956] systemd[1]: Stopped target Local File Systems. machine # [ 54.067547] systemd[1]: Stopped target Remote File Systems. machine # [ 54.069733] systemd[1]: Stopped autorestart.service. machine # [ 54.274426] systemd[1]: Reload requested from client PID 4888 ('.switch-to-conf') (unit backdoor.service)... machine # [ 54.276302] systemd[1]: Reloading... machine # [ 54.511090] systemd[1]: Reloading finished in 233 ms. machine # [ 54.573250] systemd[625]: Reexecution requested from client PID 4957 ('switch-to-confi')... machine # [ 54.575799] systemd[625]: Reexecuting. machine # [ 54.596068] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 54.668421] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 54.673598] systemd[625]: Reload requested from client PID 4957 ('switch-to-confi')... machine # [ 54.674934] systemd[625]: Reloading... machine # [ 54.746737] systemd[625]: Reloading finished in 70 ms. machine # [ 54.751811] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 54.758070] systemd[625]: Stopped Run user-specific NixOS activation. machine # [ 54.759026] systemd[625]: Stopping Run user-specific NixOS activation... machine # [ 54.761062] systemd[625]: Starting Run user-specific NixOS activation... machine # [ 54.780184] systemd[625]: Finished Run user-specific NixOS activation. machine # [ 54.783064] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 54.784499] systemd[1]: Stopping Reactivate sysinit units... machine # [ 54.785447] systemd[1]: Reached target Reactivate sysinit units. machine # [ 54.790060] systemd[1]: Reached target Local File Systems. machine # [ 54.792304] systemd[1]: Reached target Remote File Systems. machine # [ 54.793044] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 54.795195] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 54.795934] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 54.798729] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 54.800727] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 54.802135] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 54.803300] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 54.810507] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 54.811701] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 54.938698] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 54.940332] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 54.943822] systemd[1]: Starting linger-users.service... machine # [ 54.946483] systemd[1]: Starting test.service... machine # [ 54.970116] systemd[1]: Finished test.service. machine # [ 54.982508] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 54.983906] systemd[1]: Finished linger-users.service. machine # [ 55.242320] nixos[4888]: finished switching to system configuration /nix/store/8ckl6vqxr6vzfc7hm964qzy7h0rfp9yq-nixos-system-machine-test machine: (finished: must succeed: /nix/store/68vy4glkqv6dl08fwnd37a5r9s71a7b0-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1, in 1.39 seconds) machine: must succeed: /nix/store/68vy4glkqv6dl08fwnd37a5r9s71a7b0-nixos-system-machine-test/specialisation/simpleServiceWithExtraSection/bin/switch-to-configuration test 2>&1 machine # [ 55.486426] nixos[5030]: switching to system configuration /nix/store/8k9h32fn33s4lzsrn76g0638ply2ls3f-nixos-system-machine-test machine # [ 55.488674] systemd[1]: Stopped target Remote File Systems. machine # [ 55.490345] systemd[1]: Stopped target Local File Systems. machine # [ 55.715514] systemd[1]: Reload requested from client PID 5030 ('.switch-to-conf') (unit backdoor.service)... machine # [ 55.717394] systemd[1]: Reloading... machine # [ 55.967869] systemd[1]: Reloading finished in 248 ms. machine # [ 56.033855] systemd[625]: Reexecution requested from client PID 5099 ('switch-to-confi')... machine # [ 56.036615] systemd[625]: Reexecuting. machine # [ 56.057092] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 56.132667] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 56.138066] systemd[625]: Reload requested from client PID 5099 ('switch-to-confi')... machine # [ 56.140137] systemd[625]: Reloading... machine # [ 56.210779] systemd[625]: Reloading finished in 69 ms. machine # [ 56.214828] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 56.220870] systemd[625]: Stopped Run user-specific NixOS activation. machine # [ 56.222798] systemd[625]: Stopping Run user-specific NixOS activation... machine # [ 56.224403] systemd[625]: Starting Run user-specific NixOS activation... machine # [ 56.243063] systemd[625]: Finished Run user-specific NixOS activation. machine # [ 56.245901] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 56.247213] systemd[1]: Stopping Reactivate sysinit units... machine # [ 56.247995] systemd[1]: Reached target Reactivate sysinit units. machine # [ 56.249888] systemd[1]: test.service: Deactivated successfully. machine # [ 56.251231] systemd[1]: Stopped test.service. machine # [ 56.251828] systemd[1]: Stopping test.service... machine # [ 56.253778] systemd[1]: Starting test.service... machine # [ 56.268162] systemd[1]: Finished test.service. machine # [ 56.271268] systemd[1]: Reached target Local File Systems. machine # [ 56.273150] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 56.275193] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 56.278467] systemd[1]: Reached target Remote File Systems. machine # [ 56.281470] systemd[1]: Starting linger-users.service... machine # [ 56.288057] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 56.292060] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 56.292892] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 56.295726] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 56.298124] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 56.301368] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 56.302626] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 56.336540] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 56.339737] systemd[1]: Finished linger-users.service. machine # [ 56.444991] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 56.446807] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 56.703863] nixos[5030]: finished switching to system configuration /nix/store/8k9h32fn33s4lzsrn76g0638ply2ls3f-nixos-system-machine-test machine: (finished: must succeed: /nix/store/68vy4glkqv6dl08fwnd37a5r9s71a7b0-nixos-system-machine-test/specialisation/simpleServiceWithExtraSection/bin/switch-to-configuration test 2>&1, in 1.46 seconds) machine: must succeed: /nix/store/68vy4glkqv6dl08fwnd37a5r9s71a7b0-nixos-system-machine-test/specialisation/simpleServiceWithExtraSectionOtherName/bin/switch-to-configuration test 2>&1 machine # [ 56.930863] nixos[5172]: switching to system configuration /nix/store/ix9bsh1ys1zsm1l3zzmkf5z0asg95yc7-nixos-system-machine-test machine # [ 56.934599] systemd[1]: Stopped target Local File Systems. machine # [ 56.935631] systemd[1]: Stopped target Remote File Systems. machine # [ 57.152218] systemd[1]: Reload requested from client PID 5172 ('.switch-to-conf') (unit backdoor.service)... machine # [ 57.153868] systemd[1]: Reloading... machine # [ 57.388984] systemd[1]: Reloading finished in 233 ms. machine # [ 57.452777] systemd[625]: Reexecution requested from client PID 5241 ('switch-to-confi')... machine # [ 57.455349] systemd[625]: Reexecuting. machine # [ 57.474033] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 57.545725] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 57.550888] systemd[625]: Reload requested from client PID 5241 ('switch-to-confi')... machine # [ 57.552651] systemd[625]: Reloading... machine # [ 57.621686] systemd[625]: Reloading finished in 68 ms. machine # [ 57.626822] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 57.632937] systemd[625]: Stopped Run user-specific NixOS activation. machine # [ 57.634104] systemd[625]: Stopping Run user-specific NixOS activation... machine # [ 57.636682] systemd[625]: Starting Run user-specific NixOS activation... machine # [ 57.654879] systemd[625]: Finished Run user-specific NixOS activation. machine # [ 57.657858] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 57.659132] systemd[1]: Stopping Reactivate sysinit units... machine # [ 57.659929] systemd[1]: Reached target Reactivate sysinit units. machine # [ 57.661898] systemd[1]: test.service: Deactivated successfully. machine # [ 57.663143] systemd[1]: Stopped test.service. machine # [ 57.663843] systemd[1]: Stopping test.service... machine # [ 57.666195] systemd[1]: Starting test.service... machine # [ 57.679139] systemd[1]: Finished test.service. machine # [ 57.683699] systemd[1]: Reached target Remote File Systems. machine # [ 57.686182] systemd[1]: Starting linger-users.service... machine # [ 57.689628] systemd[1]: Reached target Local File Systems. machine # [ 57.691537] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 57.696157] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 57.696950] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 57.698161] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 57.700207] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 57.701616] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 57.702864] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 57.707540] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 57.711181] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 57.748826] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 57.750777] systemd[1]: Finished linger-users.service. machine # [ 57.852114] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 57.853900] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 58.111658] nixos[5172]: finished switching to system configuration /nix/store/ix9bsh1ys1zsm1l3zzmkf5z0asg95yc7-nixos-system-machine-test machine: (finished: must succeed: /nix/store/68vy4glkqv6dl08fwnd37a5r9s71a7b0-nixos-system-machine-test/specialisation/simpleServiceWithExtraSectionOtherName/bin/switch-to-configuration test 2>&1, in 1.41 seconds) machine: must succeed: /nix/store/68vy4glkqv6dl08fwnd37a5r9s71a7b0-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1 machine # [ 58.321820] nixos[5314]: switching to system configuration /nix/store/8ckl6vqxr6vzfc7hm964qzy7h0rfp9yq-nixos-system-machine-test machine # [ 58.324314] systemd[1]: Stopped target Local File Systems. machine # [ 58.326300] systemd[1]: Stopped target Remote File Systems. machine # [ 58.524909] systemd[1]: Reload requested from client PID 5314 ('.switch-to-conf') (unit backdoor.service)... machine # [ 58.526603] systemd[1]: Reloading... machine # [ 58.751082] systemd[1]: Reloading finished in 222 ms. machine # [ 58.811551] systemd[625]: Reexecution requested from client PID 5383 ('switch-to-confi')... machine # [ 58.814090] systemd[625]: Reexecuting. machine # [ 58.833061] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 58.901919] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 58.907495] systemd[625]: Reload requested from client PID 5383 ('switch-to-confi')... machine # [ 58.909762] systemd[625]: Reloading... machine # [ 58.976466] systemd[625]: Reloading finished in 67 ms. machine # [ 58.981822] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 58.988290] systemd[625]: Stopped Run user-specific NixOS activation. machine # [ 58.989172] systemd[625]: Stopping Run user-specific NixOS activation... machine # [ 58.991251] systemd[625]: Starting Run user-specific NixOS activation... machine # [ 59.009891] systemd[625]: Finished Run user-specific NixOS activation. machine # [ 59.012806] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 59.014219] systemd[1]: Stopping Reactivate sysinit units... machine # [ 59.014927] systemd[1]: Reached target Reactivate sysinit units. machine # [ 59.016764] systemd[1]: test.service: Deactivated successfully. machine # [ 59.018239] systemd[1]: Stopped test.service. machine # [ 59.018820] systemd[1]: Stopping test.service... machine # [ 59.021140] systemd[1]: Starting test.service... machine # [ 59.034129] systemd[1]: Finished test.service. machine # [ 59.036618] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 59.038205] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 59.042144] systemd[1]: Reached target Local File Systems. machine # [ 59.048681] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 59.051845] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 59.053404] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 59.056369] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 59.059302] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 59.061551] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 59.064428] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 59.065596] systemd[1]: Reached target Remote File Systems. machine # [ 59.185504] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 59.187174] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 59.190972] systemd[1]: Starting linger-users.service... machine # [ 59.215945] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 59.217611] systemd[1]: Finished linger-users.service. machine # [ 59.474678] nixos[5314]: finished switching to system configuration /nix/store/8ckl6vqxr6vzfc7hm964qzy7h0rfp9yq-nixos-system-machine-test machine: (finished: must succeed: /nix/store/68vy4glkqv6dl08fwnd37a5r9s71a7b0-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1, in 1.36 seconds) machine: must succeed: /nix/store/68vy4glkqv6dl08fwnd37a5r9s71a7b0-nixos-system-machine-test/specialisation/simpleServiceWithInstallSection/bin/switch-to-configuration test 2>&1 machine # [ 59.700281] nixos[5456]: switching to system configuration /nix/store/1lrswha52y396gp8mvzfrvmsfj1pyjcm-nixos-system-machine-test machine # [ 59.702462] systemd[1]: Stopped target Remote File Systems. machine # [ 59.704228] systemd[1]: Stopped target Local File Systems. machine # [ 59.922308] systemd[1]: Reload requested from client PID 5456 ('.switch-to-conf') (unit backdoor.service)... machine # [ 59.923962] systemd[1]: Reloading... machine # [ 60.158769] systemd[1]: Reloading finished in 232 ms. machine # [ 60.222505] systemd[625]: Reexecution requested from client PID 5525 ('switch-to-confi')... machine # [ 60.223763] systemd[625]: Reexecuting. machine # [ 60.243960] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 60.315543] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 60.321760] systemd[625]: Reload requested from client PID 5525 ('switch-to-confi')... machine # [ 60.323831] systemd[625]: Reloading... machine # [ 60.392578] systemd[625]: Reloading finished in 69 ms. machine # [ 60.397855] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 60.404196] systemd[625]: Stopped Run user-specific NixOS activation. machine # [ 60.406057] systemd[625]: Stopping Run user-specific NixOS activation... machine # [ 60.407568] systemd[625]: Starting Run user-specific NixOS activation... machine # [ 60.426239] systemd[625]: Finished Run user-specific NixOS activation. machine # [ 60.429293] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 60.430511] systemd[1]: Stopping Reactivate sysinit units... machine # [ 60.431583] systemd[1]: Reached target Reactivate sysinit units. machine # [ 60.434832] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 60.436742] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 60.439925] systemd[1]: Reached target Local File Systems. machine # [ 60.442313] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 60.446247] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 60.447822] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 60.449412] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 60.451899] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 60.455129] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 60.456334] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 60.459739] systemd[1]: Reached target Remote File Systems. machine # [ 60.582960] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 60.584616] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 60.588341] systemd[1]: Starting linger-users.service... machine # [ 60.614905] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 60.616484] systemd[1]: Finished linger-users.service. machine # [ 60.872438] nixos[5456]: finished switching to system configuration /nix/store/1lrswha52y396gp8mvzfrvmsfj1pyjcm-nixos-system-machine-test machine: (finished: must succeed: /nix/store/68vy4glkqv6dl08fwnd37a5r9s71a7b0-nixos-system-machine-test/specialisation/simpleServiceWithInstallSection/bin/switch-to-configuration test 2>&1, in 1.40 seconds) machine: must succeed: /nix/store/68vy4glkqv6dl08fwnd37a5r9s71a7b0-nixos-system-machine-test/specialisation/simpleServiceWithExtraKey/bin/switch-to-configuration test 2>&1 machine # [ 61.096339] nixos[5596]: switching to system configuration /nix/store/idzscvjg7fzlslz2zffzdy4j5w94rvcn-nixos-system-machine-test machine # [ 61.098787] systemd[1]: Stopped target Remote File Systems. machine # [ 61.100359] systemd[1]: Stopped target Local File Systems. machine # [ 61.317598] systemd[1]: Reload requested from client PID 5596 ('.switch-to-conf') (unit backdoor.service)... machine # [ 61.319239] systemd[1]: Reloading... machine # [ 61.551864] systemd[1]: Reloading finished in 230 ms. machine # [ 61.609875] systemd[625]: Reexecution requested from client PID 5665 ('switch-to-confi')... machine # [ 61.611923] systemd[625]: Reexecuting. machine # [ 61.632946] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 61.701948] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 61.707777] systemd[625]: Reload requested from client PID 5665 ('switch-to-confi')... machine # [ 61.709951] systemd[625]: Reloading... machine # [ 61.777049] systemd[625]: Reloading finished in 67 ms. machine # [ 61.782820] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 61.788884] systemd[625]: Stopped Run user-specific NixOS activation. machine # [ 61.789899] systemd[625]: Stopping Run user-specific NixOS activation... machine # [ 61.792241] systemd[625]: Starting Run user-specific NixOS activation... machine # [ 61.814955] systemd[625]: Finished Run user-specific NixOS activation. machine # [ 61.817899] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 61.819237] systemd[1]: Stopping Reactivate sysinit units... machine # [ 61.819986] systemd[1]: Reached target Reactivate sysinit units. machine # [ 61.821867] systemd[1]: test.service: Deactivated successfully. machine # [ 61.823249] systemd[1]: Stopped test.service. machine # [ 61.823920] systemd[1]: Stopping test.service... machine # [ 61.825997] systemd[1]: Starting test.service... machine # [ 61.840381] systemd[1]: Finished test.service. machine # [ 61.846609] systemd[1]: Reached target Remote File Systems. machine # [ 61.848057] systemd[1]: Starting linger-users.service... machine # [ 61.851082] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 61.852498] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 61.855688] systemd[1]: Reached target Local File Systems. machine # [ 61.863575] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 61.868337] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 61.869867] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 61.871080] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 61.873065] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 61.874592] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 61.875804] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 61.907541] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 61.910057] systemd[1]: Finished linger-users.service. machine # [ 62.016419] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 62.018285] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 62.275921] nixos[5596]: finished switching to system configuration /nix/store/idzscvjg7fzlslz2zffzdy4j5w94rvcn-nixos-system-machine-test machine: (finished: must succeed: /nix/store/68vy4glkqv6dl08fwnd37a5r9s71a7b0-nixos-system-machine-test/specialisation/simpleServiceWithExtraKey/bin/switch-to-configuration test 2>&1, in 1.40 seconds) machine: must succeed: /nix/store/68vy4glkqv6dl08fwnd37a5r9s71a7b0-nixos-system-machine-test/specialisation/simpleServiceWithExtraKeyOtherValue/bin/switch-to-configuration test 2>&1 machine # [ 62.502697] nixos[5738]: switching to system configuration /nix/store/7kx33jg7idqc2c0qygy2fzlip9hszgan-nixos-system-machine-test machine # [ 62.506221] systemd[1]: Stopped target Remote File Systems. machine # [ 62.507190] systemd[1]: Stopped target Local File Systems. machine # [ 62.722487] systemd[1]: Reload requested from client PID 5738 ('.switch-to-conf') (unit backdoor.service)... machine # [ 62.724139] systemd[1]: Reloading... machine # [ 62.958710] systemd[1]: Reloading finished in 233 ms. machine # [ 63.020658] systemd[625]: Reexecution requested from client PID 5807 ('switch-to-confi')... machine # [ 63.023176] systemd[625]: Reexecuting. machine # [ 63.043984] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 63.113681] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 63.118746] systemd[625]: Reload requested from client PID 5807 ('switch-to-confi')... machine # [ 63.120185] systemd[625]: Reloading... machine # [ 63.184978] systemd[625]: Reloading finished in 63 ms. machine # [ 63.190808] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 63.196979] systemd[625]: Stopped Run user-specific NixOS activation. machine # [ 63.197991] systemd[625]: Stopping Run user-specific NixOS activation... machine # [ 63.200458] systemd[625]: Starting Run user-specific NixOS activation... machine # [ 63.217700] systemd[625]: Finished Run user-specific NixOS activation. machine # [ 63.220630] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 63.221957] systemd[1]: Stopping Reactivate sysinit units... machine # [ 63.223337] systemd[1]: Reached target Reactivate sysinit units. machine # [ 63.224709] systemd[1]: test.service: Deactivated successfully. machine # [ 63.226171] systemd[1]: Stopped test.service. machine # [ 63.226776] systemd[1]: Stopping test.service... machine # [ 63.228824] systemd[1]: Starting test.service... machine # [ 63.242282] systemd[1]: Finished test.service. machine # [ 63.247066] systemd[1]: Reached target Local File Systems. machine # [ 63.247860] systemd[1]: Reached target Remote File Systems. machine # [ 63.248771] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 63.253231] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 63.254043] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 63.255237] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 63.257462] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 63.258918] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 63.260112] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 63.267573] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 63.268856] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 63.377706] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 63.379333] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 63.382897] systemd[1]: Starting linger-users.service... machine # [ 63.409144] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 63.410723] systemd[1]: Finished linger-users.service. machine # [ 63.668137] nixos[5738]: finished switching to system configuration /nix/store/7kx33jg7idqc2c0qygy2fzlip9hszgan-nixos-system-machine-test machine: (finished: must succeed: /nix/store/68vy4glkqv6dl08fwnd37a5r9s71a7b0-nixos-system-machine-test/specialisation/simpleServiceWithExtraKeyOtherValue/bin/switch-to-configuration test 2>&1, in 1.39 seconds) machine: must succeed: /nix/store/68vy4glkqv6dl08fwnd37a5r9s71a7b0-nixos-system-machine-test/specialisation/simpleServiceWithExtraKeyOtherName/bin/switch-to-configuration test 2>&1 machine # [ 63.882425] nixos[5880]: switching to system configuration /nix/store/r3lnhdxvn73pk5yasycxlsg0g81554ln-nixos-system-machine-test machine # [ 63.885800] systemd[1]: Stopped target Remote File Systems. machine # [ 63.886678] systemd[1]: Stopped target Local File Systems. machine # [ 64.106361] systemd[1]: Reload requested from client PID 5880 ('.switch-to-conf') (unit backdoor.service)... machine # [ 64.107988] systemd[1]: Reloading... machine # [ 64.338836] systemd[1]: Reloading finished in 229 ms. machine # [ 64.390671] systemd[625]: Reexecution requested from client PID 5949 ('switch-to-confi')... machine # [ 64.393194] systemd[625]: Reexecuting. machine # [ 64.412769] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 64.476254] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 64.480369] systemd[625]: Reload requested from client PID 5949 ('switch-to-confi')... machine # [ 64.482102] systemd[625]: Reloading... machine # [ 64.543808] systemd[625]: Reloading finished in 60 ms. machine # [ 64.549817] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 64.556786] systemd[625]: Stopped Run user-specific NixOS activation. machine # [ 64.557675] systemd[625]: Stopping Run user-specific NixOS activation... machine # [ 64.559223] systemd[625]: Starting Run user-specific NixOS activation... machine # [ 64.576711] systemd[625]: Finished Run user-specific NixOS activation. machine # [ 64.579700] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 64.580989] systemd[1]: Stopping Reactivate sysinit units... machine # [ 64.581944] systemd[1]: Reached target Reactivate sysinit units. machine # [ 64.583668] systemd[1]: test.service: Deactivated successfully. machine # [ 64.585200] systemd[1]: Stopped test.service. machine # [ 64.585833] systemd[1]: Stopping test.service... machine # [ 64.588063] systemd[1]: Starting test.service... machine # [ 64.601091] systemd[1]: Finished test.service. machine # [ 64.605799] systemd[1]: Reached target Local File Systems. machine # [ 64.611426] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 64.613261] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 64.615235] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 64.617566] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 64.619157] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 64.620775] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 64.623306] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 64.625150] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 64.626320] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 64.630347] systemd[1]: Reached target Remote File Systems. machine # [ 64.739057] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 64.741071] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 64.744712] systemd[1]: Starting linger-users.service... machine # [ 64.769620] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 64.771168] systemd[1]: Finished linger-users.service. machine # [ 65.027944] nixos[5880]: finished switching to system configuration /nix/store/r3lnhdxvn73pk5yasycxlsg0g81554ln-nixos-system-machine-test machine: (finished: must succeed: /nix/store/68vy4glkqv6dl08fwnd37a5r9s71a7b0-nixos-system-machine-test/specialisation/simpleServiceWithExtraKeyOtherName/bin/switch-to-configuration test 2>&1, in 1.36 seconds) machine: must succeed: /nix/store/68vy4glkqv6dl08fwnd37a5r9s71a7b0-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1 machine # [ 65.233053] nixos[6022]: switching to system configuration /nix/store/8ckl6vqxr6vzfc7hm964qzy7h0rfp9yq-nixos-system-machine-test machine # [ 65.236312] systemd[1]: Stopped target Remote File Systems. machine # [ 65.237494] systemd[1]: Stopped target Local File Systems. machine # [ 65.435623] systemd[1]: Reload requested from client PID 6022 ('.switch-to-conf') (unit backdoor.service)... machine # [ 65.437433] systemd[1]: Reloading... machine # [ 65.662376] systemd[1]: Reloading finished in 223 ms. machine # [ 65.720756] systemd[625]: Reexecution requested from client PID 6091 ('switch-to-confi')... machine # [ 65.722053] systemd[625]: Reexecuting. machine # [ 65.738725] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 65.801274] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 65.806452] systemd[625]: Reload requested from client PID 6091 ('switch-to-confi')... machine # [ 65.808716] systemd[625]: Reloading... machine # [ 65.874852] systemd[625]: Reloading finished in 66 ms. machine # [ 65.880067] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 65.886826] systemd[625]: Stopped Run user-specific NixOS activation. machine # [ 65.888288] systemd[625]: Stopping Run user-specific NixOS activation... machine # [ 65.890177] systemd[625]: Starting Run user-specific NixOS activation... machine # [ 65.909245] systemd[625]: Finished Run user-specific NixOS activation. machine # [ 65.912241] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 65.913537] systemd[1]: Stopping Reactivate sysinit units... machine # [ 65.914499] systemd[1]: Reached target Reactivate sysinit units. machine # [ 65.916307] systemd[1]: test.service: Deactivated successfully. machine # [ 65.918205] systemd[1]: Stopped test.service. machine # [ 65.918808] systemd[1]: Stopping test.service... machine # [ 65.920249] systemd[1]: Starting test.service... machine # [ 65.933110] systemd[1]: Finished test.service. machine # [ 65.935827] systemd[1]: Reached target Local File Systems. machine # [ 65.938059] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 65.941626] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 65.942468] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 65.944292] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 65.946708] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 65.948883] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 65.951116] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 65.954325] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 65.955503] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 65.961944] systemd[1]: Reached target Remote File Systems. machine # [ 66.084054] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 66.085847] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 66.089434] systemd[1]: Starting linger-users.service... machine # [ 66.115962] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 66.117420] systemd[1]: Finished linger-users.service. machine # [ 66.373643] nixos[6022]: finished switching to system configuration /nix/store/8ckl6vqxr6vzfc7hm964qzy7h0rfp9yq-nixos-system-machine-test machine: (finished: must succeed: /nix/store/68vy4glkqv6dl08fwnd37a5r9s71a7b0-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1, in 1.35 seconds) machine: must succeed: /nix/store/68vy4glkqv6dl08fwnd37a5r9s71a7b0-nixos-system-machine-test/specialisation/simpleServiceReloadTrigger/bin/switch-to-configuration test 2>&1 machine # [ 66.600322] nixos[6164]: switching to system configuration /nix/store/s9y449xms8mpb806wfzsg87grs8yp19r-nixos-system-machine-test machine # [ 66.602680] systemd[1]: Stopped target Local File Systems. machine # [ 66.604404] systemd[1]: Stopped target Remote File Systems. machine # [ 66.822809] systemd[1]: Reload requested from client PID 6164 ('.switch-to-conf') (unit backdoor.service)... machine # [ 66.824451] systemd[1]: Reloading... machine # [ 67.060861] systemd[1]: Reloading finished in 235 ms. machine # [ 67.124266] systemd[625]: Reexecution requested from client PID 6233 ('switch-to-confi')... machine # [ 67.125542] systemd[625]: Reexecuting. machine # [ 67.144966] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 67.215084] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 67.220493] systemd[625]: Reload requested from client PID 6233 ('switch-to-confi')... machine # [ 67.222165] systemd[625]: Reloading... machine # [ 67.291793] systemd[625]: Reloading finished in 68 ms. machine # [ 67.296821] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 67.302701] systemd[625]: Stopped Run user-specific NixOS activation. machine # [ 67.303766] systemd[625]: Stopping Run user-specific NixOS activation... machine # [ 67.306183] systemd[625]: Starting Run user-specific NixOS activation... machine # [ 67.325036] systemd[625]: Finished Run user-specific NixOS activation. machine # [ 67.327924] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 67.329366] systemd[1]: Stopping Reactivate sysinit units... machine # [ 67.330382] systemd[1]: Reached target Reactivate sysinit units. machine # [ 67.333672] systemd[1]: Reloading test.service... machine # [ 67.348129] systemd[1]: Reloaded test.service. machine # [ 67.350757] systemd[1]: Reached target Local File Systems. machine # [ 67.353667] systemd[1]: Reached target Remote File Systems. machine # [ 67.357888] systemd[1]: Starting linger-users.service... machine # [ 67.362577] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 67.366392] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 67.367229] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 67.368461] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 67.370457] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 67.371933] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 67.375356] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 67.381091] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 67.382337] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 67.421494] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 67.423124] systemd[1]: Finished linger-users.service. machine # [ 67.523180] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 67.524778] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 67.783069] nixos[6164]: finished switching to system configuration /nix/store/s9y449xms8mpb806wfzsg87grs8yp19r-nixos-system-machine-test machine: (finished: must succeed: /nix/store/68vy4glkqv6dl08fwnd37a5r9s71a7b0-nixos-system-machine-test/specialisation/simpleServiceReloadTrigger/bin/switch-to-configuration test 2>&1, in 1.41 seconds) machine: must succeed: /nix/store/68vy4glkqv6dl08fwnd37a5r9s71a7b0-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModified/bin/switch-to-configuration test 2>&1 machine # [ 68.008343] nixos[6306]: switching to system configuration /nix/store/bp8m9f9r09jmpa73x6c51zfa86ajhzxm-nixos-system-machine-test machine # [ 68.010679] systemd[1]: Stopped target Remote File Systems. machine # [ 68.012819] systemd[1]: Stopped target Local File Systems. machine # [ 68.232383] systemd[1]: Reload requested from client PID 6306 ('.switch-to-conf') (unit backdoor.service)... machine # [ 68.234115] systemd[1]: Reloading... machine # [ 68.471850] systemd[1]: Reloading finished in 235 ms. machine # [ 68.531328] systemd[625]: Reexecution requested from client PID 6375 ('switch-to-confi')... machine # [ 68.533646] systemd[625]: Reexecuting. machine # [ 68.553035] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 68.623124] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 68.628558] systemd[625]: Reload requested from client PID 6375 ('switch-to-confi')... machine # [ 68.629943] systemd[625]: Reloading... machine # [ 68.699184] systemd[625]: Reloading finished in 68 ms. machine # [ 68.704817] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 68.711230] systemd[625]: Stopped Run user-specific NixOS activation. machine # [ 68.712127] systemd[625]: Stopping Run user-specific NixOS activation... machine # [ 68.714268] systemd[625]: Starting Run user-specific NixOS activation... machine # [ 68.733061] systemd[625]: Finished Run user-specific NixOS activation. machine # [ 68.735958] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 68.737289] systemd[1]: Stopping Reactivate sysinit units... machine # [ 68.738756] systemd[1]: Reached target Reactivate sysinit units. machine # [ 68.741573] systemd[1]: Reloading test.service... machine # [ 68.755215] systemd[1]: Reloaded test.service. machine # [ 68.758784] systemd[1]: Reached target Remote File Systems. machine # [ 68.761276] systemd[1]: Reached target Local File Systems. machine # [ 68.763160] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 68.765565] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 68.767242] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 68.768456] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 68.770424] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 68.771903] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 68.776136] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 68.779285] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 68.780838] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 68.905777] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 68.907487] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 68.911306] systemd[1]: Starting linger-users.service... machine # [ 68.938329] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 68.939811] systemd[1]: Finished linger-users.service. machine # [ 69.196844] nixos[6306]: finished switching to system configuration /nix/store/bp8m9f9r09jmpa73x6c51zfa86ajhzxm-nixos-system-machine-test machine: (finished: must succeed: /nix/store/68vy4glkqv6dl08fwnd37a5r9s71a7b0-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModified/bin/switch-to-configuration test 2>&1, in 1.41 seconds) machine: must succeed: /nix/store/68vy4glkqv6dl08fwnd37a5r9s71a7b0-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModifiedAndSomethingElse/bin/switch-to-configuration test 2>&1 machine # [ 69.422362] nixos[6448]: switching to system configuration /nix/store/z936ayk0ywv74pcv96dqw4f1r3xvpnf0-nixos-system-machine-test machine # [ 69.424737] systemd[1]: Stopped target Local File Systems. machine # [ 69.426728] systemd[1]: Stopped target Remote File Systems. machine # [ 69.644850] systemd[1]: Reload requested from client PID 6448 ('.switch-to-conf') (unit backdoor.service)... machine # [ 69.646563] systemd[1]: Reloading... machine # [ 69.885146] systemd[1]: Reloading finished in 236 ms. machine # [ 69.947568] systemd[625]: Reexecution requested from client PID 6517 ('switch-to-confi')... machine # [ 69.948956] systemd[625]: Reexecuting. machine # [ 69.969033] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 70.038504] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 70.043599] systemd[625]: Reload requested from client PID 6517 ('switch-to-confi')... machine # [ 70.045055] systemd[625]: Reloading... machine # [ 70.114963] systemd[625]: Reloading finished in 68 ms. machine # [ 70.120812] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 70.127239] systemd[625]: Stopped Run user-specific NixOS activation. machine # [ 70.128186] systemd[625]: Stopping Run user-specific NixOS activation... machine # [ 70.130232] systemd[625]: Starting Run user-specific NixOS activation... machine # [ 70.148910] systemd[625]: Finished Run user-specific NixOS activation. machine # [ 70.151857] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 70.153187] systemd[1]: Stopping Reactivate sysinit units... machine # [ 70.153910] systemd[1]: Reached target Reactivate sysinit units. machine # [ 70.155923] systemd[1]: test.service: Deactivated successfully. machine # [ 70.157128] systemd[1]: Stopped test.service. machine # [ 70.157753] systemd[1]: Stopping test.service... machine # [ 70.160139] systemd[1]: Starting test.service... machine # [ 70.174277] systemd[1]: Finished test.service. machine # [ 70.176676] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 70.178425] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 70.180520] systemd[1]: Reached target Remote File Systems. machine # [ 70.186498] systemd[1]: Reached target Local File Systems. machine # [ 70.188388] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 70.191784] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 70.192783] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 70.194672] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 70.196719] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 70.198218] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 70.201709] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 70.326740] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 70.328587] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 70.332293] systemd[1]: Starting linger-users.service... machine # [ 70.358223] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 70.359642] systemd[1]: Finished linger-users.service. machine # [ 70.617686] nixos[6448]: finished switching to system configuration /nix/store/z936ayk0ywv74pcv96dqw4f1r3xvpnf0-nixos-system-machine-test machine: (finished: must succeed: /nix/store/68vy4glkqv6dl08fwnd37a5r9s71a7b0-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModifiedAndSomethingElse/bin/switch-to-configuration test 2>&1, in 1.42 seconds) machine: must succeed: /nix/store/68vy4glkqv6dl08fwnd37a5r9s71a7b0-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModifiedSomethingElse/bin/switch-to-configuration test 2>&1 machine # [ 70.823757] nixos[6590]: switching to system configuration /nix/store/idzscvjg7fzlslz2zffzdy4j5w94rvcn-nixos-system-machine-test machine # [ 70.826465] systemd[1]: Stopped target Remote File Systems. machine # [ 70.827972] systemd[1]: Stopped target Local File Systems. machine # [ 71.027145] systemd[1]: Reload requested from client PID 6590 ('.switch-to-conf') (unit backdoor.service)... machine # [ 71.028787] systemd[1]: Reloading... machine # [ 71.253027] systemd[1]: Reloading finished in 222 ms. machine # [ 71.314552] systemd[625]: Reexecution requested from client PID 6659 ('switch-to-confi')... machine # [ 71.315906] systemd[625]: Reexecuting. machine # [ 71.335954] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 71.406186] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 71.411509] systemd[625]: Reload requested from client PID 6659 ('switch-to-confi')... machine # [ 71.412987] systemd[625]: Reloading... machine # [ 71.483311] systemd[625]: Reloading finished in 68 ms. machine # [ 71.488825] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 71.494745] systemd[625]: Stopped Run user-specific NixOS activation. machine # [ 71.496209] systemd[625]: Stopping Run user-specific NixOS activation... machine # [ 71.498168] systemd[625]: Starting Run user-specific NixOS activation... machine # [ 71.517930] systemd[625]: Finished Run user-specific NixOS activation. machine # [ 71.520815] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 71.522357] systemd[1]: Stopping Reactivate sysinit units... machine # [ 71.523314] systemd[1]: Reached target Reactivate sysinit units. machine # [ 71.526757] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 71.528526] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 71.531549] systemd[1]: Reached target Remote File Systems. machine # [ 71.534434] systemd[1]: Starting linger-users.service... machine # [ 71.538135] systemd[1]: Reached target Local File Systems. machine # [ 71.538954] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 71.543878] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 71.544789] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 71.545993] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 71.548090] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 71.549622] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 71.550809] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 71.594091] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 71.595939] systemd[1]: Finished linger-users.service. machine # [ 71.697173] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 71.698760] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 71.956822] nixos[6590]: finished switching to system configuration /nix/store/idzscvjg7fzlslz2zffzdy4j5w94rvcn-nixos-system-machine-test machine: (finished: must succeed: /nix/store/68vy4glkqv6dl08fwnd37a5r9s71a7b0-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModifiedSomethingElse/bin/switch-to-configuration test 2>&1, in 1.34 seconds) (finished: subtest: unit file parser, in 18.10 seconds) subtest: restart and reload by activation script machine: must succeed: /nix/store/68vy4glkqv6dl08fwnd37a5r9s71a7b0-nixos-system-machine-test/specialisation/simpleServiceNorestart/bin/switch-to-configuration test 2>&1 machine # [ 72.161194] nixos[6730]: switching to system configuration /nix/store/d4l5928gq4qk04dz90ps5sx2y9ynckfy-nixos-system-machine-test machine # [ 72.163624] systemd[1]: Stopped target Local File Systems. machine # [ 72.165431] systemd[1]: Stopped target Remote File Systems. machine # [ 72.366713] systemd[1]: Reload requested from client PID 6730 ('.switch-to-conf') (unit backdoor.service)... machine # [ 72.368366] systemd[1]: Reloading... machine # [ 72.592593] systemd[1]: Reloading finished in 223 ms. machine # [ 72.653490] systemd[625]: Reexecution requested from client PID 6799 ('switch-to-confi')... machine # [ 72.655262] systemd[625]: Reexecuting. machine # [ 72.674946] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 72.745323] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 72.750597] systemd[625]: Reload requested from client PID 6799 ('switch-to-confi')... machine # [ 72.752920] systemd[625]: Reloading... machine # [ 72.821428] systemd[625]: Reloading finished in 68 ms. machine # [ 72.826829] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 72.832703] systemd[625]: Stopped Run user-specific NixOS activation. machine # [ 72.834256] systemd[625]: Stopping Run user-specific NixOS activation... machine # [ 72.836204] systemd[625]: Starting Run user-specific NixOS activation... machine # [ 72.855070] systemd[625]: Finished Run user-specific NixOS activation. machine # [ 72.857886] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 72.859169] systemd[1]: Stopping Reactivate sysinit units... machine # [ 72.859886] systemd[1]: Reached target Reactivate sysinit units. machine # [ 72.862599] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 72.864283] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 72.867560] systemd[1]: Reached target Remote File Systems. machine # [ 72.871274] systemd[1]: Starting linger-users.service... machine # [ 72.877432] systemd[1]: Reached target Local File Systems. machine # [ 72.878413] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 72.881520] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 72.882344] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 72.883576] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 72.885554] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 72.888024] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 72.889306] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 72.929085] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 72.931713] systemd[1]: Finished linger-users.service. machine # [ 73.035046] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 73.037170] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 73.295132] nixos[6730]: finished switching to system configuration /nix/store/d4l5928gq4qk04dz90ps5sx2y9ynckfy-nixos-system-machine-test machine: (finished: must succeed: /nix/store/68vy4glkqv6dl08fwnd37a5r9s71a7b0-nixos-system-machine-test/specialisation/simpleServiceNorestart/bin/switch-to-configuration test 2>&1, in 1.34 seconds) machine: must succeed: /nix/store/68vy4glkqv6dl08fwnd37a5r9s71a7b0-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration test 2>&1 machine # [ 73.518976] nixos[6870]: switching to system configuration /nix/store/w0r3427j850714zz043ayq664v70pdzm-nixos-system-machine-test machine # [ 73.522985] systemd[1]: Stopped target Local File Systems. machine # [ 73.523815] systemd[1]: Stopped target Remote File Systems. machine # [ 73.525683] systemd[1]: test.service: Deactivated successfully. machine # [ 73.526742] systemd[1]: Stopped test.service. machine # [ 73.750402] systemd[1]: Reload requested from client PID 6870 ('.switch-to-conf') (unit backdoor.service)... machine # [ 73.752148] systemd[1]: Reloading... machine # [ 73.997932] systemd[1]: Reloading finished in 243 ms. machine # [ 74.057779] systemd[625]: Reexecution requested from client PID 6941 ('switch-to-confi')... machine # [ 74.059660] systemd[625]: Reexecuting. machine # [ 74.076958] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 74.147165] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 74.152608] systemd[625]: Reload requested from client PID 6941 ('switch-to-confi')... machine # [ 74.154545] systemd[625]: Reloading... machine # [ 74.223658] systemd[625]: Reloading finished in 68 ms. machine # [ 74.229098] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 74.237069] systemd[625]: Stopped Run user-specific NixOS activation. machine # [ 74.237977] systemd[625]: Stopping Run user-specific NixOS activation... machine # [ 74.239874] systemd[625]: Starting Run user-specific NixOS activation... machine # [ 74.258947] systemd[625]: Finished Run user-specific NixOS activation. machine # [ 74.262087] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 74.263378] systemd[1]: Stopping Reactivate sysinit units... machine # [ 74.264314] systemd[1]: Reached target Reactivate sysinit units. machine # [ 74.269672] systemd[1]: Created slice Slice /system/templated-no-restart-service. machine # [ 74.272655] systemd[1]: Starting templated-no-restart-service@instance.service... machine # [ 74.280047] systemd[1]: Starting simple-restart-service.service... machine # [ 74.288166] systemd[1]: Created slice Slice /system/templated-reload-triggers-and-restart-by-as. machine # [ 74.290958] systemd[1]: Starting templated-reload-triggers-and-restart-by-as@instance.service... machine # [ 74.294184] systemd[1]: Reached target Remote File Systems. machine # [ 74.302414] systemd[1]: Created slice Slice /system/templated-simple-service. machine # [ 74.304406] systemd[1]: Starting templated-simple-service@instance.service... machine # [ 74.312272] systemd[1]: Starting simple-reload-service.service... machine # [ 74.325411] systemd[1]: Created slice Slice /system/templated-reload-triggers. machine # [ 74.326443] systemd[1]: Created slice Slice /system/templated-reload-triggers-and-restart. machine # [ 74.330437] systemd[1]: Starting linger-users.service... machine # [ 74.334380] systemd[1]: Starting reload-triggers-and-restart.service... machine # [ 74.338786] systemd[1]: Starting reload-triggers.service... machine # [ 74.339623] systemd[1]: Starting templated-reload-triggers-and-restart@instance.service... machine # [ 74.343310] systemd[1]: Starting templated-reload-triggers@instance.service... machine # [ 74.348257] systemd[1]: Reached target Local File Systems. machine # [ 74.353589] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 74.359292] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 74.360119] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 74.361485] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 74.377729] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 74.379171] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 74.380910] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 74.385325] systemd[1]: Finished templated-no-restart-service@instance.service. machine # [ 74.389143] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 74.395723] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 74.412213] systemd[1]: Finished simple-restart-service.service. machine # [ 74.420990] systemd[1]: Created slice Slice /system/templated-simple-restart-service. machine # [ 74.426764] systemd[1]: Created slice Slice /system/templated-simple-reload-service. machine # [ 74.433913] systemd[1]: Finished templated-reload-triggers-and-restart-by-as@instance.service. machine # [ 74.452304] systemd[1]: Finished simple-reload-service.service. machine # [ 74.460077] systemd[1]: Finished templated-simple-service@instance.service. machine # [ 74.475215] systemd[1]: Finished reload-triggers-and-restart.service. machine # [ 74.478615] systemd[1]: Finished reload-triggers.service. machine # [ 74.480203] systemd[1]: Finished templated-reload-triggers-and-restart@instance.service. machine # [ 74.483646] systemd[1]: Finished templated-reload-triggers@instance.service. machine # [ 74.503944] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 74.505869] systemd[1]: Finished linger-users.service. machine # [ 74.606447] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 74.608123] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 74.612126] systemd[1]: Starting no-restart-service.service... machine # [ 74.615059] systemd[1]: Starting reload-triggers-and-restart-by-as.service... machine # [ 74.617183] systemd[1]: Starting simple-service.service... machine # [ 74.624130] systemd[1]: Starting templated-simple-reload-service@instance.service... machine # [ 74.627458] systemd[1]: Starting templated-simple-restart-service@instance.service... machine # [ 74.669508] systemd[1]: Finished no-restart-service.service. machine # [ 74.671417] systemd[1]: Finished reload-triggers-and-restart-by-as.service. machine # [ 74.673518] systemd[1]: Finished simple-service.service. machine # [ 74.675387] systemd[1]: Finished templated-simple-reload-service@instance.service. machine # [ 74.677229] systemd[1]: Finished templated-simple-restart-service@instance.service. machine # [ 74.935295] nixos[6870]: finished switching to system configuration /nix/store/w0r3427j850714zz043ayq664v70pdzm-nixos-system-machine-test machine: (finished: must succeed: /nix/store/68vy4glkqv6dl08fwnd37a5r9s71a7b0-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration test 2>&1, in 1.64 seconds) machine: must succeed: /nix/store/68vy4glkqv6dl08fwnd37a5r9s71a7b0-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration test 2>&1 machine # [ 75.188707] nixos[7040]: switching to system configuration /nix/store/w0r3427j850714zz043ayq664v70pdzm-nixos-system-machine-test machine # [ 75.190924] systemd[1]: Stopped target Remote File Systems. machine # [ 75.192712] systemd[1]: Stopped target Local File Systems. machine # [ 75.409089] systemd[1]: Reload requested from client PID 7040 ('.switch-to-conf') (unit backdoor.service)... machine # [ 75.410789] systemd[1]: Reloading... machine # [ 75.652225] systemd[1]: Reloading finished in 239 ms. machine # [ 75.716027] systemd[625]: Reexecution requested from client PID 7111 ('switch-to-confi')... machine # [ 75.718071] systemd[625]: Reexecuting. machine # [ 75.738973] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 75.808810] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 75.813908] systemd[625]: Reload requested from client PID 7111 ('switch-to-confi')... machine # [ 75.815768] systemd[625]: Reloading... machine # [ 75.884981] systemd[625]: Reloading finished in 67 ms. machine # [ 75.888837] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 75.895280] systemd[625]: Stopped Run user-specific NixOS activation. machine # [ 75.896168] systemd[625]: Stopping Run user-specific NixOS activation... machine # [ 75.898224] systemd[625]: Starting Run user-specific NixOS activation... machine # [ 75.916970] systemd[625]: Finished Run user-specific NixOS activation. machine # [ 75.919899] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 75.921170] systemd[1]: Stopping Reactivate sysinit units... machine # [ 75.921880] systemd[1]: Reached target Reactivate sysinit units. machine # [ 75.926793] systemd[1]: Reloading reload-triggers-and-restart.service... machine # [ 75.931747] systemd[1]: Reloading reload-triggers.service... machine # [ 75.936938] systemd[1]: Reloading simple-reload-service.service... machine # [ 75.942060] systemd[1]: Reloading templated-reload-triggers-and-restart@instance.service... machine # [ 75.945236] systemd[1]: Reloading templated-reload-triggers@instance.service... machine # [ 75.950534] systemd[1]: Reloading templated-simple-reload-service@instance.service... machine # [ 75.988823] systemd[1]: Reloaded reload-triggers-and-restart.service. machine # [ 75.991252] systemd[1]: Reloaded reload-triggers.service. machine # [ 76.004203] systemd[1]: Reloaded simple-reload-service.service. machine # [ 76.006179] systemd[1]: Reloaded templated-reload-triggers-and-restart@instance.service. machine # [ 76.008325] systemd[1]: Reloaded templated-reload-triggers@instance.service. machine # [ 76.010291] systemd[1]: Reloaded templated-simple-reload-service@instance.service. machine # [ 76.013865] systemd[1]: reload-triggers-and-restart-by-as.service: Deactivated successfully. machine # [ 76.016203] systemd[1]: Stopped reload-triggers-and-restart-by-as.service. machine # [ 76.017151] systemd[1]: Stopping reload-triggers-and-restart-by-as.service... machine # [ 76.018776] systemd[1]: Starting reload-triggers-and-restart-by-as.service... machine # [ 76.021177] systemd[1]: simple-restart-service.service: Deactivated successfully. machine # [ 76.022527] systemd[1]: Stopped simple-restart-service.service. machine # [ 76.024331] systemd[1]: Stopping simple-restart-service.service... machine # [ 76.026382] systemd[1]: Starting simple-restart-service.service... machine # [ 76.031334] systemd[1]: simple-service.service: Deactivated successfully. machine # [ 76.032305] systemd[1]: Stopped simple-service.service. machine # [ 76.032983] systemd[1]: Stopping simple-service.service... machine # [ 76.035194] systemd[1]: Starting simple-service.service... machine # [ 76.035944] systemd[1]: templated-reload-triggers-and-restart-by-as@instance.service: Deactivated successfully. machine # [ 76.043854] systemd[1]: Stopped templated-reload-triggers-and-restart-by-as@instance.service. machine # [ 76.045078] systemd[1]: Stopping templated-reload-triggers-and-restart-by-as@instance.service... machine # [ 76.046201] systemd[1]: Starting templated-reload-triggers-and-restart-by-as@instance.service... machine # [ 76.047227] systemd[1]: templated-simple-restart-service@instance.service: Deactivated successfully. machine # [ 76.048327] systemd[1]: Stopped templated-simple-restart-service@instance.service. machine # [ 76.049214] systemd[1]: Stopping templated-simple-restart-service@instance.service... machine # [ 76.055339] systemd[1]: Starting templated-simple-restart-service@instance.service... machine # [ 76.056376] systemd[1]: templated-simple-service@instance.service: Deactivated successfully. machine # [ 76.059422] systemd[1]: Stopped templated-simple-service@instance.service. machine # [ 76.060356] systemd[1]: Stopping templated-simple-service@instance.service... machine # [ 76.062120] systemd[1]: Starting templated-simple-service@instance.service... machine # [ 76.103723] systemd[1]: Finished simple-restart-service.service. machine # [ 76.106259] systemd[1]: Finished reload-triggers-and-restart-by-as.service. machine # [ 76.108864] systemd[1]: Finished simple-service.service. machine # [ 76.111684] systemd[1]: Finished templated-reload-triggers-and-restart-by-as@instance.service. machine # [ 76.116182] systemd[1]: Finished templated-simple-restart-service@instance.service. machine # [ 76.118404] systemd[1]: Finished templated-simple-service@instance.service. machine # [ 76.121943] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 76.123755] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 76.129856] systemd[1]: Reached target Local File Systems. machine # [ 76.131534] systemd[1]: Reached target Remote File Systems. machine # [ 76.136204] systemd[1]: Starting linger-users.service... machine # [ 76.138721] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 76.145768] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 76.146594] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 76.148465] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 76.150381] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 76.151882] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 76.152989] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 76.187655] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 76.189614] systemd[1]: Finished linger-users.service. machine # [ 76.295947] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 76.298186] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 76.554766] nixos[7040]: finished switching to system configuration /nix/store/w0r3427j850714zz043ayq664v70pdzm-nixos-system-machine-test machine: (finished: must succeed: /nix/store/68vy4glkqv6dl08fwnd37a5r9s71a7b0-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration test 2>&1, in 1.62 seconds) machine: must succeed: /nix/store/68vy4glkqv6dl08fwnd37a5r9s71a7b0-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script-modified/bin/switch-to-configuration test 2>&1 machine # [ 76.828517] nixos[7206]: switching to system configuration /nix/store/mjb7r8n685ffgz5x2mam3w47vi2nw4kl-nixos-system-machine-test machine # [ 76.830773] systemd[1]: Stopped target Local File Systems. machine # [ 76.832680] systemd[1]: Stopped target Remote File Systems. machine # [ 77.068891] systemd[1]: Reload requested from client PID 7206 ('.switch-to-conf') (unit backdoor.service)... machine # [ 77.070571] systemd[1]: Reloading... machine # [ 77.323192] systemd[1]: Reloading finished in 250 ms. machine # [ 77.387322] systemd[625]: Reexecution requested from client PID 7277 ('switch-to-confi')... machine # [ 77.389833] systemd[625]: Reexecuting. machine # [ 77.409918] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 77.479753] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 77.485136] systemd[625]: Reload requested from client PID 7277 ('switch-to-confi')... machine # [ 77.487108] systemd[625]: Reloading... machine # [ 77.555439] systemd[625]: Reloading finished in 67 ms. machine # [ 77.560820] systemd[625]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 77.566896] systemd[625]: Stopped Run user-specific NixOS activation. machine # [ 77.567894] systemd[625]: Stopping Run user-specific NixOS activation... machine # [ 77.570240] systemd[625]: Starting Run user-specific NixOS activation... machine # [ 77.588885] systemd[625]: Finished Run user-specific NixOS activation. machine # [ 77.591892] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 77.593258] systemd[1]: Stopping Reactivate sysinit units... machine # [ 77.594262] systemd[1]: Reached target Reactivate sysinit units. machine # [ 77.598547] systemd[1]: Reloading reload-triggers.service... machine # [ 77.602232] systemd[1]: Reloading simple-reload-service.service... machine # [ 77.609300] systemd[1]: Reloading templated-reload-triggers@instance.service... machine # [ 77.612785] systemd[1]: Reloading templated-simple-reload-service@instance.service... machine # [ 77.642803] systemd[1]: Reloaded reload-triggers.service. machine # [ 77.644790] systemd[1]: Reloaded simple-reload-service.service. machine # [ 77.651405] systemd[1]: Reloaded templated-reload-triggers@instance.service. machine # [ 77.653553] systemd[1]: Reloaded templated-simple-reload-service@instance.service. machine # [ 77.656532] systemd[1]: reload-triggers-and-restart-by-as.service: Deactivated successfully. machine # [ 77.658218] systemd[1]: Stopped reload-triggers-and-restart-by-as.service. machine # [ 77.659160] systemd[1]: Stopping reload-triggers-and-restart-by-as.service... machine # [ 77.661508] systemd[1]: Starting reload-triggers-and-restart-by-as.service... machine # [ 77.664508] systemd[1]: reload-triggers-and-restart.service: Deactivated successfully. machine # [ 77.665596] systemd[1]: Stopped reload-triggers-and-restart.service. machine # [ 77.666420] systemd[1]: Stopping reload-triggers-and-restart.service... machine # [ 77.669326] systemd[1]: Starting reload-triggers-and-restart.service... machine # [ 77.671302] systemd[1]: simple-restart-service.service: Deactivated successfully. machine # [ 77.672272] systemd[1]: Stopped simple-restart-service.service. machine # [ 77.673051] systemd[1]: Stopping simple-restart-service.service... machine # [ 77.677362] systemd[1]: Starting simple-restart-service.service... machine # [ 77.678236] systemd[1]: simple-service.service: Deactivated successfully. machine # [ 77.680127] systemd[1]: Stopped simple-service.service. machine # [ 77.680830] systemd[1]: Stopping simple-service.service... machine # [ 77.684718] systemd[1]: Starting simple-service.service... machine # [ 77.686437] systemd[1]: templated-reload-triggers-and-restart-by-as@instance.service: Deactivated successfully. machine # [ 77.690229] systemd[1]: Stopped templated-reload-triggers-and-restart-by-as@instance.service. machine # [ 77.691372] systemd[1]: Stopping templated-reload-triggers-and-restart-by-as@instance.service... machine # [ 77.692555] systemd[1]: Starting templated-reload-triggers-and-restart-by-as@instance.service... machine # [ 77.696193] systemd[1]: templated-reload-triggers-and-restart@instance.service: Deactivated successfully. machine # [ 77.700112] systemd[1]: Stopped templated-reload-triggers-and-restart@instance.service. machine # [ 77.703973] systemd[1]: Stopping templated-reload-triggers-and-restart@instance.service... machine # [ 77.706176] systemd[1]: Starting templated-reload-triggers-and-restart@instance.service... machine # [ 77.708358] systemd[1]: templated-simple-restart-service@instance.service: Deactivated successfully. machine # [ 77.712207] systemd[1]: Stopped templated-simple-restart-service@instance.service. machine # [ 77.716365] systemd[1]: Stopping templated-simple-restart-service@instance.service... machine # [ 77.718146] systemd[1]: Starting templated-simple-restart-service@instance.service... machine # [ 77.721227] systemd[1]: templated-simple-service@instance.service: Deactivated successfully. machine # [ 77.726647] systemd[1]: Stopped templated-simple-service@instance.service. machine # [ 77.727694] systemd[1]: Stopping templated-simple-service@instance.service... machine # [ 77.732363] systemd[1]: Starting templated-simple-service@instance.service... machine # [ 77.771053] systemd[1]: Finished reload-triggers-and-restart.service. machine # [ 77.774518] systemd[1]: Finished reload-triggers-and-restart-by-as.service. machine # [ 77.787313] systemd[1]: Finished simple-restart-service.service. machine # [ 77.789177] systemd[1]: Finished simple-service.service. machine # [ 77.792272] systemd[1]: Finished templated-reload-triggers-and-restart-by-as@instance.service. machine # [ 77.796510] systemd[1]: Finished templated-reload-triggers-and-restart@instance.service. machine # [ 77.800609] systemd[1]: Finished templated-simple-restart-service@instance.service. machine # [ 77.804919] systemd[1]: Finished templated-simple-service@instance.service. machine # [ 77.808959] systemd[1]: Reached target Remote File Systems. machine # [ 77.813873] systemd[1]: Starting linger-users.service... machine # [ 77.815982] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 77.817920] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 77.821143] systemd[1]: Reached target Local File Systems. machine # [ 77.821930] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 77.827199] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 77.828241] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 77.829423] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 77.831668] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 77.837131] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 77.838417] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 77.878899] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 77.880662] systemd[1]: Finished linger-users.service. machine # [ 77.982106] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 77.983904] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 78.242388] nixos[7206]: finished switching to system configuration /nix/store/mjb7r8n685ffgz5x2mam3w47vi2nw4kl-nixos-system-machine-test machine: (finished: must succeed: /nix/store/68vy4glkqv6dl08fwnd37a5r9s71a7b0-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script-modified/bin/switch-to-configuration test 2>&1, in 1.69 seconds) machine: must succeed: /nix/store/68vy4glkqv6dl08fwnd37a5r9s71a7b0-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/68vy4glkqv6dl08fwnd37a5r9s71a7b0-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration dry-activate 2>&1, in 0.32 seconds) (finished: subtest: restart and reload by activation script, in 6.61 seconds) (finished: run the VM test script, in 79.51 seconds) test script finished in 79.54s cleanup kill QemuMachine (pid 45) machine # qemu-system-x86_64: terminating on signal 15 from pid 39 (/nix/store/lb41b0anx1f98y9y5s9mdv97gjgsq740-python3-3.14.7/bin/python3.14) machine # [2026-10-15T02:53:12Z INFO virtiofsd] Client disconnected, shutting down machine # [2026-10-15T02:53:12Z INFO virtiofsd] Client disconnected, shutting down machine # [2026-10-15T02:53:12Z INFO virtiofsd] Client disconnected, shutting down (finished: cleanup, in 0.17 seconds) additionally exposed symbols: machine, other, vlan1, start_all, test_script, machines, machines_qemu, machines_nspawn, vlans, driver, log, os, create_machine, subtest, run_tests, join_all, retry, serial_stdout_off, serial_stdout_on, polling_condition, BaseMachine, QemuMachine, NspawnMachine, t, debug, dump_machine_ssh