tribuchet: building on eliza Machine state will be reset. To keep it, pass --keep-machine-state start all VLans (finished: start all VLans, in 0.00 seconds) Test will time out and terminate in 3600.0 seconds run the VM test script machine: waiting for unit multi-user.target machine: waiting for the VM to finish booting machine: starting vm machine # Disk image does not exist, creating the virtualisation disk image... machine: QEMU running (pid 45) machine # Formatting '/build/vm-state-machine/tmp.zV2UM6gGaN', 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: 3f4f38db-117c-429e-9a0b-9f04d7183766 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-27T03:13:20Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1) machine # [2026-09-27T03:13:20Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether machine # [2026-09-27T03:13:20Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1) machine # [2026-09-27T03:13:20Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether machine # [2026-09-27T03:13:20Z INFO virtiofsd] Waiting for vhost-user socket connection... machine # [2026-09-27T03:13:20Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1) machine # [2026-09-27T03:13:20Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether machine # [2026-09-27T03:13:20Z INFO virtiofsd] Waiting for vhost-user socket connection... machine # [2026-09-27T03:13:20Z INFO virtiofsd] Waiting for vhost-user socket connection... machine # [2026-09-27T03:13:20Z INFO virtiofsd] Client connected, servicing requests machine # [2026-09-27T03:13:20Z INFO virtiofsd] Client connected, servicing requests machine # [2026-09-27T03:13:20Z INFO virtiofsd] Client connected, servicing requests machine # [ 0.000000] Booting Linux on physical CPU 0x0000000000 [0xc00fac40] machine # [ 0.000000] Linux version 6.18.53 (nixbld@localhost) (gcc (GCC) 15.3.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT Mon Sep 21 13:06:06 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 0x7fdee700-0x7fdf1e7f] 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 s186776 r8192 d116328 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/b2rywx23jb5nhi7b4xfic9vflyz9nzq1-nixos-system-machine-test/init regInfo=/nix/.ro-store/505sxfi2f0hjfji95qgnk52v2pbf4h20-closure-info/registration console=ttyAMA0,115200n8 console=tty0 machine # [ 0.000000] Unknown kernel command line parameters "regInfo=/nix/.ro-store/505sxfi2f0hjfji95qgnk52v2pbf4h20-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 74963 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.000032] arm-pv: using stolen time PV machine # [ 0.000419] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____) machine # [ 0.000607] Console: colour dummy device 80x25 machine # [ 0.000614] printk: legacy console [tty0] enabled machine # [ 0.000834] Calibrating delay loop (skipped), value calculated using timer frequency.. 2000.00 BogoMIPS (lpj=4000000) machine # [ 0.000840] pid_max: default: 32768 minimum: 301 machine # [ 0.000923] LSM: initializing lsm=capability,landlock,yama,bpf,ima machine # [ 0.001056] landlock: Up and running. machine # [ 0.001059] Yama: becoming mindful. machine # [ 0.001517] LSM support for eBPF active machine # [ 0.001670] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear) machine # [ 0.001690] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear) machine # [ 0.003762] rcu: Hierarchical SRCU implementation. machine # [ 0.003769] rcu: Max phase no-delay instances is 1000. machine # [ 0.005097] fsl-mc MSI: its@8080000 domain created machine # [ 0.005214] EFI services will not be available. machine # [ 0.005333] smp: Bringing up secondary CPUs ... machine # [ 0.005342] smp: Brought up 1 node, 1 CPU machine # [ 0.005345] SMP: Total of 1 processors activated. machine # [ 0.005348] CPU: All CPU(s) started at EL1 machine # [ 0.005362] CPU features: detected: Branch Target Identification machine # [ 0.005367] CPU features: detected: ARMv8.4 Translation Table Level machine # [ 0.005370] CPU features: detected: Instruction cache invalidation not required for I/D coherence machine # [ 0.005374] CPU features: detected: Data cache clean to the PoU not required for I/D coherence machine # [ 0.005377] CPU features: detected: Common not Private translations machine # [ 0.005381] CPU features: detected: CRC32 instructions machine # [ 0.005384] CPU features: detected: Data cache clean to Point of Deep Persistence machine # [ 0.005389] CPU features: detected: Data cache clean to Point of Persistence machine # [ 0.005392] CPU features: detected: Data independent timing control (DIT) machine # [ 0.005394] CPU features: detected: E0PD machine # [ 0.005397] CPU features: detected: Enhanced Counter Virtualization machine # [ 0.005400] CPU features: detected: Enhanced Counter Virtualization (CNTPOFF) machine # [ 0.005403] CPU features: detected: Enhanced Virtualization Traps machine # [ 0.005407] CPU features: detected: Fine Grained Traps machine # [ 0.005410] CPU features: detected: Generic authentication (architected QARMA5 algorithm) machine # [ 0.005415] CPU features: detected: RCpc load-acquire (LDAPR) machine # [ 0.005418] CPU features: detected: LSE atomic instructions machine # [ 0.005421] CPU features: detected: Privileged Access Never machine # [ 0.005424] CPU features: detected: PMUv3 machine # [ 0.005426] CPU features: detected: RAS Extension Support machine # [ 0.005429] CPU features: detected: RASv1p1 Extension Support machine # [ 0.005432] CPU features: detected: Random Number Generator machine # [ 0.005434] CPU features: detected: Speculation barrier (SB) machine # [ 0.005437] CPU features: detected: Stage-2 Force Write-Back machine # [ 0.005440] CPU features: detected: TLB range maintenance instructions machine # [ 0.005444] CPU features: detected: Speculative Store Bypassing Safe (SSBS) machine # [ 0.005482] alternatives: applying system-wide alternatives machine # [ 0.008590] CPU features: detected: BBM Level 2 without TLB conflict abort machine # [ 0.008754] Memory: 893752K/1048576K available (24448K kernel code, 7094K rwdata, 26592K rodata, 4736K init, 1107K bss, 113536K reserved, 32768K cma-reserved) machine # [ 0.009119] devtmpfs: initialized machine # [ 0.010902] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear) machine # [ 0.010924] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear). machine # [ 0.011111] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL machine # [ 0.011115] 0 pages in range for non-PLT usage machine # [ 0.011117] 508224 pages in range for PLT usage machine # [ 0.011248] pinctrl core: initialized pinctrl subsystem machine # [ 0.012049] DMI not present or invalid. machine # [ 0.015189] NET: Registered PF_NETLINK/PF_ROUTE protocol family machine # [ 0.017664] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations machine # [ 0.017833] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations machine # [ 0.017998] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations machine # [ 0.018021] audit: initializing netlink subsys (disabled) machine # [ 0.018670] thermal_sys: Registered thermal governor 'fair_share' machine # [ 0.018672] thermal_sys: Registered thermal governor 'bang_bang' machine # [ 0.018676] thermal_sys: Registered thermal governor 'step_wise' machine # [ 0.018678] thermal_sys: Registered thermal governor 'user_space' machine # [ 0.018681] thermal_sys: Registered thermal governor 'power_allocator' machine # [ 0.018710] audit: type=2000 audit(0.016:1): state=initialized audit_enabled=0 res=1 machine # [ 0.018719] cpuidle: using governor ladder machine # [ 0.018724] cpuidle: using governor menu machine # [ 0.018925] hw-breakpoint: found 16 breakpoint and 4 watchpoint registers. machine # [ 0.018942] ASID allocator initialised with 65536 entries machine # [ 0.020224] Serial: AMBA PL011 UART driver machine # [ 0.026031] 9000000.pl011: ttyAMA0 at MMIO 0x9000000 (irq = 13, base_baud = 0) is a PL011 rev1 machine # [ 0.026207] printk: console [ttyAMA0] enabled machine # [ 0.158319] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages machine # [ 0.158331] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page machine # [ 0.158334] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages machine # [ 0.158337] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page machine # [ 0.158340] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages machine # [ 0.158343] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page machine # [ 0.158346] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages machine # [ 0.158349] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page machine # [ 0.159580] fbcon: Taking over console machine # [ 0.159589] ACPI: Interpreter disabled. machine # [ 0.160667] iommu: Default domain type: Translated machine # [ 0.160671] iommu: DMA domain TLB invalidation policy: strict mode machine # [ 0.161055] SCSI subsystem initialized machine # [ 0.161250] usbcore: registered new interface driver usbfs machine # [ 0.161279] usbcore: registered new interface driver hub machine # [ 0.161295] usbcore: registered new device driver usb machine # [ 0.173156] pps_core: LinuxPPS API ver. 1 registered machine # [ 0.173161] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti machine # [ 0.173169] PTP clock support registered machine # [ 0.173233] EDAC MC: Ver: 3.0.0 machine # [ 0.173385] scmi_core: SCMI protocol bus registered machine # [ 0.184456] FPGA manager framework machine # [ 0.185018] vgaarb: loaded machine # [ 0.185294] clocksource: Switched to clocksource arch_sys_counter machine # [ 0.187513] VFS: Disk quotas dquot_6.6.0 machine # [ 0.187545] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) machine # [ 0.187842] netfs: FS-Cache loaded machine # [ 0.187951] pnp: PnP ACPI: disabled machine # [ 0.195528] NET: Registered PF_INET protocol family machine # [ 0.195724] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear) machine # [ 0.226526] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear) machine # [ 0.226569] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) machine # [ 0.226595] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear) machine # [ 0.226639] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear) machine # [ 0.226711] TCP: Hash tables configured (established 8192 bind 8192) machine # [ 0.226800] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear) machine # [ 0.226830] UDP hash table entries: 512 (order: 3, 32768 bytes, linear) machine # [ 0.226878] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear) machine # [ 0.226979] NET: Registered PF_UNIX/PF_LOCAL protocol family machine # [ 0.227028] NET: Registered PF_XDP protocol family machine # [ 0.227046] PCI: CLS 0 bytes, default 64 machine # [ 0.227338] Trying to unpack rootfs image as initramfs... machine # [ 0.245329] kvm [1]: HYP mode not available machine # [ 0.357928] Initialise system trusted keyrings machine # [ 0.358072] workingset: timestamp_bits=42 max_order=18 bucket_order=0 machine # [ 0.358442] squashfs: version 4.0 (2009/01/31) Phillip Lougher machine # [ 0.358508] 9p: Installing v9fs 9p2000 file system support machine # [ 0.386765] Key type asymmetric registered machine # [ 0.386782] Asymmetric key parser 'x509' registered machine # [ 0.386871] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 242) machine # [ 0.387004] io scheduler mq-deadline registered machine # [ 0.387008] io scheduler kyber registered machine # [ 0.399310] pl061_gpio 9030000.pl061: PL061 GPIO chip registered machine # [ 0.399970] ledtrig-cpu: registered to indicate activity on CPUs machine # [ 0.400354] pci-host-generic 4010000000.pcie: host bridge /pcie@10000000 ranges: machine # [ 0.400367] pci-host-generic 4010000000.pcie: IO 0x003eff0000..0x003effffff -> 0x0000000000 machine # [ 0.400377] pci-host-generic 4010000000.pcie: MEM 0x0010000000..0x003efeffff -> 0x0010000000 machine # [ 0.400383] pci-host-generic 4010000000.pcie: MEM 0x8000000000..0xffffffffff -> 0x8000000000 machine # [ 0.400400] pci-host-generic 4010000000.pcie: Memory resource size exceeds max for 32 bits machine # [ 0.400418] pci-host-generic 4010000000.pcie: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff] machine # [ 0.400515] pci-host-generic 4010000000.pcie: PCI host bridge to bus 0000:00 machine # [ 0.400522] pci_bus 0000:00: root bus resource [bus 00-ff] machine # [ 0.400526] pci_bus 0000:00: root bus resource [io 0x0000-0xffff] machine # [ 0.400529] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff] machine # [ 0.400532] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff] machine # [ 0.400599] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint machine # [ 0.401072] pci 0000:00:01.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint machine # [ 0.401271] pci 0000:00:01.0: BAR 0 [io 0x0000-0x001f] machine # [ 0.401283] pci 0000:00:01.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.425367] pci 0000:00:01.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.425389] pci 0000:00:01.0: ROM [mem 0x00000000-0x0003ffff pref] machine # [ 0.425935] pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint machine # [ 0.426139] pci 0000:00:02.0: BAR 0 [io 0x0000-0x001f] machine # [ 0.426152] pci 0000:00:02.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.426181] pci 0000:00:02.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.426691] pci 0000:00:03.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint machine # [ 0.426885] pci 0000:00:03.0: BAR 0 [io 0x0000-0x007f] machine # [ 0.426897] pci 0000:00:03.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.426928] pci 0000:00:03.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.427412] pci 0000:00:04.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint machine # [ 0.427605] pci 0000:00:04.0: BAR 0 [io 0x0000-0x001f] machine # [ 0.427686] pci 0000:00:04.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.427713] pci 0000:00:04.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.427724] pci 0000:00:04.0: ROM [mem 0x00000000-0x0003ffff pref] machine # [ 0.428204] pci 0000:00:05.0: [1af4:1050] type 00 class 0x038000 conventional PCI endpoint machine # [ 0.428393] pci 0000:00:05.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.428419] pci 0000:00:05.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.428894] pci 0000:00:06.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint machine # [ 0.429084] pci 0000:00:06.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.429110] pci 0000:00:06.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.438353] pci 0000:00:07.0: [8086:24cd] type 00 class 0x0c0320 conventional PCI endpoint machine # [ 0.438543] pci 0000:00:07.0: BAR 0 [mem 0x00000000-0x00000fff] machine # [ 0.438812] pci 0000:00:08.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint machine # [ 0.439010] pci 0000:00:08.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.439036] pci 0000:00:08.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.439528] pci 0000:00:09.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint machine # [ 0.439758] pci 0000:00:09.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.439785] pci 0000:00:09.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.440273] pci 0000:00:0a.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint machine # [ 0.440470] pci 0000:00:0a.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.440496] pci 0000:00:0a.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.441004] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint machine # [ 0.441325] pci 0000:00:0b.0: BAR 0 [io 0x0000-0x003f] machine # [ 0.441337] pci 0000:00:0b.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.441364] pci 0000:00:0b.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.441858] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint machine # [ 0.442055] pci 0000:00:0c.0: BAR 0 [io 0x0000-0x001f] machine # [ 0.442067] pci 0000:00:0c.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.442097] pci 0000:00:0c.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.442746] pci 0000:00:01.0: ROM [mem 0x10000000-0x1003ffff pref]: assigned machine # [ 0.442752] pci 0000:00:04.0: ROM [mem 0x10040000-0x1007ffff pref]: assigned machine # [ 0.442756] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned machine # [ 0.442804] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]: assigned machine # [ 0.442852] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]: assigned machine # [ 0.442898] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]: assigned machine # [ 0.442943] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]: assigned machine # [ 0.442989] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]: assigned machine # [ 0.443034] pci 0000:00:08.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]: assigned machine # [ 0.443080] pci 0000:00:09.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]: assigned machine # [ 0.443125] pci 0000:00:0a.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]: assigned machine # [ 0.443171] pci 0000:00:0b.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]: assigned machine # [ 0.443245] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]: assigned machine # [ 0.443294] pci 0000:00:01.0: BAR 1 [mem 0x10080000-0x10080fff]: assigned machine # [ 0.443312] pci 0000:00:02.0: BAR 1 [mem 0x10081000-0x10081fff]: assigned machine # [ 0.443330] pci 0000:00:03.0: BAR 1 [mem 0x10082000-0x10082fff]: assigned machine # [ 0.443349] pci 0000:00:04.0: BAR 1 [mem 0x10083000-0x10083fff]: assigned machine # [ 0.443367] pci 0000:00:05.0: BAR 1 [mem 0x10084000-0x10084fff]: assigned machine # [ 0.443384] pci 0000:00:06.0: BAR 1 [mem 0x10085000-0x10085fff]: assigned machine # [ 0.443403] pci 0000:00:07.0: BAR 0 [mem 0x10086000-0x10086fff]: assigned machine # [ 0.443421] pci 0000:00:08.0: BAR 1 [mem 0x10087000-0x10087fff]: assigned machine # [ 0.443443] pci 0000:00:09.0: BAR 1 [mem 0x10088000-0x10088fff]: assigned machine # [ 0.443462] pci 0000:00:0a.0: BAR 1 [mem 0x10089000-0x10089fff]: assigned machine # [ 0.443481] pci 0000:00:0b.0: BAR 1 [mem 0x1008a000-0x1008afff]: assigned machine # [ 0.443500] pci 0000:00:0c.0: BAR 1 [mem 0x1008b000-0x1008bfff]: assigned machine # [ 0.443518] pci 0000:00:03.0: BAR 0 [io 0x1000-0x107f]: assigned machine # [ 0.443535] pci 0000:00:0b.0: BAR 0 [io 0x1080-0x10bf]: assigned machine # [ 0.443554] pci 0000:00:01.0: BAR 0 [io 0x10c0-0x10df]: assigned machine # [ 0.443571] pci 0000:00:02.0: BAR 0 [io 0x10e0-0x10ff]: assigned machine # [ 0.443589] pci 0000:00:04.0: BAR 0 [io 0x1100-0x111f]: assigned machine # [ 0.443619] pci 0000:00:0c.0: BAR 0 [io 0x1120-0x113f]: assigned machine # [ 0.443641] pci_bus 0000:00: resource 4 [io 0x0000-0xffff] machine # [ 0.443646] pci_bus 0000:00: resource 5 [mem 0x10000000-0x3efeffff] machine # [ 0.443649] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff] machine # [ 0.444528] pci 0000:00:07.0: enabling device (0000 -> 0002) machine # [ 0.530144] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003) machine # [ 0.532652] virtio-pci 0000:00:02.0: enabling device (0000 -> 0003) machine # [ 0.550871] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003) machine # [ 0.553022] virtio-pci 0000:00:04.0: enabling device (0000 -> 0003) machine # [ 0.557074] virtio-pci 0000:00:05.0: enabling device (0000 -> 0002) machine # [ 0.561093] virtio-pci 0000:00:06.0: enabling device (0000 -> 0002) machine # [ 0.570725] virtio-pci 0000:00:08.0: enabling device (0000 -> 0002) machine # [ 0.573101] virtio-pci 0000:00:09.0: enabling device (0000 -> 0002) machine # [ 0.582864] virtio-pci 0000:00:0a.0: enabling device (0000 -> 0002) machine # [ 0.593989] virtio-pci 0000:00:0b.0: enabling device (0000 -> 0003) machine # [ 0.596608] virtio-pci 0000:00:0c.0: enabling device (0000 -> 0003) machine # [ 0.610742] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled machine # [ 0.612704] msm_serial: driver initialized machine # [ 0.612875] SuperH (H)SCI(F) driver initialized machine # [ 0.612934] STM32 USART driver initialized machine # [ 0.655936] loop: module loaded machine # [ 0.656163] virtio_blk virtio2: 1/0/0 default/read/poll queues machine # [ 0.657157] virtio_blk virtio2: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) machine # [ 0.662038] megasas: 07.734.00.00-rc1 machine # [ 0.662799] physmap-flash 0.flash: physmap platform flash device: [mem 0x00000000-0x03ffffff] machine # [ 0.665145] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000 machine # [ 0.665176] Intel/Sharp Extended Query Table at 0x0031 machine # [ 0.678484] Using buffer write method machine # [ 0.678551] physmap-flash 0.flash: physmap platform flash device: [mem 0x04000000-0x07ffffff] machine # [ 0.680368] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000 machine # [ 0.680397] Intel/Sharp Extended Query Table at 0x0031 machine # [ 0.685971] Using buffer write method machine # [ 0.685997] Concatenating MTD devices: machine # [ 0.686000] (0): "0.flash" machine # [ 0.686002] (1): "0.flash" machine # [ 0.686004] into device "0.flash" machine # [ 0.992976] Freeing initrd memory: 26424K machine # [ 0.999458] tun: Universal TUN/TAP device driver, 1.6 machine # [ 1.003693] thunder_xcv, ver 1.0 machine # [ 1.003723] thunder_bgx, ver 1.0 machine # [ 1.003742] nicpf, ver 1.0 machine # [ 1.004317] e1000: Intel(R) PRO/1000 Network Driver machine # [ 1.004320] e1000: Copyright (c) 1999-2006 Intel Corporation. machine # [ 1.004345] e1000e: Intel(R) PRO/1000 Network Driver machine # [ 1.004354] e1000e: Copyright(c) 1999 - 2015 Intel Corporation. machine # [ 1.004379] igb: Intel(R) Gigabit Ethernet Network Driver machine # [ 1.004383] igb: Copyright (c) 2007-2014 Intel Corporation. machine # [ 1.004408] igbvf: Intel(R) Gigabit Virtual Function Network Driver machine # [ 1.004412] igbvf: Copyright (c) 2009 - 2012 Intel Corporation. machine # [ 1.004552] sky2: driver version 1.30 machine # [ 1.014203] usbcore: registered new interface driver usb-storage machine # [ 1.014304] usbcore: registered new interface driver usbserial_generic machine # [ 1.014315] usbserial: USB Serial support registered for generic machine # [ 1.014959] hv_vmbus: registering driver hyperv_keyboard machine # [ 1.016384] ehci-pci 0000:00:07.0: EHCI Host Controller machine # [ 1.016408] ehci-pci 0000:00:07.0: new USB bus registered, assigned bus number 1 machine # [ 1.016642] ehci-pci 0000:00:07.0: irq 16, io mem 0x10086000 machine # [ 1.016970] rtc-pl031 9010000.pl031: registered as rtc0 machine # [ 1.016996] rtc-pl031 9010000.pl031: setting system clock to 2026-09-27T03:13:22 UTC (1790478802) machine # [ 1.024936] i2c_dev: i2c /dev entries driver machine # [ 1.025357] ehci-pci 0000:00:07.0: USB 2.0 started, EHCI 1.00 machine # [ 1.025715] hub 1-0:1.0: USB hub found machine # [ 1.025771] hub 1-0:1.0: 6 ports detected machine # [ 1.031709] sdhci: Secure Digital Host Controller Interface driver machine # [ 1.031716] sdhci: Copyright(c) Pierre Ossman machine # [ 1.032015] Synopsys Designware Multimedia Card Interface Driver machine # [ 1.032409] sdhci-pltfm: SDHCI platform and OF driver helper machine # [ 1.037011] hid: raw HID events driver (C) Jiri Kosina machine # [ 1.037266] usbcore: registered new interface driver usbhid machine # [ 1.037276] usbhid: USB HID core driver machine # [ 1.040455] hw perfevents: enabled with armv8_pmuv3 PMU driver, 11 (0,800003ff) counters available machine # [ 1.043326] drop_monitor: Initializing network drop monitor service machine # [ 1.043478] NET: Registered PF_INET6 protocol family machine # [ 1.044193] Segment Routing with IPv6 machine # [ 1.044207] In-situ OAM (IOAM) with IPv6 machine # [ 1.044253] NET: Registered PF_PACKET protocol family machine # [ 1.044310] 9pnet: Installing 9P2000 support machine # [ 1.044347] Key type dns_resolver registered machine # [ 1.055069] registered taskstats version 1 machine # [ 1.055230] Loading compiled-in X.509 certificates machine # [ 1.064341] Demotion targets for Node 0: null machine # [ 1.064463] Key type .fscrypt registered machine # [ 1.064471] Key type fscrypt-provisioning registered machine # [ 1.064569] ima: No TPM chip found, activating TPM-bypass! machine # [ 1.064587] ima: Allocated hash algorithm: sha1 machine # [ 1.064613] ima: No architecture policies found machine # [ 1.069116] input: gpio-keys as /devices/platform/gpio-keys/input/input0 machine # [ 1.088582] clk: Disabling unused clocks machine # [ 1.088602] PM: genpd: Disabling unused power domains machine # [ 1.092995] Freeing unused kernel memory: 4736K machine # [ 1.093210] Run /init as init process machine # [ 1.112081] systemd[1]: Successfully made /usr/ read-only. machine # [ 1.112527] systemd[1]: systemd 263-885fe07 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.112541] systemd[1]: Detected virtualization qemu. machine # [ 1.112592] systemd[1]: Detected architecture arm64. machine # [ 1.112597] systemd[1]: Running in initrd. machine # [ 1.112878] systemd[1]: Initializing machine ID from random generator. machine # [ 1.112976] systemd[1]: Hostname set to . machine # [ 1.216292] systemd[1]: bpf-restrict-fs: LSM BPF program attached machine # [ 1.269981] systemd[1]: Queued start job for default target Initrd Default Target. machine # [ 1.276536] systemd[1]: Created slice Slice /system/modprobe. machine # [ 1.276722] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. machine # [ 1.276747] systemd[1]: Expecting device /dev/disk/by-label/nixos... machine # [ 1.276768] systemd[1]: Reached target Path Units. machine # [ 1.276780] systemd[1]: Reached target Slice Units. machine # [ 1.276792] systemd[1]: Reached target Swaps. machine # [ 1.276807] systemd[1]: Reached target Timer Units. machine # [ 1.276938] systemd[1]: Listening on D-Bus System Message Bus Socket. machine # [ 1.277056] systemd[1]: Listening on Journal Socket (/dev/log). machine # [ 1.277199] systemd[1]: Listening on Journal Sockets. machine # [ 1.277270] systemd[1]: Listening on udev Kernel Socket. machine # [ 1.277284] systemd[1]: Reached target Socket Units. machine # [ 1.277353] usb 1-1: new high-speed USB device number 2 using ehci-pci machine # [ 1.289092] systemd[1]: Starting Create List of Static Device Nodes... machine # [ 1.289151] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs machine # [ 1.294579] systemd[1]: Mounting Kernel Configuration File System... machine # [ 1.311807] systemd[1]: Starting Journal Service... machine # [ 1.321296] systemd[1]: Starting Load Kernel Modules... machine # [ 1.330819] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 1.345682] systemd[1]: Starting Coldplug All udev Devices... machine # [ 1.357504] systemd[1]: Finished Create List of Static Device Nodes. machine # [ 1.366789] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. machine # [ 1.373479] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... machine # [ 1.373783] systemd[1]: Mounted Kernel Configuration File System. machine # [ 1.383336] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev machine # [ 1.394749] [drm] pci: virtio-gpu-pci detected at 0000:00:05.0 machine # [ 1.394984] [drm] features: -virgl +edid -resource_blob -host_visible machine # [ 1.394987] [drm] features: -context_init machine # [ 1.395802] [drm] number of scanouts: 1 machine # [ 1.395814] [drm] number of cap sets: 0 machine # [ 1.409276] systemd-journald[71]: Collecting audit messages is disabled. machine # [ 1.425709] virtio-pci 0000:00:05.0: [drm] Registered 1 planes with drm panic machine # [ 1.425726] [drm] Initialized virtio_gpu 0.1.0 for 0000:00:05.0 on minor 0 machine # [ 1.432490] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. machine # [ 1.437741] systemd[1]: Starting Create Static Device Nodes in /dev... machine # [ 1.439124] 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.481368] Console: switching to colour frame buffer device 160x50 machine # [ 1.482074] virtio-pci 0000:00:05.0: [drm] fb0: virtio_gpudrmfb frame buffer device machine # [ 1.482863] systemd[1]: Finished Create Static Device Nodes in /dev. machine # [ 1.483089] systemd[1]: Reached target Preparation for Local File Systems. machine # [ 1.483119] systemd[1]: Reached target Local File Systems. machine # [ 1.495115] systemd[1]: Starting Rule-based Manager for Device Events and Files... machine # [ 1.517560] systemd[1]: Finished Load Kernel Modules. machine # [ 1.529597] 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.531535] systemd[1]: Starting Apply Kernel Variables... machine # [ 1.592179] systemd[1]: Started Journal Service. machine # [ 1.583962] systemd-modules-load[72]: Inserted module 'dm_mod' machine # [ 1.585230] systemd-modules-load[72]: Module 'virtio_balloon' is built in machine # [ 1.586427] systemd-modules-load[72]: Module 'virtio_console' is built in machine # [ 1.587552] systemd-modules-load[72]: Inserted module 'virtio_gpu' machine # [ 1.601336] systemd-modules-load[72]: Module 'virtio_rng' is built in machine # [ 1.602502] systemd[1]: Starting Create System Files and Directories... machine # [ 1.603930] systemd-udevd[79]: Using default interface naming scheme 'v261'. machine # [ 1.616943] systemd[1]: Finished Apply Kernel Variables. machine # [ 1.649472] usb 1-2: new high-speed USB device number 3 using ehci-pci machine # [ 1.653761] systemd[1]: Finished Create System Files and Directories. machine # [ 1.661259] systemd[1]: Started Rule-based Manager for Device Events and Files. machine # [ 1.780126] systemd[1]: Starting Virtual Console Setup... machine # [ 1.810091] 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.810341] 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.864816] systemd-vconsole-setup[102]: Configuration of first virtual console was skipped, ignoring remaining ones. machine # [ 1.877219] systemd[1]: Finished Virtual Console Setup. machine # [ 2.521039] systemd[1]: Finished Coldplug All udev Devices. machine # [ 2.522055] systemd[1]: Reached target System Initialization. machine # [ 2.522962] systemd[1]: Reached target Basic System. machine # [ 2.702640] (udev-worker)[92]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. machine # [ 2.707999] (udev-worker)[92]: Network interface NamePolicy= disabled on kernel command line. machine # [ 2.771775] systemd[1]: Found device /dev/disk/by-label/nixos. machine # [ 2.776635] systemd[1]: Reached target Initrd Root Device. machine # [ 2.779500] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos... machine # [ 2.831690] systemd-fsck[111]: nixos: clean, 12/65536 files, 13019/262144 blocks machine # [ 2.838530] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos. machine # [ 2.844241] systemd[1]: Mounting /sysroot... machine # [ 2.896986] EXT4-fs (vda): mounted filesystem 3f4f38db-117c-429e-9a0b-9f04d7183766 r/w with ordered data mode. Quota mode: none. machine # [ 2.883916] systemd[1]: Mounted /sysroot. machine # [ 2.885552] systemd[1]: Reached target Initrd Root File System. machine # [ 2.889266] systemd[1]: Starting Mountpoints Configured in the Real Root... machine # [ 2.920700] systemd-sysroot-fstab-check[119]: /sysroot should be mounted in the initrd, will request daemon-reload. machine # [ 2.925222] systemd[1]: Reload requested from client PID 119 ('systemd-sysroot') (unit initrd-parse-etc.service)... machine # [ 2.929228] systemd[1]: Reloading... machine # [ 3.126755] systemd[1]: Reloading finished in 199 ms. machine # [ 3.156250] systemd-sysroot-fstab-check[119]: Requesting initrd-fs.target/start/replace... machine # [ 3.158938] systemd-sysroot-fstab-check[119]: Requesting swap.target/start/replace... machine # [ 3.167981] systemd[1]: initrd-parse-etc.service: Deactivated successfully. machine # [ 3.172604] systemd[1]: Finished Mountpoints Configured in the Real Root. machine # [ 3.173750] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies. machine # [ 3.339118] systemd[1]: Mounting /sysroot/nix/.ro-store... machine # [ 3.351195] systemd[1]: Mounting /sysroot/nix/.rw-store... machine # [ 3.369204] systemd[1]: Mounting /sysroot/run... machine # [ 3.392127] systemd[1]: Mounting /sysroot/tmp/shared... machine # [ 3.415151] systemd[1]: Mounting /sysroot/tmp/xchg... machine # [ 3.459914] systemd[1]: Mounted /sysroot/nix/.rw-store. machine # [ 3.501143] fuse: init (API version 7.45) machine # [ 3.508394] virtiofs virtio6: discovered new tag: nix-store machine # [ 3.509209] virtiofs virtio6: virtio_fs_setup_dax: No cache capability machine # [ 3.498693] systemd[1]: Mounted /sysroot/run. machine # [ 3.524480] virtiofs virtio7: discovered new tag: shared machine # [ 3.513410] systemd[1]: Starting rw-sysroot-nix-store.service... machine # [ 3.533391] virtiofs virtio7: virtio_fs_setup_dax: No cache capability machine # [ 3.536101] virtiofs virtio8: discovered new tag: xchg machine # [ 3.536878] virtiofs virtio8: virtio_fs_setup_dax: No cache capability machine # [ 3.553488] systemd[1]: Mounted /sysroot/nix/.ro-store. machine # [ 3.555908] systemd[1]: Mounted /sysroot/tmp/shared. machine # [ 3.560852] systemd[1]: Mounted /sysroot/tmp/xchg. machine # [ 3.568998] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. machine # [ 3.572176] systemd[1]: Finished rw-sysroot-nix-store.service. machine # [ 4.103161] (udev-worker)[98]: mtd0ro: Failed to find and pin callout binary "/nix/store/h0gamn89nms8prhnc5v8m85jslcyklhg-systemd-263-885fe07/lib/udev/mtd_probe": No such file or directory machine # [ 4.111094] (udev-worker)[98]: 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.143058] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. machine # [ 4.145839] systemd[1]: Stopped Virtual Console Setup. machine # [ 4.148254] systemd[1]: Stopping Virtual Console Setup... machine # [ 4.152190] systemd[1]: Starting Virtual Console Setup... machine # [ 4.162107] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. machine # [ 4.163403] systemd[1]: Stopped Virtual Console Setup. machine # [ 4.168555] systemd[1]: Starting Virtual Console Setup... machine # [ 4.195442] systemd-vconsole-setup[153]: Configuration of first virtual console was skipped, ignoring remaining ones. machine # [ 4.198562] systemd[1]: Finished Virtual Console Setup. machine # [ 4.338968] systemd[1]: Mounting /sysroot/nix/store... machine # [ 4.384079] systemd[1]: Mounted /sysroot/nix/store. machine # [ 4.386681] systemd[1]: Reached target Initrd File Systems. machine # [ 4.391047] systemd[1]: Starting Find NixOS closure... machine # [ 4.400467] systemd[1]: Starting Create Volatile Files and Directories in the Real Root... machine # [ 4.439467] systemd[1]: Finished Create Volatile Files and Directories in the Real Root. machine # [ 4.445398] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully. machine # [ 4.457186] systemd[1]: Finished Find NixOS closure. machine # [ 4.460308] systemd[1]: Reached target Initrd Default Target. machine # [ 4.462578] systemd[1]: Starting Cleaning Up and Shutting Down Daemons... machine # [ 4.491543] systemd[1]: Stopped target Initrd Default Target. machine # [ 4.493369] systemd[1]: Stopped target Basic System. machine # [ 4.494540] systemd[1]: Stopped target Initrd Root Device. machine # [ 4.496312] systemd[1]: Stopped target Path Units. machine # [ 4.500421] systemd[1]: systemd-ask-password-console.path: Deactivated successfully. machine # [ 4.501768] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch. machine # [ 4.503741] systemd[1]: Stopped target Slice Units. machine # [ 4.508332] systemd[1]: Stopped target Socket Units. machine # [ 4.509223] systemd[1]: Stopped target System Initialization. machine # [ 4.510138] systemd[1]: Stopped target Swaps. machine # [ 4.510891] systemd[1]: Stopped target Timer Units. machine # [ 4.511655] systemd[1]: dbus.socket: Deactivated successfully. machine # [ 4.516323] systemd[1]: Closed D-Bus System Message Bus Socket. machine # [ 4.520418] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully. machine # [ 4.524955] systemd[1]: Stopped Find NixOS closure. machine # [ 4.526657] systemd[1]: Starting rw-sysroot-nix-store.service... machine # [ 4.531042] systemd[1]: systemd-sysctl.service: Deactivated successfully. machine # [ 4.535114] systemd[1]: Stopped Apply Kernel Variables. machine # [ 4.535952] systemd[1]: systemd-modules-load.service: Deactivated successfully. machine # [ 4.541877] systemd[1]: Stopped Load Kernel Modules. machine # [ 4.543277] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully. machine # [ 4.549684] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root. machine # [ 4.556721] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. machine # [ 4.560255] systemd[1]: Stopped Create System Files and Directories. machine # [ 4.564634] systemd[1]: Stopped target Local File Systems. machine # [ 4.565550] systemd[1]: Stopped target Preparation for Local File Systems. machine # [ 4.566666] systemd[1]: systemd-udev-trigger.service: Deactivated successfully. machine # [ 4.569367] systemd[1]: Stopped Coldplug All udev Devices. machine # [ 4.570297] systemd[1]: Stopping Rule-based Manager for Device Events and Files... machine # [ 4.574179] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. machine # [ 4.575555] systemd[1]: Stopped Virtual Console Setup. machine # [ 4.576483] systemd[1]: initrd-cleanup.service: Deactivated successfully. machine # [ 4.577472] systemd[1]: Finished Cleaning Up and Shutting Down Daemons. machine # [ 4.578444] systemd[1]: systemd-udevd.service: Deactivated successfully. machine # [ 4.579419] systemd[1]: Stopped Rule-based Manager for Device Events and Files. machine # [ 4.584300] systemd[1]: systemd-udevd.service: Consumed 1.565s CPU time over 3.074s wall clock time, 22.5M memory peak. machine # [ 4.588353] systemd[1]: Starting Cleanup udev Database... machine # [ 4.592408] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. machine # [ 4.593815] systemd[1]: Stopped Create Static Device Nodes in /dev. machine # [ 4.594797] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. machine # [ 4.600134] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully. machine # [ 4.601267] systemd[1]: kmod-static-nodes.service: Deactivated successfully. machine # [ 4.602349] systemd[1]: Stopped Create List of Static Device Nodes. machine # [ 4.604107] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. machine # [ 4.608494] systemd[1]: Finished rw-sysroot-nix-store.service. machine # [ 4.633606] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. machine # [ 4.635381] systemd[1]: Finished Cleanup udev Database. machine # [ 4.637649] systemd[1]: Reached target Switch Root. machine # [ 4.638983] systemd[1]: Starting NixOS Activation... machine # [ 4.721024] initrd-nixos-activation-start[176]: booting system configuration /nix/store/b2rywx23jb5nhi7b4xfic9vflyz9nzq1-nixos-system-machine-test machine # [ 4.753286] initrd-nixos-activation-start[176]: running activation script... machine # [ 4.980268] initrd-nixos-activation-start[199]: setting up /etc... machine # [ 5.094472] systemd[1]: initrd-nixos-activation.service: Deactivated successfully. machine # [ 5.097381] systemd[1]: Finished NixOS Activation. machine # [ 5.098607] systemd[1]: Starting Switch Root... machine # [ 5.120355] systemd[1]: Switching root. machine # [ 5.311024] systemd-journald[71]: Received SIGTERM from PID 1 (systemd). machine # [ 5.471857] systemd[1]: systemd 263-885fe07 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE) machine # [ 5.472891] systemd[1]: Detected virtualization qemu. machine # [ 5.480992] systemd[1]: Detected architecture arm64. machine # [ 5.482944] systemd[1]: Detected first boot. machine # [ 5.484938] systemd[1]: Initializing machine ID from random generator. machine # [ 5.620945] systemd[1]: bpf-restrict-fs: LSM BPF program attached machine # [ 5.776854] systemd[1]: Applying preset policy. machine # [ 6.005533] systemd[1]: Populated /etc with preset unit settings. machine # [ 6.207150] systemd[1]: initrd-switch-root.service: Deactivated successfully. machine # [ 6.207971] systemd[1]: Stopped initrd-switch-root.service. machine # [ 6.212291] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. machine # [ 6.215947] systemd[1]: Created slice Slice /system/getty. machine # [ 6.217231] systemd[1]: Created slice User and Session Slice. machine # [ 6.219962] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. machine # [ 6.220471] systemd[1]: Started Forward Password Requests to Wall Directory Watch. machine # [ 6.221010] systemd[1]: Expecting device /dev/hvc0... machine # [ 6.224646] systemd[1]: Expecting device /dev/ttyAMA0... machine # [ 6.225054] systemd[1]: Reached target Local Encrypted Volumes. machine # [ 6.227665] systemd[1]: Stopped target initrd-fs.target. machine # [ 6.228082] systemd[1]: Stopped target initrd-root-fs.target. machine # [ 6.228640] systemd[1]: Stopped target initrd-switch-root.target. machine # [ 6.229196] systemd[1]: Reached target Virtual Machines and Containers. machine # [ 6.233384] systemd[1]: Reached target Path Units. machine # [ 6.233806] systemd[1]: Reached target Remote File Systems. machine # [ 6.234512] systemd[1]: Reached target Slice Units. machine # [ 6.235093] systemd[1]: Reached target Swaps. machine # [ 6.237022] systemd[1]: Listening on Query the User Interactively for a Password. machine # [ 6.243027] systemd[1]: Listening on Process Core Dump Socket. machine # [ 6.244419] systemd[1]: Listening on Credential Encryption/Decryption. machine # [ 6.247660] systemd[1]: Listening on Factory Reset Management. machine # [ 6.248166] systemd[1]: Listening on Hostname Service Socket. machine # [ 6.252990] systemd[1]: Starting Journal Log Access Socket... machine # [ 6.256062] systemd[1]: Listening on Journal Audit Socket. machine # [ 6.259273] systemd[1]: Listening on Console Output Muting Service Socket. machine # [ 6.261194] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket. machine # [ 6.263551] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 6.264313] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 6.270884] systemd[1]: Listening on Disk Repartitioning Service Socket. machine # [ 6.271441] systemd[1]: Listening on udev Varlink Socket. machine # [ 6.276110] systemd[1]: Mounting Huge Pages File System... machine # [ 6.280511] systemd[1]: Mounting POSIX Message Queue File System... machine # [ 6.297461] systemd[1]: Mounting Kernel Debug File System... machine # [ 6.302826] systemd[1]: Mounting Kernel Trace File System... machine # [ 6.315711] systemd[1]: Starting Create List of Static Device Nodes... machine # [ 6.321486] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs machine # [ 6.332734] systemd[1]: Mounting Kernel Configuration File System... machine # [ 6.336160] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm machine # [ 6.345077] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 6.347954] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse machine # [ 6.379415] systemd[1]: Mounting FUSE Control File System... machine # [ 6.379882] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 6.414489] systemd[1]: Starting Journal Service... machine # [ 6.429988] systemd[1]: Starting Load Kernel Modules... machine # [ 6.459050] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer... machine # [ 6.470965] systemd[1]: Starting Remount Root and Kernel File Systems... machine # [ 6.471395] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 6.493443] systemd[1]: Starting Coldplug All udev Devices... machine # [ 6.496332] systemd[1]: Listening on Journal Log Access Socket. machine # [ 6.496776] systemd[1]: Mounted Huge Pages File System. machine # [ 6.497176] systemd[1]: Mounted POSIX Message Queue File System. machine # [ 6.518877] systemd-journald[270]: Collecting audit messages is enabled. machine # [ 6.523035] systemd[1]: Mounted Kernel Debug File System. machine # [ 6.523633] systemd[1]: Mounted Kernel Trace File System. machine # [ 6.514917] systemd[1]: Queued start job for default target Multi-User System. machine # [ 6.521420] systemd[1]: systemd-journald.service: Deactivated successfully. machine # [ 6.523098] systemd-modules-load[271]: Module 'atkbd' is built in machine # [ 6.532593] systemd-modules-load[271]: Module 'loop' is built in machine # [ 6.554302] systemd[1]: Finished Create List of Static Device Nodes. machine # [ 6.559154] systemd[1]: Started Journal Service. machine # [ 6.551455] systemd[1]: Finished Load Kernel Modules. machine # [ 6.573540] EXT4-fs (vda): re-mounted 3f4f38db-117c-429e-9a0b-9f04d7183766. machine # [ 6.577824] systemd[1]: Mounted Kernel Configuration File System. machine # [ 6.582744] systemd[1]: Mounted FUSE Control File System. machine # [ 6.585149] systemd[1]: Finished Remount Root and Kernel File Systems. machine # [ 6.600813] systemd[1]: Listening on Disk Image Download Service Socket. machine # [ 6.615384] systemd[1]: Starting Firewall... machine # [ 6.623121] systemd[1]: Starting Flush Journal to Persistent Storage... machine # [ 6.628231] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 6.640112] systemd[1]: Starting Load/Save OS Random Seed... machine # [ 6.660760] systemd[1]: Starting Apply Kernel Variables... machine # [ 6.678171] systemd-oomd[273]: No swap; memory pressure usage will be degraded machine # [ 6.720230] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... machine # [ 6.721487] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 6.732361] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer. machine # [ 6.779508] systemd-journald[270]: Received client request to flush runtime journal. machine # [ 6.821434] systemd[1]: Finished Load/Save OS Random Seed. machine # [ 6.822509] systemd[1]: Reached target First Boot Complete. machine # [ 6.833291] systemd[1]: Finished Flush Journal to Persistent Storage. machine # [ 6.874298] systemd[1]: Finished Apply Kernel Variables. machine # [ 6.938071] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. machine # [ 6.940544] systemd[1]: Starting Create Static Device Nodes in /dev... machine # [ 7.082061] systemd[1]: Finished Create Static Device Nodes in /dev. machine # [ 7.084619] systemd[1]: Reached target Preparation for Local File Systems. machine # [ 7.089267] systemd[1]: Starting Rule-based Manager for Device Events and Files... machine # [ 7.201716] systemd[1]: Mounting /run/wrappers... machine # [ 7.260483] systemd-udevd[312]: Using default interface naming scheme 'v261'. machine # [ 7.275349] systemd[1]: Mounted /run/wrappers. machine # [ 7.276424] systemd[1]: Reached target Local File Systems. machine # [ 7.283871] systemd[1]: Listening on Boot Loader Control Service Socket. machine # [ 7.289796] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 7.290718] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 7.298951] systemd[1]: Starting Save Transient machine-id to Disk... machine # [ 7.304188] systemd[1]: Starting Create System Files and Directories... machine # [ 7.465035] systemd[1]: Started Rule-based Manager for Device Events and Files. machine # [ 7.553077] systemd[1]: Finished Create System Files and Directories. machine # [ 7.554223] systemd[1]: etc-machine\x2did.mount: Deactivated successfully. machine # [ 7.566839] systemd[1]: Starting Rebuild Journal Catalog... machine # [ 7.574501] systemd[1]: Starting Record System Boot/Shutdown in UTMP... machine # [ 7.584658] systemd[1]: Finished Save Transient machine-id to Disk. machine # [ 7.692555] systemd[1]: Finished Record System Boot/Shutdown in UTMP. machine # [ 7.741961] systemd[1]: Finished Rebuild Journal Catalog. machine # [ 7.753799] systemd[1]: Starting Update is Completed... machine # [ 7.803570] systemd[1]: Finished Update is Completed. machine # [ 8.225670] systemd[1]: Finished Coldplug All udev Devices. machine # [ 8.295495] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 8.299763] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 8.304682] systemd[1]: Reached target System Initialization. machine # [ 8.305610] systemd[1]: Started Discard unused filesystem blocks once a week. machine # [ 8.306711] systemd[1]: Started Daily Cleanup of Temporary Directories. machine # [ 8.307684] systemd[1]: Reached target Timer Units. machine # [ 8.317794] systemd[1]: Listening on D-Bus System Message Bus Socket. machine # [ 8.318920] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket. machine # [ 8.326935] systemd[1]: Reached target Socket Units. machine # [ 8.327745] systemd[1]: Reached target Basic System. machine # [ 8.333554] systemd[1]: Starting Import lastlog data into lastlog2 database... machine # [ 8.334802] systemd[1]: Starting Name Service Cache Daemon (nsncd)... machine # [ 8.341724] systemd[1]: Starting Post-Boot Actions... machine # [ 8.362531] systemd[1]: Started Reset console on configuration changes. machine # [ 8.406580] systemd[1]: Starting resolvconf update... machine # [ 8.459319] systemd[1]: Starting D-Bus System Message Bus... machine # [ 8.460996] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs machine # [ 8.462664] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse machine # [ 8.511144] nsncd[430]: Sep 27 03:13:30.010 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" machine # [ 8.530585] systemd[1]: Started Name Service Cache Daemon (nsncd). machine # [ 8.531633] systemd[1]: Finished Post-Boot Actions. machine # [ 8.540413] systemd[1]: Reached target Host and Network Name Lookups. machine # [ 8.541432] systemd[1]: Reached target User and Group Name Lookups. machine # [ 8.554075] systemd[1]: Starting User Login Management... machine # [ 8.660619] systemd[1]: Finished Import lastlog data into lastlog2 database. machine # [ 8.723263] dbus-broker-launch[440]: Looking up NSS user entry for 'systemd-timesync'... machine # [ 8.735005] dbus-broker-launch[440]: NSS returned no entry for 'systemd-timesync' machine # [ 8.740207] dbus-broker-launch[440]: Invalid user-name in /nix/store/svs250hlinpmmh842v5vq65hzwi7rbkc-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" machine # [ 8.800175] systemd[1]: Started D-Bus System Message Bus. machine # [ 8.817320] systemd-logind[456]: New seat seat0. machine # [ 8.825634] systemd[1]: Started User Login Management. machine # [ 8.840285] systemd[1]: Starting linger-users.service... machine # [ 8.855174] dbus-broker-launch[440]: Ready machine # [ 8.898769] systemd[1]: Condition check resulted in /dev/hvc0 being skipped. machine # [ 8.948934] systemd[1]: Stopped target Host and Network Name Lookups. machine # [ 8.950170] systemd[1]: Stopping Host and Network Name Lookups... machine # [ 8.951227] systemd[1]: Stopped target User and Group Name Lookups. machine # [ 8.967347] systemd[1]: Stopping User and Group Name Lookups... machine # [ 8.974430] systemd[1]: Stopping Name Service Cache Daemon (nsncd)... machine # [ 8.975521] systemd[1]: nscd.service: Deactivated successfully. machine # [ 8.984259] systemd[1]: Stopped Name Service Cache Daemon (nsncd). machine # [ 9.021431] systemd[1]: Starting Name Service Cache Daemon (nsncd)... machine # [ 9.067708] systemd[1]: Condition check resulted in /dev/ttyAMA0 being skipped. machine # [ 9.125383] systemd[1]: Created slice Slice /user/1001. machine # [ 9.126444] systemd[1]: Started backdoor.service. machine # [ 9.127196] systemd[1]: Starting User Runtime Directory /run/user/1001... machine # [ 9.191634] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 9.222173] systemd[1]: Finished linger-users.service. machine # [ 9.242158] (udev-worker)[394]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. machine # [ 9.303436] (udev-worker)[394]: Network interface NamePolicy= disabled on kernel command line. machine # [ 9.336694] nsncd[528]: Sep 27 03:13:30.750 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" machine # [ 9.339018] systemd[1]: Started Name Service Cache Daemon (nsncd). machine # [ 9.417275] systemd[1]: Reached target Host and Network Name Lookups. machine # [ 9.440557] systemd[1]: Reached target User and Group Name Lookups. machine # [ 9.465470] systemd[1]: Finished User Runtime Directory /run/user/1001. machine # [ 9.489652] systemd[1]: Starting User Manager for UID 1001... machine # [ 9.517345] (systemd)[561]: pam_unix(systemd-user:session): session opened for user usertest(uid=1001) by (uid=0) machine # [ 9.560799] systemd[1]: Finished resolvconf update. machine # [ 9.561740] systemd[1]: Starting DHCP Client... machine # [ 9.562484] systemd-logind[456]: New session '1' of user 'usertest' with class 'manager' and type 'unspecified'. machine # [ 9.563906] systemd[1]: Condition check resulted in Virtio network device being skipped. machine # [ 9.677226] systemd[561]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # connecting to host... machine # [ 9.890900] mousedev: PS/2 mouse device common for all mice machine: Guest shell says: b'Spawning backdoor root shell...\n' machine: connected to guest root shell machine: (connecting took 10.33 seconds) machine: (finished: waiting for the VM to finish booting, in 10.74 seconds) machine # [ 10.021511] systemd-logind[456]: Watching system buttons on /dev/input/event0 (gpio-keys) machine # [ 10.056479] systemd[561]: Queued start job for default target Main User Target. machine # [ 10.080200] systemd[561]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 10.114566] systemd[561]: Created slice User Application Slice. machine # [ 10.132714] systemd[561]: Started Daily Cleanup of User's Temporary Directories. machine # [ 10.149980] systemd[561]: Reached target Paths. machine # [ 10.150898] systemd[561]: Reached target Timers. machine # [ 10.151581] systemd[561]: Starting D-Bus User Message Bus Socket... machine # [ 10.191191] systemd[561]: Starting Create User Files and Directories... machine # [ 10.205576] systemd[561]: Finished Create User Files and Directories. machine # [ 10.206716] systemd[561]: Listening on D-Bus User Message Bus Socket. machine # [ 10.238024] systemd[561]: Reached target Sockets. machine # [ 10.238937] systemd[561]: Reached target Basic System. machine # [ 10.239689] systemd[1]: Started User Manager for UID 1001. machine # [ 10.251310] systemd[561]: Starting Run user-specific NixOS activation... machine # [ 10.259092] systemd[561]: Finished Run user-specific NixOS activation. machine # [ 10.272797] systemd[561]: Reached target Main User Target. machine # [ 10.273659] systemd[561]: Startup finished in 474ms. machine # [ 10.274393] systemd-logind[456]: Watching system buttons on /dev/input/event1 (QEMU QEMU USB Keyboard) machine # [ 10.313448] dhcpcd[591]: dhcpcd-10.3.2 starting machine # [ 10.318757] dhcpcd[605]: dev: loaded udev machine # [ 10.331491] systemd[1]: Finished Firewall. machine # [ 10.336402] systemd[1]: Reached target Preparation for Network. machine # [ 10.340776] systemd[1]: Starting Address configuration of eth1... machine # [ 10.346575] systemd[1]: Starting Extra networking commands.... machine # [ 10.372349] 8021q: 802.1Q VLAN Support v1.8 machine # [ 10.452746] cfg80211: Loading compiled-in X.509 certificates for regulatory database machine # [ 10.486912] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' machine # [ 10.487403] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600' machine # [ 10.488638] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -2 machine # [ 10.488953] cfg80211: failed to load regulatory.db machine # [ 10.612790] 8021q: adding VLAN 0 to HW filter on device eth1 machine # [ 10.664757] dhcpcd[628]: /nix/store/1ki7bgdr0niilkg9jbkpcdaggbv0kb8a-openresolv-3.17.4/sbin/.resolvconf-wrapped: line 1250: kill: (622) - Operation not permitted machine # [ 10.666756] dhcpcd[628]: .resolvconf-wrapped: clearing stale lock pid 622 machine # [ 10.708958] network-addresses-eth1-start[608]: adding address 192.168.1.1/24... done machine # [ 10.752562] network-addresses-eth1-start[608]: adding address 2001:db8:1::1/64... done machine # [ 10.849953] systemd[1]: Finished Address configuration of eth1. machine # [ 10.917467] 8021q: adding VLAN 0 to HW filter on device eth0 machine # [ 10.912987] dhcpcd[605]: eth0: waiting for carrier machine # [ 10.913807] dhcpcd[605]: eth0: carrier acquired machine # [ 10.988497] dhcpcd[605]: DUID 00:01:00:01:32:4b:46:5c:52:54:00:12:34:56 machine # [ 10.989571] dhcpcd[605]: eth0: IAID 00:12:34:56 machine # [ 10.990319] dhcpcd[605]: eth0: adding address fe80::5054:ff:fe12:3456 machine # [ 11.168826] input: QEMU Virtio Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:06.0/virtio5/input/input3 machine # [ 11.433588] systemd[1]: Finished Extra networking commands.. machine # [ 11.434635] systemd[1]: Reached target Network. machine # [ 11.455966] systemd[1]: Starting Permit User Sessions... machine # [ 11.572222] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch. machine # [ 11.597092] systemd[1]: Starting Virtual Console Setup... machine # [ 11.659425] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. machine # [ 11.666244] systemd[1]: Stopped Virtual Console Setup. machine # [ 11.667498] systemd-logind[456]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard) machine # [ 11.687873] systemd[1]: Starting Virtual Console Setup... machine # [ 11.688952] systemd[1]: Finished Permit User Sessions. machine # [ 11.689705] systemd[1]: Started Getty on tty1. machine # [ 11.690409] systemd[1]: Reached target Login Prompts. machine # [ 11.858399] systemd-vconsole-setup[707]: Configuration of first virtual console was skipped, ignoring remaining ones. machine # [ 11.865793] systemd[1]: Finished Virtual Console Setup. machine # [ 11.964370] dhcpcd[605]: eth0: soliciting a DHCP lease machine # [ 11.966662] dhcpcd[605]: eth0: offered 10.0.2.15 from 10.0.2.2 machine # [ 11.976474] dhcpcd[605]: eth0: probing address 10.0.2.15/24 machine # [ 12.994331] dhcpcd[605]: eth0: soliciting an IPv6 router machine # [ 12.996434] dhcpcd[605]: eth0: Router Advertisement from fe80::2 machine # [ 12.997921] dhcpcd[605]: eth0: adding address fec0::5054:ff:fe12:3456/64 machine # [ 12.999521] dhcpcd[605]: eth0: adding route to fec0::/64 machine # [ 13.000967] dhcpcd[605]: eth0: adding default route via fe80::2 machine # [ 16.969618] dhcpcd[605]: eth0: leased 10.0.2.15 for 86400 seconds machine # [ 16.969817] dhcpcd[605]: eth0: adding route to 10.0.2.0/24 machine # [ 16.969891] dhcpcd[605]: eth0: adding default route via 10.0.2.2 machine # [ 17.108871] systemd[1]: Started DHCP Client. machine # [ 17.114732] systemd[1]: Reached target Multi-User System. machine # [ 17.118659] systemd[1]: Startup finished in 1.081s (kernel) + 4.290s (initrd) + 11.744s (userspace) = 17.115s. machine: (finished: waiting for unit multi-user.target, in 18.97 seconds) machine: must succeed: /nix/store/glw2b718093b6m9v90xl0blwv4z9hk4p-stderr-runner /nix/store/b2rywx23jb5nhi7b4xfic9vflyz9nzq1-nixos-system-machine-test/bin/switch-to-configuration test machine # Checking switch inhibitors... done machine # [ 18.484185] nixos[835]: switching to system configuration /nix/store/b2rywx23jb5nhi7b4xfic9vflyz9nzq1-nixos-system-machine-test machine # activating the configuration... machine # [ 18.490803] systemd[1]: Stopped target Remote File Systems. machine # [ 18.491792] systemd[1]: Stopped target Local File Systems. machine # setting up /etc... machine # [ 18.791316] systemd[1]: Reload requested from client PID 835 ('.switch-to-conf') (unit backdoor.service)... machine # [ 18.793640] systemd[1]: Reloading... machine # [ 19.110767] systemd[1]: Reloading finished in 315 ms. machine # reloading user units for usertest... machine # [ 19.162783] systemd[561]: Created slice User Core Session Slice. machine # [ 19.165756] systemd[561]: Starting D-Bus User Message Bus... machine # [ 19.204736] dbus-broker-launch[905]: Ignoring duplicate name 'org.freedesktop.import1' in service file '/nix/store/svs250hlinpmmh842v5vq65hzwi7rbkc-system-path/share/dbus-1/services/org.freedesktop.import1.service' machine # [ 19.208519] dbus-broker-launch[905]: Ignoring duplicate name 'org.freedesktop.machine1' in service file '/nix/store/svs250hlinpmmh842v5vq65hzwi7rbkc-system-path/share/dbus-1/services/org.freedesktop.machine1.service' machine # [ 19.211446] dbus-broker-launch[905]: Ignoring duplicate name 'org.freedesktop.portable1' in service file '/nix/store/svs250hlinpmmh842v5vq65hzwi7rbkc-system-path/share/dbus-1/services/org.freedesktop.portable1.service' machine # [ 19.214631] dbus-broker-launch[905]: Ignoring duplicate name 'org.freedesktop.systemd1' in service file '/nix/store/svs250hlinpmmh842v5vq65hzwi7rbkc-system-path/share/dbus-1/services/org.freedesktop.systemd1.service' machine # [ 19.219292] dbus-broker-launch[905]: Policy to allow eavesdropping in /etc/dbus-1/session.conf +27: Eavesdropping is deprecated and ignored machine # [ 19.221722] dbus-broker-launch[905]: Policy to allow eavesdropping in /etc/dbus-1/session.conf +29: Eavesdropping is deprecated and ignored machine # [ 19.223534] systemd[561]: Started D-Bus User Message Bus. machine # [ 19.228280] dbus-broker-launch[905]: Ready machine # [ 19.270183] systemd[561]: Reexecution requested from client PID 904 ('switch-to-confi')... machine # [ 19.274476] systemd[561]: Reexecuting. machine # [ 19.328238] systemd[561]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 19.444853] systemd[561]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 19.451835] systemd[561]: Reload requested from client PID 904 ('switch-to-confi')... machine # [ 19.456324] systemd[561]: Reloading... machine # [ 19.563819] systemd[561]: Reloading finished in 108 ms. machine # [ 19.580206] systemd[561]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # restarting the following user units: nixos-activation.service machine # [ 19.590464] systemd[561]: Stopped Run user-specific NixOS activation. machine # [ 19.593048] systemd[561]: Stopping Run user-specific NixOS activation... machine # [ 19.595576] systemd[561]: Starting Run user-specific NixOS activation... machine # [ 19.631603] systemd[561]: Finished Run user-specific NixOS activation. machine # restarting sysinit-reactivation.target machine # [ 19.644294] systemd[1]: Starting Re-setup tmpfiles on a system that is already running.... machine # [ 19.732288] systemd[1]: Finished Re-setup tmpfiles on a system that is already running.. machine # [ 19.733571] systemd[1]: Reached target Reactivate sysinit units. machine # [ 19.739143] systemd[1]: Reached target Local File Systems. machine # [ 19.745429] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 19.747091] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 19.747931] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 19.756544] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 19.759026] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 19.769717] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 19.772863] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 19.774962] systemd[1]: Reached target Remote File Systems. machine # [ 19.776600] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 19.779873] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 19.947831] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 19.952389] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 19.955896] systemd[1]: Starting linger-users.service... machine # [ 19.998357] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 20.001100] systemd[1]: Finished linger-users.service. machine # the following new units were started: sysinit-reactivation.target, systemd-tmpfiles-resetup.service machine # [ 20.258711] nixos[835]: finished switching to system configuration /nix/store/b2rywx23jb5nhi7b4xfic9vflyz9nzq1-nixos-system-machine-test machine: (finished: must succeed: /nix/store/glw2b718093b6m9v90xl0blwv4z9hk4p-stderr-runner /nix/store/b2rywx23jb5nhi7b4xfic9vflyz9nzq1-nixos-system-machine-test/bin/switch-to-configuration test, in 2.02 seconds) machine: must succeed: rm /etc/NIXOS machine: (finished: must succeed: rm /etc/NIXOS, in 0.02 seconds) machine: must succeed: /nix/store/glw2b718093b6m9v90xl0blwv4z9hk4p-stderr-runner /nix/store/c014jg844hqw9kdghvk21k5i9sv26551-nixos-system-other-test/bin/switch-to-configuration test machine # this should succeed (config: /nix/store/c014jg844hqw9kdghvk21k5i9sv26551-nixos-system-other-test, action: test) machine # Checking switch inhibitors... done machine # [ 20.544777] nixos[982]: switching to system configuration /nix/store/c014jg844hqw9kdghvk21k5i9sv26551-nixos-system-other-test machine # [ 20.547164] systemd[1]: Stopped target Local File Systems. machine # activating the configuration... machine # [ 20.550154] systemd[1]: Stopped target Remote File Systems. machine # removing user ‘usertest’ machine # setting up /etc... machine # [ 20.835718] systemd[1]: Reload requested from client PID 982 ('.switch-to-conf') (unit backdoor.service)... machine # [ 20.838771] systemd[1]: Reloading... machine # [ 21.161411] systemd[1]: Reloading finished in 321 ms. machine # reloading user units for usertest... machine # [ 21.252227] systemd[561]: Reexecution requested from client PID 1054 ('switch-to-confi')... machine # [ 21.256704] systemd[561]: Reexecuting. machine # [ 21.311294] systemd[561]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 21.433590] systemd[561]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 21.440141] systemd[561]: Reload requested from client PID 1054 ('switch-to-confi')... machine # [ 21.442597] systemd[561]: Reloading... machine # [ 21.549574] systemd[561]: Reloading finished in 105 ms. machine # [ 21.564230] systemd[561]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # restarting the following user units: nixos-activation.service machine # [ 21.574608] systemd[561]: Stopped Run user-specific NixOS activation. machine # [ 21.576986] systemd[561]: Stopping Run user-specific NixOS activation... machine # [ 21.579327] systemd[561]: Starting Run user-specific NixOS activation... machine # [ 21.612401] systemd[561]: Finished Run user-specific NixOS activation. machine # restarting sysinit-reactivation.target machine # [ 21.617030] systemd[1]: Stopped target Reactivate sysinit units. machine # reloading the following units: dbus-broker.service machine # [ 21.620828] systemd[1]: Stopping Reactivate sysinit units... machine # [ 21.621762] systemd[1]: Reached target Reactivate sysinit units. machine # [ 21.622674] systemd[1]: Reloading D-Bus System Message Bus... machine # [ 21.626684] dbus-broker-launch[440]: Caught SIGHUP, trigger reload. machine # [ 21.631001] dbus-broker-launch[440]: Looking up NSS user entry for 'systemd-timesync'... machine # [ 21.633305] dbus-broker-launch[440]: NSS returned no entry for 'systemd-timesync' machine # [ 21.634401] dbus-broker-launch[440]: Invalid user-name in /nix/store/4wwlicycgp0fjbv9vh5f4m0xw5da8ac9-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" machine # [ 21.649309] systemd[1]: Reloaded D-Bus System Message Bus. machine # restarting the following units: network-addresses-eth1.service machine # [ 21.657688] systemd[1]: Stopping Address configuration of eth1... machine # [ 21.691295] network-addresses-eth1-pre-stop[1066]: deleting address 192.168.1.1/24... done machine # [ 21.697513] network-addresses-eth1-pre-stop[1066]: deleting address 2001:db8:1::1/64... done machine # [ 21.704337] systemd[1]: network-addresses-eth1.service: Deactivated successfully. machine # [ 21.706889] systemd[1]: Stopped Address configuration of eth1. machine # [ 21.711308] systemd[1]: Starting Address configuration of eth1... machine # [ 21.753516] network-addresses-eth1-start[1071]: adding address 192.168.1.2/24... done machine # [ 21.760414] network-addresses-eth1-start[1071]: adding address 2001:db8:1::2/64... done machine # [ 21.769960] systemd[1]: Finished Address configuration of eth1. machine # [ 21.775188] systemd[1]: Reached target Local File Systems. machine # [ 21.778673] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 21.782615] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 21.783542] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 21.792726] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 21.795125] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 21.803625] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 21.807382] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 21.808811] systemd[1]: Reached target Remote File Systems. machine # [ 21.809632] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 21.811047] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 21.987172] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 21.992485] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 21.994939] systemd[1]: Starting linger-users.service... machine # [ 22.026529] linger-users-start[1143]: id: ‘usertest’: no such user machine # [ 22.028621] linger-users-start[1141]: Removing linger for missing user usertest machine # [ 22.035092] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 22.038349] systemd[1]: Finished linger-users.service. machine # [ 22.292461] nixos[982]: finished switching to system configuration /nix/store/c014jg844hqw9kdghvk21k5i9sv26551-nixos-system-other-test machine: (finished: must succeed: /nix/store/glw2b718093b6m9v90xl0blwv4z9hk4p-stderr-runner /nix/store/c014jg844hqw9kdghvk21k5i9sv26551-nixos-system-other-test/bin/switch-to-configuration test, in 2.01 seconds) subtest: services machine: must succeed: /nix/store/b2rywx23jb5nhi7b4xfic9vflyz9nzq1-nixos-system-machine-test/bin/switch-to-configuration test 2>&1 machine # [ 22.501470] nixos[1149]: switching to system configuration /nix/store/b2rywx23jb5nhi7b4xfic9vflyz9nzq1-nixos-system-machine-test machine # [ 22.503975] systemd[1]: Stopped target Remote File Systems. machine # [ 22.505941] systemd[1]: Stopped target Local File Systems. machine # [ 22.771913] systemd[1]: Reload requested from client PID 1149 ('.switch-to-conf') (unit backdoor.service)... machine # [ 22.774108] systemd[1]: Reloading... machine # [ 23.081600] systemd[1]: Reloading finished in 305 ms. machine # [ 23.161717] systemd[561]: Reexecution requested from client PID 1218 ('switch-to-confi')... machine # [ 23.165847] systemd[561]: Reexecuting. machine # [ 23.211316] systemd[561]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 23.321337] systemd[561]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 23.328700] systemd[561]: Reload requested from client PID 1218 ('switch-to-confi')... machine # [ 23.330049] systemd[561]: Reloading... machine # [ 23.436081] systemd[561]: Reloading finished in 104 ms. machine # [ 23.452181] systemd[561]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 23.461631] systemd[561]: Stopped Run user-specific NixOS activation. machine # [ 23.464357] systemd[561]: Stopping Run user-specific NixOS activation... machine # [ 23.466465] systemd[561]: Starting Run user-specific NixOS activation... machine # [ 23.499971] systemd[561]: Finished Run user-specific NixOS activation. machine # [ 23.503920] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 23.505670] systemd[1]: Stopping Reactivate sysinit units... machine # [ 23.506577] systemd[1]: Reached target Reactivate sysinit units. machine # [ 23.509488] systemd[1]: Reloading D-Bus System Message Bus... machine # [ 23.510735] dbus-broker-launch[440]: Caught SIGHUP, trigger reload. machine # [ 23.516053] dbus-broker-launch[440]: Looking up NSS user entry for 'systemd-timesync'... machine # [ 23.518207] dbus-broker-launch[440]: NSS returned no entry for 'systemd-timesync' machine # [ 23.519293] dbus-broker-launch[440]: Invalid user-name in /nix/store/svs250hlinpmmh842v5vq65hzwi7rbkc-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" machine # [ 23.544450] systemd[1]: Reloaded D-Bus System Message Bus. machine # [ 23.550443] systemd[1]: Stopping Address configuration of eth1... machine # [ 23.582029] network-addresses-eth1-pre-stop[1230]: deleting address 192.168.1.2/24... done machine # [ 23.589580] network-addresses-eth1-pre-stop[1230]: deleting address 2001:db8:1::2/64... done machine # [ 23.596320] systemd[1]: network-addresses-eth1.service: Deactivated successfully. machine # [ 23.600260] systemd[1]: Stopped Address configuration of eth1. machine # [ 23.603028] systemd[1]: Starting Address configuration of eth1... machine # [ 23.644647] network-addresses-eth1-start[1235]: adding address 192.168.1.1/24... done machine # [ 23.651375] network-addresses-eth1-start[1235]: adding address 2001:db8:1::1/64... done machine # [ 23.660496] systemd[1]: Finished Address configuration of eth1. machine # [ 23.667711] systemd[1]: Reached target Local File Systems. machine # [ 23.672335] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 23.673923] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 23.674773] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 23.690040] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 23.692786] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 23.695349] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 23.696794] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 23.698049] systemd[1]: Reached target Remote File Systems. machine # [ 23.698983] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 23.701443] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 23.886268] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 23.889303] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 23.893755] systemd[1]: Starting linger-users.service... machine # [ 23.926430] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 23.929073] systemd[1]: Finished linger-users.service. machine # [ 24.185650] nixos[1149]: finished switching to system configuration /nix/store/b2rywx23jb5nhi7b4xfic9vflyz9nzq1-nixos-system-machine-test machine: (finished: must succeed: /nix/store/b2rywx23jb5nhi7b4xfic9vflyz9nzq1-nixos-system-machine-test/bin/switch-to-configuration test 2>&1, in 1.89 seconds) machine: must succeed: /nix/store/b2rywx23jb5nhi7b4xfic9vflyz9nzq1-nixos-system-machine-test/bin/switch-to-configuration test 2>&1 machine # [ 24.391873] nixos[1305]: switching to system configuration /nix/store/b2rywx23jb5nhi7b4xfic9vflyz9nzq1-nixos-system-machine-test machine # [ 24.395104] systemd[1]: Stopped target Remote File Systems. machine # [ 24.398079] systemd[1]: Stopped target Local File Systems. machine # [ 24.660611] systemd[1]: Reload requested from client PID 1305 ('.switch-to-conf') (unit backdoor.service)... machine # [ 24.662757] systemd[1]: Reloading... machine # [ 24.976665] systemd[1]: Reloading finished in 312 ms. machine # [ 25.060222] systemd[561]: Reexecution requested from client PID 1374 ('switch-to-confi')... machine # [ 25.064597] systemd[561]: Reexecuting. machine # [ 25.123731] systemd[561]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 25.236429] systemd[561]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 25.243126] systemd[561]: Reload requested from client PID 1374 ('switch-to-confi')... machine # [ 25.245544] systemd[561]: Reloading... machine # [ 25.352779] systemd[561]: Reloading finished in 106 ms. machine # [ 25.368182] systemd[561]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 25.377609] systemd[561]: Stopped Run user-specific NixOS activation. machine # [ 25.380065] systemd[561]: Stopping Run user-specific NixOS activation... machine # [ 25.382318] systemd[561]: Starting Run user-specific NixOS activation... machine # [ 25.416105] systemd[561]: Finished Run user-specific NixOS activation. machine # [ 25.420708] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 25.422045] systemd[1]: Stopping Reactivate sysinit units... machine # [ 25.423004] systemd[1]: Reached target Reactivate sysinit units. machine # [ 25.430473] systemd[1]: Reached target Remote File Systems. machine # [ 25.433008] systemd[1]: Reached target Local File Systems. machine # [ 25.435884] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 25.440826] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 25.442218] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 25.447636] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 25.450112] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 25.451405] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 25.454517] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 25.460191] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 25.461553] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 25.621083] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 25.623674] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 25.628952] systemd[1]: Starting linger-users.service... machine # [ 25.670323] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 25.672326] systemd[1]: Finished linger-users.service. machine # [ 25.928771] nixos[1305]: finished switching to system configuration /nix/store/b2rywx23jb5nhi7b4xfic9vflyz9nzq1-nixos-system-machine-test machine: (finished: must succeed: /nix/store/b2rywx23jb5nhi7b4xfic9vflyz9nzq1-nixos-system-machine-test/bin/switch-to-configuration test 2>&1, in 1.74 seconds) machine: must succeed: /nix/store/b2rywx23jb5nhi7b4xfic9vflyz9nzq1-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration test 2>&1 machine # [ 26.156941] nixos[1445]: switching to system configuration /nix/store/0pj9ps1n8jw61160y9ndhpskhhcz4zgc-nixos-system-machine-test machine # [ 26.159664] systemd[1]: Stopped target Local File Systems. machine # [ 26.162549] systemd[1]: Stopped target Remote File Systems. machine # [ 26.438300] systemd[1]: Reload requested from client PID 1445 ('.switch-to-conf') (unit backdoor.service)... machine # [ 26.440431] systemd[1]: Reloading... machine # [ 26.761570] systemd[1]: Reloading finished in 318 ms. machine # [ 26.846732] systemd[561]: Reexecution requested from client PID 1514 ('switch-to-confi')... machine # [ 26.849371] systemd[561]: Reexecuting. machine # [ 26.907278] systemd[561]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 27.019310] systemd[561]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 27.026300] systemd[561]: Reload requested from client PID 1514 ('switch-to-confi')... machine # [ 27.027670] systemd[561]: Reloading... machine # [ 27.171920] systemd[561]: Reloading finished in 142 ms. machine # [ 27.192178] systemd[561]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 27.201587] systemd[561]: Stopped Run user-specific NixOS activation. machine # [ 27.204058] systemd[561]: Stopping Run user-specific NixOS activation... machine # [ 27.206399] systemd[561]: Starting Run user-specific NixOS activation... machine # [ 27.239717] systemd[561]: Finished Run user-specific NixOS activation. machine # [ 27.243840] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 27.245374] systemd[1]: Stopping Reactivate sysinit units... machine # [ 27.246346] systemd[1]: Reached target Reactivate sysinit units. machine # [ 27.248877] systemd[1]: Reached target Remote File Systems. machine # [ 27.254845] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 27.260513] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 27.264267] systemd[1]: Starting linger-users.service... machine # [ 27.267967] systemd[1]: Starting test.service... machine # [ 27.282954] systemd[1]: Reached target Local File Systems. machine # [ 27.283912] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 27.292295] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 27.293245] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 27.294536] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 27.306458] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 27.309602] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 27.316158] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 27.339333] systemd[1]: Finished test.service. machine # [ 27.372986] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 27.375984] systemd[1]: Finished linger-users.service. machine # [ 27.499265] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 27.502431] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 27.758909] nixos[1445]: finished switching to system configuration /nix/store/0pj9ps1n8jw61160y9ndhpskhhcz4zgc-nixos-system-machine-test machine: (finished: must succeed: /nix/store/b2rywx23jb5nhi7b4xfic9vflyz9nzq1-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration test 2>&1, in 1.83 seconds) machine: must succeed: /nix/store/b2rywx23jb5nhi7b4xfic9vflyz9nzq1-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration test 2>&1 machine # [ 27.967765] nixos[1588]: switching to system configuration /nix/store/0pj9ps1n8jw61160y9ndhpskhhcz4zgc-nixos-system-machine-test machine # [ 27.970455] systemd[1]: Stopped target Local File Systems. machine # [ 27.973397] systemd[1]: Stopped target Remote File Systems. machine # [ 28.229132] systemd[1]: Reload requested from client PID 1588 ('.switch-to-conf') (unit backdoor.service)... machine # [ 28.231114] systemd[1]: Reloading... machine # [ 28.538273] systemd[1]: Reloading finished in 305 ms. machine # [ 28.624853] systemd[561]: Reexecution requested from client PID 1657 ('switch-to-confi')... machine # [ 28.629912] systemd[561]: Reexecuting. machine # [ 28.683877] systemd[561]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 28.795042] systemd[561]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 28.801612] systemd[561]: Reload requested from client PID 1657 ('switch-to-confi')... machine # [ 28.805148] systemd[561]: Reloading... machine # [ 28.908542] systemd[561]: Reloading finished in 104 ms. machine # [ 28.924168] systemd[561]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 28.934541] systemd[561]: Stopped Run user-specific NixOS activation. machine # [ 28.935597] systemd[561]: Stopping Run user-specific NixOS activation... machine # [ 28.940244] systemd[561]: Starting Run user-specific NixOS activation... machine # [ 28.970763] systemd[561]: Finished Run user-specific NixOS activation. machine # [ 28.974662] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 28.977148] systemd[1]: Stopping Reactivate sysinit units... machine # [ 28.978105] systemd[1]: Reached target Reactivate sysinit units. machine # [ 28.982584] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 28.983984] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 28.988728] systemd[1]: Reached target Local File Systems. machine # [ 28.992370] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 28.996367] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 29.004425] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 29.005719] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 29.011960] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 29.014468] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 29.015811] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 29.019650] systemd[1]: Reached target Remote File Systems. machine # [ 29.162939] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 29.164878] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 29.169734] systemd[1]: Starting linger-users.service... machine # [ 29.207583] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 29.209669] systemd[1]: Finished linger-users.service. machine # [ 29.465723] nixos[1588]: finished switching to system configuration /nix/store/0pj9ps1n8jw61160y9ndhpskhhcz4zgc-nixos-system-machine-test machine: (finished: must succeed: /nix/store/b2rywx23jb5nhi7b4xfic9vflyz9nzq1-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration test 2>&1, in 1.71 seconds) machine: must succeed: /nix/store/b2rywx23jb5nhi7b4xfic9vflyz9nzq1-nixos-system-machine-test/specialisation/simpleServiceDifferentDescription/bin/switch-to-configuration test 2>&1 machine # [ 29.675312] nixos[1728]: switching to system configuration /nix/store/cp7hkdkjh1mra1yf05j6hz9f2r25rxcg-nixos-system-machine-test machine # [ 29.678391] systemd[1]: Stopped target Remote File Systems. machine # [ 29.680890] systemd[1]: Stopped target Local File Systems. machine # [ 29.955018] systemd[1]: Reload requested from client PID 1728 ('.switch-to-conf') (unit backdoor.service)... machine # [ 29.957283] systemd[1]: Reloading... machine # [ 30.319339] systemd[1]: Reloading finished in 361 ms. machine # [ 30.408793] systemd[561]: Reexecution requested from client PID 1797 ('switch-to-confi')... machine # [ 30.411829] systemd[561]: Reexecuting. machine # [ 30.488282] systemd[561]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 30.602076] systemd[561]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 30.609824] systemd[561]: Reload requested from client PID 1797 ('switch-to-confi')... machine # [ 30.611257] systemd[561]: Reloading... machine # [ 30.717321] systemd[561]: Reloading finished in 104 ms. machine # [ 30.732177] systemd[561]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 30.741353] systemd[561]: Stopped Run user-specific NixOS activation. machine # [ 30.743719] systemd[561]: Stopping Run user-specific NixOS activation... machine # [ 30.745858] systemd[561]: Starting Run user-specific NixOS activation... machine # [ 30.780574] systemd[561]: Finished Run user-specific NixOS activation. machine # [ 30.785519] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 30.786581] systemd[1]: Stopping Reactivate sysinit units... machine # [ 30.790645] systemd[1]: Reached target Reactivate sysinit units. machine # [ 30.793365] systemd[1]: Reached target Local File Systems. machine # [ 30.797008] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 30.803076] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 30.806692] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 30.813213] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 30.815794] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 30.825374] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 30.826877] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 30.830014] systemd[1]: Reached target Remote File Systems. machine # [ 30.831030] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 30.832704] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 31.004330] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 31.008811] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 31.012566] systemd[1]: Starting linger-users.service... machine # [ 31.055183] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 31.058320] systemd[1]: Finished linger-users.service. machine # [ 31.313938] nixos[1728]: finished switching to system configuration /nix/store/cp7hkdkjh1mra1yf05j6hz9f2r25rxcg-nixos-system-machine-test machine: (finished: must succeed: /nix/store/b2rywx23jb5nhi7b4xfic9vflyz9nzq1-nixos-system-machine-test/specialisation/simpleServiceDifferentDescription/bin/switch-to-configuration test 2>&1, in 1.85 seconds) machine: must succeed: /nix/store/b2rywx23jb5nhi7b4xfic9vflyz9nzq1-nixos-system-machine-test/specialisation/simpleServiceModified/bin/switch-to-configuration test 2>&1 machine # [ 31.546202] nixos[1869]: switching to system configuration /nix/store/c6klgcmrsjl91j377s21xhy18cffcs8d-nixos-system-machine-test machine # [ 31.548880] systemd[1]: Stopped target Local File Systems. machine # [ 31.552594] systemd[1]: Stopped target Remote File Systems. machine # [ 31.553535] systemd[1]: test.service: Deactivated successfully. machine # [ 31.554438] systemd[1]: Stopped Test unit. machine # [ 31.830393] systemd[1]: Reload requested from client PID 1869 ('.switch-to-conf') (unit backdoor.service)... machine # [ 31.832411] systemd[1]: Reloading... machine # [ 32.156077] systemd[1]: Reloading finished in 322 ms. machine # [ 32.240405] systemd[561]: Reexecution requested from client PID 1938 ('switch-to-confi')... machine # [ 32.243628] systemd[561]: Reexecuting. machine # [ 32.299263] systemd[561]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 32.410488] systemd[561]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 32.417017] systemd[561]: Reload requested from client PID 1938 ('switch-to-confi')... machine # [ 32.421007] systemd[561]: Reloading... machine # [ 32.528067] systemd[561]: Reloading finished in 108 ms. machine # [ 32.544186] systemd[561]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 32.553785] systemd[561]: Stopped Run user-specific NixOS activation. machine # [ 32.556122] systemd[561]: Stopping Run user-specific NixOS activation... machine # [ 32.558635] systemd[561]: Starting Run user-specific NixOS activation... machine # [ 32.592100] systemd[561]: Finished Run user-specific NixOS activation. machine # [ 32.595808] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 32.598677] systemd[1]: Stopping Reactivate sysinit units... machine # [ 32.599556] systemd[1]: Reached target Reactivate sysinit units. machine # [ 32.602222] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 32.603600] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 32.605877] systemd[1]: Reached target Local File Systems. machine # [ 32.610720] systemd[1]: Starting test.service... machine # [ 32.620627] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 32.628335] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 32.629284] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 32.630579] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 32.644645] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 32.646469] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 32.655981] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 32.661436] systemd[1]: Reached target Remote File Systems. machine # [ 32.673295] systemd[1]: Finished test.service. machine # [ 32.808307] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 32.812371] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 32.815627] systemd[1]: Starting linger-users.service... machine # [ 32.857352] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 32.860646] systemd[1]: Finished linger-users.service. machine # [ 33.114730] nixos[1869]: finished switching to system configuration /nix/store/c6klgcmrsjl91j377s21xhy18cffcs8d-nixos-system-machine-test machine: (finished: must succeed: /nix/store/b2rywx23jb5nhi7b4xfic9vflyz9nzq1-nixos-system-machine-test/specialisation/simpleServiceModified/bin/switch-to-configuration test 2>&1, in 1.80 seconds) machine: must succeed: /nix/store/b2rywx23jb5nhi7b4xfic9vflyz9nzq1-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1 machine # [ 33.335482] nixos[2011]: switching to system configuration /nix/store/575y7wkacypk0xlzf3dhxi8hq8nziqi0-nixos-system-machine-test machine # [ 33.338366] systemd[1]: Stopped target Remote File Systems. machine # [ 33.340793] systemd[1]: Stopped target Local File Systems. machine # [ 33.608847] systemd[1]: Reload requested from client PID 2011 ('.switch-to-conf') (unit backdoor.service)... machine # [ 33.611146] systemd[1]: Reloading... machine # [ 33.933486] systemd[1]: Reloading finished in 320 ms. machine # [ 34.052608] systemd[561]: Reexecution requested from client PID 2080 ('switch-to-confi')... machine # [ 34.055119] systemd[561]: Reexecuting. machine # [ 34.111630] systemd[561]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 34.221703] systemd[561]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 34.229143] systemd[561]: Reload requested from client PID 2080 ('switch-to-confi')... machine # [ 34.230540] systemd[561]: Reloading... machine # [ 34.336397] systemd[561]: Reloading finished in 104 ms. machine # [ 34.352160] systemd[561]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 34.362032] systemd[561]: Stopped Run user-specific NixOS activation. machine # [ 34.364327] systemd[561]: Stopping Run user-specific NixOS activation... machine # [ 34.366490] systemd[561]: Starting Run user-specific NixOS activation... machine # [ 34.394646] systemd[561]: Finished Run user-specific NixOS activation. machine # [ 34.398471] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 34.400776] systemd[1]: Stopping Reactivate sysinit units... machine # [ 34.401654] systemd[1]: Reached target Reactivate sysinit units. machine # [ 34.404431] systemd[1]: test.service: Deactivated successfully. machine # [ 34.405344] systemd[1]: Stopped test.service. machine # [ 34.405996] systemd[1]: Stopping test.service... machine # [ 34.409079] systemd[1]: Starting test.service... machine # [ 34.431972] systemd[1]: Finished test.service. machine # [ 34.437060] systemd[1]: Reached target Remote File Systems. machine # [ 34.439145] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 34.442619] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 34.445939] systemd[1]: Reached target Local File Systems. machine # [ 34.450795] systemd[1]: Starting linger-users.service... machine # [ 34.455344] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 34.459603] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 34.465940] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 34.467275] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 34.475295] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 34.479770] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 34.483541] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 34.531366] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 34.535829] systemd[1]: Finished linger-users.service. machine # [ 34.659108] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 34.662219] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 34.917739] nixos[2011]: finished switching to system configuration /nix/store/575y7wkacypk0xlzf3dhxi8hq8nziqi0-nixos-system-machine-test machine: (finished: must succeed: /nix/store/b2rywx23jb5nhi7b4xfic9vflyz9nzq1-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1, in 1.80 seconds) machine: must succeed: /nix/store/b2rywx23jb5nhi7b4xfic9vflyz9nzq1-nixos-system-machine-test/specialisation/simpleServiceReload/bin/switch-to-configuration test 2>&1 machine # [ 35.135106] nixos[2154]: switching to system configuration /nix/store/p0083y97jq7ab78y7kkfj82f11ipxl2s-nixos-system-machine-test machine # [ 35.138334] systemd[1]: Stopped target Remote File Systems. machine # [ 35.140720] systemd[1]: Stopped target Local File Systems. machine # [ 35.405652] systemd[1]: Reload requested from client PID 2154 ('.switch-to-conf') (unit backdoor.service)... machine # [ 35.407905] systemd[1]: Reloading... machine # [ 35.713684] systemd[1]: Reloading finished in 303 ms. machine # [ 35.799029] systemd[561]: Reexecution requested from client PID 2223 ('switch-to-confi')... machine # [ 35.801435] systemd[561]: Reexecuting. machine # [ 35.855344] systemd[561]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 35.965005] systemd[561]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 35.971623] systemd[561]: Reload requested from client PID 2223 ('switch-to-confi')... machine # [ 35.975100] systemd[561]: Reloading... machine # [ 36.078189] systemd[561]: Reloading finished in 104 ms. machine # [ 36.096164] systemd[561]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 36.104759] systemd[561]: Stopped Run user-specific NixOS activation. machine # [ 36.106968] systemd[561]: Stopping Run user-specific NixOS activation... machine # [ 36.109106] systemd[561]: Starting Run user-specific NixOS activation... machine # [ 36.138171] systemd[561]: Finished Run user-specific NixOS activation. machine # [ 36.142153] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 36.147344] systemd[1]: Stopping Reactivate sysinit units... machine # [ 36.152191] systemd[1]: Reached target Reactivate sysinit units. machine # [ 36.153137] systemd[1]: Reloading test.service... machine # [ 36.171897] systemd[1]: Reloaded test.service. machine # [ 36.175696] systemd[1]: Reached target Remote File Systems. machine # [ 36.181023] systemd[1]: Starting linger-users.service... machine # [ 36.190456] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 36.191876] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 36.197599] systemd[1]: Reached target Local File Systems. machine # [ 36.198470] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 36.204985] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 36.205894] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 36.207182] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 36.219638] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 36.223878] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 36.226984] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 36.267878] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 36.272238] systemd[1]: Finished linger-users.service. machine # [ 36.399848] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 36.402944] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 36.658849] nixos[2154]: finished switching to system configuration /nix/store/p0083y97jq7ab78y7kkfj82f11ipxl2s-nixos-system-machine-test machine: (finished: must succeed: /nix/store/b2rywx23jb5nhi7b4xfic9vflyz9nzq1-nixos-system-machine-test/specialisation/simpleServiceReload/bin/switch-to-configuration test 2>&1, in 1.74 seconds) machine: must succeed: /nix/store/b2rywx23jb5nhi7b4xfic9vflyz9nzq1-nixos-system-machine-test/specialisation/simpleServiceNorestart/bin/switch-to-configuration test 2>&1 machine # [ 36.882720] nixos[2296]: switching to system configuration /nix/store/wgawr0ylgrwhwgg9kgngzf3x28l7rjv4-nixos-system-machine-test machine # [ 36.886194] systemd[1]: Stopped target Local File Systems. machine # [ 36.887954] systemd[1]: Stopped target Remote File Systems. machine # [ 37.213748] systemd[1]: Reload requested from client PID 2296 ('.switch-to-conf') (unit backdoor.service)... machine # [ 37.215839] systemd[1]: Reloading... machine # [ 37.532064] systemd[1]: Reloading finished in 314 ms. machine # [ 37.623862] systemd[561]: Reexecution requested from client PID 2366 ('switch-to-confi')... machine # [ 37.626724] systemd[561]: Reexecuting. machine # [ 37.683621] systemd[561]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 37.797798] systemd[561]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 37.804081] systemd[561]: Reload requested from client PID 2366 ('switch-to-confi')... machine # [ 37.806310] systemd[561]: Reloading... machine # [ 37.913254] systemd[561]: Reloading finished in 105 ms. machine # [ 37.928170] systemd[561]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 37.938352] systemd[561]: Stopped Run user-specific NixOS activation. machine # [ 37.940791] systemd[561]: Stopping Run user-specific NixOS activation... machine # [ 37.943049] systemd[561]: Starting Run user-specific NixOS activation... machine # [ 37.975584] systemd[561]: Finished Run user-specific NixOS activation. machine # [ 37.979511] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 37.981298] systemd[1]: Stopping Reactivate sysinit units... machine # [ 37.982250] systemd[1]: Reached target Reactivate sysinit units. machine # [ 37.984941] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 37.986339] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 37.989559] systemd[1]: Reached target Local File Systems. machine # [ 37.992086] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 37.998099] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 37.999050] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 38.008373] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 38.010686] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 38.015582] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 38.019350] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 38.021874] systemd[1]: Reached target Remote File Systems. machine # [ 38.171819] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 38.174999] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 38.179445] systemd[1]: Starting linger-users.service... machine # [ 38.219615] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 38.222251] systemd[1]: Finished linger-users.service. machine # [ 38.477458] nixos[2296]: finished switching to system configuration /nix/store/wgawr0ylgrwhwgg9kgngzf3x28l7rjv4-nixos-system-machine-test machine: (finished: must succeed: /nix/store/b2rywx23jb5nhi7b4xfic9vflyz9nzq1-nixos-system-machine-test/specialisation/simpleServiceNorestart/bin/switch-to-configuration test 2>&1, in 1.82 seconds) machine: must succeed: /nix/store/b2rywx23jb5nhi7b4xfic9vflyz9nzq1-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration dry-activate 2>&1 machine: (finished: must succeed: /nix/store/b2rywx23jb5nhi7b4xfic9vflyz9nzq1-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration dry-activate 2>&1, in 0.28 seconds) machine: must succeed: /nix/store/b2rywx23jb5nhi7b4xfic9vflyz9nzq1-nixos-system-machine-test/bin/switch-to-configuration test 2>&1 machine # [ 38.939044] nixos[2447]: switching to system configuration /nix/store/b2rywx23jb5nhi7b4xfic9vflyz9nzq1-nixos-system-machine-test machine # [ 38.941726] systemd[1]: test.service: Deactivated successfully. machine # [ 38.945683] systemd[1]: Stopped test.service. machine # [ 38.946513] systemd[1]: Stopped target Remote File Systems. machine # [ 38.947336] systemd[1]: Stopped target Local File Systems. machine # [ 39.200562] systemd[1]: Reload requested from client PID 2447 ('.switch-to-conf') (unit backdoor.service)... machine # [ 39.202576] systemd[1]: Reloading... machine # [ 39.512268] systemd[1]: Reloading finished in 307 ms. machine # [ 39.594633] systemd[561]: Reexecution requested from client PID 2516 ('switch-to-confi')... machine # [ 39.598905] systemd[561]: Reexecuting. machine # [ 39.655411] systemd[561]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 39.769288] systemd[561]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 39.776734] systemd[561]: Reload requested from client PID 2516 ('switch-to-confi')... machine # [ 39.780072] systemd[561]: Reloading... machine # [ 39.886184] systemd[561]: Reloading finished in 105 ms. machine # [ 39.900173] systemd[561]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 39.910492] systemd[561]: Stopped Run user-specific NixOS activation. machine # [ 39.912902] systemd[561]: Stopping Run user-specific NixOS activation... machine # [ 39.915090] systemd[561]: Starting Run user-specific NixOS activation... machine # [ 39.947973] systemd[561]: Finished Run user-specific NixOS activation. machine # [ 39.952174] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 39.954629] systemd[1]: Stopping Reactivate sysinit units... machine # [ 39.955557] systemd[1]: Reached target Reactivate sysinit units. machine # [ 39.958453] systemd[1]: Reached target Remote File Systems. machine # [ 39.962745] systemd[1]: Starting linger-users.service... machine # [ 39.968677] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 39.970192] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 39.980145] systemd[1]: Reached target Local File Systems. machine # [ 39.984438] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 39.987931] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 39.996411] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 39.997786] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 40.003966] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 40.010817] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 40.016239] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 40.055264] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 40.060531] systemd[1]: Finished linger-users.service. machine # [ 40.183421] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 40.186970] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 40.440653] nixos[2447]: finished switching to system configuration /nix/store/b2rywx23jb5nhi7b4xfic9vflyz9nzq1-nixos-system-machine-test machine: (finished: must succeed: /nix/store/b2rywx23jb5nhi7b4xfic9vflyz9nzq1-nixos-system-machine-test/bin/switch-to-configuration test 2>&1, in 1.69 seconds) machine: must succeed: /nix/store/b9wbq4r35p5dp0hgqxwx3rc8vn8yqcq9-separate-activation-script/bin/switch-to-configuration test 2>&1 machine # [ 40.666605] nixos[2587]: switching to system configuration /nix/store/rlb4xrk186wk9f7bvhzmhc4hcfvwsk1g-nixos-system-machine-test machine # [ 40.669301] systemd[1]: Stopped target Local File Systems. machine # [ 40.671841] systemd[1]: Stopped target Remote File Systems. machine # [ 40.937421] systemd[1]: Reload requested from client PID 2587 ('.switch-to-conf') (unit backdoor.service)... machine # [ 40.939701] systemd[1]: Reloading... machine # [ 41.245282] systemd[1]: Reloading finished in 303 ms. machine # [ 41.329934] systemd[561]: Stopped Run user-specific NixOS activation. machine # [ 41.333596] systemd[561]: Reexecution requested from client PID 2657 ('switch-to-confi')... machine # [ 41.335126] systemd[561]: Reexecuting. machine # [ 41.395377] systemd[561]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 41.511366] systemd[561]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 41.518112] systemd[561]: Reload requested from client PID 2657 ('switch-to-confi')... machine # [ 41.520551] systemd[561]: Reloading... machine # [ 41.623021] systemd[561]: Reloading finished in 101 ms. machine # [ 41.640185] systemd[561]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 41.650801] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 41.653604] systemd[1]: Stopping Reactivate sysinit units... machine # [ 41.654594] systemd[1]: Reached target Reactivate sysinit units. machine # [ 41.658092] systemd[1]: Reached target Local File Systems. machine # [ 41.659028] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 41.668283] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 41.669521] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 41.670922] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 41.676789] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 41.678583] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 41.679867] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 41.687885] systemd[1]: Reached target Remote File Systems. machine # [ 41.689299] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 41.691198] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 41.835773] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 41.840547] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 41.843757] systemd[1]: Starting linger-users.service... machine # [ 41.846987] systemd[1]: Starting test.service... machine # [ 41.882125] systemd[1]: Finished test.service. machine # [ 41.899319] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 41.902478] systemd[1]: Finished linger-users.service. machine # [ 42.158779] nixos[2587]: finished switching to system configuration /nix/store/rlb4xrk186wk9f7bvhzmhc4hcfvwsk1g-nixos-system-machine-test machine: (finished: must succeed: /nix/store/b9wbq4r35p5dp0hgqxwx3rc8vn8yqcq9-separate-activation-script/bin/switch-to-configuration test 2>&1, in 1.71 seconds) machine: must succeed: ! test -e /run/current-system/activate machine: (finished: must succeed: ! test -e /run/current-system/activate, in 0.02 seconds) machine: must succeed: ! test -e /run/current-system/dry-activate machine: (finished: must succeed: ! test -e /run/current-system/dry-activate, in 0.02 seconds) machine: must succeed: ! test -e /run/current-system/bin/switch-to-configuration machine: (finished: must succeed: ! test -e /run/current-system/bin/switch-to-configuration, in 0.02 seconds) machine: must succeed: /nix/store/b2rywx23jb5nhi7b4xfic9vflyz9nzq1-nixos-system-machine-test/specialisation/unitWithMultilineValue/bin/switch-to-configuration test 2>&1 machine # [ 42.413857] nixos[2736]: switching to system configuration /nix/store/9qxm5n3f1bm4b6yg6rbw1ji1fq8gyazj-nixos-system-machine-test machine # [ 42.416445] systemd[1]: Stopped target Remote File Systems. machine # [ 42.419101] systemd[1]: test.service: Deactivated successfully. machine # [ 42.421504] systemd[1]: Stopped test.service. machine # [ 42.422278] systemd[1]: Stopped target Local File Systems. machine # [ 42.686656] systemd[1]: Reload requested from client PID 2736 ('.switch-to-conf') (unit backdoor.service)... machine # [ 42.688843] systemd[1]: Reloading... machine # [ 42.995153] systemd[1]: Reloading finished in 305 ms. machine # [ 43.080387] systemd[561]: Reexecution requested from client PID 2805 ('switch-to-confi')... machine # [ 43.084451] systemd[561]: Reexecuting. machine # [ 43.139465] systemd[561]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 43.251570] systemd[561]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 43.258865] systemd[561]: Reload requested from client PID 2805 ('switch-to-confi')... machine # [ 43.261880] systemd[561]: Reloading... machine # [ 43.363465] systemd[561]: Reloading finished in 102 ms. machine # [ 43.380161] systemd[561]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 43.390547] systemd[561]: Starting Run user-specific NixOS activation... machine # [ 43.422522] systemd[561]: Finished Run user-specific NixOS activation. machine # [ 43.427010] systemd[561]: Stopped Run user-specific NixOS activation. machine # [ 43.432270] systemd[561]: Stopping Run user-specific NixOS activation... machine # [ 43.433308] systemd[561]: Starting Run user-specific NixOS activation... machine # [ 43.437362] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 43.438401] systemd[1]: Stopping Reactivate sysinit units... machine # [ 43.439209] systemd[1]: Reached target Reactivate sysinit units. machine # [ 43.443771] systemd[1]: Reached target Local File Systems. machine # [ 43.447951] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 43.452693] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 43.453727] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 43.455075] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 43.469262] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 43.471019] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 43.481655] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 43.483022] systemd[1]: Reached target Remote File Systems. machine # [ 43.502977] systemd[561]: Finished Run user-specific NixOS activation. machine # [ 43.507217] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 43.511203] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 43.650954] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 43.653475] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 43.658904] systemd[1]: Starting linger-users.service... machine # [ 43.662709] systemd[1]: Started test.service. machine # [ 43.699076] systemd[1]: test.service: Deactivated successfully. machine # [ 43.717528] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 43.720558] systemd[1]: Finished linger-users.service. machine # [ 43.974432] nixos[2736]: finished switching to system configuration /nix/store/9qxm5n3f1bm4b6yg6rbw1ji1fq8gyazj-nixos-system-machine-test machine: (finished: must succeed: /nix/store/b2rywx23jb5nhi7b4xfic9vflyz9nzq1-nixos-system-machine-test/specialisation/unitWithMultilineValue/bin/switch-to-configuration test 2>&1, in 1.76 seconds) machine: must succeed: /nix/store/b2rywx23jb5nhi7b4xfic9vflyz9nzq1-nixos-system-machine-test/specialisation/unitWithBackslash/bin/switch-to-configuration test 2>&1 machine # [ 44.198262] nixos[2882]: switching to system configuration /nix/store/f80xziqrf0s32dyn2z4ylpjzrhfhz9w9-nixos-system-machine-test machine # [ 44.201401] systemd[1]: Stopped target Local File Systems. machine # [ 44.202872] systemd[1]: Stopped target Remote File Systems. machine # [ 44.479749] systemd[1]: Reload requested from client PID 2882 ('.switch-to-conf') (unit backdoor.service)... machine # [ 44.482095] systemd[1]: Reloading... machine # [ 44.799309] systemd[1]: Reloading finished in 315 ms. machine # [ 44.886976] systemd[561]: Reexecution requested from client PID 2951 ('switch-to-confi')... machine # [ 44.890921] systemd[561]: Reexecuting. machine # [ 44.947616] systemd[561]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 45.060453] systemd[561]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 45.067438] systemd[561]: Reload requested from client PID 2951 ('switch-to-confi')... machine # [ 45.070774] systemd[561]: Reloading... machine # [ 45.173571] systemd[561]: Reloading finished in 103 ms. machine # [ 45.188161] systemd[561]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 45.197312] systemd[561]: Stopped Run user-specific NixOS activation. machine # [ 45.199799] systemd[561]: Stopping Run user-specific NixOS activation... machine # [ 45.201809] systemd[561]: Starting Run user-specific NixOS activation... machine # [ 45.230645] systemd[561]: Finished Run user-specific NixOS activation. machine # [ 45.234593] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 45.236656] systemd[1]: Stopping Reactivate sysinit units... machine # [ 45.237537] systemd[1]: Reached target Reactivate sysinit units. machine # [ 45.239714] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 45.243330] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 45.248413] systemd[1]: Reached target Remote File Systems. machine # [ 45.251534] systemd[1]: Starting escaped\x2ddash.service... machine # [ 45.255385] systemd[1]: Starting linger-users.service... machine # [ 45.267634] systemd[1]: Reached target Local File Systems. machine # [ 45.269094] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 45.277616] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 45.278612] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 45.279878] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 45.294707] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 45.302657] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 45.310422] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 45.326787] systemd[1]: Finished escaped\x2ddash.service. machine # [ 45.354692] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 45.357069] systemd[1]: Finished linger-users.service. machine # [ 45.482868] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 45.485701] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 45.742402] nixos[2882]: finished switching to system configuration /nix/store/f80xziqrf0s32dyn2z4ylpjzrhfhz9w9-nixos-system-machine-test machine: (finished: must succeed: /nix/store/b2rywx23jb5nhi7b4xfic9vflyz9nzq1-nixos-system-machine-test/specialisation/unitWithBackslash/bin/switch-to-configuration test 2>&1, in 1.77 seconds) machine: must succeed: /nix/store/b2rywx23jb5nhi7b4xfic9vflyz9nzq1-nixos-system-machine-test/specialisation/unitWithBackslashModified/bin/switch-to-configuration test 2>&1 machine # [ 45.958764] nixos[3024]: switching to system configuration /nix/store/ab6z4x1g5v31j7k76wnlci0c6rphnj61-nixos-system-machine-test machine # [ 45.961741] systemd[1]: Stopped target Remote File Systems. machine # [ 45.965034] systemd[1]: Stopped target Local File Systems. machine # [ 45.966008] systemd[1]: escaped\x2ddash.service: Deactivated successfully. machine # [ 45.967007] systemd[1]: Stopped escaped\x2ddash.service. machine # [ 46.258906] systemd[1]: Reload requested from client PID 3024 ('.switch-to-conf') (unit backdoor.service)... machine # [ 46.261379] systemd[1]: Reloading... machine # [ 46.575554] systemd[1]: Reloading finished in 312 ms. machine # [ 46.660420] systemd[561]: Reexecution requested from client PID 3093 ('switch-to-confi')... machine # [ 46.661871] systemd[561]: Reexecuting. machine # [ 46.723458] systemd[561]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 46.839085] systemd[561]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 46.844824] systemd[561]: Reload requested from client PID 3093 ('switch-to-confi')... machine # [ 46.846284] systemd[561]: Reloading... machine # [ 46.952582] systemd[561]: Reloading finished in 105 ms. machine # [ 46.968190] systemd[561]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 46.977728] systemd[561]: Stopped Run user-specific NixOS activation. machine # [ 46.980334] systemd[561]: Stopping Run user-specific NixOS activation... machine # [ 46.982477] systemd[561]: Starting Run user-specific NixOS activation... machine # [ 47.016638] systemd[561]: Finished Run user-specific NixOS activation. machine # [ 47.021087] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 47.023410] systemd[1]: Stopping Reactivate sysinit units... machine # [ 47.026522] systemd[1]: Reached target Reactivate sysinit units. machine # [ 47.031676] systemd[1]: Starting escaped\x2ddash.service... machine # [ 47.036328] systemd[1]: Reached target Remote File Systems. machine # [ 47.043057] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 47.045332] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 47.048464] systemd[1]: Reached target Local File Systems. machine # [ 47.049348] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 47.057481] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 47.058480] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 47.059794] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 47.079143] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 47.081650] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 47.083007] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 47.100154] systemd[1]: Finished escaped\x2ddash.service. machine # [ 47.255875] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 47.259536] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 47.264805] systemd[1]: Starting linger-users.service... machine # [ 47.307710] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 47.310894] systemd[1]: Finished linger-users.service. machine # [ 47.566588] nixos[3024]: finished switching to system configuration /nix/store/ab6z4x1g5v31j7k76wnlci0c6rphnj61-nixos-system-machine-test machine: (finished: must succeed: /nix/store/b2rywx23jb5nhi7b4xfic9vflyz9nzq1-nixos-system-machine-test/specialisation/unitWithBackslashModified/bin/switch-to-configuration test 2>&1, in 1.83 seconds) machine: must succeed: /nix/store/b2rywx23jb5nhi7b4xfic9vflyz9nzq1-nixos-system-machine-test/specialisation/unitStartingWithDash/bin/switch-to-configuration test 2>&1 machine # [ 47.824888] nixos[3166]: switching to system configuration /nix/store/bxs7w1xqfjxwfzqw8fj67f8jjdcmgsfq-nixos-system-machine-test machine # [ 47.827876] systemd[1]: Stopped target Remote File Systems. machine # [ 47.832726] systemd[1]: Stopped target Local File Systems. machine # [ 47.833819] systemd[1]: escaped\x2ddash.service: Deactivated successfully. machine # [ 47.834990] systemd[1]: Stopped escaped\x2ddash.service. machine # [ 48.120716] systemd[1]: Reload requested from client PID 3166 ('.switch-to-conf') (unit backdoor.service)... machine # [ 48.122715] systemd[1]: Reloading... machine # [ 48.449979] systemd[1]: Reloading finished in 325 ms. machine # [ 48.535485] systemd[561]: Reexecution requested from client PID 3235 ('switch-to-confi')... machine # [ 48.539605] systemd[561]: Reexecuting. machine # [ 48.595461] systemd[561]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 48.709056] systemd[561]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 48.716499] systemd[561]: Reload requested from client PID 3235 ('switch-to-confi')... machine # [ 48.717866] systemd[561]: Reloading... machine # [ 48.822801] systemd[561]: Reloading finished in 103 ms. machine # [ 48.840238] systemd[561]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 48.851009] systemd[561]: Stopped Run user-specific NixOS activation. machine # [ 48.853628] systemd[561]: Stopping Run user-specific NixOS activation... machine # [ 48.856401] systemd[561]: Starting Run user-specific NixOS activation... machine # [ 48.889338] systemd[561]: Finished Run user-specific NixOS activation. machine # [ 48.893687] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 48.896981] systemd[1]: Stopping Reactivate sysinit units... machine # [ 48.897967] systemd[1]: Reached target Reactivate sysinit units. machine # [ 48.900585] systemd[1]: Reached target Remote File Systems. machine # [ 48.906134] systemd[1]: Starting -.service... machine # [ 48.910002] systemd[1]: Starting linger-users.service... machine # [ 48.926721] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 48.934842] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 48.942124] systemd[1]: Reached target Local File Systems. machine # [ 48.943030] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 48.953511] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 48.954559] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 48.962386] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 48.975910] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 48.986745] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 48.994813] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 48.999721] systemd[1]: Finished -.service. machine # [ 49.033433] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 49.038235] systemd[1]: Finished linger-users.service. machine # [ 49.173179] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 49.176877] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 49.431635] nixos[3166]: finished switching to system configuration /nix/store/bxs7w1xqfjxwfzqw8fj67f8jjdcmgsfq-nixos-system-machine-test machine: (finished: must succeed: /nix/store/b2rywx23jb5nhi7b4xfic9vflyz9nzq1-nixos-system-machine-test/specialisation/unitStartingWithDash/bin/switch-to-configuration test 2>&1, in 1.86 seconds) machine: must succeed: /nix/store/b2rywx23jb5nhi7b4xfic9vflyz9nzq1-nixos-system-machine-test/specialisation/unitStartingWithDashModified/bin/switch-to-configuration test 2>&1 machine # [ 49.654108] nixos[3308]: switching to system configuration /nix/store/jxd7bsnyrgf4mpn4kf98f3gc43j7ws95-nixos-system-machine-test machine # [ 49.656730] systemd[1]: Stopped target Remote File Systems. machine # [ 49.659169] systemd[1]: Stopped target Local File Systems. machine # [ 49.927358] systemd[1]: Reload requested from client PID 3308 ('.switch-to-conf') (unit backdoor.service)... machine # [ 49.929740] systemd[1]: Reloading... machine # [ 50.238887] systemd[1]: Reloading finished in 307 ms. machine # [ 50.321999] systemd[561]: Reexecution requested from client PID 3377 ('switch-to-confi')... machine # [ 50.323463] systemd[561]: Reexecuting. machine # [ 50.387485] systemd[561]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 50.501704] systemd[561]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 50.507926] systemd[561]: Reload requested from client PID 3377 ('switch-to-confi')... machine # [ 50.511601] systemd[561]: Reloading... machine # [ 50.614992] systemd[561]: Reloading finished in 104 ms. machine # [ 50.632180] systemd[561]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 50.641531] systemd[561]: Stopped Run user-specific NixOS activation. machine # [ 50.643931] systemd[561]: Stopping Run user-specific NixOS activation... machine # [ 50.646195] systemd[561]: Starting Run user-specific NixOS activation... machine # [ 50.679454] systemd[561]: Finished Run user-specific NixOS activation. machine # [ 50.683359] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 50.687477] systemd[1]: Stopping Reactivate sysinit units... machine # [ 50.688664] systemd[1]: Reached target Reactivate sysinit units. machine # [ 50.690890] systemd[1]: Reloading -.service... machine # [ 50.716697] systemd[1]: Reloaded -.service. machine # [ 50.721130] systemd[1]: Reached target Remote File Systems. machine # [ 50.725039] systemd[1]: Starting linger-users.service... machine # [ 50.735957] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 50.745310] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 50.746746] systemd[1]: Reached target Local File Systems. machine # [ 50.747732] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 50.763641] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 50.764675] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 50.766098] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 50.771793] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 50.779010] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 50.783152] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 50.815139] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 50.819513] systemd[1]: Finished linger-users.service. machine # [ 50.947909] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 50.949824] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 51.206519] nixos[3308]: finished switching to system configuration /nix/store/jxd7bsnyrgf4mpn4kf98f3gc43j7ws95-nixos-system-machine-test machine: (finished: must succeed: /nix/store/b2rywx23jb5nhi7b4xfic9vflyz9nzq1-nixos-system-machine-test/specialisation/unitStartingWithDashModified/bin/switch-to-configuration test 2>&1, in 1.78 seconds) machine: must succeed: /nix/store/b2rywx23jb5nhi7b4xfic9vflyz9nzq1-nixos-system-machine-test/specialisation/unitWithRequirement/bin/switch-to-configuration test 2>&1 machine # [ 51.430080] nixos[3450]: switching to system configuration /nix/store/m81xssw6kzwj96bhxkfvz9md8mv2863b-nixos-system-machine-test machine # [ 51.433033] systemd[1]: Stopped target Remote File Systems. machine # [ 51.436848] systemd[1]: Stopped target Local File Systems. machine # [ 51.438661] systemd[1]: -.service: Deactivated successfully. machine # [ 51.439560] systemd[1]: Stopped -.service. machine # [ 51.715276] systemd[1]: Reload requested from client PID 3450 ('.switch-to-conf') (unit backdoor.service)... machine # [ 51.717734] systemd[1]: Reloading... machine # [ 52.038262] systemd[1]: Reloading finished in 319 ms. machine # [ 52.124409] systemd[561]: Reexecution requested from client PID 3519 ('switch-to-confi')... machine # [ 52.128317] systemd[561]: Reexecuting. machine # [ 52.179612] systemd[561]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 52.293530] systemd[561]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 52.301346] systemd[561]: Reload requested from client PID 3519 ('switch-to-confi')... machine # [ 52.302800] systemd[561]: Reloading... machine # [ 52.409065] systemd[561]: Reloading finished in 105 ms. machine # [ 52.424212] systemd[561]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 52.433757] systemd[561]: Stopped Run user-specific NixOS activation. machine # [ 52.436326] systemd[561]: Stopping Run user-specific NixOS activation... machine # [ 52.438495] systemd[561]: Starting Run user-specific NixOS activation... machine # [ 52.471770] systemd[561]: Finished Run user-specific NixOS activation. machine # [ 52.476757] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 52.477741] systemd[1]: Stopping Reactivate sysinit units... machine # [ 52.478700] systemd[1]: Reached target Reactivate sysinit units. machine # [ 52.482715] systemd[1]: Reached target Local File Systems. machine # [ 52.485102] systemd[1]: Reached target Remote File Systems. machine # [ 52.487278] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 52.496445] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 52.497389] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 52.498682] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 52.512198] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 52.513912] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 52.515225] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 52.516883] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 52.518273] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 52.670152] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 52.673291] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 52.678981] systemd[1]: Starting linger-users.service... machine # [ 52.683382] systemd[1]: Starting required-service.service... machine # [ 52.692643] systemd[1]: Starting test-service.service... machine # [ 52.739535] systemd[1]: Finished test-service.service. machine # [ 52.742061] systemd[1]: Finished required-service.service. machine # [ 52.760791] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 52.763849] systemd[1]: Finished linger-users.service. machine # [ 53.019280] nixos[3450]: finished switching to system configuration /nix/store/m81xssw6kzwj96bhxkfvz9md8mv2863b-nixos-system-machine-test machine: (finished: must succeed: /nix/store/b2rywx23jb5nhi7b4xfic9vflyz9nzq1-nixos-system-machine-test/specialisation/unitWithRequirement/bin/switch-to-configuration test 2>&1, in 1.81 seconds) machine: must succeed: /nix/store/b2rywx23jb5nhi7b4xfic9vflyz9nzq1-nixos-system-machine-test/specialisation/unitWithRequirementModified/bin/switch-to-configuration test 2>&1 machine # [ 53.250519] nixos[3594]: switching to system configuration /nix/store/8283ykbwi4zzsbzr8zlzljkjri94k21k-nixos-system-machine-test machine # [ 53.253275] systemd[1]: Stopped target Local File Systems. machine # [ 53.256586] systemd[1]: required-service.service: Deactivated successfully. machine # [ 53.257725] systemd[1]: Stopped required-service.service. machine # [ 53.258624] systemd[1]: test-service.service: Deactivated successfully. machine # [ 53.259562] systemd[1]: Stopped test-service.service. machine # [ 53.261466] systemd[1]: Stopped target Remote File Systems. machine # [ 53.538889] systemd[1]: Reload requested from client PID 3594 ('.switch-to-conf') (unit backdoor.service)... machine # [ 53.541057] systemd[1]: Reloading... machine # [ 53.862841] systemd[1]: Reloading finished in 320 ms. machine # [ 53.948417] systemd[561]: Reexecution requested from client PID 3663 ('switch-to-confi')... machine # [ 53.952426] systemd[561]: Reexecuting. machine # [ 54.012099] systemd[561]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 54.125520] systemd[561]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 54.132596] systemd[561]: Reload requested from client PID 3663 ('switch-to-confi')... machine # [ 54.136533] systemd[561]: Reloading... machine # [ 54.241517] systemd[561]: Reloading finished in 106 ms. machine # [ 54.256184] systemd[561]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 54.266284] systemd[561]: Stopped Run user-specific NixOS activation. machine # [ 54.268897] systemd[561]: Stopping Run user-specific NixOS activation... machine # [ 54.271279] systemd[561]: Starting Run user-specific NixOS activation... machine # [ 54.304738] systemd[561]: Finished Run user-specific NixOS activation. machine # [ 54.308971] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 54.311025] systemd[1]: Stopping Reactivate sysinit units... machine # [ 54.311893] systemd[1]: Reached target Reactivate sysinit units. machine # [ 54.319836] systemd[1]: Starting required-service.service... machine # [ 54.324453] systemd[1]: Starting test-service.service... machine # [ 54.335940] systemd[1]: Reached target Local File Systems. machine # [ 54.340284] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 54.341949] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 54.342828] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 54.353460] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 54.355920] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 54.371577] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 54.380383] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 54.388208] systemd[1]: Reached target Remote File Systems. machine # [ 54.389338] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 54.390838] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 54.405593] systemd[1]: Finished test-service.service. machine # [ 54.411957] systemd[1]: Finished required-service.service. machine # [ 54.559545] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 54.562885] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 54.568182] systemd[1]: Starting linger-users.service... machine # [ 54.613536] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 54.616344] systemd[1]: Finished linger-users.service. machine # [ 54.872517] nixos[3594]: finished switching to system configuration /nix/store/8283ykbwi4zzsbzr8zlzljkjri94k21k-nixos-system-machine-test machine: (finished: must succeed: /nix/store/b2rywx23jb5nhi7b4xfic9vflyz9nzq1-nixos-system-machine-test/specialisation/unitWithRequirementModified/bin/switch-to-configuration test 2>&1, in 1.85 seconds) machine: must succeed: /nix/store/b2rywx23jb5nhi7b4xfic9vflyz9nzq1-nixos-system-machine-test/specialisation/unitWithRequirementModifiedNostart/bin/switch-to-configuration test 2>&1 machine # [ 55.108610] nixos[3738]: switching to system configuration /nix/store/m88chl4l7cdvmh34vx076ih9z7amwzmc-nixos-system-machine-test machine # [ 55.112888] systemd[1]: required-service.service: Deactivated successfully. machine # [ 55.114046] systemd[1]: Stopped required-service.service. machine # [ 55.114849] systemd[1]: test-service.service: Deactivated successfully. machine # [ 55.115804] systemd[1]: Stopped test-service.service. machine # [ 55.117934] systemd[1]: Stopped target Local File Systems. machine # [ 55.119449] systemd[1]: Stopped target Remote File Systems. machine # [ 55.397575] systemd[1]: Reload requested from client PID 3738 ('.switch-to-conf') (unit backdoor.service)... machine # [ 55.399646] systemd[1]: Reloading... machine # [ 55.715486] systemd[1]: Reloading finished in 314 ms. machine # [ 55.798532] systemd[561]: Reexecution requested from client PID 3807 ('switch-to-confi')... machine # [ 55.802975] systemd[561]: Reexecuting. machine # [ 55.859891] systemd[561]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 55.973200] systemd[561]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 55.979657] systemd[561]: Reload requested from client PID 3807 ('switch-to-confi')... machine # [ 55.983556] systemd[561]: Reloading... machine # [ 56.088763] systemd[561]: Reloading finished in 106 ms. machine # [ 56.104252] systemd[561]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 56.114031] systemd[561]: Stopped Run user-specific NixOS activation. machine # [ 56.116638] systemd[561]: Stopping Run user-specific NixOS activation... machine # [ 56.119125] systemd[561]: Starting Run user-specific NixOS activation... machine # [ 56.153664] systemd[561]: Finished Run user-specific NixOS activation. machine # [ 56.157528] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 56.159632] systemd[1]: Stopping Reactivate sysinit units... machine # [ 56.164639] systemd[1]: Reached target Reactivate sysinit units. machine # [ 56.165553] systemd[1]: Reached target Local File Systems. machine # [ 56.166437] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 56.170001] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 56.170948] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 56.179888] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 56.186259] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 56.187924] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 56.194765] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 56.197137] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 56.199531] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 56.201878] systemd[1]: Reached target Remote File Systems. machine # [ 56.351594] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 56.354629] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 56.359901] systemd[1]: Starting linger-users.service... machine # [ 56.364533] systemd[1]: Starting required-service.service... machine # [ 56.375837] systemd[1]: Starting test-service.service... machine # [ 56.417939] systemd[1]: Finished test-service.service. machine # [ 56.421104] systemd[1]: Finished required-service.service. machine # [ 56.438785] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 56.441698] systemd[1]: Finished linger-users.service. machine # [ 56.697613] nixos[3738]: finished switching to system configuration /nix/store/m88chl4l7cdvmh34vx076ih9z7amwzmc-nixos-system-machine-test machine: (finished: must succeed: /nix/store/b2rywx23jb5nhi7b4xfic9vflyz9nzq1-nixos-system-machine-test/specialisation/unitWithRequirementModifiedNostart/bin/switch-to-configuration test 2>&1, in 1.82 seconds) machine: must succeed: /nix/store/b2rywx23jb5nhi7b4xfic9vflyz9nzq1-nixos-system-machine-test/specialisation/unitWithTemplate/bin/switch-to-configuration test 2>&1 machine # [ 56.924282] nixos[3882]: switching to system configuration /nix/store/3r2n9k779nw8sg272dfpgznv8mz7dnmq-nixos-system-machine-test machine # [ 56.927159] systemd[1]: Stopped target Remote File Systems. machine # [ 56.930687] systemd[1]: required-service.service: Deactivated successfully. machine # [ 56.931795] systemd[1]: Stopped required-service.service. machine # [ 56.933938] systemd[1]: test-service.service: Deactivated successfully. machine # [ 56.934916] systemd[1]: Stopped test-service.service. machine # [ 56.935653] systemd[1]: Stopped target Local File Systems. machine # [ 57.215547] systemd[1]: Reload requested from client PID 3882 ('.switch-to-conf') (unit backdoor.service)... machine # [ 57.217794] systemd[1]: Reloading... machine # [ 57.547017] systemd[1]: Reloading finished in 327 ms. machine # [ 57.636375] systemd[561]: Reexecution requested from client PID 3951 ('switch-to-confi')... machine # [ 57.637837] systemd[561]: Reexecuting. machine # [ 57.695356] systemd[561]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 57.807222] systemd[561]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 57.814103] systemd[561]: Reload requested from client PID 3951 ('switch-to-confi')... machine # [ 57.816718] systemd[561]: Reloading... machine # [ 57.921770] systemd[561]: Reloading finished in 104 ms. machine # [ 57.936223] systemd[561]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 57.946478] systemd[561]: Stopped Run user-specific NixOS activation. machine # [ 57.948901] systemd[561]: Stopping Run user-specific NixOS activation... machine # [ 57.951142] systemd[561]: Starting Run user-specific NixOS activation... machine # [ 57.984671] systemd[561]: Finished Run user-specific NixOS activation. machine # [ 57.988922] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 57.991247] systemd[1]: Stopping Reactivate sysinit units... machine # [ 57.994174] systemd[1]: Reached target Reactivate sysinit units. machine # [ 57.996655] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 57.998045] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 58.002294] systemd[1]: Reached target Local File Systems. machine # [ 58.007104] systemd[1]: Created slice Slice /system/instantiated. machine # [ 58.008505] systemd[1]: Reached target Remote File Systems. machine # [ 58.013602] systemd[1]: Starting instantiated@one.service... machine # [ 58.017853] systemd[1]: Starting instantiated@two.service... machine # [ 58.024704] systemd[1]: Starting linger-users.service... machine # [ 58.040879] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 58.049751] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 58.050787] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 58.061527] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 58.076232] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 58.087954] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 58.097974] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 58.106328] systemd[1]: Finished instantiated@one.service. machine # [ 58.107238] systemd[1]: Finished instantiated@two.service. machine # [ 58.140181] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 58.144133] systemd[1]: Finished linger-users.service. machine # [ 58.271571] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 58.274527] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 58.531397] nixos[3882]: finished switching to system configuration /nix/store/3r2n9k779nw8sg272dfpgznv8mz7dnmq-nixos-system-machine-test machine: (finished: must succeed: /nix/store/b2rywx23jb5nhi7b4xfic9vflyz9nzq1-nixos-system-machine-test/specialisation/unitWithTemplate/bin/switch-to-configuration test 2>&1, in 1.83 seconds) machine: must succeed: /nix/store/b2rywx23jb5nhi7b4xfic9vflyz9nzq1-nixos-system-machine-test/specialisation/unitWithTemplateModified/bin/switch-to-configuration test 2>&1 machine # [ 58.770805] nixos[4026]: switching to system configuration /nix/store/0kvx2xry2vz6l47jk8yldg30yq6g35f0-nixos-system-machine-test machine # [ 58.774973] systemd[1]: Stopped target Local File Systems. machine # [ 58.775883] systemd[1]: instantiated@two.service: Deactivated successfully. machine # [ 58.779585] systemd[1]: Stopped instantiated@two.service. machine # [ 58.781920] systemd[1]: Stopped target Remote File Systems. machine # [ 58.782813] systemd[1]: instantiated@one.service: Deactivated successfully. machine # [ 58.783819] systemd[1]: Stopped instantiated@one.service. machine # [ 59.060671] systemd[1]: Reload requested from client PID 4026 ('.switch-to-conf') (unit backdoor.service)... machine # [ 59.062415] systemd[1]: Reloading... machine # [ 59.389507] systemd[1]: Reloading finished in 325 ms. machine # [ 59.472361] systemd[561]: Reexecution requested from client PID 4095 ('switch-to-confi')... machine # [ 59.473903] systemd[561]: Reexecuting. machine # [ 59.535607] systemd[561]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 59.650779] systemd[561]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 59.657250] systemd[561]: Reload requested from client PID 4095 ('switch-to-confi')... machine # [ 59.659576] systemd[561]: Reloading... machine # [ 59.767532] systemd[561]: Reloading finished in 107 ms. machine # [ 59.784208] systemd[561]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 59.793595] systemd[561]: Stopped Run user-specific NixOS activation. machine # [ 59.796352] systemd[561]: Stopping Run user-specific NixOS activation... machine # [ 59.798436] systemd[561]: Starting Run user-specific NixOS activation... machine # [ 59.832173] systemd[561]: Finished Run user-specific NixOS activation. machine # [ 59.836167] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 59.840893] systemd[1]: Stopping Reactivate sysinit units... machine # [ 59.841901] systemd[1]: Reached target Reactivate sysinit units. machine # [ 59.842765] systemd[1]: Reached target Remote File Systems. machine # [ 59.847770] systemd[1]: Starting instantiated@one.service... machine # [ 59.851577] systemd[1]: Starting instantiated@two.service... machine # [ 59.854995] systemd[1]: Starting linger-users.service... machine # [ 59.868174] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 59.869637] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 59.880324] systemd[1]: Reached target Local File Systems. machine # [ 59.883761] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 59.892679] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 59.893619] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 59.894948] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 59.922106] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 59.923815] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 59.926506] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 59.951363] systemd[1]: Finished instantiated@one.service. machine # [ 59.954070] systemd[1]: Finished instantiated@two.service. machine # [ 59.988162] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 59.991344] systemd[1]: Finished linger-users.service. machine # [ 60.124753] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 60.127677] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 60.383453] nixos[4026]: finished switching to system configuration /nix/store/0kvx2xry2vz6l47jk8yldg30yq6g35f0-nixos-system-machine-test machine: (finished: must succeed: /nix/store/b2rywx23jb5nhi7b4xfic9vflyz9nzq1-nixos-system-machine-test/specialisation/unitWithTemplateModified/bin/switch-to-configuration test 2>&1, in 1.85 seconds) (finished: subtest: services, in 38.09 seconds) subtest: failing units machine: must succeed: /nix/store/b2rywx23jb5nhi7b4xfic9vflyz9nzq1-nixos-system-machine-test/specialisation/simpleServiceModified/bin/switch-to-configuration test 2>&1 machine # [ 60.592351] nixos[4170]: switching to system configuration /nix/store/c6klgcmrsjl91j377s21xhy18cffcs8d-nixos-system-machine-test machine # [ 60.594944] systemd[1]: Stopped target Remote File Systems. machine # [ 60.597304] systemd[1]: Stopped target Local File Systems. machine # [ 60.599042] systemd[1]: instantiated@one.service: Deactivated successfully. machine # [ 60.601873] systemd[1]: Stopped instantiated@one.service. machine # [ 60.602718] systemd[1]: instantiated@two.service: Deactivated successfully. machine # [ 60.603775] systemd[1]: Stopped instantiated@two.service. machine # [ 60.866803] systemd[1]: Reload requested from client PID 4170 ('.switch-to-conf') (unit backdoor.service)... machine # [ 60.869147] systemd[1]: Reloading... machine # [ 61.173219] systemd[1]: Reloading finished in 302 ms. machine # [ 61.256434] systemd[561]: Reexecution requested from client PID 4239 ('switch-to-confi')... machine # [ 61.257906] systemd[561]: Reexecuting. machine # [ 61.303332] systemd[561]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 61.412842] systemd[561]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 61.419799] systemd[561]: Reload requested from client PID 4239 ('switch-to-confi')... machine # [ 61.422430] systemd[561]: Reloading... machine # [ 61.530148] systemd[561]: Reloading finished in 105 ms. machine # [ 61.540168] systemd[561]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 61.550138] systemd[561]: Stopped Run user-specific NixOS activation. machine # [ 61.552582] systemd[561]: Stopping Run user-specific NixOS activation... machine # [ 61.554788] systemd[561]: Starting Run user-specific NixOS activation... machine # [ 61.588961] systemd[561]: Finished Run user-specific NixOS activation. machine # [ 61.592679] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 61.595799] systemd[1]: Stopping Reactivate sysinit units... machine # [ 61.598070] systemd[1]: Reached target Reactivate sysinit units. machine # [ 61.598976] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 61.603913] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 61.608428] systemd[1]: Reached target Remote File Systems. machine # [ 61.609292] systemd[1]: Starting linger-users.service... machine # [ 61.612654] systemd[1]: Starting test.service... machine # [ 61.627514] systemd[1]: Reached target Local File Systems. machine # [ 61.634305] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 61.635918] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 61.644375] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 61.645674] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 61.647953] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 61.661258] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 61.662771] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 61.690067] systemd[1]: Finished test.service. machine # [ 61.718545] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 61.721550] systemd[1]: Finished linger-users.service. machine # [ 61.846402] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 61.849452] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 62.106497] nixos[4170]: finished switching to system configuration /nix/store/c6klgcmrsjl91j377s21xhy18cffcs8d-nixos-system-machine-test machine: (finished: must succeed: /nix/store/b2rywx23jb5nhi7b4xfic9vflyz9nzq1-nixos-system-machine-test/specialisation/simpleServiceModified/bin/switch-to-configuration test 2>&1, in 1.72 seconds) machine: must fail: /nix/store/b2rywx23jb5nhi7b4xfic9vflyz9nzq1-nixos-system-machine-test/specialisation/simpleServiceFailing/bin/switch-to-configuration test 2>&1 machine # [ 62.330647] nixos[4312]: switching to system configuration /nix/store/f6c36nk1hqafzrlxf7p8rmpbm5ak1j56-nixos-system-machine-test machine # [ 62.333565] systemd[1]: test.service: Deactivated successfully. machine # [ 62.337140] systemd[1]: Stopped test.service. machine # [ 62.338532] systemd[1]: Stopped target Local File Systems. machine # [ 62.339356] systemd[1]: Stopped target Remote File Systems. machine # [ 62.607822] systemd[1]: Reload requested from client PID 4312 ('.switch-to-conf') (unit backdoor.service)... machine # [ 62.610122] systemd[1]: Reloading... machine # [ 62.922595] systemd[1]: Reloading finished in 311 ms. machine # [ 63.009216] systemd[561]: Reexecution requested from client PID 4381 ('switch-to-confi')... machine # [ 63.012968] systemd[561]: Reexecuting. machine # [ 63.071464] systemd[561]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 63.185072] systemd[561]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 63.192095] systemd[561]: Reload requested from client PID 4381 ('switch-to-confi')... machine # [ 63.193434] systemd[561]: Reloading... machine # [ 63.297187] systemd[561]: Reloading finished in 102 ms. machine # [ 63.312168] systemd[561]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 63.321944] systemd[561]: Stopped Run user-specific NixOS activation. machine # [ 63.324065] systemd[561]: Stopping Run user-specific NixOS activation... machine # [ 63.326392] systemd[561]: Starting Run user-specific NixOS activation... machine # [ 63.355039] systemd[561]: Finished Run user-specific NixOS activation. machine # [ 63.358834] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 63.360717] systemd[1]: Stopping Reactivate sysinit units... machine # [ 63.361617] systemd[1]: Reached target Reactivate sysinit units. machine # [ 63.363990] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 63.365869] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 63.369451] systemd[1]: Reached target Remote File Systems. machine # [ 63.372080] systemd[1]: Reached target Local File Systems. machine # [ 63.376084] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 63.384417] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 63.385394] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 63.386690] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 63.395579] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 63.398423] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 63.399849] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 63.546878] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 63.551724] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 63.555405] systemd[1]: Starting linger-users.service... machine # [ 63.557999] systemd[1]: Starting test.service... machine # [ 63.594550] systemd[1]: test.service: Main process exited, code=exited, status=1/FAILURE machine # [ 63.598782] systemd[1]: test.service: Failed with result 'exit-code'. machine # [ 63.601568] systemd[1]: Failed to start test.service. machine # [ 63.618072] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 63.620927] systemd[1]: Finished linger-users.service. machine # [ 63.901366] nixos[4312]: switching to system configuration /nix/store/f6c36nk1hqafzrlxf7p8rmpbm5ak1j56-nixos-system-machine-test failed (status 4) machine: (finished: must fail: /nix/store/b2rywx23jb5nhi7b4xfic9vflyz9nzq1-nixos-system-machine-test/specialisation/simpleServiceFailing/bin/switch-to-configuration test 2>&1, in 1.79 seconds) machine: must succeed: /nix/store/b2rywx23jb5nhi7b4xfic9vflyz9nzq1-nixos-system-machine-test/specialisation/autorestartService/bin/switch-to-configuration test 2>&1 machine # [ 64.122821] nixos[4455]: switching to system configuration /nix/store/cyc386bdjrid6cs2yv9a56wqkcw9qnvw-nixos-system-machine-test machine # [ 64.125497] systemd[1]: Stopped target Local File Systems. machine # [ 64.128296] systemd[1]: Stopped target Remote File Systems. machine # [ 64.407013] systemd[1]: Reload requested from client PID 4455 ('.switch-to-conf') (unit backdoor.service)... machine # [ 64.409351] systemd[1]: Reloading... machine # [ 64.729255] systemd[1]: Reloading finished in 318 ms. machine # [ 64.812061] systemd[561]: Reexecution requested from client PID 4524 ('switch-to-confi')... machine # [ 64.813490] systemd[561]: Reexecuting. machine # [ 64.875754] systemd[561]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 64.989556] systemd[561]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 64.997079] systemd[561]: Reload requested from client PID 4524 ('switch-to-confi')... machine # [ 64.998590] systemd[561]: Reloading... machine # [ 65.107345] systemd[561]: Reloading finished in 107 ms. machine # [ 65.124176] systemd[561]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 65.133339] systemd[561]: Stopped Run user-specific NixOS activation. machine # [ 65.135758] systemd[561]: Stopping Run user-specific NixOS activation... machine # [ 65.138003] systemd[561]: Starting Run user-specific NixOS activation... machine # [ 65.167947] systemd[561]: Finished Run user-specific NixOS activation. machine # [ 65.172001] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 65.174155] systemd[1]: Stopping Reactivate sysinit units... machine # [ 65.175066] systemd[1]: Reached target Reactivate sysinit units. machine # [ 65.180267] systemd[1]: Reached target Local File Systems. machine # [ 65.183721] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 65.188179] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 65.189099] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 65.190470] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 65.203608] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 65.208908] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 65.210360] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 65.211588] systemd[1]: Reached target Remote File Systems. machine # [ 65.212474] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 65.213923] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 65.390116] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 65.393422] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 65.399627] systemd[1]: Started autorestart.service. machine # [ 65.402924] systemd[1]: Starting linger-users.service... machine # [ 65.443353] systemd[1]: autorestart.service: Deactivated successfully. machine # [ 65.462408] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 65.465070] systemd[1]: Finished linger-users.service. machine # [ 65.722125] nixos[4455]: finished switching to system configuration /nix/store/cyc386bdjrid6cs2yv9a56wqkcw9qnvw-nixos-system-machine-test machine: (finished: must succeed: /nix/store/b2rywx23jb5nhi7b4xfic9vflyz9nzq1-nixos-system-machine-test/specialisation/autorestartService/bin/switch-to-configuration test 2>&1, in 1.82 seconds) machine # [ 65.770301] systemd[1]: Stopped autorestart.service. machine: must succeed: /nix/store/b2rywx23jb5nhi7b4xfic9vflyz9nzq1-nixos-system-machine-test/specialisation/autorestartService/bin/switch-to-configuration test 2>&1 machine # [ 65.964814] nixos[4602]: switching to system configuration /nix/store/cyc386bdjrid6cs2yv9a56wqkcw9qnvw-nixos-system-machine-test machine # [ 65.967439] systemd[1]: Stopped target Remote File Systems. machine # [ 65.970353] systemd[1]: Stopped target Local File Systems. machine # [ 66.230843] systemd[1]: Reload requested from client PID 4602 ('.switch-to-conf') (unit backdoor.service)... machine # [ 66.232971] systemd[1]: Reloading... machine # [ 66.541129] systemd[1]: Reloading finished in 306 ms. machine # [ 66.631407] systemd[561]: Reexecution requested from client PID 4671 ('switch-to-confi')... machine # [ 66.633699] systemd[561]: Reexecuting. machine # [ 66.683717] systemd[561]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 66.795552] systemd[561]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 66.802950] systemd[561]: Reload requested from client PID 4671 ('switch-to-confi')... machine # [ 66.806464] systemd[561]: Reloading... machine # [ 66.913340] systemd[561]: Reloading finished in 108 ms. machine # [ 66.928229] systemd[561]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 66.937550] systemd[561]: Stopped Run user-specific NixOS activation. machine # [ 66.940365] systemd[561]: Stopping Run user-specific NixOS activation... machine # [ 66.944000] systemd[561]: Starting Run user-specific NixOS activation... machine # [ 66.976726] systemd[561]: Finished Run user-specific NixOS activation. machine # [ 66.981000] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 66.983766] systemd[1]: Stopping Reactivate sysinit units... machine # [ 66.985942] systemd[1]: Reached target Reactivate sysinit units. machine # [ 66.988469] systemd[1]: Reached target Local File Systems. machine # [ 66.991290] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 66.998389] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 66.999360] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 67.008708] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 67.011091] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 67.018048] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 67.021016] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 67.022354] systemd[1]: Reached target Remote File Systems. machine # [ 67.023153] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 67.025378] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 67.173421] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 67.178364] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 67.180332] systemd[1]: Started autorestart.service. machine # [ 67.185127] systemd[1]: Starting linger-users.service... machine # [ 67.219800] systemd[1]: autorestart.service: Deactivated successfully. machine # [ 67.240308] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 67.243494] systemd[1]: Finished linger-users.service. machine # [ 67.499559] nixos[4602]: finished switching to system configuration /nix/store/cyc386bdjrid6cs2yv9a56wqkcw9qnvw-nixos-system-machine-test machine: (finished: must succeed: /nix/store/b2rywx23jb5nhi7b4xfic9vflyz9nzq1-nixos-system-machine-test/specialisation/autorestartService/bin/switch-to-configuration test 2>&1, in 1.73 seconds) machine # [ 67.541586] systemd[1]: Stopped autorestart.service. machine: must fail: /nix/store/b2rywx23jb5nhi7b4xfic9vflyz9nzq1-nixos-system-machine-test/specialisation/autorestartServiceFailing/bin/switch-to-configuration test 2>&1 machine # [ 67.757045] nixos[4749]: switching to system configuration /nix/store/vyqjl5admwcgzfqrgvsvnf1kvggggd35-nixos-system-machine-test machine # [ 67.759728] systemd[1]: Stopped target Remote File Systems. machine # [ 67.762121] systemd[1]: Stopped target Local File Systems. machine # [ 68.039890] systemd[1]: Reload requested from client PID 4749 ('.switch-to-conf') (unit backdoor.service)... machine # [ 68.042251] systemd[1]: Reloading... machine # [ 68.358509] systemd[1]: Reloading finished in 315 ms. machine # [ 68.444421] systemd[561]: Reexecution requested from client PID 4818 ('switch-to-confi')... machine # [ 68.447981] systemd[561]: Reexecuting. machine # [ 68.502856] systemd[561]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 68.609169] systemd[561]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 68.616112] systemd[561]: Reload requested from client PID 4818 ('switch-to-confi')... machine # [ 68.617501] systemd[561]: Reloading... machine # [ 68.722832] systemd[561]: Reloading finished in 103 ms. machine # [ 68.736179] systemd[561]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 68.745280] systemd[561]: Stopped Run user-specific NixOS activation. machine # [ 68.747963] systemd[561]: Stopping Run user-specific NixOS activation... machine # [ 68.750256] systemd[561]: Starting Run user-specific NixOS activation... machine # [ 68.786217] systemd[561]: Finished Run user-specific NixOS activation. machine # [ 68.791204] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 68.794939] systemd[1]: Stopping Reactivate sysinit units... machine # [ 68.795897] systemd[1]: Reached target Reactivate sysinit units. machine # [ 68.802125] systemd[1]: Reached target Remote File Systems. machine # [ 68.806499] systemd[1]: Started autorestart.service. machine # [ 68.811550] systemd[1]: Starting linger-users.service... machine # [ 68.824326] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 68.825912] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 68.840771] systemd[1]: Reached target Local File Systems. machine # [ 68.841912] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 68.843465] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 68.856226] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 68.857758] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 68.872956] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 68.884649] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 68.892391] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 68.895159] systemd[1]: autorestart.service: Main process exited, code=exited, status=1/FAILURE machine # [ 68.902323] systemd[1]: autorestart.service: Failed with result 'exit-code'. machine # [ 68.934552] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 68.937566] systemd[1]: Finished linger-users.service. machine # [ 69.065876] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 69.069054] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 69.349944] nixos[4749]: switching to system configuration /nix/store/vyqjl5admwcgzfqrgvsvnf1kvggggd35-nixos-system-machine-test failed (status 4) machine: (finished: must fail: /nix/store/b2rywx23jb5nhi7b4xfic9vflyz9nzq1-nixos-system-machine-test/specialisation/autorestartServiceFailing/bin/switch-to-configuration test 2>&1, in 1.80 seconds) (finished: subtest: failing units, in 8.97 seconds) subtest: unit file parser machine: must succeed: /nix/store/b2rywx23jb5nhi7b4xfic9vflyz9nzq1-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1 machine # [ 69.557214] nixos[4892]: switching to system configuration /nix/store/575y7wkacypk0xlzf3dhxi8hq8nziqi0-nixos-system-machine-test machine # [ 69.559905] systemd[1]: Stopped target Remote File Systems. machine # [ 69.563567] systemd[1]: Stopped target Local File Systems. machine # [ 69.565366] systemd[1]: Stopped autorestart.service. machine # [ 69.824656] systemd[1]: Reload requested from client PID 4892 ('.switch-to-conf') (unit backdoor.service)... machine # [ 69.826402] systemd[1]: Reloading... machine # [ 70.135830] systemd[1]: Reloading finished in 307 ms. machine # [ 70.221452] systemd[561]: Reexecution requested from client PID 4961 ('switch-to-confi')... machine # [ 70.225799] systemd[561]: Reexecuting. machine # [ 70.278800] systemd[561]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 70.383720] systemd[561]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 70.391391] systemd[561]: Reload requested from client PID 4961 ('switch-to-confi')... machine # [ 70.394776] systemd[561]: Reloading... machine # [ 70.497641] systemd[561]: Reloading finished in 104 ms. machine # [ 70.512184] systemd[561]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 70.521551] systemd[561]: Stopped Run user-specific NixOS activation. machine # [ 70.523948] systemd[561]: Stopping Run user-specific NixOS activation... machine # [ 70.526257] systemd[561]: Starting Run user-specific NixOS activation... machine # [ 70.559519] systemd[561]: Finished Run user-specific NixOS activation. machine # [ 70.563574] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 70.565601] systemd[1]: Stopping Reactivate sysinit units... machine # [ 70.566596] systemd[1]: Reached target Reactivate sysinit units. machine # [ 70.568346] systemd[1]: Reached target Remote File Systems. machine # [ 70.574369] systemd[1]: Reached target Local File Systems. machine # [ 70.577738] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 70.582135] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 70.583095] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 70.593045] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 70.595388] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 70.600931] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 70.602344] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 70.603569] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 70.604962] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 70.757053] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 70.762118] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 70.766067] systemd[1]: Starting linger-users.service... machine # [ 70.769152] systemd[1]: Starting test.service... machine # [ 70.807496] systemd[1]: Finished test.service. machine # [ 70.826434] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 70.829180] systemd[1]: Finished linger-users.service. machine # [ 71.086463] nixos[4892]: finished switching to system configuration /nix/store/575y7wkacypk0xlzf3dhxi8hq8nziqi0-nixos-system-machine-test machine: (finished: must succeed: /nix/store/b2rywx23jb5nhi7b4xfic9vflyz9nzq1-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1, in 1.74 seconds) machine: must succeed: /nix/store/b2rywx23jb5nhi7b4xfic9vflyz9nzq1-nixos-system-machine-test/specialisation/simpleServiceWithExtraSection/bin/switch-to-configuration test 2>&1 machine # [ 71.318199] nixos[5034]: switching to system configuration /nix/store/44cm528pwpgkzq5ldqi47fmvlcrrg6n9-nixos-system-machine-test machine # [ 71.320872] systemd[1]: Stopped target Remote File Systems. machine # [ 71.323395] systemd[1]: Stopped target Local File Systems. machine # [ 71.606273] systemd[1]: Reload requested from client PID 5034 ('.switch-to-conf') (unit backdoor.service)... machine # [ 71.608651] systemd[1]: Reloading... machine # [ 71.933808] systemd[1]: Reloading finished in 323 ms. machine # [ 72.021485] systemd[561]: Reexecution requested from client PID 5103 ('switch-to-confi')... machine # [ 72.023071] systemd[561]: Reexecuting. machine # [ 72.079304] systemd[561]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 72.193890] systemd[561]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 72.200404] systemd[561]: Reload requested from client PID 5103 ('switch-to-confi')... machine # [ 72.204051] systemd[561]: Reloading... machine # [ 72.307991] systemd[561]: Reloading finished in 104 ms. machine # [ 72.324182] systemd[561]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 72.333295] systemd[561]: Stopped Run user-specific NixOS activation. machine # [ 72.335654] systemd[561]: Stopping Run user-specific NixOS activation... machine # [ 72.338008] systemd[561]: Starting Run user-specific NixOS activation... machine # [ 72.371969] systemd[561]: Finished Run user-specific NixOS activation. machine # [ 72.376106] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 72.380560] systemd[1]: Stopping Reactivate sysinit units... machine # [ 72.381551] systemd[1]: Reached target Reactivate sysinit units. machine # [ 72.382519] systemd[1]: test.service: Deactivated successfully. machine # [ 72.383395] systemd[1]: Stopped test.service. machine # [ 72.385208] systemd[1]: Stopping test.service... machine # [ 72.387041] systemd[1]: Starting test.service... machine # [ 72.413214] systemd[1]: Finished test.service. machine # [ 72.416178] systemd[1]: Reached target Remote File Systems. machine # [ 72.422983] systemd[1]: Reached target Local File Systems. machine # [ 72.427295] systemd[1]: Starting linger-users.service... machine # [ 72.430103] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 72.436636] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 72.441939] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 72.449531] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 72.450466] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 72.451774] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 72.463366] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 72.468856] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 72.475486] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 72.519796] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 72.524578] systemd[1]: Finished linger-users.service. machine # [ 72.648661] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 72.652306] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 72.907969] nixos[5034]: finished switching to system configuration /nix/store/44cm528pwpgkzq5ldqi47fmvlcrrg6n9-nixos-system-machine-test machine: (finished: must succeed: /nix/store/b2rywx23jb5nhi7b4xfic9vflyz9nzq1-nixos-system-machine-test/specialisation/simpleServiceWithExtraSection/bin/switch-to-configuration test 2>&1, in 1.82 seconds) machine: must succeed: /nix/store/b2rywx23jb5nhi7b4xfic9vflyz9nzq1-nixos-system-machine-test/specialisation/simpleServiceWithExtraSectionOtherName/bin/switch-to-configuration test 2>&1 machine # [ 73.123590] nixos[5176]: switching to system configuration /nix/store/qimyh04lgr495cf1zac1yphqfylrwch0-nixos-system-machine-test machine # [ 73.126777] systemd[1]: Stopped target Remote File Systems. machine # [ 73.129503] systemd[1]: Stopped target Local File Systems. machine # [ 73.407550] systemd[1]: Reload requested from client PID 5176 ('.switch-to-conf') (unit backdoor.service)... machine # [ 73.409781] systemd[1]: Reloading... machine # [ 73.728978] systemd[1]: Reloading finished in 317 ms. machine # [ 73.814985] systemd[561]: Reexecution requested from client PID 5245 ('switch-to-confi')... machine # [ 73.819222] systemd[561]: Reexecuting. machine # [ 73.866789] systemd[561]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 73.975368] systemd[561]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 73.982009] systemd[561]: Reload requested from client PID 5245 ('switch-to-confi')... machine # [ 73.984369] systemd[561]: Reloading... machine # [ 74.088534] systemd[561]: Reloading finished in 103 ms. machine # [ 74.100215] systemd[561]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 74.110356] systemd[561]: Stopped Run user-specific NixOS activation. machine # [ 74.113144] systemd[561]: Stopping Run user-specific NixOS activation... machine # [ 74.115509] systemd[561]: Starting Run user-specific NixOS activation... machine # [ 74.148119] systemd[561]: Finished Run user-specific NixOS activation. machine # [ 74.152745] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 74.153802] systemd[1]: Stopping Reactivate sysinit units... machine # [ 74.154640] systemd[1]: Reached target Reactivate sysinit units. machine # [ 74.157406] systemd[1]: test.service: Deactivated successfully. machine # [ 74.160101] systemd[1]: Stopped test.service. machine # [ 74.160866] systemd[1]: Stopping test.service... machine # [ 74.163127] systemd[1]: Starting test.service... machine # [ 74.189040] systemd[1]: Finished test.service. machine # [ 74.194273] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 74.197359] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 74.199308] systemd[1]: Reached target Remote File Systems. machine # [ 74.204811] systemd[1]: Reached target Local File Systems. machine # [ 74.205791] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 74.210399] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 74.211374] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 74.220596] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 74.222941] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 74.227762] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 74.229324] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 74.383682] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 74.386975] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 74.391600] systemd[1]: Starting linger-users.service... machine # [ 74.433548] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 74.436784] systemd[1]: Finished linger-users.service. machine # [ 74.691184] nixos[5176]: finished switching to system configuration /nix/store/qimyh04lgr495cf1zac1yphqfylrwch0-nixos-system-machine-test machine: (finished: must succeed: /nix/store/b2rywx23jb5nhi7b4xfic9vflyz9nzq1-nixos-system-machine-test/specialisation/simpleServiceWithExtraSectionOtherName/bin/switch-to-configuration test 2>&1, in 1.78 seconds) machine: must succeed: /nix/store/b2rywx23jb5nhi7b4xfic9vflyz9nzq1-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1 machine # [ 74.897511] nixos[5318]: switching to system configuration /nix/store/575y7wkacypk0xlzf3dhxi8hq8nziqi0-nixos-system-machine-test machine # [ 74.900313] systemd[1]: Stopped target Local File Systems. machine # [ 74.902585] systemd[1]: Stopped target Remote File Systems. machine # [ 75.160769] systemd[1]: Reload requested from client PID 5318 ('.switch-to-conf') (unit backdoor.service)... machine # [ 75.162403] systemd[1]: Reloading... machine # [ 75.466796] systemd[1]: Reloading finished in 303 ms. machine # [ 75.550589] systemd[561]: Reexecution requested from client PID 5387 ('switch-to-confi')... machine # [ 75.555204] systemd[561]: Reexecuting. machine # [ 75.607238] systemd[561]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 75.719536] systemd[561]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 75.727984] systemd[561]: Reload requested from client PID 5387 ('switch-to-confi')... machine # [ 75.729722] systemd[561]: Reloading... machine # [ 75.839220] systemd[561]: Reloading finished in 108 ms. machine # [ 75.856241] systemd[561]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 75.865567] systemd[561]: Stopped Run user-specific NixOS activation. machine # [ 75.868175] systemd[561]: Stopping Run user-specific NixOS activation... machine # [ 75.870561] systemd[561]: Starting Run user-specific NixOS activation... machine # [ 75.905963] systemd[561]: Finished Run user-specific NixOS activation. machine # [ 75.910901] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 75.913376] systemd[1]: Stopping Reactivate sysinit units... machine # [ 75.914322] systemd[1]: Reached target Reactivate sysinit units. machine # [ 75.918886] systemd[1]: test.service: Deactivated successfully. machine # [ 75.919961] systemd[1]: Stopped test.service. machine # [ 75.923018] systemd[1]: Stopping test.service... machine # [ 75.923842] systemd[1]: Starting test.service... machine # [ 75.950790] systemd[1]: Finished test.service. machine # [ 75.956762] systemd[1]: Reached target Local File Systems. machine # [ 75.961037] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 75.962558] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 75.963895] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 75.969215] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 75.970210] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 75.971531] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 75.983906] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 75.991461] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 75.992964] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 75.994256] systemd[1]: Reached target Remote File Systems. machine # [ 76.161425] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 76.163528] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 76.169831] systemd[1]: Starting linger-users.service... machine # [ 76.217788] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 76.221472] systemd[1]: Finished linger-users.service. machine # [ 76.475703] nixos[5318]: finished switching to system configuration /nix/store/575y7wkacypk0xlzf3dhxi8hq8nziqi0-nixos-system-machine-test machine: (finished: must succeed: /nix/store/b2rywx23jb5nhi7b4xfic9vflyz9nzq1-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1, in 1.78 seconds) machine: must succeed: /nix/store/b2rywx23jb5nhi7b4xfic9vflyz9nzq1-nixos-system-machine-test/specialisation/simpleServiceWithInstallSection/bin/switch-to-configuration test 2>&1 machine # [ 76.701087] nixos[5460]: switching to system configuration /nix/store/mzvm6whh1m44zfxs0vwn1b30xy9axf84-nixos-system-machine-test machine # [ 76.703707] systemd[1]: Stopped target Remote File Systems. machine # [ 76.705655] systemd[1]: Stopped target Local File Systems. machine # [ 76.979795] systemd[1]: Reload requested from client PID 5460 ('.switch-to-conf') (unit backdoor.service)... machine # [ 76.982156] systemd[1]: Reloading... machine # [ 77.297572] systemd[1]: Reloading finished in 313 ms. machine # [ 77.384359] systemd[561]: Reexecution requested from client PID 5529 ('switch-to-confi')... machine # [ 77.388911] systemd[561]: Reexecuting. machine # [ 77.447527] systemd[561]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 77.566597] systemd[561]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 77.573418] systemd[561]: Reload requested from client PID 5529 ('switch-to-confi')... machine # [ 77.577800] systemd[561]: Reloading... machine # [ 77.685006] systemd[561]: Reloading finished in 108 ms. machine # [ 77.700193] systemd[561]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 77.709741] systemd[561]: Stopped Run user-specific NixOS activation. machine # [ 77.712168] systemd[561]: Stopping Run user-specific NixOS activation... machine # [ 77.714391] systemd[561]: Starting Run user-specific NixOS activation... machine # [ 77.744152] systemd[561]: Finished Run user-specific NixOS activation. machine # [ 77.747965] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 77.749410] systemd[1]: Stopping Reactivate sysinit units... machine # [ 77.750359] systemd[1]: Reached target Reactivate sysinit units. machine # [ 77.757889] systemd[1]: Reached target Local File Systems. machine # [ 77.760296] systemd[1]: Reached target Remote File Systems. machine # [ 77.765815] systemd[1]: Starting linger-users.service... machine # [ 77.773404] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 77.774976] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 77.779209] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 77.789941] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 77.790874] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 77.796416] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 77.798814] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 77.808231] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 77.809701] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 77.859072] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 77.863321] systemd[1]: Finished linger-users.service. machine # [ 77.990570] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 77.994520] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 78.249801] nixos[5460]: finished switching to system configuration /nix/store/mzvm6whh1m44zfxs0vwn1b30xy9axf84-nixos-system-machine-test machine: (finished: must succeed: /nix/store/b2rywx23jb5nhi7b4xfic9vflyz9nzq1-nixos-system-machine-test/specialisation/simpleServiceWithInstallSection/bin/switch-to-configuration test 2>&1, in 1.77 seconds) machine: must succeed: /nix/store/b2rywx23jb5nhi7b4xfic9vflyz9nzq1-nixos-system-machine-test/specialisation/simpleServiceWithExtraKey/bin/switch-to-configuration test 2>&1 machine # [ 78.474951] nixos[5600]: switching to system configuration /nix/store/s1qjllm569abgzgy05cdnix3pd4116lm-nixos-system-machine-test machine # [ 78.480397] systemd[1]: Stopped target Remote File Systems. machine # [ 78.481318] systemd[1]: Stopped target Local File Systems. machine # [ 78.752296] systemd[1]: Reload requested from client PID 5600 ('.switch-to-conf') (unit backdoor.service)... machine # [ 78.754005] systemd[1]: Reloading... machine # [ 79.073171] systemd[1]: Reloading finished in 317 ms. machine # [ 79.156156] systemd[561]: Reexecution requested from client PID 5669 ('switch-to-confi')... machine # [ 79.160107] systemd[561]: Reexecuting. machine # [ 79.215453] systemd[561]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 79.330226] systemd[561]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 79.336939] systemd[561]: Reload requested from client PID 5669 ('switch-to-confi')... machine # [ 79.340991] systemd[561]: Reloading... machine # [ 79.447851] systemd[561]: Reloading finished in 107 ms. machine # [ 79.464197] systemd[561]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 79.473691] systemd[561]: Stopped Run user-specific NixOS activation. machine # [ 79.476169] systemd[561]: Stopping Run user-specific NixOS activation... machine # [ 79.478688] systemd[561]: Starting Run user-specific NixOS activation... machine # [ 79.512619] systemd[561]: Finished Run user-specific NixOS activation. machine # [ 79.517001] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 79.518024] systemd[1]: Stopping Reactivate sysinit units... machine # [ 79.523207] systemd[1]: Reached target Reactivate sysinit units. machine # [ 79.524849] systemd[1]: test.service: Deactivated successfully. machine # [ 79.525809] systemd[1]: Stopped test.service. machine # [ 79.526485] systemd[1]: Stopping test.service... machine # [ 79.528565] systemd[1]: Starting test.service... machine # [ 79.554792] systemd[1]: Finished test.service. machine # [ 79.559054] systemd[1]: Reached target Remote File Systems. machine # [ 79.563635] systemd[1]: Starting linger-users.service... machine # [ 79.576115] systemd[1]: Reached target Local File Systems. machine # [ 79.577101] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 79.583216] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 79.586920] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 79.596808] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 79.599229] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 79.611286] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 79.615842] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 79.618726] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 79.623857] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 79.659995] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 79.663433] systemd[1]: Finished linger-users.service. machine # [ 79.791222] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 79.793822] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 80.050177] nixos[5600]: finished switching to system configuration /nix/store/s1qjllm569abgzgy05cdnix3pd4116lm-nixos-system-machine-test machine: (finished: must succeed: /nix/store/b2rywx23jb5nhi7b4xfic9vflyz9nzq1-nixos-system-machine-test/specialisation/simpleServiceWithExtraKey/bin/switch-to-configuration test 2>&1, in 1.80 seconds) machine: must succeed: /nix/store/b2rywx23jb5nhi7b4xfic9vflyz9nzq1-nixos-system-machine-test/specialisation/simpleServiceWithExtraKeyOtherValue/bin/switch-to-configuration test 2>&1 machine # [ 80.276874] nixos[5742]: switching to system configuration /nix/store/7v8lhyzy1h28smfh3gjqx0z0qv1rh3rw-nixos-system-machine-test machine # [ 80.279565] systemd[1]: Stopped target Remote File Systems. machine # [ 80.282001] systemd[1]: Stopped target Local File Systems. machine # [ 80.561704] systemd[1]: Reload requested from client PID 5742 ('.switch-to-conf') (unit backdoor.service)... machine # [ 80.563665] systemd[1]: Reloading... machine # [ 80.882773] systemd[1]: Reloading finished in 317 ms. machine # [ 80.968713] systemd[561]: Reexecution requested from client PID 5811 ('switch-to-confi')... machine # [ 80.972352] systemd[561]: Reexecuting. machine # [ 81.023239] systemd[561]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 81.131176] systemd[561]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 81.137927] systemd[561]: Reload requested from client PID 5811 ('switch-to-confi')... machine # [ 81.140392] systemd[561]: Reloading... machine # [ 81.242995] systemd[561]: Reloading finished in 101 ms. machine # [ 81.256159] systemd[561]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 81.265851] systemd[561]: Stopped Run user-specific NixOS activation. machine # [ 81.268121] systemd[561]: Stopping Run user-specific NixOS activation... machine # [ 81.270154] systemd[561]: Starting Run user-specific NixOS activation... machine # [ 81.302809] systemd[561]: Finished Run user-specific NixOS activation. machine # [ 81.306312] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 81.310909] systemd[1]: Stopping Reactivate sysinit units... machine # [ 81.311810] systemd[1]: Reached target Reactivate sysinit units. machine # [ 81.313019] systemd[1]: test.service: Deactivated successfully. machine # [ 81.313953] systemd[1]: Stopped test.service. machine # [ 81.314629] systemd[1]: Stopping test.service... machine # [ 81.316222] systemd[1]: Starting test.service... machine # [ 81.340291] systemd[1]: Finished test.service. machine # [ 81.343059] systemd[1]: Reached target Remote File Systems. machine # [ 81.348131] systemd[1]: Reached target Local File Systems. machine # [ 81.352455] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 81.361325] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 81.362268] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 81.363554] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 81.373432] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 81.375511] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 81.378607] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 81.380436] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 81.381828] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 81.521911] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 81.526499] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 81.528772] systemd[1]: Starting linger-users.service... machine # [ 81.567452] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 81.570474] systemd[1]: Finished linger-users.service. machine # [ 81.824660] nixos[5742]: finished switching to system configuration /nix/store/7v8lhyzy1h28smfh3gjqx0z0qv1rh3rw-nixos-system-machine-test machine: (finished: must succeed: /nix/store/b2rywx23jb5nhi7b4xfic9vflyz9nzq1-nixos-system-machine-test/specialisation/simpleServiceWithExtraKeyOtherValue/bin/switch-to-configuration test 2>&1, in 1.77 seconds) machine: must succeed: /nix/store/b2rywx23jb5nhi7b4xfic9vflyz9nzq1-nixos-system-machine-test/specialisation/simpleServiceWithExtraKeyOtherName/bin/switch-to-configuration test 2>&1 machine # [ 82.138272] nixos[5884]: switching to system configuration /nix/store/q1brv9w8qdrvhj4n3v2ncfrr1i2h9628-nixos-system-machine-test machine # [ 82.142181] systemd[1]: Stopped target Local File Systems. machine # [ 82.145948] systemd[1]: Stopped target Remote File Systems. machine # [ 82.428274] systemd[1]: Reload requested from client PID 5884 ('.switch-to-conf') (unit backdoor.service)... machine # [ 82.430373] systemd[1]: Reloading... machine # [ 82.742208] systemd[1]: Reloading finished in 310 ms. machine # [ 82.825329] systemd[561]: Reexecution requested from client PID 5953 ('switch-to-confi')... machine # [ 82.829588] systemd[561]: Reexecuting. machine # [ 82.887263] systemd[561]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 83.000266] systemd[561]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 83.007788] systemd[561]: Reload requested from client PID 5953 ('switch-to-confi')... machine # [ 83.010982] systemd[561]: Reloading... machine # [ 83.115472] systemd[561]: Reloading finished in 105 ms. machine # [ 83.132186] systemd[561]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 83.142712] systemd[561]: Stopped Run user-specific NixOS activation. machine # [ 83.145072] systemd[561]: Stopping Run user-specific NixOS activation... machine # [ 83.147390] systemd[561]: Starting Run user-specific NixOS activation... machine # [ 83.179673] systemd[561]: Finished Run user-specific NixOS activation. machine # [ 83.183478] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 83.184903] systemd[1]: Stopping Reactivate sysinit units... machine # [ 83.185774] systemd[1]: Reached target Reactivate sysinit units. machine # [ 83.187974] systemd[1]: test.service: Deactivated successfully. machine # [ 83.191266] systemd[1]: Stopped test.service. machine # [ 83.191946] systemd[1]: Stopping test.service... machine # [ 83.196181] systemd[1]: Starting test.service... machine # [ 83.216176] systemd[1]: Finished test.service. machine # [ 83.218969] systemd[1]: Reached target Remote File Systems. machine # [ 83.223223] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 83.226258] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 83.229651] systemd[1]: Reached target Local File Systems. machine # [ 83.234976] systemd[1]: Starting linger-users.service... machine # [ 83.240086] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 83.251618] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 83.256602] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 83.257987] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 83.260901] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 83.263103] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 83.267525] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 83.320504] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 83.323585] systemd[1]: Finished linger-users.service. machine # [ 83.444360] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 83.447745] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 83.701945] nixos[5884]: finished switching to system configuration /nix/store/q1brv9w8qdrvhj4n3v2ncfrr1i2h9628-nixos-system-machine-test machine: (finished: must succeed: /nix/store/b2rywx23jb5nhi7b4xfic9vflyz9nzq1-nixos-system-machine-test/specialisation/simpleServiceWithExtraKeyOtherName/bin/switch-to-configuration test 2>&1, in 1.88 seconds) machine: must succeed: /nix/store/b2rywx23jb5nhi7b4xfic9vflyz9nzq1-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1 machine # [ 83.919792] nixos[6026]: switching to system configuration /nix/store/575y7wkacypk0xlzf3dhxi8hq8nziqi0-nixos-system-machine-test machine # [ 83.922890] systemd[1]: Stopped target Remote File Systems. machine # [ 83.925962] systemd[1]: Stopped target Local File Systems. machine # [ 84.190063] systemd[1]: Reload requested from client PID 6026 ('.switch-to-conf') (unit backdoor.service)... machine # [ 84.192583] systemd[1]: Reloading... machine # [ 84.523475] systemd[1]: Reloading finished in 329 ms. machine # [ 84.613874] systemd[561]: Reexecution requested from client PID 6094 ('switch-to-confi')... machine # [ 84.618534] systemd[561]: Reexecuting. machine # [ 84.675518] systemd[561]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 84.791047] systemd[561]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 84.798169] systemd[561]: Reload requested from client PID 6094 ('switch-to-confi')... machine # [ 84.802468] systemd[561]: Reloading... machine # [ 84.910653] systemd[561]: Reloading finished in 109 ms. machine # [ 84.929793] systemd[561]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 84.938813] systemd[561]: Stopped Run user-specific NixOS activation. machine # [ 84.941411] systemd[561]: Stopping Run user-specific NixOS activation... machine # [ 84.943902] systemd[561]: Starting Run user-specific NixOS activation... machine # [ 84.977288] systemd[561]: Finished Run user-specific NixOS activation. machine # [ 84.981419] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 84.983810] systemd[1]: Stopping Reactivate sysinit units... machine # [ 84.987926] systemd[1]: Reached target Reactivate sysinit units. machine # [ 84.990672] systemd[1]: test.service: Deactivated successfully. machine # [ 84.991615] systemd[1]: Stopped test.service. machine # [ 84.992718] systemd[1]: Stopping test.service... machine # [ 84.993429] systemd[1]: Starting test.service... machine # [ 85.017496] systemd[1]: Finished test.service. machine # [ 85.022413] systemd[1]: Reached target Remote File Systems. machine # [ 85.027070] systemd[1]: Starting linger-users.service... machine # [ 85.032264] systemd[1]: Reached target Local File Systems. machine # [ 85.040528] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 85.042084] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 85.048122] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 85.058003] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 85.059021] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 85.069359] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 85.071876] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 85.079595] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 85.084982] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 85.127313] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 85.131869] systemd[1]: Finished linger-users.service. machine # [ 85.274247] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 85.277977] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 85.532544] nixos[6026]: finished switching to system configuration /nix/store/575y7wkacypk0xlzf3dhxi8hq8nziqi0-nixos-system-machine-test machine: (finished: must succeed: /nix/store/b2rywx23jb5nhi7b4xfic9vflyz9nzq1-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1, in 1.83 seconds) machine: must succeed: /nix/store/b2rywx23jb5nhi7b4xfic9vflyz9nzq1-nixos-system-machine-test/specialisation/simpleServiceReloadTrigger/bin/switch-to-configuration test 2>&1 machine # [ 85.770646] nixos[6168]: switching to system configuration /nix/store/n175q00z4xzkr7n7blih6wv850a1ax0r-nixos-system-machine-test machine # [ 85.775893] systemd[1]: Stopped target Local File Systems. machine # [ 85.778349] systemd[1]: Stopped target Remote File Systems. machine # [ 86.059378] systemd[1]: Reload requested from client PID 6168 ('.switch-to-conf') (unit backdoor.service)... machine # [ 86.061672] systemd[1]: Reloading... machine # [ 86.384845] systemd[1]: Reloading finished in 321 ms. machine # [ 86.469881] systemd[561]: Reexecution requested from client PID 6237 ('switch-to-confi')... machine # [ 86.474611] systemd[561]: Reexecuting. machine # [ 86.523229] systemd[561]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 86.637355] systemd[561]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 86.644239] systemd[561]: Reload requested from client PID 6237 ('switch-to-confi')... machine # [ 86.647201] systemd[561]: Reloading... machine # [ 86.759952] systemd[561]: Reloading finished in 111 ms. machine # [ 86.776513] systemd[561]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 86.789062] systemd[561]: Stopped Run user-specific NixOS activation. machine # [ 86.792207] systemd[561]: Stopping Run user-specific NixOS activation... machine # [ 86.794927] systemd[561]: Starting Run user-specific NixOS activation... machine # [ 86.832388] systemd[561]: Finished Run user-specific NixOS activation. machine # [ 86.837232] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 86.842630] systemd[1]: Stopping Reactivate sysinit units... machine # [ 86.843650] systemd[1]: Reached target Reactivate sysinit units. machine # [ 86.845960] systemd[1]: Reloading test.service... machine # [ 86.876770] systemd[1]: Reloaded test.service. machine # [ 86.880931] systemd[1]: Reached target Remote File Systems. machine # [ 86.885035] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 86.891295] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 86.894669] systemd[1]: Starting linger-users.service... machine # [ 86.908722] systemd[1]: Reached target Local File Systems. machine # [ 86.910644] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 86.918991] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 86.925935] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 86.934302] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 86.943539] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 86.946852] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 86.951527] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 87.002117] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 87.004498] systemd[1]: Finished linger-users.service. machine # [ 87.169047] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 87.172977] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 87.429862] nixos[6168]: finished switching to system configuration /nix/store/n175q00z4xzkr7n7blih6wv850a1ax0r-nixos-system-machine-test machine: (finished: must succeed: /nix/store/b2rywx23jb5nhi7b4xfic9vflyz9nzq1-nixos-system-machine-test/specialisation/simpleServiceReloadTrigger/bin/switch-to-configuration test 2>&1, in 1.90 seconds) machine: must succeed: /nix/store/b2rywx23jb5nhi7b4xfic9vflyz9nzq1-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModified/bin/switch-to-configuration test 2>&1 machine # [ 87.676767] nixos[6310]: switching to system configuration /nix/store/w8n16s939893hi4by7pbfqd2xxjlyvbb-nixos-system-machine-test machine # [ 87.679549] systemd[1]: Stopped target Remote File Systems. machine # [ 87.682759] systemd[1]: Stopped target Local File Systems. machine # [ 87.965171] systemd[1]: Reload requested from client PID 6310 ('.switch-to-conf') (unit backdoor.service)... machine # [ 87.967335] systemd[1]: Reloading... machine # [ 88.288215] systemd[1]: Reloading finished in 318 ms. machine # [ 88.372212] systemd[561]: Reexecution requested from client PID 6379 ('switch-to-confi')... machine # [ 88.376888] systemd[561]: Reexecuting. machine # [ 88.423576] systemd[561]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 88.530935] systemd[561]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 88.537311] systemd[561]: Reload requested from client PID 6379 ('switch-to-confi')... machine # [ 88.539680] systemd[561]: Reloading... machine # [ 88.643390] systemd[561]: Reloading finished in 102 ms. machine # [ 88.660171] systemd[561]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 88.669746] systemd[561]: Stopped Run user-specific NixOS activation. machine # [ 88.672106] systemd[561]: Stopping Run user-specific NixOS activation... machine # [ 88.674267] systemd[561]: Starting Run user-specific NixOS activation... machine # [ 88.702977] systemd[561]: Finished Run user-specific NixOS activation. machine # [ 88.706775] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 88.710910] systemd[1]: Stopping Reactivate sysinit units... machine # [ 88.711874] systemd[1]: Reached target Reactivate sysinit units. machine # [ 88.713961] systemd[1]: Reloading test.service... machine # [ 88.736268] systemd[1]: Reloaded test.service. machine # [ 88.742531] systemd[1]: Reached target Local File Systems. machine # [ 88.745986] systemd[1]: Reached target Remote File Systems. machine # [ 88.746872] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 88.750314] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 88.751245] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 88.759892] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 88.762886] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 88.770871] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 88.772315] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 88.773623] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 88.774900] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 88.921493] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 88.926792] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 88.929087] systemd[1]: Starting linger-users.service... machine # [ 88.968511] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 88.970817] systemd[1]: Finished linger-users.service. machine # [ 89.226795] nixos[6310]: finished switching to system configuration /nix/store/w8n16s939893hi4by7pbfqd2xxjlyvbb-nixos-system-machine-test machine: (finished: must succeed: /nix/store/b2rywx23jb5nhi7b4xfic9vflyz9nzq1-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModified/bin/switch-to-configuration test 2>&1, in 1.80 seconds) machine: must succeed: /nix/store/b2rywx23jb5nhi7b4xfic9vflyz9nzq1-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModifiedAndSomethingElse/bin/switch-to-configuration test 2>&1 machine # [ 89.444556] nixos[6452]: switching to system configuration /nix/store/xqvkqsy7g9mpmkzwsvny5yabywwmf1qy-nixos-system-machine-test machine # [ 89.447344] systemd[1]: Stopped target Local File Systems. machine # [ 89.449728] systemd[1]: Stopped target Remote File Systems. machine # [ 89.719714] systemd[1]: Reload requested from client PID 6452 ('.switch-to-conf') (unit backdoor.service)... machine # [ 89.721940] systemd[1]: Reloading... machine # [ 90.032635] systemd[1]: Reloading finished in 309 ms. machine # [ 90.115553] systemd[561]: Reexecution requested from client PID 6521 ('switch-to-confi')... machine # [ 90.119238] systemd[561]: Reexecuting. machine # [ 90.171365] systemd[561]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 90.281619] systemd[561]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 90.288191] systemd[561]: Reload requested from client PID 6521 ('switch-to-confi')... machine # [ 90.290568] systemd[561]: Reloading... machine # [ 90.405115] systemd[561]: Reloading finished in 113 ms. machine # [ 90.420198] systemd[561]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 90.430352] systemd[561]: Stopped Run user-specific NixOS activation. machine # [ 90.433190] systemd[561]: Stopping Run user-specific NixOS activation... machine # [ 90.435531] systemd[561]: Starting Run user-specific NixOS activation... machine # [ 90.470886] systemd[561]: Finished Run user-specific NixOS activation. machine # [ 90.476814] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 90.478040] systemd[1]: Stopping Reactivate sysinit units... machine # [ 90.478903] systemd[1]: Reached target Reactivate sysinit units. machine # [ 90.483804] systemd[1]: test.service: Deactivated successfully. machine # [ 90.486693] systemd[1]: Stopped test.service. machine # [ 90.487457] systemd[1]: Stopping test.service... machine # [ 90.492392] systemd[1]: Starting test.service... machine # [ 90.515306] systemd[1]: Finished test.service. machine # [ 90.519199] systemd[1]: Reached target Local File Systems. machine # [ 90.523016] systemd[1]: Reached target Remote File Systems. machine # [ 90.528197] systemd[1]: Starting linger-users.service... machine # [ 90.542845] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 90.556568] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 90.557761] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 90.559236] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 90.574392] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 90.578711] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 90.583336] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 90.589112] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 90.590682] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 90.626135] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 90.629042] systemd[1]: Finished linger-users.service. machine # [ 90.761655] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 90.764551] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 91.020467] nixos[6452]: finished switching to system configuration /nix/store/xqvkqsy7g9mpmkzwsvny5yabywwmf1qy-nixos-system-machine-test machine: (finished: must succeed: /nix/store/b2rywx23jb5nhi7b4xfic9vflyz9nzq1-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModifiedAndSomethingElse/bin/switch-to-configuration test 2>&1, in 1.79 seconds) machine: must succeed: /nix/store/b2rywx23jb5nhi7b4xfic9vflyz9nzq1-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModifiedSomethingElse/bin/switch-to-configuration test 2>&1 machine # [ 91.237639] nixos[6594]: switching to system configuration /nix/store/s1qjllm569abgzgy05cdnix3pd4116lm-nixos-system-machine-test machine # [ 91.240066] systemd[1]: Stopped target Remote File Systems. machine # [ 91.242626] systemd[1]: Stopped target Local File Systems. machine # [ 91.503795] systemd[1]: Reload requested from client PID 6594 ('.switch-to-conf') (unit backdoor.service)... machine # [ 91.506296] systemd[1]: Reloading... machine # [ 91.838251] systemd[1]: Reloading finished in 330 ms. machine # [ 91.931287] systemd[561]: Reexecution requested from client PID 6663 ('switch-to-confi')... machine # [ 91.933366] systemd[561]: Reexecuting. machine # [ 91.987290] systemd[561]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 92.103784] systemd[561]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 92.110722] systemd[561]: Reload requested from client PID 6663 ('switch-to-confi')... machine # [ 92.113444] systemd[561]: Reloading... machine # [ 92.222500] systemd[561]: Reloading finished in 108 ms. machine # [ 92.244215] systemd[561]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 92.254325] systemd[561]: Stopped Run user-specific NixOS activation. machine # [ 92.256719] systemd[561]: Stopping Run user-specific NixOS activation... machine # [ 92.258968] systemd[561]: Starting Run user-specific NixOS activation... machine # [ 92.292550] systemd[561]: Finished Run user-specific NixOS activation. machine # [ 92.296741] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 92.300285] systemd[1]: Stopping Reactivate sysinit units... machine # [ 92.301194] systemd[1]: Reached target Reactivate sysinit units. machine # [ 92.302097] systemd[1]: Reached target Local File Systems. machine # [ 92.302891] systemd[1]: Reached target Remote File Systems. machine # [ 92.308585] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 92.309980] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 92.312990] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 92.319730] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 92.322153] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 92.323493] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 92.334643] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 92.336564] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 92.337885] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 92.486905] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 92.491091] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 92.493277] systemd[1]: Starting linger-users.service... machine # [ 92.532957] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 92.535902] systemd[1]: Finished linger-users.service. machine # [ 92.789789] nixos[6594]: finished switching to system configuration /nix/store/s1qjllm569abgzgy05cdnix3pd4116lm-nixos-system-machine-test machine: (finished: must succeed: /nix/store/b2rywx23jb5nhi7b4xfic9vflyz9nzq1-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModifiedSomethingElse/bin/switch-to-configuration test 2>&1, in 1.77 seconds) (finished: subtest: unit file parser, in 23.44 seconds) subtest: restart and reload by activation script machine: must succeed: /nix/store/b2rywx23jb5nhi7b4xfic9vflyz9nzq1-nixos-system-machine-test/specialisation/simpleServiceNorestart/bin/switch-to-configuration test 2>&1 machine # [ 92.989566] nixos[6734]: switching to system configuration /nix/store/wgawr0ylgrwhwgg9kgngzf3x28l7rjv4-nixos-system-machine-test machine # [ 92.993888] systemd[1]: Stopped target Remote File Systems. machine # [ 92.995380] systemd[1]: Stopped target Local File Systems. machine # [ 93.241093] systemd[1]: Reload requested from client PID 6734 ('.switch-to-conf') (unit backdoor.service)... machine # [ 93.243054] systemd[1]: Reloading... machine # [ 93.539348] systemd[1]: Reloading finished in 294 ms. machine # [ 93.623702] systemd[561]: Reexecution requested from client PID 6803 ('switch-to-confi')... machine # [ 93.627461] systemd[561]: Reexecuting. machine # [ 93.675075] systemd[561]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 93.783044] systemd[561]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 93.789458] systemd[561]: Reload requested from client PID 6803 ('switch-to-confi')... machine # [ 93.791802] systemd[561]: Reloading... machine # [ 93.897103] systemd[561]: Reloading finished in 104 ms. machine # [ 93.912273] systemd[561]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 93.922313] systemd[561]: Stopped Run user-specific NixOS activation. machine # [ 93.924712] systemd[561]: Stopping Run user-specific NixOS activation... machine # [ 93.926932] systemd[561]: Starting Run user-specific NixOS activation... machine # [ 93.960974] systemd[561]: Finished Run user-specific NixOS activation. machine # [ 93.965177] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 93.967898] systemd[1]: Stopping Reactivate sysinit units... machine # [ 93.970330] systemd[1]: Reached target Reactivate sysinit units. machine # [ 93.971266] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 93.976815] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 93.978370] systemd[1]: Reached target Remote File Systems. machine # [ 93.980733] systemd[1]: Starting linger-users.service... machine # [ 93.984985] systemd[1]: Reached target Local File Systems. machine # [ 93.996587] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 94.006352] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 94.007471] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 94.018434] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 94.026619] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 94.029988] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 94.031472] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 94.080826] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 94.085084] systemd[1]: Finished linger-users.service. machine # [ 94.240560] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 94.244464] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 94.499001] nixos[6734]: finished switching to system configuration /nix/store/wgawr0ylgrwhwgg9kgngzf3x28l7rjv4-nixos-system-machine-test machine: (finished: must succeed: /nix/store/b2rywx23jb5nhi7b4xfic9vflyz9nzq1-nixos-system-machine-test/specialisation/simpleServiceNorestart/bin/switch-to-configuration test 2>&1, in 1.71 seconds) machine: must succeed: /nix/store/b2rywx23jb5nhi7b4xfic9vflyz9nzq1-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration test 2>&1 machine # [ 94.749084] nixos[6874]: switching to system configuration /nix/store/91z4m1r83phb2pn7m6bwrmpbrcbnkd2d-nixos-system-machine-test machine # [ 94.752632] systemd[1]: Stopped target Remote File Systems. machine # [ 94.754740] systemd[1]: Stopped target Local File Systems. machine # [ 94.756825] systemd[1]: test.service: Deactivated successfully. machine # [ 94.758542] systemd[1]: Stopped test.service. machine # [ 95.056747] systemd[1]: Reload requested from client PID 6874 ('.switch-to-conf') (unit backdoor.service)... machine # [ 95.058794] systemd[1]: Reloading... machine # [ 95.482539] systemd[1]: Reloading finished in 422 ms. machine # [ 95.579412] systemd[561]: Reexecution requested from client PID 6945 ('switch-to-confi')... machine # [ 95.585197] systemd[561]: Reexecuting. machine # [ 95.635646] systemd[561]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 95.746174] systemd[561]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 95.753128] systemd[561]: Reload requested from client PID 6945 ('switch-to-confi')... machine # [ 95.755754] systemd[561]: Reloading... machine # [ 95.862842] systemd[561]: Reloading finished in 106 ms. machine # [ 95.880183] systemd[561]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 95.889814] systemd[561]: Stopped Run user-specific NixOS activation. machine # [ 95.892083] systemd[561]: Stopping Run user-specific NixOS activation... machine # [ 95.894772] systemd[561]: Starting Run user-specific NixOS activation... machine # [ 95.928129] systemd[561]: Finished Run user-specific NixOS activation. machine # [ 95.932427] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 95.934365] systemd[1]: Stopping Reactivate sysinit units... machine # [ 95.935240] systemd[1]: Reached target Reactivate sysinit units. machine # [ 95.941671] systemd[1]: Created slice Slice /system/templated-no-restart-service. machine # [ 95.945996] systemd[1]: Starting templated-no-restart-service@instance.service... machine # [ 95.964238] systemd[1]: Starting simple-restart-service.service... machine # [ 95.974747] systemd[1]: Starting simple-reload-service.service... machine # [ 95.992190] systemd[1]: Created slice Slice /system/templated-simple-reload-service. machine # [ 96.000867] systemd[1]: Starting templated-simple-reload-service@instance.service... machine # [ 96.002216] systemd[1]: Reached target Local File Systems. machine # [ 96.003171] systemd[1]: Reached target Remote File Systems. machine # [ 96.026202] systemd[1]: Created slice Slice /system/templated-reload-triggers-and-restart-by-as. machine # [ 96.027659] systemd[1]: Starting templated-reload-triggers-and-restart-by-as@instance.service... machine # [ 96.061531] systemd[1]: Starting simple-service.service... machine # [ 96.062525] systemd[1]: Created slice Slice /system/templated-simple-service. machine # [ 96.063661] systemd[1]: Starting templated-simple-service@instance.service... machine # [ 96.097059] systemd[1]: Finished templated-no-restart-service@instance.service. machine # [ 96.098187] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 96.099670] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 96.132822] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 96.146521] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 96.160978] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 96.176506] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 96.181600] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 96.183129] systemd[1]: Created slice Slice /system/templated-simple-restart-service. machine # [ 96.188609] systemd[1]: Created slice Slice /system/templated-reload-triggers. machine # [ 96.189739] systemd[1]: Created slice Slice /system/templated-reload-triggers-and-restart. machine # [ 96.190846] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 96.193481] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 96.194811] systemd[1]: Finished simple-restart-service.service. machine # [ 96.195656] systemd[1]: Finished simple-reload-service.service. machine # [ 96.197114] systemd[1]: Finished templated-simple-reload-service@instance.service. machine # [ 96.198483] systemd[1]: Finished templated-reload-triggers-and-restart-by-as@instance.service. machine # [ 96.200964] systemd[1]: Finished simple-service.service. machine # [ 96.203898] systemd[1]: Finished templated-simple-service@instance.service. machine # [ 96.337124] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 96.340541] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 96.344341] systemd[1]: Starting linger-users.service... machine # [ 96.348474] systemd[1]: Starting no-restart-service.service... machine # [ 96.362373] systemd[1]: Starting reload-triggers-and-restart-by-as.service... machine # [ 96.363494] systemd[1]: Starting reload-triggers-and-restart.service... machine # [ 96.384482] systemd[1]: Starting reload-triggers.service... machine # [ 96.385347] systemd[1]: Starting templated-reload-triggers-and-restart@instance.service... machine # [ 96.392905] systemd[1]: Starting templated-reload-triggers@instance.service... machine # [ 96.403494] systemd[1]: Starting templated-simple-restart-service@instance.service... machine # [ 96.486082] systemd[1]: Finished reload-triggers-and-restart-by-as.service. machine # [ 96.498439] systemd[1]: Finished reload-triggers-and-restart.service. machine # [ 96.499573] systemd[1]: Finished templated-reload-triggers-and-restart@instance.service. machine # [ 96.508251] systemd[1]: Finished reload-triggers.service. machine # [ 96.509157] systemd[1]: Finished templated-reload-triggers@instance.service. machine # [ 96.510155] systemd[1]: Finished no-restart-service.service. machine # [ 96.519936] systemd[1]: Finished templated-simple-restart-service@instance.service. machine # [ 96.532870] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 96.535045] systemd[1]: Finished linger-users.service. machine # [ 96.791765] nixos[6874]: finished switching to system configuration /nix/store/91z4m1r83phb2pn7m6bwrmpbrcbnkd2d-nixos-system-machine-test machine: (finished: must succeed: /nix/store/b2rywx23jb5nhi7b4xfic9vflyz9nzq1-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration test 2>&1, in 2.29 seconds) machine: must succeed: /nix/store/b2rywx23jb5nhi7b4xfic9vflyz9nzq1-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration test 2>&1 machine # [ 97.029601] nixos[7044]: switching to system configuration /nix/store/91z4m1r83phb2pn7m6bwrmpbrcbnkd2d-nixos-system-machine-test machine # [ 97.034837] systemd[1]: Stopped target Remote File Systems. machine # [ 97.035764] systemd[1]: Stopped target Local File Systems. machine # [ 97.294396] systemd[1]: Reload requested from client PID 7044 ('.switch-to-conf') (unit backdoor.service)... machine # [ 97.296360] systemd[1]: Reloading... machine # [ 97.611516] systemd[1]: Reloading finished in 313 ms. machine # [ 97.699974] systemd[561]: Reexecution requested from client PID 7115 ('switch-to-confi')... machine # [ 97.701447] systemd[561]: Reexecuting. machine # [ 97.763370] systemd[561]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 97.880768] systemd[561]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 97.887402] systemd[561]: Reload requested from client PID 7115 ('switch-to-confi')... machine # [ 97.890808] systemd[561]: Reloading... machine # [ 97.995827] systemd[561]: Reloading finished in 106 ms. machine # [ 98.012176] systemd[561]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 98.021768] systemd[561]: Stopped Run user-specific NixOS activation. machine # [ 98.024191] systemd[561]: Stopping Run user-specific NixOS activation... machine # [ 98.026603] systemd[561]: Starting Run user-specific NixOS activation... machine # [ 98.060117] systemd[561]: Finished Run user-specific NixOS activation. machine # [ 98.064687] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 98.066268] systemd[1]: Stopping Reactivate sysinit units... machine # [ 98.067210] systemd[1]: Reached target Reactivate sysinit units. machine # [ 98.073810] systemd[1]: Reloading reload-triggers-and-restart.service... machine # [ 98.082956] systemd[1]: Reloading reload-triggers.service... machine # [ 98.096206] systemd[1]: Reloading simple-reload-service.service... machine # [ 98.100563] systemd[1]: Reloading templated-reload-triggers-and-restart@instance.service... machine # [ 98.113457] systemd[1]: Reloading templated-reload-triggers@instance.service... machine # [ 98.122017] systemd[1]: Reloading templated-simple-reload-service@instance.service... machine # [ 98.181974] systemd[1]: Reloaded reload-triggers-and-restart.service. machine # [ 98.186818] systemd[1]: Reloaded reload-triggers.service. machine # [ 98.194981] systemd[1]: Reloaded simple-reload-service.service. machine # [ 98.196002] systemd[1]: Reloaded templated-reload-triggers-and-restart@instance.service. machine # [ 98.204844] systemd[1]: Reloaded templated-reload-triggers@instance.service. machine # [ 98.207346] systemd[1]: Reloaded templated-simple-reload-service@instance.service. machine # [ 98.212153] systemd[1]: reload-triggers-and-restart-by-as.service: Deactivated successfully. machine # [ 98.213398] systemd[1]: Stopped reload-triggers-and-restart-by-as.service. machine # [ 98.214560] systemd[1]: Stopping reload-triggers-and-restart-by-as.service... machine # [ 98.220305] systemd[1]: Starting reload-triggers-and-restart-by-as.service... machine # [ 98.221372] systemd[1]: simple-restart-service.service: Deactivated successfully. machine # [ 98.222495] systemd[1]: Stopped simple-restart-service.service. machine # [ 98.223353] systemd[1]: Stopping simple-restart-service.service... machine # [ 98.228754] systemd[1]: Starting simple-restart-service.service... machine # [ 98.229703] systemd[1]: simple-service.service: Deactivated successfully. machine # [ 98.230651] systemd[1]: Stopped simple-service.service. machine # [ 98.231446] systemd[1]: Stopping simple-service.service... machine # [ 98.242769] systemd[1]: Starting simple-service.service... machine # [ 98.243634] systemd[1]: templated-reload-triggers-and-restart-by-as@instance.service: Deactivated successfully. machine # [ 98.264204] systemd[1]: Stopped templated-reload-triggers-and-restart-by-as@instance.service. machine # [ 98.265513] systemd[1]: Stopping templated-reload-triggers-and-restart-by-as@instance.service... machine # [ 98.266745] systemd[1]: Starting templated-reload-triggers-and-restart-by-as@instance.service... machine # [ 98.267971] systemd[1]: templated-simple-restart-service@instance.service: Deactivated successfully. machine # [ 98.294883] systemd[1]: Stopped templated-simple-restart-service@instance.service. machine # [ 98.305255] systemd[1]: Stopping templated-simple-restart-service@instance.service... machine # [ 98.319502] systemd[1]: Starting templated-simple-restart-service@instance.service... machine # [ 98.329748] systemd[1]: templated-simple-service@instance.service: Deactivated successfully. machine # [ 98.342622] systemd[1]: Stopped templated-simple-service@instance.service. machine # [ 98.344003] systemd[1]: Stopping templated-simple-service@instance.service... machine # [ 98.353221] systemd[1]: Starting templated-simple-service@instance.service... machine # [ 98.355433] systemd[1]: Finished reload-triggers-and-restart-by-as.service. machine # [ 98.358358] systemd[1]: Finished simple-restart-service.service. machine # [ 98.359875] systemd[1]: Finished simple-service.service. machine # [ 98.362437] systemd[1]: Finished templated-reload-triggers-and-restart-by-as@instance.service. machine # [ 98.363755] systemd[1]: Finished templated-simple-restart-service@instance.service. machine # [ 98.369149] systemd[1]: Finished templated-simple-service@instance.service. machine # [ 98.370231] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 98.371530] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 98.375812] systemd[1]: Reached target Local File Systems. machine # [ 98.378930] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 98.385045] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 98.386002] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 98.387258] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 98.400986] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 98.402786] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 98.404182] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 98.405530] systemd[1]: Reached target Remote File Systems. machine # [ 98.559225] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 98.564515] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 98.566977] systemd[1]: Starting linger-users.service... machine # [ 98.609986] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 98.612377] systemd[1]: Finished linger-users.service. machine # [ 98.868543] nixos[7044]: finished switching to system configuration /nix/store/91z4m1r83phb2pn7m6bwrmpbrcbnkd2d-nixos-system-machine-test machine: (finished: must succeed: /nix/store/b2rywx23jb5nhi7b4xfic9vflyz9nzq1-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration test 2>&1, in 2.08 seconds) machine: must succeed: /nix/store/b2rywx23jb5nhi7b4xfic9vflyz9nzq1-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script-modified/bin/switch-to-configuration test 2>&1 machine # [ 99.154700] nixos[7210]: switching to system configuration /nix/store/7drxqhi0jrwnaagj604w0nz9n7sp36p8-nixos-system-machine-test machine # [ 99.158056] systemd[1]: Stopped target Local File Systems. machine # [ 99.159834] systemd[1]: Stopped target Remote File Systems. machine # [ 99.460075] systemd[1]: Reload requested from client PID 7210 ('.switch-to-conf') (unit backdoor.service)... machine # [ 99.462157] systemd[1]: Reloading... machine # [ 99.805667] systemd[1]: Reloading finished in 341 ms. machine # [ 99.891700] systemd[561]: Reexecution requested from client PID 7281 ('switch-to-confi')... machine # [ 99.893993] systemd[561]: Reexecuting. machine # [ 99.955841] systemd[561]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 100.070893] systemd[561]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 100.077372] systemd[561]: Reload requested from client PID 7281 ('switch-to-confi')... machine # [ 100.079784] systemd[561]: Reloading... machine # [ 100.184521] systemd[561]: Reloading finished in 103 ms. machine # [ 100.200178] systemd[561]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 100.210199] systemd[561]: Stopped Run user-specific NixOS activation. machine # [ 100.211237] systemd[561]: Stopping Run user-specific NixOS activation... machine # [ 100.213693] systemd[561]: Starting Run user-specific NixOS activation... machine # [ 100.242937] systemd[561]: Finished Run user-specific NixOS activation. machine # [ 100.247067] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 100.249868] systemd[1]: Stopping Reactivate sysinit units... machine # [ 100.250754] systemd[1]: Reached target Reactivate sysinit units. machine # [ 100.255221] systemd[1]: Reloading reload-triggers.service... machine # [ 100.270159] systemd[1]: Reloading simple-reload-service.service... machine # [ 100.273127] systemd[1]: Reloading templated-reload-triggers@instance.service... machine # [ 100.282019] systemd[1]: Reloading templated-simple-reload-service@instance.service... machine # [ 100.326265] systemd[1]: Reloaded reload-triggers.service. machine # [ 100.330263] systemd[1]: Reloaded simple-reload-service.service. machine # [ 100.335153] systemd[1]: Reloaded templated-reload-triggers@instance.service. machine # [ 100.340414] systemd[1]: Reloaded templated-simple-reload-service@instance.service. machine # [ 100.343842] systemd[1]: reload-triggers-and-restart-by-as.service: Deactivated successfully. machine # [ 100.351809] systemd[1]: Stopped reload-triggers-and-restart-by-as.service. machine # [ 100.353401] systemd[1]: Stopping reload-triggers-and-restart-by-as.service... machine # [ 100.354522] systemd[1]: Starting reload-triggers-and-restart-by-as.service... machine # [ 100.355541] systemd[1]: reload-triggers-and-restart.service: Deactivated successfully. machine # [ 100.372735] systemd[1]: Stopped reload-triggers-and-restart.service. machine # [ 100.373829] systemd[1]: Stopping reload-triggers-and-restart.service... machine # [ 100.374783] systemd[1]: Starting reload-triggers-and-restart.service... machine # [ 100.375724] systemd[1]: simple-restart-service.service: Deactivated successfully. machine # [ 100.401682] systemd[1]: Stopped simple-restart-service.service. machine # [ 100.402689] systemd[1]: Stopping simple-restart-service.service... machine # [ 100.403741] systemd[1]: Starting simple-restart-service.service... machine # [ 100.432829] systemd[1]: simple-service.service: Deactivated successfully. machine # [ 100.448527] systemd[1]: Stopped simple-service.service. machine # [ 100.459974] systemd[1]: Stopping simple-service.service... machine # [ 100.472371] systemd[1]: Starting simple-service.service... machine # [ 100.485251] systemd[1]: templated-reload-triggers-and-restart-by-as@instance.service: Deactivated successfully. machine # [ 100.501896] systemd[1]: Stopped templated-reload-triggers-and-restart-by-as@instance.service. machine # [ 100.515066] systemd[1]: Stopping templated-reload-triggers-and-restart-by-as@instance.service... machine # [ 100.522970] systemd[1]: Starting templated-reload-triggers-and-restart-by-as@instance.service... machine # [ 100.531483] systemd[1]: templated-reload-triggers-and-restart@instance.service: Deactivated successfully. machine # [ 100.537075] systemd[1]: Stopped templated-reload-triggers-and-restart@instance.service. machine # [ 100.538288] systemd[1]: Stopping templated-reload-triggers-and-restart@instance.service... machine # [ 100.539480] systemd[1]: Starting templated-reload-triggers-and-restart@instance.service... machine # [ 100.545675] systemd[1]: templated-simple-restart-service@instance.service: Deactivated successfully. machine # [ 100.547028] systemd[1]: Stopped templated-simple-restart-service@instance.service. machine # [ 100.549007] systemd[1]: Stopping templated-simple-restart-service@instance.service... machine # [ 100.550257] systemd[1]: Starting templated-simple-restart-service@instance.service... machine # [ 100.551362] systemd[1]: templated-simple-service@instance.service: Deactivated successfully. machine # [ 100.560864] systemd[1]: Stopped templated-simple-service@instance.service. machine # [ 100.561992] systemd[1]: Stopping templated-simple-service@instance.service... machine # [ 100.563028] systemd[1]: Starting templated-simple-service@instance.service... machine # [ 100.564658] systemd[1]: Finished reload-triggers-and-restart-by-as.service. machine # [ 100.565783] systemd[1]: Finished reload-triggers-and-restart.service. machine # [ 100.566707] systemd[1]: Finished simple-service.service. machine # [ 100.567499] systemd[1]: Finished simple-restart-service.service. machine # [ 100.579414] systemd[1]: Finished templated-reload-triggers-and-restart-by-as@instance.service. machine # [ 100.581553] systemd[1]: Finished templated-reload-triggers-and-restart@instance.service. machine # [ 100.582765] systemd[1]: Finished templated-simple-restart-service@instance.service. machine # [ 100.583860] systemd[1]: Finished templated-simple-service@instance.service. machine # [ 100.585316] systemd[1]: Reached target Remote File Systems. machine # [ 100.586186] systemd[1]: Reached target Local File Systems. machine # [ 100.586993] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 100.588637] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 100.589566] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 100.590853] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 100.594099] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 100.596885] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 100.600936] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 100.604172] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 100.605673] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 100.749642] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 100.754403] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 100.756685] systemd[1]: Starting linger-users.service... machine # [ 100.795249] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 100.798410] systemd[1]: Finished linger-users.service. machine # [ 101.052572] nixos[7210]: finished switching to system configuration /nix/store/7drxqhi0jrwnaagj604w0nz9n7sp36p8-nixos-system-machine-test machine: (finished: must succeed: /nix/store/b2rywx23jb5nhi7b4xfic9vflyz9nzq1-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script-modified/bin/switch-to-configuration test 2>&1, in 2.18 seconds) machine: must succeed: /nix/store/b2rywx23jb5nhi7b4xfic9vflyz9nzq1-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/b2rywx23jb5nhi7b4xfic9vflyz9nzq1-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration dry-activate 2>&1, in 0.33 seconds) (finished: subtest: restart and reload by activation script, in 8.60 seconds) (finished: run the VM test script, in 102.13 seconds) test script finished in 102.45s 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-27T03:15:03Z INFO virtiofsd] Client disconnected, shutting down machine # [2026-09-27T03:15:03Z INFO virtiofsd] Client disconnected, shutting down machine # [2026-09-27T03:15:03Z INFO virtiofsd] Client disconnected, shutting down (finished: cleanup, in 0.13 seconds) additionally exposed symbols: machine, other, vlan1, start_all, test_script, machines, machines_qemu, machines_nspawn, vlans, driver, log, os, create_machine, subtest, run_tests, join_all, retry, serial_stdout_off, serial_stdout_on, polling_condition, BaseMachine, QemuMachine, NspawnMachine, t, debug, dump_machine_ssh