tribuchet: building on eliza Machine state will be reset. To keep it, pass --keep-machine-state start all VLans (finished: start all VLans, in 0.00 seconds) Test will time out and terminate in 3600.0 seconds run the VM test script machine: waiting for unit multi-user.target machine: waiting for the VM to finish booting machine: starting vm machine # Disk image does not exist, creating the virtualisation disk image... machine: QEMU running (pid 45) machine # Formatting '/build/vm-state-machine/tmp.k7MYXKDYqI', 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: d3c4f12d-f4aa-408d-bdf3-65aa464bc038 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 # [ 0.000000] Booting Linux on physical CPU 0x0000000000 [0xc00fac40] machine # [ 0.000000] Linux version 6.18.50 (nixbld@localhost) (gcc (GCC) 15.3.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT Mon Sep 7 15:23:00 UTC 2026 machine # [ 0.000000] KASLR enabled machine # [ 0.000000] random: crng init done machine # [ 0.000000] Machine model: linux,dummy-virt machine # [ 0.000000] efi: UEFI not found. machine # [ 0.000000] OF: reserved mem: Reserved memory: No reserved-memory node in the DT machine # [ 0.000000] NUMA: Faking a node at [mem 0x0000000040000000-0x000000007fffffff] machine # [ 0.000000] NODE_DATA(0) allocated [mem 0x7fded700-0x7fdf0e7f] machine # [ 0.000000] Zone ranges: machine # [ 0.000000] DMA [mem 0x0000000040000000-0x000000007fffffff] machine # [ 0.000000] DMA32 empty machine # [ 0.000000] Normal empty machine # [ 0.000000] Device empty machine # [ 0.000000] Movable zone start for each node machine # [ 0.000000] Early memory node ranges machine # [ 0.000000] node 0: [mem 0x0000000040000000-0x000000007fffffff] machine # [ 0.000000] Initmem setup node 0 [mem 0x0000000040000000-0x000000007fffffff] machine # [ 0.000000] cma: Reserved 32 MiB at 0x000000007cc00000 machine # [ 0.000000] psci: probing for conduit method from DT. machine # [ 0.000000] psci: PSCIv1.3 detected in firmware. machine # [ 0.000000] psci: Using standard PSCI v0.2 function IDs machine # [ 0.000000] psci: Trusted OS migration not required machine # [ 0.000000] psci: SMC Calling Convention v1.1 machine # [ 0.000000] smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000003) machine # [ 0.000000] percpu: Embedded 76 pages/cpu s186648 r8192 d116456 u311296 machine # [ 0.000000] Detected PIPT I-cache on CPU0 machine # [ 0.000000] CPU features: detected: Address authentication (architected QARMA5 algorithm) machine # [ 0.000000] CPU features: detected: GICv3 CPU interface machine # [ 0.000000] CPU features: detected: Spectre-v4 machine # [ 0.000000] CPU features: detected: Spectre-BHB machine # [ 0.000000] CPU features: detected: AmpereOne erratum AC03_CPU_38 machine # [ 0.000000] CPU features: detected: AmpereOne erratum AC04_CPU_23 machine # [ 0.000000] alternatives: applying boot alternatives machine # [ 0.000000] Kernel command line: console=ttyAMA0 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/h3ab1710ajdhy39vg73h26d6b55bw8cn-nixos-system-machine-test/init regInfo=/nix/store/iiymjx9wnjj3hmsj0vbq5nhvn23052df-closure-info/registration console=ttyAMA0,115200n8 console=tty0 machine # [ 0.000000] Unknown kernel command line parameters "regInfo=/nix/store/iiymjx9wnjj3hmsj0vbq5nhvn23052df-closure-info/registration", will be passed to user space. machine # [ 0.000000] printk: log buffer data + meta data: 131072 + 458752 = 589824 bytes machine # [ 0.000000] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes, linear) machine # [ 0.000000] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes, linear) machine # [ 0.000000] software IO TLB: SWIOTLB bounce buffer size adjusted to 1MB machine # [ 0.000000] software IO TLB: area num 1. machine # [ 0.000000] software IO TLB: mapped [mem 0x000000007ca80000-0x000000007cb80000] (1MB) machine # [ 0.000000] Fallback order for Node 0: 0 machine # [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 262144 machine # [ 0.000000] Policy zone: DMA machine # [ 0.000000] mem auto-init: stack:all(zero), heap alloc:on, heap free:off machine # [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1 machine # [ 0.000000] allocated 2097152 bytes of page_ext machine # [ 0.000000] ftrace: allocating 74885 entries in 294 pages machine # [ 0.000000] ftrace: allocated 294 pages with 4 groups machine # [ 0.000000] rcu: Hierarchical RCU implementation. machine # [ 0.000000] rcu: RCU event tracing is enabled. machine # [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1. machine # [ 0.000000] Trampoline variant of Tasks RCU enabled. machine # [ 0.000000] Rude variant of Tasks RCU enabled. machine # [ 0.000000] Tracing variant of Tasks RCU enabled. machine # [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies. machine # [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1 machine # [ 0.000000] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. machine # [ 0.000000] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. machine # [ 0.000000] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. machine # [ 0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 machine # [ 0.000000] GICv3: 256 SPIs implemented machine # [ 0.000000] GICv3: 0 Extended SPIs implemented machine # [ 0.000000] Root IRQ handler: gic_handle_irq machine # [ 0.000000] GICv3: GICv3 features: 16 PPIs, DirectLPI machine # [ 0.000000] GICv3: GICD_CTLR.DS=1, SCR_EL3.FIQ=0 machine # [ 0.000000] GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000 machine # [ 0.000000] ITS [mem 0x08080000-0x0809ffff] machine # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Devices @44ce0000 (indirect, esz 8, psz 64K, shr 1) machine # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Interrupt Collections @44cf0000 (flat, esz 8, psz 64K, shr 1) machine # [ 0.000000] GICv3: using LPI property table @0x0000000044d10000 machine # [ 0.000000] GICv3: CPU0: using allocated LPI pending table @0x0000000044d20000 machine # [ 0.000000] rcu: srcu_init: Setting srcu_struct sizes based on contention. machine # [ 0.000000] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns machine # [ 0.000000] arch_timer: cp15 timer running at 1000.00MHz (virt). machine # [ 0.000000] clocksource: arch_sys_counter: mask: 0x1fffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns machine # [ 0.000000] sched_clock: 61 bits at 1000MHz, resolution 1ns, wraps every 4398046511103ns machine # [ 0.000030] arm-pv: using stolen time PV machine # [ 0.000394] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____) machine # [ 0.000591] Console: colour dummy device 80x25 machine # [ 0.000599] printk: legacy console [tty0] enabled machine # [ 0.000804] Calibrating delay loop (skipped), value calculated using timer frequency.. 2000.00 BogoMIPS (lpj=4000000) machine # [ 0.000811] pid_max: default: 32768 minimum: 301 machine # [ 0.000890] LSM: initializing lsm=capability,landlock,yama,bpf,ima machine # [ 0.001030] landlock: Up and running. machine # [ 0.001033] Yama: becoming mindful. machine # [ 0.001466] LSM support for eBPF active machine # [ 0.001587] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear) machine # [ 0.001608] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear) machine # [ 0.002740] cacheinfo: Unable to detect cache hierarchy for CPU 0 machine # [ 0.003484] rcu: Hierarchical SRCU implementation. machine # [ 0.003489] rcu: Max phase no-delay instances is 1000. machine # [ 0.004714] fsl-mc MSI: its@8080000 domain created machine # [ 0.004807] EFI services will not be available. machine # [ 0.004876] smp: Bringing up secondary CPUs ... machine # [ 0.004884] smp: Brought up 1 node, 1 CPU machine # [ 0.004887] SMP: Total of 1 processors activated. machine # [ 0.004890] CPU: All CPU(s) started at EL1 machine # [ 0.004905] CPU features: detected: Branch Target Identification machine # [ 0.004909] CPU features: detected: ARMv8.4 Translation Table Level machine # [ 0.004912] CPU features: detected: Instruction cache invalidation not required for I/D coherence machine # [ 0.004916] CPU features: detected: Data cache clean to the PoU not required for I/D coherence machine # [ 0.004920] CPU features: detected: Common not Private translations machine # [ 0.004923] CPU features: detected: CRC32 instructions machine # [ 0.004926] CPU features: detected: Data cache clean to Point of Deep Persistence machine # [ 0.004929] CPU features: detected: Data cache clean to Point of Persistence machine # [ 0.004933] CPU features: detected: Data independent timing control (DIT) machine # [ 0.004936] CPU features: detected: E0PD machine # [ 0.004938] CPU features: detected: Enhanced Counter Virtualization machine # [ 0.004941] CPU features: detected: Enhanced Counter Virtualization (CNTPOFF) machine # [ 0.004944] CPU features: detected: Enhanced Virtualization Traps machine # [ 0.004948] CPU features: detected: Fine Grained Traps machine # [ 0.004952] CPU features: detected: Generic authentication (architected QARMA5 algorithm) machine # [ 0.004957] CPU features: detected: RCpc load-acquire (LDAPR) machine # [ 0.004960] CPU features: detected: LSE atomic instructions machine # [ 0.004963] CPU features: detected: Privileged Access Never machine # [ 0.004966] CPU features: detected: PMUv3 machine # [ 0.004969] CPU features: detected: RAS Extension Support machine # [ 0.004971] CPU features: detected: RASv1p1 Extension Support machine # [ 0.004974] CPU features: detected: Random Number Generator machine # [ 0.004977] CPU features: detected: Speculation barrier (SB) machine # [ 0.004980] CPU features: detected: Stage-2 Force Write-Back machine # [ 0.004982] CPU features: detected: TLB range maintenance instructions machine # [ 0.004987] CPU features: detected: Speculative Store Bypassing Safe (SSBS) machine # [ 0.005030] alternatives: applying system-wide alternatives machine # [ 0.008059] CPU features: detected: BBM Level 2 without TLB conflict abort machine # [ 0.008209] Memory: 894668K/1048576K available (24448K kernel code, 7090K rwdata, 26348K rodata, 4736K init, 1107K bss, 112608K reserved, 32768K cma-reserved) machine # [ 0.008582] devtmpfs: initialized machine # [ 0.010315] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear) machine # [ 0.010341] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear). machine # [ 0.010546] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL machine # [ 0.010550] 0 pages in range for non-PLT usage machine # [ 0.010551] 508288 pages in range for PLT usage machine # [ 0.010667] pinctrl core: initialized pinctrl subsystem machine # [ 0.011441] DMI not present or invalid. machine # [ 0.014583] NET: Registered PF_NETLINK/PF_ROUTE protocol family machine # [ 0.016839] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations machine # [ 0.016992] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations machine # [ 0.017155] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations machine # [ 0.017178] audit: initializing netlink subsys (disabled) machine # [ 0.017761] thermal_sys: Registered thermal governor 'fair_share' machine # [ 0.017763] thermal_sys: Registered thermal governor 'bang_bang' machine # [ 0.017767] thermal_sys: Registered thermal governor 'step_wise' machine # [ 0.017770] thermal_sys: Registered thermal governor 'user_space' machine # [ 0.017776] thermal_sys: Registered thermal governor 'power_allocator' machine # [ 0.017816] audit: type=2000 audit(0.016:1): state=initialized audit_enabled=0 res=1 machine # [ 0.017825] cpuidle: using governor ladder machine # [ 0.017830] cpuidle: using governor menu machine # [ 0.018023] hw-breakpoint: found 16 breakpoint and 4 watchpoint registers. machine # [ 0.018040] ASID allocator initialised with 65536 entries machine # [ 0.019347] Serial: AMBA PL011 UART driver machine # [ 0.024604] 9000000.pl011: ttyAMA0 at MMIO 0x9000000 (irq = 13, base_baud = 0) is a PL011 rev1 machine # [ 0.024772] printk: console [ttyAMA0] enabled machine # [ 0.147317] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages machine # [ 0.147341] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page machine # [ 0.147347] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages machine # [ 0.147352] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page machine # [ 0.147356] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages machine # [ 0.147361] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page machine # [ 0.147365] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages machine # [ 0.147369] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page machine # [ 0.155201] fbcon: Taking over console machine # [ 0.155218] ACPI: Interpreter disabled. machine # [ 0.157098] iommu: Default domain type: Translated machine # [ 0.157109] iommu: DMA domain TLB invalidation policy: strict mode machine # [ 0.158838] SCSI subsystem initialized machine # [ 0.166463] usbcore: registered new interface driver usbfs machine # [ 0.166494] usbcore: registered new interface driver hub machine # [ 0.166514] usbcore: registered new device driver usb machine # [ 0.166829] pps_core: LinuxPPS API ver. 1 registered machine # [ 0.166836] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti machine # [ 0.166846] PTP clock support registered machine # [ 0.166902] EDAC MC: Ver: 3.0.0 machine # [ 0.171542] scmi_core: SCMI protocol bus registered machine # [ 0.172562] FPGA manager framework machine # [ 0.173565] vgaarb: loaded machine # [ 0.174220] clocksource: Switched to clocksource arch_sys_counter machine # [ 0.174827] VFS: Disk quotas dquot_6.6.0 machine # [ 0.174861] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) machine # [ 0.177192] netfs: FS-Cache loaded machine # [ 0.177311] pnp: PnP ACPI: disabled machine # [ 0.183272] NET: Registered PF_INET protocol family machine # [ 0.183434] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear) machine # [ 0.214477] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear) machine # [ 0.214533] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) machine # [ 0.214562] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear) machine # [ 0.214637] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear) machine # [ 0.214713] TCP: Hash tables configured (established 8192 bind 8192) machine # [ 0.214810] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear) machine # [ 0.214842] UDP hash table entries: 512 (order: 3, 32768 bytes, linear) machine # [ 0.214871] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear) machine # [ 0.214952] NET: Registered PF_UNIX/PF_LOCAL protocol family machine # [ 0.214974] NET: Registered PF_XDP protocol family machine # [ 0.214998] PCI: CLS 0 bytes, default 64 machine # [ 0.215249] Trying to unpack rootfs image as initramfs... machine # [ 0.231860] kvm [1]: HYP mode not available machine # [ 0.358564] Initialise system trusted keyrings machine # [ 0.359386] workingset: timestamp_bits=42 max_order=18 bucket_order=0 machine # [ 0.360709] squashfs: version 4.0 (2009/01/31) Phillip Lougher machine # [ 0.361503] 9p: Installing v9fs 9p2000 file system support machine # [ 0.385569] Key type asymmetric registered machine # [ 0.385603] Asymmetric key parser 'x509' registered machine # [ 0.385711] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 242) machine # [ 0.394287] io scheduler mq-deadline registered machine # [ 0.394313] io scheduler kyber registered machine # [ 0.399462] pl061_gpio 9030000.pl061: PL061 GPIO chip registered machine # [ 0.400756] ledtrig-cpu: registered to indicate activity on CPUs machine # [ 0.401148] pci-host-generic 4010000000.pcie: host bridge /pcie@10000000 ranges: machine # [ 0.401166] pci-host-generic 4010000000.pcie: IO 0x003eff0000..0x003effffff -> 0x0000000000 machine # [ 0.401178] pci-host-generic 4010000000.pcie: MEM 0x0010000000..0x003efeffff -> 0x0010000000 machine # [ 0.401187] pci-host-generic 4010000000.pcie: MEM 0x8000000000..0xffffffffff -> 0x8000000000 machine # [ 0.401208] pci-host-generic 4010000000.pcie: Memory resource size exceeds max for 32 bits machine # [ 0.401232] pci-host-generic 4010000000.pcie: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff] machine # [ 0.401303] pci-host-generic 4010000000.pcie: PCI host bridge to bus 0000:00 machine # [ 0.401313] pci_bus 0000:00: root bus resource [bus 00-ff] machine # [ 0.401321] pci_bus 0000:00: root bus resource [io 0x0000-0xffff] machine # [ 0.401326] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff] machine # [ 0.401332] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff] machine # [ 0.401397] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint machine # [ 0.401869] pci 0000:00:01.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint machine # [ 0.402059] pci 0000:00:01.0: BAR 0 [io 0x0000-0x001f] machine # [ 0.402075] pci 0000:00:01.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.402104] pci 0000:00:01.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.402120] pci 0000:00:01.0: ROM [mem 0x00000000-0x0003ffff pref] machine # [ 0.402597] pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint machine # [ 0.402785] pci 0000:00:02.0: BAR 0 [io 0x0000-0x001f] machine # [ 0.402801] pci 0000:00:02.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.402830] pci 0000:00:02.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.403279] pci 0000:00:03.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint machine # [ 0.403465] pci 0000:00:03.0: BAR 0 [io 0x0000-0x003f] machine # [ 0.403483] pci 0000:00:03.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.403514] pci 0000:00:03.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.403975] pci 0000:00:04.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint machine # [ 0.404164] pci 0000:00:04.0: BAR 0 [io 0x0000-0x001f] machine # [ 0.404180] pci 0000:00:04.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.404209] pci 0000:00:04.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.404672] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint machine # [ 0.404857] pci 0000:00:05.0: BAR 0 [io 0x0000-0x001f] machine # [ 0.404873] pci 0000:00:05.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.404902] pci 0000:00:05.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.405348] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint machine # [ 0.405536] pci 0000:00:06.0: BAR 0 [io 0x0000-0x007f] machine # [ 0.405554] pci 0000:00:06.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.405586] pci 0000:00:06.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.406054] pci 0000:00:07.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint machine # [ 0.446345] pci 0000:00:07.0: BAR 0 [io 0x0000-0x001f] machine # [ 0.446383] pci 0000:00:07.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.446414] pci 0000:00:07.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.446435] pci 0000:00:07.0: ROM [mem 0x00000000-0x0003ffff pref] machine # [ 0.447010] pci 0000:00:08.0: [1af4:1050] type 00 class 0x038000 conventional PCI endpoint machine # [ 0.447212] pci 0000:00:08.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.447243] pci 0000:00:08.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.447711] pci 0000:00:09.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint machine # [ 0.447896] pci 0000:00:09.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.447924] pci 0000:00:09.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.448322] pci 0000:00:0a.0: [8086:24cd] type 00 class 0x0c0320 conventional PCI endpoint machine # [ 0.448502] pci 0000:00:0a.0: BAR 0 [mem 0x00000000-0x00000fff] machine # [ 0.448763] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint machine # [ 0.449074] pci 0000:00:0b.0: BAR 0 [io 0x0000-0x003f] machine # [ 0.449092] pci 0000:00:0b.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.449120] pci 0000:00:0b.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.449574] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint machine # [ 0.449769] pci 0000:00:0c.0: BAR 0 [io 0x0000-0x001f] machine # [ 0.449785] pci 0000:00:0c.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.449814] pci 0000:00:0c.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.470501] pci 0000:00:01.0: ROM [mem 0x10000000-0x1003ffff pref]: assigned machine # [ 0.470531] pci 0000:00:07.0: ROM [mem 0x10040000-0x1007ffff pref]: assigned machine # [ 0.470537] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned machine # [ 0.470599] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]: assigned machine # [ 0.470658] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]: assigned machine # [ 0.470711] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]: assigned machine # [ 0.470766] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]: assigned machine # [ 0.470820] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]: assigned machine # [ 0.470869] pci 0000:00:07.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]: assigned machine # [ 0.470918] pci 0000:00:08.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]: assigned machine # [ 0.470966] pci 0000:00:09.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]: assigned machine # [ 0.471014] pci 0000:00:0b.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]: assigned machine # [ 0.471132] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]: assigned machine # [ 0.471181] pci 0000:00:01.0: BAR 1 [mem 0x10080000-0x10080fff]: assigned machine # [ 0.471203] pci 0000:00:02.0: BAR 1 [mem 0x10081000-0x10081fff]: assigned machine # [ 0.471226] pci 0000:00:03.0: BAR 1 [mem 0x10082000-0x10082fff]: assigned machine # [ 0.471247] pci 0000:00:04.0: BAR 1 [mem 0x10083000-0x10083fff]: assigned machine # [ 0.471269] pci 0000:00:05.0: BAR 1 [mem 0x10084000-0x10084fff]: assigned machine # [ 0.471302] pci 0000:00:06.0: BAR 1 [mem 0x10085000-0x10085fff]: assigned machine # [ 0.471325] pci 0000:00:07.0: BAR 1 [mem 0x10086000-0x10086fff]: assigned machine # [ 0.471347] pci 0000:00:08.0: BAR 1 [mem 0x10087000-0x10087fff]: assigned machine # [ 0.471370] pci 0000:00:09.0: BAR 1 [mem 0x10088000-0x10088fff]: assigned machine # [ 0.471396] pci 0000:00:0a.0: BAR 0 [mem 0x10089000-0x10089fff]: assigned machine # [ 0.471421] pci 0000:00:0b.0: BAR 1 [mem 0x1008a000-0x1008afff]: assigned machine # [ 0.471445] pci 0000:00:0c.0: BAR 1 [mem 0x1008b000-0x1008bfff]: assigned machine # [ 0.471466] pci 0000:00:06.0: BAR 0 [io 0x1000-0x107f]: assigned machine # [ 0.471489] pci 0000:00:03.0: BAR 0 [io 0x1080-0x10bf]: assigned machine # [ 0.471510] pci 0000:00:0b.0: BAR 0 [io 0x10c0-0x10ff]: assigned machine # [ 0.471532] pci 0000:00:01.0: BAR 0 [io 0x1100-0x111f]: assigned machine # [ 0.471553] pci 0000:00:02.0: BAR 0 [io 0x1120-0x113f]: assigned machine # [ 0.471575] pci 0000:00:04.0: BAR 0 [io 0x1140-0x115f]: assigned machine # [ 0.471597] pci 0000:00:05.0: BAR 0 [io 0x1160-0x117f]: assigned machine # [ 0.471619] pci 0000:00:07.0: BAR 0 [io 0x1180-0x119f]: assigned machine # [ 0.471641] pci 0000:00:0c.0: BAR 0 [io 0x11a0-0x11bf]: assigned machine # [ 0.471668] pci_bus 0000:00: resource 4 [io 0x0000-0xffff] machine # [ 0.471678] pci_bus 0000:00: resource 5 [mem 0x10000000-0x3efeffff] machine # [ 0.471683] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff] machine # [ 0.472855] pci 0000:00:0a.0: enabling device (0000 -> 0002) machine # [ 0.529055] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003) machine # [ 0.535634] virtio-pci 0000:00:02.0: enabling device (0000 -> 0003) machine # [ 0.537735] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003) machine # [ 0.547889] virtio-pci 0000:00:04.0: enabling device (0000 -> 0003) machine # [ 0.550074] virtio-pci 0000:00:05.0: enabling device (0000 -> 0003) machine # [ 0.561296] virtio-pci 0000:00:06.0: enabling device (0000 -> 0003) machine # [ 0.567575] virtio-pci 0000:00:07.0: enabling device (0000 -> 0003) machine # [ 0.569710] virtio-pci 0000:00:08.0: enabling device (0000 -> 0002) machine # [ 0.580308] virtio-pci 0000:00:09.0: enabling device (0000 -> 0002) machine # [ 0.582170] virtio-pci 0000:00:0b.0: enabling device (0000 -> 0003) machine # [ 0.592537] virtio-pci 0000:00:0c.0: enabling device (0000 -> 0003) machine # [ 0.606483] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled machine # [ 0.609179] msm_serial: driver initialized machine # [ 0.609332] SuperH (H)SCI(F) driver initialized machine # [ 0.609385] STM32 USART driver initialized machine # [ 0.643569] loop: module loaded machine # [ 0.643763] virtio_blk virtio5: 1/0/0 default/read/poll queues machine # [ 0.644532] virtio_blk virtio5: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) machine # [ 0.655014] megasas: 07.734.00.00-rc1 machine # [ 0.655746] physmap-flash 0.flash: physmap platform flash device: [mem 0x00000000-0x03ffffff] machine # [ 0.657983] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000 machine # [ 0.658014] Intel/Sharp Extended Query Table at 0x0031 machine # [ 0.667394] Using buffer write method machine # [ 0.667493] physmap-flash 0.flash: physmap platform flash device: [mem 0x04000000-0x07ffffff] machine # [ 0.678270] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000 machine # [ 0.678308] Intel/Sharp Extended Query Table at 0x0031 machine # [ 0.679876] Using buffer write method machine # [ 0.679909] Concatenating MTD devices: machine # [ 0.679913] (0): "0.flash" machine # [ 0.679918] (1): "0.flash" machine # [ 0.679921] into device "0.flash" machine # [ 0.954881] Freeing initrd memory: 25748K machine # [ 0.960979] tun: Universal TUN/TAP device driver, 1.6 machine # [ 0.964992] thunder_xcv, ver 1.0 machine # [ 0.965039] thunder_bgx, ver 1.0 machine # [ 0.965067] nicpf, ver 1.0 machine # [ 0.965609] e1000: Intel(R) PRO/1000 Network Driver machine # [ 0.965617] e1000: Copyright (c) 1999-2006 Intel Corporation. machine # [ 0.965662] e1000e: Intel(R) PRO/1000 Network Driver machine # [ 0.965671] e1000e: Copyright(c) 1999 - 2015 Intel Corporation. machine # [ 0.965700] igb: Intel(R) Gigabit Ethernet Network Driver machine # [ 0.965706] igb: Copyright (c) 2007-2014 Intel Corporation. machine # [ 0.965728] igbvf: Intel(R) Gigabit Virtual Function Network Driver machine # [ 0.965734] igbvf: Copyright (c) 2009 - 2012 Intel Corporation. machine # [ 0.965868] sky2: driver version 1.30 machine # [ 0.975059] usbcore: registered new interface driver usb-storage machine # [ 0.975186] usbcore: registered new interface driver usbserial_generic machine # [ 0.975200] usbserial: USB Serial support registered for generic machine # [ 0.975792] hv_vmbus: registering driver hyperv_keyboard machine # [ 0.980239] ehci-pci 0000:00:0a.0: EHCI Host Controller machine # [ 0.980275] ehci-pci 0000:00:0a.0: new USB bus registered, assigned bus number 1 machine # [ 0.980445] ehci-pci 0000:00:0a.0: irq 15, io mem 0x10089000 machine # [ 0.983082] rtc-pl031 9010000.pl031: registered as rtc0 machine # [ 0.983116] rtc-pl031 9010000.pl031: setting system clock to 2026-09-10T02:43:13 UTC (1789008193) machine # [ 0.983515] i2c_dev: i2c /dev entries driver machine # [ 0.988632] sdhci: Secure Digital Host Controller Interface driver machine # [ 0.988645] sdhci: Copyright(c) Pierre Ossman machine # [ 0.988915] Synopsys Designware Multimedia Card Interface Driver machine # [ 0.989287] sdhci-pltfm: SDHCI platform and OF driver helper machine # [ 0.990258] ehci-pci 0000:00:0a.0: USB 2.0 started, EHCI 1.00 machine # [ 0.990685] hub 1-0:1.0: USB hub found machine # [ 0.990712] hub 1-0:1.0: 6 ports detected machine # [ 0.996458] hid: raw HID events driver (C) Jiri Kosina machine # [ 0.996744] usbcore: registered new interface driver usbhid machine # [ 0.996751] usbhid: USB HID core driver machine # [ 0.999738] hw perfevents: enabled with armv8_pmuv3 PMU driver, 11 (0,800003ff) counters available machine # [ 1.001296] drop_monitor: Initializing network drop monitor service machine # [ 1.001501] NET: Registered PF_INET6 protocol family machine # [ 1.004712] Segment Routing with IPv6 machine # [ 1.004744] In-situ OAM (IOAM) with IPv6 machine # [ 1.004772] NET: Registered PF_PACKET protocol family machine # [ 1.006494] 9pnet: Installing 9P2000 support machine # [ 1.008685] Key type dns_resolver registered machine # [ 1.016067] registered taskstats version 1 machine # [ 1.016240] Loading compiled-in X.509 certificates machine # [ 1.025116] Demotion targets for Node 0: null machine # [ 1.025243] Key type .fscrypt registered machine # [ 1.025252] Key type fscrypt-provisioning registered machine # [ 1.025355] ima: No TPM chip found, activating TPM-bypass! machine # [ 1.025376] ima: Allocated hash algorithm: sha1 machine # [ 1.025399] ima: No architecture policies found machine # [ 1.029725] input: gpio-keys as /devices/platform/gpio-keys/input/input0 machine # [ 1.049354] clk: Disabling unused clocks machine # [ 1.049395] PM: genpd: Disabling unused power domains machine # [ 1.053788] Freeing unused kernel memory: 4736K machine # [ 1.054003] Run /init as init process machine # [ 1.068517] systemd[1]: Successfully made /usr/ read-only. machine # [ 1.238318] usb 1-1: new high-speed USB device number 2 using ehci-pci machine # [ 1.392642] input: QEMU QEMU USB Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:0a.0/usb1/1-1/1-1:1.0/0003:0627:0001.0001/input/input1 machine # [ 1.403482] systemd[1]: systemd 262-2ff84cf running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE) machine # [ 1.415852] systemd[1]: Detected virtualization qemu. machine # [ 1.418025] systemd[1]: Detected architecture arm64. machine # [ 1.420038] systemd[1]: Running in initrd. machine # [ 1.422838] systemd[1]: Initializing machine ID from random generator. machine # [ 1.425833] systemd[1]: Hostname set to . machine # [ 1.482530] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v1.11 Keyboard [QEMU QEMU USB Keyboard] on usb-0000:00:0a.0-1/input0 machine # [ 1.582178] systemd[1]: bpf-restrict-fs: LSM BPF program attached machine # [ 1.606340] usb 1-2: new high-speed USB device number 3 using ehci-pci machine # [ 1.640079] systemd[1]: Queued start job for default target Initrd Default Target. machine # [ 1.644264] systemd[1]: Created slice Slice /system/modprobe. machine # [ 1.645303] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. machine # [ 1.646393] systemd[1]: Expecting device /dev/disk/by-label/nixos... machine # [ 1.647257] systemd[1]: Reached target Path Units. machine # [ 1.647872] systemd[1]: Reached target Slice Units. machine # [ 1.648505] systemd[1]: Reached target Swaps. machine # [ 1.649067] systemd[1]: Reached target Timer Units. machine # [ 1.649854] systemd[1]: Listening on D-Bus System Message Bus Socket. machine # [ 1.651013] systemd[1]: Listening on Journal Socket (/dev/log). machine # [ 1.651893] systemd[1]: Listening on Journal Sockets. machine # [ 1.652621] systemd[1]: Listening on udev Kernel Socket. machine # [ 1.653300] systemd[1]: Reached target Socket Units. machine # [ 1.655465] systemd[1]: Starting Create List of Static Device Nodes... machine # [ 1.665141] systemd[1]: Starting Load Kernel Module 9pnet_virtio... machine # [ 1.666355] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs machine # [ 1.675553] systemd[1]: Mounting Kernel Configuration File System... machine # [ 1.694420] systemd[1]: Starting Journal Service... machine # [ 1.696690] systemd[1]: Starting Load Kernel Modules... machine # [ 1.697471] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 1.710500] systemd[1]: Starting Coldplug All udev Devices... machine # [ 1.725601] systemd[1]: Finished Create List of Static Device Nodes. machine # [ 1.726730] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully. machine # [ 1.730548] systemd[1]: Finished Load Kernel Module 9pnet_virtio. machine # [ 1.731657] systemd[1]: Mounted Kernel Configuration File System. machine # [ 1.742695] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... machine # [ 1.774608] systemd-journald[73]: Collecting audit messages is disabled. machine # [ 1.784928] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. machine # [ 1.789414] input: QEMU QEMU USB Tablet as /devices/platform/4010000000.pcie/pci0000:00/0000:00:0a.0/usb1/1-2/1-2:1.0/0003:0627:0001.0002/input/input2 machine # [ 1.789548] hid-generic 0003:0627:0001.0002: input,hidraw1: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:0a.0-2/input0 machine # [ 1.805966] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev machine # [ 1.810824] [drm] pci: virtio-gpu-pci detected at 0000:00:08.0 machine # [ 1.811059] [drm] features: -virgl +edid -resource_blob -host_visible machine # [ 1.811070] [drm] features: -context_init machine # [ 1.811824] [drm] number of scanouts: 1 machine # [ 1.811843] [drm] number of cap sets: 0 machine # [ 1.816994] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. machine # [ 1.819600] systemd[1]: Starting Create Static Device Nodes in /dev... machine # [ 1.832552] virtio-pci 0000:00:08.0: [drm] Registered 1 planes with drm panic machine # [ 1.832574] [drm] Initialized virtio_gpu 0.1.0 for 0000:00:08.0 on minor 0 machine # [ 1.856321] Console: switching to colour frame buffer device 160x50 machine # [ 1.886915] systemd[1]: Finished Create Static Device Nodes in /dev. machine # [ 1.887296] systemd[1]: Reached target Preparation for Local File Systems. machine # [ 1.887322] systemd[1]: Reached target Local File Systems. machine # [ 1.891412] virtio-pci 0000:00:08.0: [drm] fb0: virtio_gpudrmfb frame buffer device machine # [ 1.894854] systemd[1]: Starting Rule-based Manager for Device Events and Files... machine # [ 1.918338] systemd[1]: Finished Load Kernel Modules. machine # [ 1.927629] systemd[1]: Starting Apply Kernel Variables... machine # [ 1.955712] systemd-modules-load[74]: Inserted module 'dm_mod' machine # [ 1.971371] systemd[1]: Started Journal Service. machine # [ 1.960529] systemd-modules-load[74]: Module 'virtio_balloon' is built in machine # [ 1.961650] systemd-modules-load[74]: Module 'virtio_console' is built in machine # [ 1.962706] systemd-modules-load[74]: Inserted module 'virtio_gpu' machine # [ 1.963690] systemd-modules-load[74]: Module 'virtio_rng' is built in machine # [ 1.980449] systemd[1]: Starting Create System Files and Directories... machine # [ 1.995175] systemd[1]: Finished Apply Kernel Variables. machine # [ 2.000476] systemd-udevd[80]: Using default interface naming scheme 'v261'. machine # [ 2.019944] systemd[1]: Finished Create System Files and Directories. machine # [ 2.040147] systemd[1]: Started Rule-based Manager for Device Events and Files. machine # [ 2.108207] systemd[1]: Starting Virtual Console Setup... machine # [ 2.176563] systemd-vconsole-setup[103]: Configuration of first virtual console was skipped, ignoring remaining ones. machine # [ 2.180145] systemd[1]: Finished Virtual Console Setup. machine # [ 2.796380] systemd[1]: Finished Coldplug All udev Devices. machine # [ 2.797754] systemd[1]: Reached target System Initialization. machine # [ 2.798624] systemd[1]: Reached target Basic System. machine # [ 2.975762] (udev-worker)[99]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. machine # [ 2.980744] (udev-worker)[99]: Network interface NamePolicy= disabled on kernel command line. machine # [ 2.989813] (udev-worker)[92]: Network interface NamePolicy= disabled on kernel command line. machine # [ 3.045462] systemd[1]: Found device /dev/disk/by-label/nixos. machine # [ 3.047575] systemd[1]: Reached target Initrd Root Device. machine # [ 3.051893] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos... machine # [ 3.112427] systemd-fsck[112]: nixos: clean, 12/65536 files, 13019/262144 blocks machine # [ 3.121798] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos. machine # [ 3.131449] systemd[1]: Mounting /sysroot... machine # [ 3.190896] EXT4-fs (vda): mounted filesystem d3c4f12d-f4aa-408d-bdf3-65aa464bc038 r/w with ordered data mode. Quota mode: none. machine # [ 3.189479] systemd[1]: Mounted /sysroot. machine # [ 3.190277] systemd[1]: Reached target Initrd Root File System. machine # [ 3.191976] systemd[1]: Starting Mountpoints Configured in the Real Root... machine # [ 3.224647] systemd-sysroot-fstab-check[120]: /sysroot should be mounted in the initrd, will request daemon-reload. machine # [ 3.232124] systemd[1]: Reload requested from client PID 120 ('systemd-sysroot') (unit initrd-parse-etc.service)... machine # [ 3.236174] systemd[1]: Reloading... machine # [ 3.452326] systemd[1]: Reloading finished in 215 ms. machine # [ 3.475538] systemd-sysroot-fstab-check[120]: Requesting initrd-fs.target/start/replace... machine # [ 3.480445] systemd-sysroot-fstab-check[120]: Requesting swap.target/start/replace... machine # [ 3.486850] systemd[1]: Starting Load Kernel Module 9pnet_virtio... machine # [ 3.496635] systemd[1]: initrd-parse-etc.service: Deactivated successfully. machine # [ 3.498155] systemd[1]: Finished Mountpoints Configured in the Real Root. machine # [ 3.500520] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies. machine # [ 3.526496] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully. machine # [ 3.529084] systemd[1]: Finished Load Kernel Module 9pnet_virtio. machine # [ 3.714880] systemd[1]: Mounting /sysroot/nix/.ro-store... machine # [ 3.727642] systemd[1]: Mounting /sysroot/nix/.rw-store... machine # [ 3.739329] systemd[1]: Mounting /sysroot/run... machine # [ 3.759741] systemd[1]: Mounting /sysroot/tmp/shared... machine # [ 3.785254] systemd[1]: Mounting /sysroot/tmp/xchg... machine # [ 3.837798] systemd[1]: Mounted /sysroot/nix/.rw-store. machine # [ 3.867694] systemd[1]: Starting rw-sysroot-nix-store.service... machine # [ 3.881313] systemd[1]: Mounted /sysroot/nix/.ro-store. machine # [ 3.885200] systemd[1]: Mounted /sysroot/run. machine # [ 3.895189] systemd[1]: Mounted /sysroot/tmp/shared. machine # [ 3.911832] systemd[1]: Mounted /sysroot/tmp/xchg. machine # [ 3.924786] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. machine # [ 3.927910] systemd[1]: Finished rw-sysroot-nix-store.service. machine # [ 3.932436] systemd[1]: Mounting /sysroot/nix/store... machine # [ 3.977846] systemd[1]: Mounted /sysroot/nix/store. machine # [ 3.981114] systemd[1]: Reached target Initrd File Systems. machine # [ 3.986665] systemd[1]: Starting Find NixOS closure... machine # [ 4.004868] systemd[1]: Starting Create Volatile Files and Directories in the Real Root... machine # [ 4.040390] systemd[1]: Finished Create Volatile Files and Directories in the Real Root. machine # [ 4.058814] systemd[1]: Finished Find NixOS closure. machine # [ 4.062921] systemd[1]: Reached target Initrd Default Target. machine # [ 4.065962] systemd[1]: Starting Cleaning Up and Shutting Down Daemons... machine # [ 4.107014] systemd[1]: Stopped target Initrd Default Target. machine # [ 4.110950] systemd[1]: Stopped target Basic System. machine # [ 4.113054] systemd[1]: Stopped target Initrd Root Device. machine # [ 4.115341] systemd[1]: Stopped target Path Units. machine # [ 4.120058] systemd[1]: systemd-ask-password-console.path: Deactivated successfully. machine # [ 4.122349] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch. machine # [ 4.126503] systemd[1]: Stopped target Slice Units. machine # [ 4.128171] systemd[1]: Stopped target Socket Units. machine # [ 4.132791] systemd[1]: Stopped target System Initialization. machine # [ 4.134871] systemd[1]: Stopped target Swaps. machine # [ 4.135631] systemd[1]: Stopped target Timer Units. machine # [ 4.140869] systemd[1]: dbus.socket: Deactivated successfully. machine # [ 4.141750] systemd[1]: Closed D-Bus System Message Bus Socket. machine # [ 4.142575] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully. machine # [ 4.143640] systemd[1]: Stopped Find NixOS closure. machine # [ 4.149678] systemd[1]: Starting Load Kernel Module 9pnet_virtio... machine # [ 4.153414] systemd[1]: Starting rw-sysroot-nix-store.service... machine # [ 4.156740] systemd[1]: systemd-sysctl.service: Deactivated successfully. machine # [ 4.160777] systemd[1]: Stopped Apply Kernel Variables. machine # [ 4.162930] systemd[1]: systemd-modules-load.service: Deactivated successfully. machine # [ 4.165974] systemd[1]: Stopped Load Kernel Modules. machine # [ 4.167052] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully. machine # [ 4.177188] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root. machine # [ 4.178457] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. machine # [ 4.179641] systemd[1]: Stopped Create System Files and Directories. machine # [ 4.193581] systemd[1]: Stopped target Local File Systems. machine # [ 4.194464] systemd[1]: Stopped target Preparation for Local File Systems. machine # [ 4.195448] systemd[1]: systemd-udev-trigger.service: Deactivated successfully. machine # [ 4.208319] systemd[1]: Stopped Coldplug All udev Devices. machine # [ 4.209203] systemd[1]: Stopping Rule-based Manager for Device Events and Files... machine # [ 4.210456] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. machine # [ 4.219364] systemd[1]: Stopped Virtual Console Setup. machine # [ 4.220334] systemd[1]: initrd-cleanup.service: Deactivated successfully. machine # [ 4.221268] systemd[1]: Finished Cleaning Up and Shutting Down Daemons. machine # [ 4.222202] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully. machine # [ 4.223226] systemd[1]: Finished Load Kernel Module 9pnet_virtio. machine # [ 4.232336] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. machine # [ 4.236492] systemd[1]: Finished rw-sysroot-nix-store.service. machine # [ 4.237488] systemd[1]: systemd-udevd.service: Deactivated successfully. machine # [ 4.238450] systemd[1]: Stopped Rule-based Manager for Device Events and Files. machine # [ 4.239480] systemd[1]: systemd-udevd.service: Consumed 1.094s CPU time over 2.346s wall clock time, 16.4M memory peak. machine # [ 4.241038] systemd[1]: Starting Cleanup udev Database... machine # [ 4.241825] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. machine # [ 4.242869] systemd[1]: Stopped Create Static Device Nodes in /dev. machine # [ 4.243746] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. machine # [ 4.249924] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully. machine # [ 4.256276] systemd[1]: kmod-static-nodes.service: Deactivated successfully. machine # [ 4.257536] systemd[1]: Stopped Create List of Static Device Nodes. machine # [ 4.278872] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. machine # [ 4.281411] systemd[1]: Finished Cleanup udev Database. machine # [ 4.283742] systemd[1]: Reached target Switch Root. machine # [ 4.285626] systemd[1]: Starting NixOS Activation... machine # [ 4.462757] initrd-nixos-activation-start[172]: booting system configuration /nix/store/h3ab1710ajdhy39vg73h26d6b55bw8cn-nixos-system-machine-test machine # [ 4.532917] initrd-nixos-activation-start[172]: running activation script... machine # [ 4.974007] initrd-nixos-activation-start[195]: setting up /etc... machine # [ 5.248312] systemd[1]: initrd-nixos-activation.service: Deactivated successfully. machine # [ 5.251335] systemd[1]: Finished NixOS Activation. machine # [ 5.252828] systemd[1]: Starting Switch Root... machine # [ 5.278817] systemd[1]: Switching root. machine # [ 5.476776] systemd-journald[73]: Received SIGTERM from PID 1 (systemd). machine # [ 6.117499] systemd[1]: systemd 262-2ff84cf running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE) machine # [ 6.131240] systemd[1]: Detected virtualization qemu. machine # [ 6.134454] systemd[1]: Detected architecture arm64. machine # [ 6.137693] systemd[1]: Detected first boot. machine # [ 6.145967] systemd[1]: Initializing machine ID from random generator. machine # [ 6.352494] systemd[1]: bpf-restrict-fs: LSM BPF program attached machine # [ 6.529306] systemd[1]: Applying preset policy. machine # [ 7.021450] systemd[1]: Populated /etc with preset unit settings. machine # [ 7.539835] systemd[1]: initrd-switch-root.service: Deactivated successfully. machine # [ 7.541197] systemd[1]: Stopped initrd-switch-root.service. machine # [ 7.544605] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. machine # [ 7.548372] systemd[1]: Created slice Slice /system/getty. machine # [ 7.550792] systemd[1]: Created slice User and Session Slice. machine # [ 7.553092] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. machine # [ 7.555295] systemd[1]: Started Forward Password Requests to Wall Directory Watch. machine # [ 7.556634] systemd[1]: Expecting device /dev/hvc0... machine # [ 7.558575] systemd[1]: Expecting device /dev/ttyAMA0... machine # [ 7.560216] systemd[1]: Reached target Local Encrypted Volumes. machine # [ 7.561937] systemd[1]: Stopped target initrd-fs.target. machine # [ 7.563564] systemd[1]: Stopped target initrd-root-fs.target. machine # [ 7.565245] systemd[1]: Stopped target initrd-switch-root.target. machine # [ 7.567188] systemd[1]: Reached target Virtual Machines and Containers. machine # [ 7.569274] systemd[1]: Reached target Path Units. machine # [ 7.570989] systemd[1]: Reached target Remote File Systems. machine # [ 7.572711] systemd[1]: Reached target Slice Units. machine # [ 7.574405] systemd[1]: Reached target Swaps. machine # [ 7.577996] systemd[1]: Listening on Query the User Interactively for a Password. machine # [ 7.582485] systemd[1]: Listening on Process Core Dump Socket. machine # [ 7.586094] systemd[1]: Listening on Credential Encryption/Decryption. machine # [ 7.589622] systemd[1]: Listening on Factory Reset Management. machine # [ 7.591525] systemd[1]: Listening on Hostname Service Socket. machine # [ 7.596645] systemd[1]: Starting Journal Log Access Socket... machine # [ 7.598875] systemd[1]: Listening on Journal Audit Socket. machine # [ 7.604582] systemd[1]: Listening on Console Output Muting Service Socket. machine # [ 7.606212] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket. machine # [ 7.608199] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 7.610179] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 7.621419] systemd[1]: Listening on Disk Repartitioning Service Socket. machine # [ 7.621961] systemd[1]: Listening on udev Varlink Socket. machine # [ 7.627125] systemd[1]: Mounting Huge Pages File System... machine # [ 7.631710] systemd[1]: Mounting POSIX Message Queue File System... machine # [ 7.643022] systemd[1]: Mounting Kernel Debug File System... machine # [ 7.651630] systemd[1]: Mounting Kernel Trace File System... machine # [ 7.670452] systemd[1]: Starting Create List of Static Device Nodes... machine # [ 7.688308] systemd[1]: Starting Load Kernel Module 9pnet_virtio... machine # [ 7.691611] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs machine # [ 7.710651] systemd[1]: Mounting Kernel Configuration File System... machine # [ 7.713497] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm machine # [ 7.717003] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 7.794419] systemd[1]: Starting Load Kernel Module fuse... machine # [ 7.794998] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 7.852756] systemd[1]: Starting Journal Service... machine # [ 7.890427] systemd[1]: Starting Load Kernel Modules... machine # [ 7.918613] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer... machine # [ 7.941036] fuse: init (API version 7.45) machine # [ 7.945915] systemd[1]: Starting Remount Root and Kernel File Systems... machine # [ 7.948671] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 7.962756] systemd[1]: Starting Coldplug All udev Devices... machine # [ 7.981959] systemd[1]: Listening on Journal Log Access Socket. machine # [ 8.001168] systemd[1]: Mounted Huge Pages File System. machine # [ 8.007824] systemd-journald[268]: Collecting audit messages is enabled. machine # [ 8.013152] systemd[1]: Mounted POSIX Message Queue File System. machine # [ 8.019368] systemd[1]: Mounted Kernel Debug File System. machine # [ 8.022800] systemd[1]: Mounted Kernel Trace File System. machine # [ 8.013804] systemd[1]: Queued start job for default target Multi-User System. machine # [ 8.030429] systemd[1]: Finished Create List of Static Device Nodes. machine # [ 8.020662] systemd[1]: systemd-journald.service: Deactivated successfully. machine # [ 8.036326] systemd[1]: Started Journal Service. machine # [ 8.031510] systemd-modules-load[269]: Module 'atkbd' is built in machine # [ 8.038139] systemd-modules-load[269]: Module 'loop' is built in machine # [ 8.044609] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully. machine # [ 8.053334] systemd[1]: Finished Load Kernel Module 9pnet_virtio. machine # [ 8.060890] systemd[1]: Mounted Kernel Configuration File System. machine # [ 8.066558] systemd[1]: modprobe@fuse.service: Deactivated successfully. machine # [ 8.075436] systemd[1]: Finished Load Kernel Module fuse. machine # [ 8.083612] systemd[1]: Finished Load Kernel Modules. machine # [ 8.092242] systemd[1]: Mounting FUSE Control File System... machine # [ 8.111902] EXT4-fs (vda): re-mounted d3c4f12d-f4aa-408d-bdf3-65aa464bc038. machine # [ 8.102533] systemd[1]: Starting Firewall... machine # [ 8.126815] systemd[1]: Starting Apply Kernel Variables... machine # [ 8.142429] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... machine # [ 8.158345] systemd-oomd[271]: No swap; memory pressure usage will be degraded machine # [ 8.166001] systemd[1]: Finished Remount Root and Kernel File Systems. machine # [ 8.175078] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer. machine # [ 8.209169] systemd[1]: Listening on Disk Image Download Service Socket. machine # [ 8.234780] systemd[1]: Starting Flush Journal to Persistent Storage... machine # [ 8.240282] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 8.256946] systemd[1]: Starting Load/Save OS Random Seed... machine # [ 8.260395] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 8.321633] systemd[1]: Mounted FUSE Control File System. machine # [ 8.331082] systemd[1]: Finished Apply Kernel Variables. machine # [ 8.365470] systemd-journald[268]: Received client request to flush runtime journal. machine # [ 8.424328] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. machine # [ 8.433594] systemd[1]: Starting Create Static Device Nodes in /dev... machine # [ 8.437049] systemd[1]: Finished Load/Save OS Random Seed. machine # [ 8.440664] systemd[1]: Reached target First Boot Complete. machine # [ 8.441568] systemd[1]: Finished Flush Journal to Persistent Storage. machine # [ 8.521993] systemd[1]: Finished Create Static Device Nodes in /dev. machine # [ 8.524909] systemd[1]: Reached target Preparation for Local File Systems. machine # [ 8.534863] systemd[1]: Starting Rule-based Manager for Device Events and Files... machine # [ 8.558786] systemd[1]: Mounting /run/wrappers... machine # [ 8.628526] systemd[1]: Mounted /run/wrappers. machine # [ 8.629540] systemd[1]: Reached target Local File Systems. machine # [ 8.634287] systemd[1]: Listening on Boot Loader Control Service Socket. machine # [ 8.644163] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 8.647114] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 8.665828] systemd[1]: Starting Save Transient machine-id to Disk... machine # [ 8.676394] systemd[1]: Starting Create System Files and Directories... machine # [ 8.785231] systemd[1]: etc-machine\x2did.mount: Deactivated successfully. machine # [ 8.794317] systemd[1]: Finished Save Transient machine-id to Disk. machine # [ 8.938634] systemd[1]: Finished Create System Files and Directories. machine # [ 8.956094] systemd[1]: Starting Rebuild Journal Catalog... machine # [ 8.959931] systemd[1]: Starting Record System Boot/Shutdown in UTMP... machine # [ 9.072662] systemd-udevd[309]: Using default interface naming scheme 'v261'. machine # [ 9.091128] systemd[1]: Finished Record System Boot/Shutdown in UTMP. machine # [ 9.154489] systemd[1]: Finished Rebuild Journal Catalog. machine # [ 9.166927] systemd[1]: Starting Update is Completed... machine # [ 9.258448] systemd[1]: Finished Update is Completed. machine # [ 9.300758] systemd[1]: Started Rule-based Manager for Device Events and Files. machine # [ 9.652544] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 9.657099] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 10.159175] systemd[1]: Finished Coldplug All udev Devices. machine # [ 10.160647] systemd[1]: Reached target System Initialization. machine # [ 10.161530] systemd[1]: Started Discard unused filesystem blocks once a week. machine # [ 10.162501] systemd[1]: Started Daily Cleanup of Temporary Directories. machine # [ 10.163485] systemd[1]: Reached target Timer Units. machine # [ 10.171032] systemd[1]: Listening on D-Bus System Message Bus Socket. machine # [ 10.177695] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket. machine # [ 10.183318] systemd[1]: Reached target Socket Units. machine # [ 10.188629] systemd[1]: Reached target Basic System. machine # [ 10.192296] systemd[1]: Starting Import lastlog data into lastlog2 database... machine # [ 10.196939] systemd[1]: Starting Name Service Cache Daemon (nsncd)... machine # [ 10.212940] systemd[1]: Starting Post-Boot Actions... machine # [ 10.245407] systemd[1]: Started Reset console on configuration changes. machine # [ 10.278542] systemd[1]: Starting resolvconf update... machine # [ 10.366587] systemd[1]: Starting D-Bus System Message Bus... machine # [ 10.377775] systemd[1]: Finished Post-Boot Actions. machine # [ 10.387998] nsncd[456]: Sep 10 02:43:22.916 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" machine # [ 10.407510] systemd[1]: Started Name Service Cache Daemon (nsncd). machine # [ 10.417244] systemd[1]: Finished Import lastlog data into lastlog2 database. machine # [ 10.438468] systemd[1]: Reached target Host and Network Name Lookups. machine # [ 10.445982] systemd[1]: Reached target User and Group Name Lookups. machine # [ 10.462168] systemd[1]: Starting User Login Management... machine # [ 10.555684] systemd[1]: Finished Firewall. machine # [ 10.601911] dbus-broker-launch[470]: Looking up NSS user entry for 'systemd-timesync'... machine # [ 10.613274] dbus-broker-launch[470]: NSS returned no entry for 'systemd-timesync' machine # [ 10.618329] dbus-broker-launch[470]: Invalid user-name in /nix/store/xnm1mc93sr4ddyc8s8wj9j9mpjkna1hq-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" machine # [ 10.660713] systemd[1]: Started D-Bus System Message Bus. machine # [ 10.670158] systemd-logind[488]: New seat seat0. machine # [ 10.675198] systemd[1]: Started User Login Management. machine # [ 10.683287] systemd[1]: Starting linger-users.service... machine # [ 10.719965] dbus-broker-launch[470]: Ready machine # [ 10.746132] systemd[1]: Stopped target Host and Network Name Lookups. machine # [ 10.749453] systemd[1]: Stopping Host and Network Name Lookups... machine # [ 10.755456] systemd[1]: Stopped target User and Group Name Lookups. machine # [ 10.758900] systemd[1]: Stopping User and Group Name Lookups... machine # [ 10.762073] systemd[1]: Stopping Name Service Cache Daemon (nsncd)... machine # [ 10.767624] systemd[1]: nscd.service: Deactivated successfully. machine # [ 10.770984] systemd[1]: Stopped Name Service Cache Daemon (nsncd). machine # [ 10.794289] systemd[1]: Starting Name Service Cache Daemon (nsncd)... machine # [ 10.876603] systemd[1]: Created slice Slice /user/1001. machine # [ 10.899529] systemd[1]: Starting User Runtime Directory /run/user/1001... machine # [ 10.936374] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 10.959395] systemd[1]: Finished linger-users.service. machine # [ 10.997732] systemd[1]: Started Name Service Cache Daemon (nsncd). machine # [ 11.012787] nsncd[540]: Sep 10 02:43:23.525 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" machine # [ 11.046557] systemd[1]: Reached target Host and Network Name Lookups. machine # [ 11.062435] systemd[1]: Reached target User and Group Name Lookups. machine # [ 11.082633] systemd[1]: Finished User Runtime Directory /run/user/1001. machine # [ 11.107307] systemd[1]: Starting User Manager for UID 1001... machine # [ 11.128639] input: QEMU Virtio Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:09.0/virtio8/input/input3 machine # [ 11.263990] systemd[1]: Finished resolvconf update. machine # [ 11.280533] systemd[1]: Reached target Preparation for Network. machine # [ 11.296460] systemd[1]: Starting DHCP Client... machine # [ 11.312406] systemd[1]: Starting Extra networking commands.... machine # [ 11.323168] (systemd)[568]: pam_unix(systemd-user:session): session opened for user usertest(uid=1001) by (uid=0) machine # [ 11.363894] systemd-logind[488]: New session '1' of user 'usertest' with class 'manager' and type 'unspecified'. machine # [ 11.421576] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 11.717472] systemd[568]: Queued start job for default target Main User Target. machine # [ 11.766951] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 11.815712] systemd[568]: Created slice User Application Slice. machine # [ 11.850949] systemd[568]: Started Daily Cleanup of User's Temporary Directories. machine # [ 11.886326] systemd[568]: Reached target Paths. machine # [ 11.920321] systemd[568]: Reached target Timers. machine # [ 11.933755] systemd[568]: Starting D-Bus User Message Bus Socket... machine # [ 11.946989] systemd[568]: Starting Create User Files and Directories... machine # [ 11.963888] systemd[1]: Starting Virtual Console Setup... machine # [ 11.982196] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs machine # [ 12.031396] systemd[568]: Finished Create User Files and Directories. machine # [ 12.050825] systemd[568]: Listening on D-Bus User Message Bus Socket. machine # [ 12.056540] systemd[568]: Reached target Sockets. machine # [ 12.062621] systemd[568]: Reached target Basic System. machine # [ 12.064803] systemd[1]: Started User Manager for UID 1001. machine # [ 12.071260] systemd[568]: Starting Run user-specific NixOS activation... machine # [ 12.075547] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. machine # [ 12.080889] systemd[1]: Stopped Virtual Console Setup. machine # [ 12.084522] systemd[1]: Starting Virtual Console Setup... machine # [ 12.090300] systemd[568]: Finished Run user-specific NixOS activation. machine # [ 12.103461] systemd[568]: Reached target Main User Target. machine # [ 12.105273] systemd[568]: Startup finished in 515ms. machine # [ 12.108675] systemd[1]: Condition check resulted in /dev/hvc0 being skipped. machine # [ 12.222178] dhcpcd[595]: dhcpcd-10.3.2 starting machine # [ 12.259583] dhcpcd[647]: dev: loaded udev machine # [ 12.290068] (udev-worker)[650]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.[ 12.320343] 8021q: 802.1Q VLAN Support v1.8 machine # machine # [ 12.353806] (udev-worker)[650]: Network interface NamePolicy= disabled on kernel command line. machine # [ 12.399510] systemd[1]: Finished Extra networking commands.. machine # [ 12.442303] cfg80211: Loading compiled-in X.509 certificates for regulatory database machine # [ 12.437180] systemd[1]: Reached target Network. machine # [ 12.454100] systemd[1]: Starting Permit User Sessions... machine # [ 12.481147] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' machine # [ 12.481713] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600' machine # [ 12.487180] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -2 machine # [ 12.487536] cfg80211: failed to load regulatory.db machine # [ 12.482257] systemd[1]: Condition check resulted in /dev/ttyAMA0 being skipped. machine # [ 12.506514] systemd[1]: Started backdoor.service. machine # [ 12.532439] (udev-worker)[649]: Network interface NamePolicy= disabled on kernel command line. machine # [ 12.562539] systemd[1]: Condition check resulted in Virtio network device being skipped. machine # [ 12.598503] systemd[1]: Starting Address configuration of eth1... machine # [ 12.703620] systemd[1]: Finished Permit User Sessions. machine # [ 12.721484] systemd[1]: Started Getty on tty1. machine # [ 12.738996] systemd[1]: Reached target Login Prompts. machine # [ 12.823356] systemd-logind[488]: Watching system buttons on /dev/input/event0 (gpio-keys) machine # connecting to host... machine # [ 12.927654] mousedev: PS/2 mouse device common for all mice machine # [ 12.954955] 8021q: adding VLAN 0 to HW filter on device eth0 machine # [ 12.944924] dhcpcd[647]: eth0: waiting for carrier machine # [ 12.956317] dhcpcd[647]: eth0: waiting for carrier machine # [ 12.957570] dhcpcd[647]: eth0: carrier acquired machine: Guest shell says: b'Spawning backdoor root shell...\n' machine: connected to guest root shell machine: (connecting took 13.28 seconds) machine: (finished: waiting for the VM to finish booting, in 13.80 seconds) machine # [ 12.988812] 8021q: adding VLAN 0 to HW filter on device eth1 machine # [ 12.988886] dhcpcd[647]: DUID 00:01:00:01:32:34:d5:cd:52:54:00:12:34:56 machine # [ 12.993335] dhcpcd[647]: eth0: IAID 00:12:34:56 machine # [ 12.997902] dhcpcd[647]: eth0: adding address fe80::5054:ff:fe12:3456 machine # [ 13.058541] network-addresses-eth1-start[674]: adding address 192.168.1.1/24... done machine # [ 13.080492] dhcpcd[647]: eth0: soliciting a DHCP lease machine # [ 13.089720] dhcpcd[647]: eth0: offered 10.0.2.15 from 10.0.2.2 machine # [ 13.107875] dhcpcd[647]: eth0: probing address 10.0.2.15/24 machine # [ 13.136453] network-addresses-eth1-start[674]: adding address 2001:db8:1::1/64... done machine # [ 13.162566] systemd-logind[488]: Watching system buttons on /dev/input/event1 (QEMU QEMU USB Keyboard) machine # [ 13.269651] systemd[1]: Finished Address configuration of eth1. machine # [ 13.725622] systemd-vconsole-setup[596]: Configuration of first virtual console was skipped, ignoring remaining ones. machine # [ 13.757250] systemd[1]: Finished Virtual Console Setup. machine # [ 14.332119] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. machine # [ 14.333281] systemd[1]: Stopped Virtual Console Setup. machine # [ 14.334049] systemd[1]: Stopping Virtual Console Setup... machine # [ 14.362999] systemd[1]: Starting Virtual Console Setup... machine # [ 14.384471] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch. machine # [ 14.385933] systemd-logind[488]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard) machine # [ 14.414657] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. machine # [ 14.415829] systemd[1]: Stopped Virtual Console Setup. machine # [ 14.419077] systemd[1]: Starting Virtual Console Setup... machine # [ 14.792158] systemd-vconsole-setup[713]: Configuration of first virtual console was skipped, ignoring remaining ones. machine # [ 14.798406] systemd[1]: Finished Virtual Console Setup. machine # [ 14.915887] dhcpcd[647]: eth0: soliciting an IPv6 router machine # [ 14.919894] dhcpcd[647]: eth0: Router Advertisement from fe80::2 machine # [ 14.922762] dhcpcd[647]: eth0: adding address fec0::5054:ff:fe12:3456/64 machine # [ 14.925828] dhcpcd[647]: eth0: adding route to fec0::/64 machine # [ 14.928524] dhcpcd[647]: eth0: adding default route via fe80::2 machine # [ 18.193132] dhcpcd[647]: eth0: leased 10.0.2.15 for 86400 seconds machine # [ 18.197711] dhcpcd[647]: eth0: adding route to 10.0.2.0/24 machine # [ 18.201505] dhcpcd[647]: eth0: adding default route via 10.0.2.2 machine # [ 18.346627] systemd[1]: Started DHCP Client. machine # [ 18.348773] systemd[1]: Reached target Multi-User System. machine # [ 18.349630] systemd[1]: Startup finished in 1.044s (kernel) + 4.572s (initrd) + 12.731s (userspace) = 18.348s. machine: (finished: waiting for unit multi-user.target, in 19.90 seconds) machine: must succeed: /nix/store/lcxydqrhkhwhva2mijlnq8rxfi36hpwd-stderr-runner /nix/store/h3ab1710ajdhy39vg73h26d6b55bw8cn-nixos-system-machine-test/bin/switch-to-configuration test machine # Checking switch inhibitors... done machine # [ 19.692932] nixos[820]: switching to system configuration /nix/store/h3ab1710ajdhy39vg73h26d6b55bw8cn-nixos-system-machine-test machine # [ 19.695594] systemd[1]: Stopped target Local File Systems. machine # activating the configuration... machine # [ 19.698141] systemd[1]: Stopped target Remote File Systems. machine # setting up /etc... machine # [ 20.137090] systemd[1]: Reload requested from client PID 820 ('.switch-to-conf') (unit backdoor.service)... machine # [ 20.138999] systemd[1]: Reloading... machine # [ 20.706172] systemd[1]: Reloading finished in 564 ms. machine # reloading user units for usertest... machine # [ 20.762545] systemd[568]: Created slice User Core Session Slice. machine # [ 20.766208] systemd[568]: Starting D-Bus User Message Bus... machine # [ 20.829501] dbus-broker-launch[891]: Ignoring duplicate name 'org.freedesktop.import1' in service file '/nix/store/xnm1mc93sr4ddyc8s8wj9j9mpjkna1hq-system-path/share/dbus-1/services/org.freedesktop.import1.service' machine # [ 20.832661] dbus-broker-launch[891]: Ignoring duplicate name 'org.freedesktop.machine1' in service file '/nix/store/xnm1mc93sr4ddyc8s8wj9j9mpjkna1hq-system-path/share/dbus-1/services/org.freedesktop.machine1.service' machine # [ 20.835843] dbus-broker-launch[891]: Ignoring duplicate name 'org.freedesktop.portable1' in service file '/nix/store/xnm1mc93sr4ddyc8s8wj9j9mpjkna1hq-system-path/share/dbus-1/services/org.freedesktop.portable1.service' machine # [ 20.839388] dbus-broker-launch[891]: Ignoring duplicate name 'org.freedesktop.systemd1' in service file '/nix/store/xnm1mc93sr4ddyc8s8wj9j9mpjkna1hq-system-path/share/dbus-1/services/org.freedesktop.systemd1.service' machine # [ 20.843286] dbus-broker-launch[891]: Policy to allow eavesdropping in /etc/dbus-1/session.conf +27: Eavesdropping is deprecated and ignored machine # [ 20.846616] dbus-broker-launch[891]: Policy to allow eavesdropping in /etc/dbus-1/session.conf +29: Eavesdropping is deprecated and ignored machine # [ 20.848733] systemd[568]: Started D-Bus User Message Bus. machine # [ 20.855774] dbus-broker-launch[891]: Ready machine # [ 20.957931] systemd[568]: Reexecution requested from client PID 890 ('switch-to-confi')... machine # [ 20.959326] systemd[568]: Reexecuting. machine # [ 21.024762] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 21.217097] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 21.224806] systemd[568]: Reload requested from client PID 890 ('switch-to-confi')... machine # [ 21.227513] systemd[568]: Reloading... machine # [ 21.430432] systemd[568]: Reloading finished in 200 ms. machine # [ 21.444176] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # restarting the following user units: nixos-activation.service machine # [ 21.455120] systemd[568]: Stopped Run user-specific NixOS activation. machine # [ 21.457611] systemd[568]: Stopping Run user-specific NixOS activation... machine # [ 21.460559] systemd[568]: Starting Run user-specific NixOS activation... machine # [ 21.507874] systemd[568]: Finished Run user-specific NixOS activation. machine # restarting sysinit-reactivation.target machine # [ 21.526366] systemd[1]: Starting Re-setup tmpfiles on a system that is already running.... machine # [ 21.646255] systemd[1]: Finished Re-setup tmpfiles on a system that is already running.. machine # [ 21.647494] systemd[1]: Reached target Reactivate sysinit units. machine # [ 21.653786] systemd[1]: Reached target Local File Systems. machine # [ 21.657553] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 21.659098] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 21.660966] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 21.665376] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 21.666251] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 21.667460] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 21.670971] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 21.684546] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 21.686779] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 21.688190] systemd[1]: Reached target Remote File Systems. machine # [ 22.028887] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 22.032214] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 22.036747] systemd[1]: Starting linger-users.service... machine # [ 22.103347] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 22.106052] systemd[1]: Finished linger-users.service. machine # the following new units were started: sysinit-reactivation.target, systemd-tmpfiles-resetup.service machine # [ 22.364391] nixos[820]: finished switching to system configuration /nix/store/h3ab1710ajdhy39vg73h26d6b55bw8cn-nixos-system-machine-test machine: (finished: must succeed: /nix/store/lcxydqrhkhwhva2mijlnq8rxfi36hpwd-stderr-runner /nix/store/h3ab1710ajdhy39vg73h26d6b55bw8cn-nixos-system-machine-test/bin/switch-to-configuration test, in 3.30 seconds) machine: must succeed: rm /etc/NIXOS machine: (finished: must succeed: rm /etc/NIXOS, in 0.06 seconds) machine: must succeed: /nix/store/lcxydqrhkhwhva2mijlnq8rxfi36hpwd-stderr-runner /nix/store/jvmh9fi9cb76jsqxgb0fng2iga3i36rz-nixos-system-other-test/bin/switch-to-configuration test machine # this should succeed (config: /nix/store/jvmh9fi9cb76jsqxgb0fng2iga3i36rz-nixos-system-other-test, action: test) machine # Checking switch inhibitors... done machine # [ 23.083960] nixos[968]: switching to system configuration /nix/store/jvmh9fi9cb76jsqxgb0fng2iga3i36rz-nixos-system-other-test machine # [ 23.086806] systemd[1]: Stopped target Remote File Systems. machine # activating the configuration... machine # [ 23.089664] systemd[1]: Stopped target Local File Systems. machine # removing user ‘usertest’ machine # setting up /etc... machine # [ 23.598096] systemd[1]: Reload requested from client PID 968 ('.switch-to-conf') (unit backdoor.service)... machine # [ 23.599976] systemd[1]: Reloading... machine # [ 24.278901] systemd[1]: Reloading finished in 676 ms. machine # reloading user units for usertest... machine # [ 24.444502] systemd[568]: Reexecution requested from client PID 1040 ('switch-to-confi')... machine # [ 24.445917] systemd[568]: Reexecuting. machine # [ 24.510252] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 24.711135] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 24.717823] systemd[568]: Reload requested from client PID 1040 ('switch-to-confi')... machine # [ 24.720398] systemd[568]: Reloading... machine # [ 24.903319] systemd[568]: Reloading finished in 181 ms. machine # [ 24.916182] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # restarting the following user units: nixos-activation.service machine # [ 24.927142] systemd[568]: Stopped Run user-specific NixOS activation. machine # [ 24.929582] systemd[568]: Stopping Run user-specific NixOS activation... machine # [ 24.932606] systemd[568]: Starting Run user-specific NixOS activation... machine # [ 24.986270] systemd[568]: Finished Run user-specific NixOS activation. machine # restarting sysinit-reactivation.target machine # [ 24.991675] systemd[1]: Stopped target Reactivate sysinit units. machine # reloading the following units: dbus-broker.service machine # [ 24.994767] systemd[1]: Stopping Reactivate sysinit units... machine # [ 24.995661] systemd[1]: Reached target Reactivate sysinit units. machine # [ 24.999182] systemd[1]: Reloading D-Bus System Message Bus... machine # [ 25.001436] dbus-broker-launch[470]: Caught SIGHUP, trigger reload. machine # [ 25.023460] dbus-broker-launch[470]: Looking up NSS user entry for 'systemd-timesync'... machine # [ 25.025872] dbus-broker-launch[470]: NSS returned no entry for 'systemd-timesync' machine # [ 25.027181] dbus-broker-launch[470]: Invalid user-name in /nix/store/p8lzwq9djsvv4pad8njyi3hknk69n4y5-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" machine # [ 25.064220] systemd[1]: Reloaded D-Bus System Message Bus. machine # restarting the following units: network-addresses-eth1.service machine # [ 25.072433] systemd[1]: Stopping Address configuration of eth1... machine # [ 25.131938] network-addresses-eth1-pre-stop[1052]: deleting address 192.168.1.1/24... done machine # [ 25.144497] network-addresses-eth1-pre-stop[1052]: deleting address 2001:db8:1::1/64... done machine # [ 25.155499] systemd[1]: network-addresses-eth1.service: Deactivated successfully. machine # [ 25.157872] systemd[1]: Stopped Address configuration of eth1. machine # [ 25.163485] systemd[1]: Starting Address configuration of eth1... machine # [ 25.239561] network-addresses-eth1-start[1057]: adding address 192.168.1.2/24... done machine # [ 25.253758] network-addresses-eth1-start[1057]: adding address 2001:db8:1::2/64... done machine # [ 25.271140] systemd[1]: Finished Address configuration of eth1. machine # [ 25.277369] systemd[1]: Reached target Remote File Systems. machine # [ 25.281247] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 25.282642] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 25.287166] systemd[1]: Starting linger-users.service... machine # [ 25.291445] systemd[1]: Reached target Local File Systems. machine # [ 25.301327] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 25.309936] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 25.310918] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 25.320509] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 25.322806] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 25.326274] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 25.327764] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 25.374974] linger-users-start[1071]: id: ‘usertest’: no such user machine # [ 25.378166] linger-users-start[1068]: Removing linger for missing user usertest machine # [ 25.390373] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 25.393540] systemd[1]: Finished linger-users.service. machine # [ 25.759975] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 25.762183] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 26.019954] nixos[968]: finished switching to system configuration /nix/store/jvmh9fi9cb76jsqxgb0fng2iga3i36rz-nixos-system-other-test machine: (finished: must succeed: /nix/store/lcxydqrhkhwhva2mijlnq8rxfi36hpwd-stderr-runner /nix/store/jvmh9fi9cb76jsqxgb0fng2iga3i36rz-nixos-system-other-test/bin/switch-to-configuration test, in 3.60 seconds) subtest: services machine: must succeed: /nix/store/h3ab1710ajdhy39vg73h26d6b55bw8cn-nixos-system-machine-test/bin/switch-to-configuration test 2>&1 machine # [ 26.659294] nixos[1136]: switching to system configuration /nix/store/h3ab1710ajdhy39vg73h26d6b55bw8cn-nixos-system-machine-test machine # [ 26.663027] systemd[1]: Stopped target Local File Systems. machine # [ 26.664631] systemd[1]: Stopped target Remote File Systems. machine # [ 27.154890] systemd[1]: Reload requested from client PID 1136 ('.switch-to-conf') (unit backdoor.service)... machine # [ 27.157288] systemd[1]: Reloading... machine # [ 27.705601] systemd[1]: Reloading finished in 545 ms. machine # [ 27.844959] systemd[568]: Reexecution requested from client PID 1205 ('switch-to-confi')... machine # [ 27.848709] systemd[568]: Reexecuting. machine # [ 27.898657] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 28.095376] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 28.103582] systemd[568]: Reload requested from client PID 1205 ('switch-to-confi')... machine # [ 28.106402] systemd[568]: Reloading... machine # [ 28.308436] systemd[568]: Reloading finished in 200 ms. machine # [ 28.324236] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 28.334042] systemd[568]: Stopped Run user-specific NixOS activation. machine # [ 28.336649] systemd[568]: Stopping Run user-specific NixOS activation... machine # [ 28.339998] systemd[568]: Starting Run user-specific NixOS activation... machine # [ 28.389010] systemd[568]: Finished Run user-specific NixOS activation. machine # [ 28.393710] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 28.397848] systemd[1]: Stopping Reactivate sysinit units... machine # [ 28.399633] systemd[1]: Reached target Reactivate sysinit units. machine # [ 28.401461] systemd[1]: Reloading D-Bus System Message Bus... machine # [ 28.403526] dbus-broker-launch[470]: Caught SIGHUP, trigger reload. machine # [ 28.422185] dbus-broker-launch[470]: Looking up NSS user entry for 'systemd-timesync'... machine # [ 28.424565] dbus-broker-launch[470]: NSS returned no entry for 'systemd-timesync' machine # [ 28.425722] dbus-broker-launch[470]: Invalid user-name in /nix/store/xnm1mc93sr4ddyc8s8wj9j9mpjkna1hq-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" machine # [ 28.449748] systemd[1]: Reloaded D-Bus System Message Bus. machine # [ 28.456774] systemd[1]: Stopping Address configuration of eth1... machine # [ 28.512969] network-addresses-eth1-pre-stop[1217]: deleting address 192.168.1.2/24... done machine # [ 28.525105] network-addresses-eth1-pre-stop[1217]: deleting address 2001:db8:1::2/64... done machine # [ 28.535853] systemd[1]: network-addresses-eth1.service: Deactivated successfully. machine # [ 28.538185] systemd[1]: Stopped Address configuration of eth1. machine # [ 28.543564] systemd[1]: Starting Address configuration of eth1... machine # [ 28.615624] network-addresses-eth1-start[1222]: adding address 192.168.1.1/24... done machine # [ 28.627809] network-addresses-eth1-start[1222]: adding address 2001:db8:1::1/64... done machine # [ 28.643773] systemd[1]: Finished Address configuration of eth1. machine # [ 28.646793] systemd[1]: Reached target Local File Systems. machine # [ 28.651033] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 28.658528] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 28.659502] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 28.664410] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 28.669848] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 28.676721] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 28.677997] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 28.679154] systemd[1]: Reached target Remote File Systems. machine # [ 28.679995] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 28.685643] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 29.026813] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 29.031640] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 29.035242] systemd[1]: Starting linger-users.service... machine # [ 29.086580] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 29.089390] systemd[1]: Finished linger-users.service. machine # [ 29.346455] nixos[1136]: finished switching to system configuration /nix/store/h3ab1710ajdhy39vg73h26d6b55bw8cn-nixos-system-machine-test machine: (finished: must succeed: /nix/store/h3ab1710ajdhy39vg73h26d6b55bw8cn-nixos-system-machine-test/bin/switch-to-configuration test 2>&1, in 3.32 seconds) machine: must succeed: /nix/store/h3ab1710ajdhy39vg73h26d6b55bw8cn-nixos-system-machine-test/bin/switch-to-configuration test 2>&1 machine # [ 29.957324] nixos[1292]: switching to system configuration /nix/store/h3ab1710ajdhy39vg73h26d6b55bw8cn-nixos-system-machine-test machine # [ 29.959921] systemd[1]: Stopped target Local File Systems. machine # [ 29.962281] systemd[1]: Stopped target Remote File Systems. machine # [ 30.419907] systemd[1]: Reload requested from client PID 1292 ('.switch-to-conf') (unit backdoor.service)... machine # [ 30.422133] systemd[1]: Reloading... machine # [ 31.022613] systemd[1]: Reloading finished in 598 ms. machine # [ 31.148817] systemd[568]: Reexecution requested from client PID 1361 ('switch-to-confi')... machine # [ 31.151415] systemd[568]: Reexecuting. machine # [ 31.206803] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 31.402328] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 31.409664] systemd[568]: Reload requested from client PID 1361 ('switch-to-confi')... machine # [ 31.412004] systemd[568]: Reloading... machine # [ 31.607817] systemd[568]: Reloading finished in 194 ms. machine # [ 31.620165] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 31.630570] systemd[568]: Stopped Run user-specific NixOS activation. machine # [ 31.632935] systemd[568]: Stopping Run user-specific NixOS activation... machine # [ 31.635971] systemd[568]: Starting Run user-specific NixOS activation... machine # [ 31.682343] systemd[568]: Finished Run user-specific NixOS activation. machine # [ 31.686938] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 31.689832] systemd[1]: Stopping Reactivate sysinit units... machine # [ 31.690693] systemd[1]: Reached target Reactivate sysinit units. machine # [ 31.693132] systemd[1]: Reached target Local File Systems. machine # [ 31.699831] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 31.702667] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 31.706507] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 31.711405] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 31.714523] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 31.716708] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 31.719382] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 31.721613] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 31.724172] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 31.725394] systemd[1]: Reached target Remote File Systems. machine # [ 32.062223] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 32.066679] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 32.069635] systemd[1]: Starting linger-users.service... machine # [ 32.134289] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 32.136957] systemd[1]: Finished linger-users.service. machine # [ 32.395889] nixos[1292]: finished switching to system configuration /nix/store/h3ab1710ajdhy39vg73h26d6b55bw8cn-nixos-system-machine-test machine: (finished: must succeed: /nix/store/h3ab1710ajdhy39vg73h26d6b55bw8cn-nixos-system-machine-test/bin/switch-to-configuration test 2>&1, in 3.05 seconds) machine: must succeed: /nix/store/h3ab1710ajdhy39vg73h26d6b55bw8cn-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration test 2>&1 machine # [ 33.090395] nixos[1432]: switching to system configuration /nix/store/y47xyp417kjfg7ki2xlx2c0ykkip8yls-nixos-system-machine-test machine # [ 33.093867] systemd[1]: Stopped target Local File Systems. machine # [ 33.095311] systemd[1]: Stopped target Remote File Systems. machine # [ 33.621424] systemd[1]: Reload requested from client PID 1432 ('.switch-to-conf') (unit backdoor.service)... machine # [ 33.623443] systemd[1]: Reloading... machine # [ 34.307692] systemd[1]: Reloading finished in 681 ms. machine # [ 34.455276] systemd[568]: Reexecution requested from client PID 1502 ('switch-to-confi')... machine # [ 34.458843] systemd[568]: Reexecuting. machine # [ 34.522347] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 34.722611] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 34.729418] systemd[568]: Reload requested from client PID 1502 ('switch-to-confi')... machine # [ 34.732060] systemd[568]: Reloading... machine # [ 34.929714] systemd[568]: Reloading finished in 196 ms. machine # [ 34.944180] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 34.955310] systemd[568]: Stopped Run user-specific NixOS activation. machine # [ 34.956376] systemd[568]: Stopping Run user-specific NixOS activation... machine # [ 34.959333] systemd[568]: Starting Run user-specific NixOS activation... machine # [ 35.006502] systemd[568]: Finished Run user-specific NixOS activation. machine # [ 35.010723] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 35.013285] systemd[1]: Stopping Reactivate sysinit units... machine # [ 35.014553] systemd[1]: Reached target Reactivate sysinit units. machine # [ 35.018431] systemd[1]: Reached target Remote File Systems. machine # [ 35.022261] systemd[1]: Starting linger-users.service... machine # [ 35.024949] systemd[1]: Starting test.service... machine # [ 35.028983] systemd[1]: Reached target Local File Systems. machine # [ 35.043439] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 35.050096] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 35.051045] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 35.060591] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 35.062855] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 35.068445] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 35.071210] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 35.074508] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 35.077185] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 35.107658] systemd[1]: Finished test.service. machine # [ 35.142260] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 35.145446] systemd[1]: Finished linger-users.service. machine # [ 35.425629] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 35.428793] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 35.686124] nixos[1432]: finished switching to system configuration /nix/store/y47xyp417kjfg7ki2xlx2c0ykkip8yls-nixos-system-machine-test machine: (finished: must succeed: /nix/store/h3ab1710ajdhy39vg73h26d6b55bw8cn-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration test 2>&1, in 3.29 seconds) machine: must succeed: /nix/store/h3ab1710ajdhy39vg73h26d6b55bw8cn-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration test 2>&1 machine # [ 36.344770] nixos[1575]: switching to system configuration /nix/store/y47xyp417kjfg7ki2xlx2c0ykkip8yls-nixos-system-machine-test machine # [ 36.347333] systemd[1]: Stopped target Local File Systems. machine # [ 36.349763] systemd[1]: Stopped target Remote File Systems. machine # [ 36.817538] systemd[1]: Reload requested from client PID 1575 ('.switch-to-conf') (unit backdoor.service)... machine # [ 36.819527] systemd[1]: Reloading... machine # [ 37.410202] systemd[1]: Reloading finished in 587 ms. machine # [ 37.563175] systemd[568]: Reexecution requested from client PID 1645 ('switch-to-confi')... machine # [ 37.567035] systemd[568]: Reexecuting. machine # [ 37.621934] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 37.815544] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 37.822418] systemd[568]: Reload requested from client PID 1645 ('switch-to-confi')... machine # [ 37.824533] systemd[568]: Reloading... machine # [ 38.020485] systemd[568]: Reloading finished in 194 ms. machine # [ 38.036199] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 38.046573] systemd[568]: Stopped Run user-specific NixOS activation. machine # [ 38.048952] systemd[568]: Stopping Run user-specific NixOS activation... machine # [ 38.051844] systemd[568]: Starting Run user-specific NixOS activation... machine # [ 38.100297] systemd[568]: Finished Run user-specific NixOS activation. machine # [ 38.104804] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 38.106038] systemd[1]: Stopping Reactivate sysinit units... machine # [ 38.106844] systemd[1]: Reached target Reactivate sysinit units. machine # [ 38.109578] systemd[1]: Reached target Local File Systems. machine # [ 38.112388] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 38.113782] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 38.116531] systemd[1]: Reached target Remote File Systems. machine # [ 38.121334] systemd[1]: Starting linger-users.service... machine # [ 38.134427] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 38.145433] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 38.146332] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 38.147585] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 38.150503] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 38.152945] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 38.154667] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 38.218153] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 38.221070] systemd[1]: Finished linger-users.service. machine # [ 38.508673] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 38.511853] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 38.772644] nixos[1575]: finished switching to system configuration /nix/store/y47xyp417kjfg7ki2xlx2c0ykkip8yls-nixos-system-machine-test machine: (finished: must succeed: /nix/store/h3ab1710ajdhy39vg73h26d6b55bw8cn-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration test 2>&1, in 3.08 seconds) machine: must succeed: /nix/store/h3ab1710ajdhy39vg73h26d6b55bw8cn-nixos-system-machine-test/specialisation/simpleServiceDifferentDescription/bin/switch-to-configuration test 2>&1 machine # [ 39.438662] nixos[1716]: switching to system configuration /nix/store/4avxsmb7hf1700rgsbx5jis6i96v75ls-nixos-system-machine-test machine # [ 39.442138] systemd[1]: Stopped target Local File Systems. machine # [ 39.443542] systemd[1]: Stopped target Remote File Systems. machine # [ 39.962989] systemd[1]: Reload requested from client PID 1716 ('.switch-to-conf') (unit backdoor.service)... machine # [ 39.965325] systemd[1]: Reloading... machine # [ 40.635021] systemd[1]: Reloading finished in 667 ms. machine # [ 40.788281] systemd[568]: Reexecution requested from client PID 1786 ('switch-to-confi')... machine # [ 40.789738] systemd[568]: Reexecuting. machine # [ 40.850391] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 41.048307] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 41.054931] systemd[568]: Reload requested from client PID 1786 ('switch-to-confi')... machine # [ 41.057278] systemd[568]: Reloading... machine # [ 41.255165] systemd[568]: Reloading finished in 196 ms. machine # [ 41.268165] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 41.277777] systemd[568]: Stopped Run user-specific NixOS activation. machine # [ 41.280258] systemd[568]: Stopping Run user-specific NixOS activation... machine # [ 41.283348] systemd[568]: Starting Run user-specific NixOS activation... machine # [ 41.331046] systemd[568]: Finished Run user-specific NixOS activation. machine # [ 41.335256] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 41.337071] systemd[1]: Stopping Reactivate sysinit units... machine # [ 41.337911] systemd[1]: Reached target Reactivate sysinit units. machine # [ 41.344466] systemd[1]: Reached target Local File Systems. machine # [ 41.347714] systemd[1]: Reached target Remote File Systems. machine # [ 41.352902] systemd[1]: Starting linger-users.service... machine # [ 41.357062] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 41.361784] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 41.362678] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 41.363964] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 41.380557] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 41.382225] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 41.383932] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 41.385475] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 41.386764] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 41.451827] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 41.455097] systemd[1]: Finished linger-users.service. machine # [ 41.742711] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 41.746244] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 42.003903] nixos[1716]: finished switching to system configuration /nix/store/4avxsmb7hf1700rgsbx5jis6i96v75ls-nixos-system-machine-test machine: (finished: must succeed: /nix/store/h3ab1710ajdhy39vg73h26d6b55bw8cn-nixos-system-machine-test/specialisation/simpleServiceDifferentDescription/bin/switch-to-configuration test 2>&1, in 3.23 seconds) machine: must succeed: /nix/store/h3ab1710ajdhy39vg73h26d6b55bw8cn-nixos-system-machine-test/specialisation/simpleServiceModified/bin/switch-to-configuration test 2>&1 machine # [ 42.750942] nixos[1857]: switching to system configuration /nix/store/h41y01brq9fznwfarzqgvy4la59r4wvz-nixos-system-machine-test machine # [ 42.755375] systemd[1]: Stopped target Local File Systems. machine # [ 42.757146] systemd[1]: Stopped target Remote File Systems. machine # [ 42.758021] systemd[1]: test.service: Deactivated successfully. machine # [ 42.758899] systemd[1]: Stopped Test unit. machine # [ 43.349482] systemd[1]: Reload requested from client PID 1857 ('.switch-to-conf') (unit backdoor.service)... machine # [ 43.351597] systemd[1]: Reloading... machine # [ 44.074219] systemd[1]: Reloading finished in 719 ms. machine # [ 44.226145] systemd[568]: Reexecution requested from client PID 1927 ('switch-to-confi')... machine # [ 44.230713] systemd[568]: Reexecuting. machine # [ 44.290551] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 44.497601] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 44.505195] systemd[568]: Reload requested from client PID 1927 ('switch-to-confi')... machine # [ 44.507837] systemd[568]: Reloading... machine # [ 44.710043] systemd[568]: Reloading finished in 200 ms. machine # [ 44.724195] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 44.735227] systemd[568]: Stopped Run user-specific NixOS activation. machine # [ 44.737743] systemd[568]: Stopping Run user-specific NixOS activation... machine # [ 44.740662] systemd[568]: Starting Run user-specific NixOS activation... machine # [ 44.790765] systemd[568]: Finished Run user-specific NixOS activation. machine # [ 44.795428] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 44.797352] systemd[1]: Stopping Reactivate sysinit units... machine # [ 44.798250] systemd[1]: Reached target Reactivate sysinit units. machine # [ 44.801889] systemd[1]: Reached target Local File Systems. machine # [ 44.804403] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 44.807412] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 44.810448] systemd[1]: Reached target Remote File Systems. machine # [ 44.816341] systemd[1]: Starting linger-users.service... machine # [ 44.820374] systemd[1]: Starting test.service... machine # [ 44.826832] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 44.842112] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 44.843127] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 44.846090] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 44.853451] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 44.860196] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 44.862739] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 44.896120] systemd[1]: Finished test.service. machine # [ 44.937261] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 44.940922] systemd[1]: Finished linger-users.service. machine # [ 45.250386] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 45.254193] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 45.517043] nixos[1857]: finished switching to system configuration /nix/store/h41y01brq9fznwfarzqgvy4la59r4wvz-nixos-system-machine-test machine: (finished: must succeed: /nix/store/h3ab1710ajdhy39vg73h26d6b55bw8cn-nixos-system-machine-test/specialisation/simpleServiceModified/bin/switch-to-configuration test 2>&1, in 3.51 seconds) machine: must succeed: /nix/store/h3ab1710ajdhy39vg73h26d6b55bw8cn-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1 machine # [ 46.267684] nixos[2000]: switching to system configuration /nix/store/sy8hxgrvfiqk47qgx7djail29s6czzmc-nixos-system-machine-test machine # [ 46.271404] systemd[1]: Stopped target Local File Systems. machine # [ 46.272771] systemd[1]: Stopped target Remote File Systems. machine # [ 46.823194] systemd[1]: Reload requested from client PID 2000 ('.switch-to-conf') (unit backdoor.service)... machine # [ 46.825831] systemd[1]: Reloading... machine # [ 47.515702] systemd[1]: Reloading finished in 687 ms. machine # [ 47.662630] systemd[568]: Reexecution requested from client PID 2070 ('switch-to-confi')... machine # [ 47.666467] systemd[568]: Reexecuting. machine # [ 47.729671] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 47.924933] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 47.931948] systemd[568]: Reload requested from client PID 2070 ('switch-to-confi')... machine # [ 47.934359] systemd[568]: Reloading... machine # [ 48.130637] systemd[568]: Reloading finished in 195 ms. machine # [ 48.144161] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 48.155591] systemd[568]: Stopped Run user-specific NixOS activation. machine # [ 48.156752] systemd[568]: Stopping Run user-specific NixOS activation... machine # [ 48.159740] systemd[568]: Starting Run user-specific NixOS activation... machine # [ 48.206246] systemd[568]: Finished Run user-specific NixOS activation. machine # [ 48.210422] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 48.212412] systemd[1]: Stopping Reactivate sysinit units... machine # [ 48.213788] systemd[1]: Reached target Reactivate sysinit units. machine # [ 48.216520] systemd[1]: test.service: Deactivated successfully. machine # [ 48.217391] systemd[1]: Stopped test.service. machine # [ 48.218047] systemd[1]: Stopping test.service... machine # [ 48.221620] systemd[1]: Starting test.service... machine # [ 48.260191] systemd[1]: Finished test.service. machine # [ 48.264598] systemd[1]: Reached target Remote File Systems. machine # [ 48.273127] systemd[1]: Starting linger-users.service... machine # [ 48.280996] systemd[1]: Reached target Local File Systems. machine # [ 48.285572] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 48.290565] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 48.293852] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 48.295157] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 48.297909] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 48.300730] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 48.302479] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 48.307967] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 48.309855] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 48.372089] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 48.374533] systemd[1]: Finished linger-users.service. machine # [ 48.647780] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 48.651071] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 48.910213] nixos[2000]: finished switching to system configuration /nix/store/sy8hxgrvfiqk47qgx7djail29s6czzmc-nixos-system-machine-test machine: (finished: must succeed: /nix/store/h3ab1710ajdhy39vg73h26d6b55bw8cn-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1, in 3.39 seconds) machine: must succeed: /nix/store/h3ab1710ajdhy39vg73h26d6b55bw8cn-nixos-system-machine-test/specialisation/simpleServiceReload/bin/switch-to-configuration test 2>&1 machine # [ 49.562997] nixos[2143]: switching to system configuration /nix/store/s3s7d755h96spvzz4a3h8a3iq9yxr592-nixos-system-machine-test machine # [ 49.566450] systemd[1]: Stopped target Local File Systems. machine # [ 49.567950] systemd[1]: Stopped target Remote File Systems. machine # [ 50.080348] systemd[1]: Reload requested from client PID 2143 ('.switch-to-conf') (unit backdoor.service)... machine # [ 50.082386] systemd[1]: Reloading... machine # [ 50.740155] systemd[1]: Reloading finished in 655 ms. machine # [ 50.891725] systemd[568]: Reexecution requested from client PID 2212 ('switch-to-confi')... machine # [ 50.895545] systemd[568]: Reexecuting. machine # [ 50.942032] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 51.139162] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 51.146738] systemd[568]: Reload requested from client PID 2212 ('switch-to-confi')... machine # [ 51.151136] systemd[568]: Reloading... machine # [ 51.355546] systemd[568]: Reloading finished in 205 ms. machine # [ 51.368198] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 51.378030] systemd[568]: Stopped Run user-specific NixOS activation. machine # [ 51.380817] systemd[568]: Stopping Run user-specific NixOS activation... machine # [ 51.384091] systemd[568]: Starting Run user-specific NixOS activation... machine # [ 51.439913] systemd[568]: Finished Run user-specific NixOS activation. machine # [ 51.445318] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 51.450205] systemd[1]: Stopping Reactivate sysinit units... machine # [ 51.451721] systemd[1]: Reached target Reactivate sysinit units. machine # [ 51.454570] systemd[1]: Reloading test.service... machine # [ 51.495339] systemd[1]: Reloaded test.service. machine # [ 51.501346] systemd[1]: Reached target Local File Systems. machine # [ 51.504967] systemd[1]: Reached target Remote File Systems. machine # [ 51.505955] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 51.511651] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 51.515119] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 51.519021] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 51.523563] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 51.533402] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 51.534778] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 51.535972] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 51.538830] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 51.917744] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 51.922571] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 51.926190] systemd[1]: Starting linger-users.service... machine # [ 51.994736] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 51.997542] systemd[1]: Finished linger-users.service. machine # [ 52.254879] nixos[2143]: finished switching to system configuration /nix/store/s3s7d755h96spvzz4a3h8a3iq9yxr592-nixos-system-machine-test machine: (finished: must succeed: /nix/store/h3ab1710ajdhy39vg73h26d6b55bw8cn-nixos-system-machine-test/specialisation/simpleServiceReload/bin/switch-to-configuration test 2>&1, in 3.35 seconds) machine: must succeed: /nix/store/h3ab1710ajdhy39vg73h26d6b55bw8cn-nixos-system-machine-test/specialisation/simpleServiceNorestart/bin/switch-to-configuration test 2>&1 machine # [ 52.941122] nixos[2285]: switching to system configuration /nix/store/3jfg0smvqi56d9mlm5kp5lqjd9jkhbym-nixos-system-machine-test machine # [ 52.944710] systemd[1]: Stopped target Local File Systems. machine # [ 52.946142] systemd[1]: Stopped target Remote File Systems. machine # [ 53.510173] systemd[1]: Reload requested from client PID 2285 ('.switch-to-conf') (unit backdoor.service)... machine # [ 53.512389] systemd[1]: Reloading... machine # [ 54.217632] systemd[1]: Reloading finished in 702 ms. machine # [ 54.366798] systemd[568]: Reexecution requested from client PID 2354 ('switch-to-confi')... machine # [ 54.370572] systemd[568]: Reexecuting. machine # [ 54.426521] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 54.636640] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 54.644788] systemd[568]: Reload requested from client PID 2354 ('switch-to-confi')... machine # [ 54.647414] systemd[568]: Reloading... machine # [ 54.840089] systemd[568]: Reloading finished in 191 ms. machine # [ 54.856212] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 54.865944] systemd[568]: Stopped Run user-specific NixOS activation. machine # [ 54.868459] systemd[568]: Stopping Run user-specific NixOS activation... machine # [ 54.871421] systemd[568]: Starting Run user-specific NixOS activation... machine # [ 54.917650] systemd[568]: Finished Run user-specific NixOS activation. machine # [ 54.921859] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 54.924691] systemd[1]: Stopping Reactivate sysinit units... machine # [ 54.925593] systemd[1]: Reached target Reactivate sysinit units. machine # [ 54.926447] systemd[1]: Reached target Local File Systems. machine # [ 54.929501] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 54.930853] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 54.934924] systemd[1]: Reached target Remote File Systems. machine # [ 54.941547] systemd[1]: Starting linger-users.service... machine # [ 54.952979] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 54.958259] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 54.961546] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 54.963196] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 54.966192] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 54.972479] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 54.973911] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 55.043314] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 55.046513] systemd[1]: Finished linger-users.service. machine # [ 55.331711] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 55.335313] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 55.594973] nixos[2285]: finished switching to system configuration /nix/store/3jfg0smvqi56d9mlm5kp5lqjd9jkhbym-nixos-system-machine-test machine: (finished: must succeed: /nix/store/h3ab1710ajdhy39vg73h26d6b55bw8cn-nixos-system-machine-test/specialisation/simpleServiceNorestart/bin/switch-to-configuration test 2>&1, in 3.34 seconds) machine: must succeed: /nix/store/h3ab1710ajdhy39vg73h26d6b55bw8cn-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration dry-activate 2>&1 machine: (finished: must succeed: /nix/store/h3ab1710ajdhy39vg73h26d6b55bw8cn-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration dry-activate 2>&1, in 0.68 seconds) machine: must succeed: /nix/store/h3ab1710ajdhy39vg73h26d6b55bw8cn-nixos-system-machine-test/bin/switch-to-configuration test 2>&1 machine # [ 56.841806] nixos[2435]: switching to system configuration /nix/store/h3ab1710ajdhy39vg73h26d6b55bw8cn-nixos-system-machine-test machine # [ 56.846260] systemd[1]: Stopped target Local File Systems. machine # [ 56.848964] systemd[1]: Stopped target Remote File Systems. machine # [ 56.849947] systemd[1]: test.service: Deactivated successfully. machine # [ 56.851095] systemd[1]: Stopped test.service. machine # [ 57.327696] systemd[1]: Reload requested from client PID 2435 ('.switch-to-conf') (unit backdoor.service)... machine # [ 57.329934] systemd[1]: Reloading... machine # [ 57.955708] systemd[1]: Reloading finished in 623 ms. machine # [ 58.101352] systemd[568]: Reexecution requested from client PID 2504 ('switch-to-confi')... machine # [ 58.105465] systemd[568]: Reexecuting. machine # [ 58.166714] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 58.354697] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 58.361992] systemd[568]: Reload requested from client PID 2504 ('switch-to-confi')... machine # [ 58.364640] systemd[568]: Reloading... machine # [ 58.554997] systemd[568]: Reloading finished in 189 ms. machine # [ 58.568192] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 58.579818] systemd[568]: Stopped Run user-specific NixOS activation. machine # [ 58.580967] systemd[568]: Stopping Run user-specific NixOS activation... machine # [ 58.584096] systemd[568]: Starting Run user-specific NixOS activation... machine # [ 58.631119] systemd[568]: Finished Run user-specific NixOS activation. machine # [ 58.635305] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 58.637022] systemd[1]: Stopping Reactivate sysinit units... machine # [ 58.637832] systemd[1]: Reached target Reactivate sysinit units. machine # [ 58.640953] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 58.648113] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 58.649627] systemd[1]: Reached target Local File Systems. machine # [ 58.654298] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 58.655849] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 58.661372] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 58.668475] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 58.670695] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 58.674149] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 58.675512] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 58.677116] systemd[1]: Reached target Remote File Systems. machine # [ 58.982468] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 58.987296] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 58.990191] systemd[1]: Starting linger-users.service... machine # [ 59.047935] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 59.050617] systemd[1]: Finished linger-users.service. machine # [ 59.308967] nixos[2435]: finished switching to system configuration /nix/store/h3ab1710ajdhy39vg73h26d6b55bw8cn-nixos-system-machine-test machine: (finished: must succeed: /nix/store/h3ab1710ajdhy39vg73h26d6b55bw8cn-nixos-system-machine-test/bin/switch-to-configuration test 2>&1, in 3.03 seconds) machine: must succeed: /nix/store/ayc5px57xq772f2dv6r4hiy0sb639k53-separate-activation-script/bin/switch-to-configuration test 2>&1 machine # [ 59.910131] nixos[2575]: switching to system configuration /nix/store/qsxypb7jvl3mlv3lal22m599zfr5dblz-nixos-system-machine-test machine # [ 59.912665] systemd[1]: Stopped target Local File Systems. machine # [ 59.914916] systemd[1]: Stopped target Remote File Systems. machine # [ 60.398289] systemd[1]: Reload requested from client PID 2575 ('.switch-to-conf') (unit backdoor.service)... machine # [ 60.400592] systemd[1]: Reloading... machine # [ 61.014328] systemd[1]: Reloading finished in 611 ms. machine # [ 61.178514] systemd[568]: Stopped Run user-specific NixOS activation. machine # [ 61.182637] systemd[568]: Reexecution requested from client PID 2644 ('switch-to-confi')... machine # [ 61.185456] systemd[568]: Reexecuting. machine # [ 61.256791] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 61.461258] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 61.468112] systemd[568]: Reload requested from client PID 2644 ('switch-to-confi')... machine # [ 61.469436] systemd[568]: Reloading... machine # [ 61.659946] systemd[568]: Reloading finished in 188 ms. machine # [ 61.672450] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 61.685742] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 61.686759] systemd[1]: Stopping Reactivate sysinit units... machine # [ 61.687617] systemd[1]: Reached target Reactivate sysinit units. machine # [ 61.692300] systemd[1]: Reached target Remote File Systems. machine # [ 61.698456] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 61.701967] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 61.710795] systemd[1]: Starting linger-users.service... machine # [ 61.717263] systemd[1]: Starting test.service... machine # [ 61.718119] systemd[1]: Reached target Local File Systems. machine # [ 61.718958] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 61.732818] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 61.736352] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 61.737778] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 61.739968] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 61.748294] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 61.749667] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 61.797952] systemd[1]: Finished test.service. machine # [ 61.837047] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 61.841017] systemd[1]: Finished linger-users.service. machine # [ 62.145641] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 62.149370] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 62.408598] nixos[2575]: finished switching to system configuration /nix/store/qsxypb7jvl3mlv3lal22m599zfr5dblz-nixos-system-machine-test machine: (finished: must succeed: /nix/store/ayc5px57xq772f2dv6r4hiy0sb639k53-separate-activation-script/bin/switch-to-configuration test 2>&1, in 3.10 seconds) machine: must succeed: ! test -e /run/current-system/activate machine: (finished: must succeed: ! test -e /run/current-system/activate, in 0.04 seconds) machine: must succeed: ! test -e /run/current-system/dry-activate machine: (finished: must succeed: ! test -e /run/current-system/dry-activate, in 0.03 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.03 seconds) machine: must succeed: /nix/store/h3ab1710ajdhy39vg73h26d6b55bw8cn-nixos-system-machine-test/specialisation/unitWithMultilineValue/bin/switch-to-configuration test 2>&1 machine # [ 63.107419] nixos[2723]: switching to system configuration /nix/store/gcnhch032qxmvsh57hlxjs5d9i1xzq2f-nixos-system-machine-test machine # [ 63.111658] systemd[1]: Stopped target Local File Systems. machine # [ 63.113573] systemd[1]: Stopped target Remote File Systems. machine # [ 63.114406] systemd[1]: test.service: Deactivated successfully. machine # [ 63.115258] systemd[1]: Stopped test.service. machine # [ 63.616166] systemd[1]: Reload requested from client PID 2723 ('.switch-to-conf') (unit backdoor.service)... machine # [ 63.618224] systemd[1]: Reloading... machine # [ 64.318591] systemd[1]: Reloading finished in 697 ms. machine # [ 64.469182] systemd[568]: Reexecution requested from client PID 2791 ('switch-to-confi')... machine # [ 64.473273] systemd[568]: Reexecuting. machine # [ 64.518307] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 64.719890] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 64.728256] systemd[568]: Reload requested from client PID 2791 ('switch-to-confi')... machine # [ 64.729641] systemd[568]: Reloading... machine # [ 64.929465] systemd[568]: Reloading finished in 198 ms. machine # [ 64.944209] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 64.956643] systemd[568]: Starting Run user-specific NixOS activation... machine # [ 65.003077] systemd[568]: Finished Run user-specific NixOS activation. machine # [ 65.008184] systemd[568]: Stopped Run user-specific NixOS activation. machine # [ 65.009472] systemd[568]: Stopping Run user-specific NixOS activation... machine # [ 65.013100] systemd[568]: Starting Run user-specific NixOS activation... machine # [ 65.015521] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 65.020368] systemd[1]: Stopping Reactivate sysinit units... machine # [ 65.021203] systemd[1]: Reached target Reactivate sysinit units. machine # [ 65.026788] systemd[1]: Reached target Local File Systems. machine # [ 65.027671] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 65.034805] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 65.035769] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 65.042059] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 65.049184] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 65.059897] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 65.066172] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 65.067542] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 65.074168] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 65.075542] systemd[1]: Reached target Remote File Systems. machine # [ 65.095923] systemd[568]: Finished Run user-specific NixOS activation. machine # [ 65.421167] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 65.424246] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 65.431317] systemd[1]: Starting linger-users.service... machine # [ 65.435093] systemd[1]: Started test.service. machine # [ 65.486353] systemd[1]: test.service: Deactivated successfully. machine # [ 65.519696] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 65.523115] systemd[1]: Finished linger-users.service. machine # [ 65.782234] nixos[2723]: finished switching to system configuration /nix/store/gcnhch032qxmvsh57hlxjs5d9i1xzq2f-nixos-system-machine-test machine: (finished: must succeed: /nix/store/h3ab1710ajdhy39vg73h26d6b55bw8cn-nixos-system-machine-test/specialisation/unitWithMultilineValue/bin/switch-to-configuration test 2>&1, in 3.28 seconds) machine: must succeed: /nix/store/h3ab1710ajdhy39vg73h26d6b55bw8cn-nixos-system-machine-test/specialisation/unitWithBackslash/bin/switch-to-configuration test 2>&1 machine # [ 66.411019] nixos[2868]: switching to system configuration /nix/store/1qcamijn8xbh0m15nsxsx06rswpmq0yr-nixos-system-machine-test machine # [ 66.414755] systemd[1]: Stopped target Remote File Systems. machine # [ 66.416187] systemd[1]: Stopped target Local File Systems. machine # [ 66.945905] systemd[1]: Reload requested from client PID 2868 ('.switch-to-conf') (unit backdoor.service)... machine # [ 66.947988] systemd[1]: Reloading... machine # [ 67.644084] systemd[1]: Reloading finished in 693 ms. machine # [ 67.783644] systemd[568]: Reexecution requested from client PID 2937 ('switch-to-confi')... machine # [ 67.787899] systemd[568]: Reexecuting. machine # [ 67.834877] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 68.027119] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 68.034221] systemd[568]: Reload requested from client PID 2937 ('switch-to-confi')... machine # [ 68.036766] systemd[568]: Reloading... machine # [ 68.218549] systemd[568]: Reloading finished in 180 ms. machine # [ 68.232185] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 68.241577] systemd[568]: Stopped Run user-specific NixOS activation. machine # [ 68.244072] systemd[568]: Stopping Run user-specific NixOS activation... machine # [ 68.247158] systemd[568]: Starting Run user-specific NixOS activation... machine # [ 68.296572] systemd[568]: Finished Run user-specific NixOS activation. machine # [ 68.301516] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 68.303604] systemd[1]: Stopping Reactivate sysinit units... machine # [ 68.306941] systemd[1]: Reached target Reactivate sysinit units. machine # [ 68.307798] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 68.309528] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 68.314483] systemd[1]: Reached target Remote File Systems. machine # [ 68.317567] systemd[1]: Reached target Local File Systems. machine # [ 68.320627] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 68.326312] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 68.327265] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 68.329993] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 68.336424] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 68.340238] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 68.344224] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 68.673296] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 68.678046] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 68.682012] systemd[1]: Starting escaped\x2ddash.service... machine # [ 68.685170] systemd[1]: Starting linger-users.service... machine # [ 68.732914] systemd[1]: Finished escaped\x2ddash.service. machine # [ 68.760298] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 68.762960] systemd[1]: Finished linger-users.service. machine # [ 69.023890] nixos[2868]: finished switching to system configuration /nix/store/1qcamijn8xbh0m15nsxsx06rswpmq0yr-nixos-system-machine-test machine: (finished: must succeed: /nix/store/h3ab1710ajdhy39vg73h26d6b55bw8cn-nixos-system-machine-test/specialisation/unitWithBackslash/bin/switch-to-configuration test 2>&1, in 3.24 seconds) machine: must succeed: /nix/store/h3ab1710ajdhy39vg73h26d6b55bw8cn-nixos-system-machine-test/specialisation/unitWithBackslashModified/bin/switch-to-configuration test 2>&1 machine # [ 69.696882] nixos[3010]: switching to system configuration /nix/store/73dpqcvk31dkkk9sab9fz7p30m8qda7k-nixos-system-machine-test machine # [ 69.700844] systemd[1]: Stopped target Local File Systems. machine # [ 69.702624] systemd[1]: Stopped target Remote File Systems. machine # [ 69.703528] systemd[1]: escaped\x2ddash.service: Deactivated successfully. machine # [ 69.705207] systemd[1]: Stopped escaped\x2ddash.service. machine # [ 70.223838] systemd[1]: Reload requested from client PID 3010 ('.switch-to-conf') (unit backdoor.service)... machine # [ 70.226196] systemd[1]: Reloading... machine # [ 70.864518] systemd[1]: Reloading finished in 636 ms. machine # [ 70.999611] systemd[568]: Reexecution requested from client PID 3079 ('switch-to-confi')... machine # [ 71.003488] systemd[568]: Reexecuting. machine # [ 71.075003] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 71.276878] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 71.283283] systemd[568]: Reload requested from client PID 3079 ('switch-to-confi')... machine # [ 71.285649] systemd[568]: Reloading... machine # [ 71.477139] systemd[568]: Reloading finished in 190 ms. machine # [ 71.492187] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 71.502017] systemd[568]: Stopped Run user-specific NixOS activation. machine # [ 71.504429] systemd[568]: Stopping Run user-specific NixOS activation... machine # [ 71.507359] systemd[568]: Starting Run user-specific NixOS activation... machine # [ 71.555003] systemd[568]: Finished Run user-specific NixOS activation. machine # [ 71.559161] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 71.561688] systemd[1]: Stopping Reactivate sysinit units... machine # [ 71.562561] systemd[1]: Reached target Reactivate sysinit units. machine # [ 71.565823] systemd[1]: Reached target Remote File Systems. machine # [ 71.572092] systemd[1]: Starting escaped\x2ddash.service... machine # [ 71.575250] systemd[1]: Starting linger-users.service... machine # [ 71.582137] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 71.588850] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 71.595067] systemd[1]: Reached target Local File Systems. machine # [ 71.600055] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 71.606185] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 71.607173] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 71.612740] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 71.620853] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 71.625738] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 71.627081] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 71.656423] systemd[1]: Finished escaped\x2ddash.service. machine # [ 71.691374] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 71.693920] systemd[1]: Finished linger-users.service. machine # [ 71.958256] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 71.961714] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 72.218880] nixos[3010]: finished switching to system configuration /nix/store/73dpqcvk31dkkk9sab9fz7p30m8qda7k-nixos-system-machine-test machine: (finished: must succeed: /nix/store/h3ab1710ajdhy39vg73h26d6b55bw8cn-nixos-system-machine-test/specialisation/unitWithBackslashModified/bin/switch-to-configuration test 2>&1, in 3.20 seconds) machine: must succeed: /nix/store/h3ab1710ajdhy39vg73h26d6b55bw8cn-nixos-system-machine-test/specialisation/unitStartingWithDash/bin/switch-to-configuration test 2>&1 machine # [ 72.892561] nixos[3152]: switching to system configuration /nix/store/xifjljckiv20fi9p53706ri2kihq6zg3-nixos-system-machine-test machine # [ 72.896302] systemd[1]: Stopped target Local File Systems. machine # [ 72.898147] systemd[1]: Stopped target Remote File Systems. machine # [ 72.899048] systemd[1]: escaped\x2ddash.service: Deactivated successfully. machine # [ 72.900698] systemd[1]: Stopped escaped\x2ddash.service. machine # [ 73.424502] systemd[1]: Reload requested from client PID 3152 ('.switch-to-conf') (unit backdoor.service)... machine # [ 73.426511] systemd[1]: Reloading... machine # [ 74.073849] systemd[1]: Reloading finished in 645 ms. machine # [ 74.228276] systemd[568]: Reexecution requested from client PID 3221 ('switch-to-confi')... machine # [ 74.229720] systemd[568]: Reexecuting. machine # [ 74.297840] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 74.498376] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 74.505465] systemd[568]: Reload requested from client PID 3221 ('switch-to-confi')... machine # [ 74.508136] systemd[568]: Reloading... machine # [ 74.708205] systemd[568]: Reloading finished in 198 ms. machine # [ 74.724217] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 74.733980] systemd[568]: Stopped Run user-specific NixOS activation. machine # [ 74.736523] systemd[568]: Stopping Run user-specific NixOS activation... machine # [ 74.739732] systemd[568]: Starting Run user-specific NixOS activation... machine # [ 74.787990] systemd[568]: Finished Run user-specific NixOS activation. machine # [ 74.792833] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 74.794817] systemd[1]: Stopping Reactivate sysinit units... machine # [ 74.796854] systemd[1]: Reached target Reactivate sysinit units. machine # [ 74.800308] systemd[1]: Reached target Local File Systems. machine # [ 74.801211] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 74.807606] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 74.810557] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 74.811860] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 74.823398] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 74.829346] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 74.832238] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 74.833498] systemd[1]: Reached target Remote File Systems. machine # [ 74.834291] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 74.835560] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 75.160227] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 75.164672] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 75.170036] systemd[1]: Starting -.service... machine # [ 75.172940] systemd[1]: Starting linger-users.service... machine # [ 75.221132] systemd[1]: Finished -.service. machine # [ 75.249065] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 75.250112] systemd[1]: Finished linger-users.service. machine # [ 75.510522] nixos[3152]: finished switching to system configuration /nix/store/xifjljckiv20fi9p53706ri2kihq6zg3-nixos-system-machine-test machine: (finished: must succeed: /nix/store/h3ab1710ajdhy39vg73h26d6b55bw8cn-nixos-system-machine-test/specialisation/unitStartingWithDash/bin/switch-to-configuration test 2>&1, in 3.29 seconds) machine: must succeed: /nix/store/h3ab1710ajdhy39vg73h26d6b55bw8cn-nixos-system-machine-test/specialisation/unitStartingWithDashModified/bin/switch-to-configuration test 2>&1 machine # [ 76.126198] nixos[3294]: switching to system configuration /nix/store/wn9x2xnbi04xysag6wp49sw58gkzrchr-nixos-system-machine-test machine # [ 76.129361] systemd[1]: Stopped target Remote File Systems. machine # [ 76.131712] systemd[1]: Stopped target Local File Systems. machine # [ 76.641800] systemd[1]: Reload requested from client PID 3294 ('.switch-to-conf') (unit backdoor.service)... machine # [ 76.643854] systemd[1]: Reloading... machine # [ 77.259083] systemd[1]: Reloading finished in 612 ms. machine # [ 77.405324] systemd[568]: Reexecution requested from client PID 3363 ('switch-to-confi')... machine # [ 77.409646] systemd[568]: Reexecuting. machine # [ 77.453409] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 77.635173] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 77.642631] systemd[568]: Reload requested from client PID 3363 ('switch-to-confi')... machine # [ 77.644657] systemd[568]: Reloading... machine # [ 77.834505] systemd[568]: Reloading finished in 188 ms. machine # [ 77.848373] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 77.859288] systemd[568]: Stopped Run user-specific NixOS activation. machine # [ 77.860517] systemd[568]: Stopping Run user-specific NixOS activation... machine # [ 77.863649] systemd[568]: Starting Run user-specific NixOS activation... machine # [ 77.912914] systemd[568]: Finished Run user-specific NixOS activation. machine # [ 77.917413] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 77.922095] systemd[1]: Stopping Reactivate sysinit units... machine # [ 77.923167] systemd[1]: Reached target Reactivate sysinit units. machine # [ 77.926065] systemd[1]: Reloading -.service... machine # [ 77.965732] systemd[1]: Reloaded -.service. machine # [ 77.972285] systemd[1]: Reached target Local File Systems. machine # [ 77.975850] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 77.980634] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 77.981574] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 77.982830] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 77.998182] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 78.002603] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 78.003998] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 78.005362] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 78.006667] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 78.007939] systemd[1]: Reached target Remote File Systems. machine # [ 78.341333] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 78.345465] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 78.350044] systemd[1]: Starting linger-users.service... machine # [ 78.416761] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 78.419448] systemd[1]: Finished linger-users.service. machine # [ 78.678023] nixos[3294]: finished switching to system configuration /nix/store/wn9x2xnbi04xysag6wp49sw58gkzrchr-nixos-system-machine-test machine: (finished: must succeed: /nix/store/h3ab1710ajdhy39vg73h26d6b55bw8cn-nixos-system-machine-test/specialisation/unitStartingWithDashModified/bin/switch-to-configuration test 2>&1, in 3.17 seconds) machine: must succeed: /nix/store/h3ab1710ajdhy39vg73h26d6b55bw8cn-nixos-system-machine-test/specialisation/unitWithRequirement/bin/switch-to-configuration test 2>&1 machine # [ 79.279963] nixos[3436]: switching to system configuration /nix/store/hfpi6ngaiwdf60xhqg2klirsfapirp0i-nixos-system-machine-test machine # [ 79.282651] systemd[1]: -.service: Deactivated successfully. machine # [ 79.286197] systemd[1]: Stopped -.service. machine # [ 79.287047] systemd[1]: Stopped target Remote File Systems. machine # [ 79.288131] systemd[1]: Stopped target Local File Systems. machine # [ 79.811617] systemd[1]: Reload requested from client PID 3436 ('.switch-to-conf') (unit backdoor.service)... machine # [ 79.813839] systemd[1]: Reloading... machine # [ 80.455091] systemd[1]: Reloading finished in 639 ms. machine # [ 80.612411] systemd[568]: Reexecution requested from client PID 3505 ('switch-to-confi')... machine # [ 80.613889] systemd[568]: Reexecuting. machine # [ 80.673807] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 80.872066] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 80.880216] systemd[568]: Reload requested from client PID 3505 ('switch-to-confi')... machine # [ 80.881618] systemd[568]: Reloading... machine # [ 81.075186] systemd[568]: Reloading finished in 191 ms. machine # [ 81.088185] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 81.098993] systemd[568]: Stopped Run user-specific NixOS activation. machine # [ 81.101516] systemd[568]: Stopping Run user-specific NixOS activation... machine # [ 81.104535] systemd[568]: Starting Run user-specific NixOS activation... machine # [ 81.156115] systemd[568]: Finished Run user-specific NixOS activation. machine # [ 81.161016] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 81.163808] systemd[1]: Stopping Reactivate sysinit units... machine # [ 81.165815] systemd[1]: Reached target Reactivate sysinit units. machine # [ 81.167583] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 81.170351] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 81.175248] systemd[1]: Reached target Local File Systems. machine # [ 81.179122] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 81.185158] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 81.189094] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 81.190440] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 81.197399] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 81.201631] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 81.203233] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 81.206385] systemd[1]: Reached target Remote File Systems. machine # [ 81.542155] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 81.547106] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 81.551295] systemd[1]: Starting linger-users.service... machine # [ 81.555561] systemd[1]: Starting required-service.service... machine # [ 81.561766] systemd[1]: Starting test-service.service... machine # [ 81.620971] systemd[1]: Finished required-service.service. machine # [ 81.623946] systemd[1]: Finished test-service.service. machine # [ 81.653511] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 81.656798] systemd[1]: Finished linger-users.service. machine # [ 81.916883] nixos[3436]: finished switching to system configuration /nix/store/hfpi6ngaiwdf60xhqg2klirsfapirp0i-nixos-system-machine-test machine: (finished: must succeed: /nix/store/h3ab1710ajdhy39vg73h26d6b55bw8cn-nixos-system-machine-test/specialisation/unitWithRequirement/bin/switch-to-configuration test 2>&1, in 3.24 seconds) machine: must succeed: /nix/store/h3ab1710ajdhy39vg73h26d6b55bw8cn-nixos-system-machine-test/specialisation/unitWithRequirementModified/bin/switch-to-configuration test 2>&1 machine # [ 82.573618] nixos[3580]: switching to system configuration /nix/store/y6vl2jh0y7a3bhdqyld4b2pgg511lmfx-nixos-system-machine-test machine # [ 82.578205] systemd[1]: Stopped target Local File Systems. machine # [ 82.581510] systemd[1]: Stopped target Remote File Systems. machine # [ 82.582566] systemd[1]: required-service.service: Deactivated successfully. machine # [ 82.583783] systemd[1]: Stopped required-service.service. machine # [ 82.585039] systemd[1]: test-service.service: Deactivated successfully. machine # [ 82.586203] systemd[1]: Stopped test-service.service. machine # [ 83.120637] systemd[1]: Reload requested from client PID 3580 ('.switch-to-conf') (unit backdoor.service)... machine # [ 83.122721] systemd[1]: Reloading... machine # [ 83.766947] systemd[1]: Reloading finished in 641 ms. machine # [ 83.913756] systemd[568]: Reexecution requested from client PID 3649 ('switch-to-confi')... machine # [ 83.915262] systemd[568]: Reexecuting. machine # [ 83.970335] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 84.170977] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 84.177885] systemd[568]: Reload requested from client PID 3649 ('switch-to-confi')... machine # [ 84.180705] systemd[568]: Reloading... machine # [ 84.381617] systemd[568]: Reloading finished in 199 ms. machine # [ 84.396185] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 84.406762] systemd[568]: Stopped Run user-specific NixOS activation. machine # [ 84.409419] systemd[568]: Stopping Run user-specific NixOS activation... machine # [ 84.412651] systemd[568]: Starting Run user-specific NixOS activation... machine # [ 84.466728] systemd[568]: Finished Run user-specific NixOS activation. machine # [ 84.471586] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 84.473831] systemd[1]: Stopping Reactivate sysinit units... machine # [ 84.475046] systemd[1]: Reached target Reactivate sysinit units. machine # [ 84.480849] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 84.484434] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 84.490002] systemd[1]: Reached target Remote File Systems. machine # [ 84.496278] systemd[1]: Starting linger-users.service... machine # [ 84.501890] systemd[1]: Starting required-service.service... machine # [ 84.505812] systemd[1]: Starting test-service.service... machine # [ 84.524811] systemd[1]: Reached target Local File Systems. machine # [ 84.533981] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 84.539248] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 84.543735] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 84.546207] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 84.558069] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 84.559936] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 84.565382] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 84.604599] systemd[1]: Finished required-service.service. machine # [ 84.608760] systemd[1]: Finished test-service.service. machine # [ 84.649149] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 84.652618] systemd[1]: Finished linger-users.service. machine # [ 84.950947] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 84.954448] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 85.212757] nixos[3580]: finished switching to system configuration /nix/store/y6vl2jh0y7a3bhdqyld4b2pgg511lmfx-nixos-system-machine-test machine: (finished: must succeed: /nix/store/h3ab1710ajdhy39vg73h26d6b55bw8cn-nixos-system-machine-test/specialisation/unitWithRequirementModified/bin/switch-to-configuration test 2>&1, in 3.30 seconds) machine: must succeed: /nix/store/h3ab1710ajdhy39vg73h26d6b55bw8cn-nixos-system-machine-test/specialisation/unitWithRequirementModifiedNostart/bin/switch-to-configuration test 2>&1 machine # [ 85.927093] nixos[3724]: switching to system configuration /nix/store/sxd7cvjv6lqlvzmxfinw9mc0q5lvp6i8-nixos-system-machine-test machine # [ 85.931199] systemd[1]: Stopped target Local File Systems. machine # [ 85.933449] systemd[1]: Stopped target Remote File Systems. machine # [ 85.934312] systemd[1]: required-service.service: Deactivated successfully. machine # [ 85.935294] systemd[1]: Stopped required-service.service. machine # [ 85.936900] systemd[1]: test-service.service: Deactivated successfully. machine # [ 85.938052] systemd[1]: Stopped test-service.service. machine # [ 86.475261] systemd[1]: Reload requested from client PID 3724 ('.switch-to-conf') (unit backdoor.service)... machine # [ 86.477588] systemd[1]: Reloading... machine # [ 87.186807] systemd[1]: Reloading finished in 706 ms. machine # [ 87.359953] systemd[568]: Reexecution requested from client PID 3793 ('switch-to-confi')... machine # [ 87.363954] systemd[568]: Reexecuting. machine # [ 87.414802] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 87.636393] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 87.643224] systemd[568]: Reload requested from client PID 3793 ('switch-to-confi')... machine # [ 87.646225] systemd[568]: Reloading... machine # [ 87.876731] systemd[568]: Reloading finished in 229 ms. machine # [ 87.892403] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 87.904126] systemd[568]: Stopped Run user-specific NixOS activation. machine # [ 87.905259] systemd[568]: Stopping Run user-specific NixOS activation... machine # [ 87.908847] systemd[568]: Starting Run user-specific NixOS activation... machine # [ 87.968968] systemd[568]: Finished Run user-specific NixOS activation. machine # [ 87.974609] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 87.978074] systemd[1]: Stopping Reactivate sysinit units... machine # [ 87.980423] systemd[1]: Reached target Reactivate sysinit units. machine # [ 87.984335] systemd[1]: Reached target Remote File Systems. machine # [ 87.988278] systemd[1]: Starting linger-users.service... machine # [ 87.994390] systemd[1]: Starting required-service.service... machine # [ 88.002150] systemd[1]: Starting test-service.service... machine # [ 88.021611] systemd[1]: Reached target Local File Systems. machine # [ 88.022680] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 88.035440] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 88.044694] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 88.053308] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 88.061248] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 88.078865] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 88.083658] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 88.087358] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 88.095448] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 88.102947] systemd[1]: Finished test-service.service. machine # [ 88.103754] systemd[1]: Finished required-service.service. machine # [ 88.148161] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 88.151314] systemd[1]: Finished linger-users.service. machine # [ 88.519957] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 88.522006] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 88.784220] nixos[3724]: finished switching to system configuration /nix/store/sxd7cvjv6lqlvzmxfinw9mc0q5lvp6i8-nixos-system-machine-test machine: (finished: must succeed: /nix/store/h3ab1710ajdhy39vg73h26d6b55bw8cn-nixos-system-machine-test/specialisation/unitWithRequirementModifiedNostart/bin/switch-to-configuration test 2>&1, in 3.57 seconds) machine: must succeed: /nix/store/h3ab1710ajdhy39vg73h26d6b55bw8cn-nixos-system-machine-test/specialisation/unitWithTemplate/bin/switch-to-configuration test 2>&1 machine # [ 89.472979] nixos[3868]: switching to system configuration /nix/store/jc7nw69vnxpwlwkp201chcafd5injsdg-nixos-system-machine-test machine # [ 89.477859] systemd[1]: Stopped target Local File Systems. machine # [ 89.481045] systemd[1]: Stopped target Remote File Systems. machine # [ 89.482257] systemd[1]: required-service.service: Deactivated successfully. machine # [ 89.483499] systemd[1]: Stopped required-service.service. machine # [ 89.484638] systemd[1]: test-service.service: Deactivated successfully. machine # [ 89.485872] systemd[1]: Stopped test-service.service. machine # [ 90.059406] systemd[1]: Reload requested from client PID 3868 ('.switch-to-conf') (unit backdoor.service)... machine # [ 90.061840] systemd[1]: Reloading... machine # [ 90.784569] systemd[1]: Reloading finished in 720 ms. machine # [ 90.939835] systemd[568]: Reexecution requested from client PID 3937 ('switch-to-confi')... machine # [ 90.943768] systemd[568]: Reexecuting. machine # [ 91.010889] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 91.226909] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 91.234134] systemd[568]: Reload requested from client PID 3937 ('switch-to-confi')... machine # [ 91.236759] systemd[568]: Reloading... machine # [ 91.441601] systemd[568]: Reloading finished in 203 ms. machine # [ 91.456267] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 91.467453] systemd[568]: Stopped Run user-specific NixOS activation. machine # [ 91.468710] systemd[568]: Stopping Run user-specific NixOS activation... machine # [ 91.472142] systemd[568]: Starting Run user-specific NixOS activation... machine # [ 91.527045] systemd[568]: Finished Run user-specific NixOS activation. machine # [ 91.531797] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 91.534048] systemd[1]: Stopping Reactivate sysinit units... machine # [ 91.534934] systemd[1]: Reached target Reactivate sysinit units. machine # [ 91.536780] systemd[1]: Reached target Local File Systems. machine # [ 91.538431] systemd[1]: Reached target Remote File Systems. machine # [ 91.542800] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 91.545891] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 91.550498] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 91.555965] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 91.557367] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 91.564384] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 91.573697] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 91.577242] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 91.578648] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 91.579873] systemd[1]: Created slice Slice /system/instantiated. machine # [ 91.943587] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 91.948786] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 91.952579] systemd[1]: Starting instantiated@one.service... machine # [ 91.957936] systemd[1]: Starting instantiated@two.service... machine # [ 91.961151] systemd[1]: Starting linger-users.service... machine # [ 92.016939] systemd[1]: Finished instantiated@one.service. machine # [ 92.020961] systemd[1]: Finished instantiated@two.service. machine # [ 92.053410] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 92.054524] systemd[1]: Finished linger-users.service. machine # [ 92.312633] nixos[3868]: finished switching to system configuration /nix/store/jc7nw69vnxpwlwkp201chcafd5injsdg-nixos-system-machine-test machine: (finished: must succeed: /nix/store/h3ab1710ajdhy39vg73h26d6b55bw8cn-nixos-system-machine-test/specialisation/unitWithTemplate/bin/switch-to-configuration test 2>&1, in 3.53 seconds) machine: must succeed: /nix/store/h3ab1710ajdhy39vg73h26d6b55bw8cn-nixos-system-machine-test/specialisation/unitWithTemplateModified/bin/switch-to-configuration test 2>&1 machine # [ 93.042164] nixos[4012]: switching to system configuration /nix/store/rpkw30nblk6w511b2n60pr7jy0byqn9q-nixos-system-machine-test machine # [ 93.047004] systemd[1]: Stopped target Local File Systems. machine # [ 93.050215] systemd[1]: Stopped target Remote File Systems. machine # [ 93.051409] systemd[1]: instantiated@one.service: Deactivated successfully. machine # [ 93.052697] systemd[1]: Stopped instantiated@one.service. machine # [ 93.053802] systemd[1]: instantiated@two.service: Deactivated successfully. machine # [ 93.054986] systemd[1]: Stopped instantiated@two.service. machine # [ 93.605842] systemd[1]: Reload requested from client PID 4012 ('.switch-to-conf') (unit backdoor.service)... machine # [ 93.607892] systemd[1]: Reloading... machine # [ 94.358157] systemd[1]: Reloading finished in 747 ms. machine # [ 94.531218] systemd[568]: Reexecution requested from client PID 4081 ('switch-to-confi')... machine # [ 94.533603] systemd[568]: Reexecuting. machine # [ 94.611263] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 94.828399] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 94.836169] systemd[568]: Reload requested from client PID 4081 ('switch-to-confi')... machine # [ 94.837592] systemd[568]: Reloading... machine # [ 95.049113] systemd[568]: Reloading finished in 208 ms. machine # [ 95.066191] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 95.075663] systemd[568]: Stopped Run user-specific NixOS activation. machine # [ 95.078755] systemd[568]: Stopping Run user-specific NixOS activation... machine # [ 95.082695] systemd[568]: Starting Run user-specific NixOS activation... machine # [ 95.143057] systemd[568]: Finished Run user-specific NixOS activation. machine # [ 95.147969] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 95.149339] systemd[1]: Stopping Reactivate sysinit units... machine # [ 95.151994] systemd[1]: Reached target Reactivate sysinit units. machine # [ 95.159268] systemd[1]: Starting instantiated@one.service... machine # [ 95.162166] systemd[1]: Reached target Local File Systems. machine # [ 95.167223] systemd[1]: Reached target Remote File Systems. machine # [ 95.172638] systemd[1]: Starting instantiated@two.service... machine # [ 95.176379] systemd[1]: Starting linger-users.service... machine # [ 95.187368] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 95.192899] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 95.208397] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 95.209949] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 95.210793] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 95.212000] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 95.223421] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 95.226980] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 95.231865] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 95.271778] systemd[1]: Finished instantiated@one.service. machine # [ 95.274649] systemd[1]: Finished instantiated@two.service. machine # [ 95.310673] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 95.314332] systemd[1]: Finished linger-users.service. machine # [ 95.610433] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 95.614021] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 95.870950] nixos[4012]: finished switching to system configuration /nix/store/rpkw30nblk6w511b2n60pr7jy0byqn9q-nixos-system-machine-test machine: (finished: must succeed: /nix/store/h3ab1710ajdhy39vg73h26d6b55bw8cn-nixos-system-machine-test/specialisation/unitWithTemplateModified/bin/switch-to-configuration test 2>&1, in 3.56 seconds) (finished: subtest: services, in 69.85 seconds) subtest: failing units machine: must succeed: /nix/store/h3ab1710ajdhy39vg73h26d6b55bw8cn-nixos-system-machine-test/specialisation/simpleServiceModified/bin/switch-to-configuration test 2>&1 machine # [ 96.544416] nixos[4156]: switching to system configuration /nix/store/h41y01brq9fznwfarzqgvy4la59r4wvz-nixos-system-machine-test machine # [ 96.546859] systemd[1]: instantiated@one.service: Deactivated successfully. machine # [ 96.549071] systemd[1]: Stopped instantiated@one.service. machine # [ 96.550666] systemd[1]: instantiated@two.service: Deactivated successfully. machine # [ 96.551666] systemd[1]: Stopped instantiated@two.service. machine # [ 96.553656] systemd[1]: Stopped target Remote File Systems. machine # [ 96.555185] systemd[1]: Stopped target Local File Systems. machine # [ 97.010202] systemd[1]: Reload requested from client PID 4156 ('.switch-to-conf') (unit backdoor.service)... machine # [ 97.012269] systemd[1]: Reloading... machine # [ 97.602652] systemd[1]: Reloading finished in 588 ms. machine # [ 97.753956] systemd[568]: Reexecution requested from client PID 4225 ('switch-to-confi')... machine # [ 97.758732] systemd[568]: Reexecuting. machine # [ 97.810802] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 98.011514] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 98.018359] systemd[568]: Reload requested from client PID 4225 ('switch-to-confi')... machine # [ 98.020874] systemd[568]: Reloading... machine # [ 98.230727] systemd[568]: Reloading finished in 208 ms. machine # [ 98.248198] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 98.258079] systemd[568]: Stopped Run user-specific NixOS activation. machine # [ 98.260845] systemd[568]: Stopping Run user-specific NixOS activation... machine # [ 98.265074] systemd[568]: Starting Run user-specific NixOS activation... machine # [ 98.316931] systemd[568]: Finished Run user-specific NixOS activation. machine # [ 98.321636] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 98.324587] systemd[1]: Stopping Reactivate sysinit units... machine # [ 98.325686] systemd[1]: Reached target Reactivate sysinit units. machine # [ 98.327859] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 98.330073] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 98.333086] systemd[1]: Reached target Local File Systems. machine # [ 98.336939] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 98.341788] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 98.342708] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 98.343920] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 98.347643] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 98.350314] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 98.353967] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 98.363850] systemd[1]: Reached target Remote File Systems. machine # [ 98.699491] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 98.704329] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 98.707900] systemd[1]: Starting linger-users.service... machine # [ 98.711221] systemd[1]: Starting test.service... machine # [ 98.761004] systemd[1]: Finished test.service. machine # [ 98.789711] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 98.792824] systemd[1]: Finished linger-users.service. machine # [ 99.051567] nixos[4156]: finished switching to system configuration /nix/store/h41y01brq9fznwfarzqgvy4la59r4wvz-nixos-system-machine-test machine: (finished: must succeed: /nix/store/h3ab1710ajdhy39vg73h26d6b55bw8cn-nixos-system-machine-test/specialisation/simpleServiceModified/bin/switch-to-configuration test 2>&1, in 3.18 seconds) machine: must fail: /nix/store/h3ab1710ajdhy39vg73h26d6b55bw8cn-nixos-system-machine-test/specialisation/simpleServiceFailing/bin/switch-to-configuration test 2>&1 machine # [ 99.726716] nixos[4298]: switching to system configuration /nix/store/08yxhqk630y09sv7qpsg03vdifdrm77q-nixos-system-machine-test machine # [ 99.729812] systemd[1]: test.service: Deactivated successfully. machine # [ 99.730936] systemd[1]: Stopped test.service. machine # [ 99.731764] systemd[1]: Stopped target Remote File Systems. machine # [ 99.735408] systemd[1]: Stopped target Local File Systems. machine # [ 100.334260] systemd[1]: Reload requested from client PID 4298 ('.switch-to-conf') (unit backdoor.service)... machine # [ 100.336421] systemd[1]: Reloading... machine # [ 101.032085] systemd[1]: Reloading finished in 692 ms. machine # [ 101.181382] systemd[568]: Reexecution requested from client PID 4367 ('switch-to-confi')... machine # [ 101.185806] systemd[568]: Reexecuting. machine # [ 101.234559] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 101.436193] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 101.443836] systemd[568]: Reload requested from client PID 4367 ('switch-to-confi')... machine # [ 101.446127] systemd[568]: Reloading... machine # [ 101.645238] systemd[568]: Reloading finished in 197 ms. machine # [ 101.660167] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 101.669306] systemd[568]: Stopped Run user-specific NixOS activation. machine # [ 101.671639] systemd[568]: Stopping Run user-specific NixOS activation... machine # [ 101.674594] systemd[568]: Starting Run user-specific NixOS activation... machine # [ 101.722256] systemd[568]: Finished Run user-specific NixOS activation. machine # [ 101.726509] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 101.729242] systemd[1]: Stopping Reactivate sysinit units... machine # [ 101.732576] systemd[1]: Reached target Reactivate sysinit units. machine # [ 101.736704] systemd[1]: Starting test.service... machine # [ 101.737490] systemd[1]: Reached target Remote File Systems. machine # [ 101.740545] systemd[1]: Reached target Local File Systems. machine # [ 101.749177] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 101.750598] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 101.763843] systemd[1]: Starting linger-users.service... machine # [ 101.770967] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 101.776098] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 101.777040] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 101.778271] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 101.790431] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 101.794349] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 101.795783] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 101.823164] systemd[1]: test.service: Main process exited, code=exited, status=1/FAILURE machine # [ 101.827023] systemd[1]: test.service: Failed with result 'exit-code'. machine # [ 101.830413] systemd[1]: Failed to start test.service. machine # [ 101.873124] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 101.876894] systemd[1]: Finished linger-users.service. machine # [ 102.165072] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 102.168396] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 102.497602] nixos[4298]: switching to system configuration /nix/store/08yxhqk630y09sv7qpsg03vdifdrm77q-nixos-system-machine-test failed (status 4) machine: (finished: must fail: /nix/store/h3ab1710ajdhy39vg73h26d6b55bw8cn-nixos-system-machine-test/specialisation/simpleServiceFailing/bin/switch-to-configuration test 2>&1, in 3.44 seconds) machine: must succeed: /nix/store/h3ab1710ajdhy39vg73h26d6b55bw8cn-nixos-system-machine-test/specialisation/autorestartService/bin/switch-to-configuration test 2>&1 machine # [ 103.134002] nixos[4441]: switching to system configuration /nix/store/9ah78j4gbgznwlssrccxgafcnv9f1d6c-nixos-system-machine-test machine # [ 103.137150] systemd[1]: Stopped target Local File Systems. machine # [ 103.138601] systemd[1]: Stopped target Remote File Systems. machine # [ 103.647044] systemd[1]: Reload requested from client PID 4441 ('.switch-to-conf') (unit backdoor.service)... machine # [ 103.649064] systemd[1]: Reloading... machine # [ 104.333979] systemd[1]: Reloading finished in 681 ms. machine # [ 104.489486] systemd[568]: Reexecution requested from client PID 4510 ('switch-to-confi')... machine # [ 104.493780] systemd[568]: Reexecuting. machine # [ 104.546121] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 104.748201] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 104.754832] systemd[568]: Reload requested from client PID 4510 ('switch-to-confi')... machine # [ 104.757572] systemd[568]: Reloading... machine # [ 104.960268] systemd[568]: Reloading finished in 202 ms. machine # [ 104.976181] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 104.985621] systemd[568]: Stopped Run user-specific NixOS activation. machine # [ 104.987993] systemd[568]: Stopping Run user-specific NixOS activation... machine # [ 104.991094] systemd[568]: Starting Run user-specific NixOS activation... machine # [ 105.040545] systemd[568]: Finished Run user-specific NixOS activation. machine # [ 105.045005] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 105.047450] systemd[1]: Stopping Reactivate sysinit units... machine # [ 105.049685] systemd[1]: Reached target Reactivate sysinit units. machine # [ 105.052313] systemd[1]: Reached target Remote File Systems. machine # [ 105.057709] systemd[1]: Started autorestart.service. machine # [ 105.060427] systemd[1]: Starting linger-users.service... machine # [ 105.079548] systemd[1]: Reached target Local File Systems. machine # [ 105.085132] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 105.091228] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 105.096963] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 105.098477] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 105.099283] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 105.100803] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 105.103530] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 105.106653] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 105.108443] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 105.137654] systemd[1]: autorestart.service: Deactivated successfully. machine # [ 105.175056] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 105.177756] systemd[1]: Finished linger-users.service. machine # [ 105.494528] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 105.497623] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 105.758394] nixos[4441]: finished switching to system configuration /nix/store/9ah78j4gbgznwlssrccxgafcnv9f1d6c-nixos-system-machine-test machine: (finished: must succeed: /nix/store/h3ab1710ajdhy39vg73h26d6b55bw8cn-nixos-system-machine-test/specialisation/autorestartService/bin/switch-to-configuration test 2>&1, in 3.26 seconds) machine # [ 105.844583] systemd[1]: Stopped autorestart.service. machine: must succeed: /nix/store/h3ab1710ajdhy39vg73h26d6b55bw8cn-nixos-system-machine-test/specialisation/autorestartService/bin/switch-to-configuration test 2>&1 machine # [ 106.457044] nixos[4588]: switching to system configuration /nix/store/9ah78j4gbgznwlssrccxgafcnv9f1d6c-nixos-system-machine-test machine # [ 106.459672] systemd[1]: Stopped target Remote File Systems. machine # [ 106.461898] systemd[1]: Stopped target Local File Systems. machine # [ 106.940689] systemd[1]: Reload requested from client PID 4588 ('.switch-to-conf') (unit backdoor.service)... machine # [ 106.942347] systemd[1]: Reloading... machine # [ 107.578619] systemd[1]: Reloading finished in 633 ms. machine # [ 107.728434] systemd[568]: Reexecution requested from client PID 4657 ('switch-to-confi')... machine # [ 107.731482] systemd[568]: Reexecuting. machine # [ 107.794618] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 107.993878] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 108.000139] systemd[568]: Reload requested from client PID 4657 ('switch-to-confi')... machine # [ 108.002359] systemd[568]: Reloading... machine # [ 108.192198] systemd[568]: Reloading finished in 188 ms. machine # [ 108.208173] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 108.217788] systemd[568]: Stopped Run user-specific NixOS activation. machine # [ 108.220160] systemd[568]: Stopping Run user-specific NixOS activation... machine # [ 108.223252] systemd[568]: Starting Run user-specific NixOS activation... machine # [ 108.269826] systemd[568]: Finished Run user-specific NixOS activation. machine # [ 108.273890] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 108.276758] systemd[1]: Stopping Reactivate sysinit units... machine # [ 108.277636] systemd[1]: Reached target Reactivate sysinit units. machine # [ 108.278508] systemd[1]: Reached target Remote File Systems. machine # [ 108.282618] systemd[1]: Reached target Local File Systems. machine # [ 108.285427] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 108.287754] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 108.292656] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 108.296572] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 108.297416] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 108.298653] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 108.303373] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 108.307256] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 108.308988] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 108.641557] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 108.646150] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 108.650526] systemd[1]: Started autorestart.service. machine # [ 108.653744] systemd[1]: Starting linger-users.service... machine # [ 108.695150] systemd[1]: autorestart.service: Deactivated successfully. machine # [ 108.724952] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 108.727842] systemd[1]: Finished linger-users.service. machine # [ 108.986864] nixos[4588]: finished switching to system configuration /nix/store/9ah78j4gbgznwlssrccxgafcnv9f1d6c-nixos-system-machine-test machine: (finished: must succeed: /nix/store/h3ab1710ajdhy39vg73h26d6b55bw8cn-nixos-system-machine-test/specialisation/autorestartService/bin/switch-to-configuration test 2>&1, in 3.15 seconds) machine # [ 109.071151] systemd[1]: Stopped autorestart.service. machine: must fail: /nix/store/h3ab1710ajdhy39vg73h26d6b55bw8cn-nixos-system-machine-test/specialisation/autorestartServiceFailing/bin/switch-to-configuration test 2>&1 machine # [ 109.716595] nixos[4735]: switching to system configuration /nix/store/sp0p7wfgif9qv8jvm5rm7b068xzsvbmq-nixos-system-machine-test machine # [ 109.719953] systemd[1]: Stopped target Local File Systems. machine # [ 109.721303] systemd[1]: Stopped target Remote File Systems. machine # [ 110.281175] systemd[1]: Reload requested from client PID 4735 ('.switch-to-conf') (unit backdoor.service)... machine # [ 110.283182] systemd[1]: Reloading... machine # [ 110.963586] systemd[1]: Reloading finished in 677 ms. machine # [ 111.110417] systemd[568]: Reexecution requested from client PID 4804 ('switch-to-confi')... machine # [ 111.114738] systemd[568]: Reexecuting. machine # [ 111.170006] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 111.368997] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 111.376376] systemd[568]: Reload requested from client PID 4804 ('switch-to-confi')... machine # [ 111.378808] systemd[568]: Reloading... machine # [ 111.570353] systemd[568]: Reloading finished in 190 ms. machine # [ 111.584171] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 111.594134] systemd[568]: Stopped Run user-specific NixOS activation. machine # [ 111.596809] systemd[568]: Stopping Run user-specific NixOS activation... machine # [ 111.600882] systemd[568]: Starting Run user-specific NixOS activation... machine # [ 111.650548] systemd[568]: Finished Run user-specific NixOS activation. machine # [ 111.654710] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 111.656700] systemd[1]: Stopping Reactivate sysinit units... machine # [ 111.658478] systemd[1]: Reached target Reactivate sysinit units. machine # [ 111.661888] systemd[1]: Reached target Remote File Systems. machine # [ 111.666096] systemd[1]: Started autorestart.service. machine # [ 111.668932] systemd[1]: Starting linger-users.service... machine # [ 111.673323] systemd[1]: Reached target Local File Systems. machine # [ 111.681223] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 111.689826] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 111.692413] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 111.702026] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 111.706572] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 111.710429] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 111.712534] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 111.715544] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 111.718267] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 111.750234] systemd[1]: autorestart.service: Main process exited, code=exited, status=1/FAILURE machine # [ 111.751758] systemd[1]: autorestart.service: Failed with result 'exit-code'. machine # [ 111.789870] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 111.792723] systemd[1]: Finished linger-users.service. machine # [ 112.072936] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 112.076875] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 112.398903] nixos[4735]: switching to system configuration /nix/store/sp0p7wfgif9qv8jvm5rm7b068xzsvbmq-nixos-system-machine-test failed (status 4) machine: (finished: must fail: /nix/store/h3ab1710ajdhy39vg73h26d6b55bw8cn-nixos-system-machine-test/specialisation/autorestartServiceFailing/bin/switch-to-configuration test 2>&1, in 3.33 seconds) (finished: subtest: failing units, in 16.53 seconds) subtest: unit file parser machine: must succeed: /nix/store/h3ab1710ajdhy39vg73h26d6b55bw8cn-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1 machine # [ 112.960254] nixos[4878]: switching to system configuration /nix/store/sy8hxgrvfiqk47qgx7djail29s6czzmc-nixos-system-machine-test machine # [ 112.963266] systemd[1]: Stopped target Local File Systems. machine # [ 112.965433] systemd[1]: Stopped target Remote File Systems. machine # [ 112.967067] systemd[1]: Stopped autorestart.service. machine # [ 113.414521] systemd[1]: Reload requested from client PID 4878 ('.switch-to-conf') (unit backdoor.service)... machine # [ 113.416435] systemd[1]: Reloading... machine # [ 114.038688] systemd[1]: Reloading finished in 620 ms. machine # [ 114.188445] systemd[568]: Reexecution requested from client PID 4947 ('switch-to-confi')... machine # [ 114.189890] systemd[568]: Reexecuting. machine # [ 114.255609] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 114.451168] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 114.456928] systemd[568]: Reload requested from client PID 4947 ('switch-to-confi')... machine # [ 114.458715] systemd[568]: Reloading... machine # [ 114.647605] systemd[568]: Reloading finished in 187 ms. machine # [ 114.660202] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 114.671196] systemd[568]: Stopped Run user-specific NixOS activation. machine # [ 114.673609] systemd[568]: Stopping Run user-specific NixOS activation... machine # [ 114.676550] systemd[568]: Starting Run user-specific NixOS activation... machine # [ 114.722206] systemd[568]: Finished Run user-specific NixOS activation. machine # [ 114.726944] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 114.728920] systemd[1]: Stopping Reactivate sysinit units... machine # [ 114.730250] systemd[1]: Reached target Reactivate sysinit units. machine # [ 114.734968] systemd[1]: Reached target Remote File Systems. machine # [ 114.737646] systemd[1]: Reached target Local File Systems. machine # [ 114.740822] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 114.746230] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 114.747150] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 114.752300] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 114.758920] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 114.765001] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 114.766379] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 114.767710] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 114.769269] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 115.102166] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 115.105237] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 115.111387] systemd[1]: Starting linger-users.service... machine # [ 115.114838] systemd[1]: Starting test.service... machine # [ 115.158513] systemd[1]: Finished test.service. machine # [ 115.184761] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 115.187816] systemd[1]: Finished linger-users.service. machine # [ 115.447572] nixos[4878]: finished switching to system configuration /nix/store/sy8hxgrvfiqk47qgx7djail29s6czzmc-nixos-system-machine-test machine: (finished: must succeed: /nix/store/h3ab1710ajdhy39vg73h26d6b55bw8cn-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1, in 3.05 seconds) machine: must succeed: /nix/store/h3ab1710ajdhy39vg73h26d6b55bw8cn-nixos-system-machine-test/specialisation/simpleServiceWithExtraSection/bin/switch-to-configuration test 2>&1 machine # [ 116.102191] nixos[5020]: switching to system configuration /nix/store/45wmzr8bm8ck4vwwxmk2x7v4d534vhpz-nixos-system-machine-test machine # [ 116.105811] systemd[1]: Stopped target Local File Systems. machine # [ 116.107293] systemd[1]: Stopped target Remote File Systems. machine # [ 116.621471] systemd[1]: Reload requested from client PID 5020 ('.switch-to-conf') (unit backdoor.service)... machine # [ 116.623500] systemd[1]: Reloading... machine # [ 117.283048] systemd[1]: Reloading finished in 656 ms. machine # [ 117.453132] systemd[568]: Reexecution requested from client PID 5089 ('switch-to-confi')... machine # [ 117.456973] systemd[568]: Reexecuting. machine # [ 117.519702] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 117.724146] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 117.732934] systemd[568]: Reload requested from client PID 5089 ('switch-to-confi')... machine # [ 117.735224] systemd[568]: Reloading... machine # [ 117.925974] systemd[568]: Reloading finished in 189 ms. machine # [ 117.940283] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 117.952062] systemd[568]: Stopped Run user-specific NixOS activation. machine # [ 117.953139] systemd[568]: Stopping Run user-specific NixOS activation... machine # [ 117.956394] systemd[568]: Starting Run user-specific NixOS activation... machine # [ 118.004511] systemd[568]: Finished Run user-specific NixOS activation. machine # [ 118.008793] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 118.010730] systemd[1]: Stopping Reactivate sysinit units... machine # [ 118.012385] systemd[1]: Reached target Reactivate sysinit units. machine # [ 118.015703] systemd[1]: test.service: Deactivated successfully. machine # [ 118.017161] systemd[1]: Stopped test.service. machine # [ 118.017947] systemd[1]: Stopping test.service... machine # [ 118.019849] systemd[1]: Starting test.service... machine # [ 118.055535] systemd[1]: Finished test.service. machine # [ 118.059153] systemd[1]: Reached target Local File Systems. machine # [ 118.061933] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 118.069645] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 118.070586] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 118.071819] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 118.076429] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 118.085915] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 118.087316] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 118.093521] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 118.094901] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 118.096266] systemd[1]: Reached target Remote File Systems. machine # [ 118.453982] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 118.459499] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 118.462822] systemd[1]: Starting linger-users.service... machine # [ 118.528963] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 118.531983] systemd[1]: Finished linger-users.service. machine # [ 118.790815] nixos[5020]: finished switching to system configuration /nix/store/45wmzr8bm8ck4vwwxmk2x7v4d534vhpz-nixos-system-machine-test machine: (finished: must succeed: /nix/store/h3ab1710ajdhy39vg73h26d6b55bw8cn-nixos-system-machine-test/specialisation/simpleServiceWithExtraSection/bin/switch-to-configuration test 2>&1, in 3.34 seconds) machine: must succeed: /nix/store/h3ab1710ajdhy39vg73h26d6b55bw8cn-nixos-system-machine-test/specialisation/simpleServiceWithExtraSectionOtherName/bin/switch-to-configuration test 2>&1 machine # [ 119.438505] nixos[5162]: switching to system configuration /nix/store/k0dzd5pkis4hnijrcc9fwz6bjrd2jln9-nixos-system-machine-test machine # [ 119.441686] systemd[1]: Stopped target Local File Systems. machine # [ 119.443131] systemd[1]: Stopped target Remote File Systems. machine # [ 119.955863] systemd[1]: Reload requested from client PID 5162 ('.switch-to-conf') (unit backdoor.service)... machine # [ 119.958122] systemd[1]: Reloading... machine # [ 120.619084] systemd[1]: Reloading finished in 658 ms. machine # [ 120.784575] systemd[568]: Reexecution requested from client PID 5231 ('switch-to-confi')... machine # [ 120.788587] systemd[568]: Reexecuting. machine # [ 120.841869] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 121.027761] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 121.035239] systemd[568]: Reload requested from client PID 5231 ('switch-to-confi')... machine # [ 121.039225] systemd[568]: Reloading... machine # [ 121.216663] systemd[568]: Reloading finished in 178 ms. machine # [ 121.232238] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 121.242082] systemd[568]: Stopped Run user-specific NixOS activation. machine # [ 121.244707] systemd[568]: Stopping Run user-specific NixOS activation... machine # [ 121.247607] systemd[568]: Starting Run user-specific NixOS activation... machine # [ 121.294887] systemd[568]: Finished Run user-specific NixOS activation. machine # [ 121.299713] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 121.301998] systemd[1]: Stopping Reactivate sysinit units... machine # [ 121.302885] systemd[1]: Reached target Reactivate sysinit units. machine # [ 121.306869] systemd[1]: test.service: Deactivated successfully. machine # [ 121.307802] systemd[1]: Stopped test.service. machine # [ 121.308688] systemd[1]: Stopping test.service... machine # [ 121.311440] systemd[1]: Starting test.service... machine # [ 121.346939] systemd[1]: Finished test.service. machine # [ 121.349590] systemd[1]: Reached target Local File Systems. machine # [ 121.355633] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 121.363241] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 121.367085] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 121.368652] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 121.375707] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 121.380801] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 121.382204] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 121.383425] systemd[1]: Reached target Remote File Systems. machine # [ 121.385304] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 121.386637] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 121.723283] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 121.728254] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 121.730593] systemd[1]: Starting linger-users.service... machine # [ 121.794110] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 121.797109] systemd[1]: Finished linger-users.service. machine # [ 122.055524] nixos[5162]: finished switching to system configuration /nix/store/k0dzd5pkis4hnijrcc9fwz6bjrd2jln9-nixos-system-machine-test machine: (finished: must succeed: /nix/store/h3ab1710ajdhy39vg73h26d6b55bw8cn-nixos-system-machine-test/specialisation/simpleServiceWithExtraSectionOtherName/bin/switch-to-configuration test 2>&1, in 3.27 seconds) machine: must succeed: /nix/store/h3ab1710ajdhy39vg73h26d6b55bw8cn-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1 machine # [ 122.636680] nixos[5304]: switching to system configuration /nix/store/sy8hxgrvfiqk47qgx7djail29s6czzmc-nixos-system-machine-test machine # [ 122.639475] systemd[1]: Stopped target Local File Systems. machine # [ 122.641941] systemd[1]: Stopped target Remote File Systems. machine # [ 123.072212] systemd[1]: Reload requested from client PID 5304 ('.switch-to-conf') (unit backdoor.service)... machine # [ 123.074181] systemd[1]: Reloading... machine # [ 123.667921] systemd[1]: Reloading finished in 591 ms. machine # [ 123.811844] systemd[568]: Reexecution requested from client PID 5373 ('switch-to-confi')... machine # [ 123.814258] systemd[568]: Reexecuting. machine # [ 123.873926] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 124.062484] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 124.069665] systemd[568]: Reload requested from client PID 5373 ('switch-to-confi')... machine # [ 124.072250] systemd[568]: Reloading... machine # [ 124.257394] systemd[568]: Reloading finished in 184 ms. machine # [ 124.272190] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 124.284103] systemd[568]: Stopped Run user-specific NixOS activation. machine # [ 124.285157] systemd[568]: Stopping Run user-specific NixOS activation... machine # [ 124.288330] systemd[568]: Starting Run user-specific NixOS activation... machine # [ 124.333432] systemd[568]: Finished Run user-specific NixOS activation. machine # [ 124.337970] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 124.339265] systemd[1]: Stopping Reactivate sysinit units... machine # [ 124.343866] systemd[1]: Reached target Reactivate sysinit units. machine # [ 124.345487] systemd[1]: test.service: Deactivated successfully. machine # [ 124.347440] systemd[1]: Stopped test.service. machine # [ 124.348355] systemd[1]: Stopping test.service... machine # [ 124.349313] systemd[1]: Starting test.service... machine # [ 124.383260] systemd[1]: Finished test.service. machine # [ 124.390881] systemd[1]: Reached target Remote File Systems. machine # [ 124.394073] systemd[1]: Starting linger-users.service... machine # [ 124.404384] systemd[1]: Reached target Local File Systems. machine # [ 124.408561] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 124.410125] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 124.410940] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 124.423875] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 124.426561] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 124.429930] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 124.431866] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 124.434605] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 124.437050] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 124.497193] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 124.500436] systemd[1]: Finished linger-users.service. machine # [ 124.776098] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 124.779292] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 125.037895] nixos[5304]: finished switching to system configuration /nix/store/sy8hxgrvfiqk47qgx7djail29s6czzmc-nixos-system-machine-test machine: (finished: must succeed: /nix/store/h3ab1710ajdhy39vg73h26d6b55bw8cn-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1, in 2.98 seconds) machine: must succeed: /nix/store/h3ab1710ajdhy39vg73h26d6b55bw8cn-nixos-system-machine-test/specialisation/simpleServiceWithInstallSection/bin/switch-to-configuration test 2>&1 machine # [ 125.661327] nixos[5446]: switching to system configuration /nix/store/7h6c9j5mhz1va5jpxzf1bq74gv7fyyys-nixos-system-machine-test machine # [ 125.663910] systemd[1]: Stopped target Local File Systems. machine # [ 125.666432] systemd[1]: Stopped target Remote File Systems. machine # [ 126.158121] systemd[1]: Reload requested from client PID 5446 ('.switch-to-conf') (unit backdoor.service)... machine # [ 126.160187] systemd[1]: Reloading... machine # [ 126.786282] systemd[1]: Reloading finished in 624 ms. machine # [ 126.944431] systemd[568]: Reexecution requested from client PID 5515 ('switch-to-confi')... machine # [ 126.945855] systemd[568]: Reexecuting. machine # [ 127.009755] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 127.201822] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 127.208323] systemd[568]: Reload requested from client PID 5515 ('switch-to-confi')... machine # [ 127.210518] systemd[568]: Reloading... machine # [ 127.393796] systemd[568]: Reloading finished in 182 ms. machine # [ 127.408170] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 127.417559] systemd[568]: Stopped Run user-specific NixOS activation. machine # [ 127.420153] systemd[568]: Stopping Run user-specific NixOS activation... machine # [ 127.422984] systemd[568]: Starting Run user-specific NixOS activation... machine # [ 127.469000] systemd[568]: Finished Run user-specific NixOS activation. machine # [ 127.473321] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 127.475357] systemd[1]: Stopping Reactivate sysinit units... machine # [ 127.476897] systemd[1]: Reached target Reactivate sysinit units. machine # [ 127.480629] systemd[1]: Reached target Local File Systems. machine # [ 127.481515] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 127.486756] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 127.487637] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 127.493160] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 127.500502] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 127.502083] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 127.503320] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 127.508662] systemd[1]: Reached target Remote File Systems. machine # [ 127.512885] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 127.514244] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 127.824290] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 127.825387] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 127.828502] systemd[1]: Starting linger-users.service... machine # [ 127.887244] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 127.889971] systemd[1]: Finished linger-users.service. machine # [ 128.149964] nixos[5446]: finished switching to system configuration /nix/store/7h6c9j5mhz1va5jpxzf1bq74gv7fyyys-nixos-system-machine-test machine: (finished: must succeed: /nix/store/h3ab1710ajdhy39vg73h26d6b55bw8cn-nixos-system-machine-test/specialisation/simpleServiceWithInstallSection/bin/switch-to-configuration test 2>&1, in 3.11 seconds) machine: must succeed: /nix/store/h3ab1710ajdhy39vg73h26d6b55bw8cn-nixos-system-machine-test/specialisation/simpleServiceWithExtraKey/bin/switch-to-configuration test 2>&1 machine # [ 128.785500] nixos[5586]: switching to system configuration /nix/store/r6vwsmfsgwrfgp2589j9jlx0i807l5b9-nixos-system-machine-test machine # [ 128.789158] systemd[1]: Stopped target Local File Systems. machine # [ 128.790584] systemd[1]: Stopped target Remote File Systems. machine # [ 129.295097] systemd[1]: Reload requested from client PID 5586 ('.switch-to-conf') (unit backdoor.service)... machine # [ 129.297293] systemd[1]: Reloading... machine # [ 129.935131] systemd[1]: Reloading finished in 635 ms. machine # [ 130.080457] systemd[568]: Reexecution requested from client PID 5655 ('switch-to-confi')... machine # [ 130.084484] systemd[568]: Reexecuting. machine # [ 130.138434] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 130.331858] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 130.340348] systemd[568]: Reload requested from client PID 5655 ('switch-to-confi')... machine # [ 130.342632] systemd[568]: Reloading... machine # [ 130.536198] systemd[568]: Reloading finished in 192 ms. machine # [ 130.553643] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 130.562039] systemd[568]: Stopped Run user-specific NixOS activation. machine # [ 130.564589] systemd[568]: Stopping Run user-specific NixOS activation... machine # [ 130.567542] systemd[568]: Starting Run user-specific NixOS activation... machine # [ 130.617778] systemd[568]: Finished Run user-specific NixOS activation. machine # [ 130.623253] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 130.625097] systemd[1]: Stopping Reactivate sysinit units... machine # [ 130.625908] systemd[1]: Reached target Reactivate sysinit units. machine # [ 130.627982] systemd[1]: test.service: Deactivated successfully. machine # [ 130.631473] systemd[1]: Stopped test.service. machine # [ 130.632307] systemd[1]: Stopping test.service... machine # [ 130.634515] systemd[1]: Starting test.service... machine # [ 130.667646] systemd[1]: Finished test.service. machine # [ 130.671669] systemd[1]: Reached target Remote File Systems. machine # [ 130.678384] systemd[1]: Starting linger-users.service... machine # [ 130.683382] systemd[1]: Reached target Local File Systems. machine # [ 130.687118] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 130.698208] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 130.699140] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 130.708786] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 130.711028] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 130.713524] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 130.714826] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 130.715991] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 130.721315] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 130.786975] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 130.789954] systemd[1]: Finished linger-users.service. machine # [ 131.075758] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 131.079532] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 131.336854] nixos[5586]: finished switching to system configuration /nix/store/r6vwsmfsgwrfgp2589j9jlx0i807l5b9-nixos-system-machine-test machine: (finished: must succeed: /nix/store/h3ab1710ajdhy39vg73h26d6b55bw8cn-nixos-system-machine-test/specialisation/simpleServiceWithExtraKey/bin/switch-to-configuration test 2>&1, in 3.19 seconds) machine: must succeed: /nix/store/h3ab1710ajdhy39vg73h26d6b55bw8cn-nixos-system-machine-test/specialisation/simpleServiceWithExtraKeyOtherValue/bin/switch-to-configuration test 2>&1 machine # [ 132.012848] nixos[5728]: switching to system configuration /nix/store/w0qkg6iys65nsd4g0pfk44m95ws6jxrz-nixos-system-machine-test machine # [ 132.016876] systemd[1]: Stopped target Local File Systems. machine # [ 132.018754] systemd[1]: Stopped target Remote File Systems. machine # [ 132.557125] systemd[1]: Reload requested from client PID 5728 ('.switch-to-conf') (unit backdoor.service)... machine # [ 132.559226] systemd[1]: Reloading... machine # [ 133.233713] systemd[1]: Reloading finished in 672 ms. machine # [ 133.379842] systemd[568]: Reexecution requested from client PID 5797 ('switch-to-confi')... machine # [ 133.384304] systemd[568]: Reexecuting. machine # [ 133.437682] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 133.633301] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 133.641077] systemd[568]: Reload requested from client PID 5797 ('switch-to-confi')... machine # [ 133.643070] systemd[568]: Reloading... machine # [ 133.833666] systemd[568]: Reloading finished in 189 ms. machine # [ 133.848170] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 133.858620] systemd[568]: Stopped Run user-specific NixOS activation. machine # [ 133.860981] systemd[568]: Stopping Run user-specific NixOS activation... machine # [ 133.863897] systemd[568]: Starting Run user-specific NixOS activation... machine # [ 133.910631] systemd[568]: Finished Run user-specific NixOS activation. machine # [ 133.915311] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 133.917376] systemd[1]: Stopping Reactivate sysinit units... machine # [ 133.918231] systemd[1]: Reached target Reactivate sysinit units. machine # [ 133.922080] systemd[1]: test.service: Deactivated successfully. machine # [ 133.923088] systemd[1]: Stopped test.service. machine # [ 133.923734] systemd[1]: Stopping test.service... machine # [ 133.926342] systemd[1]: Starting test.service... machine # [ 133.964859] systemd[1]: Finished test.service. machine # [ 133.971966] systemd[1]: Reached target Local File Systems. machine # [ 133.976350] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 133.980415] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 133.981291] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 133.982511] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 133.993653] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 133.995512] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 133.999318] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 134.002184] systemd[1]: Reached target Remote File Systems. machine # [ 134.004505] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 134.006326] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 134.308963] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 134.311179] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 134.315981] systemd[1]: Starting linger-users.service... machine # [ 134.374276] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 134.376944] systemd[1]: Finished linger-users.service. machine # [ 134.635229] nixos[5728]: finished switching to system configuration /nix/store/w0qkg6iys65nsd4g0pfk44m95ws6jxrz-nixos-system-machine-test machine: (finished: must succeed: /nix/store/h3ab1710ajdhy39vg73h26d6b55bw8cn-nixos-system-machine-test/specialisation/simpleServiceWithExtraKeyOtherValue/bin/switch-to-configuration test 2>&1, in 3.30 seconds) machine: must succeed: /nix/store/h3ab1710ajdhy39vg73h26d6b55bw8cn-nixos-system-machine-test/specialisation/simpleServiceWithExtraKeyOtherName/bin/switch-to-configuration test 2>&1 machine # [ 135.233927] nixos[5870]: switching to system configuration /nix/store/ka1jam6df03wcylnypyai4nqylq5x80h-nixos-system-machine-test machine # [ 135.236560] systemd[1]: Stopped target Remote File Systems. machine # [ 135.238731] systemd[1]: Stopped target Local File Systems. machine # [ 135.715085] systemd[1]: Reload requested from client PID 5870 ('.switch-to-conf') (unit backdoor.service)... machine # [ 135.717221] systemd[1]: Reloading... machine # [ 136.333577] systemd[1]: Reloading finished in 614 ms. machine # [ 136.473600] systemd[568]: Reexecution requested from client PID 5939 ('switch-to-confi')... machine # [ 136.478348] systemd[568]: Reexecuting. machine # [ 136.537788] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 136.720864] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 136.727880] systemd[568]: Reload requested from client PID 5939 ('switch-to-confi')... machine # [ 136.731643] systemd[568]: Reloading... machine # [ 136.911820] systemd[568]: Reloading finished in 181 ms. machine # [ 136.924152] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 136.934379] systemd[568]: Stopped Run user-specific NixOS activation. machine # [ 136.936668] systemd[568]: Stopping Run user-specific NixOS activation... machine # [ 136.939466] systemd[568]: Starting Run user-specific NixOS activation... machine # [ 136.983708] systemd[568]: Finished Run user-specific NixOS activation. machine # [ 136.987641] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 136.989943] systemd[1]: Stopping Reactivate sysinit units... machine # [ 136.990826] systemd[1]: Reached target Reactivate sysinit units. machine # [ 136.994037] systemd[1]: test.service: Deactivated successfully. machine # [ 136.994952] systemd[1]: Stopped test.service. machine # [ 136.995588] systemd[1]: Stopping test.service... machine # [ 136.997875] systemd[1]: Starting test.service... machine # [ 137.033802] systemd[1]: Finished test.service. machine # [ 137.038629] systemd[1]: Reached target Remote File Systems. machine # [ 137.041122] systemd[1]: Reached target Local File Systems. machine # [ 137.046475] systemd[1]: Starting linger-users.service... machine # [ 137.049853] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 137.058397] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 137.059287] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 137.065303] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 137.067502] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 137.073980] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 137.075279] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 137.076694] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 137.078801] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 137.138692] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 137.140371] systemd[1]: Finished linger-users.service. machine # [ 137.396891] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 137.400142] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 137.658863] nixos[5870]: finished switching to system configuration /nix/store/ka1jam6df03wcylnypyai4nqylq5x80h-nixos-system-machine-test machine: (finished: must succeed: /nix/store/h3ab1710ajdhy39vg73h26d6b55bw8cn-nixos-system-machine-test/specialisation/simpleServiceWithExtraKeyOtherName/bin/switch-to-configuration test 2>&1, in 3.02 seconds) machine: must succeed: /nix/store/h3ab1710ajdhy39vg73h26d6b55bw8cn-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1 machine # [ 138.206621] nixos[6012]: switching to system configuration /nix/store/sy8hxgrvfiqk47qgx7djail29s6czzmc-nixos-system-machine-test machine # [ 138.209059] systemd[1]: Stopped target Remote File Systems. machine # [ 138.211231] systemd[1]: Stopped target Local File Systems. machine # [ 138.623873] systemd[1]: Reload requested from client PID 6012 ('.switch-to-conf') (unit backdoor.service)... machine # [ 138.625995] systemd[1]: Reloading... machine # [ 139.183588] systemd[1]: Reloading finished in 555 ms. machine # [ 139.324422] systemd[568]: Reexecution requested from client PID 6081 ('switch-to-confi')... machine # [ 139.327563] systemd[568]: Reexecuting. machine # [ 139.383023] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 139.565543] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 139.571582] systemd[568]: Reload requested from client PID 6081 ('switch-to-confi')... machine # [ 139.574114] systemd[568]: Reloading... machine # [ 139.754290] systemd[568]: Reloading finished in 179 ms. machine # [ 139.768144] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 139.778356] systemd[568]: Stopped Run user-specific NixOS activation. machine # [ 139.780584] systemd[568]: Stopping Run user-specific NixOS activation... machine # [ 139.783276] systemd[568]: Starting Run user-specific NixOS activation... machine # [ 139.827287] systemd[568]: Finished Run user-specific NixOS activation. machine # [ 139.831362] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 139.833588] systemd[1]: Stopping Reactivate sysinit units... machine # [ 139.834424] systemd[1]: Reached target Reactivate sysinit units. machine # [ 139.837583] systemd[1]: test.service: Deactivated successfully. machine # [ 139.838496] systemd[1]: Stopped test.service. machine # [ 139.839121] systemd[1]: Stopping test.service... machine # [ 139.841371] systemd[1]: Starting test.service... machine # [ 139.873933] systemd[1]: Finished test.service. machine # [ 139.876774] systemd[1]: Reached target Local File Systems. machine # [ 139.878879] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 139.881900] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 139.886382] systemd[1]: Reached target Remote File Systems. machine # [ 139.889418] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 139.893066] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 139.893926] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 139.895125] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 139.900248] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 139.908185] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 139.909473] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 140.211043] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 140.215567] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 140.218310] systemd[1]: Starting linger-users.service... machine # [ 140.275732] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 140.278389] systemd[1]: Finished linger-users.service. machine # [ 140.537920] nixos[6012]: finished switching to system configuration /nix/store/sy8hxgrvfiqk47qgx7djail29s6czzmc-nixos-system-machine-test machine: (finished: must succeed: /nix/store/h3ab1710ajdhy39vg73h26d6b55bw8cn-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1, in 2.88 seconds) machine: must succeed: /nix/store/h3ab1710ajdhy39vg73h26d6b55bw8cn-nixos-system-machine-test/specialisation/simpleServiceReloadTrigger/bin/switch-to-configuration test 2>&1 machine # [ 141.124636] nixos[6154]: switching to system configuration /nix/store/4k82sqcjhg113963wqv2b6k5kcn59pkl-nixos-system-machine-test machine # [ 141.127261] systemd[1]: Stopped target Local File Systems. machine # [ 141.129424] systemd[1]: Stopped target Remote File Systems. machine # [ 141.596601] systemd[1]: Reload requested from client PID 6154 ('.switch-to-conf') (unit backdoor.service)... machine # [ 141.598559] systemd[1]: Reloading... machine # [ 142.200770] systemd[1]: Reloading finished in 599 ms. machine # [ 142.338735] systemd[568]: Reexecution requested from client PID 6222 ('switch-to-confi')... machine # [ 142.340980] systemd[568]: Reexecuting. machine # [ 142.406793] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 142.588577] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 142.594744] systemd[568]: Reload requested from client PID 6222 ('switch-to-confi')... machine # [ 142.596717] systemd[568]: Reloading... machine # [ 142.776081] systemd[568]: Reloading finished in 178 ms. machine # [ 142.792132] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 142.801538] systemd[568]: Stopped Run user-specific NixOS activation. machine # [ 142.802542] systemd[568]: Stopping Run user-specific NixOS activation... machine # [ 142.805283] systemd[568]: Starting Run user-specific NixOS activation... machine # [ 142.850608] systemd[568]: Finished Run user-specific NixOS activation. machine # [ 142.854639] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 142.855557] systemd[1]: Stopping Reactivate sysinit units... machine # [ 142.856616] systemd[1]: Reached target Reactivate sysinit units. machine # [ 142.861341] systemd[1]: Reloading test.service... machine # [ 142.893335] systemd[1]: Reloaded test.service. machine # [ 142.895327] systemd[1]: Reached target Remote File Systems. machine # [ 142.901286] systemd[1]: Starting linger-users.service... machine # [ 142.910160] systemd[1]: Reached target Local File Systems. machine # [ 142.914134] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 142.921478] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 142.922352] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 142.923526] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 142.928538] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 142.930585] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 142.935289] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 142.937070] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 142.938436] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 142.990022] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 142.990992] systemd[1]: Finished linger-users.service. machine # [ 143.256189] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 143.259263] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 143.515493] nixos[6154]: finished switching to system configuration /nix/store/4k82sqcjhg113963wqv2b6k5kcn59pkl-nixos-system-machine-test machine: (finished: must succeed: /nix/store/h3ab1710ajdhy39vg73h26d6b55bw8cn-nixos-system-machine-test/specialisation/simpleServiceReloadTrigger/bin/switch-to-configuration test 2>&1, in 2.98 seconds) machine: must succeed: /nix/store/h3ab1710ajdhy39vg73h26d6b55bw8cn-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModified/bin/switch-to-configuration test 2>&1 machine # [ 144.109388] nixos[6296]: switching to system configuration /nix/store/rnscp2dalk30cx0bnsi88wjyp9j7rz92-nixos-system-machine-test machine # [ 144.111783] systemd[1]: Stopped target Local File Systems. machine # [ 144.113980] systemd[1]: Stopped target Remote File Systems. machine # [ 144.577960] systemd[1]: Reload requested from client PID 6296 ('.switch-to-conf') (unit backdoor.service)... machine # [ 144.579851] systemd[1]: Reloading... machine # [ 145.186610] systemd[1]: Reloading finished in 604 ms. machine # [ 145.324389] systemd[568]: Reexecution requested from client PID 6364 ('switch-to-confi')... machine # [ 145.327276] systemd[568]: Reexecuting. machine # [ 145.389584] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 145.571826] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 145.578441] systemd[568]: Reload requested from client PID 6364 ('switch-to-confi')... machine # [ 145.580504] systemd[568]: Reloading... machine # [ 145.758825] systemd[568]: Reloading finished in 177 ms. machine # [ 145.776142] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 145.785964] systemd[568]: Stopped Run user-specific NixOS activation. machine # [ 145.786928] systemd[568]: Stopping Run user-specific NixOS activation... machine # [ 145.789587] systemd[568]: Starting Run user-specific NixOS activation... machine # [ 145.834642] systemd[568]: Finished Run user-specific NixOS activation. machine # [ 145.838557] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 145.842376] systemd[1]: Stopping Reactivate sysinit units... machine # [ 145.843528] systemd[1]: Reached target Reactivate sysinit units. machine # [ 145.845818] systemd[1]: Reloading test.service... machine # [ 145.879709] systemd[1]: Reloaded test.service. machine # [ 145.883419] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 145.886747] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 145.887968] systemd[1]: Reached target Remote File Systems. machine # [ 145.891311] systemd[1]: Reached target Local File Systems. machine # [ 145.894429] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 145.898091] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 145.898926] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 145.902741] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 145.908588] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 145.910123] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 145.911340] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 146.213253] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 146.216636] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 146.219717] systemd[1]: Starting linger-users.service... machine # [ 146.275833] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 146.278302] systemd[1]: Finished linger-users.service. machine # [ 146.536629] nixos[6296]: finished switching to system configuration /nix/store/rnscp2dalk30cx0bnsi88wjyp9j7rz92-nixos-system-machine-test machine: (finished: must succeed: /nix/store/h3ab1710ajdhy39vg73h26d6b55bw8cn-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModified/bin/switch-to-configuration test 2>&1, in 3.02 seconds) machine: must succeed: /nix/store/h3ab1710ajdhy39vg73h26d6b55bw8cn-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModifiedAndSomethingElse/bin/switch-to-configuration test 2>&1 machine # [ 147.144358] nixos[6438]: switching to system configuration /nix/store/q7qnb9zmsyr2jw0xvpka2pbv0b35lrln-nixos-system-machine-test machine # [ 147.147283] systemd[1]: Stopped target Remote File Systems. machine # [ 147.149566] systemd[1]: Stopped target Local File Systems. machine # [ 147.620124] systemd[1]: Reload requested from client PID 6438 ('.switch-to-conf') (unit backdoor.service)... machine # [ 147.621974] systemd[1]: Reloading... machine # [ 148.227919] systemd[1]: Reloading finished in 603 ms. machine # [ 148.364351] systemd[568]: Reexecution requested from client PID 6506 ('switch-to-confi')... machine # [ 148.365671] systemd[568]: Reexecuting. machine # [ 148.409309] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 148.586841] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 148.592881] systemd[568]: Reload requested from client PID 6506 ('switch-to-confi')... machine # [ 148.594933] systemd[568]: Reloading... machine # [ 148.774326] systemd[568]: Reloading finished in 178 ms. machine # [ 148.792135] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 148.801560] systemd[568]: Stopped Run user-specific NixOS activation. machine # [ 148.802517] systemd[568]: Stopping Run user-specific NixOS activation... machine # [ 148.805240] systemd[568]: Starting Run user-specific NixOS activation... machine # [ 148.850696] systemd[568]: Finished Run user-specific NixOS activation. machine # [ 148.854263] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 148.856148] systemd[1]: Stopping Reactivate sysinit units... machine # [ 148.857024] systemd[1]: Reached target Reactivate sysinit units. machine # [ 148.860541] systemd[1]: test.service: Deactivated successfully. machine # [ 148.861485] systemd[1]: Stopped test.service. machine # [ 148.862343] systemd[1]: Stopping test.service... machine # [ 148.864222] systemd[1]: Starting test.service... machine # [ 148.896612] systemd[1]: Finished test.service. machine # [ 148.899758] systemd[1]: Reached target Remote File Systems. machine # [ 148.903061] systemd[1]: Reached target Local File Systems. machine # [ 148.906070] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 148.912690] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 148.916344] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 148.918037] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 148.925223] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 148.926801] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 148.927972] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 148.930038] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 148.931648] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 149.229104] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 149.232658] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 149.235842] systemd[1]: Starting linger-users.service... machine # [ 149.291301] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 149.293766] systemd[1]: Finished linger-users.service. machine # [ 149.551552] nixos[6438]: finished switching to system configuration /nix/store/q7qnb9zmsyr2jw0xvpka2pbv0b35lrln-nixos-system-machine-test machine: (finished: must succeed: /nix/store/h3ab1710ajdhy39vg73h26d6b55bw8cn-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModifiedAndSomethingElse/bin/switch-to-configuration test 2>&1, in 3.02 seconds) machine: must succeed: /nix/store/h3ab1710ajdhy39vg73h26d6b55bw8cn-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModifiedSomethingElse/bin/switch-to-configuration test 2>&1 machine # [ 150.096096] nixos[6580]: switching to system configuration /nix/store/r6vwsmfsgwrfgp2589j9jlx0i807l5b9-nixos-system-machine-test machine # [ 150.098523] systemd[1]: Stopped target Remote File Systems. machine # [ 150.100459] systemd[1]: Stopped target Local File Systems. machine # [ 150.515572] systemd[1]: Reload requested from client PID 6580 ('.switch-to-conf') (unit backdoor.service)... machine # [ 150.517622] systemd[1]: Reloading... machine # [ 151.070543] systemd[1]: Reloading finished in 551 ms. machine # [ 151.206021] systemd[568]: Reexecution requested from client PID 6648 ('switch-to-confi')... machine # [ 151.209635] systemd[568]: Reexecuting. machine # [ 151.261654] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 151.441986] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 151.448687] systemd[568]: Reload requested from client PID 6648 ('switch-to-confi')... machine # [ 151.449931] systemd[568]: Reloading... machine # [ 151.629159] systemd[568]: Reloading finished in 177 ms. machine # [ 151.644135] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 151.653892] systemd[568]: Stopped Run user-specific NixOS activation. machine # [ 151.654856] systemd[568]: Stopping Run user-specific NixOS activation... machine # [ 151.657678] systemd[568]: Starting Run user-specific NixOS activation... machine # [ 151.702771] systemd[568]: Finished Run user-specific NixOS activation. machine # [ 151.706776] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 151.709571] systemd[1]: Stopping Reactivate sysinit units... machine # [ 151.710775] systemd[1]: Reached target Reactivate sysinit units. machine # [ 151.713588] systemd[1]: Reached target Remote File Systems. machine # [ 151.717820] systemd[1]: Starting linger-users.service... machine # [ 151.722858] systemd[1]: Reached target Local File Systems. machine # [ 151.724247] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 151.732358] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 151.733443] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 151.737824] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 151.739916] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 151.747136] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 151.748456] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 151.749599] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 151.750817] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 151.809090] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 151.811687] systemd[1]: Finished linger-users.service. machine # [ 152.065625] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 152.068923] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 152.326850] nixos[6580]: finished switching to system configuration /nix/store/r6vwsmfsgwrfgp2589j9jlx0i807l5b9-nixos-system-machine-test machine: (finished: must succeed: /nix/store/h3ab1710ajdhy39vg73h26d6b55bw8cn-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModifiedSomethingElse/bin/switch-to-configuration test 2>&1, in 2.77 seconds) (finished: subtest: unit file parser, in 39.93 seconds) subtest: restart and reload by activation script machine: must succeed: /nix/store/h3ab1710ajdhy39vg73h26d6b55bw8cn-nixos-system-machine-test/specialisation/simpleServiceNorestart/bin/switch-to-configuration test 2>&1 machine # [ 152.883788] nixos[6720]: switching to system configuration /nix/store/3jfg0smvqi56d9mlm5kp5lqjd9jkhbym-nixos-system-machine-test machine # [ 152.886526] systemd[1]: Stopped target Remote File Systems. machine # [ 152.888672] systemd[1]: Stopped target Local File Systems. machine # [ 153.298019] systemd[1]: Reload requested from client PID 6720 ('.switch-to-conf') (unit backdoor.service)... machine # [ 153.299787] systemd[1]: Reloading... machine # [ 153.851016] systemd[1]: Reloading finished in 549 ms. machine # [ 153.989181] systemd[568]: Reexecution requested from client PID 6788 ('switch-to-confi')... machine # [ 153.992581] systemd[568]: Reexecuting. machine # [ 154.059723] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 154.247311] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 154.254924] systemd[568]: Reload requested from client PID 6788 ('switch-to-confi')... machine # [ 154.259067] systemd[568]: Reloading... machine # [ 154.442612] systemd[568]: Reloading finished in 184 ms. machine # [ 154.456135] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 154.465979] systemd[568]: Stopped Run user-specific NixOS activation. machine # [ 154.466967] systemd[568]: Stopping Run user-specific NixOS activation... machine # [ 154.469763] systemd[568]: Starting Run user-specific NixOS activation... machine # [ 154.511347] systemd[568]: Finished Run user-specific NixOS activation. machine # [ 154.515402] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 154.517533] systemd[1]: Stopping Reactivate sysinit units... machine # [ 154.518346] systemd[1]: Reached target Reactivate sysinit units. machine # [ 154.519853] systemd[1]: Reached target Local File Systems. machine # [ 154.522902] systemd[1]: Reached target Remote File Systems. machine # [ 154.527566] systemd[1]: Starting linger-users.service... machine # [ 154.537623] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 154.544836] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 154.545701] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 154.546887] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 154.556156] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 154.560230] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 154.562151] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 154.563636] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 154.565093] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 154.617078] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 154.618027] systemd[1]: Finished linger-users.service. machine # [ 154.879674] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 154.882713] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 155.139161] nixos[6720]: finished switching to system configuration /nix/store/3jfg0smvqi56d9mlm5kp5lqjd9jkhbym-nixos-system-machine-test machine: (finished: must succeed: /nix/store/h3ab1710ajdhy39vg73h26d6b55bw8cn-nixos-system-machine-test/specialisation/simpleServiceNorestart/bin/switch-to-configuration test 2>&1, in 2.81 seconds) machine: must succeed: /nix/store/h3ab1710ajdhy39vg73h26d6b55bw8cn-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration test 2>&1 machine # [ 155.740694] nixos[6860]: switching to system configuration /nix/store/fgai0caahc8c25yiaf2fw75ascbdbwbk-nixos-system-machine-test machine # [ 155.743469] systemd[1]: Stopped target Remote File Systems. machine # [ 155.746748] systemd[1]: Stopped target Local File Systems. machine # [ 155.747737] systemd[1]: test.service: Deactivated successfully. machine # [ 155.749065] systemd[1]: Stopped test.service. machine # [ 156.228201] systemd[1]: Reload requested from client PID 6860 ('.switch-to-conf') (unit backdoor.service)... machine # [ 156.230022] systemd[1]: Reloading... machine # [ 156.858038] systemd[1]: Reloading finished in 625 ms. machine # [ 156.995097] systemd[568]: Reexecution requested from client PID 6930 ('switch-to-confi')... machine # [ 156.997313] systemd[568]: Reexecuting. machine # [ 157.065737] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 157.252274] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 157.258134] systemd[568]: Reload requested from client PID 6930 ('switch-to-confi')... machine # [ 157.260154] systemd[568]: Reloading... machine # [ 157.438693] systemd[568]: Reloading finished in 177 ms. machine # [ 157.456129] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 157.465441] systemd[568]: Stopped Run user-specific NixOS activation. machine # [ 157.466399] systemd[568]: Stopping Run user-specific NixOS activation... machine # [ 157.469018] systemd[568]: Starting Run user-specific NixOS activation... machine # [ 157.511194] systemd[568]: Finished Run user-specific NixOS activation. machine # [ 157.514688] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 157.516908] systemd[1]: Stopping Reactivate sysinit units... machine # [ 157.517891] systemd[1]: Reached target Reactivate sysinit units. machine # [ 157.526727] systemd[1]: Created slice Slice /system/templated-reload-triggers-and-restart-by-as. machine # [ 157.531454] systemd[1]: Starting templated-reload-triggers-and-restart-by-as@instance.service... machine # [ 157.534774] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 157.541008] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 157.542555] systemd[1]: Created slice Slice /system/templated-reload-triggers. machine # [ 157.547353] systemd[1]: Created slice Slice /system/templated-reload-triggers-and-restart. machine # [ 157.548926] systemd[1]: Reached target Remote File Systems. machine # [ 157.550702] systemd[1]: Starting linger-users.service... machine # [ 157.561246] systemd[1]: Starting reload-triggers-and-restart.service... machine # [ 157.564262] systemd[1]: Starting reload-triggers.service... machine # [ 157.572549] systemd[1]: Starting templated-reload-triggers-and-restart@instance.service... machine # [ 157.577099] systemd[1]: Starting templated-reload-triggers@instance.service... machine # [ 157.593564] systemd[1]: Starting no-restart-service.service... machine # [ 157.599684] systemd[1]: Reached target Local File Systems. machine # [ 157.609993] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 157.630218] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 157.640978] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 157.658484] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 157.687163] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 157.703792] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 157.716284] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 157.728779] systemd[1]: Created slice Slice /system/templated-simple-service. machine # [ 157.732621] systemd[1]: Created slice Slice /system/templated-simple-restart-service. machine # [ 157.736867] systemd[1]: Finished templated-reload-triggers-and-restart-by-as@instance.service. machine # [ 157.739805] systemd[1]: Created slice Slice /system/templated-no-restart-service. machine # [ 157.743659] systemd[1]: Finished reload-triggers-and-restart.service. machine # [ 157.748321] systemd[1]: Finished reload-triggers.service. machine # [ 157.750297] systemd[1]: Finished templated-reload-triggers-and-restart@instance.service. machine # [ 157.752922] systemd[1]: Created slice Slice /system/templated-simple-reload-service. machine # [ 157.754402] systemd[1]: Finished templated-reload-triggers@instance.service. machine # [ 157.755701] systemd[1]: Finished no-restart-service.service. machine # [ 157.766823] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 157.769386] systemd[1]: Finished linger-users.service. machine # [ 158.039720] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 158.044053] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 158.047184] systemd[1]: Starting reload-triggers-and-restart-by-as.service... machine # [ 158.051064] systemd[1]: Starting simple-reload-service.service... machine # [ 158.054693] systemd[1]: Starting simple-restart-service.service... machine # [ 158.063327] systemd[1]: Starting simple-service.service... machine # [ 158.066714] systemd[1]: Starting templated-no-restart-service@instance.service... machine # [ 158.078437] systemd[1]: Starting templated-simple-reload-service@instance.service... machine # [ 158.084189] systemd[1]: Starting templated-simple-restart-service@instance.service... machine # [ 158.097832] systemd[1]: Starting templated-simple-service@instance.service... machine # [ 158.163182] systemd[1]: Finished reload-triggers-and-restart-by-as.service. machine # [ 158.170279] systemd[1]: Finished simple-service.service. machine # [ 158.172601] systemd[1]: Finished simple-reload-service.service. machine # [ 158.181378] systemd[1]: Finished simple-restart-service.service. machine # [ 158.185774] systemd[1]: Finished templated-no-restart-service@instance.service. machine # [ 158.189919] systemd[1]: Finished templated-simple-restart-service@instance.service. machine # [ 158.193639] systemd[1]: Finished templated-simple-reload-service@instance.service. machine # [ 158.198723] systemd[1]: Finished templated-simple-service@instance.service. machine # [ 158.459257] nixos[6860]: finished switching to system configuration /nix/store/fgai0caahc8c25yiaf2fw75ascbdbwbk-nixos-system-machine-test machine: (finished: must succeed: /nix/store/h3ab1710ajdhy39vg73h26d6b55bw8cn-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration test 2>&1, in 3.32 seconds) machine: must succeed: /nix/store/h3ab1710ajdhy39vg73h26d6b55bw8cn-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration test 2>&1 machine # [ 159.135262] nixos[7030]: switching to system configuration /nix/store/fgai0caahc8c25yiaf2fw75ascbdbwbk-nixos-system-machine-test machine # [ 159.138481] systemd[1]: Stopped target Local File Systems. machine # [ 159.139749] systemd[1]: Stopped target Remote File Systems. machine # [ 159.603537] systemd[1]: Reload requested from client PID 7030 ('.switch-to-conf') (unit backdoor.service)... machine # [ 159.605743] systemd[1]: Reloading... machine # [ 160.210131] systemd[1]: Reloading finished in 601 ms. machine # [ 160.346618] systemd[568]: Reexecution requested from client PID 7101 ('switch-to-confi')... machine # [ 160.351157] systemd[568]: Reexecuting. machine # [ 160.397331] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 160.582247] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 160.588181] systemd[568]: Reload requested from client PID 7101 ('switch-to-confi')... machine # [ 160.590291] systemd[568]: Reloading... machine # [ 160.771911] systemd[568]: Reloading finished in 180 ms. machine # [ 160.784139] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 160.792577] systemd[568]: Stopped Run user-specific NixOS activation. machine # [ 160.794700] systemd[568]: Stopping Run user-specific NixOS activation... machine # [ 160.797289] systemd[568]: Starting Run user-specific NixOS activation... machine # [ 160.838568] systemd[568]: Finished Run user-specific NixOS activation. machine # [ 160.842403] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 160.843557] systemd[1]: Stopping Reactivate sysinit units... machine # [ 160.845674] systemd[1]: Reached target Reactivate sysinit units. machine # [ 160.851078] systemd[1]: Reloading reload-triggers-and-restart.service... machine # [ 160.855526] systemd[1]: Reloading reload-triggers.service... machine # [ 160.861465] systemd[1]: Reloading simple-reload-service.service... machine # [ 160.873356] systemd[1]: Reloading templated-reload-triggers-and-restart@instance.service... machine # [ 160.880182] systemd[1]: Reloading templated-reload-triggers@instance.service... machine # [ 160.890900] systemd[1]: Reloading templated-simple-reload-service@instance.service... machine # [ 160.943604] systemd[1]: Reloaded reload-triggers.service. machine # [ 160.949000] systemd[1]: Reloaded templated-reload-triggers-and-restart@instance.service. machine # [ 160.951768] systemd[1]: Reloaded reload-triggers-and-restart.service. machine # [ 160.954943] systemd[1]: Reloaded simple-reload-service.service. machine # [ 160.964554] systemd[1]: Reloaded templated-reload-triggers@instance.service. machine # [ 160.969211] systemd[1]: Reloaded templated-simple-reload-service@instance.service. machine # [ 160.971511] systemd[1]: reload-triggers-and-restart-by-as.service: Deactivated successfully. machine # [ 160.974824] systemd[1]: Stopped reload-triggers-and-restart-by-as.service. machine # [ 160.976194] systemd[1]: Stopping reload-triggers-and-restart-by-as.service... machine # [ 160.978480] systemd[1]: Starting reload-triggers-and-restart-by-as.service... machine # [ 160.981999] systemd[1]: simple-restart-service.service: Deactivated successfully. machine # [ 160.983528] systemd[1]: Stopped simple-restart-service.service. machine # [ 160.986109] systemd[1]: Stopping simple-restart-service.service... machine # [ 160.986939] systemd[1]: Starting simple-restart-service.service... machine # [ 160.992687] systemd[1]: simple-service.service: Deactivated successfully. machine # [ 161.001318] systemd[1]: Stopped simple-service.service. machine # [ 161.002084] systemd[1]: Stopping simple-service.service... machine # [ 161.002826] systemd[1]: Starting simple-service.service... machine # [ 161.003561] systemd[1]: templated-reload-triggers-and-restart-by-as@instance.service: Deactivated successfully. machine # [ 161.005082] systemd[1]: Stopped templated-reload-triggers-and-restart-by-as@instance.service. machine # [ 161.006555] systemd[1]: Stopping templated-reload-triggers-and-restart-by-as@instance.service... machine # [ 161.022627] systemd[1]: Starting templated-reload-triggers-and-restart-by-as@instance.service... machine # [ 161.031251] systemd[1]: templated-simple-restart-service@instance.service: Deactivated successfully. machine # [ 161.038919] systemd[1]: Stopped templated-simple-restart-service@instance.service. machine # [ 161.047765] systemd[1]: Stopping templated-simple-restart-service@instance.service... machine # [ 161.055526] systemd[1]: Starting templated-simple-restart-service@instance.service... machine # [ 161.066688] systemd[1]: templated-simple-service@instance.service: Deactivated successfully. machine # [ 161.069491] systemd[1]: Stopped templated-simple-service@instance.service. machine # [ 161.075476] systemd[1]: Stopping templated-simple-service@instance.service... machine # [ 161.078513] systemd[1]: Starting templated-simple-service@instance.service... machine # [ 161.095063] systemd[1]: Finished reload-triggers-and-restart-by-as.service. machine # [ 161.102077] systemd[1]: Finished templated-reload-triggers-and-restart-by-as@instance.service. machine # [ 161.103358] systemd[1]: Finished simple-service.service. machine # [ 161.104503] systemd[1]: Finished simple-restart-service.service. machine # [ 161.105407] systemd[1]: Finished templated-simple-restart-service@instance.service. machine # [ 161.112428] systemd[1]: Finished templated-simple-service@instance.service. machine # [ 161.116781] systemd[1]: Reached target Local File Systems. machine # [ 161.118913] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 161.121217] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 161.123053] systemd[1]: Reached target Remote File Systems. machine # [ 161.129714] systemd[1]: Starting linger-users.service... machine # [ 161.138070] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 161.144598] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 161.145426] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 161.146599] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 161.150404] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 161.152740] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 161.154428] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 161.208810] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 161.211650] systemd[1]: Finished linger-users.service. machine # [ 161.476119] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 161.479053] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 161.735983] nixos[7030]: finished switching to system configuration /nix/store/fgai0caahc8c25yiaf2fw75ascbdbwbk-nixos-system-machine-test machine: (finished: must succeed: /nix/store/h3ab1710ajdhy39vg73h26d6b55bw8cn-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration test 2>&1, in 3.28 seconds) machine: must succeed: /nix/store/h3ab1710ajdhy39vg73h26d6b55bw8cn-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script-modified/bin/switch-to-configuration test 2>&1 machine # [ 162.491340] nixos[7196]: switching to system configuration /nix/store/ivag9ah4xjdgmzrczf2ja3qny76kcz6p-nixos-system-machine-test machine # [ 162.494812] systemd[1]: Stopped target Local File Systems. machine # [ 162.496078] systemd[1]: Stopped target Remote File Systems. machine # [ 163.041183] systemd[1]: Reload requested from client PID 7196 ('.switch-to-conf') (unit backdoor.service)... machine # [ 163.043224] systemd[1]: Reloading... machine # [ 163.705997] systemd[1]: Reloading finished in 659 ms. machine # [ 163.849026] systemd[568]: Reexecution requested from client PID 7267 ('switch-to-confi')... machine # [ 163.852532] systemd[568]: Reexecuting. machine # [ 163.909429] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 164.092866] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 164.099342] systemd[568]: Reload requested from client PID 7267 ('switch-to-confi')... machine # [ 164.102291] systemd[568]: Reloading... machine # [ 164.284727] systemd[568]: Reloading finished in 183 ms. machine # [ 164.300133] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 164.308494] systemd[568]: Stopped Run user-specific NixOS activation. machine # [ 164.310593] systemd[568]: Stopping Run user-specific NixOS activation... machine # [ 164.313248] systemd[568]: Starting Run user-specific NixOS activation... machine # [ 164.354527] systemd[568]: Finished Run user-specific NixOS activation. machine # [ 164.358187] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 164.360651] systemd[1]: Stopping Reactivate sysinit units... machine # [ 164.361480] systemd[1]: Reached target Reactivate sysinit units. machine # [ 164.366703] systemd[1]: Reloading reload-triggers.service... machine # [ 164.372373] systemd[1]: Reloading simple-reload-service.service... machine # [ 164.375954] systemd[1]: Reloading templated-reload-triggers@instance.service... machine # [ 164.386677] systemd[1]: Reloading templated-simple-reload-service@instance.service... machine # [ 164.436601] systemd[1]: Reloaded templated-reload-triggers@instance.service. machine # [ 164.439183] systemd[1]: Reloaded simple-reload-service.service. machine # [ 164.442573] systemd[1]: Reloaded reload-triggers.service. machine # [ 164.444928] systemd[1]: Reloaded templated-simple-reload-service@instance.service. machine # [ 164.447525] systemd[1]: reload-triggers-and-restart-by-as.service: Deactivated successfully. machine # [ 164.450773] systemd[1]: Stopped reload-triggers-and-restart-by-as.service. machine # [ 164.452001] systemd[1]: Stopping reload-triggers-and-restart-by-as.service... machine # [ 164.457076] systemd[1]: Starting reload-triggers-and-restart-by-as.service... machine # [ 164.458572] systemd[1]: reload-triggers-and-restart.service: Deactivated successfully. machine # [ 164.464438] systemd[1]: Stopped reload-triggers-and-restart.service. machine # [ 164.467831] systemd[1]: Stopping reload-triggers-and-restart.service... machine # [ 164.475987] systemd[1]: Starting reload-triggers-and-restart.service... machine # [ 164.480293] systemd[1]: simple-restart-service.service: Deactivated successfully. machine # [ 164.481319] systemd[1]: Stopped simple-restart-service.service. machine # [ 164.482162] systemd[1]: Stopping simple-restart-service.service... machine # [ 164.483009] systemd[1]: Starting simple-restart-service.service... machine # [ 164.483853] systemd[1]: simple-service.service: Deactivated successfully. machine # [ 164.499345] systemd[1]: Stopped simple-service.service. machine # [ 164.511005] systemd[1]: Stopping simple-service.service... machine # [ 164.514889] systemd[1]: Starting simple-service.service... machine # [ 164.529849] systemd[1]: templated-reload-triggers-and-restart-by-as@instance.service: Deactivated successfully. machine # [ 164.531300] systemd[1]: Stopped templated-reload-triggers-and-restart-by-as@instance.service. machine # [ 164.550552] systemd[1]: Stopping templated-reload-triggers-and-restart-by-as@instance.service... machine # [ 164.562295] systemd[1]: Starting templated-reload-triggers-and-restart-by-as@instance.service... machine # [ 164.576623] systemd[1]: templated-reload-triggers-and-restart@instance.service: Deactivated successfully. machine # [ 164.591240] systemd[1]: Stopped templated-reload-triggers-and-restart@instance.service. machine # [ 164.601176] systemd[1]: Stopping templated-reload-triggers-and-restart@instance.service... machine # [ 164.604982] systemd[1]: Starting templated-reload-triggers-and-restart@instance.service... machine # [ 164.607182] systemd[1]: templated-simple-restart-service@instance.service: Deactivated successfully. machine # [ 164.612303] systemd[1]: Stopped templated-simple-restart-service@instance.service. machine # [ 164.615566] systemd[1]: Stopping templated-simple-restart-service@instance.service... machine # [ 164.617336] systemd[1]: Starting templated-simple-restart-service@instance.service... machine # [ 164.618936] systemd[1]: templated-simple-service@instance.service: Deactivated successfully. machine # [ 164.621996] systemd[1]: Stopped templated-simple-service@instance.service. machine # [ 164.623431] systemd[1]: Stopping templated-simple-service@instance.service... machine # [ 164.626374] systemd[1]: Starting templated-simple-service@instance.service... machine # [ 164.627722] systemd[1]: Finished reload-triggers-and-restart-by-as.service. machine # [ 164.630054] systemd[1]: Finished reload-triggers-and-restart.service. machine # [ 164.630972] systemd[1]: Finished simple-service.service. machine # [ 164.631686] systemd[1]: Finished simple-restart-service.service. machine # [ 164.633265] systemd[1]: Finished templated-reload-triggers-and-restart-by-as@instance.service. machine # [ 164.634487] systemd[1]: Finished templated-reload-triggers-and-restart@instance.service. machine # [ 164.635662] systemd[1]: Finished templated-simple-service@instance.service. machine # [ 164.639140] systemd[1]: Finished templated-simple-restart-service@instance.service. machine # [ 164.642662] systemd[1]: Reached target Local File Systems. machine # [ 164.645825] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 164.650111] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 164.650956] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 164.655155] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 164.659427] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 164.664922] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 164.666217] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 164.667372] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 164.671198] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 164.674725] systemd[1]: Reached target Remote File Systems. machine # [ 164.965715] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 164.969872] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 164.972439] systemd[1]: Starting linger-users.service... machine # [ 165.026797] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 165.028472] systemd[1]: Finished linger-users.service. machine # [ 165.287007] nixos[7196]: finished switching to system configuration /nix/store/ivag9ah4xjdgmzrczf2ja3qny76kcz6p-nixos-system-machine-test machine: (finished: must succeed: /nix/store/h3ab1710ajdhy39vg73h26d6b55bw8cn-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script-modified/bin/switch-to-configuration test 2>&1, in 3.55 seconds) machine: must succeed: /nix/store/h3ab1710ajdhy39vg73h26d6b55bw8cn-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/h3ab1710ajdhy39vg73h26d6b55bw8cn-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration dry-activate 2>&1, in 0.83 seconds) (finished: subtest: restart and reload by activation script, in 13.80 seconds) (finished: run the VM test script, in 166.97 seconds) test script finished in 167.01s cleanup kill QemuMachine (pid 45) machine # qemu-system-aarch64: terminating on signal 15 from pid 39 (/nix/store/lfh101cfjj8p8npcari9hk0lbqi33yvh-python3-3.14.7/bin/python3.14) (finished: cleanup, in 0.18 seconds) additionally exposed symbols: machine, other, vlan1, start_all, test_script, machines, machines_qemu, machines_nspawn, vlans, driver, log, os, create_machine, subtest, run_tests, join_all, retry, serial_stdout_off, serial_stdout_on, polling_condition, BaseMachine, QemuMachine, NspawnMachine, t, debug, dump_machine_ssh