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: QEMU running (pid 45) machine # Disk image does not exist, creating the virtualisation disk image... machine # Formatting '/build/vm-state-machine/tmp.wqExF0sBwm', 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: e516168d-bc38-4009-9518-f0c8771e8f6b machine # Superblock backups stored on blocks: machine # 32768, 98304, 163840, 229376 machine # machine # Allocating group tables: 0/8 done machine # Writing inode tables: 0/8 done machine # Creating journal (8192 blocks): done machine # Writing superblocks and filesystem accounting information: 0/8 done machine # machine # Virtualisation disk image created. machine # Starting virtiofs daemons... machine # [2026-09-15T21:17:39Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1) machine # [2026-09-15T21:17:39Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether machine # [2026-09-15T21:17:39Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1) machine # [2026-09-15T21:17:39Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether machine # [2026-09-15T21:17:39Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1) machine # [2026-09-15T21:17:39Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether machine # [2026-09-15T21:17:39Z INFO virtiofsd] Waiting for vhost-user socket connection... machine # [2026-09-15T21:17:39Z INFO virtiofsd] Waiting for vhost-user socket connection... machine # [2026-09-15T21:17:39Z INFO virtiofsd] Waiting for vhost-user socket connection... machine # [2026-09-15T21:17:39Z INFO virtiofsd] Client connected, servicing requests machine # [2026-09-15T21:17:39Z INFO virtiofsd] Client connected, servicing requests machine # [2026-09-15T21:17:39Z INFO virtiofsd] Client connected, servicing requests machine # [ 0.000000] Booting Linux on physical CPU 0x0000000000 [0xc00fac40] machine # [ 0.000000] Linux version 6.18.51 (nixbld@localhost) (gcc (GCC) 15.3.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT Fri Sep 11 09:49:46 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/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test/init regInfo=/nix/store/g3m283rd6cqyliafsdkby9nqsalry0c4-closure-info/registration console=ttyAMA0,115200n8 console=tty0 machine # [ 0.000000] Unknown kernel command line parameters "regInfo=/nix/store/g3m283rd6cqyliafsdkby9nqsalry0c4-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 74894 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 @0x0000000044d00000 machine # [ 0.000000] GICv3: CPU0: using allocated LPI pending table @0x0000000044d10000 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.000029] arm-pv: using stolen time PV machine # [ 0.000396] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____) machine # [ 0.000601] Console: colour dummy device 80x25 machine # [ 0.000609] printk: legacy console [tty0] enabled machine # [ 0.000808] Calibrating delay loop (skipped), value calculated using timer frequency.. 2000.00 BogoMIPS (lpj=4000000) machine # [ 0.000816] pid_max: default: 32768 minimum: 301 machine # [ 0.000902] LSM: initializing lsm=capability,landlock,yama,bpf,ima machine # [ 0.001047] landlock: Up and running. machine # [ 0.001050] Yama: becoming mindful. machine # [ 0.001560] LSM support for eBPF active machine # [ 0.001691] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear) machine # [ 0.001736] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear) machine # [ 0.002931] cacheinfo: Unable to detect cache hierarchy for CPU 0 machine # [ 0.003706] rcu: Hierarchical SRCU implementation. machine # [ 0.003711] rcu: Max phase no-delay instances is 1000. machine # [ 0.004977] fsl-mc MSI: its@8080000 domain created machine # [ 0.005070] EFI services will not be available. machine # [ 0.005142] smp: Bringing up secondary CPUs ... machine # [ 0.005151] smp: Brought up 1 node, 1 CPU machine # [ 0.005154] SMP: Total of 1 processors activated. machine # [ 0.005157] CPU: All CPU(s) started at EL1 machine # [ 0.005171] CPU features: detected: Branch Target Identification machine # [ 0.005176] CPU features: detected: ARMv8.4 Translation Table Level machine # [ 0.005179] CPU features: detected: Instruction cache invalidation not required for I/D coherence machine # [ 0.005183] CPU features: detected: Data cache clean to the PoU not required for I/D coherence machine # [ 0.005187] CPU features: detected: Common not Private translations machine # [ 0.005190] CPU features: detected: CRC32 instructions machine # [ 0.005193] CPU features: detected: Data cache clean to Point of Deep Persistence machine # [ 0.005196] CPU features: detected: Data cache clean to Point of Persistence machine # [ 0.005199] CPU features: detected: Data independent timing control (DIT) machine # [ 0.005202] CPU features: detected: E0PD machine # [ 0.005205] CPU features: detected: Enhanced Counter Virtualization machine # [ 0.005208] CPU features: detected: Enhanced Counter Virtualization (CNTPOFF) machine # [ 0.005211] CPU features: detected: Enhanced Virtualization Traps machine # [ 0.005214] CPU features: detected: Fine Grained Traps machine # [ 0.005218] CPU features: detected: Generic authentication (architected QARMA5 algorithm) machine # [ 0.005223] CPU features: detected: RCpc load-acquire (LDAPR) machine # [ 0.005226] CPU features: detected: LSE atomic instructions machine # [ 0.005229] CPU features: detected: Privileged Access Never machine # [ 0.005232] CPU features: detected: PMUv3 machine # [ 0.005235] CPU features: detected: RAS Extension Support machine # [ 0.005238] CPU features: detected: RASv1p1 Extension Support machine # [ 0.005240] CPU features: detected: Random Number Generator machine # [ 0.005243] CPU features: detected: Speculation barrier (SB) machine # [ 0.005245] CPU features: detected: Stage-2 Force Write-Back machine # [ 0.005249] CPU features: detected: TLB range maintenance instructions machine # [ 0.005254] CPU features: detected: Speculative Store Bypassing Safe (SSBS) machine # [ 0.005293] alternatives: applying system-wide alternatives machine # [ 0.008351] CPU features: detected: BBM Level 2 without TLB conflict abort machine # [ 0.008591] Memory: 893784K/1048576K available (24448K kernel code, 7090K rwdata, 26360K rodata, 4736K init, 1107K bss, 113268K reserved, 32768K cma-reserved) machine # [ 0.008936] devtmpfs: initialized machine # [ 0.010712] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear) machine # [ 0.010734] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear). machine # [ 0.010925] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL machine # [ 0.010929] 0 pages in range for non-PLT usage machine # [ 0.010930] 508288 pages in range for PLT usage machine # [ 0.011028] pinctrl core: initialized pinctrl subsystem machine # [ 0.011776] DMI not present or invalid. machine # [ 0.014972] NET: Registered PF_NETLINK/PF_ROUTE protocol family machine # [ 0.017440] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations machine # [ 0.017593] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations machine # [ 0.017770] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations machine # [ 0.017796] audit: initializing netlink subsys (disabled) machine # [ 0.018397] thermal_sys: Registered thermal governor 'fair_share' machine # [ 0.018399] thermal_sys: Registered thermal governor 'bang_bang' machine # [ 0.018402] thermal_sys: Registered thermal governor 'step_wise' machine # [ 0.018405] thermal_sys: Registered thermal governor 'user_space' machine # [ 0.018410] thermal_sys: Registered thermal governor 'power_allocator' machine # [ 0.018435] audit: type=2000 audit(0.016:1): state=initialized audit_enabled=0 res=1 machine # [ 0.018443] cpuidle: using governor ladder machine # [ 0.018449] cpuidle: using governor menu machine # [ 0.018641] hw-breakpoint: found 16 breakpoint and 4 watchpoint registers. machine # [ 0.018658] ASID allocator initialised with 65536 entries machine # [ 0.019749] Serial: AMBA PL011 UART driver machine # [ 0.024918] 9000000.pl011: ttyAMA0 at MMIO 0x9000000 (irq = 13, base_baud = 0) is a PL011 rev1 machine # [ 0.025081] printk: console [ttyAMA0] enabled machine # [ 0.151305] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages machine # [ 0.151328] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page machine # [ 0.151334] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages machine # [ 0.151339] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page machine # [ 0.151343] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages machine # [ 0.151347] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page machine # [ 0.151352] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages machine # [ 0.151356] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page machine # [ 0.159078] fbcon: Taking over console machine # [ 0.159094] ACPI: Interpreter disabled. machine # [ 0.160999] iommu: Default domain type: Translated machine # [ 0.161011] iommu: DMA domain TLB invalidation policy: strict mode machine # [ 0.162776] SCSI subsystem initialized machine # [ 0.170431] usbcore: registered new interface driver usbfs machine # [ 0.170462] usbcore: registered new interface driver hub machine # [ 0.170480] usbcore: registered new device driver usb machine # [ 0.170752] pps_core: LinuxPPS API ver. 1 registered machine # [ 0.170759] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti machine # [ 0.170783] PTP clock support registered machine # [ 0.170845] EDAC MC: Ver: 3.0.0 machine # [ 0.175594] scmi_core: SCMI protocol bus registered machine # [ 0.176579] FPGA manager framework machine # [ 0.177567] vgaarb: loaded machine # [ 0.178239] clocksource: Switched to clocksource arch_sys_counter machine # [ 0.178899] VFS: Disk quotas dquot_6.6.0 machine # [ 0.178933] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) machine # [ 0.181414] netfs: FS-Cache loaded machine # [ 0.181517] pnp: PnP ACPI: disabled machine # [ 0.187805] NET: Registered PF_INET protocol family machine # [ 0.187977] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear) machine # [ 0.218183] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear) machine # [ 0.218231] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) machine # [ 0.220450] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear) machine # [ 0.220498] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear) machine # [ 0.220573] TCP: Hash tables configured (established 8192 bind 8192) machine # [ 0.220659] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear) machine # [ 0.220716] UDP hash table entries: 512 (order: 3, 32768 bytes, linear) machine # [ 0.220769] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear) machine # [ 0.220873] NET: Registered PF_UNIX/PF_LOCAL protocol family machine # [ 0.220894] NET: Registered PF_XDP protocol family machine # [ 0.220916] PCI: CLS 0 bytes, default 64 machine # [ 0.221173] Trying to unpack rootfs image as initramfs... machine # [ 0.238272] kvm [1]: HYP mode not available machine # [ 0.335011] Initialise system trusted keyrings machine # [ 0.335793] workingset: timestamp_bits=42 max_order=18 bucket_order=0 machine # [ 0.337031] squashfs: version 4.0 (2009/01/31) Phillip Lougher machine # [ 0.337864] 9p: Installing v9fs 9p2000 file system support machine # [ 0.366619] Key type asymmetric registered machine # [ 0.366649] Asymmetric key parser 'x509' registered machine # [ 0.366726] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 242) machine # [ 0.368894] io scheduler mq-deadline registered machine # [ 0.368905] io scheduler kyber registered machine # [ 0.378478] pl061_gpio 9030000.pl061: PL061 GPIO chip registered machine # [ 0.379864] ledtrig-cpu: registered to indicate activity on CPUs machine # [ 0.380264] pci-host-generic 4010000000.pcie: host bridge /pcie@10000000 ranges: machine # [ 0.380282] pci-host-generic 4010000000.pcie: IO 0x003eff0000..0x003effffff -> 0x0000000000 machine # [ 0.380295] pci-host-generic 4010000000.pcie: MEM 0x0010000000..0x003efeffff -> 0x0010000000 machine # [ 0.380303] pci-host-generic 4010000000.pcie: MEM 0x8000000000..0xffffffffff -> 0x8000000000 machine # [ 0.380324] pci-host-generic 4010000000.pcie: Memory resource size exceeds max for 32 bits machine # [ 0.380348] pci-host-generic 4010000000.pcie: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff] machine # [ 0.380429] pci-host-generic 4010000000.pcie: PCI host bridge to bus 0000:00 machine # [ 0.380438] pci_bus 0000:00: root bus resource [bus 00-ff] machine # [ 0.380444] pci_bus 0000:00: root bus resource [io 0x0000-0xffff] machine # [ 0.380449] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff] machine # [ 0.380454] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff] machine # [ 0.380510] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint machine # [ 0.380950] pci 0000:00:01.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint machine # [ 0.381137] pci 0000:00:01.0: BAR 0 [io 0x0000-0x001f] machine # [ 0.381154] pci 0000:00:01.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.381184] pci 0000:00:01.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.381201] pci 0000:00:01.0: ROM [mem 0x00000000-0x0003ffff pref] machine # [ 0.381667] pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint machine # [ 0.381868] pci 0000:00:02.0: BAR 0 [io 0x0000-0x001f] machine # [ 0.381885] pci 0000:00:02.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.381916] pci 0000:00:02.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.401995] pci 0000:00:03.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint machine # [ 0.402186] pci 0000:00:03.0: BAR 0 [io 0x0000-0x007f] machine # [ 0.402205] pci 0000:00:03.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.402235] pci 0000:00:03.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.410823] pci 0000:00:04.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint machine # [ 0.411039] pci 0000:00:04.0: BAR 0 [io 0x0000-0x001f] machine # [ 0.411057] pci 0000:00:04.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.411086] pci 0000:00:04.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.411107] pci 0000:00:04.0: ROM [mem 0x00000000-0x0003ffff pref] machine # [ 0.411553] pci 0000:00:05.0: [1af4:1050] type 00 class 0x038000 conventional PCI endpoint machine # [ 0.411742] pci 0000:00:05.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.411772] pci 0000:00:05.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.412217] pci 0000:00:06.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint machine # [ 0.412405] pci 0000:00:06.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.412436] pci 0000:00:06.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.412829] pci 0000:00:07.0: [8086:24cd] type 00 class 0x0c0320 conventional PCI endpoint machine # [ 0.413014] pci 0000:00:07.0: BAR 0 [mem 0x00000000-0x00000fff] machine # [ 0.413269] pci 0000:00:08.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint machine # [ 0.413457] pci 0000:00:08.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.413487] pci 0000:00:08.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.413943] pci 0000:00:09.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint machine # [ 0.414126] pci 0000:00:09.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.414157] pci 0000:00:09.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.430568] pci 0000:00:0a.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint machine # [ 0.430755] pci 0000:00:0a.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.430786] pci 0000:00:0a.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.431235] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint machine # [ 0.431536] pci 0000:00:0b.0: BAR 0 [io 0x0000-0x003f] machine # [ 0.431554] pci 0000:00:0b.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.431583] pci 0000:00:0b.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.432042] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint machine # [ 0.432221] pci 0000:00:0c.0: BAR 0 [io 0x0000-0x001f] machine # [ 0.432238] pci 0000:00:0c.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.432268] pci 0000:00:0c.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.432871] pci 0000:00:01.0: ROM [mem 0x10000000-0x1003ffff pref]: assigned machine # [ 0.432883] pci 0000:00:04.0: ROM [mem 0x10040000-0x1007ffff pref]: assigned machine # [ 0.432889] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned machine # [ 0.432934] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]: assigned machine # [ 0.432982] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]: assigned machine # [ 0.433030] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]: assigned machine # [ 0.433077] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]: assigned machine # [ 0.433124] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]: assigned machine # [ 0.433171] pci 0000:00:08.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]: assigned machine # [ 0.433218] pci 0000:00:09.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]: assigned machine # [ 0.433266] pci 0000:00:0a.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]: assigned machine # [ 0.433312] pci 0000:00:0b.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]: assigned machine # [ 0.433398] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]: assigned machine # [ 0.433444] pci 0000:00:01.0: BAR 1 [mem 0x10080000-0x10080fff]: assigned machine # [ 0.433467] pci 0000:00:02.0: BAR 1 [mem 0x10081000-0x10081fff]: assigned machine # [ 0.433490] pci 0000:00:03.0: BAR 1 [mem 0x10082000-0x10082fff]: assigned machine # [ 0.433512] pci 0000:00:04.0: BAR 1 [mem 0x10083000-0x10083fff]: assigned machine # [ 0.433535] pci 0000:00:05.0: BAR 1 [mem 0x10084000-0x10084fff]: assigned machine # [ 0.433558] pci 0000:00:06.0: BAR 1 [mem 0x10085000-0x10085fff]: assigned machine # [ 0.433580] pci 0000:00:07.0: BAR 0 [mem 0x10086000-0x10086fff]: assigned machine # [ 0.433604] pci 0000:00:08.0: BAR 1 [mem 0x10087000-0x10087fff]: assigned machine # [ 0.433630] pci 0000:00:09.0: BAR 1 [mem 0x10088000-0x10088fff]: assigned machine # [ 0.433653] pci 0000:00:0a.0: BAR 1 [mem 0x10089000-0x10089fff]: assigned machine # [ 0.433676] pci 0000:00:0b.0: BAR 1 [mem 0x1008a000-0x1008afff]: assigned machine # [ 0.433712] pci 0000:00:0c.0: BAR 1 [mem 0x1008b000-0x1008bfff]: assigned machine # [ 0.433736] pci 0000:00:03.0: BAR 0 [io 0x1000-0x107f]: assigned machine # [ 0.433758] pci 0000:00:0b.0: BAR 0 [io 0x1080-0x10bf]: assigned machine # [ 0.433780] pci 0000:00:01.0: BAR 0 [io 0x10c0-0x10df]: assigned machine # [ 0.433805] pci 0000:00:02.0: BAR 0 [io 0x10e0-0x10ff]: assigned machine # [ 0.433827] pci 0000:00:04.0: BAR 0 [io 0x1100-0x111f]: assigned machine # [ 0.433850] pci 0000:00:0c.0: BAR 0 [io 0x1120-0x113f]: assigned machine # [ 0.433878] pci_bus 0000:00: resource 4 [io 0x0000-0xffff] machine # [ 0.433888] pci_bus 0000:00: resource 5 [mem 0x10000000-0x3efeffff] machine # [ 0.433893] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff] machine # [ 0.478796] pci 0000:00:07.0: enabling device (0000 -> 0002) machine # [ 0.504544] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003) machine # [ 0.514526] virtio-pci 0000:00:02.0: enabling device (0000 -> 0003) machine # [ 0.518225] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003) machine # [ 0.520377] virtio-pci 0000:00:04.0: enabling device (0000 -> 0003) machine # [ 0.530466] virtio-pci 0000:00:05.0: enabling device (0000 -> 0002) machine # [ 0.533239] virtio-pci 0000:00:06.0: enabling device (0000 -> 0002) machine # [ 0.543253] virtio-pci 0000:00:08.0: enabling device (0000 -> 0002) machine # [ 0.545215] virtio-pci 0000:00:09.0: enabling device (0000 -> 0002) machine # [ 0.548842] virtio-pci 0000:00:0a.0: enabling device (0000 -> 0002) machine # [ 0.555309] virtio-pci 0000:00:0b.0: enabling device (0000 -> 0003) machine # [ 0.563383] virtio-pci 0000:00:0c.0: enabling device (0000 -> 0003) machine # [ 0.579399] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled machine # [ 0.581879] msm_serial: driver initialized machine # [ 0.582030] SuperH (H)SCI(F) driver initialized machine # [ 0.582083] STM32 USART driver initialized machine # [ 0.613102] loop: module loaded machine # [ 0.613299] virtio_blk virtio2: 1/0/0 default/read/poll queues machine # [ 0.614374] virtio_blk virtio2: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) machine # [ 0.626900] megasas: 07.734.00.00-rc1 machine # [ 0.627603] physmap-flash 0.flash: physmap platform flash device: [mem 0x00000000-0x03ffffff] machine # [ 0.629616] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000 machine # [ 0.629644] Intel/Sharp Extended Query Table at 0x0031 machine # [ 0.631407] Using buffer write method machine # [ 0.631484] physmap-flash 0.flash: physmap platform flash device: [mem 0x04000000-0x07ffffff] machine # [ 0.633462] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000 machine # [ 0.633487] Intel/Sharp Extended Query Table at 0x0031 machine # [ 0.647218] Using buffer write method machine # [ 0.647246] Concatenating MTD devices: machine # [ 0.647251] (0): "0.flash" machine # [ 0.647254] (1): "0.flash" machine # [ 0.647258] into device "0.flash" machine # [ 0.916731] Freeing initrd memory: 26408K machine # [ 0.922996] tun: Universal TUN/TAP device driver, 1.6 machine # [ 0.926983] thunder_xcv, ver 1.0 machine # [ 0.927024] thunder_bgx, ver 1.0 machine # [ 0.927046] nicpf, ver 1.0 machine # [ 0.927610] e1000: Intel(R) PRO/1000 Network Driver machine # [ 0.927622] e1000: Copyright (c) 1999-2006 Intel Corporation. machine # [ 0.927651] e1000e: Intel(R) PRO/1000 Network Driver machine # [ 0.927660] e1000e: Copyright(c) 1999 - 2015 Intel Corporation. machine # [ 0.927688] igb: Intel(R) Gigabit Ethernet Network Driver machine # [ 0.927693] igb: Copyright (c) 2007-2014 Intel Corporation. machine # [ 0.927715] igbvf: Intel(R) Gigabit Virtual Function Network Driver machine # [ 0.927721] igbvf: Copyright (c) 2009 - 2012 Intel Corporation. machine # [ 0.927867] sky2: driver version 1.30 machine # [ 0.929547] usbcore: registered new interface driver usb-storage machine # [ 0.929656] usbcore: registered new interface driver usbserial_generic machine # [ 0.929673] usbserial: USB Serial support registered for generic machine # [ 0.931046] ehci-pci 0000:00:07.0: EHCI Host Controller machine # [ 0.931085] ehci-pci 0000:00:07.0: new USB bus registered, assigned bus number 1 machine # [ 0.931327] ehci-pci 0000:00:07.0: irq 16, io mem 0x10086000 machine # [ 0.943285] ehci-pci 0000:00:07.0: USB 2.0 started, EHCI 1.00 machine # [ 0.943709] hub 1-0:1.0: USB hub found machine # [ 0.943735] hub 1-0:1.0: 6 ports detected machine # [ 0.946068] hv_vmbus: registering driver hyperv_keyboard machine # [ 0.947757] rtc-pl031 9010000.pl031: registered as rtc0 machine # [ 0.947787] rtc-pl031 9010000.pl031: setting system clock to 2026-09-15T21:17:41 UTC (1789507061) machine # [ 0.948088] i2c_dev: i2c /dev entries driver machine # [ 0.953439] sdhci: Secure Digital Host Controller Interface driver machine # [ 0.953457] sdhci: Copyright(c) Pierre Ossman machine # [ 0.953730] Synopsys Designware Multimedia Card Interface Driver machine # [ 0.954093] sdhci-pltfm: SDHCI platform and OF driver helper machine # [ 0.958535] hid: raw HID events driver (C) Jiri Kosina machine # [ 0.958770] usbcore: registered new interface driver usbhid machine # [ 0.958777] usbhid: USB HID core driver machine # [ 0.961782] hw perfevents: enabled with armv8_pmuv3 PMU driver, 11 (0,800003ff) counters available machine # [ 0.964515] drop_monitor: Initializing network drop monitor service machine # [ 0.964682] NET: Registered PF_INET6 protocol family machine # [ 0.966992] Segment Routing with IPv6 machine # [ 0.967013] In-situ OAM (IOAM) with IPv6 machine # [ 0.967044] NET: Registered PF_PACKET protocol family machine # [ 0.968728] 9pnet: Installing 9P2000 support machine # [ 0.968776] Key type dns_resolver registered machine # [ 0.976118] registered taskstats version 1 machine # [ 0.976271] Loading compiled-in X.509 certificates machine # [ 0.985471] Demotion targets for Node 0: null machine # [ 0.985614] Key type .fscrypt registered machine # [ 0.985627] Key type fscrypt-provisioning registered machine # [ 0.985753] ima: No TPM chip found, activating TPM-bypass! machine # [ 0.985773] ima: Allocated hash algorithm: sha1 machine # [ 0.985798] ima: No architecture policies found machine # [ 0.989998] input: gpio-keys as /devices/platform/gpio-keys/input/input0 machine # [ 1.010140] clk: Disabling unused clocks machine # [ 1.010174] PM: genpd: Disabling unused power domains machine # [ 1.014665] Freeing unused kernel memory: 4736K machine # [ 1.014882] Run /init as init process machine # [ 1.032641] systemd[1]: Successfully made /usr/ read-only. machine # [ 1.190325] usb 1-1: new high-speed USB device number 2 using ehci-pci machine # [ 1.345351] input: QEMU QEMU USB Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:07.0/usb1/1-1/1-1:1.0/0003:0627:0001.0001/input/input1 machine # [ 1.367856] systemd[1]: systemd 262-e2c8482 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.380370] systemd[1]: Detected virtualization qemu. machine # [ 1.382670] systemd[1]: Detected architecture arm64. machine # [ 1.384650] systemd[1]: Running in initrd. machine # [ 1.387727] systemd[1]: Initializing machine ID from random generator. machine # [ 1.391002] systemd[1]: Hostname set to . machine # [ 1.438630] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v1.11 Keyboard [QEMU QEMU USB Keyboard] on usb-0000:00:07.0-1/input0 machine # [ 1.562306] usb 1-2: new high-speed USB device number 3 using ehci-pci machine # [ 1.568679] systemd[1]: bpf-restrict-fs: LSM BPF program attached machine # [ 1.628541] systemd[1]: Queued start job for default target Initrd Default Target. machine # [ 1.636596] systemd[1]: Created slice Slice /system/modprobe. machine # [ 1.637720] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. machine # [ 1.638853] systemd[1]: Expecting device /dev/disk/by-label/nixos... machine # [ 1.639672] systemd[1]: Reached target Path Units. machine # [ 1.640297] systemd[1]: Reached target Slice Units. machine # [ 1.640953] systemd[1]: Reached target Swaps. machine # [ 1.641625] systemd[1]: Reached target Timer Units. machine # [ 1.642452] systemd[1]: Listening on D-Bus System Message Bus Socket. machine # [ 1.643428] systemd[1]: Listening on Journal Socket (/dev/log). machine # [ 1.644334] systemd[1]: Listening on Journal Sockets. machine # [ 1.645061] systemd[1]: Listening on udev Kernel Socket. machine # [ 1.645758] systemd[1]: Reached target Socket Units. machine # [ 1.647847] systemd[1]: Starting Create List of Static Device Nodes... machine # [ 1.648816] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs machine # [ 1.655743] systemd[1]: Mounting Kernel Configuration File System... machine # [ 1.666745] systemd[1]: Starting Journal Service... machine # [ 1.686466] systemd[1]: Starting Load Kernel Modules... machine # [ 1.687346] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 1.694559] systemd[1]: Starting Coldplug All udev Devices... machine # [ 1.716753] systemd[1]: Finished Create List of Static Device Nodes. machine # [ 1.717945] systemd[1]: Mounted Kernel Configuration File System. machine # [ 1.726867] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... machine # [ 1.730108] input: QEMU QEMU USB Tablet as /devices/platform/4010000000.pcie/pci0000:00/0000:00:07.0/usb1/1-2/1-2:1.0/0003:0627:0001.0002/input/input2 machine # [ 1.732050] hid-generic 0003:0627:0001.0002: input,hidraw1: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:07.0-2/input0 machine # [ 1.770951] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. machine # [ 1.777017] systemd-journald[72]: Collecting audit messages is disabled. machine # [ 1.790331] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev machine # [ 1.796888] [drm] pci: virtio-gpu-pci detected at 0000:00:05.0 machine # [ 1.797139] [drm] features: -virgl +edid -resource_blob -host_visible machine # [ 1.797148] [drm] features: -context_init machine # [ 1.797961] [drm] number of scanouts: 1 machine # [ 1.797980] [drm] number of cap sets: 0 machine # [ 1.815126] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. machine # [ 1.822709] systemd[1]: Starting Create Static Device Nodes in /dev... machine # [ 1.830600] virtio-pci 0000:00:05.0: [drm] Registered 1 planes with drm panic machine # [ 1.830625] [drm] Initialized virtio_gpu 0.1.0 for 0000:00:05.0 on minor 0 machine # [ 1.882317] Console: switching to colour frame buffer device 160x50 machine # [ 1.883037] virtio-pci 0000:00:05.0: [drm] fb0: virtio_gpudrmfb frame buffer device machine # [ 1.886829] systemd[1]: Finished Create Static Device Nodes in /dev. machine # [ 1.887112] systemd[1]: Reached target Preparation for Local File Systems. machine # [ 1.887149] systemd[1]: Reached target Local File Systems. machine # [ 1.898696] systemd[1]: Starting Rule-based Manager for Device Events and Files... machine # [ 1.914452] systemd[1]: Finished Load Kernel Modules. machine # [ 1.922720] systemd[1]: Starting Apply Kernel Variables... machine # [ 1.951486] systemd-modules-load[73]: Inserted module 'dm_mod' machine # [ 1.966749] systemd[1]: Started Journal Service. machine # [ 1.956247] systemd-modules-load[73]: Module 'virtio_balloon' is built in machine # [ 1.957448] systemd-modules-load[73]: Module 'virtio_console' is built in machine # [ 1.958626] systemd-modules-load[73]: Inserted module 'virtio_gpu' machine # [ 1.959666] systemd-modules-load[73]: Module 'virtio_rng' is built in machine # [ 1.976961] systemd[1]: Starting Create System Files and Directories... machine # [ 1.989274] systemd[1]: Finished Apply Kernel Variables. machine # [ 2.015657] systemd-udevd[78]: Using default interface naming scheme 'v261'. machine # [ 2.034089] systemd[1]: Finished Create System Files and Directories. machine # [ 2.058654] systemd[1]: Started Rule-based Manager for Device Events and Files. machine # [ 2.147782] systemd[1]: Starting Virtual Console Setup... machine # [ 2.232575] systemd-vconsole-setup[100]: Configuration of first virtual console was skipped, ignoring remaining ones. machine # [ 2.237728] systemd[1]: Finished Virtual Console Setup. machine # [ 2.918119] systemd[1]: Finished Coldplug All udev Devices. machine # [ 2.919138] systemd[1]: Reached target System Initialization. machine # [ 2.920008] systemd[1]: Reached target Basic System. machine # [ 3.098478] (udev-worker)[89]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. machine # [ 3.113777] (udev-worker)[89]: Network interface NamePolicy= disabled on kernel command line. machine # [ 3.204668] systemd[1]: Found device /dev/disk/by-label/nixos. machine # [ 3.207865] systemd[1]: Reached target Initrd Root Device. machine # [ 3.210775] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos... machine # [ 3.274909] systemd-fsck[109]: nixos: clean, 12/65536 files, 13019/262144 blocks machine # [ 3.280064] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos. machine # [ 3.290207] systemd[1]: Mounting /sysroot... machine # [ 3.348410] EXT4-fs (vda): mounted filesystem e516168d-bc38-4009-9518-f0c8771e8f6b r/w with ordered data mode. Quota mode: none. machine # [ 3.340209] systemd[1]: Mounted /sysroot. machine # [ 3.342665] systemd[1]: Reached target Initrd Root File System. machine # [ 3.348183] systemd[1]: Starting Mountpoints Configured in the Real Root... machine # [ 3.381709] systemd-sysroot-fstab-check[118]: /sysroot should be mounted in the initrd, will request daemon-reload. machine # [ 3.387143] systemd[1]: Reload requested from client PID 118 ('systemd-sysroot') (unit initrd-parse-etc.service)... machine # [ 3.392916] systemd[1]: Reloading... machine # [ 3.611918] systemd[1]: Reloading finished in 221 ms. machine # [ 3.648222] systemd-sysroot-fstab-check[118]: Requesting initrd-fs.target/start/replace... machine # [ 3.652701] systemd-sysroot-fstab-check[118]: Requesting swap.target/start/replace... machine # [ 3.657441] systemd[1]: initrd-parse-etc.service: Deactivated successfully. machine # [ 3.661188] systemd[1]: Finished Mountpoints Configured in the Real Root. machine # [ 3.664214] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies. machine # [ 3.702325] systemd[1]: Mounting /sysroot/nix/.ro-store... machine # [ 3.705437] systemd[1]: Mounting /sysroot/nix/.rw-store... machine # [ 3.725946] systemd[1]: Mounting /sysroot/run... machine # [ 3.738811] systemd[1]: Mounting /sysroot/tmp/shared... machine # [ 3.771836] systemd[1]: Mounting /sysroot/tmp/xchg... machine # [ 3.867130] fuse: init (API version 7.45) machine # [ 3.862718] systemd[1]: Mounted /sysroot/nix/.rw-store. machine # [ 3.884983] virtiofs virtio6: discovered new tag: nix-store machine # [ 3.885875] virtiofs virtio6: virtio_fs_setup_dax: No cache capability machine # [ 3.873873] systemd[1]: Mounted /sysroot/run. machine # [ 3.900177] virtiofs virtio7: discovered new tag: shared machine # [ 3.900990] virtiofs virtio7: virtio_fs_setup_dax: No cache capability machine # [ 3.907222] virtiofs virtio8: discovered new tag: xchg machine # [ 3.907987] virtiofs virtio8: virtio_fs_setup_dax: No cache capability machine # [ 3.895377] systemd[1]: Starting rw-sysroot-nix-store.service... machine # [ 3.918454] systemd[1]: Mounted /sysroot/nix/.ro-store. machine # [ 3.924294] systemd[1]: Mounted /sysroot/tmp/shared. machine # [ 3.930271] systemd[1]: Mounted /sysroot/tmp/xchg. machine # [ 3.938638] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. machine # [ 3.940963] systemd[1]: Finished rw-sysroot-nix-store.service. machine # [ 4.700170] systemd[1]: Mounting /sysroot/nix/store... machine # [ 4.756112] systemd[1]: Mounted /sysroot/nix/store. machine # [ 4.757039] systemd[1]: Reached target Initrd File Systems. machine # [ 4.764261] systemd[1]: Starting Find NixOS closure... machine # [ 4.769906] systemd[1]: Starting Create Volatile Files and Directories in the Real Root... machine # [ 4.817953] systemd[1]: Finished Create Volatile Files and Directories in the Real Root. machine # [ 4.820239] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully. machine # [ 4.840247] systemd[1]: Finished Find NixOS closure. machine # [ 4.843716] systemd[1]: Reached target Initrd Default Target. machine # [ 4.855091] systemd[1]: Starting Cleaning Up and Shutting Down Daemons... machine # [ 4.874757] (udev-worker)[93]: mtd0ro: Failed to find and pin callout binary "/nix/store/yf6qr0y28a50mnhgyrfdk0hmnvgr6c9d-systemd-262-e2c8482/lib/udev/mtd_probe": No such file or directory machine # [ 4.882501] (udev-worker)[93]: mtd0ro: /etc/udev/rules.d/75-probe_mtd.rules:5 IMPORT{program}="mtd_probe $devnode": Failed to execute "mtd_probe /dev/mtd0ro", ignoring: No such file or directory machine # [ 4.906454] systemd[1]: Stopped target Initrd Default Target. machine # [ 4.909292] systemd[1]: Stopped target Basic System. machine # [ 4.913525] systemd[1]: Stopped target Initrd Root Device. machine # [ 4.915395] systemd[1]: Stopped target Path Units. machine # [ 4.921000] systemd[1]: systemd-ask-password-console.path: Deactivated successfully. machine # [ 4.924220] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch. machine # [ 4.927608] systemd[1]: Stopped target Slice Units. machine # [ 4.934132] systemd[1]: Stopped target Socket Units. machine # [ 4.935014] systemd[1]: Stopped target System Initialization. machine # [ 4.935917] systemd[1]: Stopped target Swaps. machine # [ 4.940447] systemd[1]: Stopped target Timer Units. machine # [ 4.944591] systemd[1]: dbus.socket: Deactivated successfully. machine # [ 4.946925] systemd[1]: Closed D-Bus System Message Bus Socket. machine # [ 4.949756] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully. machine # [ 4.955482] systemd[1]: Stopped Find NixOS closure. machine # [ 4.956723] systemd[1]: Starting rw-sysroot-nix-store.service... machine # [ 4.968304] systemd[1]: systemd-sysctl.service: Deactivated successfully. machine # [ 4.969555] systemd[1]: Stopped Apply Kernel Variables. machine # [ 4.971862] systemd[1]: systemd-modules-load.service: Deactivated successfully. machine # [ 4.981790] systemd[1]: Stopped Load Kernel Modules. machine # [ 4.982786] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully. machine # [ 4.989839] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root. machine # [ 4.994316] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. machine # [ 5.001621] systemd[1]: Stopped Create System Files and Directories. machine # [ 5.003200] systemd[1]: Stopped target Local File Systems. machine # [ 5.005069] systemd[1]: Stopped target Preparation for Local File Systems. machine # [ 5.011091] systemd[1]: systemd-udev-trigger.service: Deactivated successfully. machine # [ 5.014435] systemd[1]: Stopped Coldplug All udev Devices. machine # [ 5.015264] systemd[1]: Stopping Rule-based Manager for Device Events and Files... machine # [ 5.018433] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. machine # [ 5.024728] systemd[1]: Stopped Virtual Console Setup. machine # [ 5.025586] systemd[1]: initrd-cleanup.service: Deactivated successfully. machine # [ 5.026555] systemd[1]: Finished Cleaning Up and Shutting Down Daemons. machine # [ 5.028252] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. machine # [ 5.032198] systemd[1]: Finished rw-sysroot-nix-store.service. machine # [ 5.033151] systemd[1]: Starting Virtual Console Setup... machine # [ 5.042373] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. machine # [ 5.047680] systemd[1]: Stopped Virtual Console Setup. machine # [ 5.053216] systemd[1]: Starting Virtual Console Setup... machine # [ 5.070619] systemd[1]: systemd-udevd.service: Deactivated successfully. machine # [ 5.072263] systemd[1]: Stopped Rule-based Manager for Device Events and Files. machine # [ 5.076336] systemd[1]: systemd-udevd.service: Consumed 1.755s CPU time over 3.189s wall clock time, 21.5M memory peak. machine # [ 5.081627] systemd[1]: Starting Cleanup udev Database... machine # [ 5.084244] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. machine # [ 5.091156] systemd[1]: Stopped Create Static Device Nodes in /dev. machine # [ 5.092366] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. machine # [ 5.093498] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully. machine # [ 5.094493] systemd[1]: kmod-static-nodes.service: Deactivated successfully. machine # [ 5.095510] systemd[1]: Stopped Create List of Static Device Nodes. machine # [ 5.120655] systemd-vconsole-setup[172]: Configuration of first virtual console was skipped, ignoring remaining ones. machine # [ 5.128289] systemd[1]: Finished Virtual Console Setup. machine # [ 5.157941] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. machine # [ 5.160896] systemd[1]: Finished Cleanup udev Database. machine # [ 5.163540] systemd[1]: Reached target Switch Root. machine # [ 5.165150] systemd[1]: Starting NixOS Activation... machine # [ 5.262408] initrd-nixos-activation-start[178]: booting system configuration /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test machine # [ 5.301042] initrd-nixos-activation-start[178]: running activation script... machine # [ 5.595001] initrd-nixos-activation-start[201]: setting up /etc... machine # [ 5.739098] systemd[1]: initrd-nixos-activation.service: Deactivated successfully. machine # [ 5.742826] systemd[1]: Finished NixOS Activation. machine # [ 5.744223] systemd[1]: Starting Switch Root... machine # [ 5.770733] systemd[1]: Switching root. machine # [ 5.977089] systemd-journald[72]: Received SIGTERM from PID 1 (systemd). machine # [ 6.531898] systemd[1]: systemd 262-e2c8482 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.545065] systemd[1]: Detected virtualization qemu. machine # [ 6.548591] systemd[1]: Detected architecture arm64. machine # [ 6.552865] systemd[1]: Detected first boot. machine # [ 6.559978] systemd[1]: Initializing machine ID from random generator. machine # [ 6.713134] systemd[1]: bpf-restrict-fs: LSM BPF program attached machine # [ 6.880221] systemd[1]: Applying preset policy. machine # [ 7.152735] systemd[1]: Populated /etc with preset unit settings. machine # [ 7.393952] systemd[1]: initrd-switch-root.service: Deactivated successfully. machine # [ 7.395840] systemd[1]: Stopped initrd-switch-root.service. machine # [ 7.400644] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. machine # [ 7.405208] systemd[1]: Created slice Slice /system/getty. machine # [ 7.408443] systemd[1]: Created slice User and Session Slice. machine # [ 7.410886] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. machine # [ 7.413331] systemd[1]: Started Forward Password Requests to Wall Directory Watch. machine # [ 7.415878] systemd[1]: Expecting device /dev/hvc0... machine # [ 7.417822] systemd[1]: Expecting device /dev/ttyAMA0... machine # [ 7.420039] systemd[1]: Reached target Local Encrypted Volumes. machine # [ 7.422088] systemd[1]: Stopped target initrd-fs.target. machine # [ 7.424127] systemd[1]: Stopped target initrd-root-fs.target. machine # [ 7.426441] systemd[1]: Stopped target initrd-switch-root.target. machine # [ 7.428455] systemd[1]: Reached target Virtual Machines and Containers. machine # [ 7.430746] systemd[1]: Reached target Path Units. machine # [ 7.432671] systemd[1]: Reached target Remote File Systems. machine # [ 7.434857] systemd[1]: Reached target Slice Units. machine # [ 7.436782] systemd[1]: Reached target Swaps. machine # [ 7.440296] systemd[1]: Listening on Query the User Interactively for a Password. machine # [ 7.443575] systemd[1]: Listening on Process Core Dump Socket. machine # [ 7.445882] systemd[1]: Listening on Credential Encryption/Decryption. machine # [ 7.448216] systemd[1]: Listening on Factory Reset Management. machine # [ 7.449520] systemd[1]: Listening on Hostname Service Socket. machine # [ 7.454121] systemd[1]: Starting Journal Log Access Socket... machine # [ 7.456385] systemd[1]: Listening on Journal Audit Socket. machine # [ 7.460149] systemd[1]: Listening on Console Output Muting Service Socket. machine # [ 7.461785] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket. machine # [ 7.463549] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 7.466960] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 7.474279] systemd[1]: Listening on Disk Repartitioning Service Socket. machine # [ 7.475771] systemd[1]: Listening on udev Varlink Socket. machine # [ 7.479677] systemd[1]: Mounting Huge Pages File System... machine # [ 7.487266] systemd[1]: Mounting POSIX Message Queue File System... machine # [ 7.491582] systemd[1]: Mounting Kernel Debug File System... machine # [ 7.510113] systemd[1]: Mounting Kernel Trace File System... machine # [ 7.525997] systemd[1]: Starting Create List of Static Device Nodes... machine # [ 7.528494] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs machine # [ 7.546637] systemd[1]: Mounting Kernel Configuration File System... machine # [ 7.549027] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm machine # [ 7.555466] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 7.558683] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse machine # [ 7.589501] systemd[1]: Mounting FUSE Control File System... machine # [ 7.598893] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 7.621550] systemd[1]: Starting Journal Service... machine # [ 7.635850] systemd[1]: Starting Load Kernel Modules... machine # [ 7.662459] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer... machine # [ 7.674956] systemd[1]: Starting Remount Root and Kernel File Systems... machine # [ 7.677468] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 7.692402] systemd-journald[273]: Collecting audit messages is enabled. machine # [ 7.700798] systemd[1]: Starting Coldplug All udev Devices... machine # [ 7.703418] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. machine # [ 7.704788] systemd[1]: Stopped Virtual Console Setup. machine # [ 7.688838] systemd[1]: Queued start job for default target Multi-User System. machine # [ 7.690279] systemd[1]: systemd-journald.service: Deactivated successfully. machine # [ 7.712880] systemd[1]: Started Journal Service. machine # [ 7.716663] systemd[1]: Listening on Journal Log Access Socket. machine # [ 7.719417] systemd[1]: Mounted Huge Pages File System. machine # [ 7.724349] systemd[1]: Mounted POSIX Message Queue File System. machine # [ 7.725241] systemd[1]: Mounted Kernel Debug File System. machine # [ 7.726013] systemd[1]: Mounted Kernel Trace File System. machine # [ 7.736468] systemd[1]: Finished Create List of Static Device Nodes. machine # [ 7.737549] systemd[1]: Mounted Kernel Configuration File System. machine # [ 7.764493] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... machine # [ 7.765963] systemd-modules-load[274]: Module 'atkbd' is built in machine # [ 7.776162] systemd-modules-load[274]: Module 'loop' is built in machine # [ 7.777238] systemd[1]: Mounted FUSE Control File System. machine # [ 7.806402] EXT4-fs (vda): re-mounted e516168d-bc38-4009-9518-f0c8771e8f6b. machine # [ 7.792443] systemd[1]: Finished Load Kernel Modules. machine # [ 7.807198] systemd[1]: Starting Firewall... machine # [ 7.818580] systemd[1]: Starting Apply Kernel Variables... machine # [ 7.827028] systemd[1]: Finished Remount Root and Kernel File Systems. machine # [ 7.828346] systemd[1]: Listening on Disk Image Download Service Socket. machine # [ 7.838195] systemd[1]: Starting Flush Journal to Persistent Storage... machine # [ 7.839218] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 7.848568] systemd-oomd[276]: No swap; memory pressure usage will be degraded machine # [ 7.864370] systemd[1]: Starting Load/Save OS Random Seed... machine # [ 7.865347] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 7.871123] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer. machine # [ 7.969174] systemd[1]: Finished Load/Save OS Random Seed. machine # [ 7.990583] systemd-journald[273]: Received client request to flush runtime journal. machine # [ 8.024426] systemd[1]: Reached target First Boot Complete. machine # [ 8.031101] systemd[1]: Finished Flush Journal to Persistent Storage. machine # [ 8.054539] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. machine # [ 8.063724] systemd[1]: Starting Create Static Device Nodes in /dev... machine # [ 8.068754] systemd[1]: Finished Apply Kernel Variables. machine # [ 8.361102] systemd[1]: Finished Create Static Device Nodes in /dev. machine # [ 8.365700] systemd[1]: Reached target Preparation for Local File Systems. machine # [ 8.370585] systemd[1]: Starting Rule-based Manager for Device Events and Files... machine # [ 8.395669] systemd[1]: Mounting /run/wrappers... machine # [ 8.480870] systemd[1]: Mounted /run/wrappers. machine # [ 8.481684] systemd[1]: Reached target Local File Systems. machine # [ 8.486981] systemd[1]: Listening on Boot Loader Control Service Socket. machine # [ 8.493154] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 8.494103] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 8.504989] systemd[1]: Starting Save Transient machine-id to Disk... machine # [ 8.507056] systemd[1]: Starting Create System Files and Directories... machine # [ 8.572680] systemd-udevd[310]: Using default interface naming scheme 'v261'. machine # [ 8.636073] systemd[1]: etc-machine\x2did.mount: Deactivated successfully. machine # [ 8.650212] systemd[1]: Finished Save Transient machine-id to Disk. machine # [ 8.735519] systemd[1]: Finished Create System Files and Directories. machine # [ 8.743554] systemd[1]: Starting Rebuild Journal Catalog... machine # [ 8.751741] systemd[1]: Starting Record System Boot/Shutdown in UTMP... machine # [ 8.792467] systemd[1]: Started Rule-based Manager for Device Events and Files. machine # [ 8.937553] systemd[1]: Finished Record System Boot/Shutdown in UTMP. machine # [ 8.980085] systemd[1]: Finished Rebuild Journal Catalog. machine # [ 8.992684] systemd[1]: Starting Update is Completed... machine # [ 9.120599] systemd[1]: Finished Update is Completed. machine # [ 9.213592] systemd[1]: Finished Coldplug All udev Devices. machine # [ 9.340689] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs machine # [ 9.386090] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse machine # [ 9.450177] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 9.454411] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 9.462978] systemd[1]: Reached target System Initialization. machine # [ 9.463947] systemd[1]: Started Discard unused filesystem blocks once a week. machine # [ 9.469184] systemd[1]: Started Daily Cleanup of Temporary Directories. machine # [ 9.470220] systemd[1]: Reached target Timer Units. machine # [ 9.470945] systemd[1]: Listening on D-Bus System Message Bus Socket. machine # [ 9.471871] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket. machine # [ 9.484189] systemd[1]: Reached target Socket Units. machine # [ 9.484994] systemd[1]: Reached target Basic System. machine # [ 9.485734] systemd[1]: Starting Import lastlog data into lastlog2 database... machine # [ 9.486726] systemd[1]: Starting Name Service Cache Daemon (nsncd)... machine # [ 9.497163] systemd[1]: Starting Post-Boot Actions... machine # [ 9.514515] systemd[1]: Started Reset console on configuration changes. machine # [ 9.549282] systemd[1]: Starting resolvconf update... machine # [ 9.602565] systemd[1]: Starting D-Bus System Message Bus... machine # [ 9.647967] nsncd[427]: Sep 15 21:17:50.217 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" machine # [ 9.663579] systemd[1]: Started Name Service Cache Daemon (nsncd). machine # [ 9.676242] systemd[1]: Reached target Host and Network Name Lookups. machine # [ 9.677310] systemd[1]: Reached target User and Group Name Lookups. machine # [ 9.712609] systemd[1]: Starting User Login Management... machine # [ 9.719642] systemd[1]: Finished Post-Boot Actions. machine # [ 9.806361] systemd[1]: Finished Import lastlog data into lastlog2 database. machine # [ 9.823287] systemd[1]: Condition check resulted in /dev/hvc0 being skipped. machine # [ 9.860218] systemd[1]: Condition check resulted in /dev/ttyAMA0 being skipped. machine # [ 9.873797] systemd[1]: Started backdoor.service. machine # [ 9.877796] dbus-broker-launch[434]: Looking up NSS user entry for 'systemd-timesync'... machine # [ 9.906012] dbus-broker-launch[434]: NSS returned no entry for 'systemd-timesync' machine # [ 9.907225] dbus-broker-launch[434]: Invalid user-name in /nix/store/vcpvwcmmxjnida0r2hbxc1gdb3y5crj8-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" machine # [ 9.955605] systemd-logind[451]: New seat seat0. machine # [ 9.961628] systemd[1]: Started D-Bus System Message Bus. machine # [ 9.962434] systemd[1]: Started User Login Management. machine # [ 9.979782] systemd[1]: Starting linger-users.service... machine # [ 10.039893] dbus-broker-launch[434]: Ready machine # connecting to host... machine # [ 10.100397] systemd[1]: Stopped target Host and Network Name Lookups. machine # [ 10.107712] systemd[1]: Stopping Host and Network Name Lookups... machine # [ 10.116310] systemd[1]: Stopped target User and Group Name Lookups. machine # [ 10.117267] systemd[1]: Stopping User and Group Name Lookups... machine # [ 10.118068] systemd[1]: Stopping Name Service Cache Daemon (nsncd)... machine # [ 10.118922] systemd[1]: nscd.service: Deactivated successfully. machine # [ 10.133771] systemd[1]: Stopped Name Service Cache Daemon (nsncd). machine: Guest shell says: b'Spawning backdoor root shell...\n' machine: connected to guest root shell machine: (connecting took 10.46 seconds) machine: (finished: waiting for the VM to finish booting, in 10.96 seconds) machine # [ 10.161304] systemd[1]: Starting Name Service Cache Daemon (nsncd)... machine # [ 10.259148] systemd[1]: Created slice Slice /user/1001. machine # [ 10.292528] systemd[1]: Starting User Runtime Directory /run/user/1001... machine # [ 10.320668] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 10.322053] (udev-worker)[382]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. machine # [ 10.376459] (udev-worker)[382]: Network interface NamePolicy= disabled on kernel command line. machine # [ 10.377680] systemd[1]: Finished linger-users.service. machine # [ 10.463483] systemd[1]: Started Name Service Cache Daemon (nsncd). machine # [ 10.473689] nsncd[522]: Sep 15 21:17:51.018 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" machine # [ 10.475847] systemd[1]: Reached target Host and Network Name Lookups. machine # [ 10.536366] systemd[1]: Reached target User and Group Name Lookups. machine # [ 10.537368] systemd[1]: Condition check resulted in Virtio network device being skipped. machine # [ 10.586911] systemd[1]: Finished resolvconf update. machine # [ 10.587878] systemd[1]: Starting DHCP Client... machine # [ 10.640248] systemd[1]: Finished User Runtime Directory /run/user/1001. machine # [ 10.641327] systemd[1]: Starting User Manager for UID 1001... machine # [ 10.675146] systemd-logind[451]: Watching system buttons on /dev/input/event0 (gpio-keys) machine # [ 10.796365] (systemd)[568]: pam_unix(systemd-user:session): session opened for user usertest(uid=1001) by (uid=0) machine # [ 10.834398] systemd-logind[451]: New session '1' of user 'usertest' with class 'manager' and type 'unspecified'. machine # [ 10.874855] mousedev: PS/2 mouse device common for all mice machine # [ 10.899845] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 11.181391] systemd-logind[451]: Watching system buttons on /dev/input/event1 (QEMU QEMU USB Keyboard) machine # [ 11.221411] systemd[568]: Queued start job for default target Main User Target. machine # [ 11.222544] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 11.281058] systemd[568]: Created slice User Application Slice. machine # [ 11.315986] systemd[568]: Started Daily Cleanup of User's Temporary Directories. machine # [ 11.348729] systemd[568]: Reached target Paths. machine # [ 11.375859] systemd[568]: Reached target Timers. machine # [ 11.387046] systemd[568]: Starting D-Bus User Message Bus Socket... machine # [ 11.401576] systemd[568]: Starting Create User Files and Directories... machine # [ 11.402570] systemd[568]: Finished Create User Files and Directories. machine # [ 11.403455] systemd[568]: Listening on D-Bus User Message Bus Socket. machine # [ 11.440250] systemd[568]: Reached target Sockets. machine # [ 11.441002] systemd[568]: Reached target Basic System. machine # [ 11.441998] systemd[1]: Started User Manager for UID 1001. machine # [ 11.442786] systemd[568]: Starting Run user-specific NixOS activation... machine # [ 11.443738] systemd[568]: Finished Run user-specific NixOS activation. machine # [ 11.493209] systemd[568]: Reached target Main User Target. machine # [ 11.494059] systemd[568]: Startup finished in 504ms. machine # [ 11.613948] dhcpcd[585]: dhcpcd-10.3.2 starting machine # [ 11.623013] dhcpcd[607]: dev: loaded udev machine # [ 11.669473] 8021q: 802.1Q VLAN Support v1.8 machine # [ 11.794628] cfg80211: Loading compiled-in X.509 certificates for regulatory database machine # [ 11.849823] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' machine # [ 11.851888] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600' machine # [ 11.854489] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -2 machine # [ 11.854811] cfg80211: failed to load regulatory.db machine # [ 12.025022] systemd[1]: Finished Firewall. machine # [ 12.025745] systemd[1]: Reached target Preparation for Network. machine # [ 12.026555] systemd[1]: Starting Address configuration of eth1... machine # [ 12.067437] systemd[1]: Starting Extra networking commands.... machine # [ 12.247319] input: QEMU Virtio Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:06.0/virtio5/input/input3 machine # [ 12.420832] 8021q: adding VLAN 0 to HW filter on device eth0 machine # [ 12.414974] dhcpcd[607]: eth0: waiting for carrier machine # [ 12.415807] dhcpcd[607]: eth0: carrier acquired machine # [ 12.498878] dhcpcd[607]: DUID 00:01:00:01:32:3c:72:81:52:54:00:12:34:56 machine # [ 12.499956] dhcpcd[607]: eth0: IAID 00:12:34:56 machine # [ 12.515639] dhcpcd[607]: eth0: adding address fe80::5054:ff:fe12:3456 machine # [ 12.559596] 8021q: adding VLAN 0 to HW filter on device eth1 machine # [ 12.613806] systemd[1]: Starting Virtual Console Setup... machine # [ 12.653632] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch. machine # [ 12.655201] network-addresses-eth1-start[639]: adding address 192.168.1.1/24... done machine # [ 12.684945] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. machine # [ 12.686333] systemd[1]: Stopped Virtual Console Setup. machine # [ 12.705402] systemd[1]: Starting Virtual Console Setup... machine # [ 12.708288] network-addresses-eth1-start[639]: adding address 2001:db8:1::1/64... done machine # [ 12.721914] systemd-logind[451]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard) machine # [ 12.744572] systemd[1]: Finished Address configuration of eth1. machine # [ 12.813057] systemd[1]: Finished Extra networking commands.. machine # [ 12.815154] systemd[1]: Reached target Network. machine # [ 12.825009] systemd[1]: Starting Permit User Sessions... machine # [ 12.858855] systemd[1]: Finished Permit User Sessions. machine # [ 12.864801] systemd[1]: Started Getty on tty1. machine # [ 12.868705] systemd[1]: Reached target Login Prompts. machine # [ 12.931269] systemd-vconsole-setup[668]: Configuration of first virtual console was skipped, ignoring remaining ones. machine # [ 12.937994] systemd[1]: Finished Virtual Console Setup. machine # [ 14.113490] dhcpcd[607]: eth0: soliciting a DHCP lease machine # [ 14.117529] dhcpcd[607]: eth0: offered 10.0.2.15 from 10.0.2.2 machine # [ 14.124516] dhcpcd[607]: eth0: probing address 10.0.2.15/24 machine # [ 14.219299] dhcpcd[607]: eth0: soliciting an IPv6 router machine # [ 14.222989] dhcpcd[607]: eth0: Router Advertisement from fe80::2 machine # [ 14.225704] dhcpcd[607]: eth0: adding address fec0::5054:ff:fe12:3456/64 machine # [ 14.228552] dhcpcd[607]: eth0: adding route to fec0::/64 machine # [ 14.230910] dhcpcd[607]: eth0: adding default route via fe80::2 machine # [ 18.980914] dhcpcd[607]: eth0: leased 10.0.2.15 for 86400 seconds machine # [ 18.984324] dhcpcd[607]: eth0: adding route to 10.0.2.0/24 machine # [ 18.986809] dhcpcd[607]: eth0: adding default route via 10.0.2.2 machine # [ 19.189327] systemd[1]: Started DHCP Client. machine # [ 19.190721] systemd[1]: Reached target Multi-User System. machine # [ 19.191632] systemd[1]: Startup finished in 1.001s (kernel) + 5.079s (initrd) + 13.109s (userspace) = 19.190s. machine: (finished: waiting for unit multi-user.target, in 21.04 seconds) machine: must succeed: /nix/store/glw2b718093b6m9v90xl0blwv4z9hk4p-stderr-runner /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test/bin/switch-to-configuration test machine # Checking switch inhibitors... done machine # [ 20.492700] nixos[841]: switching to system configuration /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test machine # [ 20.495505] systemd[1]: Stopped target Local File Systems. machine # activating the configuration... machine # [ 20.498296] systemd[1]: Stopped target Remote File Systems. machine # setting up /etc... machine # [ 20.788984] systemd[1]: Reload requested from client PID 841 ('.switch-to-conf') (unit backdoor.service)... machine # [ 20.790937] systemd[1]: Reloading... machine # [ 21.119222] systemd[1]: Reloading finished in 326 ms. machine # reloading user units for usertest... machine # [ 21.171399] systemd[568]: Created slice User Core Session Slice. machine # [ 21.174916] systemd[568]: Starting D-Bus User Message Bus... machine # [ 21.205525] dbus-broker-launch[911]: Ignoring duplicate name 'org.freedesktop.import1' in service file '/nix/store/vcpvwcmmxjnida0r2hbxc1gdb3y5crj8-system-path/share/dbus-1/services/org.freedesktop.import1.service' machine # [ 21.208623] dbus-broker-launch[911]: Ignoring duplicate name 'org.freedesktop.machine1' in service file '/nix/store/vcpvwcmmxjnida0r2hbxc1gdb3y5crj8-system-path/share/dbus-1/services/org.freedesktop.machine1.service' machine # [ 21.211594] dbus-broker-launch[911]: Ignoring duplicate name 'org.freedesktop.portable1' in service file '/nix/store/vcpvwcmmxjnida0r2hbxc1gdb3y5crj8-system-path/share/dbus-1/services/org.freedesktop.portable1.service' machine # [ 21.214685] dbus-broker-launch[911]: Ignoring duplicate name 'org.freedesktop.systemd1' in service file '/nix/store/vcpvwcmmxjnida0r2hbxc1gdb3y5crj8-system-path/share/dbus-1/services/org.freedesktop.systemd1.service' machine # [ 21.219093] dbus-broker-launch[911]: Policy to allow eavesdropping in /etc/dbus-1/session.conf +27: Eavesdropping is deprecated and ignored machine # [ 21.221720] dbus-broker-launch[911]: Policy to allow eavesdropping in /etc/dbus-1/session.conf +29: Eavesdropping is deprecated and ignored machine # [ 21.224528] systemd[568]: Started D-Bus User Message Bus. machine # [ 21.228268] dbus-broker-launch[911]: Ready machine # [ 21.276106] systemd[568]: Reexecution requested from client PID 910 ('switch-to-confi')... machine # [ 21.277597] systemd[568]: Reexecuting. machine # [ 21.327966] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 21.445366] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 21.452376] systemd[568]: Reload requested from client PID 910 ('switch-to-confi')... machine # [ 21.454821] systemd[568]: Reloading... machine # [ 21.566413] systemd[568]: Reloading finished in 110 ms. machine # [ 21.580209] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # restarting the following user units: nixos-activation.service machine # [ 21.592089] systemd[568]: Stopped Run user-specific NixOS activation. machine # [ 21.594438] systemd[568]: Stopping Run user-specific NixOS activation... machine # [ 21.596630] systemd[568]: Starting Run user-specific NixOS activation... machine # [ 21.631661] systemd[568]: Finished Run user-specific NixOS activation. machine # restarting sysinit-reactivation.target machine # [ 21.644296] systemd[1]: Starting Re-setup tmpfiles on a system that is already running.... machine # [ 21.724336] systemd[1]: Finished Re-setup tmpfiles on a system that is already running.. machine # [ 21.731442] systemd[1]: Reached target Reactivate sysinit units. machine # [ 21.738959] systemd[1]: Reached target Remote File Systems. machine # [ 21.742692] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 21.747970] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 21.756250] systemd[1]: Starting linger-users.service... machine # [ 21.757149] systemd[1]: Reached target Local File Systems. machine # [ 21.763910] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 21.776392] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 21.777274] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 21.778481] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 21.792423] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 21.794101] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 21.805837] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 21.872879] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 21.876480] systemd[1]: Finished linger-users.service. machine # [ 22.017586] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 22.020351] systemd[1]: Finished Create SUID/SGID Wrappers. machine # the following new units were started: sysinit-reactivation.target, systemd-tmpfiles-resetup.service machine # [ 22.288871] nixos[841]: finished switching to system configuration /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test machine: (finished: must succeed: /nix/store/glw2b718093b6m9v90xl0blwv4z9hk4p-stderr-runner /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test/bin/switch-to-configuration test, in 2.07 seconds) machine: must succeed: rm /etc/NIXOS machine: (finished: must succeed: rm /etc/NIXOS, in 0.05 seconds) machine: must succeed: /nix/store/glw2b718093b6m9v90xl0blwv4z9hk4p-stderr-runner /nix/store/v77csy8p1yzqn64kirmr38008picpwnv-nixos-system-other-test/bin/switch-to-configuration test machine # this should succeed (config: /nix/store/v77csy8p1yzqn64kirmr38008picpwnv-nixos-system-other-test, action: test) machine # Checking switch inhibitors... done machine # [ 22.626857] nixos[989]: switching to system configuration /nix/store/v77csy8p1yzqn64kirmr38008picpwnv-nixos-system-other-test machine # [ 22.629641] systemd[1]: Stopped target Remote File Systems. machine # activating the configuration... machine # [ 22.632488] systemd[1]: Stopped target Local File Systems. machine # removing user ‘usertest’ machine # setting up /etc... machine # [ 22.926356] systemd[1]: Reload requested from client PID 989 ('.switch-to-conf') (unit backdoor.service)... machine # [ 22.928549] systemd[1]: Reloading... machine # [ 23.274981] systemd[1]: Reloading finished in 344 ms. machine # reloading user units for usertest... machine # [ 23.376452] systemd[568]: Reexecution requested from client PID 1060 ('switch-to-confi')... machine # [ 23.381600] systemd[568]: Reexecuting. machine # [ 23.427543] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 23.549850] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 23.556316] systemd[568]: Reload requested from client PID 1060 ('switch-to-confi')... machine # [ 23.558771] systemd[568]: Reloading... machine # [ 23.671761] systemd[568]: Reloading finished in 112 ms. machine # [ 23.688196] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # restarting the following user units: nixos-activation.service machine # [ 23.699332] systemd[568]: Stopped Run user-specific NixOS activation. machine # [ 23.701744] systemd[568]: Stopping Run user-specific NixOS activation... machine # [ 23.704063] systemd[568]: Starting Run user-specific NixOS activation... machine # [ 23.737138] systemd[568]: Finished Run user-specific NixOS activation. machine # restarting sysinit-reactivation.target machine # [ 23.741752] systemd[1]: Stopped target Reactivate sysinit units. machine # reloading the following units: dbus-broker.service[ 23.744591] systemd[1]: Stopping Reactivate sysinit units... machine # [ 23.745480] systemd[1]: Reached target Reactivate sysinit units. machine # machine # [ 23.749069] systemd[1]: Reloading D-Bus System Message Bus... machine # [ 23.751055] dbus-broker-launch[434]: Caught SIGHUP, trigger reload. machine # [ 23.757579] dbus-broker-launch[434]: Looking up NSS user entry for 'systemd-timesync'... machine # [ 23.759769] dbus-broker-launch[434]: NSS returned no entry for 'systemd-timesync' machine # [ 23.761130] dbus-broker-launch[434]: Invalid user-name in /nix/store/wcbbx87z8mk1zpdd2fxcqai8im93kzh2-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" machine # [ 23.778009] systemd[1]: Reloaded D-Bus System Message Bus. machine # restarting the following units: network-addresses-eth1.service machine # [ 23.784920] systemd[1]: Stopping Address configuration of eth1... machine # [ 23.816461] network-addresses-eth1-pre-stop[1072]: deleting address 192.168.1.1/24... done machine # [ 23.822748] network-addresses-eth1-pre-stop[1072]: deleting address 2001:db8:1::1/64... done machine # [ 23.829672] systemd[1]: network-addresses-eth1.service: Deactivated successfully. machine # [ 23.832215] systemd[1]: Stopped Address configuration of eth1. machine # [ 23.837259] systemd[1]: Starting Address configuration of eth1... machine # [ 23.879794] network-addresses-eth1-start[1077]: adding address 192.168.1.2/24... done machine # [ 23.887361] network-addresses-eth1-start[1077]: adding address 2001:db8:1::2/64... done machine # [ 23.897110] systemd[1]: Finished Address configuration of eth1. machine # [ 23.903134] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 23.906831] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 23.909762] systemd[1]: Reached target Remote File Systems. machine # [ 23.915116] systemd[1]: Starting linger-users.service... machine # [ 23.919487] systemd[1]: Reached target Local File Systems. machine # [ 23.927382] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 23.936286] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 23.937220] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 23.938445] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 23.943441] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 23.949495] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 23.950867] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 23.981892] linger-users-start[1091]: id: ‘usertest’: no such user machine # [ 23.984549] linger-users-start[1088]: Removing linger for missing user usertest machine # [ 23.995328] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 23.998205] systemd[1]: Finished linger-users.service. machine # [ 24.164320] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 24.167605] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 24.425004] nixos[989]: finished switching to system configuration /nix/store/v77csy8p1yzqn64kirmr38008picpwnv-nixos-system-other-test machine: (finished: must succeed: /nix/store/glw2b718093b6m9v90xl0blwv4z9hk4p-stderr-runner /nix/store/v77csy8p1yzqn64kirmr38008picpwnv-nixos-system-other-test/bin/switch-to-configuration test, in 2.08 seconds) subtest: services machine: must succeed: /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test/bin/switch-to-configuration test 2>&1 machine # [ 24.713841] nixos[1155]: switching to system configuration /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test machine # [ 24.716391] systemd[1]: Stopped target Remote File Systems. machine # [ 24.718767] systemd[1]: Stopped target Local File Systems. machine # [ 24.989322] systemd[1]: Reload requested from client PID 1155 ('.switch-to-conf') (unit backdoor.service)... machine # [ 24.991219] systemd[1]: Reloading... machine # [ 25.326073] systemd[1]: Reloading finished in 333 ms. machine # [ 25.439426] systemd[568]: Reexecution requested from client PID 1224 ('switch-to-confi')... machine # [ 25.443787] systemd[568]: Reexecuting. machine # [ 25.499896] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 25.619430] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 25.625934] systemd[568]: Reload requested from client PID 1224 ('switch-to-confi')... machine # [ 25.628403] systemd[568]: Reloading... machine # [ 25.741848] systemd[568]: Reloading finished in 112 ms. machine # [ 25.756182] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 25.766335] systemd[568]: Stopped Run user-specific NixOS activation. machine # [ 25.767438] systemd[568]: Stopping Run user-specific NixOS activation... machine # [ 25.769982] systemd[568]: Starting Run user-specific NixOS activation... machine # [ 25.800620] systemd[568]: Finished Run user-specific NixOS activation. machine # [ 25.804516] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 25.809045] systemd[1]: Stopping Reactivate sysinit units... machine # [ 25.810393] systemd[1]: Reached target Reactivate sysinit units. machine # [ 25.811288] systemd[1]: Reloading D-Bus System Message Bus... machine # [ 25.812778] dbus-broker-launch[434]: Caught SIGHUP, trigger reload. machine # [ 25.817143] dbus-broker-launch[434]: Looking up NSS user entry for 'systemd-timesync'... machine # [ 25.819288] dbus-broker-launch[434]: NSS returned no entry for 'systemd-timesync' machine # [ 25.820650] dbus-broker-launch[434]: Invalid user-name in /nix/store/vcpvwcmmxjnida0r2hbxc1gdb3y5crj8-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" machine # [ 25.836168] systemd[1]: Reloaded D-Bus System Message Bus. machine # [ 25.841955] systemd[1]: Stopping Address configuration of eth1... machine # [ 25.875432] network-addresses-eth1-pre-stop[1237]: deleting address 192.168.1.2/24... done machine # [ 25.882080] network-addresses-eth1-pre-stop[1237]: deleting address 2001:db8:1::2/64... done machine # [ 25.889034] systemd[1]: network-addresses-eth1.service: Deactivated successfully. machine # [ 25.891351] systemd[1]: Stopped Address configuration of eth1. machine # [ 25.896218] systemd[1]: Starting Address configuration of eth1... machine # [ 25.939085] network-addresses-eth1-start[1242]: adding address 192.168.1.1/24... done machine # [ 25.946352] network-addresses-eth1-start[1242]: adding address 2001:db8:1::1/64... done machine # [ 25.955841] systemd[1]: Finished Address configuration of eth1. machine # [ 25.961210] systemd[1]: Reached target Remote File Systems. machine # [ 25.965911] systemd[1]: Starting linger-users.service... machine # [ 25.979003] systemd[1]: Reached target Local File Systems. machine # [ 25.979949] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 25.989883] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 25.990801] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 25.997490] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 25.999816] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 26.010624] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 26.014873] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 26.019927] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 26.022656] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 26.046122] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 26.049639] systemd[1]: Finished linger-users.service. machine # [ 26.192228] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 26.194819] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 26.453969] nixos[1155]: finished switching to system configuration /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test machine: (finished: must succeed: /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test/bin/switch-to-configuration test 2>&1, in 2.03 seconds) machine: must succeed: /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test/bin/switch-to-configuration test 2>&1 machine # [ 26.726834] nixos[1311]: switching to system configuration /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test machine # [ 26.729295] systemd[1]: Stopped target Local File Systems. machine # [ 26.731714] systemd[1]: Stopped target Remote File Systems. machine # [ 27.003489] systemd[1]: Reload requested from client PID 1311 ('.switch-to-conf') (unit backdoor.service)... machine # [ 27.005586] systemd[1]: Reloading... machine # [ 27.331043] systemd[1]: Reloading finished in 324 ms. machine # [ 27.421507] systemd[568]: Reexecution requested from client PID 1380 ('switch-to-confi')... machine # [ 27.425767] systemd[568]: Reexecuting. machine # [ 27.479254] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 27.593212] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 27.599924] systemd[568]: Reload requested from client PID 1380 ('switch-to-confi')... machine # [ 27.603587] systemd[568]: Reloading... machine # [ 27.719770] systemd[568]: Reloading finished in 117 ms. machine # [ 27.740242] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 27.751038] systemd[568]: Stopped Run user-specific NixOS activation. machine # [ 27.753833] systemd[568]: Stopping Run user-specific NixOS activation... machine # [ 27.756188] systemd[568]: Starting Run user-specific NixOS activation... machine # [ 27.791644] systemd[568]: Finished Run user-specific NixOS activation. machine # [ 27.796573] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 27.799460] systemd[1]: Stopping Reactivate sysinit units... machine # [ 27.804427] systemd[1]: Reached target Reactivate sysinit units. machine # [ 27.805363] systemd[1]: Reached target Remote File Systems. machine # [ 27.808951] systemd[1]: Starting linger-users.service... machine # [ 27.813467] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 27.823806] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 27.831298] systemd[1]: Reached target Local File Systems. machine # [ 27.836369] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 27.838010] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 27.838807] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 27.846188] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 27.848914] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 27.850518] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 27.857883] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 27.917295] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 27.921391] systemd[1]: Finished linger-users.service. machine # [ 28.081068] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 28.085184] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 28.342476] nixos[1311]: finished switching to system configuration /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test machine: (finished: must succeed: /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test/bin/switch-to-configuration test 2>&1, in 1.89 seconds) machine: must succeed: /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration test 2>&1 machine # [ 28.683184] nixos[1451]: switching to system configuration /nix/store/pxk52rvva355wpm5k41573w2s5170ws7-nixos-system-machine-test machine # [ 28.686342] systemd[1]: Stopped target Remote File Systems. machine # [ 28.688283] systemd[1]: Stopped target Local File Systems. machine # [ 28.995578] systemd[1]: Reload requested from client PID 1451 ('.switch-to-conf') (unit backdoor.service)... machine # [ 28.997704] systemd[1]: Reloading... machine # [ 29.340341] systemd[1]: Reloading finished in 340 ms. machine # [ 29.432424] systemd[568]: Reexecution requested from client PID 1521 ('switch-to-confi')... machine # [ 29.436311] systemd[568]: Reexecuting. machine # [ 29.491294] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 29.608848] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 29.615483] systemd[568]: Reload requested from client PID 1521 ('switch-to-confi')... machine # [ 29.618894] systemd[568]: Reloading... machine # [ 29.730415] systemd[568]: Reloading finished in 112 ms. machine # [ 29.744233] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 29.753351] systemd[568]: Stopped Run user-specific NixOS activation. machine # [ 29.755754] systemd[568]: Stopping Run user-specific NixOS activation... machine # [ 29.757920] systemd[568]: Starting Run user-specific NixOS activation... machine # [ 29.789080] systemd[568]: Finished Run user-specific NixOS activation. machine # [ 29.792807] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 29.795779] systemd[1]: Stopping Reactivate sysinit units... machine # [ 29.800315] systemd[1]: Reached target Reactivate sysinit units. machine # [ 29.801238] systemd[1]: Reached target Remote File Systems. machine # [ 29.804184] systemd[1]: Starting linger-users.service... machine # [ 29.807263] systemd[1]: Starting test.service... machine # [ 29.822883] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 29.825829] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 29.827183] systemd[1]: Reached target Local File Systems. machine # [ 29.837848] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 29.839515] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 29.850061] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 29.851468] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 29.863533] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 29.871737] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 29.878457] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 29.879896] systemd[1]: Finished test.service. machine # [ 29.913435] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 29.917874] systemd[1]: Finished linger-users.service. machine # [ 30.060332] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 30.063289] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 30.324000] nixos[1451]: finished switching to system configuration /nix/store/pxk52rvva355wpm5k41573w2s5170ws7-nixos-system-machine-test machine: (finished: must succeed: /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration test 2>&1, in 1.98 seconds) machine: must succeed: /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration test 2>&1 machine # [ 30.602359] nixos[1594]: switching to system configuration /nix/store/pxk52rvva355wpm5k41573w2s5170ws7-nixos-system-machine-test machine # [ 30.605219] systemd[1]: Stopped target Local File Systems. machine # [ 30.607479] systemd[1]: Stopped target Remote File Systems. machine # [ 30.903020] systemd[1]: Reload requested from client PID 1594 ('.switch-to-conf') (unit backdoor.service)... machine # [ 30.905167] systemd[1]: Reloading... machine # [ 31.228337] systemd[1]: Reloading finished in 321 ms. machine # [ 31.326137] systemd[568]: Reexecution requested from client PID 1663 ('switch-to-confi')... machine # [ 31.330801] systemd[568]: Reexecuting. machine # [ 31.388805] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 31.513353] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 31.519894] systemd[568]: Reload requested from client PID 1663 ('switch-to-confi')... machine # [ 31.523951] systemd[568]: Reloading... machine # [ 31.639787] systemd[568]: Reloading finished in 116 ms. machine # [ 31.656190] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 31.666224] systemd[568]: Stopped Run user-specific NixOS activation. machine # [ 31.668897] systemd[568]: Stopping Run user-specific NixOS activation... machine # [ 31.671329] systemd[568]: Starting Run user-specific NixOS activation... machine # [ 31.705698] systemd[568]: Finished Run user-specific NixOS activation. machine # [ 31.710185] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 31.717502] systemd[1]: Stopping Reactivate sysinit units... machine # [ 31.718433] systemd[1]: Reached target Reactivate sysinit units. machine # [ 31.730655] systemd[1]: Reached target Remote File Systems. machine # [ 31.731651] systemd[1]: Starting linger-users.service... machine # [ 31.745378] systemd[1]: Reached target Local File Systems. machine # [ 31.746249] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 31.747764] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 31.762475] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 31.763855] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 31.777646] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 31.779639] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 31.793003] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 31.801456] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 31.802881] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 31.885942] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 31.889545] systemd[1]: Finished linger-users.service. machine # [ 32.025713] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 32.029497] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 32.286956] nixos[1594]: finished switching to system configuration /nix/store/pxk52rvva355wpm5k41573w2s5170ws7-nixos-system-machine-test machine: (finished: must succeed: /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration test 2>&1, in 1.97 seconds) machine: must succeed: /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test/specialisation/simpleServiceDifferentDescription/bin/switch-to-configuration test 2>&1 machine # [ 32.594392] nixos[1735]: switching to system configuration /nix/store/dvc9pfh46sckyx671swi23mv626ycjkq-nixos-system-machine-test machine # [ 32.596929] systemd[1]: Stopped target Local File Systems. machine # [ 32.599271] systemd[1]: Stopped target Remote File Systems. machine # [ 32.893608] systemd[1]: Reload requested from client PID 1735 ('.switch-to-conf') (unit backdoor.service)... machine # [ 32.895536] systemd[1]: Reloading... machine # [ 33.281438] systemd[1]: Reloading finished in 384 ms. machine # [ 33.368089] systemd[568]: Reexecution requested from client PID 1804 ('switch-to-confi')... machine # [ 33.369484] systemd[568]: Reexecuting. machine # [ 33.436182] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 33.561982] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 33.568671] systemd[568]: Reload requested from client PID 1804 ('switch-to-confi')... machine # [ 33.571287] systemd[568]: Reloading... machine # [ 33.685357] systemd[568]: Reloading finished in 113 ms. machine # [ 33.700215] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 33.711131] systemd[568]: Stopped Run user-specific NixOS activation. machine # [ 33.712249] systemd[568]: Stopping Run user-specific NixOS activation... machine # [ 33.714343] systemd[568]: Starting Run user-specific NixOS activation... machine # [ 33.743806] systemd[568]: Finished Run user-specific NixOS activation. machine # [ 33.747880] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 33.749633] systemd[1]: Stopping Reactivate sysinit units... machine # [ 33.750457] systemd[1]: Reached target Reactivate sysinit units. machine # [ 33.754223] systemd[1]: Reached target Remote File Systems. machine # [ 33.758469] systemd[1]: Starting linger-users.service... machine # [ 33.767795] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 33.771060] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 33.774214] systemd[1]: Reached target Local File Systems. machine # [ 33.780835] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 33.788239] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 33.789175] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 33.790407] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 33.799235] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 33.803901] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 33.806048] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 33.843106] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 33.847236] systemd[1]: Finished linger-users.service. machine # [ 33.987125] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 33.990514] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 34.247645] nixos[1735]: finished switching to system configuration /nix/store/dvc9pfh46sckyx671swi23mv626ycjkq-nixos-system-machine-test machine: (finished: must succeed: /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test/specialisation/simpleServiceDifferentDescription/bin/switch-to-configuration test 2>&1, in 1.96 seconds) machine: must succeed: /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test/specialisation/simpleServiceModified/bin/switch-to-configuration test 2>&1 machine # [ 34.559711] nixos[1875]: switching to system configuration /nix/store/b8v4dzxsp98n1mrz3y8s56yix8lk2gz1-nixos-system-machine-test machine # [ 34.562768] systemd[1]: Stopped target Local File Systems. machine # [ 34.566634] systemd[1]: Stopped target Remote File Systems. machine # [ 34.568004] systemd[1]: test.service: Deactivated successfully. machine # [ 34.569252] systemd[1]: Stopped Test unit. machine # [ 34.866732] systemd[1]: Reload requested from client PID 1875 ('.switch-to-conf') (unit backdoor.service)... machine # [ 34.868866] systemd[1]: Reloading... machine # [ 35.217722] systemd[1]: Reloading finished in 347 ms. machine # [ 35.340336] systemd[568]: Reexecution requested from client PID 1944 ('switch-to-confi')... machine # [ 35.344499] systemd[568]: Reexecuting. machine # [ 35.399257] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 35.511568] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 35.519085] systemd[568]: Reload requested from client PID 1944 ('switch-to-confi')... machine # [ 35.522326] systemd[568]: Reloading... machine # [ 35.633959] systemd[568]: Reloading finished in 111 ms. machine # [ 35.648183] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 35.656879] systemd[568]: Stopped Run user-specific NixOS activation. machine # [ 35.659178] systemd[568]: Stopping Run user-specific NixOS activation... machine # [ 35.661278] systemd[568]: Starting Run user-specific NixOS activation... machine # [ 35.692230] systemd[568]: Finished Run user-specific NixOS activation. machine # [ 35.697500] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 35.698724] systemd[1]: Stopping Reactivate sysinit units... machine # [ 35.699540] systemd[1]: Reached target Reactivate sysinit units. machine # [ 35.704594] systemd[1]: Reached target Remote File Systems. machine # [ 35.708205] systemd[1]: Starting linger-users.service... machine # [ 35.713048] systemd[1]: Starting test.service... machine # [ 35.713868] systemd[1]: Reached target Local File Systems. machine # [ 35.724731] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 35.726082] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 35.734988] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 35.745870] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 35.746755] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 35.756584] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 35.758894] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 35.769163] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 35.770450] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 35.788307] systemd[1]: Finished test.service. machine # [ 35.814819] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 35.816714] systemd[1]: Finished linger-users.service. machine # [ 35.967956] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 35.970737] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 36.230277] nixos[1875]: finished switching to system configuration /nix/store/b8v4dzxsp98n1mrz3y8s56yix8lk2gz1-nixos-system-machine-test machine: (finished: must succeed: /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test/specialisation/simpleServiceModified/bin/switch-to-configuration test 2>&1, in 1.98 seconds) machine: must succeed: /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1 machine # [ 36.520172] nixos[2018]: switching to system configuration /nix/store/14nf8m8wg6yp4k3p9hj90zq8a1cmn3ji-nixos-system-machine-test machine # [ 36.523006] systemd[1]: Stopped target Remote File Systems. machine # [ 36.525238] systemd[1]: Stopped target Local File Systems. machine # [ 36.809836] systemd[1]: Reload requested from client PID 2018 ('.switch-to-conf') (unit backdoor.service)... machine # [ 36.811754] systemd[1]: Reloading... machine # [ 37.142142] systemd[1]: Reloading finished in 328 ms. machine # [ 37.234810] systemd[568]: Reexecution requested from client PID 2087 ('switch-to-confi')... machine # [ 37.238794] systemd[568]: Reexecuting. machine # [ 37.304083] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 37.429947] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 37.436744] systemd[568]: Reload requested from client PID 2087 ('switch-to-confi')... machine # [ 37.439350] systemd[568]: Reloading... machine # [ 37.553576] systemd[568]: Reloading finished in 113 ms. machine # [ 37.568198] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 37.577080] systemd[568]: Stopped Run user-specific NixOS activation. machine # [ 37.579384] systemd[568]: Stopping Run user-specific NixOS activation... machine # [ 37.581507] systemd[568]: Starting Run user-specific NixOS activation... machine # [ 37.612823] systemd[568]: Finished Run user-specific NixOS activation. machine # [ 37.617102] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 37.619048] systemd[1]: Stopping Reactivate sysinit units... machine # [ 37.619904] systemd[1]: Reached target Reactivate sysinit units. machine # [ 37.624377] systemd[1]: test.service: Deactivated successfully. machine # [ 37.625253] systemd[1]: Stopped test.service. machine # [ 37.625883] systemd[1]: Stopping test.service... machine # [ 37.632214] systemd[1]: Starting test.service... machine # [ 37.654969] systemd[1]: Finished test.service. machine # [ 37.656672] systemd[1]: Reached target Local File Systems. machine # [ 37.664002] systemd[1]: Reached target Remote File Systems. machine # [ 37.668992] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 37.670384] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 37.671674] systemd[1]: Starting linger-users.service... machine # [ 37.685426] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 37.686959] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 37.687788] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 37.695985] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 37.699333] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 37.708635] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 37.714258] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 37.754233] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 37.757353] systemd[1]: Finished linger-users.service. machine # [ 37.898068] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 37.901347] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 38.158148] nixos[2018]: finished switching to system configuration /nix/store/14nf8m8wg6yp4k3p9hj90zq8a1cmn3ji-nixos-system-machine-test machine: (finished: must succeed: /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1, in 1.93 seconds) machine: must succeed: /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test/specialisation/simpleServiceReload/bin/switch-to-configuration test 2>&1 machine # [ 38.503984] nixos[2160]: switching to system configuration /nix/store/7r00hf5az34vqskj8rc0bls1ghg87nnw-nixos-system-machine-test machine # [ 38.506604] systemd[1]: Stopped target Local File Systems. machine # [ 38.508667] systemd[1]: Stopped target Remote File Systems. machine # [ 38.828734] systemd[1]: Reload requested from client PID 2160 ('.switch-to-conf') (unit backdoor.service)... machine # [ 38.830363] systemd[1]: Reloading... machine # [ 39.190362] systemd[1]: Reloading finished in 358 ms. machine # [ 39.288473] systemd[568]: Reexecution requested from client PID 2230 ('switch-to-confi')... machine # [ 39.291227] systemd[568]: Reexecuting. machine # [ 39.352149] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 39.477057] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 39.483822] systemd[568]: Reload requested from client PID 2230 ('switch-to-confi')... machine # [ 39.487560] systemd[568]: Reloading... machine # [ 39.601042] systemd[568]: Reloading finished in 114 ms. machine # [ 39.620192] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 39.629486] systemd[568]: Stopped Run user-specific NixOS activation. machine # [ 39.631975] systemd[568]: Stopping Run user-specific NixOS activation... machine # [ 39.635969] systemd[568]: Starting Run user-specific NixOS activation... machine # [ 39.666125] systemd[568]: Finished Run user-specific NixOS activation. machine # [ 39.670609] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 39.675326] systemd[1]: Stopping Reactivate sysinit units... machine # [ 39.676737] systemd[1]: Reached target Reactivate sysinit units. machine # [ 39.678947] systemd[1]: Reloading test.service... machine # [ 39.706680] systemd[1]: Reloaded test.service. machine # [ 39.709369] systemd[1]: Reached target Remote File Systems. machine # [ 39.714919] systemd[1]: Starting linger-users.service... machine # [ 39.724395] systemd[1]: Reached target Local File Systems. machine # [ 39.725379] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 39.736837] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 39.737866] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 39.739137] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 39.754046] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 39.755799] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 39.765934] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 39.770458] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 39.771910] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 39.815635] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 39.820711] systemd[1]: Finished linger-users.service. machine # [ 39.963182] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 39.966959] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 40.226360] nixos[2160]: finished switching to system configuration /nix/store/7r00hf5az34vqskj8rc0bls1ghg87nnw-nixos-system-machine-test machine: (finished: must succeed: /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test/specialisation/simpleServiceReload/bin/switch-to-configuration test 2>&1, in 2.07 seconds) machine: must succeed: /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test/specialisation/simpleServiceNorestart/bin/switch-to-configuration test 2>&1 machine # [ 40.553218] nixos[2303]: switching to system configuration /nix/store/bs0kln4r7xwqnmnna8jpd8gxfxca8r6q-nixos-system-machine-test machine # [ 40.555794] systemd[1]: Stopped target Remote File Systems. machine # [ 40.558383] systemd[1]: Stopped target Local File Systems. machine # [ 40.855806] systemd[1]: Reload requested from client PID 2303 ('.switch-to-conf') (unit backdoor.service)... machine # [ 40.857918] systemd[1]: Reloading... machine # [ 41.209947] systemd[1]: Reloading finished in 349 ms. machine # [ 41.298560] systemd[568]: Reexecution requested from client PID 2372 ('switch-to-confi')... machine # [ 41.299974] systemd[568]: Reexecuting. machine # [ 41.360060] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 41.482810] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 41.489639] systemd[568]: Reload requested from client PID 2372 ('switch-to-confi')... machine # [ 41.491761] systemd[568]: Reloading... machine # [ 41.603616] systemd[568]: Reloading finished in 110 ms. machine # [ 41.620181] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 41.629462] systemd[568]: Stopped Run user-specific NixOS activation. machine # [ 41.631811] systemd[568]: Stopping Run user-specific NixOS activation... machine # [ 41.633885] systemd[568]: Starting Run user-specific NixOS activation... machine # [ 41.664109] systemd[568]: Finished Run user-specific NixOS activation. machine # [ 41.667798] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 41.670528] systemd[1]: Stopping Reactivate sysinit units... machine # [ 41.671400] systemd[1]: Reached target Reactivate sysinit units. machine # [ 41.675612] systemd[1]: Reached target Remote File Systems. machine # [ 41.678813] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 41.681606] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 41.684881] systemd[1]: Reached target Local File Systems. machine # [ 41.690440] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 41.697883] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 41.698786] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 41.707622] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 41.713330] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 41.714923] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 41.716594] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 41.915324] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 41.920426] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 41.922631] systemd[1]: Starting linger-users.service... machine # [ 41.966641] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 41.969326] systemd[1]: Finished linger-users.service. machine # [ 42.229276] nixos[2303]: finished switching to system configuration /nix/store/bs0kln4r7xwqnmnna8jpd8gxfxca8r6q-nixos-system-machine-test machine: (finished: must succeed: /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test/specialisation/simpleServiceNorestart/bin/switch-to-configuration test 2>&1, in 2.00 seconds) machine: must succeed: /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration dry-activate 2>&1 machine: (finished: must succeed: /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration dry-activate 2>&1, in 0.36 seconds) machine: must succeed: /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test/bin/switch-to-configuration test 2>&1 machine # [ 42.811635] nixos[2454]: switching to system configuration /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test machine # [ 42.814539] systemd[1]: Stopped target Remote File Systems. machine # [ 42.818310] systemd[1]: test.service: Deactivated successfully. machine # [ 42.819575] systemd[1]: Stopped test.service. machine # [ 42.821064] systemd[1]: Stopped target Local File Systems. machine # [ 43.106129] systemd[1]: Reload requested from client PID 2454 ('.switch-to-conf') (unit backdoor.service)... machine # [ 43.108256] systemd[1]: Reloading... machine # [ 43.453921] systemd[1]: Reloading finished in 344 ms. machine # [ 43.552367] systemd[568]: Reexecution requested from client PID 2523 ('switch-to-confi')... machine # [ 43.553788] systemd[568]: Reexecuting. machine # [ 43.616394] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 43.740994] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 43.748115] systemd[568]: Reload requested from client PID 2523 ('switch-to-confi')... machine # [ 43.749469] systemd[568]: Reloading... machine # [ 43.865308] systemd[568]: Reloading finished in 114 ms. machine # [ 43.880173] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 43.890337] systemd[568]: Stopped Run user-specific NixOS activation. machine # [ 43.892835] systemd[568]: Stopping Run user-specific NixOS activation... machine # [ 43.894977] systemd[568]: Starting Run user-specific NixOS activation... machine # [ 43.930059] systemd[568]: Finished Run user-specific NixOS activation. machine # [ 43.934644] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 43.938077] systemd[1]: Stopping Reactivate sysinit units... machine # [ 43.938979] systemd[1]: Reached target Reactivate sysinit units. machine # [ 43.942823] systemd[1]: Reached target Local File Systems. machine # [ 43.946722] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 43.951347] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 43.954809] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 43.961329] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 43.963613] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 43.969953] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 43.971327] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 43.974405] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 43.975731] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 43.978067] systemd[1]: Reached target Remote File Systems. machine # [ 44.146177] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 44.151057] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 44.153504] systemd[1]: Starting linger-users.service... machine # [ 44.196177] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 44.198891] systemd[1]: Finished linger-users.service. machine # [ 44.458140] nixos[2454]: finished switching to system configuration /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test machine: (finished: must succeed: /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test/bin/switch-to-configuration test 2>&1, in 1.87 seconds) machine: must succeed: /nix/store/3srgvgzzlxwkafi9bn5xxv8l14l87k3z-separate-activation-script/bin/switch-to-configuration test 2>&1 machine # [ 44.754897] nixos[2594]: switching to system configuration /nix/store/1bv29wfflkn9clfg2wriq926b4x2k8j4-nixos-system-machine-test machine # [ 44.757613] systemd[1]: Stopped target Remote File Systems. machine # [ 44.759840] systemd[1]: Stopped target Local File Systems. machine # [ 45.097013] systemd[1]: Reload requested from client PID 2594 ('.switch-to-conf') (unit backdoor.service)... machine # [ 45.099308] systemd[1]: Reloading... machine # [ 45.445773] systemd[1]: Reloading finished in 344 ms. machine # [ 45.539674] systemd[568]: Stopped Run user-specific NixOS activation. machine # [ 45.541793] systemd[568]: Reexecution requested from client PID 2664 ('switch-to-confi')... machine # [ 45.545493] systemd[568]: Reexecuting. machine # [ 45.603598] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 45.727238] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 45.733994] systemd[568]: Reload requested from client PID 2664 ('switch-to-confi')... machine # [ 45.736491] systemd[568]: Reloading... machine # [ 45.848058] systemd[568]: Reloading finished in 110 ms. machine # [ 45.864244] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 45.876228] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 45.878559] systemd[1]: Stopping Reactivate sysinit units... machine # [ 45.879467] systemd[1]: Reached target Reactivate sysinit units. machine # [ 45.882400] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 45.883804] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 45.887020] systemd[1]: Reached target Local File Systems. machine # [ 45.891633] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 45.900691] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 45.901605] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 45.902832] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 45.912639] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 45.914360] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 45.915662] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 45.919311] systemd[1]: Reached target Remote File Systems. machine # [ 46.085094] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 46.088504] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 46.092475] systemd[1]: Starting linger-users.service... machine # [ 46.100672] systemd[1]: Starting test.service... machine # [ 46.135909] systemd[1]: Finished test.service. machine # [ 46.155622] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 46.159188] systemd[1]: Finished linger-users.service. machine # [ 46.419004] nixos[2594]: finished switching to system configuration /nix/store/1bv29wfflkn9clfg2wriq926b4x2k8j4-nixos-system-machine-test machine: (finished: must succeed: /nix/store/3srgvgzzlxwkafi9bn5xxv8l14l87k3z-separate-activation-script/bin/switch-to-configuration test 2>&1, in 1.96 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/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test/specialisation/unitWithMultilineValue/bin/switch-to-configuration test 2>&1 machine # [ 46.797460] nixos[2743]: switching to system configuration /nix/store/bj671x7sizpfcqslphs57rdwq73bclv9-nixos-system-machine-test machine # [ 46.800448] systemd[1]: Stopped target Remote File Systems. machine # [ 46.803671] systemd[1]: test.service: Deactivated successfully. machine # [ 46.806550] systemd[1]: Stopped test.service. machine # [ 46.807390] systemd[1]: Stopped target Local File Systems. machine # [ 47.142931] systemd[1]: Reload requested from client PID 2743 ('.switch-to-conf') (unit backdoor.service)... machine # [ 47.145287] systemd[1]: Reloading... machine # [ 47.505833] systemd[1]: Reloading finished in 358 ms. machine # [ 47.601359] systemd[568]: Reexecution requested from client PID 2812 ('switch-to-confi')... machine # [ 47.605652] systemd[568]: Reexecuting. machine # [ 47.651309] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 47.772321] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 47.779106] systemd[568]: Reload requested from client PID 2812 ('switch-to-confi')... machine # [ 47.783008] systemd[568]: Reloading... machine # [ 47.899325] systemd[568]: Reloading finished in 117 ms. machine # [ 47.912179] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 47.922387] systemd[568]: Starting Run user-specific NixOS activation... machine # [ 47.959435] systemd[568]: Finished Run user-specific NixOS activation. machine # [ 47.964126] systemd[568]: Stopped Run user-specific NixOS activation. machine # [ 47.965164] systemd[568]: Stopping Run user-specific NixOS activation... machine # [ 47.967591] systemd[568]: Starting Run user-specific NixOS activation... machine # [ 47.973265] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 47.976257] systemd[1]: Stopping Reactivate sysinit units... machine # [ 47.977162] systemd[1]: Reached target Reactivate sysinit units. machine # [ 47.980081] systemd[1]: Reached target Local File Systems. machine # [ 47.982808] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 47.992282] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 47.993215] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 47.994498] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 48.016904] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 48.018692] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 48.021596] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 48.024930] systemd[1]: Reached target Remote File Systems. machine # [ 48.045127] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 48.046630] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 48.052401] systemd[568]: Finished Run user-specific NixOS activation. machine # [ 48.218383] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 48.223335] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 48.227126] systemd[1]: Starting linger-users.service... machine # [ 48.230288] systemd[1]: Started test.service. machine # [ 48.272585] systemd[1]: test.service: Deactivated successfully. machine # [ 48.293497] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 48.295220] systemd[1]: Finished linger-users.service. machine # [ 48.555442] nixos[2743]: finished switching to system configuration /nix/store/bj671x7sizpfcqslphs57rdwq73bclv9-nixos-system-machine-test machine: (finished: must succeed: /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test/specialisation/unitWithMultilineValue/bin/switch-to-configuration test 2>&1, in 2.04 seconds) machine: must succeed: /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test/specialisation/unitWithBackslash/bin/switch-to-configuration test 2>&1 machine # [ 48.900121] nixos[2888]: switching to system configuration /nix/store/vzw9w24k9yy39f5zmr7ap7gg4skj4dqk-nixos-system-machine-test machine # [ 48.902744] systemd[1]: Stopped target Remote File Systems. machine # [ 48.905496] systemd[1]: Stopped target Local File Systems. machine # [ 49.229379] systemd[1]: Reload requested from client PID 2888 ('.switch-to-conf') (unit backdoor.service)... machine # [ 49.231398] systemd[1]: Reloading... machine # [ 49.592805] systemd[1]: Reloading finished in 359 ms. machine # [ 49.684566] systemd[568]: Reexecution requested from client PID 2957 ('switch-to-confi')... machine # [ 49.688427] systemd[568]: Reexecuting. machine # [ 49.743409] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 49.872088] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 49.879279] systemd[568]: Reload requested from client PID 2957 ('switch-to-confi')... machine # [ 49.883362] systemd[568]: Reloading... machine # [ 50.004068] systemd[568]: Reloading finished in 121 ms. machine # [ 50.020185] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 50.031719] systemd[568]: Stopped Run user-specific NixOS activation. machine # [ 50.034258] systemd[568]: Stopping Run user-specific NixOS activation... machine # [ 50.036309] systemd[568]: Starting Run user-specific NixOS activation... machine # [ 50.070050] systemd[568]: Finished Run user-specific NixOS activation. machine # [ 50.074372] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 50.077173] systemd[1]: Stopping Reactivate sysinit units... machine # [ 50.078073] systemd[1]: Reached target Reactivate sysinit units. machine # [ 50.078961] systemd[1]: Reached target Remote File Systems. machine # [ 50.084102] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 50.085567] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 50.090860] systemd[1]: Reached target Local File Systems. machine # [ 50.094426] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 50.098710] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 50.099648] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 50.108974] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 50.111266] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 50.114521] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 50.115839] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 50.287412] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 50.294349] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 50.295252] systemd[1]: Starting escaped\x2ddash.service... machine # [ 50.297970] systemd[1]: Starting linger-users.service... machine # [ 50.337339] systemd[1]: Finished escaped\x2ddash.service. machine # [ 50.356166] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 50.359153] systemd[1]: Finished linger-users.service. machine # [ 50.619058] nixos[2888]: finished switching to system configuration /nix/store/vzw9w24k9yy39f5zmr7ap7gg4skj4dqk-nixos-system-machine-test machine: (finished: must succeed: /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test/specialisation/unitWithBackslash/bin/switch-to-configuration test 2>&1, in 2.06 seconds) machine: must succeed: /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test/specialisation/unitWithBackslashModified/bin/switch-to-configuration test 2>&1 machine # [ 50.936600] nixos[3030]: switching to system configuration /nix/store/nwaj0js2z1i8qwp3cw3y4lgacda53v1r-nixos-system-machine-test machine # [ 50.939176] systemd[1]: Stopped target Remote File Systems. machine # [ 50.942711] systemd[1]: escaped\x2ddash.service: Deactivated successfully. machine # [ 50.943792] systemd[1]: Stopped escaped\x2ddash.service. machine # [ 50.945358] systemd[1]: Stopped target Local File Systems. machine # [ 51.255471] systemd[1]: Reload requested from client PID 3030 ('.switch-to-conf') (unit backdoor.service)... machine # [ 51.257655] systemd[1]: Reloading... machine # [ 51.615946] systemd[1]: Reloading finished in 356 ms. machine # [ 51.708885] systemd[568]: Reexecution requested from client PID 3099 ('switch-to-confi')... machine # [ 51.713332] systemd[568]: Reexecuting. machine # [ 51.776155] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 51.901438] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 51.908467] systemd[568]: Reload requested from client PID 3099 ('switch-to-confi')... machine # [ 51.912092] systemd[568]: Reloading... machine # [ 52.031398] systemd[568]: Reloading finished in 118 ms. machine # [ 52.045786] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 52.053505] systemd[568]: Stopped Run user-specific NixOS activation. machine # [ 52.056212] systemd[568]: Stopping Run user-specific NixOS activation... machine # [ 52.058557] systemd[568]: Starting Run user-specific NixOS activation... machine # [ 52.094702] systemd[568]: Finished Run user-specific NixOS activation. machine # [ 52.098964] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 52.101792] systemd[1]: Stopping Reactivate sysinit units... machine # [ 52.102699] systemd[1]: Reached target Reactivate sysinit units. machine # [ 52.108082] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 52.109442] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 52.116198] systemd[1]: Reached target Remote File Systems. machine # [ 52.120221] systemd[1]: Starting escaped\x2ddash.service... machine # [ 52.123858] systemd[1]: Starting linger-users.service... machine # [ 52.128665] systemd[1]: Reached target Local File Systems. machine # [ 52.132193] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 52.144589] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 52.149496] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 52.150853] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 52.157991] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 52.159662] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 52.161037] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 52.202450] systemd[1]: Finished escaped\x2ddash.service. machine # [ 52.234349] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 52.237844] systemd[1]: Finished linger-users.service. machine # [ 52.381104] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 52.383294] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 52.645408] nixos[3030]: finished switching to system configuration /nix/store/nwaj0js2z1i8qwp3cw3y4lgacda53v1r-nixos-system-machine-test machine: (finished: must succeed: /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test/specialisation/unitWithBackslashModified/bin/switch-to-configuration test 2>&1, in 2.03 seconds) machine: must succeed: /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test/specialisation/unitStartingWithDash/bin/switch-to-configuration test 2>&1 machine # [ 52.982581] nixos[3172]: switching to system configuration /nix/store/wnhr7ax9mz909pc8dzp75sycwi38azqz-nixos-system-machine-test machine # [ 52.985755] systemd[1]: Stopped target Local File Systems. machine # [ 52.987406] systemd[1]: Stopped target Remote File Systems. machine # [ 52.990254] systemd[1]: escaped\x2ddash.service: Deactivated successfully. machine # [ 52.991284] systemd[1]: Stopped escaped\x2ddash.service. machine # [ 53.278407] systemd[1]: Reload requested from client PID 3172 ('.switch-to-conf') (unit backdoor.service)... machine # [ 53.280513] systemd[1]: Reloading... machine # [ 53.621845] systemd[1]: Reloading finished in 339 ms. machine # [ 53.715864] systemd[568]: Reexecution requested from client PID 3241 ('switch-to-confi')... machine # [ 53.719799] systemd[568]: Reexecuting. machine # [ 53.764139] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 53.881058] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 53.887513] systemd[568]: Reload requested from client PID 3241 ('switch-to-confi')... machine # [ 53.891589] systemd[568]: Reloading... machine # [ 54.005853] systemd[568]: Reloading finished in 115 ms. machine # [ 54.024326] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 54.034193] systemd[568]: Stopped Run user-specific NixOS activation. machine # [ 54.037033] systemd[568]: Stopping Run user-specific NixOS activation... machine # [ 54.039291] systemd[568]: Starting Run user-specific NixOS activation... machine # [ 54.077644] systemd[568]: Finished Run user-specific NixOS activation. machine # [ 54.082073] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 54.085842] systemd[1]: Stopping Reactivate sysinit units... machine # [ 54.086790] systemd[1]: Reached target Reactivate sysinit units. machine # [ 54.090782] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 54.094239] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 54.097032] systemd[1]: Reached target Local File Systems. machine # [ 54.101915] systemd[1]: Reached target Remote File Systems. machine # [ 54.104328] systemd[1]: Starting -.service... machine # [ 54.108726] systemd[1]: Starting linger-users.service... machine # [ 54.124801] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 54.133712] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 54.134708] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 54.136005] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 54.143791] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 54.149224] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 54.154483] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 54.186428] systemd[1]: Finished -.service. machine # [ 54.226038] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 54.230679] systemd[1]: Finished linger-users.service. machine # [ 54.375512] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 54.379171] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 54.638351] nixos[3172]: finished switching to system configuration /nix/store/wnhr7ax9mz909pc8dzp75sycwi38azqz-nixos-system-machine-test machine: (finished: must succeed: /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test/specialisation/unitStartingWithDash/bin/switch-to-configuration test 2>&1, in 1.99 seconds) machine: must succeed: /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test/specialisation/unitStartingWithDashModified/bin/switch-to-configuration test 2>&1 machine # [ 54.929596] nixos[3314]: switching to system configuration /nix/store/6972bllwsvw66pyj58igbh91sjywwij6-nixos-system-machine-test machine # [ 54.933368] systemd[1]: Stopped target Local File Systems. machine # [ 54.935133] systemd[1]: Stopped target Remote File Systems. machine # [ 55.231600] systemd[1]: Reload requested from client PID 3314 ('.switch-to-conf') (unit backdoor.service)... machine # [ 55.233750] systemd[1]: Reloading... machine # [ 55.614689] systemd[1]: Reloading finished in 379 ms. machine # [ 55.706293] systemd[568]: Reexecution requested from client PID 3383 ('switch-to-confi')... machine # [ 55.710076] systemd[568]: Reexecuting. machine # [ 55.759632] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 55.875405] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 55.882332] systemd[568]: Reload requested from client PID 3383 ('switch-to-confi')... machine # [ 55.886345] systemd[568]: Reloading... machine # [ 56.000765] systemd[568]: Reloading finished in 115 ms. machine # [ 56.016192] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 56.025341] systemd[568]: Stopped Run user-specific NixOS activation. machine # [ 56.027944] systemd[568]: Stopping Run user-specific NixOS activation... machine # [ 56.030362] systemd[568]: Starting Run user-specific NixOS activation... machine # [ 56.061214] systemd[568]: Finished Run user-specific NixOS activation. machine # [ 56.065135] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 56.068329] systemd[1]: Stopping Reactivate sysinit units... machine # [ 56.069228] systemd[1]: Reached target Reactivate sysinit units. machine # [ 56.072736] systemd[1]: Reloading -.service... machine # [ 56.098569] systemd[1]: Reloaded -.service. machine # [ 56.102626] systemd[1]: Reached target Remote File Systems. machine # [ 56.105277] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 56.109451] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 56.112928] systemd[1]: Reached target Local File Systems. machine # [ 56.116543] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 56.119935] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 56.124494] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 56.125776] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 56.127973] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 56.137100] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 56.138419] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 56.305955] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 56.310833] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 56.313043] systemd[1]: Starting linger-users.service... machine # [ 56.353995] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 56.357124] systemd[1]: Finished linger-users.service. machine # [ 56.614213] nixos[3314]: finished switching to system configuration /nix/store/6972bllwsvw66pyj58igbh91sjywwij6-nixos-system-machine-test machine: (finished: must succeed: /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test/specialisation/unitStartingWithDashModified/bin/switch-to-configuration test 2>&1, in 1.98 seconds) machine: must succeed: /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test/specialisation/unitWithRequirement/bin/switch-to-configuration test 2>&1 machine # [ 56.916890] nixos[3456]: switching to system configuration /nix/store/mxjwscichssschxcpch8hnyn0ykj96rr-nixos-system-machine-test machine # [ 56.919455] systemd[1]: Stopped target Local File Systems. machine # [ 56.922054] systemd[1]: -.service: Deactivated successfully. machine # [ 56.923000] systemd[1]: Stopped -.service. machine # [ 56.924631] systemd[1]: Stopped target Remote File Systems. machine # [ 57.211962] systemd[1]: Reload requested from client PID 3456 ('.switch-to-conf') (unit backdoor.service)... machine # [ 57.214568] systemd[1]: Reloading... machine # [ 57.555536] systemd[1]: Reloading finished in 339 ms. machine # [ 57.644464] systemd[568]: Reexecution requested from client PID 3525 ('switch-to-confi')... machine # [ 57.648295] systemd[568]: Reexecuting. machine # [ 57.703980] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 57.825787] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 57.832433] systemd[568]: Reload requested from client PID 3525 ('switch-to-confi')... machine # [ 57.836100] systemd[568]: Reloading... machine # [ 57.948172] systemd[568]: Reloading finished in 112 ms. machine # [ 57.964256] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 57.973633] systemd[568]: Stopped Run user-specific NixOS activation. machine # [ 57.976146] systemd[568]: Stopping Run user-specific NixOS activation... machine # [ 57.978604] systemd[568]: Starting Run user-specific NixOS activation... machine # [ 58.018023] systemd[568]: Finished Run user-specific NixOS activation. machine # [ 58.022904] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 58.025045] systemd[1]: Stopping Reactivate sysinit units... machine # [ 58.025988] systemd[1]: Reached target Reactivate sysinit units. machine # [ 58.031325] systemd[1]: Reached target Local File Systems. machine # [ 58.036191] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 58.040984] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 58.042025] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 58.043316] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 58.061915] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 58.063706] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 58.066739] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 58.068227] systemd[1]: Reached target Remote File Systems. machine # [ 58.069030] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 58.070339] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 58.281258] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 58.283164] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 58.290640] systemd[1]: Starting linger-users.service... machine # [ 58.295250] systemd[1]: Starting required-service.service... machine # [ 58.298391] systemd[1]: Starting test-service.service... machine # [ 58.362926] systemd[1]: Finished required-service.service. machine # [ 58.367313] systemd[1]: Finished test-service.service. machine # [ 58.389922] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 58.391762] systemd[1]: Finished linger-users.service. machine # [ 58.654041] nixos[3456]: finished switching to system configuration /nix/store/mxjwscichssschxcpch8hnyn0ykj96rr-nixos-system-machine-test machine: (finished: must succeed: /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test/specialisation/unitWithRequirement/bin/switch-to-configuration test 2>&1, in 2.04 seconds) machine: must succeed: /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test/specialisation/unitWithRequirementModified/bin/switch-to-configuration test 2>&1 machine # [ 58.965721] nixos[3600]: switching to system configuration /nix/store/xbn1p6vyrcfrr4dvrpjg110bmjq6vfba-nixos-system-machine-test machine # [ 58.968651] systemd[1]: Stopped target Remote File Systems. machine # [ 58.973673] systemd[1]: Stopped target Local File Systems. machine # [ 58.974801] systemd[1]: required-service.service: Deactivated successfully. machine # [ 58.975830] systemd[1]: Stopped required-service.service. machine # [ 58.977756] systemd[1]: test-service.service: Deactivated successfully. machine # [ 58.980146] systemd[1]: Stopped test-service.service. machine # [ 59.286830] systemd[1]: Reload requested from client PID 3600 ('.switch-to-conf') (unit backdoor.service)... machine # [ 59.288996] systemd[1]: Reloading... machine # [ 59.642885] systemd[1]: Reloading finished in 352 ms. machine # [ 59.739961] systemd[568]: Reexecution requested from client PID 3669 ('switch-to-confi')... machine # [ 59.744633] systemd[568]: Reexecuting. machine # [ 59.799986] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 59.927277] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 59.935352] systemd[568]: Reload requested from client PID 3669 ('switch-to-confi')... machine # [ 59.938774] systemd[568]: Reloading... machine # [ 60.053903] systemd[568]: Reloading finished in 116 ms. machine # [ 60.068440] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 60.080110] systemd[568]: Stopped Run user-specific NixOS activation. machine # [ 60.081253] systemd[568]: Stopping Run user-specific NixOS activation... machine # [ 60.084449] systemd[568]: Starting Run user-specific NixOS activation... machine # [ 60.127917] systemd[568]: Finished Run user-specific NixOS activation. machine # [ 60.133728] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 60.136691] systemd[1]: Stopping Reactivate sysinit units... machine # [ 60.137684] systemd[1]: Reached target Reactivate sysinit units. machine # [ 60.145158] systemd[1]: Starting required-service.service... machine # [ 60.150289] systemd[1]: Starting test-service.service... machine # [ 60.157832] systemd[1]: Reached target Remote File Systems. machine # [ 60.171734] systemd[1]: Reached target Local File Systems. machine # [ 60.176267] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 60.177850] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 60.178678] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 60.179979] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 60.204389] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 60.206170] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 60.219767] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 60.227613] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 60.235178] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 60.251726] systemd[1]: Finished test-service.service. machine # [ 60.254056] systemd[1]: Finished required-service.service. machine # [ 60.433918] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 60.437110] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 60.441760] systemd[1]: Starting linger-users.service... machine # [ 60.496803] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 60.499785] systemd[1]: Finished linger-users.service. machine # [ 60.756603] nixos[3600]: finished switching to system configuration /nix/store/xbn1p6vyrcfrr4dvrpjg110bmjq6vfba-nixos-system-machine-test machine: (finished: must succeed: /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test/specialisation/unitWithRequirementModified/bin/switch-to-configuration test 2>&1, in 2.10 seconds) machine: must succeed: /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test/specialisation/unitWithRequirementModifiedNostart/bin/switch-to-configuration test 2>&1 machine # [ 61.038315] nixos[3744]: switching to system configuration /nix/store/s50bi1p0h5d9cyjrv2jcf8kc77qbkbic-nixos-system-machine-test machine # [ 61.040997] systemd[1]: Stopped target Local File Systems. machine # [ 61.045623] systemd[1]: Stopped target Remote File Systems. machine # [ 61.046544] systemd[1]: required-service.service: Deactivated successfully. machine # [ 61.047596] systemd[1]: Stopped required-service.service. machine # [ 61.048888] systemd[1]: test-service.service: Deactivated successfully. machine # [ 61.050914] systemd[1]: Stopped test-service.service. machine # [ 61.349958] systemd[1]: Reload requested from client PID 3744 ('.switch-to-conf') (unit backdoor.service)... machine # [ 61.351944] systemd[1]: Reloading... machine # [ 61.694357] systemd[1]: Reloading finished in 340 ms. machine # [ 61.783881] systemd[568]: Reexecution requested from client PID 3813 ('switch-to-confi')... machine # [ 61.787585] systemd[568]: Reexecuting. machine # [ 61.839452] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 61.956833] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 61.963359] systemd[568]: Reload requested from client PID 3813 ('switch-to-confi')... machine # [ 61.966702] systemd[568]: Reloading... machine # [ 62.075996] systemd[568]: Reloading finished in 110 ms. machine # [ 62.088153] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 62.098379] systemd[568]: Stopped Run user-specific NixOS activation. machine # [ 62.100664] systemd[568]: Stopping Run user-specific NixOS activation... machine # [ 62.102717] systemd[568]: Starting Run user-specific NixOS activation... machine # [ 62.135680] systemd[568]: Finished Run user-specific NixOS activation. machine # [ 62.139575] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 62.141458] systemd[1]: Stopping Reactivate sysinit units... machine # [ 62.142283] systemd[1]: Reached target Reactivate sysinit units. machine # [ 62.146387] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 62.147755] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 62.150020] systemd[1]: Reached target Remote File Systems. machine # [ 62.155645] systemd[1]: Reached target Local File Systems. machine # [ 62.159077] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 62.162852] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 62.163707] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 62.172794] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 62.174999] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 62.179859] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 62.181312] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 62.340105] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 62.344472] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 62.347669] systemd[1]: Starting linger-users.service... machine # [ 62.351665] systemd[1]: Starting required-service.service... machine # [ 62.356533] systemd[1]: Starting test-service.service... machine # [ 62.403972] systemd[1]: Finished required-service.service. machine # [ 62.407372] systemd[1]: Finished test-service.service. machine # [ 62.423586] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 62.426457] systemd[1]: Finished linger-users.service. machine # [ 62.683182] nixos[3744]: finished switching to system configuration /nix/store/s50bi1p0h5d9cyjrv2jcf8kc77qbkbic-nixos-system-machine-test machine: (finished: must succeed: /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test/specialisation/unitWithRequirementModifiedNostart/bin/switch-to-configuration test 2>&1, in 1.93 seconds) machine: must succeed: /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test/specialisation/unitWithTemplate/bin/switch-to-configuration test 2>&1 machine # [ 62.977549] nixos[3888]: switching to system configuration /nix/store/j7f25ik3lp1zxlvv502y7qydkcvkm6h6-nixos-system-machine-test machine # [ 62.980066] systemd[1]: Stopped target Local File Systems. machine # [ 62.982511] systemd[1]: test-service.service: Deactivated successfully. machine # [ 62.983520] systemd[1]: Stopped test-service.service. machine # [ 62.986166] systemd[1]: Stopped target Remote File Systems. machine # [ 62.987004] systemd[1]: required-service.service: Deactivated successfully. machine # [ 62.987937] systemd[1]: Stopped required-service.service. machine # [ 63.267845] systemd[1]: Reload requested from client PID 3888 ('.switch-to-conf') (unit backdoor.service)... machine # [ 63.269988] systemd[1]: Reloading... machine # [ 63.598466] systemd[1]: Reloading finished in 326 ms. machine # [ 63.686009] systemd[568]: Reexecution requested from client PID 3956 ('switch-to-confi')... machine # [ 63.687393] systemd[568]: Reexecuting. machine # [ 63.743431] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 63.858240] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 63.864453] systemd[568]: Reload requested from client PID 3956 ('switch-to-confi')... machine # [ 63.866573] systemd[568]: Reloading... machine # [ 63.975085] systemd[568]: Reloading finished in 108 ms. machine # [ 63.996170] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 64.006125] systemd[568]: Stopped Run user-specific NixOS activation. machine # [ 64.008476] systemd[568]: Stopping Run user-specific NixOS activation... machine # [ 64.010522] systemd[568]: Starting Run user-specific NixOS activation... machine # [ 64.043484] systemd[568]: Finished Run user-specific NixOS activation. machine # [ 64.046956] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 64.048854] systemd[1]: Stopping Reactivate sysinit units... machine # [ 64.049686] systemd[1]: Reached target Reactivate sysinit units. machine # [ 64.053719] systemd[1]: Reached target Local File Systems. machine # [ 64.056463] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 64.060600] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 64.061469] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 64.062652] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 64.078830] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 64.081892] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 64.083191] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 64.084430] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 64.085672] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 64.086950] systemd[1]: Reached target Remote File Systems. machine # [ 64.087722] systemd[1]: Created slice Slice /system/instantiated. machine # [ 64.241152] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 64.245952] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 64.248286] systemd[1]: Starting instantiated@one.service... machine # [ 64.252601] systemd[1]: Starting instantiated@two.service... machine # [ 64.263426] systemd[1]: Starting linger-users.service... machine # [ 64.305581] systemd[1]: Finished instantiated@one.service. machine # [ 64.308118] systemd[1]: Finished instantiated@two.service. machine # [ 64.326259] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 64.327870] systemd[1]: Finished linger-users.service. machine # [ 64.588810] nixos[3888]: finished switching to system configuration /nix/store/j7f25ik3lp1zxlvv502y7qydkcvkm6h6-nixos-system-machine-test machine: (finished: must succeed: /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test/specialisation/unitWithTemplate/bin/switch-to-configuration test 2>&1, in 1.90 seconds) machine: must succeed: /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test/specialisation/unitWithTemplateModified/bin/switch-to-configuration test 2>&1 machine # [ 64.913208] nixos[4032]: switching to system configuration /nix/store/bf57wrym2alqassxmh77vbp369n3wb9d-nixos-system-machine-test machine # [ 64.916308] systemd[1]: Stopped target Local File Systems. machine # [ 64.919641] systemd[1]: Stopped target Remote File Systems. machine # [ 64.922428] systemd[1]: instantiated@one.service: Deactivated successfully. machine # [ 64.923479] systemd[1]: Stopped instantiated@one.service. machine # [ 64.924929] systemd[1]: instantiated@two.service: Deactivated successfully. machine # [ 64.925943] systemd[1]: Stopped instantiated@two.service. machine # [ 65.226128] systemd[1]: Reload requested from client PID 4032 ('.switch-to-conf') (unit backdoor.service)... machine # [ 65.228421] systemd[1]: Reloading... machine # [ 65.587950] systemd[1]: Reloading finished in 357 ms. machine # [ 65.680454] systemd[568]: Reexecution requested from client PID 4101 ('switch-to-confi')... machine # [ 65.684333] systemd[568]: Reexecuting. machine # [ 65.734989] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 65.856923] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 65.863713] systemd[568]: Reload requested from client PID 4101 ('switch-to-confi')... machine # [ 65.868070] systemd[568]: Reloading... machine # [ 65.982998] systemd[568]: Reloading finished in 116 ms. machine # [ 66.000190] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 66.009570] systemd[568]: Stopped Run user-specific NixOS activation. machine # [ 66.012279] systemd[568]: Stopping Run user-specific NixOS activation... machine # [ 66.014578] systemd[568]: Starting Run user-specific NixOS activation... machine # [ 66.052340] systemd[568]: Finished Run user-specific NixOS activation. machine # [ 66.057487] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 66.061058] systemd[1]: Stopping Reactivate sysinit units... machine # [ 66.062626] systemd[1]: Reached target Reactivate sysinit units. machine # [ 66.065084] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 66.066439] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 66.069504] systemd[1]: Reached target Remote File Systems. machine # [ 66.074998] systemd[1]: Starting instantiated@two.service... machine # [ 66.097409] systemd[1]: Starting instantiated@one.service... machine # [ 66.104673] systemd[1]: Starting linger-users.service... machine # [ 66.119362] systemd[1]: Reached target Local File Systems. machine # [ 66.129951] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 66.131499] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 66.137731] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 66.139034] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 66.156371] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 66.158165] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 66.159607] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 66.172547] systemd[1]: Finished instantiated@two.service. machine # [ 66.173450] systemd[1]: Finished instantiated@one.service. machine # [ 66.211114] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 66.216277] systemd[1]: Finished linger-users.service. machine # [ 66.353594] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 66.355408] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 66.614989] nixos[4032]: finished switching to system configuration /nix/store/bf57wrym2alqassxmh77vbp369n3wb9d-nixos-system-machine-test machine: (finished: must succeed: /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test/specialisation/unitWithTemplateModified/bin/switch-to-configuration test 2>&1, in 2.03 seconds) (finished: subtest: services, in 42.19 seconds) subtest: failing units machine: must succeed: /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test/specialisation/simpleServiceModified/bin/switch-to-configuration test 2>&1 machine # [ 66.900644] nixos[4176]: switching to system configuration /nix/store/b8v4dzxsp98n1mrz3y8s56yix8lk2gz1-nixos-system-machine-test machine # [ 66.903243] systemd[1]: instantiated@two.service: Deactivated successfully. machine # [ 66.908300] systemd[1]: Stopped instantiated@two.service. machine # [ 66.909197] systemd[1]: Stopped target Remote File Systems. machine # [ 66.910021] systemd[1]: Stopped target Local File Systems. machine # [ 66.910795] systemd[1]: instantiated@one.service: Deactivated successfully. machine # [ 66.911772] systemd[1]: Stopped instantiated@one.service. machine # [ 67.184526] systemd[1]: Reload requested from client PID 4176 ('.switch-to-conf') (unit backdoor.service)... machine # [ 67.186128] systemd[1]: Reloading... machine # [ 67.518507] systemd[1]: Reloading finished in 331 ms. machine # [ 67.612442] systemd[568]: Reexecution requested from client PID 4245 ('switch-to-confi')... machine # [ 67.616436] systemd[568]: Reexecuting. machine # [ 67.675798] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 67.797144] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 67.803706] systemd[568]: Reload requested from client PID 4245 ('switch-to-confi')... machine # [ 67.807754] systemd[568]: Reloading... machine # [ 67.921737] systemd[568]: Reloading finished in 113 ms. machine # [ 67.936235] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 67.946966] systemd[568]: Stopped Run user-specific NixOS activation. machine # [ 67.949614] systemd[568]: Stopping Run user-specific NixOS activation... machine # [ 67.951983] systemd[568]: Starting Run user-specific NixOS activation... machine # [ 67.986517] systemd[568]: Finished Run user-specific NixOS activation. machine # [ 67.990769] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 67.994378] systemd[1]: Stopping Reactivate sysinit units... machine # [ 67.995402] systemd[1]: Reached target Reactivate sysinit units. machine # [ 67.997915] systemd[1]: Reached target Remote File Systems. machine # [ 68.001848] systemd[1]: Reached target Local File Systems. machine # [ 68.005926] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 68.007377] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 68.008910] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 68.012440] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 68.013359] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 68.014677] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 68.030313] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 68.033044] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 68.034391] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 68.218107] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 68.221380] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 68.227702] systemd[1]: Starting linger-users.service... machine # [ 68.230642] systemd[1]: Starting test.service... machine # [ 68.278548] systemd[1]: Finished test.service. machine # [ 68.301235] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 68.303080] systemd[1]: Finished linger-users.service. machine # [ 68.566308] nixos[4176]: finished switching to system configuration /nix/store/b8v4dzxsp98n1mrz3y8s56yix8lk2gz1-nixos-system-machine-test machine: (finished: must succeed: /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test/specialisation/simpleServiceModified/bin/switch-to-configuration test 2>&1, in 1.95 seconds) machine: must fail: /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test/specialisation/simpleServiceFailing/bin/switch-to-configuration test 2>&1 machine # [ 68.881858] nixos[4318]: switching to system configuration /nix/store/dva9cqx7c1l6n124nf4jnf6n0q8g22i0-nixos-system-machine-test machine # [ 68.884709] systemd[1]: Stopped target Remote File Systems. machine # [ 68.887583] systemd[1]: test.service: Deactivated successfully. machine # [ 68.890097] systemd[1]: Stopped test.service. machine # [ 68.891169] systemd[1]: Stopped target Local File Systems. machine # [ 69.187654] systemd[1]: Reload requested from client PID 4318 ('.switch-to-conf') (unit backdoor.service)... machine # [ 69.189797] systemd[1]: Reloading... machine # [ 69.535089] systemd[1]: Reloading finished in 343 ms. machine # [ 69.628532] systemd[568]: Reexecution requested from client PID 4387 ('switch-to-confi')... machine # [ 69.629934] systemd[568]: Reexecuting. machine # [ 69.695986] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 69.818825] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 69.825736] systemd[568]: Reload requested from client PID 4387 ('switch-to-confi')... machine # [ 69.829845] systemd[568]: Reloading... machine # [ 69.938940] systemd[568]: Reloading finished in 110 ms. machine # [ 69.953980] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 69.963649] systemd[568]: Stopped Run user-specific NixOS activation. machine # [ 69.966213] systemd[568]: Stopping Run user-specific NixOS activation... machine # [ 69.968601] systemd[568]: Starting Run user-specific NixOS activation... machine # [ 70.006956] systemd[568]: Finished Run user-specific NixOS activation. machine # [ 70.011559] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 70.013915] systemd[1]: Stopping Reactivate sysinit units... machine # [ 70.014882] systemd[1]: Reached target Reactivate sysinit units. machine # [ 70.018240] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 70.021780] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 70.023817] systemd[1]: Reached target Local File Systems. machine # [ 70.028304] systemd[1]: Reached target Remote File Systems. machine # [ 70.034756] systemd[1]: Starting test.service... machine # [ 70.044455] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 70.053459] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 70.054459] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 70.055759] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 70.071468] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 70.076790] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 70.082380] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 70.099006] systemd[1]: test.service: Main process exited, code=exited, status=1/FAILURE machine # [ 70.104336] systemd[1]: test.service: Failed with result 'exit-code'. machine # [ 70.105666] systemd[1]: Failed to start test.service. machine # [ 70.277663] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 70.281176] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 70.286298] systemd[1]: Starting linger-users.service... machine # [ 70.335660] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 70.337912] systemd[1]: Finished linger-users.service. machine # [ 70.641390] nixos[4318]: switching to system configuration /nix/store/dva9cqx7c1l6n124nf4jnf6n0q8g22i0-nixos-system-machine-test failed (status 4) machine: (finished: must fail: /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test/specialisation/simpleServiceFailing/bin/switch-to-configuration test 2>&1, in 2.07 seconds) machine: must succeed: /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test/specialisation/autorestartService/bin/switch-to-configuration test 2>&1 machine # [ 70.922343] nixos[4461]: switching to system configuration /nix/store/5048fp8gd4ljaj0maxh10i1j8m5gw7s6-nixos-system-machine-test machine # [ 70.925331] systemd[1]: Stopped target Local File Systems. machine # [ 70.927773] systemd[1]: Stopped target Remote File Systems. machine # [ 71.230001] systemd[1]: Reload requested from client PID 4461 ('.switch-to-conf') (unit backdoor.service)... machine # [ 71.231993] systemd[1]: Reloading... machine # [ 71.579282] systemd[1]: Reloading finished in 345 ms. machine # [ 71.676541] systemd[568]: Reexecution requested from client PID 4530 ('switch-to-confi')... machine # [ 71.680749] systemd[568]: Reexecuting. machine # [ 71.735223] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 71.856213] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 71.863239] systemd[568]: Reload requested from client PID 4530 ('switch-to-confi')... machine # [ 71.867290] systemd[568]: Reloading... machine # [ 71.985178] systemd[568]: Reloading finished in 119 ms. machine # [ 72.001772] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 72.009948] systemd[568]: Stopped Run user-specific NixOS activation. machine # [ 72.012639] systemd[568]: Stopping Run user-specific NixOS activation... machine # [ 72.015026] systemd[568]: Starting Run user-specific NixOS activation... machine # [ 72.050469] systemd[568]: Finished Run user-specific NixOS activation. machine # [ 72.055313] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 72.058529] systemd[1]: Stopping Reactivate sysinit units... machine # [ 72.059518] systemd[1]: Reached target Reactivate sysinit units. machine # [ 72.065338] systemd[1]: Reached target Local File Systems. machine # [ 72.066262] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 72.070575] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 72.071633] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 72.081936] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 72.091292] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 72.094397] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 72.095729] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 72.097102] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 72.098400] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 72.099703] systemd[1]: Reached target Remote File Systems. machine # [ 72.277198] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 72.282620] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 72.284903] systemd[1]: Started autorestart.service. machine # [ 72.290602] systemd[1]: Starting linger-users.service... machine # [ 72.340952] systemd[1]: autorestart.service: Deactivated successfully. machine # [ 72.367435] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 72.369413] systemd[1]: Finished linger-users.service. machine # [ 72.631828] nixos[4461]: finished switching to system configuration /nix/store/5048fp8gd4ljaj0maxh10i1j8m5gw7s6-nixos-system-machine-test machine: (finished: must succeed: /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test/specialisation/autorestartService/bin/switch-to-configuration test 2>&1, in 1.99 seconds) machine # [ 72.709400] systemd[1]: Stopped autorestart.service. machine: must succeed: /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test/specialisation/autorestartService/bin/switch-to-configuration test 2>&1 machine # [ 72.955594] nixos[4608]: switching to system configuration /nix/store/5048fp8gd4ljaj0maxh10i1j8m5gw7s6-nixos-system-machine-test machine # [ 72.958238] systemd[1]: Stopped target Local File Systems. machine # [ 72.960533] systemd[1]: Stopped target Remote File Systems. machine # [ 73.235958] systemd[1]: Reload requested from client PID 4608 ('.switch-to-conf') (unit backdoor.service)... machine # [ 73.238078] systemd[1]: Reloading... machine # [ 73.558479] systemd[1]: Reloading finished in 318 ms. machine # [ 73.648426] systemd[568]: Reexecution requested from client PID 4677 ('switch-to-confi')... machine # [ 73.651896] systemd[568]: Reexecuting. machine # [ 73.715780] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 73.835565] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 73.842333] systemd[568]: Reload requested from client PID 4677 ('switch-to-confi')... machine # [ 73.844752] systemd[568]: Reloading... machine # [ 73.957503] systemd[568]: Reloading finished in 111 ms. machine # [ 73.972184] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 73.981595] systemd[568]: Stopped Run user-specific NixOS activation. machine # [ 73.984064] systemd[568]: Stopping Run user-specific NixOS activation... machine # [ 73.986291] systemd[568]: Starting Run user-specific NixOS activation... machine # [ 74.016878] systemd[568]: Finished Run user-specific NixOS activation. machine # [ 74.020859] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 74.023950] systemd[1]: Stopping Reactivate sysinit units... machine # [ 74.025664] systemd[1]: Reached target Reactivate sysinit units. machine # [ 74.026545] systemd[1]: Reached target Local File Systems. machine # [ 74.028310] systemd[1]: Reached target Remote File Systems. machine # [ 74.037282] systemd[1]: Started autorestart.service. machine # [ 74.042199] systemd[1]: Starting linger-users.service... machine # [ 74.056447] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 74.065808] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 74.066777] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 74.068006] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 74.078106] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 74.079785] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 74.092625] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 74.100474] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 74.102935] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 74.127310] systemd[1]: autorestart.service: Deactivated successfully. machine # [ 74.154150] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 74.157185] systemd[1]: Finished linger-users.service. machine # [ 74.296558] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 74.299849] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 74.559561] nixos[4608]: finished switching to system configuration /nix/store/5048fp8gd4ljaj0maxh10i1j8m5gw7s6-nixos-system-machine-test machine: (finished: must succeed: /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test/specialisation/autorestartService/bin/switch-to-configuration test 2>&1, in 1.84 seconds) machine # [ 74.634442] systemd[1]: Stopped autorestart.service. machine: must fail: /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test/specialisation/autorestartServiceFailing/bin/switch-to-configuration test 2>&1 machine # [ 74.896582] nixos[4755]: switching to system configuration /nix/store/ld1wdavl0cngk4wh8znf17wx824qbabg-nixos-system-machine-test machine # [ 74.899046] systemd[1]: Stopped target Remote File Systems. machine # [ 74.901208] systemd[1]: Stopped target Local File Systems. machine # [ 75.191329] systemd[1]: Reload requested from client PID 4755 ('.switch-to-conf') (unit backdoor.service)... machine # [ 75.193403] systemd[1]: Reloading... machine # [ 75.532194] systemd[1]: Reloading finished in 337 ms. machine # [ 75.623566] systemd[568]: Reexecution requested from client PID 4824 ('switch-to-confi')... machine # [ 75.627271] systemd[568]: Reexecuting. machine # [ 75.687557] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 75.808817] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 75.815727] systemd[568]: Reload requested from client PID 4824 ('switch-to-confi')... machine # [ 75.818943] systemd[568]: Reloading... machine # [ 75.929966] systemd[568]: Reloading finished in 112 ms. machine # [ 75.944180] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 75.952947] systemd[568]: Stopped Run user-specific NixOS activation. machine # [ 75.955465] systemd[568]: Stopping Run user-specific NixOS activation... machine # [ 75.957646] systemd[568]: Starting Run user-specific NixOS activation... machine # [ 75.988094] systemd[568]: Finished Run user-specific NixOS activation. machine # [ 75.991524] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 75.993971] systemd[1]: Stopping Reactivate sysinit units... machine # [ 75.994787] systemd[1]: Reached target Reactivate sysinit units. machine # [ 75.997299] systemd[1]: Reached target Local File Systems. machine # [ 76.002666] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 76.008660] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 76.009509] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 76.010714] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 76.022963] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 76.026612] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 76.028616] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 76.031141] systemd[1]: Reached target Remote File Systems. machine # [ 76.031963] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 76.033561] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 76.188690] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 76.192612] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 76.196404] systemd[1]: Started autorestart.service. machine # [ 76.200558] systemd[1]: Starting linger-users.service... machine # [ 76.234995] systemd[1]: autorestart.service: Main process exited, code=exited, status=1/FAILURE machine # [ 76.239699] systemd[1]: autorestart.service: Failed with result 'exit-code'. machine # [ 76.256853] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 76.258567] systemd[1]: Finished linger-users.service. machine # [ 76.554731] nixos[4755]: switching to system configuration /nix/store/ld1wdavl0cngk4wh8znf17wx824qbabg-nixos-system-machine-test failed (status 4) machine: (finished: must fail: /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test/specialisation/autorestartServiceFailing/bin/switch-to-configuration test 2>&1, in 1.92 seconds) (finished: subtest: failing units, in 9.94 seconds) subtest: unit file parser machine: must succeed: /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1 machine # [ 76.797820] nixos[4898]: switching to system configuration /nix/store/14nf8m8wg6yp4k3p9hj90zq8a1cmn3ji-nixos-system-machine-test machine # [ 76.800678] systemd[1]: Stopped target Local File Systems. machine # [ 76.803682] systemd[1]: Stopped autorestart.service. machine # [ 76.805305] systemd[1]: Stopped target Remote File Systems. machine # [ 77.068796] systemd[1]: Reload requested from client PID 4898 ('.switch-to-conf') (unit backdoor.service)... machine # [ 77.070672] systemd[1]: Reloading... machine # [ 77.390731] systemd[1]: Reloading finished in 318 ms. machine # [ 77.482759] systemd[568]: Reexecution requested from client PID 4967 ('switch-to-confi')... machine # [ 77.486710] systemd[568]: Reexecuting. machine # [ 77.535852] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 77.650743] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 77.657659] systemd[568]: Reload requested from client PID 4967 ('switch-to-confi')... machine # [ 77.659822] systemd[568]: Reloading... machine # [ 77.773175] systemd[568]: Reloading finished in 112 ms. machine # [ 77.784174] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 77.794080] systemd[568]: Stopped Run user-specific NixOS activation. machine # [ 77.796420] systemd[568]: Stopping Run user-specific NixOS activation... machine # [ 77.798514] systemd[568]: Starting Run user-specific NixOS activation... machine # [ 77.832425] systemd[568]: Finished Run user-specific NixOS activation. machine # [ 77.836743] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 77.839796] systemd[1]: Stopping Reactivate sysinit units... machine # [ 77.841184] systemd[1]: Reached target Reactivate sysinit units. machine # [ 77.842030] systemd[1]: Reached target Local File Systems. machine # [ 77.843855] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 77.847925] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 77.852990] systemd[1]: Reached target Remote File Systems. machine # [ 77.858208] systemd[1]: Starting linger-users.service... machine # [ 77.864626] systemd[1]: Starting test.service... machine # [ 77.865416] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 77.880114] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 77.881074] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 77.882292] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 77.887015] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 77.894410] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 77.895727] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 77.926265] systemd[1]: Finished test.service. machine # [ 77.954919] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 77.957724] systemd[1]: Finished linger-users.service. machine # [ 78.090453] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 78.093829] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 78.352588] nixos[4898]: finished switching to system configuration /nix/store/14nf8m8wg6yp4k3p9hj90zq8a1cmn3ji-nixos-system-machine-test machine: (finished: must succeed: /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1, in 1.80 seconds) machine: must succeed: /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test/specialisation/simpleServiceWithExtraSection/bin/switch-to-configuration test 2>&1 machine # [ 78.645797] nixos[5040]: switching to system configuration /nix/store/fwj8mana5a8rq0l988jxvy9m51ck80zj-nixos-system-machine-test machine # [ 78.649596] systemd[1]: Stopped target Local File Systems. machine # [ 78.651817] systemd[1]: Stopped target Remote File Systems. machine # [ 78.928823] systemd[1]: Reload requested from client PID 5040 ('.switch-to-conf') (unit backdoor.service)... machine # [ 78.930689] systemd[1]: Reloading... machine # [ 79.252085] systemd[1]: Reloading finished in 319 ms. machine # [ 79.343937] systemd[568]: Reexecution requested from client PID 5109 ('switch-to-confi')... machine # [ 79.346178] systemd[568]: Reexecuting. machine # [ 79.395164] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 79.512099] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 79.518393] systemd[568]: Reload requested from client PID 5109 ('switch-to-confi')... machine # [ 79.521828] systemd[568]: Reloading... machine # [ 79.631789] systemd[568]: Reloading finished in 110 ms. machine # [ 79.648166] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 79.656707] systemd[568]: Stopped Run user-specific NixOS activation. machine # [ 79.658998] systemd[568]: Stopping Run user-specific NixOS activation... machine # [ 79.661020] systemd[568]: Starting Run user-specific NixOS activation... machine # [ 79.691398] systemd[568]: Finished Run user-specific NixOS activation. machine # [ 79.694666] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 79.696648] systemd[1]: Stopping Reactivate sysinit units... machine # [ 79.697474] systemd[1]: Reached target Reactivate sysinit units. machine # [ 79.700439] systemd[1]: test.service: Deactivated successfully. machine # [ 79.701353] systemd[1]: Stopped test.service. machine # [ 79.701972] systemd[1]: Stopping test.service... machine # [ 79.704770] systemd[1]: Starting test.service... machine # [ 79.728811] systemd[1]: Finished test.service. machine # [ 79.733198] systemd[1]: Reached target Remote File Systems. machine # [ 79.737152] systemd[1]: Starting linger-users.service... machine # [ 79.748939] systemd[1]: Reached target Local File Systems. machine # [ 79.749777] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 79.756222] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 79.757126] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 79.758343] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 79.772513] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 79.774220] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 79.782474] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 79.787852] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 79.791396] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 79.823130] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 79.827416] systemd[1]: Finished linger-users.service. machine # [ 79.955976] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 79.959256] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 80.218350] nixos[5040]: finished switching to system configuration /nix/store/fwj8mana5a8rq0l988jxvy9m51ck80zj-nixos-system-machine-test machine: (finished: must succeed: /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test/specialisation/simpleServiceWithExtraSection/bin/switch-to-configuration test 2>&1, in 1.87 seconds) machine: must succeed: /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test/specialisation/simpleServiceWithExtraSectionOtherName/bin/switch-to-configuration test 2>&1 machine # [ 80.520425] nixos[5182]: switching to system configuration /nix/store/azrmqa7q6pqcdiq78rbpv3yiyp7dxvrz-nixos-system-machine-test machine # [ 80.522919] systemd[1]: Stopped target Remote File Systems. machine # [ 80.525256] systemd[1]: Stopped target Local File Systems. machine # [ 80.810149] systemd[1]: Reload requested from client PID 5182 ('.switch-to-conf') (unit backdoor.service)... machine # [ 80.812204] systemd[1]: Reloading... machine # [ 81.148943] systemd[1]: Reloading finished in 335 ms. machine # [ 81.243130] systemd[568]: Reexecution requested from client PID 5251 ('switch-to-confi')... machine # [ 81.245354] systemd[568]: Reexecuting. machine # [ 81.303389] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 81.430375] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 81.437507] systemd[568]: Reload requested from client PID 5251 ('switch-to-confi')... machine # [ 81.438963] systemd[568]: Reloading... machine # [ 81.553614] systemd[568]: Reloading finished in 112 ms. machine # [ 81.569906] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 81.579243] systemd[568]: Stopped Run user-specific NixOS activation. machine # [ 81.582076] systemd[568]: Stopping Run user-specific NixOS activation... machine # [ 81.584724] systemd[568]: Starting Run user-specific NixOS activation... machine # [ 81.624528] systemd[568]: Finished Run user-specific NixOS activation. machine # [ 81.630090] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 81.631152] systemd[1]: Stopping Reactivate sysinit units... machine # [ 81.631945] systemd[1]: Reached target Reactivate sysinit units. machine # [ 81.635121] systemd[1]: test.service: Deactivated successfully. machine # [ 81.639041] systemd[1]: Stopped test.service. machine # [ 81.639824] systemd[1]: Stopping test.service... machine # [ 81.643387] systemd[1]: Starting test.service... machine # [ 81.677114] systemd[1]: Finished test.service. machine # [ 81.680613] systemd[1]: Reached target Remote File Systems. machine # [ 81.687387] systemd[1]: Reached target Local File Systems. machine # [ 81.691712] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 81.696672] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 81.697622] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 81.698952] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 81.708451] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 81.710156] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 81.711445] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 81.718975] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 81.721600] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 81.930522] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 81.932603] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 81.938235] systemd[1]: Starting linger-users.service... machine # [ 81.988436] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 81.991479] systemd[1]: Finished linger-users.service. machine # [ 82.250131] nixos[5182]: finished switching to system configuration /nix/store/azrmqa7q6pqcdiq78rbpv3yiyp7dxvrz-nixos-system-machine-test machine: (finished: must succeed: /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test/specialisation/simpleServiceWithExtraSectionOtherName/bin/switch-to-configuration test 2>&1, in 2.03 seconds) machine: must succeed: /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1 machine # [ 82.535613] nixos[5324]: switching to system configuration /nix/store/14nf8m8wg6yp4k3p9hj90zq8a1cmn3ji-nixos-system-machine-test machine # [ 82.541022] systemd[1]: Stopped target Local File Systems. machine # [ 82.541907] systemd[1]: Stopped target Remote File Systems. machine # [ 82.801253] systemd[1]: Reload requested from client PID 5324 ('.switch-to-conf') (unit backdoor.service)... machine # [ 82.803120] systemd[1]: Reloading... machine # [ 83.117581] systemd[1]: Reloading finished in 311 ms. machine # [ 83.206301] systemd[568]: Reexecution requested from client PID 5393 ('switch-to-confi')... machine # [ 83.210048] systemd[568]: Reexecuting. machine # [ 83.255109] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 83.367637] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 83.374209] systemd[568]: Reload requested from client PID 5393 ('switch-to-confi')... machine # [ 83.377661] systemd[568]: Reloading... machine # [ 83.486216] systemd[568]: Reloading finished in 109 ms. machine # [ 83.500161] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 83.510306] systemd[568]: Stopped Run user-specific NixOS activation. machine # [ 83.511367] systemd[568]: Stopping Run user-specific NixOS activation... machine # [ 83.514116] systemd[568]: Starting Run user-specific NixOS activation... machine # [ 83.544515] systemd[568]: Finished Run user-specific NixOS activation. machine # [ 83.548838] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 83.550718] systemd[1]: Stopping Reactivate sysinit units... machine # [ 83.551618] systemd[1]: Reached target Reactivate sysinit units. machine # [ 83.556502] systemd[1]: test.service: Deactivated successfully. machine # [ 83.557398] systemd[1]: Stopped test.service. machine # [ 83.558027] systemd[1]: Stopping test.service... machine # [ 83.558693] systemd[1]: Starting test.service... machine # [ 83.585577] systemd[1]: Finished test.service. machine # [ 83.590269] systemd[1]: Reached target Remote File Systems. machine # [ 83.592120] systemd[1]: Reached target Local File Systems. machine # [ 83.595065] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 83.600795] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 83.602076] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 83.606329] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 83.607212] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 83.615359] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 83.619980] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 83.621630] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 83.622878] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 83.792902] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 83.794721] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 83.799434] systemd[1]: Starting linger-users.service... machine # [ 83.841581] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 83.844376] systemd[1]: Finished linger-users.service. machine # [ 84.102575] nixos[5324]: finished switching to system configuration /nix/store/14nf8m8wg6yp4k3p9hj90zq8a1cmn3ji-nixos-system-machine-test machine: (finished: must succeed: /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1, in 1.85 seconds) machine: must succeed: /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test/specialisation/simpleServiceWithInstallSection/bin/switch-to-configuration test 2>&1 machine # [ 84.407772] nixos[5466]: switching to system configuration /nix/store/hkmg6vgwyb2bkwnbr0j7namf2n6nf2ls-nixos-system-machine-test machine # [ 84.410217] systemd[1]: Stopped target Remote File Systems. machine # [ 84.412722] systemd[1]: Stopped target Local File Systems. machine # [ 84.734357] systemd[1]: Reload requested from client PID 5466 ('.switch-to-conf') (unit backdoor.service)... machine # [ 84.736503] systemd[1]: Reloading... machine # [ 85.103477] systemd[1]: Reloading finished in 365 ms. machine # [ 85.202191] systemd[568]: Reexecution requested from client PID 5535 ('switch-to-confi')... machine # [ 85.203632] systemd[568]: Reexecuting. machine # [ 85.263773] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 85.389325] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 85.395692] systemd[568]: Reload requested from client PID 5535 ('switch-to-confi')... machine # [ 85.399515] systemd[568]: Reloading... machine # [ 85.510487] systemd[568]: Reloading finished in 112 ms. machine # [ 85.524216] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 85.534062] systemd[568]: Stopped Run user-specific NixOS activation. machine # [ 85.536409] systemd[568]: Stopping Run user-specific NixOS activation... machine # [ 85.538539] systemd[568]: Starting Run user-specific NixOS activation... machine # [ 85.572685] systemd[568]: Finished Run user-specific NixOS activation. machine # [ 85.576549] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 85.578516] systemd[1]: Stopping Reactivate sysinit units... machine # [ 85.579438] systemd[1]: Reached target Reactivate sysinit units. machine # [ 85.582615] systemd[1]: Reached target Local File Systems. machine # [ 85.587361] systemd[1]: Reached target Remote File Systems. machine # [ 85.589535] systemd[1]: Starting linger-users.service... machine # [ 85.600651] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 85.602044] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 85.609823] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 85.613479] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 85.614386] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 85.620382] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 85.626343] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 85.630497] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 85.631819] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 85.673297] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 85.677601] systemd[1]: Finished linger-users.service. machine # [ 85.820722] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 85.824355] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 86.083359] nixos[5466]: finished switching to system configuration /nix/store/hkmg6vgwyb2bkwnbr0j7namf2n6nf2ls-nixos-system-machine-test machine: (finished: must succeed: /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test/specialisation/simpleServiceWithInstallSection/bin/switch-to-configuration test 2>&1, in 1.98 seconds) machine: must succeed: /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test/specialisation/simpleServiceWithExtraKey/bin/switch-to-configuration test 2>&1 machine # [ 86.386743] nixos[5606]: switching to system configuration /nix/store/zhjnaiq0nqqgb9aw6vnp4bm3pky1jaa2-nixos-system-machine-test machine # [ 86.389260] systemd[1]: Stopped target Remote File Systems. machine # [ 86.391492] systemd[1]: Stopped target Local File Systems. machine # [ 86.705548] systemd[1]: Reload requested from client PID 5606 ('.switch-to-conf') (unit backdoor.service)... machine # [ 86.707636] systemd[1]: Reloading... machine # [ 87.181303] systemd[1]: Reloading finished in 471 ms. machine # [ 87.280895] systemd[568]: Reexecution requested from client PID 5675 ('switch-to-confi')... machine # [ 87.284267] systemd[568]: Reexecuting. machine # [ 87.347870] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 87.472759] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 87.479629] systemd[568]: Reload requested from client PID 5675 ('switch-to-confi')... machine # [ 87.483273] systemd[568]: Reloading... machine # [ 87.598755] systemd[568]: Reloading finished in 116 ms. machine # [ 87.616223] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 87.626458] systemd[568]: Stopped Run user-specific NixOS activation. machine # [ 87.629316] systemd[568]: Stopping Run user-specific NixOS activation... machine # [ 87.631768] systemd[568]: Starting Run user-specific NixOS activation... machine # [ 87.668397] systemd[568]: Finished Run user-specific NixOS activation. machine # [ 87.673114] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 87.675869] systemd[1]: Stopping Reactivate sysinit units... machine # [ 87.680313] systemd[1]: Reached target Reactivate sysinit units. machine # [ 87.681281] systemd[1]: test.service: Deactivated successfully. machine # [ 87.682112] systemd[1]: Stopped test.service. machine # [ 87.682848] systemd[1]: Stopping test.service... machine # [ 87.685037] systemd[1]: Starting test.service... machine # [ 87.716603] systemd[1]: Finished test.service. machine # [ 87.724234] systemd[1]: Reached target Remote File Systems. machine # [ 87.730177] systemd[1]: Starting linger-users.service... machine # [ 87.737124] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 87.738689] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 87.749042] systemd[1]: Reached target Local File Systems. machine # [ 87.750089] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 87.760378] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 87.761459] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 87.762764] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 87.775224] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 87.779671] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 87.785456] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 87.836469] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 87.840223] systemd[1]: Finished linger-users.service. machine # [ 88.003825] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 88.007380] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 88.263763] nixos[5606]: finished switching to system configuration /nix/store/zhjnaiq0nqqgb9aw6vnp4bm3pky1jaa2-nixos-system-machine-test machine: (finished: must succeed: /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test/specialisation/simpleServiceWithExtraKey/bin/switch-to-configuration test 2>&1, in 2.18 seconds) machine: must succeed: /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test/specialisation/simpleServiceWithExtraKeyOtherValue/bin/switch-to-configuration test 2>&1 machine # [ 88.579061] nixos[5748]: switching to system configuration /nix/store/kp0ijpkps26xv9lck91h497val077dzn-nixos-system-machine-test machine # [ 88.581952] systemd[1]: Stopped target Remote File Systems. machine # [ 88.584681] systemd[1]: Stopped target Local File Systems. machine # [ 88.902953] systemd[1]: Reload requested from client PID 5748 ('.switch-to-conf') (unit backdoor.service)... machine # [ 88.905030] systemd[1]: Reloading... machine # [ 89.257831] systemd[1]: Reloading finished in 350 ms. machine # [ 89.348447] systemd[568]: Reexecution requested from client PID 5817 ('switch-to-confi')... machine # [ 89.352217] systemd[568]: Reexecuting. machine # [ 89.415913] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 89.545168] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 89.551465] systemd[568]: Reload requested from client PID 5817 ('switch-to-confi')... machine # [ 89.555418] systemd[568]: Reloading... machine # [ 89.670019] systemd[568]: Reloading finished in 114 ms. machine # [ 89.686062] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 89.693814] systemd[568]: Stopped Run user-specific NixOS activation. machine # [ 89.696117] systemd[568]: Stopping Run user-specific NixOS activation... machine # [ 89.698516] systemd[568]: Starting Run user-specific NixOS activation... machine # [ 89.735290] systemd[568]: Finished Run user-specific NixOS activation. machine # [ 89.739582] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 89.741667] systemd[1]: Stopping Reactivate sysinit units... machine # [ 89.742548] systemd[1]: Reached target Reactivate sysinit units. machine # [ 89.746439] systemd[1]: test.service: Deactivated successfully. machine # [ 89.747429] systemd[1]: Stopped test.service. machine # [ 89.749808] systemd[1]: Stopping test.service... machine # [ 89.750653] systemd[1]: Starting test.service... machine # [ 89.774655] systemd[1]: Finished test.service. machine # [ 89.782212] systemd[1]: Reached target Remote File Systems. machine # [ 89.784687] systemd[1]: Starting linger-users.service... machine # [ 89.793028] systemd[1]: Reached target Local File Systems. machine # [ 89.800177] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 89.805292] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 89.806199] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 89.807423] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 89.818308] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 89.820000] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 89.828708] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 89.832175] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 89.837543] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 89.876263] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 89.879532] systemd[1]: Finished linger-users.service. machine # [ 90.022275] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 90.025567] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 90.283210] nixos[5748]: finished switching to system configuration /nix/store/kp0ijpkps26xv9lck91h497val077dzn-nixos-system-machine-test machine: (finished: must succeed: /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test/specialisation/simpleServiceWithExtraKeyOtherValue/bin/switch-to-configuration test 2>&1, in 2.02 seconds) machine: must succeed: /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test/specialisation/simpleServiceWithExtraKeyOtherName/bin/switch-to-configuration test 2>&1 machine # [ 90.638280] nixos[5890]: switching to system configuration /nix/store/bpyfh2lgj6a9rafq2mwhv4v79scz7a6g-nixos-system-machine-test machine # [ 90.642868] systemd[1]: Stopped target Local File Systems. machine # [ 90.644735] systemd[1]: Stopped target Remote File Systems. machine # [ 90.951217] systemd[1]: Reload requested from client PID 5890 ('.switch-to-conf') (unit backdoor.service)... machine # [ 90.953329] systemd[1]: Reloading... machine # [ 91.307350] systemd[1]: Reloading finished in 352 ms. machine # [ 91.404556] systemd[568]: Reexecution requested from client PID 5959 ('switch-to-confi')... machine # [ 91.408122] systemd[568]: Reexecuting. machine # [ 91.468170] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 91.592539] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 91.599628] systemd[568]: Reload requested from client PID 5959 ('switch-to-confi')... machine # [ 91.603360] systemd[568]: Reloading... machine # [ 91.722135] systemd[568]: Reloading finished in 119 ms. machine # [ 91.736191] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 91.745708] systemd[568]: Stopped Run user-specific NixOS activation. machine # [ 91.748100] systemd[568]: Stopping Run user-specific NixOS activation... machine # [ 91.750726] systemd[568]: Starting Run user-specific NixOS activation... machine # [ 91.788709] systemd[568]: Finished Run user-specific NixOS activation. machine # [ 91.792917] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 91.794937] systemd[1]: Stopping Reactivate sysinit units... machine # [ 91.795826] systemd[1]: Reached target Reactivate sysinit units. machine # [ 91.800528] systemd[1]: test.service: Deactivated successfully. machine # [ 91.801444] systemd[1]: Stopped test.service. machine # [ 91.802095] systemd[1]: Stopping test.service... machine # [ 91.804091] systemd[1]: Starting test.service... machine # [ 91.833163] systemd[1]: Finished test.service. machine # [ 91.838371] systemd[1]: Reached target Remote File Systems. machine # [ 91.843417] systemd[1]: Starting linger-users.service... machine # [ 91.849642] systemd[1]: Reached target Local File Systems. machine # [ 91.856709] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 91.860791] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 91.861711] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 91.862999] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 91.878872] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 91.884262] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 91.890429] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 91.893148] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 91.898415] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 91.939555] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 91.943362] systemd[1]: Finished linger-users.service. machine # [ 92.091391] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 92.094891] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 92.355256] nixos[5890]: finished switching to system configuration /nix/store/bpyfh2lgj6a9rafq2mwhv4v79scz7a6g-nixos-system-machine-test machine: (finished: must succeed: /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test/specialisation/simpleServiceWithExtraKeyOtherName/bin/switch-to-configuration test 2>&1, in 2.07 seconds) machine: must succeed: /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1 machine # [ 92.639762] nixos[6032]: switching to system configuration /nix/store/14nf8m8wg6yp4k3p9hj90zq8a1cmn3ji-nixos-system-machine-test machine # [ 92.642476] systemd[1]: Stopped target Local File Systems. machine # [ 92.644893] systemd[1]: Stopped target Remote File Systems. machine # [ 92.918477] systemd[1]: Reload requested from client PID 6032 ('.switch-to-conf') (unit backdoor.service)... machine # [ 92.920585] systemd[1]: Reloading... machine # [ 93.250045] systemd[1]: Reloading finished in 327 ms. machine # [ 93.344449] systemd[568]: Reexecution requested from client PID 6101 ('switch-to-confi')... machine # [ 93.345862] systemd[568]: Reexecuting. machine # [ 93.404502] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 93.529879] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 93.536512] systemd[568]: Reload requested from client PID 6101 ('switch-to-confi')... machine # [ 93.538892] systemd[568]: Reloading... machine # [ 93.653518] systemd[568]: Reloading finished in 113 ms. machine # [ 93.668183] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 93.679466] systemd[568]: Stopped Run user-specific NixOS activation. machine # [ 93.680695] systemd[568]: Stopping Run user-specific NixOS activation... machine # [ 93.682996] systemd[568]: Starting Run user-specific NixOS activation... machine # [ 93.716995] systemd[568]: Finished Run user-specific NixOS activation. machine # [ 93.721014] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 93.724367] systemd[1]: Stopping Reactivate sysinit units... machine # [ 93.725303] systemd[1]: Reached target Reactivate sysinit units. machine # [ 93.726151] systemd[1]: test.service: Deactivated successfully. machine # [ 93.727018] systemd[1]: Stopped test.service. machine # [ 93.727655] systemd[1]: Stopping test.service... machine # [ 93.731305] systemd[1]: Starting test.service... machine # [ 93.761779] systemd[1]: Finished test.service. machine # [ 93.765417] systemd[1]: Reached target Remote File Systems. machine # [ 93.770824] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 93.773466] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 93.780339] systemd[1]: Starting linger-users.service... machine # [ 93.783868] systemd[1]: Reached target Local File Systems. machine # [ 93.793881] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 93.795536] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 93.806313] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 93.807712] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 93.812267] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 93.814000] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 93.815313] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 93.873473] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 93.878088] systemd[1]: Finished linger-users.service. machine # [ 94.025381] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 94.028772] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 94.287507] nixos[6032]: finished switching to system configuration /nix/store/14nf8m8wg6yp4k3p9hj90zq8a1cmn3ji-nixos-system-machine-test machine: (finished: must succeed: /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1, in 1.93 seconds) machine: must succeed: /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test/specialisation/simpleServiceReloadTrigger/bin/switch-to-configuration test 2>&1 machine # [ 94.594845] nixos[6174]: switching to system configuration /nix/store/apnvky55swibdpp6k0zwdiqbk1d3nvw9-nixos-system-machine-test machine # [ 94.597837] systemd[1]: Stopped target Local File Systems. machine # [ 94.601049] systemd[1]: Stopped target Remote File Systems. machine # [ 94.919285] systemd[1]: Reload requested from client PID 6174 ('.switch-to-conf') (unit backdoor.service)... machine # [ 94.921605] systemd[1]: Reloading... machine # [ 95.290441] systemd[1]: Reloading finished in 367 ms. machine # [ 95.382941] systemd[568]: Reexecution requested from client PID 6243 ('switch-to-confi')... machine # [ 95.386668] systemd[568]: Reexecuting. machine # [ 95.444091] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 95.565385] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 95.571850] systemd[568]: Reload requested from client PID 6243 ('switch-to-confi')... machine # [ 95.575818] systemd[568]: Reloading... machine # [ 95.690210] systemd[568]: Reloading finished in 115 ms. machine # [ 95.704178] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 95.713074] systemd[568]: Stopped Run user-specific NixOS activation. machine # [ 95.715423] systemd[568]: Stopping Run user-specific NixOS activation... machine # [ 95.717576] systemd[568]: Starting Run user-specific NixOS activation... machine # [ 95.749113] systemd[568]: Finished Run user-specific NixOS activation. machine # [ 95.753345] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 95.757576] systemd[1]: Stopping Reactivate sysinit units... machine # [ 95.758501] systemd[1]: Reached target Reactivate sysinit units. machine # [ 95.760510] systemd[1]: Reloading test.service... machine # [ 95.785849] systemd[1]: Reloaded test.service. machine # [ 95.793518] systemd[1]: Reached target Local File Systems. machine # [ 95.796885] systemd[1]: Reached target Remote File Systems. machine # [ 95.797787] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 95.802149] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 95.803093] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 95.808466] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 95.810679] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 95.819932] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 95.822126] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 95.823852] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 95.825856] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 95.990713] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 95.995615] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 95.997900] systemd[1]: Starting linger-users.service... machine # [ 96.039752] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 96.042752] systemd[1]: Finished linger-users.service. machine # [ 96.301119] nixos[6174]: finished switching to system configuration /nix/store/apnvky55swibdpp6k0zwdiqbk1d3nvw9-nixos-system-machine-test machine: (finished: must succeed: /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test/specialisation/simpleServiceReloadTrigger/bin/switch-to-configuration test 2>&1, in 2.01 seconds) machine: must succeed: /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModified/bin/switch-to-configuration test 2>&1 machine # [ 96.608407] nixos[6316]: switching to system configuration /nix/store/5nyqmz89ws9mwqi9p5djq02n3hjldxd4-nixos-system-machine-test machine # [ 96.610927] systemd[1]: Stopped target Remote File Systems. machine # [ 96.612903] systemd[1]: Stopped target Local File Systems. machine # [ 96.905389] systemd[1]: Reload requested from client PID 6316 ('.switch-to-conf') (unit backdoor.service)... machine # [ 96.907308] systemd[1]: Reloading... machine # [ 97.246195] systemd[1]: Reloading finished in 337 ms. machine # [ 97.336328] systemd[568]: Reexecution requested from client PID 6385 ('switch-to-confi')... machine # [ 97.340483] systemd[568]: Reexecuting. machine # [ 97.395446] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 97.515255] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 97.522236] systemd[568]: Reload requested from client PID 6385 ('switch-to-confi')... machine # [ 97.525979] systemd[568]: Reloading... machine # [ 97.637215] systemd[568]: Reloading finished in 112 ms. machine # [ 97.652197] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 97.661545] systemd[568]: Stopped Run user-specific NixOS activation. machine # [ 97.663891] systemd[568]: Stopping Run user-specific NixOS activation... machine # [ 97.666163] systemd[568]: Starting Run user-specific NixOS activation... machine # [ 97.697299] systemd[568]: Finished Run user-specific NixOS activation. machine # [ 97.701206] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 97.705409] systemd[1]: Stopping Reactivate sysinit units... machine # [ 97.706342] systemd[1]: Reached target Reactivate sysinit units. machine # [ 97.708829] systemd[1]: Reloading test.service... machine # [ 97.734224] systemd[1]: Reloaded test.service. machine # [ 97.739803] systemd[1]: Reached target Local File Systems. machine # [ 97.743929] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 97.753349] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 97.754357] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 97.755643] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 97.764853] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 97.766571] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 97.767869] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 97.771529] systemd[1]: Reached target Remote File Systems. machine # [ 97.772780] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 97.774115] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 97.936433] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 97.940585] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 97.943422] systemd[1]: Starting linger-users.service... machine # [ 97.986999] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 97.990430] systemd[1]: Finished linger-users.service. machine # [ 98.247594] nixos[6316]: finished switching to system configuration /nix/store/5nyqmz89ws9mwqi9p5djq02n3hjldxd4-nixos-system-machine-test machine: (finished: must succeed: /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModified/bin/switch-to-configuration test 2>&1, in 1.95 seconds) machine: must succeed: /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModifiedAndSomethingElse/bin/switch-to-configuration test 2>&1 machine # [ 98.563774] nixos[6458]: switching to system configuration /nix/store/av1bi4ls17jw3rin7b191bnwir1wqswg-nixos-system-machine-test machine # [ 98.567793] systemd[1]: Stopped target Remote File Systems. machine # [ 98.569985] systemd[1]: Stopped target Local File Systems. machine # [ 98.883752] systemd[1]: Reload requested from client PID 6458 ('.switch-to-conf') (unit backdoor.service)... machine # [ 98.886017] systemd[1]: Reloading... machine # [ 99.255095] systemd[1]: Reloading finished in 367 ms. machine # [ 99.343299] systemd[568]: Reexecution requested from client PID 6527 ('switch-to-confi')... machine # [ 99.346921] systemd[568]: Reexecuting. machine # [ 99.403474] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 99.521137] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 99.527591] systemd[568]: Reload requested from client PID 6527 ('switch-to-confi')... machine # [ 99.531543] systemd[568]: Reloading... machine # [ 99.643497] systemd[568]: Reloading finished in 113 ms. machine # [ 99.660495] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 99.671216] systemd[568]: Stopped Run user-specific NixOS activation. machine # [ 99.672513] systemd[568]: Stopping Run user-specific NixOS activation... machine # [ 99.674953] systemd[568]: Starting Run user-specific NixOS activation... machine # [ 99.713910] systemd[568]: Finished Run user-specific NixOS activation. machine # [ 99.718661] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 99.721281] systemd[1]: Stopping Reactivate sysinit units... machine # [ 99.722217] systemd[1]: Reached target Reactivate sysinit units. machine # [ 99.726265] systemd[1]: test.service: Deactivated successfully. machine # [ 99.727285] systemd[1]: Stopped test.service. machine # [ 99.727963] systemd[1]: Stopping test.service... machine # [ 99.731326] systemd[1]: Starting test.service... machine # [ 99.760369] systemd[1]: Finished test.service. machine # [ 99.767588] systemd[1]: Reached target Local File Systems. machine # [ 99.772220] systemd[1]: Reached target Remote File Systems. machine # [ 99.773153] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 99.777309] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 99.778279] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 99.779606] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 99.788983] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 99.790677] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 99.791973] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 99.800346] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 99.802128] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 100.000701] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 100.004802] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 100.008226] systemd[1]: Starting linger-users.service... machine # [ 100.051266] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 100.053306] systemd[1]: Finished linger-users.service. machine # [ 100.312977] nixos[6458]: finished switching to system configuration /nix/store/av1bi4ls17jw3rin7b191bnwir1wqswg-nixos-system-machine-test machine: (finished: must succeed: /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModifiedAndSomethingElse/bin/switch-to-configuration test 2>&1, in 2.07 seconds) machine: must succeed: /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModifiedSomethingElse/bin/switch-to-configuration test 2>&1 machine # [ 100.585431] nixos[6600]: switching to system configuration /nix/store/zhjnaiq0nqqgb9aw6vnp4bm3pky1jaa2-nixos-system-machine-test machine # [ 100.589064] systemd[1]: Stopped target Remote File Systems. machine # [ 100.591232] systemd[1]: Stopped target Local File Systems. machine # [ 100.863002] systemd[1]: Reload requested from client PID 6600 ('.switch-to-conf') (unit backdoor.service)... machine # [ 100.865186] systemd[1]: Reloading... machine # [ 101.191090] systemd[1]: Reloading finished in 324 ms. machine # [ 101.281898] systemd[568]: Reexecution requested from client PID 6669 ('switch-to-confi')... machine # [ 101.283278] systemd[568]: Reexecuting. machine # [ 101.344090] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 101.470253] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 101.477318] systemd[568]: Reload requested from client PID 6669 ('switch-to-confi')... machine # [ 101.481447] systemd[568]: Reloading... machine # [ 101.599269] systemd[568]: Reloading finished in 118 ms. machine # [ 101.616189] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 101.624917] systemd[568]: Stopped Run user-specific NixOS activation. machine # [ 101.627303] systemd[568]: Stopping Run user-specific NixOS activation... machine # [ 101.629505] systemd[568]: Starting Run user-specific NixOS activation... machine # [ 101.661493] systemd[568]: Finished Run user-specific NixOS activation. machine # [ 101.666027] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 101.668919] systemd[1]: Stopping Reactivate sysinit units... machine # [ 101.669849] systemd[1]: Reached target Reactivate sysinit units. machine # [ 101.673435] systemd[1]: Reached target Remote File Systems. machine # [ 101.677749] systemd[1]: Starting linger-users.service... machine # [ 101.678671] systemd[1]: Reached target Local File Systems. machine # [ 101.688717] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 101.696787] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 101.698280] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 101.703584] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 101.705560] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 101.706883] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 101.719234] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 101.723528] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 101.727380] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 101.767006] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 101.769696] systemd[1]: Finished linger-users.service. machine # [ 101.927611] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 101.929938] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 102.191098] nixos[6600]: finished switching to system configuration /nix/store/zhjnaiq0nqqgb9aw6vnp4bm3pky1jaa2-nixos-system-machine-test machine: (finished: must succeed: /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModifiedSomethingElse/bin/switch-to-configuration test 2>&1, in 1.87 seconds) (finished: subtest: unit file parser, in 25.64 seconds) subtest: restart and reload by activation script machine: must succeed: /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test/specialisation/simpleServiceNorestart/bin/switch-to-configuration test 2>&1 machine # [ 102.480213] nixos[6740]: switching to system configuration /nix/store/bs0kln4r7xwqnmnna8jpd8gxfxca8r6q-nixos-system-machine-test machine # [ 102.482811] systemd[1]: Stopped target Remote File Systems. machine # [ 102.485022] systemd[1]: Stopped target Local File Systems. machine # [ 102.751625] systemd[1]: Reload requested from client PID 6740 ('.switch-to-conf') (unit backdoor.service)... machine # [ 102.753767] systemd[1]: Reloading... machine # [ 103.080218] systemd[1]: Reloading finished in 324 ms. machine # [ 103.171185] systemd[568]: Reexecution requested from client PID 6809 ('switch-to-confi')... machine # [ 103.175410] systemd[568]: Reexecuting. machine # [ 103.236564] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 103.361457] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 103.368313] systemd[568]: Reload requested from client PID 6809 ('switch-to-confi')... machine # [ 103.372164] systemd[568]: Reloading... machine # [ 103.493672] systemd[568]: Reloading finished in 122 ms. machine # [ 103.508198] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 103.517399] systemd[568]: Stopped Run user-specific NixOS activation. machine # [ 103.519972] systemd[568]: Stopping Run user-specific NixOS activation... machine # [ 103.522407] systemd[568]: Starting Run user-specific NixOS activation... machine # [ 103.558173] systemd[568]: Finished Run user-specific NixOS activation. machine # [ 103.563692] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 103.567285] systemd[1]: Stopping Reactivate sysinit units... machine # [ 103.572592] systemd[1]: Reached target Reactivate sysinit units. machine # [ 103.573640] systemd[1]: Reached target Remote File Systems. machine # [ 103.574452] systemd[1]: Reached target Local File Systems. machine # [ 103.575323] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 103.589826] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 103.590829] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 103.600481] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 103.602944] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 103.605132] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 103.606443] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 103.607630] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 103.609763] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 103.814158] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 103.819864] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 103.822256] systemd[1]: Starting linger-users.service... machine # [ 103.871499] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 103.874819] systemd[1]: Finished linger-users.service. machine # [ 104.130630] nixos[6740]: finished switching to system configuration /nix/store/bs0kln4r7xwqnmnna8jpd8gxfxca8r6q-nixos-system-machine-test machine: (finished: must succeed: /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test/specialisation/simpleServiceNorestart/bin/switch-to-configuration test 2>&1, in 1.94 seconds) machine: must succeed: /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration test 2>&1 machine # [ 104.418773] nixos[6880]: switching to system configuration /nix/store/gkikzr2zn9ldl90ifzn67hbs5jmsa8rs-nixos-system-machine-test machine # [ 104.421966] systemd[1]: test.service: Deactivated successfully. machine # [ 104.422943] systemd[1]: Stopped test.service. machine # [ 104.424463] systemd[1]: Stopped target Local File Systems. machine # [ 104.426796] systemd[1]: Stopped target Remote File Systems. machine # [ 104.725671] systemd[1]: Reload requested from client PID 6880 ('.switch-to-conf') (unit backdoor.service)... machine # [ 104.727286] systemd[1]: Reloading... machine # [ 105.079042] systemd[1]: Reloading finished in 349 ms. machine # [ 105.171663] systemd[568]: Reexecution requested from client PID 6951 ('switch-to-confi')... machine # [ 105.173683] systemd[568]: Reexecuting. machine # [ 105.231725] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 105.353393] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 105.360113] systemd[568]: Reload requested from client PID 6951 ('switch-to-confi')... machine # [ 105.363753] systemd[568]: Reloading... machine # [ 105.477248] systemd[568]: Reloading finished in 114 ms. machine # [ 105.492179] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 105.501570] systemd[568]: Stopped Run user-specific NixOS activation. machine # [ 105.504053] systemd[568]: Stopping Run user-specific NixOS activation... machine # [ 105.506233] systemd[568]: Starting Run user-specific NixOS activation... machine # [ 105.536379] systemd[568]: Finished Run user-specific NixOS activation. machine # [ 105.540515] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 105.541493] systemd[1]: Stopping Reactivate sysinit units... machine # [ 105.543307] systemd[1]: Reached target Reactivate sysinit units. machine # [ 105.546731] systemd[1]: Reached target Local File Systems. machine # [ 105.550926] systemd[1]: Reached target Remote File Systems. machine # [ 105.553671] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 105.555977] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 105.562319] systemd[1]: Starting simple-reload-service.service... machine # [ 105.578575] systemd[1]: Created slice Slice /system/templated-simple-reload-service. machine # [ 105.582793] systemd[1]: Starting templated-simple-reload-service@instance.service... machine # [ 105.600123] systemd[1]: Created slice Slice /system/templated-reload-triggers-and-restart-by-as. machine # [ 105.601509] systemd[1]: Starting templated-reload-triggers-and-restart-by-as@instance.service... machine # [ 105.620646] systemd[1]: Starting no-restart-service.service... machine # [ 105.638471] systemd[1]: Created slice Slice /system/templated-simple-service. machine # [ 105.639634] systemd[1]: Starting templated-simple-service@instance.service... machine # [ 105.659699] systemd[1]: Created slice Slice /system/templated-simple-restart-service. machine # [ 105.674415] systemd[1]: Starting templated-simple-restart-service@instance.service... machine # [ 105.675648] systemd[1]: Starting reload-triggers-and-restart-by-as.service... machine # [ 105.701470] systemd[1]: Finished simple-reload-service.service. machine # [ 105.702419] systemd[1]: Created slice Slice /system/templated-no-restart-service. machine # [ 105.703627] systemd[1]: Starting templated-no-restart-service@instance.service... machine # [ 105.744737] systemd[1]: Created slice Slice /system/templated-reload-triggers. machine # [ 105.745935] systemd[1]: Created slice Slice /system/templated-reload-triggers-and-restart. machine # [ 105.747241] systemd[1]: Starting linger-users.service... machine # [ 105.747988] systemd[1]: Starting reload-triggers-and-restart.service... machine # [ 105.818968] systemd[1]: Starting reload-triggers.service... machine # [ 105.819943] systemd[1]: Starting templated-reload-triggers-and-restart@instance.service... machine # [ 105.849806] systemd[1]: Starting templated-reload-triggers@instance.service... machine # [ 105.867449] systemd[1]: Finished templated-simple-reload-service@instance.service. machine # [ 105.885353] systemd[1]: Finished templated-reload-triggers-and-restart-by-as@instance.service. machine # [ 105.905728] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 105.925701] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 105.935625] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 105.950119] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 105.962776] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 105.967703] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 105.972473] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 105.973756] systemd[1]: Finished templated-simple-service@instance.service. machine # [ 105.974737] systemd[1]: Finished no-restart-service.service. machine # [ 105.975508] systemd[1]: Finished templated-simple-restart-service@instance.service. machine # [ 105.984329] systemd[1]: Finished reload-triggers-and-restart-by-as.service. machine # [ 105.985418] systemd[1]: Finished templated-no-restart-service@instance.service. machine # [ 105.986391] systemd[1]: Finished reload-triggers-and-restart.service. machine # [ 105.987306] systemd[1]: Finished reload-triggers.service. machine # [ 105.995268] systemd[1]: Finished templated-reload-triggers-and-restart@instance.service. machine # [ 106.000334] systemd[1]: Finished templated-reload-triggers@instance.service. machine # [ 106.001378] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 106.002285] systemd[1]: Finished linger-users.service. machine # [ 106.144659] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 106.148555] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 106.152288] systemd[1]: Starting simple-restart-service.service... machine # [ 106.156430] systemd[1]: Starting simple-service.service... machine # [ 106.193689] systemd[1]: Finished simple-restart-service.service. machine # [ 106.195987] systemd[1]: Finished simple-service.service. machine # [ 106.457216] nixos[6880]: finished switching to system configuration /nix/store/gkikzr2zn9ldl90ifzn67hbs5jmsa8rs-nixos-system-machine-test machine: (finished: must succeed: /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration test 2>&1, in 2.33 seconds) machine: must succeed: /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration test 2>&1 machine # [ 106.773922] nixos[7050]: switching to system configuration /nix/store/gkikzr2zn9ldl90ifzn67hbs5jmsa8rs-nixos-system-machine-test machine # [ 106.776486] systemd[1]: Stopped target Remote File Systems. machine # [ 106.778863] systemd[1]: Stopped target Local File Systems. machine # [ 107.062472] systemd[1]: Reload requested from client PID 7050 ('.switch-to-conf') (unit backdoor.service)... machine # [ 107.064479] systemd[1]: Reloading... machine # [ 107.396489] systemd[1]: Reloading finished in 330 ms. machine # [ 107.490382] systemd[568]: Reexecution requested from client PID 7121 ('switch-to-confi')... machine # [ 107.491765] systemd[568]: Reexecuting. machine # [ 107.555704] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 107.679195] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 107.685658] systemd[568]: Reload requested from client PID 7121 ('switch-to-confi')... machine # [ 107.689436] systemd[568]: Reloading... machine # [ 107.799674] systemd[568]: Reloading finished in 111 ms. machine # [ 107.816188] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 107.826693] systemd[568]: Stopped Run user-specific NixOS activation. machine # [ 107.829045] systemd[568]: Stopping Run user-specific NixOS activation... machine # [ 107.831303] systemd[568]: Starting Run user-specific NixOS activation... machine # [ 107.865517] systemd[568]: Finished Run user-specific NixOS activation. machine # [ 107.868962] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 107.871854] systemd[1]: Stopping Reactivate sysinit units... machine # [ 107.875331] systemd[1]: Reached target Reactivate sysinit units. machine # [ 107.877991] systemd[1]: Reloading reload-triggers-and-restart.service... machine # [ 107.891811] systemd[1]: Reloading reload-triggers.service... machine # [ 107.905272] systemd[1]: Reloading simple-reload-service.service... machine # [ 107.911650] systemd[1]: Reloading templated-reload-triggers-and-restart@instance.service... machine # [ 107.931374] systemd[1]: Reloading templated-reload-triggers@instance.service... machine # [ 107.941041] systemd[1]: Reloading templated-simple-reload-service@instance.service... machine # [ 107.972938] systemd[1]: Reloaded reload-triggers.service. machine # [ 107.981243] systemd[1]: Reloaded reload-triggers-and-restart.service. machine # [ 108.006860] systemd[1]: Reloaded simple-reload-service.service. machine # [ 108.010627] systemd[1]: Reloaded templated-reload-triggers-and-restart@instance.service. machine # [ 108.011827] systemd[1]: Reloaded templated-reload-triggers@instance.service. machine # [ 108.014179] systemd[1]: Reloaded templated-simple-reload-service@instance.service. machine # [ 108.018326] systemd[1]: reload-triggers-and-restart-by-as.service: Deactivated successfully. machine # [ 108.019578] systemd[1]: Stopped reload-triggers-and-restart-by-as.service. machine # [ 108.024792] systemd[1]: Stopping reload-triggers-and-restart-by-as.service... machine # [ 108.029324] systemd[1]: Starting reload-triggers-and-restart-by-as.service... machine # [ 108.030378] systemd[1]: simple-restart-service.service: Deactivated successfully. machine # [ 108.031439] systemd[1]: Stopped simple-restart-service.service. machine # [ 108.052875] systemd[1]: Stopping simple-restart-service.service... machine # [ 108.053865] systemd[1]: Starting simple-restart-service.service... machine # [ 108.054756] systemd[1]: simple-service.service: Deactivated successfully. machine # [ 108.055673] systemd[1]: Stopped simple-service.service. machine # [ 108.077637] systemd[1]: Stopping simple-service.service... machine # [ 108.078578] systemd[1]: Starting simple-service.service... machine # [ 108.091558] systemd[1]: templated-reload-triggers-and-restart-by-as@instance.service: Deactivated successfully. machine # [ 108.103079] systemd[1]: Stopped templated-reload-triggers-and-restart-by-as@instance.service. machine # [ 108.114661] systemd[1]: Stopping templated-reload-triggers-and-restart-by-as@instance.service... machine # [ 108.125742] systemd[1]: Starting templated-reload-triggers-and-restart-by-as@instance.service... machine # [ 108.127207] systemd[1]: templated-simple-restart-service@instance.service: Deactivated successfully. machine # [ 108.155026] systemd[1]: Stopped templated-simple-restart-service@instance.service. machine # [ 108.159068] systemd[1]: Stopping templated-simple-restart-service@instance.service... machine # [ 108.160542] systemd[1]: Starting templated-simple-restart-service@instance.service... machine # [ 108.161582] systemd[1]: templated-simple-service@instance.service: Deactivated successfully. machine # [ 108.162743] systemd[1]: Stopped templated-simple-service@instance.service. machine # [ 108.163697] systemd[1]: Stopping templated-simple-service@instance.service... machine # [ 108.165923] systemd[1]: Starting templated-simple-service@instance.service... machine # [ 108.168757] systemd[1]: Finished reload-triggers-and-restart-by-as.service. machine # [ 108.169792] systemd[1]: Finished simple-restart-service.service. machine # [ 108.170658] systemd[1]: Finished simple-service.service. machine # [ 108.171438] systemd[1]: Finished templated-reload-triggers-and-restart-by-as@instance.service. machine # [ 108.172867] systemd[1]: Finished templated-simple-restart-service@instance.service. machine # [ 108.178791] systemd[1]: Finished templated-simple-service@instance.service. machine # [ 108.186344] systemd[1]: Reached target Remote File Systems. machine # [ 108.190764] systemd[1]: Starting linger-users.service... machine # [ 108.196338] systemd[1]: Reached target Local File Systems. machine # [ 108.197255] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 108.212368] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 108.213327] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 108.214594] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 108.221446] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 108.223158] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 108.224473] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 108.225676] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 108.226932] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 108.280203] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 108.284291] systemd[1]: Finished linger-users.service. machine # [ 108.421380] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 108.424800] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 108.682671] nixos[7050]: finished switching to system configuration /nix/store/gkikzr2zn9ldl90ifzn67hbs5jmsa8rs-nixos-system-machine-test machine: (finished: must succeed: /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration test 2>&1, in 2.23 seconds) machine: must succeed: /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script-modified/bin/switch-to-configuration test 2>&1 machine # [ 109.021703] nixos[7216]: switching to system configuration /nix/store/xins467n16xp6jadjl86mkk54qcb75nf-nixos-system-machine-test machine # [ 109.024320] systemd[1]: Stopped target Local File Systems. machine # [ 109.026695] systemd[1]: Stopped target Remote File Systems. machine # [ 109.349843] systemd[1]: Reload requested from client PID 7216 ('.switch-to-conf') (unit backdoor.service)... machine # [ 109.351791] systemd[1]: Reloading... machine # [ 109.714316] systemd[1]: Reloading finished in 360 ms. machine # [ 109.809371] systemd[568]: Reexecution requested from client PID 7287 ('switch-to-confi')... machine # [ 109.813400] systemd[568]: Reexecuting. machine # [ 109.867581] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 109.977888] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 109.984552] systemd[568]: Reload requested from client PID 7287 ('switch-to-confi')... machine # [ 109.988076] systemd[568]: Reloading... machine # [ 110.096165] systemd[568]: Reloading finished in 108 ms. machine # [ 110.112167] systemd[568]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 110.121173] systemd[568]: Stopped Run user-specific NixOS activation. machine # [ 110.123514] systemd[568]: Stopping Run user-specific NixOS activation... machine # [ 110.125705] systemd[568]: Starting Run user-specific NixOS activation... machine # [ 110.156899] systemd[568]: Finished Run user-specific NixOS activation. machine # [ 110.161615] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 110.166284] systemd[1]: Stopping Reactivate sysinit units... machine # [ 110.167254] systemd[1]: Reached target Reactivate sysinit units. machine # [ 110.169670] systemd[1]: Reloading reload-triggers.service... machine # [ 110.174785] systemd[1]: Reloading simple-reload-service.service... machine # [ 110.187568] systemd[1]: Reloading templated-reload-triggers@instance.service... machine # [ 110.199744] systemd[1]: Reloading templated-simple-reload-service@instance.service... machine # [ 110.249847] systemd[1]: Reloaded reload-triggers.service. machine # [ 110.252148] systemd[1]: Reloaded simple-reload-service.service. machine # [ 110.255011] systemd[1]: Reloaded templated-reload-triggers@instance.service. machine # [ 110.256993] systemd[1]: Reloaded templated-simple-reload-service@instance.service. machine # [ 110.260454] systemd[1]: reload-triggers-and-restart-by-as.service: Deactivated successfully. machine # [ 110.261658] systemd[1]: Stopped reload-triggers-and-restart-by-as.service. machine # [ 110.262728] systemd[1]: Stopping reload-triggers-and-restart-by-as.service... machine # [ 110.267012] systemd[1]: Starting reload-triggers-and-restart-by-as.service... machine # [ 110.270918] systemd[1]: reload-triggers-and-restart.service: Deactivated successfully. machine # [ 110.283423] systemd[1]: Stopped reload-triggers-and-restart.service. machine # [ 110.292755] systemd[1]: Stopping reload-triggers-and-restart.service... machine # [ 110.293765] systemd[1]: Starting reload-triggers-and-restart.service... machine # [ 110.294746] systemd[1]: simple-restart-service.service: Deactivated successfully. machine # [ 110.295777] systemd[1]: Stopped simple-restart-service.service. machine # [ 110.329257] systemd[1]: Stopping simple-restart-service.service... machine # [ 110.330228] systemd[1]: Starting simple-restart-service.service... machine # [ 110.331292] systemd[1]: simple-service.service: Deactivated successfully. machine # [ 110.353482] systemd[1]: Stopped simple-service.service. machine # [ 110.354354] systemd[1]: Stopping simple-service.service... machine # [ 110.372695] systemd[1]: Starting simple-service.service... machine # [ 110.386055] systemd[1]: templated-reload-triggers-and-restart-by-as@instance.service: Deactivated successfully. machine # [ 110.399261] systemd[1]: Stopped templated-reload-triggers-and-restart-by-as@instance.service. machine # [ 110.422106] systemd[1]: Stopping templated-reload-triggers-and-restart-by-as@instance.service... machine # [ 110.436749] systemd[1]: Starting templated-reload-triggers-and-restart-by-as@instance.service... machine # [ 110.443687] systemd[1]: templated-reload-triggers-and-restart@instance.service: Deactivated successfully. machine # [ 110.449739] systemd[1]: Stopped templated-reload-triggers-and-restart@instance.service. machine # [ 110.450963] systemd[1]: Stopping templated-reload-triggers-and-restart@instance.service... machine # [ 110.456381] systemd[1]: Starting templated-reload-triggers-and-restart@instance.service... machine # [ 110.457923] systemd[1]: templated-simple-restart-service@instance.service: Deactivated successfully. machine # [ 110.459564] systemd[1]: Stopped templated-simple-restart-service@instance.service. machine # [ 110.461047] systemd[1]: Stopping templated-simple-restart-service@instance.service... machine # [ 110.463824] systemd[1]: Starting templated-simple-restart-service@instance.service... machine # [ 110.468122] systemd[1]: templated-simple-service@instance.service: Deactivated successfully. machine # [ 110.469365] systemd[1]: Stopped templated-simple-service@instance.service. machine # [ 110.470327] systemd[1]: Stopping templated-simple-service@instance.service... machine # [ 110.471312] systemd[1]: Starting templated-simple-service@instance.service... machine # [ 110.478057] systemd[1]: Finished reload-triggers-and-restart.service. machine # [ 110.479130] systemd[1]: Finished reload-triggers-and-restart-by-as.service. machine # [ 110.484611] systemd[1]: Finished simple-service.service. machine # [ 110.485432] systemd[1]: Finished simple-restart-service.service. machine # [ 110.486282] systemd[1]: Finished templated-reload-triggers-and-restart@instance.service. machine # [ 110.487372] systemd[1]: Finished templated-reload-triggers-and-restart-by-as@instance.service. machine # [ 110.508699] systemd[1]: Finished templated-simple-restart-service@instance.service. machine # [ 110.509907] systemd[1]: Finished templated-simple-service@instance.service. machine # [ 110.511949] systemd[1]: Reached target Local File Systems. machine # [ 110.515880] systemd[1]: Reached target Remote File Systems. machine # [ 110.519596] systemd[1]: Starting linger-users.service... machine # [ 110.520572] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 110.522010] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 110.522909] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 110.529060] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 110.535647] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 110.542301] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 110.543686] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 110.549187] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 110.550560] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 110.575806] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 110.579616] systemd[1]: Finished linger-users.service. machine # [ 110.724284] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 110.727662] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 110.985131] nixos[7216]: finished switching to system configuration /nix/store/xins467n16xp6jadjl86mkk54qcb75nf-nixos-system-machine-test machine: (finished: must succeed: /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script-modified/bin/switch-to-configuration test 2>&1, in 2.30 seconds) machine: must succeed: /nix/store/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-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/qpcvhvn4sbsk4bf5rbhplpqfhmsafpdz-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration dry-activate 2>&1, in 0.38 seconds) (finished: subtest: restart and reload by activation script, in 9.18 seconds) (finished: run the VM test script, in 112.19 seconds) test script finished in 113.37s cleanup kill QemuMachine (pid 45) machine # qemu-system-aarch64: terminating on signal 15 from pid 39 (/nix/store/3fl7bdkdxk2k4nssy1d1161isbzn6bsr-python3-3.14.7/bin/python3.14) machine # [2026-09-15T21:19:32Z INFO virtiofsd] Client disconnected, shutting down machine # [2026-09-15T21:19:32Z INFO virtiofsd] Client disconnected, shutting down machine # [2026-09-15T21:19:32Z INFO virtiofsd] Client disconnected, shutting down (finished: cleanup, in 0.20 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