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.01 seconds) Test will time out and terminate in 3600.0 seconds run the VM test script machine: waiting for unit multi-user.target machine: waiting for the VM to finish booting machine: starting vm machine # Disk image does not exist, creating the virtualisation disk image... machine: QEMU running (pid 45) machine # Formatting '/build/vm-state-machine/tmp.31fXKd9QEo', 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: ba3e954d-d93a-4fa7-8371-d9f1c9bbef23 machine # Superblock backups stored on blocks: machine # 32768, 98304, 163840, 229376 machine # machine # Allocating group tables: 0/8 done machine # Writing inode tables: 0/8 done machine # Creating journal (8192 blocks): done machine # Writing superblocks and filesystem accounting information: 0/8 done machine # machine # Virtualisation disk image created. machine # [ 0.000000] Booting Linux on physical CPU 0x0000000000 [0xc00fac40] machine # [ 0.000000] Linux version 6.18.48 (nixbld@localhost) (gcc (GCC) 15.3.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT Fri Aug 28 06:22:54 UTC 2026 machine # [ 0.000000] KASLR enabled machine # [ 0.000000] random: crng init done machine # [ 0.000000] Machine model: linux,dummy-virt machine # [ 0.000000] efi: UEFI not found. machine # [ 0.000000] OF: reserved mem: Reserved memory: No reserved-memory node in the DT machine # [ 0.000000] NUMA: Faking a node at [mem 0x0000000040000000-0x000000007fffffff] machine # [ 0.000000] NODE_DATA(0) allocated [mem 0x7fded700-0x7fdf0e7f] machine # [ 0.000000] Zone ranges: machine # [ 0.000000] DMA [mem 0x0000000040000000-0x000000007fffffff] machine # [ 0.000000] DMA32 empty machine # [ 0.000000] Normal empty machine # [ 0.000000] Device empty machine # [ 0.000000] Movable zone start for each node machine # [ 0.000000] Early memory node ranges machine # [ 0.000000] node 0: [mem 0x0000000040000000-0x000000007fffffff] machine # [ 0.000000] Initmem setup node 0 [mem 0x0000000040000000-0x000000007fffffff] machine # [ 0.000000] cma: Reserved 32 MiB at 0x000000007cc00000 machine # [ 0.000000] psci: probing for conduit method from DT. machine # [ 0.000000] psci: PSCIv1.3 detected in firmware. machine # [ 0.000000] psci: Using standard PSCI v0.2 function IDs machine # [ 0.000000] psci: Trusted OS migration not required machine # [ 0.000000] psci: SMC Calling Convention v1.1 machine # [ 0.000000] smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000003) machine # [ 0.000000] percpu: Embedded 76 pages/cpu s186648 r8192 d116456 u311296 machine # [ 0.000000] Detected PIPT I-cache on CPU0 machine # [ 0.000000] CPU features: detected: Address authentication (architected QARMA5 algorithm) machine # [ 0.000000] CPU features: detected: GICv3 CPU interface machine # [ 0.000000] CPU features: detected: Spectre-v4 machine # [ 0.000000] CPU features: detected: Spectre-BHB machine # [ 0.000000] CPU features: detected: AmpereOne erratum AC03_CPU_38 machine # [ 0.000000] CPU features: detected: AmpereOne erratum AC04_CPU_23 machine # [ 0.000000] alternatives: applying boot alternatives machine # [ 0.000000] Kernel command line: console=ttyAMA0 console=tty0 panic=1 boot.panic_on_fail clocksource=acpi_pm root=fstab loglevel=7 net.ifnames=0 lsm=landlock,yama,bpf init=/nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test/init regInfo=/nix/store/xnabmz5mzjmnf1ig382687zqn5523hkz-closure-info/registration console=ttyAMA0,115200n8 console=tty0 machine # [ 0.000000] Unknown kernel command line parameters "regInfo=/nix/store/xnabmz5mzjmnf1ig382687zqn5523hkz-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 74886 entries in 294 pages machine # [ 0.000000] ftrace: allocated 294 pages with 4 groups machine # [ 0.000000] rcu: Hierarchical RCU implementation. machine # [ 0.000000] rcu: RCU event tracing is enabled. machine # [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1. machine # [ 0.000000] Trampoline variant of Tasks RCU enabled. machine # [ 0.000000] Rude variant of Tasks RCU enabled. machine # [ 0.000000] Tracing variant of Tasks RCU enabled. machine # [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies. machine # [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1 machine # [ 0.000000] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. machine # [ 0.000000] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. machine # [ 0.000000] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. machine # [ 0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 machine # [ 0.000000] GICv3: 256 SPIs implemented machine # [ 0.000000] GICv3: 0 Extended SPIs implemented machine # [ 0.000000] Root IRQ handler: gic_handle_irq machine # [ 0.000000] GICv3: GICv3 features: 16 PPIs, DirectLPI machine # [ 0.000000] GICv3: GICD_CTLR.DS=1, SCR_EL3.FIQ=0 machine # [ 0.000000] GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000 machine # [ 0.000000] ITS [mem 0x08080000-0x0809ffff] machine # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Devices @44ce0000 (indirect, esz 8, psz 64K, shr 1) machine # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Interrupt Collections @44cf0000 (flat, esz 8, psz 64K, shr 1) machine # [ 0.000000] GICv3: using LPI property table @0x0000000044d10000 machine # [ 0.000000] GICv3: CPU0: using allocated LPI pending table @0x0000000044d20000 machine # [ 0.000000] rcu: srcu_init: Setting srcu_struct sizes based on contention. machine # [ 0.000000] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns machine # [ 0.000000] arch_timer: cp15 timer running at 1000.00MHz (virt). machine # [ 0.000000] clocksource: arch_sys_counter: mask: 0x1fffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns machine # [ 0.000000] sched_clock: 61 bits at 1000MHz, resolution 1ns, wraps every 4398046511103ns machine # [ 0.000030] arm-pv: using stolen time PV machine # [ 0.000396] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____) machine # [ 0.000570] Console: colour dummy device 80x25 machine # [ 0.000578] printk: legacy console [tty0] enabled machine # [ 0.000787] Calibrating delay loop (skipped), value calculated using timer frequency.. 2000.00 BogoMIPS (lpj=4000000) machine # [ 0.000795] pid_max: default: 32768 minimum: 301 machine # [ 0.000877] LSM: initializing lsm=capability,landlock,yama,bpf,ima machine # [ 0.001009] landlock: Up and running. machine # [ 0.001012] Yama: becoming mindful. machine # [ 0.001477] LSM support for eBPF active machine # [ 0.001604] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear) machine # [ 0.001623] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear) machine # [ 0.002754] cacheinfo: Unable to detect cache hierarchy for CPU 0 machine # [ 0.003544] rcu: Hierarchical SRCU implementation. machine # [ 0.003548] rcu: Max phase no-delay instances is 1000. machine # [ 0.004781] fsl-mc MSI: its@8080000 domain created machine # [ 0.004871] EFI services will not be available. machine # [ 0.004955] smp: Bringing up secondary CPUs ... machine # [ 0.004963] smp: Brought up 1 node, 1 CPU machine # [ 0.004967] SMP: Total of 1 processors activated. machine # [ 0.004970] CPU: All CPU(s) started at EL1 machine # [ 0.004984] CPU features: detected: Branch Target Identification machine # [ 0.004989] CPU features: detected: ARMv8.4 Translation Table Level machine # [ 0.004992] CPU features: detected: Instruction cache invalidation not required for I/D coherence machine # [ 0.004996] CPU features: detected: Data cache clean to the PoU not required for I/D coherence machine # [ 0.004999] CPU features: detected: Common not Private translations machine # [ 0.005002] CPU features: detected: CRC32 instructions machine # [ 0.005005] CPU features: detected: Data cache clean to Point of Deep Persistence machine # [ 0.005008] CPU features: detected: Data cache clean to Point of Persistence machine # [ 0.005012] CPU features: detected: Data independent timing control (DIT) machine # [ 0.005015] CPU features: detected: E0PD machine # [ 0.005017] CPU features: detected: Enhanced Counter Virtualization machine # [ 0.005020] CPU features: detected: Enhanced Counter Virtualization (CNTPOFF) machine # [ 0.005024] CPU features: detected: Enhanced Virtualization Traps machine # [ 0.005027] CPU features: detected: Fine Grained Traps machine # [ 0.005031] CPU features: detected: Generic authentication (architected QARMA5 algorithm) machine # [ 0.005036] CPU features: detected: RCpc load-acquire (LDAPR) machine # [ 0.005039] CPU features: detected: LSE atomic instructions machine # [ 0.005042] CPU features: detected: Privileged Access Never machine # [ 0.005044] CPU features: detected: PMUv3 machine # [ 0.005047] CPU features: detected: RAS Extension Support machine # [ 0.005049] CPU features: detected: RASv1p1 Extension Support machine # [ 0.005052] CPU features: detected: Random Number Generator machine # [ 0.005054] CPU features: detected: Speculation barrier (SB) machine # [ 0.005057] CPU features: detected: Stage-2 Force Write-Back machine # [ 0.005060] CPU features: detected: TLB range maintenance instructions machine # [ 0.005065] CPU features: detected: Speculative Store Bypassing Safe (SSBS) machine # [ 0.005103] alternatives: applying system-wide alternatives machine # [ 0.008134] CPU features: detected: BBM Level 2 without TLB conflict abort machine # [ 0.008354] Memory: 894664K/1048576K available (24448K kernel code, 7090K rwdata, 26344K rodata, 4736K init, 1107K bss, 112584K reserved, 32768K cma-reserved) machine # [ 0.008721] devtmpfs: initialized machine # [ 0.010521] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear) machine # [ 0.010546] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear). machine # [ 0.010748] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL machine # [ 0.010752] 0 pages in range for non-PLT usage machine # [ 0.010753] 508288 pages in range for PLT usage machine # [ 0.010864] pinctrl core: initialized pinctrl subsystem machine # [ 0.011657] DMI not present or invalid. machine # [ 0.014788] NET: Registered PF_NETLINK/PF_ROUTE protocol family machine # [ 0.017068] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations machine # [ 0.017215] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations machine # [ 0.017377] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations machine # [ 0.017398] audit: initializing netlink subsys (disabled) machine # [ 0.018007] thermal_sys: Registered thermal governor 'fair_share' machine # [ 0.018009] thermal_sys: Registered thermal governor 'bang_bang' machine # [ 0.018013] thermal_sys: Registered thermal governor 'step_wise' machine # [ 0.018016] thermal_sys: Registered thermal governor 'user_space' machine # [ 0.018021] thermal_sys: Registered thermal governor 'power_allocator' machine # [ 0.018046] audit: type=2000 audit(0.016:1): state=initialized audit_enabled=0 res=1 machine # [ 0.018055] cpuidle: using governor ladder machine # [ 0.018061] cpuidle: using governor menu machine # [ 0.018260] hw-breakpoint: found 16 breakpoint and 4 watchpoint registers. machine # [ 0.018276] ASID allocator initialised with 65536 entries machine # [ 0.019455] Serial: AMBA PL011 UART driver machine # [ 0.024668] 9000000.pl011: ttyAMA0 at MMIO 0x9000000 (irq = 13, base_baud = 0) is a PL011 rev1 machine # [ 0.024833] printk: console [ttyAMA0] enabled machine # [ 0.146555] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages machine # [ 0.146576] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page machine # [ 0.146582] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages machine # [ 0.146586] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page machine # [ 0.146591] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages machine # [ 0.146595] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page machine # [ 0.146601] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages machine # [ 0.146605] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page machine # [ 0.154057] fbcon: Taking over console machine # [ 0.154076] ACPI: Interpreter disabled. machine # [ 0.156001] iommu: Default domain type: Translated machine # [ 0.156011] iommu: DMA domain TLB invalidation policy: strict mode machine # [ 0.157716] SCSI subsystem initialized machine # [ 0.162934] usbcore: registered new interface driver usbfs machine # [ 0.162969] usbcore: registered new interface driver hub machine # [ 0.162986] usbcore: registered new device driver usb machine # [ 0.163266] pps_core: LinuxPPS API ver. 1 registered machine # [ 0.163272] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti machine # [ 0.163282] PTP clock support registered machine # [ 0.163331] EDAC MC: Ver: 3.0.0 machine # [ 0.168029] scmi_core: SCMI protocol bus registered machine # [ 0.169017] FPGA manager framework machine # [ 0.169975] vgaarb: loaded machine # [ 0.170630] clocksource: Switched to clocksource arch_sys_counter machine # [ 0.174625] VFS: Disk quotas dquot_6.6.0 machine # [ 0.177226] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) machine # [ 0.178460] netfs: FS-Cache loaded machine # [ 0.178599] pnp: PnP ACPI: disabled machine # [ 0.182687] NET: Registered PF_INET protocol family machine # [ 0.182862] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear) machine # [ 0.213685] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear) machine # [ 0.213739] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) machine # [ 0.213768] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear) machine # [ 0.213819] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear) machine # [ 0.213898] TCP: Hash tables configured (established 8192 bind 8192) machine # [ 0.213989] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear) machine # [ 0.214052] UDP hash table entries: 512 (order: 3, 32768 bytes, linear) machine # [ 0.214111] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear) machine # [ 0.214193] NET: Registered PF_UNIX/PF_LOCAL protocol family machine # [ 0.214258] NET: Registered PF_XDP protocol family machine # [ 0.214281] PCI: CLS 0 bytes, default 64 machine # [ 0.214543] Trying to unpack rootfs image as initramfs... machine # [ 0.232486] kvm [1]: HYP mode not available machine # [ 0.361475] Initialise system trusted keyrings machine # [ 0.362264] workingset: timestamp_bits=42 max_order=18 bucket_order=0 machine # [ 0.363615] squashfs: version 4.0 (2009/01/31) Phillip Lougher machine # [ 0.364402] 9p: Installing v9fs 9p2000 file system support machine # [ 0.388504] Key type asymmetric registered machine # [ 0.388536] Asymmetric key parser 'x509' registered machine # [ 0.388623] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 242) machine # [ 0.394715] io scheduler mq-deadline registered machine # [ 0.394740] io scheduler kyber registered machine # [ 0.406814] pl061_gpio 9030000.pl061: PL061 GPIO chip registered machine # [ 0.407564] ledtrig-cpu: registered to indicate activity on CPUs machine # [ 0.407944] pci-host-generic 4010000000.pcie: host bridge /pcie@10000000 ranges: machine # [ 0.407963] pci-host-generic 4010000000.pcie: IO 0x003eff0000..0x003effffff -> 0x0000000000 machine # [ 0.407991] pci-host-generic 4010000000.pcie: MEM 0x0010000000..0x003efeffff -> 0x0010000000 machine # [ 0.408000] pci-host-generic 4010000000.pcie: MEM 0x8000000000..0xffffffffff -> 0x8000000000 machine # [ 0.408023] pci-host-generic 4010000000.pcie: Memory resource size exceeds max for 32 bits machine # [ 0.408049] pci-host-generic 4010000000.pcie: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff] machine # [ 0.408159] pci-host-generic 4010000000.pcie: PCI host bridge to bus 0000:00 machine # [ 0.408168] pci_bus 0000:00: root bus resource [bus 00-ff] machine # [ 0.408175] pci_bus 0000:00: root bus resource [io 0x0000-0xffff] machine # [ 0.408180] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff] machine # [ 0.408185] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff] machine # [ 0.408309] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint machine # [ 0.408752] pci 0000:00:01.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint machine # [ 0.408942] pci 0000:00:01.0: BAR 0 [io 0x0000-0x001f] machine # [ 0.408960] pci 0000:00:01.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.408991] pci 0000:00:01.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.409008] pci 0000:00:01.0: ROM [mem 0x00000000-0x0003ffff pref] machine # [ 0.409467] pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint machine # [ 0.409648] pci 0000:00:02.0: BAR 0 [io 0x0000-0x001f] machine # [ 0.409664] pci 0000:00:02.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.409694] pci 0000:00:02.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.410139] pci 0000:00:03.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint machine # [ 0.410318] pci 0000:00:03.0: BAR 0 [io 0x0000-0x003f] machine # [ 0.410334] pci 0000:00:03.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.410364] pci 0000:00:03.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.410852] pci 0000:00:04.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint machine # [ 0.411054] pci 0000:00:04.0: BAR 0 [io 0x0000-0x001f] machine # [ 0.411071] pci 0000:00:04.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.411101] pci 0000:00:04.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.411562] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint machine # [ 0.411754] pci 0000:00:05.0: BAR 0 [io 0x0000-0x001f] machine # [ 0.411770] pci 0000:00:05.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.411800] pci 0000:00:05.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.412249] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint machine # [ 0.412428] pci 0000:00:06.0: BAR 0 [io 0x0000-0x007f] machine # [ 0.412445] pci 0000:00:06.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.412475] pci 0000:00:06.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.412913] pci 0000:00:07.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint machine # [ 0.413096] pci 0000:00:07.0: BAR 0 [io 0x0000-0x001f] machine # [ 0.413112] pci 0000:00:07.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.413142] pci 0000:00:07.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.413158] pci 0000:00:07.0: ROM [mem 0x00000000-0x0003ffff pref] machine # [ 0.413649] pci 0000:00:08.0: [1af4:1050] type 00 class 0x038000 conventional PCI endpoint machine # [ 0.413840] pci 0000:00:08.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.413870] pci 0000:00:08.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.414322] pci 0000:00:09.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint machine # [ 0.414511] pci 0000:00:09.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.414541] pci 0000:00:09.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.463087] pci 0000:00:0a.0: [8086:24cd] type 00 class 0x0c0320 conventional PCI endpoint machine # [ 0.463298] pci 0000:00:0a.0: BAR 0 [mem 0x00000000-0x00000fff] machine # [ 0.463565] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint machine # [ 0.463851] pci 0000:00:0b.0: BAR 0 [io 0x0000-0x003f] machine # [ 0.463869] pci 0000:00:0b.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.463899] pci 0000:00:0b.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.464352] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint machine # [ 0.464531] pci 0000:00:0c.0: BAR 0 [io 0x0000-0x001f] machine # [ 0.464547] pci 0000:00:0c.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.464577] pci 0000:00:0c.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.465169] pci 0000:00:01.0: ROM [mem 0x10000000-0x1003ffff pref]: assigned machine # [ 0.465181] pci 0000:00:07.0: ROM [mem 0x10040000-0x1007ffff pref]: assigned machine # [ 0.465188] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned machine # [ 0.465234] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]: assigned machine # [ 0.465281] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]: assigned machine # [ 0.465329] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]: assigned machine # [ 0.465375] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]: assigned machine # [ 0.465422] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]: assigned machine # [ 0.465469] pci 0000:00:07.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]: assigned machine # [ 0.465517] pci 0000:00:08.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]: assigned machine # [ 0.465568] pci 0000:00:09.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]: assigned machine # [ 0.465615] pci 0000:00:0b.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]: assigned machine # [ 0.465680] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]: assigned machine # [ 0.465725] pci 0000:00:01.0: BAR 1 [mem 0x10080000-0x10080fff]: assigned machine # [ 0.465747] pci 0000:00:02.0: BAR 1 [mem 0x10081000-0x10081fff]: assigned machine # [ 0.465815] pci 0000:00:03.0: BAR 1 [mem 0x10082000-0x10082fff]: assigned machine # [ 0.465838] pci 0000:00:04.0: BAR 1 [mem 0x10083000-0x10083fff]: assigned machine # [ 0.465859] pci 0000:00:05.0: BAR 1 [mem 0x10084000-0x10084fff]: assigned machine # [ 0.465887] pci 0000:00:06.0: BAR 1 [mem 0x10085000-0x10085fff]: assigned machine # [ 0.465909] pci 0000:00:07.0: BAR 1 [mem 0x10086000-0x10086fff]: assigned machine # [ 0.465931] pci 0000:00:08.0: BAR 1 [mem 0x10087000-0x10087fff]: assigned machine # [ 0.465954] pci 0000:00:09.0: BAR 1 [mem 0x10088000-0x10088fff]: assigned machine # [ 0.465977] pci 0000:00:0a.0: BAR 0 [mem 0x10089000-0x10089fff]: assigned machine # [ 0.466000] pci 0000:00:0b.0: BAR 1 [mem 0x1008a000-0x1008afff]: assigned machine # [ 0.466024] pci 0000:00:0c.0: BAR 1 [mem 0x1008b000-0x1008bfff]: assigned machine # [ 0.466045] pci 0000:00:06.0: BAR 0 [io 0x1000-0x107f]: assigned machine # [ 0.466067] pci 0000:00:03.0: BAR 0 [io 0x1080-0x10bf]: assigned machine # [ 0.466090] pci 0000:00:0b.0: BAR 0 [io 0x10c0-0x10ff]: assigned machine # [ 0.466112] pci 0000:00:01.0: BAR 0 [io 0x1100-0x111f]: assigned machine # [ 0.466134] pci 0000:00:02.0: BAR 0 [io 0x1120-0x113f]: assigned machine # [ 0.466155] pci 0000:00:04.0: BAR 0 [io 0x1140-0x115f]: assigned machine # [ 0.466177] pci 0000:00:05.0: BAR 0 [io 0x1160-0x117f]: assigned machine # [ 0.466198] pci 0000:00:07.0: BAR 0 [io 0x1180-0x119f]: assigned machine # [ 0.466220] pci 0000:00:0c.0: BAR 0 [io 0x11a0-0x11bf]: assigned machine # [ 0.466249] pci_bus 0000:00: resource 4 [io 0x0000-0xffff] machine # [ 0.466259] pci_bus 0000:00: resource 5 [mem 0x10000000-0x3efeffff] machine # [ 0.466264] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff] machine # [ 0.506347] pci 0000:00:0a.0: enabling device (0000 -> 0002) machine # [ 0.530465] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003) machine # [ 0.540150] virtio-pci 0000:00:02.0: enabling device (0000 -> 0003) machine # [ 0.551412] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003) machine # [ 0.555787] virtio-pci 0000:00:04.0: enabling device (0000 -> 0003) machine # [ 0.557935] virtio-pci 0000:00:05.0: enabling device (0000 -> 0003) machine # [ 0.568603] virtio-pci 0000:00:06.0: enabling device (0000 -> 0003) machine # [ 0.571728] virtio-pci 0000:00:07.0: enabling device (0000 -> 0003) machine # [ 0.574198] virtio-pci 0000:00:08.0: enabling device (0000 -> 0002) machine # [ 0.584874] virtio-pci 0000:00:09.0: enabling device (0000 -> 0002) machine # [ 0.594962] virtio-pci 0000:00:0b.0: enabling device (0000 -> 0003) machine # [ 0.599454] virtio-pci 0000:00:0c.0: enabling device (0000 -> 0003) machine # [ 0.613249] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled machine # [ 0.616135] msm_serial: driver initialized machine # [ 0.616324] SuperH (H)SCI(F) driver initialized machine # [ 0.616378] STM32 USART driver initialized machine # [ 0.653649] loop: module loaded machine # [ 0.653886] virtio_blk virtio5: 1/0/0 default/read/poll queues machine # [ 0.656307] virtio_blk virtio5: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) machine # [ 0.667542] megasas: 07.734.00.00-rc1 machine # [ 0.668382] physmap-flash 0.flash: physmap platform flash device: [mem 0x00000000-0x03ffffff] machine # [ 0.670441] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000 machine # [ 0.670486] Intel/Sharp Extended Query Table at 0x0031 machine # [ 0.672378] Using buffer write method machine # [ 0.672533] physmap-flash 0.flash: physmap platform flash device: [mem 0x04000000-0x07ffffff] machine # [ 0.674452] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000 machine # [ 0.674493] Intel/Sharp Extended Query Table at 0x0031 machine # [ 0.693861] Using buffer write method machine # [ 0.693940] Concatenating MTD devices: machine # [ 0.693944] (0): "0.flash" machine # [ 0.693949] (1): "0.flash" machine # [ 0.693953] into device "0.flash" machine # [ 0.983300] Freeing initrd memory: 25724K machine # [ 0.989695] tun: Universal TUN/TAP device driver, 1.6 machine # [ 0.994268] thunder_xcv, ver 1.0 machine # [ 0.994338] thunder_bgx, ver 1.0 machine # [ 0.994363] nicpf, ver 1.0 machine # [ 0.996206] e1000: Intel(R) PRO/1000 Network Driver machine # [ 0.996221] e1000: Copyright (c) 1999-2006 Intel Corporation. machine # [ 0.996254] e1000e: Intel(R) PRO/1000 Network Driver machine # [ 0.996267] e1000e: Copyright(c) 1999 - 2015 Intel Corporation. machine # [ 0.996295] igb: Intel(R) Gigabit Ethernet Network Driver machine # [ 0.996301] igb: Copyright (c) 2007-2014 Intel Corporation. machine # [ 0.996324] igbvf: Intel(R) Gigabit Virtual Function Network Driver machine # [ 0.996330] igbvf: Copyright (c) 2009 - 2012 Intel Corporation. machine # [ 0.996470] sky2: driver version 1.30 machine # [ 0.998148] usbcore: registered new interface driver usb-storage machine # [ 0.998264] usbcore: registered new interface driver usbserial_generic machine # [ 0.998280] usbserial: USB Serial support registered for generic machine # [ 0.999442] ehci-pci 0000:00:0a.0: EHCI Host Controller machine # [ 0.999492] ehci-pci 0000:00:0a.0: new USB bus registered, assigned bus number 1 machine # [ 0.999730] ehci-pci 0000:00:0a.0: irq 15, io mem 0x10089000 machine # [ 1.011192] ehci-pci 0000:00:0a.0: USB 2.0 started, EHCI 1.00 machine # [ 1.011670] hub 1-0:1.0: USB hub found machine # [ 1.011699] hub 1-0:1.0: 6 ports detected machine # [ 1.014342] hv_vmbus: registering driver hyperv_keyboard machine # [ 1.016225] rtc-pl031 9010000.pl031: registered as rtc0 machine # [ 1.016270] rtc-pl031 9010000.pl031: setting system clock to 2026-09-04T02:32:49 UTC (1788489169) machine # [ 1.016637] i2c_dev: i2c /dev entries driver machine # [ 1.022074] sdhci: Secure Digital Host Controller Interface driver machine # [ 1.022092] sdhci: Copyright(c) Pierre Ossman machine # [ 1.022373] Synopsys Designware Multimedia Card Interface Driver machine # [ 1.024921] sdhci-pltfm: SDHCI platform and OF driver helper machine # [ 1.027666] hid: raw HID events driver (C) Jiri Kosina machine # [ 1.027934] usbcore: registered new interface driver usbhid machine # [ 1.027943] usbhid: USB HID core driver machine # [ 1.031064] hw perfevents: enabled with armv8_pmuv3 PMU driver, 11 (0,800003ff) counters available machine # [ 1.032708] drop_monitor: Initializing network drop monitor service machine # [ 1.032918] NET: Registered PF_INET6 protocol family machine # [ 1.036468] Segment Routing with IPv6 machine # [ 1.036498] In-situ OAM (IOAM) with IPv6 machine # [ 1.036529] NET: Registered PF_PACKET protocol family machine # [ 1.038209] 9pnet: Installing 9P2000 support machine # [ 1.041268] Key type dns_resolver registered machine # [ 1.047853] registered taskstats version 1 machine # [ 1.048022] Loading compiled-in X.509 certificates machine # [ 1.057276] Demotion targets for Node 0: null machine # [ 1.057419] Key type .fscrypt registered machine # [ 1.057428] Key type fscrypt-provisioning registered machine # [ 1.057535] ima: No TPM chip found, activating TPM-bypass! machine # [ 1.057556] ima: Allocated hash algorithm: sha1 machine # [ 1.057580] ima: No architecture policies found machine # [ 1.061982] input: gpio-keys as /devices/platform/gpio-keys/input/input0 machine # [ 1.081891] clk: Disabling unused clocks machine # [ 1.081937] PM: genpd: Disabling unused power domains machine # [ 1.086327] Freeing unused kernel memory: 4736K machine # [ 1.086567] Run /init as init process machine # [ 1.105201] systemd[1]: Successfully made /usr/ read-only. machine # [ 1.259412] usb 1-1: new high-speed USB device number 2 using ehci-pci machine # [ 1.409067] input: QEMU QEMU USB Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:0a.0/usb1/1-1/1-1:1.0/0003:0627:0001.0001/input/input1 machine # [ 1.440276] systemd[1]: systemd 262-175b52e 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.444493] systemd[1]: Detected virtualization qemu. machine # [ 1.445179] systemd[1]: Detected architecture arm64. machine # [ 1.445879] systemd[1]: Running in initrd. machine # [ 1.446932] systemd[1]: Initializing machine ID from random generator. machine # [ 1.447931] systemd[1]: Hostname set to . machine # [ 1.498967] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v1.11 Keyboard [QEMU QEMU USB Keyboard] on usb-0000:00:0a.0-1/input0 machine # [ 1.581775] systemd[1]: bpf-restrict-fs: LSM BPF program attached machine # [ 1.618761] usb 1-2: new high-speed USB device number 3 using ehci-pci machine # [ 1.641848] systemd[1]: Queued start job for default target Initrd Default Target. machine # [ 1.648867] systemd[1]: Created slice Slice /system/modprobe. machine # [ 1.649923] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. machine # [ 1.651069] systemd[1]: Expecting device /dev/disk/by-label/nixos... machine # [ 1.651108] systemd[1]: Reached target Path Units. machine # [ 1.651125] systemd[1]: Reached target Slice Units. machine # [ 1.651141] systemd[1]: Reached target Swaps. machine # [ 1.651157] systemd[1]: Reached target Timer Units. machine # [ 1.651322] systemd[1]: Listening on D-Bus System Message Bus Socket. machine # [ 1.651490] systemd[1]: Listening on Journal Socket (/dev/log). machine # [ 1.651624] systemd[1]: Listening on Journal Sockets. machine # [ 1.651709] systemd[1]: Listening on udev Kernel Socket. machine # [ 1.651726] systemd[1]: Reached target Socket Units. machine # [ 1.660082] systemd[1]: Starting Create List of Static Device Nodes... machine # [ 1.670263] systemd[1]: Starting Load Kernel Module 9pnet_virtio... machine # [ 1.671731] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs machine # [ 1.684488] systemd[1]: Mounting Kernel Configuration File System... machine # [ 1.707145] systemd[1]: Starting Journal Service... machine # [ 1.714990] systemd[1]: Starting Load Kernel Modules... machine # [ 1.715863] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 1.723012] systemd[1]: Starting Coldplug All udev Devices... machine # [ 1.739158] systemd[1]: Finished Create List of Static Device Nodes. machine # [ 1.751936] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully. machine # [ 1.755231] systemd[1]: Finished Load Kernel Module 9pnet_virtio. machine # [ 1.782978] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... machine # [ 1.784883] input: QEMU QEMU USB Tablet as /devices/platform/4010000000.pcie/pci0000:00/0000:00:0a.0/usb1/1-2/1-2:1.0/0003:0627:0001.0002/input/input2 machine # [ 1.785027] hid-generic 0003:0627:0001.0002: input,hidraw1: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:0a.0-2/input0 machine # [ 1.790577] systemd-journald[73]: Collecting audit messages is disabled. machine # [ 1.795816] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. machine # [ 1.811516] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev machine # [ 1.814004] systemd[1]: Mounted Kernel Configuration File System. machine # [ 1.827296] [drm] pci: virtio-gpu-pci detected at 0000:00:08.0 machine # [ 1.827549] [drm] features: -virgl +edid -resource_blob -host_visible machine # [ 1.827559] [drm] features: -context_init machine # [ 1.828286] [drm] number of scanouts: 1 machine # [ 1.828304] [drm] number of cap sets: 0 machine # [ 1.842820] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. machine # [ 1.851157] systemd[1]: Starting Create Static Device Nodes in /dev... machine # [ 1.855973] virtio-pci 0000:00:08.0: [drm] Registered 1 planes with drm panic machine # [ 1.856000] [drm] Initialized virtio_gpu 0.1.0 for 0000:00:08.0 on minor 0 machine # [ 1.882986] Console: switching to colour frame buffer device 160x50 machine # [ 1.890040] virtio-pci 0000:00:08.0: [drm] fb0: virtio_gpudrmfb frame buffer device machine # [ 1.911592] systemd[1]: Finished Create Static Device Nodes in /dev. machine # [ 1.911808] systemd[1]: Reached target Preparation for Local File Systems. machine # [ 1.911845] systemd[1]: Reached target Local File Systems. machine # [ 1.919359] systemd[1]: Starting Rule-based Manager for Device Events and Files... machine # [ 1.944579] systemd[1]: Finished Load Kernel Modules. machine # [ 1.959428] systemd[1]: Starting Apply Kernel Variables... machine # [ 2.011298] systemd[1]: Started Journal Service. machine # [ 2.000979] systemd-modules-load[74]: Inserted module 'dm_mod' machine # [ 2.004731] systemd-modules-load[74]: Module 'virtio_balloon' is built in machine # [ 2.005945] systemd-modules-load[74]: Module 'virtio_console' is built in machine # [ 2.006976] systemd-modules-load[74]: Inserted module 'virtio_gpu' machine # [ 2.022170] systemd-modules-load[74]: Module 'virtio_rng' is built in machine # [ 2.023297] systemd[1]: Starting Create System Files and Directories... machine # [ 2.034278] systemd[1]: Finished Apply Kernel Variables. machine # [ 2.042567] systemd-udevd[80]: Using default interface naming scheme 'v261'. machine # [ 2.082683] systemd[1]: Finished Create System Files and Directories. machine # [ 2.091914] systemd[1]: Started Rule-based Manager for Device Events and Files. machine # [ 2.184283] systemd[1]: Starting Virtual Console Setup... machine # [ 2.264721] systemd-vconsole-setup[103]: Configuration of first virtual console was skipped, ignoring remaining ones. machine # [ 2.270703] systemd[1]: Finished Virtual Console Setup. machine # [ 2.885348] systemd[1]: Finished Coldplug All udev Devices. machine # [ 2.887014] systemd[1]: Reached target System Initialization. machine # [ 2.889415] systemd[1]: Reached target Basic System. machine # [ 3.028352] (udev-worker)[98]: Network interface NamePolicy= disabled on kernel command line. machine # [ 3.060919] (udev-worker)[95]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. machine # [ 3.068206] (udev-worker)[95]: Network interface NamePolicy= disabled on kernel command line. machine # [ 3.143435] systemd[1]: Found device /dev/disk/by-label/nixos. machine # [ 3.146798] systemd[1]: Reached target Initrd Root Device. machine # [ 3.151510] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos... machine # [ 3.206008] systemd-fsck[112]: nixos: clean, 12/65536 files, 13019/262144 blocks machine # [ 3.212274] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos. machine # [ 3.220443] systemd[1]: Mounting /sysroot... machine # [ 3.283714] EXT4-fs (vda): mounted filesystem ba3e954d-d93a-4fa7-8371-d9f1c9bbef23 r/w with ordered data mode. Quota mode: none. machine # [ 3.275800] systemd[1]: Mounted /sysroot. machine # [ 3.279221] systemd[1]: Reached target Initrd Root File System. machine # [ 3.284551] systemd[1]: Starting Mountpoints Configured in the Real Root... machine # [ 3.320443] systemd-sysroot-fstab-check[120]: /sysroot should be mounted in the initrd, will request daemon-reload. machine # [ 3.326577] systemd[1]: Reload requested from client PID 120 ('systemd-sysroot') (unit initrd-parse-etc.service)... machine # [ 3.332279] systemd[1]: Reloading... machine # [ 3.535951] systemd[1]: Reloading finished in 202 ms. machine # [ 3.568505] systemd-sysroot-fstab-check[120]: Requesting initrd-fs.target/start/replace... machine # [ 3.573693] systemd-sysroot-fstab-check[120]: Requesting swap.target/start/replace... machine # [ 3.580890] systemd[1]: Starting Load Kernel Module 9pnet_virtio... machine # [ 3.583828] systemd[1]: initrd-parse-etc.service: Deactivated successfully. machine # [ 3.591712] systemd[1]: Finished Mountpoints Configured in the Real Root. machine # [ 3.593237] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies. machine # [ 3.619595] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully. machine # [ 3.623457] systemd[1]: Finished Load Kernel Module 9pnet_virtio. machine # [ 3.725047] systemd[1]: Mounting /sysroot/nix/.ro-store... machine # [ 3.742635] systemd[1]: Mounting /sysroot/nix/.rw-store... machine # [ 3.755244] systemd[1]: Mounting /sysroot/run... machine # [ 3.766577] systemd[1]: Mounting /sysroot/tmp/shared... machine # [ 3.798064] systemd[1]: Mounting /sysroot/tmp/xchg... machine # [ 3.827385] systemd[1]: Mounted /sysroot/nix/.rw-store. machine # [ 3.867408] systemd[1]: Starting rw-sysroot-nix-store.service... machine # [ 3.887913] systemd[1]: Mounted /sysroot/nix/.ro-store. machine # [ 3.894732] systemd[1]: Mounted /sysroot/run. machine # [ 3.903622] systemd[1]: Mounted /sysroot/tmp/shared. machine # [ 3.922579] systemd[1]: Mounted /sysroot/tmp/xchg. machine # [ 3.930661] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. machine # [ 3.935892] systemd[1]: Finished rw-sysroot-nix-store.service. machine # [ 3.939301] systemd[1]: Mounting /sysroot/nix/store... machine # [ 3.993232] systemd[1]: Mounted /sysroot/nix/store. machine # [ 3.995726] systemd[1]: Reached target Initrd File Systems. machine # [ 4.000200] systemd[1]: Starting Find NixOS closure... machine # [ 4.013004] systemd[1]: Starting Create Volatile Files and Directories in the Real Root... machine # [ 4.056858] systemd[1]: Finished Create Volatile Files and Directories in the Real Root. machine # [ 4.078364] systemd[1]: Finished Find NixOS closure. machine # [ 4.080893] systemd[1]: Reached target Initrd Default Target. machine # [ 4.086098] systemd[1]: Starting Cleaning Up and Shutting Down Daemons... machine # [ 4.138688] systemd[1]: Stopped target Initrd Default Target. machine # [ 4.141254] systemd[1]: Stopped target Basic System. machine # [ 4.143000] systemd[1]: Stopped target Initrd Root Device. machine # [ 4.148449] systemd[1]: Stopped target Path Units. machine # [ 4.150207] systemd[1]: systemd-ask-password-console.path: Deactivated successfully. machine # [ 4.152134] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch. machine # [ 4.156536] systemd[1]: Stopped target Slice Units. machine # [ 4.160161] systemd[1]: Stopped target Socket Units. machine # [ 4.162398] systemd[1]: Stopped target System Initialization. machine # [ 4.165251] systemd[1]: Stopped target Swaps. machine # [ 4.168987] systemd[1]: Stopped target Timer Units. machine # [ 4.170974] systemd[1]: dbus.socket: Deactivated successfully. machine # [ 4.176715] systemd[1]: Closed D-Bus System Message Bus Socket. machine # [ 4.178175] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully. machine # [ 4.179653] systemd[1]: Stopped Find NixOS closure. machine # [ 4.185828] systemd[1]: Starting Load Kernel Module 9pnet_virtio... machine # [ 4.189065] systemd[1]: Starting rw-sysroot-nix-store.service... machine # [ 4.192931] systemd[1]: systemd-sysctl.service: Deactivated successfully. machine # [ 4.196406] systemd[1]: Stopped Apply Kernel Variables. machine # [ 4.200140] systemd[1]: systemd-modules-load.service: Deactivated successfully. machine # [ 4.204267] systemd[1]: Stopped Load Kernel Modules. machine # [ 4.205121] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully. machine # [ 4.213174] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root. machine # [ 4.222082] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. machine # [ 4.226272] systemd[1]: Stopped Create System Files and Directories. machine # [ 4.232322] systemd[1]: Stopped target Local File Systems. machine # [ 4.236310] systemd[1]: Stopped target Preparation for Local File Systems. machine # [ 4.246544] systemd[1]: systemd-udev-trigger.service: Deactivated successfully. machine # [ 4.247746] systemd[1]: Stopped Coldplug All udev Devices. machine # [ 4.250168] systemd[1]: Stopping Rule-based Manager for Device Events and Files... machine # [ 4.251269] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. machine # [ 4.255707] systemd[1]: Stopped Virtual Console Setup. machine # [ 4.256949] systemd[1]: initrd-cleanup.service: Deactivated successfully. machine # [ 4.260329] systemd[1]: Finished Cleaning Up and Shutting Down Daemons. machine # [ 4.261354] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully. machine # [ 4.262381] systemd[1]: Finished Load Kernel Module 9pnet_virtio. machine # [ 4.263691] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. machine # [ 4.264948] systemd[1]: Finished rw-sysroot-nix-store.service. machine # [ 4.271527] systemd[1]: systemd-udevd.service: Deactivated successfully. machine # [ 4.274540] systemd[1]: Stopped Rule-based Manager for Device Events and Files. machine # [ 4.276762] systemd[1]: systemd-udevd.service: Consumed 1.057s CPU time over 2.366s wall clock time, 16.1M memory peak. machine # [ 4.280537] systemd[1]: Starting Cleanup udev Database... machine # [ 4.283962] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. machine # [ 4.285561] systemd[1]: Stopped Create Static Device Nodes in /dev. machine # [ 4.286478] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. machine # [ 4.287629] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully. machine # [ 4.288798] systemd[1]: kmod-static-nodes.service: Deactivated successfully. machine # [ 4.289798] systemd[1]: Stopped Create List of Static Device Nodes. machine # [ 4.322542] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. machine # [ 4.325413] systemd[1]: Finished Cleanup udev Database. machine # [ 4.326293] systemd[1]: Reached target Switch Root. machine # [ 4.328626] systemd[1]: Starting NixOS Activation... machine # [ 4.543920] initrd-nixos-activation-start[172]: booting system configuration /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test machine # [ 4.624790] initrd-nixos-activation-start[172]: running activation script... machine # [ 5.121508] initrd-nixos-activation-start[195]: setting up /etc... machine # [ 5.450418] systemd[1]: initrd-nixos-activation.service: Deactivated successfully. machine # [ 5.453784] systemd[1]: Finished NixOS Activation. machine # [ 5.455303] systemd[1]: Starting Switch Root... machine # [ 5.482687] systemd[1]: Switching root. machine # [ 5.676632] systemd-journald[73]: Received SIGTERM from PID 1 (systemd). machine # [ 6.286198] systemd[1]: systemd 262-175b52e running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE) machine # [ 6.298862] systemd[1]: Detected virtualization qemu. machine # [ 6.302142] systemd[1]: Detected architecture arm64. machine # [ 6.306218] systemd[1]: Detected first boot. machine # [ 6.314733] systemd[1]: Initializing machine ID from random generator. machine # [ 6.509407] systemd[1]: bpf-restrict-fs: LSM BPF program attached machine # [ 6.682178] systemd[1]: Applying preset policy. machine # [ 7.181803] systemd[1]: Populated /etc with preset unit settings. machine # [ 7.736073] systemd[1]: initrd-switch-root.service: Deactivated successfully. machine # [ 7.737541] systemd[1]: Stopped initrd-switch-root.service. machine # [ 7.741197] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. machine # [ 7.745440] systemd[1]: Created slice Slice /system/getty. machine # [ 7.748890] systemd[1]: Created slice User and Session Slice. machine # [ 7.750945] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. machine # [ 7.752658] systemd[1]: Started Forward Password Requests to Wall Directory Watch. machine # [ 7.755436] systemd[1]: Expecting device /dev/hvc0... machine # [ 7.757349] systemd[1]: Expecting device /dev/ttyAMA0... machine # [ 7.759370] systemd[1]: Reached target Local Encrypted Volumes. machine # [ 7.761383] systemd[1]: Stopped target initrd-fs.target. machine # [ 7.763493] systemd[1]: Stopped target initrd-root-fs.target. machine # [ 7.765481] systemd[1]: Stopped target initrd-switch-root.target. machine # [ 7.767652] systemd[1]: Reached target Virtual Machines and Containers. machine # [ 7.769823] systemd[1]: Reached target Path Units. machine # [ 7.771847] systemd[1]: Reached target Remote File Systems. machine # [ 7.772949] systemd[1]: Reached target Slice Units. machine # [ 7.774454] systemd[1]: Reached target Swaps. machine # [ 7.779189] systemd[1]: Listening on Query the User Interactively for a Password. machine # [ 7.784447] systemd[1]: Listening on Process Core Dump Socket. machine # [ 7.788770] systemd[1]: Listening on Credential Encryption/Decryption. machine # [ 7.792887] systemd[1]: Listening on Factory Reset Management. machine # [ 7.794235] systemd[1]: Listening on Hostname Service Socket. machine # [ 7.801086] systemd[1]: Starting Journal Log Access Socket... machine # [ 7.804594] systemd[1]: Listening on Journal Audit Socket. machine # [ 7.809770] systemd[1]: Listening on Console Output Muting Service Socket. machine # [ 7.813569] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket. machine # [ 7.816209] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 7.818867] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 7.830807] systemd[1]: Listening on Disk Repartitioning Service Socket. machine # [ 7.833444] systemd[1]: Listening on udev Varlink Socket. machine # [ 7.839756] systemd[1]: Mounting Huge Pages File System... machine # [ 7.846288] systemd[1]: Mounting POSIX Message Queue File System... machine # [ 7.860774] systemd[1]: Mounting Kernel Debug File System... machine # [ 7.871655] systemd[1]: Mounting Kernel Trace File System... machine # [ 7.883504] systemd[1]: Starting Create List of Static Device Nodes... machine # [ 7.895433] systemd[1]: Starting Load Kernel Module 9pnet_virtio... machine # [ 7.897101] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs machine # [ 7.912136] systemd[1]: Mounting Kernel Configuration File System... machine # [ 7.915122] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm machine # [ 7.918457] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 7.932743] systemd[1]: Starting Load Kernel Module fuse... machine # [ 7.936025] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 7.993330] systemd[1]: Starting Journal Service... machine # [ 8.050324] systemd[1]: Starting Load Kernel Modules... machine # [ 8.064900] fuse: init (API version 7.45) machine # [ 8.081224] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer... machine # [ 8.116327] systemd[1]: Starting Remount Root and Kernel File Systems... machine # [ 8.119060] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 8.127427] systemd-journald[268]: Collecting audit messages is enabled. machine # [ 8.121069] systemd[1]: Queued start job for default target Multi-User System. machine # [ 8.124512] systemd[1]: systemd-journald.service: Deactivated successfully. machine # [ 8.144112] systemd[1]: Starting Coldplug All udev Devices... machine # [ 8.157792] systemd[1]: Started Journal Service. machine # [ 8.171584] systemd[1]: Listening on Journal Log Access Socket. machine # [ 8.177811] systemd[1]: Mounted Huge Pages File System. machine # [ 8.184725] systemd[1]: Mounted POSIX Message Queue File System. machine # [ 8.193546] systemd[1]: Mounted Kernel Debug File System. machine # [ 8.194540] systemd[1]: Mounted Kernel Trace File System. machine # [ 8.195333] systemd[1]: Finished Create List of Static Device Nodes. machine # [ 8.205022] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully. machine # [ 8.214563] systemd[1]: Finished Load Kernel Module 9pnet_virtio. machine # [ 8.221196] systemd[1]: Mounted Kernel Configuration File System. machine # [ 8.224638] systemd[1]: modprobe@fuse.service: Deactivated successfully. machine # [ 8.229326] systemd[1]: Finished Load Kernel Module fuse. machine # [ 8.246814] EXT4-fs (vda): re-mounted ba3e954d-d93a-4fa7-8371-d9f1c9bbef23. machine # [ 8.236625] systemd-modules-load[269]: Module 'atkbd' is built in machine # [ 8.241048] systemd-modules-load[269]: Module 'loop' is built in machine # [ 8.245310] systemd[1]: Finished Load Kernel Modules. machine # [ 8.258521] systemd[1]: Mounting FUSE Control File System... machine # [ 8.265385] systemd[1]: Starting Firewall... machine # [ 8.296943] systemd-oomd[271]: No swap; memory pressure usage will be degraded machine # [ 8.304259] systemd[1]: Starting Apply Kernel Variables... machine # [ 8.320474] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... machine # [ 8.330663] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer. machine # [ 8.333964] systemd[1]: Finished Remount Root and Kernel File Systems. machine # [ 8.339315] systemd[1]: Listening on Disk Image Download Service Socket. machine # [ 8.371051] systemd[1]: Starting Flush Journal to Persistent Storage... machine # [ 8.373846] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 8.402482] systemd[1]: Starting Load/Save OS Random Seed... machine # [ 8.404561] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 8.469082] systemd[1]: Mounted FUSE Control File System. machine # [ 8.491955] systemd-journald[268]: Received client request to flush runtime journal. machine # [ 8.566433] systemd[1]: Finished Apply Kernel Variables. machine # [ 8.577243] systemd[1]: Finished Load/Save OS Random Seed. machine # [ 8.578149] systemd[1]: Reached target First Boot Complete. machine # [ 8.587536] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. machine # [ 8.589145] systemd[1]: Finished Flush Journal to Persistent Storage. machine # [ 8.592860] systemd[1]: Starting Create Static Device Nodes in /dev... machine # [ 8.703372] systemd[1]: Finished Create Static Device Nodes in /dev. machine # [ 8.708343] systemd[1]: Reached target Preparation for Local File Systems. machine # [ 8.711922] systemd[1]: Starting Rule-based Manager for Device Events and Files... machine # [ 8.735845] systemd[1]: Mounting /run/wrappers... machine # [ 8.817313] systemd[1]: Mounted /run/wrappers. machine # [ 8.818295] systemd[1]: Reached target Local File Systems. machine # [ 8.827206] systemd[1]: Listening on Boot Loader Control Service Socket. machine # [ 8.834874] systemd[1]: Starting register-nix-paths.service... machine # [ 8.851356] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 8.854469] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 8.876747] systemd[1]: Starting Save Transient machine-id to Disk... machine # [ 8.910038] systemd[1]: Starting Create System Files and Directories... machine # [ 8.989690] systemd[1]: etc-machine\x2did.mount: Deactivated successfully. machine # [ 9.010106] systemd[1]: Finished Save Transient machine-id to Disk. machine # [ 9.181063] systemd[1]: Finished Create System Files and Directories. machine # [ 9.210972] systemd[1]: Starting Rebuild Journal Catalog... machine # [ 9.223260] systemd[1]: Starting Record System Boot/Shutdown in UTMP... machine # [ 9.395806] systemd-udevd[310]: Using default interface naming scheme 'v261'. machine # [ 9.413189] systemd[1]: Finished Record System Boot/Shutdown in UTMP. machine # [ 9.491254] systemd[1]: Finished Rebuild Journal Catalog. machine # [ 9.520521] systemd[1]: Starting Update is Completed... machine # [ 9.649251] systemd[1]: Finished Update is Completed. machine # [ 9.721473] systemd[1]: Started Rule-based Manager for Device Events and Files. machine # [ 10.094227] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 10.098240] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 10.930322] systemd[1]: Finished register-nix-paths.service. machine # [ 10.952077] systemd[1]: Finished Coldplug All udev Devices. machine # [ 10.954330] systemd[1]: Reached target System Initialization. machine # [ 10.959633] systemd[1]: Started Discard unused filesystem blocks once a week. machine # [ 10.968752] systemd[1]: Started Daily Cleanup of Temporary Directories. machine # [ 10.969896] systemd[1]: Reached target Timer Units. machine # [ 10.971338] systemd[1]: Listening on D-Bus System Message Bus Socket. machine # [ 10.977812] systemd[1]: Listening on Nix Daemon Socket. machine # [ 10.986567] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket. machine # [ 10.987837] systemd[1]: Reached target Socket Units. machine # [ 10.994026] systemd[1]: Reached target Basic System. machine # [ 10.999747] systemd[1]: Starting Import lastlog data into lastlog2 database... machine # [ 11.009303] systemd[1]: Starting Name Service Cache Daemon (nsncd)... machine # [ 11.010527] systemd[1]: Starting Post-Boot Actions... machine # [ 11.056123] systemd[1]: Started Reset console on configuration changes. machine # [ 11.084379] systemd[1]: Starting resolvconf update... machine # [ 11.157203] systemd[1]: Starting D-Bus System Message Bus... machine # [ 11.189218] systemd[1]: Finished Post-Boot Actions. machine # [ 11.211150] nsncd[468]: Sep 04 02:32:59.708 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" machine # [ 11.225339] systemd[1]: Finished Firewall. machine # [ 11.228504] systemd[1]: Started Name Service Cache Daemon (nsncd). machine # [ 11.263920] systemd[1]: Reached target Host and Network Name Lookups. machine # [ 11.270066] systemd[1]: Reached target User and Group Name Lookups. machine # [ 11.288850] systemd[1]: Starting User Login Management... machine # [ 11.328900] systemd[1]: Finished Import lastlog data into lastlog2 database. machine # [ 11.434509] dbus-broker-launch[478]: Looking up NSS user entry for 'systemd-timesync'... machine # [ 11.447139] dbus-broker-launch[478]: NSS returned no entry for 'systemd-timesync' machine # [ 11.453746] dbus-broker-launch[478]: Invalid user-name in /nix/store/zihqny80khrxshjrz8dszaixmccx9dn8-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" machine # [ 11.497916] systemd[1]: Started D-Bus System Message Bus. machine # [ 11.523595] systemd-logind[497]: New seat seat0. machine # [ 11.532142] systemd[1]: Started User Login Management. machine # [ 11.547302] systemd[1]: Starting linger-users.service... machine # [ 11.561308] dbus-broker-launch[478]: Ready machine # [ 11.592926] systemd[1]: Stopped target Host and Network Name Lookups. machine # [ 11.597833] systemd[1]: Stopping Host and Network Name Lookups... machine # [ 11.604510] systemd[1]: Stopped target User and Group Name Lookups. machine # [ 11.607566] systemd[1]: Stopping User and Group Name Lookups... machine # [ 11.612505] systemd[1]: Stopping Name Service Cache Daemon (nsncd)... machine # [ 11.617310] systemd[1]: nscd.service: Deactivated successfully. machine # [ 11.621200] systemd[1]: Stopped Name Service Cache Daemon (nsncd). machine # [ 11.643632] systemd[1]: Starting Name Service Cache Daemon (nsncd)... machine # [ 11.710983] systemd[1]: Created slice Slice /user/1001. machine # [ 11.722641] systemd[1]: Starting User Runtime Directory /run/user/1001... machine # [ 11.749527] nsncd[544]: Sep 04 02:33:00.246 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" machine # [ 11.768403] systemd[1]: Started Name Service Cache Daemon (nsncd). machine # [ 11.773245] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 11.778193] systemd[1]: Finished linger-users.service. machine # [ 11.789665] systemd[1]: Reached target Host and Network Name Lookups. machine # [ 11.794716] systemd[1]: Reached target User and Group Name Lookups. machine # [ 11.832095] systemd[1]: Finished resolvconf update. machine # [ 11.838045] systemd[1]: Reached target Preparation for Network. machine # [ 11.848662] systemd[1]: Starting DHCP Client... machine # [ 11.854293] systemd[1]: Starting Extra networking commands.... machine # [ 11.885976] systemd[1]: Finished User Runtime Directory /run/user/1001. machine # [ 11.933137] systemd[1]: Starting User Manager for UID 1001... machine # [ 12.117872] (systemd)[576]: pam_unix(systemd-user:session): session opened for user usertest(uid=1001) by (uid=0) machine # [ 12.140460] systemd-logind[497]: New session '1' of user 'usertest' with class 'manager' and type 'unspecified'. machine # [ 12.241817] input: QEMU Virtio Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:09.0/virtio8/input/input3 machine # [ 12.237014] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 12.466066] systemd[576]: Queued start job for default target Main User Target. machine # [ 12.476606] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 12.506981] systemd[576]: Created slice User Application Slice. machine # [ 12.526709] systemd[576]: Started Daily Cleanup of User's Temporary Directories. machine # [ 12.537749] systemd[576]: Reached target Paths. machine # [ 12.547522] systemd[576]: Reached target Timers. machine # [ 12.555556] systemd[576]: Starting D-Bus User Message Bus Socket... machine # [ 12.567338] systemd[576]: Starting Create User Files and Directories... machine # [ 12.575102] systemd[576]: Finished Create User Files and Directories. machine # [ 12.604485] systemd[576]: Listening on D-Bus User Message Bus Socket. machine # [ 12.612589] systemd[576]: Reached target Sockets. machine # [ 12.621281] systemd[576]: Reached target Basic System. machine # [ 12.624316] systemd[1]: Started User Manager for UID 1001. machine # [ 12.629686] systemd[576]: Starting Run user-specific NixOS activation... machine # [ 12.677792] systemd[576]: Finished Run user-specific NixOS activation. machine # [ 12.683417] systemd[576]: Reached target Main User Target. machine # [ 12.689831] systemd[576]: Startup finished in 491ms. machine # [ 12.856623] dhcpcd[592]: dhcpcd-10.3.2 starting machine # [ 12.924987] dhcpcd[655]: dev: loaded udev machine # [ 12.938659] systemd[1]: Finished Extra networking commands.. machine # [ 12.955501] systemd[1]: Reached target Network. machine # [ 12.970054] dhcpcd[655]: no valid interfaces found machine # [ 12.987323] dhcpcd[655]: no valid interfaces found machine # [ 12.999800] dhcpcd[655]: libudev: received NULL device machine # [ 13.016118] systemd[1]: Starting Permit User Sessions... machine # [ 13.032350] dhcpcd[655]: libudev: received NULL device machine # [ 13.089437] systemd[1]: Starting Virtual Console Setup... machine # [ 13.115295] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs machine # [ 13.201553] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. machine # [ 13.213611] systemd[1]: Stopped Virtual Console Setup. machine # [ 13.214496] systemd[1]: Starting Virtual Console Setup... machine # [ 13.250160] systemd[1]: Finished Permit User Sessions. machine # [ 13.264930] systemd[1]: Started Getty on tty1. machine # [ 13.283197] systemd[1]: Reached target Login Prompts. machine # [ 13.308919] systemd[1]: Condition check resulted in /dev/hvc0 being skipped. machine # [ 13.371844] systemd[1]: Condition check resulted in /dev/ttyAMA0 being skipped. machine # [ 13.385743] systemd[1]: Started backdoor.service. machine # [ 13.449607] (udev-worker)[651]: Network interface NamePolicy= disabled on kernel command line. machine # [ 13.490222] 8021q: 802.1Q VLAN Support v1.8 machine # [ 13.484419] (udev-worker)[640]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. machine # [ 13.540224] (udev-worker)[640]: Network interface NamePolicy= disabled on kernel command line. machine # [ 13.605575] cfg80211: Loading compiled-in X.509 certificates for regulatory database machine # [ 13.648807] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' machine # [ 13.649355] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600' machine # [ 13.656211] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -2 machine # [ 13.656565] cfg80211: failed to load regulatory.db machine # [ 13.751743] systemd[1]: Condition check resulted in Virtio network device being skipped. machine # [ 13.776331] systemd[1]: Starting Address configuration of eth1... machine # [ 13.869037] systemd-logind[497]: Watching system buttons on /dev/input/event0 (gpio-keys) machine # connecting to host... machine # [ 14.020895] 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 14.33 seconds) machine: (finished: waiting for the VM to finish booting, in 14.96 seconds) machine # [ 14.082531] 8021q: adding VLAN 0 to HW filter on device eth0 machine # [ 14.073612] dhcpcd[655]: eth0: waiting for carrier machine # [ 14.082053] dhcpcd[655]: eth0: carrier acquired machine # [ 14.112586] 8021q: adding VLAN 0 to HW filter on device eth1 machine # [ 14.127121] dhcpcd[655]: DUID 00:01:00:01:32:2c:ea:5e:52:54:00:12:34:56 machine # [ 14.141428] dhcpcd[655]: eth0: IAID 00:12:34:56 machine # [ 14.142155] dhcpcd[655]: eth0: adding address fe80::5054:ff:fe12:3456 machine # [ 14.180488] network-addresses-eth1-start[678]: adding address 192.168.1.1/24... done machine # [ 14.267758] network-addresses-eth1-start[678]: adding address 2001:db8:1::1/64... done machine # [ 14.289734] systemd-logind[497]: Watching system buttons on /dev/input/event1 (QEMU QEMU USB Keyboard) machine # [ 14.382979] systemd[1]: Finished Address configuration of eth1. machine # [ 15.092800] dhcpcd[655]: eth0: soliciting a DHCP lease machine # [ 15.107555] dhcpcd[655]: eth0: offered 10.0.2.15 from 10.0.2.2 machine # [ 15.120472] dhcpcd[655]: eth0: probing address 10.0.2.15/24 machine # [ 15.356382] systemd-vconsole-setup[662]: Configuration of first virtual console was skipped, ignoring remaining ones. machine # [ 15.358133] systemd[1]: Finished Virtual Console Setup. machine # [ 15.695605] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch. machine # [ 15.721943] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. machine # [ 15.723082] systemd[1]: Stopped Virtual Console Setup. machine # [ 15.723823] systemd[1]: Stopping Virtual Console Setup... machine # [ 15.756302] systemd[1]: Starting Virtual Console Setup... machine # [ 15.762128] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. machine # [ 15.771082] systemd[1]: Stopped Virtual Console Setup. machine # [ 15.776882] systemd-logind[497]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard) machine # [ 15.778171] systemd[1]: Starting Virtual Console Setup... machine # [ 16.117225] systemd-vconsole-setup[730]: Configuration of first virtual console was skipped, ignoring remaining ones. machine # [ 16.124346] systemd[1]: Finished Virtual Console Setup. machine # [ 16.170313] dhcpcd[655]: eth0: soliciting an IPv6 router machine # [ 16.172794] dhcpcd[655]: eth0: Router Advertisement from fe80::2 machine # [ 16.174008] dhcpcd[655]: eth0: adding address fec0::5054:ff:fe12:3456/64 machine # [ 16.175275] dhcpcd[655]: eth0: adding route to fec0::/64 machine # [ 16.176554] dhcpcd[655]: eth0: adding default route via fe80::2 machine # [ 19.469269] dhcpcd[655]: eth0: leased 10.0.2.15 for 86400 seconds machine # [ 19.469638] dhcpcd[655]: eth0: adding route to 10.0.2.0/24 machine # [ 19.469795] dhcpcd[655]: eth0: adding default route via 10.0.2.2 machine # [ 19.634971] systemd[1]: Started DHCP Client. machine # [ 19.637158] systemd[1]: Reached target Multi-User System. machine # [ 19.638801] systemd[1]: Startup finished in 1.076s (kernel) + 4.714s (initrd) + 13.847s (userspace) = 19.638s. machine: (finished: waiting for unit multi-user.target, in 21.25 seconds) machine: must succeed: /nix/store/lcxydqrhkhwhva2mijlnq8rxfi36hpwd-stderr-runner /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test/bin/switch-to-configuration test machine # Checking switch inhibitors... done machine # [ 20.897969] nixos[833]: switching to system configuration /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test machine # [ 20.900912] systemd[1]: Stopped target Local File Systems. machine # activating the configuration... machine # [ 20.903839] systemd[1]: Stopped target Remote File Systems. machine # setting up /etc... machine # [ 21.385814] systemd[1]: Reload requested from client PID 833 ('.switch-to-conf') (unit backdoor.service)... machine # [ 21.387812] systemd[1]: Reloading... machine # [ 22.205898] systemd[1]: Reloading finished in 813 ms. machine # reloading user units for usertest... machine # [ 22.261592] systemd[576]: Created slice User Core Session Slice. machine # [ 22.265824] systemd[576]: Starting D-Bus User Message Bus... machine # [ 22.338917] dbus-broker-launch[903]: Ignoring duplicate name 'org.freedesktop.import1' in service file '/nix/store/zihqny80khrxshjrz8dszaixmccx9dn8-system-path/share/dbus-1/services/org.freedesktop.import1.service' machine # [ 22.342486] dbus-broker-launch[903]: Ignoring duplicate name 'org.freedesktop.machine1' in service file '/nix/store/zihqny80khrxshjrz8dszaixmccx9dn8-system-path/share/dbus-1/services/org.freedesktop.machine1.service' machine # [ 22.345914] dbus-broker-launch[903]: Ignoring duplicate name 'org.freedesktop.portable1' in service file '/nix/store/zihqny80khrxshjrz8dszaixmccx9dn8-system-path/share/dbus-1/services/org.freedesktop.portable1.service' machine # [ 22.349460] dbus-broker-launch[903]: Ignoring duplicate name 'org.freedesktop.systemd1' in service file '/nix/store/zihqny80khrxshjrz8dszaixmccx9dn8-system-path/share/dbus-1/services/org.freedesktop.systemd1.service' machine # [ 22.353163] dbus-broker-launch[903]: Policy to allow eavesdropping in /etc/dbus-1/session.conf +27: Eavesdropping is deprecated and ignored machine # [ 22.356322] dbus-broker-launch[903]: Policy to allow eavesdropping in /etc/dbus-1/session.conf +29: Eavesdropping is deprecated and ignored machine # [ 22.358364] systemd[576]: Started D-Bus User Message Bus. machine # [ 22.366874] dbus-broker-launch[903]: Ready machine # [ 22.462805] systemd[576]: Reexecution requested from client PID 902 ('switch-to-confi')... machine # [ 22.464952] systemd[576]: Reexecuting. machine # [ 22.534754] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 22.735861] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 22.742878] systemd[576]: Reload requested from client PID 902 ('switch-to-confi')... machine # [ 22.746878] systemd[576]: Reloading... machine # [ 22.937944] systemd[576]: Reloading finished in 191 ms. machine # [ 22.956173] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # restarting the following user units: nixos-activation.service machine # [ 22.966184] systemd[576]: Stopped Run user-specific NixOS activation. machine # [ 22.968574] systemd[576]: Stopping Run user-specific NixOS activation... machine # [ 22.971458] systemd[576]: Starting Run user-specific NixOS activation... machine # [ 23.018693] systemd[576]: Finished Run user-specific NixOS activation. machine # restarting sysinit-reactivation.target machine # [ 23.035810] systemd[1]: Starting Re-setup tmpfiles on a system that is already running.... machine # [ 23.147711] systemd[1]: Finished Re-setup tmpfiles on a system that is already running.. machine # [ 23.151745] systemd[1]: Reached target Reactivate sysinit units. machine # [ 23.154342] systemd[1]: Reached target Local File Systems. machine # [ 23.158075] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 23.163002] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 23.165781] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 23.168899] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 23.171089] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 23.182018] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 23.184110] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 23.185325] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 23.186601] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 23.187837] systemd[1]: Reached target Remote File Systems. machine # [ 23.512497] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 23.514567] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 23.515701] systemd[1]: Starting linger-users.service... machine # [ 23.590588] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 23.594323] systemd[1]: Finished linger-users.service. machine # the following new units were started: sysinit-reactivation.target, systemd-tmpfiles-resetup.service machine # [ 23.858499] nixos[833]: finished switching to system configuration /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test machine: (finished: must succeed: /nix/store/lcxydqrhkhwhva2mijlnq8rxfi36hpwd-stderr-runner /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test/bin/switch-to-configuration test, in 3.53 seconds) machine: must succeed: rm /etc/NIXOS machine: (finished: must succeed: rm /etc/NIXOS, in 0.05 seconds) machine: must succeed: /nix/store/lcxydqrhkhwhva2mijlnq8rxfi36hpwd-stderr-runner /nix/store/w8d6cl9adq53p90jbi5sf420kqnqk16c-nixos-system-other-test/bin/switch-to-configuration test machine # this should succeed (config: /nix/store/w8d6cl9adq53p90jbi5sf420kqnqk16c-nixos-system-other-test, action: test) machine # Checking switch inhibitors... done machine # [ 24.572953] nixos[981]: switching to system configuration /nix/store/w8d6cl9adq53p90jbi5sf420kqnqk16c-nixos-system-other-test machine # activating the configuration... machine # [ 24.577492] systemd[1]: Stopped target Local File Systems. machine # [ 24.578672] systemd[1]: Stopped target Remote File Systems. machine # removing user ‘usertest’ machine # setting up /etc... machine # [ 25.109026] systemd[1]: Reload requested from client PID 981 ('.switch-to-conf') (unit backdoor.service)... machine # [ 25.111009] systemd[1]: Reloading... machine # [ 25.991475] systemd[1]: Reloading finished in 877 ms. machine # reloading user units for usertest... machine # [ 26.169207] systemd[576]: Reexecution requested from client PID 1052 ('switch-to-confi')... machine # [ 26.173063] systemd[576]: Reexecuting. machine # [ 26.225726] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 26.449585] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 26.457718] systemd[576]: Reload requested from client PID 1052 ('switch-to-confi')... machine # [ 26.459605] systemd[576]: Reloading... machine # [ 26.669772] systemd[576]: Reloading finished in 209 ms. machine # [ 26.684184] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # restarting the following user units: nixos-activation.service machine # [ 26.697627] systemd[576]: Stopped Run user-specific NixOS activation. machine # [ 26.698632] systemd[576]: Stopping Run user-specific NixOS activation... machine # [ 26.701743] systemd[576]: Starting Run user-specific NixOS activation... machine # [ 26.753490] systemd[576]: Finished Run user-specific NixOS activation. machine # restarting sysinit-reactivation.target machine # [ 26.760151] systemd[1]: Stopped target Reactivate sysinit units. machine # reloading the following units: dbus-broker.service machine # [ 26.763443] systemd[1]: Stopping Reactivate sysinit units... machine # [ 26.766341] systemd[1]: Reached target Reactivate sysinit units. machine # [ 26.767369] systemd[1]: Reloading D-Bus System Message Bus... machine # [ 26.769557] dbus-broker-launch[478]: Caught SIGHUP, trigger reload. machine # [ 26.790413] dbus-broker-launch[478]: Looking up NSS user entry for 'systemd-timesync'... machine # [ 26.792979] dbus-broker-launch[478]: NSS returned no entry for 'systemd-timesync' machine # [ 26.794205] dbus-broker-launch[478]: Invalid user-name in /nix/store/3rhwfjl7q5bcsy7jl3vz93dahhcdhpzi-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" machine # [ 26.824800] systemd[1]: Reloaded D-Bus System Message Bus. machine # restarting the following units: network-addresses-eth1.service machine # [ 26.833041] systemd[1]: Stopping Address configuration of eth1... machine # [ 26.910952] network-addresses-eth1-pre-stop[1064]: deleting address 192.168.1.1/24... done machine # [ 26.926810] network-addresses-eth1-pre-stop[1064]: deleting address 2001:db8:1::1/64... done machine # [ 26.940522] systemd[1]: network-addresses-eth1.service: Deactivated successfully. machine # [ 26.944750] systemd[1]: Stopped Address configuration of eth1. machine # [ 26.949246] systemd[1]: Starting Address configuration of eth1... machine # [ 27.032897] network-addresses-eth1-start[1069]: adding address 192.168.1.2/24... done machine # [ 27.045040] network-addresses-eth1-start[1069]: adding address 2001:db8:1::2/64... done machine # [ 27.061820] systemd[1]: Finished Address configuration of eth1. machine # [ 27.069935] systemd[1]: Reached target Remote File Systems. machine # [ 27.076154] systemd[1]: Starting linger-users.service... machine # [ 27.079563] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 27.084268] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 27.090153] systemd[1]: Reached target Local File Systems. machine # [ 27.096353] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 27.101352] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 27.103650] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 27.109436] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 27.111553] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 27.115043] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 27.117296] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 27.159047] linger-users-start[1084]: id: ‘usertest’: no such user machine # [ 27.163301] linger-users-start[1081]: Removing linger for missing user usertest machine # [ 27.176176] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 27.179879] systemd[1]: Finished linger-users.service. machine # [ 27.501535] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 27.504929] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 27.762230] nixos[981]: finished switching to system configuration /nix/store/w8d6cl9adq53p90jbi5sf420kqnqk16c-nixos-system-other-test machine: (finished: must succeed: /nix/store/lcxydqrhkhwhva2mijlnq8rxfi36hpwd-stderr-runner /nix/store/w8d6cl9adq53p90jbi5sf420kqnqk16c-nixos-system-other-test/bin/switch-to-configuration test, in 3.85 seconds) subtest: services machine: must succeed: /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test/bin/switch-to-configuration test 2>&1 machine # [ 28.354761] nixos[1148]: switching to system configuration /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test machine # [ 28.357824] systemd[1]: Stopped target Remote File Systems. machine # [ 28.360216] systemd[1]: Stopped target Local File Systems. machine # [ 28.851662] systemd[1]: Reload requested from client PID 1148 ('.switch-to-conf') (unit backdoor.service)... machine # [ 28.853951] systemd[1]: Reloading... machine # [ 29.845668] systemd[1]: Reloading finished in 989 ms. machine # [ 30.006231] systemd[576]: Reexecution requested from client PID 1217 ('switch-to-confi')... machine # [ 30.010586] systemd[576]: Reexecuting. machine # [ 30.070204] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 30.305592] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 30.313127] systemd[576]: Reload requested from client PID 1217 ('switch-to-confi')... machine # [ 30.315071] systemd[576]: Reloading... machine # [ 30.514494] systemd[576]: Reloading finished in 198 ms. machine # [ 30.529949] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 30.540156] systemd[576]: Stopped Run user-specific NixOS activation. machine # [ 30.541324] systemd[576]: Stopping Run user-specific NixOS activation... machine # [ 30.545264] systemd[576]: Starting Run user-specific NixOS activation... machine # [ 30.598650] systemd[576]: Finished Run user-specific NixOS activation. machine # [ 30.603482] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 30.609780] systemd[1]: Stopping Reactivate sysinit units... machine # [ 30.610939] systemd[1]: Reached target Reactivate sysinit units. machine # [ 30.612904] dbus-broker-launch[478]: Caught SIGHUP, trigger reload. machine # [ 30.614427] systemd[1]: Reloading D-Bus System Message Bus... machine # [ 30.624936] dbus-broker-launch[478]: Looking up NSS user entry for 'systemd-timesync'... machine # [ 30.627508] dbus-broker-launch[478]: NSS returned no entry for 'systemd-timesync' machine # [ 30.629001] dbus-broker-launch[478]: Invalid user-name in /nix/store/zihqny80khrxshjrz8dszaixmccx9dn8-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" machine # [ 30.658619] systemd[1]: Reloaded D-Bus System Message Bus. machine # [ 30.666793] systemd[1]: Stopping Address configuration of eth1... machine # [ 30.722350] network-addresses-eth1-pre-stop[1230]: deleting address 192.168.1.2/24... done machine # [ 30.735813] network-addresses-eth1-pre-stop[1230]: deleting address 2001:db8:1::2/64... done machine # [ 30.748263] systemd[1]: network-addresses-eth1.service: Deactivated successfully. machine # [ 30.750308] systemd[1]: Stopped Address configuration of eth1. machine # [ 30.756739] systemd[1]: Starting Address configuration of eth1... machine # [ 30.839346] network-addresses-eth1-start[1235]: adding address 192.168.1.1/24... done machine # [ 30.854478] network-addresses-eth1-start[1235]: adding address 2001:db8:1::1/64... done machine # [ 30.871894] systemd[1]: Finished Address configuration of eth1. machine # [ 30.877399] systemd[1]: Reached target Local File Systems. machine # [ 30.881069] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 30.882538] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 30.886432] systemd[1]: Reached target Remote File Systems. machine # [ 30.894363] systemd[1]: Starting linger-users.service... machine # [ 30.898821] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 30.909058] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 30.913495] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 30.918722] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 30.924564] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 30.926257] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 30.927526] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 30.983912] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 30.987296] systemd[1]: Finished linger-users.service. machine # [ 31.327807] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 31.331555] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 31.592598] nixos[1148]: finished switching to system configuration /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test machine: (finished: must succeed: /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test/bin/switch-to-configuration test 2>&1, in 3.83 seconds) machine: must succeed: /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test/bin/switch-to-configuration test 2>&1 machine # [ 32.238645] nixos[1304]: switching to system configuration /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test machine # [ 32.241681] systemd[1]: Stopped target Remote File Systems. machine # [ 32.244284] systemd[1]: Stopped target Local File Systems. machine # [ 32.780143] systemd[1]: Reload requested from client PID 1304 ('.switch-to-conf') (unit backdoor.service)... machine # [ 32.782288] systemd[1]: Reloading... machine # [ 33.441707] systemd[1]: Reloading finished in 656 ms. machine # [ 33.637566] systemd[576]: Reexecution requested from client PID 1373 ('switch-to-confi')... machine # [ 33.641585] systemd[576]: Reexecuting. machine # [ 33.690798] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 33.917838] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 33.924876] systemd[576]: Reload requested from client PID 1373 ('switch-to-confi')... machine # [ 33.927476] systemd[576]: Reloading... machine # [ 34.144301] systemd[576]: Reloading finished in 215 ms. machine # [ 34.160234] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 34.170562] systemd[576]: Stopped Run user-specific NixOS activation. machine # [ 34.173216] systemd[576]: Stopping Run user-specific NixOS activation... machine # [ 34.176522] systemd[576]: Starting Run user-specific NixOS activation... machine # [ 34.231169] systemd[576]: Finished Run user-specific NixOS activation. machine # [ 34.235813] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 34.238517] systemd[1]: Stopping Reactivate sysinit units... machine # [ 34.239393] systemd[1]: Reached target Reactivate sysinit units. machine # [ 34.241901] systemd[1]: Reached target Remote File Systems. machine # [ 34.245044] systemd[1]: Reached target Local File Systems. machine # [ 34.248833] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 34.253161] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 34.257243] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 34.258597] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 34.268373] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 34.270095] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 34.271437] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 34.274646] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 34.277430] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 34.645697] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 34.650751] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 34.653835] systemd[1]: Starting linger-users.service... machine # [ 34.721213] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 34.724543] systemd[1]: Finished linger-users.service. machine # [ 34.982981] nixos[1304]: finished switching to system configuration /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test machine: (finished: must succeed: /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test/bin/switch-to-configuration test 2>&1, in 3.39 seconds) machine: must succeed: /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration test 2>&1 machine # [ 35.672473] nixos[1445]: switching to system configuration /nix/store/p3fcif5mjimf1yzli0xiddmngr10pdq6-nixos-system-machine-test machine # [ 35.675858] systemd[1]: Stopped target Local File Systems. machine # [ 35.677417] systemd[1]: Stopped target Remote File Systems. machine # [ 36.261914] systemd[1]: Reload requested from client PID 1445 ('.switch-to-conf') (unit backdoor.service)... machine # [ 36.264151] systemd[1]: Reloading... machine # [ 37.323869] systemd[1]: Reloading finished in 1057 ms. machine # [ 37.518088] systemd[576]: Reexecution requested from client PID 1513 ('switch-to-confi')... machine # [ 37.519521] systemd[576]: Reexecuting. machine # [ 37.579309] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 37.799785] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 37.807873] systemd[576]: Reload requested from client PID 1513 ('switch-to-confi')... machine # [ 37.809953] systemd[576]: Reloading... machine # [ 38.031379] systemd[576]: Reloading finished in 220 ms. machine # [ 38.044219] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 38.056558] systemd[576]: Stopped Run user-specific NixOS activation. machine # [ 38.059218] systemd[576]: Stopping Run user-specific NixOS activation... machine # [ 38.062858] systemd[576]: Starting Run user-specific NixOS activation... machine # [ 38.114635] systemd[576]: Finished Run user-specific NixOS activation. machine # [ 38.119462] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 38.122547] systemd[1]: Stopping Reactivate sysinit units... machine # [ 38.124820] systemd[1]: Reached target Reactivate sysinit units. machine # [ 38.126891] systemd[1]: Reached target Remote File Systems. machine # [ 38.129152] systemd[1]: Reached target Local File Systems. machine # [ 38.133007] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 38.139736] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 38.142299] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 38.144660] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 38.146829] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 38.156578] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 38.160986] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 38.162304] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 38.163538] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 38.560457] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 38.565096] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 38.571273] systemd[1]: Starting linger-users.service... machine # [ 38.575369] systemd[1]: Starting test.service... machine # [ 38.628839] systemd[1]: Finished test.service. machine # [ 38.660937] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 38.663473] systemd[1]: Finished linger-users.service. machine # [ 38.922850] nixos[1445]: finished switching to system configuration /nix/store/p3fcif5mjimf1yzli0xiddmngr10pdq6-nixos-system-machine-test machine: (finished: must succeed: /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration test 2>&1, in 3.94 seconds) machine: must succeed: /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration test 2>&1 machine # [ 39.653600] nixos[1588]: switching to system configuration /nix/store/p3fcif5mjimf1yzli0xiddmngr10pdq6-nixos-system-machine-test machine # [ 39.656919] systemd[1]: Stopped target Local File Systems. machine # [ 39.659882] systemd[1]: Stopped target Remote File Systems. machine # [ 40.318908] systemd[1]: Reload requested from client PID 1588 ('.switch-to-conf') (unit backdoor.service)... machine # [ 40.321311] systemd[1]: Reloading... machine # [ 41.105913] systemd[1]: Reloading finished in 780 ms. machine # [ 41.282620] systemd[576]: Reexecution requested from client PID 1657 ('switch-to-confi')... machine # [ 41.285825] systemd[576]: Reexecuting. machine # [ 41.359728] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 41.605655] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 41.612914] systemd[576]: Reload requested from client PID 1657 ('switch-to-confi')... machine # [ 41.615487] systemd[576]: Reloading... machine # [ 41.869271] systemd[576]: Reloading finished in 251 ms. machine # [ 41.884201] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 41.894946] systemd[576]: Stopped Run user-specific NixOS activation. machine # [ 41.897755] systemd[576]: Stopping Run user-specific NixOS activation... machine # [ 41.900966] systemd[576]: Starting Run user-specific NixOS activation... machine # [ 41.965567] systemd[576]: Finished Run user-specific NixOS activation. machine # [ 41.971319] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 41.974566] systemd[1]: Stopping Reactivate sysinit units... machine # [ 41.975503] systemd[1]: Reached target Reactivate sysinit units. machine # [ 41.980535] systemd[1]: Reached target Remote File Systems. machine # [ 41.989549] systemd[1]: Starting linger-users.service... machine # [ 41.995740] systemd[1]: Reached target Local File Systems. machine # [ 41.997837] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 42.001922] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 42.002958] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 42.017537] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 42.019997] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 42.030246] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 42.031576] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 42.033261] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 42.034581] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 42.127610] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 42.131127] systemd[1]: Finished linger-users.service. machine # [ 42.537255] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 42.541339] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 42.798763] nixos[1588]: finished switching to system configuration /nix/store/p3fcif5mjimf1yzli0xiddmngr10pdq6-nixos-system-machine-test machine: (finished: must succeed: /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration test 2>&1, in 3.87 seconds) machine: must succeed: /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test/specialisation/simpleServiceDifferentDescription/bin/switch-to-configuration test 2>&1 machine # [ 43.584670] nixos[1729]: switching to system configuration /nix/store/a1s4vj6li6xk4nd7av95z7c7g1i0jqd7-nixos-system-machine-test machine # [ 43.589484] systemd[1]: Stopped target Remote File Systems. machine # [ 43.592283] systemd[1]: Stopped target Local File Systems. machine # [ 44.200490] systemd[1]: Reload requested from client PID 1729 ('.switch-to-conf') (unit backdoor.service)... machine # [ 44.202504] systemd[1]: Reloading... machine # [ 44.954195] systemd[1]: Reloading finished in 748 ms. machine # [ 45.131807] systemd[576]: Reexecution requested from client PID 1799 ('switch-to-confi')... machine # [ 45.134379] systemd[576]: Reexecuting. machine # [ 45.204095] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 45.432778] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 45.440808] systemd[576]: Reload requested from client PID 1799 ('switch-to-confi')... machine # [ 45.442960] systemd[576]: Reloading... machine # [ 45.674485] systemd[576]: Reloading finished in 230 ms. machine # [ 45.688283] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 45.699367] systemd[576]: Stopped Run user-specific NixOS activation. machine # [ 45.702048] systemd[576]: Stopping Run user-specific NixOS activation... machine # [ 45.705559] systemd[576]: Starting Run user-specific NixOS activation... machine # [ 45.769410] systemd[576]: Finished Run user-specific NixOS activation. machine # [ 45.774484] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 45.776962] systemd[1]: Stopping Reactivate sysinit units... machine # [ 45.778680] systemd[1]: Reached target Reactivate sysinit units. machine # [ 45.785674] systemd[1]: Reached target Remote File Systems. machine # [ 45.788987] systemd[1]: Reached target Local File Systems. machine # [ 45.791971] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 45.800785] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 45.801840] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 45.803092] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 45.808786] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 45.820485] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 45.821816] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 45.823021] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 45.825444] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 46.283116] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 46.288602] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 46.291553] systemd[1]: Starting linger-users.service... machine # [ 46.363443] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 46.366334] systemd[1]: Finished linger-users.service. machine # [ 46.625217] nixos[1729]: finished switching to system configuration /nix/store/a1s4vj6li6xk4nd7av95z7c7g1i0jqd7-nixos-system-machine-test machine: (finished: must succeed: /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test/specialisation/simpleServiceDifferentDescription/bin/switch-to-configuration test 2>&1, in 3.83 seconds) machine: must succeed: /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test/specialisation/simpleServiceModified/bin/switch-to-configuration test 2>&1 machine # [ 47.361853] nixos[1870]: switching to system configuration /nix/store/fc9vv51r37nmsfcdlr91j5hw1qh4ig2x-nixos-system-machine-test machine # [ 47.365980] systemd[1]: Stopped target Local File Systems. machine # [ 47.367776] systemd[1]: Stopped target Remote File Systems. machine # [ 47.369445] systemd[1]: test.service: Deactivated successfully. machine # [ 47.370296] systemd[1]: Stopped Test unit. machine # [ 47.946407] systemd[1]: Reload requested from client PID 1870 ('.switch-to-conf') (unit backdoor.service)... machine # [ 47.948634] systemd[1]: Reloading... machine # [ 48.674288] systemd[1]: Reloading finished in 721 ms. machine # [ 48.836488] systemd[576]: Reexecution requested from client PID 1940 ('switch-to-confi')... machine # [ 48.840342] systemd[576]: Reexecuting. machine # [ 48.907205] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 49.112303] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 49.118992] systemd[576]: Reload requested from client PID 1940 ('switch-to-confi')... machine # [ 49.121669] systemd[576]: Reloading... machine # [ 49.324524] systemd[576]: Reloading finished in 202 ms. machine # [ 49.340199] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 49.350836] systemd[576]: Stopped Run user-specific NixOS activation. machine # [ 49.353437] systemd[576]: Stopping Run user-specific NixOS activation... machine # [ 49.356569] systemd[576]: Starting Run user-specific NixOS activation... machine # [ 49.409924] systemd[576]: Finished Run user-specific NixOS activation. machine # [ 49.414844] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 49.417323] systemd[1]: Stopping Reactivate sysinit units... machine # [ 49.423053] systemd[1]: Reached target Reactivate sysinit units. machine # [ 49.424210] systemd[1]: Reached target Remote File Systems. machine # [ 49.428376] systemd[1]: Starting linger-users.service... machine # [ 49.432990] systemd[1]: Starting test.service... machine # [ 49.451470] systemd[1]: Reached target Local File Systems. machine # [ 49.455318] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 49.459486] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 49.468660] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 49.478140] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 49.480103] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 49.481622] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 49.488750] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 49.490547] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 49.491969] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 49.521805] systemd[1]: Finished test.service. machine # [ 49.575425] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 49.578164] systemd[1]: Finished linger-users.service. machine # [ 49.900003] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 49.903588] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 50.161186] nixos[1870]: finished switching to system configuration /nix/store/fc9vv51r37nmsfcdlr91j5hw1qh4ig2x-nixos-system-machine-test machine: (finished: must succeed: /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test/specialisation/simpleServiceModified/bin/switch-to-configuration test 2>&1, in 3.54 seconds) machine: must succeed: /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1 machine # [ 50.833143] nixos[2013]: switching to system configuration /nix/store/q4hqx9aiw9lpsqrdz9v39nigfilgnwpv-nixos-system-machine-test machine # [ 50.836488] systemd[1]: Stopped target Local File Systems. machine # [ 50.837913] systemd[1]: Stopped target Remote File Systems. machine # [ 51.407328] systemd[1]: Reload requested from client PID 2013 ('.switch-to-conf') (unit backdoor.service)... machine # [ 51.409771] systemd[1]: Reloading... machine # [ 52.087978] systemd[1]: Reloading finished in 676 ms. machine # [ 52.232924] systemd[576]: Reexecution requested from client PID 2082 ('switch-to-confi')... machine # [ 52.236677] systemd[576]: Reexecuting. machine # [ 52.285851] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 52.481609] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 52.488340] systemd[576]: Reload requested from client PID 2082 ('switch-to-confi')... machine # [ 52.490894] systemd[576]: Reloading... machine # [ 52.686675] systemd[576]: Reloading finished in 194 ms. machine # [ 52.700292] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 52.710194] systemd[576]: Stopped Run user-specific NixOS activation. machine # [ 52.712664] systemd[576]: Stopping Run user-specific NixOS activation... machine # [ 52.715554] systemd[576]: Starting Run user-specific NixOS activation... machine # [ 52.762907] systemd[576]: Finished Run user-specific NixOS activation. machine # [ 52.767474] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 52.769262] systemd[1]: Stopping Reactivate sysinit units... machine # [ 52.770091] systemd[1]: Reached target Reactivate sysinit units. machine # [ 52.772345] systemd[1]: test.service: Deactivated successfully. machine # [ 52.775326] systemd[1]: Stopped test.service. machine # [ 52.776351] systemd[1]: Stopping test.service... machine # [ 52.778569] systemd[1]: Starting test.service... machine # [ 52.816559] systemd[1]: Finished test.service. machine # [ 52.820351] systemd[1]: Reached target Remote File Systems. machine # [ 52.827014] systemd[1]: Starting linger-users.service... machine # [ 52.833142] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 52.834492] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 52.841371] systemd[1]: Reached target Local File Systems. machine # [ 52.843266] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 52.852982] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 52.853858] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 52.855046] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 52.859510] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 52.868224] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 52.871076] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 52.938137] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 52.941314] systemd[1]: Finished linger-users.service. machine # [ 53.238828] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 53.242567] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 53.499466] nixos[2013]: finished switching to system configuration /nix/store/q4hqx9aiw9lpsqrdz9v39nigfilgnwpv-nixos-system-machine-test machine: (finished: must succeed: /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1, in 3.34 seconds) machine: must succeed: /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test/specialisation/simpleServiceReload/bin/switch-to-configuration test 2>&1 machine # [ 54.160383] nixos[2155]: switching to system configuration /nix/store/klh49g58ayjnqpmd5qh5nqx9drvka1nj-nixos-system-machine-test machine # [ 54.163109] systemd[1]: Stopped target Local File Systems. machine # [ 54.165436] systemd[1]: Stopped target Remote File Systems. machine # [ 54.693253] systemd[1]: Reload requested from client PID 2155 ('.switch-to-conf') (unit backdoor.service)... machine # [ 54.695190] systemd[1]: Reloading... machine # [ 55.393780] systemd[1]: Reloading finished in 695 ms. machine # [ 55.544250] systemd[576]: Reexecution requested from client PID 2224 ('switch-to-confi')... machine # [ 55.546017] systemd[576]: Reexecuting. machine # [ 55.605510] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 55.797876] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 55.804643] systemd[576]: Reload requested from client PID 2224 ('switch-to-confi')... machine # [ 55.806844] systemd[576]: Reloading... machine # [ 56.002109] systemd[576]: Reloading finished in 193 ms. machine # [ 56.012180] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 56.023282] systemd[576]: Stopped Run user-specific NixOS activation. machine # [ 56.025724] systemd[576]: Stopping Run user-specific NixOS activation... machine # [ 56.028551] systemd[576]: Starting Run user-specific NixOS activation... machine # [ 56.077726] systemd[576]: Finished Run user-specific NixOS activation. machine # [ 56.081860] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 56.086109] systemd[1]: Stopping Reactivate sysinit units... machine # [ 56.087301] systemd[1]: Reached target Reactivate sysinit units. machine # [ 56.089983] systemd[1]: Reloading test.service... machine # [ 56.123986] systemd[1]: Reloaded test.service. machine # [ 56.127995] systemd[1]: Reached target Local File Systems. machine # [ 56.135066] systemd[1]: Reached target Remote File Systems. machine # [ 56.138301] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 56.142779] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 56.143697] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 56.147225] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 56.156569] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 56.158285] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 56.159531] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 56.164700] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 56.166055] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 56.492826] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 56.496709] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 56.499812] systemd[1]: Starting linger-users.service... machine # [ 56.563142] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 56.565871] systemd[1]: Finished linger-users.service. machine # [ 56.824598] nixos[2155]: finished switching to system configuration /nix/store/klh49g58ayjnqpmd5qh5nqx9drvka1nj-nixos-system-machine-test machine: (finished: must succeed: /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test/specialisation/simpleServiceReload/bin/switch-to-configuration test 2>&1, in 3.32 seconds) machine: must succeed: /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test/specialisation/simpleServiceNorestart/bin/switch-to-configuration test 2>&1 machine # [ 57.455271] nixos[2297]: switching to system configuration /nix/store/6cf4937d4majd9i2kzr31yq3vrqj0sid-nixos-system-machine-test machine # [ 57.458572] systemd[1]: Stopped target Local File Systems. machine # [ 57.459985] systemd[1]: Stopped target Remote File Systems. machine # [ 58.037628] systemd[1]: Reload requested from client PID 2297 ('.switch-to-conf') (unit backdoor.service)... machine # [ 58.039635] systemd[1]: Reloading... machine # [ 58.772693] systemd[1]: Reloading finished in 731 ms. machine # [ 58.936473] systemd[576]: Reexecution requested from client PID 2366 ('switch-to-confi')... machine # [ 58.940126] systemd[576]: Reexecuting. machine # [ 58.995559] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 59.251889] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 59.259641] systemd[576]: Reload requested from client PID 2366 ('switch-to-confi')... machine # [ 59.264176] systemd[576]: Reloading... machine # [ 59.473003] systemd[576]: Reloading finished in 210 ms. machine # [ 59.489753] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 59.501198] systemd[576]: Stopped Run user-specific NixOS activation. machine # [ 59.504118] systemd[576]: Stopping Run user-specific NixOS activation... machine # [ 59.507828] systemd[576]: Starting Run user-specific NixOS activation... machine # [ 59.562876] systemd[576]: Finished Run user-specific NixOS activation. machine # [ 59.567614] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 59.569871] systemd[1]: Stopping Reactivate sysinit units... machine # [ 59.574784] systemd[1]: Reached target Reactivate sysinit units. machine # [ 59.576197] systemd[1]: Reached target Remote File Systems. machine # [ 59.578998] systemd[1]: Starting linger-users.service... machine # [ 59.581981] systemd[1]: Reached target Local File Systems. machine # [ 59.586011] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 59.592813] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 59.594933] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 59.602361] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 59.609002] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 59.614639] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 59.620420] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 59.622213] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 59.624653] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 59.693890] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 59.697683] systemd[1]: Finished linger-users.service. machine # [ 60.019646] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 60.023457] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 60.280485] nixos[2297]: finished switching to system configuration /nix/store/6cf4937d4majd9i2kzr31yq3vrqj0sid-nixos-system-machine-test machine: (finished: must succeed: /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test/specialisation/simpleServiceNorestart/bin/switch-to-configuration test 2>&1, in 3.46 seconds) machine: must succeed: /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration dry-activate 2>&1 machine: (finished: must succeed: /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration dry-activate 2>&1, in 0.79 seconds) machine: must succeed: /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test/bin/switch-to-configuration test 2>&1 machine # [ 61.716691] nixos[2447]: switching to system configuration /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test machine # [ 61.721389] systemd[1]: Stopped target Local File Systems. machine # [ 61.723610] systemd[1]: Stopped target Remote File Systems. machine # [ 61.725409] systemd[1]: test.service: Deactivated successfully. machine # [ 61.726530] systemd[1]: Stopped test.service. machine # [ 62.262929] systemd[1]: Reload requested from client PID 2447 ('.switch-to-conf') (unit backdoor.service)... machine # [ 62.265272] systemd[1]: Reloading... machine # [ 62.965393] systemd[1]: Reloading finished in 697 ms. machine # [ 63.142157] systemd[576]: Reexecution requested from client PID 2516 ('switch-to-confi')... machine # [ 63.143852] systemd[576]: Reexecuting. machine # [ 63.214848] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 63.426337] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 63.432934] systemd[576]: Reload requested from client PID 2516 ('switch-to-confi')... machine # [ 63.435390] systemd[576]: Reloading... machine # [ 63.639127] systemd[576]: Reloading finished in 202 ms. machine # [ 63.652172] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 63.662085] systemd[576]: Stopped Run user-specific NixOS activation. machine # [ 63.664639] systemd[576]: Stopping Run user-specific NixOS activation... machine # [ 63.667781] systemd[576]: Starting Run user-specific NixOS activation... machine # [ 63.717796] systemd[576]: Finished Run user-specific NixOS activation. machine # [ 63.722165] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 63.724396] systemd[1]: Stopping Reactivate sysinit units... machine # [ 63.725337] systemd[1]: Reached target Reactivate sysinit units. machine # [ 63.727565] systemd[1]: Reached target Remote File Systems. machine # [ 63.729568] systemd[1]: Reached target Local File Systems. machine # [ 63.737546] systemd[1]: Starting linger-users.service... machine # [ 63.747355] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 63.750393] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 63.755712] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 63.763005] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 63.763911] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 63.766254] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 63.769226] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 63.771426] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 63.773668] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 63.835074] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 63.837777] systemd[1]: Finished linger-users.service. machine # [ 64.141921] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 64.145375] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 64.402273] nixos[2447]: finished switching to system configuration /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test machine: (finished: must succeed: /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test/bin/switch-to-configuration test 2>&1, in 3.34 seconds) machine: must succeed: /nix/store/rkj73kh2sz4jv6nhdk6fkf0j6zm71y3w-separate-activation-script/bin/switch-to-configuration test 2>&1 machine # [ 65.039502] nixos[2587]: switching to system configuration /nix/store/1ag5piy16h3v1f78wcck9whd2vfxir6x-nixos-system-machine-test machine # [ 65.042683] systemd[1]: Stopped target Local File Systems. machine # [ 65.044070] systemd[1]: Stopped target Remote File Systems. machine # [ 65.586092] systemd[1]: Reload requested from client PID 2587 ('.switch-to-conf') (unit backdoor.service)... machine # [ 65.588539] systemd[1]: Reloading... machine # [ 66.232973] systemd[1]: Reloading finished in 642 ms. machine # [ 66.399253] systemd[576]: Stopped Run user-specific NixOS activation. machine # [ 66.402666] systemd[576]: Reexecution requested from client PID 2656 ('switch-to-confi')... machine # [ 66.404985] systemd[576]: Reexecuting. machine # [ 66.470116] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 66.668806] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 66.675009] systemd[576]: Reload requested from client PID 2656 ('switch-to-confi')... machine # [ 66.678890] systemd[576]: Reloading... machine # [ 66.865644] systemd[576]: Reloading finished in 187 ms. machine # [ 66.880190] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 66.891877] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 66.895559] systemd[1]: Stopping Reactivate sysinit units... machine # [ 66.896744] systemd[1]: Reached target Reactivate sysinit units. machine # [ 66.898125] systemd[1]: Reached target Remote File Systems. machine # [ 66.904240] systemd[1]: Starting linger-users.service... machine # [ 66.907773] systemd[1]: Starting test.service... machine # [ 66.914434] systemd[1]: Reached target Local File Systems. machine # [ 66.920596] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 66.926644] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 66.936776] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 66.938100] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 66.948438] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 66.950634] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 66.953497] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 66.955768] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 66.958778] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 66.994387] systemd[1]: Finished test.service. machine # [ 67.029781] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 67.032262] systemd[1]: Finished linger-users.service. machine # [ 67.298149] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 67.301739] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 67.560848] nixos[2587]: finished switching to system configuration /nix/store/1ag5piy16h3v1f78wcck9whd2vfxir6x-nixos-system-machine-test machine: (finished: must succeed: /nix/store/rkj73kh2sz4jv6nhdk6fkf0j6zm71y3w-separate-activation-script/bin/switch-to-configuration test 2>&1, in 3.16 seconds) machine: must succeed: ! test -e /run/current-system/activate machine: (finished: must succeed: ! test -e /run/current-system/activate, in 0.04 seconds) machine: must succeed: ! test -e /run/current-system/dry-activate machine: (finished: must succeed: ! test -e /run/current-system/dry-activate, in 0.03 seconds) machine: must succeed: ! test -e /run/current-system/bin/switch-to-configuration machine: (finished: must succeed: ! test -e /run/current-system/bin/switch-to-configuration, in 0.03 seconds) machine: must succeed: /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test/specialisation/unitWithMultilineValue/bin/switch-to-configuration test 2>&1 machine # [ 68.287180] nixos[2735]: switching to system configuration /nix/store/xkkwaz9sh11f70kmm4f33xhny4iaaq0j-nixos-system-machine-test machine # [ 68.291278] systemd[1]: Stopped target Local File Systems. machine # [ 68.293267] systemd[1]: Stopped target Remote File Systems. machine # [ 68.294096] systemd[1]: test.service: Deactivated successfully. machine # [ 68.294890] systemd[1]: Stopped test.service. machine # [ 68.822430] systemd[1]: Reload requested from client PID 2735 ('.switch-to-conf') (unit backdoor.service)... machine # [ 68.824572] systemd[1]: Reloading... machine # [ 69.478181] systemd[1]: Reloading finished in 651 ms. machine # [ 69.620143] systemd[576]: Reexecution requested from client PID 2804 ('switch-to-confi')... machine # [ 69.621565] systemd[576]: Reexecuting. machine # [ 69.678123] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 69.865932] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 69.872268] systemd[576]: Reload requested from client PID 2804 ('switch-to-confi')... machine # [ 69.874580] systemd[576]: Reloading... machine # [ 70.063495] systemd[576]: Reloading finished in 187 ms. machine # [ 70.076155] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 70.086018] systemd[576]: Starting Run user-specific NixOS activation... machine # [ 70.129807] systemd[576]: Finished Run user-specific NixOS activation. machine # [ 70.132970] systemd[576]: Stopped Run user-specific NixOS activation. machine # [ 70.135325] systemd[576]: Stopping Run user-specific NixOS activation... machine # [ 70.139119] systemd[576]: Starting Run user-specific NixOS activation... machine # [ 70.141286] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 70.143285] systemd[1]: Stopping Reactivate sysinit units... machine # [ 70.148182] systemd[1]: Reached target Reactivate sysinit units. machine # [ 70.151855] systemd[1]: Reached target Remote File Systems. machine # [ 70.156374] systemd[1]: Starting linger-users.service... machine # [ 70.168331] systemd[1]: Reached target Local File Systems. machine # [ 70.171739] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 70.177585] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 70.194231] systemd[1]: Started test.service. machine # [ 70.201199] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 70.212327] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 70.225863] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 70.227231] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 70.231016] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 70.235951] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 70.238294] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 70.241715] systemd[576]: Finished Run user-specific NixOS activation. machine # [ 70.276566] systemd[1]: test.service: Deactivated successfully. machine # [ 70.294610] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 70.295623] systemd[1]: Finished linger-users.service. machine # [ 70.591969] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 70.595439] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 70.852365] nixos[2735]: finished switching to system configuration /nix/store/xkkwaz9sh11f70kmm4f33xhny4iaaq0j-nixos-system-machine-test machine: (finished: must succeed: /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test/specialisation/unitWithMultilineValue/bin/switch-to-configuration test 2>&1, in 3.19 seconds) machine: must succeed: /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test/specialisation/unitWithBackslash/bin/switch-to-configuration test 2>&1 machine # [ 71.474815] nixos[2880]: switching to system configuration /nix/store/yq7jh353wgyf6x9plx098k6di6j13nw5-nixos-system-machine-test machine # [ 71.477400] systemd[1]: Stopped target Local File Systems. machine # [ 71.479718] systemd[1]: Stopped target Remote File Systems. machine # [ 71.983322] systemd[1]: Reload requested from client PID 2880 ('.switch-to-conf') (unit backdoor.service)... machine # [ 71.985582] systemd[1]: Reloading... machine # [ 72.631428] systemd[1]: Reloading finished in 643 ms. machine # [ 72.774206] systemd[576]: Reexecution requested from client PID 2949 ('switch-to-confi')... machine # [ 72.775576] systemd[576]: Reexecuting. machine # [ 72.838003] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 73.027147] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 73.033393] systemd[576]: Reload requested from client PID 2949 ('switch-to-confi')... machine # [ 73.035526] systemd[576]: Reloading... machine # [ 73.224654] systemd[576]: Reloading finished in 187 ms. machine # [ 73.240159] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 73.250878] systemd[576]: Stopped Run user-specific NixOS activation. machine # [ 73.253248] systemd[576]: Stopping Run user-specific NixOS activation... machine # [ 73.256070] systemd[576]: Starting Run user-specific NixOS activation... machine # [ 73.299585] systemd[576]: Finished Run user-specific NixOS activation. machine # [ 73.304707] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 73.305710] systemd[1]: Stopping Reactivate sysinit units... machine # [ 73.306504] systemd[1]: Reached target Reactivate sysinit units. machine # [ 73.309655] systemd[1]: Reached target Remote File Systems. machine # [ 73.315327] systemd[1]: Starting escaped\x2ddash.service... machine # [ 73.318227] systemd[1]: Starting linger-users.service... machine # [ 73.328961] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 73.330337] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 73.337180] systemd[1]: Reached target Local File Systems. machine # [ 73.340675] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 73.349927] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 73.354623] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 73.360272] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 73.362927] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 73.365872] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 73.367302] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 73.400977] systemd[1]: Finished escaped\x2ddash.service. machine # [ 73.437037] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 73.440115] systemd[1]: Finished linger-users.service. machine # [ 73.706924] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 73.710084] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 73.968550] nixos[2880]: finished switching to system configuration /nix/store/yq7jh353wgyf6x9plx098k6di6j13nw5-nixos-system-machine-test machine: (finished: must succeed: /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test/specialisation/unitWithBackslash/bin/switch-to-configuration test 2>&1, in 3.11 seconds) machine: must succeed: /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test/specialisation/unitWithBackslashModified/bin/switch-to-configuration test 2>&1 machine # [ 74.598307] nixos[3022]: switching to system configuration /nix/store/5vypnhgbbm0icnwd4av51v79hnafgds4-nixos-system-machine-test machine # [ 74.602173] systemd[1]: Stopped target Local File Systems. machine # [ 74.603966] systemd[1]: Stopped target Remote File Systems. machine # [ 74.605505] systemd[1]: escaped\x2ddash.service: Deactivated successfully. machine # [ 74.606613] systemd[1]: Stopped escaped\x2ddash.service. machine # [ 75.132127] systemd[1]: Reload requested from client PID 3022 ('.switch-to-conf') (unit backdoor.service)... machine # [ 75.134110] systemd[1]: Reloading... machine # [ 75.820384] systemd[1]: Reloading finished in 683 ms. machine # [ 75.975045] systemd[576]: Reexecution requested from client PID 3091 ('switch-to-confi')... machine # [ 75.977504] systemd[576]: Reexecuting. machine # [ 76.042260] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 76.253845] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 76.261160] systemd[576]: Reload requested from client PID 3091 ('switch-to-confi')... machine # [ 76.264163] systemd[576]: Reloading... machine # [ 76.470650] systemd[576]: Reloading finished in 205 ms. machine # [ 76.488194] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 76.499463] systemd[576]: Stopped Run user-specific NixOS activation. machine # [ 76.500698] systemd[576]: Stopping Run user-specific NixOS activation... machine # [ 76.503773] systemd[576]: Starting Run user-specific NixOS activation... machine # [ 76.552828] systemd[576]: Finished Run user-specific NixOS activation. machine # [ 76.557122] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 76.559138] systemd[1]: Stopping Reactivate sysinit units... machine # [ 76.561999] systemd[1]: Reached target Reactivate sysinit units. machine # [ 76.566269] systemd[1]: Reached target Remote File Systems. machine # [ 76.570267] systemd[1]: Starting escaped\x2ddash.service... machine # [ 76.573474] systemd[1]: Starting linger-users.service... machine # [ 76.581474] systemd[1]: Reached target Local File Systems. machine # [ 76.589251] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 76.594112] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 76.596587] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 76.606547] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 76.607481] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 76.612648] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 76.615604] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 76.618254] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 76.624075] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 76.653333] systemd[1]: Finished escaped\x2ddash.service. machine # [ 76.691153] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 76.694863] systemd[1]: Finished linger-users.service. machine # [ 76.989291] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 76.992679] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 77.247455] nixos[3022]: finished switching to system configuration /nix/store/5vypnhgbbm0icnwd4av51v79hnafgds4-nixos-system-machine-test machine: (finished: must succeed: /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test/specialisation/unitWithBackslashModified/bin/switch-to-configuration test 2>&1, in 3.28 seconds) machine: must succeed: /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test/specialisation/unitStartingWithDash/bin/switch-to-configuration test 2>&1 machine # [ 77.910769] nixos[3164]: switching to system configuration /nix/store/1z9xdh290ypsvn0xkc8sjh10agx4znwa-nixos-system-machine-test machine # [ 77.914775] systemd[1]: Stopped target Local File Systems. machine # [ 77.916907] systemd[1]: Stopped target Remote File Systems. machine # [ 77.917760] systemd[1]: escaped\x2ddash.service: Deactivated successfully. machine # [ 77.918677] systemd[1]: Stopped escaped\x2ddash.service. machine # [ 78.465430] systemd[1]: Reload requested from client PID 3164 ('.switch-to-conf') (unit backdoor.service)... machine # [ 78.467407] systemd[1]: Reloading... machine # [ 79.137846] systemd[1]: Reloading finished in 668 ms. machine # [ 79.287215] systemd[576]: Reexecution requested from client PID 3233 ('switch-to-confi')... machine # [ 79.291561] systemd[576]: Reexecuting. machine # [ 79.354163] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 79.549600] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 79.556382] systemd[576]: Reload requested from client PID 3233 ('switch-to-confi')... machine # [ 79.558983] systemd[576]: Reloading... machine # [ 79.748354] systemd[576]: Reloading finished in 188 ms. machine # [ 79.764233] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 79.774529] systemd[576]: Stopped Run user-specific NixOS activation. machine # [ 79.777073] systemd[576]: Stopping Run user-specific NixOS activation... machine # [ 79.780100] systemd[576]: Starting Run user-specific NixOS activation... machine # [ 79.828824] systemd[576]: Finished Run user-specific NixOS activation. machine # [ 79.833453] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 79.837221] systemd[1]: Stopping Reactivate sysinit units... machine # [ 79.839198] systemd[1]: Reached target Reactivate sysinit units. machine # [ 79.840778] systemd[1]: Reached target Remote File Systems. machine # [ 79.842310] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 79.843584] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 79.847537] systemd[1]: Reached target Local File Systems. machine # [ 79.850971] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 79.855110] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 79.860406] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 79.864443] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 79.866626] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 79.873418] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 79.875269] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 80.185994] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 80.190341] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 80.194129] systemd[1]: Starting -.service... machine # [ 80.197074] systemd[1]: Starting linger-users.service... machine # [ 80.240897] systemd[1]: Finished -.service. machine # [ 80.271156] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 80.273638] systemd[1]: Finished linger-users.service. machine # [ 80.531822] nixos[3164]: finished switching to system configuration /nix/store/1z9xdh290ypsvn0xkc8sjh10agx4znwa-nixos-system-machine-test machine: (finished: must succeed: /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test/specialisation/unitStartingWithDash/bin/switch-to-configuration test 2>&1, in 3.29 seconds) machine: must succeed: /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test/specialisation/unitStartingWithDashModified/bin/switch-to-configuration test 2>&1 machine # [ 81.163079] nixos[3306]: switching to system configuration /nix/store/vv33jhqzcnwazch710hagg7vjakb9bwl-nixos-system-machine-test machine # [ 81.166007] systemd[1]: Stopped target Local File Systems. machine # [ 81.168419] systemd[1]: Stopped target Remote File Systems. machine # [ 81.688572] systemd[1]: Reload requested from client PID 3306 ('.switch-to-conf') (unit backdoor.service)... machine # [ 81.690525] systemd[1]: Reloading... machine # [ 82.335028] systemd[1]: Reloading finished in 642 ms. machine # [ 82.480580] systemd[576]: Reexecution requested from client PID 3375 ('switch-to-confi')... machine # [ 82.484296] systemd[576]: Reexecuting. machine # [ 82.537949] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 82.725714] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 82.733217] systemd[576]: Reload requested from client PID 3375 ('switch-to-confi')... machine # [ 82.735643] systemd[576]: Reloading... machine # [ 82.925837] systemd[576]: Reloading finished in 189 ms. machine # [ 82.940191] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 82.951252] systemd[576]: Stopped Run user-specific NixOS activation. machine # [ 82.953673] systemd[576]: Stopping Run user-specific NixOS activation... machine # [ 82.956504] systemd[576]: Starting Run user-specific NixOS activation... machine # [ 83.002477] systemd[576]: Finished Run user-specific NixOS activation. machine # [ 83.006629] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 83.011024] systemd[1]: Stopping Reactivate sysinit units... machine # [ 83.012278] systemd[1]: Reached target Reactivate sysinit units. machine # [ 83.014410] systemd[1]: Reloading -.service... machine # [ 83.047075] systemd[1]: Reloaded -.service. machine # [ 83.050676] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 83.053192] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 83.056445] systemd[1]: Reached target Local File Systems. machine # [ 83.059452] systemd[1]: Reached target Remote File Systems. machine # [ 83.063782] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 83.070938] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 83.072907] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 83.076337] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 83.079326] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 83.084398] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 83.085647] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 83.406678] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 83.411302] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 83.414321] systemd[1]: Starting linger-users.service... machine # [ 83.476779] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 83.479191] systemd[1]: Finished linger-users.service. machine # [ 83.737079] nixos[3306]: finished switching to system configuration /nix/store/vv33jhqzcnwazch710hagg7vjakb9bwl-nixos-system-machine-test machine: (finished: must succeed: /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test/specialisation/unitStartingWithDashModified/bin/switch-to-configuration test 2>&1, in 3.21 seconds) machine: must succeed: /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test/specialisation/unitWithRequirement/bin/switch-to-configuration test 2>&1 machine # [ 84.370077] nixos[3448]: switching to system configuration /nix/store/bkbiqsmzsx6h2b6jygf0my2v3hq0kq92-nixos-system-machine-test machine # [ 84.373878] systemd[1]: Stopped target Local File Systems. machine # [ 84.375836] systemd[1]: Stopped target Remote File Systems. machine # [ 84.377305] systemd[1]: -.service: Deactivated successfully. machine # [ 84.378345] systemd[1]: Stopped -.service. machine # [ 84.948420] systemd[1]: Reload requested from client PID 3448 ('.switch-to-conf') (unit backdoor.service)... machine # [ 84.950524] systemd[1]: Reloading... machine # [ 85.677685] systemd[1]: Reloading finished in 724 ms. machine # [ 85.836843] systemd[576]: Reexecution requested from client PID 3517 ('switch-to-confi')... machine # [ 85.840468] systemd[576]: Reexecuting. machine # [ 85.899296] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 86.106735] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 86.114832] systemd[576]: Reload requested from client PID 3517 ('switch-to-confi')... machine # [ 86.118582] systemd[576]: Reloading... machine # [ 86.318650] systemd[576]: Reloading finished in 201 ms. machine # [ 86.332323] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 86.344366] systemd[576]: Stopped Run user-specific NixOS activation. machine # [ 86.346800] systemd[576]: Stopping Run user-specific NixOS activation... machine # [ 86.350095] systemd[576]: Starting Run user-specific NixOS activation... machine # [ 86.403635] systemd[576]: Finished Run user-specific NixOS activation. machine # [ 86.409739] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 86.410773] systemd[1]: Stopping Reactivate sysinit units... machine # [ 86.411667] systemd[1]: Reached target Reactivate sysinit units. machine # [ 86.414458] systemd[1]: Reached target Remote File Systems. machine # [ 86.423913] systemd[1]: Starting linger-users.service... machine # [ 86.428661] systemd[1]: Starting required-service.service... machine # [ 86.432997] systemd[1]: Starting test-service.service... machine # [ 86.444951] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 86.446476] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 86.461812] systemd[1]: Reached target Local File Systems. machine # [ 86.468135] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 86.480226] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 86.481192] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 86.482472] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 86.496169] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 86.502103] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 86.505692] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 86.544998] systemd[1]: Finished test-service.service. machine # [ 86.552810] systemd[1]: Finished required-service.service. machine # [ 86.598626] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 86.603440] systemd[1]: Finished linger-users.service. machine # [ 86.911156] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 86.914599] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 87.174470] nixos[3448]: finished switching to system configuration /nix/store/bkbiqsmzsx6h2b6jygf0my2v3hq0kq92-nixos-system-machine-test machine: (finished: must succeed: /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test/specialisation/unitWithRequirement/bin/switch-to-configuration test 2>&1, in 3.44 seconds) machine: must succeed: /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test/specialisation/unitWithRequirementModified/bin/switch-to-configuration test 2>&1 machine # [ 87.883809] nixos[3592]: switching to system configuration /nix/store/913iag4853b91jy3w35yvzmb7nx6dysb-nixos-system-machine-test machine # [ 87.888628] systemd[1]: Stopped target Local File Systems. machine # [ 87.890966] systemd[1]: Stopped target Remote File Systems. machine # [ 87.891946] systemd[1]: required-service.service: Deactivated successfully. machine # [ 87.894027] systemd[1]: Stopped required-service.service. machine # [ 87.895020] systemd[1]: test-service.service: Deactivated successfully. machine # [ 87.896358] systemd[1]: Stopped test-service.service. machine # [ 88.446121] systemd[1]: Reload requested from client PID 3592 ('.switch-to-conf') (unit backdoor.service)... machine # [ 88.448252] systemd[1]: Reloading... machine # [ 89.151240] systemd[1]: Reloading finished in 700 ms. machine # [ 89.294755] systemd[576]: Reexecution requested from client PID 3661 ('switch-to-confi')... machine # [ 89.298935] systemd[576]: Reexecuting. machine # [ 89.357998] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 89.555963] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 89.562599] systemd[576]: Reload requested from client PID 3661 ('switch-to-confi')... machine # [ 89.565247] systemd[576]: Reloading... machine # [ 89.759103] systemd[576]: Reloading finished in 192 ms. machine # [ 89.772187] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 89.782678] systemd[576]: Stopped Run user-specific NixOS activation. machine # [ 89.785246] systemd[576]: Stopping Run user-specific NixOS activation... machine # [ 89.788309] systemd[576]: Starting Run user-specific NixOS activation... machine # [ 89.834408] systemd[576]: Finished Run user-specific NixOS activation. machine # [ 89.838716] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 89.840705] systemd[1]: Stopping Reactivate sysinit units... machine # [ 89.841697] systemd[1]: Reached target Reactivate sysinit units. machine # [ 89.848373] systemd[1]: Reached target Remote File Systems. machine # [ 89.851943] systemd[1]: Reached target Local File Systems. machine # [ 89.855242] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 89.859413] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 89.863857] systemd[1]: Starting linger-users.service... machine # [ 89.867752] systemd[1]: Starting required-service.service... machine # [ 89.872864] systemd[1]: Starting test-service.service... machine # [ 89.881137] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 89.892691] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 89.895234] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 89.902321] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 89.907403] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 89.912558] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 89.914639] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 89.956511] systemd[1]: Finished required-service.service. machine # [ 89.960628] systemd[1]: Finished test-service.service. machine # [ 89.994767] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 89.997885] systemd[1]: Finished linger-users.service. machine # [ 90.278501] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 90.281768] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 90.538591] nixos[3592]: finished switching to system configuration /nix/store/913iag4853b91jy3w35yvzmb7nx6dysb-nixos-system-machine-test machine: (finished: must succeed: /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test/specialisation/unitWithRequirementModified/bin/switch-to-configuration test 2>&1, in 3.37 seconds) machine: must succeed: /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test/specialisation/unitWithRequirementModifiedNostart/bin/switch-to-configuration test 2>&1 machine # [ 91.186545] nixos[3736]: switching to system configuration /nix/store/gfzxmp4fljp663i5pjiy51k6j7j2jxjy-nixos-system-machine-test machine # [ 91.190408] systemd[1]: Stopped target Local File Systems. machine # [ 91.192555] systemd[1]: Stopped target Remote File Systems. machine # [ 91.193381] systemd[1]: required-service.service: Deactivated successfully. machine # [ 91.194295] systemd[1]: Stopped required-service.service. machine # [ 91.195028] systemd[1]: test-service.service: Deactivated successfully. machine # [ 91.195895] systemd[1]: Stopped test-service.service. machine # [ 91.702632] systemd[1]: Reload requested from client PID 3736 ('.switch-to-conf') (unit backdoor.service)... machine # [ 91.704718] systemd[1]: Reloading... machine # [ 92.357817] systemd[1]: Reloading finished in 651 ms. machine # [ 92.503012] systemd[576]: Reexecution requested from client PID 3805 ('switch-to-confi')... machine # [ 92.506605] systemd[576]: Reexecuting. machine # [ 92.545567] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 92.744853] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 92.751672] systemd[576]: Reload requested from client PID 3805 ('switch-to-confi')... machine # [ 92.756045] systemd[576]: Reloading... machine # [ 92.960075] systemd[576]: Reloading finished in 205 ms. machine # [ 92.972190] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 92.983724] systemd[576]: Stopped Run user-specific NixOS activation. machine # [ 92.986349] systemd[576]: Stopping Run user-specific NixOS activation... machine # [ 92.989574] systemd[576]: Starting Run user-specific NixOS activation... machine # [ 93.040376] systemd[576]: Finished Run user-specific NixOS activation. machine # [ 93.045015] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 93.047131] systemd[1]: Stopping Reactivate sysinit units... machine # [ 93.048971] systemd[1]: Reached target Reactivate sysinit units. machine # [ 93.052382] systemd[1]: Reached target Remote File Systems. machine # [ 93.057550] systemd[1]: Starting linger-users.service... machine # [ 93.063460] systemd[1]: Starting required-service.service... machine # [ 93.069741] systemd[1]: Starting test-service.service... machine # [ 93.083778] systemd[1]: Reached target Local File Systems. machine # [ 93.088815] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 93.091780] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 93.104185] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 93.111632] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 93.117374] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 93.120370] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 93.128130] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 93.132107] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 93.135565] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 93.163803] systemd[1]: Finished required-service.service. machine # [ 93.168884] systemd[1]: Finished test-service.service. machine # [ 93.208092] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 93.212151] systemd[1]: Finished linger-users.service. machine # [ 93.499703] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 93.503109] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 93.762245] nixos[3736]: finished switching to system configuration /nix/store/gfzxmp4fljp663i5pjiy51k6j7j2jxjy-nixos-system-machine-test machine: (finished: must succeed: /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test/specialisation/unitWithRequirementModifiedNostart/bin/switch-to-configuration test 2>&1, in 3.22 seconds) machine: must succeed: /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test/specialisation/unitWithTemplate/bin/switch-to-configuration test 2>&1 machine # [ 94.427922] nixos[3880]: switching to system configuration /nix/store/ybgcrhrcg06mb3ayhnk6syr865c70hv5-nixos-system-machine-test machine # [ 94.432783] systemd[1]: Stopped target Local File Systems. machine # [ 94.435729] systemd[1]: Stopped target Remote File Systems. machine # [ 94.437002] systemd[1]: required-service.service: Deactivated successfully. machine # [ 94.438297] systemd[1]: Stopped required-service.service. machine # [ 94.439263] systemd[1]: test-service.service: Deactivated successfully. machine # [ 94.440296] systemd[1]: Stopped test-service.service. machine # [ 94.972213] systemd[1]: Reload requested from client PID 3880 ('.switch-to-conf') (unit backdoor.service)... machine # [ 94.974183] systemd[1]: Reloading... machine # [ 95.678577] systemd[1]: Reloading finished in 702 ms. machine # [ 95.835623] systemd[576]: Reexecution requested from client PID 3949 ('switch-to-confi')... machine # [ 95.840675] systemd[576]: Reexecuting. machine # [ 95.898564] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 96.098699] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 96.105668] systemd[576]: Reload requested from client PID 3949 ('switch-to-confi')... machine # [ 96.108476] systemd[576]: Reloading... machine # [ 96.309798] systemd[576]: Reloading finished in 200 ms. machine # [ 96.324189] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 96.335676] systemd[576]: Stopped Run user-specific NixOS activation. machine # [ 96.338102] systemd[576]: Stopping Run user-specific NixOS activation... machine # [ 96.341045] systemd[576]: Starting Run user-specific NixOS activation... machine # [ 96.391956] systemd[576]: Finished Run user-specific NixOS activation. machine # [ 96.396624] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 96.397621] systemd[1]: Stopping Reactivate sysinit units... machine # [ 96.398405] systemd[1]: Reached target Reactivate sysinit units. machine # [ 96.402133] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 96.406568] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 96.408692] systemd[1]: Reached target Remote File Systems. machine # [ 96.411530] systemd[1]: Reached target Local File Systems. machine # [ 96.415294] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 96.419574] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 96.421623] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 96.424892] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 96.436322] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 96.437968] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 96.439183] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 96.442580] systemd[1]: Created slice Slice /system/instantiated. machine # [ 96.769228] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 96.772821] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 96.777861] systemd[1]: Starting instantiated@one.service... machine # [ 96.781944] systemd[1]: Starting instantiated@two.service... machine # [ 96.785121] systemd[1]: Starting linger-users.service... machine # [ 96.842797] systemd[1]: Finished instantiated@one.service. machine # [ 96.843779] systemd[1]: Finished instantiated@two.service. machine # [ 96.869495] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 96.872501] systemd[1]: Finished linger-users.service. machine # [ 97.130841] nixos[3880]: finished switching to system configuration /nix/store/ybgcrhrcg06mb3ayhnk6syr865c70hv5-nixos-system-machine-test machine: (finished: must succeed: /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test/specialisation/unitWithTemplate/bin/switch-to-configuration test 2>&1, in 3.37 seconds) machine: must succeed: /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test/specialisation/unitWithTemplateModified/bin/switch-to-configuration test 2>&1 machine # [ 97.831528] nixos[4024]: switching to system configuration /nix/store/fn47b9f78fk8lr36d2pg5ibc495r8ryr-nixos-system-machine-test machine # [ 97.837413] systemd[1]: Stopped target Local File Systems. machine # [ 97.838284] systemd[1]: Stopped target Remote File Systems. machine # [ 97.839105] systemd[1]: instantiated@one.service: Deactivated successfully. machine # [ 97.840801] systemd[1]: Stopped instantiated@one.service. machine # [ 97.841702] systemd[1]: instantiated@two.service: Deactivated successfully. machine # [ 97.842766] systemd[1]: Stopped instantiated@two.service. machine # [ 98.364460] systemd[1]: Reload requested from client PID 4024 ('.switch-to-conf') (unit backdoor.service)... machine # [ 98.366430] systemd[1]: Reloading... machine # [ 99.043166] systemd[1]: Reloading finished in 674 ms. machine # [ 99.199466] systemd[576]: Reexecution requested from client PID 4093 ('switch-to-confi')... machine # [ 99.203766] systemd[576]: Reexecuting. machine # [ 99.266546] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 99.467867] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 99.475901] systemd[576]: Reload requested from client PID 4093 ('switch-to-confi')... machine # [ 99.477907] systemd[576]: Reloading... machine # [ 99.673536] systemd[576]: Reloading finished in 194 ms. machine # [ 99.684184] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 99.694026] systemd[576]: Stopped Run user-specific NixOS activation. machine # [ 99.696433] systemd[576]: Stopping Run user-specific NixOS activation... machine # [ 99.699361] systemd[576]: Starting Run user-specific NixOS activation... machine # [ 99.745801] systemd[576]: Finished Run user-specific NixOS activation. machine # [ 99.749942] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 99.751991] systemd[1]: Stopping Reactivate sysinit units... machine # [ 99.754437] systemd[1]: Reached target Reactivate sysinit units. machine # [ 99.755298] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 99.757836] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 99.760646] systemd[1]: Reached target Remote File Systems. machine # [ 99.766865] systemd[1]: Starting instantiated@one.service... machine # [ 99.770597] systemd[1]: Starting instantiated@two.service... machine # [ 99.774062] systemd[1]: Starting linger-users.service... machine # [ 99.779649] systemd[1]: Reached target Local File Systems. machine # [ 99.795928] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 99.802273] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 99.808084] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 99.816321] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 99.819644] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 99.825810] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 99.829828] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 99.865189] systemd[1]: Finished instantiated@one.service. machine # [ 99.868436] systemd[1]: Finished instantiated@two.service. machine # [ 99.904685] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 99.908238] systemd[1]: Finished linger-users.service. machine # [ 100.173237] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 100.176875] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 100.435853] nixos[4024]: finished switching to system configuration /nix/store/fn47b9f78fk8lr36d2pg5ibc495r8ryr-nixos-system-machine-test machine: (finished: must succeed: /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test/specialisation/unitWithTemplateModified/bin/switch-to-configuration test 2>&1, in 3.30 seconds) (finished: subtest: services, in 72.67 seconds) subtest: failing units machine: must succeed: /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test/specialisation/simpleServiceModified/bin/switch-to-configuration test 2>&1 machine # [ 101.059263] nixos[4168]: switching to system configuration /nix/store/fc9vv51r37nmsfcdlr91j5hw1qh4ig2x-nixos-system-machine-test machine # [ 101.061878] systemd[1]: Stopped target Remote File Systems. machine # [ 101.065840] systemd[1]: instantiated@one.service: Deactivated successfully. machine # [ 101.066875] systemd[1]: Stopped instantiated@one.service. machine # [ 101.067635] systemd[1]: instantiated@two.service: Deactivated successfully. machine # [ 101.069061] systemd[1]: Stopped instantiated@two.service. machine # [ 101.070010] systemd[1]: Stopped target Local File Systems. machine # [ 101.533036] systemd[1]: Reload requested from client PID 4168 ('.switch-to-conf') (unit backdoor.service)... machine # [ 101.535111] systemd[1]: Reloading... machine # [ 102.155688] systemd[1]: Reloading finished in 618 ms. machine # [ 102.302443] systemd[576]: Reexecution requested from client PID 4237 ('switch-to-confi')... machine # [ 102.306526] systemd[576]: Reexecuting. machine # [ 102.362006] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 102.554984] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 102.562589] systemd[576]: Reload requested from client PID 4237 ('switch-to-confi')... machine # [ 102.563916] systemd[576]: Reloading... machine # [ 102.757197] systemd[576]: Reloading finished in 191 ms. machine # [ 102.772169] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 102.783208] systemd[576]: Stopped Run user-specific NixOS activation. machine # [ 102.784356] systemd[576]: Stopping Run user-specific NixOS activation... machine # [ 102.787386] systemd[576]: Starting Run user-specific NixOS activation... machine # [ 102.834861] systemd[576]: Finished Run user-specific NixOS activation. machine # [ 102.839433] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 102.842223] systemd[1]: Stopping Reactivate sysinit units... machine # [ 102.843088] systemd[1]: Reached target Reactivate sysinit units. machine # [ 102.845486] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 102.846829] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 102.851035] systemd[1]: Reached target Remote File Systems. machine # [ 102.857513] systemd[1]: Starting linger-users.service... machine # [ 102.860869] systemd[1]: Starting test.service... machine # [ 102.865960] systemd[1]: Reached target Local File Systems. machine # [ 102.866864] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 102.880462] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 102.881367] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 102.882562] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 102.899288] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 102.902253] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 102.904508] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 102.938757] systemd[1]: Finished test.service. machine # [ 102.973305] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 102.975145] systemd[1]: Finished linger-users.service. machine # [ 103.247737] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 103.250560] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 103.511334] nixos[4168]: finished switching to system configuration /nix/store/fc9vv51r37nmsfcdlr91j5hw1qh4ig2x-nixos-system-machine-test machine: (finished: must succeed: /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test/specialisation/simpleServiceModified/bin/switch-to-configuration test 2>&1, in 3.07 seconds) machine: must fail: /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test/specialisation/simpleServiceFailing/bin/switch-to-configuration test 2>&1 machine # [ 104.189860] nixos[4310]: switching to system configuration /nix/store/m7fz9b68jpla2xygg7329vc7c1bxakcv-nixos-system-machine-test machine # [ 104.194248] systemd[1]: Stopped target Local File Systems. machine # [ 104.196760] systemd[1]: Stopped target Remote File Systems. machine # [ 104.197759] systemd[1]: test.service: Deactivated successfully. machine # [ 104.198751] systemd[1]: Stopped test.service. machine # [ 104.706413] systemd[1]: Reload requested from client PID 4310 ('.switch-to-conf') (unit backdoor.service)... machine # [ 104.708469] systemd[1]: Reloading... machine # [ 105.362553] systemd[1]: Reloading finished in 651 ms. machine # [ 105.509581] systemd[576]: Reexecution requested from client PID 4379 ('switch-to-confi')... machine # [ 105.514476] systemd[576]: Reexecuting. machine # [ 105.574000] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 105.767205] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 105.774796] systemd[576]: Reload requested from client PID 4379 ('switch-to-confi')... machine # [ 105.776435] systemd[576]: Reloading... machine # [ 105.964795] systemd[576]: Reloading finished in 186 ms. machine # [ 105.980160] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 105.990329] systemd[576]: Stopped Run user-specific NixOS activation. machine # [ 105.991330] systemd[576]: Stopping Run user-specific NixOS activation... machine # [ 105.994136] systemd[576]: Starting Run user-specific NixOS activation... machine # [ 106.040972] systemd[576]: Finished Run user-specific NixOS activation. machine # [ 106.045144] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 106.046069] systemd[1]: Stopping Reactivate sysinit units... machine # [ 106.046868] systemd[1]: Reached target Reactivate sysinit units. machine # [ 106.054587] systemd[1]: Starting test.service... machine # [ 106.056203] systemd[1]: Reached target Remote File Systems. machine # [ 106.065123] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 106.066493] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 106.080157] systemd[1]: Starting linger-users.service... machine # [ 106.088335] systemd[1]: Reached target Local File Systems. machine # [ 106.095202] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 106.100358] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 106.101299] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 106.102514] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 106.105175] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 106.106971] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 106.110574] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 106.135091] systemd[1]: test.service: Main process exited, code=exited, status=1/FAILURE machine # [ 106.137970] systemd[1]: test.service: Failed with result 'exit-code'. machine # [ 106.140187] systemd[1]: Failed to start test.service. machine # [ 106.187038] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 106.190217] systemd[1]: Finished linger-users.service. machine # [ 106.455619] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 106.458857] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 106.780505] nixos[4310]: switching to system configuration /nix/store/m7fz9b68jpla2xygg7329vc7c1bxakcv-nixos-system-machine-test failed (status 4) machine: (finished: must fail: /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test/specialisation/simpleServiceFailing/bin/switch-to-configuration test 2>&1, in 3.27 seconds) machine: must succeed: /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test/specialisation/autorestartService/bin/switch-to-configuration test 2>&1 machine # [ 107.411735] nixos[4453]: switching to system configuration /nix/store/w7kj494w1bgh073cizrkbgirrx7jns3m-nixos-system-machine-test machine # [ 107.414287] systemd[1]: Stopped target Local File Systems. machine # [ 107.416593] systemd[1]: Stopped target Remote File Systems. machine # [ 107.919771] systemd[1]: Reload requested from client PID 4453 ('.switch-to-conf') (unit backdoor.service)... machine # [ 107.921837] systemd[1]: Reloading... machine # [ 108.526132] systemd[1]: Reloading finished in 602 ms. machine # [ 108.673852] systemd[576]: Reexecution requested from client PID 4522 ('switch-to-confi')... machine # [ 108.678116] systemd[576]: Reexecuting. machine # [ 108.743632] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 108.951927] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 108.960216] systemd[576]: Reload requested from client PID 4522 ('switch-to-confi')... machine # [ 108.961716] systemd[576]: Reloading... machine # [ 109.159124] systemd[576]: Reloading finished in 195 ms. machine # [ 109.173730] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 109.182863] systemd[576]: Stopped Run user-specific NixOS activation. machine # [ 109.185593] systemd[576]: Stopping Run user-specific NixOS activation... machine # [ 109.189104] systemd[576]: Starting Run user-specific NixOS activation... machine # [ 109.238822] systemd[576]: Finished Run user-specific NixOS activation. machine # [ 109.243395] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 109.245897] systemd[1]: Stopping Reactivate sysinit units... machine # [ 109.246733] systemd[1]: Reached target Reactivate sysinit units. machine # [ 109.249598] systemd[1]: Reached target Remote File Systems. machine # [ 109.253689] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 109.256759] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 109.261068] systemd[1]: Reached target Local File Systems. machine # [ 109.261902] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 109.267842] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 109.271488] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 109.275102] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 109.281114] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 109.282792] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 109.286066] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 109.603254] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 109.605559] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 109.612539] systemd[1]: Started autorestart.service. machine # [ 109.615211] systemd[1]: Starting linger-users.service... machine # [ 109.663169] systemd[1]: autorestart.service: Deactivated successfully. machine # [ 109.690180] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 109.693281] systemd[1]: Finished linger-users.service. machine # [ 109.952583] nixos[4453]: finished switching to system configuration /nix/store/w7kj494w1bgh073cizrkbgirrx7jns3m-nixos-system-machine-test machine: (finished: must succeed: /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test/specialisation/autorestartService/bin/switch-to-configuration test 2>&1, in 3.17 seconds) machine # [ 110.034587] systemd[1]: Stopped autorestart.service. machine: must succeed: /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test/specialisation/autorestartService/bin/switch-to-configuration test 2>&1 machine # [ 110.634651] nixos[4600]: switching to system configuration /nix/store/w7kj494w1bgh073cizrkbgirrx7jns3m-nixos-system-machine-test machine # [ 110.637496] systemd[1]: Stopped target Local File Systems. machine # [ 110.639847] systemd[1]: Stopped target Remote File Systems. machine # [ 111.115640] systemd[1]: Reload requested from client PID 4600 ('.switch-to-conf') (unit backdoor.service)... machine # [ 111.117991] systemd[1]: Reloading... machine # [ 111.732261] systemd[1]: Reloading finished in 611 ms. machine # [ 111.878778] systemd[576]: Reexecution requested from client PID 4669 ('switch-to-confi')... machine # [ 111.883153] systemd[576]: Reexecuting. machine # [ 111.942072] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 112.142181] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 112.149495] systemd[576]: Reload requested from client PID 4669 ('switch-to-confi')... machine # [ 112.151989] systemd[576]: Reloading... machine # [ 112.347227] systemd[576]: Reloading finished in 193 ms. machine # [ 112.360168] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 112.371464] systemd[576]: Stopped Run user-specific NixOS activation. machine # [ 112.373980] systemd[576]: Stopping Run user-specific NixOS activation... machine # [ 112.377085] systemd[576]: Starting Run user-specific NixOS activation... machine # [ 112.425233] systemd[576]: Finished Run user-specific NixOS activation. machine # [ 112.429360] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 112.430610] systemd[1]: Stopping Reactivate sysinit units... machine # [ 112.431445] systemd[1]: Reached target Reactivate sysinit units. machine # [ 112.434030] systemd[1]: Reached target Remote File Systems. machine # [ 112.438816] systemd[1]: Reached target Local File Systems. machine # [ 112.442280] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 112.446628] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 112.447537] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 112.456543] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 112.459152] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 112.462920] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 112.466915] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 112.470127] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 112.471571] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 112.779433] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 112.781926] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 112.788539] systemd[1]: Started autorestart.service. machine # [ 112.792743] systemd[1]: Starting linger-users.service... machine # [ 112.835852] systemd[1]: autorestart.service: Deactivated successfully. machine # [ 112.863914] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 112.866419] systemd[1]: Finished linger-users.service. machine # [ 113.127060] nixos[4600]: finished switching to system configuration /nix/store/w7kj494w1bgh073cizrkbgirrx7jns3m-nixos-system-machine-test machine: (finished: must succeed: /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test/specialisation/autorestartService/bin/switch-to-configuration test 2>&1, in 3.09 seconds) machine # [ 113.209574] systemd[1]: Stopped autorestart.service. machine: must fail: /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test/specialisation/autorestartServiceFailing/bin/switch-to-configuration test 2>&1 machine # [ 113.767293] nixos[4747]: switching to system configuration /nix/store/dwigrjch6aw43yb0pvg8wzj0sicjhzmn-nixos-system-machine-test machine # [ 113.769871] systemd[1]: Stopped target Remote File Systems. machine # [ 113.772256] systemd[1]: Stopped target Local File Systems. machine # [ 114.269091] systemd[1]: Reload requested from client PID 4747 ('.switch-to-conf') (unit backdoor.service)... machine # [ 114.271081] systemd[1]: Reloading... machine # [ 114.934239] systemd[1]: Reloading finished in 659 ms. machine # [ 115.083387] systemd[576]: Reexecution requested from client PID 4816 ('switch-to-confi')... machine # [ 115.086993] systemd[576]: Reexecuting. machine # [ 115.149947] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 115.343080] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 115.350278] systemd[576]: Reload requested from client PID 4816 ('switch-to-confi')... machine # [ 115.352062] systemd[576]: Reloading... machine # [ 115.532679] systemd[576]: Reloading finished in 179 ms. machine # [ 115.548153] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 115.558115] systemd[576]: Stopped Run user-specific NixOS activation. machine # [ 115.560474] systemd[576]: Stopping Run user-specific NixOS activation... machine # [ 115.563253] systemd[576]: Starting Run user-specific NixOS activation... machine # [ 115.608684] systemd[576]: Finished Run user-specific NixOS activation. machine # [ 115.613010] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 115.615440] systemd[1]: Stopping Reactivate sysinit units... machine # [ 115.617158] systemd[1]: Reached target Reactivate sysinit units. machine # [ 115.620399] systemd[1]: Reached target Local File Systems. machine # [ 115.621278] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 115.627076] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 115.630586] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 115.631912] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 115.641375] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 115.647166] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 115.648915] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 115.650319] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 115.651584] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 115.653313] systemd[1]: Reached target Remote File Systems. machine # [ 115.973077] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 115.976699] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 115.982255] systemd[1]: Started autorestart.service. machine # [ 115.985359] systemd[1]: Starting linger-users.service... machine # [ 116.024133] systemd[1]: autorestart.service: Main process exited, code=exited, status=1/FAILURE machine # [ 116.028256] systemd[1]: autorestart.service: Failed with result 'exit-code'. machine # [ 116.053527] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 116.056414] systemd[1]: Finished linger-users.service. machine # [ 116.382803] nixos[4747]: switching to system configuration /nix/store/dwigrjch6aw43yb0pvg8wzj0sicjhzmn-nixos-system-machine-test failed (status 4) machine: (finished: must fail: /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test/specialisation/autorestartServiceFailing/bin/switch-to-configuration test 2>&1, in 3.18 seconds) (finished: subtest: failing units, in 15.95 seconds) subtest: unit file parser machine: must succeed: /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1 machine # [ 116.980068] nixos[4890]: switching to system configuration /nix/store/q4hqx9aiw9lpsqrdz9v39nigfilgnwpv-nixos-system-machine-test machine # [ 116.983094] systemd[1]: Stopped autorestart.service. machine # [ 116.985168] systemd[1]: Stopped target Remote File Systems. machine # [ 116.987600] systemd[1]: Stopped target Local File Systems. machine # [ 117.429148] systemd[1]: Reload requested from client PID 4890 ('.switch-to-conf') (unit backdoor.service)... machine # [ 117.431099] systemd[1]: Reloading... machine # [ 118.005937] systemd[1]: Reloading finished in 572 ms. machine # [ 118.141895] systemd[576]: Reexecution requested from client PID 4959 ('switch-to-confi')... machine # [ 118.145691] systemd[576]: Reexecuting. machine # [ 118.201360] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 118.384907] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 118.391646] systemd[576]: Reload requested from client PID 4959 ('switch-to-confi')... machine # [ 118.393947] systemd[576]: Reloading... machine # [ 118.576193] systemd[576]: Reloading finished in 181 ms. machine # [ 118.592139] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 118.600589] systemd[576]: Stopped Run user-specific NixOS activation. machine # [ 118.602614] systemd[576]: Stopping Run user-specific NixOS activation... machine # [ 118.605313] systemd[576]: Starting Run user-specific NixOS activation... machine # [ 118.646850] systemd[576]: Finished Run user-specific NixOS activation. machine # [ 118.650597] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 118.653767] systemd[1]: Stopping Reactivate sysinit units... machine # [ 118.654612] systemd[1]: Reached target Reactivate sysinit units. machine # [ 118.656898] systemd[1]: Reached target Local File Systems. machine # [ 118.659663] systemd[1]: Reached target Remote File Systems. machine # [ 118.661518] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 118.666786] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 118.668331] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 118.671696] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 118.674441] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 118.680556] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 118.682714] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 118.686285] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 118.687564] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 118.992953] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 118.996610] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 119.000346] systemd[1]: Starting linger-users.service... machine # [ 119.003933] systemd[1]: Starting test.service... machine # [ 119.047619] systemd[1]: Finished test.service. machine # [ 119.073570] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 119.075772] systemd[1]: Finished linger-users.service. machine # [ 119.333958] nixos[4890]: finished switching to system configuration /nix/store/q4hqx9aiw9lpsqrdz9v39nigfilgnwpv-nixos-system-machine-test machine: (finished: must succeed: /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1, in 2.95 seconds) machine: must succeed: /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test/specialisation/simpleServiceWithExtraSection/bin/switch-to-configuration test 2>&1 machine # [ 119.977222] nixos[5032]: switching to system configuration /nix/store/p8vchhc5sm8k0hkq5x3l5wp0v8c4sn2f-nixos-system-machine-test machine # [ 119.979703] systemd[1]: Stopped target Local File Systems. machine # [ 119.981945] systemd[1]: Stopped target Remote File Systems. machine # [ 120.484071] systemd[1]: Reload requested from client PID 5032 ('.switch-to-conf') (unit backdoor.service)... machine # [ 120.485991] systemd[1]: Reloading... machine # [ 121.122334] systemd[1]: Reloading finished in 634 ms. machine # [ 121.280281] systemd[576]: Reexecution requested from client PID 5101 ('switch-to-confi')... machine # [ 121.284178] systemd[576]: Reexecuting. machine # [ 121.329298] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 121.523299] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 121.530012] systemd[576]: Reload requested from client PID 5101 ('switch-to-confi')... machine # [ 121.532458] systemd[576]: Reloading... machine # [ 121.720284] systemd[576]: Reloading finished in 186 ms. machine # [ 121.737563] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 121.745269] systemd[576]: Stopped Run user-specific NixOS activation. machine # [ 121.747638] systemd[576]: Stopping Run user-specific NixOS activation... machine # [ 121.750494] systemd[576]: Starting Run user-specific NixOS activation... machine # [ 121.794861] systemd[576]: Finished Run user-specific NixOS activation. machine # [ 121.799006] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 121.800999] systemd[1]: Stopping Reactivate sysinit units... machine # [ 121.804789] systemd[1]: Reached target Reactivate sysinit units. machine # [ 121.805975] systemd[1]: test.service: Deactivated successfully. machine # [ 121.808287] systemd[1]: Stopped test.service. machine # [ 121.808967] systemd[1]: Stopping test.service... machine # [ 121.809599] systemd[1]: Starting test.service... machine # [ 121.843640] systemd[1]: Finished test.service. machine # [ 121.851466] systemd[1]: Reached target Local File Systems. machine # [ 121.854760] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 121.858604] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 121.859475] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 121.862484] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 121.872559] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 121.874093] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 121.875303] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 121.878258] systemd[1]: Reached target Remote File Systems. machine # [ 121.879032] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 121.880334] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 122.181015] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 122.184641] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 122.187584] systemd[1]: Starting linger-users.service... machine # [ 122.246418] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 122.248188] systemd[1]: Finished linger-users.service. machine # [ 122.507074] nixos[5032]: finished switching to system configuration /nix/store/p8vchhc5sm8k0hkq5x3l5wp0v8c4sn2f-nixos-system-machine-test machine: (finished: must succeed: /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test/specialisation/simpleServiceWithExtraSection/bin/switch-to-configuration test 2>&1, in 3.18 seconds) machine: must succeed: /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test/specialisation/simpleServiceWithExtraSectionOtherName/bin/switch-to-configuration test 2>&1 machine # [ 123.175076] nixos[5174]: switching to system configuration /nix/store/jlwbh1q28i9w1g8jal9c6mlvwy5r3hhs-nixos-system-machine-test machine # [ 123.178437] systemd[1]: Stopped target Local File Systems. machine # [ 123.179777] systemd[1]: Stopped target Remote File Systems. machine # [ 123.714553] systemd[1]: Reload requested from client PID 5174 ('.switch-to-conf') (unit backdoor.service)... machine # [ 123.716762] systemd[1]: Reloading... machine # [ 124.381694] systemd[1]: Reloading finished in 662 ms. machine # [ 124.544293] systemd[576]: Reexecution requested from client PID 5243 ('switch-to-confi')... machine # [ 124.545694] systemd[576]: Reexecuting. machine # [ 124.606038] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 124.804968] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 124.811612] systemd[576]: Reload requested from client PID 5243 ('switch-to-confi')... machine # [ 124.813780] systemd[576]: Reloading... machine # [ 125.007820] systemd[576]: Reloading finished in 193 ms. machine # [ 125.024144] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 125.034561] systemd[576]: Stopped Run user-specific NixOS activation. machine # [ 125.035584] systemd[576]: Stopping Run user-specific NixOS activation... machine # [ 125.038426] systemd[576]: Starting Run user-specific NixOS activation... machine # [ 125.087282] systemd[576]: Finished Run user-specific NixOS activation. machine # [ 125.091548] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 125.093474] systemd[1]: Stopping Reactivate sysinit units... machine # [ 125.094274] systemd[1]: Reached target Reactivate sysinit units. machine # [ 125.097996] systemd[1]: test.service: Deactivated successfully. machine # [ 125.098865] systemd[1]: Stopped test.service. machine # [ 125.099497] systemd[1]: Stopping test.service... machine # [ 125.101986] systemd[1]: Starting test.service... machine # [ 125.138704] systemd[1]: Finished test.service. machine # [ 125.145158] systemd[1]: Reached target Local File Systems. machine # [ 125.149037] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 125.153095] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 125.153959] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 125.155168] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 125.159559] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 125.170822] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 125.173041] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 125.174212] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 125.175475] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 125.176855] systemd[1]: Reached target Remote File Systems. machine # [ 125.504556] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 125.508151] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 125.512470] systemd[1]: Starting linger-users.service... machine # [ 125.576258] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 125.579087] systemd[1]: Finished linger-users.service. machine # [ 125.838276] nixos[5174]: finished switching to system configuration /nix/store/jlwbh1q28i9w1g8jal9c6mlvwy5r3hhs-nixos-system-machine-test machine: (finished: must succeed: /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test/specialisation/simpleServiceWithExtraSectionOtherName/bin/switch-to-configuration test 2>&1, in 3.33 seconds) machine: must succeed: /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1 machine # [ 126.511302] nixos[5316]: switching to system configuration /nix/store/q4hqx9aiw9lpsqrdz9v39nigfilgnwpv-nixos-system-machine-test machine # [ 126.515269] systemd[1]: Stopped target Local File Systems. machine # [ 126.517806] systemd[1]: Stopped target Remote File Systems. machine # [ 126.988941] systemd[1]: Reload requested from client PID 5316 ('.switch-to-conf') (unit backdoor.service)... machine # [ 126.991058] systemd[1]: Reloading... machine # [ 127.581605] systemd[1]: Reloading finished in 586 ms. machine # [ 127.718419] systemd[576]: Reexecution requested from client PID 5385 ('switch-to-confi')... machine # [ 127.721935] systemd[576]: Reexecuting. machine # [ 127.765326] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 127.950230] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 127.956668] systemd[576]: Reload requested from client PID 5385 ('switch-to-confi')... machine # [ 127.958951] systemd[576]: Reloading... machine # [ 128.141842] systemd[576]: Reloading finished in 181 ms. machine # [ 128.156135] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 128.166098] systemd[576]: Stopped Run user-specific NixOS activation. machine # [ 128.167042] systemd[576]: Stopping Run user-specific NixOS activation... machine # [ 128.169764] systemd[576]: Starting Run user-specific NixOS activation... machine # [ 128.214640] systemd[576]: Finished Run user-specific NixOS activation. machine # [ 128.218352] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 128.220275] systemd[1]: Stopping Reactivate sysinit units... machine # [ 128.221083] systemd[1]: Reached target Reactivate sysinit units. machine # [ 128.224420] systemd[1]: test.service: Deactivated successfully. machine # [ 128.225266] systemd[1]: Stopped test.service. machine # [ 128.225874] systemd[1]: Stopping test.service... machine # [ 128.228164] systemd[1]: Starting test.service... machine # [ 128.261812] systemd[1]: Finished test.service. machine # [ 128.265691] systemd[1]: Reached target Remote File Systems. machine # [ 128.270262] systemd[1]: Starting linger-users.service... machine # [ 128.280388] systemd[1]: Reached target Local File Systems. machine # [ 128.283465] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 128.289297] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 128.290591] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 128.295213] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 128.296798] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 128.298455] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 128.301403] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 128.303389] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 128.308343] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 128.361991] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 128.364746] systemd[1]: Finished linger-users.service. machine # [ 128.630552] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 128.633457] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 128.891153] nixos[5316]: finished switching to system configuration /nix/store/q4hqx9aiw9lpsqrdz9v39nigfilgnwpv-nixos-system-machine-test machine: (finished: must succeed: /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1, in 3.05 seconds) machine: must succeed: /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test/specialisation/simpleServiceWithInstallSection/bin/switch-to-configuration test 2>&1 machine # [ 129.521296] nixos[5458]: switching to system configuration /nix/store/xmiivwwdzvgc3vjvg5baidgrj4v9y3cl-nixos-system-machine-test machine # [ 129.523693] systemd[1]: Stopped target Remote File Systems. machine # [ 129.525949] systemd[1]: Stopped target Local File Systems. machine # [ 130.016421] systemd[1]: Reload requested from client PID 5458 ('.switch-to-conf') (unit backdoor.service)... machine # [ 130.018294] systemd[1]: Reloading... machine # [ 130.653867] systemd[1]: Reloading finished in 633 ms. machine # [ 130.808513] systemd[576]: Reexecution requested from client PID 5527 ('switch-to-confi')... machine # [ 130.812288] systemd[576]: Reexecuting. machine # [ 130.865488] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 131.056708] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 131.062571] systemd[576]: Reload requested from client PID 5527 ('switch-to-confi')... machine # [ 131.064634] systemd[576]: Reloading... machine # [ 131.246721] systemd[576]: Reloading finished in 180 ms. machine # [ 131.260128] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 131.268640] systemd[576]: Stopped Run user-specific NixOS activation. machine # [ 131.270749] systemd[576]: Stopping Run user-specific NixOS activation... machine # [ 131.273363] systemd[576]: Starting Run user-specific NixOS activation... machine # [ 131.314339] systemd[576]: Finished Run user-specific NixOS activation. machine # [ 131.318324] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 131.320602] systemd[1]: Stopping Reactivate sysinit units... machine # [ 131.321419] systemd[1]: Reached target Reactivate sysinit units. machine # [ 131.322221] systemd[1]: Reached target Remote File Systems. machine # [ 131.329284] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 131.332598] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 131.334731] systemd[1]: Reached target Local File Systems. machine # [ 131.339888] systemd[1]: Starting linger-users.service... machine # [ 131.344231] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 131.350340] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 131.352212] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 131.355673] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 131.358624] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 131.363415] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 131.365635] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 131.425487] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 131.428888] systemd[1]: Finished linger-users.service. machine # [ 131.685141] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 131.688606] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 131.946749] nixos[5458]: finished switching to system configuration /nix/store/xmiivwwdzvgc3vjvg5baidgrj4v9y3cl-nixos-system-machine-test machine: (finished: must succeed: /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test/specialisation/simpleServiceWithInstallSection/bin/switch-to-configuration test 2>&1, in 3.05 seconds) machine: must succeed: /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test/specialisation/simpleServiceWithExtraKey/bin/switch-to-configuration test 2>&1 machine # [ 132.585832] nixos[5598]: switching to system configuration /nix/store/ghg7nkcd44aijwcffaqaqaq5aiwz8is4-nixos-system-machine-test machine # [ 132.588553] systemd[1]: Stopped target Remote File Systems. machine # [ 132.590764] systemd[1]: Stopped target Local File Systems. machine # [ 133.082887] systemd[1]: Reload requested from client PID 5598 ('.switch-to-conf') (unit backdoor.service)... machine # [ 133.085049] systemd[1]: Reloading... machine # [ 133.718161] systemd[1]: Reloading finished in 631 ms. machine # [ 133.856937] systemd[576]: Reexecution requested from client PID 5667 ('switch-to-confi')... machine # [ 133.861188] systemd[576]: Reexecuting. machine # [ 133.917523] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 134.108658] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 134.115080] systemd[576]: Reload requested from client PID 5667 ('switch-to-confi')... machine # [ 134.117134] systemd[576]: Reloading... machine # [ 134.302024] systemd[576]: Reloading finished in 183 ms. machine # [ 134.316130] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 134.326715] systemd[576]: Stopped Run user-specific NixOS activation. machine # [ 134.327678] systemd[576]: Stopping Run user-specific NixOS activation... machine # [ 134.330431] systemd[576]: Starting Run user-specific NixOS activation... machine # [ 134.374468] systemd[576]: Finished Run user-specific NixOS activation. machine # [ 134.378131] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 134.380173] systemd[1]: Stopping Reactivate sysinit units... machine # [ 134.383493] systemd[1]: Reached target Reactivate sysinit units. machine # [ 134.384958] systemd[1]: test.service: Deactivated successfully. machine # [ 134.386800] systemd[1]: Stopped test.service. machine # [ 134.387476] systemd[1]: Stopping test.service... machine # [ 134.388287] systemd[1]: Starting test.service... machine # [ 134.421243] systemd[1]: Finished test.service. machine # [ 134.425247] systemd[1]: Reached target Local File Systems. machine # [ 134.428174] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 134.432968] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 134.433836] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 134.435021] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 134.438231] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 134.441218] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 134.445304] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 134.452500] systemd[1]: Reached target Remote File Systems. machine # [ 134.455158] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 134.457118] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 134.765782] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 134.770117] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 134.772604] systemd[1]: Starting linger-users.service... machine # [ 134.827868] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 134.829731] systemd[1]: Finished linger-users.service. machine # [ 135.089892] nixos[5598]: finished switching to system configuration /nix/store/ghg7nkcd44aijwcffaqaqaq5aiwz8is4-nixos-system-machine-test machine: (finished: must succeed: /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test/specialisation/simpleServiceWithExtraKey/bin/switch-to-configuration test 2>&1, in 3.14 seconds) machine: must succeed: /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test/specialisation/simpleServiceWithExtraKeyOtherValue/bin/switch-to-configuration test 2>&1 machine # [ 135.711016] nixos[5740]: switching to system configuration /nix/store/anyz7qbxhz1nav91wxbf9fjkb84lawn7-nixos-system-machine-test machine # [ 135.714770] systemd[1]: Stopped target Local File Systems. machine # [ 135.716108] systemd[1]: Stopped target Remote File Systems. machine # [ 136.222564] systemd[1]: Reload requested from client PID 5740 ('.switch-to-conf') (unit backdoor.service)... machine # [ 136.224701] systemd[1]: Reloading... machine # [ 136.885495] systemd[1]: Reloading finished in 658 ms. machine # [ 137.032386] systemd[576]: Reexecution requested from client PID 5809 ('switch-to-confi')... machine # [ 137.035132] systemd[576]: Reexecuting. machine # [ 137.097950] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 137.293221] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 137.299525] systemd[576]: Reload requested from client PID 5809 ('switch-to-confi')... machine # [ 137.302069] systemd[576]: Reloading... machine # [ 137.494359] systemd[576]: Reloading finished in 191 ms. machine # [ 137.508147] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 137.518802] systemd[576]: Stopped Run user-specific NixOS activation. machine # [ 137.521140] systemd[576]: Stopping Run user-specific NixOS activation... machine # [ 137.524076] systemd[576]: Starting Run user-specific NixOS activation... machine # [ 137.569493] systemd[576]: Finished Run user-specific NixOS activation. machine # [ 137.574097] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 137.578876] systemd[1]: Stopping Reactivate sysinit units... machine # [ 137.580268] systemd[1]: Reached target Reactivate sysinit units. machine # [ 137.582704] systemd[1]: test.service: Deactivated successfully. machine # [ 137.583700] systemd[1]: Stopped test.service. machine # [ 137.584563] systemd[1]: Stopping test.service... machine # [ 137.587404] systemd[1]: Starting test.service... machine # [ 137.624730] systemd[1]: Finished test.service. machine # [ 137.628061] systemd[1]: Reached target Local File Systems. machine # [ 137.631526] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 137.636245] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 137.637190] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 137.638397] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 137.642976] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 137.649738] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 137.657895] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 137.659205] systemd[1]: Reached target Remote File Systems. machine # [ 137.659998] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 137.661964] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 137.984735] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 137.986969] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 137.992341] systemd[1]: Starting linger-users.service... machine # [ 138.052145] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 138.054947] systemd[1]: Finished linger-users.service. machine # [ 138.311860] nixos[5740]: finished switching to system configuration /nix/store/anyz7qbxhz1nav91wxbf9fjkb84lawn7-nixos-system-machine-test machine: (finished: must succeed: /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test/specialisation/simpleServiceWithExtraKeyOtherValue/bin/switch-to-configuration test 2>&1, in 3.22 seconds) machine: must succeed: /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test/specialisation/simpleServiceWithExtraKeyOtherName/bin/switch-to-configuration test 2>&1 machine # [ 138.944527] nixos[5882]: switching to system configuration /nix/store/zj3p1m40i29n585c5xycpg24zkhllf3k-nixos-system-machine-test machine # [ 138.948170] systemd[1]: Stopped target Local File Systems. machine # [ 138.949643] systemd[1]: Stopped target Remote File Systems. machine # [ 139.492961] systemd[1]: Reload requested from client PID 5882 ('.switch-to-conf') (unit backdoor.service)... machine # [ 139.495006] systemd[1]: Reloading... machine # [ 140.174551] systemd[1]: Reloading finished in 676 ms. machine # [ 140.315323] systemd[576]: Reexecution requested from client PID 5951 ('switch-to-confi')... machine # [ 140.317569] systemd[576]: Reexecuting. machine # [ 140.373901] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 140.570971] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 140.577738] systemd[576]: Reload requested from client PID 5951 ('switch-to-confi')... machine # [ 140.580178] systemd[576]: Reloading... machine # [ 140.775237] systemd[576]: Reloading finished in 193 ms. machine # [ 140.792163] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 140.801550] systemd[576]: Stopped Run user-specific NixOS activation. machine # [ 140.803878] systemd[576]: Stopping Run user-specific NixOS activation... machine # [ 140.806806] systemd[576]: Starting Run user-specific NixOS activation... machine # [ 140.854245] systemd[576]: Finished Run user-specific NixOS activation. machine # [ 140.858206] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 140.859991] systemd[1]: Stopping Reactivate sysinit units... machine # [ 140.864357] systemd[1]: Reached target Reactivate sysinit units. machine # [ 140.866282] systemd[1]: test.service: Deactivated successfully. machine # [ 140.867155] systemd[1]: Stopped test.service. machine # [ 140.867779] systemd[1]: Stopping test.service... machine # [ 140.868722] systemd[1]: Starting test.service... machine # [ 140.903264] systemd[1]: Finished test.service. machine # [ 140.908792] systemd[1]: Reached target Local File Systems. machine # [ 140.911545] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 140.916751] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 140.917648] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 140.918868] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 140.922750] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 140.933401] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 140.934719] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 140.935937] systemd[1]: Reached target Remote File Systems. machine # [ 140.939235] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 140.940595] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 141.258885] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 141.263354] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 141.266384] systemd[1]: Starting linger-users.service... machine # [ 141.328553] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 141.330954] systemd[1]: Finished linger-users.service. machine # [ 141.585594] nixos[5882]: finished switching to system configuration /nix/store/zj3p1m40i29n585c5xycpg24zkhllf3k-nixos-system-machine-test machine: (finished: must succeed: /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test/specialisation/simpleServiceWithExtraKeyOtherName/bin/switch-to-configuration test 2>&1, in 3.27 seconds) machine: must succeed: /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1 machine # [ 142.193820] nixos[6024]: switching to system configuration /nix/store/q4hqx9aiw9lpsqrdz9v39nigfilgnwpv-nixos-system-machine-test machine # [ 142.196392] systemd[1]: Stopped target Local File Systems. machine # [ 142.198654] systemd[1]: Stopped target Remote File Systems. machine # [ 142.658050] systemd[1]: Reload requested from client PID 6024 ('.switch-to-conf') (unit backdoor.service)... machine # [ 142.660098] systemd[1]: Reloading... machine # [ 143.270550] systemd[1]: Reloading finished in 608 ms. machine # [ 143.419551] systemd[576]: Reexecution requested from client PID 6093 ('switch-to-confi')... machine # [ 143.423130] systemd[576]: Reexecuting. machine # [ 143.478029] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 143.672180] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 143.678618] systemd[576]: Reload requested from client PID 6093 ('switch-to-confi')... machine # [ 143.680916] systemd[576]: Reloading... machine # [ 143.873199] systemd[576]: Reloading finished in 191 ms. machine # [ 143.888153] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 143.896726] systemd[576]: Stopped Run user-specific NixOS activation. machine # [ 143.898931] systemd[576]: Stopping Run user-specific NixOS activation... machine # [ 143.901784] systemd[576]: Starting Run user-specific NixOS activation... machine # [ 143.947868] systemd[576]: Finished Run user-specific NixOS activation. machine # [ 143.952488] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 143.953410] systemd[1]: Stopping Reactivate sysinit units... machine # [ 143.954851] systemd[1]: Reached target Reactivate sysinit units. machine # [ 143.958813] systemd[1]: test.service: Deactivated successfully. machine # [ 143.959959] systemd[1]: Stopped test.service. machine # [ 143.961752] systemd[1]: Stopping test.service... machine # [ 143.962431] systemd[1]: Starting test.service... machine # [ 143.998559] systemd[1]: Finished test.service. machine # [ 144.002126] systemd[1]: Reached target Local File Systems. machine # [ 144.005409] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 144.009905] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 144.010749] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 144.011991] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 144.016126] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 144.023703] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 144.026701] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 144.030858] systemd[1]: Reached target Remote File Systems. machine # [ 144.033755] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 144.035232] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 144.349678] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 144.354355] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 144.356973] systemd[1]: Starting linger-users.service... machine # [ 144.413257] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 144.416089] systemd[1]: Finished linger-users.service. machine # [ 144.674449] nixos[6024]: finished switching to system configuration /nix/store/q4hqx9aiw9lpsqrdz9v39nigfilgnwpv-nixos-system-machine-test machine: (finished: must succeed: /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1, in 3.09 seconds) machine: must succeed: /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test/specialisation/simpleServiceReloadTrigger/bin/switch-to-configuration test 2>&1 machine # [ 145.293805] nixos[6166]: switching to system configuration /nix/store/iz4smcalzbvm98k9c0vqgswhq7ls88d2-nixos-system-machine-test machine # [ 145.296487] systemd[1]: Stopped target Remote File Systems. machine # [ 145.298778] systemd[1]: Stopped target Local File Systems. machine # [ 145.788328] systemd[1]: Reload requested from client PID 6166 ('.switch-to-conf') (unit backdoor.service)... machine # [ 145.790253] systemd[1]: Reloading... machine # [ 146.433264] systemd[1]: Reloading finished in 639 ms. machine # [ 146.575817] systemd[576]: Reexecution requested from client PID 6235 ('switch-to-confi')... machine # [ 146.579918] systemd[576]: Reexecuting. machine # [ 146.637677] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 146.821714] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 146.827734] systemd[576]: Reload requested from client PID 6235 ('switch-to-confi')... machine # [ 146.830292] systemd[576]: Reloading... machine # [ 147.013362] systemd[576]: Reloading finished in 181 ms. machine # [ 147.028144] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 147.038573] systemd[576]: Stopped Run user-specific NixOS activation. machine # [ 147.040913] systemd[576]: Stopping Run user-specific NixOS activation... machine # [ 147.043680] systemd[576]: Starting Run user-specific NixOS activation... machine # [ 147.087859] systemd[576]: Finished Run user-specific NixOS activation. machine # [ 147.092100] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 147.095993] systemd[1]: Stopping Reactivate sysinit units... machine # [ 147.097117] systemd[1]: Reached target Reactivate sysinit units. machine # [ 147.099739] systemd[1]: Reloading test.service... machine # [ 147.135478] systemd[1]: Reloaded test.service. machine # [ 147.139148] systemd[1]: Reached target Local File Systems. machine # [ 147.142542] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 147.146738] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 147.147665] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 147.150667] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 147.160320] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 147.161907] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 147.163166] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 147.170228] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 147.171547] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 147.173507] systemd[1]: Reached target Remote File Systems. machine # [ 147.476248] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 147.480388] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 147.482902] systemd[1]: Starting linger-users.service... machine # [ 147.544865] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 147.546492] systemd[1]: Finished linger-users.service. machine # [ 147.805959] nixos[6166]: finished switching to system configuration /nix/store/iz4smcalzbvm98k9c0vqgswhq7ls88d2-nixos-system-machine-test machine: (finished: must succeed: /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test/specialisation/simpleServiceReloadTrigger/bin/switch-to-configuration test 2>&1, in 3.13 seconds) machine: must succeed: /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModified/bin/switch-to-configuration test 2>&1 machine # [ 148.457510] nixos[6308]: switching to system configuration /nix/store/a7d2zcma8diy5nzydfg1xmn83zzz7wzd-nixos-system-machine-test machine # [ 148.460692] systemd[1]: Stopped target Local File Systems. machine # [ 148.462091] systemd[1]: Stopped target Remote File Systems. machine # [ 148.968437] systemd[1]: Reload requested from client PID 6308 ('.switch-to-conf') (unit backdoor.service)... machine # [ 148.970336] systemd[1]: Reloading... machine # [ 149.621415] systemd[1]: Reloading finished in 648 ms. machine # [ 149.762530] systemd[576]: Reexecution requested from client PID 6377 ('switch-to-confi')... machine # [ 149.763960] systemd[576]: Reexecuting. machine # [ 149.830191] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 150.018530] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 150.024919] systemd[576]: Reload requested from client PID 6377 ('switch-to-confi')... machine # [ 150.027462] systemd[576]: Reloading... machine # [ 150.213324] systemd[576]: Reloading finished in 184 ms. machine # [ 150.228136] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 150.238605] systemd[576]: Stopped Run user-specific NixOS activation. machine # [ 150.239553] systemd[576]: Stopping Run user-specific NixOS activation... machine # [ 150.242376] systemd[576]: Starting Run user-specific NixOS activation... machine # [ 150.287353] systemd[576]: Finished Run user-specific NixOS activation. machine # [ 150.291588] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 150.293217] systemd[1]: Stopping Reactivate sysinit units... machine # [ 150.294017] systemd[1]: Reached target Reactivate sysinit units. machine # [ 150.299070] systemd[1]: Reloading test.service... machine # [ 150.333414] systemd[1]: Reloaded test.service. machine # [ 150.336716] systemd[1]: Reached target Local File Systems. machine # [ 150.340101] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 150.343692] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 150.347775] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 150.353226] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 150.355600] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 150.361444] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 150.362840] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 150.367014] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 150.370429] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 150.371908] systemd[1]: Reached target Remote File Systems. machine # [ 150.674836] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 150.679382] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 150.682746] systemd[1]: Starting linger-users.service... machine # [ 150.742693] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 150.745385] systemd[1]: Finished linger-users.service. machine # [ 151.003551] nixos[6308]: finished switching to system configuration /nix/store/a7d2zcma8diy5nzydfg1xmn83zzz7wzd-nixos-system-machine-test machine: (finished: must succeed: /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModified/bin/switch-to-configuration test 2>&1, in 3.20 seconds) machine: must succeed: /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModifiedAndSomethingElse/bin/switch-to-configuration test 2>&1 machine # [ 151.632562] nixos[6450]: switching to system configuration /nix/store/69m73park9za1prxrvjykbfq9k2r8qq0-nixos-system-machine-test machine # [ 151.635253] systemd[1]: Stopped target Local File Systems. machine # [ 151.637641] systemd[1]: Stopped target Remote File Systems. machine # [ 152.140892] systemd[1]: Reload requested from client PID 6450 ('.switch-to-conf') (unit backdoor.service)... machine # [ 152.142844] systemd[1]: Reloading... machine # [ 152.814376] systemd[1]: Reloading finished in 669 ms. machine # [ 152.966621] systemd[576]: Reexecution requested from client PID 6519 ('switch-to-confi')... machine # [ 152.969560] systemd[576]: Reexecuting. machine # [ 153.026353] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 153.220622] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 153.227022] systemd[576]: Reload requested from client PID 6519 ('switch-to-confi')... machine # [ 153.229198] systemd[576]: Reloading... machine # [ 153.419826] systemd[576]: Reloading finished in 189 ms. machine # [ 153.432143] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 153.443129] systemd[576]: Stopped Run user-specific NixOS activation. machine # [ 153.444134] systemd[576]: Stopping Run user-specific NixOS activation... machine # [ 153.447001] systemd[576]: Starting Run user-specific NixOS activation... machine # [ 153.492523] systemd[576]: Finished Run user-specific NixOS activation. machine # [ 153.496505] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 153.498424] systemd[1]: Stopping Reactivate sysinit units... machine # [ 153.502313] systemd[1]: Reached target Reactivate sysinit units. machine # [ 153.503201] systemd[1]: test.service: Deactivated successfully. machine # [ 153.503981] systemd[1]: Stopped test.service. machine # [ 153.504918] systemd[1]: Stopping test.service... machine # [ 153.507027] systemd[1]: Starting test.service... machine # [ 153.542812] systemd[1]: Finished test.service. machine # [ 153.546288] systemd[1]: Reached target Local File Systems. machine # [ 153.552437] systemd[1]: Reached target Remote File Systems. machine # [ 153.554740] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 153.557392] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 153.563758] systemd[1]: Starting linger-users.service... machine # [ 153.568798] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 153.573135] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 153.573987] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 153.575267] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 153.581969] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 153.583913] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 153.585482] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 153.652360] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 153.655112] systemd[1]: Finished linger-users.service. machine # [ 153.920772] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 153.923836] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 154.180503] nixos[6450]: finished switching to system configuration /nix/store/69m73park9za1prxrvjykbfq9k2r8qq0-nixos-system-machine-test machine: (finished: must succeed: /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModifiedAndSomethingElse/bin/switch-to-configuration test 2>&1, in 3.18 seconds) machine: must succeed: /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModifiedSomethingElse/bin/switch-to-configuration test 2>&1 machine # [ 154.769876] nixos[6592]: switching to system configuration /nix/store/ghg7nkcd44aijwcffaqaqaq5aiwz8is4-nixos-system-machine-test machine # [ 154.772319] systemd[1]: Stopped target Remote File Systems. machine # [ 154.774417] systemd[1]: Stopped target Local File Systems. machine # [ 155.198661] systemd[1]: Reload requested from client PID 6592 ('.switch-to-conf') (unit backdoor.service)... machine # [ 155.200690] systemd[1]: Reloading... machine # [ 155.771625] systemd[1]: Reloading finished in 569 ms. machine # [ 155.907841] systemd[576]: Reexecution requested from client PID 6661 ('switch-to-confi')... machine # [ 155.911375] systemd[576]: Reexecuting. machine # [ 155.965529] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 156.148091] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 156.154386] systemd[576]: Reload requested from client PID 6661 ('switch-to-confi')... machine # [ 156.156694] systemd[576]: Reloading... machine # [ 156.339458] systemd[576]: Reloading finished in 181 ms. machine # [ 156.356190] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 156.368041] systemd[576]: Stopped Run user-specific NixOS activation. machine # [ 156.369052] systemd[576]: Stopping Run user-specific NixOS activation... machine # [ 156.371892] systemd[576]: Starting Run user-specific NixOS activation... machine # [ 156.415259] systemd[576]: Finished Run user-specific NixOS activation. machine # [ 156.419486] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 156.421135] systemd[1]: Stopping Reactivate sysinit units... machine # [ 156.421992] systemd[1]: Reached target Reactivate sysinit units. machine # [ 156.425202] systemd[1]: Reached target Local File Systems. machine # [ 156.428630] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 156.432369] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 156.433202] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 156.434384] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 156.450345] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 156.451984] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 156.454734] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 156.456002] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 156.457269] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 156.458472] systemd[1]: Reached target Remote File Systems. machine # [ 156.774109] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 156.778798] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 156.781552] systemd[1]: Starting linger-users.service... machine # [ 156.843915] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 156.846805] systemd[1]: Finished linger-users.service. machine # [ 157.104953] nixos[6592]: finished switching to system configuration /nix/store/ghg7nkcd44aijwcffaqaqaq5aiwz8is4-nixos-system-machine-test machine: (finished: must succeed: /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModifiedSomethingElse/bin/switch-to-configuration test 2>&1, in 2.93 seconds) (finished: subtest: unit file parser, in 40.73 seconds) subtest: restart and reload by activation script machine: must succeed: /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test/specialisation/simpleServiceNorestart/bin/switch-to-configuration test 2>&1 machine # [ 157.716391] nixos[6732]: switching to system configuration /nix/store/6cf4937d4majd9i2kzr31yq3vrqj0sid-nixos-system-machine-test machine # [ 157.719664] systemd[1]: Stopped target Remote File Systems. machine # [ 157.722568] systemd[1]: Stopped target Local File Systems. machine # [ 158.210204] systemd[1]: Reload requested from client PID 6732 ('.switch-to-conf') (unit backdoor.service)... machine # [ 158.212341] systemd[1]: Reloading... machine # [ 158.813775] systemd[1]: Reloading finished in 598 ms. machine # [ 158.975666] systemd[576]: Reexecution requested from client PID 6801 ('switch-to-confi')... machine # [ 158.978477] systemd[576]: Reexecuting. machine # [ 159.054183] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 159.254272] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 159.262773] systemd[576]: Reload requested from client PID 6801 ('switch-to-confi')... machine # [ 159.265732] systemd[576]: Reloading... machine # [ 159.471717] systemd[576]: Reloading finished in 204 ms. machine # [ 159.488197] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 159.501578] systemd[576]: Stopped Run user-specific NixOS activation. machine # [ 159.502698] systemd[576]: Stopping Run user-specific NixOS activation... machine # [ 159.506302] systemd[576]: Starting Run user-specific NixOS activation... machine # [ 159.556564] systemd[576]: Finished Run user-specific NixOS activation. machine # [ 159.561891] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 159.562859] systemd[1]: Stopping Reactivate sysinit units... machine # [ 159.563676] systemd[1]: Reached target Reactivate sysinit units. machine # [ 159.568556] systemd[1]: Reached target Local File Systems. machine # [ 159.575178] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 159.579783] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 159.581654] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 159.587149] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 159.589633] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 159.593433] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 159.596524] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 159.600277] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 159.601645] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 159.602828] systemd[1]: Reached target Remote File Systems. machine # [ 159.943614] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 159.948694] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 159.951246] systemd[1]: Starting linger-users.service... machine # [ 160.016673] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 160.019781] systemd[1]: Finished linger-users.service. machine # [ 160.277139] nixos[6732]: finished switching to system configuration /nix/store/6cf4937d4majd9i2kzr31yq3vrqj0sid-nixos-system-machine-test machine: (finished: must succeed: /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test/specialisation/simpleServiceNorestart/bin/switch-to-configuration test 2>&1, in 3.17 seconds) machine: must succeed: /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration test 2>&1 machine # [ 160.956137] nixos[6872]: switching to system configuration /nix/store/y1lnrngxcm8670zrs8pi1yg0dc1r70iz-nixos-system-machine-test machine # [ 160.960290] systemd[1]: Stopped target Local File Systems. machine # [ 160.962037] systemd[1]: Stopped target Remote File Systems. machine # [ 160.962955] systemd[1]: test.service: Deactivated successfully. machine # [ 160.963771] systemd[1]: Stopped test.service. machine # [ 161.519185] systemd[1]: Reload requested from client PID 6872 ('.switch-to-conf') (unit backdoor.service)... machine # [ 161.521490] systemd[1]: Reloading... machine # [ 162.209904] systemd[1]: Reloading finished in 685 ms. machine # [ 162.367662] systemd[576]: Reexecution requested from client PID 6943 ('switch-to-confi')... machine # [ 162.369901] systemd[576]: Reexecuting. machine # [ 162.442988] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 162.645324] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 162.651840] systemd[576]: Reload requested from client PID 6943 ('switch-to-confi')... machine # [ 162.655877] systemd[576]: Reloading... machine # [ 162.843965] systemd[576]: Reloading finished in 189 ms. machine # [ 162.856172] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 162.865949] systemd[576]: Stopped Run user-specific NixOS activation. machine # [ 162.868491] systemd[576]: Stopping Run user-specific NixOS activation... machine # [ 162.871547] systemd[576]: Starting Run user-specific NixOS activation... machine # [ 162.919162] systemd[576]: Finished Run user-specific NixOS activation. machine # [ 162.923820] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 162.925320] systemd[1]: Stopping Reactivate sysinit units... machine # [ 162.926167] systemd[1]: Reached target Reactivate sysinit units. machine # [ 162.933607] systemd[1]: Starting simple-restart-service.service... machine # [ 162.951452] systemd[1]: Created slice Slice /system/templated-no-restart-service. machine # [ 162.954572] systemd[1]: Starting templated-no-restart-service@instance.service... machine # [ 162.962091] systemd[1]: Reached target Remote File Systems. machine # [ 162.970361] systemd[1]: Reached target Local File Systems. machine # [ 162.973602] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 162.981017] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 162.989240] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 162.990589] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 163.002344] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 163.007711] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 163.014637] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 163.022692] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 163.028790] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 163.032360] systemd[1]: Created slice Slice /system/templated-reload-triggers. machine # [ 163.035372] systemd[1]: Created slice Slice /system/templated-reload-triggers-and-restart. machine # [ 163.039681] systemd[1]: Created slice Slice /system/templated-simple-service. machine # [ 163.048792] systemd[1]: Created slice Slice /system/templated-simple-restart-service. machine # [ 163.052857] systemd[1]: Created slice Slice /system/templated-reload-triggers-and-restart-by-as. machine # [ 163.057505] systemd[1]: Finished simple-restart-service.service. machine # [ 163.067912] systemd[1]: Finished templated-no-restart-service@instance.service. machine # [ 163.077232] systemd[1]: Created slice Slice /system/templated-simple-reload-service. machine # [ 163.372344] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 163.376218] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 163.380498] systemd[1]: Starting linger-users.service... machine # [ 163.384527] systemd[1]: Starting no-restart-service.service... machine # [ 163.388131] systemd[1]: Starting reload-triggers-and-restart-by-as.service... machine # [ 163.398658] systemd[1]: Starting reload-triggers-and-restart.service... machine # [ 163.409918] systemd[1]: Starting reload-triggers.service... machine # [ 163.416594] systemd[1]: Starting simple-reload-service.service... machine # [ 163.428420] systemd[1]: Starting simple-service.service... machine # [ 163.434084] systemd[1]: Starting templated-reload-triggers-and-restart-by-as@instance.service... machine # [ 163.439025] systemd[1]: Starting templated-reload-triggers-and-restart@instance.service... machine # [ 163.463435] systemd[1]: Starting templated-reload-triggers@instance.service... machine # [ 163.476488] systemd[1]: Starting templated-simple-reload-service@instance.service... machine # [ 163.495231] systemd[1]: Starting templated-simple-restart-service@instance.service... machine # [ 163.511236] systemd[1]: Starting templated-simple-service@instance.service... machine # [ 163.560191] systemd[1]: Finished reload-triggers.service. machine # [ 163.573122] systemd[1]: Finished no-restart-service.service. machine # [ 163.583894] systemd[1]: Finished reload-triggers-and-restart.service. machine # [ 163.587131] systemd[1]: Finished reload-triggers-and-restart-by-as.service. machine # [ 163.599715] systemd[1]: Finished simple-reload-service.service. machine # [ 163.615602] systemd[1]: Finished simple-service.service. machine # [ 163.622645] systemd[1]: Finished templated-reload-triggers-and-restart-by-as@instance.service. machine # [ 163.633905] systemd[1]: Finished templated-reload-triggers-and-restart@instance.service. machine # [ 163.635143] systemd[1]: Finished templated-reload-triggers@instance.service. machine # [ 163.638984] systemd[1]: Finished templated-simple-reload-service@instance.service. machine # [ 163.651017] systemd[1]: Finished templated-simple-restart-service@instance.service. machine # [ 163.656003] systemd[1]: Finished templated-simple-service@instance.service. machine # [ 163.662894] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 163.665182] systemd[1]: Finished linger-users.service. machine # [ 163.925221] nixos[6872]: finished switching to system configuration /nix/store/y1lnrngxcm8670zrs8pi1yg0dc1r70iz-nixos-system-machine-test machine: (finished: must succeed: /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration test 2>&1, in 3.65 seconds) machine: must succeed: /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration test 2>&1 machine # [ 164.653171] nixos[7042]: switching to system configuration /nix/store/y1lnrngxcm8670zrs8pi1yg0dc1r70iz-nixos-system-machine-test machine # [ 164.655928] systemd[1]: Stopped target Local File Systems. machine # [ 164.658219] systemd[1]: Stopped target Remote File Systems. machine # [ 165.142620] systemd[1]: Reload requested from client PID 7042 ('.switch-to-conf') (unit backdoor.service)... machine # [ 165.144815] systemd[1]: Reloading... machine # [ 165.780374] systemd[1]: Reloading finished in 633 ms. machine # [ 165.928428] systemd[576]: Reexecution requested from client PID 7113 ('switch-to-confi')... machine # [ 165.931718] systemd[576]: Reexecuting. machine # [ 165.985873] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 166.165892] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 166.172366] systemd[576]: Reload requested from client PID 7113 ('switch-to-confi')... machine # [ 166.174849] systemd[576]: Reloading... machine # [ 166.358712] systemd[576]: Reloading finished in 182 ms. machine # [ 166.372161] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 166.382533] systemd[576]: Stopped Run user-specific NixOS activation. machine # [ 166.383526] systemd[576]: Stopping Run user-specific NixOS activation... machine # [ 166.386386] systemd[576]: Starting Run user-specific NixOS activation... machine # [ 166.432329] systemd[576]: Finished Run user-specific NixOS activation. machine # [ 166.436363] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 166.438835] systemd[1]: Stopping Reactivate sysinit units... machine # [ 166.439720] systemd[1]: Reached target Reactivate sysinit units. machine # [ 166.445029] systemd[1]: Reloading reload-triggers-and-restart.service... machine # [ 166.450705] systemd[1]: Reloading reload-triggers.service... machine # [ 166.459933] systemd[1]: Reloading simple-reload-service.service... machine # [ 166.469924] systemd[1]: Reloading templated-reload-triggers-and-restart@instance.service... machine # [ 166.481960] systemd[1]: Reloading templated-reload-triggers@instance.service... machine # [ 166.489266] systemd[1]: Reloading templated-simple-reload-service@instance.service... machine # [ 166.555362] systemd[1]: Reloaded reload-triggers.service. machine # [ 166.558475] systemd[1]: Reloaded templated-reload-triggers-and-restart@instance.service. machine # [ 166.559596] systemd[1]: Reloaded simple-reload-service.service. machine # [ 166.562102] systemd[1]: Reloaded reload-triggers-and-restart.service. machine # [ 166.563212] systemd[1]: Reloaded templated-reload-triggers@instance.service. machine # [ 166.571017] systemd[1]: Reloaded templated-simple-reload-service@instance.service. machine # [ 166.576139] systemd[1]: reload-triggers-and-restart-by-as.service: Deactivated successfully. machine # [ 166.577309] systemd[1]: Stopped reload-triggers-and-restart-by-as.service. machine # [ 166.578236] systemd[1]: Stopping reload-triggers-and-restart-by-as.service... machine # [ 166.581894] systemd[1]: Starting reload-triggers-and-restart-by-as.service... machine # [ 166.585525] systemd[1]: simple-restart-service.service: Deactivated successfully. machine # [ 166.586603] systemd[1]: Stopped simple-restart-service.service. machine # [ 166.587416] systemd[1]: Stopping simple-restart-service.service... machine # [ 166.590583] systemd[1]: Starting simple-restart-service.service... machine # [ 166.594690] systemd[1]: simple-service.service: Deactivated successfully. machine # [ 166.597294] systemd[1]: Stopped simple-service.service. machine # [ 166.604778] systemd[1]: Stopping simple-service.service... machine # [ 166.605949] systemd[1]: Starting simple-service.service... machine # [ 166.607052] systemd[1]: templated-reload-triggers-and-restart-by-as@instance.service: Deactivated successfully. machine # [ 166.620297] systemd[1]: Stopped templated-reload-triggers-and-restart-by-as@instance.service. machine # [ 166.633109] systemd[1]: Stopping templated-reload-triggers-and-restart-by-as@instance.service... machine # [ 166.642385] systemd[1]: Starting templated-reload-triggers-and-restart-by-as@instance.service... machine # [ 166.647407] systemd[1]: templated-simple-restart-service@instance.service: Deactivated successfully. machine # [ 166.654745] systemd[1]: Stopped templated-simple-restart-service@instance.service. machine # [ 166.659875] systemd[1]: Stopping templated-simple-restart-service@instance.service... machine # [ 166.664753] systemd[1]: Starting templated-simple-restart-service@instance.service... machine # [ 166.671795] systemd[1]: templated-simple-service@instance.service: Deactivated successfully. machine # [ 166.681102] systemd[1]: Stopped templated-simple-service@instance.service. machine # [ 166.686263] systemd[1]: Stopping templated-simple-service@instance.service... machine # [ 166.692334] systemd[1]: Starting templated-simple-service@instance.service... machine # [ 166.704215] systemd[1]: Finished reload-triggers-and-restart-by-as.service. machine # [ 166.712142] systemd[1]: Finished simple-service.service. machine # [ 166.722831] systemd[1]: Finished simple-restart-service.service. machine # [ 166.726163] systemd[1]: Finished templated-simple-restart-service@instance.service. machine # [ 166.729978] systemd[1]: Finished templated-reload-triggers-and-restart-by-as@instance.service. machine # [ 166.731174] systemd[1]: Finished templated-simple-service@instance.service. machine # [ 166.734363] systemd[1]: Reached target Local File Systems. machine # [ 166.736528] systemd[1]: Reached target Remote File Systems. machine # [ 166.738814] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 166.741426] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 166.748130] systemd[1]: Starting linger-users.service... machine # [ 166.759625] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 166.769417] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 166.770342] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 166.771553] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 166.774634] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 166.776975] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 166.778640] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 166.838284] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 166.841154] systemd[1]: Finished linger-users.service. machine # [ 167.112170] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 167.115382] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 167.372621] nixos[7042]: finished switching to system configuration /nix/store/y1lnrngxcm8670zrs8pi1yg0dc1r70iz-nixos-system-machine-test machine: (finished: must succeed: /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration test 2>&1, in 3.45 seconds) machine: must succeed: /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script-modified/bin/switch-to-configuration test 2>&1 machine # [ 168.142068] nixos[7208]: switching to system configuration /nix/store/l9rdf41n3rf0dw7qm32jxcw451v3nlww-nixos-system-machine-test machine # [ 168.145078] systemd[1]: Stopped target Local File Systems. machine # [ 168.147363] systemd[1]: Stopped target Remote File Systems. machine # [ 168.709494] systemd[1]: Reload requested from client PID 7208 ('.switch-to-conf') (unit backdoor.service)... machine # [ 168.711407] systemd[1]: Reloading... machine # [ 169.385255] systemd[1]: Reloading finished in 671 ms. machine # [ 169.529856] systemd[576]: Reexecution requested from client PID 7279 ('switch-to-confi')... machine # [ 169.531291] systemd[576]: Reexecuting. machine # [ 169.597639] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 169.784126] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 169.790028] systemd[576]: Reload requested from client PID 7279 ('switch-to-confi')... machine # [ 169.792077] systemd[576]: Reloading... machine # [ 169.974268] systemd[576]: Reloading finished in 180 ms. machine # [ 169.988134] systemd[576]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 169.996679] systemd[576]: Stopped Run user-specific NixOS activation. machine # [ 169.998813] systemd[576]: Stopping Run user-specific NixOS activation... machine # [ 170.001442] systemd[576]: Starting Run user-specific NixOS activation... machine # [ 170.042485] systemd[576]: Finished Run user-specific NixOS activation. machine # [ 170.046124] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 170.050569] systemd[1]: Stopping Reactivate sysinit units... machine # [ 170.051720] systemd[1]: Reached target Reactivate sysinit units. machine # [ 170.054170] systemd[1]: Reloading reload-triggers.service... machine # [ 170.061035] systemd[1]: Reloading simple-reload-service.service... machine # [ 170.071694] systemd[1]: Reloading templated-reload-triggers@instance.service... machine # [ 170.077186] systemd[1]: Reloading templated-simple-reload-service@instance.service... machine # [ 170.124888] systemd[1]: Reloaded reload-triggers.service. machine # [ 170.128192] systemd[1]: Reloaded simple-reload-service.service. machine # [ 170.129041] systemd[1]: Reloaded templated-reload-triggers@instance.service. machine # [ 170.129950] systemd[1]: Reloaded templated-simple-reload-service@instance.service. machine # [ 170.132002] systemd[1]: reload-triggers-and-restart-by-as.service: Deactivated successfully. machine # [ 170.135150] systemd[1]: Stopped reload-triggers-and-restart-by-as.service. machine # [ 170.136355] systemd[1]: Stopping reload-triggers-and-restart-by-as.service... machine # [ 170.138715] systemd[1]: Starting reload-triggers-and-restart-by-as.service... machine # [ 170.142828] systemd[1]: reload-triggers-and-restart.service: Deactivated successfully. machine # [ 170.147331] systemd[1]: Stopped reload-triggers-and-restart.service. machine # [ 170.148306] systemd[1]: Stopping reload-triggers-and-restart.service... machine # [ 170.152639] systemd[1]: Starting reload-triggers-and-restart.service... machine # [ 170.156660] systemd[1]: simple-restart-service.service: Deactivated successfully. machine # [ 170.157675] systemd[1]: Stopped simple-restart-service.service. machine # [ 170.158465] systemd[1]: Stopping simple-restart-service.service... machine # [ 170.163052] systemd[1]: Starting simple-restart-service.service... machine # [ 170.166934] systemd[1]: simple-service.service: Deactivated successfully. machine # [ 170.179386] systemd[1]: Stopped simple-service.service. machine # [ 170.180439] systemd[1]: Stopping simple-service.service... machine # [ 170.181562] systemd[1]: Starting simple-service.service... machine # [ 170.187011] systemd[1]: templated-reload-triggers-and-restart-by-as@instance.service: Deactivated successfully. machine # [ 170.191730] systemd[1]: Stopped templated-reload-triggers-and-restart-by-as@instance.service. machine # [ 170.212495] systemd[1]: Stopping templated-reload-triggers-and-restart-by-as@instance.service... machine # [ 170.213697] systemd[1]: Starting templated-reload-triggers-and-restart-by-as@instance.service... machine # [ 170.214973] systemd[1]: templated-reload-triggers-and-restart@instance.service: Deactivated successfully. machine # [ 170.240505] systemd[1]: Stopped templated-reload-triggers-and-restart@instance.service. machine # [ 170.245241] systemd[1]: Stopping templated-reload-triggers-and-restart@instance.service... machine # [ 170.258027] systemd[1]: Starting templated-reload-triggers-and-restart@instance.service... machine # [ 170.265660] systemd[1]: templated-simple-restart-service@instance.service: Deactivated successfully. machine # [ 170.278102] systemd[1]: Stopped templated-simple-restart-service@instance.service. machine # [ 170.280581] systemd[1]: Stopping templated-simple-restart-service@instance.service... machine # [ 170.282555] systemd[1]: Starting templated-simple-restart-service@instance.service... machine # [ 170.290313] systemd[1]: templated-simple-service@instance.service: Deactivated successfully. machine # [ 170.297882] systemd[1]: Stopped templated-simple-service@instance.service. machine # [ 170.299149] systemd[1]: Stopping templated-simple-service@instance.service... machine # [ 170.303210] systemd[1]: Starting templated-simple-service@instance.service... machine # [ 170.306780] systemd[1]: Finished reload-triggers-and-restart.service. machine # [ 170.308456] systemd[1]: Finished reload-triggers-and-restart-by-as.service. machine # [ 170.310415] systemd[1]: Finished simple-service.service. machine # [ 170.311955] systemd[1]: Finished simple-restart-service.service. machine # [ 170.313960] systemd[1]: Finished templated-reload-triggers-and-restart-by-as@instance.service. machine # [ 170.315951] systemd[1]: Finished templated-simple-restart-service@instance.service. machine # [ 170.317521] systemd[1]: Finished templated-reload-triggers-and-restart@instance.service. machine # [ 170.323539] systemd[1]: Finished templated-simple-service@instance.service. machine # [ 170.326266] systemd[1]: Reached target Remote File Systems. machine # [ 170.331117] systemd[1]: Starting linger-users.service... machine # [ 170.333599] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 170.335999] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 170.344152] systemd[1]: Reached target Local File Systems. machine # [ 170.344962] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 170.353720] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 170.354573] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 170.355764] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 170.364399] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 170.366411] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 170.368648] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 170.422425] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 170.424970] systemd[1]: Finished linger-users.service. machine # [ 170.678412] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 170.681677] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 170.938595] nixos[7208]: finished switching to system configuration /nix/store/l9rdf41n3rf0dw7qm32jxcw451v3nlww-nixos-system-machine-test machine: (finished: must succeed: /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script-modified/bin/switch-to-configuration test 2>&1, in 3.57 seconds) machine: must succeed: /nix/store/hl62h6c78jglhd3ljybvx1laj1ildkj0-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/hl62h6c78jglhd3ljybvx1laj1ildkj0-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration dry-activate 2>&1, in 0.86 seconds) (finished: subtest: restart and reload by activation script, in 14.69 seconds) (finished: run the VM test script, in 172.72 seconds) test script finished in 172.77s cleanup kill QemuMachine (pid 45) machine # qemu-system-aarch64: terminating on signal 15 from pid 39 (/nix/store/lfh101cfjj8p8npcari9hk0lbqi33yvh-python3-3.14.7/bin/python3.14) (finished: cleanup, in 0.19 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