tribuchet: building on jamie Machine state will be reset. To keep it, pass --keep-machine-state start all VLans (finished: start all VLans, in 0.00 seconds) Test will time out and terminate in 3600.0 seconds run the VM test script machine: waiting for unit multi-user.target machine: waiting for the VM to finish booting machine: starting vm machine: QEMU running (pid 45) machine # Disk image does not exist, creating the virtualisation disk image... machine # Formatting '/build/vm-state-machine/tmp.w12KWICkKD', 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: 1789e940-8c0f-42ef-8261-dab122563b16 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-14T03:22:53Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1) machine # [2026-10-14T03:22:53Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether machine # [2026-10-14T03:22:53Z INFO virtiofsd] Waiting for vhost-user socket connection... machine # [2026-10-14T03:22:53Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1) machine # [2026-10-14T03:22:53Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether machine # [2026-10-14T03:22:53Z INFO virtiofsd] Waiting for vhost-user socket connection... machine # [2026-10-14T03:22:53Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1) machine # [2026-10-14T03:22:53Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether machine # [2026-10-14T03:22:53Z INFO virtiofsd] Waiting for vhost-user socket connection... machine # [2026-10-14T03:22:53Z INFO virtiofsd] Client connected, servicing requests machine # [2026-10-14T03:22:53Z INFO virtiofsd] Client connected, servicing requests machine # [2026-10-14T03:22: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/06jla896dwcr07hdzzrcz50s66462nzq-nixos-system-machine-test/init regInfo=/nix/.ro-store/dd154zy4dkzpbypwxyr0qwfqfrgqrdra-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 472544177 cycles machine # [ 0.000002] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns machine # [ 0.000005] tsc: Detected 2400.012 MHz processor machine # [ 0.000771] last_pfn = 0x3ffd8 max_arch_pfn = 0x10000000000 machine # [ 0.000798] MTRR map: 4 entries (3 fixed + 1 variable; max 19), built from 8 variable MTRRs machine # [ 0.000800] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT machine # [ 0.002703] found SMP MP-table at [mem 0x000f5450-0x000f545f] machine # [ 0.002716] Using GB pages for direct mapping machine # [ 0.002834] RAMDISK: [mem 0x3e2ba000-0x3ffcffff] machine # [ 0.002842] ACPI: Early table checksum verification disabled machine # [ 0.002845] ACPI: RSDP 0x00000000000F5270 000014 (v00 BOCHS ) machine # [ 0.002848] ACPI: RSDT 0x000000003FFE2422 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) machine # [ 0.002853] ACPI: FACP 0x000000003FFE221A 0000F4 (v03 BOCHS BXPC 00000001 BXPC 00000001) machine # [ 0.002860] ACPI: DSDT 0x000000003FFE0040 0021DA (v01 BOCHS BXPC 00000001 BXPC 00000001) machine # [ 0.002862] ACPI: FACS 0x000000003FFE0000 000040 machine # [ 0.002864] ACPI: APIC 0x000000003FFE230E 000078 (v03 BOCHS BXPC 00000001 BXPC 00000001) machine # [ 0.002865] ACPI: HPET 0x000000003FFE2386 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) machine # [ 0.002867] ACPI: MCFG 0x000000003FFE23BE 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001) machine # [ 0.002869] ACPI: WAET 0x000000003FFE23FA 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001) machine # [ 0.002870] ACPI: Reserving FACP table memory at [mem 0x3ffe221a-0x3ffe230d] machine # [ 0.002871] ACPI: Reserving DSDT table memory at [mem 0x3ffe0040-0x3ffe2219] machine # [ 0.002872] ACPI: Reserving FACS table memory at [mem 0x3ffe0000-0x3ffe003f] machine # [ 0.002872] ACPI: Reserving APIC table memory at [mem 0x3ffe230e-0x3ffe2385] machine # [ 0.002873] ACPI: Reserving HPET table memory at [mem 0x3ffe2386-0x3ffe23bd] machine # [ 0.002873] ACPI: Reserving MCFG table memory at [mem 0x3ffe23be-0x3ffe23f9] machine # [ 0.002874] ACPI: Reserving WAET table memory at [mem 0x3ffe23fa-0x3ffe2421] machine # [ 0.003094] No NUMA configuration found machine # [ 0.003095] Faking a node at [mem 0x0000000000000000-0x000000003ffd7fff] machine # [ 0.003097] NODE_DATA(0) allocated [mem 0x3ffd2780-0x3ffd7cff] machine # [ 0.005540] Zone ranges: machine # [ 0.005541] DMA [mem 0x0000000000001000-0x0000000000ffffff] machine # [ 0.005543] DMA32 [mem 0x0000000001000000-0x000000003ffd7fff] machine # [ 0.005544] Normal empty machine # [ 0.005545] Device empty machine # [ 0.005546] Movable zone start for each node machine # [ 0.005547] Early memory node ranges machine # [ 0.005547] node 0: [mem 0x0000000000001000-0x000000000009efff] machine # [ 0.005548] node 0: [mem 0x0000000000100000-0x000000003ffd7fff] machine # [ 0.005549] Initmem setup node 0 [mem 0x0000000000001000-0x000000003ffd7fff] machine # [ 0.005573] On node 0, zone DMA: 1 pages in unavailable ranges machine # [ 0.005895] On node 0, zone DMA: 97 pages in unavailable ranges machine # [ 0.024927] On node 0, zone DMA32: 40 pages in unavailable ranges machine # [ 0.025385] ACPI: PM-Timer IO Port: 0x608 machine # [ 0.025396] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) machine # [ 0.025423] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 machine # [ 0.025426] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) machine # [ 0.025427] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) machine # [ 0.025429] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) machine # [ 0.025430] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) machine # [ 0.025430] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) machine # [ 0.025433] ACPI: Using ACPI (MADT) for SMP configuration information machine # [ 0.025433] ACPI: HPET id: 0x8086a201 base: 0xfed00000 machine # [ 0.025437] TSC deadline timer available machine # [ 0.025441] CPU topo: Max. logical packages: 1 machine # [ 0.025442] CPU topo: Max. logical dies: 1 machine # [ 0.025443] CPU topo: Max. dies per package: 1 machine # [ 0.025446] CPU topo: Max. threads per core: 1 machine # [ 0.025446] CPU topo: Num. cores per package: 1 machine # [ 0.025447] CPU topo: Num. threads per package: 1 machine # [ 0.025447] CPU topo: Allowing 1 present CPUs plus 0 hotplug CPUs machine # [ 0.025464] kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write() machine # [ 0.025494] PM: hibernation: Registered nosave memory: [mem 0x00000000-0x00000fff] machine # [ 0.025496] PM: hibernation: Registered nosave memory: [mem 0x0009f000-0x000fffff] machine # [ 0.025497] [mem 0x40000000-0xafffffff] available for PCI devices machine # [ 0.025499] Booting paravirtualized kernel on KVM machine # [ 0.025501] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns machine # [ 0.030166] setup_percpu: NR_CPUS:384 nr_cpumask_bits:1 nr_cpu_ids:1 nr_node_ids:1 machine # [ 0.032441] percpu: Embedded 98 pages/cpu s278528 r8192 d114688 u2097152 machine # [ 0.032483] kvm-guest: PV spinlocks disabled, single CPU machine # [ 0.032484] 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/06jla896dwcr07hdzzrcz50s66462nzq-nixos-system-machine-test/init regInfo=/nix/.ro-store/dd154zy4dkzpbypwxyr0qwfqfrgqrdra-closure-info/registration console=ttyS0,115200n8 console=tty0 machine # [ 0.032576] Unknown kernel command line parameters "regInfo=/nix/.ro-store/dd154zy4dkzpbypwxyr0qwfqfrgqrdra-closure-info/registration", will be passed to user space. machine # [ 0.032589] random: crng init done machine # [ 0.032590] printk: log buffer data + meta data: 262144 + 917504 = 1179648 bytes machine # [ 0.032611] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes, linear) machine # [ 0.033178] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes, linear) machine # [ 0.033208] Fallback order for Node 0: 0 machine # [ 0.033211] Built 1 zonelists, mobility grouping on. Total pages: 262006 machine # [ 0.033212] Policy zone: DMA32 machine # [ 0.036041] mem auto-init: stack:all(zero), heap alloc:on, heap free:off machine # [ 0.038596] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1 machine # [ 0.040910] allocated 2097152 bytes of page_ext machine # [ 0.050797] ftrace: allocating 48837 entries in 192 pages machine # [ 0.050799] ftrace: allocated 192 pages with 2 groups machine # [ 0.051644] Dynamic Preempt: lazy machine # [ 0.051786] rcu: Preemptible hierarchical RCU implementation. machine # [ 0.051787] rcu: RCU event tracing is enabled. machine # [ 0.051787] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1. machine # [ 0.051789] Trampoline variant of Tasks RCU enabled. machine # [ 0.051789] Rude variant of Tasks RCU enabled. machine # [ 0.051789] Tracing variant of Tasks RCU enabled. machine # [ 0.051790] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. machine # [ 0.051791] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1 machine # [ 0.051813] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. machine # [ 0.051815] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. machine # [ 0.051815] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. machine # [ 0.056215] NR_IRQS: 24832, nr_irqs: 256, preallocated irqs: 16 machine # [ 0.056494] rcu: srcu_init: Setting srcu_struct sizes based on contention. machine # [ 0.056501] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns machine # [ 0.056596] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____) machine # [ 0.060123] Console: colour VGA+ 80x25 machine # [ 0.060126] printk: legacy console [tty0] enabled machine # [ 0.089640] printk: legacy console [ttyS0] enabled machine # [ 0.195632] ACPI: Core revision 20250807 machine # [ 0.196571] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns machine # [ 0.198177] APIC: Switch to symmetric I/O mode setup machine # [ 0.199169] x2apic enabled machine # [ 0.199937] APIC: Switched APIC routing to: physical x2apic machine # [ 0.201824] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 machine # [ 0.202872] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x229842dd0bd, max_idle_ns: 440795319571 ns machine # [ 0.204609] Calibrating delay loop (skipped) preset value.. 4800.02 BogoMIPS (lpj=2400012) machine # [ 0.205692] x86/cpu: User Mode Instruction Prevention (UMIP) activated machine # [ 0.207726] Last level iTLB entries: 4KB 512, 2MB 255, 4MB 127 machine # [ 0.208607] Last level dTLB entries: 4KB 512, 2MB 255, 4MB 127, 1GB 0 machine # [ 0.209610] mitigations: Enabled attack vectors: user_kernel, user_user, guest_host, guest_guest, SMT mitigations: auto machine # [ 0.210607] Speculative Store Bypass: Mitigation: Speculative Store Bypass disabled via prctl machine # [ 0.212607] Transient Scheduler Attacks: Vulnerable: No microcode machine # [ 0.213606] Spectre V2 : Mitigation: Enhanced / Automatic IBRS machine # [ 0.214606] Speculative Return Stack Overflow: Mitigation: Safe RET machine # [ 0.215606] Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization machine # [ 0.217615] Spectre V2 : Enabling IBPB for BPF machine # [ 0.218608] Spectre V2 : mitigation: Enabling conditional Indirect Branch Prediction Barrier machine # [ 0.219607] active return thunk: srso_alias_return_thunk machine # [ 0.220628] x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers' machine # [ 0.221606] x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers' machine # [ 0.222606] x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers' machine # [ 0.223606] x86/fpu: Supporting XSAVE feature 0x020: 'AVX-512 opmask' machine # [ 0.224606] x86/fpu: Supporting XSAVE feature 0x040: 'AVX-512 Hi256' machine # [ 0.225606] x86/fpu: Supporting XSAVE feature 0x080: 'AVX-512 ZMM_Hi256' machine # [ 0.226606] x86/fpu: Supporting XSAVE feature 0x200: 'Protection Keys User registers' machine # [ 0.227607] x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256 machine # [ 0.229332] x86/fpu: xstate_offset[5]: 832, xstate_sizes[5]: 64 machine # [ 0.230333] x86/fpu: xstate_offset[6]: 896, xstate_sizes[6]: 512 machine # [ 0.230606] x86/fpu: xstate_offset[7]: 1408, xstate_sizes[7]: 1024 machine # [ 0.231606] x86/fpu: xstate_offset[9]: 2432, xstate_sizes[9]: 8 machine # [ 0.232607] x86/fpu: Enabled xstate features 0x2e7, context size is 2440 bytes, using 'compacted' format. machine # [ 0.265803] Freeing SMP alternatives memory: 48K machine # [ 0.266609] pid_max: default: 32768 minimum: 301 machine # [ 0.267691] LSM: initializing lsm=capability,landlock,yama,bpf,ima machine # [ 0.268702] landlock: Up and running. machine # [ 0.269323] Yama: becoming mindful. machine # [ 0.270243] LSM support for eBPF active machine # [ 0.270703] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear) machine # [ 0.271628] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear) machine # [ 0.274438] smpboot: CPU0: AMD EPYC 9654 96-Core Processor (family: 0x19, model: 0x11, stepping: 0x1) machine # [ 0.275170] Performance Events: Fam17h+ core perfctr, AMD PMU driver. machine # [ 0.275611] ... version: 2 machine # [ 0.276307] ... bit width: 48 machine # [ 0.276609] ... generic counters: 6 machine # [ 0.277313] ... generic bitmap: 000000000000003f machine # [ 0.277655] ... fixed-purpose counters: 0 machine # [ 0.278347] ... fixed-purpose bitmap: 0000000000000000 machine # [ 0.278609] ... value mask: 0000ffffffffffff machine # [ 0.279464] ... max period: 00007fffffffffff machine # [ 0.280261] ... global_ctrl mask: 000000000000003f machine # [ 0.280728] signal: max sigframe size: 3376 machine # [ 0.281484] rcu: Hierarchical SRCU implementation. machine # [ 0.282170] rcu: Max phase no-delay instances is 400. machine # [ 0.287124] smp: Bringing up secondary CPUs ... machine # [ 0.287622] smp: Brought up 1 node, 1 CPU machine # [ 0.288279] smpboot: Total of 1 processors activated (4800.02 BogoMIPS) machine # [ 0.288776] Memory: 940320K/1048024K available (18124K kernel code, 2728K rwdata, 13644K rodata, 3656K init, 3632K bss, 100304K reserved, 0K cma-reserved) machine # [ 0.289826] devtmpfs: initialized machine # [ 0.290682] x86/mm: Memory block size: 128MB machine # [ 0.292374] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear) machine # [ 0.293493] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear). machine # [ 0.294702] pinctrl core: initialized pinctrl subsystem machine # [ 0.295826] PM: RTC time: 03:22:53, date: 2026-10-14 machine # [ 0.299878] NET: Registered PF_NETLINK/PF_ROUTE protocol family machine # [ 0.300989] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations machine # [ 0.301627] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations machine # [ 0.302761] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations machine # [ 0.303618] audit: initializing netlink subsys (disabled) machine # [ 0.304611] audit: type=2000 audit(1791948174.466:1): state=initialized audit_enabled=0 res=1 machine # [ 0.305696] thermal_sys: Registered thermal governor 'fair_share' machine # [ 0.305698] thermal_sys: Registered thermal governor 'bang_bang' machine # [ 0.306610] thermal_sys: Registered thermal governor 'step_wise' machine # [ 0.307530] thermal_sys: Registered thermal governor 'user_space' machine # [ 0.308320] thermal_sys: Registered thermal governor 'power_allocator' machine # [ 0.308621] cpuidle: using governor menu machine # [ 0.310848] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 machine # [ 0.311839] PCI: ECAM [mem 0xb0000000-0xbfffffff] (base 0xb0000000) for domain 0000 [bus 00-ff] machine # [ 0.312611] PCI: ECAM [mem 0xb0000000-0xbfffffff] reserved as E820 entry machine # [ 0.313621] PCI: Using configuration type 1 for base access machine # [ 0.314719] kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible. machine # [ 0.321631] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages machine # [ 0.322609] HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page machine # [ 0.327610] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages machine # [ 0.328610] HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page machine # [ 0.339864] ACPI: Added _OSI(Module Device) machine # [ 0.340610] ACPI: Added _OSI(Processor Device) machine # [ 0.341335] ACPI: Added _OSI(Processor Aggregator Device) machine # [ 0.347109] ACPI: 1 ACPI AML tables successfully acquired and loaded machine # [ 0.351075] ACPI: Interpreter enabled machine # [ 0.351625] ACPI: PM: (supports S0 S3 S4 S5) machine # [ 0.352373] ACPI: Using IOAPIC for interrupt routing machine # [ 0.354670] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug machine # [ 0.355609] PCI: Using E820 reservations for host bridge windows machine # [ 0.358706] ACPI: Enabled 2 GPEs in block 00 to 3F machine # [ 0.364598] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) machine # [ 0.365367] acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] machine # [ 0.366687] acpi PNP0A08:00: _OSC: platform does not support [PCIeHotplug LTR] machine # [ 0.367733] acpi PNP0A08:00: _OSC: OS now controls [PME AER PCIeCapability] machine # [ 0.368972] PCI host bridge to bus 0000:00 machine # [ 0.369613] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] machine # [ 0.370609] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] machine # [ 0.371609] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] machine # [ 0.372609] pci_bus 0000:00: root bus resource [mem 0x40000000-0xafffffff window] machine # [ 0.373609] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window] machine # [ 0.374610] pci_bus 0000:00: root bus resource [mem 0x100000000-0x8ffffffff window] machine # [ 0.375609] pci_bus 0000:00: root bus resource [bus 00-ff] machine # [ 0.376589] pci 0000:00:00.0: [8086:29c0] type 00 class 0x060000 conventional PCI endpoint machine # [ 0.378016] pci 0000:00:01.0: [1234:1111] type 00 class 0x030000 conventional PCI endpoint machine # [ 0.380675] pci 0000:00:01.0: BAR 0 [mem 0xfd000000-0xfdffffff pref] machine # [ 0.381621] pci 0000:00:01.0: BAR 2 [mem 0xfebd0000-0xfebd0fff] machine # [ 0.382543] pci 0000:00:01.0: ROM [mem 0xfebc0000-0xfebcffff pref] machine # [ 0.383519] pci 0000:00:01.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff] machine # [ 0.385311] pci 0000:00:02.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint machine # [ 0.387626] pci 0000:00:02.0: BAR 0 [io 0xc100-0xc11f] machine # [ 0.388455] pci 0000:00:02.0: BAR 1 [mem 0xfebd1000-0xfebd1fff] machine # [ 0.389331] pci 0000:00:02.0: BAR 4 [mem 0xfe000000-0xfe003fff 64bit pref] machine # [ 0.389615] pci 0000:00:02.0: ROM [mem 0xfeb40000-0xfeb7ffff pref] machine # [ 0.391284] pci 0000:00:03.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint machine # [ 0.393627] pci 0000:00:03.0: BAR 0 [io 0xc120-0xc13f] machine # [ 0.394464] pci 0000:00:03.0: BAR 1 [mem 0xfebd2000-0xfebd2fff] machine # [ 0.395347] pci 0000:00:03.0: BAR 4 [mem 0xfe004000-0xfe007fff 64bit pref] machine # [ 0.396171] pci 0000:00:04.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint machine # [ 0.398774] pci 0000:00:04.0: BAR 0 [io 0xc000-0xc07f] machine # [ 0.399615] pci 0000:00:04.0: BAR 1 [mem 0xfebd3000-0xfebd3fff] machine # [ 0.400552] pci 0000:00:04.0: BAR 4 [mem 0xfe008000-0xfe00bfff 64bit pref] machine # [ 0.401995] pci 0000:00:05.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint machine # [ 0.403617] pci 0000:00:05.0: BAR 0 [io 0xc140-0xc15f] machine # [ 0.404492] pci 0000:00:05.0: BAR 1 [mem 0xfebd4000-0xfebd4fff] machine # [ 0.405343] pci 0000:00:05.0: BAR 4 [mem 0xfe00c000-0xfe00ffff 64bit pref] machine # [ 0.405617] pci 0000:00:05.0: ROM [mem 0xfeb80000-0xfebbffff pref] machine # [ 0.407580] pci 0000:00:06.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint machine # [ 0.409448] pci 0000:00:06.0: BAR 1 [mem 0xfebd5000-0xfebd5fff] machine # [ 0.410333] pci 0000:00:06.0: BAR 4 [mem 0xfe010000-0xfe013fff 64bit pref] machine # [ 0.411153] pci 0000:00:07.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint machine # [ 0.412621] pci 0000:00:07.0: BAR 1 [mem 0xfebd6000-0xfebd6fff] machine # [ 0.413550] pci 0000:00:07.0: BAR 4 [mem 0xfe014000-0xfe017fff 64bit pref] machine # [ 0.415453] pci 0000:00:08.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint machine # [ 0.417327] pci 0000:00:08.0: BAR 1 [mem 0xfebd7000-0xfebd7fff] machine # [ 0.417631] pci 0000:00:08.0: BAR 4 [mem 0xfe018000-0xfe01bfff 64bit pref] machine # [ 0.419154] pci 0000:00:09.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint machine # [ 0.420622] pci 0000:00:09.0: BAR 1 [mem 0xfebd8000-0xfebd8fff] machine # [ 0.421570] pci 0000:00:09.0: BAR 4 [mem 0xfe01c000-0xfe01ffff 64bit pref] machine # [ 0.422984] pci 0000:00:0a.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint machine # [ 0.424648] pci 0000:00:0a.0: BAR 0 [io 0xc080-0xc0bf] machine # [ 0.425486] pci 0000:00:0a.0: BAR 1 [mem 0xfebd9000-0xfebd9fff] machine # [ 0.426352] pci 0000:00:0a.0: BAR 4 [mem 0xfe020000-0xfe023fff 64bit pref] machine # [ 0.427990] pci 0000:00:0b.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint machine # [ 0.429626] pci 0000:00:0b.0: BAR 0 [io 0xc160-0xc17f] machine # [ 0.430462] pci 0000:00:0b.0: BAR 1 [mem 0xfebda000-0xfebdafff] machine # [ 0.431351] pci 0000:00:0b.0: BAR 4 [mem 0xfe024000-0xfe027fff 64bit pref] machine # [ 0.432183] pci 0000:00:1d.0: [8086:2934] type 00 class 0x0c0300 conventional PCI endpoint machine # [ 0.433155] pci 0000:00:1d.0: BAR 4 [io 0xc180-0xc19f] machine # [ 0.433810] pci 0000:00:1d.1: [8086:2935] type 00 class 0x0c0300 conventional PCI endpoint machine # [ 0.435153] pci 0000:00:1d.1: BAR 4 [io 0xc1a0-0xc1bf] machine # [ 0.435819] pci 0000:00:1d.2: [8086:2936] type 00 class 0x0c0300 conventional PCI endpoint machine # [ 0.437617] pci 0000:00:1d.2: BAR 4 [io 0xc1c0-0xc1df] machine # [ 0.438676] pci 0000:00:1d.7: [8086:293a] type 00 class 0x0c0320 conventional PCI endpoint machine # [ 0.442148] pci 0000:00:1d.7: BAR 0 [mem 0xfebdb000-0xfebdbfff] machine # [ 0.442907] pci 0000:00:1f.0: [8086:2918] type 00 class 0x060100 conventional PCI endpoint machine # [ 0.443903] pci 0000:00:1f.0: quirk: [io 0x0600-0x067f] claimed by ICH6 ACPI/GPIO/TCO machine # [ 0.444855] pci 0000:00:1f.2: [8086:2922] type 00 class 0x010601 conventional PCI endpoint machine # [ 0.446638] pci 0000:00:1f.2: BAR 4 [io 0xc1e0-0xc1ff] machine # [ 0.447469] pci 0000:00:1f.2: BAR 5 [mem 0xfebdc000-0xfebdcfff] machine # [ 0.448636] pci 0000:00:1f.3: [8086:2930] type 00 class 0x0c0500 conventional PCI endpoint machine # [ 0.450349] pci 0000:00:1f.3: BAR 4 [io 0x0700-0x073f] machine # [ 0.453629] ACPI: PCI: Interrupt link LNKA configured for IRQ 10 machine # [ 0.454713] ACPI: PCI: Interrupt link LNKB configured for IRQ 10 machine # [ 0.455713] ACPI: PCI: Interrupt link LNKC configured for IRQ 11 machine # [ 0.456706] ACPI: PCI: Interrupt link LNKD configured for IRQ 11 machine # [ 0.457708] ACPI: PCI: Interrupt link LNKE configured for IRQ 10 machine # [ 0.458715] ACPI: PCI: Interrupt link LNKF configured for IRQ 10 machine # [ 0.459710] ACPI: PCI: Interrupt link LNKG configured for IRQ 11 machine # [ 0.460707] ACPI: PCI: Interrupt link LNKH configured for IRQ 11 machine # [ 0.461642] ACPI: PCI: Interrupt link GSIA configured for IRQ 16 machine # [ 0.462579] ACPI: PCI: Interrupt link GSIB configured for IRQ 17 machine # [ 0.463349] ACPI: PCI: Interrupt link GSIC configured for IRQ 18 machine # [ 0.463624] ACPI: PCI: Interrupt link GSID configured for IRQ 19 machine # [ 0.464569] ACPI: PCI: Interrupt link GSIE configured for IRQ 20 machine # [ 0.465344] ACPI: PCI: Interrupt link GSIF configured for IRQ 21 machine # [ 0.465625] ACPI: PCI: Interrupt link GSIG configured for IRQ 22 machine # [ 0.466624] ACPI: PCI: Interrupt link GSIH configured for IRQ 23 machine # [ 0.468642] iommu: Default domain type: Translated machine # [ 0.469473] iommu: DMA domain TLB invalidation policy: lazy mode machine # [ 0.470617] ACPI: bus type USB registered machine # [ 0.471371] usbcore: registered new interface driver usbfs machine # [ 0.471623] usbcore: registered new interface driver hub machine # [ 0.472501] usbcore: registered new device driver usb machine # [ 0.474164] NetLabel: Initializing machine # [ 0.474610] NetLabel: domain hash size = 128 machine # [ 0.475422] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO machine # [ 0.476372] NetLabel: unlabeled traffic allowed by default machine # [ 0.476621] PCI: Using ACPI for IRQ routing machine # [ 0.521600] pci 0000:00:01.0: vgaarb: setting as boot VGA device machine # [ 0.521605] pci 0000:00:01.0: vgaarb: bridge control possible machine # [ 0.521605] pci 0000:00:01.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none machine # [ 0.521614] vgaarb: loaded machine # [ 0.522331] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 machine # [ 0.522609] hpet0: 3 comparators, 64-bit 100.000000 MHz counter machine # [ 0.526696] clocksource: Switched to clocksource kvm-clock machine # [ 0.530168] VFS: Disk quotas dquot_6.6.0 machine # [ 0.530843] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) machine # [ 0.532160] pnp: PnP ACPI init machine # [ 0.532926] ACPI: IRQ 4 override to edge(!), high(!) machine # [ 0.533835] system 00:04: [mem 0xb0000000-0xbfffffff window] has been reserved machine # [ 0.535335] pnp: PnP ACPI: found 5 devices machine # [ 0.542900] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns machine # [ 0.544342] clocksource: Switched to clocksource acpi_pm machine # [ 0.545310] NET: Registered PF_INET protocol family machine # [ 0.546341] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear) machine # [ 0.563354] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear) machine # [ 0.565057] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) machine # [ 0.566375] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear) machine # [ 0.567711] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear) machine # [ 0.568932] TCP: Hash tables configured (established 8192 bind 8192) machine # [ 0.569993] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear) machine # [ 0.571283] UDP hash table entries: 512 (order: 3, 32768 bytes, linear) machine # [ 0.572369] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear) machine # [ 0.573544] NET: Registered PF_UNIX/PF_LOCAL protocol family machine # [ 0.574497] NET: Registered PF_XDP protocol family machine # [ 0.575345] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] machine # [ 0.576342] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] machine # [ 0.577352] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] machine # [ 0.578452] pci_bus 0000:00: resource 7 [mem 0x40000000-0xafffffff window] machine # [ 0.579549] pci_bus 0000:00: resource 8 [mem 0xc0000000-0xfebfffff window] machine # [ 0.580641] pci_bus 0000:00: resource 9 [mem 0x100000000-0x8ffffffff window] machine # [ 0.582388] ACPI: \_SB_.GSIA: Enabled at IRQ 16 machine # [ 0.584582] ACPI: \_SB_.GSIB: Enabled at IRQ 17 machine # [ 0.586926] ACPI: \_SB_.GSIC: Enabled at IRQ 18 machine # [ 0.588837] ACPI: \_SB_.GSID: Enabled at IRQ 19 machine # [ 0.590567] PCI: CLS 0 bytes, default 64 machine # [ 0.591516] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x229842dd0bd, max_idle_ns: 440795319571 ns machine # [ 0.593296] Trying to unpack rootfs image as initramfs... machine # [ 0.637658] Initialise system trusted keyrings machine # [ 0.640191] workingset: timestamp_bits=40 max_order=18 bucket_order=0 machine # [ 0.662005] Key type asymmetric registered machine # [ 0.664167] Asymmetric key parser 'x509' registered machine # [ 0.665010] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 248) machine # [ 0.668266] io scheduler mq-deadline registered machine # [ 0.669092] io scheduler kyber registered machine # [ 0.671698] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled machine # [ 0.673035] 00:03: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A machine # [ 0.678946] Linux agpgart interface v0.103 machine # [ 0.679739] ACPI: bus type drm_connector registered machine # [ 0.682566] usbcore: registered new interface driver usbserial_generic machine # [ 0.683659] usbserial: USB Serial support registered for generic machine # [ 0.687139] amd_pstate: The CPPC feature is supported but currently disabled by the BIOS. machine # [ 0.687139] Please enable it if your BIOS has the CPPC option. machine # [ 0.689466] amd_pstate: the _CPC object is not present in SBIOS or ACPI disabled machine # [ 0.693251] drop_monitor: Initializing network drop monitor service machine # [ 0.694470] NET: Registered PF_INET6 protocol family machine # [ 0.699238] Segment Routing with IPv6 machine # [ 0.699922] In-situ OAM (IOAM) with IPv6 machine # [ 0.702406] IPI shorthand broadcast: enabled machine # [ 0.710700] sched_clock: Marking stable (567015786, 143105439)->(779264354, -69143129) machine # [ 0.714308] registered taskstats version 1 machine # [ 0.715264] Loading compiled-in X.509 certificates machine # [ 0.736136] Demotion targets for Node 0: null machine # [ 0.737004] Key type .fscrypt registered machine # [ 0.737765] Key type fscrypt-provisioning registered machine # [ 0.738788] ima: No TPM chip found, activating TPM-bypass! machine # [ 0.743137] ima: Allocated hash algorithm: sha1 machine # [ 0.743906] ima: No architecture policies found machine # [ 0.746135] PM: Magic number: 14:215:361 machine # [ 0.747717] RAS: Correctable Errors collector initialized. machine # [ 0.755874] clk: Disabling unused clocks machine # [ 0.759133] PM: genpd: Disabling unused power domains machine # [ 0.935023] Freeing initrd memory: 29784K machine # [ 0.938260] Freeing unused decrypted memory: 2028K machine # [ 0.941043] Freeing unused kernel image (initmem) memory: 3656K machine # [ 0.942161] Write protecting the kernel read-only data: 32768k machine # [ 0.943510] Freeing unused kernel image (text/rodata gap) memory: 304K machine # [ 0.945016] Freeing unused kernel image (rodata/data gap) memory: 692K machine # [ 0.995723] x86/mm: Checked W+X mappings: passed, no W+X pages found. machine # [ 0.996866] Run /init as init process machine # [ 1.007673] systemd[1]: Inserted module 'autofs4' machine # [ 1.027711] fuse: init (API version 7.45) machine # [ 1.035187] ACPI: \_SB_.GSIG: Enabled at IRQ 22 machine # [ 1.037481] ACPI: \_SB_.GSIH: Enabled at IRQ 23 machine # [ 1.040899] ACPI: \_SB_.GSIE: Enabled at IRQ 20 machine # [ 1.042873] ACPI: \_SB_.GSIF: Enabled at IRQ 21 machine # [ 1.047913] virtiofs virtio5: discovered new tag: nix-store machine # [ 1.049723] virtiofs virtio5: virtio_fs_setup_dax: No cache capability machine # [ 1.056204] virtiofs virtio6: discovered new tag: shared machine # [ 1.057794] virtiofs virtio6: virtio_fs_setup_dax: No cache capability machine # [ 1.061097] virtiofs virtio7: discovered new tag: xchg machine # [ 1.062526] virtiofs virtio7: virtio_fs_setup_dax: No cache capability machine # [ 1.081836] systemd[1]: Successfully made /usr/ read-only. machine # [ 1.083531] systemd[1]: systemd 263-195a17c 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.088661] systemd[1]: Detected virtualization kvm. machine # [ 1.089515] systemd[1]: Detected architecture x86-64. machine # [ 1.090366] systemd[1]: Running in initrd. machine # [ 1.091308] systemd[1]: Initializing machine ID from random generator. machine # [ 1.092448] systemd[1]: Hostname set to . machine # [ 1.163045] systemd[1]: bpf-restrict-fs: LSM BPF program attached machine # [ 1.198434] systemd[1]: Queued start job for default target Initrd Default Target. machine # [ 1.202364] systemd[1]: Created slice Slice /system/modprobe. machine # [ 1.203515] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. machine # [ 1.204856] systemd[1]: Expecting device /dev/disk/by-label/nixos... machine # [ 1.205893] systemd[1]: Reached target Path Units. machine # [ 1.206717] systemd[1]: Reached target Slice Units. machine # [ 1.207620] systemd[1]: Reached target Swaps. machine # [ 1.208405] systemd[1]: Reached target Timer Units. machine # [ 1.209345] systemd[1]: Listening on D-Bus System Message Bus Socket. machine # [ 1.210518] systemd[1]: Listening on Journal Socket (/dev/log). machine # [ 1.211644] systemd[1]: Listening on Journal Sockets. machine # [ 1.212593] systemd[1]: Listening on udev Kernel Socket. machine # [ 1.213515] systemd[1]: Reached target Socket Units. machine # [ 1.215186] systemd[1]: Starting Create List of Static Device Nodes... machine # [ 1.218946] systemd[1]: Starting Load Kernel Module configfs... machine # [ 1.228535] systemd[1]: Starting Journal Service... machine # [ 1.238200] systemd[1]: Starting Load Kernel Modules... machine # [ 1.253545] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 1.258863] systemd[1]: Starting Coldplug All udev Devices... machine # [ 1.272186] systemd[1]: Finished Create List of Static Device Nodes. machine # [ 1.275924] systemd[1]: modprobe@configfs.service: Deactivated successfully. machine # [ 1.283492] systemd[1]: Finished Load Kernel Module configfs. machine # [ 1.288776] systemd[1]: Kernel Configuration File System skipped, unmet condition check ConditionPathExists=/sys/kernel/config machine # [ 1.295367] systemd-journald[65]: Collecting audit messages is disabled. machine # [ 1.301526] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... machine # [ 1.310486] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. machine # [ 1.318185] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev machine # [ 1.341664] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. machine # [ 1.351335] systemd[1]: Starting Create Static Device Nodes in /dev... machine # [ 1.361165] systemd[1]: Finished Load Kernel Modules. machine # [ 1.368307] systemd[1]: Starting Apply Kernel Variables... machine # [ 1.388443] systemd[1]: Finished Create Static Device Nodes in /dev. machine # [ 1.393359] systemd[1]: Reached target Preparation for Local File Systems. machine # [ 1.399232] systemd[1]: Reached target Local File Systems. machine # [ 1.405913] systemd[1]: Starting Rule-based Manager for Device Events and Files... machine # [ 1.266531] systemd-modules-load[66]: Inserted module 'dm_mod' machine # [ 1.270252] systemd-modules-load[66]: Inserted module 'virtio_balloon' machine # [ 1.271289] systemd-modules-load[66]: Inserted module 'virtio_gpu' machine # [ 1.417407] systemd[1]: Started Journal Service. machine # [ 1.280819] systemd[1]: Finished Apply Kernel Variables. machine # [ 1.292860] systemd[1]: Starting Create System Files and Directories... machine # [ 1.321477] systemd[1]: Finished Create System Files and Directories. machine # [ 1.327436] systemd-udevd[73]: Using default interface naming scheme 'v261'. machine # [ 1.349627] systemd[1]: Started Rule-based Manager for Device Events and Files. machine # [ 1.405773] systemd[1]: Finished Coldplug All udev Devices. machine # [ 1.408445] systemd[1]: Reached target System Initialization. machine # [ 1.409326] systemd[1]: Reached target Basic System. machine # [ 1.695424] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 machine # [ 1.701766] serio: i8042 KBD port at 0x60,0x64 irq 1 machine # [ 1.703197] virtio_blk virtio2: 1/0/0 default/read/poll queues machine # [ 1.706185] serio: i8042 AUX port at 0x60,0x64 irq 12 machine # [ 1.707814] virtio_blk virtio2: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) machine # [ 1.721160] ehci-pci 0000:00:1d.7: EHCI Host Controller machine # [ 1.721899] ehci-pci 0000:00:1d.7: new USB bus registered, assigned bus number 1 machine # [ 1.723096] ehci-pci 0000:00:1d.7: irq 19, io mem 0xfebdb000 machine # [ 1.729233] ehci-pci 0000:00:1d.7: USB 2.0 started, EHCI 1.00 machine # [ 1.732181] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 6.18 machine # [ 1.733343] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 machine # [ 1.736129] usb usb1: Product: EHCI Host Controller machine # [ 1.736783] usb usb1: Manufacturer: Linux 6.18.55 ehci_hcd machine # [ 1.738740] usb usb1: SerialNumber: 0000:00:1d.7 machine # [ 1.740585] hub 1-0:1.0: USB hub found machine # [ 1.743131] hub 1-0:1.0: 6 ports detected machine # [ 1.746700] uhci_hcd 0000:00:1d.0: UHCI Host Controller machine # [ 1.747511] uhci_hcd 0000:00:1d.0: new USB bus registered, assigned bus number 2 machine # [ 1.759250] uhci_hcd 0000:00:1d.0: detected 2 ports machine # [ 1.760004] uhci_hcd 0000:00:1d.0: irq 16, io port 0x0000c180 machine # [ 1.769096] usb usb2: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.18 machine # [ 1.770401] usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=1 machine # [ 1.789137] usb usb2: Product: UHCI Host Controller machine # [ 1.789820] usb usb2: Manufacturer: Linux 6.18.55 uhci_hcd machine # [ 1.657076] systemd[1]: Starting Virtual Console Setup... machine # [ 1.803474] usb usb2: SerialNumber: 0000:00:1d.0 machine # [ 1.813226] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input0 machine # [ 1.822218] hub 2-0:1.0: USB hub found machine # [ 1.822875] hub 2-0:1.0: 2 ports detected machine # [ 1.689308] systemd-vconsole-setup[96]: Configuration of first virtual console was skipped, ignoring remaining ones. machine # [ 1.692828] systemd[1]: Finished Virtual Console Setup. machine # [ 1.837898] SCSI subsystem initialized machine # [ 1.704312] (udev-worker)[93]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. machine # [ 1.706772] (udev-worker)[93]: Network interface NamePolicy= disabled on kernel command line. machine # [ 1.854798] uhci_hcd 0000:00:1d.1: UHCI Host Controller machine # [ 1.855572] uhci_hcd 0000:00:1d.1: new USB bus registered, assigned bus number 3 machine # [ 1.715808] systemd[1]: Found device /dev/disk/by-label/nixos. machine # [ 1.719434] systemd[1]: Reached target Initrd Root Device. machine # [ 1.722127] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos... machine # [ 1.871252] uhci_hcd 0000:00:1d.1: detected 2 ports machine # [ 1.872021] uhci_hcd 0000:00:1d.1: irq 17, io port 0x0000c1a0 machine # [ 1.877853] usb usb3: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.18 machine # [ 1.879058] usb usb3: New USB device strings: Mfr=3, Product=2, SerialNumber=1 machine # [ 1.886811] usb usb3: Product: UHCI Host Controller machine # [ 1.889148] usb usb3: Manufacturer: Linux 6.18.55 uhci_hcd machine # [ 1.889950] usb usb3: SerialNumber: 0000:00:1d.1 machine # [ 1.892558] hub 3-0:1.0: USB hub found machine # [ 1.894188] hub 3-0:1.0: 2 ports detected machine # [ 1.899404] uhci_hcd 0000:00:1d.2: UHCI Host Controller machine # [ 1.902261] uhci_hcd 0000:00:1d.2: new USB bus registered, assigned bus number 4 machine # [ 1.907256] uhci_hcd 0000:00:1d.2: detected 2 ports machine # [ 1.908044] uhci_hcd 0000:00:1d.2: irq 18, io port 0x0000c1c0 machine # [ 1.766666] systemd-fsck[103]: nixos: clean, 12/65536 files, 13019/262144 blocks machine # [ 1.913304] usb usb4: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.18 machine # [ 1.774584] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos. machine # [ 1.919866] usb usb4: New USB device strings: Mfr=3, Product=2, SerialNumber=1 machine # [ 1.923185] usb usb4: Product: UHCI Host Controller machine # [ 1.923879] usb usb4: Manufacturer: Linux 6.18.55 uhci_hcd machine # [ 1.926157] usb usb4: SerialNumber: 0000:00:1d.2 machine # [ 1.927780] hub 4-0:1.0: USB hub found machine # [ 1.929169] hub 4-0:1.0: 2 ports detected machine # [ 1.966230] ahci 0000:00:1f.2: AHCI vers 0001.0000, 32 command slots, 1.5 Gbps, SATA mode machine # [ 1.967372] ahci 0000:00:1f.2: 6/6 ports implemented (port mask 0x3f) machine # [ 1.968755] ahci 0000:00:1f.2: flags: 64bit ncq only machine # [ 1.971458] scsi host0: ahci machine # [ 1.972895] scsi host1: ahci machine # [ 1.974034] scsi host2: ahci machine # [ 1.975559] scsi host3: ahci machine # [ 1.976895] scsi host4: ahci machine # [ 1.978024] scsi host5: ahci machine # [ 1.979410] ata1: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc100 irq 47 lpm-pol 1 machine # [ 1.980695] ata2: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc180 irq 47 lpm-pol 1 machine # [ 1.981865] ata3: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc200 irq 47 lpm-pol 1 machine # [ 1.983038] ata4: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc280 irq 47 lpm-pol 1 machine # [ 1.984182] usb 1-1: new high-speed USB device number 2 using ehci-pci machine # [ 1.985333] ata5: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc300 irq 47 lpm-pol 1 machine # [ 1.986515] ata6: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc380 irq 47 lpm-pol 1 machine # [ 2.113697] usb 1-1: New USB device found, idVendor=0627, idProduct=0001, bcdDevice= 0.00 machine # [ 2.116570] usb 1-1: New USB device strings: Mfr=1, Product=3, SerialNumber=10 machine # [ 2.119646] usb 1-1: Product: QEMU USB Tablet machine # [ 2.121419] usb 1-1: Manufacturer: QEMU machine # [ 2.123002] usb 1-1: SerialNumber: 28754-0000:00:1d.7-1 machine # [ 2.156048] hid: raw HID events driver (C) Jiri Kosina machine # [ 2.125415] systemd[1]: Mounting /sysroot... machine # [ 2.296319] ata2: SATA link down (SStatus 0 SControl 300) machine # [ 2.298585] ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 300) machine # [ 2.303322] ata3.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/100 machine # [ 2.307150] ata3.00: applying bridge limits machine # [ 2.311393] ata1: SATA link down (SStatus 0 SControl 300) machine # [ 2.313737] ata4: SATA link down (SStatus 0 SControl 300) machine # [ 2.318353] ata5: SATA link down (SStatus 0 SControl 300) machine # [ 2.320264] ata6: SATA link down (SStatus 0 SControl 300) machine # [ 2.321978] ata3.00: configured for UDMA/100 machine # [ 2.325652] scsi 2:0:0:0: CD-ROM QEMU QEMU DVD-ROM 2.5+ PQ: 0 ANSI: 5 machine # [ 2.383221] usbcore: registered new interface driver usbhid machine # [ 2.383963] usbhid: USB HID core driver machine # [ 2.399246] input: QEMU QEMU USB Tablet as /devices/pci0000:00/0000:00:1d.7/usb1/1-1/1-1:1.0/0003:0627:0001.0001/input/input2 machine # [ 2.403324] sr 2:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray machine # [ 2.404341] 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.418219] cdrom: Uniform CD-ROM driver Revision: 3.20 machine # [ 2.454473] EXT4-fs (vda): mounted filesystem 1789e940-8c0f-42ef-8261-dab122563b16 r/w with ordered data mode. Quota mode: none. machine # [ 2.315505] systemd[1]: Mounted /sysroot. machine # [ 2.316394] systemd[1]: Reached target Initrd Root File System. machine # [ 2.319136] systemd[1]: Starting Mountpoints Configured in the Real Root... machine # [ 2.337919] systemd-sysroot-fstab-check[138]: /sysroot should be mounted in the initrd, will request daemon-reload. machine # [ 2.340895] systemd[1]: Reload requested from client PID 138 ('systemd-sysroot') (unit initrd-parse-etc.service)... machine # [ 2.343084] systemd[1]: Reloading... machine # [ 2.408882] systemd[1]: Reloading finished in 66 ms. machine # [ 2.417513] systemd-sysroot-fstab-check[138]: Requesting initrd-fs.target/start/replace... machine # [ 2.420138] systemd-sysroot-fstab-check[138]: Requesting swap.target/start/replace... machine # [ 2.422698] systemd[1]: initrd-parse-etc.service: Deactivated successfully. machine # [ 2.424179] systemd[1]: Finished Mountpoints Configured in the Real Root. machine # [ 2.426189] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies. machine # [ 3.127089] systemd[1]: Mounting /sysroot/nix/.ro-store... machine # [ 3.134159] systemd[1]: Mounting /sysroot/nix/.rw-store... machine # [ 3.140290] systemd[1]: Mounting /sysroot/run... machine # [ 3.151311] systemd[1]: Mounting /sysroot/tmp/shared... machine # [ 3.165839] systemd[1]: Mounting /sysroot/tmp/xchg... machine # [ 3.201284] systemd[1]: Mounted /sysroot/nix/.ro-store. machine # [ 3.202712] systemd[1]: Mounted /sysroot/nix/.rw-store. machine # [ 3.209321] systemd[1]: Mounted /sysroot/run. machine # [ 3.211064] systemd[1]: Mounted /sysroot/tmp/shared. machine # [ 3.212981] systemd[1]: Mounted /sysroot/tmp/xchg. machine # [ 3.216141] systemd[1]: Starting rw-sysroot-nix-store.service... machine # [ 3.226414] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. machine # [ 3.227863] systemd[1]: Finished rw-sysroot-nix-store.service. machine # [ 4.126462] systemd[1]: Mounting /sysroot/nix/store... machine # [ 4.173568] systemd[1]: Mounted /sysroot/nix/store. machine # [ 4.176081] systemd[1]: Reached target Initrd File Systems. machine # [ 4.180138] systemd[1]: Starting Find NixOS closure... machine # [ 4.185306] systemd[1]: Starting Create Volatile Files and Directories in the Real Root... machine # [ 4.212718] systemd[1]: Finished Create Volatile Files and Directories in the Real Root. machine # [ 4.214757] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully. machine # [ 4.222635] systemd[1]: Finished Find NixOS closure. machine # [ 4.223777] systemd[1]: Reached target Initrd Default Target. machine # [ 4.225551] systemd[1]: Starting Cleaning Up and Shutting Down Daemons... machine # [ 4.239561] systemd[1]: Stopped target Initrd Default Target. machine # [ 4.240530] systemd[1]: Stopped target Basic System. machine # [ 4.241434] systemd[1]: Stopped target Initrd Root Device. machine # [ 4.243103] systemd[1]: Stopped target Path Units. machine # [ 4.243815] systemd[1]: systemd-ask-password-console.path: Deactivated successfully. machine # [ 4.244865] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch. machine # [ 4.246000] systemd[1]: Stopped target Slice Units. machine # [ 4.246709] systemd[1]: Stopped target Socket Units. machine # [ 4.247508] systemd[1]: Stopped target System Initialization. machine # [ 4.248591] systemd[1]: Stopped target Swaps. machine # [ 4.249612] systemd[1]: Stopped target Timer Units. machine # [ 4.250540] systemd[1]: dbus.socket: Deactivated successfully. machine # [ 4.251584] systemd[1]: Closed D-Bus System Message Bus Socket. machine # [ 4.252638] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully. machine # [ 4.254188] systemd[1]: Stopped Find NixOS closure. machine # [ 4.255624] systemd[1]: Starting rw-sysroot-nix-store.service... machine # [ 4.257134] systemd[1]: systemd-sysctl.service: Deactivated successfully. machine # [ 4.258212] systemd[1]: Stopped Apply Kernel Variables. machine # [ 4.259156] systemd[1]: systemd-modules-load.service: Deactivated successfully. machine # [ 4.260948] systemd[1]: Stopped Load Kernel Modules. machine # [ 4.261666] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully. machine # [ 4.262728] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root. machine # [ 4.263939] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. machine # [ 4.265475] systemd[1]: Stopped Create System Files and Directories. machine # [ 4.266689] systemd[1]: Stopped target Local File Systems. machine # [ 4.267505] systemd[1]: Stopped target Preparation for Local File Systems. machine # [ 4.270121] systemd[1]: systemd-udev-trigger.service: Deactivated successfully. machine # [ 4.271127] systemd[1]: Stopped Coldplug All udev Devices. machine # [ 4.274424] systemd[1]: Stopping Rule-based Manager for Device Events and Files... machine # [ 4.275561] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. machine # [ 4.276607] systemd[1]: Stopped Virtual Console Setup. machine # [ 4.283934] systemd[1]: systemd-udevd.service: Deactivated successfully. machine # [ 4.286572] systemd[1]: Stopped Rule-based Manager for Device Events and Files. machine # [ 4.290119] systemd[1]: initrd-cleanup.service: Deactivated successfully. machine # [ 4.290982] systemd[1]: Finished Cleaning Up and Shutting Down Daemons. machine # [ 4.294807] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. machine # [ 4.296212] systemd[1]: Finished rw-sysroot-nix-store.service. machine # [ 4.299615] systemd[1]: Starting Cleanup udev Database... machine # [ 4.300453] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. machine # [ 4.301542] systemd[1]: Stopped Create Static Device Nodes in /dev. machine # [ 4.302384] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. machine # [ 4.304154] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully. machine # [ 4.305115] systemd[1]: kmod-static-nodes.service: Deactivated successfully. machine # [ 4.306093] systemd[1]: Stopped Create List of Static Device Nodes. machine # [ 4.320416] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. machine # [ 4.321634] systemd[1]: Finished Cleanup udev Database. machine # [ 4.322858] systemd[1]: Reached target Switch Root. machine # [ 4.324654] systemd[1]: Starting NixOS Activation... machine # [ 4.398268] initrd-nixos-activation-start[189]: booting system configuration /nix/store/06jla896dwcr07hdzzrcz50s66462nzq-nixos-system-machine-test machine # [ 4.425819] initrd-nixos-activation-start[189]: running activation script... machine # [ 4.618240] initrd-nixos-activation-start[212]: setting up /etc... machine # [ 4.720493] systemd[1]: initrd-nixos-activation.service: Deactivated successfully. machine # [ 4.722089] systemd[1]: Finished NixOS Activation. machine # [ 4.723708] systemd[1]: Starting Switch Root... machine # [ 4.736980] systemd[1]: Switching root. machine # [ 5.006388] systemd-journald[65]: Received SIGTERM from PID 1 (systemd). machine # [ 5.088752] NET: Registered PF_VSOCK protocol family machine # [ 5.115852] systemd[1]: systemd 263-195a17c 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 # [ 5.119865] systemd[1]: Detected virtualization kvm. machine # [ 5.120562] systemd[1]: Detected architecture x86-64. machine # [ 5.121330] systemd[1]: Detected first boot. machine # [ 5.123050] systemd[1]: Initializing machine ID from random generator. machine # [ 5.208616] systemd[1]: bpf-restrict-fs: LSM BPF program attached machine # [ 5.305465] systemd[1]: Applying preset policy. machine # [ 5.471455] systemd[1]: Populated /etc with preset unit settings. machine # [ 5.652985] systemd[1]: initrd-switch-root.service: Deactivated successfully. machine # [ 5.654327] systemd[1]: Stopped initrd-switch-root.service. machine # [ 5.656474] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. machine # [ 5.658498] systemd[1]: Created slice Slice /system/getty. machine # [ 5.659798] systemd[1]: Created slice User and Session Slice. machine # [ 5.660729] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. machine # [ 5.661865] systemd[1]: Started Forward Password Requests to Wall Directory Watch. machine # [ 5.662911] systemd[1]: Expecting device /dev/hvc0... machine # [ 5.663622] systemd[1]: Expecting device /dev/ttyS0... machine # [ 5.664377] systemd[1]: Reached target Local Encrypted Volumes. machine # [ 5.665222] systemd[1]: Stopped target initrd-fs.target. machine # [ 5.665922] systemd[1]: Stopped target initrd-root-fs.target. machine # [ 5.666694] systemd[1]: Stopped target initrd-switch-root.target. machine # [ 5.667563] systemd[1]: Reached target Virtual Machines and Containers. machine # [ 5.668608] systemd[1]: Reached target Path Units. machine # [ 5.669361] systemd[1]: Reached target Remote File Systems. machine # [ 5.670180] systemd[1]: Reached target Slice Units. machine # [ 5.670858] systemd[1]: Reached target Swaps. machine # [ 5.672430] systemd[1]: Listening on Query the User Interactively for a Password. machine # [ 5.686197] systemd[1]: Listening on Process Core Dump Socket. machine # [ 5.687810] systemd[1]: Listening on Credential Encryption/Decryption. machine # [ 5.689445] systemd[1]: Listening on Factory Reset Management. machine # [ 5.690397] systemd[1]: Listening on Hostname Service Socket. machine # [ 5.692875] systemd[1]: Starting Journal Log Access Socket... machine # [ 5.694219] systemd[1]: Listening on Journal Audit Socket. machine # [ 5.696753] systemd[1]: Listening on Console Output Muting Service Socket. machine # [ 5.697859] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket. machine # [ 5.698927] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 5.700248] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 5.704008] systemd[1]: Listening on Disk Repartitioning Service Socket. machine # [ 5.705057] systemd[1]: Listening on udev Varlink Socket. machine # [ 5.707349] systemd[1]: Mounting Huge Pages File System... machine # [ 5.709591] systemd[1]: Mounting POSIX Message Queue File System... machine # [ 5.714664] systemd[1]: Mounting Kernel Debug File System... machine # [ 5.722540] systemd[1]: Mounting Kernel Trace File System... machine # [ 5.730710] systemd[1]: Starting Create List of Static Device Nodes... machine # [ 5.742696] systemd[1]: Starting Load Kernel Module configfs... machine # [ 5.750453] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm machine # [ 5.761217] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 5.770037] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse machine # [ 5.780993] systemd[1]: Mounting FUSE Control File System... machine # [ 5.788192] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 5.801429] systemd[1]: Starting Journal Service... machine # [ 5.809224] systemd[1]: Starting Load Kernel Modules... machine # [ 5.817820] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer... machine # [ 5.830294] systemd[1]: Starting Remount Root and Kernel File Systems... machine # [ 5.835243] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 5.844780] systemd[1]: Starting Coldplug All udev Devices... machine # [ 5.854795] systemd[1]: Listening on Journal Log Access Socket. machine # [ 5.856388] systemd-journald[283]: Collecting audit messages is enabled. machine # [ 5.862066] systemd[1]: Mounted Huge Pages File System. machine # [ 5.868360] systemd[1]: Mounted POSIX Message Queue File System. machine # [ 5.872563] systemd[1]: Mounted Kernel Debug File System. machine # [ 5.876896] systemd[1]: Mounted Kernel Trace File System. machine # [ 5.880601] systemd[1]: Started Journal Service. machine # [ 5.735968] systemd[1]: Queued start job for default target Multi-User System. machine # [ 5.741256] systemd[1]: Unnecessary job was removed for /sys/devices/virtual/tty/hvc0. machine # [ 5.744422] systemd[1]: Unnecessary job was removed for /sys/devices/pnp0/00:03/00:03:0/00:03:0.0/tty/ttyS0. machine # [ 5.748406] systemd[1]: systemd-journald.service: Deactivated successfully. machine # [ 5.752278] systemd[1]: Finished Create List of Static Device Nodes. machine # [ 5.753331] systemd[1]: modprobe@configfs.service: Deactivated successfully. machine # [ 5.758247] systemd[1]: Finished Load Kernel Module configfs. machine # [ 5.759141] systemd[1]: Mounted FUSE Control File System. machine # [ 5.903557] loop: module loaded machine # [ 5.766406] systemd-modules-load[284]: Inserted module 'loop' machine # [ 5.777091] systemd[1]: Finished Load Kernel Modules. machine # [ 5.782074] systemd[1]: Mounting Kernel Configuration File System... machine # [ 5.930152] EXT4-fs (vda): re-mounted 1789e940-8c0f-42ef-8261-dab122563b16. machine # [ 5.789726] systemd[1]: Starting Firewall... machine # [ 5.806130] systemd[1]: Starting Apply Kernel Variables... machine # [ 5.812092] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... machine # [ 5.816303] systemd[1]: Finished Remount Root and Kernel File Systems. machine # [ 5.821507] systemd[1]: Listening on Disk Image Download Service Socket. machine # [ 5.830876] systemd-oomd[286]: No swap; memory pressure usage will be degraded machine # [ 5.835123] systemd[1]: Starting Flush Journal to Persistent Storage... machine # [ 5.836177] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 5.857099] systemd[1]: Starting Load/Save OS Random Seed... machine # [ 5.859204] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 5.861134] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer. machine # [ 6.057753] systemd-journald[283]: Received client request to flush runtime journal. machine # [ 5.999682] systemd[1]: Mounted Kernel Configuration File System. machine # [ 6.002858] systemd[1]: Finished Load/Save OS Random Seed. machine # [ 6.003714] systemd[1]: Reached target First Boot Complete. machine # [ 6.004877] systemd[1]: Finished Apply Kernel Variables. machine # [ 6.008382] systemd[1]: Finished Flush Journal to Persistent Storage. machine # [ 6.025178] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. machine # [ 6.030468] systemd[1]: Starting Create Static Device Nodes in /dev... machine # [ 6.106646] systemd[1]: Finished Coldplug All udev Devices. machine # [ 6.123651] systemd[1]: Finished Create Static Device Nodes in /dev. machine # [ 6.124857] systemd[1]: Reached target Preparation for Local File Systems. machine # [ 6.128066] systemd[1]: Starting Rule-based Manager for Device Events and Files... machine # [ 6.172604] systemd-udevd[323]: Using default interface naming scheme 'v261'. machine # [ 6.212187] systemd[1]: Started Rule-based Manager for Device Events and Files. machine # [ 6.271077] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse machine # [ 6.341804] systemd[1]: Condition check resulted in /dev/hvc0 being skipped. machine # [ 6.377476] systemd[1]: Condition check resulted in /dev/ttyS0 being skipped. machine # [ 6.393519] (udev-worker)[346]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. machine # [ 6.395662] (udev-worker)[346]: Network interface NamePolicy= disabled on kernel command line. machine # [ 6.493915] systemd[1]: Condition check resulted in Virtio network device being skipped. machine # [ 6.495032] systemd[1]: Condition check resulted in Virtio network device being skipped. machine # [ 6.496076] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 6.497467] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 6.499512] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 6.502789] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 6.505100] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 6.514183] systemd[1]: Mounting /run/wrappers... machine # [ 6.554615] systemd[1]: Mounted /run/wrappers. machine # [ 6.556104] systemd[1]: Reached target Local File Systems. machine # [ 6.559110] systemd[1]: Listening on Boot Loader Control Service Socket. machine # [ 6.565097] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 6.565897] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 6.570661] systemd[1]: Starting Save Transient machine-id to Disk... machine # [ 6.573061] systemd[1]: Starting Create System Files and Directories... machine # [ 6.796928] mousedev: PS/2 mouse device common for all mice machine # [ 6.692116] systemd[1]: Finished Create System Files and Directories. machine # [ 6.695817] systemd[1]: etc-machine\x2did.mount: Deactivated successfully. machine # [ 6.698572] systemd[1]: Finished Save Transient machine-id to Disk. machine # [ 6.706957] systemd[1]: Starting Rebuild Journal Catalog... machine # [ 6.712111] systemd[1]: Starting Record System Boot/Shutdown in UTMP... machine # [ 6.871943] bochs-drm 0000:00:01.0: vgaarb: deactivate vga console machine # [ 6.878067] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input3 machine # [ 6.787242] systemd[1]: Finished Record System Boot/Shutdown in UTMP. machine # [ 6.809372] systemd[1]: Finished Rebuild Journal Catalog. machine # [ 6.814833] systemd[1]: Starting Update is Completed... machine # [ 6.858269] systemd[1]: Finished Update is Completed. machine # [ 7.038634] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 7.042485] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 7.044303] systemd[1]: Reached target System Initialization. machine # [ 7.046100] systemd[1]: Started Discard unused filesystem blocks once a week. machine # [ 7.048053] systemd[1]: Started Daily Cleanup of Temporary Directories. machine # [ 7.048928] systemd[1]: Reached target Timer Units. machine # [ 7.050236] systemd[1]: Listening on D-Bus System Message Bus Socket. machine # [ 7.052515] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket. machine # [ 6.952000] input: QEMU Virtio Keyboard as /devices/pci0000:00/0000:00:06.0/virtio4/input/input4 machine # [ 7.055832] systemd[1]: Reached target Socket Units. machine # [ 7.056646] systemd[1]: Reached target Basic System. machine # [ 7.058064] systemd[1]: Started backdoor.service. machine # [ 7.062100] systemd[1]: Starting Import lastlog data into lastlog2 database... machine # [ 7.068149] systemd[1]: Starting Name Service Cache Daemon (nsncd)... machine # [ 7.080191] systemd[1]: Starting Post-Boot Actions... machine # [ 6.986968] ACPI: button: Power Button [PWRF] machine # [ 7.057311] rtc_cmos PNP0B00:00: RTC can wake from S4 machine # [ 7.090189] systemd[1]: Started Reset console on configuration changes. machine # [ 7.105856] systemd[1]: Starting resolvconf update... machine # [ 7.072784] rtc_cmos PNP0B00:00: registered as rtc0 machine # [ 7.072849] rtc_cmos PNP0B00:00: setting system clock to 2026-10-14T03:23:00 UTC (1791948180) machine # [ 7.116369] systemd[1]: Finished Firewall. machine # [ 7.155337] systemd[1]: Starting D-Bus System Message Bus... machine # [ 7.072928] rtc_cmos PNP0B00:00: alarms up to one day, y3k, 242 bytes nvram, hpet irqs machine # [ 7.075324] systemd-journald[283]: Time jumped backwards, rotating. machine # connecting to host... machine # [ 7.185651] systemd[1]: Finished Post-Boot Actions. machine # [ 7.096885] parport_pc 00:02: reported by Plug and Play ACPI machine # [ 7.096969] parport0: PC-style at 0x378, irq 7 [PCSPP(,...)] machine # [ 7.141910] lpc_ich 0000:00:1f.0: I/O space for GPIO uninitialized machine # [ 7.213798] nsncd[493]: Oct 14 03:23:00.783 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" machine # [ 7.218565] systemd[1]: Started Name Service Cache Daemon (nsncd). machine # [ 7.219464] systemd[1]: Reached target Host and Network Name Lookups. machine # [ 7.220344] systemd[1]: Reached target User and Group Name Lookups. machine # [ 7.235705] systemd[1]: Starting User Login Management... machine: Guest shell says: b'Spawning backdoor root shell...\n' machine: connected to guest root shell machine: (connecting took 7.93 seconds) machine: (finished: waiting for the VM to finish booting, in 8.28 seconds) machine # [ 7.197881] Console: switching to colour dummy device 80x25 machine # [ 7.410033] [drm] Found bochs VGA, ID 0xb0c5. machine # [ 7.410036] [drm] Framebuffer size 16384 kB @ 0xfd000000, mmio @ 0xfebd0000. machine # [ 7.427978] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input6 machine # [ 7.287585] systemd[1]: Finished Import lastlog data into lastlog2 database. machine # [ 7.435347] i801_smbus 0000:00:1f.3: SMBus using PCI interrupt machine # [ 7.436021] i2c i2c-0: Memory type 0x07 not supported yet, not instantiating SPD machine # [ 7.440604] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input5 machine # [ 7.441827] bochs-drm 0000:00:01.0: [drm] Registered 1 planes with drm panic machine # [ 7.470250] [drm] Initialized bochs-drm 1.0.0 for 0000:00:01.0 on minor 0 machine # [ 7.588669] Console: switching to colour frame buffer device 160x50 machine # [ 7.597873] bochs-drm 0000:00:01.0: [drm] fb0: bochs-drmdrmfb frame buffer device machine # [ 7.405115] systemd-logind[522]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard) machine # [ 7.457240] dbus-broker-launch[504]: Looking up NSS user entry for 'systemd-timesync'... machine # [ 7.459286] systemd-logind[522]: New seat seat0. machine # [ 7.461502] systemd-logind[522]: Watching system buttons on /dev/input/event3 (Power Button) machine # [ 7.463106] systemd-logind[522]: Watching system buttons on /dev/input/event2 (QEMU Virtio Keyboard) machine # [ 7.468569] systemd[1]: Started User Login Management. machine # [ 7.481678] dbus-broker-launch[504]: NSS returned no entry for 'systemd-timesync' machine # [ 7.482687] dbus-broker-launch[504]: Invalid user-name in /nix/store/g2lwg6aamksr3f20h64c82wmkbri8i4r-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" machine # [ 7.486159] systemd[1]: Stopped target Host and Network Name Lookups. machine # [ 7.487067] systemd[1]: Stopping Host and Network Name Lookups... machine # [ 7.487864] systemd[1]: Stopped target User and Group Name Lookups. machine # [ 7.488736] systemd[1]: Stopping User and Group Name Lookups... machine # [ 7.494341] systemd[1]: Starting linger-users.service... machine # [ 7.495135] systemd[1]: Stopping Name Service Cache Daemon (nsncd)... machine # [ 7.502871] systemd[1]: nscd.service: Deactivated successfully. machine # [ 7.505229] systemd[1]: Stopped Name Service Cache Daemon (nsncd). machine # [ 7.666379] ppdev: user-space parallel port driver machine # [ 7.525592] systemd[1]: Started D-Bus System Message Bus. machine # [ 7.545069] systemd[1]: Starting Name Service Cache Daemon (nsncd)... machine # [ 7.697712] iTCO_wdt iTCO_wdt.1.auto: Found a ICH9 TCO device (Version=2, TCOBASE=0x0660) machine # [ 7.556979] systemd[1]: Starting Virtual Console Setup... machine # [ 7.564620] dbus-broker-launch[504]: Ready machine # [ 7.769413] iTCO_wdt iTCO_wdt.1.auto: initialized. heartbeat=30 sec (nowayout=0) machine # [ 7.639571] systemd[1]: Started Name Service Cache Daemon (nsncd). machine # [ 7.640653] nsncd[582]: Oct 14 03:23:01.208 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" machine # [ 7.666446] systemd[1]: Created slice Slice /user/1001. machine # [ 7.669197] systemd[1]: Reached target Host and Network Name Lookups. machine # [ 7.670457] systemd[1]: Reached target User and Group Name Lookups. machine # [ 7.672639] systemd[1]: Starting User Runtime Directory /run/user/1001... machine # [ 7.679507] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 7.689278] systemd[1]: Finished linger-users.service. machine # [ 7.706653] systemd[1]: Finished resolvconf update. machine # [ 7.712537] systemd[1]: Reached target Preparation for Network. machine # [ 7.714153] systemd[1]: Starting DHCP Client... machine # [ 7.717517] systemd[1]: Starting Address configuration of eth1... machine # [ 7.724568] systemd[1]: Starting Extra networking commands.... machine # [ 7.725469] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. machine # [ 7.728718] systemd[1]: Stopped Virtual Console Setup. machine # [ 7.731208] systemd[1]: Starting Virtual Console Setup... machine # [ 7.761217] systemd[1]: Finished User Runtime Directory /run/user/1001. machine # [ 7.766065] systemd[1]: Starting User Manager for UID 1001... machine # [ 7.874131] (systemd)[620]: pam_unix(systemd-user:session): session opened for user usertest(uid=1001) by (uid=0) machine # [ 7.884478] systemd-logind[522]: New session '1' of user 'usertest' with class 'manager' and type 'unspecified'. machine # [ 7.910763] systemd[620]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 8.073338] kvm_amd: TSC scaling supported machine # [ 8.073761] kvm_amd: Nested Virtualization enabled machine # [ 8.074267] kvm_amd: Nested Paging enabled machine # [ 8.074661] kvm_amd: LBR virtualization supported machine # [ 8.088337] kvm_amd: Virtual VMLOAD VMSAVE supported machine # [ 8.088832] kvm_amd: Virtual GIF supported machine # [ 8.092938] kvm_amd: Virtual NMI enabled machine # [ 8.030271] network-addresses-eth1-start[616]: adding address 192.168.1.1/24... done machine # [ 8.184887] EDAC MC: Ver: 3.0.0 machine # [ 8.060296] network-addresses-eth1-start[616]: adding address 2001:db8:1::1/64... done machine # [ 8.074856] systemd[620]: Queued start job for default target Main User Target. machine # [ 8.080169] systemd[620]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 8.084220] systemd[620]: Created slice User Application Slice. machine # [ 8.086479] systemd[620]: Started Daily Cleanup of User's Temporary Directories. machine # [ 8.091186] systemd[620]: Reached target Paths. machine # [ 8.091892] systemd[620]: Reached target Timers. machine # [ 8.095536] systemd[620]: Starting D-Bus User Message Bus Socket... machine # [ 8.098273] systemd[620]: Starting Create User Files and Directories... machine # [ 8.112773] systemd[1]: Finished Address configuration of eth1. machine # [ 8.134542] systemd[620]: Finished Create User Files and Directories. machine # [ 8.158325] systemd[620]: Listening on D-Bus User Message Bus Socket. machine # [ 8.161294] systemd[620]: Reached target Sockets. machine # [ 8.165092] systemd[620]: Reached target Basic System. machine # [ 8.165797] systemd[1]: Started User Manager for UID 1001. machine # [ 8.166908] systemd[620]: Starting Run user-specific NixOS activation... machine # [ 8.197813] systemd[620]: Finished Run user-specific NixOS activation. machine # [ 8.199372] systemd[620]: Reached target Main User Target. machine # [ 8.200316] systemd[620]: Startup finished in 293ms. machine # [ 8.214120] systemd[1]: Finished Extra networking commands.. machine # [ 8.215871] systemd[1]: Reached target Network. machine # [ 8.219640] systemd[1]: Starting Permit User Sessions... machine # [ 8.221730] dhcpcd[636]: dhcpcd-10.3.2 starting machine # [ 8.228934] dhcpcd[700]: dev: loaded udev machine # [ 8.381760] 8021q: 802.1Q VLAN Support v1.8 machine # [ 8.382922] 8021q: adding VLAN 0 to HW filter on device eth1 machine # [ 8.249627] systemd[1]: Finished Permit User Sessions. machine # [ 8.254071] systemd[1]: Started Getty on tty1. machine # [ 8.256857] systemd[1]: Reached target Login Prompts. machine # [ 8.283850] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch. machine # [ 8.468898] cfg80211: Loading compiled-in X.509 certificates for regulatory database machine # [ 8.482968] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' machine # [ 8.483746] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600' machine # [ 8.485505] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -2 machine # [ 8.486363] cfg80211: failed to load regulatory.db machine # [ 8.515552] 8021q: adding VLAN 0 to HW filter on device eth0 machine # [ 8.373650] dhcpcd[700]: eth0: waiting for carrier machine # [ 8.375719] dhcpcd[700]: eth0: carrier acquired machine # [ 8.380212] dhcpcd[700]: DUID 00:01:00:01:32:61:b2:15:52:54:00:12:34:56 machine # [ 8.381370] dhcpcd[700]: eth0: IAID 00:12:34:56 machine # [ 8.382149] dhcpcd[700]: eth0: adding address fe80::5054:ff:fe12:3456 machine # [ 8.390807] systemd-vconsole-setup[618]: Configuration of first virtual console was skipped, ignoring remaining ones. machine # [ 8.395149] systemd[1]: Finished Virtual Console Setup. machine # [ 9.855629] dhcpcd[700]: eth0: soliciting a DHCP lease machine # [ 10.017223] NET: Registered PF_PACKET protocol family machine # [ 9.881231] dhcpcd[700]: eth0: offered 10.0.2.15 from 10.0.2.2 machine # [ 9.883725] dhcpcd[700]: eth0: probing address 10.0.2.15/24 machine # [ 9.901839] dhcpcd[700]: eth0: soliciting an IPv6 router machine # [ 9.904323] dhcpcd[700]: eth0: Router Advertisement from fe80::2 machine # [ 9.906331] dhcpcd[700]: eth0: adding address fec0::5054:ff:fe12:3456/64 machine # [ 9.909315] dhcpcd[700]: eth0: adding route to fec0::/64 machine # [ 9.910840] dhcpcd[700]: eth0: adding default route via fe80::2 machine # [ 15.665716] dhcpcd[700]: eth0: leased 10.0.2.15 for 86400 seconds machine # [ 15.668984] dhcpcd[700]: eth0: adding route to 10.0.2.0/24 machine # [ 15.671302] dhcpcd[700]: eth0: adding default route via 10.0.2.2 machine # [ 15.756502] systemd[1]: Started DHCP Client. machine # [ 15.758241] systemd[1]: Reached target Multi-User System. machine # [ 15.758954] systemd[1]: Startup finished in 857ms (kernel) + 4.065s (initrd) + 10.835s (userspace) = 15.757s. machine: (finished: waiting for unit multi-user.target, in 17.19 seconds) machine: must succeed: /nix/store/3vbcjh6yz1i6lp352svzp92f3jmjppg7-stderr-runner /nix/store/06jla896dwcr07hdzzrcz50s66462nzq-nixos-system-machine-test/bin/switch-to-configuration test machine # Checking switch inhibitors... done machine # [ 16.402604] nixos[850]: switching to system configuration /nix/store/06jla896dwcr07hdzzrcz50s66462nzq-nixos-system-machine-test machine # [ 16.404853] systemd[1]: Stopped target Local File Systems. machine # [ 16.406473] systemd[1]: Stopped target Remote File Systems. machine # activating the configuration... machine # setting up /etc... machine # [ 16.631992] systemd[1]: Reload requested from client PID 850 ('.switch-to-conf') (unit backdoor.service)... machine # [ 16.633612] systemd[1]: Reloading... machine # [ 16.863912] systemd[1]: Reloading finished in 228 ms. machine # reloading user units for usertest... machine # [ 16.893437] systemd[620]: Created slice User Core Session Slice. machine # [ 16.895669] systemd[620]: Starting D-Bus User Message Bus... machine # [ 16.919136] dbus-broker-launch[920]: Ignoring duplicate name 'org.freedesktop.import1' in service file '/nix/store/g2lwg6aamksr3f20h64c82wmkbri8i4r-system-path/share/dbus-1/services/org.freedesktop.import1.service' machine # [ 16.921907] dbus-broker-launch[920]: Ignoring duplicate name 'org.freedesktop.machine1' in service file '/nix/store/g2lwg6aamksr3f20h64c82wmkbri8i4r-system-path/share/dbus-1/services/org.freedesktop.machine1.service' machine # [ 16.924448] dbus-broker-launch[920]: Ignoring duplicate name 'org.freedesktop.portable1' in service file '/nix/store/g2lwg6aamksr3f20h64c82wmkbri8i4r-system-path/share/dbus-1/services/org.freedesktop.portable1.service' machine # [ 16.927036] dbus-broker-launch[920]: Ignoring duplicate name 'org.freedesktop.systemd1' in service file '/nix/store/g2lwg6aamksr3f20h64c82wmkbri8i4r-system-path/share/dbus-1/services/org.freedesktop.systemd1.service' machine # [ 16.929566] dbus-broker-launch[920]: Policy to allow eavesdropping in /etc/dbus-1/session.conf +27: Eavesdropping is deprecated and ignored machine # [ 16.931134] dbus-broker-launch[920]: Policy to allow eavesdropping in /etc/dbus-1/session.conf +29: Eavesdropping is deprecated and ignored machine # [ 16.933210] systemd[620]: Started D-Bus User Message Bus. machine # [ 16.936558] dbus-broker-launch[920]: Ready machine # [ 16.973460] systemd[620]: Reexecution requested from client PID 919 ('switch-to-confi')... machine # [ 16.975825] systemd[620]: Reexecuting. machine # [ 16.995187] systemd[620]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 17.065500] systemd[620]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 17.070657] systemd[620]: Reload requested from client PID 919 ('switch-to-confi')... machine # [ 17.072858] systemd[620]: Reloading... machine # [ 17.147616] systemd[620]: Reloading finished in 75 ms. machine # [ 17.152822] systemd[620]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # restarting the following user units: nixos-activation.service machine # [ 17.159492] systemd[620]: Stopped Run user-specific NixOS activation. machine # [ 17.160873] systemd[620]: Stopping Run user-specific NixOS activation... machine # [ 17.162833] systemd[620]: Starting Run user-specific NixOS activation... machine # [ 17.182055] systemd[620]: Finished Run user-specific NixOS activation. machine # restarting sysinit-reactivation.target machine # [ 17.189669] systemd[1]: Starting Re-setup tmpfiles on a system that is already running.... machine # [ 17.253164] systemd[1]: Finished Re-setup tmpfiles on a system that is already running.. machine # [ 17.255844] systemd[1]: Reached target Reactivate sysinit units. machine # [ 17.258731] systemd[1]: Reached target Local File Systems. machine # [ 17.262308] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 17.269539] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 17.270387] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 17.271990] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 17.274696] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 17.276200] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 17.277357] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 17.279496] systemd[1]: Reached target Remote File Systems. machine # [ 17.282332] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 17.284116] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 17.406512] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 17.408136] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 17.411573] systemd[1]: Starting linger-users.service... machine # [ 17.438185] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 17.439724] systemd[1]: Finished linger-users.service. machine # the following new units were started: sysinit-reactivation.target, systemd-tmpfiles-resetup.service machine # [ 17.699795] nixos[850]: finished switching to system configuration /nix/store/06jla896dwcr07hdzzrcz50s66462nzq-nixos-system-machine-test machine: (finished: must succeed: /nix/store/3vbcjh6yz1i6lp352svzp92f3jmjppg7-stderr-runner /nix/store/06jla896dwcr07hdzzrcz50s66462nzq-nixos-system-machine-test/bin/switch-to-configuration test, in 1.54 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/58r66y6cjlh8bpjiy6al3i6hghx1s620-nixos-system-other-test/bin/switch-to-configuration test machine # this should succeed (config: /nix/store/58r66y6cjlh8bpjiy6al3i6hghx1s620-nixos-system-other-test, action: test) machine # Checking switch inhibitors... done machine # [ 17.951975] nixos[997]: switching to system configuration /nix/store/58r66y6cjlh8bpjiy6al3i6hghx1s620-nixos-system-other-test machine # [ 17.954680] systemd[1]: Stopped target Remote File Systems. machine # activating the configuration... machine # [ 17.957181] systemd[1]: Stopped target Local File Systems. machine # removing user ‘usertest’ machine # setting up /etc... machine # [ 18.185179] systemd[1]: Reload requested from client PID 997 ('.switch-to-conf') (unit backdoor.service)... machine # [ 18.186762] systemd[1]: Reloading... machine # [ 18.418712] systemd[1]: Reloading finished in 230 ms. machine # reloading user units for usertest... machine # [ 18.483632] systemd[620]: Reexecution requested from client PID 1069 ('switch-to-confi')... machine # [ 18.486123] systemd[620]: Reexecuting. machine # [ 18.506768] systemd[620]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 18.578359] systemd[620]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 18.583763] systemd[620]: Reload requested from client PID 1069 ('switch-to-confi')... machine # [ 18.585038] systemd[620]: Reloading... machine # [ 18.653839] systemd[620]: Reloading finished in 67 ms. machine # [ 18.657811] systemd[620]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # restarting the following user units: nixos-activation.service machine # [ 18.664764] systemd[620]: Stopped Run user-specific NixOS activation. machine # [ 18.666232] systemd[620]: Stopping Run user-specific NixOS activation... machine # [ 18.668178] systemd[620]: Starting Run user-specific NixOS activation... machine # [ 18.686843] systemd[620]: Finished Run user-specific NixOS activation. machine # restarting sysinit-reactivation.target machine # [ 18.690293] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 18.691625] systemd[1]: Stopping Reactivate sysinit units... machine # [ 18.692596] systemd[1]: Reached target Reactivate sysinit units. machine # reloading the following units: dbus-broker.service machine # [ 18.695270] dbus-broker-launch[504]: Caught SIGHUP, trigger reload. machine # [ 18.697228] systemd[1]: Reloading D-Bus System Message Bus... machine # [ 18.701852] dbus-broker-launch[504]: Looking up NSS user entry for 'systemd-timesync'... machine # [ 18.703591] dbus-broker-launch[504]: NSS returned no entry for 'systemd-timesync' machine # [ 18.704641] dbus-broker-launch[504]: Invalid user-name in /nix/store/hl9x1s6hrpz7rz49cskcx5vaandxy1bk-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" machine # [ 18.714239] systemd[1]: Reloaded D-Bus System Message Bus. machine # restarting the following units: network-addresses-eth1.service machine # [ 18.718619] systemd[1]: Stopping Address configuration of eth1... machine # [ 18.736863] network-addresses-eth1-pre-stop[1081]: deleting address 192.168.1.1/24... done machine # [ 18.741802] network-addresses-eth1-pre-stop[1081]: deleting address 2001:db8:1::1/64... done machine # [ 18.746598] systemd[1]: network-addresses-eth1.service: Deactivated successfully. machine # [ 18.748127] systemd[1]: Stopped Address configuration of eth1. machine # [ 18.750974] systemd[1]: Starting Address configuration of eth1... machine # [ 18.777836] network-addresses-eth1-start[1086]: adding address 192.168.1.2/24... done machine # [ 18.783163] network-addresses-eth1-start[1086]: adding address 2001:db8:1::2/64... done machine # [ 18.789944] systemd[1]: Finished Address configuration of eth1. machine # [ 18.792719] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 18.794270] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 18.797814] systemd[1]: Reached target Remote File Systems. machine # [ 18.800663] systemd[1]: Starting linger-users.service... machine # [ 18.807178] systemd[1]: Reached target Local File Systems. machine # [ 18.807993] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 18.811544] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 18.813357] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 18.814510] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 18.816460] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 18.817877] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 18.822364] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 18.846383] linger-users-start[1100]: id: ‘usertest’: no such user machine # [ 18.848537] linger-users-start[1097]: Removing linger for missing user usertest machine # [ 18.853848] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 18.855711] systemd[1]: Finished linger-users.service. machine # [ 18.982564] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 18.985459] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 19.242924] nixos[997]: finished switching to system configuration /nix/store/58r66y6cjlh8bpjiy6al3i6hghx1s620-nixos-system-other-test machine: (finished: must succeed: /nix/store/3vbcjh6yz1i6lp352svzp92f3jmjppg7-stderr-runner /nix/store/58r66y6cjlh8bpjiy6al3i6hghx1s620-nixos-system-other-test/bin/switch-to-configuration test, in 1.51 seconds) subtest: services machine: must succeed: /nix/store/06jla896dwcr07hdzzrcz50s66462nzq-nixos-system-machine-test/bin/switch-to-configuration test 2>&1 machine # [ 19.446642] nixos[1164]: switching to system configuration /nix/store/06jla896dwcr07hdzzrcz50s66462nzq-nixos-system-machine-test machine # [ 19.448950] systemd[1]: Stopped target Local File Systems. machine # [ 19.450317] systemd[1]: Stopped target Remote File Systems. machine # [ 19.651355] systemd[1]: Reload requested from client PID 1164 ('.switch-to-conf') (unit backdoor.service)... machine # [ 19.652965] systemd[1]: Reloading... machine # [ 19.874296] systemd[1]: Reloading finished in 220 ms. machine # [ 19.933805] systemd[620]: Reexecution requested from client PID 1233 ('switch-to-confi')... machine # [ 19.936207] systemd[620]: Reexecuting. machine # [ 19.955971] systemd[620]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 20.025355] systemd[620]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 20.030465] systemd[620]: Reload requested from client PID 1233 ('switch-to-confi')... machine # [ 20.032674] systemd[620]: Reloading... machine # [ 20.101496] systemd[620]: Reloading finished in 69 ms. machine # [ 20.106804] systemd[620]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 20.113107] systemd[620]: Stopped Run user-specific NixOS activation. machine # [ 20.114115] systemd[620]: Stopping Run user-specific NixOS activation... machine # [ 20.116176] systemd[620]: Starting Run user-specific NixOS activation... machine # [ 20.134903] systemd[620]: Finished Run user-specific NixOS activation. machine # [ 20.138371] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 20.139468] systemd[1]: Stopping Reactivate sysinit units... machine # [ 20.140430] systemd[1]: Reached target Reactivate sysinit units. machine # [ 20.142841] dbus-broker-launch[504]: Caught SIGHUP, trigger reload. machine # [ 20.144326] systemd[1]: Reloading D-Bus System Message Bus... machine # [ 20.147719] dbus-broker-launch[504]: Looking up NSS user entry for 'systemd-timesync'... machine # [ 20.149591] dbus-broker-launch[504]: NSS returned no entry for 'systemd-timesync' machine # [ 20.150557] dbus-broker-launch[504]: Invalid user-name in /nix/store/g2lwg6aamksr3f20h64c82wmkbri8i4r-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" machine # [ 20.158102] systemd[1]: Reloaded D-Bus System Message Bus. machine # [ 20.161831] systemd[1]: Stopping Address configuration of eth1... machine # [ 20.179270] network-addresses-eth1-pre-stop[1245]: deleting address 192.168.1.2/24... done machine # [ 20.184098] network-addresses-eth1-pre-stop[1245]: deleting address 2001:db8:1::2/64... done machine # [ 20.188883] systemd[1]: network-addresses-eth1.service: Deactivated successfully. machine # [ 20.190385] systemd[1]: Stopped Address configuration of eth1. machine # [ 20.193626] systemd[1]: Starting Address configuration of eth1... machine # [ 20.220732] network-addresses-eth1-start[1250]: adding address 192.168.1.1/24... done machine # [ 20.226276] network-addresses-eth1-start[1250]: adding address 2001:db8:1::1/64... done machine # [ 20.233457] systemd[1]: Finished Address configuration of eth1. machine # [ 20.237606] systemd[1]: Reached target Local File Systems. machine # [ 20.239128] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 20.242118] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 20.242879] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 20.245640] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 20.248375] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 20.249761] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 20.250951] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 20.256963] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 20.258270] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 20.260749] systemd[1]: Reached target Remote File Systems. machine # [ 20.384509] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 20.386169] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 20.389631] systemd[1]: Starting linger-users.service... machine # [ 20.410312] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 20.412428] systemd[1]: Finished linger-users.service. machine # [ 20.669412] nixos[1164]: finished switching to system configuration /nix/store/06jla896dwcr07hdzzrcz50s66462nzq-nixos-system-machine-test machine: (finished: must succeed: /nix/store/06jla896dwcr07hdzzrcz50s66462nzq-nixos-system-machine-test/bin/switch-to-configuration test 2>&1, in 1.43 seconds) machine: must succeed: /nix/store/06jla896dwcr07hdzzrcz50s66462nzq-nixos-system-machine-test/bin/switch-to-configuration test 2>&1 machine # [ 20.877375] nixos[1319]: switching to system configuration /nix/store/06jla896dwcr07hdzzrcz50s66462nzq-nixos-system-machine-test machine # [ 20.880446] systemd[1]: Stopped target Local File Systems. machine # [ 20.881665] systemd[1]: Stopped target Remote File Systems. machine # [ 21.080127] systemd[1]: Reload requested from client PID 1319 ('.switch-to-conf') (unit backdoor.service)... machine # [ 21.081850] systemd[1]: Reloading... machine # [ 21.310469] systemd[1]: Reloading finished in 227 ms. machine # [ 21.386245] systemd[620]: Reexecution requested from client PID 1388 ('switch-to-confi')... machine # [ 21.388569] systemd[620]: Reexecuting. machine # [ 21.407986] systemd[620]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 21.475069] systemd[620]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 21.480085] systemd[620]: Reload requested from client PID 1388 ('switch-to-confi')... machine # [ 21.481492] systemd[620]: Reloading... machine # [ 21.550449] systemd[620]: Reloading finished in 67 ms. machine # [ 21.554795] systemd[620]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 21.561173] systemd[620]: Stopped Run user-specific NixOS activation. machine # [ 21.561972] systemd[620]: Stopping Run user-specific NixOS activation... machine # [ 21.564053] systemd[620]: Starting Run user-specific NixOS activation... machine # [ 21.582707] systemd[620]: Finished Run user-specific NixOS activation. machine # [ 21.585556] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 21.586818] systemd[1]: Stopping Reactivate sysinit units... machine # [ 21.587791] systemd[1]: Reached target Reactivate sysinit units. machine # [ 21.591081] systemd[1]: Reached target Local File Systems. machine # [ 21.592505] systemd[1]: Reached target Remote File Systems. machine # [ 21.594760] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 21.599188] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 21.599926] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 21.601812] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 21.604471] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 21.606436] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 21.608535] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 21.610104] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 21.611266] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 21.736467] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 21.740203] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 21.741958] systemd[1]: Starting linger-users.service... machine # [ 21.767906] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 21.769519] systemd[1]: Finished linger-users.service. machine # [ 22.027089] nixos[1319]: finished switching to system configuration /nix/store/06jla896dwcr07hdzzrcz50s66462nzq-nixos-system-machine-test machine: (finished: must succeed: /nix/store/06jla896dwcr07hdzzrcz50s66462nzq-nixos-system-machine-test/bin/switch-to-configuration test 2>&1, in 1.36 seconds) machine: must succeed: /nix/store/06jla896dwcr07hdzzrcz50s66462nzq-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration test 2>&1 machine # [ 22.263205] nixos[1460]: switching to system configuration /nix/store/s0ivrimd0sh91nb16zii7a7yz1ra9k9y-nixos-system-machine-test machine # [ 22.266378] systemd[1]: Stopped target Local File Systems. machine # [ 22.267291] systemd[1]: Stopped target Remote File Systems. machine # [ 22.489692] systemd[1]: Reload requested from client PID 1460 ('.switch-to-conf') (unit backdoor.service)... machine # [ 22.491296] systemd[1]: Reloading... machine # [ 22.728093] systemd[1]: Reloading finished in 235 ms. machine # [ 22.790328] systemd[620]: Reexecution requested from client PID 1529 ('switch-to-confi')... machine # [ 22.791589] systemd[620]: Reexecuting. machine # [ 22.813088] systemd[620]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 22.884109] systemd[620]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 22.889245] systemd[620]: Reload requested from client PID 1529 ('switch-to-confi')... machine # [ 22.890596] systemd[620]: Reloading... machine # [ 22.962368] systemd[620]: Reloading finished in 70 ms. machine # [ 22.967837] systemd[620]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 22.974192] systemd[620]: Stopped Run user-specific NixOS activation. machine # [ 22.975092] systemd[620]: Stopping Run user-specific NixOS activation... machine # [ 22.977208] systemd[620]: Starting Run user-specific NixOS activation... machine # [ 22.996531] systemd[620]: Finished Run user-specific NixOS activation. machine # [ 22.999533] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 23.000829] systemd[1]: Stopping Reactivate sysinit units... machine # [ 23.002117] systemd[1]: Reached target Reactivate sysinit units. machine # [ 23.007073] systemd[1]: Reached target Remote File Systems. machine # [ 23.009124] systemd[1]: Starting linger-users.service... machine # [ 23.012080] systemd[1]: Starting test.service... machine # [ 23.017803] systemd[1]: Reached target Local File Systems. machine # [ 23.019172] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 23.024593] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 23.025475] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 23.027248] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 23.029233] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 23.030765] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 23.031928] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 23.038581] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 23.040175] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 23.062239] systemd[1]: Finished test.service. machine # [ 23.084626] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 23.087318] systemd[1]: Finished linger-users.service. machine # [ 23.199460] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 23.201157] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 23.455851] nixos[1460]: finished switching to system configuration /nix/store/s0ivrimd0sh91nb16zii7a7yz1ra9k9y-nixos-system-machine-test machine: (finished: must succeed: /nix/store/06jla896dwcr07hdzzrcz50s66462nzq-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration test 2>&1, in 1.43 seconds) machine: must succeed: /nix/store/06jla896dwcr07hdzzrcz50s66462nzq-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration test 2>&1 machine # [ 23.641989] nixos[1602]: switching to system configuration /nix/store/s0ivrimd0sh91nb16zii7a7yz1ra9k9y-nixos-system-machine-test machine # [ 23.644243] systemd[1]: Stopped target Remote File Systems. machine # [ 23.645988] systemd[1]: Stopped target Local File Systems. machine # [ 23.857158] systemd[1]: Reload requested from client PID 1602 ('.switch-to-conf') (unit backdoor.service)... machine # [ 23.858838] systemd[1]: Reloading... machine # [ 24.251679] systemd[1]: Reloading finished in 390 ms. machine # [ 24.312361] systemd[620]: Reexecution requested from client PID 1671 ('switch-to-confi')... machine # [ 24.314739] systemd[620]: Reexecuting. machine # [ 24.334134] systemd[620]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 24.425189] systemd[620]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 24.430671] systemd[620]: Reload requested from client PID 1671 ('switch-to-confi')... machine # [ 24.432332] systemd[620]: Reloading... machine # [ 24.501435] systemd[620]: Reloading finished in 68 ms. machine # [ 24.506807] systemd[620]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 24.514796] systemd[620]: Stopped Run user-specific NixOS activation. machine # [ 24.515724] systemd[620]: Stopping Run user-specific NixOS activation... machine # [ 24.517477] systemd[620]: Starting Run user-specific NixOS activation... machine # [ 24.535435] systemd[620]: Finished Run user-specific NixOS activation. machine # [ 24.538359] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 24.539700] systemd[1]: Stopping Reactivate sysinit units... machine # [ 24.540951] systemd[1]: Reached target Reactivate sysinit units. machine # [ 24.543829] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 24.545572] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 24.550249] systemd[1]: Reached target Remote File Systems. machine # [ 24.552699] systemd[1]: Starting linger-users.service... machine # [ 24.557874] systemd[1]: Reached target Local File Systems. machine # [ 24.563173] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 24.565913] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 24.567122] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 24.568355] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 24.570471] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 24.572045] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 24.573276] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 24.608735] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 24.610185] systemd[1]: Finished linger-users.service. machine # [ 24.723271] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 24.724825] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 24.980131] nixos[1602]: finished switching to system configuration /nix/store/s0ivrimd0sh91nb16zii7a7yz1ra9k9y-nixos-system-machine-test machine: (finished: must succeed: /nix/store/06jla896dwcr07hdzzrcz50s66462nzq-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration test 2>&1, in 1.52 seconds) machine: must succeed: /nix/store/06jla896dwcr07hdzzrcz50s66462nzq-nixos-system-machine-test/specialisation/simpleServiceDifferentDescription/bin/switch-to-configuration test 2>&1 machine # [ 25.193471] nixos[1743]: switching to system configuration /nix/store/r8acnyz73m95qdkz0vzwr8s8rv0r60mc-nixos-system-machine-test machine # [ 25.195693] systemd[1]: Stopped target Local File Systems. machine # [ 25.197154] systemd[1]: Stopped target Remote File Systems. machine # [ 25.427871] systemd[1]: Reload requested from client PID 1743 ('.switch-to-conf') (unit backdoor.service)... machine # [ 25.429635] systemd[1]: Reloading... machine # [ 25.703143] systemd[1]: Reloading finished in 271 ms. machine # [ 25.763348] systemd[620]: Reexecution requested from client PID 1812 ('switch-to-confi')... machine # [ 25.764655] systemd[620]: Reexecuting. machine # [ 25.784269] systemd[620]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 25.856529] systemd[620]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 25.861961] systemd[620]: Reload requested from client PID 1812 ('switch-to-confi')... machine # [ 25.863505] systemd[620]: Reloading... machine # [ 25.939991] systemd[620]: Reloading finished in 75 ms. machine # [ 25.945821] systemd[620]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 25.952776] systemd[620]: Stopped Run user-specific NixOS activation. machine # [ 25.953847] systemd[620]: Stopping Run user-specific NixOS activation... machine # [ 25.955509] systemd[620]: Starting Run user-specific NixOS activation... machine # [ 25.974497] systemd[620]: Finished Run user-specific NixOS activation. machine # [ 25.977793] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 25.979767] systemd[1]: Stopping Reactivate sysinit units... machine # [ 25.981071] systemd[1]: Reached target Reactivate sysinit units. machine # [ 25.985063] systemd[1]: Reached target Remote File Systems. machine # [ 25.988417] systemd[1]: Reached target Local File Systems. machine # [ 25.990242] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 25.992588] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 25.994384] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 25.996722] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 25.998718] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 26.000176] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 26.001324] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 26.006285] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 26.008040] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 26.138081] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 26.139687] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 26.144067] systemd[1]: Starting linger-users.service... machine # [ 26.171987] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 26.173558] systemd[1]: Finished linger-users.service. machine # [ 26.430714] nixos[1743]: finished switching to system configuration /nix/store/r8acnyz73m95qdkz0vzwr8s8rv0r60mc-nixos-system-machine-test machine: (finished: must succeed: /nix/store/06jla896dwcr07hdzzrcz50s66462nzq-nixos-system-machine-test/specialisation/simpleServiceDifferentDescription/bin/switch-to-configuration test 2>&1, in 1.45 seconds) machine: must succeed: /nix/store/06jla896dwcr07hdzzrcz50s66462nzq-nixos-system-machine-test/specialisation/simpleServiceModified/bin/switch-to-configuration test 2>&1 machine # [ 26.624861] nixos[1883]: switching to system configuration /nix/store/a6n76qkshsbmc478aq651f25zzqqmzns-nixos-system-machine-test machine # [ 26.626967] systemd[1]: test.service: Deactivated successfully. machine # [ 26.628764] systemd[1]: Stopped Test unit. machine # [ 26.629515] systemd[1]: Stopped target Remote File Systems. machine # [ 26.630966] systemd[1]: Stopped target Local File Systems. machine # [ 26.847642] systemd[1]: Reload requested from client PID 1883 ('.switch-to-conf') (unit backdoor.service)... machine # [ 26.849272] systemd[1]: Reloading... machine # [ 27.116754] systemd[1]: Reloading finished in 265 ms. machine # [ 27.181563] systemd[620]: Reexecution requested from client PID 1952 ('switch-to-confi')... machine # [ 27.182823] systemd[620]: Reexecuting. machine # [ 27.204973] systemd[620]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 27.276820] systemd[620]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 27.282353] systemd[620]: Reload requested from client PID 1952 ('switch-to-confi')... machine # [ 27.283783] systemd[620]: Reloading... machine # [ 27.358790] systemd[620]: Reloading finished in 73 ms. machine # [ 27.364861] systemd[620]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 27.371133] systemd[620]: Stopped Run user-specific NixOS activation. machine # [ 27.372079] systemd[620]: Stopping Run user-specific NixOS activation... machine # [ 27.374587] systemd[620]: Starting Run user-specific NixOS activation... machine # [ 27.392936] systemd[620]: Finished Run user-specific NixOS activation. machine # [ 27.395927] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 27.397281] systemd[1]: Stopping Reactivate sysinit units... machine # [ 27.398925] systemd[1]: Reached target Reactivate sysinit units. machine # [ 27.403075] systemd[1]: Reached target Remote File Systems. machine # [ 27.405553] systemd[1]: Starting linger-users.service... machine # [ 27.408124] systemd[1]: Starting test.service... machine # [ 27.418043] systemd[1]: Reached target Local File Systems. machine # [ 27.418755] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 27.423110] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 27.423874] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 27.426286] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 27.430854] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 27.433145] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 27.434394] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 27.439090] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 27.441108] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 27.457629] systemd[1]: Finished test.service. machine # [ 27.479445] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 27.481055] systemd[1]: Finished linger-users.service. machine # [ 27.613322] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 27.615896] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 27.871729] nixos[1883]: finished switching to system configuration /nix/store/a6n76qkshsbmc478aq651f25zzqqmzns-nixos-system-machine-test machine: (finished: must succeed: /nix/store/06jla896dwcr07hdzzrcz50s66462nzq-nixos-system-machine-test/specialisation/simpleServiceModified/bin/switch-to-configuration test 2>&1, in 1.44 seconds) machine: must succeed: /nix/store/06jla896dwcr07hdzzrcz50s66462nzq-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1 machine # [ 28.117552] nixos[2026]: switching to system configuration /nix/store/70y2f6cixchrgih7nk81h5dg18lgy2wm-nixos-system-machine-test machine # [ 28.120204] systemd[1]: Stopped target Remote File Systems. machine # [ 28.121872] systemd[1]: Stopped target Local File Systems. machine # [ 28.346777] systemd[1]: Reload requested from client PID 2026 ('.switch-to-conf') (unit backdoor.service)... machine # [ 28.348359] systemd[1]: Reloading... machine # [ 28.644680] systemd[1]: Reloading finished in 295 ms. machine # [ 28.707296] systemd[620]: Reexecution requested from client PID 2095 ('switch-to-confi')... machine # [ 28.709797] systemd[620]: Reexecuting. machine # [ 28.731063] systemd[620]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 28.806949] systemd[620]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 28.810956] systemd[620]: Reload requested from client PID 2095 ('switch-to-confi')... machine # [ 28.812562] systemd[620]: Reloading... machine # [ 28.883626] systemd[620]: Reloading finished in 68 ms. machine # [ 28.887835] systemd[620]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 28.894076] systemd[620]: Stopped Run user-specific NixOS activation. machine # [ 28.895940] systemd[620]: Stopping Run user-specific NixOS activation... machine # [ 28.897440] systemd[620]: Starting Run user-specific NixOS activation... machine # [ 28.916147] systemd[620]: Finished Run user-specific NixOS activation. machine # [ 28.919109] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 28.920455] systemd[1]: Stopping Reactivate sysinit units... machine # [ 28.921371] systemd[1]: Reached target Reactivate sysinit units. machine # [ 28.923067] systemd[1]: test.service: Deactivated successfully. machine # [ 28.924099] systemd[1]: Stopped test.service. machine # [ 28.924690] systemd[1]: Stopping test.service... machine # [ 28.926937] systemd[1]: Starting test.service... machine # [ 28.940578] systemd[1]: Finished test.service. machine # [ 28.942683] systemd[1]: Reached target Local File Systems. machine # [ 28.945990] systemd[1]: Reached target Remote File Systems. machine # [ 28.948714] systemd[1]: Starting linger-users.service... machine # [ 28.959140] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 28.962629] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 28.964477] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 28.966112] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 28.968083] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 28.969502] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 28.970768] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 28.977180] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 28.978738] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 29.011102] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 29.012141] systemd[1]: Finished linger-users.service. machine # [ 29.122562] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 29.124373] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 29.381940] nixos[2026]: finished switching to system configuration /nix/store/70y2f6cixchrgih7nk81h5dg18lgy2wm-nixos-system-machine-test machine: (finished: must succeed: /nix/store/06jla896dwcr07hdzzrcz50s66462nzq-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1, in 1.51 seconds) machine: must succeed: /nix/store/06jla896dwcr07hdzzrcz50s66462nzq-nixos-system-machine-test/specialisation/simpleServiceReload/bin/switch-to-configuration test 2>&1 machine # [ 29.569137] nixos[2168]: switching to system configuration /nix/store/0f1papfh44ivspw1hvh358db1rf68km5-nixos-system-machine-test machine # [ 29.572308] systemd[1]: Stopped target Remote File Systems. machine # [ 29.573191] systemd[1]: Stopped target Local File Systems. machine # [ 29.778855] systemd[1]: Reload requested from client PID 2168 ('.switch-to-conf') (unit backdoor.service)... machine # [ 29.780542] systemd[1]: Reloading... machine # [ 30.038531] systemd[1]: Reloading finished in 256 ms. machine # [ 30.098301] systemd[620]: Reexecution requested from client PID 2237 ('switch-to-confi')... machine # [ 30.100587] systemd[620]: Reexecuting. machine # [ 30.118024] systemd[620]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 30.192806] systemd[620]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 30.198061] systemd[620]: Reload requested from client PID 2237 ('switch-to-confi')... machine # [ 30.199529] systemd[620]: Reloading... machine # [ 30.277928] systemd[620]: Reloading finished in 77 ms. machine # [ 30.283821] systemd[620]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 30.290825] systemd[620]: Stopped Run user-specific NixOS activation. machine # [ 30.291714] systemd[620]: Stopping Run user-specific NixOS activation... machine # [ 30.293456] systemd[620]: Starting Run user-specific NixOS activation... machine # [ 30.312346] systemd[620]: Finished Run user-specific NixOS activation. machine # [ 30.315481] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 30.317215] systemd[1]: Stopping Reactivate sysinit units... machine # [ 30.318193] systemd[1]: Reached target Reactivate sysinit units. machine # [ 30.320866] systemd[1]: Reloading test.service... machine # [ 30.334991] systemd[1]: Reloaded test.service. machine # [ 30.337810] systemd[1]: Reached target Local File Systems. machine # [ 30.340029] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 30.342180] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 30.342934] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 30.345562] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 30.347965] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 30.351150] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 30.353087] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 30.354212] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 30.355395] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 30.364718] systemd[1]: Reached target Remote File Systems. machine # [ 30.490433] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 30.492236] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 30.495873] systemd[1]: Starting linger-users.service... machine # [ 30.522229] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 30.523734] systemd[1]: Finished linger-users.service. machine # [ 30.785565] nixos[2168]: finished switching to system configuration /nix/store/0f1papfh44ivspw1hvh358db1rf68km5-nixos-system-machine-test machine: (finished: must succeed: /nix/store/06jla896dwcr07hdzzrcz50s66462nzq-nixos-system-machine-test/specialisation/simpleServiceReload/bin/switch-to-configuration test 2>&1, in 1.41 seconds) machine: must succeed: /nix/store/06jla896dwcr07hdzzrcz50s66462nzq-nixos-system-machine-test/specialisation/simpleServiceNorestart/bin/switch-to-configuration test 2>&1 machine # [ 31.011750] nixos[2310]: switching to system configuration /nix/store/r2i7kysbwpbjsfi4i3j0z0zai1nwgnjg-nixos-system-machine-test machine # [ 31.013823] systemd[1]: Stopped target Local File Systems. machine # [ 31.015604] systemd[1]: Stopped target Remote File Systems. machine # [ 31.233846] systemd[1]: Reload requested from client PID 2310 ('.switch-to-conf') (unit backdoor.service)... machine # [ 31.235546] systemd[1]: Reloading... machine # [ 31.469495] systemd[1]: Reloading finished in 232 ms. machine # [ 31.529343] systemd[620]: Reexecution requested from client PID 2380 ('switch-to-confi')... machine # [ 31.531754] systemd[620]: Reexecuting. machine # [ 31.550962] systemd[620]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 31.621262] systemd[620]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 31.626421] systemd[620]: Reload requested from client PID 2380 ('switch-to-confi')... machine # [ 31.628167] systemd[620]: Reloading... machine # [ 31.698062] systemd[620]: Reloading finished in 69 ms. machine # [ 31.703802] systemd[620]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 31.709716] systemd[620]: Stopped Run user-specific NixOS activation. machine # [ 31.711122] systemd[620]: Stopping Run user-specific NixOS activation... machine # [ 31.712992] systemd[620]: Starting Run user-specific NixOS activation... machine # [ 31.732056] systemd[620]: Finished Run user-specific NixOS activation. machine # [ 31.734847] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 31.736175] systemd[1]: Stopping Reactivate sysinit units... machine # [ 31.736902] systemd[1]: Reached target Reactivate sysinit units. machine # [ 31.740253] systemd[1]: Reached target Remote File Systems. machine # [ 31.743059] systemd[1]: Reached target Local File Systems. machine # [ 31.744153] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 31.747657] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 31.749531] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 31.751437] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 31.753426] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 31.754874] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 31.756085] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 31.765223] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 31.766516] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 31.886993] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 31.888593] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 31.892720] systemd[1]: Starting linger-users.service... machine # [ 31.918524] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 31.919962] systemd[1]: Finished linger-users.service. machine # [ 32.177581] nixos[2310]: finished switching to system configuration /nix/store/r2i7kysbwpbjsfi4i3j0z0zai1nwgnjg-nixos-system-machine-test machine: (finished: must succeed: /nix/store/06jla896dwcr07hdzzrcz50s66462nzq-nixos-system-machine-test/specialisation/simpleServiceNorestart/bin/switch-to-configuration test 2>&1, in 1.39 seconds) machine: must succeed: /nix/store/06jla896dwcr07hdzzrcz50s66462nzq-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration dry-activate 2>&1 machine: (finished: must succeed: /nix/store/06jla896dwcr07hdzzrcz50s66462nzq-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration dry-activate 2>&1, in 0.26 seconds) machine: must succeed: /nix/store/06jla896dwcr07hdzzrcz50s66462nzq-nixos-system-machine-test/bin/switch-to-configuration test 2>&1 machine # [ 32.633178] nixos[2461]: switching to system configuration /nix/store/06jla896dwcr07hdzzrcz50s66462nzq-nixos-system-machine-test machine # [ 32.635638] systemd[1]: test.service: Deactivated successfully. machine # [ 32.637688] systemd[1]: Stopped test.service. machine # [ 32.638573] systemd[1]: Stopped target Remote File Systems. machine # [ 32.639640] systemd[1]: Stopped target Local File Systems. machine # [ 32.848643] systemd[1]: Reload requested from client PID 2461 ('.switch-to-conf') (unit backdoor.service)... machine # [ 32.850607] systemd[1]: Reloading... machine # [ 33.102151] systemd[1]: Reloading finished in 250 ms. machine # [ 33.158676] systemd[620]: Reexecution requested from client PID 2530 ('switch-to-confi')... machine # [ 33.161118] systemd[620]: Reexecuting. machine # [ 33.180816] systemd[620]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 33.248361] systemd[620]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 33.253694] systemd[620]: Reload requested from client PID 2530 ('switch-to-confi')... machine # [ 33.255426] systemd[620]: Reloading... machine # [ 33.323338] systemd[620]: Reloading finished in 67 ms. machine # [ 33.328808] systemd[620]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 33.335769] systemd[620]: Stopped Run user-specific NixOS activation. machine # [ 33.336669] systemd[620]: Stopping Run user-specific NixOS activation... machine # [ 33.338223] systemd[620]: Starting Run user-specific NixOS activation... machine # [ 33.356816] systemd[620]: Finished Run user-specific NixOS activation. machine # [ 33.359711] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 33.361153] systemd[1]: Stopping Reactivate sysinit units... machine # [ 33.361872] systemd[1]: Reached target Reactivate sysinit units. machine # [ 33.365484] systemd[1]: Reached target Remote File Systems. machine # [ 33.368206] systemd[1]: Starting linger-users.service... machine # [ 33.371916] systemd[1]: Reached target Local File Systems. machine # [ 33.372700] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 33.377426] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 33.378258] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 33.379420] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 33.381373] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 33.382778] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 33.386286] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 33.394983] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 33.396524] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 33.431466] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 33.433189] systemd[1]: Finished linger-users.service. machine # [ 33.533960] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 33.535583] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 33.792675] nixos[2461]: finished switching to system configuration /nix/store/06jla896dwcr07hdzzrcz50s66462nzq-nixos-system-machine-test machine: (finished: must succeed: /nix/store/06jla896dwcr07hdzzrcz50s66462nzq-nixos-system-machine-test/bin/switch-to-configuration test 2>&1, in 1.35 seconds) machine: must succeed: /nix/store/l4j5zgim9crrqz6r7gr0g5xrpzjmcy8l-separate-activation-script/bin/switch-to-configuration test 2>&1 machine # [ 34.029110] nixos[2601]: switching to system configuration /nix/store/n7dp7rgpl7n9baqba9fv73v7jwbzqwp7-nixos-system-machine-test machine # [ 34.031753] systemd[1]: Stopped target Local File Systems. machine # [ 34.033205] systemd[1]: Stopped target Remote File Systems. machine # [ 34.249612] systemd[1]: Reload requested from client PID 2601 ('.switch-to-conf') (unit backdoor.service)... machine # [ 34.251156] systemd[1]: Reloading... machine # [ 34.474230] systemd[1]: Reloading finished in 221 ms. machine # [ 34.537243] systemd[620]: Stopped Run user-specific NixOS activation. machine # [ 34.539161] systemd[620]: Reexecution requested from client PID 2671 ('switch-to-confi')... machine # [ 34.540351] systemd[620]: Reexecuting. machine # [ 34.559917] systemd[620]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 34.630592] systemd[620]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 34.634505] systemd[620]: Reload requested from client PID 2671 ('switch-to-confi')... machine # [ 34.636129] systemd[620]: Reloading... machine # [ 34.703510] systemd[620]: Reloading finished in 66 ms. machine # [ 34.708800] systemd[620]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 34.715458] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 34.716761] systemd[1]: Stopping Reactivate sysinit units... machine # [ 34.717622] systemd[1]: Reached target Reactivate sysinit units. machine # [ 34.719807] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 34.721409] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 34.728165] systemd[1]: Reached target Remote File Systems. machine # [ 34.730178] systemd[1]: Starting linger-users.service... machine # [ 34.732868] systemd[1]: Starting test.service... machine # [ 34.739101] systemd[1]: Reached target Local File Systems. machine # [ 34.739855] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 34.741257] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 34.741941] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 34.745114] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 34.747120] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 34.753112] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 34.754307] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 34.780835] systemd[1]: Finished test.service. machine # [ 34.799790] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 34.801674] systemd[1]: Finished linger-users.service. machine # [ 34.903783] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 34.905474] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 35.163534] nixos[2601]: finished switching to system configuration /nix/store/n7dp7rgpl7n9baqba9fv73v7jwbzqwp7-nixos-system-machine-test machine: (finished: must succeed: /nix/store/l4j5zgim9crrqz6r7gr0g5xrpzjmcy8l-separate-activation-script/bin/switch-to-configuration test 2>&1, in 1.37 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/06jla896dwcr07hdzzrcz50s66462nzq-nixos-system-machine-test/specialisation/unitWithMultilineValue/bin/switch-to-configuration test 2>&1 machine # [ 35.416358] nixos[2750]: switching to system configuration /nix/store/2vqvcvf4d323s8j3w3f870ddx71z6lpl-nixos-system-machine-test machine # [ 35.418629] systemd[1]: Stopped target Local File Systems. machine # [ 35.420641] systemd[1]: Stopped target Remote File Systems. machine # [ 35.421812] systemd[1]: test.service: Deactivated successfully. machine # [ 35.423141] systemd[1]: Stopped test.service. machine # [ 35.638693] systemd[1]: Reload requested from client PID 2750 ('.switch-to-conf') (unit backdoor.service)... machine # [ 35.640349] systemd[1]: Reloading... machine # [ 35.869589] systemd[1]: Reloading finished in 228 ms. machine # [ 35.928103] systemd[620]: Reexecution requested from client PID 2819 ('switch-to-confi')... machine # [ 35.929409] systemd[620]: Reexecuting. machine # [ 35.948906] systemd[620]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 36.018418] systemd[620]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 36.023109] systemd[620]: Reload requested from client PID 2819 ('switch-to-confi')... machine # [ 36.024696] systemd[620]: Reloading... machine # [ 36.093067] systemd[620]: Reloading finished in 67 ms. machine # [ 36.098817] systemd[620]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 36.105621] systemd[620]: Starting Run user-specific NixOS activation... machine # [ 36.123833] systemd[620]: Finished Run user-specific NixOS activation. machine # [ 36.127077] systemd[620]: Stopped Run user-specific NixOS activation. machine # [ 36.127884] systemd[620]: Stopping Run user-specific NixOS activation... machine # [ 36.130623] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 36.132271] systemd[1]: Stopping Reactivate sysinit units... machine # [ 36.133314] systemd[1]: Reached target Reactivate sysinit units. machine # [ 36.134502] systemd[620]: Starting Run user-specific NixOS activation... machine # [ 36.137743] systemd[1]: Reached target Remote File Systems. machine # [ 36.141654] systemd[1]: Starting linger-users.service... machine # [ 36.153322] systemd[1]: Reached target Local File Systems. machine # [ 36.159378] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 36.163127] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 36.163861] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 36.167390] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 36.173084] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 36.175574] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 36.179230] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 36.183291] systemd[620]: Finished Run user-specific NixOS activation. machine # [ 36.188131] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 36.189801] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 36.218909] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 36.220637] systemd[1]: Finished linger-users.service. machine # [ 36.327105] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 36.329649] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 36.332448] systemd[1]: Started test.service. machine # [ 36.347300] systemd[1]: test.service: Deactivated successfully. machine # [ 36.588732] nixos[2750]: finished switching to system configuration /nix/store/2vqvcvf4d323s8j3w3f870ddx71z6lpl-nixos-system-machine-test machine: (finished: must succeed: /nix/store/06jla896dwcr07hdzzrcz50s66462nzq-nixos-system-machine-test/specialisation/unitWithMultilineValue/bin/switch-to-configuration test 2>&1, in 1.37 seconds) machine: must succeed: /nix/store/06jla896dwcr07hdzzrcz50s66462nzq-nixos-system-machine-test/specialisation/unitWithBackslash/bin/switch-to-configuration test 2>&1 machine # [ 36.810171] nixos[2895]: switching to system configuration /nix/store/6jfazyarbgm5yr06adv9ing3f5x58pqr-nixos-system-machine-test machine # [ 36.812570] systemd[1]: Stopped target Remote File Systems. machine # [ 36.814643] systemd[1]: Stopped target Local File Systems. machine # [ 37.032477] systemd[1]: Reload requested from client PID 2895 ('.switch-to-conf') (unit backdoor.service)... machine # [ 37.034166] systemd[1]: Reloading... machine # [ 37.272592] systemd[1]: Reloading finished in 237 ms. machine # [ 37.358358] systemd[620]: Reexecution requested from client PID 2964 ('switch-to-confi')... machine # [ 37.359664] systemd[620]: Reexecuting. machine # [ 37.379062] systemd[620]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 37.448353] systemd[620]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 37.453841] systemd[620]: Reload requested from client PID 2964 ('switch-to-confi')... machine # [ 37.455828] systemd[620]: Reloading... machine # [ 37.523195] systemd[620]: Reloading finished in 67 ms. machine # [ 37.528814] systemd[620]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 37.535349] systemd[620]: Stopped Run user-specific NixOS activation. machine # [ 37.537070] systemd[620]: Stopping Run user-specific NixOS activation... machine # [ 37.538710] systemd[620]: Starting Run user-specific NixOS activation... machine # [ 37.556811] systemd[620]: Finished Run user-specific NixOS activation. machine # [ 37.559752] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 37.561265] systemd[1]: Stopping Reactivate sysinit units... machine # [ 37.562271] systemd[1]: Reached target Reactivate sysinit units. machine # [ 37.568834] systemd[1]: Reached target Remote File Systems. machine # [ 37.572108] systemd[1]: Starting escaped\x2ddash.service... machine # [ 37.574643] systemd[1]: Starting linger-users.service... machine # [ 37.581753] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 37.582997] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 37.588246] systemd[1]: Reached target Local File Systems. machine # [ 37.588980] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 37.592204] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 37.594336] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 37.598112] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 37.600215] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 37.602412] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 37.604111] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 37.621601] systemd[1]: Finished escaped\x2ddash.service. machine # [ 37.643286] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 37.644872] systemd[1]: Finished linger-users.service. machine # [ 37.749372] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 37.750990] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 38.008839] nixos[2895]: finished switching to system configuration /nix/store/6jfazyarbgm5yr06adv9ing3f5x58pqr-nixos-system-machine-test machine: (finished: must succeed: /nix/store/06jla896dwcr07hdzzrcz50s66462nzq-nixos-system-machine-test/specialisation/unitWithBackslash/bin/switch-to-configuration test 2>&1, in 1.42 seconds) machine: must succeed: /nix/store/06jla896dwcr07hdzzrcz50s66462nzq-nixos-system-machine-test/specialisation/unitWithBackslashModified/bin/switch-to-configuration test 2>&1 machine # [ 38.230760] nixos[3038]: switching to system configuration /nix/store/xy65gimzf4sqg8s7i281ry9q1q9539z4-nixos-system-machine-test machine # [ 38.233503] systemd[1]: escaped\x2ddash.service: Deactivated successfully. machine # [ 38.234403] systemd[1]: Stopped escaped\x2ddash.service. machine # [ 38.236831] systemd[1]: Stopped target Remote File Systems. machine # [ 38.237819] systemd[1]: Stopped target Local File Systems. machine # [ 38.456763] systemd[1]: Reload requested from client PID 3038 ('.switch-to-conf') (unit backdoor.service)... machine # [ 38.458461] systemd[1]: Reloading... machine # [ 38.691737] systemd[1]: Reloading finished in 231 ms. machine # [ 38.751173] systemd[620]: Reexecution requested from client PID 3107 ('switch-to-confi')... machine # [ 38.752451] systemd[620]: Reexecuting. machine # [ 38.771959] systemd[620]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 38.841307] systemd[620]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 38.846567] systemd[620]: Reload requested from client PID 3107 ('switch-to-confi')... machine # [ 38.847877] systemd[620]: Reloading... machine # [ 38.918711] systemd[620]: Reloading finished in 69 ms. machine # [ 38.922836] systemd[620]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 38.928970] systemd[620]: Stopped Run user-specific NixOS activation. machine # [ 38.931038] systemd[620]: Stopping Run user-specific NixOS activation... machine # [ 38.932529] systemd[620]: Starting Run user-specific NixOS activation... machine # [ 38.951737] systemd[620]: Finished Run user-specific NixOS activation. machine # [ 38.954711] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 38.956479] systemd[1]: Stopping Reactivate sysinit units... machine # [ 38.957621] systemd[1]: Reached target Reactivate sysinit units. machine # [ 38.963694] systemd[1]: Reached target Local File Systems. machine # [ 38.965324] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 38.966513] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 38.968422] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 38.972080] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 38.972882] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 38.974038] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 38.975918] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 38.977307] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 38.978462] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 38.985675] systemd[1]: Reached target Remote File Systems. machine # [ 39.107872] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 39.109549] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 39.113320] systemd[1]: Starting escaped\x2ddash.service... machine # [ 39.117091] systemd[1]: Starting linger-users.service... machine # [ 39.164387] systemd[1]: Finished escaped\x2ddash.service. machine # [ 39.177373] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 39.178892] systemd[1]: Finished linger-users.service. machine # [ 39.436229] nixos[3038]: finished switching to system configuration /nix/store/xy65gimzf4sqg8s7i281ry9q1q9539z4-nixos-system-machine-test machine: (finished: must succeed: /nix/store/06jla896dwcr07hdzzrcz50s66462nzq-nixos-system-machine-test/specialisation/unitWithBackslashModified/bin/switch-to-configuration test 2>&1, in 1.43 seconds) machine: must succeed: /nix/store/06jla896dwcr07hdzzrcz50s66462nzq-nixos-system-machine-test/specialisation/unitStartingWithDash/bin/switch-to-configuration test 2>&1 machine # [ 39.661267] nixos[3180]: switching to system configuration /nix/store/h85rrrm66zib7b539g6vh7ib5zhqb0p5-nixos-system-machine-test machine # [ 39.663750] systemd[1]: Stopped target Remote File Systems. machine # [ 39.666129] systemd[1]: Stopped target Local File Systems. machine # [ 39.666874] systemd[1]: escaped\x2ddash.service: Deactivated successfully. machine # [ 39.668304] systemd[1]: Stopped escaped\x2ddash.service. machine # [ 39.885918] systemd[1]: Reload requested from client PID 3180 ('.switch-to-conf') (unit backdoor.service)... machine # [ 39.887543] systemd[1]: Reloading... machine # [ 40.123840] systemd[1]: Reloading finished in 235 ms. machine # [ 40.186433] systemd[620]: Reexecution requested from client PID 3249 ('switch-to-confi')... machine # [ 40.188857] systemd[620]: Reexecuting. machine # [ 40.208252] systemd[620]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 40.279263] systemd[620]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 40.284373] systemd[620]: Reload requested from client PID 3249 ('switch-to-confi')... machine # [ 40.286646] systemd[620]: Reloading... machine # [ 40.364850] systemd[620]: Reloading finished in 78 ms. machine # [ 40.374938] systemd[620]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 40.386650] systemd[620]: Stopped Run user-specific NixOS activation. machine # [ 40.388428] systemd[620]: Stopping Run user-specific NixOS activation... machine # [ 40.392067] systemd[620]: Starting Run user-specific NixOS activation... machine # [ 40.418430] systemd[620]: Finished Run user-specific NixOS activation. machine # [ 40.421371] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 40.422725] systemd[1]: Stopping Reactivate sysinit units... machine # [ 40.423653] systemd[1]: Reached target Reactivate sysinit units. machine # [ 40.428038] systemd[1]: Reached target Local File Systems. machine # [ 40.428850] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 40.430996] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 40.431925] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 40.434714] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 40.437549] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 40.440106] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 40.441443] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 40.444924] systemd[1]: Reached target Remote File Systems. machine # [ 40.449283] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 40.450530] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 40.577528] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 40.579206] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 40.583136] systemd[1]: Starting -.service... machine # [ 40.586592] systemd[1]: Starting linger-users.service... machine # [ 40.611673] systemd[1]: Finished -.service. machine # [ 40.627264] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 40.629167] systemd[1]: Finished linger-users.service. machine # [ 40.886768] nixos[3180]: finished switching to system configuration /nix/store/h85rrrm66zib7b539g6vh7ib5zhqb0p5-nixos-system-machine-test machine: (finished: must succeed: /nix/store/06jla896dwcr07hdzzrcz50s66462nzq-nixos-system-machine-test/specialisation/unitStartingWithDash/bin/switch-to-configuration test 2>&1, in 1.45 seconds) machine: must succeed: /nix/store/06jla896dwcr07hdzzrcz50s66462nzq-nixos-system-machine-test/specialisation/unitStartingWithDashModified/bin/switch-to-configuration test 2>&1 machine # [ 41.115980] nixos[3323]: switching to system configuration /nix/store/ivk713hyj4h1qwhm3xwvkzjbsm52sql3-nixos-system-machine-test machine # [ 41.118352] systemd[1]: Stopped target Remote File Systems. machine # [ 41.119978] systemd[1]: Stopped target Local File Systems. machine # [ 41.342283] systemd[1]: Reload requested from client PID 3323 ('.switch-to-conf') (unit backdoor.service)... machine # [ 41.343929] systemd[1]: Reloading... machine # [ 41.581803] systemd[1]: Reloading finished in 235 ms. machine # [ 41.643749] systemd[620]: Reexecution requested from client PID 3392 ('switch-to-confi')... machine # [ 41.645492] systemd[620]: Reexecuting. machine # [ 41.667084] systemd[620]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 41.737708] systemd[620]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 41.743954] systemd[620]: Reload requested from client PID 3392 ('switch-to-confi')... machine # [ 41.746050] systemd[620]: Reloading... machine # [ 41.814280] systemd[620]: Reloading finished in 68 ms. machine # [ 41.819802] systemd[620]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 41.826247] systemd[620]: Stopped Run user-specific NixOS activation. machine # [ 41.828072] systemd[620]: Stopping Run user-specific NixOS activation... machine # [ 41.829542] systemd[620]: Starting Run user-specific NixOS activation... machine # [ 41.847943] systemd[620]: Finished Run user-specific NixOS activation. machine # [ 41.851526] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 41.852735] systemd[1]: Stopping Reactivate sysinit units... machine # [ 41.854175] systemd[1]: Reached target Reactivate sysinit units. machine # [ 41.856807] systemd[1]: Reloading -.service... machine # [ 41.870419] systemd[1]: Reloaded -.service. machine # [ 41.873991] systemd[1]: Reached target Local File Systems. machine # [ 41.879454] systemd[1]: Reached target Remote File Systems. machine # [ 41.881888] systemd[1]: Starting linger-users.service... machine # [ 41.884054] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 41.885800] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 41.893147] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 41.896043] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 41.896866] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 41.899049] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 41.900974] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 41.902436] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 41.903580] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 41.936956] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 41.938172] systemd[1]: Finished linger-users.service. machine # [ 42.046291] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 42.048575] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 42.304708] nixos[3323]: finished switching to system configuration /nix/store/ivk713hyj4h1qwhm3xwvkzjbsm52sql3-nixos-system-machine-test machine: (finished: must succeed: /nix/store/06jla896dwcr07hdzzrcz50s66462nzq-nixos-system-machine-test/specialisation/unitStartingWithDashModified/bin/switch-to-configuration test 2>&1, in 1.42 seconds) machine: must succeed: /nix/store/06jla896dwcr07hdzzrcz50s66462nzq-nixos-system-machine-test/specialisation/unitWithRequirement/bin/switch-to-configuration test 2>&1 machine # [ 42.532541] nixos[3465]: switching to system configuration /nix/store/ych3wdf38gg9nvxcaa33qiik4qb4j82r-nixos-system-machine-test machine # [ 42.535135] systemd[1]: -.service: Deactivated successfully. machine # [ 42.537674] systemd[1]: Stopped -.service. machine # [ 42.538346] systemd[1]: Stopped target Local File Systems. machine # [ 42.539168] systemd[1]: Stopped target Remote File Systems. machine # [ 42.767551] systemd[1]: Reload requested from client PID 3465 ('.switch-to-conf') (unit backdoor.service)... machine # [ 42.769163] systemd[1]: Reloading... machine # [ 43.032218] systemd[1]: Reloading finished in 261 ms. machine # [ 43.098153] systemd[620]: Reexecution requested from client PID 3534 ('switch-to-confi')... machine # [ 43.099718] systemd[620]: Reexecuting. machine # [ 43.121282] systemd[620]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 43.194363] systemd[620]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 43.199487] systemd[620]: Reload requested from client PID 3534 ('switch-to-confi')... machine # [ 43.200701] systemd[620]: Reloading... machine # [ 43.273387] systemd[620]: Reloading finished in 71 ms. machine # [ 43.278823] systemd[620]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 43.285855] systemd[620]: Stopped Run user-specific NixOS activation. machine # [ 43.286741] systemd[620]: Stopping Run user-specific NixOS activation... machine # [ 43.288418] systemd[620]: Starting Run user-specific NixOS activation... machine # [ 43.307666] systemd[620]: Finished Run user-specific NixOS activation. machine # [ 43.311081] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 43.311915] systemd[1]: Stopping Reactivate sysinit units... machine # [ 43.313111] systemd[1]: Reached target Reactivate sysinit units. machine # [ 43.318432] systemd[1]: Reached target Local File Systems. machine # [ 43.319765] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 43.321360] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 43.325055] systemd[1]: Reached target Remote File Systems. machine # [ 43.328062] systemd[1]: Starting linger-users.service... machine # [ 43.330127] systemd[1]: Starting required-service.service... machine # [ 43.334612] systemd[1]: Starting test-service.service... machine # [ 43.346065] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 43.348280] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 43.350474] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 43.351655] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 43.355329] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 43.357330] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 43.359607] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 43.383881] systemd[1]: Finished required-service.service. machine # [ 43.388057] systemd[1]: Finished test-service.service. machine # [ 43.408842] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 43.410745] systemd[1]: Finished linger-users.service. machine # [ 43.519391] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 43.520989] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 43.775416] nixos[3465]: finished switching to system configuration /nix/store/ych3wdf38gg9nvxcaa33qiik4qb4j82r-nixos-system-machine-test machine: (finished: must succeed: /nix/store/06jla896dwcr07hdzzrcz50s66462nzq-nixos-system-machine-test/specialisation/unitWithRequirement/bin/switch-to-configuration test 2>&1, in 1.47 seconds) machine: must succeed: /nix/store/06jla896dwcr07hdzzrcz50s66462nzq-nixos-system-machine-test/specialisation/unitWithRequirementModified/bin/switch-to-configuration test 2>&1 machine # [ 43.982598] nixos[3609]: switching to system configuration /nix/store/7rmmf3sr0f6z5kffnxf86i3g0pzf2kfi-nixos-system-machine-test machine # [ 43.985425] systemd[1]: Stopped target Local File Systems. machine # [ 43.987197] systemd[1]: Stopped target Remote File Systems. machine # [ 43.988545] systemd[1]: required-service.service: Deactivated successfully. machine # [ 43.990438] systemd[1]: Stopped required-service.service. machine # [ 43.991590] systemd[1]: test-service.service: Deactivated successfully. machine # [ 43.992458] systemd[1]: Stopped test-service.service. machine # [ 44.224769] systemd[1]: Reload requested from client PID 3609 ('.switch-to-conf') (unit backdoor.service)... machine # [ 44.226369] systemd[1]: Reloading... machine # [ 44.604812] systemd[1]: Reloading finished in 377 ms. machine # [ 44.670506] systemd[620]: Reexecution requested from client PID 3678 ('switch-to-confi')... machine # [ 44.672155] systemd[620]: Reexecuting. machine # [ 44.693474] systemd[620]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 44.765477] systemd[620]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 44.770460] systemd[620]: Reload requested from client PID 3678 ('switch-to-confi')... machine # [ 44.771673] systemd[620]: Reloading... machine # [ 44.839623] systemd[620]: Reloading finished in 66 ms. machine # [ 44.843823] systemd[620]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 44.849778] systemd[620]: Stopped Run user-specific NixOS activation. machine # [ 44.850874] systemd[620]: Stopping Run user-specific NixOS activation... machine # [ 44.853180] systemd[620]: Starting Run user-specific NixOS activation... machine # [ 44.873141] systemd[620]: Finished Run user-specific NixOS activation. machine # [ 44.875943] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 44.877236] systemd[1]: Stopping Reactivate sysinit units... machine # [ 44.878321] systemd[1]: Reached target Reactivate sysinit units. machine # [ 44.883596] systemd[1]: Starting required-service.service... machine # [ 44.885946] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 44.887702] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 44.893251] systemd[1]: Reached target Local File Systems. machine # [ 44.894121] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 44.898579] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 44.899427] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 44.900539] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 44.902588] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 44.904074] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 44.905292] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 44.910912] systemd[1]: Reached target Remote File Systems. machine # [ 44.935568] systemd[1]: Finished required-service.service. machine # [ 45.050600] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 45.052227] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 45.055967] systemd[1]: Starting linger-users.service... machine # [ 45.058634] systemd[1]: Starting test-service.service... machine # [ 45.080763] systemd[1]: Finished test-service.service. machine # [ 45.094676] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 45.096174] systemd[1]: Finished linger-users.service. machine # [ 45.352718] nixos[3609]: finished switching to system configuration /nix/store/7rmmf3sr0f6z5kffnxf86i3g0pzf2kfi-nixos-system-machine-test machine: (finished: must succeed: /nix/store/06jla896dwcr07hdzzrcz50s66462nzq-nixos-system-machine-test/specialisation/unitWithRequirementModified/bin/switch-to-configuration test 2>&1, in 1.58 seconds) machine: must succeed: /nix/store/06jla896dwcr07hdzzrcz50s66462nzq-nixos-system-machine-test/specialisation/unitWithRequirementModifiedNostart/bin/switch-to-configuration test 2>&1 machine # [ 45.587256] nixos[3753]: switching to system configuration /nix/store/fdg34m9bcnmh7gclxv9dn9b2qhb62hw5-nixos-system-machine-test machine # [ 45.589294] systemd[1]: Stopped target Remote File Systems. machine # [ 45.590802] systemd[1]: Stopped target Local File Systems. machine # [ 45.592650] systemd[1]: required-service.service: Deactivated successfully. machine # [ 45.594562] systemd[1]: Stopped required-service.service. machine # [ 45.595590] systemd[1]: test-service.service: Deactivated successfully. machine # [ 45.596640] systemd[1]: Stopped test-service.service. machine # [ 45.821184] systemd[1]: Reload requested from client PID 3753 ('.switch-to-conf') (unit backdoor.service)... machine # [ 45.822836] systemd[1]: Reloading... machine # [ 46.065347] systemd[1]: Reloading finished in 241 ms. machine # [ 46.126531] systemd[620]: Reexecution requested from client PID 3822 ('switch-to-confi')... machine # [ 46.128147] systemd[620]: Reexecuting. machine # [ 46.147964] systemd[620]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 46.217301] systemd[620]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 46.222725] systemd[620]: Reload requested from client PID 3822 ('switch-to-confi')... machine # [ 46.225128] systemd[620]: Reloading... machine # [ 46.293230] systemd[620]: Reloading finished in 68 ms. machine # [ 46.298817] systemd[620]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 46.305165] systemd[620]: Stopped Run user-specific NixOS activation. machine # [ 46.307047] systemd[620]: Stopping Run user-specific NixOS activation... machine # [ 46.308546] systemd[620]: Starting Run user-specific NixOS activation... machine # [ 46.326870] systemd[620]: Finished Run user-specific NixOS activation. machine # [ 46.330072] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 46.330919] systemd[1]: Stopping Reactivate sysinit units... machine # [ 46.331969] systemd[1]: Reached target Reactivate sysinit units. machine # [ 46.334058] systemd[1]: Reached target Local File Systems. machine # [ 46.336281] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 46.338611] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 46.340320] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 46.342290] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 46.344276] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 46.345652] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 46.346809] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 46.354586] systemd[1]: Reached target Remote File Systems. machine # [ 46.360417] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 46.362179] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 46.483067] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 46.484788] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 46.488244] systemd[1]: Starting linger-users.service... machine # [ 46.491154] systemd[1]: Starting required-service.service... machine # [ 46.496162] systemd[1]: Starting test-service.service... machine # [ 46.523129] systemd[1]: Finished required-service.service. machine # [ 46.525437] systemd[1]: Finished test-service.service. machine # [ 46.538243] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 46.539679] systemd[1]: Finished linger-users.service. machine # [ 46.796875] nixos[3753]: finished switching to system configuration /nix/store/fdg34m9bcnmh7gclxv9dn9b2qhb62hw5-nixos-system-machine-test machine: (finished: must succeed: /nix/store/06jla896dwcr07hdzzrcz50s66462nzq-nixos-system-machine-test/specialisation/unitWithRequirementModifiedNostart/bin/switch-to-configuration test 2>&1, in 1.44 seconds) machine: must succeed: /nix/store/06jla896dwcr07hdzzrcz50s66462nzq-nixos-system-machine-test/specialisation/unitWithTemplate/bin/switch-to-configuration test 2>&1 machine # [ 47.023436] nixos[3897]: switching to system configuration /nix/store/3fx7q7vrshwgmnbwxb7ncrpbysm77spi-nixos-system-machine-test machine # [ 47.025666] systemd[1]: required-service.service: Deactivated successfully. machine # [ 47.027598] systemd[1]: Stopped required-service.service. machine # [ 47.028741] systemd[1]: test-service.service: Deactivated successfully. machine # [ 47.030099] systemd[1]: Stopped test-service.service. machine # [ 47.030765] systemd[1]: Stopped target Local File Systems. machine # [ 47.032774] systemd[1]: Stopped target Remote File Systems. machine # [ 47.261340] systemd[1]: Reload requested from client PID 3897 ('.switch-to-conf') (unit backdoor.service)... machine # [ 47.263084] systemd[1]: Reloading... machine # [ 47.656548] systemd[1]: Reloading finished in 392 ms. machine # [ 47.718848] systemd[620]: Reexecution requested from client PID 3966 ('switch-to-confi')... machine # [ 47.720927] systemd[620]: Reexecuting. machine # [ 47.741580] systemd[620]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 47.813606] systemd[620]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 47.818760] systemd[620]: Reload requested from client PID 3966 ('switch-to-confi')... machine # [ 47.820111] systemd[620]: Reloading... machine # [ 47.889431] systemd[620]: Reloading finished in 67 ms. machine # [ 47.894809] systemd[620]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 47.900890] systemd[620]: Stopped Run user-specific NixOS activation. machine # [ 47.902729] systemd[620]: Stopping Run user-specific NixOS activation... machine # [ 47.906713] systemd[620]: Starting Run user-specific NixOS activation... machine # [ 47.925058] systemd[620]: Finished Run user-specific NixOS activation. machine # [ 47.927832] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 47.929307] systemd[1]: Stopping Reactivate sysinit units... machine # [ 47.930552] systemd[1]: Reached target Reactivate sysinit units. machine # [ 47.933454] systemd[1]: Reached target Local File Systems. machine # [ 47.935842] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 47.940060] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 47.940836] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 47.941965] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 47.944825] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 47.946304] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 47.947485] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 47.952061] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 47.953327] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 47.961499] systemd[1]: Created slice Slice /system/instantiated. machine # [ 47.963252] systemd[1]: Reached target Remote File Systems. machine # [ 48.087831] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 48.090210] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 48.093152] systemd[1]: Starting instantiated@one.service... machine # [ 48.096114] systemd[1]: Starting instantiated@two.service... machine # [ 48.100074] systemd[1]: Starting linger-users.service... machine # [ 48.124054] systemd[1]: Finished instantiated@one.service. machine # [ 48.130576] systemd[1]: Finished instantiated@two.service. machine # [ 48.143765] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 48.145942] systemd[1]: Finished linger-users.service. machine # [ 48.402766] nixos[3897]: finished switching to system configuration /nix/store/3fx7q7vrshwgmnbwxb7ncrpbysm77spi-nixos-system-machine-test machine: (finished: must succeed: /nix/store/06jla896dwcr07hdzzrcz50s66462nzq-nixos-system-machine-test/specialisation/unitWithTemplate/bin/switch-to-configuration test 2>&1, in 1.60 seconds) machine: must succeed: /nix/store/06jla896dwcr07hdzzrcz50s66462nzq-nixos-system-machine-test/specialisation/unitWithTemplateModified/bin/switch-to-configuration test 2>&1 machine # [ 48.650277] nixos[4041]: switching to system configuration /nix/store/yg8z10jm1blqk8nnyg9260r2r04208ag-nixos-system-machine-test machine # [ 48.652824] systemd[1]: Stopped target Remote File Systems. machine # [ 48.654767] systemd[1]: instantiated@one.service: Deactivated successfully. machine # [ 48.655988] systemd[1]: Stopped instantiated@one.service. machine # [ 48.657049] systemd[1]: Stopped target Local File Systems. machine # [ 48.658763] systemd[1]: instantiated@two.service: Deactivated successfully. machine # [ 48.659862] systemd[1]: Stopped instantiated@two.service. machine # [ 48.886705] systemd[1]: Reload requested from client PID 4041 ('.switch-to-conf') (unit backdoor.service)... machine # [ 48.888418] systemd[1]: Reloading... machine # [ 49.134851] systemd[1]: Reloading finished in 245 ms. machine # [ 49.197120] systemd[620]: Reexecution requested from client PID 4110 ('switch-to-confi')... machine # [ 49.198857] systemd[620]: Reexecuting. machine # [ 49.219974] systemd[620]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 49.294689] systemd[620]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 49.300731] systemd[620]: Reload requested from client PID 4110 ('switch-to-confi')... machine # [ 49.302898] systemd[620]: Reloading... machine # [ 49.376902] systemd[620]: Reloading finished in 74 ms. machine # [ 49.381822] systemd[620]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 49.388776] systemd[620]: Stopped Run user-specific NixOS activation. machine # [ 49.389713] systemd[620]: Stopping Run user-specific NixOS activation... machine # [ 49.391218] systemd[620]: Starting Run user-specific NixOS activation... machine # [ 49.410414] systemd[620]: Finished Run user-specific NixOS activation. machine # [ 49.413296] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 49.414678] systemd[1]: Stopping Reactivate sysinit units... machine # [ 49.415720] systemd[1]: Reached target Reactivate sysinit units. machine # [ 49.421478] systemd[1]: Reached target Local File Systems. machine # [ 49.424213] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 49.425789] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 49.428735] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 49.433376] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 49.434199] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 49.436363] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 49.438617] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 49.442128] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 49.443940] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 49.445086] systemd[1]: Reached target Remote File Systems. machine # [ 49.572095] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 49.573786] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 49.578375] systemd[1]: Starting instantiated@one.service... machine # [ 49.580117] systemd[1]: Starting instantiated@two.service... machine # [ 49.583330] systemd[1]: Starting linger-users.service... machine # [ 49.612379] systemd[1]: Finished instantiated@two.service. machine # [ 49.614816] systemd[1]: Finished instantiated@one.service. machine # [ 49.627531] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 49.629078] systemd[1]: Finished linger-users.service. machine # [ 49.886136] nixos[4041]: finished switching to system configuration /nix/store/yg8z10jm1blqk8nnyg9260r2r04208ag-nixos-system-machine-test machine: (finished: must succeed: /nix/store/06jla896dwcr07hdzzrcz50s66462nzq-nixos-system-machine-test/specialisation/unitWithTemplateModified/bin/switch-to-configuration test 2>&1, in 1.48 seconds) (finished: subtest: services, in 30.64 seconds) subtest: failing units machine: must succeed: /nix/store/06jla896dwcr07hdzzrcz50s66462nzq-nixos-system-machine-test/specialisation/simpleServiceModified/bin/switch-to-configuration test 2>&1 machine # [ 50.115994] nixos[4185]: switching to system configuration /nix/store/a6n76qkshsbmc478aq651f25zzqqmzns-nixos-system-machine-test machine # [ 50.118545] systemd[1]: Stopped target Remote File Systems. machine # [ 50.120482] systemd[1]: instantiated@two.service: Deactivated successfully. machine # [ 50.121916] systemd[1]: Stopped instantiated@two.service. machine # [ 50.123346] systemd[1]: Stopped target Local File Systems. machine # [ 50.125218] systemd[1]: instantiated@one.service: Deactivated successfully. machine # [ 50.126191] systemd[1]: Stopped instantiated@one.service. machine # [ 50.328887] systemd[1]: Reload requested from client PID 4185 ('.switch-to-conf') (unit backdoor.service)... machine # [ 50.330594] systemd[1]: Reloading... machine # [ 50.565029] systemd[1]: Reloading finished in 232 ms. machine # [ 50.629823] systemd[620]: Reexecution requested from client PID 4254 ('switch-to-confi')... machine # [ 50.631672] systemd[620]: Reexecuting. machine # [ 50.651034] systemd[620]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 50.721671] systemd[620]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 50.726810] systemd[620]: Reload requested from client PID 4254 ('switch-to-confi')... machine # [ 50.728310] systemd[620]: Reloading... machine # [ 50.801875] systemd[620]: Reloading finished in 72 ms. machine # [ 50.806808] systemd[620]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 50.812796] systemd[620]: Stopped Run user-specific NixOS activation. machine # [ 50.813833] systemd[620]: Stopping Run user-specific NixOS activation... machine # [ 50.816318] systemd[620]: Starting Run user-specific NixOS activation... machine # [ 50.836059] systemd[620]: Finished Run user-specific NixOS activation. machine # [ 50.838900] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 50.840163] systemd[1]: Stopping Reactivate sysinit units... machine # [ 50.840873] systemd[1]: Reached target Reactivate sysinit units. machine # [ 50.844058] systemd[1]: Reached target Remote File Systems. machine # [ 50.846587] systemd[1]: Starting linger-users.service... machine # [ 50.849274] systemd[1]: Starting test.service... machine # [ 50.852057] systemd[1]: Reached target Local File Systems. machine # [ 50.854061] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 50.860823] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 50.861856] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 50.863115] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 50.867170] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 50.868841] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 50.873157] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 50.878628] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 50.880059] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 50.905433] systemd[1]: Finished test.service. machine # [ 50.925837] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 50.927870] systemd[1]: Finished linger-users.service. machine # [ 51.036548] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 51.038764] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 51.292871] nixos[4185]: finished switching to system configuration /nix/store/a6n76qkshsbmc478aq651f25zzqqmzns-nixos-system-machine-test machine: (finished: must succeed: /nix/store/06jla896dwcr07hdzzrcz50s66462nzq-nixos-system-machine-test/specialisation/simpleServiceModified/bin/switch-to-configuration test 2>&1, in 1.40 seconds) machine: must fail: /nix/store/06jla896dwcr07hdzzrcz50s66462nzq-nixos-system-machine-test/specialisation/simpleServiceFailing/bin/switch-to-configuration test 2>&1 machine # [ 51.496845] nixos[4327]: switching to system configuration /nix/store/qq3lpxacbb24b58a8yc6lq4x3sm7fbwl-nixos-system-machine-test machine # [ 51.499252] systemd[1]: test.service: Deactivated successfully. machine # [ 51.501309] systemd[1]: Stopped test.service. machine # [ 51.501911] systemd[1]: Stopped target Local File Systems. machine # [ 51.503100] systemd[1]: Stopped target Remote File Systems. machine # [ 51.730679] systemd[1]: Reload requested from client PID 4327 ('.switch-to-conf') (unit backdoor.service)... machine # [ 51.732469] systemd[1]: Reloading... machine # [ 51.990764] systemd[1]: Reloading finished in 257 ms. machine # [ 52.054726] systemd[620]: Reexecution requested from client PID 4396 ('switch-to-confi')... machine # [ 52.056472] systemd[620]: Reexecuting. machine # [ 52.075758] systemd[620]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 52.143563] systemd[620]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 52.148893] systemd[620]: Reload requested from client PID 4396 ('switch-to-confi')... machine # [ 52.150509] systemd[620]: Reloading... machine # [ 52.221278] systemd[620]: Reloading finished in 69 ms. machine # [ 52.226925] systemd[620]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 52.233128] systemd[620]: Stopped Run user-specific NixOS activation. machine # [ 52.234920] systemd[620]: Stopping Run user-specific NixOS activation... machine # [ 52.236480] systemd[620]: Starting Run user-specific NixOS activation... machine # [ 52.255070] systemd[620]: Finished Run user-specific NixOS activation. machine # [ 52.257948] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 52.259254] systemd[1]: Stopping Reactivate sysinit units... machine # [ 52.259961] systemd[1]: Reached target Reactivate sysinit units. machine # [ 52.261519] systemd[1]: Reached target Local File Systems. machine # [ 52.263272] systemd[1]: Reached target Remote File Systems. machine # [ 52.266849] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 52.270174] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 52.272098] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 52.274103] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 52.277231] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 52.278704] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 52.279862] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 52.282683] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 52.283919] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 52.417652] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 52.419445] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 52.422869] systemd[1]: Starting linger-users.service... machine # [ 52.425585] systemd[1]: Starting test.service... machine # [ 52.447862] systemd[1]: test.service: Main process exited, code=exited, status=1/FAILURE machine # [ 52.449578] systemd[1]: test.service: Failed with result 'exit-code'. machine # [ 52.452159] systemd[1]: Failed to start test.service. machine # [ 52.463666] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 52.465073] systemd[1]: Finished linger-users.service. machine # [ 52.746705] nixos[4327]: switching to system configuration /nix/store/qq3lpxacbb24b58a8yc6lq4x3sm7fbwl-nixos-system-machine-test failed (status 4) machine: (finished: must fail: /nix/store/06jla896dwcr07hdzzrcz50s66462nzq-nixos-system-machine-test/specialisation/simpleServiceFailing/bin/switch-to-configuration test 2>&1, in 1.46 seconds) machine: must succeed: /nix/store/06jla896dwcr07hdzzrcz50s66462nzq-nixos-system-machine-test/specialisation/autorestartService/bin/switch-to-configuration test 2>&1 machine # [ 52.955306] nixos[4470]: switching to system configuration /nix/store/rd75v1hfflhmnw6bj533grg2i3ykrrrx-nixos-system-machine-test machine # [ 52.957521] systemd[1]: Stopped target Local File Systems. machine # [ 52.959272] systemd[1]: Stopped target Remote File Systems. machine # [ 53.182426] systemd[1]: Reload requested from client PID 4470 ('.switch-to-conf') (unit backdoor.service)... machine # [ 53.184096] systemd[1]: Reloading... machine # [ 53.426665] systemd[1]: Reloading finished in 240 ms. machine # [ 53.486344] systemd[620]: Reexecution requested from client PID 4539 ('switch-to-confi')... machine # [ 53.488763] systemd[620]: Reexecuting. machine # [ 53.509033] systemd[620]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 53.585423] systemd[620]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 53.590411] systemd[620]: Reload requested from client PID 4539 ('switch-to-confi')... machine # [ 53.592628] systemd[620]: Reloading... machine # [ 53.664768] systemd[620]: Reloading finished in 72 ms. machine # [ 53.669833] systemd[620]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 53.675942] systemd[620]: Stopped Run user-specific NixOS activation. machine # [ 53.677737] systemd[620]: Stopping Run user-specific NixOS activation... machine # [ 53.679435] systemd[620]: Starting Run user-specific NixOS activation... machine # [ 53.697843] systemd[620]: Finished Run user-specific NixOS activation. machine # [ 53.700689] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 53.701895] systemd[1]: Stopping Reactivate sysinit units... machine # [ 53.702937] systemd[1]: Reached target Reactivate sysinit units. machine # [ 53.708685] systemd[1]: Reached target Local File Systems. machine # [ 53.710689] systemd[1]: Reached target Remote File Systems. machine # [ 53.712332] systemd[1]: Started autorestart.service. machine # [ 53.714890] systemd[1]: Starting linger-users.service... machine # [ 53.720847] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 53.722434] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 53.727486] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 53.731062] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 53.732879] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 53.734229] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 53.736286] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 53.740521] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 53.742871] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 53.772545] systemd[1]: autorestart.service: Deactivated successfully. machine # [ 53.792786] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 53.794694] systemd[1]: Finished linger-users.service. machine # [ 53.899043] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 53.900936] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 54.158905] nixos[4470]: finished switching to system configuration /nix/store/rd75v1hfflhmnw6bj533grg2i3ykrrrx-nixos-system-machine-test machine: (finished: must succeed: /nix/store/06jla896dwcr07hdzzrcz50s66462nzq-nixos-system-machine-test/specialisation/autorestartService/bin/switch-to-configuration test 2>&1, in 1.41 seconds) machine # [ 54.207280] systemd[1]: Stopped autorestart.service. machine: must succeed: /nix/store/06jla896dwcr07hdzzrcz50s66462nzq-nixos-system-machine-test/specialisation/autorestartService/bin/switch-to-configuration test 2>&1 machine # [ 54.395458] nixos[4617]: switching to system configuration /nix/store/rd75v1hfflhmnw6bj533grg2i3ykrrrx-nixos-system-machine-test machine # [ 54.397630] systemd[1]: Stopped target Remote File Systems. machine # [ 54.399327] systemd[1]: Stopped target Local File Systems. machine # [ 54.606362] systemd[1]: Reload requested from client PID 4617 ('.switch-to-conf') (unit backdoor.service)... machine # [ 54.608125] systemd[1]: Reloading... machine # [ 54.837567] systemd[1]: Reloading finished in 228 ms. machine # [ 54.899325] systemd[620]: Reexecution requested from client PID 4686 ('switch-to-confi')... machine # [ 54.900604] systemd[620]: Reexecuting. machine # [ 54.919965] systemd[620]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 54.989650] systemd[620]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 54.994841] systemd[620]: Reload requested from client PID 4686 ('switch-to-confi')... machine # [ 54.996065] systemd[620]: Reloading... machine # [ 55.066973] systemd[620]: Reloading finished in 69 ms. machine # [ 55.072831] systemd[620]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 55.079838] systemd[620]: Stopped Run user-specific NixOS activation. machine # [ 55.080767] systemd[620]: Stopping Run user-specific NixOS activation... machine # [ 55.082454] systemd[620]: Starting Run user-specific NixOS activation... machine # [ 55.100932] systemd[620]: Finished Run user-specific NixOS activation. machine # [ 55.103703] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 55.104934] systemd[1]: Stopping Reactivate sysinit units... machine # [ 55.105962] systemd[1]: Reached target Reactivate sysinit units. machine # [ 55.111659] systemd[1]: Reached target Remote File Systems. machine # [ 55.114224] systemd[1]: Started autorestart.service. machine # [ 55.117272] systemd[1]: Starting linger-users.service... machine # [ 55.120770] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 55.122260] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 55.130518] systemd[1]: Reached target Local File Systems. machine # [ 55.133195] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 55.137215] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 55.137957] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 55.140990] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 55.143102] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 55.144578] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 55.146275] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 55.162647] systemd[1]: autorestart.service: Deactivated successfully. machine # [ 55.186711] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 55.189812] systemd[1]: Finished linger-users.service. machine # [ 55.291087] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 55.293069] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 55.551555] nixos[4617]: finished switching to system configuration /nix/store/rd75v1hfflhmnw6bj533grg2i3ykrrrx-nixos-system-machine-test machine: (finished: must succeed: /nix/store/06jla896dwcr07hdzzrcz50s66462nzq-nixos-system-machine-test/specialisation/autorestartService/bin/switch-to-configuration test 2>&1, in 1.34 seconds) machine # [ 55.596505] systemd[1]: Stopped autorestart.service. machine: must fail: /nix/store/06jla896dwcr07hdzzrcz50s66462nzq-nixos-system-machine-test/specialisation/autorestartServiceFailing/bin/switch-to-configuration test 2>&1 machine # [ 55.763943] nixos[4764]: switching to system configuration /nix/store/8ri1nf47hjnbyzysbms2zafpkyz6i92y-nixos-system-machine-test machine # [ 55.767093] systemd[1]: Stopped target Remote File Systems. machine # [ 55.767892] systemd[1]: Stopped target Local File Systems. machine # [ 55.967791] systemd[1]: Reload requested from client PID 4764 ('.switch-to-conf') (unit backdoor.service)... machine # [ 55.969392] systemd[1]: Reloading... machine # [ 56.180690] systemd[1]: Reloading finished in 210 ms. machine # [ 56.242318] systemd[620]: Reexecution requested from client PID 4833 ('switch-to-confi')... machine # [ 56.244753] systemd[620]: Reexecuting. machine # [ 56.267132] systemd[620]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 56.342360] systemd[620]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 56.347426] systemd[620]: Reload requested from client PID 4833 ('switch-to-confi')... machine # [ 56.348782] systemd[620]: Reloading... machine # [ 56.416825] systemd[620]: Reloading finished in 66 ms. machine # [ 56.421837] systemd[620]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 56.427819] systemd[620]: Stopped Run user-specific NixOS activation. machine # [ 56.428878] systemd[620]: Stopping Run user-specific NixOS activation... machine # [ 56.431176] systemd[620]: Starting Run user-specific NixOS activation... machine # [ 56.450713] systemd[620]: Finished Run user-specific NixOS activation. machine # [ 56.453736] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 56.455386] systemd[1]: Stopping Reactivate sysinit units... machine # [ 56.456624] systemd[1]: Reached target Reactivate sysinit units. machine # [ 56.457769] systemd[1]: Reached target Remote File Systems. machine # [ 56.460210] systemd[1]: Reached target Local File Systems. machine # [ 56.468237] systemd[1]: Started autorestart.service. machine # [ 56.471059] systemd[1]: Starting linger-users.service... machine # [ 56.479803] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 56.485493] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 56.486361] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 56.487578] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 56.489624] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 56.491148] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 56.492409] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 56.496393] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 56.497682] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 56.527514] systemd[1]: autorestart.service: Main process exited, code=exited, status=1/FAILURE machine # [ 56.529290] systemd[1]: autorestart.service: Failed with result 'exit-code'. machine # [ 56.550442] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 56.552476] systemd[1]: Finished linger-users.service. machine # [ 56.660513] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 56.662290] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 56.941748] nixos[4764]: switching to system configuration /nix/store/8ri1nf47hjnbyzysbms2zafpkyz6i92y-nixos-system-machine-test failed (status 4) machine: (finished: must fail: /nix/store/06jla896dwcr07hdzzrcz50s66462nzq-nixos-system-machine-test/specialisation/autorestartServiceFailing/bin/switch-to-configuration test 2>&1, in 1.34 seconds) (finished: subtest: failing units, in 7.06 seconds) subtest: unit file parser machine: must succeed: /nix/store/06jla896dwcr07hdzzrcz50s66462nzq-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1 machine # [ 57.151102] nixos[4907]: switching to system configuration /nix/store/70y2f6cixchrgih7nk81h5dg18lgy2wm-nixos-system-machine-test machine # [ 57.153369] systemd[1]: Stopped target Local File Systems. machine # [ 57.154874] systemd[1]: Stopped autorestart.service. machine # [ 57.156624] systemd[1]: Stopped target Remote File Systems. machine # [ 57.358269] systemd[1]: Reload requested from client PID 4907 ('.switch-to-conf') (unit backdoor.service)... machine # [ 57.359848] systemd[1]: Reloading... machine # [ 57.595538] systemd[1]: Reloading finished in 234 ms. machine # [ 57.655686] systemd[620]: Reexecution requested from client PID 4976 ('switch-to-confi')... machine # [ 57.658213] systemd[620]: Reexecuting. machine # [ 57.677945] systemd[620]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 57.749282] systemd[620]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 57.754685] systemd[620]: Reload requested from client PID 4976 ('switch-to-confi')... machine # [ 57.756571] systemd[620]: Reloading... machine # [ 57.825690] systemd[620]: Reloading finished in 68 ms. machine # [ 57.830825] systemd[620]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 57.836783] systemd[620]: Stopped Run user-specific NixOS activation. machine # [ 57.837830] systemd[620]: Stopping Run user-specific NixOS activation... machine # [ 57.840318] systemd[620]: Starting Run user-specific NixOS activation... machine # [ 57.859897] systemd[620]: Finished Run user-specific NixOS activation. machine # [ 57.862913] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 57.863884] systemd[1]: Stopping Reactivate sysinit units... machine # [ 57.865144] systemd[1]: Reached target Reactivate sysinit units. machine # [ 57.868181] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 57.869907] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 57.873252] systemd[1]: Reached target Remote File Systems. machine # [ 57.878392] systemd[1]: Starting linger-users.service... machine # [ 57.880138] systemd[1]: Starting test.service... machine # [ 57.887138] systemd[1]: Reached target Local File Systems. machine # [ 57.889972] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 57.894418] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 57.895317] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 57.896500] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 57.898448] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 57.899866] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 57.901109] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 57.926465] systemd[1]: Finished test.service. machine # [ 57.946502] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 57.948080] systemd[1]: Finished linger-users.service. machine # [ 58.052332] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 58.054081] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 58.311596] nixos[4907]: finished switching to system configuration /nix/store/70y2f6cixchrgih7nk81h5dg18lgy2wm-nixos-system-machine-test machine: (finished: must succeed: /nix/store/06jla896dwcr07hdzzrcz50s66462nzq-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1, in 1.37 seconds) machine: must succeed: /nix/store/06jla896dwcr07hdzzrcz50s66462nzq-nixos-system-machine-test/specialisation/simpleServiceWithExtraSection/bin/switch-to-configuration test 2>&1 machine # [ 58.547781] nixos[5049]: switching to system configuration /nix/store/g2qmyaq32cla9iqkcsy473f5i0z72fbm-nixos-system-machine-test machine # [ 58.550782] systemd[1]: Stopped target Remote File Systems. machine # [ 58.551950] systemd[1]: Stopped target Local File Systems. machine # [ 58.774598] systemd[1]: Reload requested from client PID 5049 ('.switch-to-conf') (unit backdoor.service)... machine # [ 58.776247] systemd[1]: Reloading... machine # [ 59.024925] systemd[1]: Reloading finished in 247 ms. machine # [ 59.090517] systemd[620]: Reexecution requested from client PID 5118 ('switch-to-confi')... machine # [ 59.092871] systemd[620]: Reexecuting. machine # [ 59.113996] systemd[620]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 59.187360] systemd[620]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 59.192652] systemd[620]: Reload requested from client PID 5118 ('switch-to-confi')... machine # [ 59.194115] systemd[620]: Reloading... machine # [ 59.266309] systemd[620]: Reloading finished in 70 ms. machine # [ 59.271817] systemd[620]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 59.278296] systemd[620]: Stopped Run user-specific NixOS activation. machine # [ 59.279892] systemd[620]: Stopping Run user-specific NixOS activation... machine # [ 59.281921] systemd[620]: Starting Run user-specific NixOS activation... machine # [ 59.301233] systemd[620]: Finished Run user-specific NixOS activation. machine # [ 59.304097] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 59.305635] systemd[1]: Stopping Reactivate sysinit units... machine # [ 59.306706] systemd[1]: Reached target Reactivate sysinit units. machine # [ 59.308193] systemd[1]: test.service: Deactivated successfully. machine # [ 59.310232] systemd[1]: Stopped test.service. machine # [ 59.310826] systemd[1]: Stopping test.service... machine # [ 59.311986] systemd[1]: Starting test.service... machine # [ 59.325558] systemd[1]: Finished test.service. machine # [ 59.327604] systemd[1]: Reached target Local File Systems. machine # [ 59.331130] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 59.336244] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 59.336980] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 59.338556] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 59.340605] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 59.342595] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 59.343807] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 59.346666] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 59.347872] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 59.350765] systemd[1]: Reached target Remote File Systems. machine # [ 59.479044] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 59.481298] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 59.484748] systemd[1]: Starting linger-users.service... machine # [ 59.511894] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 59.513476] systemd[1]: Finished linger-users.service. machine # [ 59.770765] nixos[5049]: finished switching to system configuration /nix/store/g2qmyaq32cla9iqkcsy473f5i0z72fbm-nixos-system-machine-test machine: (finished: must succeed: /nix/store/06jla896dwcr07hdzzrcz50s66462nzq-nixos-system-machine-test/specialisation/simpleServiceWithExtraSection/bin/switch-to-configuration test 2>&1, in 1.46 seconds) machine: must succeed: /nix/store/06jla896dwcr07hdzzrcz50s66462nzq-nixos-system-machine-test/specialisation/simpleServiceWithExtraSectionOtherName/bin/switch-to-configuration test 2>&1 machine # [ 59.988183] nixos[5191]: switching to system configuration /nix/store/kcq1wsh9xwsnddz7z6yh6356r6g3jd6b-nixos-system-machine-test machine # [ 59.990501] systemd[1]: Stopped target Local File Systems. machine # [ 59.992271] systemd[1]: Stopped target Remote File Systems. machine # [ 60.216222] systemd[1]: Reload requested from client PID 5191 ('.switch-to-conf') (unit backdoor.service)... machine # [ 60.218209] systemd[1]: Reloading... machine # [ 60.460254] systemd[1]: Reloading finished in 241 ms. machine # [ 60.528498] systemd[620]: Reexecution requested from client PID 5260 ('switch-to-confi')... machine # [ 60.529825] systemd[620]: Reexecuting. machine # [ 60.550173] systemd[620]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 60.622667] systemd[620]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 60.628683] systemd[620]: Reload requested from client PID 5260 ('switch-to-confi')... machine # [ 60.630986] systemd[620]: Reloading... machine # [ 60.700283] systemd[620]: Reloading finished in 69 ms. machine # [ 60.705814] systemd[620]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 60.711748] systemd[620]: Stopped Run user-specific NixOS activation. machine # [ 60.713202] systemd[620]: Stopping Run user-specific NixOS activation... machine # [ 60.715160] systemd[620]: Starting Run user-specific NixOS activation... machine # [ 60.734306] systemd[620]: Finished Run user-specific NixOS activation. machine # [ 60.737295] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 60.738548] systemd[1]: Stopping Reactivate sysinit units... machine # [ 60.739582] systemd[1]: Reached target Reactivate sysinit units. machine # [ 60.741291] systemd[1]: test.service: Deactivated successfully. machine # [ 60.743111] systemd[1]: Stopped test.service. machine # [ 60.743736] systemd[1]: Stopping test.service... machine # [ 60.745561] systemd[1]: Starting test.service... machine # [ 60.758442] systemd[1]: Finished test.service. machine # [ 60.763056] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 60.764878] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 60.768230] systemd[1]: Reached target Local File Systems. machine # [ 60.769752] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 60.772212] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 60.773988] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 60.775667] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 60.778537] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 60.781115] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 60.782480] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 60.785616] systemd[1]: Reached target Remote File Systems. machine # [ 60.911112] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 60.912858] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 60.916578] systemd[1]: Starting linger-users.service... machine # [ 60.942536] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 60.943962] systemd[1]: Finished linger-users.service. machine # [ 61.201448] nixos[5191]: finished switching to system configuration /nix/store/kcq1wsh9xwsnddz7z6yh6356r6g3jd6b-nixos-system-machine-test machine: (finished: must succeed: /nix/store/06jla896dwcr07hdzzrcz50s66462nzq-nixos-system-machine-test/specialisation/simpleServiceWithExtraSectionOtherName/bin/switch-to-configuration test 2>&1, in 1.43 seconds) machine: must succeed: /nix/store/06jla896dwcr07hdzzrcz50s66462nzq-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1 machine # [ 61.410597] nixos[5333]: switching to system configuration /nix/store/70y2f6cixchrgih7nk81h5dg18lgy2wm-nixos-system-machine-test machine # [ 61.412910] systemd[1]: Stopped target Remote File Systems. machine # [ 61.414681] systemd[1]: Stopped target Local File Systems. machine # [ 61.615895] systemd[1]: Reload requested from client PID 5333 ('.switch-to-conf') (unit backdoor.service)... machine # [ 61.617490] systemd[1]: Reloading... machine # [ 61.848384] systemd[1]: Reloading finished in 229 ms. machine # [ 61.910704] systemd[620]: Reexecution requested from client PID 5402 ('switch-to-confi')... machine # [ 61.913129] systemd[620]: Reexecuting. machine # [ 61.933963] systemd[620]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 62.005077] systemd[620]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 62.010478] systemd[620]: Reload requested from client PID 5402 ('switch-to-confi')... machine # [ 62.011808] systemd[620]: Reloading... machine # [ 62.081886] systemd[620]: Reloading finished in 69 ms. machine # [ 62.086817] systemd[620]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 62.092923] systemd[620]: Stopped Run user-specific NixOS activation. machine # [ 62.093853] systemd[620]: Stopping Run user-specific NixOS activation... machine # [ 62.096313] systemd[620]: Starting Run user-specific NixOS activation... machine # [ 62.114898] systemd[620]: Finished Run user-specific NixOS activation. machine # [ 62.117730] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 62.119180] systemd[1]: Stopping Reactivate sysinit units... machine # [ 62.119891] systemd[1]: Reached target Reactivate sysinit units. machine # [ 62.121695] systemd[1]: test.service: Deactivated successfully. machine # [ 62.123241] systemd[1]: Stopped test.service. machine # [ 62.123878] systemd[1]: Stopping test.service... machine # [ 62.125659] systemd[1]: Starting test.service... machine # [ 62.140101] systemd[1]: Finished test.service. machine # [ 62.142681] systemd[1]: Reached target Remote File Systems. machine # [ 62.145423] systemd[1]: Starting linger-users.service... machine # [ 62.151712] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 62.153124] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 62.154292] systemd[1]: Reached target Local File Systems. machine # [ 62.162994] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 62.167539] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 62.168363] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 62.169566] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 62.172890] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 62.175110] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 62.176227] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 62.205315] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 62.207248] systemd[1]: Finished linger-users.service. machine # [ 62.314715] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 62.316281] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 62.573539] nixos[5333]: finished switching to system configuration /nix/store/70y2f6cixchrgih7nk81h5dg18lgy2wm-nixos-system-machine-test machine: (finished: must succeed: /nix/store/06jla896dwcr07hdzzrcz50s66462nzq-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1, in 1.37 seconds) machine: must succeed: /nix/store/06jla896dwcr07hdzzrcz50s66462nzq-nixos-system-machine-test/specialisation/simpleServiceWithInstallSection/bin/switch-to-configuration test 2>&1 machine # [ 62.800327] nixos[5475]: switching to system configuration /nix/store/d2bq39bhw2a1zcvfn25c5mb611qz23cn-nixos-system-machine-test machine # [ 62.802614] systemd[1]: Stopped target Local File Systems. machine # [ 62.804052] systemd[1]: Stopped target Remote File Systems. machine # [ 63.028889] systemd[1]: Reload requested from client PID 5475 ('.switch-to-conf') (unit backdoor.service)... machine # [ 63.030485] systemd[1]: Reloading... machine # [ 63.263985] systemd[1]: Reloading finished in 232 ms. machine # [ 63.331203] systemd[620]: Reexecution requested from client PID 5544 ('switch-to-confi')... machine # [ 63.332944] systemd[620]: Reexecuting. machine # [ 63.353518] systemd[620]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 63.427324] systemd[620]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 63.432431] systemd[620]: Reload requested from client PID 5544 ('switch-to-confi')... machine # [ 63.433746] systemd[620]: Reloading... machine # [ 63.502798] systemd[620]: Reloading finished in 68 ms. machine # [ 63.507096] systemd[620]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 63.514254] systemd[620]: Stopped Run user-specific NixOS activation. machine # [ 63.516096] systemd[620]: Stopping Run user-specific NixOS activation... machine # [ 63.517530] systemd[620]: Starting Run user-specific NixOS activation... machine # [ 63.535638] systemd[620]: Finished Run user-specific NixOS activation. machine # [ 63.538432] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 63.539813] systemd[1]: Stopping Reactivate sysinit units... machine # [ 63.540939] systemd[1]: Reached target Reactivate sysinit units. machine # [ 63.543442] systemd[1]: Reached target Local File Systems. machine # [ 63.548927] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 63.551738] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 63.552545] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 63.553686] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 63.555627] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 63.557078] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 63.558276] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 63.563425] systemd[1]: Reached target Remote File Systems. machine # [ 63.568495] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 63.570279] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 63.691621] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 63.693855] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 63.696680] systemd[1]: Starting linger-users.service... machine # [ 63.722819] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 63.724315] systemd[1]: Finished linger-users.service. machine # [ 63.980523] nixos[5475]: finished switching to system configuration /nix/store/d2bq39bhw2a1zcvfn25c5mb611qz23cn-nixos-system-machine-test machine: (finished: must succeed: /nix/store/06jla896dwcr07hdzzrcz50s66462nzq-nixos-system-machine-test/specialisation/simpleServiceWithInstallSection/bin/switch-to-configuration test 2>&1, in 1.41 seconds) machine: must succeed: /nix/store/06jla896dwcr07hdzzrcz50s66462nzq-nixos-system-machine-test/specialisation/simpleServiceWithExtraKey/bin/switch-to-configuration test 2>&1 machine # [ 64.213728] nixos[5615]: switching to system configuration /nix/store/ng95lhh22h5f50lxj99mr5ki4rsdvng3-nixos-system-machine-test machine # [ 64.216589] systemd[1]: Stopped target Remote File Systems. machine # [ 64.217973] systemd[1]: Stopped target Local File Systems. machine # [ 64.443735] systemd[1]: Reload requested from client PID 5615 ('.switch-to-conf') (unit backdoor.service)... machine # [ 64.445371] systemd[1]: Reloading... machine # [ 64.701149] systemd[1]: Reloading finished in 253 ms. machine # [ 64.766267] systemd[620]: Reexecution requested from client PID 5684 ('switch-to-confi')... machine # [ 64.768265] systemd[620]: Reexecuting. machine # [ 64.788338] systemd[620]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 64.856427] systemd[620]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 64.861614] systemd[620]: Reload requested from client PID 5684 ('switch-to-confi')... machine # [ 64.863499] systemd[620]: Reloading... machine # [ 64.940915] systemd[620]: Reloading finished in 77 ms. machine # [ 64.947026] systemd[620]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 64.954585] systemd[620]: Stopped Run user-specific NixOS activation. machine # [ 64.955799] systemd[620]: Stopping Run user-specific NixOS activation... machine # [ 64.958827] systemd[620]: Starting Run user-specific NixOS activation... machine # [ 64.981536] systemd[620]: Finished Run user-specific NixOS activation. machine # [ 64.985133] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 64.986425] systemd[1]: Stopping Reactivate sysinit units... machine # [ 64.987356] systemd[1]: Reached target Reactivate sysinit units. machine # [ 64.989062] systemd[1]: test.service: Deactivated successfully. machine # [ 64.991117] systemd[1]: Stopped test.service. machine # [ 64.991765] systemd[1]: Stopping test.service... machine # [ 64.993197] systemd[1]: Starting test.service... machine # [ 65.007839] systemd[1]: Finished test.service. machine # [ 65.010637] systemd[1]: Reached target Remote File Systems. machine # [ 65.013515] systemd[1]: Starting linger-users.service... machine # [ 65.022880] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 65.024350] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 65.027554] systemd[1]: Reached target Local File Systems. machine # [ 65.030135] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 65.034286] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 65.035960] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 65.038584] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 65.041238] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 65.042736] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 65.045543] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 65.081088] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 65.084339] systemd[1]: Finished linger-users.service. machine # [ 65.194956] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 65.196555] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 65.454111] nixos[5615]: finished switching to system configuration /nix/store/ng95lhh22h5f50lxj99mr5ki4rsdvng3-nixos-system-machine-test machine: (finished: must succeed: /nix/store/06jla896dwcr07hdzzrcz50s66462nzq-nixos-system-machine-test/specialisation/simpleServiceWithExtraKey/bin/switch-to-configuration test 2>&1, in 1.47 seconds) machine: must succeed: /nix/store/06jla896dwcr07hdzzrcz50s66462nzq-nixos-system-machine-test/specialisation/simpleServiceWithExtraKeyOtherValue/bin/switch-to-configuration test 2>&1 machine # [ 65.688322] nixos[5757]: switching to system configuration /nix/store/2ms3br68j3cpj4s69rpjapy107jv2s1g-nixos-system-machine-test machine # [ 65.690654] systemd[1]: Stopped target Local File Systems. machine # [ 65.692275] systemd[1]: Stopped target Remote File Systems. machine # [ 65.912049] systemd[1]: Reload requested from client PID 5757 ('.switch-to-conf') (unit backdoor.service)... machine # [ 65.913700] systemd[1]: Reloading... machine # [ 66.150870] systemd[1]: Reloading finished in 236 ms. machine # [ 66.213535] systemd[620]: Reexecution requested from client PID 5826 ('switch-to-confi')... machine # [ 66.214765] systemd[620]: Reexecuting. machine # [ 66.234027] systemd[620]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 66.303926] systemd[620]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 66.309150] systemd[620]: Reload requested from client PID 5826 ('switch-to-confi')... machine # [ 66.310512] systemd[620]: Reloading... machine # [ 66.379588] systemd[620]: Reloading finished in 67 ms. machine # [ 66.384836] systemd[620]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 66.391815] systemd[620]: Stopped Run user-specific NixOS activation. machine # [ 66.392731] systemd[620]: Stopping Run user-specific NixOS activation... machine # [ 66.394225] systemd[620]: Starting Run user-specific NixOS activation... machine # [ 66.413260] systemd[620]: Finished Run user-specific NixOS activation. machine # [ 66.416242] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 66.417381] systemd[1]: Stopping Reactivate sysinit units... machine # [ 66.418384] systemd[1]: Reached target Reactivate sysinit units. machine # [ 66.420114] systemd[1]: test.service: Deactivated successfully. machine # [ 66.421984] systemd[1]: Stopped test.service. machine # [ 66.422598] systemd[1]: Stopping test.service... machine # [ 66.424059] systemd[1]: Starting test.service... machine # [ 66.438352] systemd[1]: Finished test.service. machine # [ 66.443875] systemd[1]: Reached target Local File Systems. machine # [ 66.446041] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 66.449026] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 66.449798] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 66.450901] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 66.454179] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 66.457230] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 66.458482] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 66.460407] systemd[1]: Reached target Remote File Systems. machine # [ 66.463972] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 66.465495] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 66.588914] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 66.590534] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 66.594164] systemd[1]: Starting linger-users.service... machine # [ 66.621376] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 66.623801] systemd[1]: Finished linger-users.service. machine # [ 66.879956] nixos[5757]: finished switching to system configuration /nix/store/2ms3br68j3cpj4s69rpjapy107jv2s1g-nixos-system-machine-test machine: (finished: must succeed: /nix/store/06jla896dwcr07hdzzrcz50s66462nzq-nixos-system-machine-test/specialisation/simpleServiceWithExtraKeyOtherValue/bin/switch-to-configuration test 2>&1, in 1.43 seconds) machine: must succeed: /nix/store/06jla896dwcr07hdzzrcz50s66462nzq-nixos-system-machine-test/specialisation/simpleServiceWithExtraKeyOtherName/bin/switch-to-configuration test 2>&1 machine # [ 67.131444] nixos[5899]: switching to system configuration /nix/store/g82ivzpb6cjijsx8x7xi5cvc6p53nvd3-nixos-system-machine-test machine # [ 67.133832] systemd[1]: Stopped target Local File Systems. machine # [ 67.135327] systemd[1]: Stopped target Remote File Systems. machine # [ 67.367517] systemd[1]: Reload requested from client PID 5899 ('.switch-to-conf') (unit backdoor.service)... machine # [ 67.369165] systemd[1]: Reloading... machine # [ 67.607985] systemd[1]: Reloading finished in 237 ms. machine # [ 67.673320] systemd[620]: Reexecution requested from client PID 5968 ('switch-to-confi')... machine # [ 67.675789] systemd[620]: Reexecuting. machine # [ 67.693079] systemd[620]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 67.769374] systemd[620]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 67.774590] systemd[620]: Reload requested from client PID 5968 ('switch-to-confi')... machine # [ 67.776091] systemd[620]: Reloading... machine # [ 67.849472] systemd[620]: Reloading finished in 72 ms. machine # [ 67.854811] systemd[620]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 67.861825] systemd[620]: Stopped Run user-specific NixOS activation. machine # [ 67.862701] systemd[620]: Stopping Run user-specific NixOS activation... machine # [ 67.864219] systemd[620]: Starting Run user-specific NixOS activation... machine # [ 67.883223] systemd[620]: Finished Run user-specific NixOS activation. machine # [ 67.886097] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 67.887556] systemd[1]: Stopping Reactivate sysinit units... machine # [ 67.888584] systemd[1]: Reached target Reactivate sysinit units. machine # [ 67.890119] systemd[1]: test.service: Deactivated successfully. machine # [ 67.892051] systemd[1]: Stopped test.service. machine # [ 67.892643] systemd[1]: Stopping test.service... machine # [ 67.893939] systemd[1]: Starting test.service... machine # [ 67.908182] systemd[1]: Finished test.service. machine # [ 67.910726] systemd[1]: Reached target Remote File Systems. machine # [ 67.913712] systemd[1]: Starting linger-users.service... machine # [ 67.919029] systemd[1]: Reached target Local File Systems. machine # [ 67.919747] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 67.924502] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 67.926668] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 67.928291] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 67.931112] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 67.932888] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 67.936300] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 67.944673] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 67.946334] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 67.979643] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 67.981145] systemd[1]: Finished linger-users.service. machine # [ 68.090765] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 68.092328] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 68.349373] nixos[5899]: finished switching to system configuration /nix/store/g82ivzpb6cjijsx8x7xi5cvc6p53nvd3-nixos-system-machine-test machine: (finished: must succeed: /nix/store/06jla896dwcr07hdzzrcz50s66462nzq-nixos-system-machine-test/specialisation/simpleServiceWithExtraKeyOtherName/bin/switch-to-configuration test 2>&1, in 1.47 seconds) machine: must succeed: /nix/store/06jla896dwcr07hdzzrcz50s66462nzq-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1 machine # [ 68.572186] nixos[6041]: switching to system configuration /nix/store/70y2f6cixchrgih7nk81h5dg18lgy2wm-nixos-system-machine-test machine # [ 68.574547] systemd[1]: Stopped target Local File Systems. machine # [ 68.576265] systemd[1]: Stopped target Remote File Systems. machine # [ 68.780951] systemd[1]: Reload requested from client PID 6041 ('.switch-to-conf') (unit backdoor.service)... machine # [ 68.782649] systemd[1]: Reloading... machine # [ 69.021895] systemd[1]: Reloading finished in 237 ms. machine # [ 69.080956] systemd[620]: Reexecution requested from client PID 6110 ('switch-to-confi')... machine # [ 69.082976] systemd[620]: Reexecuting. machine # [ 69.104086] systemd[620]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 69.176711] systemd[620]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 69.181786] systemd[620]: Reload requested from client PID 6110 ('switch-to-confi')... machine # [ 69.183276] systemd[620]: Reloading... machine # [ 69.253584] systemd[620]: Reloading finished in 69 ms. machine # [ 69.258809] systemd[620]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 69.266060] systemd[620]: Stopped Run user-specific NixOS activation. machine # [ 69.266864] systemd[620]: Stopping Run user-specific NixOS activation... machine # [ 69.268596] systemd[620]: Starting Run user-specific NixOS activation... machine # [ 69.287785] systemd[620]: Finished Run user-specific NixOS activation. machine # [ 69.291103] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 69.291989] systemd[1]: Stopping Reactivate sysinit units... machine # [ 69.293352] systemd[1]: Reached target Reactivate sysinit units. machine # [ 69.294822] systemd[1]: test.service: Deactivated successfully. machine # [ 69.296258] systemd[1]: Stopped test.service. machine # [ 69.296925] systemd[1]: Stopping test.service... machine # [ 69.299056] systemd[1]: Starting test.service... machine # [ 69.312180] systemd[1]: Finished test.service. machine # [ 69.314524] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 69.316140] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 69.321121] systemd[1]: Reached target Local File Systems. machine # [ 69.323285] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 69.325302] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 69.327309] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 69.329375] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 69.331689] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 69.335205] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 69.337283] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 69.341282] systemd[1]: Reached target Remote File Systems. machine # [ 69.463664] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 69.465531] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 69.469377] systemd[1]: Starting linger-users.service... machine # [ 69.495772] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 69.496822] systemd[1]: Finished linger-users.service. machine # [ 69.754322] nixos[6041]: finished switching to system configuration /nix/store/70y2f6cixchrgih7nk81h5dg18lgy2wm-nixos-system-machine-test machine: (finished: must succeed: /nix/store/06jla896dwcr07hdzzrcz50s66462nzq-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1, in 1.40 seconds) machine: must succeed: /nix/store/06jla896dwcr07hdzzrcz50s66462nzq-nixos-system-machine-test/specialisation/simpleServiceReloadTrigger/bin/switch-to-configuration test 2>&1 machine # [ 69.991932] nixos[6183]: switching to system configuration /nix/store/nsc3scadmzgsq4kx7v6r8hvgvsq47396-nixos-system-machine-test machine # [ 69.994269] systemd[1]: Stopped target Local File Systems. machine # [ 69.996054] systemd[1]: Stopped target Remote File Systems. machine # [ 70.220748] systemd[1]: Reload requested from client PID 6183 ('.switch-to-conf') (unit backdoor.service)... machine # [ 70.222420] systemd[1]: Reloading... machine # [ 70.460158] systemd[1]: Reloading finished in 236 ms. machine # [ 70.521958] systemd[620]: Reexecution requested from client PID 6252 ('switch-to-confi')... machine # [ 70.523974] systemd[620]: Reexecuting. machine # [ 70.545060] systemd[620]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 70.615915] systemd[620]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 70.621230] systemd[620]: Reload requested from client PID 6252 ('switch-to-confi')... machine # [ 70.622958] systemd[620]: Reloading... machine # [ 70.693920] systemd[620]: Reloading finished in 70 ms. machine # [ 70.698814] systemd[620]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 70.704923] systemd[620]: Stopped Run user-specific NixOS activation. machine # [ 70.705854] systemd[620]: Stopping Run user-specific NixOS activation... machine # [ 70.708561] systemd[620]: Starting Run user-specific NixOS activation... machine # [ 70.727060] systemd[620]: Finished Run user-specific NixOS activation. machine # [ 70.729823] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 70.731245] systemd[1]: Stopping Reactivate sysinit units... machine # [ 70.731988] systemd[1]: Reached target Reactivate sysinit units. machine # [ 70.735223] systemd[1]: Reloading test.service... machine # [ 70.748444] systemd[1]: Reloaded test.service. machine # [ 70.750349] systemd[1]: Reached target Remote File Systems. machine # [ 70.756820] systemd[1]: Reached target Local File Systems. machine # [ 70.759151] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 70.763389] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 70.764257] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 70.765432] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 70.769095] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 70.772170] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 70.773468] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 70.775446] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 70.776606] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 70.906465] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 70.908649] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 70.911819] systemd[1]: Starting linger-users.service... machine # [ 70.938239] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 70.939674] systemd[1]: Finished linger-users.service. machine # [ 71.196897] nixos[6183]: finished switching to system configuration /nix/store/nsc3scadmzgsq4kx7v6r8hvgvsq47396-nixos-system-machine-test machine: (finished: must succeed: /nix/store/06jla896dwcr07hdzzrcz50s66462nzq-nixos-system-machine-test/specialisation/simpleServiceReloadTrigger/bin/switch-to-configuration test 2>&1, in 1.44 seconds) machine: must succeed: /nix/store/06jla896dwcr07hdzzrcz50s66462nzq-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModified/bin/switch-to-configuration test 2>&1 machine # [ 71.421692] nixos[6325]: switching to system configuration /nix/store/ywm0g3gklyhhw6dl1v9j81y3l1mbnzsh-nixos-system-machine-test machine # [ 71.423993] systemd[1]: Stopped target Local File Systems. machine # [ 71.425862] systemd[1]: Stopped target Remote File Systems. machine # [ 71.643766] systemd[1]: Reload requested from client PID 6325 ('.switch-to-conf') (unit backdoor.service)... machine # [ 71.645383] systemd[1]: Reloading... machine # [ 71.881089] systemd[1]: Reloading finished in 234 ms. machine # [ 71.942551] systemd[620]: Reexecution requested from client PID 6394 ('switch-to-confi')... machine # [ 71.943985] systemd[620]: Reexecuting. machine # [ 71.964068] systemd[620]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 72.033185] systemd[620]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 72.038747] systemd[620]: Reload requested from client PID 6394 ('switch-to-confi')... machine # [ 72.040227] systemd[620]: Reloading... machine # [ 72.110859] systemd[620]: Reloading finished in 69 ms. machine # [ 72.116823] systemd[620]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 72.122674] systemd[620]: Stopped Run user-specific NixOS activation. machine # [ 72.123687] systemd[620]: Stopping Run user-specific NixOS activation... machine # [ 72.126297] systemd[620]: Starting Run user-specific NixOS activation... machine # [ 72.145947] systemd[620]: Finished Run user-specific NixOS activation. machine # [ 72.148786] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 72.150277] systemd[1]: Stopping Reactivate sysinit units... machine # [ 72.151187] systemd[1]: Reached target Reactivate sysinit units. machine # [ 72.154187] systemd[1]: Reloading test.service... machine # [ 72.167479] systemd[1]: Reloaded test.service. machine # [ 72.169602] systemd[1]: Reached target Local File Systems. machine # [ 72.171800] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 72.175288] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 72.177129] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 72.179107] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 72.181597] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 72.183754] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 72.186464] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 72.187633] systemd[1]: Reached target Remote File Systems. machine # [ 72.193882] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 72.195427] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 72.319046] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 72.320775] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 72.324753] systemd[1]: Starting linger-users.service... machine # [ 72.351375] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 72.353078] systemd[1]: Finished linger-users.service. machine # [ 72.610343] nixos[6325]: finished switching to system configuration /nix/store/ywm0g3gklyhhw6dl1v9j81y3l1mbnzsh-nixos-system-machine-test machine: (finished: must succeed: /nix/store/06jla896dwcr07hdzzrcz50s66462nzq-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModified/bin/switch-to-configuration test 2>&1, in 1.41 seconds) machine: must succeed: /nix/store/06jla896dwcr07hdzzrcz50s66462nzq-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModifiedAndSomethingElse/bin/switch-to-configuration test 2>&1 machine # [ 72.841966] nixos[6467]: switching to system configuration /nix/store/vcic0x573szi4gxlza47j0vqk8af9rlf-nixos-system-machine-test machine # [ 72.844444] systemd[1]: Stopped target Local File Systems. machine # [ 72.846238] systemd[1]: Stopped target Remote File Systems. machine # [ 73.069106] systemd[1]: Reload requested from client PID 6467 ('.switch-to-conf') (unit backdoor.service)... machine # [ 73.070926] systemd[1]: Reloading... machine # [ 73.324983] systemd[1]: Reloading finished in 252 ms. machine # [ 73.385372] systemd[620]: Reexecution requested from client PID 6536 ('switch-to-confi')... machine # [ 73.388139] systemd[620]: Reexecuting. machine # [ 73.405126] systemd[620]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 73.477546] systemd[620]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 73.482754] systemd[620]: Reload requested from client PID 6536 ('switch-to-confi')... machine # [ 73.484222] systemd[620]: Reloading... machine # [ 73.553883] systemd[620]: Reloading finished in 68 ms. machine # [ 73.558823] systemd[620]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 73.564938] systemd[620]: Stopped Run user-specific NixOS activation. machine # [ 73.565966] systemd[620]: Stopping Run user-specific NixOS activation... machine # [ 73.568457] systemd[620]: Starting Run user-specific NixOS activation... machine # [ 73.587115] systemd[620]: Finished Run user-specific NixOS activation. machine # [ 73.589923] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 73.591150] systemd[1]: Stopping Reactivate sysinit units... machine # [ 73.591868] systemd[1]: Reached target Reactivate sysinit units. machine # [ 73.593784] systemd[1]: test.service: Deactivated successfully. machine # [ 73.595149] systemd[1]: Stopped test.service. machine # [ 73.595795] systemd[1]: Stopping test.service... machine # [ 73.598076] systemd[1]: Starting test.service... machine # [ 73.612560] systemd[1]: Finished test.service. machine # [ 73.616077] systemd[1]: Reached target Local File Systems. machine # [ 73.617966] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 73.621038] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 73.621802] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 73.623477] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 73.628607] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 73.631473] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 73.632640] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 73.633780] systemd[1]: Reached target Remote File Systems. machine # [ 73.645768] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 73.647155] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 73.773625] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 73.775933] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 73.778883] systemd[1]: Starting linger-users.service... machine # [ 73.806516] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 73.807951] systemd[1]: Finished linger-users.service. machine # [ 74.064882] nixos[6467]: finished switching to system configuration /nix/store/vcic0x573szi4gxlza47j0vqk8af9rlf-nixos-system-machine-test machine: (finished: must succeed: /nix/store/06jla896dwcr07hdzzrcz50s66462nzq-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModifiedAndSomethingElse/bin/switch-to-configuration test 2>&1, in 1.46 seconds) machine: must succeed: /nix/store/06jla896dwcr07hdzzrcz50s66462nzq-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModifiedSomethingElse/bin/switch-to-configuration test 2>&1 machine # [ 74.279158] nixos[6609]: switching to system configuration /nix/store/ng95lhh22h5f50lxj99mr5ki4rsdvng3-nixos-system-machine-test machine # [ 74.282424] systemd[1]: Stopped target Remote File Systems. machine # [ 74.283620] systemd[1]: Stopped target Local File Systems. machine # [ 74.487928] systemd[1]: Reload requested from client PID 6609 ('.switch-to-conf') (unit backdoor.service)... machine # [ 74.489550] systemd[1]: Reloading... machine # [ 74.725517] systemd[1]: Reloading finished in 234 ms. machine # [ 74.787394] systemd[620]: Reexecution requested from client PID 6678 ('switch-to-confi')... machine # [ 74.788748] systemd[620]: Reexecuting. machine # [ 74.807343] systemd[620]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 74.878585] systemd[620]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 74.883744] systemd[620]: Reload requested from client PID 6678 ('switch-to-confi')... machine # [ 74.885211] systemd[620]: Reloading... machine # [ 74.956648] systemd[620]: Reloading finished in 70 ms. machine # [ 74.961850] systemd[620]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 74.967886] systemd[620]: Stopped Run user-specific NixOS activation. machine # [ 74.968907] systemd[620]: Stopping Run user-specific NixOS activation... machine # [ 74.971316] systemd[620]: Starting Run user-specific NixOS activation... machine # [ 74.989910] systemd[620]: Finished Run user-specific NixOS activation. machine # [ 74.992776] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 74.994165] systemd[1]: Stopping Reactivate sysinit units... machine # [ 74.994907] systemd[1]: Reached target Reactivate sysinit units. machine # [ 74.998826] systemd[1]: Reached target Local File Systems. machine # [ 75.001132] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 75.002469] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 75.004129] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 75.006084] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 75.006850] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 75.009817] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 75.011866] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 75.013359] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 75.014588] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 75.018472] systemd[1]: Reached target Remote File Systems. machine # [ 75.147837] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 75.149487] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 75.153209] systemd[1]: Starting linger-users.service... machine # [ 75.179859] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 75.181339] systemd[1]: Finished linger-users.service. machine # [ 75.436544] nixos[6609]: finished switching to system configuration /nix/store/ng95lhh22h5f50lxj99mr5ki4rsdvng3-nixos-system-machine-test machine: (finished: must succeed: /nix/store/06jla896dwcr07hdzzrcz50s66462nzq-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModifiedSomethingElse/bin/switch-to-configuration test 2>&1, in 1.37 seconds) (finished: subtest: unit file parser, in 18.50 seconds) subtest: restart and reload by activation script machine: must succeed: /nix/store/06jla896dwcr07hdzzrcz50s66462nzq-nixos-system-machine-test/specialisation/simpleServiceNorestart/bin/switch-to-configuration test 2>&1 machine # [ 75.645368] nixos[6749]: switching to system configuration /nix/store/r2i7kysbwpbjsfi4i3j0z0zai1nwgnjg-nixos-system-machine-test machine # [ 75.647531] systemd[1]: Stopped target Local File Systems. machine # [ 75.649236] systemd[1]: Stopped target Remote File Systems. machine # [ 75.852266] systemd[1]: Reload requested from client PID 6749 ('.switch-to-conf') (unit backdoor.service)... machine # [ 75.853846] systemd[1]: Reloading... machine # [ 76.101779] systemd[1]: Reloading finished in 246 ms. machine # [ 76.163431] systemd[620]: Reexecution requested from client PID 6818 ('switch-to-confi')... machine # [ 76.165943] systemd[620]: Reexecuting. machine # [ 76.187049] systemd[620]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 76.253693] systemd[620]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 76.258754] systemd[620]: Reload requested from client PID 6818 ('switch-to-confi')... machine # [ 76.259948] systemd[620]: Reloading... machine # [ 76.333671] systemd[620]: Reloading finished in 72 ms. machine # [ 76.338794] systemd[620]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 76.345226] systemd[620]: Stopped Run user-specific NixOS activation. machine # [ 76.346218] systemd[620]: Stopping Run user-specific NixOS activation... machine # [ 76.348229] systemd[620]: Starting Run user-specific NixOS activation... machine # [ 76.367593] systemd[620]: Finished Run user-specific NixOS activation. machine # [ 76.370568] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 76.371932] systemd[1]: Stopping Reactivate sysinit units... machine # [ 76.372931] systemd[1]: Reached target Reactivate sysinit units. machine # [ 76.376572] systemd[1]: Reached target Local File Systems. machine # [ 76.378297] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 76.380757] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 76.382738] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 76.384772] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 76.387541] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 76.388945] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 76.390133] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 76.393169] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 76.394380] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 76.396138] systemd[1]: Reached target Remote File Systems. machine # [ 76.528114] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 76.529752] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 76.533673] systemd[1]: Starting linger-users.service... machine # [ 76.560419] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 76.561824] systemd[1]: Finished linger-users.service. machine # [ 76.818931] nixos[6749]: finished switching to system configuration /nix/store/r2i7kysbwpbjsfi4i3j0z0zai1nwgnjg-nixos-system-machine-test machine: (finished: must succeed: /nix/store/06jla896dwcr07hdzzrcz50s66462nzq-nixos-system-machine-test/specialisation/simpleServiceNorestart/bin/switch-to-configuration test 2>&1, in 1.38 seconds) machine: must succeed: /nix/store/06jla896dwcr07hdzzrcz50s66462nzq-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration test 2>&1 machine # [ 77.066764] nixos[6889]: switching to system configuration /nix/store/j133yzd3rm106lmfri6zprk3527006f2-nixos-system-machine-test machine # [ 77.069608] systemd[1]: Stopped target Local File Systems. machine # [ 77.071787] systemd[1]: Stopped target Remote File Systems. machine # [ 77.072886] systemd[1]: test.service: Deactivated successfully. machine # [ 77.073912] systemd[1]: Stopped test.service. machine # [ 77.310509] systemd[1]: Reload requested from client PID 6889 ('.switch-to-conf') (unit backdoor.service)... machine # [ 77.312125] systemd[1]: Reloading... machine # [ 77.562054] systemd[1]: Reloading finished in 248 ms. machine # [ 77.626246] systemd[620]: Reexecution requested from client PID 6960 ('switch-to-confi')... machine # [ 77.628647] systemd[620]: Reexecuting. machine # [ 77.649164] systemd[620]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 77.718980] systemd[620]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 77.724939] systemd[620]: Reload requested from client PID 6960 ('switch-to-confi')... machine # [ 77.726593] systemd[620]: Reloading... machine # [ 77.796167] systemd[620]: Reloading finished in 68 ms. machine # [ 77.801815] systemd[620]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 77.808195] systemd[620]: Stopped Run user-specific NixOS activation. machine # [ 77.810034] systemd[620]: Stopping Run user-specific NixOS activation... machine # [ 77.811534] systemd[620]: Starting Run user-specific NixOS activation... machine # [ 77.830195] systemd[620]: Finished Run user-specific NixOS activation. machine # [ 77.833227] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 77.834500] systemd[1]: Stopping Reactivate sysinit units... machine # [ 77.835505] systemd[1]: Reached target Reactivate sysinit units. machine # [ 77.840230] systemd[1]: Starting simple-restart-service.service... machine # [ 77.844071] systemd[1]: Reached target Local File Systems. machine # [ 77.844805] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 77.849734] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 77.850623] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 77.851862] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 77.853795] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 77.855183] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 77.856455] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 77.866095] systemd[1]: Created slice Slice /system/templated-no-restart-service. machine # [ 77.871908] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 77.873663] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 77.875924] systemd[1]: Reached target Remote File Systems. machine # [ 77.884877] systemd[1]: Created slice Slice /system/templated-simple-restart-service. machine # [ 77.893970] systemd[1]: Created slice Slice /system/templated-reload-triggers-and-restart-by-as. machine # [ 77.903979] systemd[1]: Finished simple-restart-service.service. machine # [ 77.911185] systemd[1]: Created slice Slice /system/templated-simple-reload-service. machine # [ 77.918210] systemd[1]: Created slice Slice /system/templated-simple-service. machine # [ 77.922898] systemd[1]: Created slice Slice /system/templated-reload-triggers. machine # [ 77.925076] systemd[1]: Created slice Slice /system/templated-reload-triggers-and-restart. machine # [ 78.034028] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 78.035584] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 78.040118] systemd[1]: Starting linger-users.service... machine # [ 78.042227] systemd[1]: Starting no-restart-service.service... machine # [ 78.048422] systemd[1]: Starting reload-triggers-and-restart-by-as.service... machine # [ 78.049418] systemd[1]: Starting reload-triggers-and-restart.service... machine # [ 78.051131] systemd[1]: Starting reload-triggers.service... machine # [ 78.057951] systemd[1]: Starting simple-reload-service.service... machine # [ 78.058803] systemd[1]: Starting simple-service.service... machine # [ 78.067206] systemd[1]: Starting templated-no-restart-service@instance.service... machine # [ 78.075059] systemd[1]: Starting templated-reload-triggers-and-restart-by-as@instance.service... machine # [ 78.081422] systemd[1]: Starting templated-reload-triggers-and-restart@instance.service... machine # [ 78.087895] systemd[1]: Starting templated-reload-triggers@instance.service... machine # [ 78.094349] systemd[1]: Starting templated-simple-reload-service@instance.service... machine # [ 78.098313] systemd[1]: Starting templated-simple-restart-service@instance.service... machine # [ 78.103233] systemd[1]: Starting templated-simple-service@instance.service... machine # [ 78.197446] systemd[1]: Finished reload-triggers.service. machine # [ 78.198373] systemd[1]: Finished no-restart-service.service. machine # [ 78.203817] systemd[1]: Finished reload-triggers-and-restart-by-as.service. machine # [ 78.213153] systemd[1]: Finished reload-triggers-and-restart.service. machine # [ 78.215138] systemd[1]: Finished simple-reload-service.service. machine # [ 78.215933] systemd[1]: Finished simple-service.service. machine # [ 78.222136] systemd[1]: Finished templated-no-restart-service@instance.service. machine # [ 78.226362] systemd[1]: Finished templated-reload-triggers-and-restart-by-as@instance.service. machine # [ 78.241294] systemd[1]: Finished templated-reload-triggers@instance.service. machine # [ 78.243289] systemd[1]: Finished templated-simple-reload-service@instance.service. machine # [ 78.248057] systemd[1]: Finished templated-reload-triggers-and-restart@instance.service. machine # [ 78.250315] systemd[1]: Finished templated-simple-restart-service@instance.service. machine # [ 78.252455] systemd[1]: Finished templated-simple-service@instance.service. machine # [ 78.263157] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 78.264662] systemd[1]: Finished linger-users.service. machine # [ 78.519489] nixos[6889]: finished switching to system configuration /nix/store/j133yzd3rm106lmfri6zprk3527006f2-nixos-system-machine-test machine: (finished: must succeed: /nix/store/06jla896dwcr07hdzzrcz50s66462nzq-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration test 2>&1, in 1.70 seconds) machine: must succeed: /nix/store/06jla896dwcr07hdzzrcz50s66462nzq-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration test 2>&1 machine # [ 78.747830] nixos[7059]: switching to system configuration /nix/store/j133yzd3rm106lmfri6zprk3527006f2-nixos-system-machine-test machine # [ 78.749957] systemd[1]: Stopped target Remote File Systems. machine # [ 78.751579] systemd[1]: Stopped target Local File Systems. machine # [ 78.975788] systemd[1]: Reload requested from client PID 7059 ('.switch-to-conf') (unit backdoor.service)... machine # [ 78.977472] systemd[1]: Reloading... machine # [ 79.228030] systemd[1]: Reloading finished in 248 ms. machine # [ 79.291698] systemd[620]: Reexecution requested from client PID 7130 ('switch-to-confi')... machine # [ 79.294182] systemd[620]: Reexecuting. machine # [ 79.313976] systemd[620]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 79.384351] systemd[620]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 79.389682] systemd[620]: Reload requested from client PID 7130 ('switch-to-confi')... machine # [ 79.390948] systemd[620]: Reloading... machine # [ 79.460581] systemd[620]: Reloading finished in 68 ms. machine # [ 79.465814] systemd[620]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 79.471738] systemd[620]: Stopped Run user-specific NixOS activation. machine # [ 79.473173] systemd[620]: Stopping Run user-specific NixOS activation... machine # [ 79.475223] systemd[620]: Starting Run user-specific NixOS activation... machine # [ 79.494301] systemd[620]: Finished Run user-specific NixOS activation. machine # [ 79.497559] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 79.498668] systemd[1]: Stopping Reactivate sysinit units... machine # [ 79.499621] systemd[1]: Reached target Reactivate sysinit units. machine # [ 79.503797] systemd[1]: Reloading reload-triggers-and-restart.service... machine # [ 79.511099] systemd[1]: Reloading reload-triggers.service... machine # [ 79.514671] systemd[1]: Reloading simple-reload-service.service... machine # [ 79.520145] systemd[1]: Reloading templated-reload-triggers-and-restart@instance.service... machine # [ 79.524063] systemd[1]: Reloading templated-reload-triggers@instance.service... machine # [ 79.529820] systemd[1]: Reloading templated-simple-reload-service@instance.service... machine # [ 79.560164] systemd[1]: Reloaded reload-triggers-and-restart.service. machine # [ 79.562096] systemd[1]: Reloaded reload-triggers.service. machine # [ 79.579977] systemd[1]: Reloaded simple-reload-service.service. machine # [ 79.582208] systemd[1]: Reloaded templated-reload-triggers-and-restart@instance.service. machine # [ 79.584550] systemd[1]: Reloaded templated-reload-triggers@instance.service. machine # [ 79.588729] systemd[1]: Reloaded templated-simple-reload-service@instance.service. machine # [ 79.591593] systemd[1]: reload-triggers-and-restart-by-as.service: Deactivated successfully. machine # [ 79.593305] systemd[1]: Stopped reload-triggers-and-restart-by-as.service. machine # [ 79.594279] systemd[1]: Stopping reload-triggers-and-restart-by-as.service... machine # [ 79.596761] systemd[1]: Starting reload-triggers-and-restart-by-as.service... machine # [ 79.602193] systemd[1]: simple-restart-service.service: Deactivated successfully. machine # [ 79.603334] systemd[1]: Stopped simple-restart-service.service. machine # [ 79.604342] systemd[1]: Stopping simple-restart-service.service... machine # [ 79.607200] systemd[1]: Starting simple-restart-service.service... machine # [ 79.609145] systemd[1]: simple-service.service: Deactivated successfully. machine # [ 79.611474] systemd[1]: Stopped simple-service.service. machine # [ 79.615376] systemd[1]: Stopping simple-service.service... machine # [ 79.616234] systemd[1]: Starting simple-service.service... machine # [ 79.616962] systemd[1]: templated-reload-triggers-and-restart-by-as@instance.service: Deactivated successfully. machine # [ 79.619884] systemd[1]: Stopped templated-reload-triggers-and-restart-by-as@instance.service. machine # [ 79.622422] systemd[1]: Stopping templated-reload-triggers-and-restart-by-as@instance.service... machine # [ 79.624392] systemd[1]: Starting templated-reload-triggers-and-restart-by-as@instance.service... machine # [ 79.628179] systemd[1]: templated-simple-restart-service@instance.service: Deactivated successfully. machine # [ 79.630155] systemd[1]: Stopped templated-simple-restart-service@instance.service. machine # [ 79.633498] systemd[1]: Stopping templated-simple-restart-service@instance.service... machine # [ 79.634549] systemd[1]: Starting templated-simple-restart-service@instance.service... machine # [ 79.635580] systemd[1]: templated-simple-service@instance.service: Deactivated successfully. machine # [ 79.637111] systemd[1]: Stopped templated-simple-service@instance.service. machine # [ 79.637988] systemd[1]: Stopping templated-simple-service@instance.service... machine # [ 79.642121] systemd[1]: Starting templated-simple-service@instance.service... machine # [ 79.671124] systemd[1]: Finished reload-triggers-and-restart-by-as.service. machine # [ 79.683295] systemd[1]: Finished simple-restart-service.service. machine # [ 79.690342] systemd[1]: Finished templated-reload-triggers-and-restart-by-as@instance.service. machine # [ 79.692380] systemd[1]: Finished simple-service.service. machine # [ 79.695203] systemd[1]: Finished templated-simple-restart-service@instance.service. machine # [ 79.699194] systemd[1]: Finished templated-simple-service@instance.service. machine # [ 79.703392] systemd[1]: Reached target Local File Systems. machine # [ 79.705313] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 79.707727] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 79.709495] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 79.710619] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 79.712589] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 79.716276] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 79.717495] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 79.723330] systemd[1]: Reached target Remote File Systems. machine # [ 79.730330] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 79.731813] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 79.854087] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 79.856072] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 79.859358] systemd[1]: Starting linger-users.service... machine # [ 79.886339] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 79.888184] systemd[1]: Finished linger-users.service. machine # [ 80.144620] nixos[7059]: finished switching to system configuration /nix/store/j133yzd3rm106lmfri6zprk3527006f2-nixos-system-machine-test machine: (finished: must succeed: /nix/store/06jla896dwcr07hdzzrcz50s66462nzq-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration test 2>&1, in 1.63 seconds) machine: must succeed: /nix/store/06jla896dwcr07hdzzrcz50s66462nzq-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script-modified/bin/switch-to-configuration test 2>&1 machine # [ 80.421576] nixos[7225]: switching to system configuration /nix/store/3c33hj0v6ankissf54rj3w5jxa3ir5gl-nixos-system-machine-test machine # [ 80.423906] systemd[1]: Stopped target Local File Systems. machine # [ 80.425882] systemd[1]: Stopped target Remote File Systems. machine # [ 80.661731] systemd[1]: Reload requested from client PID 7225 ('.switch-to-conf') (unit backdoor.service)... machine # [ 80.663359] systemd[1]: Reloading... machine # [ 80.916948] systemd[1]: Reloading finished in 252 ms. machine # [ 80.981795] systemd[620]: Reexecution requested from client PID 7296 ('switch-to-confi')... machine # [ 80.983575] systemd[620]: Reexecuting. machine # [ 81.002939] systemd[620]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 81.072367] systemd[620]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 81.077470] systemd[620]: Reload requested from client PID 7296 ('switch-to-confi')... machine # [ 81.079276] systemd[620]: Reloading... machine # [ 81.149533] systemd[620]: Reloading finished in 69 ms. machine # [ 81.153812] systemd[620]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 81.160313] systemd[620]: Stopped Run user-specific NixOS activation. machine # [ 81.162120] systemd[620]: Stopping Run user-specific NixOS activation... machine # [ 81.163377] systemd[620]: Starting Run user-specific NixOS activation... machine # [ 81.181848] systemd[620]: Finished Run user-specific NixOS activation. machine # [ 81.184683] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 81.185986] systemd[1]: Stopping Reactivate sysinit units... machine # [ 81.186908] systemd[1]: Reached target Reactivate sysinit units. machine # [ 81.190808] systemd[1]: Reloading reload-triggers.service... machine # [ 81.196729] systemd[1]: Reloading simple-reload-service.service... machine # [ 81.202109] systemd[1]: Reloading templated-reload-triggers@instance.service... machine # [ 81.206255] systemd[1]: Reloading templated-simple-reload-service@instance.service... machine # [ 81.233390] systemd[1]: Reloaded reload-triggers.service. machine # [ 81.240675] systemd[1]: Reloaded simple-reload-service.service. machine # [ 81.242711] systemd[1]: Reloaded templated-reload-triggers@instance.service. machine # [ 81.244672] systemd[1]: Reloaded templated-simple-reload-service@instance.service. machine # [ 81.247570] systemd[1]: reload-triggers-and-restart-by-as.service: Deactivated successfully. machine # [ 81.249230] systemd[1]: Stopped reload-triggers-and-restart-by-as.service. machine # [ 81.250212] systemd[1]: Stopping reload-triggers-and-restart-by-as.service... machine # [ 81.252366] systemd[1]: Starting reload-triggers-and-restart-by-as.service... machine # [ 81.255591] systemd[1]: reload-triggers-and-restart.service: Deactivated successfully. machine # [ 81.256682] systemd[1]: Stopped reload-triggers-and-restart.service. machine # [ 81.258412] systemd[1]: Stopping reload-triggers-and-restart.service... machine # [ 81.260124] systemd[1]: Starting reload-triggers-and-restart.service... machine # [ 81.263079] systemd[1]: simple-restart-service.service: Deactivated successfully. machine # [ 81.264102] systemd[1]: Stopped simple-restart-service.service. machine # [ 81.264844] systemd[1]: Stopping simple-restart-service.service... machine # [ 81.268062] systemd[1]: Starting simple-restart-service.service... machine # [ 81.270088] systemd[1]: simple-service.service: Deactivated successfully. machine # [ 81.274224] systemd[1]: Stopped simple-service.service. machine # [ 81.274899] systemd[1]: Stopping simple-service.service... machine # [ 81.276368] systemd[1]: Starting simple-service.service... machine # [ 81.279690] systemd[1]: templated-reload-triggers-and-restart-by-as@instance.service: Deactivated successfully. machine # [ 81.280978] systemd[1]: Stopped templated-reload-triggers-and-restart-by-as@instance.service. machine # [ 81.282181] systemd[1]: Stopping templated-reload-triggers-and-restart-by-as@instance.service... machine # [ 81.283990] systemd[1]: Starting templated-reload-triggers-and-restart-by-as@instance.service... machine # [ 81.288405] systemd[1]: templated-reload-triggers-and-restart@instance.service: Deactivated successfully. machine # [ 81.293119] systemd[1]: Stopped templated-reload-triggers-and-restart@instance.service. machine # [ 81.294259] systemd[1]: Stopping templated-reload-triggers-and-restart@instance.service... machine # [ 81.295366] systemd[1]: Starting templated-reload-triggers-and-restart@instance.service... machine # [ 81.301125] systemd[1]: templated-simple-restart-service@instance.service: Deactivated successfully. machine # [ 81.306432] systemd[1]: Stopped templated-simple-restart-service@instance.service. machine # [ 81.307521] systemd[1]: Stopping templated-simple-restart-service@instance.service... machine # [ 81.310173] systemd[1]: Starting templated-simple-restart-service@instance.service... machine # [ 81.313130] systemd[1]: templated-simple-service@instance.service: Deactivated successfully. machine # [ 81.317534] systemd[1]: Stopped templated-simple-service@instance.service. machine # [ 81.318485] systemd[1]: Stopping templated-simple-service@instance.service... machine # [ 81.321440] systemd[1]: Starting templated-simple-service@instance.service... machine # [ 81.357698] systemd[1]: Finished reload-triggers-and-restart.service. machine # [ 81.360140] systemd[1]: Finished reload-triggers-and-restart-by-as.service. machine # [ 81.367095] systemd[1]: Finished simple-restart-service.service. machine # [ 81.380145] systemd[1]: Finished simple-service.service. machine # [ 81.382271] systemd[1]: Finished templated-reload-triggers-and-restart-by-as@instance.service. machine # [ 81.384516] systemd[1]: Finished templated-reload-triggers-and-restart@instance.service. machine # [ 81.386636] systemd[1]: Finished templated-simple-restart-service@instance.service. machine # [ 81.388700] systemd[1]: Finished templated-simple-service@instance.service. machine # [ 81.393841] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 81.395674] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 81.397956] systemd[1]: Reached target Remote File Systems. machine # [ 81.400568] systemd[1]: Starting linger-users.service... machine # [ 81.405751] systemd[1]: Reached target Local File Systems. machine # [ 81.408040] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 81.410159] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 81.410886] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 81.413266] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 81.416101] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 81.417477] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 81.418587] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 81.458803] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 81.460598] systemd[1]: Finished linger-users.service. machine # [ 81.565964] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 81.567761] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 81.825827] nixos[7225]: finished switching to system configuration /nix/store/3c33hj0v6ankissf54rj3w5jxa3ir5gl-nixos-system-machine-test machine: (finished: must succeed: /nix/store/06jla896dwcr07hdzzrcz50s66462nzq-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script-modified/bin/switch-to-configuration test 2>&1, in 1.68 seconds) machine: must succeed: /nix/store/06jla896dwcr07hdzzrcz50s66462nzq-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/06jla896dwcr07hdzzrcz50s66462nzq-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration dry-activate 2>&1, in 0.33 seconds) (finished: subtest: restart and reload by activation script, in 6.73 seconds) (finished: run the VM test script, in 83.20 seconds) test script finished in 83.39s 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-14T03:24:16Z INFO virtiofsd] Client disconnected, shutting down machine # [2026-10-14T03:24:16Z INFO virtiofsd] Client disconnected, shutting down machine # [2026-10-14T03:24:16Z INFO virtiofsd] Client disconnected, shutting down (finished: cleanup, in 0.13 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