tribuchet: building on eliza Machine state will be reset. To keep it, pass --keep-machine-state start all VLans (finished: start all VLans, in 0.00 seconds) Test will time out and terminate in 3600.0 seconds run the VM test script machine: waiting for unit multi-user.target machine: waiting for the VM to finish booting machine: starting vm machine # Disk image does not exist, creating the virtualisation disk image... machine: QEMU running (pid 45) machine # Formatting '/build/vm-state-machine/tmp.5wTx9menFy', 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: 224d0568-8d9f-44c3-bdae-47c506d0637a machine # Superblock backups stored on blocks: machine # 32768, 98304, 163840, 229376 machine # machine # Allocating group tables: 0/8 done machine # Writing inode tables: 0/8 done machine # Creating journal (8192 blocks): done machine # Writing superblocks and filesystem accounting information: 0/8 done machine # machine # Virtualisation disk image created. machine # Starting virtiofs daemons... machine # [2026-10-18T02:43:26Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1) machine # [2026-10-18T02:43:26Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether machine # [2026-10-18T02:43:26Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1) machine # [2026-10-18T02:43:26Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether machine # [2026-10-18T02:43:26Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1) machine # [2026-10-18T02:43:26Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether machine # [2026-10-18T02:43:26Z INFO virtiofsd] Waiting for vhost-user socket connection... machine # [2026-10-18T02:43:26Z INFO virtiofsd] Waiting for vhost-user socket connection... machine # [2026-10-18T02:43:26Z INFO virtiofsd] Waiting for vhost-user socket connection... machine # [2026-10-18T02:43:26Z INFO virtiofsd] Client connected, servicing requests machine # [2026-10-18T02:43:26Z INFO virtiofsd] Client connected, servicing requests machine # [2026-10-18T02:43:26Z INFO virtiofsd] Client connected, servicing requests machine # [ 0.000000] Booting Linux on physical CPU 0x0000000000 [0xc00fac40] machine # [ 0.000000] Linux version 6.18.56 (nixbld@localhost) (gcc (GCC) 16.2.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT @1791725172 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 s186904 r8192 d116200 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/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test/init regInfo=/nix/.ro-store/a3hdbm3dx1v86v48ij6shyi9ydvyllji-closure-info/registration console=ttyAMA0,115200n8 console=tty0 machine # [ 0.000000] Unknown kernel command line parameters "regInfo=/nix/.ro-store/a3hdbm3dx1v86v48ij6shyi9ydvyllji-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 75049 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=512 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.000032] arm-pv: using stolen time PV machine # [ 0.000416] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____) machine # [ 0.000723] Console: colour dummy device 80x25 machine # [ 0.000732] printk: legacy console [tty0] enabled machine # [ 0.000923] Calibrating delay loop (skipped), value calculated using timer frequency.. 2000.00 BogoMIPS (lpj=4000000) machine # [ 0.000930] pid_max: default: 32768 minimum: 301 machine # [ 0.001010] LSM: initializing lsm=capability,landlock,yama,bpf,ima machine # [ 0.001182] landlock: Up and running. machine # [ 0.001185] Yama: becoming mindful. machine # [ 0.001647] LSM support for eBPF active machine # [ 0.001788] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear) machine # [ 0.001807] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear) machine # [ 0.003790] rcu: Hierarchical SRCU implementation. machine # [ 0.003797] rcu: Max phase no-delay instances is 1000. machine # [ 0.005177] fsl-mc MSI: its@8080000 domain created machine # [ 0.005306] EFI services will not be available. machine # [ 0.005441] smp: Bringing up secondary CPUs ... machine # [ 0.005451] smp: Brought up 1 node, 1 CPU machine # [ 0.005455] SMP: Total of 1 processors activated. machine # [ 0.005457] CPU: All CPU(s) started at EL1 machine # [ 0.005467] CPU features: detected: Branch Target Identification machine # [ 0.005472] CPU features: detected: ARMv8.4 Translation Table Level machine # [ 0.005476] CPU features: detected: Instruction cache invalidation not required for I/D coherence machine # [ 0.005479] CPU features: detected: Data cache clean to the PoU not required for I/D coherence machine # [ 0.005488] CPU features: detected: Common not Private translations machine # [ 0.005492] CPU features: detected: CRC32 instructions machine # [ 0.005494] CPU features: detected: Data cache clean to Point of Deep Persistence machine # [ 0.005498] CPU features: detected: Data cache clean to Point of Persistence machine # [ 0.005501] CPU features: detected: Data independent timing control (DIT) machine # [ 0.005504] CPU features: detected: E0PD machine # [ 0.005507] CPU features: detected: Enhanced Counter Virtualization machine # [ 0.005510] CPU features: detected: Enhanced Counter Virtualization (CNTPOFF) machine # [ 0.005513] CPU features: detected: Enhanced Virtualization Traps machine # [ 0.005516] CPU features: detected: Fine Grained Traps machine # [ 0.005520] CPU features: detected: Generic authentication (architected QARMA5 algorithm) machine # [ 0.005525] CPU features: detected: RCpc load-acquire (LDAPR) machine # [ 0.005528] CPU features: detected: LSE atomic instructions machine # [ 0.005531] CPU features: detected: Privileged Access Never machine # [ 0.005534] CPU features: detected: PMUv3 machine # [ 0.005537] CPU features: detected: RAS Extension Support machine # [ 0.005540] CPU features: detected: RASv1p1 Extension Support machine # [ 0.005543] CPU features: detected: Random Number Generator machine # [ 0.005549] CPU features: detected: Speculation barrier (SB) machine # [ 0.005552] CPU features: detected: Stage-2 Force Write-Back machine # [ 0.005555] CPU features: detected: TLB range maintenance instructions machine # [ 0.005559] CPU features: detected: Speculative Store Bypassing Safe (SSBS) machine # [ 0.005598] alternatives: applying system-wide alternatives machine # [ 0.008857] CPU features: detected: BBM Level 2 without TLB conflict abort machine # [ 0.009034] Memory: 892864K/1048576K available (24512K kernel code, 7102K rwdata, 26572K rodata, 4736K init, 1184K bss, 114392K reserved, 32768K cma-reserved) machine # [ 0.009427] devtmpfs: initialized machine # [ 0.011296] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear) machine # [ 0.011321] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear). machine # [ 0.011495] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL machine # [ 0.011499] 0 pages in range for non-PLT usage machine # [ 0.011501] 508192 pages in range for PLT usage machine # [ 0.011631] pinctrl core: initialized pinctrl subsystem machine # [ 0.012572] DMI not present or invalid. machine # [ 0.015953] NET: Registered PF_NETLINK/PF_ROUTE protocol family machine # [ 0.018434] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations machine # [ 0.018579] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations machine # [ 0.018741] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations machine # [ 0.018770] audit: initializing netlink subsys (disabled) machine # [ 0.019455] thermal_sys: Registered thermal governor 'fair_share' machine # [ 0.019457] thermal_sys: Registered thermal governor 'bang_bang' machine # [ 0.019461] thermal_sys: Registered thermal governor 'step_wise' machine # [ 0.019464] thermal_sys: Registered thermal governor 'user_space' machine # [ 0.019467] thermal_sys: Registered thermal governor 'power_allocator' machine # [ 0.019497] audit: type=2000 audit(0.016:1): state=initialized audit_enabled=0 res=1 machine # [ 0.019506] cpuidle: using governor ladder machine # [ 0.019512] cpuidle: using governor menu machine # [ 0.019739] hw-breakpoint: found 16 breakpoint and 4 watchpoint registers. machine # [ 0.019757] ASID allocator initialised with 65536 entries machine # [ 0.021303] Serial: AMBA PL011 UART driver machine # [ 0.027204] 9000000.pl011: ttyAMA0 at MMIO 0x9000000 (irq = 13, base_baud = 0) is a PL011 rev1 machine # [ 0.027393] printk: console [ttyAMA0] enabled machine # [ 0.158873] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages machine # [ 0.158886] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page machine # [ 0.158889] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages machine # [ 0.158892] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page machine # [ 0.158894] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages machine # [ 0.158897] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page machine # [ 0.158900] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages machine # [ 0.158902] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page machine # [ 0.160233] fbcon: Taking over console machine # [ 0.160244] ACPI: Interpreter disabled. machine # [ 0.170296] iommu: Default domain type: Translated machine # [ 0.170302] iommu: DMA domain TLB invalidation policy: strict mode machine # [ 0.170753] SCSI subsystem initialized machine # [ 0.173002] usbcore: registered new interface driver usbfs machine # [ 0.173035] usbcore: registered new interface driver hub machine # [ 0.173051] usbcore: registered new device driver usb machine # [ 0.173385] pps_core: LinuxPPS API ver. 1 registered machine # [ 0.173388] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti machine # [ 0.173397] PTP clock support registered machine # [ 0.173436] EDAC MC: Ver: 3.0.0 machine # [ 0.174854] scmi_core: SCMI protocol bus registered machine # [ 0.181009] FPGA manager framework machine # [ 0.183218] vgaarb: loaded machine # [ 0.184354] clocksource: Switched to clocksource arch_sys_counter machine # [ 0.192244] VFS: Disk quotas dquot_6.6.0 machine # [ 0.192278] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) machine # [ 0.196419] netfs: FS-Cache loaded machine # [ 0.196601] pnp: PnP ACPI: disabled machine # [ 0.200036] NET: Registered PF_INET protocol family machine # [ 0.200207] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear) machine # [ 0.232904] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear) machine # [ 0.232944] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) machine # [ 0.232968] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear) machine # [ 0.233014] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear) machine # [ 0.233087] TCP: Hash tables configured (established 8192 bind 8192) machine # [ 0.233171] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear) machine # [ 0.233227] UDP hash table entries: 512 (order: 3, 32768 bytes, linear) machine # [ 0.233281] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear) machine # [ 0.233376] NET: Registered PF_UNIX/PF_LOCAL protocol family machine # [ 0.233395] NET: Registered PF_XDP protocol family machine # [ 0.233410] PCI: CLS 0 bytes, default 64 machine # [ 0.233829] Trying to unpack rootfs image as initramfs... machine # [ 0.246654] kvm [1]: HYP mode not available machine # [ 0.369426] Initialise system trusted keyrings machine # [ 0.369569] workingset: timestamp_bits=42 max_order=18 bucket_order=0 machine # [ 0.369963] squashfs: version 4.0 (2009/01/31) Phillip Lougher machine # [ 0.370016] 9p: Installing v9fs 9p2000 file system support machine # [ 0.393101] Key type asymmetric registered machine # [ 0.393120] Asymmetric key parser 'x509' registered machine # [ 0.393198] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 242) machine # [ 0.393386] io scheduler mq-deadline registered machine # [ 0.393392] io scheduler kyber registered machine # [ 0.405963] pl061_gpio 9030000.pl061: PL061 GPIO chip registered machine # [ 0.409323] ledtrig-cpu: registered to indicate activity on CPUs machine # [ 0.409782] pci-host-generic 4010000000.pcie: host bridge /pcie@10000000 ranges: machine # [ 0.409798] pci-host-generic 4010000000.pcie: IO 0x003eff0000..0x003effffff -> 0x0000000000 machine # [ 0.409808] pci-host-generic 4010000000.pcie: MEM 0x0010000000..0x003efeffff -> 0x0010000000 machine # [ 0.409814] pci-host-generic 4010000000.pcie: MEM 0x8000000000..0xffffffffff -> 0x8000000000 machine # [ 0.409834] pci-host-generic 4010000000.pcie: Memory resource size exceeds max for 32 bits machine # [ 0.409859] pci-host-generic 4010000000.pcie: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff] machine # [ 0.409949] pci-host-generic 4010000000.pcie: PCI host bridge to bus 0000:00 machine # [ 0.409956] pci_bus 0000:00: root bus resource [bus 00-ff] machine # [ 0.409960] pci_bus 0000:00: root bus resource [io 0x0000-0xffff] machine # [ 0.409964] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff] machine # [ 0.409967] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff] machine # [ 0.410020] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint machine # [ 0.410475] pci 0000:00:01.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint machine # [ 0.410671] pci 0000:00:01.0: BAR 0 [io 0x0000-0x001f] machine # [ 0.410683] pci 0000:00:01.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.410709] pci 0000:00:01.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.410721] pci 0000:00:01.0: ROM [mem 0x00000000-0x0003ffff pref] machine # [ 0.411215] pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint machine # [ 0.411403] pci 0000:00:02.0: BAR 0 [io 0x0000-0x001f] machine # [ 0.411414] pci 0000:00:02.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.411440] pci 0000:00:02.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.411908] pci 0000:00:03.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint machine # [ 0.412099] pci 0000:00:03.0: BAR 0 [io 0x0000-0x007f] machine # [ 0.412110] pci 0000:00:03.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.412136] pci 0000:00:03.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.444853] pci 0000:00:04.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint machine # [ 0.445073] pci 0000:00:04.0: BAR 0 [io 0x0000-0x001f] machine # [ 0.445086] pci 0000:00:04.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.445114] pci 0000:00:04.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.445126] pci 0000:00:04.0: ROM [mem 0x00000000-0x0003ffff pref] machine # [ 0.445627] pci 0000:00:05.0: [1af4:1050] type 00 class 0x038000 conventional PCI endpoint machine # [ 0.445826] pci 0000:00:05.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.445853] pci 0000:00:05.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.446335] pci 0000:00:06.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint machine # [ 0.446525] pci 0000:00:06.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.446553] pci 0000:00:06.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.446966] pci 0000:00:07.0: [8086:24cd] type 00 class 0x0c0320 conventional PCI endpoint machine # [ 0.447151] pci 0000:00:07.0: BAR 0 [mem 0x00000000-0x00000fff] machine # [ 0.447451] pci 0000:00:08.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint machine # [ 0.447641] pci 0000:00:08.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.447667] pci 0000:00:08.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.448137] pci 0000:00:09.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint machine # [ 0.448325] pci 0000:00:09.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.448351] pci 0000:00:09.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.466259] pci 0000:00:0a.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint machine # [ 0.466453] pci 0000:00:0a.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.466483] pci 0000:00:0a.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.466977] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint machine # [ 0.467264] pci 0000:00:0b.0: BAR 0 [io 0x0000-0x003f] machine # [ 0.467276] pci 0000:00:0b.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.467306] pci 0000:00:0b.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.467802] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint machine # [ 0.467998] pci 0000:00:0c.0: BAR 0 [io 0x0000-0x001f] machine # [ 0.468010] pci 0000:00:0c.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.468036] pci 0000:00:0c.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.484876] pci 0000:00:01.0: ROM [mem 0x10000000-0x1003ffff pref]: assigned machine # [ 0.484893] pci 0000:00:04.0: ROM [mem 0x10040000-0x1007ffff pref]: assigned machine # [ 0.484897] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned machine # [ 0.484953] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]: assigned machine # [ 0.485000] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]: assigned machine # [ 0.485053] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]: assigned machine # [ 0.485097] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]: assigned machine # [ 0.485142] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]: assigned machine # [ 0.485187] pci 0000:00:08.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]: assigned machine # [ 0.485236] pci 0000:00:09.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]: assigned machine # [ 0.485287] pci 0000:00:0a.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]: assigned machine # [ 0.485333] pci 0000:00:0b.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]: assigned machine # [ 0.485454] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]: assigned machine # [ 0.485498] pci 0000:00:01.0: BAR 1 [mem 0x10080000-0x10080fff]: assigned machine # [ 0.485516] pci 0000:00:02.0: BAR 1 [mem 0x10081000-0x10081fff]: assigned machine # [ 0.485533] pci 0000:00:03.0: BAR 1 [mem 0x10082000-0x10082fff]: assigned machine # [ 0.485551] pci 0000:00:04.0: BAR 1 [mem 0x10083000-0x10083fff]: assigned machine # [ 0.485568] pci 0000:00:05.0: BAR 1 [mem 0x10084000-0x10084fff]: assigned machine # [ 0.485586] pci 0000:00:06.0: BAR 1 [mem 0x10085000-0x10085fff]: assigned machine # [ 0.485604] pci 0000:00:07.0: BAR 0 [mem 0x10086000-0x10086fff]: assigned machine # [ 0.485623] pci 0000:00:08.0: BAR 1 [mem 0x10087000-0x10087fff]: assigned machine # [ 0.485641] pci 0000:00:09.0: BAR 1 [mem 0x10088000-0x10088fff]: assigned machine # [ 0.485659] pci 0000:00:0a.0: BAR 1 [mem 0x10089000-0x10089fff]: assigned machine # [ 0.485677] pci 0000:00:0b.0: BAR 1 [mem 0x1008a000-0x1008afff]: assigned machine # [ 0.485696] pci 0000:00:0c.0: BAR 1 [mem 0x1008b000-0x1008bfff]: assigned machine # [ 0.485714] pci 0000:00:03.0: BAR 0 [io 0x1000-0x107f]: assigned machine # [ 0.485731] pci 0000:00:0b.0: BAR 0 [io 0x1080-0x10bf]: assigned machine # [ 0.485748] pci 0000:00:01.0: BAR 0 [io 0x10c0-0x10df]: assigned machine # [ 0.485765] pci 0000:00:02.0: BAR 0 [io 0x10e0-0x10ff]: assigned machine # [ 0.485783] pci 0000:00:04.0: BAR 0 [io 0x1100-0x111f]: assigned machine # [ 0.485800] pci 0000:00:0c.0: BAR 0 [io 0x1120-0x113f]: assigned machine # [ 0.485823] pci_bus 0000:00: resource 4 [io 0x0000-0xffff] machine # [ 0.485828] pci_bus 0000:00: resource 5 [mem 0x10000000-0x3efeffff] machine # [ 0.485831] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff] machine # [ 0.486735] pci 0000:00:07.0: enabling device (0000 -> 0002) machine # [ 0.540324] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003) machine # [ 0.551001] virtio-pci 0000:00:02.0: enabling device (0000 -> 0003) machine # [ 0.554250] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003) machine # [ 0.556242] virtio-pci 0000:00:04.0: enabling device (0000 -> 0003) machine # [ 0.565920] virtio-pci 0000:00:05.0: enabling device (0000 -> 0002) machine # [ 0.568182] virtio-pci 0000:00:06.0: enabling device (0000 -> 0002) machine # [ 0.577932] virtio-pci 0000:00:08.0: enabling device (0000 -> 0002) machine # [ 0.579934] virtio-pci 0000:00:09.0: enabling device (0000 -> 0002) machine # [ 0.590348] virtio-pci 0000:00:0a.0: enabling device (0000 -> 0002) machine # [ 0.593422] virtio-pci 0000:00:0b.0: enabling device (0000 -> 0003) machine # [ 0.595818] virtio-pci 0000:00:0c.0: enabling device (0000 -> 0003) machine # [ 0.617493] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled machine # [ 0.619528] msm_serial: driver initialized machine # [ 0.619666] SuperH (H)SCI(F) driver initialized machine # [ 0.619723] STM32 USART driver initialized machine # [ 0.656174] loop: module loaded machine # [ 0.656997] virtio_blk virtio2: 1/0/0 default/read/poll queues machine # [ 0.657871] virtio_blk virtio2: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) machine # [ 0.663049] megasas: 07.734.00.00-rc1 machine # [ 0.663875] physmap-flash 0.flash: physmap platform flash device: [mem 0x00000000-0x03ffffff] machine # [ 0.673759] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000 machine # [ 0.673785] Intel/Sharp Extended Query Table at 0x0031 machine # [ 0.676317] Using buffer write method machine # [ 0.678808] physmap-flash 0.flash: physmap platform flash device: [mem 0x04000000-0x07ffffff] machine # [ 0.688395] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000 machine # [ 0.688441] Intel/Sharp Extended Query Table at 0x0031 machine # [ 0.690507] Using buffer write method machine # [ 0.690527] Concatenating MTD devices: machine # [ 0.690530] (0): "0.flash" machine # [ 0.690533] (1): "0.flash" machine # [ 0.690535] into device "0.flash" machine # [ 1.032836] Freeing initrd memory: 27148K machine # [ 1.038827] tun: Universal TUN/TAP device driver, 1.6 machine # [ 1.043473] thunder_xcv, ver 1.0 machine # [ 1.043506] thunder_bgx, ver 1.0 machine # [ 1.043530] nicpf, ver 1.0 machine # [ 1.044102] e1000: Intel(R) PRO/1000 Network Driver machine # [ 1.044107] e1000: Copyright (c) 1999-2006 Intel Corporation. machine # [ 1.044135] e1000e: Intel(R) PRO/1000 Network Driver machine # [ 1.044144] e1000e: Copyright(c) 1999 - 2015 Intel Corporation. machine # [ 1.044172] igb: Intel(R) Gigabit Ethernet Network Driver machine # [ 1.044177] igb: Copyright (c) 2007-2014 Intel Corporation. machine # [ 1.044198] igbvf: Intel(R) Gigabit Virtual Function Network Driver machine # [ 1.044202] igbvf: Copyright (c) 2009 - 2012 Intel Corporation. machine # [ 1.044338] sky2: driver version 1.30 machine # [ 1.053829] usbcore: registered new interface driver usb-storage machine # [ 1.053959] usbcore: registered new interface driver usbserial_generic machine # [ 1.053971] usbserial: USB Serial support registered for generic machine # [ 1.054585] hv_vmbus: registering driver hyperv_keyboard machine # [ 1.055945] ehci-pci 0000:00:07.0: EHCI Host Controller machine # [ 1.055965] ehci-pci 0000:00:07.0: new USB bus registered, assigned bus number 1 machine # [ 1.056150] ehci-pci 0000:00:07.0: irq 16, io mem 0x10086000 machine # [ 1.062376] rtc-pl031 9010000.pl031: registered as rtc0 machine # [ 1.062411] rtc-pl031 9010000.pl031: setting system clock to 2026-10-18T02:43:28 UTC (1792291408) machine # [ 1.062851] i2c_dev: i2c /dev entries driver machine # [ 1.066350] sdhci: Secure Digital Host Controller Interface driver machine # [ 1.066358] sdhci: Copyright(c) Pierre Ossman machine # [ 1.066647] Synopsys Designware Multimedia Card Interface Driver machine # [ 1.067038] sdhci-pltfm: SDHCI platform and OF driver helper machine # [ 1.068442] ehci-pci 0000:00:07.0: USB 2.0 started, EHCI 1.00 machine # [ 1.068796] hub 1-0:1.0: USB hub found machine # [ 1.068812] hub 1-0:1.0: 6 ports detected machine # [ 1.076662] hid: raw HID events driver (C) Jiri Kosina machine # [ 1.076922] usbcore: registered new interface driver usbhid machine # [ 1.076926] usbhid: USB HID core driver machine # [ 1.078132] hw perfevents: enabled with armv8_pmuv3 PMU driver, 11 (0,800003ff) counters available machine # [ 1.079715] drop_monitor: Initializing network drop monitor service machine # [ 1.079914] NET: Registered PF_INET6 protocol family machine # [ 1.085201] Segment Routing with IPv6 machine # [ 1.085215] In-situ OAM (IOAM) with IPv6 machine # [ 1.085243] NET: Registered PF_PACKET protocol family machine # [ 1.085320] 9pnet: Installing 9P2000 support machine # [ 1.085401] Key type dns_resolver registered machine # [ 1.094553] registered taskstats version 1 machine # [ 1.094724] Loading compiled-in X.509 certificates machine # [ 1.103676] Demotion targets for Node 0: null machine # [ 1.103803] Key type .fscrypt registered machine # [ 1.103807] Key type fscrypt-provisioning registered machine # [ 1.103918] ima: No TPM chip found, activating TPM-bypass! machine # [ 1.103935] ima: Allocated hash algorithm: sha1 machine # [ 1.103957] ima: No architecture policies found machine # [ 1.108566] input: gpio-keys as /devices/platform/gpio-keys/input/input0 machine # [ 1.128806] clk: Disabling unused clocks machine # [ 1.128826] PM: genpd: Disabling unused power domains machine # [ 1.131798] Freeing unused kernel memory: 4736K machine # [ 1.132014] Run /init as init process machine # [ 1.153674] fuse: init (API version 7.45) machine # [ 1.157407] virtiofs virtio6: discovered new tag: nix-store machine # [ 1.158246] virtiofs virtio6: virtio_fs_setup_dax: No cache capability machine # [ 1.174302] virtiofs virtio7: discovered new tag: shared machine # [ 1.175104] virtiofs virtio7: virtio_fs_setup_dax: No cache capability machine # [ 1.178155] virtiofs virtio8: discovered new tag: xchg machine # [ 1.178898] virtiofs virtio8: virtio_fs_setup_dax: No cache capability machine # [ 1.191388] systemd[1]: Successfully made /usr/ read-only. machine # [ 1.191916] systemd[1]: systemd 263-409be20 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE +EXPERIMENTAL-ENVVAR) machine # [ 1.191930] systemd[1]: Detected virtualization qemu. machine # [ 1.191950] systemd[1]: Detected architecture arm64. machine # [ 1.191956] systemd[1]: Running in initrd. machine # [ 1.192240] systemd[1]: Initializing machine ID from random generator. machine # [ 1.192348] systemd[1]: Hostname set to . machine # [ 1.294894] systemd[1]: bpf-restrict-fs: LSM BPF program attached machine # [ 1.320722] usb 1-1: new high-speed USB device number 2 using ehci-pci machine # [ 1.358099] systemd[1]: Queued start job for default target Initrd Default Target. machine # [ 1.366791] systemd[1]: Created slice Slice /system/modprobe. machine # [ 1.367012] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. machine # [ 1.367042] systemd[1]: Expecting device /dev/disk/by-label/nixos... machine # [ 1.367064] systemd[1]: Reached target Path Units. machine # [ 1.367079] systemd[1]: Reached target Slice Units. machine # [ 1.367095] systemd[1]: Reached target Swaps. machine # [ 1.367109] systemd[1]: Reached target Timer Units. machine # [ 1.367266] systemd[1]: Listening on D-Bus System Message Bus Socket. machine # [ 1.367427] systemd[1]: Listening on Journal Socket (/dev/log). machine # [ 1.367580] systemd[1]: Listening on Journal Sockets. machine # [ 1.367655] systemd[1]: Listening on udev Kernel Socket. machine # [ 1.367669] systemd[1]: Reached target Socket Units. machine # [ 1.378331] systemd[1]: Starting Create List of Static Device Nodes... machine # [ 1.378413] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs machine # [ 1.388684] systemd[1]: Mounting Kernel Configuration File System... machine # [ 1.398355] systemd[1]: Starting Journal Service... machine # [ 1.412930] systemd[1]: Starting Load Kernel Modules... machine # [ 1.413075] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 1.445036] systemd[1]: Starting Coldplug All udev Devices... machine # [ 1.451389] systemd-journald[71]: Collecting audit messages is disabled. machine # [ 1.465649] systemd[1]: Finished Create List of Static Device Nodes. machine # [ 1.481458] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... machine # [ 1.487455] input: QEMU QEMU USB Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:07.0/usb1/1-1/1-1:1.0/0003:0627:0001.0001/input/input1 machine # [ 1.488176] systemd[1]: Mounted Kernel Configuration File System. machine # [ 1.535768] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. machine # [ 1.552706] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev machine # [ 1.554669] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. machine # [ 1.566029] [drm] pci: virtio-gpu-pci detected at 0000:00:05.0 machine # [ 1.566282] [drm] features: -virgl +edid -resource_blob -host_visible machine # [ 1.566285] [drm] features: -context_init machine # [ 1.567126] [drm] number of scanouts: 1 machine # [ 1.567139] [drm] number of cap sets: 0 machine # [ 1.567654] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v1.11 Keyboard [QEMU QEMU USB Keyboard] on usb-0000:00:07.0-1/input0 machine # [ 1.572933] systemd[1]: Starting Create Static Device Nodes in /dev... machine # [ 1.593060] virtio-pci 0000:00:05.0: [drm] Registered 1 planes with drm panic machine # [ 1.593078] [drm] Initialized virtio_gpu 0.1.0 for 0000:00:05.0 on minor 0 machine # [ 1.628954] Console: switching to colour frame buffer device 160x50 machine # [ 1.622762] systemd-modules-load[73]: Inserted module 'dm_mod' machine # [ 1.642457] systemd[1]: Started Journal Service. machine # [ 1.647763] virtio-pci 0000:00:05.0: [drm] fb0: virtio_gpudrmfb frame buffer device machine # [ 1.636615] systemd-modules-load[73]: Module 'virtio_balloon' is built in machine # [ 1.641061] systemd-modules-load[73]: Module 'virtio_console' is built in machine # [ 1.645226] systemd[1]: Finished Create Static Device Nodes in /dev. machine # [ 1.656632] systemd[1]: Reached target Preparation for Local File Systems. machine # [ 1.657977] systemd[1]: Reached target Local File Systems. machine # [ 1.658916] systemd[1]: Starting Create System Files and Directories... machine # [ 1.660483] systemd-modules-load[73]: Inserted module 'virtio_gpu' machine # [ 1.684447] usb 1-2: new high-speed USB device number 3 using ehci-pci machine # [ 1.669434] systemd-modules-load[73]: Module 'virtio_rng' is built in machine # [ 1.671653] systemd[1]: Starting Rule-based Manager for Device Events and Files... machine # [ 1.676985] systemd[1]: Finished Load Kernel Modules. machine # [ 1.696950] systemd[1]: Starting Apply Kernel Variables... machine # [ 1.729451] systemd[1]: Finished Create System Files and Directories. machine # [ 1.757961] systemd[1]: Finished Apply Kernel Variables. machine # [ 1.775398] systemd-udevd[79]: Using default interface naming scheme 'v261'. machine # [ 1.805835] systemd[1]: Started Rule-based Manager for Device Events and Files. machine # [ 1.831950] input: QEMU QEMU USB Tablet as /devices/platform/4010000000.pcie/pci0000:00/0000:00:07.0/usb1/1-2/1-2:1.0/0003:0627:0001.0002/input/input2 machine # [ 1.832213] hid-generic 0003:0627:0001.0002: input,hidraw1: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:07.0-2/input0 machine # [ 1.929773] systemd[1]: Starting Virtual Console Setup... machine # [ 2.022569] systemd-vconsole-setup[97]: Configuration of first virtual console was skipped, ignoring remaining ones. machine # [ 2.028422] systemd[1]: Finished Virtual Console Setup. machine # [ 2.714537] systemd[1]: Found device /dev/disk/by-label/nixos. machine # [ 2.728337] systemd[1]: Reached target Initrd Root Device. machine # [ 2.729239] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos... machine # [ 2.736525] systemd[1]: Finished Coldplug All udev Devices. machine # [ 2.741664] systemd[1]: Reached target System Initialization. machine # [ 2.749213] systemd[1]: Reached target Basic System. machine # [ 2.754457] (udev-worker)[93]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. machine # [ 2.764455] (udev-worker)[93]: Network interface NamePolicy= disabled on kernel command line. machine # [ 2.784810] systemd-fsck[110]: nixos: clean, 12/65536 files, 13019/262144 blocks machine # [ 2.792692] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos. machine # [ 2.795624] systemd[1]: Mounting /sysroot... machine # [ 2.856166] EXT4-fs (vda): mounted filesystem 224d0568-8d9f-44c3-bdae-47c506d0637a r/w with ordered data mode. Quota mode: none. machine # [ 2.843149] systemd[1]: Mounted /sysroot. machine # [ 2.845112] systemd[1]: Reached target Initrd Root File System. machine # [ 2.849793] systemd[1]: Starting Mountpoints Configured in the Real Root... machine # [ 2.876239] systemd-sysroot-fstab-check[118]: /sysroot should be mounted in the initrd, will request daemon-reload. machine # [ 2.882391] systemd[1]: Reload requested from client PID 118 ('systemd-sysroot') (unit initrd-parse-etc.service)... machine # [ 2.887883] systemd[1]: Reloading... machine # [ 3.077625] systemd[1]: Reloading finished in 189 ms. machine # [ 3.114575] systemd-sysroot-fstab-check[118]: Requesting initrd-fs.target/start/replace... machine # [ 3.120006] systemd-sysroot-fstab-check[118]: Requesting swap.target/start/replace... machine # [ 3.129050] systemd[1]: initrd-parse-etc.service: Deactivated successfully. machine # [ 3.132678] systemd[1]: Finished Mountpoints Configured in the Real Root. machine # [ 3.134256] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies. machine # [ 3.431784] systemd[1]: Mounting /sysroot/nix/.ro-store... machine # [ 3.443974] systemd[1]: Mounting /sysroot/nix/.rw-store... machine # [ 3.456998] systemd[1]: Mounting /sysroot/run... machine # [ 3.470184] systemd[1]: Mounting /sysroot/tmp/shared... machine # [ 3.525874] systemd[1]: Mounting /sysroot/tmp/xchg... machine # [ 3.541803] systemd[1]: Mounted /sysroot/nix/.ro-store. machine # [ 3.550308] systemd[1]: Mounted /sysroot/nix/.rw-store. machine # [ 3.556805] systemd[1]: Mounted /sysroot/run. machine # [ 3.570579] systemd[1]: Mounted /sysroot/tmp/shared. machine # [ 3.584923] systemd[1]: Starting rw-sysroot-nix-store.service... machine # [ 3.591942] systemd[1]: Mounted /sysroot/tmp/xchg. machine # [ 3.624134] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. machine # [ 3.626008] systemd[1]: Finished rw-sysroot-nix-store.service. machine # [ 4.038759] (udev-worker)[91]: mtd0ro: Failed to find and pin callout binary "/nix/store/126w02q3bp3kh7554k53zak86km11gnz-systemd-263-409be20/lib/udev/mtd_probe": No such file or directory machine # [ 4.045271] (udev-worker)[91]: mtd0ro: /etc/udev/rules.d/75-probe_mtd.rules:5 IMPORT{program}="mtd_probe $devnode": Failed to execute "mtd_probe /dev/mtd0ro", ignoring: No such file or directory machine # [ 4.071041] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. machine # [ 4.078560] systemd[1]: Stopped Virtual Console Setup. machine # [ 4.079415] systemd[1]: Stopping Virtual Console Setup... machine # [ 4.080415] systemd[1]: Starting Virtual Console Setup... machine # [ 4.094503] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. machine # [ 4.100272] systemd[1]: Stopped Virtual Console Setup. machine # [ 4.101131] systemd[1]: Starting Virtual Console Setup... machine # [ 4.120738] systemd-vconsole-setup[151]: Configuration of first virtual console was skipped, ignoring remaining ones. machine # [ 4.124696] systemd[1]: Finished Virtual Console Setup. machine # [ 4.430743] systemd[1]: Mounting /sysroot/nix/store... machine # [ 4.476219] systemd[1]: Mounted /sysroot/nix/store. machine # [ 4.479035] systemd[1]: Reached target Initrd File Systems. machine # [ 4.482427] systemd[1]: Starting Find NixOS closure... machine # [ 4.492517] systemd[1]: Starting Create Volatile Files and Directories in the Real Root... machine # [ 4.536207] systemd[1]: Finished Create Volatile Files and Directories in the Real Root. machine # [ 4.539285] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully. machine # [ 4.548512] systemd[1]: Finished Find NixOS closure. machine # [ 4.550349] systemd[1]: Reached target Initrd Default Target. machine # [ 4.553485] systemd[1]: Starting Cleaning Up and Shutting Down Daemons... machine # [ 4.578671] systemd[1]: Stopped target Initrd Default Target. machine # [ 4.580497] systemd[1]: Stopped target Basic System. machine # [ 4.584539] systemd[1]: Stopped target Initrd Root Device. machine # [ 4.585563] systemd[1]: Stopped target Path Units. machine # [ 4.586409] systemd[1]: systemd-ask-password-console.path: Deactivated successfully. machine # [ 4.588888] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch. machine # [ 4.595193] systemd[1]: Stopped target Slice Units. machine # [ 4.600397] systemd[1]: Stopped target Socket Units. machine # [ 4.602226] systemd[1]: Stopped target System Initialization. machine # [ 4.605203] systemd[1]: Stopped target Swaps. machine # [ 4.606462] systemd[1]: Stopped target Timer Units. machine # [ 4.608368] systemd[1]: dbus.socket: Deactivated successfully. machine # [ 4.614306] systemd[1]: Closed D-Bus System Message Bus Socket. machine # [ 4.615354] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully. machine # [ 4.618672] systemd[1]: Stopped Find NixOS closure. machine # [ 4.619583] systemd[1]: Starting rw-sysroot-nix-store.service... machine # [ 4.621575] systemd[1]: systemd-sysctl.service: Deactivated successfully. machine # [ 4.622572] systemd[1]: Stopped Apply Kernel Variables. machine # [ 4.623366] systemd[1]: systemd-modules-load.service: Deactivated successfully. machine # [ 4.629844] systemd[1]: Stopped Load Kernel Modules. machine # [ 4.631615] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully. machine # [ 4.636522] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root. machine # [ 4.639986] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. machine # [ 4.643260] systemd[1]: Stopped Create System Files and Directories. machine # [ 4.648332] systemd[1]: Stopped target Local File Systems. machine # [ 4.649165] systemd[1]: Stopped target Preparation for Local File Systems. machine # [ 4.650129] systemd[1]: systemd-udev-trigger.service: Deactivated successfully. machine # [ 4.651152] systemd[1]: Stopped Coldplug All udev Devices. machine # [ 4.651939] systemd[1]: Stopping Rule-based Manager for Device Events and Files... machine # [ 4.655189] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. machine # [ 4.656538] systemd[1]: Stopped Virtual Console Setup. machine # [ 4.657308] systemd[1]: systemd-udevd.service: Deactivated successfully. machine # [ 4.658260] systemd[1]: Stopped Rule-based Manager for Device Events and Files. machine # [ 4.659281] systemd[1]: systemd-udevd.service: Consumed 1.369s CPU time over 2.974s wall clock time, 34M memory peak. machine # [ 4.660888] systemd[1]: initrd-cleanup.service: Deactivated successfully. machine # [ 4.661860] systemd[1]: Finished Cleaning Up and Shutting Down Daemons. machine # [ 4.662812] systemd[1]: Starting Cleanup udev Database... machine # [ 4.663606] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. machine # [ 4.669513] systemd[1]: Stopped Create Static Device Nodes in /dev. machine # [ 4.670486] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. machine # [ 4.671789] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully. machine # [ 4.676388] systemd[1]: kmod-static-nodes.service: Deactivated successfully. machine # [ 4.680234] systemd[1]: Stopped Create List of Static Device Nodes. machine # [ 4.681235] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. machine # [ 4.684262] systemd[1]: Finished rw-sysroot-nix-store.service. machine # [ 4.715383] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. machine # [ 4.718866] systemd[1]: Finished Cleanup udev Database. machine # [ 4.724299] systemd[1]: Reached target Switch Root. machine # [ 4.725128] systemd[1]: Starting NixOS Activation... machine # [ 4.813668] initrd-nixos-activation-start[175]: booting system configuration /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test machine # [ 4.847712] initrd-nixos-activation-start[175]: running activation script... machine # [ 5.080782] initrd-nixos-activation-start[198]: setting up /etc... machine # [ 5.204834] systemd[1]: initrd-nixos-activation.service: Deactivated successfully. machine # [ 5.207769] systemd[1]: Finished NixOS Activation. machine # [ 5.212363] systemd[1]: Starting Switch Root... machine # [ 5.228896] systemd[1]: Switching root. machine # [ 5.405794] systemd-journald[71]: Received SIGTERM from PID 1 (systemd). machine # [ 5.502503] NET: Registered PF_VSOCK protocol family machine # [ 5.580035] systemd[1]: systemd 263-409be20 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE +EXPERIMENTAL-ENVVAR) machine # [ 5.588667] systemd[1]: Detected virtualization qemu. machine # [ 5.588727] systemd[1]: Detected architecture arm64. machine # [ 5.588831] systemd[1]: Detected first boot. machine # [ 5.590501] systemd[1]: Initializing machine ID from random generator. machine # [ 5.708592] systemd[1]: bpf-restrict-fs: LSM BPF program attached machine # [ 5.865279] systemd[1]: Applying preset policy. machine # [ 6.078520] systemd[1]: Populated /etc with preset unit settings. machine # [ 6.278668] systemd[1]: initrd-switch-root.service: Deactivated successfully. machine # [ 6.279103] systemd[1]: Stopped initrd-switch-root.service. machine # [ 6.284159] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. machine # [ 6.287341] systemd[1]: Created slice Slice /system/getty. machine # [ 6.288302] systemd[1]: Created slice User and Session Slice. machine # [ 6.290974] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. machine # [ 6.291074] systemd[1]: Started Forward Password Requests to Wall Directory Watch. machine # [ 6.291458] systemd[1]: Expecting device /dev/hvc0... machine # [ 6.291734] systemd[1]: Expecting device /dev/ttyAMA0... machine # [ 6.292013] systemd[1]: Reached target Local Encrypted Volumes. machine # [ 6.292292] systemd[1]: Stopped target initrd-fs.target. machine # [ 6.298621] systemd[1]: Stopped target initrd-root-fs.target. machine # [ 6.299055] systemd[1]: Stopped target initrd-switch-root.target. machine # [ 6.299776] systemd[1]: Reached target Virtual Machines and Containers. machine # [ 6.303495] systemd[1]: Reached target Path Units. machine # [ 6.303899] systemd[1]: Reached target Remote File Systems. machine # [ 6.306665] systemd[1]: Reached target Slice Units. machine # [ 6.307063] systemd[1]: Reached target Swaps. machine # [ 6.310532] systemd[1]: Listening on Query the User Interactively for a Password. machine # [ 6.313611] systemd[1]: Listening on Process Core Dump Socket. machine # [ 6.315008] systemd[1]: Listening on Credential Encryption/Decryption. machine # [ 6.316259] systemd[1]: Listening on Factory Reset Management. machine # [ 6.319349] systemd[1]: Listening on Hostname Service Socket. machine # [ 6.323973] systemd[1]: Starting Journal Log Access Socket... machine # [ 6.327956] systemd[1]: Listening on Journal Audit Socket. machine # [ 6.331495] systemd[1]: Listening on Console Output Muting Service Socket. machine # [ 6.332205] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket. machine # [ 6.334756] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 6.336041] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 6.344051] systemd[1]: Listening on Disk Repartitioning Service Socket. machine # [ 6.345744] systemd[1]: Listening on udev Varlink Socket. machine # [ 6.349288] systemd[1]: Mounting Huge Pages File System... machine # [ 6.354570] systemd[1]: Mounting POSIX Message Queue File System... machine # [ 6.366230] systemd[1]: Mounting Kernel Debug File System... machine # [ 6.374087] systemd[1]: Mounting Kernel Trace File System... machine # [ 6.391539] systemd[1]: Starting Create List of Static Device Nodes... machine # [ 6.392105] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs machine # [ 6.412549] systemd[1]: Mounting Kernel Configuration File System... machine # [ 6.413111] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm machine # [ 6.415078] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 6.415929] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse machine # [ 6.438440] systemd[1]: Mounting FUSE Control File System... machine # [ 6.438940] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 6.477109] systemd[1]: Starting Journal Service... machine # [ 6.502878] systemd[1]: Starting Load Kernel Modules... machine # [ 6.540721] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer... machine # [ 6.563475] systemd[1]: Starting Remount Root and Kernel File Systems... machine # [ 6.563882] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 6.574780] systemd-journald[269]: Collecting audit messages is enabled. machine # [ 6.569265] systemd[1]: Queued start job for default target Multi-User System. machine # [ 6.570735] systemd[1]: Unnecessary job was removed for /sys/devices/platform/9000000.pl011/9000000.pl011:0/9000000.pl011:0.0/tty/ttyAMA0. machine # [ 6.574200] systemd[1]: Unnecessary job was removed for /sys/devices/virtual/tty/hvc0. machine # [ 6.575528] systemd[1]: systemd-journald.service: Deactivated successfully. machine # [ 6.597261] systemd[1]: Starting Coldplug All udev Devices... machine # [ 6.600092] systemd[1]: Started Journal Service. machine # [ 6.586708] systemd-modules-load[270]: Module 'atkbd' is built in machine # [ 6.590168] systemd-modules-load[270]: Module 'loop' is built in machine # [ 6.612343] systemd[1]: Listening on Journal Log Access Socket. machine # [ 6.621508] systemd[1]: Mounted Huge Pages File System. machine # [ 6.628076] systemd[1]: Mounted POSIX Message Queue File System. machine # [ 6.629228] systemd[1]: Mounted Kernel Debug File System. machine # [ 6.630031] systemd[1]: Mounted Kernel Trace File System. machine # [ 6.634585] systemd[1]: Finished Create List of Static Device Nodes. machine # [ 6.643995] systemd[1]: Finished Load Kernel Modules. machine # [ 6.660415] systemd[1]: Mounted Kernel Configuration File System. machine # [ 6.677432] systemd[1]: Starting Firewall... machine # [ 6.691128] systemd[1]: Starting Apply Kernel Variables... machine # [ 6.693528] systemd-oomd[271]: No swap; memory pressure usage will be degraded machine # [ 6.698781] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... machine # [ 6.724627] EXT4-fs (vda): re-mounted 224d0568-8d9f-44c3-bdae-47c506d0637a. machine # [ 6.709404] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer. machine # [ 6.735187] systemd[1]: Finished Remount Root and Kernel File Systems. machine # [ 6.750886] systemd[1]: Mounted FUSE Control File System. machine # [ 6.768296] systemd[1]: Listening on Disk Image Download Service Socket. machine # [ 6.783393] systemd[1]: Starting Flush Journal to Persistent Storage... machine # [ 6.786711] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 6.800948] systemd[1]: Starting Load/Save OS Random Seed... machine # [ 6.801871] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 6.922409] systemd-journald[269]: Received client request to flush runtime journal. machine # [ 6.990294] systemd[1]: Finished Apply Kernel Variables. machine # [ 6.991504] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. machine # [ 7.008526] systemd[1]: Starting Create Static Device Nodes in /dev... machine # [ 7.009563] systemd[1]: Finished Load/Save OS Random Seed. machine # [ 7.010469] systemd[1]: Reached target First Boot Complete. machine # [ 7.011337] systemd[1]: Finished Flush Journal to Persistent Storage. machine # [ 7.137434] systemd[1]: Finished Create Static Device Nodes in /dev. machine # [ 7.140144] systemd[1]: Reached target Preparation for Local File Systems. machine # [ 7.143110] systemd[1]: Starting Rule-based Manager for Device Events and Files... machine # [ 7.268459] systemd[1]: Mounting /run/wrappers... machine # [ 7.295733] systemd-udevd[307]: Using default interface naming scheme 'v261'. machine # [ 7.350053] systemd[1]: Mounted /run/wrappers. machine # [ 7.350929] systemd[1]: Reached target Local File Systems. machine # [ 7.358974] systemd[1]: Listening on Boot Loader Control Service Socket. machine # [ 7.366414] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 7.367439] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 7.380338] systemd[1]: Starting Save Transient machine-id to Disk... machine # [ 7.396776] systemd[1]: Starting Create System Files and Directories... machine # [ 7.525666] systemd[1]: Started Rule-based Manager for Device Events and Files. machine # [ 7.632347] systemd[1]: Finished Create System Files and Directories. machine # [ 7.642332] systemd[1]: Starting Rebuild Journal Catalog... machine # [ 7.654945] systemd[1]: Starting Record System Boot/Shutdown in UTMP... machine # [ 7.789477] systemd[1]: Finished Record System Boot/Shutdown in UTMP. machine # [ 7.808980] systemd[1]: Finished Rebuild Journal Catalog. machine # [ 7.818827] systemd[1]: Starting Update is Completed... machine # [ 7.884259] systemd[1]: Finished Update is Completed. machine # [ 8.074972] systemd[1]: etc-machine\x2did.mount: Deactivated successfully. machine # [ 8.087626] systemd[1]: Finished Save Transient machine-id to Disk. machine # [ 8.108221] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs machine # [ 8.165044] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse machine # [ 8.303078] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 8.309044] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 8.440844] systemd[1]: Condition check resulted in /dev/hvc0 being skipped. machine # [ 8.480291] systemd[1]: Finished Coldplug All udev Devices. machine # [ 8.482981] systemd[1]: Reached target System Initialization. machine # [ 8.483994] systemd[1]: Started Discard unused filesystem blocks once a week. machine # [ 8.491611] systemd[1]: Started Daily Cleanup of Temporary Directories. machine # [ 8.496653] systemd[1]: Reached target Timer Units. machine # [ 8.497497] systemd[1]: Listening on D-Bus System Message Bus Socket. machine # [ 8.498468] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket. machine # [ 8.499743] systemd[1]: Reached target Socket Units. machine # [ 8.512244] systemd[1]: Reached target Basic System. machine # [ 8.513091] systemd[1]: Starting Import lastlog data into lastlog2 database... machine # [ 8.514185] systemd[1]: Starting Name Service Cache Daemon (nsncd)... machine # [ 8.515145] systemd[1]: Starting Post-Boot Actions... machine # [ 8.557445] systemd[1]: Started Reset console on configuration changes. machine # [ 8.593778] systemd[1]: Starting resolvconf update... machine # [ 8.602952] systemd[1]: Condition check resulted in /dev/ttyAMA0 being skipped. machine # [ 8.645428] systemd[1]: Started backdoor.service. machine # [ 8.701934] systemd[1]: Starting D-Bus System Message Bus... machine # [ 8.710351] nsncd[429]: Oct 18 02:43:36.163 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" machine # [ 8.736489] systemd[1]: Started Name Service Cache Daemon (nsncd). machine # [ 8.751980] systemd[1]: Finished Post-Boot Actions. machine # [ 8.767821] systemd[1]: Reached target Host and Network Name Lookups. machine # [ 8.776860] systemd[1]: Reached target User and Group Name Lookups. machine # [ 8.835503] systemd[1]: Starting User Login Management... machine # [ 8.849755] (udev-worker)[338]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. machine # [ 8.868804] (udev-worker)[338]: Network interface NamePolicy= disabled on kernel command line. machine # connecting to host... machine: Guest shell says: b'Spawning backdoor root shell...\n' machine: connected to guest root shell machine # [ 8.959493] dbus-broker-launch[440]: Looking up NSS user entry for 'systemd-timesync'... machine: (connecting took 9.29 seconds) machine: (finished: waiting for the VM to finish booting, in 9.74 seconds) machine # [ 8.970654] dbus-broker-launch[440]: NSS returned no entry for 'systemd-timesync' machine # [ 8.971849] dbus-broker-launch[440]: Invalid user-name in /nix/store/aw77bp4zfc97zizid5h923yc6ngjgsdp-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" machine # [ 8.995421] systemd[1]: Finished Import lastlog data into lastlog2 database. machine # [ 9.028481] systemd[1]: Started D-Bus System Message Bus. machine # [ 9.096748] dbus-broker-launch[440]: Ready machine # [ 9.151039] systemd-logind[457]: New seat seat0. machine # [ 9.232549] systemd[1]: Started User Login Management. machine # [ 9.262830] systemd[1]: Stopped target Host and Network Name Lookups. machine # [ 9.270511] systemd[1]: Stopping Host and Network Name Lookups... machine # [ 9.271555] systemd[1]: Stopped target User and Group Name Lookups. machine # [ 9.279689] systemd[1]: Stopping User and Group Name Lookups... machine # [ 9.287442] systemd[1]: Starting linger-users.service... machine # [ 9.293689] systemd[1]: Stopping Name Service Cache Daemon (nsncd)... machine # [ 9.294738] systemd[1]: nscd.service: Deactivated successfully. machine # [ 9.302529] systemd[1]: Stopped Name Service Cache Daemon (nsncd). machine # [ 9.389778] systemd[1]: Starting Name Service Cache Daemon (nsncd)... machine # [ 9.483814] systemd[1]: Created slice Slice /user/1001. machine # [ 9.507658] systemd[1]: Starting User Runtime Directory /run/user/1001... machine # [ 9.516773] systemd[1]: Started Name Service Cache Daemon (nsncd). machine # [ 9.518150] nsncd[547]: Oct 18 02:43:36.971 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" machine # [ 9.551086] systemd[1]: Reached target Host and Network Name Lookups. machine # [ 9.558927] systemd[1]: Reached target User and Group Name Lookups. machine # [ 9.567739] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 9.571729] systemd[1]: Finished linger-users.service. machine # [ 9.575954] systemd[1]: Finished resolvconf update. machine # [ 9.593179] systemd[1]: Condition check resulted in Virtio network device being skipped. machine # [ 9.594456] systemd[1]: Condition check resulted in Virtio network device being skipped. machine # [ 9.606087] systemd[1]: Starting DHCP Client... machine # [ 9.660957] systemd[1]: Finished User Runtime Directory /run/user/1001. machine # [ 9.694103] systemd[1]: Starting User Manager for UID 1001... machine # [ 9.729809] systemd[1]: Finished Firewall. machine # [ 9.730585] systemd[1]: Reached target Preparation for Network. machine # [ 9.763392] systemd-logind[457]: Watching system buttons on /dev/input/event0 (gpio-keys) machine # [ 9.792397] systemd[1]: Starting Address configuration of eth1... machine # [ 9.820485] systemd[1]: Starting Extra networking commands.... machine # [ 9.911136] mousedev: PS/2 mouse device common for all mice machine # [ 9.908530] (systemd)[589]: pam_unix(systemd-user:session): session opened for user usertest(uid=1001) by (uid=0) machine # [ 9.949504] systemd-logind[457]: New session '1' of user 'usertest' with class 'manager' and type 'unspecified'. machine # [ 10.024596] systemd-logind[457]: Watching system buttons on /dev/input/event1 (QEMU QEMU USB Keyboard) machine # [ 10.026339] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 10.308986] systemd[589]: Queued start job for default target Main User Target. machine # [ 10.310239] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 10.334335] systemd[589]: Created slice User Application Slice. machine # [ 10.335494] systemd[589]: Started Daily Cleanup of User's Temporary Directories. machine # [ 10.337209] systemd[589]: Reached target Paths. machine # [ 10.338035] systemd[589]: Reached target Timers. machine # [ 10.338774] systemd[589]: Starting D-Bus User Message Bus Socket... machine # [ 10.339723] systemd[589]: Starting Create User Files and Directories... machine # [ 10.401321] systemd[589]: Finished Create User Files and Directories. machine # [ 10.424712] systemd[589]: Listening on D-Bus User Message Bus Socket. machine # [ 10.425826] systemd[589]: Reached target Sockets. machine # [ 10.426571] systemd[589]: Reached target Basic System. machine # [ 10.427374] systemd[1]: Started User Manager for UID 1001. machine # [ 10.466065] systemd[589]: Starting Run user-specific NixOS activation... machine # [ 10.484387] systemd[589]: Finished Run user-specific NixOS activation. machine # [ 10.492917] systemd[589]: Reached target Main User Target. machine # [ 10.493896] systemd[589]: Startup finished in 494ms. machine # [ 10.510192] network-addresses-eth1-start[592]: adding address 192.168.1.1/24... done machine # [ 10.539184] network-addresses-eth1-start[592]: adding address 2001:db8:1::1/64... done machine # [ 10.621795] systemd[1]: Finished Address configuration of eth1. machine # [ 10.717463] dhcpcd[596]: dhcpcd-10.3.2 starting machine # [ 10.769404] dhcpcd[663]: dev: loaded udev machine # [ 10.822628] 8021q: 802.1Q VLAN Support v1.8 machine # [ 10.822991] 8021q: adding VLAN 0 to HW filter on device eth1 machine # [ 10.935777] cfg80211: Loading compiled-in X.509 certificates for regulatory database machine # [ 10.997479] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' machine # [ 10.997980] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600' machine # [ 11.000119] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -2 machine # [ 11.000625] cfg80211: failed to load regulatory.db machine # [ 11.296823] systemd[1]: Finished Extra networking commands.. machine # [ 11.297759] systemd[1]: Reached target Network. machine # [ 11.334506] systemd[1]: Starting Permit User Sessions... machine # [ 11.384585] input: QEMU Virtio Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:06.0/virtio5/input/input3 machine # [ 11.574222] systemd[1]: Finished Permit User Sessions. machine # [ 11.613918] systemd[1]: Started Getty on tty1. machine # [ 11.614728] systemd[1]: Reached target Login Prompts. machine # [ 11.760135] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch. machine # [ 11.770288] systemd[1]: Starting Virtual Console Setup... machine # [ 11.812397] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. machine # [ 11.816223] systemd[1]: Stopped Virtual Console Setup. machine # [ 11.818509] systemd[1]: Starting Virtual Console Setup... machine # [ 11.827238] systemd-logind[457]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard) machine # [ 11.992882] systemd-vconsole-setup[709]: Configuration of first virtual console was skipped, ignoring remaining ones. machine # [ 11.998810] systemd[1]: Finished Virtual Console Setup. machine # [ 12.379601] 8021q: adding VLAN 0 to HW filter on device eth0 machine # [ 12.363174] dhcpcd[663]: eth0: waiting for carrier machine # [ 12.369751] dhcpcd[663]: libudev: received NULL device machine # [ 12.371137] dhcpcd[663]: libudev: received NULL device machine # [ 12.374106] dhcpcd[663]: eth0: carrier acquired machine # [ 12.382529] dhcpcd[663]: DUID 00:01:00:01:32:66:ee:db:52:54:00:12:34:56 machine # [ 12.384758] dhcpcd[663]: eth0: IAID 00:12:34:56 machine # [ 12.385935] dhcpcd[663]: eth0: adding address fe80::5054:ff:fe12:3456 machine # [ 13.545313] dhcpcd[663]: eth0: soliciting an IPv6 router machine # [ 13.547058] dhcpcd[663]: eth0: Router Advertisement from fe80::2 machine # [ 13.548577] dhcpcd[663]: eth0: adding address fec0::5054:ff:fe12:3456/64 machine # [ 13.550164] dhcpcd[663]: eth0: adding route to fec0::/64 machine # [ 13.551447] dhcpcd[663]: eth0: adding default route via fe80::2 machine # [ 14.003943] dhcpcd[663]: eth0: soliciting a DHCP lease machine # [ 14.006209] dhcpcd[663]: eth0: offered 10.0.2.15 from 10.0.2.2 machine # [ 14.008490] dhcpcd[663]: eth0: probing address 10.0.2.15/24 machine # [ 18.440789] dhcpcd[663]: eth0: leased 10.0.2.15 for 86400 seconds machine # [ 18.443092] dhcpcd[663]: eth0: adding route to 10.0.2.0/24 machine # [ 18.446070] dhcpcd[663]: eth0: adding default route via 10.0.2.2 machine # [ 18.550537] systemd[1]: Started DHCP Client. machine # [ 18.552738] systemd[1]: Reached target Multi-User System. machine # [ 18.553635] systemd[1]: Startup finished in 1.117s (kernel) + 4.344s (initrd) + 13.090s (userspace) = 18.552s. machine: (finished: waiting for unit multi-user.target, in 20.22 seconds) machine: must succeed: /nix/store/vyagcp08nk4jxixq8lbwf1aba9f9a1qj-stderr-runner /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test/bin/switch-to-configuration test machine # Checking switch inhibitors... done machine # [ 19.686810] nixos[848]: switching to system configuration /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test machine # activating the configuration... machine # [ 19.692068] systemd[1]: Stopped target Remote File Systems. machine # [ 19.694312] systemd[1]: Stopped target Local File Systems. machine # setting up /etc... machine # [ 20.003176] systemd[1]: Reload requested from client PID 848 ('.switch-to-conf') (unit backdoor.service)... machine # [ 20.005529] systemd[1]: Reloading... machine # [ 20.360259] systemd[1]: Reloading finished in 353 ms. machine # reloading user units for usertest... machine # [ 20.416664] systemd[589]: Created slice User Core Session Slice. machine # [ 20.419617] systemd[589]: Starting D-Bus User Message Bus... machine # [ 20.456584] dbus-broker-launch[918]: Ignoring duplicate name 'org.freedesktop.import1' in service file '/nix/store/aw77bp4zfc97zizid5h923yc6ngjgsdp-system-path/share/dbus-1/services/org.freedesktop.import1.service' machine # [ 20.459873] dbus-broker-launch[918]: Ignoring duplicate name 'org.freedesktop.machine1' in service file '/nix/store/aw77bp4zfc97zizid5h923yc6ngjgsdp-system-path/share/dbus-1/services/org.freedesktop.machine1.service' machine # [ 20.463761] dbus-broker-launch[918]: Ignoring duplicate name 'org.freedesktop.portable1' in service file '/nix/store/aw77bp4zfc97zizid5h923yc6ngjgsdp-system-path/share/dbus-1/services/org.freedesktop.portable1.service' machine # [ 20.467260] dbus-broker-launch[918]: Ignoring duplicate name 'org.freedesktop.systemd1' in service file '/nix/store/aw77bp4zfc97zizid5h923yc6ngjgsdp-system-path/share/dbus-1/services/org.freedesktop.systemd1.service' machine # [ 20.472347] dbus-broker-launch[918]: Policy to allow eavesdropping in /etc/dbus-1/session.conf +27: Eavesdropping is deprecated and ignored machine # [ 20.474532] dbus-broker-launch[918]: Policy to allow eavesdropping in /etc/dbus-1/session.conf +29: Eavesdropping is deprecated and ignored machine # [ 20.478267] systemd[589]: Started D-Bus User Message Bus. machine # [ 20.481531] dbus-broker-launch[918]: Ready machine # [ 20.528354] systemd[589]: Reexecution requested from client PID 917 ('switch-to-confi')... machine # [ 20.530684] systemd[589]: Reexecuting. machine # [ 20.583649] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 20.698300] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 20.705542] systemd[589]: Reload requested from client PID 917 ('switch-to-confi')... machine # [ 20.709897] systemd[589]: Reloading... machine # [ 20.818638] systemd[589]: Reloading finished in 109 ms. machine # [ 20.836227] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # restarting the following user units: nixos-activation.service machine # [ 20.849901] systemd[589]: Stopped Run user-specific NixOS activation. machine # [ 20.851056] systemd[589]: Stopping Run user-specific NixOS activation... machine # [ 20.854478] systemd[589]: Starting Run user-specific NixOS activation... machine # [ 20.891080] systemd[589]: Finished Run user-specific NixOS activation. machine # restarting sysinit-reactivation.target machine # [ 20.904556] systemd[1]: Starting Re-setup tmpfiles on a system that is already running.... machine # [ 21.016369] systemd[1]: Finished Re-setup tmpfiles on a system that is already running.. machine # [ 21.021151] systemd[1]: Reached target Reactivate sysinit units. machine # [ 21.031700] systemd[1]: Reached target Remote File Systems. machine # [ 21.038159] systemd[1]: Starting linger-users.service... machine # [ 21.051072] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 21.061826] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 21.063320] systemd[1]: Reached target Local File Systems. machine # [ 21.076172] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 21.077861] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 21.084939] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 21.090026] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 21.094635] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 21.101898] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 21.106995] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 21.144878] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 21.149807] systemd[1]: Finished linger-users.service. machine # [ 21.297946] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 21.301174] systemd[1]: Finished Create SUID/SGID Wrappers. machine # the following new units were started: sysinit-reactivation.target, systemd-tmpfiles-resetup.service machine # [ 21.559238] nixos[848]: finished switching to system configuration /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test machine: (finished: must succeed: /nix/store/vyagcp08nk4jxixq8lbwf1aba9f9a1qj-stderr-runner /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test/bin/switch-to-configuration test, in 2.11 seconds) machine: must succeed: rm /etc/NIXOS machine: (finished: must succeed: rm /etc/NIXOS, in 0.02 seconds) machine: must succeed: /nix/store/vyagcp08nk4jxixq8lbwf1aba9f9a1qj-stderr-runner /nix/store/22ll2x53424p9fj6p91fp0gs4x5k1nb0-nixos-system-other-test/bin/switch-to-configuration test machine # this should succeed (config: /nix/store/22ll2x53424p9fj6p91fp0gs4x5k1nb0-nixos-system-other-test, action: test) machine # Checking switch inhibitors... done machine # [ 21.819036] nixos[996]: switching to system configuration /nix/store/22ll2x53424p9fj6p91fp0gs4x5k1nb0-nixos-system-other-test machine # [ 21.822369] systemd[1]: Stopped target Local File Systems. machine # activating the configuration... machine # [ 21.826366] systemd[1]: Stopped target Remote File Systems. machine # removing user ‘usertest’ machine # setting up /etc... machine # [ 22.134656] systemd[1]: Reload requested from client PID 996 ('.switch-to-conf') (unit backdoor.service)... machine # [ 22.136882] systemd[1]: Reloading... machine # [ 22.481243] systemd[1]: Reloading finished in 342 ms. machine # reloading user units for usertest... machine # [ 22.579476] systemd[589]: Reexecution requested from client PID 1067 ('switch-to-confi')... machine # [ 22.584430] systemd[589]: Reexecuting. machine # [ 22.643582] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 22.762410] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 22.769553] systemd[589]: Reload requested from client PID 1067 ('switch-to-confi')... machine # [ 22.773411] systemd[589]: Reloading... machine # [ 22.884489] systemd[589]: Reloading finished in 112 ms. machine # [ 22.900197] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # restarting the following user units: nixos-activation.service machine # [ 22.911269] systemd[589]: Stopped Run user-specific NixOS activation. machine # [ 22.913821] systemd[589]: Stopping Run user-specific NixOS activation... machine # [ 22.916189] systemd[589]: Starting Run user-specific NixOS activation... machine # [ 22.949160] systemd[589]: Finished Run user-specific NixOS activation. machine # restarting sysinit-reactivation.target machine # [ 22.954093] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 22.957378] systemd[1]: Stopping Reactivate sysinit units... machine # [ 22.958304] systemd[1]: Reached target Reactivate sysinit units. machine # reloading the following units: dbus-broker.service machine # [ 22.962768] systemd[1]: Reloading D-Bus System Message Bus... machine # [ 22.964699] dbus-broker-launch[440]: Caught SIGHUP, trigger reload. machine # [ 22.972164] dbus-broker-launch[440]: Looking up NSS user entry for 'systemd-timesync'... machine # [ 22.975219] dbus-broker-launch[440]: NSS returned no entry for 'systemd-timesync' machine # [ 22.976721] dbus-broker-launch[440]: Invalid user-name in /nix/store/vyh4zsqmi6nyb6wdmb4339cvwm6bpmb8-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" machine # [ 22.994825] systemd[1]: Reloaded D-Bus System Message Bus. machine # restarting the following units: network-addresses-eth1.service machine # [ 23.002715] systemd[1]: Stopping Address configuration of eth1... machine # [ 23.042482] network-addresses-eth1-pre-stop[1079]: deleting address 192.168.1.1/24... done machine # [ 23.051766] network-addresses-eth1-pre-stop[1079]: deleting address 2001:db8:1::1/64... done machine # [ 23.059855] systemd[1]: network-addresses-eth1.service: Deactivated successfully. machine # [ 23.062728] systemd[1]: Stopped Address configuration of eth1. machine # [ 23.067733] systemd[1]: Starting Address configuration of eth1... machine # [ 23.111469] network-addresses-eth1-start[1084]: adding address 192.168.1.2/24... done machine # [ 23.122108] network-addresses-eth1-start[1084]: adding address 2001:db8:1::2/64... done machine # [ 23.132191] systemd[1]: Finished Address configuration of eth1. machine # [ 23.135846] systemd[1]: Reached target Remote File Systems. machine # [ 23.139617] systemd[1]: Reached target Local File Systems. machine # [ 23.146813] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 23.152667] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 23.153613] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 23.154907] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 23.162595] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 23.173008] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 23.174543] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 23.177044] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 23.179101] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 23.361747] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 23.364359] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 23.369211] systemd[1]: Starting linger-users.service... machine # [ 23.399125] linger-users-start[1156]: id: ‘usertest’: no such user machine # [ 23.401302] linger-users-start[1154]: Removing linger for missing user usertest machine # [ 23.408177] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 23.410014] systemd[1]: Finished linger-users.service. machine # [ 23.666770] nixos[996]: finished switching to system configuration /nix/store/22ll2x53424p9fj6p91fp0gs4x5k1nb0-nixos-system-other-test machine: (finished: must succeed: /nix/store/vyagcp08nk4jxixq8lbwf1aba9f9a1qj-stderr-runner /nix/store/22ll2x53424p9fj6p91fp0gs4x5k1nb0-nixos-system-other-test/bin/switch-to-configuration test, in 2.09 seconds) subtest: services machine: must succeed: /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test/bin/switch-to-configuration test 2>&1 machine # [ 23.891536] nixos[1162]: switching to system configuration /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test machine # [ 23.894174] systemd[1]: Stopped target Remote File Systems. machine # [ 23.896641] systemd[1]: Stopped target Local File Systems. machine # [ 24.171734] systemd[1]: Reload requested from client PID 1162 ('.switch-to-conf') (unit backdoor.service)... machine # [ 24.174184] systemd[1]: Reloading... machine # [ 24.506562] systemd[1]: Reloading finished in 331 ms. machine # [ 24.627573] systemd[589]: Reexecution requested from client PID 1231 ('switch-to-confi')... machine # [ 24.630086] systemd[589]: Reexecuting. machine # [ 24.688167] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 24.805129] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 24.812278] systemd[589]: Reload requested from client PID 1231 ('switch-to-confi')... machine # [ 24.814747] systemd[589]: Reloading... machine # [ 24.927370] systemd[589]: Reloading finished in 111 ms. machine # [ 24.940210] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 24.952585] systemd[589]: Stopped Run user-specific NixOS activation. machine # [ 24.955268] systemd[589]: Stopping Run user-specific NixOS activation... machine # [ 24.957752] systemd[589]: Starting Run user-specific NixOS activation... machine # [ 24.994196] systemd[589]: Finished Run user-specific NixOS activation. machine # [ 24.998694] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 25.004325] systemd[1]: Stopping Reactivate sysinit units... machine # [ 25.005339] systemd[1]: Reached target Reactivate sysinit units. machine # [ 25.006591] dbus-broker-launch[440]: Caught SIGHUP, trigger reload. machine # [ 25.007540] systemd[1]: Reloading D-Bus System Message Bus... machine # [ 25.012326] dbus-broker-launch[440]: Looking up NSS user entry for 'systemd-timesync'... machine # [ 25.014642] dbus-broker-launch[440]: NSS returned no entry for 'systemd-timesync' machine # [ 25.015783] dbus-broker-launch[440]: Invalid user-name in /nix/store/aw77bp4zfc97zizid5h923yc6ngjgsdp-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" machine # [ 25.042727] systemd[1]: Reloaded D-Bus System Message Bus. machine # [ 25.049369] systemd[1]: Stopping Address configuration of eth1... machine # [ 25.085353] network-addresses-eth1-pre-stop[1244]: deleting address 192.168.1.2/24... done machine # [ 25.092653] network-addresses-eth1-pre-stop[1244]: deleting address 2001:db8:1::2/64... done machine # [ 25.100356] systemd[1]: network-addresses-eth1.service: Deactivated successfully. machine # [ 25.102823] systemd[1]: Stopped Address configuration of eth1. machine # [ 25.107688] systemd[1]: Starting Address configuration of eth1... machine # [ 25.152989] network-addresses-eth1-start[1249]: adding address 192.168.1.1/24... done machine # [ 25.160875] network-addresses-eth1-start[1249]: adding address 2001:db8:1::1/64... done machine # [ 25.171039] systemd[1]: Finished Address configuration of eth1. machine # [ 25.174874] systemd[1]: Reached target Local File Systems. machine # [ 25.180454] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 25.187344] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 25.192694] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 25.194015] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 25.201266] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 25.202976] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 25.210019] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 25.211357] systemd[1]: Reached target Remote File Systems. machine # [ 25.212319] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 25.213653] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 25.405685] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 25.407734] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 25.415113] systemd[1]: Starting linger-users.service... machine # [ 25.456001] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 25.459318] systemd[1]: Finished linger-users.service. machine # [ 25.715359] nixos[1162]: finished switching to system configuration /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test machine: (finished: must succeed: /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test/bin/switch-to-configuration test 2>&1, in 2.05 seconds) machine: must succeed: /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test/bin/switch-to-configuration test 2>&1 machine # [ 25.947704] nixos[1318]: switching to system configuration /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test machine # [ 25.953609] systemd[1]: Stopped target Remote File Systems. machine # [ 25.954563] systemd[1]: Stopped target Local File Systems. machine # [ 26.249412] systemd[1]: Reload requested from client PID 1318 ('.switch-to-conf') (unit backdoor.service)... machine # [ 26.251412] systemd[1]: Reloading... machine # [ 26.574065] systemd[1]: Reloading finished in 320 ms. machine # [ 26.667284] systemd[589]: Reexecution requested from client PID 1387 ('switch-to-confi')... machine # [ 26.669988] systemd[589]: Reexecuting. machine # [ 26.728387] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 26.845467] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 26.853730] systemd[589]: Reload requested from client PID 1387 ('switch-to-confi')... machine # [ 26.855189] systemd[589]: Reloading... machine # [ 26.963522] systemd[589]: Reloading finished in 107 ms. machine # [ 26.980198] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 26.993257] systemd[589]: Stopped Run user-specific NixOS activation. machine # [ 26.995863] systemd[589]: Stopping Run user-specific NixOS activation... machine # [ 26.998423] systemd[589]: Starting Run user-specific NixOS activation... machine # [ 27.033757] systemd[589]: Finished Run user-specific NixOS activation. machine # [ 27.037717] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 27.039944] systemd[1]: Stopping Reactivate sysinit units... machine # [ 27.042656] systemd[1]: Reached target Reactivate sysinit units. machine # [ 27.049617] systemd[1]: Reached target Local File Systems. machine # [ 27.053125] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 27.060776] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 27.061749] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 27.063020] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 27.075539] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 27.077765] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 27.079115] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 27.080474] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 27.081835] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 27.083129] systemd[1]: Reached target Remote File Systems. machine # [ 27.249856] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 27.255185] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 27.257866] systemd[1]: Starting linger-users.service... machine # [ 27.299499] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 27.302727] systemd[1]: Finished linger-users.service. machine # [ 27.558692] nixos[1318]: finished switching to system configuration /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test machine: (finished: must succeed: /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test/bin/switch-to-configuration test 2>&1, in 1.84 seconds) machine: must succeed: /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration test 2>&1 machine # [ 27.809828] nixos[1458]: switching to system configuration /nix/store/dirqgdjyc79fsfw0gf7r88l24kbyz510-nixos-system-machine-test machine # [ 27.812753] systemd[1]: Stopped target Local File Systems. machine # [ 27.814983] systemd[1]: Stopped target Remote File Systems. machine # [ 28.107383] systemd[1]: Reload requested from client PID 1458 ('.switch-to-conf') (unit backdoor.service)... machine # [ 28.109669] systemd[1]: Reloading... machine # [ 28.427195] systemd[1]: Reloading finished in 315 ms. machine # [ 28.514050] systemd[589]: Reexecution requested from client PID 1528 ('switch-to-confi')... machine # [ 28.517727] systemd[589]: Reexecuting. machine # [ 28.575577] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 28.686554] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 28.693615] systemd[589]: Reload requested from client PID 1528 ('switch-to-confi')... machine # [ 28.696237] systemd[589]: Reloading... machine # [ 28.802130] systemd[589]: Reloading finished in 104 ms. machine # [ 28.820250] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 28.830804] systemd[589]: Stopped Run user-specific NixOS activation. machine # [ 28.833375] systemd[589]: Stopping Run user-specific NixOS activation... machine # [ 28.835648] systemd[589]: Starting Run user-specific NixOS activation... machine # [ 28.869736] systemd[589]: Finished Run user-specific NixOS activation. machine # [ 28.874148] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 28.878518] systemd[1]: Stopping Reactivate sysinit units... machine # [ 28.879476] systemd[1]: Reached target Reactivate sysinit units. machine # [ 28.881255] systemd[1]: Reached target Remote File Systems. machine # [ 28.882131] systemd[1]: Reached target Local File Systems. machine # [ 28.889559] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 28.896911] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 28.897877] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 28.899179] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 28.911077] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 28.913094] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 28.914431] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 28.915680] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 28.917265] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 29.084239] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 29.088595] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 29.092334] systemd[1]: Starting linger-users.service... machine # [ 29.096510] systemd[1]: Starting test.service... machine # [ 29.138154] systemd[1]: Finished test.service. machine # [ 29.157206] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 29.160713] systemd[1]: Finished linger-users.service. machine # [ 29.415630] nixos[1458]: finished switching to system configuration /nix/store/dirqgdjyc79fsfw0gf7r88l24kbyz510-nixos-system-machine-test machine: (finished: must succeed: /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration test 2>&1, in 1.86 seconds) machine: must succeed: /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration test 2>&1 machine # [ 29.629108] nixos[1601]: switching to system configuration /nix/store/dirqgdjyc79fsfw0gf7r88l24kbyz510-nixos-system-machine-test machine # [ 29.631979] systemd[1]: Stopped target Local File Systems. machine # [ 29.634798] systemd[1]: Stopped target Remote File Systems. machine # [ 29.902960] systemd[1]: Reload requested from client PID 1601 ('.switch-to-conf') (unit backdoor.service)... machine # [ 29.905061] systemd[1]: Reloading... machine # [ 30.211727] systemd[1]: Reloading finished in 305 ms. machine # [ 30.300287] systemd[589]: Reexecution requested from client PID 1670 ('switch-to-confi')... machine # [ 30.301719] systemd[589]: Reexecuting. machine # [ 30.364140] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 30.482557] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 30.489148] systemd[589]: Reload requested from client PID 1670 ('switch-to-confi')... machine # [ 30.492081] systemd[589]: Reloading... machine # [ 30.598287] systemd[589]: Reloading finished in 106 ms. machine # [ 30.612176] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 30.622508] systemd[589]: Stopped Run user-specific NixOS activation. machine # [ 30.624944] systemd[589]: Stopping Run user-specific NixOS activation... machine # [ 30.627026] systemd[589]: Starting Run user-specific NixOS activation... machine # [ 30.660544] systemd[589]: Finished Run user-specific NixOS activation. machine # [ 30.665241] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 30.666238] systemd[1]: Stopping Reactivate sysinit units... machine # [ 30.667043] systemd[1]: Reached target Reactivate sysinit units. machine # [ 30.672710] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 30.676895] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 30.678647] systemd[1]: Reached target Remote File Systems. machine # [ 30.683028] systemd[1]: Starting linger-users.service... machine # [ 30.688833] systemd[1]: Reached target Local File Systems. machine # [ 30.696848] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 30.701644] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 30.702592] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 30.703856] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 30.713553] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 30.719249] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 30.725210] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 30.769268] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 30.773623] systemd[1]: Finished linger-users.service. machine # [ 30.905509] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 30.908720] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 31.164507] nixos[1601]: finished switching to system configuration /nix/store/dirqgdjyc79fsfw0gf7r88l24kbyz510-nixos-system-machine-test machine: (finished: must succeed: /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration test 2>&1, in 1.75 seconds) machine: must succeed: /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test/specialisation/simpleServiceDifferentDescription/bin/switch-to-configuration test 2>&1 machine # [ 31.400517] nixos[1742]: switching to system configuration /nix/store/170zwzshxiqq37nakm0y7ibnrg6y1asz-nixos-system-machine-test machine # [ 31.403050] systemd[1]: Stopped target Local File Systems. machine # [ 31.405429] systemd[1]: Stopped target Remote File Systems. machine # [ 31.700617] systemd[1]: Reload requested from client PID 1742 ('.switch-to-conf') (unit backdoor.service)... machine # [ 31.702581] systemd[1]: Reloading... machine # [ 32.065818] systemd[1]: Reloading finished in 361 ms. machine # [ 32.160518] systemd[589]: Reexecution requested from client PID 1811 ('switch-to-confi')... machine # [ 32.163360] systemd[589]: Reexecuting. machine # [ 32.224160] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 32.340990] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 32.348326] systemd[589]: Reload requested from client PID 1811 ('switch-to-confi')... machine # [ 32.350835] systemd[589]: Reloading... machine # [ 32.462742] systemd[589]: Reloading finished in 110 ms. machine # [ 32.480214] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 32.491369] systemd[589]: Stopped Run user-specific NixOS activation. machine # [ 32.494136] systemd[589]: Stopping Run user-specific NixOS activation... machine # [ 32.496434] systemd[589]: Starting Run user-specific NixOS activation... machine # [ 32.530994] systemd[589]: Finished Run user-specific NixOS activation. machine # [ 32.535198] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 32.537691] systemd[1]: Stopping Reactivate sysinit units... machine # [ 32.538626] systemd[1]: Reached target Reactivate sysinit units. machine # [ 32.541371] systemd[1]: Reached target Local File Systems. machine # [ 32.546055] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 32.550690] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 32.560457] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 32.562109] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 32.562972] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 32.572394] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 32.574728] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 32.576689] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 32.578047] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 32.579312] systemd[1]: Reached target Remote File Systems. machine # [ 32.747410] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 32.752586] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 32.755469] systemd[1]: Starting linger-users.service... machine # [ 32.806019] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 32.808132] systemd[1]: Finished linger-users.service. machine # [ 33.066405] nixos[1742]: finished switching to system configuration /nix/store/170zwzshxiqq37nakm0y7ibnrg6y1asz-nixos-system-machine-test machine: (finished: must succeed: /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test/specialisation/simpleServiceDifferentDescription/bin/switch-to-configuration test 2>&1, in 1.90 seconds) machine: must succeed: /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test/specialisation/simpleServiceModified/bin/switch-to-configuration test 2>&1 machine # [ 33.312244] nixos[1882]: switching to system configuration /nix/store/00ix772xir8b6sdxk16yapmwqyinwzak-nixos-system-machine-test machine # [ 33.315247] systemd[1]: test.service: Deactivated successfully. machine # [ 33.318562] systemd[1]: Stopped Test unit. machine # [ 33.319261] systemd[1]: Stopped target Local File Systems. machine # [ 33.320185] systemd[1]: Stopped target Remote File Systems. machine # [ 33.623364] systemd[1]: Reload requested from client PID 1882 ('.switch-to-conf') (unit backdoor.service)... machine # [ 33.625564] systemd[1]: Reloading... machine # [ 33.955749] systemd[1]: Reloading finished in 328 ms. machine # [ 34.046637] systemd[589]: Reexecution requested from client PID 1951 ('switch-to-confi')... machine # [ 34.049637] systemd[589]: Reexecuting. machine # [ 34.107742] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 34.226583] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 34.234320] systemd[589]: Reload requested from client PID 1951 ('switch-to-confi')... machine # [ 34.235669] systemd[589]: Reloading... machine # [ 34.391733] systemd[589]: Reloading finished in 154 ms. machine # [ 34.408190] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 34.419260] systemd[589]: Stopped Run user-specific NixOS activation. machine # [ 34.421753] systemd[589]: Stopping Run user-specific NixOS activation... machine # [ 34.424110] systemd[589]: Starting Run user-specific NixOS activation... machine # [ 34.458497] systemd[589]: Finished Run user-specific NixOS activation. machine # [ 34.462870] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 34.467017] systemd[1]: Stopping Reactivate sysinit units... machine # [ 34.469662] systemd[1]: Reached target Reactivate sysinit units. machine # [ 34.470598] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 34.471959] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 34.475549] systemd[1]: Reached target Local File Systems. machine # [ 34.482302] systemd[1]: Reached target Remote File Systems. machine # [ 34.485971] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 34.490064] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 34.490994] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 34.500212] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 34.502509] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 34.505016] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 34.506338] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 34.670798] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 34.675714] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 34.679957] systemd[1]: Starting linger-users.service... machine # [ 34.682486] systemd[1]: Starting test.service... machine # [ 34.721124] systemd[1]: Finished test.service. machine # [ 34.740322] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 34.742983] systemd[1]: Finished linger-users.service. machine # [ 34.999047] nixos[1882]: finished switching to system configuration /nix/store/00ix772xir8b6sdxk16yapmwqyinwzak-nixos-system-machine-test machine: (finished: must succeed: /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test/specialisation/simpleServiceModified/bin/switch-to-configuration test 2>&1, in 1.93 seconds) machine: must succeed: /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1 machine # [ 35.237062] nixos[2025]: switching to system configuration /nix/store/5sfwvj46bvawa98krfx8m6gpmwdhxczn-nixos-system-machine-test machine # [ 35.240043] systemd[1]: Stopped target Local File Systems. machine # [ 35.242515] systemd[1]: Stopped target Remote File Systems. machine # [ 35.530150] systemd[1]: Reload requested from client PID 2025 ('.switch-to-conf') (unit backdoor.service)... machine # [ 35.532295] systemd[1]: Reloading... machine # [ 35.847903] systemd[1]: Reloading finished in 314 ms. machine # [ 35.936558] systemd[589]: Reexecution requested from client PID 2094 ('switch-to-confi')... machine # [ 35.940785] systemd[589]: Reexecuting. machine # [ 36.003520] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 36.117980] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 36.124395] systemd[589]: Reload requested from client PID 2094 ('switch-to-confi')... machine # [ 36.127772] systemd[589]: Reloading... machine # [ 36.230508] systemd[589]: Reloading finished in 103 ms. machine # [ 36.248179] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 36.258920] systemd[589]: Stopped Run user-specific NixOS activation. machine # [ 36.260547] systemd[589]: Stopping Run user-specific NixOS activation... machine # [ 36.262543] systemd[589]: Starting Run user-specific NixOS activation... machine # [ 36.291186] systemd[589]: Finished Run user-specific NixOS activation. machine # [ 36.295662] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 36.300612] systemd[1]: Stopping Reactivate sysinit units... machine # [ 36.301520] systemd[1]: Reached target Reactivate sysinit units. machine # [ 36.302374] systemd[1]: test.service: Deactivated successfully. machine # [ 36.303195] systemd[1]: Stopped test.service. machine # [ 36.303854] systemd[1]: Stopping test.service... machine # [ 36.305710] systemd[1]: Starting test.service... machine # [ 36.330317] systemd[1]: Finished test.service. machine # [ 36.333187] systemd[1]: Reached target Local File Systems. machine # [ 36.336803] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 36.340516] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 36.341411] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 36.342656] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 36.352243] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 36.353903] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 36.355170] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 36.368124] systemd[1]: Reached target Remote File Systems. machine # [ 36.369351] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 36.372311] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 36.524224] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 36.528247] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 36.531256] systemd[1]: Starting linger-users.service... machine # [ 36.572348] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 36.575320] systemd[1]: Finished linger-users.service. machine # [ 36.829804] nixos[2025]: finished switching to system configuration /nix/store/5sfwvj46bvawa98krfx8m6gpmwdhxczn-nixos-system-machine-test machine: (finished: must succeed: /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1, in 1.83 seconds) machine: must succeed: /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test/specialisation/simpleServiceReload/bin/switch-to-configuration test 2>&1 machine # [ 37.064620] nixos[2167]: switching to system configuration /nix/store/girydjvgyzvib4csclzqj1agvrcd9abm-nixos-system-machine-test machine # [ 37.067715] systemd[1]: Stopped target Local File Systems. machine # [ 37.071013] systemd[1]: Stopped target Remote File Systems. machine # [ 37.361987] systemd[1]: Reload requested from client PID 2167 ('.switch-to-conf') (unit backdoor.service)... machine # [ 37.364388] systemd[1]: Reloading... machine # [ 37.695945] systemd[1]: Reloading finished in 330 ms. machine # [ 37.823050] systemd[589]: Reexecution requested from client PID 2236 ('switch-to-confi')... machine # [ 37.828140] systemd[589]: Reexecuting. machine # [ 37.879283] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 37.989846] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 37.996873] systemd[589]: Reload requested from client PID 2236 ('switch-to-confi')... machine # [ 37.999416] systemd[589]: Reloading... machine # [ 38.105325] systemd[589]: Reloading finished in 104 ms. machine # [ 38.120205] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 38.131574] systemd[589]: Stopped Run user-specific NixOS activation. machine # [ 38.134385] systemd[589]: Stopping Run user-specific NixOS activation... machine # [ 38.136735] systemd[589]: Starting Run user-specific NixOS activation... machine # [ 38.172577] systemd[589]: Finished Run user-specific NixOS activation. machine # [ 38.176619] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 38.180431] systemd[1]: Stopping Reactivate sysinit units... machine # [ 38.181376] systemd[1]: Reached target Reactivate sysinit units. machine # [ 38.184442] systemd[1]: Reloading test.service... machine # [ 38.210786] systemd[1]: Reloaded test.service. machine # [ 38.215395] systemd[1]: Reached target Remote File Systems. machine # [ 38.221699] systemd[1]: Starting linger-users.service... machine # [ 38.236668] systemd[1]: Reached target Local File Systems. machine # [ 38.237692] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 38.246664] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 38.247747] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 38.253297] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 38.255736] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 38.273342] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 38.274806] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 38.277856] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 38.282167] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 38.328842] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 38.333556] systemd[1]: Finished linger-users.service. machine # [ 38.470525] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 38.473733] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 38.729729] nixos[2167]: finished switching to system configuration /nix/store/girydjvgyzvib4csclzqj1agvrcd9abm-nixos-system-machine-test machine: (finished: must succeed: /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test/specialisation/simpleServiceReload/bin/switch-to-configuration test 2>&1, in 1.90 seconds) machine: must succeed: /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test/specialisation/simpleServiceNorestart/bin/switch-to-configuration test 2>&1 machine # [ 38.977831] nixos[2310]: switching to system configuration /nix/store/gbzii7acndhl9mz38gzyd7ly15azvhxm-nixos-system-machine-test machine # [ 38.980855] systemd[1]: Stopped target Remote File Systems. machine # [ 38.983857] systemd[1]: Stopped target Local File Systems. machine # [ 39.286185] systemd[1]: Reload requested from client PID 2310 ('.switch-to-conf') (unit backdoor.service)... machine # [ 39.288369] systemd[1]: Reloading... machine # [ 39.623861] systemd[1]: Reloading finished in 333 ms. machine # [ 39.712768] systemd[589]: Reexecution requested from client PID 2379 ('switch-to-confi')... machine # [ 39.717445] systemd[589]: Reexecuting. machine # [ 39.771641] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 39.882316] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 39.889204] systemd[589]: Reload requested from client PID 2379 ('switch-to-confi')... machine # [ 39.891651] systemd[589]: Reloading... machine # [ 39.997785] systemd[589]: Reloading finished in 105 ms. machine # [ 40.012184] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 40.023870] systemd[589]: Stopped Run user-specific NixOS activation. machine # [ 40.026315] systemd[589]: Stopping Run user-specific NixOS activation... machine # [ 40.028342] systemd[589]: Starting Run user-specific NixOS activation... machine # [ 40.060057] systemd[589]: Finished Run user-specific NixOS activation. machine # [ 40.063971] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 40.065387] systemd[1]: Stopping Reactivate sysinit units... machine # [ 40.066212] systemd[1]: Reached target Reactivate sysinit units. machine # [ 40.069528] systemd[1]: Reached target Local File Systems. machine # [ 40.072961] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 40.078051] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 40.079040] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 40.085557] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 40.087892] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 40.100874] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 40.102191] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 40.103446] systemd[1]: Reached target Remote File Systems. machine # [ 40.105194] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 40.106577] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 40.264387] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 40.268389] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 40.272480] systemd[1]: Starting linger-users.service... machine # [ 40.314159] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 40.316120] systemd[1]: Finished linger-users.service. machine # [ 40.572699] nixos[2310]: finished switching to system configuration /nix/store/gbzii7acndhl9mz38gzyd7ly15azvhxm-nixos-system-machine-test machine: (finished: must succeed: /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test/specialisation/simpleServiceNorestart/bin/switch-to-configuration test 2>&1, in 1.84 seconds) machine: must succeed: /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration dry-activate 2>&1 machine: (finished: must succeed: /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test/specialisation/simpleService/bin/switch-to-configuration dry-activate 2>&1, in 0.29 seconds) machine: must succeed: /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test/bin/switch-to-configuration test 2>&1 machine # [ 41.105296] nixos[2460]: switching to system configuration /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test machine # [ 41.108664] systemd[1]: Stopped target Local File Systems. machine # [ 41.112644] systemd[1]: Stopped target Remote File Systems. machine # [ 41.113617] systemd[1]: test.service: Deactivated successfully. machine # [ 41.114493] systemd[1]: Stopped test.service. machine # [ 41.402959] systemd[1]: Reload requested from client PID 2460 ('.switch-to-conf') (unit backdoor.service)... machine # [ 41.405184] systemd[1]: Reloading... machine # [ 41.725625] systemd[1]: Reloading finished in 317 ms. machine # [ 41.812429] systemd[589]: Reexecution requested from client PID 2530 ('switch-to-confi')... machine # [ 41.815346] systemd[589]: Reexecuting. machine # [ 41.871400] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 41.986568] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 41.993549] systemd[589]: Reload requested from client PID 2530 ('switch-to-confi')... machine # [ 41.996208] systemd[589]: Reloading... machine # [ 42.104370] systemd[589]: Reloading finished in 106 ms. machine # [ 42.120189] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 42.132611] systemd[589]: Stopped Run user-specific NixOS activation. machine # [ 42.134966] systemd[589]: Stopping Run user-specific NixOS activation... machine # [ 42.137151] systemd[589]: Starting Run user-specific NixOS activation... machine # [ 42.168405] systemd[589]: Finished Run user-specific NixOS activation. machine # [ 42.172963] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 42.175881] systemd[1]: Stopping Reactivate sysinit units... machine # [ 42.180401] systemd[1]: Reached target Reactivate sysinit units. machine # [ 42.181354] systemd[1]: Reached target Remote File Systems. machine # [ 42.183249] systemd[1]: Starting linger-users.service... machine # [ 42.190585] systemd[1]: Reached target Local File Systems. machine # [ 42.191579] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 42.204550] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 42.205499] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 42.206795] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 42.220504] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 42.222339] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 42.223876] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 42.230346] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 42.231804] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 42.285210] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 42.290121] systemd[1]: Finished linger-users.service. machine # [ 42.418819] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 42.422497] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 42.676574] nixos[2460]: finished switching to system configuration /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test machine: (finished: must succeed: /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test/bin/switch-to-configuration test 2>&1, in 1.81 seconds) machine: must succeed: /nix/store/xp3sybn14gl1vvz5vkbb5n078slvh70j-separate-activation-script/bin/switch-to-configuration test 2>&1 machine # [ 42.902172] nixos[2601]: switching to system configuration /nix/store/kq1jm0c6n8icxdmdd4k873jwmd9q2551-nixos-system-machine-test machine # [ 42.904853] systemd[1]: Stopped target Local File Systems. machine # [ 42.907469] systemd[1]: Stopped target Remote File Systems. machine # [ 43.201813] systemd[1]: Reload requested from client PID 2601 ('.switch-to-conf') (unit backdoor.service)... machine # [ 43.204206] systemd[1]: Reloading... machine # [ 43.520159] systemd[1]: Reloading finished in 314 ms. machine # [ 43.615224] systemd[589]: Stopped Run user-specific NixOS activation. machine # [ 43.619215] systemd[589]: Reexecution requested from client PID 2670 ('switch-to-confi')... machine # [ 43.621826] systemd[589]: Reexecuting. machine # [ 43.680145] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 43.795371] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 43.803715] systemd[589]: Reload requested from client PID 2670 ('switch-to-confi')... machine # [ 43.807211] systemd[589]: Reloading... machine # [ 43.913880] systemd[589]: Reloading finished in 108 ms. machine # [ 43.928193] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 43.941300] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 43.942382] systemd[1]: Stopping Reactivate sysinit units... machine # [ 43.943251] systemd[1]: Reached target Reactivate sysinit units. machine # [ 43.945881] systemd[1]: Reached target Remote File Systems. machine # [ 43.953326] systemd[1]: Starting linger-users.service... machine # [ 43.959221] systemd[1]: Starting test.service... machine # [ 43.970725] systemd[1]: Reached target Local File Systems. machine # [ 43.976362] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 43.983306] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 43.992673] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 43.994050] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 44.011349] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 44.019104] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 44.025634] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 44.027010] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 44.040176] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 44.041673] systemd[1]: Finished test.service. machine # [ 44.073376] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 44.077785] systemd[1]: Finished linger-users.service. machine # [ 44.220454] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 44.222327] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 44.480758] nixos[2601]: finished switching to system configuration /nix/store/kq1jm0c6n8icxdmdd4k873jwmd9q2551-nixos-system-machine-test machine: (finished: must succeed: /nix/store/xp3sybn14gl1vvz5vkbb5n078slvh70j-separate-activation-script/bin/switch-to-configuration test 2>&1, in 1.80 seconds) machine: must succeed: ! test -e /run/current-system/activate machine: (finished: must succeed: ! test -e /run/current-system/activate, in 0.02 seconds) machine: must succeed: ! test -e /run/current-system/dry-activate machine: (finished: must succeed: ! test -e /run/current-system/dry-activate, in 0.02 seconds) machine: must succeed: ! test -e /run/current-system/bin/switch-to-configuration machine: (finished: must succeed: ! test -e /run/current-system/bin/switch-to-configuration, in 0.02 seconds) machine: must succeed: /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test/specialisation/unitWithMultilineValue/bin/switch-to-configuration test 2>&1 machine # [ 44.769230] nixos[2750]: switching to system configuration /nix/store/r1lxp7q15z0067dj653xq9ag1bcwf1nq-nixos-system-machine-test machine # [ 44.772212] systemd[1]: Stopped target Local File Systems. machine # [ 44.774985] systemd[1]: test.service: Deactivated successfully. machine # [ 44.778010] systemd[1]: Stopped test.service. machine # [ 44.778810] systemd[1]: Stopped target Remote File Systems. machine # [ 45.084807] systemd[1]: Reload requested from client PID 2750 ('.switch-to-conf') (unit backdoor.service)... machine # [ 45.086477] systemd[1]: Reloading... machine # [ 45.421885] systemd[1]: Reloading finished in 333 ms. machine # [ 45.510113] systemd[589]: Reexecution requested from client PID 2819 ('switch-to-confi')... machine # [ 45.514181] systemd[589]: Reexecuting. machine # [ 45.568131] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 45.685136] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 45.691936] systemd[589]: Reload requested from client PID 2819 ('switch-to-confi')... machine # [ 45.694632] systemd[589]: Reloading... machine # [ 45.805752] systemd[589]: Reloading finished in 110 ms. machine # [ 45.821768] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 45.832886] systemd[589]: Starting Run user-specific NixOS activation... machine # [ 45.869006] systemd[589]: Finished Run user-specific NixOS activation. machine # [ 45.873244] systemd[589]: Stopped Run user-specific NixOS activation. machine # [ 45.874349] systemd[589]: Stopping Run user-specific NixOS activation... machine # [ 45.877061] systemd[589]: Starting Run user-specific NixOS activation... machine # [ 45.886700] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 45.888931] systemd[1]: Stopping Reactivate sysinit units... machine # [ 45.889885] systemd[1]: Reached target Reactivate sysinit units. machine # [ 45.898446] systemd[1]: Reached target Local File Systems. machine # [ 45.906980] systemd[1]: Reached target Remote File Systems. machine # [ 45.915580] systemd[1]: Starting linger-users.service... machine # [ 45.933046] systemd[1]: Started test.service. machine # [ 45.950362] systemd[589]: Finished Run user-specific NixOS activation. machine # [ 45.962356] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 45.976546] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 45.977536] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 45.978795] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 45.994325] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 46.004324] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 46.005855] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 46.012353] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 46.013817] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 46.015138] systemd[1]: test.service: Deactivated successfully. machine # [ 46.048684] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 46.052873] systemd[1]: Finished linger-users.service. machine # [ 46.196496] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 46.198454] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 46.455309] nixos[2750]: finished switching to system configuration /nix/store/r1lxp7q15z0067dj653xq9ag1bcwf1nq-nixos-system-machine-test machine: (finished: must succeed: /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test/specialisation/unitWithMultilineValue/bin/switch-to-configuration test 2>&1, in 1.91 seconds) machine: must succeed: /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test/specialisation/unitWithBackslash/bin/switch-to-configuration test 2>&1 machine # [ 46.685258] nixos[2895]: switching to system configuration /nix/store/s2c811nl45jfn9g81ngw2gkc4fc7q0iq-nixos-system-machine-test machine # [ 46.688584] systemd[1]: Stopped target Local File Systems. machine # [ 46.691559] systemd[1]: Stopped target Remote File Systems. machine # [ 47.010336] systemd[1]: Reload requested from client PID 2895 ('.switch-to-conf') (unit backdoor.service)... machine # [ 47.012583] systemd[1]: Reloading... machine # [ 47.341021] systemd[1]: Reloading finished in 326 ms. machine # [ 47.430552] systemd[589]: Reexecution requested from client PID 2964 ('switch-to-confi')... machine # [ 47.433615] systemd[589]: Reexecuting. machine # [ 47.488835] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 47.607873] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 47.615976] systemd[589]: Reload requested from client PID 2964 ('switch-to-confi')... machine # [ 47.617635] systemd[589]: Reloading... machine # [ 47.744333] systemd[589]: Reloading finished in 124 ms. machine # [ 47.760384] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 47.770708] systemd[589]: Stopped Run user-specific NixOS activation. machine # [ 47.773631] systemd[589]: Stopping Run user-specific NixOS activation... machine # [ 47.776079] systemd[589]: Starting Run user-specific NixOS activation... machine # [ 47.809687] systemd[589]: Finished Run user-specific NixOS activation. machine # [ 47.814578] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 47.816899] systemd[1]: Stopping Reactivate sysinit units... machine # [ 47.817875] systemd[1]: Reached target Reactivate sysinit units. machine # [ 47.822885] systemd[1]: Reached target Local File Systems. machine # [ 47.826912] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 47.831003] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 47.832001] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 47.837511] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 47.839827] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 47.853636] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 47.855072] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 47.856501] systemd[1]: Reached target Remote File Systems. machine # [ 47.857337] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 47.858675] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 48.039039] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 48.044805] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 48.048349] systemd[1]: Starting escaped\x2ddash.service... machine # [ 48.051907] systemd[1]: Starting linger-users.service... machine # [ 48.094458] systemd[1]: Finished escaped\x2ddash.service. machine # [ 48.117429] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 48.120136] systemd[1]: Finished linger-users.service. machine # [ 48.377358] nixos[2895]: finished switching to system configuration /nix/store/s2c811nl45jfn9g81ngw2gkc4fc7q0iq-nixos-system-machine-test machine: (finished: must succeed: /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test/specialisation/unitWithBackslash/bin/switch-to-configuration test 2>&1, in 1.92 seconds) machine: must succeed: /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test/specialisation/unitWithBackslashModified/bin/switch-to-configuration test 2>&1 machine # [ 48.679957] nixos[3037]: switching to system configuration /nix/store/9v9fafbmf5kb62d4k3vbl0vq7s5m018k-nixos-system-machine-test machine # [ 48.682800] systemd[1]: escaped\x2ddash.service: Deactivated successfully. machine # [ 48.685418] systemd[1]: Stopped escaped\x2ddash.service. machine # [ 48.687101] systemd[1]: Stopped target Local File Systems. machine # [ 48.689488] systemd[1]: Stopped target Remote File Systems. machine # [ 48.999654] systemd[1]: Reload requested from client PID 3037 ('.switch-to-conf') (unit backdoor.service)... machine # [ 49.001949] systemd[1]: Reloading... machine # [ 49.586167] systemd[1]: Reloading finished in 582 ms. machine # [ 49.684482] systemd[589]: Reexecution requested from client PID 3106 ('switch-to-confi')... machine # [ 49.687533] systemd[589]: Reexecuting. machine # [ 49.743651] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 49.858739] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 49.866101] systemd[589]: Reload requested from client PID 3106 ('switch-to-confi')... machine # [ 49.868750] systemd[589]: Reloading... machine # [ 49.979222] systemd[589]: Reloading finished in 109 ms. machine # [ 49.996395] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 50.008939] systemd[589]: Stopped Run user-specific NixOS activation. machine # [ 50.011793] systemd[589]: Stopping Run user-specific NixOS activation... machine # [ 50.014462] systemd[589]: Starting Run user-specific NixOS activation... machine # [ 50.051602] systemd[589]: Finished Run user-specific NixOS activation. machine # [ 50.057548] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 50.060974] systemd[1]: Stopping Reactivate sysinit units... machine # [ 50.061954] systemd[1]: Reached target Reactivate sysinit units. machine # [ 50.066685] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 50.070159] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 50.071622] systemd[1]: Reached target Remote File Systems. machine # [ 50.078031] systemd[1]: Reached target Local File Systems. machine # [ 50.079014] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 50.093098] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 50.094111] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 50.095411] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 50.102870] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 50.104804] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 50.106203] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 50.302179] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 50.304371] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 50.310546] systemd[1]: Starting escaped\x2ddash.service... machine # [ 50.315947] systemd[1]: Starting linger-users.service... machine # [ 50.362330] systemd[1]: Finished escaped\x2ddash.service. machine # [ 50.382907] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 50.385313] systemd[1]: Finished linger-users.service. machine # [ 50.642433] nixos[3037]: finished switching to system configuration /nix/store/9v9fafbmf5kb62d4k3vbl0vq7s5m018k-nixos-system-machine-test machine: (finished: must succeed: /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test/specialisation/unitWithBackslashModified/bin/switch-to-configuration test 2>&1, in 2.27 seconds) machine: must succeed: /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test/specialisation/unitStartingWithDash/bin/switch-to-configuration test 2>&1 machine # [ 50.934481] nixos[3179]: switching to system configuration /nix/store/5ablawqmyfdjjb2clwnv8xwv2a5si6i0-nixos-system-machine-test machine # [ 50.937307] systemd[1]: escaped\x2ddash.service: Deactivated successfully. machine # [ 50.941912] systemd[1]: Stopped escaped\x2ddash.service. machine # [ 50.942820] systemd[1]: Stopped target Remote File Systems. machine # [ 50.943641] systemd[1]: Stopped target Local File Systems. machine # [ 51.246328] systemd[1]: Reload requested from client PID 3179 ('.switch-to-conf') (unit backdoor.service)... machine # [ 51.248484] systemd[1]: Reloading... machine # [ 51.572777] systemd[1]: Reloading finished in 322 ms. machine # [ 51.664466] systemd[589]: Reexecution requested from client PID 3248 ('switch-to-confi')... machine # [ 51.665978] systemd[589]: Reexecuting. machine # [ 51.723625] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 51.837066] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 51.844247] systemd[589]: Reload requested from client PID 3248 ('switch-to-confi')... machine # [ 51.848217] systemd[589]: Reloading... machine # [ 51.958673] systemd[589]: Reloading finished in 111 ms. machine # [ 51.976210] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 51.988480] systemd[589]: Stopped Run user-specific NixOS activation. machine # [ 51.991072] systemd[589]: Stopping Run user-specific NixOS activation... machine # [ 51.993637] systemd[589]: Starting Run user-specific NixOS activation... machine # [ 52.030574] systemd[589]: Finished Run user-specific NixOS activation. machine # [ 52.034983] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 52.038096] systemd[1]: Stopping Reactivate sysinit units... machine # [ 52.039020] systemd[1]: Reached target Reactivate sysinit units. machine # [ 52.042806] systemd[1]: Reached target Local File Systems. machine # [ 52.046246] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 52.052240] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 52.053727] systemd[1]: Reached target Remote File Systems. machine # [ 52.056188] systemd[1]: Starting -.service... machine # [ 52.061394] systemd[1]: Starting linger-users.service... machine # [ 52.082330] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 52.087850] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 52.092293] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 52.093736] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 52.095999] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 52.105983] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 52.107371] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 52.136906] systemd[1]: Finished -.service. machine # [ 52.177875] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 52.181503] systemd[1]: Finished linger-users.service. machine # [ 52.317850] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 52.319787] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 52.577473] nixos[3179]: finished switching to system configuration /nix/store/5ablawqmyfdjjb2clwnv8xwv2a5si6i0-nixos-system-machine-test machine: (finished: must succeed: /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test/specialisation/unitStartingWithDash/bin/switch-to-configuration test 2>&1, in 1.93 seconds) machine: must succeed: /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test/specialisation/unitStartingWithDashModified/bin/switch-to-configuration test 2>&1 machine # [ 52.862221] nixos[3321]: switching to system configuration /nix/store/3zfy9rb9w9y6rk2izcya11532w12sl6w-nixos-system-machine-test machine # [ 52.864973] systemd[1]: Stopped target Remote File Systems. machine # [ 52.867557] systemd[1]: Stopped target Local File Systems. machine # [ 53.190117] systemd[1]: Reload requested from client PID 3321 ('.switch-to-conf') (unit backdoor.service)... machine # [ 53.192327] systemd[1]: Reloading... machine # [ 53.555878] systemd[1]: Reloading finished in 361 ms. machine # [ 53.648446] systemd[589]: Reexecution requested from client PID 3390 ('switch-to-confi')... machine # [ 53.652516] systemd[589]: Reexecuting. machine # [ 53.711824] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 53.830355] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 53.838059] systemd[589]: Reload requested from client PID 3390 ('switch-to-confi')... machine # [ 53.839498] systemd[589]: Reloading... machine # [ 53.950982] systemd[589]: Reloading finished in 109 ms. machine # [ 53.968191] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 53.978062] systemd[589]: Stopped Run user-specific NixOS activation. machine # [ 53.980818] systemd[589]: Stopping Run user-specific NixOS activation... machine # [ 53.983115] systemd[589]: Starting Run user-specific NixOS activation... machine # [ 54.017968] systemd[589]: Finished Run user-specific NixOS activation. machine # [ 54.022922] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 54.025022] systemd[1]: Stopping Reactivate sysinit units... machine # [ 54.025971] systemd[1]: Reached target Reactivate sysinit units. machine # [ 54.031933] systemd[1]: Reloading -.service... machine # [ 54.059342] systemd[1]: Reloaded -.service. machine # [ 54.063583] systemd[1]: Reached target Local File Systems. machine # [ 54.069069] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 54.072111] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 54.076951] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 54.078343] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 54.092986] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 54.094736] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 54.098979] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 54.100523] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 54.101853] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 54.103247] systemd[1]: Reached target Remote File Systems. machine # [ 54.281628] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 54.285440] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 54.290371] systemd[1]: Starting linger-users.service... machine # [ 54.336406] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 54.339402] systemd[1]: Finished linger-users.service. machine # [ 54.595401] nixos[3321]: finished switching to system configuration /nix/store/3zfy9rb9w9y6rk2izcya11532w12sl6w-nixos-system-machine-test machine: (finished: must succeed: /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test/specialisation/unitStartingWithDashModified/bin/switch-to-configuration test 2>&1, in 2.02 seconds) machine: must succeed: /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test/specialisation/unitWithRequirement/bin/switch-to-configuration test 2>&1 machine # [ 54.823530] nixos[3463]: switching to system configuration /nix/store/hrm6i1r7yvkn88mxdz3wnxq55czi1ji7-nixos-system-machine-test machine # [ 54.826809] systemd[1]: -.service: Deactivated successfully. machine # [ 54.830817] systemd[1]: Stopped -.service. machine # [ 54.832356] systemd[1]: Stopped target Local File Systems. machine # [ 54.833256] systemd[1]: Stopped target Remote File Systems. machine # [ 55.139189] systemd[1]: Reload requested from client PID 3463 ('.switch-to-conf') (unit backdoor.service)... machine # [ 55.141753] systemd[1]: Reloading... machine # [ 55.470236] systemd[1]: Reloading finished in 327 ms. machine # [ 55.558401] systemd[589]: Reexecution requested from client PID 3532 ('switch-to-confi')... machine # [ 55.563152] systemd[589]: Reexecuting. machine # [ 55.619902] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 55.733947] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 55.740739] systemd[589]: Reload requested from client PID 3532 ('switch-to-confi')... machine # [ 55.744136] systemd[589]: Reloading... machine # [ 55.850046] systemd[589]: Reloading finished in 106 ms. machine # [ 55.864177] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 55.874726] systemd[589]: Stopped Run user-specific NixOS activation. machine # [ 55.877332] systemd[589]: Stopping Run user-specific NixOS activation... machine # [ 55.880886] systemd[589]: Starting Run user-specific NixOS activation... machine # [ 55.911817] systemd[589]: Finished Run user-specific NixOS activation. machine # [ 55.916516] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 55.920506] systemd[1]: Stopping Reactivate sysinit units... machine # [ 55.921432] systemd[1]: Reached target Reactivate sysinit units. machine # [ 55.922301] systemd[1]: Reached target Remote File Systems. machine # [ 55.926175] systemd[1]: Reached target Local File Systems. machine # [ 55.927070] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 55.936425] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 55.937336] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 55.938592] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 55.947348] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 55.954471] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 55.956086] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 55.959852] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 55.964064] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 56.115556] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 56.118886] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 56.124300] systemd[1]: Starting linger-users.service... machine # [ 56.128759] systemd[1]: Starting required-service.service... machine # [ 56.140136] systemd[1]: Starting test-service.service... machine # [ 56.185795] systemd[1]: Finished required-service.service. machine # [ 56.191501] systemd[1]: Finished test-service.service. machine # [ 56.211504] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 56.215090] systemd[1]: Finished linger-users.service. machine # [ 56.470236] nixos[3463]: finished switching to system configuration /nix/store/hrm6i1r7yvkn88mxdz3wnxq55czi1ji7-nixos-system-machine-test machine: (finished: must succeed: /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test/specialisation/unitWithRequirement/bin/switch-to-configuration test 2>&1, in 1.87 seconds) machine: must succeed: /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test/specialisation/unitWithRequirementModified/bin/switch-to-configuration test 2>&1 machine # [ 56.707382] nixos[3607]: switching to system configuration /nix/store/4d21hblrh7vnzb356nz2ab6jpjmm092k-nixos-system-machine-test machine # [ 56.710292] systemd[1]: Stopped target Remote File Systems. machine # [ 56.714961] systemd[1]: Stopped target Local File Systems. machine # [ 56.716304] systemd[1]: required-service.service: Deactivated successfully. machine # [ 56.718436] systemd[1]: Stopped required-service.service. machine # [ 56.719268] systemd[1]: test-service.service: Deactivated successfully. machine # [ 56.722421] systemd[1]: Stopped test-service.service. machine # [ 57.020412] systemd[1]: Reload requested from client PID 3607 ('.switch-to-conf') (unit backdoor.service)... machine # [ 57.022423] systemd[1]: Reloading... machine # [ 57.358689] systemd[1]: Reloading finished in 334 ms. machine # [ 57.455897] systemd[589]: Reexecution requested from client PID 3676 ('switch-to-confi')... machine # [ 57.458622] systemd[589]: Reexecuting. machine # [ 57.524200] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 57.641366] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 57.648113] systemd[589]: Reload requested from client PID 3676 ('switch-to-confi')... machine # [ 57.650313] systemd[589]: Reloading... machine # [ 57.757283] systemd[589]: Reloading finished in 105 ms. machine # [ 57.772206] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 57.782306] systemd[589]: Stopped Run user-specific NixOS activation. machine # [ 57.784838] systemd[589]: Stopping Run user-specific NixOS activation... machine # [ 57.787074] systemd[589]: Starting Run user-specific NixOS activation... machine # [ 57.820421] systemd[589]: Finished Run user-specific NixOS activation. machine # [ 57.824711] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 57.826685] systemd[1]: Stopping Reactivate sysinit units... machine # [ 57.827611] systemd[1]: Reached target Reactivate sysinit units. machine # [ 57.833253] systemd[1]: Reached target Remote File Systems. machine # [ 57.836856] systemd[1]: Reached target Local File Systems. machine # [ 57.840126] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 57.844516] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 57.845415] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 57.846719] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 57.860984] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 57.862692] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 57.863999] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 57.869629] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 57.870966] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 58.024820] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 58.029978] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 58.032339] systemd[1]: Starting linger-users.service... machine # [ 58.038333] systemd[1]: Starting required-service.service... machine # [ 58.048145] systemd[1]: Starting test-service.service... machine # [ 58.095037] systemd[1]: Finished test-service.service. machine # [ 58.101179] systemd[1]: Finished required-service.service. machine # [ 58.120631] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 58.124243] systemd[1]: Finished linger-users.service. machine # [ 58.380718] nixos[3607]: finished switching to system configuration /nix/store/4d21hblrh7vnzb356nz2ab6jpjmm092k-nixos-system-machine-test machine: (finished: must succeed: /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test/specialisation/unitWithRequirementModified/bin/switch-to-configuration test 2>&1, in 1.91 seconds) machine: must succeed: /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test/specialisation/unitWithRequirementModifiedNostart/bin/switch-to-configuration test 2>&1 machine # [ 58.611737] nixos[3751]: switching to system configuration /nix/store/dnkn3mks6yi57vi1zi2r4aiv49ks2xsj-nixos-system-machine-test machine # [ 58.614631] systemd[1]: Stopped target Local File Systems. machine # [ 58.619367] systemd[1]: required-service.service: Deactivated successfully. machine # [ 58.622173] systemd[1]: Stopped required-service.service. machine # [ 58.623017] systemd[1]: test-service.service: Deactivated successfully. machine # [ 58.623950] systemd[1]: Stopped test-service.service. machine # [ 58.625646] systemd[1]: Stopped target Remote File Systems. machine # [ 58.925945] systemd[1]: Reload requested from client PID 3751 ('.switch-to-conf') (unit backdoor.service)... machine # [ 58.927978] systemd[1]: Reloading... machine # [ 59.307930] systemd[1]: Reloading finished in 377 ms. machine # [ 59.392550] systemd[589]: Reexecution requested from client PID 3820 ('switch-to-confi')... machine # [ 59.395759] systemd[589]: Reexecuting. machine # [ 59.452171] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 59.565037] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 59.571913] systemd[589]: Reload requested from client PID 3820 ('switch-to-confi')... machine # [ 59.575595] systemd[589]: Reloading... machine # [ 59.682330] systemd[589]: Reloading finished in 108 ms. machine # [ 59.700255] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 59.710212] systemd[589]: Stopped Run user-specific NixOS activation. machine # [ 59.713058] systemd[589]: Stopping Run user-specific NixOS activation... machine # [ 59.715380] systemd[589]: Starting Run user-specific NixOS activation... machine # [ 59.753399] systemd[589]: Finished Run user-specific NixOS activation. machine # [ 59.760219] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 59.761667] systemd[1]: Stopping Reactivate sysinit units... machine # [ 59.762551] systemd[1]: Reached target Reactivate sysinit units. machine # [ 59.770072] systemd[1]: Starting required-service.service... machine # [ 59.780707] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 59.782212] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 59.788904] systemd[1]: Reached target Local File Systems. machine # [ 59.789886] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 59.795333] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 59.803578] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 59.811178] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 59.819286] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 59.824549] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 59.825946] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 59.827170] systemd[1]: Reached target Remote File Systems. machine # [ 59.836231] systemd[1]: Finished required-service.service. machine # [ 59.991437] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 59.994672] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 59.998705] systemd[1]: Starting linger-users.service... machine # [ 60.004481] systemd[1]: Starting test-service.service... machine # [ 60.040647] systemd[1]: Finished test-service.service. machine # [ 60.060453] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 60.062941] systemd[1]: Finished linger-users.service. machine # [ 60.318821] nixos[3751]: finished switching to system configuration /nix/store/dnkn3mks6yi57vi1zi2r4aiv49ks2xsj-nixos-system-machine-test machine: (finished: must succeed: /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test/specialisation/unitWithRequirementModifiedNostart/bin/switch-to-configuration test 2>&1, in 1.94 seconds) machine: must succeed: /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test/specialisation/unitWithTemplate/bin/switch-to-configuration test 2>&1 machine # [ 60.550019] nixos[3895]: switching to system configuration /nix/store/vkzimcxcgzzcs375hgh1dqhmhjjq279w-nixos-system-machine-test machine # [ 60.552919] systemd[1]: test-service.service: Deactivated successfully. machine # [ 60.556467] systemd[1]: Stopped test-service.service. machine # [ 60.557300] systemd[1]: Stopped target Local File Systems. machine # [ 60.558088] systemd[1]: Stopped target Remote File Systems. machine # [ 60.559696] systemd[1]: required-service.service: Deactivated successfully. machine # [ 60.562387] systemd[1]: Stopped required-service.service. machine # [ 60.862186] systemd[1]: Reload requested from client PID 3895 ('.switch-to-conf') (unit backdoor.service)... machine # [ 60.864305] systemd[1]: Reloading... machine # [ 61.556052] systemd[1]: Reloading finished in 689 ms. machine # [ 61.644845] systemd[589]: Reexecution requested from client PID 3963 ('switch-to-confi')... machine # [ 61.649189] systemd[589]: Reexecuting. machine # [ 61.694963] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 61.805023] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 61.812183] systemd[589]: Reload requested from client PID 3963 ('switch-to-confi')... machine # [ 61.814459] systemd[589]: Reloading... machine # [ 61.917724] systemd[589]: Reloading finished in 102 ms. machine # [ 61.932188] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 61.943653] systemd[589]: Stopped Run user-specific NixOS activation. machine # [ 61.946131] systemd[589]: Stopping Run user-specific NixOS activation... machine # [ 61.948564] systemd[589]: Starting Run user-specific NixOS activation... machine # [ 61.980184] systemd[589]: Finished Run user-specific NixOS activation. machine # [ 61.984101] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 61.986091] systemd[1]: Stopping Reactivate sysinit units... machine # [ 61.986962] systemd[1]: Reached target Reactivate sysinit units. machine # [ 61.989949] systemd[1]: Reached target Remote File Systems. machine # [ 61.993980] systemd[1]: Created slice Slice /system/instantiated. machine # [ 61.999734] systemd[1]: Starting instantiated@one.service... machine # [ 62.003326] systemd[1]: Starting instantiated@two.service... machine # [ 62.008846] systemd[1]: Starting linger-users.service... machine # [ 62.027245] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 62.040254] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 62.041732] systemd[1]: Reached target Local File Systems. machine # [ 62.042757] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 62.070508] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 62.071636] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 62.080878] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 62.083230] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 62.103454] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 62.108946] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 62.113549] systemd[1]: Finished instantiated@two.service. machine # [ 62.114465] systemd[1]: Finished instantiated@one.service. machine # [ 62.144897] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 62.149591] systemd[1]: Finished linger-users.service. machine # [ 62.283308] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 62.286577] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 62.543027] nixos[3895]: finished switching to system configuration /nix/store/vkzimcxcgzzcs375hgh1dqhmhjjq279w-nixos-system-machine-test machine: (finished: must succeed: /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test/specialisation/unitWithTemplate/bin/switch-to-configuration test 2>&1, in 2.22 seconds) machine: must succeed: /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test/specialisation/unitWithTemplateModified/bin/switch-to-configuration test 2>&1 machine # [ 62.776302] nixos[4039]: switching to system configuration /nix/store/3fs1414m86460p9wdls39cqbrky55pg9-nixos-system-machine-test machine # [ 62.779199] systemd[1]: Stopped target Local File Systems. machine # [ 62.782536] systemd[1]: instantiated@two.service: Deactivated successfully. machine # [ 62.783628] systemd[1]: Stopped instantiated@two.service. machine # [ 62.786474] systemd[1]: Stopped target Remote File Systems. machine # [ 62.787362] systemd[1]: instantiated@one.service: Deactivated successfully. machine # [ 62.788556] systemd[1]: Stopped instantiated@one.service. machine # [ 63.091948] systemd[1]: Reload requested from client PID 4039 ('.switch-to-conf') (unit backdoor.service)... machine # [ 63.094126] systemd[1]: Reloading... machine # [ 63.431637] systemd[1]: Reloading finished in 336 ms. machine # [ 63.524077] systemd[589]: Reexecution requested from client PID 4108 ('switch-to-confi')... machine # [ 63.528794] systemd[589]: Reexecuting. machine # [ 63.583446] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 63.696145] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 63.702694] systemd[589]: Reload requested from client PID 4108 ('switch-to-confi')... machine # [ 63.705331] systemd[589]: Reloading... machine # [ 63.812059] systemd[589]: Reloading finished in 105 ms. machine # [ 63.828186] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 63.838334] systemd[589]: Stopped Run user-specific NixOS activation. machine # [ 63.840797] systemd[589]: Stopping Run user-specific NixOS activation... machine # [ 63.842926] systemd[589]: Starting Run user-specific NixOS activation... machine # [ 63.876323] systemd[589]: Finished Run user-specific NixOS activation. machine # [ 63.880710] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 63.883749] systemd[1]: Stopping Reactivate sysinit units... machine # [ 63.885904] systemd[1]: Reached target Reactivate sysinit units. machine # [ 63.890816] systemd[1]: Starting instantiated@two.service... machine # [ 63.900949] systemd[1]: Reached target Remote File Systems. machine # [ 63.904668] systemd[1]: Starting instantiated@one.service... machine # [ 63.907148] systemd[1]: Starting linger-users.service... machine # [ 63.921154] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 63.922679] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 63.940820] systemd[1]: Reached target Local File Systems. machine # [ 63.941741] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 63.943256] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 63.960335] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 63.961634] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 63.981663] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 63.991811] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 64.003881] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 64.008879] systemd[1]: Finished instantiated@two.service. machine # [ 64.009749] systemd[1]: Finished instantiated@one.service. machine # [ 64.041255] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 64.044694] systemd[1]: Finished linger-users.service. machine # [ 64.181144] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 64.184330] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 64.441407] nixos[4039]: finished switching to system configuration /nix/store/3fs1414m86460p9wdls39cqbrky55pg9-nixos-system-machine-test machine: (finished: must succeed: /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test/specialisation/unitWithTemplateModified/bin/switch-to-configuration test 2>&1, in 1.90 seconds) (finished: subtest: services, in 40.77 seconds) subtest: failing units machine: must succeed: /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test/specialisation/simpleServiceModified/bin/switch-to-configuration test 2>&1 machine # [ 64.668268] nixos[4183]: switching to system configuration /nix/store/00ix772xir8b6sdxk16yapmwqyinwzak-nixos-system-machine-test machine # [ 64.670964] systemd[1]: Stopped target Remote File Systems. machine # [ 64.674461] systemd[1]: Stopped target Local File Systems. machine # [ 64.675383] systemd[1]: instantiated@one.service: Deactivated successfully. machine # [ 64.677674] systemd[1]: Stopped instantiated@one.service. machine # [ 64.678537] systemd[1]: instantiated@two.service: Deactivated successfully. machine # [ 64.679544] systemd[1]: Stopped instantiated@two.service. machine # [ 64.964313] systemd[1]: Reload requested from client PID 4183 ('.switch-to-conf') (unit backdoor.service)... machine # [ 64.966292] systemd[1]: Reloading... machine # [ 65.475088] systemd[1]: Reloading finished in 507 ms. machine # [ 65.562673] systemd[589]: Reexecution requested from client PID 4252 ('switch-to-confi')... machine # [ 65.566936] systemd[589]: Reexecuting. machine # [ 65.627805] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 65.744487] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 65.752120] systemd[589]: Reload requested from client PID 4252 ('switch-to-confi')... machine # [ 65.753574] systemd[589]: Reloading... machine # [ 65.861960] systemd[589]: Reloading finished in 106 ms. machine # [ 65.876192] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 65.886570] systemd[589]: Stopped Run user-specific NixOS activation. machine # [ 65.889097] systemd[589]: Stopping Run user-specific NixOS activation... machine # [ 65.891330] systemd[589]: Starting Run user-specific NixOS activation... machine # [ 65.923885] systemd[589]: Finished Run user-specific NixOS activation. machine # [ 65.927893] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 65.930737] systemd[1]: Stopping Reactivate sysinit units... machine # [ 65.931685] systemd[1]: Reached target Reactivate sysinit units. machine # [ 65.935014] systemd[1]: Reached target Remote File Systems. machine # [ 65.939167] systemd[1]: Reached target Local File Systems. machine # [ 65.944275] systemd[1]: Starting linger-users.service... machine # [ 65.948364] systemd[1]: Starting test.service... machine # [ 65.964631] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 65.966289] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 65.967113] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 65.980900] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 65.983282] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 65.999341] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 66.008167] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 66.014615] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 66.023321] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 66.027842] systemd[1]: Finished test.service. machine # [ 66.057697] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 66.062427] systemd[1]: Finished linger-users.service. machine # [ 66.196818] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 66.199818] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 66.456701] nixos[4183]: finished switching to system configuration /nix/store/00ix772xir8b6sdxk16yapmwqyinwzak-nixos-system-machine-test machine: (finished: must succeed: /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test/specialisation/simpleServiceModified/bin/switch-to-configuration test 2>&1, in 2.02 seconds) machine: must fail: /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test/specialisation/simpleServiceFailing/bin/switch-to-configuration test 2>&1 machine # [ 66.705166] nixos[4325]: switching to system configuration /nix/store/bb15izfhgryn7nnfffyb560df1iywqfj-nixos-system-machine-test machine # [ 66.708180] systemd[1]: Stopped target Remote File Systems. machine # [ 66.711295] systemd[1]: test.service: Deactivated successfully. machine # [ 66.714256] systemd[1]: Stopped test.service. machine # [ 66.715007] systemd[1]: Stopped target Local File Systems. machine # [ 67.014594] systemd[1]: Reload requested from client PID 4325 ('.switch-to-conf') (unit backdoor.service)... machine # [ 67.016705] systemd[1]: Reloading... machine # [ 67.338120] systemd[1]: Reloading finished in 320 ms. machine # [ 67.429905] systemd[589]: Reexecution requested from client PID 4394 ('switch-to-confi')... machine # [ 67.433537] systemd[589]: Reexecuting. machine # [ 67.491005] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 67.599363] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 67.607117] systemd[589]: Reload requested from client PID 4394 ('switch-to-confi')... machine # [ 67.610639] systemd[589]: Reloading... machine # [ 67.716437] systemd[589]: Reloading finished in 106 ms. machine # [ 67.732209] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 67.742741] systemd[589]: Stopped Run user-specific NixOS activation. machine # [ 67.745359] systemd[589]: Stopping Run user-specific NixOS activation... machine # [ 67.747664] systemd[589]: Starting Run user-specific NixOS activation... machine # [ 67.781303] systemd[589]: Finished Run user-specific NixOS activation. machine # [ 67.785618] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 67.788901] systemd[1]: Stopping Reactivate sysinit units... machine # [ 67.789807] systemd[1]: Reached target Reactivate sysinit units. machine # [ 67.792793] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 67.794176] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 67.797707] systemd[1]: Reached target Local File Systems. machine # [ 67.800509] systemd[1]: Reached target Remote File Systems. machine # [ 67.807178] systemd[1]: Starting linger-users.service... machine # [ 67.811404] systemd[1]: Starting test.service... machine # [ 67.823622] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 67.833677] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 67.834616] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 67.836001] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 67.847080] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 67.853367] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 67.854889] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 67.888897] systemd[1]: test.service: Main process exited, code=exited, status=1/FAILURE machine # [ 67.890364] systemd[1]: test.service: Failed with result 'exit-code'. machine # [ 67.891659] systemd[1]: Failed to start test.service. machine # [ 67.925719] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 67.929285] systemd[1]: Finished linger-users.service. machine # [ 68.068181] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 68.071258] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 68.345059] nixos[4325]: switching to system configuration /nix/store/bb15izfhgryn7nnfffyb560df1iywqfj-nixos-system-machine-test failed (status 4) machine: (finished: must fail: /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test/specialisation/simpleServiceFailing/bin/switch-to-configuration test 2>&1, in 1.89 seconds) machine: must succeed: /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test/specialisation/autorestartService/bin/switch-to-configuration test 2>&1 machine # [ 68.559301] nixos[4468]: switching to system configuration /nix/store/3aphsxk706ykimp52m3l2nnz5i7n1n99-nixos-system-machine-test machine # [ 68.562039] systemd[1]: Stopped target Local File Systems. machine # [ 68.564610] systemd[1]: Stopped target Remote File Systems. machine # [ 68.873799] systemd[1]: Reload requested from client PID 4468 ('.switch-to-conf') (unit backdoor.service)... machine # [ 68.875895] systemd[1]: Reloading... machine # [ 69.203427] systemd[1]: Reloading finished in 325 ms. machine # [ 69.285657] systemd[589]: Reexecution requested from client PID 4537 ('switch-to-confi')... machine # [ 69.289358] systemd[589]: Reexecuting. machine # [ 69.339118] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 69.448677] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 69.455902] systemd[589]: Reload requested from client PID 4537 ('switch-to-confi')... machine # [ 69.459831] systemd[589]: Reloading... machine # [ 69.565210] systemd[589]: Reloading finished in 106 ms. machine # [ 69.580180] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 69.591944] systemd[589]: Stopped Run user-specific NixOS activation. machine # [ 69.594389] systemd[589]: Stopping Run user-specific NixOS activation... machine # [ 69.596654] systemd[589]: Starting Run user-specific NixOS activation... machine # [ 69.628074] systemd[589]: Finished Run user-specific NixOS activation. machine # [ 69.631985] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 69.633567] systemd[1]: Stopping Reactivate sysinit units... machine # [ 69.634407] systemd[1]: Reached target Reactivate sysinit units. machine # [ 69.638012] systemd[1]: Reached target Local File Systems. machine # [ 69.641285] systemd[1]: Reached target Remote File Systems. machine # [ 69.649337] systemd[1]: Started autorestart.service. machine # [ 69.654249] systemd[1]: Starting linger-users.service... machine # [ 69.668075] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 69.669857] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 69.670710] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 69.671995] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 69.686462] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 69.696551] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 69.698000] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 69.710019] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 69.718868] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 69.731952] systemd[1]: autorestart.service: Deactivated successfully. machine # [ 69.769015] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 69.772496] systemd[1]: Finished linger-users.service. machine # [ 69.898931] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 69.901951] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 70.159473] nixos[4468]: finished switching to system configuration /nix/store/3aphsxk706ykimp52m3l2nnz5i7n1n99-nixos-system-machine-test machine: (finished: must succeed: /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test/specialisation/autorestartService/bin/switch-to-configuration test 2>&1, in 1.81 seconds) machine # [ 70.202069] systemd[1]: Stopped autorestart.service. machine: must succeed: /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test/specialisation/autorestartService/bin/switch-to-configuration test 2>&1 machine # [ 70.407221] nixos[4615]: switching to system configuration /nix/store/3aphsxk706ykimp52m3l2nnz5i7n1n99-nixos-system-machine-test machine # [ 70.410400] systemd[1]: Stopped target Remote File Systems. machine # [ 70.413469] systemd[1]: Stopped target Local File Systems. machine # [ 70.701284] systemd[1]: Reload requested from client PID 4615 ('.switch-to-conf') (unit backdoor.service)... machine # [ 70.703368] systemd[1]: Reloading... machine # [ 71.036434] systemd[1]: Reloading finished in 331 ms. machine # [ 71.127435] systemd[589]: Reexecution requested from client PID 4684 ('switch-to-confi')... machine # [ 71.131769] systemd[589]: Reexecuting. machine # [ 71.179682] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 71.289734] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 71.296664] systemd[589]: Reload requested from client PID 4684 ('switch-to-confi')... machine # [ 71.299208] systemd[589]: Reloading... machine # [ 71.406398] systemd[589]: Reloading finished in 106 ms. machine # [ 71.424189] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 71.433898] systemd[589]: Stopped Run user-specific NixOS activation. machine # [ 71.436071] systemd[589]: Stopping Run user-specific NixOS activation... machine # [ 71.438641] systemd[589]: Starting Run user-specific NixOS activation... machine # [ 71.472590] systemd[589]: Finished Run user-specific NixOS activation. machine # [ 71.477003] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 71.478001] systemd[1]: Stopping Reactivate sysinit units... machine # [ 71.478825] systemd[1]: Reached target Reactivate sysinit units. machine # [ 71.485196] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 71.488534] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 71.492959] systemd[1]: Reached target Local File Systems. machine # [ 71.496692] systemd[1]: Reached target Remote File Systems. machine # [ 71.504523] systemd[1]: Started autorestart.service. machine # [ 71.505351] systemd[1]: Starting linger-users.service... machine # [ 71.524481] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 71.526210] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 71.527046] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 71.531368] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 71.536842] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 71.538552] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 71.553849] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 71.577411] systemd[1]: autorestart.service: Deactivated successfully. machine # [ 71.612836] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 71.615447] systemd[1]: Finished linger-users.service. machine # [ 71.744729] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 71.748399] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 72.003696] nixos[4615]: finished switching to system configuration /nix/store/3aphsxk706ykimp52m3l2nnz5i7n1n99-nixos-system-machine-test machine: (finished: must succeed: /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test/specialisation/autorestartService/bin/switch-to-configuration test 2>&1, in 1.80 seconds) machine # [ 72.045266] systemd[1]: Stopped autorestart.service. machine: must fail: /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test/specialisation/autorestartServiceFailing/bin/switch-to-configuration test 2>&1 machine # [ 72.260936] nixos[4762]: switching to system configuration /nix/store/w50a3bypllc1h0iz4yvcvfdn1cwa3ii9-nixos-system-machine-test machine # [ 72.263489] systemd[1]: Stopped target Local File Systems. machine # [ 72.266389] systemd[1]: Stopped target Remote File Systems. machine # [ 72.550993] systemd[1]: Reload requested from client PID 4762 ('.switch-to-conf') (unit backdoor.service)... machine # [ 72.553070] systemd[1]: Reloading... machine # [ 72.880782] systemd[1]: Reloading finished in 326 ms. machine # [ 72.970866] systemd[589]: Reexecution requested from client PID 4831 ('switch-to-confi')... machine # [ 72.973174] systemd[589]: Reexecuting. machine # [ 73.036124] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 73.154335] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 73.161093] systemd[589]: Reload requested from client PID 4831 ('switch-to-confi')... machine # [ 73.165074] systemd[589]: Reloading... machine # [ 73.270965] systemd[589]: Reloading finished in 106 ms. machine # [ 73.288183] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 73.299111] systemd[589]: Stopped Run user-specific NixOS activation. machine # [ 73.300520] systemd[589]: Stopping Run user-specific NixOS activation... machine # [ 73.303135] systemd[589]: Starting Run user-specific NixOS activation... machine # [ 73.336300] systemd[589]: Finished Run user-specific NixOS activation. machine # [ 73.340671] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 73.341710] systemd[1]: Stopping Reactivate sysinit units... machine # [ 73.342526] systemd[1]: Reached target Reactivate sysinit units. machine # [ 73.345213] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 73.352405] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 73.353814] systemd[1]: Reached target Remote File Systems. machine # [ 73.356325] systemd[1]: Started autorestart.service. machine # [ 73.361670] systemd[1]: Starting linger-users.service... machine # [ 73.362533] systemd[1]: Reached target Local File Systems. machine # [ 73.376398] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 73.382113] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 73.383102] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 73.392639] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 73.395083] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 73.410609] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 73.416397] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 73.434441] systemd[1]: autorestart.service: Main process exited, code=exited, status=1/FAILURE machine # [ 73.439842] systemd[1]: autorestart.service: Failed with result 'exit-code'. machine # [ 73.469145] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 73.473776] systemd[1]: Finished linger-users.service. machine # [ 73.608189] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 73.611700] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 73.887354] nixos[4762]: switching to system configuration /nix/store/w50a3bypllc1h0iz4yvcvfdn1cwa3ii9-nixos-system-machine-test failed (status 4) machine: (finished: must fail: /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test/specialisation/autorestartServiceFailing/bin/switch-to-configuration test 2>&1, in 1.84 seconds) (finished: subtest: failing units, in 9.45 seconds) subtest: unit file parser machine: must succeed: /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1 machine # [ 74.089013] nixos[4905]: switching to system configuration /nix/store/5sfwvj46bvawa98krfx8m6gpmwdhxczn-nixos-system-machine-test machine # [ 74.091839] systemd[1]: Stopped autorestart.service. machine # [ 74.094356] systemd[1]: Stopped target Local File Systems. machine # [ 74.095725] systemd[1]: Stopped target Remote File Systems. machine # [ 74.367732] systemd[1]: Reload requested from client PID 4905 ('.switch-to-conf') (unit backdoor.service)... machine # [ 74.369843] systemd[1]: Reloading... machine # [ 74.686859] systemd[1]: Reloading finished in 315 ms. machine # [ 74.774319] systemd[589]: Reexecution requested from client PID 4974 ('switch-to-confi')... machine # [ 74.779344] systemd[589]: Reexecuting. machine # [ 74.835901] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 74.952164] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 74.959106] systemd[589]: Reload requested from client PID 4974 ('switch-to-confi')... machine # [ 74.961808] systemd[589]: Reloading... machine # [ 75.073324] systemd[589]: Reloading finished in 110 ms. machine # [ 75.088223] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 75.097847] systemd[589]: Stopped Run user-specific NixOS activation. machine # [ 75.100762] systemd[589]: Stopping Run user-specific NixOS activation... machine # [ 75.102983] systemd[589]: Starting Run user-specific NixOS activation... machine # [ 75.138444] systemd[589]: Finished Run user-specific NixOS activation. machine # [ 75.143111] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 75.149455] systemd[1]: Stopping Reactivate sysinit units... machine # [ 75.150447] systemd[1]: Reached target Reactivate sysinit units. machine # [ 75.151351] systemd[1]: Reached target Local File Systems. machine # [ 75.153049] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 75.156466] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 75.157443] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 75.158743] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 75.169266] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 75.171017] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 75.179607] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 75.187917] systemd[1]: Reached target Remote File Systems. machine # [ 75.189900] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 75.192238] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 75.348988] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 75.351335] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 75.358081] systemd[1]: Starting linger-users.service... machine # [ 75.361387] systemd[1]: Starting test.service... machine # [ 75.402128] systemd[1]: Finished test.service. machine # [ 75.425524] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 75.427307] systemd[1]: Finished linger-users.service. machine # [ 75.685013] nixos[4905]: finished switching to system configuration /nix/store/5sfwvj46bvawa98krfx8m6gpmwdhxczn-nixos-system-machine-test machine: (finished: must succeed: /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1, in 1.80 seconds) machine: must succeed: /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test/specialisation/simpleServiceWithExtraSection/bin/switch-to-configuration test 2>&1 machine # [ 75.915050] nixos[5047]: switching to system configuration /nix/store/pymc084x8i03dp4nd3bynbjhjx9k8xsp-nixos-system-machine-test machine # [ 75.920773] systemd[1]: Stopped target Remote File Systems. machine # [ 75.921723] systemd[1]: Stopped target Local File Systems. machine # [ 76.213196] systemd[1]: Reload requested from client PID 5047 ('.switch-to-conf') (unit backdoor.service)... machine # [ 76.215204] systemd[1]: Reloading... machine # [ 76.537791] systemd[1]: Reloading finished in 321 ms. machine # [ 76.627178] systemd[589]: Reexecution requested from client PID 5116 ('switch-to-confi')... machine # [ 76.631736] systemd[589]: Reexecuting. machine # [ 76.688377] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 76.803958] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 76.810553] systemd[589]: Reload requested from client PID 5116 ('switch-to-confi')... machine # [ 76.814519] systemd[589]: Reloading... machine # [ 76.919444] systemd[589]: Reloading finished in 106 ms. machine # [ 76.936182] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 76.945973] systemd[589]: Stopped Run user-specific NixOS activation. machine # [ 76.948524] systemd[589]: Stopping Run user-specific NixOS activation... machine # [ 76.950669] systemd[589]: Starting Run user-specific NixOS activation... machine # [ 76.985618] systemd[589]: Finished Run user-specific NixOS activation. machine # [ 76.990066] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 76.992830] systemd[1]: Stopping Reactivate sysinit units... machine # [ 76.993797] systemd[1]: Reached target Reactivate sysinit units. machine # [ 76.997562] systemd[1]: test.service: Deactivated successfully. machine # [ 76.998569] systemd[1]: Stopped test.service. machine # [ 76.999238] systemd[1]: Stopping test.service... machine # [ 77.004260] systemd[1]: Starting test.service... machine # [ 77.030352] systemd[1]: Finished test.service. machine # [ 77.036452] systemd[1]: Reached target Remote File Systems. machine # [ 77.041373] systemd[1]: Starting linger-users.service... machine # [ 77.048624] systemd[1]: Reached target Local File Systems. machine # [ 77.056279] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 77.060599] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 77.061590] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 77.074319] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 77.080976] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 77.085769] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 77.088276] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 77.089546] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 77.090829] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 77.142852] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 77.146850] systemd[1]: Finished linger-users.service. machine # [ 77.294625] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 77.298532] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 77.552510] nixos[5047]: finished switching to system configuration /nix/store/pymc084x8i03dp4nd3bynbjhjx9k8xsp-nixos-system-machine-test machine: (finished: must succeed: /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test/specialisation/simpleServiceWithExtraSection/bin/switch-to-configuration test 2>&1, in 1.87 seconds) machine: must succeed: /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test/specialisation/simpleServiceWithExtraSectionOtherName/bin/switch-to-configuration test 2>&1 machine # [ 77.784541] nixos[5189]: switching to system configuration /nix/store/5rywmxck83fw59fcyn0m0lgqkbghvbwi-nixos-system-machine-test machine # [ 77.786924] systemd[1]: Stopped target Remote File Systems. machine # [ 77.789159] systemd[1]: Stopped target Local File Systems. machine # [ 78.082869] systemd[1]: Reload requested from client PID 5189 ('.switch-to-conf') (unit backdoor.service)... machine # [ 78.085124] systemd[1]: Reloading... machine # [ 78.408068] systemd[1]: Reloading finished in 321 ms. machine # [ 78.496929] systemd[589]: Reexecution requested from client PID 5258 ('switch-to-confi')... machine # [ 78.500278] systemd[589]: Reexecuting. machine # [ 78.560087] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 78.676149] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 78.683169] systemd[589]: Reload requested from client PID 5258 ('switch-to-confi')... machine # [ 78.686906] systemd[589]: Reloading... machine # [ 78.790871] systemd[589]: Reloading finished in 105 ms. machine # [ 78.808179] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 78.818835] systemd[589]: Stopped Run user-specific NixOS activation. machine # [ 78.821341] systemd[589]: Stopping Run user-specific NixOS activation... machine # [ 78.823724] systemd[589]: Starting Run user-specific NixOS activation... machine # [ 78.855840] systemd[589]: Finished Run user-specific NixOS activation. machine # [ 78.859354] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 78.861460] systemd[1]: Stopping Reactivate sysinit units... machine # [ 78.862346] systemd[1]: Reached target Reactivate sysinit units. machine # [ 78.867547] systemd[1]: test.service: Deactivated successfully. machine # [ 78.872219] systemd[1]: Stopped test.service. machine # [ 78.872958] systemd[1]: Stopping test.service... machine # [ 78.873624] systemd[1]: Starting test.service... machine # [ 78.893061] systemd[1]: Finished test.service. machine # [ 78.898478] systemd[1]: Reached target Remote File Systems. machine # [ 78.902574] systemd[1]: Starting linger-users.service... machine # [ 78.910377] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 78.911847] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 78.918940] systemd[1]: Reached target Local File Systems. machine # [ 78.923428] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 78.931897] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 78.936382] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 78.942586] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 78.947808] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 78.952675] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 78.954036] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 78.993392] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 78.996393] systemd[1]: Finished linger-users.service. machine # [ 79.130106] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 79.133562] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 79.387588] nixos[5189]: finished switching to system configuration /nix/store/5rywmxck83fw59fcyn0m0lgqkbghvbwi-nixos-system-machine-test machine: (finished: must succeed: /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test/specialisation/simpleServiceWithExtraSectionOtherName/bin/switch-to-configuration test 2>&1, in 1.84 seconds) machine: must succeed: /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1 machine # [ 79.596709] nixos[5331]: switching to system configuration /nix/store/5sfwvj46bvawa98krfx8m6gpmwdhxczn-nixos-system-machine-test machine # [ 79.599137] systemd[1]: Stopped target Remote File Systems. machine # [ 79.601925] systemd[1]: Stopped target Local File Systems. machine # [ 79.867011] systemd[1]: Reload requested from client PID 5331 ('.switch-to-conf') (unit backdoor.service)... machine # [ 79.869200] systemd[1]: Reloading... machine # [ 80.245739] systemd[1]: Reloading finished in 374 ms. machine # [ 80.329128] systemd[589]: Reexecution requested from client PID 5400 ('switch-to-confi')... machine # [ 80.333409] systemd[589]: Reexecuting. machine # [ 80.375030] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 80.482006] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 80.488643] systemd[589]: Reload requested from client PID 5400 ('switch-to-confi')... machine # [ 80.491053] systemd[589]: Reloading... machine # [ 80.596300] systemd[589]: Reloading finished in 104 ms. machine # [ 80.612170] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 80.625368] systemd[589]: Stopped Run user-specific NixOS activation. machine # [ 80.626415] systemd[589]: Stopping Run user-specific NixOS activation... machine # [ 80.628558] systemd[589]: Starting Run user-specific NixOS activation... machine # [ 80.658675] systemd[589]: Finished Run user-specific NixOS activation. machine # [ 80.662858] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 80.663860] systemd[1]: Stopping Reactivate sysinit units... machine # [ 80.668852] systemd[1]: Reached target Reactivate sysinit units. machine # [ 80.669751] systemd[1]: test.service: Deactivated successfully. machine # [ 80.670577] systemd[1]: Stopped test.service. machine # [ 80.671209] systemd[1]: Stopping test.service... machine # [ 80.672887] systemd[1]: Starting test.service... machine # [ 80.696386] systemd[1]: Finished test.service. machine # [ 80.699061] systemd[1]: Reached target Remote File Systems. machine # [ 80.704405] systemd[1]: Reached target Local File Systems. machine # [ 80.705300] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 80.707726] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 80.713594] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 80.714833] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 80.728271] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 80.729935] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 80.731218] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 80.733187] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 80.734479] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 80.889982] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 80.894950] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 80.897526] systemd[1]: Starting linger-users.service... machine # [ 80.937275] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 80.940344] systemd[1]: Finished linger-users.service. machine # [ 81.197640] nixos[5331]: finished switching to system configuration /nix/store/5sfwvj46bvawa98krfx8m6gpmwdhxczn-nixos-system-machine-test machine: (finished: must succeed: /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1, in 1.81 seconds) machine: must succeed: /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test/specialisation/simpleServiceWithInstallSection/bin/switch-to-configuration test 2>&1 machine # [ 81.427039] nixos[5473]: switching to system configuration /nix/store/7k3k0w111mgnv89p2r01pdqbshn8k3yp-nixos-system-machine-test machine # [ 81.430529] systemd[1]: Stopped target Local File Systems. machine # [ 81.432341] systemd[1]: Stopped target Remote File Systems. machine # [ 81.726855] systemd[1]: Reload requested from client PID 5473 ('.switch-to-conf') (unit backdoor.service)... machine # [ 81.729318] systemd[1]: Reloading... machine # [ 82.051274] systemd[1]: Reloading finished in 320 ms. machine # [ 82.144467] systemd[589]: Reexecution requested from client PID 5542 ('switch-to-confi')... machine # [ 82.145947] systemd[589]: Reexecuting. machine # [ 82.203370] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 82.320708] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 82.327660] systemd[589]: Reload requested from client PID 5542 ('switch-to-confi')... machine # [ 82.330043] systemd[589]: Reloading... machine # [ 82.434853] systemd[589]: Reloading finished in 103 ms. machine # [ 82.452167] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 82.462035] systemd[589]: Stopped Run user-specific NixOS activation. machine # [ 82.464514] systemd[589]: Stopping Run user-specific NixOS activation... machine # [ 82.466602] systemd[589]: Starting Run user-specific NixOS activation... machine # [ 82.499331] systemd[589]: Finished Run user-specific NixOS activation. machine # [ 82.503711] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 82.507768] systemd[1]: Stopping Reactivate sysinit units... machine # [ 82.512787] systemd[1]: Reached target Reactivate sysinit units. machine # [ 82.513703] systemd[1]: Reached target Local File Systems. machine # [ 82.514473] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 82.516923] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 82.517834] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 82.529502] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 82.531889] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 82.538093] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 82.539548] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 82.540930] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 82.542216] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 82.543497] systemd[1]: Reached target Remote File Systems. machine # [ 82.693421] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 82.695325] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 82.700343] systemd[1]: Starting linger-users.service... machine # [ 82.740666] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 82.743467] systemd[1]: Finished linger-users.service. machine # [ 82.998767] nixos[5473]: finished switching to system configuration /nix/store/7k3k0w111mgnv89p2r01pdqbshn8k3yp-nixos-system-machine-test machine: (finished: must succeed: /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test/specialisation/simpleServiceWithInstallSection/bin/switch-to-configuration test 2>&1, in 1.80 seconds) machine: must succeed: /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test/specialisation/simpleServiceWithExtraKey/bin/switch-to-configuration test 2>&1 machine # [ 83.220842] nixos[5613]: switching to system configuration /nix/store/ha9xbsxa2rlcsk3y16bgpf9yzsrw7zhp-nixos-system-machine-test machine # [ 83.224782] systemd[1]: Stopped target Remote File Systems. machine # [ 83.225668] systemd[1]: Stopped target Local File Systems. machine # [ 83.506745] systemd[1]: Reload requested from client PID 5613 ('.switch-to-conf') (unit backdoor.service)... machine # [ 83.508883] systemd[1]: Reloading... machine # [ 83.818576] systemd[1]: Reloading finished in 308 ms. machine # [ 83.907477] systemd[589]: Reexecution requested from client PID 5682 ('switch-to-confi')... machine # [ 83.910431] systemd[589]: Reexecuting. machine # [ 83.972147] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 84.087423] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 84.094022] systemd[589]: Reload requested from client PID 5682 ('switch-to-confi')... machine # [ 84.097966] systemd[589]: Reloading... machine # [ 84.200654] systemd[589]: Reloading finished in 103 ms. machine # [ 84.216178] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 84.226340] systemd[589]: Stopped Run user-specific NixOS activation. machine # [ 84.228935] systemd[589]: Stopping Run user-specific NixOS activation... machine # [ 84.231144] systemd[589]: Starting Run user-specific NixOS activation... machine # [ 84.264124] systemd[589]: Finished Run user-specific NixOS activation. machine # [ 84.268120] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 84.272519] systemd[1]: Stopping Reactivate sysinit units... machine # [ 84.273468] systemd[1]: Reached target Reactivate sysinit units. machine # [ 84.274381] systemd[1]: test.service: Deactivated successfully. machine # [ 84.275230] systemd[1]: Stopped test.service. machine # [ 84.275894] systemd[1]: Stopping test.service... machine # [ 84.278396] systemd[1]: Starting test.service... machine # [ 84.305313] systemd[1]: Finished test.service. machine # [ 84.310419] systemd[1]: Reached target Local File Systems. machine # [ 84.314164] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 84.318567] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 84.319629] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 84.328408] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 84.330756] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 84.334126] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 84.335507] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 84.348135] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 84.349604] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 84.351788] systemd[1]: Reached target Remote File Systems. machine # [ 84.520774] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 84.525807] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 84.528407] systemd[1]: Starting linger-users.service... machine # [ 84.568439] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 84.571629] systemd[1]: Finished linger-users.service. machine # [ 84.825602] nixos[5613]: finished switching to system configuration /nix/store/ha9xbsxa2rlcsk3y16bgpf9yzsrw7zhp-nixos-system-machine-test machine: (finished: must succeed: /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test/specialisation/simpleServiceWithExtraKey/bin/switch-to-configuration test 2>&1, in 1.83 seconds) machine: must succeed: /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test/specialisation/simpleServiceWithExtraKeyOtherValue/bin/switch-to-configuration test 2>&1 machine # [ 85.047272] nixos[5755]: switching to system configuration /nix/store/r98v1gxb34fn1a91wp3rikv857jj70xv-nixos-system-machine-test machine # [ 85.052206] systemd[1]: Stopped target Local File Systems. machine # [ 85.053092] systemd[1]: Stopped target Remote File Systems. machine # [ 85.332884] systemd[1]: Reload requested from client PID 5755 ('.switch-to-conf') (unit backdoor.service)... machine # [ 85.335022] systemd[1]: Reloading... machine # [ 85.655221] systemd[1]: Reloading finished in 318 ms. machine # [ 85.738940] systemd[589]: Reexecution requested from client PID 5824 ('switch-to-confi')... machine # [ 85.743053] systemd[589]: Reexecuting. machine # [ 85.795516] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 85.906453] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 85.912937] systemd[589]: Reload requested from client PID 5824 ('switch-to-confi')... machine # [ 85.916057] systemd[589]: Reloading... machine # [ 86.019643] systemd[589]: Reloading finished in 103 ms. machine # [ 86.036160] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 86.045429] systemd[589]: Stopped Run user-specific NixOS activation. machine # [ 86.047652] systemd[589]: Stopping Run user-specific NixOS activation... machine # [ 86.049744] systemd[589]: Starting Run user-specific NixOS activation... machine # [ 86.079254] systemd[589]: Finished Run user-specific NixOS activation. machine # [ 86.083218] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 86.085136] systemd[1]: Stopping Reactivate sysinit units... machine # [ 86.085974] systemd[1]: Reached target Reactivate sysinit units. machine # [ 86.089811] systemd[1]: test.service: Deactivated successfully. machine # [ 86.090733] systemd[1]: Stopped test.service. machine # [ 86.091484] systemd[1]: Stopping test.service... machine # [ 86.096213] systemd[1]: Starting test.service... machine # [ 86.117012] systemd[1]: Finished test.service. machine # [ 86.121892] systemd[1]: Reached target Local File Systems. machine # [ 86.124644] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 86.130062] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 86.131029] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 86.140533] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 86.142808] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 86.151672] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 86.153121] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 86.154330] systemd[1]: Reached target Remote File Systems. machine # [ 86.155157] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 86.157251] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 86.304587] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 86.306446] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 86.311739] systemd[1]: Starting linger-users.service... machine # [ 86.351623] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 86.354487] systemd[1]: Finished linger-users.service. machine # [ 86.609859] nixos[5755]: finished switching to system configuration /nix/store/r98v1gxb34fn1a91wp3rikv857jj70xv-nixos-system-machine-test machine: (finished: must succeed: /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test/specialisation/simpleServiceWithExtraKeyOtherValue/bin/switch-to-configuration test 2>&1, in 1.78 seconds) machine: must succeed: /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test/specialisation/simpleServiceWithExtraKeyOtherName/bin/switch-to-configuration test 2>&1 machine # [ 86.884876] nixos[5897]: switching to system configuration /nix/store/1q78rcbk2ckw3lrdh1c4c5yx3zlh63df-nixos-system-machine-test machine # [ 86.888437] systemd[1]: Stopped target Remote File Systems. machine # [ 86.891613] systemd[1]: Stopped target Local File Systems. machine # [ 87.168919] systemd[1]: Reload requested from client PID 5897 ('.switch-to-conf') (unit backdoor.service)... machine # [ 87.170878] systemd[1]: Reloading... machine # [ 87.477637] systemd[1]: Reloading finished in 305 ms. machine # [ 87.560576] systemd[589]: Reexecution requested from client PID 5966 ('switch-to-confi')... machine # [ 87.564272] systemd[589]: Reexecuting. machine # [ 87.623619] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 87.733887] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 87.740281] systemd[589]: Reload requested from client PID 5966 ('switch-to-confi')... machine # [ 87.742601] systemd[589]: Reloading... machine # [ 87.844518] systemd[589]: Reloading finished in 100 ms. machine # [ 87.860152] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 87.869298] systemd[589]: Stopped Run user-specific NixOS activation. machine # [ 87.871576] systemd[589]: Stopping Run user-specific NixOS activation... machine # [ 87.873667] systemd[589]: Starting Run user-specific NixOS activation... machine # [ 87.902087] systemd[589]: Finished Run user-specific NixOS activation. machine # [ 87.906165] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 87.910980] systemd[1]: Stopping Reactivate sysinit units... machine # [ 87.911902] systemd[1]: Reached target Reactivate sysinit units. machine # [ 87.914017] systemd[1]: test.service: Deactivated successfully. machine # [ 87.914883] systemd[1]: Stopped test.service. machine # [ 87.915650] systemd[1]: Stopping test.service... machine # [ 87.920258] systemd[1]: Starting test.service... machine # [ 87.939952] systemd[1]: Finished test.service. machine # [ 87.943325] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 87.946293] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 87.949763] systemd[1]: Reached target Remote File Systems. machine # [ 87.953980] systemd[1]: Reached target Local File Systems. machine # [ 87.957501] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 87.963910] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 87.966469] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 87.967772] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 87.971210] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 87.976152] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 87.977490] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 88.129186] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 88.132845] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 88.135433] systemd[1]: Starting linger-users.service... machine # [ 88.175428] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 88.177942] systemd[1]: Finished linger-users.service. machine # [ 88.433443] nixos[5897]: finished switching to system configuration /nix/store/1q78rcbk2ckw3lrdh1c4c5yx3zlh63df-nixos-system-machine-test machine: (finished: must succeed: /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test/specialisation/simpleServiceWithExtraKeyOtherName/bin/switch-to-configuration test 2>&1, in 1.82 seconds) machine: must succeed: /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1 machine # [ 88.641427] nixos[6039]: switching to system configuration /nix/store/5sfwvj46bvawa98krfx8m6gpmwdhxczn-nixos-system-machine-test machine # [ 88.643923] systemd[1]: Stopped target Remote File Systems. machine # [ 88.646181] systemd[1]: Stopped target Local File Systems. machine # [ 88.897429] systemd[1]: Reload requested from client PID 6039 ('.switch-to-conf') (unit backdoor.service)... machine # [ 88.899020] systemd[1]: Reloading... machine # [ 89.192494] systemd[1]: Reloading finished in 291 ms. machine # [ 89.275946] systemd[589]: Reexecution requested from client PID 6108 ('switch-to-confi')... machine # [ 89.280213] systemd[589]: Reexecuting. machine # [ 89.335607] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 89.443114] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 89.450024] systemd[589]: Reload requested from client PID 6108 ('switch-to-confi')... machine # [ 89.451317] systemd[589]: Reloading... machine # [ 89.551764] systemd[589]: Reloading finished in 99 ms. machine # [ 89.569532] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 89.578244] systemd[589]: Stopped Run user-specific NixOS activation. machine # [ 89.579213] systemd[589]: Stopping Run user-specific NixOS activation... machine # [ 89.582011] systemd[589]: Starting Run user-specific NixOS activation... machine # [ 89.609409] systemd[589]: Finished Run user-specific NixOS activation. machine # [ 89.613165] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 89.614376] systemd[1]: Stopping Reactivate sysinit units... machine # [ 89.615198] systemd[1]: Reached target Reactivate sysinit units. machine # [ 89.617452] systemd[1]: test.service: Deactivated successfully. machine # [ 89.620548] systemd[1]: Stopped test.service. machine # [ 89.621243] systemd[1]: Stopping test.service... machine # [ 89.622802] systemd[1]: Starting test.service... machine # [ 89.643171] systemd[1]: Finished test.service. machine # [ 89.645754] systemd[1]: Reached target Local File Systems. machine # [ 89.648439] systemd[1]: Reached target Remote File Systems. machine # [ 89.650620] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 89.651999] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 89.657104] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 89.663239] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 89.666404] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 89.667737] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 89.675676] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 89.678819] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 89.680181] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 89.827826] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 89.832722] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 89.834736] systemd[1]: Starting linger-users.service... machine # [ 89.874461] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 89.877455] systemd[1]: Finished linger-users.service. machine # [ 90.131488] nixos[6039]: finished switching to system configuration /nix/store/5sfwvj46bvawa98krfx8m6gpmwdhxczn-nixos-system-machine-test machine: (finished: must succeed: /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test/specialisation/simpleServiceNostop/bin/switch-to-configuration test 2>&1, in 1.70 seconds) machine: must succeed: /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test/specialisation/simpleServiceReloadTrigger/bin/switch-to-configuration test 2>&1 machine # [ 90.351152] nixos[6181]: switching to system configuration /nix/store/qr9cfi7jniiibz56zsxn6c4f8lvg1cb5-nixos-system-machine-test machine # [ 90.354417] systemd[1]: Stopped target Local File Systems. machine # [ 90.355914] systemd[1]: Stopped target Remote File Systems. machine # [ 90.619522] systemd[1]: Reload requested from client PID 6181 ('.switch-to-conf') (unit backdoor.service)... machine # [ 90.621596] systemd[1]: Reloading... machine # [ 90.921186] systemd[1]: Reloading finished in 298 ms. machine # [ 91.004398] systemd[589]: Reexecution requested from client PID 6250 ('switch-to-confi')... machine # [ 91.008053] systemd[589]: Reexecuting. machine # [ 91.063580] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 91.175215] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 91.181630] systemd[589]: Reload requested from client PID 6250 ('switch-to-confi')... machine # [ 91.183863] systemd[589]: Reloading... machine # [ 91.286020] systemd[589]: Reloading finished in 101 ms. machine # [ 91.300141] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 91.310592] systemd[589]: Stopped Run user-specific NixOS activation. machine # [ 91.312745] systemd[589]: Stopping Run user-specific NixOS activation... machine # [ 91.314677] systemd[589]: Starting Run user-specific NixOS activation... machine # [ 91.346189] systemd[589]: Finished Run user-specific NixOS activation. machine # [ 91.349996] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 91.354226] systemd[1]: Stopping Reactivate sysinit units... machine # [ 91.355071] systemd[1]: Reached target Reactivate sysinit units. machine # [ 91.357179] systemd[1]: Reloading test.service... machine # [ 91.379796] systemd[1]: Reloaded test.service. machine # [ 91.382737] systemd[1]: Reached target Local File Systems. machine # [ 91.387583] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 91.390089] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 91.390943] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 91.400205] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 91.402421] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 91.404003] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 91.407611] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 91.414933] systemd[1]: Reached target Remote File Systems. machine # [ 91.415970] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 91.419505] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 91.558926] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 91.562961] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 91.565071] systemd[1]: Starting linger-users.service... machine # [ 91.602297] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 91.604149] systemd[1]: Finished linger-users.service. machine # [ 91.861167] nixos[6181]: finished switching to system configuration /nix/store/qr9cfi7jniiibz56zsxn6c4f8lvg1cb5-nixos-system-machine-test machine: (finished: must succeed: /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test/specialisation/simpleServiceReloadTrigger/bin/switch-to-configuration test 2>&1, in 1.73 seconds) machine: must succeed: /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModified/bin/switch-to-configuration test 2>&1 machine # [ 92.078249] nixos[6323]: switching to system configuration /nix/store/vrbx2vzpvcldbqyrfcw2f5cpzknqp5pz-nixos-system-machine-test machine # [ 92.080661] systemd[1]: Stopped target Local File Systems. machine # [ 92.082954] systemd[1]: Stopped target Remote File Systems. machine # [ 92.357404] systemd[1]: Reload requested from client PID 6323 ('.switch-to-conf') (unit backdoor.service)... machine # [ 92.359281] systemd[1]: Reloading... machine # [ 92.661322] systemd[1]: Reloading finished in 299 ms. machine # [ 92.743766] systemd[589]: Reexecution requested from client PID 6392 ('switch-to-confi')... machine # [ 92.746089] systemd[589]: Reexecuting. machine # [ 92.803750] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 92.915202] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 92.922472] systemd[589]: Reload requested from client PID 6392 ('switch-to-confi')... machine # [ 92.923850] systemd[589]: Reloading... machine # [ 93.025427] systemd[589]: Reloading finished in 100 ms. machine # [ 93.040170] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 93.050974] systemd[589]: Stopped Run user-specific NixOS activation. machine # [ 93.053345] systemd[589]: Stopping Run user-specific NixOS activation... machine # [ 93.055346] systemd[589]: Starting Run user-specific NixOS activation... machine # [ 93.086283] systemd[589]: Finished Run user-specific NixOS activation. machine # [ 93.090018] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 93.094081] systemd[1]: Stopping Reactivate sysinit units... machine # [ 93.094954] systemd[1]: Reached target Reactivate sysinit units. machine # [ 93.096981] systemd[1]: Reloading test.service... machine # [ 93.119801] systemd[1]: Reloaded test.service. machine # [ 93.125384] systemd[1]: Reached target Remote File Systems. machine # [ 93.129455] systemd[1]: Starting linger-users.service... machine # [ 93.137063] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 93.144106] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 93.145507] systemd[1]: Reached target Local File Systems. machine # [ 93.146438] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 93.160248] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 93.161175] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 93.162430] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 93.172067] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 93.174768] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 93.179298] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 93.213904] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 93.217999] systemd[1]: Finished linger-users.service. machine # [ 93.345728] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 93.349293] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 93.603233] nixos[6323]: finished switching to system configuration /nix/store/vrbx2vzpvcldbqyrfcw2f5cpzknqp5pz-nixos-system-machine-test machine: (finished: must succeed: /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModified/bin/switch-to-configuration test 2>&1, in 1.74 seconds) machine: must succeed: /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModifiedAndSomethingElse/bin/switch-to-configuration test 2>&1 machine # [ 93.830827] nixos[6465]: switching to system configuration /nix/store/ysypx78vwaxb2cwn9bd7qw9rs1x6ssd3-nixos-system-machine-test machine # [ 93.836389] systemd[1]: Stopped target Remote File Systems. machine # [ 93.837280] systemd[1]: Stopped target Local File Systems. machine # [ 94.113325] systemd[1]: Reload requested from client PID 6465 ('.switch-to-conf') (unit backdoor.service)... machine # [ 94.115534] systemd[1]: Reloading... machine # [ 94.419399] systemd[1]: Reloading finished in 302 ms. machine # [ 94.503874] systemd[589]: Reexecution requested from client PID 6534 ('switch-to-confi')... machine # [ 94.507578] systemd[589]: Reexecuting. machine # [ 94.563516] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 94.675768] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 94.682391] systemd[589]: Reload requested from client PID 6534 ('switch-to-confi')... machine # [ 94.685775] systemd[589]: Reloading... machine # [ 94.785940] systemd[589]: Reloading finished in 101 ms. machine # [ 94.804170] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 94.813192] systemd[589]: Stopped Run user-specific NixOS activation. machine # [ 94.815457] systemd[589]: Stopping Run user-specific NixOS activation... machine # [ 94.817512] systemd[589]: Starting Run user-specific NixOS activation... machine # [ 94.846288] systemd[589]: Finished Run user-specific NixOS activation. machine # [ 94.850373] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 94.852581] systemd[1]: Stopping Reactivate sysinit units... machine # [ 94.853433] systemd[1]: Reached target Reactivate sysinit units. machine # [ 94.856443] systemd[1]: test.service: Deactivated successfully. machine # [ 94.857359] systemd[1]: Stopped test.service. machine # [ 94.857999] systemd[1]: Stopping test.service... machine # [ 94.860322] systemd[1]: Starting test.service... machine # [ 94.883720] systemd[1]: Finished test.service. machine # [ 94.888134] systemd[1]: Reached target Remote File Systems. machine # [ 94.892471] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 94.893818] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 94.895108] systemd[1]: Starting linger-users.service... machine # [ 94.905232] systemd[1]: Reached target Local File Systems. machine # [ 94.909592] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 94.917003] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 94.917915] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 94.919139] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 94.928312] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 94.930830] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 94.934419] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 94.978057] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 94.981111] systemd[1]: Finished linger-users.service. machine # [ 95.102273] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 95.105067] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 95.359166] nixos[6465]: finished switching to system configuration /nix/store/ysypx78vwaxb2cwn9bd7qw9rs1x6ssd3-nixos-system-machine-test machine: (finished: must succeed: /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModifiedAndSomethingElse/bin/switch-to-configuration test 2>&1, in 1.76 seconds) machine: must succeed: /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModifiedSomethingElse/bin/switch-to-configuration test 2>&1 machine # [ 95.559641] nixos[6607]: switching to system configuration /nix/store/ha9xbsxa2rlcsk3y16bgpf9yzsrw7zhp-nixos-system-machine-test machine # [ 95.562223] systemd[1]: Stopped target Local File Systems. machine # [ 95.564817] systemd[1]: Stopped target Remote File Systems. machine # [ 95.817990] systemd[1]: Reload requested from client PID 6607 ('.switch-to-conf') (unit backdoor.service)... machine # [ 95.820194] systemd[1]: Reloading... machine # [ 96.107461] systemd[1]: Reloading finished in 285 ms. machine # [ 96.188398] systemd[589]: Reexecution requested from client PID 6676 ('switch-to-confi')... machine # [ 96.191198] systemd[589]: Reexecuting. machine # [ 96.247415] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 96.355507] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 96.362181] systemd[589]: Reload requested from client PID 6676 ('switch-to-confi')... machine # [ 96.364515] systemd[589]: Reloading... machine # [ 96.465280] systemd[589]: Reloading finished in 99 ms. machine # [ 96.481525] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 96.489183] systemd[589]: Stopped Run user-specific NixOS activation. machine # [ 96.491508] systemd[589]: Stopping Run user-specific NixOS activation... machine # [ 96.493586] systemd[589]: Starting Run user-specific NixOS activation... machine # [ 96.522196] systemd[589]: Finished Run user-specific NixOS activation. machine # [ 96.525812] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 96.528782] systemd[1]: Stopping Reactivate sysinit units... machine # [ 96.529649] systemd[1]: Reached target Reactivate sysinit units. machine # [ 96.531584] systemd[1]: Reached target Local File Systems. machine # [ 96.534132] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 96.535555] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 96.538506] systemd[1]: Reached target Remote File Systems. machine # [ 96.543199] systemd[1]: Starting linger-users.service... machine # [ 96.553456] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 96.560839] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 96.561727] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 96.562963] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 96.574573] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 96.579473] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 96.581258] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 96.615534] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 96.618979] systemd[1]: Finished linger-users.service. machine # [ 96.747827] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 96.750279] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 97.005764] nixos[6607]: finished switching to system configuration /nix/store/ha9xbsxa2rlcsk3y16bgpf9yzsrw7zhp-nixos-system-machine-test machine: (finished: must succeed: /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test/specialisation/simpleServiceReloadTriggerModifiedSomethingElse/bin/switch-to-configuration test 2>&1, in 1.65 seconds) (finished: subtest: unit file parser, in 23.12 seconds) subtest: restart and reload by activation script machine: must succeed: /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test/specialisation/simpleServiceNorestart/bin/switch-to-configuration test 2>&1 machine # [ 97.213634] nixos[6747]: switching to system configuration /nix/store/gbzii7acndhl9mz38gzyd7ly15azvhxm-nixos-system-machine-test machine # [ 97.216308] systemd[1]: Stopped target Remote File Systems. machine # [ 97.218561] systemd[1]: Stopped target Local File Systems. machine # [ 97.471420] systemd[1]: Reload requested from client PID 6747 ('.switch-to-conf') (unit backdoor.service)... machine # [ 97.473719] systemd[1]: Reloading... machine # [ 97.761473] systemd[1]: Reloading finished in 285 ms. machine # [ 97.845806] systemd[589]: Reexecution requested from client PID 6816 ('switch-to-confi')... machine # [ 97.849541] systemd[589]: Reexecuting. machine # [ 97.907074] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 98.015109] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 98.021913] systemd[589]: Reload requested from client PID 6816 ('switch-to-confi')... machine # [ 98.025931] systemd[589]: Reloading... machine # [ 98.124724] systemd[589]: Reloading finished in 100 ms. machine # [ 98.140135] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 98.148688] systemd[589]: Stopped Run user-specific NixOS activation. machine # [ 98.150777] systemd[589]: Stopping Run user-specific NixOS activation... machine # [ 98.152840] systemd[589]: Starting Run user-specific NixOS activation... machine # [ 98.181688] systemd[589]: Finished Run user-specific NixOS activation. machine # [ 98.185458] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 98.187589] systemd[1]: Stopping Reactivate sysinit units... machine # [ 98.190207] systemd[1]: Reached target Reactivate sysinit units. machine # [ 98.191082] systemd[1]: Reached target Local File Systems. machine # [ 98.194083] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 98.198732] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 98.201034] systemd[1]: Reached target Remote File Systems. machine # [ 98.204062] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 98.209628] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 98.210542] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 98.211836] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 98.220218] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 98.221834] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 98.223079] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 98.373502] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 98.376535] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 98.379560] systemd[1]: Starting linger-users.service... machine # [ 98.417357] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 98.419862] systemd[1]: Finished linger-users.service. machine # [ 98.674858] nixos[6747]: finished switching to system configuration /nix/store/gbzii7acndhl9mz38gzyd7ly15azvhxm-nixos-system-machine-test machine: (finished: must succeed: /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test/specialisation/simpleServiceNorestart/bin/switch-to-configuration test 2>&1, in 1.67 seconds) machine: must succeed: /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration test 2>&1 machine # [ 98.891099] nixos[6887]: switching to system configuration /nix/store/hliaz6k7vl55m0psgk6vn1m7gslyqdn5-nixos-system-machine-test machine # [ 98.893746] systemd[1]: test.service: Deactivated successfully. machine # [ 98.897133] systemd[1]: Stopped test.service. machine # [ 98.898367] systemd[1]: Stopped target Local File Systems. machine # [ 98.899167] systemd[1]: Stopped target Remote File Systems. machine # [ 99.168363] systemd[1]: Reload requested from client PID 6887 ('.switch-to-conf') (unit backdoor.service)... machine # [ 99.170244] systemd[1]: Reloading... machine # [ 99.474624] systemd[1]: Reloading finished in 302 ms. machine # [ 99.559097] systemd[589]: Reexecution requested from client PID 6958 ('switch-to-confi')... machine # [ 99.561222] systemd[589]: Reexecuting. machine # [ 99.623790] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 99.734874] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 99.741472] systemd[589]: Reload requested from client PID 6958 ('switch-to-confi')... machine # [ 99.744848] systemd[589]: Reloading... machine # [ 99.844909] systemd[589]: Reloading finished in 100 ms. machine # [ 99.860133] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 99.869180] systemd[589]: Stopped Run user-specific NixOS activation. machine # [ 99.871365] systemd[589]: Stopping Run user-specific NixOS activation... machine # [ 99.873332] systemd[589]: Starting Run user-specific NixOS activation... machine # [ 99.901616] systemd[589]: Finished Run user-specific NixOS activation. machine # [ 99.905391] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 99.906777] systemd[1]: Stopping Reactivate sysinit units... machine # [ 99.907700] systemd[1]: Reached target Reactivate sysinit units. machine # [ 99.915840] systemd[1]: Created slice Slice /system/templated-no-restart-service. machine # [ 99.918890] systemd[1]: Reached target Local File Systems. machine # [ 99.920836] systemd[1]: Starting templated-no-restart-service@instance.service... machine # [ 99.925991] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 99.936390] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 99.937297] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 99.938563] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 99.945423] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 99.947042] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 99.957969] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 99.959247] systemd[1]: Reached target Remote File Systems. machine # [ 99.965128] systemd[1]: Created slice Slice /system/templated-reload-triggers. machine # [ 99.969270] systemd[1]: Created slice Slice /system/templated-reload-triggers-and-restart. machine # [ 99.983104] systemd[1]: Created slice Slice /system/templated-simple-restart-service. machine # [ 99.992738] systemd[1]: Created slice Slice /system/templated-simple-reload-service. machine # [ 99.997994] systemd[1]: Created slice Slice /system/templated-simple-service. machine # [ 100.006226] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 100.010818] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 100.016812] systemd[1]: Finished templated-no-restart-service@instance.service. machine # [ 100.017873] systemd[1]: Created slice Slice /system/templated-reload-triggers-and-restart-by-as. machine # [ 100.150696] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 100.155082] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 100.158140] systemd[1]: Starting linger-users.service... machine # [ 100.162117] systemd[1]: Starting no-restart-service.service... machine # [ 100.174422] systemd[1]: Starting reload-triggers-and-restart-by-as.service... machine # [ 100.175515] systemd[1]: Starting reload-triggers-and-restart.service... machine # [ 100.188283] systemd[1]: Starting reload-triggers.service... machine # [ 100.195033] systemd[1]: Starting simple-reload-service.service... machine # [ 100.204084] systemd[1]: Starting simple-restart-service.service... machine # [ 100.219772] systemd[1]: Starting simple-service.service... machine # [ 100.239473] systemd[1]: Starting templated-reload-triggers-and-restart-by-as@instance.service... machine # [ 100.276577] systemd[1]: Starting templated-reload-triggers-and-restart@instance.service... machine # [ 100.293513] systemd[1]: Starting templated-reload-triggers@instance.service... machine # [ 100.294632] systemd[1]: Starting templated-simple-reload-service@instance.service... machine # [ 100.322650] systemd[1]: Starting templated-simple-restart-service@instance.service... machine # [ 100.348313] systemd[1]: Starting templated-simple-service@instance.service... machine # [ 100.386218] systemd[1]: Finished no-restart-service.service. machine # [ 100.404336] systemd[1]: Finished reload-triggers-and-restart-by-as.service. machine # [ 100.420774] systemd[1]: Finished reload-triggers.service. machine # [ 100.434212] systemd[1]: Finished reload-triggers-and-restart.service. machine # [ 100.446072] systemd[1]: Finished simple-reload-service.service. machine # [ 100.447090] systemd[1]: Finished simple-restart-service.service. machine # [ 100.455795] systemd[1]: Finished simple-service.service. machine # [ 100.458872] systemd[1]: Finished templated-reload-triggers-and-restart-by-as@instance.service. machine # [ 100.462149] systemd[1]: Finished templated-simple-restart-service@instance.service. machine # [ 100.463270] systemd[1]: Finished templated-reload-triggers-and-restart@instance.service. machine # [ 100.467382] systemd[1]: Finished templated-simple-reload-service@instance.service. machine # [ 100.469707] systemd[1]: Finished templated-reload-triggers@instance.service. machine # [ 100.470761] systemd[1]: Finished templated-simple-service@instance.service. machine # [ 100.474811] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 100.475854] systemd[1]: Finished linger-users.service. machine # [ 100.729532] nixos[6887]: finished switching to system configuration /nix/store/hliaz6k7vl55m0psgk6vn1m7gslyqdn5-nixos-system-machine-test machine: (finished: must succeed: /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration test 2>&1, in 2.05 seconds) machine: must succeed: /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration test 2>&1 machine # [ 100.974220] nixos[7057]: switching to system configuration /nix/store/hliaz6k7vl55m0psgk6vn1m7gslyqdn5-nixos-system-machine-test machine # [ 100.976747] systemd[1]: Stopped target Local File Systems. machine # [ 100.979371] systemd[1]: Stopped target Remote File Systems. machine # [ 101.244673] systemd[1]: Reload requested from client PID 7057 ('.switch-to-conf') (unit backdoor.service)... machine # [ 101.246586] systemd[1]: Reloading... machine # [ 101.550543] systemd[1]: Reloading finished in 302 ms. machine # [ 101.640157] systemd[589]: Reexecution requested from client PID 7128 ('switch-to-confi')... machine # [ 101.641556] systemd[589]: Reexecuting. machine # [ 101.699724] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 101.808788] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 101.815129] systemd[589]: Reload requested from client PID 7128 ('switch-to-confi')... machine # [ 101.817192] systemd[589]: Reloading... machine # [ 101.917022] systemd[589]: Reloading finished in 99 ms. machine # [ 101.932130] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 101.941824] systemd[589]: Stopped Run user-specific NixOS activation. machine # [ 101.942813] systemd[589]: Stopping Run user-specific NixOS activation... machine # [ 101.945526] systemd[589]: Starting Run user-specific NixOS activation... machine # [ 101.972900] systemd[589]: Finished Run user-specific NixOS activation. machine # [ 101.976531] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 101.978994] systemd[1]: Stopping Reactivate sysinit units... machine # [ 101.979885] systemd[1]: Reached target Reactivate sysinit units. machine # [ 101.984703] systemd[1]: Reloading reload-triggers-and-restart.service... machine # [ 101.989559] systemd[1]: Reloading reload-triggers.service... machine # [ 102.000589] systemd[1]: Reloading simple-reload-service.service... machine # [ 102.009085] systemd[1]: Reloading templated-reload-triggers-and-restart@instance.service... machine # [ 102.010301] systemd[1]: Reloading templated-reload-triggers@instance.service... machine # [ 102.025020] systemd[1]: Reloading templated-simple-reload-service@instance.service... machine # [ 102.085324] systemd[1]: Reloaded reload-triggers.service. machine # [ 102.091062] systemd[1]: Reloaded simple-reload-service.service. machine # [ 102.096691] systemd[1]: Reloaded templated-reload-triggers-and-restart@instance.service. machine # [ 102.098553] systemd[1]: Reloaded reload-triggers-and-restart.service. machine # [ 102.099592] systemd[1]: Reloaded templated-reload-triggers@instance.service. machine # [ 102.103221] systemd[1]: Reloaded templated-simple-reload-service@instance.service. machine # [ 102.108556] systemd[1]: reload-triggers-and-restart-by-as.service: Deactivated successfully. machine # [ 102.109724] systemd[1]: Stopped reload-triggers-and-restart-by-as.service. machine # [ 102.110688] systemd[1]: Stopping reload-triggers-and-restart-by-as.service... machine # [ 102.116654] systemd[1]: Starting reload-triggers-and-restart-by-as.service... machine # [ 102.121963] systemd[1]: simple-restart-service.service: Deactivated successfully. machine # [ 102.123063] systemd[1]: Stopped simple-restart-service.service. machine # [ 102.123998] systemd[1]: Stopping simple-restart-service.service... machine # [ 102.129098] systemd[1]: Starting simple-restart-service.service... machine # [ 102.129983] systemd[1]: simple-service.service: Deactivated successfully. machine # [ 102.130908] systemd[1]: Stopped simple-service.service. machine # [ 102.131721] systemd[1]: Stopping simple-service.service... machine # [ 102.140191] systemd[1]: Starting simple-service.service... machine # [ 102.141089] systemd[1]: templated-reload-triggers-and-restart-by-as@instance.service: Deactivated successfully. machine # [ 102.142572] systemd[1]: Stopped templated-reload-triggers-and-restart-by-as@instance.service. machine # [ 102.143828] systemd[1]: Stopping templated-reload-triggers-and-restart-by-as@instance.service... machine # [ 102.161072] systemd[1]: Starting templated-reload-triggers-and-restart-by-as@instance.service... machine # [ 102.162312] systemd[1]: templated-simple-restart-service@instance.service: Deactivated successfully. machine # [ 102.163608] systemd[1]: Stopped templated-simple-restart-service@instance.service. machine # [ 102.184891] systemd[1]: Stopping templated-simple-restart-service@instance.service... machine # [ 102.195541] systemd[1]: Starting templated-simple-restart-service@instance.service... machine # [ 102.210830] systemd[1]: templated-simple-service@instance.service: Deactivated successfully. machine # [ 102.219422] systemd[1]: Stopped templated-simple-service@instance.service. machine # [ 102.227149] systemd[1]: Stopping templated-simple-service@instance.service... machine # [ 102.236221] systemd[1]: Starting templated-simple-service@instance.service... machine # [ 102.237259] systemd[1]: Finished reload-triggers-and-restart-by-as.service. machine # [ 102.238216] systemd[1]: Finished simple-restart-service.service. machine # [ 102.245216] systemd[1]: Finished simple-service.service. machine # [ 102.249980] systemd[1]: Finished templated-reload-triggers-and-restart-by-as@instance.service. machine # [ 102.251293] systemd[1]: Finished templated-simple-restart-service@instance.service. machine # [ 102.254612] systemd[1]: Finished templated-simple-service@instance.service. machine # [ 102.260905] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 102.262285] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 102.266933] systemd[1]: Reached target Local File Systems. machine # [ 102.273357] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 102.274952] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 102.275837] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 102.285482] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 102.287747] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 102.289573] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 102.290853] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 102.292224] systemd[1]: Reached target Remote File Systems. machine # [ 102.438924] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 102.443592] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 102.446026] systemd[1]: Starting linger-users.service... machine # [ 102.482757] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 102.485581] systemd[1]: Finished linger-users.service. machine # [ 102.741689] nixos[7057]: finished switching to system configuration /nix/store/hliaz6k7vl55m0psgk6vn1m7gslyqdn5-nixos-system-machine-test machine: (finished: must succeed: /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration test 2>&1, in 2.01 seconds) machine: must succeed: /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script-modified/bin/switch-to-configuration test 2>&1 machine # [ 103.002036] nixos[7223]: switching to system configuration /nix/store/z22nydczhynsypv60wfnziwiw5rh7r9b-nixos-system-machine-test machine # [ 103.004791] systemd[1]: Stopped target Local File Systems. machine # [ 103.007141] systemd[1]: Stopped target Remote File Systems. machine # [ 103.287612] systemd[1]: Reload requested from client PID 7223 ('.switch-to-conf') (unit backdoor.service)... machine # [ 103.289610] systemd[1]: Reloading... machine # [ 103.605729] systemd[1]: Reloading finished in 313 ms. machine # [ 103.691906] systemd[589]: Reexecution requested from client PID 7294 ('switch-to-confi')... machine # [ 103.693945] systemd[589]: Reexecuting. machine # [ 103.755966] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 103.867677] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 103.874157] systemd[589]: Reload requested from client PID 7294 ('switch-to-confi')... machine # [ 103.877307] systemd[589]: Reloading... machine # [ 103.975167] systemd[589]: Reloading finished in 98 ms. machine # [ 103.992147] systemd[589]: Failed to adjust io pressure threshold, ignoring: Device or resource busy machine # [ 104.001145] systemd[589]: Stopped Run user-specific NixOS activation. machine # [ 104.003406] systemd[589]: Stopping Run user-specific NixOS activation... machine # [ 104.005545] systemd[589]: Starting Run user-specific NixOS activation... machine # [ 104.033420] systemd[589]: Finished Run user-specific NixOS activation. machine # [ 104.037027] systemd[1]: Stopped target Reactivate sysinit units. machine # [ 104.041799] systemd[1]: Stopping Reactivate sysinit units... machine # [ 104.042699] systemd[1]: Reached target Reactivate sysinit units. machine # [ 104.047194] systemd[1]: Reloading reload-triggers.service... machine # [ 104.052630] systemd[1]: Reloading simple-reload-service.service... machine # [ 104.061307] systemd[1]: Reloading templated-reload-triggers@instance.service... machine # [ 104.062378] systemd[1]: Reloading templated-simple-reload-service@instance.service... machine # [ 104.121405] systemd[1]: Reloaded reload-triggers.service. machine # [ 104.123531] systemd[1]: Reloaded simple-reload-service.service. machine # [ 104.126634] systemd[1]: Reloaded templated-reload-triggers@instance.service. machine # [ 104.127662] systemd[1]: Reloaded templated-simple-reload-service@instance.service. machine # [ 104.132726] systemd[1]: reload-triggers-and-restart-by-as.service: Deactivated successfully. machine # [ 104.133920] systemd[1]: Stopped reload-triggers-and-restart-by-as.service. machine # [ 104.134874] systemd[1]: Stopping reload-triggers-and-restart-by-as.service... machine # [ 104.137895] systemd[1]: Starting reload-triggers-and-restart-by-as.service... machine # [ 104.141600] systemd[1]: reload-triggers-and-restart.service: Deactivated successfully. machine # [ 104.142745] systemd[1]: Stopped reload-triggers-and-restart.service. machine # [ 104.143690] systemd[1]: Stopping reload-triggers-and-restart.service... machine # [ 104.161534] systemd[1]: Starting reload-triggers-and-restart.service... machine # [ 104.162490] systemd[1]: simple-restart-service.service: Deactivated successfully. machine # [ 104.163652] systemd[1]: Stopped simple-restart-service.service. machine # [ 104.180748] systemd[1]: Stopping simple-restart-service.service... machine # [ 104.181675] systemd[1]: Starting simple-restart-service.service... machine # [ 104.182690] systemd[1]: simple-service.service: Deactivated successfully. machine # [ 104.183659] systemd[1]: Stopped simple-service.service. machine # [ 104.220428] systemd[1]: Stopping simple-service.service... machine # [ 104.221291] systemd[1]: Starting simple-service.service... machine # [ 104.235721] systemd[1]: templated-reload-triggers-and-restart-by-as@instance.service: Deactivated successfully. machine # [ 104.252517] systemd[1]: Stopped templated-reload-triggers-and-restart-by-as@instance.service. machine # [ 104.253909] systemd[1]: Stopping templated-reload-triggers-and-restart-by-as@instance.service... machine # [ 104.255282] systemd[1]: Starting templated-reload-triggers-and-restart-by-as@instance.service... machine # [ 104.288597] systemd[1]: templated-reload-triggers-and-restart@instance.service: Deactivated successfully. machine # [ 104.296818] systemd[1]: Stopped templated-reload-triggers-and-restart@instance.service. machine # [ 104.298127] systemd[1]: Stopping templated-reload-triggers-and-restart@instance.service... machine # [ 104.299344] systemd[1]: Starting templated-reload-triggers-and-restart@instance.service... machine # [ 104.307053] systemd[1]: templated-simple-restart-service@instance.service: Deactivated successfully. machine # [ 104.309277] systemd[1]: Stopped templated-simple-restart-service@instance.service. machine # [ 104.310348] systemd[1]: Stopping templated-simple-restart-service@instance.service... machine # [ 104.311418] systemd[1]: Starting templated-simple-restart-service@instance.service... machine # [ 104.318941] systemd[1]: templated-simple-service@instance.service: Deactivated successfully. machine # [ 104.322256] systemd[1]: Stopped templated-simple-service@instance.service. machine # [ 104.323338] systemd[1]: Stopping templated-simple-service@instance.service... machine # [ 104.325013] systemd[1]: Starting templated-simple-service@instance.service... machine # [ 104.326009] systemd[1]: Finished reload-triggers-and-restart-by-as.service. machine # [ 104.326959] systemd[1]: Finished simple-restart-service.service. machine # [ 104.327812] systemd[1]: Finished reload-triggers-and-restart.service. machine # [ 104.339611] systemd[1]: Finished simple-service.service. machine # [ 104.347420] systemd[1]: Finished templated-reload-triggers-and-restart-by-as@instance.service. machine # [ 104.348750] systemd[1]: Finished templated-reload-triggers-and-restart@instance.service. machine # [ 104.349849] systemd[1]: Finished templated-simple-restart-service@instance.service. machine # [ 104.350912] systemd[1]: Finished templated-simple-service@instance.service. machine # [ 104.351889] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os machine # [ 104.353997] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 104.355372] systemd[1]: Reached target Remote File Systems. machine # [ 104.356238] systemd[1]: Reached target Local File Systems. machine # [ 104.357024] systemd[1]: Starting linger-users.service... machine # [ 104.357781] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 104.359255] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 104.365804] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 104.367092] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 104.376412] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 104.378138] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 104.379473] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os machine # [ 104.417161] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 104.418139] systemd[1]: Finished linger-users.service. machine # [ 104.537011] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 104.540148] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 104.794349] nixos[7223]: finished switching to system configuration /nix/store/z22nydczhynsypv60wfnziwiw5rh7r9b-nixos-system-machine-test machine: (finished: must succeed: /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script-modified/bin/switch-to-configuration test 2>&1, in 2.05 seconds) machine: must succeed: /nix/store/clkacyxq45yd6r43ajw5wck8z2jra1q2-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/clkacyxq45yd6r43ajw5wck8z2jra1q2-nixos-system-machine-test/specialisation/restart-and-reload-by-activation-script/bin/switch-to-configuration dry-activate 2>&1, in 0.34 seconds) (finished: subtest: restart and reload by activation script, in 8.13 seconds) (finished: run the VM test script, in 105.91 seconds) test script finished in 105.95s cleanup kill QemuMachine (pid 45) machine # qemu-system-aarch64: terminating on signal 15 from pid 39 (/nix/store/81ag9nxz1flw3xjkv1vvqg8y2ipx2ins-python3-3.14.7/bin/python3.14) machine # [2026-10-18T02:45:12Z INFO virtiofsd] Client disconnected, shutting down machine # [2026-10-18T02:45:12Z INFO virtiofsd] Client disconnected, shutting down machine # [2026-10-18T02:45:12Z INFO virtiofsd] Client disconnected, shutting down (finished: cleanup, in 0.16 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